Jun 21 04:42:52.185015 kernel: Linux version 6.12.34-flatcar (build@pony-truck.infra.kinvolk.io) (x86_64-cros-linux-gnu-gcc (Gentoo Hardened 14.2.1_p20241221 p7) 14.2.1 20241221, GNU ld (Gentoo 2.44 p1) 2.44.0) #1 SMP PREEMPT_DYNAMIC Fri Jun 20 23:59:04 -00 2025 Jun 21 04:42:52.185042 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=d3c0be6f64121476b0313f5d7d7bbd73e21bc1a219aacd38b8006b291898eca1 Jun 21 04:42:52.185052 kernel: BIOS-provided physical RAM map: Jun 21 04:42:52.185059 kernel: BIOS-e820: [mem 0x0000000000000000-0x000000000009ffff] usable Jun 21 04:42:52.185065 kernel: BIOS-e820: [mem 0x00000000000c0000-0x00000000000fffff] reserved Jun 21 04:42:52.185072 kernel: BIOS-e820: [mem 0x0000000000100000-0x000000003ff40fff] usable Jun 21 04:42:52.185080 kernel: BIOS-e820: [mem 0x000000003ff41000-0x000000003ffc8fff] reserved Jun 21 04:42:52.185089 kernel: BIOS-e820: [mem 0x000000003ffc9000-0x000000003fffafff] ACPI data Jun 21 04:42:52.185096 kernel: BIOS-e820: [mem 0x000000003fffb000-0x000000003fffefff] ACPI NVS Jun 21 04:42:52.185103 kernel: BIOS-e820: [mem 0x000000003ffff000-0x000000003fffffff] usable Jun 21 04:42:52.185110 kernel: BIOS-e820: [mem 0x0000000100000000-0x0000000fdfffffff] usable Jun 21 04:42:52.185117 kernel: BIOS-e820: [mem 0x0000004fe0000000-0x0000005cbfffffff] usable Jun 21 04:42:52.185123 kernel: printk: legacy bootconsole [earlyser0] enabled Jun 21 04:42:52.185131 kernel: NX (Execute Disable) protection: active Jun 21 04:42:52.185141 kernel: APIC: Static calls initialized Jun 21 04:42:52.185149 kernel: efi: EFI v2.7 by Microsoft Jun 21 04:42:52.185157 kernel: efi: ACPI=0x3fffa000 ACPI 2.0=0x3fffa014 SMBIOS=0x3ff85000 SMBIOS 3.0=0x3ff83000 MEMATTR=0x3f5bea98 RNG=0x3ffd1018 Jun 21 04:42:52.185164 kernel: random: crng init done Jun 21 04:42:52.185172 kernel: secureboot: Secure boot disabled Jun 21 04:42:52.185179 kernel: SMBIOS 3.1.0 present. Jun 21 04:42:52.185187 kernel: DMI: Microsoft Corporation Virtual Machine/Virtual Machine, BIOS Hyper-V UEFI Release v4.1 03/08/2024 Jun 21 04:42:52.185195 kernel: DMI: Memory slots populated: 3/3 Jun 21 04:42:52.185202 kernel: Hypervisor detected: Microsoft Hyper-V Jun 21 04:42:52.185210 kernel: Hyper-V: privilege flags low 0x2e7f, high 0x3b8030, hints 0x62c2c, misc 0xed7b2 Jun 21 04:42:52.185220 kernel: Hyper-V: LAPIC Timer Frequency: 0x30d40 Jun 21 04:42:52.185227 kernel: Hyper-V: Using hypercall for remote TLB flush Jun 21 04:42:52.185235 kernel: clocksource: hyperv_clocksource_tsc_page: mask: 0xffffffffffffffff max_cycles: 0x24e6a1710, max_idle_ns: 440795202120 ns Jun 21 04:42:52.185256 kernel: clocksource: hyperv_clocksource_msr: mask: 0xffffffffffffffff max_cycles: 0x24e6a1710, max_idle_ns: 440795202120 ns Jun 21 04:42:52.185264 kernel: tsc: Marking TSC unstable due to running on Hyper-V Jun 21 04:42:52.185272 kernel: tsc: Detected 2593.990 MHz processor Jun 21 04:42:52.185280 kernel: e820: update [mem 0x00000000-0x00000fff] usable ==> reserved Jun 21 04:42:52.185288 kernel: e820: remove [mem 0x000a0000-0x000fffff] usable Jun 21 04:42:52.185296 kernel: last_pfn = 0x5cc0000 max_arch_pfn = 0x400000000 Jun 21 04:42:52.185307 kernel: MTRR map: 5 entries (2 fixed + 3 variable; max 18), built from 8 variable MTRRs Jun 21 04:42:52.185315 kernel: x86/PAT: Configuration [0-7]: WB WC UC- UC WB WP UC- WT Jun 21 04:42:52.185323 kernel: e820: update [mem 0x40000000-0xffffffff] usable ==> reserved Jun 21 04:42:52.185331 kernel: e820: update [mem 0x1100000000-0x4fdfffffff] usable ==> reserved Jun 21 04:42:52.185338 kernel: last_pfn = 0x40000 max_arch_pfn = 0x400000000 Jun 21 04:42:52.185346 kernel: Using GB pages for direct mapping Jun 21 04:42:52.185354 kernel: ACPI: Early table checksum verification disabled Jun 21 04:42:52.185365 kernel: ACPI: RSDP 0x000000003FFFA014 000024 (v02 VRTUAL) Jun 21 04:42:52.185376 kernel: ACPI: XSDT 0x000000003FFF90E8 000064 (v01 VRTUAL MICROSFT 00000001 MSFT 00000001) Jun 21 04:42:52.185384 kernel: ACPI: FACP 0x000000003FFF8000 000114 (v06 VRTUAL MICROSFT 00000001 MSFT 00000001) Jun 21 04:42:52.185392 kernel: ACPI: DSDT 0x000000003FFD6000 01E184 (v02 MSFTVM DSDT01 00000001 MSFT 05000000) Jun 21 04:42:52.185400 kernel: ACPI: FACS 0x000000003FFFE000 000040 Jun 21 04:42:52.185409 kernel: ACPI: OEM0 0x000000003FFF7000 000064 (v01 VRTUAL MICROSFT 00000001 MSFT 00000001) Jun 21 04:42:52.185417 kernel: ACPI: SPCR 0x000000003FFF6000 000050 (v02 VRTUAL MICROSFT 00000001 MSFT 00000001) Jun 21 04:42:52.185427 kernel: ACPI: WAET 0x000000003FFF5000 000028 (v01 VRTUAL MICROSFT 00000001 MSFT 00000001) Jun 21 04:42:52.185436 kernel: ACPI: APIC 0x000000003FFD5000 000078 (v04 VRTUAL MICROSFT 00000001 MSFT 00000001) Jun 21 04:42:52.185444 kernel: ACPI: SRAT 0x000000003FFD4000 0001D0 (v02 VRTUAL MICROSFT 00000001 MSFT 00000001) Jun 21 04:42:52.185452 kernel: ACPI: BGRT 0x000000003FFD3000 000038 (v01 VRTUAL MICROSFT 00000001 MSFT 00000001) Jun 21 04:42:52.185460 kernel: ACPI: FPDT 0x000000003FFD2000 000034 (v01 VRTUAL MICROSFT 00000001 MSFT 00000001) Jun 21 04:42:52.185469 kernel: ACPI: Reserving FACP table memory at [mem 0x3fff8000-0x3fff8113] Jun 21 04:42:52.185477 kernel: ACPI: Reserving DSDT table memory at [mem 0x3ffd6000-0x3fff4183] Jun 21 04:42:52.185485 kernel: ACPI: Reserving FACS table memory at [mem 0x3fffe000-0x3fffe03f] Jun 21 04:42:52.185495 kernel: ACPI: Reserving OEM0 table memory at [mem 0x3fff7000-0x3fff7063] Jun 21 04:42:52.185503 kernel: ACPI: Reserving SPCR table memory at [mem 0x3fff6000-0x3fff604f] Jun 21 04:42:52.185512 kernel: ACPI: Reserving WAET table memory at [mem 0x3fff5000-0x3fff5027] Jun 21 04:42:52.185520 kernel: ACPI: Reserving APIC table memory at [mem 0x3ffd5000-0x3ffd5077] Jun 21 04:42:52.185528 kernel: ACPI: Reserving SRAT table memory at [mem 0x3ffd4000-0x3ffd41cf] Jun 21 04:42:52.185536 kernel: ACPI: Reserving BGRT table memory at [mem 0x3ffd3000-0x3ffd3037] Jun 21 04:42:52.185544 kernel: ACPI: Reserving FPDT table memory at [mem 0x3ffd2000-0x3ffd2033] Jun 21 04:42:52.185552 kernel: ACPI: SRAT: Node 0 PXM 0 [mem 0x00000000-0x3fffffff] hotplug Jun 21 04:42:52.185560 kernel: ACPI: SRAT: Node 0 PXM 0 [mem 0x100000000-0xfdfffffff] hotplug Jun 21 04:42:52.185571 kernel: ACPI: SRAT: Node 0 PXM 0 [mem 0x4fe0000000-0x5cbfffffff] hotplug Jun 21 04:42:52.185579 kernel: ACPI: SRAT: Node 0 PXM 0 [mem 0x5cc0200000-0xffffffffff] hotplug Jun 21 04:42:52.185587 kernel: ACPI: SRAT: Node 0 PXM 0 [mem 0x10000200000-0x1ffffffffff] hotplug Jun 21 04:42:52.185595 kernel: ACPI: SRAT: Node 0 PXM 0 [mem 0x20000200000-0x3ffffffffff] hotplug Jun 21 04:42:52.185604 kernel: ACPI: SRAT: Node 0 PXM 0 [mem 0x40000200000-0x7ffffffffff] hotplug Jun 21 04:42:52.185612 kernel: ACPI: SRAT: Node 0 PXM 0 [mem 0x80000200000-0xfffffffffff] hotplug Jun 21 04:42:52.185620 kernel: NUMA: Node 0 [mem 0x00001000-0x3fffffff] + [mem 0x100000000-0xfdfffffff] -> [mem 0x00001000-0xfdfffffff] Jun 21 04:42:52.185628 kernel: NUMA: Node 0 [mem 0x00001000-0xfdfffffff] + [mem 0x4fe0000000-0x5cbfffffff] -> [mem 0x00001000-0x5cbfffffff] Jun 21 04:42:52.185637 kernel: NODE_DATA(0) allocated [mem 0x5cbfff7dc0-0x5cbfffefff] Jun 21 04:42:52.185647 kernel: Zone ranges: Jun 21 04:42:52.185655 kernel: DMA [mem 0x0000000000001000-0x0000000000ffffff] Jun 21 04:42:52.185663 kernel: DMA32 [mem 0x0000000001000000-0x00000000ffffffff] Jun 21 04:42:52.185672 kernel: Normal [mem 0x0000000100000000-0x0000005cbfffffff] Jun 21 04:42:52.185680 kernel: Device empty Jun 21 04:42:52.185688 kernel: Movable zone start for each node Jun 21 04:42:52.185696 kernel: Early memory node ranges Jun 21 04:42:52.185704 kernel: node 0: [mem 0x0000000000001000-0x000000000009ffff] Jun 21 04:42:52.185712 kernel: node 0: [mem 0x0000000000100000-0x000000003ff40fff] Jun 21 04:42:52.185723 kernel: node 0: [mem 0x000000003ffff000-0x000000003fffffff] Jun 21 04:42:52.185731 kernel: node 0: [mem 0x0000000100000000-0x0000000fdfffffff] Jun 21 04:42:52.185739 kernel: node 0: [mem 0x0000004fe0000000-0x0000005cbfffffff] Jun 21 04:42:52.185747 kernel: Initmem setup node 0 [mem 0x0000000000001000-0x0000005cbfffffff] Jun 21 04:42:52.185755 kernel: On node 0, zone DMA: 1 pages in unavailable ranges Jun 21 04:42:52.185763 kernel: On node 0, zone DMA: 96 pages in unavailable ranges Jun 21 04:42:52.185771 kernel: On node 0, zone DMA32: 190 pages in unavailable ranges Jun 21 04:42:52.185779 kernel: ACPI: PM-Timer IO Port: 0x408 Jun 21 04:42:52.185788 kernel: ACPI: LAPIC_NMI (acpi_id[0x01] dfl dfl lint[0x1]) Jun 21 04:42:52.185798 kernel: IOAPIC[0]: apic_id 6, version 17, address 0xfec00000, GSI 0-23 Jun 21 04:42:52.185806 kernel: ACPI: INT_SRC_OVR (bus 0 bus_irq 9 global_irq 9 high level) Jun 21 04:42:52.185814 kernel: ACPI: Using ACPI (MADT) for SMP configuration information Jun 21 04:42:52.185823 kernel: ACPI: SPCR: console: uart,io,0x3f8,115200 Jun 21 04:42:52.185831 kernel: CPU topo: Max. logical packages: 1 Jun 21 04:42:52.185839 kernel: CPU topo: Max. logical dies: 1 Jun 21 04:42:52.185847 kernel: CPU topo: Max. dies per package: 1 Jun 21 04:42:52.185855 kernel: CPU topo: Max. threads per core: 1 Jun 21 04:42:52.185863 kernel: CPU topo: Num. cores per package: 6 Jun 21 04:42:52.185873 kernel: CPU topo: Num. threads per package: 6 Jun 21 04:42:52.185882 kernel: CPU topo: Allowing 6 present CPUs plus 0 hotplug CPUs Jun 21 04:42:52.185890 kernel: [mem 0x40000000-0xffffffff] available for PCI devices Jun 21 04:42:52.185898 kernel: Booting paravirtualized kernel on Hyper-V Jun 21 04:42:52.185906 kernel: clocksource: refined-jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1910969940391419 ns Jun 21 04:42:52.185914 kernel: setup_percpu: NR_CPUS:512 nr_cpumask_bits:6 nr_cpu_ids:6 nr_node_ids:1 Jun 21 04:42:52.185923 kernel: percpu: Embedded 60 pages/cpu s207832 r8192 d29736 u262144 Jun 21 04:42:52.185931 kernel: pcpu-alloc: s207832 r8192 d29736 u262144 alloc=1*2097152 Jun 21 04:42:52.185939 kernel: pcpu-alloc: [0] 0 1 2 3 4 5 - - Jun 21 04:42:52.185949 kernel: Hyper-V: PV spinlocks enabled Jun 21 04:42:52.185957 kernel: PV qspinlock hash table entries: 256 (order: 0, 4096 bytes, linear) Jun 21 04:42:52.185967 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=d3c0be6f64121476b0313f5d7d7bbd73e21bc1a219aacd38b8006b291898eca1 Jun 21 04:42:52.185975 kernel: Unknown kernel command line parameters "BOOT_IMAGE=/flatcar/vmlinuz-a", will be passed to user space. Jun 21 04:42:52.185984 kernel: Dentry cache hash table entries: 8388608 (order: 14, 67108864 bytes, linear) Jun 21 04:42:52.185992 kernel: Inode-cache hash table entries: 4194304 (order: 13, 33554432 bytes, linear) Jun 21 04:42:52.186000 kernel: Fallback order for Node 0: 0 Jun 21 04:42:52.186008 kernel: Built 1 zonelists, mobility grouping on. Total pages: 29359841 Jun 21 04:42:52.186019 kernel: Policy zone: Normal Jun 21 04:42:52.186034 kernel: mem auto-init: stack:off, heap alloc:off, heap free:off Jun 21 04:42:52.186043 kernel: software IO TLB: area num 8. Jun 21 04:42:52.186054 kernel: SLUB: HWalign=64, Order=0-3, MinObjects=0, CPUs=6, Nodes=1 Jun 21 04:42:52.186062 kernel: Kernel/User page tables isolation: enabled Jun 21 04:42:52.186071 kernel: ftrace: allocating 40093 entries in 157 pages Jun 21 04:42:52.186080 kernel: ftrace: allocated 157 pages with 5 groups Jun 21 04:42:52.186088 kernel: Dynamic Preempt: voluntary Jun 21 04:42:52.186097 kernel: rcu: Preemptible hierarchical RCU implementation. Jun 21 04:42:52.186106 kernel: rcu: RCU event tracing is enabled. Jun 21 04:42:52.186115 kernel: rcu: RCU restricting CPUs from NR_CPUS=512 to nr_cpu_ids=6. Jun 21 04:42:52.186124 kernel: Trampoline variant of Tasks RCU enabled. Jun 21 04:42:52.186134 kernel: Rude variant of Tasks RCU enabled. Jun 21 04:42:52.186143 kernel: Tracing variant of Tasks RCU enabled. Jun 21 04:42:52.186152 kernel: rcu: RCU calculated value of scheduler-enlistment delay is 100 jiffies. Jun 21 04:42:52.186161 kernel: rcu: Adjusting geometry for rcu_fanout_leaf=16, nr_cpu_ids=6 Jun 21 04:42:52.186169 kernel: RCU Tasks: Setting shift to 3 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=6. Jun 21 04:42:52.186180 kernel: RCU Tasks Rude: Setting shift to 3 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=6. Jun 21 04:42:52.186189 kernel: RCU Tasks Trace: Setting shift to 3 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=6. Jun 21 04:42:52.186198 kernel: Using NULL legacy PIC Jun 21 04:42:52.186206 kernel: NR_IRQS: 33024, nr_irqs: 472, preallocated irqs: 0 Jun 21 04:42:52.186215 kernel: rcu: srcu_init: Setting srcu_struct sizes based on contention. Jun 21 04:42:52.186224 kernel: Console: colour dummy device 80x25 Jun 21 04:42:52.186232 kernel: printk: legacy console [tty1] enabled Jun 21 04:42:52.186250 kernel: printk: legacy console [ttyS0] enabled Jun 21 04:42:52.186259 kernel: printk: legacy bootconsole [earlyser0] disabled Jun 21 04:42:52.186270 kernel: ACPI: Core revision 20240827 Jun 21 04:42:52.186279 kernel: Failed to register legacy timer interrupt Jun 21 04:42:52.186288 kernel: APIC: Switch to symmetric I/O mode setup Jun 21 04:42:52.186299 kernel: Hyper-V: Host Build 10.0.20348.1827-1-0 Jun 21 04:42:52.186307 kernel: Hyper-V: enabling crash_kexec_post_notifiers Jun 21 04:42:52.186316 kernel: Hyper-V: Using IPI hypercalls Jun 21 04:42:52.186325 kernel: APIC: send_IPI() replaced with hv_send_ipi() Jun 21 04:42:52.186333 kernel: APIC: send_IPI_mask() replaced with hv_send_ipi_mask() Jun 21 04:42:52.186342 kernel: APIC: send_IPI_mask_allbutself() replaced with hv_send_ipi_mask_allbutself() Jun 21 04:42:52.186353 kernel: APIC: send_IPI_allbutself() replaced with hv_send_ipi_allbutself() Jun 21 04:42:52.186362 kernel: APIC: send_IPI_all() replaced with hv_send_ipi_all() Jun 21 04:42:52.186371 kernel: APIC: send_IPI_self() replaced with hv_send_ipi_self() Jun 21 04:42:52.186379 kernel: Hyper-V: Using enlightened APIC (xapic mode) Jun 21 04:42:52.186388 kernel: APIC: eoi() replaced with hv_apic_eoi_write() Jun 21 04:42:52.186396 kernel: APIC: read() replaced with hv_apic_read() Jun 21 04:42:52.186405 kernel: APIC: write() replaced with hv_apic_write() Jun 21 04:42:52.186414 kernel: APIC: icr_write() replaced with hv_apic_icr_write() Jun 21 04:42:52.186422 kernel: APIC: icr_read() replaced with hv_apic_icr_read() Jun 21 04:42:52.186433 kernel: Calibrating delay loop (skipped), value calculated using timer frequency.. 5187.98 BogoMIPS (lpj=2593990) Jun 21 04:42:52.186442 kernel: Last level iTLB entries: 4KB 128, 2MB 8, 4MB 8 Jun 21 04:42:52.186451 kernel: Last level dTLB entries: 4KB 64, 2MB 32, 4MB 32, 1GB 4 Jun 21 04:42:52.186460 kernel: Spectre V1 : Mitigation: usercopy/swapgs barriers and __user pointer sanitization Jun 21 04:42:52.186468 kernel: Spectre V2 : Mitigation: Retpolines Jun 21 04:42:52.186476 kernel: Spectre V2 : Spectre v2 / SpectreRSB: Filling RSB on context switch and VMEXIT Jun 21 04:42:52.186485 kernel: Speculative Store Bypass: Vulnerable Jun 21 04:42:52.186493 kernel: MDS: Mitigation: Clear CPU buffers Jun 21 04:42:52.186502 kernel: TAA: Mitigation: Clear CPU buffers Jun 21 04:42:52.186510 kernel: MMIO Stale Data: Vulnerable: Clear CPU buffers attempted, no microcode Jun 21 04:42:52.186521 kernel: ITS: Mitigation: Aligned branch/return thunks Jun 21 04:42:52.186529 kernel: x86/fpu: Supporting XSAVE feature 0x001: 'x87 floating point registers' Jun 21 04:42:52.186538 kernel: x86/fpu: Supporting XSAVE feature 0x002: 'SSE registers' Jun 21 04:42:52.186546 kernel: x86/fpu: Supporting XSAVE feature 0x004: 'AVX registers' Jun 21 04:42:52.186554 kernel: x86/fpu: xstate_offset[2]: 576, xstate_sizes[2]: 256 Jun 21 04:42:52.186563 kernel: x86/fpu: Enabled xstate features 0x7, context size is 832 bytes, using 'standard' format. Jun 21 04:42:52.186572 kernel: Freeing SMP alternatives memory: 32K Jun 21 04:42:52.186580 kernel: pid_max: default: 32768 minimum: 301 Jun 21 04:42:52.186589 kernel: LSM: initializing lsm=lockdown,capability,landlock,selinux,ima Jun 21 04:42:52.186597 kernel: landlock: Up and running. Jun 21 04:42:52.186613 kernel: SELinux: Initializing. Jun 21 04:42:52.186625 kernel: Mount-cache hash table entries: 131072 (order: 8, 1048576 bytes, linear) Jun 21 04:42:52.186634 kernel: Mountpoint-cache hash table entries: 131072 (order: 8, 1048576 bytes, linear) Jun 21 04:42:52.186643 kernel: smpboot: CPU0: Intel(R) Xeon(R) CPU E5-2690 v4 @ 2.60GHz (family: 0x6, model: 0x4f, stepping: 0x1) Jun 21 04:42:52.186651 kernel: Performance Events: unsupported p6 CPU model 79 no PMU driver, software events only. Jun 21 04:42:52.186660 kernel: signal: max sigframe size: 1776 Jun 21 04:42:52.186669 kernel: rcu: Hierarchical SRCU implementation. Jun 21 04:42:52.186678 kernel: rcu: Max phase no-delay instances is 400. Jun 21 04:42:52.186686 kernel: Timer migration: 1 hierarchy levels; 8 children per group; 1 crossnode level Jun 21 04:42:52.186695 kernel: NMI watchdog: Perf NMI watchdog permanently disabled Jun 21 04:42:52.186704 kernel: smp: Bringing up secondary CPUs ... Jun 21 04:42:52.186715 kernel: smpboot: x86: Booting SMP configuration: Jun 21 04:42:52.186723 kernel: .... node #0, CPUs: #1 #2 #3 #4 #5 Jun 21 04:42:52.186732 kernel: smp: Brought up 1 node, 6 CPUs Jun 21 04:42:52.186741 kernel: smpboot: Total of 6 processors activated (31127.88 BogoMIPS) Jun 21 04:42:52.186749 kernel: Memory: 115339092K/117439364K available (14336K kernel code, 2430K rwdata, 9956K rodata, 54424K init, 2544K bss, 2089996K reserved, 0K cma-reserved) Jun 21 04:42:52.186758 kernel: devtmpfs: initialized Jun 21 04:42:52.186767 kernel: x86/mm: Memory block size: 1024MB Jun 21 04:42:52.186776 kernel: ACPI: PM: Registering ACPI NVS region [mem 0x3fffb000-0x3fffefff] (16384 bytes) Jun 21 04:42:52.186785 kernel: clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1911260446275000 ns Jun 21 04:42:52.186796 kernel: futex hash table entries: 2048 (order: 5, 131072 bytes, linear) Jun 21 04:42:52.186804 kernel: pinctrl core: initialized pinctrl subsystem Jun 21 04:42:52.186813 kernel: NET: Registered PF_NETLINK/PF_ROUTE protocol family Jun 21 04:42:52.186822 kernel: audit: initializing netlink subsys (disabled) Jun 21 04:42:52.186831 kernel: audit: type=2000 audit(1750480968.028:1): state=initialized audit_enabled=0 res=1 Jun 21 04:42:52.186839 kernel: thermal_sys: Registered thermal governor 'step_wise' Jun 21 04:42:52.186848 kernel: thermal_sys: Registered thermal governor 'user_space' Jun 21 04:42:52.186856 kernel: cpuidle: using governor menu Jun 21 04:42:52.186865 kernel: acpiphp: ACPI Hot Plug PCI Controller Driver version: 0.5 Jun 21 04:42:52.186876 kernel: dca service started, version 1.12.1 Jun 21 04:42:52.186885 kernel: e820: reserve RAM buffer [mem 0x3ff41000-0x3fffffff] Jun 21 04:42:52.186893 kernel: kprobes: kprobe jump-optimization is enabled. All kprobes are optimized if possible. Jun 21 04:42:52.186902 kernel: HugeTLB: registered 1.00 GiB page size, pre-allocated 0 pages Jun 21 04:42:52.186910 kernel: HugeTLB: 16380 KiB vmemmap can be freed for a 1.00 GiB page Jun 21 04:42:52.186919 kernel: HugeTLB: registered 2.00 MiB page size, pre-allocated 0 pages Jun 21 04:42:52.186928 kernel: HugeTLB: 28 KiB vmemmap can be freed for a 2.00 MiB page Jun 21 04:42:52.186936 kernel: ACPI: Added _OSI(Module Device) Jun 21 04:42:52.186945 kernel: ACPI: Added _OSI(Processor Device) Jun 21 04:42:52.186956 kernel: ACPI: Added _OSI(Processor Aggregator Device) Jun 21 04:42:52.186965 kernel: ACPI: 1 ACPI AML tables successfully acquired and loaded Jun 21 04:42:52.186973 kernel: ACPI: Interpreter enabled Jun 21 04:42:52.186982 kernel: ACPI: PM: (supports S0 S5) Jun 21 04:42:52.186990 kernel: ACPI: Using IOAPIC for interrupt routing Jun 21 04:42:52.186999 kernel: PCI: Using host bridge windows from ACPI; if necessary, use "pci=nocrs" and report a bug Jun 21 04:42:52.187008 kernel: PCI: Ignoring E820 reservations for host bridge windows Jun 21 04:42:52.187016 kernel: ACPI: Enabled 1 GPEs in block 00 to 0F Jun 21 04:42:52.187025 kernel: iommu: Default domain type: Translated Jun 21 04:42:52.187036 kernel: iommu: DMA domain TLB invalidation policy: lazy mode Jun 21 04:42:52.187045 kernel: efivars: Registered efivars operations Jun 21 04:42:52.187053 kernel: PCI: Using ACPI for IRQ routing Jun 21 04:42:52.187062 kernel: PCI: System does not support PCI Jun 21 04:42:52.187071 kernel: vgaarb: loaded Jun 21 04:42:52.187079 kernel: clocksource: Switched to clocksource hyperv_clocksource_tsc_page Jun 21 04:42:52.187088 kernel: VFS: Disk quotas dquot_6.6.0 Jun 21 04:42:52.187097 kernel: VFS: Dquot-cache hash table entries: 512 (order 0, 4096 bytes) Jun 21 04:42:52.187105 kernel: pnp: PnP ACPI init Jun 21 04:42:52.187116 kernel: pnp: PnP ACPI: found 3 devices Jun 21 04:42:52.187125 kernel: clocksource: acpi_pm: mask: 0xffffff max_cycles: 0xffffff, max_idle_ns: 2085701024 ns Jun 21 04:42:52.187133 kernel: NET: Registered PF_INET protocol family Jun 21 04:42:52.187142 kernel: IP idents hash table entries: 262144 (order: 9, 2097152 bytes, linear) Jun 21 04:42:52.187151 kernel: tcp_listen_portaddr_hash hash table entries: 65536 (order: 8, 1048576 bytes, linear) Jun 21 04:42:52.187160 kernel: Table-perturb hash table entries: 65536 (order: 6, 262144 bytes, linear) Jun 21 04:42:52.187168 kernel: TCP established hash table entries: 524288 (order: 10, 4194304 bytes, linear) Jun 21 04:42:52.187177 kernel: TCP bind hash table entries: 65536 (order: 9, 2097152 bytes, linear) Jun 21 04:42:52.187188 kernel: TCP: Hash tables configured (established 524288 bind 65536) Jun 21 04:42:52.187197 kernel: UDP hash table entries: 65536 (order: 9, 2097152 bytes, linear) Jun 21 04:42:52.187206 kernel: UDP-Lite hash table entries: 65536 (order: 9, 2097152 bytes, linear) Jun 21 04:42:52.187215 kernel: NET: Registered PF_UNIX/PF_LOCAL protocol family Jun 21 04:42:52.187223 kernel: NET: Registered PF_XDP protocol family Jun 21 04:42:52.187232 kernel: PCI: CLS 0 bytes, default 64 Jun 21 04:42:52.187249 kernel: PCI-DMA: Using software bounce buffering for IO (SWIOTLB) Jun 21 04:42:52.187258 kernel: software IO TLB: mapped [mem 0x000000003b5be000-0x000000003f5be000] (64MB) Jun 21 04:42:52.187267 kernel: RAPL PMU: API unit is 2^-32 Joules, 0 fixed counters, 10737418240 ms ovfl timer Jun 21 04:42:52.187279 kernel: Initialise system trusted keyrings Jun 21 04:42:52.187287 kernel: workingset: timestamp_bits=39 max_order=25 bucket_order=0 Jun 21 04:42:52.187296 kernel: Key type asymmetric registered Jun 21 04:42:52.187304 kernel: Asymmetric key parser 'x509' registered Jun 21 04:42:52.187313 kernel: Block layer SCSI generic (bsg) driver version 0.4 loaded (major 250) Jun 21 04:42:52.187322 kernel: io scheduler mq-deadline registered Jun 21 04:42:52.187330 kernel: io scheduler kyber registered Jun 21 04:42:52.187339 kernel: io scheduler bfq registered Jun 21 04:42:52.187348 kernel: ioatdma: Intel(R) QuickData Technology Driver 5.00 Jun 21 04:42:52.187359 kernel: Serial: 8250/16550 driver, 4 ports, IRQ sharing enabled Jun 21 04:42:52.187367 kernel: 00:00: ttyS0 at I/O 0x3f8 (irq = 4, base_baud = 115200) is a 16550A Jun 21 04:42:52.187376 kernel: 00:01: ttyS1 at I/O 0x2f8 (irq = 3, base_baud = 115200) is a 16550A Jun 21 04:42:52.187385 kernel: i8042: PNP: No PS/2 controller found. Jun 21 04:42:52.187535 kernel: rtc_cmos 00:02: registered as rtc0 Jun 21 04:42:52.187637 kernel: rtc_cmos 00:02: setting system clock to 2025-06-21T04:42:51 UTC (1750480971) Jun 21 04:42:52.187730 kernel: rtc_cmos 00:02: alarms up to one month, 114 bytes nvram Jun 21 04:42:52.187742 kernel: intel_pstate: CPU model not supported Jun 21 04:42:52.187755 kernel: efifb: probing for efifb Jun 21 04:42:52.187764 kernel: efifb: framebuffer at 0x40000000, using 3072k, total 3072k Jun 21 04:42:52.187773 kernel: efifb: mode is 1024x768x32, linelength=4096, pages=1 Jun 21 04:42:52.187781 kernel: efifb: scrolling: redraw Jun 21 04:42:52.187790 kernel: efifb: Truecolor: size=8:8:8:8, shift=24:16:8:0 Jun 21 04:42:52.187799 kernel: Console: switching to colour frame buffer device 128x48 Jun 21 04:42:52.187807 kernel: fb0: EFI VGA frame buffer device Jun 21 04:42:52.187816 kernel: pstore: Using crash dump compression: deflate Jun 21 04:42:52.187825 kernel: pstore: Registered efi_pstore as persistent store backend Jun 21 04:42:52.187836 kernel: NET: Registered PF_INET6 protocol family Jun 21 04:42:52.187844 kernel: Segment Routing with IPv6 Jun 21 04:42:52.187853 kernel: In-situ OAM (IOAM) with IPv6 Jun 21 04:42:52.187862 kernel: NET: Registered PF_PACKET protocol family Jun 21 04:42:52.187870 kernel: Key type dns_resolver registered Jun 21 04:42:52.187879 kernel: IPI shorthand broadcast: enabled Jun 21 04:42:52.187888 kernel: sched_clock: Marking stable (3696005800, 108860500)->(4129703500, -324837200) Jun 21 04:42:52.187896 kernel: registered taskstats version 1 Jun 21 04:42:52.187905 kernel: Loading compiled-in X.509 certificates Jun 21 04:42:52.187916 kernel: Loaded X.509 cert 'Kinvolk GmbH: Module signing key for 6.12.34-flatcar: ec4617d162e00e1890f71f252cdf44036a7b66f7' Jun 21 04:42:52.187925 kernel: Demotion targets for Node 0: null Jun 21 04:42:52.187933 kernel: Key type .fscrypt registered Jun 21 04:42:52.187942 kernel: Key type fscrypt-provisioning registered Jun 21 04:42:52.187950 kernel: ima: No TPM chip found, activating TPM-bypass! Jun 21 04:42:52.187959 kernel: ima: Allocated hash algorithm: sha1 Jun 21 04:42:52.187968 kernel: ima: No architecture policies found Jun 21 04:42:52.187976 kernel: clk: Disabling unused clocks Jun 21 04:42:52.187985 kernel: Warning: unable to open an initial console. Jun 21 04:42:52.187996 kernel: Freeing unused kernel image (initmem) memory: 54424K Jun 21 04:42:52.188005 kernel: Write protecting the kernel read-only data: 24576k Jun 21 04:42:52.188014 kernel: Freeing unused kernel image (rodata/data gap) memory: 284K Jun 21 04:42:52.188022 kernel: Run /init as init process Jun 21 04:42:52.188031 kernel: with arguments: Jun 21 04:42:52.188039 kernel: /init Jun 21 04:42:52.188048 kernel: with environment: Jun 21 04:42:52.188056 kernel: HOME=/ Jun 21 04:42:52.188064 kernel: TERM=linux Jun 21 04:42:52.188075 kernel: BOOT_IMAGE=/flatcar/vmlinuz-a Jun 21 04:42:52.188086 systemd[1]: Successfully made /usr/ read-only. Jun 21 04:42:52.188097 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) Jun 21 04:42:52.188107 systemd[1]: Detected virtualization microsoft. Jun 21 04:42:52.188116 systemd[1]: Detected architecture x86-64. Jun 21 04:42:52.188124 systemd[1]: Running in initrd. Jun 21 04:42:52.188133 systemd[1]: No hostname configured, using default hostname. Jun 21 04:42:52.188145 systemd[1]: Hostname set to . Jun 21 04:42:52.188154 systemd[1]: Initializing machine ID from random generator. Jun 21 04:42:52.188163 systemd[1]: Queued start job for default target initrd.target. Jun 21 04:42:52.188172 systemd[1]: Started clevis-luks-askpass.path - Forward Password Requests to Clevis Directory Watch. Jun 21 04:42:52.188181 systemd[1]: Started systemd-ask-password-console.path - Dispatch Password Requests to Console Directory Watch. Jun 21 04:42:52.188191 systemd[1]: Expecting device dev-disk-by\x2dlabel-EFI\x2dSYSTEM.device - /dev/disk/by-label/EFI-SYSTEM... Jun 21 04:42:52.188201 systemd[1]: Expecting device dev-disk-by\x2dlabel-OEM.device - /dev/disk/by-label/OEM... Jun 21 04:42:52.188210 systemd[1]: Expecting device dev-disk-by\x2dlabel-ROOT.device - /dev/disk/by-label/ROOT... Jun 21 04:42:52.188222 systemd[1]: Expecting device dev-disk-by\x2dpartlabel-USR\x2dA.device - /dev/disk/by-partlabel/USR-A... Jun 21 04:42:52.188232 systemd[1]: Expecting device dev-disk-by\x2dpartuuid-7130c94a\x2d213a\x2d4e5a\x2d8e26\x2d6cce9662f132.device - /dev/disk/by-partuuid/7130c94a-213a-4e5a-8e26-6cce9662f132... Jun 21 04:42:52.188254 systemd[1]: Expecting device dev-mapper-usr.device - /dev/mapper/usr... Jun 21 04:42:52.188264 systemd[1]: Reached target cryptsetup-pre.target - Local Encrypted Volumes (Pre). Jun 21 04:42:52.188274 systemd[1]: Reached target cryptsetup.target - Local Encrypted Volumes. Jun 21 04:42:52.188283 systemd[1]: Reached target paths.target - Path Units. Jun 21 04:42:52.188292 systemd[1]: Reached target slices.target - Slice Units. Jun 21 04:42:52.188304 systemd[1]: Reached target swap.target - Swaps. Jun 21 04:42:52.188314 systemd[1]: Reached target timers.target - Timer Units. Jun 21 04:42:52.188323 systemd[1]: Listening on iscsid.socket - Open-iSCSI iscsid Socket. Jun 21 04:42:52.188332 systemd[1]: Listening on iscsiuio.socket - Open-iSCSI iscsiuio Socket. Jun 21 04:42:52.188342 systemd[1]: Listening on systemd-journald-dev-log.socket - Journal Socket (/dev/log). Jun 21 04:42:52.188351 systemd[1]: Listening on systemd-journald.socket - Journal Sockets. Jun 21 04:42:52.188360 systemd[1]: Listening on systemd-networkd.socket - Network Service Netlink Socket. Jun 21 04:42:52.188369 systemd[1]: Listening on systemd-udevd-control.socket - udev Control Socket. Jun 21 04:42:52.188379 systemd[1]: Listening on systemd-udevd-kernel.socket - udev Kernel Socket. Jun 21 04:42:52.188390 systemd[1]: Reached target sockets.target - Socket Units. Jun 21 04:42:52.188399 systemd[1]: Starting ignition-setup-pre.service - Ignition env setup... Jun 21 04:42:52.188409 systemd[1]: Starting kmod-static-nodes.service - Create List of Static Device Nodes... Jun 21 04:42:52.188418 systemd[1]: Finished network-cleanup.service - Network Cleanup. Jun 21 04:42:52.188427 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). Jun 21 04:42:52.188436 systemd[1]: Starting systemd-fsck-usr.service... Jun 21 04:42:52.188445 systemd[1]: Starting systemd-journald.service - Journal Service... Jun 21 04:42:52.188455 systemd[1]: Starting systemd-modules-load.service - Load Kernel Modules... Jun 21 04:42:52.188485 systemd-journald[232]: Collecting audit messages is disabled. Jun 21 04:42:52.188511 systemd[1]: Starting systemd-vconsole-setup.service - Virtual Console Setup... Jun 21 04:42:52.188521 systemd-journald[232]: Journal started Jun 21 04:42:52.188544 systemd-journald[232]: Runtime Journal (/run/log/journal/e76529ed482a4ddebc1fc0626405caa6) is 8M, max 2.2G, 2.1G free. Jun 21 04:42:52.191197 systemd-modules-load[235]: Inserted module 'overlay' Jun 21 04:42:52.197745 systemd[1]: Started systemd-journald.service - Journal Service. Jun 21 04:42:52.203794 systemd[1]: Finished ignition-setup-pre.service - Ignition env setup. Jun 21 04:42:52.205396 systemd[1]: Finished kmod-static-nodes.service - Create List of Static Device Nodes. Jun 21 04:42:52.206071 systemd[1]: Finished systemd-fsck-usr.service. Jun 21 04:42:52.208208 systemd[1]: Starting systemd-tmpfiles-setup-dev-early.service - Create Static Device Nodes in /dev gracefully... Jun 21 04:42:52.209353 systemd[1]: Starting systemd-tmpfiles-setup.service - Create System Files and Directories... Jun 21 04:42:52.251475 systemd-tmpfiles[245]: /usr/lib/tmpfiles.d/var.conf:14: Duplicate line for path "/var/log", ignoring. Jun 21 04:42:52.257947 systemd[1]: Finished systemd-tmpfiles-setup-dev-early.service - Create Static Device Nodes in /dev gracefully. Jun 21 04:42:52.268938 systemd[1]: Finished systemd-vconsole-setup.service - Virtual Console Setup. Jun 21 04:42:52.270555 systemd[1]: Finished systemd-tmpfiles-setup.service - Create System Files and Directories. Jun 21 04:42:52.281082 systemd[1]: Starting dracut-cmdline-ask.service - dracut ask for additional cmdline parameters... Jun 21 04:42:52.297858 systemd[1]: Starting systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev... Jun 21 04:42:52.317259 kernel: bridge: filtering via arp/ip/ip6tables is no longer available by default. Update your scripts to load br_netfilter if you need this. Jun 21 04:42:52.320642 systemd-modules-load[235]: Inserted module 'br_netfilter' Jun 21 04:42:52.324211 kernel: Bridge firewalling registered Jun 21 04:42:52.330491 systemd[1]: Finished systemd-modules-load.service - Load Kernel Modules. Jun 21 04:42:52.332152 systemd[1]: Starting systemd-sysctl.service - Apply Kernel Variables... Jun 21 04:42:52.346887 systemd[1]: Finished dracut-cmdline-ask.service - dracut ask for additional cmdline parameters. Jun 21 04:42:52.357045 systemd[1]: Starting dracut-cmdline.service - dracut cmdline hook... Jun 21 04:42:52.358523 systemd[1]: Finished systemd-sysctl.service - Apply Kernel Variables. Jun 21 04:42:52.366809 systemd[1]: Finished systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev. Jun 21 04:42:52.369361 systemd[1]: Starting systemd-resolved.service - Network Name Resolution... Jun 21 04:42:52.396711 dracut-cmdline[271]: 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=d3c0be6f64121476b0313f5d7d7bbd73e21bc1a219aacd38b8006b291898eca1 Jun 21 04:42:52.416858 systemd-resolved[275]: Positive Trust Anchors: Jun 21 04:42:52.416866 systemd-resolved[275]: . IN DS 20326 8 2 e06d44b80b8f1d39a95c0b0d7c65d08458e880409bbc683457104237c7f8ec8d Jun 21 04:42:52.416897 systemd-resolved[275]: 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 Jun 21 04:42:52.420200 systemd-resolved[275]: Defaulting to hostname 'linux'. Jun 21 04:42:52.421284 systemd[1]: Started systemd-resolved.service - Network Name Resolution. Jun 21 04:42:52.428533 systemd[1]: Reached target nss-lookup.target - Host and Network Name Lookups. Jun 21 04:42:52.558265 kernel: SCSI subsystem initialized Jun 21 04:42:52.568260 kernel: Loading iSCSI transport class v2.0-870. Jun 21 04:42:52.580260 kernel: iscsi: registered transport (tcp) Jun 21 04:42:52.603559 kernel: iscsi: registered transport (qla4xxx) Jun 21 04:42:52.603580 kernel: QLogic iSCSI HBA Driver Jun 21 04:42:52.621432 systemd[1]: Starting systemd-network-generator.service - Generate network units from Kernel command line... Jun 21 04:42:52.652945 systemd[1]: Finished systemd-network-generator.service - Generate network units from Kernel command line. Jun 21 04:42:52.655430 systemd[1]: Reached target network-pre.target - Preparation for Network. Jun 21 04:42:52.706779 systemd[1]: Finished dracut-cmdline.service - dracut cmdline hook. Jun 21 04:42:52.709468 systemd[1]: Starting dracut-pre-udev.service - dracut pre-udev hook... Jun 21 04:42:52.785267 kernel: raid6: avx2x4 gen() 31057 MB/s Jun 21 04:42:52.804264 kernel: raid6: avx2x2 gen() 31081 MB/s Jun 21 04:42:52.825443 kernel: raid6: avx2x1 gen() 28166 MB/s Jun 21 04:42:52.825474 kernel: raid6: using algorithm avx2x2 gen() 31081 MB/s Jun 21 04:42:52.848580 kernel: raid6: .... xor() 18606 MB/s, rmw enabled Jun 21 04:42:52.848607 kernel: raid6: using avx2x2 recovery algorithm Jun 21 04:42:52.872263 kernel: xor: automatically using best checksumming function avx Jun 21 04:42:53.043272 kernel: Btrfs loaded, zoned=no, fsverity=no Jun 21 04:42:53.049523 systemd[1]: Finished dracut-pre-udev.service - dracut pre-udev hook. Jun 21 04:42:53.053259 systemd[1]: Starting systemd-udevd.service - Rule-based Manager for Device Events and Files... Jun 21 04:42:53.085327 systemd-udevd[486]: Using default interface naming scheme 'v255'. Jun 21 04:42:53.091444 systemd[1]: Started systemd-udevd.service - Rule-based Manager for Device Events and Files. Jun 21 04:42:53.092944 systemd[1]: Starting dracut-pre-trigger.service - dracut pre-trigger hook... Jun 21 04:42:53.132231 dracut-pre-trigger[492]: rd.md=0: removing MD RAID activation Jun 21 04:42:53.159675 systemd[1]: Finished dracut-pre-trigger.service - dracut pre-trigger hook. Jun 21 04:42:53.162363 systemd[1]: Starting systemd-udev-trigger.service - Coldplug All udev Devices... Jun 21 04:42:53.238467 systemd[1]: Finished systemd-udev-trigger.service - Coldplug All udev Devices. Jun 21 04:42:53.241501 systemd[1]: Starting dracut-initqueue.service - dracut initqueue hook... Jun 21 04:42:53.269289 kernel: cryptd: max_cpu_qlen set to 1000 Jun 21 04:42:53.279265 kernel: AES CTR mode by8 optimization enabled Jun 21 04:42:53.295682 systemd[1]: systemd-vconsole-setup.service: Deactivated successfully. Jun 21 04:42:53.295855 systemd[1]: Stopped systemd-vconsole-setup.service - Virtual Console Setup. Jun 21 04:42:53.308583 systemd[1]: Stopping systemd-vconsole-setup.service - Virtual Console Setup... Jun 21 04:42:53.317608 systemd[1]: Starting systemd-vconsole-setup.service - Virtual Console Setup... Jun 21 04:42:53.322251 systemd[1]: run-credentials-systemd\x2dvconsole\x2dsetup.service.mount: Deactivated successfully. Jun 21 04:42:53.345259 kernel: hv_vmbus: Vmbus version:4.0 Jun 21 04:42:53.354838 kernel: pps_core: LinuxPPS API ver. 1 registered Jun 21 04:42:53.354874 kernel: pps_core: Software ver. 5.3.6 - Copyright 2005-2007 Rodolfo Giometti Jun 21 04:42:53.354889 kernel: hv_vmbus: registering driver hyperv_keyboard Jun 21 04:42:53.366263 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 Jun 21 04:42:53.366293 kernel: PTP clock support registered Jun 21 04:42:53.369257 kernel: hid: raw HID events driver (C) Jiri Kosina Jun 21 04:42:53.372949 kernel: hv_vmbus: registering driver hv_pci Jun 21 04:42:53.372986 kernel: hv_vmbus: registering driver hv_storvsc Jun 21 04:42:53.373007 kernel: hv_vmbus: registering driver hv_netvsc Jun 21 04:42:53.383458 kernel: hv_pci 47505500-0001-0000-3130-444531444234: PCI VMBus probing: Using version 0x10004 Jun 21 04:42:53.383667 kernel: scsi host1: storvsc_host_t Jun 21 04:42:53.383700 kernel: scsi host0: storvsc_host_t Jun 21 04:42:53.383837 kernel: scsi 0:0:0:0: Direct-Access Msft Virtual Disk 1.0 PQ: 0 ANSI: 5 Jun 21 04:42:53.384412 kernel: hv_vmbus: registering driver hid_hyperv Jun 21 04:42:53.386459 kernel: hv_pci 47505500-0001-0000-3130-444531444234: PCI host bridge to bus 0001:00 Jun 21 04:42:53.386640 kernel: pci_bus 0001:00: root bus resource [mem 0x41000000-0x41ffffff window] Jun 21 04:42:53.386790 kernel: pci_bus 0001:00: root bus resource [mem 0x1000000000-0x1401ffffff window] Jun 21 04:42:53.386912 kernel: pci_bus 0001:00: No busn resource found for root bus, will use [bus 00-ff] Jun 21 04:42:53.387767 kernel: pci 0001:00:00.0: [10de:1db4] type 00 class 0x030200 PCIe Endpoint Jun 21 04:42:53.392418 kernel: input: Microsoft Vmbus HID-compliant Mouse as /devices/0006:045E:0621.0001/input/input1 Jun 21 04:42:53.392504 kernel: scsi 0:0:0:1: Direct-Access Msft Virtual Disk 1.0 PQ: 0 ANSI: 5 Jun 21 04:42:53.395825 kernel: scsi 0:0:0:2: CD-ROM Msft Virtual DVD-ROM 1.0 PQ: 0 ANSI: 0 Jun 21 04:42:53.395872 kernel: pci 0001:00:00.0: BAR 0 [mem 0x41000000-0x41ffffff] Jun 21 04:42:53.395895 kernel: pci 0001:00:00.0: BAR 1 [mem 0x1000000000-0x13ffffffff 64bit pref] Jun 21 04:42:53.395914 kernel: pci 0001:00:00.0: BAR 3 [mem 0x1400000000-0x1401ffffff 64bit pref] Jun 21 04:42:53.395932 kernel: hid-hyperv 0006:045E:0621.0001: input: VIRTUAL HID v0.01 Mouse [Microsoft Vmbus HID-compliant Mouse] on Jun 21 04:42:53.398546 kernel: pci 0001:00:00.0: Enabling HDA controller Jun 21 04:42:53.412422 kernel: hv_utils: Registering HyperV Utility Driver Jun 21 04:42:53.419882 kernel: pci_bus 0001:00: busn_res: [bus 00-ff] end is updated to 00 Jun 21 04:42:53.420051 kernel: hv_vmbus: registering driver hv_utils Jun 21 04:42:53.420066 kernel: pci 0001:00:00.0: BAR 1 [mem 0x1000000000-0x13ffffffff 64bit pref]: assigned Jun 21 04:42:53.429259 kernel: hv_utils: Heartbeat IC version 3.0 Jun 21 04:42:53.429288 kernel: pci 0001:00:00.0: BAR 3 [mem 0x1400000000-0x1401ffffff 64bit pref]: assigned Jun 21 04:42:53.434246 kernel: hv_utils: Shutdown IC version 3.2 Jun 21 04:42:53.436260 kernel: pci 0001:00:00.0: BAR 0 [mem 0x41000000-0x41ffffff]: assigned Jun 21 04:42:53.442718 kernel: hv_utils: TimeSync IC version 4.0 Jun 21 04:42:53.462283 kernel: sd 0:0:0:0: [sda] 63737856 512-byte logical blocks: (32.6 GB/30.4 GiB) Jun 21 04:42:53.462474 kernel: sd 0:0:0:1: [sdb] 1543503872 512-byte logical blocks: (790 GB/736 GiB) Jun 21 04:42:53.462660 kernel: sd 0:0:0:1: [sdb] 4096-byte physical blocks Jun 21 04:42:53.462796 kernel: sd 0:0:0:1: [sdb] Write Protect is off Jun 21 04:42:53.462987 kernel: sd 0:0:0:1: [sdb] Mode Sense: 0f 00 10 00 Jun 21 04:42:53.463120 kernel: sd 0:0:0:1: [sdb] Write cache: disabled, read cache: enabled, supports DPO and FUA Jun 21 04:42:53.463262 kernel: hv_storvsc f8b3781a-1e82-4818-a1c3-63d806ec15bb: tag#75 cmd 0x5a status: scsi 0x2 srb 0x86 hv 0xc0000001 Jun 21 04:42:53.464258 kernel: hv_storvsc f8b3781a-1e82-4818-a1c3-63d806ec15bb: tag#389 cmd 0x5a status: scsi 0x2 srb 0x86 hv 0xc0000001 Jun 21 04:42:53.663169 systemd-resolved[275]: Clock change detected. Flushing caches. Jun 21 04:42:53.729786 kernel: sd 0:0:0:0: [sda] 4096-byte physical blocks Jun 21 04:42:53.729970 kernel: sd 0:0:0:0: [sda] Write Protect is off Jun 21 04:42:53.730113 kernel: sd 0:0:0:0: [sda] Mode Sense: 0f 00 10 00 Jun 21 04:42:53.730245 kernel: sd 0:0:0:0: [sda] Write cache: disabled, read cache: enabled, supports DPO and FUA Jun 21 04:42:53.730373 kernel: hv_storvsc f8b3781a-1e82-4818-a1c3-63d806ec15bb: tag#449 cmd 0x5a status: scsi 0x2 srb 0x86 hv 0xc0000001 Jun 21 04:42:53.730523 kernel: hv_storvsc f8b3781a-1e82-4818-a1c3-63d806ec15bb: tag#456 cmd 0x5a status: scsi 0x2 srb 0x86 hv 0xc0000001 Jun 21 04:42:53.730643 kernel: sdb: sdb1 Jun 21 04:42:53.712992 systemd[1]: Finished systemd-vconsole-setup.service - Virtual Console Setup. Jun 21 04:42:53.742627 kernel: sd 0:0:0:1: [sdb] Attached SCSI disk Jun 21 04:42:53.757448 kernel: sda: sda1 sda2 sda3 sda4 sda6 sda7 sda9 Jun 21 04:42:53.757479 kernel: sd 0:0:0:0: [sda] Attached SCSI disk Jun 21 04:42:53.760459 kernel: sr 0:0:0:2: [sr0] scsi-1 drive Jun 21 04:42:53.769023 kernel: cdrom: Uniform CD-ROM driver Revision: 3.20 Jun 21 04:42:53.771496 kernel: sr 0:0:0:2: Attached scsi CD-ROM sr0 Jun 21 04:42:54.338003 systemd[1]: Found device dev-disk-by\x2dlabel-ROOT.device - Virtual_Disk ROOT. Jun 21 04:42:54.397664 systemd[1]: Found device dev-disk-by\x2dlabel-OEM.device - Virtual_Disk OEM. Jun 21 04:42:54.437242 systemd[1]: Found device dev-disk-by\x2dpartlabel-USR\x2dA.device - Virtual_Disk USR-A. Jun 21 04:42:54.438754 systemd[1]: Found device dev-disk-by\x2dpartuuid-7130c94a\x2d213a\x2d4e5a\x2d8e26\x2d6cce9662f132.device - Virtual_Disk USR-A. Jun 21 04:42:54.449824 systemd[1]: Starting disk-uuid.service - Generate new UUID for disk GPT if necessary... Jun 21 04:42:54.483981 systemd[1]: Found device dev-disk-by\x2dlabel-EFI\x2dSYSTEM.device - Virtual_Disk EFI-SYSTEM. Jun 21 04:42:54.505462 kernel: hv_storvsc f8b3781a-1e82-4818-a1c3-63d806ec15bb: tag#506 cmd 0x5a status: scsi 0x2 srb 0x86 hv 0xc0000001 Jun 21 04:42:54.527461 kernel: sda: sda1 sda2 sda3 sda4 sda6 sda7 sda9 Jun 21 04:42:54.535621 kernel: hv_storvsc f8b3781a-1e82-4818-a1c3-63d806ec15bb: tag#325 cmd 0x5a status: scsi 0x2 srb 0x86 hv 0xc0000001 Jun 21 04:42:54.556460 kernel: sda: sda1 sda2 sda3 sda4 sda6 sda7 sda9 Jun 21 04:42:55.563952 kernel: hv_storvsc f8b3781a-1e82-4818-a1c3-63d806ec15bb: tag#374 cmd 0x5a status: scsi 0x2 srb 0x86 hv 0xc0000001 Jun 21 04:42:55.574405 disk-uuid[719]: The operation has completed successfully. Jun 21 04:42:55.578257 kernel: sda: sda1 sda2 sda3 sda4 sda6 sda7 sda9 Jun 21 04:42:57.458084 systemd[1]: disk-uuid.service: Deactivated successfully. Jun 21 04:42:57.458200 systemd[1]: Finished disk-uuid.service - Generate new UUID for disk GPT if necessary. Jun 21 04:42:57.464205 systemd[1]: Starting verity-setup.service - Verity Setup for /dev/mapper/usr... Jun 21 04:42:57.481242 systemd[1]: Finished dracut-initqueue.service - dracut initqueue hook. Jun 21 04:42:57.488952 systemd[1]: Reached target remote-fs-pre.target - Preparation for Remote File Systems. Jun 21 04:42:57.497921 systemd[1]: Reached target remote-cryptsetup.target - Remote Encrypted Volumes. Jun 21 04:42:57.508273 sh[882]: Success Jun 21 04:42:57.507491 systemd[1]: Reached target remote-fs.target - Remote File Systems. Jun 21 04:42:57.509783 systemd[1]: Starting dracut-pre-mount.service - dracut pre-mount hook... Jun 21 04:42:57.541974 kernel: device-mapper: core: CONFIG_IMA_DISABLE_HTABLE is disabled. Duplicate IMA measurements will not be recorded in the IMA log. Jun 21 04:42:57.542007 kernel: device-mapper: uevent: version 1.0.3 Jun 21 04:42:57.546730 kernel: device-mapper: ioctl: 4.48.0-ioctl (2023-03-01) initialised: dm-devel@lists.linux.dev Jun 21 04:42:57.558461 kernel: device-mapper: verity: sha256 using shash "sha256-avx2" Jun 21 04:42:57.561398 systemd[1]: Finished dracut-pre-mount.service - dracut pre-mount hook. Jun 21 04:42:57.724792 systemd[1]: Found device dev-mapper-usr.device - /dev/mapper/usr. Jun 21 04:42:57.734291 systemd[1]: Mounting sysusr-usr.mount - /sysusr/usr... Jun 21 04:42:57.758088 systemd[1]: Finished verity-setup.service - Verity Setup for /dev/mapper/usr. Jun 21 04:42:57.778711 kernel: BTRFS info: 'norecovery' is for compatibility only, recommended to use 'rescue=nologreplay' Jun 21 04:42:57.778744 kernel: BTRFS: device fsid bfb8168c-5be0-428c-83e7-820ccaf1f8e9 devid 1 transid 41 /dev/mapper/usr (254:0) scanned by mount (909) Jun 21 04:42:57.784298 kernel: BTRFS info (device dm-0): first mount of filesystem bfb8168c-5be0-428c-83e7-820ccaf1f8e9 Jun 21 04:42:57.788534 kernel: BTRFS info (device dm-0): using crc32c (crc32c-intel) checksum algorithm Jun 21 04:42:57.791569 kernel: BTRFS info (device dm-0): using free-space-tree Jun 21 04:42:58.109089 systemd[1]: Mounted sysusr-usr.mount - /sysusr/usr. Jun 21 04:42:58.111074 systemd[1]: Reached target initrd-usr-fs.target - Initrd /usr File System. Jun 21 04:42:58.116539 systemd[1]: afterburn-network-kargs.service - Afterburn Initrd Setup Network Kernel Arguments was skipped because no trigger condition checks were met. Jun 21 04:42:58.117329 systemd[1]: Starting ignition-setup.service - Ignition (setup)... Jun 21 04:42:58.126666 systemd[1]: Starting parse-ip-for-networkd.service - Write systemd-networkd units from cmdline... Jun 21 04:42:58.180460 kernel: BTRFS: device label OEM devid 1 transid 16 /dev/sda6 (8:6) scanned by mount (943) Jun 21 04:42:58.189466 kernel: BTRFS info (device sda6): first mount of filesystem 57d2b200-37a8-4067-8765-910d3ed0182c Jun 21 04:42:58.189498 kernel: BTRFS info (device sda6): using crc32c (crc32c-intel) checksum algorithm Jun 21 04:42:58.192644 kernel: BTRFS info (device sda6): using free-space-tree Jun 21 04:42:58.224485 kernel: BTRFS info (device sda6): last unmount of filesystem 57d2b200-37a8-4067-8765-910d3ed0182c Jun 21 04:42:58.224981 systemd[1]: Finished ignition-setup.service - Ignition (setup). Jun 21 04:42:58.227642 systemd[1]: Starting ignition-fetch-offline.service - Ignition (fetch-offline)... Jun 21 04:42:58.259963 systemd[1]: Finished parse-ip-for-networkd.service - Write systemd-networkd units from cmdline. Jun 21 04:42:58.263006 systemd[1]: Starting systemd-networkd.service - Network Configuration... Jun 21 04:42:58.308635 systemd-networkd[1078]: lo: Link UP Jun 21 04:42:58.308646 systemd-networkd[1078]: lo: Gained carrier Jun 21 04:42:58.309764 systemd-networkd[1078]: Enumeration completed Jun 21 04:42:58.309857 systemd[1]: Started systemd-networkd.service - Network Configuration. Jun 21 04:42:58.310129 systemd-networkd[1078]: eth0: found matching network '/usr/lib/systemd/network/zz-default.network', based on potentially unpredictable interface name. Jun 21 04:42:58.310134 systemd-networkd[1078]: eth0: Configuring with /usr/lib/systemd/network/zz-default.network. Jun 21 04:42:58.310990 systemd-networkd[1078]: eth0: Link UP Jun 21 04:42:58.311176 systemd-networkd[1078]: eth0: Gained carrier Jun 21 04:42:58.311186 systemd-networkd[1078]: eth0: found matching network '/usr/lib/systemd/network/zz-default.network', based on potentially unpredictable interface name. Jun 21 04:42:58.316186 systemd[1]: Reached target network.target - Network. Jun 21 04:42:58.364478 systemd-networkd[1078]: eth0: DHCPv4 address 10.200.8.27/24, gateway 10.200.8.1 acquired from 168.63.129.16 Jun 21 04:43:00.104387 ignition[1055]: Ignition 2.21.0 Jun 21 04:43:00.104402 ignition[1055]: Stage: fetch-offline Jun 21 04:43:00.104531 ignition[1055]: no configs at "/usr/lib/ignition/base.d" Jun 21 04:43:00.104541 ignition[1055]: no config dir at "/usr/lib/ignition/base.platform.d/azure" Jun 21 04:43:00.104645 ignition[1055]: parsed url from cmdline: "" Jun 21 04:43:00.104649 ignition[1055]: no config URL provided Jun 21 04:43:00.104655 ignition[1055]: reading system config file "/usr/lib/ignition/user.ign" Jun 21 04:43:00.104664 ignition[1055]: no config at "/usr/lib/ignition/user.ign" Jun 21 04:43:00.104669 ignition[1055]: failed to fetch config: resource requires networking Jun 21 04:43:00.104828 ignition[1055]: Ignition finished successfully Jun 21 04:43:00.135671 systemd[1]: Finished ignition-fetch-offline.service - Ignition (fetch-offline). Jun 21 04:43:00.138502 systemd[1]: Starting ignition-fetch.service - Ignition (fetch)... Jun 21 04:43:00.183196 ignition[1094]: Ignition 2.21.0 Jun 21 04:43:00.183210 ignition[1094]: Stage: fetch Jun 21 04:43:00.183396 ignition[1094]: no configs at "/usr/lib/ignition/base.d" Jun 21 04:43:00.183407 ignition[1094]: no config dir at "/usr/lib/ignition/base.platform.d/azure" Jun 21 04:43:00.183497 ignition[1094]: parsed url from cmdline: "" Jun 21 04:43:00.183501 ignition[1094]: no config URL provided Jun 21 04:43:00.183507 ignition[1094]: reading system config file "/usr/lib/ignition/user.ign" Jun 21 04:43:00.183515 ignition[1094]: no config at "/usr/lib/ignition/user.ign" Jun 21 04:43:00.183546 ignition[1094]: GET http://169.254.169.254/metadata/instance/compute/userData?api-version=2021-01-01&format=text: attempt #1 Jun 21 04:43:00.277321 ignition[1094]: GET result: OK Jun 21 04:43:00.277392 ignition[1094]: config has been read from IMDS userdata Jun 21 04:43:00.277407 ignition[1094]: parsing config with SHA512: 809a7a205b0fe766093964e74e342207a89dd171289bfd01896701f7ef337a713b12b371f4c120c8a4897d09d665d7ac7a0e580db03e3fae61788cda85d900d3 Jun 21 04:43:00.282478 unknown[1094]: fetched base config from "system" Jun 21 04:43:00.282637 ignition[1094]: fetch: fetch complete Jun 21 04:43:00.282485 unknown[1094]: fetched base config from "system" Jun 21 04:43:00.282642 ignition[1094]: fetch: fetch passed Jun 21 04:43:00.282491 unknown[1094]: fetched user config from "azure" Jun 21 04:43:00.282686 ignition[1094]: Ignition finished successfully Jun 21 04:43:00.285009 systemd[1]: Finished ignition-fetch.service - Ignition (fetch). Jun 21 04:43:00.291515 systemd-networkd[1078]: eth0: Gained IPv6LL Jun 21 04:43:00.294152 systemd[1]: Starting ignition-kargs.service - Ignition (kargs)... Jun 21 04:43:00.345992 ignition[1104]: Ignition 2.21.0 Jun 21 04:43:00.346009 ignition[1104]: Stage: kargs Jun 21 04:43:00.346252 ignition[1104]: no configs at "/usr/lib/ignition/base.d" Jun 21 04:43:00.346268 ignition[1104]: no config dir at "/usr/lib/ignition/base.platform.d/azure" Jun 21 04:43:00.346794 ignition[1104]: kargs: kargs passed Jun 21 04:43:00.359369 systemd[1]: Finished ignition-kargs.service - Ignition (kargs). Jun 21 04:43:00.346838 ignition[1104]: Ignition finished successfully Jun 21 04:43:00.366324 systemd[1]: Starting ignition-disks.service - Ignition (disks)... Jun 21 04:43:00.405380 ignition[1114]: Ignition 2.21.0 Jun 21 04:43:00.405392 ignition[1114]: Stage: disks Jun 21 04:43:00.405648 ignition[1114]: no configs at "/usr/lib/ignition/base.d" Jun 21 04:43:00.405660 ignition[1114]: no config dir at "/usr/lib/ignition/base.platform.d/azure" Jun 21 04:43:00.412043 systemd[1]: Finished ignition-disks.service - Ignition (disks). Jun 21 04:43:00.406824 ignition[1114]: disks: disks passed Jun 21 04:43:00.418297 systemd[1]: Reached target initrd-root-device.target - Initrd Root Device. Jun 21 04:43:00.406889 ignition[1114]: Ignition finished successfully Jun 21 04:43:00.426854 systemd[1]: Reached target local-fs-pre.target - Preparation for Local File Systems. Jun 21 04:43:00.435668 systemd[1]: Reached target local-fs.target - Local File Systems. Jun 21 04:43:00.437118 systemd[1]: Reached target sysinit.target - System Initialization. Jun 21 04:43:00.450849 systemd[1]: Reached target basic.target - Basic System. Jun 21 04:43:00.458233 systemd[1]: Starting systemd-fsck-root.service - File System Check on /dev/disk/by-label/ROOT... Jun 21 04:43:00.534063 systemd-fsck[1126]: ROOT: clean, 15/7326000 files, 477845/7359488 blocks Jun 21 04:43:00.539300 systemd[1]: Finished systemd-fsck-root.service - File System Check on /dev/disk/by-label/ROOT. Jun 21 04:43:00.549610 systemd[1]: Mounting sysroot.mount - /sysroot... Jun 21 04:43:00.778472 kernel: EXT4-fs (sda9): mounted filesystem 6d18c974-0fd6-4e4a-98cf-62524fcf9e99 r/w with ordered data mode. Quota mode: none. Jun 21 04:43:00.779427 systemd[1]: Mounted sysroot.mount - /sysroot. Jun 21 04:43:00.782388 systemd[1]: Reached target initrd-root-fs.target - Initrd Root File System. Jun 21 04:43:00.800173 systemd[1]: Mounting sysroot-oem.mount - /sysroot/oem... Jun 21 04:43:00.807042 systemd[1]: Mounting sysroot-usr.mount - /sysroot/usr... Jun 21 04:43:00.821191 systemd[1]: Starting flatcar-metadata-hostname.service - Flatcar Metadata Hostname Agent... Jun 21 04:43:00.835361 kernel: BTRFS: device label OEM devid 1 transid 16 /dev/sda6 (8:6) scanned by mount (1140) Jun 21 04:43:00.822745 systemd[1]: ignition-remount-sysroot.service - Remount /sysroot read-write for Ignition was skipped because of an unmet condition check (ConditionPathIsReadWrite=!/sysroot). Jun 21 04:43:00.822778 systemd[1]: Reached target ignition-diskful.target - Ignition Boot Disk Setup. Jun 21 04:43:00.866119 kernel: BTRFS info (device sda6): first mount of filesystem 57d2b200-37a8-4067-8765-910d3ed0182c Jun 21 04:43:00.866141 kernel: BTRFS info (device sda6): using crc32c (crc32c-intel) checksum algorithm Jun 21 04:43:00.866161 kernel: BTRFS info (device sda6): using free-space-tree Jun 21 04:43:00.838180 systemd[1]: Mounted sysroot-usr.mount - /sysroot/usr. Jun 21 04:43:00.865728 systemd[1]: Mounted sysroot-oem.mount - /sysroot/oem. Jun 21 04:43:00.868602 systemd[1]: Starting initrd-setup-root.service - Root filesystem setup... Jun 21 04:43:02.415873 coreos-metadata[1142]: Jun 21 04:43:02.415 INFO Fetching http://168.63.129.16/?comp=versions: Attempt #1 Jun 21 04:43:02.423404 coreos-metadata[1142]: Jun 21 04:43:02.423 INFO Fetch successful Jun 21 04:43:02.427424 coreos-metadata[1142]: Jun 21 04:43:02.423 INFO Fetching http://169.254.169.254/metadata/instance/compute/name?api-version=2017-08-01&format=text: Attempt #1 Jun 21 04:43:02.435642 coreos-metadata[1142]: Jun 21 04:43:02.435 INFO Fetch successful Jun 21 04:43:02.442849 coreos-metadata[1142]: Jun 21 04:43:02.442 INFO wrote hostname ci-4372.0.0-a-09d8be67c2 to /sysroot/etc/hostname Jun 21 04:43:02.450070 systemd[1]: Finished flatcar-metadata-hostname.service - Flatcar Metadata Hostname Agent. Jun 21 04:43:02.515150 initrd-setup-root[1170]: cut: /sysroot/etc/passwd: No such file or directory Jun 21 04:43:02.572621 initrd-setup-root[1177]: cut: /sysroot/etc/group: No such file or directory Jun 21 04:43:02.579899 initrd-setup-root[1184]: cut: /sysroot/etc/shadow: No such file or directory Jun 21 04:43:02.586395 initrd-setup-root[1191]: cut: /sysroot/etc/gshadow: No such file or directory Jun 21 04:43:04.073243 systemd[1]: Finished initrd-setup-root.service - Root filesystem setup. Jun 21 04:43:04.076144 systemd[1]: Starting ignition-mount.service - Ignition (mount)... Jun 21 04:43:04.096042 systemd[1]: Starting sysroot-boot.service - /sysroot/boot... Jun 21 04:43:04.108542 systemd[1]: sysroot-oem.mount: Deactivated successfully. Jun 21 04:43:04.117312 kernel: BTRFS info (device sda6): last unmount of filesystem 57d2b200-37a8-4067-8765-910d3ed0182c Jun 21 04:43:04.144278 systemd[1]: Finished sysroot-boot.service - /sysroot/boot. Jun 21 04:43:04.154740 ignition[1258]: INFO : Ignition 2.21.0 Jun 21 04:43:04.154740 ignition[1258]: INFO : Stage: mount Jun 21 04:43:04.160513 ignition[1258]: INFO : no configs at "/usr/lib/ignition/base.d" Jun 21 04:43:04.160513 ignition[1258]: INFO : no config dir at "/usr/lib/ignition/base.platform.d/azure" Jun 21 04:43:04.160513 ignition[1258]: INFO : mount: mount passed Jun 21 04:43:04.160513 ignition[1258]: INFO : Ignition finished successfully Jun 21 04:43:04.170524 systemd[1]: Finished ignition-mount.service - Ignition (mount). Jun 21 04:43:04.177264 systemd[1]: Starting ignition-files.service - Ignition (files)... Jun 21 04:43:04.207457 systemd[1]: Mounting sysroot-oem.mount - /sysroot/oem... Jun 21 04:43:04.231706 kernel: BTRFS: device label OEM devid 1 transid 16 /dev/sda6 (8:6) scanned by mount (1275) Jun 21 04:43:04.231741 kernel: BTRFS info (device sda6): first mount of filesystem 57d2b200-37a8-4067-8765-910d3ed0182c Jun 21 04:43:04.237231 kernel: BTRFS info (device sda6): using crc32c (crc32c-intel) checksum algorithm Jun 21 04:43:04.240681 kernel: BTRFS info (device sda6): using free-space-tree Jun 21 04:43:04.244762 systemd[1]: Mounted sysroot-oem.mount - /sysroot/oem. Jun 21 04:43:04.269822 ignition[1292]: INFO : Ignition 2.21.0 Jun 21 04:43:04.269822 ignition[1292]: INFO : Stage: files Jun 21 04:43:04.275584 ignition[1292]: INFO : no configs at "/usr/lib/ignition/base.d" Jun 21 04:43:04.275584 ignition[1292]: INFO : no config dir at "/usr/lib/ignition/base.platform.d/azure" Jun 21 04:43:04.275584 ignition[1292]: DEBUG : files: compiled without relabeling support, skipping Jun 21 04:43:04.334640 ignition[1292]: INFO : files: ensureUsers: op(1): [started] creating or modifying user "core" Jun 21 04:43:04.334640 ignition[1292]: DEBUG : files: ensureUsers: op(1): executing: "usermod" "--root" "/sysroot" "core" Jun 21 04:43:04.371466 ignition[1292]: INFO : files: ensureUsers: op(1): [finished] creating or modifying user "core" Jun 21 04:43:04.377096 ignition[1292]: INFO : files: ensureUsers: op(2): [started] adding ssh keys to user "core" Jun 21 04:43:04.382789 unknown[1292]: wrote ssh authorized keys file for user: core Jun 21 04:43:04.386598 ignition[1292]: INFO : files: ensureUsers: op(2): [finished] adding ssh keys to user "core" Jun 21 04:43:04.433849 ignition[1292]: INFO : files: createFilesystemsFiles: createFiles: op(3): [started] writing file "/sysroot/etc/flatcar/update.conf" Jun 21 04:43:04.441328 ignition[1292]: INFO : files: createFilesystemsFiles: createFiles: op(3): [finished] writing file "/sysroot/etc/flatcar/update.conf" Jun 21 04:43:04.441328 ignition[1292]: INFO : files: createResultFile: createFiles: op(4): [started] writing file "/sysroot/etc/.ignition-result.json" Jun 21 04:43:04.441328 ignition[1292]: INFO : files: createResultFile: createFiles: op(4): [finished] writing file "/sysroot/etc/.ignition-result.json" Jun 21 04:43:04.441328 ignition[1292]: INFO : files: files passed Jun 21 04:43:04.441328 ignition[1292]: INFO : Ignition finished successfully Jun 21 04:43:04.450734 systemd[1]: Finished ignition-files.service - Ignition (files). Jun 21 04:43:04.459800 systemd[1]: Starting ignition-quench.service - Ignition (record completion)... Jun 21 04:43:04.490131 systemd[1]: Starting initrd-setup-root-after-ignition.service - Root filesystem completion... Jun 21 04:43:04.492950 systemd[1]: ignition-quench.service: Deactivated successfully. Jun 21 04:43:04.493047 systemd[1]: Finished ignition-quench.service - Ignition (record completion). Jun 21 04:43:04.556866 initrd-setup-root-after-ignition[1325]: grep: /sysroot/etc/flatcar/enabled-sysext.conf: No such file or directory Jun 21 04:43:04.556866 initrd-setup-root-after-ignition[1325]: grep: /sysroot/usr/share/flatcar/enabled-sysext.conf: No such file or directory Jun 21 04:43:04.570747 initrd-setup-root-after-ignition[1329]: grep: /sysroot/etc/flatcar/enabled-sysext.conf: No such file or directory Jun 21 04:43:04.564571 systemd[1]: Finished initrd-setup-root-after-ignition.service - Root filesystem completion. Jun 21 04:43:04.582459 systemd[1]: Reached target ignition-complete.target - Ignition Complete. Jun 21 04:43:04.585490 systemd[1]: Starting initrd-parse-etc.service - Mountpoints Configured in the Real Root... Jun 21 04:43:04.624375 systemd[1]: initrd-parse-etc.service: Deactivated successfully. Jun 21 04:43:04.624505 systemd[1]: Finished initrd-parse-etc.service - Mountpoints Configured in the Real Root. Jun 21 04:43:04.626701 systemd[1]: Reached target initrd-fs.target - Initrd File Systems. Jun 21 04:43:04.645962 systemd[1]: Reached target initrd.target - Initrd Default Target. Jun 21 04:43:04.647530 systemd[1]: dracut-mount.service - dracut mount hook was skipped because no trigger condition checks were met. Jun 21 04:43:04.648316 systemd[1]: Starting dracut-pre-pivot.service - dracut pre-pivot and cleanup hook... Jun 21 04:43:04.684192 systemd[1]: Finished dracut-pre-pivot.service - dracut pre-pivot and cleanup hook. Jun 21 04:43:04.687314 systemd[1]: Starting initrd-cleanup.service - Cleaning Up and Shutting Down Daemons... Jun 21 04:43:04.703785 systemd[1]: Stopped target nss-lookup.target - Host and Network Name Lookups. Jun 21 04:43:04.705354 systemd[1]: Stopped target remote-cryptsetup.target - Remote Encrypted Volumes. Jun 21 04:43:04.713588 systemd[1]: Stopped target timers.target - Timer Units. Jun 21 04:43:04.725306 systemd[1]: dracut-pre-pivot.service: Deactivated successfully. Jun 21 04:43:04.725425 systemd[1]: Stopped dracut-pre-pivot.service - dracut pre-pivot and cleanup hook. Jun 21 04:43:04.737113 systemd[1]: Stopped target initrd.target - Initrd Default Target. Jun 21 04:43:04.745884 systemd[1]: Stopped target basic.target - Basic System. Jun 21 04:43:04.753332 systemd[1]: Stopped target ignition-complete.target - Ignition Complete. Jun 21 04:43:04.760868 systemd[1]: Stopped target ignition-diskful.target - Ignition Boot Disk Setup. Jun 21 04:43:04.769587 systemd[1]: Stopped target initrd-root-device.target - Initrd Root Device. Jun 21 04:43:04.778466 systemd[1]: Stopped target initrd-usr-fs.target - Initrd /usr File System. Jun 21 04:43:04.779904 systemd[1]: Stopped target remote-fs.target - Remote File Systems. Jun 21 04:43:04.799093 systemd[1]: Stopped target remote-fs-pre.target - Preparation for Remote File Systems. Jun 21 04:43:04.804375 systemd[1]: Stopped target sysinit.target - System Initialization. Jun 21 04:43:04.806858 systemd[1]: Stopped target local-fs.target - Local File Systems. Jun 21 04:43:04.818556 systemd[1]: Stopped target swap.target - Swaps. Jun 21 04:43:04.831261 systemd[1]: dracut-pre-mount.service: Deactivated successfully. Jun 21 04:43:04.831398 systemd[1]: Stopped dracut-pre-mount.service - dracut pre-mount hook. Jun 21 04:43:04.843808 systemd[1]: Stopped target cryptsetup.target - Local Encrypted Volumes. Jun 21 04:43:04.845531 systemd[1]: Stopped target cryptsetup-pre.target - Local Encrypted Volumes (Pre). Jun 21 04:43:04.853598 systemd[1]: clevis-luks-askpass.path: Deactivated successfully. Jun 21 04:43:04.853747 systemd[1]: Stopped clevis-luks-askpass.path - Forward Password Requests to Clevis Directory Watch. Jun 21 04:43:04.862290 systemd[1]: dracut-initqueue.service: Deactivated successfully. Jun 21 04:43:04.862414 systemd[1]: Stopped dracut-initqueue.service - dracut initqueue hook. Jun 21 04:43:04.879728 systemd[1]: initrd-setup-root-after-ignition.service: Deactivated successfully. Jun 21 04:43:04.879859 systemd[1]: Stopped initrd-setup-root-after-ignition.service - Root filesystem completion. Jun 21 04:43:04.888464 systemd[1]: ignition-files.service: Deactivated successfully. Jun 21 04:43:04.888589 systemd[1]: Stopped ignition-files.service - Ignition (files). Jun 21 04:43:04.896226 systemd[1]: flatcar-metadata-hostname.service: Deactivated successfully. Jun 21 04:43:04.896344 systemd[1]: Stopped flatcar-metadata-hostname.service - Flatcar Metadata Hostname Agent. Jun 21 04:43:04.906544 systemd[1]: Stopping ignition-mount.service - Ignition (mount)... Jun 21 04:43:04.907032 systemd[1]: kmod-static-nodes.service: Deactivated successfully. Jun 21 04:43:04.907149 systemd[1]: Stopped kmod-static-nodes.service - Create List of Static Device Nodes. Jun 21 04:43:04.956733 ignition[1349]: INFO : Ignition 2.21.0 Jun 21 04:43:04.956733 ignition[1349]: INFO : Stage: umount Jun 21 04:43:04.956733 ignition[1349]: INFO : no configs at "/usr/lib/ignition/base.d" Jun 21 04:43:04.956733 ignition[1349]: INFO : no config dir at "/usr/lib/ignition/base.platform.d/azure" Jun 21 04:43:04.956733 ignition[1349]: INFO : umount: umount passed Jun 21 04:43:04.956733 ignition[1349]: INFO : Ignition finished successfully Jun 21 04:43:04.935983 systemd[1]: Stopping sysroot-boot.service - /sysroot/boot... Jun 21 04:43:04.942814 systemd[1]: systemd-udev-trigger.service: Deactivated successfully. Jun 21 04:43:04.942939 systemd[1]: Stopped systemd-udev-trigger.service - Coldplug All udev Devices. Jun 21 04:43:04.956754 systemd[1]: dracut-pre-trigger.service: Deactivated successfully. Jun 21 04:43:04.956876 systemd[1]: Stopped dracut-pre-trigger.service - dracut pre-trigger hook. Jun 21 04:43:05.002964 systemd[1]: sysroot-boot.mount: Deactivated successfully. Jun 21 04:43:05.003924 systemd[1]: ignition-mount.service: Deactivated successfully. Jun 21 04:43:05.004023 systemd[1]: Stopped ignition-mount.service - Ignition (mount). Jun 21 04:43:05.012771 systemd[1]: initrd-cleanup.service: Deactivated successfully. Jun 21 04:43:05.012863 systemd[1]: Finished initrd-cleanup.service - Cleaning Up and Shutting Down Daemons. Jun 21 04:43:05.015864 systemd[1]: ignition-disks.service: Deactivated successfully. Jun 21 04:43:05.015927 systemd[1]: Stopped ignition-disks.service - Ignition (disks). Jun 21 04:43:05.023915 systemd[1]: ignition-kargs.service: Deactivated successfully. Jun 21 04:43:05.023963 systemd[1]: Stopped ignition-kargs.service - Ignition (kargs). Jun 21 04:43:05.031328 systemd[1]: ignition-fetch.service: Deactivated successfully. Jun 21 04:43:05.031372 systemd[1]: Stopped ignition-fetch.service - Ignition (fetch). Jun 21 04:43:05.040046 systemd[1]: Stopped target network.target - Network. Jun 21 04:43:05.047622 systemd[1]: ignition-fetch-offline.service: Deactivated successfully. Jun 21 04:43:05.047673 systemd[1]: Stopped ignition-fetch-offline.service - Ignition (fetch-offline). Jun 21 04:43:05.054862 systemd[1]: Stopped target paths.target - Path Units. Jun 21 04:43:05.064189 systemd[1]: systemd-ask-password-console.path: Deactivated successfully. Jun 21 04:43:05.073653 systemd[1]: Stopped systemd-ask-password-console.path - Dispatch Password Requests to Console Directory Watch. Jun 21 04:43:05.081497 systemd[1]: Stopped target slices.target - Slice Units. Jun 21 04:43:05.082913 systemd[1]: Stopped target sockets.target - Socket Units. Jun 21 04:43:05.093434 systemd[1]: iscsid.socket: Deactivated successfully. Jun 21 04:43:05.093500 systemd[1]: Closed iscsid.socket - Open-iSCSI iscsid Socket. Jun 21 04:43:05.101497 systemd[1]: iscsiuio.socket: Deactivated successfully. Jun 21 04:43:05.101537 systemd[1]: Closed iscsiuio.socket - Open-iSCSI iscsiuio Socket. Jun 21 04:43:05.108509 systemd[1]: ignition-setup.service: Deactivated successfully. Jun 21 04:43:05.108568 systemd[1]: Stopped ignition-setup.service - Ignition (setup). Jun 21 04:43:05.116735 systemd[1]: ignition-setup-pre.service: Deactivated successfully. Jun 21 04:43:05.116834 systemd[1]: Stopped ignition-setup-pre.service - Ignition env setup. Jun 21 04:43:05.164610 systemd[1]: Stopping systemd-networkd.service - Network Configuration... Jun 21 04:43:05.165514 systemd[1]: Stopping systemd-resolved.service - Network Name Resolution... Jun 21 04:43:05.177124 systemd[1]: systemd-resolved.service: Deactivated successfully. Jun 21 04:43:05.177237 systemd[1]: Stopped systemd-resolved.service - Network Name Resolution. Jun 21 04:43:05.190308 systemd[1]: run-credentials-systemd\x2dresolved.service.mount: Deactivated successfully. Jun 21 04:43:05.190571 systemd[1]: sysroot-boot.service: Deactivated successfully. Jun 21 04:43:05.190707 systemd[1]: Stopped sysroot-boot.service - /sysroot/boot. Jun 21 04:43:05.198293 systemd[1]: systemd-networkd.service: Deactivated successfully. Jun 21 04:43:05.198578 systemd[1]: Stopped systemd-networkd.service - Network Configuration. Jun 21 04:43:05.208196 systemd[1]: run-credentials-systemd\x2dnetworkd.service.mount: Deactivated successfully. Jun 21 04:43:05.209596 systemd[1]: Stopped target network-pre.target - Preparation for Network. Jun 21 04:43:05.211258 systemd[1]: systemd-networkd.socket: Deactivated successfully. Jun 21 04:43:05.211313 systemd[1]: Closed systemd-networkd.socket - Network Service Netlink Socket. Jun 21 04:43:05.220298 systemd[1]: initrd-setup-root.service: Deactivated successfully. Jun 21 04:43:05.220357 systemd[1]: Stopped initrd-setup-root.service - Root filesystem setup. Jun 21 04:43:05.239043 systemd[1]: Stopping network-cleanup.service - Network Cleanup... Jun 21 04:43:05.246651 systemd[1]: parse-ip-for-networkd.service: Deactivated successfully. Jun 21 04:43:05.246705 systemd[1]: Stopped parse-ip-for-networkd.service - Write systemd-networkd units from cmdline. Jun 21 04:43:05.255720 systemd[1]: systemd-sysctl.service: Deactivated successfully. Jun 21 04:43:05.255771 systemd[1]: Stopped systemd-sysctl.service - Apply Kernel Variables. Jun 21 04:43:05.264400 systemd[1]: systemd-modules-load.service: Deactivated successfully. Jun 21 04:43:05.264464 systemd[1]: Stopped systemd-modules-load.service - Load Kernel Modules. Jun 21 04:43:05.272342 systemd[1]: systemd-tmpfiles-setup.service: Deactivated successfully. Jun 21 04:43:05.272396 systemd[1]: Stopped systemd-tmpfiles-setup.service - Create System Files and Directories. Jun 21 04:43:05.282062 systemd[1]: Stopping systemd-udevd.service - Rule-based Manager for Device Events and Files... Jun 21 04:43:05.290966 systemd[1]: run-credentials-systemd\x2dsysctl.service.mount: Deactivated successfully. Jun 21 04:43:05.291033 systemd[1]: run-credentials-systemd\x2dtmpfiles\x2dsetup.service.mount: Deactivated successfully. Jun 21 04:43:05.315214 systemd[1]: systemd-udevd.service: Deactivated successfully. Jun 21 04:43:05.325611 systemd[1]: Stopped systemd-udevd.service - Rule-based Manager for Device Events and Files. Jun 21 04:43:05.330803 systemd[1]: network-cleanup.service: Deactivated successfully. Jun 21 04:43:05.330898 systemd[1]: Stopped network-cleanup.service - Network Cleanup. Jun 21 04:43:05.341097 systemd[1]: systemd-udevd-control.socket: Deactivated successfully. Jun 21 04:43:05.341142 systemd[1]: Closed systemd-udevd-control.socket - udev Control Socket. Jun 21 04:43:05.349712 systemd[1]: systemd-udevd-kernel.socket: Deactivated successfully. Jun 21 04:43:05.349749 systemd[1]: Closed systemd-udevd-kernel.socket - udev Kernel Socket. Jun 21 04:43:05.362455 systemd[1]: dracut-pre-udev.service: Deactivated successfully. Jun 21 04:43:05.362506 systemd[1]: Stopped dracut-pre-udev.service - dracut pre-udev hook. Jun 21 04:43:05.375924 systemd[1]: dracut-cmdline.service: Deactivated successfully. Jun 21 04:43:05.375976 systemd[1]: Stopped dracut-cmdline.service - dracut cmdline hook. Jun 21 04:43:05.385882 systemd[1]: dracut-cmdline-ask.service: Deactivated successfully. Jun 21 04:43:05.385934 systemd[1]: Stopped dracut-cmdline-ask.service - dracut ask for additional cmdline parameters. Jun 21 04:43:05.405381 systemd[1]: Starting initrd-udevadm-cleanup-db.service - Cleanup udev Database... Jun 21 04:43:05.409427 systemd[1]: systemd-network-generator.service: Deactivated successfully. Jun 21 04:43:05.409494 systemd[1]: Stopped systemd-network-generator.service - Generate network units from Kernel command line. Jun 21 04:43:05.436414 systemd[1]: systemd-tmpfiles-setup-dev.service: Deactivated successfully. Jun 21 04:43:05.436484 systemd[1]: Stopped systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev. Jun 21 04:43:05.449814 systemd[1]: systemd-vconsole-setup.service: Deactivated successfully. Jun 21 04:43:05.449864 systemd[1]: Stopped systemd-vconsole-setup.service - Virtual Console Setup. Jun 21 04:43:05.460370 systemd[1]: run-credentials-systemd\x2dnetwork\x2dgenerator.service.mount: Deactivated successfully. Jun 21 04:43:05.460427 systemd[1]: run-credentials-systemd\x2dtmpfiles\x2dsetup\x2ddev.service.mount: Deactivated successfully. Jun 21 04:43:05.460493 systemd[1]: run-credentials-systemd\x2dvconsole\x2dsetup.service.mount: Deactivated successfully. Jun 21 04:43:05.460840 systemd[1]: initrd-udevadm-cleanup-db.service: Deactivated successfully. Jun 21 04:43:05.460933 systemd[1]: Finished initrd-udevadm-cleanup-db.service - Cleanup udev Database. Jun 21 04:43:05.464925 systemd[1]: Reached target initrd-switch-root.target - Switch Root. Jun 21 04:43:05.473932 systemd[1]: Starting initrd-switch-root.service - Switch Root... Jun 21 04:43:05.488335 systemd[1]: Switching root. Jun 21 04:43:05.584650 systemd-journald[232]: Journal stopped Jun 21 04:43:11.934236 systemd-journald[232]: Received SIGTERM from PID 1 (systemd). Jun 21 04:43:11.934314 kernel: SELinux: policy capability network_peer_controls=1 Jun 21 04:43:11.934332 kernel: SELinux: policy capability open_perms=1 Jun 21 04:43:11.934342 kernel: SELinux: policy capability extended_socket_class=1 Jun 21 04:43:11.934351 kernel: SELinux: policy capability always_check_network=0 Jun 21 04:43:11.934360 kernel: SELinux: policy capability cgroup_seclabel=1 Jun 21 04:43:11.934370 kernel: SELinux: policy capability nnp_nosuid_transition=1 Jun 21 04:43:11.934385 kernel: SELinux: policy capability genfs_seclabel_symlinks=0 Jun 21 04:43:11.934395 kernel: SELinux: policy capability ioctl_skip_cloexec=0 Jun 21 04:43:11.934409 kernel: SELinux: policy capability userspace_initial_context=0 Jun 21 04:43:11.934419 kernel: audit: type=1403 audit(1750480986.559:2): auid=4294967295 ses=4294967295 lsm=selinux res=1 Jun 21 04:43:11.934430 systemd[1]: Successfully loaded SELinux policy in 237.453ms. Jun 21 04:43:11.934454 systemd[1]: Relabeled /dev/, /dev/shm/, /run/ in 15.458ms. Jun 21 04:43:11.934466 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) Jun 21 04:43:11.934482 systemd[1]: Detected virtualization microsoft. Jun 21 04:43:11.934493 systemd[1]: Detected architecture x86-64. Jun 21 04:43:11.934503 systemd[1]: Detected first boot. Jun 21 04:43:11.934514 systemd[1]: Hostname set to . Jun 21 04:43:11.934525 systemd[1]: Initializing machine ID from random generator. Jun 21 04:43:11.934539 zram_generator::config[1394]: No configuration found. Jun 21 04:43:11.934550 kernel: Guest personality initialized and is inactive Jun 21 04:43:11.934560 kernel: VMCI host device registered (name=vmci, major=10, minor=124) Jun 21 04:43:11.934570 kernel: Initialized host personality Jun 21 04:43:11.934580 kernel: NET: Registered PF_VSOCK protocol family Jun 21 04:43:11.934590 systemd[1]: Populated /etc with preset unit settings. Jun 21 04:43:11.934602 systemd[1]: run-credentials-systemd\x2djournald.service.mount: Deactivated successfully. Jun 21 04:43:11.934615 systemd[1]: initrd-switch-root.service: Deactivated successfully. Jun 21 04:43:11.934627 systemd[1]: Stopped initrd-switch-root.service - Switch Root. Jun 21 04:43:11.934637 systemd[1]: systemd-journald.service: Scheduled restart job, restart counter is at 1. Jun 21 04:43:11.934648 systemd[1]: Created slice system-addon\x2dconfig.slice - Slice /system/addon-config. Jun 21 04:43:11.934663 systemd[1]: Created slice system-addon\x2drun.slice - Slice /system/addon-run. Jun 21 04:43:11.934675 systemd[1]: Created slice system-getty.slice - Slice /system/getty. Jun 21 04:43:11.934686 systemd[1]: Created slice system-modprobe.slice - Slice /system/modprobe. Jun 21 04:43:11.934700 systemd[1]: Created slice system-serial\x2dgetty.slice - Slice /system/serial-getty. Jun 21 04:43:11.934711 systemd[1]: Created slice system-system\x2dcloudinit.slice - Slice /system/system-cloudinit. Jun 21 04:43:11.934723 systemd[1]: Created slice system-systemd\x2dfsck.slice - Slice /system/systemd-fsck. Jun 21 04:43:11.934734 systemd[1]: Created slice user.slice - User and Session Slice. Jun 21 04:43:11.934768 systemd[1]: Started clevis-luks-askpass.path - Forward Password Requests to Clevis Directory Watch. Jun 21 04:43:11.934790 systemd[1]: Started systemd-ask-password-console.path - Dispatch Password Requests to Console Directory Watch. Jun 21 04:43:11.934802 systemd[1]: Started systemd-ask-password-wall.path - Forward Password Requests to Wall Directory Watch. Jun 21 04:43:11.934819 systemd[1]: Set up automount boot.automount - Boot partition Automount Point. Jun 21 04:43:11.934831 systemd[1]: Set up automount proc-sys-fs-binfmt_misc.automount - Arbitrary Executable File Formats File System Automount Point. Jun 21 04:43:11.934846 systemd[1]: Expecting device dev-disk-by\x2dlabel-OEM.device - /dev/disk/by-label/OEM... Jun 21 04:43:11.934857 systemd[1]: Expecting device dev-ttyS0.device - /dev/ttyS0... Jun 21 04:43:11.934868 systemd[1]: Reached target cryptsetup-pre.target - Local Encrypted Volumes (Pre). Jun 21 04:43:11.934880 systemd[1]: Reached target cryptsetup.target - Local Encrypted Volumes. Jun 21 04:43:11.934891 systemd[1]: Stopped target initrd-switch-root.target - Switch Root. Jun 21 04:43:11.934902 systemd[1]: Stopped target initrd-fs.target - Initrd File Systems. Jun 21 04:43:11.934913 systemd[1]: Stopped target initrd-root-fs.target - Initrd Root File System. Jun 21 04:43:11.934927 systemd[1]: Reached target integritysetup.target - Local Integrity Protected Volumes. Jun 21 04:43:11.934939 systemd[1]: Reached target remote-cryptsetup.target - Remote Encrypted Volumes. Jun 21 04:43:11.934954 systemd[1]: Reached target remote-fs.target - Remote File Systems. Jun 21 04:43:11.934965 systemd[1]: Reached target slices.target - Slice Units. Jun 21 04:43:11.935004 systemd[1]: Reached target swap.target - Swaps. Jun 21 04:43:11.935021 systemd[1]: Reached target veritysetup.target - Local Verity Protected Volumes. Jun 21 04:43:11.935033 systemd[1]: Listening on systemd-coredump.socket - Process Core Dump Socket. Jun 21 04:43:11.935050 systemd[1]: Listening on systemd-creds.socket - Credential Encryption/Decryption. Jun 21 04:43:11.935062 systemd[1]: Listening on systemd-networkd.socket - Network Service Netlink Socket. Jun 21 04:43:11.935073 systemd[1]: Listening on systemd-udevd-control.socket - udev Control Socket. Jun 21 04:43:11.935085 systemd[1]: Listening on systemd-udevd-kernel.socket - udev Kernel Socket. Jun 21 04:43:11.935096 systemd[1]: Listening on systemd-userdbd.socket - User Database Manager Socket. Jun 21 04:43:11.935107 systemd[1]: Mounting dev-hugepages.mount - Huge Pages File System... Jun 21 04:43:11.935121 systemd[1]: Mounting dev-mqueue.mount - POSIX Message Queue File System... Jun 21 04:43:11.935133 systemd[1]: Mounting media.mount - External Media Directory... Jun 21 04:43:11.935144 systemd[1]: proc-xen.mount - /proc/xen was skipped because of an unmet condition check (ConditionVirtualization=xen). Jun 21 04:43:11.935156 systemd[1]: Mounting sys-kernel-debug.mount - Kernel Debug File System... Jun 21 04:43:11.935167 systemd[1]: Mounting sys-kernel-tracing.mount - Kernel Trace File System... Jun 21 04:43:11.935178 systemd[1]: Mounting tmp.mount - Temporary Directory /tmp... Jun 21 04:43:11.935190 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). Jun 21 04:43:11.935202 systemd[1]: Reached target machines.target - Containers. Jun 21 04:43:11.935243 systemd[1]: Starting flatcar-tmpfiles.service - Create missing system files... Jun 21 04:43:11.935261 systemd[1]: ignition-delete-config.service - Ignition (delete config) was skipped because no trigger condition checks were met. Jun 21 04:43:11.935280 systemd[1]: Starting kmod-static-nodes.service - Create List of Static Device Nodes... Jun 21 04:43:11.935292 systemd[1]: Starting modprobe@configfs.service - Load Kernel Module configfs... Jun 21 04:43:11.935303 systemd[1]: Starting modprobe@dm_mod.service - Load Kernel Module dm_mod... Jun 21 04:43:11.935315 systemd[1]: Starting modprobe@drm.service - Load Kernel Module drm... Jun 21 04:43:11.935326 systemd[1]: Starting modprobe@efi_pstore.service - Load Kernel Module efi_pstore... Jun 21 04:43:11.935338 systemd[1]: Starting modprobe@fuse.service - Load Kernel Module fuse... Jun 21 04:43:11.935354 systemd[1]: Starting modprobe@loop.service - Load Kernel Module loop... Jun 21 04:43:11.935366 systemd[1]: setup-nsswitch.service - Create /etc/nsswitch.conf was skipped because of an unmet condition check (ConditionPathExists=!/etc/nsswitch.conf). Jun 21 04:43:11.935377 systemd[1]: systemd-fsck-root.service: Deactivated successfully. Jun 21 04:43:11.935389 systemd[1]: Stopped systemd-fsck-root.service - File System Check on Root Device. Jun 21 04:43:11.935400 systemd[1]: systemd-fsck-usr.service: Deactivated successfully. Jun 21 04:43:11.935411 systemd[1]: Stopped systemd-fsck-usr.service. Jun 21 04:43:11.935423 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). Jun 21 04:43:11.935479 systemd[1]: Starting systemd-journald.service - Journal Service... Jun 21 04:43:11.935498 kernel: fuse: init (API version 7.41) Jun 21 04:43:11.935570 systemd[1]: Starting systemd-modules-load.service - Load Kernel Modules... Jun 21 04:43:11.935587 systemd[1]: Starting systemd-network-generator.service - Generate network units from Kernel command line... Jun 21 04:43:11.935598 systemd[1]: Starting systemd-remount-fs.service - Remount Root and Kernel File Systems... Jun 21 04:43:11.935611 systemd[1]: Starting systemd-udev-load-credentials.service - Load udev Rules from Credentials... Jun 21 04:43:11.935622 systemd[1]: Starting systemd-udev-trigger.service - Coldplug All udev Devices... Jun 21 04:43:11.935633 systemd[1]: verity-setup.service: Deactivated successfully. Jun 21 04:43:11.935649 systemd[1]: Stopped verity-setup.service. Jun 21 04:43:11.935661 systemd[1]: xenserver-pv-version.service - Set fake PV driver version for XenServer was skipped because of an unmet condition check (ConditionVirtualization=xen). Jun 21 04:43:11.935677 kernel: loop: module loaded Jun 21 04:43:11.935714 systemd[1]: Mounted dev-hugepages.mount - Huge Pages File System. Jun 21 04:43:11.935734 systemd[1]: Mounted dev-mqueue.mount - POSIX Message Queue File System. Jun 21 04:43:11.935745 systemd[1]: Mounted media.mount - External Media Directory. Jun 21 04:43:11.935757 systemd[1]: Mounted sys-kernel-debug.mount - Kernel Debug File System. Jun 21 04:43:11.935795 systemd[1]: Mounted sys-kernel-tracing.mount - Kernel Trace File System. Jun 21 04:43:11.935916 systemd-journald[1497]: Collecting audit messages is disabled. Jun 21 04:43:11.935995 systemd[1]: Mounted tmp.mount - Temporary Directory /tmp. Jun 21 04:43:11.936015 systemd-journald[1497]: Journal started Jun 21 04:43:11.936038 systemd-journald[1497]: Runtime Journal (/run/log/journal/65311ef39f2d40dcb9206e35d6171403) is 8M, max 2.2G, 2.1G free. Jun 21 04:43:11.034245 systemd[1]: Queued start job for default target multi-user.target. Jun 21 04:43:11.058836 systemd[1]: Unnecessary job was removed for dev-sda6.device - /dev/sda6. Jun 21 04:43:11.059343 systemd[1]: systemd-journald.service: Deactivated successfully. Jun 21 04:43:11.943137 systemd[1]: Started systemd-journald.service - Journal Service. Jun 21 04:43:11.946807 systemd[1]: Finished flatcar-tmpfiles.service - Create missing system files. Jun 21 04:43:11.951840 systemd[1]: Finished kmod-static-nodes.service - Create List of Static Device Nodes. Jun 21 04:43:11.957056 systemd[1]: modprobe@configfs.service: Deactivated successfully. Jun 21 04:43:11.957242 systemd[1]: Finished modprobe@configfs.service - Load Kernel Module configfs. Jun 21 04:43:11.962061 systemd[1]: modprobe@dm_mod.service: Deactivated successfully. Jun 21 04:43:11.962248 systemd[1]: Finished modprobe@dm_mod.service - Load Kernel Module dm_mod. Jun 21 04:43:11.967025 systemd[1]: modprobe@efi_pstore.service: Deactivated successfully. Jun 21 04:43:11.967208 systemd[1]: Finished modprobe@efi_pstore.service - Load Kernel Module efi_pstore. Jun 21 04:43:11.972188 systemd[1]: modprobe@fuse.service: Deactivated successfully. Jun 21 04:43:11.972374 systemd[1]: Finished modprobe@fuse.service - Load Kernel Module fuse. Jun 21 04:43:11.976883 systemd[1]: modprobe@loop.service: Deactivated successfully. Jun 21 04:43:11.977070 systemd[1]: Finished modprobe@loop.service - Load Kernel Module loop. Jun 21 04:43:11.981932 systemd[1]: Finished systemd-modules-load.service - Load Kernel Modules. Jun 21 04:43:11.986709 systemd[1]: Finished systemd-network-generator.service - Generate network units from Kernel command line. Jun 21 04:43:11.992088 systemd[1]: Finished systemd-remount-fs.service - Remount Root and Kernel File Systems. Jun 21 04:43:11.998420 systemd[1]: Finished systemd-udev-load-credentials.service - Load udev Rules from Credentials. Jun 21 04:43:12.012383 systemd[1]: Reached target network-pre.target - Preparation for Network. Jun 21 04:43:12.018466 systemd[1]: Mounting sys-fs-fuse-connections.mount - FUSE Control File System... Jun 21 04:43:12.032630 systemd[1]: Mounting sys-kernel-config.mount - Kernel Configuration File System... Jun 21 04:43:12.037081 systemd[1]: remount-root.service - Remount Root File System was skipped because of an unmet condition check (ConditionPathIsReadWrite=!/). Jun 21 04:43:12.037120 systemd[1]: Reached target local-fs.target - Local File Systems. Jun 21 04:43:12.042204 systemd[1]: Listening on systemd-sysext.socket - System Extension Image Management. Jun 21 04:43:12.048917 systemd[1]: Starting ldconfig.service - Rebuild Dynamic Linker Cache... Jun 21 04:43:12.087525 systemd[1]: systemd-binfmt.service - Set Up Additional Binary Formats was skipped because no trigger condition checks were met. Jun 21 04:43:12.089333 systemd[1]: Starting systemd-hwdb-update.service - Rebuild Hardware Database... Jun 21 04:43:12.093456 kernel: ACPI: bus type drm_connector registered Jun 21 04:43:12.095543 systemd[1]: Starting systemd-journal-flush.service - Flush Journal to Persistent Storage... Jun 21 04:43:12.101426 systemd[1]: systemd-pstore.service - Platform Persistent Storage Archival was skipped because of an unmet condition check (ConditionDirectoryNotEmpty=/sys/fs/pstore). Jun 21 04:43:12.110336 systemd[1]: Starting systemd-random-seed.service - Load/Save OS Random Seed... Jun 21 04:43:12.114702 systemd[1]: systemd-repart.service - Repartition Root Disk was skipped because no trigger condition checks were met. Jun 21 04:43:12.115655 systemd[1]: Starting systemd-sysctl.service - Apply Kernel Variables... Jun 21 04:43:12.120667 systemd[1]: Starting systemd-sysext.service - Merge System Extension Images into /usr/ and /opt/... Jun 21 04:43:12.126206 systemd[1]: Starting systemd-sysusers.service - Create System Users... Jun 21 04:43:12.132937 systemd[1]: modprobe@drm.service: Deactivated successfully. Jun 21 04:43:12.133137 systemd[1]: Finished modprobe@drm.service - Load Kernel Module drm. Jun 21 04:43:12.138040 systemd[1]: Finished systemd-udev-trigger.service - Coldplug All udev Devices. Jun 21 04:43:12.144107 systemd[1]: Mounted sys-fs-fuse-connections.mount - FUSE Control File System. Jun 21 04:43:12.148880 systemd[1]: Mounted sys-kernel-config.mount - Kernel Configuration File System. Jun 21 04:43:12.154151 systemd[1]: Finished systemd-random-seed.service - Load/Save OS Random Seed. Jun 21 04:43:12.161569 systemd[1]: Reached target first-boot-complete.target - First Boot Complete. Jun 21 04:43:12.166208 systemd-journald[1497]: Time spent on flushing to /var/log/journal/65311ef39f2d40dcb9206e35d6171403 is 15.040ms for 950 entries. Jun 21 04:43:12.166208 systemd-journald[1497]: System Journal (/var/log/journal/65311ef39f2d40dcb9206e35d6171403) is 8M, max 2.6G, 2.6G free. Jun 21 04:43:12.217481 systemd-journald[1497]: Received client request to flush runtime journal. Jun 21 04:43:12.217540 kernel: loop0: detected capacity change from 0 to 113872 Jun 21 04:43:12.167415 systemd[1]: Starting systemd-machine-id-commit.service - Save Transient machine-id to Disk... Jun 21 04:43:12.206246 systemd[1]: Finished systemd-sysctl.service - Apply Kernel Variables. Jun 21 04:43:12.218737 systemd[1]: Finished systemd-journal-flush.service - Flush Journal to Persistent Storage. Jun 21 04:43:12.268173 systemd[1]: etc-machine\x2did.mount: Deactivated successfully. Jun 21 04:43:12.268870 systemd[1]: Finished systemd-machine-id-commit.service - Save Transient machine-id to Disk. Jun 21 04:43:12.429011 systemd[1]: Finished systemd-sysusers.service - Create System Users. Jun 21 04:43:12.434711 systemd[1]: Starting systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev... Jun 21 04:43:12.612234 systemd-tmpfiles[1550]: ACLs are not supported, ignoring. Jun 21 04:43:12.612256 systemd-tmpfiles[1550]: ACLs are not supported, ignoring. Jun 21 04:43:12.628073 systemd[1]: Finished systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev. Jun 21 04:43:12.906472 kernel: squashfs: version 4.0 (2009/01/31) Phillip Lougher Jun 21 04:43:12.984473 kernel: loop1: detected capacity change from 0 to 28496 Jun 21 04:43:13.412688 systemd[1]: Finished systemd-hwdb-update.service - Rebuild Hardware Database. Jun 21 04:43:13.419079 systemd[1]: Starting systemd-udevd.service - Rule-based Manager for Device Events and Files... Jun 21 04:43:13.466948 systemd-udevd[1557]: Using default interface naming scheme 'v255'. Jun 21 04:43:13.684475 kernel: loop2: detected capacity change from 0 to 146240 Jun 21 04:43:13.968478 kernel: loop3: detected capacity change from 0 to 113872 Jun 21 04:43:13.979465 kernel: loop4: detected capacity change from 0 to 28496 Jun 21 04:43:13.988457 kernel: loop5: detected capacity change from 0 to 146240 Jun 21 04:43:13.998314 (sd-merge)[1560]: Using extensions 'containerd-flatcar', 'docker-flatcar', 'oem-azure'. Jun 21 04:43:13.998848 (sd-merge)[1560]: Merged extensions into '/usr'. Jun 21 04:43:14.002044 systemd[1]: Finished systemd-sysext.service - Merge System Extension Images into /usr/ and /opt/. Jun 21 04:43:14.009076 systemd[1]: Starting ensure-sysext.service... Jun 21 04:43:14.012930 systemd[1]: Starting systemd-tmpfiles-setup.service - Create System Files and Directories... Jun 21 04:43:14.049976 systemd-tmpfiles[1563]: /usr/lib/tmpfiles.d/nfs-utils.conf:6: Duplicate line for path "/var/lib/nfs/sm", ignoring. Jun 21 04:43:14.050019 systemd-tmpfiles[1563]: /usr/lib/tmpfiles.d/nfs-utils.conf:7: Duplicate line for path "/var/lib/nfs/sm.bak", ignoring. Jun 21 04:43:14.050307 systemd-tmpfiles[1563]: /usr/lib/tmpfiles.d/provision.conf:20: Duplicate line for path "/root", ignoring. Jun 21 04:43:14.050630 systemd-tmpfiles[1563]: /usr/lib/tmpfiles.d/systemd-flatcar.conf:6: Duplicate line for path "/var/log/journal", ignoring. Jun 21 04:43:14.051703 systemd-tmpfiles[1563]: /usr/lib/tmpfiles.d/systemd.conf:29: Duplicate line for path "/var/lib/systemd", ignoring. Jun 21 04:43:14.051995 systemd-tmpfiles[1563]: ACLs are not supported, ignoring. Jun 21 04:43:14.051997 systemd[1]: Reload requested from client PID 1562 ('systemctl') (unit ensure-sysext.service)... Jun 21 04:43:14.052015 systemd[1]: Reloading... Jun 21 04:43:14.052061 systemd-tmpfiles[1563]: ACLs are not supported, ignoring. Jun 21 04:43:14.055922 systemd-tmpfiles[1563]: Detected autofs mount point /boot during canonicalization of boot. Jun 21 04:43:14.055934 systemd-tmpfiles[1563]: Skipping /boot Jun 21 04:43:14.068737 systemd-tmpfiles[1563]: Detected autofs mount point /boot during canonicalization of boot. Jun 21 04:43:14.068752 systemd-tmpfiles[1563]: Skipping /boot Jun 21 04:43:14.093590 zram_generator::config[1590]: No configuration found. Jun 21 04:43:14.178462 kernel: hv_vmbus: registering driver hyperv_fb Jun 21 04:43:14.188774 kernel: hyperv_fb: Synthvid Version major 3, minor 5 Jun 21 04:43:14.188855 kernel: hyperv_fb: Screen resolution: 1024x768, Color depth: 32, Frame buffer size: 8388608 Jun 21 04:43:14.189456 kernel: Console: switching to colour dummy device 80x25 Jun 21 04:43:14.200105 kernel: Console: switching to colour frame buffer device 128x48 Jun 21 04:43:14.212460 kernel: hv_vmbus: registering driver hv_balloon Jun 21 04:43:14.224458 kernel: mousedev: PS/2 mouse device common for all mice Jun 21 04:43:14.224522 kernel: hv_balloon: Using Dynamic Memory protocol version 2.0 Jun 21 04:43:14.247293 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. Jun 21 04:43:14.303461 kernel: EDAC MC: Ver: 3.0.0 Jun 21 04:43:14.388797 systemd[1]: Condition check resulted in dev-ttyS0.device - /dev/ttyS0 being skipped. Jun 21 04:43:14.388996 systemd[1]: Reloading finished in 336 ms. Jun 21 04:43:14.418797 systemd[1]: Started systemd-udevd.service - Rule-based Manager for Device Events and Files. Jun 21 04:43:14.438301 systemd[1]: Finished systemd-tmpfiles-setup.service - Create System Files and Directories. Jun 21 04:43:14.475806 systemd[1]: Finished ensure-sysext.service. Jun 21 04:43:14.510743 systemd[1]: Found device dev-disk-by\x2dlabel-OEM.device - Virtual_Disk OEM. Jun 21 04:43:14.519988 systemd[1]: proc-xen.mount - /proc/xen was skipped because of an unmet condition check (ConditionVirtualization=xen). Jun 21 04:43:14.521382 systemd[1]: Starting audit-rules.service - Load Audit Rules... Jun 21 04:43:14.533691 systemd[1]: Starting clean-ca-certificates.service - Clean up broken links in /etc/ssl/certs... Jun 21 04:43:14.539109 systemd[1]: ignition-delete-config.service - Ignition (delete config) was skipped because no trigger condition checks were met. Jun 21 04:43:14.540127 systemd[1]: Starting modprobe@dm_mod.service - Load Kernel Module dm_mod... Jun 21 04:43:14.545198 systemd[1]: Starting modprobe@drm.service - Load Kernel Module drm... Jun 21 04:43:14.550029 systemd[1]: Starting modprobe@efi_pstore.service - Load Kernel Module efi_pstore... Jun 21 04:43:14.555594 systemd[1]: Starting modprobe@loop.service - Load Kernel Module loop... Jun 21 04:43:14.560031 systemd[1]: systemd-binfmt.service - Set Up Additional Binary Formats was skipped because no trigger condition checks were met. Jun 21 04:43:14.560987 systemd[1]: Starting systemd-fsck@dev-disk-by\x2dlabel-OEM.service - File System Check on /dev/disk/by-label/OEM... Jun 21 04:43:14.566357 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). Jun 21 04:43:14.567380 systemd[1]: Starting systemd-journal-catalog-update.service - Rebuild Journal Catalog... Jun 21 04:43:14.573549 systemd[1]: Starting systemd-networkd.service - Network Configuration... Jun 21 04:43:14.579222 systemd[1]: Starting systemd-resolved.service - Network Name Resolution... Jun 21 04:43:14.580803 systemd[1]: Reached target time-set.target - System Time Set. Jun 21 04:43:14.583541 systemd[1]: Starting systemd-update-utmp.service - Record System Boot/Shutdown in UTMP... Jun 21 04:43:14.585400 systemd[1]: Starting systemd-vconsole-setup.service - Virtual Console Setup... Jun 21 04:43:14.586452 systemd[1]: xenserver-pv-version.service - Set fake PV driver version for XenServer was skipped because of an unmet condition check (ConditionVirtualization=xen). Jun 21 04:43:14.587345 systemd[1]: modprobe@dm_mod.service: Deactivated successfully. Jun 21 04:43:14.587551 systemd[1]: Finished modprobe@dm_mod.service - Load Kernel Module dm_mod. Jun 21 04:43:14.588300 systemd[1]: modprobe@drm.service: Deactivated successfully. Jun 21 04:43:14.588498 systemd[1]: Finished modprobe@drm.service - Load Kernel Module drm. Jun 21 04:43:14.588853 systemd[1]: modprobe@efi_pstore.service: Deactivated successfully. Jun 21 04:43:14.589021 systemd[1]: Finished modprobe@efi_pstore.service - Load Kernel Module efi_pstore. Jun 21 04:43:14.589613 systemd[1]: modprobe@loop.service: Deactivated successfully. Jun 21 04:43:14.589780 systemd[1]: Finished modprobe@loop.service - Load Kernel Module loop. Jun 21 04:43:14.594865 systemd[1]: systemd-pstore.service - Platform Persistent Storage Archival was skipped because of an unmet condition check (ConditionDirectoryNotEmpty=/sys/fs/pstore). Jun 21 04:43:14.595014 systemd[1]: systemd-repart.service - Repartition Root Disk was skipped because no trigger condition checks were met. Jun 21 04:43:14.596297 systemd[1]: Finished systemd-update-utmp.service - Record System Boot/Shutdown in UTMP. Jun 21 04:43:14.621258 systemd[1]: Finished systemd-fsck@dev-disk-by\x2dlabel-OEM.service - File System Check on /dev/disk/by-label/OEM. Jun 21 04:43:14.631172 systemd[1]: Starting systemd-userdbd.service - User Database Manager... Jun 21 04:43:14.665975 systemd[1]: Finished systemd-journal-catalog-update.service - Rebuild Journal Catalog. Jun 21 04:43:14.671133 augenrules[1828]: No rules Jun 21 04:43:14.672167 systemd[1]: audit-rules.service: Deactivated successfully. Jun 21 04:43:14.672393 systemd[1]: Finished audit-rules.service - Load Audit Rules. Jun 21 04:43:14.682991 systemd[1]: Started systemd-userdbd.service - User Database Manager. Jun 21 04:43:14.788667 systemd-resolved[1802]: Positive Trust Anchors: Jun 21 04:43:14.788681 systemd-resolved[1802]: . IN DS 20326 8 2 e06d44b80b8f1d39a95c0b0d7c65d08458e880409bbc683457104237c7f8ec8d Jun 21 04:43:14.788714 systemd-resolved[1802]: 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 Jun 21 04:43:14.796493 systemd-networkd[1800]: lo: Link UP Jun 21 04:43:14.796503 systemd-networkd[1800]: lo: Gained carrier Jun 21 04:43:14.797789 systemd-networkd[1800]: Enumeration completed Jun 21 04:43:14.797894 systemd[1]: Started systemd-networkd.service - Network Configuration. Jun 21 04:43:14.798163 systemd-networkd[1800]: eth0: found matching network '/usr/lib/systemd/network/zz-default.network', based on potentially unpredictable interface name. Jun 21 04:43:14.798172 systemd-networkd[1800]: eth0: Configuring with /usr/lib/systemd/network/zz-default.network. Jun 21 04:43:14.798769 systemd-networkd[1800]: eth0: Link UP Jun 21 04:43:14.798778 systemd-networkd[1800]: eth0: Gained carrier Jun 21 04:43:14.798793 systemd-networkd[1800]: eth0: found matching network '/usr/lib/systemd/network/zz-default.network', based on potentially unpredictable interface name. Jun 21 04:43:14.800729 systemd[1]: Starting systemd-networkd-persistent-storage.service - Enable Persistent Storage in systemd-networkd... Jun 21 04:43:14.801748 systemd[1]: Starting systemd-networkd-wait-online.service - Wait for Network to be Configured... Jun 21 04:43:14.854507 systemd-networkd[1800]: eth0: DHCPv4 address 10.200.8.27/24, gateway 10.200.8.1 acquired from 168.63.129.16 Jun 21 04:43:14.858871 systemd[1]: Finished systemd-networkd-persistent-storage.service - Enable Persistent Storage in systemd-networkd. Jun 21 04:43:14.864843 systemd-resolved[1802]: Using system hostname 'ci-4372.0.0-a-09d8be67c2'. Jun 21 04:43:14.865086 systemd[1]: Finished systemd-vconsole-setup.service - Virtual Console Setup. Jun 21 04:43:14.869957 systemd[1]: Started systemd-resolved.service - Network Name Resolution. Jun 21 04:43:14.874661 systemd[1]: Reached target network.target - Network. Jun 21 04:43:14.878254 systemd[1]: Reached target nss-lookup.target - Host and Network Name Lookups. Jun 21 04:43:15.273667 systemd[1]: Finished clean-ca-certificates.service - Clean up broken links in /etc/ssl/certs. Jun 21 04:43:15.279023 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). Jun 21 04:43:16.547585 systemd-networkd[1800]: eth0: Gained IPv6LL Jun 21 04:43:16.549932 systemd[1]: Finished systemd-networkd-wait-online.service - Wait for Network to be Configured. Jun 21 04:43:16.555300 systemd[1]: Reached target network-online.target - Network is Online. Jun 21 04:43:20.900876 ldconfig[1529]: /sbin/ldconfig: /usr/lib/ld.so.conf is not an ELF file - it has the wrong magic bytes at the start. Jun 21 04:43:20.912729 systemd[1]: Finished ldconfig.service - Rebuild Dynamic Linker Cache. Jun 21 04:43:20.919036 systemd[1]: Starting systemd-update-done.service - Update is Completed... Jun 21 04:43:20.946639 systemd[1]: Finished systemd-update-done.service - Update is Completed. Jun 21 04:43:20.952015 systemd[1]: Reached target sysinit.target - System Initialization. Jun 21 04:43:20.956461 systemd[1]: Started motdgen.path - Watch for update engine configuration changes. Jun 21 04:43:20.961312 systemd[1]: Started user-cloudinit@var-lib-flatcar\x2dinstall-user_data.path - Watch for a cloud-config at /var/lib/flatcar-install/user_data. Jun 21 04:43:20.966481 systemd[1]: Started google-oslogin-cache.timer - NSS cache refresh timer. Jun 21 04:43:20.971328 systemd[1]: Started logrotate.timer - Daily rotation of log files. Jun 21 04:43:20.975821 systemd[1]: Started mdadm.timer - Weekly check for MD array's redundancy information.. Jun 21 04:43:20.981097 systemd[1]: Started systemd-tmpfiles-clean.timer - Daily Cleanup of Temporary Directories. Jun 21 04:43:20.986372 systemd[1]: update-engine-stub.timer - Update Engine Stub Timer was skipped because of an unmet condition check (ConditionPathExists=/usr/.noupdate). Jun 21 04:43:20.986407 systemd[1]: Reached target paths.target - Path Units. Jun 21 04:43:20.990158 systemd[1]: Reached target timers.target - Timer Units. Jun 21 04:43:20.994749 systemd[1]: Listening on dbus.socket - D-Bus System Message Bus Socket. Jun 21 04:43:21.000310 systemd[1]: Starting docker.socket - Docker Socket for the API... Jun 21 04:43:21.006817 systemd[1]: Listening on sshd-unix-local.socket - OpenSSH Server Socket (systemd-ssh-generator, AF_UNIX Local). Jun 21 04:43:21.012485 systemd[1]: Listening on sshd-vsock.socket - OpenSSH Server Socket (systemd-ssh-generator, AF_VSOCK). Jun 21 04:43:21.018623 systemd[1]: Reached target ssh-access.target - SSH Access Available. Jun 21 04:43:21.024834 systemd[1]: Listening on sshd.socket - OpenSSH Server Socket. Jun 21 04:43:21.029206 systemd[1]: Listening on systemd-hostnamed.socket - Hostname Service Socket. Jun 21 04:43:21.034780 systemd[1]: Listening on docker.socket - Docker Socket for the API. Jun 21 04:43:21.040774 systemd[1]: Reached target sockets.target - Socket Units. Jun 21 04:43:21.045567 systemd[1]: Reached target basic.target - Basic System. Jun 21 04:43:21.049358 systemd[1]: addon-config@oem.service - Configure Addon /oem was skipped because no trigger condition checks were met. Jun 21 04:43:21.049396 systemd[1]: addon-run@oem.service - Run Addon /oem was skipped because no trigger condition checks were met. Jun 21 04:43:21.051775 systemd[1]: Starting chronyd.service - NTP client/server... Jun 21 04:43:21.056155 systemd[1]: Starting containerd.service - containerd container runtime... Jun 21 04:43:21.082305 systemd[1]: Starting coreos-metadata.service - Flatcar Metadata Agent... Jun 21 04:43:21.087469 systemd[1]: Starting dbus.service - D-Bus System Message Bus... Jun 21 04:43:21.092054 systemd[1]: Starting dracut-shutdown.service - Restore /run/initramfs on shutdown... Jun 21 04:43:21.098981 systemd[1]: Starting enable-oem-cloudinit.service - Enable cloudinit... Jun 21 04:43:21.104266 systemd[1]: Starting extend-filesystems.service - Extend Filesystems... Jun 21 04:43:21.105748 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). Jun 21 04:43:21.107853 systemd[1]: Starting google-oslogin-cache.service - NSS cache refresh... Jun 21 04:43:21.112182 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). Jun 21 04:43:21.112419 jq[1863]: false Jun 21 04:43:21.113200 systemd[1]: Started hv_kvp_daemon.service - Hyper-V KVP daemon. Jun 21 04:43:21.117790 systemd[1]: hv_vss_daemon.service - Hyper-V VSS daemon was skipped because of an unmet condition check (ConditionPathExists=/dev/vmbus/hv_vss). Jun 21 04:43:21.119078 systemd[1]: Starting motdgen.service - Generate /run/flatcar/motd... Jun 21 04:43:21.121534 KVP[1866]: KVP starting; pid is:1866 Jun 21 04:43:21.123779 KVP[1866]: KVP LIC Version: 3.1 Jun 21 04:43:21.124022 systemd[1]: Starting nvidia.service - NVIDIA Configure Service... Jun 21 04:43:21.125464 kernel: hv_utils: KVP IC version 4.0 Jun 21 04:43:21.131566 systemd[1]: Starting ssh-key-proc-cmdline.service - Install an ssh key from /proc/cmdline... Jun 21 04:43:21.137240 systemd[1]: Starting sshd-keygen.service - Generate sshd host keys... Jun 21 04:43:21.141303 systemd[1]: Starting systemd-logind.service - User Login Management... Jun 21 04:43:21.147213 systemd[1]: tcsd.service - TCG Core Services Daemon was skipped because of an unmet condition check (ConditionPathExists=/dev/tpm0). Jun 21 04:43:21.147653 systemd[1]: cgroup compatibility translation between legacy and unified hierarchy settings activated. See cgroup-compat debug messages for details. Jun 21 04:43:21.148152 (chronyd)[1855]: chronyd.service: Referenced but unset environment variable evaluates to an empty string: OPTIONS Jun 21 04:43:21.148245 systemd[1]: Starting update-engine.service - Update Engine... Jun 21 04:43:21.150792 systemd[1]: Starting update-ssh-keys-after-ignition.service - Run update-ssh-keys once after Ignition... Jun 21 04:43:21.152526 google_oslogin_nss_cache[1865]: oslogin_cache_refresh[1865]: Refreshing passwd entry cache Jun 21 04:43:21.152415 oslogin_cache_refresh[1865]: Refreshing passwd entry cache Jun 21 04:43:21.154184 chronyd[1881]: chronyd version 4.6.1 starting (+CMDMON +NTP +REFCLOCK +RTC +PRIVDROP +SCFILTER -SIGND +ASYNCDNS +NTS +SECHASH +IPV6 -DEBUG) Jun 21 04:43:21.158468 systemd[1]: Finished dracut-shutdown.service - Restore /run/initramfs on shutdown. Jun 21 04:43:21.163788 jq[1879]: true Jun 21 04:43:21.163709 oslogin_cache_refresh[1865]: Failure getting users, quitting Jun 21 04:43:21.164047 google_oslogin_nss_cache[1865]: oslogin_cache_refresh[1865]: Failure getting users, quitting Jun 21 04:43:21.164047 google_oslogin_nss_cache[1865]: oslogin_cache_refresh[1865]: Produced empty passwd cache file, removing /etc/oslogin_passwd.cache.bak. Jun 21 04:43:21.163854 systemd[1]: enable-oem-cloudinit.service: Skipped due to 'exec-condition'. Jun 21 04:43:21.163725 oslogin_cache_refresh[1865]: Produced empty passwd cache file, removing /etc/oslogin_passwd.cache.bak. Jun 21 04:43:21.164070 systemd[1]: Condition check resulted in enable-oem-cloudinit.service - Enable cloudinit being skipped. Jun 21 04:43:21.164371 systemd[1]: ssh-key-proc-cmdline.service: Deactivated successfully. Jun 21 04:43:21.164753 systemd[1]: Finished ssh-key-proc-cmdline.service - Install an ssh key from /proc/cmdline. Jun 21 04:43:21.175033 (ntainerd)[1886]: containerd.service: Referenced but unset environment variable evaluates to an empty string: TORCX_IMAGEDIR, TORCX_UNPACKDIR Jun 21 04:43:21.177927 jq[1885]: true Jun 21 04:43:21.182092 google_oslogin_nss_cache[1865]: oslogin_cache_refresh[1865]: Refreshing group entry cache Jun 21 04:43:21.181979 oslogin_cache_refresh[1865]: Refreshing group entry cache Jun 21 04:43:21.186773 systemd[1]: motdgen.service: Deactivated successfully. Jun 21 04:43:21.187092 systemd[1]: Finished motdgen.service - Generate /run/flatcar/motd. Jun 21 04:43:21.187493 oslogin_cache_refresh[1865]: Failure getting groups, quitting Jun 21 04:43:21.187618 google_oslogin_nss_cache[1865]: oslogin_cache_refresh[1865]: Failure getting groups, quitting Jun 21 04:43:21.187618 google_oslogin_nss_cache[1865]: oslogin_cache_refresh[1865]: Produced empty group cache file, removing /etc/oslogin_group.cache.bak. Jun 21 04:43:21.187505 oslogin_cache_refresh[1865]: Produced empty group cache file, removing /etc/oslogin_group.cache.bak. Jun 21 04:43:21.191702 systemd[1]: google-oslogin-cache.service: Deactivated successfully. Jun 21 04:43:21.191922 systemd[1]: Finished google-oslogin-cache.service - NSS cache refresh. Jun 21 04:43:21.194202 extend-filesystems[1864]: Found /dev/sda6 Jun 21 04:43:21.199549 extend-filesystems[1864]: Found /dev/sda9 Jun 21 04:43:21.199549 extend-filesystems[1864]: Checking size of /dev/sda9 Jun 21 04:43:21.215899 chronyd[1881]: Timezone right/UTC failed leap second check, ignoring Jun 21 04:43:21.216087 chronyd[1881]: Loaded seccomp filter (level 2) Jun 21 04:43:21.217392 systemd[1]: Started chronyd.service - NTP client/server. Jun 21 04:43:21.243474 extend-filesystems[1864]: Old size kept for /dev/sda9 Jun 21 04:43:21.245339 systemd[1]: extend-filesystems.service: Deactivated successfully. Jun 21 04:43:21.245622 systemd[1]: Finished extend-filesystems.service - Extend Filesystems. Jun 21 04:43:21.249231 update_engine[1878]: I20250621 04:43:21.249135 1878 main.cc:92] Flatcar Update Engine starting Jun 21 04:43:21.261268 dbus-daemon[1858]: [system] SELinux support is enabled Jun 21 04:43:21.261434 systemd[1]: Started dbus.service - D-Bus System Message Bus. Jun 21 04:43:21.263623 systemd-logind[1877]: New seat seat0. Jun 21 04:43:21.266181 systemd-logind[1877]: Watching system buttons on /dev/input/event0 (AT Translated Set 2 keyboard) Jun 21 04:43:21.267003 update_engine[1878]: I20250621 04:43:21.266955 1878 update_check_scheduler.cc:74] Next update check in 3m23s Jun 21 04:43:21.267872 systemd[1]: Started systemd-logind.service - User Login Management. Jun 21 04:43:21.272617 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). Jun 21 04:43:21.272655 systemd[1]: Reached target system-config.target - Load system-provided cloud configs. Jun 21 04:43:21.277556 dbus-daemon[1858]: [system] Successfully activated service 'org.freedesktop.systemd1' Jun 21 04:43:21.278022 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). Jun 21 04:43:21.278051 systemd[1]: Reached target user-config.target - Load user-provided cloud configs. Jun 21 04:43:21.283589 systemd[1]: Started update-engine.service - Update Engine. Jun 21 04:43:21.290035 systemd[1]: Started locksmithd.service - Cluster reboot manager. Jun 21 04:43:21.326312 bash[1921]: Updated "/home/core/.ssh/authorized_keys" Jun 21 04:43:21.332152 systemd[1]: Finished update-ssh-keys-after-ignition.service - Run update-ssh-keys once after Ignition. Jun 21 04:43:21.342275 coreos-metadata[1857]: Jun 21 04:43:21.342 INFO Fetching http://168.63.129.16/?comp=versions: Attempt #1 Jun 21 04:43:21.345222 coreos-metadata[1857]: Jun 21 04:43:21.344 INFO Fetch successful Jun 21 04:43:21.345222 coreos-metadata[1857]: Jun 21 04:43:21.344 INFO Fetching http://168.63.129.16/machine/?comp=goalstate: Attempt #1 Jun 21 04:43:21.348901 coreos-metadata[1857]: Jun 21 04:43:21.348 INFO Fetch successful Jun 21 04:43:21.349264 coreos-metadata[1857]: Jun 21 04:43:21.349 INFO Fetching http://168.63.129.16/machine/f5663ffe-f552-4ad1-9b35-a4881407f16e/5a76f8fc%2D651f%2D449a%2D99ee%2D46212b534f70.%5Fci%2D4372.0.0%2Da%2D09d8be67c2?comp=config&type=sharedConfig&incarnation=1: Attempt #1 Jun 21 04:43:21.355572 systemd[1]: sshkeys.service was skipped because no trigger condition checks were met. Jun 21 04:43:21.378393 coreos-metadata[1857]: Jun 21 04:43:21.378 INFO Fetch successful Jun 21 04:43:21.378393 coreos-metadata[1857]: Jun 21 04:43:21.378 INFO Fetching http://169.254.169.254/metadata/instance/compute/vmSize?api-version=2017-08-01&format=text: Attempt #1 Jun 21 04:43:21.378992 setup-nvidia[1868]: Downloading Flatcar Container Linux Developer Container for version: 4372.0.0 Jun 21 04:43:21.385954 coreos-metadata[1857]: Jun 21 04:43:21.385 INFO Fetch successful Jun 21 04:43:21.427390 systemd[1]: Finished coreos-metadata.service - Flatcar Metadata Agent. Jun 21 04:43:21.432259 systemd[1]: packet-phone-home.service - Report Success to Packet was skipped because no trigger condition checks were met. Jun 21 04:43:21.466649 locksmithd[1947]: locksmithd starting currentOperation="UPDATE_STATUS_IDLE" strategy="reboot" Jun 21 04:43:21.589236 sshd_keygen[1899]: ssh-keygen: generating new host keys: RSA ECDSA ED25519 Jun 21 04:43:21.610669 systemd[1]: Finished sshd-keygen.service - Generate sshd host keys. Jun 21 04:43:21.616737 systemd[1]: Starting issuegen.service - Generate /run/issue... Jun 21 04:43:21.643728 systemd[1]: Starting waagent.service - Microsoft Azure Linux Agent... Jun 21 04:43:21.649488 systemd[1]: issuegen.service: Deactivated successfully. Jun 21 04:43:21.649712 systemd[1]: Finished issuegen.service - Generate /run/issue. Jun 21 04:43:21.655379 systemd[1]: Starting systemd-user-sessions.service - Permit User Sessions... Jun 21 04:43:21.684951 systemd[1]: Finished systemd-user-sessions.service - Permit User Sessions. Jun 21 04:43:21.688140 systemd[1]: Started getty@tty1.service - Getty on tty1. Jun 21 04:43:21.693895 systemd[1]: Started serial-getty@ttyS0.service - Serial Getty on ttyS0. Jun 21 04:43:21.699106 systemd[1]: Reached target getty.target - Login Prompts. Jun 21 04:43:21.704271 systemd[1]: Started waagent.service - Microsoft Azure Linux Agent. Jun 21 04:43:21.981253 setup-nvidia[2040]: % Total % Received % Xferd Average Speed Time Time Time Current Jun 21 04:43:21.981638 setup-nvidia[2040]: Dload Upload Total Spent Left Speed Jun 21 04:43:22.225829 containerd[1886]: time="2025-06-21T04:43:22Z" 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 Jun 21 04:43:22.226890 containerd[1886]: time="2025-06-21T04:43:22.226851200Z" level=info msg="starting containerd" revision=06b99ca80cdbfbc6cc8bd567021738c9af2b36ce version=v2.0.4 Jun 21 04:43:22.236020 containerd[1886]: time="2025-06-21T04:43:22.235945100Z" level=warning msg="Configuration migrated from version 2, use `containerd config migrate` to avoid migration" t="8.5µs" Jun 21 04:43:22.236020 containerd[1886]: time="2025-06-21T04:43:22.235974500Z" level=info msg="loading plugin" id=io.containerd.image-verifier.v1.bindir type=io.containerd.image-verifier.v1 Jun 21 04:43:22.236020 containerd[1886]: time="2025-06-21T04:43:22.235992700Z" level=info msg="loading plugin" id=io.containerd.internal.v1.opt type=io.containerd.internal.v1 Jun 21 04:43:22.236158 containerd[1886]: time="2025-06-21T04:43:22.236135900Z" level=info msg="loading plugin" id=io.containerd.warning.v1.deprecations type=io.containerd.warning.v1 Jun 21 04:43:22.236207 containerd[1886]: time="2025-06-21T04:43:22.236158500Z" level=info msg="loading plugin" id=io.containerd.content.v1.content type=io.containerd.content.v1 Jun 21 04:43:22.236232 containerd[1886]: time="2025-06-21T04:43:22.236202500Z" level=info msg="loading plugin" id=io.containerd.snapshotter.v1.blockfile type=io.containerd.snapshotter.v1 Jun 21 04:43:22.236298 containerd[1886]: time="2025-06-21T04:43:22.236274900Z" level=info msg="skip loading plugin" error="no scratch file generator: skip plugin" id=io.containerd.snapshotter.v1.blockfile type=io.containerd.snapshotter.v1 Jun 21 04:43:22.236298 containerd[1886]: time="2025-06-21T04:43:22.236295600Z" level=info msg="loading plugin" id=io.containerd.snapshotter.v1.btrfs type=io.containerd.snapshotter.v1 Jun 21 04:43:22.236575 containerd[1886]: time="2025-06-21T04:43:22.236551100Z" 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 Jun 21 04:43:22.236575 containerd[1886]: time="2025-06-21T04:43:22.236572100Z" level=info msg="loading plugin" id=io.containerd.snapshotter.v1.devmapper type=io.containerd.snapshotter.v1 Jun 21 04:43:22.236636 containerd[1886]: time="2025-06-21T04:43:22.236584600Z" level=info msg="skip loading plugin" error="devmapper not configured: skip plugin" id=io.containerd.snapshotter.v1.devmapper type=io.containerd.snapshotter.v1 Jun 21 04:43:22.236636 containerd[1886]: time="2025-06-21T04:43:22.236593100Z" level=info msg="loading plugin" id=io.containerd.snapshotter.v1.native type=io.containerd.snapshotter.v1 Jun 21 04:43:22.236711 containerd[1886]: time="2025-06-21T04:43:22.236689400Z" level=info msg="loading plugin" id=io.containerd.snapshotter.v1.overlayfs type=io.containerd.snapshotter.v1 Jun 21 04:43:22.236999 containerd[1886]: time="2025-06-21T04:43:22.236975900Z" level=info msg="loading plugin" id=io.containerd.snapshotter.v1.zfs type=io.containerd.snapshotter.v1 Jun 21 04:43:22.237027 containerd[1886]: time="2025-06-21T04:43:22.237016400Z" 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 Jun 21 04:43:22.237051 containerd[1886]: time="2025-06-21T04:43:22.237028500Z" level=info msg="loading plugin" id=io.containerd.event.v1.exchange type=io.containerd.event.v1 Jun 21 04:43:22.237375 containerd[1886]: time="2025-06-21T04:43:22.237339400Z" level=info msg="loading plugin" id=io.containerd.monitor.task.v1.cgroups type=io.containerd.monitor.task.v1 Jun 21 04:43:22.238007 containerd[1886]: time="2025-06-21T04:43:22.237972800Z" level=info msg="loading plugin" id=io.containerd.metadata.v1.bolt type=io.containerd.metadata.v1 Jun 21 04:43:22.238062 containerd[1886]: time="2025-06-21T04:43:22.238050600Z" level=info msg="metadata content store policy set" policy=shared Jun 21 04:43:22.253458 containerd[1886]: time="2025-06-21T04:43:22.253419300Z" level=info msg="loading plugin" id=io.containerd.gc.v1.scheduler type=io.containerd.gc.v1 Jun 21 04:43:22.253517 containerd[1886]: time="2025-06-21T04:43:22.253477200Z" level=info msg="loading plugin" id=io.containerd.differ.v1.walking type=io.containerd.differ.v1 Jun 21 04:43:22.253517 containerd[1886]: time="2025-06-21T04:43:22.253493300Z" level=info msg="loading plugin" id=io.containerd.lease.v1.manager type=io.containerd.lease.v1 Jun 21 04:43:22.253517 containerd[1886]: time="2025-06-21T04:43:22.253505500Z" level=info msg="loading plugin" id=io.containerd.service.v1.containers-service type=io.containerd.service.v1 Jun 21 04:43:22.253589 containerd[1886]: time="2025-06-21T04:43:22.253517000Z" level=info msg="loading plugin" id=io.containerd.service.v1.content-service type=io.containerd.service.v1 Jun 21 04:43:22.253589 containerd[1886]: time="2025-06-21T04:43:22.253527200Z" level=info msg="loading plugin" id=io.containerd.service.v1.diff-service type=io.containerd.service.v1 Jun 21 04:43:22.253589 containerd[1886]: time="2025-06-21T04:43:22.253538600Z" level=info msg="loading plugin" id=io.containerd.service.v1.images-service type=io.containerd.service.v1 Jun 21 04:43:22.253589 containerd[1886]: time="2025-06-21T04:43:22.253550200Z" level=info msg="loading plugin" id=io.containerd.service.v1.introspection-service type=io.containerd.service.v1 Jun 21 04:43:22.253589 containerd[1886]: time="2025-06-21T04:43:22.253561100Z" level=info msg="loading plugin" id=io.containerd.service.v1.namespaces-service type=io.containerd.service.v1 Jun 21 04:43:22.253589 containerd[1886]: time="2025-06-21T04:43:22.253573100Z" level=info msg="loading plugin" id=io.containerd.service.v1.snapshots-service type=io.containerd.service.v1 Jun 21 04:43:22.253589 containerd[1886]: time="2025-06-21T04:43:22.253582000Z" level=info msg="loading plugin" id=io.containerd.shim.v1.manager type=io.containerd.shim.v1 Jun 21 04:43:22.253736 containerd[1886]: time="2025-06-21T04:43:22.253593700Z" level=info msg="loading plugin" id=io.containerd.runtime.v2.task type=io.containerd.runtime.v2 Jun 21 04:43:22.253736 containerd[1886]: time="2025-06-21T04:43:22.253700600Z" level=info msg="loading plugin" id=io.containerd.service.v1.tasks-service type=io.containerd.service.v1 Jun 21 04:43:22.253736 containerd[1886]: time="2025-06-21T04:43:22.253727100Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.containers type=io.containerd.grpc.v1 Jun 21 04:43:22.253802 containerd[1886]: time="2025-06-21T04:43:22.253741900Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.content type=io.containerd.grpc.v1 Jun 21 04:43:22.253802 containerd[1886]: time="2025-06-21T04:43:22.253753200Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.diff type=io.containerd.grpc.v1 Jun 21 04:43:22.253802 containerd[1886]: time="2025-06-21T04:43:22.253763800Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.events type=io.containerd.grpc.v1 Jun 21 04:43:22.253802 containerd[1886]: time="2025-06-21T04:43:22.253773800Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.images type=io.containerd.grpc.v1 Jun 21 04:43:22.253802 containerd[1886]: time="2025-06-21T04:43:22.253784900Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.introspection type=io.containerd.grpc.v1 Jun 21 04:43:22.253802 containerd[1886]: time="2025-06-21T04:43:22.253794700Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.leases type=io.containerd.grpc.v1 Jun 21 04:43:22.253935 containerd[1886]: time="2025-06-21T04:43:22.253823400Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.namespaces type=io.containerd.grpc.v1 Jun 21 04:43:22.253935 containerd[1886]: time="2025-06-21T04:43:22.253837500Z" level=info msg="loading plugin" id=io.containerd.sandbox.store.v1.local type=io.containerd.sandbox.store.v1 Jun 21 04:43:22.253935 containerd[1886]: time="2025-06-21T04:43:22.253848800Z" level=info msg="loading plugin" id=io.containerd.cri.v1.images type=io.containerd.cri.v1 Jun 21 04:43:22.253935 containerd[1886]: time="2025-06-21T04:43:22.253907800Z" level=info msg="Get image filesystem path \"/var/lib/containerd/io.containerd.snapshotter.v1.overlayfs\" for snapshotter \"overlayfs\"" Jun 21 04:43:22.253935 containerd[1886]: time="2025-06-21T04:43:22.253923700Z" level=info msg="Start snapshots syncer" Jun 21 04:43:22.254044 containerd[1886]: time="2025-06-21T04:43:22.253950100Z" level=info msg="loading plugin" id=io.containerd.cri.v1.runtime type=io.containerd.cri.v1 Jun 21 04:43:22.254213 containerd[1886]: time="2025-06-21T04:43:22.254164600Z" 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\"}" Jun 21 04:43:22.254337 containerd[1886]: time="2025-06-21T04:43:22.254228900Z" level=info msg="loading plugin" id=io.containerd.podsandbox.controller.v1.podsandbox type=io.containerd.podsandbox.controller.v1 Jun 21 04:43:22.254337 containerd[1886]: time="2025-06-21T04:43:22.254303900Z" level=info msg="loading plugin" id=io.containerd.sandbox.controller.v1.shim type=io.containerd.sandbox.controller.v1 Jun 21 04:43:22.254482 containerd[1886]: time="2025-06-21T04:43:22.254455100Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.sandbox-controllers type=io.containerd.grpc.v1 Jun 21 04:43:22.254512 containerd[1886]: time="2025-06-21T04:43:22.254499000Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.sandboxes type=io.containerd.grpc.v1 Jun 21 04:43:22.254536 containerd[1886]: time="2025-06-21T04:43:22.254513200Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.snapshots type=io.containerd.grpc.v1 Jun 21 04:43:22.254536 containerd[1886]: time="2025-06-21T04:43:22.254523400Z" level=info msg="loading plugin" id=io.containerd.streaming.v1.manager type=io.containerd.streaming.v1 Jun 21 04:43:22.254589 containerd[1886]: time="2025-06-21T04:43:22.254543800Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.streaming type=io.containerd.grpc.v1 Jun 21 04:43:22.254589 containerd[1886]: time="2025-06-21T04:43:22.254557500Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.tasks type=io.containerd.grpc.v1 Jun 21 04:43:22.254589 containerd[1886]: time="2025-06-21T04:43:22.254568500Z" level=info msg="loading plugin" id=io.containerd.transfer.v1.local type=io.containerd.transfer.v1 Jun 21 04:43:22.254656 containerd[1886]: time="2025-06-21T04:43:22.254589100Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.transfer type=io.containerd.grpc.v1 Jun 21 04:43:22.254656 containerd[1886]: time="2025-06-21T04:43:22.254614800Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.version type=io.containerd.grpc.v1 Jun 21 04:43:22.254656 containerd[1886]: time="2025-06-21T04:43:22.254627500Z" level=info msg="loading plugin" id=io.containerd.monitor.container.v1.restart type=io.containerd.monitor.container.v1 Jun 21 04:43:22.254725 containerd[1886]: time="2025-06-21T04:43:22.254654100Z" level=info msg="loading plugin" id=io.containerd.tracing.processor.v1.otlp type=io.containerd.tracing.processor.v1 Jun 21 04:43:22.254725 containerd[1886]: time="2025-06-21T04:43:22.254666900Z" 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 Jun 21 04:43:22.254725 containerd[1886]: time="2025-06-21T04:43:22.254675300Z" level=info msg="loading plugin" id=io.containerd.internal.v1.tracing type=io.containerd.internal.v1 Jun 21 04:43:22.254725 containerd[1886]: time="2025-06-21T04:43:22.254684800Z" level=info msg="skip loading plugin" error="skip plugin: tracing endpoint not configured" id=io.containerd.internal.v1.tracing type=io.containerd.internal.v1 Jun 21 04:43:22.254725 containerd[1886]: time="2025-06-21T04:43:22.254692000Z" level=info msg="loading plugin" id=io.containerd.ttrpc.v1.otelttrpc type=io.containerd.ttrpc.v1 Jun 21 04:43:22.254725 containerd[1886]: time="2025-06-21T04:43:22.254711200Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.healthcheck type=io.containerd.grpc.v1 Jun 21 04:43:22.254851 containerd[1886]: time="2025-06-21T04:43:22.254728700Z" level=info msg="loading plugin" id=io.containerd.nri.v1.nri type=io.containerd.nri.v1 Jun 21 04:43:22.254851 containerd[1886]: time="2025-06-21T04:43:22.254744200Z" level=info msg="runtime interface created" Jun 21 04:43:22.254851 containerd[1886]: time="2025-06-21T04:43:22.254750000Z" level=info msg="created NRI interface" Jun 21 04:43:22.254851 containerd[1886]: time="2025-06-21T04:43:22.254771000Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.cri type=io.containerd.grpc.v1 Jun 21 04:43:22.254851 containerd[1886]: time="2025-06-21T04:43:22.254784100Z" level=info msg="Connect containerd service" Jun 21 04:43:22.254851 containerd[1886]: time="2025-06-21T04:43:22.254808000Z" level=info msg="using experimental NRI integration - disable nri plugin to prevent this" Jun 21 04:43:22.255543 containerd[1886]: time="2025-06-21T04:43:22.255514600Z" 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" Jun 21 04:43:23.237386 containerd[1886]: time="2025-06-21T04:43:23.237331500Z" level=info msg="Start subscribing containerd event" Jun 21 04:43:23.237761 containerd[1886]: time="2025-06-21T04:43:23.237448200Z" level=info msg="Start recovering state" Jun 21 04:43:23.237761 containerd[1886]: time="2025-06-21T04:43:23.237552500Z" level=info msg="Start event monitor" Jun 21 04:43:23.237761 containerd[1886]: time="2025-06-21T04:43:23.237566500Z" level=info msg=serving... address=/run/containerd/containerd.sock.ttrpc Jun 21 04:43:23.237761 containerd[1886]: time="2025-06-21T04:43:23.237575300Z" level=info msg="Start cni network conf syncer for default" Jun 21 04:43:23.237761 containerd[1886]: time="2025-06-21T04:43:23.237602000Z" level=info msg="Start streaming server" Jun 21 04:43:23.237761 containerd[1886]: time="2025-06-21T04:43:23.237626400Z" level=info msg="Registered namespace \"k8s.io\" with NRI" Jun 21 04:43:23.237761 containerd[1886]: time="2025-06-21T04:43:23.237637500Z" level=info msg="runtime interface starting up..." Jun 21 04:43:23.237761 containerd[1886]: time="2025-06-21T04:43:23.237642400Z" level=info msg=serving... address=/run/containerd/containerd.sock Jun 21 04:43:23.237761 containerd[1886]: time="2025-06-21T04:43:23.237643700Z" level=info msg="starting plugins..." Jun 21 04:43:23.237761 containerd[1886]: time="2025-06-21T04:43:23.237724300Z" level=info msg="Synchronizing NRI (plugin) with current runtime state" Jun 21 04:43:23.238004 containerd[1886]: time="2025-06-21T04:43:23.237880200Z" level=info msg="containerd successfully booted in 1.012387s" Jun 21 04:43:23.237976 systemd[1]: Started containerd.service - containerd container runtime. Jun 21 04:43:23.703414 waagent[2033]: 2025-06-21T04:43:23.703329Z INFO Daemon Daemon Azure Linux Agent Version: 2.12.0.4 Jun 21 04:43:23.707939 waagent[2033]: 2025-06-21T04:43:23.707893Z INFO Daemon Daemon OS: flatcar 4372.0.0 Jun 21 04:43:23.711627 waagent[2033]: 2025-06-21T04:43:23.711586Z INFO Daemon Daemon Python: 3.11.12 Jun 21 04:43:23.715246 waagent[2033]: 2025-06-21T04:43:23.715199Z INFO Daemon Daemon Run daemon Jun 21 04:43:23.718531 waagent[2033]: 2025-06-21T04:43:23.718490Z INFO Daemon Daemon No RDMA handler exists for distro='Flatcar Container Linux by Kinvolk' version='4372.0.0' Jun 21 04:43:23.725242 waagent[2033]: 2025-06-21T04:43:23.725200Z INFO Daemon Daemon Using waagent for provisioning Jun 21 04:43:23.729473 waagent[2033]: 2025-06-21T04:43:23.729418Z INFO Daemon Daemon Activate resource disk Jun 21 04:43:23.733216 waagent[2033]: 2025-06-21T04:43:23.733175Z INFO Daemon Daemon Searching gen1 prefix 00000000-0001 or gen2 f8b3781a-1e82-4818-a1c3-63d806ec15bb Jun 21 04:43:23.740691 waagent[2033]: 2025-06-21T04:43:23.740644Z INFO Daemon Daemon Found device: sdb Jun 21 04:43:23.749760 waagent[2033]: 2025-06-21T04:43:23.749713Z INFO Daemon Daemon Examining partition table Jun 21 04:43:23.818912 waagent[2033]: 2025-06-21T04:43:23.818806Z INFO Daemon Daemon GPT not detected, determining filesystem Jun 21 04:43:23.853018 waagent[2033]: 2025-06-21T04:43:23.852951Z INFO Daemon Daemon sfdisk --part-type -f /dev/sdb 1 -n succeeded Jun 21 04:43:23.857766 waagent[2033]: 2025-06-21T04:43:23.857715Z INFO Daemon Daemon The partition is formatted with ntfs, updating partition type to 83 Jun 21 04:43:24.351913 kernel: hv_storvsc f8b3781a-1e82-4818-a1c3-63d806ec15bb: tag#87 cmd 0x5a status: scsi 0x2 srb 0x86 hv 0xc0000001 Jun 21 04:43:24.364630 kernel: sdb: sdb1 Jun 21 04:43:24.374092 kernel: hv_storvsc f8b3781a-1e82-4818-a1c3-63d806ec15bb: tag#433 cmd 0x5a status: scsi 0x2 srb 0x86 hv 0xc0000001 Jun 21 04:43:24.381911 waagent[2033]: 2025-06-21T04:43:24.381840Z INFO Daemon Daemon sfdisk --part-type /dev/sdb 1 83 succeeded Jun 21 04:43:24.395453 kernel: sdb: sdb1 Jun 21 04:43:24.401458 kernel: hv_storvsc f8b3781a-1e82-4818-a1c3-63d806ec15bb: tag#6 cmd 0x5a status: scsi 0x2 srb 0x86 hv 0xc0000001 Jun 21 04:43:24.411452 kernel: sdb: sdb1 Jun 21 04:43:24.411511 waagent[2033]: 2025-06-21T04:43:24.411394Z INFO Daemon Daemon Format partition [mkfs.ext4 -F /dev/sdb1] Jun 21 04:43:29.473080 login[2030]: pam_unix(login:session): session opened for user core(uid=500) by LOGIN(uid=0) Jun 21 04:43:29.474472 login[2031]: pam_unix(login:session): session opened for user core(uid=500) by LOGIN(uid=0) Jun 21 04:43:29.480205 systemd[1]: Created slice user-500.slice - User Slice of UID 500. Jun 21 04:43:29.481347 systemd[1]: Starting user-runtime-dir@500.service - User Runtime Directory /run/user/500... Jun 21 04:43:29.488186 systemd-logind[1877]: New session 2 of user core. Jun 21 04:43:29.491725 systemd-logind[1877]: New session 1 of user core. Jun 21 04:43:29.535050 systemd[1]: Finished user-runtime-dir@500.service - User Runtime Directory /run/user/500. Jun 21 04:43:29.537613 systemd[1]: Starting user@500.service - User Manager for UID 500... Jun 21 04:43:29.574120 (systemd)[2131]: pam_unix(systemd-user:session): session opened for user core(uid=500) by (uid=0) Jun 21 04:43:29.576386 systemd-logind[1877]: New session c1 of user core. Jun 21 04:43:30.238884 waagent[2033]: 2025-06-21T04:43:30.238796Z INFO Daemon Daemon Mount resource disk [mount -t ext4 /dev/sdb1 /mnt/resource] Jun 21 04:43:30.294392 systemd[2131]: Queued start job for default target default.target. Jun 21 04:43:30.315535 systemd[2131]: Created slice app.slice - User Application Slice. Jun 21 04:43:30.315582 systemd[2131]: Reached target paths.target - Paths. Jun 21 04:43:30.315633 systemd[2131]: Reached target timers.target - Timers. Jun 21 04:43:30.316998 systemd[2131]: Starting dbus.socket - D-Bus User Message Bus Socket... Jun 21 04:43:30.327762 systemd[2131]: Listening on dbus.socket - D-Bus User Message Bus Socket. Jun 21 04:43:30.327884 systemd[2131]: Reached target sockets.target - Sockets. Jun 21 04:43:30.327928 systemd[2131]: Reached target basic.target - Basic System. Jun 21 04:43:30.327971 systemd[2131]: Reached target default.target - Main User Target. Jun 21 04:43:30.328002 systemd[2131]: Startup finished in 745ms. Jun 21 04:43:30.328222 systemd[1]: Started user@500.service - User Manager for UID 500. Jun 21 04:43:30.330070 systemd[1]: Started session-1.scope - Session 1 of User core. Jun 21 04:43:30.331000 systemd[1]: Started session-2.scope - Session 2 of User core. Jun 21 04:43:30.362462 kernel: EXT4-fs (sdb1): mounted filesystem ff9f30f9-d5cf-4557-b7ff-e531f663b509 r/w with ordered data mode. Quota mode: none. Jun 21 04:43:30.362714 waagent[2033]: 2025-06-21T04:43:30.362651Z INFO Daemon Daemon Resource disk /dev/sdb is mounted at /mnt/resource with ext4 Jun 21 04:43:30.364822 waagent[2033]: 2025-06-21T04:43:30.364754Z INFO Daemon Daemon Clean protocol and wireserver endpoint Jun 21 04:43:30.365033 waagent[2033]: 2025-06-21T04:43:30.364997Z INFO Daemon Daemon Running default provisioning handler Jun 21 04:43:30.373156 waagent[2033]: 2025-06-21T04:43:30.373109Z 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. Jun 21 04:43:30.375092 waagent[2033]: 2025-06-21T04:43:30.375048Z INFO Daemon Daemon Unable to get cloud-init enabled status from service: [Errno 2] No such file or directory: 'service' Jun 21 04:43:30.377093 waagent[2033]: 2025-06-21T04:43:30.377048Z INFO Daemon Daemon cloud-init is enabled: False Jun 21 04:43:30.377877 waagent[2033]: 2025-06-21T04:43:30.377842Z INFO Daemon Daemon Copying ovf-env.xml Jun 21 04:43:30.447020 waagent[2033]: 2025-06-21T04:43:30.446958Z INFO Daemon Daemon Successfully mounted dvd Jun 21 04:43:30.469745 systemd[1]: mnt-cdrom-secure.mount: Deactivated successfully. Jun 21 04:43:30.469896 waagent[2033]: 2025-06-21T04:43:30.469736Z INFO Daemon Daemon Detect protocol endpoint Jun 21 04:43:30.471421 waagent[2033]: 2025-06-21T04:43:30.471378Z INFO Daemon Daemon Clean protocol and wireserver endpoint Jun 21 04:43:30.472173 waagent[2033]: 2025-06-21T04:43:30.472133Z INFO Daemon Daemon WireServer endpoint is not found. Rerun dhcp handler Jun 21 04:43:30.473569 waagent[2033]: 2025-06-21T04:43:30.473537Z INFO Daemon Daemon Test for route to 168.63.129.16 Jun 21 04:43:30.474421 waagent[2033]: 2025-06-21T04:43:30.474379Z INFO Daemon Daemon Route to 168.63.129.16 exists Jun 21 04:43:30.475026 waagent[2033]: 2025-06-21T04:43:30.474993Z INFO Daemon Daemon Wire server endpoint:168.63.129.16 Jun 21 04:43:30.486745 waagent[2033]: 2025-06-21T04:43:30.486690Z INFO Daemon Daemon Fabric preferred wire protocol version:2015-04-05 Jun 21 04:43:30.487199 waagent[2033]: 2025-06-21T04:43:30.487172Z INFO Daemon Daemon Wire protocol version:2012-11-30 Jun 21 04:43:30.488515 waagent[2033]: 2025-06-21T04:43:30.488482Z INFO Daemon Daemon Server preferred version:2015-04-05 Jun 21 04:43:30.622194 waagent[2033]: 2025-06-21T04:43:30.622101Z INFO Daemon Daemon Initializing goal state during protocol detection Jun 21 04:43:30.623818 waagent[2033]: 2025-06-21T04:43:30.623771Z INFO Daemon Daemon Forcing an update of the goal state. Jun 21 04:43:30.628516 waagent[2033]: 2025-06-21T04:43:30.628473Z INFO Daemon Fetched a new incarnation for the WireServer goal state [incarnation 1] Jun 21 04:43:30.671127 waagent[2033]: 2025-06-21T04:43:30.671075Z INFO Daemon Daemon HostGAPlugin version: 1.0.8.175 Jun 21 04:43:30.673719 waagent[2033]: 2025-06-21T04:43:30.673631Z INFO Daemon Jun 21 04:43:30.676538 waagent[2033]: 2025-06-21T04:43:30.676498Z INFO Daemon Fetched new vmSettings [HostGAPlugin correlation ID: aab7967c-10ba-43fa-8359-85069837bb1d eTag: 10448755558732628487 source: Fabric] Jun 21 04:43:30.679089 waagent[2033]: 2025-06-21T04:43:30.679000Z INFO Daemon The vmSettings originated via Fabric; will ignore them. Jun 21 04:43:30.681319 waagent[2033]: 2025-06-21T04:43:30.681232Z INFO Daemon Jun 21 04:43:30.683078 waagent[2033]: 2025-06-21T04:43:30.683031Z INFO Daemon Fetching full goal state from the WireServer [incarnation 1] Jun 21 04:43:30.690263 waagent[2033]: 2025-06-21T04:43:30.690193Z INFO Daemon Daemon Downloading artifacts profile blob Jun 21 04:43:30.818560 waagent[2033]: 2025-06-21T04:43:30.818499Z INFO Daemon Downloaded certificate {'thumbprint': 'F253CAC37E7ABFD2972652B6BDAA990CBE0503C1', 'hasPrivateKey': True} Jun 21 04:43:30.820585 waagent[2033]: 2025-06-21T04:43:30.820543Z INFO Daemon Fetch goal state completed Jun 21 04:43:30.857265 waagent[2033]: 2025-06-21T04:43:30.857222Z INFO Daemon Daemon Starting provisioning Jun 21 04:43:30.860006 waagent[2033]: 2025-06-21T04:43:30.859963Z INFO Daemon Daemon Handle ovf-env.xml. Jun 21 04:43:30.862609 waagent[2033]: 2025-06-21T04:43:30.862561Z INFO Daemon Daemon Set hostname [ci-4372.0.0-a-09d8be67c2] Jun 21 04:43:30.940451 waagent[2033]: 2025-06-21T04:43:30.940381Z INFO Daemon Daemon Publish hostname [ci-4372.0.0-a-09d8be67c2] Jun 21 04:43:30.942290 waagent[2033]: 2025-06-21T04:43:30.942226Z INFO Daemon Daemon Examine /proc/net/route for primary interface Jun 21 04:43:30.943718 waagent[2033]: 2025-06-21T04:43:30.943643Z INFO Daemon Daemon Primary interface is [eth0] Jun 21 04:43:30.960942 systemd-networkd[1800]: eth0: found matching network '/usr/lib/systemd/network/zz-default.network', based on potentially unpredictable interface name. Jun 21 04:43:30.960953 systemd-networkd[1800]: eth0: Configuring with /usr/lib/systemd/network/zz-default.network. Jun 21 04:43:30.960983 systemd-networkd[1800]: eth0: DHCP lease lost Jun 21 04:43:30.961527 waagent[2033]: 2025-06-21T04:43:30.961479Z INFO Daemon Daemon Create user account if not exists Jun 21 04:43:30.963209 waagent[2033]: 2025-06-21T04:43:30.963164Z INFO Daemon Daemon User core already exists, skip useradd Jun 21 04:43:30.964573 waagent[2033]: 2025-06-21T04:43:30.964534Z INFO Daemon Daemon Configure sudoer Jun 21 04:43:30.968981 waagent[2033]: 2025-06-21T04:43:30.968943Z INFO Daemon Daemon Configure sshd Jun 21 04:43:30.973922 waagent[2033]: 2025-06-21T04:43:30.973873Z INFO Daemon Daemon Added a configuration snippet disabling SSH password-based authentication methods. It also configures SSH client probing to keep connections alive. Jun 21 04:43:30.974280 waagent[2033]: 2025-06-21T04:43:30.974249Z INFO Daemon Daemon Deploy ssh public key. Jun 21 04:43:31.034486 systemd-networkd[1800]: eth0: DHCPv4 address 10.200.8.27/24, gateway 10.200.8.1 acquired from 168.63.129.16 Jun 21 04:43:44.995911 chronyd[1881]: Selected source PHC0 Jun 21 04:43:47.361512 setup-nvidia[2040]: \u000d 0 0 0 0 0 0 0 0 --:--:-- --:--:-- --:--:-- 0\u000d 0 0 0 0 0 0 0 0 --:--:-- --:--:-- --:--:-- 0\u000d 0 488M 0 1407k 0 0 1107k 0 0:07:31 0:00:01 0:07:30 1106k\u000d 4 488M 4 23.8M 0 0 9.9M 0 0:00:48 0:00:02 0:00:46 9.9M\u000d 9 488M 9 47.9M 0 0 14.1M 0 0:00:34 0:00:03 0:00:31 14.1M\u000d 14 488M 14 72.2M 0 0 16.4M 0 0:00:29 0:00:04 0:00:25 16.4M\u000d 19 488M 19 97.0M 0 0 18.0M 0 0:00:27 0:00:05 0:00:22 19.1M\u000d 24 488M 24 119M 0 0 18.8M 0 0:00:25 0:00:06 0:00:19 23.2M\u000d 29 488M 29 143M 0 0 19.4M 0 0:00:25 0:00:07 0:00:18 24.0M\u000d 34 488M 34 166M 0 0 19.9M 0 0:00:24 0:00:08 0:00:16 23.8M\u000d 37 488M 37 181M 0 0 19.3M 0 0:00:25 0:00:09 0:00:16 21.8M\u000d 37 488M 37 181M 0 0 17.5M 0 0:00:27 0:00:10 0:00:17 17.0M\u000d 37 488M 37 181M 0 0 16.1M 0 0:00:30 0:00:11 0:00:19 12.5M\u000d 37 488M 37 184M 0 0 14.9M 0 0:00:32 0:00:12 0:00:20 8478k\u000d 42 488M 42 208M 0 0 15.5M 0 0:00:31 0:00:13 0:00:18 8557k\u000d 47 488M 47 230M 0 0 16.0M 0 0:00:30 0:00:14 0:00:16 9.7M\u000d 51 488M 51 251M 0 0 16.3M 0 0:00:29 0:00:15 0:00:14 13.9M\u000d 56 488M 56 276M 0 0 16.9M 0 0:00:28 0:00:16 0:00:12 18.7M\u000d 61 488M 61 299M 0 0 17.2M 0 0:00:28 0:00:17 0:00:11 23.1M\u000d 65 488M 65 321M 0 0 17.5M 0 0:00:27 0:00:18 0:00:09 22.9M\u000d 70 488M 70 344M 0 0 17.8M 0 0:00:27 0:00:19 0:00:08 23.0M\u000d 74 488M 74 365M 0 0 18.0M 0 0:00:27 0:00:20 0:00:07 23.0M\u000d 79 488M 79 389M 0 0 18.2M 0 0:00:26 0:00:21 0:00:05 22.8M\u000d 84 488M 84 413M 0 0 18.5M 0 0:00:26 0:00:22 0:00:04 23.1M\u000d 89 488M 89 437M 0 0 18.7M 0 0:00:26 0:00:23 0:00:03 22.8M\u000d 94 488M 94 463M 0 0 18.9M 0 0:00:25 0:00:24 0:00:01 23.4M\u000d 99 488M 99 485M 0 0 19.1M 0 0:00:25 0:00:25 --:--:-- 23.7M\u000d100 488M 100 488M 0 0 19.2M 0 0:00:25 0:00:25 --:--:-- 24.1M Jun 21 04:43:58.082774 setup-nvidia[1868]: Downloading NVIDIA 535.230.02 Driver Jun 21 04:43:58.087168 setup-nvidia[2207]: % Total % Received % Xferd Average Speed Time Time Time Current Jun 21 04:43:58.087402 setup-nvidia[2207]: Dload Upload Total Spent Left Speed Jun 21 04:43:59.307962 setup-nvidia[2207]: \u000d 0 0 0 0 0 0 0 0 --:--:-- --:--:-- --:--:-- 0\u000d 4 326M 4 15.7M 0 0 96.6M 0 0:00:03 --:--:-- 0:00:03 96.3M\u000d 95 326M 95 310M 0 0 266M 0 0:00:01 0:00:01 --:--:-- 266M\u000d100 326M 100 326M 0 0 267M 0 0:00:01 0:00:01 --:--:-- 267M Jun 21 04:43:59.341125 setup-nvidia[1868]: Extract the NVIDIA Driver Installer 535.230.02 Jun 21 04:43:59.341386 setup-nvidia[1868]: /opt/nvidia/workdir/nvidia-workdir / Jun 21 04:43:59.358658 setup-nvidia[2210]: Creating directory NVIDIA-Linux-x86_64-535.230.02 Jun 21 04:43:59.632659 setup-nvidia[2210]: Verifying archive integrity... OK Jun 21 04:44:00.306895 setup-nvidia[2210]: Uncompressing NVIDIA Accelerated Graphics Driver for Linux-x86_64 535.230.02 Jun 21 04:44:01.069802 waagent[2033]: 2025-06-21T04:44:01.069126Z INFO Daemon Daemon Provisioning complete Jun 21 04:44:01.081402 waagent[2033]: 2025-06-21T04:44:01.081352Z INFO Daemon Daemon RDMA capabilities are not enabled, skipping Jun 21 04:44:01.082376 waagent[2033]: 2025-06-21T04:44:01.082335Z INFO Daemon Daemon End of log to /dev/console. The agent will now check for updates and then will process extensions. Jun 21 04:44:01.084143 waagent[2033]: 2025-06-21T04:44:01.084100Z INFO Daemon Daemon Installed Agent WALinuxAgent-2.12.0.4 is the most current agent Jun 21 04:44:01.229878 waagent[2240]: 2025-06-21T04:44:01.229725Z INFO ExtHandler ExtHandler Azure Linux Agent (Goal State Agent version 2.12.0.4) Jun 21 04:44:01.230200 waagent[2240]: 2025-06-21T04:44:01.229878Z INFO ExtHandler ExtHandler OS: flatcar 4372.0.0 Jun 21 04:44:01.230200 waagent[2240]: 2025-06-21T04:44:01.229949Z INFO ExtHandler ExtHandler Python: 3.11.12 Jun 21 04:44:01.230200 waagent[2240]: 2025-06-21T04:44:01.230018Z INFO ExtHandler ExtHandler CPU Arch: x86_64 Jun 21 04:44:01.311245 waagent[2240]: 2025-06-21T04:44:01.311164Z INFO ExtHandler ExtHandler Distro: flatcar-4372.0.0; OSUtil: FlatcarUtil; AgentService: waagent; Python: 3.11.12; Arch: x86_64; systemd: True; LISDrivers: Absent; logrotate: logrotate 3.22.0; Jun 21 04:44:01.311667 waagent[2240]: 2025-06-21T04:44:01.311621Z INFO ExtHandler ExtHandler WireServer endpoint 168.63.129.16 read from file Jun 21 04:44:01.311743 waagent[2240]: 2025-06-21T04:44:01.311714Z INFO ExtHandler ExtHandler Wire server endpoint:168.63.129.16 Jun 21 04:44:01.318544 waagent[2240]: 2025-06-21T04:44:01.318491Z INFO ExtHandler Fetched a new incarnation for the WireServer goal state [incarnation 1] Jun 21 04:44:01.331504 waagent[2240]: 2025-06-21T04:44:01.329282Z INFO ExtHandler ExtHandler HostGAPlugin version: 1.0.8.175 Jun 21 04:44:01.331504 waagent[2240]: 2025-06-21T04:44:01.329861Z INFO ExtHandler Jun 21 04:44:01.331504 waagent[2240]: 2025-06-21T04:44:01.329942Z INFO ExtHandler Fetched new vmSettings [HostGAPlugin correlation ID: a652ebec-b512-4116-ac24-0b26156f850f eTag: 10448755558732628487 source: Fabric] Jun 21 04:44:01.331504 waagent[2240]: 2025-06-21T04:44:01.330240Z INFO ExtHandler The vmSettings originated via Fabric; will ignore them. Jun 21 04:44:01.331504 waagent[2240]: 2025-06-21T04:44:01.330849Z INFO ExtHandler Jun 21 04:44:01.331504 waagent[2240]: 2025-06-21T04:44:01.330920Z INFO ExtHandler Fetching full goal state from the WireServer [incarnation 1] Jun 21 04:44:01.335467 waagent[2240]: 2025-06-21T04:44:01.335426Z INFO ExtHandler ExtHandler Downloading artifacts profile blob Jun 21 04:44:01.414081 waagent[2240]: 2025-06-21T04:44:01.414007Z INFO ExtHandler Downloaded certificate {'thumbprint': 'F253CAC37E7ABFD2972652B6BDAA990CBE0503C1', 'hasPrivateKey': True} Jun 21 04:44:01.414690 waagent[2240]: 2025-06-21T04:44:01.414649Z INFO ExtHandler Fetch goal state completed Jun 21 04:44:01.427083 waagent[2240]: 2025-06-21T04:44:01.427029Z INFO ExtHandler ExtHandler OpenSSL version: OpenSSL 3.3.3 11 Feb 2025 (Library: OpenSSL 3.3.3 11 Feb 2025) Jun 21 04:44:01.432259 waagent[2240]: 2025-06-21T04:44:01.432216Z INFO ExtHandler ExtHandler WALinuxAgent-2.12.0.4 running as process 2240 Jun 21 04:44:01.432398 waagent[2240]: 2025-06-21T04:44:01.432364Z INFO ExtHandler ExtHandler ******** AutoUpdate.Enabled is set to False, not processing the operation ******** Jun 21 04:44:01.432749 waagent[2240]: 2025-06-21T04:44:01.432713Z INFO ExtHandler ExtHandler ******** AutoUpdate.UpdateToLatestVersion is set to False, not processing the operation ******** Jun 21 04:44:01.434315 waagent[2240]: 2025-06-21T04:44:01.434275Z INFO ExtHandler ExtHandler [CGI] Cgroup monitoring is not supported on ['flatcar', '4372.0.0', '', 'Flatcar Container Linux by Kinvolk'] Jun 21 04:44:01.434802 waagent[2240]: 2025-06-21T04:44:01.434760Z INFO ExtHandler ExtHandler [CGI] Agent will reset the quotas in case distro: ['flatcar', '4372.0.0', '', 'Flatcar Container Linux by Kinvolk'] went from supported to unsupported Jun 21 04:44:01.434953 waagent[2240]: 2025-06-21T04:44:01.434918Z INFO ExtHandler ExtHandler [CGI] Agent cgroups enabled: False Jun 21 04:44:01.436107 waagent[2240]: 2025-06-21T04:44:01.435793Z INFO ExtHandler ExtHandler Starting setup for Persistent firewall rules Jun 21 04:44:01.549523 waagent[2240]: 2025-06-21T04:44:01.549473Z INFO ExtHandler ExtHandler Firewalld service not running/unavailable, trying to set up waagent-network-setup.service Jun 21 04:44:01.549734 waagent[2240]: 2025-06-21T04:44:01.549697Z INFO ExtHandler ExtHandler Successfully updated the Binary file /var/lib/waagent/waagent-network-setup.py for firewall setup Jun 21 04:44:01.556194 waagent[2240]: 2025-06-21T04:44:01.556153Z INFO ExtHandler ExtHandler Service: waagent-network-setup.service not enabled. Adding it now Jun 21 04:44:01.563165 systemd[1]: Reload requested from client PID 2255 ('systemctl') (unit waagent.service)... Jun 21 04:44:01.563184 systemd[1]: Reloading... Jun 21 04:44:01.642459 zram_generator::config[2300]: No configuration found. Jun 21 04:44:01.750197 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. Jun 21 04:44:01.913170 systemd[1]: Reloading finished in 349 ms. Jun 21 04:44:01.927135 waagent[2240]: 2025-06-21T04:44:01.927064Z INFO ExtHandler ExtHandler Successfully added and enabled the waagent-network-setup.service Jun 21 04:44:01.927235 waagent[2240]: 2025-06-21T04:44:01.927212Z INFO ExtHandler ExtHandler Persistent firewall rules setup successfully Jun 21 04:44:02.282860 setup-nvidia[2236]: ........................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................ Jun 21 04:44:02.336057 setup-nvidia[1868]: / Jun 21 04:44:02.336280 setup-nvidia[1868]: Spawn system-nspawn container to install the NVIDIA drivers Jun 21 04:44:02.352463 kernel: hv_balloon: Max. dynamic memory size: 114688 MB Jun 21 04:44:02.556879 sudo[2361]: root : PWD=/ ; USER=root ; COMMAND=/usr/sbin/systemd-nspawn --keep-unit --register=no --read-only --volatile=overlay --image=/opt/nvidia/workdir/flatcar_developer_container-4372.0.0.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.230.02 Jun 21 04:44:02.558695 sudo[2361]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=0) Jun 21 04:44:02.566948 systemd[1]: Created slice user-0.slice - User Slice of UID 0. Jun 21 04:44:02.573332 systemd[1]: Starting user-runtime-dir@0.service - User Runtime Directory /run/user/0... Jun 21 04:44:02.587021 waagent[2240]: 2025-06-21T04:44:02.586954Z INFO ExtHandler ExtHandler DROP rule is not available which implies no firewall rules are set yet. Environment thread will set it up. Jun 21 04:44:02.587299 waagent[2240]: 2025-06-21T04:44:02.587262Z 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] Jun 21 04:44:02.588029 waagent[2240]: 2025-06-21T04:44:02.587983Z INFO ExtHandler ExtHandler Starting env monitor service. Jun 21 04:44:02.588367 waagent[2240]: 2025-06-21T04:44:02.588323Z INFO MonitorHandler ExtHandler WireServer endpoint 168.63.129.16 read from file Jun 21 04:44:02.588556 waagent[2240]: 2025-06-21T04:44:02.588515Z INFO ExtHandler ExtHandler Start SendTelemetryHandler service. Jun 21 04:44:02.588967 waagent[2240]: 2025-06-21T04:44:02.588930Z INFO MonitorHandler ExtHandler Wire server endpoint:168.63.129.16 Jun 21 04:44:02.589095 waagent[2240]: 2025-06-21T04:44:02.589042Z INFO SendTelemetryHandler ExtHandler Successfully started the SendTelemetryHandler thread Jun 21 04:44:02.589162 waagent[2240]: 2025-06-21T04:44:02.589115Z INFO ExtHandler ExtHandler Start Extension Telemetry service. Jun 21 04:44:02.589397 waagent[2240]: 2025-06-21T04:44:02.589356Z INFO EnvHandler ExtHandler WireServer endpoint 168.63.129.16 read from file Jun 21 04:44:02.589992 waagent[2240]: 2025-06-21T04:44:02.589936Z INFO TelemetryEventsCollector ExtHandler Extension Telemetry pipeline enabled: True Jun 21 04:44:02.590149 waagent[2240]: 2025-06-21T04:44:02.589993Z INFO EnvHandler ExtHandler Wire server endpoint:168.63.129.16 Jun 21 04:44:02.590423 waagent[2240]: 2025-06-21T04:44:02.590368Z INFO MonitorHandler ExtHandler Monitor.NetworkConfigurationChanges is disabled. Jun 21 04:44:02.590652 waagent[2240]: 2025-06-21T04:44:02.590603Z INFO ExtHandler ExtHandler Goal State Period: 6 sec. This indicates how often the agent checks for new goal states and reports status. Jun 21 04:44:02.590979 waagent[2240]: 2025-06-21T04:44:02.590924Z INFO EnvHandler ExtHandler Configure routes Jun 21 04:44:02.591170 waagent[2240]: 2025-06-21T04:44:02.591134Z INFO TelemetryEventsCollector ExtHandler Successfully started the TelemetryEventsCollector thread Jun 21 04:44:02.591615 waagent[2240]: 2025-06-21T04:44:02.591571Z INFO MonitorHandler ExtHandler Routing table from /proc/net/route: Jun 21 04:44:02.591615 waagent[2240]: Iface Destination Gateway Flags RefCnt Use Metric Mask MTU Window IRTT Jun 21 04:44:02.591615 waagent[2240]: eth0 00000000 0108C80A 0003 0 0 1024 00000000 0 0 0 Jun 21 04:44:02.591615 waagent[2240]: eth0 0008C80A 00000000 0001 0 0 1024 00FFFFFF 0 0 0 Jun 21 04:44:02.591615 waagent[2240]: eth0 0108C80A 00000000 0005 0 0 1024 FFFFFFFF 0 0 0 Jun 21 04:44:02.591615 waagent[2240]: eth0 10813FA8 0108C80A 0007 0 0 1024 FFFFFFFF 0 0 0 Jun 21 04:44:02.591615 waagent[2240]: eth0 FEA9FEA9 0108C80A 0007 0 0 1024 FFFFFFFF 0 0 0 Jun 21 04:44:02.591805 waagent[2240]: 2025-06-21T04:44:02.591620Z INFO EnvHandler ExtHandler Gateway:None Jun 21 04:44:02.592406 waagent[2240]: 2025-06-21T04:44:02.592363Z INFO EnvHandler ExtHandler Routes:None Jun 21 04:44:02.597973 waagent[2240]: 2025-06-21T04:44:02.597930Z INFO ExtHandler ExtHandler Jun 21 04:44:02.598232 waagent[2240]: 2025-06-21T04:44:02.598197Z INFO ExtHandler ExtHandler ProcessExtensionsGoalState started [incarnation_1 channel: WireServer source: Fabric activity: d091b0a3-60ab-4ccf-b7f4-9ea59830c9bf correlation e1816efb-2807-435f-96d6-0bbb6d8c7a2f created: 2025-06-21T04:41:59.050430Z] Jun 21 04:44:02.599127 waagent[2240]: 2025-06-21T04:44:02.599087Z INFO ExtHandler ExtHandler No extension handlers found, not processing anything. Jun 21 04:44:02.600032 systemd[1]: Finished user-runtime-dir@0.service - User Runtime Directory /run/user/0. Jun 21 04:44:02.600563 waagent[2240]: 2025-06-21T04:44:02.600516Z INFO ExtHandler ExtHandler ProcessExtensionsGoalState completed [incarnation_1 2 ms] Jun 21 04:44:02.603739 systemd[1]: Starting user@0.service - User Manager for UID 0... Jun 21 04:44:02.626637 (systemd)[2369]: pam_unix(systemd-user:session): session opened for user root(uid=0) by (uid=0) Jun 21 04:44:02.629021 systemd-logind[1877]: New session c3 of user root. Jun 21 04:44:02.637518 waagent[2240]: 2025-06-21T04:44:02.637465Z 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 Jun 21 04:44:02.637518 waagent[2240]: Try `iptables -h' or 'iptables --help' for more information.) Jun 21 04:44:02.638514 waagent[2240]: 2025-06-21T04:44:02.638450Z INFO ExtHandler ExtHandler [HEARTBEAT] Agent WALinuxAgent-2.12.0.4 is running as the goal state agent [DEBUG HeartbeatCounter: 0;HeartbeatId: 15845FBD-9E95-4E95-9B25-A32BA76CF722;DroppedPackets: -1;UpdateGSErrors: 0;AutoUpdate: 0;UpdateMode: SelfUpdate;] Jun 21 04:44:02.709536 waagent[2240]: 2025-06-21T04:44:02.709470Z INFO MonitorHandler ExtHandler Network interfaces: Jun 21 04:44:02.709536 waagent[2240]: Executing ['ip', '-a', '-o', 'link']: Jun 21 04:44:02.709536 waagent[2240]: 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 Jun 21 04:44:02.709536 waagent[2240]: 2: eth0: mtu 1500 qdisc mq state UP mode DEFAULT group default qlen 1000\ link/ether 7c:1e:52:75:f3:f1 brd ff:ff:ff:ff:ff:ff Jun 21 04:44:02.709536 waagent[2240]: Executing ['ip', '-4', '-a', '-o', 'address']: Jun 21 04:44:02.709536 waagent[2240]: 1: lo inet 127.0.0.1/8 scope host lo\ valid_lft forever preferred_lft forever Jun 21 04:44:02.709536 waagent[2240]: 2: eth0 inet 10.200.8.27/24 metric 1024 brd 10.200.8.255 scope global eth0\ valid_lft forever preferred_lft forever Jun 21 04:44:02.709536 waagent[2240]: Executing ['ip', '-6', '-a', '-o', 'address']: Jun 21 04:44:02.709536 waagent[2240]: 1: lo inet6 ::1/128 scope host noprefixroute \ valid_lft forever preferred_lft forever Jun 21 04:44:02.709536 waagent[2240]: 2: eth0 inet6 fe80::7e1e:52ff:fe75:f3f1/64 scope link proto kernel_ll \ valid_lft forever preferred_lft forever Jun 21 04:44:02.805301 systemd[2369]: Queued start job for default target default.target. Jun 21 04:44:02.823566 systemd[2369]: Created slice app.slice - User Application Slice. Jun 21 04:44:02.823597 systemd[2369]: Reached target paths.target - Paths. Jun 21 04:44:02.823644 systemd[2369]: Reached target timers.target - Timers. Jun 21 04:44:02.824808 systemd[2369]: Starting dbus.socket - D-Bus User Message Bus Socket... Jun 21 04:44:02.831757 waagent[2240]: 2025-06-21T04:44:02.831702Z INFO EnvHandler ExtHandler Created firewall rules for the Azure Fabric: Jun 21 04:44:02.831757 waagent[2240]: Chain INPUT (policy ACCEPT 0 packets, 0 bytes) Jun 21 04:44:02.831757 waagent[2240]: pkts bytes target prot opt in out source destination Jun 21 04:44:02.831757 waagent[2240]: Chain FORWARD (policy ACCEPT 0 packets, 0 bytes) Jun 21 04:44:02.831757 waagent[2240]: pkts bytes target prot opt in out source destination Jun 21 04:44:02.831757 waagent[2240]: Chain OUTPUT (policy ACCEPT 0 packets, 0 bytes) Jun 21 04:44:02.831757 waagent[2240]: pkts bytes target prot opt in out source destination Jun 21 04:44:02.831757 waagent[2240]: 0 0 ACCEPT tcp -- * * 0.0.0.0/0 168.63.129.16 tcp dpt:53 Jun 21 04:44:02.831757 waagent[2240]: 0 0 ACCEPT tcp -- * * 0.0.0.0/0 168.63.129.16 owner UID match 0 Jun 21 04:44:02.831757 waagent[2240]: 0 0 DROP tcp -- * * 0.0.0.0/0 168.63.129.16 ctstate INVALID,NEW Jun 21 04:44:02.835106 waagent[2240]: 2025-06-21T04:44:02.835056Z INFO EnvHandler ExtHandler Current Firewall rules: Jun 21 04:44:02.835106 waagent[2240]: Chain INPUT (policy ACCEPT 0 packets, 0 bytes) Jun 21 04:44:02.835106 waagent[2240]: pkts bytes target prot opt in out source destination Jun 21 04:44:02.835106 waagent[2240]: Chain FORWARD (policy ACCEPT 0 packets, 0 bytes) Jun 21 04:44:02.835106 waagent[2240]: pkts bytes target prot opt in out source destination Jun 21 04:44:02.835106 waagent[2240]: Chain OUTPUT (policy ACCEPT 0 packets, 0 bytes) Jun 21 04:44:02.835106 waagent[2240]: pkts bytes target prot opt in out source destination Jun 21 04:44:02.835106 waagent[2240]: 0 0 ACCEPT tcp -- * * 0.0.0.0/0 168.63.129.16 tcp dpt:53 Jun 21 04:44:02.835106 waagent[2240]: 0 0 ACCEPT tcp -- * * 0.0.0.0/0 168.63.129.16 owner UID match 0 Jun 21 04:44:02.835106 waagent[2240]: 0 0 DROP tcp -- * * 0.0.0.0/0 168.63.129.16 ctstate INVALID,NEW Jun 21 04:44:02.835345 waagent[2240]: 2025-06-21T04:44:02.835311Z INFO EnvHandler ExtHandler Set block dev timeout: sdb with timeout: 300 Jun 21 04:44:02.835106 systemd[2369]: Listening on dbus.socket - D-Bus User Message Bus Socket. Jun 21 04:44:02.835158 systemd[2369]: Reached target sockets.target - Sockets. Jun 21 04:44:02.835210 systemd[2369]: Reached target basic.target - Basic System. Jun 21 04:44:02.835254 systemd[2369]: Reached target default.target - Main User Target. Jun 21 04:44:02.835579 waagent[2240]: 2025-06-21T04:44:02.835469Z INFO EnvHandler ExtHandler Set block dev timeout: sda with timeout: 300 Jun 21 04:44:02.835287 systemd[2369]: Startup finished in 199ms. Jun 21 04:44:02.835357 systemd[1]: Started user@0.service - User Manager for UID 0. Jun 21 04:44:02.839523 systemd[1]: Started session-c2.scope - Session c2 of User root. Jun 21 04:44:02.905461 kernel: loop6: detected capacity change from 0 to 12644352 Jun 21 04:44:02.913459 kernel: loop6: p9 Jun 21 04:44:03.023024 setup-nvidia[2402]: ░ Spawning container flatcardevelopercontainer-4372.0.0.bin on /opt/nvidia/workdir/flatcar_developer_container-4372.0.0.bin. Jun 21 04:44:06.084794 update_engine[1878]: I20250621 04:44:06.084717 1878 update_attempter.cc:509] Updating boot flags... Jun 21 04:44:06.832347 kernel: EXT4-fs (loop6p9): write access unavailable, skipping orphan cleanup Jun 21 04:44:06.832501 kernel: EXT4-fs (loop6p9): mounted filesystem cbb8b014-b9c9-40d9-aeee-0a301ce97b84 ro without journal. Quota mode: none. Jun 21 04:44:16.070847 systemd[1]: Created slice system-sshd.slice - Slice /system/sshd. Jun 21 04:44:16.073560 systemd[1]: Started sshd@0-10.200.8.27:22-10.200.16.10:52136.service - OpenSSH per-connection server daemon (10.200.16.10:52136). Jun 21 04:44:16.991166 sshd[2681]: Accepted publickey for core from 10.200.16.10 port 52136 ssh2: RSA SHA256:jYWBM1yPGAIe+p2LiJChTbS35lH+dRwTR5p0HY6W3Bk Jun 21 04:44:16.992460 sshd-session[2681]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Jun 21 04:44:16.997431 systemd-logind[1877]: New session 3 of user core. Jun 21 04:44:17.013572 systemd[1]: Started session-3.scope - Session 3 of User core. Jun 21 04:44:17.585826 systemd[1]: Started sshd@1-10.200.8.27:22-10.200.16.10:52152.service - OpenSSH per-connection server daemon (10.200.16.10:52152). Jun 21 04:44:18.275579 sshd[3096]: Accepted publickey for core from 10.200.16.10 port 52152 ssh2: RSA SHA256:jYWBM1yPGAIe+p2LiJChTbS35lH+dRwTR5p0HY6W3Bk Jun 21 04:44:18.276919 sshd-session[3096]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Jun 21 04:44:18.281705 systemd-logind[1877]: New session 4 of user core. Jun 21 04:44:18.297614 systemd[1]: Started session-4.scope - Session 4 of User core. Jun 21 04:44:18.748523 sshd[3297]: Connection closed by 10.200.16.10 port 52152 Jun 21 04:44:18.748909 sshd-session[3096]: pam_unix(sshd:session): session closed for user core Jun 21 04:44:18.752683 systemd[1]: sshd@1-10.200.8.27:22-10.200.16.10:52152.service: Deactivated successfully. Jun 21 04:44:18.754221 systemd[1]: session-4.scope: Deactivated successfully. Jun 21 04:44:18.754919 systemd-logind[1877]: Session 4 logged out. Waiting for processes to exit. Jun 21 04:44:18.755948 systemd-logind[1877]: Removed session 4. Jun 21 04:44:18.863920 systemd[1]: Started sshd@2-10.200.8.27:22-10.200.16.10:39030.service - OpenSSH per-connection server daemon (10.200.16.10:39030). Jun 21 04:44:19.493537 sshd[3304]: Accepted publickey for core from 10.200.16.10 port 39030 ssh2: RSA SHA256:jYWBM1yPGAIe+p2LiJChTbS35lH+dRwTR5p0HY6W3Bk Jun 21 04:44:19.494855 sshd-session[3304]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Jun 21 04:44:19.499246 systemd-logind[1877]: New session 5 of user core. Jun 21 04:44:19.511563 systemd[1]: Started session-5.scope - Session 5 of User core. Jun 21 04:44:19.937788 sshd[3306]: Connection closed by 10.200.16.10 port 39030 Jun 21 04:44:19.938136 sshd-session[3304]: pam_unix(sshd:session): session closed for user core Jun 21 04:44:19.941611 systemd[1]: sshd@2-10.200.8.27:22-10.200.16.10:39030.service: Deactivated successfully. Jun 21 04:44:19.943160 systemd[1]: session-5.scope: Deactivated successfully. Jun 21 04:44:19.943853 systemd-logind[1877]: Session 5 logged out. Waiting for processes to exit. Jun 21 04:44:19.944804 systemd-logind[1877]: Removed session 5. Jun 21 04:44:30.061121 systemd[1]: Started sshd@3-10.200.8.27:22-10.200.16.10:37168.service - OpenSSH per-connection server daemon (10.200.16.10:37168). Jun 21 04:44:31.179502 sshd[3312]: Accepted publickey for core from 10.200.16.10 port 37168 ssh2: RSA SHA256:jYWBM1yPGAIe+p2LiJChTbS35lH+dRwTR5p0HY6W3Bk Jun 21 04:44:31.179855 sshd-session[3312]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Jun 21 04:44:31.184216 systemd-logind[1877]: New session 6 of user core. Jun 21 04:44:31.197561 systemd[1]: Started session-6.scope - Session 6 of User core. Jun 21 04:44:31.561153 sshd[3314]: Connection closed by 10.200.16.10 port 37168 Jun 21 04:44:31.561452 sshd-session[3312]: pam_unix(sshd:session): session closed for user core Jun 21 04:44:31.565289 systemd[1]: sshd@3-10.200.8.27:22-10.200.16.10:37168.service: Deactivated successfully. Jun 21 04:44:31.567046 systemd[1]: session-6.scope: Deactivated successfully. Jun 21 04:44:31.567845 systemd-logind[1877]: Session 6 logged out. Waiting for processes to exit. Jun 21 04:44:31.568847 systemd-logind[1877]: Removed session 6. Jun 21 04:44:31.684055 systemd[1]: Started sshd@4-10.200.8.27:22-10.200.16.10:37184.service - OpenSSH per-connection server daemon (10.200.16.10:37184). Jun 21 04:44:32.313699 sshd[3320]: Accepted publickey for core from 10.200.16.10 port 37184 ssh2: RSA SHA256:jYWBM1yPGAIe+p2LiJChTbS35lH+dRwTR5p0HY6W3Bk Jun 21 04:44:32.315013 sshd-session[3320]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Jun 21 04:44:32.319360 systemd-logind[1877]: New session 7 of user core. Jun 21 04:44:32.342578 systemd[1]: Started session-7.scope - Session 7 of User core. Jun 21 04:44:32.759045 sshd[3322]: Connection closed by 10.200.16.10 port 37184 Jun 21 04:44:32.759394 sshd-session[3320]: pam_unix(sshd:session): session closed for user core Jun 21 04:44:32.762714 systemd[1]: sshd@4-10.200.8.27:22-10.200.16.10:37184.service: Deactivated successfully. Jun 21 04:44:32.764202 systemd[1]: session-7.scope: Deactivated successfully. Jun 21 04:44:32.764876 systemd-logind[1877]: Session 7 logged out. Waiting for processes to exit. Jun 21 04:44:32.765795 systemd-logind[1877]: Removed session 7. Jun 21 04:44:42.874379 systemd[1]: Started sshd@5-10.200.8.27:22-10.200.16.10:39442.service - OpenSSH per-connection server daemon (10.200.16.10:39442). Jun 21 04:44:43.503741 sshd[3444]: Accepted publickey for core from 10.200.16.10 port 39442 ssh2: RSA SHA256:jYWBM1yPGAIe+p2LiJChTbS35lH+dRwTR5p0HY6W3Bk Jun 21 04:44:43.505093 sshd-session[3444]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Jun 21 04:44:43.510150 systemd-logind[1877]: New session 8 of user core. Jun 21 04:44:43.523587 systemd[1]: Started session-8.scope - Session 8 of User core. Jun 21 04:44:43.959160 sshd[3471]: Connection closed by 10.200.16.10 port 39442 Jun 21 04:44:43.959529 sshd-session[3444]: pam_unix(sshd:session): session closed for user core Jun 21 04:44:43.963008 systemd[1]: sshd@5-10.200.8.27:22-10.200.16.10:39442.service: Deactivated successfully. Jun 21 04:44:43.964516 systemd[1]: session-8.scope: Deactivated successfully. Jun 21 04:44:43.965153 systemd-logind[1877]: Session 8 logged out. Waiting for processes to exit. Jun 21 04:44:43.966234 systemd-logind[1877]: Removed session 8. Jun 21 04:44:44.082018 systemd[1]: Started sshd@6-10.200.8.27:22-10.200.16.10:39444.service - OpenSSH per-connection server daemon (10.200.16.10:39444). Jun 21 04:44:44.713220 sshd[3478]: Accepted publickey for core from 10.200.16.10 port 39444 ssh2: RSA SHA256:jYWBM1yPGAIe+p2LiJChTbS35lH+dRwTR5p0HY6W3Bk Jun 21 04:44:44.714592 sshd-session[3478]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Jun 21 04:44:44.718921 systemd-logind[1877]: New session 9 of user core. Jun 21 04:44:44.731573 systemd[1]: Started session-9.scope - Session 9 of User core. Jun 21 04:44:45.158537 sshd[3480]: Connection closed by 10.200.16.10 port 39444 Jun 21 04:44:45.158890 sshd-session[3478]: pam_unix(sshd:session): session closed for user core Jun 21 04:44:45.162339 systemd[1]: sshd@6-10.200.8.27:22-10.200.16.10:39444.service: Deactivated successfully. Jun 21 04:44:45.163860 systemd[1]: session-9.scope: Deactivated successfully. Jun 21 04:44:45.164526 systemd-logind[1877]: Session 9 logged out. Waiting for processes to exit. Jun 21 04:44:45.165431 systemd-logind[1877]: Removed session 9. Jun 21 04:44:55.273941 systemd[1]: Started sshd@7-10.200.8.27:22-10.200.16.10:60640.service - OpenSSH per-connection server daemon (10.200.16.10:60640). Jun 21 04:44:55.918294 sshd[5909]: Accepted publickey for core from 10.200.16.10 port 60640 ssh2: RSA SHA256:jYWBM1yPGAIe+p2LiJChTbS35lH+dRwTR5p0HY6W3Bk Jun 21 04:44:55.919641 sshd-session[5909]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Jun 21 04:44:55.923939 systemd-logind[1877]: New session 10 of user core. Jun 21 04:44:55.933561 systemd[1]: Started session-10.scope - Session 10 of User core. Jun 21 04:44:56.363662 sshd[5935]: Connection closed by 10.200.16.10 port 60640 Jun 21 04:44:56.364031 sshd-session[5909]: pam_unix(sshd:session): session closed for user core Jun 21 04:44:56.367457 systemd[1]: sshd@7-10.200.8.27:22-10.200.16.10:60640.service: Deactivated successfully. Jun 21 04:44:56.368975 systemd[1]: session-10.scope: Deactivated successfully. Jun 21 04:44:56.369654 systemd-logind[1877]: Session 10 logged out. Waiting for processes to exit. Jun 21 04:44:56.370765 systemd-logind[1877]: Removed session 10. Jun 21 04:44:56.478731 systemd[1]: Started sshd@8-10.200.8.27:22-10.200.16.10:60656.service - OpenSSH per-connection server daemon (10.200.16.10:60656). Jun 21 04:44:57.107177 sshd[5965]: Accepted publickey for core from 10.200.16.10 port 60656 ssh2: RSA SHA256:jYWBM1yPGAIe+p2LiJChTbS35lH+dRwTR5p0HY6W3Bk Jun 21 04:44:57.108556 sshd-session[5965]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Jun 21 04:44:57.112775 systemd-logind[1877]: New session 11 of user core. Jun 21 04:44:57.130564 systemd[1]: Started session-11.scope - Session 11 of User core. Jun 21 04:44:58.773186 sshd[5989]: Connection closed by 10.200.16.10 port 60656 Jun 21 04:44:58.773279 sshd-session[5965]: pam_unix(sshd:session): session closed for user core Jun 21 04:44:58.776988 systemd[1]: sshd@8-10.200.8.27:22-10.200.16.10:60656.service: Deactivated successfully. Jun 21 04:44:58.778582 systemd[1]: session-11.scope: Deactivated successfully. Jun 21 04:44:58.779257 systemd-logind[1877]: Session 11 logged out. Waiting for processes to exit. Jun 21 04:44:58.780457 systemd-logind[1877]: Removed session 11. Jun 21 04:45:07.666783 systemd[1]: Started sshd@9-10.200.8.27:22-10.200.16.10:50572.service - OpenSSH per-connection server daemon (10.200.16.10:50572). Jun 21 04:45:08.296296 sshd[8287]: Accepted publickey for core from 10.200.16.10 port 50572 ssh2: RSA SHA256:jYWBM1yPGAIe+p2LiJChTbS35lH+dRwTR5p0HY6W3Bk Jun 21 04:45:08.297670 sshd-session[8287]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Jun 21 04:45:08.302379 systemd-logind[1877]: New session 12 of user core. Jun 21 04:45:08.318654 systemd[1]: Started session-12.scope - Session 12 of User core. Jun 21 04:45:08.741602 sshd[8720]: Connection closed by 10.200.16.10 port 50572 Jun 21 04:45:08.743627 sshd-session[8287]: pam_unix(sshd:session): session closed for user core Jun 21 04:45:08.748796 systemd[1]: sshd@9-10.200.8.27:22-10.200.16.10:50572.service: Deactivated successfully. Jun 21 04:45:08.752604 systemd[1]: session-12.scope: Deactivated successfully. Jun 21 04:45:08.753693 systemd-logind[1877]: Session 12 logged out. Waiting for processes to exit. Jun 21 04:45:08.755970 systemd-logind[1877]: Removed session 12. Jun 21 04:45:08.856678 systemd[1]: Started sshd@10-10.200.8.27:22-10.200.16.10:43470.service - OpenSSH per-connection server daemon (10.200.16.10:43470). Jun 21 04:45:09.505205 sshd[9013]: Accepted publickey for core from 10.200.16.10 port 43470 ssh2: RSA SHA256:jYWBM1yPGAIe+p2LiJChTbS35lH+dRwTR5p0HY6W3Bk Jun 21 04:45:09.505852 sshd-session[9013]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Jun 21 04:45:09.512806 systemd-logind[1877]: New session 13 of user core. Jun 21 04:45:09.520583 systemd[1]: Started session-13.scope - Session 13 of User core. Jun 21 04:45:09.950531 sshd[9153]: Connection closed by 10.200.16.10 port 43470 Jun 21 04:45:09.951097 sshd-session[9013]: pam_unix(sshd:session): session closed for user core Jun 21 04:45:09.954645 systemd[1]: sshd@10-10.200.8.27:22-10.200.16.10:43470.service: Deactivated successfully. Jun 21 04:45:09.958994 systemd[1]: session-13.scope: Deactivated successfully. Jun 21 04:45:09.960550 systemd-logind[1877]: Session 13 logged out. Waiting for processes to exit. Jun 21 04:45:09.962118 systemd-logind[1877]: Removed session 13. Jun 21 04:45:20.064684 systemd[1]: Started sshd@11-10.200.8.27:22-10.200.16.10:33498.service - OpenSSH per-connection server daemon (10.200.16.10:33498). Jun 21 04:45:20.712962 sshd[11516]: Accepted publickey for core from 10.200.16.10 port 33498 ssh2: RSA SHA256:jYWBM1yPGAIe+p2LiJChTbS35lH+dRwTR5p0HY6W3Bk Jun 21 04:45:20.714848 sshd-session[11516]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Jun 21 04:45:20.723487 systemd-logind[1877]: New session 14 of user core. Jun 21 04:45:20.733627 systemd[1]: Started session-14.scope - Session 14 of User core. Jun 21 04:45:21.163308 sshd[11554]: Connection closed by 10.200.16.10 port 33498 Jun 21 04:45:21.164110 sshd-session[11516]: pam_unix(sshd:session): session closed for user core Jun 21 04:45:21.168367 systemd-logind[1877]: Session 14 logged out. Waiting for processes to exit. Jun 21 04:45:21.169819 systemd[1]: sshd@11-10.200.8.27:22-10.200.16.10:33498.service: Deactivated successfully. Jun 21 04:45:21.171393 systemd[1]: session-14.scope: Deactivated successfully. Jun 21 04:45:21.175137 systemd-logind[1877]: Removed session 14. Jun 21 04:45:21.278849 systemd[1]: Started sshd@12-10.200.8.27:22-10.200.16.10:33510.service - OpenSSH per-connection server daemon (10.200.16.10:33510). Jun 21 04:45:21.931526 sshd[11581]: Accepted publickey for core from 10.200.16.10 port 33510 ssh2: RSA SHA256:jYWBM1yPGAIe+p2LiJChTbS35lH+dRwTR5p0HY6W3Bk Jun 21 04:45:21.933307 sshd-session[11581]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Jun 21 04:45:21.941460 systemd-logind[1877]: New session 15 of user core. Jun 21 04:45:21.947024 systemd[1]: Started session-15.scope - Session 15 of User core. Jun 21 04:45:22.383742 sshd[11665]: Connection closed by 10.200.16.10 port 33510 Jun 21 04:45:22.384585 sshd-session[11581]: pam_unix(sshd:session): session closed for user core Jun 21 04:45:22.391166 systemd-logind[1877]: Session 15 logged out. Waiting for processes to exit. Jun 21 04:45:22.391787 systemd[1]: sshd@12-10.200.8.27:22-10.200.16.10:33510.service: Deactivated successfully. Jun 21 04:45:22.393463 systemd[1]: session-15.scope: Deactivated successfully. Jun 21 04:45:22.400092 systemd-logind[1877]: Removed session 15. Jun 21 04:45:32.501685 systemd[1]: Started sshd@13-10.200.8.27:22-10.200.16.10:49376.service - OpenSSH per-connection server daemon (10.200.16.10:49376). Jun 21 04:45:33.150896 sshd[11984]: Accepted publickey for core from 10.200.16.10 port 49376 ssh2: RSA SHA256:jYWBM1yPGAIe+p2LiJChTbS35lH+dRwTR5p0HY6W3Bk Jun 21 04:45:33.152226 sshd-session[11984]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Jun 21 04:45:33.158629 systemd-logind[1877]: New session 16 of user core. Jun 21 04:45:33.164647 systemd[1]: Started session-16.scope - Session 16 of User core. Jun 21 04:45:33.597848 sshd[12015]: Connection closed by 10.200.16.10 port 49376 Jun 21 04:45:33.598216 sshd-session[11984]: pam_unix(sshd:session): session closed for user core Jun 21 04:45:33.601660 systemd[1]: sshd@13-10.200.8.27:22-10.200.16.10:49376.service: Deactivated successfully. Jun 21 04:45:33.603265 systemd[1]: session-16.scope: Deactivated successfully. Jun 21 04:45:33.604182 systemd-logind[1877]: Session 16 logged out. Waiting for processes to exit. Jun 21 04:45:33.607956 systemd-logind[1877]: Removed session 16. Jun 21 04:45:33.835652 systemd[1]: Started sshd@14-10.200.8.27:22-10.200.16.10:49388.service - OpenSSH per-connection server daemon (10.200.16.10:49388). Jun 21 04:45:34.478392 sshd[12052]: Accepted publickey for core from 10.200.16.10 port 49388 ssh2: RSA SHA256:jYWBM1yPGAIe+p2LiJChTbS35lH+dRwTR5p0HY6W3Bk Jun 21 04:45:34.480247 sshd-session[12052]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Jun 21 04:45:34.486645 systemd-logind[1877]: New session 17 of user core. Jun 21 04:45:34.497964 systemd[1]: Started session-17.scope - Session 17 of User core. Jun 21 04:45:34.931567 sshd[12065]: Connection closed by 10.200.16.10 port 49388 Jun 21 04:45:34.932336 sshd-session[12052]: pam_unix(sshd:session): session closed for user core Jun 21 04:45:34.936758 systemd[1]: sshd@14-10.200.8.27:22-10.200.16.10:49388.service: Deactivated successfully. Jun 21 04:45:34.937238 systemd-logind[1877]: Session 17 logged out. Waiting for processes to exit. Jun 21 04:45:34.939352 systemd[1]: session-17.scope: Deactivated successfully. Jun 21 04:45:34.943858 systemd-logind[1877]: Removed session 17. Jun 21 04:45:45.053516 systemd[1]: Started sshd@15-10.200.8.27:22-10.200.16.10:47718.service - OpenSSH per-connection server daemon (10.200.16.10:47718). Jun 21 04:45:45.695084 sshd[12395]: Accepted publickey for core from 10.200.16.10 port 47718 ssh2: RSA SHA256:jYWBM1yPGAIe+p2LiJChTbS35lH+dRwTR5p0HY6W3Bk Jun 21 04:45:45.698885 sshd-session[12395]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Jun 21 04:45:45.706382 systemd-logind[1877]: New session 18 of user core. Jun 21 04:45:45.715582 systemd[1]: Started session-18.scope - Session 18 of User core. Jun 21 04:45:46.145354 sshd[12415]: Connection closed by 10.200.16.10 port 47718 Jun 21 04:45:46.146263 sshd-session[12395]: pam_unix(sshd:session): session closed for user core Jun 21 04:45:46.149818 systemd-logind[1877]: Session 18 logged out. Waiting for processes to exit. Jun 21 04:45:46.150816 systemd[1]: sshd@15-10.200.8.27:22-10.200.16.10:47718.service: Deactivated successfully. Jun 21 04:45:46.152385 systemd[1]: session-18.scope: Deactivated successfully. Jun 21 04:45:46.156987 systemd-logind[1877]: Removed session 18. Jun 21 04:45:46.280680 systemd[1]: Started sshd@16-10.200.8.27:22-10.200.16.10:47720.service - OpenSSH per-connection server daemon (10.200.16.10:47720). Jun 21 04:45:46.977526 sshd[12439]: Accepted publickey for core from 10.200.16.10 port 47720 ssh2: RSA SHA256:jYWBM1yPGAIe+p2LiJChTbS35lH+dRwTR5p0HY6W3Bk Jun 21 04:45:46.978725 sshd-session[12439]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Jun 21 04:45:46.985981 systemd-logind[1877]: New session 19 of user core. Jun 21 04:45:46.991606 systemd[1]: Started session-19.scope - Session 19 of User core. Jun 21 04:45:47.530651 sshd[12472]: Connection closed by 10.200.16.10 port 47720 Jun 21 04:45:47.531641 sshd-session[12439]: pam_unix(sshd:session): session closed for user core Jun 21 04:45:47.537013 systemd-logind[1877]: Session 19 logged out. Waiting for processes to exit. Jun 21 04:45:47.537656 systemd[1]: sshd@16-10.200.8.27:22-10.200.16.10:47720.service: Deactivated successfully. Jun 21 04:45:47.539256 systemd[1]: session-19.scope: Deactivated successfully. Jun 21 04:45:47.544332 systemd-logind[1877]: Removed session 19. Jun 21 04:45:57.648975 systemd[1]: Started sshd@17-10.200.8.27:22-10.200.16.10:59774.service - OpenSSH per-connection server daemon (10.200.16.10:59774). Jun 21 04:45:57.924730 setup-nvidia[2402]: \u000d Jun 21 04:45:57.924730 setup-nvidia[2402]: ERROR: Unable to load the kernel module 'nvidia.ko'. This happens most Jun 21 04:45:57.924730 setup-nvidia[2402]: frequently when this kernel module was built against the wrong or Jun 21 04:45:57.924730 setup-nvidia[2402]: improperly configured kernel sources, with a version of gcc that differs Jun 21 04:45:57.924730 setup-nvidia[2402]: from the one used to build the target kernel, or if another driver, such Jun 21 04:45:57.924730 setup-nvidia[2402]: as nouveau, is present and prevents the NVIDIA kernel module from Jun 21 04:45:57.924730 setup-nvidia[2402]: obtaining ownership of the NVIDIA device(s), or no NVIDIA device Jun 21 04:45:57.924730 setup-nvidia[2402]: installed in this system is supported by this NVIDIA Linux graphics Jun 21 04:45:57.924730 setup-nvidia[2402]: driver release. Jun 21 04:45:57.924730 setup-nvidia[2402]: \u000d Jun 21 04:45:57.924730 setup-nvidia[2402]: Please see the log entries 'Kernel module load error' and 'Kernel Jun 21 04:45:57.924730 setup-nvidia[2402]: messages' at the end of the file Jun 21 04:45:57.924730 setup-nvidia[2402]: '/nvidia/NVIDIA-Linux-x86_64-535.230.02/nvidia-installer.log' for more Jun 21 04:45:57.924730 setup-nvidia[2402]: information. Jun 21 04:45:57.924730 setup-nvidia[2402]: \u000d Jun 21 04:45:57.940563 setup-nvidia[2402]: dmesg: read kernel buffer failed: Operation not permitted Jun 21 04:45:57.959652 setup-nvidia[2402]: \u000d Jun 21 04:45:57.959652 setup-nvidia[2402]: ERROR: Installation has failed. Please see the file Jun 21 04:45:57.959652 setup-nvidia[2402]: '/nvidia/NVIDIA-Linux-x86_64-535.230.02/nvidia-installer.log' for Jun 21 04:45:57.959652 setup-nvidia[2402]: details. You may find suggestions on fixing installation problems in Jun 21 04:45:57.959652 setup-nvidia[2402]: the README available on the Linux driver download page at Jun 21 04:45:57.959652 setup-nvidia[2402]: www.nvidia.com. Jun 21 04:45:57.959652 setup-nvidia[2402]: \u000d Jun 21 04:45:57.960057 setup-nvidia[2402]: Last 50 lines of nvidia-installer.log: Jun 21 04:45:57.960873 setup-nvidia[2402]: /nvidia/NVIDIA-Linux-x86_64-535.230.02/kernel/nvidia.o: warning: objtool: _nv039000rm+0x53: 'naked' return found in MITIGATION_RETHUNK build Jun 21 04:45:57.960873 setup-nvidia[2402]: /nvidia/NVIDIA-Linux-x86_64-535.230.02/kernel/nvidia.o: warning: objtool: _nv038997rm+0x90: 'naked' return found in MITIGATION_RETHUNK build Jun 21 04:45:57.960873 setup-nvidia[2402]: /nvidia/NVIDIA-Linux-x86_64-535.230.02/kernel/nvidia.o: warning: objtool: _nv038990rm+0x2b: 'naked' return found in MITIGATION_RETHUNK build Jun 21 04:45:57.960873 setup-nvidia[2402]: /nvidia/NVIDIA-Linux-x86_64-535.230.02/kernel/nvidia.o: warning: objtool: _nv039046rm+0x93: 'naked' return found in MITIGATION_RETHUNK build Jun 21 04:45:57.960873 setup-nvidia[2402]: /nvidia/NVIDIA-Linux-x86_64-535.230.02/kernel/nvidia.o: warning: objtool: _nv039042rm+0x36: 'naked' return found in MITIGATION_RETHUNK build Jun 21 04:45:57.960873 setup-nvidia[2402]: /nvidia/NVIDIA-Linux-x86_64-535.230.02/kernel/nvidia.o: warning: objtool: _nv039041rm+0x9d: 'naked' return found in MITIGATION_RETHUNK build Jun 21 04:45:57.960873 setup-nvidia[2402]: /nvidia/NVIDIA-Linux-x86_64-535.230.02/kernel/nvidia.o: warning: objtool: _nv039043rm+0x77: 'naked' return found in MITIGATION_RETHUNK build Jun 21 04:45:57.960873 setup-nvidia[2402]: /nvidia/NVIDIA-Linux-x86_64-535.230.02/kernel/nvidia.o: warning: objtool: _nv038987rm+0x7f: 'naked' return found in MITIGATION_RETHUNK build Jun 21 04:45:57.960873 setup-nvidia[2402]: /nvidia/NVIDIA-Linux-x86_64-535.230.02/kernel/nvidia.o: warning: objtool: _nv030558rm+0x3e: 'naked' return found in MITIGATION_RETHUNK build Jun 21 04:45:57.960873 setup-nvidia[2402]: /nvidia/NVIDIA-Linux-x86_64-535.230.02/kernel/nvidia.o: warning: objtool: _nv030557rm+0x27: 'naked' return found in MITIGATION_RETHUNK build Jun 21 04:45:57.960873 setup-nvidia[2402]: /nvidia/NVIDIA-Linux-x86_64-535.230.02/kernel/nvidia.o: warning: objtool: _nv030561rm+0x37: 'naked' return found in MITIGATION_RETHUNK build Jun 21 04:45:57.960873 setup-nvidia[2402]: /nvidia/NVIDIA-Linux-x86_64-535.230.02/kernel/nvidia.o: warning: objtool: _nv030560rm+0x24: 'naked' return found in MITIGATION_RETHUNK build Jun 21 04:45:57.960873 setup-nvidia[2402]: /nvidia/NVIDIA-Linux-x86_64-535.230.02/kernel/nvidia.o: warning: objtool: _nv030559rm+0xca: 'naked' return found in MITIGATION_RETHUNK build Jun 21 04:45:57.960873 setup-nvidia[2402]: /nvidia/NVIDIA-Linux-x86_64-535.230.02/kernel/nvidia.o: warning: objtool: _nv030562rm+0x193: 'naked' return found in MITIGATION_RETHUNK build Jun 21 04:45:57.960873 setup-nvidia[2402]: /nvidia/NVIDIA-Linux-x86_64-535.230.02/kernel/nvidia.o: warning: objtool: _nv030564rm+0x17f: 'naked' return found in MITIGATION_RETHUNK build Jun 21 04:45:57.960873 setup-nvidia[2402]: /nvidia/NVIDIA-Linux-x86_64-535.230.02/kernel/nvidia.o: warning: objtool: _nv011860rm+0x5d: 'naked' return found in MITIGATION_RETHUNK build Jun 21 04:45:57.960873 setup-nvidia[2402]: /nvidia/NVIDIA-Linux-x86_64-535.230.02/kernel/nvidia.o: warning: objtool: _nv039354rm+0x12f: 'naked' return found in MITIGATION_RETHUNK build Jun 21 04:45:57.960873 setup-nvidia[2402]: MODPOST /nvidia/NVIDIA-Linux-x86_64-535.230.02/kernel/Module.symvers Jun 21 04:45:57.960873 setup-nvidia[2402]: CC [M] /nvidia/NVIDIA-Linux-x86_64-535.230.02/kernel/nvidia.mod.o Jun 21 04:45:57.960873 setup-nvidia[2402]: CC [M] /nvidia/NVIDIA-Linux-x86_64-535.230.02/kernel/.module-common.o Jun 21 04:45:57.960873 setup-nvidia[2402]: CC [M] /nvidia/NVIDIA-Linux-x86_64-535.230.02/kernel/nvidia-uvm.mod.o Jun 21 04:45:57.960873 setup-nvidia[2402]: CC [M] /nvidia/NVIDIA-Linux-x86_64-535.230.02/kernel/nvidia-modeset.mod.o Jun 21 04:45:57.960873 setup-nvidia[2402]: CC [M] /nvidia/NVIDIA-Linux-x86_64-535.230.02/kernel/nvidia-peermem.mod.o Jun 21 04:45:57.960873 setup-nvidia[2402]: CC [M] /nvidia/NVIDIA-Linux-x86_64-535.230.02/kernel/nvidia-drm.mod.o Jun 21 04:45:57.960873 setup-nvidia[2402]: LD [M] /nvidia/NVIDIA-Linux-x86_64-535.230.02/kernel/nvidia.ko Jun 21 04:45:57.960873 setup-nvidia[2402]: LD [M] /nvidia/NVIDIA-Linux-x86_64-535.230.02/kernel/nvidia-peermem.ko Jun 21 04:45:57.960873 setup-nvidia[2402]: LD [M] /nvidia/NVIDIA-Linux-x86_64-535.230.02/kernel/nvidia-modeset.ko Jun 21 04:45:57.960873 setup-nvidia[2402]: LD [M] /nvidia/NVIDIA-Linux-x86_64-535.230.02/kernel/nvidia-uvm.ko Jun 21 04:45:57.960873 setup-nvidia[2402]: BTF [M] /nvidia/NVIDIA-Linux-x86_64-535.230.02/kernel/nvidia-peermem.ko Jun 21 04:45:57.960873 setup-nvidia[2402]: Skipping BTF generation for /nvidia/NVIDIA-Linux-x86_64-535.230.02/kernel/nvidia-peermem.ko due to unavailability of vmlinux Jun 21 04:45:57.960873 setup-nvidia[2402]: BTF [M] /nvidia/NVIDIA-Linux-x86_64-535.230.02/kernel/nvidia-modeset.ko Jun 21 04:45:57.960873 setup-nvidia[2402]: Skipping BTF generation for /nvidia/NVIDIA-Linux-x86_64-535.230.02/kernel/nvidia-modeset.ko due to unavailability of vmlinux Jun 21 04:45:57.960873 setup-nvidia[2402]: LD [M] /nvidia/NVIDIA-Linux-x86_64-535.230.02/kernel/nvidia-drm.ko Jun 21 04:45:57.960873 setup-nvidia[2402]: BTF [M] /nvidia/NVIDIA-Linux-x86_64-535.230.02/kernel/nvidia-drm.ko Jun 21 04:45:57.960873 setup-nvidia[2402]: Skipping BTF generation for /nvidia/NVIDIA-Linux-x86_64-535.230.02/kernel/nvidia-drm.ko due to unavailability of vmlinux Jun 21 04:45:57.960873 setup-nvidia[2402]: BTF [M] /nvidia/NVIDIA-Linux-x86_64-535.230.02/kernel/nvidia-uvm.ko Jun 21 04:45:57.960873 setup-nvidia[2402]: Skipping BTF generation for /nvidia/NVIDIA-Linux-x86_64-535.230.02/kernel/nvidia-uvm.ko due to unavailability of vmlinux Jun 21 04:45:57.960873 setup-nvidia[2402]: BTF [M] /nvidia/NVIDIA-Linux-x86_64-535.230.02/kernel/nvidia.ko Jun 21 04:45:57.960873 setup-nvidia[2402]: Skipping BTF generation for /nvidia/NVIDIA-Linux-x86_64-535.230.02/kernel/nvidia.ko due to unavailability of vmlinux Jun 21 04:45:57.960873 setup-nvidia[2402]: make[2]: Leaving directory '/usr/lib/modules/6.12.34-flatcar/build' Jun 21 04:45:57.960873 setup-nvidia[2402]: make[1]: Leaving directory '/usr/lib/modules/6.12.34-flatcar/source' Jun 21 04:45:57.960873 setup-nvidia[2402]: -> done. Jun 21 04:45:57.960873 setup-nvidia[2402]: -> Kernel module compilation complete. Jun 21 04:45:57.960873 setup-nvidia[2402]: -> Unable to determine if Secure Boot is enabled: No such file or directory Jun 21 04:45:57.961936 setup-nvidia[2402]: 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. Jun 21 04:45:57.961936 setup-nvidia[2402]: \u000d Jun 21 04:45:57.961936 setup-nvidia[2402]: Please see the log entries 'Kernel module load error' and 'Kernel messages' at the end of the file '/nvidia/NVIDIA-Linux-x86_64-535.230.02/nvidia-installer.log' for more information. Jun 21 04:45:57.961936 setup-nvidia[2402]: -> Kernel module load error: Operation not permitted Jun 21 04:45:57.961936 setup-nvidia[2402]: -> Kernel messages: Jun 21 04:45:57.961936 setup-nvidia[2402]: ERROR: Installation has failed. Please see the file '/nvidia/NVIDIA-Linux-x86_64-535.230.02/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. Jun 21 04:45:58.305127 sshd[12699]: Accepted publickey for core from 10.200.16.10 port 59774 ssh2: RSA SHA256:jYWBM1yPGAIe+p2LiJChTbS35lH+dRwTR5p0HY6W3Bk Jun 21 04:45:58.306430 sshd-session[12699]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Jun 21 04:45:58.310712 systemd-logind[1877]: New session 20 of user core. Jun 21 04:45:58.320583 systemd[1]: Started session-20.scope - Session 20 of User core. Jun 21 04:45:58.749528 sshd[12776]: Connection closed by 10.200.16.10 port 59774 Jun 21 04:45:58.749903 sshd-session[12699]: pam_unix(sshd:session): session closed for user core Jun 21 04:45:58.753354 systemd[1]: sshd@17-10.200.8.27:22-10.200.16.10:59774.service: Deactivated successfully. Jun 21 04:45:58.755031 systemd[1]: session-20.scope: Deactivated successfully. Jun 21 04:45:58.755812 systemd-logind[1877]: Session 20 logged out. Waiting for processes to exit. Jun 21 04:45:58.756781 systemd-logind[1877]: Removed session 20. Jun 21 04:45:58.882112 systemd[1]: Started sshd@18-10.200.8.27:22-10.200.16.10:45102.service - OpenSSH per-connection server daemon (10.200.16.10:45102). Jun 21 04:45:59.519538 sshd[12782]: Accepted publickey for core from 10.200.16.10 port 45102 ssh2: RSA SHA256:jYWBM1yPGAIe+p2LiJChTbS35lH+dRwTR5p0HY6W3Bk Jun 21 04:45:59.520880 sshd-session[12782]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Jun 21 04:45:59.525300 systemd-logind[1877]: New session 21 of user core. Jun 21 04:45:59.538560 systemd[1]: Started session-21.scope - Session 21 of User core. Jun 21 04:45:59.980594 sshd[12784]: Connection closed by 10.200.16.10 port 45102 Jun 21 04:45:59.980956 sshd-session[12782]: pam_unix(sshd:session): session closed for user core Jun 21 04:45:59.984330 systemd[1]: sshd@18-10.200.8.27:22-10.200.16.10:45102.service: Deactivated successfully. Jun 21 04:45:59.985887 systemd[1]: session-21.scope: Deactivated successfully. Jun 21 04:45:59.986551 systemd-logind[1877]: Session 21 logged out. Waiting for processes to exit. Jun 21 04:45:59.987471 systemd-logind[1877]: Removed session 21. Jun 21 04:46:10.096846 systemd[1]: Started sshd@19-10.200.8.27:22-10.200.16.10:56890.service - OpenSSH per-connection server daemon (10.200.16.10:56890). Jun 21 04:46:10.725898 sshd[12790]: Accepted publickey for core from 10.200.16.10 port 56890 ssh2: RSA SHA256:jYWBM1yPGAIe+p2LiJChTbS35lH+dRwTR5p0HY6W3Bk Jun 21 04:46:10.727209 sshd-session[12790]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Jun 21 04:46:10.731484 systemd-logind[1877]: New session 22 of user core. Jun 21 04:46:10.740560 systemd[1]: Started session-22.scope - Session 22 of User core. Jun 21 04:46:11.175067 sshd[12792]: Connection closed by 10.200.16.10 port 56890 Jun 21 04:46:11.175481 sshd-session[12790]: pam_unix(sshd:session): session closed for user core Jun 21 04:46:11.179223 systemd[1]: sshd@19-10.200.8.27:22-10.200.16.10:56890.service: Deactivated successfully. Jun 21 04:46:11.180810 systemd[1]: session-22.scope: Deactivated successfully. Jun 21 04:46:11.181495 systemd-logind[1877]: Session 22 logged out. Waiting for processes to exit. Jun 21 04:46:11.182535 systemd-logind[1877]: Removed session 22. Jun 21 04:46:11.286811 systemd[1]: Started sshd@20-10.200.8.27:22-10.200.16.10:56898.service - OpenSSH per-connection server daemon (10.200.16.10:56898). Jun 21 04:46:11.938716 sshd[12799]: Accepted publickey for core from 10.200.16.10 port 56898 ssh2: RSA SHA256:jYWBM1yPGAIe+p2LiJChTbS35lH+dRwTR5p0HY6W3Bk Jun 21 04:46:11.939995 sshd-session[12799]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Jun 21 04:46:11.944192 systemd-logind[1877]: New session 23 of user core. Jun 21 04:46:11.962571 systemd[1]: Started session-23.scope - Session 23 of User core. Jun 21 04:46:12.388628 sshd[12801]: Connection closed by 10.200.16.10 port 56898 Jun 21 04:46:12.389005 sshd-session[12799]: pam_unix(sshd:session): session closed for user core Jun 21 04:46:12.392422 systemd[1]: sshd@20-10.200.8.27:22-10.200.16.10:56898.service: Deactivated successfully. Jun 21 04:46:12.394002 systemd[1]: session-23.scope: Deactivated successfully. Jun 21 04:46:12.394683 systemd-logind[1877]: Session 23 logged out. Waiting for processes to exit. Jun 21 04:46:12.395709 systemd-logind[1877]: Removed session 23. Jun 21 04:46:14.659465 kernel: EXT4-fs (loop6p9): unmounting filesystem cbb8b014-b9c9-40d9-aeee-0a301ce97b84. Jun 21 04:46:14.660062 setup-nvidia[2402]: Container flatcardevelopercontainer-4372.0.0.bin exited successfully. Jun 21 04:46:14.662386 systemd[1]: run-systemd-nspawn-unix\x2dexport-flatcardevelopercontainer\x2d4372.0.0.bin.mount: Deactivated successfully. Jun 21 04:46:14.723215 sudo[2361]: pam_unix(sudo:session): session closed for user root Jun 21 04:46:14.725187 systemd[1]: session-c2.scope: Deactivated successfully. Jun 21 04:46:14.725492 systemd[1]: session-c2.scope: Consumed 5min 12.439s CPU time, 893.1M memory peak. Jun 21 04:46:15.136193 setup-nvidia[1868]: /opt/nvidia / Jun 21 04:46:15.137150 setup-nvidia[1868]: / Jun 21 04:46:15.146457 kernel: IPMI message handler: version 39.2 Jun 21 04:46:15.149457 kernel: ipmi device interface Jun 21 04:46:15.162329 setup-nvidia[1868]: /opt/nvidia/current/usr/lib/modules/6.12.34-flatcar/video / Jun 21 04:46:15.216747 kernel: nvidia: loading out-of-tree module taints kernel. Jun 21 04:46:15.216878 kernel: nvidia: module license 'NVIDIA' taints kernel. Jun 21 04:46:15.216902 kernel: Disabling lock debugging due to kernel taint Jun 21 04:46:15.224326 kernel: nvidia: module verification failed: signature and/or required key missing - tainting kernel Jun 21 04:46:15.224372 kernel: nvidia: module license taints kernel. Jun 21 04:46:15.615461 kernel: nvidia-nvlink: Nvlink Core is being initialized, major device number 243 Jun 21 04:46:16.028126 kernel: Jun 21 04:46:16.028262 kernel: nvidia 0001:00:00.0: enabling device (0000 -> 0002) Jun 21 04:46:16.235468 kernel: NVRM: loading NVIDIA UNIX x86_64 Kernel Module 535.230.02 Fri Dec 20 21:42:05 UTC 2024 Jun 21 04:46:16.257457 kernel: nvidia-modeset: Loading NVIDIA Kernel Mode Setting Driver for UNIX platforms 535.230.02 Fri Dec 20 21:52:34 UTC 2024 Jun 21 04:46:16.276468 kernel: nvidia_uvm: module uses symbols nvUvmInterfaceDisableAccessCntr from proprietary module nvidia, inheriting taint. Jun 21 04:46:16.325462 kernel: nvidia-uvm: Loaded the UVM driver, major device number 241. Jun 21 04:46:16.325598 setup-nvidia[1868]: / Jun 21 04:46:16.338935 setup-nvidia[12840]: ldconfig: /usr/lib/ld.so.conf is not an ELF file - it has the wrong magic bytes at the start. Jun 21 04:46:18.621869 setup-nvidia[12857]: Sat Jun 21 04:46:18 2025 Jun 21 04:46:18.621869 setup-nvidia[12857]: +---------------------------------------------------------------------------------------+ Jun 21 04:46:18.621869 setup-nvidia[12857]: | NVIDIA-SMI 535.230.02 Driver Version: 535.230.02 CUDA Version: 12.2 | Jun 21 04:46:18.621869 setup-nvidia[12857]: |-----------------------------------------+----------------------+----------------------+ Jun 21 04:46:18.621869 setup-nvidia[12857]: | GPU Name Persistence-M | Bus-Id Disp.A | Volatile Uncorr. ECC | Jun 21 04:46:18.621869 setup-nvidia[12857]: | Fan Temp Perf Pwr:Usage/Cap | Memory-Usage | GPU-Util Compute M. | Jun 21 04:46:18.621869 setup-nvidia[12857]: | | | MIG M. | Jun 21 04:46:18.621869 setup-nvidia[12857]: |=========================================+======================+======================| Jun 21 04:46:18.625416 setup-nvidia[12857]: | 0 Tesla V100-PCIE-16GB Off | 00000001:00:00.0 Off | Off | Jun 21 04:46:18.625416 setup-nvidia[12857]: | N/A 28C P0 36W / 250W | 0MiB / 16384MiB | 0% Default | Jun 21 04:46:18.625416 setup-nvidia[12857]: | | | N/A | Jun 21 04:46:18.625416 setup-nvidia[12857]: +-----------------------------------------+----------------------+----------------------+ Jun 21 04:46:18.625416 setup-nvidia[12857]: Jun 21 04:46:18.625416 setup-nvidia[12857]: +---------------------------------------------------------------------------------------+ Jun 21 04:46:18.625416 setup-nvidia[12857]: | Processes: | Jun 21 04:46:18.625416 setup-nvidia[12857]: | GPU GI CI PID Type Process name GPU Memory | Jun 21 04:46:18.625416 setup-nvidia[12857]: | ID ID Usage | Jun 21 04:46:18.625416 setup-nvidia[12857]: |=======================================================================================| Jun 21 04:46:18.625687 setup-nvidia[12857]: | No running processes found | Jun 21 04:46:18.625687 setup-nvidia[12857]: +---------------------------------------------------------------------------------------+ Jun 21 04:46:18.996424 systemd[1]: Finished nvidia.service - NVIDIA Configure Service. Jun 21 04:46:18.999018 systemd[1]: Reached target multi-user.target - Multi-User System. Jun 21 04:46:18.999414 systemd[1]: Startup finished in 1.393s (firmware) + 29.849s (loader) + 3.825s (kernel) + 14.416s (initrd) + 3min 12.676s (userspace) = 4min 2.160s. Jun 21 04:46:22.501176 systemd[1]: Started sshd@21-10.200.8.27:22-10.200.16.10:34066.service - OpenSSH per-connection server daemon (10.200.16.10:34066). Jun 21 04:46:23.130563 sshd[12864]: Accepted publickey for core from 10.200.16.10 port 34066 ssh2: RSA SHA256:jYWBM1yPGAIe+p2LiJChTbS35lH+dRwTR5p0HY6W3Bk Jun 21 04:46:23.131859 sshd-session[12864]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Jun 21 04:46:23.136267 systemd-logind[1877]: New session 24 of user core. Jun 21 04:46:23.146567 systemd[1]: Started session-24.scope - Session 24 of User core. Jun 21 04:46:23.576954 sshd[12866]: Connection closed by 10.200.16.10 port 34066 Jun 21 04:46:23.577247 sshd-session[12864]: pam_unix(sshd:session): session closed for user core Jun 21 04:46:23.580698 systemd[1]: sshd@21-10.200.8.27:22-10.200.16.10:34066.service: Deactivated successfully. Jun 21 04:46:23.582311 systemd[1]: session-24.scope: Deactivated successfully. Jun 21 04:46:23.583016 systemd-logind[1877]: Session 24 logged out. Waiting for processes to exit. Jun 21 04:46:23.583961 systemd-logind[1877]: Removed session 24. Jun 21 04:46:23.691816 systemd[1]: Started sshd@22-10.200.8.27:22-10.200.16.10:34072.service - OpenSSH per-connection server daemon (10.200.16.10:34072). Jun 21 04:46:24.319988 sshd[12872]: Accepted publickey for core from 10.200.16.10 port 34072 ssh2: RSA SHA256:jYWBM1yPGAIe+p2LiJChTbS35lH+dRwTR5p0HY6W3Bk Jun 21 04:46:24.321355 sshd-session[12872]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Jun 21 04:46:24.325992 systemd-logind[1877]: New session 25 of user core. Jun 21 04:46:24.343579 systemd[1]: Started session-25.scope - Session 25 of User core. Jun 21 04:46:24.761709 sshd[12874]: Connection closed by 10.200.16.10 port 34072 Jun 21 04:46:24.762055 sshd-session[12872]: pam_unix(sshd:session): session closed for user core Jun 21 04:46:24.764246 systemd[1]: Stopping user@0.service - User Manager for UID 0... Jun 21 04:46:24.765012 systemd[2369]: Activating special unit exit.target... Jun 21 04:46:24.765088 systemd[2369]: Stopped target default.target - Main User Target. Jun 21 04:46:24.765128 systemd[2369]: Stopped target basic.target - Basic System. Jun 21 04:46:24.765156 systemd[2369]: Stopped target paths.target - Paths. Jun 21 04:46:24.765182 systemd[2369]: Stopped target sockets.target - Sockets. Jun 21 04:46:24.765207 systemd[2369]: Stopped target timers.target - Timers. Jun 21 04:46:24.765551 systemd[2369]: Closed dbus.socket - D-Bus User Message Bus Socket. Jun 21 04:46:24.765952 systemd[2369]: Removed slice app.slice - User Application Slice. Jun 21 04:46:24.765973 systemd[1]: sshd@22-10.200.8.27:22-10.200.16.10:34072.service: Deactivated successfully. Jun 21 04:46:24.765985 systemd[2369]: Reached target shutdown.target - Shutdown. Jun 21 04:46:24.766193 systemd[2369]: Finished systemd-exit.service - Exit the Session. Jun 21 04:46:24.766245 systemd[2369]: Reached target exit.target - Exit the Session. Jun 21 04:46:24.767660 systemd[1]: session-25.scope: Deactivated successfully. Jun 21 04:46:24.769429 systemd-logind[1877]: Session 25 logged out. Waiting for processes to exit. Jun 21 04:46:24.774843 systemd-logind[1877]: Removed session 25. Jun 21 04:46:24.782024 (sd-pam)[2370]: pam_unix(systemd-user:session): session closed for user root Jun 21 04:46:24.783325 systemd[1]: user@0.service: Deactivated successfully. Jun 21 04:46:24.783681 systemd[1]: Stopped user@0.service - User Manager for UID 0. Jun 21 04:46:24.785814 systemd[1]: Stopping user-runtime-dir@0.service - User Runtime Directory /run/user/0... Jun 21 04:46:24.820153 systemd[1]: run-user-0.mount: Deactivated successfully. Jun 21 04:46:24.821093 systemd[1]: user-runtime-dir@0.service: Deactivated successfully. Jun 21 04:46:24.821281 systemd[1]: Stopped user-runtime-dir@0.service - User Runtime Directory /run/user/0. Jun 21 04:46:24.822829 systemd[1]: Removed slice user-0.slice - User Slice of UID 0. Jun 21 04:46:24.822918 systemd[1]: user-0.slice: Consumed 5min 12.742s CPU time, 902.7M memory peak. Jun 21 04:46:24.823306 systemd-logind[1877]: Removed session c3. Jun 21 04:46:24.877574 systemd[1]: Started sshd@23-10.200.8.27:22-10.200.16.10:34078.service - OpenSSH per-connection server daemon (10.200.16.10:34078). Jun 21 04:46:25.506650 sshd[12884]: Accepted publickey for core from 10.200.16.10 port 34078 ssh2: RSA SHA256:jYWBM1yPGAIe+p2LiJChTbS35lH+dRwTR5p0HY6W3Bk Jun 21 04:46:25.507941 sshd-session[12884]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Jun 21 04:46:25.512330 systemd-logind[1877]: New session 26 of user core. Jun 21 04:46:25.530591 systemd[1]: Started session-26.scope - Session 26 of User core. Jun 21 04:46:25.952136 sshd[12886]: Connection closed by 10.200.16.10 port 34078 Jun 21 04:46:25.952497 sshd-session[12884]: pam_unix(sshd:session): session closed for user core Jun 21 04:46:25.955922 systemd[1]: sshd@23-10.200.8.27:22-10.200.16.10:34078.service: Deactivated successfully. Jun 21 04:46:25.957534 systemd[1]: session-26.scope: Deactivated successfully. Jun 21 04:46:25.958181 systemd-logind[1877]: Session 26 logged out. Waiting for processes to exit. Jun 21 04:46:25.959151 systemd-logind[1877]: Removed session 26. Jun 21 04:46:26.067700 systemd[1]: Started sshd@24-10.200.8.27:22-10.200.16.10:34086.service - OpenSSH per-connection server daemon (10.200.16.10:34086). Jun 21 04:46:26.718883 sshd[12892]: Accepted publickey for core from 10.200.16.10 port 34086 ssh2: RSA SHA256:jYWBM1yPGAIe+p2LiJChTbS35lH+dRwTR5p0HY6W3Bk Jun 21 04:46:26.720265 sshd-session[12892]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Jun 21 04:46:26.724573 systemd-logind[1877]: New session 27 of user core. Jun 21 04:46:26.737552 systemd[1]: Started session-27.scope - Session 27 of User core. Jun 21 04:46:27.166814 sshd[12894]: Connection closed by 10.200.16.10 port 34086 Jun 21 04:46:27.167186 sshd-session[12892]: pam_unix(sshd:session): session closed for user core Jun 21 04:46:27.170542 systemd[1]: sshd@24-10.200.8.27:22-10.200.16.10:34086.service: Deactivated successfully. Jun 21 04:46:27.172156 systemd[1]: session-27.scope: Deactivated successfully. Jun 21 04:46:27.172928 systemd-logind[1877]: Session 27 logged out. Waiting for processes to exit. Jun 21 04:46:27.173851 systemd-logind[1877]: Removed session 27. Jun 21 04:46:27.281533 systemd[1]: Started sshd@25-10.200.8.27:22-10.200.16.10:34090.service - OpenSSH per-connection server daemon (10.200.16.10:34090). Jun 21 04:46:27.931371 sshd[12900]: Accepted publickey for core from 10.200.16.10 port 34090 ssh2: RSA SHA256:jYWBM1yPGAIe+p2LiJChTbS35lH+dRwTR5p0HY6W3Bk Jun 21 04:46:27.932695 sshd-session[12900]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Jun 21 04:46:27.936922 systemd-logind[1877]: New session 28 of user core. Jun 21 04:46:27.948557 systemd[1]: Started session-28.scope - Session 28 of User core. Jun 21 04:46:29.865783 sshd[12902]: Connection closed by 10.200.16.10 port 34090 Jun 21 04:46:29.866163 sshd-session[12900]: pam_unix(sshd:session): session closed for user core Jun 21 04:46:29.869560 systemd[1]: sshd@25-10.200.8.27:22-10.200.16.10:34090.service: Deactivated successfully. Jun 21 04:46:29.871090 systemd[1]: session-28.scope: Deactivated successfully. Jun 21 04:46:29.871333 systemd[1]: session-28.scope: Consumed 1.424s CPU time, 14M memory peak. Jun 21 04:46:29.871828 systemd-logind[1877]: Session 28 logged out. Waiting for processes to exit. Jun 21 04:46:29.872780 systemd-logind[1877]: Removed session 28.