Oct 29 00:17:51.170291 kernel: Linux version 6.12.114-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.1 p1) 2.46.1) #1 SMP PREEMPT_DYNAMIC Wed Oct 28 22:01:27 -00 2026 Oct 29 00:17:51.170330 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=461a545bfda7ad88fe8124696be7a206cb0111a62d631c9f1c0d4934f867df02 Oct 29 00:17:51.170342 kernel: BIOS-provided physical RAM map: Oct 29 00:17:51.170351 kernel: BIOS-e820: [mem 0x0000000000000000-0x000000000009ffff] usable Oct 29 00:17:51.170360 kernel: BIOS-e820: [mem 0x00000000000c0000-0x00000000000fffff] reserved Oct 29 00:17:51.170369 kernel: BIOS-e820: [mem 0x0000000000100000-0x00000000044fdfff] usable Oct 29 00:17:51.170380 kernel: BIOS-e820: [mem 0x00000000044fe000-0x00000000048fdfff] reserved Oct 29 00:17:51.170389 kernel: BIOS-e820: [mem 0x00000000048fe000-0x000000003ff1efff] usable Oct 29 00:17:51.170396 kernel: BIOS-e820: [mem 0x000000003ff1f000-0x000000003ffc8fff] reserved Oct 29 00:17:51.170404 kernel: BIOS-e820: [mem 0x000000003ffc9000-0x000000003fffafff] ACPI data Oct 29 00:17:51.170412 kernel: BIOS-e820: [mem 0x000000003fffb000-0x000000003fffefff] ACPI NVS Oct 29 00:17:51.170419 kernel: BIOS-e820: [mem 0x000000003ffff000-0x000000003fffffff] usable Oct 29 00:17:51.170428 kernel: BIOS-e820: [mem 0x0000000100000000-0x00000002bfffffff] usable Oct 29 00:17:51.170442 kernel: printk: legacy bootconsole [earlyser0] enabled Oct 29 00:17:51.170451 kernel: NX (Execute Disable) protection: active Oct 29 00:17:51.170458 kernel: APIC: Static calls initialized Oct 29 00:17:51.170467 kernel: efi: EFI v2.7 by Microsoft Oct 29 00:17:51.170478 kernel: efi: ACPI=0x3fffa000 ACPI 2.0=0x3fffa014 SMBIOS=0x3ff88000 SMBIOS 3.0=0x3ff86000 MEMATTR=0x3ea69018 RNG=0x3ffd2018 Oct 29 00:17:51.170489 kernel: random: crng init done Oct 29 00:17:51.170497 kernel: secureboot: Secure boot disabled Oct 29 00:17:51.170505 kernel: SMBIOS 3.1.0 present. Oct 29 00:17:51.170514 kernel: DMI: Microsoft Corporation Virtual Machine/Virtual Machine, BIOS Hyper-V UEFI Release v4.1 04/22/2026 Oct 29 00:17:51.170523 kernel: DMI: Memory slots populated: 2/2 Oct 29 00:17:51.170531 kernel: Hypervisor detected: Microsoft Hyper-V Oct 29 00:17:51.170540 kernel: Hyper-V: privilege flags low 0xae7f, high 0x3b8030, hints 0x9e4e24, misc 0xe0bed7b2 Oct 29 00:17:51.170548 kernel: Hyper-V: Nested features: 0x3e0101 Oct 29 00:17:51.170556 kernel: Hyper-V: LAPIC Timer Frequency: 0x30d40 Oct 29 00:17:51.170564 kernel: Hyper-V: Using hypercall for remote TLB flush Oct 29 00:17:51.170576 kernel: clocksource: hyperv_clocksource_tsc_page: mask: 0xffffffffffffffff max_cycles: 0x24e6a1710, max_idle_ns: 440795202120 ns Oct 29 00:17:51.170586 kernel: clocksource: hyperv_clocksource_msr: mask: 0xffffffffffffffff max_cycles: 0x24e6a1710, max_idle_ns: 440795202120 ns Oct 29 00:17:51.170594 kernel: tsc: Detected 2299.999 MHz processor Oct 29 00:17:51.170603 kernel: e820: update [mem 0x00000000-0x00000fff] usable ==> reserved Oct 29 00:17:51.170613 kernel: e820: remove [mem 0x000a0000-0x000fffff] usable Oct 29 00:17:51.170622 kernel: last_pfn = 0x2c0000 max_arch_pfn = 0x10000000000 Oct 29 00:17:51.170631 kernel: MTRR map: 4 entries (2 fixed + 2 variable; max 18), built from 8 variable MTRRs Oct 29 00:17:51.170641 kernel: x86/PAT: Configuration [0-7]: WB WC UC- UC WB WP UC- WT Oct 29 00:17:51.170654 kernel: e820: update [mem 0x48000000-0xffffffff] usable ==> reserved Oct 29 00:17:51.170663 kernel: last_pfn = 0x40000 max_arch_pfn = 0x10000000000 Oct 29 00:17:51.170689 kernel: Using GB pages for direct mapping Oct 29 00:17:51.170699 kernel: ACPI: Early table checksum verification disabled Oct 29 00:17:51.170713 kernel: ACPI: RSDP 0x000000003FFFA014 000024 (v02 VRTUAL) Oct 29 00:17:51.170725 kernel: ACPI: XSDT 0x000000003FFF90E8 00005C (v01 VRTUAL MICROSFT 00000001 MSFT 00000001) Oct 29 00:17:51.170734 kernel: ACPI: FACP 0x000000003FFF8000 000114 (v06 VRTUAL MICROSFT 00000001 MSFT 00000001) Oct 29 00:17:51.170742 kernel: ACPI: DSDT 0x000000003FFD6000 01E22B (v02 MSFTVM DSDT01 00000001 INTL 20230628) Oct 29 00:17:51.170751 kernel: ACPI: FACS 0x000000003FFFE000 000040 Oct 29 00:17:51.170761 kernel: ACPI: OEM0 0x000000003FFF7000 000064 (v01 VRTUAL MICROSFT 00000001 MSFT 00000001) Oct 29 00:17:51.170769 kernel: ACPI: SPCR 0x000000003FFF6000 000050 (v02 VRTUAL MICROSFT 00000001 MSFT 00000001) Oct 29 00:17:51.170781 kernel: ACPI: WAET 0x000000003FFF5000 000028 (v01 VRTUAL MICROSFT 00000001 MSFT 00000001) Oct 29 00:17:51.170790 kernel: ACPI: APIC 0x000000003FFD5000 000058 (v05 HVLITE HVLITETB 00000000 MSHV 00000000) Oct 29 00:17:51.170799 kernel: ACPI: SRAT 0x000000003FFD4000 0000A0 (v03 HVLITE HVLITETB 00000000 MSHV 00000000) Oct 29 00:17:51.170808 kernel: ACPI: BGRT 0x000000003FFD3000 000038 (v01 VRTUAL MICROSFT 00000001 MSFT 00000001) Oct 29 00:17:51.170817 kernel: ACPI: Reserving FACP table memory at [mem 0x3fff8000-0x3fff8113] Oct 29 00:17:51.170826 kernel: ACPI: Reserving DSDT table memory at [mem 0x3ffd6000-0x3fff422a] Oct 29 00:17:51.170836 kernel: ACPI: Reserving FACS table memory at [mem 0x3fffe000-0x3fffe03f] Oct 29 00:17:51.170848 kernel: ACPI: Reserving OEM0 table memory at [mem 0x3fff7000-0x3fff7063] Oct 29 00:17:51.170857 kernel: ACPI: Reserving SPCR table memory at [mem 0x3fff6000-0x3fff604f] Oct 29 00:17:51.170865 kernel: ACPI: Reserving WAET table memory at [mem 0x3fff5000-0x3fff5027] Oct 29 00:17:51.170874 kernel: ACPI: Reserving APIC table memory at [mem 0x3ffd5000-0x3ffd5057] Oct 29 00:17:51.170884 kernel: ACPI: Reserving SRAT table memory at [mem 0x3ffd4000-0x3ffd409f] Oct 29 00:17:51.170893 kernel: ACPI: Reserving BGRT table memory at [mem 0x3ffd3000-0x3ffd3037] Oct 29 00:17:51.170901 kernel: ACPI: SRAT: Node 0 PXM 0 [mem 0x00000000-0x3fffffff] Oct 29 00:17:51.170911 kernel: ACPI: SRAT: Node 0 PXM 0 [mem 0x100000000-0x2bfffffff] Oct 29 00:17:51.170919 kernel: NUMA: Node 0 [mem 0x00001000-0x3fffffff] + [mem 0x100000000-0x2bfffffff] -> [mem 0x00001000-0x2bfffffff] Oct 29 00:17:51.170928 kernel: NODE_DATA(0) allocated [mem 0x2bfff8dc0-0x2bfffffff] Oct 29 00:17:51.170936 kernel: Zone ranges: Oct 29 00:17:51.170945 kernel: DMA [mem 0x0000000000001000-0x0000000000ffffff] Oct 29 00:17:51.170954 kernel: DMA32 [mem 0x0000000001000000-0x00000000ffffffff] Oct 29 00:17:51.170962 kernel: Normal [mem 0x0000000100000000-0x00000002bfffffff] Oct 29 00:17:51.170972 kernel: Device empty Oct 29 00:17:51.170981 kernel: Movable zone start for each node Oct 29 00:17:51.170990 kernel: Early memory node ranges Oct 29 00:17:51.170998 kernel: node 0: [mem 0x0000000000001000-0x000000000009ffff] Oct 29 00:17:51.171007 kernel: node 0: [mem 0x0000000000100000-0x00000000044fdfff] Oct 29 00:17:51.171016 kernel: node 0: [mem 0x00000000048fe000-0x000000003ff1efff] Oct 29 00:17:51.171025 kernel: node 0: [mem 0x000000003ffff000-0x000000003fffffff] Oct 29 00:17:51.171035 kernel: node 0: [mem 0x0000000100000000-0x00000002bfffffff] Oct 29 00:17:51.171046 kernel: Initmem setup node 0 [mem 0x0000000000001000-0x00000002bfffffff] Oct 29 00:17:51.171055 kernel: On node 0, zone DMA: 1 pages in unavailable ranges Oct 29 00:17:51.171064 kernel: On node 0, zone DMA: 96 pages in unavailable ranges Oct 29 00:17:51.171073 kernel: On node 0, zone DMA32: 1024 pages in unavailable ranges Oct 29 00:17:51.171082 kernel: On node 0, zone DMA32: 224 pages in unavailable ranges Oct 29 00:17:51.171091 kernel: ACPI: PM-Timer IO Port: 0x408 Oct 29 00:17:51.171100 kernel: ACPI: LAPIC_NMI (acpi_id[0x01] dfl dfl lint[0x1]) Oct 29 00:17:51.171110 kernel: IOAPIC[0]: apic_id 0, version 17, address 0xfec00000, GSI 0-23 Oct 29 00:17:51.171119 kernel: ACPI: INT_SRC_OVR (bus 0 bus_irq 9 global_irq 9 high level) Oct 29 00:17:51.171129 kernel: ACPI: Using ACPI (MADT) for SMP configuration information Oct 29 00:17:51.171138 kernel: ACPI: SPCR: console: uart,io,0x3f8,115200 Oct 29 00:17:51.171147 kernel: TSC deadline timer available Oct 29 00:17:51.171156 kernel: CPU topo: Max. logical packages: 1 Oct 29 00:17:51.171165 kernel: CPU topo: Max. logical dies: 1 Oct 29 00:17:51.171176 kernel: CPU topo: Max. dies per package: 1 Oct 29 00:17:51.171185 kernel: CPU topo: Max. threads per core: 2 Oct 29 00:17:51.171194 kernel: CPU topo: Num. cores per package: 1 Oct 29 00:17:51.171202 kernel: CPU topo: Num. threads per package: 2 Oct 29 00:17:51.171210 kernel: CPU topo: Allowing 2 present CPUs plus 0 hotplug CPUs Oct 29 00:17:51.171218 kernel: [mem 0x40000000-0xffffffff] available for PCI devices Oct 29 00:17:51.171226 kernel: Booting paravirtualized kernel on Hyper-V Oct 29 00:17:51.171235 kernel: clocksource: refined-jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1910969940391419 ns Oct 29 00:17:51.171244 kernel: setup_percpu: NR_CPUS:512 nr_cpumask_bits:2 nr_cpu_ids:2 nr_node_ids:1 Oct 29 00:17:51.171253 kernel: percpu: Embedded 60 pages/cpu s208408 r8192 d29160 u1048576 Oct 29 00:17:51.171261 kernel: pcpu-alloc: s208408 r8192 d29160 u1048576 alloc=1*2097152 Oct 29 00:17:51.171269 kernel: pcpu-alloc: [0] 0 1 Oct 29 00:17:51.171277 kernel: Hyper-V: PV spinlocks enabled Oct 29 00:17:51.171286 kernel: PV qspinlock hash table entries: 256 (order: 0, 4096 bytes, linear) Oct 29 00:17:51.171298 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=461a545bfda7ad88fe8124696be7a206cb0111a62d631c9f1c0d4934f867df02 Oct 29 00:17:51.171307 kernel: Dentry cache hash table entries: 1048576 (order: 11, 8388608 bytes, linear) Oct 29 00:17:51.171316 kernel: Inode-cache hash table entries: 524288 (order: 10, 4194304 bytes, linear) Oct 29 00:17:51.171325 kernel: Fallback order for Node 0: 0 Oct 29 00:17:51.171334 kernel: Built 1 zonelists, mobility grouping on. Total pages: 2095807 Oct 29 00:17:51.171343 kernel: Policy zone: Normal Oct 29 00:17:51.171352 kernel: mem auto-init: stack:off, heap alloc:off, heap free:off Oct 29 00:17:51.171362 kernel: software IO TLB: area num 2. Oct 29 00:17:51.171370 kernel: SLUB: HWalign=64, Order=0-3, MinObjects=0, CPUs=2, Nodes=1 Oct 29 00:17:51.171378 kernel: ftrace: allocating 41543 entries in 164 pages Oct 29 00:17:51.171388 kernel: ftrace: allocated 164 pages with 3 groups Oct 29 00:17:51.171395 kernel: Dynamic Preempt: voluntary Oct 29 00:17:51.171404 kernel: rcu: Preemptible hierarchical RCU implementation. Oct 29 00:17:51.171414 kernel: rcu: RCU event tracing is enabled. Oct 29 00:17:51.171434 kernel: rcu: RCU restricting CPUs from NR_CPUS=512 to nr_cpu_ids=2. Oct 29 00:17:51.171444 kernel: Trampoline variant of Tasks RCU enabled. Oct 29 00:17:51.171455 kernel: Rude variant of Tasks RCU enabled. Oct 29 00:17:51.171465 kernel: Tracing variant of Tasks RCU enabled. Oct 29 00:17:51.171475 kernel: rcu: RCU calculated value of scheduler-enlistment delay is 100 jiffies. Oct 29 00:17:51.171484 kernel: rcu: Adjusting geometry for rcu_fanout_leaf=16, nr_cpu_ids=2 Oct 29 00:17:51.171494 kernel: RCU Tasks: Setting shift to 1 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=2. Oct 29 00:17:51.171504 kernel: RCU Tasks Rude: Setting shift to 1 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=2. Oct 29 00:17:51.171514 kernel: RCU Tasks Trace: Setting shift to 1 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=2. Oct 29 00:17:51.171526 kernel: Using NULL legacy PIC Oct 29 00:17:51.171536 kernel: NR_IRQS: 33024, nr_irqs: 440, preallocated irqs: 0 Oct 29 00:17:51.171546 kernel: rcu: srcu_init: Setting srcu_struct sizes based on contention. Oct 29 00:17:51.171556 kernel: clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1911260446275000 ns Oct 29 00:17:51.171567 kernel: Console: colour dummy device 80x25 Oct 29 00:17:51.171577 kernel: printk: legacy console [tty1] enabled Oct 29 00:17:51.171587 kernel: printk: legacy console [ttyS0] enabled Oct 29 00:17:51.171596 kernel: printk: legacy bootconsole [earlyser0] disabled Oct 29 00:17:51.171606 kernel: ACPI: Core revision 20240827 Oct 29 00:17:51.171616 kernel: Failed to register legacy timer interrupt Oct 29 00:17:51.171626 kernel: APIC: Switch to symmetric I/O mode setup Oct 29 00:17:51.171638 kernel: x2apic enabled Oct 29 00:17:51.171648 kernel: APIC: Switched APIC routing to: physical x2apic Oct 29 00:17:51.171657 kernel: Hyper-V: Host Build 10.0.26102.3704-3-0 Oct 29 00:17:51.171746 kernel: Hyper-V: enabling crash_kexec_post_notifiers Oct 29 00:17:51.171757 kernel: Hyper-V: Disabling IBT because of Hyper-V bug Oct 29 00:17:51.171768 kernel: Hyper-V: Using IPI hypercalls Oct 29 00:17:51.171778 kernel: APIC: send_IPI() replaced with hv_send_ipi() Oct 29 00:17:51.171791 kernel: APIC: send_IPI_mask() replaced with hv_send_ipi_mask() Oct 29 00:17:51.171801 kernel: APIC: send_IPI_mask_allbutself() replaced with hv_send_ipi_mask_allbutself() Oct 29 00:17:51.171811 kernel: APIC: send_IPI_allbutself() replaced with hv_send_ipi_allbutself() Oct 29 00:17:51.171821 kernel: APIC: send_IPI_all() replaced with hv_send_ipi_all() Oct 29 00:17:51.171831 kernel: APIC: send_IPI_self() replaced with hv_send_ipi_self() Oct 29 00:17:51.171841 kernel: clocksource: tsc-early: mask: 0xffffffffffffffff max_cycles: 0x2127345424d, max_idle_ns: 440795318347 ns Oct 29 00:17:51.171851 kernel: Calibrating delay loop (skipped), value calculated using timer frequency.. 4599.99 BogoMIPS (lpj=2299999) Oct 29 00:17:51.171863 kernel: x86/cpu: User Mode Instruction Prevention (UMIP) activated Oct 29 00:17:51.171873 kernel: Last level iTLB entries: 4KB 0, 2MB 0, 4MB 0 Oct 29 00:17:51.171883 kernel: Last level dTLB entries: 4KB 0, 2MB 0, 4MB 0, 1GB 0 Oct 29 00:17:51.171892 kernel: Spectre V1 : Mitigation: usercopy/swapgs barriers and __user pointer sanitization Oct 29 00:17:51.171901 kernel: Spectre V2 : Mitigation: Retpolines Oct 29 00:17:51.171911 kernel: Spectre V2 : Spectre v2 / SpectreRSB: Filling RSB on context switch and VMEXIT Oct 29 00:17:51.171920 kernel: RETBleed: WARNING: Spectre v2 mitigation leaves CPU vulnerable to RETBleed attacks, data leaks possible! Oct 29 00:17:51.171930 kernel: RETBleed: Vulnerable Oct 29 00:17:51.171938 kernel: Speculative Store Bypass: Vulnerable Oct 29 00:17:51.171950 kernel: active return thunk: its_return_thunk Oct 29 00:17:51.171960 kernel: ITS: Mitigation: Aligned branch/return thunks Oct 29 00:17:51.171970 kernel: x86/fpu: Supporting XSAVE feature 0x001: 'x87 floating point registers' Oct 29 00:17:51.171979 kernel: x86/fpu: Supporting XSAVE feature 0x002: 'SSE registers' Oct 29 00:17:51.171988 kernel: x86/fpu: Supporting XSAVE feature 0x004: 'AVX registers' Oct 29 00:17:51.171997 kernel: x86/fpu: Supporting XSAVE feature 0x020: 'AVX-512 opmask' Oct 29 00:17:51.172007 kernel: x86/fpu: Supporting XSAVE feature 0x040: 'AVX-512 Hi256' Oct 29 00:17:51.172016 kernel: x86/fpu: Supporting XSAVE feature 0x080: 'AVX-512 ZMM_Hi256' Oct 29 00:17:51.172029 kernel: x86/fpu: Supporting XSAVE feature 0x800: 'Control-flow User registers' Oct 29 00:17:51.172038 kernel: x86/fpu: Supporting XSAVE feature 0x20000: 'AMX Tile config' Oct 29 00:17:51.172049 kernel: x86/fpu: Supporting XSAVE feature 0x40000: 'AMX Tile data' Oct 29 00:17:51.172059 kernel: x86/fpu: xstate_offset[2]: 576, xstate_sizes[2]: 256 Oct 29 00:17:51.172068 kernel: x86/fpu: xstate_offset[5]: 832, xstate_sizes[5]: 64 Oct 29 00:17:51.172077 kernel: x86/fpu: xstate_offset[6]: 896, xstate_sizes[6]: 512 Oct 29 00:17:51.172086 kernel: x86/fpu: xstate_offset[7]: 1408, xstate_sizes[7]: 1024 Oct 29 00:17:51.172095 kernel: x86/fpu: xstate_offset[11]: 2432, xstate_sizes[11]: 16 Oct 29 00:17:51.172104 kernel: x86/fpu: xstate_offset[17]: 2496, xstate_sizes[17]: 64 Oct 29 00:17:51.172113 kernel: x86/fpu: xstate_offset[18]: 2560, xstate_sizes[18]: 8192 Oct 29 00:17:51.172123 kernel: x86/fpu: Enabled xstate features 0x608e7, context size is 10752 bytes, using 'compacted' format. Oct 29 00:17:51.172132 kernel: Freeing SMP alternatives memory: 36K Oct 29 00:17:51.172141 kernel: pid_max: default: 32768 minimum: 301 Oct 29 00:17:51.172152 kernel: LSM: initializing lsm=lockdown,capability,landlock,selinux,ima Oct 29 00:17:51.172161 kernel: landlock: Up and running. Oct 29 00:17:51.172170 kernel: SELinux: Initializing. Oct 29 00:17:51.172180 kernel: Mount-cache hash table entries: 16384 (order: 5, 131072 bytes, linear) Oct 29 00:17:51.172189 kernel: Mountpoint-cache hash table entries: 16384 (order: 5, 131072 bytes, linear) Oct 29 00:17:51.172199 kernel: smpboot: CPU0: Intel INTEL(R) XEON(R) PLATINUM 8573C (family: 0x6, model: 0xcf, stepping: 0x2) Oct 29 00:17:51.172208 kernel: Performance Events: unsupported p6 CPU model 207 no PMU driver, software events only. Oct 29 00:17:51.172218 kernel: signal: max sigframe size: 11952 Oct 29 00:17:51.172228 kernel: rcu: Hierarchical SRCU implementation. Oct 29 00:17:51.172241 kernel: rcu: Max phase no-delay instances is 400. Oct 29 00:17:51.172251 kernel: Timer migration: 1 hierarchy levels; 8 children per group; 1 crossnode level Oct 29 00:17:51.172261 kernel: NMI watchdog: Perf NMI watchdog permanently disabled Oct 29 00:17:51.172270 kernel: smp: Bringing up secondary CPUs ... Oct 29 00:17:51.172279 kernel: smpboot: x86: Booting SMP configuration: Oct 29 00:17:51.172289 kernel: .... node #0, CPUs: #1 Oct 29 00:17:51.172299 kernel: smp: Brought up 1 node, 2 CPUs Oct 29 00:17:51.172309 kernel: smpboot: Total of 2 processors activated (9199.99 BogoMIPS) Oct 29 00:17:51.172321 kernel: Memory: 8056344K/8383228K available (14336K kernel code, 2476K rwdata, 33320K rodata, 16280K init, 1748K bss, 320624K reserved, 0K cma-reserved) Oct 29 00:17:51.172331 kernel: devtmpfs: initialized Oct 29 00:17:51.172341 kernel: x86/mm: Memory block size: 128MB Oct 29 00:17:51.172351 kernel: ACPI: PM: Registering ACPI NVS region [mem 0x3fffb000-0x3fffefff] (16384 bytes) Oct 29 00:17:51.172361 kernel: futex hash table entries: 512 (order: 3, 32768 bytes, linear) Oct 29 00:17:51.172371 kernel: pinctrl core: initialized pinctrl subsystem Oct 29 00:17:51.172381 kernel: NET: Registered PF_NETLINK/PF_ROUTE protocol family Oct 29 00:17:51.172393 kernel: audit: initializing netlink subsys (disabled) Oct 29 00:17:51.172403 kernel: audit: type=2000 audit(1793233064.120:1): state=initialized audit_enabled=0 res=1 Oct 29 00:17:51.172413 kernel: thermal_sys: Registered thermal governor 'step_wise' Oct 29 00:17:51.172422 kernel: thermal_sys: Registered thermal governor 'user_space' Oct 29 00:17:51.172432 kernel: cpuidle: using governor menu Oct 29 00:17:51.172442 kernel: efi: Freeing EFI boot services memory: 34976K Oct 29 00:17:51.172451 kernel: acpiphp: ACPI Hot Plug PCI Controller Driver version: 0.5 Oct 29 00:17:51.172463 kernel: dca service started, version 1.12.1 Oct 29 00:17:51.172473 kernel: e820: reserve RAM buffer [mem 0x044fe000-0x07ffffff] Oct 29 00:17:51.172483 kernel: e820: reserve RAM buffer [mem 0x3ff1f000-0x3fffffff] Oct 29 00:17:51.172492 kernel: kprobes: kprobe jump-optimization is enabled. All kprobes are optimized if possible. Oct 29 00:17:51.172502 kernel: HugeTLB: registered 1.00 GiB page size, pre-allocated 0 pages Oct 29 00:17:51.172512 kernel: HugeTLB: 16380 KiB vmemmap can be freed for a 1.00 GiB page Oct 29 00:17:51.172522 kernel: HugeTLB: registered 2.00 MiB page size, pre-allocated 0 pages Oct 29 00:17:51.172534 kernel: HugeTLB: 28 KiB vmemmap can be freed for a 2.00 MiB page Oct 29 00:17:51.172543 kernel: ACPI: Added _OSI(Module Device) Oct 29 00:17:51.172553 kernel: ACPI: Added _OSI(Processor Device) Oct 29 00:17:51.172563 kernel: ACPI: Added _OSI(Processor Aggregator Device) Oct 29 00:17:51.172573 kernel: ACPI: 1 ACPI AML tables successfully acquired and loaded Oct 29 00:17:51.172582 kernel: ACPI: Interpreter enabled Oct 29 00:17:51.172592 kernel: ACPI: PM: (supports S0 S5) Oct 29 00:17:51.172603 kernel: ACPI: Using IOAPIC for interrupt routing Oct 29 00:17:51.172614 kernel: PCI: Using host bridge windows from ACPI; if necessary, use "pci=nocrs" and report a bug Oct 29 00:17:51.172624 kernel: PCI: Ignoring E820 reservations for host bridge windows Oct 29 00:17:51.172634 kernel: ACPI: Enabled 1 GPEs in block 00 to 0F Oct 29 00:17:51.172643 kernel: iommu: Default domain type: Translated Oct 29 00:17:51.172653 kernel: iommu: DMA domain TLB invalidation policy: lazy mode Oct 29 00:17:51.172663 kernel: efivars: Registered efivars operations Oct 29 00:17:51.172684 kernel: PCI: Using ACPI for IRQ routing Oct 29 00:17:51.172694 kernel: PCI: System does not support PCI Oct 29 00:17:51.172704 kernel: vgaarb: loaded Oct 29 00:17:51.172714 kernel: clocksource: Switched to clocksource tsc-early Oct 29 00:17:51.172723 kernel: VFS: Disk quotas dquot_6.6.0 Oct 29 00:17:51.172733 kernel: VFS: Dquot-cache hash table entries: 512 (order 0, 4096 bytes) Oct 29 00:17:51.172743 kernel: pnp: PnP ACPI init Oct 29 00:17:51.172755 kernel: pnp: PnP ACPI: found 3 devices Oct 29 00:17:51.172765 kernel: clocksource: acpi_pm: mask: 0xffffff max_cycles: 0xffffff, max_idle_ns: 2085701024 ns Oct 29 00:17:51.172775 kernel: NET: Registered PF_INET protocol family Oct 29 00:17:51.172785 kernel: IP idents hash table entries: 131072 (order: 8, 1048576 bytes, linear) Oct 29 00:17:51.172795 kernel: tcp_listen_portaddr_hash hash table entries: 4096 (order: 4, 65536 bytes, linear) Oct 29 00:17:51.172805 kernel: Table-perturb hash table entries: 65536 (order: 6, 262144 bytes, linear) Oct 29 00:17:51.172815 kernel: TCP established hash table entries: 65536 (order: 7, 524288 bytes, linear) Oct 29 00:17:51.172826 kernel: TCP bind hash table entries: 65536 (order: 9, 2097152 bytes, linear) Oct 29 00:17:51.172836 kernel: TCP: Hash tables configured (established 65536 bind 65536) Oct 29 00:17:51.172846 kernel: UDP hash table entries: 4096 (order: 5, 131072 bytes, linear) Oct 29 00:17:51.172856 kernel: UDP-Lite hash table entries: 4096 (order: 5, 131072 bytes, linear) Oct 29 00:17:51.172866 kernel: NET: Registered PF_UNIX/PF_LOCAL protocol family Oct 29 00:17:51.172875 kernel: NET: Registered PF_XDP protocol family Oct 29 00:17:51.172885 kernel: PCI: CLS 0 bytes, default 64 Oct 29 00:17:51.172897 kernel: PCI-DMA: Using software bounce buffering for IO (SWIOTLB) Oct 29 00:17:51.172907 kernel: software IO TLB: mapped [mem 0x000000003a96c000-0x000000003e96c000] (64MB) Oct 29 00:17:51.172917 kernel: RAPL PMU: API unit is 2^-32 Joules, 1 fixed counters, 10737418240 ms ovfl timer Oct 29 00:17:51.172927 kernel: RAPL PMU: hw unit of domain psys 2^-0 Joules Oct 29 00:17:51.172937 kernel: clocksource: tsc: mask: 0xffffffffffffffff max_cycles: 0x2127345424d, max_idle_ns: 440795318347 ns Oct 29 00:17:51.172946 kernel: clocksource: Switched to clocksource tsc Oct 29 00:17:51.172955 kernel: Initialise system trusted keyrings Oct 29 00:17:51.172967 kernel: workingset: timestamp_bits=39 max_order=21 bucket_order=0 Oct 29 00:17:51.172976 kernel: Key type asymmetric registered Oct 29 00:17:51.172986 kernel: Asymmetric key parser 'x509' registered Oct 29 00:17:51.172994 kernel: Block layer SCSI generic (bsg) driver version 0.4 loaded (major 250) Oct 29 00:17:51.173003 kernel: io scheduler mq-deadline registered Oct 29 00:17:51.173013 kernel: io scheduler kyber registered Oct 29 00:17:51.173023 kernel: io scheduler bfq registered Oct 29 00:17:51.173033 kernel: ioatdma: Intel(R) QuickData Technology Driver 5.00 Oct 29 00:17:51.173045 kernel: Serial: 8250/16550 driver, 4 ports, IRQ sharing enabled Oct 29 00:17:51.173055 kernel: 00:00: ttyS0 at I/O 0x3f8 (irq = 4, base_baud = 115200) is a 16550A Oct 29 00:17:51.173066 kernel: 00:01: ttyS1 at I/O 0x2f8 (irq = 3, base_baud = 115200) is a 16550A Oct 29 00:17:51.173076 kernel: serial8250: ttyS2 at I/O 0x3e8 (irq = 4, base_baud = 115200) is a 16550A Oct 29 00:17:51.173086 kernel: ACPI: bus type drm_connector registered Oct 29 00:17:51.173095 kernel: i8042: PNP: No PS/2 controller found. Oct 29 00:17:51.173287 kernel: rtc_cmos 00:02: registered as rtc0 Oct 29 00:17:51.173405 kernel: rtc_cmos 00:02: setting system clock to 2026-10-29T00:17:46 UTC (1793233066) Oct 29 00:17:51.173509 kernel: rtc_cmos 00:02: alarms up to one month, 114 bytes nvram Oct 29 00:17:51.173520 kernel: intel_pstate: Intel P-state driver initializing Oct 29 00:17:51.173529 kernel: efifb: probing for efifb Oct 29 00:17:51.173540 kernel: efifb: framebuffer at 0x40000000, using 3072k, total 3072k Oct 29 00:17:51.173552 kernel: efifb: mode is 1024x768x32, linelength=4096, pages=1 Oct 29 00:17:51.173562 kernel: efifb: scrolling: redraw Oct 29 00:17:51.173571 kernel: efifb: Truecolor: size=8:8:8:8, shift=24:16:8:0 Oct 29 00:17:51.173581 kernel: Console: switching to colour frame buffer device 128x48 Oct 29 00:17:51.173592 kernel: fb0: EFI VGA frame buffer device Oct 29 00:17:51.173602 kernel: pstore: Using crash dump compression: deflate Oct 29 00:17:51.173612 kernel: pstore: Registered efi_pstore as persistent store backend Oct 29 00:17:51.173623 kernel: NET: Registered PF_INET6 protocol family Oct 29 00:17:51.173635 kernel: Segment Routing with IPv6 Oct 29 00:17:51.173646 kernel: In-situ OAM (IOAM) with IPv6 Oct 29 00:17:51.173656 kernel: NET: Registered PF_PACKET protocol family Oct 29 00:17:51.173666 kernel: Key type dns_resolver registered Oct 29 00:17:51.173688 kernel: IPI shorthand broadcast: enabled Oct 29 00:17:51.173699 kernel: sched_clock: Marking stable (2218014472, 110030462)->(2642359967, -314315033) Oct 29 00:17:51.173709 kernel: registered taskstats version 1 Oct 29 00:17:51.173722 kernel: Loading compiled-in X.509 certificates Oct 29 00:17:51.173733 kernel: Loaded X.509 cert 'Kinvolk GmbH: Module signing key for 6.12.114-flatcar: 838a325c6c4d01ac8fcd0572c551794f13730c96' Oct 29 00:17:51.173744 kernel: Demotion targets for Node 0: null Oct 29 00:17:51.173754 kernel: Key type .fscrypt registered Oct 29 00:17:51.173764 kernel: Key type fscrypt-provisioning registered Oct 29 00:17:51.173773 kernel: ima: No TPM chip found, activating TPM-bypass! Oct 29 00:17:51.173781 kernel: ima: Allocated hash algorithm: sha1 Oct 29 00:17:51.173792 kernel: ima: No architecture policies found Oct 29 00:17:51.173801 kernel: clk: Disabling unused clocks Oct 29 00:17:51.173810 kernel: Freeing unused kernel image (initmem) memory: 16280K Oct 29 00:17:51.173820 kernel: Write protecting the kernel read-only data: 49152k Oct 29 00:17:51.173830 kernel: Freeing unused kernel image (rodata/data gap) memory: 1496K Oct 29 00:17:51.173839 kernel: Run /init as init process Oct 29 00:17:51.173849 kernel: with arguments: Oct 29 00:17:51.173860 kernel: /init Oct 29 00:17:51.173869 kernel: with environment: Oct 29 00:17:51.173878 kernel: HOME=/ Oct 29 00:17:51.173887 kernel: TERM=linux Oct 29 00:17:51.173897 kernel: hv_vmbus: hv_mmio=[mem 0x40000000-0xfed3ffff],[mem 0xfc0000000-0xfffffffff] fb=[mem 0x40000000-0x47ffffff] Oct 29 00:17:51.173906 kernel: hv_vmbus: Vmbus version:5.3 Oct 29 00:17:51.173917 kernel: pps_core: LinuxPPS API ver. 1 registered Oct 29 00:17:51.173925 kernel: pps_core: Software ver. 5.3.6 - Copyright 2005-2007 Rodolfo Giometti Oct 29 00:17:51.173936 kernel: PTP clock support registered Oct 29 00:17:51.173945 kernel: hv_utils: Registering HyperV Utility Driver Oct 29 00:17:51.173954 kernel: hv_vmbus: registering driver hv_utils Oct 29 00:17:51.173963 kernel: hv_utils: Shutdown IC version 3.2 Oct 29 00:17:51.173973 kernel: hv_utils: Heartbeat IC version 3.0 Oct 29 00:17:51.173983 kernel: hv_utils: TimeSync IC version 4.0 Oct 29 00:17:51.173993 kernel: SCSI subsystem initialized Oct 29 00:17:51.174005 kernel: hv_vmbus: registering driver hv_pci Oct 29 00:17:51.174183 kernel: hv_pci 7ad35d50-c05b-47ab-b3a0-56a9a845852b: PCI VMBus probing: Using version 0x10004 Oct 29 00:17:51.174316 kernel: hv_pci 7ad35d50-c05b-47ab-b3a0-56a9a845852b: PCI host bridge to bus c05b:00 Oct 29 00:17:51.174473 kernel: pci_bus c05b:00: root bus resource [mem 0xfc0000000-0xfc007ffff window] Oct 29 00:17:51.174605 kernel: pci_bus c05b:00: No busn resource found for root bus, will use [bus 00-ff] Oct 29 00:17:51.174788 kernel: pci c05b:00:00.0: [1414:00a9] type 00 class 0x010802 PCIe Endpoint Oct 29 00:17:51.174937 kernel: pci c05b:00:00.0: BAR 0 [mem 0xfc0000000-0xfc007ffff 64bit] Oct 29 00:17:51.175068 kernel: pci_bus c05b:00: busn_res: [bus 00-ff] end is updated to 00 Oct 29 00:17:51.175215 kernel: pci c05b:00:00.0: BAR 0 [mem 0xfc0000000-0xfc007ffff 64bit]: assigned Oct 29 00:17:51.175227 kernel: hv_vmbus: registering driver hv_storvsc Oct 29 00:17:51.175367 kernel: scsi host0: storvsc_host_t Oct 29 00:17:51.175523 kernel: scsi 0:0:0:2: CD-ROM Msft Virtual DVD-ROM 1.0 PQ: 0 ANSI: 5 Oct 29 00:17:51.175536 kernel: hid: raw HID events driver (C) Jiri Kosina Oct 29 00:17:51.175546 kernel: hv_vmbus: registering driver hid_hyperv Oct 29 00:17:51.175555 kernel: input: Microsoft Vmbus HID-compliant Mouse as /devices/0006:045E:0621.0001/input/input0 Oct 29 00:17:51.175685 kernel: hid-hyperv 0006:045E:0621.0001: input: VIRTUAL HID v0.01 Mouse [Microsoft Vmbus HID-compliant Mouse] on Oct 29 00:17:51.175700 kernel: hv_vmbus: registering driver hyperv_keyboard Oct 29 00:17:51.175709 kernel: input: AT Translated Set 2 keyboard as /devices/LNXSYSTM:00/LNXSYBUS:00/ACPI0004:00/MSFT1000:00/d34b2567-b9b6-42b9-8778-0a4ec0b955bf/serio0/input/input1 Oct 29 00:17:51.175850 kernel: nvme nvme0: pci function c05b:00:00.0 Oct 29 00:17:51.175998 kernel: nvme c05b:00:00.0: enabling device (0000 -> 0002) Oct 29 00:17:51.176125 kernel: nvme nvme0: 2/0/0 default/read/poll queues Oct 29 00:17:51.176138 kernel: nvme0n1: p1 p2 p3 p4 p6 p7 p9 Oct 29 00:17:51.176287 kernel: sr 0:0:0:2: [sr0] scsi-1 drive Oct 29 00:17:51.176299 kernel: cdrom: Uniform CD-ROM driver Revision: 3.20 Oct 29 00:17:51.176439 kernel: sr 0:0:0:2: Attached scsi CD-ROM sr0 Oct 29 00:17:51.176451 kernel: device-mapper: core: CONFIG_IMA_DISABLE_HTABLE is disabled. Duplicate IMA measurements will not be recorded in the IMA log. Oct 29 00:17:51.176478 kernel: device-mapper: uevent: version 1.0.3 Oct 29 00:17:51.176491 kernel: device-mapper: ioctl: 4.48.0-ioctl (2023-03-01) initialised: dm-devel@lists.linux.dev Oct 29 00:17:51.176503 kernel: device-mapper: verity: sha256 using shash "sha256-generic" Oct 29 00:17:51.176514 kernel: raid6: avx512x4 gen() 43747 MB/s Oct 29 00:17:51.176524 kernel: raid6: avx512x2 gen() 42757 MB/s Oct 29 00:17:51.176533 kernel: raid6: avx512x1 gen() 25132 MB/s Oct 29 00:17:51.176551 kernel: raid6: avx2x4 gen() 34390 MB/s Oct 29 00:17:51.176562 kernel: raid6: avx2x2 gen() 36714 MB/s Oct 29 00:17:51.176572 kernel: raid6: avx2x1 gen() 29575 MB/s Oct 29 00:17:51.176584 kernel: raid6: using algorithm avx512x4 gen() 43747 MB/s Oct 29 00:17:51.176594 kernel: raid6: .... xor() 7362 MB/s, rmw enabled Oct 29 00:17:51.176604 kernel: raid6: using avx512x2 recovery algorithm Oct 29 00:17:51.176614 kernel: xor: automatically using best checksumming function avx Oct 29 00:17:51.176623 kernel: Btrfs loaded, zoned=no, fsverity=no Oct 29 00:17:51.176633 kernel: BTRFS: device fsid 22bd0b97-bda5-4278-b349-6876fbe30c1a devid 1 transid 39 /dev/mapper/usr (254:0) scanned by mount (945) Oct 29 00:17:51.176643 kernel: BTRFS info (device dm-0): first mount of filesystem 22bd0b97-bda5-4278-b349-6876fbe30c1a Oct 29 00:17:51.176655 kernel: BTRFS info (device dm-0): using crc32c (crc32c-intel) checksum algorithm Oct 29 00:17:51.176666 kernel: BTRFS info (device dm-0 state E): enabling ssd optimizations Oct 29 00:17:51.176690 kernel: BTRFS info (device dm-0 state E): disabling log replay at mount time Oct 29 00:17:51.176701 kernel: BTRFS info (device dm-0 state E): enabling free space tree Oct 29 00:17:51.176711 kernel: loop: module loaded Oct 29 00:17:51.176721 kernel: loop0: detected capacity change from 0 to 110264 Oct 29 00:17:51.176731 kernel: squashfs: version 4.0 (2009/01/31) Phillip Lougher Oct 29 00:17:51.176742 systemd[1]: Successfully made /usr/ read-only. Oct 29 00:17:51.176760 systemd[1]: systemd 261.2 running in system mode (+PAM +AUDIT +SELINUX -APPARMOR +IMA +IPE +SMACK +SECCOMP -GCRYPT -GNUTLS +OPENSSL -ACL +BLKID +CURL +ELFUTILS -FIDO2 +IDN2 +KMOD +LIBCRYPTSETUP +LIBCRYPTSETUP_PLUGINS +LIBFDISK +PCRE2 -PWQUALITY -P11KIT -QRENCODE +TPM2 +BZIP2 +LZ4 +XZ +ZLIB +ZSTD -BPF_FRAMEWORK -BTF -XKBCOMMON +UTMP +LIBARCHIVE) Oct 29 00:17:51.176771 systemd[1]: Detected virtualization microsoft. Oct 29 00:17:51.176782 systemd[1]: Detected architecture x86-64. Oct 29 00:17:51.176791 systemd[1]: Running in initrd. Oct 29 00:17:51.176801 systemd[1]: Initializing machine ID from random generator. Oct 29 00:17:51.176814 systemd[1]: No hostname configured, using default hostname. Oct 29 00:17:51.176824 systemd[1]: Hostname set to . Oct 29 00:17:51.176835 (gene[978]: '/usr/lib/systemd/system-generators/dracut-crypt-generator' failed with exit status 2. Oct 29 00:17:51.176847 systemd[1]: Queued start job for default target initrd.target. Oct 29 00:17:51.176858 systemd[1]: Started clevis-luks-askpass.path - Forward Password Requests to Clevis Directory Watch. Oct 29 00:17:51.176870 systemd[1]: Started systemd-ask-password-console.path - Dispatch Password Requests to Console Directory Watch. Oct 29 00:17:51.176881 systemd[1]: Expecting device dev-disk-by\x2dlabel-EFI\x2dSYSTEM.device - /dev/disk/by-label/EFI-SYSTEM... Oct 29 00:17:51.176892 systemd[1]: Expecting device dev-disk-by\x2dlabel-OEM.device - /dev/disk/by-label/OEM... Oct 29 00:17:51.176902 systemd[1]: Expecting device dev-disk-by\x2dlabel-ROOT.device - /dev/disk/by-label/ROOT... Oct 29 00:17:51.176913 systemd[1]: Expecting device dev-disk-by\x2dpartlabel-USR\x2dA.device - /dev/disk/by-partlabel/USR-A... Oct 29 00:17:51.176926 systemd[1]: Expecting device dev-mapper-usr.device - /dev/mapper/usr... Oct 29 00:17:51.176937 systemd[1]: Reached target cryptsetup-pre.target - Local Encrypted Volumes (Pre). Oct 29 00:17:51.176948 systemd[1]: Reached target cryptsetup.target - Local Encrypted Volumes. Oct 29 00:17:51.176959 systemd[1]: Reached target initrd-usr-fs.target - Initrd /usr File System. Oct 29 00:17:51.176968 systemd[1]: Reached target paths.target - Path Units. Oct 29 00:17:51.176978 systemd[1]: Reached target slices.target - Slice Units. Oct 29 00:17:51.176990 systemd[1]: Reached target swap.target - Swaps. Oct 29 00:17:51.177000 systemd[1]: Reached target timers.target - Timer Units. Oct 29 00:17:51.177011 systemd[1]: Listening on iscsid.socket - Open-iSCSI iscsid Socket. Oct 29 00:17:51.177021 systemd[1]: Listening on iscsiuio.socket - Open-iSCSI iscsiuio Socket. Oct 29 00:17:51.177031 systemd[1]: Listening on systemd-coredump.socket - Process Core Dump Socket. Oct 29 00:17:51.177042 systemd[1]: Listening on systemd-journald-audit.socket - Journal Audit Socket. Oct 29 00:17:51.177053 systemd[1]: Listening on systemd-journald-dev-log.socket - Journal Socket (/dev/log). Oct 29 00:17:51.177066 systemd[1]: Listening on systemd-journald.socket - Journal Sockets. Oct 29 00:17:51.177076 systemd[1]: Listening on systemd-networkd.socket - Network Management Netlink Socket. Oct 29 00:17:51.177086 systemd[1]: Listening on systemd-udevd-control.socket - udev Control Socket. Oct 29 00:17:51.177096 systemd[1]: Listening on systemd-udevd-kernel.socket - udev Kernel Socket. Oct 29 00:17:51.177105 systemd[1]: Reached target sockets.target - Socket Units. Oct 29 00:17:51.177114 systemd[1]: afterburn-network-kargs.service - Afterburn Initrd Setup Network Kernel Arguments skipped, no trigger condition checks were met. Oct 29 00:17:51.177124 systemd[1]: Starting ignition-setup-pre.service - Ignition env setup... Oct 29 00:17:51.177138 systemd[1]: Starting kmod-static-nodes.service - Create List of Static Device Nodes... Oct 29 00:17:51.177148 systemd[1]: Finished network-cleanup.service - Network Cleanup. Oct 29 00:17:51.177159 systemd[1]: systemd-battery-check.service - Early Battery Level Check skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/class/power_supply Oct 29 00:17:51.177169 systemd[1]: Starting systemd-journald.service - Journal Service... Oct 29 00:17:51.177180 systemd[1]: Starting systemd-modules-load.service - Load Kernel Modules... Oct 29 00:17:51.177193 systemd[1]: Starting systemd-network-generator.service - Generate Network Units from Kernel Command Line... Oct 29 00:17:51.177203 systemd[1]: Starting systemd-vconsole-setup.service - Virtual Console Setup... Oct 29 00:17:51.177213 systemd[1]: Finished ignition-setup-pre.service - Ignition env setup. Oct 29 00:17:51.177225 systemd[1]: Finished kmod-static-nodes.service - Create List of Static Device Nodes. Oct 29 00:17:51.177236 systemd[1]: Finished systemd-network-generator.service - Generate Network Units from Kernel Command Line. Oct 29 00:17:51.177249 systemd[1]: Reached target network-pre.target - Preparation for Network. Oct 29 00:17:51.177260 systemd[1]: Listening on systemd-networkd-resolve-hook.socket - Network Management Resolve Hook Socket. Oct 29 00:17:51.177271 systemd[1]: Starting systemd-tmpfiles-setup-dev-early.service - Create Static Device Nodes in /dev gracefully... Oct 29 00:17:51.177281 kernel: bridge: filtering via arp/ip/ip6tables is no longer available by default. Update your scripts to load br_netfilter if you need this. Oct 29 00:17:51.177317 systemd-journald[1072]: Collecting audit messages is enabled. Oct 29 00:17:51.177344 kernel: Bridge firewalling registered Oct 29 00:17:51.177354 systemd[1]: Finished systemd-modules-load.service - Load Kernel Modules. Oct 29 00:17:51.177369 systemd-journald[1072]: Journal started Oct 29 00:17:51.177393 systemd-journald[1072]: Runtime Journal (/run/log/journal/5e889297a0ae43ad95ad96e921af76f2) is 8M, max 158.5M, 150.5M free. Oct 29 00:17:51.030814 systemd-modules-load[1074]: Using 2 probe threads Oct 29 00:17:51.175000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=systemd-modules-load comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Oct 29 00:17:51.167827 systemd-modules-load[1074]: Inserted module 'br_netfilter' Oct 29 00:17:51.184381 kernel: audit: type=1130 audit(1793233071.175:2): pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=systemd-modules-load comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Oct 29 00:17:51.184453 systemd[1]: Started systemd-journald.service - Journal Service. Oct 29 00:17:51.183000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=systemd-journald comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Oct 29 00:17:51.188616 systemd[1]: Finished systemd-tmpfiles-setup-dev-early.service - Create Static Device Nodes in /dev gracefully. Oct 29 00:17:51.190155 kernel: audit: type=1130 audit(1793233071.183:3): pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=systemd-journald comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Oct 29 00:17:51.188000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=systemd-tmpfiles-setup-dev-early comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Oct 29 00:17:51.195968 systemd[1]: Starting systemd-sysctl.service - Apply Kernel Variables... Oct 29 00:17:51.196790 kernel: audit: type=1130 audit(1793233071.188:4): pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=systemd-tmpfiles-setup-dev-early comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Oct 29 00:17:51.197800 systemd[1]: Starting systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev... Oct 29 00:17:51.200444 systemd[1]: Starting systemd-tmpfiles-setup.service - Create System Files and Directories... Oct 29 00:17:51.224547 systemd-tmpfiles[1087]: /usr/lib/tmpfiles.d/systemd.conf:30: Duplicate line for path "/var/lib/systemd", ignoring. Oct 29 00:17:51.227833 systemd-tmpfiles[1087]: /usr/lib/tmpfiles.d/var.conf:14: Duplicate line for path "/var/log", ignoring. Oct 29 00:17:51.228423 systemd[1]: Finished systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev. Oct 29 00:17:51.226000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=systemd-tmpfiles-setup-dev comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Oct 29 00:17:51.234744 kernel: audit: type=1130 audit(1793233071.226:5): pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=systemd-tmpfiles-setup-dev comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Oct 29 00:17:51.252979 systemd[1]: systemd-sysctl.service: Deactivated successfully. Oct 29 00:17:51.255273 systemd-vconsole-setup[1077]: Configuration of first virtual console was skipped, ignoring remaining ones. Oct 29 00:17:51.254000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=systemd-sysctl comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Oct 29 00:17:51.254000 audit[1]: SERVICE_STOP pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=systemd-sysctl comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Oct 29 00:17:51.255279 systemd[1]: Finished systemd-sysctl.service - Apply Kernel Variables. Oct 29 00:17:51.262000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=systemd-vconsole-setup comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Oct 29 00:17:51.268288 kernel: audit: type=1130 audit(1793233071.254:6): pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=systemd-sysctl comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Oct 29 00:17:51.262400 systemd[1]: Finished systemd-vconsole-setup.service - Virtual Console Setup. Oct 29 00:17:51.270726 kernel: audit: type=1131 audit(1793233071.254:7): pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=systemd-sysctl comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Oct 29 00:17:51.267095 systemd[1]: Finished systemd-tmpfiles-setup.service - Create System Files and Directories. Oct 29 00:17:51.273958 kernel: audit: type=1130 audit(1793233071.262:8): pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=systemd-vconsole-setup comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Oct 29 00:17:51.270000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=systemd-tmpfiles-setup comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Oct 29 00:17:51.276931 systemd[1]: Starting dracut-cmdline-ask.service - dracut ask for additional cmdline parameters... Oct 29 00:17:51.283455 kernel: audit: type=1130 audit(1793233071.270:9): pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=systemd-tmpfiles-setup comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Oct 29 00:17:51.282000 audit: BPF prog-id=5 op=LOAD Oct 29 00:17:51.284011 systemd[1]: Starting systemd-resolved.service - Network Name Resolution... Oct 29 00:17:51.289295 kernel: audit: type=1334 audit(1793233071.282:10): prog-id=5 op=LOAD Oct 29 00:17:51.307892 systemd[1]: Finished dracut-cmdline-ask.service - dracut ask for additional cmdline parameters. Oct 29 00:17:51.310000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=dracut-cmdline-ask comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Oct 29 00:17:51.319379 kernel: audit: type=1130 audit(1793233071.310:11): pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=dracut-cmdline-ask comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Oct 29 00:17:51.320799 systemd[1]: Starting dracut-cmdline.service - dracut cmdline hook... Oct 29 00:17:51.328557 systemd-resolved[1094]: Positive Trust Anchors: Oct 29 00:17:51.328572 systemd-resolved[1094]: . IN DS 20326 8 2 e06d44b80b8f1d39a95c0b0d7c65d08458e880409bbc683457104237c7f8ec8d Oct 29 00:17:51.328576 systemd-resolved[1094]: . IN DS 38696 8 2 683d2d0acb8c9b712a1948b27f741219298d0a450d612c483af444a4c0fb2b16 Oct 29 00:17:51.328610 systemd-resolved[1094]: Negative trust anchors: home.arpa 10.in-addr.arpa 16.172.in-addr.arpa 17.172.in-addr.arpa 18.172.in-addr.arpa 19.172.in-addr.arpa 20.172.in-addr.arpa 21.172.in-addr.arpa 22.172.in-addr.arpa 23.172.in-addr.arpa 24.172.in-addr.arpa 25.172.in-addr.arpa 26.172.in-addr.arpa 27.172.in-addr.arpa 28.172.in-addr.arpa 29.172.in-addr.arpa 30.172.in-addr.arpa 31.172.in-addr.arpa 170.0.0.192.in-addr.arpa 171.0.0.192.in-addr.arpa 168.192.in-addr.arpa d.f.ip6.arpa ipv4only.arpa resolver.arpa corp home internal intranet lan local private test Oct 29 00:17:51.424312 dracut-cmdline[1105]: dracut-111 Oct 29 00:17:51.427576 dracut-cmdline[1105]: 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=461a545bfda7ad88fe8124696be7a206cb0111a62d631c9f1c0d4934f867df02 Oct 29 00:17:51.469893 systemd-resolved[1094]: Defaulting to hostname 'linux'. Oct 29 00:17:51.472753 systemd[1]: Started systemd-resolved.service - Network Name Resolution. Oct 29 00:17:51.475000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=systemd-resolved comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Oct 29 00:17:51.476852 systemd[1]: Reached target nss-lookup.target - Host and Network Name Lookups. Oct 29 00:17:51.582701 kernel: Loading iSCSI transport class v2.0-870. Oct 29 00:17:51.646828 kernel: iscsi: registered transport (tcp) Oct 29 00:17:51.709834 kernel: iscsi: registered transport (qla4xxx) Oct 29 00:17:51.709906 kernel: QLogic iSCSI HBA Driver Oct 29 00:17:51.759508 systemd[1]: afterburn-network-kargs.service - Afterburn Initrd Setup Network Kernel Arguments skipped, no trigger condition checks were met. Oct 29 00:17:51.772990 systemd[1]: Finished dracut-cmdline.service - dracut cmdline hook. Oct 29 00:17:51.771000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=dracut-cmdline comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Oct 29 00:17:51.776498 systemd[1]: Starting dracut-pre-udev.service - dracut pre-udev hook... Oct 29 00:17:51.805849 systemd[1]: Finished dracut-pre-udev.service - dracut pre-udev hook. Oct 29 00:17:51.807000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=dracut-pre-udev comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Oct 29 00:17:51.807000 audit: BPF prog-id=6 op=LOAD Oct 29 00:17:51.807000 audit: BPF prog-id=7 op=LOAD Oct 29 00:17:51.810827 systemd[1]: Starting systemd-udevd.service - Rule-based Manager for Device Events and Files... Oct 29 00:17:51.892076 systemd-udevd[1239]: Using default interface naming scheme 'v261'. Oct 29 00:17:51.910915 systemd[1]: Started systemd-udevd.service - Rule-based Manager for Device Events and Files. Oct 29 00:17:51.913974 systemd[1]: Starting dracut-pre-trigger.service - dracut pre-trigger hook... Oct 29 00:17:51.912000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=systemd-udevd comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Oct 29 00:17:51.919000 audit: BPF prog-id=8 op=LOAD Oct 29 00:17:51.923703 systemd[1]: Starting systemd-networkd.service - Network Management... Oct 29 00:17:51.947443 dracut-pre-trigger[1241]: rd.md=0: removing MD RAID activation Oct 29 00:17:51.971266 systemd-networkd[1248]: Failed to open nftables netlink socket. IPMasquerade= and NFTSet= settings will not be applied. Ignoring: Protocol not supported Oct 29 00:17:51.974992 systemd[1]: Finished dracut-pre-trigger.service - dracut pre-trigger hook. Oct 29 00:17:51.982000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=dracut-pre-trigger comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Oct 29 00:17:51.984802 systemd[1]: Starting systemd-udev-trigger.service - Coldplug All udev Devices... Oct 29 00:17:51.985303 systemd-networkd[1248]: lo: Link UP Oct 29 00:17:51.991000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=systemd-networkd comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Oct 29 00:17:51.985307 systemd-networkd[1248]: lo: Gained carrier Oct 29 00:17:51.988848 systemd[1]: Started systemd-networkd.service - Network Management. Oct 29 00:17:51.992941 systemd[1]: Reached target network.target - Network. Oct 29 00:17:52.046149 systemd[1]: Finished systemd-udev-trigger.service - Coldplug All udev Devices. Oct 29 00:17:52.050000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=systemd-udev-trigger comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Oct 29 00:17:52.052862 systemd[1]: Starting dracut-initqueue.service - dracut initqueue hook... Oct 29 00:17:52.148619 systemd[1]: systemd-vconsole-setup.service: Deactivated successfully. Oct 29 00:17:52.150778 systemd[1]: Stopped systemd-vconsole-setup.service - Virtual Console Setup. Oct 29 00:17:52.152000 audit[1]: SERVICE_STOP pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=systemd-vconsole-setup comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Oct 29 00:17:52.154137 systemd[1]: Stopping systemd-vconsole-setup.service - Virtual Console Setup... Oct 29 00:17:52.159865 systemd[1]: Starting systemd-vconsole-setup.service - Virtual Console Setup... Oct 29 00:17:52.166996 kernel: hv_vmbus: registering driver hv_netvsc Oct 29 00:17:52.181325 kernel: hv_netvsc f8615163-0000-1000-2000-7c1e528753a4 (unnamed net_device) (uninitialized): VF slot 1 added Oct 29 00:17:52.181922 systemd[1]: systemd-vconsole-setup.service: Deactivated successfully. Oct 29 00:17:52.184000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=systemd-vconsole-setup comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Oct 29 00:17:52.184000 audit[1]: SERVICE_STOP pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=systemd-vconsole-setup comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Oct 29 00:17:52.182151 systemd[1]: Stopped systemd-vconsole-setup.service - Virtual Console Setup. Oct 29 00:17:52.189556 systemd[1]: Starting systemd-vconsole-setup.service - Virtual Console Setup... Oct 29 00:17:52.198924 systemd-networkd[1248]: eth0: Configuring with /usr/lib/systemd/network/zz-default.network. Oct 29 00:17:52.201980 systemd-networkd[1248]: eth0: Link UP Oct 29 00:17:52.202091 systemd-networkd[1248]: eth0: Gained carrier Oct 29 00:17:52.209777 kernel: cryptd: max_cpu_qlen set to 1000 Oct 29 00:17:52.214704 kernel: hv_storvsc f8b3781a-1e82-4818-a1c3-63d806ec15bb: tag#233 cmd 0x85 status: scsi 0x2 srb 0x6 hv 0xc0000001 Oct 29 00:17:52.221259 systemd-networkd[1248]: eth0: DHCPv4 address 10.0.0.4/24, gateway 10.0.0.1 acquired from 168.63.129.16 Oct 29 00:17:52.235552 systemd-vconsole-setup[1337]: Configuration of first virtual console was skipped, ignoring remaining ones. Oct 29 00:17:52.236875 systemd[1]: Finished systemd-vconsole-setup.service - Virtual Console Setup. Oct 29 00:17:52.239000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=systemd-vconsole-setup comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Oct 29 00:17:52.247984 kernel: AES CTR mode by8 optimization enabled Oct 29 00:17:52.404781 kernel: nvme nvme0: using unchecked data buffer Oct 29 00:17:52.949595 systemd[1]: Found device dev-disk-by\x2dpartlabel-USR\x2dA.device - MSFT NVMe Accelerator v1.0 USR-A. Oct 29 00:17:52.951326 systemd[1]: Starting disk-uuid.service - Generate new UUID for disk GPT if necessary... Oct 29 00:17:53.046775 systemd[1]: Found device dev-disk-by\x2dlabel-EFI\x2dSYSTEM.device - MSFT NVMe Accelerator v1.0 EFI-SYSTEM. Oct 29 00:17:53.122224 systemd[1]: Found device dev-disk-by\x2dlabel-OEM.device - MSFT NVMe Accelerator v1.0 OEM. Oct 29 00:17:53.143047 systemd[1]: Mounting oem.mount - /oem... Oct 29 00:17:53.196093 kernel: hv_pci 00000001-7870-47b5-b203-907d12ca697e: PCI VMBus probing: Using version 0x10004 Oct 29 00:17:53.196350 kernel: hv_pci 00000001-7870-47b5-b203-907d12ca697e: PCI host bridge to bus 7870:00 Oct 29 00:17:53.198920 kernel: pci_bus 7870:00: root bus resource [mem 0xfc2000000-0xfc4007fff window] Oct 29 00:17:53.200529 kernel: pci_bus 7870:00: No busn resource found for root bus, will use [bus 00-ff] Oct 29 00:17:53.205851 kernel: pci 7870:00:00.0: [1414:00ba] type 00 class 0x020000 PCIe Endpoint Oct 29 00:17:53.209782 kernel: pci 7870:00:00.0: BAR 0 [mem 0xfc2000000-0xfc3ffffff 64bit pref] Oct 29 00:17:53.215299 kernel: pci 7870:00:00.0: BAR 4 [mem 0xfc4000000-0xfc4007fff 64bit pref] Oct 29 00:17:53.215360 kernel: pci 7870:00:00.0: enabling Extended Tags Oct 29 00:17:53.228905 kernel: pci_bus 7870:00: busn_res: [bus 00-ff] end is updated to 00 Oct 29 00:17:53.229133 kernel: pci 7870:00:00.0: BAR 0 [mem 0xfc2000000-0xfc3ffffff 64bit pref]: assigned Oct 29 00:17:53.232765 kernel: pci 7870:00:00.0: BAR 4 [mem 0xfc4000000-0xfc4007fff 64bit pref]: assigned Oct 29 00:17:53.304734 kernel: BTRFS: device label OEM devid 1 transid 11 /dev/nvme0n1p6 (259:5) scanned by mount (1455) Oct 29 00:17:53.308008 systemd[1]: Found device dev-disk-by\x2dlabel-ROOT.device - MSFT NVMe Accelerator v1.0 ROOT. Oct 29 00:17:53.316688 kernel: BTRFS info (device nvme0n1p6): first mount of filesystem c1a92d8f-fd69-41a6-b89b-07bf41b35e57 Oct 29 00:17:53.322719 kernel: BTRFS info (device nvme0n1p6): using crc32c (crc32c-intel) checksum algorithm Oct 29 00:17:53.333684 kernel: mana 7870:00:00.0: enabling device (0000 -> 0002) Oct 29 00:17:53.344690 kernel: mana 7870:00:00.0: Microsoft Azure Network Adapter protocol version: 0.1.1 Oct 29 00:17:53.349312 kernel: hv_netvsc f8615163-0000-1000-2000-7c1e528753a4 eth0: VF registering: eth1 Oct 29 00:17:53.349553 kernel: mana 7870:00:00.0 eth1: joined to eth0 Oct 29 00:17:53.358761 kernel: mana 7870:00:00.0 enP30832s1: renamed from eth1 Oct 29 00:17:53.358735 systemd-networkd[1248]: eth1: Interface name change detected, renamed to enP30832s1. Oct 29 00:17:53.458732 kernel: mana 7870:00:00.0 enP30832s1: Configured vPort 0 PD 18 DB 16 Oct 29 00:17:53.461499 systemd-networkd[1248]: enP30832s1: Link UP Oct 29 00:17:53.464032 systemd-networkd[1248]: enP30832s1: Gained carrier Oct 29 00:17:53.467747 kernel: mana 7870:00:00.0 enP30832s1: Configured steering vPort 0 entries 64 Oct 29 00:17:53.467933 kernel: hv_netvsc f8615163-0000-1000-2000-7c1e528753a4 eth0: Data path switched to VF: enP30832s1 Oct 29 00:17:53.656831 systemd-networkd[1248]: eth0: Gained IPv6LL Oct 29 00:17:54.020188 kernel: BTRFS info (device nvme0n1p6): enabling ssd optimizations Oct 29 00:17:54.020257 kernel: BTRFS info (device nvme0n1p6): turning on async discard Oct 29 00:17:54.021387 kernel: BTRFS info (device nvme0n1p6): enabling free space tree Oct 29 00:17:54.023118 systemd[1]: Mounted oem.mount - /oem. Oct 29 00:17:54.024580 systemd[1]: Starting ignition-fetch-offline.service - Ignition (fetch-offline)... Oct 29 00:17:54.033902 systemd[1]: Finished dracut-initqueue.service - dracut initqueue hook. Oct 29 00:17:54.036000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=dracut-initqueue comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Oct 29 00:17:54.037940 systemd[1]: Reached target remote-fs-pre.target - Preparation for Remote File Systems. Oct 29 00:17:54.044742 systemd[1]: Reached target remote-cryptsetup.target - Remote Encrypted Volumes. Oct 29 00:17:54.046077 systemd[1]: Reached target remote-fs.target - Remote File Systems. Oct 29 00:17:54.071204 systemd[1]: Starting dracut-pre-mount.service - dracut pre-mount hook... Oct 29 00:17:54.094795 systemd[1]: Finished dracut-pre-mount.service - dracut pre-mount hook. Oct 29 00:17:54.097000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=dracut-pre-mount comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Oct 29 00:17:55.322784 disk-uuid[1451]: Warning: The kernel is still using the old partition table. Oct 29 00:17:55.322784 disk-uuid[1451]: The new table will be used at the next reboot or after you Oct 29 00:17:55.322784 disk-uuid[1451]: run partprobe(8) or kpartx(8) Oct 29 00:17:55.322784 disk-uuid[1451]: The operation has completed successfully. Oct 29 00:17:55.692581 ignition[1489]: Ignition 2.27.0 Oct 29 00:17:55.692595 ignition[1489]: Stage: fetch-offline Oct 29 00:17:55.692724 ignition[1489]: no config dir at "/run/ignition/base.d" Oct 29 00:17:55.692738 ignition[1489]: no config dir at "/etc/ignition/base.d" Oct 29 00:17:55.693325 ignition[1489]: no config dir at "/usr/lib/ignition/base.d" Oct 29 00:17:55.701000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=ignition-fetch-offline comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Oct 29 00:17:55.698706 systemd[1]: Finished ignition-fetch-offline.service - Ignition (fetch-offline). Oct 29 00:17:55.693331 ignition[1489]: no configs found in "base.d" across system config directories Oct 29 00:17:55.706203 systemd[1]: Starting ignition-fetch.service - Ignition (fetch)... Oct 29 00:17:55.693345 ignition[1489]: no config dir at "/run/ignition/base.platform.d/azure" Oct 29 00:17:55.693351 ignition[1489]: no config dir at "/etc/ignition/base.platform.d/azure" Oct 29 00:17:55.693361 ignition[1489]: no config dir at "/usr/lib/ignition/base.platform.d/azure" Oct 29 00:17:55.693365 ignition[1489]: no configs found in "base.platform.d/azure" across system config directories Oct 29 00:17:55.694496 ignition[1489]: reading system config file "/run/ignition/user.ign" Oct 29 00:17:55.694504 ignition[1489]: no config at "/run/ignition/user.ign" Oct 29 00:17:55.694507 ignition[1489]: reading system config file "/etc/ignition/user.ign" Oct 29 00:17:55.694512 ignition[1489]: no config at "/etc/ignition/user.ign" Oct 29 00:17:55.694515 ignition[1489]: reading system config file "/usr/lib/ignition/user.ign" Oct 29 00:17:55.695611 ignition[1489]: no config at "/usr/lib/ignition/user.ign" Oct 29 00:17:55.695619 ignition[1489]: failed to fetch config: resource requires networking Oct 29 00:17:55.697412 ignition[1489]: Ignition finished successfully Oct 29 00:17:55.726394 ignition[1515]: Ignition 2.27.0 Oct 29 00:17:55.726401 ignition[1515]: Stage: fetch Oct 29 00:17:55.726687 ignition[1515]: no config dir at "/run/ignition/base.d" Oct 29 00:17:55.726693 ignition[1515]: no config dir at "/etc/ignition/base.d" Oct 29 00:17:55.726705 ignition[1515]: no config dir at "/usr/lib/ignition/base.d" Oct 29 00:17:55.726708 ignition[1515]: no configs found in "base.d" across system config directories Oct 29 00:17:55.726716 ignition[1515]: no config dir at "/run/ignition/base.platform.d/azure" Oct 29 00:17:55.726721 ignition[1515]: no config dir at "/etc/ignition/base.platform.d/azure" Oct 29 00:17:55.726726 ignition[1515]: no config dir at "/usr/lib/ignition/base.platform.d/azure" Oct 29 00:17:55.726729 ignition[1515]: no configs found in "base.platform.d/azure" across system config directories Oct 29 00:17:55.726846 ignition[1515]: reading system config file "/run/ignition/user.ign" Oct 29 00:17:55.726853 ignition[1515]: no config at "/run/ignition/user.ign" Oct 29 00:17:55.726856 ignition[1515]: reading system config file "/etc/ignition/user.ign" Oct 29 00:17:55.726861 ignition[1515]: no config at "/etc/ignition/user.ign" Oct 29 00:17:55.726865 ignition[1515]: reading system config file "/usr/lib/ignition/user.ign" Oct 29 00:17:55.726873 ignition[1515]: no config at "/usr/lib/ignition/user.ign" Oct 29 00:17:55.726890 ignition[1515]: GET http://169.254.169.254/metadata/instance/compute/userData?api-version=2021-01-01&format=text: attempt #1 Oct 29 00:17:55.795684 ignition[1515]: GET result: OK Oct 29 00:17:55.795787 ignition[1515]: config has been read from IMDS userdata Oct 29 00:17:55.796355 ignition[1515]: parsing config with SHA512: 5f78394a8d3230562a04f57b26a3352d2acb10d127e340f56d2a43ce6d4c68429c14a9995cdc8e58e48f93f43f0a6ca8ba7e5e2a386b88cf3230d9d21e40954b Oct 29 00:17:55.802976 unknown[1515]: fetched base config from "system" Oct 29 00:17:55.802989 unknown[1515]: fetched base config from "system" Oct 29 00:17:55.803209 ignition[1515]: fetch: fetch complete Oct 29 00:17:55.802994 unknown[1515]: fetched user config from "azure" Oct 29 00:17:55.803214 ignition[1515]: fetch: fetch passed Oct 29 00:17:55.807207 systemd[1]: Finished ignition-fetch.service - Ignition (fetch). Oct 29 00:17:55.811000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=ignition-fetch comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Oct 29 00:17:55.803253 ignition[1515]: Ignition finished successfully Oct 29 00:17:55.817614 systemd[1]: Starting ignition-kargs.service - Ignition (kargs)... Oct 29 00:17:55.833744 ignition[1523]: Ignition 2.27.0 Oct 29 00:17:55.833755 ignition[1523]: Stage: kargs Oct 29 00:17:55.837000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=ignition-kargs comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Oct 29 00:17:55.835906 systemd[1]: Finished ignition-kargs.service - Ignition (kargs). Oct 29 00:17:55.834037 ignition[1523]: no config dir at "/run/ignition/base.d" Oct 29 00:17:55.834044 ignition[1523]: no config dir at "/etc/ignition/base.d" Oct 29 00:17:55.834055 ignition[1523]: no config dir at "/usr/lib/ignition/base.d" Oct 29 00:17:55.834058 ignition[1523]: no configs found in "base.d" across system config directories Oct 29 00:17:55.834065 ignition[1523]: no config dir at "/run/ignition/base.platform.d/azure" Oct 29 00:17:55.834069 ignition[1523]: no config dir at "/etc/ignition/base.platform.d/azure" Oct 29 00:17:55.834075 ignition[1523]: no config dir at "/usr/lib/ignition/base.platform.d/azure" Oct 29 00:17:55.834078 ignition[1523]: no configs found in "base.platform.d/azure" across system config directories Oct 29 00:17:55.834723 ignition[1523]: kargs: kargs passed Oct 29 00:17:55.834761 ignition[1523]: Ignition finished successfully Oct 29 00:17:56.072468 systemd[1]: disk-uuid.service: Deactivated successfully. Oct 29 00:17:56.072000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=disk-uuid comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Oct 29 00:17:56.072000 audit[1]: SERVICE_STOP pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=disk-uuid comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Oct 29 00:17:56.072587 systemd[1]: Finished disk-uuid.service - Generate new UUID for disk GPT if necessary. Oct 29 00:17:56.077497 systemd[1]: Mounting boot.mount - Boot partition... Oct 29 00:17:56.085182 systemd[1]: Starting ignition-disks.service - Ignition (disks)... Oct 29 00:17:56.206126 systemd[1]: Mounted boot.mount - Boot partition. Oct 29 00:17:56.209361 systemd[1]: ignition-kargs.service: Deactivated successfully. Oct 29 00:17:56.210555 systemd[1]: Stopped ignition-kargs.service - Ignition (kargs). Oct 29 00:17:56.213000 audit[1]: SERVICE_STOP pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=ignition-kargs comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Oct 29 00:17:56.218776 kernel: kauditd_printk_skb: 21 callbacks suppressed Oct 29 00:17:56.214412 systemd[1]: ignition-fetch.service: Deactivated successfully. Oct 29 00:17:56.220868 kernel: audit: type=1131 audit(1793233076.213:33): pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=ignition-kargs comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Oct 29 00:17:56.219000 audit[1]: SERVICE_STOP pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=ignition-fetch comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Oct 29 00:17:56.214758 systemd[1]: Stopped ignition-fetch.service - Ignition (fetch). Oct 29 00:17:56.224000 audit[1]: SERVICE_STOP pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=ignition-fetch-offline comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Oct 29 00:17:56.228825 kernel: audit: type=1131 audit(1793233076.219:34): pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=ignition-fetch comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Oct 29 00:17:56.220761 systemd[1]: ignition-fetch-offline.service: Deactivated successfully. Oct 29 00:17:56.230197 kernel: audit: type=1131 audit(1793233076.224:35): pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=ignition-fetch-offline comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Oct 29 00:17:56.220852 systemd[1]: Stopped ignition-fetch-offline.service - Ignition (fetch-offline). Oct 29 00:17:56.229029 systemd[1]: Unmounting oem.mount - /oem... Oct 29 00:17:56.243696 kernel: BTRFS info (device nvme0n1p6): last unmount of filesystem c1a92d8f-fd69-41a6-b89b-07bf41b35e57 Oct 29 00:17:56.244400 systemd[1]: oem.mount: Deactivated successfully. Oct 29 00:17:56.245599 systemd[1]: Unmounted oem.mount - /oem. Oct 29 00:17:56.264696 ignition[1542]: Ignition 2.27.0 Oct 29 00:17:56.264709 ignition[1542]: Stage: disks Oct 29 00:17:56.264981 ignition[1542]: no config dir at "/run/ignition/base.d" Oct 29 00:17:56.264986 ignition[1542]: no config dir at "/etc/ignition/base.d" Oct 29 00:17:56.269000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=ignition-disks comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Oct 29 00:17:56.268543 systemd[1]: Finished ignition-disks.service - Ignition (disks). Oct 29 00:17:56.265001 ignition[1542]: no config dir at "/usr/lib/ignition/base.d" Oct 29 00:17:56.275967 kernel: audit: type=1130 audit(1793233076.269:36): pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=ignition-disks comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Oct 29 00:17:56.274955 systemd[1]: Reached target initrd-root-device.target - Initrd Root Device. Oct 29 00:17:56.265004 ignition[1542]: no configs found in "base.d" across system config directories Oct 29 00:17:56.265011 ignition[1542]: no config dir at "/run/ignition/base.platform.d/azure" Oct 29 00:17:56.265016 ignition[1542]: no config dir at "/etc/ignition/base.platform.d/azure" Oct 29 00:17:56.265021 ignition[1542]: no config dir at "/usr/lib/ignition/base.platform.d/azure" Oct 29 00:17:56.265024 ignition[1542]: no configs found in "base.platform.d/azure" across system config directories Oct 29 00:17:56.265997 ignition[1542]: disks: disks passed Oct 29 00:17:56.266048 ignition[1542]: Ignition finished successfully Oct 29 00:17:56.296505 systemd[1]: Reached target local-fs-pre.target - Preparation for Local File Systems. Oct 29 00:17:56.296582 systemd[1]: Reached target local-fs.target - Local File Systems. Oct 29 00:17:56.296724 systemd[1]: Reached target sysinit.target - System Initialization. Oct 29 00:17:56.302728 systemd[1]: Reached target basic.target - Basic System. Oct 29 00:17:56.308813 systemd[1]: Starting systemd-fsck-root.service - File System Check on /dev/disk/by-label/ROOT... Oct 29 00:17:56.549728 systemd-fsck[1551]: ROOT: clean, 15/6361680 files, 408771/6359552 blocks Oct 29 00:17:56.554777 systemd[1]: Finished systemd-fsck-root.service - File System Check on /dev/disk/by-label/ROOT. Oct 29 00:17:56.554000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=systemd-fsck-root comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Oct 29 00:17:56.561710 kernel: audit: type=1130 audit(1793233076.554:37): pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=systemd-fsck-root comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Oct 29 00:17:56.561910 systemd[1]: Mounting sysroot.mount - /sysroot... Oct 29 00:17:56.922724 kernel: EXT4-fs (nvme0n1p9): mounted filesystem e00046a2-7e78-459b-a21e-e25cf48059ad r/w with ordered data mode. Quota mode: none. Oct 29 00:17:56.923937 systemd[1]: Mounted sysroot.mount - /sysroot. Oct 29 00:17:56.926460 systemd[1]: Reached target initrd-root-fs.target - Initrd Root File System. Oct 29 00:17:56.957090 systemd[1]: Mounting sysroot-usr.mount - /sysroot/usr... Oct 29 00:17:56.960566 systemd[1]: Starting flatcar-metadata-hostname.service - Flatcar Metadata Hostname Agent... Oct 29 00:17:56.964380 systemd[1]: ignition-remount-sysroot.service - Remount /sysroot read-write for Ignition skipped, unmet condition check ConditionPathIsReadWrite=!/sysroot Oct 29 00:17:56.964431 systemd[1]: Reached target ignition-diskful.target - Ignition Boot Disk Setup. Oct 29 00:17:56.976923 systemd[1]: Mounted sysroot-usr.mount - /sysroot/usr. Oct 29 00:17:56.978628 systemd[1]: Starting initrd-setup-root.service - Root filesystem setup... Oct 29 00:17:58.611713 kernel: loop1: detected capacity change from 0 to 44465 Oct 29 00:17:58.658698 kernel: loop1: p1 p2 p3 Oct 29 00:17:58.886030 kernel: device-mapper: verity: sha256 using shash "sha256-ni" Oct 29 00:17:58.886097 kernel: device-mapper: verity: Unrecognized verity feature request: root_hash_sig_key_desc Oct 29 00:17:58.887345 kernel: device-mapper: table: 254:1: verity: Unrecognized verity feature request (-EINVAL) Oct 29 00:17:58.888938 kernel: device-mapper: ioctl: error adding target to table Oct 29 00:17:58.888987 systemd-confext[1637]: device-mapper: reload ioctl on loop1p1-14-verity (254:1) failed: Invalid argument Oct 29 00:17:58.897693 kernel: device-mapper: verity: sha256 using shash "sha256-ni" Oct 29 00:17:59.114742 kernel: erofs: (device dm-1): mounted with root inode @ nid 40. Oct 29 00:17:59.128695 kernel: loop2: detected capacity change from 0 to 44465 Oct 29 00:17:59.139865 kernel: loop2: p1 p2 p3 Oct 29 00:17:59.146698 kernel: device-mapper: verity: sha256 using shash "sha256-ni" Oct 29 00:17:59.150742 kernel: device-mapper: verity: Unrecognized verity feature request: root_hash_sig_key_desc Oct 29 00:17:59.150781 kernel: device-mapper: table: 254:1: verity: Unrecognized verity feature request (-EINVAL) Oct 29 00:17:59.153789 kernel: device-mapper: ioctl: error adding target to table Oct 29 00:17:59.154459 (sd-merge)[1648]: device-mapper: reload ioctl on loop2p1-18-verity (254:1) failed: Invalid argument Oct 29 00:17:59.161718 kernel: device-mapper: verity: sha256 using shash "sha256-ni" Oct 29 00:17:59.179231 (sd-merge)[1648]: Using extensions '00-flatcar-default.raw'. Oct 29 00:17:59.181160 (sd-merge)[1648]: Merged extensions into '/sysroot/etc'. Oct 29 00:17:59.184353 kernel: erofs: (device dm-1): mounted with root inode @ nid 40. Oct 29 00:17:59.186240 initrd-setup-root[1656]: /etc 00-flatcar-default Thu 2026-10-29 00:17:51 UTC Oct 29 00:17:59.188152 systemd[1]: Finished initrd-setup-root.service - Root filesystem setup. Oct 29 00:17:59.189000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=initrd-setup-root comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Oct 29 00:17:59.193729 kernel: audit: type=1130 audit(1793233079.189:38): pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=initrd-setup-root comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Oct 29 00:17:59.193842 systemd[1]: Starting ignition-mount.service - Ignition (mount)... Oct 29 00:17:59.225730 ignition[1660]: INFO : Ignition 2.27.0 Oct 29 00:17:59.225730 ignition[1660]: INFO : Stage: mount Oct 29 00:17:59.230628 ignition[1660]: INFO : no config dir at "/run/ignition/base.d" Oct 29 00:17:59.230628 ignition[1660]: INFO : no config dir at "/etc/ignition/base.d" Oct 29 00:17:59.230628 ignition[1660]: INFO : no config dir at "/usr/lib/ignition/base.d" Oct 29 00:17:59.230628 ignition[1660]: INFO : no configs found in "base.d" across system config directories Oct 29 00:17:59.230628 ignition[1660]: INFO : no config dir at "/run/ignition/base.platform.d/azure" Oct 29 00:17:59.230628 ignition[1660]: INFO : no config dir at "/etc/ignition/base.platform.d/azure" Oct 29 00:17:59.230628 ignition[1660]: INFO : no config dir at "/usr/lib/ignition/base.platform.d/azure" Oct 29 00:17:59.230628 ignition[1660]: INFO : no configs found in "base.platform.d/azure" across system config directories Oct 29 00:17:59.230628 ignition[1660]: INFO : mount: mount passed Oct 29 00:17:59.230628 ignition[1660]: INFO : Ignition finished successfully Oct 29 00:17:59.230000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=ignition-mount comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Oct 29 00:17:59.227990 systemd[1]: Finished ignition-mount.service - Ignition (mount). Oct 29 00:17:59.259717 kernel: audit: type=1130 audit(1793233079.230:39): pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=ignition-mount comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Oct 29 00:18:26.503195 coreos-metadata[1561]: Oct 29 00:18:26.502 WARN Failed to get fabric address from DHCP: maximum number of retries (60) reached Oct 29 00:18:26.503195 coreos-metadata[1561]: Oct 29 00:18:26.503 INFO using fallback address Oct 29 00:18:26.515139 coreos-metadata[1561]: Oct 29 00:18:26.515 INFO Fetching http://168.63.129.16/?comp=versions: Attempt #1 Oct 29 00:18:26.518781 coreos-metadata[1561]: Oct 29 00:18:26.517 INFO Fetch successful Oct 29 00:18:26.518781 coreos-metadata[1561]: Oct 29 00:18:26.517 INFO Fetching http://169.254.169.254/metadata/instance/compute/name?api-version=2017-08-01&format=text: Attempt #1 Oct 29 00:18:26.530301 coreos-metadata[1561]: Oct 29 00:18:26.530 INFO Fetch successful Oct 29 00:18:26.532785 coreos-metadata[1561]: Oct 29 00:18:26.530 INFO wrote hostname ci-4820.1.0-n-75d75734f8 to /sysroot/etc/hostname Oct 29 00:18:26.533687 systemd[1]: Finished flatcar-metadata-hostname.service - Flatcar Metadata Hostname Agent. Oct 29 00:18:26.537000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=flatcar-metadata-hostname comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Oct 29 00:18:26.545794 systemd[1]: Starting ignition-files.service - Ignition (files)... Oct 29 00:18:26.549749 kernel: audit: type=1130 audit(1793233106.537:40): pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=flatcar-metadata-hostname comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Oct 29 00:18:26.560814 systemd[1]: Mounting oem.mount - /oem... Oct 29 00:18:26.575689 kernel: BTRFS: device label OEM devid 1 transid 11 /dev/nvme0n1p6 (259:5) scanned by mount (1725) Oct 29 00:18:26.578852 kernel: BTRFS info (device nvme0n1p6): first mount of filesystem c1a92d8f-fd69-41a6-b89b-07bf41b35e57 Oct 29 00:18:26.578896 kernel: BTRFS info (device nvme0n1p6): using crc32c (crc32c-intel) checksum algorithm Oct 29 00:18:26.587080 kernel: BTRFS info (device nvme0n1p6): enabling ssd optimizations Oct 29 00:18:26.587185 kernel: BTRFS info (device nvme0n1p6): turning on async discard Oct 29 00:18:26.588149 kernel: BTRFS info (device nvme0n1p6): enabling free space tree Oct 29 00:18:26.590483 systemd[1]: Mounted oem.mount - /oem. Oct 29 00:18:26.593011 systemd[1]: Mounting sysroot-oem.mount - /sysroot/oem... Oct 29 00:18:26.606566 systemd[1]: Mounted sysroot-oem.mount - /sysroot/oem. Oct 29 00:18:26.626892 ignition[1743]: INFO : Ignition 2.27.0 Oct 29 00:18:26.626892 ignition[1743]: INFO : Stage: files Oct 29 00:18:26.631828 ignition[1743]: INFO : no config dir at "/run/ignition/base.d" Oct 29 00:18:26.631828 ignition[1743]: INFO : no config dir at "/etc/ignition/base.d" Oct 29 00:18:26.631828 ignition[1743]: INFO : no config dir at "/usr/lib/ignition/base.d" Oct 29 00:18:26.631828 ignition[1743]: INFO : no configs found in "base.d" across system config directories Oct 29 00:18:26.631828 ignition[1743]: INFO : no config dir at "/run/ignition/base.platform.d/azure" Oct 29 00:18:26.631828 ignition[1743]: INFO : no config dir at "/etc/ignition/base.platform.d/azure" Oct 29 00:18:26.631828 ignition[1743]: INFO : no config dir at "/usr/lib/ignition/base.platform.d/azure" Oct 29 00:18:26.631828 ignition[1743]: INFO : no configs found in "base.platform.d/azure" across system config directories Oct 29 00:18:26.631828 ignition[1743]: DEBUG : files: compiled without relabeling support, skipping Oct 29 00:18:26.659727 ignition[1743]: INFO : files: ensureUsers: op(1): [started] creating or modifying user "core" Oct 29 00:18:26.659727 ignition[1743]: DEBUG : files: ensureUsers: op(1): executing: "usermod" "--root" "/sysroot" "core" Oct 29 00:18:26.659727 ignition[1743]: INFO : files: ensureUsers: op(1): [finished] creating or modifying user "core" Oct 29 00:18:26.659727 ignition[1743]: INFO : files: ensureUsers: op(2): [started] adding ssh keys to user "core" Oct 29 00:18:26.659727 ignition[1743]: INFO : files: ensureUsers: op(2): [finished] adding ssh keys to user "core" Oct 29 00:18:26.659727 ignition[1743]: INFO : files: createFilesystemsFiles: createFiles: op(3): [started] writing file "/sysroot/etc/sysctl.d/80-swappiness.conf" Oct 29 00:18:26.659727 ignition[1743]: INFO : files: createFilesystemsFiles: createFiles: op(3): [finished] writing file "/sysroot/etc/sysctl.d/80-swappiness.conf" Oct 29 00:18:26.659727 ignition[1743]: INFO : files: createFilesystemsFiles: createFiles: op(4): [started] writing file "/sysroot/etc/flatcar/update.conf" Oct 29 00:18:26.659727 ignition[1743]: INFO : files: createFilesystemsFiles: createFiles: op(4): [finished] writing file "/sysroot/etc/flatcar/update.conf" Oct 29 00:18:26.659727 ignition[1743]: INFO : files: op(5): [started] processing unit "var-vm-swapfile1.swap" Oct 29 00:18:26.681000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=ignition-files comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Oct 29 00:18:26.653214 unknown[1743]: wrote ssh authorized keys file for user: core Oct 29 00:18:26.693788 ignition[1743]: INFO : files: op(5): op(6): [started] writing unit "var-vm-swapfile1.swap" at "/sysroot/etc/systemd/system/var-vm-swapfile1.swap" Oct 29 00:18:26.693788 ignition[1743]: INFO : files: op(5): op(6): [finished] writing unit "var-vm-swapfile1.swap" at "/sysroot/etc/systemd/system/var-vm-swapfile1.swap" Oct 29 00:18:26.693788 ignition[1743]: INFO : files: op(5): [finished] processing unit "var-vm-swapfile1.swap" Oct 29 00:18:26.693788 ignition[1743]: INFO : files: op(7): [started] processing unit "create-swapfile.service" Oct 29 00:18:26.693788 ignition[1743]: INFO : files: op(7): op(8): [started] writing unit "create-swapfile.service" at "/sysroot/etc/systemd/system/create-swapfile.service" Oct 29 00:18:26.693788 ignition[1743]: INFO : files: op(7): op(8): [finished] writing unit "create-swapfile.service" at "/sysroot/etc/systemd/system/create-swapfile.service" Oct 29 00:18:26.693788 ignition[1743]: INFO : files: op(7): [finished] processing unit "create-swapfile.service" Oct 29 00:18:26.693788 ignition[1743]: INFO : files: op(9): [started] setting preset to enabled for "var-vm-swapfile1.swap" Oct 29 00:18:26.693788 ignition[1743]: INFO : files: op(9): [finished] setting preset to enabled for "var-vm-swapfile1.swap" Oct 29 00:18:26.693788 ignition[1743]: INFO : files: createResultFile: createFiles: op(a): [started] writing file "/sysroot/etc/.ignition-result.json" Oct 29 00:18:26.693788 ignition[1743]: INFO : files: createResultFile: createFiles: op(a): [finished] writing file "/sysroot/etc/.ignition-result.json" Oct 29 00:18:26.693788 ignition[1743]: INFO : files: files passed Oct 29 00:18:26.693788 ignition[1743]: INFO : Ignition finished successfully Oct 29 00:18:26.704000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=ignition-quench comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Oct 29 00:18:26.704000 audit[1]: SERVICE_STOP pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=ignition-quench comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Oct 29 00:18:26.681203 systemd[1]: Finished ignition-files.service - Ignition (files). Oct 29 00:18:26.750750 kernel: audit: type=1130 audit(1793233106.681:41): pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=ignition-files comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Oct 29 00:18:26.684047 systemd[1]: Starting ignition-quench.service - Ignition (record completion)... Oct 29 00:18:26.752100 kernel: audit: type=1130 audit(1793233106.704:42): pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=ignition-quench comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Oct 29 00:18:26.693767 systemd[1]: Starting initrd-setup-root-after-ignition.service - Root filesystem completion... Oct 29 00:18:26.755040 kernel: audit: type=1131 audit(1793233106.704:43): pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=ignition-quench comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Oct 29 00:18:26.700272 systemd[1]: ignition-quench.service: Deactivated successfully. Oct 29 00:18:26.760742 kernel: loop3: detected capacity change from 0 to 44465 Oct 29 00:18:26.760764 initrd-setup-root-after-ignition[1775]: grep: /sysroot/etc/flatcar/enabled-sysext.conf: No such file or directory Oct 29 00:18:26.760764 initrd-setup-root-after-ignition[1775]: grep: /sysroot/usr/share/flatcar/enabled-sysext.conf: No such file or directory Oct 29 00:18:26.701818 systemd[1]: Finished ignition-quench.service - Ignition (record completion). Oct 29 00:18:26.774789 kernel: loop3: p1 p2 p3 Oct 29 00:18:26.774811 initrd-setup-root-after-ignition[1779]: grep: /sysroot/etc/flatcar/enabled-sysext.conf: No such file or directory Oct 29 00:18:26.770499 systemd-confext[1781]: device-mapper: reload ioctl on loop3p1-21-verity (254:2) failed: Invalid argument Oct 29 00:18:26.782791 kernel: device-mapper: verity: sha256 using shash "sha256-ni" Oct 29 00:18:26.782812 kernel: device-mapper: verity: Unrecognized verity feature request: root_hash_sig_key_desc Oct 29 00:18:26.782824 kernel: device-mapper: table: 254:2: verity: Unrecognized verity feature request (-EINVAL) Oct 29 00:18:26.782836 kernel: device-mapper: ioctl: error adding target to table Oct 29 00:18:26.782848 kernel: device-mapper: verity: sha256 using shash "sha256-ni" Oct 29 00:18:26.797692 kernel: erofs: (device dm-2): mounted with root inode @ nid 40. Oct 29 00:18:26.819689 kernel: loop4: detected capacity change from 0 to 44465 Oct 29 00:18:26.826704 kernel: loop4: p1 p2 p3 Oct 29 00:18:26.833466 kernel: device-mapper: verity: sha256 using shash "sha256-ni" Oct 29 00:18:26.833499 kernel: device-mapper: verity: Unrecognized verity feature request: root_hash_sig_key_desc Oct 29 00:18:26.838810 kernel: device-mapper: table: 254:2: verity: Unrecognized verity feature request (-EINVAL) Oct 29 00:18:26.838843 kernel: device-mapper: ioctl: error adding target to table Oct 29 00:18:26.839720 (sd-merge)[1794]: device-mapper: reload ioctl on loop4p1-25-verity (254:2) failed: Invalid argument Oct 29 00:18:26.844707 kernel: device-mapper: verity: sha256 using shash "sha256-ni" Oct 29 00:18:26.861518 (sd-merge)[1794]: Skipping extension refresh because no change was found, use --always-refresh=yes to always do a refresh. Oct 29 00:18:26.864776 kernel: erofs: (device dm-2): mounted with root inode @ nid 40. Oct 29 00:18:26.869693 kernel: loop5: detected capacity change from 0 to 169096 Oct 29 00:18:26.949943 kernel: loop5: p1 p2 p3 Oct 29 00:18:27.046615 kernel: device-mapper: verity: sha256 using shash "sha256-ni" Oct 29 00:18:27.046667 kernel: device-mapper: verity: Unrecognized verity feature request: root_hash_sig_key_desc Oct 29 00:18:27.048597 kernel: device-mapper: table: 254:2: verity: Unrecognized verity feature request (-EINVAL) Oct 29 00:18:27.050156 kernel: device-mapper: ioctl: error adding target to table Oct 29 00:18:27.050191 systemd-sysext[1802]: device-mapper: reload ioctl on loop5p1-28-verity (254:2) failed: Invalid argument Oct 29 00:18:27.054730 kernel: device-mapper: verity: sha256 using shash "sha256-ni" Oct 29 00:18:27.669690 kernel: erofs: (device dm-2): mounted with root inode @ nid 39. Oct 29 00:18:27.729693 kernel: loop4: detected capacity change from 0 to 135808 Oct 29 00:18:27.770711 kernel: loop4: p1 p2 p3 Oct 29 00:18:27.810921 kernel: device-mapper: verity: sha256 using shash "sha256-ni" Oct 29 00:18:27.811034 kernel: device-mapper: verity: Unrecognized verity feature request: root_hash_sig_key_desc Oct 29 00:18:27.812107 kernel: device-mapper: table: 254:2: verity: Unrecognized verity feature request (-EINVAL) Oct 29 00:18:27.813166 kernel: device-mapper: ioctl: error adding target to table Oct 29 00:18:27.813602 systemd-sysext[1802]: device-mapper: reload ioctl on loop4p1-33-verity (254:2) failed: Invalid argument Oct 29 00:18:27.817773 kernel: device-mapper: verity: sha256 using shash "sha256-ni" Oct 29 00:18:28.126716 kernel: erofs: (device dm-2): mounted with root inode @ nid 39. Oct 29 00:18:28.155720 kernel: loop6: detected capacity change from 0 to 431960 Oct 29 00:18:28.232696 kernel: loop6: p1 p2 p3 Oct 29 00:18:28.355807 kernel: device-mapper: verity: sha256 using shash "sha256-ni" Oct 29 00:18:28.355930 kernel: device-mapper: verity: Unrecognized verity feature request: root_hash_sig_key_desc Oct 29 00:18:28.357300 kernel: device-mapper: table: 254:2: verity: Unrecognized verity feature request (-EINVAL) Oct 29 00:18:28.358815 kernel: device-mapper: ioctl: error adding target to table Oct 29 00:18:28.358840 systemd-sysext[1802]: device-mapper: reload ioctl on loop6p1-37-verity (254:2) failed: Invalid argument Oct 29 00:18:28.361715 kernel: device-mapper: verity: sha256 using shash "sha256-ni" Oct 29 00:18:28.671738 kernel: erofs: (device dm-2): mounted with root inode @ nid 39. Oct 29 00:18:28.762694 kernel: loop7: detected capacity change from 0 to 169096 Oct 29 00:18:28.784707 kernel: loop7: p1 p2 p3 Oct 29 00:18:28.790855 kernel: device-mapper: verity: sha256 using shash "sha256-ni" Oct 29 00:18:28.790894 kernel: device-mapper: verity: Unrecognized verity feature request: root_hash_sig_key_desc Oct 29 00:18:28.792958 kernel: device-mapper: table: 254:2: verity: Unrecognized verity feature request (-EINVAL) Oct 29 00:18:28.796417 (sd-merge)[1825]: device-mapper: reload ioctl on loop7p1-41-verity (254:2) failed: Invalid argument Oct 29 00:18:28.802819 kernel: device-mapper: ioctl: error adding target to table Oct 29 00:18:28.802839 kernel: device-mapper: verity: sha256 using shash "sha256-ni" Oct 29 00:18:28.839697 kernel: erofs: (device dm-2): mounted with root inode @ nid 39. Oct 29 00:18:28.841709 kernel: loop1: detected capacity change from 0 to 135808 Oct 29 00:18:28.854327 kernel: loop1: p1 p2 p3 Oct 29 00:18:28.860421 kernel: device-mapper: verity: sha256 using shash "sha256-ni" Oct 29 00:18:28.860458 kernel: device-mapper: verity: Unrecognized verity feature request: root_hash_sig_key_desc Oct 29 00:18:28.862479 kernel: device-mapper: table: 254:3: verity: Unrecognized verity feature request (-EINVAL) Oct 29 00:18:28.865691 kernel: device-mapper: ioctl: error adding target to table Oct 29 00:18:28.866900 (sd-merge)[1825]: device-mapper: reload ioctl on loop1p1-45-verity (254:3) failed: Invalid argument Oct 29 00:18:28.876701 kernel: device-mapper: verity: sha256 using shash "sha256-ni" Oct 29 00:18:28.922369 kernel: erofs: (device dm-3): mounted with root inode @ nid 39. Oct 29 00:18:28.922404 kernel: loop3: detected capacity change from 0 to 431960 Oct 29 00:18:28.933687 kernel: loop3: p1 p2 p3 Oct 29 00:18:28.938297 kernel: device-mapper: verity: sha256 using shash "sha256-ni" Oct 29 00:18:28.938336 kernel: device-mapper: verity: Unrecognized verity feature request: root_hash_sig_key_desc Oct 29 00:18:28.942692 kernel: device-mapper: table: 254:4: verity: Unrecognized verity feature request (-EINVAL) Oct 29 00:18:28.942728 kernel: device-mapper: ioctl: error adding target to table Oct 29 00:18:28.943331 (sd-merge)[1825]: device-mapper: reload ioctl on loop3p1-49-verity (254:4) failed: Invalid argument Oct 29 00:18:28.947690 kernel: device-mapper: verity: sha256 using shash "sha256-ni" Oct 29 00:18:29.000691 kernel: erofs: (device dm-4): mounted with root inode @ nid 39. Oct 29 00:18:29.001802 (sd-merge)[1825]: Using extensions 'containerd-flatcar.raw', 'docker-flatcar.raw', 'oem-azure-4820.1.0+nightly-20261028-2100.raw'. Oct 29 00:18:29.004276 (sd-merge)[1825]: Merged extensions into '/sysroot/usr'. Oct 29 00:18:29.006964 systemd[1]: Finished initrd-setup-root-after-ignition.service - Root filesystem completion. Oct 29 00:18:29.006000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=initrd-setup-root-after-ignition comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Oct 29 00:18:29.013839 kernel: audit: type=1130 audit(1793233109.006:44): pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=initrd-setup-root-after-ignition comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Oct 29 00:18:29.012135 systemd[1]: Starting initrd-parse-etc.service - Mountpoints Configured in the Real Root... Oct 29 00:18:29.039817 systemd[1]: initrd-parse-etc.service: Deactivated successfully. Oct 29 00:18:29.039930 systemd[1]: Finished initrd-parse-etc.service - Mountpoints Configured in the Real Root. Oct 29 00:18:29.040000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=initrd-parse-etc comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Oct 29 00:18:29.042324 systemd[1]: initrd-parse-etc.service: Triggering OnSuccess= dependencies. Oct 29 00:18:29.040000 audit[1]: SERVICE_STOP pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=initrd-parse-etc comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Oct 29 00:18:29.051849 kernel: audit: type=1130 audit(1793233109.040:45): pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=initrd-parse-etc comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Oct 29 00:18:29.042512 systemd[1]: Reached target initrd-fs.target - Initrd File Systems. Oct 29 00:18:29.054754 kernel: audit: type=1131 audit(1793233109.040:46): pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=initrd-parse-etc comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Oct 29 00:18:29.050860 systemd[1]: Starting dracut-mount.service - dracut mount hook... Oct 29 00:18:29.386840 systemd[1]: Finished dracut-mount.service - dracut mount hook. Oct 29 00:18:29.388000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=dracut-mount comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Oct 29 00:18:29.391746 systemd[1]: Starting dracut-pre-pivot.service - dracut pre-pivot and cleanup hook... Oct 29 00:18:29.399867 kernel: audit: type=1130 audit(1793233109.388:47): pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=dracut-mount comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Oct 29 00:18:29.412747 systemd[1]: Finished dracut-pre-pivot.service - dracut pre-pivot and cleanup hook. Oct 29 00:18:29.416000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=dracut-pre-pivot comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Oct 29 00:18:29.419808 systemd[1]: Starting initrd-cleanup.service - Cleaning Up and Shutting Down Daemons... Oct 29 00:18:29.427822 kernel: audit: type=1130 audit(1793233109.416:48): pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=dracut-pre-pivot comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Oct 29 00:18:29.437088 systemd[1]: Stopped target basic.target - Basic System. Oct 29 00:18:29.438271 systemd[1]: Stopped target ignition-diskful.target - Ignition Boot Disk Setup. Oct 29 00:18:29.441469 systemd[1]: Stopped target initrd-root-device.target - Initrd Root Device. Oct 29 00:18:29.453796 systemd[1]: Stopped target initrd-usr-fs.target - Initrd /usr File System. Oct 29 00:18:29.454615 systemd[1]: Stopped target nss-lookup.target - Host and Network Name Lookups. Oct 29 00:18:29.456545 systemd[1]: Stopped target paths.target - Path Units. Oct 29 00:18:29.459951 systemd[1]: Stopped target remote-cryptsetup.target - Remote Encrypted Volumes. Oct 29 00:18:29.463475 systemd[1]: Stopped target slices.target - Slice Units. Oct 29 00:18:29.467186 systemd[1]: Stopped target sockets.target - Socket Units. Oct 29 00:18:29.469928 systemd[1]: Stopped target sysinit.target - System Initialization. Oct 29 00:18:29.472976 systemd[1]: Stopped target local-fs.target - Local File Systems. Oct 29 00:18:29.475115 systemd[1]: Stopped target local-fs-pre.target - Preparation for Local File Systems. Oct 29 00:18:29.478927 systemd[1]: Stopped target swap.target - Swaps. Oct 29 00:18:29.484271 systemd[1]: Stopped target timers.target - Timer Units. Oct 29 00:18:29.488156 systemd[1]: iscsid.socket: Deactivated successfully. Oct 29 00:18:29.488261 systemd[1]: Closed iscsid.socket - Open-iSCSI iscsid Socket. Oct 29 00:18:29.493798 systemd[1]: iscsiuio.socket: Deactivated successfully. Oct 29 00:18:29.494116 systemd[1]: Closed iscsiuio.socket - Open-iSCSI iscsiuio Socket. Oct 29 00:18:29.496041 systemd[1]: systemd-coredump.socket: Deactivated successfully. Oct 29 00:18:29.496197 systemd[1]: Closed systemd-coredump.socket - Process Core Dump Socket. Oct 29 00:18:29.501090 systemd[1]: systemd-journald-audit.socket: Deactivated successfully. Oct 29 00:18:29.505000 audit[1]: SERVICE_STOP pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=dracut-pre-pivot comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Oct 29 00:18:29.501157 systemd[1]: Closed systemd-journald-audit.socket - Journal Audit Socket. Oct 29 00:18:29.503103 systemd[1]: dracut-pre-pivot.service: Deactivated successfully. Oct 29 00:18:29.503193 systemd[1]: Stopped dracut-pre-pivot.service - dracut pre-pivot and cleanup hook. Oct 29 00:18:29.507211 systemd[1]: Stopped target remote-fs.target - Remote File Systems. Oct 29 00:18:29.515768 kernel: audit: type=1131 audit(1793233109.505:49): pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=dracut-pre-pivot comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Oct 29 00:18:29.519708 systemd[1]: Stopped target remote-fs-pre.target - Preparation for Remote File Systems. Oct 29 00:18:29.519917 systemd[1]: dracut-mount.service: Deactivated successfully. Oct 29 00:18:29.522000 audit[1]: SERVICE_STOP pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=dracut-mount comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Oct 29 00:18:29.520018 systemd[1]: Stopped dracut-mount.service - dracut mount hook. Oct 29 00:18:29.525000 audit[1]: SERVICE_STOP pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=dracut-pre-mount comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Oct 29 00:18:29.524137 systemd[1]: dracut-pre-mount.service: Deactivated successfully. Oct 29 00:18:29.524227 systemd[1]: Stopped dracut-pre-mount.service - dracut pre-mount hook. Oct 29 00:18:29.527161 systemd[1]: Stopped target cryptsetup.target - Local Encrypted Volumes. Oct 29 00:18:29.530150 systemd[1]: systemd-ask-password-console.path: Deactivated successfully. Oct 29 00:18:29.530473 systemd[1]: Stopped systemd-ask-password-console.path - Dispatch Password Requests to Console Directory Watch. Oct 29 00:18:29.546000 audit[1]: SERVICE_STOP pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=dracut-initqueue comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Oct 29 00:18:29.533392 systemd[1]: Stopped target cryptsetup-pre.target - Local Encrypted Volumes (Pre). Oct 29 00:18:29.547000 audit[1]: SERVICE_STOP pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=initrd-setup-root-after-ignition comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Oct 29 00:18:29.536981 systemd[1]: clevis-luks-askpass.path: Deactivated successfully. Oct 29 00:18:29.553000 audit[1]: SERVICE_STOP pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=ignition-files comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Oct 29 00:18:29.537292 systemd[1]: Stopped clevis-luks-askpass.path - Forward Password Requests to Clevis Directory Watch. Oct 29 00:18:29.555000 audit[1]: SERVICE_STOP pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=flatcar-metadata-hostname comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Oct 29 00:18:29.541598 systemd[1]: dracut-initqueue.service: Deactivated successfully. Oct 29 00:18:29.542232 systemd[1]: Stopped dracut-initqueue.service - dracut initqueue hook. Oct 29 00:18:29.547345 systemd[1]: initrd-setup-root-after-ignition.service: Deactivated successfully. Oct 29 00:18:29.566000 audit[1]: SERVICE_STOP pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=systemd-modules-load comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Oct 29 00:18:29.547442 systemd[1]: Stopped initrd-setup-root-after-ignition.service - Root filesystem completion. Oct 29 00:18:29.549605 systemd[1]: ignition-files.service: Deactivated successfully. Oct 29 00:18:29.569000 audit[1]: SERVICE_STOP pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=systemd-tmpfiles-setup comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Oct 29 00:18:29.577103 ignition[1867]: INFO : Ignition 2.27.0 Oct 29 00:18:29.577103 ignition[1867]: INFO : Stage: umount Oct 29 00:18:29.577103 ignition[1867]: INFO : no config dir at "/run/ignition/base.d" Oct 29 00:18:29.577103 ignition[1867]: INFO : no config dir at "/etc/ignition/base.d" Oct 29 00:18:29.577103 ignition[1867]: INFO : no config dir at "/usr/lib/ignition/base.d" Oct 29 00:18:29.577103 ignition[1867]: INFO : no configs found in "base.d" across system config directories Oct 29 00:18:29.577103 ignition[1867]: INFO : no config dir at "/run/ignition/base.platform.d/azure" Oct 29 00:18:29.577103 ignition[1867]: INFO : no config dir at "/etc/ignition/base.platform.d/azure" Oct 29 00:18:29.577103 ignition[1867]: INFO : no config dir at "/usr/lib/ignition/base.platform.d/azure" Oct 29 00:18:29.577103 ignition[1867]: INFO : no configs found in "base.platform.d/azure" across system config directories Oct 29 00:18:29.577103 ignition[1867]: INFO : umount: umount passed Oct 29 00:18:29.577103 ignition[1867]: INFO : Ignition finished successfully Oct 29 00:18:29.578000 audit[1]: SERVICE_STOP pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=systemd-udev-trigger comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Oct 29 00:18:29.580000 audit[1]: SERVICE_STOP pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=dracut-pre-trigger comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Oct 29 00:18:29.585000 audit[1]: SERVICE_STOP pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=ignition-mount comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Oct 29 00:18:29.592000 audit[1]: SERVICE_STOP pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=ignition-disks comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Oct 29 00:18:29.594000 audit[1]: SERVICE_STOP pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=ignition-setup-pre comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Oct 29 00:18:29.603000 audit[1]: SERVICE_STOP pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=initrd-setup-root comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Oct 29 00:18:29.549717 systemd[1]: Stopped ignition-files.service - Ignition (files). Oct 29 00:18:29.554870 systemd[1]: flatcar-metadata-hostname.service: Deactivated successfully. Oct 29 00:18:29.554971 systemd[1]: Stopped flatcar-metadata-hostname.service - Flatcar Metadata Hostname Agent. Oct 29 00:18:29.558870 systemd[1]: Stopping ignition-mount.service - Ignition (mount)... Oct 29 00:18:29.615000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=initrd-cleanup comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Oct 29 00:18:29.615000 audit[1]: SERVICE_STOP pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=initrd-cleanup comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Oct 29 00:18:29.563491 systemd[1]: systemd-modules-load.service: Deactivated successfully. Oct 29 00:18:29.619000 audit[1]: SERVICE_STOP pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=systemd-networkd comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Oct 29 00:18:29.563620 systemd[1]: Stopped systemd-modules-load.service - Load Kernel Modules. Oct 29 00:18:29.567980 systemd[1]: systemd-tmpfiles-setup.service: Deactivated successfully. Oct 29 00:18:29.568078 systemd[1]: Stopped systemd-tmpfiles-setup.service - Create System Files and Directories. Oct 29 00:18:29.572085 systemd[1]: systemd-udev-trigger.service: Deactivated successfully. Oct 29 00:18:29.573076 systemd[1]: Stopped systemd-udev-trigger.service - Coldplug All udev Devices. Oct 29 00:18:29.580460 systemd[1]: dracut-pre-trigger.service: Deactivated successfully. Oct 29 00:18:29.580598 systemd[1]: Stopped dracut-pre-trigger.service - dracut pre-trigger hook. Oct 29 00:18:29.586173 systemd[1]: ignition-mount.service: Deactivated successfully. Oct 29 00:18:29.586258 systemd[1]: Stopped ignition-mount.service - Ignition (mount). Oct 29 00:18:29.588214 systemd[1]: Stopped target network.target - Network. Oct 29 00:18:29.651000 audit[1]: SERVICE_STOP pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=systemd-resolved comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Oct 29 00:18:29.589932 systemd[1]: ignition-disks.service: Deactivated successfully. Oct 29 00:18:29.654000 audit: BPF prog-id=5 op=UNLOAD Oct 29 00:18:29.589965 systemd[1]: Stopped ignition-disks.service - Ignition (disks). Oct 29 00:18:29.593896 systemd[1]: ignition-setup-pre.service: Deactivated successfully. Oct 29 00:18:29.663000 audit[1]: SERVICE_STOP pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=systemd-udevd comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Oct 29 00:18:29.594221 systemd[1]: Stopped ignition-setup-pre.service - Ignition env setup. Oct 29 00:18:29.596891 systemd[1]: initrd-setup-root.service: Deactivated successfully. Oct 29 00:18:29.597080 systemd[1]: Stopped initrd-setup-root.service - Root filesystem setup. Oct 29 00:18:29.605002 systemd-networkd[1248]: eth0: DHCP lease lost Oct 29 00:18:29.676000 audit: BPF prog-id=8 op=UNLOAD Oct 29 00:18:29.677000 audit[1]: SERVICE_STOP pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=dracut-pre-udev comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Oct 29 00:18:29.605272 systemd[1]: Stopping systemd-networkd.service - Network Management... Oct 29 00:18:29.684000 audit[1]: SERVICE_STOP pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=dracut-cmdline comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Oct 29 00:18:29.688787 kernel: hv_netvsc f8615163-0000-1000-2000-7c1e528753a4 eth0: Data path switched from VF: enP30832s1 Oct 29 00:18:29.608631 systemd[1]: Stopping systemd-resolved.service - Network Name Resolution... Oct 29 00:18:29.687000 audit[1]: SERVICE_STOP pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=dracut-cmdline-ask comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Oct 29 00:18:29.690905 kernel: mana 7870:00:00.0 enP30832s1: Configured steering vPort 0 entries 64 Oct 29 00:18:29.611174 systemd[1]: initrd-cleanup.service: Deactivated successfully. Oct 29 00:18:29.611279 systemd[1]: Finished initrd-cleanup.service - Cleaning Up and Shutting Down Daemons. Oct 29 00:18:29.617107 systemd[1]: systemd-networkd.service: Deactivated successfully. Oct 29 00:18:29.699000 audit[1]: SERVICE_STOP pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=systemd-network-generator comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Oct 29 00:18:29.617225 systemd[1]: Stopped systemd-networkd.service - Network Management. Oct 29 00:18:29.703000 audit[1]: SERVICE_STOP pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=systemd-tmpfiles-setup-dev comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Oct 29 00:18:29.706000 audit[1]: SERVICE_STOP pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=systemd-tmpfiles-setup-dev-early comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Oct 29 00:18:29.627133 systemd[1]: systemd-networkd-resolve-hook.socket: Deactivated successfully. Oct 29 00:18:29.713000 audit[1]: SERVICE_STOP pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=kmod-static-nodes comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Oct 29 00:18:29.627194 systemd[1]: Closed systemd-networkd-resolve-hook.socket - Network Management Resolve Hook Socket. Oct 29 00:18:29.716000 audit[1]: SERVICE_STOP pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=systemd-vconsole-setup comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Oct 29 00:18:29.630761 systemd[1]: Stopped target network-pre.target - Preparation for Network. Oct 29 00:18:29.632895 systemd[1]: systemd-networkd.socket: Deactivated successfully. Oct 29 00:18:29.632936 systemd[1]: Closed systemd-networkd.socket - Network Management Netlink Socket. Oct 29 00:18:29.634594 systemd[1]: Stopping network-cleanup.service - Network Cleanup... Oct 29 00:18:29.641128 systemd[1]: Stopping systemd-udevd.service - Rule-based Manager for Device Events and Files... Oct 29 00:18:29.650004 systemd[1]: systemd-resolved.service: Deactivated successfully. Oct 29 00:18:29.650088 systemd[1]: Stopped systemd-resolved.service - Network Name Resolution. Oct 29 00:18:29.726000 audit[1]: SERVICE_STOP pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=network-cleanup comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Oct 29 00:18:29.660528 systemd[1]: systemd-udevd.service: Deactivated successfully. Oct 29 00:18:29.729000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=initrd-udevadm-cleanup-db comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Oct 29 00:18:29.729000 audit[1]: SERVICE_STOP pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=initrd-udevadm-cleanup-db comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Oct 29 00:18:29.660664 systemd[1]: Stopped systemd-udevd.service - Rule-based Manager for Device Events and Files. Oct 29 00:18:29.666611 systemd[1]: systemd-udevd-control.socket: Deactivated successfully. Oct 29 00:18:29.666721 systemd[1]: Closed systemd-udevd-control.socket - udev Control Socket. Oct 29 00:18:29.671243 systemd[1]: dracut-pre-udev.service: Deactivated successfully. Oct 29 00:18:29.671283 systemd[1]: Stopped dracut-pre-udev.service - dracut pre-udev hook. Oct 29 00:18:29.680992 systemd[1]: dracut-cmdline.service: Deactivated successfully. Oct 29 00:18:29.681037 systemd[1]: Stopped dracut-cmdline.service - dracut cmdline hook. Oct 29 00:18:29.686019 systemd[1]: dracut-cmdline-ask.service: Deactivated successfully. Oct 29 00:18:29.686053 systemd[1]: Stopped dracut-cmdline-ask.service - dracut ask for additional cmdline parameters. Oct 29 00:18:29.692459 systemd[1]: Starting initrd-udevadm-cleanup-db.service - Cleanup udev Database... Oct 29 00:18:29.697723 systemd[1]: systemd-network-generator.service: Deactivated successfully. Oct 29 00:18:29.697766 systemd[1]: Stopped systemd-network-generator.service - Generate Network Units from Kernel Command Line. Oct 29 00:18:29.700794 systemd[1]: systemd-tmpfiles-setup-dev.service: Deactivated successfully. Oct 29 00:18:29.700833 systemd[1]: Stopped systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev. Oct 29 00:18:29.704817 systemd[1]: systemd-tmpfiles-setup-dev-early.service: Deactivated successfully. Oct 29 00:18:29.704856 systemd[1]: Stopped systemd-tmpfiles-setup-dev-early.service - Create Static Device Nodes in /dev gracefully. Oct 29 00:18:29.708548 systemd[1]: kmod-static-nodes.service: Deactivated successfully. Oct 29 00:18:29.708582 systemd[1]: Stopped kmod-static-nodes.service - Create List of Static Device Nodes. Oct 29 00:18:29.714853 systemd[1]: systemd-vconsole-setup.service: Deactivated successfully. Oct 29 00:18:29.714883 systemd[1]: Stopped systemd-vconsole-setup.service - Virtual Console Setup. Oct 29 00:18:29.718695 systemd[1]: network-cleanup.service: Deactivated successfully. Oct 29 00:18:29.718794 systemd[1]: Stopped network-cleanup.service - Network Cleanup. Oct 29 00:18:29.729401 systemd[1]: initrd-udevadm-cleanup-db.service: Deactivated successfully. Oct 29 00:18:29.729478 systemd[1]: Finished initrd-udevadm-cleanup-db.service - Cleanup udev Database. Oct 29 00:18:29.733407 systemd[1]: Reached target initrd-switch-root.target - Switch Root. Oct 29 00:18:29.737111 systemd[1]: Starting initrd-switch-root.service - Switch Root... Oct 29 00:18:29.751773 systemd[1]: Switching root. Oct 29 00:18:29.821316 systemd-journald[1072]: Journal stopped Oct 29 00:18:36.118906 systemd-journald[1072]: Received SIGTERM from PID 1 (systemd). Oct 29 00:18:36.118941 kernel: SELinux: policy capability network_peer_controls=1 Oct 29 00:18:36.118956 kernel: SELinux: policy capability open_perms=1 Oct 29 00:18:36.118966 kernel: SELinux: policy capability extended_socket_class=1 Oct 29 00:18:36.118978 kernel: SELinux: policy capability always_check_network=0 Oct 29 00:18:36.118988 kernel: SELinux: policy capability cgroup_seclabel=1 Oct 29 00:18:36.119000 kernel: SELinux: policy capability nnp_nosuid_transition=1 Oct 29 00:18:36.119009 kernel: SELinux: policy capability genfs_seclabel_symlinks=0 Oct 29 00:18:36.119019 kernel: SELinux: policy capability ioctl_skip_cloexec=0 Oct 29 00:18:36.119028 kernel: SELinux: policy capability userspace_initial_context=0 Oct 29 00:18:36.119040 systemd[1]: Successfully loaded SELinux policy in 157.175ms. Oct 29 00:18:36.119052 systemd[1]: Relabeled /dev/, /dev/shm/, /run/ in 6.024ms. Oct 29 00:18:36.119064 systemd[1]: systemd 261.2 running in system mode (+PAM +AUDIT +SELINUX -APPARMOR +IMA +IPE +SMACK +SECCOMP -GCRYPT -GNUTLS +OPENSSL -ACL +BLKID +CURL +ELFUTILS -FIDO2 +IDN2 +KMOD +LIBCRYPTSETUP +LIBCRYPTSETUP_PLUGINS +LIBFDISK +PCRE2 -PWQUALITY -P11KIT -QRENCODE +TPM2 +BZIP2 +LZ4 +XZ +ZLIB +ZSTD -BPF_FRAMEWORK -BTF -XKBCOMMON +UTMP +LIBARCHIVE) Oct 29 00:18:36.119078 systemd[1]: Detected virtualization microsoft. Oct 29 00:18:36.119091 systemd[1]: Detected architecture x86-64. Oct 29 00:18:36.119102 systemd[1]: Detected first boot. Oct 29 00:18:36.119113 systemd[1]: Initializing machine ID from random generator. Oct 29 00:18:36.119124 systemd[1]: Hostname set to . Oct 29 00:18:36.119135 kernel: kauditd_printk_skb: 34 callbacks suppressed Oct 29 00:18:36.119149 kernel: audit: type=1334 audit(1793233112.463:84): prog-id=9 op=LOAD Oct 29 00:18:36.119159 kernel: audit: type=1334 audit(1793233112.463:85): prog-id=9 op=UNLOAD Oct 29 00:18:36.119169 zram_generator::config[1907]: No configuration found. Oct 29 00:18:36.119180 kernel: Guest personality initialized and is inactive Oct 29 00:18:36.119190 kernel: VMCI host device registered (name=vmci, major=10, minor=259) Oct 29 00:18:36.119201 kernel: Initialized host personality Oct 29 00:18:36.119213 kernel: NET: Registered PF_VSOCK protocol family Oct 29 00:18:36.119224 systemd[1]: Applying preset policy. Oct 29 00:18:36.119240 systemd[1]: Created symlink '/etc/systemd/system/multi-user.target.wants/var-vm-swapfile1.swap' → '/etc/systemd/system/var-vm-swapfile1.swap'. Oct 29 00:18:36.119252 systemd[1]: Created symlink '/etc/systemd/system/timers.target.wants/google-oslogin-cache.timer' → '/usr/lib/systemd/system/google-oslogin-cache.timer'. Oct 29 00:18:36.119262 systemd[1]: Populated /etc with preset unit settings. Oct 29 00:18:36.119272 kernel: audit: type=1334 audit(1793233115.513:86): prog-id=10 op=LOAD Oct 29 00:18:36.119282 kernel: audit: type=1334 audit(1793233115.513:87): prog-id=2 op=UNLOAD Oct 29 00:18:36.119294 kernel: audit: type=1334 audit(1793233115.513:88): prog-id=11 op=LOAD Oct 29 00:18:36.119304 kernel: audit: type=1334 audit(1793233115.513:89): prog-id=12 op=LOAD Oct 29 00:18:36.119316 kernel: audit: type=1334 audit(1793233115.513:90): prog-id=3 op=UNLOAD Oct 29 00:18:36.119326 kernel: audit: type=1334 audit(1793233115.513:91): prog-id=4 op=UNLOAD Oct 29 00:18:36.119336 kernel: audit: type=1334 audit(1793233115.514:92): prog-id=13 op=LOAD Oct 29 00:18:36.119346 kernel: audit: type=1334 audit(1793233115.514:93): prog-id=10 op=UNLOAD Oct 29 00:18:36.119358 systemd[1]: initrd-switch-root.service: Deactivated successfully. Oct 29 00:18:36.119369 systemd[1]: Stopped initrd-switch-root.service - Switch Root. Oct 29 00:18:36.119384 systemd[1]: systemd-journald.service: Scheduled restart job, restart counter is at 1. Oct 29 00:18:36.119396 systemd[1]: Created slice system-addon\x2dconfig.slice - Slice /system/addon-config. Oct 29 00:18:36.119408 systemd[1]: Created slice system-addon\x2drun.slice - Slice /system/addon-run. Oct 29 00:18:36.119419 systemd[1]: Created slice system-getty.slice - Slice /system/getty. Oct 29 00:18:36.119432 systemd[1]: Created slice system-modprobe.slice - Slice /system/modprobe. Oct 29 00:18:36.119443 systemd[1]: Created slice system-serial\x2dgetty.slice - Slice /system/serial-getty. Oct 29 00:18:36.119455 systemd[1]: Created slice system-system\x2dcloudinit.slice - Slice /system/system-cloudinit. Oct 29 00:18:36.119467 systemd[1]: Created slice system-systemd\x2dfsck.slice - Slice /system/systemd-fsck. Oct 29 00:18:36.119479 systemd[1]: Created slice user.slice - User and Session Slice. Oct 29 00:18:36.119490 systemd[1]: Started clevis-luks-askpass.path - Forward Password Requests to Clevis Directory Watch. Oct 29 00:18:36.119501 systemd[1]: Started systemd-ask-password-console.path - Dispatch Password Requests to Console Directory Watch. Oct 29 00:18:36.119514 systemd[1]: Started systemd-ask-password-wall.path - Forward Password Requests to Wall Directory Watch. Oct 29 00:18:36.119525 systemd[1]: Set up automount boot.automount - Boot partition Automount Point. Oct 29 00:18:36.119537 systemd[1]: Set up automount proc-sys-fs-binfmt_misc.automount - Arbitrary Executable File Formats File System Automount Point. Oct 29 00:18:36.119549 systemd[1]: Expecting device dev-disk-by\x2dlabel-OEM.device - /dev/disk/by-label/OEM... Oct 29 00:18:36.119561 systemd[1]: Expecting device dev-ptp_hyperv.device - /dev/ptp_hyperv... Oct 29 00:18:36.119572 systemd[1]: Expecting device dev-ttyS0.device - /dev/ttyS0... Oct 29 00:18:36.119585 systemd[1]: Reached target cryptsetup-pre.target - Local Encrypted Volumes (Pre). Oct 29 00:18:36.119597 systemd[1]: Reached target cryptsetup.target - Local Encrypted Volumes. Oct 29 00:18:36.119609 systemd[1]: Reached target imports.target - Image Downloads. Oct 29 00:18:36.119620 systemd[1]: Stopped target initrd-switch-root.target - Switch Root. Oct 29 00:18:36.119632 systemd[1]: Stopped target initrd-fs.target - Initrd File Systems. Oct 29 00:18:36.119642 systemd[1]: Stopped target initrd-root-fs.target - Initrd Root File System. Oct 29 00:18:36.119653 systemd[1]: Reached target integritysetup.target - Local Integrity Protected Volumes. Oct 29 00:18:36.119666 systemd[1]: Reached target remote-cryptsetup.target - Remote Encrypted Volumes. Oct 29 00:18:36.119696 systemd[1]: Reached target remote-fs.target - Remote File Systems. Oct 29 00:18:36.119709 systemd[1]: Reached target remote-integritysetup.target - Remote Integrity Protected Volumes. Oct 29 00:18:36.119722 systemd[1]: Reached target remote-veritysetup.target - Remote Verity Protected Volumes. Oct 29 00:18:36.119733 systemd[1]: Reached target slices.target - Slice Units. Oct 29 00:18:36.119744 systemd[1]: Reached target veritysetup.target - Local Verity Protected Volumes. Oct 29 00:18:36.119755 systemd[1]: Listening on systemd-ask-password.socket - Query the User Interactively for a Password. Oct 29 00:18:36.119766 systemd[1]: Listening on systemd-coredump.socket - Process Core Dump Socket. Oct 29 00:18:36.119776 systemd[1]: Listening on systemd-creds.socket - Credential Encryption/Decryption. Oct 29 00:18:36.119786 systemd[1]: Listening on systemd-factory-reset.socket - Factory Reset Management. Oct 29 00:18:36.119799 systemd[1]: Listening on systemd-hostnamed.socket - Hostname Service Socket. Oct 29 00:18:36.119811 systemd[1]: Listening on systemd-journald-audit.socket - Journal Audit Socket. Oct 29 00:18:36.119824 systemd[1]: Listening on systemd-mountfsd.socket - DDI File System Mounter Socket. Oct 29 00:18:36.119836 systemd[1]: Listening on systemd-mute-console.socket - Console Output Muting Service Socket. Oct 29 00:18:36.119848 systemd[1]: Listening on systemd-networkd-varlink-metrics.socket - Network Management Metrics Varlink Socket. Oct 29 00:18:36.119859 systemd[1]: Listening on systemd-networkd-varlink.socket - Network Management Varlink Socket. Oct 29 00:18:36.119870 systemd[1]: Listening on systemd-networkd.socket - Network Management Netlink Socket. Oct 29 00:18:36.119883 systemd[1]: Listening on systemd-nsresourced.socket - Namespace Resource Manager Socket. Oct 29 00:18:36.119894 systemd[1]: Listening on systemd-oomd.socket - Userspace Out-Of-Memory (OOM) Killer Socket. Oct 29 00:18:36.119905 systemd[1]: Listening on systemd-repart.socket - Disk Repartitioning Service Socket. Oct 29 00:18:36.119917 systemd[1]: Listening on systemd-report-basic.socket - Report System Basic Metrics Socket. Oct 29 00:18:36.119929 systemd[1]: Listening on systemd-report-cgroup.socket - CGroup Report Varlink Socket. Oct 29 00:18:36.119941 systemd[1]: Listening on systemd-resolved-monitor.socket - Resolve Monitor Varlink Socket. Oct 29 00:18:36.119954 systemd[1]: Listening on systemd-resolved-varlink.socket - Resolve Service Varlink Socket. Oct 29 00:18:36.119965 systemd[1]: Listening on systemd-storage-block.socket - Simple Block Device Backed Storage Provider. Oct 29 00:18:36.119976 systemd[1]: Listening on systemd-storage-fs.socket - Simple File System Backed Storage Provider. Oct 29 00:18:36.119988 systemd[1]: Listening on systemd-udevd-control.socket - udev Control Socket. Oct 29 00:18:36.119999 systemd[1]: Listening on systemd-udevd-varlink.socket - udev Varlink Socket. Oct 29 00:18:36.120011 systemd[1]: Listening on systemd-userdbd.socket - User Database Manager Socket. Oct 29 00:18:36.120023 systemd[1]: Mounting dev-hugepages.mount - Huge Pages File System... Oct 29 00:18:36.120036 systemd[1]: Mounting dev-mqueue.mount - POSIX Message Queue File System... Oct 29 00:18:36.120047 systemd[1]: Mounting media.mount - External Media Directory... Oct 29 00:18:36.120058 systemd[1]: proc-xen.mount - /proc/xen skipped, unmet condition check ConditionVirtualization=xen Oct 29 00:18:36.120070 systemd[1]: Mounting sys-kernel-debug.mount - Kernel Debug File System... Oct 29 00:18:36.120082 systemd[1]: Mounting sys-kernel-tracing.mount - Kernel Trace File System... Oct 29 00:18:36.120093 systemd[1]: Starting create-swapfile.service - Create a swapfile... Oct 29 00:18:36.120105 systemd[1]: Starting flatcar-tmpfiles.service - Create missing system files... Oct 29 00:18:36.120119 systemd[1]: ignition-delete-config.service - Ignition (delete config) skipped, no trigger condition checks were met. Oct 29 00:18:36.120131 systemd[1]: Starting kmod-static-nodes.service - Create List of Static Device Nodes... Oct 29 00:18:36.120143 systemd[1]: Starting modprobe@configfs.service - Load Kernel Module configfs... Oct 29 00:18:36.120153 systemd[1]: modprobe@drm.service - Load Kernel Module drm skipped, unmet condition check ConditionKernelModuleLoaded=!drm Oct 29 00:18:36.120165 systemd[1]: modprobe@efi_pstore.service - Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore Oct 29 00:18:36.120176 systemd[1]: Starting modprobe@fuse.service - Load Kernel Module fuse... Oct 29 00:18:36.120189 systemd[1]: setup-nsswitch.service - Create /etc/nsswitch.conf skipped, unmet condition check ConditionPathExists=!/etc/nsswitch.conf Oct 29 00:18:36.120200 systemd[1]: systemd-fsck-root.service: Deactivated successfully. Oct 29 00:18:36.120211 systemd[1]: Stopped systemd-fsck-root.service - File System Check on Root Device. Oct 29 00:18:36.120223 systemd[1]: systemd-hibernate-clear.service - Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 Oct 29 00:18:36.120235 systemd[1]: Starting systemd-journald.service - Journal Service... Oct 29 00:18:36.120247 systemd[1]: Starting systemd-modules-load.service - Load Kernel Modules... Oct 29 00:18:36.120274 systemd-journald[1985]: Collecting audit messages is enabled. Oct 29 00:18:36.120304 systemd[1]: Starting systemd-network-generator.service - Generate Network Units from Kernel Command Line... Oct 29 00:18:36.120318 systemd-journald[1985]: Journal started Oct 29 00:18:36.120346 systemd-journald[1985]: Runtime Journal (/run/log/journal/4fc1442ab83f41129c64623b60a9c9b0) is 8M, max 158.5M, 150.5M free. Oct 29 00:18:35.748000 audit[1]: EVENT_LISTENER pid=1 uid=0 auid=4294967295 tty=(none) ses=4294967295 subj=system_u:system_r:kernel_t:s0 comm="systemd" exe="/usr/lib/systemd/systemd" nl-mcgrp=1 op=connect res=1 Oct 29 00:18:36.058000 audit[1]: SERVICE_STOP pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=systemd-fsck-root comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Oct 29 00:18:36.061000 audit: BPF prog-id=15 op=UNLOAD Oct 29 00:18:36.061000 audit: BPF prog-id=14 op=UNLOAD Oct 29 00:18:36.061000 audit: BPF prog-id=16 op=LOAD Oct 29 00:18:36.061000 audit: BPF prog-id=17 op=LOAD Oct 29 00:18:36.061000 audit: BPF prog-id=18 op=LOAD Oct 29 00:18:36.114000 audit: CONFIG_CHANGE op=set audit_enabled=1 old=1 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 res=1 Oct 29 00:18:36.114000 audit[1985]: SYSCALL arch=c000003e syscall=46 success=yes exit=60 a0=5 a1=7ffd89935290 a2=4000 a3=0 items=0 ppid=1 pid=1985 auid=4294967295 uid=0 gid=0 euid=0 suid=0 fsuid=0 egid=0 sgid=0 fsgid=0 tty=(none) ses=4294967295 comm="systemd-journal" exe="/usr/lib/systemd/systemd-journald" subj=system_u:system_r:kernel_t:s0 key=(null) Oct 29 00:18:36.114000 audit: PROCTITLE proctitle="/usr/lib/systemd/systemd-journald" Oct 29 00:18:35.506668 systemd[1]: Queued start job for default target multi-user.target. Oct 29 00:18:35.516262 systemd[1]: Unnecessary job was removed for dev-nvme0n1p6.device - /dev/nvme0n1p6. Oct 29 00:18:35.516746 systemd[1]: systemd-journald.service: Deactivated successfully. Oct 29 00:18:36.123753 systemd[1]: Reached target time-set.target - System Time Set. Oct 29 00:18:36.131713 systemd[1]: Starting systemd-remount-fs.service - Remount Root and Kernel File Systems... Oct 29 00:18:36.143769 systemd[1]: Starting systemd-udev-load-credentials.service - Load udev Rules from Credentials... Oct 29 00:18:36.151712 systemd[1]: Starting systemd-udev-trigger.service - Coldplug All udev Devices... Oct 29 00:18:36.163713 systemd[1]: xenserver-pv-version.service - Set fake PV driver version for XenServer skipped, unmet condition check ConditionVirtualization=xen Oct 29 00:18:36.164392 systemd-modules-load[1989]: Using 2 probe threads Oct 29 00:18:36.171711 kernel: fuse: init (API version 7.41) Oct 29 00:18:36.171758 systemd[1]: Started systemd-journald.service - Journal Service. Oct 29 00:18:36.174000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=systemd-journald comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Oct 29 00:18:36.176541 systemd[1]: Mounted dev-hugepages.mount - Huge Pages File System. Oct 29 00:18:36.179866 systemd[1]: Mounted dev-mqueue.mount - POSIX Message Queue File System. Oct 29 00:18:36.183205 systemd[1]: Mounted media.mount - External Media Directory. Oct 29 00:18:36.184811 systemd[1]: Mounted sys-kernel-debug.mount - Kernel Debug File System. Oct 29 00:18:36.187200 systemd[1]: Mounted sys-kernel-tracing.mount - Kernel Trace File System. Oct 29 00:18:36.190315 systemd[1]: Finished kmod-static-nodes.service - Create List of Static Device Nodes. Oct 29 00:18:36.192000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=kmod-static-nodes comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Oct 29 00:18:36.194043 systemd[1]: modprobe@configfs.service: Deactivated successfully. Oct 29 00:18:36.194205 systemd[1]: Finished modprobe@configfs.service - Load Kernel Module configfs. Oct 29 00:18:36.195000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=modprobe@configfs comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Oct 29 00:18:36.195000 audit[1]: SERVICE_STOP pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=modprobe@configfs comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Oct 29 00:18:36.197258 systemd[1]: modprobe@fuse.service: Deactivated successfully. Oct 29 00:18:36.197590 systemd[1]: Finished modprobe@fuse.service - Load Kernel Module fuse. Oct 29 00:18:36.198000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=modprobe@fuse comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Oct 29 00:18:36.198000 audit[1]: SERVICE_STOP pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=modprobe@fuse comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Oct 29 00:18:36.205051 systemd[1]: Finished systemd-network-generator.service - Generate Network Units from Kernel Command Line. Oct 29 00:18:36.207000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=systemd-network-generator comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Oct 29 00:18:36.210347 systemd[1]: Finished systemd-remount-fs.service - Remount Root and Kernel File Systems. Oct 29 00:18:36.213000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=systemd-remount-fs comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Oct 29 00:18:36.215566 systemd[1]: Finished systemd-modules-load.service - Load Kernel Modules. Oct 29 00:18:36.215000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=systemd-modules-load comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Oct 29 00:18:36.223878 systemd[1]: Finished systemd-udev-load-credentials.service - Load udev Rules from Credentials. Oct 29 00:18:36.224000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=systemd-udev-load-credentials comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Oct 29 00:18:36.229459 systemd[1]: Reached target network-pre.target - Preparation for Network. Oct 29 00:18:36.234120 systemd[1]: Listening on systemd-networkd-resolve-hook.socket - Network Management Resolve Hook Socket. Oct 29 00:18:36.238212 systemd[1]: Mounting sys-fs-fuse-connections.mount - FUSE Control File System... Oct 29 00:18:36.255843 systemd[1]: Mounting sys-kernel-config.mount - Kernel Configuration File System... Oct 29 00:18:36.259140 systemd[1]: remount-root.service - Remount Root File System skipped, unmet condition check ConditionPathIsReadWrite=!/ Oct 29 00:18:36.260294 systemd[1]: Starting systemd-hwdb-update.service - Rebuild Hardware Database... Oct 29 00:18:36.264808 systemd[1]: Starting systemd-journal-flush.service - Flush Journal to Persistent Storage... Oct 29 00:18:36.267065 systemd[1]: systemd-pstore.service - Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore Oct 29 00:18:36.270883 systemd[1]: Starting systemd-random-seed.service - Load/Save OS Random Seed... Oct 29 00:18:36.278281 systemd[1]: Starting systemd-sysctl.service - Apply Kernel Variables... Oct 29 00:18:36.283861 systemd[1]: Starting systemd-tmpfiles-setup-dev-early.service - Create Static Device Nodes in /dev gracefully... Oct 29 00:18:36.289271 systemd[1]: Mounted sys-fs-fuse-connections.mount - FUSE Control File System. Oct 29 00:18:36.291830 systemd[1]: Mounted sys-kernel-config.mount - Kernel Configuration File System. Oct 29 00:18:36.324129 systemd-journald[1985]: Time spent on flushing to /var/log/journal/4fc1442ab83f41129c64623b60a9c9b0 is 12.239ms for 1242 entries. Oct 29 00:18:36.324129 systemd-journald[1985]: System Journal (/var/log/journal/4fc1442ab83f41129c64623b60a9c9b0) is 8M, max 2.2G, 2.2G free. Oct 29 00:18:36.329000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=systemd-udev-trigger comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Oct 29 00:18:36.338000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=systemd-random-seed comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Oct 29 00:18:36.360451 systemd-journald[1985]: Received client request to flush runtime journal. Oct 29 00:18:36.329948 systemd[1]: Finished systemd-udev-trigger.service - Coldplug All udev Devices. Oct 29 00:18:36.337291 systemd[1]: Finished systemd-random-seed.service - Load/Save OS Random Seed. Oct 29 00:18:36.339928 systemd[1]: Reached target first-boot-complete.target - First Boot Complete. Oct 29 00:18:36.361595 systemd[1]: Finished systemd-journal-flush.service - Flush Journal to Persistent Storage. Oct 29 00:18:36.361000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=systemd-journal-flush comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Oct 29 00:18:36.382770 systemd[1]: Finished systemd-sysctl.service - Apply Kernel Variables. Oct 29 00:18:36.385000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=systemd-sysctl comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Oct 29 00:18:36.411261 mkswap[2044]: Setting up swapspace version 1, size = 1024 MiB (1073737728 bytes) Oct 29 00:18:36.411261 mkswap[2044]: no label, UUID=62d84569-16fb-474c-a126-59aadc13de42 Oct 29 00:18:36.411645 systemd[1]: Finished create-swapfile.service - Create a swapfile. Oct 29 00:18:36.411000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=create-swapfile comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Oct 29 00:18:36.414192 systemd[1]: Activating swap var-vm-swapfile1.swap - Turn on swap... Oct 29 00:18:36.433913 systemd[1]: Finished flatcar-tmpfiles.service - Create missing system files. Oct 29 00:18:36.435000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=flatcar-tmpfiles comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Oct 29 00:18:36.440581 systemd-tmpfiles[2039]: ACLs are not supported, ignoring. Oct 29 00:18:36.440603 systemd-tmpfiles[2039]: ACLs are not supported, ignoring. Oct 29 00:18:36.443017 systemd[1]: Finished systemd-tmpfiles-setup-dev-early.service - Create Static Device Nodes in /dev gracefully. Oct 29 00:18:36.444000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=systemd-tmpfiles-setup-dev-early comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Oct 29 00:18:36.446741 systemd[1]: Starting systemd-sysusers.service - Create System Users... Oct 29 00:18:36.500286 systemd[1]: Activated swap var-vm-swapfile1.swap - Turn on swap. Oct 29 00:18:36.501795 kernel: Adding 1048572k swap on /var/vm/swapfile1. Priority:-2 extents:6 across:1114108k SS Oct 29 00:18:36.502724 systemd[1]: Reached target swap.target - Swaps. Oct 29 00:18:36.595221 systemd[1]: tmp.mount: x-systemd.graceful-option=usrquota specified, but option is not available, suppressing. Oct 29 00:18:36.596141 systemd[1]: Mounting tmp.mount - Temporary Directory /tmp... Oct 29 00:18:36.609604 systemd[1]: Mounted tmp.mount - Temporary Directory /tmp. Oct 29 00:18:36.680291 systemd[1]: Finished systemd-sysusers.service - Create System Users. Oct 29 00:18:36.682000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=systemd-sysusers comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Oct 29 00:18:36.687768 systemd[1]: Starting systemd-journalctl.socket - Journal Log Access Socket... Oct 29 00:18:36.692000 audit: BPF prog-id=19 op=LOAD Oct 29 00:18:36.692000 audit: BPF prog-id=20 op=LOAD Oct 29 00:18:36.692000 audit: BPF prog-id=21 op=LOAD Oct 29 00:18:36.694736 systemd[1]: Starting systemd-oomd.service - Userspace Out-Of-Memory (OOM) Killer... Oct 29 00:18:36.700000 audit: BPF prog-id=22 op=LOAD Oct 29 00:18:36.704838 systemd[1]: Starting systemd-resolved.service - Network Name Resolution... Oct 29 00:18:36.708819 systemd[1]: Starting systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev... Oct 29 00:18:36.712239 systemd[1]: Listening on systemd-journalctl.socket - Journal Log Access Socket. Oct 29 00:18:36.716940 systemd[1]: Starting modprobe@tun.service - Load Kernel Module tun... Oct 29 00:18:36.723000 audit: BPF prog-id=23 op=LOAD Oct 29 00:18:36.723000 audit: BPF prog-id=24 op=LOAD Oct 29 00:18:36.723000 audit: BPF prog-id=25 op=LOAD Oct 29 00:18:36.726053 systemd[1]: Starting systemd-userdbd.service - User Database Manager... Oct 29 00:18:36.743049 systemd-tmpfiles[2064]: ACLs are not supported, ignoring. Oct 29 00:18:36.743068 systemd-tmpfiles[2064]: ACLs are not supported, ignoring. Oct 29 00:18:36.745946 systemd[1]: Finished systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev. Oct 29 00:18:36.750209 systemd[1]: Reached target local-fs-pre.target - Preparation for Local File Systems. Oct 29 00:18:36.747000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=systemd-tmpfiles-setup-dev comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Oct 29 00:18:36.752210 systemd[1]: var-lib-machines.mount - Virtual Machine and Container Storage (Compatibility) skipped, unmet condition check ConditionPathExists=/var/lib/machines.raw Oct 29 00:18:36.752236 systemd[1]: Reached target local-fs.target - Local File Systems. Oct 29 00:18:36.754747 systemd[1]: Reached target machines.target - Virtual Machines and Containers. Oct 29 00:18:36.758028 systemd[1]: Listening on systemd-importd.socket - Disk Image Download Service Socket. Oct 29 00:18:36.760726 systemd[1]: Listening on systemd-sysext.socket - System Extension Image Management. Oct 29 00:18:36.763886 systemd[1]: systemd-binfmt.service - Set Up Additional Binary Formats skipped, no trigger condition checks were met. Oct 29 00:18:36.766778 systemd[1]: Starting systemd-confext.service - Merge System Configuration Images into /etc/... Oct 29 00:18:36.772814 systemd[1]: Starting systemd-machine-id-commit.service - Save Transient machine-id to Disk... Oct 29 00:18:36.774886 systemd[1]: systemd-repart.service - Repartition Root Disk skipped, no trigger condition checks were met. Oct 29 00:18:36.777812 systemd[1]: Starting systemd-userdb-load-credentials.service - Load JSON user/group Records from Credentials... Oct 29 00:18:36.780419 systemd[1]: proc-sys-fs-binfmt_misc.automount: Got automount request for /proc/sys/fs/binfmt_misc, triggered by 2066 ((systemd-userd)) Oct 29 00:18:36.781171 systemd[1]: Mounting proc-sys-fs-binfmt_misc.mount - Arbitrary Executable File Formats File System... Oct 29 00:18:36.811706 kernel: tun: Universal TUN/TAP device driver, 1.6 Oct 29 00:18:36.812334 systemd[1]: modprobe@tun.service: Deactivated successfully. Oct 29 00:18:36.812517 systemd[1]: Finished modprobe@tun.service - Load Kernel Module tun. Oct 29 00:18:36.812000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=modprobe@tun comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Oct 29 00:18:36.812000 audit[1]: SERVICE_STOP pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=modprobe@tun comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Oct 29 00:18:36.813000 audit: BPF prog-id=26 op=LOAD Oct 29 00:18:36.813000 audit: BPF prog-id=27 op=LOAD Oct 29 00:18:36.813000 audit: BPF prog-id=28 op=LOAD Oct 29 00:18:36.816823 systemd[1]: Starting systemd-nsresourced.service - Namespace Resource Manager... Oct 29 00:18:36.825261 systemd[1]: Mounted proc-sys-fs-binfmt_misc.mount - Arbitrary Executable File Formats File System. Oct 29 00:18:36.834054 systemd[1]: Finished systemd-userdb-load-credentials.service - Load JSON user/group Records from Credentials. Oct 29 00:18:36.834000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=systemd-userdb-load-credentials comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Oct 29 00:18:37.033824 kernel: loop4: detected capacity change from 0 to 44465 Oct 29 00:18:37.037689 kernel: loop4: p1 p2 p3 Oct 29 00:18:37.054787 systemd[1]: Started systemd-userdbd.service - User Database Manager. Oct 29 00:18:37.054000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=systemd-userdbd comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Oct 29 00:18:37.060085 systemd-nsresourced[2077]: Not setting up BPF subsystem, as functionality has been disabled at compile time. Oct 29 00:18:37.061368 systemd[1]: Started systemd-nsresourced.service - Namespace Resource Manager. Oct 29 00:18:37.063000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=systemd-nsresourced comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Oct 29 00:18:37.124366 systemd[1]: Finished systemd-machine-id-commit.service - Save Transient machine-id to Disk. Oct 29 00:18:37.124000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=systemd-machine-id-commit comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Oct 29 00:18:37.140693 kernel: device-mapper: verity: sha256 using shash "sha256-ni" Oct 29 00:18:37.146688 kernel: device-mapper: verity: Unrecognized verity feature request: root_hash_sig_key_desc Oct 29 00:18:37.151752 kernel: device-mapper: table: 254:5: verity: Unrecognized verity feature request (-EINVAL) Oct 29 00:18:37.151895 kernel: device-mapper: ioctl: error adding target to table Oct 29 00:18:37.154718 systemd-confext[2074]: device-mapper: reload ioctl on loop4p1-53-verity (254:5) failed: Invalid argument Oct 29 00:18:37.161707 kernel: device-mapper: verity: sha256 using shash "sha256-ni" Oct 29 00:18:37.200981 systemd[1]: Started systemd-oomd.service - Userspace Out-Of-Memory (OOM) Killer. Oct 29 00:18:37.201000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=systemd-oomd comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Oct 29 00:18:37.219739 systemd-resolved[2063]: Positive Trust Anchors: Oct 29 00:18:37.219754 systemd-resolved[2063]: . IN DS 20326 8 2 e06d44b80b8f1d39a95c0b0d7c65d08458e880409bbc683457104237c7f8ec8d Oct 29 00:18:37.219758 systemd-resolved[2063]: . IN DS 38696 8 2 683d2d0acb8c9b712a1948b27f741219298d0a450d612c483af444a4c0fb2b16 Oct 29 00:18:37.219794 systemd-resolved[2063]: Negative trust anchors: home.arpa 10.in-addr.arpa 16.172.in-addr.arpa 17.172.in-addr.arpa 18.172.in-addr.arpa 19.172.in-addr.arpa 20.172.in-addr.arpa 21.172.in-addr.arpa 22.172.in-addr.arpa 23.172.in-addr.arpa 24.172.in-addr.arpa 25.172.in-addr.arpa 26.172.in-addr.arpa 27.172.in-addr.arpa 28.172.in-addr.arpa 29.172.in-addr.arpa 30.172.in-addr.arpa 31.172.in-addr.arpa 170.0.0.192.in-addr.arpa 171.0.0.192.in-addr.arpa 168.192.in-addr.arpa d.f.ip6.arpa ipv4only.arpa resolver.arpa corp home internal intranet lan local private test Oct 29 00:18:37.595172 systemd[1]: etc-machine\x2did.mount: Deactivated successfully. Oct 29 00:18:37.859025 systemd-resolved[2063]: Using system hostname 'ci-4820.1.0-n-75d75734f8'. Oct 29 00:18:37.860563 systemd[1]: Started systemd-resolved.service - Network Name Resolution. Oct 29 00:18:37.862000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=systemd-resolved comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Oct 29 00:18:37.868883 kernel: kauditd_printk_skb: 54 callbacks suppressed Oct 29 00:18:37.868921 kernel: audit: type=1130 audit(1793233117.862:146): pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=systemd-resolved comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Oct 29 00:18:37.869097 systemd[1]: Reached target nss-lookup.target - Host and Network Name Lookups. Oct 29 00:18:37.880163 systemd[1]: Finished systemd-hwdb-update.service - Rebuild Hardware Database. Oct 29 00:18:37.882000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=systemd-hwdb-update comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Oct 29 00:18:37.887831 systemd[1]: Starting systemd-udevd.service - Rule-based Manager for Device Events and Files... Oct 29 00:18:37.890972 kernel: audit: type=1130 audit(1793233117.882:147): pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=systemd-hwdb-update comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Oct 29 00:18:37.882000 audit: BPF prog-id=7 op=UNLOAD Oct 29 00:18:37.882000 audit: BPF prog-id=6 op=UNLOAD Oct 29 00:18:37.893555 kernel: audit: type=1334 audit(1793233117.882:148): prog-id=7 op=UNLOAD Oct 29 00:18:37.893588 kernel: audit: type=1334 audit(1793233117.882:149): prog-id=6 op=UNLOAD Oct 29 00:18:37.882000 audit: BPF prog-id=29 op=LOAD Oct 29 00:18:37.895093 kernel: audit: type=1334 audit(1793233117.882:150): prog-id=29 op=LOAD Oct 29 00:18:37.882000 audit: BPF prog-id=30 op=LOAD Oct 29 00:18:37.896471 kernel: audit: type=1334 audit(1793233117.882:151): prog-id=30 op=LOAD Oct 29 00:18:38.255978 systemd-udevd[2098]: Using default interface naming scheme 'v261'. Oct 29 00:18:38.447280 systemd[1]: Started systemd-udevd.service - Rule-based Manager for Device Events and Files. Oct 29 00:18:38.447000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=systemd-udevd comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Oct 29 00:18:38.458031 kernel: audit: type=1130 audit(1793233118.447:152): pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=systemd-udevd comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Oct 29 00:18:38.459828 systemd[1]: Starting systemd-networkd.service - Network Management... Oct 29 00:18:38.455000 audit: BPF prog-id=31 op=LOAD Oct 29 00:18:38.465742 kernel: audit: type=1334 audit(1793233118.455:153): prog-id=31 op=LOAD Oct 29 00:18:38.532077 systemd[1]: Condition check resulted in dev-ttyS0.device - /dev/ttyS0 being skipped. Oct 29 00:18:38.636830 kernel: mousedev: PS/2 mouse device common for all mice Oct 29 00:18:38.650721 kernel: hv_storvsc f8b3781a-1e82-4818-a1c3-63d806ec15bb: tag#207 cmd 0x85 status: scsi 0x2 srb 0x6 hv 0xc0000001 Oct 29 00:18:38.655696 kernel: hv_vmbus: registering driver hv_balloon Oct 29 00:18:38.659703 kernel: hv_balloon: Using Dynamic Memory protocol version 2.0 Oct 29 00:18:38.664825 systemd-networkd[2100]: lo: Link UP Oct 29 00:18:38.664834 systemd-networkd[2100]: lo: Gained carrier Oct 29 00:18:38.668692 kernel: hv_vmbus: registering driver hyperv_fb Oct 29 00:18:38.668684 systemd[1]: Started systemd-networkd.service - Network Management. Oct 29 00:18:38.670294 systemd[1]: Reached target network.target - Network. Oct 29 00:18:38.668000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=systemd-networkd comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Oct 29 00:18:38.677801 kernel: audit: type=1130 audit(1793233118.668:154): pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=systemd-networkd comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Oct 29 00:18:38.679698 kernel: hyperv_fb: Synthvid Version major 3, minor 5 Oct 29 00:18:38.680817 systemd[1]: Starting systemd-networkd-persistent-storage.service - Enable Persistent Storage in systemd-networkd... Oct 29 00:18:38.685800 kernel: hyperv_fb: Screen resolution: 1024x768, Color depth: 32, Frame buffer size: 8388608 Oct 29 00:18:38.685354 systemd-networkd[2100]: eth0: Configuring with /usr/lib/systemd/network/zz-default.network. Oct 29 00:18:38.686685 kernel: Console: switching to colour dummy device 80x25 Oct 29 00:18:38.689798 kernel: mana 7870:00:00.0 enP30832s1: Configured vPort 0 PD 18 DB 16 Oct 29 00:18:38.693371 kernel: Console: switching to colour frame buffer device 128x48 Oct 29 00:18:38.689817 systemd[1]: Starting systemd-networkd-wait-online.service - Wait for Network to be Online... Oct 29 00:18:38.698742 kernel: mana 7870:00:00.0 enP30832s1: Configured steering vPort 0 entries 64 Oct 29 00:18:38.702345 kernel: hv_netvsc f8615163-0000-1000-2000-7c1e528753a4 eth0: Data path switched to VF: enP30832s1 Oct 29 00:18:38.702093 systemd-networkd[2100]: enP30832s1: Link UP Oct 29 00:18:38.702194 systemd-networkd[2100]: eth0: Link UP Oct 29 00:18:38.702198 systemd-networkd[2100]: eth0: Gained carrier Oct 29 00:18:38.707789 systemd-networkd[2100]: enP30832s1: Gained carrier Oct 29 00:18:38.720182 systemd[1]: Condition check resulted in dev-ptp_hyperv.device - /dev/ptp_hyperv being skipped. Oct 29 00:18:38.724891 systemd-networkd[2100]: eth0: DHCPv4 address 10.0.0.4/24, gateway 10.0.0.1 acquired from 168.63.129.16 Oct 29 00:18:38.757641 systemd[1]: Finished systemd-networkd-persistent-storage.service - Enable Persistent Storage in systemd-networkd. Oct 29 00:18:38.757000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=systemd-networkd-persistent-storage comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Oct 29 00:18:38.763692 kernel: audit: type=1130 audit(1793233118.757:155): pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=systemd-networkd-persistent-storage comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Oct 29 00:18:38.778819 systemd[1]: Starting systemd-vconsole-setup.service - Virtual Console Setup... Oct 29 00:18:38.997492 systemd[1]: systemd-vconsole-setup.service: Deactivated successfully. Oct 29 00:18:38.997742 systemd[1]: Stopped systemd-vconsole-setup.service - Virtual Console Setup. Oct 29 00:18:38.999000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=systemd-vconsole-setup comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Oct 29 00:18:38.999000 audit[1]: SERVICE_STOP pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=systemd-vconsole-setup comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Oct 29 00:18:39.005090 systemd[1]: Starting systemd-vconsole-setup.service - Virtual Console Setup... Oct 29 00:18:39.068768 kernel: kvm_intel: Using Hyper-V Enlightened VMCS Oct 29 00:18:39.070684 kernel: cpu_based_exec_ctrl unsupported with eVMCS: 0x20000 Oct 29 00:18:39.294707 kernel: erofs: (device dm-5): mounted with root inode @ nid 40. Oct 29 00:18:39.314722 kernel: loop4: detected capacity change from 0 to 44465 Oct 29 00:18:39.320987 systemd[1]: Found device dev-disk-by\x2dlabel-OEM.device - MSFT NVMe Accelerator v1.0 OEM. Oct 29 00:18:39.323569 systemd[1]: Starting systemd-fsck@dev-disk-by\x2dlabel-OEM.service - File System Check on /dev/disk/by-label/OEM... Oct 29 00:18:39.384697 kernel: loop4: p1 p2 p3 Oct 29 00:18:39.398017 kernel: device-mapper: verity: sha256 using shash "sha256-ni" Oct 29 00:18:39.398075 kernel: device-mapper: verity: Unrecognized verity feature request: root_hash_sig_key_desc Oct 29 00:18:39.398091 kernel: device-mapper: table: 254:5: verity: Unrecognized verity feature request (-EINVAL) Oct 29 00:18:39.403739 kernel: device-mapper: ioctl: error adding target to table Oct 29 00:18:39.403040 (sd-merge)[2183]: device-mapper: reload ioctl on loop4p1-58-verity (254:5) failed: Invalid argument Oct 29 00:18:39.406761 kernel: device-mapper: verity: sha256 using shash "sha256-ni" Oct 29 00:18:39.430599 systemd[1]: Finished systemd-fsck@dev-disk-by\x2dlabel-OEM.service - File System Check on /dev/disk/by-label/OEM. Oct 29 00:18:39.429000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=systemd-fsck@dev-disk-by\x2dlabel-OEM comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Oct 29 00:18:39.439697 kernel: erofs: (device dm-5): mounted with root inode @ nid 40. Oct 29 00:18:39.440164 (sd-merge)[2183]: Skipping extension refresh because no change was found, use --always-refresh=yes to always do a refresh. Oct 29 00:18:39.446022 systemd[1]: Finished systemd-confext.service - Merge System Configuration Images into /etc/. Oct 29 00:18:39.444000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=systemd-confext comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Oct 29 00:18:39.449686 systemd[1]: Starting systemd-sysext.service - Merge System Extension Images into /usr/ and /opt/... Oct 29 00:18:39.462689 kernel: loop4: detected capacity change from 0 to 169096 Oct 29 00:18:39.467798 kernel: loop4: p1 p2 p3 Oct 29 00:18:39.477776 kernel: device-mapper: verity: sha256 using shash "sha256-ni" Oct 29 00:18:39.477827 kernel: device-mapper: verity: Unrecognized verity feature request: root_hash_sig_key_desc Oct 29 00:18:39.477850 kernel: device-mapper: table: 254:5: verity: Unrecognized verity feature request (-EINVAL) Oct 29 00:18:39.480168 kernel: device-mapper: ioctl: error adding target to table Oct 29 00:18:39.480301 systemd-sysext[2197]: device-mapper: reload ioctl on loop4p1-62-verity (254:5) failed: Invalid argument Oct 29 00:18:39.484783 kernel: device-mapper: verity: sha256 using shash "sha256-ni" Oct 29 00:18:39.516746 kernel: erofs: (device dm-5): mounted with root inode @ nid 39. Oct 29 00:18:39.536704 kernel: loop4: detected capacity change from 0 to 431960 Oct 29 00:18:39.542692 kernel: loop4: p1 p2 p3 Oct 29 00:18:39.547302 kernel: device-mapper: verity: sha256 using shash "sha256-ni" Oct 29 00:18:39.547348 kernel: device-mapper: verity: Unrecognized verity feature request: root_hash_sig_key_desc Oct 29 00:18:39.548650 kernel: device-mapper: table: 254:5: verity: Unrecognized verity feature request (-EINVAL) Oct 29 00:18:39.549946 kernel: device-mapper: ioctl: error adding target to table Oct 29 00:18:39.549967 systemd-sysext[2197]: device-mapper: reload ioctl on loop4p1-67-verity (254:5) failed: Invalid argument Oct 29 00:18:39.552712 kernel: device-mapper: verity: sha256 using shash "sha256-ni" Oct 29 00:18:39.594802 kernel: erofs: (device dm-5): mounted with root inode @ nid 39. Oct 29 00:18:39.619701 kernel: loop4: detected capacity change from 0 to 135808 Oct 29 00:18:39.619941 systemd-vconsole-setup[2173]: Configuration of first virtual console was skipped, ignoring remaining ones. Oct 29 00:18:39.620545 systemd[1]: Finished systemd-vconsole-setup.service - Virtual Console Setup. Oct 29 00:18:39.622000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=systemd-vconsole-setup comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Oct 29 00:18:39.626721 kernel: loop4: p1 p2 p3 Oct 29 00:18:39.632699 kernel: device-mapper: verity: sha256 using shash "sha256-ni" Oct 29 00:18:39.632738 kernel: device-mapper: verity: Unrecognized verity feature request: root_hash_sig_key_desc Oct 29 00:18:39.632763 kernel: device-mapper: table: 254:5: verity: Unrecognized verity feature request (-EINVAL) Oct 29 00:18:39.634905 kernel: device-mapper: ioctl: error adding target to table Oct 29 00:18:39.635390 systemd-sysext[2197]: device-mapper: reload ioctl on loop4p1-72-verity (254:5) failed: Invalid argument Oct 29 00:18:39.637703 kernel: device-mapper: verity: sha256 using shash "sha256-ni" Oct 29 00:18:39.668758 kernel: erofs: (device dm-5): mounted with root inode @ nid 39. Oct 29 00:18:39.687690 kernel: loop4: detected capacity change from 0 to 169096 Oct 29 00:18:39.696696 kernel: loop4: p1 p2 p3 Oct 29 00:18:39.702753 kernel: device-mapper: verity: sha256 using shash "sha256-ni" Oct 29 00:18:39.702796 kernel: device-mapper: verity: Unrecognized verity feature request: root_hash_sig_key_desc Oct 29 00:18:39.706336 kernel: device-mapper: table: 254:5: verity: Unrecognized verity feature request (-EINVAL) Oct 29 00:18:39.707938 (sd-merge)[2222]: device-mapper: reload ioctl on loop4p1-77-verity (254:5) failed: Invalid argument Oct 29 00:18:39.708693 kernel: device-mapper: ioctl: error adding target to table Oct 29 00:18:39.711745 kernel: device-mapper: verity: sha256 using shash "sha256-ni" Oct 29 00:18:39.743694 kernel: erofs: (device dm-5): mounted with root inode @ nid 39. Oct 29 00:18:39.745708 kernel: loop5: detected capacity change from 0 to 431960 Oct 29 00:18:39.751713 kernel: loop5: p1 p2 p3 Oct 29 00:18:39.756794 kernel: device-mapper: verity: sha256 using shash "sha256-ni" Oct 29 00:18:39.756844 kernel: device-mapper: verity: Unrecognized verity feature request: root_hash_sig_key_desc Oct 29 00:18:39.757956 kernel: device-mapper: table: 254:6: verity: Unrecognized verity feature request (-EINVAL) Oct 29 00:18:39.759045 kernel: device-mapper: ioctl: error adding target to table Oct 29 00:18:39.759155 (sd-merge)[2222]: device-mapper: reload ioctl on loop5p1-81-verity (254:6) failed: Invalid argument Oct 29 00:18:39.761717 kernel: device-mapper: verity: sha256 using shash "sha256-ni" Oct 29 00:18:39.802727 kernel: erofs: (device dm-6): mounted with root inode @ nid 39. Oct 29 00:18:39.805695 kernel: loop6: detected capacity change from 0 to 135808 Oct 29 00:18:39.814697 kernel: loop6: p1 p2 p3 Oct 29 00:18:39.818806 kernel: device-mapper: verity: sha256 using shash "sha256-ni" Oct 29 00:18:39.818857 kernel: device-mapper: verity: Unrecognized verity feature request: root_hash_sig_key_desc Oct 29 00:18:39.820062 kernel: device-mapper: table: 254:7: verity: Unrecognized verity feature request (-EINVAL) Oct 29 00:18:39.821073 kernel: device-mapper: ioctl: error adding target to table Oct 29 00:18:39.821358 (sd-merge)[2222]: device-mapper: reload ioctl on loop6p1-85-verity (254:7) failed: Invalid argument Oct 29 00:18:39.823696 kernel: device-mapper: verity: sha256 using shash "sha256-ni" Oct 29 00:18:39.860487 (sd-merge)[2222]: Skipping extension refresh because no change was found, use --always-refresh=yes to always do a refresh. Oct 29 00:18:39.860814 kernel: erofs: (device dm-7): mounted with root inode @ nid 39. Oct 29 00:18:39.862494 systemd[1]: Finished systemd-sysext.service - Merge System Extension Images into /usr/ and /opt/. Oct 29 00:18:39.862000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=systemd-sysext comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Oct 29 00:18:39.866955 systemd[1]: Starting systemd-tmpfiles-setup.service - Create System Files and Directories... Oct 29 00:18:39.906040 systemd-tmpfiles[2244]: /usr/lib/tmpfiles.d/nfs-utils.conf:6: Duplicate line for path "/var/lib/nfs/sm", ignoring. Oct 29 00:18:39.906070 systemd-tmpfiles[2244]: /usr/lib/tmpfiles.d/nfs-utils.conf:7: Duplicate line for path "/var/lib/nfs/sm.bak", ignoring. Oct 29 00:18:39.906295 systemd-tmpfiles[2244]: /usr/lib/tmpfiles.d/provision.conf:20: Duplicate line for path "/root", ignoring. Oct 29 00:18:39.907172 systemd-tmpfiles[2244]: ACLs are not supported, ignoring. Oct 29 00:18:39.907228 systemd-tmpfiles[2244]: ACLs are not supported, ignoring. Oct 29 00:18:39.909538 systemd-tmpfiles[2244]: Detected autofs mount point '/boot' during canonicalization of 'boot'. Oct 29 00:18:39.909549 systemd-tmpfiles[2244]: Skipping /boot Oct 29 00:18:39.913859 systemd-tmpfiles[2244]: Detected autofs mount point '/boot' during canonicalization of 'boot'. Oct 29 00:18:39.913871 systemd-tmpfiles[2244]: Skipping /boot Oct 29 00:18:39.920819 systemd[1]: Finished systemd-tmpfiles-setup.service - Create System Files and Directories. Oct 29 00:18:39.922000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=systemd-tmpfiles-setup comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Oct 29 00:18:39.928813 systemd[1]: Starting audit-rules.service - Load Audit Rules... Oct 29 00:18:39.938815 systemd[1]: Starting clean-ca-certificates.service - Clean up broken links in /etc/ssl/certs... Oct 29 00:18:39.943811 systemd[1]: Starting ldconfig.service - Rebuild Dynamic Linker Cache... Oct 29 00:18:39.947828 systemd[1]: Starting systemd-journal-catalog-update.service - Rebuild Journal Catalog... Oct 29 00:18:39.955879 systemd[1]: Starting systemd-update-utmp.service - Record System Boot/Shutdown in UTMP... Oct 29 00:18:39.977000 audit[2251]: AUDIT1127 pid=2251 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg=' comm="systemd-update-utmp" exe="/usr/lib/systemd/systemd-update-utmp" hostname=? addr=? terminal=? res=success' Oct 29 00:18:39.982098 systemd[1]: Finished systemd-update-utmp.service - Record System Boot/Shutdown in UTMP. Oct 29 00:18:39.983000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=systemd-update-utmp comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Oct 29 00:18:40.161314 systemd[1]: Finished systemd-journal-catalog-update.service - Rebuild Journal Catalog. Oct 29 00:18:40.161000 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' Oct 29 00:18:40.238000 audit: CONFIG_CHANGE auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 op=add_rule key=(null) list=5 res=1 Oct 29 00:18:40.238000 audit[2275]: SYSCALL arch=c000003e syscall=44 success=yes exit=1056 a0=3 a1=7ffda2a17c60 a2=420 a3=0 items=0 ppid=2247 pid=2275 auid=4294967295 uid=0 gid=0 euid=0 suid=0 fsuid=0 egid=0 sgid=0 fsgid=0 tty=(none) ses=4294967295 comm="auditctl" exe="/usr/bin/auditctl" subj=system_u:system_r:kernel_t:s0 key=(null) Oct 29 00:18:40.238000 audit: PROCTITLE proctitle=2F7362696E2F617564697463746C002D52002F6574632F61756469742F61756469742E72756C6573 Oct 29 00:18:40.240300 augenrules[2275]: No rules Oct 29 00:18:40.240880 systemd[1]: audit-rules.service: Deactivated successfully. Oct 29 00:18:40.241148 systemd[1]: Finished audit-rules.service - Load Audit Rules. Oct 29 00:18:40.406595 systemd[1]: Finished clean-ca-certificates.service - Clean up broken links in /etc/ssl/certs. Oct 29 00:18:40.409947 systemd[1]: update-ca-certificates.service - Update CA bundle at /etc/ssl/certs/ca-certificates.crt skipped, unmet condition check ConditionPathIsSymbolicLink=!/etc/ssl/certs/ca-certificates.crt Oct 29 00:18:40.503903 systemd-networkd[2100]: eth0: Gained IPv6LL Oct 29 00:18:40.505566 systemd[1]: Finished systemd-networkd-wait-online.service - Wait for Network to be Online. Oct 29 00:18:40.509924 systemd[1]: Reached target network-online.target - Network is Online. Oct 29 00:18:47.289749 ldconfig[2249]: ldconfig: /usr/lib/ld.so.conf is not an ELF file - it has the wrong magic bytes at the start. Oct 29 00:18:47.302607 systemd[1]: Finished ldconfig.service - Rebuild Dynamic Linker Cache. Oct 29 00:18:47.307198 systemd[1]: Starting systemd-update-done.service - Update is Completed... Oct 29 00:18:47.326813 systemd[1]: Finished systemd-update-done.service - Update is Completed. Oct 29 00:18:47.329901 systemd[1]: Reached target sysinit.target - System Initialization. Oct 29 00:18:47.331074 systemd[1]: Started motdgen.path - Watch for update engine configuration changes. Oct 29 00:18:47.332506 systemd[1]: Started user-cloudinit@var-lib-flatcar\x2dinstall-user_data.path - Watch for a cloud-config at /var/lib/flatcar-install/user_data. Oct 29 00:18:47.335727 systemd[1]: Started google-oslogin-cache.timer - NSS cache refresh timer. Oct 29 00:18:47.338854 systemd[1]: Started logrotate.timer - Daily rotation of log files. Oct 29 00:18:47.341824 systemd[1]: Started mdadm.timer - Weekly check for MD array's redundancy information.. Oct 29 00:18:47.344752 systemd[1]: Started systemd-sysupdate-reboot.timer - Reboot Automatically After System Update. Oct 29 00:18:47.347768 systemd[1]: Started systemd-sysupdate.timer - Automatic System Update. Oct 29 00:18:47.350717 systemd[1]: Started systemd-tmpfiles-clean.timer - Daily Cleanup of Temporary Directories. Oct 29 00:18:47.353720 systemd[1]: update-engine-stub.timer - Update Engine Stub Timer skipped, unmet condition check ConditionPathExists=/usr/.noupdate Oct 29 00:18:47.353758 systemd[1]: Reached target paths.target - Path Units. Oct 29 00:18:47.355716 systemd[1]: Reached target timers.target - Timer Units. Oct 29 00:18:47.374166 systemd[1]: Listening on dbus.socket - D-Bus System Message Bus Socket. Oct 29 00:18:47.377713 systemd[1]: Starting docker.socket - Docker Socket for the API... Oct 29 00:18:47.380119 systemd[1]: Listening on sshd-unix-local.socket - OpenSSH Server Socket (systemd-ssh-generator, AF_UNIX Local). Oct 29 00:18:47.387944 systemd[1]: Listening on sshd.socket - OpenSSH Server Socket. Oct 29 00:18:47.389392 systemd[1]: Listening on systemd-logind-varlink.socket - User Login Management Varlink Socket. Oct 29 00:18:47.392935 systemd[1]: Listening on systemd-machined.socket - Virtual Machine and Container Registration Service Socket. Oct 29 00:18:47.396239 systemd[1]: Listening on docker.socket - Docker Socket for the API. Oct 29 00:18:47.399539 systemd[1]: Reached target sockets.target - Socket Units. Oct 29 00:18:47.400860 systemd[1]: Reached target basic.target - Basic System. Oct 29 00:18:47.403768 systemd[1]: addon-config@oem.service - Configure Addon /oem skipped, no trigger condition checks were met. Oct 29 00:18:47.403796 systemd[1]: addon-run@oem.service - Run Addon /oem skipped, no trigger condition checks were met. Oct 29 00:18:47.405398 systemd[1]: Starting chronyd.service - NTP client/server... Oct 29 00:18:47.408635 systemd[1]: Starting containerd.service - containerd container runtime... Oct 29 00:18:47.416562 systemd[1]: Starting dbus.service - D-Bus System Message Bus... Oct 29 00:18:47.422166 systemd[1]: Starting dracut-shutdown.service - Restore /run/initramfs on shutdown... Oct 29 00:18:47.426780 systemd[1]: Starting enable-oem-cloudinit.service - Enable cloudinit... Oct 29 00:18:47.433800 systemd[1]: Starting extend-filesystems.service - Extend Filesystems... Oct 29 00:18:47.435432 systemd[1]: flatcar-setup-environment.service - Modifies /etc/environment for CoreOS skipped, unmet condition check ConditionPathExists=/oem/bin/flatcar-setup-environment Oct 29 00:18:47.440800 systemd[1]: Starting google-oslogin-cache.service - NSS cache refresh... Oct 29 00:18:47.444546 jq[2296]: false Oct 29 00:18:47.444787 systemd[1]: hv_fcopy_uio_daemon.service - Hyper-V FCOPY UIO daemon skipped, unmet condition check ConditionPathExists=/sys/bus/vmbus/devices/eb765408-105f-49b6-b4aa-c123b64d17d4/uio Oct 29 00:18:47.445836 systemd[1]: Started hv_kvp_daemon.service - Hyper-V KVP daemon. Oct 29 00:18:47.449835 systemd[1]: hv_vss_daemon.service - Hyper-V VSS daemon skipped, unmet condition check ConditionPathExists=/dev/vmbus/hv_vss Oct 29 00:18:47.451121 systemd[1]: Starting motdgen.service - Generate /run/flatcar/motd... Oct 29 00:18:47.456106 systemd[1]: Starting nvidia.service - NVIDIA Configure Service... Oct 29 00:18:47.466004 systemd[1]: Starting ssh-key-proc-cmdline.service - Install an ssh key from /proc/cmdline... Oct 29 00:18:47.471382 KVP[2299]: KVP starting; pid is:2299 Oct 29 00:18:47.472813 systemd[1]: Starting sshd-keygen.service - Generate sshd host keys... Oct 29 00:18:47.481432 KVP[2299]: KVP LIC Version: 3.1 Oct 29 00:18:47.481729 kernel: hv_utils: KVP IC version 4.0 Oct 29 00:18:47.483133 systemd[1]: Starting systemd-logind.service - User Login Management... Oct 29 00:18:47.484955 systemd[1]: tcsd.service - TCG Core Services Daemon skipped, unmet condition check ConditionPathExists=/dev/tpm0 Oct 29 00:18:47.488324 systemd[1]: Starting update-engine.service - Update Engine... Oct 29 00:18:47.491793 systemd[1]: Starting update-ssh-keys-after-ignition.service - Run update-ssh-keys once after Ignition... Oct 29 00:18:47.502156 systemd[1]: Finished dracut-shutdown.service - Restore /run/initramfs on shutdown. Oct 29 00:18:47.506143 systemd[1]: enable-oem-cloudinit.service: Skipped due to 'exec-condition'. Oct 29 00:18:47.506368 systemd[1]: Condition check resulted in enable-oem-cloudinit.service - Enable cloudinit being skipped. Oct 29 00:18:47.508542 extend-filesystems[2297]: Found /dev/nvme0n1p6 Oct 29 00:18:47.508953 systemd[1]: ssh-key-proc-cmdline.service: Deactivated successfully. Oct 29 00:18:47.509862 systemd[1]: Finished ssh-key-proc-cmdline.service - Install an ssh key from /proc/cmdline. Oct 29 00:18:47.536869 extend-filesystems[2297]: Found /dev/nvme0n1p9 Oct 29 00:18:47.539909 google_oslogin_nss_cache[2298]: oslogin_cache_refresh[2298]: Refreshing passwd entry cache Oct 29 00:18:47.538388 oslogin_cache_refresh[2298]: Refreshing passwd entry cache Oct 29 00:18:47.542579 jq[2311]: true Oct 29 00:18:47.546512 extend-filesystems[2297]: Checking size of /dev/nvme0n1p9 Oct 29 00:18:47.546470 chronyd[2292]: chronyd version 4.8 starting (+CMDMON +REFCLOCK +RTC +PRIVDROP +SCFILTER -SIGND +NTS +SECHASH +IPV6 -DEBUG) Oct 29 00:18:47.549337 motdgen[2334]: /oem/oem-release: line 2: Azure: command not found Oct 29 00:18:47.560753 systemd[1]: motdgen.service: Deactivated successfully. Oct 29 00:18:47.564791 oslogin_cache_refresh[2298]: Failure getting users, quitting Oct 29 00:18:47.563536 systemd[1]: Finished motdgen.service - Generate /run/flatcar/motd. Oct 29 00:18:47.574449 google_oslogin_nss_cache[2298]: oslogin_cache_refresh[2298]: Failure getting users, quitting Oct 29 00:18:47.574449 google_oslogin_nss_cache[2298]: oslogin_cache_refresh[2298]: Produced empty passwd cache file, removing /etc/oslogin_passwd.cache.bak. Oct 29 00:18:47.574449 google_oslogin_nss_cache[2298]: oslogin_cache_refresh[2298]: Refreshing group entry cache Oct 29 00:18:47.574510 jq[2332]: true Oct 29 00:18:47.564808 oslogin_cache_refresh[2298]: Produced empty passwd cache file, removing /etc/oslogin_passwd.cache.bak. Oct 29 00:18:47.565904 systemd[1]: Finished nvidia.service - NVIDIA Configure Service. Oct 29 00:18:47.564847 oslogin_cache_refresh[2298]: Refreshing group entry cache Oct 29 00:18:47.582119 google_oslogin_nss_cache[2298]: oslogin_cache_refresh[2298]: Failure getting groups, quitting Oct 29 00:18:47.582119 google_oslogin_nss_cache[2298]: oslogin_cache_refresh[2298]: Produced empty group cache file, removing /etc/oslogin_group.cache.bak. Oct 29 00:18:47.582115 oslogin_cache_refresh[2298]: Failure getting groups, quitting Oct 29 00:18:47.582125 oslogin_cache_refresh[2298]: Produced empty group cache file, removing /etc/oslogin_group.cache.bak. Oct 29 00:18:47.584392 systemd[1]: google-oslogin-cache.service: Deactivated successfully. Oct 29 00:18:47.584713 systemd[1]: Finished google-oslogin-cache.service - NSS cache refresh. Oct 29 00:18:47.587923 chronyd[2292]: Timezone right/UTC failed leap second check, ignoring Oct 29 00:18:47.588068 chronyd[2292]: Loaded seccomp filter (level 2) Oct 29 00:18:47.588247 systemd[1]: Started chronyd.service - NTP client/server. Oct 29 00:18:47.602853 extend-filesystems[2297]: Resized partition /dev/nvme0n1p9 Oct 29 00:18:47.620985 extend-filesystems[2368]: resize2fs 1.47.4 (6-Mar-2025) Oct 29 00:18:47.635834 update_engine[2310]: I20261029 00:18:47.635777 2310 main.cc:92] Flatcar Update Engine starting Oct 29 00:18:47.682666 systemd-logind[2308]: New seat seat0. Oct 29 00:18:47.684248 systemd-logind[2308]: Watching system buttons on /dev/input/event1 (AT Translated Set 2 keyboard) Oct 29 00:18:47.689005 systemd[1]: Started systemd-logind.service - User Login Management. Oct 29 00:18:47.693700 kernel: EXT4-fs (nvme0n1p9): resizing filesystem from 6359552 to 6376955 blocks Oct 29 00:18:47.696712 kernel: EXT4-fs (nvme0n1p9): resized filesystem to 6376955 Oct 29 00:18:48.077846 sshd_keygen[2347]: ssh-keygen: generating new host keys: RSA ECDSA ED25519 MLDSA44-ED25519 Oct 29 00:18:48.106399 systemd[1]: Finished sshd-keygen.service - Generate sshd host keys. Oct 29 00:18:48.109944 systemd[1]: Starting issuegen.service - Generate /run/issue... Oct 29 00:18:48.112820 systemd[1]: Starting waagent.service - Microsoft Azure Linux Agent... Oct 29 00:18:48.124168 systemd[1]: issuegen.service: Deactivated successfully. Oct 29 00:18:48.124523 systemd[1]: Finished issuegen.service - Generate /run/issue. Oct 29 00:18:48.132831 systemd[1]: Starting systemd-user-sessions.service - Permit User Sessions... Oct 29 00:18:48.142158 systemd[1]: Started waagent.service - Microsoft Azure Linux Agent. Oct 29 00:18:48.187033 extend-filesystems[2368]: Filesystem at /dev/nvme0n1p9 is mounted on /; on-line resizing required Oct 29 00:18:48.187033 extend-filesystems[2368]: old_desc_blocks = 4, new_desc_blocks = 4 Oct 29 00:18:48.187033 extend-filesystems[2368]: The filesystem on /dev/nvme0n1p9 is now 6376955 (4k) blocks long. Oct 29 00:18:48.196226 extend-filesystems[2297]: Resized filesystem in /dev/nvme0n1p9 Oct 29 00:18:48.197328 systemd[1]: extend-filesystems.service: Deactivated successfully. Oct 29 00:18:48.197585 systemd[1]: Finished extend-filesystems.service - Extend Filesystems. Oct 29 00:18:48.206085 bash[2364]: Updated "/home/core/.ssh/authorized_keys" Oct 29 00:18:48.207084 systemd[1]: Finished update-ssh-keys-after-ignition.service - Run update-ssh-keys once after Ignition. Oct 29 00:18:48.210114 systemd[1]: sshkeys.service skipped, no trigger condition checks were met. Oct 29 00:18:48.235182 systemd[1]: Finished systemd-user-sessions.service - Permit User Sessions. Oct 29 00:18:48.239889 systemd[1]: Started getty@tty1.service - Getty on tty1. Oct 29 00:18:48.245040 systemd[1]: Started serial-getty@ttyS0.service - Serial Getty on ttyS0. Oct 29 00:18:48.247805 systemd[1]: Reached target getty.target - Login Prompts. Oct 29 00:18:48.282808 dbus-daemon[2294]: [system] SELinux support is enabled Oct 29 00:18:48.283216 systemd[1]: Started dbus.service - D-Bus System Message Bus. Oct 29 00:18:48.285107 systemd[1]: system-cloudinit@usr-share-coreos-cloud\x2dconfig.yml.service - Load cloud-config from /usr/share/coreos/cloud-config.yml skipped, unmet condition check ConditionFileNotEmpty=/usr/share/coreos/cloud-config.yml Oct 29 00:18:48.285136 systemd[1]: Reached target system-config.target - Load system-provided cloud configs. Oct 29 00:18:48.290170 update_engine[2310]: I20261029 00:18:48.290064 2310 update_check_scheduler.cc:74] Next update check in 5m38s Oct 29 00:18:48.287547 systemd[1]: user-cloudinit-proc-cmdline.service - Load cloud-config from url defined in /proc/cmdline skipped, unmet condition check ConditionKernelCommandLine=cloud-config-url Oct 29 00:18:48.287567 systemd[1]: Reached target user-config.target - Load user-provided cloud configs. Oct 29 00:18:48.294346 systemd[1]: Started update-engine.service - Update Engine. Oct 29 00:18:48.294470 dbus-daemon[2294]: [system] Successfully activated service 'org.freedesktop.systemd1' Oct 29 00:18:48.298026 systemd[1]: Started locksmithd.service - Cluster reboot manager. Oct 29 00:18:48.719411 locksmithd[2421]: locksmithd starting currentOperation="UPDATE_STATUS_IDLE" strategy="reboot" Oct 29 00:18:50.900607 containerd[2329]: time="2026-10-29T00:18:50Z" level=warning msg="Ignoring unknown key in TOML" column=1 error="strict mode: fields in the document are missing in the target struct" file=/usr/share/containerd/config.toml key=subreaper row=8 Oct 29 00:18:50.901016 containerd[2329]: time="2026-10-29T00:18:50Z" level=warning msg="Configuration migrated from version 2, use `containerd config migrate` to avoid migration" t="27.005µs" Oct 29 00:18:50.902878 containerd[2329]: time="2026-10-29T00:18:50.902747441Z" level=info msg="starting containerd" revision=db8809540e1a7a9da5d518876894933ff55692ab version=v2.3.4 Oct 29 00:18:50.903124 containerd[2329]: time="2026-10-29T00:18:50.903091318Z" level=info msg="loading plugin" id=io.containerd.content.v1.content type=io.containerd.content.v1 Oct 29 00:18:50.903279 containerd[2329]: time="2026-10-29T00:18:50.903258111Z" level=warning msg="failed check for fsverity support" error="enable fsverity failed: operation not supported" path=/var/lib/containerd/io.containerd.content.v1.content Oct 29 00:18:50.903322 containerd[2329]: time="2026-10-29T00:18:50.903278526Z" level=info msg="loading plugin" id=io.containerd.image-verifier.v1.bindir type=io.containerd.image-verifier.v1 Oct 29 00:18:50.903322 containerd[2329]: time="2026-10-29T00:18:50.903290581Z" level=info msg="loading plugin" id=io.containerd.internal.v1.opt type=io.containerd.internal.v1 Oct 29 00:18:50.903425 containerd[2329]: time="2026-10-29T00:18:50.903410190Z" level=info msg="loading plugin" id=io.containerd.warning.v1.deprecations type=io.containerd.warning.v1 Oct 29 00:18:50.903454 containerd[2329]: time="2026-10-29T00:18:50.903425152Z" level=info msg="loading plugin" id=io.containerd.event.v1.exchange type=io.containerd.event.v1 Oct 29 00:18:50.903623 containerd[2329]: time="2026-10-29T00:18:50.903606017Z" level=info msg="loading plugin" id=io.containerd.mount-handler.v1.erofs type=io.containerd.mount-handler.v1 Oct 29 00:18:50.903650 containerd[2329]: time="2026-10-29T00:18:50.903624804Z" level=info msg="loading plugin" id=io.containerd.snapshotter.v1.blockfile type=io.containerd.snapshotter.v1 Oct 29 00:18:50.903698 containerd[2329]: time="2026-10-29T00:18:50.903688999Z" level=info msg="skip loading plugin" error="no scratch file generator: skip plugin" id=io.containerd.snapshotter.v1.blockfile type=io.containerd.snapshotter.v1 Oct 29 00:18:50.903719 containerd[2329]: time="2026-10-29T00:18:50.903699858Z" level=info msg="loading plugin" id=io.containerd.snapshotter.v1.btrfs type=io.containerd.snapshotter.v1 Oct 29 00:18:50.903884 containerd[2329]: time="2026-10-29T00:18:50.903864968Z" level=info msg="skip loading plugin" error="path /var/lib/containerd/io.containerd.snapshotter.v1.btrfs (ext4) must be a btrfs filesystem to be used with the btrfs snapshotter: skip plugin" id=io.containerd.snapshotter.v1.btrfs type=io.containerd.snapshotter.v1 Oct 29 00:18:50.903884 containerd[2329]: time="2026-10-29T00:18:50.903880232Z" level=info msg="loading plugin" id=io.containerd.snapshotter.v1.devmapper type=io.containerd.snapshotter.v1 Oct 29 00:18:50.903940 containerd[2329]: time="2026-10-29T00:18:50.903891061Z" level=info msg="skip loading plugin" error="devmapper not configured: skip plugin" id=io.containerd.snapshotter.v1.devmapper type=io.containerd.snapshotter.v1 Oct 29 00:18:50.903940 containerd[2329]: time="2026-10-29T00:18:50.903907044Z" level=info msg="loading plugin" id=io.containerd.snapshotter.v1.erofs type=io.containerd.snapshotter.v1 Oct 29 00:18:50.904063 containerd[2329]: time="2026-10-29T00:18:50.904048119Z" level=info msg="loading plugin" id=io.containerd.snapshotter.v1.native type=io.containerd.snapshotter.v1 Oct 29 00:18:50.904126 containerd[2329]: time="2026-10-29T00:18:50.904099301Z" level=info msg="loading plugin" id=io.containerd.snapshotter.v1.overlayfs type=io.containerd.snapshotter.v1 Oct 29 00:18:50.904246 containerd[2329]: time="2026-10-29T00:18:50.904230289Z" level=info msg="loading plugin" id=io.containerd.snapshotter.v1.zfs type=io.containerd.snapshotter.v1 Oct 29 00:18:50.904273 containerd[2329]: time="2026-10-29T00:18:50.904252375Z" level=info msg="skip loading plugin" error="lstat /var/lib/containerd/io.containerd.snapshotter.v1.zfs: no such file or directory: skip plugin" id=io.containerd.snapshotter.v1.zfs type=io.containerd.snapshotter.v1 Oct 29 00:18:50.904273 containerd[2329]: time="2026-10-29T00:18:50.904261624Z" level=info msg="loading plugin" id=io.containerd.monitor.task.v1.cgroups type=io.containerd.monitor.task.v1 Oct 29 00:18:50.905100 containerd[2329]: time="2026-10-29T00:18:50.904735672Z" level=info msg="loading plugin" id=io.containerd.metadata.v1.bolt type=io.containerd.metadata.v1 Oct 29 00:18:50.905100 containerd[2329]: time="2026-10-29T00:18:50.904802948Z" level=info msg="metadata content store policy set" policy=shared Oct 29 00:18:50.924319 containerd[2329]: time="2026-10-29T00:18:50.924286014Z" level=info msg="loading plugin" id=io.containerd.gc.v1.scheduler type=io.containerd.gc.v1 Oct 29 00:18:50.924383 containerd[2329]: time="2026-10-29T00:18:50.924356068Z" level=info msg="loading plugin" id=io.containerd.server.v1.metrics type=io.containerd.server.v1 Oct 29 00:18:50.924383 containerd[2329]: time="2026-10-29T00:18:50.924373899Z" level=info msg="skip loading plugin" error="skip plugin" id=io.containerd.server.v1.metrics type=io.containerd.server.v1 Oct 29 00:18:50.924429 containerd[2329]: time="2026-10-29T00:18:50.924383601Z" level=info msg="loading plugin" id=io.containerd.tracing.processor.v1.otlp type=io.containerd.tracing.processor.v1 Oct 29 00:18:50.924429 containerd[2329]: time="2026-10-29T00:18:50.924396606Z" level=info msg="skip loading plugin" error="skip plugin: tracing endpoint not configured" id=io.containerd.tracing.processor.v1.otlp type=io.containerd.tracing.processor.v1 Oct 29 00:18:50.924429 containerd[2329]: time="2026-10-29T00:18:50.924406702Z" level=info msg="loading plugin" id=io.containerd.internal.v1.tracing type=io.containerd.internal.v1 Oct 29 00:18:50.924500 containerd[2329]: time="2026-10-29T00:18:50.924417437Z" level=info msg="skip loading plugin" error="skip plugin: tracing endpoint not configured" id=io.containerd.internal.v1.tracing type=io.containerd.internal.v1 Oct 29 00:18:50.924500 containerd[2329]: time="2026-10-29T00:18:50.924438045Z" level=info msg="loading plugin" id=io.containerd.nri.v1.nri type=io.containerd.nri.v1 Oct 29 00:18:50.925123 containerd[2329]: time="2026-10-29T00:18:50.925104006Z" level=info msg="built-in NRI default validator is disabled" Oct 29 00:18:50.925123 containerd[2329]: time="2026-10-29T00:18:50.925120401Z" level=info msg="runtime interface created" Oct 29 00:18:50.925200 containerd[2329]: time="2026-10-29T00:18:50.925126603Z" level=info msg="created NRI interface" Oct 29 00:18:50.925200 containerd[2329]: time="2026-10-29T00:18:50.925134291Z" level=info msg="loading plugin" id=io.containerd.ttrpc.v1.otelttrpc type=io.containerd.ttrpc.v1 Oct 29 00:18:50.925200 containerd[2329]: time="2026-10-29T00:18:50.925146697Z" level=info msg="loading plugin" id=io.containerd.service.v1.containers-service type=io.containerd.service.v1 Oct 29 00:18:50.925200 containerd[2329]: time="2026-10-29T00:18:50.925161328Z" level=info msg="loading plugin" id=io.containerd.service.v1.content-service type=io.containerd.service.v1 Oct 29 00:18:50.925200 containerd[2329]: time="2026-10-29T00:18:50.925171608Z" level=info msg="loading plugin" id=io.containerd.differ.v1.erofs type=io.containerd.differ.v1 Oct 29 00:18:50.961139 containerd[2329]: time="2026-10-29T00:18:50.960495636Z" level=info msg="loading plugin" id=io.containerd.mount-manager.v1.bolt type=io.containerd.mount-manager.v1 Oct 29 00:18:50.961139 containerd[2329]: time="2026-10-29T00:18:50.960639209Z" level=info msg="loading plugin" id=io.containerd.differ.v1.walking type=io.containerd.differ.v1 Oct 29 00:18:50.961139 containerd[2329]: time="2026-10-29T00:18:50.960690647Z" level=info msg="loading plugin" id=io.containerd.service.v1.diff-service type=io.containerd.service.v1 Oct 29 00:18:50.961139 containerd[2329]: time="2026-10-29T00:18:50.960704298Z" level=info msg="loading plugin" id=io.containerd.service.v1.images-service type=io.containerd.service.v1 Oct 29 00:18:50.961139 containerd[2329]: time="2026-10-29T00:18:50.960716498Z" level=info msg="loading plugin" id=io.containerd.service.v1.introspection-service type=io.containerd.service.v1 Oct 29 00:18:50.961139 containerd[2329]: time="2026-10-29T00:18:50.960737984Z" level=info msg="loading plugin" id=io.containerd.service.v1.namespaces-service type=io.containerd.service.v1 Oct 29 00:18:50.961139 containerd[2329]: time="2026-10-29T00:18:50.960744827Z" level=info msg="loading plugin" id=io.containerd.service.v1.snapshots-service type=io.containerd.service.v1 Oct 29 00:18:50.961139 containerd[2329]: time="2026-10-29T00:18:50.960755936Z" level=info msg="loading plugin" id=io.containerd.shim.v1.manager type=io.containerd.shim.v1 Oct 29 00:18:50.961139 containerd[2329]: time="2026-10-29T00:18:50.960764949Z" level=info msg="loading plugin" id=io.containerd.runtime.v2.task type=io.containerd.runtime.v2 Oct 29 00:18:50.961139 containerd[2329]: time="2026-10-29T00:18:50.960853070Z" level=info msg="loading plugin" id=io.containerd.service.v1.tasks-service type=io.containerd.service.v1 Oct 29 00:18:50.961139 containerd[2329]: time="2026-10-29T00:18:50.960881523Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.containers type=io.containerd.grpc.v1 Oct 29 00:18:50.961139 containerd[2329]: time="2026-10-29T00:18:50.960894781Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.content type=io.containerd.grpc.v1 Oct 29 00:18:50.961139 containerd[2329]: time="2026-10-29T00:18:50.960903004Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.diff type=io.containerd.grpc.v1 Oct 29 00:18:50.961139 containerd[2329]: time="2026-10-29T00:18:50.960920478Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.events type=io.containerd.grpc.v1 Oct 29 00:18:50.961474 containerd[2329]: time="2026-10-29T00:18:50.960938742Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.images type=io.containerd.grpc.v1 Oct 29 00:18:50.961474 containerd[2329]: time="2026-10-29T00:18:50.960956758Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.introspection type=io.containerd.grpc.v1 Oct 29 00:18:50.961474 containerd[2329]: time="2026-10-29T00:18:50.960967636Z" level=info msg="loading plugin" id=io.containerd.lease.v1.manager type=io.containerd.lease.v1 Oct 29 00:18:50.961474 containerd[2329]: time="2026-10-29T00:18:50.960977206Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.leases type=io.containerd.grpc.v1 Oct 29 00:18:50.961474 containerd[2329]: time="2026-10-29T00:18:50.960987097Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.mounts type=io.containerd.grpc.v1 Oct 29 00:18:50.961474 containerd[2329]: time="2026-10-29T00:18:50.960995682Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.namespaces type=io.containerd.grpc.v1 Oct 29 00:18:50.961474 containerd[2329]: time="2026-10-29T00:18:50.961020962Z" level=info msg="loading plugin" id=io.containerd.sandbox.store.v1.local type=io.containerd.sandbox.store.v1 Oct 29 00:18:50.961474 containerd[2329]: time="2026-10-29T00:18:50.961032085Z" level=info msg="loading plugin" id=io.containerd.transfer.v1.local type=io.containerd.transfer.v1 Oct 29 00:18:50.961474 containerd[2329]: time="2026-10-29T00:18:50.961079143Z" level=info msg="loading plugin" id=io.containerd.cri.v1.images type=io.containerd.cri.v1 Oct 29 00:18:50.962359 containerd[2329]: time="2026-10-29T00:18:50.961803360Z" level=info msg="Get image filesystem path \"/var/lib/containerd/io.containerd.snapshotter.v1.overlayfs\" for snapshotter \"overlayfs\"" Oct 29 00:18:50.962430 containerd[2329]: time="2026-10-29T00:18:50.962361815Z" level=info msg="Start snapshots syncer" Oct 29 00:18:50.962430 containerd[2329]: time="2026-10-29T00:18:50.962382115Z" level=info msg="loading plugin" id=io.containerd.cri.v1.runtime type=io.containerd.cri.v1 Oct 29 00:18:50.962774 containerd[2329]: time="2026-10-29T00:18:50.962743308Z" 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\":\"\",\"enableCRIU\":true,\"enableExperimentalRestoreViaCreate\":false,\"containerdRootDir\":\"/var/lib/containerd\",\"containerdEndpoint\":\"/run/containerd/containerd.sock\",\"rootDir\":\"/var/lib/containerd/io.containerd.grpc.v1.cri\",\"stateDir\":\"/run/containerd/io.containerd.grpc.v1.cri\"}" Oct 29 00:18:50.962902 containerd[2329]: time="2026-10-29T00:18:50.962792154Z" level=info msg="loading plugin" id=io.containerd.podsandbox.controller.v1.podsandbox type=io.containerd.podsandbox.controller.v1 Oct 29 00:18:50.962902 containerd[2329]: time="2026-10-29T00:18:50.962844934Z" level=info msg="loading plugin" id=io.containerd.sandbox.controller.v1.shim type=io.containerd.sandbox.controller.v1 Oct 29 00:18:50.962963 containerd[2329]: time="2026-10-29T00:18:50.962944597Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.sandbox-controllers type=io.containerd.grpc.v1 Oct 29 00:18:50.962993 containerd[2329]: time="2026-10-29T00:18:50.962970236Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.sandboxes type=io.containerd.grpc.v1 Oct 29 00:18:50.962993 containerd[2329]: time="2026-10-29T00:18:50.962980583Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.snapshots type=io.containerd.grpc.v1 Oct 29 00:18:50.962993 containerd[2329]: time="2026-10-29T00:18:50.962989212Z" level=info msg="loading plugin" id=io.containerd.streaming.v1.manager type=io.containerd.streaming.v1 Oct 29 00:18:50.963068 containerd[2329]: time="2026-10-29T00:18:50.963000522Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.streaming type=io.containerd.grpc.v1 Oct 29 00:18:50.963068 containerd[2329]: time="2026-10-29T00:18:50.963013742Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.tasks type=io.containerd.grpc.v1 Oct 29 00:18:50.963068 containerd[2329]: time="2026-10-29T00:18:50.963024506Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.transfer type=io.containerd.grpc.v1 Oct 29 00:18:50.963068 containerd[2329]: time="2026-10-29T00:18:50.963035446Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.version type=io.containerd.grpc.v1 Oct 29 00:18:50.963068 containerd[2329]: time="2026-10-29T00:18:50.963043838Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.healthcheck type=io.containerd.grpc.v1 Oct 29 00:18:50.963068 containerd[2329]: time="2026-10-29T00:18:50.963053742Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.cri type=io.containerd.grpc.v1 Oct 29 00:18:50.963215 containerd[2329]: time="2026-10-29T00:18:50.963083598Z" level=info msg="Connect containerd service" Oct 29 00:18:50.963215 containerd[2329]: time="2026-10-29T00:18:50.963106014Z" level=info msg="using experimental NRI integration - disable nri plugin to prevent this" Oct 29 00:18:50.964574 containerd[2329]: time="2026-10-29T00:18:50.964541929Z" 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" Oct 29 00:18:51.828354 containerd[2329]: time="2026-10-29T00:18:51.828293881Z" level=info msg="loading plugin" id=io.containerd.server.v1.ttrpc type=io.containerd.server.v1 Oct 29 00:18:51.828503 containerd[2329]: time="2026-10-29T00:18:51.828409273Z" level=info msg="loading plugin" id=io.containerd.monitor.container.v1.restart type=io.containerd.monitor.container.v1 Oct 29 00:18:51.828503 containerd[2329]: time="2026-10-29T00:18:51.828446414Z" level=info msg="loading plugin" id=io.containerd.metrics.v1.grpc-prometheus type=io.containerd.metrics.v1 Oct 29 00:18:51.828503 containerd[2329]: time="2026-10-29T00:18:51.828488414Z" level=info msg="loading plugin" id=io.containerd.metrics.v1.grpc-otel type=io.containerd.metrics.v1 Oct 29 00:18:51.828570 containerd[2329]: time="2026-10-29T00:18:51.828514821Z" level=info msg="loading plugin" id=io.containerd.server.v1.grpc type=io.containerd.server.v1 Oct 29 00:18:51.829100 containerd[2329]: time="2026-10-29T00:18:51.828732380Z" level=info msg="Start subscribing containerd event" Oct 29 00:18:51.829100 containerd[2329]: time="2026-10-29T00:18:51.828838518Z" level=info msg="Start stats collector" Oct 29 00:18:51.829100 containerd[2329]: time="2026-10-29T00:18:51.828846818Z" level=info msg="Start recovering state" Oct 29 00:18:51.829278 containerd[2329]: time="2026-10-29T00:18:51.829215864Z" level=info msg="Start event monitor" Oct 29 00:18:51.829278 containerd[2329]: time="2026-10-29T00:18:51.829231815Z" level=info msg="Start cni network conf syncer for default" Oct 29 00:18:51.829278 containerd[2329]: time="2026-10-29T00:18:51.829239366Z" level=info msg="Start streaming server" Oct 29 00:18:51.829278 containerd[2329]: time="2026-10-29T00:18:51.829253439Z" level=info msg="Registered namespace \"k8s.io\" with NRI" Oct 29 00:18:51.829278 containerd[2329]: time="2026-10-29T00:18:51.829261020Z" level=info msg="runtime interface starting up..." Oct 29 00:18:51.830171 containerd[2329]: time="2026-10-29T00:18:51.829267564Z" level=info msg="starting plugins..." Oct 29 00:18:51.830171 containerd[2329]: time="2026-10-29T00:18:51.829399114Z" level=info msg="Synchronizing NRI (plugin) with current runtime state" Oct 29 00:18:51.837777 containerd[2329]: time="2026-10-29T00:18:51.837660656Z" level=info msg="loading plugin" id=io.containerd.server.v1.grpc-tcp type=io.containerd.server.v1 Oct 29 00:18:51.837777 containerd[2329]: time="2026-10-29T00:18:51.837773928Z" level=info msg="skip loading plugin" error="skip plugin" id=io.containerd.server.v1.grpc-tcp type=io.containerd.server.v1 Oct 29 00:18:51.837878 containerd[2329]: time="2026-10-29T00:18:51.837785436Z" level=info msg="loading plugin" id=io.containerd.http.v1.pprof type=io.containerd.http.v1 Oct 29 00:18:51.837878 containerd[2329]: time="2026-10-29T00:18:51.837833910Z" level=info msg="loading plugin" id=io.containerd.server.v1.debug type=io.containerd.server.v1 Oct 29 00:18:51.837878 containerd[2329]: time="2026-10-29T00:18:51.837842010Z" level=info msg="skip loading plugin" error="skip plugin" id=io.containerd.server.v1.debug type=io.containerd.server.v1 Oct 29 00:18:51.837961 containerd[2329]: time="2026-10-29T00:18:51.837948068Z" level=info msg=serving... address=/run/containerd/containerd.sock.ttrpc Oct 29 00:18:51.837985 containerd[2329]: time="2026-10-29T00:18:51.837970650Z" level=info msg="starting GRPC server" address=/run/containerd/containerd.sock gid=0 uid=0 Oct 29 00:18:51.838011 containerd[2329]: time="2026-10-29T00:18:51.838000839Z" level=info msg=serving... address=/run/containerd/containerd.sock Oct 29 00:18:51.838793 containerd[2329]: time="2026-10-29T00:18:51.838112765Z" level=info msg="containerd successfully booted in 0.939154s" Oct 29 00:18:51.838350 systemd[1]: Started containerd.service - containerd container runtime. Oct 29 00:18:51.842237 systemd[1]: Reached target multi-user.target - Multi-User System. Oct 29 00:18:51.844957 systemd[1]: Startup finished in 4.377s (kernel) + 41.832s (initrd) + 21.631s (userspace) = 1min 7.841s. Oct 29 00:18:52.263708 login[2419]: pam_unix(login:session): session opened for user core(uid=500) by LOGIN(uid=0) Oct 29 00:18:52.269535 systemd[1]: Created slice user-500.slice - User Slice of UID 500. Oct 29 00:18:52.270417 systemd[1]: Starting user-runtime-dir@500.service - User Runtime Directory /run/user/500... Oct 29 00:18:52.274147 systemd-logind[2308]: New session '1' of user 'core' with class 'user-light' and type 'tty'. Oct 29 00:18:52.308857 systemd[1]: Finished user-runtime-dir@500.service - User Runtime Directory /run/user/500. Oct 29 00:18:52.318880 systemd[1]: Started session-1.scope - Session 1 of User core. Oct 29 00:18:52.531140 login[2420]: pam_unix(login:session): session opened for user core(uid=500) by LOGIN(uid=0) Oct 29 00:18:52.536955 systemd-logind[2308]: New session '2' of user 'core' with class 'user-light' and type 'tty'. Oct 29 00:18:52.542856 systemd[1]: Started session-2.scope - Session 2 of User core. Oct 29 00:18:53.101553 waagent[2412]: 2026-10-29T00:18:53.101482Z INFO Daemon Daemon Azure Linux Agent Version: 2.12.0.4 Oct 29 00:18:53.102846 waagent[2412]: 2026-10-29T00:18:53.102338Z INFO Daemon Daemon OS: flatcar 4820.1.0 Oct 29 00:18:53.104036 waagent[2412]: 2026-10-29T00:18:53.104001Z INFO Daemon Daemon Python: 3.13.15 Oct 29 00:18:53.105746 waagent[2412]: 2026-10-29T00:18:53.105027Z INFO Daemon Daemon Run daemon Oct 29 00:18:53.106200 waagent[2412]: 2026-10-29T00:18:53.106154Z INFO Daemon Daemon No RDMA handler exists for distro='Flatcar Container Linux by Kinvolk' version='4820.1.0' Oct 29 00:18:53.106620 waagent[2412]: 2026-10-29T00:18:53.106584Z INFO Daemon Daemon Using waagent for provisioning Oct 29 00:18:53.107230 waagent[2412]: 2026-10-29T00:18:53.107159Z INFO Daemon Daemon Activate resource disk Oct 29 00:18:53.107328 waagent[2412]: 2026-10-29T00:18:53.107281Z INFO Daemon Daemon Searching gen1 prefix 00000000-0001 or gen2 f8b3781a-1e82-4818-a1c3-63d806ec15bb Oct 29 00:18:53.108569 waagent[2412]: 2026-10-29T00:18:53.108532Z INFO Daemon Daemon Found device: None Oct 29 00:18:53.108720 waagent[2412]: 2026-10-29T00:18:53.108690Z ERROR Daemon Daemon Failed to mount resource disk [ResourceDiskError] unable to detect disk topology Oct 29 00:18:53.108814 waagent[2412]: 2026-10-29T00:18:53.108790Z ERROR Daemon Daemon Event: name=WALinuxAgent, op=ActivateResourceDisk, message=[ResourceDiskError] unable to detect disk topology, duration=0 Oct 29 00:18:53.109177 waagent[2412]: 2026-10-29T00:18:53.109144Z INFO Daemon Daemon Clean protocol and wireserver endpoint Oct 29 00:18:53.109302 waagent[2412]: 2026-10-29T00:18:53.109276Z INFO Daemon Daemon Running default provisioning handler Oct 29 00:18:53.124580 waagent[2412]: 2026-10-29T00:18:53.124251Z INFO Daemon Daemon Unable to get cloud-init enabled status from systemctl: Command '['systemctl', 'is-enabled', 'cloud-init-local.service']' returned non-zero exit status 4. Oct 29 00:18:53.124898 waagent[2412]: 2026-10-29T00:18:53.124861Z INFO Daemon Daemon Unable to get cloud-init enabled status from service: [Errno 2] No such file or directory: 'service' Oct 29 00:18:53.125105 waagent[2412]: 2026-10-29T00:18:53.125082Z INFO Daemon Daemon cloud-init is enabled: False Oct 29 00:18:53.125283 waagent[2412]: 2026-10-29T00:18:53.125264Z INFO Daemon Daemon Copying ovf-env.xml Oct 29 00:18:53.221710 waagent[2412]: 2026-10-29T00:18:53.220138Z INFO Daemon Daemon Successfully mounted dvd Oct 29 00:18:53.261154 systemd[1]: mnt-cdrom-secure.mount: Deactivated successfully. Oct 29 00:18:53.262010 waagent[2412]: 2026-10-29T00:18:53.261967Z INFO Daemon Daemon Detect protocol endpoint Oct 29 00:18:53.263384 waagent[2412]: 2026-10-29T00:18:53.263335Z INFO Daemon Daemon Clean protocol and wireserver endpoint Oct 29 00:18:53.264631 waagent[2412]: 2026-10-29T00:18:53.264556Z INFO Daemon Daemon WireServer endpoint is not found. Rerun dhcp handler Oct 29 00:18:53.266054 waagent[2412]: 2026-10-29T00:18:53.265984Z INFO Daemon Daemon Test for route to 168.63.129.16 Oct 29 00:18:53.267229 waagent[2412]: 2026-10-29T00:18:53.267199Z INFO Daemon Daemon Route to 168.63.129.16 exists Oct 29 00:18:53.268217 waagent[2412]: 2026-10-29T00:18:53.267450Z INFO Daemon Daemon Wire server endpoint:168.63.129.16 Oct 29 00:18:53.323652 waagent[2412]: 2026-10-29T00:18:53.323612Z INFO Daemon Daemon Fabric preferred wire protocol version:2015-04-05 Oct 29 00:18:53.324026 waagent[2412]: 2026-10-29T00:18:53.323993Z INFO Daemon Daemon Wire protocol version:2012-11-30 Oct 29 00:18:53.325798 waagent[2412]: 2026-10-29T00:18:53.324076Z INFO Daemon Daemon Server preferred version:2015-04-05 Oct 29 00:18:53.420286 waagent[2412]: 2026-10-29T00:18:53.420187Z INFO Daemon Daemon Initializing goal state during protocol detection Oct 29 00:18:53.421698 waagent[2412]: 2026-10-29T00:18:53.421474Z INFO Daemon Daemon Forcing an update of the goal state. Oct 29 00:18:53.427483 waagent[2412]: 2026-10-29T00:18:53.427440Z INFO Daemon Fetched a new incarnation for the WireServer goal state [incarnation 1] Oct 29 00:18:53.445190 waagent[2412]: 2026-10-29T00:18:53.445158Z INFO Daemon Daemon HostGAPlugin version: 1.0.8.189 Oct 29 00:18:53.446634 waagent[2412]: 2026-10-29T00:18:53.446598Z INFO Daemon Oct 29 00:18:53.447260 waagent[2412]: 2026-10-29T00:18:53.447042Z INFO Daemon Fetched new vmSettings [HostGAPlugin correlation ID: eec3e911-6158-49b5-a13e-4d2e3bdc641a eTag: 15365446084270580025 source: Fabric] Oct 29 00:18:53.449557 waagent[2412]: 2026-10-29T00:18:53.449527Z INFO Daemon The vmSettings originated via Fabric; will ignore them. Oct 29 00:18:53.451018 waagent[2412]: 2026-10-29T00:18:53.450991Z INFO Daemon Oct 29 00:18:53.451408 waagent[2412]: 2026-10-29T00:18:53.451224Z INFO Daemon Fetching full goal state from the WireServer [incarnation 1] Oct 29 00:18:53.457279 waagent[2412]: 2026-10-29T00:18:53.457249Z INFO Daemon Daemon Downloading artifacts profile blob Oct 29 00:18:53.534536 waagent[2412]: 2026-10-29T00:18:53.534485Z INFO Daemon Downloaded certificate {'thumbprint': '325DFBC43C4487DB2A70DDE0B55560EFDBC2CEF9', 'hasPrivateKey': True} Oct 29 00:18:53.535067 waagent[2412]: 2026-10-29T00:18:53.534976Z INFO Daemon Fetch goal state completed Oct 29 00:18:53.548877 waagent[2412]: 2026-10-29T00:18:53.548826Z INFO Daemon Daemon Starting provisioning Oct 29 00:18:53.549163 waagent[2412]: 2026-10-29T00:18:53.548990Z INFO Daemon Daemon Handle ovf-env.xml. Oct 29 00:18:53.549206 waagent[2412]: 2026-10-29T00:18:53.549176Z INFO Daemon Daemon Set hostname [ci-4820.1.0-n-75d75734f8] Oct 29 00:18:53.583262 waagent[2412]: 2026-10-29T00:18:53.583214Z INFO Daemon Daemon Publish hostname [ci-4820.1.0-n-75d75734f8] Oct 29 00:18:53.584690 waagent[2412]: 2026-10-29T00:18:53.584641Z INFO Daemon Daemon Examine /proc/net/route for primary interface Oct 29 00:18:53.586108 waagent[2412]: 2026-10-29T00:18:53.586077Z INFO Daemon Daemon Primary interface is [eth0] Oct 29 00:18:53.591769 systemd-networkd[2100]: eth0: Reconfiguring with /usr/lib/systemd/network/zz-default.network. Oct 29 00:18:53.591870 systemd-networkd[2100]: eth0: DHCP lease lost Oct 29 00:18:53.607657 waagent[2412]: 2026-10-29T00:18:53.607609Z INFO Daemon Daemon Create user account if not exists Oct 29 00:18:53.608009 waagent[2412]: 2026-10-29T00:18:53.607869Z INFO Daemon Daemon User core already exists, skip useradd Oct 29 00:18:53.614001 waagent[2412]: 2026-10-29T00:18:53.608022Z INFO Daemon Daemon Configure sudoer Oct 29 00:18:53.614001 waagent[2412]: 2026-10-29T00:18:53.608316Z INFO Daemon Daemon Configure sshd Oct 29 00:18:53.614001 waagent[2412]: 2026-10-29T00:18:53.608756Z INFO Daemon Daemon Added a configuration snippet disabling SSH password-based authentication methods. It also configures SSH client probing to keep connections alive. Oct 29 00:18:53.614001 waagent[2412]: 2026-10-29T00:18:53.609029Z INFO Daemon Daemon Deploy ssh public key. Oct 29 00:18:53.615369 systemd-networkd[2100]: eth0: DHCPv4 address 10.0.0.4/24, gateway 10.0.0.1 acquired from 168.63.129.16 Oct 29 00:18:54.701036 waagent[2412]: 2026-10-29T00:18:54.700967Z INFO Daemon Daemon Provisioning complete Oct 29 00:18:54.708933 waagent[2412]: 2026-10-29T00:18:54.708895Z INFO Daemon Daemon RDMA capabilities are not enabled, skipping Oct 29 00:18:54.710316 waagent[2412]: 2026-10-29T00:18:54.710132Z INFO Daemon Daemon End of log to /dev/console. The agent will now check for updates and then will process extensions. Oct 29 00:18:54.712270 waagent[2412]: 2026-10-29T00:18:54.712192Z INFO Daemon Daemon Installed Agent WALinuxAgent-2.12.0.4 is the most current agent Oct 29 00:18:54.823986 waagent[2510]: 2026-10-29T00:18:54.823908Z INFO ExtHandler ExtHandler Azure Linux Agent (Goal State Agent version 2.12.0.4) Oct 29 00:18:54.824332 waagent[2510]: 2026-10-29T00:18:54.824023Z INFO ExtHandler ExtHandler OS: flatcar 4820.1.0 Oct 29 00:18:54.824332 waagent[2510]: 2026-10-29T00:18:54.824078Z INFO ExtHandler ExtHandler Python: 3.13.15 Oct 29 00:18:54.824332 waagent[2510]: 2026-10-29T00:18:54.824122Z INFO ExtHandler ExtHandler CPU Arch: x86_64 Oct 29 00:18:54.865921 waagent[2510]: 2026-10-29T00:18:54.865871Z INFO ExtHandler ExtHandler Distro: flatcar-4820.1.0; OSUtil: FlatcarUtil; AgentService: waagent; Python: 3.13.15; Arch: x86_64; systemd: True; LISDrivers: Absent; logrotate: logrotate 3.22.0; Oct 29 00:18:54.866078 waagent[2510]: 2026-10-29T00:18:54.866050Z INFO ExtHandler ExtHandler WireServer endpoint 168.63.129.16 read from file Oct 29 00:18:54.866148 waagent[2510]: 2026-10-29T00:18:54.866117Z INFO ExtHandler ExtHandler Wire server endpoint:168.63.129.16 Oct 29 00:18:54.871918 waagent[2510]: 2026-10-29T00:18:54.871868Z INFO ExtHandler Fetched a new incarnation for the WireServer goal state [incarnation 1] Oct 29 00:18:54.877199 waagent[2510]: 2026-10-29T00:18:54.877164Z INFO ExtHandler ExtHandler HostGAPlugin version: 1.0.8.189 Oct 29 00:18:54.877560 waagent[2510]: 2026-10-29T00:18:54.877528Z INFO ExtHandler Oct 29 00:18:54.877633 waagent[2510]: 2026-10-29T00:18:54.877595Z INFO ExtHandler Fetched new vmSettings [HostGAPlugin correlation ID: a48df10e-28b9-4586-86d5-81d9323cc9e8 eTag: 15365446084270580025 source: Fabric] Oct 29 00:18:54.877885 waagent[2510]: 2026-10-29T00:18:54.877860Z INFO ExtHandler The vmSettings originated via Fabric; will ignore them. Oct 29 00:18:54.878279 waagent[2510]: 2026-10-29T00:18:54.878249Z INFO ExtHandler Oct 29 00:18:54.878325 waagent[2510]: 2026-10-29T00:18:54.878305Z INFO ExtHandler Fetching full goal state from the WireServer [incarnation 1] Oct 29 00:18:54.882256 waagent[2510]: 2026-10-29T00:18:54.882229Z INFO ExtHandler ExtHandler Downloading artifacts profile blob Oct 29 00:18:54.967097 waagent[2510]: 2026-10-29T00:18:54.967012Z INFO ExtHandler Downloaded certificate {'thumbprint': '325DFBC43C4487DB2A70DDE0B55560EFDBC2CEF9', 'hasPrivateKey': True} Oct 29 00:18:54.967421 waagent[2510]: 2026-10-29T00:18:54.967388Z INFO ExtHandler Fetch goal state completed Oct 29 00:18:54.977780 waagent[2510]: 2026-10-29T00:18:54.977734Z INFO ExtHandler ExtHandler OpenSSL version: OpenSSL 3.6.5 29 Sep 2026 (Library: OpenSSL 3.6.5 29 Sep 2026) Oct 29 00:18:54.981026 waagent[2510]: 2026-10-29T00:18:54.980982Z INFO ExtHandler ExtHandler WALinuxAgent-2.12.0.4 running as process 2510 Oct 29 00:18:54.981156 waagent[2510]: 2026-10-29T00:18:54.981130Z INFO ExtHandler ExtHandler ******** AutoUpdate.Enabled is set to False, not processing the operation ******** Oct 29 00:18:54.981416 waagent[2510]: 2026-10-29T00:18:54.981389Z INFO ExtHandler ExtHandler ******** AutoUpdate.UpdateToLatestVersion is set to False, not processing the operation ******** Oct 29 00:18:54.982534 waagent[2510]: 2026-10-29T00:18:54.982498Z INFO ExtHandler ExtHandler [CGI] Cgroup monitoring is not supported on ['flatcar', '4820.1.0', '', 'Flatcar Container Linux by Kinvolk'] Oct 29 00:18:54.982881 waagent[2510]: 2026-10-29T00:18:54.982854Z INFO ExtHandler ExtHandler [CGI] Agent will reset the quotas in case distro: ['flatcar', '4820.1.0', '', 'Flatcar Container Linux by Kinvolk'] went from supported to unsupported Oct 29 00:18:54.982990 waagent[2510]: 2026-10-29T00:18:54.982969Z INFO ExtHandler ExtHandler [CGI] Agent cgroups enabled: False Oct 29 00:18:54.983415 waagent[2510]: 2026-10-29T00:18:54.983391Z INFO ExtHandler ExtHandler Starting setup for Persistent firewall rules Oct 29 00:18:55.042453 waagent[2510]: 2026-10-29T00:18:55.042420Z INFO ExtHandler ExtHandler Firewalld service not running/unavailable, trying to set up waagent-network-setup.service Oct 29 00:18:55.042598 waagent[2510]: 2026-10-29T00:18:55.042573Z INFO ExtHandler ExtHandler Successfully updated the Binary file /var/lib/waagent/waagent-network-setup.py for firewall setup Oct 29 00:18:55.047234 waagent[2510]: 2026-10-29T00:18:55.046838Z INFO ExtHandler ExtHandler Service: waagent-network-setup.service not enabled. Adding it now Oct 29 00:18:55.051460 systemd[1]: Reload requested from client PID 2525 ('systemctl') (unit waagent.service)... Oct 29 00:18:55.051476 systemd[1]: Reloading... Oct 29 00:18:55.126704 zram_generator::config[2569]: No configuration found. Oct 29 00:18:55.290695 kernel: hv_storvsc f8b3781a-1e82-4818-a1c3-63d806ec15bb: tag#195 cmd 0x4a status: scsi 0x0 srb 0x20 hv 0xc0000001 Oct 29 00:18:55.373387 systemd[1]: Reloading finished in 321 ms. Oct 29 00:18:55.410700 waagent[2510]: 2026-10-29T00:18:55.409948Z INFO ExtHandler ExtHandler Successfully added and enabled the waagent-network-setup.service Oct 29 00:18:55.410700 waagent[2510]: 2026-10-29T00:18:55.410111Z INFO ExtHandler ExtHandler Persistent firewall rules setup successfully Oct 29 00:18:55.681132 waagent[2510]: 2026-10-29T00:18:55.681015Z INFO ExtHandler ExtHandler DROP rule is not available which implies no firewall rules are set yet. Environment thread will set it up. Oct 29 00:18:55.681370 waagent[2510]: 2026-10-29T00:18:55.681338Z INFO ExtHandler ExtHandler Checking if log collection is allowed at this time [False]. All three conditions must be met: 1. configuration enabled [True], 2. cgroups v1 enabled [False] OR cgroups v2 is in use and v2 resource limiting configuration enabled [False], 3. python supported: [True] Oct 29 00:18:55.682089 waagent[2510]: 2026-10-29T00:18:55.682020Z INFO ExtHandler ExtHandler Starting env monitor service. Oct 29 00:18:55.682474 waagent[2510]: 2026-10-29T00:18:55.682443Z INFO MonitorHandler ExtHandler WireServer endpoint 168.63.129.16 read from file Oct 29 00:18:55.682564 waagent[2510]: 2026-10-29T00:18:55.682541Z INFO MonitorHandler ExtHandler Wire server endpoint:168.63.129.16 Oct 29 00:18:55.682844 waagent[2510]: 2026-10-29T00:18:55.682818Z INFO MonitorHandler ExtHandler Monitor.NetworkConfigurationChanges is disabled. Oct 29 00:18:55.682959 waagent[2510]: 2026-10-29T00:18:55.682888Z INFO ExtHandler ExtHandler Start SendTelemetryHandler service. Oct 29 00:18:55.683195 waagent[2510]: 2026-10-29T00:18:55.683146Z INFO SendTelemetryHandler ExtHandler Successfully started the SendTelemetryHandler thread Oct 29 00:18:55.683350 waagent[2510]: 2026-10-29T00:18:55.683328Z INFO ExtHandler ExtHandler Start Extension Telemetry service. Oct 29 00:18:55.683689 waagent[2510]: 2026-10-29T00:18:55.683636Z INFO TelemetryEventsCollector ExtHandler Extension Telemetry pipeline enabled: True Oct 29 00:18:55.683784 waagent[2510]: 2026-10-29T00:18:55.683748Z INFO EnvHandler ExtHandler WireServer endpoint 168.63.129.16 read from file Oct 29 00:18:55.683844 waagent[2510]: 2026-10-29T00:18:55.683814Z INFO ExtHandler ExtHandler Goal State Period: 6 sec. This indicates how often the agent checks for new goal states and reports status. Oct 29 00:18:55.684031 waagent[2510]: 2026-10-29T00:18:55.684010Z INFO EnvHandler ExtHandler Wire server endpoint:168.63.129.16 Oct 29 00:18:55.684179 waagent[2510]: 2026-10-29T00:18:55.684153Z INFO EnvHandler ExtHandler Configure routes Oct 29 00:18:55.684240 waagent[2510]: 2026-10-29T00:18:55.684214Z INFO EnvHandler ExtHandler Gateway:None Oct 29 00:18:55.684304 waagent[2510]: 2026-10-29T00:18:55.684277Z INFO EnvHandler ExtHandler Routes:None Oct 29 00:18:55.684607 waagent[2510]: 2026-10-29T00:18:55.684576Z INFO MonitorHandler ExtHandler Routing table from /proc/net/route: Oct 29 00:18:55.684607 waagent[2510]: Iface Destination Gateway Flags RefCnt Use Metric Mask MTU Window IRTT Oct 29 00:18:55.684607 waagent[2510]: eth0 00000000 0100000A 0003 0 0 1024 00000000 0 0 0 Oct 29 00:18:55.684607 waagent[2510]: eth0 0000000A 00000000 0001 0 0 1024 00FFFFFF 0 0 0 Oct 29 00:18:55.684607 waagent[2510]: eth0 0100000A 00000000 0005 0 0 1024 FFFFFFFF 0 0 0 Oct 29 00:18:55.684607 waagent[2510]: eth0 10813FA8 0100000A 0007 0 0 1024 FFFFFFFF 0 0 0 Oct 29 00:18:55.684607 waagent[2510]: eth0 FEA9FEA9 0100000A 0007 0 0 1024 FFFFFFFF 0 0 0 Oct 29 00:18:55.684886 waagent[2510]: 2026-10-29T00:18:55.684704Z INFO TelemetryEventsCollector ExtHandler Successfully started the TelemetryEventsCollector thread Oct 29 00:18:55.692978 waagent[2510]: 2026-10-29T00:18:55.692940Z INFO ExtHandler ExtHandler Oct 29 00:18:55.693048 waagent[2510]: 2026-10-29T00:18:55.693010Z INFO ExtHandler ExtHandler ProcessExtensionsGoalState started [incarnation_1 channel: WireServer source: Fabric activity: 381b14fa-5131-4412-a854-0c61423d20d3 correlation 4fb99375-a956-46e5-bbd5-17ba364a5334 created: 2026-10-29T00:17:21.347786Z] Oct 29 00:18:55.693294 waagent[2510]: 2026-10-29T00:18:55.693269Z INFO ExtHandler ExtHandler No extension handlers found, not processing anything. Oct 29 00:18:55.693723 waagent[2510]: 2026-10-29T00:18:55.693696Z INFO ExtHandler ExtHandler ProcessExtensionsGoalState completed [incarnation_1 0 ms] Oct 29 00:18:55.718096 waagent[2510]: 2026-10-29T00:18:55.718053Z INFO ExtHandler ExtHandler [HEARTBEAT] Agent WALinuxAgent-2.12.0.4 is running as the goal state agent [DEBUG HeartbeatCounter: 0;HeartbeatId: EE033A63-C240-43CC-B972-7F77B847F0B2;DroppedPackets: 0;UpdateGSErrors: 0;AutoUpdate: 0;UpdateMode: SelfUpdate;] Oct 29 00:18:55.739331 waagent[2510]: 2026-10-29T00:18:55.739284Z INFO MonitorHandler ExtHandler Network interfaces: Oct 29 00:18:55.739331 waagent[2510]: Executing ['ip', '-a', '-o', 'link']: Oct 29 00:18:55.739331 waagent[2510]: 1: lo: mtu 65536 qdisc noqueue state UNKNOWN mode DEFAULT group default qlen 1000\ link/loopback 00:00:00:00:00:00 brd 00:00:00:00:00:00 Oct 29 00:18:55.739331 waagent[2510]: 2: eth0: mtu 1500 qdisc mq state UP mode DEFAULT group default qlen 1000\ link/ether 7c:1e:52:87:53:a4 brd ff:ff:ff:ff:ff:ff\ alias Network Device\ altname enx7c1e528753a4 Oct 29 00:18:55.739331 waagent[2510]: 3: enP30832s1: mtu 1500 qdisc mq master eth0 state UP mode DEFAULT group default qlen 1000\ link/ether 7c:1e:52:87:53:a4 brd ff:ff:ff:ff:ff:ff\ altname enP30832p0s0\ altname enp0s0\ altname ens1 Oct 29 00:18:55.739331 waagent[2510]: Executing ['ip', '-4', '-a', '-o', 'address']: Oct 29 00:18:55.739331 waagent[2510]: 1: lo inet 127.0.0.1/8 scope host lo\ valid_lft forever preferred_lft forever Oct 29 00:18:55.739331 waagent[2510]: 2: eth0 inet 10.0.0.4/24 metric 1024 brd 10.0.0.255 scope global eth0\ valid_lft forever preferred_lft forever Oct 29 00:18:55.739331 waagent[2510]: Executing ['ip', '-6', '-a', '-o', 'address']: Oct 29 00:18:55.739331 waagent[2510]: 1: lo inet6 ::1/128 scope host noprefixroute \ valid_lft forever preferred_lft forever Oct 29 00:18:55.739331 waagent[2510]: 2: eth0 inet6 fe80::7e1e:52ff:fe87:53a4/64 scope link proto kernel_ll \ valid_lft forever preferred_lft forever Oct 29 00:18:55.800385 waagent[2510]: 2026-10-29T00:18:55.800337Z INFO EnvHandler ExtHandler Created firewall rules for the Azure Fabric: Oct 29 00:18:55.800385 waagent[2510]: Chain INPUT (policy ACCEPT 0 packets, 0 bytes) Oct 29 00:18:55.800385 waagent[2510]: pkts bytes target prot opt in out source destination Oct 29 00:18:55.800385 waagent[2510]: Chain FORWARD (policy ACCEPT 0 packets, 0 bytes) Oct 29 00:18:55.800385 waagent[2510]: pkts bytes target prot opt in out source destination Oct 29 00:18:55.800385 waagent[2510]: Chain OUTPUT (policy ACCEPT 0 packets, 0 bytes) Oct 29 00:18:55.800385 waagent[2510]: pkts bytes target prot opt in out source destination Oct 29 00:18:55.800385 waagent[2510]: 0 0 ACCEPT tcp -- * * 0.0.0.0/0 168.63.129.16 tcp dpt:53 Oct 29 00:18:55.800385 waagent[2510]: 5 468 ACCEPT tcp -- * * 0.0.0.0/0 168.63.129.16 owner UID match 0 Oct 29 00:18:55.800385 waagent[2510]: 0 0 DROP tcp -- * * 0.0.0.0/0 168.63.129.16 ctstate INVALID,NEW Oct 29 00:18:55.803041 waagent[2510]: 2026-10-29T00:18:55.802993Z INFO EnvHandler ExtHandler Current Firewall rules: Oct 29 00:18:55.803041 waagent[2510]: Chain INPUT (policy ACCEPT 0 packets, 0 bytes) Oct 29 00:18:55.803041 waagent[2510]: pkts bytes target prot opt in out source destination Oct 29 00:18:55.803041 waagent[2510]: Chain FORWARD (policy ACCEPT 0 packets, 0 bytes) Oct 29 00:18:55.803041 waagent[2510]: pkts bytes target prot opt in out source destination Oct 29 00:18:55.803041 waagent[2510]: Chain OUTPUT (policy ACCEPT 0 packets, 0 bytes) Oct 29 00:18:55.803041 waagent[2510]: pkts bytes target prot opt in out source destination Oct 29 00:18:55.803041 waagent[2510]: 0 0 ACCEPT tcp -- * * 0.0.0.0/0 168.63.129.16 tcp dpt:53 Oct 29 00:18:55.803041 waagent[2510]: 5 468 ACCEPT tcp -- * * 0.0.0.0/0 168.63.129.16 owner UID match 0 Oct 29 00:18:55.803041 waagent[2510]: 0 0 DROP tcp -- * * 0.0.0.0/0 168.63.129.16 ctstate INVALID,NEW Oct 29 00:19:07.810990 systemd[1]: Created slice system-sshd.slice - Slice /system/sshd. Oct 29 00:19:07.814001 systemd[1]: Started sshd@0-1-10.0.0.4:22-20.76.155.168:33090.service - OpenSSH per-connection server daemon (20.76.155.168:33090). Oct 29 00:19:08.095811 sshd[2665]: Accepted publickey for core from 20.76.155.168 port 33090 ssh2: RSA SHA256:vzlgDtkafvjq22bZuKcQOIkW3JUxo+xuFBK6kjsTDP8 Oct 29 00:19:08.096898 sshd-session[2665]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Oct 29 00:19:08.104656 systemd[1]: Starting user@500.service - User Manager for UID 500... Oct 29 00:19:08.107411 systemd-logind[2308]: New session '3' of user 'core' with class 'user' and type 'tty'. Oct 29 00:19:08.113576 (systemd)[2669]: pam_unix(systemd-user:session): session opened for user core(uid=500) by core(uid=0) Oct 29 00:19:08.115801 systemd-logind[2308]: New session '4' of user 'core' with class 'manager-early' and type 'unspecified'. Oct 29 00:19:08.354282 systemd[2669]: Queued start job for default target default.target. Oct 29 00:19:08.363389 systemd[2669]: Created slice app.slice - User Application Slice. Oct 29 00:19:08.363420 systemd[2669]: Started systemd-tmpfiles-clean.timer - Daily Cleanup of User's Temporary Directories. Oct 29 00:19:08.363437 systemd[2669]: Reached target machines.target - Virtual Machines and Containers. Oct 29 00:19:08.363478 systemd[2669]: Reached target paths.target - Paths. Oct 29 00:19:08.363505 systemd[2669]: Reached target timers.target - Timers. Oct 29 00:19:08.364543 systemd[2669]: Starting dbus.socket - D-Bus User Message Bus Socket... Oct 29 00:19:08.366201 systemd[2669]: Listening on systemd-ask-password.socket - Query the User Interactively for a Password. Oct 29 00:19:08.366426 systemd[2669]: Listening on systemd-importd.socket - Disk Image Download Service Socket. Oct 29 00:19:08.367393 systemd[2669]: Listening on systemd-journalctl.socket - Journal Log Access Socket. Oct 29 00:19:08.367602 systemd[2669]: Listening on systemd-machined.socket - Virtual Machine and Container Registration Service Socket. Oct 29 00:19:08.369205 systemd[2669]: Listening on systemd-storage-fs.socket - Simple File System Backed Storage Provider. Oct 29 00:19:08.369942 systemd[2669]: Starting systemd-tmpfiles-setup.service - Create User Files and Directories... Oct 29 00:19:08.376850 systemd[2669]: Listening on dbus.socket - D-Bus User Message Bus Socket. Oct 29 00:19:08.378250 systemd[2669]: Reached target sockets.target - Sockets. Oct 29 00:19:08.381145 systemd[2669]: Finished systemd-tmpfiles-setup.service - Create User Files and Directories. Oct 29 00:19:08.381238 systemd[2669]: Reached target basic.target - Basic System. Oct 29 00:19:08.381285 systemd[2669]: Reached target default.target - Main User Target. Oct 29 00:19:08.381307 systemd[2669]: Startup finished in 260ms. Oct 29 00:19:08.381516 systemd[1]: Started user@500.service - User Manager for UID 500. Oct 29 00:19:08.391889 systemd[1]: Started session-3.scope - Session 3 of User core. Oct 29 00:19:08.452246 systemd[1]: Started sshd@1-4097-10.0.0.4:22-20.76.155.168:33092.service - OpenSSH per-connection server daemon (20.76.155.168:33092). Oct 29 00:19:08.568258 sshd[2683]: Accepted publickey for core from 20.76.155.168 port 33092 ssh2: RSA SHA256:vzlgDtkafvjq22bZuKcQOIkW3JUxo+xuFBK6kjsTDP8 Oct 29 00:19:08.569363 sshd-session[2683]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Oct 29 00:19:08.573808 systemd-logind[2308]: New session '5' of user 'core' with class 'user' and type 'tty'. Oct 29 00:19:08.582857 systemd[1]: Started session-5.scope - Session 5 of User core. Oct 29 00:19:08.618605 sshd[2687]: Connection closed by 20.76.155.168 port 33092 Oct 29 00:19:08.619873 sshd-session[2683]: pam_unix(sshd:session): session closed for user core Oct 29 00:19:08.621482 systemd[1]: sshd@1-4097-10.0.0.4:22-20.76.155.168:33092.service: Deactivated successfully. Oct 29 00:19:08.622891 systemd[1]: session-5.scope: Deactivated successfully. Oct 29 00:19:08.624535 systemd-logind[2308]: Session 5 logged out. Waiting for processes to exit. Oct 29 00:19:08.625344 systemd-logind[2308]: Removed session 5. Oct 29 00:19:08.643047 systemd[1]: Started sshd@2-2-10.0.0.4:22-20.76.155.168:33102.service - OpenSSH per-connection server daemon (20.76.155.168:33102). Oct 29 00:19:08.750512 sshd[2693]: Accepted publickey for core from 20.76.155.168 port 33102 ssh2: RSA SHA256:vzlgDtkafvjq22bZuKcQOIkW3JUxo+xuFBK6kjsTDP8 Oct 29 00:19:08.751382 sshd-session[2693]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Oct 29 00:19:08.755550 systemd-logind[2308]: New session '6' of user 'core' with class 'user' and type 'tty'. Oct 29 00:19:08.760868 systemd[1]: Started session-6.scope - Session 6 of User core. Oct 29 00:19:08.793877 sshd[2697]: Connection closed by 20.76.155.168 port 33102 Oct 29 00:19:08.794295 sshd-session[2693]: pam_unix(sshd:session): session closed for user core Oct 29 00:19:08.796522 systemd[1]: sshd@2-2-10.0.0.4:22-20.76.155.168:33102.service: Deactivated successfully. Oct 29 00:19:08.797834 systemd[1]: session-6.scope: Deactivated successfully. Oct 29 00:19:08.799064 systemd-logind[2308]: Session 6 logged out. Waiting for processes to exit. Oct 29 00:19:08.799751 systemd-logind[2308]: Removed session 6. Oct 29 00:19:08.817952 systemd[1]: Started sshd@3-3-10.0.0.4:22-20.76.155.168:52588.service - OpenSSH per-connection server daemon (20.76.155.168:52588). Oct 29 00:19:08.930737 sshd[2703]: Accepted publickey for core from 20.76.155.168 port 52588 ssh2: RSA SHA256:vzlgDtkafvjq22bZuKcQOIkW3JUxo+xuFBK6kjsTDP8 Oct 29 00:19:08.931986 sshd-session[2703]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Oct 29 00:19:08.936091 systemd-logind[2308]: New session '7' of user 'core' with class 'user' and type 'tty'. Oct 29 00:19:08.946873 systemd[1]: Started session-7.scope - Session 7 of User core. Oct 29 00:19:08.981896 sshd[2707]: Connection closed by 20.76.155.168 port 52588 Oct 29 00:19:08.982836 sshd-session[2703]: pam_unix(sshd:session): session closed for user core Oct 29 00:19:08.984356 systemd[1]: sshd@3-3-10.0.0.4:22-20.76.155.168:52588.service: Deactivated successfully. Oct 29 00:19:08.985583 systemd[1]: session-7.scope: Deactivated successfully. Oct 29 00:19:08.987190 systemd-logind[2308]: Session 7 logged out. Waiting for processes to exit. Oct 29 00:19:08.987948 systemd-logind[2308]: Removed session 7. Oct 29 00:19:09.004972 systemd[1]: Started sshd@4-4-10.0.0.4:22-20.76.155.168:52600.service - OpenSSH per-connection server daemon (20.76.155.168:52600). Oct 29 00:19:09.114647 sshd[2713]: Accepted publickey for core from 20.76.155.168 port 52600 ssh2: RSA SHA256:vzlgDtkafvjq22bZuKcQOIkW3JUxo+xuFBK6kjsTDP8 Oct 29 00:19:09.115133 sshd-session[2713]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Oct 29 00:19:09.118749 systemd-logind[2308]: New session '8' of user 'core' with class 'user' and type 'tty'. Oct 29 00:19:09.124839 systemd[1]: Started session-8.scope - Session 8 of User core. Oct 29 00:19:09.293812 sudo[2718]: core : PWD=/home/core ; USER=root ; COMMAND=/usr/sbin/setenforce 1 Oct 29 00:19:09.294053 sudo[2718]: pam_unix(sudo:session): session opened for user root(uid=0) by core(uid=500) Oct 29 00:19:09.308520 sudo[2718]: pam_unix(sudo:session): session closed for user root Oct 29 00:19:09.323279 sshd[2717]: Connection closed by 20.76.155.168 port 52600 Oct 29 00:19:09.324736 sshd-session[2713]: pam_unix(sshd:session): session closed for user core Oct 29 00:19:09.327094 systemd[1]: sshd@4-4-10.0.0.4:22-20.76.155.168:52600.service: Deactivated successfully. Oct 29 00:19:09.328668 systemd[1]: session-8.scope: Deactivated successfully. Oct 29 00:19:09.330280 systemd-logind[2308]: Session 8 logged out. Waiting for processes to exit. Oct 29 00:19:09.331182 systemd-logind[2308]: Removed session 8. Oct 29 00:19:09.348261 systemd[1]: Started sshd@5-5-10.0.0.4:22-20.76.155.168:52604.service - OpenSSH per-connection server daemon (20.76.155.168:52604). Oct 29 00:19:09.456496 sshd[2725]: Accepted publickey for core from 20.76.155.168 port 52604 ssh2: RSA SHA256:vzlgDtkafvjq22bZuKcQOIkW3JUxo+xuFBK6kjsTDP8 Oct 29 00:19:09.457527 sshd-session[2725]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Oct 29 00:19:09.461920 systemd-logind[2308]: New session '9' of user 'core' with class 'user' and type 'tty'. Oct 29 00:19:09.473830 systemd[1]: Started session-9.scope - Session 9 of User core. Oct 29 00:19:09.497383 sudo[2731]: core : PWD=/home/core ; USER=root ; COMMAND=/usr/sbin/rm -rf /etc/audit/rules.d/80-selinux.rules /etc/audit/rules.d/99-default.rules Oct 29 00:19:09.497622 sudo[2731]: pam_unix(sudo:session): session opened for user root(uid=0) by core(uid=500) Oct 29 00:19:09.498909 sudo[2731]: pam_unix(sudo:session): session closed for user root Oct 29 00:19:09.503559 sudo[2730]: core : PWD=/home/core ; USER=root ; COMMAND=/usr/sbin/systemctl restart audit-rules Oct 29 00:19:09.503816 sudo[2730]: pam_unix(sudo:session): session opened for user root(uid=0) by core(uid=500) Oct 29 00:19:09.509086 systemd[1]: Starting audit-rules.service - Load Audit Rules... Oct 29 00:19:09.549000 audit: CONFIG_CHANGE auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 op=remove_rule key=(null) list=5 res=1 Oct 29 00:19:09.559698 kernel: kauditd_printk_skb: 13 callbacks suppressed Oct 29 00:19:09.559772 augenrules[2755]: No rules Oct 29 00:19:09.559873 kernel: audit: type=1305 audit(1793233149.549:167): auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 op=remove_rule key=(null) list=5 res=1 Oct 29 00:19:09.560051 systemd[1]: audit-rules.service: Deactivated successfully. Oct 29 00:19:09.560260 systemd[1]: Finished audit-rules.service - Load Audit Rules. Oct 29 00:19:09.549000 audit[2755]: SYSCALL arch=c000003e syscall=44 success=yes exit=1056 a0=3 a1=7fff7a326bd0 a2=420 a3=0 items=0 ppid=2736 pid=2755 auid=4294967295 uid=0 gid=0 euid=0 suid=0 fsuid=0 egid=0 sgid=0 fsgid=0 tty=(none) ses=4294967295 comm="auditctl" exe="/usr/bin/auditctl" subj=system_u:system_r:kernel_t:s0 key=(null) Oct 29 00:19:09.562304 sudo[2730]: pam_unix(sudo:session): session closed for user root Oct 29 00:19:09.549000 audit: PROCTITLE proctitle=2F7362696E2F617564697463746C002D52002F6574632F61756469742F61756469742E72756C6573 Oct 29 00:19:09.565157 kernel: audit: type=1300 audit(1793233149.549:167): arch=c000003e syscall=44 success=yes exit=1056 a0=3 a1=7fff7a326bd0 a2=420 a3=0 items=0 ppid=2736 pid=2755 auid=4294967295 uid=0 gid=0 euid=0 suid=0 fsuid=0 egid=0 sgid=0 fsgid=0 tty=(none) ses=4294967295 comm="auditctl" exe="/usr/bin/auditctl" subj=system_u:system_r:kernel_t:s0 key=(null) Oct 29 00:19:09.565190 kernel: audit: type=1327 audit(1793233149.549:167): proctitle=2F7362696E2F617564697463746C002D52002F6574632F61756469742F61756469742E72756C6573 Oct 29 00:19:09.558000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=audit-rules comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Oct 29 00:19:09.567434 kernel: audit: type=1130 audit(1793233149.558:168): pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=audit-rules comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Oct 29 00:19:09.558000 audit[1]: SERVICE_STOP pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=audit-rules comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Oct 29 00:19:09.569469 kernel: audit: type=1131 audit(1793233149.558:169): pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=audit-rules comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Oct 29 00:19:09.559000 audit[2730]: AUDIT1106 pid=2730 uid=500 auid=500 ses=9 subj=system_u:system_r:kernel_t:s0 msg='op=PAM:session_close grantors=pam_limits,pam_env,pam_umask,pam_unix acct="root" exe="/usr/bin/sudo" hostname=? addr=? terminal=? res=success' Oct 29 00:19:09.571698 kernel: audit: type=1106 audit(1793233149.559:170): pid=2730 uid=500 auid=500 ses=9 subj=system_u:system_r:kernel_t:s0 msg='op=PAM:session_close grantors=pam_limits,pam_env,pam_umask,pam_unix acct="root" exe="/usr/bin/sudo" hostname=? addr=? terminal=? res=success' Oct 29 00:19:09.559000 audit[2730]: AUDIT1104 pid=2730 uid=500 auid=500 ses=9 subj=system_u:system_r:kernel_t:s0 msg='op=PAM:setcred grantors=pam_env,pam_faillock,pam_unix acct="root" exe="/usr/bin/sudo" hostname=? addr=? terminal=? res=success' Oct 29 00:19:09.573616 kernel: audit: type=1104 audit(1793233149.559:171): pid=2730 uid=500 auid=500 ses=9 subj=system_u:system_r:kernel_t:s0 msg='op=PAM:setcred grantors=pam_env,pam_faillock,pam_unix acct="root" exe="/usr/bin/sudo" hostname=? addr=? terminal=? res=success' Oct 29 00:19:09.582099 sshd[2729]: Connection closed by 20.76.155.168 port 52604 Oct 29 00:19:09.583338 sshd-session[2725]: pam_unix(sshd:session): session closed for user core Oct 29 00:19:09.581000 audit[2725]: AUDIT1106 pid=2725 uid=0 auid=500 ses=9 subj=system_u:system_r:kernel_t:s0 msg='op=PAM:session_close grantors=pam_loginuid,pam_env,pam_namespace,pam_keyinit,pam_limits,pam_env,pam_umask,pam_unix,pam_systemd,pam_lastlog,pam_mail acct="core" exe="/usr/lib64/misc/sshd-session" hostname=20.76.155.168 addr=20.76.155.168 terminal=ssh res=success' Oct 29 00:19:09.581000 audit[2725]: AUDIT1104 pid=2725 uid=0 auid=500 ses=9 subj=system_u:system_r:kernel_t:s0 msg='op=PAM:setcred grantors=pam_env,pam_faillock,pam_unix acct="core" exe="/usr/lib64/misc/sshd-session" hostname=20.76.155.168 addr=20.76.155.168 terminal=ssh res=success' Oct 29 00:19:09.588647 kernel: audit: type=1106 audit(1793233149.581:172): pid=2725 uid=0 auid=500 ses=9 subj=system_u:system_r:kernel_t:s0 msg='op=PAM:session_close grantors=pam_loginuid,pam_env,pam_namespace,pam_keyinit,pam_limits,pam_env,pam_umask,pam_unix,pam_systemd,pam_lastlog,pam_mail acct="core" exe="/usr/lib64/misc/sshd-session" hostname=20.76.155.168 addr=20.76.155.168 terminal=ssh res=success' Oct 29 00:19:09.587415 systemd[1]: sshd@5-5-10.0.0.4:22-20.76.155.168:52604.service: Deactivated successfully. Oct 29 00:19:09.588753 kernel: audit: type=1104 audit(1793233149.581:173): pid=2725 uid=0 auid=500 ses=9 subj=system_u:system_r:kernel_t:s0 msg='op=PAM:setcred grantors=pam_env,pam_faillock,pam_unix acct="core" exe="/usr/lib64/misc/sshd-session" hostname=20.76.155.168 addr=20.76.155.168 terminal=ssh res=success' Oct 29 00:19:09.585000 audit[1]: SERVICE_STOP pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=sshd@5-5-10.0.0.4:22-20.76.155.168:52604 comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Oct 29 00:19:09.591723 kernel: audit: type=1131 audit(1793233149.585:174): pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=sshd@5-5-10.0.0.4:22-20.76.155.168:52604 comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Oct 29 00:19:09.591812 systemd[1]: session-9.scope: Deactivated successfully. Oct 29 00:19:09.593041 systemd-logind[2308]: Session 9 logged out. Waiting for processes to exit. Oct 29 00:19:09.594247 systemd-logind[2308]: Removed session 9. Oct 29 00:19:09.609433 systemd[1]: Started sshd@6-4098-10.0.0.4:22-20.76.155.168:52616.service - OpenSSH per-connection server daemon (20.76.155.168:52616). Oct 29 00:19:09.607000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=sshd@6-4098-10.0.0.4:22-20.76.155.168:52616 comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Oct 29 00:19:09.715000 audit[2764]: AUDIT1101 pid=2764 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='op=PAM:accounting grantors=pam_access,pam_time,pam_unix,pam_faillock,pam_permit acct="core" exe="/usr/lib64/misc/sshd-session" hostname=20.76.155.168 addr=20.76.155.168 terminal=ssh res=success' Oct 29 00:19:09.717244 sshd[2764]: Accepted publickey for core from 20.76.155.168 port 52616 ssh2: RSA SHA256:vzlgDtkafvjq22bZuKcQOIkW3JUxo+xuFBK6kjsTDP8 Oct 29 00:19:09.716000 audit[2764]: AUDIT1103 pid=2764 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='op=PAM:setcred grantors=pam_env,pam_faillock,pam_unix acct="core" exe="/usr/lib64/misc/sshd-session" hostname=20.76.155.168 addr=20.76.155.168 terminal=ssh res=success' Oct 29 00:19:09.716000 audit[2764]: SYSCALL arch=c000003e syscall=1 success=yes exit=3 a0=8 a1=7ffe5b31a7a0 a2=3 a3=0 items=0 ppid=1 pid=2764 auid=500 uid=0 gid=0 euid=0 suid=0 fsuid=0 egid=0 sgid=0 fsgid=0 tty=(none) ses=10 comm="sshd-session" exe="/usr/lib64/misc/sshd-session" subj=system_u:system_r:kernel_t:s0 key=(null) Oct 29 00:19:09.716000 audit: PROCTITLE proctitle=737368642D73657373696F6E3A20636F7265205B706F7374617574685D Oct 29 00:19:09.718344 sshd-session[2764]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Oct 29 00:19:09.722598 systemd-logind[2308]: New session '10' of user 'core' with class 'user' and type 'tty'. Oct 29 00:19:09.730822 systemd[1]: Started session-10.scope - Session 10 of User core. Oct 29 00:19:09.731000 audit[2764]: AUDIT1105 pid=2764 uid=0 auid=500 ses=10 subj=system_u:system_r:kernel_t:s0 msg='op=PAM:session_open grantors=pam_loginuid,pam_env,pam_namespace,pam_keyinit,pam_limits,pam_env,pam_umask,pam_unix,pam_systemd,pam_lastlog,pam_mail acct="core" exe="/usr/lib64/misc/sshd-session" hostname=20.76.155.168 addr=20.76.155.168 terminal=ssh res=success' Oct 29 00:19:09.732000 audit[2768]: AUDIT1103 pid=2768 uid=0 auid=500 ses=10 subj=system_u:system_r:kernel_t:s0 msg='op=PAM:setcred grantors=pam_env,pam_faillock,pam_unix acct="core" exe="/usr/lib64/misc/sshd-session" hostname=20.76.155.168 addr=20.76.155.168 terminal=ssh res=success' Oct 29 00:19:09.765817 sshd[2768]: Connection closed by 20.76.155.168 port 52616 Oct 29 00:19:09.766813 sshd-session[2764]: pam_unix(sshd:session): session closed for user core Oct 29 00:19:09.765000 audit[2764]: AUDIT1106 pid=2764 uid=0 auid=500 ses=10 subj=system_u:system_r:kernel_t:s0 msg='op=PAM:session_close grantors=pam_loginuid,pam_env,pam_namespace,pam_keyinit,pam_limits,pam_env,pam_umask,pam_unix,pam_systemd,pam_lastlog,pam_mail acct="core" exe="/usr/lib64/misc/sshd-session" hostname=20.76.155.168 addr=20.76.155.168 terminal=ssh res=success' Oct 29 00:19:09.765000 audit[2764]: AUDIT1104 pid=2764 uid=0 auid=500 ses=10 subj=system_u:system_r:kernel_t:s0 msg='op=PAM:setcred grantors=pam_env,pam_faillock,pam_unix acct="core" exe="/usr/lib64/misc/sshd-session" hostname=20.76.155.168 addr=20.76.155.168 terminal=ssh res=success' Oct 29 00:19:09.768960 systemd[1]: sshd@6-4098-10.0.0.4:22-20.76.155.168:52616.service: Deactivated successfully. Oct 29 00:19:09.767000 audit[1]: SERVICE_STOP pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=sshd@6-4098-10.0.0.4:22-20.76.155.168:52616 comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Oct 29 00:19:09.770290 systemd[1]: session-10.scope: Deactivated successfully. Oct 29 00:19:09.770972 systemd-logind[2308]: Session 10 logged out. Waiting for processes to exit. Oct 29 00:19:09.772029 systemd-logind[2308]: Removed session 10. Oct 29 00:19:11.370194 chronyd[2292]: Selected source PHC0