Mar 19 11:41:01.205128 kernel: Linux version 6.6.83-flatcar (build@pony-truck.infra.kinvolk.io) (x86_64-cros-linux-gnu-gcc (Gentoo Hardened 14.2.1_p20241221 p7) 14.2.1 20241221, GNU ld (Gentoo 2.43 p3) 2.43.1) #1 SMP PREEMPT_DYNAMIC Wed Mar 19 10:13:43 -00 2025 Mar 19 11:41:01.205158 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=08c32ef14ad6302a92b1d281c48443f5b56d59f0d37d38df628e5b6f012967bc Mar 19 11:41:01.205168 kernel: BIOS-provided physical RAM map: Mar 19 11:41:01.205176 kernel: BIOS-e820: [mem 0x0000000000000000-0x000000000009ffff] usable Mar 19 11:41:01.205182 kernel: BIOS-e820: [mem 0x00000000000c0000-0x00000000000fffff] reserved Mar 19 11:41:01.205189 kernel: BIOS-e820: [mem 0x0000000000100000-0x000000003ff40fff] usable Mar 19 11:41:01.205197 kernel: BIOS-e820: [mem 0x000000003ff41000-0x000000003ffc8fff] reserved Mar 19 11:41:01.205207 kernel: BIOS-e820: [mem 0x000000003ffc9000-0x000000003fffafff] ACPI data Mar 19 11:41:01.205214 kernel: BIOS-e820: [mem 0x000000003fffb000-0x000000003fffefff] ACPI NVS Mar 19 11:41:01.205221 kernel: BIOS-e820: [mem 0x000000003ffff000-0x000000003fffffff] usable Mar 19 11:41:01.205228 kernel: BIOS-e820: [mem 0x0000000100000000-0x0000000fdfffffff] usable Mar 19 11:41:01.205235 kernel: BIOS-e820: [mem 0x0000004fe0000000-0x0000005cbfffffff] usable Mar 19 11:41:01.205242 kernel: printk: bootconsole [earlyser0] enabled Mar 19 11:41:01.205249 kernel: NX (Execute Disable) protection: active Mar 19 11:41:01.205260 kernel: APIC: Static calls initialized Mar 19 11:41:01.205268 kernel: efi: EFI v2.7 by Microsoft Mar 19 11:41:01.205277 kernel: efi: ACPI=0x3fffa000 ACPI 2.0=0x3fffa014 SMBIOS=0x3ff85000 SMBIOS 3.0=0x3ff83000 MEMATTR=0x3f5bfa98 RNG=0x3ffd1018 Mar 19 11:41:01.205284 kernel: random: crng init done Mar 19 11:41:01.205292 kernel: secureboot: Secure boot disabled Mar 19 11:41:01.205299 kernel: SMBIOS 3.1.0 present. Mar 19 11:41:01.205307 kernel: DMI: Microsoft Corporation Virtual Machine/Virtual Machine, BIOS Hyper-V UEFI Release v4.1 03/08/2024 Mar 19 11:41:01.205315 kernel: Hypervisor detected: Microsoft Hyper-V Mar 19 11:41:01.205322 kernel: Hyper-V: privilege flags low 0x2e7f, high 0x3b8030, hints 0x62c2c, misc 0xed7b2 Mar 19 11:41:01.205330 kernel: Hyper-V: Host Build 10.0.20348.1799-1-0 Mar 19 11:41:01.205340 kernel: Hyper-V: LAPIC Timer Frequency: 0x30d40 Mar 19 11:41:01.205347 kernel: Hyper-V: Using hypercall for remote TLB flush Mar 19 11:41:01.205355 kernel: clocksource: hyperv_clocksource_tsc_page: mask: 0xffffffffffffffff max_cycles: 0x24e6a1710, max_idle_ns: 440795202120 ns Mar 19 11:41:01.205363 kernel: clocksource: hyperv_clocksource_msr: mask: 0xffffffffffffffff max_cycles: 0x24e6a1710, max_idle_ns: 440795202120 ns Mar 19 11:41:01.205383 kernel: tsc: Marking TSC unstable due to running on Hyper-V Mar 19 11:41:01.205391 kernel: tsc: Detected 2593.993 MHz processor Mar 19 11:41:01.205399 kernel: e820: update [mem 0x00000000-0x00000fff] usable ==> reserved Mar 19 11:41:01.205408 kernel: e820: remove [mem 0x000a0000-0x000fffff] usable Mar 19 11:41:01.205416 kernel: last_pfn = 0x5cc0000 max_arch_pfn = 0x400000000 Mar 19 11:41:01.205426 kernel: MTRR map: 5 entries (2 fixed + 3 variable; max 18), built from 8 variable MTRRs Mar 19 11:41:01.205434 kernel: x86/PAT: Configuration [0-7]: WB WC UC- UC WB WP UC- WT Mar 19 11:41:01.205442 kernel: e820: update [mem 0x40000000-0xffffffff] usable ==> reserved Mar 19 11:41:01.205450 kernel: e820: update [mem 0x1100000000-0x4fdfffffff] usable ==> reserved Mar 19 11:41:01.205462 kernel: last_pfn = 0x40000 max_arch_pfn = 0x400000000 Mar 19 11:41:01.205469 kernel: Using GB pages for direct mapping Mar 19 11:41:01.205477 kernel: ACPI: Early table checksum verification disabled Mar 19 11:41:01.205490 kernel: ACPI: RSDP 0x000000003FFFA014 000024 (v02 VRTUAL) Mar 19 11:41:01.205500 kernel: ACPI: XSDT 0x000000003FFF90E8 000064 (v01 VRTUAL MICROSFT 00000001 MSFT 00000001) Mar 19 11:41:01.205509 kernel: ACPI: FACP 0x000000003FFF8000 000114 (v06 VRTUAL MICROSFT 00000001 MSFT 00000001) Mar 19 11:41:01.205517 kernel: ACPI: DSDT 0x000000003FFD6000 01E184 (v02 MSFTVM DSDT01 00000001 MSFT 05000000) Mar 19 11:41:01.205525 kernel: ACPI: FACS 0x000000003FFFE000 000040 Mar 19 11:41:01.205534 kernel: ACPI: OEM0 0x000000003FFF7000 000064 (v01 VRTUAL MICROSFT 00000001 MSFT 00000001) Mar 19 11:41:01.205542 kernel: ACPI: SPCR 0x000000003FFF6000 000050 (v02 VRTUAL MICROSFT 00000001 MSFT 00000001) Mar 19 11:41:01.205553 kernel: ACPI: WAET 0x000000003FFF5000 000028 (v01 VRTUAL MICROSFT 00000001 MSFT 00000001) Mar 19 11:41:01.205561 kernel: ACPI: APIC 0x000000003FFD5000 000078 (v04 VRTUAL MICROSFT 00000001 MSFT 00000001) Mar 19 11:41:01.205570 kernel: ACPI: SRAT 0x000000003FFD4000 0001D0 (v02 VRTUAL MICROSFT 00000001 MSFT 00000001) Mar 19 11:41:01.205578 kernel: ACPI: BGRT 0x000000003FFD3000 000038 (v01 VRTUAL MICROSFT 00000001 MSFT 00000001) Mar 19 11:41:01.205586 kernel: ACPI: FPDT 0x000000003FFD2000 000034 (v01 VRTUAL MICROSFT 00000001 MSFT 00000001) Mar 19 11:41:01.205595 kernel: ACPI: Reserving FACP table memory at [mem 0x3fff8000-0x3fff8113] Mar 19 11:41:01.205603 kernel: ACPI: Reserving DSDT table memory at [mem 0x3ffd6000-0x3fff4183] Mar 19 11:41:01.205611 kernel: ACPI: Reserving FACS table memory at [mem 0x3fffe000-0x3fffe03f] Mar 19 11:41:01.205622 kernel: ACPI: Reserving OEM0 table memory at [mem 0x3fff7000-0x3fff7063] Mar 19 11:41:01.205630 kernel: ACPI: Reserving SPCR table memory at [mem 0x3fff6000-0x3fff604f] Mar 19 11:41:01.205639 kernel: ACPI: Reserving WAET table memory at [mem 0x3fff5000-0x3fff5027] Mar 19 11:41:01.205647 kernel: ACPI: Reserving APIC table memory at [mem 0x3ffd5000-0x3ffd5077] Mar 19 11:41:01.205655 kernel: ACPI: Reserving SRAT table memory at [mem 0x3ffd4000-0x3ffd41cf] Mar 19 11:41:01.205663 kernel: ACPI: Reserving BGRT table memory at [mem 0x3ffd3000-0x3ffd3037] Mar 19 11:41:01.205671 kernel: ACPI: Reserving FPDT table memory at [mem 0x3ffd2000-0x3ffd2033] Mar 19 11:41:01.205680 kernel: SRAT: PXM 0 -> APIC 0x00 -> Node 0 Mar 19 11:41:01.205688 kernel: SRAT: PXM 0 -> APIC 0x01 -> Node 0 Mar 19 11:41:01.205699 kernel: SRAT: PXM 0 -> APIC 0x02 -> Node 0 Mar 19 11:41:01.205707 kernel: SRAT: PXM 0 -> APIC 0x03 -> Node 0 Mar 19 11:41:01.205715 kernel: SRAT: PXM 0 -> APIC 0x04 -> Node 0 Mar 19 11:41:01.205723 kernel: SRAT: PXM 0 -> APIC 0x05 -> Node 0 Mar 19 11:41:01.205731 kernel: ACPI: SRAT: Node 0 PXM 0 [mem 0x00000000-0x3fffffff] hotplug Mar 19 11:41:01.205740 kernel: ACPI: SRAT: Node 0 PXM 0 [mem 0x100000000-0xfdfffffff] hotplug Mar 19 11:41:01.205748 kernel: ACPI: SRAT: Node 0 PXM 0 [mem 0x4fe0000000-0x5cbfffffff] hotplug Mar 19 11:41:01.205757 kernel: ACPI: SRAT: Node 0 PXM 0 [mem 0x5cc0200000-0xffffffffff] hotplug Mar 19 11:41:01.205765 kernel: ACPI: SRAT: Node 0 PXM 0 [mem 0x10000200000-0x1ffffffffff] hotplug Mar 19 11:41:01.205776 kernel: ACPI: SRAT: Node 0 PXM 0 [mem 0x20000200000-0x3ffffffffff] hotplug Mar 19 11:41:01.205784 kernel: ACPI: SRAT: Node 0 PXM 0 [mem 0x40000200000-0x7ffffffffff] hotplug Mar 19 11:41:01.205792 kernel: ACPI: SRAT: Node 0 PXM 0 [mem 0x80000200000-0xfffffffffff] hotplug Mar 19 11:41:01.205801 kernel: NUMA: Node 0 [mem 0x00000000-0x3fffffff] + [mem 0x100000000-0xfdfffffff] -> [mem 0x00000000-0xfdfffffff] Mar 19 11:41:01.205809 kernel: NUMA: Node 0 [mem 0x00000000-0xfdfffffff] + [mem 0x4fe0000000-0x5cbfffffff] -> [mem 0x00000000-0x5cbfffffff] Mar 19 11:41:01.205818 kernel: NODE_DATA(0) allocated [mem 0x5cbfff9000-0x5cbfffefff] Mar 19 11:41:01.205826 kernel: Zone ranges: Mar 19 11:41:01.205834 kernel: DMA [mem 0x0000000000001000-0x0000000000ffffff] Mar 19 11:41:01.205842 kernel: DMA32 [mem 0x0000000001000000-0x00000000ffffffff] Mar 19 11:41:01.205853 kernel: Normal [mem 0x0000000100000000-0x0000005cbfffffff] Mar 19 11:41:01.205861 kernel: Movable zone start for each node Mar 19 11:41:01.205870 kernel: Early memory node ranges Mar 19 11:41:01.205878 kernel: node 0: [mem 0x0000000000001000-0x000000000009ffff] Mar 19 11:41:01.205886 kernel: node 0: [mem 0x0000000000100000-0x000000003ff40fff] Mar 19 11:41:01.205894 kernel: node 0: [mem 0x000000003ffff000-0x000000003fffffff] Mar 19 11:41:01.205902 kernel: node 0: [mem 0x0000000100000000-0x0000000fdfffffff] Mar 19 11:41:01.205911 kernel: node 0: [mem 0x0000004fe0000000-0x0000005cbfffffff] Mar 19 11:41:01.205919 kernel: Initmem setup node 0 [mem 0x0000000000001000-0x0000005cbfffffff] Mar 19 11:41:01.205930 kernel: On node 0, zone DMA: 1 pages in unavailable ranges Mar 19 11:41:01.205938 kernel: On node 0, zone DMA: 96 pages in unavailable ranges Mar 19 11:41:01.205946 kernel: On node 0, zone DMA32: 190 pages in unavailable ranges Mar 19 11:41:01.205954 kernel: ACPI: PM-Timer IO Port: 0x408 Mar 19 11:41:01.205963 kernel: ACPI: LAPIC_NMI (acpi_id[0x01] dfl dfl lint[0x1]) Mar 19 11:41:01.205971 kernel: IOAPIC[0]: apic_id 6, version 17, address 0xfec00000, GSI 0-23 Mar 19 11:41:01.205979 kernel: ACPI: INT_SRC_OVR (bus 0 bus_irq 9 global_irq 9 high level) Mar 19 11:41:01.205987 kernel: ACPI: Using ACPI (MADT) for SMP configuration information Mar 19 11:41:01.205995 kernel: ACPI: SPCR: console: uart,io,0x3f8,115200 Mar 19 11:41:01.206013 kernel: smpboot: Allowing 6 CPUs, 0 hotplug CPUs Mar 19 11:41:01.206021 kernel: [mem 0x40000000-0xffffffff] available for PCI devices Mar 19 11:41:01.206029 kernel: Booting paravirtualized kernel on Hyper-V Mar 19 11:41:01.206038 kernel: clocksource: refined-jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1910969940391419 ns Mar 19 11:41:01.206046 kernel: setup_percpu: NR_CPUS:512 nr_cpumask_bits:6 nr_cpu_ids:6 nr_node_ids:1 Mar 19 11:41:01.206054 kernel: percpu: Embedded 58 pages/cpu s197032 r8192 d32344 u262144 Mar 19 11:41:01.206062 kernel: pcpu-alloc: s197032 r8192 d32344 u262144 alloc=1*2097152 Mar 19 11:41:01.206071 kernel: pcpu-alloc: [0] 0 1 2 3 4 5 - - Mar 19 11:41:01.206079 kernel: Hyper-V: PV spinlocks enabled Mar 19 11:41:01.206090 kernel: PV qspinlock hash table entries: 256 (order: 0, 4096 bytes, linear) Mar 19 11:41:01.206099 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=08c32ef14ad6302a92b1d281c48443f5b56d59f0d37d38df628e5b6f012967bc Mar 19 11:41:01.206108 kernel: Unknown kernel command line parameters "BOOT_IMAGE=/flatcar/vmlinuz-a", will be passed to user space. Mar 19 11:41:01.206116 kernel: Dentry cache hash table entries: 8388608 (order: 14, 67108864 bytes, linear) Mar 19 11:41:01.206125 kernel: Inode-cache hash table entries: 4194304 (order: 13, 33554432 bytes, linear) Mar 19 11:41:01.206133 kernel: Fallback order for Node 0: 0 Mar 19 11:41:01.206141 kernel: Built 1 zonelists, mobility grouping on. Total pages: 28899610 Mar 19 11:41:01.206149 kernel: Policy zone: Normal Mar 19 11:41:01.206160 kernel: mem auto-init: stack:off, heap alloc:off, heap free:off Mar 19 11:41:01.206177 kernel: software IO TLB: area num 8. Mar 19 11:41:01.206186 kernel: Memory: 115335988K/117439364K available (14336K kernel code, 2303K rwdata, 22860K rodata, 43480K init, 1592K bss, 2103120K reserved, 0K cma-reserved) Mar 19 11:41:01.206197 kernel: SLUB: HWalign=64, Order=0-3, MinObjects=0, CPUs=6, Nodes=1 Mar 19 11:41:01.206206 kernel: Kernel/User page tables isolation: enabled Mar 19 11:41:01.206215 kernel: ftrace: allocating 37910 entries in 149 pages Mar 19 11:41:01.206223 kernel: ftrace: allocated 149 pages with 4 groups Mar 19 11:41:01.206232 kernel: Dynamic Preempt: voluntary Mar 19 11:41:01.206241 kernel: rcu: Preemptible hierarchical RCU implementation. Mar 19 11:41:01.206250 kernel: rcu: RCU event tracing is enabled. Mar 19 11:41:01.206259 kernel: rcu: RCU restricting CPUs from NR_CPUS=512 to nr_cpu_ids=6. Mar 19 11:41:01.206268 kernel: Trampoline variant of Tasks RCU enabled. Mar 19 11:41:01.206280 kernel: Rude variant of Tasks RCU enabled. Mar 19 11:41:01.206289 kernel: Tracing variant of Tasks RCU enabled. Mar 19 11:41:01.206297 kernel: rcu: RCU calculated value of scheduler-enlistment delay is 100 jiffies. Mar 19 11:41:01.206306 kernel: rcu: Adjusting geometry for rcu_fanout_leaf=16, nr_cpu_ids=6 Mar 19 11:41:01.206317 kernel: Using NULL legacy PIC Mar 19 11:41:01.206326 kernel: NR_IRQS: 33024, nr_irqs: 472, preallocated irqs: 0 Mar 19 11:41:01.206335 kernel: rcu: srcu_init: Setting srcu_struct sizes based on contention. Mar 19 11:41:01.206344 kernel: Console: colour dummy device 80x25 Mar 19 11:41:01.206352 kernel: printk: console [tty1] enabled Mar 19 11:41:01.206361 kernel: printk: console [ttyS0] enabled Mar 19 11:41:01.206377 kernel: printk: bootconsole [earlyser0] disabled Mar 19 11:41:01.206386 kernel: ACPI: Core revision 20230628 Mar 19 11:41:01.206395 kernel: Failed to register legacy timer interrupt Mar 19 11:41:01.206404 kernel: APIC: Switch to symmetric I/O mode setup Mar 19 11:41:01.206416 kernel: Hyper-V: enabling crash_kexec_post_notifiers Mar 19 11:41:01.206424 kernel: Hyper-V: Using IPI hypercalls Mar 19 11:41:01.206433 kernel: APIC: send_IPI() replaced with hv_send_ipi() Mar 19 11:41:01.206442 kernel: APIC: send_IPI_mask() replaced with hv_send_ipi_mask() Mar 19 11:41:01.206451 kernel: APIC: send_IPI_mask_allbutself() replaced with hv_send_ipi_mask_allbutself() Mar 19 11:41:01.206459 kernel: APIC: send_IPI_allbutself() replaced with hv_send_ipi_allbutself() Mar 19 11:41:01.206468 kernel: APIC: send_IPI_all() replaced with hv_send_ipi_all() Mar 19 11:41:01.206477 kernel: APIC: send_IPI_self() replaced with hv_send_ipi_self() Mar 19 11:41:01.206486 kernel: Hyper-V: Using enlightened APIC (xapic mode) Mar 19 11:41:01.206497 kernel: APIC: eoi() replaced with hv_apic_eoi_write() Mar 19 11:41:01.206506 kernel: APIC: read() replaced with hv_apic_read() Mar 19 11:41:01.206515 kernel: APIC: write() replaced with hv_apic_write() Mar 19 11:41:01.206523 kernel: APIC: icr_write() replaced with hv_apic_icr_write() Mar 19 11:41:01.206532 kernel: APIC: icr_read() replaced with hv_apic_icr_read() Mar 19 11:41:01.206541 kernel: Calibrating delay loop (skipped), value calculated using timer frequency.. 5187.98 BogoMIPS (lpj=2593993) Mar 19 11:41:01.206550 kernel: Last level iTLB entries: 4KB 128, 2MB 8, 4MB 8 Mar 19 11:41:01.206559 kernel: Last level dTLB entries: 4KB 64, 2MB 32, 4MB 32, 1GB 4 Mar 19 11:41:01.206568 kernel: Spectre V1 : Mitigation: usercopy/swapgs barriers and __user pointer sanitization Mar 19 11:41:01.206579 kernel: Spectre V2 : Mitigation: Retpolines Mar 19 11:41:01.206587 kernel: Spectre V2 : Spectre v2 / SpectreRSB mitigation: Filling RSB on context switch Mar 19 11:41:01.206596 kernel: Spectre V2 : Spectre v2 / SpectreRSB : Filling RSB on VMEXIT Mar 19 11:41:01.206605 kernel: Speculative Store Bypass: Vulnerable Mar 19 11:41:01.206613 kernel: MDS: Mitigation: Clear CPU buffers Mar 19 11:41:01.206621 kernel: TAA: Mitigation: Clear CPU buffers Mar 19 11:41:01.206630 kernel: MMIO Stale Data: Vulnerable: Clear CPU buffers attempted, no microcode Mar 19 11:41:01.206638 kernel: x86/fpu: Supporting XSAVE feature 0x001: 'x87 floating point registers' Mar 19 11:41:01.206647 kernel: x86/fpu: Supporting XSAVE feature 0x002: 'SSE registers' Mar 19 11:41:01.206656 kernel: x86/fpu: Supporting XSAVE feature 0x004: 'AVX registers' Mar 19 11:41:01.206664 kernel: x86/fpu: xstate_offset[2]: 576, xstate_sizes[2]: 256 Mar 19 11:41:01.206675 kernel: x86/fpu: Enabled xstate features 0x7, context size is 832 bytes, using 'standard' format. Mar 19 11:41:01.206684 kernel: Freeing SMP alternatives memory: 32K Mar 19 11:41:01.206693 kernel: pid_max: default: 32768 minimum: 301 Mar 19 11:41:01.206701 kernel: LSM: initializing lsm=lockdown,capability,landlock,selinux,integrity Mar 19 11:41:01.206710 kernel: landlock: Up and running. Mar 19 11:41:01.206718 kernel: SELinux: Initializing. Mar 19 11:41:01.206727 kernel: Mount-cache hash table entries: 131072 (order: 8, 1048576 bytes, linear) Mar 19 11:41:01.206735 kernel: Mountpoint-cache hash table entries: 131072 (order: 8, 1048576 bytes, linear) Mar 19 11:41:01.206744 kernel: smpboot: CPU0: Intel(R) Xeon(R) CPU E5-2690 v4 @ 2.60GHz (family: 0x6, model: 0x4f, stepping: 0x1) Mar 19 11:41:01.206753 kernel: RCU Tasks: Setting shift to 3 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=6. Mar 19 11:41:01.206762 kernel: RCU Tasks Rude: Setting shift to 3 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=6. Mar 19 11:41:01.206773 kernel: RCU Tasks Trace: Setting shift to 3 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=6. Mar 19 11:41:01.206782 kernel: Performance Events: unsupported p6 CPU model 79 no PMU driver, software events only. Mar 19 11:41:01.206791 kernel: signal: max sigframe size: 1776 Mar 19 11:41:01.206800 kernel: rcu: Hierarchical SRCU implementation. Mar 19 11:41:01.206809 kernel: rcu: Max phase no-delay instances is 400. Mar 19 11:41:01.206817 kernel: NMI watchdog: Perf NMI watchdog permanently disabled Mar 19 11:41:01.206826 kernel: smp: Bringing up secondary CPUs ... Mar 19 11:41:01.206835 kernel: smpboot: x86: Booting SMP configuration: Mar 19 11:41:01.206843 kernel: .... node #0, CPUs: #1 #2 #3 #4 #5 Mar 19 11:41:01.206855 kernel: smp: Brought up 1 node, 6 CPUs Mar 19 11:41:01.206863 kernel: smpboot: Max logical packages: 1 Mar 19 11:41:01.206872 kernel: smpboot: Total of 6 processors activated (31127.91 BogoMIPS) Mar 19 11:41:01.206881 kernel: devtmpfs: initialized Mar 19 11:41:01.206890 kernel: x86/mm: Memory block size: 1024MB Mar 19 11:41:01.206898 kernel: ACPI: PM: Registering ACPI NVS region [mem 0x3fffb000-0x3fffefff] (16384 bytes) Mar 19 11:41:01.206907 kernel: clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1911260446275000 ns Mar 19 11:41:01.206916 kernel: futex hash table entries: 2048 (order: 5, 131072 bytes, linear) Mar 19 11:41:01.206925 kernel: pinctrl core: initialized pinctrl subsystem Mar 19 11:41:01.206936 kernel: NET: Registered PF_NETLINK/PF_ROUTE protocol family Mar 19 11:41:01.206945 kernel: audit: initializing netlink subsys (disabled) Mar 19 11:41:01.206954 kernel: audit: type=2000 audit(1742384459.028:1): state=initialized audit_enabled=0 res=1 Mar 19 11:41:01.206963 kernel: thermal_sys: Registered thermal governor 'step_wise' Mar 19 11:41:01.206971 kernel: thermal_sys: Registered thermal governor 'user_space' Mar 19 11:41:01.206980 kernel: cpuidle: using governor menu Mar 19 11:41:01.206989 kernel: acpiphp: ACPI Hot Plug PCI Controller Driver version: 0.5 Mar 19 11:41:01.206997 kernel: dca service started, version 1.12.1 Mar 19 11:41:01.207006 kernel: e820: reserve RAM buffer [mem 0x3ff41000-0x3fffffff] Mar 19 11:41:01.207017 kernel: kprobes: kprobe jump-optimization is enabled. All kprobes are optimized if possible. Mar 19 11:41:01.207026 kernel: HugeTLB: registered 1.00 GiB page size, pre-allocated 0 pages Mar 19 11:41:01.207035 kernel: HugeTLB: 16380 KiB vmemmap can be freed for a 1.00 GiB page Mar 19 11:41:01.207044 kernel: HugeTLB: registered 2.00 MiB page size, pre-allocated 0 pages Mar 19 11:41:01.207052 kernel: HugeTLB: 28 KiB vmemmap can be freed for a 2.00 MiB page Mar 19 11:41:01.207061 kernel: ACPI: Added _OSI(Module Device) Mar 19 11:41:01.207070 kernel: ACPI: Added _OSI(Processor Device) Mar 19 11:41:01.207078 kernel: ACPI: Added _OSI(3.0 _SCP Extensions) Mar 19 11:41:01.207087 kernel: ACPI: Added _OSI(Processor Aggregator Device) Mar 19 11:41:01.207098 kernel: ACPI: 1 ACPI AML tables successfully acquired and loaded Mar 19 11:41:01.207107 kernel: ACPI: _OSC evaluation for CPUs failed, trying _PDC Mar 19 11:41:01.207116 kernel: ACPI: Interpreter enabled Mar 19 11:41:01.207124 kernel: ACPI: PM: (supports S0 S5) Mar 19 11:41:01.207133 kernel: ACPI: Using IOAPIC for interrupt routing Mar 19 11:41:01.207142 kernel: PCI: Using host bridge windows from ACPI; if necessary, use "pci=nocrs" and report a bug Mar 19 11:41:01.207151 kernel: PCI: Ignoring E820 reservations for host bridge windows Mar 19 11:41:01.207159 kernel: ACPI: Enabled 1 GPEs in block 00 to 0F Mar 19 11:41:01.207168 kernel: iommu: Default domain type: Translated Mar 19 11:41:01.207179 kernel: iommu: DMA domain TLB invalidation policy: lazy mode Mar 19 11:41:01.207188 kernel: efivars: Registered efivars operations Mar 19 11:41:01.207197 kernel: PCI: Using ACPI for IRQ routing Mar 19 11:41:01.207205 kernel: PCI: System does not support PCI Mar 19 11:41:01.207214 kernel: vgaarb: loaded Mar 19 11:41:01.207223 kernel: clocksource: Switched to clocksource hyperv_clocksource_tsc_page Mar 19 11:41:01.207231 kernel: VFS: Disk quotas dquot_6.6.0 Mar 19 11:41:01.207240 kernel: VFS: Dquot-cache hash table entries: 512 (order 0, 4096 bytes) Mar 19 11:41:01.207249 kernel: pnp: PnP ACPI init Mar 19 11:41:01.207260 kernel: pnp: PnP ACPI: found 3 devices Mar 19 11:41:01.207269 kernel: clocksource: acpi_pm: mask: 0xffffff max_cycles: 0xffffff, max_idle_ns: 2085701024 ns Mar 19 11:41:01.207278 kernel: NET: Registered PF_INET protocol family Mar 19 11:41:01.207287 kernel: IP idents hash table entries: 262144 (order: 9, 2097152 bytes, linear) Mar 19 11:41:01.207298 kernel: tcp_listen_portaddr_hash hash table entries: 65536 (order: 8, 1048576 bytes, linear) Mar 19 11:41:01.207307 kernel: Table-perturb hash table entries: 65536 (order: 6, 262144 bytes, linear) Mar 19 11:41:01.207316 kernel: TCP established hash table entries: 524288 (order: 10, 4194304 bytes, linear) Mar 19 11:41:01.207324 kernel: TCP bind hash table entries: 65536 (order: 9, 2097152 bytes, linear) Mar 19 11:41:01.207336 kernel: TCP: Hash tables configured (established 524288 bind 65536) Mar 19 11:41:01.207344 kernel: UDP hash table entries: 65536 (order: 9, 2097152 bytes, linear) Mar 19 11:41:01.207353 kernel: UDP-Lite hash table entries: 65536 (order: 9, 2097152 bytes, linear) Mar 19 11:41:01.207362 kernel: NET: Registered PF_UNIX/PF_LOCAL protocol family Mar 19 11:41:01.207378 kernel: NET: Registered PF_XDP protocol family Mar 19 11:41:01.207387 kernel: PCI: CLS 0 bytes, default 64 Mar 19 11:41:01.207396 kernel: PCI-DMA: Using software bounce buffering for IO (SWIOTLB) Mar 19 11:41:01.207405 kernel: software IO TLB: mapped [mem 0x000000003b5bf000-0x000000003f5bf000] (64MB) Mar 19 11:41:01.207414 kernel: RAPL PMU: API unit is 2^-32 Joules, 0 fixed counters, 10737418240 ms ovfl timer Mar 19 11:41:01.207425 kernel: Initialise system trusted keyrings Mar 19 11:41:01.207434 kernel: workingset: timestamp_bits=39 max_order=25 bucket_order=0 Mar 19 11:41:01.207443 kernel: Key type asymmetric registered Mar 19 11:41:01.207451 kernel: Asymmetric key parser 'x509' registered Mar 19 11:41:01.207460 kernel: Block layer SCSI generic (bsg) driver version 0.4 loaded (major 251) Mar 19 11:41:01.207468 kernel: io scheduler mq-deadline registered Mar 19 11:41:01.207484 kernel: io scheduler kyber registered Mar 19 11:41:01.207494 kernel: io scheduler bfq registered Mar 19 11:41:01.207502 kernel: ioatdma: Intel(R) QuickData Technology Driver 5.00 Mar 19 11:41:01.207511 kernel: Serial: 8250/16550 driver, 4 ports, IRQ sharing enabled Mar 19 11:41:01.207524 kernel: 00:00: ttyS0 at I/O 0x3f8 (irq = 4, base_baud = 115200) is a 16550A Mar 19 11:41:01.207533 kernel: 00:01: ttyS1 at I/O 0x2f8 (irq = 3, base_baud = 115200) is a 16550A Mar 19 11:41:01.207541 kernel: i8042: PNP: No PS/2 controller found. Mar 19 11:41:01.207698 kernel: rtc_cmos 00:02: registered as rtc0 Mar 19 11:41:01.207808 kernel: rtc_cmos 00:02: setting system clock to 2025-03-19T11:41:00 UTC (1742384460) Mar 19 11:41:01.207909 kernel: rtc_cmos 00:02: alarms up to one month, 114 bytes nvram Mar 19 11:41:01.207923 kernel: intel_pstate: CPU model not supported Mar 19 11:41:01.207936 kernel: efifb: probing for efifb Mar 19 11:41:01.207946 kernel: efifb: framebuffer at 0x40000000, using 3072k, total 3072k Mar 19 11:41:01.207954 kernel: efifb: mode is 1024x768x32, linelength=4096, pages=1 Mar 19 11:41:01.207963 kernel: efifb: scrolling: redraw Mar 19 11:41:01.207972 kernel: efifb: Truecolor: size=8:8:8:8, shift=24:16:8:0 Mar 19 11:41:01.207981 kernel: Console: switching to colour frame buffer device 128x48 Mar 19 11:41:01.207990 kernel: fb0: EFI VGA frame buffer device Mar 19 11:41:01.207999 kernel: pstore: Using crash dump compression: deflate Mar 19 11:41:01.208008 kernel: pstore: Registered efi_pstore as persistent store backend Mar 19 11:41:01.208019 kernel: NET: Registered PF_INET6 protocol family Mar 19 11:41:01.208028 kernel: Segment Routing with IPv6 Mar 19 11:41:01.208037 kernel: In-situ OAM (IOAM) with IPv6 Mar 19 11:41:01.208046 kernel: NET: Registered PF_PACKET protocol family Mar 19 11:41:01.208054 kernel: Key type dns_resolver registered Mar 19 11:41:01.208063 kernel: IPI shorthand broadcast: enabled Mar 19 11:41:01.208072 kernel: sched_clock: Marking stable (1655005200, 102851500)->(2098508200, -340651500) Mar 19 11:41:01.208081 kernel: registered taskstats version 1 Mar 19 11:41:01.208090 kernel: Loading compiled-in X.509 certificates Mar 19 11:41:01.208101 kernel: Loaded X.509 cert 'Kinvolk GmbH: Module signing key for 6.6.83-flatcar: ea8d6696bd19c98b32173a761210456cdad6b56b' Mar 19 11:41:01.208110 kernel: Key type .fscrypt registered Mar 19 11:41:01.208118 kernel: Key type fscrypt-provisioning registered Mar 19 11:41:01.208127 kernel: ima: No TPM chip found, activating TPM-bypass! Mar 19 11:41:01.208136 kernel: ima: Allocated hash algorithm: sha1 Mar 19 11:41:01.208145 kernel: ima: No architecture policies found Mar 19 11:41:01.208154 kernel: clk: Disabling unused clocks Mar 19 11:41:01.208162 kernel: Freeing unused kernel image (initmem) memory: 43480K Mar 19 11:41:01.208171 kernel: Write protecting the kernel read-only data: 38912k Mar 19 11:41:01.208183 kernel: Freeing unused kernel image (rodata/data gap) memory: 1716K Mar 19 11:41:01.208191 kernel: Run /init as init process Mar 19 11:41:01.208200 kernel: with arguments: Mar 19 11:41:01.208209 kernel: /init Mar 19 11:41:01.208218 kernel: with environment: Mar 19 11:41:01.208226 kernel: HOME=/ Mar 19 11:41:01.208235 kernel: TERM=linux Mar 19 11:41:01.208243 kernel: BOOT_IMAGE=/flatcar/vmlinuz-a Mar 19 11:41:01.208253 systemd[1]: Successfully made /usr/ read-only. Mar 19 11:41:01.208268 systemd[1]: systemd 256.8 running in system mode (+PAM +AUDIT +SELINUX -APPARMOR +IMA +SMACK +SECCOMP +GCRYPT -GNUTLS +OPENSSL -ACL +BLKID +CURL +ELFUTILS -FIDO2 +IDN2 -IDN +IPTC +KMOD +LIBCRYPTSETUP +LIBCRYPTSETUP_PLUGINS +LIBFDISK +PCRE2 -PWQUALITY -P11KIT -QRENCODE +TPM2 +BZIP2 +LZ4 +XZ +ZLIB +ZSTD -BPF_FRAMEWORK -XKBCOMMON +UTMP -SYSVINIT +LIBARCHIVE) Mar 19 11:41:01.208278 systemd[1]: Detected virtualization microsoft. Mar 19 11:41:01.208287 systemd[1]: Detected architecture x86-64. Mar 19 11:41:01.208296 systemd[1]: Running in initrd. Mar 19 11:41:01.208305 systemd[1]: No hostname configured, using default hostname. Mar 19 11:41:01.208314 systemd[1]: Hostname set to . Mar 19 11:41:01.208323 systemd[1]: Initializing machine ID from random generator. Mar 19 11:41:01.208335 systemd[1]: Queued start job for default target initrd.target. Mar 19 11:41:01.208345 systemd[1]: Started clevis-luks-askpass.path - Forward Password Requests to Clevis Directory Watch. Mar 19 11:41:01.208354 systemd[1]: Started systemd-ask-password-console.path - Dispatch Password Requests to Console Directory Watch. Mar 19 11:41:01.208364 systemd[1]: Expecting device dev-disk-by\x2dlabel-EFI\x2dSYSTEM.device - /dev/disk/by-label/EFI-SYSTEM... Mar 19 11:41:01.208386 systemd[1]: Expecting device dev-disk-by\x2dlabel-OEM.device - /dev/disk/by-label/OEM... Mar 19 11:41:01.208396 systemd[1]: Expecting device dev-disk-by\x2dlabel-ROOT.device - /dev/disk/by-label/ROOT... Mar 19 11:41:01.208407 systemd[1]: Expecting device dev-disk-by\x2dpartlabel-USR\x2dA.device - /dev/disk/by-partlabel/USR-A... Mar 19 11:41:01.208420 systemd[1]: Expecting device dev-disk-by\x2dpartuuid-7130c94a\x2d213a\x2d4e5a\x2d8e26\x2d6cce9662f132.device - /dev/disk/by-partuuid/7130c94a-213a-4e5a-8e26-6cce9662f132... Mar 19 11:41:01.208430 systemd[1]: Expecting device dev-mapper-usr.device - /dev/mapper/usr... Mar 19 11:41:01.208439 systemd[1]: Reached target cryptsetup-pre.target - Local Encrypted Volumes (Pre). Mar 19 11:41:01.208449 systemd[1]: Reached target cryptsetup.target - Local Encrypted Volumes. Mar 19 11:41:01.208458 systemd[1]: Reached target paths.target - Path Units. Mar 19 11:41:01.208467 systemd[1]: Reached target slices.target - Slice Units. Mar 19 11:41:01.208477 systemd[1]: Reached target swap.target - Swaps. Mar 19 11:41:01.208486 systemd[1]: Reached target timers.target - Timer Units. Mar 19 11:41:01.208498 systemd[1]: Listening on iscsid.socket - Open-iSCSI iscsid Socket. Mar 19 11:41:01.208508 systemd[1]: Listening on iscsiuio.socket - Open-iSCSI iscsiuio Socket. Mar 19 11:41:01.208517 systemd[1]: Listening on systemd-journald-dev-log.socket - Journal Socket (/dev/log). Mar 19 11:41:01.208527 systemd[1]: Listening on systemd-journald.socket - Journal Sockets. Mar 19 11:41:01.208536 systemd[1]: Listening on systemd-networkd.socket - Network Service Netlink Socket. Mar 19 11:41:01.208545 systemd[1]: Listening on systemd-udevd-control.socket - udev Control Socket. Mar 19 11:41:01.208555 systemd[1]: Listening on systemd-udevd-kernel.socket - udev Kernel Socket. Mar 19 11:41:01.208564 systemd[1]: Reached target sockets.target - Socket Units. Mar 19 11:41:01.208574 systemd[1]: Starting ignition-setup-pre.service - Ignition env setup... Mar 19 11:41:01.208586 systemd[1]: Starting kmod-static-nodes.service - Create List of Static Device Nodes... Mar 19 11:41:01.208595 systemd[1]: Finished network-cleanup.service - Network Cleanup. Mar 19 11:41:01.208604 systemd[1]: Starting systemd-fsck-usr.service... Mar 19 11:41:01.208614 systemd[1]: Starting systemd-journald.service - Journal Service... Mar 19 11:41:01.208623 systemd[1]: Starting systemd-modules-load.service - Load Kernel Modules... Mar 19 11:41:01.208652 systemd-journald[205]: Collecting audit messages is disabled. Mar 19 11:41:01.208682 systemd[1]: Starting systemd-vconsole-setup.service - Virtual Console Setup... Mar 19 11:41:01.208692 systemd-journald[205]: Journal started Mar 19 11:41:01.208713 systemd-journald[205]: Runtime Journal (/run/log/journal/4cc691496a344083a30cc9afc97ab90e) is 8M, max 2.2G, 2.1G free. Mar 19 11:41:01.216699 systemd[1]: Started systemd-journald.service - Journal Service. Mar 19 11:41:01.220077 systemd-modules-load[207]: Inserted module 'overlay' Mar 19 11:41:01.220587 systemd[1]: Finished ignition-setup-pre.service - Ignition env setup. Mar 19 11:41:01.221926 systemd[1]: Finished kmod-static-nodes.service - Create List of Static Device Nodes. Mar 19 11:41:01.222529 systemd[1]: Finished systemd-fsck-usr.service. Mar 19 11:41:01.224936 systemd[1]: Starting systemd-tmpfiles-setup-dev-early.service - Create Static Device Nodes in /dev gracefully... Mar 19 11:41:01.252298 systemd[1]: Starting systemd-tmpfiles-setup.service - Create System Files and Directories... Mar 19 11:41:01.259646 systemd[1]: Finished systemd-vconsole-setup.service - Virtual Console Setup. Mar 19 11:41:01.270260 systemd[1]: Finished systemd-tmpfiles-setup-dev-early.service - Create Static Device Nodes in /dev gracefully. Mar 19 11:41:01.282851 systemd[1]: Starting dracut-cmdline-ask.service - dracut ask for additional cmdline parameters... Mar 19 11:41:01.296767 systemd[1]: Starting systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev... Mar 19 11:41:01.298527 systemd[1]: Finished systemd-tmpfiles-setup.service - Create System Files and Directories. Mar 19 11:41:01.314630 systemd[1]: Finished dracut-cmdline-ask.service - dracut ask for additional cmdline parameters. Mar 19 11:41:01.318151 systemd[1]: Starting dracut-cmdline.service - dracut cmdline hook... Mar 19 11:41:01.329576 systemd[1]: Finished systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev. Mar 19 11:41:01.351387 kernel: bridge: filtering via arp/ip/ip6tables is no longer available by default. Update your scripts to load br_netfilter if you need this. Mar 19 11:41:01.353094 dracut-cmdline[234]: dracut-dracut-053 Mar 19 11:41:01.357072 kernel: Bridge firewalling registered Mar 19 11:41:01.355567 systemd-modules-load[207]: Inserted module 'br_netfilter' Mar 19 11:41:01.364030 dracut-cmdline[234]: Using kernel command line parameters: rd.driver.pre=btrfs 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=08c32ef14ad6302a92b1d281c48443f5b56d59f0d37d38df628e5b6f012967bc Mar 19 11:41:01.356575 systemd[1]: Finished systemd-modules-load.service - Load Kernel Modules. Mar 19 11:41:01.363476 systemd[1]: Starting systemd-sysctl.service - Apply Kernel Variables... Mar 19 11:41:01.404297 systemd[1]: Finished systemd-sysctl.service - Apply Kernel Variables. Mar 19 11:41:01.407221 systemd[1]: Starting systemd-resolved.service - Network Name Resolution... Mar 19 11:41:01.447973 systemd-resolved[259]: Positive Trust Anchors: Mar 19 11:41:01.447990 systemd-resolved[259]: . IN DS 20326 8 2 e06d44b80b8f1d39a95c0b0d7c65d08458e880409bbc683457104237c7f8ec8d Mar 19 11:41:01.448021 systemd-resolved[259]: Negative trust anchors: home.arpa 10.in-addr.arpa 16.172.in-addr.arpa 17.172.in-addr.arpa 18.172.in-addr.arpa 19.172.in-addr.arpa 20.172.in-addr.arpa 21.172.in-addr.arpa 22.172.in-addr.arpa 23.172.in-addr.arpa 24.172.in-addr.arpa 25.172.in-addr.arpa 26.172.in-addr.arpa 27.172.in-addr.arpa 28.172.in-addr.arpa 29.172.in-addr.arpa 30.172.in-addr.arpa 31.172.in-addr.arpa 170.0.0.192.in-addr.arpa 171.0.0.192.in-addr.arpa 168.192.in-addr.arpa d.f.ip6.arpa ipv4only.arpa resolver.arpa corp home internal intranet lan local private test Mar 19 11:41:01.450664 systemd-resolved[259]: Defaulting to hostname 'linux'. Mar 19 11:41:01.453043 systemd[1]: Started systemd-resolved.service - Network Name Resolution. Mar 19 11:41:01.459572 systemd[1]: Reached target nss-lookup.target - Host and Network Name Lookups. Mar 19 11:41:01.541401 kernel: SCSI subsystem initialized Mar 19 11:41:01.551396 kernel: Loading iSCSI transport class v2.0-870. Mar 19 11:41:01.564397 kernel: iscsi: registered transport (tcp) Mar 19 11:41:01.587834 kernel: iscsi: registered transport (qla4xxx) Mar 19 11:41:01.587900 kernel: QLogic iSCSI HBA Driver Mar 19 11:41:01.629901 systemd[1]: Finished dracut-cmdline.service - dracut cmdline hook. Mar 19 11:41:01.651512 systemd[1]: Starting dracut-pre-udev.service - dracut pre-udev hook... Mar 19 11:41:01.690363 kernel: device-mapper: core: CONFIG_IMA_DISABLE_HTABLE is disabled. Duplicate IMA measurements will not be recorded in the IMA log. Mar 19 11:41:01.690459 kernel: device-mapper: uevent: version 1.0.3 Mar 19 11:41:01.694847 kernel: device-mapper: ioctl: 4.48.0-ioctl (2023-03-01) initialised: dm-devel@redhat.com Mar 19 11:41:01.737405 kernel: raid6: avx2x4 gen() 30802 MB/s Mar 19 11:41:01.756386 kernel: raid6: avx2x2 gen() 30741 MB/s Mar 19 11:41:01.777628 kernel: raid6: avx2x1 gen() 27602 MB/s Mar 19 11:41:01.777684 kernel: raid6: using algorithm avx2x4 gen() 30802 MB/s Mar 19 11:41:01.800713 kernel: raid6: .... xor() 10275 MB/s, rmw enabled Mar 19 11:41:01.800779 kernel: raid6: using avx2x2 recovery algorithm Mar 19 11:41:01.823399 kernel: xor: automatically using best checksumming function avx Mar 19 11:41:01.979400 kernel: Btrfs loaded, zoned=no, fsverity=no Mar 19 11:41:01.991123 systemd[1]: Finished dracut-pre-udev.service - dracut pre-udev hook. Mar 19 11:41:02.005662 systemd[1]: Starting systemd-udevd.service - Rule-based Manager for Device Events and Files... Mar 19 11:41:02.028338 systemd-udevd[427]: Using default interface naming scheme 'v255'. Mar 19 11:41:02.033966 systemd[1]: Started systemd-udevd.service - Rule-based Manager for Device Events and Files. Mar 19 11:41:02.048538 systemd[1]: Starting dracut-pre-trigger.service - dracut pre-trigger hook... Mar 19 11:41:02.064821 dracut-pre-trigger[431]: rd.md=0: removing MD RAID activation Mar 19 11:41:02.095217 systemd[1]: Finished dracut-pre-trigger.service - dracut pre-trigger hook. Mar 19 11:41:02.113704 systemd[1]: Starting systemd-udev-trigger.service - Coldplug All udev Devices... Mar 19 11:41:02.173285 systemd[1]: Finished systemd-udev-trigger.service - Coldplug All udev Devices. Mar 19 11:41:02.194562 systemd[1]: Starting dracut-initqueue.service - dracut initqueue hook... Mar 19 11:41:02.205090 kernel: cryptd: max_cpu_qlen set to 1000 Mar 19 11:41:02.207619 systemd[1]: Finished dracut-initqueue.service - dracut initqueue hook. Mar 19 11:41:02.230208 kernel: AVX2 version of gcm_enc/dec engaged. Mar 19 11:41:02.230234 kernel: AES CTR mode by8 optimization enabled Mar 19 11:41:02.213168 systemd[1]: Reached target remote-fs-pre.target - Preparation for Remote File Systems. Mar 19 11:41:02.253684 kernel: hv_vmbus: Vmbus version:4.0 Mar 19 11:41:02.253718 kernel: hv_vmbus: registering driver hyperv_keyboard Mar 19 11:41:02.253732 kernel: input: AT Translated Set 2 keyboard as /devices/LNXSYSTM:00/LNXSYBUS:00/ACPI0004:00/VMBUS:00/d34b2567-b9b6-42b9-8778-0a4ec0b955bf/serio0/input/input0 Mar 19 11:41:02.218422 systemd[1]: Reached target remote-cryptsetup.target - Remote Encrypted Volumes. Mar 19 11:41:02.223732 systemd[1]: Reached target remote-fs.target - Remote File Systems. Mar 19 11:41:02.264457 kernel: hid: raw HID events driver (C) Jiri Kosina Mar 19 11:41:02.264495 kernel: pps_core: LinuxPPS API ver. 1 registered Mar 19 11:41:02.264509 kernel: hv_vmbus: registering driver hv_pci Mar 19 11:41:02.266391 kernel: hv_pci 47505500-0001-0000-3130-444531444234: PCI VMBus probing: Using version 0x10004 Mar 19 11:41:02.373856 kernel: pps_core: Software ver. 5.3.6 - Copyright 2005-2007 Rodolfo Giometti Mar 19 11:41:02.373889 kernel: hv_pci 47505500-0001-0000-3130-444531444234: PCI host bridge to bus 0001:00 Mar 19 11:41:02.374054 kernel: pci_bus 0001:00: root bus resource [mem 0x41000000-0x41ffffff window] Mar 19 11:41:02.374206 kernel: pci_bus 0001:00: root bus resource [mem 0x1000000000-0x1401ffffff window] Mar 19 11:41:02.374338 kernel: pci_bus 0001:00: No busn resource found for root bus, will use [bus 00-ff] Mar 19 11:41:02.374487 kernel: pci 0001:00:00.0: [10de:1db4] type 00 class 0x030200 Mar 19 11:41:02.374662 kernel: pci 0001:00:00.0: reg 0x10: [mem 0x41000000-0x41ffffff] Mar 19 11:41:02.388579 kernel: pci 0001:00:00.0: reg 0x14: [mem 0x1000000000-0x13ffffffff 64bit pref] Mar 19 11:41:02.389840 kernel: hv_vmbus: registering driver hv_netvsc Mar 19 11:41:02.389873 kernel: pci 0001:00:00.0: reg 0x1c: [mem 0x1400000000-0x1401ffffff 64bit pref] Mar 19 11:41:02.390058 kernel: pci 0001:00:00.0: Enabling HDA controller Mar 19 11:41:02.390215 kernel: PTP clock support registered Mar 19 11:41:02.390229 kernel: hv_vmbus: registering driver hid_hyperv Mar 19 11:41:02.390242 kernel: input: Microsoft Vmbus HID-compliant Mouse as /devices/0006:045E:0621.0001/input/input1 Mar 19 11:41:02.390262 kernel: hid-hyperv 0006:045E:0621.0001: input: VIRTUAL HID v0.01 Mouse [Microsoft Vmbus HID-compliant Mouse] on Mar 19 11:41:02.390412 kernel: pci_bus 0001:00: busn_res: [bus 00-ff] end is updated to 00 Mar 19 11:41:02.390554 kernel: pci 0001:00:00.0: BAR 1: assigned [mem 0x1000000000-0x13ffffffff 64bit pref] Mar 19 11:41:02.390706 kernel: pci 0001:00:00.0: BAR 3: assigned [mem 0x1400000000-0x1401ffffff 64bit pref] Mar 19 11:41:02.390862 kernel: pci 0001:00:00.0: BAR 0: assigned [mem 0x41000000-0x41ffffff] Mar 19 11:41:02.391015 kernel: hv_vmbus: registering driver hv_storvsc Mar 19 11:41:02.391029 kernel: hv_utils: Registering HyperV Utility Driver Mar 19 11:41:02.268034 systemd[1]: Starting dracut-pre-mount.service - dracut pre-mount hook... Mar 19 11:41:02.436302 kernel: scsi host1: storvsc_host_t Mar 19 11:41:02.436516 kernel: hv_vmbus: registering driver hv_utils Mar 19 11:41:02.436532 kernel: scsi host0: storvsc_host_t Mar 19 11:41:02.436685 kernel: hv_utils: Heartbeat IC version 3.0 Mar 19 11:41:02.436699 kernel: hv_utils: Shutdown IC version 3.2 Mar 19 11:41:02.436711 kernel: hv_utils: TimeSync IC version 4.0 Mar 19 11:41:02.436723 kernel: scsi 0:0:0:0: Direct-Access Msft Virtual Disk 1.0 PQ: 0 ANSI: 5 Mar 19 11:41:02.286342 systemd[1]: Finished dracut-pre-mount.service - dracut pre-mount hook. Mar 19 11:41:02.452466 kernel: scsi 0:0:0:1: Direct-Access Msft Virtual Disk 1.0 PQ: 0 ANSI: 5 Mar 19 11:41:02.452513 kernel: scsi 0:0:0:2: CD-ROM Msft Virtual DVD-ROM 1.0 PQ: 0 ANSI: 0 Mar 19 11:41:02.319163 systemd[1]: dracut-cmdline-ask.service: Deactivated successfully. Mar 19 11:41:02.319233 systemd[1]: Stopped dracut-cmdline-ask.service - dracut ask for additional cmdline parameters. Mar 19 11:41:02.340818 systemd[1]: Stopping dracut-cmdline-ask.service - dracut ask for additional cmdline parameters... Mar 19 11:41:02.361937 systemd[1]: systemd-vconsole-setup.service: Deactivated successfully. Mar 19 11:41:02.362039 systemd[1]: Stopped systemd-vconsole-setup.service - Virtual Console Setup. Mar 19 11:41:02.375257 systemd[1]: Stopping systemd-vconsole-setup.service - Virtual Console Setup... Mar 19 11:41:02.428088 systemd-resolved[259]: Clock change detected. Flushing caches. Mar 19 11:41:02.436447 systemd[1]: Starting systemd-vconsole-setup.service - Virtual Console Setup... Mar 19 11:41:02.438173 systemd[1]: run-credentials-systemd\x2dvconsole\x2dsetup.service.mount: Deactivated successfully. Mar 19 11:41:02.498560 systemd[1]: Finished systemd-vconsole-setup.service - Virtual Console Setup. Mar 19 11:41:02.514373 kernel: sr 0:0:0:2: [sr0] scsi-1 drive Mar 19 11:41:02.515688 kernel: cdrom: Uniform CD-ROM driver Revision: 3.20 Mar 19 11:41:02.515715 kernel: sr 0:0:0:2: Attached scsi CD-ROM sr0 Mar 19 11:41:02.515960 systemd[1]: Starting dracut-cmdline-ask.service - dracut ask for additional cmdline parameters... Mar 19 11:41:02.540630 kernel: sd 0:0:0:0: [sda] 63737856 512-byte logical blocks: (32.6 GB/30.4 GiB) Mar 19 11:41:02.572098 kernel: sd 0:0:0:1: [sdb] 1543503872 512-byte logical blocks: (790 GB/736 GiB) Mar 19 11:41:02.575467 kernel: sd 0:0:0:0: [sda] 4096-byte physical blocks Mar 19 11:41:02.575653 kernel: sd 0:0:0:1: [sdb] 4096-byte physical blocks Mar 19 11:41:02.575887 kernel: sd 0:0:0:0: [sda] Write Protect is off Mar 19 11:41:02.576050 kernel: sd 0:0:0:1: [sdb] Write Protect is off Mar 19 11:41:02.576237 kernel: sd 0:0:0:0: [sda] Mode Sense: 0f 00 10 00 Mar 19 11:41:02.576823 kernel: sd 0:0:0:0: [sda] Write cache: disabled, read cache: enabled, supports DPO and FUA Mar 19 11:41:02.577018 kernel: sd 0:0:0:1: [sdb] Mode Sense: 0f 00 10 00 Mar 19 11:41:02.577167 kernel: sd 0:0:0:1: [sdb] Write cache: disabled, read cache: enabled, supports DPO and FUA Mar 19 11:41:02.577321 kernel: sda: sda1 sda2 sda3 sda4 sda6 sda7 sda9 Mar 19 11:41:02.577343 kernel: sdb: sdb1 Mar 19 11:41:02.577355 kernel: sd 0:0:0:0: [sda] Attached SCSI disk Mar 19 11:41:02.577501 kernel: sd 0:0:0:1: [sdb] Attached SCSI disk Mar 19 11:41:02.546314 systemd[1]: Finished dracut-cmdline-ask.service - dracut ask for additional cmdline parameters. Mar 19 11:41:03.307641 systemd[1]: Found device dev-disk-by\x2dlabel-EFI\x2dSYSTEM.device - Virtual_Disk EFI-SYSTEM. Mar 19 11:41:03.327755 kernel: BTRFS: device label OEM devid 1 transid 15 /dev/sda6 scanned by (udev-worker) (478) Mar 19 11:41:03.349664 systemd[1]: Found device dev-disk-by\x2dlabel-OEM.device - Virtual_Disk OEM. Mar 19 11:41:03.422532 systemd[1]: Found device dev-disk-by\x2dlabel-ROOT.device - Virtual_Disk ROOT. Mar 19 11:41:03.433962 kernel: BTRFS: device fsid 8d57424d-5abc-4888-810f-658d040a58e4 devid 1 transid 36 /dev/sda3 scanned by (udev-worker) (480) Mar 19 11:41:03.455058 systemd[1]: Found device dev-disk-by\x2dpartuuid-7130c94a\x2d213a\x2d4e5a\x2d8e26\x2d6cce9662f132.device - Virtual_Disk USR-A. Mar 19 11:41:03.456698 systemd[1]: Found device dev-disk-by\x2dpartlabel-USR\x2dA.device - Virtual_Disk USR-A. Mar 19 11:41:03.486915 systemd[1]: Starting disk-uuid.service - Generate new UUID for disk GPT if necessary... Mar 19 11:41:03.508759 kernel: sda: sda1 sda2 sda3 sda4 sda6 sda7 sda9 Mar 19 11:41:03.516754 kernel: sda: sda1 sda2 sda3 sda4 sda6 sda7 sda9 Mar 19 11:41:04.526968 kernel: sda: sda1 sda2 sda3 sda4 sda6 sda7 sda9 Mar 19 11:41:04.527083 disk-uuid[638]: The operation has completed successfully. Mar 19 11:41:05.003839 systemd[1]: disk-uuid.service: Deactivated successfully. Mar 19 11:41:05.003955 systemd[1]: Finished disk-uuid.service - Generate new UUID for disk GPT if necessary. Mar 19 11:41:05.028458 systemd[1]: Starting verity-setup.service - Verity Setup for /dev/mapper/usr... Mar 19 11:41:05.038298 sh[725]: Success Mar 19 11:41:05.089763 kernel: device-mapper: verity: sha256 using implementation "sha256-avx2" Mar 19 11:41:05.306904 systemd[1]: Found device dev-mapper-usr.device - /dev/mapper/usr. Mar 19 11:41:05.328362 systemd[1]: Mounting sysusr-usr.mount - /sysusr/usr... Mar 19 11:41:05.339370 systemd[1]: Finished verity-setup.service - Verity Setup for /dev/mapper/usr. Mar 19 11:41:05.358823 kernel: BTRFS info (device dm-0): first mount of filesystem 8d57424d-5abc-4888-810f-658d040a58e4 Mar 19 11:41:05.358878 kernel: BTRFS info (device dm-0): using crc32c (crc32c-intel) checksum algorithm Mar 19 11:41:05.363728 kernel: BTRFS warning (device dm-0): 'nologreplay' is deprecated, use 'rescue=nologreplay' instead Mar 19 11:41:05.367398 kernel: BTRFS info (device dm-0): disabling log replay at mount time Mar 19 11:41:05.370837 kernel: BTRFS info (device dm-0): using free space tree Mar 19 11:41:06.012480 systemd[1]: Mounted sysusr-usr.mount - /sysusr/usr. Mar 19 11:41:06.019604 systemd[1]: afterburn-network-kargs.service - Afterburn Initrd Setup Network Kernel Arguments was skipped because no trigger condition checks were met. Mar 19 11:41:06.032905 systemd[1]: Starting ignition-setup.service - Ignition (setup)... Mar 19 11:41:06.035546 systemd[1]: Starting parse-ip-for-networkd.service - Write systemd-networkd units from cmdline... Mar 19 11:41:06.068719 kernel: BTRFS info (device sda6): first mount of filesystem 3c2c2d54-a06e-4f36-8d13-ab30a5d0eab5 Mar 19 11:41:06.068793 kernel: BTRFS info (device sda6): using crc32c (crc32c-intel) checksum algorithm Mar 19 11:41:06.071880 kernel: BTRFS info (device sda6): using free space tree Mar 19 11:41:06.093772 kernel: BTRFS info (device sda6): auto enabling async discard Mar 19 11:41:06.103225 systemd[1]: mnt-oem.mount: Deactivated successfully. Mar 19 11:41:06.111585 kernel: BTRFS info (device sda6): last unmount of filesystem 3c2c2d54-a06e-4f36-8d13-ab30a5d0eab5 Mar 19 11:41:06.121841 systemd[1]: Finished ignition-setup.service - Ignition (setup). Mar 19 11:41:06.138909 systemd[1]: Starting ignition-fetch-offline.service - Ignition (fetch-offline)... Mar 19 11:41:06.139986 systemd[1]: Finished parse-ip-for-networkd.service - Write systemd-networkd units from cmdline. Mar 19 11:41:06.158330 systemd[1]: Starting systemd-networkd.service - Network Configuration... Mar 19 11:41:06.190866 systemd-networkd[911]: lo: Link UP Mar 19 11:41:06.190876 systemd-networkd[911]: lo: Gained carrier Mar 19 11:41:06.192053 systemd-networkd[911]: Enumeration completed Mar 19 11:41:06.192144 systemd[1]: Started systemd-networkd.service - Network Configuration. Mar 19 11:41:06.192484 systemd-networkd[911]: eth0: found matching network '/usr/lib/systemd/network/zz-default.network', based on potentially unpredictable interface name. Mar 19 11:41:06.192489 systemd-networkd[911]: eth0: Configuring with /usr/lib/systemd/network/zz-default.network. Mar 19 11:41:06.193314 systemd-networkd[911]: eth0: Link UP Mar 19 11:41:06.193482 systemd-networkd[911]: eth0: Gained carrier Mar 19 11:41:06.193491 systemd-networkd[911]: eth0: found matching network '/usr/lib/systemd/network/zz-default.network', based on potentially unpredictable interface name. Mar 19 11:41:06.198013 systemd[1]: Reached target network.target - Network. Mar 19 11:41:06.259801 systemd-networkd[911]: eth0: DHCPv4 address 10.200.8.11/24, gateway 10.200.8.1 acquired from 168.63.129.16 Mar 19 11:41:07.562886 ignition[905]: Ignition 2.20.0 Mar 19 11:41:07.562899 ignition[905]: Stage: fetch-offline Mar 19 11:41:07.562940 ignition[905]: no configs at "/usr/lib/ignition/base.d" Mar 19 11:41:07.562951 ignition[905]: no config dir at "/usr/lib/ignition/base.platform.d/azure" Mar 19 11:41:07.563060 ignition[905]: parsed url from cmdline: "" Mar 19 11:41:07.563064 ignition[905]: no config URL provided Mar 19 11:41:07.563070 ignition[905]: reading system config file "/usr/lib/ignition/user.ign" Mar 19 11:41:07.563080 ignition[905]: no config at "/usr/lib/ignition/user.ign" Mar 19 11:41:07.563086 ignition[905]: failed to fetch config: resource requires networking Mar 19 11:41:07.563267 ignition[905]: Ignition finished successfully Mar 19 11:41:07.593424 systemd[1]: Finished ignition-fetch-offline.service - Ignition (fetch-offline). Mar 19 11:41:07.610906 systemd[1]: Starting ignition-fetch.service - Ignition (fetch)... Mar 19 11:41:07.623150 ignition[923]: Ignition 2.20.0 Mar 19 11:41:07.623161 ignition[923]: Stage: fetch Mar 19 11:41:07.623327 ignition[923]: no configs at "/usr/lib/ignition/base.d" Mar 19 11:41:07.623338 ignition[923]: no config dir at "/usr/lib/ignition/base.platform.d/azure" Mar 19 11:41:07.623441 ignition[923]: parsed url from cmdline: "" Mar 19 11:41:07.623445 ignition[923]: no config URL provided Mar 19 11:41:07.623452 ignition[923]: reading system config file "/usr/lib/ignition/user.ign" Mar 19 11:41:07.623461 ignition[923]: no config at "/usr/lib/ignition/user.ign" Mar 19 11:41:07.623486 ignition[923]: GET http://169.254.169.254/metadata/instance/compute/userData?api-version=2021-01-01&format=text: attempt #1 Mar 19 11:41:07.701546 ignition[923]: GET result: OK Mar 19 11:41:07.701577 ignition[923]: failed to retrieve userdata from IMDS, falling back to custom data: not a config (empty) Mar 19 11:41:07.744553 ignition[923]: opening config device: "/dev/sr0" Mar 19 11:41:07.745096 ignition[923]: getting drive status for "/dev/sr0" Mar 19 11:41:07.745179 ignition[923]: drive status: OK Mar 19 11:41:07.745226 ignition[923]: mounting config device Mar 19 11:41:07.745236 ignition[923]: op(1): [started] mounting "/dev/sr0" at "/tmp/ignition-azure1100934708" Mar 19 11:41:07.771400 ignition[923]: op(1): [finished] mounting "/dev/sr0" at "/tmp/ignition-azure1100934708" Mar 19 11:41:07.777775 kernel: UDF-fs: INFO Mounting volume 'UDF Volume', timestamp 2025/03/20 00:00 (1000) Mar 19 11:41:07.772928 systemd[1]: tmp-ignition\x2dazure1100934708.mount: Deactivated successfully. Mar 19 11:41:07.771411 ignition[923]: checking for config drive Mar 19 11:41:07.776763 unknown[923]: fetched base config from "system" Mar 19 11:41:07.771783 ignition[923]: reading config Mar 19 11:41:07.776770 unknown[923]: fetched base config from "system" Mar 19 11:41:07.772167 ignition[923]: op(2): [started] unmounting "/dev/sr0" at "/tmp/ignition-azure1100934708" Mar 19 11:41:07.776776 unknown[923]: fetched user config from "azure" Mar 19 11:41:07.772261 ignition[923]: op(2): [finished] unmounting "/dev/sr0" at "/tmp/ignition-azure1100934708" Mar 19 11:41:07.779236 systemd[1]: Finished ignition-fetch.service - Ignition (fetch). Mar 19 11:41:07.772281 ignition[923]: config has been read from custom data Mar 19 11:41:07.805899 systemd[1]: Starting ignition-kargs.service - Ignition (kargs)... Mar 19 11:41:07.772295 ignition[923]: parsing config with SHA512: 4c31a54c69624e8de7c9d5102e6e6ed217a510b9982d71edd446dc0a6b8a0e02183edd624f29e1c9ca969899f22b92e15c740fb605f97c024bdb4f9f8a0a14b4 Mar 19 11:41:07.777183 ignition[923]: fetch: fetch complete Mar 19 11:41:07.777188 ignition[923]: fetch: fetch passed Mar 19 11:41:07.777234 ignition[923]: Ignition finished successfully Mar 19 11:41:07.840331 ignition[934]: Ignition 2.20.0 Mar 19 11:41:07.840343 ignition[934]: Stage: kargs Mar 19 11:41:07.840514 ignition[934]: no configs at "/usr/lib/ignition/base.d" Mar 19 11:41:07.840526 ignition[934]: no config dir at "/usr/lib/ignition/base.platform.d/azure" Mar 19 11:41:07.841133 ignition[934]: kargs: kargs passed Mar 19 11:41:07.841184 ignition[934]: Ignition finished successfully Mar 19 11:41:07.853665 systemd[1]: Finished ignition-kargs.service - Ignition (kargs). Mar 19 11:41:07.874967 systemd[1]: Starting ignition-disks.service - Ignition (disks)... Mar 19 11:41:07.889469 ignition[944]: Ignition 2.20.0 Mar 19 11:41:07.889481 ignition[944]: Stage: disks Mar 19 11:41:07.889646 ignition[944]: no configs at "/usr/lib/ignition/base.d" Mar 19 11:41:07.889659 ignition[944]: no config dir at "/usr/lib/ignition/base.platform.d/azure" Mar 19 11:41:07.895328 systemd[1]: Finished ignition-disks.service - Ignition (disks). Mar 19 11:41:07.890239 ignition[944]: disks: disks passed Mar 19 11:41:07.901487 systemd[1]: Reached target initrd-root-device.target - Initrd Root Device. Mar 19 11:41:07.890288 ignition[944]: Ignition finished successfully Mar 19 11:41:07.909908 systemd[1]: Reached target local-fs-pre.target - Preparation for Local File Systems. Mar 19 11:41:07.911302 systemd[1]: Reached target local-fs.target - Local File Systems. Mar 19 11:41:07.922938 systemd[1]: Reached target sysinit.target - System Initialization. Mar 19 11:41:07.929747 systemd[1]: Reached target basic.target - Basic System. Mar 19 11:41:07.958930 systemd[1]: Starting systemd-fsck-root.service - File System Check on /dev/disk/by-label/ROOT... Mar 19 11:41:08.031677 systemd-fsck[955]: ROOT: clean, 14/7326000 files, 477710/7359488 blocks Mar 19 11:41:08.038878 systemd[1]: Finished systemd-fsck-root.service - File System Check on /dev/disk/by-label/ROOT. Mar 19 11:41:08.052828 systemd-networkd[911]: eth0: Gained IPv6LL Mar 19 11:41:08.073863 systemd[1]: Mounting sysroot.mount - /sysroot... Mar 19 11:41:08.172899 kernel: EXT4-fs (sda9): mounted filesystem 303a73dd-e104-408b-9302-bf91b04ba1ca r/w with ordered data mode. Quota mode: none. Mar 19 11:41:08.173488 systemd[1]: Mounted sysroot.mount - /sysroot. Mar 19 11:41:08.175522 systemd[1]: Reached target initrd-root-fs.target - Initrd Root File System. Mar 19 11:41:08.215816 systemd[1]: Mounting sysroot-oem.mount - /sysroot/oem... Mar 19 11:41:08.217618 systemd[1]: Mounting sysroot-usr.mount - /sysroot/usr... Mar 19 11:41:08.233459 kernel: BTRFS: device label OEM devid 1 transid 16 /dev/sda6 scanned by mount (966) Mar 19 11:41:08.228687 systemd[1]: Starting flatcar-metadata-hostname.service - Flatcar Metadata Hostname Agent... Mar 19 11:41:08.265422 kernel: BTRFS info (device sda6): first mount of filesystem 3c2c2d54-a06e-4f36-8d13-ab30a5d0eab5 Mar 19 11:41:08.265451 kernel: BTRFS info (device sda6): using crc32c (crc32c-intel) checksum algorithm Mar 19 11:41:08.265464 kernel: BTRFS info (device sda6): using free space tree Mar 19 11:41:08.265477 kernel: BTRFS info (device sda6): auto enabling async discard Mar 19 11:41:08.252259 systemd[1]: ignition-remount-sysroot.service - Remount /sysroot read-write for Ignition was skipped because of an unmet condition check (ConditionPathIsReadWrite=!/sysroot). Mar 19 11:41:08.252309 systemd[1]: Reached target ignition-diskful.target - Ignition Boot Disk Setup. Mar 19 11:41:08.255810 systemd[1]: Mounted sysroot-usr.mount - /sysroot/usr. Mar 19 11:41:08.274549 systemd[1]: Starting initrd-setup-root.service - Root filesystem setup... Mar 19 11:41:08.279852 systemd[1]: Mounted sysroot-oem.mount - /sysroot/oem. Mar 19 11:41:09.131657 coreos-metadata[968]: Mar 19 11:41:09.131 INFO Fetching http://168.63.129.16/?comp=versions: Attempt #1 Mar 19 11:41:09.139551 coreos-metadata[968]: Mar 19 11:41:09.139 INFO Fetch successful Mar 19 11:41:09.143403 coreos-metadata[968]: Mar 19 11:41:09.143 INFO Fetching http://169.254.169.254/metadata/instance/compute/name?api-version=2017-08-01&format=text: Attempt #1 Mar 19 11:41:09.151350 coreos-metadata[968]: Mar 19 11:41:09.151 INFO Fetch successful Mar 19 11:41:09.158885 coreos-metadata[968]: Mar 19 11:41:09.158 INFO wrote hostname ci-4230.1.0-a-0674828377 to /sysroot/etc/hostname Mar 19 11:41:09.166016 systemd[1]: Finished flatcar-metadata-hostname.service - Flatcar Metadata Hostname Agent. Mar 19 11:41:09.392721 initrd-setup-root[997]: cut: /sysroot/etc/passwd: No such file or directory Mar 19 11:41:09.493129 initrd-setup-root[1004]: cut: /sysroot/etc/group: No such file or directory Mar 19 11:41:09.523468 initrd-setup-root[1011]: cut: /sysroot/etc/shadow: No such file or directory Mar 19 11:41:09.530014 initrd-setup-root[1018]: cut: /sysroot/etc/gshadow: No such file or directory Mar 19 11:41:10.478125 systemd[1]: Finished initrd-setup-root.service - Root filesystem setup. Mar 19 11:41:10.498893 systemd[1]: Starting ignition-mount.service - Ignition (mount)... Mar 19 11:41:10.503392 systemd[1]: Starting sysroot-boot.service - /sysroot/boot... Mar 19 11:41:10.516212 systemd[1]: sysroot-oem.mount: Deactivated successfully. Mar 19 11:41:10.524701 kernel: BTRFS info (device sda6): last unmount of filesystem 3c2c2d54-a06e-4f36-8d13-ab30a5d0eab5 Mar 19 11:41:10.547806 systemd[1]: Finished sysroot-boot.service - /sysroot/boot. Mar 19 11:41:10.558414 ignition[1088]: INFO : Ignition 2.20.0 Mar 19 11:41:10.558414 ignition[1088]: INFO : Stage: mount Mar 19 11:41:10.564843 ignition[1088]: INFO : no configs at "/usr/lib/ignition/base.d" Mar 19 11:41:10.564843 ignition[1088]: INFO : no config dir at "/usr/lib/ignition/base.platform.d/azure" Mar 19 11:41:10.564843 ignition[1088]: INFO : mount: mount passed Mar 19 11:41:10.564843 ignition[1088]: INFO : Ignition finished successfully Mar 19 11:41:10.565956 systemd[1]: Finished ignition-mount.service - Ignition (mount). Mar 19 11:41:10.592955 systemd[1]: Starting ignition-files.service - Ignition (files)... Mar 19 11:41:10.600361 systemd[1]: Mounting sysroot-oem.mount - /sysroot/oem... Mar 19 11:41:10.620753 kernel: BTRFS: device label OEM devid 1 transid 17 /dev/sda6 scanned by mount (1101) Mar 19 11:41:10.620802 kernel: BTRFS info (device sda6): first mount of filesystem 3c2c2d54-a06e-4f36-8d13-ab30a5d0eab5 Mar 19 11:41:10.629575 kernel: BTRFS info (device sda6): using crc32c (crc32c-intel) checksum algorithm Mar 19 11:41:10.632656 kernel: BTRFS info (device sda6): using free space tree Mar 19 11:41:10.638752 kernel: BTRFS info (device sda6): auto enabling async discard Mar 19 11:41:10.640173 systemd[1]: Mounted sysroot-oem.mount - /sysroot/oem. Mar 19 11:41:10.675387 ignition[1118]: INFO : Ignition 2.20.0 Mar 19 11:41:10.675387 ignition[1118]: INFO : Stage: files Mar 19 11:41:10.681304 ignition[1118]: INFO : no configs at "/usr/lib/ignition/base.d" Mar 19 11:41:10.681304 ignition[1118]: INFO : no config dir at "/usr/lib/ignition/base.platform.d/azure" Mar 19 11:41:10.681304 ignition[1118]: DEBUG : files: compiled without relabeling support, skipping Mar 19 11:41:10.709199 ignition[1118]: INFO : files: ensureUsers: op(1): [started] creating or modifying user "core" Mar 19 11:41:10.709199 ignition[1118]: DEBUG : files: ensureUsers: op(1): executing: "usermod" "--root" "/sysroot" "core" Mar 19 11:41:10.848499 ignition[1118]: INFO : files: ensureUsers: op(1): [finished] creating or modifying user "core" Mar 19 11:41:10.854038 ignition[1118]: INFO : files: ensureUsers: op(2): [started] adding ssh keys to user "core" Mar 19 11:41:10.854038 ignition[1118]: INFO : files: ensureUsers: op(2): [finished] adding ssh keys to user "core" Mar 19 11:41:10.854038 ignition[1118]: INFO : files: createFilesystemsFiles: createFiles: op(3): [started] writing file "/sysroot/etc/flatcar/update.conf" Mar 19 11:41:10.854038 ignition[1118]: INFO : files: createFilesystemsFiles: createFiles: op(3): [finished] writing file "/sysroot/etc/flatcar/update.conf" Mar 19 11:41:10.854038 ignition[1118]: INFO : files: createResultFile: createFiles: op(4): [started] writing file "/sysroot/etc/.ignition-result.json" Mar 19 11:41:10.854038 ignition[1118]: INFO : files: createResultFile: createFiles: op(4): [finished] writing file "/sysroot/etc/.ignition-result.json" Mar 19 11:41:10.854038 ignition[1118]: INFO : files: files passed Mar 19 11:41:10.854038 ignition[1118]: INFO : Ignition finished successfully Mar 19 11:41:10.849184 unknown[1118]: wrote ssh authorized keys file for user: core Mar 19 11:41:10.860557 systemd[1]: Finished ignition-files.service - Ignition (files). Mar 19 11:41:10.886972 systemd[1]: Starting ignition-quench.service - Ignition (record completion)... Mar 19 11:41:10.895076 systemd[1]: Starting initrd-setup-root-after-ignition.service - Root filesystem completion... Mar 19 11:41:10.938477 initrd-setup-root-after-ignition[1149]: grep: /sysroot/etc/flatcar/enabled-sysext.conf: No such file or directory Mar 19 11:41:10.938477 initrd-setup-root-after-ignition[1149]: grep: /sysroot/usr/share/flatcar/enabled-sysext.conf: No such file or directory Mar 19 11:41:10.904104 systemd[1]: ignition-quench.service: Deactivated successfully. Mar 19 11:41:10.964126 initrd-setup-root-after-ignition[1153]: grep: /sysroot/etc/flatcar/enabled-sysext.conf: No such file or directory Mar 19 11:41:10.904215 systemd[1]: Finished ignition-quench.service - Ignition (record completion). Mar 19 11:41:10.935603 systemd[1]: Finished initrd-setup-root-after-ignition.service - Root filesystem completion. Mar 19 11:41:10.940216 systemd[1]: Reached target ignition-complete.target - Ignition Complete. Mar 19 11:41:10.974935 systemd[1]: Starting initrd-parse-etc.service - Mountpoints Configured in the Real Root... Mar 19 11:41:11.003891 systemd[1]: initrd-parse-etc.service: Deactivated successfully. Mar 19 11:41:11.004012 systemd[1]: Finished initrd-parse-etc.service - Mountpoints Configured in the Real Root. Mar 19 11:41:11.013097 systemd[1]: Reached target initrd-fs.target - Initrd File Systems. Mar 19 11:41:11.022116 systemd[1]: Reached target initrd.target - Initrd Default Target. Mar 19 11:41:11.030188 systemd[1]: dracut-mount.service - dracut mount hook was skipped because no trigger condition checks were met. Mar 19 11:41:11.045918 systemd[1]: Starting dracut-pre-pivot.service - dracut pre-pivot and cleanup hook... Mar 19 11:41:11.060559 systemd[1]: Finished dracut-pre-pivot.service - dracut pre-pivot and cleanup hook. Mar 19 11:41:11.072385 systemd[1]: Starting initrd-cleanup.service - Cleaning Up and Shutting Down Daemons... Mar 19 11:41:11.091838 systemd[1]: Stopped target nss-lookup.target - Host and Network Name Lookups. Mar 19 11:41:11.101053 systemd[1]: Stopped target remote-cryptsetup.target - Remote Encrypted Volumes. Mar 19 11:41:11.102684 systemd[1]: Stopped target timers.target - Timer Units. Mar 19 11:41:11.112042 systemd[1]: dracut-pre-pivot.service: Deactivated successfully. Mar 19 11:41:11.112203 systemd[1]: Stopped dracut-pre-pivot.service - dracut pre-pivot and cleanup hook. Mar 19 11:41:11.126353 systemd[1]: Stopped target initrd.target - Initrd Default Target. Mar 19 11:41:11.135111 systemd[1]: Stopped target basic.target - Basic System. Mar 19 11:41:11.142589 systemd[1]: Stopped target ignition-complete.target - Ignition Complete. Mar 19 11:41:11.150279 systemd[1]: Stopped target ignition-diskful.target - Ignition Boot Disk Setup. Mar 19 11:41:11.158954 systemd[1]: Stopped target initrd-root-device.target - Initrd Root Device. Mar 19 11:41:11.167954 systemd[1]: Stopped target remote-fs.target - Remote File Systems. Mar 19 11:41:11.176526 systemd[1]: Stopped target remote-fs-pre.target - Preparation for Remote File Systems. Mar 19 11:41:11.185305 systemd[1]: Stopped target sysinit.target - System Initialization. Mar 19 11:41:11.194316 systemd[1]: Stopped target local-fs.target - Local File Systems. Mar 19 11:41:11.202120 systemd[1]: Stopped target swap.target - Swaps. Mar 19 11:41:11.209185 systemd[1]: dracut-pre-mount.service: Deactivated successfully. Mar 19 11:41:11.209355 systemd[1]: Stopped dracut-pre-mount.service - dracut pre-mount hook. Mar 19 11:41:11.220122 systemd[1]: Stopped target cryptsetup.target - Local Encrypted Volumes. Mar 19 11:41:11.228467 systemd[1]: Stopped target cryptsetup-pre.target - Local Encrypted Volumes (Pre). Mar 19 11:41:11.237340 systemd[1]: clevis-luks-askpass.path: Deactivated successfully. Mar 19 11:41:11.241978 systemd[1]: Stopped clevis-luks-askpass.path - Forward Password Requests to Clevis Directory Watch. Mar 19 11:41:11.250681 systemd[1]: dracut-initqueue.service: Deactivated successfully. Mar 19 11:41:11.250860 systemd[1]: Stopped dracut-initqueue.service - dracut initqueue hook. Mar 19 11:41:11.264114 systemd[1]: initrd-setup-root-after-ignition.service: Deactivated successfully. Mar 19 11:41:11.264263 systemd[1]: Stopped initrd-setup-root-after-ignition.service - Root filesystem completion. Mar 19 11:41:11.273185 systemd[1]: ignition-files.service: Deactivated successfully. Mar 19 11:41:11.273315 systemd[1]: Stopped ignition-files.service - Ignition (files). Mar 19 11:41:11.281501 systemd[1]: flatcar-metadata-hostname.service: Deactivated successfully. Mar 19 11:41:11.281626 systemd[1]: Stopped flatcar-metadata-hostname.service - Flatcar Metadata Hostname Agent. Mar 19 11:41:11.311971 systemd[1]: Stopping ignition-mount.service - Ignition (mount)... Mar 19 11:41:11.313451 systemd[1]: kmod-static-nodes.service: Deactivated successfully. Mar 19 11:41:11.313596 systemd[1]: Stopped kmod-static-nodes.service - Create List of Static Device Nodes. Mar 19 11:41:11.321954 systemd[1]: Stopping sysroot-boot.service - /sysroot/boot... Mar 19 11:41:11.344720 ignition[1174]: INFO : Ignition 2.20.0 Mar 19 11:41:11.344720 ignition[1174]: INFO : Stage: umount Mar 19 11:41:11.344720 ignition[1174]: INFO : no configs at "/usr/lib/ignition/base.d" Mar 19 11:41:11.344720 ignition[1174]: INFO : no config dir at "/usr/lib/ignition/base.platform.d/azure" Mar 19 11:41:11.329956 systemd[1]: systemd-udev-trigger.service: Deactivated successfully. Mar 19 11:41:11.374657 ignition[1174]: INFO : umount: umount passed Mar 19 11:41:11.374657 ignition[1174]: INFO : Ignition finished successfully Mar 19 11:41:11.330106 systemd[1]: Stopped systemd-udev-trigger.service - Coldplug All udev Devices. Mar 19 11:41:11.338134 systemd[1]: dracut-pre-trigger.service: Deactivated successfully. Mar 19 11:41:11.338271 systemd[1]: Stopped dracut-pre-trigger.service - dracut pre-trigger hook. Mar 19 11:41:11.354089 systemd[1]: ignition-mount.service: Deactivated successfully. Mar 19 11:41:11.354197 systemd[1]: Stopped ignition-mount.service - Ignition (mount). Mar 19 11:41:11.358302 systemd[1]: initrd-cleanup.service: Deactivated successfully. Mar 19 11:41:11.358404 systemd[1]: Finished initrd-cleanup.service - Cleaning Up and Shutting Down Daemons. Mar 19 11:41:11.364192 systemd[1]: ignition-disks.service: Deactivated successfully. Mar 19 11:41:11.364263 systemd[1]: Stopped ignition-disks.service - Ignition (disks). Mar 19 11:41:11.374089 systemd[1]: ignition-kargs.service: Deactivated successfully. Mar 19 11:41:11.374148 systemd[1]: Stopped ignition-kargs.service - Ignition (kargs). Mar 19 11:41:11.384116 systemd[1]: ignition-fetch.service: Deactivated successfully. Mar 19 11:41:11.384177 systemd[1]: Stopped ignition-fetch.service - Ignition (fetch). Mar 19 11:41:11.391118 systemd[1]: Stopped target network.target - Network. Mar 19 11:41:11.398057 systemd[1]: ignition-fetch-offline.service: Deactivated successfully. Mar 19 11:41:11.398134 systemd[1]: Stopped ignition-fetch-offline.service - Ignition (fetch-offline). Mar 19 11:41:11.406854 systemd[1]: Stopped target paths.target - Path Units. Mar 19 11:41:11.414150 systemd[1]: systemd-ask-password-console.path: Deactivated successfully. Mar 19 11:41:11.414274 systemd[1]: Stopped systemd-ask-password-console.path - Dispatch Password Requests to Console Directory Watch. Mar 19 11:41:11.423210 systemd[1]: Stopped target slices.target - Slice Units. Mar 19 11:41:11.430439 systemd[1]: Stopped target sockets.target - Socket Units. Mar 19 11:41:11.437695 systemd[1]: iscsid.socket: Deactivated successfully. Mar 19 11:41:11.437772 systemd[1]: Closed iscsid.socket - Open-iSCSI iscsid Socket. Mar 19 11:41:11.445187 systemd[1]: iscsiuio.socket: Deactivated successfully. Mar 19 11:41:11.445237 systemd[1]: Closed iscsiuio.socket - Open-iSCSI iscsiuio Socket. Mar 19 11:41:11.453822 systemd[1]: ignition-setup.service: Deactivated successfully. Mar 19 11:41:11.453894 systemd[1]: Stopped ignition-setup.service - Ignition (setup). Mar 19 11:41:11.461380 systemd[1]: ignition-setup-pre.service: Deactivated successfully. Mar 19 11:41:11.461440 systemd[1]: Stopped ignition-setup-pre.service - Ignition env setup. Mar 19 11:41:11.469262 systemd[1]: Stopping systemd-networkd.service - Network Configuration... Mar 19 11:41:11.476784 systemd[1]: Stopping systemd-resolved.service - Network Name Resolution... Mar 19 11:41:11.486508 systemd[1]: sysroot-boot.mount: Deactivated successfully. Mar 19 11:41:11.487242 systemd[1]: sysroot-boot.service: Deactivated successfully. Mar 19 11:41:11.487350 systemd[1]: Stopped sysroot-boot.service - /sysroot/boot. Mar 19 11:41:11.490442 systemd[1]: systemd-resolved.service: Deactivated successfully. Mar 19 11:41:11.490546 systemd[1]: Stopped systemd-resolved.service - Network Name Resolution. Mar 19 11:41:11.507838 systemd[1]: run-credentials-systemd\x2dresolved.service.mount: Deactivated successfully. Mar 19 11:41:11.508099 systemd[1]: systemd-networkd.service: Deactivated successfully. Mar 19 11:41:11.508205 systemd[1]: Stopped systemd-networkd.service - Network Configuration. Mar 19 11:41:11.520926 systemd[1]: run-credentials-systemd\x2dnetworkd.service.mount: Deactivated successfully. Mar 19 11:41:11.523923 systemd[1]: systemd-networkd.socket: Deactivated successfully. Mar 19 11:41:11.524010 systemd[1]: Closed systemd-networkd.socket - Network Service Netlink Socket. Mar 19 11:41:11.526067 systemd[1]: initrd-setup-root.service: Deactivated successfully. Mar 19 11:41:11.526128 systemd[1]: Stopped initrd-setup-root.service - Root filesystem setup. Mar 19 11:41:11.558911 systemd[1]: Stopping network-cleanup.service - Network Cleanup... Mar 19 11:41:11.561633 systemd[1]: parse-ip-for-networkd.service: Deactivated successfully. Mar 19 11:41:11.561708 systemd[1]: Stopped parse-ip-for-networkd.service - Write systemd-networkd units from cmdline. Mar 19 11:41:11.569036 systemd[1]: systemd-sysctl.service: Deactivated successfully. Mar 19 11:41:11.569190 systemd[1]: Stopped systemd-sysctl.service - Apply Kernel Variables. Mar 19 11:41:11.584811 systemd[1]: systemd-modules-load.service: Deactivated successfully. Mar 19 11:41:11.584882 systemd[1]: Stopped systemd-modules-load.service - Load Kernel Modules. Mar 19 11:41:11.587086 systemd[1]: systemd-tmpfiles-setup.service: Deactivated successfully. Mar 19 11:41:11.587215 systemd[1]: Stopped systemd-tmpfiles-setup.service - Create System Files and Directories. Mar 19 11:41:11.605880 systemd[1]: Stopping systemd-udevd.service - Rule-based Manager for Device Events and Files... Mar 19 11:41:11.616442 systemd[1]: run-credentials-systemd\x2dsysctl.service.mount: Deactivated successfully. Mar 19 11:41:11.616523 systemd[1]: run-credentials-systemd\x2dtmpfiles\x2dsetup.service.mount: Deactivated successfully. Mar 19 11:41:11.639584 systemd[1]: systemd-udevd.service: Deactivated successfully. Mar 19 11:41:11.639816 systemd[1]: Stopped systemd-udevd.service - Rule-based Manager for Device Events and Files. Mar 19 11:41:11.647872 systemd[1]: network-cleanup.service: Deactivated successfully. Mar 19 11:41:11.647989 systemd[1]: Stopped network-cleanup.service - Network Cleanup. Mar 19 11:41:11.655949 systemd[1]: systemd-udevd-control.socket: Deactivated successfully. Mar 19 11:41:11.656006 systemd[1]: Closed systemd-udevd-control.socket - udev Control Socket. Mar 19 11:41:11.661820 systemd[1]: systemd-udevd-kernel.socket: Deactivated successfully. Mar 19 11:41:11.661862 systemd[1]: Closed systemd-udevd-kernel.socket - udev Kernel Socket. Mar 19 11:41:11.672495 systemd[1]: dracut-pre-udev.service: Deactivated successfully. Mar 19 11:41:11.672561 systemd[1]: Stopped dracut-pre-udev.service - dracut pre-udev hook. Mar 19 11:41:11.683221 systemd[1]: dracut-cmdline.service: Deactivated successfully. Mar 19 11:41:11.683285 systemd[1]: Stopped dracut-cmdline.service - dracut cmdline hook. Mar 19 11:41:11.700629 systemd[1]: dracut-cmdline-ask.service: Deactivated successfully. Mar 19 11:41:11.700707 systemd[1]: Stopped dracut-cmdline-ask.service - dracut ask for additional cmdline parameters. Mar 19 11:41:11.739936 systemd[1]: Starting initrd-udevadm-cleanup-db.service - Cleanup udev Database... Mar 19 11:41:11.741643 systemd[1]: systemd-tmpfiles-setup-dev.service: Deactivated successfully. Mar 19 11:41:11.741712 systemd[1]: Stopped systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev. Mar 19 11:41:11.759539 systemd[1]: systemd-vconsole-setup.service: Deactivated successfully. Mar 19 11:41:11.759611 systemd[1]: Stopped systemd-vconsole-setup.service - Virtual Console Setup. Mar 19 11:41:11.773895 systemd[1]: run-credentials-systemd\x2dtmpfiles\x2dsetup\x2ddev.service.mount: Deactivated successfully. Mar 19 11:41:11.773970 systemd[1]: run-credentials-systemd\x2dvconsole\x2dsetup.service.mount: Deactivated successfully. Mar 19 11:41:11.774380 systemd[1]: initrd-udevadm-cleanup-db.service: Deactivated successfully. Mar 19 11:41:11.774479 systemd[1]: Finished initrd-udevadm-cleanup-db.service - Cleanup udev Database. Mar 19 11:41:11.778669 systemd[1]: Reached target initrd-switch-root.target - Switch Root. Mar 19 11:41:11.805918 systemd[1]: Starting initrd-switch-root.service - Switch Root... Mar 19 11:41:11.813308 systemd[1]: Switching root. Mar 19 11:41:11.921225 systemd-journald[205]: Journal stopped Mar 19 11:41:18.428361 systemd-journald[205]: Received SIGTERM from PID 1 (systemd). Mar 19 11:41:18.428396 kernel: SELinux: policy capability network_peer_controls=1 Mar 19 11:41:18.428409 kernel: SELinux: policy capability open_perms=1 Mar 19 11:41:18.428418 kernel: SELinux: policy capability extended_socket_class=1 Mar 19 11:41:18.428427 kernel: SELinux: policy capability always_check_network=0 Mar 19 11:41:18.428436 kernel: SELinux: policy capability cgroup_seclabel=1 Mar 19 11:41:18.428446 kernel: SELinux: policy capability nnp_nosuid_transition=1 Mar 19 11:41:18.428458 kernel: SELinux: policy capability genfs_seclabel_symlinks=0 Mar 19 11:41:18.428468 kernel: SELinux: policy capability ioctl_skip_cloexec=0 Mar 19 11:41:18.428477 kernel: audit: type=1403 audit(1742384473.100:2): auid=4294967295 ses=4294967295 lsm=selinux res=1 Mar 19 11:41:18.428487 systemd[1]: Successfully loaded SELinux policy in 226.186ms. Mar 19 11:41:18.428498 systemd[1]: Relabeled /dev/, /dev/shm/, /run/ in 15.859ms. Mar 19 11:41:18.428510 systemd[1]: systemd 256.8 running in system mode (+PAM +AUDIT +SELINUX -APPARMOR +IMA +SMACK +SECCOMP +GCRYPT -GNUTLS +OPENSSL -ACL +BLKID +CURL +ELFUTILS -FIDO2 +IDN2 -IDN +IPTC +KMOD +LIBCRYPTSETUP +LIBCRYPTSETUP_PLUGINS +LIBFDISK +PCRE2 -PWQUALITY -P11KIT -QRENCODE +TPM2 +BZIP2 +LZ4 +XZ +ZLIB +ZSTD -BPF_FRAMEWORK -XKBCOMMON +UTMP -SYSVINIT +LIBARCHIVE) Mar 19 11:41:18.428520 systemd[1]: Detected virtualization microsoft. Mar 19 11:41:18.428537 systemd[1]: Detected architecture x86-64. Mar 19 11:41:18.428548 systemd[1]: Detected first boot. Mar 19 11:41:18.428559 systemd[1]: Hostname set to . Mar 19 11:41:18.428569 systemd[1]: Initializing machine ID from random generator. Mar 19 11:41:18.428580 zram_generator::config[1219]: No configuration found. Mar 19 11:41:18.428594 kernel: Guest personality initialized and is inactive Mar 19 11:41:18.428604 kernel: VMCI host device registered (name=vmci, major=10, minor=124) Mar 19 11:41:18.428614 kernel: Initialized host personality Mar 19 11:41:18.428623 kernel: NET: Registered PF_VSOCK protocol family Mar 19 11:41:18.428633 systemd[1]: Populated /etc with preset unit settings. Mar 19 11:41:18.428644 systemd[1]: run-credentials-systemd\x2djournald.service.mount: Deactivated successfully. Mar 19 11:41:18.428654 systemd[1]: initrd-switch-root.service: Deactivated successfully. Mar 19 11:41:18.428664 systemd[1]: Stopped initrd-switch-root.service - Switch Root. Mar 19 11:41:18.428677 systemd[1]: systemd-journald.service: Scheduled restart job, restart counter is at 1. Mar 19 11:41:18.428687 systemd[1]: Created slice system-addon\x2dconfig.slice - Slice /system/addon-config. Mar 19 11:41:18.428698 systemd[1]: Created slice system-addon\x2drun.slice - Slice /system/addon-run. Mar 19 11:41:18.428709 systemd[1]: Created slice system-getty.slice - Slice /system/getty. Mar 19 11:41:18.428719 systemd[1]: Created slice system-modprobe.slice - Slice /system/modprobe. Mar 19 11:41:18.428730 systemd[1]: Created slice system-serial\x2dgetty.slice - Slice /system/serial-getty. Mar 19 11:41:18.428750 systemd[1]: Created slice system-system\x2dcloudinit.slice - Slice /system/system-cloudinit. Mar 19 11:41:18.428764 systemd[1]: Created slice system-systemd\x2dfsck.slice - Slice /system/systemd-fsck. Mar 19 11:41:18.428778 systemd[1]: Created slice user.slice - User and Session Slice. Mar 19 11:41:18.428789 systemd[1]: Started clevis-luks-askpass.path - Forward Password Requests to Clevis Directory Watch. Mar 19 11:41:18.428799 systemd[1]: Started systemd-ask-password-console.path - Dispatch Password Requests to Console Directory Watch. Mar 19 11:41:18.428810 systemd[1]: Started systemd-ask-password-wall.path - Forward Password Requests to Wall Directory Watch. Mar 19 11:41:18.428821 systemd[1]: Set up automount boot.automount - Boot partition Automount Point. Mar 19 11:41:18.428835 systemd[1]: Set up automount proc-sys-fs-binfmt_misc.automount - Arbitrary Executable File Formats File System Automount Point. Mar 19 11:41:18.428847 systemd[1]: Expecting device dev-disk-by\x2dlabel-OEM.device - /dev/disk/by-label/OEM... Mar 19 11:41:18.428860 systemd[1]: Expecting device dev-ttyS0.device - /dev/ttyS0... Mar 19 11:41:18.428871 systemd[1]: Reached target cryptsetup-pre.target - Local Encrypted Volumes (Pre). Mar 19 11:41:18.428882 systemd[1]: Stopped target initrd-switch-root.target - Switch Root. Mar 19 11:41:18.428893 systemd[1]: Stopped target initrd-fs.target - Initrd File Systems. Mar 19 11:41:18.428904 systemd[1]: Stopped target initrd-root-fs.target - Initrd Root File System. Mar 19 11:41:18.428915 systemd[1]: Reached target integritysetup.target - Local Integrity Protected Volumes. Mar 19 11:41:18.428925 systemd[1]: Reached target remote-cryptsetup.target - Remote Encrypted Volumes. Mar 19 11:41:18.428936 systemd[1]: Reached target remote-fs.target - Remote File Systems. Mar 19 11:41:18.428949 systemd[1]: Reached target slices.target - Slice Units. Mar 19 11:41:18.428960 systemd[1]: Reached target swap.target - Swaps. Mar 19 11:41:18.428971 systemd[1]: Reached target veritysetup.target - Local Verity Protected Volumes. Mar 19 11:41:18.428982 systemd[1]: Listening on systemd-coredump.socket - Process Core Dump Socket. Mar 19 11:41:18.428993 systemd[1]: Listening on systemd-creds.socket - Credential Encryption/Decryption. Mar 19 11:41:18.429007 systemd[1]: Listening on systemd-networkd.socket - Network Service Netlink Socket. Mar 19 11:41:18.429021 systemd[1]: Listening on systemd-udevd-control.socket - udev Control Socket. Mar 19 11:41:18.429032 systemd[1]: Listening on systemd-udevd-kernel.socket - udev Kernel Socket. Mar 19 11:41:18.429043 systemd[1]: Listening on systemd-userdbd.socket - User Database Manager Socket. Mar 19 11:41:18.429054 systemd[1]: Mounting dev-hugepages.mount - Huge Pages File System... Mar 19 11:41:18.429065 systemd[1]: Mounting dev-mqueue.mount - POSIX Message Queue File System... Mar 19 11:41:18.429076 systemd[1]: Mounting media.mount - External Media Directory... Mar 19 11:41:18.429088 systemd[1]: proc-xen.mount - /proc/xen was skipped because of an unmet condition check (ConditionVirtualization=xen). Mar 19 11:41:18.429102 systemd[1]: Mounting sys-kernel-debug.mount - Kernel Debug File System... Mar 19 11:41:18.429113 systemd[1]: Mounting sys-kernel-tracing.mount - Kernel Trace File System... Mar 19 11:41:18.429124 systemd[1]: Mounting tmp.mount - Temporary Directory /tmp... Mar 19 11:41:18.429135 systemd[1]: var-lib-machines.mount - Virtual Machine and Container Storage (Compatibility) was skipped because of an unmet condition check (ConditionPathExists=/var/lib/machines.raw). Mar 19 11:41:18.429146 systemd[1]: Reached target machines.target - Containers. Mar 19 11:41:18.429157 systemd[1]: Starting flatcar-tmpfiles.service - Create missing system files... Mar 19 11:41:18.429168 systemd[1]: ignition-delete-config.service - Ignition (delete config) was skipped because no trigger condition checks were met. Mar 19 11:41:18.429179 systemd[1]: Starting kmod-static-nodes.service - Create List of Static Device Nodes... Mar 19 11:41:18.429193 systemd[1]: Starting modprobe@configfs.service - Load Kernel Module configfs... Mar 19 11:41:18.429204 systemd[1]: Starting modprobe@dm_mod.service - Load Kernel Module dm_mod... Mar 19 11:41:18.429215 systemd[1]: Starting modprobe@drm.service - Load Kernel Module drm... Mar 19 11:41:18.429226 systemd[1]: Starting modprobe@efi_pstore.service - Load Kernel Module efi_pstore... Mar 19 11:41:18.429240 systemd[1]: Starting modprobe@fuse.service - Load Kernel Module fuse... Mar 19 11:41:18.429251 systemd[1]: Starting modprobe@loop.service - Load Kernel Module loop... Mar 19 11:41:18.429265 systemd[1]: setup-nsswitch.service - Create /etc/nsswitch.conf was skipped because of an unmet condition check (ConditionPathExists=!/etc/nsswitch.conf). Mar 19 11:41:18.429276 systemd[1]: systemd-fsck-root.service: Deactivated successfully. Mar 19 11:41:18.429290 systemd[1]: Stopped systemd-fsck-root.service - File System Check on Root Device. Mar 19 11:41:18.429301 systemd[1]: systemd-fsck-usr.service: Deactivated successfully. Mar 19 11:41:18.429312 systemd[1]: Stopped systemd-fsck-usr.service. Mar 19 11:41:18.429323 systemd[1]: systemd-hibernate-clear.service - Clear Stale Hibernate Storage Info was skipped because of an unmet condition check (ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67). Mar 19 11:41:18.429335 systemd[1]: Starting systemd-journald.service - Journal Service... Mar 19 11:41:18.429346 systemd[1]: Starting systemd-modules-load.service - Load Kernel Modules... Mar 19 11:41:18.429357 systemd[1]: Starting systemd-network-generator.service - Generate network units from Kernel command line... Mar 19 11:41:18.429367 kernel: fuse: init (API version 7.39) Mar 19 11:41:18.429381 systemd[1]: Starting systemd-remount-fs.service - Remount Root and Kernel File Systems... Mar 19 11:41:18.429392 systemd[1]: Starting systemd-udev-load-credentials.service - Load udev Rules from Credentials... Mar 19 11:41:18.429425 systemd-journald[1326]: Collecting audit messages is disabled. Mar 19 11:41:18.429449 systemd[1]: Starting systemd-udev-trigger.service - Coldplug All udev Devices... Mar 19 11:41:18.429464 systemd-journald[1326]: Journal started Mar 19 11:41:18.429487 systemd-journald[1326]: Runtime Journal (/run/log/journal/6e812918c8854a679884e7a170c69dd8) is 8M, max 2.2G, 2.1G free. Mar 19 11:41:17.715504 systemd[1]: Queued start job for default target multi-user.target. Mar 19 11:41:17.728161 systemd[1]: Unnecessary job was removed for dev-sda6.device - /dev/sda6. Mar 19 11:41:17.728695 systemd[1]: systemd-journald.service: Deactivated successfully. Mar 19 11:41:18.443081 systemd[1]: verity-setup.service: Deactivated successfully. Mar 19 11:41:18.443143 systemd[1]: Stopped verity-setup.service. Mar 19 11:41:18.455757 systemd[1]: xenserver-pv-version.service - Set fake PV driver version for XenServer was skipped because of an unmet condition check (ConditionVirtualization=xen). Mar 19 11:41:18.463075 systemd[1]: Started systemd-journald.service - Journal Service. Mar 19 11:41:18.467230 systemd[1]: Mounted dev-hugepages.mount - Huge Pages File System. Mar 19 11:41:18.471434 systemd[1]: Mounted dev-mqueue.mount - POSIX Message Queue File System. Mar 19 11:41:18.476004 systemd[1]: Mounted media.mount - External Media Directory. Mar 19 11:41:18.481965 systemd[1]: Mounted sys-kernel-debug.mount - Kernel Debug File System. Mar 19 11:41:18.487756 kernel: loop: module loaded Mar 19 11:41:18.487944 systemd[1]: Mounted sys-kernel-tracing.mount - Kernel Trace File System. Mar 19 11:41:18.495629 systemd[1]: Mounted tmp.mount - Temporary Directory /tmp. Mar 19 11:41:18.500150 systemd[1]: Finished flatcar-tmpfiles.service - Create missing system files. Mar 19 11:41:18.505093 systemd[1]: Finished kmod-static-nodes.service - Create List of Static Device Nodes. Mar 19 11:41:18.510612 systemd[1]: modprobe@configfs.service: Deactivated successfully. Mar 19 11:41:18.510855 systemd[1]: Finished modprobe@configfs.service - Load Kernel Module configfs. Mar 19 11:41:18.515752 kernel: ACPI: bus type drm_connector registered Mar 19 11:41:18.518652 systemd[1]: modprobe@dm_mod.service: Deactivated successfully. Mar 19 11:41:18.519056 systemd[1]: Finished modprobe@dm_mod.service - Load Kernel Module dm_mod. Mar 19 11:41:18.524367 systemd[1]: modprobe@drm.service: Deactivated successfully. Mar 19 11:41:18.524572 systemd[1]: Finished modprobe@drm.service - Load Kernel Module drm. Mar 19 11:41:18.529327 systemd[1]: modprobe@efi_pstore.service: Deactivated successfully. Mar 19 11:41:18.529509 systemd[1]: Finished modprobe@efi_pstore.service - Load Kernel Module efi_pstore. Mar 19 11:41:18.534656 systemd[1]: modprobe@fuse.service: Deactivated successfully. Mar 19 11:41:18.534865 systemd[1]: Finished modprobe@fuse.service - Load Kernel Module fuse. Mar 19 11:41:18.539397 systemd[1]: modprobe@loop.service: Deactivated successfully. Mar 19 11:41:18.539628 systemd[1]: Finished modprobe@loop.service - Load Kernel Module loop. Mar 19 11:41:18.544147 systemd[1]: Finished systemd-modules-load.service - Load Kernel Modules. Mar 19 11:41:18.548873 systemd[1]: Finished systemd-network-generator.service - Generate network units from Kernel command line. Mar 19 11:41:18.554064 systemd[1]: Finished systemd-remount-fs.service - Remount Root and Kernel File Systems. Mar 19 11:41:18.559233 systemd[1]: Finished systemd-udev-load-credentials.service - Load udev Rules from Credentials. Mar 19 11:41:18.573566 systemd[1]: Reached target network-pre.target - Preparation for Network. Mar 19 11:41:18.599901 systemd[1]: Mounting sys-fs-fuse-connections.mount - FUSE Control File System... Mar 19 11:41:18.605588 systemd[1]: Mounting sys-kernel-config.mount - Kernel Configuration File System... Mar 19 11:41:18.609967 systemd[1]: remount-root.service - Remount Root File System was skipped because of an unmet condition check (ConditionPathIsReadWrite=!/). Mar 19 11:41:18.610012 systemd[1]: Reached target local-fs.target - Local File Systems. Mar 19 11:41:18.615129 systemd[1]: Listening on systemd-sysext.socket - System Extension Image Management. Mar 19 11:41:18.621194 systemd[1]: Starting dracut-shutdown.service - Restore /run/initramfs on shutdown... Mar 19 11:41:18.626696 systemd[1]: Starting ldconfig.service - Rebuild Dynamic Linker Cache... Mar 19 11:41:18.630857 systemd[1]: systemd-binfmt.service - Set Up Additional Binary Formats was skipped because no trigger condition checks were met. Mar 19 11:41:18.722908 systemd[1]: Starting systemd-hwdb-update.service - Rebuild Hardware Database... Mar 19 11:41:18.728443 systemd[1]: Starting systemd-journal-flush.service - Flush Journal to Persistent Storage... Mar 19 11:41:18.733142 systemd[1]: systemd-pstore.service - Platform Persistent Storage Archival was skipped because of an unmet condition check (ConditionDirectoryNotEmpty=/sys/fs/pstore). Mar 19 11:41:18.734094 systemd[1]: Starting systemd-random-seed.service - Load/Save OS Random Seed... Mar 19 11:41:18.738384 systemd[1]: systemd-repart.service - Repartition Root Disk was skipped because no trigger condition checks were met. Mar 19 11:41:18.739429 systemd[1]: Starting systemd-sysctl.service - Apply Kernel Variables... Mar 19 11:41:18.744545 systemd[1]: Starting systemd-sysext.service - Merge System Extension Images into /usr/ and /opt/... Mar 19 11:41:18.750231 systemd[1]: Starting systemd-sysusers.service - Create System Users... Mar 19 11:41:18.756747 systemd[1]: Finished systemd-udev-trigger.service - Coldplug All udev Devices. Mar 19 11:41:18.761886 systemd[1]: Mounted sys-fs-fuse-connections.mount - FUSE Control File System. Mar 19 11:41:18.771038 systemd[1]: Mounted sys-kernel-config.mount - Kernel Configuration File System. Mar 19 11:41:18.776159 systemd[1]: Finished dracut-shutdown.service - Restore /run/initramfs on shutdown. Mar 19 11:41:18.781637 systemd[1]: Finished systemd-random-seed.service - Load/Save OS Random Seed. Mar 19 11:41:18.789718 systemd[1]: Reached target first-boot-complete.target - First Boot Complete. Mar 19 11:41:18.812956 systemd[1]: Starting systemd-machine-id-commit.service - Save Transient machine-id to Disk... Mar 19 11:41:18.818804 systemd[1]: Starting systemd-udev-settle.service - Wait for udev To Complete Device Initialization... Mar 19 11:41:18.833115 systemd-journald[1326]: Time spent on flushing to /var/log/journal/6e812918c8854a679884e7a170c69dd8 is 16.602ms for 957 entries. Mar 19 11:41:18.833115 systemd-journald[1326]: System Journal (/var/log/journal/6e812918c8854a679884e7a170c69dd8) is 8M, max 2.6G, 2.6G free. Mar 19 11:41:18.884547 systemd-journald[1326]: Received client request to flush runtime journal. Mar 19 11:41:18.833835 udevadm[1371]: systemd-udev-settle.service is deprecated. Please fix lvm2-activation.service, lvm2-activation-early.service not to pull it in. Mar 19 11:41:18.886267 systemd[1]: Finished systemd-journal-flush.service - Flush Journal to Persistent Storage. Mar 19 11:41:18.911344 systemd[1]: Finished systemd-sysctl.service - Apply Kernel Variables. Mar 19 11:41:18.916352 systemd[1]: Finished systemd-sysusers.service - Create System Users. Mar 19 11:41:18.922776 kernel: loop0: detected capacity change from 0 to 138176 Mar 19 11:41:18.934924 systemd[1]: Starting systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev... Mar 19 11:41:18.941912 systemd[1]: etc-machine\x2did.mount: Deactivated successfully. Mar 19 11:41:18.942673 systemd[1]: Finished systemd-machine-id-commit.service - Save Transient machine-id to Disk. Mar 19 11:41:19.016371 systemd-tmpfiles[1377]: ACLs are not supported, ignoring. Mar 19 11:41:19.016393 systemd-tmpfiles[1377]: ACLs are not supported, ignoring. Mar 19 11:41:19.022078 systemd[1]: Finished systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev. Mar 19 11:41:19.665846 kernel: squashfs: version 4.0 (2009/01/31) Phillip Lougher Mar 19 11:41:19.742779 kernel: loop1: detected capacity change from 0 to 147912 Mar 19 11:41:20.434281 systemd[1]: Finished systemd-hwdb-update.service - Rebuild Hardware Database. Mar 19 11:41:20.447994 systemd[1]: Starting systemd-udevd.service - Rule-based Manager for Device Events and Files... Mar 19 11:41:20.475613 systemd-udevd[1385]: Using default interface naming scheme 'v255'. Mar 19 11:41:20.583765 kernel: loop2: detected capacity change from 0 to 28272 Mar 19 11:41:20.629969 systemd[1]: Started systemd-udevd.service - Rule-based Manager for Device Events and Files. Mar 19 11:41:20.647918 systemd[1]: Starting systemd-networkd.service - Network Configuration... Mar 19 11:41:20.659452 systemd[1]: Condition check resulted in dev-ttyS0.device - /dev/ttyS0 being skipped. Mar 19 11:41:20.730934 systemd[1]: Starting systemd-userdbd.service - User Database Manager... Mar 19 11:41:20.746783 kernel: hv_vmbus: registering driver hv_balloon Mar 19 11:41:20.746952 kernel: hv_balloon: Using Dynamic Memory protocol version 2.0 Mar 19 11:41:20.751661 systemd[1]: Starting systemd-vconsole-setup.service - Virtual Console Setup... Mar 19 11:41:20.769760 kernel: hv_vmbus: registering driver hyperv_fb Mar 19 11:41:20.769844 kernel: hyperv_fb: Synthvid Version major 3, minor 5 Mar 19 11:41:20.776926 kernel: hyperv_fb: Screen resolution: 1024x768, Color depth: 32, Frame buffer size: 8388608 Mar 19 11:41:20.781058 kernel: Console: switching to colour dummy device 80x25 Mar 19 11:41:20.781763 kernel: Console: switching to colour frame buffer device 128x48 Mar 19 11:41:20.787862 systemd[1]: Started systemd-userdbd.service - User Database Manager. Mar 19 11:41:20.792227 systemd[1]: systemd-vconsole-setup.service: Deactivated successfully. Mar 19 11:41:20.792457 systemd[1]: Stopped systemd-vconsole-setup.service - Virtual Console Setup. Mar 19 11:41:20.798111 systemd[1]: run-credentials-systemd\x2dvconsole\x2dsetup.service.mount: Deactivated successfully. Mar 19 11:41:20.806758 kernel: EDAC MC: Ver: 3.0.0 Mar 19 11:41:20.809256 systemd[1]: Starting systemd-vconsole-setup.service - Virtual Console Setup... Mar 19 11:41:20.812572 kernel: mousedev: PS/2 mouse device common for all mice Mar 19 11:41:20.943762 kernel: BTRFS warning: duplicate device /dev/sda3 devid 1 generation 36 scanned by (udev-worker) (1396) Mar 19 11:41:20.960123 systemd-networkd[1400]: lo: Link UP Mar 19 11:41:20.960135 systemd-networkd[1400]: lo: Gained carrier Mar 19 11:41:20.961508 systemd-networkd[1400]: Enumeration completed Mar 19 11:41:20.961980 systemd-networkd[1400]: eth0: found matching network '/usr/lib/systemd/network/zz-default.network', based on potentially unpredictable interface name. Mar 19 11:41:20.961989 systemd-networkd[1400]: eth0: Configuring with /usr/lib/systemd/network/zz-default.network. Mar 19 11:41:20.962560 systemd-networkd[1400]: eth0: Link UP Mar 19 11:41:20.962570 systemd-networkd[1400]: eth0: Gained carrier Mar 19 11:41:20.962583 systemd-networkd[1400]: eth0: found matching network '/usr/lib/systemd/network/zz-default.network', based on potentially unpredictable interface name. Mar 19 11:41:20.962894 systemd[1]: Started systemd-networkd.service - Network Configuration. Mar 19 11:41:20.984480 systemd[1]: Found device dev-disk-by\x2dlabel-OEM.device - Virtual_Disk OEM. Mar 19 11:41:20.986397 systemd[1]: Finished systemd-udev-settle.service - Wait for udev To Complete Device Initialization. Mar 19 11:41:21.008806 systemd-networkd[1400]: eth0: DHCPv4 address 10.200.8.11/24, gateway 10.200.8.1 acquired from 168.63.129.16 Mar 19 11:41:21.009129 systemd[1]: Starting lvm2-activation-early.service - Activation of LVM2 logical volumes... Mar 19 11:41:21.012790 systemd[1]: Starting systemd-fsck@dev-disk-by\x2dlabel-OEM.service - File System Check on /dev/disk/by-label/OEM... Mar 19 11:41:21.014641 systemd[1]: Starting systemd-networkd-persistent-storage.service - Enable Persistent Storage in systemd-networkd... Mar 19 11:41:21.016143 systemd[1]: Starting systemd-networkd-wait-online.service - Wait for Network to be Configured... Mar 19 11:41:21.080972 systemd[1]: Finished systemd-networkd-persistent-storage.service - Enable Persistent Storage in systemd-networkd. Mar 19 11:41:21.108702 systemd[1]: Finished systemd-fsck@dev-disk-by\x2dlabel-OEM.service - File System Check on /dev/disk/by-label/OEM. Mar 19 11:41:21.155272 lvm[1514]: WARNING: Failed to connect to lvmetad. Falling back to device scanning. Mar 19 11:41:21.211762 kernel: loop3: detected capacity change from 0 to 138176 Mar 19 11:41:21.215639 systemd[1]: Finished lvm2-activation-early.service - Activation of LVM2 logical volumes. Mar 19 11:41:21.217348 systemd[1]: Reached target cryptsetup.target - Local Encrypted Volumes. Mar 19 11:41:21.229239 systemd[1]: Starting lvm2-activation.service - Activation of LVM2 logical volumes... Mar 19 11:41:21.233983 kernel: loop4: detected capacity change from 0 to 147912 Mar 19 11:41:21.234021 lvm[1524]: WARNING: Failed to connect to lvmetad. Falling back to device scanning. Mar 19 11:41:21.244757 kernel: loop5: detected capacity change from 0 to 28272 Mar 19 11:41:21.250749 (sd-merge)[1522]: Using extensions 'containerd-flatcar', 'docker-flatcar', 'oem-azure'. Mar 19 11:41:21.251266 (sd-merge)[1522]: Merged extensions into '/usr'. Mar 19 11:41:21.255122 systemd[1]: Finished systemd-sysext.service - Merge System Extension Images into /usr/ and /opt/. Mar 19 11:41:21.266999 systemd[1]: Starting ensure-sysext.service... Mar 19 11:41:21.270167 systemd[1]: Starting systemd-tmpfiles-setup.service - Create System Files and Directories... Mar 19 11:41:21.274068 systemd[1]: Reload requested from client PID 1526 ('systemctl') (unit ensure-sysext.service)... Mar 19 11:41:21.274086 systemd[1]: Reloading... Mar 19 11:41:21.319826 zram_generator::config[1556]: No configuration found. Mar 19 11:41:21.325531 systemd-tmpfiles[1527]: /usr/lib/tmpfiles.d/provision.conf:20: Duplicate line for path "/root", ignoring. Mar 19 11:41:21.325852 systemd-tmpfiles[1527]: /usr/lib/tmpfiles.d/systemd-flatcar.conf:6: Duplicate line for path "/var/log/journal", ignoring. Mar 19 11:41:21.326789 systemd-tmpfiles[1527]: /usr/lib/tmpfiles.d/systemd.conf:29: Duplicate line for path "/var/lib/systemd", ignoring. Mar 19 11:41:21.327081 systemd-tmpfiles[1527]: ACLs are not supported, ignoring. Mar 19 11:41:21.327151 systemd-tmpfiles[1527]: ACLs are not supported, ignoring. Mar 19 11:41:21.381333 systemd-tmpfiles[1527]: Detected autofs mount point /boot during canonicalization of boot. Mar 19 11:41:21.381350 systemd-tmpfiles[1527]: Skipping /boot Mar 19 11:41:21.394119 systemd-tmpfiles[1527]: Detected autofs mount point /boot during canonicalization of boot. Mar 19 11:41:21.394135 systemd-tmpfiles[1527]: Skipping /boot Mar 19 11:41:21.470981 systemd[1]: /usr/lib/systemd/system/docker.socket:6: ListenStream= references a path below legacy directory /var/run/, updating /var/run/docker.sock → /run/docker.sock; please update the unit file accordingly. Mar 19 11:41:21.609470 systemd[1]: Reloading finished in 334 ms. Mar 19 11:41:21.630630 systemd[1]: Finished systemd-vconsole-setup.service - Virtual Console Setup. Mar 19 11:41:21.635957 systemd[1]: Finished lvm2-activation.service - Activation of LVM2 logical volumes. Mar 19 11:41:21.662868 systemd[1]: Finished systemd-tmpfiles-setup.service - Create System Files and Directories. Mar 19 11:41:21.676492 systemd[1]: Starting audit-rules.service - Load Audit Rules... Mar 19 11:41:21.695894 systemd[1]: Starting clean-ca-certificates.service - Clean up broken links in /etc/ssl/certs... Mar 19 11:41:21.701960 systemd[1]: Starting systemd-journal-catalog-update.service - Rebuild Journal Catalog... Mar 19 11:41:21.708520 systemd[1]: Starting systemd-resolved.service - Network Name Resolution... Mar 19 11:41:21.714140 systemd[1]: Starting systemd-update-utmp.service - Record System Boot/Shutdown in UTMP... Mar 19 11:41:21.721860 systemd[1]: ignition-delete-config.service - Ignition (delete config) was skipped because no trigger condition checks were met. Mar 19 11:41:21.723115 systemd[1]: Starting modprobe@dm_mod.service - Load Kernel Module dm_mod... Mar 19 11:41:21.728489 systemd[1]: Starting modprobe@efi_pstore.service - Load Kernel Module efi_pstore... Mar 19 11:41:21.734367 systemd[1]: Starting modprobe@loop.service - Load Kernel Module loop... Mar 19 11:41:21.738370 systemd[1]: systemd-binfmt.service - Set Up Additional Binary Formats was skipped because no trigger condition checks were met. Mar 19 11:41:21.738506 systemd[1]: systemd-hibernate-clear.service - Clear Stale Hibernate Storage Info was skipped because of an unmet condition check (ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67). Mar 19 11:41:21.740189 systemd[1]: modprobe@dm_mod.service: Deactivated successfully. Mar 19 11:41:21.740750 systemd[1]: Finished modprobe@dm_mod.service - Load Kernel Module dm_mod. Mar 19 11:41:21.751319 systemd[1]: modprobe@efi_pstore.service: Deactivated successfully. Mar 19 11:41:21.751562 systemd[1]: Finished modprobe@efi_pstore.service - Load Kernel Module efi_pstore. Mar 19 11:41:21.757092 systemd[1]: modprobe@loop.service: Deactivated successfully. Mar 19 11:41:21.757299 systemd[1]: Finished modprobe@loop.service - Load Kernel Module loop. Mar 19 11:41:21.770732 systemd[1]: proc-xen.mount - /proc/xen was skipped because of an unmet condition check (ConditionVirtualization=xen). Mar 19 11:41:21.772489 systemd[1]: ignition-delete-config.service - Ignition (delete config) was skipped because no trigger condition checks were met. Mar 19 11:41:21.786058 systemd[1]: Starting modprobe@dm_mod.service - Load Kernel Module dm_mod... Mar 19 11:41:21.792167 systemd[1]: Starting modprobe@efi_pstore.service - Load Kernel Module efi_pstore... Mar 19 11:41:21.798273 systemd[1]: Starting modprobe@loop.service - Load Kernel Module loop... Mar 19 11:41:21.802701 systemd[1]: systemd-binfmt.service - Set Up Additional Binary Formats was skipped because no trigger condition checks were met. Mar 19 11:41:21.802848 systemd[1]: systemd-hibernate-clear.service - Clear Stale Hibernate Storage Info was skipped because of an unmet condition check (ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67). Mar 19 11:41:21.802962 systemd[1]: xenserver-pv-version.service - Set fake PV driver version for XenServer was skipped because of an unmet condition check (ConditionVirtualization=xen). Mar 19 11:41:21.804640 systemd[1]: Finished systemd-journal-catalog-update.service - Rebuild Journal Catalog. Mar 19 11:41:21.811160 systemd[1]: Finished systemd-update-utmp.service - Record System Boot/Shutdown in UTMP. Mar 19 11:41:21.816586 systemd[1]: modprobe@dm_mod.service: Deactivated successfully. Mar 19 11:41:21.816789 systemd[1]: Finished modprobe@dm_mod.service - Load Kernel Module dm_mod. Mar 19 11:41:21.821801 systemd[1]: modprobe@efi_pstore.service: Deactivated successfully. Mar 19 11:41:21.821985 systemd[1]: Finished modprobe@efi_pstore.service - Load Kernel Module efi_pstore. Mar 19 11:41:21.828034 systemd[1]: modprobe@loop.service: Deactivated successfully. Mar 19 11:41:21.828228 systemd[1]: Finished modprobe@loop.service - Load Kernel Module loop. Mar 19 11:41:21.840546 systemd[1]: proc-xen.mount - /proc/xen was skipped because of an unmet condition check (ConditionVirtualization=xen). Mar 19 11:41:21.840933 systemd[1]: ignition-delete-config.service - Ignition (delete config) was skipped because no trigger condition checks were met. Mar 19 11:41:21.856090 systemd[1]: Starting modprobe@dm_mod.service - Load Kernel Module dm_mod... Mar 19 11:41:21.861364 systemd[1]: Starting modprobe@drm.service - Load Kernel Module drm... Mar 19 11:41:21.866433 systemd[1]: Starting modprobe@efi_pstore.service - Load Kernel Module efi_pstore... Mar 19 11:41:21.872045 systemd[1]: Starting modprobe@loop.service - Load Kernel Module loop... Mar 19 11:41:21.876287 systemd[1]: systemd-binfmt.service - Set Up Additional Binary Formats was skipped because no trigger condition checks were met. Mar 19 11:41:21.876424 systemd[1]: systemd-hibernate-clear.service - Clear Stale Hibernate Storage Info was skipped because of an unmet condition check (ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67). Mar 19 11:41:21.876613 systemd[1]: Reached target time-set.target - System Time Set. Mar 19 11:41:21.880717 systemd[1]: xenserver-pv-version.service - Set fake PV driver version for XenServer was skipped because of an unmet condition check (ConditionVirtualization=xen). Mar 19 11:41:21.882486 systemd[1]: modprobe@dm_mod.service: Deactivated successfully. Mar 19 11:41:21.882698 systemd[1]: Finished modprobe@dm_mod.service - Load Kernel Module dm_mod. Mar 19 11:41:21.888024 systemd[1]: modprobe@drm.service: Deactivated successfully. Mar 19 11:41:21.888234 systemd[1]: Finished modprobe@drm.service - Load Kernel Module drm. Mar 19 11:41:21.892910 augenrules[1668]: No rules Mar 19 11:41:21.892991 systemd[1]: modprobe@efi_pstore.service: Deactivated successfully. Mar 19 11:41:21.893166 systemd[1]: Finished modprobe@efi_pstore.service - Load Kernel Module efi_pstore. Mar 19 11:41:21.898617 systemd[1]: audit-rules.service: Deactivated successfully. Mar 19 11:41:21.898845 systemd[1]: Finished audit-rules.service - Load Audit Rules. Mar 19 11:41:21.903239 systemd[1]: modprobe@loop.service: Deactivated successfully. Mar 19 11:41:21.903433 systemd[1]: Finished modprobe@loop.service - Load Kernel Module loop. Mar 19 11:41:21.911577 systemd[1]: Finished ensure-sysext.service. Mar 19 11:41:21.919496 systemd[1]: systemd-pstore.service - Platform Persistent Storage Archival was skipped because of an unmet condition check (ConditionDirectoryNotEmpty=/sys/fs/pstore). Mar 19 11:41:21.919564 systemd[1]: systemd-repart.service - Repartition Root Disk was skipped because no trigger condition checks were met. Mar 19 11:41:22.058638 systemd-resolved[1629]: Positive Trust Anchors: Mar 19 11:41:22.058656 systemd-resolved[1629]: . IN DS 20326 8 2 e06d44b80b8f1d39a95c0b0d7c65d08458e880409bbc683457104237c7f8ec8d Mar 19 11:41:22.058689 systemd-resolved[1629]: Negative trust anchors: home.arpa 10.in-addr.arpa 16.172.in-addr.arpa 17.172.in-addr.arpa 18.172.in-addr.arpa 19.172.in-addr.arpa 20.172.in-addr.arpa 21.172.in-addr.arpa 22.172.in-addr.arpa 23.172.in-addr.arpa 24.172.in-addr.arpa 25.172.in-addr.arpa 26.172.in-addr.arpa 27.172.in-addr.arpa 28.172.in-addr.arpa 29.172.in-addr.arpa 30.172.in-addr.arpa 31.172.in-addr.arpa 170.0.0.192.in-addr.arpa 171.0.0.192.in-addr.arpa 168.192.in-addr.arpa d.f.ip6.arpa ipv4only.arpa resolver.arpa corp home internal intranet lan local private test Mar 19 11:41:22.094876 systemd-resolved[1629]: Using system hostname 'ci-4230.1.0-a-0674828377'. Mar 19 11:41:22.096852 systemd[1]: Started systemd-resolved.service - Network Name Resolution. Mar 19 11:41:22.101346 systemd[1]: Reached target network.target - Network. Mar 19 11:41:22.104833 systemd[1]: Reached target nss-lookup.target - Host and Network Name Lookups. Mar 19 11:41:22.580878 systemd-networkd[1400]: eth0: Gained IPv6LL Mar 19 11:41:22.583472 systemd[1]: Finished systemd-networkd-wait-online.service - Wait for Network to be Configured. Mar 19 11:41:22.589225 systemd[1]: Reached target network-online.target - Network is Online. Mar 19 11:41:23.010799 systemd[1]: Finished clean-ca-certificates.service - Clean up broken links in /etc/ssl/certs. Mar 19 11:41:23.017112 systemd[1]: update-ca-certificates.service - Update CA bundle at /etc/ssl/certs/ca-certificates.crt was skipped because of an unmet condition check (ConditionPathIsSymbolicLink=!/etc/ssl/certs/ca-certificates.crt). Mar 19 11:41:27.484683 ldconfig[1356]: /sbin/ldconfig: /usr/lib/ld.so.conf is not an ELF file - it has the wrong magic bytes at the start. Mar 19 11:41:27.499108 systemd[1]: Finished ldconfig.service - Rebuild Dynamic Linker Cache. Mar 19 11:41:27.513010 systemd[1]: Starting systemd-update-done.service - Update is Completed... Mar 19 11:41:27.522043 systemd[1]: Finished systemd-update-done.service - Update is Completed. Mar 19 11:41:27.526589 systemd[1]: Reached target sysinit.target - System Initialization. Mar 19 11:41:27.531020 systemd[1]: Started motdgen.path - Watch for update engine configuration changes. Mar 19 11:41:27.536053 systemd[1]: Started user-cloudinit@var-lib-flatcar\x2dinstall-user_data.path - Watch for a cloud-config at /var/lib/flatcar-install/user_data. Mar 19 11:41:27.541575 systemd[1]: Started logrotate.timer - Daily rotation of log files. Mar 19 11:41:27.546105 systemd[1]: Started mdadm.timer - Weekly check for MD array's redundancy information.. Mar 19 11:41:27.551205 systemd[1]: Started systemd-tmpfiles-clean.timer - Daily Cleanup of Temporary Directories. Mar 19 11:41:27.556316 systemd[1]: update-engine-stub.timer - Update Engine Stub Timer was skipped because of an unmet condition check (ConditionPathExists=/usr/.noupdate). Mar 19 11:41:27.556377 systemd[1]: Reached target paths.target - Path Units. Mar 19 11:41:27.559885 systemd[1]: Reached target timers.target - Timer Units. Mar 19 11:41:27.564874 systemd[1]: Listening on dbus.socket - D-Bus System Message Bus Socket. Mar 19 11:41:27.570893 systemd[1]: Starting docker.socket - Docker Socket for the API... Mar 19 11:41:27.578280 systemd[1]: Listening on sshd-unix-local.socket - OpenSSH Server Socket (systemd-ssh-generator, AF_UNIX Local). Mar 19 11:41:27.583660 systemd[1]: Listening on sshd-vsock.socket - OpenSSH Server Socket (systemd-ssh-generator, AF_VSOCK). Mar 19 11:41:27.588833 systemd[1]: Reached target ssh-access.target - SSH Access Available. Mar 19 11:41:27.595412 systemd[1]: Listening on sshd.socket - OpenSSH Server Socket. Mar 19 11:41:27.599944 systemd[1]: Listening on systemd-hostnamed.socket - Hostname Service Socket. Mar 19 11:41:27.605385 systemd[1]: Listening on docker.socket - Docker Socket for the API. Mar 19 11:41:27.609943 systemd[1]: Reached target sockets.target - Socket Units. Mar 19 11:41:27.613857 systemd[1]: Reached target basic.target - Basic System. Mar 19 11:41:27.617698 systemd[1]: addon-config@oem.service - Configure Addon /oem was skipped because no trigger condition checks were met. Mar 19 11:41:27.617760 systemd[1]: addon-run@oem.service - Run Addon /oem was skipped because no trigger condition checks were met. Mar 19 11:41:27.620633 systemd[1]: Starting chronyd.service - NTP client/server... Mar 19 11:41:27.628159 systemd[1]: Starting containerd.service - containerd container runtime... Mar 19 11:41:27.633825 systemd[1]: Starting coreos-metadata.service - Flatcar Metadata Agent... Mar 19 11:41:27.638872 systemd[1]: Starting dbus.service - D-Bus System Message Bus... Mar 19 11:41:27.644881 systemd[1]: Starting enable-oem-cloudinit.service - Enable cloudinit... Mar 19 11:41:27.650197 systemd[1]: Starting extend-filesystems.service - Extend Filesystems... Mar 19 11:41:27.655476 jq[1693]: false Mar 19 11:41:27.656610 systemd[1]: flatcar-setup-environment.service - Modifies /etc/environment for CoreOS was skipped because of an unmet condition check (ConditionPathExists=/oem/bin/flatcar-setup-environment). Mar 19 11:41:27.656655 systemd[1]: hv_fcopy_daemon.service - Hyper-V FCOPY daemon was skipped because of an unmet condition check (ConditionPathExists=/dev/vmbus/hv_fcopy). Mar 19 11:41:27.657807 systemd[1]: Started hv_kvp_daemon.service - Hyper-V KVP daemon. Mar 19 11:41:27.662133 systemd[1]: hv_vss_daemon.service - Hyper-V VSS daemon was skipped because of an unmet condition check (ConditionPathExists=/dev/vmbus/hv_vss). Mar 19 11:41:27.663253 systemd[1]: Starting motdgen.service - Generate /run/flatcar/motd... Mar 19 11:41:27.666304 KVP[1695]: KVP starting; pid is:1695 Mar 19 11:41:27.668899 (chronyd)[1686]: chronyd.service: Referenced but unset environment variable evaluates to an empty string: OPTIONS Mar 19 11:41:27.669211 systemd[1]: Starting nvidia.service - NVIDIA Configure Service... Mar 19 11:41:27.670283 KVP[1695]: KVP LIC Version: 3.1 Mar 19 11:41:27.674204 kernel: hv_utils: KVP IC version 4.0 Mar 19 11:41:27.675135 chronyd[1700]: chronyd version 4.6.1 starting (+CMDMON +NTP +REFCLOCK +RTC +PRIVDROP +SCFILTER -SIGND +ASYNCDNS +NTS +SECHASH +IPV6 -DEBUG) Mar 19 11:41:27.675404 systemd[1]: Starting ssh-key-proc-cmdline.service - Install an ssh key from /proc/cmdline... Mar 19 11:41:27.682626 systemd[1]: Starting sshd-keygen.service - Generate sshd host keys... Mar 19 11:41:27.689414 systemd[1]: Starting systemd-logind.service - User Login Management... Mar 19 11:41:27.694329 systemd[1]: tcsd.service - TCG Core Services Daemon was skipped because of an unmet condition check (ConditionPathExists=/dev/tpm0). Mar 19 11:41:27.694874 systemd[1]: cgroup compatibility translation between legacy and unified hierarchy settings activated. See cgroup-compat debug messages for details. Mar 19 11:41:27.695594 systemd[1]: Starting update-engine.service - Update Engine... Mar 19 11:41:27.700888 systemd[1]: Starting update-ssh-keys-after-ignition.service - Run update-ssh-keys once after Ignition... Mar 19 11:41:27.703294 chronyd[1700]: Timezone right/UTC failed leap second check, ignoring Mar 19 11:41:27.703460 chronyd[1700]: Loaded seccomp filter (level 2) Mar 19 11:41:27.706918 systemd[1]: Started chronyd.service - NTP client/server. Mar 19 11:41:27.711845 systemd[1]: enable-oem-cloudinit.service: Skipped due to 'exec-condition'. Mar 19 11:41:27.712066 systemd[1]: Condition check resulted in enable-oem-cloudinit.service - Enable cloudinit being skipped. Mar 19 11:41:27.712398 systemd[1]: ssh-key-proc-cmdline.service: Deactivated successfully. Mar 19 11:41:27.712588 systemd[1]: Finished ssh-key-proc-cmdline.service - Install an ssh key from /proc/cmdline. Mar 19 11:41:27.715373 jq[1711]: true Mar 19 11:41:27.726224 jq[1713]: true Mar 19 11:41:27.732718 systemd[1]: motdgen.service: Deactivated successfully. Mar 19 11:41:27.732986 systemd[1]: Finished motdgen.service - Generate /run/flatcar/motd. Mar 19 11:41:27.733599 (ntainerd)[1727]: containerd.service: Referenced but unset environment variable evaluates to an empty string: TORCX_IMAGEDIR, TORCX_UNPACKDIR Mar 19 11:41:27.769554 extend-filesystems[1694]: Found loop3 Mar 19 11:41:27.769554 extend-filesystems[1694]: Found loop4 Mar 19 11:41:27.769554 extend-filesystems[1694]: Found loop5 Mar 19 11:41:27.777856 extend-filesystems[1694]: Found sda Mar 19 11:41:27.777856 extend-filesystems[1694]: Found sda1 Mar 19 11:41:27.777856 extend-filesystems[1694]: Found sda2 Mar 19 11:41:27.777856 extend-filesystems[1694]: Found sda3 Mar 19 11:41:27.777856 extend-filesystems[1694]: Found usr Mar 19 11:41:27.777856 extend-filesystems[1694]: Found sda4 Mar 19 11:41:27.777856 extend-filesystems[1694]: Found sda6 Mar 19 11:41:27.777856 extend-filesystems[1694]: Found sda7 Mar 19 11:41:27.777856 extend-filesystems[1694]: Found sda9 Mar 19 11:41:27.777856 extend-filesystems[1694]: Checking size of /dev/sda9 Mar 19 11:41:27.805718 extend-filesystems[1694]: Old size kept for /dev/sda9 Mar 19 11:41:27.809378 extend-filesystems[1694]: Found sdb Mar 19 11:41:27.809378 extend-filesystems[1694]: Found sdb1 Mar 19 11:41:27.809378 extend-filesystems[1694]: Found sr0 Mar 19 11:41:27.806503 systemd[1]: extend-filesystems.service: Deactivated successfully. Mar 19 11:41:27.806774 systemd[1]: Finished extend-filesystems.service - Extend Filesystems. Mar 19 11:41:27.819500 systemd-logind[1706]: New seat seat0. Mar 19 11:41:27.825637 systemd-logind[1706]: Watching system buttons on /dev/input/event0 (AT Translated Set 2 keyboard) Mar 19 11:41:27.825882 systemd[1]: Started systemd-logind.service - User Login Management. Mar 19 11:41:27.832452 update_engine[1709]: I20250319 11:41:27.832242 1709 main.cc:92] Flatcar Update Engine starting Mar 19 11:41:27.852769 kernel: BTRFS warning: duplicate device /dev/sda3 devid 1 generation 36 scanned by (udev-worker) (1761) Mar 19 11:41:27.854006 dbus-daemon[1689]: [system] SELinux support is enabled Mar 19 11:41:27.862809 dbus-daemon[1689]: [system] Successfully activated service 'org.freedesktop.systemd1' Mar 19 11:41:27.870359 update_engine[1709]: I20250319 11:41:27.859961 1709 update_check_scheduler.cc:74] Next update check in 8m1s Mar 19 11:41:27.870405 bash[1744]: Updated "/home/core/.ssh/authorized_keys" Mar 19 11:41:27.854214 systemd[1]: Started dbus.service - D-Bus System Message Bus. Mar 19 11:41:27.861000 systemd[1]: system-cloudinit@usr-share-oem-cloud\x2dconfig.yml.service - Load cloud-config from /usr/share/oem/cloud-config.yml was skipped because of an unmet condition check (ConditionFileNotEmpty=/usr/share/oem/cloud-config.yml). Mar 19 11:41:27.861032 systemd[1]: Reached target system-config.target - Load system-provided cloud configs. Mar 19 11:41:27.866515 systemd[1]: user-cloudinit-proc-cmdline.service - Load cloud-config from url defined in /proc/cmdline was skipped because of an unmet condition check (ConditionKernelCommandLine=cloud-config-url). Mar 19 11:41:27.866536 systemd[1]: Reached target user-config.target - Load user-provided cloud configs. Mar 19 11:41:27.872185 systemd[1]: Finished update-ssh-keys-after-ignition.service - Run update-ssh-keys once after Ignition. Mar 19 11:41:27.905903 systemd[1]: Started update-engine.service - Update Engine. Mar 19 11:41:27.911526 systemd[1]: sshkeys.service was skipped because no trigger condition checks were met. Mar 19 11:41:27.925061 systemd[1]: Started locksmithd.service - Cluster reboot manager. Mar 19 11:41:27.932998 coreos-metadata[1688]: Mar 19 11:41:27.932 INFO Fetching http://168.63.129.16/?comp=versions: Attempt #1 Mar 19 11:41:27.937556 coreos-metadata[1688]: Mar 19 11:41:27.937 INFO Fetch successful Mar 19 11:41:27.937752 coreos-metadata[1688]: Mar 19 11:41:27.937 INFO Fetching http://168.63.129.16/machine/?comp=goalstate: Attempt #1 Mar 19 11:41:27.941851 coreos-metadata[1688]: Mar 19 11:41:27.941 INFO Fetch successful Mar 19 11:41:27.942172 coreos-metadata[1688]: Mar 19 11:41:27.942 INFO Fetching http://168.63.129.16/machine/260786a0-21a3-41d8-b513-fcbfbc779b01/9004aff5%2D2463%2D4b6c%2D83b7%2Da56da5c0b0ac.%5Fci%2D4230.1.0%2Da%2D0674828377?comp=config&type=sharedConfig&incarnation=1: Attempt #1 Mar 19 11:41:27.944278 coreos-metadata[1688]: Mar 19 11:41:27.944 INFO Fetch successful Mar 19 11:41:27.944422 coreos-metadata[1688]: Mar 19 11:41:27.944 INFO Fetching http://169.254.169.254/metadata/instance/compute/vmSize?api-version=2017-08-01&format=text: Attempt #1 Mar 19 11:41:27.952288 coreos-metadata[1688]: Mar 19 11:41:27.952 INFO Fetch successful Mar 19 11:41:27.964789 sshd_keygen[1710]: ssh-keygen: generating new host keys: RSA ECDSA ED25519 Mar 19 11:41:27.979021 setup-nvidia[1698]: Downloading Flatcar Container Linux Developer Container for version: 4230.1.0 Mar 19 11:41:27.989129 systemd[1]: Finished sshd-keygen.service - Generate sshd host keys. Mar 19 11:41:27.994086 systemd[1]: Starting issuegen.service - Generate /run/issue... Mar 19 11:41:28.002156 systemd[1]: Starting waagent.service - Microsoft Azure Linux Agent... Mar 19 11:41:28.006991 systemd[1]: Finished coreos-metadata.service - Flatcar Metadata Agent. Mar 19 11:41:28.012660 systemd[1]: issuegen.service: Deactivated successfully. Mar 19 11:41:28.013157 systemd[1]: Finished issuegen.service - Generate /run/issue. Mar 19 11:41:28.020630 systemd[1]: packet-phone-home.service - Report Success to Packet was skipped because no trigger condition checks were met. Mar 19 11:41:28.022114 systemd[1]: Starting systemd-user-sessions.service - Permit User Sessions... Mar 19 11:41:28.033774 systemd[1]: Started waagent.service - Microsoft Azure Linux Agent. Mar 19 11:41:28.038869 systemd[1]: Finished systemd-user-sessions.service - Permit User Sessions. Mar 19 11:41:28.047493 systemd[1]: Started getty@tty1.service - Getty on tty1. Mar 19 11:41:28.053251 systemd[1]: Started serial-getty@ttyS0.service - Serial Getty on ttyS0. Mar 19 11:41:28.057814 systemd[1]: Reached target getty.target - Login Prompts. Mar 19 11:41:28.137850 locksmithd[1814]: locksmithd starting currentOperation="UPDATE_STATUS_IDLE" strategy="reboot" Mar 19 11:41:29.131308 setup-nvidia[1857]: % Total % Received % Xferd Average Speed Time Time Time Current Mar 19 11:41:29.131644 setup-nvidia[1857]: Dload Upload Total Spent Left Speed Mar 19 11:41:29.180520 containerd[1727]: time="2025-03-19T11:41:29.180433900Z" level=info msg="starting containerd" revision=9b2ad7760328148397346d10c7b2004271249db4 version=v1.7.23 Mar 19 11:41:29.200685 containerd[1727]: time="2025-03-19T11:41:29.200623300Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.aufs\"..." type=io.containerd.snapshotter.v1 Mar 19 11:41:29.202295 containerd[1727]: time="2025-03-19T11:41:29.202260900Z" level=info msg="skip loading plugin \"io.containerd.snapshotter.v1.aufs\"..." error="aufs is not supported (modprobe aufs failed: exit status 1 \"modprobe: FATAL: Module aufs not found in directory /lib/modules/6.6.83-flatcar\\n\"): skip plugin" type=io.containerd.snapshotter.v1 Mar 19 11:41:29.202295 containerd[1727]: time="2025-03-19T11:41:29.202292300Z" level=info msg="loading plugin \"io.containerd.event.v1.exchange\"..." type=io.containerd.event.v1 Mar 19 11:41:29.202361 containerd[1727]: time="2025-03-19T11:41:29.202309900Z" level=info msg="loading plugin \"io.containerd.internal.v1.opt\"..." type=io.containerd.internal.v1 Mar 19 11:41:29.202498 containerd[1727]: time="2025-03-19T11:41:29.202476900Z" level=info msg="loading plugin \"io.containerd.warning.v1.deprecations\"..." type=io.containerd.warning.v1 Mar 19 11:41:29.202530 containerd[1727]: time="2025-03-19T11:41:29.202514400Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.blockfile\"..." type=io.containerd.snapshotter.v1 Mar 19 11:41:29.202631 containerd[1727]: time="2025-03-19T11:41:29.202606900Z" level=info msg="skip loading plugin \"io.containerd.snapshotter.v1.blockfile\"..." error="no scratch file generator: skip plugin" type=io.containerd.snapshotter.v1 Mar 19 11:41:29.202663 containerd[1727]: time="2025-03-19T11:41:29.202628700Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.btrfs\"..." type=io.containerd.snapshotter.v1 Mar 19 11:41:29.202880 containerd[1727]: time="2025-03-19T11:41:29.202856800Z" level=info msg="skip loading plugin \"io.containerd.snapshotter.v1.btrfs\"..." 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" type=io.containerd.snapshotter.v1 Mar 19 11:41:29.202908 containerd[1727]: time="2025-03-19T11:41:29.202878000Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.devmapper\"..." type=io.containerd.snapshotter.v1 Mar 19 11:41:29.202908 containerd[1727]: time="2025-03-19T11:41:29.202893400Z" level=info msg="skip loading plugin \"io.containerd.snapshotter.v1.devmapper\"..." error="devmapper not configured: skip plugin" type=io.containerd.snapshotter.v1 Mar 19 11:41:29.202908 containerd[1727]: time="2025-03-19T11:41:29.202903400Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.native\"..." type=io.containerd.snapshotter.v1 Mar 19 11:41:29.203028 containerd[1727]: time="2025-03-19T11:41:29.203005100Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.overlayfs\"..." type=io.containerd.snapshotter.v1 Mar 19 11:41:29.203293 containerd[1727]: time="2025-03-19T11:41:29.203268700Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.zfs\"..." type=io.containerd.snapshotter.v1 Mar 19 11:41:29.203430 containerd[1727]: time="2025-03-19T11:41:29.203408500Z" level=info msg="skip loading plugin \"io.containerd.snapshotter.v1.zfs\"..." error="path /var/lib/containerd/io.containerd.snapshotter.v1.zfs must be a zfs filesystem to be used with the zfs snapshotter: skip plugin" type=io.containerd.snapshotter.v1 Mar 19 11:41:29.203458 containerd[1727]: time="2025-03-19T11:41:29.203428600Z" level=info msg="loading plugin \"io.containerd.content.v1.content\"..." type=io.containerd.content.v1 Mar 19 11:41:29.203563 containerd[1727]: time="2025-03-19T11:41:29.203541500Z" level=info msg="loading plugin \"io.containerd.metadata.v1.bolt\"..." type=io.containerd.metadata.v1 Mar 19 11:41:29.203634 containerd[1727]: time="2025-03-19T11:41:29.203614600Z" level=info msg="metadata content store policy set" policy=shared Mar 19 11:41:29.228614 containerd[1727]: time="2025-03-19T11:41:29.228544400Z" level=info msg="loading plugin \"io.containerd.gc.v1.scheduler\"..." type=io.containerd.gc.v1 Mar 19 11:41:29.228614 containerd[1727]: time="2025-03-19T11:41:29.228615300Z" level=info msg="loading plugin \"io.containerd.differ.v1.walking\"..." type=io.containerd.differ.v1 Mar 19 11:41:29.229048 containerd[1727]: time="2025-03-19T11:41:29.228635500Z" level=info msg="loading plugin \"io.containerd.lease.v1.manager\"..." type=io.containerd.lease.v1 Mar 19 11:41:29.229048 containerd[1727]: time="2025-03-19T11:41:29.228678700Z" level=info msg="loading plugin \"io.containerd.streaming.v1.manager\"..." type=io.containerd.streaming.v1 Mar 19 11:41:29.229048 containerd[1727]: time="2025-03-19T11:41:29.228699100Z" level=info msg="loading plugin \"io.containerd.runtime.v1.linux\"..." type=io.containerd.runtime.v1 Mar 19 11:41:29.229048 containerd[1727]: time="2025-03-19T11:41:29.228909900Z" level=info msg="loading plugin \"io.containerd.monitor.v1.cgroups\"..." type=io.containerd.monitor.v1 Mar 19 11:41:29.229232 containerd[1727]: time="2025-03-19T11:41:29.229193100Z" level=info msg="loading plugin \"io.containerd.runtime.v2.task\"..." type=io.containerd.runtime.v2 Mar 19 11:41:29.229426 containerd[1727]: time="2025-03-19T11:41:29.229398800Z" level=info msg="loading plugin \"io.containerd.runtime.v2.shim\"..." type=io.containerd.runtime.v2 Mar 19 11:41:29.229461 containerd[1727]: time="2025-03-19T11:41:29.229427100Z" level=info msg="loading plugin \"io.containerd.sandbox.store.v1.local\"..." type=io.containerd.sandbox.store.v1 Mar 19 11:41:29.229461 containerd[1727]: time="2025-03-19T11:41:29.229443800Z" level=info msg="loading plugin \"io.containerd.sandbox.controller.v1.local\"..." type=io.containerd.sandbox.controller.v1 Mar 19 11:41:29.229507 containerd[1727]: time="2025-03-19T11:41:29.229471200Z" level=info msg="loading plugin \"io.containerd.service.v1.containers-service\"..." type=io.containerd.service.v1 Mar 19 11:41:29.229507 containerd[1727]: time="2025-03-19T11:41:29.229490300Z" level=info msg="loading plugin \"io.containerd.service.v1.content-service\"..." type=io.containerd.service.v1 Mar 19 11:41:29.229507 containerd[1727]: time="2025-03-19T11:41:29.229503800Z" level=info msg="loading plugin \"io.containerd.service.v1.diff-service\"..." type=io.containerd.service.v1 Mar 19 11:41:29.229576 containerd[1727]: time="2025-03-19T11:41:29.229518700Z" level=info msg="loading plugin \"io.containerd.service.v1.images-service\"..." type=io.containerd.service.v1 Mar 19 11:41:29.229576 containerd[1727]: time="2025-03-19T11:41:29.229534400Z" level=info msg="loading plugin \"io.containerd.service.v1.introspection-service\"..." type=io.containerd.service.v1 Mar 19 11:41:29.229576 containerd[1727]: time="2025-03-19T11:41:29.229548500Z" level=info msg="loading plugin \"io.containerd.service.v1.namespaces-service\"..." type=io.containerd.service.v1 Mar 19 11:41:29.229576 containerd[1727]: time="2025-03-19T11:41:29.229562000Z" level=info msg="loading plugin \"io.containerd.service.v1.snapshots-service\"..." type=io.containerd.service.v1 Mar 19 11:41:29.229666 containerd[1727]: time="2025-03-19T11:41:29.229577000Z" level=info msg="loading plugin \"io.containerd.service.v1.tasks-service\"..." type=io.containerd.service.v1 Mar 19 11:41:29.229666 containerd[1727]: time="2025-03-19T11:41:29.229598100Z" level=info msg="loading plugin \"io.containerd.grpc.v1.containers\"..." type=io.containerd.grpc.v1 Mar 19 11:41:29.229666 containerd[1727]: time="2025-03-19T11:41:29.229614000Z" level=info msg="loading plugin \"io.containerd.grpc.v1.content\"..." type=io.containerd.grpc.v1 Mar 19 11:41:29.229666 containerd[1727]: time="2025-03-19T11:41:29.229626300Z" level=info msg="loading plugin \"io.containerd.grpc.v1.diff\"..." type=io.containerd.grpc.v1 Mar 19 11:41:29.229666 containerd[1727]: time="2025-03-19T11:41:29.229639600Z" level=info msg="loading plugin \"io.containerd.grpc.v1.events\"..." type=io.containerd.grpc.v1 Mar 19 11:41:29.229666 containerd[1727]: time="2025-03-19T11:41:29.229651600Z" level=info msg="loading plugin \"io.containerd.grpc.v1.images\"..." type=io.containerd.grpc.v1 Mar 19 11:41:29.229666 containerd[1727]: time="2025-03-19T11:41:29.229665500Z" level=info msg="loading plugin \"io.containerd.grpc.v1.introspection\"..." type=io.containerd.grpc.v1 Mar 19 11:41:29.229847 containerd[1727]: time="2025-03-19T11:41:29.229677600Z" level=info msg="loading plugin \"io.containerd.grpc.v1.leases\"..." type=io.containerd.grpc.v1 Mar 19 11:41:29.229847 containerd[1727]: time="2025-03-19T11:41:29.229690900Z" level=info msg="loading plugin \"io.containerd.grpc.v1.namespaces\"..." type=io.containerd.grpc.v1 Mar 19 11:41:29.229847 containerd[1727]: time="2025-03-19T11:41:29.229714700Z" level=info msg="loading plugin \"io.containerd.grpc.v1.sandbox-controllers\"..." type=io.containerd.grpc.v1 Mar 19 11:41:29.229847 containerd[1727]: time="2025-03-19T11:41:29.229733400Z" level=info msg="loading plugin \"io.containerd.grpc.v1.sandboxes\"..." type=io.containerd.grpc.v1 Mar 19 11:41:29.229847 containerd[1727]: time="2025-03-19T11:41:29.229766900Z" level=info msg="loading plugin \"io.containerd.grpc.v1.snapshots\"..." type=io.containerd.grpc.v1 Mar 19 11:41:29.229847 containerd[1727]: time="2025-03-19T11:41:29.229780000Z" level=info msg="loading plugin \"io.containerd.grpc.v1.streaming\"..." type=io.containerd.grpc.v1 Mar 19 11:41:29.229847 containerd[1727]: time="2025-03-19T11:41:29.229793000Z" level=info msg="loading plugin \"io.containerd.grpc.v1.tasks\"..." type=io.containerd.grpc.v1 Mar 19 11:41:29.229847 containerd[1727]: time="2025-03-19T11:41:29.229807500Z" level=info msg="loading plugin \"io.containerd.transfer.v1.local\"..." type=io.containerd.transfer.v1 Mar 19 11:41:29.229847 containerd[1727]: time="2025-03-19T11:41:29.229828100Z" level=info msg="loading plugin \"io.containerd.grpc.v1.transfer\"..." type=io.containerd.grpc.v1 Mar 19 11:41:29.229847 containerd[1727]: time="2025-03-19T11:41:29.229841900Z" level=info msg="loading plugin \"io.containerd.grpc.v1.version\"..." type=io.containerd.grpc.v1 Mar 19 11:41:29.230045 containerd[1727]: time="2025-03-19T11:41:29.229853700Z" level=info msg="loading plugin \"io.containerd.internal.v1.restart\"..." type=io.containerd.internal.v1 Mar 19 11:41:29.230045 containerd[1727]: time="2025-03-19T11:41:29.229902100Z" level=info msg="loading plugin \"io.containerd.tracing.processor.v1.otlp\"..." type=io.containerd.tracing.processor.v1 Mar 19 11:41:29.230045 containerd[1727]: time="2025-03-19T11:41:29.229922700Z" level=info msg="skip loading plugin \"io.containerd.tracing.processor.v1.otlp\"..." error="skip plugin: tracing endpoint not configured" type=io.containerd.tracing.processor.v1 Mar 19 11:41:29.230045 containerd[1727]: time="2025-03-19T11:41:29.229934100Z" level=info msg="loading plugin \"io.containerd.internal.v1.tracing\"..." type=io.containerd.internal.v1 Mar 19 11:41:29.230045 containerd[1727]: time="2025-03-19T11:41:29.229947000Z" level=info msg="skip loading plugin \"io.containerd.internal.v1.tracing\"..." error="skip plugin: tracing endpoint not configured" type=io.containerd.internal.v1 Mar 19 11:41:29.230045 containerd[1727]: time="2025-03-19T11:41:29.229957200Z" level=info msg="loading plugin \"io.containerd.grpc.v1.healthcheck\"..." type=io.containerd.grpc.v1 Mar 19 11:41:29.230045 containerd[1727]: time="2025-03-19T11:41:29.229969700Z" level=info msg="loading plugin \"io.containerd.nri.v1.nri\"..." type=io.containerd.nri.v1 Mar 19 11:41:29.230045 containerd[1727]: time="2025-03-19T11:41:29.229979800Z" level=info msg="NRI interface is disabled by configuration." Mar 19 11:41:29.230045 containerd[1727]: time="2025-03-19T11:41:29.229991200Z" level=info msg="loading plugin \"io.containerd.grpc.v1.cri\"..." type=io.containerd.grpc.v1 Mar 19 11:41:29.230300 containerd[1727]: time="2025-03-19T11:41:29.230240600Z" level=info msg="Start cri plugin with config {PluginConfig:{ContainerdConfig:{Snapshotter:overlayfs DefaultRuntimeName:runc DefaultRuntime:{Type: Path: Engine: PodAnnotations:[] ContainerAnnotations:[] Root: Options:map[] PrivilegedWithoutHostDevices:false PrivilegedWithoutHostDevicesAllDevicesAllowed:false BaseRuntimeSpec: NetworkPluginConfDir: NetworkPluginMaxConfNum:0 Snapshotter: SandboxMode:} UntrustedWorkloadRuntime:{Type: Path: Engine: PodAnnotations:[] ContainerAnnotations:[] Root: Options:map[] PrivilegedWithoutHostDevices:false PrivilegedWithoutHostDevicesAllDevicesAllowed:false BaseRuntimeSpec: NetworkPluginConfDir: NetworkPluginMaxConfNum:0 Snapshotter: SandboxMode:} Runtimes:map[runc:{Type:io.containerd.runc.v2 Path: Engine: PodAnnotations:[] ContainerAnnotations:[] Root: Options:map[SystemdCgroup:true] PrivilegedWithoutHostDevices:false PrivilegedWithoutHostDevicesAllDevicesAllowed:false BaseRuntimeSpec: NetworkPluginConfDir: NetworkPluginMaxConfNum:0 Snapshotter: SandboxMode:podsandbox}] NoPivot:false DisableSnapshotAnnotations:true DiscardUnpackedLayers:false IgnoreBlockIONotEnabledErrors:false IgnoreRdtNotEnabledErrors:false} CniConfig:{NetworkPluginBinDir:/opt/cni/bin NetworkPluginConfDir:/etc/cni/net.d NetworkPluginMaxConfNum:1 NetworkPluginSetupSerially:false NetworkPluginConfTemplate: IPPreference:} Registry:{ConfigPath: Mirrors:map[] Configs:map[] Auths:map[] Headers:map[]} ImageDecryption:{KeyModel:node} DisableTCPService:true StreamServerAddress:127.0.0.1 StreamServerPort:0 StreamIdleTimeout:4h0m0s EnableSelinux:true SelinuxCategoryRange:1024 SandboxImage:registry.k8s.io/pause:3.8 StatsCollectPeriod:10 SystemdCgroup:false EnableTLSStreaming:false X509KeyPairStreaming:{TLSCertFile: TLSKeyFile:} MaxContainerLogLineSize:16384 DisableCgroup:false DisableApparmor:false RestrictOOMScoreAdj:false MaxConcurrentDownloads:3 DisableProcMount:false UnsetSeccompProfile: TolerateMissingHugetlbController:true DisableHugetlbController:true DeviceOwnershipFromSecurityContext:false IgnoreImageDefinedVolumes:false NetNSMountsUnderStateDir:false EnableUnprivilegedPorts:false EnableUnprivilegedICMP:false EnableCDI:false CDISpecDirs:[/etc/cdi /var/run/cdi] ImagePullProgressTimeout:5m0s DrainExecSyncIOTimeout:0s ImagePullWithSyncFs:false IgnoreDeprecationWarnings:[]} ContainerdRootDir:/var/lib/containerd ContainerdEndpoint:/run/containerd/containerd.sock RootDir:/var/lib/containerd/io.containerd.grpc.v1.cri StateDir:/run/containerd/io.containerd.grpc.v1.cri}" Mar 19 11:41:29.230442 containerd[1727]: time="2025-03-19T11:41:29.230304600Z" level=info msg="Connect containerd service" Mar 19 11:41:29.230442 containerd[1727]: time="2025-03-19T11:41:29.230344600Z" level=info msg="using legacy CRI server" Mar 19 11:41:29.230442 containerd[1727]: time="2025-03-19T11:41:29.230355500Z" level=info msg="using experimental NRI integration - disable nri plugin to prevent this" Mar 19 11:41:29.230712 containerd[1727]: time="2025-03-19T11:41:29.230678500Z" level=info msg="Get image filesystem path \"/var/lib/containerd/io.containerd.snapshotter.v1.overlayfs\"" Mar 19 11:41:29.231810 containerd[1727]: time="2025-03-19T11:41:29.231779600Z" level=error msg="failed to load cni during init, please check CRI plugin status before setting up network for pods" error="cni config load failed: no network config found in /etc/cni/net.d: cni plugin not initialized: failed to load cni config" Mar 19 11:41:29.231952 containerd[1727]: time="2025-03-19T11:41:29.231912000Z" level=info msg="Start subscribing containerd event" Mar 19 11:41:29.232002 containerd[1727]: time="2025-03-19T11:41:29.231982000Z" level=info msg="Start recovering state" Mar 19 11:41:29.232065 containerd[1727]: time="2025-03-19T11:41:29.232048700Z" level=info msg="Start event monitor" Mar 19 11:41:29.232102 containerd[1727]: time="2025-03-19T11:41:29.232074700Z" level=info msg="Start snapshots syncer" Mar 19 11:41:29.232102 containerd[1727]: time="2025-03-19T11:41:29.232084300Z" level=info msg="Start cni network conf syncer for default" Mar 19 11:41:29.232102 containerd[1727]: time="2025-03-19T11:41:29.232091700Z" level=info msg="Start streaming server" Mar 19 11:41:29.232215 containerd[1727]: time="2025-03-19T11:41:29.232099900Z" level=info msg=serving... address=/run/containerd/containerd.sock.ttrpc Mar 19 11:41:29.232215 containerd[1727]: time="2025-03-19T11:41:29.232169600Z" level=info msg=serving... address=/run/containerd/containerd.sock Mar 19 11:41:29.232260 containerd[1727]: time="2025-03-19T11:41:29.232232700Z" level=info msg="containerd successfully booted in 0.052790s" Mar 19 11:41:29.232331 systemd[1]: Started containerd.service - containerd container runtime. Mar 19 11:41:30.711204 waagent[1843]: 2025-03-19T11:41:30.711102Z INFO Daemon Daemon Azure Linux Agent Version: 2.9.1.1 Mar 19 11:41:30.715534 waagent[1843]: 2025-03-19T11:41:30.715477Z INFO Daemon Daemon OS: flatcar 4230.1.0 Mar 19 11:41:30.719003 waagent[1843]: 2025-03-19T11:41:30.718951Z INFO Daemon Daemon Python: 3.11.11 Mar 19 11:41:30.722690 waagent[1843]: 2025-03-19T11:41:30.722629Z INFO Daemon Daemon Run daemon Mar 19 11:41:30.725831 waagent[1843]: 2025-03-19T11:41:30.725768Z INFO Daemon Daemon No RDMA handler exists for distro='Flatcar Container Linux by Kinvolk' version='4230.1.0' Mar 19 11:41:30.732132 waagent[1843]: 2025-03-19T11:41:30.732071Z INFO Daemon Daemon Using waagent for provisioning Mar 19 11:41:30.736418 waagent[1843]: 2025-03-19T11:41:30.736356Z INFO Daemon Daemon Activate resource disk Mar 19 11:41:30.739956 waagent[1843]: 2025-03-19T11:41:30.739862Z INFO Daemon Daemon Searching gen1 prefix 00000000-0001 or gen2 f8b3781a-1e82-4818-a1c3-63d806ec15bb Mar 19 11:41:30.746648 waagent[1843]: 2025-03-19T11:41:30.746573Z INFO Daemon Daemon Found device: sdb Mar 19 11:41:30.755925 waagent[1843]: 2025-03-19T11:41:30.755856Z INFO Daemon Daemon Examining partition table Mar 19 11:41:30.784620 waagent[1843]: 2025-03-19T11:41:30.784534Z INFO Daemon Daemon GPT not detected, determining filesystem Mar 19 11:41:30.847099 waagent[1843]: 2025-03-19T11:41:30.847001Z INFO Daemon Daemon sfdisk --part-type -f /dev/sdb 1 -n succeeded Mar 19 11:41:30.860072 waagent[1843]: 2025-03-19T11:41:30.859962Z INFO Daemon Daemon The partition is formatted with ntfs, updating partition type to 83 Mar 19 11:41:31.248765 kernel: sdb: sdb1 Mar 19 11:41:31.269963 waagent[1843]: 2025-03-19T11:41:31.269859Z INFO Daemon Daemon sfdisk --part-type /dev/sdb 1 83 succeeded Mar 19 11:41:31.283088 waagent[1843]: 2025-03-19T11:41:31.283028Z INFO Daemon Daemon Format partition [mkfs.ext4 -F /dev/sdb1] Mar 19 11:41:36.158714 login[1845]: pam_lastlog(login:session): file /var/log/lastlog is locked/write, retrying Mar 19 11:41:36.160558 login[1846]: pam_unix(login:session): session opened for user core(uid=500) by LOGIN(uid=0) Mar 19 11:41:36.171527 systemd-logind[1706]: New session 2 of user core. Mar 19 11:41:36.172592 systemd[1]: Created slice user-500.slice - User Slice of UID 500. Mar 19 11:41:36.182978 systemd[1]: Starting user-runtime-dir@500.service - User Runtime Directory /run/user/500... Mar 19 11:41:36.269630 systemd[1]: Finished user-runtime-dir@500.service - User Runtime Directory /run/user/500. Mar 19 11:41:36.281095 systemd[1]: Starting user@500.service - User Manager for UID 500... Mar 19 11:41:36.316694 (systemd)[1912]: pam_unix(systemd-user:session): session opened for user core(uid=500) by (uid=0) Mar 19 11:41:36.319229 systemd-logind[1706]: New session c1 of user core. Mar 19 11:41:37.066134 waagent[1843]: 2025-03-19T11:41:37.066031Z INFO Daemon Daemon Mount resource disk [mount -t ext4 /dev/sdb1 /mnt/resource] Mar 19 11:41:37.086768 kernel: EXT4-fs (sdb1): mounted filesystem 9f84ae80-281b-411b-af23-828b744ecf5d r/w with ordered data mode. Quota mode: none. Mar 19 11:41:37.086857 waagent[1843]: 2025-03-19T11:41:37.086769Z INFO Daemon Daemon Resource disk /dev/sdb is mounted at /mnt/resource with ext4 Mar 19 11:41:37.092125 waagent[1843]: 2025-03-19T11:41:37.088992Z INFO Daemon Daemon Clean protocol and wireserver endpoint Mar 19 11:41:37.092125 waagent[1843]: 2025-03-19T11:41:37.090651Z INFO Daemon Daemon Running default provisioning handler Mar 19 11:41:37.101435 waagent[1843]: 2025-03-19T11:41:37.100267Z INFO Daemon Daemon Unable to get cloud-init enabled status from systemctl: Command '['systemctl', 'is-enabled', 'cloud-init-local.service']' returned non-zero exit status 4. Mar 19 11:41:37.103689 waagent[1843]: 2025-03-19T11:41:37.103621Z INFO Daemon Daemon Unable to get cloud-init enabled status from service: [Errno 2] No such file or directory: 'service' Mar 19 11:41:37.105357 waagent[1843]: 2025-03-19T11:41:37.105284Z INFO Daemon Daemon cloud-init is enabled: False Mar 19 11:41:37.107529 waagent[1843]: 2025-03-19T11:41:37.106829Z INFO Daemon Daemon Copying ovf-env.xml Mar 19 11:41:37.122165 waagent[1843]: 2025-03-19T11:41:37.122082Z INFO Daemon Daemon Successfully mounted dvd Mar 19 11:41:37.137345 systemd[1]: mnt-cdrom-secure.mount: Deactivated successfully. Mar 19 11:41:37.142319 waagent[1843]: 2025-03-19T11:41:37.142250Z INFO Daemon Daemon Detect protocol endpoint Mar 19 11:41:37.143994 waagent[1843]: 2025-03-19T11:41:37.143936Z INFO Daemon Daemon Clean protocol and wireserver endpoint Mar 19 11:41:37.144713 waagent[1843]: 2025-03-19T11:41:37.144669Z INFO Daemon Daemon WireServer endpoint is not found. Rerun dhcp handler Mar 19 11:41:37.145390 waagent[1843]: 2025-03-19T11:41:37.145351Z INFO Daemon Daemon Test for route to 168.63.129.16 Mar 19 11:41:37.147713 waagent[1843]: 2025-03-19T11:41:37.147662Z INFO Daemon Daemon Route to 168.63.129.16 exists Mar 19 11:41:37.148287 waagent[1843]: 2025-03-19T11:41:37.148247Z INFO Daemon Daemon Wire server endpoint:168.63.129.16 Mar 19 11:41:37.159080 login[1845]: pam_unix(login:session): session opened for user core(uid=500) by LOGIN(uid=0) Mar 19 11:41:37.163397 systemd-logind[1706]: New session 1 of user core. Mar 19 11:41:37.194208 systemd[1912]: Queued start job for default target default.target. Mar 19 11:41:37.210032 systemd[1912]: Created slice app.slice - User Application Slice. Mar 19 11:41:37.210081 systemd[1912]: Reached target paths.target - Paths. Mar 19 11:41:37.210134 systemd[1912]: Reached target timers.target - Timers. Mar 19 11:41:37.211487 systemd[1912]: Starting dbus.socket - D-Bus User Message Bus Socket... Mar 19 11:41:37.223087 systemd[1912]: Listening on dbus.socket - D-Bus User Message Bus Socket. Mar 19 11:41:37.223223 systemd[1912]: Reached target sockets.target - Sockets. Mar 19 11:41:37.223281 systemd[1912]: Reached target basic.target - Basic System. Mar 19 11:41:37.223374 systemd[1912]: Reached target default.target - Main User Target. Mar 19 11:41:37.223416 systemd[1912]: Startup finished in 897ms. Mar 19 11:41:37.223435 systemd[1]: Started user@500.service - User Manager for UID 500. Mar 19 11:41:37.225023 systemd[1]: Started session-1.scope - Session 1 of User core. Mar 19 11:41:37.225550 waagent[1843]: 2025-03-19T11:41:37.225504Z INFO Daemon Daemon Fabric preferred wire protocol version:2015-04-05 Mar 19 11:41:37.225797 systemd[1]: Started session-2.scope - Session 2 of User core. Mar 19 11:41:37.227328 waagent[1843]: 2025-03-19T11:41:37.227296Z INFO Daemon Daemon Wire protocol version:2012-11-30 Mar 19 11:41:37.229451 waagent[1843]: 2025-03-19T11:41:37.229396Z INFO Daemon Daemon Server preferred version:2015-04-05 Mar 19 11:41:37.422809 waagent[1843]: 2025-03-19T11:41:37.422677Z INFO Daemon Daemon Initializing goal state during protocol detection Mar 19 11:41:37.424577 waagent[1843]: 2025-03-19T11:41:37.424510Z INFO Daemon Daemon Forcing an update of the goal state. Mar 19 11:41:37.430180 waagent[1843]: 2025-03-19T11:41:37.430127Z INFO Daemon Fetched a new incarnation for the WireServer goal state [incarnation 1] Mar 19 11:41:37.465168 waagent[1843]: 2025-03-19T11:41:37.465098Z INFO Daemon Daemon HostGAPlugin version: 1.0.8.164 Mar 19 11:41:37.467275 waagent[1843]: 2025-03-19T11:41:37.467225Z INFO Daemon Mar 19 11:41:37.467557 waagent[1843]: 2025-03-19T11:41:37.467516Z INFO Daemon Fetched new vmSettings [HostGAPlugin correlation ID: ed62e3ca-1935-4d91-9c46-99415606b738 eTag: 17694932521304504561 source: Fabric] Mar 19 11:41:37.469270 waagent[1843]: 2025-03-19T11:41:37.469223Z INFO Daemon The vmSettings originated via Fabric; will ignore them. Mar 19 11:41:37.470327 waagent[1843]: 2025-03-19T11:41:37.470275Z INFO Daemon Mar 19 11:41:37.470497 waagent[1843]: 2025-03-19T11:41:37.470458Z INFO Daemon Fetching full goal state from the WireServer [incarnation 1] Mar 19 11:41:37.476040 waagent[1843]: 2025-03-19T11:41:37.475989Z INFO Daemon Daemon Downloading artifacts profile blob Mar 19 11:41:37.633249 waagent[1843]: 2025-03-19T11:41:37.633144Z INFO Daemon Downloaded certificate {'thumbprint': 'C51E35E32F91015377A4C186BE86C91093BD3271', 'hasPrivateKey': True} Mar 19 11:41:37.635320 waagent[1843]: 2025-03-19T11:41:37.635266Z INFO Daemon Downloaded certificate {'thumbprint': '9B8053F512822F1881B672A01C6C2F60583D298D', 'hasPrivateKey': False} Mar 19 11:41:37.636705 waagent[1843]: 2025-03-19T11:41:37.636659Z INFO Daemon Fetch goal state completed Mar 19 11:41:37.677796 waagent[1843]: 2025-03-19T11:41:37.677653Z INFO Daemon Daemon Starting provisioning Mar 19 11:41:37.679621 waagent[1843]: 2025-03-19T11:41:37.679424Z INFO Daemon Daemon Handle ovf-env.xml. Mar 19 11:41:37.680963 waagent[1843]: 2025-03-19T11:41:37.680905Z INFO Daemon Daemon Set hostname [ci-4230.1.0-a-0674828377] Mar 19 11:41:37.690872 waagent[1843]: 2025-03-19T11:41:37.690795Z INFO Daemon Daemon Publish hostname [ci-4230.1.0-a-0674828377] Mar 19 11:41:37.693107 waagent[1843]: 2025-03-19T11:41:37.692998Z INFO Daemon Daemon Examine /proc/net/route for primary interface Mar 19 11:41:37.695126 waagent[1843]: 2025-03-19T11:41:37.695022Z INFO Daemon Daemon Primary interface is [eth0] Mar 19 11:41:37.711390 systemd-networkd[1400]: eth0: found matching network '/usr/lib/systemd/network/zz-default.network', based on potentially unpredictable interface name. Mar 19 11:41:37.711401 systemd-networkd[1400]: eth0: Configuring with /usr/lib/systemd/network/zz-default.network. Mar 19 11:41:37.711435 systemd-networkd[1400]: eth0: DHCP lease lost Mar 19 11:41:37.711871 waagent[1843]: 2025-03-19T11:41:37.711798Z INFO Daemon Daemon Create user account if not exists Mar 19 11:41:37.713452 waagent[1843]: 2025-03-19T11:41:37.713393Z INFO Daemon Daemon User core already exists, skip useradd Mar 19 11:41:37.714797 waagent[1843]: 2025-03-19T11:41:37.714751Z INFO Daemon Daemon Configure sudoer Mar 19 11:41:37.715827 waagent[1843]: 2025-03-19T11:41:37.715775Z INFO Daemon Daemon Configure sshd Mar 19 11:41:37.716400 waagent[1843]: 2025-03-19T11:41:37.716349Z INFO Daemon Daemon Added a configuration snippet disabling SSH password-based authentication methods. It also configures SSH client probing to keep connections alive. Mar 19 11:41:37.717604 waagent[1843]: 2025-03-19T11:41:37.717559Z INFO Daemon Daemon Deploy ssh public key. Mar 19 11:41:37.786807 systemd-networkd[1400]: eth0: DHCPv4 address 10.200.8.11/24, gateway 10.200.8.1 acquired from 168.63.129.16 Mar 19 11:41:37.835607 waagent[1843]: 2025-03-19T11:41:37.835510Z INFO Daemon Daemon Decode custom data Mar 19 11:41:37.837415 waagent[1843]: 2025-03-19T11:41:37.837349Z INFO Daemon Daemon Save custom data Mar 19 11:41:38.924129 waagent[1843]: 2025-03-19T11:41:38.924062Z INFO Daemon Daemon Provisioning complete Mar 19 11:41:38.934810 waagent[1843]: 2025-03-19T11:41:38.934654Z INFO Daemon Daemon RDMA capabilities are not enabled, skipping Mar 19 11:41:38.936758 waagent[1843]: 2025-03-19T11:41:38.936695Z INFO Daemon Daemon End of log to /dev/console. The agent will now check for updates and then will process extensions. Mar 19 11:41:38.937470 waagent[1843]: 2025-03-19T11:41:38.937423Z INFO Daemon Daemon Installed Agent WALinuxAgent-2.9.1.1 is the most current agent Mar 19 11:41:39.109948 waagent[1975]: 2025-03-19T11:41:39.109838Z INFO ExtHandler ExtHandler Azure Linux Agent (Goal State Agent version 2.9.1.1) Mar 19 11:41:39.110352 waagent[1975]: 2025-03-19T11:41:39.110009Z INFO ExtHandler ExtHandler OS: flatcar 4230.1.0 Mar 19 11:41:39.110352 waagent[1975]: 2025-03-19T11:41:39.110090Z INFO ExtHandler ExtHandler Python: 3.11.11 Mar 19 11:41:39.181198 waagent[1975]: 2025-03-19T11:41:39.181030Z INFO ExtHandler ExtHandler Distro: flatcar-4230.1.0; OSUtil: FlatcarUtil; AgentService: waagent; Python: 3.11.11; systemd: True; LISDrivers: Absent; logrotate: logrotate 3.20.1; Mar 19 11:41:39.181356 waagent[1975]: 2025-03-19T11:41:39.181311Z INFO ExtHandler ExtHandler WireServer endpoint 168.63.129.16 read from file Mar 19 11:41:39.181444 waagent[1975]: 2025-03-19T11:41:39.181405Z INFO ExtHandler ExtHandler Wire server endpoint:168.63.129.16 Mar 19 11:41:39.189617 waagent[1975]: 2025-03-19T11:41:39.189542Z INFO ExtHandler Fetched a new incarnation for the WireServer goal state [incarnation 1] Mar 19 11:41:39.195560 waagent[1975]: 2025-03-19T11:41:39.195502Z INFO ExtHandler ExtHandler HostGAPlugin version: 1.0.8.164 Mar 19 11:41:39.196112 waagent[1975]: 2025-03-19T11:41:39.196065Z INFO ExtHandler Mar 19 11:41:39.196204 waagent[1975]: 2025-03-19T11:41:39.196165Z INFO ExtHandler Fetched new vmSettings [HostGAPlugin correlation ID: c64a2175-edd3-4bb4-bcb8-b4d85d0b97ea eTag: 17694932521304504561 source: Fabric] Mar 19 11:41:39.196615 waagent[1975]: 2025-03-19T11:41:39.196561Z INFO ExtHandler The vmSettings originated via Fabric; will ignore them. Mar 19 11:41:39.197314 waagent[1975]: 2025-03-19T11:41:39.197266Z INFO ExtHandler Mar 19 11:41:39.197399 waagent[1975]: 2025-03-19T11:41:39.197362Z INFO ExtHandler Fetching full goal state from the WireServer [incarnation 1] Mar 19 11:41:39.201105 waagent[1975]: 2025-03-19T11:41:39.201052Z INFO ExtHandler ExtHandler Downloading artifacts profile blob Mar 19 11:41:39.293451 waagent[1975]: 2025-03-19T11:41:39.293352Z INFO ExtHandler Downloaded certificate {'thumbprint': 'C51E35E32F91015377A4C186BE86C91093BD3271', 'hasPrivateKey': True} Mar 19 11:41:39.293961 waagent[1975]: 2025-03-19T11:41:39.293909Z INFO ExtHandler Downloaded certificate {'thumbprint': '9B8053F512822F1881B672A01C6C2F60583D298D', 'hasPrivateKey': False} Mar 19 11:41:39.294449 waagent[1975]: 2025-03-19T11:41:39.294401Z INFO ExtHandler Fetch goal state completed Mar 19 11:41:39.306368 waagent[1975]: 2025-03-19T11:41:39.306304Z INFO ExtHandler ExtHandler WALinuxAgent-2.9.1.1 running as process 1975 Mar 19 11:41:39.306524 waagent[1975]: 2025-03-19T11:41:39.306480Z INFO ExtHandler ExtHandler ******** AutoUpdate.Enabled is set to False, not processing the operation ******** Mar 19 11:41:39.308622 waagent[1975]: 2025-03-19T11:41:39.308567Z INFO ExtHandler ExtHandler Cgroup monitoring is not supported on ['flatcar', '4230.1.0', '', 'Flatcar Container Linux by Kinvolk'] Mar 19 11:41:39.309050 waagent[1975]: 2025-03-19T11:41:39.308998Z INFO ExtHandler ExtHandler Starting setup for Persistent firewall rules Mar 19 11:41:39.342830 waagent[1975]: 2025-03-19T11:41:39.342774Z INFO ExtHandler ExtHandler Firewalld service not running/unavailable, trying to set up waagent-network-setup.service Mar 19 11:41:39.343075 waagent[1975]: 2025-03-19T11:41:39.343017Z INFO ExtHandler ExtHandler Successfully updated the Binary file /var/lib/waagent/waagent-network-setup.py for firewall setup Mar 19 11:41:39.353643 waagent[1975]: 2025-03-19T11:41:39.353594Z INFO ExtHandler ExtHandler Service: waagent-network-setup.service not enabled. Adding it now Mar 19 11:41:39.361980 systemd[1]: Reload requested from client PID 1990 ('systemctl') (unit waagent.service)... Mar 19 11:41:39.361998 systemd[1]: Reloading... Mar 19 11:41:39.441857 zram_generator::config[2030]: No configuration found. Mar 19 11:41:39.596711 systemd[1]: /usr/lib/systemd/system/docker.socket:6: ListenStream= references a path below legacy directory /var/run/, updating /var/run/docker.sock → /run/docker.sock; please update the unit file accordingly. Mar 19 11:41:39.753773 systemd[1]: Reloading finished in 391 ms. Mar 19 11:41:39.766377 waagent[1975]: 2025-03-19T11:41:39.766287Z INFO ExtHandler ExtHandler Executing systemctl daemon-reload for setting up waagent-network-setup.service Mar 19 11:41:39.772439 systemd[1]: Reload requested from client PID 2087 ('systemctl') (unit waagent.service)... Mar 19 11:41:39.772456 systemd[1]: Reloading... Mar 19 11:41:39.838770 zram_generator::config[2130]: No configuration found. Mar 19 11:41:39.980257 systemd[1]: /usr/lib/systemd/system/docker.socket:6: ListenStream= references a path below legacy directory /var/run/, updating /var/run/docker.sock → /run/docker.sock; please update the unit file accordingly. Mar 19 11:41:40.126275 systemd[1]: Reloading finished in 353 ms. Mar 19 11:41:40.141551 waagent[1975]: 2025-03-19T11:41:40.141465Z INFO ExtHandler ExtHandler Successfully added and enabled the waagent-network-setup.service Mar 19 11:41:40.141880 waagent[1975]: 2025-03-19T11:41:40.141639Z INFO ExtHandler ExtHandler Persistent firewall rules setup successfully Mar 19 11:41:40.978282 waagent[1975]: 2025-03-19T11:41:40.978182Z INFO ExtHandler ExtHandler DROP rule is not available which implies no firewall rules are set yet. Environment thread will set it up. Mar 19 11:41:40.978902 waagent[1975]: 2025-03-19T11:41:40.978842Z INFO ExtHandler ExtHandler Checking if log collection is allowed at this time [False]. All three conditions must be met: configuration enabled [True], cgroups enabled [False], python supported: [True] Mar 19 11:41:40.979803 waagent[1975]: 2025-03-19T11:41:40.979729Z INFO ExtHandler ExtHandler Starting env monitor service. Mar 19 11:41:40.980197 waagent[1975]: 2025-03-19T11:41:40.980129Z INFO MonitorHandler ExtHandler WireServer endpoint 168.63.129.16 read from file Mar 19 11:41:40.980384 waagent[1975]: 2025-03-19T11:41:40.980326Z INFO ExtHandler ExtHandler Start SendTelemetryHandler service. Mar 19 11:41:40.980678 waagent[1975]: 2025-03-19T11:41:40.980633Z INFO MonitorHandler ExtHandler Wire server endpoint:168.63.129.16 Mar 19 11:41:40.980779 waagent[1975]: 2025-03-19T11:41:40.980712Z INFO EnvHandler ExtHandler WireServer endpoint 168.63.129.16 read from file Mar 19 11:41:40.981226 waagent[1975]: 2025-03-19T11:41:40.981152Z INFO SendTelemetryHandler ExtHandler Successfully started the SendTelemetryHandler thread Mar 19 11:41:40.981396 waagent[1975]: 2025-03-19T11:41:40.981338Z INFO MonitorHandler ExtHandler Monitor.NetworkConfigurationChanges is disabled. Mar 19 11:41:40.981517 waagent[1975]: 2025-03-19T11:41:40.981459Z INFO ExtHandler ExtHandler Start Extension Telemetry service. Mar 19 11:41:40.981843 waagent[1975]: 2025-03-19T11:41:40.981796Z INFO EnvHandler ExtHandler Wire server endpoint:168.63.129.16 Mar 19 11:41:40.982243 waagent[1975]: 2025-03-19T11:41:40.982169Z INFO TelemetryEventsCollector ExtHandler Extension Telemetry pipeline enabled: True Mar 19 11:41:40.982496 waagent[1975]: 2025-03-19T11:41:40.982430Z INFO EnvHandler ExtHandler Configure routes Mar 19 11:41:40.982578 waagent[1975]: 2025-03-19T11:41:40.982528Z INFO ExtHandler ExtHandler Goal State Period: 6 sec. This indicates how often the agent checks for new goal states and reports status. Mar 19 11:41:40.982828 waagent[1975]: 2025-03-19T11:41:40.982784Z INFO EnvHandler ExtHandler Gateway:None Mar 19 11:41:40.982931 waagent[1975]: 2025-03-19T11:41:40.982879Z INFO MonitorHandler ExtHandler Routing table from /proc/net/route: Mar 19 11:41:40.982931 waagent[1975]: Iface Destination Gateway Flags RefCnt Use Metric Mask MTU Window IRTT Mar 19 11:41:40.982931 waagent[1975]: eth0 00000000 0108C80A 0003 0 0 1024 00000000 0 0 0 Mar 19 11:41:40.982931 waagent[1975]: eth0 0008C80A 00000000 0001 0 0 1024 00FFFFFF 0 0 0 Mar 19 11:41:40.982931 waagent[1975]: eth0 0108C80A 00000000 0005 0 0 1024 FFFFFFFF 0 0 0 Mar 19 11:41:40.982931 waagent[1975]: eth0 10813FA8 0108C80A 0007 0 0 1024 FFFFFFFF 0 0 0 Mar 19 11:41:40.982931 waagent[1975]: eth0 FEA9FEA9 0108C80A 0007 0 0 1024 FFFFFFFF 0 0 0 Mar 19 11:41:40.983384 waagent[1975]: 2025-03-19T11:41:40.983333Z INFO EnvHandler ExtHandler Routes:None Mar 19 11:41:40.984052 waagent[1975]: 2025-03-19T11:41:40.983992Z INFO TelemetryEventsCollector ExtHandler Successfully started the TelemetryEventsCollector thread Mar 19 11:41:40.989581 waagent[1975]: 2025-03-19T11:41:40.989483Z INFO ExtHandler ExtHandler Mar 19 11:41:40.989787 waagent[1975]: 2025-03-19T11:41:40.989718Z INFO ExtHandler ExtHandler ProcessExtensionsGoalState started [incarnation_1 channel: WireServer source: Fabric activity: f4042906-4965-4fbe-8f8e-a1267515552b correlation b574f5db-4107-4de9-ac81-6a95078ecdb9 created: 2025-03-19T11:40:05.894104Z] Mar 19 11:41:40.991081 waagent[1975]: 2025-03-19T11:41:40.991028Z INFO ExtHandler ExtHandler No extension handlers found, not processing anything. Mar 19 11:41:40.993137 waagent[1975]: 2025-03-19T11:41:40.993089Z INFO ExtHandler ExtHandler ProcessExtensionsGoalState completed [incarnation_1 3 ms] Mar 19 11:41:41.095950 waagent[1975]: 2025-03-19T11:41:41.095887Z INFO ExtHandler ExtHandler [HEARTBEAT] Agent WALinuxAgent-2.9.1.1 is running as the goal state agent [DEBUG HeartbeatCounter: 0;HeartbeatId: 2510393A-32BB-4D5C-B066-71AD8541010F;DroppedPackets: 0;UpdateGSErrors: 0;AutoUpdate: 0] Mar 19 11:41:41.131162 waagent[1975]: 2025-03-19T11:41:41.131070Z INFO EnvHandler ExtHandler Successfully added Azure fabric firewall rules. Current Firewall rules: Mar 19 11:41:41.131162 waagent[1975]: Chain INPUT (policy ACCEPT 0 packets, 0 bytes) Mar 19 11:41:41.131162 waagent[1975]: pkts bytes target prot opt in out source destination Mar 19 11:41:41.131162 waagent[1975]: Chain FORWARD (policy ACCEPT 0 packets, 0 bytes) Mar 19 11:41:41.131162 waagent[1975]: pkts bytes target prot opt in out source destination Mar 19 11:41:41.131162 waagent[1975]: Chain OUTPUT (policy ACCEPT 0 packets, 0 bytes) Mar 19 11:41:41.131162 waagent[1975]: pkts bytes target prot opt in out source destination Mar 19 11:41:41.131162 waagent[1975]: 0 0 ACCEPT tcp -- * * 0.0.0.0/0 168.63.129.16 tcp dpt:53 Mar 19 11:41:41.131162 waagent[1975]: 0 0 ACCEPT tcp -- * * 0.0.0.0/0 168.63.129.16 owner UID match 0 Mar 19 11:41:41.131162 waagent[1975]: 0 0 DROP tcp -- * * 0.0.0.0/0 168.63.129.16 ctstate INVALID,NEW Mar 19 11:41:41.134821 waagent[1975]: 2025-03-19T11:41:41.134771Z INFO EnvHandler ExtHandler Current Firewall rules: Mar 19 11:41:41.134821 waagent[1975]: Chain INPUT (policy ACCEPT 0 packets, 0 bytes) Mar 19 11:41:41.134821 waagent[1975]: pkts bytes target prot opt in out source destination Mar 19 11:41:41.134821 waagent[1975]: Chain FORWARD (policy ACCEPT 0 packets, 0 bytes) Mar 19 11:41:41.134821 waagent[1975]: pkts bytes target prot opt in out source destination Mar 19 11:41:41.134821 waagent[1975]: Chain OUTPUT (policy ACCEPT 0 packets, 0 bytes) Mar 19 11:41:41.134821 waagent[1975]: pkts bytes target prot opt in out source destination Mar 19 11:41:41.134821 waagent[1975]: 0 0 ACCEPT tcp -- * * 0.0.0.0/0 168.63.129.16 tcp dpt:53 Mar 19 11:41:41.134821 waagent[1975]: 0 0 ACCEPT tcp -- * * 0.0.0.0/0 168.63.129.16 owner UID match 0 Mar 19 11:41:41.134821 waagent[1975]: 0 0 DROP tcp -- * * 0.0.0.0/0 168.63.129.16 ctstate INVALID,NEW Mar 19 11:41:41.135098 waagent[1975]: 2025-03-19T11:41:41.135058Z INFO EnvHandler ExtHandler Set block dev timeout: sdb with timeout: 300 Mar 19 11:41:41.135260 waagent[1975]: 2025-03-19T11:41:41.135223Z INFO EnvHandler ExtHandler Set block dev timeout: sda with timeout: 300 Mar 19 11:41:41.317499 waagent[1975]: 2025-03-19T11:41:41.317341Z INFO MonitorHandler ExtHandler Network interfaces: Mar 19 11:41:41.317499 waagent[1975]: Executing ['ip', '-a', '-o', 'link']: Mar 19 11:41:41.317499 waagent[1975]: 1: lo: mtu 65536 qdisc noqueue state UNKNOWN mode DEFAULT group default qlen 1000\ link/loopback 00:00:00:00:00:00 brd 00:00:00:00:00:00 Mar 19 11:41:41.317499 waagent[1975]: 2: eth0: mtu 1500 qdisc mq state UP mode DEFAULT group default qlen 1000\ link/ether 60:45:bd:df:51:30 brd ff:ff:ff:ff:ff:ff Mar 19 11:41:41.317499 waagent[1975]: Executing ['ip', '-4', '-a', '-o', 'address']: Mar 19 11:41:41.317499 waagent[1975]: 1: lo inet 127.0.0.1/8 scope host lo\ valid_lft forever preferred_lft forever Mar 19 11:41:41.317499 waagent[1975]: 2: eth0 inet 10.200.8.11/24 metric 1024 brd 10.200.8.255 scope global eth0\ valid_lft forever preferred_lft forever Mar 19 11:41:41.317499 waagent[1975]: Executing ['ip', '-6', '-a', '-o', 'address']: Mar 19 11:41:41.317499 waagent[1975]: 1: lo inet6 ::1/128 scope host noprefixroute \ valid_lft forever preferred_lft forever Mar 19 11:41:41.317499 waagent[1975]: 2: eth0 inet6 fe80::6245:bdff:fedf:5130/64 scope link proto kernel_ll \ valid_lft forever preferred_lft forever Mar 19 11:41:51.484798 chronyd[1700]: Selected source PHC0 Mar 19 11:41:51.639659 setup-nvidia[1857]: \u000d 0 0 0 0 0 0 0 0 --:--:-- --:--:-- --:--:-- 0\u000d 0 478M 0 224k 0 0 211k 0 0:38:38 0:00:01 0:38:37 211k\u000d 2 478M 2 11.6M 0 0 5884k 0 0:01:23 0:00:02 0:01:21 5885k\u000d 7 478M 7 35.3M 0 0 11.7M 0 0:00:40 0:00:03 0:00:37 11.7M\u000d 11 478M 11 57.4M 0 0 14.3M 0 0:00:33 0:00:04 0:00:29 14.3M\u000d 16 478M 16 80.0M 0 0 16.0M 0 0:00:29 0:00:04 0:00:25 16.0M\u000d 21 478M 21 101M 0 0 17.0M 0 0:00:28 0:00:05 0:00:23 20.6M\u000d 26 478M 26 124M 0 0 17.8M 0 0:00:26 0:00:06 0:00:20 22.8M\u000d 31 478M 31 148M 0 0 18.6M 0 0:00:25 0:00:07 0:00:18 22.9M\u000d 36 478M 36 172M 0 0 19.2M 0 0:00:24 0:00:08 0:00:16 23.2M\u000d 41 478M 41 198M 0 0 19.9M 0 0:00:23 0:00:09 0:00:14 23.8M\u000d 46 478M 46 223M 0 0 20.4M 0 0:00:23 0:00:10 0:00:13 24.5M\u000d 52 478M 52 250M 0 0 20.7M 0 0:00:23 0:00:12 0:00:11 24.5M\u000d 52 478M 52 253M 0 0 19.5M 0 0:00:24 0:00:12 0:00:12 20.8M\u000d 57 478M 57 277M 0 0 19.8M 0 0:00:24 0:00:13 0:00:11 20.9M\u000d 63 478M 63 302M 0 0 20.1M 0 0:00:23 0:00:14 0:00:09 20.6M\u000d 68 478M 68 325M 0 0 20.4M 0 0:00:23 0:00:15 0:00:08 20.3M\u000d 73 478M 73 349M 0 0 20.6M 0 0:00:23 0:00:16 0:00:07 20.4M\u000d 77 478M 77 372M 0 0 20.6M 0 0:00:23 0:00:17 0:00:06 23.7M\u000d 82 478M 82 393M 0 0 20.7M 0 0:00:23 0:00:18 0:00:05 23.1M\u000d 86 478M 86 416M 0 0 20.8M 0 0:00:22 0:00:19 0:00:03 22.8M\u000d 92 478M 92 441M 0 0 21.0M 0 0:00:22 0:00:20 0:00:02 23.2M\u000d 97 478M 97 467M 0 0 21.1M 0 0:00:22 0:00:22 --:--:-- 22.9M\u000d100 478M 100 478M 0 0 21.2M 0 0:00:22 0:00:22 --:--:-- 23.6M Mar 19 11:41:53.431535 systemd[1]: Created slice system-sshd.slice - Slice /system/sshd. Mar 19 11:41:53.446083 systemd[1]: Started sshd@0-10.200.8.11:22-10.200.16.10:36986.service - OpenSSH per-connection server daemon (10.200.16.10:36986). Mar 19 11:41:54.285242 sshd[2228]: Accepted publickey for core from 10.200.16.10 port 36986 ssh2: RSA SHA256:spf3OijCpLuZYElFk97aEjkfr8djrCt0njqv3sYaas8 Mar 19 11:41:54.285403 sshd-session[2228]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Mar 19 11:41:54.293830 systemd-logind[1706]: New session 3 of user core. Mar 19 11:41:54.302207 systemd[1]: Started session-3.scope - Session 3 of User core. Mar 19 11:41:54.881392 systemd[1]: Started sshd@1-10.200.8.11:22-10.200.16.10:36998.service - OpenSSH per-connection server daemon (10.200.16.10:36998). Mar 19 11:41:55.179060 kernel: hv_netvsc 6045bddf-5130-6045-bddf-51306045bddf eth0: nvsp_rndis_pkt_complete error status: 2 Mar 19 11:41:55.278764 kernel: hv_netvsc 6045bddf-5130-6045-bddf-51306045bddf eth0: nvsp_rndis_pkt_complete error status: 2 Mar 19 11:41:55.388761 kernel: hv_netvsc 6045bddf-5130-6045-bddf-51306045bddf eth0: nvsp_rndis_pkt_complete error status: 2 Mar 19 11:41:55.540377 sshd[2233]: Accepted publickey for core from 10.200.16.10 port 36998 ssh2: RSA SHA256:spf3OijCpLuZYElFk97aEjkfr8djrCt0njqv3sYaas8 Mar 19 11:41:55.541698 sshd-session[2233]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Mar 19 11:41:55.551820 systemd-logind[1706]: New session 4 of user core. Mar 19 11:41:55.559518 systemd[1]: Started session-4.scope - Session 4 of User core. Mar 19 11:41:56.010747 sshd[2235]: Connection closed by 10.200.16.10 port 36998 Mar 19 11:41:56.011954 sshd-session[2233]: pam_unix(sshd:session): session closed for user core Mar 19 11:41:56.014901 systemd[1]: sshd@1-10.200.8.11:22-10.200.16.10:36998.service: Deactivated successfully. Mar 19 11:41:56.016638 systemd[1]: session-4.scope: Deactivated successfully. Mar 19 11:41:56.019119 systemd-logind[1706]: Session 4 logged out. Waiting for processes to exit. Mar 19 11:41:56.020339 systemd-logind[1706]: Removed session 4. Mar 19 11:41:56.140067 systemd[1]: Started sshd@2-10.200.8.11:22-10.200.16.10:37008.service - OpenSSH per-connection server daemon (10.200.16.10:37008). Mar 19 11:41:56.787780 sshd[2241]: Accepted publickey for core from 10.200.16.10 port 37008 ssh2: RSA SHA256:spf3OijCpLuZYElFk97aEjkfr8djrCt0njqv3sYaas8 Mar 19 11:41:56.789164 sshd-session[2241]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Mar 19 11:41:56.798529 systemd-logind[1706]: New session 5 of user core. Mar 19 11:41:56.803967 systemd[1]: Started session-5.scope - Session 5 of User core. Mar 19 11:41:57.252120 sshd[2243]: Connection closed by 10.200.16.10 port 37008 Mar 19 11:41:57.252532 sshd-session[2241]: pam_unix(sshd:session): session closed for user core Mar 19 11:41:57.258925 systemd[1]: sshd@2-10.200.8.11:22-10.200.16.10:37008.service: Deactivated successfully. Mar 19 11:41:57.263026 systemd[1]: session-5.scope: Deactivated successfully. Mar 19 11:41:57.263791 systemd-logind[1706]: Session 5 logged out. Waiting for processes to exit. Mar 19 11:41:57.264746 systemd-logind[1706]: Removed session 5. Mar 19 11:42:03.533093 setup-nvidia[1698]: Downloading NVIDIA 535.230.02 Driver Mar 19 11:42:03.537546 setup-nvidia[2249]: % Total % Received % Xferd Average Speed Time Time Time Current Mar 19 11:42:03.537793 setup-nvidia[2249]: Dload Upload Total Spent Left Speed Mar 19 11:42:05.405565 setup-nvidia[2249]: \u000d 0 0 0 0 0 0 0 0 --:--:-- --:--:-- --:--:-- 0\u000d 4 326M 4 15.2M 0 0 27.8M 0 0:00:11 --:--:-- 0:00:11 27.8M\u000d 76 326M 76 249M 0 0 161M 0 0:00:02 0:00:01 0:00:01 161M\u000d100 326M 100 326M 0 0 174M 0 0:00:01 0:00:01 --:--:-- 174M Mar 19 11:42:05.456154 setup-nvidia[1698]: Extract the NVIDIA Driver Installer 535.230.02 Mar 19 11:42:05.456154 setup-nvidia[1698]: /opt/nvidia/workdir/nvidia-workdir / Mar 19 11:42:05.474354 setup-nvidia[2252]: Creating directory NVIDIA-Linux-x86_64-535.230.02 Mar 19 11:42:05.726418 setup-nvidia[2252]: Verifying archive integrity... OK Mar 19 11:42:06.475053 setup-nvidia[2252]: Uncompressing NVIDIA Accelerated Graphics Driver for Linux-x86_64 535.230.02 Mar 19 11:42:07.372127 systemd[1]: Started sshd@3-10.200.8.11:22-10.200.16.10:45394.service - OpenSSH per-connection server daemon (10.200.16.10:45394). Mar 19 11:42:08.023331 sshd[2283]: Accepted publickey for core from 10.200.16.10 port 45394 ssh2: RSA SHA256:spf3OijCpLuZYElFk97aEjkfr8djrCt0njqv3sYaas8 Mar 19 11:42:08.024817 sshd-session[2283]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Mar 19 11:42:08.029088 systemd-logind[1706]: New session 6 of user core. Mar 19 11:42:08.043962 systemd[1]: Started session-6.scope - Session 6 of User core. Mar 19 11:42:08.355271 setup-nvidia[2278]: ........................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................ Mar 19 11:42:08.448413 setup-nvidia[1698]: / Mar 19 11:42:08.448413 setup-nvidia[1698]: Spawn system-nspawn container to install the NVIDIA drivers Mar 19 11:42:08.487564 sshd[2285]: Connection closed by 10.200.16.10 port 45394 Mar 19 11:42:08.487998 sshd-session[2283]: pam_unix(sshd:session): session closed for user core Mar 19 11:42:08.491256 systemd[1]: sshd@3-10.200.8.11:22-10.200.16.10:45394.service: Deactivated successfully. Mar 19 11:42:08.492992 systemd[1]: session-6.scope: Deactivated successfully. Mar 19 11:42:08.493625 systemd-logind[1706]: Session 6 logged out. Waiting for processes to exit. Mar 19 11:42:08.494401 systemd-logind[1706]: Removed session 6. Mar 19 11:42:08.602522 systemd[1]: Started sshd@4-10.200.8.11:22-10.200.16.10:49992.service - OpenSSH per-connection server daemon (10.200.16.10:49992). Mar 19 11:42:08.811396 sudo[2290]: root : PWD=/ ; USER=root ; COMMAND=/usr/sbin/systemd-nspawn --keep-unit --register=no --read-only --volatile=overlay --image=/opt/nvidia/workdir/flatcar_developer_container-4230.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.230.02 Mar 19 11:42:08.813107 sudo[2290]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=0) Mar 19 11:42:08.822615 systemd[1]: Created slice user-0.slice - User Slice of UID 0. Mar 19 11:42:08.843097 systemd[1]: Starting user-runtime-dir@0.service - User Runtime Directory /run/user/0... Mar 19 11:42:08.854187 systemd[1]: Finished user-runtime-dir@0.service - User Runtime Directory /run/user/0. Mar 19 11:42:08.859979 systemd[1]: Starting user@0.service - User Manager for UID 0... Mar 19 11:42:08.867307 (systemd)[2299]: pam_unix(systemd-user:session): session opened for user root(uid=0) by (uid=0) Mar 19 11:42:08.869573 systemd-logind[1706]: New session c3 of user root. Mar 19 11:42:08.907299 kernel: hv_balloon: Max. dynamic memory size: 114688 MB Mar 19 11:42:09.050575 systemd[2299]: Queued start job for default target default.target. Mar 19 11:42:09.061879 systemd[2299]: Created slice app.slice - User Application Slice. Mar 19 11:42:09.061910 systemd[2299]: Reached target paths.target - Paths. Mar 19 11:42:09.061961 systemd[2299]: Reached target timers.target - Timers. Mar 19 11:42:09.063283 systemd[2299]: Starting dbus.socket - D-Bus User Message Bus Socket... Mar 19 11:42:09.075999 systemd[2299]: Listening on dbus.socket - D-Bus User Message Bus Socket. Mar 19 11:42:09.076135 systemd[2299]: Reached target sockets.target - Sockets. Mar 19 11:42:09.076196 systemd[2299]: Reached target basic.target - Basic System. Mar 19 11:42:09.076245 systemd[2299]: Reached target default.target - Main User Target. Mar 19 11:42:09.076281 systemd[2299]: Startup finished in 200ms. Mar 19 11:42:09.076306 systemd[1]: Started user@0.service - User Manager for UID 0. Mar 19 11:42:09.086898 systemd[1]: Started session-c2.scope - Session c2 of User root. Mar 19 11:42:09.240772 kernel: loop6: detected capacity change from 0 to 12644352 Mar 19 11:42:09.249765 kernel: loop6: p9 Mar 19 11:42:09.257087 sshd[2295]: Accepted publickey for core from 10.200.16.10 port 49992 ssh2: RSA SHA256:spf3OijCpLuZYElFk97aEjkfr8djrCt0njqv3sYaas8 Mar 19 11:42:09.258405 sshd-session[2295]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Mar 19 11:42:09.263234 systemd-logind[1706]: New session 7 of user core. Mar 19 11:42:09.269888 systemd[1]: Started session-7.scope - Session 7 of User core. Mar 19 11:42:09.372448 setup-nvidia[2308]: ░ Spawning container flatcardevelopercontainer-4230.1.0.bin on /opt/nvidia/workdir/flatcar_developer_container-4230.1.0.bin. Mar 19 11:42:09.417795 kernel: EXT4-fs (loop6p9): mounted filesystem abca95e3-c627-4304-9eb1-ed9b39d44da4 ro without journal. Quota mode: none. Mar 19 11:42:09.716674 sshd[2310]: Connection closed by 10.200.16.10 port 49992 Mar 19 11:42:09.717133 sshd-session[2295]: pam_unix(sshd:session): session closed for user core Mar 19 11:42:09.720573 systemd[1]: sshd@4-10.200.8.11:22-10.200.16.10:49992.service: Deactivated successfully. Mar 19 11:42:09.722289 systemd[1]: session-7.scope: Deactivated successfully. Mar 19 11:42:09.722937 systemd-logind[1706]: Session 7 logged out. Waiting for processes to exit. Mar 19 11:42:09.723727 systemd-logind[1706]: Removed session 7. Mar 19 11:42:12.955512 update_engine[1709]: I20250319 11:42:12.955403 1709 update_attempter.cc:509] Updating boot flags... Mar 19 11:42:13.001769 kernel: BTRFS warning: duplicate device /dev/sda3 devid 1 generation 36 scanned by (udev-worker) (2390) Mar 19 11:42:19.844387 systemd[1]: Started sshd@5-10.200.8.11:22-10.200.16.10:47192.service - OpenSSH per-connection server daemon (10.200.16.10:47192). Mar 19 11:42:20.606244 sshd[2974]: Accepted publickey for core from 10.200.16.10 port 47192 ssh2: RSA SHA256:spf3OijCpLuZYElFk97aEjkfr8djrCt0njqv3sYaas8 Mar 19 11:42:20.607628 sshd-session[2974]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Mar 19 11:42:20.612105 systemd-logind[1706]: New session 8 of user core. Mar 19 11:42:20.624923 systemd[1]: Started session-8.scope - Session 8 of User core. Mar 19 11:42:21.063798 sshd[3203]: Connection closed by 10.200.16.10 port 47192 Mar 19 11:42:21.064308 sshd-session[2974]: pam_unix(sshd:session): session closed for user core Mar 19 11:42:21.067769 systemd[1]: sshd@5-10.200.8.11:22-10.200.16.10:47192.service: Deactivated successfully. Mar 19 11:42:21.069395 systemd[1]: session-8.scope: Deactivated successfully. Mar 19 11:42:21.070057 systemd-logind[1706]: Session 8 logged out. Waiting for processes to exit. Mar 19 11:42:21.070852 systemd-logind[1706]: Removed session 8. Mar 19 11:42:21.182477 systemd[1]: Started sshd@6-10.200.8.11:22-10.200.16.10:47204.service - OpenSSH per-connection server daemon (10.200.16.10:47204). Mar 19 11:42:21.837071 sshd[3408]: Accepted publickey for core from 10.200.16.10 port 47204 ssh2: RSA SHA256:spf3OijCpLuZYElFk97aEjkfr8djrCt0njqv3sYaas8 Mar 19 11:42:21.840324 sshd-session[3408]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Mar 19 11:42:21.844429 systemd-logind[1706]: New session 9 of user core. Mar 19 11:42:21.858896 systemd[1]: Started session-9.scope - Session 9 of User core. Mar 19 11:42:22.466979 sshd[3410]: Connection closed by 10.200.16.10 port 47204 Mar 19 11:42:22.467418 sshd-session[3408]: pam_unix(sshd:session): session closed for user core Mar 19 11:42:22.470711 systemd[1]: sshd@6-10.200.8.11:22-10.200.16.10:47204.service: Deactivated successfully. Mar 19 11:42:22.472381 systemd[1]: session-9.scope: Deactivated successfully. Mar 19 11:42:22.473026 systemd-logind[1706]: Session 9 logged out. Waiting for processes to exit. Mar 19 11:42:22.473798 systemd-logind[1706]: Removed session 9. Mar 19 11:42:32.585550 systemd[1]: Started sshd@7-10.200.8.11:22-10.200.16.10:40348.service - OpenSSH per-connection server daemon (10.200.16.10:40348). Mar 19 11:42:33.236904 sshd[3416]: Accepted publickey for core from 10.200.16.10 port 40348 ssh2: RSA SHA256:spf3OijCpLuZYElFk97aEjkfr8djrCt0njqv3sYaas8 Mar 19 11:42:33.238281 sshd-session[3416]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Mar 19 11:42:33.242466 systemd-logind[1706]: New session 10 of user core. Mar 19 11:42:33.254893 systemd[1]: Started session-10.scope - Session 10 of User core. Mar 19 11:42:33.695954 sshd[3418]: Connection closed by 10.200.16.10 port 40348 Mar 19 11:42:33.696401 sshd-session[3416]: pam_unix(sshd:session): session closed for user core Mar 19 11:42:33.699714 systemd[1]: sshd@7-10.200.8.11:22-10.200.16.10:40348.service: Deactivated successfully. Mar 19 11:42:33.701365 systemd[1]: session-10.scope: Deactivated successfully. Mar 19 11:42:33.702021 systemd-logind[1706]: Session 10 logged out. Waiting for processes to exit. Mar 19 11:42:33.702785 systemd-logind[1706]: Removed session 10. Mar 19 11:42:33.811456 systemd[1]: Started sshd@8-10.200.8.11:22-10.200.16.10:40362.service - OpenSSH per-connection server daemon (10.200.16.10:40362). Mar 19 11:42:34.459760 sshd[3425]: Accepted publickey for core from 10.200.16.10 port 40362 ssh2: RSA SHA256:spf3OijCpLuZYElFk97aEjkfr8djrCt0njqv3sYaas8 Mar 19 11:42:34.461209 sshd-session[3425]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Mar 19 11:42:34.465417 systemd-logind[1706]: New session 11 of user core. Mar 19 11:42:34.477904 systemd[1]: Started session-11.scope - Session 11 of User core. Mar 19 11:42:34.922183 sshd[3427]: Connection closed by 10.200.16.10 port 40362 Mar 19 11:42:34.922596 sshd-session[3425]: pam_unix(sshd:session): session closed for user core Mar 19 11:42:34.925868 systemd[1]: sshd@8-10.200.8.11:22-10.200.16.10:40362.service: Deactivated successfully. Mar 19 11:42:34.927488 systemd[1]: session-11.scope: Deactivated successfully. Mar 19 11:42:34.928131 systemd-logind[1706]: Session 11 logged out. Waiting for processes to exit. Mar 19 11:42:34.928914 systemd-logind[1706]: Removed session 11. Mar 19 11:42:45.037593 systemd[1]: Started sshd@9-10.200.8.11:22-10.200.16.10:49744.service - OpenSSH per-connection server daemon (10.200.16.10:49744). Mar 19 11:42:45.689084 sshd[3524]: Accepted publickey for core from 10.200.16.10 port 49744 ssh2: RSA SHA256:spf3OijCpLuZYElFk97aEjkfr8djrCt0njqv3sYaas8 Mar 19 11:42:45.690407 sshd-session[3524]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Mar 19 11:42:45.694885 systemd-logind[1706]: New session 12 of user core. Mar 19 11:42:45.703892 systemd[1]: Started session-12.scope - Session 12 of User core. Mar 19 11:42:46.147212 sshd[3554]: Connection closed by 10.200.16.10 port 49744 Mar 19 11:42:46.147649 sshd-session[3524]: pam_unix(sshd:session): session closed for user core Mar 19 11:42:46.151089 systemd[1]: sshd@9-10.200.8.11:22-10.200.16.10:49744.service: Deactivated successfully. Mar 19 11:42:46.152786 systemd[1]: session-12.scope: Deactivated successfully. Mar 19 11:42:46.153511 systemd-logind[1706]: Session 12 logged out. Waiting for processes to exit. Mar 19 11:42:46.154453 systemd-logind[1706]: Removed session 12. Mar 19 11:42:46.262473 systemd[1]: Started sshd@10-10.200.8.11:22-10.200.16.10:49758.service - OpenSSH per-connection server daemon (10.200.16.10:49758). Mar 19 11:42:46.912172 sshd[3582]: Accepted publickey for core from 10.200.16.10 port 49758 ssh2: RSA SHA256:spf3OijCpLuZYElFk97aEjkfr8djrCt0njqv3sYaas8 Mar 19 11:42:46.913596 sshd-session[3582]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Mar 19 11:42:46.917807 systemd-logind[1706]: New session 13 of user core. Mar 19 11:42:46.929883 systemd[1]: Started session-13.scope - Session 13 of User core. Mar 19 11:42:47.370964 sshd[3584]: Connection closed by 10.200.16.10 port 49758 Mar 19 11:42:47.559232 sshd-session[3582]: pam_unix(sshd:session): session closed for user core Mar 19 11:42:47.562687 systemd[1]: sshd@10-10.200.8.11:22-10.200.16.10:49758.service: Deactivated successfully. Mar 19 11:42:47.564343 systemd[1]: session-13.scope: Deactivated successfully. Mar 19 11:42:47.564997 systemd-logind[1706]: Session 13 logged out. Waiting for processes to exit. Mar 19 11:42:47.566050 systemd-logind[1706]: Removed session 13. Mar 19 11:42:57.490600 systemd[1]: Started sshd@11-10.200.8.11:22-10.200.16.10:47216.service - OpenSSH per-connection server daemon (10.200.16.10:47216). Mar 19 11:42:58.145755 sshd[4955]: Accepted publickey for core from 10.200.16.10 port 47216 ssh2: RSA SHA256:spf3OijCpLuZYElFk97aEjkfr8djrCt0njqv3sYaas8 Mar 19 11:42:58.147231 sshd-session[4955]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Mar 19 11:42:58.151393 systemd-logind[1706]: New session 14 of user core. Mar 19 11:42:58.606333 sshd-session[4955]: pam_unix(sshd:session): session closed for user core Mar 19 11:42:58.755245 sshd[5110]: Connection closed by 10.200.16.10 port 47216 Mar 19 11:42:58.162886 systemd[1]: Started session-14.scope - Session 14 of User core. Mar 19 11:42:58.610396 systemd[1]: sshd@11-10.200.8.11:22-10.200.16.10:47216.service: Deactivated successfully. Mar 19 11:42:58.612711 systemd[1]: session-14.scope: Deactivated successfully. Mar 19 11:42:58.613479 systemd-logind[1706]: Session 14 logged out. Waiting for processes to exit. Mar 19 11:42:58.614507 systemd-logind[1706]: Removed session 14. Mar 19 11:42:58.721564 systemd[1]: Started sshd@12-10.200.8.11:22-10.200.16.10:33100.service - OpenSSH per-connection server daemon (10.200.16.10:33100). Mar 19 11:42:59.370243 sshd[5298]: Accepted publickey for core from 10.200.16.10 port 33100 ssh2: RSA SHA256:spf3OijCpLuZYElFk97aEjkfr8djrCt0njqv3sYaas8 Mar 19 11:42:59.371662 sshd-session[5298]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Mar 19 11:42:59.377599 systemd-logind[1706]: New session 15 of user core. Mar 19 11:42:59.385944 systemd[1]: Started session-15.scope - Session 15 of User core. Mar 19 11:42:59.828375 sshd[5479]: Connection closed by 10.200.16.10 port 33100 Mar 19 11:42:59.828708 sshd-session[5298]: pam_unix(sshd:session): session closed for user core Mar 19 11:42:59.831898 systemd[1]: sshd@12-10.200.8.11:22-10.200.16.10:33100.service: Deactivated successfully. Mar 19 11:42:59.833495 systemd[1]: session-15.scope: Deactivated successfully. Mar 19 11:42:59.834395 systemd-logind[1706]: Session 15 logged out. Waiting for processes to exit. Mar 19 11:42:59.835189 systemd-logind[1706]: Removed session 15. Mar 19 11:43:09.949550 systemd[1]: Started sshd@13-10.200.8.11:22-10.200.16.10:39808.service - OpenSSH per-connection server daemon (10.200.16.10:39808). Mar 19 11:43:17.356984 sshd-session[5619]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Mar 19 11:43:17.361542 systemd-logind[1706]: New session 16 of user core. Mar 19 11:43:23.165845 sshd[5619]: Accepted publickey for core from 10.200.16.10 port 39808 ssh2: RSA SHA256:spf3OijCpLuZYElFk97aEjkfr8djrCt0njqv3sYaas8 Mar 19 11:43:23.165585 sshd-session[5619]: pam_unix(sshd:session): session closed for user core Mar 19 11:43:17.369873 systemd[1]: Started session-16.scope - Session 16 of User core. Mar 19 11:43:23.166457 sshd[5624]: Accepted publickey for core from 10.200.16.10 port 39814 ssh2: RSA SHA256:spf3OijCpLuZYElFk97aEjkfr8djrCt0njqv3sYaas8 Mar 19 11:43:23.166716 sshd[5621]: Connection closed by 10.200.16.10 port 39808 Mar 19 11:43:23.165805 sshd-session[5624]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Mar 19 11:43:17.855607 systemd[1]: Started sshd@14-10.200.8.11:22-10.200.16.10:39814.service - OpenSSH per-connection server daemon (10.200.16.10:39814). Mar 19 11:43:23.169222 systemd[1]: sshd@13-10.200.8.11:22-10.200.16.10:39808.service: Deactivated successfully. Mar 19 11:43:23.170916 systemd[1]: session-16.scope: Deactivated successfully. Mar 19 11:43:23.174657 systemd-logind[1706]: New session 17 of user core. Mar 19 11:43:23.188095 systemd[1]: Started session-17.scope - Session 17 of User core. Mar 19 11:43:23.193175 systemd-logind[1706]: Session 16 logged out. Waiting for processes to exit. Mar 19 11:43:23.193971 systemd-logind[1706]: Removed session 16. Mar 19 11:43:25.507472 sshd[5629]: Connection closed by 10.200.16.10 port 39814 Mar 19 11:43:25.507580 sshd-session[5624]: pam_unix(sshd:session): session closed for user core Mar 19 11:43:25.515242 systemd[1]: sshd@14-10.200.8.11:22-10.200.16.10:39814.service: Deactivated successfully. Mar 19 11:43:25.517141 systemd[1]: session-17.scope: Deactivated successfully. Mar 19 11:43:25.517900 systemd-logind[1706]: Session 17 logged out. Waiting for processes to exit. Mar 19 11:43:25.518821 systemd-logind[1706]: Removed session 17. Mar 19 11:43:31.517507 waagent[1975]: 2025-03-19T11:43:31.516596Z INFO ExtHandler Fetched a new incarnation for the WireServer goal state [incarnation 2] Mar 19 11:43:31.525781 waagent[1975]: 2025-03-19T11:43:31.525677Z INFO ExtHandler Mar 19 11:43:31.525903 waagent[1975]: 2025-03-19T11:43:31.525858Z INFO ExtHandler Fetched new vmSettings [HostGAPlugin correlation ID: 0645fb41-7c15-498d-9031-d5289a74f431 eTag: 1394255250221988129 source: Fabric] Mar 19 11:43:31.526333 waagent[1975]: 2025-03-19T11:43:31.526283Z INFO ExtHandler The vmSettings originated via Fabric; will ignore them. Mar 19 11:43:31.527121 waagent[1975]: 2025-03-19T11:43:31.527071Z INFO ExtHandler Mar 19 11:43:31.527344 waagent[1975]: 2025-03-19T11:43:31.527179Z INFO ExtHandler Fetching full goal state from the WireServer [incarnation 2] Mar 19 11:43:31.657518 waagent[1975]: 2025-03-19T11:43:31.657460Z INFO ExtHandler ExtHandler Downloading artifacts profile blob Mar 19 11:43:31.737214 waagent[1975]: 2025-03-19T11:43:31.737101Z INFO ExtHandler Downloaded certificate {'thumbprint': 'C51E35E32F91015377A4C186BE86C91093BD3271', 'hasPrivateKey': True} Mar 19 11:43:31.737614 waagent[1975]: 2025-03-19T11:43:31.737567Z INFO ExtHandler Downloaded certificate {'thumbprint': '9B8053F512822F1881B672A01C6C2F60583D298D', 'hasPrivateKey': False} Mar 19 11:43:31.738093 waagent[1975]: 2025-03-19T11:43:31.738047Z INFO ExtHandler Fetch goal state completed Mar 19 11:43:31.739092 waagent[1975]: 2025-03-19T11:43:31.738453Z INFO ExtHandler ExtHandler Mar 19 11:43:31.739092 waagent[1975]: 2025-03-19T11:43:31.738541Z INFO ExtHandler ExtHandler ProcessExtensionsGoalState started [incarnation_2 channel: WireServer source: Fabric activity: 2e92f0a1-50f5-4b0a-9b00-fd11a549e2f1 correlation b574f5db-4107-4de9-ac81-6a95078ecdb9 created: 2025-03-19T11:43:21.301109Z] Mar 19 11:43:31.739092 waagent[1975]: 2025-03-19T11:43:31.738880Z INFO ExtHandler ExtHandler No extension handlers found, not processing anything. Mar 19 11:43:31.739484 waagent[1975]: 2025-03-19T11:43:31.739442Z INFO ExtHandler ExtHandler ProcessExtensionsGoalState completed [incarnation_2 0 ms] Mar 19 11:43:33.676004 systemd[1]: Started sshd@15-10.200.8.11:22-10.200.16.10:53456.service - OpenSSH per-connection server daemon (10.200.16.10:53456). Mar 19 11:43:34.336308 sshd[7833]: Accepted publickey for core from 10.200.16.10 port 53456 ssh2: RSA SHA256:spf3OijCpLuZYElFk97aEjkfr8djrCt0njqv3sYaas8 Mar 19 11:43:34.337702 sshd-session[7833]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Mar 19 11:43:34.344229 systemd-logind[1706]: New session 18 of user core. Mar 19 11:43:34.352983 systemd[1]: Started session-18.scope - Session 18 of User core. Mar 19 11:43:34.800047 sshd[7962]: Connection closed by 10.200.16.10 port 53456 Mar 19 11:43:34.800669 sshd-session[7833]: pam_unix(sshd:session): session closed for user core Mar 19 11:43:34.804252 systemd[1]: sshd@15-10.200.8.11:22-10.200.16.10:53456.service: Deactivated successfully. Mar 19 11:43:34.808682 systemd[1]: session-18.scope: Deactivated successfully. Mar 19 11:43:34.809862 systemd-logind[1706]: Session 18 logged out. Waiting for processes to exit. Mar 19 11:43:34.811357 systemd-logind[1706]: Removed session 18. Mar 19 11:43:34.933891 systemd[1]: Started sshd@16-10.200.8.11:22-10.200.16.10:53458.service - OpenSSH per-connection server daemon (10.200.16.10:53458). Mar 19 11:43:35.588671 sshd[8042]: Accepted publickey for core from 10.200.16.10 port 53458 ssh2: RSA SHA256:spf3OijCpLuZYElFk97aEjkfr8djrCt0njqv3sYaas8 Mar 19 11:43:35.590438 sshd-session[8042]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Mar 19 11:43:35.597511 systemd-logind[1706]: New session 19 of user core. Mar 19 11:43:35.603922 systemd[1]: Started session-19.scope - Session 19 of User core. Mar 19 11:43:36.049244 sshd[8288]: Connection closed by 10.200.16.10 port 53458 Mar 19 11:43:36.051069 sshd-session[8042]: pam_unix(sshd:session): session closed for user core Mar 19 11:43:36.054519 systemd[1]: sshd@16-10.200.8.11:22-10.200.16.10:53458.service: Deactivated successfully. Mar 19 11:43:36.056486 systemd[1]: session-19.scope: Deactivated successfully. Mar 19 11:43:36.057321 systemd-logind[1706]: Session 19 logged out. Waiting for processes to exit. Mar 19 11:43:36.058366 systemd-logind[1706]: Removed session 19. Mar 19 11:43:46.170506 systemd[1]: Started sshd@17-10.200.8.11:22-10.200.16.10:51312.service - OpenSSH per-connection server daemon (10.200.16.10:51312). Mar 19 11:43:46.831353 sshd[11562]: Accepted publickey for core from 10.200.16.10 port 51312 ssh2: RSA SHA256:spf3OijCpLuZYElFk97aEjkfr8djrCt0njqv3sYaas8 Mar 19 11:43:46.833007 sshd-session[11562]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Mar 19 11:43:46.838091 systemd-logind[1706]: New session 20 of user core. Mar 19 11:43:46.845921 systemd[1]: Started session-20.scope - Session 20 of User core. Mar 19 11:43:47.295133 sshd[11576]: Connection closed by 10.200.16.10 port 51312 Mar 19 11:43:47.296057 sshd-session[11562]: pam_unix(sshd:session): session closed for user core Mar 19 11:43:47.303132 systemd-logind[1706]: Session 20 logged out. Waiting for processes to exit. Mar 19 11:43:47.304935 systemd[1]: sshd@17-10.200.8.11:22-10.200.16.10:51312.service: Deactivated successfully. Mar 19 11:43:47.309029 systemd[1]: session-20.scope: Deactivated successfully. Mar 19 11:43:47.310939 systemd-logind[1706]: Removed session 20. Mar 19 11:43:47.427121 systemd[1]: Started sshd@18-10.200.8.11:22-10.200.16.10:51316.service - OpenSSH per-connection server daemon (10.200.16.10:51316). Mar 19 11:43:48.081798 sshd[11605]: Accepted publickey for core from 10.200.16.10 port 51316 ssh2: RSA SHA256:spf3OijCpLuZYElFk97aEjkfr8djrCt0njqv3sYaas8 Mar 19 11:43:48.082765 sshd-session[11605]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Mar 19 11:43:48.089916 systemd-logind[1706]: New session 21 of user core. Mar 19 11:43:48.092921 systemd[1]: Started session-21.scope - Session 21 of User core. Mar 19 11:43:48.540069 sshd[11622]: Connection closed by 10.200.16.10 port 51316 Mar 19 11:43:48.540467 sshd-session[11605]: pam_unix(sshd:session): session closed for user core Mar 19 11:43:48.543395 systemd-logind[1706]: Session 21 logged out. Waiting for processes to exit. Mar 19 11:43:48.544449 systemd[1]: sshd@18-10.200.8.11:22-10.200.16.10:51316.service: Deactivated successfully. Mar 19 11:43:48.549348 systemd[1]: session-21.scope: Deactivated successfully. Mar 19 11:43:48.552563 systemd-logind[1706]: Removed session 21. Mar 19 11:43:58.660035 systemd[1]: Started sshd@19-10.200.8.11:22-10.200.16.10:42636.service - OpenSSH per-connection server daemon (10.200.16.10:42636). Mar 19 11:43:59.325220 sshd[12028]: Accepted publickey for core from 10.200.16.10 port 42636 ssh2: RSA SHA256:spf3OijCpLuZYElFk97aEjkfr8djrCt0njqv3sYaas8 Mar 19 11:43:59.326631 sshd-session[12028]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Mar 19 11:43:59.333268 systemd-logind[1706]: New session 22 of user core. Mar 19 11:43:59.339413 systemd[1]: Started session-22.scope - Session 22 of User core. Mar 19 11:43:59.788375 sshd[12048]: Connection closed by 10.200.16.10 port 42636 Mar 19 11:43:59.789929 sshd-session[12028]: pam_unix(sshd:session): session closed for user core Mar 19 11:43:59.795605 systemd-logind[1706]: Session 22 logged out. Waiting for processes to exit. Mar 19 11:43:59.799022 systemd[1]: sshd@19-10.200.8.11:22-10.200.16.10:42636.service: Deactivated successfully. Mar 19 11:43:59.801017 systemd[1]: session-22.scope: Deactivated successfully. Mar 19 11:43:59.802441 systemd-logind[1706]: Removed session 22. Mar 19 11:43:59.921104 systemd[1]: Started sshd@20-10.200.8.11:22-10.200.16.10:42640.service - OpenSSH per-connection server daemon (10.200.16.10:42640). Mar 19 11:44:00.590337 sshd[12066]: Accepted publickey for core from 10.200.16.10 port 42640 ssh2: RSA SHA256:spf3OijCpLuZYElFk97aEjkfr8djrCt0njqv3sYaas8 Mar 19 11:44:00.592154 sshd-session[12066]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Mar 19 11:44:00.600679 systemd-logind[1706]: New session 23 of user core. Mar 19 11:44:00.610991 systemd[1]: Started session-23.scope - Session 23 of User core. Mar 19 11:44:01.051691 sshd[12086]: Connection closed by 10.200.16.10 port 42640 Mar 19 11:44:01.052123 sshd-session[12066]: pam_unix(sshd:session): session closed for user core Mar 19 11:44:01.055152 systemd-logind[1706]: Session 23 logged out. Waiting for processes to exit. Mar 19 11:44:01.056978 systemd[1]: sshd@20-10.200.8.11:22-10.200.16.10:42640.service: Deactivated successfully. Mar 19 11:44:01.060408 systemd[1]: session-23.scope: Deactivated successfully. Mar 19 11:44:01.061796 systemd-logind[1706]: Removed session 23. Mar 19 11:44:11.179027 systemd[1]: Started sshd@21-10.200.8.11:22-10.200.16.10:44970.service - OpenSSH per-connection server daemon (10.200.16.10:44970). Mar 19 11:44:11.838329 sshd[12417]: Accepted publickey for core from 10.200.16.10 port 44970 ssh2: RSA SHA256:spf3OijCpLuZYElFk97aEjkfr8djrCt0njqv3sYaas8 Mar 19 11:44:11.840186 sshd-session[12417]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Mar 19 11:44:11.851128 systemd-logind[1706]: New session 24 of user core. Mar 19 11:44:11.867034 systemd[1]: Started session-24.scope - Session 24 of User core. Mar 19 11:44:12.307273 sshd[12442]: Connection closed by 10.200.16.10 port 44970 Mar 19 11:44:12.307961 sshd-session[12417]: pam_unix(sshd:session): session closed for user core Mar 19 11:44:12.310991 systemd-logind[1706]: Session 24 logged out. Waiting for processes to exit. Mar 19 11:44:12.312056 systemd[1]: sshd@21-10.200.8.11:22-10.200.16.10:44970.service: Deactivated successfully. Mar 19 11:44:12.314251 systemd[1]: session-24.scope: Deactivated successfully. Mar 19 11:44:12.319057 systemd-logind[1706]: Removed session 24. Mar 19 11:44:12.425324 systemd[1]: Started sshd@22-10.200.8.11:22-10.200.16.10:44976.service - OpenSSH per-connection server daemon (10.200.16.10:44976). Mar 19 11:44:13.093778 sshd[12455]: Accepted publickey for core from 10.200.16.10 port 44976 ssh2: RSA SHA256:spf3OijCpLuZYElFk97aEjkfr8djrCt0njqv3sYaas8 Mar 19 11:44:13.094776 sshd-session[12455]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Mar 19 11:44:13.101612 systemd-logind[1706]: New session 25 of user core. Mar 19 11:44:13.108927 systemd[1]: Started session-25.scope - Session 25 of User core. Mar 19 11:44:13.554079 sshd[12474]: Connection closed by 10.200.16.10 port 44976 Mar 19 11:44:13.555701 sshd-session[12455]: pam_unix(sshd:session): session closed for user core Mar 19 11:44:13.559130 systemd[1]: sshd@22-10.200.8.11:22-10.200.16.10:44976.service: Deactivated successfully. Mar 19 11:44:13.561220 systemd[1]: session-25.scope: Deactivated successfully. Mar 19 11:44:13.562195 systemd-logind[1706]: Session 25 logged out. Waiting for processes to exit. Mar 19 11:44:13.563343 systemd-logind[1706]: Removed session 25. Mar 19 11:44:23.673816 systemd[1]: Started sshd@23-10.200.8.11:22-10.200.16.10:51182.service - OpenSSH per-connection server daemon (10.200.16.10:51182). Mar 19 11:44:24.327702 sshd[12717]: Accepted publickey for core from 10.200.16.10 port 51182 ssh2: RSA SHA256:spf3OijCpLuZYElFk97aEjkfr8djrCt0njqv3sYaas8 Mar 19 11:44:24.329173 sshd-session[12717]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Mar 19 11:44:24.333449 systemd-logind[1706]: New session 26 of user core. Mar 19 11:44:24.344928 systemd[1]: Started session-26.scope - Session 26 of User core. Mar 19 11:44:24.786344 sshd[12719]: Connection closed by 10.200.16.10 port 51182 Mar 19 11:44:24.786822 sshd-session[12717]: pam_unix(sshd:session): session closed for user core Mar 19 11:44:24.790354 systemd[1]: sshd@23-10.200.8.11:22-10.200.16.10:51182.service: Deactivated successfully. Mar 19 11:44:24.792014 systemd[1]: session-26.scope: Deactivated successfully. Mar 19 11:44:24.792632 systemd-logind[1706]: Session 26 logged out. Waiting for processes to exit. Mar 19 11:44:24.793500 systemd-logind[1706]: Removed session 26. Mar 19 11:44:24.902463 systemd[1]: Started sshd@24-10.200.8.11:22-10.200.16.10:51198.service - OpenSSH per-connection server daemon (10.200.16.10:51198). Mar 19 11:44:25.561090 sshd[12725]: Accepted publickey for core from 10.200.16.10 port 51198 ssh2: RSA SHA256:spf3OijCpLuZYElFk97aEjkfr8djrCt0njqv3sYaas8 Mar 19 11:44:25.562514 sshd-session[12725]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Mar 19 11:44:25.568527 systemd-logind[1706]: New session 27 of user core. Mar 19 11:44:25.578862 systemd[1]: Started session-27.scope - Session 27 of User core. Mar 19 11:44:26.024212 sshd[12737]: Connection closed by 10.200.16.10 port 51198 Mar 19 11:44:26.024634 sshd-session[12725]: pam_unix(sshd:session): session closed for user core Mar 19 11:44:26.027890 systemd[1]: sshd@24-10.200.8.11:22-10.200.16.10:51198.service: Deactivated successfully. Mar 19 11:44:26.029560 systemd[1]: session-27.scope: Deactivated successfully. Mar 19 11:44:26.030214 systemd-logind[1706]: Session 27 logged out. Waiting for processes to exit. Mar 19 11:44:26.030984 systemd-logind[1706]: Removed session 27. Mar 19 11:44:28.155193 setup-nvidia[2308]: \u000d Mar 19 11:44:28.155193 setup-nvidia[2308]: ERROR: Unable to load the kernel module 'nvidia.ko'. This happens most Mar 19 11:44:28.155193 setup-nvidia[2308]: frequently when this kernel module was built against the wrong or Mar 19 11:44:28.155193 setup-nvidia[2308]: improperly configured kernel sources, with a version of gcc that differs Mar 19 11:44:28.155193 setup-nvidia[2308]: from the one used to build the target kernel, or if another driver, such Mar 19 11:44:28.155193 setup-nvidia[2308]: as nouveau, is present and prevents the NVIDIA kernel module from Mar 19 11:44:28.155193 setup-nvidia[2308]: obtaining ownership of the NVIDIA device(s), or no NVIDIA device Mar 19 11:44:28.155193 setup-nvidia[2308]: installed in this system is supported by this NVIDIA Linux graphics Mar 19 11:44:28.155193 setup-nvidia[2308]: driver release. Mar 19 11:44:28.155193 setup-nvidia[2308]: \u000d Mar 19 11:44:28.155193 setup-nvidia[2308]: Please see the log entries 'Kernel module load error' and 'Kernel Mar 19 11:44:28.155193 setup-nvidia[2308]: messages' at the end of the file Mar 19 11:44:28.155193 setup-nvidia[2308]: '/nvidia/NVIDIA-Linux-x86_64-535.230.02/nvidia-installer.log' for more Mar 19 11:44:28.155193 setup-nvidia[2308]: information. Mar 19 11:44:28.155193 setup-nvidia[2308]: \u000d Mar 19 11:44:28.171772 setup-nvidia[2308]: dmesg: read kernel buffer failed: Operation not permitted Mar 19 11:44:28.193548 setup-nvidia[2308]: \u000d Mar 19 11:44:28.193548 setup-nvidia[2308]: ERROR: Installation has failed. Please see the file Mar 19 11:44:28.193548 setup-nvidia[2308]: '/nvidia/NVIDIA-Linux-x86_64-535.230.02/nvidia-installer.log' for Mar 19 11:44:28.193548 setup-nvidia[2308]: details. You may find suggestions on fixing installation problems in Mar 19 11:44:28.193548 setup-nvidia[2308]: the README available on the Linux driver download page at Mar 19 11:44:28.193548 setup-nvidia[2308]: www.nvidia.com. Mar 19 11:44:28.193548 setup-nvidia[2308]: \u000d Mar 19 11:44:28.193881 setup-nvidia[2308]: Last 50 lines of nvidia-installer.log: Mar 19 11:44:28.194698 setup-nvidia[2308]: /nvidia/NVIDIA-Linux-x86_64-535.230.02/kernel/nvidia.o: warning: objtool: _nv038989rm+0x32: 'naked' return found in RETHUNK build Mar 19 11:44:28.194698 setup-nvidia[2308]: /nvidia/NVIDIA-Linux-x86_64-535.230.02/kernel/nvidia.o: warning: objtool: _nv039000rm+0x53: 'naked' return found in RETHUNK build Mar 19 11:44:28.194698 setup-nvidia[2308]: /nvidia/NVIDIA-Linux-x86_64-535.230.02/kernel/nvidia.o: warning: objtool: _nv038997rm+0x90: 'naked' return found in RETHUNK build Mar 19 11:44:28.194698 setup-nvidia[2308]: /nvidia/NVIDIA-Linux-x86_64-535.230.02/kernel/nvidia.o: warning: objtool: _nv038990rm+0x2b: 'naked' return found in RETHUNK build Mar 19 11:44:28.194698 setup-nvidia[2308]: /nvidia/NVIDIA-Linux-x86_64-535.230.02/kernel/nvidia.o: warning: objtool: _nv039046rm+0x93: 'naked' return found in RETHUNK build Mar 19 11:44:28.194698 setup-nvidia[2308]: /nvidia/NVIDIA-Linux-x86_64-535.230.02/kernel/nvidia.o: warning: objtool: _nv039042rm+0x36: 'naked' return found in RETHUNK build Mar 19 11:44:28.194698 setup-nvidia[2308]: /nvidia/NVIDIA-Linux-x86_64-535.230.02/kernel/nvidia.o: warning: objtool: _nv039041rm+0x9d: 'naked' return found in RETHUNK build Mar 19 11:44:28.194698 setup-nvidia[2308]: /nvidia/NVIDIA-Linux-x86_64-535.230.02/kernel/nvidia.o: warning: objtool: _nv039043rm+0x77: 'naked' return found in RETHUNK build Mar 19 11:44:28.194698 setup-nvidia[2308]: /nvidia/NVIDIA-Linux-x86_64-535.230.02/kernel/nvidia.o: warning: objtool: _nv038987rm+0x7f: 'naked' return found in RETHUNK build Mar 19 11:44:28.194698 setup-nvidia[2308]: /nvidia/NVIDIA-Linux-x86_64-535.230.02/kernel/nvidia.o: warning: objtool: _nv030558rm+0x3e: 'naked' return found in RETHUNK build Mar 19 11:44:28.194698 setup-nvidia[2308]: /nvidia/NVIDIA-Linux-x86_64-535.230.02/kernel/nvidia.o: warning: objtool: _nv030557rm+0x27: 'naked' return found in RETHUNK build Mar 19 11:44:28.194698 setup-nvidia[2308]: /nvidia/NVIDIA-Linux-x86_64-535.230.02/kernel/nvidia.o: warning: objtool: _nv030561rm+0x37: 'naked' return found in RETHUNK build Mar 19 11:44:28.194698 setup-nvidia[2308]: /nvidia/NVIDIA-Linux-x86_64-535.230.02/kernel/nvidia.o: warning: objtool: _nv030560rm+0x24: 'naked' return found in RETHUNK build Mar 19 11:44:28.194698 setup-nvidia[2308]: /nvidia/NVIDIA-Linux-x86_64-535.230.02/kernel/nvidia.o: warning: objtool: _nv030559rm+0xca: 'naked' return found in RETHUNK build Mar 19 11:44:28.194698 setup-nvidia[2308]: /nvidia/NVIDIA-Linux-x86_64-535.230.02/kernel/nvidia.o: warning: objtool: _nv030562rm+0x193: 'naked' return found in RETHUNK build Mar 19 11:44:28.194698 setup-nvidia[2308]: /nvidia/NVIDIA-Linux-x86_64-535.230.02/kernel/nvidia.o: warning: objtool: _nv030564rm+0x17f: 'naked' return found in RETHUNK build Mar 19 11:44:28.194698 setup-nvidia[2308]: /nvidia/NVIDIA-Linux-x86_64-535.230.02/kernel/nvidia.o: warning: objtool: _nv011860rm+0x5d: 'naked' return found in RETHUNK build Mar 19 11:44:28.194698 setup-nvidia[2308]: /nvidia/NVIDIA-Linux-x86_64-535.230.02/kernel/nvidia.o: warning: objtool: _nv039354rm+0x12f: 'naked' return found in RETHUNK build Mar 19 11:44:28.194698 setup-nvidia[2308]: MODPOST /nvidia/NVIDIA-Linux-x86_64-535.230.02/kernel/Module.symvers Mar 19 11:44:28.194698 setup-nvidia[2308]: CC [M] /nvidia/NVIDIA-Linux-x86_64-535.230.02/kernel/nvidia.mod.o Mar 19 11:44:28.194698 setup-nvidia[2308]: CC [M] /nvidia/NVIDIA-Linux-x86_64-535.230.02/kernel/nvidia-uvm.mod.o Mar 19 11:44:28.194698 setup-nvidia[2308]: CC [M] /nvidia/NVIDIA-Linux-x86_64-535.230.02/kernel/nvidia-modeset.mod.o Mar 19 11:44:28.194698 setup-nvidia[2308]: CC [M] /nvidia/NVIDIA-Linux-x86_64-535.230.02/kernel/nvidia-drm.mod.o Mar 19 11:44:28.194698 setup-nvidia[2308]: CC [M] /nvidia/NVIDIA-Linux-x86_64-535.230.02/kernel/nvidia-peermem.mod.o Mar 19 11:44:28.194698 setup-nvidia[2308]: LD [M] /nvidia/NVIDIA-Linux-x86_64-535.230.02/kernel/nvidia-modeset.ko Mar 19 11:44:28.194698 setup-nvidia[2308]: LD [M] /nvidia/NVIDIA-Linux-x86_64-535.230.02/kernel/nvidia-drm.ko Mar 19 11:44:28.194698 setup-nvidia[2308]: LD [M] /nvidia/NVIDIA-Linux-x86_64-535.230.02/kernel/nvidia-peermem.ko Mar 19 11:44:28.194698 setup-nvidia[2308]: LD [M] /nvidia/NVIDIA-Linux-x86_64-535.230.02/kernel/nvidia.ko Mar 19 11:44:28.194698 setup-nvidia[2308]: LD [M] /nvidia/NVIDIA-Linux-x86_64-535.230.02/kernel/nvidia-uvm.ko Mar 19 11:44:28.194698 setup-nvidia[2308]: BTF [M] /nvidia/NVIDIA-Linux-x86_64-535.230.02/kernel/nvidia-peermem.ko Mar 19 11:44:28.194698 setup-nvidia[2308]: Skipping BTF generation for /nvidia/NVIDIA-Linux-x86_64-535.230.02/kernel/nvidia-peermem.ko due to unavailability of vmlinux Mar 19 11:44:28.194698 setup-nvidia[2308]: BTF [M] /nvidia/NVIDIA-Linux-x86_64-535.230.02/kernel/nvidia-modeset.ko Mar 19 11:44:28.194698 setup-nvidia[2308]: Skipping BTF generation for /nvidia/NVIDIA-Linux-x86_64-535.230.02/kernel/nvidia-modeset.ko due to unavailability of vmlinux Mar 19 11:44:28.194698 setup-nvidia[2308]: BTF [M] /nvidia/NVIDIA-Linux-x86_64-535.230.02/kernel/nvidia-drm.ko Mar 19 11:44:28.194698 setup-nvidia[2308]: Skipping BTF generation for /nvidia/NVIDIA-Linux-x86_64-535.230.02/kernel/nvidia-drm.ko due to unavailability of vmlinux Mar 19 11:44:28.194698 setup-nvidia[2308]: BTF [M] /nvidia/NVIDIA-Linux-x86_64-535.230.02/kernel/nvidia-uvm.ko Mar 19 11:44:28.194698 setup-nvidia[2308]: Skipping BTF generation for /nvidia/NVIDIA-Linux-x86_64-535.230.02/kernel/nvidia-uvm.ko due to unavailability of vmlinux Mar 19 11:44:28.194698 setup-nvidia[2308]: BTF [M] /nvidia/NVIDIA-Linux-x86_64-535.230.02/kernel/nvidia.ko Mar 19 11:44:28.194698 setup-nvidia[2308]: Skipping BTF generation for /nvidia/NVIDIA-Linux-x86_64-535.230.02/kernel/nvidia.ko due to unavailability of vmlinux Mar 19 11:44:28.194698 setup-nvidia[2308]: make[2]: Leaving directory '/usr/lib/modules/6.6.83-flatcar/build' Mar 19 11:44:28.194698 setup-nvidia[2308]: make[1]: Leaving directory '/usr/lib/modules/6.6.83-flatcar/source' Mar 19 11:44:28.194698 setup-nvidia[2308]: -> done. Mar 19 11:44:28.194698 setup-nvidia[2308]: -> Kernel module compilation complete. Mar 19 11:44:28.194698 setup-nvidia[2308]: -> Unable to determine if Secure Boot is enabled: No such file or directory Mar 19 11:44:28.194698 setup-nvidia[2308]: ERROR: Unable to load the kernel module 'nvidia.ko'. This happens most frequently when this kernel module was built against the wrong or improperly configured kernel sources, with a version of gcc that differs from the one used to build the target kernel, or if another driver, such as nouveau, is present and prevents the NVIDIA kernel module from obtaining ownership of the NVIDIA device(s), or no NVIDIA device installed in this system is supported by this NVIDIA Linux graphics driver release. Mar 19 11:44:28.194698 setup-nvidia[2308]: \u000d Mar 19 11:44:28.195875 setup-nvidia[2308]: Please see the log entries 'Kernel module load error' and 'Kernel messages' at the end of the file '/nvidia/NVIDIA-Linux-x86_64-535.230.02/nvidia-installer.log' for more information. Mar 19 11:44:28.195875 setup-nvidia[2308]: -> Kernel module load error: Operation not permitted Mar 19 11:44:28.195875 setup-nvidia[2308]: -> Kernel messages: Mar 19 11:44:28.195875 setup-nvidia[2308]: ERROR: Installation has failed. Please see the file '/nvidia/NVIDIA-Linux-x86_64-535.230.02/nvidia-installer.log' for details. You may find suggestions on fixing installation problems in the README available on the Linux driver download page at www.nvidia.com. Mar 19 11:44:36.144572 systemd[1]: Started sshd@25-10.200.8.11:22-10.200.16.10:41672.service - OpenSSH per-connection server daemon (10.200.16.10:41672). Mar 19 11:44:36.795180 sshd[12942]: Accepted publickey for core from 10.200.16.10 port 41672 ssh2: RSA SHA256:spf3OijCpLuZYElFk97aEjkfr8djrCt0njqv3sYaas8 Mar 19 11:44:36.796546 sshd-session[12942]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Mar 19 11:44:36.800765 systemd-logind[1706]: New session 28 of user core. Mar 19 11:44:36.815908 systemd[1]: Started session-28.scope - Session 28 of User core. Mar 19 11:44:37.255069 sshd[12944]: Connection closed by 10.200.16.10 port 41672 Mar 19 11:44:37.255478 sshd-session[12942]: pam_unix(sshd:session): session closed for user core Mar 19 11:44:37.258766 systemd[1]: sshd@25-10.200.8.11:22-10.200.16.10:41672.service: Deactivated successfully. Mar 19 11:44:37.260406 systemd[1]: session-28.scope: Deactivated successfully. Mar 19 11:44:37.261060 systemd-logind[1706]: Session 28 logged out. Waiting for processes to exit. Mar 19 11:44:37.261866 systemd-logind[1706]: Removed session 28. Mar 19 11:44:37.371442 systemd[1]: Started sshd@26-10.200.8.11:22-10.200.16.10:41686.service - OpenSSH per-connection server daemon (10.200.16.10:41686). Mar 19 11:44:38.021243 sshd[12950]: Accepted publickey for core from 10.200.16.10 port 41686 ssh2: RSA SHA256:spf3OijCpLuZYElFk97aEjkfr8djrCt0njqv3sYaas8 Mar 19 11:44:38.022686 sshd-session[12950]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Mar 19 11:44:38.026904 systemd-logind[1706]: New session 29 of user core. Mar 19 11:44:38.036879 systemd[1]: Started session-29.scope - Session 29 of User core. Mar 19 11:44:38.477565 sshd[12952]: Connection closed by 10.200.16.10 port 41686 Mar 19 11:44:38.477937 sshd-session[12950]: pam_unix(sshd:session): session closed for user core Mar 19 11:44:38.481282 systemd[1]: sshd@26-10.200.8.11:22-10.200.16.10:41686.service: Deactivated successfully. Mar 19 11:44:38.483172 systemd[1]: session-29.scope: Deactivated successfully. Mar 19 11:44:38.483855 systemd-logind[1706]: Session 29 logged out. Waiting for processes to exit. Mar 19 11:44:38.484682 systemd-logind[1706]: Removed session 29. Mar 19 11:44:42.980769 kernel: EXT4-fs (loop6p9): unmounting filesystem abca95e3-c627-4304-9eb1-ed9b39d44da4. Mar 19 11:44:42.981571 setup-nvidia[2308]: Container flatcardevelopercontainer-4230.1.0.bin exited successfully. Mar 19 11:44:42.984048 systemd[1]: run-systemd-nspawn-unix\x2dexport-flatcardevelopercontainer\x2d4230.1.0.bin.mount: Deactivated successfully. Mar 19 11:44:43.047773 sudo[2290]: pam_unix(sudo:session): session closed for user root Mar 19 11:44:43.049575 systemd[1]: session-c2.scope: Deactivated successfully. Mar 19 11:44:43.049871 systemd[1]: session-c2.scope: Consumed 5min 23.011s CPU time, 881.9M memory peak. Mar 19 11:44:43.451270 setup-nvidia[1698]: /opt/nvidia / Mar 19 11:44:43.452301 setup-nvidia[1698]: / Mar 19 11:44:43.468586 setup-nvidia[12977]: ldconfig: /usr/lib/ld.so.conf is not an ELF file - it has the wrong magic bytes at the start. Mar 19 11:44:43.493765 kernel: IPMI message handler: version 39.2 Mar 19 11:44:43.496753 kernel: ipmi device interface Mar 19 11:44:43.498127 setup-nvidia[1698]: /opt/nvidia/current/usr/lib/modules/6.6.83-flatcar/video / Mar 19 11:44:43.550090 kernel: nvidia: loading out-of-tree module taints kernel. Mar 19 11:44:43.550224 kernel: nvidia: module license 'NVIDIA' taints kernel. Mar 19 11:44:43.550248 kernel: Disabling lock debugging due to kernel taint Mar 19 11:44:43.557365 kernel: nvidia: module verification failed: signature and/or required key missing - tainting kernel Mar 19 11:44:43.557427 kernel: nvidia: module license taints kernel. Mar 19 11:44:43.948763 kernel: nvidia-nvlink: Nvlink Core is being initialized, major device number 245 Mar 19 11:44:44.350798 kernel: Mar 19 11:44:44.350944 kernel: nvidia 0001:00:00.0: enabling device (0000 -> 0002) Mar 19 11:44:44.553268 kernel: NVRM: loading NVIDIA UNIX x86_64 Kernel Module 535.230.02 Fri Dec 20 21:42:05 UTC 2024 Mar 19 11:44:44.578770 kernel: nvidia-modeset: Loading NVIDIA Kernel Mode Setting Driver for UNIX platforms 535.230.02 Fri Dec 20 21:52:34 UTC 2024 Mar 19 11:44:44.598768 kernel: nvidia_uvm: module uses symbols nvUvmInterfaceDisableAccessCntr from proprietary module nvidia, inheriting taint. Mar 19 11:44:44.641615 setup-nvidia[1698]: / Mar 19 11:44:44.641973 kernel: nvidia-uvm: Loaded the UVM driver, major device number 243. Mar 19 11:44:46.428188 setup-nvidia[13007]: Wed Mar 19 11:44:46 2025 Mar 19 11:44:46.428188 setup-nvidia[13007]: +---------------------------------------------------------------------------------------+ Mar 19 11:44:46.428188 setup-nvidia[13007]: | NVIDIA-SMI 535.230.02 Driver Version: 535.230.02 CUDA Version: 12.2 | Mar 19 11:44:46.428188 setup-nvidia[13007]: |-----------------------------------------+----------------------+----------------------+ Mar 19 11:44:46.428188 setup-nvidia[13007]: | GPU Name Persistence-M | Bus-Id Disp.A | Volatile Uncorr. ECC | Mar 19 11:44:46.428188 setup-nvidia[13007]: | Fan Temp Perf Pwr:Usage/Cap | Memory-Usage | GPU-Util Compute M. | Mar 19 11:44:46.428188 setup-nvidia[13007]: | | | MIG M. | Mar 19 11:44:46.428188 setup-nvidia[13007]: |=========================================+======================+======================| Mar 19 11:44:46.431714 setup-nvidia[13007]: | 0 Tesla V100-PCIE-16GB Off | 00000001:00:00.0 Off | Off | Mar 19 11:44:46.431714 setup-nvidia[13007]: | N/A 25C P0 36W / 250W | 0MiB / 16384MiB | 0% Default | Mar 19 11:44:46.431714 setup-nvidia[13007]: | | | N/A | Mar 19 11:44:46.431714 setup-nvidia[13007]: +-----------------------------------------+----------------------+----------------------+ Mar 19 11:44:46.431845 setup-nvidia[13007]: Mar 19 11:44:46.431845 setup-nvidia[13007]: +---------------------------------------------------------------------------------------+ Mar 19 11:44:46.431845 setup-nvidia[13007]: | Processes: | Mar 19 11:44:46.431845 setup-nvidia[13007]: | GPU GI CI PID Type Process name GPU Memory | Mar 19 11:44:46.431845 setup-nvidia[13007]: | ID ID Usage | Mar 19 11:44:46.431845 setup-nvidia[13007]: |=======================================================================================| Mar 19 11:44:46.431978 setup-nvidia[13007]: | No running processes found | Mar 19 11:44:46.431978 setup-nvidia[13007]: +---------------------------------------------------------------------------------------+ Mar 19 11:44:46.806355 systemd[1]: Finished nvidia.service - NVIDIA Configure Service. Mar 19 11:44:46.808509 systemd[1]: Reached target multi-user.target - Multi-User System. Mar 19 11:44:46.808868 systemd[1]: Startup finished in 1.110s (firmware) + 30.906s (loader) + 1.837s (kernel) + 12.086s (initrd) + 3min 33.933s (userspace) = 4min 19.873s. Mar 19 11:44:48.610623 systemd[1]: Started sshd@27-10.200.8.11:22-10.200.16.10:51502.service - OpenSSH per-connection server daemon (10.200.16.10:51502). Mar 19 11:44:49.262759 sshd[13014]: Accepted publickey for core from 10.200.16.10 port 51502 ssh2: RSA SHA256:spf3OijCpLuZYElFk97aEjkfr8djrCt0njqv3sYaas8 Mar 19 11:44:49.264173 sshd-session[13014]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Mar 19 11:44:49.268948 systemd-logind[1706]: New session 30 of user core. Mar 19 11:44:49.280170 systemd[1]: Started session-30.scope - Session 30 of User core. Mar 19 11:44:49.724596 sshd[13016]: Connection closed by 10.200.16.10 port 51502 Mar 19 11:44:49.725037 sshd-session[13014]: pam_unix(sshd:session): session closed for user core Mar 19 11:44:49.728502 systemd[1]: sshd@27-10.200.8.11:22-10.200.16.10:51502.service: Deactivated successfully. Mar 19 11:44:49.730277 systemd[1]: session-30.scope: Deactivated successfully. Mar 19 11:44:49.730916 systemd-logind[1706]: Session 30 logged out. Waiting for processes to exit. Mar 19 11:44:49.731691 systemd-logind[1706]: Removed session 30. Mar 19 11:44:49.839433 systemd[1]: Started sshd@28-10.200.8.11:22-10.200.16.10:51512.service - OpenSSH per-connection server daemon (10.200.16.10:51512). Mar 19 11:44:50.489854 sshd[13022]: Accepted publickey for core from 10.200.16.10 port 51512 ssh2: RSA SHA256:spf3OijCpLuZYElFk97aEjkfr8djrCt0njqv3sYaas8 Mar 19 11:44:50.490842 sshd-session[13022]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Mar 19 11:44:50.495064 systemd-logind[1706]: New session 31 of user core. Mar 19 11:44:50.507898 systemd[1]: Started session-31.scope - Session 31 of User core. Mar 19 11:44:50.949663 sshd[13025]: Connection closed by 10.200.16.10 port 51512 Mar 19 11:44:50.950121 sshd-session[13022]: pam_unix(sshd:session): session closed for user core Mar 19 11:44:50.953427 systemd[1]: sshd@28-10.200.8.11:22-10.200.16.10:51512.service: Deactivated successfully. Mar 19 11:44:50.955182 systemd[1]: session-31.scope: Deactivated successfully. Mar 19 11:44:50.955821 systemd-logind[1706]: Session 31 logged out. Waiting for processes to exit. Mar 19 11:44:50.956595 systemd-logind[1706]: Removed session 31. Mar 19 11:44:51.064535 systemd[1]: Started sshd@29-10.200.8.11:22-10.200.16.10:51520.service - OpenSSH per-connection server daemon (10.200.16.10:51520). Mar 19 11:44:51.715053 sshd[13031]: Accepted publickey for core from 10.200.16.10 port 51520 ssh2: RSA SHA256:spf3OijCpLuZYElFk97aEjkfr8djrCt0njqv3sYaas8 Mar 19 11:44:51.717812 sshd-session[13031]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Mar 19 11:44:51.722661 systemd-logind[1706]: New session 32 of user core. Mar 19 11:44:51.731986 systemd[1]: Started session-32.scope - Session 32 of User core. Mar 19 11:44:52.173604 sshd[13033]: Connection closed by 10.200.16.10 port 51520 Mar 19 11:44:52.174054 sshd-session[13031]: pam_unix(sshd:session): session closed for user core Mar 19 11:44:52.177440 systemd[1]: sshd@29-10.200.8.11:22-10.200.16.10:51520.service: Deactivated successfully. Mar 19 11:44:52.179118 systemd[1]: session-32.scope: Deactivated successfully. Mar 19 11:44:52.179741 systemd-logind[1706]: Session 32 logged out. Waiting for processes to exit. Mar 19 11:44:52.180508 systemd-logind[1706]: Removed session 32. Mar 19 11:44:52.289826 systemd[1]: Started sshd@30-10.200.8.11:22-10.200.16.10:51536.service - OpenSSH per-connection server daemon (10.200.16.10:51536). Mar 19 11:44:52.941242 sshd[13039]: Accepted publickey for core from 10.200.16.10 port 51536 ssh2: RSA SHA256:spf3OijCpLuZYElFk97aEjkfr8djrCt0njqv3sYaas8 Mar 19 11:44:52.942685 sshd-session[13039]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Mar 19 11:44:52.946904 systemd-logind[1706]: New session 33 of user core. Mar 19 11:44:52.958890 systemd[1]: Started session-33.scope - Session 33 of User core. Mar 19 11:44:53.134005 systemd[1]: Stopping user@0.service - User Manager for UID 0... Mar 19 11:44:53.134825 systemd[2299]: Activating special unit exit.target... Mar 19 11:44:53.134912 systemd[2299]: Stopped target default.target - Main User Target. Mar 19 11:44:53.134954 systemd[2299]: Stopped target basic.target - Basic System. Mar 19 11:44:53.134984 systemd[2299]: Stopped target paths.target - Paths. Mar 19 11:44:53.135012 systemd[2299]: Stopped target sockets.target - Sockets. Mar 19 11:44:53.135040 systemd[2299]: Stopped target timers.target - Timers. Mar 19 11:44:53.135390 systemd[2299]: Closed dbus.socket - D-Bus User Message Bus Socket. Mar 19 11:44:53.135601 systemd[2299]: Removed slice app.slice - User Application Slice. Mar 19 11:44:53.135634 systemd[2299]: Reached target shutdown.target - Shutdown. Mar 19 11:44:53.135805 systemd[2299]: Finished systemd-exit.service - Exit the Session. Mar 19 11:44:53.135847 systemd[2299]: Reached target exit.target - Exit the Session. Mar 19 11:44:53.148517 (sd-pam)[2300]: pam_unix(systemd-user:session): session closed for user root Mar 19 11:44:53.149991 systemd[1]: user@0.service: Deactivated successfully. Mar 19 11:44:53.150353 systemd[1]: Stopped user@0.service - User Manager for UID 0. Mar 19 11:44:53.160100 systemd[1]: Stopping user-runtime-dir@0.service - User Runtime Directory /run/user/0... Mar 19 11:44:53.169223 systemd[1]: run-user-0.mount: Deactivated successfully. Mar 19 11:44:53.170080 systemd[1]: user-runtime-dir@0.service: Deactivated successfully. Mar 19 11:44:53.170280 systemd[1]: Stopped user-runtime-dir@0.service - User Runtime Directory /run/user/0. Mar 19 11:44:53.172165 systemd[1]: Removed slice user-0.slice - User Slice of UID 0. Mar 19 11:44:53.172254 systemd[1]: user-0.slice: Consumed 5min 23.259s CPU time, 891.5M memory peak. Mar 19 11:44:53.172627 systemd-logind[1706]: Removed session c3. Mar 19 11:44:53.298294 sudo[13046]: core : PWD=/home/core ; USER=root ; COMMAND=/usr/sbin/setenforce 1 Mar 19 11:44:53.298606 sudo[13046]: pam_unix(sudo:session): session opened for user root(uid=0) by core(uid=500) Mar 19 11:44:53.313076 sudo[13046]: pam_unix(sudo:session): session closed for user root Mar 19 11:44:53.416706 sshd[13041]: Connection closed by 10.200.16.10 port 51536 Mar 19 11:44:53.417216 sshd-session[13039]: pam_unix(sshd:session): session closed for user core Mar 19 11:44:53.420820 systemd[1]: sshd@30-10.200.8.11:22-10.200.16.10:51536.service: Deactivated successfully. Mar 19 11:44:53.422444 systemd[1]: session-33.scope: Deactivated successfully. Mar 19 11:44:53.423098 systemd-logind[1706]: Session 33 logged out. Waiting for processes to exit. Mar 19 11:44:53.423908 systemd-logind[1706]: Removed session 33. Mar 19 11:44:53.531867 systemd[1]: Started sshd@31-10.200.8.11:22-10.200.16.10:51542.service - OpenSSH per-connection server daemon (10.200.16.10:51542). Mar 19 11:44:54.181202 sshd[13052]: Accepted publickey for core from 10.200.16.10 port 51542 ssh2: RSA SHA256:spf3OijCpLuZYElFk97aEjkfr8djrCt0njqv3sYaas8 Mar 19 11:44:54.182599 sshd-session[13052]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Mar 19 11:44:54.194965 systemd-logind[1706]: New session 34 of user core. Mar 19 11:44:54.211989 systemd[1]: Started session-34.scope - Session 34 of User core. Mar 19 11:44:54.536949 sudo[13056]: 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 Mar 19 11:44:54.537272 sudo[13056]: pam_unix(sudo:session): session opened for user root(uid=0) by core(uid=500) Mar 19 11:44:54.540492 sudo[13056]: pam_unix(sudo:session): session closed for user root Mar 19 11:44:54.546109 sudo[13055]: core : PWD=/home/core ; USER=root ; COMMAND=/usr/sbin/systemctl restart audit-rules Mar 19 11:44:54.546404 sudo[13055]: pam_unix(sudo:session): session opened for user root(uid=0) by core(uid=500) Mar 19 11:44:54.561052 systemd[1]: Starting audit-rules.service - Load Audit Rules... Mar 19 11:44:54.975959 augenrules[13078]: No rules Mar 19 11:44:54.977325 systemd[1]: audit-rules.service: Deactivated successfully. Mar 19 11:44:54.977573 systemd[1]: Finished audit-rules.service - Load Audit Rules. Mar 19 11:44:54.979499 sudo[13055]: pam_unix(sudo:session): session closed for user root Mar 19 11:44:55.085604 sshd[13054]: Connection closed by 10.200.16.10 port 51542 Mar 19 11:44:55.086119 sshd-session[13052]: pam_unix(sshd:session): session closed for user core Mar 19 11:44:55.089641 systemd[1]: sshd@31-10.200.8.11:22-10.200.16.10:51542.service: Deactivated successfully. Mar 19 11:44:55.091336 systemd[1]: session-34.scope: Deactivated successfully. Mar 19 11:44:55.091995 systemd-logind[1706]: Session 34 logged out. Waiting for processes to exit. Mar 19 11:44:55.092787 systemd-logind[1706]: Removed session 34. Mar 19 11:44:55.208726 systemd[1]: Started sshd@32-10.200.8.11:22-10.200.16.10:51546.service - OpenSSH per-connection server daemon (10.200.16.10:51546). Mar 19 11:44:55.858545 sshd[13087]: Accepted publickey for core from 10.200.16.10 port 51546 ssh2: RSA SHA256:spf3OijCpLuZYElFk97aEjkfr8djrCt0njqv3sYaas8 Mar 19 11:44:55.859941 sshd-session[13087]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Mar 19 11:44:55.865237 systemd-logind[1706]: New session 35 of user core. Mar 19 11:44:55.877879 systemd[1]: Started session-35.scope - Session 35 of User core. Mar 19 11:44:56.215092 sudo[13090]: core : PWD=/home/core ; USER=root ; COMMAND=/usr/sbin/mkdir -p . Mar 19 11:44:56.215420 sudo[13090]: pam_unix(sudo:session): session opened for user root(uid=0) by core(uid=500) Mar 19 11:44:56.218664 sudo[13090]: pam_unix(sudo:session): session closed for user root Mar 19 11:44:56.327600 sshd[13089]: Connection closed by 10.200.16.10 port 51546 Mar 19 11:44:56.328049 sshd-session[13087]: pam_unix(sshd:session): session closed for user core Mar 19 11:44:56.331402 systemd[1]: sshd@32-10.200.8.11:22-10.200.16.10:51546.service: Deactivated successfully. Mar 19 11:44:56.333129 systemd[1]: session-35.scope: Deactivated successfully. Mar 19 11:44:56.333770 systemd-logind[1706]: Session 35 logged out. Waiting for processes to exit. Mar 19 11:44:56.334536 systemd-logind[1706]: Removed session 35. Mar 19 11:44:56.448416 systemd[1]: Started sshd@33-10.200.8.11:22-10.200.16.10:51550.service - OpenSSH per-connection server daemon (10.200.16.10:51550). Mar 19 11:44:57.098412 sshd[13096]: Accepted publickey for core from 10.200.16.10 port 51550 ssh2: RSA SHA256:spf3OijCpLuZYElFk97aEjkfr8djrCt0njqv3sYaas8 Mar 19 11:44:57.099727 sshd-session[13096]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Mar 19 11:44:57.104486 systemd-logind[1706]: New session 36 of user core. Mar 19 11:44:57.120920 systemd[1]: Started session-36.scope - Session 36 of User core. Mar 19 11:44:57.454779 sudo[13099]: core : PWD=/home/core ; USER=root ; COMMAND=/usr/sbin/install -m 0755 /dev/stdin kolet Mar 19 11:44:57.455095 sudo[13099]: pam_unix(sudo:session): session opened for user root(uid=0) by core(uid=500) Mar 19 11:45:01.056324 sudo[13099]: pam_unix(sudo:session): session closed for user root Mar 19 11:45:01.165438 sshd[13098]: Connection closed by 10.200.16.10 port 51550 Mar 19 11:45:01.166418 sshd-session[13096]: pam_unix(sshd:session): session closed for user core Mar 19 11:45:01.169755 systemd[1]: sshd@33-10.200.8.11:22-10.200.16.10:51550.service: Deactivated successfully. Mar 19 11:45:01.171408 systemd[1]: session-36.scope: Deactivated successfully. Mar 19 11:45:01.172036 systemd-logind[1706]: Session 36 logged out. Waiting for processes to exit. Mar 19 11:45:01.172826 systemd-logind[1706]: Removed session 36. Mar 19 11:45:01.280580 systemd[1]: Started sshd@34-10.200.8.11:22-10.200.16.10:46824.service - OpenSSH per-connection server daemon (10.200.16.10:46824). Mar 19 11:45:01.933474 sshd[13105]: Accepted publickey for core from 10.200.16.10 port 46824 ssh2: RSA SHA256:spf3OijCpLuZYElFk97aEjkfr8djrCt0njqv3sYaas8 Mar 19 11:45:01.934906 sshd-session[13105]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Mar 19 11:45:01.939046 systemd-logind[1706]: New session 37 of user core. Mar 19 11:45:01.954922 systemd[1]: Started session-37.scope - Session 37 of User core. Mar 19 11:45:02.519003 sshd[13107]: Connection closed by 10.200.16.10 port 46824 Mar 19 11:45:02.519474 sshd-session[13105]: pam_unix(sshd:session): session closed for user core Mar 19 11:45:02.522874 systemd[1]: sshd@34-10.200.8.11:22-10.200.16.10:46824.service: Deactivated successfully. Mar 19 11:45:02.524583 systemd[1]: session-37.scope: Deactivated successfully. Mar 19 11:45:02.525952 systemd-logind[1706]: Session 37 logged out. Waiting for processes to exit. Mar 19 11:45:02.526957 systemd-logind[1706]: Removed session 37. Mar 19 11:45:02.634499 systemd[1]: Started sshd@35-10.200.8.11:22-10.200.16.10:46826.service - OpenSSH per-connection server daemon (10.200.16.10:46826). Mar 19 11:45:03.299844 sshd[13123]: Accepted publickey for core from 10.200.16.10 port 46826 ssh2: RSA SHA256:spf3OijCpLuZYElFk97aEjkfr8djrCt0njqv3sYaas8 Mar 19 11:45:03.301265 sshd-session[13123]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Mar 19 11:45:03.305458 systemd-logind[1706]: New session 38 of user core. Mar 19 11:45:03.314877 systemd[1]: Started session-38.scope - Session 38 of User core. Mar 19 11:45:04.599998 systemd[1]: Starting docker.service - Docker Application Container Engine... Mar 19 11:45:04.600464 (dockerd)[13145]: 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 Mar 19 11:45:08.280752 dockerd[13145]: time="2025-03-19T11:45:08.280672369Z" level=info msg="Starting up" Mar 19 11:45:09.287992 dockerd[13145]: time="2025-03-19T11:45:09.287938487Z" level=info msg="Loading containers: start." Mar 19 11:45:09.462760 kernel: Initializing XFRM netlink socket Mar 19 11:45:09.525092 systemd-networkd[1400]: docker0: Link UP Mar 19 11:45:09.585283 dockerd[13145]: time="2025-03-19T11:45:09.585108014Z" level=info msg="Loading containers: done." Mar 19 11:45:09.599429 systemd[1]: var-lib-docker-overlay2-opaque\x2dbug\x2dcheck277899847-merged.mount: Deactivated successfully. Mar 19 11:45:09.612930 dockerd[13145]: time="2025-03-19T11:45:09.612881295Z" 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 Mar 19 11:45:09.613062 dockerd[13145]: time="2025-03-19T11:45:09.613041889Z" level=info msg="Docker daemon" commit=41ca978a0a5400cc24b274137efa9f25517fcc0b containerd-snapshotter=false storage-driver=overlay2 version=27.3.1 Mar 19 11:45:09.613188 dockerd[13145]: time="2025-03-19T11:45:09.613165684Z" level=info msg="Daemon has completed initialization" Mar 19 11:45:09.690049 dockerd[13145]: time="2025-03-19T11:45:09.689983389Z" level=info msg="API listen on /run/docker.sock" Mar 19 11:45:09.690188 systemd[1]: Started docker.service - Docker Application Container Engine. Mar 19 11:45:10.958933 systemd[1]: var-lib-docker-overlay2-80637494c606aed86ac70385ca41765dc3a55c7683be383fbd3298bdda0376e0\x2dinit-merged.mount: Deactivated successfully. Mar 19 11:45:11.083416 kernel: docker0: port 1(veth56e00ba) entered blocking state Mar 19 11:45:11.083539 kernel: docker0: port 1(veth56e00ba) entered disabled state Mar 19 11:45:11.083562 kernel: veth56e00ba: entered allmulticast mode Mar 19 11:45:11.088448 kernel: veth56e00ba: entered promiscuous mode Mar 19 11:45:11.089125 systemd-networkd[1400]: veth56e00ba: Link UP Mar 19 11:45:12.207168 containerd[1727]: time="2025-03-19T11:45:12.207071981Z" level=info msg="loading plugin \"io.containerd.event.v1.publisher\"..." runtime=io.containerd.runc.v2 type=io.containerd.event.v1 Mar 19 11:45:12.207168 containerd[1727]: time="2025-03-19T11:45:12.207140978Z" level=info msg="loading plugin \"io.containerd.internal.v1.shutdown\"..." runtime=io.containerd.runc.v2 type=io.containerd.internal.v1 Mar 19 11:45:12.207168 containerd[1727]: time="2025-03-19T11:45:12.207155078Z" level=info msg="loading plugin \"io.containerd.ttrpc.v1.task\"..." runtime=io.containerd.runc.v2 type=io.containerd.ttrpc.v1 Mar 19 11:45:12.207630 containerd[1727]: time="2025-03-19T11:45:12.207235374Z" level=info msg="loading plugin \"io.containerd.ttrpc.v1.pause\"..." runtime=io.containerd.runc.v2 type=io.containerd.ttrpc.v1 Mar 19 11:45:12.257957 systemd[1]: Started docker-ed1d7debed1342a0c0b9fe977a6fdb2a92e77c1d185b1e7aa3ea1542ca304c90.scope - libcontainer container ed1d7debed1342a0c0b9fe977a6fdb2a92e77c1d185b1e7aa3ea1542ca304c90. Mar 19 11:45:12.317761 kernel: eth0: renamed from veth413e0e0 Mar 19 11:45:12.332387 kernel: docker0: port 1(veth56e00ba) entered blocking state Mar 19 11:45:12.332478 kernel: docker0: port 1(veth56e00ba) entered forwarding state Mar 19 11:45:12.332517 systemd-networkd[1400]: veth56e00ba: Gained carrier Mar 19 11:45:12.332836 systemd-networkd[1400]: docker0: Gained carrier Mar 19 11:45:13.876927 systemd-networkd[1400]: veth56e00ba: Gained IPv6LL Mar 19 11:45:14.388906 systemd-networkd[1400]: docker0: Gained IPv6LL Mar 19 11:45:15.625979 systemd[1]: docker-ed1d7debed1342a0c0b9fe977a6fdb2a92e77c1d185b1e7aa3ea1542ca304c90.scope: Deactivated successfully. Mar 19 11:45:15.638653 dockerd[13145]: time="2025-03-19T11:45:15.638595960Z" level=info msg="ignoring event" container=ed1d7debed1342a0c0b9fe977a6fdb2a92e77c1d185b1e7aa3ea1542ca304c90 module=libcontainerd namespace=moby topic=/tasks/delete type="*events.TaskDelete" Mar 19 11:45:15.639084 containerd[1727]: time="2025-03-19T11:45:15.639024943Z" level=info msg="shim disconnected" id=ed1d7debed1342a0c0b9fe977a6fdb2a92e77c1d185b1e7aa3ea1542ca304c90 namespace=moby Mar 19 11:45:15.639307 containerd[1727]: time="2025-03-19T11:45:15.639083141Z" level=warning msg="cleaning up after shim disconnected" id=ed1d7debed1342a0c0b9fe977a6fdb2a92e77c1d185b1e7aa3ea1542ca304c90 namespace=moby Mar 19 11:45:15.639307 containerd[1727]: time="2025-03-19T11:45:15.639093340Z" level=info msg="cleaning up dead shim" namespace=moby Mar 19 11:45:15.676597 systemd-networkd[1400]: veth56e00ba: Lost carrier Mar 19 11:45:15.676959 kernel: docker0: port 1(veth56e00ba) entered disabled state Mar 19 11:45:15.676990 kernel: veth413e0e0: renamed from eth0 Mar 19 11:45:15.705045 systemd-networkd[1400]: veth56e00ba: Link DOWN Mar 19 11:45:15.712557 kernel: docker0: port 1(veth56e00ba) entered disabled state Mar 19 11:45:15.712637 kernel: veth56e00ba (unregistering): left allmulticast mode Mar 19 11:45:15.716029 kernel: veth56e00ba (unregistering): left promiscuous mode Mar 19 11:45:15.719484 kernel: docker0: port 1(veth56e00ba) entered disabled state Mar 19 11:45:15.767266 systemd[1]: run-docker-netns-a246b3d1637a.mount: Deactivated successfully. Mar 19 11:45:15.773873 systemd[1]: var-lib-docker-overlay2-80637494c606aed86ac70385ca41765dc3a55c7683be383fbd3298bdda0376e0-merged.mount: Deactivated successfully. Mar 19 11:45:15.925503 sshd[13125]: Connection closed by 10.200.16.10 port 46826 Mar 19 11:45:15.926213 sshd-session[13123]: pam_unix(sshd:session): session closed for user core Mar 19 11:45:15.928764 systemd[1]: sshd@35-10.200.8.11:22-10.200.16.10:46826.service: Deactivated successfully. Mar 19 11:45:15.930508 systemd[1]: session-38.scope: Deactivated successfully. Mar 19 11:45:15.931828 systemd-logind[1706]: Session 38 logged out. Waiting for processes to exit. Mar 19 11:45:15.932617 systemd-logind[1706]: Removed session 38. Mar 19 11:45:16.040460 systemd[1]: Started sshd@36-10.200.8.11:22-10.200.16.10:56156.service - OpenSSH per-connection server daemon (10.200.16.10:56156). Mar 19 11:45:16.688463 sshd[13417]: Accepted publickey for core from 10.200.16.10 port 56156 ssh2: RSA SHA256:spf3OijCpLuZYElFk97aEjkfr8djrCt0njqv3sYaas8 Mar 19 11:45:16.689835 sshd-session[13417]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Mar 19 11:45:16.692948 systemd-networkd[1400]: docker0: Lost carrier Mar 19 11:45:16.694072 systemd-logind[1706]: New session 39 of user core. Mar 19 11:45:16.706909 systemd[1]: Started session-39.scope - Session 39 of User core. Mar 19 11:45:17.103878 systemd[1]: var-lib-docker-overlay2-1d32e3885f977e0f63bd87fc68d1350a8d27a2e030839200af0dd39877c40259\x2dinit-merged.mount: Deactivated successfully. Mar 19 11:45:17.229418 kernel: docker0: port 1(vetha380065) entered blocking state Mar 19 11:45:17.229533 kernel: docker0: port 1(vetha380065) entered disabled state Mar 19 11:45:17.232340 kernel: vetha380065: entered allmulticast mode Mar 19 11:45:17.232754 kernel: vetha380065: entered promiscuous mode Mar 19 11:45:17.235757 kernel: docker0: port 1(vetha380065) entered blocking state Mar 19 11:45:17.236092 systemd-networkd[1400]: vetha380065: Link UP Mar 19 11:45:17.242068 kernel: docker0: port 1(vetha380065) entered forwarding state Mar 19 11:45:17.242769 kernel: docker0: port 1(vetha380065) entered disabled state Mar 19 11:45:17.346000 containerd[1727]: time="2025-03-19T11:45:17.345911590Z" level=info msg="loading plugin \"io.containerd.event.v1.publisher\"..." runtime=io.containerd.runc.v2 type=io.containerd.event.v1 Mar 19 11:45:17.346000 containerd[1727]: time="2025-03-19T11:45:17.345972287Z" level=info msg="loading plugin \"io.containerd.internal.v1.shutdown\"..." runtime=io.containerd.runc.v2 type=io.containerd.internal.v1 Mar 19 11:45:17.346000 containerd[1727]: time="2025-03-19T11:45:17.345984987Z" level=info msg="loading plugin \"io.containerd.ttrpc.v1.task\"..." runtime=io.containerd.runc.v2 type=io.containerd.ttrpc.v1 Mar 19 11:45:17.346441 containerd[1727]: time="2025-03-19T11:45:17.346060384Z" level=info msg="loading plugin \"io.containerd.ttrpc.v1.pause\"..." runtime=io.containerd.runc.v2 type=io.containerd.ttrpc.v1 Mar 19 11:45:17.370891 systemd[1]: Started docker-e961c53c99b2b16d3673e9a3d423d73603aa52fe79a20242dc9198285284ea27.scope - libcontainer container e961c53c99b2b16d3673e9a3d423d73603aa52fe79a20242dc9198285284ea27. Mar 19 11:45:17.432765 kernel: eth0: renamed from veth35ec341 Mar 19 11:45:17.446758 kernel: docker0: port 1(vetha380065) entered blocking state Mar 19 11:45:17.446841 kernel: docker0: port 1(vetha380065) entered forwarding state Mar 19 11:45:17.447163 systemd-networkd[1400]: vetha380065: Gained carrier Mar 19 11:45:17.447498 systemd-networkd[1400]: docker0: Gained carrier Mar 19 11:45:17.485209 systemd[1]: docker-e961c53c99b2b16d3673e9a3d423d73603aa52fe79a20242dc9198285284ea27.scope: Deactivated successfully. Mar 19 11:45:17.515326 containerd[1727]: time="2025-03-19T11:45:17.515260369Z" level=info msg="shim disconnected" id=e961c53c99b2b16d3673e9a3d423d73603aa52fe79a20242dc9198285284ea27 namespace=moby Mar 19 11:45:17.515687 containerd[1727]: time="2025-03-19T11:45:17.515383864Z" level=warning msg="cleaning up after shim disconnected" id=e961c53c99b2b16d3673e9a3d423d73603aa52fe79a20242dc9198285284ea27 namespace=moby Mar 19 11:45:17.515687 containerd[1727]: time="2025-03-19T11:45:17.515396963Z" level=info msg="cleaning up dead shim" namespace=moby Mar 19 11:45:17.515781 dockerd[13145]: time="2025-03-19T11:45:17.515413562Z" level=info msg="ignoring event" container=e961c53c99b2b16d3673e9a3d423d73603aa52fe79a20242dc9198285284ea27 module=libcontainerd namespace=moby topic=/tasks/delete type="*events.TaskDelete" Mar 19 11:45:17.552541 systemd-networkd[1400]: vetha380065: Lost carrier Mar 19 11:45:17.552754 kernel: docker0: port 1(vetha380065) entered disabled state Mar 19 11:45:17.552795 kernel: veth35ec341: renamed from eth0 Mar 19 11:45:17.592388 systemd-networkd[1400]: vetha380065: Link DOWN Mar 19 11:45:17.599581 kernel: docker0: port 1(vetha380065) entered disabled state Mar 19 11:45:17.599650 kernel: vetha380065 (unregistering): left allmulticast mode Mar 19 11:45:17.602856 kernel: vetha380065 (unregistering): left promiscuous mode Mar 19 11:45:17.606216 kernel: docker0: port 1(vetha380065) entered disabled state Mar 19 11:45:17.701002 systemd-networkd[1400]: docker0: Lost carrier Mar 19 11:45:17.779939 sshd[13419]: Connection closed by 10.200.16.10 port 56156 Mar 19 11:45:17.780372 sshd-session[13417]: pam_unix(sshd:session): session closed for user core Mar 19 11:45:17.783799 systemd[1]: sshd@36-10.200.8.11:22-10.200.16.10:56156.service: Deactivated successfully. Mar 19 11:45:17.785506 systemd[1]: session-39.scope: Deactivated successfully. Mar 19 11:45:17.786159 systemd-logind[1706]: Session 39 logged out. Waiting for processes to exit. Mar 19 11:45:17.786918 systemd-logind[1706]: Removed session 39. Mar 19 11:45:17.896524 systemd[1]: Started sshd@37-10.200.8.11:22-10.200.16.10:56162.service - OpenSSH per-connection server daemon (10.200.16.10:56162). Mar 19 11:45:18.101254 systemd[1]: var-lib-docker-overlay2-1d32e3885f977e0f63bd87fc68d1350a8d27a2e030839200af0dd39877c40259-merged.mount: Deactivated successfully. Mar 19 11:45:18.546681 sshd[13526]: Accepted publickey for core from 10.200.16.10 port 56162 ssh2: RSA SHA256:spf3OijCpLuZYElFk97aEjkfr8djrCt0njqv3sYaas8 Mar 19 11:45:18.548052 sshd-session[13526]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Mar 19 11:45:18.552283 systemd-logind[1706]: New session 40 of user core. Mar 19 11:45:18.564896 systemd[1]: Started session-40.scope - Session 40 of User core. Mar 19 11:45:19.004798 ntpdate[13540]: ntpdate 4.2.8p17@1.4004-o Wed Mar 19 09:45:32 UTC 2025 (1) Mar 19 11:45:25.903092 ntpdate[13540]: adjust time server 193.1.8.106 offset -0.001699 sec Mar 19 11:45:26.010126 sshd[13528]: Connection closed by 10.200.16.10 port 56162 Mar 19 11:45:26.010567 sshd-session[13526]: pam_unix(sshd:session): session closed for user core Mar 19 11:45:26.013918 systemd[1]: sshd@37-10.200.8.11:22-10.200.16.10:56162.service: Deactivated successfully. Mar 19 11:45:26.015559 systemd[1]: session-40.scope: Deactivated successfully. Mar 19 11:45:26.016220 systemd-logind[1706]: Session 40 logged out. Waiting for processes to exit. Mar 19 11:45:26.017009 systemd-logind[1706]: Removed session 40.