Jul 15 05:16:06.174779 kernel: Linux version 6.12.36-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 p1) 2.44.0) #1 SMP PREEMPT_DYNAMIC Tue Jul 15 03:28:48 -00 2025 Jul 15 05:16:06.174808 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=926b029026d98240a9e8b6527b65fc026ae523bea87c3b77ffd7237bcc7be4fb Jul 15 05:16:06.174818 kernel: BIOS-provided physical RAM map: Jul 15 05:16:06.174825 kernel: BIOS-e820: [mem 0x0000000000000000-0x000000000009ffff] usable Jul 15 05:16:06.174831 kernel: BIOS-e820: [mem 0x00000000000c0000-0x00000000000fffff] reserved Jul 15 05:16:06.174838 kernel: BIOS-e820: [mem 0x0000000000100000-0x000000003ff40fff] usable Jul 15 05:16:06.174846 kernel: BIOS-e820: [mem 0x000000003ff41000-0x000000003ffc8fff] reserved Jul 15 05:16:06.174856 kernel: BIOS-e820: [mem 0x000000003ffc9000-0x000000003fffafff] ACPI data Jul 15 05:16:06.174863 kernel: BIOS-e820: [mem 0x000000003fffb000-0x000000003fffefff] ACPI NVS Jul 15 05:16:06.174869 kernel: BIOS-e820: [mem 0x000000003ffff000-0x000000003fffffff] usable Jul 15 05:16:06.174876 kernel: BIOS-e820: [mem 0x0000000100000000-0x0000000fdfffffff] usable Jul 15 05:16:06.174883 kernel: BIOS-e820: [mem 0x0000004fe0000000-0x0000005cbfffffff] usable Jul 15 05:16:06.174889 kernel: printk: legacy bootconsole [earlyser0] enabled Jul 15 05:16:06.174897 kernel: NX (Execute Disable) protection: active Jul 15 05:16:06.174907 kernel: APIC: Static calls initialized Jul 15 05:16:06.174915 kernel: efi: EFI v2.7 by Microsoft Jul 15 05:16:06.174923 kernel: efi: ACPI=0x3fffa000 ACPI 2.0=0x3fffa014 SMBIOS=0x3ff85000 SMBIOS 3.0=0x3ff83000 MEMATTR=0x3f5bea98 RNG=0x3ffd1018 Jul 15 05:16:06.174931 kernel: random: crng init done Jul 15 05:16:06.174938 kernel: secureboot: Secure boot disabled Jul 15 05:16:06.174946 kernel: SMBIOS 3.1.0 present. Jul 15 05:16:06.174954 kernel: DMI: Microsoft Corporation Virtual Machine/Virtual Machine, BIOS Hyper-V UEFI Release v4.1 03/08/2024 Jul 15 05:16:06.174961 kernel: DMI: Memory slots populated: 3/3 Jul 15 05:16:06.174968 kernel: Hypervisor detected: Microsoft Hyper-V Jul 15 05:16:06.174976 kernel: Hyper-V: privilege flags low 0x2e7f, high 0x3b8030, hints 0x62c2c, misc 0xed7b2 Jul 15 05:16:06.174986 kernel: Hyper-V: LAPIC Timer Frequency: 0x30d40 Jul 15 05:16:06.174994 kernel: Hyper-V: Using hypercall for remote TLB flush Jul 15 05:16:06.175002 kernel: clocksource: hyperv_clocksource_tsc_page: mask: 0xffffffffffffffff max_cycles: 0x24e6a1710, max_idle_ns: 440795202120 ns Jul 15 05:16:06.175009 kernel: clocksource: hyperv_clocksource_msr: mask: 0xffffffffffffffff max_cycles: 0x24e6a1710, max_idle_ns: 440795202120 ns Jul 15 05:16:06.175017 kernel: tsc: Marking TSC unstable due to running on Hyper-V Jul 15 05:16:06.175025 kernel: tsc: Detected 2593.992 MHz processor Jul 15 05:16:06.175033 kernel: e820: update [mem 0x00000000-0x00000fff] usable ==> reserved Jul 15 05:16:06.175041 kernel: e820: remove [mem 0x000a0000-0x000fffff] usable Jul 15 05:16:06.175049 kernel: last_pfn = 0x5cc0000 max_arch_pfn = 0x400000000 Jul 15 05:16:06.175059 kernel: MTRR map: 5 entries (2 fixed + 3 variable; max 18), built from 8 variable MTRRs Jul 15 05:16:06.175067 kernel: x86/PAT: Configuration [0-7]: WB WC UC- UC WB WP UC- WT Jul 15 05:16:06.175074 kernel: e820: update [mem 0x40000000-0xffffffff] usable ==> reserved Jul 15 05:16:06.175082 kernel: e820: update [mem 0x1100000000-0x4fdfffffff] usable ==> reserved Jul 15 05:16:06.175089 kernel: last_pfn = 0x40000 max_arch_pfn = 0x400000000 Jul 15 05:16:06.175096 kernel: Using GB pages for direct mapping Jul 15 05:16:06.175115 kernel: ACPI: Early table checksum verification disabled Jul 15 05:16:06.175132 kernel: ACPI: RSDP 0x000000003FFFA014 000024 (v02 VRTUAL) Jul 15 05:16:06.175144 kernel: ACPI: XSDT 0x000000003FFF90E8 000064 (v01 VRTUAL MICROSFT 00000001 MSFT 00000001) Jul 15 05:16:06.175157 kernel: ACPI: FACP 0x000000003FFF8000 000114 (v06 VRTUAL MICROSFT 00000001 MSFT 00000001) Jul 15 05:16:06.175170 kernel: ACPI: DSDT 0x000000003FFD6000 01E184 (v02 MSFTVM DSDT01 00000001 MSFT 05000000) Jul 15 05:16:06.175178 kernel: ACPI: FACS 0x000000003FFFE000 000040 Jul 15 05:16:06.175189 kernel: ACPI: OEM0 0x000000003FFF7000 000064 (v01 VRTUAL MICROSFT 00000001 MSFT 00000001) Jul 15 05:16:06.175205 kernel: ACPI: SPCR 0x000000003FFF6000 000050 (v02 VRTUAL MICROSFT 00000001 MSFT 00000001) Jul 15 05:16:06.175224 kernel: ACPI: WAET 0x000000003FFF5000 000028 (v01 VRTUAL MICROSFT 00000001 MSFT 00000001) Jul 15 05:16:06.175233 kernel: ACPI: APIC 0x000000003FFD5000 000078 (v04 VRTUAL MICROSFT 00000001 MSFT 00000001) Jul 15 05:16:06.175241 kernel: ACPI: SRAT 0x000000003FFD4000 0001D0 (v02 VRTUAL MICROSFT 00000001 MSFT 00000001) Jul 15 05:16:06.175249 kernel: ACPI: BGRT 0x000000003FFD3000 000038 (v01 VRTUAL MICROSFT 00000001 MSFT 00000001) Jul 15 05:16:06.175258 kernel: ACPI: FPDT 0x000000003FFD2000 000034 (v01 VRTUAL MICROSFT 00000001 MSFT 00000001) Jul 15 05:16:06.175266 kernel: ACPI: Reserving FACP table memory at [mem 0x3fff8000-0x3fff8113] Jul 15 05:16:06.175274 kernel: ACPI: Reserving DSDT table memory at [mem 0x3ffd6000-0x3fff4183] Jul 15 05:16:06.175282 kernel: ACPI: Reserving FACS table memory at [mem 0x3fffe000-0x3fffe03f] Jul 15 05:16:06.175290 kernel: ACPI: Reserving OEM0 table memory at [mem 0x3fff7000-0x3fff7063] Jul 15 05:16:06.175301 kernel: ACPI: Reserving SPCR table memory at [mem 0x3fff6000-0x3fff604f] Jul 15 05:16:06.175309 kernel: ACPI: Reserving WAET table memory at [mem 0x3fff5000-0x3fff5027] Jul 15 05:16:06.175317 kernel: ACPI: Reserving APIC table memory at [mem 0x3ffd5000-0x3ffd5077] Jul 15 05:16:06.175325 kernel: ACPI: Reserving SRAT table memory at [mem 0x3ffd4000-0x3ffd41cf] Jul 15 05:16:06.175333 kernel: ACPI: Reserving BGRT table memory at [mem 0x3ffd3000-0x3ffd3037] Jul 15 05:16:06.175341 kernel: ACPI: Reserving FPDT table memory at [mem 0x3ffd2000-0x3ffd2033] Jul 15 05:16:06.175349 kernel: ACPI: SRAT: Node 0 PXM 0 [mem 0x00000000-0x3fffffff] hotplug Jul 15 05:16:06.175360 kernel: ACPI: SRAT: Node 0 PXM 0 [mem 0x100000000-0xfdfffffff] hotplug Jul 15 05:16:06.175371 kernel: ACPI: SRAT: Node 0 PXM 0 [mem 0x4fe0000000-0x5cbfffffff] hotplug Jul 15 05:16:06.175379 kernel: ACPI: SRAT: Node 0 PXM 0 [mem 0x5cc0200000-0xffffffffff] hotplug Jul 15 05:16:06.175387 kernel: ACPI: SRAT: Node 0 PXM 0 [mem 0x10000200000-0x1ffffffffff] hotplug Jul 15 05:16:06.175395 kernel: ACPI: SRAT: Node 0 PXM 0 [mem 0x20000200000-0x3ffffffffff] hotplug Jul 15 05:16:06.175403 kernel: ACPI: SRAT: Node 0 PXM 0 [mem 0x40000200000-0x7ffffffffff] hotplug Jul 15 05:16:06.175412 kernel: ACPI: SRAT: Node 0 PXM 0 [mem 0x80000200000-0xfffffffffff] hotplug Jul 15 05:16:06.175420 kernel: NUMA: Node 0 [mem 0x00001000-0x3fffffff] + [mem 0x100000000-0xfdfffffff] -> [mem 0x00001000-0xfdfffffff] Jul 15 05:16:06.175428 kernel: NUMA: Node 0 [mem 0x00001000-0xfdfffffff] + [mem 0x4fe0000000-0x5cbfffffff] -> [mem 0x00001000-0x5cbfffffff] Jul 15 05:16:06.175436 kernel: NODE_DATA(0) allocated [mem 0x5cbfff7dc0-0x5cbfffefff] Jul 15 05:16:06.175447 kernel: Zone ranges: Jul 15 05:16:06.175455 kernel: DMA [mem 0x0000000000001000-0x0000000000ffffff] Jul 15 05:16:06.175463 kernel: DMA32 [mem 0x0000000001000000-0x00000000ffffffff] Jul 15 05:16:06.175471 kernel: Normal [mem 0x0000000100000000-0x0000005cbfffffff] Jul 15 05:16:06.175479 kernel: Device empty Jul 15 05:16:06.175487 kernel: Movable zone start for each node Jul 15 05:16:06.175495 kernel: Early memory node ranges Jul 15 05:16:06.175503 kernel: node 0: [mem 0x0000000000001000-0x000000000009ffff] Jul 15 05:16:06.175511 kernel: node 0: [mem 0x0000000000100000-0x000000003ff40fff] Jul 15 05:16:06.175522 kernel: node 0: [mem 0x000000003ffff000-0x000000003fffffff] Jul 15 05:16:06.175530 kernel: node 0: [mem 0x0000000100000000-0x0000000fdfffffff] Jul 15 05:16:06.175538 kernel: node 0: [mem 0x0000004fe0000000-0x0000005cbfffffff] Jul 15 05:16:06.175546 kernel: Initmem setup node 0 [mem 0x0000000000001000-0x0000005cbfffffff] Jul 15 05:16:06.175554 kernel: On node 0, zone DMA: 1 pages in unavailable ranges Jul 15 05:16:06.175562 kernel: On node 0, zone DMA: 96 pages in unavailable ranges Jul 15 05:16:06.175570 kernel: On node 0, zone DMA32: 190 pages in unavailable ranges Jul 15 05:16:06.175577 kernel: ACPI: PM-Timer IO Port: 0x408 Jul 15 05:16:06.175585 kernel: ACPI: LAPIC_NMI (acpi_id[0x01] dfl dfl lint[0x1]) Jul 15 05:16:06.175596 kernel: IOAPIC[0]: apic_id 6, version 17, address 0xfec00000, GSI 0-23 Jul 15 05:16:06.175604 kernel: ACPI: INT_SRC_OVR (bus 0 bus_irq 9 global_irq 9 high level) Jul 15 05:16:06.175612 kernel: ACPI: Using ACPI (MADT) for SMP configuration information Jul 15 05:16:06.175620 kernel: ACPI: SPCR: console: uart,io,0x3f8,115200 Jul 15 05:16:06.175628 kernel: CPU topo: Max. logical packages: 1 Jul 15 05:16:06.175636 kernel: CPU topo: Max. logical dies: 1 Jul 15 05:16:06.175644 kernel: CPU topo: Max. dies per package: 1 Jul 15 05:16:06.175652 kernel: CPU topo: Max. threads per core: 1 Jul 15 05:16:06.175660 kernel: CPU topo: Num. cores per package: 6 Jul 15 05:16:06.175671 kernel: CPU topo: Num. threads per package: 6 Jul 15 05:16:06.175679 kernel: CPU topo: Allowing 6 present CPUs plus 0 hotplug CPUs Jul 15 05:16:06.175687 kernel: [mem 0x40000000-0xffffffff] available for PCI devices Jul 15 05:16:06.175695 kernel: Booting paravirtualized kernel on Hyper-V Jul 15 05:16:06.175703 kernel: clocksource: refined-jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1910969940391419 ns Jul 15 05:16:06.175711 kernel: setup_percpu: NR_CPUS:512 nr_cpumask_bits:6 nr_cpu_ids:6 nr_node_ids:1 Jul 15 05:16:06.175719 kernel: percpu: Embedded 60 pages/cpu s207832 r8192 d29736 u262144 Jul 15 05:16:06.175727 kernel: pcpu-alloc: s207832 r8192 d29736 u262144 alloc=1*2097152 Jul 15 05:16:06.175735 kernel: pcpu-alloc: [0] 0 1 2 3 4 5 - - Jul 15 05:16:06.175745 kernel: Hyper-V: PV spinlocks enabled Jul 15 05:16:06.175753 kernel: PV qspinlock hash table entries: 256 (order: 0, 4096 bytes, linear) Jul 15 05:16:06.175772 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=926b029026d98240a9e8b6527b65fc026ae523bea87c3b77ffd7237bcc7be4fb Jul 15 05:16:06.175781 kernel: Unknown kernel command line parameters "BOOT_IMAGE=/flatcar/vmlinuz-a", will be passed to user space. Jul 15 05:16:06.175789 kernel: Dentry cache hash table entries: 8388608 (order: 14, 67108864 bytes, linear) Jul 15 05:16:06.175797 kernel: Inode-cache hash table entries: 4194304 (order: 13, 33554432 bytes, linear) Jul 15 05:16:06.175805 kernel: Fallback order for Node 0: 0 Jul 15 05:16:06.175813 kernel: Built 1 zonelists, mobility grouping on. Total pages: 29359841 Jul 15 05:16:06.175825 kernel: Policy zone: Normal Jul 15 05:16:06.175841 kernel: mem auto-init: stack:off, heap alloc:off, heap free:off Jul 15 05:16:06.175850 kernel: software IO TLB: area num 8. Jul 15 05:16:06.175861 kernel: SLUB: HWalign=64, Order=0-3, MinObjects=0, CPUs=6, Nodes=1 Jul 15 05:16:06.175870 kernel: Kernel/User page tables isolation: enabled Jul 15 05:16:06.175878 kernel: ftrace: allocating 40097 entries in 157 pages Jul 15 05:16:06.175887 kernel: ftrace: allocated 157 pages with 5 groups Jul 15 05:16:06.175900 kernel: Dynamic Preempt: voluntary Jul 15 05:16:06.175911 kernel: rcu: Preemptible hierarchical RCU implementation. Jul 15 05:16:06.175928 kernel: rcu: RCU event tracing is enabled. Jul 15 05:16:06.175941 kernel: rcu: RCU restricting CPUs from NR_CPUS=512 to nr_cpu_ids=6. Jul 15 05:16:06.175952 kernel: Trampoline variant of Tasks RCU enabled. Jul 15 05:16:06.175964 kernel: Rude variant of Tasks RCU enabled. Jul 15 05:16:06.175972 kernel: Tracing variant of Tasks RCU enabled. Jul 15 05:16:06.175981 kernel: rcu: RCU calculated value of scheduler-enlistment delay is 100 jiffies. Jul 15 05:16:06.175989 kernel: rcu: Adjusting geometry for rcu_fanout_leaf=16, nr_cpu_ids=6 Jul 15 05:16:06.175998 kernel: RCU Tasks: Setting shift to 3 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=6. Jul 15 05:16:06.176009 kernel: RCU Tasks Rude: Setting shift to 3 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=6. Jul 15 05:16:06.176018 kernel: RCU Tasks Trace: Setting shift to 3 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=6. Jul 15 05:16:06.176026 kernel: Using NULL legacy PIC Jul 15 05:16:06.176035 kernel: NR_IRQS: 33024, nr_irqs: 472, preallocated irqs: 0 Jul 15 05:16:06.176043 kernel: rcu: srcu_init: Setting srcu_struct sizes based on contention. Jul 15 05:16:06.176052 kernel: Console: colour dummy device 80x25 Jul 15 05:16:06.176060 kernel: printk: legacy console [tty1] enabled Jul 15 05:16:06.176068 kernel: printk: legacy console [ttyS0] enabled Jul 15 05:16:06.176077 kernel: printk: legacy bootconsole [earlyser0] disabled Jul 15 05:16:06.176088 kernel: ACPI: Core revision 20240827 Jul 15 05:16:06.176096 kernel: Failed to register legacy timer interrupt Jul 15 05:16:06.176105 kernel: APIC: Switch to symmetric I/O mode setup Jul 15 05:16:06.176113 kernel: Hyper-V: Host Build 10.0.20348.1827-1-0 Jul 15 05:16:06.176121 kernel: Hyper-V: enabling crash_kexec_post_notifiers Jul 15 05:16:06.176130 kernel: Hyper-V: Using IPI hypercalls Jul 15 05:16:06.176147 kernel: APIC: send_IPI() replaced with hv_send_ipi() Jul 15 05:16:06.176160 kernel: APIC: send_IPI_mask() replaced with hv_send_ipi_mask() Jul 15 05:16:06.176169 kernel: APIC: send_IPI_mask_allbutself() replaced with hv_send_ipi_mask_allbutself() Jul 15 05:16:06.176181 kernel: APIC: send_IPI_allbutself() replaced with hv_send_ipi_allbutself() Jul 15 05:16:06.176190 kernel: APIC: send_IPI_all() replaced with hv_send_ipi_all() Jul 15 05:16:06.176198 kernel: APIC: send_IPI_self() replaced with hv_send_ipi_self() Jul 15 05:16:06.176207 kernel: Hyper-V: Using enlightened APIC (xapic mode) Jul 15 05:16:06.176215 kernel: APIC: eoi() replaced with hv_apic_eoi_write() Jul 15 05:16:06.176223 kernel: APIC: read() replaced with hv_apic_read() Jul 15 05:16:06.176232 kernel: APIC: write() replaced with hv_apic_write() Jul 15 05:16:06.176240 kernel: APIC: icr_write() replaced with hv_apic_icr_write() Jul 15 05:16:06.176249 kernel: APIC: icr_read() replaced with hv_apic_icr_read() Jul 15 05:16:06.176260 kernel: Calibrating delay loop (skipped), value calculated using timer frequency.. 5187.98 BogoMIPS (lpj=2593992) Jul 15 05:16:06.176269 kernel: Last level iTLB entries: 4KB 128, 2MB 8, 4MB 8 Jul 15 05:16:06.176277 kernel: Last level dTLB entries: 4KB 64, 2MB 32, 4MB 32, 1GB 4 Jul 15 05:16:06.176286 kernel: Spectre V1 : Mitigation: usercopy/swapgs barriers and __user pointer sanitization Jul 15 05:16:06.176294 kernel: Spectre V2 : Mitigation: Retpolines Jul 15 05:16:06.176302 kernel: Spectre V2 : Spectre v2 / SpectreRSB: Filling RSB on context switch and VMEXIT Jul 15 05:16:06.176310 kernel: Speculative Store Bypass: Vulnerable Jul 15 05:16:06.176319 kernel: MDS: Mitigation: Clear CPU buffers Jul 15 05:16:06.176327 kernel: TAA: Mitigation: Clear CPU buffers Jul 15 05:16:06.176335 kernel: MMIO Stale Data: Vulnerable: Clear CPU buffers attempted, no microcode Jul 15 05:16:06.176346 kernel: ITS: Mitigation: Aligned branch/return thunks Jul 15 05:16:06.176354 kernel: x86/fpu: Supporting XSAVE feature 0x001: 'x87 floating point registers' Jul 15 05:16:06.176363 kernel: x86/fpu: Supporting XSAVE feature 0x002: 'SSE registers' Jul 15 05:16:06.176371 kernel: x86/fpu: Supporting XSAVE feature 0x004: 'AVX registers' Jul 15 05:16:06.176379 kernel: x86/fpu: xstate_offset[2]: 576, xstate_sizes[2]: 256 Jul 15 05:16:06.176388 kernel: x86/fpu: Enabled xstate features 0x7, context size is 832 bytes, using 'standard' format. Jul 15 05:16:06.176396 kernel: Freeing SMP alternatives memory: 32K Jul 15 05:16:06.176404 kernel: pid_max: default: 32768 minimum: 301 Jul 15 05:16:06.176412 kernel: LSM: initializing lsm=lockdown,capability,landlock,selinux,ima Jul 15 05:16:06.176420 kernel: landlock: Up and running. Jul 15 05:16:06.176429 kernel: SELinux: Initializing. Jul 15 05:16:06.176440 kernel: Mount-cache hash table entries: 131072 (order: 8, 1048576 bytes, linear) Jul 15 05:16:06.176448 kernel: Mountpoint-cache hash table entries: 131072 (order: 8, 1048576 bytes, linear) Jul 15 05:16:06.176457 kernel: smpboot: CPU0: Intel(R) Xeon(R) CPU E5-2690 v4 @ 2.60GHz (family: 0x6, model: 0x4f, stepping: 0x1) Jul 15 05:16:06.176465 kernel: Performance Events: unsupported p6 CPU model 79 no PMU driver, software events only. Jul 15 05:16:06.176473 kernel: signal: max sigframe size: 1776 Jul 15 05:16:06.176482 kernel: rcu: Hierarchical SRCU implementation. Jul 15 05:16:06.176491 kernel: rcu: Max phase no-delay instances is 400. Jul 15 05:16:06.176499 kernel: Timer migration: 1 hierarchy levels; 8 children per group; 1 crossnode level Jul 15 05:16:06.176508 kernel: NMI watchdog: Perf NMI watchdog permanently disabled Jul 15 05:16:06.176516 kernel: smp: Bringing up secondary CPUs ... Jul 15 05:16:06.176527 kernel: smpboot: x86: Booting SMP configuration: Jul 15 05:16:06.176536 kernel: .... node #0, CPUs: #1 #2 #3 #4 #5 Jul 15 05:16:06.176544 kernel: smp: Brought up 1 node, 6 CPUs Jul 15 05:16:06.176552 kernel: smpboot: Total of 6 processors activated (31127.90 BogoMIPS) Jul 15 05:16:06.176561 kernel: Memory: 115339092K/117439364K available (14336K kernel code, 2430K rwdata, 9956K rodata, 54608K init, 2360K bss, 2089996K reserved, 0K cma-reserved) Jul 15 05:16:06.176582 kernel: devtmpfs: initialized Jul 15 05:16:06.176591 kernel: x86/mm: Memory block size: 1024MB Jul 15 05:16:06.176600 kernel: ACPI: PM: Registering ACPI NVS region [mem 0x3fffb000-0x3fffefff] (16384 bytes) Jul 15 05:16:06.176608 kernel: clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1911260446275000 ns Jul 15 05:16:06.176620 kernel: futex hash table entries: 2048 (order: 5, 131072 bytes, linear) Jul 15 05:16:06.176628 kernel: pinctrl core: initialized pinctrl subsystem Jul 15 05:16:06.176636 kernel: NET: Registered PF_NETLINK/PF_ROUTE protocol family Jul 15 05:16:06.176645 kernel: audit: initializing netlink subsys (disabled) Jul 15 05:16:06.176654 kernel: audit: type=2000 audit(1752556562.029:1): state=initialized audit_enabled=0 res=1 Jul 15 05:16:06.176662 kernel: thermal_sys: Registered thermal governor 'step_wise' Jul 15 05:16:06.176670 kernel: thermal_sys: Registered thermal governor 'user_space' Jul 15 05:16:06.176679 kernel: cpuidle: using governor menu Jul 15 05:16:06.176688 kernel: acpiphp: ACPI Hot Plug PCI Controller Driver version: 0.5 Jul 15 05:16:06.176699 kernel: dca service started, version 1.12.1 Jul 15 05:16:06.176707 kernel: e820: reserve RAM buffer [mem 0x3ff41000-0x3fffffff] Jul 15 05:16:06.176716 kernel: kprobes: kprobe jump-optimization is enabled. All kprobes are optimized if possible. Jul 15 05:16:06.176724 kernel: HugeTLB: registered 1.00 GiB page size, pre-allocated 0 pages Jul 15 05:16:06.176733 kernel: HugeTLB: 16380 KiB vmemmap can be freed for a 1.00 GiB page Jul 15 05:16:06.176741 kernel: HugeTLB: registered 2.00 MiB page size, pre-allocated 0 pages Jul 15 05:16:06.176750 kernel: HugeTLB: 28 KiB vmemmap can be freed for a 2.00 MiB page Jul 15 05:16:06.176758 kernel: ACPI: Added _OSI(Module Device) Jul 15 05:16:06.176815 kernel: ACPI: Added _OSI(Processor Device) Jul 15 05:16:06.176827 kernel: ACPI: Added _OSI(Processor Aggregator Device) Jul 15 05:16:06.176836 kernel: ACPI: 1 ACPI AML tables successfully acquired and loaded Jul 15 05:16:06.176844 kernel: ACPI: Interpreter enabled Jul 15 05:16:06.176852 kernel: ACPI: PM: (supports S0 S5) Jul 15 05:16:06.176861 kernel: ACPI: Using IOAPIC for interrupt routing Jul 15 05:16:06.176869 kernel: PCI: Using host bridge windows from ACPI; if necessary, use "pci=nocrs" and report a bug Jul 15 05:16:06.176878 kernel: PCI: Ignoring E820 reservations for host bridge windows Jul 15 05:16:06.176886 kernel: ACPI: Enabled 1 GPEs in block 00 to 0F Jul 15 05:16:06.176895 kernel: iommu: Default domain type: Translated Jul 15 05:16:06.176906 kernel: iommu: DMA domain TLB invalidation policy: lazy mode Jul 15 05:16:06.176914 kernel: efivars: Registered efivars operations Jul 15 05:16:06.176923 kernel: PCI: Using ACPI for IRQ routing Jul 15 05:16:06.176931 kernel: PCI: System does not support PCI Jul 15 05:16:06.176940 kernel: vgaarb: loaded Jul 15 05:16:06.176948 kernel: clocksource: Switched to clocksource hyperv_clocksource_tsc_page Jul 15 05:16:06.176957 kernel: VFS: Disk quotas dquot_6.6.0 Jul 15 05:16:06.176965 kernel: VFS: Dquot-cache hash table entries: 512 (order 0, 4096 bytes) Jul 15 05:16:06.176973 kernel: pnp: PnP ACPI init Jul 15 05:16:06.176985 kernel: pnp: PnP ACPI: found 3 devices Jul 15 05:16:06.176993 kernel: clocksource: acpi_pm: mask: 0xffffff max_cycles: 0xffffff, max_idle_ns: 2085701024 ns Jul 15 05:16:06.177002 kernel: NET: Registered PF_INET protocol family Jul 15 05:16:06.177010 kernel: IP idents hash table entries: 262144 (order: 9, 2097152 bytes, linear) Jul 15 05:16:06.177019 kernel: tcp_listen_portaddr_hash hash table entries: 65536 (order: 8, 1048576 bytes, linear) Jul 15 05:16:06.177027 kernel: Table-perturb hash table entries: 65536 (order: 6, 262144 bytes, linear) Jul 15 05:16:06.177036 kernel: TCP established hash table entries: 524288 (order: 10, 4194304 bytes, linear) Jul 15 05:16:06.177044 kernel: TCP bind hash table entries: 65536 (order: 9, 2097152 bytes, linear) Jul 15 05:16:06.177055 kernel: TCP: Hash tables configured (established 524288 bind 65536) Jul 15 05:16:06.177064 kernel: UDP hash table entries: 65536 (order: 9, 2097152 bytes, linear) Jul 15 05:16:06.177072 kernel: UDP-Lite hash table entries: 65536 (order: 9, 2097152 bytes, linear) Jul 15 05:16:06.177081 kernel: NET: Registered PF_UNIX/PF_LOCAL protocol family Jul 15 05:16:06.177089 kernel: NET: Registered PF_XDP protocol family Jul 15 05:16:06.177097 kernel: PCI: CLS 0 bytes, default 64 Jul 15 05:16:06.177106 kernel: PCI-DMA: Using software bounce buffering for IO (SWIOTLB) Jul 15 05:16:06.177114 kernel: software IO TLB: mapped [mem 0x000000003b5be000-0x000000003f5be000] (64MB) Jul 15 05:16:06.177123 kernel: RAPL PMU: API unit is 2^-32 Joules, 0 fixed counters, 10737418240 ms ovfl timer Jul 15 05:16:06.177134 kernel: Initialise system trusted keyrings Jul 15 05:16:06.177142 kernel: workingset: timestamp_bits=39 max_order=25 bucket_order=0 Jul 15 05:16:06.177151 kernel: Key type asymmetric registered Jul 15 05:16:06.177159 kernel: Asymmetric key parser 'x509' registered Jul 15 05:16:06.177167 kernel: Block layer SCSI generic (bsg) driver version 0.4 loaded (major 250) Jul 15 05:16:06.177176 kernel: io scheduler mq-deadline registered Jul 15 05:16:06.177184 kernel: io scheduler kyber registered Jul 15 05:16:06.177192 kernel: io scheduler bfq registered Jul 15 05:16:06.177201 kernel: ioatdma: Intel(R) QuickData Technology Driver 5.00 Jul 15 05:16:06.177209 kernel: Serial: 8250/16550 driver, 4 ports, IRQ sharing enabled Jul 15 05:16:06.177220 kernel: 00:00: ttyS0 at I/O 0x3f8 (irq = 4, base_baud = 115200) is a 16550A Jul 15 05:16:06.177229 kernel: 00:01: ttyS1 at I/O 0x2f8 (irq = 3, base_baud = 115200) is a 16550A Jul 15 05:16:06.177237 kernel: i8042: PNP: No PS/2 controller found. Jul 15 05:16:06.177395 kernel: rtc_cmos 00:02: registered as rtc0 Jul 15 05:16:06.177499 kernel: rtc_cmos 00:02: setting system clock to 2025-07-15T05:16:05 UTC (1752556565) Jul 15 05:16:06.177595 kernel: rtc_cmos 00:02: alarms up to one month, 114 bytes nvram Jul 15 05:16:06.177608 kernel: intel_pstate: CPU model not supported Jul 15 05:16:06.177621 kernel: efifb: probing for efifb Jul 15 05:16:06.177630 kernel: efifb: framebuffer at 0x40000000, using 3072k, total 3072k Jul 15 05:16:06.177638 kernel: efifb: mode is 1024x768x32, linelength=4096, pages=1 Jul 15 05:16:06.177647 kernel: efifb: scrolling: redraw Jul 15 05:16:06.177655 kernel: efifb: Truecolor: size=8:8:8:8, shift=24:16:8:0 Jul 15 05:16:06.177664 kernel: Console: switching to colour frame buffer device 128x48 Jul 15 05:16:06.177672 kernel: fb0: EFI VGA frame buffer device Jul 15 05:16:06.177681 kernel: pstore: Using crash dump compression: deflate Jul 15 05:16:06.177689 kernel: pstore: Registered efi_pstore as persistent store backend Jul 15 05:16:06.177700 kernel: NET: Registered PF_INET6 protocol family Jul 15 05:16:06.177709 kernel: Segment Routing with IPv6 Jul 15 05:16:06.177717 kernel: In-situ OAM (IOAM) with IPv6 Jul 15 05:16:06.177726 kernel: NET: Registered PF_PACKET protocol family Jul 15 05:16:06.177734 kernel: Key type dns_resolver registered Jul 15 05:16:06.177743 kernel: IPI shorthand broadcast: enabled Jul 15 05:16:06.177751 kernel: sched_clock: Marking stable (3838004700, 107605600)->(4271148500, -325538200) Jul 15 05:16:06.177771 kernel: registered taskstats version 1 Jul 15 05:16:06.177781 kernel: Loading compiled-in X.509 certificates Jul 15 05:16:06.177793 kernel: Loaded X.509 cert 'Kinvolk GmbH: Module signing key for 6.12.36-flatcar: a24478b628e55368911ce1800a2bd6bc158938c7' Jul 15 05:16:06.177802 kernel: Demotion targets for Node 0: null Jul 15 05:16:06.177810 kernel: Key type .fscrypt registered Jul 15 05:16:06.177818 kernel: Key type fscrypt-provisioning registered Jul 15 05:16:06.177827 kernel: ima: No TPM chip found, activating TPM-bypass! Jul 15 05:16:06.177836 kernel: ima: Allocated hash algorithm: sha1 Jul 15 05:16:06.177844 kernel: ima: No architecture policies found Jul 15 05:16:06.177852 kernel: clk: Disabling unused clocks Jul 15 05:16:06.177861 kernel: Warning: unable to open an initial console. Jul 15 05:16:06.177872 kernel: Freeing unused kernel image (initmem) memory: 54608K Jul 15 05:16:06.177881 kernel: Write protecting the kernel read-only data: 24576k Jul 15 05:16:06.177889 kernel: Freeing unused kernel image (rodata/data gap) memory: 284K Jul 15 05:16:06.177898 kernel: Run /init as init process Jul 15 05:16:06.177906 kernel: with arguments: Jul 15 05:16:06.177915 kernel: /init Jul 15 05:16:06.177923 kernel: with environment: Jul 15 05:16:06.177931 kernel: HOME=/ Jul 15 05:16:06.177939 kernel: TERM=linux Jul 15 05:16:06.177950 kernel: BOOT_IMAGE=/flatcar/vmlinuz-a Jul 15 05:16:06.177960 systemd[1]: Successfully made /usr/ read-only. Jul 15 05:16:06.177971 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) Jul 15 05:16:06.177981 systemd[1]: Detected virtualization microsoft. Jul 15 05:16:06.177990 systemd[1]: Detected architecture x86-64. Jul 15 05:16:06.177998 systemd[1]: Running in initrd. Jul 15 05:16:06.178007 systemd[1]: No hostname configured, using default hostname. Jul 15 05:16:06.178019 systemd[1]: Hostname set to . Jul 15 05:16:06.178028 systemd[1]: Initializing machine ID from random generator. Jul 15 05:16:06.178037 systemd[1]: Queued start job for default target initrd.target. Jul 15 05:16:06.178046 systemd[1]: Started clevis-luks-askpass.path - Forward Password Requests to Clevis Directory Watch. Jul 15 05:16:06.178055 systemd[1]: Started systemd-ask-password-console.path - Dispatch Password Requests to Console Directory Watch. Jul 15 05:16:06.178065 systemd[1]: Expecting device dev-disk-by\x2dlabel-EFI\x2dSYSTEM.device - /dev/disk/by-label/EFI-SYSTEM... Jul 15 05:16:06.178074 systemd[1]: Expecting device dev-disk-by\x2dlabel-OEM.device - /dev/disk/by-label/OEM... Jul 15 05:16:06.178083 systemd[1]: Expecting device dev-disk-by\x2dlabel-ROOT.device - /dev/disk/by-label/ROOT... Jul 15 05:16:06.178096 systemd[1]: Expecting device dev-disk-by\x2dpartlabel-USR\x2dA.device - /dev/disk/by-partlabel/USR-A... Jul 15 05:16:06.178106 systemd[1]: Expecting device dev-disk-by\x2dpartuuid-7130c94a\x2d213a\x2d4e5a\x2d8e26\x2d6cce9662f132.device - /dev/disk/by-partuuid/7130c94a-213a-4e5a-8e26-6cce9662f132... Jul 15 05:16:06.178115 systemd[1]: Expecting device dev-mapper-usr.device - /dev/mapper/usr... Jul 15 05:16:06.178124 systemd[1]: Reached target cryptsetup-pre.target - Local Encrypted Volumes (Pre). Jul 15 05:16:06.178133 systemd[1]: Reached target cryptsetup.target - Local Encrypted Volumes. Jul 15 05:16:06.178142 systemd[1]: Reached target paths.target - Path Units. Jul 15 05:16:06.178151 systemd[1]: Reached target slices.target - Slice Units. Jul 15 05:16:06.178162 systemd[1]: Reached target swap.target - Swaps. Jul 15 05:16:06.178171 systemd[1]: Reached target timers.target - Timer Units. Jul 15 05:16:06.178180 systemd[1]: Listening on iscsid.socket - Open-iSCSI iscsid Socket. Jul 15 05:16:06.178189 systemd[1]: Listening on iscsiuio.socket - Open-iSCSI iscsiuio Socket. Jul 15 05:16:06.178198 systemd[1]: Listening on systemd-journald-dev-log.socket - Journal Socket (/dev/log). Jul 15 05:16:06.178208 systemd[1]: Listening on systemd-journald.socket - Journal Sockets. Jul 15 05:16:06.178217 systemd[1]: Listening on systemd-networkd.socket - Network Service Netlink Socket. Jul 15 05:16:06.178226 systemd[1]: Listening on systemd-udevd-control.socket - udev Control Socket. Jul 15 05:16:06.178235 systemd[1]: Listening on systemd-udevd-kernel.socket - udev Kernel Socket. Jul 15 05:16:06.178246 systemd[1]: Reached target sockets.target - Socket Units. Jul 15 05:16:06.178255 systemd[1]: Starting ignition-setup-pre.service - Ignition env setup... Jul 15 05:16:06.178264 systemd[1]: Starting kmod-static-nodes.service - Create List of Static Device Nodes... Jul 15 05:16:06.178273 systemd[1]: Finished network-cleanup.service - Network Cleanup. Jul 15 05:16:06.178282 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). Jul 15 05:16:06.178291 systemd[1]: Starting systemd-fsck-usr.service... Jul 15 05:16:06.178300 systemd[1]: Starting systemd-journald.service - Journal Service... Jul 15 05:16:06.178309 systemd[1]: Starting systemd-modules-load.service - Load Kernel Modules... Jul 15 05:16:06.178320 systemd[1]: Starting systemd-vconsole-setup.service - Virtual Console Setup... Jul 15 05:16:06.178349 systemd-journald[232]: Collecting audit messages is disabled. Jul 15 05:16:06.178371 systemd[1]: Finished ignition-setup-pre.service - Ignition env setup. Jul 15 05:16:06.178385 systemd-journald[232]: Journal started Jul 15 05:16:06.178405 systemd-journald[232]: Runtime Journal (/run/log/journal/b351486f3b774476849171732a9055b0) is 8M, max 2.2G, 2.1G free. Jul 15 05:16:06.176181 systemd-modules-load[234]: Inserted module 'overlay' Jul 15 05:16:06.187780 systemd[1]: Started systemd-journald.service - Journal Service. Jul 15 05:16:06.188062 systemd[1]: Finished kmod-static-nodes.service - Create List of Static Device Nodes. Jul 15 05:16:06.188563 systemd[1]: Finished systemd-fsck-usr.service. Jul 15 05:16:06.212671 systemd[1]: Starting systemd-tmpfiles-setup-dev-early.service - Create Static Device Nodes in /dev gracefully... Jul 15 05:16:06.223225 systemd[1]: Starting systemd-tmpfiles-setup.service - Create System Files and Directories... Jul 15 05:16:06.225036 systemd[1]: Finished systemd-vconsole-setup.service - Virtual Console Setup. Jul 15 05:16:06.235044 systemd[1]: Starting dracut-cmdline-ask.service - dracut ask for additional cmdline parameters... Jul 15 05:16:06.247680 systemd[1]: Finished systemd-tmpfiles-setup-dev-early.service - Create Static Device Nodes in /dev gracefully. Jul 15 05:16:06.270781 kernel: bridge: filtering via arp/ip/ip6tables is no longer available by default. Update your scripts to load br_netfilter if you need this. Jul 15 05:16:06.274325 systemd[1]: Starting systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev... Jul 15 05:16:06.276296 kernel: Bridge firewalling registered Jul 15 05:16:06.274878 systemd-modules-load[234]: Inserted module 'br_netfilter' Jul 15 05:16:06.276706 systemd[1]: Finished systemd-modules-load.service - Load Kernel Modules. Jul 15 05:16:06.277962 systemd[1]: Starting systemd-sysctl.service - Apply Kernel Variables... Jul 15 05:16:06.286387 systemd[1]: Finished dracut-cmdline-ask.service - dracut ask for additional cmdline parameters. Jul 15 05:16:06.288796 systemd[1]: Starting dracut-cmdline.service - dracut cmdline hook... Jul 15 05:16:06.289973 systemd-tmpfiles[245]: /usr/lib/tmpfiles.d/var.conf:14: Duplicate line for path "/var/log", ignoring. Jul 15 05:16:06.297714 systemd[1]: Finished systemd-tmpfiles-setup.service - Create System Files and Directories. Jul 15 05:16:06.314551 systemd[1]: Finished systemd-sysctl.service - Apply Kernel Variables. Jul 15 05:16:06.323637 systemd[1]: Finished systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev. Jul 15 05:16:06.327664 systemd[1]: Starting systemd-resolved.service - Network Name Resolution... Jul 15 05:16:06.345826 dracut-cmdline[269]: 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=926b029026d98240a9e8b6527b65fc026ae523bea87c3b77ffd7237bcc7be4fb Jul 15 05:16:06.398150 systemd-resolved[285]: Positive Trust Anchors: Jul 15 05:16:06.398168 systemd-resolved[285]: . IN DS 20326 8 2 e06d44b80b8f1d39a95c0b0d7c65d08458e880409bbc683457104237c7f8ec8d Jul 15 05:16:06.398200 systemd-resolved[285]: 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 Jul 15 05:16:06.400656 systemd-resolved[285]: Defaulting to hostname 'linux'. Jul 15 05:16:06.401650 systemd[1]: Started systemd-resolved.service - Network Name Resolution. Jul 15 05:16:06.411322 systemd[1]: Reached target nss-lookup.target - Host and Network Name Lookups. Jul 15 05:16:06.489788 kernel: SCSI subsystem initialized Jul 15 05:16:06.500783 kernel: Loading iSCSI transport class v2.0-870. Jul 15 05:16:06.512782 kernel: iscsi: registered transport (tcp) Jul 15 05:16:06.535744 kernel: iscsi: registered transport (qla4xxx) Jul 15 05:16:06.535793 kernel: QLogic iSCSI HBA Driver Jul 15 05:16:06.553814 systemd[1]: Starting systemd-network-generator.service - Generate network units from Kernel command line... Jul 15 05:16:06.577121 systemd[1]: Finished systemd-network-generator.service - Generate network units from Kernel command line. Jul 15 05:16:06.588994 systemd[1]: Reached target network-pre.target - Preparation for Network. Jul 15 05:16:06.632145 systemd[1]: Finished dracut-cmdline.service - dracut cmdline hook. Jul 15 05:16:06.634959 systemd[1]: Starting dracut-pre-udev.service - dracut pre-udev hook... Jul 15 05:16:06.704779 kernel: raid6: avx2x4 gen() 31107 MB/s Jul 15 05:16:06.723775 kernel: raid6: avx2x2 gen() 31253 MB/s Jul 15 05:16:06.744869 kernel: raid6: avx2x1 gen() 27020 MB/s Jul 15 05:16:06.744897 kernel: raid6: using algorithm avx2x2 gen() 31253 MB/s Jul 15 05:16:06.767922 kernel: raid6: .... xor() 18536 MB/s, rmw enabled Jul 15 05:16:06.767958 kernel: raid6: using avx2x2 recovery algorithm Jul 15 05:16:06.789782 kernel: xor: automatically using best checksumming function avx Jul 15 05:16:06.949792 kernel: Btrfs loaded, zoned=no, fsverity=no Jul 15 05:16:06.957275 systemd[1]: Finished dracut-pre-udev.service - dracut pre-udev hook. Jul 15 05:16:06.960198 systemd[1]: Starting systemd-udevd.service - Rule-based Manager for Device Events and Files... Jul 15 05:16:06.994372 systemd-udevd[486]: Using default interface naming scheme 'v255'. Jul 15 05:16:07.000420 systemd[1]: Started systemd-udevd.service - Rule-based Manager for Device Events and Files. Jul 15 05:16:07.002588 systemd[1]: Starting dracut-pre-trigger.service - dracut pre-trigger hook... Jul 15 05:16:07.048898 dracut-pre-trigger[494]: rd.md=0: removing MD RAID activation Jul 15 05:16:07.075994 systemd[1]: Finished dracut-pre-trigger.service - dracut pre-trigger hook. Jul 15 05:16:07.078238 systemd[1]: Starting systemd-udev-trigger.service - Coldplug All udev Devices... Jul 15 05:16:07.154699 systemd[1]: Finished systemd-udev-trigger.service - Coldplug All udev Devices. Jul 15 05:16:07.157189 systemd[1]: Starting dracut-initqueue.service - dracut initqueue hook... Jul 15 05:16:07.189861 kernel: cryptd: max_cpu_qlen set to 1000 Jul 15 05:16:07.198804 kernel: AES CTR mode by8 optimization enabled Jul 15 05:16:07.212801 kernel: hv_vmbus: Vmbus version:4.0 Jul 15 05:16:07.220701 systemd[1]: systemd-vconsole-setup.service: Deactivated successfully. Jul 15 05:16:07.243478 kernel: hv_vmbus: registering driver hyperv_keyboard Jul 15 05:16:07.243500 kernel: pps_core: LinuxPPS API ver. 1 registered Jul 15 05:16:07.243513 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 Jul 15 05:16:07.243558 kernel: pps_core: Software ver. 5.3.6 - Copyright 2005-2007 Rodolfo Giometti Jul 15 05:16:07.243668 kernel: hid: raw HID events driver (C) Jiri Kosina Jul 15 05:16:07.243745 kernel: PTP clock support registered Jul 15 05:16:07.243855 kernel: hv_vmbus: registering driver hv_netvsc Jul 15 05:16:07.221454 systemd[1]: Stopped systemd-vconsole-setup.service - Virtual Console Setup. Jul 15 05:16:07.269826 kernel: hv_vmbus: registering driver hid_hyperv Jul 15 05:16:07.269867 kernel: input: Microsoft Vmbus HID-compliant Mouse as /devices/0006:045E:0621.0001/input/input1 Jul 15 05:16:07.269891 kernel: hid-hyperv 0006:045E:0621.0001: input: VIRTUAL HID v0.01 Mouse [Microsoft Vmbus HID-compliant Mouse] on Jul 15 05:16:07.261473 systemd[1]: Stopping systemd-vconsole-setup.service - Virtual Console Setup... Jul 15 05:16:07.282417 systemd[1]: Starting systemd-vconsole-setup.service - Virtual Console Setup... Jul 15 05:16:07.586863 kernel: hv_utils: Registering HyperV Utility Driver Jul 15 05:16:07.586891 kernel: hv_vmbus: registering driver hv_pci Jul 15 05:16:07.586913 kernel: hv_vmbus: registering driver hv_utils Jul 15 05:16:07.586926 kernel: hv_vmbus: registering driver hv_storvsc Jul 15 05:16:07.586937 kernel: scsi host0: storvsc_host_t Jul 15 05:16:07.587108 kernel: hv_pci 47505500-0001-0000-3130-444531444234: PCI VMBus probing: Using version 0x10004 Jul 15 05:16:07.587251 kernel: hv_pci 47505500-0001-0000-3130-444531444234: PCI host bridge to bus 0001:00 Jul 15 05:16:07.587372 kernel: pci_bus 0001:00: root bus resource [mem 0x41000000-0x41ffffff window] Jul 15 05:16:07.587515 kernel: pci_bus 0001:00: root bus resource [mem 0x1000000000-0x1401ffffff window] Jul 15 05:16:07.587635 kernel: pci_bus 0001:00: No busn resource found for root bus, will use [bus 00-ff] Jul 15 05:16:07.587778 kernel: hv_utils: Heartbeat IC version 3.0 Jul 15 05:16:07.587843 kernel: pci 0001:00:00.0: [10de:1db4] type 00 class 0x030200 PCIe Endpoint Jul 15 05:16:07.588004 kernel: pci 0001:00:00.0: BAR 0 [mem 0x41000000-0x41ffffff] Jul 15 05:16:07.588135 kernel: pci 0001:00:00.0: BAR 1 [mem 0x1000000000-0x13ffffffff 64bit pref] Jul 15 05:16:07.588264 kernel: pci 0001:00:00.0: BAR 3 [mem 0x1400000000-0x1401ffffff 64bit pref] Jul 15 05:16:07.588397 kernel: scsi 0:0:0:0: Direct-Access Msft Virtual Disk 1.0 PQ: 0 ANSI: 5 Jul 15 05:16:07.588557 kernel: hv_utils: Shutdown IC version 3.2 Jul 15 05:16:07.588574 kernel: scsi 0:0:0:1: Direct-Access Msft Virtual Disk 1.0 PQ: 0 ANSI: 5 Jul 15 05:16:07.588736 kernel: scsi 0:0:0:2: CD-ROM Msft Virtual DVD-ROM 1.0 PQ: 0 ANSI: 0 Jul 15 05:16:07.588874 kernel: pci 0001:00:00.0: Enabling HDA controller Jul 15 05:16:07.589003 kernel: hv_utils: TimeSync IC version 4.0 Jul 15 05:16:07.589017 kernel: scsi host1: storvsc_host_t Jul 15 05:16:07.589140 kernel: pci_bus 0001:00: busn_res: [bus 00-ff] end is updated to 00 Jul 15 05:16:07.589258 kernel: sd 0:0:0:1: [sda] 1543503872 512-byte logical blocks: (790 GB/736 GiB) Jul 15 05:16:07.589391 kernel: sd 0:0:0:0: [sdb] 63737856 512-byte logical blocks: (32.6 GB/30.4 GiB) Jul 15 05:16:07.589522 kernel: sd 0:0:0:0: [sdb] 4096-byte physical blocks Jul 15 05:16:07.589649 kernel: sd 0:0:0:0: [sdb] Write Protect is off Jul 15 05:16:07.589802 kernel: sd 0:0:0:0: [sdb] Mode Sense: 0f 00 10 00 Jul 15 05:16:07.589932 kernel: sd 0:0:0:0: [sdb] Write cache: disabled, read cache: enabled, supports DPO and FUA Jul 15 05:16:07.590060 kernel: hv_storvsc f8b3781a-1e82-4818-a1c3-63d806ec15bb: tag#564 cmd 0x5a status: scsi 0x2 srb 0x86 hv 0xc0000001 Jul 15 05:16:07.590187 kernel: hv_storvsc f8b3781a-1e82-4818-a1c3-63d806ec15bb: tag#571 cmd 0x5a status: scsi 0x2 srb 0x86 hv 0xc0000001 Jul 15 05:16:07.590304 kernel: pci 0001:00:00.0: BAR 1 [mem 0x1000000000-0x13ffffffff 64bit pref]: assigned Jul 15 05:16:07.590432 kernel: sd 0:0:0:1: [sda] 4096-byte physical blocks Jul 15 05:16:07.590560 kernel: pci 0001:00:00.0: BAR 3 [mem 0x1400000000-0x1401ffffff 64bit pref]: assigned Jul 15 05:16:07.590700 kernel: sd 0:0:0:1: [sda] Write Protect is off Jul 15 05:16:07.590833 kernel: pci 0001:00:00.0: BAR 0 [mem 0x41000000-0x41ffffff]: assigned Jul 15 05:16:07.590960 kernel: sd 0:0:0:1: [sda] Mode Sense: 0f 00 10 00 Jul 15 05:16:07.591093 kernel: sd 0:0:0:1: [sda] Write cache: disabled, read cache: enabled, supports DPO and FUA Jul 15 05:16:07.591222 kernel: hv_storvsc f8b3781a-1e82-4818-a1c3-63d806ec15bb: tag#257 cmd 0x5a status: scsi 0x2 srb 0x86 hv 0xc0000001 Jul 15 05:16:07.591339 kernel: hv_storvsc f8b3781a-1e82-4818-a1c3-63d806ec15bb: tag#261 cmd 0x5a status: scsi 0x2 srb 0x86 hv 0xc0000001 Jul 15 05:16:07.591453 kernel: sdb: sdb1 sdb2 sdb3 sdb4 sdb6 sdb7 sdb9 Jul 15 05:16:07.459309 systemd-resolved[285]: Clock change detected. Flushing caches. Jul 15 05:16:07.606513 kernel: sd 0:0:0:0: [sdb] Attached SCSI disk Jul 15 05:16:07.606752 kernel: sda: sda1 Jul 15 05:16:07.606771 kernel: sd 0:0:0:1: [sda] Attached SCSI disk Jul 15 05:16:07.584816 systemd[1]: run-credentials-systemd\x2dvconsole\x2dsetup.service.mount: Deactivated successfully. Jul 15 05:16:07.593167 systemd[1]: systemd-vconsole-setup.service: Deactivated successfully. Jul 15 05:16:07.625215 kernel: sr 0:0:0:2: [sr0] scsi-1 drive Jul 15 05:16:07.625400 kernel: cdrom: Uniform CD-ROM driver Revision: 3.20 Jul 15 05:16:07.625422 kernel: sr 0:0:0:2: Attached scsi CD-ROM sr0 Jul 15 05:16:07.593271 systemd[1]: Stopped systemd-vconsole-setup.service - Virtual Console Setup. Jul 15 05:16:07.607608 systemd[1]: Starting systemd-vconsole-setup.service - Virtual Console Setup... Jul 15 05:16:07.655722 systemd[1]: Finished systemd-vconsole-setup.service - Virtual Console Setup. Jul 15 05:16:08.210247 systemd[1]: Found device dev-disk-by\x2dlabel-ROOT.device - Virtual_Disk ROOT. Jul 15 05:16:08.238516 systemd[1]: Found device dev-disk-by\x2dpartlabel-USR\x2dA.device - Virtual_Disk USR-A. Jul 15 05:16:08.239993 systemd[1]: Found device dev-disk-by\x2dpartuuid-7130c94a\x2d213a\x2d4e5a\x2d8e26\x2d6cce9662f132.device - Virtual_Disk USR-A. Jul 15 05:16:08.250995 systemd[1]: Starting disk-uuid.service - Generate new UUID for disk GPT if necessary... Jul 15 05:16:08.304205 systemd[1]: Found device dev-disk-by\x2dlabel-OEM.device - Virtual_Disk OEM. Jul 15 05:16:08.357730 systemd[1]: Found device dev-disk-by\x2dlabel-EFI\x2dSYSTEM.device - Virtual_Disk EFI-SYSTEM. Jul 15 05:16:09.299610 kernel: hv_storvsc f8b3781a-1e82-4818-a1c3-63d806ec15bb: tag#534 cmd 0x5a status: scsi 0x2 srb 0x86 hv 0xc0000001 Jul 15 05:16:09.310153 disk-uuid[717]: The operation has completed successfully. Jul 15 05:16:09.313989 kernel: sdb: sdb1 sdb2 sdb3 sdb4 sdb6 sdb7 sdb9 Jul 15 05:16:10.061287 systemd[1]: Finished dracut-initqueue.service - dracut initqueue hook. Jul 15 05:16:10.064375 systemd[1]: disk-uuid.service: Deactivated successfully. Jul 15 05:16:10.064468 systemd[1]: Finished disk-uuid.service - Generate new UUID for disk GPT if necessary. Jul 15 05:16:10.073120 systemd[1]: Reached target remote-fs-pre.target - Preparation for Remote File Systems. Jul 15 05:16:10.080313 systemd[1]: Reached target remote-cryptsetup.target - Remote Encrypted Volumes. Jul 15 05:16:10.093345 systemd[1]: Reached target remote-fs.target - Remote File Systems. Jul 15 05:16:10.103778 systemd[1]: Starting dracut-pre-mount.service - dracut pre-mount hook... Jul 15 05:16:10.109415 systemd[1]: Starting verity-setup.service - Verity Setup for /dev/mapper/usr... Jul 15 05:16:10.160601 sh[888]: Success Jul 15 05:16:10.167841 systemd[1]: Finished dracut-pre-mount.service - dracut pre-mount hook. Jul 15 05:16:10.217271 kernel: device-mapper: core: CONFIG_IMA_DISABLE_HTABLE is disabled. Duplicate IMA measurements will not be recorded in the IMA log. Jul 15 05:16:10.217333 kernel: device-mapper: uevent: version 1.0.3 Jul 15 05:16:10.222700 kernel: device-mapper: ioctl: 4.48.0-ioctl (2023-03-01) initialised: dm-devel@lists.linux.dev Jul 15 05:16:10.233697 kernel: device-mapper: verity: sha256 using shash "sha256-avx2" Jul 15 05:16:10.405240 systemd[1]: Found device dev-mapper-usr.device - /dev/mapper/usr. Jul 15 05:16:10.414978 systemd[1]: Mounting sysusr-usr.mount - /sysusr/usr... Jul 15 05:16:10.450607 systemd[1]: Finished verity-setup.service - Verity Setup for /dev/mapper/usr. Jul 15 05:16:10.471695 kernel: BTRFS info: 'norecovery' is for compatibility only, recommended to use 'rescue=nologreplay' Jul 15 05:16:10.471757 kernel: BTRFS: device fsid eb96c768-dac4-4ca9-ae1d-82815d4ce00b devid 1 transid 36 /dev/mapper/usr (254:0) scanned by mount (913) Jul 15 05:16:10.478698 kernel: BTRFS info (device dm-0): first mount of filesystem eb96c768-dac4-4ca9-ae1d-82815d4ce00b Jul 15 05:16:10.487071 kernel: BTRFS info (device dm-0): using crc32c (crc32c-intel) checksum algorithm Jul 15 05:16:10.490350 kernel: BTRFS info (device dm-0): using free-space-tree Jul 15 05:16:10.775911 systemd[1]: Mounted sysusr-usr.mount - /sysusr/usr. Jul 15 05:16:10.777916 systemd[1]: Reached target initrd-usr-fs.target - Initrd /usr File System. Jul 15 05:16:10.784267 systemd[1]: afterburn-network-kargs.service - Afterburn Initrd Setup Network Kernel Arguments was skipped because no trigger condition checks were met. Jul 15 05:16:10.785143 systemd[1]: Starting ignition-setup.service - Ignition (setup)... Jul 15 05:16:10.812223 systemd[1]: Starting parse-ip-for-networkd.service - Write systemd-networkd units from cmdline... Jul 15 05:16:10.844943 kernel: BTRFS: device label OEM devid 1 transid 12 /dev/sdb6 (8:22) scanned by mount (944) Jul 15 05:16:10.844980 kernel: BTRFS info (device sdb6): first mount of filesystem 86e7a055-b4ff-48a6-9a0a-c301ff74862f Jul 15 05:16:10.849171 kernel: BTRFS info (device sdb6): using crc32c (crc32c-intel) checksum algorithm Jul 15 05:16:10.852466 kernel: BTRFS info (device sdb6): using free-space-tree Jul 15 05:16:10.874700 kernel: BTRFS info (device sdb6): last unmount of filesystem 86e7a055-b4ff-48a6-9a0a-c301ff74862f Jul 15 05:16:10.875368 systemd[1]: Finished ignition-setup.service - Ignition (setup). Jul 15 05:16:10.883748 systemd[1]: Starting ignition-fetch-offline.service - Ignition (fetch-offline)... Jul 15 05:16:10.928522 systemd[1]: Finished parse-ip-for-networkd.service - Write systemd-networkd units from cmdline. Jul 15 05:16:10.931544 systemd[1]: Starting systemd-networkd.service - Network Configuration... Jul 15 05:16:10.975958 systemd-networkd[1082]: lo: Link UP Jul 15 05:16:10.975968 systemd-networkd[1082]: lo: Gained carrier Jul 15 05:16:10.977045 systemd-networkd[1082]: Enumeration completed Jul 15 05:16:10.977127 systemd[1]: Started systemd-networkd.service - Network Configuration. Jul 15 05:16:10.977404 systemd-networkd[1082]: eth0: found matching network '/usr/lib/systemd/network/zz-default.network', based on potentially unpredictable interface name. Jul 15 05:16:10.977408 systemd-networkd[1082]: eth0: Configuring with /usr/lib/systemd/network/zz-default.network. Jul 15 05:16:10.978210 systemd-networkd[1082]: eth0: Link UP Jul 15 05:16:10.978372 systemd-networkd[1082]: eth0: Gained carrier Jul 15 05:16:10.978381 systemd-networkd[1082]: eth0: found matching network '/usr/lib/systemd/network/zz-default.network', based on potentially unpredictable interface name. Jul 15 05:16:10.983069 systemd[1]: Reached target network.target - Network. Jul 15 05:16:11.046714 systemd-networkd[1082]: eth0: DHCPv4 address 10.200.8.11/24, gateway 10.200.8.1 acquired from 168.63.129.16 Jul 15 05:16:12.115384 ignition[1039]: Ignition 2.21.0 Jul 15 05:16:12.115399 ignition[1039]: Stage: fetch-offline Jul 15 05:16:12.115512 ignition[1039]: no configs at "/usr/lib/ignition/base.d" Jul 15 05:16:12.115522 ignition[1039]: no config dir at "/usr/lib/ignition/base.platform.d/azure" Jul 15 05:16:12.115623 ignition[1039]: parsed url from cmdline: "" Jul 15 05:16:12.115628 ignition[1039]: no config URL provided Jul 15 05:16:12.115633 ignition[1039]: reading system config file "/usr/lib/ignition/user.ign" Jul 15 05:16:12.115642 ignition[1039]: no config at "/usr/lib/ignition/user.ign" Jul 15 05:16:12.115648 ignition[1039]: failed to fetch config: resource requires networking Jul 15 05:16:12.140282 systemd[1]: Finished ignition-fetch-offline.service - Ignition (fetch-offline). Jul 15 05:16:12.115848 ignition[1039]: Ignition finished successfully Jul 15 05:16:12.143065 systemd[1]: Starting ignition-fetch.service - Ignition (fetch)... Jul 15 05:16:12.189694 ignition[1095]: Ignition 2.21.0 Jul 15 05:16:12.189707 ignition[1095]: Stage: fetch Jul 15 05:16:12.189979 ignition[1095]: no configs at "/usr/lib/ignition/base.d" Jul 15 05:16:12.189991 ignition[1095]: no config dir at "/usr/lib/ignition/base.platform.d/azure" Jul 15 05:16:12.190105 ignition[1095]: parsed url from cmdline: "" Jul 15 05:16:12.190109 ignition[1095]: no config URL provided Jul 15 05:16:12.190115 ignition[1095]: reading system config file "/usr/lib/ignition/user.ign" Jul 15 05:16:12.190124 ignition[1095]: no config at "/usr/lib/ignition/user.ign" Jul 15 05:16:12.190156 ignition[1095]: GET http://169.254.169.254/metadata/instance/compute/userData?api-version=2021-01-01&format=text: attempt #1 Jul 15 05:16:12.283254 ignition[1095]: GET result: OK Jul 15 05:16:12.283302 ignition[1095]: config has been read from IMDS userdata Jul 15 05:16:12.283327 ignition[1095]: parsing config with SHA512: 988103deb30238f101eaf0d7495bccc4feb622f760f1ce4100781eed0b8448fa67b948d51322fb6f74bdfd4cf2f0d7212dcacd5e281011c316511908e3d3a8bb Jul 15 05:16:12.289306 unknown[1095]: fetched base config from "system" Jul 15 05:16:12.289317 unknown[1095]: fetched base config from "system" Jul 15 05:16:12.289476 ignition[1095]: fetch: fetch complete Jul 15 05:16:12.289322 unknown[1095]: fetched user config from "azure" Jul 15 05:16:12.289482 ignition[1095]: fetch: fetch passed Jul 15 05:16:12.298467 systemd[1]: Finished ignition-fetch.service - Ignition (fetch). Jul 15 05:16:12.289527 ignition[1095]: Ignition finished successfully Jul 15 05:16:12.301339 systemd[1]: Starting ignition-kargs.service - Ignition (kargs)... Jul 15 05:16:12.340494 ignition[1105]: Ignition 2.21.0 Jul 15 05:16:12.340528 ignition[1105]: Stage: kargs Jul 15 05:16:12.340878 ignition[1105]: no configs at "/usr/lib/ignition/base.d" Jul 15 05:16:12.340896 ignition[1105]: no config dir at "/usr/lib/ignition/base.platform.d/azure" Jul 15 05:16:12.341547 ignition[1105]: kargs: kargs passed Jul 15 05:16:12.349302 systemd[1]: Finished ignition-kargs.service - Ignition (kargs). Jul 15 05:16:12.341595 ignition[1105]: Ignition finished successfully Jul 15 05:16:12.351689 systemd[1]: Starting ignition-disks.service - Ignition (disks)... Jul 15 05:16:12.376778 systemd-networkd[1082]: eth0: Gained IPv6LL Jul 15 05:16:12.393228 ignition[1114]: Ignition 2.21.0 Jul 15 05:16:12.393241 ignition[1114]: Stage: disks Jul 15 05:16:12.393631 ignition[1114]: no configs at "/usr/lib/ignition/base.d" Jul 15 05:16:12.393646 ignition[1114]: no config dir at "/usr/lib/ignition/base.platform.d/azure" Jul 15 05:16:12.398867 systemd[1]: Finished ignition-disks.service - Ignition (disks). Jul 15 05:16:12.394673 ignition[1114]: disks: disks passed Jul 15 05:16:12.405038 systemd[1]: Reached target initrd-root-device.target - Initrd Root Device. Jul 15 05:16:12.394748 ignition[1114]: Ignition finished successfully Jul 15 05:16:12.406955 systemd[1]: Reached target local-fs-pre.target - Preparation for Local File Systems. Jul 15 05:16:12.418549 systemd[1]: Reached target local-fs.target - Local File Systems. Jul 15 05:16:12.425841 systemd[1]: Reached target sysinit.target - System Initialization. Jul 15 05:16:12.434505 systemd[1]: Reached target basic.target - Basic System. Jul 15 05:16:12.442665 systemd[1]: Starting systemd-fsck-root.service - File System Check on /dev/disk/by-label/ROOT... Jul 15 05:16:12.634592 systemd-fsck[1126]: ROOT: clean, 15/7326000 files, 477845/7359488 blocks Jul 15 05:16:12.641813 systemd[1]: Finished systemd-fsck-root.service - File System Check on /dev/disk/by-label/ROOT. Jul 15 05:16:12.644100 systemd[1]: Mounting sysroot.mount - /sysroot... Jul 15 05:16:12.876695 kernel: EXT4-fs (sdb9): mounted filesystem 277c3938-5262-4ab1-8fa3-62fde82f8257 r/w with ordered data mode. Quota mode: none. Jul 15 05:16:12.877429 systemd[1]: Mounted sysroot.mount - /sysroot. Jul 15 05:16:12.879488 systemd[1]: Reached target initrd-root-fs.target - Initrd Root File System. Jul 15 05:16:12.897632 systemd[1]: Mounting sysroot-oem.mount - /sysroot/oem... Jul 15 05:16:12.904032 systemd[1]: Mounting sysroot-usr.mount - /sysroot/usr... Jul 15 05:16:12.923222 systemd[1]: Starting flatcar-metadata-hostname.service - Flatcar Metadata Hostname Agent... Jul 15 05:16:12.927897 systemd[1]: ignition-remount-sysroot.service - Remount /sysroot read-write for Ignition was skipped because of an unmet condition check (ConditionPathIsReadWrite=!/sysroot). Jul 15 05:16:12.954941 kernel: BTRFS: device label OEM devid 1 transid 12 /dev/sdb6 (8:22) scanned by mount (1141) Jul 15 05:16:12.954970 kernel: BTRFS info (device sdb6): first mount of filesystem 86e7a055-b4ff-48a6-9a0a-c301ff74862f Jul 15 05:16:12.954983 kernel: BTRFS info (device sdb6): using crc32c (crc32c-intel) checksum algorithm Jul 15 05:16:12.954995 kernel: BTRFS info (device sdb6): using free-space-tree Jul 15 05:16:12.927929 systemd[1]: Reached target ignition-diskful.target - Ignition Boot Disk Setup. Jul 15 05:16:12.954771 systemd[1]: Mounted sysroot-usr.mount - /sysroot/usr. Jul 15 05:16:12.966996 systemd[1]: Starting initrd-setup-root.service - Root filesystem setup... Jul 15 05:16:12.975657 systemd[1]: Mounted sysroot-oem.mount - /sysroot/oem. Jul 15 05:16:13.546237 coreos-metadata[1143]: Jul 15 05:16:13.546 INFO Fetching http://168.63.129.16/?comp=versions: Attempt #1 Jul 15 05:16:13.554135 coreos-metadata[1143]: Jul 15 05:16:13.554 INFO Fetch successful Jul 15 05:16:13.557914 coreos-metadata[1143]: Jul 15 05:16:13.554 INFO Fetching http://169.254.169.254/metadata/instance/compute/name?api-version=2017-08-01&format=text: Attempt #1 Jul 15 05:16:13.565825 coreos-metadata[1143]: Jul 15 05:16:13.561 INFO Fetch successful Jul 15 05:16:13.573265 coreos-metadata[1143]: Jul 15 05:16:13.573 INFO wrote hostname ci-4396.0.0-n-957ef44c1e to /sysroot/etc/hostname Jul 15 05:16:13.580736 systemd[1]: Finished flatcar-metadata-hostname.service - Flatcar Metadata Hostname Agent. Jul 15 05:16:14.120986 initrd-setup-root[1171]: cut: /sysroot/etc/passwd: No such file or directory Jul 15 05:16:14.330466 initrd-setup-root[1178]: cut: /sysroot/etc/group: No such file or directory Jul 15 05:16:14.337804 initrd-setup-root[1185]: cut: /sysroot/etc/shadow: No such file or directory Jul 15 05:16:14.394228 initrd-setup-root[1192]: cut: /sysroot/etc/gshadow: No such file or directory Jul 15 05:16:15.587401 systemd[1]: Finished initrd-setup-root.service - Root filesystem setup. Jul 15 05:16:15.590376 systemd[1]: Starting ignition-mount.service - Ignition (mount)... Jul 15 05:16:15.616415 systemd[1]: Starting sysroot-boot.service - /sysroot/boot... Jul 15 05:16:15.623407 systemd[1]: sysroot-oem.mount: Deactivated successfully. Jul 15 05:16:15.632767 kernel: BTRFS info (device sdb6): last unmount of filesystem 86e7a055-b4ff-48a6-9a0a-c301ff74862f Jul 15 05:16:15.659766 ignition[1261]: INFO : Ignition 2.21.0 Jul 15 05:16:15.659766 ignition[1261]: INFO : Stage: mount Jul 15 05:16:15.665070 ignition[1261]: INFO : no configs at "/usr/lib/ignition/base.d" Jul 15 05:16:15.665070 ignition[1261]: INFO : no config dir at "/usr/lib/ignition/base.platform.d/azure" Jul 15 05:16:15.665070 ignition[1261]: INFO : mount: mount passed Jul 15 05:16:15.665070 ignition[1261]: INFO : Ignition finished successfully Jul 15 05:16:15.664492 systemd[1]: Finished sysroot-boot.service - /sysroot/boot. Jul 15 05:16:15.669321 systemd[1]: Finished ignition-mount.service - Ignition (mount). Jul 15 05:16:15.680884 systemd[1]: Starting ignition-files.service - Ignition (files)... Jul 15 05:16:15.714783 systemd[1]: Mounting sysroot-oem.mount - /sysroot/oem... Jul 15 05:16:15.737769 kernel: BTRFS: device label OEM devid 1 transid 12 /dev/sdb6 (8:22) scanned by mount (1276) Jul 15 05:16:15.737823 kernel: BTRFS info (device sdb6): first mount of filesystem 86e7a055-b4ff-48a6-9a0a-c301ff74862f Jul 15 05:16:15.741912 kernel: BTRFS info (device sdb6): using crc32c (crc32c-intel) checksum algorithm Jul 15 05:16:15.745084 kernel: BTRFS info (device sdb6): using free-space-tree Jul 15 05:16:15.749289 systemd[1]: Mounted sysroot-oem.mount - /sysroot/oem. Jul 15 05:16:15.786689 ignition[1293]: INFO : Ignition 2.21.0 Jul 15 05:16:15.786689 ignition[1293]: INFO : Stage: files Jul 15 05:16:15.792788 ignition[1293]: INFO : no configs at "/usr/lib/ignition/base.d" Jul 15 05:16:15.792788 ignition[1293]: INFO : no config dir at "/usr/lib/ignition/base.platform.d/azure" Jul 15 05:16:15.792788 ignition[1293]: DEBUG : files: compiled without relabeling support, skipping Jul 15 05:16:15.805473 ignition[1293]: INFO : files: ensureUsers: op(1): [started] creating or modifying user "core" Jul 15 05:16:15.805473 ignition[1293]: DEBUG : files: ensureUsers: op(1): executing: "usermod" "--root" "/sysroot" "core" Jul 15 05:16:15.870355 ignition[1293]: INFO : files: ensureUsers: op(1): [finished] creating or modifying user "core" Jul 15 05:16:15.875700 ignition[1293]: INFO : files: ensureUsers: op(2): [started] adding ssh keys to user "core" Jul 15 05:16:15.875700 ignition[1293]: INFO : files: ensureUsers: op(2): [finished] adding ssh keys to user "core" Jul 15 05:16:15.871199 unknown[1293]: wrote ssh authorized keys file for user: core Jul 15 05:16:15.892199 ignition[1293]: INFO : files: createFilesystemsFiles: createFiles: op(3): [started] writing file "/sysroot/etc/flatcar/update.conf" Jul 15 05:16:15.892199 ignition[1293]: INFO : files: createFilesystemsFiles: createFiles: op(3): [finished] writing file "/sysroot/etc/flatcar/update.conf" Jul 15 05:16:15.892199 ignition[1293]: INFO : files: createResultFile: createFiles: op(4): [started] writing file "/sysroot/etc/.ignition-result.json" Jul 15 05:16:15.892199 ignition[1293]: INFO : files: createResultFile: createFiles: op(4): [finished] writing file "/sysroot/etc/.ignition-result.json" Jul 15 05:16:15.892199 ignition[1293]: INFO : files: files passed Jul 15 05:16:15.892199 ignition[1293]: INFO : Ignition finished successfully Jul 15 05:16:15.882163 systemd[1]: Finished ignition-files.service - Ignition (files). Jul 15 05:16:15.891755 systemd[1]: Starting ignition-quench.service - Ignition (record completion)... Jul 15 05:16:15.898775 systemd[1]: Starting initrd-setup-root-after-ignition.service - Root filesystem completion... Jul 15 05:16:15.943523 systemd[1]: ignition-quench.service: Deactivated successfully. Jul 15 05:16:15.943614 systemd[1]: Finished ignition-quench.service - Ignition (record completion). Jul 15 05:16:15.977434 initrd-setup-root-after-ignition[1325]: grep: /sysroot/etc/flatcar/enabled-sysext.conf: No such file or directory Jul 15 05:16:15.983284 initrd-setup-root-after-ignition[1325]: grep: /sysroot/usr/share/flatcar/enabled-sysext.conf: No such file or directory Jul 15 05:16:15.989423 initrd-setup-root-after-ignition[1329]: grep: /sysroot/etc/flatcar/enabled-sysext.conf: No such file or directory Jul 15 05:16:15.995937 systemd[1]: Finished initrd-setup-root-after-ignition.service - Root filesystem completion. Jul 15 05:16:15.997588 systemd[1]: Reached target ignition-complete.target - Ignition Complete. Jul 15 05:16:16.008339 systemd[1]: Starting initrd-parse-etc.service - Mountpoints Configured in the Real Root... Jul 15 05:16:16.056221 systemd[1]: initrd-parse-etc.service: Deactivated successfully. Jul 15 05:16:16.056335 systemd[1]: Finished initrd-parse-etc.service - Mountpoints Configured in the Real Root. Jul 15 05:16:16.065083 systemd[1]: Reached target initrd-fs.target - Initrd File Systems. Jul 15 05:16:16.074403 systemd[1]: Reached target initrd.target - Initrd Default Target. Jul 15 05:16:16.082209 systemd[1]: dracut-mount.service - dracut mount hook was skipped because no trigger condition checks were met. Jul 15 05:16:16.083040 systemd[1]: Starting dracut-pre-pivot.service - dracut pre-pivot and cleanup hook... Jul 15 05:16:16.120805 systemd[1]: Finished dracut-pre-pivot.service - dracut pre-pivot and cleanup hook. Jul 15 05:16:16.122795 systemd[1]: Starting initrd-cleanup.service - Cleaning Up and Shutting Down Daemons... Jul 15 05:16:16.157671 systemd[1]: Stopped target nss-lookup.target - Host and Network Name Lookups. Jul 15 05:16:16.158555 systemd[1]: Stopped target remote-cryptsetup.target - Remote Encrypted Volumes. Jul 15 05:16:16.171222 systemd[1]: Stopped target timers.target - Timer Units. Jul 15 05:16:16.179004 systemd[1]: dracut-pre-pivot.service: Deactivated successfully. Jul 15 05:16:16.179119 systemd[1]: Stopped dracut-pre-pivot.service - dracut pre-pivot and cleanup hook. Jul 15 05:16:16.190570 systemd[1]: Stopped target initrd.target - Initrd Default Target. Jul 15 05:16:16.198632 systemd[1]: Stopped target basic.target - Basic System. Jul 15 05:16:16.205758 systemd[1]: Stopped target ignition-complete.target - Ignition Complete. Jul 15 05:16:16.213161 systemd[1]: Stopped target ignition-diskful.target - Ignition Boot Disk Setup. Jul 15 05:16:16.221736 systemd[1]: Stopped target initrd-root-device.target - Initrd Root Device. Jul 15 05:16:16.230391 systemd[1]: Stopped target initrd-usr-fs.target - Initrd /usr File System. Jul 15 05:16:16.238959 systemd[1]: Stopped target remote-fs.target - Remote File Systems. Jul 15 05:16:16.241185 systemd[1]: Stopped target remote-fs-pre.target - Preparation for Remote File Systems. Jul 15 05:16:16.242547 systemd[1]: Stopped target sysinit.target - System Initialization. Jul 15 05:16:16.268411 systemd[1]: Stopped target local-fs.target - Local File Systems. Jul 15 05:16:16.276563 systemd[1]: Stopped target swap.target - Swaps. Jul 15 05:16:16.278095 systemd[1]: dracut-pre-mount.service: Deactivated successfully. Jul 15 05:16:16.278235 systemd[1]: Stopped dracut-pre-mount.service - dracut pre-mount hook. Jul 15 05:16:16.290633 systemd[1]: Stopped target cryptsetup.target - Local Encrypted Volumes. Jul 15 05:16:16.292096 systemd[1]: Stopped target cryptsetup-pre.target - Local Encrypted Volumes (Pre). Jul 15 05:16:16.300094 systemd[1]: clevis-luks-askpass.path: Deactivated successfully. Jul 15 05:16:16.300222 systemd[1]: Stopped clevis-luks-askpass.path - Forward Password Requests to Clevis Directory Watch. Jul 15 05:16:16.308716 systemd[1]: dracut-initqueue.service: Deactivated successfully. Jul 15 05:16:16.308834 systemd[1]: Stopped dracut-initqueue.service - dracut initqueue hook. Jul 15 05:16:16.336638 systemd[1]: initrd-setup-root-after-ignition.service: Deactivated successfully. Jul 15 05:16:16.336792 systemd[1]: Stopped initrd-setup-root-after-ignition.service - Root filesystem completion. Jul 15 05:16:16.345818 systemd[1]: ignition-files.service: Deactivated successfully. Jul 15 05:16:16.345936 systemd[1]: Stopped ignition-files.service - Ignition (files). Jul 15 05:16:16.354605 systemd[1]: flatcar-metadata-hostname.service: Deactivated successfully. Jul 15 05:16:16.354732 systemd[1]: Stopped flatcar-metadata-hostname.service - Flatcar Metadata Hostname Agent. Jul 15 05:16:16.363979 systemd[1]: Stopping ignition-mount.service - Ignition (mount)... Jul 15 05:16:16.370515 systemd[1]: Stopping sysroot-boot.service - /sysroot/boot... Jul 15 05:16:16.377142 systemd[1]: systemd-udev-trigger.service: Deactivated successfully. Jul 15 05:16:16.377272 systemd[1]: Stopped systemd-udev-trigger.service - Coldplug All udev Devices. Jul 15 05:16:16.420484 ignition[1349]: INFO : Ignition 2.21.0 Jul 15 05:16:16.420484 ignition[1349]: INFO : Stage: umount Jul 15 05:16:16.420484 ignition[1349]: INFO : no configs at "/usr/lib/ignition/base.d" Jul 15 05:16:16.420484 ignition[1349]: INFO : no config dir at "/usr/lib/ignition/base.platform.d/azure" Jul 15 05:16:16.420484 ignition[1349]: INFO : umount: umount passed Jul 15 05:16:16.420484 ignition[1349]: INFO : Ignition finished successfully Jul 15 05:16:16.386502 systemd[1]: dracut-pre-trigger.service: Deactivated successfully. Jul 15 05:16:16.386615 systemd[1]: Stopped dracut-pre-trigger.service - dracut pre-trigger hook. Jul 15 05:16:16.398780 systemd[1]: initrd-cleanup.service: Deactivated successfully. Jul 15 05:16:16.398882 systemd[1]: Finished initrd-cleanup.service - Cleaning Up and Shutting Down Daemons. Jul 15 05:16:16.406691 systemd[1]: sysroot-boot.mount: Deactivated successfully. Jul 15 05:16:16.409430 systemd[1]: ignition-mount.service: Deactivated successfully. Jul 15 05:16:16.409557 systemd[1]: Stopped ignition-mount.service - Ignition (mount). Jul 15 05:16:16.412225 systemd[1]: ignition-disks.service: Deactivated successfully. Jul 15 05:16:16.412281 systemd[1]: Stopped ignition-disks.service - Ignition (disks). Jul 15 05:16:16.421852 systemd[1]: ignition-kargs.service: Deactivated successfully. Jul 15 05:16:16.421903 systemd[1]: Stopped ignition-kargs.service - Ignition (kargs). Jul 15 05:16:16.430801 systemd[1]: ignition-fetch.service: Deactivated successfully. Jul 15 05:16:16.430847 systemd[1]: Stopped ignition-fetch.service - Ignition (fetch). Jul 15 05:16:16.434496 systemd[1]: Stopped target network.target - Network. Jul 15 05:16:16.452062 systemd[1]: ignition-fetch-offline.service: Deactivated successfully. Jul 15 05:16:16.452121 systemd[1]: Stopped ignition-fetch-offline.service - Ignition (fetch-offline). Jul 15 05:16:16.460053 systemd[1]: Stopped target paths.target - Path Units. Jul 15 05:16:16.466984 systemd[1]: systemd-ask-password-console.path: Deactivated successfully. Jul 15 05:16:16.471726 systemd[1]: Stopped systemd-ask-password-console.path - Dispatch Password Requests to Console Directory Watch. Jul 15 05:16:16.479637 systemd[1]: Stopped target slices.target - Slice Units. Jul 15 05:16:16.487850 systemd[1]: Stopped target sockets.target - Socket Units. Jul 15 05:16:16.489302 systemd[1]: iscsid.socket: Deactivated successfully. Jul 15 05:16:16.489389 systemd[1]: Closed iscsid.socket - Open-iSCSI iscsid Socket. Jul 15 05:16:16.500148 systemd[1]: iscsiuio.socket: Deactivated successfully. Jul 15 05:16:16.500192 systemd[1]: Closed iscsiuio.socket - Open-iSCSI iscsiuio Socket. Jul 15 05:16:16.506744 systemd[1]: ignition-setup.service: Deactivated successfully. Jul 15 05:16:16.506799 systemd[1]: Stopped ignition-setup.service - Ignition (setup). Jul 15 05:16:16.516879 systemd[1]: ignition-setup-pre.service: Deactivated successfully. Jul 15 05:16:16.516926 systemd[1]: Stopped ignition-setup-pre.service - Ignition env setup. Jul 15 05:16:16.524649 systemd[1]: Stopping systemd-networkd.service - Network Configuration... Jul 15 05:16:16.531832 systemd[1]: Stopping systemd-resolved.service - Network Name Resolution... Jul 15 05:16:16.539654 systemd[1]: sysroot-boot.service: Deactivated successfully. Jul 15 05:16:16.539785 systemd[1]: Stopped sysroot-boot.service - /sysroot/boot. Jul 15 05:16:16.547106 systemd[1]: initrd-setup-root.service: Deactivated successfully. Jul 15 05:16:16.547168 systemd[1]: Stopped initrd-setup-root.service - Root filesystem setup. Jul 15 05:16:16.557510 systemd[1]: systemd-resolved.service: Deactivated successfully. Jul 15 05:16:16.557639 systemd[1]: Stopped systemd-resolved.service - Network Name Resolution. Jul 15 05:16:16.569960 systemd[1]: systemd-networkd.service: Deactivated successfully. Jul 15 05:16:16.570083 systemd[1]: Stopped systemd-networkd.service - Network Configuration. Jul 15 05:16:16.582268 systemd[1]: Stopped target network-pre.target - Preparation for Network. Jul 15 05:16:16.590725 systemd[1]: systemd-networkd.socket: Deactivated successfully. Jul 15 05:16:16.590769 systemd[1]: Closed systemd-networkd.socket - Network Service Netlink Socket. Jul 15 05:16:16.598982 systemd[1]: Stopping network-cleanup.service - Network Cleanup... Jul 15 05:16:16.605178 systemd[1]: parse-ip-for-networkd.service: Deactivated successfully. Jul 15 05:16:16.605232 systemd[1]: Stopped parse-ip-for-networkd.service - Write systemd-networkd units from cmdline. Jul 15 05:16:16.613231 systemd[1]: systemd-sysctl.service: Deactivated successfully. Jul 15 05:16:16.613276 systemd[1]: Stopped systemd-sysctl.service - Apply Kernel Variables. Jul 15 05:16:16.623995 systemd[1]: systemd-modules-load.service: Deactivated successfully. Jul 15 05:16:16.624041 systemd[1]: Stopped systemd-modules-load.service - Load Kernel Modules. Jul 15 05:16:16.631720 systemd[1]: systemd-tmpfiles-setup.service: Deactivated successfully. Jul 15 05:16:16.631771 systemd[1]: Stopped systemd-tmpfiles-setup.service - Create System Files and Directories. Jul 15 05:16:16.643501 systemd[1]: Stopping systemd-udevd.service - Rule-based Manager for Device Events and Files... Jul 15 05:16:16.653154 systemd[1]: run-credentials-systemd\x2dsysctl.service.mount: Deactivated successfully. Jul 15 05:16:16.653214 systemd[1]: run-credentials-systemd\x2dnetworkd.service.mount: Deactivated successfully. Jul 15 05:16:16.653258 systemd[1]: run-credentials-systemd\x2dresolved.service.mount: Deactivated successfully. Jul 15 05:16:16.653299 systemd[1]: run-credentials-systemd\x2dtmpfiles\x2dsetup.service.mount: Deactivated successfully. Jul 15 05:16:16.683226 systemd[1]: systemd-udevd.service: Deactivated successfully. Jul 15 05:16:16.683386 systemd[1]: Stopped systemd-udevd.service - Rule-based Manager for Device Events and Files. Jul 15 05:16:16.691793 systemd[1]: network-cleanup.service: Deactivated successfully. Jul 15 05:16:16.691884 systemd[1]: Stopped network-cleanup.service - Network Cleanup. Jul 15 05:16:16.699757 systemd[1]: systemd-udevd-control.socket: Deactivated successfully. Jul 15 05:16:16.699811 systemd[1]: Closed systemd-udevd-control.socket - udev Control Socket. Jul 15 05:16:16.701454 systemd[1]: systemd-udevd-kernel.socket: Deactivated successfully. Jul 15 05:16:16.701493 systemd[1]: Closed systemd-udevd-kernel.socket - udev Kernel Socket. Jul 15 05:16:16.712262 systemd[1]: dracut-pre-udev.service: Deactivated successfully. Jul 15 05:16:16.712312 systemd[1]: Stopped dracut-pre-udev.service - dracut pre-udev hook. Jul 15 05:16:16.726355 systemd[1]: dracut-cmdline.service: Deactivated successfully. Jul 15 05:16:16.726402 systemd[1]: Stopped dracut-cmdline.service - dracut cmdline hook. Jul 15 05:16:16.738007 systemd[1]: dracut-cmdline-ask.service: Deactivated successfully. Jul 15 05:16:16.738064 systemd[1]: Stopped dracut-cmdline-ask.service - dracut ask for additional cmdline parameters. Jul 15 05:16:16.752278 systemd[1]: Starting initrd-udevadm-cleanup-db.service - Cleanup udev Database... Jul 15 05:16:16.759270 systemd[1]: systemd-network-generator.service: Deactivated successfully. Jul 15 05:16:16.759321 systemd[1]: Stopped systemd-network-generator.service - Generate network units from Kernel command line. Jul 15 05:16:16.772575 systemd[1]: systemd-tmpfiles-setup-dev.service: Deactivated successfully. Jul 15 05:16:16.772625 systemd[1]: Stopped systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev. Jul 15 05:16:16.782226 systemd[1]: systemd-tmpfiles-setup-dev-early.service: Deactivated successfully. Jul 15 05:16:16.782270 systemd[1]: Stopped systemd-tmpfiles-setup-dev-early.service - Create Static Device Nodes in /dev gracefully. Jul 15 05:16:16.791046 systemd[1]: kmod-static-nodes.service: Deactivated successfully. Jul 15 05:16:16.791090 systemd[1]: Stopped kmod-static-nodes.service - Create List of Static Device Nodes. Jul 15 05:16:16.799904 systemd[1]: systemd-vconsole-setup.service: Deactivated successfully. Jul 15 05:16:16.799948 systemd[1]: Stopped systemd-vconsole-setup.service - Virtual Console Setup. Jul 15 05:16:16.814873 systemd[1]: run-credentials-systemd\x2dnetwork\x2dgenerator.service.mount: Deactivated successfully. Jul 15 05:16:16.814927 systemd[1]: run-credentials-systemd\x2dtmpfiles\x2dsetup\x2ddev\x2dearly.service.mount: Deactivated successfully. Jul 15 05:16:16.814962 systemd[1]: run-credentials-systemd\x2dtmpfiles\x2dsetup\x2ddev.service.mount: Deactivated successfully. Jul 15 05:16:16.815004 systemd[1]: run-credentials-systemd\x2dvconsole\x2dsetup.service.mount: Deactivated successfully. Jul 15 05:16:16.815385 systemd[1]: initrd-udevadm-cleanup-db.service: Deactivated successfully. Jul 15 05:16:16.815476 systemd[1]: Finished initrd-udevadm-cleanup-db.service - Cleanup udev Database. Jul 15 05:16:16.820391 systemd[1]: Reached target initrd-switch-root.target - Switch Root. Jul 15 05:16:16.829352 systemd[1]: Starting initrd-switch-root.service - Switch Root... Jul 15 05:16:16.989781 systemd-journald[232]: Received SIGTERM from PID 1 (systemd). Jul 15 05:16:16.864885 systemd[1]: Switching root. Jul 15 05:16:16.992459 systemd-journald[232]: Journal stopped Jul 15 05:16:22.890033 kernel: SELinux: policy capability network_peer_controls=1 Jul 15 05:16:22.890070 kernel: SELinux: policy capability open_perms=1 Jul 15 05:16:22.890082 kernel: SELinux: policy capability extended_socket_class=1 Jul 15 05:16:22.890092 kernel: SELinux: policy capability always_check_network=0 Jul 15 05:16:22.890101 kernel: SELinux: policy capability cgroup_seclabel=1 Jul 15 05:16:22.890110 kernel: SELinux: policy capability nnp_nosuid_transition=1 Jul 15 05:16:22.890120 kernel: SELinux: policy capability genfs_seclabel_symlinks=0 Jul 15 05:16:22.890133 kernel: SELinux: policy capability ioctl_skip_cloexec=0 Jul 15 05:16:22.890142 kernel: SELinux: policy capability userspace_initial_context=0 Jul 15 05:16:22.890152 kernel: audit: type=1403 audit(1752556578.140:2): auid=4294967295 ses=4294967295 lsm=selinux res=1 Jul 15 05:16:22.890164 systemd[1]: Successfully loaded SELinux policy in 394.908ms. Jul 15 05:16:22.890176 systemd[1]: Relabeled /dev/, /dev/shm/, /run/ in 7.915ms. Jul 15 05:16:22.890187 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) Jul 15 05:16:22.890198 systemd[1]: Detected virtualization microsoft. Jul 15 05:16:22.890211 systemd[1]: Detected architecture x86-64. Jul 15 05:16:22.890222 systemd[1]: Detected first boot. Jul 15 05:16:22.890233 systemd[1]: Hostname set to . Jul 15 05:16:22.890243 systemd[1]: Initializing machine ID from random generator. Jul 15 05:16:22.890253 zram_generator::config[1393]: No configuration found. Jul 15 05:16:22.890268 kernel: Guest personality initialized and is inactive Jul 15 05:16:22.890278 kernel: VMCI host device registered (name=vmci, major=10, minor=124) Jul 15 05:16:22.890292 kernel: Initialized host personality Jul 15 05:16:22.890301 kernel: NET: Registered PF_VSOCK protocol family Jul 15 05:16:22.890312 systemd[1]: Populated /etc with preset unit settings. Jul 15 05:16:22.890323 systemd[1]: run-credentials-systemd\x2djournald.service.mount: Deactivated successfully. Jul 15 05:16:22.890333 systemd[1]: initrd-switch-root.service: Deactivated successfully. Jul 15 05:16:22.890347 systemd[1]: Stopped initrd-switch-root.service - Switch Root. Jul 15 05:16:22.890357 systemd[1]: systemd-journald.service: Scheduled restart job, restart counter is at 1. Jul 15 05:16:22.890368 systemd[1]: Created slice system-addon\x2dconfig.slice - Slice /system/addon-config. Jul 15 05:16:22.890380 systemd[1]: Created slice system-addon\x2drun.slice - Slice /system/addon-run. Jul 15 05:16:22.890390 systemd[1]: Created slice system-getty.slice - Slice /system/getty. Jul 15 05:16:22.890401 systemd[1]: Created slice system-modprobe.slice - Slice /system/modprobe. Jul 15 05:16:22.890412 systemd[1]: Created slice system-serial\x2dgetty.slice - Slice /system/serial-getty. Jul 15 05:16:22.890423 systemd[1]: Created slice system-system\x2dcloudinit.slice - Slice /system/system-cloudinit. Jul 15 05:16:22.890437 systemd[1]: Created slice system-systemd\x2dfsck.slice - Slice /system/systemd-fsck. Jul 15 05:16:22.890448 systemd[1]: Created slice user.slice - User and Session Slice. Jul 15 05:16:22.890458 systemd[1]: Started clevis-luks-askpass.path - Forward Password Requests to Clevis Directory Watch. Jul 15 05:16:22.890468 systemd[1]: Started systemd-ask-password-console.path - Dispatch Password Requests to Console Directory Watch. Jul 15 05:16:22.890479 systemd[1]: Started systemd-ask-password-wall.path - Forward Password Requests to Wall Directory Watch. Jul 15 05:16:22.890490 systemd[1]: Set up automount boot.automount - Boot partition Automount Point. Jul 15 05:16:22.890505 systemd[1]: Set up automount proc-sys-fs-binfmt_misc.automount - Arbitrary Executable File Formats File System Automount Point. Jul 15 05:16:22.890516 systemd[1]: Expecting device dev-disk-by\x2dlabel-OEM.device - /dev/disk/by-label/OEM... Jul 15 05:16:22.890533 systemd[1]: Expecting device dev-ttyS0.device - /dev/ttyS0... Jul 15 05:16:22.890544 systemd[1]: Reached target cryptsetup-pre.target - Local Encrypted Volumes (Pre). Jul 15 05:16:22.890555 systemd[1]: Reached target cryptsetup.target - Local Encrypted Volumes. Jul 15 05:16:22.890566 systemd[1]: Stopped target initrd-switch-root.target - Switch Root. Jul 15 05:16:22.890577 systemd[1]: Stopped target initrd-fs.target - Initrd File Systems. Jul 15 05:16:22.890589 systemd[1]: Stopped target initrd-root-fs.target - Initrd Root File System. Jul 15 05:16:22.890600 systemd[1]: Reached target integritysetup.target - Local Integrity Protected Volumes. Jul 15 05:16:22.890613 systemd[1]: Reached target remote-cryptsetup.target - Remote Encrypted Volumes. Jul 15 05:16:22.890624 systemd[1]: Reached target remote-fs.target - Remote File Systems. Jul 15 05:16:22.890635 systemd[1]: Reached target slices.target - Slice Units. Jul 15 05:16:22.890646 systemd[1]: Reached target swap.target - Swaps. Jul 15 05:16:22.890657 systemd[1]: Reached target veritysetup.target - Local Verity Protected Volumes. Jul 15 05:16:22.890667 systemd[1]: Listening on systemd-coredump.socket - Process Core Dump Socket. Jul 15 05:16:22.890692 systemd[1]: Listening on systemd-creds.socket - Credential Encryption/Decryption. Jul 15 05:16:22.890704 systemd[1]: Listening on systemd-networkd.socket - Network Service Netlink Socket. Jul 15 05:16:22.890715 systemd[1]: Listening on systemd-udevd-control.socket - udev Control Socket. Jul 15 05:16:22.890726 systemd[1]: Listening on systemd-udevd-kernel.socket - udev Kernel Socket. Jul 15 05:16:22.890737 systemd[1]: Listening on systemd-userdbd.socket - User Database Manager Socket. Jul 15 05:16:22.890748 systemd[1]: Mounting dev-hugepages.mount - Huge Pages File System... Jul 15 05:16:22.890759 systemd[1]: Mounting dev-mqueue.mount - POSIX Message Queue File System... Jul 15 05:16:22.890773 systemd[1]: Mounting media.mount - External Media Directory... Jul 15 05:16:22.890787 systemd[1]: proc-xen.mount - /proc/xen was skipped because of an unmet condition check (ConditionVirtualization=xen). Jul 15 05:16:22.890798 systemd[1]: Mounting sys-kernel-debug.mount - Kernel Debug File System... Jul 15 05:16:22.890809 systemd[1]: Mounting sys-kernel-tracing.mount - Kernel Trace File System... Jul 15 05:16:22.890821 systemd[1]: Mounting tmp.mount - Temporary Directory /tmp... Jul 15 05:16:22.890833 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). Jul 15 05:16:22.890844 systemd[1]: Reached target machines.target - Containers. Jul 15 05:16:22.890855 systemd[1]: Starting flatcar-tmpfiles.service - Create missing system files... Jul 15 05:16:22.890866 systemd[1]: ignition-delete-config.service - Ignition (delete config) was skipped because no trigger condition checks were met. Jul 15 05:16:22.890880 systemd[1]: Starting kmod-static-nodes.service - Create List of Static Device Nodes... Jul 15 05:16:22.890891 systemd[1]: Starting modprobe@configfs.service - Load Kernel Module configfs... Jul 15 05:16:22.890902 systemd[1]: Starting modprobe@dm_mod.service - Load Kernel Module dm_mod... Jul 15 05:16:22.890913 systemd[1]: Starting modprobe@drm.service - Load Kernel Module drm... Jul 15 05:16:22.890923 systemd[1]: Starting modprobe@efi_pstore.service - Load Kernel Module efi_pstore... Jul 15 05:16:22.890935 systemd[1]: Starting modprobe@fuse.service - Load Kernel Module fuse... Jul 15 05:16:22.890945 systemd[1]: Starting modprobe@loop.service - Load Kernel Module loop... Jul 15 05:16:22.890956 systemd[1]: setup-nsswitch.service - Create /etc/nsswitch.conf was skipped because of an unmet condition check (ConditionPathExists=!/etc/nsswitch.conf). Jul 15 05:16:22.890970 systemd[1]: systemd-fsck-root.service: Deactivated successfully. Jul 15 05:16:22.890981 systemd[1]: Stopped systemd-fsck-root.service - File System Check on Root Device. Jul 15 05:16:22.890992 systemd[1]: systemd-fsck-usr.service: Deactivated successfully. Jul 15 05:16:22.891003 systemd[1]: Stopped systemd-fsck-usr.service. Jul 15 05:16:22.891014 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). Jul 15 05:16:22.891028 systemd[1]: Starting systemd-journald.service - Journal Service... Jul 15 05:16:22.891039 kernel: fuse: init (API version 7.41) Jul 15 05:16:22.891050 systemd[1]: Starting systemd-modules-load.service - Load Kernel Modules... Jul 15 05:16:22.891064 systemd[1]: Starting systemd-network-generator.service - Generate network units from Kernel command line... Jul 15 05:16:22.891075 kernel: loop: module loaded Jul 15 05:16:22.891085 systemd[1]: Starting systemd-remount-fs.service - Remount Root and Kernel File Systems... Jul 15 05:16:22.891097 systemd[1]: Starting systemd-udev-load-credentials.service - Load udev Rules from Credentials... Jul 15 05:16:22.891108 systemd[1]: Starting systemd-udev-trigger.service - Coldplug All udev Devices... Jul 15 05:16:22.891119 systemd[1]: verity-setup.service: Deactivated successfully. Jul 15 05:16:22.891130 systemd[1]: Stopped verity-setup.service. Jul 15 05:16:22.891141 systemd[1]: xenserver-pv-version.service - Set fake PV driver version for XenServer was skipped because of an unmet condition check (ConditionVirtualization=xen). Jul 15 05:16:22.891152 systemd[1]: Mounted dev-hugepages.mount - Huge Pages File System. Jul 15 05:16:22.891165 systemd[1]: Mounted dev-mqueue.mount - POSIX Message Queue File System. Jul 15 05:16:22.891176 systemd[1]: Mounted media.mount - External Media Directory. Jul 15 05:16:22.891212 systemd-journald[1501]: Collecting audit messages is disabled. Jul 15 05:16:22.891242 systemd[1]: Mounted sys-kernel-debug.mount - Kernel Debug File System. Jul 15 05:16:22.891254 systemd-journald[1501]: Journal started Jul 15 05:16:22.891277 systemd-journald[1501]: Runtime Journal (/run/log/journal/6c8a9fed9a094bbca17ee936d685edac) is 8M, max 2.2G, 2.1G free. Jul 15 05:16:22.086763 systemd[1]: Queued start job for default target multi-user.target. Jul 15 05:16:22.111227 systemd[1]: Unnecessary job was removed for dev-sdb6.device - /dev/sdb6. Jul 15 05:16:22.111750 systemd[1]: systemd-journald.service: Deactivated successfully. Jul 15 05:16:22.901913 systemd[1]: Started systemd-journald.service - Journal Service. Jul 15 05:16:22.905933 systemd[1]: Mounted sys-kernel-tracing.mount - Kernel Trace File System. Jul 15 05:16:22.911069 systemd[1]: Mounted tmp.mount - Temporary Directory /tmp. Jul 15 05:16:22.916470 systemd[1]: Finished flatcar-tmpfiles.service - Create missing system files. Jul 15 05:16:22.921253 systemd[1]: Finished kmod-static-nodes.service - Create List of Static Device Nodes. Jul 15 05:16:22.926375 systemd[1]: modprobe@configfs.service: Deactivated successfully. Jul 15 05:16:22.926581 systemd[1]: Finished modprobe@configfs.service - Load Kernel Module configfs. Jul 15 05:16:22.931416 systemd[1]: modprobe@dm_mod.service: Deactivated successfully. Jul 15 05:16:22.931601 systemd[1]: Finished modprobe@dm_mod.service - Load Kernel Module dm_mod. Jul 15 05:16:22.936233 systemd[1]: modprobe@efi_pstore.service: Deactivated successfully. Jul 15 05:16:22.936419 systemd[1]: Finished modprobe@efi_pstore.service - Load Kernel Module efi_pstore. Jul 15 05:16:22.941394 systemd[1]: modprobe@fuse.service: Deactivated successfully. Jul 15 05:16:22.941594 systemd[1]: Finished modprobe@fuse.service - Load Kernel Module fuse. Jul 15 05:16:22.946016 systemd[1]: modprobe@loop.service: Deactivated successfully. Jul 15 05:16:22.946206 systemd[1]: Finished modprobe@loop.service - Load Kernel Module loop. Jul 15 05:16:22.950732 systemd[1]: Finished systemd-modules-load.service - Load Kernel Modules. Jul 15 05:16:22.955358 systemd[1]: Finished systemd-network-generator.service - Generate network units from Kernel command line. Jul 15 05:16:22.960548 systemd[1]: Finished systemd-remount-fs.service - Remount Root and Kernel File Systems. Jul 15 05:16:22.974407 systemd[1]: Reached target network-pre.target - Preparation for Network. Jul 15 05:16:22.984093 systemd[1]: Mounting sys-fs-fuse-connections.mount - FUSE Control File System... Jul 15 05:16:22.997935 systemd[1]: Mounting sys-kernel-config.mount - Kernel Configuration File System... Jul 15 05:16:23.002179 systemd[1]: remount-root.service - Remount Root File System was skipped because of an unmet condition check (ConditionPathIsReadWrite=!/). Jul 15 05:16:23.002217 systemd[1]: Reached target local-fs.target - Local File Systems. Jul 15 05:16:23.004600 systemd[1]: Listening on systemd-sysext.socket - System Extension Image Management. Jul 15 05:16:23.012062 systemd[1]: Starting ldconfig.service - Rebuild Dynamic Linker Cache... Jul 15 05:16:23.016598 systemd[1]: systemd-binfmt.service - Set Up Additional Binary Formats was skipped because no trigger condition checks were met. Jul 15 05:16:23.018049 systemd[1]: Starting systemd-hwdb-update.service - Rebuild Hardware Database... Jul 15 05:16:23.023386 systemd[1]: Starting systemd-journal-flush.service - Flush Journal to Persistent Storage... Jul 15 05:16:23.028710 kernel: ACPI: bus type drm_connector registered Jul 15 05:16:23.030381 systemd[1]: systemd-pstore.service - Platform Persistent Storage Archival was skipped because of an unmet condition check (ConditionDirectoryNotEmpty=/sys/fs/pstore). Jul 15 05:16:23.031436 systemd[1]: Starting systemd-random-seed.service - Load/Save OS Random Seed... Jul 15 05:16:23.036384 systemd[1]: systemd-repart.service - Repartition Root Disk was skipped because no trigger condition checks were met. Jul 15 05:16:23.037387 systemd[1]: Starting systemd-sysctl.service - Apply Kernel Variables... Jul 15 05:16:23.042368 systemd[1]: Starting systemd-sysext.service - Merge System Extension Images into /usr/ and /opt/... Jul 15 05:16:23.048318 systemd[1]: Starting systemd-tmpfiles-setup-dev-early.service - Create Static Device Nodes in /dev gracefully... Jul 15 05:16:23.054891 systemd-journald[1501]: Time spent on flushing to /var/log/journal/6c8a9fed9a094bbca17ee936d685edac is 13.927ms for 944 entries. Jul 15 05:16:23.054891 systemd-journald[1501]: System Journal (/var/log/journal/6c8a9fed9a094bbca17ee936d685edac) is 8M, max 2.6G, 2.6G free. Jul 15 05:16:23.133862 systemd-journald[1501]: Received client request to flush runtime journal. Jul 15 05:16:23.055082 systemd[1]: modprobe@drm.service: Deactivated successfully. Jul 15 05:16:23.055285 systemd[1]: Finished modprobe@drm.service - Load Kernel Module drm. Jul 15 05:16:23.065274 systemd[1]: Mounted sys-fs-fuse-connections.mount - FUSE Control File System. Jul 15 05:16:23.070626 systemd[1]: Mounted sys-kernel-config.mount - Kernel Configuration File System. Jul 15 05:16:23.080890 systemd[1]: Finished systemd-random-seed.service - Load/Save OS Random Seed. Jul 15 05:16:23.088820 systemd[1]: Reached target first-boot-complete.target - First Boot Complete. Jul 15 05:16:23.095844 systemd[1]: Starting systemd-machine-id-commit.service - Save Transient machine-id to Disk... Jul 15 05:16:23.121231 systemd[1]: Finished systemd-udev-load-credentials.service - Load udev Rules from Credentials. Jul 15 05:16:23.126765 systemd[1]: Finished systemd-udev-trigger.service - Coldplug All udev Devices. Jul 15 05:16:23.134874 systemd[1]: Finished systemd-journal-flush.service - Flush Journal to Persistent Storage. Jul 15 05:16:23.150700 kernel: loop0: detected capacity change from 0 to 146488 Jul 15 05:16:23.180420 systemd[1]: etc-machine\x2did.mount: Deactivated successfully. Jul 15 05:16:23.181193 systemd[1]: Finished systemd-machine-id-commit.service - Save Transient machine-id to Disk. Jul 15 05:16:23.186359 systemd-tmpfiles[1535]: ACLs are not supported, ignoring. Jul 15 05:16:23.186380 systemd-tmpfiles[1535]: ACLs are not supported, ignoring. Jul 15 05:16:23.191951 systemd[1]: Finished systemd-tmpfiles-setup-dev-early.service - Create Static Device Nodes in /dev gracefully. Jul 15 05:16:23.198008 systemd[1]: Starting systemd-sysusers.service - Create System Users... Jul 15 05:16:23.239501 systemd[1]: Finished systemd-sysctl.service - Apply Kernel Variables. Jul 15 05:16:23.283325 systemd[1]: Finished systemd-sysusers.service - Create System Users. Jul 15 05:16:23.289161 systemd[1]: Starting systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev... Jul 15 05:16:23.323553 systemd-tmpfiles[1555]: ACLs are not supported, ignoring. Jul 15 05:16:23.323576 systemd-tmpfiles[1555]: ACLs are not supported, ignoring. Jul 15 05:16:23.327142 systemd[1]: Finished systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev. Jul 15 05:16:23.517710 kernel: squashfs: version 4.0 (2009/01/31) Phillip Lougher Jul 15 05:16:23.557704 kernel: loop1: detected capacity change from 0 to 28624 Jul 15 05:16:24.206714 kernel: loop2: detected capacity change from 0 to 114000 Jul 15 05:16:24.271927 systemd[1]: Finished systemd-hwdb-update.service - Rebuild Hardware Database. Jul 15 05:16:24.278212 systemd[1]: Starting systemd-udevd.service - Rule-based Manager for Device Events and Files... Jul 15 05:16:24.317538 systemd-udevd[1562]: Using default interface naming scheme 'v255'. Jul 15 05:16:24.435424 systemd[1]: Started systemd-udevd.service - Rule-based Manager for Device Events and Files. Jul 15 05:16:24.447812 systemd[1]: Starting systemd-networkd.service - Network Configuration... Jul 15 05:16:24.486154 systemd[1]: Condition check resulted in dev-ttyS0.device - /dev/ttyS0 being skipped. Jul 15 05:16:24.554541 systemd[1]: Starting systemd-userdbd.service - User Database Manager... Jul 15 05:16:24.566722 kernel: hv_vmbus: registering driver hyperv_fb Jul 15 05:16:24.566872 kernel: hyperv_fb: Synthvid Version major 3, minor 5 Jul 15 05:16:24.573708 kernel: hyperv_fb: Screen resolution: 1024x768, Color depth: 32, Frame buffer size: 8388608 Jul 15 05:16:24.576831 kernel: Console: switching to colour dummy device 80x25 Jul 15 05:16:24.576892 kernel: mousedev: PS/2 mouse device common for all mice Jul 15 05:16:24.582692 kernel: hv_vmbus: registering driver hv_balloon Jul 15 05:16:24.582741 kernel: Console: switching to colour frame buffer device 128x48 Jul 15 05:16:24.589699 kernel: hv_balloon: Using Dynamic Memory protocol version 2.0 Jul 15 05:16:24.591088 systemd[1]: Starting systemd-vconsole-setup.service - Virtual Console Setup... Jul 15 05:16:24.600723 kernel: EDAC MC: Ver: 3.0.0 Jul 15 05:16:24.603144 systemd[1]: systemd-vconsole-setup.service: Deactivated successfully. Jul 15 05:16:24.603376 systemd[1]: Stopped systemd-vconsole-setup.service - Virtual Console Setup. Jul 15 05:16:24.612427 systemd[1]: Starting systemd-vconsole-setup.service - Virtual Console Setup... Jul 15 05:16:24.619250 systemd[1]: systemd-vconsole-setup.service: Deactivated successfully. Jul 15 05:16:24.619439 systemd[1]: Stopped systemd-vconsole-setup.service - Virtual Console Setup. Jul 15 05:16:24.625640 systemd[1]: Starting systemd-vconsole-setup.service - Virtual Console Setup... Jul 15 05:16:24.633671 systemd[1]: Started systemd-userdbd.service - User Database Manager. Jul 15 05:16:24.648698 kernel: loop3: detected capacity change from 0 to 146488 Jul 15 05:16:24.665183 kernel: loop4: detected capacity change from 0 to 28624 Jul 15 05:16:24.674699 kernel: loop5: detected capacity change from 0 to 114000 Jul 15 05:16:24.681317 (sd-merge)[1642]: Using extensions 'containerd-flatcar', 'docker-flatcar', 'oem-azure'. Jul 15 05:16:24.681812 (sd-merge)[1642]: Merged extensions into '/usr'. Jul 15 05:16:24.685249 systemd[1]: Finished systemd-sysext.service - Merge System Extension Images into /usr/ and /opt/. Jul 15 05:16:24.688285 systemd[1]: Starting ensure-sysext.service... Jul 15 05:16:24.689731 systemd[1]: Starting systemd-tmpfiles-setup.service - Create System Files and Directories... Jul 15 05:16:24.721228 systemd-tmpfiles[1647]: /usr/lib/tmpfiles.d/nfs-utils.conf:6: Duplicate line for path "/var/lib/nfs/sm", ignoring. Jul 15 05:16:24.721270 systemd-tmpfiles[1647]: /usr/lib/tmpfiles.d/nfs-utils.conf:7: Duplicate line for path "/var/lib/nfs/sm.bak", ignoring. Jul 15 05:16:24.721568 systemd-tmpfiles[1647]: /usr/lib/tmpfiles.d/provision.conf:20: Duplicate line for path "/root", ignoring. Jul 15 05:16:24.721950 systemd-tmpfiles[1647]: /usr/lib/tmpfiles.d/systemd-flatcar.conf:6: Duplicate line for path "/var/log/journal", ignoring. Jul 15 05:16:24.722849 systemd-tmpfiles[1647]: /usr/lib/tmpfiles.d/systemd.conf:29: Duplicate line for path "/var/lib/systemd", ignoring. Jul 15 05:16:24.723878 systemd-tmpfiles[1647]: ACLs are not supported, ignoring. Jul 15 05:16:24.723948 systemd-tmpfiles[1647]: ACLs are not supported, ignoring. Jul 15 05:16:24.738827 systemd-tmpfiles[1647]: Detected autofs mount point /boot during canonicalization of boot. Jul 15 05:16:24.738841 systemd-tmpfiles[1647]: Skipping /boot Jul 15 05:16:24.748032 systemd-tmpfiles[1647]: Detected autofs mount point /boot during canonicalization of boot. Jul 15 05:16:24.748047 systemd-tmpfiles[1647]: Skipping /boot Jul 15 05:16:24.756736 systemd[1]: Reload requested from client PID 1646 ('systemctl') (unit ensure-sysext.service)... Jul 15 05:16:24.756821 systemd[1]: Reloading... Jul 15 05:16:24.813719 zram_generator::config[1744]: No configuration found. Jul 15 05:16:24.875027 systemd-networkd[1580]: lo: Link UP Jul 15 05:16:24.875039 systemd-networkd[1580]: lo: Gained carrier Jul 15 05:16:24.876500 systemd-networkd[1580]: Enumeration completed Jul 15 05:16:24.876890 systemd-networkd[1580]: eth0: found matching network '/usr/lib/systemd/network/zz-default.network', based on potentially unpredictable interface name. Jul 15 05:16:24.876900 systemd-networkd[1580]: eth0: Configuring with /usr/lib/systemd/network/zz-default.network. Jul 15 05:16:24.877459 systemd-networkd[1580]: eth0: Link UP Jul 15 05:16:24.877469 systemd-networkd[1580]: eth0: Gained carrier Jul 15 05:16:24.877483 systemd-networkd[1580]: eth0: found matching network '/usr/lib/systemd/network/zz-default.network', based on potentially unpredictable interface name. Jul 15 05:16:24.916719 systemd-networkd[1580]: eth0: DHCPv4 address 10.200.8.11/24, gateway 10.200.8.1 acquired from 168.63.129.16 Jul 15 05:16:24.927243 systemd[1]: /usr/lib/systemd/system/docker.socket:6: ListenStream= references a path below legacy directory /var/run/, updating /var/run/docker.sock → /run/docker.sock; please update the unit file accordingly. Jul 15 05:16:25.080277 systemd[1]: Found device dev-disk-by\x2dlabel-OEM.device - Virtual_Disk OEM. Jul 15 05:16:25.085507 systemd[1]: Reloading finished in 328 ms. Jul 15 05:16:25.120897 systemd[1]: Started systemd-networkd.service - Network Configuration. Jul 15 05:16:25.125358 systemd[1]: Finished systemd-vconsole-setup.service - Virtual Console Setup. Jul 15 05:16:25.149319 systemd[1]: Finished systemd-tmpfiles-setup.service - Create System Files and Directories. Jul 15 05:16:25.193270 systemd[1]: proc-xen.mount - /proc/xen was skipped because of an unmet condition check (ConditionVirtualization=xen). Jul 15 05:16:25.194751 systemd[1]: Starting audit-rules.service - Load Audit Rules... Jul 15 05:16:25.219131 systemd[1]: Starting clean-ca-certificates.service - Clean up broken links in /etc/ssl/certs... Jul 15 05:16:25.224175 systemd[1]: ignition-delete-config.service - Ignition (delete config) was skipped because no trigger condition checks were met. Jul 15 05:16:25.225574 systemd[1]: Starting modprobe@dm_mod.service - Load Kernel Module dm_mod... Jul 15 05:16:25.230563 systemd[1]: Starting modprobe@efi_pstore.service - Load Kernel Module efi_pstore... Jul 15 05:16:25.235877 systemd[1]: Starting modprobe@loop.service - Load Kernel Module loop... Jul 15 05:16:25.239906 systemd[1]: systemd-binfmt.service - Set Up Additional Binary Formats was skipped because no trigger condition checks were met. Jul 15 05:16:25.240995 systemd[1]: Starting systemd-fsck@dev-disk-by\x2dlabel-OEM.service - File System Check on /dev/disk/by-label/OEM... Jul 15 05:16:25.245542 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). Jul 15 05:16:25.246754 systemd[1]: Starting systemd-journal-catalog-update.service - Rebuild Journal Catalog... Jul 15 05:16:25.252378 systemd[1]: Starting systemd-networkd-persistent-storage.service - Enable Persistent Storage in systemd-networkd... Jul 15 05:16:25.257134 systemd[1]: Starting systemd-networkd-wait-online.service - Wait for Network to be Configured... Jul 15 05:16:25.260418 systemd[1]: Starting systemd-resolved.service - Network Name Resolution... Jul 15 05:16:25.261879 systemd[1]: Starting systemd-update-utmp.service - Record System Boot/Shutdown in UTMP... Jul 15 05:16:25.262304 systemd[1]: xenserver-pv-version.service - Set fake PV driver version for XenServer was skipped because of an unmet condition check (ConditionVirtualization=xen). Jul 15 05:16:25.264537 systemd[1]: modprobe@dm_mod.service: Deactivated successfully. Jul 15 05:16:25.264742 systemd[1]: Finished modprobe@dm_mod.service - Load Kernel Module dm_mod. Jul 15 05:16:25.265471 systemd[1]: modprobe@efi_pstore.service: Deactivated successfully. Jul 15 05:16:25.265646 systemd[1]: Finished modprobe@efi_pstore.service - Load Kernel Module efi_pstore. Jul 15 05:16:25.266136 systemd[1]: modprobe@loop.service: Deactivated successfully. Jul 15 05:16:25.266302 systemd[1]: Finished modprobe@loop.service - Load Kernel Module loop. Jul 15 05:16:25.277524 systemd[1]: proc-xen.mount - /proc/xen was skipped because of an unmet condition check (ConditionVirtualization=xen). Jul 15 05:16:25.277783 systemd[1]: ignition-delete-config.service - Ignition (delete config) was skipped because no trigger condition checks were met. Jul 15 05:16:25.279860 systemd[1]: Starting modprobe@dm_mod.service - Load Kernel Module dm_mod... Jul 15 05:16:25.281942 systemd[1]: Starting modprobe@drm.service - Load Kernel Module drm... Jul 15 05:16:25.283722 systemd[1]: Starting modprobe@efi_pstore.service - Load Kernel Module efi_pstore... Jul 15 05:16:25.292649 systemd[1]: Starting modprobe@loop.service - Load Kernel Module loop... Jul 15 05:16:25.300574 systemd[1]: systemd-binfmt.service - Set Up Additional Binary Formats was skipped because no trigger condition checks were met. Jul 15 05:16:25.300623 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). Jul 15 05:16:25.300698 systemd[1]: Reached target time-set.target - System Time Set. Jul 15 05:16:25.304815 systemd[1]: xenserver-pv-version.service - Set fake PV driver version for XenServer was skipped because of an unmet condition check (ConditionVirtualization=xen). Jul 15 05:16:25.307313 systemd[1]: Finished ensure-sysext.service. Jul 15 05:16:25.310960 systemd[1]: Finished systemd-fsck@dev-disk-by\x2dlabel-OEM.service - File System Check on /dev/disk/by-label/OEM. Jul 15 05:16:25.316498 systemd[1]: Finished systemd-networkd-persistent-storage.service - Enable Persistent Storage in systemd-networkd. Jul 15 05:16:25.321645 systemd[1]: modprobe@dm_mod.service: Deactivated successfully. Jul 15 05:16:25.321889 systemd[1]: Finished modprobe@dm_mod.service - Load Kernel Module dm_mod. Jul 15 05:16:25.326788 systemd[1]: modprobe@drm.service: Deactivated successfully. Jul 15 05:16:25.326965 systemd[1]: Finished modprobe@drm.service - Load Kernel Module drm. Jul 15 05:16:25.331511 systemd[1]: modprobe@efi_pstore.service: Deactivated successfully. Jul 15 05:16:25.331696 systemd[1]: Finished modprobe@efi_pstore.service - Load Kernel Module efi_pstore. Jul 15 05:16:25.336805 systemd[1]: modprobe@loop.service: Deactivated successfully. Jul 15 05:16:25.336990 systemd[1]: Finished modprobe@loop.service - Load Kernel Module loop. Jul 15 05:16:25.341642 systemd[1]: Finished systemd-journal-catalog-update.service - Rebuild Journal Catalog. Jul 15 05:16:25.353778 systemd[1]: systemd-pstore.service - Platform Persistent Storage Archival was skipped because of an unmet condition check (ConditionDirectoryNotEmpty=/sys/fs/pstore). Jul 15 05:16:25.354077 systemd[1]: systemd-repart.service - Repartition Root Disk was skipped because no trigger condition checks were met. Jul 15 05:16:25.355628 systemd[1]: Finished systemd-update-utmp.service - Record System Boot/Shutdown in UTMP. Jul 15 05:16:25.420665 systemd-resolved[1818]: Positive Trust Anchors: Jul 15 05:16:25.420703 systemd-resolved[1818]: . IN DS 20326 8 2 e06d44b80b8f1d39a95c0b0d7c65d08458e880409bbc683457104237c7f8ec8d Jul 15 05:16:25.420737 systemd-resolved[1818]: 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 Jul 15 05:16:25.458859 augenrules[1856]: No rules Jul 15 05:16:25.460193 systemd[1]: audit-rules.service: Deactivated successfully. Jul 15 05:16:25.460463 systemd[1]: Finished audit-rules.service - Load Audit Rules. Jul 15 05:16:25.487195 systemd-resolved[1818]: Using system hostname 'ci-4396.0.0-n-957ef44c1e'. Jul 15 05:16:25.489044 systemd[1]: Started systemd-resolved.service - Network Name Resolution. Jul 15 05:16:25.493824 systemd[1]: Reached target network.target - Network. Jul 15 05:16:25.497451 systemd[1]: Reached target nss-lookup.target - Host and Network Name Lookups. Jul 15 05:16:26.008868 systemd-networkd[1580]: eth0: Gained IPv6LL Jul 15 05:16:26.011306 systemd[1]: Finished systemd-networkd-wait-online.service - Wait for Network to be Configured. Jul 15 05:16:26.016588 systemd[1]: Reached target network-online.target - Network is Online. Jul 15 05:16:26.053692 systemd[1]: Finished clean-ca-certificates.service - Clean up broken links in /etc/ssl/certs. Jul 15 05:16:26.059939 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). Jul 15 05:16:30.383104 ldconfig[1528]: /sbin/ldconfig: /usr/lib/ld.so.conf is not an ELF file - it has the wrong magic bytes at the start. Jul 15 05:16:30.396163 systemd[1]: Finished ldconfig.service - Rebuild Dynamic Linker Cache. Jul 15 05:16:30.402616 systemd[1]: Starting systemd-update-done.service - Update is Completed... Jul 15 05:16:30.437117 systemd[1]: Finished systemd-update-done.service - Update is Completed. Jul 15 05:16:30.441824 systemd[1]: Reached target sysinit.target - System Initialization. Jul 15 05:16:30.446349 systemd[1]: Started motdgen.path - Watch for update engine configuration changes. Jul 15 05:16:30.451470 systemd[1]: Started user-cloudinit@var-lib-flatcar\x2dinstall-user_data.path - Watch for a cloud-config at /var/lib/flatcar-install/user_data. Jul 15 05:16:30.457345 systemd[1]: Started google-oslogin-cache.timer - NSS cache refresh timer. Jul 15 05:16:30.462819 systemd[1]: Started logrotate.timer - Daily rotation of log files. Jul 15 05:16:30.467052 systemd[1]: Started mdadm.timer - Weekly check for MD array's redundancy information.. Jul 15 05:16:30.471918 systemd[1]: Started systemd-tmpfiles-clean.timer - Daily Cleanup of Temporary Directories. Jul 15 05:16:30.476963 systemd[1]: update-engine-stub.timer - Update Engine Stub Timer was skipped because of an unmet condition check (ConditionPathExists=/usr/.noupdate). Jul 15 05:16:30.477008 systemd[1]: Reached target paths.target - Path Units. Jul 15 05:16:30.480770 systemd[1]: Reached target timers.target - Timer Units. Jul 15 05:16:30.485381 systemd[1]: Listening on dbus.socket - D-Bus System Message Bus Socket. Jul 15 05:16:30.491463 systemd[1]: Starting docker.socket - Docker Socket for the API... Jul 15 05:16:30.497288 systemd[1]: Listening on sshd-unix-local.socket - OpenSSH Server Socket (systemd-ssh-generator, AF_UNIX Local). Jul 15 05:16:30.504289 systemd[1]: Listening on sshd-vsock.socket - OpenSSH Server Socket (systemd-ssh-generator, AF_VSOCK). Jul 15 05:16:30.510635 systemd[1]: Reached target ssh-access.target - SSH Access Available. Jul 15 05:16:30.516644 systemd[1]: Listening on sshd.socket - OpenSSH Server Socket. Jul 15 05:16:30.521132 systemd[1]: Listening on systemd-hostnamed.socket - Hostname Service Socket. Jul 15 05:16:30.526433 systemd[1]: Listening on docker.socket - Docker Socket for the API. Jul 15 05:16:30.531616 systemd[1]: Reached target sockets.target - Socket Units. Jul 15 05:16:30.536542 systemd[1]: Reached target basic.target - Basic System. Jul 15 05:16:30.540282 systemd[1]: addon-config@oem.service - Configure Addon /oem was skipped because no trigger condition checks were met. Jul 15 05:16:30.540312 systemd[1]: addon-run@oem.service - Run Addon /oem was skipped because no trigger condition checks were met. Jul 15 05:16:30.542779 systemd[1]: Starting chronyd.service - NTP client/server... Jul 15 05:16:30.547021 systemd[1]: Starting containerd.service - containerd container runtime... Jul 15 05:16:30.565409 systemd[1]: Starting coreos-metadata.service - Flatcar Metadata Agent... Jul 15 05:16:30.570352 systemd[1]: Starting dbus.service - D-Bus System Message Bus... Jul 15 05:16:30.575248 systemd[1]: Starting dracut-shutdown.service - Restore /run/initramfs on shutdown... Jul 15 05:16:30.580832 systemd[1]: Starting enable-oem-cloudinit.service - Enable cloudinit... Jul 15 05:16:30.586189 systemd[1]: Starting extend-filesystems.service - Extend Filesystems... Jul 15 05:16:30.587959 jq[1877]: false Jul 15 05:16:30.590408 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). Jul 15 05:16:30.591438 systemd[1]: Starting google-oslogin-cache.service - NSS cache refresh... Jul 15 05:16:30.596042 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). Jul 15 05:16:30.597060 systemd[1]: Started hv_kvp_daemon.service - Hyper-V KVP daemon. Jul 15 05:16:30.601361 systemd[1]: hv_vss_daemon.service - Hyper-V VSS daemon was skipped because of an unmet condition check (ConditionPathExists=/dev/vmbus/hv_vss). Jul 15 05:16:30.602360 systemd[1]: Starting motdgen.service - Generate /run/flatcar/motd... Jul 15 05:16:30.607374 systemd[1]: Starting nvidia.service - NVIDIA Configure Service... Jul 15 05:16:30.608074 KVP[1880]: KVP starting; pid is:1880 Jul 15 05:16:30.611709 KVP[1880]: KVP LIC Version: 3.1 Jul 15 05:16:30.611999 systemd[1]: Starting ssh-key-proc-cmdline.service - Install an ssh key from /proc/cmdline... Jul 15 05:16:30.612751 (chronyd)[1869]: chronyd.service: Referenced but unset environment variable evaluates to an empty string: OPTIONS Jul 15 05:16:30.613697 kernel: hv_utils: KVP IC version 4.0 Jul 15 05:16:30.618597 systemd[1]: Starting sshd-keygen.service - Generate sshd host keys... Jul 15 05:16:30.625115 systemd[1]: Starting systemd-logind.service - User Login Management... Jul 15 05:16:30.627287 chronyd[1891]: chronyd version 4.6.1 starting (+CMDMON +NTP +REFCLOCK +RTC +PRIVDROP +SCFILTER -SIGND +ASYNCDNS +NTS +SECHASH +IPV6 -DEBUG) Jul 15 05:16:30.629979 systemd[1]: tcsd.service - TCG Core Services Daemon was skipped because of an unmet condition check (ConditionPathExists=/dev/tpm0). Jul 15 05:16:30.630416 systemd[1]: cgroup compatibility translation between legacy and unified hierarchy settings activated. See cgroup-compat debug messages for details. Jul 15 05:16:30.631578 systemd[1]: Starting update-engine.service - Update Engine... Jul 15 05:16:30.635903 systemd[1]: Starting update-ssh-keys-after-ignition.service - Run update-ssh-keys once after Ignition... Jul 15 05:16:30.642390 systemd[1]: Finished dracut-shutdown.service - Restore /run/initramfs on shutdown. Jul 15 05:16:30.643589 jq[1896]: true Jul 15 05:16:30.647973 systemd[1]: enable-oem-cloudinit.service: Skipped due to 'exec-condition'. Jul 15 05:16:30.648999 systemd[1]: Condition check resulted in enable-oem-cloudinit.service - Enable cloudinit being skipped. Jul 15 05:16:30.649376 systemd[1]: ssh-key-proc-cmdline.service: Deactivated successfully. Jul 15 05:16:30.649584 systemd[1]: Finished ssh-key-proc-cmdline.service - Install an ssh key from /proc/cmdline. Jul 15 05:16:30.651131 extend-filesystems[1878]: Found /dev/sdb6 Jul 15 05:16:30.657191 systemd[1]: Started chronyd.service - NTP client/server. Jul 15 05:16:30.655352 chronyd[1891]: Timezone right/UTC failed leap second check, ignoring Jul 15 05:16:30.655554 chronyd[1891]: Loaded seccomp filter (level 2) Jul 15 05:16:30.660372 systemd[1]: motdgen.service: Deactivated successfully. Jul 15 05:16:30.660584 systemd[1]: Finished motdgen.service - Generate /run/flatcar/motd. Jul 15 05:16:30.666363 jq[1901]: true Jul 15 05:16:30.670525 google_oslogin_nss_cache[1879]: oslogin_cache_refresh[1879]: Refreshing passwd entry cache Jul 15 05:16:30.670535 oslogin_cache_refresh[1879]: Refreshing passwd entry cache Jul 15 05:16:30.671212 (ntainerd)[1906]: containerd.service: Referenced but unset environment variable evaluates to an empty string: TORCX_IMAGEDIR, TORCX_UNPACKDIR Jul 15 05:16:30.672316 extend-filesystems[1878]: Found /dev/sdb9 Jul 15 05:16:30.676548 extend-filesystems[1878]: Checking size of /dev/sdb9 Jul 15 05:16:30.679811 google_oslogin_nss_cache[1879]: oslogin_cache_refresh[1879]: Failure getting users, quitting Jul 15 05:16:30.679806 oslogin_cache_refresh[1879]: Failure getting users, quitting Jul 15 05:16:30.679882 google_oslogin_nss_cache[1879]: oslogin_cache_refresh[1879]: Produced empty passwd cache file, removing /etc/oslogin_passwd.cache.bak. Jul 15 05:16:30.679882 google_oslogin_nss_cache[1879]: oslogin_cache_refresh[1879]: Refreshing group entry cache Jul 15 05:16:30.679824 oslogin_cache_refresh[1879]: Produced empty passwd cache file, removing /etc/oslogin_passwd.cache.bak. Jul 15 05:16:30.679865 oslogin_cache_refresh[1879]: Refreshing group entry cache Jul 15 05:16:30.685342 google_oslogin_nss_cache[1879]: oslogin_cache_refresh[1879]: Failure getting groups, quitting Jul 15 05:16:30.685342 google_oslogin_nss_cache[1879]: oslogin_cache_refresh[1879]: Produced empty group cache file, removing /etc/oslogin_group.cache.bak. Jul 15 05:16:30.685327 oslogin_cache_refresh[1879]: Failure getting groups, quitting Jul 15 05:16:30.685337 oslogin_cache_refresh[1879]: Produced empty group cache file, removing /etc/oslogin_group.cache.bak. Jul 15 05:16:30.686854 systemd[1]: google-oslogin-cache.service: Deactivated successfully. Jul 15 05:16:30.692511 systemd-logind[1889]: New seat seat0. Jul 15 05:16:30.693354 systemd[1]: Finished google-oslogin-cache.service - NSS cache refresh. Jul 15 05:16:30.693924 systemd-logind[1889]: Watching system buttons on /dev/input/event0 (AT Translated Set 2 keyboard) Jul 15 05:16:30.698037 systemd[1]: Started systemd-logind.service - User Login Management. Jul 15 05:16:30.703453 extend-filesystems[1878]: Old size kept for /dev/sdb9 Jul 15 05:16:30.705760 systemd[1]: extend-filesystems.service: Deactivated successfully. Jul 15 05:16:30.705989 systemd[1]: Finished extend-filesystems.service - Extend Filesystems. Jul 15 05:16:30.715186 update_engine[1894]: I20250715 05:16:30.715044 1894 main.cc:92] Flatcar Update Engine starting Jul 15 05:16:30.811517 bash[1934]: Updated "/home/core/.ssh/authorized_keys" Jul 15 05:16:30.813255 systemd[1]: Finished update-ssh-keys-after-ignition.service - Run update-ssh-keys once after Ignition. Jul 15 05:16:30.818882 systemd[1]: sshkeys.service was skipped because no trigger condition checks were met. Jul 15 05:16:30.872099 dbus-daemon[1872]: [system] SELinux support is enabled Jul 15 05:16:30.872277 systemd[1]: Started dbus.service - D-Bus System Message Bus. Jul 15 05:16:30.875699 update_engine[1894]: I20250715 05:16:30.875636 1894 update_check_scheduler.cc:74] Next update check in 11m19s Jul 15 05:16:30.878713 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). Jul 15 05:16:30.878747 systemd[1]: Reached target system-config.target - Load system-provided cloud configs. Jul 15 05:16:30.880884 dbus-daemon[1872]: [system] Successfully activated service 'org.freedesktop.systemd1' Jul 15 05:16:30.883825 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). Jul 15 05:16:30.883854 systemd[1]: Reached target user-config.target - Load user-provided cloud configs. Jul 15 05:16:30.889078 systemd[1]: Started update-engine.service - Update Engine. Jul 15 05:16:30.894961 systemd[1]: Started locksmithd.service - Cluster reboot manager. Jul 15 05:16:30.900860 sshd_keygen[1895]: ssh-keygen: generating new host keys: RSA ECDSA ED25519 Jul 15 05:16:30.903316 setup-nvidia[1885]: Downloading Flatcar Container Linux Developer Container for version: 4396.0.0+nightly-20250714-2100 Jul 15 05:16:30.922367 systemd[1]: Finished sshd-keygen.service - Generate sshd host keys. Jul 15 05:16:30.928160 systemd[1]: Starting issuegen.service - Generate /run/issue... Jul 15 05:16:30.944961 systemd[1]: Starting waagent.service - Microsoft Azure Linux Agent... Jul 15 05:16:30.950020 systemd[1]: issuegen.service: Deactivated successfully. Jul 15 05:16:30.950225 systemd[1]: Finished issuegen.service - Generate /run/issue. Jul 15 05:16:30.957197 systemd[1]: Starting systemd-user-sessions.service - Permit User Sessions... Jul 15 05:16:30.966750 systemd[1]: Started waagent.service - Microsoft Azure Linux Agent. Jul 15 05:16:30.971250 coreos-metadata[1871]: Jul 15 05:16:30.971 INFO Fetching http://168.63.129.16/?comp=versions: Attempt #1 Jul 15 05:16:30.971584 systemd[1]: Finished systemd-user-sessions.service - Permit User Sessions. Jul 15 05:16:30.973734 coreos-metadata[1871]: Jul 15 05:16:30.973 INFO Fetch successful Jul 15 05:16:30.973892 coreos-metadata[1871]: Jul 15 05:16:30.973 INFO Fetching http://168.63.129.16/machine/?comp=goalstate: Attempt #1 Jul 15 05:16:30.978020 coreos-metadata[1871]: Jul 15 05:16:30.977 INFO Fetch successful Jul 15 05:16:30.978247 systemd[1]: Started getty@tty1.service - Getty on tty1. Jul 15 05:16:30.981962 coreos-metadata[1871]: Jul 15 05:16:30.978 INFO Fetching http://168.63.129.16/machine/a1977997-26df-4767-95d7-7e7642951b1b/8dad2d5d%2D76d4%2D49cc%2Db956%2D96109b608da1.%5Fci%2D4396.0.0%2Dn%2D957ef44c1e?comp=config&type=sharedConfig&incarnation=1: Attempt #1 Jul 15 05:16:30.981962 coreos-metadata[1871]: Jul 15 05:16:30.981 INFO Fetch successful Jul 15 05:16:30.982045 coreos-metadata[1871]: Jul 15 05:16:30.981 INFO Fetching http://169.254.169.254/metadata/instance/compute/vmSize?api-version=2017-08-01&format=text: Attempt #1 Jul 15 05:16:30.983232 systemd[1]: Started serial-getty@ttyS0.service - Serial Getty on ttyS0. Jul 15 05:16:30.987152 coreos-metadata[1871]: Jul 15 05:16:30.987 INFO Fetch successful Jul 15 05:16:30.988311 systemd[1]: Reached target getty.target - Login Prompts. Jul 15 05:16:31.027464 systemd[1]: Finished coreos-metadata.service - Flatcar Metadata Agent. Jul 15 05:16:31.032117 systemd[1]: packet-phone-home.service - Report Success to Packet was skipped because no trigger condition checks were met. Jul 15 05:16:31.240007 locksmithd[2006]: locksmithd starting currentOperation="UPDATE_STATUS_IDLE" strategy="reboot" Jul 15 05:16:32.069825 containerd[1906]: time="2025-07-15T05:16:32Z" 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 Jul 15 05:16:32.071419 containerd[1906]: time="2025-07-15T05:16:32.071385800Z" level=info msg="starting containerd" revision=fb4c30d4ede3531652d86197bf3fc9515e5276d9 version=v2.0.5 Jul 15 05:16:32.081093 containerd[1906]: time="2025-07-15T05:16:32.081059500Z" level=warning msg="Configuration migrated from version 2, use `containerd config migrate` to avoid migration" t="8.6µs" Jul 15 05:16:32.081093 containerd[1906]: time="2025-07-15T05:16:32.081088200Z" level=info msg="loading plugin" id=io.containerd.image-verifier.v1.bindir type=io.containerd.image-verifier.v1 Jul 15 05:16:32.081183 containerd[1906]: time="2025-07-15T05:16:32.081106000Z" level=info msg="loading plugin" id=io.containerd.internal.v1.opt type=io.containerd.internal.v1 Jul 15 05:16:32.081279 containerd[1906]: time="2025-07-15T05:16:32.081256400Z" level=info msg="loading plugin" id=io.containerd.warning.v1.deprecations type=io.containerd.warning.v1 Jul 15 05:16:32.081309 containerd[1906]: time="2025-07-15T05:16:32.081278300Z" level=info msg="loading plugin" id=io.containerd.content.v1.content type=io.containerd.content.v1 Jul 15 05:16:32.081309 containerd[1906]: time="2025-07-15T05:16:32.081302100Z" level=info msg="loading plugin" id=io.containerd.snapshotter.v1.blockfile type=io.containerd.snapshotter.v1 Jul 15 05:16:32.081386 containerd[1906]: time="2025-07-15T05:16:32.081364700Z" level=info msg="skip loading plugin" error="no scratch file generator: skip plugin" id=io.containerd.snapshotter.v1.blockfile type=io.containerd.snapshotter.v1 Jul 15 05:16:32.081386 containerd[1906]: time="2025-07-15T05:16:32.081383700Z" level=info msg="loading plugin" id=io.containerd.snapshotter.v1.btrfs type=io.containerd.snapshotter.v1 Jul 15 05:16:32.081597 containerd[1906]: time="2025-07-15T05:16:32.081574600Z" 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 Jul 15 05:16:32.081597 containerd[1906]: time="2025-07-15T05:16:32.081594100Z" level=info msg="loading plugin" id=io.containerd.snapshotter.v1.devmapper type=io.containerd.snapshotter.v1 Jul 15 05:16:32.081643 containerd[1906]: time="2025-07-15T05:16:32.081605500Z" level=info msg="skip loading plugin" error="devmapper not configured: skip plugin" id=io.containerd.snapshotter.v1.devmapper type=io.containerd.snapshotter.v1 Jul 15 05:16:32.081643 containerd[1906]: time="2025-07-15T05:16:32.081613500Z" level=info msg="loading plugin" id=io.containerd.snapshotter.v1.native type=io.containerd.snapshotter.v1 Jul 15 05:16:32.081726 containerd[1906]: time="2025-07-15T05:16:32.081706000Z" level=info msg="loading plugin" id=io.containerd.snapshotter.v1.overlayfs type=io.containerd.snapshotter.v1 Jul 15 05:16:32.081962 containerd[1906]: time="2025-07-15T05:16:32.081941500Z" level=info msg="loading plugin" id=io.containerd.snapshotter.v1.zfs type=io.containerd.snapshotter.v1 Jul 15 05:16:32.081989 containerd[1906]: time="2025-07-15T05:16:32.081976700Z" 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 Jul 15 05:16:32.082018 containerd[1906]: time="2025-07-15T05:16:32.081987500Z" level=info msg="loading plugin" id=io.containerd.event.v1.exchange type=io.containerd.event.v1 Jul 15 05:16:32.082018 containerd[1906]: time="2025-07-15T05:16:32.082013700Z" level=info msg="loading plugin" id=io.containerd.monitor.task.v1.cgroups type=io.containerd.monitor.task.v1 Jul 15 05:16:32.082320 containerd[1906]: time="2025-07-15T05:16:32.082291500Z" level=info msg="loading plugin" id=io.containerd.metadata.v1.bolt type=io.containerd.metadata.v1 Jul 15 05:16:32.082380 containerd[1906]: time="2025-07-15T05:16:32.082361700Z" level=info msg="metadata content store policy set" policy=shared Jul 15 05:16:32.097929 containerd[1906]: time="2025-07-15T05:16:32.097894100Z" level=info msg="loading plugin" id=io.containerd.gc.v1.scheduler type=io.containerd.gc.v1 Jul 15 05:16:32.097976 containerd[1906]: time="2025-07-15T05:16:32.097933500Z" level=info msg="loading plugin" id=io.containerd.differ.v1.walking type=io.containerd.differ.v1 Jul 15 05:16:32.097976 containerd[1906]: time="2025-07-15T05:16:32.097947400Z" level=info msg="loading plugin" id=io.containerd.lease.v1.manager type=io.containerd.lease.v1 Jul 15 05:16:32.097976 containerd[1906]: time="2025-07-15T05:16:32.097959200Z" level=info msg="loading plugin" id=io.containerd.service.v1.containers-service type=io.containerd.service.v1 Jul 15 05:16:32.097976 containerd[1906]: time="2025-07-15T05:16:32.097973700Z" level=info msg="loading plugin" id=io.containerd.service.v1.content-service type=io.containerd.service.v1 Jul 15 05:16:32.098076 containerd[1906]: time="2025-07-15T05:16:32.097984500Z" level=info msg="loading plugin" id=io.containerd.service.v1.diff-service type=io.containerd.service.v1 Jul 15 05:16:32.098076 containerd[1906]: time="2025-07-15T05:16:32.097995900Z" level=info msg="loading plugin" id=io.containerd.service.v1.images-service type=io.containerd.service.v1 Jul 15 05:16:32.098076 containerd[1906]: time="2025-07-15T05:16:32.098007900Z" level=info msg="loading plugin" id=io.containerd.service.v1.introspection-service type=io.containerd.service.v1 Jul 15 05:16:32.098076 containerd[1906]: time="2025-07-15T05:16:32.098018400Z" level=info msg="loading plugin" id=io.containerd.service.v1.namespaces-service type=io.containerd.service.v1 Jul 15 05:16:32.098076 containerd[1906]: time="2025-07-15T05:16:32.098027900Z" level=info msg="loading plugin" id=io.containerd.service.v1.snapshots-service type=io.containerd.service.v1 Jul 15 05:16:32.098076 containerd[1906]: time="2025-07-15T05:16:32.098037000Z" level=info msg="loading plugin" id=io.containerd.shim.v1.manager type=io.containerd.shim.v1 Jul 15 05:16:32.098076 containerd[1906]: time="2025-07-15T05:16:32.098047800Z" level=info msg="loading plugin" id=io.containerd.runtime.v2.task type=io.containerd.runtime.v2 Jul 15 05:16:32.098217 containerd[1906]: time="2025-07-15T05:16:32.098149400Z" level=info msg="loading plugin" id=io.containerd.service.v1.tasks-service type=io.containerd.service.v1 Jul 15 05:16:32.098217 containerd[1906]: time="2025-07-15T05:16:32.098174600Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.containers type=io.containerd.grpc.v1 Jul 15 05:16:32.098217 containerd[1906]: time="2025-07-15T05:16:32.098189500Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.content type=io.containerd.grpc.v1 Jul 15 05:16:32.098217 containerd[1906]: time="2025-07-15T05:16:32.098199600Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.diff type=io.containerd.grpc.v1 Jul 15 05:16:32.098217 containerd[1906]: time="2025-07-15T05:16:32.098209100Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.events type=io.containerd.grpc.v1 Jul 15 05:16:32.098374 containerd[1906]: time="2025-07-15T05:16:32.098233400Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.images type=io.containerd.grpc.v1 Jul 15 05:16:32.098374 containerd[1906]: time="2025-07-15T05:16:32.098248800Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.introspection type=io.containerd.grpc.v1 Jul 15 05:16:32.098374 containerd[1906]: time="2025-07-15T05:16:32.098258200Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.leases type=io.containerd.grpc.v1 Jul 15 05:16:32.098374 containerd[1906]: time="2025-07-15T05:16:32.098269200Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.namespaces type=io.containerd.grpc.v1 Jul 15 05:16:32.098374 containerd[1906]: time="2025-07-15T05:16:32.098358300Z" level=info msg="loading plugin" id=io.containerd.sandbox.store.v1.local type=io.containerd.sandbox.store.v1 Jul 15 05:16:32.098374 containerd[1906]: time="2025-07-15T05:16:32.098375500Z" level=info msg="loading plugin" id=io.containerd.cri.v1.images type=io.containerd.cri.v1 Jul 15 05:16:32.098503 containerd[1906]: time="2025-07-15T05:16:32.098432500Z" level=info msg="Get image filesystem path \"/var/lib/containerd/io.containerd.snapshotter.v1.overlayfs\" for snapshotter \"overlayfs\"" Jul 15 05:16:32.098503 containerd[1906]: time="2025-07-15T05:16:32.098457600Z" level=info msg="Start snapshots syncer" Jul 15 05:16:32.098549 containerd[1906]: time="2025-07-15T05:16:32.098499000Z" level=info msg="loading plugin" id=io.containerd.cri.v1.runtime type=io.containerd.cri.v1 Jul 15 05:16:32.098819 containerd[1906]: time="2025-07-15T05:16:32.098771700Z" 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\"}" Jul 15 05:16:32.098955 containerd[1906]: time="2025-07-15T05:16:32.098840800Z" level=info msg="loading plugin" id=io.containerd.podsandbox.controller.v1.podsandbox type=io.containerd.podsandbox.controller.v1 Jul 15 05:16:32.098955 containerd[1906]: time="2025-07-15T05:16:32.098910300Z" level=info msg="loading plugin" id=io.containerd.sandbox.controller.v1.shim type=io.containerd.sandbox.controller.v1 Jul 15 05:16:32.099036 containerd[1906]: time="2025-07-15T05:16:32.099012900Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.sandbox-controllers type=io.containerd.grpc.v1 Jul 15 05:16:32.099071 containerd[1906]: time="2025-07-15T05:16:32.099053800Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.sandboxes type=io.containerd.grpc.v1 Jul 15 05:16:32.099097 containerd[1906]: time="2025-07-15T05:16:32.099068900Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.snapshots type=io.containerd.grpc.v1 Jul 15 05:16:32.099097 containerd[1906]: time="2025-07-15T05:16:32.099080300Z" level=info msg="loading plugin" id=io.containerd.streaming.v1.manager type=io.containerd.streaming.v1 Jul 15 05:16:32.099097 containerd[1906]: time="2025-07-15T05:16:32.099092200Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.streaming type=io.containerd.grpc.v1 Jul 15 05:16:32.099164 containerd[1906]: time="2025-07-15T05:16:32.099101800Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.tasks type=io.containerd.grpc.v1 Jul 15 05:16:32.099164 containerd[1906]: time="2025-07-15T05:16:32.099111800Z" level=info msg="loading plugin" id=io.containerd.transfer.v1.local type=io.containerd.transfer.v1 Jul 15 05:16:32.099164 containerd[1906]: time="2025-07-15T05:16:32.099133100Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.transfer type=io.containerd.grpc.v1 Jul 15 05:16:32.099164 containerd[1906]: time="2025-07-15T05:16:32.099143600Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.version type=io.containerd.grpc.v1 Jul 15 05:16:32.099242 containerd[1906]: time="2025-07-15T05:16:32.099164200Z" level=info msg="loading plugin" id=io.containerd.monitor.container.v1.restart type=io.containerd.monitor.container.v1 Jul 15 05:16:32.099242 containerd[1906]: time="2025-07-15T05:16:32.099201600Z" level=info msg="loading plugin" id=io.containerd.tracing.processor.v1.otlp type=io.containerd.tracing.processor.v1 Jul 15 05:16:32.099242 containerd[1906]: time="2025-07-15T05:16:32.099216600Z" 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 Jul 15 05:16:32.099242 containerd[1906]: time="2025-07-15T05:16:32.099224800Z" level=info msg="loading plugin" id=io.containerd.internal.v1.tracing type=io.containerd.internal.v1 Jul 15 05:16:32.099242 containerd[1906]: time="2025-07-15T05:16:32.099233800Z" level=info msg="skip loading plugin" error="skip plugin: tracing endpoint not configured" id=io.containerd.internal.v1.tracing type=io.containerd.internal.v1 Jul 15 05:16:32.099242 containerd[1906]: time="2025-07-15T05:16:32.099241100Z" level=info msg="loading plugin" id=io.containerd.ttrpc.v1.otelttrpc type=io.containerd.ttrpc.v1 Jul 15 05:16:32.099362 containerd[1906]: time="2025-07-15T05:16:32.099250200Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.healthcheck type=io.containerd.grpc.v1 Jul 15 05:16:32.099362 containerd[1906]: time="2025-07-15T05:16:32.099259800Z" level=info msg="loading plugin" id=io.containerd.nri.v1.nri type=io.containerd.nri.v1 Jul 15 05:16:32.099362 containerd[1906]: time="2025-07-15T05:16:32.099274900Z" level=info msg="runtime interface created" Jul 15 05:16:32.099362 containerd[1906]: time="2025-07-15T05:16:32.099280000Z" level=info msg="created NRI interface" Jul 15 05:16:32.099362 containerd[1906]: time="2025-07-15T05:16:32.099287400Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.cri type=io.containerd.grpc.v1 Jul 15 05:16:32.099362 containerd[1906]: time="2025-07-15T05:16:32.099297800Z" level=info msg="Connect containerd service" Jul 15 05:16:32.099362 containerd[1906]: time="2025-07-15T05:16:32.099327000Z" level=info msg="using experimental NRI integration - disable nri plugin to prevent this" Jul 15 05:16:32.100074 containerd[1906]: time="2025-07-15T05:16:32.100045300Z" 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" Jul 15 05:16:33.101546 waagent[2032]: 2025-07-15T05:16:33.101456Z INFO Daemon Daemon Azure Linux Agent Version: 2.12.0.4 Jul 15 05:16:33.105795 waagent[2032]: 2025-07-15T05:16:33.105739Z INFO Daemon Daemon OS: flatcar 4396.0.0 Jul 15 05:16:33.109226 waagent[2032]: 2025-07-15T05:16:33.109175Z INFO Daemon Daemon Python: 3.11.13 Jul 15 05:16:33.112593 waagent[2032]: 2025-07-15T05:16:33.112542Z INFO Daemon Daemon Run daemon Jul 15 05:16:33.115561 waagent[2032]: 2025-07-15T05:16:33.115512Z INFO Daemon Daemon No RDMA handler exists for distro='Flatcar Container Linux by Kinvolk' version='4396.0.0' Jul 15 05:16:33.122152 waagent[2032]: 2025-07-15T05:16:33.122097Z INFO Daemon Daemon Using waagent for provisioning Jul 15 05:16:33.126090 waagent[2032]: 2025-07-15T05:16:33.126036Z INFO Daemon Daemon Activate resource disk Jul 15 05:16:33.129335 waagent[2032]: 2025-07-15T05:16:33.129282Z INFO Daemon Daemon Searching gen1 prefix 00000000-0001 or gen2 f8b3781a-1e82-4818-a1c3-63d806ec15bb Jul 15 05:16:33.136374 waagent[2032]: 2025-07-15T05:16:33.136319Z INFO Daemon Daemon Found device: sda Jul 15 05:16:33.141838 containerd[1906]: time="2025-07-15T05:16:33.141793800Z" level=info msg="Start subscribing containerd event" Jul 15 05:16:33.142170 containerd[1906]: time="2025-07-15T05:16:33.141850100Z" level=info msg="Start recovering state" Jul 15 05:16:33.142170 containerd[1906]: time="2025-07-15T05:16:33.141969200Z" level=info msg="Start event monitor" Jul 15 05:16:33.142170 containerd[1906]: time="2025-07-15T05:16:33.141983400Z" level=info msg="Start cni network conf syncer for default" Jul 15 05:16:33.142170 containerd[1906]: time="2025-07-15T05:16:33.141991700Z" level=info msg="Start streaming server" Jul 15 05:16:33.142170 containerd[1906]: time="2025-07-15T05:16:33.142007700Z" level=info msg="Registered namespace \"k8s.io\" with NRI" Jul 15 05:16:33.142170 containerd[1906]: time="2025-07-15T05:16:33.142016200Z" level=info msg="runtime interface starting up..." Jul 15 05:16:33.142170 containerd[1906]: time="2025-07-15T05:16:33.142021800Z" level=info msg=serving... address=/run/containerd/containerd.sock.ttrpc Jul 15 05:16:33.142170 containerd[1906]: time="2025-07-15T05:16:33.142022100Z" level=info msg="starting plugins..." Jul 15 05:16:33.142170 containerd[1906]: time="2025-07-15T05:16:33.142098500Z" level=info msg=serving... address=/run/containerd/containerd.sock Jul 15 05:16:33.142170 containerd[1906]: time="2025-07-15T05:16:33.142117900Z" level=info msg="Synchronizing NRI (plugin) with current runtime state" Jul 15 05:16:33.142376 containerd[1906]: time="2025-07-15T05:16:33.142326500Z" level=info msg="containerd successfully booted in 1.072988s" Jul 15 05:16:33.142415 systemd[1]: Started containerd.service - containerd container runtime. Jul 15 05:16:33.145411 waagent[2032]: 2025-07-15T05:16:33.145354Z INFO Daemon Daemon Examining partition table Jul 15 05:16:33.212740 waagent[2032]: 2025-07-15T05:16:33.212658Z INFO Daemon Daemon GPT not detected, determining filesystem Jul 15 05:16:33.246834 waagent[2032]: 2025-07-15T05:16:33.246775Z INFO Daemon Daemon sfdisk --part-type -f /dev/sda 1 -n succeeded Jul 15 05:16:33.251356 waagent[2032]: 2025-07-15T05:16:33.251303Z INFO Daemon Daemon The partition is formatted with ntfs, updating partition type to 83 Jul 15 05:16:33.568557 kernel: hv_storvsc f8b3781a-1e82-4818-a1c3-63d806ec15bb: tag#249 cmd 0x5a status: scsi 0x2 srb 0x86 hv 0xc0000001 Jul 15 05:16:33.579701 kernel: sda: sda1 Jul 15 05:16:33.589564 waagent[2032]: 2025-07-15T05:16:33.589494Z INFO Daemon Daemon sfdisk --part-type /dev/sda 1 83 succeeded Jul 15 05:16:33.609705 kernel: hv_storvsc f8b3781a-1e82-4818-a1c3-63d806ec15bb: tag#211 cmd 0x5a status: scsi 0x2 srb 0x86 hv 0xc0000001 Jul 15 05:16:33.616696 kernel: sda: sda1 Jul 15 05:16:33.616990 waagent[2032]: 2025-07-15T05:16:33.616931Z INFO Daemon Daemon Format partition [mkfs.ext4 -F /dev/sda1] Jul 15 05:16:39.235257 login[2035]: pam_lastlog(login:session): file /var/log/lastlog is locked/write, retrying Jul 15 05:16:39.235708 login[2034]: pam_unix(login:session): session opened for user core(uid=500) by LOGIN(uid=0) Jul 15 05:16:39.242243 systemd[1]: Created slice user-500.slice - User Slice of UID 500. Jul 15 05:16:39.243558 systemd[1]: Starting user-runtime-dir@500.service - User Runtime Directory /run/user/500... Jul 15 05:16:39.249856 systemd-logind[1889]: New session 1 of user core. Jul 15 05:16:39.307648 systemd[1]: Finished user-runtime-dir@500.service - User Runtime Directory /run/user/500. Jul 15 05:16:39.310186 systemd[1]: Starting user@500.service - User Manager for UID 500... Jul 15 05:16:39.378093 waagent[2032]: 2025-07-15T05:16:39.378022Z INFO Daemon Daemon Mount resource disk [mount -t ext4 /dev/sda1 /mnt/resource] Jul 15 05:16:39.389754 (systemd)[2131]: pam_unix(systemd-user:session): session opened for user core(uid=500) by (uid=0) Jul 15 05:16:39.392207 systemd-logind[1889]: New session c1 of user core. Jul 15 05:16:39.485712 kernel: EXT4-fs (sda1): mounted filesystem f73064b4-2d29-4d3c-9c7a-9136d383fb3f r/w with ordered data mode. Quota mode: none. Jul 15 05:16:39.486124 waagent[2032]: 2025-07-15T05:16:39.486051Z INFO Daemon Daemon Resource disk /dev/sda is mounted at /mnt/resource with ext4 Jul 15 05:16:39.488298 waagent[2032]: 2025-07-15T05:16:39.488235Z INFO Daemon Daemon Clean protocol and wireserver endpoint Jul 15 05:16:39.488515 waagent[2032]: 2025-07-15T05:16:39.488472Z INFO Daemon Daemon Running default provisioning handler Jul 15 05:16:39.496061 waagent[2032]: 2025-07-15T05:16:39.495978Z 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. Jul 15 05:16:39.497891 waagent[2032]: 2025-07-15T05:16:39.497823Z INFO Daemon Daemon Unable to get cloud-init enabled status from service: [Errno 2] No such file or directory: 'service' Jul 15 05:16:39.499432 waagent[2032]: 2025-07-15T05:16:39.499396Z INFO Daemon Daemon cloud-init is enabled: False Jul 15 05:16:39.500880 waagent[2032]: 2025-07-15T05:16:39.500843Z INFO Daemon Daemon Copying ovf-env.xml Jul 15 05:16:39.578797 systemd[2131]: Queued start job for default target default.target. Jul 15 05:16:39.596538 systemd[2131]: Created slice app.slice - User Application Slice. Jul 15 05:16:39.596569 systemd[2131]: Reached target paths.target - Paths. Jul 15 05:16:39.596615 systemd[2131]: Reached target timers.target - Timers. Jul 15 05:16:39.597889 systemd[2131]: Starting dbus.socket - D-Bus User Message Bus Socket... Jul 15 05:16:39.608591 systemd[2131]: Listening on dbus.socket - D-Bus User Message Bus Socket. Jul 15 05:16:39.608650 systemd[2131]: Reached target sockets.target - Sockets. Jul 15 05:16:39.608710 systemd[2131]: Reached target basic.target - Basic System. Jul 15 05:16:39.608756 systemd[2131]: Reached target default.target - Main User Target. Jul 15 05:16:39.608773 systemd[1]: Started user@500.service - User Manager for UID 500. Jul 15 05:16:39.608786 systemd[2131]: Startup finished in 210ms. Jul 15 05:16:39.609946 systemd[1]: Started session-1.scope - Session 1 of User core. Jul 15 05:16:39.675788 waagent[2032]: 2025-07-15T05:16:39.675712Z INFO Daemon Daemon Successfully mounted dvd Jul 15 05:16:39.711588 systemd[1]: mnt-cdrom-secure.mount: Deactivated successfully. Jul 15 05:16:39.711795 waagent[2032]: 2025-07-15T05:16:39.711664Z INFO Daemon Daemon Detect protocol endpoint Jul 15 05:16:39.713231 waagent[2032]: 2025-07-15T05:16:39.713189Z INFO Daemon Daemon Clean protocol and wireserver endpoint Jul 15 05:16:39.714665 waagent[2032]: 2025-07-15T05:16:39.714628Z INFO Daemon Daemon WireServer endpoint is not found. Rerun dhcp handler Jul 15 05:16:39.716072 waagent[2032]: 2025-07-15T05:16:39.716036Z INFO Daemon Daemon Test for route to 168.63.129.16 Jul 15 05:16:39.717974 waagent[2032]: 2025-07-15T05:16:39.717845Z INFO Daemon Daemon Route to 168.63.129.16 exists Jul 15 05:16:39.719615 waagent[2032]: 2025-07-15T05:16:39.719579Z INFO Daemon Daemon Wire server endpoint:168.63.129.16 Jul 15 05:16:39.731316 waagent[2032]: 2025-07-15T05:16:39.731276Z INFO Daemon Daemon Fabric preferred wire protocol version:2015-04-05 Jul 15 05:16:39.731822 waagent[2032]: 2025-07-15T05:16:39.731786Z INFO Daemon Daemon Wire protocol version:2012-11-30 Jul 15 05:16:39.732336 waagent[2032]: 2025-07-15T05:16:39.732306Z INFO Daemon Daemon Server preferred version:2015-04-05 Jul 15 05:16:39.847638 waagent[2032]: 2025-07-15T05:16:39.847575Z INFO Daemon Daemon Initializing goal state during protocol detection Jul 15 05:16:39.849279 waagent[2032]: 2025-07-15T05:16:39.849238Z INFO Daemon Daemon Forcing an update of the goal state. Jul 15 05:16:39.853471 waagent[2032]: 2025-07-15T05:16:39.853423Z INFO Daemon Fetched a new incarnation for the WireServer goal state [incarnation 1] Jul 15 05:16:39.896228 waagent[2032]: 2025-07-15T05:16:39.896184Z INFO Daemon Daemon HostGAPlugin version: 1.0.8.175 Jul 15 05:16:39.898241 waagent[2032]: 2025-07-15T05:16:39.898195Z INFO Daemon Jul 15 05:16:39.898588 waagent[2032]: 2025-07-15T05:16:39.898554Z INFO Daemon Fetched new vmSettings [HostGAPlugin correlation ID: 4a6ef430-9e3d-4473-851b-98f584cfec42 eTag: 10383794345585771523 source: Fabric] Jul 15 05:16:39.900374 waagent[2032]: 2025-07-15T05:16:39.900327Z INFO Daemon The vmSettings originated via Fabric; will ignore them. Jul 15 05:16:39.901891 waagent[2032]: 2025-07-15T05:16:39.901851Z INFO Daemon Jul 15 05:16:39.902390 waagent[2032]: 2025-07-15T05:16:39.902357Z INFO Daemon Fetching full goal state from the WireServer [incarnation 1] Jul 15 05:16:39.907318 waagent[2032]: 2025-07-15T05:16:39.907287Z INFO Daemon Daemon Downloading artifacts profile blob Jul 15 05:16:40.044887 waagent[2032]: 2025-07-15T05:16:40.044813Z INFO Daemon Downloaded certificate {'thumbprint': '2AB012E98361C00BC4794D4ECE23B705B1988DBF', 'hasPrivateKey': True} Jul 15 05:16:40.046853 waagent[2032]: 2025-07-15T05:16:40.046800Z INFO Daemon Fetch goal state completed Jul 15 05:16:40.084168 waagent[2032]: 2025-07-15T05:16:40.084118Z INFO Daemon Daemon Starting provisioning Jul 15 05:16:40.087819 waagent[2032]: 2025-07-15T05:16:40.087764Z INFO Daemon Daemon Handle ovf-env.xml. Jul 15 05:16:40.089849 waagent[2032]: 2025-07-15T05:16:40.089804Z INFO Daemon Daemon Set hostname [ci-4396.0.0-n-957ef44c1e] Jul 15 05:16:40.143325 waagent[2032]: 2025-07-15T05:16:40.143275Z INFO Daemon Daemon Publish hostname [ci-4396.0.0-n-957ef44c1e] Jul 15 05:16:40.145068 waagent[2032]: 2025-07-15T05:16:40.145025Z INFO Daemon Daemon Examine /proc/net/route for primary interface Jul 15 05:16:40.145757 waagent[2032]: 2025-07-15T05:16:40.145720Z INFO Daemon Daemon Primary interface is [eth0] Jul 15 05:16:40.162588 systemd-networkd[1580]: eth0: found matching network '/usr/lib/systemd/network/zz-default.network', based on potentially unpredictable interface name. Jul 15 05:16:40.162598 systemd-networkd[1580]: eth0: Configuring with /usr/lib/systemd/network/zz-default.network. Jul 15 05:16:40.162633 systemd-networkd[1580]: eth0: DHCP lease lost Jul 15 05:16:40.163050 waagent[2032]: 2025-07-15T05:16:40.163005Z INFO Daemon Daemon Create user account if not exists Jul 15 05:16:40.164647 waagent[2032]: 2025-07-15T05:16:40.164578Z INFO Daemon Daemon User core already exists, skip useradd Jul 15 05:16:40.165961 waagent[2032]: 2025-07-15T05:16:40.165923Z INFO Daemon Daemon Configure sudoer Jul 15 05:16:40.177526 waagent[2032]: 2025-07-15T05:16:40.177479Z INFO Daemon Daemon Configure sshd Jul 15 05:16:40.184230 waagent[2032]: 2025-07-15T05:16:40.184180Z INFO Daemon Daemon Added a configuration snippet disabling SSH password-based authentication methods. It also configures SSH client probing to keep connections alive. Jul 15 05:16:40.185806 waagent[2032]: 2025-07-15T05:16:40.185762Z INFO Daemon Daemon Deploy ssh public key. Jul 15 05:16:40.238528 login[2035]: pam_unix(login:session): session opened for user core(uid=500) by LOGIN(uid=0) Jul 15 05:16:40.242947 systemd-logind[1889]: New session 2 of user core. Jul 15 05:16:40.252746 systemd-networkd[1580]: eth0: DHCPv4 address 10.200.8.11/24, gateway 10.200.8.1 acquired from 168.63.129.16 Jul 15 05:16:40.259860 systemd[1]: Started session-2.scope - Session 2 of User core. Jul 15 05:16:41.363279 waagent[2032]: 2025-07-15T05:16:41.363204Z INFO Daemon Daemon Provisioning complete Jul 15 05:16:41.373317 waagent[2032]: 2025-07-15T05:16:41.373276Z INFO Daemon Daemon RDMA capabilities are not enabled, skipping Jul 15 05:16:41.374943 waagent[2032]: 2025-07-15T05:16:41.374894Z INFO Daemon Daemon End of log to /dev/console. The agent will now check for updates and then will process extensions. Jul 15 05:16:41.376314 waagent[2032]: 2025-07-15T05:16:41.376275Z INFO Daemon Daemon Installed Agent WALinuxAgent-2.12.0.4 is the most current agent Jul 15 05:16:41.524152 waagent[2191]: 2025-07-15T05:16:41.524065Z INFO ExtHandler ExtHandler Azure Linux Agent (Goal State Agent version 2.12.0.4) Jul 15 05:16:41.524505 waagent[2191]: 2025-07-15T05:16:41.524216Z INFO ExtHandler ExtHandler OS: flatcar 4396.0.0 Jul 15 05:16:41.524505 waagent[2191]: 2025-07-15T05:16:41.524286Z INFO ExtHandler ExtHandler Python: 3.11.13 Jul 15 05:16:41.524505 waagent[2191]: 2025-07-15T05:16:41.524353Z INFO ExtHandler ExtHandler CPU Arch: x86_64 Jul 15 05:16:41.548698 waagent[2191]: 2025-07-15T05:16:41.548624Z INFO ExtHandler ExtHandler Distro: flatcar-4396.0.0; OSUtil: FlatcarUtil; AgentService: waagent; Python: 3.11.13; Arch: x86_64; systemd: True; LISDrivers: Absent; logrotate: logrotate 3.22.0; Jul 15 05:16:41.548914 waagent[2191]: 2025-07-15T05:16:41.548875Z INFO ExtHandler ExtHandler WireServer endpoint 168.63.129.16 read from file Jul 15 05:16:41.548994 waagent[2191]: 2025-07-15T05:16:41.548961Z INFO ExtHandler ExtHandler Wire server endpoint:168.63.129.16 Jul 15 05:16:41.555775 waagent[2191]: 2025-07-15T05:16:41.555729Z INFO ExtHandler Fetched a new incarnation for the WireServer goal state [incarnation 1] Jul 15 05:16:41.560741 waagent[2191]: 2025-07-15T05:16:41.560670Z INFO ExtHandler ExtHandler HostGAPlugin version: 1.0.8.175 Jul 15 05:16:41.561190 waagent[2191]: 2025-07-15T05:16:41.561151Z INFO ExtHandler Jul 15 05:16:41.561272 waagent[2191]: 2025-07-15T05:16:41.561240Z INFO ExtHandler Fetched new vmSettings [HostGAPlugin correlation ID: 0ba599b9-7a49-44f0-bb3a-79c0cfac9369 eTag: 10383794345585771523 source: Fabric] Jul 15 05:16:41.561594 waagent[2191]: 2025-07-15T05:16:41.561556Z INFO ExtHandler The vmSettings originated via Fabric; will ignore them. Jul 15 05:16:41.562246 waagent[2191]: 2025-07-15T05:16:41.562207Z INFO ExtHandler Jul 15 05:16:41.562321 waagent[2191]: 2025-07-15T05:16:41.562290Z INFO ExtHandler Fetching full goal state from the WireServer [incarnation 1] Jul 15 05:16:41.565794 waagent[2191]: 2025-07-15T05:16:41.565764Z INFO ExtHandler ExtHandler Downloading artifacts profile blob Jul 15 05:16:41.641922 waagent[2191]: 2025-07-15T05:16:41.641800Z INFO ExtHandler Downloaded certificate {'thumbprint': '2AB012E98361C00BC4794D4ECE23B705B1988DBF', 'hasPrivateKey': True} Jul 15 05:16:41.642394 waagent[2191]: 2025-07-15T05:16:41.642351Z INFO ExtHandler Fetch goal state completed Jul 15 05:16:41.653948 waagent[2191]: 2025-07-15T05:16:41.653908Z INFO ExtHandler ExtHandler OpenSSL version: OpenSSL 3.4.1 11 Feb 2025 (Library: OpenSSL 3.4.1 11 Feb 2025) Jul 15 05:16:41.658771 waagent[2191]: 2025-07-15T05:16:41.658729Z INFO ExtHandler ExtHandler WALinuxAgent-2.12.0.4 running as process 2191 Jul 15 05:16:41.658916 waagent[2191]: 2025-07-15T05:16:41.658880Z INFO ExtHandler ExtHandler ******** AutoUpdate.Enabled is set to False, not processing the operation ******** Jul 15 05:16:41.659252 waagent[2191]: 2025-07-15T05:16:41.659215Z INFO ExtHandler ExtHandler ******** AutoUpdate.UpdateToLatestVersion is set to False, not processing the operation ******** Jul 15 05:16:41.660949 waagent[2191]: 2025-07-15T05:16:41.660857Z INFO ExtHandler ExtHandler [CGI] Cgroup monitoring is not supported on ['flatcar', '4396.0.0', '', 'Flatcar Container Linux by Kinvolk'] Jul 15 05:16:41.661391 waagent[2191]: 2025-07-15T05:16:41.661353Z INFO ExtHandler ExtHandler [CGI] Agent will reset the quotas in case distro: ['flatcar', '4396.0.0', '', 'Flatcar Container Linux by Kinvolk'] went from supported to unsupported Jul 15 05:16:41.661546 waagent[2191]: 2025-07-15T05:16:41.661512Z INFO ExtHandler ExtHandler [CGI] Agent cgroups enabled: False Jul 15 05:16:41.662171 waagent[2191]: 2025-07-15T05:16:41.662133Z INFO ExtHandler ExtHandler Starting setup for Persistent firewall rules Jul 15 05:16:41.709750 waagent[2191]: 2025-07-15T05:16:41.709711Z INFO ExtHandler ExtHandler Firewalld service not running/unavailable, trying to set up waagent-network-setup.service Jul 15 05:16:41.709944 waagent[2191]: 2025-07-15T05:16:41.709908Z INFO ExtHandler ExtHandler Successfully updated the Binary file /var/lib/waagent/waagent-network-setup.py for firewall setup Jul 15 05:16:41.716655 waagent[2191]: 2025-07-15T05:16:41.716627Z INFO ExtHandler ExtHandler Service: waagent-network-setup.service not enabled. Adding it now Jul 15 05:16:41.723428 systemd[1]: Reload requested from client PID 2206 ('systemctl') (unit waagent.service)... Jul 15 05:16:41.723445 systemd[1]: Reloading... Jul 15 05:16:41.787747 zram_generator::config[2245]: No configuration found. Jul 15 05:16:41.911170 systemd[1]: /usr/lib/systemd/system/docker.socket:6: ListenStream= references a path below legacy directory /var/run/, updating /var/run/docker.sock → /run/docker.sock; please update the unit file accordingly. Jul 15 05:16:42.073294 systemd[1]: Reloading finished in 349 ms. Jul 15 05:16:42.096582 waagent[2191]: 2025-07-15T05:16:42.096510Z INFO ExtHandler ExtHandler Successfully added and enabled the waagent-network-setup.service Jul 15 05:16:42.096721 waagent[2191]: 2025-07-15T05:16:42.096667Z INFO ExtHandler ExtHandler Persistent firewall rules setup successfully Jul 15 05:16:42.457571 waagent[2191]: 2025-07-15T05:16:42.457488Z INFO ExtHandler ExtHandler DROP rule is not available which implies no firewall rules are set yet. Environment thread will set it up. Jul 15 05:16:42.457905 waagent[2191]: 2025-07-15T05:16:42.457866Z 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] Jul 15 05:16:42.458713 waagent[2191]: 2025-07-15T05:16:42.458651Z INFO ExtHandler ExtHandler Starting env monitor service. Jul 15 05:16:42.459075 waagent[2191]: 2025-07-15T05:16:42.459028Z INFO MonitorHandler ExtHandler WireServer endpoint 168.63.129.16 read from file Jul 15 05:16:42.459256 waagent[2191]: 2025-07-15T05:16:42.459212Z INFO ExtHandler ExtHandler Start SendTelemetryHandler service. Jul 15 05:16:42.459508 waagent[2191]: 2025-07-15T05:16:42.459471Z INFO MonitorHandler ExtHandler Wire server endpoint:168.63.129.16 Jul 15 05:16:42.459647 waagent[2191]: 2025-07-15T05:16:42.459603Z INFO EnvHandler ExtHandler WireServer endpoint 168.63.129.16 read from file Jul 15 05:16:42.460047 waagent[2191]: 2025-07-15T05:16:42.459990Z INFO SendTelemetryHandler ExtHandler Successfully started the SendTelemetryHandler thread Jul 15 05:16:42.460330 waagent[2191]: 2025-07-15T05:16:42.460280Z INFO MonitorHandler ExtHandler Monitor.NetworkConfigurationChanges is disabled. Jul 15 05:16:42.460398 waagent[2191]: 2025-07-15T05:16:42.460355Z INFO EnvHandler ExtHandler Wire server endpoint:168.63.129.16 Jul 15 05:16:42.460449 waagent[2191]: 2025-07-15T05:16:42.460404Z INFO ExtHandler ExtHandler Start Extension Telemetry service. Jul 15 05:16:42.461210 waagent[2191]: 2025-07-15T05:16:42.461159Z INFO EnvHandler ExtHandler Configure routes Jul 15 05:16:42.461291 waagent[2191]: 2025-07-15T05:16:42.461249Z INFO MonitorHandler ExtHandler Routing table from /proc/net/route: Jul 15 05:16:42.461291 waagent[2191]: Iface Destination Gateway Flags RefCnt Use Metric Mask MTU Window IRTT Jul 15 05:16:42.461291 waagent[2191]: eth0 00000000 0108C80A 0003 0 0 1024 00000000 0 0 0 Jul 15 05:16:42.461291 waagent[2191]: eth0 0008C80A 00000000 0001 0 0 1024 00FFFFFF 0 0 0 Jul 15 05:16:42.461291 waagent[2191]: eth0 0108C80A 00000000 0005 0 0 1024 FFFFFFFF 0 0 0 Jul 15 05:16:42.461291 waagent[2191]: eth0 10813FA8 0108C80A 0007 0 0 1024 FFFFFFFF 0 0 0 Jul 15 05:16:42.461291 waagent[2191]: eth0 FEA9FEA9 0108C80A 0007 0 0 1024 FFFFFFFF 0 0 0 Jul 15 05:16:42.461491 waagent[2191]: 2025-07-15T05:16:42.461346Z INFO TelemetryEventsCollector ExtHandler Extension Telemetry pipeline enabled: True Jul 15 05:16:42.461650 waagent[2191]: 2025-07-15T05:16:42.461612Z INFO EnvHandler ExtHandler Gateway:None Jul 15 05:16:42.461800 waagent[2191]: 2025-07-15T05:16:42.461760Z INFO TelemetryEventsCollector ExtHandler Successfully started the TelemetryEventsCollector thread Jul 15 05:16:42.462042 waagent[2191]: 2025-07-15T05:16:42.461981Z INFO ExtHandler ExtHandler Goal State Period: 6 sec. This indicates how often the agent checks for new goal states and reports status. Jul 15 05:16:42.462078 waagent[2191]: 2025-07-15T05:16:42.462046Z INFO EnvHandler ExtHandler Routes:None Jul 15 05:16:42.469603 waagent[2191]: 2025-07-15T05:16:42.469557Z INFO ExtHandler ExtHandler Jul 15 05:16:42.469939 waagent[2191]: 2025-07-15T05:16:42.469900Z INFO ExtHandler ExtHandler ProcessExtensionsGoalState started [incarnation_1 channel: WireServer source: Fabric activity: e84fafd5-e612-4880-a330-5e15b652c583 correlation 04f14c55-a352-4d4a-9f35-c8ec668930f9 created: 2025-07-15T05:15:12.953728Z] Jul 15 05:16:42.471613 waagent[2191]: 2025-07-15T05:16:42.471565Z INFO ExtHandler ExtHandler No extension handlers found, not processing anything. Jul 15 05:16:42.472897 waagent[2191]: 2025-07-15T05:16:42.472858Z INFO ExtHandler ExtHandler ProcessExtensionsGoalState completed [incarnation_1 3 ms] Jul 15 05:16:42.506517 waagent[2191]: 2025-07-15T05:16:42.506464Z 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 Jul 15 05:16:42.506517 waagent[2191]: Try `iptables -h' or 'iptables --help' for more information.) Jul 15 05:16:42.506908 waagent[2191]: 2025-07-15T05:16:42.506868Z INFO ExtHandler ExtHandler [HEARTBEAT] Agent WALinuxAgent-2.12.0.4 is running as the goal state agent [DEBUG HeartbeatCounter: 0;HeartbeatId: C016B8A0-DB1C-4A9E-B760-79464657A60F;DroppedPackets: -1;UpdateGSErrors: 0;AutoUpdate: 0;UpdateMode: SelfUpdate;] Jul 15 05:16:42.522280 waagent[2191]: 2025-07-15T05:16:42.522223Z INFO MonitorHandler ExtHandler Network interfaces: Jul 15 05:16:42.522280 waagent[2191]: Executing ['ip', '-a', '-o', 'link']: Jul 15 05:16:42.522280 waagent[2191]: 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 Jul 15 05:16:42.522280 waagent[2191]: 2: eth0: mtu 1500 qdisc mq state UP mode DEFAULT group default qlen 1000\ link/ether 7c:ed:8d:46:40:f5 brd ff:ff:ff:ff:ff:ff Jul 15 05:16:42.522280 waagent[2191]: Executing ['ip', '-4', '-a', '-o', 'address']: Jul 15 05:16:42.522280 waagent[2191]: 1: lo inet 127.0.0.1/8 scope host lo\ valid_lft forever preferred_lft forever Jul 15 05:16:42.522280 waagent[2191]: 2: eth0 inet 10.200.8.11/24 metric 1024 brd 10.200.8.255 scope global eth0\ valid_lft forever preferred_lft forever Jul 15 05:16:42.522280 waagent[2191]: Executing ['ip', '-6', '-a', '-o', 'address']: Jul 15 05:16:42.522280 waagent[2191]: 1: lo inet6 ::1/128 scope host noprefixroute \ valid_lft forever preferred_lft forever Jul 15 05:16:42.522280 waagent[2191]: 2: eth0 inet6 fe80::7eed:8dff:fe46:40f5/64 scope link proto kernel_ll \ valid_lft forever preferred_lft forever Jul 15 05:16:42.581625 waagent[2191]: 2025-07-15T05:16:42.581553Z INFO EnvHandler ExtHandler Created firewall rules for the Azure Fabric: Jul 15 05:16:42.581625 waagent[2191]: Chain INPUT (policy ACCEPT 0 packets, 0 bytes) Jul 15 05:16:42.581625 waagent[2191]: pkts bytes target prot opt in out source destination Jul 15 05:16:42.581625 waagent[2191]: Chain FORWARD (policy ACCEPT 0 packets, 0 bytes) Jul 15 05:16:42.581625 waagent[2191]: pkts bytes target prot opt in out source destination Jul 15 05:16:42.581625 waagent[2191]: Chain OUTPUT (policy ACCEPT 2 packets, 112 bytes) Jul 15 05:16:42.581625 waagent[2191]: pkts bytes target prot opt in out source destination Jul 15 05:16:42.581625 waagent[2191]: 0 0 ACCEPT tcp -- * * 0.0.0.0/0 168.63.129.16 tcp dpt:53 Jul 15 05:16:42.581625 waagent[2191]: 12 1351 ACCEPT tcp -- * * 0.0.0.0/0 168.63.129.16 owner UID match 0 Jul 15 05:16:42.581625 waagent[2191]: 0 0 DROP tcp -- * * 0.0.0.0/0 168.63.129.16 ctstate INVALID,NEW Jul 15 05:16:42.585254 waagent[2191]: 2025-07-15T05:16:42.585204Z INFO EnvHandler ExtHandler Current Firewall rules: Jul 15 05:16:42.585254 waagent[2191]: Chain INPUT (policy ACCEPT 0 packets, 0 bytes) Jul 15 05:16:42.585254 waagent[2191]: pkts bytes target prot opt in out source destination Jul 15 05:16:42.585254 waagent[2191]: Chain FORWARD (policy ACCEPT 0 packets, 0 bytes) Jul 15 05:16:42.585254 waagent[2191]: pkts bytes target prot opt in out source destination Jul 15 05:16:42.585254 waagent[2191]: Chain OUTPUT (policy ACCEPT 5 packets, 461 bytes) Jul 15 05:16:42.585254 waagent[2191]: pkts bytes target prot opt in out source destination Jul 15 05:16:42.585254 waagent[2191]: 0 0 ACCEPT tcp -- * * 0.0.0.0/0 168.63.129.16 tcp dpt:53 Jul 15 05:16:42.585254 waagent[2191]: 13 1403 ACCEPT tcp -- * * 0.0.0.0/0 168.63.129.16 owner UID match 0 Jul 15 05:16:42.585254 waagent[2191]: 0 0 DROP tcp -- * * 0.0.0.0/0 168.63.129.16 ctstate INVALID,NEW Jul 15 05:16:42.585512 waagent[2191]: 2025-07-15T05:16:42.585472Z INFO EnvHandler ExtHandler Set block dev timeout: sdb with timeout: 300 Jul 15 05:16:42.585664 waagent[2191]: 2025-07-15T05:16:42.585633Z INFO EnvHandler ExtHandler Set block dev timeout: sda with timeout: 300 Jul 15 05:16:54.436519 chronyd[1891]: Selected source PHC0 Jul 15 05:16:59.947195 systemd[1]: Created slice system-sshd.slice - Slice /system/sshd. Jul 15 05:16:59.949948 systemd[1]: Started sshd@0-10.200.8.11:22-10.200.16.10:50902.service - OpenSSH per-connection server daemon (10.200.16.10:50902). Jul 15 05:17:01.016261 sshd[2338]: Accepted publickey for core from 10.200.16.10 port 50902 ssh2: RSA SHA256:tFaO/Gkpdf2AjbVf3W+X+FNU/vH2JWmxNlepyUE0K5I Jul 15 05:17:01.017588 sshd-session[2338]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Jul 15 05:17:01.021702 systemd-logind[1889]: New session 3 of user core. Jul 15 05:17:01.035796 systemd[1]: Started session-3.scope - Session 3 of User core. Jul 15 05:17:01.589780 systemd[1]: Started sshd@1-10.200.8.11:22-10.200.16.10:47456.service - OpenSSH per-connection server daemon (10.200.16.10:47456). Jul 15 05:17:02.222197 sshd[2344]: Accepted publickey for core from 10.200.16.10 port 47456 ssh2: RSA SHA256:tFaO/Gkpdf2AjbVf3W+X+FNU/vH2JWmxNlepyUE0K5I Jul 15 05:17:02.223532 sshd-session[2344]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Jul 15 05:17:02.228221 systemd-logind[1889]: New session 4 of user core. Jul 15 05:17:02.246132 systemd[1]: Started session-4.scope - Session 4 of User core. Jul 15 05:17:02.668782 sshd[2347]: Connection closed by 10.200.16.10 port 47456 Jul 15 05:17:02.669145 sshd-session[2344]: pam_unix(sshd:session): session closed for user core Jul 15 05:17:02.672754 systemd[1]: sshd@1-10.200.8.11:22-10.200.16.10:47456.service: Deactivated successfully. Jul 15 05:17:02.674892 systemd[1]: session-4.scope: Deactivated successfully. Jul 15 05:17:02.675637 systemd-logind[1889]: Session 4 logged out. Waiting for processes to exit. Jul 15 05:17:02.676524 systemd-logind[1889]: Removed session 4. Jul 15 05:17:02.778946 systemd[1]: Started sshd@2-10.200.8.11:22-10.200.16.10:47472.service - OpenSSH per-connection server daemon (10.200.16.10:47472). Jul 15 05:17:03.413080 sshd[2353]: Accepted publickey for core from 10.200.16.10 port 47472 ssh2: RSA SHA256:tFaO/Gkpdf2AjbVf3W+X+FNU/vH2JWmxNlepyUE0K5I Jul 15 05:17:03.414428 sshd-session[2353]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Jul 15 05:17:03.418699 systemd-logind[1889]: New session 5 of user core. Jul 15 05:17:03.427803 systemd[1]: Started session-5.scope - Session 5 of User core. Jul 15 05:17:03.855760 sshd[2356]: Connection closed by 10.200.16.10 port 47472 Jul 15 05:17:03.856102 sshd-session[2353]: pam_unix(sshd:session): session closed for user core Jul 15 05:17:03.859527 systemd[1]: sshd@2-10.200.8.11:22-10.200.16.10:47472.service: Deactivated successfully. Jul 15 05:17:03.861144 systemd[1]: session-5.scope: Deactivated successfully. Jul 15 05:17:03.861820 systemd-logind[1889]: Session 5 logged out. Waiting for processes to exit. Jul 15 05:17:03.862690 systemd-logind[1889]: Removed session 5. Jul 15 05:17:12.709081 kernel: hv_balloon: Max. dynamic memory size: 114688 MB Jul 15 05:17:13.967888 systemd[1]: Started sshd@3-10.200.8.11:22-10.200.16.10:35336.service - OpenSSH per-connection server daemon (10.200.16.10:35336). Jul 15 05:17:14.611303 sshd[2362]: Accepted publickey for core from 10.200.16.10 port 35336 ssh2: RSA SHA256:tFaO/Gkpdf2AjbVf3W+X+FNU/vH2JWmxNlepyUE0K5I Jul 15 05:17:14.612668 sshd-session[2362]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Jul 15 05:17:14.616833 systemd-logind[1889]: New session 6 of user core. Jul 15 05:17:14.626796 systemd[1]: Started session-6.scope - Session 6 of User core. Jul 15 05:17:15.056113 sshd[2365]: Connection closed by 10.200.16.10 port 35336 Jul 15 05:17:15.056497 sshd-session[2362]: pam_unix(sshd:session): session closed for user core Jul 15 05:17:15.060634 systemd[1]: sshd@3-10.200.8.11:22-10.200.16.10:35336.service: Deactivated successfully. Jul 15 05:17:15.062532 systemd[1]: session-6.scope: Deactivated successfully. Jul 15 05:17:15.064960 systemd-logind[1889]: Session 6 logged out. Waiting for processes to exit. Jul 15 05:17:15.067463 systemd-logind[1889]: Removed session 6. Jul 15 05:17:15.167194 systemd[1]: Started sshd@4-10.200.8.11:22-10.200.16.10:35352.service - OpenSSH per-connection server daemon (10.200.16.10:35352). Jul 15 05:17:15.798420 sshd[2371]: Accepted publickey for core from 10.200.16.10 port 35352 ssh2: RSA SHA256:tFaO/Gkpdf2AjbVf3W+X+FNU/vH2JWmxNlepyUE0K5I Jul 15 05:17:15.799809 sshd-session[2371]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Jul 15 05:17:15.804224 systemd-logind[1889]: New session 7 of user core. Jul 15 05:17:15.822810 systemd[1]: Started session-7.scope - Session 7 of User core. Jul 15 05:17:15.899879 update_engine[1894]: I20250715 05:17:15.899791 1894 update_attempter.cc:509] Updating boot flags... Jul 15 05:17:16.246466 sshd[2374]: Connection closed by 10.200.16.10 port 35352 Jul 15 05:17:16.246808 sshd-session[2371]: pam_unix(sshd:session): session closed for user core Jul 15 05:17:16.250226 systemd[1]: sshd@4-10.200.8.11:22-10.200.16.10:35352.service: Deactivated successfully. Jul 15 05:17:16.251836 systemd[1]: session-7.scope: Deactivated successfully. Jul 15 05:17:16.252493 systemd-logind[1889]: Session 7 logged out. Waiting for processes to exit. Jul 15 05:17:16.253384 systemd-logind[1889]: Removed session 7. Jul 15 05:17:26.362091 systemd[1]: Started sshd@5-10.200.8.11:22-10.200.16.10:44406.service - OpenSSH per-connection server daemon (10.200.16.10:44406). Jul 15 05:17:26.991263 sshd[2444]: Accepted publickey for core from 10.200.16.10 port 44406 ssh2: RSA SHA256:tFaO/Gkpdf2AjbVf3W+X+FNU/vH2JWmxNlepyUE0K5I Jul 15 05:17:26.992622 sshd-session[2444]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Jul 15 05:17:26.996775 systemd-logind[1889]: New session 8 of user core. Jul 15 05:17:27.012801 systemd[1]: Started session-8.scope - Session 8 of User core. Jul 15 05:17:27.434245 sshd[2447]: Connection closed by 10.200.16.10 port 44406 Jul 15 05:17:27.434625 sshd-session[2444]: pam_unix(sshd:session): session closed for user core Jul 15 05:17:27.437551 systemd[1]: sshd@5-10.200.8.11:22-10.200.16.10:44406.service: Deactivated successfully. Jul 15 05:17:27.439176 systemd[1]: session-8.scope: Deactivated successfully. Jul 15 05:17:27.440369 systemd-logind[1889]: Session 8 logged out. Waiting for processes to exit. Jul 15 05:17:27.441282 systemd-logind[1889]: Removed session 8. Jul 15 05:17:27.545058 systemd[1]: Started sshd@6-10.200.8.11:22-10.200.16.10:44414.service - OpenSSH per-connection server daemon (10.200.16.10:44414). Jul 15 05:17:28.174093 sshd[2453]: Accepted publickey for core from 10.200.16.10 port 44414 ssh2: RSA SHA256:tFaO/Gkpdf2AjbVf3W+X+FNU/vH2JWmxNlepyUE0K5I Jul 15 05:17:28.175428 sshd-session[2453]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Jul 15 05:17:28.179615 systemd-logind[1889]: New session 9 of user core. Jul 15 05:17:28.193802 systemd[1]: Started session-9.scope - Session 9 of User core. Jul 15 05:17:28.617386 sshd[2456]: Connection closed by 10.200.16.10 port 44414 Jul 15 05:17:28.617747 sshd-session[2453]: pam_unix(sshd:session): session closed for user core Jul 15 05:17:28.621096 systemd[1]: sshd@6-10.200.8.11:22-10.200.16.10:44414.service: Deactivated successfully. Jul 15 05:17:28.622813 systemd[1]: session-9.scope: Deactivated successfully. Jul 15 05:17:28.623470 systemd-logind[1889]: Session 9 logged out. Waiting for processes to exit. Jul 15 05:17:28.624347 systemd-logind[1889]: Removed session 9. Jul 15 05:17:31.249215 setup-nvidia[2461]: % Total % Received % Xferd Average Speed Time Time Time Current Jul 15 05:17:31.249577 setup-nvidia[2461]: Dload Upload Total Spent Left Speed Jul 15 05:17:38.732902 systemd[1]: Started sshd@7-10.200.8.11:22-10.200.16.10:52218.service - OpenSSH per-connection server daemon (10.200.16.10:52218). Jul 15 05:17:39.386743 sshd[2463]: Accepted publickey for core from 10.200.16.10 port 52218 ssh2: RSA SHA256:tFaO/Gkpdf2AjbVf3W+X+FNU/vH2JWmxNlepyUE0K5I Jul 15 05:17:39.388103 sshd-session[2463]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Jul 15 05:17:39.392403 systemd-logind[1889]: New session 10 of user core. Jul 15 05:17:39.403797 systemd[1]: Started session-10.scope - Session 10 of User core. Jul 15 05:17:39.832155 sshd[2466]: Connection closed by 10.200.16.10 port 52218 Jul 15 05:17:39.832533 sshd-session[2463]: pam_unix(sshd:session): session closed for user core Jul 15 05:17:39.836141 systemd[1]: sshd@7-10.200.8.11:22-10.200.16.10:52218.service: Deactivated successfully. Jul 15 05:17:39.837920 systemd[1]: session-10.scope: Deactivated successfully. Jul 15 05:17:39.838717 systemd-logind[1889]: Session 10 logged out. Waiting for processes to exit. Jul 15 05:17:39.839598 systemd-logind[1889]: Removed session 10. Jul 15 05:17:39.942976 systemd[1]: Started sshd@8-10.200.8.11:22-10.200.16.10:52224.service - OpenSSH per-connection server daemon (10.200.16.10:52224). Jul 15 05:17:40.571156 sshd[2472]: Accepted publickey for core from 10.200.16.10 port 52224 ssh2: RSA SHA256:tFaO/Gkpdf2AjbVf3W+X+FNU/vH2JWmxNlepyUE0K5I Jul 15 05:17:40.572513 sshd-session[2472]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Jul 15 05:17:40.576784 systemd-logind[1889]: New session 11 of user core. Jul 15 05:17:40.589799 systemd[1]: Started session-11.scope - Session 11 of User core. Jul 15 05:17:41.014716 sshd[2475]: Connection closed by 10.200.16.10 port 52224 Jul 15 05:17:41.014994 sshd-session[2472]: pam_unix(sshd:session): session closed for user core Jul 15 05:17:41.018407 systemd[1]: sshd@8-10.200.8.11:22-10.200.16.10:52224.service: Deactivated successfully. Jul 15 05:17:41.020098 systemd[1]: session-11.scope: Deactivated successfully. Jul 15 05:17:41.020769 systemd-logind[1889]: Session 11 logged out. Waiting for processes to exit. Jul 15 05:17:41.021642 systemd-logind[1889]: Removed session 11. Jul 15 05:17:51.125810 systemd[1]: Started sshd@9-10.200.8.11:22-10.200.16.10:55622.service - OpenSSH per-connection server daemon (10.200.16.10:55622). Jul 15 05:17:51.754933 sshd[2481]: Accepted publickey for core from 10.200.16.10 port 55622 ssh2: RSA SHA256:tFaO/Gkpdf2AjbVf3W+X+FNU/vH2JWmxNlepyUE0K5I Jul 15 05:17:51.756300 sshd-session[2481]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Jul 15 05:17:51.760419 systemd-logind[1889]: New session 12 of user core. Jul 15 05:17:51.768797 systemd[1]: Started session-12.scope - Session 12 of User core. Jul 15 05:17:52.202586 sshd[2484]: Connection closed by 10.200.16.10 port 55622 Jul 15 05:17:52.202978 sshd-session[2481]: pam_unix(sshd:session): session closed for user core Jul 15 05:17:52.206483 systemd[1]: sshd@9-10.200.8.11:22-10.200.16.10:55622.service: Deactivated successfully. Jul 15 05:17:52.208307 systemd[1]: session-12.scope: Deactivated successfully. Jul 15 05:17:52.209142 systemd-logind[1889]: Session 12 logged out. Waiting for processes to exit. Jul 15 05:17:52.210178 systemd-logind[1889]: Removed session 12. Jul 15 05:17:52.319288 systemd[1]: Started sshd@10-10.200.8.11:22-10.200.16.10:55630.service - OpenSSH per-connection server daemon (10.200.16.10:55630). Jul 15 05:17:52.950457 sshd[2490]: Accepted publickey for core from 10.200.16.10 port 55630 ssh2: RSA SHA256:tFaO/Gkpdf2AjbVf3W+X+FNU/vH2JWmxNlepyUE0K5I Jul 15 05:17:52.951766 sshd-session[2490]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Jul 15 05:17:52.959254 systemd-logind[1889]: New session 13 of user core. Jul 15 05:17:52.969828 systemd[1]: Started session-13.scope - Session 13 of User core. Jul 15 05:17:53.394497 sshd[2493]: Connection closed by 10.200.16.10 port 55630 Jul 15 05:17:53.394882 sshd-session[2490]: pam_unix(sshd:session): session closed for user core Jul 15 05:17:53.398524 systemd[1]: sshd@10-10.200.8.11:22-10.200.16.10:55630.service: Deactivated successfully. Jul 15 05:17:53.400125 systemd[1]: session-13.scope: Deactivated successfully. Jul 15 05:17:53.400823 systemd-logind[1889]: Session 13 logged out. Waiting for processes to exit. Jul 15 05:17:53.401729 systemd-logind[1889]: Removed session 13. Jul 15 05:17:55.314473 setup-nvidia[2461]: \u000d 0 0 0 0 0 0 0 0 --:--:-- --:--:-- --:--:-- 0\u000d 0 546M 0 240k 0 0 237k 0 0:39:20 0:00:01 0:39:19 237k\u000d 2 546M 2 13.5M 0 0 6999k 0 0:01:19 0:00:01 0:01:18 7000k\u000d 7 546M 7 38.9M 0 0 13.0M 0 0:00:41 0:00:02 0:00:39 13.0M\u000d 11 546M 11 64.3M 0 0 16.1M 0 0:00:33 0:00:03 0:00:30 16.1M\u000d 16 546M 16 87.7M 0 0 17.6M 0 0:00:30 0:00:04 0:00:26 17.6M\u000d 20 546M 20 110M 0 0 18.5M 0 0:00:29 0:00:05 0:00:24 22.3M\u000d 24 546M 24 134M 0 0 19.4M 0 0:00:28 0:00:06 0:00:22 24.4M\u000d 29 546M 29 161M 0 0 20.2M 0 0:00:26 0:00:07 0:00:19 24.6M\u000d 34 546M 34 187M 0 0 20.9M 0 0:00:26 0:00:08 0:00:18 24.8M\u000d 39 546M 39 213M 0 0 21.2M 0 0:00:25 0:00:10 0:00:15 24.6M\u000d 43 546M 43 238M 0 0 21.6M 0 0:00:25 0:00:11 0:00:14 25.1M\u000d 48 546M 48 263M 0 0 21.8M 0 0:00:24 0:00:12 0:00:12 25.1M\u000d 52 546M 52 288M 0 0 22.0M 0 0:00:24 0:00:13 0:00:11 24.8M\u000d 57 546M 57 312M 0 0 22.2M 0 0:00:24 0:00:14 0:00:10 24.4M\u000d 61 546M 61 336M 0 0 22.3M 0 0:00:24 0:00:15 0:00:09 24.7M\u000d 66 546M 66 361M 0 0 22.5M 0 0:00:24 0:00:16 0:00:08 24.6M\u000d 70 546M 70 385M 0 0 22.6M 0 0:00:24 0:00:17 0:00:07 24.5M\u000d 74 546M 74 409M 0 0 22.7M 0 0:00:24 0:00:18 0:00:06 24.3M\u000d 79 546M 79 432M 0 0 22.7M 0 0:00:24 0:00:19 0:00:05 24.1M\u000d 83 546M 83 454M 0 0 22.7M 0 0:00:24 0:00:19 0:00:05 23.7M\u000d 87 546M 87 476M 0 0 22.7M 0 0:00:24 0:00:20 0:00:04 23.3M\u000d 91 546M 91 498M 0 0 22.7M 0 0:00:24 0:00:21 0:00:03 22.9M\u000d 95 546M 95 520M 0 0 22.6M 0 0:00:24 0:00:22 0:00:02 22.5M\u000d 99 546M 99 544M 0 0 22.6M 0 0:00:24 0:00:24 --:--:-- 22.2M\u000d100 546M 100 546M 0 0 22.7M 0 0:00:24 0:00:24 --:--:-- 22.7M Jul 15 05:18:03.512019 systemd[1]: Started sshd@11-10.200.8.11:22-10.200.16.10:46916.service - OpenSSH per-connection server daemon (10.200.16.10:46916). Jul 15 05:18:04.154859 sshd[2509]: Accepted publickey for core from 10.200.16.10 port 46916 ssh2: RSA SHA256:tFaO/Gkpdf2AjbVf3W+X+FNU/vH2JWmxNlepyUE0K5I Jul 15 05:18:04.157622 sshd-session[2509]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Jul 15 05:18:04.167253 systemd-logind[1889]: New session 14 of user core. Jul 15 05:18:04.177934 systemd[1]: Started session-14.scope - Session 14 of User core. Jul 15 05:18:04.607491 sshd[2512]: Connection closed by 10.200.16.10 port 46916 Jul 15 05:18:04.608894 sshd-session[2509]: pam_unix(sshd:session): session closed for user core Jul 15 05:18:04.614265 systemd[1]: sshd@11-10.200.8.11:22-10.200.16.10:46916.service: Deactivated successfully. Jul 15 05:18:04.617451 systemd[1]: session-14.scope: Deactivated successfully. Jul 15 05:18:04.619979 systemd-logind[1889]: Session 14 logged out. Waiting for processes to exit. Jul 15 05:18:04.622023 systemd-logind[1889]: Removed session 14. Jul 15 05:18:04.722047 systemd[1]: Started sshd@12-10.200.8.11:22-10.200.16.10:46918.service - OpenSSH per-connection server daemon (10.200.16.10:46918). Jul 15 05:18:05.368045 sshd[2518]: Accepted publickey for core from 10.200.16.10 port 46918 ssh2: RSA SHA256:tFaO/Gkpdf2AjbVf3W+X+FNU/vH2JWmxNlepyUE0K5I Jul 15 05:18:05.369518 sshd-session[2518]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Jul 15 05:18:05.378922 systemd-logind[1889]: New session 15 of user core. Jul 15 05:18:05.388873 systemd[1]: Started session-15.scope - Session 15 of User core. Jul 15 05:18:05.815370 sshd[2521]: Connection closed by 10.200.16.10 port 46918 Jul 15 05:18:05.813913 sshd-session[2518]: pam_unix(sshd:session): session closed for user core Jul 15 05:18:05.819661 systemd-logind[1889]: Session 15 logged out. Waiting for processes to exit. Jul 15 05:18:05.821050 systemd[1]: sshd@12-10.200.8.11:22-10.200.16.10:46918.service: Deactivated successfully. Jul 15 05:18:05.822546 systemd[1]: session-15.scope: Deactivated successfully. Jul 15 05:18:05.826880 systemd-logind[1889]: Removed session 15. Jul 15 05:18:05.939901 setup-nvidia[1885]: Downloading NVIDIA 535.247.01 Driver Jul 15 05:18:05.944632 setup-nvidia[2527]: % Total % Received % Xferd Average Speed Time Time Time Current Jul 15 05:18:05.944879 setup-nvidia[2527]: Dload Upload Total Spent Left Speed Jul 15 05:18:08.526483 setup-nvidia[2527]: \u000d 0 0 0 0 0 0 0 0 --:--:-- --:--:-- --:--:-- 0\u000d 0 326M 0 65536 0 0 129k 0 0:43:03 --:--:-- 0:43:03 129k\u000d 35 326M 35 115M 0 0 92.5M 0 0:00:03 0:00:01 0:00:02 92.5M\u000d 86 326M 86 282M 0 0 125M 0 0:00:02 0:00:02 --:--:-- 125M\u000d100 326M 100 326M 0 0 126M 0 0:00:02 0:00:02 --:--:-- 126M Jul 15 05:18:08.583164 setup-nvidia[1885]: Extract the NVIDIA Driver Installer 535.247.01 Jul 15 05:18:08.583353 setup-nvidia[1885]: /opt/nvidia/workdir/nvidia-workdir / Jul 15 05:18:08.600765 setup-nvidia[2530]: Creating directory NVIDIA-Linux-x86_64-535.247.01 Jul 15 05:18:08.922865 setup-nvidia[2530]: Verifying archive integrity... OK Jul 15 05:18:09.599126 setup-nvidia[2530]: Uncompressing NVIDIA Accelerated Graphics Driver for Linux-x86_64 535.247.01 Jul 15 05:18:11.373161 setup-nvidia[2556]: ........................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................ Jul 15 05:18:11.444663 setup-nvidia[1885]: / Jul 15 05:18:11.444911 setup-nvidia[1885]: Spawn system-nspawn container to install the NVIDIA drivers Jul 15 05:18:11.631373 sudo[2563]: root : PWD=/ ; USER=root ; COMMAND=/usr/sbin/systemd-nspawn --keep-unit --register=no --read-only --volatile=overlay --image=/opt/nvidia/workdir/flatcar_developer_container-4396.0.0+nightly-20250714-2100.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.247.01 Jul 15 05:18:11.633099 sudo[2563]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=0) Jul 15 05:18:11.639172 systemd[1]: Created slice user-0.slice - User Slice of UID 0. Jul 15 05:18:11.641162 systemd[1]: Starting user-runtime-dir@0.service - User Runtime Directory /run/user/0... Jul 15 05:18:11.677039 systemd[1]: Finished user-runtime-dir@0.service - User Runtime Directory /run/user/0. Jul 15 05:18:11.684639 systemd[1]: Starting user@0.service - User Manager for UID 0... Jul 15 05:18:11.698911 (systemd)[2566]: pam_unix(systemd-user:session): session opened for user root(uid=0) by (uid=0) Jul 15 05:18:11.701142 systemd-logind[1889]: New session c3 of user root. Jul 15 05:18:11.876807 systemd[2566]: Queued start job for default target default.target. Jul 15 05:18:11.896779 systemd[2566]: Created slice app.slice - User Application Slice. Jul 15 05:18:11.896806 systemd[2566]: Reached target paths.target - Paths. Jul 15 05:18:11.896850 systemd[2566]: Reached target timers.target - Timers. Jul 15 05:18:11.897966 systemd[2566]: Starting dbus.socket - D-Bus User Message Bus Socket... Jul 15 05:18:11.908014 systemd[2566]: Listening on dbus.socket - D-Bus User Message Bus Socket. Jul 15 05:18:11.908071 systemd[2566]: Reached target sockets.target - Sockets. Jul 15 05:18:11.908121 systemd[2566]: Reached target basic.target - Basic System. Jul 15 05:18:11.908165 systemd[2566]: Reached target default.target - Main User Target. Jul 15 05:18:11.908195 systemd[2566]: Startup finished in 201ms. Jul 15 05:18:11.908270 systemd[1]: Started user@0.service - User Manager for UID 0. Jul 15 05:18:11.911011 systemd[1]: Started session-c2.scope - Session c2 of User root. Jul 15 05:18:11.963706 kernel: loop6: detected capacity change from 0 to 12644352 Jul 15 05:18:11.971700 kernel: loop6: p9 Jul 15 05:18:12.010740 setup-nvidia[2575]: ░ Spawning container flatcardevelopercontainer-4396.0.0nightly-20250714-2100.bin on /opt/nvidia/workdir/flatcar_developer_container-4396.0.0+nightly-20250714-2100.bin. Jul 15 05:18:12.638849 kernel: EXT4-fs (loop6p9): write access unavailable, skipping orphan cleanup Jul 15 05:18:12.638981 kernel: EXT4-fs (loop6p9): mounted filesystem 972f2beb-d1b6-473e-a98a-ae044746a8ba ro without journal. Quota mode: none. Jul 15 05:18:15.930988 systemd[1]: Started sshd@13-10.200.8.11:22-10.200.16.10:40458.service - OpenSSH per-connection server daemon (10.200.16.10:40458). Jul 15 05:18:16.559916 sshd[2931]: Accepted publickey for core from 10.200.16.10 port 40458 ssh2: RSA SHA256:tFaO/Gkpdf2AjbVf3W+X+FNU/vH2JWmxNlepyUE0K5I Jul 15 05:18:16.561271 sshd-session[2931]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Jul 15 05:18:16.565850 systemd-logind[1889]: New session 16 of user core. Jul 15 05:18:16.577871 systemd[1]: Started session-16.scope - Session 16 of User core. Jul 15 05:18:17.007246 sshd[3195]: Connection closed by 10.200.16.10 port 40458 Jul 15 05:18:17.007659 sshd-session[2931]: pam_unix(sshd:session): session closed for user core Jul 15 05:18:17.010779 systemd[1]: sshd@13-10.200.8.11:22-10.200.16.10:40458.service: Deactivated successfully. Jul 15 05:18:17.012551 systemd[1]: session-16.scope: Deactivated successfully. Jul 15 05:18:17.014361 systemd-logind[1889]: Session 16 logged out. Waiting for processes to exit. Jul 15 05:18:17.015261 systemd-logind[1889]: Removed session 16. Jul 15 05:18:17.123027 systemd[1]: Started sshd@14-10.200.8.11:22-10.200.16.10:40468.service - OpenSSH per-connection server daemon (10.200.16.10:40468). Jul 15 05:18:17.751817 sshd[3308]: Accepted publickey for core from 10.200.16.10 port 40468 ssh2: RSA SHA256:tFaO/Gkpdf2AjbVf3W+X+FNU/vH2JWmxNlepyUE0K5I Jul 15 05:18:17.753303 sshd-session[3308]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Jul 15 05:18:17.757636 systemd-logind[1889]: New session 17 of user core. Jul 15 05:18:17.771801 systemd[1]: Started session-17.scope - Session 17 of User core. Jul 15 05:18:18.196571 sshd[3311]: Connection closed by 10.200.16.10 port 40468 Jul 15 05:18:18.196951 sshd-session[3308]: pam_unix(sshd:session): session closed for user core Jul 15 05:18:18.200500 systemd[1]: sshd@14-10.200.8.11:22-10.200.16.10:40468.service: Deactivated successfully. Jul 15 05:18:18.202181 systemd[1]: session-17.scope: Deactivated successfully. Jul 15 05:18:18.202950 systemd-logind[1889]: Session 17 logged out. Waiting for processes to exit. Jul 15 05:18:18.203871 systemd-logind[1889]: Removed session 17. Jul 15 05:18:28.355095 systemd[1]: Started sshd@15-10.200.8.11:22-10.200.16.10:45186.service - OpenSSH per-connection server daemon (10.200.16.10:45186). Jul 15 05:18:29.007921 sshd[6605]: Accepted publickey for core from 10.200.16.10 port 45186 ssh2: RSA SHA256:tFaO/Gkpdf2AjbVf3W+X+FNU/vH2JWmxNlepyUE0K5I Jul 15 05:18:29.009431 sshd-session[6605]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Jul 15 05:18:29.016715 systemd-logind[1889]: New session 18 of user core. Jul 15 05:18:29.027889 systemd[1]: Started session-18.scope - Session 18 of User core. Jul 15 05:18:29.452611 sshd[6829]: Connection closed by 10.200.16.10 port 45186 Jul 15 05:18:29.453030 sshd-session[6605]: pam_unix(sshd:session): session closed for user core Jul 15 05:18:29.458239 systemd-logind[1889]: Session 18 logged out. Waiting for processes to exit. Jul 15 05:18:29.458406 systemd[1]: sshd@15-10.200.8.11:22-10.200.16.10:45186.service: Deactivated successfully. Jul 15 05:18:29.461038 systemd[1]: session-18.scope: Deactivated successfully. Jul 15 05:18:29.463546 systemd-logind[1889]: Removed session 18. Jul 15 05:18:29.566384 systemd[1]: Started sshd@16-10.200.8.11:22-10.200.16.10:45188.service - OpenSSH per-connection server daemon (10.200.16.10:45188). Jul 15 05:18:30.213224 sshd[7025]: Accepted publickey for core from 10.200.16.10 port 45188 ssh2: RSA SHA256:tFaO/Gkpdf2AjbVf3W+X+FNU/vH2JWmxNlepyUE0K5I Jul 15 05:18:30.215251 sshd-session[7025]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Jul 15 05:18:30.224672 systemd-logind[1889]: New session 19 of user core. Jul 15 05:18:30.230830 systemd[1]: Started session-19.scope - Session 19 of User core. Jul 15 05:18:30.662094 sshd[7212]: Connection closed by 10.200.16.10 port 45188 Jul 15 05:18:30.662732 sshd-session[7025]: pam_unix(sshd:session): session closed for user core Jul 15 05:18:30.666593 systemd-logind[1889]: Session 19 logged out. Waiting for processes to exit. Jul 15 05:18:30.668398 systemd[1]: sshd@16-10.200.8.11:22-10.200.16.10:45188.service: Deactivated successfully. Jul 15 05:18:30.671004 systemd[1]: session-19.scope: Deactivated successfully. Jul 15 05:18:30.673588 systemd-logind[1889]: Removed session 19. Jul 15 05:18:40.777846 systemd[1]: Started sshd@17-10.200.8.11:22-10.200.16.10:47902.service - OpenSSH per-connection server daemon (10.200.16.10:47902). Jul 15 05:18:41.424366 sshd[10113]: Accepted publickey for core from 10.200.16.10 port 47902 ssh2: RSA SHA256:tFaO/Gkpdf2AjbVf3W+X+FNU/vH2JWmxNlepyUE0K5I Jul 15 05:18:41.425886 sshd-session[10113]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Jul 15 05:18:41.432277 systemd-logind[1889]: New session 20 of user core. Jul 15 05:18:41.439812 systemd[1]: Started session-20.scope - Session 20 of User core. Jul 15 05:18:41.871651 sshd[10257]: Connection closed by 10.200.16.10 port 47902 Jul 15 05:18:41.873767 sshd-session[10113]: pam_unix(sshd:session): session closed for user core Jul 15 05:18:41.877823 systemd-logind[1889]: Session 20 logged out. Waiting for processes to exit. Jul 15 05:18:41.878012 systemd[1]: sshd@17-10.200.8.11:22-10.200.16.10:47902.service: Deactivated successfully. Jul 15 05:18:41.879934 systemd[1]: session-20.scope: Deactivated successfully. Jul 15 05:18:41.881338 systemd-logind[1889]: Removed session 20. Jul 15 05:18:41.984172 systemd[1]: Started sshd@18-10.200.8.11:22-10.200.16.10:47910.service - OpenSSH per-connection server daemon (10.200.16.10:47910). Jul 15 05:18:43.534167 sshd[10340]: Accepted publickey for core from 10.200.16.10 port 47910 ssh2: RSA SHA256:tFaO/Gkpdf2AjbVf3W+X+FNU/vH2JWmxNlepyUE0K5I Jul 15 05:18:43.534337 sshd-session[10340]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Jul 15 05:18:43.539709 systemd-logind[1889]: New session 21 of user core. Jul 15 05:18:43.546866 systemd[1]: Started session-21.scope - Session 21 of User core. Jul 15 05:18:43.904046 sshd[10376]: Connection closed by 10.200.16.10 port 47910 Jul 15 05:18:43.905883 sshd-session[10340]: pam_unix(sshd:session): session closed for user core Jul 15 05:18:43.909601 systemd-logind[1889]: Session 21 logged out. Waiting for processes to exit. Jul 15 05:18:43.911041 systemd[1]: sshd@18-10.200.8.11:22-10.200.16.10:47910.service: Deactivated successfully. Jul 15 05:18:43.914226 systemd[1]: session-21.scope: Deactivated successfully. Jul 15 05:18:43.916866 systemd-logind[1889]: Removed session 21. Jul 15 05:18:54.014959 systemd[1]: Started sshd@19-10.200.8.11:22-10.200.16.10:54218.service - OpenSSH per-connection server daemon (10.200.16.10:54218). Jul 15 05:18:55.534501 sshd-session[11469]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Jul 15 05:18:55.535059 sshd[11469]: Accepted publickey for core from 10.200.16.10 port 54218 ssh2: RSA SHA256:tFaO/Gkpdf2AjbVf3W+X+FNU/vH2JWmxNlepyUE0K5I Jul 15 05:18:55.540436 systemd-logind[1889]: New session 22 of user core. Jul 15 05:18:55.550872 systemd[1]: Started session-22.scope - Session 22 of User core. Jul 15 05:18:55.902750 sshd[11494]: Connection closed by 10.200.16.10 port 54218 Jul 15 05:18:55.903176 sshd-session[11469]: pam_unix(sshd:session): session closed for user core Jul 15 05:18:55.907066 systemd[1]: sshd@19-10.200.8.11:22-10.200.16.10:54218.service: Deactivated successfully. Jul 15 05:18:55.908956 systemd[1]: session-22.scope: Deactivated successfully. Jul 15 05:18:55.909744 systemd-logind[1889]: Session 22 logged out. Waiting for processes to exit. Jul 15 05:18:55.910674 systemd-logind[1889]: Removed session 22. Jul 15 05:18:56.015362 systemd[1]: Started sshd@20-10.200.8.11:22-10.200.16.10:54222.service - OpenSSH per-connection server daemon (10.200.16.10:54222). Jul 15 05:19:00.282408 sshd[11627]: Accepted publickey for core from 10.200.16.10 port 54222 ssh2: RSA SHA256:tFaO/Gkpdf2AjbVf3W+X+FNU/vH2JWmxNlepyUE0K5I Jul 15 05:19:00.282814 sshd-session[11627]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Jul 15 05:19:00.290810 systemd-logind[1889]: New session 23 of user core. Jul 15 05:19:00.303844 systemd[1]: Started session-23.scope - Session 23 of User core. Jul 15 05:19:00.655381 sshd[11652]: Connection closed by 10.200.16.10 port 54222 Jul 15 05:19:00.655855 sshd-session[11627]: pam_unix(sshd:session): session closed for user core Jul 15 05:19:00.659663 systemd[1]: sshd@20-10.200.8.11:22-10.200.16.10:54222.service: Deactivated successfully. Jul 15 05:19:00.661391 systemd[1]: session-23.scope: Deactivated successfully. Jul 15 05:19:00.662108 systemd-logind[1889]: Session 23 logged out. Waiting for processes to exit. Jul 15 05:19:00.663060 systemd-logind[1889]: Removed session 23. Jul 15 05:19:10.772655 systemd[1]: Started sshd@21-10.200.8.11:22-10.200.16.10:57370.service - OpenSSH per-connection server daemon (10.200.16.10:57370). Jul 15 05:19:11.422871 sshd[12043]: Accepted publickey for core from 10.200.16.10 port 57370 ssh2: RSA SHA256:tFaO/Gkpdf2AjbVf3W+X+FNU/vH2JWmxNlepyUE0K5I Jul 15 05:19:11.426598 sshd-session[12043]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Jul 15 05:19:11.440150 systemd-logind[1889]: New session 24 of user core. Jul 15 05:19:11.446419 systemd[1]: Started session-24.scope - Session 24 of User core. Jul 15 05:19:11.873135 sshd[12069]: Connection closed by 10.200.16.10 port 57370 Jul 15 05:19:11.876871 sshd-session[12043]: pam_unix(sshd:session): session closed for user core Jul 15 05:19:11.880869 systemd[1]: sshd@21-10.200.8.11:22-10.200.16.10:57370.service: Deactivated successfully. Jul 15 05:19:11.881323 systemd-logind[1889]: Session 24 logged out. Waiting for processes to exit. Jul 15 05:19:11.884974 systemd[1]: session-24.scope: Deactivated successfully. Jul 15 05:19:11.889148 systemd-logind[1889]: Removed session 24. Jul 15 05:19:11.994077 systemd[1]: Started sshd@22-10.200.8.11:22-10.200.16.10:57386.service - OpenSSH per-connection server daemon (10.200.16.10:57386). Jul 15 05:19:12.635748 sshd[12093]: Accepted publickey for core from 10.200.16.10 port 57386 ssh2: RSA SHA256:tFaO/Gkpdf2AjbVf3W+X+FNU/vH2JWmxNlepyUE0K5I Jul 15 05:19:12.637742 sshd-session[12093]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Jul 15 05:19:12.646137 systemd-logind[1889]: New session 25 of user core. Jul 15 05:19:12.654486 systemd[1]: Started session-25.scope - Session 25 of User core. Jul 15 05:19:13.090096 sshd[12114]: Connection closed by 10.200.16.10 port 57386 Jul 15 05:19:13.091000 sshd-session[12093]: pam_unix(sshd:session): session closed for user core Jul 15 05:19:13.098339 systemd[1]: sshd@22-10.200.8.11:22-10.200.16.10:57386.service: Deactivated successfully. Jul 15 05:19:13.100028 systemd[1]: session-25.scope: Deactivated successfully. Jul 15 05:19:13.101002 systemd-logind[1889]: Session 25 logged out. Waiting for processes to exit. Jul 15 05:19:13.104530 systemd-logind[1889]: Removed session 25. Jul 15 05:19:23.206522 systemd[1]: Started sshd@23-10.200.8.11:22-10.200.16.10:59862.service - OpenSSH per-connection server daemon (10.200.16.10:59862). Jul 15 05:19:23.863230 sshd[12444]: Accepted publickey for core from 10.200.16.10 port 59862 ssh2: RSA SHA256:tFaO/Gkpdf2AjbVf3W+X+FNU/vH2JWmxNlepyUE0K5I Jul 15 05:19:23.866270 sshd-session[12444]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Jul 15 05:19:23.872176 systemd-logind[1889]: New session 26 of user core. Jul 15 05:19:23.882826 systemd[1]: Started session-26.scope - Session 26 of User core. Jul 15 05:19:24.308854 sshd[12465]: Connection closed by 10.200.16.10 port 59862 Jul 15 05:19:24.309183 sshd-session[12444]: pam_unix(sshd:session): session closed for user core Jul 15 05:19:24.312748 systemd[1]: sshd@23-10.200.8.11:22-10.200.16.10:59862.service: Deactivated successfully. Jul 15 05:19:24.315285 systemd[1]: session-26.scope: Deactivated successfully. Jul 15 05:19:24.318207 systemd-logind[1889]: Session 26 logged out. Waiting for processes to exit. Jul 15 05:19:24.320556 systemd-logind[1889]: Removed session 26. Jul 15 05:19:24.421882 systemd[1]: Started sshd@24-10.200.8.11:22-10.200.16.10:59866.service - OpenSSH per-connection server daemon (10.200.16.10:59866). Jul 15 05:19:25.071340 sshd[12484]: Accepted publickey for core from 10.200.16.10 port 59866 ssh2: RSA SHA256:tFaO/Gkpdf2AjbVf3W+X+FNU/vH2JWmxNlepyUE0K5I Jul 15 05:19:25.076309 sshd-session[12484]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Jul 15 05:19:25.084875 systemd-logind[1889]: New session 27 of user core. Jul 15 05:19:25.094949 systemd[1]: Started session-27.scope - Session 27 of User core. Jul 15 05:19:25.517104 sshd[12510]: Connection closed by 10.200.16.10 port 59866 Jul 15 05:19:25.520884 sshd-session[12484]: pam_unix(sshd:session): session closed for user core Jul 15 05:19:25.525154 systemd[1]: sshd@24-10.200.8.11:22-10.200.16.10:59866.service: Deactivated successfully. Jul 15 05:19:25.527689 systemd[1]: session-27.scope: Deactivated successfully. Jul 15 05:19:25.531025 systemd-logind[1889]: Session 27 logged out. Waiting for processes to exit. Jul 15 05:19:25.532351 systemd-logind[1889]: Removed session 27. Jul 15 05:19:35.639279 systemd[1]: Started sshd@25-10.200.8.11:22-10.200.16.10:39612.service - OpenSSH per-connection server daemon (10.200.16.10:39612). Jul 15 05:19:36.272964 sshd[12831]: Accepted publickey for core from 10.200.16.10 port 39612 ssh2: RSA SHA256:tFaO/Gkpdf2AjbVf3W+X+FNU/vH2JWmxNlepyUE0K5I Jul 15 05:19:36.274328 sshd-session[12831]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Jul 15 05:19:36.278716 systemd-logind[1889]: New session 28 of user core. Jul 15 05:19:36.293804 systemd[1]: Started session-28.scope - Session 28 of User core. Jul 15 05:19:36.717459 sshd[12834]: Connection closed by 10.200.16.10 port 39612 Jul 15 05:19:36.717912 sshd-session[12831]: pam_unix(sshd:session): session closed for user core Jul 15 05:19:36.721832 systemd[1]: sshd@25-10.200.8.11:22-10.200.16.10:39612.service: Deactivated successfully. Jul 15 05:19:36.723494 systemd[1]: session-28.scope: Deactivated successfully. Jul 15 05:19:36.724190 systemd-logind[1889]: Session 28 logged out. Waiting for processes to exit. Jul 15 05:19:36.725089 systemd-logind[1889]: Removed session 28. Jul 15 05:19:36.837037 systemd[1]: Started sshd@26-10.200.8.11:22-10.200.16.10:39618.service - OpenSSH per-connection server daemon (10.200.16.10:39618). Jul 15 05:19:37.467645 sshd[12840]: Accepted publickey for core from 10.200.16.10 port 39618 ssh2: RSA SHA256:tFaO/Gkpdf2AjbVf3W+X+FNU/vH2JWmxNlepyUE0K5I Jul 15 05:19:37.469153 sshd-session[12840]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Jul 15 05:19:37.473386 systemd-logind[1889]: New session 29 of user core. Jul 15 05:19:37.483801 systemd[1]: Started session-29.scope - Session 29 of User core. Jul 15 05:19:37.911125 sshd[12843]: Connection closed by 10.200.16.10 port 39618 Jul 15 05:19:37.911507 sshd-session[12840]: pam_unix(sshd:session): session closed for user core Jul 15 05:19:37.915224 systemd[1]: sshd@26-10.200.8.11:22-10.200.16.10:39618.service: Deactivated successfully. Jul 15 05:19:37.916883 systemd[1]: session-29.scope: Deactivated successfully. Jul 15 05:19:37.917565 systemd-logind[1889]: Session 29 logged out. Waiting for processes to exit. Jul 15 05:19:37.918466 systemd-logind[1889]: Removed session 29. Jul 15 05:19:43.765152 setup-nvidia[2575]: \u000d Jul 15 05:19:43.765152 setup-nvidia[2575]: ERROR: Unable to load the kernel module 'nvidia.ko'. This happens most Jul 15 05:19:43.765152 setup-nvidia[2575]: frequently when this kernel module was built against the wrong or Jul 15 05:19:43.765152 setup-nvidia[2575]: improperly configured kernel sources, with a version of gcc that differs Jul 15 05:19:43.765152 setup-nvidia[2575]: from the one used to build the target kernel, or if another driver, such Jul 15 05:19:43.765152 setup-nvidia[2575]: as nouveau, is present and prevents the NVIDIA kernel module from Jul 15 05:19:43.765152 setup-nvidia[2575]: obtaining ownership of the NVIDIA device(s), or no NVIDIA device Jul 15 05:19:43.765152 setup-nvidia[2575]: installed in this system is supported by this NVIDIA Linux graphics Jul 15 05:19:43.765152 setup-nvidia[2575]: driver release. Jul 15 05:19:43.765152 setup-nvidia[2575]: \u000d Jul 15 05:19:43.765152 setup-nvidia[2575]: Please see the log entries 'Kernel module load error' and 'Kernel Jul 15 05:19:43.765152 setup-nvidia[2575]: messages' at the end of the file Jul 15 05:19:43.765152 setup-nvidia[2575]: '/nvidia/NVIDIA-Linux-x86_64-535.247.01/nvidia-installer.log' for more Jul 15 05:19:43.765152 setup-nvidia[2575]: information. Jul 15 05:19:43.765152 setup-nvidia[2575]: \u000d Jul 15 05:19:43.779687 setup-nvidia[2575]: dmesg: read kernel buffer failed: Operation not permitted Jul 15 05:19:43.798130 setup-nvidia[2575]: \u000d Jul 15 05:19:43.798130 setup-nvidia[2575]: ERROR: Installation has failed. Please see the file Jul 15 05:19:43.798130 setup-nvidia[2575]: '/nvidia/NVIDIA-Linux-x86_64-535.247.01/nvidia-installer.log' for Jul 15 05:19:43.798130 setup-nvidia[2575]: details. You may find suggestions on fixing installation problems in Jul 15 05:19:43.798130 setup-nvidia[2575]: the README available on the Linux driver download page at Jul 15 05:19:43.798130 setup-nvidia[2575]: www.nvidia.com. Jul 15 05:19:43.798130 setup-nvidia[2575]: \u000d Jul 15 05:19:43.798806 setup-nvidia[2575]: Last 50 lines of nvidia-installer.log: Jul 15 05:19:43.799639 setup-nvidia[2575]: /nvidia/NVIDIA-Linux-x86_64-535.247.01/kernel/nvidia.o: warning: objtool: _nv039045rm+0x53: 'naked' return found in MITIGATION_RETHUNK build Jul 15 05:19:43.799639 setup-nvidia[2575]: /nvidia/NVIDIA-Linux-x86_64-535.247.01/kernel/nvidia.o: warning: objtool: _nv039042rm+0x90: 'naked' return found in MITIGATION_RETHUNK build Jul 15 05:19:43.799639 setup-nvidia[2575]: /nvidia/NVIDIA-Linux-x86_64-535.247.01/kernel/nvidia.o: warning: objtool: _nv039035rm+0x2b: 'naked' return found in MITIGATION_RETHUNK build Jul 15 05:19:43.799639 setup-nvidia[2575]: /nvidia/NVIDIA-Linux-x86_64-535.247.01/kernel/nvidia.o: warning: objtool: _nv039091rm+0x93: 'naked' return found in MITIGATION_RETHUNK build Jul 15 05:19:43.799639 setup-nvidia[2575]: /nvidia/NVIDIA-Linux-x86_64-535.247.01/kernel/nvidia.o: warning: objtool: _nv039087rm+0x36: 'naked' return found in MITIGATION_RETHUNK build Jul 15 05:19:43.799639 setup-nvidia[2575]: /nvidia/NVIDIA-Linux-x86_64-535.247.01/kernel/nvidia.o: warning: objtool: _nv039086rm+0x9d: 'naked' return found in MITIGATION_RETHUNK build Jul 15 05:19:43.799639 setup-nvidia[2575]: /nvidia/NVIDIA-Linux-x86_64-535.247.01/kernel/nvidia.o: warning: objtool: _nv039088rm+0x77: 'naked' return found in MITIGATION_RETHUNK build Jul 15 05:19:43.799639 setup-nvidia[2575]: /nvidia/NVIDIA-Linux-x86_64-535.247.01/kernel/nvidia.o: warning: objtool: _nv039032rm+0x7f: 'naked' return found in MITIGATION_RETHUNK build Jul 15 05:19:43.799639 setup-nvidia[2575]: /nvidia/NVIDIA-Linux-x86_64-535.247.01/kernel/nvidia.o: warning: objtool: _nv030603rm+0x3e: 'naked' return found in MITIGATION_RETHUNK build Jul 15 05:19:43.799639 setup-nvidia[2575]: /nvidia/NVIDIA-Linux-x86_64-535.247.01/kernel/nvidia.o: warning: objtool: _nv030602rm+0x27: 'naked' return found in MITIGATION_RETHUNK build Jul 15 05:19:43.799639 setup-nvidia[2575]: /nvidia/NVIDIA-Linux-x86_64-535.247.01/kernel/nvidia.o: warning: objtool: _nv030606rm+0x37: 'naked' return found in MITIGATION_RETHUNK build Jul 15 05:19:43.799639 setup-nvidia[2575]: /nvidia/NVIDIA-Linux-x86_64-535.247.01/kernel/nvidia.o: warning: objtool: _nv030605rm+0x24: 'naked' return found in MITIGATION_RETHUNK build Jul 15 05:19:43.799639 setup-nvidia[2575]: /nvidia/NVIDIA-Linux-x86_64-535.247.01/kernel/nvidia.o: warning: objtool: _nv030604rm+0xca: 'naked' return found in MITIGATION_RETHUNK build Jul 15 05:19:43.799639 setup-nvidia[2575]: /nvidia/NVIDIA-Linux-x86_64-535.247.01/kernel/nvidia.o: warning: objtool: _nv030607rm+0x193: 'naked' return found in MITIGATION_RETHUNK build Jul 15 05:19:43.799639 setup-nvidia[2575]: /nvidia/NVIDIA-Linux-x86_64-535.247.01/kernel/nvidia.o: warning: objtool: _nv030609rm+0x17f: 'naked' return found in MITIGATION_RETHUNK build Jul 15 05:19:43.799639 setup-nvidia[2575]: /nvidia/NVIDIA-Linux-x86_64-535.247.01/kernel/nvidia.o: warning: objtool: _nv011864rm+0x5d: 'naked' return found in MITIGATION_RETHUNK build Jul 15 05:19:43.799639 setup-nvidia[2575]: /nvidia/NVIDIA-Linux-x86_64-535.247.01/kernel/nvidia.o: warning: objtool: _nv039399rm+0x12f: 'naked' return found in MITIGATION_RETHUNK build Jul 15 05:19:43.799639 setup-nvidia[2575]: MODPOST /nvidia/NVIDIA-Linux-x86_64-535.247.01/kernel/Module.symvers Jul 15 05:19:43.799639 setup-nvidia[2575]: CC [M] /nvidia/NVIDIA-Linux-x86_64-535.247.01/kernel/nvidia.mod.o Jul 15 05:19:43.799639 setup-nvidia[2575]: CC [M] /nvidia/NVIDIA-Linux-x86_64-535.247.01/kernel/.module-common.o Jul 15 05:19:43.799639 setup-nvidia[2575]: CC [M] /nvidia/NVIDIA-Linux-x86_64-535.247.01/kernel/nvidia-uvm.mod.o Jul 15 05:19:43.799639 setup-nvidia[2575]: CC [M] /nvidia/NVIDIA-Linux-x86_64-535.247.01/kernel/nvidia-modeset.mod.o Jul 15 05:19:43.799639 setup-nvidia[2575]: CC [M] /nvidia/NVIDIA-Linux-x86_64-535.247.01/kernel/nvidia-drm.mod.o Jul 15 05:19:43.799639 setup-nvidia[2575]: CC [M] /nvidia/NVIDIA-Linux-x86_64-535.247.01/kernel/nvidia-peermem.mod.o Jul 15 05:19:43.799639 setup-nvidia[2575]: LD [M] /nvidia/NVIDIA-Linux-x86_64-535.247.01/kernel/nvidia.ko Jul 15 05:19:43.799639 setup-nvidia[2575]: LD [M] /nvidia/NVIDIA-Linux-x86_64-535.247.01/kernel/nvidia-uvm.ko Jul 15 05:19:43.799639 setup-nvidia[2575]: LD [M] /nvidia/NVIDIA-Linux-x86_64-535.247.01/kernel/nvidia-modeset.ko Jul 15 05:19:43.799639 setup-nvidia[2575]: LD [M] /nvidia/NVIDIA-Linux-x86_64-535.247.01/kernel/nvidia-drm.ko Jul 15 05:19:43.799639 setup-nvidia[2575]: LD [M] /nvidia/NVIDIA-Linux-x86_64-535.247.01/kernel/nvidia-peermem.ko Jul 15 05:19:43.799639 setup-nvidia[2575]: BTF [M] /nvidia/NVIDIA-Linux-x86_64-535.247.01/kernel/nvidia-peermem.ko Jul 15 05:19:43.799639 setup-nvidia[2575]: Skipping BTF generation for /nvidia/NVIDIA-Linux-x86_64-535.247.01/kernel/nvidia-peermem.ko due to unavailability of vmlinux Jul 15 05:19:43.799639 setup-nvidia[2575]: BTF [M] /nvidia/NVIDIA-Linux-x86_64-535.247.01/kernel/nvidia-modeset.ko Jul 15 05:19:43.799639 setup-nvidia[2575]: Skipping BTF generation for /nvidia/NVIDIA-Linux-x86_64-535.247.01/kernel/nvidia-modeset.ko due to unavailability of vmlinux Jul 15 05:19:43.799639 setup-nvidia[2575]: BTF [M] /nvidia/NVIDIA-Linux-x86_64-535.247.01/kernel/nvidia-drm.ko Jul 15 05:19:43.799639 setup-nvidia[2575]: Skipping BTF generation for /nvidia/NVIDIA-Linux-x86_64-535.247.01/kernel/nvidia-drm.ko due to unavailability of vmlinux Jul 15 05:19:43.799639 setup-nvidia[2575]: BTF [M] /nvidia/NVIDIA-Linux-x86_64-535.247.01/kernel/nvidia-uvm.ko Jul 15 05:19:43.799639 setup-nvidia[2575]: Skipping BTF generation for /nvidia/NVIDIA-Linux-x86_64-535.247.01/kernel/nvidia-uvm.ko due to unavailability of vmlinux Jul 15 05:19:43.799639 setup-nvidia[2575]: BTF [M] /nvidia/NVIDIA-Linux-x86_64-535.247.01/kernel/nvidia.ko Jul 15 05:19:43.799639 setup-nvidia[2575]: Skipping BTF generation for /nvidia/NVIDIA-Linux-x86_64-535.247.01/kernel/nvidia.ko due to unavailability of vmlinux Jul 15 05:19:43.799639 setup-nvidia[2575]: make[2]: Leaving directory '/usr/lib/modules/6.12.36-flatcar/build' Jul 15 05:19:43.799639 setup-nvidia[2575]: make[1]: Leaving directory '/usr/lib/modules/6.12.36-flatcar/source' Jul 15 05:19:43.799639 setup-nvidia[2575]: -> done. Jul 15 05:19:43.799639 setup-nvidia[2575]: -> Kernel module compilation complete. Jul 15 05:19:43.799639 setup-nvidia[2575]: -> Unable to determine if Secure Boot is enabled: No such file or directory Jul 15 05:19:43.799639 setup-nvidia[2575]: 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. Jul 15 05:19:43.799639 setup-nvidia[2575]: \u000d Jul 15 05:19:43.800750 setup-nvidia[2575]: Please see the log entries 'Kernel module load error' and 'Kernel messages' at the end of the file '/nvidia/NVIDIA-Linux-x86_64-535.247.01/nvidia-installer.log' for more information. Jul 15 05:19:43.800750 setup-nvidia[2575]: -> Kernel module load error: Operation not permitted Jul 15 05:19:43.800750 setup-nvidia[2575]: -> Kernel messages: Jul 15 05:19:43.800750 setup-nvidia[2575]: ERROR: Installation has failed. Please see the file '/nvidia/NVIDIA-Linux-x86_64-535.247.01/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. Jul 15 05:19:48.022163 systemd[1]: Started sshd@27-10.200.8.11:22-10.200.16.10:39990.service - OpenSSH per-connection server daemon (10.200.16.10:39990). Jul 15 05:19:48.652585 sshd[13030]: Accepted publickey for core from 10.200.16.10 port 39990 ssh2: RSA SHA256:tFaO/Gkpdf2AjbVf3W+X+FNU/vH2JWmxNlepyUE0K5I Jul 15 05:19:48.654059 sshd-session[13030]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Jul 15 05:19:48.658593 systemd-logind[1889]: New session 30 of user core. Jul 15 05:19:48.671843 systemd[1]: Started session-30.scope - Session 30 of User core. Jul 15 05:19:49.100147 sshd[13035]: Connection closed by 10.200.16.10 port 39990 Jul 15 05:19:49.100529 sshd-session[13030]: pam_unix(sshd:session): session closed for user core Jul 15 05:19:49.104236 systemd[1]: sshd@27-10.200.8.11:22-10.200.16.10:39990.service: Deactivated successfully. Jul 15 05:19:49.105932 systemd[1]: session-30.scope: Deactivated successfully. Jul 15 05:19:49.106584 systemd-logind[1889]: Session 30 logged out. Waiting for processes to exit. Jul 15 05:19:49.107689 systemd-logind[1889]: Removed session 30. Jul 15 05:19:49.210801 systemd[1]: Started sshd@28-10.200.8.11:22-10.200.16.10:39994.service - OpenSSH per-connection server daemon (10.200.16.10:39994). Jul 15 05:19:49.839658 sshd[13041]: Accepted publickey for core from 10.200.16.10 port 39994 ssh2: RSA SHA256:tFaO/Gkpdf2AjbVf3W+X+FNU/vH2JWmxNlepyUE0K5I Jul 15 05:19:49.841094 sshd-session[13041]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Jul 15 05:19:49.845587 systemd-logind[1889]: New session 31 of user core. Jul 15 05:19:49.856810 systemd[1]: Started session-31.scope - Session 31 of User core. Jul 15 05:19:50.282835 sshd[13044]: Connection closed by 10.200.16.10 port 39994 Jul 15 05:19:50.283108 sshd-session[13041]: pam_unix(sshd:session): session closed for user core Jul 15 05:19:50.286760 systemd[1]: sshd@28-10.200.8.11:22-10.200.16.10:39994.service: Deactivated successfully. Jul 15 05:19:50.288465 systemd[1]: session-31.scope: Deactivated successfully. Jul 15 05:19:50.289163 systemd-logind[1889]: Session 31 logged out. Waiting for processes to exit. Jul 15 05:19:50.290053 systemd-logind[1889]: Removed session 31. Jul 15 05:19:56.142815 kernel: EXT4-fs (loop6p9): unmounting filesystem 972f2beb-d1b6-473e-a98a-ae044746a8ba. Jul 15 05:19:56.143047 setup-nvidia[2575]: Container flatcardevelopercontainer-4396.0.0nightly-20250714-2100.bin exited successfully. Jul 15 05:19:56.145263 systemd[1]: run-systemd-nspawn-unix\x2dexport-flatcardevelopercontainer\x2d4396.0.0nightly\x2d20250714\x2d2100.bin.mount: Deactivated successfully. Jul 15 05:19:56.198537 sudo[2563]: pam_unix(sudo:session): session closed for user root Jul 15 05:19:56.200525 systemd[1]: session-c2.scope: Deactivated successfully. Jul 15 05:19:56.200829 systemd[1]: session-c2.scope: Consumed 5min 23.298s CPU time, 889.1M memory peak. Jul 15 05:19:56.672236 setup-nvidia[1885]: /opt/nvidia / Jul 15 05:19:56.673246 setup-nvidia[1885]: / Jul 15 05:19:56.682700 kernel: IPMI message handler: version 39.2 Jul 15 05:19:56.685699 kernel: ipmi device interface Jul 15 05:19:56.698647 setup-nvidia[1885]: /opt/nvidia/current/usr/lib/modules/6.12.36-flatcar/video / Jul 15 05:19:56.765808 kernel: nvidia: loading out-of-tree module taints kernel. Jul 15 05:19:56.766154 kernel: nvidia: module license 'NVIDIA' taints kernel. Jul 15 05:19:56.766376 kernel: Disabling lock debugging due to kernel taint Jul 15 05:19:56.773116 kernel: nvidia: module verification failed: signature and/or required key missing - tainting kernel Jul 15 05:19:56.773159 kernel: nvidia: module license taints kernel. Jul 15 05:19:57.165704 kernel: nvidia-nvlink: Nvlink Core is being initialized, major device number 243 Jul 15 05:19:57.733192 kernel: Jul 15 05:19:57.733357 kernel: nvidia 0001:00:00.0: enabling device (0000 -> 0002) Jul 15 05:19:57.939703 kernel: NVRM: loading NVIDIA UNIX x86_64 Kernel Module 535.247.01 Wed Mar 26 11:50:32 UTC 2025 Jul 15 05:19:57.961736 kernel: nvidia-modeset: Loading NVIDIA Kernel Mode Setting Driver for UNIX platforms 535.247.01 Wed Mar 26 06:12:31 UTC 2025 Jul 15 05:19:57.984714 kernel: nvidia_uvm: module uses symbols nvUvmInterfaceDisableAccessCntr from proprietary module nvidia, inheriting taint. Jul 15 05:19:58.027703 kernel: nvidia-uvm: Loaded the UVM driver, major device number 241. Jul 15 05:19:58.027962 setup-nvidia[1885]: / Jul 15 05:19:58.047040 setup-nvidia[13084]: ldconfig: /usr/lib/ld.so.conf is not an ELF file - it has the wrong magic bytes at the start. Jul 15 05:19:59.922800 setup-nvidia[13101]: Tue Jul 15 05:19:59 2025 Jul 15 05:19:59.922800 setup-nvidia[13101]: +---------------------------------------------------------------------------------------+ Jul 15 05:19:59.922800 setup-nvidia[13101]: | NVIDIA-SMI 535.247.01 Driver Version: 535.247.01 CUDA Version: 12.2 | Jul 15 05:19:59.922800 setup-nvidia[13101]: |-----------------------------------------+----------------------+----------------------+ Jul 15 05:19:59.922800 setup-nvidia[13101]: | GPU Name Persistence-M | Bus-Id Disp.A | Volatile Uncorr. ECC | Jul 15 05:19:59.922800 setup-nvidia[13101]: | Fan Temp Perf Pwr:Usage/Cap | Memory-Usage | GPU-Util Compute M. | Jul 15 05:19:59.922800 setup-nvidia[13101]: | | | MIG M. | Jul 15 05:19:59.922800 setup-nvidia[13101]: |=========================================+======================+======================| Jul 15 05:19:59.926743 setup-nvidia[13101]: | 0 Tesla V100-PCIE-16GB Off | 00000001:00:00.0 Off | Off | Jul 15 05:19:59.926743 setup-nvidia[13101]: | N/A 25C P0 37W / 250W | 0MiB / 16384MiB | 0% Default | Jul 15 05:19:59.926743 setup-nvidia[13101]: | | | N/A | Jul 15 05:19:59.926743 setup-nvidia[13101]: +-----------------------------------------+----------------------+----------------------+ Jul 15 05:19:59.926854 setup-nvidia[13101]: Jul 15 05:19:59.926854 setup-nvidia[13101]: +---------------------------------------------------------------------------------------+ Jul 15 05:19:59.926854 setup-nvidia[13101]: | Processes: | Jul 15 05:19:59.926854 setup-nvidia[13101]: | GPU GI CI PID Type Process name GPU Memory | Jul 15 05:19:59.926854 setup-nvidia[13101]: | ID ID Usage | Jul 15 05:19:59.926854 setup-nvidia[13101]: |=======================================================================================| Jul 15 05:19:59.926981 setup-nvidia[13101]: | No running processes found | Jul 15 05:19:59.926981 setup-nvidia[13101]: +---------------------------------------------------------------------------------------+ Jul 15 05:20:00.299991 systemd[1]: Finished nvidia.service - NVIDIA Configure Service. Jul 15 05:20:00.302174 systemd[1]: Reached target multi-user.target - Multi-User System. Jul 15 05:20:00.302481 systemd[1]: Startup finished in 1.137s (firmware) + 28.870s (loader) + 3.958s (kernel) + 11.888s (initrd) + 3min 42.556s (userspace) = 4min 28.410s. Jul 15 05:20:00.410349 systemd[1]: Started sshd@29-10.200.8.11:22-10.200.16.10:46630.service - OpenSSH per-connection server daemon (10.200.16.10:46630). Jul 15 05:20:01.038404 sshd[13108]: Accepted publickey for core from 10.200.16.10 port 46630 ssh2: RSA SHA256:tFaO/Gkpdf2AjbVf3W+X+FNU/vH2JWmxNlepyUE0K5I Jul 15 05:20:01.039834 sshd-session[13108]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Jul 15 05:20:01.044255 systemd-logind[1889]: New session 32 of user core. Jul 15 05:20:01.056891 systemd[1]: Started session-32.scope - Session 32 of User core. Jul 15 05:20:01.481597 sshd[13111]: Connection closed by 10.200.16.10 port 46630 Jul 15 05:20:01.482043 sshd-session[13108]: pam_unix(sshd:session): session closed for user core Jul 15 05:20:01.486886 systemd[1]: sshd@29-10.200.8.11:22-10.200.16.10:46630.service: Deactivated successfully. Jul 15 05:20:01.488571 systemd[1]: session-32.scope: Deactivated successfully. Jul 15 05:20:01.489284 systemd-logind[1889]: Session 32 logged out. Waiting for processes to exit. Jul 15 05:20:01.490243 systemd-logind[1889]: Removed session 32. Jul 15 05:20:01.598239 systemd[1]: Started sshd@30-10.200.8.11:22-10.200.16.10:46642.service - OpenSSH per-connection server daemon (10.200.16.10:46642). Jul 15 05:20:02.247844 sshd[13117]: Accepted publickey for core from 10.200.16.10 port 46642 ssh2: RSA SHA256:tFaO/Gkpdf2AjbVf3W+X+FNU/vH2JWmxNlepyUE0K5I Jul 15 05:20:02.249241 sshd-session[13117]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Jul 15 05:20:02.253643 systemd-logind[1889]: New session 33 of user core. Jul 15 05:20:02.272804 systemd[1]: Started session-33.scope - Session 33 of User core. Jul 15 05:20:02.688112 sshd[13120]: Connection closed by 10.200.16.10 port 46642 Jul 15 05:20:02.688478 sshd-session[13117]: pam_unix(sshd:session): session closed for user core Jul 15 05:20:02.692170 systemd[1]: sshd@30-10.200.8.11:22-10.200.16.10:46642.service: Deactivated successfully. Jul 15 05:20:02.693831 systemd[1]: session-33.scope: Deactivated successfully. Jul 15 05:20:02.702234 systemd-logind[1889]: Session 33 logged out. Waiting for processes to exit. Jul 15 05:20:02.703113 systemd-logind[1889]: Removed session 33. Jul 15 05:20:02.803108 systemd[1]: Started sshd@31-10.200.8.11:22-10.200.16.10:46658.service - OpenSSH per-connection server daemon (10.200.16.10:46658). Jul 15 05:20:03.431795 sshd[13126]: Accepted publickey for core from 10.200.16.10 port 46658 ssh2: RSA SHA256:tFaO/Gkpdf2AjbVf3W+X+FNU/vH2JWmxNlepyUE0K5I Jul 15 05:20:03.433184 sshd-session[13126]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Jul 15 05:20:03.437483 systemd-logind[1889]: New session 34 of user core. Jul 15 05:20:03.450799 systemd[1]: Started session-34.scope - Session 34 of User core. Jul 15 05:20:03.876880 sshd[13129]: Connection closed by 10.200.16.10 port 46658 Jul 15 05:20:03.877252 sshd-session[13126]: pam_unix(sshd:session): session closed for user core Jul 15 05:20:03.880926 systemd[1]: sshd@31-10.200.8.11:22-10.200.16.10:46658.service: Deactivated successfully. Jul 15 05:20:03.882615 systemd[1]: session-34.scope: Deactivated successfully. Jul 15 05:20:03.883309 systemd-logind[1889]: Session 34 logged out. Waiting for processes to exit. Jul 15 05:20:03.884211 systemd-logind[1889]: Removed session 34. Jul 15 05:20:03.992061 systemd[1]: Started sshd@32-10.200.8.11:22-10.200.16.10:46672.service - OpenSSH per-connection server daemon (10.200.16.10:46672). Jul 15 05:20:04.639832 sshd[13135]: Accepted publickey for core from 10.200.16.10 port 46672 ssh2: RSA SHA256:tFaO/Gkpdf2AjbVf3W+X+FNU/vH2JWmxNlepyUE0K5I Jul 15 05:20:04.641286 sshd-session[13135]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Jul 15 05:20:04.645518 systemd-logind[1889]: New session 35 of user core. Jul 15 05:20:04.660818 systemd[1]: Started session-35.scope - Session 35 of User core. Jul 15 05:20:04.986090 sudo[13139]: core : PWD=/home/core ; USER=root ; COMMAND=/usr/sbin/setenforce 1 Jul 15 05:20:04.986384 sudo[13139]: pam_unix(sudo:session): session opened for user root(uid=0) by core(uid=500) Jul 15 05:20:05.000359 sudo[13139]: pam_unix(sudo:session): session closed for user root Jul 15 05:20:05.101053 sshd[13138]: Connection closed by 10.200.16.10 port 46672 Jul 15 05:20:05.101493 sshd-session[13135]: pam_unix(sshd:session): session closed for user core Jul 15 05:20:05.105468 systemd[1]: sshd@32-10.200.8.11:22-10.200.16.10:46672.service: Deactivated successfully. Jul 15 05:20:05.107208 systemd[1]: session-35.scope: Deactivated successfully. Jul 15 05:20:05.107934 systemd-logind[1889]: Session 35 logged out. Waiting for processes to exit. Jul 15 05:20:05.108874 systemd-logind[1889]: Removed session 35. Jul 15 05:20:05.214953 systemd[1]: Started sshd@33-10.200.8.11:22-10.200.16.10:46688.service - OpenSSH per-connection server daemon (10.200.16.10:46688). Jul 15 05:20:05.845815 sshd[13145]: Accepted publickey for core from 10.200.16.10 port 46688 ssh2: RSA SHA256:tFaO/Gkpdf2AjbVf3W+X+FNU/vH2JWmxNlepyUE0K5I Jul 15 05:20:05.847238 sshd-session[13145]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Jul 15 05:20:05.851531 systemd-logind[1889]: New session 36 of user core. Jul 15 05:20:05.869862 systemd[1]: Started session-36.scope - Session 36 of User core. Jul 15 05:20:06.190429 sudo[13150]: 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 Jul 15 05:20:06.190786 sudo[13150]: pam_unix(sudo:session): session opened for user root(uid=0) by core(uid=500) Jul 15 05:20:06.197787 sudo[13150]: pam_unix(sudo:session): session closed for user root Jul 15 05:20:06.203248 sudo[13149]: core : PWD=/home/core ; USER=root ; COMMAND=/usr/sbin/systemctl restart audit-rules Jul 15 05:20:06.203534 sudo[13149]: pam_unix(sudo:session): session opened for user root(uid=0) by core(uid=500) Jul 15 05:20:06.205974 systemd[1]: Stopping user@0.service - User Manager for UID 0... Jul 15 05:20:06.206800 systemd[2566]: Activating special unit exit.target... Jul 15 05:20:06.206878 systemd[2566]: Stopped target default.target - Main User Target. Jul 15 05:20:06.206918 systemd[2566]: Stopped target basic.target - Basic System. Jul 15 05:20:06.206945 systemd[2566]: Stopped target paths.target - Paths. Jul 15 05:20:06.206970 systemd[2566]: Stopped target sockets.target - Sockets. Jul 15 05:20:06.206994 systemd[2566]: Stopped target timers.target - Timers. Jul 15 05:20:06.207353 systemd[2566]: Closed dbus.socket - D-Bus User Message Bus Socket. Jul 15 05:20:06.207561 systemd[2566]: Removed slice app.slice - User Application Slice. Jul 15 05:20:06.207595 systemd[2566]: Reached target shutdown.target - Shutdown. Jul 15 05:20:06.207760 systemd[2566]: Finished systemd-exit.service - Exit the Session. Jul 15 05:20:06.207797 systemd[2566]: Reached target exit.target - Exit the Session. Jul 15 05:20:06.212738 systemd[1]: Starting audit-rules.service - Load Audit Rules... Jul 15 05:20:06.221625 (sd-pam)[2567]: pam_unix(systemd-user:session): session closed for user root Jul 15 05:20:06.222931 systemd[1]: user@0.service: Deactivated successfully. Jul 15 05:20:06.232948 systemd[1]: Stopped user@0.service - User Manager for UID 0. Jul 15 05:20:06.235425 systemd[1]: Stopping user-runtime-dir@0.service - User Runtime Directory /run/user/0... Jul 15 05:20:06.246785 systemd[1]: run-user-0.mount: Deactivated successfully. Jul 15 05:20:06.247918 systemd[1]: user-runtime-dir@0.service: Deactivated successfully. Jul 15 05:20:06.248108 systemd[1]: Stopped user-runtime-dir@0.service - User Runtime Directory /run/user/0. Jul 15 05:20:06.249782 systemd[1]: Removed slice user-0.slice - User Slice of UID 0. Jul 15 05:20:06.249903 systemd[1]: user-0.slice: Consumed 5min 23.519s CPU time, 895M memory peak. Jul 15 05:20:06.250343 systemd-logind[1889]: Removed session c3. Jul 15 05:20:06.256871 augenrules[13176]: No rules Jul 15 05:20:06.258009 systemd[1]: audit-rules.service: Deactivated successfully. Jul 15 05:20:06.258238 systemd[1]: Finished audit-rules.service - Load Audit Rules. Jul 15 05:20:06.259049 sudo[13149]: pam_unix(sudo:session): session closed for user root Jul 15 05:20:06.359569 sshd[13148]: Connection closed by 10.200.16.10 port 46688 Jul 15 05:20:06.359948 sshd-session[13145]: pam_unix(sshd:session): session closed for user core Jul 15 05:20:06.363659 systemd[1]: sshd@33-10.200.8.11:22-10.200.16.10:46688.service: Deactivated successfully. Jul 15 05:20:06.365218 systemd[1]: session-36.scope: Deactivated successfully. Jul 15 05:20:06.365905 systemd-logind[1889]: Session 36 logged out. Waiting for processes to exit. Jul 15 05:20:06.366870 systemd-logind[1889]: Removed session 36. Jul 15 05:20:06.473919 systemd[1]: Started sshd@34-10.200.8.11:22-10.200.16.10:46702.service - OpenSSH per-connection server daemon (10.200.16.10:46702). Jul 15 05:20:07.125915 sshd[13185]: Accepted publickey for core from 10.200.16.10 port 46702 ssh2: RSA SHA256:tFaO/Gkpdf2AjbVf3W+X+FNU/vH2JWmxNlepyUE0K5I Jul 15 05:20:07.129283 sshd-session[13185]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Jul 15 05:20:07.133893 systemd-logind[1889]: New session 37 of user core. Jul 15 05:20:07.144808 systemd[1]: Started session-37.scope - Session 37 of User core. Jul 15 05:20:07.470930 sudo[13189]: core : PWD=/home/core ; USER=root ; COMMAND=/usr/sbin/mkdir -p . Jul 15 05:20:07.471235 sudo[13189]: pam_unix(sudo:session): session opened for user root(uid=0) by core(uid=500) Jul 15 05:20:07.474481 sudo[13189]: pam_unix(sudo:session): session closed for user root Jul 15 05:20:07.576320 sshd[13188]: Connection closed by 10.200.16.10 port 46702 Jul 15 05:20:07.576752 sshd-session[13185]: pam_unix(sshd:session): session closed for user core Jul 15 05:20:07.580434 systemd[1]: sshd@34-10.200.8.11:22-10.200.16.10:46702.service: Deactivated successfully. Jul 15 05:20:07.582128 systemd[1]: session-37.scope: Deactivated successfully. Jul 15 05:20:07.582844 systemd-logind[1889]: Session 37 logged out. Waiting for processes to exit. Jul 15 05:20:07.583769 systemd-logind[1889]: Removed session 37. Jul 15 05:20:07.692780 systemd[1]: Started sshd@35-10.200.8.11:22-10.200.16.10:46718.service - OpenSSH per-connection server daemon (10.200.16.10:46718). Jul 15 05:20:08.341293 sshd[13195]: Accepted publickey for core from 10.200.16.10 port 46718 ssh2: RSA SHA256:tFaO/Gkpdf2AjbVf3W+X+FNU/vH2JWmxNlepyUE0K5I Jul 15 05:20:08.342692 sshd-session[13195]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Jul 15 05:20:08.347011 systemd-logind[1889]: New session 38 of user core. Jul 15 05:20:08.362799 systemd[1]: Started session-38.scope - Session 38 of User core. Jul 15 05:20:08.686369 sudo[13199]: core : PWD=/home/core ; USER=root ; COMMAND=/usr/sbin/install -m 0755 /dev/stdin kolet Jul 15 05:20:08.686697 sudo[13199]: pam_unix(sudo:session): session opened for user root(uid=0) by core(uid=500) Jul 15 05:20:12.440726 sudo[13199]: pam_unix(sudo:session): session closed for user root Jul 15 05:20:12.540971 sshd[13198]: Connection closed by 10.200.16.10 port 46718 Jul 15 05:20:12.541227 sshd-session[13195]: pam_unix(sshd:session): session closed for user core Jul 15 05:20:12.544827 systemd[1]: sshd@35-10.200.8.11:22-10.200.16.10:46718.service: Deactivated successfully. Jul 15 05:20:12.546518 systemd[1]: session-38.scope: Deactivated successfully. Jul 15 05:20:12.547229 systemd-logind[1889]: Session 38 logged out. Waiting for processes to exit. Jul 15 05:20:12.548200 systemd-logind[1889]: Removed session 38. Jul 15 05:20:12.667722 systemd[1]: Started sshd@36-10.200.8.11:22-10.200.16.10:53198.service - OpenSSH per-connection server daemon (10.200.16.10:53198). Jul 15 05:20:13.295261 sshd[13205]: Accepted publickey for core from 10.200.16.10 port 53198 ssh2: RSA SHA256:tFaO/Gkpdf2AjbVf3W+X+FNU/vH2JWmxNlepyUE0K5I Jul 15 05:20:13.296698 sshd-session[13205]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Jul 15 05:20:13.301008 systemd-logind[1889]: New session 39 of user core. Jul 15 05:20:13.317809 systemd[1]: Started session-39.scope - Session 39 of User core. Jul 15 05:20:13.707741 ntpdate[13219]: ntpdate 4.2.8p17@1.4004-o Tue Jul 15 03:00:17 UTC 2025 (1) Jul 15 05:20:20.439015 ntpdate[13219]: adjust time server 85.91.1.164 offset -0.010535 sec Jul 15 05:20:20.540256 sshd[13208]: Connection closed by 10.200.16.10 port 53198 Jul 15 05:20:20.540663 sshd-session[13205]: pam_unix(sshd:session): session closed for user core Jul 15 05:20:20.544433 systemd[1]: sshd@36-10.200.8.11:22-10.200.16.10:53198.service: Deactivated successfully. Jul 15 05:20:20.546243 systemd[1]: session-39.scope: Deactivated successfully. Jul 15 05:20:20.547026 systemd-logind[1889]: Session 39 logged out. Waiting for processes to exit. Jul 15 05:20:20.548006 systemd-logind[1889]: Removed session 39. Jul 15 05:20:20.655069 systemd[1]: Started sshd@37-10.200.8.11:22-10.200.16.10:48904.service - OpenSSH per-connection server daemon (10.200.16.10:48904). Jul 15 05:20:21.305913 sshd[13224]: Accepted publickey for core from 10.200.16.10 port 48904 ssh2: RSA SHA256:tFaO/Gkpdf2AjbVf3W+X+FNU/vH2JWmxNlepyUE0K5I Jul 15 05:20:21.307300 sshd-session[13224]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Jul 15 05:20:21.311684 systemd-logind[1889]: New session 40 of user core. Jul 15 05:20:21.326887 systemd[1]: Started session-40.scope - Session 40 of User core. Jul 15 05:20:21.810841 sshd[13227]: Connection closed by 10.200.16.10 port 48904 Jul 15 05:20:21.811242 sshd-session[13224]: pam_unix(sshd:session): session closed for user core Jul 15 05:20:21.814830 systemd[1]: sshd@37-10.200.8.11:22-10.200.16.10:48904.service: Deactivated successfully. Jul 15 05:20:21.816523 systemd[1]: session-40.scope: Deactivated successfully. Jul 15 05:20:21.817205 systemd-logind[1889]: Session 40 logged out. Waiting for processes to exit. Jul 15 05:20:21.818152 systemd-logind[1889]: Removed session 40. Jul 15 05:20:21.924785 systemd[1]: Started sshd@38-10.200.8.11:22-10.200.16.10:48912.service - OpenSSH per-connection server daemon (10.200.16.10:48912). Jul 15 05:20:22.568844 sshd[13242]: Accepted publickey for core from 10.200.16.10 port 48912 ssh2: RSA SHA256:tFaO/Gkpdf2AjbVf3W+X+FNU/vH2JWmxNlepyUE0K5I Jul 15 05:20:22.570180 sshd-session[13242]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Jul 15 05:20:22.574539 systemd-logind[1889]: New session 41 of user core. Jul 15 05:20:22.585811 systemd[1]: Started session-41.scope - Session 41 of User core. Jul 15 05:20:24.108487 systemd[1]: Starting docker.service - Docker Application Container Engine... Jul 15 05:20:24.127033 (dockerd)[13265]: 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 Jul 15 05:20:25.442766 dockerd[13265]: time="2025-07-15T05:20:25.442697569Z" level=info msg="Starting up" Jul 15 05:20:25.444944 dockerd[13265]: time="2025-07-15T05:20:25.443399546Z" level=info msg="OTEL tracing is not configured, using no-op tracer provider" Jul 15 05:20:25.457329 dockerd[13265]: time="2025-07-15T05:20:25.457271096Z" level=info msg="Creating a containerd client" address=/var/run/docker/libcontainerd/docker-containerd.sock timeout=1m0s Jul 15 05:20:26.267602 dockerd[13265]: time="2025-07-15T05:20:26.267550521Z" level=info msg="Loading containers: start." Jul 15 05:20:26.284704 kernel: Initializing XFRM netlink socket Jul 15 05:20:26.583432 systemd-networkd[1580]: docker0: Link UP Jul 15 05:20:26.602446 dockerd[13265]: time="2025-07-15T05:20:26.602401516Z" level=info msg="Loading containers: done." Jul 15 05:20:26.615920 systemd[1]: var-lib-docker-overlay2-opaque\x2dbug\x2dcheck2915039676-merged.mount: Deactivated successfully. Jul 15 05:20:26.625598 dockerd[13265]: time="2025-07-15T05:20:26.625558003Z" 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 Jul 15 05:20:26.625743 dockerd[13265]: time="2025-07-15T05:20:26.625714096Z" level=info msg="Docker daemon" commit=6430e49a55babd9b8f4d08e70ecb2b68900770fe containerd-snapshotter=false storage-driver=overlay2 version=28.0.4 Jul 15 05:20:26.625838 dockerd[13265]: time="2025-07-15T05:20:26.625818891Z" level=info msg="Initializing buildkit" Jul 15 05:20:26.675914 dockerd[13265]: time="2025-07-15T05:20:26.675882702Z" level=info msg="Completed buildkit initialization" Jul 15 05:20:26.681326 dockerd[13265]: time="2025-07-15T05:20:26.681291965Z" level=info msg="Daemon has completed initialization" Jul 15 05:20:26.681407 dockerd[13265]: time="2025-07-15T05:20:26.681357562Z" level=info msg="API listen on /run/docker.sock" Jul 15 05:20:26.681497 systemd[1]: Started docker.service - Docker Application Container Engine. Jul 15 05:20:27.837114 systemd[1]: var-lib-docker-overlay2-e9650420ff25a1a6990bcc3f2779d041c7c58d4f986d9d81019addc764c95a96\x2dinit-merged.mount: Deactivated successfully. Jul 15 05:20:27.932194 containerd[1906]: time="2025-07-15T05:20:27.932139662Z" level=info msg="connecting to shim 7d3b1ebbdd25c08f7f0a6bcebfbeb41306cfaa631b914aec1010e0d102440bc9" address="unix:///run/containerd/s/2b064e5e96cf0f5a79f9da3905180a3f452a156bbe439ac9ee113b530d9af64e" namespace=moby protocol=ttrpc version=3 Jul 15 05:20:27.966901 systemd[1]: Started docker-7d3b1ebbdd25c08f7f0a6bcebfbeb41306cfaa631b914aec1010e0d102440bc9.scope - libcontainer container 7d3b1ebbdd25c08f7f0a6bcebfbeb41306cfaa631b914aec1010e0d102440bc9. Jul 15 05:20:28.015148 kernel: docker0: port 1(veth34d5bf7) entered blocking state Jul 15 05:20:28.015242 kernel: docker0: port 1(veth34d5bf7) entered disabled state Jul 15 05:20:28.015265 kernel: veth34d5bf7: entered allmulticast mode Jul 15 05:20:28.020365 kernel: veth34d5bf7: entered promiscuous mode Jul 15 05:20:28.020556 systemd-networkd[1580]: veth34d5bf7: Link UP Jul 15 05:20:28.048713 kernel: eth0: renamed from veth1b5f5d9 Jul 15 05:20:28.052696 kernel: docker0: port 1(veth34d5bf7) entered blocking state Jul 15 05:20:28.052750 kernel: docker0: port 1(veth34d5bf7) entered forwarding state Jul 15 05:20:28.055832 systemd-networkd[1580]: veth34d5bf7: Gained carrier Jul 15 05:20:28.056175 systemd-networkd[1580]: docker0: Gained carrier Jul 15 05:20:29.080851 systemd-networkd[1580]: veth34d5bf7: Gained IPv6LL Jul 15 05:20:29.784850 systemd-networkd[1580]: docker0: Gained IPv6LL Jul 15 05:20:31.350861 systemd[1]: docker-7d3b1ebbdd25c08f7f0a6bcebfbeb41306cfaa631b914aec1010e0d102440bc9.scope: Deactivated successfully. Jul 15 05:20:31.364966 dockerd[13265]: time="2025-07-15T05:20:31.364908546Z" level=info msg="ignoring event" container=7d3b1ebbdd25c08f7f0a6bcebfbeb41306cfaa631b914aec1010e0d102440bc9 module=libcontainerd namespace=moby topic=/tasks/delete type="*events.TaskDelete" Jul 15 05:20:31.365300 containerd[1906]: time="2025-07-15T05:20:31.365180834Z" level=info msg="shim disconnected" id=7d3b1ebbdd25c08f7f0a6bcebfbeb41306cfaa631b914aec1010e0d102440bc9 namespace=moby Jul 15 05:20:31.365300 containerd[1906]: time="2025-07-15T05:20:31.365209433Z" level=warning msg="cleaning up after shim disconnected" id=7d3b1ebbdd25c08f7f0a6bcebfbeb41306cfaa631b914aec1010e0d102440bc9 namespace=moby Jul 15 05:20:31.365300 containerd[1906]: time="2025-07-15T05:20:31.365218933Z" level=info msg="cleaning up dead shim" namespace=moby Jul 15 05:20:31.399959 systemd-networkd[1580]: veth34d5bf7: Lost carrier Jul 15 05:20:31.400704 kernel: docker0: port 1(veth34d5bf7) entered disabled state Jul 15 05:20:31.400754 kernel: veth1b5f5d9: renamed from eth0 Jul 15 05:20:31.428030 systemd-networkd[1580]: veth34d5bf7: Link DOWN Jul 15 05:20:31.431697 kernel: docker0: port 1(veth34d5bf7) entered disabled state Jul 15 05:20:31.437969 kernel: veth34d5bf7 (unregistering): left allmulticast mode Jul 15 05:20:31.438013 kernel: veth34d5bf7 (unregistering): left promiscuous mode Jul 15 05:20:31.441585 kernel: docker0: port 1(veth34d5bf7) entered disabled state Jul 15 05:20:31.463591 systemd[1]: run-docker-netns-4cef99b53d67.mount: Deactivated successfully. Jul 15 05:20:31.469099 systemd[1]: var-lib-docker-overlay2-e9650420ff25a1a6990bcc3f2779d041c7c58d4f986d9d81019addc764c95a96-merged.mount: Deactivated successfully. Jul 15 05:20:31.608483 sshd[13245]: Connection closed by 10.200.16.10 port 48912 Jul 15 05:20:31.609400 sshd-session[13242]: pam_unix(sshd:session): session closed for user core Jul 15 05:20:31.612938 systemd[1]: sshd@38-10.200.8.11:22-10.200.16.10:48912.service: Deactivated successfully. Jul 15 05:20:31.614604 systemd[1]: session-41.scope: Deactivated successfully. Jul 15 05:20:31.615289 systemd-logind[1889]: Session 41 logged out. Waiting for processes to exit. Jul 15 05:20:31.616244 systemd-logind[1889]: Removed session 41. Jul 15 05:20:31.726728 systemd[1]: Started sshd@39-10.200.8.11:22-10.200.16.10:45972.service - OpenSSH per-connection server daemon (10.200.16.10:45972). Jul 15 05:20:32.370385 sshd[13558]: Accepted publickey for core from 10.200.16.10 port 45972 ssh2: RSA SHA256:tFaO/Gkpdf2AjbVf3W+X+FNU/vH2JWmxNlepyUE0K5I Jul 15 05:20:32.371792 sshd-session[13558]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Jul 15 05:20:32.376149 systemd-logind[1889]: New session 42 of user core. Jul 15 05:20:32.385799 systemd[1]: Started session-42.scope - Session 42 of User core. Jul 15 05:20:32.408974 systemd-networkd[1580]: docker0: Lost carrier Jul 15 05:20:32.772402 systemd[1]: var-lib-docker-overlay2-5faa82e15992b49746a45126f163c06b4245e6f472c07a145eab777bf52ec52d\x2dinit-merged.mount: Deactivated successfully. Jul 15 05:20:32.874074 containerd[1906]: time="2025-07-15T05:20:32.874025682Z" level=info msg="connecting to shim a46e46c8725b5ca6e5a6b67343b872a782c80a5c3801c563621a1360e0eb1b49" address="unix:///run/containerd/s/76f4ad659d214d642c0730aa6007f394c0fb20cb8a6bcd9f24f35fb222586196" namespace=moby protocol=ttrpc version=3 Jul 15 05:20:32.898810 systemd[1]: Started docker-a46e46c8725b5ca6e5a6b67343b872a782c80a5c3801c563621a1360e0eb1b49.scope - libcontainer container a46e46c8725b5ca6e5a6b67343b872a782c80a5c3801c563621a1360e0eb1b49. Jul 15 05:20:32.942246 kernel: docker0: port 1(veth2b00f19) entered blocking state Jul 15 05:20:32.942335 kernel: docker0: port 1(veth2b00f19) entered disabled state Jul 15 05:20:32.944933 kernel: veth2b00f19: entered allmulticast mode Jul 15 05:20:32.947725 kernel: veth2b00f19: entered promiscuous mode Jul 15 05:20:32.948548 systemd-networkd[1580]: veth2b00f19: Link UP Jul 15 05:20:32.972700 kernel: eth0: renamed from veth9ed21f6 Jul 15 05:20:32.979511 kernel: docker0: port 1(veth2b00f19) entered blocking state Jul 15 05:20:32.979548 kernel: docker0: port 1(veth2b00f19) entered forwarding state Jul 15 05:20:32.979914 systemd-networkd[1580]: veth2b00f19: Gained carrier Jul 15 05:20:32.980156 systemd-networkd[1580]: docker0: Gained carrier Jul 15 05:20:33.016161 systemd[1]: docker-a46e46c8725b5ca6e5a6b67343b872a782c80a5c3801c563621a1360e0eb1b49.scope: Deactivated successfully. Jul 15 05:20:33.041071 containerd[1906]: time="2025-07-15T05:20:33.040507514Z" level=info msg="shim disconnected" id=a46e46c8725b5ca6e5a6b67343b872a782c80a5c3801c563621a1360e0eb1b49 namespace=moby Jul 15 05:20:33.041071 containerd[1906]: time="2025-07-15T05:20:33.040869399Z" level=warning msg="cleaning up after shim disconnected" id=a46e46c8725b5ca6e5a6b67343b872a782c80a5c3801c563621a1360e0eb1b49 namespace=moby Jul 15 05:20:33.041071 containerd[1906]: time="2025-07-15T05:20:33.040885899Z" level=info msg="cleaning up dead shim" namespace=moby Jul 15 05:20:33.041229 dockerd[13265]: time="2025-07-15T05:20:33.040722105Z" level=info msg="ignoring event" container=a46e46c8725b5ca6e5a6b67343b872a782c80a5c3801c563621a1360e0eb1b49 module=libcontainerd namespace=moby topic=/tasks/delete type="*events.TaskDelete" Jul 15 05:20:33.072705 kernel: docker0: port 1(veth2b00f19) entered disabled state Jul 15 05:20:33.072800 kernel: veth9ed21f6: renamed from eth0 Jul 15 05:20:33.072779 systemd-networkd[1580]: veth2b00f19: Lost carrier Jul 15 05:20:33.107821 systemd-networkd[1580]: veth2b00f19: Link DOWN Jul 15 05:20:33.110703 kernel: docker0: port 1(veth2b00f19) entered disabled state Jul 15 05:20:33.117453 kernel: veth2b00f19 (unregistering): left allmulticast mode Jul 15 05:20:33.117505 kernel: veth2b00f19 (unregistering): left promiscuous mode Jul 15 05:20:33.120762 kernel: docker0: port 1(veth2b00f19) entered disabled state Jul 15 05:20:33.282423 sshd[13561]: Connection closed by 10.200.16.10 port 45972 Jul 15 05:20:33.282839 sshd-session[13558]: pam_unix(sshd:session): session closed for user core Jul 15 05:20:33.285949 systemd[1]: sshd@39-10.200.8.11:22-10.200.16.10:45972.service: Deactivated successfully. Jul 15 05:20:33.287739 systemd[1]: session-42.scope: Deactivated successfully. Jul 15 05:20:33.288963 systemd-logind[1889]: Session 42 logged out. Waiting for processes to exit. Jul 15 05:20:33.289934 systemd-logind[1889]: Removed session 42. Jul 15 05:20:33.416954 systemd-networkd[1580]: docker0: Lost carrier Jul 15 05:20:33.769849 systemd[1]: var-lib-docker-overlay2-5faa82e15992b49746a45126f163c06b4245e6f472c07a145eab777bf52ec52d-merged.mount: Deactivated successfully.