Mar 3 14:01:20.174402 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 Tue Mar 3 10:59:45 -00 2026 Mar 3 14:01:20.174429 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=51ade538e3d3c371f07ae1ec6fa9803fff0566ec060cf4b56dc685fc36d0e01c Mar 3 14:01:20.174439 kernel: BIOS-provided physical RAM map: Mar 3 14:01:20.174446 kernel: BIOS-e820: [mem 0x0000000000000000-0x000000000009ffff] usable Mar 3 14:01:20.174452 kernel: BIOS-e820: [mem 0x00000000000c0000-0x00000000000fffff] reserved Mar 3 14:01:20.174459 kernel: BIOS-e820: [mem 0x0000000000100000-0x000000003ff40fff] usable Mar 3 14:01:20.174466 kernel: BIOS-e820: [mem 0x000000003ff41000-0x000000003ffc8fff] reserved Mar 3 14:01:20.174476 kernel: BIOS-e820: [mem 0x000000003ffc9000-0x000000003fffafff] ACPI data Mar 3 14:01:20.174483 kernel: BIOS-e820: [mem 0x000000003fffb000-0x000000003fffefff] ACPI NVS Mar 3 14:01:20.174489 kernel: BIOS-e820: [mem 0x000000003ffff000-0x000000003fffffff] usable Mar 3 14:01:20.174496 kernel: BIOS-e820: [mem 0x0000000100000000-0x0000000fdfffffff] usable Mar 3 14:01:20.174503 kernel: BIOS-e820: [mem 0x0000004fe0000000-0x0000005cbfffffff] usable Mar 3 14:01:20.174509 kernel: printk: legacy bootconsole [earlyser0] enabled Mar 3 14:01:20.174516 kernel: NX (Execute Disable) protection: active Mar 3 14:01:20.174527 kernel: APIC: Static calls initialized Mar 3 14:01:20.174534 kernel: efi: EFI v2.7 by Microsoft Mar 3 14:01:20.174542 kernel: efi: ACPI=0x3fffa000 ACPI 2.0=0x3fffa014 SMBIOS=0x3ff85000 SMBIOS 3.0=0x3ff83000 MEMATTR=0x3f5bfa98 RNG=0x3ffd1018 Mar 3 14:01:20.174549 kernel: random: crng init done Mar 3 14:01:20.174557 kernel: secureboot: Secure boot disabled Mar 3 14:01:20.174564 kernel: SMBIOS 3.1.0 present. Mar 3 14:01:20.174572 kernel: DMI: Microsoft Corporation Virtual Machine/Virtual Machine, BIOS Hyper-V UEFI Release v4.1 03/08/2024 Mar 3 14:01:20.174579 kernel: DMI: Memory slots populated: 3/3 Mar 3 14:01:20.174586 kernel: Hypervisor detected: Microsoft Hyper-V Mar 3 14:01:20.174593 kernel: Hyper-V: privilege flags low 0x2e7f, high 0x3b8030, hints 0x62c2c, misc 0xed7b2 Mar 3 14:01:20.174615 kernel: Hyper-V: LAPIC Timer Frequency: 0x30d40 Mar 3 14:01:20.174623 kernel: Hyper-V: Using hypercall for remote TLB flush Mar 3 14:01:20.174631 kernel: clocksource: hyperv_clocksource_tsc_page: mask: 0xffffffffffffffff max_cycles: 0x24e6a1710, max_idle_ns: 440795202120 ns Mar 3 14:01:20.174638 kernel: clocksource: hyperv_clocksource_msr: mask: 0xffffffffffffffff max_cycles: 0x24e6a1710, max_idle_ns: 440795202120 ns Mar 3 14:01:20.174646 kernel: tsc: Marking TSC unstable due to running on Hyper-V Mar 3 14:01:20.174654 kernel: tsc: Detected 2593.993 MHz processor Mar 3 14:01:20.174662 kernel: e820: update [mem 0x00000000-0x00000fff] usable ==> reserved Mar 3 14:01:20.174670 kernel: e820: remove [mem 0x000a0000-0x000fffff] usable Mar 3 14:01:20.174677 kernel: last_pfn = 0x5cc0000 max_arch_pfn = 0x400000000 Mar 3 14:01:20.174688 kernel: MTRR map: 5 entries (2 fixed + 3 variable; max 18), built from 8 variable MTRRs Mar 3 14:01:20.174696 kernel: x86/PAT: Configuration [0-7]: WB WC UC- UC WB WP UC- WT Mar 3 14:01:20.174703 kernel: e820: update [mem 0x40000000-0xffffffff] usable ==> reserved Mar 3 14:01:20.174710 kernel: e820: update [mem 0x1100000000-0x4fdfffffff] usable ==> reserved Mar 3 14:01:20.174718 kernel: last_pfn = 0x40000 max_arch_pfn = 0x400000000 Mar 3 14:01:20.174725 kernel: Using GB pages for direct mapping Mar 3 14:01:20.174733 kernel: ACPI: Early table checksum verification disabled Mar 3 14:01:20.174744 kernel: ACPI: RSDP 0x000000003FFFA014 000024 (v02 VRTUAL) Mar 3 14:01:20.174755 kernel: ACPI: XSDT 0x000000003FFF90E8 000064 (v01 VRTUAL MICROSFT 00000001 MSFT 00000001) Mar 3 14:01:20.174763 kernel: ACPI: FACP 0x000000003FFF8000 000114 (v06 VRTUAL MICROSFT 00000001 MSFT 00000001) Mar 3 14:01:20.174771 kernel: ACPI: DSDT 0x000000003FFD6000 01E184 (v02 MSFTVM DSDT01 00000001 MSFT 05000000) Mar 3 14:01:20.174779 kernel: ACPI: FACS 0x000000003FFFE000 000040 Mar 3 14:01:20.174787 kernel: ACPI: OEM0 0x000000003FFF7000 000064 (v01 VRTUAL MICROSFT 00000001 MSFT 00000001) Mar 3 14:01:20.174795 kernel: ACPI: SPCR 0x000000003FFF6000 000050 (v02 VRTUAL MICROSFT 00000001 MSFT 00000001) Mar 3 14:01:20.174805 kernel: ACPI: WAET 0x000000003FFF5000 000028 (v01 VRTUAL MICROSFT 00000001 MSFT 00000001) Mar 3 14:01:20.174813 kernel: ACPI: APIC 0x000000003FFD5000 000078 (v04 VRTUAL MICROSFT 00000001 MSFT 00000001) Mar 3 14:01:20.174821 kernel: ACPI: SRAT 0x000000003FFD4000 0001D0 (v02 VRTUAL MICROSFT 00000001 MSFT 00000001) Mar 3 14:01:20.174832 kernel: ACPI: BGRT 0x000000003FFD3000 000038 (v01 VRTUAL MICROSFT 00000001 MSFT 00000001) Mar 3 14:01:20.174839 kernel: ACPI: FPDT 0x000000003FFD2000 000034 (v01 VRTUAL MICROSFT 00000001 MSFT 00000001) Mar 3 14:01:20.174847 kernel: ACPI: Reserving FACP table memory at [mem 0x3fff8000-0x3fff8113] Mar 3 14:01:20.174855 kernel: ACPI: Reserving DSDT table memory at [mem 0x3ffd6000-0x3fff4183] Mar 3 14:01:20.174863 kernel: ACPI: Reserving FACS table memory at [mem 0x3fffe000-0x3fffe03f] Mar 3 14:01:20.174871 kernel: ACPI: Reserving OEM0 table memory at [mem 0x3fff7000-0x3fff7063] Mar 3 14:01:20.174882 kernel: ACPI: Reserving SPCR table memory at [mem 0x3fff6000-0x3fff604f] Mar 3 14:01:20.174890 kernel: ACPI: Reserving WAET table memory at [mem 0x3fff5000-0x3fff5027] Mar 3 14:01:20.174898 kernel: ACPI: Reserving APIC table memory at [mem 0x3ffd5000-0x3ffd5077] Mar 3 14:01:20.174906 kernel: ACPI: Reserving SRAT table memory at [mem 0x3ffd4000-0x3ffd41cf] Mar 3 14:01:20.174914 kernel: ACPI: Reserving BGRT table memory at [mem 0x3ffd3000-0x3ffd3037] Mar 3 14:01:20.174922 kernel: ACPI: Reserving FPDT table memory at [mem 0x3ffd2000-0x3ffd2033] Mar 3 14:01:20.174930 kernel: ACPI: SRAT: Node 0 PXM 0 [mem 0x00000000-0x3fffffff] hotplug Mar 3 14:01:20.174938 kernel: ACPI: SRAT: Node 0 PXM 0 [mem 0x100000000-0xfdfffffff] hotplug Mar 3 14:01:20.174948 kernel: ACPI: SRAT: Node 0 PXM 0 [mem 0x4fe0000000-0x5cbfffffff] hotplug Mar 3 14:01:20.174956 kernel: ACPI: SRAT: Node 0 PXM 0 [mem 0x5cc0200000-0xffffffffff] hotplug Mar 3 14:01:20.174964 kernel: ACPI: SRAT: Node 0 PXM 0 [mem 0x10000200000-0x1ffffffffff] hotplug Mar 3 14:01:20.174972 kernel: ACPI: SRAT: Node 0 PXM 0 [mem 0x20000200000-0x3ffffffffff] hotplug Mar 3 14:01:20.174980 kernel: ACPI: SRAT: Node 0 PXM 0 [mem 0x40000200000-0x7ffffffffff] hotplug Mar 3 14:01:20.174988 kernel: ACPI: SRAT: Node 0 PXM 0 [mem 0x80000200000-0xfffffffffff] hotplug Mar 3 14:01:20.174996 kernel: NUMA: Node 0 [mem 0x00001000-0x3fffffff] + [mem 0x100000000-0xfdfffffff] -> [mem 0x00001000-0xfdfffffff] Mar 3 14:01:20.175004 kernel: NUMA: Node 0 [mem 0x00001000-0xfdfffffff] + [mem 0x4fe0000000-0x5cbfffffff] -> [mem 0x00001000-0x5cbfffffff] Mar 3 14:01:20.175012 kernel: NODE_DATA(0) allocated [mem 0x5cbfff7dc0-0x5cbfffefff] Mar 3 14:01:20.175022 kernel: Zone ranges: Mar 3 14:01:20.175030 kernel: DMA [mem 0x0000000000001000-0x0000000000ffffff] Mar 3 14:01:20.175038 kernel: DMA32 [mem 0x0000000001000000-0x00000000ffffffff] Mar 3 14:01:20.175046 kernel: Normal [mem 0x0000000100000000-0x0000005cbfffffff] Mar 3 14:01:20.175054 kernel: Device empty Mar 3 14:01:20.175062 kernel: Movable zone start for each node Mar 3 14:01:20.175069 kernel: Early memory node ranges Mar 3 14:01:20.175077 kernel: node 0: [mem 0x0000000000001000-0x000000000009ffff] Mar 3 14:01:20.175085 kernel: node 0: [mem 0x0000000000100000-0x000000003ff40fff] Mar 3 14:01:20.175095 kernel: node 0: [mem 0x000000003ffff000-0x000000003fffffff] Mar 3 14:01:20.175103 kernel: node 0: [mem 0x0000000100000000-0x0000000fdfffffff] Mar 3 14:01:20.175111 kernel: node 0: [mem 0x0000004fe0000000-0x0000005cbfffffff] Mar 3 14:01:20.175119 kernel: Initmem setup node 0 [mem 0x0000000000001000-0x0000005cbfffffff] Mar 3 14:01:20.175127 kernel: On node 0, zone DMA: 1 pages in unavailable ranges Mar 3 14:01:20.175135 kernel: On node 0, zone DMA: 96 pages in unavailable ranges Mar 3 14:01:20.175143 kernel: On node 0, zone DMA32: 190 pages in unavailable ranges Mar 3 14:01:20.175151 kernel: ACPI: PM-Timer IO Port: 0x408 Mar 3 14:01:20.175159 kernel: ACPI: LAPIC_NMI (acpi_id[0x01] dfl dfl lint[0x1]) Mar 3 14:01:20.175169 kernel: IOAPIC[0]: apic_id 6, version 17, address 0xfec00000, GSI 0-23 Mar 3 14:01:20.175177 kernel: ACPI: INT_SRC_OVR (bus 0 bus_irq 9 global_irq 9 high level) Mar 3 14:01:20.175185 kernel: ACPI: Using ACPI (MADT) for SMP configuration information Mar 3 14:01:20.175193 kernel: ACPI: SPCR: console: uart,io,0x3f8,115200 Mar 3 14:01:20.175201 kernel: CPU topo: Max. logical packages: 1 Mar 3 14:01:20.175209 kernel: CPU topo: Max. logical dies: 1 Mar 3 14:01:20.175217 kernel: CPU topo: Max. dies per package: 1 Mar 3 14:01:20.175225 kernel: CPU topo: Max. threads per core: 1 Mar 3 14:01:20.175233 kernel: CPU topo: Num. cores per package: 6 Mar 3 14:01:20.175243 kernel: CPU topo: Num. threads per package: 6 Mar 3 14:01:20.175251 kernel: CPU topo: Allowing 6 present CPUs plus 0 hotplug CPUs Mar 3 14:01:20.175259 kernel: [mem 0x40000000-0xffffffff] available for PCI devices Mar 3 14:01:20.175267 kernel: Booting paravirtualized kernel on Hyper-V Mar 3 14:01:20.175275 kernel: clocksource: refined-jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1910969940391419 ns Mar 3 14:01:20.175283 kernel: setup_percpu: NR_CPUS:512 nr_cpumask_bits:6 nr_cpu_ids:6 nr_node_ids:1 Mar 3 14:01:20.175291 kernel: percpu: Embedded 60 pages/cpu s207832 r8192 d29736 u262144 Mar 3 14:01:20.175299 kernel: pcpu-alloc: s207832 r8192 d29736 u262144 alloc=1*2097152 Mar 3 14:01:20.175306 kernel: pcpu-alloc: [0] 0 1 2 3 4 5 - - Mar 3 14:01:20.175316 kernel: Hyper-V: PV spinlocks enabled Mar 3 14:01:20.175324 kernel: PV qspinlock hash table entries: 256 (order: 0, 4096 bytes, linear) Mar 3 14:01:20.175333 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=51ade538e3d3c371f07ae1ec6fa9803fff0566ec060cf4b56dc685fc36d0e01c Mar 3 14:01:20.175342 kernel: Dentry cache hash table entries: 8388608 (order: 14, 67108864 bytes, linear) Mar 3 14:01:20.175350 kernel: Inode-cache hash table entries: 4194304 (order: 13, 33554432 bytes, linear) Mar 3 14:01:20.175358 kernel: Fallback order for Node 0: 0 Mar 3 14:01:20.175366 kernel: Built 1 zonelists, mobility grouping on. Total pages: 29359841 Mar 3 14:01:20.175374 kernel: Policy zone: Normal Mar 3 14:01:20.175384 kernel: mem auto-init: stack:off, heap alloc:off, heap free:off Mar 3 14:01:20.175400 kernel: software IO TLB: area num 8. Mar 3 14:01:20.175409 kernel: SLUB: HWalign=64, Order=0-3, MinObjects=0, CPUs=6, Nodes=1 Mar 3 14:01:20.175420 kernel: Kernel/User page tables isolation: enabled Mar 3 14:01:20.175428 kernel: ftrace: allocating 40099 entries in 157 pages Mar 3 14:01:20.175436 kernel: ftrace: allocated 157 pages with 5 groups Mar 3 14:01:20.175445 kernel: Dynamic Preempt: voluntary Mar 3 14:01:20.175453 kernel: rcu: Preemptible hierarchical RCU implementation. Mar 3 14:01:20.175465 kernel: rcu: RCU event tracing is enabled. Mar 3 14:01:20.175474 kernel: rcu: RCU restricting CPUs from NR_CPUS=512 to nr_cpu_ids=6. Mar 3 14:01:20.175483 kernel: Trampoline variant of Tasks RCU enabled. Mar 3 14:01:20.175494 kernel: Rude variant of Tasks RCU enabled. Mar 3 14:01:20.175503 kernel: Tracing variant of Tasks RCU enabled. Mar 3 14:01:20.175511 kernel: rcu: RCU calculated value of scheduler-enlistment delay is 100 jiffies. Mar 3 14:01:20.175520 kernel: rcu: Adjusting geometry for rcu_fanout_leaf=16, nr_cpu_ids=6 Mar 3 14:01:20.175529 kernel: RCU Tasks: Setting shift to 3 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=6. Mar 3 14:01:20.175537 kernel: RCU Tasks Rude: Setting shift to 3 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=6. Mar 3 14:01:20.175548 kernel: RCU Tasks Trace: Setting shift to 3 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=6. Mar 3 14:01:20.175556 kernel: Using NULL legacy PIC Mar 3 14:01:20.175565 kernel: NR_IRQS: 33024, nr_irqs: 472, preallocated irqs: 0 Mar 3 14:01:20.175573 kernel: rcu: srcu_init: Setting srcu_struct sizes based on contention. Mar 3 14:01:20.175582 kernel: Console: colour dummy device 80x25 Mar 3 14:01:20.175590 kernel: printk: legacy console [tty1] enabled Mar 3 14:01:20.175598 kernel: printk: legacy console [ttyS0] enabled Mar 3 14:01:20.175619 kernel: printk: legacy bootconsole [earlyser0] disabled Mar 3 14:01:20.175628 kernel: ACPI: Core revision 20240827 Mar 3 14:01:20.175639 kernel: Failed to register legacy timer interrupt Mar 3 14:01:20.175648 kernel: APIC: Switch to symmetric I/O mode setup Mar 3 14:01:20.175656 kernel: Hyper-V: Host Build 10.0.20348.1969-1-0 Mar 3 14:01:20.175665 kernel: Hyper-V: enabling crash_kexec_post_notifiers Mar 3 14:01:20.175673 kernel: Hyper-V: Using IPI hypercalls Mar 3 14:01:20.175681 kernel: APIC: send_IPI() replaced with hv_send_ipi() Mar 3 14:01:20.175690 kernel: APIC: send_IPI_mask() replaced with hv_send_ipi_mask() Mar 3 14:01:20.175698 kernel: APIC: send_IPI_mask_allbutself() replaced with hv_send_ipi_mask_allbutself() Mar 3 14:01:20.175707 kernel: APIC: send_IPI_allbutself() replaced with hv_send_ipi_allbutself() Mar 3 14:01:20.175718 kernel: APIC: send_IPI_all() replaced with hv_send_ipi_all() Mar 3 14:01:20.175726 kernel: APIC: send_IPI_self() replaced with hv_send_ipi_self() Mar 3 14:01:20.175734 kernel: Hyper-V: Using enlightened APIC (xapic mode) Mar 3 14:01:20.175743 kernel: APIC: eoi() replaced with hv_apic_eoi_write() Mar 3 14:01:20.175751 kernel: APIC: read() replaced with hv_apic_read() Mar 3 14:01:20.175759 kernel: APIC: write() replaced with hv_apic_write() Mar 3 14:01:20.175768 kernel: APIC: icr_write() replaced with hv_apic_icr_write() Mar 3 14:01:20.175776 kernel: APIC: icr_read() replaced with hv_apic_icr_read() Mar 3 14:01:20.175785 kernel: Calibrating delay loop (skipped), value calculated using timer frequency.. 5187.98 BogoMIPS (lpj=2593993) Mar 3 14:01:20.175796 kernel: Last level iTLB entries: 4KB 128, 2MB 8, 4MB 8 Mar 3 14:01:20.175804 kernel: Last level dTLB entries: 4KB 64, 2MB 32, 4MB 32, 1GB 4 Mar 3 14:01:20.175813 kernel: Spectre V1 : Mitigation: usercopy/swapgs barriers and __user pointer sanitization Mar 3 14:01:20.175821 kernel: Spectre V2 : Mitigation: Retpolines Mar 3 14:01:20.175829 kernel: Spectre V2 : Spectre v2 / SpectreRSB: Filling RSB on context switch and VMEXIT Mar 3 14:01:20.175837 kernel: Speculative Store Bypass: Vulnerable Mar 3 14:01:20.175846 kernel: MDS: Mitigation: Clear CPU buffers Mar 3 14:01:20.175854 kernel: TAA: Mitigation: Clear CPU buffers Mar 3 14:01:20.175862 kernel: MMIO Stale Data: Vulnerable: Clear CPU buffers attempted, no microcode Mar 3 14:01:20.175870 kernel: active return thunk: its_return_thunk Mar 3 14:01:20.175878 kernel: ITS: Mitigation: Aligned branch/return thunks Mar 3 14:01:20.175889 kernel: x86/fpu: Supporting XSAVE feature 0x001: 'x87 floating point registers' Mar 3 14:01:20.175897 kernel: x86/fpu: Supporting XSAVE feature 0x002: 'SSE registers' Mar 3 14:01:20.175905 kernel: x86/fpu: Supporting XSAVE feature 0x004: 'AVX registers' Mar 3 14:01:20.175914 kernel: x86/fpu: xstate_offset[2]: 576, xstate_sizes[2]: 256 Mar 3 14:01:20.175922 kernel: x86/fpu: Enabled xstate features 0x7, context size is 832 bytes, using 'standard' format. Mar 3 14:01:20.175930 kernel: Freeing SMP alternatives memory: 32K Mar 3 14:01:20.175939 kernel: pid_max: default: 32768 minimum: 301 Mar 3 14:01:20.175947 kernel: LSM: initializing lsm=lockdown,capability,landlock,selinux,ima Mar 3 14:01:20.175955 kernel: landlock: Up and running. Mar 3 14:01:20.175963 kernel: SELinux: Initializing. Mar 3 14:01:20.175971 kernel: Mount-cache hash table entries: 131072 (order: 8, 1048576 bytes, linear) Mar 3 14:01:20.175982 kernel: Mountpoint-cache hash table entries: 131072 (order: 8, 1048576 bytes, linear) Mar 3 14:01:20.175991 kernel: smpboot: CPU0: Intel(R) Xeon(R) CPU E5-2690 v4 @ 2.60GHz (family: 0x6, model: 0x4f, stepping: 0x1) Mar 3 14:01:20.175999 kernel: Performance Events: unsupported p6 CPU model 79 no PMU driver, software events only. Mar 3 14:01:20.176008 kernel: signal: max sigframe size: 1776 Mar 3 14:01:20.176016 kernel: rcu: Hierarchical SRCU implementation. Mar 3 14:01:20.176025 kernel: rcu: Max phase no-delay instances is 400. Mar 3 14:01:20.176033 kernel: Timer migration: 1 hierarchy levels; 8 children per group; 1 crossnode level Mar 3 14:01:20.176042 kernel: NMI watchdog: Perf NMI watchdog permanently disabled Mar 3 14:01:20.176050 kernel: smp: Bringing up secondary CPUs ... Mar 3 14:01:20.176061 kernel: smpboot: x86: Booting SMP configuration: Mar 3 14:01:20.176069 kernel: .... node #0, CPUs: #1 #2 #3 #4 #5 Mar 3 14:01:20.176077 kernel: smp: Brought up 1 node, 6 CPUs Mar 3 14:01:20.176086 kernel: smpboot: Total of 6 processors activated (31127.91 BogoMIPS) Mar 3 14:01:20.176094 kernel: Memory: 115330896K/117439364K available (14336K kernel code, 2445K rwdata, 26064K rodata, 46200K init, 2560K bss, 2098192K reserved, 0K cma-reserved) Mar 3 14:01:20.176103 kernel: devtmpfs: initialized Mar 3 14:01:20.176111 kernel: x86/mm: Memory block size: 1024MB Mar 3 14:01:20.176120 kernel: ACPI: PM: Registering ACPI NVS region [mem 0x3fffb000-0x3fffefff] (16384 bytes) Mar 3 14:01:20.176128 kernel: clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1911260446275000 ns Mar 3 14:01:20.176139 kernel: futex hash table entries: 2048 (order: 5, 131072 bytes, linear) Mar 3 14:01:20.176148 kernel: pinctrl core: initialized pinctrl subsystem Mar 3 14:01:20.176156 kernel: NET: Registered PF_NETLINK/PF_ROUTE protocol family Mar 3 14:01:20.176164 kernel: audit: initializing netlink subsys (disabled) Mar 3 14:01:20.176173 kernel: audit: type=2000 audit(1772546476.028:1): state=initialized audit_enabled=0 res=1 Mar 3 14:01:20.176181 kernel: thermal_sys: Registered thermal governor 'step_wise' Mar 3 14:01:20.176190 kernel: thermal_sys: Registered thermal governor 'user_space' Mar 3 14:01:20.176198 kernel: cpuidle: using governor menu Mar 3 14:01:20.176206 kernel: acpiphp: ACPI Hot Plug PCI Controller Driver version: 0.5 Mar 3 14:01:20.176217 kernel: dca service started, version 1.12.1 Mar 3 14:01:20.176226 kernel: e820: reserve RAM buffer [mem 0x3ff41000-0x3fffffff] Mar 3 14:01:20.176234 kernel: kprobes: kprobe jump-optimization is enabled. All kprobes are optimized if possible. Mar 3 14:01:20.176242 kernel: HugeTLB: registered 1.00 GiB page size, pre-allocated 0 pages Mar 3 14:01:20.176251 kernel: HugeTLB: 16380 KiB vmemmap can be freed for a 1.00 GiB page Mar 3 14:01:20.176259 kernel: HugeTLB: registered 2.00 MiB page size, pre-allocated 0 pages Mar 3 14:01:20.176268 kernel: HugeTLB: 28 KiB vmemmap can be freed for a 2.00 MiB page Mar 3 14:01:20.176276 kernel: ACPI: Added _OSI(Module Device) Mar 3 14:01:20.176284 kernel: ACPI: Added _OSI(Processor Device) Mar 3 14:01:20.176295 kernel: ACPI: Added _OSI(Processor Aggregator Device) Mar 3 14:01:20.176303 kernel: ACPI: 1 ACPI AML tables successfully acquired and loaded Mar 3 14:01:20.176312 kernel: ACPI: Interpreter enabled Mar 3 14:01:20.176320 kernel: ACPI: PM: (supports S0 S5) Mar 3 14:01:20.176328 kernel: ACPI: Using IOAPIC for interrupt routing Mar 3 14:01:20.176337 kernel: PCI: Using host bridge windows from ACPI; if necessary, use "pci=nocrs" and report a bug Mar 3 14:01:20.176345 kernel: PCI: Ignoring E820 reservations for host bridge windows Mar 3 14:01:20.176354 kernel: ACPI: Enabled 1 GPEs in block 00 to 0F Mar 3 14:01:20.176362 kernel: iommu: Default domain type: Translated Mar 3 14:01:20.176373 kernel: iommu: DMA domain TLB invalidation policy: lazy mode Mar 3 14:01:20.176381 kernel: efivars: Registered efivars operations Mar 3 14:01:20.176390 kernel: PCI: Using ACPI for IRQ routing Mar 3 14:01:20.176398 kernel: PCI: System does not support PCI Mar 3 14:01:20.176407 kernel: vgaarb: loaded Mar 3 14:01:20.176415 kernel: clocksource: Switched to clocksource hyperv_clocksource_tsc_page Mar 3 14:01:20.176423 kernel: VFS: Disk quotas dquot_6.6.0 Mar 3 14:01:20.176431 kernel: VFS: Dquot-cache hash table entries: 512 (order 0, 4096 bytes) Mar 3 14:01:20.176440 kernel: pnp: PnP ACPI init Mar 3 14:01:20.176451 kernel: pnp: PnP ACPI: found 3 devices Mar 3 14:01:20.176459 kernel: clocksource: acpi_pm: mask: 0xffffff max_cycles: 0xffffff, max_idle_ns: 2085701024 ns Mar 3 14:01:20.176468 kernel: NET: Registered PF_INET protocol family Mar 3 14:01:20.176476 kernel: IP idents hash table entries: 262144 (order: 9, 2097152 bytes, linear) Mar 3 14:01:20.176485 kernel: tcp_listen_portaddr_hash hash table entries: 65536 (order: 8, 1048576 bytes, linear) Mar 3 14:01:20.176493 kernel: Table-perturb hash table entries: 65536 (order: 6, 262144 bytes, linear) Mar 3 14:01:20.176502 kernel: TCP established hash table entries: 524288 (order: 10, 4194304 bytes, linear) Mar 3 14:01:20.176510 kernel: TCP bind hash table entries: 65536 (order: 9, 2097152 bytes, linear) Mar 3 14:01:20.176519 kernel: TCP: Hash tables configured (established 524288 bind 65536) Mar 3 14:01:20.176529 kernel: UDP hash table entries: 65536 (order: 9, 2097152 bytes, linear) Mar 3 14:01:20.176538 kernel: UDP-Lite hash table entries: 65536 (order: 9, 2097152 bytes, linear) Mar 3 14:01:20.176546 kernel: NET: Registered PF_UNIX/PF_LOCAL protocol family Mar 3 14:01:20.176554 kernel: NET: Registered PF_XDP protocol family Mar 3 14:01:20.176563 kernel: PCI: CLS 0 bytes, default 64 Mar 3 14:01:20.176571 kernel: PCI-DMA: Using software bounce buffering for IO (SWIOTLB) Mar 3 14:01:20.176580 kernel: software IO TLB: mapped [mem 0x000000003b5bf000-0x000000003f5bf000] (64MB) Mar 3 14:01:20.176588 kernel: RAPL PMU: API unit is 2^-32 Joules, 0 fixed counters, 10737418240 ms ovfl timer Mar 3 14:01:20.176597 kernel: Initialise system trusted keyrings Mar 3 14:01:20.176616 kernel: workingset: timestamp_bits=39 max_order=25 bucket_order=0 Mar 3 14:01:20.176624 kernel: Key type asymmetric registered Mar 3 14:01:20.176633 kernel: Asymmetric key parser 'x509' registered Mar 3 14:01:20.176641 kernel: Block layer SCSI generic (bsg) driver version 0.4 loaded (major 250) Mar 3 14:01:20.176649 kernel: io scheduler mq-deadline registered Mar 3 14:01:20.176658 kernel: io scheduler kyber registered Mar 3 14:01:20.176666 kernel: io scheduler bfq registered Mar 3 14:01:20.176674 kernel: ioatdma: Intel(R) QuickData Technology Driver 5.00 Mar 3 14:01:20.176683 kernel: Serial: 8250/16550 driver, 4 ports, IRQ sharing enabled Mar 3 14:01:20.176694 kernel: 00:00: ttyS0 at I/O 0x3f8 (irq = 4, base_baud = 115200) is a 16550A Mar 3 14:01:20.176702 kernel: 00:01: ttyS1 at I/O 0x2f8 (irq = 3, base_baud = 115200) is a 16550A Mar 3 14:01:20.176711 kernel: i8042: PNP: No PS/2 controller found. Mar 3 14:01:20.176858 kernel: rtc_cmos 00:02: registered as rtc0 Mar 3 14:01:20.176959 kernel: rtc_cmos 00:02: setting system clock to 2026-03-03T14:01:19 UTC (1772546479) Mar 3 14:01:20.177052 kernel: rtc_cmos 00:02: alarms up to one month, 114 bytes nvram Mar 3 14:01:20.177065 kernel: intel_pstate: CPU model not supported Mar 3 14:01:20.177077 kernel: efifb: probing for efifb Mar 3 14:01:20.177086 kernel: efifb: framebuffer at 0x40000000, using 3072k, total 3072k Mar 3 14:01:20.177094 kernel: efifb: mode is 1024x768x32, linelength=4096, pages=1 Mar 3 14:01:20.177103 kernel: efifb: scrolling: redraw Mar 3 14:01:20.177111 kernel: efifb: Truecolor: size=8:8:8:8, shift=24:16:8:0 Mar 3 14:01:20.177119 kernel: Console: switching to colour frame buffer device 128x48 Mar 3 14:01:20.177128 kernel: fb0: EFI VGA frame buffer device Mar 3 14:01:20.177136 kernel: pstore: Using crash dump compression: deflate Mar 3 14:01:20.177145 kernel: pstore: Registered efi_pstore as persistent store backend Mar 3 14:01:20.177155 kernel: NET: Registered PF_INET6 protocol family Mar 3 14:01:20.177164 kernel: Segment Routing with IPv6 Mar 3 14:01:20.177172 kernel: In-situ OAM (IOAM) with IPv6 Mar 3 14:01:20.177180 kernel: NET: Registered PF_PACKET protocol family Mar 3 14:01:20.177189 kernel: Key type dns_resolver registered Mar 3 14:01:20.177197 kernel: IPI shorthand broadcast: enabled Mar 3 14:01:20.177205 kernel: sched_clock: Marking stable (3585004500, 106662300)->(4033488200, -341821400) Mar 3 14:01:20.177214 kernel: registered taskstats version 1 Mar 3 14:01:20.177222 kernel: Loading compiled-in X.509 certificates Mar 3 14:01:20.177231 kernel: Loaded X.509 cert 'Kinvolk GmbH: Module signing key for 6.12.74-flatcar: bf135b2a3d3664cc6742f4e1848867384c1e52f1' Mar 3 14:01:20.177241 kernel: Demotion targets for Node 0: null Mar 3 14:01:20.177250 kernel: Key type .fscrypt registered Mar 3 14:01:20.177258 kernel: Key type fscrypt-provisioning registered Mar 3 14:01:20.177266 kernel: ima: No TPM chip found, activating TPM-bypass! Mar 3 14:01:20.177274 kernel: ima: Allocated hash algorithm: sha1 Mar 3 14:01:20.177283 kernel: ima: No architecture policies found Mar 3 14:01:20.177291 kernel: clk: Disabling unused clocks Mar 3 14:01:20.177299 kernel: Warning: unable to open an initial console. Mar 3 14:01:20.177308 kernel: Freeing unused kernel image (initmem) memory: 46200K Mar 3 14:01:20.177319 kernel: Write protecting the kernel read-only data: 40960k Mar 3 14:01:20.177327 kernel: Freeing unused kernel image (rodata/data gap) memory: 560K Mar 3 14:01:20.177336 kernel: Run /init as init process Mar 3 14:01:20.177344 kernel: with arguments: Mar 3 14:01:20.177352 kernel: /init Mar 3 14:01:20.177361 kernel: with environment: Mar 3 14:01:20.177369 kernel: HOME=/ Mar 3 14:01:20.177377 kernel: TERM=linux Mar 3 14:01:20.177387 systemd[1]: Successfully made /usr/ read-only. Mar 3 14:01:20.177400 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 3 14:01:20.177410 systemd[1]: Detected virtualization microsoft. Mar 3 14:01:20.177419 systemd[1]: Detected architecture x86-64. Mar 3 14:01:20.177427 systemd[1]: Running in initrd. Mar 3 14:01:20.177436 systemd[1]: No hostname configured, using default hostname. Mar 3 14:01:20.177445 systemd[1]: Hostname set to . Mar 3 14:01:20.177454 systemd[1]: Initializing machine ID from random generator. Mar 3 14:01:20.177465 systemd[1]: Queued start job for default target initrd.target. Mar 3 14:01:20.177474 systemd[1]: Started clevis-luks-askpass.path - Forward Password Requests to Clevis Directory Watch. Mar 3 14:01:20.177483 systemd[1]: Started systemd-ask-password-console.path - Dispatch Password Requests to Console Directory Watch. Mar 3 14:01:20.177492 systemd[1]: Expecting device dev-disk-by\x2dlabel-EFI\x2dSYSTEM.device - /dev/disk/by-label/EFI-SYSTEM... Mar 3 14:01:20.177501 systemd[1]: Expecting device dev-disk-by\x2dlabel-OEM.device - /dev/disk/by-label/OEM... Mar 3 14:01:20.177511 systemd[1]: Expecting device dev-disk-by\x2dlabel-ROOT.device - /dev/disk/by-label/ROOT... Mar 3 14:01:20.177520 systemd[1]: Expecting device dev-disk-by\x2dpartlabel-USR\x2dA.device - /dev/disk/by-partlabel/USR-A... Mar 3 14:01:20.177533 systemd[1]: Expecting device dev-disk-by\x2dpartuuid-7130c94a\x2d213a\x2d4e5a\x2d8e26\x2d6cce9662f132.device - /dev/disk/by-partuuid/7130c94a-213a-4e5a-8e26-6cce9662f132... Mar 3 14:01:20.177542 systemd[1]: Expecting device dev-mapper-usr.device - /dev/mapper/usr... Mar 3 14:01:20.177551 systemd[1]: Reached target cryptsetup-pre.target - Local Encrypted Volumes (Pre). Mar 3 14:01:20.177560 systemd[1]: Reached target cryptsetup.target - Local Encrypted Volumes. Mar 3 14:01:20.177569 systemd[1]: Reached target paths.target - Path Units. Mar 3 14:01:20.177578 systemd[1]: Reached target slices.target - Slice Units. Mar 3 14:01:20.177587 systemd[1]: Reached target swap.target - Swaps. Mar 3 14:01:20.177595 systemd[1]: Reached target timers.target - Timer Units. Mar 3 14:01:20.177656 systemd[1]: Listening on iscsid.socket - Open-iSCSI iscsid Socket. Mar 3 14:01:20.177666 systemd[1]: Listening on iscsiuio.socket - Open-iSCSI iscsiuio Socket. Mar 3 14:01:20.177675 systemd[1]: Listening on systemd-journald-dev-log.socket - Journal Socket (/dev/log). Mar 3 14:01:20.177684 systemd[1]: Listening on systemd-journald.socket - Journal Sockets. Mar 3 14:01:20.177693 systemd[1]: Listening on systemd-networkd.socket - Network Service Netlink Socket. Mar 3 14:01:20.177702 systemd[1]: Listening on systemd-udevd-control.socket - udev Control Socket. Mar 3 14:01:20.177711 systemd[1]: Listening on systemd-udevd-kernel.socket - udev Kernel Socket. Mar 3 14:01:20.177720 systemd[1]: Reached target sockets.target - Socket Units. Mar 3 14:01:20.177729 systemd[1]: Starting ignition-setup-pre.service - Ignition env setup... Mar 3 14:01:20.177742 systemd[1]: Starting kmod-static-nodes.service - Create List of Static Device Nodes... Mar 3 14:01:20.177751 systemd[1]: Finished network-cleanup.service - Network Cleanup. Mar 3 14:01:20.177760 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 3 14:01:20.177769 systemd[1]: Starting systemd-fsck-usr.service... Mar 3 14:01:20.177778 systemd[1]: Starting systemd-journald.service - Journal Service... Mar 3 14:01:20.177787 systemd[1]: Starting systemd-modules-load.service - Load Kernel Modules... Mar 3 14:01:20.177816 systemd-journald[214]: Collecting audit messages is disabled. Mar 3 14:01:20.177842 systemd-journald[214]: Journal started Mar 3 14:01:20.177862 systemd-journald[214]: Runtime Journal (/run/log/journal/9ce92132d7f340ddbd48fa1429012680) is 8M, max 2.2G, 2.1G free. Mar 3 14:01:20.193061 systemd[1]: Starting systemd-vconsole-setup.service - Virtual Console Setup... Mar 3 14:01:20.202090 systemd[1]: Started systemd-journald.service - Journal Service. Mar 3 14:01:20.203162 systemd[1]: Finished ignition-setup-pre.service - Ignition env setup. Mar 3 14:01:20.204447 systemd[1]: Finished kmod-static-nodes.service - Create List of Static Device Nodes. Mar 3 14:01:20.205114 systemd[1]: Finished systemd-fsck-usr.service. Mar 3 14:01:20.230074 systemd-modules-load[216]: Inserted module 'overlay' Mar 3 14:01:20.230677 systemd[1]: Starting systemd-tmpfiles-setup-dev-early.service - Create Static Device Nodes in /dev gracefully... Mar 3 14:01:20.232345 systemd[1]: Starting systemd-tmpfiles-setup.service - Create System Files and Directories... Mar 3 14:01:20.257237 systemd-tmpfiles[225]: /usr/lib/tmpfiles.d/var.conf:14: Duplicate line for path "/var/log", ignoring. Mar 3 14:01:20.258276 systemd[1]: Finished systemd-tmpfiles-setup-dev-early.service - Create Static Device Nodes in /dev gracefully. Mar 3 14:01:20.259938 systemd[1]: Starting systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev... Mar 3 14:01:20.261089 systemd[1]: Finished systemd-tmpfiles-setup.service - Create System Files and Directories. Mar 3 14:01:20.293654 systemd[1]: Finished systemd-vconsole-setup.service - Virtual Console Setup. Mar 3 14:01:20.302813 systemd[1]: Finished systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev. Mar 3 14:01:20.308990 systemd[1]: Starting dracut-cmdline-ask.service - dracut ask for additional cmdline parameters... Mar 3 14:01:20.337620 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 3 14:01:20.341326 systemd-modules-load[216]: Inserted module 'br_netfilter' Mar 3 14:01:20.344825 kernel: Bridge firewalling registered Mar 3 14:01:20.347756 systemd[1]: Finished systemd-modules-load.service - Load Kernel Modules. Mar 3 14:01:20.349336 systemd[1]: Starting systemd-sysctl.service - Apply Kernel Variables... Mar 3 14:01:20.369239 systemd[1]: Finished dracut-cmdline-ask.service - dracut ask for additional cmdline parameters. Mar 3 14:01:20.370925 systemd[1]: Finished systemd-sysctl.service - Apply Kernel Variables. Mar 3 14:01:20.381381 systemd[1]: Starting dracut-cmdline.service - dracut cmdline hook... Mar 3 14:01:20.389747 systemd[1]: Starting systemd-resolved.service - Network Name Resolution... Mar 3 14:01:20.408312 dracut-cmdline[255]: 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=51ade538e3d3c371f07ae1ec6fa9803fff0566ec060cf4b56dc685fc36d0e01c Mar 3 14:01:20.430349 systemd-resolved[256]: Positive Trust Anchors: Mar 3 14:01:20.430359 systemd-resolved[256]: . IN DS 20326 8 2 e06d44b80b8f1d39a95c0b0d7c65d08458e880409bbc683457104237c7f8ec8d Mar 3 14:01:20.430389 systemd-resolved[256]: 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 3 14:01:20.432835 systemd-resolved[256]: Defaulting to hostname 'linux'. Mar 3 14:01:20.433827 systemd[1]: Started systemd-resolved.service - Network Name Resolution. Mar 3 14:01:20.439786 systemd[1]: Reached target nss-lookup.target - Host and Network Name Lookups. Mar 3 14:01:20.569629 kernel: SCSI subsystem initialized Mar 3 14:01:20.581650 kernel: Loading iSCSI transport class v2.0-870. Mar 3 14:01:20.593625 kernel: iscsi: registered transport (tcp) Mar 3 14:01:20.617740 kernel: iscsi: registered transport (qla4xxx) Mar 3 14:01:20.617768 kernel: QLogic iSCSI HBA Driver Mar 3 14:01:20.636134 systemd[1]: Starting systemd-network-generator.service - Generate network units from Kernel command line... Mar 3 14:01:20.669050 systemd[1]: Finished systemd-network-generator.service - Generate network units from Kernel command line. Mar 3 14:01:20.671433 systemd[1]: Reached target network-pre.target - Preparation for Network. Mar 3 14:01:20.727299 systemd[1]: Finished dracut-cmdline.service - dracut cmdline hook. Mar 3 14:01:20.730058 systemd[1]: Starting dracut-pre-udev.service - dracut pre-udev hook... Mar 3 14:01:20.796618 kernel: raid6: avx2x4 gen() 30791 MB/s Mar 3 14:01:20.815621 kernel: raid6: avx2x2 gen() 31063 MB/s Mar 3 14:01:20.836621 kernel: raid6: avx2x1 gen() 28032 MB/s Mar 3 14:01:20.836649 kernel: raid6: using algorithm avx2x2 gen() 31063 MB/s Mar 3 14:01:20.859660 kernel: raid6: .... xor() 18348 MB/s, rmw enabled Mar 3 14:01:20.859685 kernel: raid6: using avx2x2 recovery algorithm Mar 3 14:01:20.881624 kernel: xor: automatically using best checksumming function avx Mar 3 14:01:21.052642 kernel: Btrfs loaded, zoned=no, fsverity=no Mar 3 14:01:21.059616 systemd[1]: Finished dracut-pre-udev.service - dracut pre-udev hook. Mar 3 14:01:21.062697 systemd[1]: Starting systemd-udevd.service - Rule-based Manager for Device Events and Files... Mar 3 14:01:21.098394 systemd-udevd[465]: Using default interface naming scheme 'v255'. Mar 3 14:01:21.104594 systemd[1]: Started systemd-udevd.service - Rule-based Manager for Device Events and Files. Mar 3 14:01:21.106972 systemd[1]: Starting dracut-pre-trigger.service - dracut pre-trigger hook... Mar 3 14:01:21.146366 dracut-pre-trigger[472]: rd.md=0: removing MD RAID activation Mar 3 14:01:21.171063 systemd[1]: Finished dracut-pre-trigger.service - dracut pre-trigger hook. Mar 3 14:01:21.176423 systemd[1]: Starting systemd-udev-trigger.service - Coldplug All udev Devices... Mar 3 14:01:21.252818 systemd[1]: Finished systemd-udev-trigger.service - Coldplug All udev Devices. Mar 3 14:01:21.266534 systemd[1]: Starting dracut-initqueue.service - dracut initqueue hook... Mar 3 14:01:21.281624 kernel: cryptd: max_cpu_qlen set to 1000 Mar 3 14:01:21.295851 kernel: AES CTR mode by8 optimization enabled Mar 3 14:01:21.295884 kernel: hv_vmbus: Vmbus version:4.0 Mar 3 14:01:21.312686 systemd[1]: systemd-vconsole-setup.service: Deactivated successfully. Mar 3 14:01:21.328185 kernel: pps_core: LinuxPPS API ver. 1 registered Mar 3 14:01:21.328207 kernel: pps_core: Software ver. 5.3.6 - Copyright 2005-2007 Rodolfo Giometti Mar 3 14:01:21.328220 kernel: hv_vmbus: registering driver hyperv_keyboard Mar 3 14:01:21.312752 systemd[1]: Stopped systemd-vconsole-setup.service - Virtual Console Setup. Mar 3 14:01:21.347759 kernel: hv_vmbus: registering driver hv_netvsc Mar 3 14:01:21.347783 kernel: input: AT Translated Set 2 keyboard as /devices/LNXSYSTM:00/LNXSYBUS:00/ACPI0004:00/VMBUS:00/d34b2567-b9b6-42b9-8778-0a4ec0b955bf/serio0/input/input0 Mar 3 14:01:21.324826 systemd[1]: Stopping systemd-vconsole-setup.service - Virtual Console Setup... Mar 3 14:01:21.342907 systemd[1]: Starting systemd-vconsole-setup.service - Virtual Console Setup... Mar 3 14:01:21.349291 systemd[1]: run-credentials-systemd\x2dvconsole\x2dsetup.service.mount: Deactivated successfully. Mar 3 14:01:21.363044 systemd[1]: systemd-vconsole-setup.service: Deactivated successfully. Mar 3 14:01:21.382843 kernel: PTP clock support registered Mar 3 14:01:21.382867 kernel: hv_vmbus: registering driver hv_pci Mar 3 14:01:21.382880 kernel: hv_pci 47505500-0001-0000-3130-444531444234: PCI VMBus probing: Using version 0x10004 Mar 3 14:01:21.383053 kernel: hv_pci 47505500-0001-0000-3130-444531444234: PCI host bridge to bus 0001:00 Mar 3 14:01:21.383193 kernel: pci_bus 0001:00: root bus resource [mem 0x41000000-0x41ffffff window] Mar 3 14:01:21.363152 systemd[1]: Stopped systemd-vconsole-setup.service - Virtual Console Setup. Mar 3 14:01:21.419145 kernel: pci_bus 0001:00: root bus resource [mem 0x1000000000-0x1401ffffff window] Mar 3 14:01:21.419306 kernel: pci_bus 0001:00: No busn resource found for root bus, will use [bus 00-ff] Mar 3 14:01:21.419433 kernel: pci 0001:00:00.0: [10de:1db4] type 00 class 0x030200 PCIe Endpoint Mar 3 14:01:21.419462 kernel: hid: raw HID events driver (C) Jiri Kosina Mar 3 14:01:21.419474 kernel: pci 0001:00:00.0: BAR 0 [mem 0x41000000-0x41ffffff] Mar 3 14:01:21.419491 kernel: pci 0001:00:00.0: BAR 1 [mem 0x1000000000-0x13ffffffff 64bit pref] Mar 3 14:01:21.419511 kernel: pci 0001:00:00.0: BAR 3 [mem 0x1400000000-0x1401ffffff 64bit pref] Mar 3 14:01:21.419529 kernel: pci 0001:00:00.0: Enabling HDA controller Mar 3 14:01:21.423290 systemd[1]: Starting systemd-vconsole-setup.service - Virtual Console Setup... Mar 3 14:01:21.428027 kernel: hv_vmbus: registering driver hv_storvsc Mar 3 14:01:21.439809 kernel: pci_bus 0001:00: busn_res: [bus 00-ff] end is updated to 00 Mar 3 14:01:21.439970 kernel: hv_utils: Registering HyperV Utility Driver Mar 3 14:01:21.439985 kernel: pci 0001:00:00.0: BAR 1 [mem 0x1000000000-0x13ffffffff 64bit pref]: assigned Mar 3 14:01:21.440140 kernel: pci 0001:00:00.0: BAR 3 [mem 0x1400000000-0x1401ffffff 64bit pref]: assigned Mar 3 14:01:21.445181 kernel: hv_vmbus: registering driver hv_utils Mar 3 14:01:21.445677 kernel: hv_vmbus: registering driver hid_hyperv Mar 3 14:01:21.446709 kernel: pci 0001:00:00.0: BAR 0 [mem 0x41000000-0x41ffffff]: assigned Mar 3 14:01:21.479926 systemd[1]: Finished systemd-vconsole-setup.service - Virtual Console Setup. Mar 3 14:01:21.903633 kernel: hv_utils: Shutdown IC version 3.2 Mar 3 14:01:21.903736 kernel: scsi host1: storvsc_host_t Mar 3 14:01:21.903782 kernel: scsi host0: storvsc_host_t Mar 3 14:01:21.905652 kernel: scsi 0:0:0:0: Direct-Access Msft Virtual Disk 1.0 PQ: 0 ANSI: 5 Mar 3 14:01:21.906497 kernel: scsi 0:0:0:1: Direct-Access Msft Virtual Disk 1.0 PQ: 0 ANSI: 5 Mar 3 14:01:21.906536 kernel: hv_utils: Heartbeat IC version 3.0 Mar 3 14:01:21.907617 kernel: scsi 0:0:0:2: CD-ROM Msft Virtual DVD-ROM 1.0 PQ: 0 ANSI: 0 Mar 3 14:01:21.929954 kernel: hv_utils: TimeSync IC version 4.0 Mar 3 14:01:21.930636 kernel: input: Microsoft Vmbus HID-compliant Mouse as /devices/0006:045E:0621.0001/input/input1 Mar 3 14:01:22.035429 systemd-resolved[256]: Clock change detected. Flushing caches. Mar 3 14:01:22.047980 kernel: hid-hyperv 0006:045E:0621.0001: input: VIRTUAL HID v0.01 Mouse [Microsoft Vmbus HID-compliant Mouse] on Mar 3 14:01:22.061873 kernel: sd 0:0:0:0: [sdb] 63737856 512-byte logical blocks: (32.6 GB/30.4 GiB) Mar 3 14:01:22.062135 kernel: sd 0:0:0:1: [sda] 1543503872 512-byte logical blocks: (790 GB/736 GiB) Mar 3 14:01:22.062284 kernel: sd 0:0:0:0: [sdb] 4096-byte physical blocks Mar 3 14:01:22.062416 kernel: sd 0:0:0:1: [sda] 4096-byte physical blocks Mar 3 14:01:22.062545 kernel: sd 0:0:0:1: [sda] Write Protect is off Mar 3 14:01:22.071081 kernel: sd 0:0:0:0: [sdb] Write Protect is off Mar 3 14:01:22.071261 kernel: sd 0:0:0:1: [sda] Mode Sense: 0f 00 10 00 Mar 3 14:01:22.071402 kernel: sd 0:0:0:0: [sdb] Mode Sense: 0f 00 10 00 Mar 3 14:01:22.074837 kernel: sd 0:0:0:0: [sdb] Write cache: disabled, read cache: enabled, supports DPO and FUA Mar 3 14:01:22.074988 kernel: sd 0:0:0:1: [sda] Write cache: disabled, read cache: enabled, supports DPO and FUA Mar 3 14:01:22.103851 kernel: sdb: sdb1 sdb2 sdb3 sdb4 sdb6 sdb7 sdb9 Mar 3 14:01:22.103881 kernel: sd 0:0:0:0: [sdb] Attached SCSI disk Mar 3 14:01:22.111979 kernel: sda: sda1 Mar 3 14:01:22.112010 kernel: sd 0:0:0:1: [sda] Attached SCSI disk Mar 3 14:01:22.119850 kernel: sr 0:0:0:2: [sr0] scsi-1 drive Mar 3 14:01:22.120046 kernel: cdrom: Uniform CD-ROM driver Revision: 3.20 Mar 3 14:01:22.121848 kernel: sr 0:0:0:2: Attached scsi CD-ROM sr0 Mar 3 14:01:22.629571 systemd[1]: Found device dev-disk-by\x2dlabel-OEM.device - Virtual_Disk OEM. Mar 3 14:01:22.666054 systemd[1]: Found device dev-disk-by\x2dlabel-EFI\x2dSYSTEM.device - Virtual_Disk EFI-SYSTEM. Mar 3 14:01:22.683440 systemd[1]: Found device dev-disk-by\x2dlabel-ROOT.device - Virtual_Disk ROOT. Mar 3 14:01:22.702247 systemd[1]: Found device dev-disk-by\x2dpartuuid-7130c94a\x2d213a\x2d4e5a\x2d8e26\x2d6cce9662f132.device - Virtual_Disk USR-A. Mar 3 14:01:22.703733 systemd[1]: Found device dev-disk-by\x2dpartlabel-USR\x2dA.device - Virtual_Disk USR-A. Mar 3 14:01:22.715862 systemd[1]: Starting disk-uuid.service - Generate new UUID for disk GPT if necessary... Mar 3 14:01:22.777847 kernel: sdb: sdb1 sdb2 sdb3 sdb4 sdb6 sdb7 sdb9 Mar 3 14:01:23.799386 disk-uuid[706]: The operation has completed successfully. Mar 3 14:01:23.803055 kernel: sdb: sdb1 sdb2 sdb3 sdb4 sdb6 sdb7 sdb9 Mar 3 14:01:25.457891 systemd[1]: disk-uuid.service: Deactivated successfully. Mar 3 14:01:25.458009 systemd[1]: Finished disk-uuid.service - Generate new UUID for disk GPT if necessary. Mar 3 14:01:25.474400 systemd[1]: Finished dracut-initqueue.service - dracut initqueue hook. Mar 3 14:01:25.484064 systemd[1]: Reached target remote-fs-pre.target - Preparation for Remote File Systems. Mar 3 14:01:25.493958 systemd[1]: Reached target remote-cryptsetup.target - Remote Encrypted Volumes. Mar 3 14:01:25.503494 systemd[1]: Reached target remote-fs.target - Remote File Systems. Mar 3 14:01:25.512784 systemd[1]: Starting dracut-pre-mount.service - dracut pre-mount hook... Mar 3 14:01:25.540382 systemd[1]: Starting verity-setup.service - Verity Setup for /dev/mapper/usr... Mar 3 14:01:25.549289 sh[874]: Success Mar 3 14:01:25.555277 systemd[1]: Finished dracut-pre-mount.service - dracut pre-mount hook. Mar 3 14:01:25.585434 kernel: device-mapper: core: CONFIG_IMA_DISABLE_HTABLE is disabled. Duplicate IMA measurements will not be recorded in the IMA log. Mar 3 14:01:25.585470 kernel: device-mapper: uevent: version 1.0.3 Mar 3 14:01:25.590041 kernel: device-mapper: ioctl: 4.48.0-ioctl (2023-03-01) initialised: dm-devel@lists.linux.dev Mar 3 14:01:25.601840 kernel: device-mapper: verity: sha256 using shash "sha256-avx2" Mar 3 14:01:25.847139 systemd[1]: Found device dev-mapper-usr.device - /dev/mapper/usr. Mar 3 14:01:25.857125 systemd[1]: Mounting sysusr-usr.mount - /sysusr/usr... Mar 3 14:01:25.876509 systemd[1]: Finished verity-setup.service - Verity Setup for /dev/mapper/usr. Mar 3 14:01:25.896843 kernel: BTRFS: device fsid f550cb98-648e-4600-9237-4b15eb09827b devid 1 transid 41 /dev/mapper/usr (254:0) scanned by mount (897) Mar 3 14:01:25.906320 kernel: BTRFS info (device dm-0): first mount of filesystem f550cb98-648e-4600-9237-4b15eb09827b Mar 3 14:01:25.906345 kernel: BTRFS info (device dm-0): using crc32c (crc32c-intel) checksum algorithm Mar 3 14:01:26.266121 kernel: BTRFS info (device dm-0 state E): disabling log replay at mount time Mar 3 14:01:26.266197 kernel: BTRFS info (device dm-0 state E): enabling free space tree Mar 3 14:01:26.319303 systemd[1]: Mounted sysusr-usr.mount - /sysusr/usr. Mar 3 14:01:26.321364 systemd[1]: Reached target initrd-usr-fs.target - Initrd /usr File System. Mar 3 14:01:26.327804 systemd[1]: afterburn-network-kargs.service - Afterburn Initrd Setup Network Kernel Arguments was skipped because no trigger condition checks were met. Mar 3 14:01:26.328594 systemd[1]: Starting ignition-setup.service - Ignition (setup)... Mar 3 14:01:26.359354 systemd[1]: Starting parse-ip-for-networkd.service - Write systemd-networkd units from cmdline... Mar 3 14:01:26.391895 kernel: BTRFS: device label OEM devid 1 transid 12 /dev/sdb6 (8:22) scanned by mount (928) Mar 3 14:01:26.396839 kernel: BTRFS info (device sdb6): first mount of filesystem af9be1e8-b0f0-42a3-a696-521642a3b9f8 Mar 3 14:01:26.396872 kernel: BTRFS info (device sdb6): using crc32c (crc32c-intel) checksum algorithm Mar 3 14:01:26.423999 kernel: BTRFS info (device sdb6): turning on async discard Mar 3 14:01:26.424029 kernel: BTRFS info (device sdb6): enabling free space tree Mar 3 14:01:26.432837 kernel: BTRFS info (device sdb6): last unmount of filesystem af9be1e8-b0f0-42a3-a696-521642a3b9f8 Mar 3 14:01:26.433033 systemd[1]: Finished ignition-setup.service - Ignition (setup). Mar 3 14:01:26.435487 systemd[1]: Starting ignition-fetch-offline.service - Ignition (fetch-offline)... Mar 3 14:01:26.479637 systemd[1]: Finished parse-ip-for-networkd.service - Write systemd-networkd units from cmdline. Mar 3 14:01:26.491926 systemd[1]: Starting systemd-networkd.service - Network Configuration... Mar 3 14:01:26.536207 systemd-networkd[1066]: lo: Link UP Mar 3 14:01:26.536217 systemd-networkd[1066]: lo: Gained carrier Mar 3 14:01:26.537234 systemd-networkd[1066]: Enumeration completed Mar 3 14:01:26.537364 systemd[1]: Started systemd-networkd.service - Network Configuration. Mar 3 14:01:26.537586 systemd-networkd[1066]: eth0: found matching network '/usr/lib/systemd/network/zz-default.network', based on potentially unpredictable interface name. Mar 3 14:01:26.537590 systemd-networkd[1066]: eth0: Configuring with /usr/lib/systemd/network/zz-default.network. Mar 3 14:01:26.538620 systemd[1]: Reached target network.target - Network. Mar 3 14:01:26.539030 systemd-networkd[1066]: eth0: Link UP Mar 3 14:01:26.539218 systemd-networkd[1066]: eth0: Gained carrier Mar 3 14:01:26.539228 systemd-networkd[1066]: eth0: found matching network '/usr/lib/systemd/network/zz-default.network', based on potentially unpredictable interface name. Mar 3 14:01:26.597853 systemd-networkd[1066]: eth0: DHCPv4 address 10.200.8.10/24, gateway 10.200.8.1 acquired from 168.63.129.16 Mar 3 14:01:27.764135 ignition[1027]: Ignition 2.22.0 Mar 3 14:01:27.764153 ignition[1027]: Stage: fetch-offline Mar 3 14:01:27.764343 ignition[1027]: no configs at "/usr/lib/ignition/base.d" Mar 3 14:01:27.764360 ignition[1027]: no config dir at "/usr/lib/ignition/base.platform.d/azure" Mar 3 14:01:27.764465 ignition[1027]: parsed url from cmdline: "" Mar 3 14:01:27.764469 ignition[1027]: no config URL provided Mar 3 14:01:27.764475 ignition[1027]: reading system config file "/usr/lib/ignition/user.ign" Mar 3 14:01:27.764484 ignition[1027]: no config at "/usr/lib/ignition/user.ign" Mar 3 14:01:27.764490 ignition[1027]: failed to fetch config: resource requires networking Mar 3 14:01:27.764671 ignition[1027]: Ignition finished successfully Mar 3 14:01:27.794809 systemd[1]: Finished ignition-fetch-offline.service - Ignition (fetch-offline). Mar 3 14:01:27.797314 systemd[1]: Starting ignition-fetch.service - Ignition (fetch)... Mar 3 14:01:27.847838 ignition[1083]: Ignition 2.22.0 Mar 3 14:01:27.847851 ignition[1083]: Stage: fetch Mar 3 14:01:27.848097 ignition[1083]: no configs at "/usr/lib/ignition/base.d" Mar 3 14:01:27.848109 ignition[1083]: no config dir at "/usr/lib/ignition/base.platform.d/azure" Mar 3 14:01:27.848209 ignition[1083]: parsed url from cmdline: "" Mar 3 14:01:27.848213 ignition[1083]: no config URL provided Mar 3 14:01:27.848219 ignition[1083]: reading system config file "/usr/lib/ignition/user.ign" Mar 3 14:01:27.848229 ignition[1083]: no config at "/usr/lib/ignition/user.ign" Mar 3 14:01:27.848248 ignition[1083]: GET http://169.254.169.254/metadata/instance/compute/userData?api-version=2021-01-01&format=text: attempt #1 Mar 3 14:01:27.892963 systemd-networkd[1066]: eth0: Gained IPv6LL Mar 3 14:01:27.974768 ignition[1083]: GET result: OK Mar 3 14:01:27.974849 ignition[1083]: config has been read from IMDS userdata Mar 3 14:01:27.974862 ignition[1083]: parsing config with SHA512: f5690e543237c7daaf5a4647a253aa7455e1f695459a366a1481e78dcec55dd0d3ba1ed424af835d422cff6af4a990356bf3b2190c82ab3514754b9b59d96b81 Mar 3 14:01:27.982528 unknown[1083]: fetched base config from "system" Mar 3 14:01:27.982540 unknown[1083]: fetched base config from "system" Mar 3 14:01:27.982699 ignition[1083]: fetch: fetch complete Mar 3 14:01:27.982546 unknown[1083]: fetched user config from "azure" Mar 3 14:01:27.982705 ignition[1083]: fetch: fetch passed Mar 3 14:01:27.982752 ignition[1083]: Ignition finished successfully Mar 3 14:01:28.001698 systemd[1]: Finished ignition-fetch.service - Ignition (fetch). Mar 3 14:01:28.009647 systemd[1]: Starting ignition-kargs.service - Ignition (kargs)... Mar 3 14:01:28.052935 ignition[1093]: Ignition 2.22.0 Mar 3 14:01:28.052947 ignition[1093]: Stage: kargs Mar 3 14:01:28.053182 ignition[1093]: no configs at "/usr/lib/ignition/base.d" Mar 3 14:01:28.053194 ignition[1093]: no config dir at "/usr/lib/ignition/base.platform.d/azure" Mar 3 14:01:28.062620 systemd[1]: Finished ignition-kargs.service - Ignition (kargs). Mar 3 14:01:28.053642 ignition[1093]: kargs: kargs passed Mar 3 14:01:28.065423 systemd[1]: Starting ignition-disks.service - Ignition (disks)... Mar 3 14:01:28.053686 ignition[1093]: Ignition finished successfully Mar 3 14:01:28.113757 ignition[1102]: Ignition 2.22.0 Mar 3 14:01:28.113783 ignition[1102]: Stage: disks Mar 3 14:01:28.114024 ignition[1102]: no configs at "/usr/lib/ignition/base.d" Mar 3 14:01:28.114035 ignition[1102]: no config dir at "/usr/lib/ignition/base.platform.d/azure" Mar 3 14:01:28.119839 systemd[1]: Finished ignition-disks.service - Ignition (disks). Mar 3 14:01:28.114638 ignition[1102]: disks: disks passed Mar 3 14:01:28.126061 systemd[1]: Reached target initrd-root-device.target - Initrd Root Device. Mar 3 14:01:28.114685 ignition[1102]: Ignition finished successfully Mar 3 14:01:28.134685 systemd[1]: Reached target local-fs-pre.target - Preparation for Local File Systems. Mar 3 14:01:28.143515 systemd[1]: Reached target local-fs.target - Local File Systems. Mar 3 14:01:28.149689 systemd[1]: Reached target sysinit.target - System Initialization. Mar 3 14:01:28.157869 systemd[1]: Reached target basic.target - Basic System. Mar 3 14:01:28.164951 systemd[1]: Starting systemd-fsck-root.service - File System Check on /dev/disk/by-label/ROOT... Mar 3 14:01:28.256799 systemd-fsck[1113]: ROOT: clean, 15/7326000 files, 477845/7359488 blocks Mar 3 14:01:28.262100 systemd[1]: Finished systemd-fsck-root.service - File System Check on /dev/disk/by-label/ROOT. Mar 3 14:01:28.273086 systemd[1]: Mounting sysroot.mount - /sysroot... Mar 3 14:01:28.628845 kernel: EXT4-fs (sdb9): mounted filesystem f0c751de-febc-4e57-b330-c926d38ed5ec r/w with ordered data mode. Quota mode: none. Mar 3 14:01:28.629892 systemd[1]: Mounted sysroot.mount - /sysroot. Mar 3 14:01:28.632451 systemd[1]: Reached target initrd-root-fs.target - Initrd Root File System. Mar 3 14:01:28.651364 systemd[1]: Mounting sysroot-oem.mount - /sysroot/oem... Mar 3 14:01:28.654194 systemd[1]: Mounting sysroot-usr.mount - /sysroot/usr... Mar 3 14:01:28.660362 systemd[1]: Starting flatcar-metadata-hostname.service - Flatcar Metadata Hostname Agent... Mar 3 14:01:28.665782 systemd[1]: ignition-remount-sysroot.service - Remount /sysroot read-write for Ignition was skipped because of an unmet condition check (ConditionPathIsReadWrite=!/sysroot). Mar 3 14:01:28.665813 systemd[1]: Reached target ignition-diskful.target - Ignition Boot Disk Setup. Mar 3 14:01:28.698746 systemd[1]: Mounted sysroot-usr.mount - /sysroot/usr. Mar 3 14:01:28.706804 systemd[1]: Starting initrd-setup-root.service - Root filesystem setup... Mar 3 14:01:28.719001 kernel: BTRFS: device label OEM devid 1 transid 12 /dev/sdb6 (8:22) scanned by mount (1127) Mar 3 14:01:28.728277 kernel: BTRFS info (device sdb6): first mount of filesystem af9be1e8-b0f0-42a3-a696-521642a3b9f8 Mar 3 14:01:28.728306 kernel: BTRFS info (device sdb6): using crc32c (crc32c-intel) checksum algorithm Mar 3 14:01:28.738175 kernel: BTRFS info (device sdb6): turning on async discard Mar 3 14:01:28.738208 kernel: BTRFS info (device sdb6): enabling free space tree Mar 3 14:01:28.739937 systemd[1]: Mounted sysroot-oem.mount - /sysroot/oem. Mar 3 14:01:29.396640 coreos-metadata[1129]: Mar 03 14:01:29.396 INFO Fetching http://168.63.129.16/?comp=versions: Attempt #1 Mar 3 14:01:29.402615 coreos-metadata[1129]: Mar 03 14:01:29.399 INFO Fetch successful Mar 3 14:01:29.402615 coreos-metadata[1129]: Mar 03 14:01:29.399 INFO Fetching http://169.254.169.254/metadata/instance/compute/name?api-version=2017-08-01&format=text: Attempt #1 Mar 3 14:01:29.414828 coreos-metadata[1129]: Mar 03 14:01:29.405 INFO Fetch successful Mar 3 14:01:29.418856 coreos-metadata[1129]: Mar 03 14:01:29.417 INFO wrote hostname ci-4459.2.4-a-868b7edfa5 to /sysroot/etc/hostname Mar 3 14:01:29.419637 systemd[1]: Finished flatcar-metadata-hostname.service - Flatcar Metadata Hostname Agent. Mar 3 14:01:29.696116 initrd-setup-root[1157]: cut: /sysroot/etc/passwd: No such file or directory Mar 3 14:01:29.745098 initrd-setup-root[1164]: cut: /sysroot/etc/group: No such file or directory Mar 3 14:01:29.796453 initrd-setup-root[1171]: cut: /sysroot/etc/shadow: No such file or directory Mar 3 14:01:29.811382 initrd-setup-root[1178]: cut: /sysroot/etc/gshadow: No such file or directory Mar 3 14:01:30.931639 systemd[1]: Finished initrd-setup-root.service - Root filesystem setup. Mar 3 14:01:30.937349 systemd[1]: Starting ignition-mount.service - Ignition (mount)... Mar 3 14:01:30.942949 systemd[1]: Starting sysroot-boot.service - /sysroot/boot... Mar 3 14:01:30.971787 systemd[1]: sysroot-oem.mount: Deactivated successfully. Mar 3 14:01:30.980382 kernel: BTRFS info (device sdb6): last unmount of filesystem af9be1e8-b0f0-42a3-a696-521642a3b9f8 Mar 3 14:01:30.995934 systemd[1]: Finished sysroot-boot.service - /sysroot/boot. Mar 3 14:01:31.017320 ignition[1248]: INFO : Ignition 2.22.0 Mar 3 14:01:31.017320 ignition[1248]: INFO : Stage: mount Mar 3 14:01:31.023095 ignition[1248]: INFO : no configs at "/usr/lib/ignition/base.d" Mar 3 14:01:31.023095 ignition[1248]: INFO : no config dir at "/usr/lib/ignition/base.platform.d/azure" Mar 3 14:01:31.023095 ignition[1248]: INFO : mount: mount passed Mar 3 14:01:31.023095 ignition[1248]: INFO : Ignition finished successfully Mar 3 14:01:31.024376 systemd[1]: Finished ignition-mount.service - Ignition (mount). Mar 3 14:01:31.031867 systemd[1]: Starting ignition-files.service - Ignition (files)... Mar 3 14:01:31.057052 systemd[1]: Mounting sysroot-oem.mount - /sysroot/oem... Mar 3 14:01:31.085902 kernel: BTRFS: device label OEM devid 1 transid 12 /dev/sdb6 (8:22) scanned by mount (1262) Mar 3 14:01:31.094977 kernel: BTRFS info (device sdb6): first mount of filesystem af9be1e8-b0f0-42a3-a696-521642a3b9f8 Mar 3 14:01:31.095008 kernel: BTRFS info (device sdb6): using crc32c (crc32c-intel) checksum algorithm Mar 3 14:01:31.104756 kernel: BTRFS info (device sdb6): turning on async discard Mar 3 14:01:31.104785 kernel: BTRFS info (device sdb6): enabling free space tree Mar 3 14:01:31.106966 systemd[1]: Mounted sysroot-oem.mount - /sysroot/oem. Mar 3 14:01:31.143241 ignition[1279]: INFO : Ignition 2.22.0 Mar 3 14:01:31.143241 ignition[1279]: INFO : Stage: files Mar 3 14:01:31.148942 ignition[1279]: INFO : no configs at "/usr/lib/ignition/base.d" Mar 3 14:01:31.148942 ignition[1279]: INFO : no config dir at "/usr/lib/ignition/base.platform.d/azure" Mar 3 14:01:31.148942 ignition[1279]: DEBUG : files: compiled without relabeling support, skipping Mar 3 14:01:31.163286 ignition[1279]: INFO : files: ensureUsers: op(1): [started] creating or modifying user "core" Mar 3 14:01:31.163286 ignition[1279]: DEBUG : files: ensureUsers: op(1): executing: "usermod" "--root" "/sysroot" "core" Mar 3 14:01:31.192486 ignition[1279]: INFO : files: ensureUsers: op(1): [finished] creating or modifying user "core" Mar 3 14:01:31.198212 ignition[1279]: INFO : files: ensureUsers: op(2): [started] adding ssh keys to user "core" Mar 3 14:01:31.204041 unknown[1279]: wrote ssh authorized keys file for user: core Mar 3 14:01:31.207988 ignition[1279]: INFO : files: ensureUsers: op(2): [finished] adding ssh keys to user "core" Mar 3 14:01:31.253517 ignition[1279]: INFO : files: createFilesystemsFiles: createFiles: op(3): [started] writing file "/sysroot/etc/flatcar/update.conf" Mar 3 14:01:31.261145 ignition[1279]: INFO : files: createFilesystemsFiles: createFiles: op(3): [finished] writing file "/sysroot/etc/flatcar/update.conf" Mar 3 14:01:31.261145 ignition[1279]: INFO : files: createResultFile: createFiles: op(4): [started] writing file "/sysroot/etc/.ignition-result.json" Mar 3 14:01:31.261145 ignition[1279]: INFO : files: createResultFile: createFiles: op(4): [finished] writing file "/sysroot/etc/.ignition-result.json" Mar 3 14:01:31.261145 ignition[1279]: INFO : files: files passed Mar 3 14:01:31.261145 ignition[1279]: INFO : Ignition finished successfully Mar 3 14:01:31.255798 systemd[1]: Finished ignition-files.service - Ignition (files). Mar 3 14:01:31.263671 systemd[1]: Starting ignition-quench.service - Ignition (record completion)... Mar 3 14:01:31.308343 systemd[1]: Starting initrd-setup-root-after-ignition.service - Root filesystem completion... Mar 3 14:01:31.314458 systemd[1]: ignition-quench.service: Deactivated successfully. Mar 3 14:01:31.314561 systemd[1]: Finished ignition-quench.service - Ignition (record completion). Mar 3 14:01:31.361499 initrd-setup-root-after-ignition[1312]: grep: /sysroot/etc/flatcar/enabled-sysext.conf: No such file or directory Mar 3 14:01:31.361499 initrd-setup-root-after-ignition[1312]: grep: /sysroot/usr/share/flatcar/enabled-sysext.conf: No such file or directory Mar 3 14:01:31.369021 initrd-setup-root-after-ignition[1316]: grep: /sysroot/etc/flatcar/enabled-sysext.conf: No such file or directory Mar 3 14:01:31.368691 systemd[1]: Finished initrd-setup-root-after-ignition.service - Root filesystem completion. Mar 3 14:01:31.378629 systemd[1]: Reached target ignition-complete.target - Ignition Complete. Mar 3 14:01:31.390252 systemd[1]: Starting initrd-parse-etc.service - Mountpoints Configured in the Real Root... Mar 3 14:01:31.438358 systemd[1]: initrd-parse-etc.service: Deactivated successfully. Mar 3 14:01:31.438465 systemd[1]: Finished initrd-parse-etc.service - Mountpoints Configured in the Real Root. Mar 3 14:01:31.447224 systemd[1]: Reached target initrd-fs.target - Initrd File Systems. Mar 3 14:01:31.456243 systemd[1]: Reached target initrd.target - Initrd Default Target. Mar 3 14:01:31.464330 systemd[1]: dracut-mount.service - dracut mount hook was skipped because no trigger condition checks were met. Mar 3 14:01:31.465197 systemd[1]: Starting dracut-pre-pivot.service - dracut pre-pivot and cleanup hook... Mar 3 14:01:31.496454 systemd[1]: Finished dracut-pre-pivot.service - dracut pre-pivot and cleanup hook. Mar 3 14:01:31.499076 systemd[1]: Starting initrd-cleanup.service - Cleaning Up and Shutting Down Daemons... Mar 3 14:01:31.515860 systemd[1]: Stopped target nss-lookup.target - Host and Network Name Lookups. Mar 3 14:01:31.517355 systemd[1]: Stopped target remote-cryptsetup.target - Remote Encrypted Volumes. Mar 3 14:01:31.526020 systemd[1]: Stopped target timers.target - Timer Units. Mar 3 14:01:31.534883 systemd[1]: dracut-pre-pivot.service: Deactivated successfully. Mar 3 14:01:31.535004 systemd[1]: Stopped dracut-pre-pivot.service - dracut pre-pivot and cleanup hook. Mar 3 14:01:31.548706 systemd[1]: Stopped target initrd.target - Initrd Default Target. Mar 3 14:01:31.557621 systemd[1]: Stopped target basic.target - Basic System. Mar 3 14:01:31.565400 systemd[1]: Stopped target ignition-complete.target - Ignition Complete. Mar 3 14:01:31.573631 systemd[1]: Stopped target ignition-diskful.target - Ignition Boot Disk Setup. Mar 3 14:01:31.575776 systemd[1]: Stopped target initrd-root-device.target - Initrd Root Device. Mar 3 14:01:31.587844 systemd[1]: Stopped target initrd-usr-fs.target - Initrd /usr File System. Mar 3 14:01:31.595737 systemd[1]: Stopped target remote-fs.target - Remote File Systems. Mar 3 14:01:31.607882 systemd[1]: Stopped target remote-fs-pre.target - Preparation for Remote File Systems. Mar 3 14:01:31.610149 systemd[1]: Stopped target sysinit.target - System Initialization. Mar 3 14:01:31.623022 systemd[1]: Stopped target local-fs.target - Local File Systems. Mar 3 14:01:31.631312 systemd[1]: Stopped target swap.target - Swaps. Mar 3 14:01:31.632727 systemd[1]: dracut-pre-mount.service: Deactivated successfully. Mar 3 14:01:31.633388 systemd[1]: Stopped dracut-pre-mount.service - dracut pre-mount hook. Mar 3 14:01:31.651787 systemd[1]: Stopped target cryptsetup.target - Local Encrypted Volumes. Mar 3 14:01:31.659981 systemd[1]: Stopped target cryptsetup-pre.target - Local Encrypted Volumes (Pre). Mar 3 14:01:31.668962 systemd[1]: clevis-luks-askpass.path: Deactivated successfully. Mar 3 14:01:31.669072 systemd[1]: Stopped clevis-luks-askpass.path - Forward Password Requests to Clevis Directory Watch. Mar 3 14:01:31.678416 systemd[1]: dracut-initqueue.service: Deactivated successfully. Mar 3 14:01:31.678536 systemd[1]: Stopped dracut-initqueue.service - dracut initqueue hook. Mar 3 14:01:31.691683 systemd[1]: initrd-setup-root-after-ignition.service: Deactivated successfully. Mar 3 14:01:31.691810 systemd[1]: Stopped initrd-setup-root-after-ignition.service - Root filesystem completion. Mar 3 14:01:31.700384 systemd[1]: ignition-files.service: Deactivated successfully. Mar 3 14:01:31.700508 systemd[1]: Stopped ignition-files.service - Ignition (files). Mar 3 14:01:31.702490 systemd[1]: flatcar-metadata-hostname.service: Deactivated successfully. Mar 3 14:01:31.702605 systemd[1]: Stopped flatcar-metadata-hostname.service - Flatcar Metadata Hostname Agent. Mar 3 14:01:31.715111 systemd[1]: Stopping ignition-mount.service - Ignition (mount)... Mar 3 14:01:31.724260 systemd[1]: kmod-static-nodes.service: Deactivated successfully. Mar 3 14:01:31.724925 systemd[1]: Stopped kmod-static-nodes.service - Create List of Static Device Nodes. Mar 3 14:01:31.756383 systemd[1]: Stopping sysroot-boot.service - /sysroot/boot... Mar 3 14:01:31.763708 systemd[1]: systemd-udev-trigger.service: Deactivated successfully. Mar 3 14:01:31.763866 systemd[1]: Stopped systemd-udev-trigger.service - Coldplug All udev Devices. Mar 3 14:01:31.782438 ignition[1336]: INFO : Ignition 2.22.0 Mar 3 14:01:31.782438 ignition[1336]: INFO : Stage: umount Mar 3 14:01:31.782438 ignition[1336]: INFO : no configs at "/usr/lib/ignition/base.d" Mar 3 14:01:31.782438 ignition[1336]: INFO : no config dir at "/usr/lib/ignition/base.platform.d/azure" Mar 3 14:01:31.782438 ignition[1336]: INFO : umount: umount passed Mar 3 14:01:31.782438 ignition[1336]: INFO : Ignition finished successfully Mar 3 14:01:31.772191 systemd[1]: dracut-pre-trigger.service: Deactivated successfully. Mar 3 14:01:31.772950 systemd[1]: Stopped dracut-pre-trigger.service - dracut pre-trigger hook. Mar 3 14:01:31.786892 systemd[1]: ignition-mount.service: Deactivated successfully. Mar 3 14:01:31.786988 systemd[1]: Stopped ignition-mount.service - Ignition (mount). Mar 3 14:01:31.791293 systemd[1]: initrd-cleanup.service: Deactivated successfully. Mar 3 14:01:31.791389 systemd[1]: Finished initrd-cleanup.service - Cleaning Up and Shutting Down Daemons. Mar 3 14:01:31.799050 systemd[1]: sysroot-boot.mount: Deactivated successfully. Mar 3 14:01:31.799971 systemd[1]: ignition-disks.service: Deactivated successfully. Mar 3 14:01:31.800052 systemd[1]: Stopped ignition-disks.service - Ignition (disks). Mar 3 14:01:31.805654 systemd[1]: ignition-kargs.service: Deactivated successfully. Mar 3 14:01:31.805855 systemd[1]: Stopped ignition-kargs.service - Ignition (kargs). Mar 3 14:01:31.814366 systemd[1]: ignition-fetch.service: Deactivated successfully. Mar 3 14:01:31.814421 systemd[1]: Stopped ignition-fetch.service - Ignition (fetch). Mar 3 14:01:31.821062 systemd[1]: Stopped target network.target - Network. Mar 3 14:01:31.833699 systemd[1]: ignition-fetch-offline.service: Deactivated successfully. Mar 3 14:01:31.833758 systemd[1]: Stopped ignition-fetch-offline.service - Ignition (fetch-offline). Mar 3 14:01:31.842172 systemd[1]: Stopped target paths.target - Path Units. Mar 3 14:01:31.849137 systemd[1]: systemd-ask-password-console.path: Deactivated successfully. Mar 3 14:01:31.856875 systemd[1]: Stopped systemd-ask-password-console.path - Dispatch Password Requests to Console Directory Watch. Mar 3 14:01:31.865666 systemd[1]: Stopped target slices.target - Slice Units. Mar 3 14:01:31.872623 systemd[1]: Stopped target sockets.target - Socket Units. Mar 3 14:01:31.879857 systemd[1]: iscsid.socket: Deactivated successfully. Mar 3 14:01:31.879900 systemd[1]: Closed iscsid.socket - Open-iSCSI iscsid Socket. Mar 3 14:01:31.887391 systemd[1]: iscsiuio.socket: Deactivated successfully. Mar 3 14:01:31.887435 systemd[1]: Closed iscsiuio.socket - Open-iSCSI iscsiuio Socket. Mar 3 14:01:31.894878 systemd[1]: ignition-setup.service: Deactivated successfully. Mar 3 14:01:31.894929 systemd[1]: Stopped ignition-setup.service - Ignition (setup). Mar 3 14:01:31.902390 systemd[1]: ignition-setup-pre.service: Deactivated successfully. Mar 3 14:01:31.902435 systemd[1]: Stopped ignition-setup-pre.service - Ignition env setup. Mar 3 14:01:31.910188 systemd[1]: Stopping systemd-networkd.service - Network Configuration... Mar 3 14:01:31.917525 systemd[1]: Stopping systemd-resolved.service - Network Name Resolution... Mar 3 14:01:31.924787 systemd[1]: systemd-resolved.service: Deactivated successfully. Mar 3 14:01:31.924950 systemd[1]: Stopped systemd-resolved.service - Network Name Resolution. Mar 3 14:01:31.938387 systemd[1]: run-credentials-systemd\x2dresolved.service.mount: Deactivated successfully. Mar 3 14:01:31.938684 systemd[1]: systemd-networkd.service: Deactivated successfully. Mar 3 14:01:31.938791 systemd[1]: Stopped systemd-networkd.service - Network Configuration. Mar 3 14:01:31.949303 systemd[1]: run-credentials-systemd\x2dnetworkd.service.mount: Deactivated successfully. Mar 3 14:01:31.949537 systemd[1]: sysroot-boot.service: Deactivated successfully. Mar 3 14:01:31.949626 systemd[1]: Stopped sysroot-boot.service - /sysroot/boot. Mar 3 14:01:31.955955 systemd[1]: Stopped target network-pre.target - Preparation for Network. Mar 3 14:01:31.961708 systemd[1]: systemd-networkd.socket: Deactivated successfully. Mar 3 14:01:31.961761 systemd[1]: Closed systemd-networkd.socket - Network Service Netlink Socket. Mar 3 14:01:31.972917 systemd[1]: initrd-setup-root.service: Deactivated successfully. Mar 3 14:01:31.972982 systemd[1]: Stopped initrd-setup-root.service - Root filesystem setup. Mar 3 14:01:31.981086 systemd[1]: Stopping network-cleanup.service - Network Cleanup... Mar 3 14:01:31.982607 systemd[1]: parse-ip-for-networkd.service: Deactivated successfully. Mar 3 14:01:31.982655 systemd[1]: Stopped parse-ip-for-networkd.service - Write systemd-networkd units from cmdline. Mar 3 14:01:31.999083 systemd[1]: systemd-sysctl.service: Deactivated successfully. Mar 3 14:01:31.999132 systemd[1]: Stopped systemd-sysctl.service - Apply Kernel Variables. Mar 3 14:01:32.010030 systemd[1]: systemd-modules-load.service: Deactivated successfully. Mar 3 14:01:32.010077 systemd[1]: Stopped systemd-modules-load.service - Load Kernel Modules. Mar 3 14:01:32.011496 systemd[1]: systemd-tmpfiles-setup.service: Deactivated successfully. Mar 3 14:01:32.011547 systemd[1]: Stopped systemd-tmpfiles-setup.service - Create System Files and Directories. Mar 3 14:01:32.030396 systemd[1]: Stopping systemd-udevd.service - Rule-based Manager for Device Events and Files... Mar 3 14:01:32.040201 systemd[1]: run-credentials-systemd\x2dsysctl.service.mount: Deactivated successfully. Mar 3 14:01:32.040263 systemd[1]: run-credentials-systemd\x2dtmpfiles\x2dsetup.service.mount: Deactivated successfully. Mar 3 14:01:32.075637 systemd[1]: systemd-udevd.service: Deactivated successfully. Mar 3 14:01:32.075954 systemd[1]: Stopped systemd-udevd.service - Rule-based Manager for Device Events and Files. Mar 3 14:01:32.077675 systemd[1]: systemd-udevd-control.socket: Deactivated successfully. Mar 3 14:01:32.077723 systemd[1]: Closed systemd-udevd-control.socket - udev Control Socket. Mar 3 14:01:32.093111 systemd[1]: systemd-udevd-kernel.socket: Deactivated successfully. Mar 3 14:01:32.093150 systemd[1]: Closed systemd-udevd-kernel.socket - udev Kernel Socket. Mar 3 14:01:32.100870 systemd[1]: dracut-pre-udev.service: Deactivated successfully. Mar 3 14:01:32.100919 systemd[1]: Stopped dracut-pre-udev.service - dracut pre-udev hook. Mar 3 14:01:32.112758 systemd[1]: dracut-cmdline.service: Deactivated successfully. Mar 3 14:01:32.112805 systemd[1]: Stopped dracut-cmdline.service - dracut cmdline hook. Mar 3 14:01:32.125689 systemd[1]: dracut-cmdline-ask.service: Deactivated successfully. Mar 3 14:01:32.125742 systemd[1]: Stopped dracut-cmdline-ask.service - dracut ask for additional cmdline parameters. Mar 3 14:01:32.142411 systemd[1]: Starting initrd-udevadm-cleanup-db.service - Cleanup udev Database... Mar 3 14:01:32.149900 systemd[1]: systemd-network-generator.service: Deactivated successfully. Mar 3 14:01:32.149957 systemd[1]: Stopped systemd-network-generator.service - Generate network units from Kernel command line. Mar 3 14:01:32.163438 systemd[1]: systemd-tmpfiles-setup-dev.service: Deactivated successfully. Mar 3 14:01:32.163486 systemd[1]: Stopped systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev. Mar 3 14:01:32.174604 systemd[1]: systemd-vconsole-setup.service: Deactivated successfully. Mar 3 14:01:32.174651 systemd[1]: Stopped systemd-vconsole-setup.service - Virtual Console Setup. Mar 3 14:01:32.184638 systemd[1]: run-credentials-systemd\x2dnetwork\x2dgenerator.service.mount: Deactivated successfully. Mar 3 14:01:32.184696 systemd[1]: run-credentials-systemd\x2dtmpfiles\x2dsetup\x2ddev.service.mount: Deactivated successfully. Mar 3 14:01:32.184746 systemd[1]: run-credentials-systemd\x2dvconsole\x2dsetup.service.mount: Deactivated successfully. Mar 3 14:01:32.185155 systemd[1]: network-cleanup.service: Deactivated successfully. Mar 3 14:01:32.185249 systemd[1]: Stopped network-cleanup.service - Network Cleanup. Mar 3 14:01:32.189045 systemd[1]: initrd-udevadm-cleanup-db.service: Deactivated successfully. Mar 3 14:01:32.189151 systemd[1]: Finished initrd-udevadm-cleanup-db.service - Cleanup udev Database. Mar 3 14:01:32.200133 systemd[1]: Reached target initrd-switch-root.target - Switch Root. Mar 3 14:01:32.212292 systemd[1]: Starting initrd-switch-root.service - Switch Root... Mar 3 14:01:32.254333 systemd[1]: Switching root. Mar 3 14:01:32.353157 systemd-journald[214]: Journal stopped Mar 3 14:01:37.894563 systemd-journald[214]: Received SIGTERM from PID 1 (systemd). Mar 3 14:01:37.894595 kernel: SELinux: policy capability network_peer_controls=1 Mar 3 14:01:37.894608 kernel: SELinux: policy capability open_perms=1 Mar 3 14:01:37.894617 kernel: SELinux: policy capability extended_socket_class=1 Mar 3 14:01:37.894626 kernel: SELinux: policy capability always_check_network=0 Mar 3 14:01:37.894634 kernel: SELinux: policy capability cgroup_seclabel=1 Mar 3 14:01:37.894644 kernel: SELinux: policy capability nnp_nosuid_transition=1 Mar 3 14:01:37.894656 kernel: SELinux: policy capability genfs_seclabel_symlinks=0 Mar 3 14:01:37.894669 kernel: SELinux: policy capability ioctl_skip_cloexec=0 Mar 3 14:01:37.894678 kernel: SELinux: policy capability userspace_initial_context=0 Mar 3 14:01:37.894687 kernel: audit: type=1403 audit(1772546493.483:2): auid=4294967295 ses=4294967295 lsm=selinux res=1 Mar 3 14:01:37.894698 systemd[1]: Successfully loaded SELinux policy in 210.167ms. Mar 3 14:01:37.894709 systemd[1]: Relabeled /dev/, /dev/shm/, /run/ in 8.314ms. Mar 3 14:01:37.894720 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 3 14:01:37.894734 systemd[1]: Detected virtualization microsoft. Mar 3 14:01:37.894744 systemd[1]: Detected architecture x86-64. Mar 3 14:01:37.894754 systemd[1]: Detected first boot. Mar 3 14:01:37.894764 systemd[1]: Hostname set to . Mar 3 14:01:37.894774 systemd[1]: Initializing machine ID from random generator. Mar 3 14:01:37.894787 zram_generator::config[1382]: No configuration found. Mar 3 14:01:37.894798 kernel: Guest personality initialized and is inactive Mar 3 14:01:37.894808 kernel: VMCI host device registered (name=vmci, major=10, minor=259) Mar 3 14:01:37.894817 kernel: Initialized host personality Mar 3 14:01:37.894844 kernel: NET: Registered PF_VSOCK protocol family Mar 3 14:01:37.894854 systemd[1]: Populated /etc with preset unit settings. Mar 3 14:01:37.894866 systemd[1]: run-credentials-systemd\x2djournald.service.mount: Deactivated successfully. Mar 3 14:01:37.894880 systemd[1]: initrd-switch-root.service: Deactivated successfully. Mar 3 14:01:37.894891 systemd[1]: Stopped initrd-switch-root.service - Switch Root. Mar 3 14:01:37.894901 systemd[1]: systemd-journald.service: Scheduled restart job, restart counter is at 1. Mar 3 14:01:37.894914 systemd[1]: Created slice system-addon\x2dconfig.slice - Slice /system/addon-config. Mar 3 14:01:37.894926 systemd[1]: Created slice system-addon\x2drun.slice - Slice /system/addon-run. Mar 3 14:01:37.894936 systemd[1]: Created slice system-getty.slice - Slice /system/getty. Mar 3 14:01:37.894946 systemd[1]: Created slice system-modprobe.slice - Slice /system/modprobe. Mar 3 14:01:37.894959 systemd[1]: Created slice system-serial\x2dgetty.slice - Slice /system/serial-getty. Mar 3 14:01:37.894970 systemd[1]: Created slice system-system\x2dcloudinit.slice - Slice /system/system-cloudinit. Mar 3 14:01:37.894981 systemd[1]: Created slice system-systemd\x2dfsck.slice - Slice /system/systemd-fsck. Mar 3 14:01:37.895033 systemd[1]: Created slice user.slice - User and Session Slice. Mar 3 14:01:37.895046 systemd[1]: Started clevis-luks-askpass.path - Forward Password Requests to Clevis Directory Watch. Mar 3 14:01:37.895057 systemd[1]: Started systemd-ask-password-console.path - Dispatch Password Requests to Console Directory Watch. Mar 3 14:01:37.895068 systemd[1]: Started systemd-ask-password-wall.path - Forward Password Requests to Wall Directory Watch. Mar 3 14:01:37.895084 systemd[1]: Set up automount boot.automount - Boot partition Automount Point. Mar 3 14:01:37.895095 systemd[1]: Set up automount proc-sys-fs-binfmt_misc.automount - Arbitrary Executable File Formats File System Automount Point. Mar 3 14:01:37.895109 systemd[1]: Expecting device dev-disk-by\x2dlabel-OEM.device - /dev/disk/by-label/OEM... Mar 3 14:01:37.895120 systemd[1]: Expecting device dev-ttyS0.device - /dev/ttyS0... Mar 3 14:01:37.895130 systemd[1]: Reached target cryptsetup-pre.target - Local Encrypted Volumes (Pre). Mar 3 14:01:37.895141 systemd[1]: Reached target cryptsetup.target - Local Encrypted Volumes. Mar 3 14:01:37.895152 systemd[1]: Stopped target initrd-switch-root.target - Switch Root. Mar 3 14:01:37.895163 systemd[1]: Stopped target initrd-fs.target - Initrd File Systems. Mar 3 14:01:37.895173 systemd[1]: Stopped target initrd-root-fs.target - Initrd Root File System. Mar 3 14:01:37.895186 systemd[1]: Reached target integritysetup.target - Local Integrity Protected Volumes. Mar 3 14:01:37.895203 systemd[1]: Reached target remote-cryptsetup.target - Remote Encrypted Volumes. Mar 3 14:01:37.895213 systemd[1]: Reached target remote-fs.target - Remote File Systems. Mar 3 14:01:37.895224 systemd[1]: Reached target slices.target - Slice Units. Mar 3 14:01:37.895235 systemd[1]: Reached target swap.target - Swaps. Mar 3 14:01:37.895246 systemd[1]: Reached target veritysetup.target - Local Verity Protected Volumes. Mar 3 14:01:37.895256 systemd[1]: Listening on systemd-coredump.socket - Process Core Dump Socket. Mar 3 14:01:37.895273 systemd[1]: Listening on systemd-creds.socket - Credential Encryption/Decryption. Mar 3 14:01:37.895285 systemd[1]: Listening on systemd-networkd.socket - Network Service Netlink Socket. Mar 3 14:01:37.895296 systemd[1]: Listening on systemd-udevd-control.socket - udev Control Socket. Mar 3 14:01:37.895307 systemd[1]: Listening on systemd-udevd-kernel.socket - udev Kernel Socket. Mar 3 14:01:37.895318 systemd[1]: Listening on systemd-userdbd.socket - User Database Manager Socket. Mar 3 14:01:37.895329 systemd[1]: Mounting dev-hugepages.mount - Huge Pages File System... Mar 3 14:01:37.895342 systemd[1]: Mounting dev-mqueue.mount - POSIX Message Queue File System... Mar 3 14:01:37.895353 systemd[1]: Mounting media.mount - External Media Directory... Mar 3 14:01:37.895364 systemd[1]: proc-xen.mount - /proc/xen was skipped because of an unmet condition check (ConditionVirtualization=xen). Mar 3 14:01:37.895375 systemd[1]: Mounting sys-kernel-debug.mount - Kernel Debug File System... Mar 3 14:01:37.895385 systemd[1]: Mounting sys-kernel-tracing.mount - Kernel Trace File System... Mar 3 14:01:37.895396 systemd[1]: Mounting tmp.mount - Temporary Directory /tmp... Mar 3 14:01:37.895408 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 3 14:01:37.895418 systemd[1]: Reached target machines.target - Containers. Mar 3 14:01:37.895432 systemd[1]: Starting flatcar-tmpfiles.service - Create missing system files... Mar 3 14:01:37.895446 systemd[1]: ignition-delete-config.service - Ignition (delete config) was skipped because no trigger condition checks were met. Mar 3 14:01:37.895457 systemd[1]: Starting kmod-static-nodes.service - Create List of Static Device Nodes... Mar 3 14:01:37.895468 systemd[1]: Starting modprobe@configfs.service - Load Kernel Module configfs... Mar 3 14:01:37.895479 systemd[1]: Starting modprobe@dm_mod.service - Load Kernel Module dm_mod... Mar 3 14:01:37.895490 systemd[1]: Starting modprobe@drm.service - Load Kernel Module drm... Mar 3 14:01:37.895501 systemd[1]: Starting modprobe@efi_pstore.service - Load Kernel Module efi_pstore... Mar 3 14:01:37.895511 systemd[1]: Starting modprobe@fuse.service - Load Kernel Module fuse... Mar 3 14:01:37.895525 systemd[1]: Starting modprobe@loop.service - Load Kernel Module loop... Mar 3 14:01:37.895536 systemd[1]: setup-nsswitch.service - Create /etc/nsswitch.conf was skipped because of an unmet condition check (ConditionPathExists=!/etc/nsswitch.conf). Mar 3 14:01:37.895547 systemd[1]: systemd-fsck-root.service: Deactivated successfully. Mar 3 14:01:37.895558 systemd[1]: Stopped systemd-fsck-root.service - File System Check on Root Device. Mar 3 14:01:37.895569 systemd[1]: systemd-fsck-usr.service: Deactivated successfully. Mar 3 14:01:37.895580 systemd[1]: Stopped systemd-fsck-usr.service. Mar 3 14:01:37.895591 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 3 14:01:37.895602 systemd[1]: Starting systemd-journald.service - Journal Service... Mar 3 14:01:37.895612 systemd[1]: Starting systemd-modules-load.service - Load Kernel Modules... Mar 3 14:01:37.895626 kernel: loop: module loaded Mar 3 14:01:37.895636 kernel: fuse: init (API version 7.41) Mar 3 14:01:37.895672 systemd-journald[1489]: Collecting audit messages is disabled. Mar 3 14:01:37.895698 systemd[1]: Starting systemd-network-generator.service - Generate network units from Kernel command line... Mar 3 14:01:37.895714 systemd-journald[1489]: Journal started Mar 3 14:01:37.895740 systemd-journald[1489]: Runtime Journal (/run/log/journal/c37701f083ed418d9bf5c60bf9f727a7) is 8M, max 2.2G, 2.1G free. Mar 3 14:01:37.120216 systemd[1]: Queued start job for default target multi-user.target. Mar 3 14:01:37.144188 systemd[1]: Unnecessary job was removed for dev-sdb6.device - /dev/sdb6. Mar 3 14:01:37.144671 systemd[1]: systemd-journald.service: Deactivated successfully. Mar 3 14:01:37.907368 systemd[1]: Starting systemd-remount-fs.service - Remount Root and Kernel File Systems... Mar 3 14:01:37.918246 systemd[1]: Starting systemd-udev-load-credentials.service - Load udev Rules from Credentials... Mar 3 14:01:37.929348 systemd[1]: Starting systemd-udev-trigger.service - Coldplug All udev Devices... Mar 3 14:01:37.939146 systemd[1]: verity-setup.service: Deactivated successfully. Mar 3 14:01:37.939185 systemd[1]: Stopped verity-setup.service. Mar 3 14:01:37.951836 systemd[1]: xenserver-pv-version.service - Set fake PV driver version for XenServer was skipped because of an unmet condition check (ConditionVirtualization=xen). Mar 3 14:01:37.959175 systemd[1]: Started systemd-journald.service - Journal Service. Mar 3 14:01:37.963325 systemd[1]: Mounted dev-hugepages.mount - Huge Pages File System. Mar 3 14:01:37.967703 systemd[1]: Mounted dev-mqueue.mount - POSIX Message Queue File System. Mar 3 14:01:37.972263 systemd[1]: Mounted media.mount - External Media Directory. Mar 3 14:01:37.976331 systemd[1]: Mounted sys-kernel-debug.mount - Kernel Debug File System. Mar 3 14:01:37.980756 systemd[1]: Mounted sys-kernel-tracing.mount - Kernel Trace File System. Mar 3 14:01:37.985228 systemd[1]: Mounted tmp.mount - Temporary Directory /tmp. Mar 3 14:01:37.989326 systemd[1]: Finished flatcar-tmpfiles.service - Create missing system files. Mar 3 14:01:37.994663 systemd[1]: Finished kmod-static-nodes.service - Create List of Static Device Nodes. Mar 3 14:01:37.999872 systemd[1]: modprobe@configfs.service: Deactivated successfully. Mar 3 14:01:38.000064 systemd[1]: Finished modprobe@configfs.service - Load Kernel Module configfs. Mar 3 14:01:38.004960 systemd[1]: modprobe@dm_mod.service: Deactivated successfully. Mar 3 14:01:38.005156 systemd[1]: Finished modprobe@dm_mod.service - Load Kernel Module dm_mod. Mar 3 14:01:38.009936 systemd[1]: modprobe@efi_pstore.service: Deactivated successfully. Mar 3 14:01:38.010120 systemd[1]: Finished modprobe@efi_pstore.service - Load Kernel Module efi_pstore. Mar 3 14:01:38.015246 systemd[1]: modprobe@fuse.service: Deactivated successfully. Mar 3 14:01:38.015456 systemd[1]: Finished modprobe@fuse.service - Load Kernel Module fuse. Mar 3 14:01:38.022081 kernel: ACPI: bus type drm_connector registered Mar 3 14:01:38.022324 systemd[1]: modprobe@loop.service: Deactivated successfully. Mar 3 14:01:38.022512 systemd[1]: Finished modprobe@loop.service - Load Kernel Module loop. Mar 3 14:01:38.026993 systemd[1]: modprobe@drm.service: Deactivated successfully. Mar 3 14:01:38.027174 systemd[1]: Finished modprobe@drm.service - Load Kernel Module drm. Mar 3 14:01:38.031576 systemd[1]: Finished systemd-modules-load.service - Load Kernel Modules. Mar 3 14:01:38.036196 systemd[1]: Finished systemd-network-generator.service - Generate network units from Kernel command line. Mar 3 14:01:38.041412 systemd[1]: Finished systemd-remount-fs.service - Remount Root and Kernel File Systems. Mar 3 14:01:38.046703 systemd[1]: Finished systemd-udev-load-credentials.service - Load udev Rules from Credentials. Mar 3 14:01:38.060679 systemd[1]: Reached target network-pre.target - Preparation for Network. Mar 3 14:01:38.066575 systemd[1]: Mounting sys-fs-fuse-connections.mount - FUSE Control File System... Mar 3 14:01:38.085034 systemd[1]: Mounting sys-kernel-config.mount - Kernel Configuration File System... Mar 3 14:01:38.089230 systemd[1]: remount-root.service - Remount Root File System was skipped because of an unmet condition check (ConditionPathIsReadWrite=!/). Mar 3 14:01:38.089266 systemd[1]: Reached target local-fs.target - Local File Systems. Mar 3 14:01:38.094263 systemd[1]: Listening on systemd-sysext.socket - System Extension Image Management. Mar 3 14:01:38.100369 systemd[1]: Starting ldconfig.service - Rebuild Dynamic Linker Cache... Mar 3 14:01:38.104389 systemd[1]: systemd-binfmt.service - Set Up Additional Binary Formats was skipped because no trigger condition checks were met. Mar 3 14:01:38.105844 systemd[1]: Starting systemd-hwdb-update.service - Rebuild Hardware Database... Mar 3 14:01:38.110866 systemd[1]: Starting systemd-journal-flush.service - Flush Journal to Persistent Storage... Mar 3 14:01:38.115417 systemd[1]: systemd-pstore.service - Platform Persistent Storage Archival was skipped because of an unmet condition check (ConditionDirectoryNotEmpty=/sys/fs/pstore). Mar 3 14:01:38.116327 systemd[1]: Starting systemd-random-seed.service - Load/Save OS Random Seed... Mar 3 14:01:38.120546 systemd[1]: systemd-repart.service - Repartition Root Disk was skipped because no trigger condition checks were met. Mar 3 14:01:38.121436 systemd[1]: Starting systemd-sysctl.service - Apply Kernel Variables... Mar 3 14:01:38.126315 systemd[1]: Starting systemd-sysext.service - Merge System Extension Images into /usr/ and /opt/... Mar 3 14:01:38.131695 systemd[1]: Starting systemd-sysusers.service - Create System Users... Mar 3 14:01:38.137539 systemd[1]: Finished systemd-udev-trigger.service - Coldplug All udev Devices. Mar 3 14:01:38.139206 systemd[1]: Mounted sys-fs-fuse-connections.mount - FUSE Control File System. Mar 3 14:01:38.147052 systemd[1]: Mounted sys-kernel-config.mount - Kernel Configuration File System. Mar 3 14:01:38.158599 systemd-journald[1489]: Time spent on flushing to /var/log/journal/c37701f083ed418d9bf5c60bf9f727a7 is 14.109ms for 945 entries. Mar 3 14:01:38.158599 systemd-journald[1489]: System Journal (/var/log/journal/c37701f083ed418d9bf5c60bf9f727a7) is 8M, max 2.6G, 2.6G free. Mar 3 14:01:38.214632 systemd-journald[1489]: Received client request to flush runtime journal. Mar 3 14:01:38.185935 systemd[1]: Finished systemd-random-seed.service - Load/Save OS Random Seed. Mar 3 14:01:38.192302 systemd[1]: Reached target first-boot-complete.target - First Boot Complete. Mar 3 14:01:38.201554 systemd[1]: Starting systemd-machine-id-commit.service - Save Transient machine-id to Disk... Mar 3 14:01:38.222162 systemd[1]: Finished systemd-journal-flush.service - Flush Journal to Persistent Storage. Mar 3 14:01:38.249841 kernel: loop0: detected capacity change from 0 to 128560 Mar 3 14:01:38.285476 systemd[1]: etc-machine\x2did.mount: Deactivated successfully. Mar 3 14:01:38.286235 systemd[1]: Finished systemd-machine-id-commit.service - Save Transient machine-id to Disk. Mar 3 14:01:38.292656 systemd[1]: Finished systemd-sysctl.service - Apply Kernel Variables. Mar 3 14:01:38.362772 systemd[1]: Finished systemd-sysusers.service - Create System Users. Mar 3 14:01:38.368358 systemd[1]: Starting systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev... Mar 3 14:01:38.442545 systemd-tmpfiles[1540]: ACLs are not supported, ignoring. Mar 3 14:01:38.442565 systemd-tmpfiles[1540]: ACLs are not supported, ignoring. Mar 3 14:01:38.446291 systemd[1]: Finished systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev. Mar 3 14:01:39.035878 kernel: squashfs: version 4.0 (2009/01/31) Phillip Lougher Mar 3 14:01:39.097314 systemd[1]: Finished systemd-hwdb-update.service - Rebuild Hardware Database. Mar 3 14:01:39.103899 systemd[1]: Starting systemd-udevd.service - Rule-based Manager for Device Events and Files... Mar 3 14:01:39.144382 systemd-udevd[1546]: Using default interface naming scheme 'v255'. Mar 3 14:01:39.171840 kernel: loop1: detected capacity change from 0 to 110984 Mar 3 14:01:39.452074 systemd[1]: Started systemd-udevd.service - Rule-based Manager for Device Events and Files. Mar 3 14:01:39.460386 systemd[1]: Starting systemd-networkd.service - Network Configuration... Mar 3 14:01:39.519905 systemd[1]: Condition check resulted in dev-ttyS0.device - /dev/ttyS0 being skipped. Mar 3 14:01:39.547586 systemd[1]: Starting systemd-userdbd.service - User Database Manager... Mar 3 14:01:39.562843 kernel: hv_vmbus: registering driver hyperv_fb Mar 3 14:01:39.571642 kernel: hv_vmbus: registering driver hv_balloon Mar 3 14:01:39.571708 kernel: hyperv_fb: Synthvid Version major 3, minor 5 Mar 3 14:01:39.571731 kernel: hyperv_fb: Screen resolution: 1024x768, Color depth: 32, Frame buffer size: 8388608 Mar 3 14:01:39.579636 kernel: hv_balloon: Using Dynamic Memory protocol version 2.0 Mar 3 14:01:39.579692 kernel: Console: switching to colour dummy device 80x25 Mar 3 14:01:39.589056 kernel: mousedev: PS/2 mouse device common for all mice Mar 3 14:01:39.589109 kernel: Console: switching to colour frame buffer device 128x48 Mar 3 14:01:39.630083 systemd[1]: Started systemd-userdbd.service - User Database Manager. Mar 3 14:01:39.677194 systemd[1]: Starting systemd-vconsole-setup.service - Virtual Console Setup... Mar 3 14:01:39.690840 kernel: EDAC MC: Ver: 3.0.0 Mar 3 14:01:39.691383 systemd[1]: systemd-vconsole-setup.service: Deactivated successfully. Mar 3 14:01:39.691593 systemd[1]: Stopped systemd-vconsole-setup.service - Virtual Console Setup. Mar 3 14:01:39.698709 systemd[1]: Starting systemd-vconsole-setup.service - Virtual Console Setup... Mar 3 14:01:39.750287 systemd-networkd[1568]: lo: Link UP Mar 3 14:01:39.750590 systemd-networkd[1568]: lo: Gained carrier Mar 3 14:01:39.751923 systemd-networkd[1568]: Enumeration completed Mar 3 14:01:39.752127 systemd[1]: Started systemd-networkd.service - Network Configuration. Mar 3 14:01:39.752629 systemd-networkd[1568]: eth0: found matching network '/usr/lib/systemd/network/zz-default.network', based on potentially unpredictable interface name. Mar 3 14:01:39.752639 systemd-networkd[1568]: eth0: Configuring with /usr/lib/systemd/network/zz-default.network. Mar 3 14:01:39.754037 systemd-networkd[1568]: eth0: Link UP Mar 3 14:01:39.754042 systemd-networkd[1568]: eth0: Gained carrier Mar 3 14:01:39.754057 systemd-networkd[1568]: eth0: found matching network '/usr/lib/systemd/network/zz-default.network', based on potentially unpredictable interface name. Mar 3 14:01:39.756394 systemd[1]: Starting systemd-networkd-persistent-storage.service - Enable Persistent Storage in systemd-networkd... Mar 3 14:01:39.759954 systemd[1]: Starting systemd-networkd-wait-online.service - Wait for Network to be Configured... Mar 3 14:01:39.786360 kernel: loop2: detected capacity change from 0 to 27936 Mar 3 14:01:39.809878 systemd-networkd[1568]: eth0: DHCPv4 address 10.200.8.10/24, gateway 10.200.8.1 acquired from 168.63.129.16 Mar 3 14:01:39.818560 systemd[1]: Found device dev-disk-by\x2dlabel-OEM.device - Virtual_Disk OEM. Mar 3 14:01:39.821105 systemd[1]: Starting systemd-fsck@dev-disk-by\x2dlabel-OEM.service - File System Check on /dev/disk/by-label/OEM... Mar 3 14:01:39.837969 systemd[1]: Finished systemd-networkd-persistent-storage.service - Enable Persistent Storage in systemd-networkd. Mar 3 14:01:39.878391 systemd[1]: Finished systemd-fsck@dev-disk-by\x2dlabel-OEM.service - File System Check on /dev/disk/by-label/OEM. Mar 3 14:01:40.233409 systemd[1]: Finished systemd-vconsole-setup.service - Virtual Console Setup. Mar 3 14:01:40.355850 kernel: loop3: detected capacity change from 0 to 128560 Mar 3 14:01:40.374859 kernel: loop4: detected capacity change from 0 to 110984 Mar 3 14:01:40.391841 kernel: loop5: detected capacity change from 0 to 27936 Mar 3 14:01:40.406516 (sd-merge)[1706]: Using extensions 'containerd-flatcar', 'docker-flatcar', 'oem-azure'. Mar 3 14:01:40.407018 (sd-merge)[1706]: Merged extensions into '/usr'. Mar 3 14:01:40.410670 systemd[1]: Finished systemd-sysext.service - Merge System Extension Images into /usr/ and /opt/. Mar 3 14:01:40.417420 systemd[1]: Starting ensure-sysext.service... Mar 3 14:01:40.421041 systemd[1]: Starting systemd-tmpfiles-setup.service - Create System Files and Directories... Mar 3 14:01:40.457309 systemd[1]: Reload requested from client PID 1708 ('systemctl') (unit ensure-sysext.service)... Mar 3 14:01:40.457327 systemd[1]: Reloading... Mar 3 14:01:40.479678 systemd-tmpfiles[1709]: /usr/lib/tmpfiles.d/nfs-utils.conf:6: Duplicate line for path "/var/lib/nfs/sm", ignoring. Mar 3 14:01:40.479717 systemd-tmpfiles[1709]: /usr/lib/tmpfiles.d/nfs-utils.conf:7: Duplicate line for path "/var/lib/nfs/sm.bak", ignoring. Mar 3 14:01:40.480048 systemd-tmpfiles[1709]: /usr/lib/tmpfiles.d/provision.conf:20: Duplicate line for path "/root", ignoring. Mar 3 14:01:40.480350 systemd-tmpfiles[1709]: /usr/lib/tmpfiles.d/systemd-flatcar.conf:6: Duplicate line for path "/var/log/journal", ignoring. Mar 3 14:01:40.481291 systemd-tmpfiles[1709]: /usr/lib/tmpfiles.d/systemd.conf:29: Duplicate line for path "/var/lib/systemd", ignoring. Mar 3 14:01:40.481577 systemd-tmpfiles[1709]: ACLs are not supported, ignoring. Mar 3 14:01:40.481645 systemd-tmpfiles[1709]: ACLs are not supported, ignoring. Mar 3 14:01:40.496846 zram_generator::config[1739]: No configuration found. Mar 3 14:01:40.497466 systemd-tmpfiles[1709]: Detected autofs mount point /boot during canonicalization of boot. Mar 3 14:01:40.497481 systemd-tmpfiles[1709]: Skipping /boot Mar 3 14:01:40.505849 systemd-tmpfiles[1709]: Detected autofs mount point /boot during canonicalization of boot. Mar 3 14:01:40.505863 systemd-tmpfiles[1709]: Skipping /boot Mar 3 14:01:40.770876 systemd[1]: Reloading finished in 313 ms. Mar 3 14:01:40.837440 systemd[1]: Finished systemd-tmpfiles-setup.service - Create System Files and Directories. Mar 3 14:01:40.857883 systemd[1]: proc-xen.mount - /proc/xen was skipped because of an unmet condition check (ConditionVirtualization=xen). Mar 3 14:01:40.859119 systemd[1]: Starting audit-rules.service - Load Audit Rules... Mar 3 14:01:40.864353 systemd[1]: Starting clean-ca-certificates.service - Clean up broken links in /etc/ssl/certs... Mar 3 14:01:40.869003 systemd[1]: ignition-delete-config.service - Ignition (delete config) was skipped because no trigger condition checks were met. Mar 3 14:01:40.870090 systemd[1]: Starting modprobe@dm_mod.service - Load Kernel Module dm_mod... Mar 3 14:01:40.875128 systemd[1]: Starting modprobe@efi_pstore.service - Load Kernel Module efi_pstore... Mar 3 14:01:40.880381 systemd[1]: Starting modprobe@loop.service - Load Kernel Module loop... Mar 3 14:01:40.881978 systemd[1]: systemd-binfmt.service - Set Up Additional Binary Formats was skipped because no trigger condition checks were met. Mar 3 14:01:40.882104 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 3 14:01:40.883352 systemd[1]: Starting systemd-journal-catalog-update.service - Rebuild Journal Catalog... Mar 3 14:01:40.890590 systemd[1]: Starting systemd-resolved.service - Network Name Resolution... Mar 3 14:01:40.895546 systemd[1]: Starting systemd-update-utmp.service - Record System Boot/Shutdown in UTMP... Mar 3 14:01:40.900078 systemd[1]: xenserver-pv-version.service - Set fake PV driver version for XenServer was skipped because of an unmet condition check (ConditionVirtualization=xen). Mar 3 14:01:40.902238 systemd[1]: modprobe@dm_mod.service: Deactivated successfully. Mar 3 14:01:40.902424 systemd[1]: Finished modprobe@dm_mod.service - Load Kernel Module dm_mod. Mar 3 14:01:40.907375 systemd[1]: modprobe@efi_pstore.service: Deactivated successfully. Mar 3 14:01:40.907566 systemd[1]: Finished modprobe@efi_pstore.service - Load Kernel Module efi_pstore. Mar 3 14:01:40.912670 systemd[1]: modprobe@loop.service: Deactivated successfully. Mar 3 14:01:40.912894 systemd[1]: Finished modprobe@loop.service - Load Kernel Module loop. Mar 3 14:01:40.929029 systemd[1]: Finished systemd-update-utmp.service - Record System Boot/Shutdown in UTMP. Mar 3 14:01:40.940224 systemd[1]: proc-xen.mount - /proc/xen was skipped because of an unmet condition check (ConditionVirtualization=xen). Mar 3 14:01:40.940508 systemd[1]: ignition-delete-config.service - Ignition (delete config) was skipped because no trigger condition checks were met. Mar 3 14:01:40.941722 systemd[1]: Starting modprobe@dm_mod.service - Load Kernel Module dm_mod... Mar 3 14:01:40.946880 systemd[1]: Starting modprobe@drm.service - Load Kernel Module drm... Mar 3 14:01:40.951805 systemd[1]: Starting modprobe@efi_pstore.service - Load Kernel Module efi_pstore... Mar 3 14:01:40.966057 systemd[1]: Starting modprobe@loop.service - Load Kernel Module loop... Mar 3 14:01:40.970098 systemd[1]: systemd-binfmt.service - Set Up Additional Binary Formats was skipped because no trigger condition checks were met. Mar 3 14:01:40.970230 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 3 14:01:40.970407 systemd[1]: Reached target time-set.target - System Time Set. Mar 3 14:01:40.974288 systemd[1]: xenserver-pv-version.service - Set fake PV driver version for XenServer was skipped because of an unmet condition check (ConditionVirtualization=xen). Mar 3 14:01:40.975937 systemd[1]: modprobe@dm_mod.service: Deactivated successfully. Mar 3 14:01:40.976151 systemd[1]: Finished modprobe@dm_mod.service - Load Kernel Module dm_mod. Mar 3 14:01:40.981079 systemd[1]: modprobe@drm.service: Deactivated successfully. Mar 3 14:01:40.981274 systemd[1]: Finished modprobe@drm.service - Load Kernel Module drm. Mar 3 14:01:40.985870 systemd[1]: modprobe@efi_pstore.service: Deactivated successfully. Mar 3 14:01:40.986069 systemd[1]: Finished modprobe@efi_pstore.service - Load Kernel Module efi_pstore. Mar 3 14:01:40.991494 systemd[1]: modprobe@loop.service: Deactivated successfully. Mar 3 14:01:40.991682 systemd[1]: Finished modprobe@loop.service - Load Kernel Module loop. Mar 3 14:01:40.999260 systemd[1]: Finished ensure-sysext.service. Mar 3 14:01:41.005436 systemd[1]: systemd-pstore.service - Platform Persistent Storage Archival was skipped because of an unmet condition check (ConditionDirectoryNotEmpty=/sys/fs/pstore). Mar 3 14:01:41.005494 systemd[1]: systemd-repart.service - Repartition Root Disk was skipped because no trigger condition checks were met. Mar 3 14:01:41.028146 systemd[1]: Finished systemd-journal-catalog-update.service - Rebuild Journal Catalog. Mar 3 14:01:41.064693 systemd-resolved[1807]: Positive Trust Anchors: Mar 3 14:01:41.064711 systemd-resolved[1807]: . IN DS 20326 8 2 e06d44b80b8f1d39a95c0b0d7c65d08458e880409bbc683457104237c7f8ec8d Mar 3 14:01:41.064742 systemd-resolved[1807]: 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 3 14:01:41.097047 augenrules[1843]: No rules Mar 3 14:01:41.098272 systemd[1]: audit-rules.service: Deactivated successfully. Mar 3 14:01:41.098517 systemd[1]: Finished audit-rules.service - Load Audit Rules. Mar 3 14:01:41.139163 systemd-resolved[1807]: Using system hostname 'ci-4459.2.4-a-868b7edfa5'. Mar 3 14:01:41.140921 systemd[1]: Started systemd-resolved.service - Network Name Resolution. Mar 3 14:01:41.145254 systemd[1]: Reached target network.target - Network. Mar 3 14:01:41.148733 systemd[1]: Reached target nss-lookup.target - Host and Network Name Lookups. Mar 3 14:01:41.332987 systemd-networkd[1568]: eth0: Gained IPv6LL Mar 3 14:01:41.335440 systemd[1]: Finished systemd-networkd-wait-online.service - Wait for Network to be Configured. Mar 3 14:01:41.340988 systemd[1]: Reached target network-online.target - Network is Online. Mar 3 14:01:41.770114 systemd[1]: Finished clean-ca-certificates.service - Clean up broken links in /etc/ssl/certs. Mar 3 14:01:41.775765 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 3 14:01:45.829785 ldconfig[1518]: /sbin/ldconfig: /usr/lib/ld.so.conf is not an ELF file - it has the wrong magic bytes at the start. Mar 3 14:01:45.844490 systemd[1]: Finished ldconfig.service - Rebuild Dynamic Linker Cache. Mar 3 14:01:45.851433 systemd[1]: Starting systemd-update-done.service - Update is Completed... Mar 3 14:01:45.878847 systemd[1]: Finished systemd-update-done.service - Update is Completed. Mar 3 14:01:45.883457 systemd[1]: Reached target sysinit.target - System Initialization. Mar 3 14:01:45.887926 systemd[1]: Started motdgen.path - Watch for update engine configuration changes. Mar 3 14:01:45.892937 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 3 14:01:45.897926 systemd[1]: Started google-oslogin-cache.timer - NSS cache refresh timer. Mar 3 14:01:45.902792 systemd[1]: Started logrotate.timer - Daily rotation of log files. Mar 3 14:01:45.907235 systemd[1]: Started mdadm.timer - Weekly check for MD array's redundancy information.. Mar 3 14:01:45.912392 systemd[1]: Started systemd-tmpfiles-clean.timer - Daily Cleanup of Temporary Directories. Mar 3 14:01:45.917552 systemd[1]: update-engine-stub.timer - Update Engine Stub Timer was skipped because of an unmet condition check (ConditionPathExists=/usr/.noupdate). Mar 3 14:01:45.917609 systemd[1]: Reached target paths.target - Path Units. Mar 3 14:01:45.921257 systemd[1]: Reached target timers.target - Timer Units. Mar 3 14:01:45.925948 systemd[1]: Listening on dbus.socket - D-Bus System Message Bus Socket. Mar 3 14:01:45.931448 systemd[1]: Starting docker.socket - Docker Socket for the API... Mar 3 14:01:45.937213 systemd[1]: Listening on sshd-unix-local.socket - OpenSSH Server Socket (systemd-ssh-generator, AF_UNIX Local). Mar 3 14:01:45.942361 systemd[1]: Listening on sshd-vsock.socket - OpenSSH Server Socket (systemd-ssh-generator, AF_VSOCK). Mar 3 14:01:45.947371 systemd[1]: Reached target ssh-access.target - SSH Access Available. Mar 3 14:01:45.954282 systemd[1]: Listening on sshd.socket - OpenSSH Server Socket. Mar 3 14:01:45.958598 systemd[1]: Listening on systemd-hostnamed.socket - Hostname Service Socket. Mar 3 14:01:45.963810 systemd[1]: Listening on docker.socket - Docker Socket for the API. Mar 3 14:01:45.969023 systemd[1]: Reached target sockets.target - Socket Units. Mar 3 14:01:45.972794 systemd[1]: Reached target basic.target - Basic System. Mar 3 14:01:45.976446 systemd[1]: addon-config@oem.service - Configure Addon /oem was skipped because no trigger condition checks were met. Mar 3 14:01:45.976477 systemd[1]: addon-run@oem.service - Run Addon /oem was skipped because no trigger condition checks were met. Mar 3 14:01:45.978979 systemd[1]: Starting chronyd.service - NTP client/server... Mar 3 14:01:45.983137 systemd[1]: Starting containerd.service - containerd container runtime... Mar 3 14:01:45.989007 systemd[1]: Starting coreos-metadata.service - Flatcar Metadata Agent... Mar 3 14:01:45.996412 systemd[1]: Starting dbus.service - D-Bus System Message Bus... Mar 3 14:01:46.001024 systemd[1]: Starting dracut-shutdown.service - Restore /run/initramfs on shutdown... Mar 3 14:01:46.006377 systemd[1]: Starting enable-oem-cloudinit.service - Enable cloudinit... Mar 3 14:01:46.012045 systemd[1]: Starting extend-filesystems.service - Extend Filesystems... Mar 3 14:01:46.016024 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 3 14:01:46.017094 systemd[1]: Starting google-oslogin-cache.service - NSS cache refresh... Mar 3 14:01:46.021144 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 3 14:01:46.022119 systemd[1]: Started hv_kvp_daemon.service - Hyper-V KVP daemon. Mar 3 14:01:46.026242 systemd[1]: hv_vss_daemon.service - Hyper-V VSS daemon was skipped because of an unmet condition check (ConditionPathExists=/dev/vmbus/hv_vss). Mar 3 14:01:46.027759 systemd[1]: Starting motdgen.service - Generate /run/flatcar/motd... Mar 3 14:01:46.030388 systemd[1]: Starting nvidia.service - NVIDIA Configure Service... Mar 3 14:01:46.035275 jq[1864]: false Mar 3 14:01:46.036171 systemd[1]: Starting ssh-key-proc-cmdline.service - Install an ssh key from /proc/cmdline... Mar 3 14:01:46.040878 systemd[1]: Starting sshd-keygen.service - Generate sshd host keys... Mar 3 14:01:46.047802 systemd[1]: Starting systemd-logind.service - User Login Management... Mar 3 14:01:46.050182 systemd[1]: tcsd.service - TCG Core Services Daemon was skipped because of an unmet condition check (ConditionPathExists=/dev/tpm0). Mar 3 14:01:46.050642 systemd[1]: cgroup compatibility translation between legacy and unified hierarchy settings activated. See cgroup-compat debug messages for details. Mar 3 14:01:46.051243 systemd[1]: Starting update-engine.service - Update Engine... Mar 3 14:01:46.056276 systemd[1]: Starting update-ssh-keys-after-ignition.service - Run update-ssh-keys once after Ignition... Mar 3 14:01:46.063288 systemd[1]: enable-oem-cloudinit.service: Skipped due to 'exec-condition'. Mar 3 14:01:46.063546 systemd[1]: Condition check resulted in enable-oem-cloudinit.service - Enable cloudinit being skipped. Mar 3 14:01:46.063881 systemd[1]: ssh-key-proc-cmdline.service: Deactivated successfully. Mar 3 14:01:46.064074 systemd[1]: Finished ssh-key-proc-cmdline.service - Install an ssh key from /proc/cmdline. Mar 3 14:01:46.069877 extend-filesystems[1865]: Found /dev/sdb6 Mar 3 14:01:46.073878 KVP[1867]: KVP starting; pid is:1867 Mar 3 14:01:46.076729 chronyd[1856]: chronyd version 4.7 starting (+CMDMON +REFCLOCK +RTC +PRIVDROP +SCFILTER -SIGND +NTS +SECHASH +IPV6 -DEBUG) Mar 3 14:01:46.076870 KVP[1867]: KVP LIC Version: 3.1 Mar 3 14:01:46.081837 kernel: hv_utils: KVP IC version 4.0 Mar 3 14:01:46.081914 extend-filesystems[1865]: Found /dev/sdb9 Mar 3 14:01:46.081914 extend-filesystems[1865]: Checking size of /dev/sdb9 Mar 3 14:01:46.078880 systemd[1]: Finished dracut-shutdown.service - Restore /run/initramfs on shutdown. Mar 3 14:01:46.090896 oslogin_cache_refresh[1866]: Refreshing passwd entry cache Mar 3 14:01:46.093291 google_oslogin_nss_cache[1866]: oslogin_cache_refresh[1866]: Refreshing passwd entry cache Mar 3 14:01:46.093027 systemd[1]: motdgen.service: Deactivated successfully. Mar 3 14:01:46.093268 systemd[1]: Finished motdgen.service - Generate /run/flatcar/motd. Mar 3 14:01:46.093662 jq[1880]: true Mar 3 14:01:46.101431 google_oslogin_nss_cache[1866]: oslogin_cache_refresh[1866]: Failure getting users, quitting Mar 3 14:01:46.101431 google_oslogin_nss_cache[1866]: oslogin_cache_refresh[1866]: Produced empty passwd cache file, removing /etc/oslogin_passwd.cache.bak. Mar 3 14:01:46.101415 oslogin_cache_refresh[1866]: Failure getting users, quitting Mar 3 14:01:46.101802 google_oslogin_nss_cache[1866]: oslogin_cache_refresh[1866]: Refreshing group entry cache Mar 3 14:01:46.101434 oslogin_cache_refresh[1866]: Produced empty passwd cache file, removing /etc/oslogin_passwd.cache.bak. Mar 3 14:01:46.101478 oslogin_cache_refresh[1866]: Refreshing group entry cache Mar 3 14:01:46.105267 (ntainerd)[1892]: containerd.service: Referenced but unset environment variable evaluates to an empty string: TORCX_IMAGEDIR, TORCX_UNPACKDIR Mar 3 14:01:46.108695 jq[1889]: true Mar 3 14:01:46.109249 google_oslogin_nss_cache[1866]: oslogin_cache_refresh[1866]: Failure getting groups, quitting Mar 3 14:01:46.109249 google_oslogin_nss_cache[1866]: oslogin_cache_refresh[1866]: Produced empty group cache file, removing /etc/oslogin_group.cache.bak. Mar 3 14:01:46.109170 oslogin_cache_refresh[1866]: Failure getting groups, quitting Mar 3 14:01:46.109183 oslogin_cache_refresh[1866]: Produced empty group cache file, removing /etc/oslogin_group.cache.bak. Mar 3 14:01:46.110416 systemd[1]: google-oslogin-cache.service: Deactivated successfully. Mar 3 14:01:46.110724 systemd[1]: Finished google-oslogin-cache.service - NSS cache refresh. Mar 3 14:01:46.113922 update_engine[1878]: I20260303 14:01:46.113852 1878 main.cc:92] Flatcar Update Engine starting Mar 3 14:01:46.134028 chronyd[1856]: Timezone right/UTC failed leap second check, ignoring Mar 3 14:01:46.134190 chronyd[1856]: Loaded seccomp filter (level 2) Mar 3 14:01:46.134299 systemd[1]: Started chronyd.service - NTP client/server. Mar 3 14:01:46.156759 extend-filesystems[1865]: Old size kept for /dev/sdb9 Mar 3 14:01:46.160598 systemd[1]: extend-filesystems.service: Deactivated successfully. Mar 3 14:01:46.160860 systemd[1]: Finished extend-filesystems.service - Extend Filesystems. Mar 3 14:01:46.171917 systemd-logind[1877]: New seat seat0. Mar 3 14:01:46.173043 systemd-logind[1877]: Watching system buttons on /dev/input/event0 (AT Translated Set 2 keyboard) Mar 3 14:01:46.173354 systemd[1]: Started systemd-logind.service - User Login Management. Mar 3 14:01:46.223896 bash[1920]: Updated "/home/core/.ssh/authorized_keys" Mar 3 14:01:46.225142 systemd[1]: Finished update-ssh-keys-after-ignition.service - Run update-ssh-keys once after Ignition. Mar 3 14:01:46.237180 sshd_keygen[1893]: ssh-keygen: generating new host keys: RSA ECDSA ED25519 Mar 3 14:01:46.245707 systemd[1]: sshkeys.service was skipped because no trigger condition checks were met. Mar 3 14:01:46.257797 systemd[1]: Finished sshd-keygen.service - Generate sshd host keys. Mar 3 14:01:46.263327 systemd[1]: Starting issuegen.service - Generate /run/issue... Mar 3 14:01:46.268635 setup-nvidia[1869]: Downloading Flatcar Container Linux Developer Container for version: 4459.2.4 Mar 3 14:01:46.280115 systemd[1]: Starting waagent.service - Microsoft Azure Linux Agent... Mar 3 14:01:46.286111 systemd[1]: issuegen.service: Deactivated successfully. Mar 3 14:01:46.286365 systemd[1]: Finished issuegen.service - Generate /run/issue. Mar 3 14:01:46.292767 systemd[1]: Starting systemd-user-sessions.service - Permit User Sessions... Mar 3 14:01:46.303109 systemd[1]: Started waagent.service - Microsoft Azure Linux Agent. Mar 3 14:01:46.307618 systemd[1]: Finished systemd-user-sessions.service - Permit User Sessions. Mar 3 14:01:46.313322 dbus-daemon[1859]: [system] SELinux support is enabled Mar 3 14:01:46.313978 systemd[1]: Started getty@tty1.service - Getty on tty1. Mar 3 14:01:46.316957 update_engine[1878]: I20260303 14:01:46.316872 1878 update_check_scheduler.cc:74] Next update check in 9m10s Mar 3 14:01:46.318644 systemd[1]: Started serial-getty@ttyS0.service - Serial Getty on ttyS0. Mar 3 14:01:46.323104 systemd[1]: Reached target getty.target - Login Prompts. Mar 3 14:01:46.327112 systemd[1]: Started dbus.service - D-Bus System Message Bus. Mar 3 14:01:46.333702 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 3 14:01:46.333733 systemd[1]: Reached target system-config.target - Load system-provided cloud configs. Mar 3 14:01:46.334599 dbus-daemon[1859]: [system] Successfully activated service 'org.freedesktop.systemd1' Mar 3 14:01:46.338855 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 3 14:01:46.338889 systemd[1]: Reached target user-config.target - Load user-provided cloud configs. Mar 3 14:01:46.343785 systemd[1]: Started update-engine.service - Update Engine. Mar 3 14:01:46.349309 systemd[1]: Started locksmithd.service - Cluster reboot manager. Mar 3 14:01:46.433038 coreos-metadata[1858]: Mar 03 14:01:46.432 INFO Fetching http://168.63.129.16/?comp=versions: Attempt #1 Mar 3 14:01:46.434901 coreos-metadata[1858]: Mar 03 14:01:46.434 INFO Fetch successful Mar 3 14:01:46.435072 coreos-metadata[1858]: Mar 03 14:01:46.435 INFO Fetching http://168.63.129.16/machine/?comp=goalstate: Attempt #1 Mar 3 14:01:46.438666 coreos-metadata[1858]: Mar 03 14:01:46.438 INFO Fetch successful Mar 3 14:01:46.438980 coreos-metadata[1858]: Mar 03 14:01:46.438 INFO Fetching http://168.63.129.16/machine/8672f615-443b-40e5-b579-f6ed8f03a03a/887ef4bc%2Da0c4%2D4b21%2Dad21%2D67d164ab3519.%5Fci%2D4459.2.4%2Da%2D868b7edfa5?comp=config&type=sharedConfig&incarnation=1: Attempt #1 Mar 3 14:01:46.471796 coreos-metadata[1858]: Mar 03 14:01:46.471 INFO Fetch successful Mar 3 14:01:46.471975 coreos-metadata[1858]: Mar 03 14:01:46.471 INFO Fetching http://169.254.169.254/metadata/instance/compute/vmSize?api-version=2017-08-01&format=text: Attempt #1 Mar 3 14:01:46.478355 coreos-metadata[1858]: Mar 03 14:01:46.478 INFO Fetch successful Mar 3 14:01:46.517111 systemd[1]: Finished coreos-metadata.service - Flatcar Metadata Agent. Mar 3 14:01:46.521832 systemd[1]: packet-phone-home.service - Report Success to Packet was skipped because no trigger condition checks were met. Mar 3 14:01:46.739205 locksmithd[2019]: locksmithd starting currentOperation="UPDATE_STATUS_IDLE" strategy="reboot" Mar 3 14:01:46.775039 setup-nvidia[2029]: % Total % Received % Xferd Average Speed Time Time Time Current Mar 3 14:01:46.775309 setup-nvidia[2029]: Dload Upload Total Spent Left Speed Mar 3 14:01:47.530729 containerd[1892]: time="2026-03-03T14:01:47Z" 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 3 14:01:47.531355 containerd[1892]: time="2026-03-03T14:01:47.531320300Z" level=info msg="starting containerd" revision=4ac6c20c7bbf8177f29e46bbdc658fec02ffb8ad version=v2.0.7 Mar 3 14:01:47.540436 containerd[1892]: time="2026-03-03T14:01:47.540401100Z" level=warning msg="Configuration migrated from version 2, use `containerd config migrate` to avoid migration" t="13.9µs" Mar 3 14:01:47.540496 containerd[1892]: time="2026-03-03T14:01:47.540431700Z" level=info msg="loading plugin" id=io.containerd.image-verifier.v1.bindir type=io.containerd.image-verifier.v1 Mar 3 14:01:47.540496 containerd[1892]: time="2026-03-03T14:01:47.540457800Z" level=info msg="loading plugin" id=io.containerd.internal.v1.opt type=io.containerd.internal.v1 Mar 3 14:01:47.540714 containerd[1892]: time="2026-03-03T14:01:47.540681300Z" level=info msg="loading plugin" id=io.containerd.warning.v1.deprecations type=io.containerd.warning.v1 Mar 3 14:01:47.540877 containerd[1892]: time="2026-03-03T14:01:47.540776200Z" level=info msg="loading plugin" id=io.containerd.content.v1.content type=io.containerd.content.v1 Mar 3 14:01:47.540877 containerd[1892]: time="2026-03-03T14:01:47.540841800Z" level=info msg="loading plugin" id=io.containerd.snapshotter.v1.blockfile type=io.containerd.snapshotter.v1 Mar 3 14:01:47.540941 containerd[1892]: time="2026-03-03T14:01:47.540921500Z" 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 3 14:01:47.540969 containerd[1892]: time="2026-03-03T14:01:47.540941800Z" level=info msg="loading plugin" id=io.containerd.snapshotter.v1.btrfs type=io.containerd.snapshotter.v1 Mar 3 14:01:47.541280 containerd[1892]: time="2026-03-03T14:01:47.541248900Z" level=info msg="skip loading plugin" error="path /var/lib/containerd/io.containerd.snapshotter.v1.btrfs (ext4) must be a btrfs filesystem to be used with the btrfs snapshotter: skip plugin" id=io.containerd.snapshotter.v1.btrfs type=io.containerd.snapshotter.v1 Mar 3 14:01:47.541280 containerd[1892]: time="2026-03-03T14:01:47.541271200Z" level=info msg="loading plugin" id=io.containerd.snapshotter.v1.devmapper type=io.containerd.snapshotter.v1 Mar 3 14:01:47.541365 containerd[1892]: time="2026-03-03T14:01:47.541285000Z" level=info msg="skip loading plugin" error="devmapper not configured: skip plugin" id=io.containerd.snapshotter.v1.devmapper type=io.containerd.snapshotter.v1 Mar 3 14:01:47.541365 containerd[1892]: time="2026-03-03T14:01:47.541293400Z" level=info msg="loading plugin" id=io.containerd.snapshotter.v1.native type=io.containerd.snapshotter.v1 Mar 3 14:01:47.541438 containerd[1892]: time="2026-03-03T14:01:47.541420100Z" level=info msg="loading plugin" id=io.containerd.snapshotter.v1.overlayfs type=io.containerd.snapshotter.v1 Mar 3 14:01:47.541669 containerd[1892]: time="2026-03-03T14:01:47.541638700Z" level=info msg="loading plugin" id=io.containerd.snapshotter.v1.zfs type=io.containerd.snapshotter.v1 Mar 3 14:01:47.541709 containerd[1892]: time="2026-03-03T14:01:47.541678300Z" 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 3 14:01:47.541709 containerd[1892]: time="2026-03-03T14:01:47.541689100Z" level=info msg="loading plugin" id=io.containerd.event.v1.exchange type=io.containerd.event.v1 Mar 3 14:01:47.541763 containerd[1892]: time="2026-03-03T14:01:47.541717200Z" level=info msg="loading plugin" id=io.containerd.monitor.task.v1.cgroups type=io.containerd.monitor.task.v1 Mar 3 14:01:47.541984 containerd[1892]: time="2026-03-03T14:01:47.541956300Z" level=info msg="loading plugin" id=io.containerd.metadata.v1.bolt type=io.containerd.metadata.v1 Mar 3 14:01:47.542064 containerd[1892]: time="2026-03-03T14:01:47.542042300Z" level=info msg="metadata content store policy set" policy=shared Mar 3 14:01:47.558508 containerd[1892]: time="2026-03-03T14:01:47.558465200Z" level=info msg="loading plugin" id=io.containerd.gc.v1.scheduler type=io.containerd.gc.v1 Mar 3 14:01:47.558578 containerd[1892]: time="2026-03-03T14:01:47.558521100Z" level=info msg="loading plugin" id=io.containerd.differ.v1.walking type=io.containerd.differ.v1 Mar 3 14:01:47.558578 containerd[1892]: time="2026-03-03T14:01:47.558537600Z" level=info msg="loading plugin" id=io.containerd.lease.v1.manager type=io.containerd.lease.v1 Mar 3 14:01:47.558578 containerd[1892]: time="2026-03-03T14:01:47.558549100Z" level=info msg="loading plugin" id=io.containerd.service.v1.containers-service type=io.containerd.service.v1 Mar 3 14:01:47.558578 containerd[1892]: time="2026-03-03T14:01:47.558561400Z" level=info msg="loading plugin" id=io.containerd.service.v1.content-service type=io.containerd.service.v1 Mar 3 14:01:47.558578 containerd[1892]: time="2026-03-03T14:01:47.558572100Z" level=info msg="loading plugin" id=io.containerd.service.v1.diff-service type=io.containerd.service.v1 Mar 3 14:01:47.558697 containerd[1892]: time="2026-03-03T14:01:47.558585100Z" level=info msg="loading plugin" id=io.containerd.service.v1.images-service type=io.containerd.service.v1 Mar 3 14:01:47.558697 containerd[1892]: time="2026-03-03T14:01:47.558596700Z" level=info msg="loading plugin" id=io.containerd.service.v1.introspection-service type=io.containerd.service.v1 Mar 3 14:01:47.558697 containerd[1892]: time="2026-03-03T14:01:47.558607700Z" level=info msg="loading plugin" id=io.containerd.service.v1.namespaces-service type=io.containerd.service.v1 Mar 3 14:01:47.558697 containerd[1892]: time="2026-03-03T14:01:47.558618600Z" level=info msg="loading plugin" id=io.containerd.service.v1.snapshots-service type=io.containerd.service.v1 Mar 3 14:01:47.558697 containerd[1892]: time="2026-03-03T14:01:47.558627500Z" level=info msg="loading plugin" id=io.containerd.shim.v1.manager type=io.containerd.shim.v1 Mar 3 14:01:47.558697 containerd[1892]: time="2026-03-03T14:01:47.558638900Z" level=info msg="loading plugin" id=io.containerd.runtime.v2.task type=io.containerd.runtime.v2 Mar 3 14:01:47.558839 containerd[1892]: time="2026-03-03T14:01:47.558741700Z" level=info msg="loading plugin" id=io.containerd.service.v1.tasks-service type=io.containerd.service.v1 Mar 3 14:01:47.558839 containerd[1892]: time="2026-03-03T14:01:47.558761500Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.containers type=io.containerd.grpc.v1 Mar 3 14:01:47.558839 containerd[1892]: time="2026-03-03T14:01:47.558775800Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.content type=io.containerd.grpc.v1 Mar 3 14:01:47.558839 containerd[1892]: time="2026-03-03T14:01:47.558786900Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.diff type=io.containerd.grpc.v1 Mar 3 14:01:47.558839 containerd[1892]: time="2026-03-03T14:01:47.558802900Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.events type=io.containerd.grpc.v1 Mar 3 14:01:47.558839 containerd[1892]: time="2026-03-03T14:01:47.558813800Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.images type=io.containerd.grpc.v1 Mar 3 14:01:47.558966 containerd[1892]: time="2026-03-03T14:01:47.558845700Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.introspection type=io.containerd.grpc.v1 Mar 3 14:01:47.558966 containerd[1892]: time="2026-03-03T14:01:47.558858100Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.leases type=io.containerd.grpc.v1 Mar 3 14:01:47.558966 containerd[1892]: time="2026-03-03T14:01:47.558869600Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.namespaces type=io.containerd.grpc.v1 Mar 3 14:01:47.558966 containerd[1892]: time="2026-03-03T14:01:47.558879200Z" level=info msg="loading plugin" id=io.containerd.sandbox.store.v1.local type=io.containerd.sandbox.store.v1 Mar 3 14:01:47.558966 containerd[1892]: time="2026-03-03T14:01:47.558890000Z" level=info msg="loading plugin" id=io.containerd.cri.v1.images type=io.containerd.cri.v1 Mar 3 14:01:47.558966 containerd[1892]: time="2026-03-03T14:01:47.558930400Z" level=info msg="Get image filesystem path \"/var/lib/containerd/io.containerd.snapshotter.v1.overlayfs\" for snapshotter \"overlayfs\"" Mar 3 14:01:47.558966 containerd[1892]: time="2026-03-03T14:01:47.558943500Z" level=info msg="Start snapshots syncer" Mar 3 14:01:47.559118 containerd[1892]: time="2026-03-03T14:01:47.558970800Z" level=info msg="loading plugin" id=io.containerd.cri.v1.runtime type=io.containerd.cri.v1 Mar 3 14:01:47.559269 containerd[1892]: time="2026-03-03T14:01:47.559213700Z" 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 3 14:01:47.559387 containerd[1892]: time="2026-03-03T14:01:47.559275000Z" level=info msg="loading plugin" id=io.containerd.podsandbox.controller.v1.podsandbox type=io.containerd.podsandbox.controller.v1 Mar 3 14:01:47.559387 containerd[1892]: time="2026-03-03T14:01:47.559332300Z" level=info msg="loading plugin" id=io.containerd.sandbox.controller.v1.shim type=io.containerd.sandbox.controller.v1 Mar 3 14:01:47.559464 containerd[1892]: time="2026-03-03T14:01:47.559439400Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.sandbox-controllers type=io.containerd.grpc.v1 Mar 3 14:01:47.559499 containerd[1892]: time="2026-03-03T14:01:47.559471000Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.sandboxes type=io.containerd.grpc.v1 Mar 3 14:01:47.559499 containerd[1892]: time="2026-03-03T14:01:47.559483100Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.snapshots type=io.containerd.grpc.v1 Mar 3 14:01:47.559499 containerd[1892]: time="2026-03-03T14:01:47.559493600Z" level=info msg="loading plugin" id=io.containerd.streaming.v1.manager type=io.containerd.streaming.v1 Mar 3 14:01:47.559571 containerd[1892]: time="2026-03-03T14:01:47.559506100Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.streaming type=io.containerd.grpc.v1 Mar 3 14:01:47.559571 containerd[1892]: time="2026-03-03T14:01:47.559516600Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.tasks type=io.containerd.grpc.v1 Mar 3 14:01:47.559571 containerd[1892]: time="2026-03-03T14:01:47.559526900Z" level=info msg="loading plugin" id=io.containerd.transfer.v1.local type=io.containerd.transfer.v1 Mar 3 14:01:47.559571 containerd[1892]: time="2026-03-03T14:01:47.559546300Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.transfer type=io.containerd.grpc.v1 Mar 3 14:01:47.559571 containerd[1892]: time="2026-03-03T14:01:47.559556800Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.version type=io.containerd.grpc.v1 Mar 3 14:01:47.559571 containerd[1892]: time="2026-03-03T14:01:47.559566200Z" level=info msg="loading plugin" id=io.containerd.monitor.container.v1.restart type=io.containerd.monitor.container.v1 Mar 3 14:01:47.559692 containerd[1892]: time="2026-03-03T14:01:47.559592100Z" level=info msg="loading plugin" id=io.containerd.tracing.processor.v1.otlp type=io.containerd.tracing.processor.v1 Mar 3 14:01:47.559692 containerd[1892]: time="2026-03-03T14:01:47.559606600Z" 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 3 14:01:47.559692 containerd[1892]: time="2026-03-03T14:01:47.559615200Z" level=info msg="loading plugin" id=io.containerd.internal.v1.tracing type=io.containerd.internal.v1 Mar 3 14:01:47.559692 containerd[1892]: time="2026-03-03T14:01:47.559623700Z" 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 3 14:01:47.559692 containerd[1892]: time="2026-03-03T14:01:47.559631500Z" level=info msg="loading plugin" id=io.containerd.ttrpc.v1.otelttrpc type=io.containerd.ttrpc.v1 Mar 3 14:01:47.559692 containerd[1892]: time="2026-03-03T14:01:47.559639500Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.healthcheck type=io.containerd.grpc.v1 Mar 3 14:01:47.559692 containerd[1892]: time="2026-03-03T14:01:47.559656200Z" level=info msg="loading plugin" id=io.containerd.nri.v1.nri type=io.containerd.nri.v1 Mar 3 14:01:47.559692 containerd[1892]: time="2026-03-03T14:01:47.559671900Z" level=info msg="runtime interface created" Mar 3 14:01:47.559692 containerd[1892]: time="2026-03-03T14:01:47.559677400Z" level=info msg="created NRI interface" Mar 3 14:01:47.559692 containerd[1892]: time="2026-03-03T14:01:47.559685000Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.cri type=io.containerd.grpc.v1 Mar 3 14:01:47.559922 containerd[1892]: time="2026-03-03T14:01:47.559695000Z" level=info msg="Connect containerd service" Mar 3 14:01:47.559922 containerd[1892]: time="2026-03-03T14:01:47.559712200Z" level=info msg="using experimental NRI integration - disable nri plugin to prevent this" Mar 3 14:01:47.560369 containerd[1892]: time="2026-03-03T14:01:47.560339300Z" 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 3 14:01:48.077658 containerd[1892]: time="2026-03-03T14:01:48.077558100Z" level=info msg="Start subscribing containerd event" Mar 3 14:01:48.077789 containerd[1892]: time="2026-03-03T14:01:48.077670500Z" level=info msg="Start recovering state" Mar 3 14:01:48.077789 containerd[1892]: time="2026-03-03T14:01:48.077767200Z" level=info msg="Start event monitor" Mar 3 14:01:48.077789 containerd[1892]: time="2026-03-03T14:01:48.077786400Z" level=info msg="Start cni network conf syncer for default" Mar 3 14:01:48.077915 containerd[1892]: time="2026-03-03T14:01:48.077798800Z" level=info msg="Start streaming server" Mar 3 14:01:48.077915 containerd[1892]: time="2026-03-03T14:01:48.077810500Z" level=info msg="Registered namespace \"k8s.io\" with NRI" Mar 3 14:01:48.077915 containerd[1892]: time="2026-03-03T14:01:48.077835900Z" level=info msg="runtime interface starting up..." Mar 3 14:01:48.077915 containerd[1892]: time="2026-03-03T14:01:48.077846200Z" level=info msg="starting plugins..." Mar 3 14:01:48.077915 containerd[1892]: time="2026-03-03T14:01:48.077863400Z" level=info msg="Synchronizing NRI (plugin) with current runtime state" Mar 3 14:01:48.078015 containerd[1892]: time="2026-03-03T14:01:48.077866800Z" level=info msg=serving... address=/run/containerd/containerd.sock.ttrpc Mar 3 14:01:48.078089 containerd[1892]: time="2026-03-03T14:01:48.078066400Z" level=info msg=serving... address=/run/containerd/containerd.sock Mar 3 14:01:48.078170 containerd[1892]: time="2026-03-03T14:01:48.078142400Z" level=info msg="containerd successfully booted in 0.547820s" Mar 3 14:01:48.078252 systemd[1]: Started containerd.service - containerd container runtime. Mar 3 14:01:48.998407 waagent[2013]: 2026-03-03T14:01:48.998321Z INFO Daemon Daemon Azure Linux Agent Version: 2.12.0.4 Mar 3 14:01:49.002784 waagent[2013]: 2026-03-03T14:01:49.002734Z INFO Daemon Daemon OS: flatcar 4459.2.4 Mar 3 14:01:49.006295 waagent[2013]: 2026-03-03T14:01:49.006247Z INFO Daemon Daemon Python: 3.11.13 Mar 3 14:01:49.009724 waagent[2013]: 2026-03-03T14:01:49.009667Z INFO Daemon Daemon Run daemon Mar 3 14:01:49.012960 waagent[2013]: 2026-03-03T14:01:49.012897Z INFO Daemon Daemon No RDMA handler exists for distro='Flatcar Container Linux by Kinvolk' version='4459.2.4' Mar 3 14:01:49.019497 waagent[2013]: 2026-03-03T14:01:49.019446Z INFO Daemon Daemon Using waagent for provisioning Mar 3 14:01:49.023601 waagent[2013]: 2026-03-03T14:01:49.023557Z INFO Daemon Daemon Activate resource disk Mar 3 14:01:49.030738 waagent[2013]: 2026-03-03T14:01:49.030685Z INFO Daemon Daemon Searching gen1 prefix 00000000-0001 or gen2 f8b3781a-1e82-4818-a1c3-63d806ec15bb Mar 3 14:01:49.037984 waagent[2013]: 2026-03-03T14:01:49.037942Z INFO Daemon Daemon Found device: sda Mar 3 14:01:49.047173 waagent[2013]: 2026-03-03T14:01:49.047124Z INFO Daemon Daemon Examining partition table Mar 3 14:01:49.065187 waagent[2013]: 2026-03-03T14:01:49.065128Z INFO Daemon Daemon GPT not detected, determining filesystem Mar 3 14:01:49.126657 waagent[2013]: 2026-03-03T14:01:49.126597Z INFO Daemon Daemon sfdisk --part-type -f /dev/sda 1 -n succeeded Mar 3 14:01:49.131060 waagent[2013]: 2026-03-03T14:01:49.131018Z INFO Daemon Daemon The partition is formatted with ntfs, updating partition type to 83 Mar 3 14:01:50.075846 kernel: sda: sda1 Mar 3 14:01:50.093839 kernel: sda: sda1 Mar 3 14:01:50.309797 waagent[2013]: 2026-03-03T14:01:50.309714Z INFO Daemon Daemon sfdisk --part-type /dev/sda 1 83 succeeded Mar 3 14:01:50.345875 kernel: sda: sda1 Mar 3 14:01:50.346141 waagent[2013]: 2026-03-03T14:01:50.346076Z INFO Daemon Daemon Format partition [mkfs.ext4 -F /dev/sda1] Mar 3 14:01:54.110353 login[2015]: pam_lastlog(login:session): file /var/log/lastlog is locked/read, retrying Mar 3 14:01:54.112085 login[2018]: pam_unix(login:session): session opened for user core(uid=500) by LOGIN(uid=0) Mar 3 14:01:54.118545 systemd[1]: Created slice user-500.slice - User Slice of UID 500. Mar 3 14:01:54.119586 systemd[1]: Starting user-runtime-dir@500.service - User Runtime Directory /run/user/500... Mar 3 14:01:54.125719 systemd-logind[1877]: New session 1 of user core. Mar 3 14:01:54.181869 systemd[1]: Finished user-runtime-dir@500.service - User Runtime Directory /run/user/500. Mar 3 14:01:54.184243 systemd[1]: Starting user@500.service - User Manager for UID 500... Mar 3 14:01:54.358093 (systemd)[2130]: pam_unix(systemd-user:session): session opened for user core(uid=500) by (uid=0) Mar 3 14:01:54.360556 systemd-logind[1877]: New session c1 of user core. Mar 3 14:01:55.110839 login[2015]: pam_unix(login:session): session opened for user core(uid=500) by LOGIN(uid=0) Mar 3 14:01:55.115244 systemd-logind[1877]: New session 2 of user core. Mar 3 14:01:55.414187 setup-nvidia[2029]: \u000d 0 0 0 0 0 0 0 0 --:--:-- --:--:-- --:--:-- 0\u000d 0 0 0 0 0 0 0 0 --:--:-- 0:00:01 --:--:-- 0\u000d 4 471M 4 19.8M 0 0 13.5M 0 0:00:34 0:00:01 0:00:33 13.5M\u000d 19 471M 19 91.3M 0 0 37.0M 0 0:00:12 0:00:02 0:00:10 37.0M\u000d 32 471M 32 154M 0 0 44.7M 0 0:00:10 0:00:03 0:00:07 44.7M\u000d 46 471M 46 218M 0 0 49.0M 0 0:00:09 0:00:04 0:00:05 49.0M\u000d 58 471M 58 275M 0 0 50.4M 0 0:00:09 0:00:05 0:00:04 63.2M\u000d 71 471M 71 334M 0 0 51.7M 0 0:00:09 0:00:06 0:00:03 62.9M\u000d 83 471M 83 393M 0 0 52.6M 0 0:00:08 0:00:07 0:00:01 60.3M\u000d 97 471M 97 459M 0 0 54.3M 0 0:00:08 0:00:08 --:--:-- 61.0M\u000d100 471M 100 471M 0 0 54.5M 0 0:00:08 0:00:08 --:--:-- 60.4M Mar 3 14:01:55.459122 systemd[2130]: Queued start job for default target default.target. Mar 3 14:01:55.482860 systemd[2130]: Created slice app.slice - User Application Slice. Mar 3 14:01:55.482889 systemd[2130]: Reached target paths.target - Paths. Mar 3 14:01:55.482938 systemd[2130]: Reached target timers.target - Timers. Mar 3 14:01:55.487183 systemd[2130]: Starting dbus.socket - D-Bus User Message Bus Socket... Mar 3 14:01:55.498008 systemd[2130]: Listening on dbus.socket - D-Bus User Message Bus Socket. Mar 3 14:01:55.498070 systemd[2130]: Reached target sockets.target - Sockets. Mar 3 14:01:55.498117 systemd[2130]: Reached target basic.target - Basic System. Mar 3 14:01:55.498162 systemd[2130]: Reached target default.target - Main User Target. Mar 3 14:01:55.498200 systemd[2130]: Startup finished in 1.130s. Mar 3 14:01:55.499794 systemd[1]: Started user@500.service - User Manager for UID 500. Mar 3 14:01:55.501625 systemd[1]: Started session-1.scope - Session 1 of User core. Mar 3 14:01:55.502427 systemd[1]: Started session-2.scope - Session 2 of User core. Mar 3 14:01:55.867585 waagent[2013]: 2026-03-03T14:01:55.865167Z INFO Daemon Daemon Mount resource disk [mount -t ext4 /dev/sda1 /mnt/resource] Mar 3 14:01:56.057106 kernel: EXT4-fs (sda1): mounted filesystem 9c6dc7b1-47c6-4448-b2ac-dfeff6bd57be r/w with ordered data mode. Quota mode: none. Mar 3 14:01:56.057210 waagent[2013]: 2026-03-03T14:01:56.056163Z INFO Daemon Daemon Resource disk /dev/sda is mounted at /mnt/resource with ext4 Mar 3 14:01:56.058616 waagent[2013]: 2026-03-03T14:01:56.058569Z INFO Daemon Daemon Clean protocol and wireserver endpoint Mar 3 14:01:56.060020 waagent[2013]: 2026-03-03T14:01:56.059983Z INFO Daemon Daemon Running default provisioning handler Mar 3 14:01:56.077598 waagent[2013]: 2026-03-03T14:01:56.077423Z 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 3 14:01:56.081108 waagent[2013]: 2026-03-03T14:01:56.081068Z INFO Daemon Daemon Unable to get cloud-init enabled status from service: [Errno 2] No such file or directory: 'service' Mar 3 14:01:56.081476 waagent[2013]: 2026-03-03T14:01:56.081441Z INFO Daemon Daemon cloud-init is enabled: False Mar 3 14:01:56.082867 waagent[2013]: 2026-03-03T14:01:56.082831Z INFO Daemon Daemon Copying ovf-env.xml Mar 3 14:01:56.250952 waagent[2013]: 2026-03-03T14:01:56.250791Z INFO Daemon Daemon Successfully mounted dvd Mar 3 14:01:56.299748 systemd[1]: mnt-cdrom-secure.mount: Deactivated successfully. Mar 3 14:01:56.302887 waagent[2013]: 2026-03-03T14:01:56.301917Z INFO Daemon Daemon Detect protocol endpoint Mar 3 14:01:56.303659 waagent[2013]: 2026-03-03T14:01:56.303618Z INFO Daemon Daemon Clean protocol and wireserver endpoint Mar 3 14:01:56.305141 waagent[2013]: 2026-03-03T14:01:56.305068Z INFO Daemon Daemon WireServer endpoint is not found. Rerun dhcp handler Mar 3 14:01:56.307909 waagent[2013]: 2026-03-03T14:01:56.307870Z INFO Daemon Daemon Test for route to 168.63.129.16 Mar 3 14:01:56.309881 waagent[2013]: 2026-03-03T14:01:56.309688Z INFO Daemon Daemon Route to 168.63.129.16 exists Mar 3 14:01:56.311423 waagent[2013]: 2026-03-03T14:01:56.311385Z INFO Daemon Daemon Wire server endpoint:168.63.129.16 Mar 3 14:01:56.339458 waagent[2013]: 2026-03-03T14:01:56.339407Z INFO Daemon Daemon Fabric preferred wire protocol version:2015-04-05 Mar 3 14:01:56.341992 waagent[2013]: 2026-03-03T14:01:56.341966Z INFO Daemon Daemon Wire protocol version:2012-11-30 Mar 3 14:01:56.345727 waagent[2013]: 2026-03-03T14:01:56.345688Z INFO Daemon Daemon Server preferred version:2015-04-05 Mar 3 14:01:56.601891 waagent[2013]: 2026-03-03T14:01:56.599424Z INFO Daemon Daemon Initializing goal state during protocol detection Mar 3 14:01:56.601891 waagent[2013]: 2026-03-03T14:01:56.601080Z INFO Daemon Daemon Forcing an update of the goal state. Mar 3 14:01:56.604846 waagent[2013]: 2026-03-03T14:01:56.604794Z INFO Daemon Fetched a new incarnation for the WireServer goal state [incarnation 1] Mar 3 14:01:56.631230 waagent[2013]: 2026-03-03T14:01:56.631182Z INFO Daemon Daemon HostGAPlugin version: 1.0.8.179 Mar 3 14:01:56.634944 waagent[2013]: 2026-03-03T14:01:56.634907Z INFO Daemon Mar 3 14:01:56.636838 waagent[2013]: 2026-03-03T14:01:56.635149Z INFO Daemon Fetched new vmSettings [HostGAPlugin correlation ID: 97d4853c-e819-4924-84d5-19e28c83e24b eTag: 745338510229620044 source: Fabric] Mar 3 14:01:56.636952 waagent[2013]: 2026-03-03T14:01:56.636913Z INFO Daemon The vmSettings originated via Fabric; will ignore them. Mar 3 14:01:56.637634 waagent[2013]: 2026-03-03T14:01:56.637598Z INFO Daemon Mar 3 14:01:56.638798 waagent[2013]: 2026-03-03T14:01:56.638762Z INFO Daemon Fetching full goal state from the WireServer [incarnation 1] Mar 3 14:01:56.661947 waagent[2013]: 2026-03-03T14:01:56.661905Z INFO Daemon Daemon Downloading artifacts profile blob Mar 3 14:01:56.815347 waagent[2013]: 2026-03-03T14:01:56.815277Z INFO Daemon Downloaded certificate {'thumbprint': '1DD7EBCB2D7C35F82FE2C62A0A5C885C4C9091D0', 'hasPrivateKey': True} Mar 3 14:01:56.826066 waagent[2013]: 2026-03-03T14:01:56.822845Z INFO Daemon Fetch goal state completed Mar 3 14:01:56.864542 waagent[2013]: 2026-03-03T14:01:56.864448Z INFO Daemon Daemon Starting provisioning Mar 3 14:01:56.874146 waagent[2013]: 2026-03-03T14:01:56.870651Z INFO Daemon Daemon Handle ovf-env.xml. Mar 3 14:01:56.879738 waagent[2013]: 2026-03-03T14:01:56.874732Z INFO Daemon Daemon Set hostname [ci-4459.2.4-a-868b7edfa5] Mar 3 14:01:56.882122 waagent[2013]: 2026-03-03T14:01:56.882081Z INFO Daemon Daemon Publish hostname [ci-4459.2.4-a-868b7edfa5] Mar 3 14:01:56.887280 waagent[2013]: 2026-03-03T14:01:56.887240Z INFO Daemon Daemon Examine /proc/net/route for primary interface Mar 3 14:01:56.893275 waagent[2013]: 2026-03-03T14:01:56.893237Z INFO Daemon Daemon Primary interface is [eth0] Mar 3 14:01:56.906831 systemd-networkd[1568]: eth0: found matching network '/usr/lib/systemd/network/zz-default.network', based on potentially unpredictable interface name. Mar 3 14:01:56.907239 systemd-networkd[1568]: eth0: Configuring with /usr/lib/systemd/network/zz-default.network. Mar 3 14:01:56.907352 systemd-networkd[1568]: eth0: DHCP lease lost Mar 3 14:01:56.907856 waagent[2013]: 2026-03-03T14:01:56.907776Z INFO Daemon Daemon Create user account if not exists Mar 3 14:01:56.912101 waagent[2013]: 2026-03-03T14:01:56.912062Z INFO Daemon Daemon User core already exists, skip useradd Mar 3 14:01:56.916836 waagent[2013]: 2026-03-03T14:01:56.916777Z INFO Daemon Daemon Configure sudoer Mar 3 14:01:56.936360 waagent[2013]: 2026-03-03T14:01:56.936285Z INFO Daemon Daemon Configure sshd Mar 3 14:01:56.959883 waagent[2013]: 2026-03-03T14:01:56.946603Z INFO Daemon Daemon Added a configuration snippet disabling SSH password-based authentication methods. It also configures SSH client probing to keep connections alive. Mar 3 14:01:56.959883 waagent[2013]: 2026-03-03T14:01:56.955813Z INFO Daemon Daemon Deploy ssh public key. Mar 3 14:01:56.965889 systemd-networkd[1568]: eth0: DHCPv4 address 10.200.8.10/24, gateway 10.200.8.1 acquired from 168.63.129.16 Mar 3 14:01:58.082571 waagent[2013]: 2026-03-03T14:01:58.082514Z INFO Daemon Daemon Provisioning complete Mar 3 14:01:58.092066 waagent[2013]: 2026-03-03T14:01:58.092014Z INFO Daemon Daemon RDMA capabilities are not enabled, skipping Mar 3 14:01:58.103350 waagent[2013]: 2026-03-03T14:01:58.093645Z INFO Daemon Daemon End of log to /dev/console. The agent will now check for updates and then will process extensions. Mar 3 14:01:58.103350 waagent[2013]: 2026-03-03T14:01:58.096484Z INFO Daemon Daemon Installed Agent WALinuxAgent-2.12.0.4 is the most current agent Mar 3 14:01:58.252844 waagent[2198]: 2026-03-03T14:01:58.252466Z INFO ExtHandler ExtHandler Azure Linux Agent (Goal State Agent version 2.12.0.4) Mar 3 14:01:58.252844 waagent[2198]: 2026-03-03T14:01:58.252623Z INFO ExtHandler ExtHandler OS: flatcar 4459.2.4 Mar 3 14:01:58.252844 waagent[2198]: 2026-03-03T14:01:58.252694Z INFO ExtHandler ExtHandler Python: 3.11.13 Mar 3 14:01:58.252844 waagent[2198]: 2026-03-03T14:01:58.252764Z INFO ExtHandler ExtHandler CPU Arch: x86_64 Mar 3 14:01:58.311845 waagent[2198]: 2026-03-03T14:01:58.309836Z INFO ExtHandler ExtHandler Distro: flatcar-4459.2.4; OSUtil: FlatcarUtil; AgentService: waagent; Python: 3.11.13; Arch: x86_64; systemd: True; LISDrivers: Absent; logrotate: logrotate 3.22.0; Mar 3 14:01:58.311845 waagent[2198]: 2026-03-03T14:01:58.310101Z INFO ExtHandler ExtHandler WireServer endpoint 168.63.129.16 read from file Mar 3 14:01:58.311845 waagent[2198]: 2026-03-03T14:01:58.310177Z INFO ExtHandler ExtHandler Wire server endpoint:168.63.129.16 Mar 3 14:01:58.317354 waagent[2198]: 2026-03-03T14:01:58.317311Z INFO ExtHandler Fetched a new incarnation for the WireServer goal state [incarnation 1] Mar 3 14:01:58.322220 waagent[2198]: 2026-03-03T14:01:58.322185Z INFO ExtHandler ExtHandler HostGAPlugin version: 1.0.8.179 Mar 3 14:01:58.322775 waagent[2198]: 2026-03-03T14:01:58.322739Z INFO ExtHandler Mar 3 14:01:58.322964 waagent[2198]: 2026-03-03T14:01:58.322931Z INFO ExtHandler Fetched new vmSettings [HostGAPlugin correlation ID: 492e0bb1-f015-4486-b594-c5f541f5726c eTag: 745338510229620044 source: Fabric] Mar 3 14:01:58.323366 waagent[2198]: 2026-03-03T14:01:58.323330Z INFO ExtHandler The vmSettings originated via Fabric; will ignore them. Mar 3 14:01:58.324079 waagent[2198]: 2026-03-03T14:01:58.324042Z INFO ExtHandler Mar 3 14:01:58.324288 waagent[2198]: 2026-03-03T14:01:58.324211Z INFO ExtHandler Fetching full goal state from the WireServer [incarnation 1] Mar 3 14:01:58.327514 waagent[2198]: 2026-03-03T14:01:58.327486Z INFO ExtHandler ExtHandler Downloading artifacts profile blob Mar 3 14:01:58.394891 waagent[2198]: 2026-03-03T14:01:58.394058Z INFO ExtHandler Downloaded certificate {'thumbprint': '1DD7EBCB2D7C35F82FE2C62A0A5C885C4C9091D0', 'hasPrivateKey': True} Mar 3 14:01:58.394891 waagent[2198]: 2026-03-03T14:01:58.394772Z INFO ExtHandler Fetch goal state completed Mar 3 14:01:58.405911 waagent[2198]: 2026-03-03T14:01:58.405866Z INFO ExtHandler ExtHandler OpenSSL version: OpenSSL 3.4.4 27 Jan 2026 (Library: OpenSSL 3.4.4 27 Jan 2026) Mar 3 14:01:58.411885 waagent[2198]: 2026-03-03T14:01:58.411834Z INFO ExtHandler ExtHandler WALinuxAgent-2.12.0.4 running as process 2198 Mar 3 14:01:58.412030 waagent[2198]: 2026-03-03T14:01:58.411993Z INFO ExtHandler ExtHandler ******** AutoUpdate.Enabled is set to False, not processing the operation ******** Mar 3 14:01:58.412388 waagent[2198]: 2026-03-03T14:01:58.412351Z INFO ExtHandler ExtHandler ******** AutoUpdate.UpdateToLatestVersion is set to False, not processing the operation ******** Mar 3 14:01:58.414028 waagent[2198]: 2026-03-03T14:01:58.413990Z INFO ExtHandler ExtHandler [CGI] Cgroup monitoring is not supported on ['flatcar', '4459.2.4', '', 'Flatcar Container Linux by Kinvolk'] Mar 3 14:01:58.414474 waagent[2198]: 2026-03-03T14:01:58.414438Z INFO ExtHandler ExtHandler [CGI] Agent will reset the quotas in case distro: ['flatcar', '4459.2.4', '', 'Flatcar Container Linux by Kinvolk'] went from supported to unsupported Mar 3 14:01:58.414633 waagent[2198]: 2026-03-03T14:01:58.414599Z INFO ExtHandler ExtHandler [CGI] Agent cgroups enabled: False Mar 3 14:01:58.415267 waagent[2198]: 2026-03-03T14:01:58.415231Z INFO ExtHandler ExtHandler Starting setup for Persistent firewall rules Mar 3 14:01:58.527145 waagent[2198]: 2026-03-03T14:01:58.526615Z INFO ExtHandler ExtHandler Firewalld service not running/unavailable, trying to set up waagent-network-setup.service Mar 3 14:01:58.527145 waagent[2198]: 2026-03-03T14:01:58.526896Z INFO ExtHandler ExtHandler Successfully updated the Binary file /var/lib/waagent/waagent-network-setup.py for firewall setup Mar 3 14:01:58.537068 waagent[2198]: 2026-03-03T14:01:58.536537Z INFO ExtHandler ExtHandler Service: waagent-network-setup.service not enabled. Adding it now Mar 3 14:01:58.545306 systemd[1]: Reload requested from client PID 2213 ('systemctl') (unit waagent.service)... Mar 3 14:01:58.545327 systemd[1]: Reloading... Mar 3 14:01:58.638877 zram_generator::config[2253]: No configuration found. Mar 3 14:01:58.923107 systemd[1]: Reloading finished in 377 ms. Mar 3 14:01:58.954002 waagent[2198]: 2026-03-03T14:01:58.953208Z INFO ExtHandler ExtHandler Successfully added and enabled the waagent-network-setup.service Mar 3 14:01:58.954002 waagent[2198]: 2026-03-03T14:01:58.953356Z INFO ExtHandler ExtHandler Persistent firewall rules setup successfully Mar 3 14:01:59.394785 waagent[2198]: 2026-03-03T14:01:59.394710Z INFO ExtHandler ExtHandler DROP rule is not available which implies no firewall rules are set yet. Environment thread will set it up. Mar 3 14:01:59.395170 waagent[2198]: 2026-03-03T14:01:59.395079Z 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 3 14:01:59.395884 waagent[2198]: 2026-03-03T14:01:59.395831Z INFO ExtHandler ExtHandler Starting env monitor service. Mar 3 14:01:59.396321 waagent[2198]: 2026-03-03T14:01:59.396270Z INFO MonitorHandler ExtHandler WireServer endpoint 168.63.129.16 read from file Mar 3 14:01:59.396529 waagent[2198]: 2026-03-03T14:01:59.396481Z INFO ExtHandler ExtHandler Start SendTelemetryHandler service. Mar 3 14:01:59.396993 waagent[2198]: 2026-03-03T14:01:59.396951Z INFO MonitorHandler ExtHandler Wire server endpoint:168.63.129.16 Mar 3 14:01:59.397158 waagent[2198]: 2026-03-03T14:01:59.397079Z INFO SendTelemetryHandler ExtHandler Successfully started the SendTelemetryHandler thread Mar 3 14:01:59.397324 waagent[2198]: 2026-03-03T14:01:59.397269Z INFO ExtHandler ExtHandler Start Extension Telemetry service. Mar 3 14:01:59.397324 waagent[2198]: 2026-03-03T14:01:59.397229Z INFO EnvHandler ExtHandler WireServer endpoint 168.63.129.16 read from file Mar 3 14:01:59.397709 waagent[2198]: 2026-03-03T14:01:59.397654Z INFO EnvHandler ExtHandler Wire server endpoint:168.63.129.16 Mar 3 14:01:59.398090 waagent[2198]: 2026-03-03T14:01:59.398031Z INFO TelemetryEventsCollector ExtHandler Extension Telemetry pipeline enabled: True Mar 3 14:01:59.400121 waagent[2198]: 2026-03-03T14:01:59.400084Z INFO ExtHandler ExtHandler Goal State Period: 6 sec. This indicates how often the agent checks for new goal states and reports status. Mar 3 14:01:59.400196 waagent[2198]: 2026-03-03T14:01:59.400030Z INFO MonitorHandler ExtHandler Monitor.NetworkConfigurationChanges is disabled. Mar 3 14:01:59.400239 waagent[2198]: 2026-03-03T14:01:59.400200Z INFO EnvHandler ExtHandler Configure routes Mar 3 14:01:59.400470 waagent[2198]: 2026-03-03T14:01:59.400430Z INFO EnvHandler ExtHandler Gateway:None Mar 3 14:01:59.400635 waagent[2198]: 2026-03-03T14:01:59.400600Z INFO TelemetryEventsCollector ExtHandler Successfully started the TelemetryEventsCollector thread Mar 3 14:01:59.401149 waagent[2198]: 2026-03-03T14:01:59.401109Z INFO EnvHandler ExtHandler Routes:None Mar 3 14:01:59.404011 waagent[2198]: 2026-03-03T14:01:59.403936Z INFO MonitorHandler ExtHandler Routing table from /proc/net/route: Mar 3 14:01:59.404011 waagent[2198]: Iface Destination Gateway Flags RefCnt Use Metric Mask MTU Window IRTT Mar 3 14:01:59.404011 waagent[2198]: eth0 00000000 0108C80A 0003 0 0 1024 00000000 0 0 0 Mar 3 14:01:59.404011 waagent[2198]: eth0 0008C80A 00000000 0001 0 0 1024 00FFFFFF 0 0 0 Mar 3 14:01:59.404011 waagent[2198]: eth0 0108C80A 00000000 0005 0 0 1024 FFFFFFFF 0 0 0 Mar 3 14:01:59.404011 waagent[2198]: eth0 10813FA8 0108C80A 0007 0 0 1024 FFFFFFFF 0 0 0 Mar 3 14:01:59.404011 waagent[2198]: eth0 FEA9FEA9 0108C80A 0007 0 0 1024 FFFFFFFF 0 0 0 Mar 3 14:01:59.410149 waagent[2198]: 2026-03-03T14:01:59.410113Z INFO ExtHandler ExtHandler Mar 3 14:01:59.410328 waagent[2198]: 2026-03-03T14:01:59.410296Z INFO ExtHandler ExtHandler ProcessExtensionsGoalState started [incarnation_1 channel: WireServer source: Fabric activity: 079adacf-ea7c-4538-b915-aa4dfe523ffa correlation be867c67-9d96-4f47-9710-4c2814ed0db3 created: 2026-03-03T14:00:33.397476Z] Mar 3 14:01:59.410770 waagent[2198]: 2026-03-03T14:01:59.410735Z INFO ExtHandler ExtHandler No extension handlers found, not processing anything. Mar 3 14:01:59.413503 waagent[2198]: 2026-03-03T14:01:59.413467Z INFO ExtHandler ExtHandler ProcessExtensionsGoalState completed [incarnation_1 3 ms] Mar 3 14:01:59.448338 waagent[2198]: 2026-03-03T14:01:59.447213Z 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 3 14:01:59.448338 waagent[2198]: Try `iptables -h' or 'iptables --help' for more information.) Mar 3 14:01:59.448338 waagent[2198]: 2026-03-03T14:01:59.447664Z INFO ExtHandler ExtHandler [HEARTBEAT] Agent WALinuxAgent-2.12.0.4 is running as the goal state agent [DEBUG HeartbeatCounter: 0;HeartbeatId: 0028F78B-48F9-464E-8452-E66653F62682;DroppedPackets: -1;UpdateGSErrors: 0;AutoUpdate: 0;UpdateMode: SelfUpdate;] Mar 3 14:01:59.483732 waagent[2198]: 2026-03-03T14:01:59.483660Z INFO MonitorHandler ExtHandler Network interfaces: Mar 3 14:01:59.483732 waagent[2198]: Executing ['ip', '-a', '-o', 'link']: Mar 3 14:01:59.483732 waagent[2198]: 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 3 14:01:59.483732 waagent[2198]: 2: eth0: mtu 1500 qdisc mq state UP mode DEFAULT group default qlen 1000\ link/ether 7c:ed:8d:47:2c:cb brd ff:ff:ff:ff:ff:ff Mar 3 14:01:59.483732 waagent[2198]: Executing ['ip', '-4', '-a', '-o', 'address']: Mar 3 14:01:59.483732 waagent[2198]: 1: lo inet 127.0.0.1/8 scope host lo\ valid_lft forever preferred_lft forever Mar 3 14:01:59.483732 waagent[2198]: 2: eth0 inet 10.200.8.10/24 metric 1024 brd 10.200.8.255 scope global eth0\ valid_lft forever preferred_lft forever Mar 3 14:01:59.483732 waagent[2198]: Executing ['ip', '-6', '-a', '-o', 'address']: Mar 3 14:01:59.483732 waagent[2198]: 1: lo inet6 ::1/128 scope host noprefixroute \ valid_lft forever preferred_lft forever Mar 3 14:01:59.483732 waagent[2198]: 2: eth0 inet6 fe80::7eed:8dff:fe47:2ccb/64 scope link proto kernel_ll \ valid_lft forever preferred_lft forever Mar 3 14:01:59.585780 waagent[2198]: 2026-03-03T14:01:59.584861Z INFO EnvHandler ExtHandler Created firewall rules for the Azure Fabric: Mar 3 14:01:59.585780 waagent[2198]: Chain INPUT (policy ACCEPT 0 packets, 0 bytes) Mar 3 14:01:59.585780 waagent[2198]: pkts bytes target prot opt in out source destination Mar 3 14:01:59.585780 waagent[2198]: Chain FORWARD (policy ACCEPT 0 packets, 0 bytes) Mar 3 14:01:59.585780 waagent[2198]: pkts bytes target prot opt in out source destination Mar 3 14:01:59.585780 waagent[2198]: Chain OUTPUT (policy ACCEPT 0 packets, 0 bytes) Mar 3 14:01:59.585780 waagent[2198]: pkts bytes target prot opt in out source destination Mar 3 14:01:59.585780 waagent[2198]: 0 0 ACCEPT tcp -- * * 0.0.0.0/0 168.63.129.16 tcp dpt:53 Mar 3 14:01:59.585780 waagent[2198]: 0 0 ACCEPT tcp -- * * 0.0.0.0/0 168.63.129.16 owner UID match 0 Mar 3 14:01:59.585780 waagent[2198]: 0 0 DROP tcp -- * * 0.0.0.0/0 168.63.129.16 ctstate INVALID,NEW Mar 3 14:01:59.588530 waagent[2198]: 2026-03-03T14:01:59.588484Z INFO EnvHandler ExtHandler Current Firewall rules: Mar 3 14:01:59.588530 waagent[2198]: Chain INPUT (policy ACCEPT 0 packets, 0 bytes) Mar 3 14:01:59.588530 waagent[2198]: pkts bytes target prot opt in out source destination Mar 3 14:01:59.588530 waagent[2198]: Chain FORWARD (policy ACCEPT 0 packets, 0 bytes) Mar 3 14:01:59.588530 waagent[2198]: pkts bytes target prot opt in out source destination Mar 3 14:01:59.588530 waagent[2198]: Chain OUTPUT (policy ACCEPT 0 packets, 0 bytes) Mar 3 14:01:59.588530 waagent[2198]: pkts bytes target prot opt in out source destination Mar 3 14:01:59.588530 waagent[2198]: 0 0 ACCEPT tcp -- * * 0.0.0.0/0 168.63.129.16 tcp dpt:53 Mar 3 14:01:59.588530 waagent[2198]: 0 0 ACCEPT tcp -- * * 0.0.0.0/0 168.63.129.16 owner UID match 0 Mar 3 14:01:59.588530 waagent[2198]: 0 0 DROP tcp -- * * 0.0.0.0/0 168.63.129.16 ctstate INVALID,NEW Mar 3 14:01:59.589085 waagent[2198]: 2026-03-03T14:01:59.589053Z INFO EnvHandler ExtHandler Set block dev timeout: sdb with timeout: 300 Mar 3 14:01:59.589325 waagent[2198]: 2026-03-03T14:01:59.589293Z INFO EnvHandler ExtHandler Set block dev timeout: sda with timeout: 300 Mar 3 14:02:05.676913 setup-nvidia[1869]: Downloading NVIDIA 535.261.03 Driver Mar 3 14:02:05.681141 setup-nvidia[2345]: % Total % Received % Xferd Average Speed Time Time Time Current Mar 3 14:02:05.681365 setup-nvidia[2345]: Dload Upload Total Spent Left Speed Mar 3 14:02:08.092294 setup-nvidia[2345]: \u000d 0 0 0 0 0 0 0 0 --:--:-- --:--:-- --:--:-- 0\u000d 0 325M 0 1984k 0 0 3562k 0 0:01:33 --:--:-- 0:01:33 3563k\u000d 53 325M 53 174M 0 0 111M 0 0:00:02 0:00:01 0:00:01 111M\u000d100 325M 100 325M 0 0 135M 0 0:00:02 0:00:02 --:--:-- 135M Mar 3 14:02:08.149390 setup-nvidia[1869]: Extract the NVIDIA Driver Installer 535.261.03 Mar 3 14:02:08.149614 setup-nvidia[1869]: /opt/nvidia/workdir/nvidia-workdir / Mar 3 14:02:08.167479 setup-nvidia[2348]: Creating directory NVIDIA-Linux-x86_64-535.261.03 Mar 3 14:02:08.460372 setup-nvidia[2348]: Verifying archive integrity... OK Mar 3 14:02:09.220498 setup-nvidia[2348]: Uncompressing NVIDIA Accelerated Graphics Driver for Linux-x86_64 535.261.03 Mar 3 14:02:09.914532 chronyd[1856]: Selected source PHC0 Mar 3 14:02:11.036543 setup-nvidia[2374]: ........................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................ Mar 3 14:02:11.133030 setup-nvidia[1869]: / Mar 3 14:02:11.133287 setup-nvidia[1869]: Spawn system-nspawn container to install the NVIDIA drivers Mar 3 14:02:11.396779 sudo[2381]: root : PWD=/ ; USER=root ; COMMAND=/usr/sbin/systemd-nspawn --keep-unit --register=no --read-only --volatile=overlay --image=/opt/nvidia/workdir/flatcar_developer_container-4459.2.4.bin --overlay=/usr/lib/modules::/usr/lib/modules --bind=/opt/nvidia/workdir/nvidia-workdir:/nvidia --bind=/usr/lib/nvidia/bin:/app/bin/ /app/bin/install-nvidia NVIDIA-Linux-x86_64-535.261.03 Mar 3 14:02:11.398501 sudo[2381]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=0) Mar 3 14:02:11.404049 systemd[1]: Created slice user-0.slice - User Slice of UID 0. Mar 3 14:02:11.406497 systemd[1]: Starting user-runtime-dir@0.service - User Runtime Directory /run/user/0... Mar 3 14:02:11.436372 systemd[1]: Finished user-runtime-dir@0.service - User Runtime Directory /run/user/0. Mar 3 14:02:11.440252 systemd[1]: Starting user@0.service - User Manager for UID 0... Mar 3 14:02:11.457814 (systemd)[2384]: pam_unix(systemd-user:session): session opened for user root(uid=0) by (uid=0) Mar 3 14:02:11.460092 systemd-logind[1877]: New session c3 of user root. Mar 3 14:02:11.641215 systemd[2384]: Queued start job for default target default.target. Mar 3 14:02:11.658911 systemd[2384]: Created slice app.slice - User Application Slice. Mar 3 14:02:11.658939 systemd[2384]: Reached target paths.target - Paths. Mar 3 14:02:11.658986 systemd[2384]: Reached target timers.target - Timers. Mar 3 14:02:11.660134 systemd[2384]: Starting dbus.socket - D-Bus User Message Bus Socket... Mar 3 14:02:11.671044 systemd[2384]: Listening on dbus.socket - D-Bus User Message Bus Socket. Mar 3 14:02:11.671158 systemd[2384]: Reached target sockets.target - Sockets. Mar 3 14:02:11.671212 systemd[2384]: Reached target basic.target - Basic System. Mar 3 14:02:11.671256 systemd[2384]: Reached target default.target - Main User Target. Mar 3 14:02:11.671287 systemd[2384]: Startup finished in 204ms. Mar 3 14:02:11.671319 systemd[1]: Started user@0.service - User Manager for UID 0. Mar 3 14:02:11.674130 systemd[1]: Started session-c2.scope - Session c2 of User root. Mar 3 14:02:11.751851 kernel: loop6: detected capacity change from 0 to 12644352 Mar 3 14:02:11.803844 kernel: loop6: p9 Mar 3 14:02:12.017801 setup-nvidia[2393]: ░ Spawning container flatcardevelopercontainer-4459.2.4.bin on /opt/nvidia/workdir/flatcar_developer_container-4459.2.4.bin. Mar 3 14:02:14.371392 kernel: EXT4-fs (loop6p9): write access unavailable, skipping orphan cleanup Mar 3 14:02:14.371517 kernel: EXT4-fs (loop6p9): mounted filesystem 244f0e8e-2740-426a-bc73-a1401354f280 ro without journal. Quota mode: none. Mar 3 14:02:19.743418 systemd[1]: Created slice system-sshd.slice - Slice /system/sshd. Mar 3 14:02:19.746124 systemd[1]: Started sshd@0-10.200.8.10:22-10.200.16.10:57510.service - OpenSSH per-connection server daemon (10.200.16.10:57510). Mar 3 14:02:20.520636 sshd[2457]: Accepted publickey for core from 10.200.16.10 port 57510 ssh2: RSA SHA256:8W4DoHNKBfbl6D0QDhi4iRjE4dImxv/T8O/sEee+660 Mar 3 14:02:20.521873 sshd-session[2457]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Mar 3 14:02:20.526142 systemd-logind[1877]: New session 3 of user core. Mar 3 14:02:20.535937 systemd[1]: Started session-3.scope - Session 3 of User core. Mar 3 14:02:20.943128 systemd[1]: Started sshd@1-10.200.8.10:22-10.200.16.10:39902.service - OpenSSH per-connection server daemon (10.200.16.10:39902). Mar 3 14:02:21.489710 sshd[2463]: Accepted publickey for core from 10.200.16.10 port 39902 ssh2: RSA SHA256:8W4DoHNKBfbl6D0QDhi4iRjE4dImxv/T8O/sEee+660 Mar 3 14:02:21.490921 sshd-session[2463]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Mar 3 14:02:21.495080 systemd-logind[1877]: New session 4 of user core. Mar 3 14:02:21.506942 systemd[1]: Started session-4.scope - Session 4 of User core. Mar 3 14:02:21.803195 sshd[2466]: Connection closed by 10.200.16.10 port 39902 Mar 3 14:02:21.803556 sshd-session[2463]: pam_unix(sshd:session): session closed for user core Mar 3 14:02:21.806992 systemd[1]: sshd@1-10.200.8.10:22-10.200.16.10:39902.service: Deactivated successfully. Mar 3 14:02:21.808594 systemd[1]: session-4.scope: Deactivated successfully. Mar 3 14:02:21.809345 systemd-logind[1877]: Session 4 logged out. Waiting for processes to exit. Mar 3 14:02:21.810374 systemd-logind[1877]: Removed session 4. Mar 3 14:02:21.919888 systemd[1]: Started sshd@2-10.200.8.10:22-10.200.16.10:39918.service - OpenSSH per-connection server daemon (10.200.16.10:39918). Mar 3 14:02:22.464217 sshd[2472]: Accepted publickey for core from 10.200.16.10 port 39918 ssh2: RSA SHA256:8W4DoHNKBfbl6D0QDhi4iRjE4dImxv/T8O/sEee+660 Mar 3 14:02:22.465464 sshd-session[2472]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Mar 3 14:02:22.469737 systemd-logind[1877]: New session 5 of user core. Mar 3 14:02:22.485932 systemd[1]: Started session-5.scope - Session 5 of User core. Mar 3 14:02:22.776313 sshd[2475]: Connection closed by 10.200.16.10 port 39918 Mar 3 14:02:22.776668 sshd-session[2472]: pam_unix(sshd:session): session closed for user core Mar 3 14:02:22.779417 systemd[1]: sshd@2-10.200.8.10:22-10.200.16.10:39918.service: Deactivated successfully. Mar 3 14:02:22.781222 systemd[1]: session-5.scope: Deactivated successfully. Mar 3 14:02:22.782710 systemd-logind[1877]: Session 5 logged out. Waiting for processes to exit. Mar 3 14:02:22.783670 systemd-logind[1877]: Removed session 5. Mar 3 14:02:27.724285 kernel: hv_balloon: Max. dynamic memory size: 114688 MB Mar 3 14:02:31.101619 update_engine[1878]: I20260303 14:02:31.101527 1878 update_attempter.cc:509] Updating boot flags... Mar 3 14:02:32.893202 systemd[1]: Started sshd@3-10.200.8.10:22-10.200.16.10:34244.service - OpenSSH per-connection server daemon (10.200.16.10:34244). Mar 3 14:02:33.447839 sshd[3200]: Accepted publickey for core from 10.200.16.10 port 34244 ssh2: RSA SHA256:8W4DoHNKBfbl6D0QDhi4iRjE4dImxv/T8O/sEee+660 Mar 3 14:02:33.449121 sshd-session[3200]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Mar 3 14:02:33.453945 systemd-logind[1877]: New session 6 of user core. Mar 3 14:02:33.466958 systemd[1]: Started session-6.scope - Session 6 of User core. Mar 3 14:02:33.764389 sshd[3374]: Connection closed by 10.200.16.10 port 34244 Mar 3 14:02:33.764769 sshd-session[3200]: pam_unix(sshd:session): session closed for user core Mar 3 14:02:33.768564 systemd[1]: sshd@3-10.200.8.10:22-10.200.16.10:34244.service: Deactivated successfully. Mar 3 14:02:33.770141 systemd[1]: session-6.scope: Deactivated successfully. Mar 3 14:02:33.770940 systemd-logind[1877]: Session 6 logged out. Waiting for processes to exit. Mar 3 14:02:33.772240 systemd-logind[1877]: Removed session 6. Mar 3 14:02:33.877926 systemd[1]: Started sshd@4-10.200.8.10:22-10.200.16.10:34260.service - OpenSSH per-connection server daemon (10.200.16.10:34260). Mar 3 14:02:34.437950 sshd[3380]: Accepted publickey for core from 10.200.16.10 port 34260 ssh2: RSA SHA256:8W4DoHNKBfbl6D0QDhi4iRjE4dImxv/T8O/sEee+660 Mar 3 14:02:34.439180 sshd-session[3380]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Mar 3 14:02:34.443394 systemd-logind[1877]: New session 7 of user core. Mar 3 14:02:34.455009 systemd[1]: Started session-7.scope - Session 7 of User core. Mar 3 14:02:34.765321 sshd[3383]: Connection closed by 10.200.16.10 port 34260 Mar 3 14:02:34.765692 sshd-session[3380]: pam_unix(sshd:session): session closed for user core Mar 3 14:02:34.769159 systemd[1]: sshd@4-10.200.8.10:22-10.200.16.10:34260.service: Deactivated successfully. Mar 3 14:02:34.770787 systemd[1]: session-7.scope: Deactivated successfully. Mar 3 14:02:34.771494 systemd-logind[1877]: Session 7 logged out. Waiting for processes to exit. Mar 3 14:02:34.772376 systemd-logind[1877]: Removed session 7. Mar 3 14:02:44.882140 systemd[1]: Started sshd@5-10.200.8.10:22-10.200.16.10:49470.service - OpenSSH per-connection server daemon (10.200.16.10:49470). Mar 3 14:02:45.425255 sshd[4894]: Accepted publickey for core from 10.200.16.10 port 49470 ssh2: RSA SHA256:8W4DoHNKBfbl6D0QDhi4iRjE4dImxv/T8O/sEee+660 Mar 3 14:02:45.426503 sshd-session[4894]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Mar 3 14:02:45.432552 systemd-logind[1877]: New session 8 of user core. Mar 3 14:02:45.442999 systemd[1]: Started session-8.scope - Session 8 of User core. Mar 3 14:02:45.736803 sshd[4942]: Connection closed by 10.200.16.10 port 49470 Mar 3 14:02:45.738644 sshd-session[4894]: pam_unix(sshd:session): session closed for user core Mar 3 14:02:45.742053 systemd[1]: sshd@5-10.200.8.10:22-10.200.16.10:49470.service: Deactivated successfully. Mar 3 14:02:45.743777 systemd[1]: session-8.scope: Deactivated successfully. Mar 3 14:02:45.744688 systemd-logind[1877]: Session 8 logged out. Waiting for processes to exit. Mar 3 14:02:45.745892 systemd-logind[1877]: Removed session 8. Mar 3 14:02:45.851067 systemd[1]: Started sshd@6-10.200.8.10:22-10.200.16.10:49482.service - OpenSSH per-connection server daemon (10.200.16.10:49482). Mar 3 14:02:46.411120 sshd[5171]: Accepted publickey for core from 10.200.16.10 port 49482 ssh2: RSA SHA256:8W4DoHNKBfbl6D0QDhi4iRjE4dImxv/T8O/sEee+660 Mar 3 14:02:46.412327 sshd-session[5171]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Mar 3 14:02:46.416481 systemd-logind[1877]: New session 9 of user core. Mar 3 14:02:46.442938 systemd[1]: Started session-9.scope - Session 9 of User core. Mar 3 14:02:46.723016 sshd[5412]: Connection closed by 10.200.16.10 port 49482 Mar 3 14:02:46.723300 sshd-session[5171]: pam_unix(sshd:session): session closed for user core Mar 3 14:02:46.726752 systemd[1]: sshd@6-10.200.8.10:22-10.200.16.10:49482.service: Deactivated successfully. Mar 3 14:02:46.728333 systemd[1]: session-9.scope: Deactivated successfully. Mar 3 14:02:46.729015 systemd-logind[1877]: Session 9 logged out. Waiting for processes to exit. Mar 3 14:02:46.730140 systemd-logind[1877]: Removed session 9. Mar 3 14:02:56.845047 systemd[1]: Started sshd@7-10.200.8.10:22-10.200.16.10:40772.service - OpenSSH per-connection server daemon (10.200.16.10:40772). Mar 3 14:02:57.400278 sshd[8931]: Accepted publickey for core from 10.200.16.10 port 40772 ssh2: RSA SHA256:8W4DoHNKBfbl6D0QDhi4iRjE4dImxv/T8O/sEee+660 Mar 3 14:02:57.401938 sshd-session[8931]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Mar 3 14:02:57.406852 systemd-logind[1877]: New session 10 of user core. Mar 3 14:02:57.421015 systemd[1]: Started session-10.scope - Session 10 of User core. Mar 3 14:02:57.715035 sshd[9117]: Connection closed by 10.200.16.10 port 40772 Mar 3 14:02:57.716772 sshd-session[8931]: pam_unix(sshd:session): session closed for user core Mar 3 14:02:57.719837 systemd[1]: sshd@7-10.200.8.10:22-10.200.16.10:40772.service: Deactivated successfully. Mar 3 14:02:57.722605 systemd[1]: session-10.scope: Deactivated successfully. Mar 3 14:02:57.726468 systemd-logind[1877]: Session 10 logged out. Waiting for processes to exit. Mar 3 14:02:57.728482 systemd-logind[1877]: Removed session 10. Mar 3 14:02:57.839616 systemd[1]: Started sshd@8-10.200.8.10:22-10.200.16.10:40778.service - OpenSSH per-connection server daemon (10.200.16.10:40778). Mar 3 14:02:58.410349 sshd[9200]: Accepted publickey for core from 10.200.16.10 port 40778 ssh2: RSA SHA256:8W4DoHNKBfbl6D0QDhi4iRjE4dImxv/T8O/sEee+660 Mar 3 14:02:58.411666 sshd-session[9200]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Mar 3 14:02:58.418747 systemd-logind[1877]: New session 11 of user core. Mar 3 14:02:58.430123 systemd[1]: Started session-11.scope - Session 11 of User core. Mar 3 14:02:58.721872 sshd[9296]: Connection closed by 10.200.16.10 port 40778 Mar 3 14:02:58.724001 sshd-session[9200]: pam_unix(sshd:session): session closed for user core Mar 3 14:02:58.727502 systemd-logind[1877]: Session 11 logged out. Waiting for processes to exit. Mar 3 14:02:58.729155 systemd[1]: sshd@8-10.200.8.10:22-10.200.16.10:40778.service: Deactivated successfully. Mar 3 14:02:58.731551 systemd[1]: session-11.scope: Deactivated successfully. Mar 3 14:02:58.735766 systemd-logind[1877]: Removed session 11. Mar 3 14:03:08.845044 systemd[1]: Started sshd@9-10.200.8.10:22-10.200.16.10:54762.service - OpenSSH per-connection server daemon (10.200.16.10:54762). Mar 3 14:03:09.397855 sshd[13549]: Accepted publickey for core from 10.200.16.10 port 54762 ssh2: RSA SHA256:8W4DoHNKBfbl6D0QDhi4iRjE4dImxv/T8O/sEee+660 Mar 3 14:03:09.399578 sshd-session[13549]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Mar 3 14:03:09.405043 systemd-logind[1877]: New session 12 of user core. Mar 3 14:03:09.418013 systemd[1]: Started session-12.scope - Session 12 of User core. Mar 3 14:03:09.712517 sshd[13846]: Connection closed by 10.200.16.10 port 54762 Mar 3 14:03:09.714722 sshd-session[13549]: pam_unix(sshd:session): session closed for user core Mar 3 14:03:09.717887 systemd[1]: sshd@9-10.200.8.10:22-10.200.16.10:54762.service: Deactivated successfully. Mar 3 14:03:09.720237 systemd[1]: session-12.scope: Deactivated successfully. Mar 3 14:03:09.721998 systemd-logind[1877]: Session 12 logged out. Waiting for processes to exit. Mar 3 14:03:09.723038 systemd-logind[1877]: Removed session 12. Mar 3 14:03:09.828961 systemd[1]: Started sshd@10-10.200.8.10:22-10.200.16.10:54764.service - OpenSSH per-connection server daemon (10.200.16.10:54764). Mar 3 14:03:10.373210 sshd[14032]: Accepted publickey for core from 10.200.16.10 port 54764 ssh2: RSA SHA256:8W4DoHNKBfbl6D0QDhi4iRjE4dImxv/T8O/sEee+660 Mar 3 14:03:10.374454 sshd-session[14032]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Mar 3 14:03:10.378578 systemd-logind[1877]: New session 13 of user core. Mar 3 14:03:10.390943 systemd[1]: Started session-13.scope - Session 13 of User core. Mar 3 14:03:10.690804 sshd[14040]: Connection closed by 10.200.16.10 port 54764 Mar 3 14:03:10.691552 sshd-session[14032]: pam_unix(sshd:session): session closed for user core Mar 3 14:03:10.696219 systemd-logind[1877]: Session 13 logged out. Waiting for processes to exit. Mar 3 14:03:10.697395 systemd[1]: sshd@10-10.200.8.10:22-10.200.16.10:54764.service: Deactivated successfully. Mar 3 14:03:10.699702 systemd[1]: session-13.scope: Deactivated successfully. Mar 3 14:03:10.705611 systemd-logind[1877]: Removed session 13. Mar 3 14:03:20.809425 systemd[1]: Started sshd@11-10.200.8.10:22-10.200.16.10:39284.service - OpenSSH per-connection server daemon (10.200.16.10:39284). Mar 3 14:03:21.385714 sshd[14491]: Accepted publickey for core from 10.200.16.10 port 39284 ssh2: RSA SHA256:8W4DoHNKBfbl6D0QDhi4iRjE4dImxv/T8O/sEee+660 Mar 3 14:03:21.389212 sshd-session[14491]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Mar 3 14:03:21.396133 systemd-logind[1877]: New session 14 of user core. Mar 3 14:03:21.404916 systemd[1]: Started session-14.scope - Session 14 of User core. Mar 3 14:03:21.706516 sshd[14518]: Connection closed by 10.200.16.10 port 39284 Mar 3 14:03:21.709017 sshd-session[14491]: pam_unix(sshd:session): session closed for user core Mar 3 14:03:21.712593 systemd[1]: sshd@11-10.200.8.10:22-10.200.16.10:39284.service: Deactivated successfully. Mar 3 14:03:21.715590 systemd[1]: session-14.scope: Deactivated successfully. Mar 3 14:03:21.719343 systemd-logind[1877]: Session 14 logged out. Waiting for processes to exit. Mar 3 14:03:21.720426 systemd-logind[1877]: Removed session 14. Mar 3 14:03:21.823312 systemd[1]: Started sshd@12-10.200.8.10:22-10.200.16.10:39292.service - OpenSSH per-connection server daemon (10.200.16.10:39292). Mar 3 14:03:22.388281 sshd[14525]: Accepted publickey for core from 10.200.16.10 port 39292 ssh2: RSA SHA256:8W4DoHNKBfbl6D0QDhi4iRjE4dImxv/T8O/sEee+660 Mar 3 14:03:22.391417 sshd-session[14525]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Mar 3 14:03:22.399343 systemd-logind[1877]: New session 15 of user core. Mar 3 14:03:22.408906 systemd[1]: Started session-15.scope - Session 15 of User core. Mar 3 14:03:22.703973 sshd[14540]: Connection closed by 10.200.16.10 port 39292 Mar 3 14:03:22.704927 sshd-session[14525]: pam_unix(sshd:session): session closed for user core Mar 3 14:03:22.710117 systemd-logind[1877]: Session 15 logged out. Waiting for processes to exit. Mar 3 14:03:22.710898 systemd[1]: sshd@12-10.200.8.10:22-10.200.16.10:39292.service: Deactivated successfully. Mar 3 14:03:22.712996 systemd[1]: session-15.scope: Deactivated successfully. Mar 3 14:03:22.717547 systemd-logind[1877]: Removed session 15. Mar 3 14:03:32.821061 systemd[1]: Started sshd@13-10.200.8.10:22-10.200.16.10:57166.service - OpenSSH per-connection server daemon (10.200.16.10:57166). Mar 3 14:03:33.387849 sshd[14887]: Accepted publickey for core from 10.200.16.10 port 57166 ssh2: RSA SHA256:8W4DoHNKBfbl6D0QDhi4iRjE4dImxv/T8O/sEee+660 Mar 3 14:03:33.388271 sshd-session[14887]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Mar 3 14:03:33.395413 systemd-logind[1877]: New session 16 of user core. Mar 3 14:03:33.404021 systemd[1]: Started session-16.scope - Session 16 of User core. Mar 3 14:03:33.700304 sshd[14902]: Connection closed by 10.200.16.10 port 57166 Mar 3 14:03:33.700556 sshd-session[14887]: pam_unix(sshd:session): session closed for user core Mar 3 14:03:33.704118 systemd-logind[1877]: Session 16 logged out. Waiting for processes to exit. Mar 3 14:03:33.705922 systemd[1]: sshd@13-10.200.8.10:22-10.200.16.10:57166.service: Deactivated successfully. Mar 3 14:03:33.709630 systemd[1]: session-16.scope: Deactivated successfully. Mar 3 14:03:33.712070 systemd-logind[1877]: Removed session 16. Mar 3 14:03:33.817076 systemd[1]: Started sshd@14-10.200.8.10:22-10.200.16.10:57170.service - OpenSSH per-connection server daemon (10.200.16.10:57170). Mar 3 14:03:34.393064 sshd[14920]: Accepted publickey for core from 10.200.16.10 port 57170 ssh2: RSA SHA256:8W4DoHNKBfbl6D0QDhi4iRjE4dImxv/T8O/sEee+660 Mar 3 14:03:34.394784 sshd-session[14920]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Mar 3 14:03:34.405728 systemd-logind[1877]: New session 17 of user core. Mar 3 14:03:34.413909 systemd[1]: Started session-17.scope - Session 17 of User core. Mar 3 14:03:34.708447 sshd[14942]: Connection closed by 10.200.16.10 port 57170 Mar 3 14:03:34.708575 sshd-session[14920]: pam_unix(sshd:session): session closed for user core Mar 3 14:03:34.712021 systemd-logind[1877]: Session 17 logged out. Waiting for processes to exit. Mar 3 14:03:34.712793 systemd[1]: sshd@14-10.200.8.10:22-10.200.16.10:57170.service: Deactivated successfully. Mar 3 14:03:34.714482 systemd[1]: session-17.scope: Deactivated successfully. Mar 3 14:03:34.718374 systemd-logind[1877]: Removed session 17. Mar 3 14:03:44.835054 systemd[1]: Started sshd@15-10.200.8.10:22-10.200.16.10:37040.service - OpenSSH per-connection server daemon (10.200.16.10:37040). Mar 3 14:03:45.383794 sshd[15232]: Accepted publickey for core from 10.200.16.10 port 37040 ssh2: RSA SHA256:8W4DoHNKBfbl6D0QDhi4iRjE4dImxv/T8O/sEee+660 Mar 3 14:03:45.385022 sshd-session[15232]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Mar 3 14:03:45.389260 systemd-logind[1877]: New session 18 of user core. Mar 3 14:03:45.398947 systemd[1]: Started session-18.scope - Session 18 of User core. Mar 3 14:03:45.699552 sshd[15235]: Connection closed by 10.200.16.10 port 37040 Mar 3 14:03:45.699865 sshd-session[15232]: pam_unix(sshd:session): session closed for user core Mar 3 14:03:45.703136 systemd[1]: sshd@15-10.200.8.10:22-10.200.16.10:37040.service: Deactivated successfully. Mar 3 14:03:45.705083 systemd[1]: session-18.scope: Deactivated successfully. Mar 3 14:03:45.706358 systemd-logind[1877]: Session 18 logged out. Waiting for processes to exit. Mar 3 14:03:45.707378 systemd-logind[1877]: Removed session 18. Mar 3 14:03:45.819176 systemd[1]: Started sshd@16-10.200.8.10:22-10.200.16.10:37052.service - OpenSSH per-connection server daemon (10.200.16.10:37052). Mar 3 14:03:46.365082 sshd[15241]: Accepted publickey for core from 10.200.16.10 port 37052 ssh2: RSA SHA256:8W4DoHNKBfbl6D0QDhi4iRjE4dImxv/T8O/sEee+660 Mar 3 14:03:46.366332 sshd-session[15241]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Mar 3 14:03:46.370520 systemd-logind[1877]: New session 19 of user core. Mar 3 14:03:46.379958 systemd[1]: Started session-19.scope - Session 19 of User core. Mar 3 14:03:46.676909 sshd[15244]: Connection closed by 10.200.16.10 port 37052 Mar 3 14:03:46.677215 sshd-session[15241]: pam_unix(sshd:session): session closed for user core Mar 3 14:03:46.680795 systemd[1]: sshd@16-10.200.8.10:22-10.200.16.10:37052.service: Deactivated successfully. Mar 3 14:03:46.682381 systemd[1]: session-19.scope: Deactivated successfully. Mar 3 14:03:46.683052 systemd-logind[1877]: Session 19 logged out. Waiting for processes to exit. Mar 3 14:03:46.684010 systemd-logind[1877]: Removed session 19. Mar 3 14:03:51.816331 setup-nvidia[2393]: \u000d Mar 3 14:03:51.816331 setup-nvidia[2393]: ERROR: Unable to load the kernel module 'nvidia.ko'. This happens most Mar 3 14:03:51.816331 setup-nvidia[2393]: frequently when this kernel module was built against the wrong or Mar 3 14:03:51.816331 setup-nvidia[2393]: improperly configured kernel sources, with a version of gcc that differs Mar 3 14:03:51.816331 setup-nvidia[2393]: from the one used to build the target kernel, or if another driver, such Mar 3 14:03:51.816331 setup-nvidia[2393]: as nouveau, is present and prevents the NVIDIA kernel module from Mar 3 14:03:51.816331 setup-nvidia[2393]: obtaining ownership of the NVIDIA device(s), or no NVIDIA device Mar 3 14:03:51.816331 setup-nvidia[2393]: installed in this system is supported by this NVIDIA Linux graphics Mar 3 14:03:51.816331 setup-nvidia[2393]: driver release. Mar 3 14:03:51.816331 setup-nvidia[2393]: \u000d Mar 3 14:03:51.816331 setup-nvidia[2393]: Please see the log entries 'Kernel module load error' and 'Kernel Mar 3 14:03:51.816331 setup-nvidia[2393]: messages' at the end of the file Mar 3 14:03:51.816331 setup-nvidia[2393]: '/nvidia/NVIDIA-Linux-x86_64-535.261.03/nvidia-installer.log' for more Mar 3 14:03:51.816331 setup-nvidia[2393]: information. Mar 3 14:03:51.816331 setup-nvidia[2393]: \u000d Mar 3 14:03:51.831695 setup-nvidia[2393]: dmesg: read kernel buffer failed: Operation not permitted Mar 3 14:03:51.850882 setup-nvidia[2393]: \u000d Mar 3 14:03:51.850882 setup-nvidia[2393]: ERROR: Installation has failed. Please see the file Mar 3 14:03:51.850882 setup-nvidia[2393]: '/nvidia/NVIDIA-Linux-x86_64-535.261.03/nvidia-installer.log' for Mar 3 14:03:51.850882 setup-nvidia[2393]: details. You may find suggestions on fixing installation problems in Mar 3 14:03:51.850882 setup-nvidia[2393]: the README available on the Linux driver download page at Mar 3 14:03:51.850882 setup-nvidia[2393]: www.nvidia.com. Mar 3 14:03:51.850882 setup-nvidia[2393]: \u000d Mar 3 14:03:51.851315 setup-nvidia[2393]: Last 50 lines of nvidia-installer.log: Mar 3 14:03:51.852126 setup-nvidia[2393]: /nvidia/NVIDIA-Linux-x86_64-535.261.03/kernel/nvidia.o: warning: objtool: _nv039059rm+0x53: 'naked' return found in MITIGATION_RETHUNK build Mar 3 14:03:51.852126 setup-nvidia[2393]: /nvidia/NVIDIA-Linux-x86_64-535.261.03/kernel/nvidia.o: warning: objtool: _nv039056rm+0x90: 'naked' return found in MITIGATION_RETHUNK build Mar 3 14:03:51.852126 setup-nvidia[2393]: /nvidia/NVIDIA-Linux-x86_64-535.261.03/kernel/nvidia.o: warning: objtool: _nv039049rm+0x2b: 'naked' return found in MITIGATION_RETHUNK build Mar 3 14:03:51.852126 setup-nvidia[2393]: /nvidia/NVIDIA-Linux-x86_64-535.261.03/kernel/nvidia.o: warning: objtool: _nv039105rm+0x93: 'naked' return found in MITIGATION_RETHUNK build Mar 3 14:03:51.852126 setup-nvidia[2393]: /nvidia/NVIDIA-Linux-x86_64-535.261.03/kernel/nvidia.o: warning: objtool: _nv039101rm+0x36: 'naked' return found in MITIGATION_RETHUNK build Mar 3 14:03:51.852126 setup-nvidia[2393]: /nvidia/NVIDIA-Linux-x86_64-535.261.03/kernel/nvidia.o: warning: objtool: _nv039100rm+0x9d: 'naked' return found in MITIGATION_RETHUNK build Mar 3 14:03:51.852126 setup-nvidia[2393]: /nvidia/NVIDIA-Linux-x86_64-535.261.03/kernel/nvidia.o: warning: objtool: _nv039102rm+0x77: 'naked' return found in MITIGATION_RETHUNK build Mar 3 14:03:51.852126 setup-nvidia[2393]: /nvidia/NVIDIA-Linux-x86_64-535.261.03/kernel/nvidia.o: warning: objtool: _nv039046rm+0x7f: 'naked' return found in MITIGATION_RETHUNK build Mar 3 14:03:51.852126 setup-nvidia[2393]: /nvidia/NVIDIA-Linux-x86_64-535.261.03/kernel/nvidia.o: warning: objtool: _nv030615rm+0x3e: 'naked' return found in MITIGATION_RETHUNK build Mar 3 14:03:51.852126 setup-nvidia[2393]: /nvidia/NVIDIA-Linux-x86_64-535.261.03/kernel/nvidia.o: warning: objtool: _nv030614rm+0x27: 'naked' return found in MITIGATION_RETHUNK build Mar 3 14:03:51.852126 setup-nvidia[2393]: /nvidia/NVIDIA-Linux-x86_64-535.261.03/kernel/nvidia.o: warning: objtool: _nv030618rm+0x37: 'naked' return found in MITIGATION_RETHUNK build Mar 3 14:03:51.852126 setup-nvidia[2393]: /nvidia/NVIDIA-Linux-x86_64-535.261.03/kernel/nvidia.o: warning: objtool: _nv030617rm+0x24: 'naked' return found in MITIGATION_RETHUNK build Mar 3 14:03:51.852126 setup-nvidia[2393]: /nvidia/NVIDIA-Linux-x86_64-535.261.03/kernel/nvidia.o: warning: objtool: _nv030616rm+0xca: 'naked' return found in MITIGATION_RETHUNK build Mar 3 14:03:51.852126 setup-nvidia[2393]: /nvidia/NVIDIA-Linux-x86_64-535.261.03/kernel/nvidia.o: warning: objtool: _nv030619rm+0x193: 'naked' return found in MITIGATION_RETHUNK build Mar 3 14:03:51.852473 setup-nvidia[2393]: /nvidia/NVIDIA-Linux-x86_64-535.261.03/kernel/nvidia.o: warning: objtool: _nv030621rm+0x17f: 'naked' return found in MITIGATION_RETHUNK build Mar 3 14:03:51.852473 setup-nvidia[2393]: /nvidia/NVIDIA-Linux-x86_64-535.261.03/kernel/nvidia.o: warning: objtool: _nv011864rm+0x5d: 'naked' return found in MITIGATION_RETHUNK build Mar 3 14:03:51.852473 setup-nvidia[2393]: /nvidia/NVIDIA-Linux-x86_64-535.261.03/kernel/nvidia.o: warning: objtool: _nv039413rm+0x12f: 'naked' return found in MITIGATION_RETHUNK build Mar 3 14:03:51.852473 setup-nvidia[2393]: MODPOST /nvidia/NVIDIA-Linux-x86_64-535.261.03/kernel/Module.symvers Mar 3 14:03:51.852473 setup-nvidia[2393]: CC [M] /nvidia/NVIDIA-Linux-x86_64-535.261.03/kernel/nvidia.mod.o Mar 3 14:03:51.852473 setup-nvidia[2393]: CC [M] /nvidia/NVIDIA-Linux-x86_64-535.261.03/kernel/.module-common.o Mar 3 14:03:51.852473 setup-nvidia[2393]: CC [M] /nvidia/NVIDIA-Linux-x86_64-535.261.03/kernel/nvidia-uvm.mod.o Mar 3 14:03:51.852473 setup-nvidia[2393]: CC [M] /nvidia/NVIDIA-Linux-x86_64-535.261.03/kernel/nvidia-modeset.mod.o Mar 3 14:03:51.852473 setup-nvidia[2393]: CC [M] /nvidia/NVIDIA-Linux-x86_64-535.261.03/kernel/nvidia-drm.mod.o Mar 3 14:03:51.852473 setup-nvidia[2393]: CC [M] /nvidia/NVIDIA-Linux-x86_64-535.261.03/kernel/nvidia-peermem.mod.o Mar 3 14:03:51.852473 setup-nvidia[2393]: LD [M] /nvidia/NVIDIA-Linux-x86_64-535.261.03/kernel/nvidia-drm.ko Mar 3 14:03:51.852473 setup-nvidia[2393]: LD [M] /nvidia/NVIDIA-Linux-x86_64-535.261.03/kernel/nvidia-uvm.ko Mar 3 14:03:51.852473 setup-nvidia[2393]: LD [M] /nvidia/NVIDIA-Linux-x86_64-535.261.03/kernel/nvidia-modeset.ko Mar 3 14:03:51.852473 setup-nvidia[2393]: LD [M] /nvidia/NVIDIA-Linux-x86_64-535.261.03/kernel/nvidia-peermem.ko Mar 3 14:03:51.852473 setup-nvidia[2393]: LD [M] /nvidia/NVIDIA-Linux-x86_64-535.261.03/kernel/nvidia.ko Mar 3 14:03:51.852473 setup-nvidia[2393]: BTF [M] /nvidia/NVIDIA-Linux-x86_64-535.261.03/kernel/nvidia-peermem.ko Mar 3 14:03:51.852473 setup-nvidia[2393]: Skipping BTF generation for /nvidia/NVIDIA-Linux-x86_64-535.261.03/kernel/nvidia-peermem.ko due to unavailability of vmlinux Mar 3 14:03:51.852473 setup-nvidia[2393]: BTF [M] /nvidia/NVIDIA-Linux-x86_64-535.261.03/kernel/nvidia-modeset.ko Mar 3 14:03:51.852473 setup-nvidia[2393]: Skipping BTF generation for /nvidia/NVIDIA-Linux-x86_64-535.261.03/kernel/nvidia-modeset.ko due to unavailability of vmlinux Mar 3 14:03:51.852473 setup-nvidia[2393]: BTF [M] /nvidia/NVIDIA-Linux-x86_64-535.261.03/kernel/nvidia-drm.ko Mar 3 14:03:51.852473 setup-nvidia[2393]: Skipping BTF generation for /nvidia/NVIDIA-Linux-x86_64-535.261.03/kernel/nvidia-drm.ko due to unavailability of vmlinux Mar 3 14:03:51.852473 setup-nvidia[2393]: BTF [M] /nvidia/NVIDIA-Linux-x86_64-535.261.03/kernel/nvidia-uvm.ko Mar 3 14:03:51.853056 setup-nvidia[2393]: Skipping BTF generation for /nvidia/NVIDIA-Linux-x86_64-535.261.03/kernel/nvidia-uvm.ko due to unavailability of vmlinux Mar 3 14:03:51.853056 setup-nvidia[2393]: BTF [M] /nvidia/NVIDIA-Linux-x86_64-535.261.03/kernel/nvidia.ko Mar 3 14:03:51.853056 setup-nvidia[2393]: Skipping BTF generation for /nvidia/NVIDIA-Linux-x86_64-535.261.03/kernel/nvidia.ko due to unavailability of vmlinux Mar 3 14:03:51.853056 setup-nvidia[2393]: make[2]: Leaving directory '/usr/lib/modules/6.12.74-flatcar/build' Mar 3 14:03:51.853056 setup-nvidia[2393]: make[1]: Leaving directory '/usr/lib/modules/6.12.74-flatcar/source' Mar 3 14:03:51.853056 setup-nvidia[2393]: -> done. Mar 3 14:03:51.853056 setup-nvidia[2393]: -> Kernel module compilation complete. Mar 3 14:03:51.853056 setup-nvidia[2393]: -> Unable to determine if Secure Boot is enabled: No such file or directory Mar 3 14:03:51.853056 setup-nvidia[2393]: ERROR: Unable to load the kernel module 'nvidia.ko'. This happens most frequently when this kernel module was built against the wrong or improperly configured kernel sources, with a version of gcc that differs from the one used to build the target kernel, or if another driver, such as nouveau, is present and prevents the NVIDIA kernel module from obtaining ownership of the NVIDIA device(s), or no NVIDIA device installed in this system is supported by this NVIDIA Linux graphics driver release. Mar 3 14:03:51.853056 setup-nvidia[2393]: \u000d Mar 3 14:03:51.853056 setup-nvidia[2393]: Please see the log entries 'Kernel module load error' and 'Kernel messages' at the end of the file '/nvidia/NVIDIA-Linux-x86_64-535.261.03/nvidia-installer.log' for more information. Mar 3 14:03:51.853056 setup-nvidia[2393]: -> Kernel module load error: Operation not permitted Mar 3 14:03:51.853056 setup-nvidia[2393]: -> Kernel messages: Mar 3 14:03:51.853056 setup-nvidia[2393]: ERROR: Installation has failed. Please see the file '/nvidia/NVIDIA-Linux-x86_64-535.261.03/nvidia-installer.log' for details. You may find suggestions on fixing installation problems in the README available on the Linux driver download page at www.nvidia.com. Mar 3 14:03:56.811698 systemd[1]: Started sshd@17-10.200.8.10:22-10.200.16.10:41790.service - OpenSSH per-connection server daemon (10.200.16.10:41790). Mar 3 14:03:57.373575 sshd[15430]: Accepted publickey for core from 10.200.16.10 port 41790 ssh2: RSA SHA256:8W4DoHNKBfbl6D0QDhi4iRjE4dImxv/T8O/sEee+660 Mar 3 14:03:57.374847 sshd-session[15430]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Mar 3 14:03:57.379011 systemd-logind[1877]: New session 20 of user core. Mar 3 14:03:57.388940 systemd[1]: Started session-20.scope - Session 20 of User core. Mar 3 14:03:57.688364 sshd[15433]: Connection closed by 10.200.16.10 port 41790 Mar 3 14:03:57.688620 sshd-session[15430]: pam_unix(sshd:session): session closed for user core Mar 3 14:03:57.692076 systemd[1]: sshd@17-10.200.8.10:22-10.200.16.10:41790.service: Deactivated successfully. Mar 3 14:03:57.693892 systemd[1]: session-20.scope: Deactivated successfully. Mar 3 14:03:57.694627 systemd-logind[1877]: Session 20 logged out. Waiting for processes to exit. Mar 3 14:03:57.695725 systemd-logind[1877]: Removed session 20. Mar 3 14:03:57.820245 systemd[1]: Started sshd@18-10.200.8.10:22-10.200.16.10:41804.service - OpenSSH per-connection server daemon (10.200.16.10:41804). Mar 3 14:03:58.540914 sshd[15439]: Accepted publickey for core from 10.200.16.10 port 41804 ssh2: RSA SHA256:8W4DoHNKBfbl6D0QDhi4iRjE4dImxv/T8O/sEee+660 Mar 3 14:03:58.542116 sshd-session[15439]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Mar 3 14:03:58.546286 systemd-logind[1877]: New session 21 of user core. Mar 3 14:03:58.552939 systemd[1]: Started session-21.scope - Session 21 of User core. Mar 3 14:03:58.865600 sshd[15442]: Connection closed by 10.200.16.10 port 41804 Mar 3 14:03:58.865924 sshd-session[15439]: pam_unix(sshd:session): session closed for user core Mar 3 14:03:58.869312 systemd[1]: sshd@18-10.200.8.10:22-10.200.16.10:41804.service: Deactivated successfully. Mar 3 14:03:58.870879 systemd[1]: session-21.scope: Deactivated successfully. Mar 3 14:03:58.871524 systemd-logind[1877]: Session 21 logged out. Waiting for processes to exit. Mar 3 14:03:58.872454 systemd-logind[1877]: Removed session 21. Mar 3 14:04:07.813842 kernel: EXT4-fs (loop6p9): unmounting filesystem 244f0e8e-2740-426a-bc73-a1401354f280. Mar 3 14:04:07.814583 setup-nvidia[2393]: Container flatcardevelopercontainer-4459.2.4.bin exited successfully. Mar 3 14:04:07.816929 systemd[1]: run-systemd-nspawn-unix\x2dexport-flatcardevelopercontainer\x2d4459.2.4.bin.mount: Deactivated successfully. Mar 3 14:04:07.866643 sudo[2381]: pam_unix(sudo:session): session closed for user root Mar 3 14:04:07.869530 systemd[1]: session-c2.scope: Deactivated successfully. Mar 3 14:04:07.869861 systemd[1]: session-c2.scope: Consumed 5min 21.008s CPU time, 890M memory peak. Mar 3 14:04:08.309123 setup-nvidia[1869]: /opt/nvidia / Mar 3 14:04:08.310084 setup-nvidia[1869]: / Mar 3 14:04:08.319843 kernel: IPMI message handler: version 39.2 Mar 3 14:04:08.322839 kernel: ipmi device interface Mar 3 14:04:08.334872 setup-nvidia[1869]: /opt/nvidia/current/usr/lib/modules/6.12.74-flatcar/video / Mar 3 14:04:08.388652 kernel: nvidia: loading out-of-tree module taints kernel. Mar 3 14:04:08.388797 kernel: nvidia: module license 'NVIDIA' taints kernel. Mar 3 14:04:08.388846 kernel: Disabling lock debugging due to kernel taint Mar 3 14:04:08.396184 kernel: nvidia: module verification failed: signature and/or required key missing - tainting kernel Mar 3 14:04:08.396215 kernel: nvidia: module license taints kernel. Mar 3 14:04:08.791855 kernel: nvidia-nvlink: Nvlink Core is being initialized, major device number 243 Mar 3 14:04:09.193855 kernel: Mar 3 14:04:09.193995 kernel: nvidia 0001:00:00.0: enabling device (0000 -> 0002) Mar 3 14:04:09.307163 systemd[1]: Started sshd@19-10.200.8.10:22-10.200.16.10:60982.service - OpenSSH per-connection server daemon (10.200.16.10:60982). Mar 3 14:04:09.400846 kernel: NVRM: loading NVIDIA UNIX x86_64 Kernel Module 535.261.03 Sat Jun 14 16:05:50 UTC 2025 Mar 3 14:04:09.424844 kernel: nvidia-modeset: Loading NVIDIA Kernel Mode Setting Driver for UNIX platforms 535.261.03 Sat Jun 14 15:39:16 UTC 2025 Mar 3 14:04:09.444850 kernel: nvidia_uvm: module uses symbols nvUvmInterfaceDisableAccessCntr from proprietary module nvidia, inheriting taint. Mar 3 14:04:09.490843 kernel: nvidia-uvm: Loaded the UVM driver, major device number 241. Mar 3 14:04:09.490908 setup-nvidia[1869]: / Mar 3 14:04:09.506007 setup-nvidia[15486]: ldconfig: /usr/lib/ld.so.conf is not an ELF file - it has the wrong magic bytes at the start. Mar 3 14:04:09.853182 sshd[15476]: Accepted publickey for core from 10.200.16.10 port 60982 ssh2: RSA SHA256:8W4DoHNKBfbl6D0QDhi4iRjE4dImxv/T8O/sEee+660 Mar 3 14:04:09.854368 sshd-session[15476]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Mar 3 14:04:09.858626 systemd-logind[1877]: New session 22 of user core. Mar 3 14:04:09.869963 systemd[1]: Started session-22.scope - Session 22 of User core. Mar 3 14:04:10.167132 sshd[15507]: Connection closed by 10.200.16.10 port 60982 Mar 3 14:04:10.167427 sshd-session[15476]: pam_unix(sshd:session): session closed for user core Mar 3 14:04:10.171021 systemd[1]: sshd@19-10.200.8.10:22-10.200.16.10:60982.service: Deactivated successfully. Mar 3 14:04:10.172614 systemd[1]: session-22.scope: Deactivated successfully. Mar 3 14:04:10.173311 systemd-logind[1877]: Session 22 logged out. Waiting for processes to exit. Mar 3 14:04:10.174296 systemd-logind[1877]: Removed session 22. Mar 3 14:04:10.284063 systemd[1]: Started sshd@20-10.200.8.10:22-10.200.16.10:55138.service - OpenSSH per-connection server daemon (10.200.16.10:55138). Mar 3 14:04:10.853757 sshd[15513]: Accepted publickey for core from 10.200.16.10 port 55138 ssh2: RSA SHA256:8W4DoHNKBfbl6D0QDhi4iRjE4dImxv/T8O/sEee+660 Mar 3 14:04:10.854999 sshd-session[15513]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Mar 3 14:04:10.859266 systemd-logind[1877]: New session 23 of user core. Mar 3 14:04:10.868965 systemd[1]: Started session-23.scope - Session 23 of User core. Mar 3 14:04:11.169846 sshd[15516]: Connection closed by 10.200.16.10 port 55138 Mar 3 14:04:11.170138 sshd-session[15513]: pam_unix(sshd:session): session closed for user core Mar 3 14:04:11.173529 systemd[1]: sshd@20-10.200.8.10:22-10.200.16.10:55138.service: Deactivated successfully. Mar 3 14:04:11.175153 systemd[1]: session-23.scope: Deactivated successfully. Mar 3 14:04:11.175865 systemd-logind[1877]: Session 23 logged out. Waiting for processes to exit. Mar 3 14:04:11.176841 systemd-logind[1877]: Removed session 23. Mar 3 14:04:11.300264 setup-nvidia[15503]: Tue Mar 3 14:04:11 2026 Mar 3 14:04:11.300264 setup-nvidia[15503]: +---------------------------------------------------------------------------------------+ Mar 3 14:04:11.300264 setup-nvidia[15503]: | NVIDIA-SMI 535.261.03 Driver Version: 535.261.03 CUDA Version: 12.2 | Mar 3 14:04:11.300264 setup-nvidia[15503]: |-----------------------------------------+----------------------+----------------------+ Mar 3 14:04:11.300264 setup-nvidia[15503]: | GPU Name Persistence-M | Bus-Id Disp.A | Volatile Uncorr. ECC | Mar 3 14:04:11.300264 setup-nvidia[15503]: | Fan Temp Perf Pwr:Usage/Cap | Memory-Usage | GPU-Util Compute M. | Mar 3 14:04:11.300264 setup-nvidia[15503]: | | | MIG M. | Mar 3 14:04:11.300264 setup-nvidia[15503]: |=========================================+======================+======================| Mar 3 14:04:11.303724 setup-nvidia[15503]: | 0 Tesla V100-PCIE-16GB Off | 00000001:00:00.0 Off | Off | Mar 3 14:04:11.303724 setup-nvidia[15503]: | N/A 25C P0 35W / 250W | 0MiB / 16384MiB | 0% Default | Mar 3 14:04:11.303724 setup-nvidia[15503]: | | | N/A | Mar 3 14:04:11.303724 setup-nvidia[15503]: +-----------------------------------------+----------------------+----------------------+ Mar 3 14:04:11.303724 setup-nvidia[15503]: Mar 3 14:04:11.303724 setup-nvidia[15503]: +---------------------------------------------------------------------------------------+ Mar 3 14:04:11.303724 setup-nvidia[15503]: | Processes: | Mar 3 14:04:11.303724 setup-nvidia[15503]: | GPU GI CI PID Type Process name GPU Memory | Mar 3 14:04:11.303724 setup-nvidia[15503]: | ID ID Usage | Mar 3 14:04:11.303724 setup-nvidia[15503]: |=======================================================================================| Mar 3 14:04:11.304033 setup-nvidia[15503]: | No running processes found | Mar 3 14:04:11.304033 setup-nvidia[15503]: +---------------------------------------------------------------------------------------+ Mar 3 14:04:11.684771 systemd[1]: Finished nvidia.service - NVIDIA Configure Service. Mar 3 14:04:11.686815 systemd[1]: Reached target multi-user.target - Multi-User System. Mar 3 14:04:11.692948 systemd[1]: Startup finished in 1.295s (firmware) + 21.125s (loader) + 3.701s (kernel) + 13.474s (initrd) + 2min 38.418s (userspace) = 3min 18.015s. Mar 3 14:04:17.993478 systemd[1]: Stopping user@0.service - User Manager for UID 0... Mar 3 14:04:17.994311 systemd[2384]: Activating special unit exit.target... Mar 3 14:04:17.994398 systemd[2384]: Stopped target default.target - Main User Target. Mar 3 14:04:17.994439 systemd[2384]: Stopped target basic.target - Basic System. Mar 3 14:04:17.994468 systemd[2384]: Stopped target paths.target - Paths. Mar 3 14:04:17.994494 systemd[2384]: Stopped target sockets.target - Sockets. Mar 3 14:04:17.994520 systemd[2384]: Stopped target timers.target - Timers. Mar 3 14:04:17.994870 systemd[2384]: Closed dbus.socket - D-Bus User Message Bus Socket. Mar 3 14:04:17.995144 systemd[2384]: Removed slice app.slice - User Application Slice. Mar 3 14:04:17.995179 systemd[2384]: Reached target shutdown.target - Shutdown. Mar 3 14:04:17.995326 systemd[2384]: Finished systemd-exit.service - Exit the Session. Mar 3 14:04:17.995363 systemd[2384]: Reached target exit.target - Exit the Session. Mar 3 14:04:18.004348 (sd-pam)[2385]: pam_unix(systemd-user:session): session closed for user root Mar 3 14:04:18.005596 systemd[1]: user@0.service: Deactivated successfully. Mar 3 14:04:18.005968 systemd[1]: Stopped user@0.service - User Manager for UID 0. Mar 3 14:04:18.008124 systemd[1]: Stopping user-runtime-dir@0.service - User Runtime Directory /run/user/0... Mar 3 14:04:18.029026 systemd[1]: run-user-0.mount: Deactivated successfully. Mar 3 14:04:18.029906 systemd[1]: user-runtime-dir@0.service: Deactivated successfully. Mar 3 14:04:18.030111 systemd[1]: Stopped user-runtime-dir@0.service - User Runtime Directory /run/user/0. Mar 3 14:04:18.031576 systemd[1]: Removed slice user-0.slice - User Slice of UID 0. Mar 3 14:04:18.031666 systemd[1]: user-0.slice: Consumed 5min 21.314s CPU time, 896.1M memory peak. Mar 3 14:04:18.032088 systemd-logind[1877]: Removed session c3. Mar 3 14:04:21.289881 systemd[1]: Started sshd@21-10.200.8.10:22-10.200.16.10:34908.service - OpenSSH per-connection server daemon (10.200.16.10:34908). Mar 3 14:04:21.860236 sshd[15528]: Accepted publickey for core from 10.200.16.10 port 34908 ssh2: RSA SHA256:8W4DoHNKBfbl6D0QDhi4iRjE4dImxv/T8O/sEee+660 Mar 3 14:04:21.861484 sshd-session[15528]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Mar 3 14:04:21.865654 systemd-logind[1877]: New session 24 of user core. Mar 3 14:04:21.879953 systemd[1]: Started session-24.scope - Session 24 of User core. Mar 3 14:04:22.176981 sshd[15531]: Connection closed by 10.200.16.10 port 34908 Mar 3 14:04:22.177244 sshd-session[15528]: pam_unix(sshd:session): session closed for user core Mar 3 14:04:22.180578 systemd[1]: sshd@21-10.200.8.10:22-10.200.16.10:34908.service: Deactivated successfully. Mar 3 14:04:22.182254 systemd[1]: session-24.scope: Deactivated successfully. Mar 3 14:04:22.182915 systemd-logind[1877]: Session 24 logged out. Waiting for processes to exit. Mar 3 14:04:22.183801 systemd-logind[1877]: Removed session 24. Mar 3 14:04:22.294809 systemd[1]: Started sshd@22-10.200.8.10:22-10.200.16.10:34918.service - OpenSSH per-connection server daemon (10.200.16.10:34918). Mar 3 14:04:22.847958 sshd[15537]: Accepted publickey for core from 10.200.16.10 port 34918 ssh2: RSA SHA256:8W4DoHNKBfbl6D0QDhi4iRjE4dImxv/T8O/sEee+660 Mar 3 14:04:22.849224 sshd-session[15537]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Mar 3 14:04:22.853899 systemd-logind[1877]: New session 25 of user core. Mar 3 14:04:22.862947 systemd[1]: Started session-25.scope - Session 25 of User core. Mar 3 14:04:23.162891 sshd[15540]: Connection closed by 10.200.16.10 port 34918 Mar 3 14:04:23.165691 sshd-session[15537]: pam_unix(sshd:session): session closed for user core Mar 3 14:04:23.169144 systemd[1]: sshd@22-10.200.8.10:22-10.200.16.10:34918.service: Deactivated successfully. Mar 3 14:04:23.170767 systemd[1]: session-25.scope: Deactivated successfully. Mar 3 14:04:23.171450 systemd-logind[1877]: Session 25 logged out. Waiting for processes to exit. Mar 3 14:04:23.172344 systemd-logind[1877]: Removed session 25. Mar 3 14:04:23.282103 systemd[1]: Started sshd@23-10.200.8.10:22-10.200.16.10:34928.service - OpenSSH per-connection server daemon (10.200.16.10:34928). Mar 3 14:04:23.862257 sshd[15546]: Accepted publickey for core from 10.200.16.10 port 34928 ssh2: RSA SHA256:8W4DoHNKBfbl6D0QDhi4iRjE4dImxv/T8O/sEee+660 Mar 3 14:04:23.863521 sshd-session[15546]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Mar 3 14:04:23.867751 systemd-logind[1877]: New session 26 of user core. Mar 3 14:04:23.878951 systemd[1]: Started session-26.scope - Session 26 of User core. Mar 3 14:04:24.178728 sshd[15549]: Connection closed by 10.200.16.10 port 34928 Mar 3 14:04:24.179027 sshd-session[15546]: pam_unix(sshd:session): session closed for user core Mar 3 14:04:24.182394 systemd[1]: sshd@23-10.200.8.10:22-10.200.16.10:34928.service: Deactivated successfully. Mar 3 14:04:24.183952 systemd[1]: session-26.scope: Deactivated successfully. Mar 3 14:04:24.184617 systemd-logind[1877]: Session 26 logged out. Waiting for processes to exit. Mar 3 14:04:24.185536 systemd-logind[1877]: Removed session 26. Mar 3 14:04:24.298052 systemd[1]: Started sshd@24-10.200.8.10:22-10.200.16.10:34938.service - OpenSSH per-connection server daemon (10.200.16.10:34938). Mar 3 14:04:24.874457 sshd[15555]: Accepted publickey for core from 10.200.16.10 port 34938 ssh2: RSA SHA256:8W4DoHNKBfbl6D0QDhi4iRjE4dImxv/T8O/sEee+660 Mar 3 14:04:24.875704 sshd-session[15555]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Mar 3 14:04:24.879846 systemd-logind[1877]: New session 27 of user core. Mar 3 14:04:24.893939 systemd[1]: Started session-27.scope - Session 27 of User core. Mar 3 14:04:25.198065 sshd[15558]: Connection closed by 10.200.16.10 port 34938 Mar 3 14:04:25.198410 sshd-session[15555]: pam_unix(sshd:session): session closed for user core Mar 3 14:04:25.201907 systemd[1]: sshd@24-10.200.8.10:22-10.200.16.10:34938.service: Deactivated successfully. Mar 3 14:04:25.203698 systemd[1]: session-27.scope: Deactivated successfully. Mar 3 14:04:25.204487 systemd-logind[1877]: Session 27 logged out. Waiting for processes to exit. Mar 3 14:04:25.205393 systemd-logind[1877]: Removed session 27. Mar 3 14:04:25.316155 systemd[1]: Started sshd@25-10.200.8.10:22-10.200.16.10:34946.service - OpenSSH per-connection server daemon (10.200.16.10:34946). Mar 3 14:04:25.890444 sshd[15564]: Accepted publickey for core from 10.200.16.10 port 34946 ssh2: RSA SHA256:8W4DoHNKBfbl6D0QDhi4iRjE4dImxv/T8O/sEee+660 Mar 3 14:04:25.891728 sshd-session[15564]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Mar 3 14:04:25.895932 systemd-logind[1877]: New session 28 of user core. Mar 3 14:04:25.912939 systemd[1]: Started session-28.scope - Session 28 of User core. Mar 3 14:04:27.687379 sshd[15567]: Connection closed by 10.200.16.10 port 34946 Mar 3 14:04:27.687789 sshd-session[15564]: pam_unix(sshd:session): session closed for user core Mar 3 14:04:27.691336 systemd[1]: sshd@25-10.200.8.10:22-10.200.16.10:34946.service: Deactivated successfully. Mar 3 14:04:27.693011 systemd[1]: session-28.scope: Deactivated successfully. Mar 3 14:04:27.693206 systemd[1]: session-28.scope: Consumed 1.421s CPU time, 14.2M memory peak. Mar 3 14:04:27.693672 systemd-logind[1877]: Session 28 logged out. Waiting for processes to exit. Mar 3 14:04:27.694731 systemd-logind[1877]: Removed session 28.