Nov 24 00:19:43.172795 kernel: Linux version 6.12.58-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 Sun Nov 23 20:54:38 -00 2025 Nov 24 00:19:43.172824 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=1969a6ee0c0ec5507eb68849c160e94c58e52d2291c767873af68a1f52b30801 Nov 24 00:19:43.172834 kernel: BIOS-provided physical RAM map: Nov 24 00:19:43.172841 kernel: BIOS-e820: [mem 0x0000000000000000-0x000000000009ffff] usable Nov 24 00:19:43.172848 kernel: BIOS-e820: [mem 0x00000000000c0000-0x00000000000fffff] reserved Nov 24 00:19:43.172854 kernel: BIOS-e820: [mem 0x0000000000100000-0x000000003ff40fff] usable Nov 24 00:19:43.172862 kernel: BIOS-e820: [mem 0x000000003ff41000-0x000000003ffc8fff] reserved Nov 24 00:19:43.172872 kernel: BIOS-e820: [mem 0x000000003ffc9000-0x000000003fffafff] ACPI data Nov 24 00:19:43.172879 kernel: BIOS-e820: [mem 0x000000003fffb000-0x000000003fffefff] ACPI NVS Nov 24 00:19:43.172886 kernel: BIOS-e820: [mem 0x000000003ffff000-0x000000003fffffff] usable Nov 24 00:19:43.172893 kernel: BIOS-e820: [mem 0x0000000100000000-0x0000000fdfffffff] usable Nov 24 00:19:43.172899 kernel: BIOS-e820: [mem 0x0000004fe0000000-0x0000005cbfffffff] usable Nov 24 00:19:43.172906 kernel: printk: legacy bootconsole [earlyser0] enabled Nov 24 00:19:43.172913 kernel: NX (Execute Disable) protection: active Nov 24 00:19:43.172924 kernel: APIC: Static calls initialized Nov 24 00:19:43.172932 kernel: efi: EFI v2.7 by Microsoft Nov 24 00:19:43.172940 kernel: efi: ACPI=0x3fffa000 ACPI 2.0=0x3fffa014 SMBIOS=0x3ff85000 SMBIOS 3.0=0x3ff83000 MEMATTR=0x3f5bfa98 RNG=0x3ffd1018 Nov 24 00:19:43.172947 kernel: random: crng init done Nov 24 00:19:43.172955 kernel: secureboot: Secure boot disabled Nov 24 00:19:43.172962 kernel: SMBIOS 3.1.0 present. Nov 24 00:19:43.172970 kernel: DMI: Microsoft Corporation Virtual Machine/Virtual Machine, BIOS Hyper-V UEFI Release v4.1 03/08/2024 Nov 24 00:19:43.172978 kernel: DMI: Memory slots populated: 3/3 Nov 24 00:19:43.172985 kernel: Hypervisor detected: Microsoft Hyper-V Nov 24 00:19:43.172993 kernel: Hyper-V: privilege flags low 0x2e7f, high 0x3b8030, hints 0x62c2c, misc 0xed7b2 Nov 24 00:19:43.173003 kernel: Hyper-V: LAPIC Timer Frequency: 0x30d40 Nov 24 00:19:43.173010 kernel: Hyper-V: Using hypercall for remote TLB flush Nov 24 00:19:43.173018 kernel: clocksource: hyperv_clocksource_tsc_page: mask: 0xffffffffffffffff max_cycles: 0x24e6a1710, max_idle_ns: 440795202120 ns Nov 24 00:19:43.173026 kernel: clocksource: hyperv_clocksource_msr: mask: 0xffffffffffffffff max_cycles: 0x24e6a1710, max_idle_ns: 440795202120 ns Nov 24 00:19:43.173034 kernel: tsc: Marking TSC unstable due to running on Hyper-V Nov 24 00:19:43.173042 kernel: tsc: Detected 2593.992 MHz processor Nov 24 00:19:43.173050 kernel: e820: update [mem 0x00000000-0x00000fff] usable ==> reserved Nov 24 00:19:43.173057 kernel: e820: remove [mem 0x000a0000-0x000fffff] usable Nov 24 00:19:43.173065 kernel: last_pfn = 0x5cc0000 max_arch_pfn = 0x400000000 Nov 24 00:19:43.173075 kernel: MTRR map: 5 entries (2 fixed + 3 variable; max 18), built from 8 variable MTRRs Nov 24 00:19:43.173083 kernel: x86/PAT: Configuration [0-7]: WB WC UC- UC WB WP UC- WT Nov 24 00:19:43.173091 kernel: e820: update [mem 0x40000000-0xffffffff] usable ==> reserved Nov 24 00:19:43.173098 kernel: e820: update [mem 0x1100000000-0x4fdfffffff] usable ==> reserved Nov 24 00:19:43.173111 kernel: last_pfn = 0x40000 max_arch_pfn = 0x400000000 Nov 24 00:19:43.173121 kernel: Using GB pages for direct mapping Nov 24 00:19:43.173129 kernel: ACPI: Early table checksum verification disabled Nov 24 00:19:43.173142 kernel: ACPI: RSDP 0x000000003FFFA014 000024 (v02 VRTUAL) Nov 24 00:19:43.173153 kernel: ACPI: XSDT 0x000000003FFF90E8 000064 (v01 VRTUAL MICROSFT 00000001 MSFT 00000001) Nov 24 00:19:43.173161 kernel: ACPI: FACP 0x000000003FFF8000 000114 (v06 VRTUAL MICROSFT 00000001 MSFT 00000001) Nov 24 00:19:43.173169 kernel: ACPI: DSDT 0x000000003FFD6000 01E184 (v02 MSFTVM DSDT01 00000001 MSFT 05000000) Nov 24 00:19:43.173177 kernel: ACPI: FACS 0x000000003FFFE000 000040 Nov 24 00:19:43.173186 kernel: ACPI: OEM0 0x000000003FFF7000 000064 (v01 VRTUAL MICROSFT 00000001 MSFT 00000001) Nov 24 00:19:43.173194 kernel: ACPI: SPCR 0x000000003FFF6000 000050 (v02 VRTUAL MICROSFT 00000001 MSFT 00000001) Nov 24 00:19:43.173204 kernel: ACPI: WAET 0x000000003FFF5000 000028 (v01 VRTUAL MICROSFT 00000001 MSFT 00000001) Nov 24 00:19:43.173212 kernel: ACPI: APIC 0x000000003FFD5000 000078 (v04 VRTUAL MICROSFT 00000001 MSFT 00000001) Nov 24 00:19:43.173221 kernel: ACPI: SRAT 0x000000003FFD4000 0001D0 (v02 VRTUAL MICROSFT 00000001 MSFT 00000001) Nov 24 00:19:43.173229 kernel: ACPI: BGRT 0x000000003FFD3000 000038 (v01 VRTUAL MICROSFT 00000001 MSFT 00000001) Nov 24 00:19:43.173237 kernel: ACPI: FPDT 0x000000003FFD2000 000034 (v01 VRTUAL MICROSFT 00000001 MSFT 00000001) Nov 24 00:19:43.173245 kernel: ACPI: Reserving FACP table memory at [mem 0x3fff8000-0x3fff8113] Nov 24 00:19:43.173253 kernel: ACPI: Reserving DSDT table memory at [mem 0x3ffd6000-0x3fff4183] Nov 24 00:19:43.173261 kernel: ACPI: Reserving FACS table memory at [mem 0x3fffe000-0x3fffe03f] Nov 24 00:19:43.173269 kernel: ACPI: Reserving OEM0 table memory at [mem 0x3fff7000-0x3fff7063] Nov 24 00:19:43.173280 kernel: ACPI: Reserving SPCR table memory at [mem 0x3fff6000-0x3fff604f] Nov 24 00:19:43.173288 kernel: ACPI: Reserving WAET table memory at [mem 0x3fff5000-0x3fff5027] Nov 24 00:19:43.173296 kernel: ACPI: Reserving APIC table memory at [mem 0x3ffd5000-0x3ffd5077] Nov 24 00:19:43.173304 kernel: ACPI: Reserving SRAT table memory at [mem 0x3ffd4000-0x3ffd41cf] Nov 24 00:19:43.173312 kernel: ACPI: Reserving BGRT table memory at [mem 0x3ffd3000-0x3ffd3037] Nov 24 00:19:43.173320 kernel: ACPI: Reserving FPDT table memory at [mem 0x3ffd2000-0x3ffd2033] Nov 24 00:19:43.173328 kernel: ACPI: SRAT: Node 0 PXM 0 [mem 0x00000000-0x3fffffff] hotplug Nov 24 00:19:43.173336 kernel: ACPI: SRAT: Node 0 PXM 0 [mem 0x100000000-0xfdfffffff] hotplug Nov 24 00:19:43.173347 kernel: ACPI: SRAT: Node 0 PXM 0 [mem 0x4fe0000000-0x5cbfffffff] hotplug Nov 24 00:19:43.173355 kernel: ACPI: SRAT: Node 0 PXM 0 [mem 0x5cc0200000-0xffffffffff] hotplug Nov 24 00:19:43.173363 kernel: ACPI: SRAT: Node 0 PXM 0 [mem 0x10000200000-0x1ffffffffff] hotplug Nov 24 00:19:43.173371 kernel: ACPI: SRAT: Node 0 PXM 0 [mem 0x20000200000-0x3ffffffffff] hotplug Nov 24 00:19:43.173379 kernel: ACPI: SRAT: Node 0 PXM 0 [mem 0x40000200000-0x7ffffffffff] hotplug Nov 24 00:19:43.173388 kernel: ACPI: SRAT: Node 0 PXM 0 [mem 0x80000200000-0xfffffffffff] hotplug Nov 24 00:19:43.173396 kernel: NUMA: Node 0 [mem 0x00001000-0x3fffffff] + [mem 0x100000000-0xfdfffffff] -> [mem 0x00001000-0xfdfffffff] Nov 24 00:19:43.173404 kernel: NUMA: Node 0 [mem 0x00001000-0xfdfffffff] + [mem 0x4fe0000000-0x5cbfffffff] -> [mem 0x00001000-0x5cbfffffff] Nov 24 00:19:43.173412 kernel: NODE_DATA(0) allocated [mem 0x5cbfff7dc0-0x5cbfffefff] Nov 24 00:19:43.173423 kernel: Zone ranges: Nov 24 00:19:43.173431 kernel: DMA [mem 0x0000000000001000-0x0000000000ffffff] Nov 24 00:19:43.173439 kernel: DMA32 [mem 0x0000000001000000-0x00000000ffffffff] Nov 24 00:19:43.173448 kernel: Normal [mem 0x0000000100000000-0x0000005cbfffffff] Nov 24 00:19:43.173456 kernel: Device empty Nov 24 00:19:43.173464 kernel: Movable zone start for each node Nov 24 00:19:43.173472 kernel: Early memory node ranges Nov 24 00:19:43.173480 kernel: node 0: [mem 0x0000000000001000-0x000000000009ffff] Nov 24 00:19:43.173488 kernel: node 0: [mem 0x0000000000100000-0x000000003ff40fff] Nov 24 00:19:43.173499 kernel: node 0: [mem 0x000000003ffff000-0x000000003fffffff] Nov 24 00:19:43.173507 kernel: node 0: [mem 0x0000000100000000-0x0000000fdfffffff] Nov 24 00:19:43.173515 kernel: node 0: [mem 0x0000004fe0000000-0x0000005cbfffffff] Nov 24 00:19:43.173523 kernel: Initmem setup node 0 [mem 0x0000000000001000-0x0000005cbfffffff] Nov 24 00:19:43.173531 kernel: On node 0, zone DMA: 1 pages in unavailable ranges Nov 24 00:19:43.173539 kernel: On node 0, zone DMA: 96 pages in unavailable ranges Nov 24 00:19:43.173547 kernel: On node 0, zone DMA32: 190 pages in unavailable ranges Nov 24 00:19:43.173555 kernel: ACPI: PM-Timer IO Port: 0x408 Nov 24 00:19:43.173563 kernel: ACPI: LAPIC_NMI (acpi_id[0x01] dfl dfl lint[0x1]) Nov 24 00:19:43.173574 kernel: IOAPIC[0]: apic_id 6, version 17, address 0xfec00000, GSI 0-23 Nov 24 00:19:43.173582 kernel: ACPI: INT_SRC_OVR (bus 0 bus_irq 9 global_irq 9 high level) Nov 24 00:19:43.173590 kernel: ACPI: Using ACPI (MADT) for SMP configuration information Nov 24 00:19:43.173598 kernel: ACPI: SPCR: console: uart,io,0x3f8,115200 Nov 24 00:19:43.173606 kernel: CPU topo: Max. logical packages: 1 Nov 24 00:19:43.173615 kernel: CPU topo: Max. logical dies: 1 Nov 24 00:19:43.173623 kernel: CPU topo: Max. dies per package: 1 Nov 24 00:19:43.173631 kernel: CPU topo: Max. threads per core: 1 Nov 24 00:19:43.173639 kernel: CPU topo: Num. cores per package: 6 Nov 24 00:19:43.173649 kernel: CPU topo: Num. threads per package: 6 Nov 24 00:19:43.173657 kernel: CPU topo: Allowing 6 present CPUs plus 0 hotplug CPUs Nov 24 00:19:43.173666 kernel: [mem 0x40000000-0xffffffff] available for PCI devices Nov 24 00:19:43.173674 kernel: Booting paravirtualized kernel on Hyper-V Nov 24 00:19:43.173682 kernel: clocksource: refined-jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1910969940391419 ns Nov 24 00:19:43.173701 kernel: setup_percpu: NR_CPUS:512 nr_cpumask_bits:6 nr_cpu_ids:6 nr_node_ids:1 Nov 24 00:19:43.173709 kernel: percpu: Embedded 60 pages/cpu s207832 r8192 d29736 u262144 Nov 24 00:19:43.173718 kernel: pcpu-alloc: s207832 r8192 d29736 u262144 alloc=1*2097152 Nov 24 00:19:43.173726 kernel: pcpu-alloc: [0] 0 1 2 3 4 5 - - Nov 24 00:19:43.173737 kernel: Hyper-V: PV spinlocks enabled Nov 24 00:19:43.173745 kernel: PV qspinlock hash table entries: 256 (order: 0, 4096 bytes, linear) Nov 24 00:19:43.173754 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=1969a6ee0c0ec5507eb68849c160e94c58e52d2291c767873af68a1f52b30801 Nov 24 00:19:43.173763 kernel: Dentry cache hash table entries: 8388608 (order: 14, 67108864 bytes, linear) Nov 24 00:19:43.173771 kernel: Inode-cache hash table entries: 4194304 (order: 13, 33554432 bytes, linear) Nov 24 00:19:43.173779 kernel: Fallback order for Node 0: 0 Nov 24 00:19:43.173788 kernel: Built 1 zonelists, mobility grouping on. Total pages: 29359841 Nov 24 00:19:43.173796 kernel: Policy zone: Normal Nov 24 00:19:43.173807 kernel: mem auto-init: stack:off, heap alloc:off, heap free:off Nov 24 00:19:43.173823 kernel: software IO TLB: area num 8. Nov 24 00:19:43.173831 kernel: SLUB: HWalign=64, Order=0-3, MinObjects=0, CPUs=6, Nodes=1 Nov 24 00:19:43.173842 kernel: Kernel/User page tables isolation: enabled Nov 24 00:19:43.173851 kernel: ftrace: allocating 40103 entries in 157 pages Nov 24 00:19:43.173859 kernel: ftrace: allocated 157 pages with 5 groups Nov 24 00:19:43.173868 kernel: Dynamic Preempt: voluntary Nov 24 00:19:43.173877 kernel: rcu: Preemptible hierarchical RCU implementation. Nov 24 00:19:43.173886 kernel: rcu: RCU event tracing is enabled. Nov 24 00:19:43.173895 kernel: rcu: RCU restricting CPUs from NR_CPUS=512 to nr_cpu_ids=6. Nov 24 00:19:43.173904 kernel: Trampoline variant of Tasks RCU enabled. Nov 24 00:19:43.173915 kernel: Rude variant of Tasks RCU enabled. Nov 24 00:19:43.173923 kernel: Tracing variant of Tasks RCU enabled. Nov 24 00:19:43.173932 kernel: rcu: RCU calculated value of scheduler-enlistment delay is 100 jiffies. Nov 24 00:19:43.173940 kernel: rcu: Adjusting geometry for rcu_fanout_leaf=16, nr_cpu_ids=6 Nov 24 00:19:43.173949 kernel: RCU Tasks: Setting shift to 3 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=6. Nov 24 00:19:43.173958 kernel: RCU Tasks Rude: Setting shift to 3 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=6. Nov 24 00:19:43.173969 kernel: RCU Tasks Trace: Setting shift to 3 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=6. Nov 24 00:19:43.173978 kernel: Using NULL legacy PIC Nov 24 00:19:43.173986 kernel: NR_IRQS: 33024, nr_irqs: 472, preallocated irqs: 0 Nov 24 00:19:43.173995 kernel: rcu: srcu_init: Setting srcu_struct sizes based on contention. Nov 24 00:19:43.174003 kernel: Console: colour dummy device 80x25 Nov 24 00:19:43.174012 kernel: printk: legacy console [tty1] enabled Nov 24 00:19:43.174021 kernel: printk: legacy console [ttyS0] enabled Nov 24 00:19:43.174029 kernel: printk: legacy bootconsole [earlyser0] disabled Nov 24 00:19:43.174038 kernel: ACPI: Core revision 20240827 Nov 24 00:19:43.174049 kernel: Failed to register legacy timer interrupt Nov 24 00:19:43.174058 kernel: APIC: Switch to symmetric I/O mode setup Nov 24 00:19:43.174066 kernel: Hyper-V: Host Build 10.0.20348.1827-1-0 Nov 24 00:19:43.174075 kernel: Hyper-V: enabling crash_kexec_post_notifiers Nov 24 00:19:43.174083 kernel: Hyper-V: Using IPI hypercalls Nov 24 00:19:43.174092 kernel: APIC: send_IPI() replaced with hv_send_ipi() Nov 24 00:19:43.174100 kernel: APIC: send_IPI_mask() replaced with hv_send_ipi_mask() Nov 24 00:19:43.174109 kernel: APIC: send_IPI_mask_allbutself() replaced with hv_send_ipi_mask_allbutself() Nov 24 00:19:43.174117 kernel: APIC: send_IPI_allbutself() replaced with hv_send_ipi_allbutself() Nov 24 00:19:43.174128 kernel: APIC: send_IPI_all() replaced with hv_send_ipi_all() Nov 24 00:19:43.174137 kernel: APIC: send_IPI_self() replaced with hv_send_ipi_self() Nov 24 00:19:43.174145 kernel: Hyper-V: Using enlightened APIC (xapic mode) Nov 24 00:19:43.174154 kernel: APIC: eoi() replaced with hv_apic_eoi_write() Nov 24 00:19:43.174162 kernel: APIC: read() replaced with hv_apic_read() Nov 24 00:19:43.174171 kernel: APIC: write() replaced with hv_apic_write() Nov 24 00:19:43.174180 kernel: APIC: icr_write() replaced with hv_apic_icr_write() Nov 24 00:19:43.174188 kernel: APIC: icr_read() replaced with hv_apic_icr_read() Nov 24 00:19:43.174197 kernel: Calibrating delay loop (skipped), value calculated using timer frequency.. 5187.98 BogoMIPS (lpj=2593992) Nov 24 00:19:43.174208 kernel: Last level iTLB entries: 4KB 128, 2MB 8, 4MB 8 Nov 24 00:19:43.174216 kernel: Last level dTLB entries: 4KB 64, 2MB 32, 4MB 32, 1GB 4 Nov 24 00:19:43.174225 kernel: Spectre V1 : Mitigation: usercopy/swapgs barriers and __user pointer sanitization Nov 24 00:19:43.174233 kernel: Spectre V2 : Mitigation: Retpolines Nov 24 00:19:43.174242 kernel: Spectre V2 : Spectre v2 / SpectreRSB: Filling RSB on context switch and VMEXIT Nov 24 00:19:43.174250 kernel: Speculative Store Bypass: Vulnerable Nov 24 00:19:43.174258 kernel: MDS: Mitigation: Clear CPU buffers Nov 24 00:19:43.174267 kernel: TAA: Mitigation: Clear CPU buffers Nov 24 00:19:43.174275 kernel: MMIO Stale Data: Vulnerable: Clear CPU buffers attempted, no microcode Nov 24 00:19:43.174283 kernel: active return thunk: its_return_thunk Nov 24 00:19:43.174292 kernel: ITS: Mitigation: Aligned branch/return thunks Nov 24 00:19:43.174303 kernel: x86/fpu: Supporting XSAVE feature 0x001: 'x87 floating point registers' Nov 24 00:19:43.174311 kernel: x86/fpu: Supporting XSAVE feature 0x002: 'SSE registers' Nov 24 00:19:43.174319 kernel: x86/fpu: Supporting XSAVE feature 0x004: 'AVX registers' Nov 24 00:19:43.174328 kernel: x86/fpu: xstate_offset[2]: 576, xstate_sizes[2]: 256 Nov 24 00:19:43.174336 kernel: x86/fpu: Enabled xstate features 0x7, context size is 832 bytes, using 'standard' format. Nov 24 00:19:43.174345 kernel: Freeing SMP alternatives memory: 32K Nov 24 00:19:43.174353 kernel: pid_max: default: 32768 minimum: 301 Nov 24 00:19:43.174361 kernel: LSM: initializing lsm=lockdown,capability,landlock,selinux,ima Nov 24 00:19:43.174370 kernel: landlock: Up and running. Nov 24 00:19:43.174378 kernel: SELinux: Initializing. Nov 24 00:19:43.174387 kernel: Mount-cache hash table entries: 131072 (order: 8, 1048576 bytes, linear) Nov 24 00:19:43.174397 kernel: Mountpoint-cache hash table entries: 131072 (order: 8, 1048576 bytes, linear) Nov 24 00:19:43.174406 kernel: smpboot: CPU0: Intel(R) Xeon(R) CPU E5-2690 v4 @ 2.60GHz (family: 0x6, model: 0x4f, stepping: 0x1) Nov 24 00:19:43.174414 kernel: Performance Events: unsupported p6 CPU model 79 no PMU driver, software events only. Nov 24 00:19:43.174423 kernel: signal: max sigframe size: 1776 Nov 24 00:19:43.174432 kernel: rcu: Hierarchical SRCU implementation. Nov 24 00:19:43.174447 kernel: rcu: Max phase no-delay instances is 400. Nov 24 00:19:43.174456 kernel: Timer migration: 1 hierarchy levels; 8 children per group; 1 crossnode level Nov 24 00:19:43.174465 kernel: NMI watchdog: Perf NMI watchdog permanently disabled Nov 24 00:19:43.174474 kernel: smp: Bringing up secondary CPUs ... Nov 24 00:19:43.174490 kernel: smpboot: x86: Booting SMP configuration: Nov 24 00:19:43.174499 kernel: .... node #0, CPUs: #1 #2 #3 #4 #5 Nov 24 00:19:43.174508 kernel: smp: Brought up 1 node, 6 CPUs Nov 24 00:19:43.174516 kernel: smpboot: Total of 6 processors activated (31127.90 BogoMIPS) Nov 24 00:19:43.174525 kernel: Memory: 115330896K/117439364K available (14336K kernel code, 2444K rwdata, 26064K rodata, 46188K init, 2572K bss, 2098192K reserved, 0K cma-reserved) Nov 24 00:19:43.174534 kernel: devtmpfs: initialized Nov 24 00:19:43.174543 kernel: x86/mm: Memory block size: 1024MB Nov 24 00:19:43.174551 kernel: ACPI: PM: Registering ACPI NVS region [mem 0x3fffb000-0x3fffefff] (16384 bytes) Nov 24 00:19:43.174560 kernel: clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1911260446275000 ns Nov 24 00:19:43.174571 kernel: futex hash table entries: 2048 (order: 5, 131072 bytes, linear) Nov 24 00:19:43.174580 kernel: pinctrl core: initialized pinctrl subsystem Nov 24 00:19:43.174589 kernel: NET: Registered PF_NETLINK/PF_ROUTE protocol family Nov 24 00:19:43.174598 kernel: audit: initializing netlink subsys (disabled) Nov 24 00:19:43.174606 kernel: audit: type=2000 audit(1763943579.028:1): state=initialized audit_enabled=0 res=1 Nov 24 00:19:43.174615 kernel: thermal_sys: Registered thermal governor 'step_wise' Nov 24 00:19:43.174623 kernel: thermal_sys: Registered thermal governor 'user_space' Nov 24 00:19:43.174632 kernel: cpuidle: using governor menu Nov 24 00:19:43.174641 kernel: acpiphp: ACPI Hot Plug PCI Controller Driver version: 0.5 Nov 24 00:19:43.174652 kernel: dca service started, version 1.12.1 Nov 24 00:19:43.174660 kernel: e820: reserve RAM buffer [mem 0x3ff41000-0x3fffffff] Nov 24 00:19:43.174669 kernel: kprobes: kprobe jump-optimization is enabled. All kprobes are optimized if possible. Nov 24 00:19:43.174678 kernel: HugeTLB: registered 1.00 GiB page size, pre-allocated 0 pages Nov 24 00:19:43.174694 kernel: HugeTLB: 16380 KiB vmemmap can be freed for a 1.00 GiB page Nov 24 00:19:43.174703 kernel: HugeTLB: registered 2.00 MiB page size, pre-allocated 0 pages Nov 24 00:19:43.174712 kernel: HugeTLB: 28 KiB vmemmap can be freed for a 2.00 MiB page Nov 24 00:19:43.174720 kernel: ACPI: Added _OSI(Module Device) Nov 24 00:19:43.174729 kernel: ACPI: Added _OSI(Processor Device) Nov 24 00:19:43.174740 kernel: ACPI: Added _OSI(Processor Aggregator Device) Nov 24 00:19:43.174749 kernel: ACPI: 1 ACPI AML tables successfully acquired and loaded Nov 24 00:19:43.174758 kernel: ACPI: Interpreter enabled Nov 24 00:19:43.174766 kernel: ACPI: PM: (supports S0 S5) Nov 24 00:19:43.174784 kernel: ACPI: Using IOAPIC for interrupt routing Nov 24 00:19:43.174797 kernel: PCI: Using host bridge windows from ACPI; if necessary, use "pci=nocrs" and report a bug Nov 24 00:19:43.174807 kernel: PCI: Ignoring E820 reservations for host bridge windows Nov 24 00:19:43.174815 kernel: ACPI: Enabled 1 GPEs in block 00 to 0F Nov 24 00:19:43.174824 kernel: iommu: Default domain type: Translated Nov 24 00:19:43.174835 kernel: iommu: DMA domain TLB invalidation policy: lazy mode Nov 24 00:19:43.174844 kernel: efivars: Registered efivars operations Nov 24 00:19:43.174853 kernel: PCI: Using ACPI for IRQ routing Nov 24 00:19:43.174861 kernel: PCI: System does not support PCI Nov 24 00:19:43.174870 kernel: vgaarb: loaded Nov 24 00:19:43.174879 kernel: clocksource: Switched to clocksource hyperv_clocksource_tsc_page Nov 24 00:19:43.174887 kernel: VFS: Disk quotas dquot_6.6.0 Nov 24 00:19:43.174896 kernel: VFS: Dquot-cache hash table entries: 512 (order 0, 4096 bytes) Nov 24 00:19:43.174904 kernel: pnp: PnP ACPI init Nov 24 00:19:43.174915 kernel: pnp: PnP ACPI: found 3 devices Nov 24 00:19:43.174924 kernel: clocksource: acpi_pm: mask: 0xffffff max_cycles: 0xffffff, max_idle_ns: 2085701024 ns Nov 24 00:19:43.174933 kernel: NET: Registered PF_INET protocol family Nov 24 00:19:43.174942 kernel: IP idents hash table entries: 262144 (order: 9, 2097152 bytes, linear) Nov 24 00:19:43.174950 kernel: tcp_listen_portaddr_hash hash table entries: 65536 (order: 8, 1048576 bytes, linear) Nov 24 00:19:43.174959 kernel: Table-perturb hash table entries: 65536 (order: 6, 262144 bytes, linear) Nov 24 00:19:43.174968 kernel: TCP established hash table entries: 524288 (order: 10, 4194304 bytes, linear) Nov 24 00:19:43.174976 kernel: TCP bind hash table entries: 65536 (order: 9, 2097152 bytes, linear) Nov 24 00:19:43.174985 kernel: TCP: Hash tables configured (established 524288 bind 65536) Nov 24 00:19:43.174996 kernel: UDP hash table entries: 65536 (order: 9, 2097152 bytes, linear) Nov 24 00:19:43.175005 kernel: UDP-Lite hash table entries: 65536 (order: 9, 2097152 bytes, linear) Nov 24 00:19:43.175013 kernel: NET: Registered PF_UNIX/PF_LOCAL protocol family Nov 24 00:19:43.175022 kernel: NET: Registered PF_XDP protocol family Nov 24 00:19:43.175031 kernel: PCI: CLS 0 bytes, default 64 Nov 24 00:19:43.175039 kernel: PCI-DMA: Using software bounce buffering for IO (SWIOTLB) Nov 24 00:19:43.175048 kernel: software IO TLB: mapped [mem 0x000000003b5bf000-0x000000003f5bf000] (64MB) Nov 24 00:19:43.175057 kernel: RAPL PMU: API unit is 2^-32 Joules, 0 fixed counters, 10737418240 ms ovfl timer Nov 24 00:19:43.175065 kernel: Initialise system trusted keyrings Nov 24 00:19:43.175076 kernel: workingset: timestamp_bits=39 max_order=25 bucket_order=0 Nov 24 00:19:43.175085 kernel: Key type asymmetric registered Nov 24 00:19:43.175093 kernel: Asymmetric key parser 'x509' registered Nov 24 00:19:43.175102 kernel: Block layer SCSI generic (bsg) driver version 0.4 loaded (major 250) Nov 24 00:19:43.175110 kernel: io scheduler mq-deadline registered Nov 24 00:19:43.175119 kernel: io scheduler kyber registered Nov 24 00:19:43.175127 kernel: io scheduler bfq registered Nov 24 00:19:43.175136 kernel: ioatdma: Intel(R) QuickData Technology Driver 5.00 Nov 24 00:19:43.175145 kernel: Serial: 8250/16550 driver, 4 ports, IRQ sharing enabled Nov 24 00:19:43.175156 kernel: 00:00: ttyS0 at I/O 0x3f8 (irq = 4, base_baud = 115200) is a 16550A Nov 24 00:19:43.175164 kernel: 00:01: ttyS1 at I/O 0x2f8 (irq = 3, base_baud = 115200) is a 16550A Nov 24 00:19:43.175173 kernel: i8042: PNP: No PS/2 controller found. Nov 24 00:19:43.175333 kernel: rtc_cmos 00:02: registered as rtc0 Nov 24 00:19:43.175437 kernel: rtc_cmos 00:02: setting system clock to 2025-11-24T00:19:42 UTC (1763943582) Nov 24 00:19:43.175541 kernel: rtc_cmos 00:02: alarms up to one month, 114 bytes nvram Nov 24 00:19:43.175554 kernel: intel_pstate: CPU model not supported Nov 24 00:19:43.175567 kernel: efifb: probing for efifb Nov 24 00:19:43.175576 kernel: efifb: framebuffer at 0x40000000, using 3072k, total 3072k Nov 24 00:19:43.175585 kernel: efifb: mode is 1024x768x32, linelength=4096, pages=1 Nov 24 00:19:43.175594 kernel: efifb: scrolling: redraw Nov 24 00:19:43.175602 kernel: efifb: Truecolor: size=8:8:8:8, shift=24:16:8:0 Nov 24 00:19:43.175611 kernel: Console: switching to colour frame buffer device 128x48 Nov 24 00:19:43.175620 kernel: fb0: EFI VGA frame buffer device Nov 24 00:19:43.175628 kernel: pstore: Using crash dump compression: deflate Nov 24 00:19:43.175637 kernel: pstore: Registered efi_pstore as persistent store backend Nov 24 00:19:43.175648 kernel: NET: Registered PF_INET6 protocol family Nov 24 00:19:43.175656 kernel: Segment Routing with IPv6 Nov 24 00:19:43.175665 kernel: In-situ OAM (IOAM) with IPv6 Nov 24 00:19:43.175674 kernel: NET: Registered PF_PACKET protocol family Nov 24 00:19:43.175682 kernel: Key type dns_resolver registered Nov 24 00:19:43.175702 kernel: IPI shorthand broadcast: enabled Nov 24 00:19:43.175711 kernel: sched_clock: Marking stable (3580006000, 109370700)->(4030107000, -340730300) Nov 24 00:19:43.175720 kernel: registered taskstats version 1 Nov 24 00:19:43.175729 kernel: Loading compiled-in X.509 certificates Nov 24 00:19:43.175737 kernel: Loaded X.509 cert 'Kinvolk GmbH: Module signing key for 6.12.58-flatcar: 5d380f93d180914be04be8068ab300f495c35900' Nov 24 00:19:43.175749 kernel: Demotion targets for Node 0: null Nov 24 00:19:43.175758 kernel: Key type .fscrypt registered Nov 24 00:19:43.175766 kernel: Key type fscrypt-provisioning registered Nov 24 00:19:43.175774 kernel: ima: No TPM chip found, activating TPM-bypass! Nov 24 00:19:43.175783 kernel: ima: Allocated hash algorithm: sha1 Nov 24 00:19:43.175791 kernel: ima: No architecture policies found Nov 24 00:19:43.175800 kernel: clk: Disabling unused clocks Nov 24 00:19:43.175808 kernel: Warning: unable to open an initial console. Nov 24 00:19:43.175817 kernel: Freeing unused kernel image (initmem) memory: 46188K Nov 24 00:19:43.175828 kernel: Write protecting the kernel read-only data: 40960k Nov 24 00:19:43.175837 kernel: Freeing unused kernel image (rodata/data gap) memory: 560K Nov 24 00:19:43.175845 kernel: Run /init as init process Nov 24 00:19:43.175854 kernel: with arguments: Nov 24 00:19:43.175862 kernel: /init Nov 24 00:19:43.175871 kernel: with environment: Nov 24 00:19:43.175879 kernel: HOME=/ Nov 24 00:19:43.175888 kernel: TERM=linux Nov 24 00:19:43.175897 systemd[1]: Successfully made /usr/ read-only. Nov 24 00:19:43.175912 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) Nov 24 00:19:43.175922 systemd[1]: Detected virtualization microsoft. Nov 24 00:19:43.175931 systemd[1]: Detected architecture x86-64. Nov 24 00:19:43.175939 systemd[1]: Running in initrd. Nov 24 00:19:43.175948 systemd[1]: No hostname configured, using default hostname. Nov 24 00:19:43.175958 systemd[1]: Hostname set to . Nov 24 00:19:43.175967 systemd[1]: Initializing machine ID from random generator. Nov 24 00:19:43.175978 systemd[1]: Queued start job for default target initrd.target. Nov 24 00:19:43.175987 systemd[1]: Started clevis-luks-askpass.path - Forward Password Requests to Clevis Directory Watch. Nov 24 00:19:43.175997 systemd[1]: Started systemd-ask-password-console.path - Dispatch Password Requests to Console Directory Watch. Nov 24 00:19:43.176006 systemd[1]: Expecting device dev-disk-by\x2dlabel-EFI\x2dSYSTEM.device - /dev/disk/by-label/EFI-SYSTEM... Nov 24 00:19:43.176016 systemd[1]: Expecting device dev-disk-by\x2dlabel-OEM.device - /dev/disk/by-label/OEM... Nov 24 00:19:43.176025 systemd[1]: Expecting device dev-disk-by\x2dlabel-ROOT.device - /dev/disk/by-label/ROOT... Nov 24 00:19:43.176035 systemd[1]: Expecting device dev-disk-by\x2dpartlabel-USR\x2dA.device - /dev/disk/by-partlabel/USR-A... Nov 24 00:19:43.176048 systemd[1]: Expecting device dev-disk-by\x2dpartuuid-7130c94a\x2d213a\x2d4e5a\x2d8e26\x2d6cce9662f132.device - /dev/disk/by-partuuid/7130c94a-213a-4e5a-8e26-6cce9662f132... Nov 24 00:19:43.176057 systemd[1]: Expecting device dev-mapper-usr.device - /dev/mapper/usr... Nov 24 00:19:43.176067 systemd[1]: Reached target cryptsetup-pre.target - Local Encrypted Volumes (Pre). Nov 24 00:19:43.176076 systemd[1]: Reached target cryptsetup.target - Local Encrypted Volumes. Nov 24 00:19:43.176085 systemd[1]: Reached target paths.target - Path Units. Nov 24 00:19:43.176094 systemd[1]: Reached target slices.target - Slice Units. Nov 24 00:19:43.176103 systemd[1]: Reached target swap.target - Swaps. Nov 24 00:19:43.176112 systemd[1]: Reached target timers.target - Timer Units. Nov 24 00:19:43.176124 systemd[1]: Listening on iscsid.socket - Open-iSCSI iscsid Socket. Nov 24 00:19:43.176133 systemd[1]: Listening on iscsiuio.socket - Open-iSCSI iscsiuio Socket. Nov 24 00:19:43.176142 systemd[1]: Listening on systemd-journald-dev-log.socket - Journal Socket (/dev/log). Nov 24 00:19:43.176151 systemd[1]: Listening on systemd-journald.socket - Journal Sockets. Nov 24 00:19:43.176160 systemd[1]: Listening on systemd-networkd.socket - Network Service Netlink Socket. Nov 24 00:19:43.176170 systemd[1]: Listening on systemd-udevd-control.socket - udev Control Socket. Nov 24 00:19:43.176179 systemd[1]: Listening on systemd-udevd-kernel.socket - udev Kernel Socket. Nov 24 00:19:43.176188 systemd[1]: Reached target sockets.target - Socket Units. Nov 24 00:19:43.176197 systemd[1]: Starting ignition-setup-pre.service - Ignition env setup... Nov 24 00:19:43.176209 systemd[1]: Starting kmod-static-nodes.service - Create List of Static Device Nodes... Nov 24 00:19:43.176218 systemd[1]: Finished network-cleanup.service - Network Cleanup. Nov 24 00:19:43.176227 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). Nov 24 00:19:43.176237 systemd[1]: Starting systemd-fsck-usr.service... Nov 24 00:19:43.176246 systemd[1]: Starting systemd-journald.service - Journal Service... Nov 24 00:19:43.176255 systemd[1]: Starting systemd-modules-load.service - Load Kernel Modules... Nov 24 00:19:43.176283 systemd-journald[214]: Collecting audit messages is disabled. Nov 24 00:19:43.176310 systemd[1]: Starting systemd-vconsole-setup.service - Virtual Console Setup... Nov 24 00:19:43.176320 systemd-journald[214]: Journal started Nov 24 00:19:43.176344 systemd-journald[214]: Runtime Journal (/run/log/journal/ae32ff07d44f417c8e0f6b8cade7173b) is 8M, max 2.2G, 2.1G free. Nov 24 00:19:43.179454 systemd-modules-load[216]: Inserted module 'overlay' Nov 24 00:19:43.185704 systemd[1]: Started systemd-journald.service - Journal Service. Nov 24 00:19:43.190531 systemd[1]: Finished ignition-setup-pre.service - Ignition env setup. Nov 24 00:19:43.195095 systemd[1]: Finished kmod-static-nodes.service - Create List of Static Device Nodes. Nov 24 00:19:43.197411 systemd[1]: Finished systemd-fsck-usr.service. Nov 24 00:19:43.199643 systemd[1]: Starting systemd-tmpfiles-setup-dev-early.service - Create Static Device Nodes in /dev gracefully... Nov 24 00:19:43.200746 systemd[1]: Starting systemd-tmpfiles-setup.service - Create System Files and Directories... Nov 24 00:19:43.238310 systemd-tmpfiles[225]: /usr/lib/tmpfiles.d/var.conf:14: Duplicate line for path "/var/log", ignoring. Nov 24 00:19:43.246972 kernel: bridge: filtering via arp/ip/ip6tables is no longer available by default. Update your scripts to load br_netfilter if you need this. Nov 24 00:19:43.239401 systemd[1]: Finished systemd-tmpfiles-setup-dev-early.service - Create Static Device Nodes in /dev gracefully. Nov 24 00:19:43.256710 systemd[1]: Finished systemd-vconsole-setup.service - Virtual Console Setup. Nov 24 00:19:43.270350 kernel: Bridge firewalling registered Nov 24 00:19:43.269060 systemd[1]: Finished systemd-tmpfiles-setup.service - Create System Files and Directories. Nov 24 00:19:43.269616 systemd-modules-load[216]: Inserted module 'br_netfilter' Nov 24 00:19:43.278446 systemd[1]: Finished systemd-modules-load.service - Load Kernel Modules. Nov 24 00:19:43.289348 systemd[1]: Starting dracut-cmdline-ask.service - dracut ask for additional cmdline parameters... Nov 24 00:19:43.293081 systemd[1]: Starting systemd-sysctl.service - Apply Kernel Variables... Nov 24 00:19:43.317970 systemd[1]: Starting systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev... Nov 24 00:19:43.333211 systemd[1]: Finished systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev. Nov 24 00:19:43.335016 systemd[1]: Finished dracut-cmdline-ask.service - dracut ask for additional cmdline parameters. Nov 24 00:19:43.347212 systemd[1]: Finished systemd-sysctl.service - Apply Kernel Variables. Nov 24 00:19:43.366377 systemd[1]: Starting dracut-cmdline.service - dracut cmdline hook... Nov 24 00:19:43.369034 systemd[1]: Starting systemd-resolved.service - Network Name Resolution... Nov 24 00:19:43.406954 dracut-cmdline[256]: 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=1969a6ee0c0ec5507eb68849c160e94c58e52d2291c767873af68a1f52b30801 Nov 24 00:19:43.421303 systemd-resolved[257]: Positive Trust Anchors: Nov 24 00:19:43.421311 systemd-resolved[257]: . IN DS 20326 8 2 e06d44b80b8f1d39a95c0b0d7c65d08458e880409bbc683457104237c7f8ec8d Nov 24 00:19:43.421342 systemd-resolved[257]: 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 Nov 24 00:19:43.423797 systemd-resolved[257]: Defaulting to hostname 'linux'. Nov 24 00:19:43.424800 systemd[1]: Started systemd-resolved.service - Network Name Resolution. Nov 24 00:19:43.433935 systemd[1]: Reached target nss-lookup.target - Host and Network Name Lookups. Nov 24 00:19:43.573716 kernel: SCSI subsystem initialized Nov 24 00:19:43.584710 kernel: Loading iSCSI transport class v2.0-870. Nov 24 00:19:43.597711 kernel: iscsi: registered transport (tcp) Nov 24 00:19:43.620770 kernel: iscsi: registered transport (qla4xxx) Nov 24 00:19:43.620798 kernel: QLogic iSCSI HBA Driver Nov 24 00:19:43.639329 systemd[1]: Starting systemd-network-generator.service - Generate network units from Kernel command line... Nov 24 00:19:43.673147 systemd[1]: Finished systemd-network-generator.service - Generate network units from Kernel command line. Nov 24 00:19:43.675735 systemd[1]: Reached target network-pre.target - Preparation for Network. Nov 24 00:19:43.738742 systemd[1]: Finished dracut-cmdline.service - dracut cmdline hook. Nov 24 00:19:43.740844 systemd[1]: Starting dracut-pre-udev.service - dracut pre-udev hook... Nov 24 00:19:43.815715 kernel: raid6: avx2x4 gen() 31069 MB/s Nov 24 00:19:43.834709 kernel: raid6: avx2x2 gen() 31207 MB/s Nov 24 00:19:43.856879 kernel: raid6: avx2x1 gen() 27826 MB/s Nov 24 00:19:43.856906 kernel: raid6: using algorithm avx2x2 gen() 31207 MB/s Nov 24 00:19:43.878932 kernel: raid6: .... xor() 18168 MB/s, rmw enabled Nov 24 00:19:43.878959 kernel: raid6: using avx2x2 recovery algorithm Nov 24 00:19:43.903706 kernel: xor: automatically using best checksumming function avx Nov 24 00:19:44.069718 kernel: Btrfs loaded, zoned=no, fsverity=no Nov 24 00:19:44.076608 systemd[1]: Finished dracut-pre-udev.service - dracut pre-udev hook. Nov 24 00:19:44.079604 systemd[1]: Starting systemd-udevd.service - Rule-based Manager for Device Events and Files... Nov 24 00:19:44.114220 systemd-udevd[469]: Using default interface naming scheme 'v255'. Nov 24 00:19:44.120278 systemd[1]: Started systemd-udevd.service - Rule-based Manager for Device Events and Files. Nov 24 00:19:44.131190 systemd[1]: Starting dracut-pre-trigger.service - dracut pre-trigger hook... Nov 24 00:19:44.156521 dracut-pre-trigger[480]: rd.md=0: removing MD RAID activation Nov 24 00:19:44.188903 systemd[1]: Finished dracut-pre-trigger.service - dracut pre-trigger hook. Nov 24 00:19:44.190904 systemd[1]: Starting systemd-udev-trigger.service - Coldplug All udev Devices... Nov 24 00:19:44.271838 systemd[1]: Finished systemd-udev-trigger.service - Coldplug All udev Devices. Nov 24 00:19:44.275802 systemd[1]: Starting dracut-initqueue.service - dracut initqueue hook... Nov 24 00:19:44.302715 kernel: cryptd: max_cpu_qlen set to 1000 Nov 24 00:19:44.317709 kernel: AES CTR mode by8 optimization enabled Nov 24 00:19:44.317745 kernel: hv_vmbus: Vmbus version:4.0 Nov 24 00:19:44.326463 systemd[1]: systemd-vconsole-setup.service: Deactivated successfully. Nov 24 00:19:44.331617 systemd[1]: Stopped systemd-vconsole-setup.service - Virtual Console Setup. Nov 24 00:19:44.341420 systemd[1]: Stopping systemd-vconsole-setup.service - Virtual Console Setup... Nov 24 00:19:44.357819 kernel: hv_vmbus: registering driver hyperv_keyboard Nov 24 00:19:44.357854 kernel: pps_core: LinuxPPS API ver. 1 registered Nov 24 00:19:44.366036 kernel: pps_core: Software ver. 5.3.6 - Copyright 2005-2007 Rodolfo Giometti Nov 24 00:19:44.366712 kernel: hid: raw HID events driver (C) Jiri Kosina Nov 24 00:19:44.371342 systemd[1]: Starting systemd-vconsole-setup.service - Virtual Console Setup... Nov 24 00:19:44.373118 systemd[1]: run-credentials-systemd\x2dvconsole\x2dsetup.service.mount: Deactivated successfully. Nov 24 00:19:44.394947 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 Nov 24 00:19:44.394972 kernel: PTP clock support registered Nov 24 00:19:44.394986 kernel: hv_vmbus: registering driver hid_hyperv Nov 24 00:19:44.388233 systemd[1]: systemd-vconsole-setup.service: Deactivated successfully. Nov 24 00:19:44.415526 kernel: input: Microsoft Vmbus HID-compliant Mouse as /devices/0006:045E:0621.0001/input/input1 Nov 24 00:19:44.415554 kernel: hid-hyperv 0006:045E:0621.0001: input: VIRTUAL HID v0.01 Mouse [Microsoft Vmbus HID-compliant Mouse] on Nov 24 00:19:44.388349 systemd[1]: Stopped systemd-vconsole-setup.service - Virtual Console Setup. Nov 24 00:19:44.424087 systemd[1]: Starting systemd-vconsole-setup.service - Virtual Console Setup... Nov 24 00:19:45.153131 kernel: hv_utils: Registering HyperV Utility Driver Nov 24 00:19:45.153166 kernel: hv_vmbus: registering driver hv_utils Nov 24 00:19:45.153187 kernel: hv_utils: Shutdown IC version 3.2 Nov 24 00:19:45.153206 kernel: hv_utils: TimeSync IC version 4.0 Nov 24 00:19:45.153223 kernel: hv_utils: Heartbeat IC version 3.0 Nov 24 00:19:45.148069 systemd-resolved[257]: Clock change detected. Flushing caches. Nov 24 00:19:45.168606 kernel: hv_vmbus: registering driver hv_pci Nov 24 00:19:45.168628 kernel: hv_vmbus: registering driver hv_storvsc Nov 24 00:19:45.168640 kernel: hv_vmbus: registering driver hv_netvsc Nov 24 00:19:45.168658 kernel: hv_pci 47505500-0001-0000-3130-444531444234: PCI VMBus probing: Using version 0x10004 Nov 24 00:19:45.171015 kernel: scsi host0: storvsc_host_t Nov 24 00:19:45.171065 kernel: scsi host1: storvsc_host_t Nov 24 00:19:45.174068 kernel: hv_pci 47505500-0001-0000-3130-444531444234: PCI host bridge to bus 0001:00 Nov 24 00:19:45.185027 kernel: scsi 0:0:0:0: Direct-Access Msft Virtual Disk 1.0 PQ: 0 ANSI: 5 Nov 24 00:19:45.185081 kernel: pci_bus 0001:00: root bus resource [mem 0x41000000-0x41ffffff window] Nov 24 00:19:45.194323 kernel: pci_bus 0001:00: root bus resource [mem 0x1000000000-0x1401ffffff window] Nov 24 00:19:45.195012 kernel: pci_bus 0001:00: No busn resource found for root bus, will use [bus 00-ff] Nov 24 00:19:45.197016 kernel: scsi 0:0:0:1: Direct-Access Msft Virtual Disk 1.0 PQ: 0 ANSI: 5 Nov 24 00:19:45.197048 kernel: pci 0001:00:00.0: [10de:1db4] type 00 class 0x030200 PCIe Endpoint Nov 24 00:19:45.197081 kernel: pci 0001:00:00.0: BAR 0 [mem 0x41000000-0x41ffffff] Nov 24 00:19:45.198062 kernel: pci 0001:00:00.0: BAR 1 [mem 0x1000000000-0x13ffffffff 64bit pref] Nov 24 00:19:45.199037 kernel: pci 0001:00:00.0: BAR 3 [mem 0x1400000000-0x1401ffffff 64bit pref] Nov 24 00:19:45.203003 kernel: pci 0001:00:00.0: Enabling HDA controller Nov 24 00:19:45.227015 kernel: pci 0001:00:00.0: quirk_nvidia_hda+0x0/0x70 took 21559 usecs Nov 24 00:19:45.227059 kernel: scsi 0:0:0:2: CD-ROM Msft Virtual DVD-ROM 1.0 PQ: 0 ANSI: 0 Nov 24 00:19:45.234487 systemd[1]: Finished systemd-vconsole-setup.service - Virtual Console Setup. Nov 24 00:19:45.250934 kernel: pci_bus 0001:00: busn_res: [bus 00-ff] end is updated to 00 Nov 24 00:19:45.251125 kernel: pci 0001:00:00.0: BAR 1 [mem 0x1000000000-0x13ffffffff 64bit pref]: assigned Nov 24 00:19:45.253135 kernel: sd 0:0:0:0: [sda] 63737856 512-byte logical blocks: (32.6 GB/30.4 GiB) Nov 24 00:19:45.253328 kernel: pci 0001:00:00.0: BAR 3 [mem 0x1400000000-0x1401ffffff 64bit pref]: assigned Nov 24 00:19:45.253532 kernel: sd 0:0:0:1: [sdb] 1543503872 512-byte logical blocks: (790 GB/736 GiB) Nov 24 00:19:45.253684 kernel: sd 0:0:0:1: [sdb] 4096-byte physical blocks Nov 24 00:19:45.255997 kernel: sd 0:0:0:0: [sda] 4096-byte physical blocks Nov 24 00:19:45.256177 kernel: sd 0:0:0:1: [sdb] Write Protect is off Nov 24 00:19:45.256321 kernel: sd 0:0:0:0: [sda] Write Protect is off Nov 24 00:19:45.256454 kernel: sd 0:0:0:0: [sda] Mode Sense: 0f 00 10 00 Nov 24 00:19:45.261070 kernel: sd 0:0:0:0: [sda] Write cache: disabled, read cache: enabled, supports DPO and FUA Nov 24 00:19:45.261285 kernel: pci 0001:00:00.0: BAR 0 [mem 0x41000000-0x41ffffff]: assigned Nov 24 00:19:45.266541 kernel: sd 0:0:0:1: [sdb] Mode Sense: 0f 00 10 00 Nov 24 00:19:45.291155 kernel: hv_storvsc f8b3781a-1e82-4818-a1c3-63d806ec15bb: tag#194 cmd 0x5a status: scsi 0x2 srb 0x86 hv 0xc0000001 Nov 24 00:19:45.291307 kernel: sd 0:0:0:1: [sdb] Write cache: disabled, read cache: enabled, supports DPO and FUA Nov 24 00:19:45.302044 kernel: hv_storvsc f8b3781a-1e82-4818-a1c3-63d806ec15bb: tag#201 cmd 0x5a status: scsi 0x2 srb 0x86 hv 0xc0000001 Nov 24 00:19:45.302227 kernel: hv_storvsc f8b3781a-1e82-4818-a1c3-63d806ec15bb: tag#326 cmd 0x5a status: scsi 0x2 srb 0x86 hv 0xc0000001 Nov 24 00:19:45.313007 kernel: hv_storvsc f8b3781a-1e82-4818-a1c3-63d806ec15bb: tag#333 cmd 0x5a status: scsi 0x2 srb 0x86 hv 0xc0000001 Nov 24 00:19:45.323255 kernel: sda: sda1 sda2 sda3 sda4 sda6 sda7 sda9 Nov 24 00:19:45.323284 kernel: sd 0:0:0:0: [sda] Attached SCSI disk Nov 24 00:19:45.328558 kernel: sdb: sdb1 Nov 24 00:19:45.328586 kernel: sd 0:0:0:1: [sdb] Attached SCSI disk Nov 24 00:19:45.337688 kernel: sr 0:0:0:2: [sr0] scsi-1 drive Nov 24 00:19:45.337884 kernel: cdrom: Uniform CD-ROM driver Revision: 3.20 Nov 24 00:19:45.339011 kernel: sr 0:0:0:2: Attached scsi CD-ROM sr0 Nov 24 00:19:45.896372 systemd[1]: Found device dev-disk-by\x2dlabel-OEM.device - Virtual_Disk OEM. Nov 24 00:19:45.930665 systemd[1]: Found device dev-disk-by\x2dlabel-ROOT.device - Virtual_Disk ROOT. Nov 24 00:19:46.036275 systemd[1]: Found device dev-disk-by\x2dlabel-EFI\x2dSYSTEM.device - Virtual_Disk EFI-SYSTEM. Nov 24 00:19:46.086659 systemd[1]: Found device dev-disk-by\x2dpartuuid-7130c94a\x2d213a\x2d4e5a\x2d8e26\x2d6cce9662f132.device - Virtual_Disk USR-A. Nov 24 00:19:46.088195 systemd[1]: Found device dev-disk-by\x2dpartlabel-USR\x2dA.device - Virtual_Disk USR-A. Nov 24 00:19:46.175731 systemd[1]: Starting disk-uuid.service - Generate new UUID for disk GPT if necessary... Nov 24 00:19:46.219997 kernel: hv_storvsc f8b3781a-1e82-4818-a1c3-63d806ec15bb: tag#248 cmd 0x5a status: scsi 0x2 srb 0x86 hv 0xc0000001 Nov 24 00:19:46.244010 kernel: sda: sda1 sda2 sda3 sda4 sda6 sda7 sda9 Nov 24 00:19:46.252999 kernel: hv_storvsc f8b3781a-1e82-4818-a1c3-63d806ec15bb: tag#201 cmd 0x5a status: scsi 0x2 srb 0x86 hv 0xc0000001 Nov 24 00:19:46.278995 kernel: sda: sda1 sda2 sda3 sda4 sda6 sda7 sda9 Nov 24 00:19:47.286017 kernel: hv_storvsc f8b3781a-1e82-4818-a1c3-63d806ec15bb: tag#331 cmd 0x5a status: scsi 0x2 srb 0x86 hv 0xc0000001 Nov 24 00:19:47.303998 kernel: sda: sda1 sda2 sda3 sda4 sda6 sda7 sda9 Nov 24 00:19:47.304419 disk-uuid[709]: The operation has completed successfully. Nov 24 00:19:48.495698 systemd[1]: disk-uuid.service: Deactivated successfully. Nov 24 00:19:48.495810 systemd[1]: Finished disk-uuid.service - Generate new UUID for disk GPT if necessary. Nov 24 00:19:48.506005 systemd[1]: Starting verity-setup.service - Verity Setup for /dev/mapper/usr... Nov 24 00:19:48.512288 systemd[1]: Finished dracut-initqueue.service - dracut initqueue hook. Nov 24 00:19:48.527146 systemd[1]: Reached target remote-fs-pre.target - Preparation for Remote File Systems. Nov 24 00:19:48.527921 systemd[1]: Reached target remote-cryptsetup.target - Remote Encrypted Volumes. Nov 24 00:19:48.529344 systemd[1]: Reached target remote-fs.target - Remote File Systems. Nov 24 00:19:48.556508 systemd[1]: Starting dracut-pre-mount.service - dracut pre-mount hook... Nov 24 00:19:48.564453 sh[874]: Success Nov 24 00:19:48.575671 systemd[1]: Finished dracut-pre-mount.service - dracut pre-mount hook. Nov 24 00:19:48.612598 kernel: device-mapper: core: CONFIG_IMA_DISABLE_HTABLE is disabled. Duplicate IMA measurements will not be recorded in the IMA log. Nov 24 00:19:48.612632 kernel: device-mapper: uevent: version 1.0.3 Nov 24 00:19:48.618026 kernel: device-mapper: ioctl: 4.48.0-ioctl (2023-03-01) initialised: dm-devel@lists.linux.dev Nov 24 00:19:48.628995 kernel: device-mapper: verity: sha256 using shash "sha256-avx2" Nov 24 00:19:48.918517 systemd[1]: Found device dev-mapper-usr.device - /dev/mapper/usr. Nov 24 00:19:48.921819 systemd[1]: Mounting sysusr-usr.mount - /sysusr/usr... Nov 24 00:19:48.943203 systemd[1]: Finished verity-setup.service - Verity Setup for /dev/mapper/usr. Nov 24 00:19:48.969999 kernel: BTRFS: device fsid c993ebd2-0e38-4cfc-8615-2c75294bea72 devid 1 transid 36 /dev/mapper/usr (254:0) scanned by mount (899) Nov 24 00:19:48.970086 kernel: BTRFS info (device dm-0): first mount of filesystem c993ebd2-0e38-4cfc-8615-2c75294bea72 Nov 24 00:19:48.978630 kernel: BTRFS info (device dm-0): using crc32c (crc32c-intel) checksum algorithm Nov 24 00:19:49.365561 kernel: BTRFS info (device dm-0): disabling log replay at mount time Nov 24 00:19:49.365623 kernel: BTRFS info (device dm-0): enabling free space tree Nov 24 00:19:49.411213 systemd[1]: Mounted sysusr-usr.mount - /sysusr/usr. Nov 24 00:19:49.412543 systemd[1]: Reached target initrd-usr-fs.target - Initrd /usr File System. Nov 24 00:19:49.413602 systemd[1]: afterburn-network-kargs.service - Afterburn Initrd Setup Network Kernel Arguments was skipped because no trigger condition checks were met. Nov 24 00:19:49.414527 systemd[1]: Starting ignition-setup.service - Ignition (setup)... Nov 24 00:19:49.454243 systemd[1]: Starting parse-ip-for-networkd.service - Write systemd-networkd units from cmdline... Nov 24 00:19:49.486005 kernel: BTRFS: device label OEM devid 1 transid 12 /dev/sda6 (8:6) scanned by mount (932) Nov 24 00:19:49.495634 kernel: BTRFS info (device sda6): first mount of filesystem 8f3e7759-f869-465c-a676-2cd550a2d4e4 Nov 24 00:19:49.495664 kernel: BTRFS info (device sda6): using crc32c (crc32c-intel) checksum algorithm Nov 24 00:19:49.516472 kernel: BTRFS info (device sda6): turning on async discard Nov 24 00:19:49.516502 kernel: BTRFS info (device sda6): enabling free space tree Nov 24 00:19:49.525015 kernel: BTRFS info (device sda6): last unmount of filesystem 8f3e7759-f869-465c-a676-2cd550a2d4e4 Nov 24 00:19:49.525678 systemd[1]: Finished ignition-setup.service - Ignition (setup). Nov 24 00:19:49.528106 systemd[1]: Starting ignition-fetch-offline.service - Ignition (fetch-offline)... Nov 24 00:19:49.570855 systemd[1]: Finished parse-ip-for-networkd.service - Write systemd-networkd units from cmdline. Nov 24 00:19:49.574021 systemd[1]: Starting systemd-networkd.service - Network Configuration... Nov 24 00:19:49.624236 systemd-networkd[1068]: lo: Link UP Nov 24 00:19:49.624246 systemd-networkd[1068]: lo: Gained carrier Nov 24 00:19:49.625329 systemd-networkd[1068]: Enumeration completed Nov 24 00:19:49.625417 systemd[1]: Started systemd-networkd.service - Network Configuration. Nov 24 00:19:49.625686 systemd-networkd[1068]: eth0: found matching network '/usr/lib/systemd/network/zz-default.network', based on potentially unpredictable interface name. Nov 24 00:19:49.625691 systemd-networkd[1068]: eth0: Configuring with /usr/lib/systemd/network/zz-default.network. Nov 24 00:19:49.626455 systemd-networkd[1068]: eth0: Link UP Nov 24 00:19:49.626616 systemd-networkd[1068]: eth0: Gained carrier Nov 24 00:19:49.626626 systemd-networkd[1068]: eth0: found matching network '/usr/lib/systemd/network/zz-default.network', based on potentially unpredictable interface name. Nov 24 00:19:49.631395 systemd[1]: Reached target network.target - Network. Nov 24 00:19:49.677014 systemd-networkd[1068]: eth0: DHCPv4 address 10.200.0.13/24, gateway 10.200.0.1 acquired from 168.63.129.16 Nov 24 00:19:50.834488 ignition[1031]: Ignition 2.22.0 Nov 24 00:19:50.834504 ignition[1031]: Stage: fetch-offline Nov 24 00:19:50.834628 ignition[1031]: no configs at "/usr/lib/ignition/base.d" Nov 24 00:19:50.834638 ignition[1031]: no config dir at "/usr/lib/ignition/base.platform.d/azure" Nov 24 00:19:50.834754 ignition[1031]: parsed url from cmdline: "" Nov 24 00:19:50.834759 ignition[1031]: no config URL provided Nov 24 00:19:50.834765 ignition[1031]: reading system config file "/usr/lib/ignition/user.ign" Nov 24 00:19:50.834774 ignition[1031]: no config at "/usr/lib/ignition/user.ign" Nov 24 00:19:50.834780 ignition[1031]: failed to fetch config: resource requires networking Nov 24 00:19:50.834929 ignition[1031]: Ignition finished successfully Nov 24 00:19:50.866057 systemd[1]: Finished ignition-fetch-offline.service - Ignition (fetch-offline). Nov 24 00:19:50.868495 systemd[1]: Starting ignition-fetch.service - Ignition (fetch)... Nov 24 00:19:50.915951 ignition[1082]: Ignition 2.22.0 Nov 24 00:19:50.915964 ignition[1082]: Stage: fetch Nov 24 00:19:50.916204 ignition[1082]: no configs at "/usr/lib/ignition/base.d" Nov 24 00:19:50.916216 ignition[1082]: no config dir at "/usr/lib/ignition/base.platform.d/azure" Nov 24 00:19:50.916308 ignition[1082]: parsed url from cmdline: "" Nov 24 00:19:50.916312 ignition[1082]: no config URL provided Nov 24 00:19:50.916318 ignition[1082]: reading system config file "/usr/lib/ignition/user.ign" Nov 24 00:19:50.916328 ignition[1082]: no config at "/usr/lib/ignition/user.ign" Nov 24 00:19:50.916346 ignition[1082]: GET http://169.254.169.254/metadata/instance/compute/userData?api-version=2021-01-01&format=text: attempt #1 Nov 24 00:19:51.011202 ignition[1082]: GET result: OK Nov 24 00:19:51.011244 ignition[1082]: config has been read from IMDS userdata Nov 24 00:19:51.011256 ignition[1082]: parsing config with SHA512: fb574f0a45c0431d6bff2ed0f9b7855374650faa92fd517c4382b72060b127d21afb58141516d86c85af2b252ab408967e562e039fe9f684a5c8e8487201592b Nov 24 00:19:51.015594 unknown[1082]: fetched base config from "system" Nov 24 00:19:51.015811 ignition[1082]: fetch: fetch complete Nov 24 00:19:51.015608 unknown[1082]: fetched base config from "system" Nov 24 00:19:51.015816 ignition[1082]: fetch: fetch passed Nov 24 00:19:51.015614 unknown[1082]: fetched user config from "azure" Nov 24 00:19:51.015861 ignition[1082]: Ignition finished successfully Nov 24 00:19:51.019089 systemd[1]: Finished ignition-fetch.service - Ignition (fetch). Nov 24 00:19:51.022018 systemd[1]: Starting ignition-kargs.service - Ignition (kargs)... Nov 24 00:19:51.071024 ignition[1091]: Ignition 2.22.0 Nov 24 00:19:51.071037 ignition[1091]: Stage: kargs Nov 24 00:19:51.071267 ignition[1091]: no configs at "/usr/lib/ignition/base.d" Nov 24 00:19:51.071278 ignition[1091]: no config dir at "/usr/lib/ignition/base.platform.d/azure" Nov 24 00:19:51.079800 systemd[1]: Finished ignition-kargs.service - Ignition (kargs). Nov 24 00:19:51.072351 ignition[1091]: kargs: kargs passed Nov 24 00:19:51.088368 systemd[1]: Starting ignition-disks.service - Ignition (disks)... Nov 24 00:19:51.072494 ignition[1091]: Ignition finished successfully Nov 24 00:19:51.134677 ignition[1100]: Ignition 2.22.0 Nov 24 00:19:51.134690 ignition[1100]: Stage: disks Nov 24 00:19:51.134890 ignition[1100]: no configs at "/usr/lib/ignition/base.d" Nov 24 00:19:51.134900 ignition[1100]: no config dir at "/usr/lib/ignition/base.platform.d/azure" Nov 24 00:19:51.135481 ignition[1100]: disks: disks passed Nov 24 00:19:51.144227 systemd[1]: Finished ignition-disks.service - Ignition (disks). Nov 24 00:19:51.135526 ignition[1100]: Ignition finished successfully Nov 24 00:19:51.146094 systemd[1]: Reached target initrd-root-device.target - Initrd Root Device. Nov 24 00:19:51.154918 systemd[1]: Reached target local-fs-pre.target - Preparation for Local File Systems. Nov 24 00:19:51.167066 systemd[1]: Reached target local-fs.target - Local File Systems. Nov 24 00:19:51.168497 systemd[1]: Reached target sysinit.target - System Initialization. Nov 24 00:19:51.179748 systemd[1]: Reached target basic.target - Basic System. Nov 24 00:19:51.189322 systemd[1]: Starting systemd-fsck-root.service - File System Check on /dev/disk/by-label/ROOT... Nov 24 00:19:51.287440 systemd-fsck[1112]: ROOT: clean, 15/7326000 files, 477845/7359488 blocks Nov 24 00:19:51.292520 systemd[1]: Finished systemd-fsck-root.service - File System Check on /dev/disk/by-label/ROOT. Nov 24 00:19:51.299967 systemd[1]: Mounting sysroot.mount - /sysroot... Nov 24 00:19:51.605993 kernel: EXT4-fs (sda9): mounted filesystem 5d9d0447-100f-4769-adb5-76fdba966eb2 r/w with ordered data mode. Quota mode: none. Nov 24 00:19:51.606689 systemd[1]: Mounted sysroot.mount - /sysroot. Nov 24 00:19:51.608731 systemd[1]: Reached target initrd-root-fs.target - Initrd Root File System. Nov 24 00:19:51.628047 systemd[1]: Mounting sysroot-oem.mount - /sysroot/oem... Nov 24 00:19:51.629810 systemd[1]: Mounting sysroot-usr.mount - /sysroot/usr... Nov 24 00:19:51.646079 systemd-networkd[1068]: eth0: Gained IPv6LL Nov 24 00:19:51.656547 systemd[1]: Starting flatcar-metadata-hostname.service - Flatcar Metadata Hostname Agent... Nov 24 00:19:51.658024 systemd[1]: ignition-remount-sysroot.service - Remount /sysroot read-write for Ignition was skipped because of an unmet condition check (ConditionPathIsReadWrite=!/sysroot). Nov 24 00:19:51.682997 kernel: BTRFS: device label OEM devid 1 transid 12 /dev/sda6 (8:6) scanned by mount (1126) Nov 24 00:19:51.658052 systemd[1]: Reached target ignition-diskful.target - Ignition Boot Disk Setup. Nov 24 00:19:51.704686 kernel: BTRFS info (device sda6): first mount of filesystem 8f3e7759-f869-465c-a676-2cd550a2d4e4 Nov 24 00:19:51.704706 kernel: BTRFS info (device sda6): using crc32c (crc32c-intel) checksum algorithm Nov 24 00:19:51.704718 kernel: BTRFS info (device sda6): turning on async discard Nov 24 00:19:51.704730 kernel: BTRFS info (device sda6): enabling free space tree Nov 24 00:19:51.673269 systemd[1]: Mounted sysroot-usr.mount - /sysroot/usr. Nov 24 00:19:51.694429 systemd[1]: Starting initrd-setup-root.service - Root filesystem setup... Nov 24 00:19:51.707420 systemd[1]: Mounted sysroot-oem.mount - /sysroot/oem. Nov 24 00:19:52.628892 coreos-metadata[1128]: Nov 24 00:19:52.628 INFO Fetching http://168.63.129.16/?comp=versions: Attempt #1 Nov 24 00:19:52.634927 coreos-metadata[1128]: Nov 24 00:19:52.631 INFO Fetch successful Nov 24 00:19:52.634927 coreos-metadata[1128]: Nov 24 00:19:52.631 INFO Fetching http://169.254.169.254/metadata/instance/compute/name?api-version=2017-08-01&format=text: Attempt #1 Nov 24 00:19:52.647089 coreos-metadata[1128]: Nov 24 00:19:52.638 INFO Fetch successful Nov 24 00:19:52.652320 coreos-metadata[1128]: Nov 24 00:19:52.652 INFO wrote hostname ci-4459.1.2-a-239ffcb467 to /sysroot/etc/hostname Nov 24 00:19:52.659352 systemd[1]: Finished flatcar-metadata-hostname.service - Flatcar Metadata Hostname Agent. Nov 24 00:19:52.966438 initrd-setup-root[1156]: cut: /sysroot/etc/passwd: No such file or directory Nov 24 00:19:53.018576 initrd-setup-root[1163]: cut: /sysroot/etc/group: No such file or directory Nov 24 00:19:53.054876 initrd-setup-root[1170]: cut: /sysroot/etc/shadow: No such file or directory Nov 24 00:19:53.076926 initrd-setup-root[1177]: cut: /sysroot/etc/gshadow: No such file or directory Nov 24 00:19:54.118179 systemd[1]: Finished initrd-setup-root.service - Root filesystem setup. Nov 24 00:19:54.121127 systemd[1]: Starting ignition-mount.service - Ignition (mount)... Nov 24 00:19:54.156520 systemd[1]: Starting sysroot-boot.service - /sysroot/boot... Nov 24 00:19:54.162006 systemd[1]: sysroot-oem.mount: Deactivated successfully. Nov 24 00:19:54.172966 kernel: BTRFS info (device sda6): last unmount of filesystem 8f3e7759-f869-465c-a676-2cd550a2d4e4 Nov 24 00:19:54.194331 ignition[1245]: INFO : Ignition 2.22.0 Nov 24 00:19:54.194331 ignition[1245]: INFO : Stage: mount Nov 24 00:19:54.203957 ignition[1245]: INFO : no configs at "/usr/lib/ignition/base.d" Nov 24 00:19:54.203957 ignition[1245]: INFO : no config dir at "/usr/lib/ignition/base.platform.d/azure" Nov 24 00:19:54.203957 ignition[1245]: INFO : mount: mount passed Nov 24 00:19:54.203957 ignition[1245]: INFO : Ignition finished successfully Nov 24 00:19:54.196699 systemd[1]: Finished ignition-mount.service - Ignition (mount). Nov 24 00:19:54.200481 systemd[1]: Finished sysroot-boot.service - /sysroot/boot. Nov 24 00:19:54.206810 systemd[1]: Starting ignition-files.service - Ignition (files)... Nov 24 00:19:54.241502 systemd[1]: Mounting sysroot-oem.mount - /sysroot/oem... Nov 24 00:19:54.268344 kernel: BTRFS: device label OEM devid 1 transid 12 /dev/sda6 (8:6) scanned by mount (1259) Nov 24 00:19:54.268380 kernel: BTRFS info (device sda6): first mount of filesystem 8f3e7759-f869-465c-a676-2cd550a2d4e4 Nov 24 00:19:54.272574 kernel: BTRFS info (device sda6): using crc32c (crc32c-intel) checksum algorithm Nov 24 00:19:54.282347 kernel: BTRFS info (device sda6): turning on async discard Nov 24 00:19:54.282403 kernel: BTRFS info (device sda6): enabling free space tree Nov 24 00:19:54.284503 systemd[1]: Mounted sysroot-oem.mount - /sysroot/oem. Nov 24 00:19:54.334963 ignition[1276]: INFO : Ignition 2.22.0 Nov 24 00:19:54.334963 ignition[1276]: INFO : Stage: files Nov 24 00:19:54.340818 ignition[1276]: INFO : no configs at "/usr/lib/ignition/base.d" Nov 24 00:19:54.340818 ignition[1276]: INFO : no config dir at "/usr/lib/ignition/base.platform.d/azure" Nov 24 00:19:54.340818 ignition[1276]: DEBUG : files: compiled without relabeling support, skipping Nov 24 00:19:54.340818 ignition[1276]: INFO : files: ensureUsers: op(1): [started] creating or modifying user "core" Nov 24 00:19:54.340818 ignition[1276]: DEBUG : files: ensureUsers: op(1): executing: "usermod" "--root" "/sysroot" "core" Nov 24 00:19:54.419343 ignition[1276]: INFO : files: ensureUsers: op(1): [finished] creating or modifying user "core" Nov 24 00:19:54.424921 ignition[1276]: INFO : files: ensureUsers: op(2): [started] adding ssh keys to user "core" Nov 24 00:19:54.430522 unknown[1276]: wrote ssh authorized keys file for user: core Nov 24 00:19:54.434276 ignition[1276]: INFO : files: ensureUsers: op(2): [finished] adding ssh keys to user "core" Nov 24 00:19:54.467449 ignition[1276]: INFO : files: createFilesystemsFiles: createFiles: op(3): [started] writing file "/sysroot/etc/flatcar/update.conf" Nov 24 00:19:54.474639 ignition[1276]: INFO : files: createFilesystemsFiles: createFiles: op(3): [finished] writing file "/sysroot/etc/flatcar/update.conf" Nov 24 00:19:54.474639 ignition[1276]: INFO : files: createResultFile: createFiles: op(4): [started] writing file "/sysroot/etc/.ignition-result.json" Nov 24 00:19:54.474639 ignition[1276]: INFO : files: createResultFile: createFiles: op(4): [finished] writing file "/sysroot/etc/.ignition-result.json" Nov 24 00:19:54.474639 ignition[1276]: INFO : files: files passed Nov 24 00:19:54.474639 ignition[1276]: INFO : Ignition finished successfully Nov 24 00:19:54.493454 systemd[1]: Finished ignition-files.service - Ignition (files). Nov 24 00:19:54.500789 systemd[1]: Starting ignition-quench.service - Ignition (record completion)... Nov 24 00:19:54.527199 systemd[1]: Starting initrd-setup-root-after-ignition.service - Root filesystem completion... Nov 24 00:19:54.553866 systemd[1]: ignition-quench.service: Deactivated successfully. Nov 24 00:19:54.553962 systemd[1]: Finished ignition-quench.service - Ignition (record completion). Nov 24 00:19:54.642253 initrd-setup-root-after-ignition[1309]: grep: /sysroot/etc/flatcar/enabled-sysext.conf: No such file or directory Nov 24 00:19:54.642253 initrd-setup-root-after-ignition[1309]: grep: /sysroot/usr/share/flatcar/enabled-sysext.conf: No such file or directory Nov 24 00:19:54.659972 initrd-setup-root-after-ignition[1313]: grep: /sysroot/etc/flatcar/enabled-sysext.conf: No such file or directory Nov 24 00:19:54.644299 systemd[1]: Finished initrd-setup-root-after-ignition.service - Root filesystem completion. Nov 24 00:19:54.650270 systemd[1]: Reached target ignition-complete.target - Ignition Complete. Nov 24 00:19:54.662281 systemd[1]: Starting initrd-parse-etc.service - Mountpoints Configured in the Real Root... Nov 24 00:19:54.714465 systemd[1]: initrd-parse-etc.service: Deactivated successfully. Nov 24 00:19:54.714570 systemd[1]: Finished initrd-parse-etc.service - Mountpoints Configured in the Real Root. Nov 24 00:19:54.723555 systemd[1]: Reached target initrd-fs.target - Initrd File Systems. Nov 24 00:19:54.732372 systemd[1]: Reached target initrd.target - Initrd Default Target. Nov 24 00:19:54.740449 systemd[1]: dracut-mount.service - dracut mount hook was skipped because no trigger condition checks were met. Nov 24 00:19:54.741286 systemd[1]: Starting dracut-pre-pivot.service - dracut pre-pivot and cleanup hook... Nov 24 00:19:54.787101 systemd[1]: Finished dracut-pre-pivot.service - dracut pre-pivot and cleanup hook. Nov 24 00:19:54.797761 systemd[1]: Starting initrd-cleanup.service - Cleaning Up and Shutting Down Daemons... Nov 24 00:19:54.835975 systemd[1]: Stopped target nss-lookup.target - Host and Network Name Lookups. Nov 24 00:19:54.837561 systemd[1]: Stopped target remote-cryptsetup.target - Remote Encrypted Volumes. Nov 24 00:19:54.845927 systemd[1]: Stopped target timers.target - Timer Units. Nov 24 00:19:54.857858 systemd[1]: dracut-pre-pivot.service: Deactivated successfully. Nov 24 00:19:54.857992 systemd[1]: Stopped dracut-pre-pivot.service - dracut pre-pivot and cleanup hook. Nov 24 00:19:54.869767 systemd[1]: Stopped target initrd.target - Initrd Default Target. Nov 24 00:19:54.878408 systemd[1]: Stopped target basic.target - Basic System. Nov 24 00:19:54.886045 systemd[1]: Stopped target ignition-complete.target - Ignition Complete. Nov 24 00:19:54.893698 systemd[1]: Stopped target ignition-diskful.target - Ignition Boot Disk Setup. Nov 24 00:19:54.902539 systemd[1]: Stopped target initrd-root-device.target - Initrd Root Device. Nov 24 00:19:54.911508 systemd[1]: Stopped target initrd-usr-fs.target - Initrd /usr File System. Nov 24 00:19:54.920097 systemd[1]: Stopped target remote-fs.target - Remote File Systems. Nov 24 00:19:54.928378 systemd[1]: Stopped target remote-fs-pre.target - Preparation for Remote File Systems. Nov 24 00:19:54.937120 systemd[1]: Stopped target sysinit.target - System Initialization. Nov 24 00:19:54.945822 systemd[1]: Stopped target local-fs.target - Local File Systems. Nov 24 00:19:54.953665 systemd[1]: Stopped target swap.target - Swaps. Nov 24 00:19:54.960523 systemd[1]: dracut-pre-mount.service: Deactivated successfully. Nov 24 00:19:54.960644 systemd[1]: Stopped dracut-pre-mount.service - dracut pre-mount hook. Nov 24 00:19:54.971218 systemd[1]: Stopped target cryptsetup.target - Local Encrypted Volumes. Nov 24 00:19:54.979612 systemd[1]: Stopped target cryptsetup-pre.target - Local Encrypted Volumes (Pre). Nov 24 00:19:54.988439 systemd[1]: clevis-luks-askpass.path: Deactivated successfully. Nov 24 00:19:54.989116 systemd[1]: Stopped clevis-luks-askpass.path - Forward Password Requests to Clevis Directory Watch. Nov 24 00:19:54.997951 systemd[1]: dracut-initqueue.service: Deactivated successfully. Nov 24 00:19:54.998080 systemd[1]: Stopped dracut-initqueue.service - dracut initqueue hook. Nov 24 00:19:55.011410 systemd[1]: initrd-setup-root-after-ignition.service: Deactivated successfully. Nov 24 00:19:55.011538 systemd[1]: Stopped initrd-setup-root-after-ignition.service - Root filesystem completion. Nov 24 00:19:55.019896 systemd[1]: ignition-files.service: Deactivated successfully. Nov 24 00:19:55.020023 systemd[1]: Stopped ignition-files.service - Ignition (files). Nov 24 00:19:55.027773 systemd[1]: flatcar-metadata-hostname.service: Deactivated successfully. Nov 24 00:19:55.027883 systemd[1]: Stopped flatcar-metadata-hostname.service - Flatcar Metadata Hostname Agent. Nov 24 00:19:55.037656 systemd[1]: Stopping ignition-mount.service - Ignition (mount)... Nov 24 00:19:55.046055 systemd[1]: Stopping sysroot-boot.service - /sysroot/boot... Nov 24 00:19:55.052410 systemd[1]: systemd-udev-trigger.service: Deactivated successfully. Nov 24 00:19:55.052535 systemd[1]: Stopped systemd-udev-trigger.service - Coldplug All udev Devices. Nov 24 00:19:55.102397 ignition[1333]: INFO : Ignition 2.22.0 Nov 24 00:19:55.102397 ignition[1333]: INFO : Stage: umount Nov 24 00:19:55.102397 ignition[1333]: INFO : no configs at "/usr/lib/ignition/base.d" Nov 24 00:19:55.102397 ignition[1333]: INFO : no config dir at "/usr/lib/ignition/base.platform.d/azure" Nov 24 00:19:55.102397 ignition[1333]: INFO : umount: umount passed Nov 24 00:19:55.102397 ignition[1333]: INFO : Ignition finished successfully Nov 24 00:19:55.061170 systemd[1]: dracut-pre-trigger.service: Deactivated successfully. Nov 24 00:19:55.061284 systemd[1]: Stopped dracut-pre-trigger.service - dracut pre-trigger hook. Nov 24 00:19:55.077838 systemd[1]: initrd-cleanup.service: Deactivated successfully. Nov 24 00:19:55.077940 systemd[1]: Finished initrd-cleanup.service - Cleaning Up and Shutting Down Daemons. Nov 24 00:19:55.095809 systemd[1]: ignition-mount.service: Deactivated successfully. Nov 24 00:19:55.095916 systemd[1]: Stopped ignition-mount.service - Ignition (mount). Nov 24 00:19:55.102524 systemd[1]: ignition-disks.service: Deactivated successfully. Nov 24 00:19:55.102573 systemd[1]: Stopped ignition-disks.service - Ignition (disks). Nov 24 00:19:55.112187 systemd[1]: ignition-kargs.service: Deactivated successfully. Nov 24 00:19:55.112233 systemd[1]: Stopped ignition-kargs.service - Ignition (kargs). Nov 24 00:19:55.120087 systemd[1]: ignition-fetch.service: Deactivated successfully. Nov 24 00:19:55.120135 systemd[1]: Stopped ignition-fetch.service - Ignition (fetch). Nov 24 00:19:55.128742 systemd[1]: Stopped target network.target - Network. Nov 24 00:19:55.136924 systemd[1]: ignition-fetch-offline.service: Deactivated successfully. Nov 24 00:19:55.136975 systemd[1]: Stopped ignition-fetch-offline.service - Ignition (fetch-offline). Nov 24 00:19:55.144927 systemd[1]: Stopped target paths.target - Path Units. Nov 24 00:19:55.149988 systemd[1]: systemd-ask-password-console.path: Deactivated successfully. Nov 24 00:19:55.154042 systemd[1]: Stopped systemd-ask-password-console.path - Dispatch Password Requests to Console Directory Watch. Nov 24 00:19:55.157530 systemd[1]: Stopped target slices.target - Slice Units. Nov 24 00:19:55.166144 systemd[1]: Stopped target sockets.target - Socket Units. Nov 24 00:19:55.174471 systemd[1]: iscsid.socket: Deactivated successfully. Nov 24 00:19:55.174509 systemd[1]: Closed iscsid.socket - Open-iSCSI iscsid Socket. Nov 24 00:19:55.181045 systemd[1]: iscsiuio.socket: Deactivated successfully. Nov 24 00:19:55.181078 systemd[1]: Closed iscsiuio.socket - Open-iSCSI iscsiuio Socket. Nov 24 00:19:55.191665 systemd[1]: ignition-setup.service: Deactivated successfully. Nov 24 00:19:55.191719 systemd[1]: Stopped ignition-setup.service - Ignition (setup). Nov 24 00:19:55.199204 systemd[1]: ignition-setup-pre.service: Deactivated successfully. Nov 24 00:19:55.199248 systemd[1]: Stopped ignition-setup-pre.service - Ignition env setup. Nov 24 00:19:55.207022 systemd[1]: Stopping systemd-networkd.service - Network Configuration... Nov 24 00:19:55.214457 systemd[1]: Stopping systemd-resolved.service - Network Name Resolution... Nov 24 00:19:55.216757 systemd[1]: sysroot-boot.mount: Deactivated successfully. Nov 24 00:19:55.217342 systemd[1]: sysroot-boot.service: Deactivated successfully. Nov 24 00:19:55.217432 systemd[1]: Stopped sysroot-boot.service - /sysroot/boot. Nov 24 00:19:55.223040 systemd[1]: systemd-resolved.service: Deactivated successfully. Nov 24 00:19:55.223137 systemd[1]: Stopped systemd-resolved.service - Network Name Resolution. Nov 24 00:19:55.238617 systemd[1]: run-credentials-systemd\x2dresolved.service.mount: Deactivated successfully. Nov 24 00:19:55.239458 systemd[1]: initrd-setup-root.service: Deactivated successfully. Nov 24 00:19:55.239559 systemd[1]: Stopped initrd-setup-root.service - Root filesystem setup. Nov 24 00:19:55.242366 systemd[1]: systemd-tmpfiles-setup.service: Deactivated successfully. Nov 24 00:19:55.242428 systemd[1]: Stopped systemd-tmpfiles-setup.service - Create System Files and Directories. Nov 24 00:19:55.259648 systemd[1]: run-credentials-systemd\x2dtmpfiles\x2dsetup.service.mount: Deactivated successfully. Nov 24 00:19:55.259882 systemd[1]: systemd-networkd.service: Deactivated successfully. Nov 24 00:19:55.259997 systemd[1]: Stopped systemd-networkd.service - Network Configuration. Nov 24 00:19:55.271087 systemd[1]: run-credentials-systemd\x2dnetworkd.service.mount: Deactivated successfully. Nov 24 00:19:55.271591 systemd[1]: Stopped target network-pre.target - Preparation for Network. Nov 24 00:19:55.280426 systemd[1]: systemd-networkd.socket: Deactivated successfully. Nov 24 00:19:55.280466 systemd[1]: Closed systemd-networkd.socket - Network Service Netlink Socket. Nov 24 00:19:55.289215 systemd[1]: Stopping network-cleanup.service - Network Cleanup... Nov 24 00:19:55.295415 systemd[1]: parse-ip-for-networkd.service: Deactivated successfully. Nov 24 00:19:55.295470 systemd[1]: Stopped parse-ip-for-networkd.service - Write systemd-networkd units from cmdline. Nov 24 00:19:55.303812 systemd[1]: systemd-sysctl.service: Deactivated successfully. Nov 24 00:19:55.303857 systemd[1]: Stopped systemd-sysctl.service - Apply Kernel Variables. Nov 24 00:19:55.312432 systemd[1]: systemd-modules-load.service: Deactivated successfully. Nov 24 00:19:55.312475 systemd[1]: Stopped systemd-modules-load.service - Load Kernel Modules. Nov 24 00:19:55.319252 systemd[1]: Stopping systemd-udevd.service - Rule-based Manager for Device Events and Files... Nov 24 00:19:55.329652 systemd[1]: run-credentials-systemd\x2dsysctl.service.mount: Deactivated successfully. Nov 24 00:19:55.349679 systemd[1]: network-cleanup.service: Deactivated successfully. Nov 24 00:19:55.349817 systemd[1]: Stopped network-cleanup.service - Network Cleanup. Nov 24 00:19:55.357560 systemd[1]: systemd-udevd.service: Deactivated successfully. Nov 24 00:19:55.357732 systemd[1]: Stopped systemd-udevd.service - Rule-based Manager for Device Events and Files. Nov 24 00:19:55.361128 systemd[1]: systemd-udevd-control.socket: Deactivated successfully. Nov 24 00:19:55.361171 systemd[1]: Closed systemd-udevd-control.socket - udev Control Socket. Nov 24 00:19:55.369285 systemd[1]: systemd-udevd-kernel.socket: Deactivated successfully. Nov 24 00:19:55.369323 systemd[1]: Closed systemd-udevd-kernel.socket - udev Kernel Socket. Nov 24 00:19:55.379735 systemd[1]: dracut-pre-udev.service: Deactivated successfully. Nov 24 00:19:55.379788 systemd[1]: Stopped dracut-pre-udev.service - dracut pre-udev hook. Nov 24 00:19:55.391506 systemd[1]: dracut-cmdline.service: Deactivated successfully. Nov 24 00:19:55.391554 systemd[1]: Stopped dracut-cmdline.service - dracut cmdline hook. Nov 24 00:19:55.404232 systemd[1]: dracut-cmdline-ask.service: Deactivated successfully. Nov 24 00:19:55.404284 systemd[1]: Stopped dracut-cmdline-ask.service - dracut ask for additional cmdline parameters. Nov 24 00:19:55.422759 systemd[1]: Starting initrd-udevadm-cleanup-db.service - Cleanup udev Database... Nov 24 00:19:55.431806 systemd[1]: systemd-network-generator.service: Deactivated successfully. Nov 24 00:19:55.431857 systemd[1]: Stopped systemd-network-generator.service - Generate network units from Kernel command line. Nov 24 00:19:55.441230 systemd[1]: systemd-tmpfiles-setup-dev.service: Deactivated successfully. Nov 24 00:19:55.441277 systemd[1]: Stopped systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev. Nov 24 00:19:55.454393 systemd[1]: systemd-tmpfiles-setup-dev-early.service: Deactivated successfully. Nov 24 00:19:55.454438 systemd[1]: Stopped systemd-tmpfiles-setup-dev-early.service - Create Static Device Nodes in /dev gracefully. Nov 24 00:19:55.466737 systemd[1]: kmod-static-nodes.service: Deactivated successfully. Nov 24 00:19:55.466784 systemd[1]: Stopped kmod-static-nodes.service - Create List of Static Device Nodes. Nov 24 00:19:55.476114 systemd[1]: systemd-vconsole-setup.service: Deactivated successfully. Nov 24 00:19:55.476159 systemd[1]: Stopped systemd-vconsole-setup.service - Virtual Console Setup. Nov 24 00:19:55.485833 systemd[1]: initrd-udevadm-cleanup-db.service: Deactivated successfully. Nov 24 00:19:55.651086 systemd-journald[214]: Received SIGTERM from PID 1 (systemd). Nov 24 00:19:55.485919 systemd[1]: Finished initrd-udevadm-cleanup-db.service - Cleanup udev Database. Nov 24 00:19:55.490358 systemd[1]: Reached target initrd-switch-root.target - Switch Root. Nov 24 00:19:55.500583 systemd[1]: Starting initrd-switch-root.service - Switch Root... Nov 24 00:19:55.530864 systemd[1]: Switching root. Nov 24 00:19:55.666357 systemd-journald[214]: Journal stopped Nov 24 00:20:01.080688 kernel: SELinux: policy capability network_peer_controls=1 Nov 24 00:20:01.080718 kernel: SELinux: policy capability open_perms=1 Nov 24 00:20:01.080730 kernel: SELinux: policy capability extended_socket_class=1 Nov 24 00:20:01.080739 kernel: SELinux: policy capability always_check_network=0 Nov 24 00:20:01.080748 kernel: SELinux: policy capability cgroup_seclabel=1 Nov 24 00:20:01.080757 kernel: SELinux: policy capability nnp_nosuid_transition=1 Nov 24 00:20:01.080768 kernel: SELinux: policy capability genfs_seclabel_symlinks=0 Nov 24 00:20:01.080780 kernel: SELinux: policy capability ioctl_skip_cloexec=0 Nov 24 00:20:01.080790 kernel: SELinux: policy capability userspace_initial_context=0 Nov 24 00:20:01.080800 kernel: audit: type=1403 audit(1763943596.992:2): auid=4294967295 ses=4294967295 lsm=selinux res=1 Nov 24 00:20:01.080811 systemd[1]: Successfully loaded SELinux policy in 313.943ms. Nov 24 00:20:01.080827 systemd[1]: Relabeled /dev/, /dev/shm/, /run/ in 7.878ms. Nov 24 00:20:01.080839 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) Nov 24 00:20:01.080850 systemd[1]: Detected virtualization microsoft. Nov 24 00:20:01.080864 systemd[1]: Detected architecture x86-64. Nov 24 00:20:01.080875 systemd[1]: Detected first boot. Nov 24 00:20:01.080886 systemd[1]: Hostname set to . Nov 24 00:20:01.080896 systemd[1]: Initializing machine ID from random generator. Nov 24 00:20:01.080907 zram_generator::config[1377]: No configuration found. Nov 24 00:20:01.081090 kernel: Guest personality initialized and is inactive Nov 24 00:20:01.081110 kernel: VMCI host device registered (name=vmci, major=10, minor=259) Nov 24 00:20:01.081120 kernel: Initialized host personality Nov 24 00:20:01.081130 kernel: NET: Registered PF_VSOCK protocol family Nov 24 00:20:01.081141 systemd[1]: Populated /etc with preset unit settings. Nov 24 00:20:01.081154 systemd[1]: run-credentials-systemd\x2djournald.service.mount: Deactivated successfully. Nov 24 00:20:01.081165 systemd[1]: initrd-switch-root.service: Deactivated successfully. Nov 24 00:20:01.081181 systemd[1]: Stopped initrd-switch-root.service - Switch Root. Nov 24 00:20:01.081192 systemd[1]: systemd-journald.service: Scheduled restart job, restart counter is at 1. Nov 24 00:20:01.081202 systemd[1]: Created slice system-addon\x2dconfig.slice - Slice /system/addon-config. Nov 24 00:20:01.081214 systemd[1]: Created slice system-addon\x2drun.slice - Slice /system/addon-run. Nov 24 00:20:01.081225 systemd[1]: Created slice system-getty.slice - Slice /system/getty. Nov 24 00:20:01.081235 systemd[1]: Created slice system-modprobe.slice - Slice /system/modprobe. Nov 24 00:20:01.081251 systemd[1]: Created slice system-serial\x2dgetty.slice - Slice /system/serial-getty. Nov 24 00:20:01.081262 systemd[1]: Created slice system-system\x2dcloudinit.slice - Slice /system/system-cloudinit. Nov 24 00:20:01.081372 systemd[1]: Created slice system-systemd\x2dfsck.slice - Slice /system/systemd-fsck. Nov 24 00:20:01.081388 systemd[1]: Created slice user.slice - User and Session Slice. Nov 24 00:20:01.081400 systemd[1]: Started clevis-luks-askpass.path - Forward Password Requests to Clevis Directory Watch. Nov 24 00:20:01.081411 systemd[1]: Started systemd-ask-password-console.path - Dispatch Password Requests to Console Directory Watch. Nov 24 00:20:01.081422 systemd[1]: Started systemd-ask-password-wall.path - Forward Password Requests to Wall Directory Watch. Nov 24 00:20:01.081433 systemd[1]: Set up automount boot.automount - Boot partition Automount Point. Nov 24 00:20:01.081451 systemd[1]: Set up automount proc-sys-fs-binfmt_misc.automount - Arbitrary Executable File Formats File System Automount Point. Nov 24 00:20:01.081462 systemd[1]: Expecting device dev-disk-by\x2dlabel-OEM.device - /dev/disk/by-label/OEM... Nov 24 00:20:01.081476 systemd[1]: Expecting device dev-ttyS0.device - /dev/ttyS0... Nov 24 00:20:01.081487 systemd[1]: Reached target cryptsetup-pre.target - Local Encrypted Volumes (Pre). Nov 24 00:20:01.081499 systemd[1]: Reached target cryptsetup.target - Local Encrypted Volumes. Nov 24 00:20:01.081509 systemd[1]: Stopped target initrd-switch-root.target - Switch Root. Nov 24 00:20:01.081521 systemd[1]: Stopped target initrd-fs.target - Initrd File Systems. Nov 24 00:20:01.081532 systemd[1]: Stopped target initrd-root-fs.target - Initrd Root File System. Nov 24 00:20:01.081544 systemd[1]: Reached target integritysetup.target - Local Integrity Protected Volumes. Nov 24 00:20:01.081557 systemd[1]: Reached target remote-cryptsetup.target - Remote Encrypted Volumes. Nov 24 00:20:01.081569 systemd[1]: Reached target remote-fs.target - Remote File Systems. Nov 24 00:20:01.081580 systemd[1]: Reached target slices.target - Slice Units. Nov 24 00:20:01.081591 systemd[1]: Reached target swap.target - Swaps. Nov 24 00:20:01.081606 systemd[1]: Reached target veritysetup.target - Local Verity Protected Volumes. Nov 24 00:20:01.081617 systemd[1]: Listening on systemd-coredump.socket - Process Core Dump Socket. Nov 24 00:20:01.081632 systemd[1]: Listening on systemd-creds.socket - Credential Encryption/Decryption. Nov 24 00:20:01.081643 systemd[1]: Listening on systemd-networkd.socket - Network Service Netlink Socket. Nov 24 00:20:01.081655 systemd[1]: Listening on systemd-udevd-control.socket - udev Control Socket. Nov 24 00:20:01.081666 systemd[1]: Listening on systemd-udevd-kernel.socket - udev Kernel Socket. Nov 24 00:20:01.081677 systemd[1]: Listening on systemd-userdbd.socket - User Database Manager Socket. Nov 24 00:20:01.081689 systemd[1]: Mounting dev-hugepages.mount - Huge Pages File System... Nov 24 00:20:01.081700 systemd[1]: Mounting dev-mqueue.mount - POSIX Message Queue File System... Nov 24 00:20:01.081714 systemd[1]: Mounting media.mount - External Media Directory... Nov 24 00:20:01.081726 systemd[1]: proc-xen.mount - /proc/xen was skipped because of an unmet condition check (ConditionVirtualization=xen). Nov 24 00:20:01.081737 systemd[1]: Mounting sys-kernel-debug.mount - Kernel Debug File System... Nov 24 00:20:01.081748 systemd[1]: Mounting sys-kernel-tracing.mount - Kernel Trace File System... Nov 24 00:20:01.081759 systemd[1]: Mounting tmp.mount - Temporary Directory /tmp... Nov 24 00:20:01.081771 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). Nov 24 00:20:01.081783 systemd[1]: Reached target machines.target - Containers. Nov 24 00:20:01.081794 systemd[1]: Starting flatcar-tmpfiles.service - Create missing system files... Nov 24 00:20:01.081805 systemd[1]: ignition-delete-config.service - Ignition (delete config) was skipped because no trigger condition checks were met. Nov 24 00:20:01.081819 systemd[1]: Starting kmod-static-nodes.service - Create List of Static Device Nodes... Nov 24 00:20:01.081831 systemd[1]: Starting modprobe@configfs.service - Load Kernel Module configfs... Nov 24 00:20:01.081842 systemd[1]: Starting modprobe@dm_mod.service - Load Kernel Module dm_mod... Nov 24 00:20:01.081857 systemd[1]: Starting modprobe@drm.service - Load Kernel Module drm... Nov 24 00:20:01.081869 systemd[1]: Starting modprobe@efi_pstore.service - Load Kernel Module efi_pstore... Nov 24 00:20:01.081880 systemd[1]: Starting modprobe@fuse.service - Load Kernel Module fuse... Nov 24 00:20:01.081891 systemd[1]: Starting modprobe@loop.service - Load Kernel Module loop... Nov 24 00:20:01.081903 systemd[1]: setup-nsswitch.service - Create /etc/nsswitch.conf was skipped because of an unmet condition check (ConditionPathExists=!/etc/nsswitch.conf). Nov 24 00:20:01.081917 systemd[1]: systemd-fsck-root.service: Deactivated successfully. Nov 24 00:20:01.081929 systemd[1]: Stopped systemd-fsck-root.service - File System Check on Root Device. Nov 24 00:20:01.081940 systemd[1]: systemd-fsck-usr.service: Deactivated successfully. Nov 24 00:20:01.081951 systemd[1]: Stopped systemd-fsck-usr.service. Nov 24 00:20:01.081963 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). Nov 24 00:20:01.081975 systemd[1]: Starting systemd-journald.service - Journal Service... Nov 24 00:20:01.081999 kernel: fuse: init (API version 7.41) Nov 24 00:20:01.082010 kernel: loop: module loaded Nov 24 00:20:01.082024 systemd[1]: Starting systemd-modules-load.service - Load Kernel Modules... Nov 24 00:20:01.082036 systemd[1]: Starting systemd-network-generator.service - Generate network units from Kernel command line... Nov 24 00:20:01.082047 systemd[1]: Starting systemd-remount-fs.service - Remount Root and Kernel File Systems... Nov 24 00:20:01.082058 systemd[1]: Starting systemd-udev-load-credentials.service - Load udev Rules from Credentials... Nov 24 00:20:01.082070 systemd[1]: Starting systemd-udev-trigger.service - Coldplug All udev Devices... Nov 24 00:20:01.082081 systemd[1]: verity-setup.service: Deactivated successfully. Nov 24 00:20:01.082092 systemd[1]: Stopped verity-setup.service. Nov 24 00:20:01.082104 systemd[1]: xenserver-pv-version.service - Set fake PV driver version for XenServer was skipped because of an unmet condition check (ConditionVirtualization=xen). Nov 24 00:20:01.082119 systemd[1]: Mounted dev-hugepages.mount - Huge Pages File System. Nov 24 00:20:01.082133 systemd[1]: Mounted dev-mqueue.mount - POSIX Message Queue File System. Nov 24 00:20:01.082145 systemd[1]: Mounted media.mount - External Media Directory. Nov 24 00:20:01.082156 systemd[1]: Mounted sys-kernel-debug.mount - Kernel Debug File System. Nov 24 00:20:01.082195 systemd-journald[1484]: Collecting audit messages is disabled. Nov 24 00:20:01.082224 systemd[1]: Mounted sys-kernel-tracing.mount - Kernel Trace File System. Nov 24 00:20:01.082237 systemd-journald[1484]: Journal started Nov 24 00:20:01.082259 systemd-journald[1484]: Runtime Journal (/run/log/journal/73257de8833845c39a9066379102db58) is 8M, max 2.2G, 2.1G free. Nov 24 00:20:00.224244 systemd[1]: Queued start job for default target multi-user.target. Nov 24 00:20:00.252295 systemd[1]: Unnecessary job was removed for dev-sda6.device - /dev/sda6. Nov 24 00:20:00.252762 systemd[1]: systemd-journald.service: Deactivated successfully. Nov 24 00:20:01.093117 systemd[1]: Started systemd-journald.service - Journal Service. Nov 24 00:20:01.097307 systemd[1]: Mounted tmp.mount - Temporary Directory /tmp. Nov 24 00:20:01.101432 systemd[1]: Finished flatcar-tmpfiles.service - Create missing system files. Nov 24 00:20:01.106636 systemd[1]: Finished kmod-static-nodes.service - Create List of Static Device Nodes. Nov 24 00:20:01.111926 systemd[1]: modprobe@configfs.service: Deactivated successfully. Nov 24 00:20:01.112141 systemd[1]: Finished modprobe@configfs.service - Load Kernel Module configfs. Nov 24 00:20:01.117164 systemd[1]: modprobe@dm_mod.service: Deactivated successfully. Nov 24 00:20:01.117351 systemd[1]: Finished modprobe@dm_mod.service - Load Kernel Module dm_mod. Nov 24 00:20:01.122489 systemd[1]: modprobe@efi_pstore.service: Deactivated successfully. Nov 24 00:20:01.122682 systemd[1]: Finished modprobe@efi_pstore.service - Load Kernel Module efi_pstore. Nov 24 00:20:01.128364 systemd[1]: modprobe@fuse.service: Deactivated successfully. Nov 24 00:20:01.128570 systemd[1]: Finished modprobe@fuse.service - Load Kernel Module fuse. Nov 24 00:20:01.132993 kernel: ACPI: bus type drm_connector registered Nov 24 00:20:01.135496 systemd[1]: modprobe@loop.service: Deactivated successfully. Nov 24 00:20:01.135732 systemd[1]: Finished modprobe@loop.service - Load Kernel Module loop. Nov 24 00:20:01.140615 systemd[1]: modprobe@drm.service: Deactivated successfully. Nov 24 00:20:01.140809 systemd[1]: Finished modprobe@drm.service - Load Kernel Module drm. Nov 24 00:20:01.145495 systemd[1]: Finished systemd-modules-load.service - Load Kernel Modules. Nov 24 00:20:01.150228 systemd[1]: Finished systemd-network-generator.service - Generate network units from Kernel command line. Nov 24 00:20:01.155439 systemd[1]: Finished systemd-remount-fs.service - Remount Root and Kernel File Systems. Nov 24 00:20:01.160675 systemd[1]: Finished systemd-udev-load-credentials.service - Load udev Rules from Credentials. Nov 24 00:20:01.166023 systemd[1]: Finished systemd-udev-trigger.service - Coldplug All udev Devices. Nov 24 00:20:01.180567 systemd[1]: Reached target network-pre.target - Preparation for Network. Nov 24 00:20:01.186287 systemd[1]: Mounting sys-fs-fuse-connections.mount - FUSE Control File System... Nov 24 00:20:01.207218 systemd[1]: Mounting sys-kernel-config.mount - Kernel Configuration File System... Nov 24 00:20:01.211959 systemd[1]: remount-root.service - Remount Root File System was skipped because of an unmet condition check (ConditionPathIsReadWrite=!/). Nov 24 00:20:01.212011 systemd[1]: Reached target local-fs.target - Local File Systems. Nov 24 00:20:01.217142 systemd[1]: Listening on systemd-sysext.socket - System Extension Image Management. Nov 24 00:20:01.223098 systemd[1]: Starting ldconfig.service - Rebuild Dynamic Linker Cache... Nov 24 00:20:01.227582 systemd[1]: systemd-binfmt.service - Set Up Additional Binary Formats was skipped because no trigger condition checks were met. Nov 24 00:20:01.244777 systemd[1]: Starting systemd-hwdb-update.service - Rebuild Hardware Database... Nov 24 00:20:01.270250 systemd[1]: Starting systemd-journal-flush.service - Flush Journal to Persistent Storage... Nov 24 00:20:01.274929 systemd[1]: systemd-pstore.service - Platform Persistent Storage Archival was skipped because of an unmet condition check (ConditionDirectoryNotEmpty=/sys/fs/pstore). Nov 24 00:20:01.275858 systemd[1]: Starting systemd-random-seed.service - Load/Save OS Random Seed... Nov 24 00:20:01.280187 systemd[1]: systemd-repart.service - Repartition Root Disk was skipped because no trigger condition checks were met. Nov 24 00:20:01.281147 systemd[1]: Starting systemd-sysctl.service - Apply Kernel Variables... Nov 24 00:20:01.286215 systemd[1]: Starting systemd-sysext.service - Merge System Extension Images into /usr/ and /opt/... Nov 24 00:20:01.291708 systemd[1]: Starting systemd-tmpfiles-setup-dev-early.service - Create Static Device Nodes in /dev gracefully... Nov 24 00:20:01.298317 systemd[1]: Mounted sys-fs-fuse-connections.mount - FUSE Control File System. Nov 24 00:20:01.302400 systemd-journald[1484]: Time spent on flushing to /var/log/journal/73257de8833845c39a9066379102db58 is 14.492ms for 952 entries. Nov 24 00:20:01.302400 systemd-journald[1484]: System Journal (/var/log/journal/73257de8833845c39a9066379102db58) is 8M, max 2.6G, 2.6G free. Nov 24 00:20:01.341937 systemd-journald[1484]: Received client request to flush runtime journal. Nov 24 00:20:01.307121 systemd[1]: Mounted sys-kernel-config.mount - Kernel Configuration File System. Nov 24 00:20:01.326212 systemd[1]: Finished systemd-random-seed.service - Load/Save OS Random Seed. Nov 24 00:20:01.331318 systemd[1]: Reached target first-boot-complete.target - First Boot Complete. Nov 24 00:20:01.337161 systemd[1]: Starting systemd-machine-id-commit.service - Save Transient machine-id to Disk... Nov 24 00:20:01.352150 systemd[1]: Finished systemd-journal-flush.service - Flush Journal to Persistent Storage. Nov 24 00:20:01.378003 kernel: loop0: detected capacity change from 0 to 128560 Nov 24 00:20:01.398787 systemd[1]: etc-machine\x2did.mount: Deactivated successfully. Nov 24 00:20:01.399513 systemd[1]: Finished systemd-machine-id-commit.service - Save Transient machine-id to Disk. Nov 24 00:20:01.406541 systemd-tmpfiles[1522]: ACLs are not supported, ignoring. Nov 24 00:20:01.406562 systemd-tmpfiles[1522]: ACLs are not supported, ignoring. Nov 24 00:20:01.410496 systemd[1]: Finished systemd-tmpfiles-setup-dev-early.service - Create Static Device Nodes in /dev gracefully. Nov 24 00:20:01.416821 systemd[1]: Starting systemd-sysusers.service - Create System Users... Nov 24 00:20:01.421097 systemd[1]: Finished systemd-sysctl.service - Apply Kernel Variables. Nov 24 00:20:01.525889 systemd[1]: Finished systemd-sysusers.service - Create System Users. Nov 24 00:20:01.531455 systemd[1]: Starting systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev... Nov 24 00:20:01.570634 systemd-tmpfiles[1539]: ACLs are not supported, ignoring. Nov 24 00:20:01.570654 systemd-tmpfiles[1539]: ACLs are not supported, ignoring. Nov 24 00:20:01.574116 systemd[1]: Finished systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev. Nov 24 00:20:02.023015 kernel: squashfs: version 4.0 (2009/01/31) Phillip Lougher Nov 24 00:20:02.098004 kernel: loop1: detected capacity change from 0 to 110984 Nov 24 00:20:02.306184 systemd[1]: Finished systemd-hwdb-update.service - Rebuild Hardware Database. Nov 24 00:20:02.312535 systemd[1]: Starting systemd-udevd.service - Rule-based Manager for Device Events and Files... Nov 24 00:20:02.362949 systemd-udevd[1545]: Using default interface naming scheme 'v255'. Nov 24 00:20:02.556006 kernel: loop2: detected capacity change from 0 to 27936 Nov 24 00:20:02.635425 systemd[1]: Started systemd-udevd.service - Rule-based Manager for Device Events and Files. Nov 24 00:20:02.643422 systemd[1]: Starting systemd-networkd.service - Network Configuration... Nov 24 00:20:02.680222 systemd[1]: Condition check resulted in dev-ttyS0.device - /dev/ttyS0 being skipped. Nov 24 00:20:02.720997 kernel: hv_vmbus: registering driver hyperv_fb Nov 24 00:20:02.729001 kernel: hyperv_fb: Synthvid Version major 3, minor 5 Nov 24 00:20:02.729059 kernel: hyperv_fb: Screen resolution: 1024x768, Color depth: 32, Frame buffer size: 8388608 Nov 24 00:20:02.732063 kernel: Console: switching to colour dummy device 80x25 Nov 24 00:20:02.740032 kernel: Console: switching to colour frame buffer device 128x48 Nov 24 00:20:02.742233 systemd[1]: Starting systemd-userdbd.service - User Database Manager... Nov 24 00:20:02.789999 kernel: mousedev: PS/2 mouse device common for all mice Nov 24 00:20:02.802312 systemd[1]: Started systemd-userdbd.service - User Database Manager. Nov 24 00:20:02.812034 kernel: hv_vmbus: registering driver hv_balloon Nov 24 00:20:02.812088 kernel: hv_balloon: Using Dynamic Memory protocol version 2.0 Nov 24 00:20:02.860005 kernel: EDAC MC: Ver: 3.0.0 Nov 24 00:20:02.869915 systemd[1]: Starting systemd-vconsole-setup.service - Virtual Console Setup... Nov 24 00:20:02.887511 systemd[1]: systemd-vconsole-setup.service: Deactivated successfully. Nov 24 00:20:02.887704 systemd[1]: Stopped systemd-vconsole-setup.service - Virtual Console Setup. Nov 24 00:20:02.893816 systemd[1]: Starting systemd-vconsole-setup.service - Virtual Console Setup... Nov 24 00:20:02.915754 systemd-networkd[1569]: lo: Link UP Nov 24 00:20:02.915762 systemd-networkd[1569]: lo: Gained carrier Nov 24 00:20:02.917058 systemd-networkd[1569]: Enumeration completed Nov 24 00:20:02.917324 systemd[1]: Started systemd-networkd.service - Network Configuration. Nov 24 00:20:02.917427 systemd-networkd[1569]: eth0: found matching network '/usr/lib/systemd/network/zz-default.network', based on potentially unpredictable interface name. Nov 24 00:20:02.917431 systemd-networkd[1569]: eth0: Configuring with /usr/lib/systemd/network/zz-default.network. Nov 24 00:20:02.918223 systemd-networkd[1569]: eth0: Link UP Nov 24 00:20:02.918232 systemd-networkd[1569]: eth0: Gained carrier Nov 24 00:20:02.918246 systemd-networkd[1569]: eth0: found matching network '/usr/lib/systemd/network/zz-default.network', based on potentially unpredictable interface name. Nov 24 00:20:02.922229 systemd[1]: Starting systemd-networkd-persistent-storage.service - Enable Persistent Storage in systemd-networkd... Nov 24 00:20:02.925381 systemd[1]: Starting systemd-networkd-wait-online.service - Wait for Network to be Configured... Nov 24 00:20:02.959087 systemd-networkd[1569]: eth0: DHCPv4 address 10.200.0.13/24, gateway 10.200.0.1 acquired from 168.63.129.16 Nov 24 00:20:03.005818 systemd[1]: Found device dev-disk-by\x2dlabel-OEM.device - Virtual_Disk OEM. Nov 24 00:20:03.008691 systemd[1]: Starting systemd-fsck@dev-disk-by\x2dlabel-OEM.service - File System Check on /dev/disk/by-label/OEM... Nov 24 00:20:03.070635 systemd[1]: Finished systemd-networkd-persistent-storage.service - Enable Persistent Storage in systemd-networkd. Nov 24 00:20:03.114804 systemd[1]: Finished systemd-fsck@dev-disk-by\x2dlabel-OEM.service - File System Check on /dev/disk/by-label/OEM. Nov 24 00:20:03.195005 kernel: loop3: detected capacity change from 0 to 128560 Nov 24 00:20:03.213998 kernel: loop4: detected capacity change from 0 to 110984 Nov 24 00:20:03.229999 kernel: loop5: detected capacity change from 0 to 27936 Nov 24 00:20:03.240116 (sd-merge)[1700]: Using extensions 'containerd-flatcar', 'docker-flatcar', 'oem-azure'. Nov 24 00:20:03.240573 (sd-merge)[1700]: Merged extensions into '/usr'. Nov 24 00:20:03.243892 systemd[1]: Finished systemd-sysext.service - Merge System Extension Images into /usr/ and /opt/. Nov 24 00:20:03.246790 systemd[1]: Starting ensure-sysext.service... Nov 24 00:20:03.247774 systemd[1]: Starting systemd-tmpfiles-setup.service - Create System Files and Directories... Nov 24 00:20:03.285491 systemd[1]: Reload requested from client PID 1702 ('systemctl') (unit ensure-sysext.service)... Nov 24 00:20:03.285507 systemd[1]: Reloading... Nov 24 00:20:03.296071 systemd-tmpfiles[1703]: /usr/lib/tmpfiles.d/nfs-utils.conf:6: Duplicate line for path "/var/lib/nfs/sm", ignoring. Nov 24 00:20:03.296106 systemd-tmpfiles[1703]: /usr/lib/tmpfiles.d/nfs-utils.conf:7: Duplicate line for path "/var/lib/nfs/sm.bak", ignoring. Nov 24 00:20:03.296372 systemd-tmpfiles[1703]: /usr/lib/tmpfiles.d/provision.conf:20: Duplicate line for path "/root", ignoring. Nov 24 00:20:03.296661 systemd-tmpfiles[1703]: /usr/lib/tmpfiles.d/systemd-flatcar.conf:6: Duplicate line for path "/var/log/journal", ignoring. Nov 24 00:20:03.297561 systemd-tmpfiles[1703]: /usr/lib/tmpfiles.d/systemd.conf:29: Duplicate line for path "/var/lib/systemd", ignoring. Nov 24 00:20:03.297857 systemd-tmpfiles[1703]: ACLs are not supported, ignoring. Nov 24 00:20:03.297926 systemd-tmpfiles[1703]: ACLs are not supported, ignoring. Nov 24 00:20:03.302817 systemd-tmpfiles[1703]: Detected autofs mount point /boot during canonicalization of boot. Nov 24 00:20:03.302830 systemd-tmpfiles[1703]: Skipping /boot Nov 24 00:20:03.311537 systemd-tmpfiles[1703]: Detected autofs mount point /boot during canonicalization of boot. Nov 24 00:20:03.311555 systemd-tmpfiles[1703]: Skipping /boot Nov 24 00:20:03.321005 zram_generator::config[1735]: No configuration found. Nov 24 00:20:03.596754 systemd[1]: Reloading finished in 310 ms. Nov 24 00:20:03.624216 systemd[1]: Finished systemd-vconsole-setup.service - Virtual Console Setup. Nov 24 00:20:03.656585 systemd[1]: Finished systemd-tmpfiles-setup.service - Create System Files and Directories. Nov 24 00:20:03.674122 systemd[1]: proc-xen.mount - /proc/xen was skipped because of an unmet condition check (ConditionVirtualization=xen). Nov 24 00:20:03.675371 systemd[1]: Starting audit-rules.service - Load Audit Rules... Nov 24 00:20:03.701862 systemd[1]: Starting clean-ca-certificates.service - Clean up broken links in /etc/ssl/certs... Nov 24 00:20:03.706766 systemd[1]: ignition-delete-config.service - Ignition (delete config) was skipped because no trigger condition checks were met. Nov 24 00:20:03.707877 systemd[1]: Starting modprobe@dm_mod.service - Load Kernel Module dm_mod... Nov 24 00:20:03.713076 systemd[1]: Starting modprobe@efi_pstore.service - Load Kernel Module efi_pstore... Nov 24 00:20:03.718514 systemd[1]: Starting modprobe@loop.service - Load Kernel Module loop... Nov 24 00:20:03.722634 systemd[1]: systemd-binfmt.service - Set Up Additional Binary Formats was skipped because no trigger condition checks were met. Nov 24 00:20:03.722802 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). Nov 24 00:20:03.723958 systemd[1]: Starting systemd-journal-catalog-update.service - Rebuild Journal Catalog... Nov 24 00:20:03.730147 systemd[1]: Starting systemd-resolved.service - Network Name Resolution... Nov 24 00:20:03.735297 systemd[1]: Starting systemd-update-utmp.service - Record System Boot/Shutdown in UTMP... Nov 24 00:20:03.740002 systemd[1]: xenserver-pv-version.service - Set fake PV driver version for XenServer was skipped because of an unmet condition check (ConditionVirtualization=xen). Nov 24 00:20:03.742089 systemd[1]: modprobe@dm_mod.service: Deactivated successfully. Nov 24 00:20:03.742287 systemd[1]: Finished modprobe@dm_mod.service - Load Kernel Module dm_mod. Nov 24 00:20:03.747430 systemd[1]: modprobe@efi_pstore.service: Deactivated successfully. Nov 24 00:20:03.747606 systemd[1]: Finished modprobe@efi_pstore.service - Load Kernel Module efi_pstore. Nov 24 00:20:03.753025 systemd[1]: modprobe@loop.service: Deactivated successfully. Nov 24 00:20:03.753213 systemd[1]: Finished modprobe@loop.service - Load Kernel Module loop. Nov 24 00:20:03.773119 systemd[1]: Finished systemd-update-utmp.service - Record System Boot/Shutdown in UTMP. Nov 24 00:20:03.784129 systemd[1]: proc-xen.mount - /proc/xen was skipped because of an unmet condition check (ConditionVirtualization=xen). Nov 24 00:20:03.784412 systemd[1]: ignition-delete-config.service - Ignition (delete config) was skipped because no trigger condition checks were met. Nov 24 00:20:03.786029 systemd[1]: Starting modprobe@dm_mod.service - Load Kernel Module dm_mod... Nov 24 00:20:03.792017 systemd[1]: Starting modprobe@drm.service - Load Kernel Module drm... Nov 24 00:20:03.807152 systemd[1]: Starting modprobe@efi_pstore.service - Load Kernel Module efi_pstore... Nov 24 00:20:03.812719 systemd[1]: Starting modprobe@loop.service - Load Kernel Module loop... Nov 24 00:20:03.816691 systemd[1]: systemd-binfmt.service - Set Up Additional Binary Formats was skipped because no trigger condition checks were met. Nov 24 00:20:03.816818 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). Nov 24 00:20:03.817035 systemd[1]: Reached target time-set.target - System Time Set. Nov 24 00:20:03.821390 systemd[1]: xenserver-pv-version.service - Set fake PV driver version for XenServer was skipped because of an unmet condition check (ConditionVirtualization=xen). Nov 24 00:20:03.822960 systemd[1]: modprobe@dm_mod.service: Deactivated successfully. Nov 24 00:20:03.823165 systemd[1]: Finished modprobe@dm_mod.service - Load Kernel Module dm_mod. Nov 24 00:20:03.828466 systemd[1]: modprobe@drm.service: Deactivated successfully. Nov 24 00:20:03.828641 systemd[1]: Finished modprobe@drm.service - Load Kernel Module drm. Nov 24 00:20:03.833375 systemd[1]: modprobe@efi_pstore.service: Deactivated successfully. Nov 24 00:20:03.833559 systemd[1]: Finished modprobe@efi_pstore.service - Load Kernel Module efi_pstore. Nov 24 00:20:03.838844 systemd[1]: modprobe@loop.service: Deactivated successfully. Nov 24 00:20:03.839028 systemd[1]: Finished modprobe@loop.service - Load Kernel Module loop. Nov 24 00:20:03.845831 systemd[1]: Finished ensure-sysext.service. Nov 24 00:20:03.852293 systemd[1]: systemd-pstore.service - Platform Persistent Storage Archival was skipped because of an unmet condition check (ConditionDirectoryNotEmpty=/sys/fs/pstore). Nov 24 00:20:03.852348 systemd[1]: systemd-repart.service - Repartition Root Disk was skipped because no trigger condition checks were met. Nov 24 00:20:03.865583 systemd[1]: Finished systemd-journal-catalog-update.service - Rebuild Journal Catalog. Nov 24 00:20:03.877680 systemd-resolved[1810]: Positive Trust Anchors: Nov 24 00:20:03.877696 systemd-resolved[1810]: . IN DS 20326 8 2 e06d44b80b8f1d39a95c0b0d7c65d08458e880409bbc683457104237c7f8ec8d Nov 24 00:20:03.877728 systemd-resolved[1810]: 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 Nov 24 00:20:03.893608 augenrules[1842]: No rules Nov 24 00:20:03.893732 systemd-resolved[1810]: Using system hostname 'ci-4459.1.2-a-239ffcb467'. Nov 24 00:20:03.894675 systemd[1]: audit-rules.service: Deactivated successfully. Nov 24 00:20:03.894900 systemd[1]: Finished audit-rules.service - Load Audit Rules. Nov 24 00:20:03.899153 systemd[1]: Started systemd-resolved.service - Network Name Resolution. Nov 24 00:20:03.903753 systemd[1]: Reached target network.target - Network. Nov 24 00:20:03.907321 systemd[1]: Reached target nss-lookup.target - Host and Network Name Lookups. Nov 24 00:20:04.189120 systemd-networkd[1569]: eth0: Gained IPv6LL Nov 24 00:20:04.191336 systemd[1]: Finished systemd-networkd-wait-online.service - Wait for Network to be Configured. Nov 24 00:20:04.196557 systemd[1]: Reached target network-online.target - Network is Online. Nov 24 00:20:04.646180 systemd[1]: Finished clean-ca-certificates.service - Clean up broken links in /etc/ssl/certs. Nov 24 00:20:04.651688 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). Nov 24 00:20:09.448521 ldconfig[1515]: /sbin/ldconfig: /usr/lib/ld.so.conf is not an ELF file - it has the wrong magic bytes at the start. Nov 24 00:20:09.460138 systemd[1]: Finished ldconfig.service - Rebuild Dynamic Linker Cache. Nov 24 00:20:09.466713 systemd[1]: Starting systemd-update-done.service - Update is Completed... Nov 24 00:20:09.498212 systemd[1]: Finished systemd-update-done.service - Update is Completed. Nov 24 00:20:09.502855 systemd[1]: Reached target sysinit.target - System Initialization. Nov 24 00:20:09.507287 systemd[1]: Started motdgen.path - Watch for update engine configuration changes. Nov 24 00:20:09.512807 systemd[1]: Started user-cloudinit@var-lib-flatcar\x2dinstall-user_data.path - Watch for a cloud-config at /var/lib/flatcar-install/user_data. Nov 24 00:20:09.518006 systemd[1]: Started google-oslogin-cache.timer - NSS cache refresh timer. Nov 24 00:20:09.522749 systemd[1]: Started logrotate.timer - Daily rotation of log files. Nov 24 00:20:09.527186 systemd[1]: Started mdadm.timer - Weekly check for MD array's redundancy information.. Nov 24 00:20:09.532284 systemd[1]: Started systemd-tmpfiles-clean.timer - Daily Cleanup of Temporary Directories. Nov 24 00:20:09.537514 systemd[1]: update-engine-stub.timer - Update Engine Stub Timer was skipped because of an unmet condition check (ConditionPathExists=/usr/.noupdate). Nov 24 00:20:09.537560 systemd[1]: Reached target paths.target - Path Units. Nov 24 00:20:09.541129 systemd[1]: Reached target timers.target - Timer Units. Nov 24 00:20:09.546403 systemd[1]: Listening on dbus.socket - D-Bus System Message Bus Socket. Nov 24 00:20:09.566896 systemd[1]: Starting docker.socket - Docker Socket for the API... Nov 24 00:20:09.572855 systemd[1]: Listening on sshd-unix-local.socket - OpenSSH Server Socket (systemd-ssh-generator, AF_UNIX Local). Nov 24 00:20:09.578140 systemd[1]: Listening on sshd-vsock.socket - OpenSSH Server Socket (systemd-ssh-generator, AF_VSOCK). Nov 24 00:20:09.583151 systemd[1]: Reached target ssh-access.target - SSH Access Available. Nov 24 00:20:09.589397 systemd[1]: Listening on sshd.socket - OpenSSH Server Socket. Nov 24 00:20:09.593818 systemd[1]: Listening on systemd-hostnamed.socket - Hostname Service Socket. Nov 24 00:20:09.599320 systemd[1]: Listening on docker.socket - Docker Socket for the API. Nov 24 00:20:09.604530 systemd[1]: Reached target sockets.target - Socket Units. Nov 24 00:20:09.608492 systemd[1]: Reached target basic.target - Basic System. Nov 24 00:20:09.612199 systemd[1]: addon-config@oem.service - Configure Addon /oem was skipped because no trigger condition checks were met. Nov 24 00:20:09.612236 systemd[1]: addon-run@oem.service - Run Addon /oem was skipped because no trigger condition checks were met. Nov 24 00:20:09.614666 systemd[1]: Starting chronyd.service - NTP client/server... Nov 24 00:20:09.619020 systemd[1]: Starting containerd.service - containerd container runtime... Nov 24 00:20:09.640854 systemd[1]: Starting coreos-metadata.service - Flatcar Metadata Agent... Nov 24 00:20:09.648562 systemd[1]: Starting dbus.service - D-Bus System Message Bus... Nov 24 00:20:09.653171 systemd[1]: Starting dracut-shutdown.service - Restore /run/initramfs on shutdown... Nov 24 00:20:09.659121 systemd[1]: Starting enable-oem-cloudinit.service - Enable cloudinit... Nov 24 00:20:09.664090 systemd[1]: Starting extend-filesystems.service - Extend Filesystems... Nov 24 00:20:09.666706 jq[1863]: false Nov 24 00:20:09.668025 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). Nov 24 00:20:09.669066 systemd[1]: Starting google-oslogin-cache.service - NSS cache refresh... Nov 24 00:20:09.673411 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). Nov 24 00:20:09.687901 systemd[1]: Started hv_kvp_daemon.service - Hyper-V KVP daemon. Nov 24 00:20:09.692359 systemd[1]: hv_vss_daemon.service - Hyper-V VSS daemon was skipped because of an unmet condition check (ConditionPathExists=/dev/vmbus/hv_vss). Nov 24 00:20:09.693359 systemd[1]: Starting motdgen.service - Generate /run/flatcar/motd... Nov 24 00:20:09.698261 systemd[1]: Starting nvidia.service - NVIDIA Configure Service... Nov 24 00:20:09.702926 systemd[1]: Starting ssh-key-proc-cmdline.service - Install an ssh key from /proc/cmdline... Nov 24 00:20:09.710140 systemd[1]: Starting sshd-keygen.service - Generate sshd host keys... Nov 24 00:20:09.716711 systemd[1]: Starting systemd-logind.service - User Login Management... Nov 24 00:20:09.721692 systemd[1]: tcsd.service - TCG Core Services Daemon was skipped because of an unmet condition check (ConditionPathExists=/dev/tpm0). Nov 24 00:20:09.722164 systemd[1]: cgroup compatibility translation between legacy and unified hierarchy settings activated. See cgroup-compat debug messages for details. Nov 24 00:20:09.723151 systemd[1]: Starting update-engine.service - Update Engine... Nov 24 00:20:09.725532 systemd[1]: Starting update-ssh-keys-after-ignition.service - Run update-ssh-keys once after Ignition... Nov 24 00:20:09.726579 oslogin_cache_refresh[1865]: Refreshing passwd entry cache Nov 24 00:20:09.736797 google_oslogin_nss_cache[1865]: oslogin_cache_refresh[1865]: Refreshing passwd entry cache Nov 24 00:20:09.730593 systemd[1]: Finished dracut-shutdown.service - Restore /run/initramfs on shutdown. Nov 24 00:20:09.736825 systemd[1]: enable-oem-cloudinit.service: Skipped due to 'exec-condition'. Nov 24 00:20:09.737254 jq[1885]: true Nov 24 00:20:09.737201 oslogin_cache_refresh[1865]: Failure getting users, quitting Nov 24 00:20:09.742014 google_oslogin_nss_cache[1865]: oslogin_cache_refresh[1865]: Failure getting users, quitting Nov 24 00:20:09.742014 google_oslogin_nss_cache[1865]: oslogin_cache_refresh[1865]: Produced empty passwd cache file, removing /etc/oslogin_passwd.cache.bak. Nov 24 00:20:09.742014 google_oslogin_nss_cache[1865]: oslogin_cache_refresh[1865]: Refreshing group entry cache Nov 24 00:20:09.737054 systemd[1]: Condition check resulted in enable-oem-cloudinit.service - Enable cloudinit being skipped. Nov 24 00:20:09.737218 oslogin_cache_refresh[1865]: Produced empty passwd cache file, removing /etc/oslogin_passwd.cache.bak. Nov 24 00:20:09.742418 extend-filesystems[1864]: Found /dev/sda6 Nov 24 00:20:09.737420 systemd[1]: motdgen.service: Deactivated successfully. Nov 24 00:20:09.737262 oslogin_cache_refresh[1865]: Refreshing group entry cache Nov 24 00:20:09.750766 google_oslogin_nss_cache[1865]: oslogin_cache_refresh[1865]: Failure getting groups, quitting Nov 24 00:20:09.750766 google_oslogin_nss_cache[1865]: oslogin_cache_refresh[1865]: Produced empty group cache file, removing /etc/oslogin_group.cache.bak. Nov 24 00:20:09.737619 systemd[1]: Finished motdgen.service - Generate /run/flatcar/motd. Nov 24 00:20:09.750457 oslogin_cache_refresh[1865]: Failure getting groups, quitting Nov 24 00:20:09.742307 systemd[1]: ssh-key-proc-cmdline.service: Deactivated successfully. Nov 24 00:20:09.750470 oslogin_cache_refresh[1865]: Produced empty group cache file, removing /etc/oslogin_group.cache.bak. Nov 24 00:20:09.742503 systemd[1]: Finished ssh-key-proc-cmdline.service - Install an ssh key from /proc/cmdline. Nov 24 00:20:09.752169 systemd[1]: google-oslogin-cache.service: Deactivated successfully. Nov 24 00:20:09.752309 (ntainerd)[1892]: containerd.service: Referenced but unset environment variable evaluates to an empty string: TORCX_IMAGEDIR, TORCX_UNPACKDIR Nov 24 00:20:09.752495 systemd[1]: Finished google-oslogin-cache.service - NSS cache refresh. Nov 24 00:20:09.754129 jq[1891]: true Nov 24 00:20:09.754524 KVP[1866]: KVP starting; pid is:1866 Nov 24 00:20:09.755392 extend-filesystems[1864]: Found /dev/sda9 Nov 24 00:20:09.762023 kernel: hv_utils: KVP IC version 4.0 Nov 24 00:20:09.759186 KVP[1866]: KVP LIC Version: 3.1 Nov 24 00:20:09.762092 extend-filesystems[1864]: Checking size of /dev/sda9 Nov 24 00:20:09.759770 chronyd[1855]: chronyd version 4.7 starting (+CMDMON +REFCLOCK +RTC +PRIVDROP +SCFILTER -SIGND +NTS +SECHASH +IPV6 -DEBUG) Nov 24 00:20:09.774734 extend-filesystems[1864]: Old size kept for /dev/sda9 Nov 24 00:20:09.778587 systemd[1]: extend-filesystems.service: Deactivated successfully. Nov 24 00:20:09.778826 systemd[1]: Finished extend-filesystems.service - Extend Filesystems. Nov 24 00:20:09.803554 chronyd[1855]: Timezone right/UTC failed leap second check, ignoring Nov 24 00:20:09.803727 chronyd[1855]: Loaded seccomp filter (level 2) Nov 24 00:20:09.803846 systemd[1]: Started chronyd.service - NTP client/server. Nov 24 00:20:09.809784 update_engine[1880]: I20251124 00:20:09.809705 1880 main.cc:92] Flatcar Update Engine starting Nov 24 00:20:09.852039 setup-nvidia[1871]: Downloading Flatcar Container Linux Developer Container for version: 4459.1.2 Nov 24 00:20:09.870813 systemd-logind[1877]: New seat seat0. Nov 24 00:20:09.874113 systemd-logind[1877]: Watching system buttons on /dev/input/event0 (AT Translated Set 2 keyboard) Nov 24 00:20:09.874306 systemd[1]: Started systemd-logind.service - User Login Management. Nov 24 00:20:09.963145 bash[1924]: Updated "/home/core/.ssh/authorized_keys" Nov 24 00:20:09.964587 systemd[1]: Finished update-ssh-keys-after-ignition.service - Run update-ssh-keys once after Ignition. Nov 24 00:20:09.970184 systemd[1]: sshkeys.service was skipped because no trigger condition checks were met. Nov 24 00:20:10.002510 dbus-daemon[1858]: [system] SELinux support is enabled Nov 24 00:20:10.002679 systemd[1]: Started dbus.service - D-Bus System Message Bus. Nov 24 00:20:10.005337 update_engine[1880]: I20251124 00:20:10.005286 1880 update_check_scheduler.cc:74] Next update check in 2m45s Nov 24 00:20:10.009119 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). Nov 24 00:20:10.009153 systemd[1]: Reached target system-config.target - Load system-provided cloud configs. Nov 24 00:20:10.009921 dbus-daemon[1858]: [system] Successfully activated service 'org.freedesktop.systemd1' Nov 24 00:20:10.014123 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). Nov 24 00:20:10.014156 systemd[1]: Reached target user-config.target - Load user-provided cloud configs. Nov 24 00:20:10.019060 systemd[1]: Started update-engine.service - Update Engine. Nov 24 00:20:10.024610 systemd[1]: Started locksmithd.service - Cluster reboot manager. Nov 24 00:20:10.030936 sshd_keygen[1887]: ssh-keygen: generating new host keys: RSA ECDSA ED25519 Nov 24 00:20:10.037232 coreos-metadata[1857]: Nov 24 00:20:10.037 INFO Fetching http://168.63.129.16/?comp=versions: Attempt #1 Nov 24 00:20:10.039516 coreos-metadata[1857]: Nov 24 00:20:10.039 INFO Fetch successful Nov 24 00:20:10.039658 coreos-metadata[1857]: Nov 24 00:20:10.039 INFO Fetching http://168.63.129.16/machine/?comp=goalstate: Attempt #1 Nov 24 00:20:10.043350 coreos-metadata[1857]: Nov 24 00:20:10.043 INFO Fetch successful Nov 24 00:20:10.043645 coreos-metadata[1857]: Nov 24 00:20:10.043 INFO Fetching http://168.63.129.16/machine/2da04988-a341-4f68-86ba-9d0e79b73929/c06bcff7%2Ddc2e%2D464a%2D80dd%2Dc5829d751f8a.%5Fci%2D4459.1.2%2Da%2D239ffcb467?comp=config&type=sharedConfig&incarnation=1: Attempt #1 Nov 24 00:20:10.052843 systemd[1]: Finished sshd-keygen.service - Generate sshd host keys. Nov 24 00:20:10.063496 systemd[1]: Starting issuegen.service - Generate /run/issue... Nov 24 00:20:10.072856 systemd[1]: Starting waagent.service - Microsoft Azure Linux Agent... Nov 24 00:20:10.076858 coreos-metadata[1857]: Nov 24 00:20:10.075 INFO Fetch successful Nov 24 00:20:10.076858 coreos-metadata[1857]: Nov 24 00:20:10.075 INFO Fetching http://169.254.169.254/metadata/instance/compute/vmSize?api-version=2017-08-01&format=text: Attempt #1 Nov 24 00:20:10.078471 systemd[1]: issuegen.service: Deactivated successfully. Nov 24 00:20:10.078689 systemd[1]: Finished issuegen.service - Generate /run/issue. Nov 24 00:20:10.082867 coreos-metadata[1857]: Nov 24 00:20:10.082 INFO Fetch successful Nov 24 00:20:10.084289 systemd[1]: Starting systemd-user-sessions.service - Permit User Sessions... Nov 24 00:20:10.099501 systemd[1]: Started waagent.service - Microsoft Azure Linux Agent. Nov 24 00:20:10.106321 systemd[1]: Finished coreos-metadata.service - Flatcar Metadata Agent. Nov 24 00:20:10.111125 systemd[1]: packet-phone-home.service - Report Success to Packet was skipped because no trigger condition checks were met. Nov 24 00:20:10.124259 systemd[1]: Finished systemd-user-sessions.service - Permit User Sessions. Nov 24 00:20:10.130682 systemd[1]: Started getty@tty1.service - Getty on tty1. Nov 24 00:20:10.136247 systemd[1]: Started serial-getty@ttyS0.service - Serial Getty on ttyS0. Nov 24 00:20:10.141024 systemd[1]: Reached target getty.target - Login Prompts. Nov 24 00:20:10.171126 locksmithd[1992]: locksmithd starting currentOperation="UPDATE_STATUS_IDLE" strategy="reboot" Nov 24 00:20:10.334074 setup-nvidia[2025]: % Total % Received % Xferd Average Speed Time Time Time Current Nov 24 00:20:10.334471 setup-nvidia[2025]: Dload Upload Total Spent Left Speed Nov 24 00:20:11.349204 containerd[1892]: time="2025-11-24T00:20:11Z" 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 Nov 24 00:20:11.349837 containerd[1892]: time="2025-11-24T00:20:11.349802100Z" level=info msg="starting containerd" revision=4ac6c20c7bbf8177f29e46bbdc658fec02ffb8ad version=v2.0.7 Nov 24 00:20:11.357856 containerd[1892]: time="2025-11-24T00:20:11.357731000Z" level=warning msg="Configuration migrated from version 2, use `containerd config migrate` to avoid migration" t="8.9µs" Nov 24 00:20:11.357856 containerd[1892]: time="2025-11-24T00:20:11.357766900Z" level=info msg="loading plugin" id=io.containerd.image-verifier.v1.bindir type=io.containerd.image-verifier.v1 Nov 24 00:20:11.357856 containerd[1892]: time="2025-11-24T00:20:11.357791000Z" level=info msg="loading plugin" id=io.containerd.internal.v1.opt type=io.containerd.internal.v1 Nov 24 00:20:11.358118 containerd[1892]: time="2025-11-24T00:20:11.358085500Z" level=info msg="loading plugin" id=io.containerd.warning.v1.deprecations type=io.containerd.warning.v1 Nov 24 00:20:11.358118 containerd[1892]: time="2025-11-24T00:20:11.358113800Z" level=info msg="loading plugin" id=io.containerd.content.v1.content type=io.containerd.content.v1 Nov 24 00:20:11.358170 containerd[1892]: time="2025-11-24T00:20:11.358141200Z" level=info msg="loading plugin" id=io.containerd.snapshotter.v1.blockfile type=io.containerd.snapshotter.v1 Nov 24 00:20:11.358228 containerd[1892]: time="2025-11-24T00:20:11.358201200Z" level=info msg="skip loading plugin" error="no scratch file generator: skip plugin" id=io.containerd.snapshotter.v1.blockfile type=io.containerd.snapshotter.v1 Nov 24 00:20:11.358228 containerd[1892]: time="2025-11-24T00:20:11.358220500Z" level=info msg="loading plugin" id=io.containerd.snapshotter.v1.btrfs type=io.containerd.snapshotter.v1 Nov 24 00:20:11.358435 containerd[1892]: time="2025-11-24T00:20:11.358409900Z" 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 Nov 24 00:20:11.358435 containerd[1892]: time="2025-11-24T00:20:11.358430000Z" level=info msg="loading plugin" id=io.containerd.snapshotter.v1.devmapper type=io.containerd.snapshotter.v1 Nov 24 00:20:11.358486 containerd[1892]: time="2025-11-24T00:20:11.358441500Z" level=info msg="skip loading plugin" error="devmapper not configured: skip plugin" id=io.containerd.snapshotter.v1.devmapper type=io.containerd.snapshotter.v1 Nov 24 00:20:11.358486 containerd[1892]: time="2025-11-24T00:20:11.358448900Z" level=info msg="loading plugin" id=io.containerd.snapshotter.v1.native type=io.containerd.snapshotter.v1 Nov 24 00:20:11.358539 containerd[1892]: time="2025-11-24T00:20:11.358520400Z" level=info msg="loading plugin" id=io.containerd.snapshotter.v1.overlayfs type=io.containerd.snapshotter.v1 Nov 24 00:20:11.358747 containerd[1892]: time="2025-11-24T00:20:11.358724000Z" level=info msg="loading plugin" id=io.containerd.snapshotter.v1.zfs type=io.containerd.snapshotter.v1 Nov 24 00:20:11.358783 containerd[1892]: time="2025-11-24T00:20:11.358763200Z" 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 Nov 24 00:20:11.358783 containerd[1892]: time="2025-11-24T00:20:11.358773300Z" level=info msg="loading plugin" id=io.containerd.event.v1.exchange type=io.containerd.event.v1 Nov 24 00:20:11.358831 containerd[1892]: time="2025-11-24T00:20:11.358796900Z" level=info msg="loading plugin" id=io.containerd.monitor.task.v1.cgroups type=io.containerd.monitor.task.v1 Nov 24 00:20:11.359020 containerd[1892]: time="2025-11-24T00:20:11.358994400Z" level=info msg="loading plugin" id=io.containerd.metadata.v1.bolt type=io.containerd.metadata.v1 Nov 24 00:20:11.359093 containerd[1892]: time="2025-11-24T00:20:11.359071100Z" level=info msg="metadata content store policy set" policy=shared Nov 24 00:20:11.373191 containerd[1892]: time="2025-11-24T00:20:11.373158500Z" level=info msg="loading plugin" id=io.containerd.gc.v1.scheduler type=io.containerd.gc.v1 Nov 24 00:20:11.373231 containerd[1892]: time="2025-11-24T00:20:11.373198900Z" level=info msg="loading plugin" id=io.containerd.differ.v1.walking type=io.containerd.differ.v1 Nov 24 00:20:11.373231 containerd[1892]: time="2025-11-24T00:20:11.373214700Z" level=info msg="loading plugin" id=io.containerd.lease.v1.manager type=io.containerd.lease.v1 Nov 24 00:20:11.373231 containerd[1892]: time="2025-11-24T00:20:11.373226000Z" level=info msg="loading plugin" id=io.containerd.service.v1.containers-service type=io.containerd.service.v1 Nov 24 00:20:11.373305 containerd[1892]: time="2025-11-24T00:20:11.373237900Z" level=info msg="loading plugin" id=io.containerd.service.v1.content-service type=io.containerd.service.v1 Nov 24 00:20:11.373305 containerd[1892]: time="2025-11-24T00:20:11.373262800Z" level=info msg="loading plugin" id=io.containerd.service.v1.diff-service type=io.containerd.service.v1 Nov 24 00:20:11.373305 containerd[1892]: time="2025-11-24T00:20:11.373280000Z" level=info msg="loading plugin" id=io.containerd.service.v1.images-service type=io.containerd.service.v1 Nov 24 00:20:11.373305 containerd[1892]: time="2025-11-24T00:20:11.373291200Z" level=info msg="loading plugin" id=io.containerd.service.v1.introspection-service type=io.containerd.service.v1 Nov 24 00:20:11.373305 containerd[1892]: time="2025-11-24T00:20:11.373301000Z" level=info msg="loading plugin" id=io.containerd.service.v1.namespaces-service type=io.containerd.service.v1 Nov 24 00:20:11.373411 containerd[1892]: time="2025-11-24T00:20:11.373310200Z" level=info msg="loading plugin" id=io.containerd.service.v1.snapshots-service type=io.containerd.service.v1 Nov 24 00:20:11.373411 containerd[1892]: time="2025-11-24T00:20:11.373318500Z" level=info msg="loading plugin" id=io.containerd.shim.v1.manager type=io.containerd.shim.v1 Nov 24 00:20:11.373411 containerd[1892]: time="2025-11-24T00:20:11.373329600Z" level=info msg="loading plugin" id=io.containerd.runtime.v2.task type=io.containerd.runtime.v2 Nov 24 00:20:11.373475 containerd[1892]: time="2025-11-24T00:20:11.373426800Z" level=info msg="loading plugin" id=io.containerd.service.v1.tasks-service type=io.containerd.service.v1 Nov 24 00:20:11.373475 containerd[1892]: time="2025-11-24T00:20:11.373446500Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.containers type=io.containerd.grpc.v1 Nov 24 00:20:11.373475 containerd[1892]: time="2025-11-24T00:20:11.373459700Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.content type=io.containerd.grpc.v1 Nov 24 00:20:11.373534 containerd[1892]: time="2025-11-24T00:20:11.373476200Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.diff type=io.containerd.grpc.v1 Nov 24 00:20:11.373534 containerd[1892]: time="2025-11-24T00:20:11.373486400Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.events type=io.containerd.grpc.v1 Nov 24 00:20:11.373534 containerd[1892]: time="2025-11-24T00:20:11.373496300Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.images type=io.containerd.grpc.v1 Nov 24 00:20:11.373534 containerd[1892]: time="2025-11-24T00:20:11.373506300Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.introspection type=io.containerd.grpc.v1 Nov 24 00:20:11.373534 containerd[1892]: time="2025-11-24T00:20:11.373516100Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.leases type=io.containerd.grpc.v1 Nov 24 00:20:11.373647 containerd[1892]: time="2025-11-24T00:20:11.373540700Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.namespaces type=io.containerd.grpc.v1 Nov 24 00:20:11.373647 containerd[1892]: time="2025-11-24T00:20:11.373555300Z" level=info msg="loading plugin" id=io.containerd.sandbox.store.v1.local type=io.containerd.sandbox.store.v1 Nov 24 00:20:11.373647 containerd[1892]: time="2025-11-24T00:20:11.373565800Z" level=info msg="loading plugin" id=io.containerd.cri.v1.images type=io.containerd.cri.v1 Nov 24 00:20:11.373647 containerd[1892]: time="2025-11-24T00:20:11.373624000Z" level=info msg="Get image filesystem path \"/var/lib/containerd/io.containerd.snapshotter.v1.overlayfs\" for snapshotter \"overlayfs\"" Nov 24 00:20:11.373647 containerd[1892]: time="2025-11-24T00:20:11.373639700Z" level=info msg="Start snapshots syncer" Nov 24 00:20:11.373752 containerd[1892]: time="2025-11-24T00:20:11.373676100Z" level=info msg="loading plugin" id=io.containerd.cri.v1.runtime type=io.containerd.cri.v1 Nov 24 00:20:11.373961 containerd[1892]: time="2025-11-24T00:20:11.373911800Z" 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\"}" Nov 24 00:20:11.374089 containerd[1892]: time="2025-11-24T00:20:11.373996000Z" level=info msg="loading plugin" id=io.containerd.podsandbox.controller.v1.podsandbox type=io.containerd.podsandbox.controller.v1 Nov 24 00:20:11.374089 containerd[1892]: time="2025-11-24T00:20:11.374039000Z" level=info msg="loading plugin" id=io.containerd.sandbox.controller.v1.shim type=io.containerd.sandbox.controller.v1 Nov 24 00:20:11.374147 containerd[1892]: time="2025-11-24T00:20:11.374135500Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.sandbox-controllers type=io.containerd.grpc.v1 Nov 24 00:20:11.374171 containerd[1892]: time="2025-11-24T00:20:11.374157600Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.sandboxes type=io.containerd.grpc.v1 Nov 24 00:20:11.374193 containerd[1892]: time="2025-11-24T00:20:11.374169000Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.snapshots type=io.containerd.grpc.v1 Nov 24 00:20:11.374215 containerd[1892]: time="2025-11-24T00:20:11.374193100Z" level=info msg="loading plugin" id=io.containerd.streaming.v1.manager type=io.containerd.streaming.v1 Nov 24 00:20:11.374215 containerd[1892]: time="2025-11-24T00:20:11.374209000Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.streaming type=io.containerd.grpc.v1 Nov 24 00:20:11.374255 containerd[1892]: time="2025-11-24T00:20:11.374219700Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.tasks type=io.containerd.grpc.v1 Nov 24 00:20:11.374255 containerd[1892]: time="2025-11-24T00:20:11.374229500Z" level=info msg="loading plugin" id=io.containerd.transfer.v1.local type=io.containerd.transfer.v1 Nov 24 00:20:11.374303 containerd[1892]: time="2025-11-24T00:20:11.374260400Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.transfer type=io.containerd.grpc.v1 Nov 24 00:20:11.374303 containerd[1892]: time="2025-11-24T00:20:11.374275500Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.version type=io.containerd.grpc.v1 Nov 24 00:20:11.374303 containerd[1892]: time="2025-11-24T00:20:11.374285900Z" level=info msg="loading plugin" id=io.containerd.monitor.container.v1.restart type=io.containerd.monitor.container.v1 Nov 24 00:20:11.374369 containerd[1892]: time="2025-11-24T00:20:11.374320200Z" level=info msg="loading plugin" id=io.containerd.tracing.processor.v1.otlp type=io.containerd.tracing.processor.v1 Nov 24 00:20:11.374369 containerd[1892]: time="2025-11-24T00:20:11.374335800Z" 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 Nov 24 00:20:11.374369 containerd[1892]: time="2025-11-24T00:20:11.374343900Z" level=info msg="loading plugin" id=io.containerd.internal.v1.tracing type=io.containerd.internal.v1 Nov 24 00:20:11.374369 containerd[1892]: time="2025-11-24T00:20:11.374352200Z" level=info msg="skip loading plugin" error="skip plugin: tracing endpoint not configured" id=io.containerd.internal.v1.tracing type=io.containerd.internal.v1 Nov 24 00:20:11.374369 containerd[1892]: time="2025-11-24T00:20:11.374359600Z" level=info msg="loading plugin" id=io.containerd.ttrpc.v1.otelttrpc type=io.containerd.ttrpc.v1 Nov 24 00:20:11.374369 containerd[1892]: time="2025-11-24T00:20:11.374367600Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.healthcheck type=io.containerd.grpc.v1 Nov 24 00:20:11.374492 containerd[1892]: time="2025-11-24T00:20:11.374382600Z" level=info msg="loading plugin" id=io.containerd.nri.v1.nri type=io.containerd.nri.v1 Nov 24 00:20:11.374492 containerd[1892]: time="2025-11-24T00:20:11.374396900Z" level=info msg="runtime interface created" Nov 24 00:20:11.374492 containerd[1892]: time="2025-11-24T00:20:11.374402000Z" level=info msg="created NRI interface" Nov 24 00:20:11.374492 containerd[1892]: time="2025-11-24T00:20:11.374409500Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.cri type=io.containerd.grpc.v1 Nov 24 00:20:11.374492 containerd[1892]: time="2025-11-24T00:20:11.374419300Z" level=info msg="Connect containerd service" Nov 24 00:20:11.374492 containerd[1892]: time="2025-11-24T00:20:11.374436100Z" level=info msg="using experimental NRI integration - disable nri plugin to prevent this" Nov 24 00:20:11.375103 containerd[1892]: time="2025-11-24T00:20:11.375073100Z" 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" Nov 24 00:20:11.970396 containerd[1892]: time="2025-11-24T00:20:11.970350200Z" level=info msg="Start subscribing containerd event" Nov 24 00:20:11.970506 containerd[1892]: time="2025-11-24T00:20:11.970404800Z" level=info msg="Start recovering state" Nov 24 00:20:11.970506 containerd[1892]: time="2025-11-24T00:20:11.970497700Z" level=info msg="Start event monitor" Nov 24 00:20:11.970570 containerd[1892]: time="2025-11-24T00:20:11.970519000Z" level=info msg="Start cni network conf syncer for default" Nov 24 00:20:11.970570 containerd[1892]: time="2025-11-24T00:20:11.970528900Z" level=info msg="Start streaming server" Nov 24 00:20:11.970570 containerd[1892]: time="2025-11-24T00:20:11.970544900Z" level=info msg="Registered namespace \"k8s.io\" with NRI" Nov 24 00:20:11.970632 containerd[1892]: time="2025-11-24T00:20:11.970543700Z" level=info msg=serving... address=/run/containerd/containerd.sock.ttrpc Nov 24 00:20:11.970667 containerd[1892]: time="2025-11-24T00:20:11.970627800Z" level=info msg=serving... address=/run/containerd/containerd.sock Nov 24 00:20:11.970667 containerd[1892]: time="2025-11-24T00:20:11.970563600Z" level=info msg="runtime interface starting up..." Nov 24 00:20:11.970715 containerd[1892]: time="2025-11-24T00:20:11.970668100Z" level=info msg="starting plugins..." Nov 24 00:20:11.970715 containerd[1892]: time="2025-11-24T00:20:11.970685200Z" level=info msg="Synchronizing NRI (plugin) with current runtime state" Nov 24 00:20:11.970831 containerd[1892]: time="2025-11-24T00:20:11.970811700Z" level=info msg="containerd successfully booted in 0.622078s" Nov 24 00:20:11.970916 systemd[1]: Started containerd.service - containerd container runtime. Nov 24 00:20:12.373051 waagent[2016]: 2025-11-24T00:20:12.372962Z INFO Daemon Daemon Azure Linux Agent Version: 2.12.0.4 Nov 24 00:20:12.377278 waagent[2016]: 2025-11-24T00:20:12.377225Z INFO Daemon Daemon OS: flatcar 4459.1.2 Nov 24 00:20:12.380624 waagent[2016]: 2025-11-24T00:20:12.380584Z INFO Daemon Daemon Python: 3.11.13 Nov 24 00:20:12.383913 waagent[2016]: 2025-11-24T00:20:12.383868Z INFO Daemon Daemon Run daemon Nov 24 00:20:12.386851 waagent[2016]: 2025-11-24T00:20:12.386805Z INFO Daemon Daemon No RDMA handler exists for distro='Flatcar Container Linux by Kinvolk' version='4459.1.2' Nov 24 00:20:12.393391 waagent[2016]: 2025-11-24T00:20:12.393323Z INFO Daemon Daemon Using waagent for provisioning Nov 24 00:20:12.397284 waagent[2016]: 2025-11-24T00:20:12.397242Z INFO Daemon Daemon Activate resource disk Nov 24 00:20:12.400767 waagent[2016]: 2025-11-24T00:20:12.400718Z INFO Daemon Daemon Searching gen1 prefix 00000000-0001 or gen2 f8b3781a-1e82-4818-a1c3-63d806ec15bb Nov 24 00:20:12.408150 waagent[2016]: 2025-11-24T00:20:12.408101Z INFO Daemon Daemon Found device: sdb Nov 24 00:20:12.417208 waagent[2016]: 2025-11-24T00:20:12.417158Z INFO Daemon Daemon Examining partition table Nov 24 00:20:12.457528 waagent[2016]: 2025-11-24T00:20:12.457466Z INFO Daemon Daemon GPT not detected, determining filesystem Nov 24 00:20:12.501642 waagent[2016]: 2025-11-24T00:20:12.501584Z INFO Daemon Daemon sfdisk --part-type -f /dev/sdb 1 -n succeeded Nov 24 00:20:12.506163 waagent[2016]: 2025-11-24T00:20:12.506120Z INFO Daemon Daemon The partition is formatted with ntfs, updating partition type to 83 Nov 24 00:20:13.487273 kernel: hv_storvsc f8b3781a-1e82-4818-a1c3-63d806ec15bb: tag#409 cmd 0x5a status: scsi 0x2 srb 0x86 hv 0xc0000001 Nov 24 00:20:13.498998 kernel: sdb: sdb1 Nov 24 00:20:13.505998 kernel: hv_storvsc f8b3781a-1e82-4818-a1c3-63d806ec15bb: tag#416 cmd 0x5a status: scsi 0x2 srb 0x86 hv 0xc0000001 Nov 24 00:20:13.520997 kernel: sdb: sdb1 Nov 24 00:20:13.627959 waagent[2016]: 2025-11-24T00:20:13.627885Z INFO Daemon Daemon sfdisk --part-type /dev/sdb 1 83 succeeded Nov 24 00:20:13.646004 kernel: hv_storvsc f8b3781a-1e82-4818-a1c3-63d806ec15bb: tag#518 cmd 0x5a status: scsi 0x2 srb 0x86 hv 0xc0000001 Nov 24 00:20:13.665007 kernel: sdb: sdb1 Nov 24 00:20:13.665080 waagent[2016]: 2025-11-24T00:20:13.665034Z INFO Daemon Daemon Format partition [mkfs.ext4 -F /dev/sdb1] Nov 24 00:20:17.756652 login[2019]: pam_lastlog(login:session): file /var/log/lastlog is locked/write, retrying Nov 24 00:20:17.758387 login[2020]: pam_unix(login:session): session opened for user core(uid=500) by LOGIN(uid=0) Nov 24 00:20:17.764705 systemd[1]: Created slice user-500.slice - User Slice of UID 500. Nov 24 00:20:17.765724 systemd[1]: Starting user-runtime-dir@500.service - User Runtime Directory /run/user/500... Nov 24 00:20:17.772043 systemd-logind[1877]: New session 1 of user core. Nov 24 00:20:17.823402 systemd[1]: Finished user-runtime-dir@500.service - User Runtime Directory /run/user/500. Nov 24 00:20:17.825738 systemd[1]: Starting user@500.service - User Manager for UID 500... Nov 24 00:20:17.910576 (systemd)[2126]: pam_unix(systemd-user:session): session opened for user core(uid=500) by (uid=0) Nov 24 00:20:17.912801 systemd-logind[1877]: New session c1 of user core. Nov 24 00:20:18.868353 login[2019]: pam_unix(login:session): session opened for user core(uid=500) by LOGIN(uid=0) Nov 24 00:20:18.872788 systemd-logind[1877]: New session 2 of user core. Nov 24 00:20:19.201860 waagent[2016]: 2025-11-24T00:20:19.201733Z INFO Daemon Daemon Mount resource disk [mount -t ext4 /dev/sdb1 /mnt/resource] Nov 24 00:20:19.220321 systemd[2126]: Queued start job for default target default.target. Nov 24 00:20:19.235806 systemd[2126]: Created slice app.slice - User Application Slice. Nov 24 00:20:19.235848 systemd[2126]: Reached target paths.target - Paths. Nov 24 00:20:19.235895 systemd[2126]: Reached target timers.target - Timers. Nov 24 00:20:19.237144 systemd[2126]: Starting dbus.socket - D-Bus User Message Bus Socket... Nov 24 00:20:19.247488 systemd[2126]: Listening on dbus.socket - D-Bus User Message Bus Socket. Nov 24 00:20:19.247607 systemd[2126]: Reached target sockets.target - Sockets. Nov 24 00:20:19.247659 systemd[2126]: Reached target basic.target - Basic System. Nov 24 00:20:19.247705 systemd[2126]: Reached target default.target - Main User Target. Nov 24 00:20:19.247737 systemd[2126]: Startup finished in 1.329s. Nov 24 00:20:19.247764 systemd[1]: Started user@500.service - User Manager for UID 500. Nov 24 00:20:19.249195 systemd[1]: Started session-1.scope - Session 1 of User core. Nov 24 00:20:19.249909 systemd[1]: Started session-2.scope - Session 2 of User core. Nov 24 00:20:19.307008 kernel: EXT4-fs (sdb1): mounted filesystem 6c65ba81-4e93-4291-8e56-0f2aac3a52b2 r/w with ordered data mode. Quota mode: none. Nov 24 00:20:19.307246 waagent[2016]: 2025-11-24T00:20:19.307181Z INFO Daemon Daemon Resource disk /dev/sdb is mounted at /mnt/resource with ext4 Nov 24 00:20:19.309385 waagent[2016]: 2025-11-24T00:20:19.309335Z INFO Daemon Daemon Clean protocol and wireserver endpoint Nov 24 00:20:19.309677 waagent[2016]: 2025-11-24T00:20:19.309639Z INFO Daemon Daemon Running default provisioning handler Nov 24 00:20:19.317127 waagent[2016]: 2025-11-24T00:20:19.317075Z 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. Nov 24 00:20:19.318174 waagent[2016]: 2025-11-24T00:20:19.318132Z INFO Daemon Daemon Unable to get cloud-init enabled status from service: [Errno 2] No such file or directory: 'service' Nov 24 00:20:19.318521 waagent[2016]: 2025-11-24T00:20:19.318489Z INFO Daemon Daemon cloud-init is enabled: False Nov 24 00:20:19.319265 waagent[2016]: 2025-11-24T00:20:19.319234Z INFO Daemon Daemon Copying ovf-env.xml Nov 24 00:20:19.410233 waagent[2016]: 2025-11-24T00:20:19.410151Z INFO Daemon Daemon Successfully mounted dvd Nov 24 00:20:19.477655 systemd[1]: mnt-cdrom-secure.mount: Deactivated successfully. Nov 24 00:20:19.477853 waagent[2016]: 2025-11-24T00:20:19.477707Z INFO Daemon Daemon Detect protocol endpoint Nov 24 00:20:19.479336 waagent[2016]: 2025-11-24T00:20:19.479283Z INFO Daemon Daemon Clean protocol and wireserver endpoint Nov 24 00:20:19.480755 waagent[2016]: 2025-11-24T00:20:19.480717Z INFO Daemon Daemon WireServer endpoint is not found. Rerun dhcp handler Nov 24 00:20:19.482147 waagent[2016]: 2025-11-24T00:20:19.482113Z INFO Daemon Daemon Test for route to 168.63.129.16 Nov 24 00:20:19.483002 waagent[2016]: 2025-11-24T00:20:19.482956Z INFO Daemon Daemon Route to 168.63.129.16 exists Nov 24 00:20:19.483577 waagent[2016]: 2025-11-24T00:20:19.483546Z INFO Daemon Daemon Wire server endpoint:168.63.129.16 Nov 24 00:20:19.495498 waagent[2016]: 2025-11-24T00:20:19.495457Z INFO Daemon Daemon Fabric preferred wire protocol version:2015-04-05 Nov 24 00:20:19.495947 waagent[2016]: 2025-11-24T00:20:19.495922Z INFO Daemon Daemon Wire protocol version:2012-11-30 Nov 24 00:20:19.496549 waagent[2016]: 2025-11-24T00:20:19.496520Z INFO Daemon Daemon Server preferred version:2015-04-05 Nov 24 00:20:19.707784 waagent[2016]: 2025-11-24T00:20:19.707693Z INFO Daemon Daemon Initializing goal state during protocol detection Nov 24 00:20:19.709499 waagent[2016]: 2025-11-24T00:20:19.709451Z INFO Daemon Daemon Forcing an update of the goal state. Nov 24 00:20:19.718685 waagent[2016]: 2025-11-24T00:20:19.718642Z INFO Daemon Fetched a new incarnation for the WireServer goal state [incarnation 1] Nov 24 00:20:19.763112 waagent[2016]: 2025-11-24T00:20:19.763011Z INFO Daemon Daemon HostGAPlugin version: 1.0.8.177 Nov 24 00:20:19.765130 waagent[2016]: 2025-11-24T00:20:19.765087Z INFO Daemon Nov 24 00:20:19.765423 waagent[2016]: 2025-11-24T00:20:19.765390Z INFO Daemon Fetched new vmSettings [HostGAPlugin correlation ID: ba8fc69e-bf85-4f24-a010-068965551b14 eTag: 2869281582147884543 source: Fabric] Nov 24 00:20:19.767143 waagent[2016]: 2025-11-24T00:20:19.767102Z INFO Daemon The vmSettings originated via Fabric; will ignore them. Nov 24 00:20:19.767856 waagent[2016]: 2025-11-24T00:20:19.767818Z INFO Daemon Nov 24 00:20:19.769042 waagent[2016]: 2025-11-24T00:20:19.769007Z INFO Daemon Fetching full goal state from the WireServer [incarnation 1] Nov 24 00:20:19.773278 waagent[2016]: 2025-11-24T00:20:19.773242Z INFO Daemon Daemon Downloading artifacts profile blob Nov 24 00:20:19.888967 waagent[2016]: 2025-11-24T00:20:19.888900Z INFO Daemon Downloaded certificate {'thumbprint': '8F907D341136EA788E92A5AAA0116CB4D32B5945', 'hasPrivateKey': True} Nov 24 00:20:19.892826 waagent[2016]: 2025-11-24T00:20:19.892774Z INFO Daemon Fetch goal state completed Nov 24 00:20:19.927708 waagent[2016]: 2025-11-24T00:20:19.927663Z INFO Daemon Daemon Starting provisioning Nov 24 00:20:19.930730 waagent[2016]: 2025-11-24T00:20:19.930680Z INFO Daemon Daemon Handle ovf-env.xml. Nov 24 00:20:19.932551 waagent[2016]: 2025-11-24T00:20:19.932511Z INFO Daemon Daemon Set hostname [ci-4459.1.2-a-239ffcb467] Nov 24 00:20:19.996284 waagent[2016]: 2025-11-24T00:20:19.996234Z INFO Daemon Daemon Publish hostname [ci-4459.1.2-a-239ffcb467] Nov 24 00:20:20.008365 waagent[2016]: 2025-11-24T00:20:19.997968Z INFO Daemon Daemon Examine /proc/net/route for primary interface Nov 24 00:20:20.008365 waagent[2016]: 2025-11-24T00:20:19.998671Z INFO Daemon Daemon Primary interface is [eth0] Nov 24 00:20:20.009117 systemd-networkd[1569]: eth0: found matching network '/usr/lib/systemd/network/zz-default.network', based on potentially unpredictable interface name. Nov 24 00:20:20.009127 systemd-networkd[1569]: eth0: Configuring with /usr/lib/systemd/network/zz-default.network. Nov 24 00:20:20.009151 systemd-networkd[1569]: eth0: DHCP lease lost Nov 24 00:20:20.009631 waagent[2016]: 2025-11-24T00:20:20.009584Z INFO Daemon Daemon Create user account if not exists Nov 24 00:20:20.011308 waagent[2016]: 2025-11-24T00:20:20.011268Z INFO Daemon Daemon User core already exists, skip useradd Nov 24 00:20:20.012014 waagent[2016]: 2025-11-24T00:20:20.011967Z INFO Daemon Daemon Configure sudoer Nov 24 00:20:20.017339 waagent[2016]: 2025-11-24T00:20:20.017267Z INFO Daemon Daemon Configure sshd Nov 24 00:20:20.021601 waagent[2016]: 2025-11-24T00:20:20.021562Z INFO Daemon Daemon Added a configuration snippet disabling SSH password-based authentication methods. It also configures SSH client probing to keep connections alive. Nov 24 00:20:20.023073 waagent[2016]: 2025-11-24T00:20:20.023029Z INFO Daemon Daemon Deploy ssh public key. Nov 24 00:20:20.088016 systemd-networkd[1569]: eth0: DHCPv4 address 10.200.0.13/24, gateway 10.200.0.1 acquired from 168.63.129.16 Nov 24 00:20:22.115955 setup-nvidia[2025]: \u000d 0 0 0 0 0 0 0 0 --:--:-- --:--:-- --:--:-- 0\u000d 2 473M 2 10.0M 0 0 18.9M 0 0:00:25 --:--:-- 0:00:25 18.9M\u000d 14 473M 14 67.5M 0 0 43.7M 0 0:00:10 0:00:01 0:00:09 43.7M\u000d 23 473M 23 110M 0 0 43.8M 0 0:00:10 0:00:02 0:00:08 43.8M\u000d 30 473M 30 145M 0 0 41.3M 0 0:00:11 0:00:03 0:00:08 41.3M\u000d 49 473M 49 235M 0 0 51.8M 0 0:00:09 0:00:04 0:00:05 51.8M\u000d 55 473M 55 262M 0 0 47.5M 0 0:00:09 0:00:05 0:00:04 50.5M\u000d 61 473M 61 292M 0 0 44.7M 0 0:00:10 0:00:06 0:00:04 44.9M\u000d 67 473M 67 319M 0 0 42.4M 0 0:00:11 0:00:07 0:00:04 41.7M\u000d 77 473M 77 368M 0 0 43.1M 0 0:00:10 0:00:08 0:00:02 44.4M\u000d 86 473M 86 408M 0 0 42.8M 0 0:00:11 0:00:09 0:00:02 34.5M\u000d 94 473M 94 446M 0 0 42.3M 0 0:00:11 0:00:10 0:00:01 36.6M\u000d 99 473M 99 469M 0 0 40.6M 0 0:00:11 0:00:11 --:--:-- 35.4M\u000d100 473M 100 473M 0 0 40.2M 0 0:00:11 0:00:11 --:--:-- 36.3M Nov 24 00:20:32.122506 setup-nvidia[1871]: Downloading NVIDIA 535.261.03 Driver Nov 24 00:20:32.126774 setup-nvidia[2195]: % Total % Received % Xferd Average Speed Time Time Time Current Nov 24 00:20:32.127013 setup-nvidia[2195]: Dload Upload Total Spent Left Speed Nov 24 00:20:33.583723 chronyd[1855]: Selected source PHC0 Nov 24 00:20:50.109318 waagent[2016]: 2025-11-24T00:20:50.109255Z INFO Daemon Daemon Provisioning complete Nov 24 00:20:50.120084 waagent[2016]: 2025-11-24T00:20:50.120040Z INFO Daemon Daemon RDMA capabilities are not enabled, skipping Nov 24 00:20:50.121773 waagent[2016]: 2025-11-24T00:20:50.121732Z INFO Daemon Daemon End of log to /dev/console. The agent will now check for updates and then will process extensions. Nov 24 00:20:50.123251 waagent[2016]: 2025-11-24T00:20:50.123214Z INFO Daemon Daemon Installed Agent WALinuxAgent-2.12.0.4 is the most current agent Nov 24 00:20:51.055755 kernel: hv_balloon: Max. dynamic memory size: 114688 MB Nov 24 00:20:51.066957 waagent[2196]: 2025-11-24T00:20:51.066883Z INFO ExtHandler ExtHandler Azure Linux Agent (Goal State Agent version 2.12.0.4) Nov 24 00:20:51.067343 waagent[2196]: 2025-11-24T00:20:51.067040Z INFO ExtHandler ExtHandler OS: flatcar 4459.1.2 Nov 24 00:20:51.067343 waagent[2196]: 2025-11-24T00:20:51.067114Z INFO ExtHandler ExtHandler Python: 3.11.13 Nov 24 00:20:51.067343 waagent[2196]: 2025-11-24T00:20:51.067183Z INFO ExtHandler ExtHandler CPU Arch: x86_64 Nov 24 00:20:51.122347 waagent[2196]: 2025-11-24T00:20:51.122277Z INFO ExtHandler ExtHandler Distro: flatcar-4459.1.2; OSUtil: FlatcarUtil; AgentService: waagent; Python: 3.11.13; Arch: x86_64; systemd: True; LISDrivers: Absent; logrotate: logrotate 3.22.0; Nov 24 00:20:51.122594 waagent[2196]: 2025-11-24T00:20:51.122551Z INFO ExtHandler ExtHandler WireServer endpoint 168.63.129.16 read from file Nov 24 00:20:51.122674 waagent[2196]: 2025-11-24T00:20:51.122641Z INFO ExtHandler ExtHandler Wire server endpoint:168.63.129.16 Nov 24 00:20:51.129263 waagent[2196]: 2025-11-24T00:20:51.129206Z INFO ExtHandler Fetched a new incarnation for the WireServer goal state [incarnation 1] Nov 24 00:20:51.140288 waagent[2196]: 2025-11-24T00:20:51.140246Z INFO ExtHandler ExtHandler HostGAPlugin version: 1.0.8.177 Nov 24 00:20:51.140723 waagent[2196]: 2025-11-24T00:20:51.140683Z INFO ExtHandler Nov 24 00:20:51.140803 waagent[2196]: 2025-11-24T00:20:51.140771Z INFO ExtHandler Fetched new vmSettings [HostGAPlugin correlation ID: b59aaa59-2416-48da-9674-96a2029818d1 eTag: 2869281582147884543 source: Fabric] Nov 24 00:20:51.141165 waagent[2196]: 2025-11-24T00:20:51.141126Z INFO ExtHandler The vmSettings originated via Fabric; will ignore them. Nov 24 00:20:51.141763 waagent[2196]: 2025-11-24T00:20:51.141726Z INFO ExtHandler Nov 24 00:20:51.141835 waagent[2196]: 2025-11-24T00:20:51.141806Z INFO ExtHandler Fetching full goal state from the WireServer [incarnation 1] Nov 24 00:20:51.145228 waagent[2196]: 2025-11-24T00:20:51.145188Z INFO ExtHandler ExtHandler Downloading artifacts profile blob Nov 24 00:20:51.215289 waagent[2196]: 2025-11-24T00:20:51.215238Z INFO ExtHandler Downloaded certificate {'thumbprint': '8F907D341136EA788E92A5AAA0116CB4D32B5945', 'hasPrivateKey': True} Nov 24 00:20:51.215767 waagent[2196]: 2025-11-24T00:20:51.215728Z INFO ExtHandler Fetch goal state completed Nov 24 00:20:51.227496 waagent[2196]: 2025-11-24T00:20:51.227452Z INFO ExtHandler ExtHandler OpenSSL version: OpenSSL 3.4.2 1 Jul 2025 (Library: OpenSSL 3.4.2 1 Jul 2025) Nov 24 00:20:51.232252 waagent[2196]: 2025-11-24T00:20:51.232211Z INFO ExtHandler ExtHandler WALinuxAgent-2.12.0.4 running as process 2196 Nov 24 00:20:51.232391 waagent[2196]: 2025-11-24T00:20:51.232357Z INFO ExtHandler ExtHandler ******** AutoUpdate.Enabled is set to False, not processing the operation ******** Nov 24 00:20:51.232742 waagent[2196]: 2025-11-24T00:20:51.232700Z INFO ExtHandler ExtHandler ******** AutoUpdate.UpdateToLatestVersion is set to False, not processing the operation ******** Nov 24 00:20:51.234412 waagent[2196]: 2025-11-24T00:20:51.234370Z INFO ExtHandler ExtHandler [CGI] Cgroup monitoring is not supported on ['flatcar', '4459.1.2', '', 'Flatcar Container Linux by Kinvolk'] Nov 24 00:20:51.234840 waagent[2196]: 2025-11-24T00:20:51.234803Z INFO ExtHandler ExtHandler [CGI] Agent will reset the quotas in case distro: ['flatcar', '4459.1.2', '', 'Flatcar Container Linux by Kinvolk'] went from supported to unsupported Nov 24 00:20:51.235016 waagent[2196]: 2025-11-24T00:20:51.234957Z INFO ExtHandler ExtHandler [CGI] Agent cgroups enabled: False Nov 24 00:20:51.235632 waagent[2196]: 2025-11-24T00:20:51.235595Z INFO ExtHandler ExtHandler Starting setup for Persistent firewall rules Nov 24 00:20:51.378711 waagent[2196]: 2025-11-24T00:20:51.378670Z INFO ExtHandler ExtHandler Firewalld service not running/unavailable, trying to set up waagent-network-setup.service Nov 24 00:20:51.378890 waagent[2196]: 2025-11-24T00:20:51.378848Z INFO ExtHandler ExtHandler Successfully updated the Binary file /var/lib/waagent/waagent-network-setup.py for firewall setup Nov 24 00:20:51.385353 waagent[2196]: 2025-11-24T00:20:51.385316Z INFO ExtHandler ExtHandler Service: waagent-network-setup.service not enabled. Adding it now Nov 24 00:20:51.391630 systemd[1]: Reload requested from client PID 2214 ('systemctl') (unit waagent.service)... Nov 24 00:20:51.391647 systemd[1]: Reloading... Nov 24 00:20:51.447013 zram_generator::config[2257]: No configuration found. Nov 24 00:20:51.704615 systemd[1]: Reloading finished in 312 ms. Nov 24 00:20:51.727348 waagent[2196]: 2025-11-24T00:20:51.727285Z INFO ExtHandler ExtHandler Successfully added and enabled the waagent-network-setup.service Nov 24 00:20:51.727459 waagent[2196]: 2025-11-24T00:20:51.727424Z INFO ExtHandler ExtHandler Persistent firewall rules setup successfully Nov 24 00:20:52.329575 waagent[2196]: 2025-11-24T00:20:52.329493Z INFO ExtHandler ExtHandler DROP rule is not available which implies no firewall rules are set yet. Environment thread will set it up. Nov 24 00:20:52.329926 waagent[2196]: 2025-11-24T00:20:52.329823Z 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] Nov 24 00:20:52.330634 waagent[2196]: 2025-11-24T00:20:52.330583Z INFO ExtHandler ExtHandler Starting env monitor service. Nov 24 00:20:52.331147 waagent[2196]: 2025-11-24T00:20:52.331106Z INFO ExtHandler ExtHandler Start SendTelemetryHandler service. Nov 24 00:20:52.331223 waagent[2196]: 2025-11-24T00:20:52.331176Z INFO MonitorHandler ExtHandler WireServer endpoint 168.63.129.16 read from file Nov 24 00:20:52.331656 waagent[2196]: 2025-11-24T00:20:52.331619Z INFO MonitorHandler ExtHandler Wire server endpoint:168.63.129.16 Nov 24 00:20:52.331717 waagent[2196]: 2025-11-24T00:20:52.331674Z INFO EnvHandler ExtHandler WireServer endpoint 168.63.129.16 read from file Nov 24 00:20:52.331824 waagent[2196]: 2025-11-24T00:20:52.331773Z INFO SendTelemetryHandler ExtHandler Successfully started the SendTelemetryHandler thread Nov 24 00:20:52.332113 waagent[2196]: 2025-11-24T00:20:52.331964Z INFO ExtHandler ExtHandler Start Extension Telemetry service. Nov 24 00:20:52.332374 waagent[2196]: 2025-11-24T00:20:52.332331Z INFO MonitorHandler ExtHandler Monitor.NetworkConfigurationChanges is disabled. Nov 24 00:20:52.332589 waagent[2196]: 2025-11-24T00:20:52.332545Z INFO EnvHandler ExtHandler Wire server endpoint:168.63.129.16 Nov 24 00:20:52.333002 waagent[2196]: 2025-11-24T00:20:52.332947Z INFO EnvHandler ExtHandler Configure routes Nov 24 00:20:52.333173 waagent[2196]: 2025-11-24T00:20:52.333121Z INFO TelemetryEventsCollector ExtHandler Extension Telemetry pipeline enabled: True Nov 24 00:20:52.333343 waagent[2196]: 2025-11-24T00:20:52.333304Z INFO ExtHandler ExtHandler Goal State Period: 6 sec. This indicates how often the agent checks for new goal states and reports status. Nov 24 00:20:52.333506 waagent[2196]: 2025-11-24T00:20:52.333471Z INFO EnvHandler ExtHandler Gateway:None Nov 24 00:20:52.333676 waagent[2196]: 2025-11-24T00:20:52.333635Z INFO TelemetryEventsCollector ExtHandler Successfully started the TelemetryEventsCollector thread Nov 24 00:20:52.333795 waagent[2196]: 2025-11-24T00:20:52.333755Z INFO MonitorHandler ExtHandler Routing table from /proc/net/route: Nov 24 00:20:52.333795 waagent[2196]: Iface Destination Gateway Flags RefCnt Use Metric Mask MTU Window IRTT Nov 24 00:20:52.333795 waagent[2196]: eth0 00000000 0100C80A 0003 0 0 1024 00000000 0 0 0 Nov 24 00:20:52.333795 waagent[2196]: eth0 0000C80A 00000000 0001 0 0 1024 00FFFFFF 0 0 0 Nov 24 00:20:52.333795 waagent[2196]: eth0 0100C80A 00000000 0005 0 0 1024 FFFFFFFF 0 0 0 Nov 24 00:20:52.333795 waagent[2196]: eth0 10813FA8 0100C80A 0007 0 0 1024 FFFFFFFF 0 0 0 Nov 24 00:20:52.333795 waagent[2196]: eth0 FEA9FEA9 0100C80A 0007 0 0 1024 FFFFFFFF 0 0 0 Nov 24 00:20:52.334723 waagent[2196]: 2025-11-24T00:20:52.334677Z INFO EnvHandler ExtHandler Routes:None Nov 24 00:20:52.339612 waagent[2196]: 2025-11-24T00:20:52.339562Z INFO ExtHandler ExtHandler Nov 24 00:20:52.339904 waagent[2196]: 2025-11-24T00:20:52.339864Z INFO ExtHandler ExtHandler ProcessExtensionsGoalState started [incarnation_1 channel: WireServer source: Fabric activity: bd24546a-ecdf-41ac-986e-87fe486a7543 correlation 5a03b9d1-8816-4ad8-8b92-9bd561e3734b created: 2025-11-24T00:18:59.723267Z] Nov 24 00:20:52.341036 waagent[2196]: 2025-11-24T00:20:52.340974Z INFO ExtHandler ExtHandler No extension handlers found, not processing anything. Nov 24 00:20:52.343547 waagent[2196]: 2025-11-24T00:20:52.343497Z INFO ExtHandler ExtHandler ProcessExtensionsGoalState completed [incarnation_1 3 ms] Nov 24 00:20:52.476896 waagent[2196]: 2025-11-24T00:20:52.476840Z 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 Nov 24 00:20:52.476896 waagent[2196]: Try `iptables -h' or 'iptables --help' for more information.) Nov 24 00:20:52.477367 waagent[2196]: 2025-11-24T00:20:52.477326Z INFO ExtHandler ExtHandler [HEARTBEAT] Agent WALinuxAgent-2.12.0.4 is running as the goal state agent [DEBUG HeartbeatCounter: 0;HeartbeatId: 06589524-B4BA-4B7B-A7BA-5F05239F8CB3;DroppedPackets: -1;UpdateGSErrors: 0;AutoUpdate: 0;UpdateMode: SelfUpdate;] Nov 24 00:20:52.524011 waagent[2196]: 2025-11-24T00:20:52.523926Z INFO MonitorHandler ExtHandler Network interfaces: Nov 24 00:20:52.524011 waagent[2196]: Executing ['ip', '-a', '-o', 'link']: Nov 24 00:20:52.524011 waagent[2196]: 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 Nov 24 00:20:52.524011 waagent[2196]: 2: eth0: mtu 1500 qdisc mq state UP mode DEFAULT group default qlen 1000\ link/ether 7c:1e:52:84:88:42 brd ff:ff:ff:ff:ff:ff Nov 24 00:20:52.524011 waagent[2196]: Executing ['ip', '-4', '-a', '-o', 'address']: Nov 24 00:20:52.524011 waagent[2196]: 1: lo inet 127.0.0.1/8 scope host lo\ valid_lft forever preferred_lft forever Nov 24 00:20:52.524011 waagent[2196]: 2: eth0 inet 10.200.0.13/24 metric 1024 brd 10.200.0.255 scope global eth0\ valid_lft forever preferred_lft forever Nov 24 00:20:52.524011 waagent[2196]: Executing ['ip', '-6', '-a', '-o', 'address']: Nov 24 00:20:52.524011 waagent[2196]: 1: lo inet6 ::1/128 scope host noprefixroute \ valid_lft forever preferred_lft forever Nov 24 00:20:52.524011 waagent[2196]: 2: eth0 inet6 fe80::7e1e:52ff:fe84:8842/64 scope link proto kernel_ll \ valid_lft forever preferred_lft forever Nov 24 00:20:52.650536 waagent[2196]: 2025-11-24T00:20:52.650438Z INFO EnvHandler ExtHandler Created firewall rules for the Azure Fabric: Nov 24 00:20:52.650536 waagent[2196]: Chain INPUT (policy ACCEPT 0 packets, 0 bytes) Nov 24 00:20:52.650536 waagent[2196]: pkts bytes target prot opt in out source destination Nov 24 00:20:52.650536 waagent[2196]: Chain FORWARD (policy ACCEPT 0 packets, 0 bytes) Nov 24 00:20:52.650536 waagent[2196]: pkts bytes target prot opt in out source destination Nov 24 00:20:52.650536 waagent[2196]: Chain OUTPUT (policy ACCEPT 43 packets, 2236 bytes) Nov 24 00:20:52.650536 waagent[2196]: pkts bytes target prot opt in out source destination Nov 24 00:20:52.650536 waagent[2196]: 0 0 ACCEPT tcp -- * * 0.0.0.0/0 168.63.129.16 tcp dpt:53 Nov 24 00:20:52.650536 waagent[2196]: 0 0 ACCEPT tcp -- * * 0.0.0.0/0 168.63.129.16 owner UID match 0 Nov 24 00:20:52.650536 waagent[2196]: 0 0 DROP tcp -- * * 0.0.0.0/0 168.63.129.16 ctstate INVALID,NEW Nov 24 00:20:52.654312 waagent[2196]: 2025-11-24T00:20:52.654262Z INFO EnvHandler ExtHandler Current Firewall rules: Nov 24 00:20:52.654312 waagent[2196]: Chain INPUT (policy ACCEPT 0 packets, 0 bytes) Nov 24 00:20:52.654312 waagent[2196]: pkts bytes target prot opt in out source destination Nov 24 00:20:52.654312 waagent[2196]: Chain FORWARD (policy ACCEPT 0 packets, 0 bytes) Nov 24 00:20:52.654312 waagent[2196]: pkts bytes target prot opt in out source destination Nov 24 00:20:52.654312 waagent[2196]: Chain OUTPUT (policy ACCEPT 62 packets, 3224 bytes) Nov 24 00:20:52.654312 waagent[2196]: pkts bytes target prot opt in out source destination Nov 24 00:20:52.654312 waagent[2196]: 0 0 ACCEPT tcp -- * * 0.0.0.0/0 168.63.129.16 tcp dpt:53 Nov 24 00:20:52.654312 waagent[2196]: 0 0 ACCEPT tcp -- * * 0.0.0.0/0 168.63.129.16 owner UID match 0 Nov 24 00:20:52.654312 waagent[2196]: 0 0 DROP tcp -- * * 0.0.0.0/0 168.63.129.16 ctstate INVALID,NEW Nov 24 00:20:52.654678 waagent[2196]: 2025-11-24T00:20:52.654521Z INFO EnvHandler ExtHandler Set block dev timeout: sdb with timeout: 300 Nov 24 00:20:52.654678 waagent[2196]: 2025-11-24T00:20:52.654662Z INFO EnvHandler ExtHandler Set block dev timeout: sda with timeout: 300 Nov 24 00:20:55.725110 update_engine[1880]: I20251124 00:20:55.725025 1880 update_attempter.cc:509] Updating boot flags... Nov 24 00:20:55.908576 setup-nvidia[2195]: \u000d 0 0 0 0 0 0 0 0 --:--:-- --:--:-- --:--:-- 0\u000d 0 325M 0 16144 0 0 20490 0 4:38:00 --:--:-- 4:38:00 20487\u000d 1 325M 1 6145k 0 0 3459k 0 0:01:36 0:00:01 0:01:35 3458k\u000d 5 325M 5 18.0M 0 0 6712k 0 0:00:49 0:00:02 0:00:47 6712k\u000d 10 325M 10 34.0M 0 0 9089k 0 0:00:36 0:00:03 0:00:33 9088k\u000d 14 325M 14 48.0M 0 0 10.0M 0 0:00:32 0:00:04 0:00:28 10.0M\u000d 18 325M 18 60.0M 0 0 10.3M 0 0:00:31 0:00:05 0:00:26 11.9M\u000d 22 325M 22 74.0M 0 0 10.8M 0 0:00:29 0:00:06 0:00:23 13.5M\u000d 27 325M 27 89.1M 0 0 11.5M 0 0:00:28 0:00:07 0:00:21 14.2M\u000d 31 325M 31 102M 0 0 11.6M 0 0:00:27 0:00:08 0:00:19 13.9M\u000d 36 325M 36 118M 0 0 12.0M 0 0:00:27 0:00:09 0:00:18 13.9M\u000d 39 325M 39 130M 0 0 12.1M 0 0:00:26 0:00:10 0:00:16 14.1M\u000d 44 325M 44 146M 0 0 12.3M 0 0:00:26 0:00:11 0:00:15 14.3M\u000d 49 325M 49 161M 0 0 12.7M 0 0:00:25 0:00:12 0:00:13 14.5M\u000d 54 325M 54 176M 0 0 12.8M 0 0:00:25 0:00:13 0:00:12 14.8M\u000d 58 325M 58 192M 0 0 12.9M 0 0:00:25 0:00:14 0:00:11 14.8M\u000d 63 325M 63 206M 0 0 13.0M 0 0:00:24 0:00:15 0:00:09 15.0M\u000d 67 325M 67 220M 0 0 13.1M 0 0:00:24 0:00:16 0:00:08 14.8M\u000d 72 325M 72 236M 0 0 13.2M 0 0:00:24 0:00:17 0:00:07 14.7M\u000d 74 325M 74 242M 0 0 12.7M 0 0:00:25 0:00:18 0:00:07 12.6M\u000d 80 325M 80 264M 0 0 13.3M 0 0:00:24 0:00:19 0:00:05 14.5M\u000d 85 325M 85 280M 0 0 13.4M 0 0:00:24 0:00:20 0:00:04 14.8M\u000d 90 325M 90 294M 0 0 13.4M 0 0:00:24 0:00:21 0:00:03 14.6M\u000d 94 325M 94 308M 0 0 13.5M 0 0:00:23 0:00:22 0:00:01 14.6M\u000d 99 325M 99 324M 0 0 13.6M 0 0:00:23 0:00:23 --:--:-- 16.9M\u000d100 325M 100 325M 0 0 13.7M 0 0:00:23 0:00:23 --:--:-- 15.3M Nov 24 00:20:57.070548 setup-nvidia[1871]: Extract the NVIDIA Driver Installer 535.261.03 Nov 24 00:20:57.070867 setup-nvidia[1871]: /opt/nvidia/workdir/nvidia-workdir / Nov 24 00:20:57.120216 setup-nvidia[2348]: Creating directory NVIDIA-Linux-x86_64-535.261.03 Nov 24 00:20:57.426482 setup-nvidia[2348]: Verifying archive integrity... OK Nov 24 00:21:05.874823 setup-nvidia[2348]: Uncompressing NVIDIA Accelerated Graphics Driver for Linux-x86_64 535.261.03 Nov 24 00:21:07.966771 setup-nvidia[2488]: ........................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................ Nov 24 00:21:15.145817 setup-nvidia[1871]: / Nov 24 00:21:15.145817 setup-nvidia[1871]: Spawn system-nspawn container to install the NVIDIA drivers Nov 24 00:21:15.312708 sudo[2495]: 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.1.2.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 Nov 24 00:21:15.314486 sudo[2495]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=0) Nov 24 00:21:15.319869 systemd[1]: Created slice user-0.slice - User Slice of UID 0. Nov 24 00:21:15.322449 systemd[1]: Starting user-runtime-dir@0.service - User Runtime Directory /run/user/0... Nov 24 00:21:15.343967 systemd[1]: Finished user-runtime-dir@0.service - User Runtime Directory /run/user/0. Nov 24 00:21:15.348073 systemd[1]: Starting user@0.service - User Manager for UID 0... Nov 24 00:21:15.374159 (systemd)[2498]: pam_unix(systemd-user:session): session opened for user root(uid=0) by (uid=0) Nov 24 00:21:15.376564 systemd-logind[1877]: New session c3 of user root. Nov 24 00:21:15.563857 systemd[2498]: Queued start job for default target default.target. Nov 24 00:21:15.584138 systemd[2498]: Created slice app.slice - User Application Slice. Nov 24 00:21:15.584168 systemd[2498]: Reached target paths.target - Paths. Nov 24 00:21:15.584215 systemd[2498]: Reached target timers.target - Timers. Nov 24 00:21:15.585325 systemd[2498]: Starting dbus.socket - D-Bus User Message Bus Socket... Nov 24 00:21:15.595911 systemd[2498]: Listening on dbus.socket - D-Bus User Message Bus Socket. Nov 24 00:21:15.595969 systemd[2498]: Reached target sockets.target - Sockets. Nov 24 00:21:15.596041 systemd[2498]: Reached target basic.target - Basic System. Nov 24 00:21:15.596088 systemd[2498]: Reached target default.target - Main User Target. Nov 24 00:21:15.596117 systemd[2498]: Startup finished in 213ms. Nov 24 00:21:15.596176 systemd[1]: Started user@0.service - User Manager for UID 0. Nov 24 00:21:15.600273 systemd[1]: Started session-c2.scope - Session c2 of User root. Nov 24 00:21:16.190014 kernel: loop6: detected capacity change from 0 to 12644352 Nov 24 00:21:16.302013 kernel: loop6: p9 Nov 24 00:21:16.358590 setup-nvidia[2507]: ░ Spawning container flatcardevelopercontainer-4459.1.2.bin on /opt/nvidia/workdir/flatcar_developer_container-4459.1.2.bin. Nov 24 00:21:16.397527 systemd[1]: Created slice system-sshd.slice - Slice /system/sshd. Nov 24 00:21:16.400347 systemd[1]: Started sshd@0-10.200.0.13:22-10.200.16.10:36144.service - OpenSSH per-connection server daemon (10.200.16.10:36144). Nov 24 00:21:17.809515 kernel: EXT4-fs (loop6p9): write access unavailable, skipping orphan cleanup Nov 24 00:21:17.809614 kernel: EXT4-fs (loop6p9): mounted filesystem 60190da1-d0f3-413a-a3e8-c35679f803bc ro without journal. Quota mode: none. Nov 24 00:21:17.878138 sshd[2512]: Accepted publickey for core from 10.200.16.10 port 36144 ssh2: RSA SHA256:ZsGZdPSMLsIMFvMfgveQ3HAPJ+x9oI8EZIYVEgGiY/o Nov 24 00:21:17.879301 sshd-session[2512]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Nov 24 00:21:17.883595 systemd-logind[1877]: New session 3 of user core. Nov 24 00:21:17.884571 systemd[1]: Started session-3.scope - Session 3 of User core. Nov 24 00:21:18.364656 systemd[1]: Started sshd@1-10.200.0.13:22-10.200.16.10:36150.service - OpenSSH per-connection server daemon (10.200.16.10:36150). Nov 24 00:21:18.937123 sshd[2520]: Accepted publickey for core from 10.200.16.10 port 36150 ssh2: RSA SHA256:ZsGZdPSMLsIMFvMfgveQ3HAPJ+x9oI8EZIYVEgGiY/o Nov 24 00:21:18.938380 sshd-session[2520]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Nov 24 00:21:18.942686 systemd-logind[1877]: New session 4 of user core. Nov 24 00:21:18.953109 systemd[1]: Started session-4.scope - Session 4 of User core. Nov 24 00:21:19.339665 sshd[2523]: Connection closed by 10.200.16.10 port 36150 Nov 24 00:21:19.340029 sshd-session[2520]: pam_unix(sshd:session): session closed for user core Nov 24 00:21:19.343596 systemd[1]: sshd@1-10.200.0.13:22-10.200.16.10:36150.service: Deactivated successfully. Nov 24 00:21:19.345244 systemd[1]: session-4.scope: Deactivated successfully. Nov 24 00:21:19.345919 systemd-logind[1877]: Session 4 logged out. Waiting for processes to exit. Nov 24 00:21:19.346896 systemd-logind[1877]: Removed session 4. Nov 24 00:21:19.443146 systemd[1]: Started sshd@2-10.200.0.13:22-10.200.16.10:36166.service - OpenSSH per-connection server daemon (10.200.16.10:36166). Nov 24 00:21:20.013898 sshd[2529]: Accepted publickey for core from 10.200.16.10 port 36166 ssh2: RSA SHA256:ZsGZdPSMLsIMFvMfgveQ3HAPJ+x9oI8EZIYVEgGiY/o Nov 24 00:21:20.015196 sshd-session[2529]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Nov 24 00:21:20.019426 systemd-logind[1877]: New session 5 of user core. Nov 24 00:21:20.029104 systemd[1]: Started session-5.scope - Session 5 of User core. Nov 24 00:21:20.407690 sshd[2532]: Connection closed by 10.200.16.10 port 36166 Nov 24 00:21:20.408060 sshd-session[2529]: pam_unix(sshd:session): session closed for user core Nov 24 00:21:20.411475 systemd[1]: sshd@2-10.200.0.13:22-10.200.16.10:36166.service: Deactivated successfully. Nov 24 00:21:20.413089 systemd[1]: session-5.scope: Deactivated successfully. Nov 24 00:21:20.413752 systemd-logind[1877]: Session 5 logged out. Waiting for processes to exit. Nov 24 00:21:20.414627 systemd-logind[1877]: Removed session 5. Nov 24 00:21:30.510348 systemd[1]: Started sshd@3-10.200.0.13:22-10.200.16.10:42838.service - OpenSSH per-connection server daemon (10.200.16.10:42838). Nov 24 00:21:31.081359 sshd[3524]: Accepted publickey for core from 10.200.16.10 port 42838 ssh2: RSA SHA256:ZsGZdPSMLsIMFvMfgveQ3HAPJ+x9oI8EZIYVEgGiY/o Nov 24 00:21:31.082689 sshd-session[3524]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Nov 24 00:21:31.086947 systemd-logind[1877]: New session 6 of user core. Nov 24 00:21:31.100160 systemd[1]: Started session-6.scope - Session 6 of User core. Nov 24 00:21:31.476338 sshd[3842]: Connection closed by 10.200.16.10 port 42838 Nov 24 00:21:31.476629 sshd-session[3524]: pam_unix(sshd:session): session closed for user core Nov 24 00:21:31.480089 systemd[1]: sshd@3-10.200.0.13:22-10.200.16.10:42838.service: Deactivated successfully. Nov 24 00:21:31.481744 systemd[1]: session-6.scope: Deactivated successfully. Nov 24 00:21:31.482565 systemd-logind[1877]: Session 6 logged out. Waiting for processes to exit. Nov 24 00:21:31.483532 systemd-logind[1877]: Removed session 6. Nov 24 00:21:31.579365 systemd[1]: Started sshd@4-10.200.0.13:22-10.200.16.10:42848.service - OpenSSH per-connection server daemon (10.200.16.10:42848). Nov 24 00:21:32.142752 sshd[4109]: Accepted publickey for core from 10.200.16.10 port 42848 ssh2: RSA SHA256:ZsGZdPSMLsIMFvMfgveQ3HAPJ+x9oI8EZIYVEgGiY/o Nov 24 00:21:32.144006 sshd-session[4109]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Nov 24 00:21:32.148301 systemd-logind[1877]: New session 7 of user core. Nov 24 00:21:32.158131 systemd[1]: Started session-7.scope - Session 7 of User core. Nov 24 00:21:32.536679 sshd[4444]: Connection closed by 10.200.16.10 port 42848 Nov 24 00:21:32.536961 sshd-session[4109]: pam_unix(sshd:session): session closed for user core Nov 24 00:21:32.540563 systemd[1]: sshd@4-10.200.0.13:22-10.200.16.10:42848.service: Deactivated successfully. Nov 24 00:21:32.542145 systemd[1]: session-7.scope: Deactivated successfully. Nov 24 00:21:32.542791 systemd-logind[1877]: Session 7 logged out. Waiting for processes to exit. Nov 24 00:21:32.543701 systemd-logind[1877]: Removed session 7. Nov 24 00:21:42.641126 systemd[1]: Started sshd@5-10.200.0.13:22-10.200.16.10:38882.service - OpenSSH per-connection server daemon (10.200.16.10:38882). Nov 24 00:21:43.959840 sshd[8814]: Accepted publickey for core from 10.200.16.10 port 38882 ssh2: RSA SHA256:ZsGZdPSMLsIMFvMfgveQ3HAPJ+x9oI8EZIYVEgGiY/o Nov 24 00:21:43.206106 sshd-session[8814]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Nov 24 00:21:43.210352 systemd-logind[1877]: New session 8 of user core. Nov 24 00:21:43.960429 sshd[8920]: Connection closed by 10.200.16.10 port 38882 Nov 24 00:21:43.608242 sshd-session[8814]: pam_unix(sshd:session): session closed for user core Nov 24 00:21:43.221109 systemd[1]: Started session-8.scope - Session 8 of User core. Nov 24 00:21:43.612205 systemd[1]: sshd@5-10.200.0.13:22-10.200.16.10:38882.service: Deactivated successfully. Nov 24 00:21:43.613769 systemd[1]: session-8.scope: Deactivated successfully. Nov 24 00:21:43.614502 systemd-logind[1877]: Session 8 logged out. Waiting for processes to exit. Nov 24 00:21:43.615478 systemd-logind[1877]: Removed session 8. Nov 24 00:21:43.709169 systemd[1]: Started sshd@6-10.200.0.13:22-10.200.16.10:38884.service - OpenSSH per-connection server daemon (10.200.16.10:38884). Nov 24 00:21:44.264868 sshd[8927]: Accepted publickey for core from 10.200.16.10 port 38884 ssh2: RSA SHA256:ZsGZdPSMLsIMFvMfgveQ3HAPJ+x9oI8EZIYVEgGiY/o Nov 24 00:21:44.268592 sshd-session[8927]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Nov 24 00:21:44.277206 systemd-logind[1877]: New session 9 of user core. Nov 24 00:21:44.286067 systemd[1]: Started session-9.scope - Session 9 of User core. Nov 24 00:21:44.662804 sshd[9036]: Connection closed by 10.200.16.10 port 38884 Nov 24 00:21:44.663648 sshd-session[8927]: pam_unix(sshd:session): session closed for user core Nov 24 00:21:44.667588 systemd-logind[1877]: Session 9 logged out. Waiting for processes to exit. Nov 24 00:21:44.669358 systemd[1]: sshd@6-10.200.0.13:22-10.200.16.10:38884.service: Deactivated successfully. Nov 24 00:21:44.672827 systemd[1]: session-9.scope: Deactivated successfully. Nov 24 00:21:44.676212 systemd-logind[1877]: Removed session 9. Nov 24 00:21:54.767961 systemd[1]: Started sshd@7-10.200.0.13:22-10.200.16.10:39968.service - OpenSSH per-connection server daemon (10.200.16.10:39968). Nov 24 00:21:57.754355 sshd[10262]: Accepted publickey for core from 10.200.16.10 port 39968 ssh2: RSA SHA256:ZsGZdPSMLsIMFvMfgveQ3HAPJ+x9oI8EZIYVEgGiY/o Nov 24 00:21:57.754535 sshd-session[10262]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Nov 24 00:21:57.760052 systemd-logind[1877]: New session 10 of user core. Nov 24 00:21:57.776158 systemd[1]: Started session-10.scope - Session 10 of User core. Nov 24 00:21:58.097158 sshd[10282]: Connection closed by 10.200.16.10 port 39968 Nov 24 00:21:58.097513 sshd-session[10262]: pam_unix(sshd:session): session closed for user core Nov 24 00:21:58.101013 systemd[1]: sshd@7-10.200.0.13:22-10.200.16.10:39968.service: Deactivated successfully. Nov 24 00:21:58.104160 systemd[1]: session-10.scope: Deactivated successfully. Nov 24 00:21:58.104969 systemd-logind[1877]: Session 10 logged out. Waiting for processes to exit. Nov 24 00:21:58.106218 systemd-logind[1877]: Removed session 10. Nov 24 00:21:58.205448 systemd[1]: Started sshd@8-10.200.0.13:22-10.200.16.10:39974.service - OpenSSH per-connection server daemon (10.200.16.10:39974). Nov 24 00:22:01.058169 sshd[10462]: Accepted publickey for core from 10.200.16.10 port 39974 ssh2: RSA SHA256:ZsGZdPSMLsIMFvMfgveQ3HAPJ+x9oI8EZIYVEgGiY/o Nov 24 00:22:01.058539 sshd-session[10462]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Nov 24 00:22:01.063263 systemd-logind[1877]: New session 11 of user core. Nov 24 00:22:01.074136 systemd[1]: Started session-11.scope - Session 11 of User core. Nov 24 00:22:01.385887 sshd[10480]: Connection closed by 10.200.16.10 port 39974 Nov 24 00:22:01.386306 sshd-session[10462]: pam_unix(sshd:session): session closed for user core Nov 24 00:22:01.390158 systemd[1]: sshd@8-10.200.0.13:22-10.200.16.10:39974.service: Deactivated successfully. Nov 24 00:22:01.391758 systemd[1]: session-11.scope: Deactivated successfully. Nov 24 00:22:01.392465 systemd-logind[1877]: Session 11 logged out. Waiting for processes to exit. Nov 24 00:22:01.393695 systemd-logind[1877]: Removed session 11. Nov 24 00:22:11.490216 systemd[1]: Started sshd@9-10.200.0.13:22-10.200.16.10:39294.service - OpenSSH per-connection server daemon (10.200.16.10:39294). Nov 24 00:22:12.074070 sshd[14017]: Accepted publickey for core from 10.200.16.10 port 39294 ssh2: RSA SHA256:ZsGZdPSMLsIMFvMfgveQ3HAPJ+x9oI8EZIYVEgGiY/o Nov 24 00:22:12.075483 sshd-session[14017]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Nov 24 00:22:12.081653 systemd-logind[1877]: New session 12 of user core. Nov 24 00:22:12.094087 systemd[1]: Started session-12.scope - Session 12 of User core. Nov 24 00:22:12.470343 sshd[14032]: Connection closed by 10.200.16.10 port 39294 Nov 24 00:22:12.473176 sshd-session[14017]: pam_unix(sshd:session): session closed for user core Nov 24 00:22:12.477923 systemd-logind[1877]: Session 12 logged out. Waiting for processes to exit. Nov 24 00:22:12.479741 systemd[1]: sshd@9-10.200.0.13:22-10.200.16.10:39294.service: Deactivated successfully. Nov 24 00:22:12.483153 systemd[1]: session-12.scope: Deactivated successfully. Nov 24 00:22:12.485729 systemd-logind[1877]: Removed session 12. Nov 24 00:22:12.572128 systemd[1]: Started sshd@10-10.200.0.13:22-10.200.16.10:39304.service - OpenSSH per-connection server daemon (10.200.16.10:39304). Nov 24 00:22:13.142167 sshd[14057]: Accepted publickey for core from 10.200.16.10 port 39304 ssh2: RSA SHA256:ZsGZdPSMLsIMFvMfgveQ3HAPJ+x9oI8EZIYVEgGiY/o Nov 24 00:22:13.146524 sshd-session[14057]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Nov 24 00:22:13.156574 systemd-logind[1877]: New session 13 of user core. Nov 24 00:22:13.166069 systemd[1]: Started session-13.scope - Session 13 of User core. Nov 24 00:22:13.552343 sshd[14077]: Connection closed by 10.200.16.10 port 39304 Nov 24 00:22:13.554140 sshd-session[14057]: pam_unix(sshd:session): session closed for user core Nov 24 00:22:13.557616 systemd[1]: sshd@10-10.200.0.13:22-10.200.16.10:39304.service: Deactivated successfully. Nov 24 00:22:13.559706 systemd[1]: session-13.scope: Deactivated successfully. Nov 24 00:22:13.561176 systemd-logind[1877]: Session 13 logged out. Waiting for processes to exit. Nov 24 00:22:13.565689 systemd-logind[1877]: Removed session 13. Nov 24 00:22:23.658224 systemd[1]: Started sshd@11-10.200.0.13:22-10.200.16.10:47834.service - OpenSSH per-connection server daemon (10.200.16.10:47834). Nov 24 00:22:24.231323 sshd[14511]: Accepted publickey for core from 10.200.16.10 port 47834 ssh2: RSA SHA256:ZsGZdPSMLsIMFvMfgveQ3HAPJ+x9oI8EZIYVEgGiY/o Nov 24 00:22:24.231871 sshd-session[14511]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Nov 24 00:22:24.239602 systemd-logind[1877]: New session 14 of user core. Nov 24 00:22:24.246134 systemd[1]: Started session-14.scope - Session 14 of User core. Nov 24 00:22:24.627454 sshd[14524]: Connection closed by 10.200.16.10 port 47834 Nov 24 00:22:24.627829 sshd-session[14511]: pam_unix(sshd:session): session closed for user core Nov 24 00:22:24.631245 systemd-logind[1877]: Session 14 logged out. Waiting for processes to exit. Nov 24 00:22:24.632617 systemd[1]: sshd@11-10.200.0.13:22-10.200.16.10:47834.service: Deactivated successfully. Nov 24 00:22:24.634145 systemd[1]: session-14.scope: Deactivated successfully. Nov 24 00:22:24.637209 systemd-logind[1877]: Removed session 14. Nov 24 00:22:24.728401 systemd[1]: Started sshd@12-10.200.0.13:22-10.200.16.10:47846.service - OpenSSH per-connection server daemon (10.200.16.10:47846). Nov 24 00:22:25.320212 sshd[14542]: Accepted publickey for core from 10.200.16.10 port 47846 ssh2: RSA SHA256:ZsGZdPSMLsIMFvMfgveQ3HAPJ+x9oI8EZIYVEgGiY/o Nov 24 00:22:25.322043 sshd-session[14542]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Nov 24 00:22:25.330027 systemd-logind[1877]: New session 15 of user core. Nov 24 00:22:25.339071 systemd[1]: Started session-15.scope - Session 15 of User core. Nov 24 00:22:25.726198 sshd[14563]: Connection closed by 10.200.16.10 port 47846 Nov 24 00:22:25.726939 sshd-session[14542]: pam_unix(sshd:session): session closed for user core Nov 24 00:22:25.730497 systemd-logind[1877]: Session 15 logged out. Waiting for processes to exit. Nov 24 00:22:25.731283 systemd[1]: sshd@12-10.200.0.13:22-10.200.16.10:47846.service: Deactivated successfully. Nov 24 00:22:25.732908 systemd[1]: session-15.scope: Deactivated successfully. Nov 24 00:22:25.737489 systemd-logind[1877]: Removed session 15. Nov 24 00:22:27.833678 waagent[2196]: 2025-11-24T00:22:27.832897Z INFO ExtHandler Fetched a new incarnation for the WireServer goal state [incarnation 2] Nov 24 00:22:27.843269 waagent[2196]: 2025-11-24T00:22:27.843191Z INFO ExtHandler Nov 24 00:22:27.843482 waagent[2196]: 2025-11-24T00:22:27.843450Z INFO ExtHandler Fetching full goal state from the WireServer [incarnation 2] Nov 24 00:22:27.905634 waagent[2196]: 2025-11-24T00:22:27.905589Z INFO ExtHandler ExtHandler Downloading artifacts profile blob Nov 24 00:22:27.979003 waagent[2196]: 2025-11-24T00:22:27.977756Z INFO ExtHandler Downloaded certificate {'thumbprint': '8F907D341136EA788E92A5AAA0116CB4D32B5945', 'hasPrivateKey': True} Nov 24 00:22:27.979003 waagent[2196]: 2025-11-24T00:22:27.978347Z INFO ExtHandler Fetch goal state completed Nov 24 00:22:27.979003 waagent[2196]: 2025-11-24T00:22:27.978733Z INFO ExtHandler ExtHandler Nov 24 00:22:27.979003 waagent[2196]: 2025-11-24T00:22:27.978805Z INFO ExtHandler ExtHandler ProcessExtensionsGoalState started [incarnation_2 channel: WireServer source: Fabric activity: 35320b2b-9d50-4e56-908a-2a2280c92309 correlation 5a03b9d1-8816-4ad8-8b92-9bd561e3734b created: 2025-11-24T00:22:20.863976Z] Nov 24 00:22:27.979417 waagent[2196]: 2025-11-24T00:22:27.979379Z INFO ExtHandler ExtHandler No extension handlers found, not processing anything. Nov 24 00:22:27.982050 waagent[2196]: 2025-11-24T00:22:27.982001Z INFO ExtHandler ExtHandler ProcessExtensionsGoalState completed [incarnation_2 1 ms] Nov 24 00:22:34.007725 waagent[2196]: 2025-11-24T00:22:34.007671Z INFO ExtHandler Nov 24 00:22:34.008318 waagent[2196]: 2025-11-24T00:22:34.008283Z INFO ExtHandler Fetched new vmSettings [HostGAPlugin correlation ID: 9b84d194-4be0-4a0d-8259-f4d27178270c eTag: 10605860603438007020 source: Fabric] Nov 24 00:22:34.008793 waagent[2196]: 2025-11-24T00:22:34.008757Z INFO ExtHandler The vmSettings originated via Fabric; will ignore them. Nov 24 00:22:35.832212 systemd[1]: Started sshd@13-10.200.0.13:22-10.200.16.10:60984.service - OpenSSH per-connection server daemon (10.200.16.10:60984). Nov 24 00:22:36.415586 sshd[14922]: Accepted publickey for core from 10.200.16.10 port 60984 ssh2: RSA SHA256:ZsGZdPSMLsIMFvMfgveQ3HAPJ+x9oI8EZIYVEgGiY/o Nov 24 00:22:36.417337 sshd-session[14922]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Nov 24 00:22:36.423620 systemd-logind[1877]: New session 16 of user core. Nov 24 00:22:36.428633 systemd[1]: Started session-16.scope - Session 16 of User core. Nov 24 00:22:36.814711 sshd[14932]: Connection closed by 10.200.16.10 port 60984 Nov 24 00:22:36.815504 sshd-session[14922]: pam_unix(sshd:session): session closed for user core Nov 24 00:22:36.819944 systemd-logind[1877]: Session 16 logged out. Waiting for processes to exit. Nov 24 00:22:36.820745 systemd[1]: sshd@13-10.200.0.13:22-10.200.16.10:60984.service: Deactivated successfully. Nov 24 00:22:36.822423 systemd[1]: session-16.scope: Deactivated successfully. Nov 24 00:22:36.826501 systemd-logind[1877]: Removed session 16. Nov 24 00:22:36.918777 systemd[1]: Started sshd@14-10.200.0.13:22-10.200.16.10:60992.service - OpenSSH per-connection server daemon (10.200.16.10:60992). Nov 24 00:22:37.496116 sshd[14950]: Accepted publickey for core from 10.200.16.10 port 60992 ssh2: RSA SHA256:ZsGZdPSMLsIMFvMfgveQ3HAPJ+x9oI8EZIYVEgGiY/o Nov 24 00:22:37.500431 sshd-session[14950]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Nov 24 00:22:37.506495 systemd-logind[1877]: New session 17 of user core. Nov 24 00:22:37.511627 systemd[1]: Started session-17.scope - Session 17 of User core. Nov 24 00:22:37.897450 sshd[14966]: Connection closed by 10.200.16.10 port 60992 Nov 24 00:22:37.898279 sshd-session[14950]: pam_unix(sshd:session): session closed for user core Nov 24 00:22:37.902737 systemd-logind[1877]: Session 17 logged out. Waiting for processes to exit. Nov 24 00:22:37.904168 systemd[1]: sshd@14-10.200.0.13:22-10.200.16.10:60992.service: Deactivated successfully. Nov 24 00:22:37.905972 systemd[1]: session-17.scope: Deactivated successfully. Nov 24 00:22:37.909846 systemd-logind[1877]: Removed session 17. Nov 24 00:22:48.008528 systemd[1]: Started sshd@15-10.200.0.13:22-10.200.16.10:45302.service - OpenSSH per-connection server daemon (10.200.16.10:45302). Nov 24 00:22:48.584627 sshd[15183]: Accepted publickey for core from 10.200.16.10 port 45302 ssh2: RSA SHA256:ZsGZdPSMLsIMFvMfgveQ3HAPJ+x9oI8EZIYVEgGiY/o Nov 24 00:22:48.585909 sshd-session[15183]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Nov 24 00:22:48.590324 systemd-logind[1877]: New session 18 of user core. Nov 24 00:22:48.600112 systemd[1]: Started session-18.scope - Session 18 of User core. Nov 24 00:22:48.987271 sshd[15194]: Connection closed by 10.200.16.10 port 45302 Nov 24 00:22:48.987589 sshd-session[15183]: pam_unix(sshd:session): session closed for user core Nov 24 00:22:48.991112 systemd[1]: sshd@15-10.200.0.13:22-10.200.16.10:45302.service: Deactivated successfully. Nov 24 00:22:48.992920 systemd[1]: session-18.scope: Deactivated successfully. Nov 24 00:22:48.993760 systemd-logind[1877]: Session 18 logged out. Waiting for processes to exit. Nov 24 00:22:48.994681 systemd-logind[1877]: Removed session 18. Nov 24 00:22:49.090178 systemd[1]: Started sshd@16-10.200.0.13:22-10.200.16.10:45314.service - OpenSSH per-connection server daemon (10.200.16.10:45314). Nov 24 00:22:49.642687 sshd[15224]: Accepted publickey for core from 10.200.16.10 port 45314 ssh2: RSA SHA256:ZsGZdPSMLsIMFvMfgveQ3HAPJ+x9oI8EZIYVEgGiY/o Nov 24 00:22:49.643927 sshd-session[15224]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Nov 24 00:22:49.648097 systemd-logind[1877]: New session 19 of user core. Nov 24 00:22:49.663092 systemd[1]: Started session-19.scope - Session 19 of User core. Nov 24 00:22:50.051595 sshd[15227]: Connection closed by 10.200.16.10 port 45314 Nov 24 00:22:50.052167 sshd-session[15224]: pam_unix(sshd:session): session closed for user core Nov 24 00:22:50.062025 systemd-logind[1877]: Session 19 logged out. Waiting for processes to exit. Nov 24 00:22:50.063466 systemd[1]: sshd@16-10.200.0.13:22-10.200.16.10:45314.service: Deactivated successfully. Nov 24 00:22:50.068718 systemd[1]: session-19.scope: Deactivated successfully. Nov 24 00:22:50.070500 systemd-logind[1877]: Removed session 19. Nov 24 00:22:50.905507 setup-nvidia[2507]: \u000d Nov 24 00:22:50.905507 setup-nvidia[2507]: ERROR: Unable to load the kernel module 'nvidia.ko'. This happens most Nov 24 00:22:50.905507 setup-nvidia[2507]: frequently when this kernel module was built against the wrong or Nov 24 00:22:50.905507 setup-nvidia[2507]: improperly configured kernel sources, with a version of gcc that differs Nov 24 00:22:50.905507 setup-nvidia[2507]: from the one used to build the target kernel, or if another driver, such Nov 24 00:22:50.905507 setup-nvidia[2507]: as nouveau, is present and prevents the NVIDIA kernel module from Nov 24 00:22:50.905507 setup-nvidia[2507]: obtaining ownership of the NVIDIA device(s), or no NVIDIA device Nov 24 00:22:50.905507 setup-nvidia[2507]: installed in this system is supported by this NVIDIA Linux graphics Nov 24 00:22:50.905507 setup-nvidia[2507]: driver release. Nov 24 00:22:50.905507 setup-nvidia[2507]: \u000d Nov 24 00:22:50.905507 setup-nvidia[2507]: Please see the log entries 'Kernel module load error' and 'Kernel Nov 24 00:22:50.905507 setup-nvidia[2507]: messages' at the end of the file Nov 24 00:22:50.905507 setup-nvidia[2507]: '/nvidia/NVIDIA-Linux-x86_64-535.261.03/nvidia-installer.log' for more Nov 24 00:22:50.905507 setup-nvidia[2507]: information. Nov 24 00:22:50.905507 setup-nvidia[2507]: \u000d Nov 24 00:22:50.920076 setup-nvidia[2507]: dmesg: read kernel buffer failed: Operation not permitted Nov 24 00:22:50.938804 setup-nvidia[2507]: \u000d Nov 24 00:22:50.938804 setup-nvidia[2507]: ERROR: Installation has failed. Please see the file Nov 24 00:22:50.938804 setup-nvidia[2507]: '/nvidia/NVIDIA-Linux-x86_64-535.261.03/nvidia-installer.log' for Nov 24 00:22:50.938804 setup-nvidia[2507]: details. You may find suggestions on fixing installation problems in Nov 24 00:22:50.938804 setup-nvidia[2507]: the README available on the Linux driver download page at Nov 24 00:22:50.938804 setup-nvidia[2507]: www.nvidia.com. Nov 24 00:22:50.938804 setup-nvidia[2507]: \u000d Nov 24 00:22:50.939206 setup-nvidia[2507]: Last 50 lines of nvidia-installer.log: Nov 24 00:22:50.939985 setup-nvidia[2507]: /nvidia/NVIDIA-Linux-x86_64-535.261.03/kernel/nvidia.o: warning: objtool: _nv039059rm+0x53: 'naked' return found in MITIGATION_RETHUNK build Nov 24 00:22:50.939985 setup-nvidia[2507]: /nvidia/NVIDIA-Linux-x86_64-535.261.03/kernel/nvidia.o: warning: objtool: _nv039056rm+0x90: 'naked' return found in MITIGATION_RETHUNK build Nov 24 00:22:50.939985 setup-nvidia[2507]: /nvidia/NVIDIA-Linux-x86_64-535.261.03/kernel/nvidia.o: warning: objtool: _nv039049rm+0x2b: 'naked' return found in MITIGATION_RETHUNK build Nov 24 00:22:50.939985 setup-nvidia[2507]: /nvidia/NVIDIA-Linux-x86_64-535.261.03/kernel/nvidia.o: warning: objtool: _nv039105rm+0x93: 'naked' return found in MITIGATION_RETHUNK build Nov 24 00:22:50.939985 setup-nvidia[2507]: /nvidia/NVIDIA-Linux-x86_64-535.261.03/kernel/nvidia.o: warning: objtool: _nv039101rm+0x36: 'naked' return found in MITIGATION_RETHUNK build Nov 24 00:22:50.939985 setup-nvidia[2507]: /nvidia/NVIDIA-Linux-x86_64-535.261.03/kernel/nvidia.o: warning: objtool: _nv039100rm+0x9d: 'naked' return found in MITIGATION_RETHUNK build Nov 24 00:22:50.939985 setup-nvidia[2507]: /nvidia/NVIDIA-Linux-x86_64-535.261.03/kernel/nvidia.o: warning: objtool: _nv039102rm+0x77: 'naked' return found in MITIGATION_RETHUNK build Nov 24 00:22:50.939985 setup-nvidia[2507]: /nvidia/NVIDIA-Linux-x86_64-535.261.03/kernel/nvidia.o: warning: objtool: _nv039046rm+0x7f: 'naked' return found in MITIGATION_RETHUNK build Nov 24 00:22:50.939985 setup-nvidia[2507]: /nvidia/NVIDIA-Linux-x86_64-535.261.03/kernel/nvidia.o: warning: objtool: _nv030615rm+0x3e: 'naked' return found in MITIGATION_RETHUNK build Nov 24 00:22:50.939985 setup-nvidia[2507]: /nvidia/NVIDIA-Linux-x86_64-535.261.03/kernel/nvidia.o: warning: objtool: _nv030614rm+0x27: 'naked' return found in MITIGATION_RETHUNK build Nov 24 00:22:50.940231 setup-nvidia[2507]: /nvidia/NVIDIA-Linux-x86_64-535.261.03/kernel/nvidia.o: warning: objtool: _nv030618rm+0x37: 'naked' return found in MITIGATION_RETHUNK build Nov 24 00:22:50.940231 setup-nvidia[2507]: /nvidia/NVIDIA-Linux-x86_64-535.261.03/kernel/nvidia.o: warning: objtool: _nv030617rm+0x24: 'naked' return found in MITIGATION_RETHUNK build Nov 24 00:22:50.940231 setup-nvidia[2507]: /nvidia/NVIDIA-Linux-x86_64-535.261.03/kernel/nvidia.o: warning: objtool: _nv030616rm+0xca: 'naked' return found in MITIGATION_RETHUNK build Nov 24 00:22:50.940231 setup-nvidia[2507]: /nvidia/NVIDIA-Linux-x86_64-535.261.03/kernel/nvidia.o: warning: objtool: _nv030619rm+0x193: 'naked' return found in MITIGATION_RETHUNK build Nov 24 00:22:50.940231 setup-nvidia[2507]: /nvidia/NVIDIA-Linux-x86_64-535.261.03/kernel/nvidia.o: warning: objtool: _nv030621rm+0x17f: 'naked' return found in MITIGATION_RETHUNK build Nov 24 00:22:50.940231 setup-nvidia[2507]: /nvidia/NVIDIA-Linux-x86_64-535.261.03/kernel/nvidia.o: warning: objtool: _nv011864rm+0x5d: 'naked' return found in MITIGATION_RETHUNK build Nov 24 00:22:50.940231 setup-nvidia[2507]: /nvidia/NVIDIA-Linux-x86_64-535.261.03/kernel/nvidia.o: warning: objtool: _nv039413rm+0x12f: 'naked' return found in MITIGATION_RETHUNK build Nov 24 00:22:50.940231 setup-nvidia[2507]: MODPOST /nvidia/NVIDIA-Linux-x86_64-535.261.03/kernel/Module.symvers Nov 24 00:22:50.940231 setup-nvidia[2507]: CC [M] /nvidia/NVIDIA-Linux-x86_64-535.261.03/kernel/nvidia.mod.o Nov 24 00:22:50.940231 setup-nvidia[2507]: CC [M] /nvidia/NVIDIA-Linux-x86_64-535.261.03/kernel/.module-common.o Nov 24 00:22:50.940231 setup-nvidia[2507]: CC [M] /nvidia/NVIDIA-Linux-x86_64-535.261.03/kernel/nvidia-uvm.mod.o Nov 24 00:22:50.940231 setup-nvidia[2507]: CC [M] /nvidia/NVIDIA-Linux-x86_64-535.261.03/kernel/nvidia-modeset.mod.o Nov 24 00:22:50.940231 setup-nvidia[2507]: CC [M] /nvidia/NVIDIA-Linux-x86_64-535.261.03/kernel/nvidia-drm.mod.o Nov 24 00:22:50.940231 setup-nvidia[2507]: CC [M] /nvidia/NVIDIA-Linux-x86_64-535.261.03/kernel/nvidia-peermem.mod.o Nov 24 00:22:50.940231 setup-nvidia[2507]: LD [M] /nvidia/NVIDIA-Linux-x86_64-535.261.03/kernel/nvidia.ko Nov 24 00:22:50.940231 setup-nvidia[2507]: LD [M] /nvidia/NVIDIA-Linux-x86_64-535.261.03/kernel/nvidia-modeset.ko Nov 24 00:22:50.940231 setup-nvidia[2507]: LD [M] /nvidia/NVIDIA-Linux-x86_64-535.261.03/kernel/nvidia-uvm.ko Nov 24 00:22:50.940231 setup-nvidia[2507]: LD [M] /nvidia/NVIDIA-Linux-x86_64-535.261.03/kernel/nvidia-peermem.ko Nov 24 00:22:50.940231 setup-nvidia[2507]: LD [M] /nvidia/NVIDIA-Linux-x86_64-535.261.03/kernel/nvidia-drm.ko Nov 24 00:22:50.940231 setup-nvidia[2507]: BTF [M] /nvidia/NVIDIA-Linux-x86_64-535.261.03/kernel/nvidia-peermem.ko Nov 24 00:22:50.940231 setup-nvidia[2507]: Skipping BTF generation for /nvidia/NVIDIA-Linux-x86_64-535.261.03/kernel/nvidia-peermem.ko due to unavailability of vmlinux Nov 24 00:22:50.940231 setup-nvidia[2507]: BTF [M] /nvidia/NVIDIA-Linux-x86_64-535.261.03/kernel/nvidia-modeset.ko Nov 24 00:22:50.940231 setup-nvidia[2507]: Skipping BTF generation for /nvidia/NVIDIA-Linux-x86_64-535.261.03/kernel/nvidia-modeset.ko due to unavailability of vmlinux Nov 24 00:22:50.940231 setup-nvidia[2507]: BTF [M] /nvidia/NVIDIA-Linux-x86_64-535.261.03/kernel/nvidia-drm.ko Nov 24 00:22:50.940231 setup-nvidia[2507]: Skipping BTF generation for /nvidia/NVIDIA-Linux-x86_64-535.261.03/kernel/nvidia-drm.ko due to unavailability of vmlinux Nov 24 00:22:50.940231 setup-nvidia[2507]: BTF [M] /nvidia/NVIDIA-Linux-x86_64-535.261.03/kernel/nvidia-uvm.ko Nov 24 00:22:50.940231 setup-nvidia[2507]: Skipping BTF generation for /nvidia/NVIDIA-Linux-x86_64-535.261.03/kernel/nvidia-uvm.ko due to unavailability of vmlinux Nov 24 00:22:50.940231 setup-nvidia[2507]: BTF [M] /nvidia/NVIDIA-Linux-x86_64-535.261.03/kernel/nvidia.ko Nov 24 00:22:50.940231 setup-nvidia[2507]: Skipping BTF generation for /nvidia/NVIDIA-Linux-x86_64-535.261.03/kernel/nvidia.ko due to unavailability of vmlinux Nov 24 00:22:50.940231 setup-nvidia[2507]: make[2]: Leaving directory '/usr/lib/modules/6.12.58-flatcar/build' Nov 24 00:22:50.940231 setup-nvidia[2507]: make[1]: Leaving directory '/usr/lib/modules/6.12.58-flatcar/source' Nov 24 00:22:50.940231 setup-nvidia[2507]: -> done. Nov 24 00:22:50.940231 setup-nvidia[2507]: -> Kernel module compilation complete. Nov 24 00:22:50.940231 setup-nvidia[2507]: -> Unable to determine if Secure Boot is enabled: No such file or directory Nov 24 00:22:50.940231 setup-nvidia[2507]: 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. Nov 24 00:22:50.940231 setup-nvidia[2507]: \u000d Nov 24 00:22:50.940231 setup-nvidia[2507]: 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. Nov 24 00:22:50.940231 setup-nvidia[2507]: -> Kernel module load error: Operation not permitted Nov 24 00:22:50.940231 setup-nvidia[2507]: -> Kernel messages: Nov 24 00:22:50.940231 setup-nvidia[2507]: 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. Nov 24 00:22:55.724797 update_engine[1880]: I20251124 00:22:55.724735 1880 prefs.cc:52] certificate-report-to-send-update not present in /var/lib/update_engine/prefs Nov 24 00:22:55.724797 update_engine[1880]: I20251124 00:22:55.724788 1880 prefs.cc:52] certificate-report-to-send-download not present in /var/lib/update_engine/prefs Nov 24 00:22:55.725283 update_engine[1880]: I20251124 00:22:55.724947 1880 prefs.cc:52] aleph-version not present in /var/lib/update_engine/prefs Nov 24 00:22:55.725444 update_engine[1880]: I20251124 00:22:55.725415 1880 omaha_request_params.cc:62] Current group set to beta Nov 24 00:22:55.725549 update_engine[1880]: I20251124 00:22:55.725521 1880 update_attempter.cc:499] Already updated boot flags. Skipping. Nov 24 00:22:55.725549 update_engine[1880]: I20251124 00:22:55.725538 1880 update_attempter.cc:643] Scheduling an action processor start. Nov 24 00:22:55.725641 update_engine[1880]: I20251124 00:22:55.725553 1880 action_processor.cc:36] ActionProcessor::StartProcessing: OmahaRequestAction Nov 24 00:22:55.725641 update_engine[1880]: I20251124 00:22:55.725584 1880 prefs.cc:52] previous-version not present in /var/lib/update_engine/prefs Nov 24 00:22:55.725698 update_engine[1880]: I20251124 00:22:55.725646 1880 omaha_request_action.cc:271] Posting an Omaha request to disabled Nov 24 00:22:55.725698 update_engine[1880]: I20251124 00:22:55.725656 1880 omaha_request_action.cc:272] Request: Nov 24 00:22:55.725698 update_engine[1880]: Nov 24 00:22:55.725698 update_engine[1880]: Nov 24 00:22:55.725698 update_engine[1880]: Nov 24 00:22:55.725698 update_engine[1880]: Nov 24 00:22:55.725698 update_engine[1880]: Nov 24 00:22:55.725698 update_engine[1880]: Nov 24 00:22:55.725698 update_engine[1880]: Nov 24 00:22:55.725698 update_engine[1880]: Nov 24 00:22:55.725698 update_engine[1880]: I20251124 00:22:55.725664 1880 libcurl_http_fetcher.cc:47] Starting/Resuming transfer Nov 24 00:22:55.725931 locksmithd[1992]: LastCheckedTime=0 Progress=0 CurrentOperation="UPDATE_STATUS_CHECKING_FOR_UPDATE" NewVersion=0.0.0 NewSize=0 Nov 24 00:22:55.726727 update_engine[1880]: I20251124 00:22:55.726693 1880 libcurl_http_fetcher.cc:151] Setting up curl options for HTTP Nov 24 00:22:55.727279 update_engine[1880]: I20251124 00:22:55.727244 1880 libcurl_http_fetcher.cc:449] Setting up timeout source: 1 seconds. Nov 24 00:22:55.754194 update_engine[1880]: E20251124 00:22:55.754156 1880 libcurl_http_fetcher.cc:266] Unable to get http response code: Could not resolve host: disabled Nov 24 00:22:55.754243 update_engine[1880]: I20251124 00:22:55.754228 1880 libcurl_http_fetcher.cc:283] No HTTP response, retry 1 Nov 24 00:23:00.155320 systemd[1]: Started sshd@17-10.200.0.13:22-10.200.16.10:48352.service - OpenSSH per-connection server daemon (10.200.16.10:48352). Nov 24 00:23:00.724117 sshd[15381]: Accepted publickey for core from 10.200.16.10 port 48352 ssh2: RSA SHA256:ZsGZdPSMLsIMFvMfgveQ3HAPJ+x9oI8EZIYVEgGiY/o Nov 24 00:23:00.725346 sshd-session[15381]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Nov 24 00:23:00.729570 systemd-logind[1877]: New session 20 of user core. Nov 24 00:23:00.738108 systemd[1]: Started session-20.scope - Session 20 of User core. Nov 24 00:23:01.126679 sshd[15384]: Connection closed by 10.200.16.10 port 48352 Nov 24 00:23:01.127006 sshd-session[15381]: pam_unix(sshd:session): session closed for user core Nov 24 00:23:01.130320 systemd[1]: sshd@17-10.200.0.13:22-10.200.16.10:48352.service: Deactivated successfully. Nov 24 00:23:01.131923 systemd[1]: session-20.scope: Deactivated successfully. Nov 24 00:23:01.132670 systemd-logind[1877]: Session 20 logged out. Waiting for processes to exit. Nov 24 00:23:01.133552 systemd-logind[1877]: Removed session 20. Nov 24 00:23:01.235156 systemd[1]: Started sshd@18-10.200.0.13:22-10.200.16.10:48362.service - OpenSSH per-connection server daemon (10.200.16.10:48362). Nov 24 00:23:01.813099 sshd[15390]: Accepted publickey for core from 10.200.16.10 port 48362 ssh2: RSA SHA256:ZsGZdPSMLsIMFvMfgveQ3HAPJ+x9oI8EZIYVEgGiY/o Nov 24 00:23:01.814344 sshd-session[15390]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Nov 24 00:23:01.818478 systemd-logind[1877]: New session 21 of user core. Nov 24 00:23:01.829093 systemd[1]: Started session-21.scope - Session 21 of User core. Nov 24 00:23:02.214569 sshd[15393]: Connection closed by 10.200.16.10 port 48362 Nov 24 00:23:02.214871 sshd-session[15390]: pam_unix(sshd:session): session closed for user core Nov 24 00:23:02.218413 systemd[1]: sshd@18-10.200.0.13:22-10.200.16.10:48362.service: Deactivated successfully. Nov 24 00:23:02.220002 systemd[1]: session-21.scope: Deactivated successfully. Nov 24 00:23:02.220668 systemd-logind[1877]: Session 21 logged out. Waiting for processes to exit. Nov 24 00:23:02.221554 systemd-logind[1877]: Removed session 21. Nov 24 00:23:04.748010 kernel: EXT4-fs (loop6p9): unmounting filesystem 60190da1-d0f3-413a-a3e8-c35679f803bc. Nov 24 00:23:04.749085 setup-nvidia[2507]: Container flatcardevelopercontainer-4459.1.2.bin exited successfully. Nov 24 00:23:04.751462 systemd[1]: run-systemd-nspawn-unix\x2dexport-flatcardevelopercontainer\x2d4459.1.2.bin.mount: Deactivated successfully. Nov 24 00:23:04.811793 sudo[2495]: pam_unix(sudo:session): session closed for user root Nov 24 00:23:04.813691 systemd[1]: session-c2.scope: Deactivated successfully. Nov 24 00:23:04.813992 systemd[1]: session-c2.scope: Consumed 5min 18.331s CPU time, 890.2M memory peak. Nov 24 00:23:05.239040 setup-nvidia[1871]: /opt/nvidia / Nov 24 00:23:05.240021 setup-nvidia[1871]: / Nov 24 00:23:05.250006 kernel: IPMI message handler: version 39.2 Nov 24 00:23:05.252996 kernel: ipmi device interface Nov 24 00:23:05.265247 setup-nvidia[1871]: /opt/nvidia/current/usr/lib/modules/6.12.58-flatcar/video / Nov 24 00:23:05.317068 kernel: nvidia: loading out-of-tree module taints kernel. Nov 24 00:23:05.317192 kernel: nvidia: module license 'NVIDIA' taints kernel. Nov 24 00:23:05.317215 kernel: Disabling lock debugging due to kernel taint Nov 24 00:23:05.324552 kernel: nvidia: module verification failed: signature and/or required key missing - tainting kernel Nov 24 00:23:05.324585 kernel: nvidia: module license taints kernel. Nov 24 00:23:05.719097 update_engine[1880]: I20251124 00:23:05.719027 1880 libcurl_http_fetcher.cc:47] Starting/Resuming transfer Nov 24 00:23:05.719468 update_engine[1880]: I20251124 00:23:05.719118 1880 libcurl_http_fetcher.cc:151] Setting up curl options for HTTP Nov 24 00:23:05.719468 update_engine[1880]: I20251124 00:23:05.719424 1880 libcurl_http_fetcher.cc:449] Setting up timeout source: 1 seconds. Nov 24 00:23:05.728000 kernel: nvidia-nvlink: Nvlink Core is being initialized, major device number 243 Nov 24 00:23:05.738721 update_engine[1880]: E20251124 00:23:05.738683 1880 libcurl_http_fetcher.cc:266] Unable to get http response code: Could not resolve host: disabled Nov 24 00:23:05.738782 update_engine[1880]: I20251124 00:23:05.738756 1880 libcurl_http_fetcher.cc:283] No HTTP response, retry 2 Nov 24 00:23:06.122891 kernel: Nov 24 00:23:06.123072 kernel: nvidia 0001:00:00.0: enabling device (0000 -> 0002) Nov 24 00:23:06.330001 kernel: NVRM: loading NVIDIA UNIX x86_64 Kernel Module 535.261.03 Sat Jun 14 16:05:50 UTC 2025 Nov 24 00:23:06.352003 kernel: nvidia-modeset: Loading NVIDIA Kernel Mode Setting Driver for UNIX platforms 535.261.03 Sat Jun 14 15:39:16 UTC 2025 Nov 24 00:23:06.372013 kernel: nvidia_uvm: module uses symbols nvUvmInterfaceDisableAccessCntr from proprietary module nvidia, inheriting taint. Nov 24 00:23:06.418615 setup-nvidia[1871]: / Nov 24 00:23:06.419014 kernel: nvidia-uvm: Loaded the UVM driver, major device number 241. Nov 24 00:23:06.433013 setup-nvidia[15433]: ldconfig: /usr/lib/ld.so.conf is not an ELF file - it has the wrong magic bytes at the start. Nov 24 00:23:08.162693 setup-nvidia[15450]: Mon Nov 24 00:23:08 2025 Nov 24 00:23:08.162693 setup-nvidia[15450]: +---------------------------------------------------------------------------------------+ Nov 24 00:23:08.162693 setup-nvidia[15450]: | NVIDIA-SMI 535.261.03 Driver Version: 535.261.03 CUDA Version: 12.2 | Nov 24 00:23:08.162693 setup-nvidia[15450]: |-----------------------------------------+----------------------+----------------------+ Nov 24 00:23:08.162693 setup-nvidia[15450]: | GPU Name Persistence-M | Bus-Id Disp.A | Volatile Uncorr. ECC | Nov 24 00:23:08.162693 setup-nvidia[15450]: | Fan Temp Perf Pwr:Usage/Cap | Memory-Usage | GPU-Util Compute M. | Nov 24 00:23:08.162693 setup-nvidia[15450]: | | | MIG M. | Nov 24 00:23:08.162693 setup-nvidia[15450]: |=========================================+======================+======================| Nov 24 00:23:08.166566 setup-nvidia[15450]: | 0 Tesla V100-PCIE-16GB Off | 00000001:00:00.0 Off | Off | Nov 24 00:23:08.166566 setup-nvidia[15450]: | N/A 29C P0 38W / 250W | 0MiB / 16384MiB | 0% Default | Nov 24 00:23:08.166566 setup-nvidia[15450]: | | | N/A | Nov 24 00:23:08.166566 setup-nvidia[15450]: +-----------------------------------------+----------------------+----------------------+ Nov 24 00:23:08.166680 setup-nvidia[15450]: Nov 24 00:23:08.166680 setup-nvidia[15450]: +---------------------------------------------------------------------------------------+ Nov 24 00:23:08.166680 setup-nvidia[15450]: | Processes: | Nov 24 00:23:08.166680 setup-nvidia[15450]: | GPU GI CI PID Type Process name GPU Memory | Nov 24 00:23:08.166680 setup-nvidia[15450]: | ID ID Usage | Nov 24 00:23:08.166680 setup-nvidia[15450]: |=======================================================================================| Nov 24 00:23:08.166865 setup-nvidia[15450]: | No running processes found | Nov 24 00:23:08.166865 setup-nvidia[15450]: +---------------------------------------------------------------------------------------+ Nov 24 00:23:08.538015 systemd[1]: Finished nvidia.service - NVIDIA Configure Service. Nov 24 00:23:08.540834 systemd[1]: Reached target multi-user.target - Multi-User System. Nov 24 00:23:08.541173 systemd[1]: Startup finished in 1.053s (firmware) + 17.220s (loader) + 3.699s (kernel) + 13.261s (initrd) + 3min 11.861s (userspace) = 3min 47.095s. Nov 24 00:23:12.327234 systemd[1]: Started sshd@19-10.200.0.13:22-10.200.16.10:50098.service - OpenSSH per-connection server daemon (10.200.16.10:50098). Nov 24 00:23:12.896930 sshd[15457]: Accepted publickey for core from 10.200.16.10 port 50098 ssh2: RSA SHA256:ZsGZdPSMLsIMFvMfgveQ3HAPJ+x9oI8EZIYVEgGiY/o Nov 24 00:23:12.898178 sshd-session[15457]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Nov 24 00:23:12.902336 systemd-logind[1877]: New session 22 of user core. Nov 24 00:23:12.913100 systemd[1]: Started session-22.scope - Session 22 of User core. Nov 24 00:23:13.290906 sshd[15460]: Connection closed by 10.200.16.10 port 50098 Nov 24 00:23:13.291218 sshd-session[15457]: pam_unix(sshd:session): session closed for user core Nov 24 00:23:13.294674 systemd[1]: sshd@19-10.200.0.13:22-10.200.16.10:50098.service: Deactivated successfully. Nov 24 00:23:13.296274 systemd[1]: session-22.scope: Deactivated successfully. Nov 24 00:23:13.296953 systemd-logind[1877]: Session 22 logged out. Waiting for processes to exit. Nov 24 00:23:13.297842 systemd-logind[1877]: Removed session 22. Nov 24 00:23:13.393011 systemd[1]: Started sshd@20-10.200.0.13:22-10.200.16.10:50100.service - OpenSSH per-connection server daemon (10.200.16.10:50100). Nov 24 00:23:13.962321 sshd[15466]: Accepted publickey for core from 10.200.16.10 port 50100 ssh2: RSA SHA256:ZsGZdPSMLsIMFvMfgveQ3HAPJ+x9oI8EZIYVEgGiY/o Nov 24 00:23:13.963614 sshd-session[15466]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Nov 24 00:23:13.967924 systemd-logind[1877]: New session 23 of user core. Nov 24 00:23:13.977113 systemd[1]: Started session-23.scope - Session 23 of User core. Nov 24 00:23:14.352378 sshd[15469]: Connection closed by 10.200.16.10 port 50100 Nov 24 00:23:14.352693 sshd-session[15466]: pam_unix(sshd:session): session closed for user core Nov 24 00:23:14.356132 systemd[1]: sshd@20-10.200.0.13:22-10.200.16.10:50100.service: Deactivated successfully. Nov 24 00:23:14.357732 systemd[1]: session-23.scope: Deactivated successfully. Nov 24 00:23:14.358431 systemd-logind[1877]: Session 23 logged out. Waiting for processes to exit. Nov 24 00:23:14.359541 systemd-logind[1877]: Removed session 23. Nov 24 00:23:14.453969 systemd[1]: Started sshd@21-10.200.0.13:22-10.200.16.10:50104.service - OpenSSH per-connection server daemon (10.200.16.10:50104). Nov 24 00:23:15.020616 sshd[15475]: Accepted publickey for core from 10.200.16.10 port 50104 ssh2: RSA SHA256:ZsGZdPSMLsIMFvMfgveQ3HAPJ+x9oI8EZIYVEgGiY/o Nov 24 00:23:15.021875 sshd-session[15475]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Nov 24 00:23:15.026193 systemd-logind[1877]: New session 24 of user core. Nov 24 00:23:15.037143 systemd[1]: Started session-24.scope - Session 24 of User core. Nov 24 00:23:15.038437 systemd[1]: Stopping user@0.service - User Manager for UID 0... Nov 24 00:23:15.039170 systemd[2498]: Activating special unit exit.target... Nov 24 00:23:15.039238 systemd[2498]: Stopped target default.target - Main User Target. Nov 24 00:23:15.039275 systemd[2498]: Stopped target basic.target - Basic System. Nov 24 00:23:15.039302 systemd[2498]: Stopped target paths.target - Paths. Nov 24 00:23:15.039327 systemd[2498]: Stopped target sockets.target - Sockets. Nov 24 00:23:15.039351 systemd[2498]: Stopped target timers.target - Timers. Nov 24 00:23:15.039668 systemd[2498]: Closed dbus.socket - D-Bus User Message Bus Socket. Nov 24 00:23:15.039873 systemd[2498]: Removed slice app.slice - User Application Slice. Nov 24 00:23:15.039902 systemd[2498]: Reached target shutdown.target - Shutdown. Nov 24 00:23:15.040053 systemd[2498]: Finished systemd-exit.service - Exit the Session. Nov 24 00:23:15.040093 systemd[2498]: Reached target exit.target - Exit the Session. Nov 24 00:23:15.064086 (sd-pam)[2499]: pam_unix(systemd-user:session): session closed for user root Nov 24 00:23:15.065381 systemd[1]: user@0.service: Deactivated successfully. Nov 24 00:23:15.065752 systemd[1]: Stopped user@0.service - User Manager for UID 0. Nov 24 00:23:15.068058 systemd[1]: Stopping user-runtime-dir@0.service - User Runtime Directory /run/user/0... Nov 24 00:23:15.092484 systemd[1]: run-user-0.mount: Deactivated successfully. Nov 24 00:23:15.093398 systemd[1]: user-runtime-dir@0.service: Deactivated successfully. Nov 24 00:23:15.093594 systemd[1]: Stopped user-runtime-dir@0.service - User Runtime Directory /run/user/0. Nov 24 00:23:15.095203 systemd[1]: Removed slice user-0.slice - User Slice of UID 0. Nov 24 00:23:15.095292 systemd[1]: user-0.slice: Consumed 5min 18.557s CPU time, 896.2M memory peak. Nov 24 00:23:15.095706 systemd-logind[1877]: Removed session c3. Nov 24 00:23:15.414585 sshd[15478]: Connection closed by 10.200.16.10 port 50104 Nov 24 00:23:15.414943 sshd-session[15475]: pam_unix(sshd:session): session closed for user core Nov 24 00:23:15.418436 systemd[1]: sshd@21-10.200.0.13:22-10.200.16.10:50104.service: Deactivated successfully. Nov 24 00:23:15.420135 systemd[1]: session-24.scope: Deactivated successfully. Nov 24 00:23:15.420796 systemd-logind[1877]: Session 24 logged out. Waiting for processes to exit. Nov 24 00:23:15.421745 systemd-logind[1877]: Removed session 24. Nov 24 00:23:15.515965 systemd[1]: Started sshd@22-10.200.0.13:22-10.200.16.10:50108.service - OpenSSH per-connection server daemon (10.200.16.10:50108). Nov 24 00:23:15.719446 update_engine[1880]: I20251124 00:23:15.719321 1880 libcurl_http_fetcher.cc:47] Starting/Resuming transfer Nov 24 00:23:15.719446 update_engine[1880]: I20251124 00:23:15.719399 1880 libcurl_http_fetcher.cc:151] Setting up curl options for HTTP Nov 24 00:23:15.719777 update_engine[1880]: I20251124 00:23:15.719699 1880 libcurl_http_fetcher.cc:449] Setting up timeout source: 1 seconds. Nov 24 00:23:15.736239 update_engine[1880]: E20251124 00:23:15.736207 1880 libcurl_http_fetcher.cc:266] Unable to get http response code: Could not resolve host: disabled Nov 24 00:23:15.736300 update_engine[1880]: I20251124 00:23:15.736275 1880 libcurl_http_fetcher.cc:283] No HTTP response, retry 3 Nov 24 00:23:16.091425 sshd[15488]: Accepted publickey for core from 10.200.16.10 port 50108 ssh2: RSA SHA256:ZsGZdPSMLsIMFvMfgveQ3HAPJ+x9oI8EZIYVEgGiY/o Nov 24 00:23:16.092684 sshd-session[15488]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Nov 24 00:23:16.096949 systemd-logind[1877]: New session 25 of user core. Nov 24 00:23:16.109096 systemd[1]: Started session-25.scope - Session 25 of User core. Nov 24 00:23:16.399119 sudo[15492]: core : PWD=/home/core ; USER=root ; COMMAND=/usr/sbin/setenforce 1 Nov 24 00:23:16.399423 sudo[15492]: pam_unix(sudo:session): session opened for user root(uid=0) by core(uid=500) Nov 24 00:23:16.467671 sudo[15492]: pam_unix(sudo:session): session closed for user root Nov 24 00:23:16.564302 sshd[15491]: Connection closed by 10.200.16.10 port 50108 Nov 24 00:23:16.564674 sshd-session[15488]: pam_unix(sshd:session): session closed for user core Nov 24 00:23:16.568139 systemd[1]: sshd@22-10.200.0.13:22-10.200.16.10:50108.service: Deactivated successfully. Nov 24 00:23:16.569715 systemd[1]: session-25.scope: Deactivated successfully. Nov 24 00:23:16.570434 systemd-logind[1877]: Session 25 logged out. Waiting for processes to exit. Nov 24 00:23:16.571377 systemd-logind[1877]: Removed session 25. Nov 24 00:23:16.662273 systemd[1]: Started sshd@23-10.200.0.13:22-10.200.16.10:50122.service - OpenSSH per-connection server daemon (10.200.16.10:50122). Nov 24 00:23:17.232524 sshd[15498]: Accepted publickey for core from 10.200.16.10 port 50122 ssh2: RSA SHA256:ZsGZdPSMLsIMFvMfgveQ3HAPJ+x9oI8EZIYVEgGiY/o Nov 24 00:23:17.233802 sshd-session[15498]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Nov 24 00:23:17.238250 systemd-logind[1877]: New session 26 of user core. Nov 24 00:23:17.259134 systemd[1]: Started session-26.scope - Session 26 of User core. Nov 24 00:23:17.539283 sudo[15503]: core : PWD=/home/core ; USER=root ; COMMAND=/usr/sbin/rm -rf /etc/audit/rules.d/80-selinux.rules /etc/audit/rules.d/99-default.rules Nov 24 00:23:17.539577 sudo[15503]: pam_unix(sudo:session): session opened for user root(uid=0) by core(uid=500) Nov 24 00:23:17.545901 sudo[15503]: pam_unix(sudo:session): session closed for user root Nov 24 00:23:17.551386 sudo[15502]: core : PWD=/home/core ; USER=root ; COMMAND=/usr/sbin/systemctl restart audit-rules Nov 24 00:23:17.551670 sudo[15502]: pam_unix(sudo:session): session opened for user root(uid=0) by core(uid=500) Nov 24 00:23:17.560637 systemd[1]: Starting audit-rules.service - Load Audit Rules... Nov 24 00:23:17.606311 augenrules[15525]: No rules Nov 24 00:23:17.607429 systemd[1]: audit-rules.service: Deactivated successfully. Nov 24 00:23:17.607672 systemd[1]: Finished audit-rules.service - Load Audit Rules. Nov 24 00:23:17.608421 sudo[15502]: pam_unix(sudo:session): session closed for user root Nov 24 00:23:17.696494 sshd[15501]: Connection closed by 10.200.16.10 port 50122 Nov 24 00:23:17.696836 sshd-session[15498]: pam_unix(sshd:session): session closed for user core Nov 24 00:23:17.700216 systemd[1]: sshd@23-10.200.0.13:22-10.200.16.10:50122.service: Deactivated successfully. Nov 24 00:23:17.701772 systemd[1]: session-26.scope: Deactivated successfully. Nov 24 00:23:17.702512 systemd-logind[1877]: Session 26 logged out. Waiting for processes to exit. Nov 24 00:23:17.703404 systemd-logind[1877]: Removed session 26. Nov 24 00:23:17.798974 systemd[1]: Started sshd@24-10.200.0.13:22-10.200.16.10:50132.service - OpenSSH per-connection server daemon (10.200.16.10:50132). Nov 24 00:23:18.374631 sshd[15534]: Accepted publickey for core from 10.200.16.10 port 50132 ssh2: RSA SHA256:ZsGZdPSMLsIMFvMfgveQ3HAPJ+x9oI8EZIYVEgGiY/o Nov 24 00:23:18.375821 sshd-session[15534]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Nov 24 00:23:18.379906 systemd-logind[1877]: New session 27 of user core. Nov 24 00:23:18.388105 systemd[1]: Started session-27.scope - Session 27 of User core. Nov 24 00:23:18.681627 sudo[15538]: core : PWD=/home/core ; USER=root ; COMMAND=/usr/sbin/mkdir -p . Nov 24 00:23:18.681923 sudo[15538]: pam_unix(sudo:session): session opened for user root(uid=0) by core(uid=500) Nov 24 00:23:18.685181 sudo[15538]: pam_unix(sudo:session): session closed for user root Nov 24 00:23:18.772351 sshd[15537]: Connection closed by 10.200.16.10 port 50132 Nov 24 00:23:18.772666 sshd-session[15534]: pam_unix(sshd:session): session closed for user core Nov 24 00:23:18.775790 systemd[1]: sshd@24-10.200.0.13:22-10.200.16.10:50132.service: Deactivated successfully. Nov 24 00:23:18.777368 systemd[1]: session-27.scope: Deactivated successfully. Nov 24 00:23:18.778111 systemd-logind[1877]: Session 27 logged out. Waiting for processes to exit. Nov 24 00:23:18.779097 systemd-logind[1877]: Removed session 27. Nov 24 00:23:18.881953 systemd[1]: Started sshd@25-10.200.0.13:22-10.200.16.10:50146.service - OpenSSH per-connection server daemon (10.200.16.10:50146). Nov 24 00:23:19.437146 sshd[15544]: Accepted publickey for core from 10.200.16.10 port 50146 ssh2: RSA SHA256:ZsGZdPSMLsIMFvMfgveQ3HAPJ+x9oI8EZIYVEgGiY/o Nov 24 00:23:19.438395 sshd-session[15544]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Nov 24 00:23:19.442505 systemd-logind[1877]: New session 28 of user core. Nov 24 00:23:19.456122 systemd[1]: Started session-28.scope - Session 28 of User core. Nov 24 00:23:19.745311 sudo[15550]: core : PWD=/home/core ; USER=root ; COMMAND=/usr/sbin/install -m 0755 /dev/stdin kolet Nov 24 00:23:19.745608 sudo[15550]: pam_unix(sudo:session): session opened for user root(uid=0) by core(uid=500) Nov 24 00:23:22.751689 sudo[15550]: pam_unix(sudo:session): session closed for user root Nov 24 00:23:22.839314 sshd[15549]: Connection closed by 10.200.16.10 port 50146 Nov 24 00:23:22.839590 sshd-session[15544]: pam_unix(sshd:session): session closed for user core Nov 24 00:23:22.843112 systemd[1]: sshd@25-10.200.0.13:22-10.200.16.10:50146.service: Deactivated successfully. Nov 24 00:23:22.844966 systemd[1]: session-28.scope: Deactivated successfully. Nov 24 00:23:22.845775 systemd-logind[1877]: Session 28 logged out. Waiting for processes to exit. Nov 24 00:23:22.846699 systemd-logind[1877]: Removed session 28. Nov 24 00:23:22.941369 systemd[1]: Started sshd@26-10.200.0.13:22-10.200.16.10:37462.service - OpenSSH per-connection server daemon (10.200.16.10:37462). Nov 24 00:23:23.516236 sshd[15557]: Accepted publickey for core from 10.200.16.10 port 37462 ssh2: RSA SHA256:ZsGZdPSMLsIMFvMfgveQ3HAPJ+x9oI8EZIYVEgGiY/o Nov 24 00:23:23.517438 sshd-session[15557]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Nov 24 00:23:23.521945 systemd-logind[1877]: New session 29 of user core. Nov 24 00:23:23.532096 systemd[1]: Started session-29.scope - Session 29 of User core. Nov 24 00:23:23.963370 sshd[15560]: Connection closed by 10.200.16.10 port 37462 Nov 24 00:23:23.963732 sshd-session[15557]: pam_unix(sshd:session): session closed for user core Nov 24 00:23:23.967105 systemd[1]: sshd@26-10.200.0.13:22-10.200.16.10:37462.service: Deactivated successfully. Nov 24 00:23:23.968741 systemd[1]: session-29.scope: Deactivated successfully. Nov 24 00:23:23.969477 systemd-logind[1877]: Session 29 logged out. Waiting for processes to exit. Nov 24 00:23:23.970381 systemd-logind[1877]: Removed session 29. Nov 24 00:23:24.066261 systemd[1]: Started sshd@27-10.200.0.13:22-10.200.16.10:37478.service - OpenSSH per-connection server daemon (10.200.16.10:37478). Nov 24 00:23:24.649736 sshd[15575]: Accepted publickey for core from 10.200.16.10 port 37478 ssh2: RSA SHA256:ZsGZdPSMLsIMFvMfgveQ3HAPJ+x9oI8EZIYVEgGiY/o Nov 24 00:23:24.651000 sshd-session[15575]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Nov 24 00:23:24.655150 systemd-logind[1877]: New session 30 of user core. Nov 24 00:23:24.671095 systemd[1]: Started session-30.scope - Session 30 of User core. Nov 24 00:23:25.720141 update_engine[1880]: I20251124 00:23:25.720063 1880 libcurl_http_fetcher.cc:47] Starting/Resuming transfer Nov 24 00:23:25.720523 update_engine[1880]: I20251124 00:23:25.720196 1880 libcurl_http_fetcher.cc:151] Setting up curl options for HTTP Nov 24 00:23:25.720607 update_engine[1880]: I20251124 00:23:25.720577 1880 libcurl_http_fetcher.cc:449] Setting up timeout source: 1 seconds. Nov 24 00:23:25.733363 update_engine[1880]: E20251124 00:23:25.733320 1880 libcurl_http_fetcher.cc:266] Unable to get http response code: Could not resolve host: disabled Nov 24 00:23:25.733440 update_engine[1880]: I20251124 00:23:25.733397 1880 libcurl_http_fetcher.cc:297] Transfer resulted in an error (0), 0 bytes downloaded Nov 24 00:23:25.733440 update_engine[1880]: I20251124 00:23:25.733413 1880 omaha_request_action.cc:617] Omaha request response: Nov 24 00:23:25.733513 update_engine[1880]: E20251124 00:23:25.733496 1880 omaha_request_action.cc:636] Omaha request network transfer failed. Nov 24 00:23:25.733549 update_engine[1880]: I20251124 00:23:25.733520 1880 action_processor.cc:68] ActionProcessor::ActionComplete: OmahaRequestAction action failed. Aborting processing. Nov 24 00:23:25.733549 update_engine[1880]: I20251124 00:23:25.733526 1880 action_processor.cc:73] ActionProcessor::ActionComplete: finished last action of type OmahaRequestAction Nov 24 00:23:25.733549 update_engine[1880]: I20251124 00:23:25.733532 1880 update_attempter.cc:306] Processing Done. Nov 24 00:23:25.733549 update_engine[1880]: E20251124 00:23:25.733546 1880 update_attempter.cc:619] Update failed. Nov 24 00:23:25.733640 update_engine[1880]: I20251124 00:23:25.733553 1880 utils.cc:600] Converting error code 2000 to kActionCodeOmahaErrorInHTTPResponse Nov 24 00:23:25.733640 update_engine[1880]: I20251124 00:23:25.733558 1880 payload_state.cc:97] Updating payload state for error code: 37 (kActionCodeOmahaErrorInHTTPResponse) Nov 24 00:23:25.733640 update_engine[1880]: I20251124 00:23:25.733564 1880 payload_state.cc:103] Ignoring failures until we get a valid Omaha response. Nov 24 00:23:25.733640 update_engine[1880]: I20251124 00:23:25.733632 1880 action_processor.cc:36] ActionProcessor::StartProcessing: OmahaRequestAction Nov 24 00:23:25.733726 update_engine[1880]: I20251124 00:23:25.733657 1880 omaha_request_action.cc:271] Posting an Omaha request to disabled Nov 24 00:23:25.733726 update_engine[1880]: I20251124 00:23:25.733664 1880 omaha_request_action.cc:272] Request: Nov 24 00:23:25.733726 update_engine[1880]: Nov 24 00:23:25.733726 update_engine[1880]: Nov 24 00:23:25.733726 update_engine[1880]: Nov 24 00:23:25.733726 update_engine[1880]: Nov 24 00:23:25.733726 update_engine[1880]: Nov 24 00:23:25.733726 update_engine[1880]: Nov 24 00:23:25.733726 update_engine[1880]: I20251124 00:23:25.733670 1880 libcurl_http_fetcher.cc:47] Starting/Resuming transfer Nov 24 00:23:25.733726 update_engine[1880]: I20251124 00:23:25.733687 1880 libcurl_http_fetcher.cc:151] Setting up curl options for HTTP Nov 24 00:23:25.733933 update_engine[1880]: I20251124 00:23:25.733897 1880 libcurl_http_fetcher.cc:449] Setting up timeout source: 1 seconds. Nov 24 00:23:25.733962 locksmithd[1992]: LastCheckedTime=0 Progress=0 CurrentOperation="UPDATE_STATUS_REPORTING_ERROR_EVENT" NewVersion=0.0.0 NewSize=0 Nov 24 00:23:25.741814 update_engine[1880]: E20251124 00:23:25.741781 1880 libcurl_http_fetcher.cc:266] Unable to get http response code: Could not resolve host: disabled Nov 24 00:23:25.741874 update_engine[1880]: I20251124 00:23:25.741842 1880 libcurl_http_fetcher.cc:297] Transfer resulted in an error (0), 0 bytes downloaded Nov 24 00:23:25.741874 update_engine[1880]: I20251124 00:23:25.741854 1880 omaha_request_action.cc:617] Omaha request response: Nov 24 00:23:25.741874 update_engine[1880]: I20251124 00:23:25.741860 1880 action_processor.cc:65] ActionProcessor::ActionComplete: finished last action of type OmahaRequestAction Nov 24 00:23:25.741874 update_engine[1880]: I20251124 00:23:25.741865 1880 action_processor.cc:73] ActionProcessor::ActionComplete: finished last action of type OmahaRequestAction Nov 24 00:23:25.741874 update_engine[1880]: I20251124 00:23:25.741870 1880 update_attempter.cc:306] Processing Done. Nov 24 00:23:25.742010 update_engine[1880]: I20251124 00:23:25.741876 1880 update_attempter.cc:310] Error event sent. Nov 24 00:23:25.742010 update_engine[1880]: I20251124 00:23:25.741884 1880 update_check_scheduler.cc:74] Next update check in 44m26s Nov 24 00:23:25.742165 locksmithd[1992]: LastCheckedTime=0 Progress=0 CurrentOperation="UPDATE_STATUS_IDLE" NewVersion=0.0.0 NewSize=0 Nov 24 00:23:26.132790 systemd[1]: Starting docker.service - Docker Application Container Engine... Nov 24 00:23:26.160334 (dockerd)[15598]: docker.service: Referenced but unset environment variable evaluates to an empty string: DOCKER_CGROUPS, DOCKER_OPTS, DOCKER_OPT_BIP, DOCKER_OPT_IPMASQ, DOCKER_OPT_MTU Nov 24 00:23:27.645328 dockerd[15598]: time="2025-11-24T00:23:27.645271684Z" level=info msg="Starting up" Nov 24 00:23:27.647662 dockerd[15598]: time="2025-11-24T00:23:27.646027052Z" level=info msg="OTEL tracing is not configured, using no-op tracer provider" Nov 24 00:23:27.658784 dockerd[15598]: time="2025-11-24T00:23:27.658746912Z" level=info msg="Creating a containerd client" address=/var/run/docker/libcontainerd/docker-containerd.sock timeout=1m0s Nov 24 00:23:30.705434 dockerd[15598]: time="2025-11-24T00:23:30.705381604Z" level=info msg="Loading containers: start." Nov 24 00:23:30.718999 kernel: Initializing XFRM netlink socket Nov 24 00:23:30.980634 systemd-networkd[1569]: docker0: Link UP Nov 24 00:23:30.996884 dockerd[15598]: time="2025-11-24T00:23:30.996843921Z" level=info msg="Loading containers: done." Nov 24 00:23:31.010107 systemd[1]: var-lib-docker-overlay2-opaque\x2dbug\x2dcheck4264801479-merged.mount: Deactivated successfully. Nov 24 00:23:31.015739 dockerd[15598]: time="2025-11-24T00:23:31.015707903Z" level=warning msg="Not using native diff for overlay2, this may cause degraded performance for building images: kernel has CONFIG_OVERLAY_FS_REDIRECT_DIR enabled" storage-driver=overlay2 Nov 24 00:23:31.015799 dockerd[15598]: time="2025-11-24T00:23:31.015771801Z" level=info msg="Docker daemon" commit=6430e49a55babd9b8f4d08e70ecb2b68900770fe containerd-snapshotter=false storage-driver=overlay2 version=28.0.4 Nov 24 00:23:31.015869 dockerd[15598]: time="2025-11-24T00:23:31.015850098Z" level=info msg="Initializing buildkit" Nov 24 00:23:31.086040 dockerd[15598]: time="2025-11-24T00:23:31.086010530Z" level=info msg="Completed buildkit initialization" Nov 24 00:23:31.092361 dockerd[15598]: time="2025-11-24T00:23:31.092330390Z" level=info msg="Daemon has completed initialization" Nov 24 00:23:31.092497 dockerd[15598]: time="2025-11-24T00:23:31.092456485Z" level=info msg="API listen on /run/docker.sock" Nov 24 00:23:31.092526 systemd[1]: Started docker.service - Docker Application Container Engine. Nov 24 00:23:32.277660 systemd[1]: var-lib-docker-overlay2-8ee2f9301fe87dcdbf58f28cc14582c14815755254a89d56c9e39798e152957c\x2dinit-merged.mount: Deactivated successfully. Nov 24 00:23:32.346333 systemd[1]: var-lib-docker-overlay2-8ee2f9301fe87dcdbf58f28cc14582c14815755254a89d56c9e39798e152957c-merged.mount: Deactivated successfully. Nov 24 00:23:32.417391 containerd[1892]: time="2025-11-24T00:23:32.417342704Z" level=info msg="connecting to shim dbd57584bef9f4cef7d58c6c9d858ed7807c44e5c7aa333dcd103f88180daa1b" address="unix:///run/containerd/s/1238d865893c95f56e5fb4e62b63660153435e44391bc0cbe985016ef8d241cf" namespace=moby protocol=ttrpc version=3 Nov 24 00:23:32.445152 systemd[1]: Started docker-dbd57584bef9f4cef7d58c6c9d858ed7807c44e5c7aa333dcd103f88180daa1b.scope - libcontainer container dbd57584bef9f4cef7d58c6c9d858ed7807c44e5c7aa333dcd103f88180daa1b. Nov 24 00:23:32.492780 kernel: docker0: port 1(veth3134b39) entered blocking state Nov 24 00:23:32.492852 kernel: docker0: port 1(veth3134b39) entered disabled state Nov 24 00:23:32.492875 kernel: veth3134b39: entered allmulticast mode Nov 24 00:23:32.497902 kernel: veth3134b39: entered promiscuous mode Nov 24 00:23:32.498123 systemd-networkd[1569]: veth3134b39: Link UP Nov 24 00:23:32.532996 kernel: eth0: renamed from veth144bc7e Nov 24 00:23:32.533062 kernel: docker0: port 1(veth3134b39) entered blocking state Nov 24 00:23:32.539598 kernel: docker0: port 1(veth3134b39) entered forwarding state Nov 24 00:23:32.540004 systemd-networkd[1569]: veth3134b39: Gained carrier Nov 24 00:23:32.540319 systemd-networkd[1569]: docker0: Gained carrier Nov 24 00:23:34.109127 systemd-networkd[1569]: docker0: Gained IPv6LL Nov 24 00:23:34.557125 systemd-networkd[1569]: veth3134b39: Gained IPv6LL Nov 24 00:23:35.609835 systemd[1]: docker-dbd57584bef9f4cef7d58c6c9d858ed7807c44e5c7aa333dcd103f88180daa1b.scope: Deactivated successfully. Nov 24 00:23:35.622571 containerd[1892]: time="2025-11-24T00:23:35.622532899Z" level=info msg="shim disconnected" id=dbd57584bef9f4cef7d58c6c9d858ed7807c44e5c7aa333dcd103f88180daa1b namespace=moby Nov 24 00:23:35.622853 dockerd[15598]: time="2025-11-24T00:23:35.622542899Z" level=info msg="ignoring event" container=dbd57584bef9f4cef7d58c6c9d858ed7807c44e5c7aa333dcd103f88180daa1b module=libcontainerd namespace=moby topic=/tasks/delete type="*events.TaskDelete" Nov 24 00:23:35.623546 containerd[1892]: time="2025-11-24T00:23:35.623515657Z" level=warning msg="cleaning up after shim disconnected" id=dbd57584bef9f4cef7d58c6c9d858ed7807c44e5c7aa333dcd103f88180daa1b namespace=moby Nov 24 00:23:35.623610 containerd[1892]: time="2025-11-24T00:23:35.623536656Z" level=info msg="cleaning up dead shim" namespace=moby Nov 24 00:23:35.654400 systemd-networkd[1569]: veth3134b39: Lost carrier Nov 24 00:23:35.654997 kernel: docker0: port 1(veth3134b39) entered disabled state Nov 24 00:23:35.655034 kernel: veth144bc7e: renamed from eth0 Nov 24 00:23:35.683310 systemd-networkd[1569]: veth3134b39: Link DOWN Nov 24 00:23:35.686994 kernel: docker0: port 1(veth3134b39) entered disabled state Nov 24 00:23:35.693516 kernel: veth3134b39 (unregistering): left allmulticast mode Nov 24 00:23:35.693566 kernel: veth3134b39 (unregistering): left promiscuous mode Nov 24 00:23:35.696858 kernel: docker0: port 1(veth3134b39) entered disabled state Nov 24 00:23:35.720540 systemd[1]: run-docker-netns-be9d765fd33a.mount: Deactivated successfully. Nov 24 00:23:35.724219 systemd[1]: var-lib-docker-overlay2-8ee2f9301fe87dcdbf58f28cc14582c14815755254a89d56c9e39798e152957c-merged.mount: Deactivated successfully. Nov 24 00:23:35.851683 sshd[15578]: Connection closed by 10.200.16.10 port 37478 Nov 24 00:23:35.852083 sshd-session[15575]: pam_unix(sshd:session): session closed for user core Nov 24 00:23:35.855590 systemd[1]: sshd@27-10.200.0.13:22-10.200.16.10:37478.service: Deactivated successfully. Nov 24 00:23:35.857239 systemd[1]: session-30.scope: Deactivated successfully. Nov 24 00:23:35.857915 systemd-logind[1877]: Session 30 logged out. Waiting for processes to exit. Nov 24 00:23:35.858850 systemd-logind[1877]: Removed session 30. Nov 24 00:23:35.969395 systemd[1]: Started sshd@28-10.200.0.13:22-10.200.16.10:47328.service - OpenSSH per-connection server daemon (10.200.16.10:47328). Nov 24 00:23:36.546350 sshd[15891]: Accepted publickey for core from 10.200.16.10 port 47328 ssh2: RSA SHA256:ZsGZdPSMLsIMFvMfgveQ3HAPJ+x9oI8EZIYVEgGiY/o Nov 24 00:23:36.547602 sshd-session[15891]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Nov 24 00:23:36.551741 systemd-logind[1877]: New session 31 of user core. Nov 24 00:23:36.562094 systemd[1]: Started session-31.scope - Session 31 of User core. Nov 24 00:23:36.669207 systemd-networkd[1569]: docker0: Lost carrier Nov 24 00:23:36.920113 systemd[1]: var-lib-docker-overlay2-e06e500b9cb539811c81822e314b707580bff1f3c8e916b26840dd63feb12fae\x2dinit-merged.mount: Deactivated successfully. Nov 24 00:23:37.017305 containerd[1892]: time="2025-11-24T00:23:37.017256336Z" level=info msg="connecting to shim 801c96e6ba98e95938d727522f9fa64815e2cade5d163d09d0923f010eb53231" address="unix:///run/containerd/s/684d5b37a6b3aedfc623dcad3e1a4f0024adcbe36cec2482f65a7a0a743202c6" namespace=moby protocol=ttrpc version=3 Nov 24 00:23:37.049120 systemd[1]: Started docker-801c96e6ba98e95938d727522f9fa64815e2cade5d163d09d0923f010eb53231.scope - libcontainer container 801c96e6ba98e95938d727522f9fa64815e2cade5d163d09d0923f010eb53231. Nov 24 00:23:37.094520 kernel: docker0: port 1(vethcb11bc0) entered blocking state Nov 24 00:23:37.094616 kernel: docker0: port 1(vethcb11bc0) entered disabled state Nov 24 00:23:37.097224 kernel: vethcb11bc0: entered allmulticast mode Nov 24 00:23:37.100118 kernel: vethcb11bc0: entered promiscuous mode Nov 24 00:23:37.100629 systemd-networkd[1569]: vethcb11bc0: Link UP Nov 24 00:23:37.120001 kernel: eth0: renamed from veth7e53824 Nov 24 00:23:37.126727 kernel: docker0: port 1(vethcb11bc0) entered blocking state Nov 24 00:23:37.126777 kernel: docker0: port 1(vethcb11bc0) entered forwarding state Nov 24 00:23:37.127116 systemd-networkd[1569]: vethcb11bc0: Gained carrier Nov 24 00:23:37.127360 systemd-networkd[1569]: docker0: Gained carrier Nov 24 00:23:37.163303 systemd[1]: docker-801c96e6ba98e95938d727522f9fa64815e2cade5d163d09d0923f010eb53231.scope: Deactivated successfully. Nov 24 00:23:37.178268 containerd[1892]: time="2025-11-24T00:23:37.178187040Z" level=info msg="shim disconnected" id=801c96e6ba98e95938d727522f9fa64815e2cade5d163d09d0923f010eb53231 namespace=moby Nov 24 00:23:37.178268 containerd[1892]: time="2025-11-24T00:23:37.178218338Z" level=warning msg="cleaning up after shim disconnected" id=801c96e6ba98e95938d727522f9fa64815e2cade5d163d09d0923f010eb53231 namespace=moby Nov 24 00:23:37.178268 containerd[1892]: time="2025-11-24T00:23:37.178242937Z" level=info msg="cleaning up dead shim" namespace=moby Nov 24 00:23:37.178391 dockerd[15598]: time="2025-11-24T00:23:37.178217438Z" level=info msg="ignoring event" container=801c96e6ba98e95938d727522f9fa64815e2cade5d163d09d0923f010eb53231 module=libcontainerd namespace=moby topic=/tasks/delete type="*events.TaskDelete" Nov 24 00:23:37.208281 systemd-networkd[1569]: vethcb11bc0: Lost carrier Nov 24 00:23:37.209004 kernel: docker0: port 1(vethcb11bc0) entered disabled state Nov 24 00:23:37.209056 kernel: veth7e53824: renamed from eth0 Nov 24 00:23:37.229699 systemd-networkd[1569]: vethcb11bc0: Link DOWN Nov 24 00:23:37.236914 kernel: docker0: port 1(vethcb11bc0) entered disabled state Nov 24 00:23:37.236962 kernel: vethcb11bc0 (unregistering): left allmulticast mode Nov 24 00:23:37.240253 kernel: vethcb11bc0 (unregistering): left promiscuous mode Nov 24 00:23:37.243483 kernel: docker0: port 1(vethcb11bc0) entered disabled state Nov 24 00:23:37.386534 sshd[15894]: Connection closed by 10.200.16.10 port 47328 Nov 24 00:23:37.386888 sshd-session[15891]: pam_unix(sshd:session): session closed for user core Nov 24 00:23:37.390307 systemd[1]: sshd@28-10.200.0.13:22-10.200.16.10:47328.service: Deactivated successfully. Nov 24 00:23:37.391955 systemd[1]: session-31.scope: Deactivated successfully. Nov 24 00:23:37.392654 systemd-logind[1877]: Session 31 logged out. Waiting for processes to exit. Nov 24 00:23:37.393621 systemd-logind[1877]: Removed session 31. Nov 24 00:23:37.489454 systemd[1]: Started sshd@29-10.200.0.13:22-10.200.16.10:47342.service - OpenSSH per-connection server daemon (10.200.16.10:47342). Nov 24 00:23:37.677231 systemd-networkd[1569]: docker0: Lost carrier Nov 24 00:23:37.917565 systemd[1]: var-lib-docker-overlay2-e06e500b9cb539811c81822e314b707580bff1f3c8e916b26840dd63feb12fae-merged.mount: Deactivated successfully. Nov 24 00:23:38.069036 sshd[15997]: Accepted publickey for core from 10.200.16.10 port 47342 ssh2: RSA SHA256:ZsGZdPSMLsIMFvMfgveQ3HAPJ+x9oI8EZIYVEgGiY/o Nov 24 00:23:38.070247 sshd-session[15997]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Nov 24 00:23:38.074377 systemd-logind[1877]: New session 32 of user core. Nov 24 00:23:38.096103 systemd[1]: Started session-32.scope - Session 32 of User core. Nov 24 00:23:38.445751 ntpdate[16012]: ntpdate 4.2.8p18@1.4062-o Sun Nov 23 20:17:44 UTC 2025 (1) Nov 24 00:23:45.262016 ntpdate[16012]: adjust time server 185.51.192.62 offset -0.006367 sec Nov 24 00:23:45.356043 sshd[16000]: Connection closed by 10.200.16.10 port 47342 Nov 24 00:23:45.356425 sshd-session[15997]: pam_unix(sshd:session): session closed for user core Nov 24 00:23:45.359924 systemd[1]: sshd@29-10.200.0.13:22-10.200.16.10:47342.service: Deactivated successfully. Nov 24 00:23:45.361524 systemd[1]: session-32.scope: Deactivated successfully. Nov 24 00:23:45.362205 systemd-logind[1877]: Session 32 logged out. Waiting for processes to exit. Nov 24 00:23:45.363200 systemd-logind[1877]: Removed session 32.