Mar 6 02:26:07.927408 kernel: Linux version 6.12.74-flatcar (build@pony-truck.infra.kinvolk.io) (x86_64-cros-linux-gnu-gcc (Gentoo Hardened 14.3.0 p8) 14.3.0, GNU ld (Gentoo 2.44 p4) 2.44.0) #1 SMP PREEMPT_DYNAMIC Thu Mar 5 23:16:40 -00 2026 Mar 6 02:26:07.927431 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=5bef16c10382b6f77f9493af2297475832ff2f09f1ada4155425ad9b32dd6e53 Mar 6 02:26:07.927442 kernel: BIOS-provided physical RAM map: Mar 6 02:26:07.927450 kernel: BIOS-e820: [mem 0x0000000000000000-0x000000000009ffff] usable Mar 6 02:26:07.927457 kernel: BIOS-e820: [mem 0x00000000000c0000-0x00000000000fffff] reserved Mar 6 02:26:07.927464 kernel: BIOS-e820: [mem 0x0000000000100000-0x00000000044fdfff] usable Mar 6 02:26:07.927472 kernel: BIOS-e820: [mem 0x00000000044fe000-0x00000000048fdfff] reserved Mar 6 02:26:07.927479 kernel: BIOS-e820: [mem 0x00000000048fe000-0x000000003ff1efff] usable Mar 6 02:26:07.927486 kernel: BIOS-e820: [mem 0x000000003ff1f000-0x000000003ffc8fff] reserved Mar 6 02:26:07.927495 kernel: BIOS-e820: [mem 0x000000003ffc9000-0x000000003fffafff] ACPI data Mar 6 02:26:07.927502 kernel: BIOS-e820: [mem 0x000000003fffb000-0x000000003fffefff] ACPI NVS Mar 6 02:26:07.927509 kernel: BIOS-e820: [mem 0x000000003ffff000-0x000000003fffffff] usable Mar 6 02:26:07.927516 kernel: BIOS-e820: [mem 0x0000000100000000-0x00000002bfffffff] usable Mar 6 02:26:07.927523 kernel: printk: legacy bootconsole [earlyser0] enabled Mar 6 02:26:07.927531 kernel: NX (Execute Disable) protection: active Mar 6 02:26:07.928256 kernel: APIC: Static calls initialized Mar 6 02:26:07.928267 kernel: efi: EFI v2.7 by Microsoft Mar 6 02:26:07.928275 kernel: efi: ACPI=0x3fffa000 ACPI 2.0=0x3fffa014 SMBIOS=0x3ff88000 SMBIOS 3.0=0x3ff86000 MEMATTR=0x3e9ab698 RNG=0x3ffd2018 Mar 6 02:26:07.928283 kernel: random: crng init done Mar 6 02:26:07.928291 kernel: secureboot: Secure boot disabled Mar 6 02:26:07.928299 kernel: SMBIOS 3.1.0 present. Mar 6 02:26:07.928307 kernel: DMI: Microsoft Corporation Virtual Machine/Virtual Machine, BIOS Hyper-V UEFI Release v4.1 07/25/2025 Mar 6 02:26:07.928315 kernel: DMI: Memory slots populated: 2/2 Mar 6 02:26:07.928322 kernel: Hypervisor detected: Microsoft Hyper-V Mar 6 02:26:07.928329 kernel: Hyper-V: privilege flags low 0xae7f, high 0x3b8030, hints 0x9e4e24, misc 0xe0bed7b2 Mar 6 02:26:07.928337 kernel: Hyper-V: Nested features: 0x3e0101 Mar 6 02:26:07.928346 kernel: Hyper-V: LAPIC Timer Frequency: 0x30d40 Mar 6 02:26:07.928353 kernel: Hyper-V: Using hypercall for remote TLB flush Mar 6 02:26:07.928361 kernel: clocksource: hyperv_clocksource_tsc_page: mask: 0xffffffffffffffff max_cycles: 0x24e6a1710, max_idle_ns: 440795202120 ns Mar 6 02:26:07.928369 kernel: clocksource: hyperv_clocksource_msr: mask: 0xffffffffffffffff max_cycles: 0x24e6a1710, max_idle_ns: 440795202120 ns Mar 6 02:26:07.928377 kernel: tsc: Detected 2300.000 MHz processor Mar 6 02:26:07.928385 kernel: e820: update [mem 0x00000000-0x00000fff] usable ==> reserved Mar 6 02:26:07.928394 kernel: e820: remove [mem 0x000a0000-0x000fffff] usable Mar 6 02:26:07.928402 kernel: last_pfn = 0x2c0000 max_arch_pfn = 0x10000000000 Mar 6 02:26:07.928410 kernel: MTRR map: 4 entries (2 fixed + 2 variable; max 18), built from 8 variable MTRRs Mar 6 02:26:07.928418 kernel: x86/PAT: Configuration [0-7]: WB WC UC- UC WB WP UC- WT Mar 6 02:26:07.928428 kernel: e820: update [mem 0x48000000-0xffffffff] usable ==> reserved Mar 6 02:26:07.928436 kernel: last_pfn = 0x40000 max_arch_pfn = 0x10000000000 Mar 6 02:26:07.928444 kernel: Using GB pages for direct mapping Mar 6 02:26:07.928452 kernel: ACPI: Early table checksum verification disabled Mar 6 02:26:07.928463 kernel: ACPI: RSDP 0x000000003FFFA014 000024 (v02 VRTUAL) Mar 6 02:26:07.928472 kernel: ACPI: XSDT 0x000000003FFF90E8 00005C (v01 VRTUAL MICROSFT 00000001 MSFT 00000001) Mar 6 02:26:07.928481 kernel: ACPI: FACP 0x000000003FFF8000 000114 (v06 VRTUAL MICROSFT 00000001 MSFT 00000001) Mar 6 02:26:07.928490 kernel: ACPI: DSDT 0x000000003FFD6000 01E22B (v02 MSFTVM DSDT01 00000001 INTL 20230628) Mar 6 02:26:07.928497 kernel: ACPI: FACS 0x000000003FFFE000 000040 Mar 6 02:26:07.928506 kernel: ACPI: OEM0 0x000000003FFF7000 000064 (v01 VRTUAL MICROSFT 00000001 MSFT 00000001) Mar 6 02:26:07.928515 kernel: ACPI: SPCR 0x000000003FFF6000 000050 (v02 VRTUAL MICROSFT 00000001 MSFT 00000001) Mar 6 02:26:07.928523 kernel: ACPI: WAET 0x000000003FFF5000 000028 (v01 VRTUAL MICROSFT 00000001 MSFT 00000001) Mar 6 02:26:07.928531 kernel: ACPI: APIC 0x000000003FFD5000 000058 (v05 HVLITE HVLITETB 00000000 MSHV 00000000) Mar 6 02:26:07.928594 kernel: ACPI: SRAT 0x000000003FFD4000 0000A0 (v03 HVLITE HVLITETB 00000000 MSHV 00000000) Mar 6 02:26:07.928603 kernel: ACPI: BGRT 0x000000003FFD3000 000038 (v01 VRTUAL MICROSFT 00000001 MSFT 00000001) Mar 6 02:26:07.928611 kernel: ACPI: Reserving FACP table memory at [mem 0x3fff8000-0x3fff8113] Mar 6 02:26:07.928620 kernel: ACPI: Reserving DSDT table memory at [mem 0x3ffd6000-0x3fff422a] Mar 6 02:26:07.928627 kernel: ACPI: Reserving FACS table memory at [mem 0x3fffe000-0x3fffe03f] Mar 6 02:26:07.928635 kernel: ACPI: Reserving OEM0 table memory at [mem 0x3fff7000-0x3fff7063] Mar 6 02:26:07.928644 kernel: ACPI: Reserving SPCR table memory at [mem 0x3fff6000-0x3fff604f] Mar 6 02:26:07.928652 kernel: ACPI: Reserving WAET table memory at [mem 0x3fff5000-0x3fff5027] Mar 6 02:26:07.928660 kernel: ACPI: Reserving APIC table memory at [mem 0x3ffd5000-0x3ffd5057] Mar 6 02:26:07.928670 kernel: ACPI: Reserving SRAT table memory at [mem 0x3ffd4000-0x3ffd409f] Mar 6 02:26:07.928678 kernel: ACPI: Reserving BGRT table memory at [mem 0x3ffd3000-0x3ffd3037] Mar 6 02:26:07.928685 kernel: ACPI: SRAT: Node 0 PXM 0 [mem 0x00000000-0x3fffffff] Mar 6 02:26:07.928693 kernel: ACPI: SRAT: Node 0 PXM 0 [mem 0x100000000-0x2bfffffff] Mar 6 02:26:07.928700 kernel: NUMA: Node 0 [mem 0x00001000-0x3fffffff] + [mem 0x100000000-0x2bfffffff] -> [mem 0x00001000-0x2bfffffff] Mar 6 02:26:07.928707 kernel: NODE_DATA(0) allocated [mem 0x2bfff8dc0-0x2bfffffff] Mar 6 02:26:07.928714 kernel: Zone ranges: Mar 6 02:26:07.928721 kernel: DMA [mem 0x0000000000001000-0x0000000000ffffff] Mar 6 02:26:07.928728 kernel: DMA32 [mem 0x0000000001000000-0x00000000ffffffff] Mar 6 02:26:07.928737 kernel: Normal [mem 0x0000000100000000-0x00000002bfffffff] Mar 6 02:26:07.928743 kernel: Device empty Mar 6 02:26:07.928750 kernel: Movable zone start for each node Mar 6 02:26:07.928757 kernel: Early memory node ranges Mar 6 02:26:07.928763 kernel: node 0: [mem 0x0000000000001000-0x000000000009ffff] Mar 6 02:26:07.928770 kernel: node 0: [mem 0x0000000000100000-0x00000000044fdfff] Mar 6 02:26:07.928777 kernel: node 0: [mem 0x00000000048fe000-0x000000003ff1efff] Mar 6 02:26:07.928784 kernel: node 0: [mem 0x000000003ffff000-0x000000003fffffff] Mar 6 02:26:07.928791 kernel: node 0: [mem 0x0000000100000000-0x00000002bfffffff] Mar 6 02:26:07.928800 kernel: Initmem setup node 0 [mem 0x0000000000001000-0x00000002bfffffff] Mar 6 02:26:07.928807 kernel: On node 0, zone DMA: 1 pages in unavailable ranges Mar 6 02:26:07.928813 kernel: On node 0, zone DMA: 96 pages in unavailable ranges Mar 6 02:26:07.928820 kernel: On node 0, zone DMA32: 1024 pages in unavailable ranges Mar 6 02:26:07.928827 kernel: On node 0, zone DMA32: 224 pages in unavailable ranges Mar 6 02:26:07.928833 kernel: ACPI: PM-Timer IO Port: 0x408 Mar 6 02:26:07.928840 kernel: ACPI: LAPIC_NMI (acpi_id[0x01] dfl dfl lint[0x1]) Mar 6 02:26:07.928847 kernel: IOAPIC[0]: apic_id 0, version 17, address 0xfec00000, GSI 0-23 Mar 6 02:26:07.928854 kernel: ACPI: INT_SRC_OVR (bus 0 bus_irq 9 global_irq 9 high level) Mar 6 02:26:07.928862 kernel: ACPI: Using ACPI (MADT) for SMP configuration information Mar 6 02:26:07.928869 kernel: ACPI: SPCR: console: uart,io,0x3f8,115200 Mar 6 02:26:07.928877 kernel: TSC deadline timer available Mar 6 02:26:07.928883 kernel: CPU topo: Max. logical packages: 1 Mar 6 02:26:07.928890 kernel: CPU topo: Max. logical dies: 1 Mar 6 02:26:07.928896 kernel: CPU topo: Max. dies per package: 1 Mar 6 02:26:07.928903 kernel: CPU topo: Max. threads per core: 2 Mar 6 02:26:07.928910 kernel: CPU topo: Num. cores per package: 1 Mar 6 02:26:07.928917 kernel: CPU topo: Num. threads per package: 2 Mar 6 02:26:07.928923 kernel: CPU topo: Allowing 2 present CPUs plus 0 hotplug CPUs Mar 6 02:26:07.928932 kernel: [mem 0x40000000-0xffffffff] available for PCI devices Mar 6 02:26:07.928939 kernel: Booting paravirtualized kernel on Hyper-V Mar 6 02:26:07.928946 kernel: clocksource: refined-jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1910969940391419 ns Mar 6 02:26:07.928953 kernel: setup_percpu: NR_CPUS:512 nr_cpumask_bits:2 nr_cpu_ids:2 nr_node_ids:1 Mar 6 02:26:07.928959 kernel: percpu: Embedded 60 pages/cpu s207832 r8192 d29736 u1048576 Mar 6 02:26:07.928966 kernel: pcpu-alloc: s207832 r8192 d29736 u1048576 alloc=1*2097152 Mar 6 02:26:07.928973 kernel: pcpu-alloc: [0] 0 1 Mar 6 02:26:07.928980 kernel: Hyper-V: PV spinlocks enabled Mar 6 02:26:07.928987 kernel: PV qspinlock hash table entries: 256 (order: 0, 4096 bytes, linear) Mar 6 02:26:07.928997 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=5bef16c10382b6f77f9493af2297475832ff2f09f1ada4155425ad9b32dd6e53 Mar 6 02:26:07.929005 kernel: Dentry cache hash table entries: 1048576 (order: 11, 8388608 bytes, linear) Mar 6 02:26:07.929011 kernel: Inode-cache hash table entries: 524288 (order: 10, 4194304 bytes, linear) Mar 6 02:26:07.929018 kernel: Fallback order for Node 0: 0 Mar 6 02:26:07.929024 kernel: Built 1 zonelists, mobility grouping on. Total pages: 2095807 Mar 6 02:26:07.929031 kernel: Policy zone: Normal Mar 6 02:26:07.929038 kernel: mem auto-init: stack:off, heap alloc:off, heap free:off Mar 6 02:26:07.929045 kernel: software IO TLB: area num 2. Mar 6 02:26:07.929054 kernel: SLUB: HWalign=64, Order=0-3, MinObjects=0, CPUs=2, Nodes=1 Mar 6 02:26:07.929061 kernel: ftrace: allocating 40099 entries in 157 pages Mar 6 02:26:07.929068 kernel: ftrace: allocated 157 pages with 5 groups Mar 6 02:26:07.929074 kernel: Dynamic Preempt: voluntary Mar 6 02:26:07.929081 kernel: rcu: Preemptible hierarchical RCU implementation. Mar 6 02:26:07.929088 kernel: rcu: RCU event tracing is enabled. Mar 6 02:26:07.929102 kernel: rcu: RCU restricting CPUs from NR_CPUS=512 to nr_cpu_ids=2. Mar 6 02:26:07.929111 kernel: Trampoline variant of Tasks RCU enabled. Mar 6 02:26:07.929118 kernel: Rude variant of Tasks RCU enabled. Mar 6 02:26:07.929126 kernel: Tracing variant of Tasks RCU enabled. Mar 6 02:26:07.929133 kernel: rcu: RCU calculated value of scheduler-enlistment delay is 100 jiffies. Mar 6 02:26:07.929142 kernel: rcu: Adjusting geometry for rcu_fanout_leaf=16, nr_cpu_ids=2 Mar 6 02:26:07.929149 kernel: RCU Tasks: Setting shift to 1 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=2. Mar 6 02:26:07.929156 kernel: RCU Tasks Rude: Setting shift to 1 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=2. Mar 6 02:26:07.929164 kernel: RCU Tasks Trace: Setting shift to 1 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=2. Mar 6 02:26:07.929172 kernel: Using NULL legacy PIC Mar 6 02:26:07.929181 kernel: NR_IRQS: 33024, nr_irqs: 440, preallocated irqs: 0 Mar 6 02:26:07.929189 kernel: rcu: srcu_init: Setting srcu_struct sizes based on contention. Mar 6 02:26:07.929196 kernel: Console: colour dummy device 80x25 Mar 6 02:26:07.929203 kernel: printk: legacy console [tty1] enabled Mar 6 02:26:07.929210 kernel: printk: legacy console [ttyS0] enabled Mar 6 02:26:07.929217 kernel: printk: legacy bootconsole [earlyser0] disabled Mar 6 02:26:07.929225 kernel: ACPI: Core revision 20240827 Mar 6 02:26:07.929232 kernel: Failed to register legacy timer interrupt Mar 6 02:26:07.929240 kernel: APIC: Switch to symmetric I/O mode setup Mar 6 02:26:07.929249 kernel: x2apic enabled Mar 6 02:26:07.929257 kernel: APIC: Switched APIC routing to: physical x2apic Mar 6 02:26:07.929264 kernel: Hyper-V: Host Build 10.0.26100.1480-1-0 Mar 6 02:26:07.929271 kernel: Hyper-V: enabling crash_kexec_post_notifiers Mar 6 02:26:07.929278 kernel: Hyper-V: Disabling IBT because of Hyper-V bug Mar 6 02:26:07.929286 kernel: Hyper-V: Using IPI hypercalls Mar 6 02:26:07.929293 kernel: APIC: send_IPI() replaced with hv_send_ipi() Mar 6 02:26:07.929301 kernel: APIC: send_IPI_mask() replaced with hv_send_ipi_mask() Mar 6 02:26:07.929308 kernel: APIC: send_IPI_mask_allbutself() replaced with hv_send_ipi_mask_allbutself() Mar 6 02:26:07.929318 kernel: APIC: send_IPI_allbutself() replaced with hv_send_ipi_allbutself() Mar 6 02:26:07.929325 kernel: APIC: send_IPI_all() replaced with hv_send_ipi_all() Mar 6 02:26:07.929332 kernel: APIC: send_IPI_self() replaced with hv_send_ipi_self() Mar 6 02:26:07.929340 kernel: clocksource: tsc-early: mask: 0xffffffffffffffff max_cycles: 0x212735223b2, max_idle_ns: 440795277976 ns Mar 6 02:26:07.929347 kernel: Calibrating delay loop (skipped), value calculated using timer frequency.. 4600.00 BogoMIPS (lpj=2300000) Mar 6 02:26:07.929355 kernel: x86/cpu: User Mode Instruction Prevention (UMIP) activated Mar 6 02:26:07.929362 kernel: Last level iTLB entries: 4KB 0, 2MB 0, 4MB 0 Mar 6 02:26:07.929370 kernel: Last level dTLB entries: 4KB 0, 2MB 0, 4MB 0, 1GB 0 Mar 6 02:26:07.929377 kernel: Spectre V1 : Mitigation: usercopy/swapgs barriers and __user pointer sanitization Mar 6 02:26:07.929384 kernel: Spectre V2 : Mitigation: Retpolines Mar 6 02:26:07.929393 kernel: Spectre V2 : Spectre v2 / SpectreRSB: Filling RSB on context switch and VMEXIT Mar 6 02:26:07.929400 kernel: RETBleed: WARNING: Spectre v2 mitigation leaves CPU vulnerable to RETBleed attacks, data leaks possible! Mar 6 02:26:07.929407 kernel: RETBleed: Vulnerable Mar 6 02:26:07.929415 kernel: Speculative Store Bypass: Vulnerable Mar 6 02:26:07.929422 kernel: active return thunk: its_return_thunk Mar 6 02:26:07.929429 kernel: ITS: Mitigation: Aligned branch/return thunks Mar 6 02:26:07.929436 kernel: x86/fpu: Supporting XSAVE feature 0x001: 'x87 floating point registers' Mar 6 02:26:07.929444 kernel: x86/fpu: Supporting XSAVE feature 0x002: 'SSE registers' Mar 6 02:26:07.929450 kernel: x86/fpu: Supporting XSAVE feature 0x004: 'AVX registers' Mar 6 02:26:07.929458 kernel: x86/fpu: Supporting XSAVE feature 0x020: 'AVX-512 opmask' Mar 6 02:26:07.929466 kernel: x86/fpu: Supporting XSAVE feature 0x040: 'AVX-512 Hi256' Mar 6 02:26:07.929473 kernel: x86/fpu: Supporting XSAVE feature 0x080: 'AVX-512 ZMM_Hi256' Mar 6 02:26:07.929481 kernel: x86/fpu: Supporting XSAVE feature 0x800: 'Control-flow User registers' Mar 6 02:26:07.929488 kernel: x86/fpu: Supporting XSAVE feature 0x20000: 'AMX Tile config' Mar 6 02:26:07.929496 kernel: x86/fpu: Supporting XSAVE feature 0x40000: 'AMX Tile data' Mar 6 02:26:07.929503 kernel: x86/fpu: xstate_offset[2]: 576, xstate_sizes[2]: 256 Mar 6 02:26:07.929510 kernel: x86/fpu: xstate_offset[5]: 832, xstate_sizes[5]: 64 Mar 6 02:26:07.929517 kernel: x86/fpu: xstate_offset[6]: 896, xstate_sizes[6]: 512 Mar 6 02:26:07.929524 kernel: x86/fpu: xstate_offset[7]: 1408, xstate_sizes[7]: 1024 Mar 6 02:26:07.929530 kernel: x86/fpu: xstate_offset[11]: 2432, xstate_sizes[11]: 16 Mar 6 02:26:07.931557 kernel: x86/fpu: xstate_offset[17]: 2496, xstate_sizes[17]: 64 Mar 6 02:26:07.931568 kernel: x86/fpu: xstate_offset[18]: 2560, xstate_sizes[18]: 8192 Mar 6 02:26:07.931580 kernel: x86/fpu: Enabled xstate features 0x608e7, context size is 10752 bytes, using 'compacted' format. Mar 6 02:26:07.931587 kernel: Freeing SMP alternatives memory: 32K Mar 6 02:26:07.931594 kernel: pid_max: default: 32768 minimum: 301 Mar 6 02:26:07.931600 kernel: LSM: initializing lsm=lockdown,capability,landlock,selinux,ima Mar 6 02:26:07.931604 kernel: landlock: Up and running. Mar 6 02:26:07.931609 kernel: SELinux: Initializing. Mar 6 02:26:07.931614 kernel: Mount-cache hash table entries: 16384 (order: 5, 131072 bytes, linear) Mar 6 02:26:07.931621 kernel: Mountpoint-cache hash table entries: 16384 (order: 5, 131072 bytes, linear) Mar 6 02:26:07.931630 kernel: smpboot: CPU0: Intel INTEL(R) XEON(R) PLATINUM 8573C (family: 0x6, model: 0xcf, stepping: 0x2) Mar 6 02:26:07.931638 kernel: Performance Events: unsupported p6 CPU model 207 no PMU driver, software events only. Mar 6 02:26:07.931645 kernel: signal: max sigframe size: 11952 Mar 6 02:26:07.931651 kernel: rcu: Hierarchical SRCU implementation. Mar 6 02:26:07.931656 kernel: rcu: Max phase no-delay instances is 400. Mar 6 02:26:07.931661 kernel: Timer migration: 1 hierarchy levels; 8 children per group; 1 crossnode level Mar 6 02:26:07.931670 kernel: NMI watchdog: Perf NMI watchdog permanently disabled Mar 6 02:26:07.931679 kernel: smp: Bringing up secondary CPUs ... Mar 6 02:26:07.931686 kernel: smpboot: x86: Booting SMP configuration: Mar 6 02:26:07.931693 kernel: .... node #0, CPUs: #1 Mar 6 02:26:07.931698 kernel: smp: Brought up 1 node, 2 CPUs Mar 6 02:26:07.931702 kernel: smpboot: Total of 2 processors activated (9200.00 BogoMIPS) Mar 6 02:26:07.931709 kernel: Memory: 8068832K/8383228K available (14336K kernel code, 2445K rwdata, 26064K rodata, 46196K init, 2564K bss, 308180K reserved, 0K cma-reserved) Mar 6 02:26:07.931718 kernel: devtmpfs: initialized Mar 6 02:26:07.931727 kernel: x86/mm: Memory block size: 128MB Mar 6 02:26:07.931736 kernel: ACPI: PM: Registering ACPI NVS region [mem 0x3fffb000-0x3fffefff] (16384 bytes) Mar 6 02:26:07.931743 kernel: clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1911260446275000 ns Mar 6 02:26:07.931750 kernel: futex hash table entries: 512 (order: 3, 32768 bytes, linear) Mar 6 02:26:07.931757 kernel: pinctrl core: initialized pinctrl subsystem Mar 6 02:26:07.931764 kernel: NET: Registered PF_NETLINK/PF_ROUTE protocol family Mar 6 02:26:07.931772 kernel: audit: initializing netlink subsys (disabled) Mar 6 02:26:07.931780 kernel: audit: type=2000 audit(1772763965.070:1): state=initialized audit_enabled=0 res=1 Mar 6 02:26:07.931788 kernel: thermal_sys: Registered thermal governor 'step_wise' Mar 6 02:26:07.931795 kernel: thermal_sys: Registered thermal governor 'user_space' Mar 6 02:26:07.931803 kernel: cpuidle: using governor menu Mar 6 02:26:07.931810 kernel: acpiphp: ACPI Hot Plug PCI Controller Driver version: 0.5 Mar 6 02:26:07.931818 kernel: dca service started, version 1.12.1 Mar 6 02:26:07.931825 kernel: e820: reserve RAM buffer [mem 0x044fe000-0x07ffffff] Mar 6 02:26:07.931832 kernel: e820: reserve RAM buffer [mem 0x3ff1f000-0x3fffffff] Mar 6 02:26:07.931841 kernel: kprobes: kprobe jump-optimization is enabled. All kprobes are optimized if possible. Mar 6 02:26:07.931849 kernel: HugeTLB: registered 1.00 GiB page size, pre-allocated 0 pages Mar 6 02:26:07.931856 kernel: HugeTLB: 16380 KiB vmemmap can be freed for a 1.00 GiB page Mar 6 02:26:07.931864 kernel: HugeTLB: registered 2.00 MiB page size, pre-allocated 0 pages Mar 6 02:26:07.931871 kernel: HugeTLB: 28 KiB vmemmap can be freed for a 2.00 MiB page Mar 6 02:26:07.931878 kernel: ACPI: Added _OSI(Module Device) Mar 6 02:26:07.931886 kernel: ACPI: Added _OSI(Processor Device) Mar 6 02:26:07.931893 kernel: ACPI: Added _OSI(Processor Aggregator Device) Mar 6 02:26:07.931900 kernel: ACPI: 1 ACPI AML tables successfully acquired and loaded Mar 6 02:26:07.931909 kernel: ACPI: Interpreter enabled Mar 6 02:26:07.931916 kernel: ACPI: PM: (supports S0 S5) Mar 6 02:26:07.931924 kernel: ACPI: Using IOAPIC for interrupt routing Mar 6 02:26:07.931931 kernel: PCI: Using host bridge windows from ACPI; if necessary, use "pci=nocrs" and report a bug Mar 6 02:26:07.931938 kernel: PCI: Ignoring E820 reservations for host bridge windows Mar 6 02:26:07.931946 kernel: ACPI: Enabled 1 GPEs in block 00 to 0F Mar 6 02:26:07.931954 kernel: iommu: Default domain type: Translated Mar 6 02:26:07.931961 kernel: iommu: DMA domain TLB invalidation policy: lazy mode Mar 6 02:26:07.931968 kernel: efivars: Registered efivars operations Mar 6 02:26:07.931976 kernel: PCI: Using ACPI for IRQ routing Mar 6 02:26:07.931984 kernel: PCI: System does not support PCI Mar 6 02:26:07.931991 kernel: vgaarb: loaded Mar 6 02:26:07.931999 kernel: clocksource: Switched to clocksource tsc-early Mar 6 02:26:07.932006 kernel: VFS: Disk quotas dquot_6.6.0 Mar 6 02:26:07.932013 kernel: VFS: Dquot-cache hash table entries: 512 (order 0, 4096 bytes) Mar 6 02:26:07.932021 kernel: pnp: PnP ACPI init Mar 6 02:26:07.932028 kernel: pnp: PnP ACPI: found 3 devices Mar 6 02:26:07.932036 kernel: clocksource: acpi_pm: mask: 0xffffff max_cycles: 0xffffff, max_idle_ns: 2085701024 ns Mar 6 02:26:07.932043 kernel: NET: Registered PF_INET protocol family Mar 6 02:26:07.932052 kernel: IP idents hash table entries: 131072 (order: 8, 1048576 bytes, linear) Mar 6 02:26:07.932059 kernel: tcp_listen_portaddr_hash hash table entries: 4096 (order: 4, 65536 bytes, linear) Mar 6 02:26:07.932067 kernel: Table-perturb hash table entries: 65536 (order: 6, 262144 bytes, linear) Mar 6 02:26:07.932074 kernel: TCP established hash table entries: 65536 (order: 7, 524288 bytes, linear) Mar 6 02:26:07.932081 kernel: TCP bind hash table entries: 65536 (order: 9, 2097152 bytes, linear) Mar 6 02:26:07.932089 kernel: TCP: Hash tables configured (established 65536 bind 65536) Mar 6 02:26:07.932096 kernel: UDP hash table entries: 4096 (order: 5, 131072 bytes, linear) Mar 6 02:26:07.932104 kernel: UDP-Lite hash table entries: 4096 (order: 5, 131072 bytes, linear) Mar 6 02:26:07.932112 kernel: NET: Registered PF_UNIX/PF_LOCAL protocol family Mar 6 02:26:07.932120 kernel: NET: Registered PF_XDP protocol family Mar 6 02:26:07.932127 kernel: PCI: CLS 0 bytes, default 64 Mar 6 02:26:07.932134 kernel: PCI-DMA: Using software bounce buffering for IO (SWIOTLB) Mar 6 02:26:07.932142 kernel: software IO TLB: mapped [mem 0x000000003a9ab000-0x000000003e9ab000] (64MB) Mar 6 02:26:07.932149 kernel: RAPL PMU: API unit is 2^-32 Joules, 1 fixed counters, 10737418240 ms ovfl timer Mar 6 02:26:07.932156 kernel: RAPL PMU: hw unit of domain psys 2^-0 Joules Mar 6 02:26:07.932163 kernel: clocksource: tsc: mask: 0xffffffffffffffff max_cycles: 0x212735223b2, max_idle_ns: 440795277976 ns Mar 6 02:26:07.932171 kernel: clocksource: Switched to clocksource tsc Mar 6 02:26:07.932179 kernel: Initialise system trusted keyrings Mar 6 02:26:07.932187 kernel: workingset: timestamp_bits=39 max_order=21 bucket_order=0 Mar 6 02:26:07.932194 kernel: Key type asymmetric registered Mar 6 02:26:07.932201 kernel: Asymmetric key parser 'x509' registered Mar 6 02:26:07.932208 kernel: Block layer SCSI generic (bsg) driver version 0.4 loaded (major 250) Mar 6 02:26:07.932216 kernel: io scheduler mq-deadline registered Mar 6 02:26:07.932223 kernel: io scheduler kyber registered Mar 6 02:26:07.932230 kernel: io scheduler bfq registered Mar 6 02:26:07.932238 kernel: ioatdma: Intel(R) QuickData Technology Driver 5.00 Mar 6 02:26:07.932250 kernel: Serial: 8250/16550 driver, 4 ports, IRQ sharing enabled Mar 6 02:26:07.932258 kernel: 00:00: ttyS0 at I/O 0x3f8 (irq = 4, base_baud = 115200) is a 16550A Mar 6 02:26:07.932266 kernel: 00:01: ttyS1 at I/O 0x2f8 (irq = 3, base_baud = 115200) is a 16550A Mar 6 02:26:07.932274 kernel: serial8250: ttyS2 at I/O 0x3e8 (irq = 4, base_baud = 115200) is a 16550A Mar 6 02:26:07.932280 kernel: i8042: PNP: No PS/2 controller found. Mar 6 02:26:07.932393 kernel: rtc_cmos 00:02: registered as rtc0 Mar 6 02:26:07.932453 kernel: rtc_cmos 00:02: setting system clock to 2026-03-06T02:26:07 UTC (1772763967) Mar 6 02:26:07.932510 kernel: rtc_cmos 00:02: alarms up to one month, 114 bytes nvram Mar 6 02:26:07.932519 kernel: intel_pstate: Intel P-state driver initializing Mar 6 02:26:07.932527 kernel: efifb: probing for efifb Mar 6 02:26:07.932534 kernel: efifb: framebuffer at 0x40000000, using 3072k, total 3072k Mar 6 02:26:07.933502 kernel: efifb: mode is 1024x768x32, linelength=4096, pages=1 Mar 6 02:26:07.933517 kernel: efifb: scrolling: redraw Mar 6 02:26:07.933525 kernel: efifb: Truecolor: size=8:8:8:8, shift=24:16:8:0 Mar 6 02:26:07.933533 kernel: Console: switching to colour frame buffer device 128x48 Mar 6 02:26:07.933563 kernel: fb0: EFI VGA frame buffer device Mar 6 02:26:07.933571 kernel: pstore: Using crash dump compression: deflate Mar 6 02:26:07.933581 kernel: pstore: Registered efi_pstore as persistent store backend Mar 6 02:26:07.933588 kernel: NET: Registered PF_INET6 protocol family Mar 6 02:26:07.933595 kernel: Segment Routing with IPv6 Mar 6 02:26:07.933602 kernel: In-situ OAM (IOAM) with IPv6 Mar 6 02:26:07.933609 kernel: NET: Registered PF_PACKET protocol family Mar 6 02:26:07.933616 kernel: Key type dns_resolver registered Mar 6 02:26:07.933623 kernel: IPI shorthand broadcast: enabled Mar 6 02:26:07.933631 kernel: sched_clock: Marking stable (2650004091, 80143132)->(3023946845, -293799622) Mar 6 02:26:07.933638 kernel: registered taskstats version 1 Mar 6 02:26:07.933647 kernel: Loading compiled-in X.509 certificates Mar 6 02:26:07.933654 kernel: Loaded X.509 cert 'Kinvolk GmbH: Module signing key for 6.12.74-flatcar: 30893fe9fd219d26109af079e6493e1c8b1c00af' Mar 6 02:26:07.933661 kernel: Demotion targets for Node 0: null Mar 6 02:26:07.933669 kernel: Key type .fscrypt registered Mar 6 02:26:07.933676 kernel: Key type fscrypt-provisioning registered Mar 6 02:26:07.933683 kernel: ima: No TPM chip found, activating TPM-bypass! Mar 6 02:26:07.933690 kernel: ima: Allocated hash algorithm: sha1 Mar 6 02:26:07.933697 kernel: ima: No architecture policies found Mar 6 02:26:07.933704 kernel: clk: Disabling unused clocks Mar 6 02:26:07.933713 kernel: Warning: unable to open an initial console. Mar 6 02:26:07.933720 kernel: Freeing unused kernel image (initmem) memory: 46196K Mar 6 02:26:07.933727 kernel: Write protecting the kernel read-only data: 40960k Mar 6 02:26:07.933734 kernel: Freeing unused kernel image (rodata/data gap) memory: 560K Mar 6 02:26:07.933741 kernel: Run /init as init process Mar 6 02:26:07.933748 kernel: with arguments: Mar 6 02:26:07.933755 kernel: /init Mar 6 02:26:07.933762 kernel: with environment: Mar 6 02:26:07.933769 kernel: HOME=/ Mar 6 02:26:07.933777 kernel: TERM=linux Mar 6 02:26:07.933786 systemd[1]: Successfully made /usr/ read-only. Mar 6 02:26:07.933796 systemd[1]: systemd 256.8 running in system mode (+PAM +AUDIT +SELINUX -APPARMOR +IMA +SMACK +SECCOMP -GCRYPT -GNUTLS +OPENSSL -ACL +BLKID +CURL +ELFUTILS -FIDO2 +IDN2 -IDN +IPTC +KMOD +LIBCRYPTSETUP +LIBCRYPTSETUP_PLUGINS +LIBFDISK +PCRE2 -PWQUALITY -P11KIT -QRENCODE +TPM2 +BZIP2 +LZ4 +XZ +ZLIB +ZSTD -BPF_FRAMEWORK -XKBCOMMON +UTMP -SYSVINIT +LIBARCHIVE) Mar 6 02:26:07.933804 systemd[1]: Detected virtualization microsoft. Mar 6 02:26:07.933812 systemd[1]: Detected architecture x86-64. Mar 6 02:26:07.933819 systemd[1]: Running in initrd. Mar 6 02:26:07.933826 systemd[1]: No hostname configured, using default hostname. Mar 6 02:26:07.933835 systemd[1]: Hostname set to . Mar 6 02:26:07.933843 systemd[1]: Initializing machine ID from random generator. Mar 6 02:26:07.933850 systemd[1]: Queued start job for default target initrd.target. Mar 6 02:26:07.933857 systemd[1]: Started clevis-luks-askpass.path - Forward Password Requests to Clevis Directory Watch. Mar 6 02:26:07.933865 systemd[1]: Started systemd-ask-password-console.path - Dispatch Password Requests to Console Directory Watch. Mar 6 02:26:07.933873 systemd[1]: Expecting device dev-disk-by\x2dlabel-EFI\x2dSYSTEM.device - /dev/disk/by-label/EFI-SYSTEM... Mar 6 02:26:07.933881 systemd[1]: Expecting device dev-disk-by\x2dlabel-OEM.device - /dev/disk/by-label/OEM... Mar 6 02:26:07.933888 systemd[1]: Expecting device dev-disk-by\x2dlabel-ROOT.device - /dev/disk/by-label/ROOT... Mar 6 02:26:07.933898 systemd[1]: Expecting device dev-disk-by\x2dpartlabel-USR\x2dA.device - /dev/disk/by-partlabel/USR-A... Mar 6 02:26:07.933906 systemd[1]: Expecting device dev-disk-by\x2dpartuuid-7130c94a\x2d213a\x2d4e5a\x2d8e26\x2d6cce9662f132.device - /dev/disk/by-partuuid/7130c94a-213a-4e5a-8e26-6cce9662f132... Mar 6 02:26:07.933914 systemd[1]: Expecting device dev-mapper-usr.device - /dev/mapper/usr... Mar 6 02:26:07.933922 systemd[1]: Reached target cryptsetup-pre.target - Local Encrypted Volumes (Pre). Mar 6 02:26:07.933929 systemd[1]: Reached target cryptsetup.target - Local Encrypted Volumes. Mar 6 02:26:07.933937 systemd[1]: Reached target paths.target - Path Units. Mar 6 02:26:07.933944 systemd[1]: Reached target slices.target - Slice Units. Mar 6 02:26:07.933952 systemd[1]: Reached target swap.target - Swaps. Mar 6 02:26:07.933959 systemd[1]: Reached target timers.target - Timer Units. Mar 6 02:26:07.933966 systemd[1]: Listening on iscsid.socket - Open-iSCSI iscsid Socket. Mar 6 02:26:07.933973 systemd[1]: Listening on iscsiuio.socket - Open-iSCSI iscsiuio Socket. Mar 6 02:26:07.933980 systemd[1]: Listening on systemd-journald-dev-log.socket - Journal Socket (/dev/log). Mar 6 02:26:07.933987 systemd[1]: Listening on systemd-journald.socket - Journal Sockets. Mar 6 02:26:07.933995 systemd[1]: Listening on systemd-networkd.socket - Network Service Netlink Socket. Mar 6 02:26:07.934002 systemd[1]: Listening on systemd-udevd-control.socket - udev Control Socket. Mar 6 02:26:07.934009 systemd[1]: Listening on systemd-udevd-kernel.socket - udev Kernel Socket. Mar 6 02:26:07.934018 systemd[1]: Reached target sockets.target - Socket Units. Mar 6 02:26:07.934026 systemd[1]: Starting ignition-setup-pre.service - Ignition env setup... Mar 6 02:26:07.934033 systemd[1]: Starting kmod-static-nodes.service - Create List of Static Device Nodes... Mar 6 02:26:07.934041 systemd[1]: Finished network-cleanup.service - Network Cleanup. Mar 6 02:26:07.934049 systemd[1]: systemd-battery-check.service - Check battery level during early boot was skipped because of an unmet condition check (ConditionDirectoryNotEmpty=/sys/class/power_supply). Mar 6 02:26:07.934056 systemd[1]: Starting systemd-fsck-usr.service... Mar 6 02:26:07.934064 systemd[1]: Starting systemd-journald.service - Journal Service... Mar 6 02:26:07.934072 systemd[1]: Starting systemd-modules-load.service - Load Kernel Modules... Mar 6 02:26:07.934089 systemd[1]: Starting systemd-vconsole-setup.service - Virtual Console Setup... Mar 6 02:26:07.934098 systemd[1]: Finished ignition-setup-pre.service - Ignition env setup. Mar 6 02:26:07.934106 systemd[1]: Finished kmod-static-nodes.service - Create List of Static Device Nodes. Mar 6 02:26:07.934116 systemd[1]: Finished systemd-fsck-usr.service. Mar 6 02:26:07.934143 systemd-journald[186]: Collecting audit messages is disabled. Mar 6 02:26:07.934164 systemd[1]: Starting systemd-tmpfiles-setup-dev-early.service - Create Static Device Nodes in /dev gracefully... Mar 6 02:26:07.934176 systemd-journald[186]: Journal started Mar 6 02:26:07.934197 systemd-journald[186]: Runtime Journal (/run/log/journal/0a7ab7e8a42243038915915383f57e5c) is 8M, max 158.6M, 150.6M free. Mar 6 02:26:07.938329 systemd[1]: Started systemd-journald.service - Journal Service. Mar 6 02:26:07.940652 systemd-modules-load[187]: Inserted module 'overlay' Mar 6 02:26:07.942484 systemd[1]: Starting systemd-tmpfiles-setup.service - Create System Files and Directories... Mar 6 02:26:07.951562 systemd[1]: Finished systemd-vconsole-setup.service - Virtual Console Setup. Mar 6 02:26:07.958901 systemd[1]: Finished systemd-tmpfiles-setup-dev-early.service - Create Static Device Nodes in /dev gracefully. Mar 6 02:26:07.965835 systemd[1]: Starting dracut-cmdline-ask.service - dracut ask for additional cmdline parameters... Mar 6 02:26:07.969484 systemd-tmpfiles[200]: /usr/lib/tmpfiles.d/var.conf:14: Duplicate line for path "/var/log", ignoring. Mar 6 02:26:07.972640 systemd[1]: Starting systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev... Mar 6 02:26:07.981919 kernel: bridge: filtering via arp/ip/ip6tables is no longer available by default. Update your scripts to load br_netfilter if you need this. Mar 6 02:26:07.981277 systemd[1]: Finished systemd-tmpfiles-setup.service - Create System Files and Directories. Mar 6 02:26:07.988557 kernel: Bridge firewalling registered Mar 6 02:26:07.989584 systemd-modules-load[187]: Inserted module 'br_netfilter' Mar 6 02:26:07.991572 systemd[1]: Finished systemd-modules-load.service - Load Kernel Modules. Mar 6 02:26:07.993587 systemd[1]: Starting systemd-sysctl.service - Apply Kernel Variables... Mar 6 02:26:08.000759 systemd[1]: Finished systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev. Mar 6 02:26:08.006997 systemd[1]: Finished dracut-cmdline-ask.service - dracut ask for additional cmdline parameters. Mar 6 02:26:08.008440 systemd[1]: Finished systemd-sysctl.service - Apply Kernel Variables. Mar 6 02:26:08.014592 systemd[1]: Starting dracut-cmdline.service - dracut cmdline hook... Mar 6 02:26:08.022780 systemd[1]: Starting systemd-resolved.service - Network Name Resolution... Mar 6 02:26:08.032176 dracut-cmdline[226]: Using kernel command line parameters: rd.driver.pre=btrfs 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=5bef16c10382b6f77f9493af2297475832ff2f09f1ada4155425ad9b32dd6e53 Mar 6 02:26:08.067088 systemd-resolved[227]: Positive Trust Anchors: Mar 6 02:26:08.067100 systemd-resolved[227]: . IN DS 20326 8 2 e06d44b80b8f1d39a95c0b0d7c65d08458e880409bbc683457104237c7f8ec8d Mar 6 02:26:08.067130 systemd-resolved[227]: 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 Mar 6 02:26:08.085906 systemd-resolved[227]: Defaulting to hostname 'linux'. Mar 6 02:26:08.088087 systemd[1]: Started systemd-resolved.service - Network Name Resolution. Mar 6 02:26:08.092470 systemd[1]: Reached target nss-lookup.target - Host and Network Name Lookups. Mar 6 02:26:08.102558 kernel: SCSI subsystem initialized Mar 6 02:26:08.109555 kernel: Loading iSCSI transport class v2.0-870. Mar 6 02:26:08.117576 kernel: iscsi: registered transport (tcp) Mar 6 02:26:08.132634 kernel: iscsi: registered transport (qla4xxx) Mar 6 02:26:08.132671 kernel: QLogic iSCSI HBA Driver Mar 6 02:26:08.143951 systemd[1]: Starting systemd-network-generator.service - Generate network units from Kernel command line... Mar 6 02:26:08.156496 systemd[1]: Finished systemd-network-generator.service - Generate network units from Kernel command line. Mar 6 02:26:08.157704 systemd[1]: Reached target network-pre.target - Preparation for Network. Mar 6 02:26:08.188706 systemd[1]: Finished dracut-cmdline.service - dracut cmdline hook. Mar 6 02:26:08.191659 systemd[1]: Starting dracut-pre-udev.service - dracut pre-udev hook... Mar 6 02:26:08.237569 kernel: raid6: avx512x4 gen() 45014 MB/s Mar 6 02:26:08.254553 kernel: raid6: avx512x2 gen() 45420 MB/s Mar 6 02:26:08.271550 kernel: raid6: avx512x1 gen() 30205 MB/s Mar 6 02:26:08.289552 kernel: raid6: avx2x4 gen() 42074 MB/s Mar 6 02:26:08.306551 kernel: raid6: avx2x2 gen() 43765 MB/s Mar 6 02:26:08.323966 kernel: raid6: avx2x1 gen() 28697 MB/s Mar 6 02:26:08.324045 kernel: raid6: using algorithm avx512x2 gen() 45420 MB/s Mar 6 02:26:08.342816 kernel: raid6: .... xor() 37409 MB/s, rmw enabled Mar 6 02:26:08.342842 kernel: raid6: using avx512x2 recovery algorithm Mar 6 02:26:08.358559 kernel: xor: automatically using best checksumming function avx Mar 6 02:26:08.464560 kernel: Btrfs loaded, zoned=no, fsverity=no Mar 6 02:26:08.468751 systemd[1]: Finished dracut-pre-udev.service - dracut pre-udev hook. Mar 6 02:26:08.472566 systemd[1]: Starting systemd-udevd.service - Rule-based Manager for Device Events and Files... Mar 6 02:26:08.496719 systemd-udevd[436]: Using default interface naming scheme 'v255'. Mar 6 02:26:08.500901 systemd[1]: Started systemd-udevd.service - Rule-based Manager for Device Events and Files. Mar 6 02:26:08.503653 systemd[1]: Starting dracut-pre-trigger.service - dracut pre-trigger hook... Mar 6 02:26:08.520193 dracut-pre-trigger[440]: rd.md=0: removing MD RAID activation Mar 6 02:26:08.537746 systemd[1]: Finished dracut-pre-trigger.service - dracut pre-trigger hook. Mar 6 02:26:08.540654 systemd[1]: Starting systemd-udev-trigger.service - Coldplug All udev Devices... Mar 6 02:26:08.569114 systemd[1]: Finished systemd-udev-trigger.service - Coldplug All udev Devices. Mar 6 02:26:08.572312 systemd[1]: Starting dracut-initqueue.service - dracut initqueue hook... Mar 6 02:26:08.616562 kernel: cryptd: max_cpu_qlen set to 1000 Mar 6 02:26:08.633554 kernel: hv_vmbus: Vmbus version:5.3 Mar 6 02:26:08.634901 systemd[1]: systemd-vconsole-setup.service: Deactivated successfully. Mar 6 02:26:08.636945 systemd[1]: Stopped systemd-vconsole-setup.service - Virtual Console Setup. Mar 6 02:26:08.641567 kernel: AES CTR mode by8 optimization enabled Mar 6 02:26:08.644519 systemd[1]: Stopping systemd-vconsole-setup.service - Virtual Console Setup... Mar 6 02:26:08.658229 systemd[1]: Starting systemd-vconsole-setup.service - Virtual Console Setup... Mar 6 02:26:08.667157 systemd[1]: systemd-vconsole-setup.service: Deactivated successfully. Mar 6 02:26:08.669155 systemd[1]: Stopped systemd-vconsole-setup.service - Virtual Console Setup. Mar 6 02:26:08.676744 systemd[1]: Starting systemd-vconsole-setup.service - Virtual Console Setup... Mar 6 02:26:08.686002 kernel: hv_vmbus: registering driver hyperv_keyboard Mar 6 02:26:08.688223 kernel: pps_core: LinuxPPS API ver. 1 registered Mar 6 02:26:08.688264 kernel: pps_core: Software ver. 5.3.6 - Copyright 2005-2007 Rodolfo Giometti Mar 6 02:26:08.693560 kernel: input: AT Translated Set 2 keyboard as /devices/LNXSYSTM:00/LNXSYBUS:00/ACPI0004:00/MSFT1000:00/d34b2567-b9b6-42b9-8778-0a4ec0b955bf/serio0/input/input0 Mar 6 02:26:08.708734 systemd[1]: Finished systemd-vconsole-setup.service - Virtual Console Setup. Mar 6 02:26:08.717224 kernel: hv_vmbus: registering driver hv_pci Mar 6 02:26:08.717247 kernel: PTP clock support registered Mar 6 02:26:08.722557 kernel: hv_vmbus: registering driver hv_netvsc Mar 6 02:26:08.724902 kernel: hv_utils: Registering HyperV Utility Driver Mar 6 02:26:08.724936 kernel: hid: raw HID events driver (C) Jiri Kosina Mar 6 02:26:08.724948 kernel: hv_vmbus: registering driver hv_utils Mar 6 02:26:08.730307 kernel: hv_vmbus: registering driver hv_storvsc Mar 6 02:26:08.730344 kernel: hv_utils: Shutdown IC version 3.2 Mar 6 02:26:08.733222 kernel: hv_pci 7ad35d50-c05b-47ab-b3a0-56a9a845852b: PCI VMBus probing: Using version 0x10004 Mar 6 02:26:08.735820 kernel: hv_utils: Heartbeat IC version 3.0 Mar 6 02:26:08.739085 kernel: hv_utils: TimeSync IC version 4.0 Mar 6 02:26:08.739118 kernel: hv_vmbus: registering driver hid_hyperv Mar 6 02:26:08.739130 kernel: hv_pci 7ad35d50-c05b-47ab-b3a0-56a9a845852b: PCI host bridge to bus c05b:00 Mar 6 02:26:08.821395 systemd-resolved[227]: Clock change detected. Flushing caches. Mar 6 02:26:08.825545 kernel: input: Microsoft Vmbus HID-compliant Mouse as /devices/0006:045E:0621.0001/input/input1 Mar 6 02:26:08.828513 kernel: pci_bus c05b:00: root bus resource [mem 0xfc0000000-0xfc007ffff window] Mar 6 02:26:08.828914 kernel: pci_bus c05b:00: No busn resource found for root bus, will use [bus 00-ff] Mar 6 02:26:08.829042 kernel: scsi host0: storvsc_host_t Mar 6 02:26:08.831224 kernel: hid-hyperv 0006:045E:0621.0001: input: VIRTUAL HID v0.01 Mouse [Microsoft Vmbus HID-compliant Mouse] on Mar 6 02:26:08.833508 kernel: scsi 0:0:0:2: CD-ROM Msft Virtual DVD-ROM 1.0 PQ: 0 ANSI: 5 Mar 6 02:26:08.833560 kernel: pci c05b:00:00.0: [1414:00a9] type 00 class 0x010802 PCIe Endpoint Mar 6 02:26:08.838698 kernel: hv_netvsc f8615163-0000-1000-2000-000d3addfbcf (unnamed net_device) (uninitialized): VF slot 1 added Mar 6 02:26:08.841503 kernel: pci c05b:00:00.0: BAR 0 [mem 0xfc0000000-0xfc007ffff 64bit] Mar 6 02:26:08.858513 kernel: pci_bus c05b:00: busn_res: [bus 00-ff] end is updated to 00 Mar 6 02:26:08.861914 kernel: pci c05b:00:00.0: BAR 0 [mem 0xfc0000000-0xfc007ffff 64bit]: assigned Mar 6 02:26:08.867487 kernel: sr 0:0:0:2: [sr0] scsi-1 drive Mar 6 02:26:08.867688 kernel: cdrom: Uniform CD-ROM driver Revision: 3.20 Mar 6 02:26:08.868516 kernel: sr 0:0:0:2: Attached scsi CD-ROM sr0 Mar 6 02:26:08.883512 kernel: nvme nvme0: pci function c05b:00:00.0 Mar 6 02:26:08.883697 kernel: hv_storvsc f8b3781a-1e82-4818-a1c3-63d806ec15bb: tag#182 cmd 0x85 status: scsi 0x2 srb 0x6 hv 0xc0000001 Mar 6 02:26:08.885027 kernel: nvme c05b:00:00.0: enabling device (0000 -> 0002) Mar 6 02:26:08.901514 kernel: hv_storvsc f8b3781a-1e82-4818-a1c3-63d806ec15bb: tag#154 cmd 0x85 status: scsi 0x2 srb 0x6 hv 0xc0000001 Mar 6 02:26:09.043505 kernel: nvme nvme0: 2/0/0 default/read/poll queues Mar 6 02:26:09.048513 kernel: nvme0n1: p1 p2 p3 p4 p6 p7 p9 Mar 6 02:26:09.338512 kernel: nvme nvme0: using unchecked data buffer Mar 6 02:26:09.527932 systemd[1]: Found device dev-disk-by\x2dlabel-EFI\x2dSYSTEM.device - MSFT NVMe Accelerator v1.0 EFI-SYSTEM. Mar 6 02:26:09.558240 systemd[1]: Found device dev-disk-by\x2dlabel-ROOT.device - MSFT NVMe Accelerator v1.0 ROOT. Mar 6 02:26:09.570969 systemd[1]: Found device dev-disk-by\x2dlabel-OEM.device - MSFT NVMe Accelerator v1.0 OEM. Mar 6 02:26:09.573778 systemd[1]: Finished dracut-initqueue.service - dracut initqueue hook. Mar 6 02:26:09.592248 systemd[1]: Found device dev-disk-by\x2dpartlabel-USR\x2dA.device - MSFT NVMe Accelerator v1.0 USR-A. Mar 6 02:26:09.593942 systemd[1]: Found device dev-disk-by\x2dpartuuid-7130c94a\x2d213a\x2d4e5a\x2d8e26\x2d6cce9662f132.device - MSFT NVMe Accelerator v1.0 USR-A. Mar 6 02:26:09.596911 systemd[1]: Reached target remote-fs-pre.target - Preparation for Remote File Systems. Mar 6 02:26:09.600122 systemd[1]: Reached target remote-cryptsetup.target - Remote Encrypted Volumes. Mar 6 02:26:09.604539 systemd[1]: Reached target remote-fs.target - Remote File Systems. Mar 6 02:26:09.609121 systemd[1]: Starting disk-uuid.service - Generate new UUID for disk GPT if necessary... Mar 6 02:26:09.612606 systemd[1]: Starting dracut-pre-mount.service - dracut pre-mount hook... Mar 6 02:26:09.625683 systemd[1]: Finished dracut-pre-mount.service - dracut pre-mount hook. Mar 6 02:26:09.634829 kernel: nvme0n1: p1 p2 p3 p4 p6 p7 p9 Mar 6 02:26:09.864618 kernel: hv_pci 00000001-7870-47b5-b203-907d12ca697e: PCI VMBus probing: Using version 0x10004 Mar 6 02:26:09.864785 kernel: hv_pci 00000001-7870-47b5-b203-907d12ca697e: PCI host bridge to bus 7870:00 Mar 6 02:26:09.867501 kernel: pci_bus 7870:00: root bus resource [mem 0xfc2000000-0xfc4007fff window] Mar 6 02:26:09.869007 kernel: pci_bus 7870:00: No busn resource found for root bus, will use [bus 00-ff] Mar 6 02:26:09.873564 kernel: pci 7870:00:00.0: [1414:00ba] type 00 class 0x020000 PCIe Endpoint Mar 6 02:26:09.876606 kernel: pci 7870:00:00.0: BAR 0 [mem 0xfc2000000-0xfc3ffffff 64bit pref] Mar 6 02:26:09.882815 kernel: pci 7870:00:00.0: BAR 4 [mem 0xfc4000000-0xfc4007fff 64bit pref] Mar 6 02:26:09.882839 kernel: pci 7870:00:00.0: enabling Extended Tags Mar 6 02:26:09.898525 kernel: pci_bus 7870:00: busn_res: [bus 00-ff] end is updated to 00 Mar 6 02:26:09.898681 kernel: pci 7870:00:00.0: BAR 0 [mem 0xfc2000000-0xfc3ffffff 64bit pref]: assigned Mar 6 02:26:09.898808 kernel: pci 7870:00:00.0: BAR 4 [mem 0xfc4000000-0xfc4007fff 64bit pref]: assigned Mar 6 02:26:09.908721 kernel: mana 7870:00:00.0: enabling device (0000 -> 0002) Mar 6 02:26:09.917506 kernel: mana 7870:00:00.0: Microsoft Azure Network Adapter protocol version: 0.1.1 Mar 6 02:26:09.919509 kernel: hv_netvsc f8615163-0000-1000-2000-000d3addfbcf eth0: VF registering: eth1 Mar 6 02:26:09.919628 kernel: mana 7870:00:00.0 eth1: joined to eth0 Mar 6 02:26:09.923512 kernel: mana 7870:00:00.0 enP30832s1: renamed from eth1 Mar 6 02:26:10.643227 disk-uuid[663]: The operation has completed successfully. Mar 6 02:26:10.645216 kernel: nvme0n1: p1 p2 p3 p4 p6 p7 p9 Mar 6 02:26:10.689280 systemd[1]: disk-uuid.service: Deactivated successfully. Mar 6 02:26:10.689359 systemd[1]: Finished disk-uuid.service - Generate new UUID for disk GPT if necessary. Mar 6 02:26:10.721350 systemd[1]: Starting verity-setup.service - Verity Setup for /dev/mapper/usr... Mar 6 02:26:10.737961 sh[701]: Success Mar 6 02:26:10.768844 kernel: device-mapper: core: CONFIG_IMA_DISABLE_HTABLE is disabled. Duplicate IMA measurements will not be recorded in the IMA log. Mar 6 02:26:10.768883 kernel: device-mapper: uevent: version 1.0.3 Mar 6 02:26:10.770129 kernel: device-mapper: ioctl: 4.48.0-ioctl (2023-03-01) initialised: dm-devel@lists.linux.dev Mar 6 02:26:10.778795 kernel: device-mapper: verity: sha256 using shash "sha256-ni" Mar 6 02:26:11.000937 systemd[1]: Found device dev-mapper-usr.device - /dev/mapper/usr. Mar 6 02:26:11.006613 systemd[1]: Mounting sysusr-usr.mount - /sysusr/usr... Mar 6 02:26:11.018233 systemd[1]: Finished verity-setup.service - Verity Setup for /dev/mapper/usr. Mar 6 02:26:11.028572 kernel: BTRFS: device fsid 1235dd15-5252-4928-9c6c-372370c6bfca devid 1 transid 39 /dev/mapper/usr (254:0) scanned by mount (714) Mar 6 02:26:11.028612 kernel: BTRFS info (device dm-0): first mount of filesystem 1235dd15-5252-4928-9c6c-372370c6bfca Mar 6 02:26:11.029580 kernel: BTRFS info (device dm-0): using crc32c (crc32c-intel) checksum algorithm Mar 6 02:26:11.360332 kernel: BTRFS info (device dm-0 state E): enabling ssd optimizations Mar 6 02:26:11.360401 kernel: BTRFS info (device dm-0 state E): disabling log replay at mount time Mar 6 02:26:11.361546 kernel: BTRFS info (device dm-0 state E): enabling free space tree Mar 6 02:26:11.397303 systemd[1]: Mounted sysusr-usr.mount - /sysusr/usr. Mar 6 02:26:11.399899 systemd[1]: Reached target initrd-usr-fs.target - Initrd /usr File System. Mar 6 02:26:11.403616 systemd[1]: afterburn-network-kargs.service - Afterburn Initrd Setup Network Kernel Arguments was skipped because no trigger condition checks were met. Mar 6 02:26:11.404283 systemd[1]: Starting ignition-setup.service - Ignition (setup)... Mar 6 02:26:11.409073 systemd[1]: Starting parse-ip-for-networkd.service - Write systemd-networkd units from cmdline... Mar 6 02:26:11.441517 kernel: BTRFS: device label OEM devid 1 transid 12 /dev/nvme0n1p6 (259:5) scanned by mount (747) Mar 6 02:26:11.443515 kernel: BTRFS info (device nvme0n1p6): first mount of filesystem 993ea71e-e97d-4f5e-b5c7-fdac31a53b6b Mar 6 02:26:11.445523 kernel: BTRFS info (device nvme0n1p6): using crc32c (crc32c-intel) checksum algorithm Mar 6 02:26:11.463724 kernel: BTRFS info (device nvme0n1p6): enabling ssd optimizations Mar 6 02:26:11.463758 kernel: BTRFS info (device nvme0n1p6): turning on async discard Mar 6 02:26:11.463767 kernel: BTRFS info (device nvme0n1p6): enabling free space tree Mar 6 02:26:11.469508 kernel: BTRFS info (device nvme0n1p6): last unmount of filesystem 993ea71e-e97d-4f5e-b5c7-fdac31a53b6b Mar 6 02:26:11.470148 systemd[1]: Finished ignition-setup.service - Ignition (setup). Mar 6 02:26:11.473610 systemd[1]: Starting ignition-fetch-offline.service - Ignition (fetch-offline)... Mar 6 02:26:11.495454 systemd[1]: Finished parse-ip-for-networkd.service - Write systemd-networkd units from cmdline. Mar 6 02:26:11.502453 systemd[1]: Starting systemd-networkd.service - Network Configuration... Mar 6 02:26:11.538066 systemd-networkd[883]: lo: Link UP Mar 6 02:26:11.542586 kernel: mana 7870:00:00.0 enP30832s1: Configured vPort 0 PD 18 DB 16 Mar 6 02:26:11.538074 systemd-networkd[883]: lo: Gained carrier Mar 6 02:26:11.538930 systemd-networkd[883]: Enumeration completed Mar 6 02:26:11.539462 systemd-networkd[883]: eth0: found matching network '/usr/lib/systemd/network/zz-default.network', based on potentially unpredictable interface name. Mar 6 02:26:11.553543 kernel: mana 7870:00:00.0 enP30832s1: Configured steering vPort 0 entries 64 Mar 6 02:26:11.553672 kernel: hv_netvsc f8615163-0000-1000-2000-000d3addfbcf eth0: Data path switched to VF: enP30832s1 Mar 6 02:26:11.539465 systemd-networkd[883]: eth0: Configuring with /usr/lib/systemd/network/zz-default.network. Mar 6 02:26:11.539599 systemd[1]: Started systemd-networkd.service - Network Configuration. Mar 6 02:26:11.545929 systemd[1]: Reached target network.target - Network. Mar 6 02:26:11.550415 systemd-networkd[883]: enP30832s1: Link UP Mar 6 02:26:11.550477 systemd-networkd[883]: eth0: Link UP Mar 6 02:26:11.550582 systemd-networkd[883]: eth0: Gained carrier Mar 6 02:26:11.550592 systemd-networkd[883]: eth0: found matching network '/usr/lib/systemd/network/zz-default.network', based on potentially unpredictable interface name. Mar 6 02:26:11.565538 systemd-networkd[883]: enP30832s1: Gained carrier Mar 6 02:26:11.574534 systemd-networkd[883]: eth0: DHCPv4 address 10.200.8.28/24, gateway 10.200.8.1 acquired from 168.63.129.16 Mar 6 02:26:12.457240 ignition[840]: Ignition 2.22.0 Mar 6 02:26:12.457251 ignition[840]: Stage: fetch-offline Mar 6 02:26:12.457338 ignition[840]: no configs at "/usr/lib/ignition/base.d" Mar 6 02:26:12.460368 systemd[1]: Finished ignition-fetch-offline.service - Ignition (fetch-offline). Mar 6 02:26:12.457344 ignition[840]: no config dir at "/usr/lib/ignition/base.platform.d/azure" Mar 6 02:26:12.457417 ignition[840]: parsed url from cmdline: "" Mar 6 02:26:12.457420 ignition[840]: no config URL provided Mar 6 02:26:12.457423 ignition[840]: reading system config file "/usr/lib/ignition/user.ign" Mar 6 02:26:12.457428 ignition[840]: no config at "/usr/lib/ignition/user.ign" Mar 6 02:26:12.457434 ignition[840]: failed to fetch config: resource requires networking Mar 6 02:26:12.459234 ignition[840]: Ignition finished successfully Mar 6 02:26:12.471612 systemd[1]: Starting ignition-fetch.service - Ignition (fetch)... Mar 6 02:26:12.498530 ignition[892]: Ignition 2.22.0 Mar 6 02:26:12.498539 ignition[892]: Stage: fetch Mar 6 02:26:12.498718 ignition[892]: no configs at "/usr/lib/ignition/base.d" Mar 6 02:26:12.498726 ignition[892]: no config dir at "/usr/lib/ignition/base.platform.d/azure" Mar 6 02:26:12.499235 ignition[892]: parsed url from cmdline: "" Mar 6 02:26:12.499238 ignition[892]: no config URL provided Mar 6 02:26:12.499275 ignition[892]: reading system config file "/usr/lib/ignition/user.ign" Mar 6 02:26:12.499279 ignition[892]: no config at "/usr/lib/ignition/user.ign" Mar 6 02:26:12.499294 ignition[892]: GET http://169.254.169.254/metadata/instance/compute/userData?api-version=2021-01-01&format=text: attempt #1 Mar 6 02:26:12.560702 ignition[892]: GET result: OK Mar 6 02:26:12.560753 ignition[892]: config has been read from IMDS userdata Mar 6 02:26:12.560764 ignition[892]: parsing config with SHA512: 6ce0ae082f309c368ca0bf25d4b4bc71c626468813b761e0436c935d581e6909f3dd680b2fa53b19641b778455403bc9936d6e586fe7b2f9e383aec04bc31e7f Mar 6 02:26:12.563439 unknown[892]: fetched base config from "system" Mar 6 02:26:12.563444 unknown[892]: fetched base config from "system" Mar 6 02:26:12.564873 ignition[892]: fetch: fetch complete Mar 6 02:26:12.563449 unknown[892]: fetched user config from "azure" Mar 6 02:26:12.564878 ignition[892]: fetch: fetch passed Mar 6 02:26:12.568850 systemd[1]: Finished ignition-fetch.service - Ignition (fetch). Mar 6 02:26:12.564921 ignition[892]: Ignition finished successfully Mar 6 02:26:12.572056 systemd[1]: Starting ignition-kargs.service - Ignition (kargs)... Mar 6 02:26:12.598127 ignition[898]: Ignition 2.22.0 Mar 6 02:26:12.598136 ignition[898]: Stage: kargs Mar 6 02:26:12.600396 systemd[1]: Finished ignition-kargs.service - Ignition (kargs). Mar 6 02:26:12.598307 ignition[898]: no configs at "/usr/lib/ignition/base.d" Mar 6 02:26:12.601799 systemd[1]: Starting ignition-disks.service - Ignition (disks)... Mar 6 02:26:12.598313 ignition[898]: no config dir at "/usr/lib/ignition/base.platform.d/azure" Mar 6 02:26:12.599343 ignition[898]: kargs: kargs passed Mar 6 02:26:12.599367 ignition[898]: Ignition finished successfully Mar 6 02:26:12.626618 ignition[905]: Ignition 2.22.0 Mar 6 02:26:12.626627 ignition[905]: Stage: disks Mar 6 02:26:12.626811 ignition[905]: no configs at "/usr/lib/ignition/base.d" Mar 6 02:26:12.626818 ignition[905]: no config dir at "/usr/lib/ignition/base.platform.d/azure" Mar 6 02:26:12.627261 ignition[905]: disks: createFilesystems: op(1): [started] waiting for devices [/dev/disk/by-partlabel/ROOT] Mar 6 02:26:12.632487 ignition[905]: disks: createFilesystems: op(1): [finished] waiting for devices [/dev/disk/by-partlabel/ROOT] Mar 6 02:26:12.632566 ignition[905]: disks: createFilesystems: created device alias for "/dev/disk/by-partlabel/ROOT": "/run/ignition/dev_aliases/dev/disk/by-partlabel/ROOT" -> "/dev/nvme0n1p9" Mar 6 02:26:12.632621 ignition[905]: disks: createFilesystems: op(2): [started] determining filesystem type of "/dev/disk/by-partlabel/ROOT" Mar 6 02:26:12.648563 ignition[905]: disks: createFilesystems: op(2): [finished] determining filesystem type of "/dev/disk/by-partlabel/ROOT" Mar 6 02:26:12.648774 ignition[905]: disks: createFilesystems: found ext4 filesystem at "/dev/disk/by-partlabel/ROOT" with uuid "16ab7223-a8af-43d2-ad40-7e1bf0ff2a89" and label "ROOT" Mar 6 02:26:12.648798 ignition[905]: disks: createFilesystems: op(3): [started] wiping filesystem signatures from "/run/ignition/dev_aliases/dev/disk/by-partlabel/ROOT" Mar 6 02:26:12.648803 ignition[905]: disks: createFilesystems: op(3): executing: "wipefs" "-a" "/run/ignition/dev_aliases/dev/disk/by-partlabel/ROOT" Mar 6 02:26:12.703049 ignition[905]: disks: createFilesystems: op(3): [finished] wiping filesystem signatures from "/run/ignition/dev_aliases/dev/disk/by-partlabel/ROOT" Mar 6 02:26:12.703072 ignition[905]: disks: createFilesystems: op(4): [started] creating "xfs" filesystem on "/run/ignition/dev_aliases/dev/disk/by-partlabel/ROOT" Mar 6 02:26:12.703079 ignition[905]: disks: createFilesystems: op(4): executing: "mkfs.xfs" "-L" "ROOT" "-m" "uuid=9aa5237a-ab6b-458b-a7e8-f25e2baef1a3" "-f" "/run/ignition/dev_aliases/dev/disk/by-partlabel/ROOT" Mar 6 02:26:13.339670 systemd-networkd[883]: eth0: Gained IPv6LL Mar 6 02:26:13.380815 ignition[905]: disks: createFilesystems: op(4): [finished] creating "xfs" filesystem on "/run/ignition/dev_aliases/dev/disk/by-partlabel/ROOT" Mar 6 02:26:13.380869 ignition[905]: disks: createFilesystems: op(5): [started] waiting for triggered uevent Mar 6 02:26:13.380875 ignition[905]: disks: createFilesystems: op(5): executing: "udevadm" "trigger" "--settle" "/dev/nvme0n1p9" Mar 6 02:26:14.550148 ignition[905]: disks: createFilesystems: op(5): [finished] waiting for triggered uevent Mar 6 02:26:14.552374 ignition[905]: disks: disks passed Mar 6 02:26:14.554252 systemd[1]: Finished ignition-disks.service - Ignition (disks). Mar 6 02:26:14.552443 ignition[905]: Ignition finished successfully Mar 6 02:26:14.560140 systemd[1]: Reached target initrd-root-device.target - Initrd Root Device. Mar 6 02:26:14.561539 systemd[1]: Reached target local-fs-pre.target - Preparation for Local File Systems. Mar 6 02:26:14.564337 systemd[1]: Reached target local-fs.target - Local File Systems. Mar 6 02:26:14.567551 systemd[1]: Reached target sysinit.target - System Initialization. Mar 6 02:26:14.571554 systemd[1]: Reached target basic.target - Basic System. Mar 6 02:26:14.575055 systemd[1]: Starting systemd-fsck-root.service - File System Check on /dev/disk/by-label/ROOT... Mar 6 02:26:14.596867 systemd-fsck[919]: nvme0n1p9: fsck.xfs doesn't exist, not checking file system. Mar 6 02:26:14.598464 systemd[1]: Finished systemd-fsck-root.service - File System Check on /dev/disk/by-label/ROOT. Mar 6 02:26:14.604850 systemd[1]: Mounting sysroot.mount - /sysroot... Mar 6 02:26:14.816732 kernel: SGI XFS with ACLs, security attributes, quota, no debug enabled Mar 6 02:26:14.819510 kernel: XFS (nvme0n1p9): Mounting V5 Filesystem 9aa5237a-ab6b-458b-a7e8-f25e2baef1a3 Mar 6 02:26:14.832508 kernel: XFS (nvme0n1p9): Ending clean mount Mar 6 02:26:14.834588 systemd[1]: Mounted sysroot.mount - /sysroot. Mar 6 02:26:14.835836 systemd[1]: Reached target initrd-root-fs.target - Initrd Root File System. Mar 6 02:26:14.842693 systemd[1]: Mounting sysroot-oem.mount - /sysroot/oem... Mar 6 02:26:14.847074 systemd[1]: Mounting sysroot-usr.mount - /sysroot/usr... Mar 6 02:26:14.854616 systemd[1]: Starting flatcar-metadata-hostname.service - Flatcar Metadata Hostname Agent... Mar 6 02:26:14.856216 systemd[1]: ignition-remount-sysroot.service - Remount /sysroot read-write for Ignition was skipped because of an unmet condition check (ConditionPathIsReadWrite=!/sysroot). Mar 6 02:26:14.858161 systemd[1]: Reached target ignition-diskful.target - Ignition Boot Disk Setup. Mar 6 02:26:14.862253 systemd[1]: Mounted sysroot-usr.mount - /sysroot/usr. Mar 6 02:26:14.871538 kernel: BTRFS: device label OEM devid 1 transid 12 /dev/nvme0n1p6 (259:5) scanned by mount (934) Mar 6 02:26:14.872917 systemd[1]: Starting initrd-setup-root.service - Root filesystem setup... Mar 6 02:26:14.876739 kernel: BTRFS info (device nvme0n1p6): first mount of filesystem 993ea71e-e97d-4f5e-b5c7-fdac31a53b6b Mar 6 02:26:14.876766 kernel: BTRFS info (device nvme0n1p6): using crc32c (crc32c-intel) checksum algorithm Mar 6 02:26:14.882720 kernel: BTRFS info (device nvme0n1p6): enabling ssd optimizations Mar 6 02:26:14.882753 kernel: BTRFS info (device nvme0n1p6): turning on async discard Mar 6 02:26:14.883878 kernel: BTRFS info (device nvme0n1p6): enabling free space tree Mar 6 02:26:14.886475 systemd[1]: Mounted sysroot-oem.mount - /sysroot/oem. Mar 6 02:26:15.050770 initrd-setup-root[959]: cut: /sysroot/etc/passwd: No such file or directory Mar 6 02:26:15.055158 initrd-setup-root[966]: cut: /sysroot/etc/group: No such file or directory Mar 6 02:26:15.059617 initrd-setup-root[973]: cut: /sysroot/etc/shadow: No such file or directory Mar 6 02:26:15.063619 initrd-setup-root[980]: cut: /sysroot/etc/gshadow: No such file or directory Mar 6 02:26:15.162005 coreos-metadata[936]: Mar 06 02:26:15.161 INFO Fetching http://168.63.129.16/?comp=versions: Attempt #1 Mar 6 02:26:15.164614 coreos-metadata[936]: Mar 06 02:26:15.164 INFO Fetch successful Mar 6 02:26:15.167540 coreos-metadata[936]: Mar 06 02:26:15.165 INFO Fetching http://169.254.169.254/metadata/instance/compute/name?api-version=2017-08-01&format=text: Attempt #1 Mar 6 02:26:15.175007 coreos-metadata[936]: Mar 06 02:26:15.174 INFO Fetch successful Mar 6 02:26:15.176603 coreos-metadata[936]: Mar 06 02:26:15.175 INFO wrote hostname ci-4459.2.3-n-a3850cb512 to /sysroot/etc/hostname Mar 6 02:26:15.178782 systemd[1]: Finished flatcar-metadata-hostname.service - Flatcar Metadata Hostname Agent. Mar 6 02:26:15.540108 systemd[1]: Finished initrd-setup-root.service - Root filesystem setup. Mar 6 02:26:15.543284 systemd[1]: Starting ignition-mount.service - Ignition (mount)... Mar 6 02:26:15.547129 systemd[1]: Starting sysroot-boot.service - /sysroot/boot... Mar 6 02:26:15.563192 systemd[1]: sysroot-oem.mount: Deactivated successfully. Mar 6 02:26:15.567142 kernel: BTRFS info (device nvme0n1p6): last unmount of filesystem 993ea71e-e97d-4f5e-b5c7-fdac31a53b6b Mar 6 02:26:15.579132 systemd[1]: Finished sysroot-boot.service - /sysroot/boot. Mar 6 02:26:15.591876 ignition[1054]: INFO : Ignition 2.22.0 Mar 6 02:26:15.591876 ignition[1054]: INFO : Stage: mount Mar 6 02:26:15.597581 ignition[1054]: INFO : no configs at "/usr/lib/ignition/base.d" Mar 6 02:26:15.597581 ignition[1054]: INFO : no config dir at "/usr/lib/ignition/base.platform.d/azure" Mar 6 02:26:15.597581 ignition[1054]: INFO : mount: op(1): [started] mounting "/dev/disk/by-partlabel/ROOT" at "/sysroot/tmp/_translate-filesystem-0-ign1" with type "xfs" and options "" Mar 6 02:26:15.597581 ignition[1054]: DEBUG : mount: op(1): executing: "mount" "-o" "" "-t" "xfs" "/dev/disk/by-partlabel/ROOT" "/sysroot/tmp/_translate-filesystem-0-ign1" Mar 6 02:26:15.597581 ignition[1054]: INFO : mount: op(1): [finished] mounting "/dev/disk/by-partlabel/ROOT" at "/sysroot/tmp/_translate-filesystem-0-ign1" with type "xfs" and options "" Mar 6 02:26:15.597581 ignition[1054]: INFO : mount: mount passed Mar 6 02:26:15.597581 ignition[1054]: INFO : Ignition finished successfully Mar 6 02:26:15.596601 systemd[1]: Finished ignition-mount.service - Ignition (mount). Mar 6 02:26:15.599582 systemd[1]: Starting ignition-files.service - Ignition (files)... Mar 6 02:26:15.836439 systemd[1]: Mounting sysroot-oem.mount - /sysroot/oem... Mar 6 02:26:15.870038 kernel: BTRFS: device label OEM devid 1 transid 12 /dev/nvme0n1p6 (259:5) scanned by mount (1067) Mar 6 02:26:15.870080 kernel: BTRFS info (device nvme0n1p6): first mount of filesystem 993ea71e-e97d-4f5e-b5c7-fdac31a53b6b Mar 6 02:26:15.871746 kernel: BTRFS info (device nvme0n1p6): using crc32c (crc32c-intel) checksum algorithm Mar 6 02:26:15.877225 kernel: BTRFS info (device nvme0n1p6): enabling ssd optimizations Mar 6 02:26:15.877262 kernel: BTRFS info (device nvme0n1p6): turning on async discard Mar 6 02:26:15.878781 kernel: BTRFS info (device nvme0n1p6): enabling free space tree Mar 6 02:26:15.880610 systemd[1]: Mounted sysroot-oem.mount - /sysroot/oem. Mar 6 02:26:15.910627 ignition[1083]: INFO : Ignition 2.22.0 Mar 6 02:26:15.910627 ignition[1083]: INFO : Stage: files Mar 6 02:26:15.914613 ignition[1083]: INFO : no configs at "/usr/lib/ignition/base.d" Mar 6 02:26:15.914613 ignition[1083]: INFO : no config dir at "/usr/lib/ignition/base.platform.d/azure" Mar 6 02:26:15.914613 ignition[1083]: DEBUG : files: compiled without relabeling support, skipping Mar 6 02:26:15.914613 ignition[1083]: INFO : files: ensureUsers: op(1): [started] creating or modifying user "core" Mar 6 02:26:15.914613 ignition[1083]: DEBUG : files: ensureUsers: op(1): executing: "usermod" "--root" "/sysroot" "core" Mar 6 02:26:15.970718 ignition[1083]: INFO : files: ensureUsers: op(1): [finished] creating or modifying user "core" Mar 6 02:26:15.974552 ignition[1083]: INFO : files: ensureUsers: op(2): [started] adding ssh keys to user "core" Mar 6 02:26:15.974552 ignition[1083]: INFO : files: ensureUsers: op(2): [finished] adding ssh keys to user "core" Mar 6 02:26:15.971080 unknown[1083]: wrote ssh authorized keys file for user: core Mar 6 02:26:15.984788 ignition[1083]: INFO : files: createFilesystemsFiles: createFiles: op(3): [started] writing file "/sysroot/tmp/_translate-filesystem-0-ign1/etc/flatcar/update.conf" Mar 6 02:26:15.987619 ignition[1083]: INFO : files: createFilesystemsFiles: createFiles: op(3): [finished] writing file "/sysroot/tmp/_translate-filesystem-0-ign1/etc/flatcar/update.conf" Mar 6 02:26:15.987619 ignition[1083]: INFO : files: createResultFile: createFiles: op(4): [started] writing file "/sysroot/etc/.ignition-result.json" Mar 6 02:26:15.987619 ignition[1083]: INFO : files: createResultFile: createFiles: op(4): [finished] writing file "/sysroot/etc/.ignition-result.json" Mar 6 02:26:15.987619 ignition[1083]: INFO : files: files passed Mar 6 02:26:15.987619 ignition[1083]: INFO : Ignition finished successfully Mar 6 02:26:15.987248 systemd[1]: Finished ignition-files.service - Ignition (files). Mar 6 02:26:15.990917 systemd[1]: Starting ignition-quench.service - Ignition (record completion)... Mar 6 02:26:16.003054 systemd[1]: Starting initrd-setup-root-after-ignition.service - Root filesystem completion... Mar 6 02:26:16.010226 systemd[1]: ignition-quench.service: Deactivated successfully. Mar 6 02:26:16.010290 systemd[1]: Finished ignition-quench.service - Ignition (record completion). Mar 6 02:26:16.040369 initrd-setup-root-after-ignition[1117]: grep: Mar 6 02:26:16.041339 initrd-setup-root-after-ignition[1113]: grep: Mar 6 02:26:16.042137 initrd-setup-root-after-ignition[1117]: /sysroot/etc/flatcar/enabled-sysext.conf Mar 6 02:26:16.043507 initrd-setup-root-after-ignition[1113]: /sysroot/etc/flatcar/enabled-sysext.conf Mar 6 02:26:16.046538 initrd-setup-root-after-ignition[1117]: : No such file or directory Mar 6 02:26:16.044272 systemd[1]: Finished initrd-setup-root-after-ignition.service - Root filesystem completion. Mar 6 02:26:16.053820 initrd-setup-root-after-ignition[1113]: : No such file or directory Mar 6 02:26:16.047670 systemd[1]: Reached target ignition-complete.target - Ignition Complete. Mar 6 02:26:16.057929 initrd-setup-root-after-ignition[1113]: grep: /sysroot/usr/share/flatcar/enabled-sysext.conf: No such file or directory Mar 6 02:26:16.052043 systemd[1]: Starting initrd-parse-etc.service - Mountpoints Configured in the Real Root... Mar 6 02:26:16.100846 systemd[1]: initrd-parse-etc.service: Deactivated successfully. Mar 6 02:26:16.100928 systemd[1]: Finished initrd-parse-etc.service - Mountpoints Configured in the Real Root. Mar 6 02:26:16.104694 systemd[1]: Reached target initrd-fs.target - Initrd File Systems. Mar 6 02:26:16.108545 systemd[1]: Reached target initrd.target - Initrd Default Target. Mar 6 02:26:16.112569 systemd[1]: dracut-mount.service - dracut mount hook was skipped because no trigger condition checks were met. Mar 6 02:26:16.115909 systemd[1]: Starting dracut-pre-pivot.service - dracut pre-pivot and cleanup hook... Mar 6 02:26:16.132733 systemd[1]: Finished dracut-pre-pivot.service - dracut pre-pivot and cleanup hook. Mar 6 02:26:16.138443 systemd[1]: Starting initrd-cleanup.service - Cleaning Up and Shutting Down Daemons... Mar 6 02:26:16.150912 systemd[1]: Stopped target nss-lookup.target - Host and Network Name Lookups. Mar 6 02:26:16.151516 systemd[1]: Stopped target remote-cryptsetup.target - Remote Encrypted Volumes. Mar 6 02:26:16.152518 systemd[1]: Stopped target timers.target - Timer Units. Mar 6 02:26:16.152973 systemd[1]: dracut-pre-pivot.service: Deactivated successfully. Mar 6 02:26:16.153076 systemd[1]: Stopped dracut-pre-pivot.service - dracut pre-pivot and cleanup hook. Mar 6 02:26:16.164140 systemd[1]: Stopped target initrd.target - Initrd Default Target. Mar 6 02:26:16.166800 systemd[1]: Stopped target basic.target - Basic System. Mar 6 02:26:16.167955 systemd[1]: Stopped target ignition-complete.target - Ignition Complete. Mar 6 02:26:16.170571 systemd[1]: Stopped target ignition-diskful.target - Ignition Boot Disk Setup. Mar 6 02:26:16.174767 systemd[1]: Stopped target initrd-root-device.target - Initrd Root Device. Mar 6 02:26:16.175028 systemd[1]: Stopped target initrd-usr-fs.target - Initrd /usr File System. Mar 6 02:26:16.182191 systemd[1]: Stopped target remote-fs.target - Remote File Systems. Mar 6 02:26:16.189612 systemd[1]: Stopped target remote-fs-pre.target - Preparation for Remote File Systems. Mar 6 02:26:16.192642 systemd[1]: Stopped target sysinit.target - System Initialization. Mar 6 02:26:16.195227 systemd[1]: Stopped target local-fs.target - Local File Systems. Mar 6 02:26:16.195431 systemd[1]: Stopped target swap.target - Swaps. Mar 6 02:26:16.195603 systemd[1]: dracut-pre-mount.service: Deactivated successfully. Mar 6 02:26:16.195699 systemd[1]: Stopped dracut-pre-mount.service - dracut pre-mount hook. Mar 6 02:26:16.196009 systemd[1]: Stopped target cryptsetup.target - Local Encrypted Volumes. Mar 6 02:26:16.196226 systemd[1]: Stopped target cryptsetup-pre.target - Local Encrypted Volumes (Pre). Mar 6 02:26:16.203581 systemd[1]: clevis-luks-askpass.path: Deactivated successfully. Mar 6 02:26:16.203790 systemd[1]: Stopped clevis-luks-askpass.path - Forward Password Requests to Clevis Directory Watch. Mar 6 02:26:16.207612 systemd[1]: dracut-initqueue.service: Deactivated successfully. Mar 6 02:26:16.207730 systemd[1]: Stopped dracut-initqueue.service - dracut initqueue hook. Mar 6 02:26:16.209819 systemd[1]: initrd-setup-root-after-ignition.service: Deactivated successfully. Mar 6 02:26:16.209908 systemd[1]: Stopped initrd-setup-root-after-ignition.service - Root filesystem completion. Mar 6 02:26:16.213644 systemd[1]: ignition-files.service: Deactivated successfully. Mar 6 02:26:16.213745 systemd[1]: Stopped ignition-files.service - Ignition (files). Mar 6 02:26:16.257153 ignition[1137]: INFO : Ignition 2.22.0 Mar 6 02:26:16.257153 ignition[1137]: INFO : Stage: umount Mar 6 02:26:16.257153 ignition[1137]: INFO : no configs at "/usr/lib/ignition/base.d" Mar 6 02:26:16.257153 ignition[1137]: INFO : no config dir at "/usr/lib/ignition/base.platform.d/azure" Mar 6 02:26:16.257153 ignition[1137]: INFO : umount: op(1): [started] umounting "/sysroot/tmp/_translate-filesystem-0-ign1" Mar 6 02:26:16.257153 ignition[1137]: INFO : umount: op(1): [finished] umounting "/sysroot/tmp/_translate-filesystem-0-ign1" Mar 6 02:26:16.257153 ignition[1137]: INFO : umount: umount passed Mar 6 02:26:16.257153 ignition[1137]: INFO : Ignition finished successfully Mar 6 02:26:16.217660 systemd[1]: flatcar-metadata-hostname.service: Deactivated successfully. Mar 6 02:26:16.217773 systemd[1]: Stopped flatcar-metadata-hostname.service - Flatcar Metadata Hostname Agent. Mar 6 02:26:16.219608 systemd[1]: Stopping ignition-mount.service - Ignition (mount)... Mar 6 02:26:16.219752 systemd[1]: kmod-static-nodes.service: Deactivated successfully. Mar 6 02:26:16.219867 systemd[1]: Stopped kmod-static-nodes.service - Create List of Static Device Nodes. Mar 6 02:26:16.221653 systemd[1]: Stopping sysroot-boot.service - /sysroot/boot... Mar 6 02:26:16.222033 systemd[1]: systemd-udev-trigger.service: Deactivated successfully. Mar 6 02:26:16.223616 systemd[1]: Stopped systemd-udev-trigger.service - Coldplug All udev Devices. Mar 6 02:26:16.223815 systemd[1]: dracut-pre-trigger.service: Deactivated successfully. Mar 6 02:26:16.223908 systemd[1]: Stopped dracut-pre-trigger.service - dracut pre-trigger hook. Mar 6 02:26:16.232592 systemd[1]: initrd-cleanup.service: Deactivated successfully. Mar 6 02:26:16.232661 systemd[1]: Finished initrd-cleanup.service - Cleaning Up and Shutting Down Daemons. Mar 6 02:26:16.254907 systemd[1]: sysroot-tmp-_translate\x2dfilesystem\x2d0\x2dign1.mount: Deactivated successfully. Mar 6 02:26:16.258089 systemd[1]: ignition-mount.service: Deactivated successfully. Mar 6 02:26:16.258170 systemd[1]: Stopped ignition-mount.service - Ignition (mount). Mar 6 02:26:16.261645 systemd[1]: ignition-disks.service: Deactivated successfully. Mar 6 02:26:16.261719 systemd[1]: Stopped ignition-disks.service - Ignition (disks). Mar 6 02:26:16.283054 systemd[1]: ignition-kargs.service: Deactivated successfully. Mar 6 02:26:16.283102 systemd[1]: Stopped ignition-kargs.service - Ignition (kargs). Mar 6 02:26:16.291013 systemd[1]: ignition-fetch.service: Deactivated successfully. Mar 6 02:26:16.291055 systemd[1]: Stopped ignition-fetch.service - Ignition (fetch). Mar 6 02:26:16.293268 systemd[1]: Stopped target network.target - Network. Mar 6 02:26:16.295130 systemd[1]: ignition-fetch-offline.service: Deactivated successfully. Mar 6 02:26:16.295170 systemd[1]: Stopped ignition-fetch-offline.service - Ignition (fetch-offline). Mar 6 02:26:16.297439 systemd[1]: Stopped target paths.target - Path Units. Mar 6 02:26:16.298693 systemd[1]: systemd-ask-password-console.path: Deactivated successfully. Mar 6 02:26:16.301758 systemd[1]: Stopped systemd-ask-password-console.path - Dispatch Password Requests to Console Directory Watch. Mar 6 02:26:16.306273 systemd[1]: Stopped target slices.target - Slice Units. Mar 6 02:26:16.308830 systemd[1]: Stopped target sockets.target - Socket Units. Mar 6 02:26:16.312580 systemd[1]: iscsid.socket: Deactivated successfully. Mar 6 02:26:16.312609 systemd[1]: Closed iscsid.socket - Open-iSCSI iscsid Socket. Mar 6 02:26:16.315859 systemd[1]: iscsiuio.socket: Deactivated successfully. Mar 6 02:26:16.315892 systemd[1]: Closed iscsiuio.socket - Open-iSCSI iscsiuio Socket. Mar 6 02:26:16.321844 systemd[1]: ignition-setup.service: Deactivated successfully. Mar 6 02:26:16.321917 systemd[1]: Stopped ignition-setup.service - Ignition (setup). Mar 6 02:26:16.327189 systemd[1]: ignition-setup-pre.service: Deactivated successfully. Mar 6 02:26:16.327233 systemd[1]: Stopped ignition-setup-pre.service - Ignition env setup. Mar 6 02:26:16.332572 systemd[1]: Stopping systemd-networkd.service - Network Configuration... Mar 6 02:26:16.336422 systemd[1]: Stopping systemd-resolved.service - Network Name Resolution... Mar 6 02:26:16.337584 systemd[1]: sysroot-boot.mount: Deactivated successfully. Mar 6 02:26:16.348767 systemd[1]: systemd-networkd.service: Deactivated successfully. Mar 6 02:26:16.348843 systemd[1]: Stopped systemd-networkd.service - Network Configuration. Mar 6 02:26:16.355846 systemd[1]: run-credentials-systemd\x2dnetworkd.service.mount: Deactivated successfully. Mar 6 02:26:16.356037 systemd[1]: sysroot-boot.service: Deactivated successfully. Mar 6 02:26:16.356100 systemd[1]: Stopped sysroot-boot.service - /sysroot/boot. Mar 6 02:26:16.360988 systemd[1]: systemd-resolved.service: Deactivated successfully. Mar 6 02:26:16.361069 systemd[1]: Stopped systemd-resolved.service - Network Name Resolution. Mar 6 02:26:16.367081 systemd[1]: Stopped target network-pre.target - Preparation for Network. Mar 6 02:26:16.369239 systemd[1]: systemd-networkd.socket: Deactivated successfully. Mar 6 02:26:16.369968 systemd[1]: Closed systemd-networkd.socket - Network Service Netlink Socket. Mar 6 02:26:16.371716 systemd[1]: initrd-setup-root.service: Deactivated successfully. Mar 6 02:26:16.372092 systemd[1]: Stopped initrd-setup-root.service - Root filesystem setup. Mar 6 02:26:16.378045 systemd[1]: Stopping network-cleanup.service - Network Cleanup... Mar 6 02:26:16.382453 systemd[1]: parse-ip-for-networkd.service: Deactivated successfully. Mar 6 02:26:16.384632 systemd[1]: Stopped parse-ip-for-networkd.service - Write systemd-networkd units from cmdline. Mar 6 02:26:16.393223 systemd[1]: systemd-sysctl.service: Deactivated successfully. Mar 6 02:26:16.393265 systemd[1]: Stopped systemd-sysctl.service - Apply Kernel Variables. Mar 6 02:26:16.396674 systemd[1]: systemd-modules-load.service: Deactivated successfully. Mar 6 02:26:16.396714 systemd[1]: Stopped systemd-modules-load.service - Load Kernel Modules. Mar 6 02:26:16.407569 systemd[1]: systemd-tmpfiles-setup.service: Deactivated successfully. Mar 6 02:26:16.407622 systemd[1]: Stopped systemd-tmpfiles-setup.service - Create System Files and Directories. Mar 6 02:26:16.411411 systemd[1]: Stopping systemd-udevd.service - Rule-based Manager for Device Events and Files... Mar 6 02:26:16.428528 kernel: hv_netvsc f8615163-0000-1000-2000-000d3addfbcf eth0: Data path switched from VF: enP30832s1 Mar 6 02:26:16.428841 kernel: mana 7870:00:00.0 enP30832s1: Configured steering vPort 0 entries 64 Mar 6 02:26:16.429581 systemd[1]: systemd-udevd.service: Deactivated successfully. Mar 6 02:26:16.429712 systemd[1]: Stopped systemd-udevd.service - Rule-based Manager for Device Events and Files. Mar 6 02:26:16.431196 systemd[1]: systemd-udevd-control.socket: Deactivated successfully. Mar 6 02:26:16.431228 systemd[1]: Closed systemd-udevd-control.socket - udev Control Socket. Mar 6 02:26:16.431381 systemd[1]: systemd-udevd-kernel.socket: Deactivated successfully. Mar 6 02:26:16.431401 systemd[1]: Closed systemd-udevd-kernel.socket - udev Kernel Socket. Mar 6 02:26:16.431634 systemd[1]: dracut-pre-udev.service: Deactivated successfully. Mar 6 02:26:16.431662 systemd[1]: Stopped dracut-pre-udev.service - dracut pre-udev hook. Mar 6 02:26:16.446553 systemd[1]: dracut-cmdline.service: Deactivated successfully. Mar 6 02:26:16.446611 systemd[1]: Stopped dracut-cmdline.service - dracut cmdline hook. Mar 6 02:26:16.449291 systemd[1]: dracut-cmdline-ask.service: Deactivated successfully. Mar 6 02:26:16.449329 systemd[1]: Stopped dracut-cmdline-ask.service - dracut ask for additional cmdline parameters. Mar 6 02:26:16.453605 systemd[1]: Starting initrd-udevadm-cleanup-db.service - Cleanup udev Database... Mar 6 02:26:16.458540 systemd[1]: systemd-network-generator.service: Deactivated successfully. Mar 6 02:26:16.458593 systemd[1]: Stopped systemd-network-generator.service - Generate network units from Kernel command line. Mar 6 02:26:16.461046 systemd[1]: systemd-tmpfiles-setup-dev.service: Deactivated successfully. Mar 6 02:26:16.461093 systemd[1]: Stopped systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev. Mar 6 02:26:16.468696 systemd[1]: systemd-vconsole-setup.service: Deactivated successfully. Mar 6 02:26:16.468743 systemd[1]: Stopped systemd-vconsole-setup.service - Virtual Console Setup. Mar 6 02:26:16.475182 systemd[1]: network-cleanup.service: Deactivated successfully. Mar 6 02:26:16.476342 systemd[1]: Stopped network-cleanup.service - Network Cleanup. Mar 6 02:26:16.478922 systemd[1]: initrd-udevadm-cleanup-db.service: Deactivated successfully. Mar 6 02:26:16.478994 systemd[1]: Finished initrd-udevadm-cleanup-db.service - Cleanup udev Database. Mar 6 02:26:16.483009 systemd[1]: Reached target initrd-switch-root.target - Switch Root. Mar 6 02:26:16.485964 systemd[1]: Starting initrd-switch-root.service - Switch Root... Mar 6 02:26:16.502966 systemd[1]: Switching root. Mar 6 02:26:16.578883 systemd-journald[186]: Journal stopped Mar 6 02:26:19.750441 systemd-journald[186]: Received SIGTERM from PID 1 (systemd). Mar 6 02:26:19.750465 kernel: SELinux: policy capability network_peer_controls=1 Mar 6 02:26:19.750477 kernel: SELinux: policy capability open_perms=1 Mar 6 02:26:19.750484 kernel: SELinux: policy capability extended_socket_class=1 Mar 6 02:26:19.750491 kernel: SELinux: policy capability always_check_network=0 Mar 6 02:26:19.750511 kernel: SELinux: policy capability cgroup_seclabel=1 Mar 6 02:26:19.750520 kernel: SELinux: policy capability nnp_nosuid_transition=1 Mar 6 02:26:19.750529 kernel: SELinux: policy capability genfs_seclabel_symlinks=0 Mar 6 02:26:19.750538 kernel: SELinux: policy capability ioctl_skip_cloexec=0 Mar 6 02:26:19.750546 kernel: SELinux: policy capability userspace_initial_context=0 Mar 6 02:26:19.750554 kernel: audit: type=1403 audit(1772763977.002:2): auid=4294967295 ses=4294967295 lsm=selinux res=1 Mar 6 02:26:19.750564 systemd[1]: Successfully loaded SELinux policy in 175.170ms. Mar 6 02:26:19.750574 systemd[1]: Relabeled /dev/, /dev/shm/, /run/ in 3.725ms. Mar 6 02:26:19.750585 systemd[1]: systemd 256.8 running in system mode (+PAM +AUDIT +SELINUX -APPARMOR +IMA +SMACK +SECCOMP -GCRYPT -GNUTLS +OPENSSL -ACL +BLKID +CURL +ELFUTILS -FIDO2 +IDN2 -IDN +IPTC +KMOD +LIBCRYPTSETUP +LIBCRYPTSETUP_PLUGINS +LIBFDISK +PCRE2 -PWQUALITY -P11KIT -QRENCODE +TPM2 +BZIP2 +LZ4 +XZ +ZLIB +ZSTD -BPF_FRAMEWORK -XKBCOMMON +UTMP -SYSVINIT +LIBARCHIVE) Mar 6 02:26:19.750598 systemd[1]: Detected virtualization microsoft. Mar 6 02:26:19.750609 systemd[1]: Detected architecture x86-64. Mar 6 02:26:19.750620 systemd[1]: Detected first boot. Mar 6 02:26:19.750631 systemd[1]: Hostname set to . Mar 6 02:26:19.750643 systemd[1]: Initializing machine ID from random generator. Mar 6 02:26:19.750653 zram_generator::config[1181]: No configuration found. Mar 6 02:26:19.750665 kernel: Guest personality initialized and is inactive Mar 6 02:26:19.750677 kernel: VMCI host device registered (name=vmci, major=10, minor=259) Mar 6 02:26:19.750684 kernel: Initialized host personality Mar 6 02:26:19.750693 kernel: NET: Registered PF_VSOCK protocol family Mar 6 02:26:19.750704 systemd[1]: Populated /etc with preset unit settings. Mar 6 02:26:19.750715 systemd[1]: run-credentials-systemd\x2djournald.service.mount: Deactivated successfully. Mar 6 02:26:19.750725 systemd[1]: initrd-switch-root.service: Deactivated successfully. Mar 6 02:26:19.750737 systemd[1]: Stopped initrd-switch-root.service - Switch Root. Mar 6 02:26:19.750751 systemd[1]: systemd-journald.service: Scheduled restart job, restart counter is at 1. Mar 6 02:26:19.750762 systemd[1]: Created slice system-addon\x2dconfig.slice - Slice /system/addon-config. Mar 6 02:26:19.750772 systemd[1]: Created slice system-addon\x2drun.slice - Slice /system/addon-run. Mar 6 02:26:19.750780 systemd[1]: Created slice system-getty.slice - Slice /system/getty. Mar 6 02:26:19.750792 systemd[1]: Created slice system-modprobe.slice - Slice /system/modprobe. Mar 6 02:26:19.750804 systemd[1]: Created slice system-serial\x2dgetty.slice - Slice /system/serial-getty. Mar 6 02:26:19.750816 systemd[1]: Created slice system-system\x2dcloudinit.slice - Slice /system/system-cloudinit. Mar 6 02:26:19.750829 systemd[1]: Created slice system-systemd\x2dfsck.slice - Slice /system/systemd-fsck. Mar 6 02:26:19.750840 systemd[1]: Created slice user.slice - User and Session Slice. Mar 6 02:26:19.750850 systemd[1]: Started clevis-luks-askpass.path - Forward Password Requests to Clevis Directory Watch. Mar 6 02:26:19.750861 systemd[1]: Started systemd-ask-password-console.path - Dispatch Password Requests to Console Directory Watch. Mar 6 02:26:19.750872 systemd[1]: Started systemd-ask-password-wall.path - Forward Password Requests to Wall Directory Watch. Mar 6 02:26:19.750887 systemd[1]: Set up automount boot.automount - Boot partition Automount Point. Mar 6 02:26:19.750899 systemd[1]: Set up automount proc-sys-fs-binfmt_misc.automount - Arbitrary Executable File Formats File System Automount Point. Mar 6 02:26:19.750913 systemd[1]: Expecting device dev-disk-by\x2dlabel-OEM.device - /dev/disk/by-label/OEM... Mar 6 02:26:19.750922 systemd[1]: Expecting device dev-ttyS0.device - /dev/ttyS0... Mar 6 02:26:19.750931 systemd[1]: Reached target cryptsetup-pre.target - Local Encrypted Volumes (Pre). Mar 6 02:26:19.750941 systemd[1]: Reached target cryptsetup.target - Local Encrypted Volumes. Mar 6 02:26:19.750949 systemd[1]: Stopped target initrd-switch-root.target - Switch Root. Mar 6 02:26:19.750967 systemd[1]: Stopped target initrd-fs.target - Initrd File Systems. Mar 6 02:26:19.750977 systemd[1]: Stopped target initrd-root-fs.target - Initrd Root File System. Mar 6 02:26:19.750988 systemd[1]: Reached target integritysetup.target - Local Integrity Protected Volumes. Mar 6 02:26:19.751000 systemd[1]: Reached target remote-cryptsetup.target - Remote Encrypted Volumes. Mar 6 02:26:19.751014 systemd[1]: Reached target remote-fs.target - Remote File Systems. Mar 6 02:26:19.751026 systemd[1]: Reached target slices.target - Slice Units. Mar 6 02:26:19.751039 systemd[1]: Reached target swap.target - Swaps. Mar 6 02:26:19.751049 systemd[1]: Reached target veritysetup.target - Local Verity Protected Volumes. Mar 6 02:26:19.751063 systemd[1]: Listening on systemd-coredump.socket - Process Core Dump Socket. Mar 6 02:26:19.751079 systemd[1]: Listening on systemd-creds.socket - Credential Encryption/Decryption. Mar 6 02:26:19.751094 systemd[1]: Listening on systemd-networkd.socket - Network Service Netlink Socket. Mar 6 02:26:19.751107 systemd[1]: Listening on systemd-udevd-control.socket - udev Control Socket. Mar 6 02:26:19.751118 systemd[1]: Listening on systemd-udevd-kernel.socket - udev Kernel Socket. Mar 6 02:26:19.751131 systemd[1]: Listening on systemd-userdbd.socket - User Database Manager Socket. Mar 6 02:26:19.751140 systemd[1]: Mounting dev-hugepages.mount - Huge Pages File System... Mar 6 02:26:19.751149 systemd[1]: Mounting dev-mqueue.mount - POSIX Message Queue File System... Mar 6 02:26:19.751162 systemd[1]: Mounting media.mount - External Media Directory... Mar 6 02:26:19.751172 systemd[1]: proc-xen.mount - /proc/xen was skipped because of an unmet condition check (ConditionVirtualization=xen). Mar 6 02:26:19.751181 systemd[1]: Mounting sys-kernel-debug.mount - Kernel Debug File System... Mar 6 02:26:19.751189 systemd[1]: Mounting sys-kernel-tracing.mount - Kernel Trace File System... Mar 6 02:26:19.751196 systemd[1]: tmp.mount: Directory /tmp to mount over is not empty, mounting anyway. Mar 6 02:26:19.751206 systemd[1]: Mounting tmp.mount - Temporary Directory /tmp... Mar 6 02:26:19.751215 systemd[1]: var-lib-machines.mount - Virtual Machine and Container Storage (Compatibility) was skipped because of an unmet condition check (ConditionPathExists=/var/lib/machines.raw). Mar 6 02:26:19.751224 systemd[1]: Reached target machines.target - Containers. Mar 6 02:26:19.751232 systemd[1]: Starting flatcar-tmpfiles.service - Create missing system files... Mar 6 02:26:19.751242 systemd[1]: ignition-delete-config.service - Ignition (delete config) was skipped because no trigger condition checks were met. Mar 6 02:26:19.751251 systemd[1]: Starting kmod-static-nodes.service - Create List of Static Device Nodes... Mar 6 02:26:19.751259 systemd[1]: Starting modprobe@configfs.service - Load Kernel Module configfs... Mar 6 02:26:19.751268 systemd[1]: Starting modprobe@dm_mod.service - Load Kernel Module dm_mod... Mar 6 02:26:19.751281 systemd[1]: Starting modprobe@drm.service - Load Kernel Module drm... Mar 6 02:26:19.751290 systemd[1]: Starting modprobe@efi_pstore.service - Load Kernel Module efi_pstore... Mar 6 02:26:19.751298 systemd[1]: Starting modprobe@fuse.service - Load Kernel Module fuse... Mar 6 02:26:19.751307 systemd[1]: Starting modprobe@loop.service - Load Kernel Module loop... Mar 6 02:26:19.751317 systemd[1]: setup-nsswitch.service - Create /etc/nsswitch.conf was skipped because of an unmet condition check (ConditionPathExists=!/etc/nsswitch.conf). Mar 6 02:26:19.751326 systemd[1]: systemd-fsck-root.service: Deactivated successfully. Mar 6 02:26:19.751333 systemd[1]: Stopped systemd-fsck-root.service - File System Check on Root Device. Mar 6 02:26:19.751342 systemd[1]: systemd-fsck-usr.service: Deactivated successfully. Mar 6 02:26:19.751350 systemd[1]: Stopped systemd-fsck-usr.service. Mar 6 02:26:19.751359 systemd[1]: systemd-hibernate-clear.service - Clear Stale Hibernate Storage Info was skipped because of an unmet condition check (ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67). Mar 6 02:26:19.751367 systemd[1]: Starting systemd-journald.service - Journal Service... Mar 6 02:26:19.751375 systemd[1]: Starting systemd-modules-load.service - Load Kernel Modules... Mar 6 02:26:19.751387 systemd[1]: Starting systemd-network-generator.service - Generate network units from Kernel command line... Mar 6 02:26:19.751399 systemd[1]: Starting systemd-remount-fs.service - Remount Root and Kernel File Systems... Mar 6 02:26:19.751410 systemd[1]: Starting systemd-udev-load-credentials.service - Load udev Rules from Credentials... Mar 6 02:26:19.751420 systemd[1]: Starting systemd-udev-trigger.service - Coldplug All udev Devices... Mar 6 02:26:19.751431 systemd[1]: verity-setup.service: Deactivated successfully. Mar 6 02:26:19.751441 systemd[1]: Stopped verity-setup.service. Mar 6 02:26:19.751453 systemd[1]: xenserver-pv-version.service - Set fake PV driver version for XenServer was skipped because of an unmet condition check (ConditionVirtualization=xen). Mar 6 02:26:19.751464 systemd[1]: Mounted dev-hugepages.mount - Huge Pages File System. Mar 6 02:26:19.751477 kernel: fuse: init (API version 7.41) Mar 6 02:26:19.751488 systemd[1]: Mounted dev-mqueue.mount - POSIX Message Queue File System. Mar 6 02:26:19.751521 systemd[1]: Mounted media.mount - External Media Directory. Mar 6 02:26:19.751533 systemd[1]: Mounted sys-kernel-debug.mount - Kernel Debug File System. Mar 6 02:26:19.751544 systemd[1]: Mounted sys-kernel-tracing.mount - Kernel Trace File System. Mar 6 02:26:19.751573 systemd-journald[1264]: Collecting audit messages is disabled. Mar 6 02:26:19.751598 systemd[1]: Mounted tmp.mount - Temporary Directory /tmp. Mar 6 02:26:19.751607 systemd[1]: Finished kmod-static-nodes.service - Create List of Static Device Nodes. Mar 6 02:26:19.751618 systemd-journald[1264]: Journal started Mar 6 02:26:19.751646 systemd-journald[1264]: Runtime Journal (/run/log/journal/a9d805345c2c4299b767b1b6d2278614) is 8M, max 158.6M, 150.6M free. Mar 6 02:26:19.333985 systemd[1]: Queued start job for default target multi-user.target. Mar 6 02:26:19.337920 systemd[1]: Unnecessary job was removed for dev-nvme0n1p6.device - /dev/nvme0n1p6. Mar 6 02:26:19.338187 systemd[1]: systemd-journald.service: Deactivated successfully. Mar 6 02:26:19.759524 systemd[1]: Started systemd-journald.service - Journal Service. Mar 6 02:26:19.759562 kernel: loop: module loaded Mar 6 02:26:19.760456 systemd[1]: modprobe@configfs.service: Deactivated successfully. Mar 6 02:26:19.760647 systemd[1]: Finished modprobe@configfs.service - Load Kernel Module configfs. Mar 6 02:26:19.763026 systemd[1]: modprobe@dm_mod.service: Deactivated successfully. Mar 6 02:26:19.763135 systemd[1]: Finished modprobe@dm_mod.service - Load Kernel Module dm_mod. Mar 6 02:26:19.764657 systemd[1]: modprobe@efi_pstore.service: Deactivated successfully. Mar 6 02:26:19.764751 systemd[1]: Finished modprobe@efi_pstore.service - Load Kernel Module efi_pstore. Mar 6 02:26:19.766319 systemd[1]: modprobe@fuse.service: Deactivated successfully. Mar 6 02:26:19.766434 systemd[1]: Finished modprobe@fuse.service - Load Kernel Module fuse. Mar 6 02:26:19.768786 systemd[1]: modprobe@loop.service: Deactivated successfully. Mar 6 02:26:19.768920 systemd[1]: Finished modprobe@loop.service - Load Kernel Module loop. Mar 6 02:26:19.770764 systemd[1]: Finished flatcar-tmpfiles.service - Create missing system files. Mar 6 02:26:19.772132 systemd[1]: Finished systemd-modules-load.service - Load Kernel Modules. Mar 6 02:26:19.774802 systemd[1]: Finished systemd-network-generator.service - Generate network units from Kernel command line. Mar 6 02:26:19.777755 systemd[1]: Finished systemd-remount-fs.service - Remount Root and Kernel File Systems. Mar 6 02:26:19.785336 systemd[1]: Reached target network-pre.target - Preparation for Network. Mar 6 02:26:19.787260 systemd[1]: Mounting sys-fs-fuse-connections.mount - FUSE Control File System... Mar 6 02:26:19.791622 systemd[1]: Mounting sys-kernel-config.mount - Kernel Configuration File System... Mar 6 02:26:19.795550 systemd[1]: remount-root.service - Remount Root File System was skipped because of an unmet condition check (ConditionPathIsReadWrite=!/). Mar 6 02:26:19.795584 systemd[1]: Reached target local-fs.target - Local File Systems. Mar 6 02:26:19.800194 systemd[1]: Listening on systemd-sysext.socket - System Extension Image Management. Mar 6 02:26:19.806002 systemd[1]: Starting ldconfig.service - Rebuild Dynamic Linker Cache... Mar 6 02:26:19.807905 systemd[1]: systemd-binfmt.service - Set Up Additional Binary Formats was skipped because no trigger condition checks were met. Mar 6 02:26:19.844505 kernel: ACPI: bus type drm_connector registered Mar 6 02:26:19.856898 systemd[1]: Starting systemd-hwdb-update.service - Rebuild Hardware Database... Mar 6 02:26:19.859076 systemd[1]: Starting systemd-journal-flush.service - Flush Journal to Persistent Storage... Mar 6 02:26:19.862614 systemd[1]: systemd-pstore.service - Platform Persistent Storage Archival was skipped because of an unmet condition check (ConditionDirectoryNotEmpty=/sys/fs/pstore). Mar 6 02:26:19.864608 systemd[1]: Starting systemd-random-seed.service - Load/Save OS Random Seed... Mar 6 02:26:19.866772 systemd[1]: systemd-repart.service - Repartition Root Disk was skipped because no trigger condition checks were met. Mar 6 02:26:19.871405 systemd[1]: Starting systemd-sysctl.service - Apply Kernel Variables... Mar 6 02:26:19.877606 systemd[1]: Starting systemd-sysext.service - Merge System Extension Images into /usr/ and /opt/... Mar 6 02:26:19.883687 systemd[1]: Starting systemd-sysusers.service - Create System Users... Mar 6 02:26:19.888228 systemd[1]: modprobe@drm.service: Deactivated successfully. Mar 6 02:26:19.889560 systemd[1]: Finished modprobe@drm.service - Load Kernel Module drm. Mar 6 02:26:19.892427 systemd[1]: Finished systemd-udev-load-credentials.service - Load udev Rules from Credentials. Mar 6 02:26:19.895236 systemd[1]: Mounted sys-fs-fuse-connections.mount - FUSE Control File System. Mar 6 02:26:19.899660 systemd[1]: Mounted sys-kernel-config.mount - Kernel Configuration File System. Mar 6 02:26:19.907772 systemd[1]: Finished systemd-random-seed.service - Load/Save OS Random Seed. Mar 6 02:26:19.912088 systemd[1]: Reached target first-boot-complete.target - First Boot Complete. Mar 6 02:26:19.915387 systemd[1]: Starting systemd-machine-id-commit.service - Save Transient machine-id to Disk... Mar 6 02:26:19.922487 systemd[1]: Finished systemd-udev-trigger.service - Coldplug All udev Devices. Mar 6 02:26:19.925346 systemd-journald[1264]: Time spent on flushing to /var/log/journal/a9d805345c2c4299b767b1b6d2278614 is 12.438ms for 991 entries. Mar 6 02:26:19.925346 systemd-journald[1264]: System Journal (/var/log/journal/a9d805345c2c4299b767b1b6d2278614) is 8M, max 2.8G, 2.7G free. Mar 6 02:26:22.227990 systemd-journald[1264]: Received client request to flush runtime journal. Mar 6 02:26:22.228056 kernel: loop0: detected capacity change from 0 to 27936 Mar 6 02:26:21.645899 systemd[1]: Finished systemd-sysctl.service - Apply Kernel Variables. Mar 6 02:26:22.229809 systemd[1]: Finished systemd-journal-flush.service - Flush Journal to Persistent Storage. Mar 6 02:26:22.418664 systemd[1]: etc-machine\x2did.mount: Deactivated successfully. Mar 6 02:26:22.419256 systemd[1]: Finished systemd-machine-id-commit.service - Save Transient machine-id to Disk. Mar 6 02:26:22.429947 systemd[1]: Finished systemd-sysusers.service - Create System Users. Mar 6 02:26:22.434460 systemd[1]: Starting systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev... Mar 6 02:26:22.588482 systemd-tmpfiles[1338]: ACLs are not supported, ignoring. Mar 6 02:26:22.588508 systemd-tmpfiles[1338]: ACLs are not supported, ignoring. Mar 6 02:26:22.591645 systemd[1]: Finished systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev. Mar 6 02:26:23.234472 systemd[1]: Finished systemd-hwdb-update.service - Rebuild Hardware Database. Mar 6 02:26:23.239524 kernel: squashfs: version 4.0 (2009/01/31) Phillip Lougher Mar 6 02:26:23.240795 systemd[1]: Starting systemd-udevd.service - Rule-based Manager for Device Events and Files... Mar 6 02:26:23.265315 systemd-udevd[1344]: Using default interface naming scheme 'v255'. Mar 6 02:26:23.446539 kernel: loop1: detected capacity change from 0 to 110984 Mar 6 02:26:23.631822 systemd[1]: Started systemd-udevd.service - Rule-based Manager for Device Events and Files. Mar 6 02:26:23.636667 systemd[1]: Starting systemd-networkd.service - Network Configuration... Mar 6 02:26:23.671103 systemd[1]: Condition check resulted in dev-ttyS0.device - /dev/ttyS0 being skipped. Mar 6 02:26:23.755520 kernel: hv_storvsc f8b3781a-1e82-4818-a1c3-63d806ec15bb: tag#136 cmd 0x85 status: scsi 0x2 srb 0x6 hv 0xc0000001 Mar 6 02:26:23.791550 kernel: hv_vmbus: registering driver hv_balloon Mar 6 02:26:23.794517 kernel: hv_balloon: Using Dynamic Memory protocol version 2.0 Mar 6 02:26:23.819512 kernel: hv_vmbus: registering driver hyperv_fb Mar 6 02:26:23.835826 kernel: hyperv_fb: Synthvid Version major 3, minor 5 Mar 6 02:26:23.835876 kernel: hyperv_fb: Screen resolution: 1024x768, Color depth: 32, Frame buffer size: 8388608 Mar 6 02:26:23.839176 kernel: Console: switching to colour dummy device 80x25 Mar 6 02:26:23.844122 kernel: Console: switching to colour frame buffer device 128x48 Mar 6 02:26:23.866541 kernel: mousedev: PS/2 mouse device common for all mice Mar 6 02:26:23.994126 systemd[1]: Starting systemd-userdbd.service - User Database Manager... Mar 6 02:26:24.052623 systemd[1]: Starting systemd-vconsole-setup.service - Virtual Console Setup... Mar 6 02:26:24.058913 systemd[1]: systemd-vconsole-setup.service: Deactivated successfully. Mar 6 02:26:24.059074 systemd[1]: Stopped systemd-vconsole-setup.service - Virtual Console Setup. Mar 6 02:26:24.062181 systemd[1]: Starting systemd-vconsole-setup.service - Virtual Console Setup... Mar 6 02:26:24.075791 systemd[1]: Started systemd-userdbd.service - User Database Manager. Mar 6 02:26:24.370520 kernel: kvm_intel: Using Hyper-V Enlightened VMCS Mar 6 02:26:24.435457 systemd[1]: Found device dev-disk-by\x2dlabel-OEM.device - MSFT NVMe Accelerator v1.0 OEM. Mar 6 02:26:24.437367 systemd[1]: Starting systemd-fsck@dev-disk-by\x2dlabel-OEM.service - File System Check on /dev/disk/by-label/OEM... Mar 6 02:26:24.484559 systemd-networkd[1352]: lo: Link UP Mar 6 02:26:24.484565 systemd-networkd[1352]: lo: Gained carrier Mar 6 02:26:24.485458 systemd-networkd[1352]: Enumeration completed Mar 6 02:26:24.485594 systemd[1]: Started systemd-networkd.service - Network Configuration. Mar 6 02:26:24.487253 systemd-networkd[1352]: eth0: found matching network '/usr/lib/systemd/network/zz-default.network', based on potentially unpredictable interface name. Mar 6 02:26:24.487264 systemd-networkd[1352]: eth0: Configuring with /usr/lib/systemd/network/zz-default.network. Mar 6 02:26:24.489836 kernel: mana 7870:00:00.0 enP30832s1: Configured vPort 0 PD 18 DB 16 Mar 6 02:26:24.488620 systemd[1]: Starting systemd-networkd-persistent-storage.service - Enable Persistent Storage in systemd-networkd... Mar 6 02:26:24.490862 systemd[1]: Starting systemd-networkd-wait-online.service - Wait for Network to be Configured... Mar 6 02:26:24.499799 kernel: mana 7870:00:00.0 enP30832s1: Configured steering vPort 0 entries 64 Mar 6 02:26:24.500008 kernel: hv_netvsc f8615163-0000-1000-2000-000d3addfbcf eth0: Data path switched to VF: enP30832s1 Mar 6 02:26:24.499679 systemd-networkd[1352]: enP30832s1: Link UP Mar 6 02:26:24.499749 systemd-networkd[1352]: eth0: Link UP Mar 6 02:26:24.499751 systemd-networkd[1352]: eth0: Gained carrier Mar 6 02:26:24.499766 systemd-networkd[1352]: eth0: found matching network '/usr/lib/systemd/network/zz-default.network', based on potentially unpredictable interface name. Mar 6 02:26:24.507739 systemd-networkd[1352]: enP30832s1: Gained carrier Mar 6 02:26:24.535553 systemd-networkd[1352]: eth0: DHCPv4 address 10.200.8.28/24, gateway 10.200.8.1 acquired from 168.63.129.16 Mar 6 02:26:24.594752 systemd[1]: Finished systemd-fsck@dev-disk-by\x2dlabel-OEM.service - File System Check on /dev/disk/by-label/OEM. Mar 6 02:26:24.642114 systemd[1]: Finished systemd-networkd-persistent-storage.service - Enable Persistent Storage in systemd-networkd. Mar 6 02:26:24.653509 kernel: loop2: detected capacity change from 0 to 128560 Mar 6 02:26:25.175273 systemd[1]: Finished systemd-vconsole-setup.service - Virtual Console Setup. Mar 6 02:26:25.282511 kernel: loop3: detected capacity change from 0 to 27936 Mar 6 02:26:25.328511 kernel: loop4: detected capacity change from 0 to 110984 Mar 6 02:26:25.413513 kernel: loop5: detected capacity change from 0 to 128560 Mar 6 02:26:25.502756 (sd-merge)[1446]: Using extensions 'containerd-flatcar', 'docker-flatcar', 'oem-azure'. Mar 6 02:26:25.503095 (sd-merge)[1446]: Merged extensions into '/usr'. Mar 6 02:26:25.506430 systemd[1]: Finished systemd-sysext.service - Merge System Extension Images into /usr/ and /opt/. Mar 6 02:26:25.508931 systemd[1]: Starting ensure-sysext.service... Mar 6 02:26:25.514686 systemd[1]: Starting systemd-tmpfiles-setup.service - Create System Files and Directories... Mar 6 02:26:25.530848 systemd[1]: Reload requested from client PID 1448 ('systemctl') (unit ensure-sysext.service)... Mar 6 02:26:25.530860 systemd[1]: Reloading... Mar 6 02:26:25.566738 systemd-tmpfiles[1449]: /usr/lib/tmpfiles.d/nfs-utils.conf:6: Duplicate line for path "/var/lib/nfs/sm", ignoring. Mar 6 02:26:25.566759 systemd-tmpfiles[1449]: /usr/lib/tmpfiles.d/nfs-utils.conf:7: Duplicate line for path "/var/lib/nfs/sm.bak", ignoring. Mar 6 02:26:25.567442 systemd-tmpfiles[1449]: /usr/lib/tmpfiles.d/provision.conf:20: Duplicate line for path "/root", ignoring. Mar 6 02:26:25.567993 systemd-tmpfiles[1449]: /usr/lib/tmpfiles.d/systemd-flatcar.conf:6: Duplicate line for path "/var/log/journal", ignoring. Mar 6 02:26:25.569114 systemd-tmpfiles[1449]: /usr/lib/tmpfiles.d/systemd.conf:29: Duplicate line for path "/var/lib/systemd", ignoring. Mar 6 02:26:25.569870 systemd-tmpfiles[1449]: ACLs are not supported, ignoring. Mar 6 02:26:25.569963 systemd-tmpfiles[1449]: ACLs are not supported, ignoring. Mar 6 02:26:25.574209 systemd-tmpfiles[1449]: Detected autofs mount point /boot during canonicalization of boot. Mar 6 02:26:25.574218 systemd-tmpfiles[1449]: Skipping /boot Mar 6 02:26:25.578567 zram_generator::config[1483]: No configuration found. Mar 6 02:26:25.583878 systemd-tmpfiles[1449]: Detected autofs mount point /boot during canonicalization of boot. Mar 6 02:26:25.584651 systemd-tmpfiles[1449]: Skipping /boot Mar 6 02:26:25.739605 systemd[1]: Reloading finished in 208 ms. Mar 6 02:26:25.771199 systemd[1]: Finished systemd-tmpfiles-setup.service - Create System Files and Directories. Mar 6 02:26:25.777623 systemd[1]: Starting audit-rules.service - Load Audit Rules... Mar 6 02:26:25.829067 systemd[1]: Starting clean-ca-certificates.service - Clean up broken links in /etc/ssl/certs... Mar 6 02:26:25.833611 systemd[1]: Starting systemd-journal-catalog-update.service - Rebuild Journal Catalog... Mar 6 02:26:25.839883 systemd[1]: Starting systemd-resolved.service - Network Name Resolution... Mar 6 02:26:25.845602 systemd[1]: Starting systemd-update-utmp.service - Record System Boot/Shutdown in UTMP... Mar 6 02:26:25.852071 systemd[1]: proc-xen.mount - /proc/xen was skipped because of an unmet condition check (ConditionVirtualization=xen). Mar 6 02:26:25.852214 systemd[1]: ignition-delete-config.service - Ignition (delete config) was skipped because no trigger condition checks were met. Mar 6 02:26:25.853039 systemd[1]: Starting modprobe@dm_mod.service - Load Kernel Module dm_mod... Mar 6 02:26:25.857785 systemd[1]: Starting modprobe@efi_pstore.service - Load Kernel Module efi_pstore... Mar 6 02:26:25.861777 systemd[1]: Starting modprobe@loop.service - Load Kernel Module loop... Mar 6 02:26:25.864904 systemd[1]: systemd-binfmt.service - Set Up Additional Binary Formats was skipped because no trigger condition checks were met. Mar 6 02:26:25.865017 systemd[1]: systemd-hibernate-clear.service - Clear Stale Hibernate Storage Info was skipped because of an unmet condition check (ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67). Mar 6 02:26:25.865103 systemd[1]: xenserver-pv-version.service - Set fake PV driver version for XenServer was skipped because of an unmet condition check (ConditionVirtualization=xen). Mar 6 02:26:25.870814 systemd[1]: modprobe@efi_pstore.service: Deactivated successfully. Mar 6 02:26:25.871102 systemd[1]: Finished modprobe@efi_pstore.service - Load Kernel Module efi_pstore. Mar 6 02:26:25.873258 systemd[1]: modprobe@loop.service: Deactivated successfully. Mar 6 02:26:25.874532 systemd[1]: Finished modprobe@loop.service - Load Kernel Module loop. Mar 6 02:26:25.876593 systemd[1]: modprobe@dm_mod.service: Deactivated successfully. Mar 6 02:26:25.876876 systemd[1]: Finished modprobe@dm_mod.service - Load Kernel Module dm_mod. Mar 6 02:26:25.880978 systemd[1]: Finished systemd-update-utmp.service - Record System Boot/Shutdown in UTMP. Mar 6 02:26:25.891444 systemd[1]: proc-xen.mount - /proc/xen was skipped because of an unmet condition check (ConditionVirtualization=xen). Mar 6 02:26:25.893763 systemd[1]: ignition-delete-config.service - Ignition (delete config) was skipped because no trigger condition checks were met. Mar 6 02:26:25.895564 systemd[1]: Starting modprobe@dm_mod.service - Load Kernel Module dm_mod... Mar 6 02:26:25.900710 systemd[1]: Starting modprobe@drm.service - Load Kernel Module drm... Mar 6 02:26:25.905222 systemd[1]: Starting modprobe@efi_pstore.service - Load Kernel Module efi_pstore... Mar 6 02:26:25.910821 systemd[1]: Starting modprobe@loop.service - Load Kernel Module loop... Mar 6 02:26:25.912646 systemd[1]: systemd-binfmt.service - Set Up Additional Binary Formats was skipped because no trigger condition checks were met. Mar 6 02:26:25.912752 systemd[1]: systemd-hibernate-clear.service - Clear Stale Hibernate Storage Info was skipped because of an unmet condition check (ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67). Mar 6 02:26:25.912894 systemd[1]: Reached target time-set.target - System Time Set. Mar 6 02:26:25.915239 systemd[1]: xenserver-pv-version.service - Set fake PV driver version for XenServer was skipped because of an unmet condition check (ConditionVirtualization=xen). Mar 6 02:26:25.916070 systemd[1]: modprobe@dm_mod.service: Deactivated successfully. Mar 6 02:26:25.916317 systemd[1]: Finished modprobe@dm_mod.service - Load Kernel Module dm_mod. Mar 6 02:26:25.922733 systemd[1]: Finished ensure-sysext.service. Mar 6 02:26:25.924822 systemd[1]: modprobe@drm.service: Deactivated successfully. Mar 6 02:26:25.924972 systemd[1]: Finished modprobe@drm.service - Load Kernel Module drm. Mar 6 02:26:25.927806 systemd[1]: modprobe@efi_pstore.service: Deactivated successfully. Mar 6 02:26:25.927968 systemd[1]: Finished modprobe@efi_pstore.service - Load Kernel Module efi_pstore. Mar 6 02:26:25.929474 systemd[1]: modprobe@loop.service: Deactivated successfully. Mar 6 02:26:25.929638 systemd[1]: Finished modprobe@loop.service - Load Kernel Module loop. Mar 6 02:26:25.932278 systemd[1]: systemd-pstore.service - Platform Persistent Storage Archival was skipped because of an unmet condition check (ConditionDirectoryNotEmpty=/sys/fs/pstore). Mar 6 02:26:25.932381 systemd[1]: systemd-repart.service - Repartition Root Disk was skipped because no trigger condition checks were met. Mar 6 02:26:26.043692 systemd-resolved[1543]: Positive Trust Anchors: Mar 6 02:26:26.043707 systemd-resolved[1543]: . IN DS 20326 8 2 e06d44b80b8f1d39a95c0b0d7c65d08458e880409bbc683457104237c7f8ec8d Mar 6 02:26:26.043734 systemd-resolved[1543]: 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 Mar 6 02:26:26.097352 systemd-resolved[1543]: Using system hostname 'ci-4459.2.3-n-a3850cb512'. Mar 6 02:26:26.098426 systemd[1]: Started systemd-resolved.service - Network Name Resolution. Mar 6 02:26:26.101608 systemd[1]: Reached target network.target - Network. Mar 6 02:26:26.104543 systemd[1]: Reached target nss-lookup.target - Host and Network Name Lookups. Mar 6 02:26:26.203620 systemd-networkd[1352]: eth0: Gained IPv6LL Mar 6 02:26:26.205488 systemd[1]: Finished systemd-networkd-wait-online.service - Wait for Network to be Configured. Mar 6 02:26:26.208750 systemd[1]: Reached target network-online.target - Network is Online. Mar 6 02:26:26.399612 augenrules[1582]: No rules Mar 6 02:26:26.400465 systemd[1]: audit-rules.service: Deactivated successfully. Mar 6 02:26:26.400649 systemd[1]: Finished audit-rules.service - Load Audit Rules. Mar 6 02:26:26.645844 systemd[1]: Finished systemd-journal-catalog-update.service - Rebuild Journal Catalog. Mar 6 02:26:27.718545 systemd[1]: Finished clean-ca-certificates.service - Clean up broken links in /etc/ssl/certs. Mar 6 02:26:27.720382 systemd[1]: update-ca-certificates.service - Update CA bundle at /etc/ssl/certs/ca-certificates.crt was skipped because of an unmet condition check (ConditionPathIsSymbolicLink=!/etc/ssl/certs/ca-certificates.crt). Mar 6 02:26:30.105759 ldconfig[1315]: /sbin/ldconfig: /usr/lib/ld.so.conf is not an ELF file - it has the wrong magic bytes at the start. Mar 6 02:26:30.112905 systemd[1]: Finished ldconfig.service - Rebuild Dynamic Linker Cache. Mar 6 02:26:30.116879 systemd[1]: Starting systemd-update-done.service - Update is Completed... Mar 6 02:26:30.133804 systemd[1]: Finished systemd-update-done.service - Update is Completed. Mar 6 02:26:30.135141 systemd[1]: Reached target sysinit.target - System Initialization. Mar 6 02:26:30.136473 systemd[1]: Started motdgen.path - Watch for update engine configuration changes. Mar 6 02:26:30.137818 systemd[1]: Started user-cloudinit@var-lib-flatcar\x2dinstall-user_data.path - Watch for a cloud-config at /var/lib/flatcar-install/user_data. Mar 6 02:26:30.140540 systemd[1]: Started google-oslogin-cache.timer - NSS cache refresh timer. Mar 6 02:26:30.141869 systemd[1]: Started logrotate.timer - Daily rotation of log files. Mar 6 02:26:30.143102 systemd[1]: Started mdadm.timer - Weekly check for MD array's redundancy information.. Mar 6 02:26:30.145542 systemd[1]: Started systemd-tmpfiles-clean.timer - Daily Cleanup of Temporary Directories. Mar 6 02:26:30.148556 systemd[1]: update-engine-stub.timer - Update Engine Stub Timer was skipped because of an unmet condition check (ConditionPathExists=/usr/.noupdate). Mar 6 02:26:30.148597 systemd[1]: Reached target paths.target - Path Units. Mar 6 02:26:30.151549 systemd[1]: Reached target timers.target - Timer Units. Mar 6 02:26:30.167628 systemd[1]: Listening on dbus.socket - D-Bus System Message Bus Socket. Mar 6 02:26:30.170032 systemd[1]: Starting docker.socket - Docker Socket for the API... Mar 6 02:26:30.173912 systemd[1]: Listening on sshd-unix-local.socket - OpenSSH Server Socket (systemd-ssh-generator, AF_UNIX Local). Mar 6 02:26:30.176706 systemd[1]: Listening on sshd-vsock.socket - OpenSSH Server Socket (systemd-ssh-generator, AF_VSOCK). Mar 6 02:26:30.179560 systemd[1]: Reached target ssh-access.target - SSH Access Available. Mar 6 02:26:30.182096 systemd[1]: Listening on sshd.socket - OpenSSH Server Socket. Mar 6 02:26:30.183647 systemd[1]: Listening on systemd-hostnamed.socket - Hostname Service Socket. Mar 6 02:26:30.187065 systemd[1]: Listening on docker.socket - Docker Socket for the API. Mar 6 02:26:30.190225 systemd[1]: Reached target sockets.target - Socket Units. Mar 6 02:26:30.192543 systemd[1]: Reached target basic.target - Basic System. Mar 6 02:26:30.194583 systemd[1]: addon-config@oem.service - Configure Addon /oem was skipped because no trigger condition checks were met. Mar 6 02:26:30.194603 systemd[1]: addon-run@oem.service - Run Addon /oem was skipped because no trigger condition checks were met. Mar 6 02:26:30.196279 systemd[1]: Starting chronyd.service - NTP client/server... Mar 6 02:26:30.199322 systemd[1]: Starting containerd.service - containerd container runtime... Mar 6 02:26:30.207138 systemd[1]: Starting coreos-metadata.service - Flatcar Metadata Agent... Mar 6 02:26:30.211525 systemd[1]: Starting dbus.service - D-Bus System Message Bus... Mar 6 02:26:30.216690 systemd[1]: Starting dracut-shutdown.service - Restore /run/initramfs on shutdown... Mar 6 02:26:30.222755 systemd[1]: Starting enable-oem-cloudinit.service - Enable cloudinit... Mar 6 02:26:30.226032 systemd[1]: Starting extend-filesystems.service - Extend Filesystems... Mar 6 02:26:30.227993 systemd[1]: flatcar-setup-environment.service - Modifies /etc/environment for CoreOS was skipped because of an unmet condition check (ConditionPathExists=/oem/bin/flatcar-setup-environment). Mar 6 02:26:30.230679 systemd[1]: Starting google-oslogin-cache.service - NSS cache refresh... Mar 6 02:26:30.234807 systemd[1]: hv_fcopy_uio_daemon.service - Hyper-V FCOPY UIO daemon was skipped because of an unmet condition check (ConditionPathExists=/sys/bus/vmbus/devices/eb765408-105f-49b6-b4aa-c123b64d17d4/uio). Mar 6 02:26:30.236199 systemd[1]: Started hv_kvp_daemon.service - Hyper-V KVP daemon. Mar 6 02:26:30.238625 systemd[1]: hv_vss_daemon.service - Hyper-V VSS daemon was skipped because of an unmet condition check (ConditionPathExists=/dev/vmbus/hv_vss). Mar 6 02:26:30.242741 jq[1600]: false Mar 6 02:26:30.243027 systemd[1]: Starting motdgen.service - Generate /run/flatcar/motd... Mar 6 02:26:30.247613 systemd[1]: Starting nvidia.service - NVIDIA Configure Service... Mar 6 02:26:30.250515 systemd[1]: Starting ssh-key-proc-cmdline.service - Install an ssh key from /proc/cmdline... Mar 6 02:26:30.254057 systemd[1]: Starting sshd-keygen.service - Generate sshd host keys... Mar 6 02:26:30.264887 systemd[1]: Starting systemd-logind.service - User Login Management... Mar 6 02:26:30.268250 systemd[1]: tcsd.service - TCG Core Services Daemon was skipped because of an unmet condition check (ConditionPathExists=/dev/tpm0). Mar 6 02:26:30.268649 systemd[1]: cgroup compatibility translation between legacy and unified hierarchy settings activated. See cgroup-compat debug messages for details. Mar 6 02:26:30.270648 systemd[1]: Starting update-engine.service - Update Engine... Mar 6 02:26:30.277663 systemd[1]: Starting update-ssh-keys-after-ignition.service - Run update-ssh-keys once after Ignition... Mar 6 02:26:30.283412 KVP[1606]: KVP starting; pid is:1606 Mar 6 02:26:30.284715 extend-filesystems[1602]: Found /dev/nvme0n1p6 Mar 6 02:26:30.288553 systemd[1]: Finished dracut-shutdown.service - Restore /run/initramfs on shutdown. Mar 6 02:26:30.291545 kernel: hv_utils: KVP IC version 4.0 Mar 6 02:26:30.290630 KVP[1606]: KVP LIC Version: 3.1 Mar 6 02:26:30.292888 systemd[1]: enable-oem-cloudinit.service: Skipped due to 'exec-condition'. Mar 6 02:26:30.293034 systemd[1]: Condition check resulted in enable-oem-cloudinit.service - Enable cloudinit being skipped. Mar 6 02:26:30.293203 systemd[1]: ssh-key-proc-cmdline.service: Deactivated successfully. Mar 6 02:26:30.293322 systemd[1]: Finished ssh-key-proc-cmdline.service - Install an ssh key from /proc/cmdline. Mar 6 02:26:30.298557 jq[1618]: true Mar 6 02:26:30.309891 extend-filesystems[1602]: Found /dev/nvme0n1p9 Mar 6 02:26:30.314577 extend-filesystems[1602]: Checking size of /dev/nvme0n1p9 Mar 6 02:26:30.322807 (ntainerd)[1634]: containerd.service: Referenced but unset environment variable evaluates to an empty string: TORCX_IMAGEDIR, TORCX_UNPACKDIR Mar 6 02:26:30.326030 chronyd[1595]: chronyd version 4.7 starting (+CMDMON +REFCLOCK +RTC +PRIVDROP +SCFILTER -SIGND +NTS +SECHASH +IPV6 -DEBUG) Mar 6 02:26:30.329391 systemd[1]: motdgen.service: Deactivated successfully. Mar 6 02:26:30.329621 systemd[1]: Finished motdgen.service - Generate /run/flatcar/motd. Mar 6 02:26:30.332775 jq[1629]: true Mar 6 02:26:30.339837 systemd[1]: Finished nvidia.service - NVIDIA Configure Service. Mar 6 02:26:30.355630 extend-filesystems[1602]: Old size kept for /dev/nvme0n1p9 Mar 6 02:26:30.353026 systemd[1]: extend-filesystems.service: Deactivated successfully. Mar 6 02:26:30.353200 systemd[1]: Finished extend-filesystems.service - Extend Filesystems. Mar 6 02:26:30.366864 chronyd[1595]: Timezone right/UTC failed leap second check, ignoring Mar 6 02:26:30.366990 chronyd[1595]: Loaded seccomp filter (level 2) Mar 6 02:26:30.367372 systemd[1]: Started chronyd.service - NTP client/server. Mar 6 02:26:30.385256 systemd-logind[1614]: New seat seat0. Mar 6 02:26:30.386573 systemd-logind[1614]: Watching system buttons on /dev/input/event0 (AT Translated Set 2 keyboard) Mar 6 02:26:30.387545 systemd[1]: Started systemd-logind.service - User Login Management. Mar 6 02:26:30.390703 update_engine[1616]: I20260306 02:26:30.390636 1616 main.cc:92] Flatcar Update Engine starting Mar 6 02:26:30.397113 google_oslogin_nss_cache[1605]: oslogin_cache_refresh[1605]: Refreshing passwd entry cache Mar 6 02:26:30.395629 oslogin_cache_refresh[1605]: Refreshing passwd entry cache Mar 6 02:26:30.406829 google_oslogin_nss_cache[1605]: oslogin_cache_refresh[1605]: Failure getting users, quitting Mar 6 02:26:30.406829 google_oslogin_nss_cache[1605]: oslogin_cache_refresh[1605]: Produced empty passwd cache file, removing /etc/oslogin_passwd.cache.bak. Mar 6 02:26:30.406829 google_oslogin_nss_cache[1605]: oslogin_cache_refresh[1605]: Refreshing group entry cache Mar 6 02:26:30.406685 oslogin_cache_refresh[1605]: Failure getting users, quitting Mar 6 02:26:30.406700 oslogin_cache_refresh[1605]: Produced empty passwd cache file, removing /etc/oslogin_passwd.cache.bak. Mar 6 02:26:30.406737 oslogin_cache_refresh[1605]: Refreshing group entry cache Mar 6 02:26:30.428604 google_oslogin_nss_cache[1605]: oslogin_cache_refresh[1605]: Failure getting groups, quitting Mar 6 02:26:30.428652 oslogin_cache_refresh[1605]: Failure getting groups, quitting Mar 6 02:26:30.428709 google_oslogin_nss_cache[1605]: oslogin_cache_refresh[1605]: Produced empty group cache file, removing /etc/oslogin_group.cache.bak. Mar 6 02:26:30.428733 oslogin_cache_refresh[1605]: Produced empty group cache file, removing /etc/oslogin_group.cache.bak. Mar 6 02:26:30.430225 systemd[1]: google-oslogin-cache.service: Deactivated successfully. Mar 6 02:26:30.430809 systemd[1]: Finished google-oslogin-cache.service - NSS cache refresh. Mar 6 02:26:30.468538 bash[1667]: Updated "/home/core/.ssh/authorized_keys" Mar 6 02:26:30.469874 systemd[1]: Finished update-ssh-keys-after-ignition.service - Run update-ssh-keys once after Ignition. Mar 6 02:26:30.473117 systemd[1]: sshkeys.service was skipped because no trigger condition checks were met. Mar 6 02:26:30.547375 dbus-daemon[1598]: [system] SELinux support is enabled Mar 6 02:26:30.547512 systemd[1]: Started dbus.service - D-Bus System Message Bus. Mar 6 02:26:30.557090 update_engine[1616]: I20260306 02:26:30.553881 1616 update_check_scheduler.cc:74] Next update check in 6m8s Mar 6 02:26:30.556599 dbus-daemon[1598]: [system] Successfully activated service 'org.freedesktop.systemd1' Mar 6 02:26:30.555749 systemd[1]: system-cloudinit@usr-share-oem-cloud\x2dconfig.yml.service - Load cloud-config from /usr/share/oem/cloud-config.yml was skipped because of an unmet condition check (ConditionFileNotEmpty=/usr/share/oem/cloud-config.yml). Mar 6 02:26:30.555772 systemd[1]: Reached target system-config.target - Load system-provided cloud configs. Mar 6 02:26:30.557585 systemd[1]: user-cloudinit-proc-cmdline.service - Load cloud-config from url defined in /proc/cmdline was skipped because of an unmet condition check (ConditionKernelCommandLine=cloud-config-url). Mar 6 02:26:30.557602 systemd[1]: Reached target user-config.target - Load user-provided cloud configs. Mar 6 02:26:30.559657 systemd[1]: Started update-engine.service - Update Engine. Mar 6 02:26:30.564696 systemd[1]: Started locksmithd.service - Cluster reboot manager. Mar 6 02:26:30.587843 sshd_keygen[1638]: ssh-keygen: generating new host keys: RSA ECDSA ED25519 Mar 6 02:26:30.604873 systemd[1]: Finished sshd-keygen.service - Generate sshd host keys. Mar 6 02:26:30.607906 systemd[1]: Starting issuegen.service - Generate /run/issue... Mar 6 02:26:30.617722 systemd[1]: Starting waagent.service - Microsoft Azure Linux Agent... Mar 6 02:26:30.622834 coreos-metadata[1597]: Mar 06 02:26:30.622 INFO Fetching http://168.63.129.16/?comp=versions: Attempt #1 Mar 6 02:26:30.625429 coreos-metadata[1597]: Mar 06 02:26:30.625 INFO Fetch successful Mar 6 02:26:30.625534 coreos-metadata[1597]: Mar 06 02:26:30.625 INFO Fetching http://168.63.129.16/machine/?comp=goalstate: Attempt #1 Mar 6 02:26:30.626392 systemd[1]: issuegen.service: Deactivated successfully. Mar 6 02:26:30.628792 coreos-metadata[1597]: Mar 06 02:26:30.628 INFO Fetch successful Mar 6 02:26:30.629312 coreos-metadata[1597]: Mar 06 02:26:30.629 INFO Fetching http://168.63.129.16/machine/33077be7-9b4e-4f3c-ae28-c637f8f1aa8b/715d77d0%2Df3bf%2D4ac8%2Db7bd%2D386f61a05fd2.%5Fci%2D4459.2.3%2Dn%2Da3850cb512?comp=config&type=sharedConfig&incarnation=1: Attempt #1 Mar 6 02:26:30.630224 coreos-metadata[1597]: Mar 06 02:26:30.630 INFO Fetch successful Mar 6 02:26:30.630339 coreos-metadata[1597]: Mar 06 02:26:30.630 INFO Fetching http://169.254.169.254/metadata/instance/compute/vmSize?api-version=2017-08-01&format=text: Attempt #1 Mar 6 02:26:30.630669 systemd[1]: Finished issuegen.service - Generate /run/issue. Mar 6 02:26:30.635291 systemd[1]: Starting systemd-user-sessions.service - Permit User Sessions... Mar 6 02:26:30.639131 coreos-metadata[1597]: Mar 06 02:26:30.637 INFO Fetch successful Mar 6 02:26:30.646028 systemd[1]: Finished systemd-user-sessions.service - Permit User Sessions. Mar 6 02:26:30.657549 systemd[1]: Started getty@tty1.service - Getty on tty1. Mar 6 02:26:30.665897 systemd[1]: Started serial-getty@ttyS0.service - Serial Getty on ttyS0. Mar 6 02:26:30.667947 systemd[1]: Reached target getty.target - Login Prompts. Mar 6 02:26:30.673181 systemd[1]: Started waagent.service - Microsoft Azure Linux Agent. Mar 6 02:26:30.680859 systemd[1]: Finished coreos-metadata.service - Flatcar Metadata Agent. Mar 6 02:26:30.682869 systemd[1]: packet-phone-home.service - Report Success to Packet was skipped because no trigger condition checks were met. Mar 6 02:26:30.816889 locksmithd[1696]: locksmithd starting currentOperation="UPDATE_STATUS_IDLE" strategy="reboot" Mar 6 02:26:31.761382 containerd[1634]: time="2026-03-06T02:26:31Z" 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 Mar 6 02:26:31.762416 containerd[1634]: time="2026-03-06T02:26:31.762380804Z" level=info msg="starting containerd" revision=4ac6c20c7bbf8177f29e46bbdc658fec02ffb8ad version=v2.0.7 Mar 6 02:26:31.767908 containerd[1634]: time="2026-03-06T02:26:31.767872151Z" level=warning msg="Configuration migrated from version 2, use `containerd config migrate` to avoid migration" t="7.636µs" Mar 6 02:26:31.767908 containerd[1634]: time="2026-03-06T02:26:31.767896988Z" level=info msg="loading plugin" id=io.containerd.image-verifier.v1.bindir type=io.containerd.image-verifier.v1 Mar 6 02:26:31.767908 containerd[1634]: time="2026-03-06T02:26:31.767912573Z" level=info msg="loading plugin" id=io.containerd.internal.v1.opt type=io.containerd.internal.v1 Mar 6 02:26:31.768028 containerd[1634]: time="2026-03-06T02:26:31.768021449Z" level=info msg="loading plugin" id=io.containerd.warning.v1.deprecations type=io.containerd.warning.v1 Mar 6 02:26:31.768045 containerd[1634]: time="2026-03-06T02:26:31.768033405Z" level=info msg="loading plugin" id=io.containerd.content.v1.content type=io.containerd.content.v1 Mar 6 02:26:31.768060 containerd[1634]: time="2026-03-06T02:26:31.768052604Z" level=info msg="loading plugin" id=io.containerd.snapshotter.v1.blockfile type=io.containerd.snapshotter.v1 Mar 6 02:26:31.768117 containerd[1634]: time="2026-03-06T02:26:31.768101513Z" level=info msg="skip loading plugin" error="no scratch file generator: skip plugin" id=io.containerd.snapshotter.v1.blockfile type=io.containerd.snapshotter.v1 Mar 6 02:26:31.768117 containerd[1634]: time="2026-03-06T02:26:31.768111631Z" level=info msg="loading plugin" id=io.containerd.snapshotter.v1.btrfs type=io.containerd.snapshotter.v1 Mar 6 02:26:31.768297 containerd[1634]: time="2026-03-06T02:26:31.768282724Z" level=info msg="skip loading plugin" error="path /var/lib/containerd/io.containerd.snapshotter.v1.btrfs (xfs) 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 Mar 6 02:26:31.768297 containerd[1634]: time="2026-03-06T02:26:31.768292262Z" level=info msg="loading plugin" id=io.containerd.snapshotter.v1.devmapper type=io.containerd.snapshotter.v1 Mar 6 02:26:31.768335 containerd[1634]: time="2026-03-06T02:26:31.768301055Z" level=info msg="skip loading plugin" error="devmapper not configured: skip plugin" id=io.containerd.snapshotter.v1.devmapper type=io.containerd.snapshotter.v1 Mar 6 02:26:31.768335 containerd[1634]: time="2026-03-06T02:26:31.768307405Z" level=info msg="loading plugin" id=io.containerd.snapshotter.v1.native type=io.containerd.snapshotter.v1 Mar 6 02:26:31.768368 containerd[1634]: time="2026-03-06T02:26:31.768349200Z" level=info msg="loading plugin" id=io.containerd.snapshotter.v1.overlayfs type=io.containerd.snapshotter.v1 Mar 6 02:26:31.768562 containerd[1634]: time="2026-03-06T02:26:31.768546972Z" level=info msg="loading plugin" id=io.containerd.snapshotter.v1.zfs type=io.containerd.snapshotter.v1 Mar 6 02:26:31.768591 containerd[1634]: time="2026-03-06T02:26:31.768567693Z" 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 Mar 6 02:26:31.768591 containerd[1634]: time="2026-03-06T02:26:31.768576305Z" level=info msg="loading plugin" id=io.containerd.event.v1.exchange type=io.containerd.event.v1 Mar 6 02:26:31.768624 containerd[1634]: time="2026-03-06T02:26:31.768599908Z" level=info msg="loading plugin" id=io.containerd.monitor.task.v1.cgroups type=io.containerd.monitor.task.v1 Mar 6 02:26:31.768828 containerd[1634]: time="2026-03-06T02:26:31.768814421Z" level=info msg="loading plugin" id=io.containerd.metadata.v1.bolt type=io.containerd.metadata.v1 Mar 6 02:26:31.768864 containerd[1634]: time="2026-03-06T02:26:31.768851145Z" level=info msg="metadata content store policy set" policy=shared Mar 6 02:26:31.777405 containerd[1634]: time="2026-03-06T02:26:31.777379048Z" level=info msg="loading plugin" id=io.containerd.gc.v1.scheduler type=io.containerd.gc.v1 Mar 6 02:26:31.777465 containerd[1634]: time="2026-03-06T02:26:31.777414739Z" level=info msg="loading plugin" id=io.containerd.differ.v1.walking type=io.containerd.differ.v1 Mar 6 02:26:31.777465 containerd[1634]: time="2026-03-06T02:26:31.777427683Z" level=info msg="loading plugin" id=io.containerd.lease.v1.manager type=io.containerd.lease.v1 Mar 6 02:26:31.777465 containerd[1634]: time="2026-03-06T02:26:31.777437466Z" level=info msg="loading plugin" id=io.containerd.service.v1.containers-service type=io.containerd.service.v1 Mar 6 02:26:31.777465 containerd[1634]: time="2026-03-06T02:26:31.777448539Z" level=info msg="loading plugin" id=io.containerd.service.v1.content-service type=io.containerd.service.v1 Mar 6 02:26:31.777465 containerd[1634]: time="2026-03-06T02:26:31.777457606Z" level=info msg="loading plugin" id=io.containerd.service.v1.diff-service type=io.containerd.service.v1 Mar 6 02:26:31.777570 containerd[1634]: time="2026-03-06T02:26:31.777469339Z" level=info msg="loading plugin" id=io.containerd.service.v1.images-service type=io.containerd.service.v1 Mar 6 02:26:31.777570 containerd[1634]: time="2026-03-06T02:26:31.777479278Z" level=info msg="loading plugin" id=io.containerd.service.v1.introspection-service type=io.containerd.service.v1 Mar 6 02:26:31.777570 containerd[1634]: time="2026-03-06T02:26:31.777491241Z" level=info msg="loading plugin" id=io.containerd.service.v1.namespaces-service type=io.containerd.service.v1 Mar 6 02:26:31.777570 containerd[1634]: time="2026-03-06T02:26:31.777524954Z" level=info msg="loading plugin" id=io.containerd.service.v1.snapshots-service type=io.containerd.service.v1 Mar 6 02:26:31.777570 containerd[1634]: time="2026-03-06T02:26:31.777534333Z" level=info msg="loading plugin" id=io.containerd.shim.v1.manager type=io.containerd.shim.v1 Mar 6 02:26:31.777570 containerd[1634]: time="2026-03-06T02:26:31.777549893Z" level=info msg="loading plugin" id=io.containerd.runtime.v2.task type=io.containerd.runtime.v2 Mar 6 02:26:31.777689 containerd[1634]: time="2026-03-06T02:26:31.777669027Z" level=info msg="loading plugin" id=io.containerd.service.v1.tasks-service type=io.containerd.service.v1 Mar 6 02:26:31.777689 containerd[1634]: time="2026-03-06T02:26:31.777684839Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.containers type=io.containerd.grpc.v1 Mar 6 02:26:31.777720 containerd[1634]: time="2026-03-06T02:26:31.777696574Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.content type=io.containerd.grpc.v1 Mar 6 02:26:31.777720 containerd[1634]: time="2026-03-06T02:26:31.777706418Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.diff type=io.containerd.grpc.v1 Mar 6 02:26:31.777720 containerd[1634]: time="2026-03-06T02:26:31.777715290Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.events type=io.containerd.grpc.v1 Mar 6 02:26:31.777779 containerd[1634]: time="2026-03-06T02:26:31.777724196Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.images type=io.containerd.grpc.v1 Mar 6 02:26:31.777779 containerd[1634]: time="2026-03-06T02:26:31.777739287Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.introspection type=io.containerd.grpc.v1 Mar 6 02:26:31.777779 containerd[1634]: time="2026-03-06T02:26:31.777749100Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.leases type=io.containerd.grpc.v1 Mar 6 02:26:31.777779 containerd[1634]: time="2026-03-06T02:26:31.777758945Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.namespaces type=io.containerd.grpc.v1 Mar 6 02:26:31.777779 containerd[1634]: time="2026-03-06T02:26:31.777767840Z" level=info msg="loading plugin" id=io.containerd.sandbox.store.v1.local type=io.containerd.sandbox.store.v1 Mar 6 02:26:31.777779 containerd[1634]: time="2026-03-06T02:26:31.777776979Z" level=info msg="loading plugin" id=io.containerd.cri.v1.images type=io.containerd.cri.v1 Mar 6 02:26:31.777951 containerd[1634]: time="2026-03-06T02:26:31.777824194Z" level=info msg="Get image filesystem path \"/var/lib/containerd/io.containerd.snapshotter.v1.overlayfs\" for snapshotter \"overlayfs\"" Mar 6 02:26:31.777951 containerd[1634]: time="2026-03-06T02:26:31.777836607Z" level=info msg="Start snapshots syncer" Mar 6 02:26:31.777951 containerd[1634]: time="2026-03-06T02:26:31.777868102Z" level=info msg="loading plugin" id=io.containerd.cri.v1.runtime type=io.containerd.cri.v1 Mar 6 02:26:31.778097 containerd[1634]: time="2026-03-06T02:26:31.778071901Z" 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,\"baseRuntimeSpec\":\"\",\"cniConfDir\":\"\",\"cniMaxConfNum\":0,\"snapshotter\":\"\",\"sandboxer\":\"podsandbox\",\"io_type\":\"\"}},\"ignoreBlockIONotEnabledErrors\":false,\"ignoreRdtNotEnabledErrors\":false},\"cni\":{\"binDir\":\"/opt/cni/bin\",\"confDir\":\"/etc/cni/net.d\",\"maxConfNum\":1,\"setupSerially\":false,\"confTemplate\":\"\",\"ipPref\":\"\",\"useInternalLoopback\":false},\"enableSelinux\":true,\"selinuxCategoryRange\":1024,\"maxContainerLogSize\":16384,\"disableApparmor\":false,\"restrictOOMScoreAdj\":false,\"disableProcMount\":false,\"unsetSeccompProfile\":\"\",\"tolerateMissingHugetlbController\":true,\"disableHugetlbController\":true,\"device_ownership_from_security_context\":false,\"ignoreImageDefinedVolumes\":false,\"netnsMountsUnderStateDir\":false,\"enableUnprivilegedPorts\":true,\"enableUnprivilegedICMP\":true,\"enableCDI\":true,\"cdiSpecDirs\":[\"/etc/cdi\",\"/var/run/cdi\"],\"drainExecSyncIOTimeout\":\"0s\",\"ignoreDeprecationWarnings\":null,\"containerdRootDir\":\"/var/lib/containerd\",\"containerdEndpoint\":\"/run/containerd/containerd.sock\",\"rootDir\":\"/var/lib/containerd/io.containerd.grpc.v1.cri\",\"stateDir\":\"/run/containerd/io.containerd.grpc.v1.cri\"}" Mar 6 02:26:31.778248 containerd[1634]: time="2026-03-06T02:26:31.778112174Z" level=info msg="loading plugin" id=io.containerd.podsandbox.controller.v1.podsandbox type=io.containerd.podsandbox.controller.v1 Mar 6 02:26:31.778248 containerd[1634]: time="2026-03-06T02:26:31.778160976Z" level=info msg="loading plugin" id=io.containerd.sandbox.controller.v1.shim type=io.containerd.sandbox.controller.v1 Mar 6 02:26:31.778248 containerd[1634]: time="2026-03-06T02:26:31.778232394Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.sandbox-controllers type=io.containerd.grpc.v1 Mar 6 02:26:31.778303 containerd[1634]: time="2026-03-06T02:26:31.778247034Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.sandboxes type=io.containerd.grpc.v1 Mar 6 02:26:31.778303 containerd[1634]: time="2026-03-06T02:26:31.778256104Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.snapshots type=io.containerd.grpc.v1 Mar 6 02:26:31.778303 containerd[1634]: time="2026-03-06T02:26:31.778264197Z" level=info msg="loading plugin" id=io.containerd.streaming.v1.manager type=io.containerd.streaming.v1 Mar 6 02:26:31.778303 containerd[1634]: time="2026-03-06T02:26:31.778275283Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.streaming type=io.containerd.grpc.v1 Mar 6 02:26:31.778303 containerd[1634]: time="2026-03-06T02:26:31.778284574Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.tasks type=io.containerd.grpc.v1 Mar 6 02:26:31.778303 containerd[1634]: time="2026-03-06T02:26:31.778294194Z" level=info msg="loading plugin" id=io.containerd.transfer.v1.local type=io.containerd.transfer.v1 Mar 6 02:26:31.778434 containerd[1634]: time="2026-03-06T02:26:31.778314101Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.transfer type=io.containerd.grpc.v1 Mar 6 02:26:31.778434 containerd[1634]: time="2026-03-06T02:26:31.778322508Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.version type=io.containerd.grpc.v1 Mar 6 02:26:31.778434 containerd[1634]: time="2026-03-06T02:26:31.778331814Z" level=info msg="loading plugin" id=io.containerd.monitor.container.v1.restart type=io.containerd.monitor.container.v1 Mar 6 02:26:31.778434 containerd[1634]: time="2026-03-06T02:26:31.778355130Z" level=info msg="loading plugin" id=io.containerd.tracing.processor.v1.otlp type=io.containerd.tracing.processor.v1 Mar 6 02:26:31.778434 containerd[1634]: time="2026-03-06T02:26:31.778366583Z" 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 Mar 6 02:26:31.778434 containerd[1634]: time="2026-03-06T02:26:31.778374840Z" level=info msg="loading plugin" id=io.containerd.internal.v1.tracing type=io.containerd.internal.v1 Mar 6 02:26:31.778434 containerd[1634]: time="2026-03-06T02:26:31.778382831Z" level=info msg="skip loading plugin" error="skip plugin: tracing endpoint not configured" id=io.containerd.internal.v1.tracing type=io.containerd.internal.v1 Mar 6 02:26:31.778434 containerd[1634]: time="2026-03-06T02:26:31.778389650Z" level=info msg="loading plugin" id=io.containerd.ttrpc.v1.otelttrpc type=io.containerd.ttrpc.v1 Mar 6 02:26:31.778434 containerd[1634]: time="2026-03-06T02:26:31.778396862Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.healthcheck type=io.containerd.grpc.v1 Mar 6 02:26:31.778434 containerd[1634]: time="2026-03-06T02:26:31.778414581Z" level=info msg="loading plugin" id=io.containerd.nri.v1.nri type=io.containerd.nri.v1 Mar 6 02:26:31.778434 containerd[1634]: time="2026-03-06T02:26:31.778428181Z" level=info msg="runtime interface created" Mar 6 02:26:31.778434 containerd[1634]: time="2026-03-06T02:26:31.778432434Z" level=info msg="created NRI interface" Mar 6 02:26:31.778745 containerd[1634]: time="2026-03-06T02:26:31.778439730Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.cri type=io.containerd.grpc.v1 Mar 6 02:26:31.778745 containerd[1634]: time="2026-03-06T02:26:31.778448954Z" level=info msg="Connect containerd service" Mar 6 02:26:31.778745 containerd[1634]: time="2026-03-06T02:26:31.778469424Z" level=info msg="using experimental NRI integration - disable nri plugin to prevent this" Mar 6 02:26:31.779036 containerd[1634]: time="2026-03-06T02:26:31.779011835Z" level=error msg="failed to load cni during init, please check CRI plugin status before setting up network for pods" error="cni config load failed: no network config found in /etc/cni/net.d: cni plugin not initialized: failed to load cni config" Mar 6 02:26:32.319513 containerd[1634]: time="2026-03-06T02:26:32.319457467Z" level=info msg="Start subscribing containerd event" Mar 6 02:26:32.319736 containerd[1634]: time="2026-03-06T02:26:32.319595496Z" level=info msg="Start recovering state" Mar 6 02:26:32.319736 containerd[1634]: time="2026-03-06T02:26:32.319645889Z" level=info msg=serving... address=/run/containerd/containerd.sock.ttrpc Mar 6 02:26:32.319736 containerd[1634]: time="2026-03-06T02:26:32.319679319Z" level=info msg=serving... address=/run/containerd/containerd.sock Mar 6 02:26:32.320182 containerd[1634]: time="2026-03-06T02:26:32.320155971Z" level=info msg="Start event monitor" Mar 6 02:26:32.320182 containerd[1634]: time="2026-03-06T02:26:32.320177159Z" level=info msg="Start cni network conf syncer for default" Mar 6 02:26:32.320253 containerd[1634]: time="2026-03-06T02:26:32.320184802Z" level=info msg="Start streaming server" Mar 6 02:26:32.320253 containerd[1634]: time="2026-03-06T02:26:32.320198071Z" level=info msg="Registered namespace \"k8s.io\" with NRI" Mar 6 02:26:32.320253 containerd[1634]: time="2026-03-06T02:26:32.320205982Z" level=info msg="runtime interface starting up..." Mar 6 02:26:32.320253 containerd[1634]: time="2026-03-06T02:26:32.320212056Z" level=info msg="starting plugins..." Mar 6 02:26:32.320253 containerd[1634]: time="2026-03-06T02:26:32.320225934Z" level=info msg="Synchronizing NRI (plugin) with current runtime state" Mar 6 02:26:32.321731 containerd[1634]: time="2026-03-06T02:26:32.320453384Z" level=info msg="containerd successfully booted in 0.559478s" Mar 6 02:26:32.320600 systemd[1]: Started containerd.service - containerd container runtime. Mar 6 02:26:32.325121 systemd[1]: Reached target multi-user.target - Multi-User System. Mar 6 02:26:32.329781 systemd[1]: Startup finished in 2.753s (kernel) + 9.070s (initrd) + 15.501s (userspace) = 27.325s. Mar 6 02:26:32.615710 login[1721]: pam_lastlog(login:session): file /var/log/lastlog is locked/write, retrying Mar 6 02:26:32.616575 login[1719]: pam_unix(login:session): session opened for user core(uid=500) by LOGIN(uid=0) Mar 6 02:26:32.624580 systemd[1]: Created slice user-500.slice - User Slice of UID 500. Mar 6 02:26:32.626371 systemd[1]: Starting user-runtime-dir@500.service - User Runtime Directory /run/user/500... Mar 6 02:26:32.637539 systemd-logind[1614]: New session 2 of user core. Mar 6 02:26:32.655614 systemd[1]: Finished user-runtime-dir@500.service - User Runtime Directory /run/user/500. Mar 6 02:26:32.657681 systemd[1]: Starting user@500.service - User Manager for UID 500... Mar 6 02:26:32.668073 (systemd)[1755]: pam_unix(systemd-user:session): session opened for user core(uid=500) by (uid=0) Mar 6 02:26:32.669607 systemd-logind[1614]: New session c1 of user core. Mar 6 02:26:32.819918 systemd[1755]: Queued start job for default target default.target. Mar 6 02:26:32.823286 systemd[1755]: Created slice app.slice - User Application Slice. Mar 6 02:26:32.823317 systemd[1755]: Reached target paths.target - Paths. Mar 6 02:26:32.823347 systemd[1755]: Reached target timers.target - Timers. Mar 6 02:26:32.826609 systemd[1755]: Starting dbus.socket - D-Bus User Message Bus Socket... Mar 6 02:26:32.835613 systemd[1755]: Listening on dbus.socket - D-Bus User Message Bus Socket. Mar 6 02:26:32.835692 systemd[1755]: Reached target sockets.target - Sockets. Mar 6 02:26:32.835800 systemd[1755]: Reached target basic.target - Basic System. Mar 6 02:26:32.835848 systemd[1]: Started user@500.service - User Manager for UID 500. Mar 6 02:26:32.836351 systemd[1755]: Reached target default.target - Main User Target. Mar 6 02:26:32.836386 systemd[1755]: Startup finished in 162ms. Mar 6 02:26:32.837973 waagent[1723]: 2026-03-06T02:26:32.837911Z INFO Daemon Daemon Azure Linux Agent Version: 2.12.0.4 Mar 6 02:26:32.839150 waagent[1723]: 2026-03-06T02:26:32.838860Z INFO Daemon Daemon OS: flatcar 4459.2.3 Mar 6 02:26:32.840196 waagent[1723]: 2026-03-06T02:26:32.840167Z INFO Daemon Daemon Python: 3.11.13 Mar 6 02:26:32.840660 systemd[1]: Started session-2.scope - Session 2 of User core. Mar 6 02:26:32.841598 waagent[1723]: 2026-03-06T02:26:32.841552Z INFO Daemon Daemon Run daemon Mar 6 02:26:32.843436 waagent[1723]: 2026-03-06T02:26:32.842837Z INFO Daemon Daemon No RDMA handler exists for distro='Flatcar Container Linux by Kinvolk' version='4459.2.3' Mar 6 02:26:32.844486 waagent[1723]: 2026-03-06T02:26:32.844443Z INFO Daemon Daemon Using waagent for provisioning Mar 6 02:26:32.844890 waagent[1723]: 2026-03-06T02:26:32.844866Z INFO Daemon Daemon Activate resource disk Mar 6 02:26:32.845229 waagent[1723]: 2026-03-06T02:26:32.845209Z INFO Daemon Daemon Searching gen1 prefix 00000000-0001 or gen2 f8b3781a-1e82-4818-a1c3-63d806ec15bb Mar 6 02:26:32.846859 waagent[1723]: 2026-03-06T02:26:32.846826Z INFO Daemon Daemon Found device: None Mar 6 02:26:32.847139 waagent[1723]: 2026-03-06T02:26:32.847120Z ERROR Daemon Daemon Failed to mount resource disk [ResourceDiskError] unable to detect disk topology Mar 6 02:26:32.847433 waagent[1723]: 2026-03-06T02:26:32.847416Z ERROR Daemon Daemon Event: name=WALinuxAgent, op=ActivateResourceDisk, message=[ResourceDiskError] unable to detect disk topology, duration=0 Mar 6 02:26:32.848187 waagent[1723]: 2026-03-06T02:26:32.848152Z INFO Daemon Daemon Clean protocol and wireserver endpoint Mar 6 02:26:32.848612 waagent[1723]: 2026-03-06T02:26:32.848590Z INFO Daemon Daemon Running default provisioning handler Mar 6 02:26:32.856455 waagent[1723]: 2026-03-06T02:26:32.856419Z 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. Mar 6 02:26:32.859510 waagent[1723]: 2026-03-06T02:26:32.858775Z INFO Daemon Daemon Unable to get cloud-init enabled status from service: [Errno 2] No such file or directory: 'service' Mar 6 02:26:32.859510 waagent[1723]: 2026-03-06T02:26:32.858887Z INFO Daemon Daemon cloud-init is enabled: False Mar 6 02:26:32.859510 waagent[1723]: 2026-03-06T02:26:32.859147Z INFO Daemon Daemon Copying ovf-env.xml Mar 6 02:26:32.946559 waagent[1723]: 2026-03-06T02:26:32.943920Z INFO Daemon Daemon Successfully mounted dvd Mar 6 02:26:32.968953 systemd[1]: mnt-cdrom-secure.mount: Deactivated successfully. Mar 6 02:26:32.970727 waagent[1723]: 2026-03-06T02:26:32.970684Z INFO Daemon Daemon Detect protocol endpoint Mar 6 02:26:32.971362 waagent[1723]: 2026-03-06T02:26:32.971242Z INFO Daemon Daemon Clean protocol and wireserver endpoint Mar 6 02:26:32.972553 waagent[1723]: 2026-03-06T02:26:32.971391Z INFO Daemon Daemon WireServer endpoint is not found. Rerun dhcp handler Mar 6 02:26:32.972553 waagent[1723]: 2026-03-06T02:26:32.971454Z INFO Daemon Daemon Test for route to 168.63.129.16 Mar 6 02:26:32.972553 waagent[1723]: 2026-03-06T02:26:32.971721Z INFO Daemon Daemon Route to 168.63.129.16 exists Mar 6 02:26:32.972553 waagent[1723]: 2026-03-06T02:26:32.971839Z INFO Daemon Daemon Wire server endpoint:168.63.129.16 Mar 6 02:26:32.990292 waagent[1723]: 2026-03-06T02:26:32.990262Z INFO Daemon Daemon Fabric preferred wire protocol version:2015-04-05 Mar 6 02:26:32.992293 waagent[1723]: 2026-03-06T02:26:32.990878Z INFO Daemon Daemon Wire protocol version:2012-11-30 Mar 6 02:26:32.992293 waagent[1723]: 2026-03-06T02:26:32.991078Z INFO Daemon Daemon Server preferred version:2015-04-05 Mar 6 02:26:33.152051 waagent[1723]: 2026-03-06T02:26:33.151973Z INFO Daemon Daemon Initializing goal state during protocol detection Mar 6 02:26:33.154052 waagent[1723]: 2026-03-06T02:26:33.152429Z INFO Daemon Daemon Forcing an update of the goal state. Mar 6 02:26:33.160912 waagent[1723]: 2026-03-06T02:26:33.160873Z INFO Daemon Fetched a new incarnation for the WireServer goal state [incarnation 1] Mar 6 02:26:33.174877 waagent[1723]: 2026-03-06T02:26:33.174846Z INFO Daemon Daemon HostGAPlugin version: 1.0.8.179 Mar 6 02:26:33.176283 waagent[1723]: 2026-03-06T02:26:33.175715Z INFO Daemon Mar 6 02:26:33.176283 waagent[1723]: 2026-03-06T02:26:33.176034Z INFO Daemon Fetched new vmSettings [HostGAPlugin correlation ID: 51919649-fb6c-45b1-b65e-9f80ccd901be eTag: 9028442126788252027 source: Fabric] Mar 6 02:26:33.179779 waagent[1723]: 2026-03-06T02:26:33.176474Z INFO Daemon The vmSettings originated via Fabric; will ignore them. Mar 6 02:26:33.179779 waagent[1723]: 2026-03-06T02:26:33.176888Z INFO Daemon Mar 6 02:26:33.179779 waagent[1723]: 2026-03-06T02:26:33.177167Z INFO Daemon Fetching full goal state from the WireServer [incarnation 1] Mar 6 02:26:33.184768 waagent[1723]: 2026-03-06T02:26:33.184746Z INFO Daemon Daemon Downloading artifacts profile blob Mar 6 02:26:33.263523 waagent[1723]: 2026-03-06T02:26:33.263432Z INFO Daemon Downloaded certificate {'thumbprint': 'FBCD9674D163389B8DF61D7B3F0F137C1CDC08E2', 'hasPrivateKey': True} Mar 6 02:26:33.266485 waagent[1723]: 2026-03-06T02:26:33.264185Z INFO Daemon Fetch goal state completed Mar 6 02:26:33.269703 waagent[1723]: 2026-03-06T02:26:33.269646Z INFO Daemon Daemon Starting provisioning Mar 6 02:26:33.271760 waagent[1723]: 2026-03-06T02:26:33.270092Z INFO Daemon Daemon Handle ovf-env.xml. Mar 6 02:26:33.271760 waagent[1723]: 2026-03-06T02:26:33.270545Z INFO Daemon Daemon Set hostname [ci-4459.2.3-n-a3850cb512] Mar 6 02:26:33.277734 waagent[1723]: 2026-03-06T02:26:33.272183Z INFO Daemon Daemon Publish hostname [ci-4459.2.3-n-a3850cb512] Mar 6 02:26:33.277734 waagent[1723]: 2026-03-06T02:26:33.272391Z INFO Daemon Daemon Examine /proc/net/route for primary interface Mar 6 02:26:33.277734 waagent[1723]: 2026-03-06T02:26:33.272651Z INFO Daemon Daemon Primary interface is [eth0] Mar 6 02:26:33.279863 systemd-networkd[1352]: eth0: found matching network '/usr/lib/systemd/network/zz-default.network', based on potentially unpredictable interface name. Mar 6 02:26:33.279872 systemd-networkd[1352]: eth0: Configuring with /usr/lib/systemd/network/zz-default.network. Mar 6 02:26:33.279894 systemd-networkd[1352]: eth0: DHCP lease lost Mar 6 02:26:33.280722 waagent[1723]: 2026-03-06T02:26:33.280680Z INFO Daemon Daemon Create user account if not exists Mar 6 02:26:33.282064 waagent[1723]: 2026-03-06T02:26:33.281711Z INFO Daemon Daemon User core already exists, skip useradd Mar 6 02:26:33.282064 waagent[1723]: 2026-03-06T02:26:33.281885Z INFO Daemon Daemon Configure sudoer Mar 6 02:26:33.284394 waagent[1723]: 2026-03-06T02:26:33.284337Z INFO Daemon Daemon Configure sshd Mar 6 02:26:33.288822 waagent[1723]: 2026-03-06T02:26:33.288779Z INFO Daemon Daemon Added a configuration snippet disabling SSH password-based authentication methods. It also configures SSH client probing to keep connections alive. Mar 6 02:26:33.289398 waagent[1723]: 2026-03-06T02:26:33.289175Z INFO Daemon Daemon Deploy ssh public key. Mar 6 02:26:33.300537 systemd-networkd[1352]: eth0: DHCPv4 address 10.200.8.28/24, gateway 10.200.8.1 acquired from 168.63.129.16 Mar 6 02:26:33.617163 login[1721]: pam_unix(login:session): session opened for user core(uid=500) by LOGIN(uid=0) Mar 6 02:26:33.621221 systemd-logind[1614]: New session 1 of user core. Mar 6 02:26:33.630632 systemd[1]: Started session-1.scope - Session 1 of User core. Mar 6 02:26:34.361029 waagent[1723]: 2026-03-06T02:26:34.360988Z INFO Daemon Daemon Provisioning complete Mar 6 02:26:34.369583 waagent[1723]: 2026-03-06T02:26:34.369552Z INFO Daemon Daemon RDMA capabilities are not enabled, skipping Mar 6 02:26:34.371187 waagent[1723]: 2026-03-06T02:26:34.370043Z INFO Daemon Daemon End of log to /dev/console. The agent will now check for updates and then will process extensions. Mar 6 02:26:34.371187 waagent[1723]: 2026-03-06T02:26:34.370292Z INFO Daemon Daemon Installed Agent WALinuxAgent-2.12.0.4 is the most current agent Mar 6 02:26:34.461167 waagent[1805]: 2026-03-06T02:26:34.461102Z INFO ExtHandler ExtHandler Azure Linux Agent (Goal State Agent version 2.12.0.4) Mar 6 02:26:34.461387 waagent[1805]: 2026-03-06T02:26:34.461190Z INFO ExtHandler ExtHandler OS: flatcar 4459.2.3 Mar 6 02:26:34.461387 waagent[1805]: 2026-03-06T02:26:34.461227Z INFO ExtHandler ExtHandler Python: 3.11.13 Mar 6 02:26:34.461387 waagent[1805]: 2026-03-06T02:26:34.461263Z INFO ExtHandler ExtHandler CPU Arch: x86_64 Mar 6 02:26:34.496267 waagent[1805]: 2026-03-06T02:26:34.496223Z INFO ExtHandler ExtHandler Distro: flatcar-4459.2.3; OSUtil: FlatcarUtil; AgentService: waagent; Python: 3.11.13; Arch: x86_64; systemd: True; LISDrivers: Absent; logrotate: logrotate 3.22.0; Mar 6 02:26:34.496380 waagent[1805]: 2026-03-06T02:26:34.496356Z INFO ExtHandler ExtHandler WireServer endpoint 168.63.129.16 read from file Mar 6 02:26:34.496419 waagent[1805]: 2026-03-06T02:26:34.496404Z INFO ExtHandler ExtHandler Wire server endpoint:168.63.129.16 Mar 6 02:26:34.501061 waagent[1805]: 2026-03-06T02:26:34.501017Z INFO ExtHandler Fetched a new incarnation for the WireServer goal state [incarnation 1] Mar 6 02:26:34.505620 waagent[1805]: 2026-03-06T02:26:34.505592Z INFO ExtHandler ExtHandler HostGAPlugin version: 1.0.8.179 Mar 6 02:26:34.505925 waagent[1805]: 2026-03-06T02:26:34.505897Z INFO ExtHandler Mar 6 02:26:34.505966 waagent[1805]: 2026-03-06T02:26:34.505944Z INFO ExtHandler Fetched new vmSettings [HostGAPlugin correlation ID: 2b5a3451-0d4e-4e3e-9178-12fa834fe4e7 eTag: 9028442126788252027 source: Fabric] Mar 6 02:26:34.506147 waagent[1805]: 2026-03-06T02:26:34.506123Z INFO ExtHandler The vmSettings originated via Fabric; will ignore them. Mar 6 02:26:34.506442 waagent[1805]: 2026-03-06T02:26:34.506417Z INFO ExtHandler Mar 6 02:26:34.506483 waagent[1805]: 2026-03-06T02:26:34.506453Z INFO ExtHandler Fetching full goal state from the WireServer [incarnation 1] Mar 6 02:26:34.508944 waagent[1805]: 2026-03-06T02:26:34.508917Z INFO ExtHandler ExtHandler Downloading artifacts profile blob Mar 6 02:26:34.564800 waagent[1805]: 2026-03-06T02:26:34.564753Z INFO ExtHandler Downloaded certificate {'thumbprint': 'FBCD9674D163389B8DF61D7B3F0F137C1CDC08E2', 'hasPrivateKey': True} Mar 6 02:26:34.565101 waagent[1805]: 2026-03-06T02:26:34.565074Z INFO ExtHandler Fetch goal state completed Mar 6 02:26:34.575086 waagent[1805]: 2026-03-06T02:26:34.575046Z INFO ExtHandler ExtHandler OpenSSL version: OpenSSL 3.4.4 27 Jan 2026 (Library: OpenSSL 3.4.4 27 Jan 2026) Mar 6 02:26:34.578682 waagent[1805]: 2026-03-06T02:26:34.578641Z INFO ExtHandler ExtHandler WALinuxAgent-2.12.0.4 running as process 1805 Mar 6 02:26:34.578786 waagent[1805]: 2026-03-06T02:26:34.578748Z INFO ExtHandler ExtHandler ******** AutoUpdate.Enabled is set to False, not processing the operation ******** Mar 6 02:26:34.578989 waagent[1805]: 2026-03-06T02:26:34.578968Z INFO ExtHandler ExtHandler ******** AutoUpdate.UpdateToLatestVersion is set to False, not processing the operation ******** Mar 6 02:26:34.579870 waagent[1805]: 2026-03-06T02:26:34.579838Z INFO ExtHandler ExtHandler [CGI] Cgroup monitoring is not supported on ['flatcar', '4459.2.3', '', 'Flatcar Container Linux by Kinvolk'] Mar 6 02:26:34.580125 waagent[1805]: 2026-03-06T02:26:34.580101Z INFO ExtHandler ExtHandler [CGI] Agent will reset the quotas in case distro: ['flatcar', '4459.2.3', '', 'Flatcar Container Linux by Kinvolk'] went from supported to unsupported Mar 6 02:26:34.580212 waagent[1805]: 2026-03-06T02:26:34.580194Z INFO ExtHandler ExtHandler [CGI] Agent cgroups enabled: False Mar 6 02:26:34.580597 waagent[1805]: 2026-03-06T02:26:34.580576Z INFO ExtHandler ExtHandler Starting setup for Persistent firewall rules Mar 6 02:26:34.639739 waagent[1805]: 2026-03-06T02:26:34.639688Z INFO ExtHandler ExtHandler Firewalld service not running/unavailable, trying to set up waagent-network-setup.service Mar 6 02:26:34.639834 waagent[1805]: 2026-03-06T02:26:34.639812Z INFO ExtHandler ExtHandler Successfully updated the Binary file /var/lib/waagent/waagent-network-setup.py for firewall setup Mar 6 02:26:34.644521 waagent[1805]: 2026-03-06T02:26:34.644371Z INFO ExtHandler ExtHandler Service: waagent-network-setup.service not enabled. Adding it now Mar 6 02:26:34.649003 systemd[1]: Reload requested from client PID 1820 ('systemctl') (unit waagent.service)... Mar 6 02:26:34.649015 systemd[1]: Reloading... Mar 6 02:26:34.725512 zram_generator::config[1855]: No configuration found. Mar 6 02:26:34.878949 systemd[1]: Reloading finished in 229 ms. Mar 6 02:26:34.890565 waagent[1805]: 2026-03-06T02:26:34.888604Z INFO ExtHandler ExtHandler Successfully added and enabled the waagent-network-setup.service Mar 6 02:26:34.890565 waagent[1805]: 2026-03-06T02:26:34.888695Z INFO ExtHandler ExtHandler Persistent firewall rules setup successfully Mar 6 02:26:34.974510 kernel: hv_storvsc f8b3781a-1e82-4818-a1c3-63d806ec15bb: tag#208 cmd 0x4a status: scsi 0x0 srb 0x20 hv 0xc0000001 Mar 6 02:26:35.456357 waagent[1805]: 2026-03-06T02:26:35.456298Z INFO ExtHandler ExtHandler DROP rule is not available which implies no firewall rules are set yet. Environment thread will set it up. Mar 6 02:26:35.456634 waagent[1805]: 2026-03-06T02:26:35.456609Z 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] Mar 6 02:26:35.457219 waagent[1805]: 2026-03-06T02:26:35.457190Z INFO ExtHandler ExtHandler Starting env monitor service. Mar 6 02:26:35.457441 waagent[1805]: 2026-03-06T02:26:35.457409Z INFO MonitorHandler ExtHandler WireServer endpoint 168.63.129.16 read from file Mar 6 02:26:35.457488 waagent[1805]: 2026-03-06T02:26:35.457471Z INFO MonitorHandler ExtHandler Wire server endpoint:168.63.129.16 Mar 6 02:26:35.457684 waagent[1805]: 2026-03-06T02:26:35.457665Z INFO MonitorHandler ExtHandler Monitor.NetworkConfigurationChanges is disabled. Mar 6 02:26:35.458040 waagent[1805]: 2026-03-06T02:26:35.458013Z INFO ExtHandler ExtHandler Start SendTelemetryHandler service. Mar 6 02:26:35.458080 waagent[1805]: 2026-03-06T02:26:35.458055Z INFO EnvHandler ExtHandler WireServer endpoint 168.63.129.16 read from file Mar 6 02:26:35.458140 waagent[1805]: 2026-03-06T02:26:35.458108Z INFO EnvHandler ExtHandler Wire server endpoint:168.63.129.16 Mar 6 02:26:35.458252 waagent[1805]: 2026-03-06T02:26:35.458234Z INFO EnvHandler ExtHandler Configure routes Mar 6 02:26:35.458329 waagent[1805]: 2026-03-06T02:26:35.458275Z INFO EnvHandler ExtHandler Gateway:None Mar 6 02:26:35.458536 waagent[1805]: 2026-03-06T02:26:35.458484Z INFO SendTelemetryHandler ExtHandler Successfully started the SendTelemetryHandler thread Mar 6 02:26:35.458574 waagent[1805]: 2026-03-06T02:26:35.458548Z INFO MonitorHandler ExtHandler Routing table from /proc/net/route: Mar 6 02:26:35.458574 waagent[1805]: Iface Destination Gateway Flags RefCnt Use Metric Mask MTU Window IRTT Mar 6 02:26:35.458574 waagent[1805]: eth0 00000000 0108C80A 0003 0 0 1024 00000000 0 0 0 Mar 6 02:26:35.458574 waagent[1805]: eth0 0008C80A 00000000 0001 0 0 1024 00FFFFFF 0 0 0 Mar 6 02:26:35.458574 waagent[1805]: eth0 0108C80A 00000000 0005 0 0 1024 FFFFFFFF 0 0 0 Mar 6 02:26:35.458574 waagent[1805]: eth0 10813FA8 0108C80A 0007 0 0 1024 FFFFFFFF 0 0 0 Mar 6 02:26:35.458574 waagent[1805]: eth0 FEA9FEA9 0108C80A 0007 0 0 1024 FFFFFFFF 0 0 0 Mar 6 02:26:35.458776 waagent[1805]: 2026-03-06T02:26:35.458759Z INFO EnvHandler ExtHandler Routes:None Mar 6 02:26:35.458994 waagent[1805]: 2026-03-06T02:26:35.458970Z INFO ExtHandler ExtHandler Start Extension Telemetry service. Mar 6 02:26:35.459204 waagent[1805]: 2026-03-06T02:26:35.459173Z INFO TelemetryEventsCollector ExtHandler Extension Telemetry pipeline enabled: True Mar 6 02:26:35.459539 waagent[1805]: 2026-03-06T02:26:35.459489Z INFO ExtHandler ExtHandler Goal State Period: 6 sec. This indicates how often the agent checks for new goal states and reports status. Mar 6 02:26:35.459889 waagent[1805]: 2026-03-06T02:26:35.459866Z INFO TelemetryEventsCollector ExtHandler Successfully started the TelemetryEventsCollector thread Mar 6 02:26:35.477527 waagent[1805]: 2026-03-06T02:26:35.476673Z INFO ExtHandler ExtHandler Mar 6 02:26:35.477527 waagent[1805]: 2026-03-06T02:26:35.476736Z INFO ExtHandler ExtHandler ProcessExtensionsGoalState started [incarnation_1 channel: WireServer source: Fabric activity: 27179aef-5237-4ea7-ba5b-33dd200d902c correlation d4161aad-378d-4356-a059-a0a52a4931b7 created: 2026-03-06T02:25:37.971024Z] Mar 6 02:26:35.477527 waagent[1805]: 2026-03-06T02:26:35.477030Z INFO ExtHandler ExtHandler No extension handlers found, not processing anything. Mar 6 02:26:35.477817 waagent[1805]: 2026-03-06T02:26:35.477540Z INFO ExtHandler ExtHandler ProcessExtensionsGoalState completed [incarnation_1 0 ms] Mar 6 02:26:35.507362 waagent[1805]: 2026-03-06T02:26:35.507321Z INFO MonitorHandler ExtHandler Network interfaces: Mar 6 02:26:35.507362 waagent[1805]: Executing ['ip', '-a', '-o', 'link']: Mar 6 02:26:35.507362 waagent[1805]: 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 Mar 6 02:26:35.507362 waagent[1805]: 2: eth0: mtu 1500 qdisc mq state UP mode DEFAULT group default qlen 1000\ link/ether 00:0d:3a:dd:fb:cf brd ff:ff:ff:ff:ff:ff\ alias Network Device Mar 6 02:26:35.507362 waagent[1805]: 3: enP30832s1: mtu 1500 qdisc mq master eth0 state UP mode DEFAULT group default qlen 1000\ link/ether 00:0d:3a:dd:fb:cf brd ff:ff:ff:ff:ff:ff\ altname enP30832p0s0 Mar 6 02:26:35.507362 waagent[1805]: Executing ['ip', '-4', '-a', '-o', 'address']: Mar 6 02:26:35.507362 waagent[1805]: 1: lo inet 127.0.0.1/8 scope host lo\ valid_lft forever preferred_lft forever Mar 6 02:26:35.507362 waagent[1805]: 2: eth0 inet 10.200.8.28/24 metric 1024 brd 10.200.8.255 scope global eth0\ valid_lft forever preferred_lft forever Mar 6 02:26:35.507362 waagent[1805]: Executing ['ip', '-6', '-a', '-o', 'address']: Mar 6 02:26:35.507362 waagent[1805]: 1: lo inet6 ::1/128 scope host noprefixroute \ valid_lft forever preferred_lft forever Mar 6 02:26:35.507362 waagent[1805]: 2: eth0 inet6 fe80::20d:3aff:fedd:fbcf/64 scope link proto kernel_ll \ valid_lft forever preferred_lft forever Mar 6 02:26:35.524338 waagent[1805]: 2026-03-06T02:26:35.524297Z WARNING ExtHandler ExtHandler Failed to get firewall packets: 'iptables -w -t security -L OUTPUT --zero OUTPUT -nxv' failed: 2 (iptables v1.8.11 (nf_tables): Illegal option `--numeric' with this command Mar 6 02:26:35.524338 waagent[1805]: Try `iptables -h' or 'iptables --help' for more information.) Mar 6 02:26:35.524669 waagent[1805]: 2026-03-06T02:26:35.524643Z INFO ExtHandler ExtHandler [HEARTBEAT] Agent WALinuxAgent-2.12.0.4 is running as the goal state agent [DEBUG HeartbeatCounter: 0;HeartbeatId: 0DD223BD-8716-43FD-9DD3-797388537944;DroppedPackets: -1;UpdateGSErrors: 0;AutoUpdate: 0;UpdateMode: SelfUpdate;] Mar 6 02:26:35.555632 waagent[1805]: 2026-03-06T02:26:35.555587Z INFO EnvHandler ExtHandler Created firewall rules for the Azure Fabric: Mar 6 02:26:35.555632 waagent[1805]: Chain INPUT (policy ACCEPT 0 packets, 0 bytes) Mar 6 02:26:35.555632 waagent[1805]: pkts bytes target prot opt in out source destination Mar 6 02:26:35.555632 waagent[1805]: Chain FORWARD (policy ACCEPT 0 packets, 0 bytes) Mar 6 02:26:35.555632 waagent[1805]: pkts bytes target prot opt in out source destination Mar 6 02:26:35.555632 waagent[1805]: Chain OUTPUT (policy ACCEPT 0 packets, 0 bytes) Mar 6 02:26:35.555632 waagent[1805]: pkts bytes target prot opt in out source destination Mar 6 02:26:35.555632 waagent[1805]: 0 0 ACCEPT tcp -- * * 0.0.0.0/0 168.63.129.16 tcp dpt:53 Mar 6 02:26:35.555632 waagent[1805]: 0 0 ACCEPT tcp -- * * 0.0.0.0/0 168.63.129.16 owner UID match 0 Mar 6 02:26:35.555632 waagent[1805]: 0 0 DROP tcp -- * * 0.0.0.0/0 168.63.129.16 ctstate INVALID,NEW Mar 6 02:26:35.558034 waagent[1805]: 2026-03-06T02:26:35.557993Z INFO EnvHandler ExtHandler Current Firewall rules: Mar 6 02:26:35.558034 waagent[1805]: Chain INPUT (policy ACCEPT 0 packets, 0 bytes) Mar 6 02:26:35.558034 waagent[1805]: pkts bytes target prot opt in out source destination Mar 6 02:26:35.558034 waagent[1805]: Chain FORWARD (policy ACCEPT 0 packets, 0 bytes) Mar 6 02:26:35.558034 waagent[1805]: pkts bytes target prot opt in out source destination Mar 6 02:26:35.558034 waagent[1805]: Chain OUTPUT (policy ACCEPT 0 packets, 0 bytes) Mar 6 02:26:35.558034 waagent[1805]: pkts bytes target prot opt in out source destination Mar 6 02:26:35.558034 waagent[1805]: 0 0 ACCEPT tcp -- * * 0.0.0.0/0 168.63.129.16 tcp dpt:53 Mar 6 02:26:35.558034 waagent[1805]: 0 0 ACCEPT tcp -- * * 0.0.0.0/0 168.63.129.16 owner UID match 0 Mar 6 02:26:35.558034 waagent[1805]: 0 0 DROP tcp -- * * 0.0.0.0/0 168.63.129.16 ctstate INVALID,NEW Mar 6 02:26:54.006719 systemd[1]: Created slice system-sshd.slice - Slice /system/sshd. Mar 6 02:26:54.007785 systemd[1]: Started sshd@0-10.200.8.28:22-10.200.16.10:41984.service - OpenSSH per-connection server daemon (10.200.16.10:41984). Mar 6 02:26:54.148010 chronyd[1595]: Selected source PHC0 Mar 6 02:26:54.638380 sshd[1951]: Accepted publickey for core from 10.200.16.10 port 41984 ssh2: RSA SHA256:0Gw468yuBB7jlce/Xw60xOk7lSF5ihLZsmNpE+GQ81Y Mar 6 02:26:54.639402 sshd-session[1951]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Mar 6 02:26:54.643608 systemd-logind[1614]: New session 3 of user core. Mar 6 02:26:54.649627 systemd[1]: Started session-3.scope - Session 3 of User core. Mar 6 02:26:55.045847 systemd[1]: Started sshd@1-10.200.8.28:22-10.200.16.10:41998.service - OpenSSH per-connection server daemon (10.200.16.10:41998). Mar 6 02:26:55.579772 sshd[1957]: Accepted publickey for core from 10.200.16.10 port 41998 ssh2: RSA SHA256:0Gw468yuBB7jlce/Xw60xOk7lSF5ihLZsmNpE+GQ81Y Mar 6 02:26:55.580821 sshd-session[1957]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Mar 6 02:26:55.584154 systemd-logind[1614]: New session 4 of user core. Mar 6 02:26:55.593636 systemd[1]: Started session-4.scope - Session 4 of User core. Mar 6 02:26:55.883099 sshd[1960]: Connection closed by 10.200.16.10 port 41998 Mar 6 02:26:55.883521 sshd-session[1957]: pam_unix(sshd:session): session closed for user core Mar 6 02:26:55.886406 systemd[1]: sshd@1-10.200.8.28:22-10.200.16.10:41998.service: Deactivated successfully. Mar 6 02:26:55.888437 systemd-logind[1614]: Session 4 logged out. Waiting for processes to exit. Mar 6 02:26:55.888572 systemd[1]: session-4.scope: Deactivated successfully. Mar 6 02:26:55.890198 systemd-logind[1614]: Removed session 4. Mar 6 02:26:55.992611 systemd[1]: Started sshd@2-10.200.8.28:22-10.200.16.10:42014.service - OpenSSH per-connection server daemon (10.200.16.10:42014). Mar 6 02:26:56.526123 sshd[1966]: Accepted publickey for core from 10.200.16.10 port 42014 ssh2: RSA SHA256:0Gw468yuBB7jlce/Xw60xOk7lSF5ihLZsmNpE+GQ81Y Mar 6 02:26:56.527182 sshd-session[1966]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Mar 6 02:26:56.531063 systemd-logind[1614]: New session 5 of user core. Mar 6 02:26:56.532640 systemd[1]: Started session-5.scope - Session 5 of User core. Mar 6 02:26:56.825657 sshd[1969]: Connection closed by 10.200.16.10 port 42014 Mar 6 02:26:56.826669 sshd-session[1966]: pam_unix(sshd:session): session closed for user core Mar 6 02:26:56.829588 systemd[1]: sshd@2-10.200.8.28:22-10.200.16.10:42014.service: Deactivated successfully. Mar 6 02:26:56.831075 systemd[1]: session-5.scope: Deactivated successfully. Mar 6 02:26:56.831832 systemd-logind[1614]: Session 5 logged out. Waiting for processes to exit. Mar 6 02:26:56.832817 systemd-logind[1614]: Removed session 5. Mar 6 02:26:56.934559 systemd[1]: Started sshd@3-10.200.8.28:22-10.200.16.10:42020.service - OpenSSH per-connection server daemon (10.200.16.10:42020). Mar 6 02:26:57.469577 sshd[1975]: Accepted publickey for core from 10.200.16.10 port 42020 ssh2: RSA SHA256:0Gw468yuBB7jlce/Xw60xOk7lSF5ihLZsmNpE+GQ81Y Mar 6 02:26:57.470491 sshd-session[1975]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Mar 6 02:26:57.474568 systemd-logind[1614]: New session 6 of user core. Mar 6 02:26:57.479617 systemd[1]: Started session-6.scope - Session 6 of User core. Mar 6 02:26:57.771394 sshd[1978]: Connection closed by 10.200.16.10 port 42020 Mar 6 02:26:57.771869 sshd-session[1975]: pam_unix(sshd:session): session closed for user core Mar 6 02:26:57.774821 systemd[1]: sshd@3-10.200.8.28:22-10.200.16.10:42020.service: Deactivated successfully. Mar 6 02:26:57.776285 systemd[1]: session-6.scope: Deactivated successfully. Mar 6 02:26:57.777702 systemd-logind[1614]: Session 6 logged out. Waiting for processes to exit. Mar 6 02:26:57.778394 systemd-logind[1614]: Removed session 6. Mar 6 02:26:57.894580 systemd[1]: Started sshd@4-10.200.8.28:22-10.200.16.10:42022.service - OpenSSH per-connection server daemon (10.200.16.10:42022). Mar 6 02:26:58.429541 sshd[1984]: Accepted publickey for core from 10.200.16.10 port 42022 ssh2: RSA SHA256:0Gw468yuBB7jlce/Xw60xOk7lSF5ihLZsmNpE+GQ81Y Mar 6 02:26:58.430167 sshd-session[1984]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Mar 6 02:26:58.433952 systemd-logind[1614]: New session 7 of user core. Mar 6 02:26:58.439637 systemd[1]: Started session-7.scope - Session 7 of User core. Mar 6 02:26:58.788341 sudo[1988]: core : PWD=/home/core ; USER=root ; COMMAND=/usr/sbin/setenforce 1 Mar 6 02:26:58.788549 sudo[1988]: pam_unix(sudo:session): session opened for user root(uid=0) by core(uid=500) Mar 6 02:26:58.800112 sudo[1988]: pam_unix(sudo:session): session closed for user root Mar 6 02:26:58.900282 sshd[1987]: Connection closed by 10.200.16.10 port 42022 Mar 6 02:26:58.901646 sshd-session[1984]: pam_unix(sshd:session): session closed for user core Mar 6 02:26:58.903956 systemd[1]: sshd@4-10.200.8.28:22-10.200.16.10:42022.service: Deactivated successfully. Mar 6 02:26:58.905314 systemd[1]: session-7.scope: Deactivated successfully. Mar 6 02:26:58.906759 systemd-logind[1614]: Session 7 logged out. Waiting for processes to exit. Mar 6 02:26:58.907674 systemd-logind[1614]: Removed session 7. Mar 6 02:26:59.015693 systemd[1]: Started sshd@5-10.200.8.28:22-10.200.16.10:42024.service - OpenSSH per-connection server daemon (10.200.16.10:42024). Mar 6 02:26:59.548193 sshd[1994]: Accepted publickey for core from 10.200.16.10 port 42024 ssh2: RSA SHA256:0Gw468yuBB7jlce/Xw60xOk7lSF5ihLZsmNpE+GQ81Y Mar 6 02:26:59.548625 sshd-session[1994]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Mar 6 02:26:59.552572 systemd-logind[1614]: New session 8 of user core. Mar 6 02:26:59.557602 systemd[1]: Started session-8.scope - Session 8 of User core. Mar 6 02:26:59.750864 sudo[1999]: 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 Mar 6 02:26:59.751072 sudo[1999]: pam_unix(sudo:session): session opened for user root(uid=0) by core(uid=500) Mar 6 02:26:59.754951 sudo[1999]: pam_unix(sudo:session): session closed for user root Mar 6 02:26:59.758555 sudo[1998]: core : PWD=/home/core ; USER=root ; COMMAND=/usr/sbin/systemctl restart audit-rules Mar 6 02:26:59.758739 sudo[1998]: pam_unix(sudo:session): session opened for user root(uid=0) by core(uid=500) Mar 6 02:26:59.765348 systemd[1]: Starting audit-rules.service - Load Audit Rules... Mar 6 02:26:59.792442 augenrules[2021]: No rules Mar 6 02:26:59.793225 systemd[1]: audit-rules.service: Deactivated successfully. Mar 6 02:26:59.793481 systemd[1]: Finished audit-rules.service - Load Audit Rules. Mar 6 02:26:59.794450 sudo[1998]: pam_unix(sudo:session): session closed for user root Mar 6 02:26:59.894110 sshd[1997]: Connection closed by 10.200.16.10 port 42024 Mar 6 02:26:59.895672 sshd-session[1994]: pam_unix(sshd:session): session closed for user core Mar 6 02:26:59.898927 systemd[1]: sshd@5-10.200.8.28:22-10.200.16.10:42024.service: Deactivated successfully. Mar 6 02:26:59.899123 systemd-logind[1614]: Session 8 logged out. Waiting for processes to exit. Mar 6 02:26:59.900552 systemd[1]: session-8.scope: Deactivated successfully. Mar 6 02:26:59.901805 systemd-logind[1614]: Removed session 8. Mar 6 02:27:00.008755 systemd[1]: Started sshd@6-10.200.8.28:22-10.200.16.10:35666.service - OpenSSH per-connection server daemon (10.200.16.10:35666). Mar 6 02:27:00.541541 sshd[2030]: Accepted publickey for core from 10.200.16.10 port 35666 ssh2: RSA SHA256:0Gw468yuBB7jlce/Xw60xOk7lSF5ihLZsmNpE+GQ81Y Mar 6 02:27:00.542150 sshd-session[2030]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Mar 6 02:27:00.546097 systemd-logind[1614]: New session 9 of user core. Mar 6 02:27:00.550637 systemd[1]: Started session-9.scope - Session 9 of User core. Mar 6 02:27:00.760643 sudo[2034]: core : PWD=/home/core ; USER=root ; COMMAND=/usr/sbin/blkid -s UUID -o value /dev/disk/by-label/ROOT Mar 6 02:27:00.760841 sudo[2034]: pam_unix(sudo:session): session opened for user root(uid=0) by core(uid=500) Mar 6 02:27:00.808819 sudo[2034]: pam_unix(sudo:session): session closed for user root Mar 6 02:27:00.908413 sshd[2033]: Connection closed by 10.200.16.10 port 35666 Mar 6 02:27:00.908823 sshd-session[2030]: pam_unix(sshd:session): session closed for user core Mar 6 02:27:00.911555 systemd[1]: sshd@6-10.200.8.28:22-10.200.16.10:35666.service: Deactivated successfully. Mar 6 02:27:00.912874 systemd[1]: session-9.scope: Deactivated successfully. Mar 6 02:27:00.913430 systemd-logind[1614]: Session 9 logged out. Waiting for processes to exit. Mar 6 02:27:00.914436 systemd-logind[1614]: Removed session 9. Mar 6 02:27:01.034942 systemd[1]: Started sshd@7-10.200.8.28:22-10.200.16.10:35680.service - OpenSSH per-connection server daemon (10.200.16.10:35680). Mar 6 02:27:01.568530 sshd[2040]: Accepted publickey for core from 10.200.16.10 port 35680 ssh2: RSA SHA256:0Gw468yuBB7jlce/Xw60xOk7lSF5ihLZsmNpE+GQ81Y Mar 6 02:27:01.569236 sshd-session[2040]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Mar 6 02:27:01.573317 systemd-logind[1614]: New session 10 of user core. Mar 6 02:27:01.579616 systemd[1]: Started session-10.scope - Session 10 of User core. Mar 6 02:27:01.771771 sudo[2044]: core : PWD=/home/core ; USER=root ; COMMAND=/usr/sbin/blkid -s TYPE -o value /dev/disk/by-label/ROOT Mar 6 02:27:01.771971 sudo[2044]: pam_unix(sudo:session): session opened for user root(uid=0) by core(uid=500) Mar 6 02:27:01.774357 sudo[2044]: pam_unix(sudo:session): session closed for user root Mar 6 02:27:01.873818 sshd[2043]: Connection closed by 10.200.16.10 port 35680 Mar 6 02:27:01.874647 sshd-session[2040]: pam_unix(sshd:session): session closed for user core Mar 6 02:27:01.876593 systemd[1]: sshd@7-10.200.8.28:22-10.200.16.10:35680.service: Deactivated successfully. Mar 6 02:27:01.878857 systemd[1]: session-10.scope: Deactivated successfully. Mar 6 02:27:01.879490 systemd-logind[1614]: Session 10 logged out. Waiting for processes to exit. Mar 6 02:27:01.880141 systemd-logind[1614]: Removed session 10. Mar 6 02:27:01.990515 systemd[1]: Started sshd@8-10.200.8.28:22-10.200.16.10:35688.service - OpenSSH per-connection server daemon (10.200.16.10:35688). Mar 6 02:27:02.523246 sshd[2050]: Accepted publickey for core from 10.200.16.10 port 35688 ssh2: RSA SHA256:0Gw468yuBB7jlce/Xw60xOk7lSF5ihLZsmNpE+GQ81Y Mar 6 02:27:02.524193 sshd-session[2050]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Mar 6 02:27:02.528333 systemd-logind[1614]: New session 11 of user core. Mar 6 02:27:02.534617 systemd[1]: Started session-11.scope - Session 11 of User core. Mar 6 02:27:02.824684 sshd[2053]: Connection closed by 10.200.16.10 port 35688 Mar 6 02:27:02.825664 sshd-session[2050]: pam_unix(sshd:session): session closed for user core Mar 6 02:27:02.828632 systemd[1]: sshd@8-10.200.8.28:22-10.200.16.10:35688.service: Deactivated successfully. Mar 6 02:27:02.829969 systemd[1]: session-11.scope: Deactivated successfully. Mar 6 02:27:02.830722 systemd-logind[1614]: Session 11 logged out. Waiting for processes to exit. Mar 6 02:27:02.831812 systemd-logind[1614]: Removed session 11.