Sep 12 17:44:50.214250 kernel: Linux version 6.12.47-flatcar (build@pony-truck.infra.kinvolk.io) (x86_64-cros-linux-gnu-gcc (Gentoo Hardened 14.3.0 p8) 14.3.0, GNU ld (Gentoo 2.44 p4) 2.44.0) #1 SMP PREEMPT_DYNAMIC Fri Sep 12 15:34:39 -00 2025 Sep 12 17:44:50.214277 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=271a44cc8ea1639cfb6fdf777202a5f025fda0b3ce9b293cc4e0e7047aecb858 Sep 12 17:44:50.214287 kernel: BIOS-provided physical RAM map: Sep 12 17:44:50.214294 kernel: BIOS-e820: [mem 0x0000000000000000-0x000000000009ffff] usable Sep 12 17:44:50.214300 kernel: BIOS-e820: [mem 0x00000000000c0000-0x00000000000fffff] reserved Sep 12 17:44:50.214307 kernel: BIOS-e820: [mem 0x0000000000100000-0x000000003ff40fff] usable Sep 12 17:44:50.214315 kernel: BIOS-e820: [mem 0x000000003ff41000-0x000000003ffc8fff] reserved Sep 12 17:44:50.214324 kernel: BIOS-e820: [mem 0x000000003ffc9000-0x000000003fffafff] ACPI data Sep 12 17:44:50.214331 kernel: BIOS-e820: [mem 0x000000003fffb000-0x000000003fffefff] ACPI NVS Sep 12 17:44:50.214338 kernel: BIOS-e820: [mem 0x000000003ffff000-0x000000003fffffff] usable Sep 12 17:44:50.214345 kernel: BIOS-e820: [mem 0x0000000100000000-0x0000000fdfffffff] usable Sep 12 17:44:50.214352 kernel: BIOS-e820: [mem 0x0000004fe0000000-0x0000005cbfffffff] usable Sep 12 17:44:50.214359 kernel: printk: legacy bootconsole [earlyser0] enabled Sep 12 17:44:50.214377 kernel: NX (Execute Disable) protection: active Sep 12 17:44:50.214389 kernel: APIC: Static calls initialized Sep 12 17:44:50.214396 kernel: efi: EFI v2.7 by Microsoft Sep 12 17:44:50.214404 kernel: efi: ACPI=0x3fffa000 ACPI 2.0=0x3fffa014 SMBIOS=0x3ff85000 SMBIOS 3.0=0x3ff83000 MEMATTR=0x3f5bfa98 RNG=0x3ffd1018 Sep 12 17:44:50.214412 kernel: random: crng init done Sep 12 17:44:50.214420 kernel: secureboot: Secure boot disabled Sep 12 17:44:50.214427 kernel: SMBIOS 3.1.0 present. Sep 12 17:44:50.214435 kernel: DMI: Microsoft Corporation Virtual Machine/Virtual Machine, BIOS Hyper-V UEFI Release v4.1 03/08/2024 Sep 12 17:44:50.214443 kernel: DMI: Memory slots populated: 3/3 Sep 12 17:44:50.214450 kernel: Hypervisor detected: Microsoft Hyper-V Sep 12 17:44:50.214458 kernel: Hyper-V: privilege flags low 0x2e7f, high 0x3b8030, hints 0x62c2c, misc 0xed7b2 Sep 12 17:44:50.214468 kernel: Hyper-V: LAPIC Timer Frequency: 0x30d40 Sep 12 17:44:50.214475 kernel: Hyper-V: Using hypercall for remote TLB flush Sep 12 17:44:50.214483 kernel: clocksource: hyperv_clocksource_tsc_page: mask: 0xffffffffffffffff max_cycles: 0x24e6a1710, max_idle_ns: 440795202120 ns Sep 12 17:44:50.214491 kernel: clocksource: hyperv_clocksource_msr: mask: 0xffffffffffffffff max_cycles: 0x24e6a1710, max_idle_ns: 440795202120 ns Sep 12 17:44:50.214499 kernel: tsc: Marking TSC unstable due to running on Hyper-V Sep 12 17:44:50.214507 kernel: tsc: Detected 2593.992 MHz processor Sep 12 17:44:50.214515 kernel: e820: update [mem 0x00000000-0x00000fff] usable ==> reserved Sep 12 17:44:50.214523 kernel: e820: remove [mem 0x000a0000-0x000fffff] usable Sep 12 17:44:50.214530 kernel: last_pfn = 0x5cc0000 max_arch_pfn = 0x400000000 Sep 12 17:44:50.214540 kernel: MTRR map: 5 entries (2 fixed + 3 variable; max 18), built from 8 variable MTRRs Sep 12 17:44:50.214548 kernel: x86/PAT: Configuration [0-7]: WB WC UC- UC WB WP UC- WT Sep 12 17:44:50.214555 kernel: e820: update [mem 0x40000000-0xffffffff] usable ==> reserved Sep 12 17:44:50.214565 kernel: e820: update [mem 0x1100000000-0x4fdfffffff] usable ==> reserved Sep 12 17:44:50.214573 kernel: last_pfn = 0x40000 max_arch_pfn = 0x400000000 Sep 12 17:44:50.214580 kernel: Using GB pages for direct mapping Sep 12 17:44:50.214588 kernel: ACPI: Early table checksum verification disabled Sep 12 17:44:50.214600 kernel: ACPI: RSDP 0x000000003FFFA014 000024 (v02 VRTUAL) Sep 12 17:44:50.214610 kernel: ACPI: XSDT 0x000000003FFF90E8 000064 (v01 VRTUAL MICROSFT 00000001 MSFT 00000001) Sep 12 17:44:50.214618 kernel: ACPI: FACP 0x000000003FFF8000 000114 (v06 VRTUAL MICROSFT 00000001 MSFT 00000001) Sep 12 17:44:50.214626 kernel: ACPI: DSDT 0x000000003FFD6000 01E184 (v02 MSFTVM DSDT01 00000001 MSFT 05000000) Sep 12 17:44:50.214634 kernel: ACPI: FACS 0x000000003FFFE000 000040 Sep 12 17:44:50.214642 kernel: ACPI: OEM0 0x000000003FFF7000 000064 (v01 VRTUAL MICROSFT 00000001 MSFT 00000001) Sep 12 17:44:50.214650 kernel: ACPI: SPCR 0x000000003FFF6000 000050 (v02 VRTUAL MICROSFT 00000001 MSFT 00000001) Sep 12 17:44:50.214661 kernel: ACPI: WAET 0x000000003FFF5000 000028 (v01 VRTUAL MICROSFT 00000001 MSFT 00000001) Sep 12 17:44:50.214669 kernel: ACPI: APIC 0x000000003FFD5000 000078 (v04 VRTUAL MICROSFT 00000001 MSFT 00000001) Sep 12 17:44:50.214677 kernel: ACPI: SRAT 0x000000003FFD4000 0001D0 (v02 VRTUAL MICROSFT 00000001 MSFT 00000001) Sep 12 17:44:50.214685 kernel: ACPI: BGRT 0x000000003FFD3000 000038 (v01 VRTUAL MICROSFT 00000001 MSFT 00000001) Sep 12 17:44:50.214693 kernel: ACPI: FPDT 0x000000003FFD2000 000034 (v01 VRTUAL MICROSFT 00000001 MSFT 00000001) Sep 12 17:44:50.214701 kernel: ACPI: Reserving FACP table memory at [mem 0x3fff8000-0x3fff8113] Sep 12 17:44:50.214709 kernel: ACPI: Reserving DSDT table memory at [mem 0x3ffd6000-0x3fff4183] Sep 12 17:44:50.214717 kernel: ACPI: Reserving FACS table memory at [mem 0x3fffe000-0x3fffe03f] Sep 12 17:44:50.214725 kernel: ACPI: Reserving OEM0 table memory at [mem 0x3fff7000-0x3fff7063] Sep 12 17:44:50.214735 kernel: ACPI: Reserving SPCR table memory at [mem 0x3fff6000-0x3fff604f] Sep 12 17:44:50.214743 kernel: ACPI: Reserving WAET table memory at [mem 0x3fff5000-0x3fff5027] Sep 12 17:44:50.214751 kernel: ACPI: Reserving APIC table memory at [mem 0x3ffd5000-0x3ffd5077] Sep 12 17:44:50.214759 kernel: ACPI: Reserving SRAT table memory at [mem 0x3ffd4000-0x3ffd41cf] Sep 12 17:44:50.214767 kernel: ACPI: Reserving BGRT table memory at [mem 0x3ffd3000-0x3ffd3037] Sep 12 17:44:50.214775 kernel: ACPI: Reserving FPDT table memory at [mem 0x3ffd2000-0x3ffd2033] Sep 12 17:44:50.214783 kernel: ACPI: SRAT: Node 0 PXM 0 [mem 0x00000000-0x3fffffff] hotplug Sep 12 17:44:50.214791 kernel: ACPI: SRAT: Node 0 PXM 0 [mem 0x100000000-0xfdfffffff] hotplug Sep 12 17:44:50.214801 kernel: ACPI: SRAT: Node 0 PXM 0 [mem 0x4fe0000000-0x5cbfffffff] hotplug Sep 12 17:44:50.214809 kernel: ACPI: SRAT: Node 0 PXM 0 [mem 0x5cc0200000-0xffffffffff] hotplug Sep 12 17:44:50.214817 kernel: ACPI: SRAT: Node 0 PXM 0 [mem 0x10000200000-0x1ffffffffff] hotplug Sep 12 17:44:50.214826 kernel: ACPI: SRAT: Node 0 PXM 0 [mem 0x20000200000-0x3ffffffffff] hotplug Sep 12 17:44:50.214834 kernel: ACPI: SRAT: Node 0 PXM 0 [mem 0x40000200000-0x7ffffffffff] hotplug Sep 12 17:44:50.214842 kernel: ACPI: SRAT: Node 0 PXM 0 [mem 0x80000200000-0xfffffffffff] hotplug Sep 12 17:44:50.214850 kernel: NUMA: Node 0 [mem 0x00001000-0x3fffffff] + [mem 0x100000000-0xfdfffffff] -> [mem 0x00001000-0xfdfffffff] Sep 12 17:44:50.214858 kernel: NUMA: Node 0 [mem 0x00001000-0xfdfffffff] + [mem 0x4fe0000000-0x5cbfffffff] -> [mem 0x00001000-0x5cbfffffff] Sep 12 17:44:50.214866 kernel: NODE_DATA(0) allocated [mem 0x5cbfff7dc0-0x5cbfffefff] Sep 12 17:44:50.214877 kernel: Zone ranges: Sep 12 17:44:50.214885 kernel: DMA [mem 0x0000000000001000-0x0000000000ffffff] Sep 12 17:44:50.214893 kernel: DMA32 [mem 0x0000000001000000-0x00000000ffffffff] Sep 12 17:44:50.214901 kernel: Normal [mem 0x0000000100000000-0x0000005cbfffffff] Sep 12 17:44:50.214909 kernel: Device empty Sep 12 17:44:50.214917 kernel: Movable zone start for each node Sep 12 17:44:50.214924 kernel: Early memory node ranges Sep 12 17:44:50.214932 kernel: node 0: [mem 0x0000000000001000-0x000000000009ffff] Sep 12 17:44:50.214941 kernel: node 0: [mem 0x0000000000100000-0x000000003ff40fff] Sep 12 17:44:50.214952 kernel: node 0: [mem 0x000000003ffff000-0x000000003fffffff] Sep 12 17:44:50.214960 kernel: node 0: [mem 0x0000000100000000-0x0000000fdfffffff] Sep 12 17:44:50.214968 kernel: node 0: [mem 0x0000004fe0000000-0x0000005cbfffffff] Sep 12 17:44:50.214976 kernel: Initmem setup node 0 [mem 0x0000000000001000-0x0000005cbfffffff] Sep 12 17:44:50.214984 kernel: On node 0, zone DMA: 1 pages in unavailable ranges Sep 12 17:44:50.214992 kernel: On node 0, zone DMA: 96 pages in unavailable ranges Sep 12 17:44:50.215000 kernel: On node 0, zone DMA32: 190 pages in unavailable ranges Sep 12 17:44:50.215008 kernel: ACPI: PM-Timer IO Port: 0x408 Sep 12 17:44:50.215016 kernel: ACPI: LAPIC_NMI (acpi_id[0x01] dfl dfl lint[0x1]) Sep 12 17:44:50.215026 kernel: IOAPIC[0]: apic_id 6, version 17, address 0xfec00000, GSI 0-23 Sep 12 17:44:50.215034 kernel: ACPI: INT_SRC_OVR (bus 0 bus_irq 9 global_irq 9 high level) Sep 12 17:44:50.215042 kernel: ACPI: Using ACPI (MADT) for SMP configuration information Sep 12 17:44:50.215050 kernel: ACPI: SPCR: console: uart,io,0x3f8,115200 Sep 12 17:44:50.215058 kernel: CPU topo: Max. logical packages: 1 Sep 12 17:44:50.215066 kernel: CPU topo: Max. logical dies: 1 Sep 12 17:44:50.215074 kernel: CPU topo: Max. dies per package: 1 Sep 12 17:44:50.215082 kernel: CPU topo: Max. threads per core: 1 Sep 12 17:44:50.215090 kernel: CPU topo: Num. cores per package: 6 Sep 12 17:44:50.215100 kernel: CPU topo: Num. threads per package: 6 Sep 12 17:44:50.215108 kernel: CPU topo: Allowing 6 present CPUs plus 0 hotplug CPUs Sep 12 17:44:50.215116 kernel: [mem 0x40000000-0xffffffff] available for PCI devices Sep 12 17:44:50.215124 kernel: Booting paravirtualized kernel on Hyper-V Sep 12 17:44:50.215132 kernel: clocksource: refined-jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1910969940391419 ns Sep 12 17:44:50.215141 kernel: setup_percpu: NR_CPUS:512 nr_cpumask_bits:6 nr_cpu_ids:6 nr_node_ids:1 Sep 12 17:44:50.215149 kernel: percpu: Embedded 60 pages/cpu s207832 r8192 d29736 u262144 Sep 12 17:44:50.215156 kernel: pcpu-alloc: s207832 r8192 d29736 u262144 alloc=1*2097152 Sep 12 17:44:50.215164 kernel: pcpu-alloc: [0] 0 1 2 3 4 5 - - Sep 12 17:44:50.215175 kernel: Hyper-V: PV spinlocks enabled Sep 12 17:44:50.215183 kernel: PV qspinlock hash table entries: 256 (order: 0, 4096 bytes, linear) Sep 12 17:44:50.215192 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=271a44cc8ea1639cfb6fdf777202a5f025fda0b3ce9b293cc4e0e7047aecb858 Sep 12 17:44:50.215200 kernel: Unknown kernel command line parameters "BOOT_IMAGE=/flatcar/vmlinuz-a", will be passed to user space. Sep 12 17:44:50.215208 kernel: Dentry cache hash table entries: 8388608 (order: 14, 67108864 bytes, linear) Sep 12 17:44:50.215217 kernel: Inode-cache hash table entries: 4194304 (order: 13, 33554432 bytes, linear) Sep 12 17:44:50.215225 kernel: Fallback order for Node 0: 0 Sep 12 17:44:50.215233 kernel: Built 1 zonelists, mobility grouping on. Total pages: 29359841 Sep 12 17:44:50.215243 kernel: Policy zone: Normal Sep 12 17:44:50.215259 kernel: mem auto-init: stack:off, heap alloc:off, heap free:off Sep 12 17:44:50.215267 kernel: software IO TLB: area num 8. Sep 12 17:44:50.215278 kernel: SLUB: HWalign=64, Order=0-3, MinObjects=0, CPUs=6, Nodes=1 Sep 12 17:44:50.215286 kernel: Kernel/User page tables isolation: enabled Sep 12 17:44:50.215295 kernel: ftrace: allocating 40125 entries in 157 pages Sep 12 17:44:50.215304 kernel: ftrace: allocated 157 pages with 5 groups Sep 12 17:44:50.215312 kernel: Dynamic Preempt: voluntary Sep 12 17:44:50.215320 kernel: rcu: Preemptible hierarchical RCU implementation. Sep 12 17:44:50.215330 kernel: rcu: RCU event tracing is enabled. Sep 12 17:44:50.215338 kernel: rcu: RCU restricting CPUs from NR_CPUS=512 to nr_cpu_ids=6. Sep 12 17:44:50.215347 kernel: Trampoline variant of Tasks RCU enabled. Sep 12 17:44:50.215358 kernel: Rude variant of Tasks RCU enabled. Sep 12 17:44:50.215375 kernel: Tracing variant of Tasks RCU enabled. Sep 12 17:44:50.215383 kernel: rcu: RCU calculated value of scheduler-enlistment delay is 100 jiffies. Sep 12 17:44:50.215392 kernel: rcu: Adjusting geometry for rcu_fanout_leaf=16, nr_cpu_ids=6 Sep 12 17:44:50.215401 kernel: RCU Tasks: Setting shift to 3 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=6. Sep 12 17:44:50.215412 kernel: RCU Tasks Rude: Setting shift to 3 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=6. Sep 12 17:44:50.215421 kernel: RCU Tasks Trace: Setting shift to 3 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=6. Sep 12 17:44:50.215430 kernel: Using NULL legacy PIC Sep 12 17:44:50.215438 kernel: NR_IRQS: 33024, nr_irqs: 472, preallocated irqs: 0 Sep 12 17:44:50.215447 kernel: rcu: srcu_init: Setting srcu_struct sizes based on contention. Sep 12 17:44:50.215455 kernel: Console: colour dummy device 80x25 Sep 12 17:44:50.215464 kernel: printk: legacy console [tty1] enabled Sep 12 17:44:50.215472 kernel: printk: legacy console [ttyS0] enabled Sep 12 17:44:50.215481 kernel: printk: legacy bootconsole [earlyser0] disabled Sep 12 17:44:50.215491 kernel: ACPI: Core revision 20240827 Sep 12 17:44:50.215500 kernel: Failed to register legacy timer interrupt Sep 12 17:44:50.215508 kernel: APIC: Switch to symmetric I/O mode setup Sep 12 17:44:50.215517 kernel: Hyper-V: Host Build 10.0.20348.1827-1-0 Sep 12 17:44:50.215525 kernel: Hyper-V: enabling crash_kexec_post_notifiers Sep 12 17:44:50.215534 kernel: Hyper-V: Using IPI hypercalls Sep 12 17:44:50.215542 kernel: APIC: send_IPI() replaced with hv_send_ipi() Sep 12 17:44:50.215551 kernel: APIC: send_IPI_mask() replaced with hv_send_ipi_mask() Sep 12 17:44:50.215559 kernel: APIC: send_IPI_mask_allbutself() replaced with hv_send_ipi_mask_allbutself() Sep 12 17:44:50.215570 kernel: APIC: send_IPI_allbutself() replaced with hv_send_ipi_allbutself() Sep 12 17:44:50.215579 kernel: APIC: send_IPI_all() replaced with hv_send_ipi_all() Sep 12 17:44:50.215587 kernel: APIC: send_IPI_self() replaced with hv_send_ipi_self() Sep 12 17:44:50.215596 kernel: Hyper-V: Using enlightened APIC (xapic mode) Sep 12 17:44:50.215604 kernel: APIC: eoi() replaced with hv_apic_eoi_write() Sep 12 17:44:50.215612 kernel: APIC: read() replaced with hv_apic_read() Sep 12 17:44:50.215621 kernel: APIC: write() replaced with hv_apic_write() Sep 12 17:44:50.215629 kernel: APIC: icr_write() replaced with hv_apic_icr_write() Sep 12 17:44:50.215638 kernel: APIC: icr_read() replaced with hv_apic_icr_read() Sep 12 17:44:50.215649 kernel: Calibrating delay loop (skipped), value calculated using timer frequency.. 5187.98 BogoMIPS (lpj=2593992) Sep 12 17:44:50.215657 kernel: Last level iTLB entries: 4KB 128, 2MB 8, 4MB 8 Sep 12 17:44:50.215666 kernel: Last level dTLB entries: 4KB 64, 2MB 32, 4MB 32, 1GB 4 Sep 12 17:44:50.215674 kernel: Spectre V1 : Mitigation: usercopy/swapgs barriers and __user pointer sanitization Sep 12 17:44:50.215683 kernel: Spectre V2 : Mitigation: Retpolines Sep 12 17:44:50.215698 kernel: Spectre V2 : Spectre v2 / SpectreRSB: Filling RSB on context switch and VMEXIT Sep 12 17:44:50.215707 kernel: Speculative Store Bypass: Vulnerable Sep 12 17:44:50.215715 kernel: MDS: Mitigation: Clear CPU buffers Sep 12 17:44:50.215724 kernel: TAA: Mitigation: Clear CPU buffers Sep 12 17:44:50.215732 kernel: MMIO Stale Data: Vulnerable: Clear CPU buffers attempted, no microcode Sep 12 17:44:50.215744 kernel: active return thunk: its_return_thunk Sep 12 17:44:50.215752 kernel: ITS: Mitigation: Aligned branch/return thunks Sep 12 17:44:50.215760 kernel: x86/fpu: Supporting XSAVE feature 0x001: 'x87 floating point registers' Sep 12 17:44:50.215769 kernel: x86/fpu: Supporting XSAVE feature 0x002: 'SSE registers' Sep 12 17:44:50.215777 kernel: x86/fpu: Supporting XSAVE feature 0x004: 'AVX registers' Sep 12 17:44:50.215786 kernel: x86/fpu: xstate_offset[2]: 576, xstate_sizes[2]: 256 Sep 12 17:44:50.215794 kernel: x86/fpu: Enabled xstate features 0x7, context size is 832 bytes, using 'standard' format. Sep 12 17:44:50.215803 kernel: Freeing SMP alternatives memory: 32K Sep 12 17:44:50.215811 kernel: pid_max: default: 32768 minimum: 301 Sep 12 17:44:50.215819 kernel: LSM: initializing lsm=lockdown,capability,landlock,selinux,ima Sep 12 17:44:50.215828 kernel: landlock: Up and running. Sep 12 17:44:50.215838 kernel: SELinux: Initializing. Sep 12 17:44:50.215847 kernel: Mount-cache hash table entries: 131072 (order: 8, 1048576 bytes, linear) Sep 12 17:44:50.215855 kernel: Mountpoint-cache hash table entries: 131072 (order: 8, 1048576 bytes, linear) Sep 12 17:44:50.215864 kernel: smpboot: CPU0: Intel(R) Xeon(R) CPU E5-2690 v4 @ 2.60GHz (family: 0x6, model: 0x4f, stepping: 0x1) Sep 12 17:44:50.215873 kernel: Performance Events: unsupported p6 CPU model 79 no PMU driver, software events only. Sep 12 17:44:50.215881 kernel: signal: max sigframe size: 1776 Sep 12 17:44:50.215890 kernel: rcu: Hierarchical SRCU implementation. Sep 12 17:44:50.215898 kernel: rcu: Max phase no-delay instances is 400. Sep 12 17:44:50.215907 kernel: Timer migration: 1 hierarchy levels; 8 children per group; 1 crossnode level Sep 12 17:44:50.215916 kernel: NMI watchdog: Perf NMI watchdog permanently disabled Sep 12 17:44:50.215926 kernel: smp: Bringing up secondary CPUs ... Sep 12 17:44:50.215935 kernel: smpboot: x86: Booting SMP configuration: Sep 12 17:44:50.215943 kernel: .... node #0, CPUs: #1 #2 #3 #4 #5 Sep 12 17:44:50.215952 kernel: smp: Brought up 1 node, 6 CPUs Sep 12 17:44:50.215960 kernel: smpboot: Total of 6 processors activated (31127.90 BogoMIPS) Sep 12 17:44:50.215969 kernel: Memory: 115339104K/117439364K available (14336K kernel code, 2432K rwdata, 9960K rodata, 54040K init, 2924K bss, 2089992K reserved, 0K cma-reserved) Sep 12 17:44:50.215978 kernel: devtmpfs: initialized Sep 12 17:44:50.215987 kernel: x86/mm: Memory block size: 1024MB Sep 12 17:44:50.215995 kernel: ACPI: PM: Registering ACPI NVS region [mem 0x3fffb000-0x3fffefff] (16384 bytes) Sep 12 17:44:50.216006 kernel: clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1911260446275000 ns Sep 12 17:44:50.216015 kernel: futex hash table entries: 2048 (order: 5, 131072 bytes, linear) Sep 12 17:44:50.216023 kernel: pinctrl core: initialized pinctrl subsystem Sep 12 17:44:50.216032 kernel: NET: Registered PF_NETLINK/PF_ROUTE protocol family Sep 12 17:44:50.216040 kernel: audit: initializing netlink subsys (disabled) Sep 12 17:44:50.216049 kernel: audit: type=2000 audit(1757699087.028:1): state=initialized audit_enabled=0 res=1 Sep 12 17:44:50.216057 kernel: thermal_sys: Registered thermal governor 'step_wise' Sep 12 17:44:50.216066 kernel: thermal_sys: Registered thermal governor 'user_space' Sep 12 17:44:50.216074 kernel: cpuidle: using governor menu Sep 12 17:44:50.216085 kernel: acpiphp: ACPI Hot Plug PCI Controller Driver version: 0.5 Sep 12 17:44:50.216094 kernel: dca service started, version 1.12.1 Sep 12 17:44:50.216102 kernel: e820: reserve RAM buffer [mem 0x3ff41000-0x3fffffff] Sep 12 17:44:50.216111 kernel: kprobes: kprobe jump-optimization is enabled. All kprobes are optimized if possible. Sep 12 17:44:50.216119 kernel: HugeTLB: registered 1.00 GiB page size, pre-allocated 0 pages Sep 12 17:44:50.216128 kernel: HugeTLB: 16380 KiB vmemmap can be freed for a 1.00 GiB page Sep 12 17:44:50.216136 kernel: HugeTLB: registered 2.00 MiB page size, pre-allocated 0 pages Sep 12 17:44:50.216145 kernel: HugeTLB: 28 KiB vmemmap can be freed for a 2.00 MiB page Sep 12 17:44:50.216153 kernel: ACPI: Added _OSI(Module Device) Sep 12 17:44:50.216164 kernel: ACPI: Added _OSI(Processor Device) Sep 12 17:44:50.216173 kernel: ACPI: Added _OSI(Processor Aggregator Device) Sep 12 17:44:50.216181 kernel: ACPI: 1 ACPI AML tables successfully acquired and loaded Sep 12 17:44:50.216190 kernel: ACPI: Interpreter enabled Sep 12 17:44:50.216198 kernel: ACPI: PM: (supports S0 S5) Sep 12 17:44:50.216207 kernel: ACPI: Using IOAPIC for interrupt routing Sep 12 17:44:50.216215 kernel: PCI: Using host bridge windows from ACPI; if necessary, use "pci=nocrs" and report a bug Sep 12 17:44:50.216224 kernel: PCI: Ignoring E820 reservations for host bridge windows Sep 12 17:44:50.216232 kernel: ACPI: Enabled 1 GPEs in block 00 to 0F Sep 12 17:44:50.216243 kernel: iommu: Default domain type: Translated Sep 12 17:44:50.216251 kernel: iommu: DMA domain TLB invalidation policy: lazy mode Sep 12 17:44:50.216260 kernel: efivars: Registered efivars operations Sep 12 17:44:50.216268 kernel: PCI: Using ACPI for IRQ routing Sep 12 17:44:50.216277 kernel: PCI: System does not support PCI Sep 12 17:44:50.216286 kernel: vgaarb: loaded Sep 12 17:44:50.216294 kernel: clocksource: Switched to clocksource hyperv_clocksource_tsc_page Sep 12 17:44:50.216303 kernel: VFS: Disk quotas dquot_6.6.0 Sep 12 17:44:50.216311 kernel: VFS: Dquot-cache hash table entries: 512 (order 0, 4096 bytes) Sep 12 17:44:50.216322 kernel: pnp: PnP ACPI init Sep 12 17:44:50.216331 kernel: pnp: PnP ACPI: found 3 devices Sep 12 17:44:50.216339 kernel: clocksource: acpi_pm: mask: 0xffffff max_cycles: 0xffffff, max_idle_ns: 2085701024 ns Sep 12 17:44:50.216348 kernel: NET: Registered PF_INET protocol family Sep 12 17:44:50.216356 kernel: IP idents hash table entries: 262144 (order: 9, 2097152 bytes, linear) Sep 12 17:44:50.216373 kernel: tcp_listen_portaddr_hash hash table entries: 65536 (order: 8, 1048576 bytes, linear) Sep 12 17:44:50.216382 kernel: Table-perturb hash table entries: 65536 (order: 6, 262144 bytes, linear) Sep 12 17:44:50.216391 kernel: TCP established hash table entries: 524288 (order: 10, 4194304 bytes, linear) Sep 12 17:44:50.216399 kernel: TCP bind hash table entries: 65536 (order: 9, 2097152 bytes, linear) Sep 12 17:44:50.216411 kernel: TCP: Hash tables configured (established 524288 bind 65536) Sep 12 17:44:50.216419 kernel: UDP hash table entries: 65536 (order: 9, 2097152 bytes, linear) Sep 12 17:44:50.216428 kernel: UDP-Lite hash table entries: 65536 (order: 9, 2097152 bytes, linear) Sep 12 17:44:50.216436 kernel: NET: Registered PF_UNIX/PF_LOCAL protocol family Sep 12 17:44:50.216444 kernel: NET: Registered PF_XDP protocol family Sep 12 17:44:50.216453 kernel: PCI: CLS 0 bytes, default 64 Sep 12 17:44:50.216461 kernel: PCI-DMA: Using software bounce buffering for IO (SWIOTLB) Sep 12 17:44:50.216470 kernel: software IO TLB: mapped [mem 0x000000003ae61000-0x000000003ee61000] (64MB) Sep 12 17:44:50.216478 kernel: RAPL PMU: API unit is 2^-32 Joules, 0 fixed counters, 10737418240 ms ovfl timer Sep 12 17:44:50.216489 kernel: Initialise system trusted keyrings Sep 12 17:44:50.216498 kernel: workingset: timestamp_bits=39 max_order=25 bucket_order=0 Sep 12 17:44:50.216506 kernel: Key type asymmetric registered Sep 12 17:44:50.216514 kernel: Asymmetric key parser 'x509' registered Sep 12 17:44:50.216523 kernel: Block layer SCSI generic (bsg) driver version 0.4 loaded (major 250) Sep 12 17:44:50.216531 kernel: io scheduler mq-deadline registered Sep 12 17:44:50.216540 kernel: io scheduler kyber registered Sep 12 17:44:50.216548 kernel: io scheduler bfq registered Sep 12 17:44:50.216557 kernel: ioatdma: Intel(R) QuickData Technology Driver 5.00 Sep 12 17:44:50.216567 kernel: Serial: 8250/16550 driver, 4 ports, IRQ sharing enabled Sep 12 17:44:50.216576 kernel: 00:00: ttyS0 at I/O 0x3f8 (irq = 4, base_baud = 115200) is a 16550A Sep 12 17:44:50.216584 kernel: 00:01: ttyS1 at I/O 0x2f8 (irq = 3, base_baud = 115200) is a 16550A Sep 12 17:44:50.216593 kernel: i8042: PNP: No PS/2 controller found. Sep 12 17:44:50.216744 kernel: rtc_cmos 00:02: registered as rtc0 Sep 12 17:44:50.216848 kernel: rtc_cmos 00:02: setting system clock to 2025-09-12T17:44:49 UTC (1757699089) Sep 12 17:44:50.216950 kernel: rtc_cmos 00:02: alarms up to one month, 114 bytes nvram Sep 12 17:44:50.216968 kernel: intel_pstate: CPU model not supported Sep 12 17:44:50.216977 kernel: efifb: probing for efifb Sep 12 17:44:50.216986 kernel: efifb: framebuffer at 0x40000000, using 3072k, total 3072k Sep 12 17:44:50.216994 kernel: efifb: mode is 1024x768x32, linelength=4096, pages=1 Sep 12 17:44:50.217003 kernel: efifb: scrolling: redraw Sep 12 17:44:50.217011 kernel: efifb: Truecolor: size=8:8:8:8, shift=24:16:8:0 Sep 12 17:44:50.217020 kernel: Console: switching to colour frame buffer device 128x48 Sep 12 17:44:50.217028 kernel: fb0: EFI VGA frame buffer device Sep 12 17:44:50.217037 kernel: pstore: Using crash dump compression: deflate Sep 12 17:44:50.217048 kernel: pstore: Registered efi_pstore as persistent store backend Sep 12 17:44:50.217056 kernel: NET: Registered PF_INET6 protocol family Sep 12 17:44:50.217065 kernel: Segment Routing with IPv6 Sep 12 17:44:50.217073 kernel: In-situ OAM (IOAM) with IPv6 Sep 12 17:44:50.217082 kernel: NET: Registered PF_PACKET protocol family Sep 12 17:44:50.217090 kernel: Key type dns_resolver registered Sep 12 17:44:50.217099 kernel: IPI shorthand broadcast: enabled Sep 12 17:44:50.217107 kernel: sched_clock: Marking stable (3691004600, 107338900)->(4121622300, -323278800) Sep 12 17:44:50.217116 kernel: registered taskstats version 1 Sep 12 17:44:50.217124 kernel: Loading compiled-in X.509 certificates Sep 12 17:44:50.217135 kernel: Loaded X.509 cert 'Kinvolk GmbH: Module signing key for 6.12.47-flatcar: f1ae8d6e9bfae84d90f4136cf098b0465b2a5bd7' Sep 12 17:44:50.217143 kernel: Demotion targets for Node 0: null Sep 12 17:44:50.217152 kernel: Key type .fscrypt registered Sep 12 17:44:50.217160 kernel: Key type fscrypt-provisioning registered Sep 12 17:44:50.217169 kernel: ima: No TPM chip found, activating TPM-bypass! Sep 12 17:44:50.217177 kernel: ima: Allocated hash algorithm: sha1 Sep 12 17:44:50.217186 kernel: ima: No architecture policies found Sep 12 17:44:50.217194 kernel: clk: Disabling unused clocks Sep 12 17:44:50.217205 kernel: Warning: unable to open an initial console. Sep 12 17:44:50.217214 kernel: Freeing unused kernel image (initmem) memory: 54040K Sep 12 17:44:50.217222 kernel: Write protecting the kernel read-only data: 24576k Sep 12 17:44:50.217231 kernel: Freeing unused kernel image (rodata/data gap) memory: 280K Sep 12 17:44:50.217239 kernel: Run /init as init process Sep 12 17:44:50.217248 kernel: with arguments: Sep 12 17:44:50.217256 kernel: /init Sep 12 17:44:50.217264 kernel: with environment: Sep 12 17:44:50.217273 kernel: HOME=/ Sep 12 17:44:50.217283 kernel: TERM=linux Sep 12 17:44:50.217291 kernel: BOOT_IMAGE=/flatcar/vmlinuz-a Sep 12 17:44:50.217301 systemd[1]: Successfully made /usr/ read-only. Sep 12 17:44:50.217312 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) Sep 12 17:44:50.217322 systemd[1]: Detected virtualization microsoft. Sep 12 17:44:50.217331 systemd[1]: Detected architecture x86-64. Sep 12 17:44:50.217339 systemd[1]: Running in initrd. Sep 12 17:44:50.217348 systemd[1]: No hostname configured, using default hostname. Sep 12 17:44:50.217371 systemd[1]: Hostname set to . Sep 12 17:44:50.217382 systemd[1]: Initializing machine ID from random generator. Sep 12 17:44:50.217391 systemd[1]: Queued start job for default target initrd.target. Sep 12 17:44:50.217400 systemd[1]: Started clevis-luks-askpass.path - Forward Password Requests to Clevis Directory Watch. Sep 12 17:44:50.217409 systemd[1]: Started systemd-ask-password-console.path - Dispatch Password Requests to Console Directory Watch. Sep 12 17:44:50.217419 systemd[1]: Expecting device dev-disk-by\x2dlabel-EFI\x2dSYSTEM.device - /dev/disk/by-label/EFI-SYSTEM... Sep 12 17:44:50.217428 systemd[1]: Expecting device dev-disk-by\x2dlabel-OEM.device - /dev/disk/by-label/OEM... Sep 12 17:44:50.217437 systemd[1]: Expecting device dev-disk-by\x2dlabel-ROOT.device - /dev/disk/by-label/ROOT... Sep 12 17:44:50.217450 systemd[1]: Expecting device dev-disk-by\x2dpartlabel-USR\x2dA.device - /dev/disk/by-partlabel/USR-A... Sep 12 17:44:50.217461 systemd[1]: Expecting device dev-disk-by\x2dpartuuid-7130c94a\x2d213a\x2d4e5a\x2d8e26\x2d6cce9662f132.device - /dev/disk/by-partuuid/7130c94a-213a-4e5a-8e26-6cce9662f132... Sep 12 17:44:50.217470 systemd[1]: Expecting device dev-mapper-usr.device - /dev/mapper/usr... Sep 12 17:44:50.217479 systemd[1]: Reached target cryptsetup-pre.target - Local Encrypted Volumes (Pre). Sep 12 17:44:50.217488 systemd[1]: Reached target cryptsetup.target - Local Encrypted Volumes. Sep 12 17:44:50.217497 systemd[1]: Reached target paths.target - Path Units. Sep 12 17:44:50.217509 systemd[1]: Reached target slices.target - Slice Units. Sep 12 17:44:50.217518 systemd[1]: Reached target swap.target - Swaps. Sep 12 17:44:50.217527 systemd[1]: Reached target timers.target - Timer Units. Sep 12 17:44:50.217536 systemd[1]: Listening on iscsid.socket - Open-iSCSI iscsid Socket. Sep 12 17:44:50.217545 systemd[1]: Listening on iscsiuio.socket - Open-iSCSI iscsiuio Socket. Sep 12 17:44:50.217554 systemd[1]: Listening on systemd-journald-dev-log.socket - Journal Socket (/dev/log). Sep 12 17:44:50.217564 systemd[1]: Listening on systemd-journald.socket - Journal Sockets. Sep 12 17:44:50.217573 systemd[1]: Listening on systemd-networkd.socket - Network Service Netlink Socket. Sep 12 17:44:50.217582 systemd[1]: Listening on systemd-udevd-control.socket - udev Control Socket. Sep 12 17:44:50.217593 systemd[1]: Listening on systemd-udevd-kernel.socket - udev Kernel Socket. Sep 12 17:44:50.217602 systemd[1]: Reached target sockets.target - Socket Units. Sep 12 17:44:50.217611 systemd[1]: Starting ignition-setup-pre.service - Ignition env setup... Sep 12 17:44:50.217620 systemd[1]: Starting kmod-static-nodes.service - Create List of Static Device Nodes... Sep 12 17:44:50.217629 systemd[1]: Finished network-cleanup.service - Network Cleanup. Sep 12 17:44:50.217639 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). Sep 12 17:44:50.217648 systemd[1]: Starting systemd-fsck-usr.service... Sep 12 17:44:50.217657 systemd[1]: Starting systemd-journald.service - Journal Service... Sep 12 17:44:50.217668 systemd[1]: Starting systemd-modules-load.service - Load Kernel Modules... Sep 12 17:44:50.217698 systemd-journald[232]: Collecting audit messages is disabled. Sep 12 17:44:50.217720 systemd[1]: Starting systemd-vconsole-setup.service - Virtual Console Setup... Sep 12 17:44:50.217730 systemd-journald[232]: Journal started Sep 12 17:44:50.217753 systemd-journald[232]: Runtime Journal (/run/log/journal/ad6dd7cfce934df1abf0c738d467083c) is 8M, max 2.2G, 2.1G free. Sep 12 17:44:50.226288 systemd[1]: Started systemd-journald.service - Journal Service. Sep 12 17:44:50.226666 systemd[1]: Finished ignition-setup-pre.service - Ignition env setup. Sep 12 17:44:50.227150 systemd[1]: Finished kmod-static-nodes.service - Create List of Static Device Nodes. Sep 12 17:44:50.227882 systemd[1]: Finished systemd-fsck-usr.service. Sep 12 17:44:50.230501 systemd[1]: Starting systemd-tmpfiles-setup-dev-early.service - Create Static Device Nodes in /dev gracefully... Sep 12 17:44:50.232517 systemd[1]: Starting systemd-tmpfiles-setup.service - Create System Files and Directories... Sep 12 17:44:50.236730 systemd[1]: Finished systemd-vconsole-setup.service - Virtual Console Setup. Sep 12 17:44:50.280514 systemd-modules-load[234]: Inserted module 'overlay' Sep 12 17:44:50.282060 systemd[1]: Starting dracut-cmdline-ask.service - dracut ask for additional cmdline parameters... Sep 12 17:44:50.288389 systemd[1]: Finished systemd-tmpfiles-setup-dev-early.service - Create Static Device Nodes in /dev gracefully. Sep 12 17:44:50.291987 systemd-tmpfiles[245]: /usr/lib/tmpfiles.d/var.conf:14: Duplicate line for path "/var/log", ignoring. Sep 12 17:44:50.298500 systemd[1]: Finished systemd-tmpfiles-setup.service - Create System Files and Directories. Sep 12 17:44:50.301812 systemd[1]: Starting systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev... Sep 12 17:44:50.312103 systemd[1]: Finished dracut-cmdline-ask.service - dracut ask for additional cmdline parameters. Sep 12 17:44:50.323131 systemd[1]: Starting dracut-cmdline.service - dracut cmdline hook... Sep 12 17:44:50.327273 systemd[1]: Finished systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev. Sep 12 17:44:50.349717 dracut-cmdline[265]: 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=271a44cc8ea1639cfb6fdf777202a5f025fda0b3ce9b293cc4e0e7047aecb858 Sep 12 17:44:50.376656 kernel: bridge: filtering via arp/ip/ip6tables is no longer available by default. Update your scripts to load br_netfilter if you need this. Sep 12 17:44:50.379101 systemd-modules-load[234]: Inserted module 'br_netfilter' Sep 12 17:44:50.380742 kernel: Bridge firewalling registered Sep 12 17:44:50.380222 systemd[1]: Finished systemd-modules-load.service - Load Kernel Modules. Sep 12 17:44:50.382437 systemd[1]: Starting systemd-sysctl.service - Apply Kernel Variables... Sep 12 17:44:50.410938 systemd[1]: Finished systemd-sysctl.service - Apply Kernel Variables. Sep 12 17:44:50.420531 systemd[1]: Starting systemd-resolved.service - Network Name Resolution... Sep 12 17:44:50.467440 systemd-resolved[322]: Positive Trust Anchors: Sep 12 17:44:50.467455 systemd-resolved[322]: . IN DS 20326 8 2 e06d44b80b8f1d39a95c0b0d7c65d08458e880409bbc683457104237c7f8ec8d Sep 12 17:44:50.467485 systemd-resolved[322]: 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 Sep 12 17:44:50.470059 systemd-resolved[322]: Defaulting to hostname 'linux'. Sep 12 17:44:50.471102 systemd[1]: Started systemd-resolved.service - Network Name Resolution. Sep 12 17:44:50.480468 systemd[1]: Reached target nss-lookup.target - Host and Network Name Lookups. Sep 12 17:44:50.534386 kernel: SCSI subsystem initialized Sep 12 17:44:50.544385 kernel: Loading iSCSI transport class v2.0-870. Sep 12 17:44:50.556382 kernel: iscsi: registered transport (tcp) Sep 12 17:44:50.579487 kernel: iscsi: registered transport (qla4xxx) Sep 12 17:44:50.579529 kernel: QLogic iSCSI HBA Driver Sep 12 17:44:50.599289 systemd[1]: Starting systemd-network-generator.service - Generate network units from Kernel command line... Sep 12 17:44:50.631090 systemd[1]: Finished systemd-network-generator.service - Generate network units from Kernel command line. Sep 12 17:44:50.633739 systemd[1]: Reached target network-pre.target - Preparation for Network. Sep 12 17:44:50.687766 systemd[1]: Finished dracut-cmdline.service - dracut cmdline hook. Sep 12 17:44:50.690675 systemd[1]: Starting dracut-pre-udev.service - dracut pre-udev hook... Sep 12 17:44:50.761384 kernel: raid6: avx2x4 gen() 30837 MB/s Sep 12 17:44:50.780374 kernel: raid6: avx2x2 gen() 31208 MB/s Sep 12 17:44:50.801453 kernel: raid6: avx2x1 gen() 27959 MB/s Sep 12 17:44:50.801477 kernel: raid6: using algorithm avx2x2 gen() 31208 MB/s Sep 12 17:44:50.824602 kernel: raid6: .... xor() 18533 MB/s, rmw enabled Sep 12 17:44:50.824658 kernel: raid6: using avx2x2 recovery algorithm Sep 12 17:44:50.847395 kernel: xor: automatically using best checksumming function avx Sep 12 17:44:51.007392 kernel: Btrfs loaded, zoned=no, fsverity=no Sep 12 17:44:51.014339 systemd[1]: Finished dracut-pre-udev.service - dracut pre-udev hook. Sep 12 17:44:51.017299 systemd[1]: Starting systemd-udevd.service - Rule-based Manager for Device Events and Files... Sep 12 17:44:51.056306 systemd-udevd[485]: Using default interface naming scheme 'v255'. Sep 12 17:44:51.062626 systemd[1]: Started systemd-udevd.service - Rule-based Manager for Device Events and Files. Sep 12 17:44:51.064155 systemd[1]: Starting dracut-pre-trigger.service - dracut pre-trigger hook... Sep 12 17:44:51.102677 dracut-pre-trigger[491]: rd.md=0: removing MD RAID activation Sep 12 17:44:51.130037 systemd[1]: Finished dracut-pre-trigger.service - dracut pre-trigger hook. Sep 12 17:44:51.132751 systemd[1]: Starting systemd-udev-trigger.service - Coldplug All udev Devices... Sep 12 17:44:51.214257 systemd[1]: Finished systemd-udev-trigger.service - Coldplug All udev Devices. Sep 12 17:44:51.224811 systemd[1]: Starting dracut-initqueue.service - dracut initqueue hook... Sep 12 17:44:51.247385 kernel: cryptd: max_cpu_qlen set to 1000 Sep 12 17:44:51.257382 kernel: AES CTR mode by8 optimization enabled Sep 12 17:44:51.260373 kernel: hv_vmbus: Vmbus version:4.0 Sep 12 17:44:51.280802 systemd[1]: systemd-vconsole-setup.service: Deactivated successfully. Sep 12 17:44:51.299180 kernel: pps_core: LinuxPPS API ver. 1 registered Sep 12 17:44:51.299206 kernel: pps_core: Software ver. 5.3.6 - Copyright 2005-2007 Rodolfo Giometti Sep 12 17:44:51.299226 kernel: hv_vmbus: registering driver hv_netvsc Sep 12 17:44:51.299239 kernel: PTP clock support registered Sep 12 17:44:51.280938 systemd[1]: Stopped systemd-vconsole-setup.service - Virtual Console Setup. Sep 12 17:44:51.301464 systemd[1]: Stopping systemd-vconsole-setup.service - Virtual Console Setup... Sep 12 17:44:51.306883 systemd[1]: Starting systemd-vconsole-setup.service - Virtual Console Setup... Sep 12 17:44:51.316772 systemd[1]: run-credentials-systemd\x2dvconsole\x2dsetup.service.mount: Deactivated successfully. Sep 12 17:44:51.330385 kernel: hv_vmbus: registering driver hyperv_keyboard Sep 12 17:44:51.330420 kernel: hv_vmbus: registering driver hv_pci Sep 12 17:44:51.330433 kernel: hv_vmbus: registering driver hv_storvsc Sep 12 17:44:51.334180 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 Sep 12 17:44:51.334219 kernel: scsi host1: storvsc_host_t Sep 12 17:44:51.334432 kernel: scsi host0: storvsc_host_t Sep 12 17:44:51.334581 kernel: scsi 1:0:0:0: Direct-Access Msft Virtual Disk 1.0 PQ: 0 ANSI: 5 Sep 12 17:44:51.343416 kernel: hv_pci 47505500-0001-0000-3130-444531444234: PCI VMBus probing: Using version 0x10004 Sep 12 17:44:51.349379 kernel: hid: raw HID events driver (C) Jiri Kosina Sep 12 17:44:51.349408 kernel: scsi 1:0:0:1: Direct-Access Msft Virtual Disk 1.0 PQ: 0 ANSI: 5 Sep 12 17:44:51.350399 kernel: hv_pci 47505500-0001-0000-3130-444531444234: PCI host bridge to bus 0001:00 Sep 12 17:44:51.350563 kernel: pci_bus 0001:00: root bus resource [mem 0x41000000-0x41ffffff window] Sep 12 17:44:51.350710 kernel: pci_bus 0001:00: root bus resource [mem 0x1000000000-0x1401ffffff window] Sep 12 17:44:51.350831 kernel: pci_bus 0001:00: No busn resource found for root bus, will use [bus 00-ff] Sep 12 17:44:51.351383 kernel: pci 0001:00:00.0: [10de:1db4] type 00 class 0x030200 PCIe Endpoint Sep 12 17:44:51.352441 kernel: pci 0001:00:00.0: BAR 0 [mem 0x41000000-0x41ffffff] Sep 12 17:44:51.353383 kernel: pci 0001:00:00.0: BAR 1 [mem 0x1000000000-0x13ffffffff 64bit pref] Sep 12 17:44:51.353426 kernel: pci 0001:00:00.0: BAR 3 [mem 0x1400000000-0x1401ffffff 64bit pref] Sep 12 17:44:51.357384 kernel: hv_utils: Registering HyperV Utility Driver Sep 12 17:44:51.367042 kernel: pci 0001:00:00.0: Enabling HDA controller Sep 12 17:44:51.367137 kernel: hv_vmbus: registering driver hv_utils Sep 12 17:44:51.386375 kernel: pci_bus 0001:00: busn_res: [bus 00-ff] end is updated to 00 Sep 12 17:44:51.386563 kernel: scsi 1:0:0:2: CD-ROM Msft Virtual DVD-ROM 1.0 PQ: 0 ANSI: 0 Sep 12 17:44:51.392721 kernel: pci 0001:00:00.0: BAR 1 [mem 0x1000000000-0x13ffffffff 64bit pref]: assigned Sep 12 17:44:51.420957 kernel: pci 0001:00:00.0: BAR 3 [mem 0x1400000000-0x1401ffffff 64bit pref]: assigned Sep 12 17:44:51.425421 kernel: pci 0001:00:00.0: BAR 0 [mem 0x41000000-0x41ffffff]: assigned Sep 12 17:44:51.427607 systemd[1]: Finished systemd-vconsole-setup.service - Virtual Console Setup. Sep 12 17:44:51.519903 kernel: hv_utils: Heartbeat IC version 3.0 Sep 12 17:44:51.519934 kernel: hv_utils: Shutdown IC version 3.2 Sep 12 17:44:51.522385 kernel: hv_utils: TimeSync IC version 4.0 Sep 12 17:44:52.517798 systemd-resolved[322]: Clock change detected. Flushing caches. Sep 12 17:44:52.524595 kernel: hv_vmbus: registering driver hid_hyperv Sep 12 17:44:52.534665 kernel: input: Microsoft Vmbus HID-compliant Mouse as /devices/0006:045E:0621.0001/input/input1 Sep 12 17:44:52.534703 kernel: hid-hyperv 0006:045E:0621.0001: input: VIRTUAL HID v0.01 Mouse [Microsoft Vmbus HID-compliant Mouse] on Sep 12 17:44:52.535674 kernel: sd 1:0:0:1: [sda] 1543503872 512-byte logical blocks: (790 GB/736 GiB) Sep 12 17:44:52.535860 kernel: sd 1:0:0:0: [sdb] 63737856 512-byte logical blocks: (32.6 GB/30.4 GiB) Sep 12 17:44:52.542827 kernel: sd 1:0:0:1: [sda] 4096-byte physical blocks Sep 12 17:44:52.543001 kernel: sd 1:0:0:0: [sdb] 4096-byte physical blocks Sep 12 17:44:52.547951 kernel: sd 1:0:0:1: [sda] Write Protect is off Sep 12 17:44:52.553288 kernel: sd 1:0:0:0: [sdb] Write Protect is off Sep 12 17:44:52.553449 kernel: sd 1:0:0:1: [sda] Mode Sense: 0f 00 10 00 Sep 12 17:44:52.553599 kernel: sd 1:0:0:0: [sdb] Mode Sense: 0f 00 10 00 Sep 12 17:44:52.554591 kernel: sd 1:0:0:1: [sda] Write cache: disabled, read cache: enabled, supports DPO and FUA Sep 12 17:44:52.559593 kernel: sd 1:0:0:0: [sdb] Write cache: disabled, read cache: enabled, supports DPO and FUA Sep 12 17:44:52.564337 kernel: hv_storvsc f8b3781a-1e82-4818-a1c3-63d806ec15bb: tag#262 cmd 0x5a status: scsi 0x2 srb 0x86 hv 0xc0000001 Sep 12 17:44:52.570591 kernel: hv_storvsc f8b3781a-1e82-4818-a1c3-63d806ec15bb: tag#92 cmd 0x5a status: scsi 0x2 srb 0x86 hv 0xc0000001 Sep 12 17:44:52.580588 kernel: hv_storvsc f8b3781a-1e82-4818-a1c3-63d806ec15bb: tag#269 cmd 0x5a status: scsi 0x2 srb 0x86 hv 0xc0000001 Sep 12 17:44:52.586591 kernel: hv_storvsc f8b3781a-1e82-4818-a1c3-63d806ec15bb: tag#99 cmd 0x5a status: scsi 0x2 srb 0x86 hv 0xc0000001 Sep 12 17:44:52.597594 kernel: sda: sda1 Sep 12 17:44:52.597631 kernel: sd 1:0:0:1: [sda] Attached SCSI disk Sep 12 17:44:52.608395 kernel: sdb: sdb1 sdb2 sdb3 sdb4 sdb6 sdb7 sdb9 Sep 12 17:44:52.608423 kernel: sd 1:0:0:0: [sdb] Attached SCSI disk Sep 12 17:44:52.609597 kernel: sr 1:0:0:2: [sr0] scsi-1 drive Sep 12 17:44:52.615313 kernel: cdrom: Uniform CD-ROM driver Revision: 3.20 Sep 12 17:44:52.616605 kernel: sr 1:0:0:2: Attached scsi CD-ROM sr0 Sep 12 17:44:53.176824 systemd[1]: Found device dev-disk-by\x2dlabel-OEM.device - Virtual_Disk OEM. Sep 12 17:44:53.198284 systemd[1]: Found device dev-disk-by\x2dlabel-ROOT.device - Virtual_Disk ROOT. Sep 12 17:44:53.241000 systemd[1]: Found device dev-disk-by\x2dlabel-EFI\x2dSYSTEM.device - Virtual_Disk EFI-SYSTEM. Sep 12 17:44:53.252318 systemd[1]: Found device dev-disk-by\x2dpartuuid-7130c94a\x2d213a\x2d4e5a\x2d8e26\x2d6cce9662f132.device - Virtual_Disk USR-A. Sep 12 17:44:53.266463 systemd[1]: Found device dev-disk-by\x2dpartlabel-USR\x2dA.device - Virtual_Disk USR-A. Sep 12 17:44:53.285895 systemd[1]: Starting disk-uuid.service - Generate new UUID for disk GPT if necessary... Sep 12 17:44:53.328595 kernel: hv_storvsc f8b3781a-1e82-4818-a1c3-63d806ec15bb: tag#313 cmd 0x5a status: scsi 0x2 srb 0x86 hv 0xc0000001 Sep 12 17:44:53.339592 kernel: sdb: sdb1 sdb2 sdb3 sdb4 sdb6 sdb7 sdb9 Sep 12 17:44:54.353293 kernel: hv_storvsc f8b3781a-1e82-4818-a1c3-63d806ec15bb: tag#476 cmd 0x5a status: scsi 0x2 srb 0x86 hv 0xc0000001 Sep 12 17:44:54.371595 kernel: sdb: sdb1 sdb2 sdb3 sdb4 sdb6 sdb7 sdb9 Sep 12 17:44:54.372013 disk-uuid[722]: The operation has completed successfully. Sep 12 17:44:54.880707 systemd[1]: disk-uuid.service: Deactivated successfully. Sep 12 17:44:54.880823 systemd[1]: Finished disk-uuid.service - Generate new UUID for disk GPT if necessary. Sep 12 17:44:54.893974 systemd[1]: Finished dracut-initqueue.service - dracut initqueue hook. Sep 12 17:44:54.903410 systemd[1]: Reached target remote-fs-pre.target - Preparation for Remote File Systems. Sep 12 17:44:54.913676 systemd[1]: Reached target remote-cryptsetup.target - Remote Encrypted Volumes. Sep 12 17:44:54.923391 systemd[1]: Reached target remote-fs.target - Remote File Systems. Sep 12 17:44:54.932712 systemd[1]: Starting dracut-pre-mount.service - dracut pre-mount hook... Sep 12 17:44:54.958134 systemd[1]: Starting verity-setup.service - Verity Setup for /dev/mapper/usr... Sep 12 17:44:54.967099 systemd[1]: Finished dracut-pre-mount.service - dracut pre-mount hook. Sep 12 17:44:54.976626 sh[893]: Success Sep 12 17:44:55.021593 kernel: device-mapper: core: CONFIG_IMA_DISABLE_HTABLE is disabled. Duplicate IMA measurements will not be recorded in the IMA log. Sep 12 17:44:55.021632 kernel: device-mapper: uevent: version 1.0.3 Sep 12 17:44:55.029066 kernel: device-mapper: ioctl: 4.48.0-ioctl (2023-03-01) initialised: dm-devel@lists.linux.dev Sep 12 17:44:55.040594 kernel: device-mapper: verity: sha256 using shash "sha256-avx2" Sep 12 17:44:55.390011 systemd[1]: Found device dev-mapper-usr.device - /dev/mapper/usr. Sep 12 17:44:55.400286 systemd[1]: Mounting sysusr-usr.mount - /sysusr/usr... Sep 12 17:44:55.413043 systemd[1]: Finished verity-setup.service - Verity Setup for /dev/mapper/usr. Sep 12 17:44:55.431596 kernel: BTRFS: device fsid 74707491-1b86-4926-8bdb-c533ce2a0c32 devid 1 transid 38 /dev/mapper/usr (254:0) scanned by mount (912) Sep 12 17:44:55.437595 kernel: BTRFS info (device dm-0): first mount of filesystem 74707491-1b86-4926-8bdb-c533ce2a0c32 Sep 12 17:44:55.437625 kernel: BTRFS info (device dm-0): using crc32c (crc32c-intel) checksum algorithm Sep 12 17:44:55.924379 kernel: BTRFS info (device dm-0): disabling log replay at mount time Sep 12 17:44:55.924452 kernel: BTRFS info (device dm-0): enabling free space tree Sep 12 17:44:55.971290 systemd[1]: Mounted sysusr-usr.mount - /sysusr/usr. Sep 12 17:44:55.975313 systemd[1]: Reached target initrd-usr-fs.target - Initrd /usr File System. Sep 12 17:44:55.983356 systemd[1]: afterburn-network-kargs.service - Afterburn Initrd Setup Network Kernel Arguments was skipped because no trigger condition checks were met. Sep 12 17:44:55.984330 systemd[1]: Starting ignition-setup.service - Ignition (setup)... Sep 12 17:44:55.993556 systemd[1]: Starting parse-ip-for-networkd.service - Write systemd-networkd units from cmdline... Sep 12 17:44:56.040596 kernel: BTRFS: device label OEM devid 1 transid 12 /dev/sdb6 (8:22) scanned by mount (963) Sep 12 17:44:56.050000 kernel: BTRFS info (device sdb6): first mount of filesystem 5410dae6-8d31-4ea4-a4b4-868064445761 Sep 12 17:44:56.050031 kernel: BTRFS info (device sdb6): using crc32c (crc32c-intel) checksum algorithm Sep 12 17:44:56.086330 systemd[1]: Finished parse-ip-for-networkd.service - Write systemd-networkd units from cmdline. Sep 12 17:44:56.099773 kernel: BTRFS info (device sdb6): turning on async discard Sep 12 17:44:56.099800 kernel: BTRFS info (device sdb6): enabling free space tree Sep 12 17:44:56.104165 systemd[1]: Starting systemd-networkd.service - Network Configuration... Sep 12 17:44:56.118592 kernel: BTRFS info (device sdb6): last unmount of filesystem 5410dae6-8d31-4ea4-a4b4-868064445761 Sep 12 17:44:56.129692 systemd[1]: Finished ignition-setup.service - Ignition (setup). Sep 12 17:44:56.132194 systemd[1]: Starting ignition-fetch-offline.service - Ignition (fetch-offline)... Sep 12 17:44:56.170134 systemd-networkd[1078]: lo: Link UP Sep 12 17:44:56.170145 systemd-networkd[1078]: lo: Gained carrier Sep 12 17:44:56.171163 systemd-networkd[1078]: Enumeration completed Sep 12 17:44:56.171529 systemd-networkd[1078]: eth0: found matching network '/usr/lib/systemd/network/zz-default.network', based on potentially unpredictable interface name. Sep 12 17:44:56.171533 systemd-networkd[1078]: eth0: Configuring with /usr/lib/systemd/network/zz-default.network. Sep 12 17:44:56.172303 systemd-networkd[1078]: eth0: Link UP Sep 12 17:44:56.172465 systemd-networkd[1078]: eth0: Gained carrier Sep 12 17:44:56.172475 systemd-networkd[1078]: eth0: found matching network '/usr/lib/systemd/network/zz-default.network', based on potentially unpredictable interface name. Sep 12 17:44:56.172967 systemd[1]: Started systemd-networkd.service - Network Configuration. Sep 12 17:44:56.179972 systemd[1]: Reached target network.target - Network. Sep 12 17:44:56.225614 systemd-networkd[1078]: eth0: DHCPv4 address 10.200.8.11/24, gateway 10.200.8.1 acquired from 168.63.129.16 Sep 12 17:44:57.993699 systemd-networkd[1078]: eth0: Gained IPv6LL Sep 12 17:44:58.368086 ignition[1082]: Ignition 2.21.0 Sep 12 17:44:58.368100 ignition[1082]: Stage: fetch-offline Sep 12 17:44:58.368208 ignition[1082]: no configs at "/usr/lib/ignition/base.d" Sep 12 17:44:58.368217 ignition[1082]: no config dir at "/usr/lib/ignition/base.platform.d/azure" Sep 12 17:44:58.368319 ignition[1082]: parsed url from cmdline: "" Sep 12 17:44:58.368323 ignition[1082]: no config URL provided Sep 12 17:44:58.368328 ignition[1082]: reading system config file "/usr/lib/ignition/user.ign" Sep 12 17:44:58.368337 ignition[1082]: no config at "/usr/lib/ignition/user.ign" Sep 12 17:44:58.368343 ignition[1082]: failed to fetch config: resource requires networking Sep 12 17:44:58.368524 ignition[1082]: Ignition finished successfully Sep 12 17:44:58.403739 systemd[1]: Finished ignition-fetch-offline.service - Ignition (fetch-offline). Sep 12 17:44:58.406219 systemd[1]: Starting ignition-fetch.service - Ignition (fetch)... Sep 12 17:44:58.457922 ignition[1094]: Ignition 2.21.0 Sep 12 17:44:58.457935 ignition[1094]: Stage: fetch Sep 12 17:44:58.458135 ignition[1094]: no configs at "/usr/lib/ignition/base.d" Sep 12 17:44:58.458147 ignition[1094]: no config dir at "/usr/lib/ignition/base.platform.d/azure" Sep 12 17:44:58.458239 ignition[1094]: parsed url from cmdline: "" Sep 12 17:44:58.458243 ignition[1094]: no config URL provided Sep 12 17:44:58.458249 ignition[1094]: reading system config file "/usr/lib/ignition/user.ign" Sep 12 17:44:58.458258 ignition[1094]: no config at "/usr/lib/ignition/user.ign" Sep 12 17:44:58.458290 ignition[1094]: GET http://169.254.169.254/metadata/instance/compute/userData?api-version=2021-01-01&format=text: attempt #1 Sep 12 17:44:58.558700 ignition[1094]: GET result: OK Sep 12 17:44:58.558753 ignition[1094]: config has been read from IMDS userdata Sep 12 17:44:58.558766 ignition[1094]: parsing config with SHA512: 0d127cc7e8c4ffd9a4bfe3480ee53864b77f15a1f4f1842bbfe00b62e27e1a447b3e720fd0025364b998f16765184545e9cdb88c7ce3e2e98f0e8e678192c1c0 Sep 12 17:44:58.562058 unknown[1094]: fetched base config from "system" Sep 12 17:44:58.562224 ignition[1094]: fetch: fetch complete Sep 12 17:44:58.562065 unknown[1094]: fetched base config from "system" Sep 12 17:44:58.562229 ignition[1094]: fetch: fetch passed Sep 12 17:44:58.562071 unknown[1094]: fetched user config from "azure" Sep 12 17:44:58.562273 ignition[1094]: Ignition finished successfully Sep 12 17:44:58.569815 systemd[1]: Finished ignition-fetch.service - Ignition (fetch). Sep 12 17:44:58.577599 systemd[1]: Starting ignition-kargs.service - Ignition (kargs)... Sep 12 17:44:58.630249 ignition[1104]: Ignition 2.21.0 Sep 12 17:44:58.630262 ignition[1104]: Stage: kargs Sep 12 17:44:58.630539 ignition[1104]: no configs at "/usr/lib/ignition/base.d" Sep 12 17:44:58.630551 ignition[1104]: no config dir at "/usr/lib/ignition/base.platform.d/azure" Sep 12 17:44:58.636488 systemd[1]: Finished ignition-kargs.service - Ignition (kargs). Sep 12 17:44:58.631800 ignition[1104]: kargs: kargs passed Sep 12 17:44:58.644547 systemd[1]: Starting ignition-disks.service - Ignition (disks)... Sep 12 17:44:58.631875 ignition[1104]: Ignition finished successfully Sep 12 17:44:58.682222 ignition[1113]: Ignition 2.21.0 Sep 12 17:44:58.682236 ignition[1113]: Stage: disks Sep 12 17:44:58.682508 ignition[1113]: no configs at "/usr/lib/ignition/base.d" Sep 12 17:44:58.682521 ignition[1113]: no config dir at "/usr/lib/ignition/base.platform.d/azure" Sep 12 17:44:58.683343 ignition[1113]: disks: disks passed Sep 12 17:44:58.692075 systemd[1]: Finished ignition-disks.service - Ignition (disks). Sep 12 17:44:58.683390 ignition[1113]: Ignition finished successfully Sep 12 17:44:58.695563 systemd[1]: Reached target initrd-root-device.target - Initrd Root Device. Sep 12 17:44:58.705665 systemd[1]: Reached target local-fs-pre.target - Preparation for Local File Systems. Sep 12 17:44:58.707115 systemd[1]: Reached target local-fs.target - Local File Systems. Sep 12 17:44:58.718889 systemd[1]: Reached target sysinit.target - System Initialization. Sep 12 17:44:58.726557 systemd[1]: Reached target basic.target - Basic System. Sep 12 17:44:58.739173 systemd[1]: Starting systemd-fsck-root.service - File System Check on /dev/disk/by-label/ROOT... Sep 12 17:44:58.848361 systemd-fsck[1124]: ROOT: clean, 15/7326000 files, 477845/7359488 blocks Sep 12 17:44:58.855271 systemd[1]: Finished systemd-fsck-root.service - File System Check on /dev/disk/by-label/ROOT. Sep 12 17:44:58.857684 systemd[1]: Mounting sysroot.mount - /sysroot... Sep 12 17:45:00.787594 kernel: EXT4-fs (sdb9): mounted filesystem 26739aba-b0be-4ce3-bfbd-ca4dbcbe2426 r/w with ordered data mode. Quota mode: none. Sep 12 17:45:00.787802 systemd[1]: Mounted sysroot.mount - /sysroot. Sep 12 17:45:00.791771 systemd[1]: Reached target initrd-root-fs.target - Initrd Root File System. Sep 12 17:45:00.824104 systemd[1]: Mounting sysroot-oem.mount - /sysroot/oem... Sep 12 17:45:00.850076 systemd[1]: Mounting sysroot-usr.mount - /sysroot/usr... Sep 12 17:45:00.852521 systemd[1]: Starting flatcar-metadata-hostname.service - Flatcar Metadata Hostname Agent... Sep 12 17:45:00.871128 kernel: BTRFS: device label OEM devid 1 transid 12 /dev/sdb6 (8:22) scanned by mount (1138) Sep 12 17:45:00.858371 systemd[1]: ignition-remount-sysroot.service - Remount /sysroot read-write for Ignition was skipped because of an unmet condition check (ConditionPathIsReadWrite=!/sysroot). Sep 12 17:45:00.899126 kernel: BTRFS info (device sdb6): first mount of filesystem 5410dae6-8d31-4ea4-a4b4-868064445761 Sep 12 17:45:00.899147 kernel: BTRFS info (device sdb6): using crc32c (crc32c-intel) checksum algorithm Sep 12 17:45:00.899160 kernel: BTRFS info (device sdb6): turning on async discard Sep 12 17:45:00.899172 kernel: BTRFS info (device sdb6): enabling free space tree Sep 12 17:45:00.858399 systemd[1]: Reached target ignition-diskful.target - Ignition Boot Disk Setup. Sep 12 17:45:00.882814 systemd[1]: Mounted sysroot-usr.mount - /sysroot/usr. Sep 12 17:45:00.901649 systemd[1]: Mounted sysroot-oem.mount - /sysroot/oem. Sep 12 17:45:00.909779 systemd[1]: Starting initrd-setup-root.service - Root filesystem setup... Sep 12 17:45:01.845883 coreos-metadata[1140]: Sep 12 17:45:01.845 INFO Fetching http://168.63.129.16/?comp=versions: Attempt #1 Sep 12 17:45:01.851856 coreos-metadata[1140]: Sep 12 17:45:01.851 INFO Fetch successful Sep 12 17:45:01.851856 coreos-metadata[1140]: Sep 12 17:45:01.851 INFO Fetching http://169.254.169.254/metadata/instance/compute/name?api-version=2017-08-01&format=text: Attempt #1 Sep 12 17:45:01.863609 coreos-metadata[1140]: Sep 12 17:45:01.855 INFO Fetch successful Sep 12 17:45:01.863609 coreos-metadata[1140]: Sep 12 17:45:01.863 INFO wrote hostname ci-4426.1.0-a-b6cbffdee1 to /sysroot/etc/hostname Sep 12 17:45:01.864740 systemd[1]: Finished flatcar-metadata-hostname.service - Flatcar Metadata Hostname Agent. Sep 12 17:45:02.208697 initrd-setup-root[1168]: cut: /sysroot/etc/passwd: No such file or directory Sep 12 17:45:02.282152 initrd-setup-root[1175]: cut: /sysroot/etc/group: No such file or directory Sep 12 17:45:02.297343 initrd-setup-root[1182]: cut: /sysroot/etc/shadow: No such file or directory Sep 12 17:45:02.317944 initrd-setup-root[1189]: cut: /sysroot/etc/gshadow: No such file or directory Sep 12 17:45:03.555270 systemd[1]: Finished initrd-setup-root.service - Root filesystem setup. Sep 12 17:45:03.558063 systemd[1]: Starting ignition-mount.service - Ignition (mount)... Sep 12 17:45:03.578116 systemd[1]: Starting sysroot-boot.service - /sysroot/boot... Sep 12 17:45:03.583664 systemd[1]: sysroot-oem.mount: Deactivated successfully. Sep 12 17:45:03.595959 kernel: BTRFS info (device sdb6): last unmount of filesystem 5410dae6-8d31-4ea4-a4b4-868064445761 Sep 12 17:45:03.617848 ignition[1257]: INFO : Ignition 2.21.0 Sep 12 17:45:03.620866 ignition[1257]: INFO : Stage: mount Sep 12 17:45:03.620866 ignition[1257]: INFO : no configs at "/usr/lib/ignition/base.d" Sep 12 17:45:03.620866 ignition[1257]: INFO : no config dir at "/usr/lib/ignition/base.platform.d/azure" Sep 12 17:45:03.620866 ignition[1257]: INFO : mount: mount passed Sep 12 17:45:03.620866 ignition[1257]: INFO : Ignition finished successfully Sep 12 17:45:03.625215 systemd[1]: Finished sysroot-boot.service - /sysroot/boot. Sep 12 17:45:03.629091 systemd[1]: Finished ignition-mount.service - Ignition (mount). Sep 12 17:45:03.646534 systemd[1]: Starting ignition-files.service - Ignition (files)... Sep 12 17:45:03.680982 systemd[1]: Mounting sysroot-oem.mount - /sysroot/oem... Sep 12 17:45:03.704604 kernel: BTRFS: device label OEM devid 1 transid 12 /dev/sdb6 (8:22) scanned by mount (1273) Sep 12 17:45:03.704636 kernel: BTRFS info (device sdb6): first mount of filesystem 5410dae6-8d31-4ea4-a4b4-868064445761 Sep 12 17:45:03.713343 kernel: BTRFS info (device sdb6): using crc32c (crc32c-intel) checksum algorithm Sep 12 17:45:03.723990 kernel: BTRFS info (device sdb6): turning on async discard Sep 12 17:45:03.724018 kernel: BTRFS info (device sdb6): enabling free space tree Sep 12 17:45:03.726203 systemd[1]: Mounted sysroot-oem.mount - /sysroot/oem. Sep 12 17:45:03.769483 ignition[1290]: INFO : Ignition 2.21.0 Sep 12 17:45:03.769483 ignition[1290]: INFO : Stage: files Sep 12 17:45:03.775302 ignition[1290]: INFO : no configs at "/usr/lib/ignition/base.d" Sep 12 17:45:03.775302 ignition[1290]: INFO : no config dir at "/usr/lib/ignition/base.platform.d/azure" Sep 12 17:45:03.775302 ignition[1290]: DEBUG : files: compiled without relabeling support, skipping Sep 12 17:45:03.788274 ignition[1290]: INFO : files: ensureUsers: op(1): [started] creating or modifying user "core" Sep 12 17:45:03.788274 ignition[1290]: DEBUG : files: ensureUsers: op(1): executing: "usermod" "--root" "/sysroot" "core" Sep 12 17:45:03.847720 ignition[1290]: INFO : files: ensureUsers: op(1): [finished] creating or modifying user "core" Sep 12 17:45:03.853168 ignition[1290]: INFO : files: ensureUsers: op(2): [started] adding ssh keys to user "core" Sep 12 17:45:03.853168 ignition[1290]: INFO : files: ensureUsers: op(2): [finished] adding ssh keys to user "core" Sep 12 17:45:03.848436 unknown[1290]: wrote ssh authorized keys file for user: core Sep 12 17:45:03.924364 ignition[1290]: INFO : files: createFilesystemsFiles: createFiles: op(3): [started] writing file "/sysroot/etc/flatcar/update.conf" Sep 12 17:45:03.931548 ignition[1290]: INFO : files: createFilesystemsFiles: createFiles: op(3): [finished] writing file "/sysroot/etc/flatcar/update.conf" Sep 12 17:45:03.931548 ignition[1290]: INFO : files: createResultFile: createFiles: op(4): [started] writing file "/sysroot/etc/.ignition-result.json" Sep 12 17:45:03.931548 ignition[1290]: INFO : files: createResultFile: createFiles: op(4): [finished] writing file "/sysroot/etc/.ignition-result.json" Sep 12 17:45:03.931548 ignition[1290]: INFO : files: files passed Sep 12 17:45:03.931548 ignition[1290]: INFO : Ignition finished successfully Sep 12 17:45:03.932662 systemd[1]: Finished ignition-files.service - Ignition (files). Sep 12 17:45:03.943964 systemd[1]: Starting ignition-quench.service - Ignition (record completion)... Sep 12 17:45:03.954372 systemd[1]: Starting initrd-setup-root-after-ignition.service - Root filesystem completion... Sep 12 17:45:03.981192 systemd[1]: ignition-quench.service: Deactivated successfully. Sep 12 17:45:03.981293 systemd[1]: Finished ignition-quench.service - Ignition (record completion). Sep 12 17:45:04.024433 initrd-setup-root-after-ignition[1320]: grep: /sysroot/etc/flatcar/enabled-sysext.conf: No such file or directory Sep 12 17:45:04.024433 initrd-setup-root-after-ignition[1320]: grep: /sysroot/usr/share/flatcar/enabled-sysext.conf: No such file or directory Sep 12 17:45:04.046072 initrd-setup-root-after-ignition[1324]: grep: /sysroot/etc/flatcar/enabled-sysext.conf: No such file or directory Sep 12 17:45:04.055541 systemd[1]: Finished initrd-setup-root-after-ignition.service - Root filesystem completion. Sep 12 17:45:04.057288 systemd[1]: Reached target ignition-complete.target - Ignition Complete. Sep 12 17:45:04.068039 systemd[1]: Starting initrd-parse-etc.service - Mountpoints Configured in the Real Root... Sep 12 17:45:04.137356 systemd[1]: initrd-parse-etc.service: Deactivated successfully. Sep 12 17:45:04.137469 systemd[1]: Finished initrd-parse-etc.service - Mountpoints Configured in the Real Root. Sep 12 17:45:04.146061 systemd[1]: Reached target initrd-fs.target - Initrd File Systems. Sep 12 17:45:04.154842 systemd[1]: Reached target initrd.target - Initrd Default Target. Sep 12 17:45:04.162919 systemd[1]: dracut-mount.service - dracut mount hook was skipped because no trigger condition checks were met. Sep 12 17:45:04.163717 systemd[1]: Starting dracut-pre-pivot.service - dracut pre-pivot and cleanup hook... Sep 12 17:45:04.186997 systemd[1]: Finished dracut-pre-pivot.service - dracut pre-pivot and cleanup hook. Sep 12 17:45:04.190472 systemd[1]: Starting initrd-cleanup.service - Cleaning Up and Shutting Down Daemons... Sep 12 17:45:04.206204 systemd[1]: Stopped target nss-lookup.target - Host and Network Name Lookups. Sep 12 17:45:04.207748 systemd[1]: Stopped target remote-cryptsetup.target - Remote Encrypted Volumes. Sep 12 17:45:04.224420 systemd[1]: Stopped target timers.target - Timer Units. Sep 12 17:45:04.225966 systemd[1]: dracut-pre-pivot.service: Deactivated successfully. Sep 12 17:45:04.226099 systemd[1]: Stopped dracut-pre-pivot.service - dracut pre-pivot and cleanup hook. Sep 12 17:45:04.239887 systemd[1]: Stopped target initrd.target - Initrd Default Target. Sep 12 17:45:04.248300 systemd[1]: Stopped target basic.target - Basic System. Sep 12 17:45:04.255640 systemd[1]: Stopped target ignition-complete.target - Ignition Complete. Sep 12 17:45:04.263297 systemd[1]: Stopped target ignition-diskful.target - Ignition Boot Disk Setup. Sep 12 17:45:04.273001 systemd[1]: Stopped target initrd-root-device.target - Initrd Root Device. Sep 12 17:45:04.282150 systemd[1]: Stopped target initrd-usr-fs.target - Initrd /usr File System. Sep 12 17:45:04.290820 systemd[1]: Stopped target remote-fs.target - Remote File Systems. Sep 12 17:45:04.299104 systemd[1]: Stopped target remote-fs-pre.target - Preparation for Remote File Systems. Sep 12 17:45:04.307772 systemd[1]: Stopped target sysinit.target - System Initialization. Sep 12 17:45:04.316417 systemd[1]: Stopped target local-fs.target - Local File Systems. Sep 12 17:45:04.324175 systemd[1]: Stopped target swap.target - Swaps. Sep 12 17:45:04.331068 systemd[1]: dracut-pre-mount.service: Deactivated successfully. Sep 12 17:45:04.331212 systemd[1]: Stopped dracut-pre-mount.service - dracut pre-mount hook. Sep 12 17:45:04.341761 systemd[1]: Stopped target cryptsetup.target - Local Encrypted Volumes. Sep 12 17:45:04.343112 systemd[1]: Stopped target cryptsetup-pre.target - Local Encrypted Volumes (Pre). Sep 12 17:45:04.355399 systemd[1]: clevis-luks-askpass.path: Deactivated successfully. Sep 12 17:45:04.355532 systemd[1]: Stopped clevis-luks-askpass.path - Forward Password Requests to Clevis Directory Watch. Sep 12 17:45:04.364477 systemd[1]: dracut-initqueue.service: Deactivated successfully. Sep 12 17:45:04.364614 systemd[1]: Stopped dracut-initqueue.service - dracut initqueue hook. Sep 12 17:45:04.381367 systemd[1]: initrd-setup-root-after-ignition.service: Deactivated successfully. Sep 12 17:45:04.381497 systemd[1]: Stopped initrd-setup-root-after-ignition.service - Root filesystem completion. Sep 12 17:45:04.383745 systemd[1]: ignition-files.service: Deactivated successfully. Sep 12 17:45:04.383871 systemd[1]: Stopped ignition-files.service - Ignition (files). Sep 12 17:45:04.395368 systemd[1]: flatcar-metadata-hostname.service: Deactivated successfully. Sep 12 17:45:04.395490 systemd[1]: Stopped flatcar-metadata-hostname.service - Flatcar Metadata Hostname Agent. Sep 12 17:45:04.404537 systemd[1]: Stopping ignition-mount.service - Ignition (mount)... Sep 12 17:45:04.413169 systemd[1]: kmod-static-nodes.service: Deactivated successfully. Sep 12 17:45:04.413298 systemd[1]: Stopped kmod-static-nodes.service - Create List of Static Device Nodes. Sep 12 17:45:04.438182 systemd[1]: Stopping sysroot-boot.service - /sysroot/boot... Sep 12 17:45:04.442139 systemd[1]: systemd-udev-trigger.service: Deactivated successfully. Sep 12 17:45:04.442270 systemd[1]: Stopped systemd-udev-trigger.service - Coldplug All udev Devices. Sep 12 17:45:04.472543 ignition[1344]: INFO : Ignition 2.21.0 Sep 12 17:45:04.472543 ignition[1344]: INFO : Stage: umount Sep 12 17:45:04.472543 ignition[1344]: INFO : no configs at "/usr/lib/ignition/base.d" Sep 12 17:45:04.472543 ignition[1344]: INFO : no config dir at "/usr/lib/ignition/base.platform.d/azure" Sep 12 17:45:04.472543 ignition[1344]: INFO : umount: umount passed Sep 12 17:45:04.472543 ignition[1344]: INFO : Ignition finished successfully Sep 12 17:45:04.456680 systemd[1]: dracut-pre-trigger.service: Deactivated successfully. Sep 12 17:45:04.456802 systemd[1]: Stopped dracut-pre-trigger.service - dracut pre-trigger hook. Sep 12 17:45:04.471630 systemd[1]: initrd-cleanup.service: Deactivated successfully. Sep 12 17:45:04.471724 systemd[1]: Finished initrd-cleanup.service - Cleaning Up and Shutting Down Daemons. Sep 12 17:45:04.474164 systemd[1]: ignition-mount.service: Deactivated successfully. Sep 12 17:45:04.474253 systemd[1]: Stopped ignition-mount.service - Ignition (mount). Sep 12 17:45:04.482098 systemd[1]: ignition-disks.service: Deactivated successfully. Sep 12 17:45:04.482152 systemd[1]: Stopped ignition-disks.service - Ignition (disks). Sep 12 17:45:04.490275 systemd[1]: ignition-kargs.service: Deactivated successfully. Sep 12 17:45:04.490323 systemd[1]: Stopped ignition-kargs.service - Ignition (kargs). Sep 12 17:45:04.492415 systemd[1]: ignition-fetch.service: Deactivated successfully. Sep 12 17:45:04.492458 systemd[1]: Stopped ignition-fetch.service - Ignition (fetch). Sep 12 17:45:04.503957 systemd[1]: Stopped target network.target - Network. Sep 12 17:45:04.510845 systemd[1]: ignition-fetch-offline.service: Deactivated successfully. Sep 12 17:45:04.510897 systemd[1]: Stopped ignition-fetch-offline.service - Ignition (fetch-offline). Sep 12 17:45:04.517796 systemd[1]: Stopped target paths.target - Path Units. Sep 12 17:45:04.527430 systemd[1]: systemd-ask-password-console.path: Deactivated successfully. Sep 12 17:45:04.530651 systemd[1]: Stopped systemd-ask-password-console.path - Dispatch Password Requests to Console Directory Watch. Sep 12 17:45:04.534352 systemd[1]: Stopped target slices.target - Slice Units. Sep 12 17:45:04.545669 systemd[1]: Stopped target sockets.target - Socket Units. Sep 12 17:45:04.547149 systemd[1]: iscsid.socket: Deactivated successfully. Sep 12 17:45:04.547191 systemd[1]: Closed iscsid.socket - Open-iSCSI iscsid Socket. Sep 12 17:45:04.558867 systemd[1]: iscsiuio.socket: Deactivated successfully. Sep 12 17:45:04.558909 systemd[1]: Closed iscsiuio.socket - Open-iSCSI iscsiuio Socket. Sep 12 17:45:04.566369 systemd[1]: ignition-setup.service: Deactivated successfully. Sep 12 17:45:04.566423 systemd[1]: Stopped ignition-setup.service - Ignition (setup). Sep 12 17:45:04.580534 systemd[1]: ignition-setup-pre.service: Deactivated successfully. Sep 12 17:45:04.580598 systemd[1]: Stopped ignition-setup-pre.service - Ignition env setup. Sep 12 17:45:04.588815 systemd[1]: Stopping systemd-networkd.service - Network Configuration... Sep 12 17:45:04.596195 systemd[1]: Stopping systemd-resolved.service - Network Name Resolution... Sep 12 17:45:04.604774 systemd[1]: sysroot-boot.mount: Deactivated successfully. Sep 12 17:45:04.605338 systemd[1]: sysroot-boot.service: Deactivated successfully. Sep 12 17:45:04.605423 systemd[1]: Stopped sysroot-boot.service - /sysroot/boot. Sep 12 17:45:04.609125 systemd[1]: initrd-setup-root.service: Deactivated successfully. Sep 12 17:45:04.609202 systemd[1]: Stopped initrd-setup-root.service - Root filesystem setup. Sep 12 17:45:04.615687 systemd[1]: systemd-resolved.service: Deactivated successfully. Sep 12 17:45:04.615793 systemd[1]: Stopped systemd-resolved.service - Network Name Resolution. Sep 12 17:45:04.632867 systemd[1]: run-credentials-systemd\x2dresolved.service.mount: Deactivated successfully. Sep 12 17:45:04.633073 systemd[1]: systemd-networkd.service: Deactivated successfully. Sep 12 17:45:04.633192 systemd[1]: Stopped systemd-networkd.service - Network Configuration. Sep 12 17:45:04.648588 systemd[1]: run-credentials-systemd\x2dnetworkd.service.mount: Deactivated successfully. Sep 12 17:45:04.649428 systemd[1]: Stopped target network-pre.target - Preparation for Network. Sep 12 17:45:04.661865 systemd[1]: systemd-networkd.socket: Deactivated successfully. Sep 12 17:45:04.661908 systemd[1]: Closed systemd-networkd.socket - Network Service Netlink Socket. Sep 12 17:45:04.670380 systemd[1]: Stopping network-cleanup.service - Network Cleanup... Sep 12 17:45:04.676329 systemd[1]: parse-ip-for-networkd.service: Deactivated successfully. Sep 12 17:45:04.676382 systemd[1]: Stopped parse-ip-for-networkd.service - Write systemd-networkd units from cmdline. Sep 12 17:45:04.684822 systemd[1]: systemd-sysctl.service: Deactivated successfully. Sep 12 17:45:04.684869 systemd[1]: Stopped systemd-sysctl.service - Apply Kernel Variables. Sep 12 17:45:04.692418 systemd[1]: systemd-modules-load.service: Deactivated successfully. Sep 12 17:45:04.692463 systemd[1]: Stopped systemd-modules-load.service - Load Kernel Modules. Sep 12 17:45:04.694443 systemd[1]: systemd-tmpfiles-setup.service: Deactivated successfully. Sep 12 17:45:04.694494 systemd[1]: Stopped systemd-tmpfiles-setup.service - Create System Files and Directories. Sep 12 17:45:04.712776 systemd[1]: Stopping systemd-udevd.service - Rule-based Manager for Device Events and Files... Sep 12 17:45:04.715988 systemd[1]: run-credentials-systemd\x2dsysctl.service.mount: Deactivated successfully. Sep 12 17:45:04.716061 systemd[1]: run-credentials-systemd\x2dtmpfiles\x2dsetup.service.mount: Deactivated successfully. Sep 12 17:45:04.749800 systemd[1]: network-cleanup.service: Deactivated successfully. Sep 12 17:45:04.749999 systemd[1]: Stopped network-cleanup.service - Network Cleanup. Sep 12 17:45:04.756248 systemd[1]: systemd-udevd.service: Deactivated successfully. Sep 12 17:45:04.756396 systemd[1]: Stopped systemd-udevd.service - Rule-based Manager for Device Events and Files. Sep 12 17:45:04.758523 systemd[1]: systemd-udevd-control.socket: Deactivated successfully. Sep 12 17:45:04.758590 systemd[1]: Closed systemd-udevd-control.socket - udev Control Socket. Sep 12 17:45:04.769184 systemd[1]: systemd-udevd-kernel.socket: Deactivated successfully. Sep 12 17:45:04.769223 systemd[1]: Closed systemd-udevd-kernel.socket - udev Kernel Socket. Sep 12 17:45:04.776792 systemd[1]: dracut-pre-udev.service: Deactivated successfully. Sep 12 17:45:04.776846 systemd[1]: Stopped dracut-pre-udev.service - dracut pre-udev hook. Sep 12 17:45:04.795820 systemd[1]: dracut-cmdline.service: Deactivated successfully. Sep 12 17:45:04.795870 systemd[1]: Stopped dracut-cmdline.service - dracut cmdline hook. Sep 12 17:45:04.807783 systemd[1]: dracut-cmdline-ask.service: Deactivated successfully. Sep 12 17:45:04.807844 systemd[1]: Stopped dracut-cmdline-ask.service - dracut ask for additional cmdline parameters. Sep 12 17:45:04.820768 systemd[1]: Starting initrd-udevadm-cleanup-db.service - Cleanup udev Database... Sep 12 17:45:04.828211 systemd[1]: systemd-network-generator.service: Deactivated successfully. Sep 12 17:45:04.828267 systemd[1]: Stopped systemd-network-generator.service - Generate network units from Kernel command line. Sep 12 17:45:04.839352 systemd[1]: systemd-tmpfiles-setup-dev.service: Deactivated successfully. Sep 12 17:45:04.839406 systemd[1]: Stopped systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev. Sep 12 17:45:04.853296 systemd[1]: systemd-vconsole-setup.service: Deactivated successfully. Sep 12 17:45:04.853355 systemd[1]: Stopped systemd-vconsole-setup.service - Virtual Console Setup. Sep 12 17:45:04.865412 systemd[1]: run-credentials-systemd\x2dnetwork\x2dgenerator.service.mount: Deactivated successfully. Sep 12 17:45:04.865467 systemd[1]: run-credentials-systemd\x2dtmpfiles\x2dsetup\x2ddev.service.mount: Deactivated successfully. Sep 12 17:45:04.865511 systemd[1]: run-credentials-systemd\x2dvconsole\x2dsetup.service.mount: Deactivated successfully. Sep 12 17:45:04.865937 systemd[1]: initrd-udevadm-cleanup-db.service: Deactivated successfully. Sep 12 17:45:04.866033 systemd[1]: Finished initrd-udevadm-cleanup-db.service - Cleanup udev Database. Sep 12 17:45:04.869973 systemd[1]: Reached target initrd-switch-root.target - Switch Root. Sep 12 17:45:04.878597 systemd[1]: Starting initrd-switch-root.service - Switch Root... Sep 12 17:45:05.031955 systemd-journald[232]: Received SIGTERM from PID 1 (systemd). Sep 12 17:45:04.912119 systemd[1]: Switching root. Sep 12 17:45:05.034641 systemd-journald[232]: Journal stopped Sep 12 17:45:12.959234 kernel: SELinux: policy capability network_peer_controls=1 Sep 12 17:45:12.959271 kernel: SELinux: policy capability open_perms=1 Sep 12 17:45:12.959283 kernel: SELinux: policy capability extended_socket_class=1 Sep 12 17:45:12.959297 kernel: SELinux: policy capability always_check_network=0 Sep 12 17:45:12.959306 kernel: SELinux: policy capability cgroup_seclabel=1 Sep 12 17:45:12.959314 kernel: SELinux: policy capability nnp_nosuid_transition=1 Sep 12 17:45:12.959325 kernel: SELinux: policy capability genfs_seclabel_symlinks=0 Sep 12 17:45:12.959337 kernel: SELinux: policy capability ioctl_skip_cloexec=0 Sep 12 17:45:12.959346 kernel: SELinux: policy capability userspace_initial_context=0 Sep 12 17:45:12.959355 kernel: audit: type=1403 audit(1757699106.365:2): auid=4294967295 ses=4294967295 lsm=selinux res=1 Sep 12 17:45:12.959367 systemd[1]: Successfully loaded SELinux policy in 236.465ms. Sep 12 17:45:12.959378 systemd[1]: Relabeled /dev/, /dev/shm/, /run/ in 7.468ms. Sep 12 17:45:12.959390 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) Sep 12 17:45:12.959400 systemd[1]: Detected virtualization microsoft. Sep 12 17:45:12.959413 systemd[1]: Detected architecture x86-64. Sep 12 17:45:12.959424 systemd[1]: Detected first boot. Sep 12 17:45:12.959434 systemd[1]: Hostname set to . Sep 12 17:45:12.959444 systemd[1]: Initializing machine ID from random generator. Sep 12 17:45:12.959455 zram_generator::config[1391]: No configuration found. Sep 12 17:45:12.959468 kernel: Guest personality initialized and is inactive Sep 12 17:45:12.959477 kernel: VMCI host device registered (name=vmci, major=10, minor=124) Sep 12 17:45:12.959487 kernel: Initialized host personality Sep 12 17:45:12.959496 kernel: NET: Registered PF_VSOCK protocol family Sep 12 17:45:12.959506 systemd[1]: Populated /etc with preset unit settings. Sep 12 17:45:12.959520 systemd[1]: run-credentials-systemd\x2djournald.service.mount: Deactivated successfully. Sep 12 17:45:12.959530 systemd[1]: initrd-switch-root.service: Deactivated successfully. Sep 12 17:45:12.959543 systemd[1]: Stopped initrd-switch-root.service - Switch Root. Sep 12 17:45:12.959607 systemd[1]: systemd-journald.service: Scheduled restart job, restart counter is at 1. Sep 12 17:45:12.959627 systemd[1]: Created slice system-addon\x2dconfig.slice - Slice /system/addon-config. Sep 12 17:45:12.959639 systemd[1]: Created slice system-addon\x2drun.slice - Slice /system/addon-run. Sep 12 17:45:12.959650 systemd[1]: Created slice system-getty.slice - Slice /system/getty. Sep 12 17:45:12.959660 systemd[1]: Created slice system-modprobe.slice - Slice /system/modprobe. Sep 12 17:45:12.959671 systemd[1]: Created slice system-serial\x2dgetty.slice - Slice /system/serial-getty. Sep 12 17:45:12.959682 systemd[1]: Created slice system-system\x2dcloudinit.slice - Slice /system/system-cloudinit. Sep 12 17:45:12.959698 systemd[1]: Created slice system-systemd\x2dfsck.slice - Slice /system/systemd-fsck. Sep 12 17:45:12.959709 systemd[1]: Created slice user.slice - User and Session Slice. Sep 12 17:45:12.959719 systemd[1]: Started clevis-luks-askpass.path - Forward Password Requests to Clevis Directory Watch. Sep 12 17:45:12.959730 systemd[1]: Started systemd-ask-password-console.path - Dispatch Password Requests to Console Directory Watch. Sep 12 17:45:12.959741 systemd[1]: Started systemd-ask-password-wall.path - Forward Password Requests to Wall Directory Watch. Sep 12 17:45:12.959751 systemd[1]: Set up automount boot.automount - Boot partition Automount Point. Sep 12 17:45:12.959766 systemd[1]: Set up automount proc-sys-fs-binfmt_misc.automount - Arbitrary Executable File Formats File System Automount Point. Sep 12 17:45:12.959778 systemd[1]: Expecting device dev-disk-by\x2dlabel-OEM.device - /dev/disk/by-label/OEM... Sep 12 17:45:12.959792 systemd[1]: Expecting device dev-ttyS0.device - /dev/ttyS0... Sep 12 17:45:12.959803 systemd[1]: Reached target cryptsetup-pre.target - Local Encrypted Volumes (Pre). Sep 12 17:45:12.959813 systemd[1]: Reached target cryptsetup.target - Local Encrypted Volumes. Sep 12 17:45:12.959828 systemd[1]: Stopped target initrd-switch-root.target - Switch Root. Sep 12 17:45:12.959839 systemd[1]: Stopped target initrd-fs.target - Initrd File Systems. Sep 12 17:45:12.959849 systemd[1]: Stopped target initrd-root-fs.target - Initrd Root File System. Sep 12 17:45:12.959860 systemd[1]: Reached target integritysetup.target - Local Integrity Protected Volumes. Sep 12 17:45:12.959874 systemd[1]: Reached target remote-cryptsetup.target - Remote Encrypted Volumes. Sep 12 17:45:12.959885 systemd[1]: Reached target remote-fs.target - Remote File Systems. Sep 12 17:45:12.959896 systemd[1]: Reached target slices.target - Slice Units. Sep 12 17:45:12.959907 systemd[1]: Reached target swap.target - Swaps. Sep 12 17:45:12.959918 systemd[1]: Reached target veritysetup.target - Local Verity Protected Volumes. Sep 12 17:45:12.959928 systemd[1]: Listening on systemd-coredump.socket - Process Core Dump Socket. Sep 12 17:45:12.959943 systemd[1]: Listening on systemd-creds.socket - Credential Encryption/Decryption. Sep 12 17:45:12.959954 systemd[1]: Listening on systemd-networkd.socket - Network Service Netlink Socket. Sep 12 17:45:12.959964 systemd[1]: Listening on systemd-udevd-control.socket - udev Control Socket. Sep 12 17:45:12.959975 systemd[1]: Listening on systemd-udevd-kernel.socket - udev Kernel Socket. Sep 12 17:45:12.959986 systemd[1]: Listening on systemd-userdbd.socket - User Database Manager Socket. Sep 12 17:45:12.959996 systemd[1]: Mounting dev-hugepages.mount - Huge Pages File System... Sep 12 17:45:12.960007 systemd[1]: Mounting dev-mqueue.mount - POSIX Message Queue File System... Sep 12 17:45:12.960021 systemd[1]: Mounting media.mount - External Media Directory... Sep 12 17:45:12.960032 systemd[1]: proc-xen.mount - /proc/xen was skipped because of an unmet condition check (ConditionVirtualization=xen). Sep 12 17:45:12.960043 systemd[1]: Mounting sys-kernel-debug.mount - Kernel Debug File System... Sep 12 17:45:12.960059 systemd[1]: Mounting sys-kernel-tracing.mount - Kernel Trace File System... Sep 12 17:45:12.960073 systemd[1]: Mounting tmp.mount - Temporary Directory /tmp... Sep 12 17:45:12.960084 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). Sep 12 17:45:12.960096 systemd[1]: Reached target machines.target - Containers. Sep 12 17:45:12.960107 systemd[1]: Starting flatcar-tmpfiles.service - Create missing system files... Sep 12 17:45:12.960118 systemd[1]: ignition-delete-config.service - Ignition (delete config) was skipped because no trigger condition checks were met. Sep 12 17:45:12.960133 systemd[1]: Starting kmod-static-nodes.service - Create List of Static Device Nodes... Sep 12 17:45:12.960144 systemd[1]: Starting modprobe@configfs.service - Load Kernel Module configfs... Sep 12 17:45:12.960154 systemd[1]: Starting modprobe@dm_mod.service - Load Kernel Module dm_mod... Sep 12 17:45:12.960166 systemd[1]: Starting modprobe@drm.service - Load Kernel Module drm... Sep 12 17:45:12.960176 systemd[1]: Starting modprobe@efi_pstore.service - Load Kernel Module efi_pstore... Sep 12 17:45:12.960187 systemd[1]: Starting modprobe@fuse.service - Load Kernel Module fuse... Sep 12 17:45:12.960198 systemd[1]: Starting modprobe@loop.service - Load Kernel Module loop... Sep 12 17:45:12.960209 systemd[1]: setup-nsswitch.service - Create /etc/nsswitch.conf was skipped because of an unmet condition check (ConditionPathExists=!/etc/nsswitch.conf). Sep 12 17:45:12.960223 systemd[1]: systemd-fsck-root.service: Deactivated successfully. Sep 12 17:45:12.960234 systemd[1]: Stopped systemd-fsck-root.service - File System Check on Root Device. Sep 12 17:45:12.960245 systemd[1]: systemd-fsck-usr.service: Deactivated successfully. Sep 12 17:45:12.960255 systemd[1]: Stopped systemd-fsck-usr.service. Sep 12 17:45:12.960267 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). Sep 12 17:45:12.960278 systemd[1]: Starting systemd-journald.service - Journal Service... Sep 12 17:45:12.960289 kernel: fuse: init (API version 7.41) Sep 12 17:45:12.960299 systemd[1]: Starting systemd-modules-load.service - Load Kernel Modules... Sep 12 17:45:12.960316 systemd[1]: Starting systemd-network-generator.service - Generate network units from Kernel command line... Sep 12 17:45:12.960327 systemd[1]: Starting systemd-remount-fs.service - Remount Root and Kernel File Systems... Sep 12 17:45:12.960338 systemd[1]: Starting systemd-udev-load-credentials.service - Load udev Rules from Credentials... Sep 12 17:45:12.960375 systemd-journald[1474]: Collecting audit messages is disabled. Sep 12 17:45:12.960404 systemd[1]: Starting systemd-udev-trigger.service - Coldplug All udev Devices... Sep 12 17:45:12.960417 systemd-journald[1474]: Journal started Sep 12 17:45:12.960443 systemd-journald[1474]: Runtime Journal (/run/log/journal/352101e85aee44c1974ca95b7169dcfc) is 8M, max 2.2G, 2.1G free. Sep 12 17:45:12.137480 systemd[1]: Queued start job for default target multi-user.target. Sep 12 17:45:12.157894 systemd[1]: Unnecessary job was removed for dev-sdb6.device - /dev/sdb6. Sep 12 17:45:12.158377 systemd[1]: systemd-journald.service: Deactivated successfully. Sep 12 17:45:12.973844 systemd[1]: verity-setup.service: Deactivated successfully. Sep 12 17:45:12.973959 systemd[1]: Stopped verity-setup.service. Sep 12 17:45:12.988597 systemd[1]: xenserver-pv-version.service - Set fake PV driver version for XenServer was skipped because of an unmet condition check (ConditionVirtualization=xen). Sep 12 17:45:12.992591 kernel: loop: module loaded Sep 12 17:45:12.992625 systemd[1]: Started systemd-journald.service - Journal Service. Sep 12 17:45:13.001232 systemd[1]: Mounted dev-hugepages.mount - Huge Pages File System. Sep 12 17:45:13.005464 systemd[1]: Mounted dev-mqueue.mount - POSIX Message Queue File System. Sep 12 17:45:13.009883 systemd[1]: Mounted media.mount - External Media Directory. Sep 12 17:45:13.013877 systemd[1]: Mounted sys-kernel-debug.mount - Kernel Debug File System. Sep 12 17:45:13.018248 systemd[1]: Mounted sys-kernel-tracing.mount - Kernel Trace File System. Sep 12 17:45:13.023390 systemd[1]: Mounted tmp.mount - Temporary Directory /tmp. Sep 12 17:45:13.027509 systemd[1]: Finished flatcar-tmpfiles.service - Create missing system files. Sep 12 17:45:13.032727 systemd[1]: Finished kmod-static-nodes.service - Create List of Static Device Nodes. Sep 12 17:45:13.038041 systemd[1]: modprobe@configfs.service: Deactivated successfully. Sep 12 17:45:13.038241 systemd[1]: Finished modprobe@configfs.service - Load Kernel Module configfs. Sep 12 17:45:13.043238 systemd[1]: modprobe@dm_mod.service: Deactivated successfully. Sep 12 17:45:13.043502 systemd[1]: Finished modprobe@dm_mod.service - Load Kernel Module dm_mod. Sep 12 17:45:13.048254 systemd[1]: modprobe@efi_pstore.service: Deactivated successfully. Sep 12 17:45:13.048443 systemd[1]: Finished modprobe@efi_pstore.service - Load Kernel Module efi_pstore. Sep 12 17:45:13.053703 systemd[1]: modprobe@fuse.service: Deactivated successfully. Sep 12 17:45:13.053884 systemd[1]: Finished modprobe@fuse.service - Load Kernel Module fuse. Sep 12 17:45:13.058421 systemd[1]: modprobe@loop.service: Deactivated successfully. Sep 12 17:45:13.058628 systemd[1]: Finished modprobe@loop.service - Load Kernel Module loop. Sep 12 17:45:13.063193 systemd[1]: Finished systemd-modules-load.service - Load Kernel Modules. Sep 12 17:45:13.067620 systemd[1]: Finished systemd-network-generator.service - Generate network units from Kernel command line. Sep 12 17:45:13.072881 systemd[1]: Finished systemd-remount-fs.service - Remount Root and Kernel File Systems. Sep 12 17:45:13.085871 systemd[1]: Reached target network-pre.target - Preparation for Network. Sep 12 17:45:13.091484 systemd[1]: Mounting sys-fs-fuse-connections.mount - FUSE Control File System... Sep 12 17:45:13.115800 systemd[1]: Mounting sys-kernel-config.mount - Kernel Configuration File System... Sep 12 17:45:13.118595 kernel: ACPI: bus type drm_connector registered Sep 12 17:45:13.122422 systemd[1]: remount-root.service - Remount Root File System was skipped because of an unmet condition check (ConditionPathIsReadWrite=!/). Sep 12 17:45:13.122463 systemd[1]: Reached target local-fs.target - Local File Systems. Sep 12 17:45:13.127353 systemd[1]: Listening on systemd-sysext.socket - System Extension Image Management. Sep 12 17:45:13.133387 systemd[1]: Starting ldconfig.service - Rebuild Dynamic Linker Cache... Sep 12 17:45:13.137385 systemd[1]: systemd-binfmt.service - Set Up Additional Binary Formats was skipped because no trigger condition checks were met. Sep 12 17:45:13.163723 systemd[1]: Starting systemd-hwdb-update.service - Rebuild Hardware Database... Sep 12 17:45:13.178836 systemd[1]: Starting systemd-journal-flush.service - Flush Journal to Persistent Storage... Sep 12 17:45:13.183419 systemd[1]: systemd-pstore.service - Platform Persistent Storage Archival was skipped because of an unmet condition check (ConditionDirectoryNotEmpty=/sys/fs/pstore). Sep 12 17:45:13.184353 systemd[1]: Starting systemd-random-seed.service - Load/Save OS Random Seed... Sep 12 17:45:13.188698 systemd[1]: systemd-repart.service - Repartition Root Disk was skipped because no trigger condition checks were met. Sep 12 17:45:13.189672 systemd[1]: Starting systemd-sysctl.service - Apply Kernel Variables... Sep 12 17:45:13.203518 systemd[1]: Starting systemd-sysext.service - Merge System Extension Images into /usr/ and /opt/... Sep 12 17:45:13.210278 systemd[1]: Starting systemd-sysusers.service - Create System Users... Sep 12 17:45:13.216252 systemd[1]: modprobe@drm.service: Deactivated successfully. Sep 12 17:45:13.216467 systemd[1]: Finished modprobe@drm.service - Load Kernel Module drm. Sep 12 17:45:13.221041 systemd[1]: Finished systemd-udev-load-credentials.service - Load udev Rules from Credentials. Sep 12 17:45:13.227403 systemd[1]: Finished systemd-udev-trigger.service - Coldplug All udev Devices. Sep 12 17:45:13.232933 systemd[1]: Mounted sys-fs-fuse-connections.mount - FUSE Control File System. Sep 12 17:45:13.235142 systemd-journald[1474]: Time spent on flushing to /var/log/journal/352101e85aee44c1974ca95b7169dcfc is 13.778ms for 949 entries. Sep 12 17:45:13.235142 systemd-journald[1474]: System Journal (/var/log/journal/352101e85aee44c1974ca95b7169dcfc) is 8M, max 2.6G, 2.6G free. Sep 12 17:45:13.265514 systemd-journald[1474]: Received client request to flush runtime journal. Sep 12 17:45:13.241490 systemd[1]: Mounted sys-kernel-config.mount - Kernel Configuration File System. Sep 12 17:45:13.246599 systemd[1]: Finished systemd-random-seed.service - Load/Save OS Random Seed. Sep 12 17:45:13.254777 systemd[1]: Reached target first-boot-complete.target - First Boot Complete. Sep 12 17:45:13.260840 systemd[1]: Starting systemd-machine-id-commit.service - Save Transient machine-id to Disk... Sep 12 17:45:13.275725 systemd[1]: Finished systemd-journal-flush.service - Flush Journal to Persistent Storage. Sep 12 17:45:13.330600 kernel: loop0: detected capacity change from 0 to 128016 Sep 12 17:45:13.358545 systemd[1]: etc-machine\x2did.mount: Deactivated successfully. Sep 12 17:45:13.359259 systemd[1]: Finished systemd-machine-id-commit.service - Save Transient machine-id to Disk. Sep 12 17:45:13.385455 systemd[1]: Finished systemd-sysctl.service - Apply Kernel Variables. Sep 12 17:45:13.902406 systemd[1]: Finished systemd-sysusers.service - Create System Users. Sep 12 17:45:13.908236 systemd[1]: Starting systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev... Sep 12 17:45:14.114401 systemd-tmpfiles[1547]: ACLs are not supported, ignoring. Sep 12 17:45:14.114423 systemd-tmpfiles[1547]: ACLs are not supported, ignoring. Sep 12 17:45:14.131170 systemd[1]: Finished systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev. Sep 12 17:45:14.247604 kernel: squashfs: version 4.0 (2009/01/31) Phillip Lougher Sep 12 17:45:14.341595 kernel: loop1: detected capacity change from 0 to 111000 Sep 12 17:45:14.954603 kernel: loop2: detected capacity change from 0 to 29272 Sep 12 17:45:15.649773 systemd[1]: Finished systemd-hwdb-update.service - Rebuild Hardware Database. Sep 12 17:45:15.656165 systemd[1]: Starting systemd-udevd.service - Rule-based Manager for Device Events and Files... Sep 12 17:45:15.695410 systemd-udevd[1556]: Using default interface naming scheme 'v255'. Sep 12 17:45:15.698598 kernel: loop3: detected capacity change from 0 to 128016 Sep 12 17:45:15.714594 kernel: loop4: detected capacity change from 0 to 111000 Sep 12 17:45:15.730601 kernel: loop5: detected capacity change from 0 to 29272 Sep 12 17:45:15.746941 (sd-merge)[1557]: Using extensions 'containerd-flatcar', 'docker-flatcar', 'oem-azure'. Sep 12 17:45:15.747414 (sd-merge)[1557]: Merged extensions into '/usr'. Sep 12 17:45:15.751803 systemd[1]: Finished systemd-sysext.service - Merge System Extension Images into /usr/ and /opt/. Sep 12 17:45:15.758264 systemd[1]: Starting ensure-sysext.service... Sep 12 17:45:15.761867 systemd[1]: Starting systemd-tmpfiles-setup.service - Create System Files and Directories... Sep 12 17:45:15.817926 systemd[1]: Reload requested from client PID 1559 ('systemctl') (unit ensure-sysext.service)... Sep 12 17:45:15.817942 systemd[1]: Reloading... Sep 12 17:45:15.853605 zram_generator::config[1587]: No configuration found. Sep 12 17:45:15.907314 systemd-tmpfiles[1560]: /usr/lib/tmpfiles.d/nfs-utils.conf:6: Duplicate line for path "/var/lib/nfs/sm", ignoring. Sep 12 17:45:15.907366 systemd-tmpfiles[1560]: /usr/lib/tmpfiles.d/nfs-utils.conf:7: Duplicate line for path "/var/lib/nfs/sm.bak", ignoring. Sep 12 17:45:15.907712 systemd-tmpfiles[1560]: /usr/lib/tmpfiles.d/provision.conf:20: Duplicate line for path "/root", ignoring. Sep 12 17:45:15.908007 systemd-tmpfiles[1560]: /usr/lib/tmpfiles.d/systemd-flatcar.conf:6: Duplicate line for path "/var/log/journal", ignoring. Sep 12 17:45:15.908934 systemd-tmpfiles[1560]: /usr/lib/tmpfiles.d/systemd.conf:29: Duplicate line for path "/var/lib/systemd", ignoring. Sep 12 17:45:15.909839 systemd-tmpfiles[1560]: ACLs are not supported, ignoring. Sep 12 17:45:15.909911 systemd-tmpfiles[1560]: ACLs are not supported, ignoring. Sep 12 17:45:15.959257 systemd-tmpfiles[1560]: Detected autofs mount point /boot during canonicalization of boot. Sep 12 17:45:15.959275 systemd-tmpfiles[1560]: Skipping /boot Sep 12 17:45:15.967954 systemd-tmpfiles[1560]: Detected autofs mount point /boot during canonicalization of boot. Sep 12 17:45:15.967968 systemd-tmpfiles[1560]: Skipping /boot Sep 12 17:45:16.081390 systemd[1]: Reloading finished in 263 ms. Sep 12 17:45:16.139631 systemd[1]: Finished systemd-tmpfiles-setup.service - Create System Files and Directories. Sep 12 17:45:16.155718 systemd[1]: Starting audit-rules.service - Load Audit Rules... Sep 12 17:45:16.184529 systemd[1]: Starting clean-ca-certificates.service - Clean up broken links in /etc/ssl/certs... Sep 12 17:45:16.190265 systemd[1]: Starting systemd-journal-catalog-update.service - Rebuild Journal Catalog... Sep 12 17:45:16.208454 systemd[1]: Starting systemd-resolved.service - Network Name Resolution... Sep 12 17:45:16.213995 systemd[1]: Starting systemd-update-utmp.service - Record System Boot/Shutdown in UTMP... Sep 12 17:45:16.223458 systemd[1]: proc-xen.mount - /proc/xen was skipped because of an unmet condition check (ConditionVirtualization=xen). Sep 12 17:45:16.223672 systemd[1]: ignition-delete-config.service - Ignition (delete config) was skipped because no trigger condition checks were met. Sep 12 17:45:16.224913 systemd[1]: Starting modprobe@dm_mod.service - Load Kernel Module dm_mod... Sep 12 17:45:16.230086 systemd[1]: Starting modprobe@efi_pstore.service - Load Kernel Module efi_pstore... Sep 12 17:45:16.235794 systemd[1]: Starting modprobe@loop.service - Load Kernel Module loop... Sep 12 17:45:16.240162 systemd[1]: systemd-binfmt.service - Set Up Additional Binary Formats was skipped because no trigger condition checks were met. Sep 12 17:45:16.240283 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). Sep 12 17:45:16.240392 systemd[1]: xenserver-pv-version.service - Set fake PV driver version for XenServer was skipped because of an unmet condition check (ConditionVirtualization=xen). Sep 12 17:45:16.241634 systemd[1]: modprobe@dm_mod.service: Deactivated successfully. Sep 12 17:45:16.241812 systemd[1]: Finished modprobe@dm_mod.service - Load Kernel Module dm_mod. Sep 12 17:45:16.246906 systemd[1]: modprobe@efi_pstore.service: Deactivated successfully. Sep 12 17:45:16.247080 systemd[1]: Finished modprobe@efi_pstore.service - Load Kernel Module efi_pstore. Sep 12 17:45:16.252459 systemd[1]: modprobe@loop.service: Deactivated successfully. Sep 12 17:45:16.252650 systemd[1]: Finished modprobe@loop.service - Load Kernel Module loop. Sep 12 17:45:16.263539 systemd[1]: proc-xen.mount - /proc/xen was skipped because of an unmet condition check (ConditionVirtualization=xen). Sep 12 17:45:16.263804 systemd[1]: ignition-delete-config.service - Ignition (delete config) was skipped because no trigger condition checks were met. Sep 12 17:45:16.265011 systemd[1]: Starting modprobe@dm_mod.service - Load Kernel Module dm_mod... Sep 12 17:45:16.283989 systemd[1]: Starting modprobe@efi_pstore.service - Load Kernel Module efi_pstore... Sep 12 17:45:16.289635 systemd[1]: Starting modprobe@loop.service - Load Kernel Module loop... Sep 12 17:45:16.293976 systemd[1]: systemd-binfmt.service - Set Up Additional Binary Formats was skipped because no trigger condition checks were met. Sep 12 17:45:16.294148 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). Sep 12 17:45:16.294314 systemd[1]: xenserver-pv-version.service - Set fake PV driver version for XenServer was skipped because of an unmet condition check (ConditionVirtualization=xen). Sep 12 17:45:16.296916 systemd[1]: modprobe@dm_mod.service: Deactivated successfully. Sep 12 17:45:16.297205 systemd[1]: Finished modprobe@dm_mod.service - Load Kernel Module dm_mod. Sep 12 17:45:16.302718 systemd[1]: modprobe@efi_pstore.service: Deactivated successfully. Sep 12 17:45:16.302890 systemd[1]: Finished modprobe@efi_pstore.service - Load Kernel Module efi_pstore. Sep 12 17:45:16.308452 systemd[1]: modprobe@loop.service: Deactivated successfully. Sep 12 17:45:16.308646 systemd[1]: Finished modprobe@loop.service - Load Kernel Module loop. Sep 12 17:45:16.314389 systemd[1]: Finished systemd-update-utmp.service - Record System Boot/Shutdown in UTMP. Sep 12 17:45:16.326968 systemd[1]: Expecting device dev-ptp_hyperv.device - /dev/ptp_hyperv... Sep 12 17:45:16.330967 systemd[1]: proc-xen.mount - /proc/xen was skipped because of an unmet condition check (ConditionVirtualization=xen). Sep 12 17:45:16.331218 systemd[1]: ignition-delete-config.service - Ignition (delete config) was skipped because no trigger condition checks were met. Sep 12 17:45:16.332215 systemd[1]: Starting modprobe@dm_mod.service - Load Kernel Module dm_mod... Sep 12 17:45:16.352909 systemd[1]: Starting modprobe@drm.service - Load Kernel Module drm... Sep 12 17:45:16.357485 systemd[1]: Starting modprobe@efi_pstore.service - Load Kernel Module efi_pstore... Sep 12 17:45:16.362996 systemd[1]: Starting modprobe@loop.service - Load Kernel Module loop... Sep 12 17:45:16.367101 systemd[1]: systemd-binfmt.service - Set Up Additional Binary Formats was skipped because no trigger condition checks were met. Sep 12 17:45:16.367146 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). Sep 12 17:45:16.367215 systemd[1]: Reached target time-set.target - System Time Set. Sep 12 17:45:16.372742 systemd[1]: Starting systemd-userdbd.service - User Database Manager... Sep 12 17:45:16.376828 systemd[1]: xenserver-pv-version.service - Set fake PV driver version for XenServer was skipped because of an unmet condition check (ConditionVirtualization=xen). Sep 12 17:45:16.377693 systemd[1]: Finished ensure-sysext.service. Sep 12 17:45:16.381281 systemd[1]: modprobe@dm_mod.service: Deactivated successfully. Sep 12 17:45:16.381474 systemd[1]: Finished modprobe@dm_mod.service - Load Kernel Module dm_mod. Sep 12 17:45:16.386481 systemd[1]: modprobe@drm.service: Deactivated successfully. Sep 12 17:45:16.386681 systemd[1]: Finished modprobe@drm.service - Load Kernel Module drm. Sep 12 17:45:16.391407 systemd[1]: modprobe@efi_pstore.service: Deactivated successfully. Sep 12 17:45:16.391613 systemd[1]: Finished modprobe@efi_pstore.service - Load Kernel Module efi_pstore. Sep 12 17:45:16.403099 systemd[1]: modprobe@loop.service: Deactivated successfully. Sep 12 17:45:16.403301 systemd[1]: Finished modprobe@loop.service - Load Kernel Module loop. Sep 12 17:45:16.411280 systemd[1]: systemd-pstore.service - Platform Persistent Storage Archival was skipped because of an unmet condition check (ConditionDirectoryNotEmpty=/sys/fs/pstore). Sep 12 17:45:16.411352 systemd[1]: systemd-repart.service - Repartition Root Disk was skipped because no trigger condition checks were met. Sep 12 17:45:16.442060 systemd[1]: Started systemd-userdbd.service - User Database Manager. Sep 12 17:45:16.499731 systemd[1]: Started systemd-udevd.service - Rule-based Manager for Device Events and Files. Sep 12 17:45:16.509262 systemd[1]: Starting systemd-networkd.service - Network Configuration... Sep 12 17:45:16.534203 systemd[1]: Condition check resulted in dev-ttyS0.device - /dev/ttyS0 being skipped. Sep 12 17:45:16.571948 systemd[1]: Finished systemd-journal-catalog-update.service - Rebuild Journal Catalog. Sep 12 17:45:16.621602 kernel: hv_vmbus: registering driver hv_balloon Sep 12 17:45:16.627621 kernel: hv_balloon: Using Dynamic Memory protocol version 2.0 Sep 12 17:45:16.632618 systemd-resolved[1651]: Positive Trust Anchors: Sep 12 17:45:16.632642 systemd-resolved[1651]: . IN DS 20326 8 2 e06d44b80b8f1d39a95c0b0d7c65d08458e880409bbc683457104237c7f8ec8d Sep 12 17:45:16.632681 systemd-resolved[1651]: 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 Sep 12 17:45:16.645610 kernel: hv_vmbus: registering driver hyperv_fb Sep 12 17:45:16.645870 systemd[1]: Condition check resulted in dev-ptp_hyperv.device - /dev/ptp_hyperv being skipped. Sep 12 17:45:16.648981 systemd-resolved[1651]: Using system hostname 'ci-4426.1.0-a-b6cbffdee1'. Sep 12 17:45:16.654182 systemd[1]: Starting systemd-vconsole-setup.service - Virtual Console Setup... Sep 12 17:45:16.665098 kernel: hyperv_fb: Synthvid Version major 3, minor 5 Sep 12 17:45:16.665158 kernel: hyperv_fb: Screen resolution: 1024x768, Color depth: 32, Frame buffer size: 8388608 Sep 12 17:45:16.665591 kernel: Console: switching to colour dummy device 80x25 Sep 12 17:45:16.665772 systemd[1]: Started systemd-resolved.service - Network Name Resolution. Sep 12 17:45:16.672595 kernel: mousedev: PS/2 mouse device common for all mice Sep 12 17:45:16.672647 kernel: Console: switching to colour frame buffer device 128x48 Sep 12 17:45:16.689962 systemd[1]: Reached target nss-lookup.target - Host and Network Name Lookups. Sep 12 17:45:16.695937 systemd[1]: systemd-vconsole-setup.service: Deactivated successfully. Sep 12 17:45:16.696154 systemd[1]: Stopped systemd-vconsole-setup.service - Virtual Console Setup. Sep 12 17:45:16.703118 systemd[1]: Starting systemd-vconsole-setup.service - Virtual Console Setup... Sep 12 17:45:16.713769 augenrules[1778]: No rules Sep 12 17:45:16.715080 systemd[1]: audit-rules.service: Deactivated successfully. Sep 12 17:45:16.715380 systemd[1]: Finished audit-rules.service - Load Audit Rules. Sep 12 17:45:16.809666 kernel: EDAC MC: Ver: 3.0.0 Sep 12 17:45:16.857315 systemd-networkd[1717]: lo: Link UP Sep 12 17:45:16.857324 systemd-networkd[1717]: lo: Gained carrier Sep 12 17:45:16.858810 systemd-networkd[1717]: Enumeration completed Sep 12 17:45:16.858932 systemd[1]: Started systemd-networkd.service - Network Configuration. Sep 12 17:45:16.859209 systemd-networkd[1717]: eth0: found matching network '/usr/lib/systemd/network/zz-default.network', based on potentially unpredictable interface name. Sep 12 17:45:16.859219 systemd-networkd[1717]: eth0: Configuring with /usr/lib/systemd/network/zz-default.network. Sep 12 17:45:16.862513 systemd-networkd[1717]: eth0: Link UP Sep 12 17:45:16.862524 systemd-networkd[1717]: eth0: Gained carrier Sep 12 17:45:16.862543 systemd-networkd[1717]: eth0: found matching network '/usr/lib/systemd/network/zz-default.network', based on potentially unpredictable interface name. Sep 12 17:45:16.863000 systemd[1]: Reached target network.target - Network. Sep 12 17:45:16.864844 systemd[1]: Starting systemd-networkd-persistent-storage.service - Enable Persistent Storage in systemd-networkd... Sep 12 17:45:16.865995 systemd[1]: Starting systemd-networkd-wait-online.service - Wait for Network to be Configured... Sep 12 17:45:16.908662 systemd-networkd[1717]: eth0: DHCPv4 address 10.200.8.11/24, gateway 10.200.8.1 acquired from 168.63.129.16 Sep 12 17:45:16.928394 systemd[1]: Found device dev-disk-by\x2dlabel-OEM.device - Virtual_Disk OEM. Sep 12 17:45:16.930971 systemd[1]: Starting systemd-fsck@dev-disk-by\x2dlabel-OEM.service - File System Check on /dev/disk/by-label/OEM... Sep 12 17:45:16.960823 systemd[1]: Finished systemd-networkd-persistent-storage.service - Enable Persistent Storage in systemd-networkd. Sep 12 17:45:17.032545 systemd[1]: Finished systemd-fsck@dev-disk-by\x2dlabel-OEM.service - File System Check on /dev/disk/by-label/OEM. Sep 12 17:45:18.100341 systemd[1]: Finished systemd-vconsole-setup.service - Virtual Console Setup. Sep 12 17:45:18.217753 systemd-networkd[1717]: eth0: Gained IPv6LL Sep 12 17:45:18.220170 systemd[1]: Finished systemd-networkd-wait-online.service - Wait for Network to be Configured. Sep 12 17:45:18.228705 systemd[1]: Reached target network-online.target - Network is Online. Sep 12 17:45:18.777202 systemd[1]: Finished clean-ca-certificates.service - Clean up broken links in /etc/ssl/certs. Sep 12 17:45:18.782770 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). Sep 12 17:45:23.574376 ldconfig[1525]: /sbin/ldconfig: /usr/lib/ld.so.conf is not an ELF file - it has the wrong magic bytes at the start. Sep 12 17:45:23.588029 systemd[1]: Finished ldconfig.service - Rebuild Dynamic Linker Cache. Sep 12 17:45:23.594683 systemd[1]: Starting systemd-update-done.service - Update is Completed... Sep 12 17:45:23.641831 systemd[1]: Finished systemd-update-done.service - Update is Completed. Sep 12 17:45:23.646573 systemd[1]: Reached target sysinit.target - System Initialization. Sep 12 17:45:23.650929 systemd[1]: Started motdgen.path - Watch for update engine configuration changes. Sep 12 17:45:23.655842 systemd[1]: Started user-cloudinit@var-lib-flatcar\x2dinstall-user_data.path - Watch for a cloud-config at /var/lib/flatcar-install/user_data. Sep 12 17:45:23.661189 systemd[1]: Started google-oslogin-cache.timer - NSS cache refresh timer. Sep 12 17:45:23.666409 systemd[1]: Started logrotate.timer - Daily rotation of log files. Sep 12 17:45:23.670759 systemd[1]: Started mdadm.timer - Weekly check for MD array's redundancy information.. Sep 12 17:45:23.675739 systemd[1]: Started systemd-tmpfiles-clean.timer - Daily Cleanup of Temporary Directories. Sep 12 17:45:23.681667 systemd[1]: update-engine-stub.timer - Update Engine Stub Timer was skipped because of an unmet condition check (ConditionPathExists=/usr/.noupdate). Sep 12 17:45:23.681703 systemd[1]: Reached target paths.target - Path Units. Sep 12 17:45:23.685302 systemd[1]: Reached target timers.target - Timer Units. Sep 12 17:45:23.702060 systemd[1]: Listening on dbus.socket - D-Bus System Message Bus Socket. Sep 12 17:45:23.707855 systemd[1]: Starting docker.socket - Docker Socket for the API... Sep 12 17:45:23.713824 systemd[1]: Listening on sshd-unix-local.socket - OpenSSH Server Socket (systemd-ssh-generator, AF_UNIX Local). Sep 12 17:45:23.718984 systemd[1]: Listening on sshd-vsock.socket - OpenSSH Server Socket (systemd-ssh-generator, AF_VSOCK). Sep 12 17:45:23.724021 systemd[1]: Reached target ssh-access.target - SSH Access Available. Sep 12 17:45:23.730048 systemd[1]: Listening on sshd.socket - OpenSSH Server Socket. Sep 12 17:45:23.734220 systemd[1]: Listening on systemd-hostnamed.socket - Hostname Service Socket. Sep 12 17:45:23.739515 systemd[1]: Listening on docker.socket - Docker Socket for the API. Sep 12 17:45:23.744672 systemd[1]: Reached target sockets.target - Socket Units. Sep 12 17:45:23.748470 systemd[1]: Reached target basic.target - Basic System. Sep 12 17:45:23.752273 systemd[1]: addon-config@oem.service - Configure Addon /oem was skipped because no trigger condition checks were met. Sep 12 17:45:23.752307 systemd[1]: addon-run@oem.service - Run Addon /oem was skipped because no trigger condition checks were met. Sep 12 17:45:23.781030 systemd[1]: Starting chronyd.service - NTP client/server... Sep 12 17:45:23.785497 systemd[1]: Starting containerd.service - containerd container runtime... Sep 12 17:45:23.810738 systemd[1]: Starting coreos-metadata.service - Flatcar Metadata Agent... Sep 12 17:45:23.815905 systemd[1]: Starting dbus.service - D-Bus System Message Bus... Sep 12 17:45:23.821589 systemd[1]: Starting dracut-shutdown.service - Restore /run/initramfs on shutdown... Sep 12 17:45:23.836833 systemd[1]: Starting enable-oem-cloudinit.service - Enable cloudinit... Sep 12 17:45:23.842244 systemd[1]: Starting extend-filesystems.service - Extend Filesystems... Sep 12 17:45:23.846096 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). Sep 12 17:45:23.847100 systemd[1]: Starting google-oslogin-cache.service - NSS cache refresh... Sep 12 17:45:23.848571 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). Sep 12 17:45:23.849587 systemd[1]: Started hv_kvp_daemon.service - Hyper-V KVP daemon. Sep 12 17:45:23.857204 systemd[1]: hv_vss_daemon.service - Hyper-V VSS daemon was skipped because of an unmet condition check (ConditionPathExists=/dev/vmbus/hv_vss). Sep 12 17:45:23.858253 systemd[1]: Starting motdgen.service - Generate /run/flatcar/motd... Sep 12 17:45:23.858966 jq[1876]: false Sep 12 17:45:23.872672 systemd[1]: Starting nvidia.service - NVIDIA Configure Service... Sep 12 17:45:23.877419 systemd[1]: Starting ssh-key-proc-cmdline.service - Install an ssh key from /proc/cmdline... Sep 12 17:45:23.881692 systemd[1]: Starting sshd-keygen.service - Generate sshd host keys... Sep 12 17:45:23.890714 systemd[1]: Starting systemd-logind.service - User Login Management... Sep 12 17:45:23.895460 systemd[1]: tcsd.service - TCG Core Services Daemon was skipped because of an unmet condition check (ConditionPathExists=/dev/tpm0). Sep 12 17:45:23.895902 systemd[1]: cgroup compatibility translation between legacy and unified hierarchy settings activated. See cgroup-compat debug messages for details. Sep 12 17:45:23.896466 systemd[1]: Starting update-engine.service - Update Engine... Sep 12 17:45:23.900662 systemd[1]: Starting update-ssh-keys-after-ignition.service - Run update-ssh-keys once after Ignition... Sep 12 17:45:23.907277 jq[1891]: true Sep 12 17:45:23.908727 systemd[1]: Finished dracut-shutdown.service - Restore /run/initramfs on shutdown. Sep 12 17:45:23.914350 systemd[1]: enable-oem-cloudinit.service: Skipped due to 'exec-condition'. Sep 12 17:45:23.914701 systemd[1]: Condition check resulted in enable-oem-cloudinit.service - Enable cloudinit being skipped. Sep 12 17:45:23.915058 systemd[1]: ssh-key-proc-cmdline.service: Deactivated successfully. Sep 12 17:45:23.915387 systemd[1]: Finished ssh-key-proc-cmdline.service - Install an ssh key from /proc/cmdline. Sep 12 17:45:23.919187 KVP[1879]: KVP starting; pid is:1879 Sep 12 17:45:23.922048 chronyd[1868]: chronyd version 4.7 starting (+CMDMON +REFCLOCK +RTC +PRIVDROP +SCFILTER -SIGND +NTS +SECHASH +IPV6 -DEBUG) Sep 12 17:45:23.924946 systemd[1]: motdgen.service: Deactivated successfully. Sep 12 17:45:23.925307 systemd[1]: Finished motdgen.service - Generate /run/flatcar/motd. Sep 12 17:45:23.928903 google_oslogin_nss_cache[1878]: oslogin_cache_refresh[1878]: Refreshing passwd entry cache Sep 12 17:45:23.928911 oslogin_cache_refresh[1878]: Refreshing passwd entry cache Sep 12 17:45:23.930323 (ntainerd)[1900]: containerd.service: Referenced but unset environment variable evaluates to an empty string: TORCX_IMAGEDIR, TORCX_UNPACKDIR Sep 12 17:45:23.932557 jq[1898]: true Sep 12 17:45:23.935061 KVP[1879]: KVP LIC Version: 3.1 Sep 12 17:45:23.937647 kernel: hv_utils: KVP IC version 4.0 Sep 12 17:45:23.937702 google_oslogin_nss_cache[1878]: oslogin_cache_refresh[1878]: Failure getting users, quitting Sep 12 17:45:23.937702 google_oslogin_nss_cache[1878]: oslogin_cache_refresh[1878]: Produced empty passwd cache file, removing /etc/oslogin_passwd.cache.bak. Sep 12 17:45:23.937702 google_oslogin_nss_cache[1878]: oslogin_cache_refresh[1878]: Refreshing group entry cache Sep 12 17:45:23.937637 oslogin_cache_refresh[1878]: Failure getting users, quitting Sep 12 17:45:23.937654 oslogin_cache_refresh[1878]: Produced empty passwd cache file, removing /etc/oslogin_passwd.cache.bak. Sep 12 17:45:23.937694 oslogin_cache_refresh[1878]: Refreshing group entry cache Sep 12 17:45:23.942162 google_oslogin_nss_cache[1878]: oslogin_cache_refresh[1878]: Failure getting groups, quitting Sep 12 17:45:23.942162 google_oslogin_nss_cache[1878]: oslogin_cache_refresh[1878]: Produced empty group cache file, removing /etc/oslogin_group.cache.bak. Sep 12 17:45:23.942156 oslogin_cache_refresh[1878]: Failure getting groups, quitting Sep 12 17:45:23.942168 oslogin_cache_refresh[1878]: Produced empty group cache file, removing /etc/oslogin_group.cache.bak. Sep 12 17:45:23.943672 systemd[1]: google-oslogin-cache.service: Deactivated successfully. Sep 12 17:45:23.943908 systemd[1]: Finished google-oslogin-cache.service - NSS cache refresh. Sep 12 17:45:23.957524 extend-filesystems[1877]: Found /dev/sdb6 Sep 12 17:45:23.989907 chronyd[1868]: Timezone right/UTC failed leap second check, ignoring Sep 12 17:45:23.990110 chronyd[1868]: Loaded seccomp filter (level 2) Sep 12 17:45:23.990262 systemd[1]: Started chronyd.service - NTP client/server. Sep 12 17:45:24.007990 update_engine[1890]: I20250912 17:45:24.007899 1890 main.cc:92] Flatcar Update Engine starting Sep 12 17:45:24.015342 extend-filesystems[1877]: Found /dev/sdb9 Sep 12 17:45:24.019584 extend-filesystems[1877]: Checking size of /dev/sdb9 Sep 12 17:45:24.035662 systemd-logind[1889]: New seat seat0. Sep 12 17:45:24.036940 systemd-logind[1889]: Watching system buttons on /dev/input/event0 (AT Translated Set 2 keyboard) Sep 12 17:45:24.037123 systemd[1]: Started systemd-logind.service - User Login Management. Sep 12 17:45:24.054974 extend-filesystems[1877]: Old size kept for /dev/sdb9 Sep 12 17:45:24.055549 systemd[1]: extend-filesystems.service: Deactivated successfully. Sep 12 17:45:24.055848 systemd[1]: Finished extend-filesystems.service - Extend Filesystems. Sep 12 17:45:24.075150 bash[1928]: Updated "/home/core/.ssh/authorized_keys" Sep 12 17:45:24.076494 systemd[1]: Finished update-ssh-keys-after-ignition.service - Run update-ssh-keys once after Ignition. Sep 12 17:45:24.084174 systemd[1]: sshkeys.service was skipped because no trigger condition checks were met. Sep 12 17:45:24.230539 setup-nvidia[1881]: Downloading Flatcar Container Linux Developer Container for version: 4426.1.0 Sep 12 17:45:24.240984 dbus-daemon[1871]: [system] SELinux support is enabled Sep 12 17:45:24.241198 systemd[1]: Started dbus.service - D-Bus System Message Bus. Sep 12 17:45:24.244096 update_engine[1890]: I20250912 17:45:24.244043 1890 update_check_scheduler.cc:74] Next update check in 10m17s Sep 12 17:45:24.248062 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). Sep 12 17:45:24.248108 systemd[1]: Reached target system-config.target - Load system-provided cloud configs. Sep 12 17:45:24.248868 dbus-daemon[1871]: [system] Successfully activated service 'org.freedesktop.systemd1' Sep 12 17:45:24.253447 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). Sep 12 17:45:24.253475 systemd[1]: Reached target user-config.target - Load user-provided cloud configs. Sep 12 17:45:24.258859 systemd[1]: Started update-engine.service - Update Engine. Sep 12 17:45:24.265067 systemd[1]: Started locksmithd.service - Cluster reboot manager. Sep 12 17:45:24.292379 sshd_keygen[1908]: ssh-keygen: generating new host keys: RSA ECDSA ED25519 Sep 12 17:45:24.313721 systemd[1]: Finished sshd-keygen.service - Generate sshd host keys. Sep 12 17:45:24.319202 coreos-metadata[1870]: Sep 12 17:45:24.319 INFO Fetching http://168.63.129.16/?comp=versions: Attempt #1 Sep 12 17:45:24.319615 systemd[1]: Starting issuegen.service - Generate /run/issue... Sep 12 17:45:24.325024 coreos-metadata[1870]: Sep 12 17:45:24.324 INFO Fetch successful Sep 12 17:45:24.325168 coreos-metadata[1870]: Sep 12 17:45:24.325 INFO Fetching http://168.63.129.16/machine/?comp=goalstate: Attempt #1 Sep 12 17:45:24.329395 coreos-metadata[1870]: Sep 12 17:45:24.329 INFO Fetch successful Sep 12 17:45:24.329704 coreos-metadata[1870]: Sep 12 17:45:24.329 INFO Fetching http://168.63.129.16/machine/b439683e-b30c-4383-ba6b-5f474760d6f5/f0da2b98%2Dfdd3%2D43b2%2Da453%2D3bba4e7df0e9.%5Fci%2D4426.1.0%2Da%2Db6cbffdee1?comp=config&type=sharedConfig&incarnation=1: Attempt #1 Sep 12 17:45:24.338884 systemd[1]: Starting waagent.service - Microsoft Azure Linux Agent... Sep 12 17:45:24.344687 systemd[1]: issuegen.service: Deactivated successfully. Sep 12 17:45:24.344915 systemd[1]: Finished issuegen.service - Generate /run/issue. Sep 12 17:45:24.351653 systemd[1]: Starting systemd-user-sessions.service - Permit User Sessions... Sep 12 17:45:24.355927 coreos-metadata[1870]: Sep 12 17:45:24.355 INFO Fetch successful Sep 12 17:45:24.355927 coreos-metadata[1870]: Sep 12 17:45:24.355 INFO Fetching http://169.254.169.254/metadata/instance/compute/vmSize?api-version=2017-08-01&format=text: Attempt #1 Sep 12 17:45:24.361521 systemd[1]: Started waagent.service - Microsoft Azure Linux Agent. Sep 12 17:45:24.362605 coreos-metadata[1870]: Sep 12 17:45:24.362 INFO Fetch successful Sep 12 17:45:24.379742 systemd[1]: Finished coreos-metadata.service - Flatcar Metadata Agent. Sep 12 17:45:24.388254 systemd[1]: packet-phone-home.service - Report Success to Packet was skipped because no trigger condition checks were met. Sep 12 17:45:24.410457 systemd[1]: Finished systemd-user-sessions.service - Permit User Sessions. Sep 12 17:45:24.416844 systemd[1]: Started getty@tty1.service - Getty on tty1. Sep 12 17:45:24.421775 systemd[1]: Started serial-getty@ttyS0.service - Serial Getty on ttyS0. Sep 12 17:45:24.426516 systemd[1]: Reached target getty.target - Login Prompts. Sep 12 17:45:24.505230 locksmithd[2006]: locksmithd starting currentOperation="UPDATE_STATUS_IDLE" strategy="reboot" Sep 12 17:45:24.889844 setup-nvidia[2044]: % Total % Received % Xferd Average Speed Time Time Time Current Sep 12 17:45:24.890140 setup-nvidia[2044]: Dload Upload Total Spent Left Speed Sep 12 17:45:25.178864 containerd[1900]: time="2025-09-12T17:45:25Z" 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 Sep 12 17:45:25.179384 containerd[1900]: time="2025-09-12T17:45:25.179350900Z" level=info msg="starting containerd" revision=fb4c30d4ede3531652d86197bf3fc9515e5276d9 version=v2.0.5 Sep 12 17:45:25.188471 containerd[1900]: time="2025-09-12T17:45:25.188426300Z" level=warning msg="Configuration migrated from version 2, use `containerd config migrate` to avoid migration" t="8.3µs" Sep 12 17:45:25.188471 containerd[1900]: time="2025-09-12T17:45:25.188460500Z" level=info msg="loading plugin" id=io.containerd.image-verifier.v1.bindir type=io.containerd.image-verifier.v1 Sep 12 17:45:25.188562 containerd[1900]: time="2025-09-12T17:45:25.188479100Z" level=info msg="loading plugin" id=io.containerd.internal.v1.opt type=io.containerd.internal.v1 Sep 12 17:45:25.188663 containerd[1900]: time="2025-09-12T17:45:25.188639300Z" level=info msg="loading plugin" id=io.containerd.warning.v1.deprecations type=io.containerd.warning.v1 Sep 12 17:45:25.188698 containerd[1900]: time="2025-09-12T17:45:25.188661800Z" level=info msg="loading plugin" id=io.containerd.content.v1.content type=io.containerd.content.v1 Sep 12 17:45:25.188698 containerd[1900]: time="2025-09-12T17:45:25.188685200Z" level=info msg="loading plugin" id=io.containerd.snapshotter.v1.blockfile type=io.containerd.snapshotter.v1 Sep 12 17:45:25.188784 containerd[1900]: time="2025-09-12T17:45:25.188758200Z" level=info msg="skip loading plugin" error="no scratch file generator: skip plugin" id=io.containerd.snapshotter.v1.blockfile type=io.containerd.snapshotter.v1 Sep 12 17:45:25.188784 containerd[1900]: time="2025-09-12T17:45:25.188780100Z" level=info msg="loading plugin" id=io.containerd.snapshotter.v1.btrfs type=io.containerd.snapshotter.v1 Sep 12 17:45:25.189023 containerd[1900]: time="2025-09-12T17:45:25.189000400Z" 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 Sep 12 17:45:25.189023 containerd[1900]: time="2025-09-12T17:45:25.189020200Z" level=info msg="loading plugin" id=io.containerd.snapshotter.v1.devmapper type=io.containerd.snapshotter.v1 Sep 12 17:45:25.189084 containerd[1900]: time="2025-09-12T17:45:25.189032600Z" level=info msg="skip loading plugin" error="devmapper not configured: skip plugin" id=io.containerd.snapshotter.v1.devmapper type=io.containerd.snapshotter.v1 Sep 12 17:45:25.189084 containerd[1900]: time="2025-09-12T17:45:25.189041600Z" level=info msg="loading plugin" id=io.containerd.snapshotter.v1.native type=io.containerd.snapshotter.v1 Sep 12 17:45:25.189155 containerd[1900]: time="2025-09-12T17:45:25.189131300Z" level=info msg="loading plugin" id=io.containerd.snapshotter.v1.overlayfs type=io.containerd.snapshotter.v1 Sep 12 17:45:25.189380 containerd[1900]: time="2025-09-12T17:45:25.189357500Z" level=info msg="loading plugin" id=io.containerd.snapshotter.v1.zfs type=io.containerd.snapshotter.v1 Sep 12 17:45:25.189410 containerd[1900]: time="2025-09-12T17:45:25.189393500Z" 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 Sep 12 17:45:25.189410 containerd[1900]: time="2025-09-12T17:45:25.189404300Z" level=info msg="loading plugin" id=io.containerd.event.v1.exchange type=io.containerd.event.v1 Sep 12 17:45:25.189455 containerd[1900]: time="2025-09-12T17:45:25.189434000Z" level=info msg="loading plugin" id=io.containerd.monitor.task.v1.cgroups type=io.containerd.monitor.task.v1 Sep 12 17:45:25.189668 containerd[1900]: time="2025-09-12T17:45:25.189644800Z" level=info msg="loading plugin" id=io.containerd.metadata.v1.bolt type=io.containerd.metadata.v1 Sep 12 17:45:25.189734 containerd[1900]: time="2025-09-12T17:45:25.189713600Z" level=info msg="metadata content store policy set" policy=shared Sep 12 17:45:25.205529 containerd[1900]: time="2025-09-12T17:45:25.205499800Z" level=info msg="loading plugin" id=io.containerd.gc.v1.scheduler type=io.containerd.gc.v1 Sep 12 17:45:25.205608 containerd[1900]: time="2025-09-12T17:45:25.205540600Z" level=info msg="loading plugin" id=io.containerd.differ.v1.walking type=io.containerd.differ.v1 Sep 12 17:45:25.205608 containerd[1900]: time="2025-09-12T17:45:25.205555900Z" level=info msg="loading plugin" id=io.containerd.lease.v1.manager type=io.containerd.lease.v1 Sep 12 17:45:25.205608 containerd[1900]: time="2025-09-12T17:45:25.205567800Z" level=info msg="loading plugin" id=io.containerd.service.v1.containers-service type=io.containerd.service.v1 Sep 12 17:45:25.205608 containerd[1900]: time="2025-09-12T17:45:25.205591000Z" level=info msg="loading plugin" id=io.containerd.service.v1.content-service type=io.containerd.service.v1 Sep 12 17:45:25.205608 containerd[1900]: time="2025-09-12T17:45:25.205603100Z" level=info msg="loading plugin" id=io.containerd.service.v1.diff-service type=io.containerd.service.v1 Sep 12 17:45:25.205737 containerd[1900]: time="2025-09-12T17:45:25.205617400Z" level=info msg="loading plugin" id=io.containerd.service.v1.images-service type=io.containerd.service.v1 Sep 12 17:45:25.205737 containerd[1900]: time="2025-09-12T17:45:25.205629400Z" level=info msg="loading plugin" id=io.containerd.service.v1.introspection-service type=io.containerd.service.v1 Sep 12 17:45:25.205737 containerd[1900]: time="2025-09-12T17:45:25.205640500Z" level=info msg="loading plugin" id=io.containerd.service.v1.namespaces-service type=io.containerd.service.v1 Sep 12 17:45:25.205737 containerd[1900]: time="2025-09-12T17:45:25.205650800Z" level=info msg="loading plugin" id=io.containerd.service.v1.snapshots-service type=io.containerd.service.v1 Sep 12 17:45:25.205737 containerd[1900]: time="2025-09-12T17:45:25.205660300Z" level=info msg="loading plugin" id=io.containerd.shim.v1.manager type=io.containerd.shim.v1 Sep 12 17:45:25.205737 containerd[1900]: time="2025-09-12T17:45:25.205671800Z" level=info msg="loading plugin" id=io.containerd.runtime.v2.task type=io.containerd.runtime.v2 Sep 12 17:45:25.205896 containerd[1900]: time="2025-09-12T17:45:25.205787500Z" level=info msg="loading plugin" id=io.containerd.service.v1.tasks-service type=io.containerd.service.v1 Sep 12 17:45:25.205896 containerd[1900]: time="2025-09-12T17:45:25.205810500Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.containers type=io.containerd.grpc.v1 Sep 12 17:45:25.205896 containerd[1900]: time="2025-09-12T17:45:25.205825500Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.content type=io.containerd.grpc.v1 Sep 12 17:45:25.205896 containerd[1900]: time="2025-09-12T17:45:25.205836000Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.diff type=io.containerd.grpc.v1 Sep 12 17:45:25.205896 containerd[1900]: time="2025-09-12T17:45:25.205845300Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.events type=io.containerd.grpc.v1 Sep 12 17:45:25.205896 containerd[1900]: time="2025-09-12T17:45:25.205855100Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.images type=io.containerd.grpc.v1 Sep 12 17:45:25.205896 containerd[1900]: time="2025-09-12T17:45:25.205865500Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.introspection type=io.containerd.grpc.v1 Sep 12 17:45:25.205896 containerd[1900]: time="2025-09-12T17:45:25.205875100Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.leases type=io.containerd.grpc.v1 Sep 12 17:45:25.205896 containerd[1900]: time="2025-09-12T17:45:25.205885100Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.namespaces type=io.containerd.grpc.v1 Sep 12 17:45:25.205896 containerd[1900]: time="2025-09-12T17:45:25.205894500Z" level=info msg="loading plugin" id=io.containerd.sandbox.store.v1.local type=io.containerd.sandbox.store.v1 Sep 12 17:45:25.206110 containerd[1900]: time="2025-09-12T17:45:25.205904400Z" level=info msg="loading plugin" id=io.containerd.cri.v1.images type=io.containerd.cri.v1 Sep 12 17:45:25.206110 containerd[1900]: time="2025-09-12T17:45:25.205959100Z" level=info msg="Get image filesystem path \"/var/lib/containerd/io.containerd.snapshotter.v1.overlayfs\" for snapshotter \"overlayfs\"" Sep 12 17:45:25.206110 containerd[1900]: time="2025-09-12T17:45:25.205984200Z" level=info msg="Start snapshots syncer" Sep 12 17:45:25.206110 containerd[1900]: time="2025-09-12T17:45:25.206029600Z" level=info msg="loading plugin" id=io.containerd.cri.v1.runtime type=io.containerd.cri.v1 Sep 12 17:45:25.206297 containerd[1900]: time="2025-09-12T17:45:25.206254700Z" 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\"}" Sep 12 17:45:25.206408 containerd[1900]: time="2025-09-12T17:45:25.206312500Z" level=info msg="loading plugin" id=io.containerd.podsandbox.controller.v1.podsandbox type=io.containerd.podsandbox.controller.v1 Sep 12 17:45:25.206408 containerd[1900]: time="2025-09-12T17:45:25.206373900Z" level=info msg="loading plugin" id=io.containerd.sandbox.controller.v1.shim type=io.containerd.sandbox.controller.v1 Sep 12 17:45:25.206514 containerd[1900]: time="2025-09-12T17:45:25.206487300Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.sandbox-controllers type=io.containerd.grpc.v1 Sep 12 17:45:25.206546 containerd[1900]: time="2025-09-12T17:45:25.206520700Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.sandboxes type=io.containerd.grpc.v1 Sep 12 17:45:25.206546 containerd[1900]: time="2025-09-12T17:45:25.206533200Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.snapshots type=io.containerd.grpc.v1 Sep 12 17:45:25.206601 containerd[1900]: time="2025-09-12T17:45:25.206545200Z" level=info msg="loading plugin" id=io.containerd.streaming.v1.manager type=io.containerd.streaming.v1 Sep 12 17:45:25.206601 containerd[1900]: time="2025-09-12T17:45:25.206556300Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.streaming type=io.containerd.grpc.v1 Sep 12 17:45:25.206601 containerd[1900]: time="2025-09-12T17:45:25.206566100Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.tasks type=io.containerd.grpc.v1 Sep 12 17:45:25.206601 containerd[1900]: time="2025-09-12T17:45:25.206592900Z" level=info msg="loading plugin" id=io.containerd.transfer.v1.local type=io.containerd.transfer.v1 Sep 12 17:45:25.206694 containerd[1900]: time="2025-09-12T17:45:25.206620900Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.transfer type=io.containerd.grpc.v1 Sep 12 17:45:25.206694 containerd[1900]: time="2025-09-12T17:45:25.206632900Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.version type=io.containerd.grpc.v1 Sep 12 17:45:25.206694 containerd[1900]: time="2025-09-12T17:45:25.206643000Z" level=info msg="loading plugin" id=io.containerd.monitor.container.v1.restart type=io.containerd.monitor.container.v1 Sep 12 17:45:25.206694 containerd[1900]: time="2025-09-12T17:45:25.206680800Z" level=info msg="loading plugin" id=io.containerd.tracing.processor.v1.otlp type=io.containerd.tracing.processor.v1 Sep 12 17:45:25.206772 containerd[1900]: time="2025-09-12T17:45:25.206699100Z" 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 Sep 12 17:45:25.206772 containerd[1900]: time="2025-09-12T17:45:25.206707800Z" level=info msg="loading plugin" id=io.containerd.internal.v1.tracing type=io.containerd.internal.v1 Sep 12 17:45:25.206772 containerd[1900]: time="2025-09-12T17:45:25.206716700Z" level=info msg="skip loading plugin" error="skip plugin: tracing endpoint not configured" id=io.containerd.internal.v1.tracing type=io.containerd.internal.v1 Sep 12 17:45:25.206772 containerd[1900]: time="2025-09-12T17:45:25.206725100Z" level=info msg="loading plugin" id=io.containerd.ttrpc.v1.otelttrpc type=io.containerd.ttrpc.v1 Sep 12 17:45:25.206772 containerd[1900]: time="2025-09-12T17:45:25.206733900Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.healthcheck type=io.containerd.grpc.v1 Sep 12 17:45:25.206772 containerd[1900]: time="2025-09-12T17:45:25.206744800Z" level=info msg="loading plugin" id=io.containerd.nri.v1.nri type=io.containerd.nri.v1 Sep 12 17:45:25.206772 containerd[1900]: time="2025-09-12T17:45:25.206761900Z" level=info msg="runtime interface created" Sep 12 17:45:25.206772 containerd[1900]: time="2025-09-12T17:45:25.206767600Z" level=info msg="created NRI interface" Sep 12 17:45:25.206979 containerd[1900]: time="2025-09-12T17:45:25.206775200Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.cri type=io.containerd.grpc.v1 Sep 12 17:45:25.206979 containerd[1900]: time="2025-09-12T17:45:25.206785300Z" level=info msg="Connect containerd service" Sep 12 17:45:25.206979 containerd[1900]: time="2025-09-12T17:45:25.206833700Z" level=info msg="using experimental NRI integration - disable nri plugin to prevent this" Sep 12 17:45:25.207482 containerd[1900]: time="2025-09-12T17:45:25.207452200Z" 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" Sep 12 17:45:25.926360 containerd[1900]: time="2025-09-12T17:45:25.926299500Z" level=info msg="Start subscribing containerd event" Sep 12 17:45:25.926496 containerd[1900]: time="2025-09-12T17:45:25.926358800Z" level=info msg="Start recovering state" Sep 12 17:45:25.926496 containerd[1900]: time="2025-09-12T17:45:25.926462900Z" level=info msg="Start event monitor" Sep 12 17:45:25.926496 containerd[1900]: time="2025-09-12T17:45:25.926478500Z" level=info msg="Start cni network conf syncer for default" Sep 12 17:45:25.926496 containerd[1900]: time="2025-09-12T17:45:25.926485500Z" level=info msg="Start streaming server" Sep 12 17:45:25.926496 containerd[1900]: time="2025-09-12T17:45:25.926494000Z" level=info msg="Registered namespace \"k8s.io\" with NRI" Sep 12 17:45:25.926644 containerd[1900]: time="2025-09-12T17:45:25.926502900Z" level=info msg="runtime interface starting up..." Sep 12 17:45:25.926644 containerd[1900]: time="2025-09-12T17:45:25.926508800Z" level=info msg="starting plugins..." Sep 12 17:45:25.926644 containerd[1900]: time="2025-09-12T17:45:25.926522700Z" level=info msg="Synchronizing NRI (plugin) with current runtime state" Sep 12 17:45:25.926644 containerd[1900]: time="2025-09-12T17:45:25.926557800Z" level=info msg=serving... address=/run/containerd/containerd.sock.ttrpc Sep 12 17:45:25.926644 containerd[1900]: time="2025-09-12T17:45:25.926635200Z" level=info msg=serving... address=/run/containerd/containerd.sock Sep 12 17:45:25.926754 containerd[1900]: time="2025-09-12T17:45:25.926706300Z" level=info msg="containerd successfully booted in 0.748336s" Sep 12 17:45:25.926824 systemd[1]: Started containerd.service - containerd container runtime. Sep 12 17:45:26.865281 waagent[2026]: 2025-09-12T17:45:26.865191Z INFO Daemon Daemon Azure Linux Agent Version: 2.12.0.4 Sep 12 17:45:26.869490 waagent[2026]: 2025-09-12T17:45:26.869446Z INFO Daemon Daemon OS: flatcar 4426.1.0 Sep 12 17:45:26.872847 waagent[2026]: 2025-09-12T17:45:26.872801Z INFO Daemon Daemon Python: 3.11.13 Sep 12 17:45:26.876073 waagent[2026]: 2025-09-12T17:45:26.876030Z INFO Daemon Daemon Run daemon Sep 12 17:45:26.878967 waagent[2026]: 2025-09-12T17:45:26.878929Z INFO Daemon Daemon No RDMA handler exists for distro='Flatcar Container Linux by Kinvolk' version='4426.1.0' Sep 12 17:45:26.885410 waagent[2026]: 2025-09-12T17:45:26.885367Z INFO Daemon Daemon Using waagent for provisioning Sep 12 17:45:26.889280 waagent[2026]: 2025-09-12T17:45:26.889232Z INFO Daemon Daemon Activate resource disk Sep 12 17:45:26.892765 waagent[2026]: 2025-09-12T17:45:26.892712Z INFO Daemon Daemon Searching gen1 prefix 00000000-0001 or gen2 f8b3781a-1e82-4818-a1c3-63d806ec15bb Sep 12 17:45:26.903038 waagent[2026]: 2025-09-12T17:45:26.902988Z INFO Daemon Daemon Found device: sda Sep 12 17:45:26.912176 waagent[2026]: 2025-09-12T17:45:26.912127Z INFO Daemon Daemon Examining partition table Sep 12 17:45:26.960842 waagent[2026]: 2025-09-12T17:45:26.960797Z INFO Daemon Daemon GPT not detected, determining filesystem Sep 12 17:45:27.029915 waagent[2026]: 2025-09-12T17:45:27.029849Z INFO Daemon Daemon sfdisk --part-type -f /dev/sda 1 -n succeeded Sep 12 17:45:27.034890 waagent[2026]: 2025-09-12T17:45:27.034848Z INFO Daemon Daemon The partition is formatted with ntfs, updating partition type to 83 Sep 12 17:45:27.526599 kernel: hv_storvsc f8b3781a-1e82-4818-a1c3-63d806ec15bb: tag#478 cmd 0x5a status: scsi 0x2 srb 0x86 hv 0xc0000001 Sep 12 17:45:27.538597 kernel: sda: sda1 Sep 12 17:45:27.545689 kernel: hv_storvsc f8b3781a-1e82-4818-a1c3-63d806ec15bb: tag#501 cmd 0x5a status: scsi 0x2 srb 0x86 hv 0xc0000001 Sep 12 17:45:27.562598 kernel: sda: sda1 Sep 12 17:45:27.569107 waagent[2026]: 2025-09-12T17:45:27.569035Z INFO Daemon Daemon sfdisk --part-type /dev/sda 1 83 succeeded Sep 12 17:45:27.588641 kernel: hv_storvsc f8b3781a-1e82-4818-a1c3-63d806ec15bb: tag#509 cmd 0x5a status: scsi 0x2 srb 0x86 hv 0xc0000001 Sep 12 17:45:27.602596 kernel: sda: sda1 Sep 12 17:45:27.602769 waagent[2026]: 2025-09-12T17:45:27.602718Z INFO Daemon Daemon Format partition [mkfs.ext4 -F /dev/sda1] Sep 12 17:45:33.068069 login[2034]: pam_lastlog(login:session): file /var/log/lastlog is locked/write, retrying Sep 12 17:45:33.068342 login[2033]: pam_unix(login:session): session opened for user core(uid=500) by LOGIN(uid=0) Sep 12 17:45:33.074676 systemd[1]: Created slice user-500.slice - User Slice of UID 500. Sep 12 17:45:33.075720 systemd[1]: Starting user-runtime-dir@500.service - User Runtime Directory /run/user/500... Sep 12 17:45:33.081788 systemd-logind[1889]: New session 1 of user core. Sep 12 17:45:33.177789 systemd[1]: Finished user-runtime-dir@500.service - User Runtime Directory /run/user/500. Sep 12 17:45:33.180250 systemd[1]: Starting user@500.service - User Manager for UID 500... Sep 12 17:45:33.265567 waagent[2026]: 2025-09-12T17:45:33.265482Z INFO Daemon Daemon Mount resource disk [mount -t ext4 /dev/sda1 /mnt/resource] Sep 12 17:45:33.281413 (systemd)[2139]: pam_unix(systemd-user:session): session opened for user core(uid=500) by (uid=0) Sep 12 17:45:33.283902 systemd-logind[1889]: New session c1 of user core. Sep 12 17:45:33.383614 kernel: EXT4-fs (sda1): mounted filesystem a6708bf6-2f95-4e93-9da4-5e60aac67f8c r/w with ordered data mode. Quota mode: none. Sep 12 17:45:33.383847 waagent[2026]: 2025-09-12T17:45:33.383777Z INFO Daemon Daemon Resource disk /dev/sda is mounted at /mnt/resource with ext4 Sep 12 17:45:33.386022 waagent[2026]: 2025-09-12T17:45:33.385970Z INFO Daemon Daemon Clean protocol and wireserver endpoint Sep 12 17:45:33.386250 waagent[2026]: 2025-09-12T17:45:33.386212Z INFO Daemon Daemon Running default provisioning handler Sep 12 17:45:33.397034 waagent[2026]: 2025-09-12T17:45:33.396986Z 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. Sep 12 17:45:33.407067 waagent[2026]: 2025-09-12T17:45:33.407023Z INFO Daemon Daemon Unable to get cloud-init enabled status from service: [Errno 2] No such file or directory: 'service' Sep 12 17:45:33.414076 waagent[2026]: 2025-09-12T17:45:33.414032Z INFO Daemon Daemon cloud-init is enabled: False Sep 12 17:45:33.417917 waagent[2026]: 2025-09-12T17:45:33.417876Z INFO Daemon Daemon Copying ovf-env.xml Sep 12 17:45:33.503918 waagent[2026]: 2025-09-12T17:45:33.503849Z INFO Daemon Daemon Successfully mounted dvd Sep 12 17:45:33.532911 systemd[1]: mnt-cdrom-secure.mount: Deactivated successfully. Sep 12 17:45:33.533064 waagent[2026]: 2025-09-12T17:45:33.533023Z INFO Daemon Daemon Detect protocol endpoint Sep 12 17:45:33.534664 waagent[2026]: 2025-09-12T17:45:33.534619Z INFO Daemon Daemon Clean protocol and wireserver endpoint Sep 12 17:45:33.535436 waagent[2026]: 2025-09-12T17:45:33.535401Z INFO Daemon Daemon WireServer endpoint is not found. Rerun dhcp handler Sep 12 17:45:33.536900 waagent[2026]: 2025-09-12T17:45:33.536864Z INFO Daemon Daemon Test for route to 168.63.129.16 Sep 12 17:45:33.538564 waagent[2026]: 2025-09-12T17:45:33.538518Z INFO Daemon Daemon Route to 168.63.129.16 exists Sep 12 17:45:33.539177 waagent[2026]: 2025-09-12T17:45:33.539140Z INFO Daemon Daemon Wire server endpoint:168.63.129.16 Sep 12 17:45:33.549668 waagent[2026]: 2025-09-12T17:45:33.549615Z INFO Daemon Daemon Fabric preferred wire protocol version:2015-04-05 Sep 12 17:45:33.551431 waagent[2026]: 2025-09-12T17:45:33.551404Z INFO Daemon Daemon Wire protocol version:2012-11-30 Sep 12 17:45:33.552091 waagent[2026]: 2025-09-12T17:45:33.552059Z INFO Daemon Daemon Server preferred version:2015-04-05 Sep 12 17:45:33.666774 systemd[2139]: Queued start job for default target default.target. Sep 12 17:45:33.686429 systemd[2139]: Created slice app.slice - User Application Slice. Sep 12 17:45:33.686460 systemd[2139]: Reached target paths.target - Paths. Sep 12 17:45:33.686507 systemd[2139]: Reached target timers.target - Timers. Sep 12 17:45:33.687716 systemd[2139]: Starting dbus.socket - D-Bus User Message Bus Socket... Sep 12 17:45:33.703878 systemd[2139]: Listening on dbus.socket - D-Bus User Message Bus Socket. Sep 12 17:45:33.704708 systemd[2139]: Reached target sockets.target - Sockets. Sep 12 17:45:33.704771 systemd[2139]: Reached target basic.target - Basic System. Sep 12 17:45:33.704817 systemd[2139]: Reached target default.target - Main User Target. Sep 12 17:45:33.704848 systemd[1]: Started user@500.service - User Manager for UID 500. Sep 12 17:45:33.704850 systemd[2139]: Startup finished in 414ms. Sep 12 17:45:33.712743 systemd[1]: Started session-1.scope - Session 1 of User core. Sep 12 17:45:33.714257 waagent[2026]: 2025-09-12T17:45:33.714191Z INFO Daemon Daemon Initializing goal state during protocol detection Sep 12 17:45:33.715919 waagent[2026]: 2025-09-12T17:45:33.715873Z INFO Daemon Daemon Forcing an update of the goal state. Sep 12 17:45:33.719840 waagent[2026]: 2025-09-12T17:45:33.719796Z INFO Daemon Fetched a new incarnation for the WireServer goal state [incarnation 1] Sep 12 17:45:33.756373 waagent[2026]: 2025-09-12T17:45:33.756323Z INFO Daemon Daemon HostGAPlugin version: 1.0.8.175 Sep 12 17:45:33.758357 waagent[2026]: 2025-09-12T17:45:33.758317Z INFO Daemon Sep 12 17:45:33.759377 waagent[2026]: 2025-09-12T17:45:33.759338Z INFO Daemon Fetched new vmSettings [HostGAPlugin correlation ID: dbec70f6-daae-43d5-aaa5-a02ccb545af2 eTag: 6664082842097304902 source: Fabric] Sep 12 17:45:33.761128 waagent[2026]: 2025-09-12T17:45:33.761083Z INFO Daemon The vmSettings originated via Fabric; will ignore them. Sep 12 17:45:33.761850 waagent[2026]: 2025-09-12T17:45:33.761809Z INFO Daemon Sep 12 17:45:33.762302 waagent[2026]: 2025-09-12T17:45:33.762267Z INFO Daemon Fetching full goal state from the WireServer [incarnation 1] Sep 12 17:45:33.767324 waagent[2026]: 2025-09-12T17:45:33.767283Z INFO Daemon Daemon Downloading artifacts profile blob Sep 12 17:45:33.902179 waagent[2026]: 2025-09-12T17:45:33.902108Z INFO Daemon Downloaded certificate {'thumbprint': '459D645D70DB2D9007366C20DD2D3E413D8F7415', 'hasPrivateKey': True} Sep 12 17:45:33.904184 waagent[2026]: 2025-09-12T17:45:33.904132Z INFO Daemon Fetch goal state completed Sep 12 17:45:33.940150 waagent[2026]: 2025-09-12T17:45:33.940058Z INFO Daemon Daemon Starting provisioning Sep 12 17:45:33.942720 waagent[2026]: 2025-09-12T17:45:33.942659Z INFO Daemon Daemon Handle ovf-env.xml. Sep 12 17:45:33.943352 waagent[2026]: 2025-09-12T17:45:33.943317Z INFO Daemon Daemon Set hostname [ci-4426.1.0-a-b6cbffdee1] Sep 12 17:45:33.987149 waagent[2026]: 2025-09-12T17:45:33.987098Z INFO Daemon Daemon Publish hostname [ci-4426.1.0-a-b6cbffdee1] Sep 12 17:45:33.989036 waagent[2026]: 2025-09-12T17:45:33.988986Z INFO Daemon Daemon Examine /proc/net/route for primary interface Sep 12 17:45:33.989641 waagent[2026]: 2025-09-12T17:45:33.989601Z INFO Daemon Daemon Primary interface is [eth0] Sep 12 17:45:34.007832 systemd-networkd[1717]: eth0: found matching network '/usr/lib/systemd/network/zz-default.network', based on potentially unpredictable interface name. Sep 12 17:45:34.007843 systemd-networkd[1717]: eth0: Configuring with /usr/lib/systemd/network/zz-default.network. Sep 12 17:45:34.007876 systemd-networkd[1717]: eth0: DHCP lease lost Sep 12 17:45:34.008371 waagent[2026]: 2025-09-12T17:45:34.008326Z INFO Daemon Daemon Create user account if not exists Sep 12 17:45:34.009975 waagent[2026]: 2025-09-12T17:45:34.009931Z INFO Daemon Daemon User core already exists, skip useradd Sep 12 17:45:34.011431 waagent[2026]: 2025-09-12T17:45:34.011384Z INFO Daemon Daemon Configure sudoer Sep 12 17:45:34.017627 waagent[2026]: 2025-09-12T17:45:34.017563Z INFO Daemon Daemon Configure sshd Sep 12 17:45:34.029973 waagent[2026]: 2025-09-12T17:45:34.029929Z INFO Daemon Daemon Added a configuration snippet disabling SSH password-based authentication methods. It also configures SSH client probing to keep connections alive. Sep 12 17:45:34.032584 waagent[2026]: 2025-09-12T17:45:34.032524Z INFO Daemon Daemon Deploy ssh public key. Sep 12 17:45:34.070074 login[2034]: pam_unix(login:session): session opened for user core(uid=500) by LOGIN(uid=0) Sep 12 17:45:34.074534 systemd-logind[1889]: New session 2 of user core. Sep 12 17:45:34.074631 systemd-networkd[1717]: eth0: DHCPv4 address 10.200.8.11/24, gateway 10.200.8.1 acquired from 168.63.129.16 Sep 12 17:45:34.081718 systemd[1]: Started session-2.scope - Session 2 of User core. Sep 12 17:45:35.165036 waagent[2026]: 2025-09-12T17:45:35.164993Z INFO Daemon Daemon Provisioning complete Sep 12 17:45:35.176009 waagent[2026]: 2025-09-12T17:45:35.175964Z INFO Daemon Daemon RDMA capabilities are not enabled, skipping Sep 12 17:45:35.178547 waagent[2026]: 2025-09-12T17:45:35.178504Z INFO Daemon Daemon End of log to /dev/console. The agent will now check for updates and then will process extensions. Sep 12 17:45:35.179327 waagent[2026]: 2025-09-12T17:45:35.179281Z INFO Daemon Daemon Installed Agent WALinuxAgent-2.12.0.4 is the most current agent Sep 12 17:45:35.342321 waagent[2199]: 2025-09-12T17:45:35.342240Z INFO ExtHandler ExtHandler Azure Linux Agent (Goal State Agent version 2.12.0.4) Sep 12 17:45:35.342674 waagent[2199]: 2025-09-12T17:45:35.342387Z INFO ExtHandler ExtHandler OS: flatcar 4426.1.0 Sep 12 17:45:35.342674 waagent[2199]: 2025-09-12T17:45:35.342456Z INFO ExtHandler ExtHandler Python: 3.11.13 Sep 12 17:45:35.342674 waagent[2199]: 2025-09-12T17:45:35.342525Z INFO ExtHandler ExtHandler CPU Arch: x86_64 Sep 12 17:45:35.492908 waagent[2199]: 2025-09-12T17:45:35.492778Z INFO ExtHandler ExtHandler Distro: flatcar-4426.1.0; OSUtil: FlatcarUtil; AgentService: waagent; Python: 3.11.13; Arch: x86_64; systemd: True; LISDrivers: Absent; logrotate: logrotate 3.22.0; Sep 12 17:45:35.493060 waagent[2199]: 2025-09-12T17:45:35.493021Z INFO ExtHandler ExtHandler WireServer endpoint 168.63.129.16 read from file Sep 12 17:45:35.493137 waagent[2199]: 2025-09-12T17:45:35.493105Z INFO ExtHandler ExtHandler Wire server endpoint:168.63.129.16 Sep 12 17:45:35.500081 waagent[2199]: 2025-09-12T17:45:35.500027Z INFO ExtHandler Fetched a new incarnation for the WireServer goal state [incarnation 1] Sep 12 17:45:35.504885 waagent[2199]: 2025-09-12T17:45:35.504848Z INFO ExtHandler ExtHandler HostGAPlugin version: 1.0.8.175 Sep 12 17:45:35.505330 waagent[2199]: 2025-09-12T17:45:35.505291Z INFO ExtHandler Sep 12 17:45:35.505408 waagent[2199]: 2025-09-12T17:45:35.505377Z INFO ExtHandler Fetched new vmSettings [HostGAPlugin correlation ID: 2e3b29f0-ecec-4257-9423-ac22ea9174ed eTag: 6664082842097304902 source: Fabric] Sep 12 17:45:35.505751 waagent[2199]: 2025-09-12T17:45:35.505712Z INFO ExtHandler The vmSettings originated via Fabric; will ignore them. Sep 12 17:45:35.506353 waagent[2199]: 2025-09-12T17:45:35.506315Z INFO ExtHandler Sep 12 17:45:35.506422 waagent[2199]: 2025-09-12T17:45:35.506392Z INFO ExtHandler Fetching full goal state from the WireServer [incarnation 1] Sep 12 17:45:35.509807 waagent[2199]: 2025-09-12T17:45:35.509777Z INFO ExtHandler ExtHandler Downloading artifacts profile blob Sep 12 17:45:35.593521 waagent[2199]: 2025-09-12T17:45:35.593452Z INFO ExtHandler Downloaded certificate {'thumbprint': '459D645D70DB2D9007366C20DD2D3E413D8F7415', 'hasPrivateKey': True} Sep 12 17:45:35.594142 waagent[2199]: 2025-09-12T17:45:35.594088Z INFO ExtHandler Fetch goal state completed Sep 12 17:45:35.605286 waagent[2199]: 2025-09-12T17:45:35.605242Z INFO ExtHandler ExtHandler OpenSSL version: OpenSSL 3.4.1 11 Feb 2025 (Library: OpenSSL 3.4.1 11 Feb 2025) Sep 12 17:45:35.610204 waagent[2199]: 2025-09-12T17:45:35.610165Z INFO ExtHandler ExtHandler WALinuxAgent-2.12.0.4 running as process 2199 Sep 12 17:45:35.610350 waagent[2199]: 2025-09-12T17:45:35.610315Z INFO ExtHandler ExtHandler ******** AutoUpdate.Enabled is set to False, not processing the operation ******** Sep 12 17:45:35.610763 waagent[2199]: 2025-09-12T17:45:35.610717Z INFO ExtHandler ExtHandler ******** AutoUpdate.UpdateToLatestVersion is set to False, not processing the operation ******** Sep 12 17:45:35.612389 waagent[2199]: 2025-09-12T17:45:35.612345Z INFO ExtHandler ExtHandler [CGI] Cgroup monitoring is not supported on ['flatcar', '4426.1.0', '', 'Flatcar Container Linux by Kinvolk'] Sep 12 17:45:35.612843 waagent[2199]: 2025-09-12T17:45:35.612804Z INFO ExtHandler ExtHandler [CGI] Agent will reset the quotas in case distro: ['flatcar', '4426.1.0', '', 'Flatcar Container Linux by Kinvolk'] went from supported to unsupported Sep 12 17:45:35.612998 waagent[2199]: 2025-09-12T17:45:35.612964Z INFO ExtHandler ExtHandler [CGI] Agent cgroups enabled: False Sep 12 17:45:35.613606 waagent[2199]: 2025-09-12T17:45:35.613551Z INFO ExtHandler ExtHandler Starting setup for Persistent firewall rules Sep 12 17:45:35.766974 waagent[2199]: 2025-09-12T17:45:35.766877Z INFO ExtHandler ExtHandler Firewalld service not running/unavailable, trying to set up waagent-network-setup.service Sep 12 17:45:35.767123 waagent[2199]: 2025-09-12T17:45:35.767089Z INFO ExtHandler ExtHandler Successfully updated the Binary file /var/lib/waagent/waagent-network-setup.py for firewall setup Sep 12 17:45:35.773783 waagent[2199]: 2025-09-12T17:45:35.773749Z INFO ExtHandler ExtHandler Service: waagent-network-setup.service not enabled. Adding it now Sep 12 17:45:35.780271 systemd[1]: Reload requested from client PID 2214 ('systemctl') (unit waagent.service)... Sep 12 17:45:35.780287 systemd[1]: Reloading... Sep 12 17:45:35.843610 zram_generator::config[2256]: No configuration found. Sep 12 17:45:36.121844 systemd[1]: Reloading finished in 341 ms. Sep 12 17:45:36.147126 waagent[2199]: 2025-09-12T17:45:36.147047Z INFO ExtHandler ExtHandler Successfully added and enabled the waagent-network-setup.service Sep 12 17:45:36.147227 waagent[2199]: 2025-09-12T17:45:36.147201Z INFO ExtHandler ExtHandler Persistent firewall rules setup successfully Sep 12 17:45:37.040230 waagent[2199]: 2025-09-12T17:45:37.040147Z INFO ExtHandler ExtHandler DROP rule is not available which implies no firewall rules are set yet. Environment thread will set it up. Sep 12 17:45:37.040625 waagent[2199]: 2025-09-12T17:45:37.040481Z 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] Sep 12 17:45:37.041302 waagent[2199]: 2025-09-12T17:45:37.041254Z INFO ExtHandler ExtHandler Starting env monitor service. Sep 12 17:45:37.041551 waagent[2199]: 2025-09-12T17:45:37.041506Z INFO MonitorHandler ExtHandler WireServer endpoint 168.63.129.16 read from file Sep 12 17:45:37.041899 waagent[2199]: 2025-09-12T17:45:37.041858Z INFO ExtHandler ExtHandler Start SendTelemetryHandler service. Sep 12 17:45:37.041978 waagent[2199]: 2025-09-12T17:45:37.041942Z INFO MonitorHandler ExtHandler Wire server endpoint:168.63.129.16 Sep 12 17:45:37.042339 waagent[2199]: 2025-09-12T17:45:37.042294Z INFO EnvHandler ExtHandler WireServer endpoint 168.63.129.16 read from file Sep 12 17:45:37.042766 waagent[2199]: 2025-09-12T17:45:37.042718Z INFO MonitorHandler ExtHandler Monitor.NetworkConfigurationChanges is disabled. Sep 12 17:45:37.042878 waagent[2199]: 2025-09-12T17:45:37.042824Z INFO SendTelemetryHandler ExtHandler Successfully started the SendTelemetryHandler thread Sep 12 17:45:37.043001 waagent[2199]: 2025-09-12T17:45:37.042960Z INFO ExtHandler ExtHandler Start Extension Telemetry service. Sep 12 17:45:37.043289 waagent[2199]: 2025-09-12T17:45:37.043252Z INFO EnvHandler ExtHandler Wire server endpoint:168.63.129.16 Sep 12 17:45:37.043634 waagent[2199]: 2025-09-12T17:45:37.043555Z INFO TelemetryEventsCollector ExtHandler Extension Telemetry pipeline enabled: True Sep 12 17:45:37.043717 waagent[2199]: 2025-09-12T17:45:37.043645Z INFO ExtHandler ExtHandler Goal State Period: 6 sec. This indicates how often the agent checks for new goal states and reports status. Sep 12 17:45:37.043997 waagent[2199]: 2025-09-12T17:45:37.043950Z INFO MonitorHandler ExtHandler Routing table from /proc/net/route: Sep 12 17:45:37.043997 waagent[2199]: Iface Destination Gateway Flags RefCnt Use Metric Mask MTU Window IRTT Sep 12 17:45:37.043997 waagent[2199]: eth0 00000000 0108C80A 0003 0 0 1024 00000000 0 0 0 Sep 12 17:45:37.043997 waagent[2199]: eth0 0008C80A 00000000 0001 0 0 1024 00FFFFFF 0 0 0 Sep 12 17:45:37.043997 waagent[2199]: eth0 0108C80A 00000000 0005 0 0 1024 FFFFFFFF 0 0 0 Sep 12 17:45:37.043997 waagent[2199]: eth0 10813FA8 0108C80A 0007 0 0 1024 FFFFFFFF 0 0 0 Sep 12 17:45:37.043997 waagent[2199]: eth0 FEA9FEA9 0108C80A 0007 0 0 1024 FFFFFFFF 0 0 0 Sep 12 17:45:37.044156 waagent[2199]: 2025-09-12T17:45:37.044090Z INFO TelemetryEventsCollector ExtHandler Successfully started the TelemetryEventsCollector thread Sep 12 17:45:37.044425 waagent[2199]: 2025-09-12T17:45:37.044379Z INFO EnvHandler ExtHandler Configure routes Sep 12 17:45:37.045139 waagent[2199]: 2025-09-12T17:45:37.045100Z INFO EnvHandler ExtHandler Gateway:None Sep 12 17:45:37.045437 waagent[2199]: 2025-09-12T17:45:37.045398Z INFO EnvHandler ExtHandler Routes:None Sep 12 17:45:37.049668 waagent[2199]: 2025-09-12T17:45:37.049627Z INFO ExtHandler ExtHandler Sep 12 17:45:37.049991 waagent[2199]: 2025-09-12T17:45:37.049952Z INFO ExtHandler ExtHandler ProcessExtensionsGoalState started [incarnation_1 channel: WireServer source: Fabric activity: caf2472f-87ce-4b37-aa28-8bf24281e896 correlation 85e10c09-7286-49aa-8e52-ce354abdfe21 created: 2025-09-12T17:43:54.375450Z] Sep 12 17:45:37.051078 waagent[2199]: 2025-09-12T17:45:37.051036Z INFO ExtHandler ExtHandler No extension handlers found, not processing anything. Sep 12 17:45:37.055302 waagent[2199]: 2025-09-12T17:45:37.055258Z INFO ExtHandler ExtHandler ProcessExtensionsGoalState completed [incarnation_1 5 ms] Sep 12 17:45:37.082647 waagent[2199]: 2025-09-12T17:45:37.082599Z 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 Sep 12 17:45:37.082647 waagent[2199]: Try `iptables -h' or 'iptables --help' for more information.) Sep 12 17:45:37.083012 waagent[2199]: 2025-09-12T17:45:37.082974Z INFO ExtHandler ExtHandler [HEARTBEAT] Agent WALinuxAgent-2.12.0.4 is running as the goal state agent [DEBUG HeartbeatCounter: 0;HeartbeatId: 77CF3B6A-F215-403E-8E51-AFDF74F53446;DroppedPackets: -1;UpdateGSErrors: 0;AutoUpdate: 0;UpdateMode: SelfUpdate;] Sep 12 17:45:37.135440 waagent[2199]: 2025-09-12T17:45:37.135386Z INFO MonitorHandler ExtHandler Network interfaces: Sep 12 17:45:37.135440 waagent[2199]: Executing ['ip', '-a', '-o', 'link']: Sep 12 17:45:37.135440 waagent[2199]: 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 Sep 12 17:45:37.135440 waagent[2199]: 2: eth0: mtu 1500 qdisc mq state UP mode DEFAULT group default qlen 1000\ link/ether 7c:ed:8d:2d:a0:60 brd ff:ff:ff:ff:ff:ff Sep 12 17:45:37.135440 waagent[2199]: Executing ['ip', '-4', '-a', '-o', 'address']: Sep 12 17:45:37.135440 waagent[2199]: 1: lo inet 127.0.0.1/8 scope host lo\ valid_lft forever preferred_lft forever Sep 12 17:45:37.135440 waagent[2199]: 2: eth0 inet 10.200.8.11/24 metric 1024 brd 10.200.8.255 scope global eth0\ valid_lft forever preferred_lft forever Sep 12 17:45:37.135440 waagent[2199]: Executing ['ip', '-6', '-a', '-o', 'address']: Sep 12 17:45:37.135440 waagent[2199]: 1: lo inet6 ::1/128 scope host noprefixroute \ valid_lft forever preferred_lft forever Sep 12 17:45:37.135440 waagent[2199]: 2: eth0 inet6 fe80::7eed:8dff:fe2d:a060/64 scope link proto kernel_ll \ valid_lft forever preferred_lft forever Sep 12 17:45:37.284948 waagent[2199]: 2025-09-12T17:45:37.284826Z INFO EnvHandler ExtHandler Created firewall rules for the Azure Fabric: Sep 12 17:45:37.284948 waagent[2199]: Chain INPUT (policy ACCEPT 0 packets, 0 bytes) Sep 12 17:45:37.284948 waagent[2199]: pkts bytes target prot opt in out source destination Sep 12 17:45:37.284948 waagent[2199]: Chain FORWARD (policy ACCEPT 0 packets, 0 bytes) Sep 12 17:45:37.284948 waagent[2199]: pkts bytes target prot opt in out source destination Sep 12 17:45:37.284948 waagent[2199]: Chain OUTPUT (policy ACCEPT 0 packets, 0 bytes) Sep 12 17:45:37.284948 waagent[2199]: pkts bytes target prot opt in out source destination Sep 12 17:45:37.284948 waagent[2199]: 0 0 ACCEPT tcp -- * * 0.0.0.0/0 168.63.129.16 tcp dpt:53 Sep 12 17:45:37.284948 waagent[2199]: 0 0 ACCEPT tcp -- * * 0.0.0.0/0 168.63.129.16 owner UID match 0 Sep 12 17:45:37.284948 waagent[2199]: 0 0 DROP tcp -- * * 0.0.0.0/0 168.63.129.16 ctstate INVALID,NEW Sep 12 17:45:37.290892 waagent[2199]: 2025-09-12T17:45:37.290818Z INFO EnvHandler ExtHandler Current Firewall rules: Sep 12 17:45:37.290892 waagent[2199]: Chain INPUT (policy ACCEPT 0 packets, 0 bytes) Sep 12 17:45:37.290892 waagent[2199]: pkts bytes target prot opt in out source destination Sep 12 17:45:37.290892 waagent[2199]: Chain FORWARD (policy ACCEPT 0 packets, 0 bytes) Sep 12 17:45:37.290892 waagent[2199]: pkts bytes target prot opt in out source destination Sep 12 17:45:37.290892 waagent[2199]: Chain OUTPUT (policy ACCEPT 2 packets, 104 bytes) Sep 12 17:45:37.290892 waagent[2199]: pkts bytes target prot opt in out source destination Sep 12 17:45:37.290892 waagent[2199]: 0 0 ACCEPT tcp -- * * 0.0.0.0/0 168.63.129.16 tcp dpt:53 Sep 12 17:45:37.290892 waagent[2199]: 0 0 ACCEPT tcp -- * * 0.0.0.0/0 168.63.129.16 owner UID match 0 Sep 12 17:45:37.290892 waagent[2199]: 0 0 DROP tcp -- * * 0.0.0.0/0 168.63.129.16 ctstate INVALID,NEW Sep 12 17:45:37.291108 waagent[2199]: 2025-09-12T17:45:37.291075Z INFO EnvHandler ExtHandler Set block dev timeout: sdb with timeout: 300 Sep 12 17:45:37.291251 waagent[2199]: 2025-09-12T17:45:37.291217Z INFO EnvHandler ExtHandler Set block dev timeout: sda with timeout: 300 Sep 12 17:45:41.181623 systemd[1]: Created slice system-sshd.slice - Slice /system/sshd. Sep 12 17:45:41.184368 systemd[1]: Started sshd@0-10.200.8.11:22-10.200.16.10:39572.service - OpenSSH per-connection server daemon (10.200.16.10:39572). Sep 12 17:45:42.174303 sshd[2347]: Accepted publickey for core from 10.200.16.10 port 39572 ssh2: RSA SHA256:N57c16sACXEH7T/hPh2WdUB1bqX8lYhBLQ19XJC/uD8 Sep 12 17:45:42.175539 sshd-session[2347]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Sep 12 17:45:42.180047 systemd-logind[1889]: New session 3 of user core. Sep 12 17:45:42.190701 systemd[1]: Started session-3.scope - Session 3 of User core. Sep 12 17:45:42.727802 systemd[1]: Started sshd@1-10.200.8.11:22-10.200.16.10:39586.service - OpenSSH per-connection server daemon (10.200.16.10:39586). Sep 12 17:45:43.352533 sshd[2353]: Accepted publickey for core from 10.200.16.10 port 39586 ssh2: RSA SHA256:N57c16sACXEH7T/hPh2WdUB1bqX8lYhBLQ19XJC/uD8 Sep 12 17:45:43.353791 sshd-session[2353]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Sep 12 17:45:43.358061 systemd-logind[1889]: New session 4 of user core. Sep 12 17:45:43.371717 systemd[1]: Started session-4.scope - Session 4 of User core. Sep 12 17:45:43.794617 sshd[2356]: Connection closed by 10.200.16.10 port 39586 Sep 12 17:45:43.794952 sshd-session[2353]: pam_unix(sshd:session): session closed for user core Sep 12 17:45:43.798298 systemd[1]: sshd@1-10.200.8.11:22-10.200.16.10:39586.service: Deactivated successfully. Sep 12 17:45:43.799827 systemd[1]: session-4.scope: Deactivated successfully. Sep 12 17:45:43.800487 systemd-logind[1889]: Session 4 logged out. Waiting for processes to exit. Sep 12 17:45:43.801374 systemd-logind[1889]: Removed session 4. Sep 12 17:45:43.916661 systemd[1]: Started sshd@2-10.200.8.11:22-10.200.16.10:39596.service - OpenSSH per-connection server daemon (10.200.16.10:39596). Sep 12 17:45:44.566773 sshd[2362]: Accepted publickey for core from 10.200.16.10 port 39596 ssh2: RSA SHA256:N57c16sACXEH7T/hPh2WdUB1bqX8lYhBLQ19XJC/uD8 Sep 12 17:45:44.568026 sshd-session[2362]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Sep 12 17:45:44.572128 systemd-logind[1889]: New session 5 of user core. Sep 12 17:45:44.578697 systemd[1]: Started session-5.scope - Session 5 of User core. Sep 12 17:45:45.009448 sshd[2365]: Connection closed by 10.200.16.10 port 39596 Sep 12 17:45:45.009803 sshd-session[2362]: pam_unix(sshd:session): session closed for user core Sep 12 17:45:45.013141 systemd[1]: sshd@2-10.200.8.11:22-10.200.16.10:39596.service: Deactivated successfully. Sep 12 17:45:45.014692 systemd[1]: session-5.scope: Deactivated successfully. Sep 12 17:45:45.015351 systemd-logind[1889]: Session 5 logged out. Waiting for processes to exit. Sep 12 17:45:45.016417 systemd-logind[1889]: Removed session 5. Sep 12 17:45:46.801440 setup-nvidia[2044]: \u000d 0 0 0 0 0 0 0 0 --:--:-- --:--:-- --:--:-- 0\u000d 0 0 0 0 0 0 0 0 --:--:-- --:--:-- --:--:-- 0\u000d 0 472M 0 704k 0 0 553k 0 0:14:32 0:00:01 0:14:31 553k\u000d 4 472M 4 19.3M 0 0 8795k 0 0:00:54 0:00:02 0:00:52 8793k\u000d 9 472M 9 44.7M 0 0 13.7M 0 0:00:34 0:00:03 0:00:31 13.7M\u000d 14 472M 14 68.9M 0 0 16.1M 0 0:00:29 0:00:04 0:00:25 16.1M\u000d 19 472M 19 94.2M 0 0 17.9M 0 0:00:26 0:00:05 0:00:21 18.5M\u000d 25 472M 25 118M 0 0 18.9M 0 0:00:24 0:00:06 0:00:18 23.5M\u000d 29 472M 29 140M 0 0 19.3M 0 0:00:24 0:00:07 0:00:17 24.2M\u000d 33 472M 33 158M 0 0 19.3M 0 0:00:24 0:00:08 0:00:16 23.1M\u000d 38 472M 38 182M 0 0 19.6M 0 0:00:24 0:00:09 0:00:15 22.5M\u000d 43 472M 43 205M 0 0 20.0M 0 0:00:23 0:00:10 0:00:13 22.2M\u000d 48 472M 48 228M 0 0 20.3M 0 0:00:23 0:00:11 0:00:12 22.0M\u000d 53 472M 53 251M 0 0 20.4M 0 0:00:23 0:00:12 0:00:11 22.0M\u000d 57 472M 57 273M 0 0 20.6M 0 0:00:22 0:00:13 0:00:09 22.7M\u000d 62 472M 62 296M 0 0 20.8M 0 0:00:22 0:00:14 0:00:08 23.0M\u000d 67 472M 67 319M 0 0 20.9M 0 0:00:22 0:00:15 0:00:07 22.9M\u000d 72 472M 72 341M 0 0 21.0M 0 0:00:22 0:00:16 0:00:06 22.7M\u000d 77 472M 77 364M 0 0 21.1M 0 0:00:22 0:00:17 0:00:05 22.8M\u000d 82 472M 82 387M 0 0 21.2M 0 0:00:22 0:00:18 0:00:04 22.9M\u000d 86 472M 86 409M 0 0 21.3M 0 0:00:22 0:00:19 0:00:03 22.8M\u000d 91 472M 91 432M 0 0 21.3M 0 0:00:22 0:00:20 0:00:02 22.6M\u000d 96 472M 96 455M 0 0 21.4M 0 0:00:21 0:00:21 --:--:-- 22.8M\u000d100 472M 100 472M 0 0 21.5M 0 0:00:21 0:00:21 --:--:-- 22.9M Sep 12 17:45:47.771983 chronyd[1868]: Selected source PHC0 Sep 12 17:45:55.124917 systemd[1]: Started sshd@3-10.200.8.11:22-10.200.16.10:41258.service - OpenSSH per-connection server daemon (10.200.16.10:41258). Sep 12 17:45:55.762252 sshd[2381]: Accepted publickey for core from 10.200.16.10 port 41258 ssh2: RSA SHA256:N57c16sACXEH7T/hPh2WdUB1bqX8lYhBLQ19XJC/uD8 Sep 12 17:45:55.764255 sshd-session[2381]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Sep 12 17:45:55.774605 systemd-logind[1889]: New session 6 of user core. Sep 12 17:45:55.782768 systemd[1]: Started session-6.scope - Session 6 of User core. Sep 12 17:45:56.211610 sshd[2384]: Connection closed by 10.200.16.10 port 41258 Sep 12 17:45:56.210813 sshd-session[2381]: pam_unix(sshd:session): session closed for user core Sep 12 17:45:56.214398 systemd[1]: sshd@3-10.200.8.11:22-10.200.16.10:41258.service: Deactivated successfully. Sep 12 17:45:56.218193 systemd[1]: session-6.scope: Deactivated successfully. Sep 12 17:45:56.219747 systemd-logind[1889]: Session 6 logged out. Waiting for processes to exit. Sep 12 17:45:56.221947 systemd-logind[1889]: Removed session 6. Sep 12 17:45:56.326296 systemd[1]: Started sshd@4-10.200.8.11:22-10.200.16.10:41270.service - OpenSSH per-connection server daemon (10.200.16.10:41270). Sep 12 17:45:56.725003 setup-nvidia[1881]: Downloading NVIDIA 535.247.01 Driver Sep 12 17:45:56.729357 setup-nvidia[2394]: % Total % Received % Xferd Average Speed Time Time Time Current Sep 12 17:45:56.729555 setup-nvidia[2394]: Dload Upload Total Spent Left Speed Sep 12 17:45:56.975217 sshd[2390]: Accepted publickey for core from 10.200.16.10 port 41270 ssh2: RSA SHA256:N57c16sACXEH7T/hPh2WdUB1bqX8lYhBLQ19XJC/uD8 Sep 12 17:45:56.976381 sshd-session[2390]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Sep 12 17:45:56.980561 systemd-logind[1889]: New session 7 of user core. Sep 12 17:45:56.990710 systemd[1]: Started session-7.scope - Session 7 of User core. Sep 12 17:45:57.420205 sshd[2395]: Connection closed by 10.200.16.10 port 41270 Sep 12 17:45:57.420540 sshd-session[2390]: pam_unix(sshd:session): session closed for user core Sep 12 17:45:57.423804 systemd[1]: sshd@4-10.200.8.11:22-10.200.16.10:41270.service: Deactivated successfully. Sep 12 17:45:57.425339 systemd[1]: session-7.scope: Deactivated successfully. Sep 12 17:45:57.426025 systemd-logind[1889]: Session 7 logged out. Waiting for processes to exit. Sep 12 17:45:57.426963 systemd-logind[1889]: Removed session 7. Sep 12 17:46:04.737140 kernel: hv_balloon: Max. dynamic memory size: 114688 MB Sep 12 17:46:07.532692 systemd[1]: Started sshd@5-10.200.8.11:22-10.200.16.10:42696.service - OpenSSH per-connection server daemon (10.200.16.10:42696). Sep 12 17:46:08.159621 sshd[2402]: Accepted publickey for core from 10.200.16.10 port 42696 ssh2: RSA SHA256:N57c16sACXEH7T/hPh2WdUB1bqX8lYhBLQ19XJC/uD8 Sep 12 17:46:08.160829 sshd-session[2402]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Sep 12 17:46:08.165001 systemd-logind[1889]: New session 8 of user core. Sep 12 17:46:08.167464 setup-nvidia[2394]: \u000d 0 0 0 0 0 0 0 0 --:--:-- --:--:-- --:--:-- 0\u000d 0 326M 0 15608 0 0 21324 0 4:27:11 --:--:-- 4:27:11 21322\u000d 4 326M 4 14.1M 0 0 10.8M 0 0:00:30 0:00:01 0:00:29 10.8M\u000d 14 326M 14 48.0M 0 0 20.5M 0 0:00:15 0:00:02 0:00:13 20.5M\u000d 23 326M 23 78.0M 0 0 23.3M 0 0:00:13 0:00:03 0:00:10 23.3M\u000d 34 326M 34 114M 0 0 26.3M 0 0:00:12 0:00:04 0:00:08 26.3M\u000d 43 326M 43 142M 0 0 26.8M 0 0:00:12 0:00:05 0:00:07 31.1M\u000d 54 326M 54 178M 0 0 28.1M 0 0:00:11 0:00:06 0:00:05 32.6M\u000d 65 326M 65 213M 0 0 29.2M 0 0:00:11 0:00:07 0:00:04 33.3M\u000d 74 326M 74 242M 0 0 29.1M 0 0:00:11 0:00:08 0:00:03 33.0M\u000d 85 326M 85 278M 0 0 29.9M 0 0:00:10 0:00:09 0:00:01 33.1M\u000d 96 326M 96 314M 0 0 29.2M 0 0:00:11 0:00:10 0:00:01 31.6M\u000d 98 326M 98 320M 0 0 28.2M 0 0:00:11 0:00:11 --:--:-- 28.4M\u000d100 326M 100 326M 0 0 28.5M 0 0:00:11 0:00:11 --:--:-- 27.1M Sep 12 17:46:08.175696 systemd[1]: Started session-8.scope - Session 8 of User core. Sep 12 17:46:08.238749 setup-nvidia[1881]: Extract the NVIDIA Driver Installer 535.247.01 Sep 12 17:46:08.238979 setup-nvidia[1881]: /opt/nvidia/workdir/nvidia-workdir / Sep 12 17:46:08.256418 setup-nvidia[2408]: Creating directory NVIDIA-Linux-x86_64-535.247.01 Sep 12 17:46:08.524008 setup-nvidia[2408]: Verifying archive integrity... OK Sep 12 17:46:08.602793 sshd[2406]: Connection closed by 10.200.16.10 port 42696 Sep 12 17:46:08.603176 sshd-session[2402]: pam_unix(sshd:session): session closed for user core Sep 12 17:46:08.606230 systemd[1]: sshd@5-10.200.8.11:22-10.200.16.10:42696.service: Deactivated successfully. Sep 12 17:46:08.608088 systemd[1]: session-8.scope: Deactivated successfully. Sep 12 17:46:08.609295 systemd-logind[1889]: Session 8 logged out. Waiting for processes to exit. Sep 12 17:46:08.610287 systemd-logind[1889]: Removed session 8. Sep 12 17:46:08.725803 systemd[1]: Started sshd@6-10.200.8.11:22-10.200.16.10:42700.service - OpenSSH per-connection server daemon (10.200.16.10:42700). Sep 12 17:46:09.328696 setup-nvidia[2408]: Uncompressing NVIDIA Accelerated Graphics Driver for Linux-x86_64 535.247.01 Sep 12 17:46:09.363382 sshd[2436]: Accepted publickey for core from 10.200.16.10 port 42700 ssh2: RSA SHA256:N57c16sACXEH7T/hPh2WdUB1bqX8lYhBLQ19XJC/uD8 Sep 12 17:46:09.365250 sshd-session[2436]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Sep 12 17:46:09.371503 systemd-logind[1889]: New session 9 of user core. Sep 12 17:46:09.377764 systemd[1]: Started session-9.scope - Session 9 of User core. Sep 12 17:46:09.809057 sshd[2446]: Connection closed by 10.200.16.10 port 42700 Sep 12 17:46:09.809454 sshd-session[2436]: pam_unix(sshd:session): session closed for user core Sep 12 17:46:09.813068 systemd[1]: sshd@6-10.200.8.11:22-10.200.16.10:42700.service: Deactivated successfully. Sep 12 17:46:09.814682 systemd[1]: session-9.scope: Deactivated successfully. Sep 12 17:46:09.815396 systemd-logind[1889]: Session 9 logged out. Waiting for processes to exit. Sep 12 17:46:09.816507 systemd-logind[1889]: Removed session 9. Sep 12 17:46:09.881721 update_engine[1890]: I20250912 17:46:09.881611 1890 update_attempter.cc:509] Updating boot flags... Sep 12 17:46:11.111158 setup-nvidia[2442]: ........................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................ Sep 12 17:46:11.229187 setup-nvidia[1881]: / Sep 12 17:46:11.229442 setup-nvidia[1881]: Spawn system-nspawn container to install the NVIDIA drivers Sep 12 17:46:11.524344 sudo[2518]: root : PWD=/ ; USER=root ; COMMAND=/usr/sbin/systemd-nspawn --keep-unit --register=no --read-only --volatile=overlay --image=/opt/nvidia/workdir/flatcar_developer_container-4426.1.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.247.01 Sep 12 17:46:11.526048 sudo[2518]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=0) Sep 12 17:46:11.531722 systemd[1]: Created slice user-0.slice - User Slice of UID 0. Sep 12 17:46:11.534317 systemd[1]: Starting user-runtime-dir@0.service - User Runtime Directory /run/user/0... Sep 12 17:46:11.567811 systemd[1]: Finished user-runtime-dir@0.service - User Runtime Directory /run/user/0. Sep 12 17:46:11.572065 systemd[1]: Starting user@0.service - User Manager for UID 0... Sep 12 17:46:11.588556 (systemd)[2521]: pam_unix(systemd-user:session): session opened for user root(uid=0) by (uid=0) Sep 12 17:46:11.590765 systemd-logind[1889]: New session c3 of user root. Sep 12 17:46:11.767814 systemd[2521]: Queued start job for default target default.target. Sep 12 17:46:11.785738 systemd[2521]: Created slice app.slice - User Application Slice. Sep 12 17:46:11.785769 systemd[2521]: Reached target paths.target - Paths. Sep 12 17:46:11.785816 systemd[2521]: Reached target timers.target - Timers. Sep 12 17:46:11.786941 systemd[2521]: Starting dbus.socket - D-Bus User Message Bus Socket... Sep 12 17:46:11.797804 systemd[2521]: Listening on dbus.socket - D-Bus User Message Bus Socket. Sep 12 17:46:11.797922 systemd[2521]: Reached target sockets.target - Sockets. Sep 12 17:46:11.797977 systemd[2521]: Reached target basic.target - Basic System. Sep 12 17:46:11.798021 systemd[2521]: Reached target default.target - Main User Target. Sep 12 17:46:11.798053 systemd[2521]: Startup finished in 201ms. Sep 12 17:46:11.798082 systemd[1]: Started user@0.service - User Manager for UID 0. Sep 12 17:46:11.801695 systemd[1]: Started session-c2.scope - Session c2 of User root. Sep 12 17:46:11.836603 kernel: loop6: detected capacity change from 0 to 12644352 Sep 12 17:46:11.845593 kernel: loop6: p9 Sep 12 17:46:11.904798 setup-nvidia[2530]: ░ Spawning container flatcardevelopercontainer-4426.1.0.bin on /opt/nvidia/workdir/flatcar_developer_container-4426.1.0.bin. Sep 12 17:46:12.280096 kernel: EXT4-fs (loop6p9): write access unavailable, skipping orphan cleanup Sep 12 17:46:12.280202 kernel: EXT4-fs (loop6p9): mounted filesystem 551f0cf8-e67b-4b0c-a816-719b45050a1c ro without journal. Quota mode: none. Sep 12 17:46:19.924194 systemd[1]: Started sshd@7-10.200.8.11:22-10.200.16.10:49268.service - OpenSSH per-connection server daemon (10.200.16.10:49268). Sep 12 17:46:20.550305 sshd[2925]: Accepted publickey for core from 10.200.16.10 port 49268 ssh2: RSA SHA256:N57c16sACXEH7T/hPh2WdUB1bqX8lYhBLQ19XJC/uD8 Sep 12 17:46:20.551642 sshd-session[2925]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Sep 12 17:46:20.556070 systemd-logind[1889]: New session 10 of user core. Sep 12 17:46:20.566719 systemd[1]: Started session-10.scope - Session 10 of User core. Sep 12 17:46:20.992639 sshd[3057]: Connection closed by 10.200.16.10 port 49268 Sep 12 17:46:20.993025 sshd-session[2925]: pam_unix(sshd:session): session closed for user core Sep 12 17:46:20.996537 systemd[1]: sshd@7-10.200.8.11:22-10.200.16.10:49268.service: Deactivated successfully. Sep 12 17:46:20.998085 systemd[1]: session-10.scope: Deactivated successfully. Sep 12 17:46:20.998782 systemd-logind[1889]: Session 10 logged out. Waiting for processes to exit. Sep 12 17:46:20.999664 systemd-logind[1889]: Removed session 10. Sep 12 17:46:21.107624 systemd[1]: Started sshd@8-10.200.8.11:22-10.200.16.10:49274.service - OpenSSH per-connection server daemon (10.200.16.10:49274). Sep 12 17:46:21.750309 sshd[3262]: Accepted publickey for core from 10.200.16.10 port 49274 ssh2: RSA SHA256:N57c16sACXEH7T/hPh2WdUB1bqX8lYhBLQ19XJC/uD8 Sep 12 17:46:21.751534 sshd-session[3262]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Sep 12 17:46:21.755689 systemd-logind[1889]: New session 11 of user core. Sep 12 17:46:21.768712 systemd[1]: Started session-11.scope - Session 11 of User core. Sep 12 17:46:22.193754 sshd[3265]: Connection closed by 10.200.16.10 port 49274 Sep 12 17:46:22.194081 sshd-session[3262]: pam_unix(sshd:session): session closed for user core Sep 12 17:46:22.197590 systemd[1]: sshd@8-10.200.8.11:22-10.200.16.10:49274.service: Deactivated successfully. Sep 12 17:46:22.203051 systemd[1]: session-11.scope: Deactivated successfully. Sep 12 17:46:22.207916 systemd-logind[1889]: Session 11 logged out. Waiting for processes to exit. Sep 12 17:46:22.208864 systemd-logind[1889]: Removed session 11. Sep 12 17:46:32.312914 systemd[1]: Started sshd@9-10.200.8.11:22-10.200.16.10:49424.service - OpenSSH per-connection server daemon (10.200.16.10:49424). Sep 12 17:46:32.951817 sshd[4162]: Accepted publickey for core from 10.200.16.10 port 49424 ssh2: RSA SHA256:N57c16sACXEH7T/hPh2WdUB1bqX8lYhBLQ19XJC/uD8 Sep 12 17:46:32.953194 sshd-session[4162]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Sep 12 17:46:32.958692 systemd-logind[1889]: New session 12 of user core. Sep 12 17:46:32.967724 systemd[1]: Started session-12.scope - Session 12 of User core. Sep 12 17:46:33.394940 sshd[4461]: Connection closed by 10.200.16.10 port 49424 Sep 12 17:46:33.396449 sshd-session[4162]: pam_unix(sshd:session): session closed for user core Sep 12 17:46:33.400326 systemd[1]: sshd@9-10.200.8.11:22-10.200.16.10:49424.service: Deactivated successfully. Sep 12 17:46:33.402172 systemd[1]: session-12.scope: Deactivated successfully. Sep 12 17:46:33.402980 systemd-logind[1889]: Session 12 logged out. Waiting for processes to exit. Sep 12 17:46:33.404233 systemd-logind[1889]: Removed session 12. Sep 12 17:46:33.505794 systemd[1]: Started sshd@10-10.200.8.11:22-10.200.16.10:49434.service - OpenSSH per-connection server daemon (10.200.16.10:49434). Sep 12 17:46:34.132849 sshd[4792]: Accepted publickey for core from 10.200.16.10 port 49434 ssh2: RSA SHA256:N57c16sACXEH7T/hPh2WdUB1bqX8lYhBLQ19XJC/uD8 Sep 12 17:46:34.134098 sshd-session[4792]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Sep 12 17:46:34.138453 systemd-logind[1889]: New session 13 of user core. Sep 12 17:46:34.149711 systemd[1]: Started session-13.scope - Session 13 of User core. Sep 12 17:46:34.575457 sshd[4972]: Connection closed by 10.200.16.10 port 49434 Sep 12 17:46:34.575759 sshd-session[4792]: pam_unix(sshd:session): session closed for user core Sep 12 17:46:34.579239 systemd[1]: sshd@10-10.200.8.11:22-10.200.16.10:49434.service: Deactivated successfully. Sep 12 17:46:34.581005 systemd[1]: session-13.scope: Deactivated successfully. Sep 12 17:46:34.582185 systemd-logind[1889]: Session 13 logged out. Waiting for processes to exit. Sep 12 17:46:34.583323 systemd-logind[1889]: Removed session 13. Sep 12 17:46:44.691624 systemd[1]: Started sshd@11-10.200.8.11:22-10.200.16.10:56282.service - OpenSSH per-connection server daemon (10.200.16.10:56282). Sep 12 17:46:45.320176 sshd[7150]: Accepted publickey for core from 10.200.16.10 port 56282 ssh2: RSA SHA256:N57c16sACXEH7T/hPh2WdUB1bqX8lYhBLQ19XJC/uD8 Sep 12 17:46:45.321604 sshd-session[7150]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Sep 12 17:46:45.326280 systemd-logind[1889]: New session 14 of user core. Sep 12 17:46:45.334721 systemd[1]: Started session-14.scope - Session 14 of User core. Sep 12 17:46:45.763741 sshd[7236]: Connection closed by 10.200.16.10 port 56282 Sep 12 17:46:45.764129 sshd-session[7150]: pam_unix(sshd:session): session closed for user core Sep 12 17:46:45.768151 systemd[1]: sshd@11-10.200.8.11:22-10.200.16.10:56282.service: Deactivated successfully. Sep 12 17:46:45.770931 systemd[1]: session-14.scope: Deactivated successfully. Sep 12 17:46:45.772423 systemd-logind[1889]: Session 14 logged out. Waiting for processes to exit. Sep 12 17:46:45.773496 systemd-logind[1889]: Removed session 14. Sep 12 17:46:45.877939 systemd[1]: Started sshd@12-10.200.8.11:22-10.200.16.10:56298.service - OpenSSH per-connection server daemon (10.200.16.10:56298). Sep 12 17:46:46.504345 sshd[7317]: Accepted publickey for core from 10.200.16.10 port 56298 ssh2: RSA SHA256:N57c16sACXEH7T/hPh2WdUB1bqX8lYhBLQ19XJC/uD8 Sep 12 17:46:46.505888 sshd-session[7317]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Sep 12 17:46:46.510793 systemd-logind[1889]: New session 15 of user core. Sep 12 17:46:46.520721 systemd[1]: Started session-15.scope - Session 15 of User core. Sep 12 17:46:46.946522 sshd[7412]: Connection closed by 10.200.16.10 port 56298 Sep 12 17:46:46.947759 sshd-session[7317]: pam_unix(sshd:session): session closed for user core Sep 12 17:46:46.953089 systemd[1]: sshd@12-10.200.8.11:22-10.200.16.10:56298.service: Deactivated successfully. Sep 12 17:46:46.954807 systemd[1]: session-15.scope: Deactivated successfully. Sep 12 17:46:46.958692 systemd-logind[1889]: Session 15 logged out. Waiting for processes to exit. Sep 12 17:46:46.959589 systemd-logind[1889]: Removed session 15. Sep 12 17:46:57.066627 systemd[1]: Started sshd@13-10.200.8.11:22-10.200.16.10:53870.service - OpenSSH per-connection server daemon (10.200.16.10:53870). Sep 12 17:46:57.727038 sshd[10722]: Accepted publickey for core from 10.200.16.10 port 53870 ssh2: RSA SHA256:N57c16sACXEH7T/hPh2WdUB1bqX8lYhBLQ19XJC/uD8 Sep 12 17:46:57.728766 sshd-session[10722]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Sep 12 17:46:57.733656 systemd-logind[1889]: New session 16 of user core. Sep 12 17:46:57.743761 systemd[1]: Started session-16.scope - Session 16 of User core. Sep 12 17:46:58.185185 sshd[10982]: Connection closed by 10.200.16.10 port 53870 Sep 12 17:46:58.185961 sshd-session[10722]: pam_unix(sshd:session): session closed for user core Sep 12 17:46:58.193393 systemd[1]: sshd@13-10.200.8.11:22-10.200.16.10:53870.service: Deactivated successfully. Sep 12 17:46:58.196501 systemd[1]: session-16.scope: Deactivated successfully. Sep 12 17:46:58.196542 systemd-logind[1889]: Session 16 logged out. Waiting for processes to exit. Sep 12 17:46:58.199883 systemd-logind[1889]: Removed session 16. Sep 12 17:46:58.300800 systemd[1]: Started sshd@14-10.200.8.11:22-10.200.16.10:53884.service - OpenSSH per-connection server daemon (10.200.16.10:53884). Sep 12 17:46:58.931510 sshd[11142]: Accepted publickey for core from 10.200.16.10 port 53884 ssh2: RSA SHA256:N57c16sACXEH7T/hPh2WdUB1bqX8lYhBLQ19XJC/uD8 Sep 12 17:46:58.933202 sshd-session[11142]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Sep 12 17:46:58.940460 systemd-logind[1889]: New session 17 of user core. Sep 12 17:46:58.949671 systemd[1]: Started session-17.scope - Session 17 of User core. Sep 12 17:46:59.386659 sshd[11483]: Connection closed by 10.200.16.10 port 53884 Sep 12 17:46:59.387039 sshd-session[11142]: pam_unix(sshd:session): session closed for user core Sep 12 17:46:59.390571 systemd[1]: sshd@14-10.200.8.11:22-10.200.16.10:53884.service: Deactivated successfully. Sep 12 17:46:59.392164 systemd[1]: session-17.scope: Deactivated successfully. Sep 12 17:46:59.392836 systemd-logind[1889]: Session 17 logged out. Waiting for processes to exit. Sep 12 17:46:59.393762 systemd-logind[1889]: Removed session 17. Sep 12 17:47:09.502014 systemd[1]: Started sshd@15-10.200.8.11:22-10.200.16.10:60612.service - OpenSSH per-connection server daemon (10.200.16.10:60612). Sep 12 17:47:10.150376 sshd[12018]: Accepted publickey for core from 10.200.16.10 port 60612 ssh2: RSA SHA256:N57c16sACXEH7T/hPh2WdUB1bqX8lYhBLQ19XJC/uD8 Sep 12 17:47:10.152135 sshd-session[12018]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Sep 12 17:47:10.162368 systemd-logind[1889]: New session 18 of user core. Sep 12 17:47:10.172864 systemd[1]: Started session-18.scope - Session 18 of User core. Sep 12 17:47:10.595093 sshd[12045]: Connection closed by 10.200.16.10 port 60612 Sep 12 17:47:10.595897 sshd-session[12018]: pam_unix(sshd:session): session closed for user core Sep 12 17:47:10.601537 systemd-logind[1889]: Session 18 logged out. Waiting for processes to exit. Sep 12 17:47:10.603171 systemd[1]: sshd@15-10.200.8.11:22-10.200.16.10:60612.service: Deactivated successfully. Sep 12 17:47:10.605054 systemd[1]: session-18.scope: Deactivated successfully. Sep 12 17:47:10.607676 systemd-logind[1889]: Removed session 18. Sep 12 17:47:10.710850 systemd[1]: Started sshd@16-10.200.8.11:22-10.200.16.10:36628.service - OpenSSH per-connection server daemon (10.200.16.10:36628). Sep 12 17:47:11.355288 sshd[12069]: Accepted publickey for core from 10.200.16.10 port 36628 ssh2: RSA SHA256:N57c16sACXEH7T/hPh2WdUB1bqX8lYhBLQ19XJC/uD8 Sep 12 17:47:11.357058 sshd-session[12069]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Sep 12 17:47:11.363905 systemd-logind[1889]: New session 19 of user core. Sep 12 17:47:11.370235 systemd[1]: Started session-19.scope - Session 19 of User core. Sep 12 17:47:11.798936 sshd[12084]: Connection closed by 10.200.16.10 port 36628 Sep 12 17:47:11.800909 sshd-session[12069]: pam_unix(sshd:session): session closed for user core Sep 12 17:47:11.804513 systemd-logind[1889]: Session 19 logged out. Waiting for processes to exit. Sep 12 17:47:11.807558 systemd[1]: sshd@16-10.200.8.11:22-10.200.16.10:36628.service: Deactivated successfully. Sep 12 17:47:11.809118 systemd[1]: session-19.scope: Deactivated successfully. Sep 12 17:47:11.811915 systemd-logind[1889]: Removed session 19. Sep 12 17:47:21.907991 systemd[1]: Started sshd@17-10.200.8.11:22-10.200.16.10:47984.service - OpenSSH per-connection server daemon (10.200.16.10:47984). Sep 12 17:47:22.556524 sshd[12423]: Accepted publickey for core from 10.200.16.10 port 47984 ssh2: RSA SHA256:N57c16sACXEH7T/hPh2WdUB1bqX8lYhBLQ19XJC/uD8 Sep 12 17:47:22.557442 sshd-session[12423]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Sep 12 17:47:22.566025 systemd-logind[1889]: New session 20 of user core. Sep 12 17:47:22.571002 systemd[1]: Started session-20.scope - Session 20 of User core. Sep 12 17:47:22.999418 sshd[12453]: Connection closed by 10.200.16.10 port 47984 Sep 12 17:47:22.999818 sshd-session[12423]: pam_unix(sshd:session): session closed for user core Sep 12 17:47:23.005669 systemd[1]: sshd@17-10.200.8.11:22-10.200.16.10:47984.service: Deactivated successfully. Sep 12 17:47:23.008034 systemd-logind[1889]: Session 20 logged out. Waiting for processes to exit. Sep 12 17:47:23.008852 systemd[1]: session-20.scope: Deactivated successfully. Sep 12 17:47:23.013162 systemd-logind[1889]: Removed session 20. Sep 12 17:47:23.112833 systemd[1]: Started sshd@18-10.200.8.11:22-10.200.16.10:47988.service - OpenSSH per-connection server daemon (10.200.16.10:47988). Sep 12 17:47:23.755368 sshd[12477]: Accepted publickey for core from 10.200.16.10 port 47988 ssh2: RSA SHA256:N57c16sACXEH7T/hPh2WdUB1bqX8lYhBLQ19XJC/uD8 Sep 12 17:47:23.756705 sshd-session[12477]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Sep 12 17:47:23.764632 systemd-logind[1889]: New session 21 of user core. Sep 12 17:47:23.768203 systemd[1]: Started session-21.scope - Session 21 of User core. Sep 12 17:47:24.202963 sshd[12499]: Connection closed by 10.200.16.10 port 47988 Sep 12 17:47:24.203364 sshd-session[12477]: pam_unix(sshd:session): session closed for user core Sep 12 17:47:24.207131 systemd-logind[1889]: Session 21 logged out. Waiting for processes to exit. Sep 12 17:47:24.210007 systemd[1]: sshd@18-10.200.8.11:22-10.200.16.10:47988.service: Deactivated successfully. Sep 12 17:47:24.211952 systemd[1]: session-21.scope: Deactivated successfully. Sep 12 17:47:24.217127 systemd-logind[1889]: Removed session 21. Sep 12 17:47:34.321852 systemd[1]: Started sshd@19-10.200.8.11:22-10.200.16.10:36842.service - OpenSSH per-connection server daemon (10.200.16.10:36842). Sep 12 17:47:34.952588 sshd[12783]: Accepted publickey for core from 10.200.16.10 port 36842 ssh2: RSA SHA256:N57c16sACXEH7T/hPh2WdUB1bqX8lYhBLQ19XJC/uD8 Sep 12 17:47:34.953827 sshd-session[12783]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Sep 12 17:47:34.958019 systemd-logind[1889]: New session 22 of user core. Sep 12 17:47:34.971728 systemd[1]: Started session-22.scope - Session 22 of User core. Sep 12 17:47:35.395681 sshd[12786]: Connection closed by 10.200.16.10 port 36842 Sep 12 17:47:35.396073 sshd-session[12783]: pam_unix(sshd:session): session closed for user core Sep 12 17:47:35.399736 systemd[1]: sshd@19-10.200.8.11:22-10.200.16.10:36842.service: Deactivated successfully. Sep 12 17:47:35.401341 systemd[1]: session-22.scope: Deactivated successfully. Sep 12 17:47:35.402037 systemd-logind[1889]: Session 22 logged out. Waiting for processes to exit. Sep 12 17:47:35.403059 systemd-logind[1889]: Removed session 22. Sep 12 17:47:35.513898 systemd[1]: Started sshd@20-10.200.8.11:22-10.200.16.10:36858.service - OpenSSH per-connection server daemon (10.200.16.10:36858). Sep 12 17:47:36.140552 sshd[12792]: Accepted publickey for core from 10.200.16.10 port 36858 ssh2: RSA SHA256:N57c16sACXEH7T/hPh2WdUB1bqX8lYhBLQ19XJC/uD8 Sep 12 17:47:36.141803 sshd-session[12792]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Sep 12 17:47:36.146056 systemd-logind[1889]: New session 23 of user core. Sep 12 17:47:36.157723 systemd[1]: Started session-23.scope - Session 23 of User core. Sep 12 17:47:36.583204 sshd[12795]: Connection closed by 10.200.16.10 port 36858 Sep 12 17:47:36.583489 sshd-session[12792]: pam_unix(sshd:session): session closed for user core Sep 12 17:47:36.586990 systemd[1]: sshd@20-10.200.8.11:22-10.200.16.10:36858.service: Deactivated successfully. Sep 12 17:47:36.588541 systemd[1]: session-23.scope: Deactivated successfully. Sep 12 17:47:36.589227 systemd-logind[1889]: Session 23 logged out. Waiting for processes to exit. Sep 12 17:47:36.590115 systemd-logind[1889]: Removed session 23. Sep 12 17:47:40.741123 setup-nvidia[2530]: \u000d Sep 12 17:47:40.741123 setup-nvidia[2530]: ERROR: Unable to load the kernel module 'nvidia.ko'. This happens most Sep 12 17:47:40.741123 setup-nvidia[2530]: frequently when this kernel module was built against the wrong or Sep 12 17:47:40.741123 setup-nvidia[2530]: improperly configured kernel sources, with a version of gcc that differs Sep 12 17:47:40.741123 setup-nvidia[2530]: from the one used to build the target kernel, or if another driver, such Sep 12 17:47:40.741123 setup-nvidia[2530]: as nouveau, is present and prevents the NVIDIA kernel module from Sep 12 17:47:40.741123 setup-nvidia[2530]: obtaining ownership of the NVIDIA device(s), or no NVIDIA device Sep 12 17:47:40.741123 setup-nvidia[2530]: installed in this system is supported by this NVIDIA Linux graphics Sep 12 17:47:40.741123 setup-nvidia[2530]: driver release. Sep 12 17:47:40.741123 setup-nvidia[2530]: \u000d Sep 12 17:47:40.741123 setup-nvidia[2530]: Please see the log entries 'Kernel module load error' and 'Kernel Sep 12 17:47:40.741123 setup-nvidia[2530]: messages' at the end of the file Sep 12 17:47:40.741123 setup-nvidia[2530]: '/nvidia/NVIDIA-Linux-x86_64-535.247.01/nvidia-installer.log' for more Sep 12 17:47:40.741123 setup-nvidia[2530]: information. Sep 12 17:47:40.741123 setup-nvidia[2530]: \u000d Sep 12 17:47:40.758987 setup-nvidia[2530]: dmesg: read kernel buffer failed: Operation not permitted Sep 12 17:47:40.777922 setup-nvidia[2530]: \u000d Sep 12 17:47:40.777922 setup-nvidia[2530]: ERROR: Installation has failed. Please see the file Sep 12 17:47:40.777922 setup-nvidia[2530]: '/nvidia/NVIDIA-Linux-x86_64-535.247.01/nvidia-installer.log' for Sep 12 17:47:40.777922 setup-nvidia[2530]: details. You may find suggestions on fixing installation problems in Sep 12 17:47:40.777922 setup-nvidia[2530]: the README available on the Linux driver download page at Sep 12 17:47:40.777922 setup-nvidia[2530]: www.nvidia.com. Sep 12 17:47:40.777922 setup-nvidia[2530]: \u000d Sep 12 17:47:40.778606 setup-nvidia[2530]: Last 50 lines of nvidia-installer.log: Sep 12 17:47:40.779394 setup-nvidia[2530]: /nvidia/NVIDIA-Linux-x86_64-535.247.01/kernel/nvidia.o: warning: objtool: _nv039045rm+0x53: 'naked' return found in MITIGATION_RETHUNK build Sep 12 17:47:40.779394 setup-nvidia[2530]: /nvidia/NVIDIA-Linux-x86_64-535.247.01/kernel/nvidia.o: warning: objtool: _nv039042rm+0x90: 'naked' return found in MITIGATION_RETHUNK build Sep 12 17:47:40.779394 setup-nvidia[2530]: /nvidia/NVIDIA-Linux-x86_64-535.247.01/kernel/nvidia.o: warning: objtool: _nv039035rm+0x2b: 'naked' return found in MITIGATION_RETHUNK build Sep 12 17:47:40.779394 setup-nvidia[2530]: /nvidia/NVIDIA-Linux-x86_64-535.247.01/kernel/nvidia.o: warning: objtool: _nv039091rm+0x93: 'naked' return found in MITIGATION_RETHUNK build Sep 12 17:47:40.779394 setup-nvidia[2530]: /nvidia/NVIDIA-Linux-x86_64-535.247.01/kernel/nvidia.o: warning: objtool: _nv039087rm+0x36: 'naked' return found in MITIGATION_RETHUNK build Sep 12 17:47:40.779394 setup-nvidia[2530]: /nvidia/NVIDIA-Linux-x86_64-535.247.01/kernel/nvidia.o: warning: objtool: _nv039086rm+0x9d: 'naked' return found in MITIGATION_RETHUNK build Sep 12 17:47:40.779394 setup-nvidia[2530]: /nvidia/NVIDIA-Linux-x86_64-535.247.01/kernel/nvidia.o: warning: objtool: _nv039088rm+0x77: 'naked' return found in MITIGATION_RETHUNK build Sep 12 17:47:40.779394 setup-nvidia[2530]: /nvidia/NVIDIA-Linux-x86_64-535.247.01/kernel/nvidia.o: warning: objtool: _nv039032rm+0x7f: 'naked' return found in MITIGATION_RETHUNK build Sep 12 17:47:40.779394 setup-nvidia[2530]: /nvidia/NVIDIA-Linux-x86_64-535.247.01/kernel/nvidia.o: warning: objtool: _nv030603rm+0x3e: 'naked' return found in MITIGATION_RETHUNK build Sep 12 17:47:40.779394 setup-nvidia[2530]: /nvidia/NVIDIA-Linux-x86_64-535.247.01/kernel/nvidia.o: warning: objtool: _nv030602rm+0x27: 'naked' return found in MITIGATION_RETHUNK build Sep 12 17:47:40.779394 setup-nvidia[2530]: /nvidia/NVIDIA-Linux-x86_64-535.247.01/kernel/nvidia.o: warning: objtool: _nv030606rm+0x37: 'naked' return found in MITIGATION_RETHUNK build Sep 12 17:47:40.779394 setup-nvidia[2530]: /nvidia/NVIDIA-Linux-x86_64-535.247.01/kernel/nvidia.o: warning: objtool: _nv030605rm+0x24: 'naked' return found in MITIGATION_RETHUNK build Sep 12 17:47:40.779394 setup-nvidia[2530]: /nvidia/NVIDIA-Linux-x86_64-535.247.01/kernel/nvidia.o: warning: objtool: _nv030604rm+0xca: 'naked' return found in MITIGATION_RETHUNK build Sep 12 17:47:40.779394 setup-nvidia[2530]: /nvidia/NVIDIA-Linux-x86_64-535.247.01/kernel/nvidia.o: warning: objtool: _nv030607rm+0x193: 'naked' return found in MITIGATION_RETHUNK build Sep 12 17:47:40.779394 setup-nvidia[2530]: /nvidia/NVIDIA-Linux-x86_64-535.247.01/kernel/nvidia.o: warning: objtool: _nv030609rm+0x17f: 'naked' return found in MITIGATION_RETHUNK build Sep 12 17:47:40.779394 setup-nvidia[2530]: /nvidia/NVIDIA-Linux-x86_64-535.247.01/kernel/nvidia.o: warning: objtool: _nv011864rm+0x5d: 'naked' return found in MITIGATION_RETHUNK build Sep 12 17:47:40.779394 setup-nvidia[2530]: /nvidia/NVIDIA-Linux-x86_64-535.247.01/kernel/nvidia.o: warning: objtool: _nv039399rm+0x12f: 'naked' return found in MITIGATION_RETHUNK build Sep 12 17:47:40.779394 setup-nvidia[2530]: MODPOST /nvidia/NVIDIA-Linux-x86_64-535.247.01/kernel/Module.symvers Sep 12 17:47:40.779394 setup-nvidia[2530]: CC [M] /nvidia/NVIDIA-Linux-x86_64-535.247.01/kernel/nvidia.mod.o Sep 12 17:47:40.779394 setup-nvidia[2530]: CC [M] /nvidia/NVIDIA-Linux-x86_64-535.247.01/kernel/.module-common.o Sep 12 17:47:40.779394 setup-nvidia[2530]: CC [M] /nvidia/NVIDIA-Linux-x86_64-535.247.01/kernel/nvidia-uvm.mod.o Sep 12 17:47:40.779394 setup-nvidia[2530]: CC [M] /nvidia/NVIDIA-Linux-x86_64-535.247.01/kernel/nvidia-modeset.mod.o Sep 12 17:47:40.779394 setup-nvidia[2530]: CC [M] /nvidia/NVIDIA-Linux-x86_64-535.247.01/kernel/nvidia-drm.mod.o Sep 12 17:47:40.779394 setup-nvidia[2530]: CC [M] /nvidia/NVIDIA-Linux-x86_64-535.247.01/kernel/nvidia-peermem.mod.o Sep 12 17:47:40.779394 setup-nvidia[2530]: LD [M] /nvidia/NVIDIA-Linux-x86_64-535.247.01/kernel/nvidia-modeset.ko Sep 12 17:47:40.780027 setup-nvidia[2530]: LD [M] /nvidia/NVIDIA-Linux-x86_64-535.247.01/kernel/nvidia.ko Sep 12 17:47:40.780027 setup-nvidia[2530]: LD [M] /nvidia/NVIDIA-Linux-x86_64-535.247.01/kernel/nvidia-peermem.ko Sep 12 17:47:40.780027 setup-nvidia[2530]: BTF [M] /nvidia/NVIDIA-Linux-x86_64-535.247.01/kernel/nvidia-peermem.ko Sep 12 17:47:40.780027 setup-nvidia[2530]: Skipping BTF generation for /nvidia/NVIDIA-Linux-x86_64-535.247.01/kernel/nvidia-peermem.ko due to unavailability of vmlinux Sep 12 17:47:40.780027 setup-nvidia[2530]: LD [M] /nvidia/NVIDIA-Linux-x86_64-535.247.01/kernel/nvidia-uvm.ko Sep 12 17:47:40.780027 setup-nvidia[2530]: LD [M] /nvidia/NVIDIA-Linux-x86_64-535.247.01/kernel/nvidia-drm.ko Sep 12 17:47:40.780027 setup-nvidia[2530]: BTF [M] /nvidia/NVIDIA-Linux-x86_64-535.247.01/kernel/nvidia-modeset.ko Sep 12 17:47:40.780027 setup-nvidia[2530]: Skipping BTF generation for /nvidia/NVIDIA-Linux-x86_64-535.247.01/kernel/nvidia-modeset.ko due to unavailability of vmlinux Sep 12 17:47:40.780027 setup-nvidia[2530]: BTF [M] /nvidia/NVIDIA-Linux-x86_64-535.247.01/kernel/nvidia-drm.ko Sep 12 17:47:40.780027 setup-nvidia[2530]: Skipping BTF generation for /nvidia/NVIDIA-Linux-x86_64-535.247.01/kernel/nvidia-drm.ko due to unavailability of vmlinux Sep 12 17:47:40.780027 setup-nvidia[2530]: BTF [M] /nvidia/NVIDIA-Linux-x86_64-535.247.01/kernel/nvidia-uvm.ko Sep 12 17:47:40.780027 setup-nvidia[2530]: Skipping BTF generation for /nvidia/NVIDIA-Linux-x86_64-535.247.01/kernel/nvidia-uvm.ko due to unavailability of vmlinux Sep 12 17:47:40.780027 setup-nvidia[2530]: BTF [M] /nvidia/NVIDIA-Linux-x86_64-535.247.01/kernel/nvidia.ko Sep 12 17:47:40.780027 setup-nvidia[2530]: Skipping BTF generation for /nvidia/NVIDIA-Linux-x86_64-535.247.01/kernel/nvidia.ko due to unavailability of vmlinux Sep 12 17:47:40.780027 setup-nvidia[2530]: make[2]: Leaving directory '/usr/lib/modules/6.12.47-flatcar/build' Sep 12 17:47:40.780027 setup-nvidia[2530]: make[1]: Leaving directory '/usr/lib/modules/6.12.47-flatcar/source' Sep 12 17:47:40.780027 setup-nvidia[2530]: -> done. Sep 12 17:47:40.780027 setup-nvidia[2530]: -> Kernel module compilation complete. Sep 12 17:47:40.780027 setup-nvidia[2530]: -> Unable to determine if Secure Boot is enabled: No such file or directory Sep 12 17:47:40.780027 setup-nvidia[2530]: 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. Sep 12 17:47:40.780027 setup-nvidia[2530]: \u000d Sep 12 17:47:40.780027 setup-nvidia[2530]: Please see the log entries 'Kernel module load error' and 'Kernel messages' at the end of the file '/nvidia/NVIDIA-Linux-x86_64-535.247.01/nvidia-installer.log' for more information. Sep 12 17:47:40.780027 setup-nvidia[2530]: -> Kernel module load error: Operation not permitted Sep 12 17:47:40.780027 setup-nvidia[2530]: -> Kernel messages: Sep 12 17:47:40.780027 setup-nvidia[2530]: ERROR: Installation has failed. Please see the file '/nvidia/NVIDIA-Linux-x86_64-535.247.01/nvidia-installer.log' for details. You may find suggestions on fixing installation problems in the README available on the Linux driver download page at www.nvidia.com. Sep 12 17:47:46.701804 systemd[1]: Started sshd@21-10.200.8.11:22-10.200.16.10:49606.service - OpenSSH per-connection server daemon (10.200.16.10:49606). Sep 12 17:47:47.343469 sshd[12981]: Accepted publickey for core from 10.200.16.10 port 49606 ssh2: RSA SHA256:N57c16sACXEH7T/hPh2WdUB1bqX8lYhBLQ19XJC/uD8 Sep 12 17:47:47.344769 sshd-session[12981]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Sep 12 17:47:47.348913 systemd-logind[1889]: New session 24 of user core. Sep 12 17:47:47.365028 systemd[1]: Started session-24.scope - Session 24 of User core. Sep 12 17:47:47.786804 sshd[12984]: Connection closed by 10.200.16.10 port 49606 Sep 12 17:47:47.787160 sshd-session[12981]: pam_unix(sshd:session): session closed for user core Sep 12 17:47:47.790682 systemd[1]: sshd@21-10.200.8.11:22-10.200.16.10:49606.service: Deactivated successfully. Sep 12 17:47:47.792346 systemd[1]: session-24.scope: Deactivated successfully. Sep 12 17:47:47.793105 systemd-logind[1889]: Session 24 logged out. Waiting for processes to exit. Sep 12 17:47:47.794023 systemd-logind[1889]: Removed session 24. Sep 12 17:47:47.898236 systemd[1]: Started sshd@22-10.200.8.11:22-10.200.16.10:49614.service - OpenSSH per-connection server daemon (10.200.16.10:49614). Sep 12 17:47:48.526724 sshd[12990]: Accepted publickey for core from 10.200.16.10 port 49614 ssh2: RSA SHA256:N57c16sACXEH7T/hPh2WdUB1bqX8lYhBLQ19XJC/uD8 Sep 12 17:47:48.527966 sshd-session[12990]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Sep 12 17:47:48.532424 systemd-logind[1889]: New session 25 of user core. Sep 12 17:47:48.541699 systemd[1]: Started session-25.scope - Session 25 of User core. Sep 12 17:47:48.973387 sshd[12993]: Connection closed by 10.200.16.10 port 49614 Sep 12 17:47:48.973743 sshd-session[12990]: pam_unix(sshd:session): session closed for user core Sep 12 17:47:48.977296 systemd[1]: sshd@22-10.200.8.11:22-10.200.16.10:49614.service: Deactivated successfully. Sep 12 17:47:48.978876 systemd[1]: session-25.scope: Deactivated successfully. Sep 12 17:47:48.979570 systemd-logind[1889]: Session 25 logged out. Waiting for processes to exit. Sep 12 17:47:48.980491 systemd-logind[1889]: Removed session 25. Sep 12 17:47:59.091921 systemd[1]: Started sshd@23-10.200.8.11:22-10.200.16.10:54396.service - OpenSSH per-connection server daemon (10.200.16.10:54396). Sep 12 17:47:59.737974 sshd[12999]: Accepted publickey for core from 10.200.16.10 port 54396 ssh2: RSA SHA256:N57c16sACXEH7T/hPh2WdUB1bqX8lYhBLQ19XJC/uD8 Sep 12 17:47:59.739191 sshd-session[12999]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Sep 12 17:47:59.743271 systemd-logind[1889]: New session 26 of user core. Sep 12 17:47:59.752698 systemd[1]: Started session-26.scope - Session 26 of User core. Sep 12 17:48:00.184214 sshd[13002]: Connection closed by 10.200.16.10 port 54396 Sep 12 17:48:00.184556 sshd-session[12999]: pam_unix(sshd:session): session closed for user core Sep 12 17:48:00.187859 systemd[1]: sshd@23-10.200.8.11:22-10.200.16.10:54396.service: Deactivated successfully. Sep 12 17:48:00.189464 systemd[1]: session-26.scope: Deactivated successfully. Sep 12 17:48:00.190170 systemd-logind[1889]: Session 26 logged out. Waiting for processes to exit. Sep 12 17:48:00.191097 systemd-logind[1889]: Removed session 26. Sep 12 17:48:00.311800 systemd[1]: Started sshd@24-10.200.8.11:22-10.200.16.10:38934.service - OpenSSH per-connection server daemon (10.200.16.10:38934). Sep 12 17:48:00.937683 sshd[13008]: Accepted publickey for core from 10.200.16.10 port 38934 ssh2: RSA SHA256:N57c16sACXEH7T/hPh2WdUB1bqX8lYhBLQ19XJC/uD8 Sep 12 17:48:00.938883 sshd-session[13008]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Sep 12 17:48:00.943120 systemd-logind[1889]: New session 27 of user core. Sep 12 17:48:00.957697 systemd[1]: Started session-27.scope - Session 27 of User core. Sep 12 17:48:01.379386 sshd[13011]: Connection closed by 10.200.16.10 port 38934 Sep 12 17:48:01.379739 sshd-session[13008]: pam_unix(sshd:session): session closed for user core Sep 12 17:48:01.383004 systemd[1]: sshd@24-10.200.8.11:22-10.200.16.10:38934.service: Deactivated successfully. Sep 12 17:48:01.384543 systemd[1]: session-27.scope: Deactivated successfully. Sep 12 17:48:01.385263 systemd-logind[1889]: Session 27 logged out. Waiting for processes to exit. Sep 12 17:48:01.386144 systemd-logind[1889]: Removed session 27. Sep 12 17:48:08.348607 kernel: EXT4-fs (loop6p9): unmounting filesystem 551f0cf8-e67b-4b0c-a816-719b45050a1c. Sep 12 17:48:08.348753 setup-nvidia[2530]: Container flatcardevelopercontainer-4426.1.0.bin exited successfully. Sep 12 17:48:08.351097 systemd[1]: run-systemd-nspawn-unix\x2dexport-flatcardevelopercontainer\x2d4426.1.0.bin.mount: Deactivated successfully. Sep 12 17:48:08.397367 sudo[2518]: pam_unix(sudo:session): session closed for user root Sep 12 17:48:08.399203 systemd[1]: session-c2.scope: Deactivated successfully. Sep 12 17:48:08.399468 systemd[1]: session-c2.scope: Consumed 5min 10.213s CPU time, 888.4M memory peak. Sep 12 17:48:08.810426 setup-nvidia[1881]: /opt/nvidia / Sep 12 17:48:08.811382 setup-nvidia[1881]: / Sep 12 17:48:08.820597 kernel: IPMI message handler: version 39.2 Sep 12 17:48:08.823599 kernel: ipmi device interface Sep 12 17:48:08.836827 setup-nvidia[1881]: /opt/nvidia/current/usr/lib/modules/6.12.47-flatcar/video / Sep 12 17:48:08.887934 kernel: nvidia: loading out-of-tree module taints kernel. Sep 12 17:48:08.888064 kernel: nvidia: module license 'NVIDIA' taints kernel. Sep 12 17:48:08.888086 kernel: Disabling lock debugging due to kernel taint Sep 12 17:48:08.895012 kernel: nvidia: module verification failed: signature and/or required key missing - tainting kernel Sep 12 17:48:08.895052 kernel: nvidia: module license taints kernel. Sep 12 17:48:09.282608 kernel: nvidia-nvlink: Nvlink Core is being initialized, major device number 243 Sep 12 17:48:09.678567 kernel: Sep 12 17:48:09.678709 kernel: nvidia 0001:00:00.0: enabling device (0000 -> 0002) Sep 12 17:48:09.885599 kernel: NVRM: loading NVIDIA UNIX x86_64 Kernel Module 535.247.01 Wed Mar 26 11:50:32 UTC 2025 Sep 12 17:48:09.907601 kernel: nvidia-modeset: Loading NVIDIA Kernel Mode Setting Driver for UNIX platforms 535.247.01 Wed Mar 26 06:12:31 UTC 2025 Sep 12 17:48:09.926605 kernel: nvidia_uvm: module uses symbols nvUvmInterfaceDisableAccessCntr from proprietary module nvidia, inheriting taint. Sep 12 17:48:09.977597 kernel: nvidia-uvm: Loaded the UVM driver, major device number 241. Sep 12 17:48:09.977956 setup-nvidia[1881]: / Sep 12 17:48:09.992402 setup-nvidia[13051]: ldconfig: /usr/lib/ld.so.conf is not an ELF file - it has the wrong magic bytes at the start. Sep 12 17:48:11.502841 systemd[1]: Started sshd@25-10.200.8.11:22-10.200.16.10:58382.service - OpenSSH per-connection server daemon (10.200.16.10:58382). Sep 12 17:48:11.773239 setup-nvidia[13068]: Fri Sep 12 17:48:11 2025 Sep 12 17:48:11.773239 setup-nvidia[13068]: +---------------------------------------------------------------------------------------+ Sep 12 17:48:11.773239 setup-nvidia[13068]: | NVIDIA-SMI 535.247.01 Driver Version: 535.247.01 CUDA Version: 12.2 | Sep 12 17:48:11.773239 setup-nvidia[13068]: |-----------------------------------------+----------------------+----------------------+ Sep 12 17:48:11.773239 setup-nvidia[13068]: | GPU Name Persistence-M | Bus-Id Disp.A | Volatile Uncorr. ECC | Sep 12 17:48:11.773239 setup-nvidia[13068]: | Fan Temp Perf Pwr:Usage/Cap | Memory-Usage | GPU-Util Compute M. | Sep 12 17:48:11.773239 setup-nvidia[13068]: | | | MIG M. | Sep 12 17:48:11.773239 setup-nvidia[13068]: |=========================================+======================+======================| Sep 12 17:48:11.777002 setup-nvidia[13068]: | 0 Tesla V100-PCIE-16GB Off | 00000001:00:00.0 Off | Off | Sep 12 17:48:11.777002 setup-nvidia[13068]: | N/A 26C P0 35W / 250W | 0MiB / 16384MiB | 0% Default | Sep 12 17:48:11.777002 setup-nvidia[13068]: | | | N/A | Sep 12 17:48:11.777002 setup-nvidia[13068]: +-----------------------------------------+----------------------+----------------------+ Sep 12 17:48:11.777002 setup-nvidia[13068]: Sep 12 17:48:11.777002 setup-nvidia[13068]: +---------------------------------------------------------------------------------------+ Sep 12 17:48:11.777002 setup-nvidia[13068]: | Processes: | Sep 12 17:48:11.777002 setup-nvidia[13068]: | GPU GI CI PID Type Process name GPU Memory | Sep 12 17:48:11.777002 setup-nvidia[13068]: | ID ID Usage | Sep 12 17:48:11.777002 setup-nvidia[13068]: |=======================================================================================| Sep 12 17:48:11.777248 setup-nvidia[13068]: | No running processes found | Sep 12 17:48:11.777248 setup-nvidia[13068]: +---------------------------------------------------------------------------------------+ Sep 12 17:48:12.129472 sshd[13073]: Accepted publickey for core from 10.200.16.10 port 58382 ssh2: RSA SHA256:N57c16sACXEH7T/hPh2WdUB1bqX8lYhBLQ19XJC/uD8 Sep 12 17:48:12.130742 sshd-session[13073]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Sep 12 17:48:12.134912 systemd-logind[1889]: New session 28 of user core. Sep 12 17:48:12.144702 systemd[1]: Started session-28.scope - Session 28 of User core. Sep 12 17:48:12.154949 systemd[1]: Finished nvidia.service - NVIDIA Configure Service. Sep 12 17:48:12.156901 systemd[1]: Reached target multi-user.target - Multi-User System. Sep 12 17:48:12.157228 systemd[1]: Startup finished in 1.273s (firmware) + 30.431s (loader) + 3.822s (kernel) + 15.426s (initrd) + 3min 6.026s (userspace) = 3min 56.981s. Sep 12 17:48:12.574984 sshd[13077]: Connection closed by 10.200.16.10 port 58382 Sep 12 17:48:12.575263 sshd-session[13073]: pam_unix(sshd:session): session closed for user core Sep 12 17:48:12.578623 systemd[1]: sshd@25-10.200.8.11:22-10.200.16.10:58382.service: Deactivated successfully. Sep 12 17:48:12.580219 systemd[1]: session-28.scope: Deactivated successfully. Sep 12 17:48:12.580913 systemd-logind[1889]: Session 28 logged out. Waiting for processes to exit. Sep 12 17:48:12.581879 systemd-logind[1889]: Removed session 28. Sep 12 17:48:12.698885 systemd[1]: Started sshd@26-10.200.8.11:22-10.200.16.10:58396.service - OpenSSH per-connection server daemon (10.200.16.10:58396). Sep 12 17:48:13.329638 sshd[13084]: Accepted publickey for core from 10.200.16.10 port 58396 ssh2: RSA SHA256:N57c16sACXEH7T/hPh2WdUB1bqX8lYhBLQ19XJC/uD8 Sep 12 17:48:13.330941 sshd-session[13084]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Sep 12 17:48:13.335169 systemd-logind[1889]: New session 29 of user core. Sep 12 17:48:13.347703 systemd[1]: Started session-29.scope - Session 29 of User core. Sep 12 17:48:13.769097 sshd[13087]: Connection closed by 10.200.16.10 port 58396 Sep 12 17:48:13.769429 sshd-session[13084]: pam_unix(sshd:session): session closed for user core Sep 12 17:48:13.773010 systemd[1]: sshd@26-10.200.8.11:22-10.200.16.10:58396.service: Deactivated successfully. Sep 12 17:48:13.774601 systemd[1]: session-29.scope: Deactivated successfully. Sep 12 17:48:13.775273 systemd-logind[1889]: Session 29 logged out. Waiting for processes to exit. Sep 12 17:48:13.776159 systemd-logind[1889]: Removed session 29. Sep 12 17:48:13.884025 systemd[1]: Started sshd@27-10.200.8.11:22-10.200.16.10:58406.service - OpenSSH per-connection server daemon (10.200.16.10:58406). Sep 12 17:48:14.509996 sshd[13094]: Accepted publickey for core from 10.200.16.10 port 58406 ssh2: RSA SHA256:N57c16sACXEH7T/hPh2WdUB1bqX8lYhBLQ19XJC/uD8 Sep 12 17:48:14.511228 sshd-session[13094]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Sep 12 17:48:14.515643 systemd-logind[1889]: New session 30 of user core. Sep 12 17:48:14.527709 systemd[1]: Started session-30.scope - Session 30 of User core. Sep 12 17:48:14.952915 sshd[13099]: Connection closed by 10.200.16.10 port 58406 Sep 12 17:48:14.953253 sshd-session[13094]: pam_unix(sshd:session): session closed for user core Sep 12 17:48:14.956663 systemd[1]: sshd@27-10.200.8.11:22-10.200.16.10:58406.service: Deactivated successfully. Sep 12 17:48:14.958198 systemd[1]: session-30.scope: Deactivated successfully. Sep 12 17:48:14.958872 systemd-logind[1889]: Session 30 logged out. Waiting for processes to exit. Sep 12 17:48:14.959881 systemd-logind[1889]: Removed session 30. Sep 12 17:48:15.074547 systemd[1]: Started sshd@28-10.200.8.11:22-10.200.16.10:58420.service - OpenSSH per-connection server daemon (10.200.16.10:58420). Sep 12 17:48:15.728232 sshd[13105]: Accepted publickey for core from 10.200.16.10 port 58420 ssh2: RSA SHA256:N57c16sACXEH7T/hPh2WdUB1bqX8lYhBLQ19XJC/uD8 Sep 12 17:48:15.729515 sshd-session[13105]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Sep 12 17:48:15.733973 systemd-logind[1889]: New session 31 of user core. Sep 12 17:48:15.746746 systemd[1]: Started session-31.scope - Session 31 of User core. Sep 12 17:48:16.094362 sudo[13109]: core : PWD=/home/core ; USER=root ; COMMAND=/usr/sbin/setenforce 1 Sep 12 17:48:16.094682 sudo[13109]: pam_unix(sudo:session): session opened for user root(uid=0) by core(uid=500) Sep 12 17:48:16.141237 sudo[13109]: pam_unix(sudo:session): session closed for user root Sep 12 17:48:16.241347 sshd[13108]: Connection closed by 10.200.16.10 port 58420 Sep 12 17:48:16.241757 sshd-session[13105]: pam_unix(sshd:session): session closed for user core Sep 12 17:48:16.245433 systemd[1]: sshd@28-10.200.8.11:22-10.200.16.10:58420.service: Deactivated successfully. Sep 12 17:48:16.247098 systemd[1]: session-31.scope: Deactivated successfully. Sep 12 17:48:16.247795 systemd-logind[1889]: Session 31 logged out. Waiting for processes to exit. Sep 12 17:48:16.248911 systemd-logind[1889]: Removed session 31. Sep 12 17:48:16.355722 systemd[1]: Started sshd@29-10.200.8.11:22-10.200.16.10:58424.service - OpenSSH per-connection server daemon (10.200.16.10:58424). Sep 12 17:48:17.003465 sshd[13115]: Accepted publickey for core from 10.200.16.10 port 58424 ssh2: RSA SHA256:N57c16sACXEH7T/hPh2WdUB1bqX8lYhBLQ19XJC/uD8 Sep 12 17:48:17.004843 sshd-session[13115]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Sep 12 17:48:17.008973 systemd-logind[1889]: New session 32 of user core. Sep 12 17:48:17.023716 systemd[1]: Started session-32.scope - Session 32 of User core. Sep 12 17:48:17.348108 sudo[13120]: core : PWD=/home/core ; USER=root ; COMMAND=/usr/sbin/rm -rf /etc/audit/rules.d/80-selinux.rules /etc/audit/rules.d/99-default.rules Sep 12 17:48:17.348407 sudo[13120]: pam_unix(sudo:session): session opened for user root(uid=0) by core(uid=500) Sep 12 17:48:17.355944 sudo[13120]: pam_unix(sudo:session): session closed for user root Sep 12 17:48:17.361308 sudo[13119]: core : PWD=/home/core ; USER=root ; COMMAND=/usr/sbin/systemctl restart audit-rules Sep 12 17:48:17.361614 sudo[13119]: pam_unix(sudo:session): session opened for user root(uid=0) by core(uid=500) Sep 12 17:48:17.370439 systemd[1]: Starting audit-rules.service - Load Audit Rules... Sep 12 17:48:17.412271 augenrules[13142]: No rules Sep 12 17:48:17.413339 systemd[1]: audit-rules.service: Deactivated successfully. Sep 12 17:48:17.413561 systemd[1]: Finished audit-rules.service - Load Audit Rules. Sep 12 17:48:17.414289 sudo[13119]: pam_unix(sudo:session): session closed for user root Sep 12 17:48:17.513801 sshd[13118]: Connection closed by 10.200.16.10 port 58424 Sep 12 17:48:17.514154 sshd-session[13115]: pam_unix(sshd:session): session closed for user core Sep 12 17:48:17.517893 systemd[1]: sshd@29-10.200.8.11:22-10.200.16.10:58424.service: Deactivated successfully. Sep 12 17:48:17.519537 systemd[1]: session-32.scope: Deactivated successfully. Sep 12 17:48:17.520224 systemd-logind[1889]: Session 32 logged out. Waiting for processes to exit. Sep 12 17:48:17.521124 systemd-logind[1889]: Removed session 32. Sep 12 17:48:17.631968 systemd[1]: Started sshd@30-10.200.8.11:22-10.200.16.10:58430.service - OpenSSH per-connection server daemon (10.200.16.10:58430). Sep 12 17:48:18.280074 sshd[13151]: Accepted publickey for core from 10.200.16.10 port 58430 ssh2: RSA SHA256:N57c16sACXEH7T/hPh2WdUB1bqX8lYhBLQ19XJC/uD8 Sep 12 17:48:18.281344 sshd-session[13151]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Sep 12 17:48:18.285511 systemd-logind[1889]: New session 33 of user core. Sep 12 17:48:18.295699 systemd[1]: Started session-33.scope - Session 33 of User core. Sep 12 17:48:18.626541 sudo[13155]: core : PWD=/home/core ; USER=root ; COMMAND=/usr/sbin/mkdir -p . Sep 12 17:48:18.626860 sudo[13155]: pam_unix(sudo:session): session opened for user root(uid=0) by core(uid=500) Sep 12 17:48:18.628875 systemd[1]: Stopping user@0.service - User Manager for UID 0... Sep 12 17:48:18.629686 systemd[2521]: Activating special unit exit.target... Sep 12 17:48:18.629761 systemd[2521]: Stopped target default.target - Main User Target. Sep 12 17:48:18.629802 systemd[2521]: Stopped target basic.target - Basic System. Sep 12 17:48:18.629831 systemd[2521]: Stopped target paths.target - Paths. Sep 12 17:48:18.629855 systemd[2521]: Stopped target sockets.target - Sockets. Sep 12 17:48:18.629880 systemd[2521]: Stopped target timers.target - Timers. Sep 12 17:48:18.630231 systemd[2521]: Closed dbus.socket - D-Bus User Message Bus Socket. Sep 12 17:48:18.630440 systemd[2521]: Removed slice app.slice - User Application Slice. Sep 12 17:48:18.630471 systemd[2521]: Reached target shutdown.target - Shutdown. Sep 12 17:48:18.630626 systemd[2521]: Finished systemd-exit.service - Exit the Session. Sep 12 17:48:18.630663 systemd[2521]: Reached target exit.target - Exit the Session. Sep 12 17:48:18.631284 sudo[13155]: pam_unix(sudo:session): session closed for user root Sep 12 17:48:18.642060 (sd-pam)[2522]: pam_unix(systemd-user:session): session closed for user root Sep 12 17:48:18.643215 systemd[1]: user@0.service: Deactivated successfully. Sep 12 17:48:18.643632 systemd[1]: Stopped user@0.service - User Manager for UID 0. Sep 12 17:48:18.645992 systemd[1]: Stopping user-runtime-dir@0.service - User Runtime Directory /run/user/0... Sep 12 17:48:18.676375 systemd[1]: run-user-0.mount: Deactivated successfully. Sep 12 17:48:18.677295 systemd[1]: user-runtime-dir@0.service: Deactivated successfully. Sep 12 17:48:18.677486 systemd[1]: Stopped user-runtime-dir@0.service - User Runtime Directory /run/user/0. Sep 12 17:48:18.678984 systemd[1]: Removed slice user-0.slice - User Slice of UID 0. Sep 12 17:48:18.679074 systemd[1]: user-0.slice: Consumed 5min 10.436s CPU time, 894.6M memory peak. Sep 12 17:48:18.679472 systemd-logind[1889]: Removed session c3. Sep 12 17:48:18.730931 sshd[13154]: Connection closed by 10.200.16.10 port 58430 Sep 12 17:48:18.731266 sshd-session[13151]: pam_unix(sshd:session): session closed for user core Sep 12 17:48:18.734471 systemd[1]: sshd@30-10.200.8.11:22-10.200.16.10:58430.service: Deactivated successfully. Sep 12 17:48:18.735997 systemd[1]: session-33.scope: Deactivated successfully. Sep 12 17:48:18.736751 systemd-logind[1889]: Session 33 logged out. Waiting for processes to exit. Sep 12 17:48:18.737659 systemd-logind[1889]: Removed session 33. Sep 12 17:48:18.852997 systemd[1]: Started sshd@31-10.200.8.11:22-10.200.16.10:58432.service - OpenSSH per-connection server daemon (10.200.16.10:58432). Sep 12 17:48:19.501327 sshd[13165]: Accepted publickey for core from 10.200.16.10 port 58432 ssh2: RSA SHA256:N57c16sACXEH7T/hPh2WdUB1bqX8lYhBLQ19XJC/uD8 Sep 12 17:48:19.502591 sshd-session[13165]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Sep 12 17:48:19.506756 systemd-logind[1889]: New session 34 of user core. Sep 12 17:48:19.518696 systemd[1]: Started session-34.scope - Session 34 of User core. Sep 12 17:48:19.846089 sudo[13169]: core : PWD=/home/core ; USER=root ; COMMAND=/usr/sbin/install -m 0755 /dev/stdin kolet Sep 12 17:48:19.846403 sudo[13169]: pam_unix(sudo:session): session opened for user root(uid=0) by core(uid=500) Sep 12 17:48:24.074590 sudo[13169]: pam_unix(sudo:session): session closed for user root Sep 12 17:48:24.175337 sshd[13168]: Connection closed by 10.200.16.10 port 58432 Sep 12 17:48:24.175599 sshd-session[13165]: pam_unix(sshd:session): session closed for user core Sep 12 17:48:24.179022 systemd[1]: sshd@31-10.200.8.11:22-10.200.16.10:58432.service: Deactivated successfully. Sep 12 17:48:24.180631 systemd[1]: session-34.scope: Deactivated successfully. Sep 12 17:48:24.181283 systemd-logind[1889]: Session 34 logged out. Waiting for processes to exit. Sep 12 17:48:24.182158 systemd-logind[1889]: Removed session 34. Sep 12 17:48:24.289609 systemd[1]: Started sshd@32-10.200.8.11:22-10.200.16.10:40428.service - OpenSSH per-connection server daemon (10.200.16.10:40428). Sep 12 17:48:24.936862 sshd[13175]: Accepted publickey for core from 10.200.16.10 port 40428 ssh2: RSA SHA256:N57c16sACXEH7T/hPh2WdUB1bqX8lYhBLQ19XJC/uD8 Sep 12 17:48:24.938073 sshd-session[13175]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Sep 12 17:48:24.942244 systemd-logind[1889]: New session 35 of user core. Sep 12 17:48:24.951695 systemd[1]: Started session-35.scope - Session 35 of User core. Sep 12 17:48:25.371420 ntpdate[13189]: ntpdate 4.2.8p17@1.4004-o Fri Sep 12 14:59:10 UTC 2025 (1) Sep 12 17:48:32.154181 ntpdate[13189]: adjust time server 85.91.1.164 offset -0.014099 sec Sep 12 17:48:32.254185 sshd[13178]: Connection closed by 10.200.16.10 port 40428 Sep 12 17:48:32.254557 sshd-session[13175]: pam_unix(sshd:session): session closed for user core Sep 12 17:48:32.258065 systemd[1]: sshd@32-10.200.8.11:22-10.200.16.10:40428.service: Deactivated successfully. Sep 12 17:48:32.259742 systemd[1]: session-35.scope: Deactivated successfully. Sep 12 17:48:32.260436 systemd-logind[1889]: Session 35 logged out. Waiting for processes to exit. Sep 12 17:48:32.261319 systemd-logind[1889]: Removed session 35. Sep 12 17:48:32.368524 systemd[1]: Started sshd@33-10.200.8.11:22-10.200.16.10:56576.service - OpenSSH per-connection server daemon (10.200.16.10:56576). Sep 12 17:48:33.016140 sshd[13194]: Accepted publickey for core from 10.200.16.10 port 56576 ssh2: RSA SHA256:N57c16sACXEH7T/hPh2WdUB1bqX8lYhBLQ19XJC/uD8 Sep 12 17:48:33.017342 sshd-session[13194]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Sep 12 17:48:33.021450 systemd-logind[1889]: New session 36 of user core. Sep 12 17:48:33.034694 systemd[1]: Started session-36.scope - Session 36 of User core. Sep 12 17:48:33.563748 sshd[13197]: Connection closed by 10.200.16.10 port 56576 Sep 12 17:48:33.564095 sshd-session[13194]: pam_unix(sshd:session): session closed for user core Sep 12 17:48:33.567476 systemd[1]: sshd@33-10.200.8.11:22-10.200.16.10:56576.service: Deactivated successfully. Sep 12 17:48:33.569063 systemd[1]: session-36.scope: Deactivated successfully. Sep 12 17:48:33.569759 systemd-logind[1889]: Session 36 logged out. Waiting for processes to exit. Sep 12 17:48:33.570671 systemd-logind[1889]: Removed session 36. Sep 12 17:48:33.676869 systemd[1]: Started sshd@34-10.200.8.11:22-10.200.16.10:56590.service - OpenSSH per-connection server daemon (10.200.16.10:56590). Sep 12 17:48:34.319865 sshd[13212]: Accepted publickey for core from 10.200.16.10 port 56590 ssh2: RSA SHA256:N57c16sACXEH7T/hPh2WdUB1bqX8lYhBLQ19XJC/uD8 Sep 12 17:48:34.321099 sshd-session[13212]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Sep 12 17:48:34.325281 systemd-logind[1889]: New session 37 of user core. Sep 12 17:48:34.338708 systemd[1]: Started session-37.scope - Session 37 of User core. Sep 12 17:48:35.442280 systemd[1]: Starting docker.service - Docker Application Container Engine... Sep 12 17:48:35.460928 (dockerd)[13236]: docker.service: Referenced but unset environment variable evaluates to an empty string: DOCKER_CGROUPS, DOCKER_OPTS, DOCKER_OPT_BIP, DOCKER_OPT_IPMASQ, DOCKER_OPT_MTU Sep 12 17:48:37.505936 dockerd[13236]: time="2025-09-12T17:48:37.505877881Z" level=info msg="Starting up" Sep 12 17:48:37.506522 dockerd[13236]: time="2025-09-12T17:48:37.506499257Z" level=info msg="OTEL tracing is not configured, using no-op tracer provider" Sep 12 17:48:37.516558 dockerd[13236]: time="2025-09-12T17:48:37.516527970Z" level=info msg="Creating a containerd client" address=/var/run/docker/libcontainerd/docker-containerd.sock timeout=1m0s Sep 12 17:48:38.000347 dockerd[13236]: time="2025-09-12T17:48:38.000306536Z" level=info msg="Loading containers: start." Sep 12 17:48:38.015602 kernel: Initializing XFRM netlink socket Sep 12 17:48:38.389887 systemd-networkd[1717]: docker0: Link UP Sep 12 17:48:38.415033 dockerd[13236]: time="2025-09-12T17:48:38.414988164Z" level=info msg="Loading containers: done." Sep 12 17:48:38.433640 dockerd[13236]: time="2025-09-12T17:48:38.433563849Z" level=warning msg="Not using native diff for overlay2, this may cause degraded performance for building images: kernel has CONFIG_OVERLAY_FS_REDIRECT_DIR enabled" storage-driver=overlay2 Sep 12 17:48:38.433768 dockerd[13236]: time="2025-09-12T17:48:38.433673344Z" level=info msg="Docker daemon" commit=6430e49a55babd9b8f4d08e70ecb2b68900770fe containerd-snapshotter=false storage-driver=overlay2 version=28.0.4 Sep 12 17:48:38.433768 dockerd[13236]: time="2025-09-12T17:48:38.433756041Z" level=info msg="Initializing buildkit" Sep 12 17:48:38.491180 dockerd[13236]: time="2025-09-12T17:48:38.491148731Z" level=info msg="Completed buildkit initialization" Sep 12 17:48:38.495994 dockerd[13236]: time="2025-09-12T17:48:38.495965645Z" level=info msg="Daemon has completed initialization" Sep 12 17:48:38.496097 dockerd[13236]: time="2025-09-12T17:48:38.496022043Z" level=info msg="API listen on /run/docker.sock" Sep 12 17:48:38.496136 systemd[1]: Started docker.service - Docker Application Container Engine. Sep 12 17:48:38.552899 systemd[1]: var-lib-docker-overlay2-opaque\x2dbug\x2dcheck181310174-merged.mount: Deactivated successfully. Sep 12 17:48:39.661436 systemd[1]: var-lib-docker-overlay2-84d420217b761d6300b224297fe8813b9270df6a89685f3b14b0aaa0bc910a78\x2dinit-merged.mount: Deactivated successfully. Sep 12 17:48:39.782814 containerd[1900]: time="2025-09-12T17:48:39.782766181Z" level=info msg="connecting to shim 43169a5303eff9b31eb1760d656fe731ad7a56841e6fa9935f21a8f577128e42" address="unix:///run/containerd/s/10ac744f8291371b61858bd728f2252e6202136d87397e3a6b0af3579c3b69b0" namespace=moby protocol=ttrpc version=3 Sep 12 17:48:39.812716 systemd[1]: Started docker-43169a5303eff9b31eb1760d656fe731ad7a56841e6fa9935f21a8f577128e42.scope - libcontainer container 43169a5303eff9b31eb1760d656fe731ad7a56841e6fa9935f21a8f577128e42. Sep 12 17:48:39.860174 kernel: docker0: port 1(veth5e33a1f) entered blocking state Sep 12 17:48:39.860255 kernel: docker0: port 1(veth5e33a1f) entered disabled state Sep 12 17:48:39.860278 kernel: veth5e33a1f: entered allmulticast mode Sep 12 17:48:39.865119 kernel: veth5e33a1f: entered promiscuous mode Sep 12 17:48:39.865358 systemd-networkd[1717]: veth5e33a1f: Link UP Sep 12 17:48:39.894604 kernel: eth0: renamed from veth93cf889 Sep 12 17:48:39.901408 kernel: docker0: port 1(veth5e33a1f) entered blocking state Sep 12 17:48:39.901453 kernel: docker0: port 1(veth5e33a1f) entered forwarding state Sep 12 17:48:39.901840 systemd-networkd[1717]: veth5e33a1f: Gained carrier Sep 12 17:48:39.902184 systemd-networkd[1717]: docker0: Gained carrier Sep 12 17:48:41.801732 systemd-networkd[1717]: docker0: Gained IPv6LL Sep 12 17:48:41.929670 systemd-networkd[1717]: veth5e33a1f: Gained IPv6LL Sep 12 17:48:43.191100 systemd[1]: docker-43169a5303eff9b31eb1760d656fe731ad7a56841e6fa9935f21a8f577128e42.scope: Deactivated successfully. Sep 12 17:48:43.204534 containerd[1900]: time="2025-09-12T17:48:43.204500285Z" level=info msg="shim disconnected" id=43169a5303eff9b31eb1760d656fe731ad7a56841e6fa9935f21a8f577128e42 namespace=moby Sep 12 17:48:43.204838 dockerd[13236]: time="2025-09-12T17:48:43.204563082Z" level=info msg="ignoring event" container=43169a5303eff9b31eb1760d656fe731ad7a56841e6fa9935f21a8f577128e42 module=libcontainerd namespace=moby topic=/tasks/delete type="*events.TaskDelete" Sep 12 17:48:43.205633 containerd[1900]: time="2025-09-12T17:48:43.205600443Z" level=warning msg="cleaning up after shim disconnected" id=43169a5303eff9b31eb1760d656fe731ad7a56841e6fa9935f21a8f577128e42 namespace=moby Sep 12 17:48:43.205726 containerd[1900]: time="2025-09-12T17:48:43.205624942Z" level=info msg="cleaning up dead shim" namespace=moby Sep 12 17:48:43.242604 kernel: docker0: port 1(veth5e33a1f) entered disabled state Sep 12 17:48:43.242692 kernel: veth93cf889: renamed from eth0 Sep 12 17:48:43.242717 systemd-networkd[1717]: veth5e33a1f: Lost carrier Sep 12 17:48:43.276294 kernel: docker0: port 1(veth5e33a1f) entered disabled state Sep 12 17:48:43.276356 kernel: veth5e33a1f (unregistering): left allmulticast mode Sep 12 17:48:43.279589 kernel: veth5e33a1f (unregistering): left promiscuous mode Sep 12 17:48:43.282885 kernel: docker0: port 1(veth5e33a1f) entered disabled state Sep 12 17:48:43.284821 systemd-networkd[1717]: veth93cf889: Configuring with /usr/lib/systemd/network/zz-default.network. Sep 12 17:48:43.284911 systemd-networkd[1717]: veth93cf889: Cannot enable IPv6, ignoring: No such file or directory Sep 12 17:48:43.284928 systemd-networkd[1717]: veth93cf889: Cannot configure IPv6 privacy extensions for interface, ignoring: No such file or directory Sep 12 17:48:43.284942 systemd-networkd[1717]: veth93cf889: Cannot disable kernel IPv6 accept_ra for interface, ignoring: No such file or directory Sep 12 17:48:43.284955 systemd-networkd[1717]: veth93cf889: Cannot set IPv6 proxy NDP, ignoring: No such file or directory Sep 12 17:48:43.284971 systemd-networkd[1717]: veth93cf889: Cannot enable promote_secondaries for interface, ignoring: No such file or directory Sep 12 17:48:43.285315 systemd-networkd[1717]: veth5e33a1f: Link DOWN Sep 12 17:48:43.305439 systemd[1]: run-docker-netns-a8a9f1310c83.mount: Deactivated successfully. Sep 12 17:48:43.309239 systemd[1]: var-lib-docker-overlay2-84d420217b761d6300b224297fe8813b9270df6a89685f3b14b0aaa0bc910a78-merged.mount: Deactivated successfully. Sep 12 17:48:43.454946 sshd[13215]: Connection closed by 10.200.16.10 port 56590 Sep 12 17:48:43.455246 sshd-session[13212]: pam_unix(sshd:session): session closed for user core Sep 12 17:48:43.458845 systemd[1]: sshd@34-10.200.8.11:22-10.200.16.10:56590.service: Deactivated successfully. Sep 12 17:48:43.460372 systemd[1]: session-37.scope: Deactivated successfully. Sep 12 17:48:43.461051 systemd-logind[1889]: Session 37 logged out. Waiting for processes to exit. Sep 12 17:48:43.462103 systemd-logind[1889]: Removed session 37. Sep 12 17:48:43.577057 systemd[1]: Started sshd@35-10.200.8.11:22-10.200.16.10:55926.service - OpenSSH per-connection server daemon (10.200.16.10:55926). Sep 12 17:48:44.226304 sshd[13528]: Accepted publickey for core from 10.200.16.10 port 55926 ssh2: RSA SHA256:N57c16sACXEH7T/hPh2WdUB1bqX8lYhBLQ19XJC/uD8 Sep 12 17:48:44.227687 sshd-session[13528]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Sep 12 17:48:44.231861 systemd-logind[1889]: New session 38 of user core. Sep 12 17:48:44.246698 systemd[1]: Started session-38.scope - Session 38 of User core. Sep 12 17:48:44.297810 systemd-networkd[1717]: docker0: Lost carrier Sep 12 17:48:44.698534 systemd[1]: var-lib-docker-overlay2-0598c78af8e7bdd927e11c023c108cc9ff0423ee8b96a5ee6e88b4610f137437\x2dinit-merged.mount: Deactivated successfully. Sep 12 17:48:44.802593 containerd[1900]: time="2025-09-12T17:48:44.802528280Z" level=info msg="connecting to shim 775a4fcfb00d66251889e9f7d4bb03138cf43668b021cdb148075dddace39b2d" address="unix:///run/containerd/s/bab59d7d2ea358543a98954697572001a62dde0107497219d82ed3e79b3e4cbc" namespace=moby protocol=ttrpc version=3 Sep 12 17:48:44.836709 systemd[1]: Started docker-775a4fcfb00d66251889e9f7d4bb03138cf43668b021cdb148075dddace39b2d.scope - libcontainer container 775a4fcfb00d66251889e9f7d4bb03138cf43668b021cdb148075dddace39b2d. Sep 12 17:48:44.877876 kernel: docker0: port 1(vethf465325) entered blocking state Sep 12 17:48:44.877962 kernel: docker0: port 1(vethf465325) entered disabled state Sep 12 17:48:44.880557 kernel: vethf465325: entered allmulticast mode Sep 12 17:48:44.883464 kernel: vethf465325: entered promiscuous mode Sep 12 17:48:44.884445 systemd-networkd[1717]: vethf465325: Link UP Sep 12 17:48:44.906600 kernel: eth0: renamed from veth43d9dd7 Sep 12 17:48:44.914908 kernel: docker0: port 1(vethf465325) entered blocking state Sep 12 17:48:44.914958 kernel: docker0: port 1(vethf465325) entered forwarding state Sep 12 17:48:44.913982 systemd-networkd[1717]: vethf465325: Gained carrier Sep 12 17:48:44.914220 systemd-networkd[1717]: docker0: Gained carrier Sep 12 17:48:44.953155 systemd[1]: docker-775a4fcfb00d66251889e9f7d4bb03138cf43668b021cdb148075dddace39b2d.scope: Deactivated successfully. Sep 12 17:48:44.975948 containerd[1900]: time="2025-09-12T17:48:44.975747761Z" level=info msg="shim disconnected" id=775a4fcfb00d66251889e9f7d4bb03138cf43668b021cdb148075dddace39b2d namespace=moby Sep 12 17:48:44.975948 containerd[1900]: time="2025-09-12T17:48:44.975783360Z" level=warning msg="cleaning up after shim disconnected" id=775a4fcfb00d66251889e9f7d4bb03138cf43668b021cdb148075dddace39b2d namespace=moby Sep 12 17:48:44.975948 containerd[1900]: time="2025-09-12T17:48:44.975792760Z" level=info msg="cleaning up dead shim" namespace=moby Sep 12 17:48:44.976086 dockerd[13236]: time="2025-09-12T17:48:44.975785860Z" level=info msg="ignoring event" container=775a4fcfb00d66251889e9f7d4bb03138cf43668b021cdb148075dddace39b2d module=libcontainerd namespace=moby topic=/tasks/delete type="*events.TaskDelete" Sep 12 17:48:45.006377 systemd-networkd[1717]: vethf465325: Lost carrier Sep 12 17:48:45.006597 kernel: docker0: port 1(vethf465325) entered disabled state Sep 12 17:48:45.006654 kernel: veth43d9dd7: renamed from eth0 Sep 12 17:48:45.035123 systemd-networkd[1717]: vethf465325: Link DOWN Sep 12 17:48:45.039596 kernel: docker0: port 1(vethf465325) entered disabled state Sep 12 17:48:45.039647 kernel: vethf465325 (unregistering): left allmulticast mode Sep 12 17:48:45.044929 kernel: vethf465325 (unregistering): left promiscuous mode Sep 12 17:48:45.048091 kernel: docker0: port 1(vethf465325) entered disabled state Sep 12 17:48:45.208318 sshd[13531]: Connection closed by 10.200.16.10 port 55926 Sep 12 17:48:45.208653 sshd-session[13528]: pam_unix(sshd:session): session closed for user core Sep 12 17:48:45.212164 systemd[1]: sshd@35-10.200.8.11:22-10.200.16.10:55926.service: Deactivated successfully. Sep 12 17:48:45.213753 systemd[1]: session-38.scope: Deactivated successfully. Sep 12 17:48:45.214425 systemd-logind[1889]: Session 38 logged out. Waiting for processes to exit. Sep 12 17:48:45.215362 systemd-logind[1889]: Removed session 38. Sep 12 17:48:45.305807 systemd-networkd[1717]: docker0: Lost carrier Sep 12 17:48:45.695330 systemd[1]: var-lib-docker-overlay2-0598c78af8e7bdd927e11c023c108cc9ff0423ee8b96a5ee6e88b4610f137437-merged.mount: Deactivated successfully.