May 14 18:07:57.939963 kernel: Linux version 6.12.20-flatcar (build@pony-truck.infra.kinvolk.io) (x86_64-cros-linux-gnu-gcc (Gentoo Hardened 14.2.1_p20241221 p7) 14.2.1 20241221, GNU ld (Gentoo 2.44 p1) 2.44.0) #1 SMP PREEMPT_DYNAMIC Wed May 14 16:37:27 -00 2025 May 14 18:07:57.939988 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=adf4ab3cd3fc72d424aa1ba920dfa0e67212fa35eadab2c698966b09b9e294b0 May 14 18:07:57.939994 kernel: BIOS-provided physical RAM map: May 14 18:07:57.939998 kernel: BIOS-e820: [mem 0x0000000000000000-0x000000000009ffff] usable May 14 18:07:57.940002 kernel: BIOS-e820: [mem 0x00000000000c0000-0x00000000000fffff] reserved May 14 18:07:57.940006 kernel: BIOS-e820: [mem 0x0000000000100000-0x000000003ff40fff] usable May 14 18:07:57.940011 kernel: BIOS-e820: [mem 0x000000003ff41000-0x000000003ffc4fff] reserved May 14 18:07:57.940017 kernel: BIOS-e820: [mem 0x000000003ffc5000-0x000000003ffd1fff] usable May 14 18:07:57.940022 kernel: BIOS-e820: [mem 0x000000003ffd2000-0x000000003fffafff] ACPI data May 14 18:07:57.940028 kernel: BIOS-e820: [mem 0x000000003fffb000-0x000000003fffefff] ACPI NVS May 14 18:07:57.940034 kernel: BIOS-e820: [mem 0x000000003ffff000-0x000000003fffffff] usable May 14 18:07:57.940040 kernel: BIOS-e820: [mem 0x0000000100000000-0x00000002bfffffff] usable May 14 18:07:57.940045 kernel: printk: legacy bootconsole [earlyser0] enabled May 14 18:07:57.940049 kernel: NX (Execute Disable) protection: active May 14 18:07:57.940055 kernel: APIC: Static calls initialized May 14 18:07:57.940059 kernel: efi: EFI v2.7 by Microsoft May 14 18:07:57.940063 kernel: efi: ACPI=0x3fffa000 ACPI 2.0=0x3fffa014 SMBIOS=0x3ff85000 SMBIOS 3.0=0x3ff83000 MEMATTR=0x3ebb9a98 RNG=0x3ffd2018 May 14 18:07:57.940067 kernel: random: crng init done May 14 18:07:57.940072 kernel: secureboot: Secure boot disabled May 14 18:07:57.940078 kernel: SMBIOS 3.1.0 present. May 14 18:07:57.940084 kernel: DMI: Microsoft Corporation Virtual Machine/Virtual Machine, BIOS Hyper-V UEFI Release v4.1 11/21/2024 May 14 18:07:57.940091 kernel: DMI: Memory slots populated: 2/2 May 14 18:07:57.940098 kernel: Hypervisor detected: Microsoft Hyper-V May 14 18:07:57.940102 kernel: Hyper-V: privilege flags low 0xae7f, high 0x3b8030, hints 0x9e4e24, misc 0xe0bed7b2 May 14 18:07:57.940106 kernel: Hyper-V: Nested features: 0x3e0101 May 14 18:07:57.940110 kernel: Hyper-V: LAPIC Timer Frequency: 0x30d40 May 14 18:07:57.940114 kernel: Hyper-V: Using hypercall for remote TLB flush May 14 18:07:57.940118 kernel: clocksource: hyperv_clocksource_tsc_page: mask: 0xffffffffffffffff max_cycles: 0x24e6a1710, max_idle_ns: 440795202120 ns May 14 18:07:57.940126 kernel: clocksource: hyperv_clocksource_msr: mask: 0xffffffffffffffff max_cycles: 0x24e6a1710, max_idle_ns: 440795202120 ns May 14 18:07:57.940132 kernel: tsc: Detected 2299.999 MHz processor May 14 18:07:57.940138 kernel: e820: update [mem 0x00000000-0x00000fff] usable ==> reserved May 14 18:07:57.940144 kernel: e820: remove [mem 0x000a0000-0x000fffff] usable May 14 18:07:57.940148 kernel: last_pfn = 0x2c0000 max_arch_pfn = 0x10000000000 May 14 18:07:57.940153 kernel: MTRR map: 4 entries (2 fixed + 2 variable; max 18), built from 8 variable MTRRs May 14 18:07:57.940158 kernel: x86/PAT: Configuration [0-7]: WB WC UC- UC WB WP UC- WT May 14 18:07:57.940162 kernel: e820: update [mem 0x48000000-0xffffffff] usable ==> reserved May 14 18:07:57.940166 kernel: last_pfn = 0x40000 max_arch_pfn = 0x10000000000 May 14 18:07:57.940171 kernel: Using GB pages for direct mapping May 14 18:07:57.940179 kernel: ACPI: Early table checksum verification disabled May 14 18:07:57.940185 kernel: ACPI: RSDP 0x000000003FFFA014 000024 (v02 VRTUAL) May 14 18:07:57.940193 kernel: ACPI: XSDT 0x000000003FFF90E8 00005C (v01 VRTUAL MICROSFT 00000001 MSFT 00000001) May 14 18:07:57.940198 kernel: ACPI: FACP 0x000000003FFF8000 000114 (v06 VRTUAL MICROSFT 00000001 MSFT 00000001) May 14 18:07:57.940203 kernel: ACPI: DSDT 0x000000003FFD6000 01E11C (v02 MSFTVM DSDT01 00000001 INTL 20230628) May 14 18:07:57.940207 kernel: ACPI: FACS 0x000000003FFFE000 000040 May 14 18:07:57.940211 kernel: ACPI: OEM0 0x000000003FFF7000 000064 (v01 VRTUAL MICROSFT 00000001 MSFT 00000001) May 14 18:07:57.940216 kernel: ACPI: SPCR 0x000000003FFF6000 000050 (v02 VRTUAL MICROSFT 00000001 MSFT 00000001) May 14 18:07:57.940221 kernel: ACPI: WAET 0x000000003FFF5000 000028 (v01 VRTUAL MICROSFT 00000001 MSFT 00000001) May 14 18:07:57.940225 kernel: ACPI: APIC 0x000000003FFD5000 000052 (v05 HVLITE HVLITETB 00000000 MSHV 00000000) May 14 18:07:57.940229 kernel: ACPI: SRAT 0x000000003FFD4000 0000A0 (v03 HVLITE HVLITETB 00000000 MSHV 00000000) May 14 18:07:57.940238 kernel: ACPI: BGRT 0x000000003FFD3000 000038 (v01 VRTUAL MICROSFT 00000001 MSFT 00000001) May 14 18:07:57.940245 kernel: ACPI: Reserving FACP table memory at [mem 0x3fff8000-0x3fff8113] May 14 18:07:57.940252 kernel: ACPI: Reserving DSDT table memory at [mem 0x3ffd6000-0x3fff411b] May 14 18:07:57.940258 kernel: ACPI: Reserving FACS table memory at [mem 0x3fffe000-0x3fffe03f] May 14 18:07:57.940262 kernel: ACPI: Reserving OEM0 table memory at [mem 0x3fff7000-0x3fff7063] May 14 18:07:57.940267 kernel: ACPI: Reserving SPCR table memory at [mem 0x3fff6000-0x3fff604f] May 14 18:07:57.940272 kernel: ACPI: Reserving WAET table memory at [mem 0x3fff5000-0x3fff5027] May 14 18:07:57.940276 kernel: ACPI: Reserving APIC table memory at [mem 0x3ffd5000-0x3ffd5051] May 14 18:07:57.940280 kernel: ACPI: Reserving SRAT table memory at [mem 0x3ffd4000-0x3ffd409f] May 14 18:07:57.940284 kernel: ACPI: Reserving BGRT table memory at [mem 0x3ffd3000-0x3ffd3037] May 14 18:07:57.940289 kernel: ACPI: SRAT: Node 0 PXM 0 [mem 0x00000000-0x3fffffff] May 14 18:07:57.940296 kernel: ACPI: SRAT: Node 0 PXM 0 [mem 0x100000000-0x2bfffffff] May 14 18:07:57.940304 kernel: NUMA: Node 0 [mem 0x00001000-0x3fffffff] + [mem 0x100000000-0x2bfffffff] -> [mem 0x00001000-0x2bfffffff] May 14 18:07:57.940310 kernel: NODE_DATA(0) allocated [mem 0x2bfff8dc0-0x2bfffffff] May 14 18:07:57.940316 kernel: Zone ranges: May 14 18:07:57.940322 kernel: DMA [mem 0x0000000000001000-0x0000000000ffffff] May 14 18:07:57.940326 kernel: DMA32 [mem 0x0000000001000000-0x00000000ffffffff] May 14 18:07:57.940330 kernel: Normal [mem 0x0000000100000000-0x00000002bfffffff] May 14 18:07:57.940335 kernel: Device empty May 14 18:07:57.940343 kernel: Movable zone start for each node May 14 18:07:57.940350 kernel: Early memory node ranges May 14 18:07:57.940356 kernel: node 0: [mem 0x0000000000001000-0x000000000009ffff] May 14 18:07:57.940361 kernel: node 0: [mem 0x0000000000100000-0x000000003ff40fff] May 14 18:07:57.940365 kernel: node 0: [mem 0x000000003ffc5000-0x000000003ffd1fff] May 14 18:07:57.940370 kernel: node 0: [mem 0x000000003ffff000-0x000000003fffffff] May 14 18:07:57.940374 kernel: node 0: [mem 0x0000000100000000-0x00000002bfffffff] May 14 18:07:57.940380 kernel: Initmem setup node 0 [mem 0x0000000000001000-0x00000002bfffffff] May 14 18:07:57.940388 kernel: On node 0, zone DMA: 1 pages in unavailable ranges May 14 18:07:57.940395 kernel: On node 0, zone DMA: 96 pages in unavailable ranges May 14 18:07:57.940402 kernel: On node 0, zone DMA32: 132 pages in unavailable ranges May 14 18:07:57.940406 kernel: On node 0, zone DMA32: 45 pages in unavailable ranges May 14 18:07:57.940410 kernel: ACPI: PM-Timer IO Port: 0x408 May 14 18:07:57.940415 kernel: IOAPIC[0]: apic_id 0, version 17, address 0xfec00000, GSI 0-23 May 14 18:07:57.940420 kernel: ACPI: INT_SRC_OVR (bus 0 bus_irq 9 global_irq 9 high level) May 14 18:07:57.940425 kernel: ACPI: Using ACPI (MADT) for SMP configuration information May 14 18:07:57.940433 kernel: ACPI: SPCR: console: uart,io,0x3f8,115200 May 14 18:07:57.940440 kernel: TSC deadline timer available May 14 18:07:57.940447 kernel: CPU topo: Max. logical packages: 1 May 14 18:07:57.940453 kernel: CPU topo: Max. logical dies: 1 May 14 18:07:57.940458 kernel: CPU topo: Max. dies per package: 1 May 14 18:07:57.940462 kernel: CPU topo: Max. threads per core: 2 May 14 18:07:57.940467 kernel: CPU topo: Num. cores per package: 1 May 14 18:07:57.940472 kernel: CPU topo: Num. threads per package: 2 May 14 18:07:57.940477 kernel: CPU topo: Allowing 2 present CPUs plus 0 hotplug CPUs May 14 18:07:57.940485 kernel: [mem 0x40000000-0xffffffff] available for PCI devices May 14 18:07:57.940492 kernel: Booting paravirtualized kernel on Hyper-V May 14 18:07:57.940499 kernel: clocksource: refined-jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1910969940391419 ns May 14 18:07:57.940507 kernel: setup_percpu: NR_CPUS:512 nr_cpumask_bits:2 nr_cpu_ids:2 nr_node_ids:1 May 14 18:07:57.940514 kernel: percpu: Embedded 60 pages/cpu s207832 r8192 d29736 u1048576 May 14 18:07:57.940520 kernel: pcpu-alloc: s207832 r8192 d29736 u1048576 alloc=1*2097152 May 14 18:07:57.940524 kernel: pcpu-alloc: [0] 0 1 May 14 18:07:57.940529 kernel: Hyper-V: PV spinlocks enabled May 14 18:07:57.940534 kernel: PV qspinlock hash table entries: 256 (order: 0, 4096 bytes, linear) May 14 18:07:57.940539 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=adf4ab3cd3fc72d424aa1ba920dfa0e67212fa35eadab2c698966b09b9e294b0 May 14 18:07:57.940546 kernel: Unknown kernel command line parameters "BOOT_IMAGE=/flatcar/vmlinuz-a", will be passed to user space. May 14 18:07:57.940554 kernel: Dentry cache hash table entries: 1048576 (order: 11, 8388608 bytes, linear) May 14 18:07:57.940562 kernel: Inode-cache hash table entries: 524288 (order: 10, 4194304 bytes, linear) May 14 18:07:57.940569 kernel: Fallback order for Node 0: 0 May 14 18:07:57.940575 kernel: Built 1 zonelists, mobility grouping on. Total pages: 2096878 May 14 18:07:57.940581 kernel: Policy zone: Normal May 14 18:07:57.940585 kernel: mem auto-init: stack:off, heap alloc:off, heap free:off May 14 18:07:57.940589 kernel: software IO TLB: area num 2. May 14 18:07:57.940593 kernel: SLUB: HWalign=64, Order=0-3, MinObjects=0, CPUs=2, Nodes=1 May 14 18:07:57.940598 kernel: ftrace: allocating 40065 entries in 157 pages May 14 18:07:57.940605 kernel: ftrace: allocated 157 pages with 5 groups May 14 18:07:57.940611 kernel: Dynamic Preempt: voluntary May 14 18:07:57.940618 kernel: rcu: Preemptible hierarchical RCU implementation. May 14 18:07:57.940623 kernel: rcu: RCU event tracing is enabled. May 14 18:07:57.940629 kernel: rcu: RCU restricting CPUs from NR_CPUS=512 to nr_cpu_ids=2. May 14 18:07:57.940637 kernel: Trampoline variant of Tasks RCU enabled. May 14 18:07:57.940642 kernel: Rude variant of Tasks RCU enabled. May 14 18:07:57.940647 kernel: Tracing variant of Tasks RCU enabled. May 14 18:07:57.940652 kernel: rcu: RCU calculated value of scheduler-enlistment delay is 100 jiffies. May 14 18:07:57.940657 kernel: rcu: Adjusting geometry for rcu_fanout_leaf=16, nr_cpu_ids=2 May 14 18:07:57.940664 kernel: RCU Tasks: Setting shift to 1 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=2. May 14 18:07:57.940672 kernel: RCU Tasks Rude: Setting shift to 1 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=2. May 14 18:07:57.940680 kernel: RCU Tasks Trace: Setting shift to 1 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=2. May 14 18:07:57.940687 kernel: Using NULL legacy PIC May 14 18:07:57.940691 kernel: NR_IRQS: 33024, nr_irqs: 440, preallocated irqs: 0 May 14 18:07:57.940697 kernel: rcu: srcu_init: Setting srcu_struct sizes based on contention. May 14 18:07:57.940702 kernel: Console: colour dummy device 80x25 May 14 18:07:57.940706 kernel: printk: legacy console [tty1] enabled May 14 18:07:57.940713 kernel: printk: legacy console [ttyS0] enabled May 14 18:07:57.940720 kernel: printk: legacy bootconsole [earlyser0] disabled May 14 18:07:57.940728 kernel: ACPI: Core revision 20240827 May 14 18:07:57.940737 kernel: Failed to register legacy timer interrupt May 14 18:07:57.940743 kernel: APIC: Switch to symmetric I/O mode setup May 14 18:07:57.940747 kernel: x2apic enabled May 14 18:07:57.940752 kernel: APIC: Switched APIC routing to: physical x2apic May 14 18:07:57.940756 kernel: Hyper-V: Host Build 10.0.26100.1221-1-0 May 14 18:07:57.940761 kernel: Hyper-V: enabling crash_kexec_post_notifiers May 14 18:07:57.940766 kernel: Hyper-V: Disabling IBT because of Hyper-V bug May 14 18:07:57.940771 kernel: Hyper-V: Using IPI hypercalls May 14 18:07:57.940778 kernel: APIC: send_IPI() replaced with hv_send_ipi() May 14 18:07:57.940787 kernel: APIC: send_IPI_mask() replaced with hv_send_ipi_mask() May 14 18:07:57.940795 kernel: APIC: send_IPI_mask_allbutself() replaced with hv_send_ipi_mask_allbutself() May 14 18:07:57.940802 kernel: APIC: send_IPI_allbutself() replaced with hv_send_ipi_allbutself() May 14 18:07:57.940843 kernel: APIC: send_IPI_all() replaced with hv_send_ipi_all() May 14 18:07:57.940851 kernel: APIC: send_IPI_self() replaced with hv_send_ipi_self() May 14 18:07:57.940859 kernel: clocksource: tsc-early: mask: 0xffffffffffffffff max_cycles: 0x2127345424d, max_idle_ns: 440795318347 ns May 14 18:07:57.940867 kernel: Calibrating delay loop (skipped), value calculated using timer frequency.. 4599.99 BogoMIPS (lpj=2299999) May 14 18:07:57.940875 kernel: x86/cpu: User Mode Instruction Prevention (UMIP) activated May 14 18:07:57.940882 kernel: Last level iTLB entries: 4KB 0, 2MB 0, 4MB 0 May 14 18:07:57.940891 kernel: Last level dTLB entries: 4KB 0, 2MB 0, 4MB 0, 1GB 0 May 14 18:07:57.940899 kernel: Spectre V1 : Mitigation: usercopy/swapgs barriers and __user pointer sanitization May 14 18:07:57.940906 kernel: Spectre V2 : Mitigation: Retpolines May 14 18:07:57.940913 kernel: Spectre V2 : Spectre v2 / SpectreRSB mitigation: Filling RSB on context switch May 14 18:07:57.940921 kernel: Spectre V2 : Spectre v2 / SpectreRSB : Filling RSB on VMEXIT May 14 18:07:57.940929 kernel: RETBleed: WARNING: Spectre v2 mitigation leaves CPU vulnerable to RETBleed attacks, data leaks possible! May 14 18:07:57.940937 kernel: RETBleed: Vulnerable May 14 18:07:57.940944 kernel: Speculative Store Bypass: Vulnerable May 14 18:07:57.940951 kernel: x86/fpu: Supporting XSAVE feature 0x001: 'x87 floating point registers' May 14 18:07:57.940959 kernel: x86/fpu: Supporting XSAVE feature 0x002: 'SSE registers' May 14 18:07:57.940966 kernel: x86/fpu: Supporting XSAVE feature 0x004: 'AVX registers' May 14 18:07:57.940975 kernel: x86/fpu: Supporting XSAVE feature 0x020: 'AVX-512 opmask' May 14 18:07:57.940983 kernel: x86/fpu: Supporting XSAVE feature 0x040: 'AVX-512 Hi256' May 14 18:07:57.940991 kernel: x86/fpu: Supporting XSAVE feature 0x080: 'AVX-512 ZMM_Hi256' May 14 18:07:57.940998 kernel: x86/fpu: Supporting XSAVE feature 0x800: 'Control-flow User registers' May 14 18:07:57.941006 kernel: x86/fpu: Supporting XSAVE feature 0x20000: 'AMX Tile config' May 14 18:07:57.941013 kernel: x86/fpu: Supporting XSAVE feature 0x40000: 'AMX Tile data' May 14 18:07:57.941021 kernel: x86/fpu: xstate_offset[2]: 576, xstate_sizes[2]: 256 May 14 18:07:57.941028 kernel: x86/fpu: xstate_offset[5]: 832, xstate_sizes[5]: 64 May 14 18:07:57.941035 kernel: x86/fpu: xstate_offset[6]: 896, xstate_sizes[6]: 512 May 14 18:07:57.941043 kernel: x86/fpu: xstate_offset[7]: 1408, xstate_sizes[7]: 1024 May 14 18:07:57.941051 kernel: x86/fpu: xstate_offset[11]: 2432, xstate_sizes[11]: 16 May 14 18:07:57.941058 kernel: x86/fpu: xstate_offset[17]: 2496, xstate_sizes[17]: 64 May 14 18:07:57.941066 kernel: x86/fpu: xstate_offset[18]: 2560, xstate_sizes[18]: 8192 May 14 18:07:57.941074 kernel: x86/fpu: Enabled xstate features 0x608e7, context size is 10752 bytes, using 'compacted' format. May 14 18:07:57.941081 kernel: Freeing SMP alternatives memory: 32K May 14 18:07:57.941089 kernel: pid_max: default: 32768 minimum: 301 May 14 18:07:57.941097 kernel: LSM: initializing lsm=lockdown,capability,landlock,selinux,ima May 14 18:07:57.941105 kernel: landlock: Up and running. May 14 18:07:57.941112 kernel: SELinux: Initializing. May 14 18:07:57.941120 kernel: Mount-cache hash table entries: 16384 (order: 5, 131072 bytes, linear) May 14 18:07:57.941127 kernel: Mountpoint-cache hash table entries: 16384 (order: 5, 131072 bytes, linear) May 14 18:07:57.941135 kernel: smpboot: CPU0: Intel INTEL(R) XEON(R) PLATINUM 8573C (family: 0x6, model: 0xcf, stepping: 0x2) May 14 18:07:57.941143 kernel: Performance Events: unsupported p6 CPU model 207 no PMU driver, software events only. May 14 18:07:57.941151 kernel: signal: max sigframe size: 11952 May 14 18:07:57.941159 kernel: rcu: Hierarchical SRCU implementation. May 14 18:07:57.941167 kernel: rcu: Max phase no-delay instances is 400. May 14 18:07:57.941174 kernel: Timer migration: 1 hierarchy levels; 8 children per group; 1 crossnode level May 14 18:07:57.941182 kernel: NMI watchdog: Perf NMI watchdog permanently disabled May 14 18:07:57.941189 kernel: smp: Bringing up secondary CPUs ... May 14 18:07:57.941197 kernel: smpboot: x86: Booting SMP configuration: May 14 18:07:57.941204 kernel: .... node #0, CPUs: #1 May 14 18:07:57.941214 kernel: smp: Brought up 1 node, 2 CPUs May 14 18:07:57.941222 kernel: smpboot: Total of 2 processors activated (9199.99 BogoMIPS) May 14 18:07:57.941230 kernel: Memory: 8082316K/8387512K available (14336K kernel code, 2438K rwdata, 9944K rodata, 54424K init, 2536K bss, 299988K reserved, 0K cma-reserved) May 14 18:07:57.941238 kernel: devtmpfs: initialized May 14 18:07:57.941246 kernel: x86/mm: Memory block size: 128MB May 14 18:07:57.941253 kernel: ACPI: PM: Registering ACPI NVS region [mem 0x3fffb000-0x3fffefff] (16384 bytes) May 14 18:07:57.941261 kernel: clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1911260446275000 ns May 14 18:07:57.941269 kernel: futex hash table entries: 512 (order: 3, 32768 bytes, linear) May 14 18:07:57.941276 kernel: pinctrl core: initialized pinctrl subsystem May 14 18:07:57.941285 kernel: NET: Registered PF_NETLINK/PF_ROUTE protocol family May 14 18:07:57.941293 kernel: audit: initializing netlink subsys (disabled) May 14 18:07:57.941300 kernel: audit: type=2000 audit(1747246074.031:1): state=initialized audit_enabled=0 res=1 May 14 18:07:57.941308 kernel: thermal_sys: Registered thermal governor 'step_wise' May 14 18:07:57.941315 kernel: thermal_sys: Registered thermal governor 'user_space' May 14 18:07:57.941323 kernel: cpuidle: using governor menu May 14 18:07:57.941331 kernel: acpiphp: ACPI Hot Plug PCI Controller Driver version: 0.5 May 14 18:07:57.941338 kernel: dca service started, version 1.12.1 May 14 18:07:57.941346 kernel: e820: reserve RAM buffer [mem 0x3ff41000-0x3fffffff] May 14 18:07:57.941355 kernel: e820: reserve RAM buffer [mem 0x3ffd2000-0x3fffffff] May 14 18:07:57.941362 kernel: kprobes: kprobe jump-optimization is enabled. All kprobes are optimized if possible. May 14 18:07:57.941370 kernel: HugeTLB: registered 1.00 GiB page size, pre-allocated 0 pages May 14 18:07:57.941378 kernel: HugeTLB: 16380 KiB vmemmap can be freed for a 1.00 GiB page May 14 18:07:57.941385 kernel: HugeTLB: registered 2.00 MiB page size, pre-allocated 0 pages May 14 18:07:57.941392 kernel: HugeTLB: 28 KiB vmemmap can be freed for a 2.00 MiB page May 14 18:07:57.941400 kernel: ACPI: Added _OSI(Module Device) May 14 18:07:57.941408 kernel: ACPI: Added _OSI(Processor Device) May 14 18:07:57.941415 kernel: ACPI: Added _OSI(3.0 _SCP Extensions) May 14 18:07:57.941424 kernel: ACPI: Added _OSI(Processor Aggregator Device) May 14 18:07:57.941431 kernel: ACPI: 1 ACPI AML tables successfully acquired and loaded May 14 18:07:57.941439 kernel: ACPI: Interpreter enabled May 14 18:07:57.941447 kernel: ACPI: PM: (supports S0 S5) May 14 18:07:57.941454 kernel: ACPI: Using IOAPIC for interrupt routing May 14 18:07:57.941462 kernel: PCI: Using host bridge windows from ACPI; if necessary, use "pci=nocrs" and report a bug May 14 18:07:57.941469 kernel: PCI: Ignoring E820 reservations for host bridge windows May 14 18:07:57.941477 kernel: ACPI: Enabled 1 GPEs in block 00 to 0F May 14 18:07:57.941485 kernel: iommu: Default domain type: Translated May 14 18:07:57.941493 kernel: iommu: DMA domain TLB invalidation policy: lazy mode May 14 18:07:57.941501 kernel: efivars: Registered efivars operations May 14 18:07:57.941508 kernel: PCI: Using ACPI for IRQ routing May 14 18:07:57.941516 kernel: PCI: System does not support PCI May 14 18:07:57.941523 kernel: vgaarb: loaded May 14 18:07:57.941531 kernel: clocksource: Switched to clocksource tsc-early May 14 18:07:57.941538 kernel: VFS: Disk quotas dquot_6.6.0 May 14 18:07:57.941546 kernel: VFS: Dquot-cache hash table entries: 512 (order 0, 4096 bytes) May 14 18:07:57.941553 kernel: pnp: PnP ACPI init May 14 18:07:57.941562 kernel: pnp: PnP ACPI: found 3 devices May 14 18:07:57.941570 kernel: clocksource: acpi_pm: mask: 0xffffff max_cycles: 0xffffff, max_idle_ns: 2085701024 ns May 14 18:07:57.941577 kernel: NET: Registered PF_INET protocol family May 14 18:07:57.941585 kernel: IP idents hash table entries: 131072 (order: 8, 1048576 bytes, linear) May 14 18:07:57.941593 kernel: tcp_listen_portaddr_hash hash table entries: 4096 (order: 4, 65536 bytes, linear) May 14 18:07:57.941600 kernel: Table-perturb hash table entries: 65536 (order: 6, 262144 bytes, linear) May 14 18:07:57.941608 kernel: TCP established hash table entries: 65536 (order: 7, 524288 bytes, linear) May 14 18:07:57.941616 kernel: TCP bind hash table entries: 65536 (order: 9, 2097152 bytes, linear) May 14 18:07:57.941624 kernel: TCP: Hash tables configured (established 65536 bind 65536) May 14 18:07:57.941633 kernel: UDP hash table entries: 4096 (order: 5, 131072 bytes, linear) May 14 18:07:57.941640 kernel: UDP-Lite hash table entries: 4096 (order: 5, 131072 bytes, linear) May 14 18:07:57.941648 kernel: NET: Registered PF_UNIX/PF_LOCAL protocol family May 14 18:07:57.941655 kernel: NET: Registered PF_XDP protocol family May 14 18:07:57.941663 kernel: PCI: CLS 0 bytes, default 64 May 14 18:07:57.941671 kernel: PCI-DMA: Using software bounce buffering for IO (SWIOTLB) May 14 18:07:57.941678 kernel: software IO TLB: mapped [mem 0x000000003aa59000-0x000000003ea59000] (64MB) May 14 18:07:57.941686 kernel: RAPL PMU: API unit is 2^-32 Joules, 1 fixed counters, 10737418240 ms ovfl timer May 14 18:07:57.941694 kernel: RAPL PMU: hw unit of domain psys 2^-0 Joules May 14 18:07:57.941702 kernel: clocksource: tsc: mask: 0xffffffffffffffff max_cycles: 0x2127345424d, max_idle_ns: 440795318347 ns May 14 18:07:57.941710 kernel: clocksource: Switched to clocksource tsc May 14 18:07:57.941717 kernel: Initialise system trusted keyrings May 14 18:07:57.941725 kernel: workingset: timestamp_bits=39 max_order=21 bucket_order=0 May 14 18:07:57.941732 kernel: Key type asymmetric registered May 14 18:07:57.941740 kernel: Asymmetric key parser 'x509' registered May 14 18:07:57.941747 kernel: Block layer SCSI generic (bsg) driver version 0.4 loaded (major 250) May 14 18:07:57.941755 kernel: io scheduler mq-deadline registered May 14 18:07:57.941763 kernel: io scheduler kyber registered May 14 18:07:57.941771 kernel: io scheduler bfq registered May 14 18:07:57.941779 kernel: ioatdma: Intel(R) QuickData Technology Driver 5.00 May 14 18:07:57.941787 kernel: Serial: 8250/16550 driver, 4 ports, IRQ sharing enabled May 14 18:07:57.941794 kernel: 00:00: ttyS0 at I/O 0x3f8 (irq = 4, base_baud = 115200) is a 16550A May 14 18:07:57.941802 kernel: 00:01: ttyS1 at I/O 0x2f8 (irq = 3, base_baud = 115200) is a 16550A May 14 18:07:57.941817 kernel: serial8250: ttyS2 at I/O 0x3e8 (irq = 4, base_baud = 115200) is a 16550A May 14 18:07:57.941825 kernel: i8042: PNP: No PS/2 controller found. May 14 18:07:57.941934 kernel: rtc_cmos 00:02: registered as rtc0 May 14 18:07:57.945315 kernel: rtc_cmos 00:02: setting system clock to 2025-05-14T18:07:57 UTC (1747246077) May 14 18:07:57.945607 kernel: rtc_cmos 00:02: alarms up to one month, 114 bytes nvram May 14 18:07:57.945626 kernel: intel_pstate: Intel P-state driver initializing May 14 18:07:57.945637 kernel: efifb: probing for efifb May 14 18:07:57.945647 kernel: efifb: framebuffer at 0x40000000, using 3072k, total 3072k May 14 18:07:57.945656 kernel: efifb: mode is 1024x768x32, linelength=4096, pages=1 May 14 18:07:57.945665 kernel: efifb: scrolling: redraw May 14 18:07:57.945673 kernel: efifb: Truecolor: size=8:8:8:8, shift=24:16:8:0 May 14 18:07:57.945686 kernel: Console: switching to colour frame buffer device 128x48 May 14 18:07:57.945693 kernel: fb0: EFI VGA frame buffer device May 14 18:07:57.945702 kernel: pstore: Using crash dump compression: deflate May 14 18:07:57.945711 kernel: pstore: Registered efi_pstore as persistent store backend May 14 18:07:57.945719 kernel: NET: Registered PF_INET6 protocol family May 14 18:07:57.945726 kernel: Segment Routing with IPv6 May 14 18:07:57.945735 kernel: In-situ OAM (IOAM) with IPv6 May 14 18:07:57.945742 kernel: NET: Registered PF_PACKET protocol family May 14 18:07:57.945751 kernel: Key type dns_resolver registered May 14 18:07:57.945762 kernel: IPI shorthand broadcast: enabled May 14 18:07:57.945771 kernel: sched_clock: Marking stable (2780002941, 85308433)->(3169476707, -304165333) May 14 18:07:57.945779 kernel: registered taskstats version 1 May 14 18:07:57.945788 kernel: Loading compiled-in X.509 certificates May 14 18:07:57.945796 kernel: Loaded X.509 cert 'Kinvolk GmbH: Module signing key for 6.12.20-flatcar: 41e2a150aa08ec2528be2394819b3db677e5f4ef' May 14 18:07:57.945805 kernel: Demotion targets for Node 0: null May 14 18:07:57.946569 kernel: Key type .fscrypt registered May 14 18:07:57.946578 kernel: Key type fscrypt-provisioning registered May 14 18:07:57.946586 kernel: ima: No TPM chip found, activating TPM-bypass! May 14 18:07:57.946596 kernel: ima: Allocated hash algorithm: sha1 May 14 18:07:57.946604 kernel: ima: No architecture policies found May 14 18:07:57.946611 kernel: clk: Disabling unused clocks May 14 18:07:57.946618 kernel: Warning: unable to open an initial console. May 14 18:07:57.946625 kernel: Freeing unused kernel image (initmem) memory: 54424K May 14 18:07:57.946632 kernel: Write protecting the kernel read-only data: 24576k May 14 18:07:57.946640 kernel: Freeing unused kernel image (rodata/data gap) memory: 296K May 14 18:07:57.946647 kernel: Run /init as init process May 14 18:07:57.946654 kernel: with arguments: May 14 18:07:57.946664 kernel: /init May 14 18:07:57.946671 kernel: with environment: May 14 18:07:57.946678 kernel: HOME=/ May 14 18:07:57.946685 kernel: TERM=linux May 14 18:07:57.946692 kernel: BOOT_IMAGE=/flatcar/vmlinuz-a May 14 18:07:57.946701 systemd[1]: Successfully made /usr/ read-only. May 14 18:07:57.946712 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) May 14 18:07:57.946722 systemd[1]: Detected virtualization microsoft. May 14 18:07:57.946730 systemd[1]: Detected architecture x86-64. May 14 18:07:57.946738 systemd[1]: Running in initrd. May 14 18:07:57.946746 systemd[1]: No hostname configured, using default hostname. May 14 18:07:57.946755 systemd[1]: Hostname set to . May 14 18:07:57.946763 systemd[1]: Initializing machine ID from random generator. May 14 18:07:57.946771 systemd[1]: Queued start job for default target initrd.target. May 14 18:07:57.946780 systemd[1]: Started clevis-luks-askpass.path - Forward Password Requests to Clevis Directory Watch. May 14 18:07:57.946788 systemd[1]: Started systemd-ask-password-console.path - Dispatch Password Requests to Console Directory Watch. May 14 18:07:57.946799 systemd[1]: Expecting device dev-disk-by\x2dlabel-EFI\x2dSYSTEM.device - /dev/disk/by-label/EFI-SYSTEM... May 14 18:07:57.946807 systemd[1]: Expecting device dev-disk-by\x2dlabel-OEM.device - /dev/disk/by-label/OEM... May 14 18:07:57.946832 systemd[1]: Expecting device dev-disk-by\x2dlabel-ROOT.device - /dev/disk/by-label/ROOT... May 14 18:07:57.946841 systemd[1]: Expecting device dev-disk-by\x2dpartlabel-USR\x2dA.device - /dev/disk/by-partlabel/USR-A... May 14 18:07:57.946851 systemd[1]: Expecting device dev-disk-by\x2dpartuuid-7130c94a\x2d213a\x2d4e5a\x2d8e26\x2d6cce9662f132.device - /dev/disk/by-partuuid/7130c94a-213a-4e5a-8e26-6cce9662f132... May 14 18:07:57.946859 systemd[1]: Expecting device dev-mapper-usr.device - /dev/mapper/usr... May 14 18:07:57.946869 systemd[1]: Reached target cryptsetup-pre.target - Local Encrypted Volumes (Pre). May 14 18:07:57.946877 systemd[1]: Reached target cryptsetup.target - Local Encrypted Volumes. May 14 18:07:57.946886 systemd[1]: Reached target paths.target - Path Units. May 14 18:07:57.946894 systemd[1]: Reached target slices.target - Slice Units. May 14 18:07:57.946902 systemd[1]: Reached target swap.target - Swaps. May 14 18:07:57.946910 systemd[1]: Reached target timers.target - Timer Units. May 14 18:07:57.946919 systemd[1]: Listening on iscsid.socket - Open-iSCSI iscsid Socket. May 14 18:07:57.946927 systemd[1]: Listening on iscsiuio.socket - Open-iSCSI iscsiuio Socket. May 14 18:07:57.946935 systemd[1]: Listening on systemd-journald-dev-log.socket - Journal Socket (/dev/log). May 14 18:07:57.946945 systemd[1]: Listening on systemd-journald.socket - Journal Sockets. May 14 18:07:57.946953 systemd[1]: Listening on systemd-networkd.socket - Network Service Netlink Socket. May 14 18:07:57.946961 systemd[1]: Listening on systemd-udevd-control.socket - udev Control Socket. May 14 18:07:57.946969 systemd[1]: Listening on systemd-udevd-kernel.socket - udev Kernel Socket. May 14 18:07:57.946977 systemd[1]: Reached target sockets.target - Socket Units. May 14 18:07:57.946985 systemd[1]: Starting ignition-setup-pre.service - Ignition env setup... May 14 18:07:57.946993 systemd[1]: Starting kmod-static-nodes.service - Create List of Static Device Nodes... May 14 18:07:57.947002 systemd[1]: Finished network-cleanup.service - Network Cleanup. May 14 18:07:57.947010 systemd[1]: systemd-battery-check.service - Check battery level during early boot was skipped because of an unmet condition check (ConditionDirectoryNotEmpty=/sys/class/power_supply). May 14 18:07:57.947020 systemd[1]: Starting systemd-fsck-usr.service... May 14 18:07:57.947028 systemd[1]: Starting systemd-journald.service - Journal Service... May 14 18:07:57.947036 systemd[1]: Starting systemd-modules-load.service - Load Kernel Modules... May 14 18:07:57.947051 systemd[1]: Starting systemd-vconsole-setup.service - Virtual Console Setup... May 14 18:07:57.947061 systemd[1]: Finished ignition-setup-pre.service - Ignition env setup. May 14 18:07:57.947071 systemd[1]: Finished kmod-static-nodes.service - Create List of Static Device Nodes. May 14 18:07:57.947099 systemd-journald[204]: Collecting audit messages is disabled. May 14 18:07:57.947122 systemd[1]: Finished systemd-fsck-usr.service. May 14 18:07:57.947131 systemd[1]: Starting systemd-tmpfiles-setup-dev-early.service - Create Static Device Nodes in /dev gracefully... May 14 18:07:57.947141 systemd-journald[204]: Journal started May 14 18:07:57.947162 systemd-journald[204]: Runtime Journal (/run/log/journal/69ff3dfa1752469897e9ffdc8c455b1b) is 8M, max 159M, 151M free. May 14 18:07:57.936608 systemd-modules-load[206]: Inserted module 'overlay' May 14 18:07:57.955941 systemd[1]: Started systemd-journald.service - Journal Service. May 14 18:07:57.962491 systemd[1]: Starting systemd-tmpfiles-setup.service - Create System Files and Directories... May 14 18:07:57.966775 systemd[1]: Finished systemd-vconsole-setup.service - Virtual Console Setup. May 14 18:07:57.976835 kernel: bridge: filtering via arp/ip/ip6tables is no longer available by default. Update your scripts to load br_netfilter if you need this. May 14 18:07:57.975921 systemd[1]: Starting dracut-cmdline-ask.service - dracut ask for additional cmdline parameters... May 14 18:07:57.984887 kernel: Bridge firewalling registered May 14 18:07:57.981261 systemd-modules-load[206]: Inserted module 'br_netfilter' May 14 18:07:57.982199 systemd[1]: Finished systemd-tmpfiles-setup-dev-early.service - Create Static Device Nodes in /dev gracefully. May 14 18:07:57.983920 systemd-tmpfiles[220]: /usr/lib/tmpfiles.d/var.conf:14: Duplicate line for path "/var/log", ignoring. May 14 18:07:57.988056 systemd[1]: Finished systemd-modules-load.service - Load Kernel Modules. May 14 18:07:57.996920 systemd[1]: Finished systemd-tmpfiles-setup.service - Create System Files and Directories. May 14 18:07:57.999917 systemd[1]: Starting systemd-sysctl.service - Apply Kernel Variables... May 14 18:07:58.000489 systemd[1]: Starting systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev... May 14 18:07:58.017152 systemd[1]: Finished dracut-cmdline-ask.service - dracut ask for additional cmdline parameters. May 14 18:07:58.019995 systemd[1]: Finished systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev. May 14 18:07:58.025993 systemd[1]: Finished systemd-sysctl.service - Apply Kernel Variables. May 14 18:07:58.034653 systemd[1]: Starting dracut-cmdline.service - dracut cmdline hook... May 14 18:07:58.045920 systemd[1]: Starting systemd-resolved.service - Network Name Resolution... May 14 18:07:58.057836 dracut-cmdline[245]: Using kernel command line parameters: rd.driver.pre=btrfs SYSTEMD_SULOGIN_FORCE=1 rootflags=rw mount.usrflags=ro BOOT_IMAGE=/flatcar/vmlinuz-a mount.usr=/dev/mapper/usr verity.usr=PARTUUID=7130c94a-213a-4e5a-8e26-6cce9662f132 rootflags=rw mount.usrflags=ro consoleblank=0 root=LABEL=ROOT console=tty1 console=ttyS0,115200n8 earlyprintk=ttyS0,115200 flatcar.first_boot=detected flatcar.oem.id=azure flatcar.autologin verity.usrhash=adf4ab3cd3fc72d424aa1ba920dfa0e67212fa35eadab2c698966b09b9e294b0 May 14 18:07:58.084570 systemd-resolved[246]: Positive Trust Anchors: May 14 18:07:58.085893 systemd-resolved[246]: . IN DS 20326 8 2 e06d44b80b8f1d39a95c0b0d7c65d08458e880409bbc683457104237c7f8ec8d May 14 18:07:58.088362 systemd-resolved[246]: 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 May 14 18:07:58.102735 systemd-resolved[246]: Defaulting to hostname 'linux'. May 14 18:07:58.105467 systemd[1]: Started systemd-resolved.service - Network Name Resolution. May 14 18:07:58.109688 systemd[1]: Reached target nss-lookup.target - Host and Network Name Lookups. May 14 18:07:58.123826 kernel: SCSI subsystem initialized May 14 18:07:58.129824 kernel: Loading iSCSI transport class v2.0-870. May 14 18:07:58.138824 kernel: iscsi: registered transport (tcp) May 14 18:07:58.154827 kernel: iscsi: registered transport (qla4xxx) May 14 18:07:58.154861 kernel: QLogic iSCSI HBA Driver May 14 18:07:58.165587 systemd[1]: Starting systemd-network-generator.service - Generate network units from Kernel command line... May 14 18:07:58.176464 systemd[1]: Finished systemd-network-generator.service - Generate network units from Kernel command line. May 14 18:07:58.177796 systemd[1]: Reached target network-pre.target - Preparation for Network. May 14 18:07:58.205904 systemd[1]: Finished dracut-cmdline.service - dracut cmdline hook. May 14 18:07:58.208913 systemd[1]: Starting dracut-pre-udev.service - dracut pre-udev hook... May 14 18:07:58.253826 kernel: raid6: avx512x4 gen() 45568 MB/s May 14 18:07:58.271823 kernel: raid6: avx512x2 gen() 44157 MB/s May 14 18:07:58.288819 kernel: raid6: avx512x1 gen() 29329 MB/s May 14 18:07:58.306819 kernel: raid6: avx2x4 gen() 43136 MB/s May 14 18:07:58.323820 kernel: raid6: avx2x2 gen() 43795 MB/s May 14 18:07:58.341423 kernel: raid6: avx2x1 gen() 32252 MB/s May 14 18:07:58.341450 kernel: raid6: using algorithm avx512x4 gen() 45568 MB/s May 14 18:07:58.360021 kernel: raid6: .... xor() 7647 MB/s, rmw enabled May 14 18:07:58.360048 kernel: raid6: using avx512x2 recovery algorithm May 14 18:07:58.375825 kernel: xor: automatically using best checksumming function avx May 14 18:07:58.477824 kernel: Btrfs loaded, zoned=no, fsverity=no May 14 18:07:58.482033 systemd[1]: Finished dracut-pre-udev.service - dracut pre-udev hook. May 14 18:07:58.485392 systemd[1]: Starting systemd-udevd.service - Rule-based Manager for Device Events and Files... May 14 18:07:58.506793 systemd-udevd[455]: Using default interface naming scheme 'v255'. May 14 18:07:58.511389 systemd[1]: Started systemd-udevd.service - Rule-based Manager for Device Events and Files. May 14 18:07:58.518241 systemd[1]: Starting dracut-pre-trigger.service - dracut pre-trigger hook... May 14 18:07:58.535922 dracut-pre-trigger[466]: rd.md=0: removing MD RAID activation May 14 18:07:58.551304 systemd[1]: Finished dracut-pre-trigger.service - dracut pre-trigger hook. May 14 18:07:58.554430 systemd[1]: Starting systemd-udev-trigger.service - Coldplug All udev Devices... May 14 18:07:58.581249 systemd[1]: Finished systemd-udev-trigger.service - Coldplug All udev Devices. May 14 18:07:58.588306 systemd[1]: Starting dracut-initqueue.service - dracut initqueue hook... May 14 18:07:58.619824 kernel: cryptd: max_cpu_qlen set to 1000 May 14 18:07:58.626828 kernel: AES CTR mode by8 optimization enabled May 14 18:07:58.651252 kernel: hv_vmbus: Vmbus version:5.3 May 14 18:07:58.653240 systemd[1]: systemd-vconsole-setup.service: Deactivated successfully. May 14 18:07:58.653386 systemd[1]: Stopped systemd-vconsole-setup.service - Virtual Console Setup. May 14 18:07:58.657244 systemd[1]: Stopping systemd-vconsole-setup.service - Virtual Console Setup... May 14 18:07:58.666117 kernel: hv_vmbus: registering driver hyperv_keyboard May 14 18:07:58.666344 systemd[1]: Starting systemd-vconsole-setup.service - Virtual Console Setup... May 14 18:07:58.680722 kernel: pps_core: LinuxPPS API ver. 1 registered May 14 18:07:58.680738 kernel: pps_core: Software ver. 5.3.6 - Copyright 2005-2007 Rodolfo Giometti May 14 18:07:58.680752 kernel: input: AT Translated Set 2 keyboard as /devices/LNXSYSTM:00/LNXSYBUS:00/ACPI0004:00/MSFT1000:00/d34b2567-b9b6-42b9-8778-0a4ec0b955bf/serio0/input/input0 May 14 18:07:58.692863 kernel: hv_vmbus: registering driver hv_storvsc May 14 18:07:58.695826 kernel: scsi host0: storvsc_host_t May 14 18:07:58.698846 kernel: scsi 0:0:0:2: CD-ROM Msft Virtual DVD-ROM 1.0 PQ: 0 ANSI: 5 May 14 18:07:58.698899 kernel: PTP clock support registered May 14 18:07:58.700128 kernel: hid: raw HID events driver (C) Jiri Kosina May 14 18:07:58.705830 kernel: hv_vmbus: registering driver hv_netvsc May 14 18:07:58.712462 kernel: hv_utils: Registering HyperV Utility Driver May 14 18:07:58.712498 kernel: hv_vmbus: registering driver hv_utils May 14 18:07:58.715241 systemd[1]: Finished systemd-vconsole-setup.service - Virtual Console Setup. May 14 18:07:58.764270 kernel: hv_utils: Shutdown IC version 3.2 May 14 18:07:58.764308 kernel: hv_utils: TimeSync IC version 4.0 May 14 18:07:58.765875 kernel: hv_utils: Heartbeat IC version 3.0 May 14 18:07:58.330681 systemd-resolved[246]: Clock change detected. Flushing caches. May 14 18:07:58.353967 kernel: hv_vmbus: registering driver hid_hyperv May 14 18:07:58.353989 systemd-journald[204]: Time jumped backwards, rotating. May 14 18:07:58.354027 kernel: hv_vmbus: registering driver hv_pci May 14 18:07:58.354038 kernel: input: Microsoft Vmbus HID-compliant Mouse as /devices/0006:045E:0621.0001/input/input1 May 14 18:07:58.354048 kernel: hv_netvsc f8615163-0000-1000-2000-6045bde03002 (unnamed net_device) (uninitialized): VF slot 1 added May 14 18:07:58.374833 kernel: hid-hyperv 0006:045E:0621.0001: input: VIRTUAL HID v0.01 Mouse [Microsoft Vmbus HID-compliant Mouse] on May 14 18:07:58.374956 kernel: hv_pci 7ad35d50-c05b-47ab-b3a0-56a9a845852b: PCI VMBus probing: Using version 0x10004 May 14 18:07:58.404879 kernel: hv_pci 7ad35d50-c05b-47ab-b3a0-56a9a845852b: PCI host bridge to bus c05b:00 May 14 18:07:58.404975 kernel: pci_bus c05b:00: root bus resource [mem 0xfc0000000-0xfc007ffff window] May 14 18:07:58.405074 kernel: pci_bus c05b:00: No busn resource found for root bus, will use [bus 00-ff] May 14 18:07:58.405171 kernel: sr 0:0:0:2: [sr0] scsi-1 drive May 14 18:07:58.405264 kernel: cdrom: Uniform CD-ROM driver Revision: 3.20 May 14 18:07:58.405273 kernel: pci c05b:00:00.0: [1414:00a9] type 00 class 0x010802 PCIe Endpoint May 14 18:07:58.405372 kernel: sr 0:0:0:2: Attached scsi CD-ROM sr0 May 14 18:07:58.405456 kernel: pci c05b:00:00.0: BAR 0 [mem 0xfc0000000-0xfc007ffff 64bit] May 14 18:07:58.405539 kernel: pci c05b:00:00.0: 32.000 Gb/s available PCIe bandwidth, limited by 2.5 GT/s PCIe x16 link at c05b:00:00.0 (capable of 1024.000 Gb/s with 64.0 GT/s PCIe x16 link) May 14 18:07:58.405631 kernel: pci_bus c05b:00: busn_res: [bus 00-ff] end is updated to 00 May 14 18:07:58.405706 kernel: pci c05b:00:00.0: BAR 0 [mem 0xfc0000000-0xfc007ffff 64bit]: assigned May 14 18:07:58.415147 kernel: hv_storvsc f8b3781a-1e82-4818-a1c3-63d806ec15bb: tag#258 cmd 0x85 status: scsi 0x2 srb 0x6 hv 0xc0000001 May 14 18:07:58.424490 kernel: nvme nvme0: pci function c05b:00:00.0 May 14 18:07:58.424628 kernel: nvme c05b:00:00.0: enabling device (0000 -> 0002) May 14 18:07:58.661355 kernel: hv_storvsc f8b3781a-1e82-4818-a1c3-63d806ec15bb: tag#100 cmd 0x85 status: scsi 0x2 srb 0x6 hv 0xc0000001 May 14 18:07:58.661478 kernel: nvme nvme0: 2/0/0 default/read/poll queues May 14 18:07:58.661581 kernel: nvme0n1: p1 p2 p3 p4 p6 p7 p9 May 14 18:07:58.908152 kernel: nvme nvme0: using unchecked data buffer May 14 18:07:59.089255 systemd[1]: Found device dev-disk-by\x2dlabel-EFI\x2dSYSTEM.device - MSFT NVMe Accelerator v1.0 EFI-SYSTEM. May 14 18:07:59.114296 systemd[1]: Found device dev-disk-by\x2dlabel-ROOT.device - MSFT NVMe Accelerator v1.0 ROOT. May 14 18:07:59.133749 systemd[1]: Found device dev-disk-by\x2dlabel-OEM.device - MSFT NVMe Accelerator v1.0 OEM. May 14 18:07:59.142214 systemd[1]: Found device dev-disk-by\x2dpartlabel-USR\x2dA.device - MSFT NVMe Accelerator v1.0 USR-A. May 14 18:07:59.143579 systemd[1]: Found device dev-disk-by\x2dpartuuid-7130c94a\x2d213a\x2d4e5a\x2d8e26\x2d6cce9662f132.device - MSFT NVMe Accelerator v1.0 USR-A. May 14 18:07:59.155060 systemd[1]: Starting disk-uuid.service - Generate new UUID for disk GPT if necessary... May 14 18:07:59.404173 kernel: hv_pci 00000001-7870-47b5-b203-907d12ca697e: PCI VMBus probing: Using version 0x10004 May 14 18:07:59.450310 kernel: hv_pci 00000001-7870-47b5-b203-907d12ca697e: PCI host bridge to bus 7870:00 May 14 18:07:59.450451 kernel: pci_bus 7870:00: root bus resource [mem 0xfc2000000-0xfc4007fff window] May 14 18:07:59.450546 kernel: pci_bus 7870:00: No busn resource found for root bus, will use [bus 00-ff] May 14 18:07:59.450619 kernel: pci 7870:00:00.0: [1414:00ba] type 00 class 0x020000 PCIe Endpoint May 14 18:07:59.450729 kernel: pci 7870:00:00.0: BAR 0 [mem 0xfc2000000-0xfc3ffffff 64bit pref] May 14 18:07:59.450821 kernel: pci 7870:00:00.0: BAR 4 [mem 0xfc4000000-0xfc4007fff 64bit pref] May 14 18:07:59.450912 kernel: pci 7870:00:00.0: enabling Extended Tags May 14 18:07:59.451000 kernel: pci_bus 7870:00: busn_res: [bus 00-ff] end is updated to 00 May 14 18:07:59.451075 kernel: pci 7870:00:00.0: BAR 0 [mem 0xfc2000000-0xfc3ffffff 64bit pref]: assigned May 14 18:07:59.451184 kernel: pci 7870:00:00.0: BAR 4 [mem 0xfc4000000-0xfc4007fff 64bit pref]: assigned May 14 18:07:59.460156 kernel: mana 7870:00:00.0: enabling device (0000 -> 0002) May 14 18:07:59.478817 kernel: mana 7870:00:00.0: Microsoft Azure Network Adapter protocol version: 0.1.1 May 14 18:07:59.478929 kernel: hv_netvsc f8615163-0000-1000-2000-6045bde03002 eth0: VF registering: eth1 May 14 18:07:59.479012 kernel: mana 7870:00:00.0 eth1: joined to eth0 May 14 18:07:59.483155 kernel: mana 7870:00:00.0 enP30832s1: renamed from eth1 May 14 18:07:59.521463 systemd[1]: Finished dracut-initqueue.service - dracut initqueue hook. May 14 18:07:59.525490 systemd[1]: Reached target remote-fs-pre.target - Preparation for Remote File Systems. May 14 18:07:59.525895 systemd[1]: Reached target remote-cryptsetup.target - Remote Encrypted Volumes. May 14 18:07:59.532165 systemd[1]: Reached target remote-fs.target - Remote File Systems. May 14 18:07:59.535295 systemd[1]: Starting dracut-pre-mount.service - dracut pre-mount hook... May 14 18:07:59.560203 systemd[1]: Finished dracut-pre-mount.service - dracut pre-mount hook. May 14 18:08:00.181103 disk-uuid[664]: The operation has completed successfully. May 14 18:08:00.185268 kernel: nvme0n1: p1 p2 p3 p4 p6 p7 p9 May 14 18:08:00.223069 systemd[1]: disk-uuid.service: Deactivated successfully. May 14 18:08:00.223165 systemd[1]: Finished disk-uuid.service - Generate new UUID for disk GPT if necessary. May 14 18:08:00.258770 systemd[1]: Starting verity-setup.service - Verity Setup for /dev/mapper/usr... May 14 18:08:00.269016 sh[714]: Success May 14 18:08:00.297380 kernel: device-mapper: core: CONFIG_IMA_DISABLE_HTABLE is disabled. Duplicate IMA measurements will not be recorded in the IMA log. May 14 18:08:00.297435 kernel: device-mapper: uevent: version 1.0.3 May 14 18:08:00.298452 kernel: device-mapper: ioctl: 4.48.0-ioctl (2023-03-01) initialised: dm-devel@lists.linux.dev May 14 18:08:00.306150 kernel: device-mapper: verity: sha256 using shash "sha256-ni" May 14 18:08:00.522738 systemd[1]: Found device dev-mapper-usr.device - /dev/mapper/usr. May 14 18:08:00.527749 systemd[1]: Mounting sysusr-usr.mount - /sysusr/usr... May 14 18:08:00.542830 systemd[1]: Finished verity-setup.service - Verity Setup for /dev/mapper/usr. May 14 18:08:00.555146 kernel: BTRFS info: 'norecovery' is for compatibility only, recommended to use 'rescue=nologreplay' May 14 18:08:00.558146 kernel: BTRFS: device fsid dedcf745-d4ff-44ac-b61c-5ec1bad114c7 devid 1 transid 39 /dev/mapper/usr (254:0) scanned by mount (727) May 14 18:08:00.558173 kernel: BTRFS info (device dm-0): first mount of filesystem dedcf745-d4ff-44ac-b61c-5ec1bad114c7 May 14 18:08:00.560275 kernel: BTRFS info (device dm-0): using crc32c (crc32c-intel) checksum algorithm May 14 18:08:00.561341 kernel: BTRFS info (device dm-0): using free-space-tree May 14 18:08:00.835904 systemd[1]: Mounted sysusr-usr.mount - /sysusr/usr. May 14 18:08:00.837296 systemd[1]: Reached target initrd-usr-fs.target - Initrd /usr File System. May 14 18:08:00.837771 systemd[1]: afterburn-network-kargs.service - Afterburn Initrd Setup Network Kernel Arguments was skipped because no trigger condition checks were met. May 14 18:08:00.838577 systemd[1]: Starting ignition-setup.service - Ignition (setup)... May 14 18:08:00.841236 systemd[1]: Starting parse-ip-for-networkd.service - Write systemd-networkd units from cmdline... May 14 18:08:00.873254 kernel: BTRFS: device label OEM devid 1 transid 15 /dev/nvme0n1p6 (259:5) scanned by mount (771) May 14 18:08:00.873288 kernel: BTRFS info (device nvme0n1p6): first mount of filesystem 9b1e3c61-417b-43c0-b064-c7db19a42998 May 14 18:08:00.876838 kernel: BTRFS info (device nvme0n1p6): using crc32c (crc32c-intel) checksum algorithm May 14 18:08:00.876873 kernel: BTRFS info (device nvme0n1p6): using free-space-tree May 14 18:08:00.901158 kernel: BTRFS info (device nvme0n1p6): last unmount of filesystem 9b1e3c61-417b-43c0-b064-c7db19a42998 May 14 18:08:00.902065 systemd[1]: Finished ignition-setup.service - Ignition (setup). May 14 18:08:00.904310 systemd[1]: Starting ignition-fetch-offline.service - Ignition (fetch-offline)... May 14 18:08:00.910063 systemd[1]: Finished parse-ip-for-networkd.service - Write systemd-networkd units from cmdline. May 14 18:08:00.916204 systemd[1]: Starting systemd-networkd.service - Network Configuration... May 14 18:08:00.948572 systemd-networkd[896]: lo: Link UP May 14 18:08:00.948577 systemd-networkd[896]: lo: Gained carrier May 14 18:08:00.949926 systemd-networkd[896]: Enumeration completed May 14 18:08:00.953416 kernel: mana 7870:00:00.0 enP30832s1: Configured vPort 0 PD 18 DB 16 May 14 18:08:00.950195 systemd[1]: Started systemd-networkd.service - Network Configuration. May 14 18:08:00.961235 kernel: mana 7870:00:00.0 enP30832s1: Configured steering vPort 0 entries 64 May 14 18:08:00.961417 kernel: hv_netvsc f8615163-0000-1000-2000-6045bde03002 eth0: Data path switched to VF: enP30832s1 May 14 18:08:00.950326 systemd-networkd[896]: eth0: found matching network '/usr/lib/systemd/network/zz-default.network', based on potentially unpredictable interface name. May 14 18:08:00.950329 systemd-networkd[896]: eth0: Configuring with /usr/lib/systemd/network/zz-default.network. May 14 18:08:00.957111 systemd[1]: Reached target network.target - Network. May 14 18:08:00.960912 systemd-networkd[896]: enP30832s1: Link UP May 14 18:08:00.960970 systemd-networkd[896]: eth0: Link UP May 14 18:08:00.961043 systemd-networkd[896]: eth0: Gained carrier May 14 18:08:00.961051 systemd-networkd[896]: eth0: found matching network '/usr/lib/systemd/network/zz-default.network', based on potentially unpredictable interface name. May 14 18:08:00.965278 systemd-networkd[896]: enP30832s1: Gained carrier May 14 18:08:00.975166 systemd-networkd[896]: eth0: DHCPv4 address 10.200.8.19/24, gateway 10.200.8.1 acquired from 168.63.129.16 May 14 18:08:01.766842 ignition[891]: Ignition 2.21.0 May 14 18:08:01.766854 ignition[891]: Stage: fetch-offline May 14 18:08:01.768334 systemd[1]: Finished ignition-fetch-offline.service - Ignition (fetch-offline). May 14 18:08:01.766924 ignition[891]: no configs at "/usr/lib/ignition/base.d" May 14 18:08:01.771244 systemd[1]: Starting ignition-fetch.service - Ignition (fetch)... May 14 18:08:01.766930 ignition[891]: no config dir at "/usr/lib/ignition/base.platform.d/azure" May 14 18:08:01.766995 ignition[891]: parsed url from cmdline: "" May 14 18:08:01.766997 ignition[891]: no config URL provided May 14 18:08:01.767001 ignition[891]: reading system config file "/usr/lib/ignition/user.ign" May 14 18:08:01.767005 ignition[891]: no config at "/usr/lib/ignition/user.ign" May 14 18:08:01.767009 ignition[891]: failed to fetch config: resource requires networking May 14 18:08:01.767237 ignition[891]: Ignition finished successfully May 14 18:08:01.797185 ignition[906]: Ignition 2.21.0 May 14 18:08:01.797195 ignition[906]: Stage: fetch May 14 18:08:01.797355 ignition[906]: no configs at "/usr/lib/ignition/base.d" May 14 18:08:01.797362 ignition[906]: no config dir at "/usr/lib/ignition/base.platform.d/azure" May 14 18:08:01.797428 ignition[906]: parsed url from cmdline: "" May 14 18:08:01.797431 ignition[906]: no config URL provided May 14 18:08:01.797434 ignition[906]: reading system config file "/usr/lib/ignition/user.ign" May 14 18:08:01.797439 ignition[906]: no config at "/usr/lib/ignition/user.ign" May 14 18:08:01.797465 ignition[906]: GET http://169.254.169.254/metadata/instance/compute/userData?api-version=2021-01-01&format=text: attempt #1 May 14 18:08:01.896198 ignition[906]: GET result: OK May 14 18:08:01.896248 ignition[906]: config has been read from IMDS userdata May 14 18:08:01.896260 ignition[906]: parsing config with SHA512: 550c94b3558f18b2c55141094b7a8b9ac1227b6f220c9476cd1d6bb9104510e34aa834346442d87586a7ef3086de4b079f497960f97eecbe39f29928a6c73b08 May 14 18:08:01.902465 unknown[906]: fetched base config from "system" May 14 18:08:01.902660 unknown[906]: fetched base config from "system" May 14 18:08:01.902803 ignition[906]: fetch: fetch complete May 14 18:08:01.902665 unknown[906]: fetched user config from "azure" May 14 18:08:01.902807 ignition[906]: fetch: fetch passed May 14 18:08:01.904558 systemd[1]: Finished ignition-fetch.service - Ignition (fetch). May 14 18:08:01.902840 ignition[906]: Ignition finished successfully May 14 18:08:01.905981 systemd[1]: Starting ignition-kargs.service - Ignition (kargs)... May 14 18:08:01.930766 ignition[912]: Ignition 2.21.0 May 14 18:08:01.930776 ignition[912]: Stage: kargs May 14 18:08:01.930924 ignition[912]: no configs at "/usr/lib/ignition/base.d" May 14 18:08:01.933018 systemd[1]: Finished ignition-kargs.service - Ignition (kargs). May 14 18:08:01.930930 ignition[912]: no config dir at "/usr/lib/ignition/base.platform.d/azure" May 14 18:08:01.931645 ignition[912]: kargs: kargs passed May 14 18:08:01.938614 systemd[1]: Starting ignition-disks.service - Ignition (disks)... May 14 18:08:01.931677 ignition[912]: Ignition finished successfully May 14 18:08:01.955437 ignition[918]: Ignition 2.21.0 May 14 18:08:01.955447 ignition[918]: Stage: disks May 14 18:08:01.955591 ignition[918]: no configs at "/usr/lib/ignition/base.d" May 14 18:08:01.958053 systemd[1]: Finished ignition-disks.service - Ignition (disks). May 14 18:08:01.955597 ignition[918]: no config dir at "/usr/lib/ignition/base.platform.d/azure" May 14 18:08:01.960772 systemd[1]: Reached target initrd-root-device.target - Initrd Root Device. May 14 18:08:01.957419 ignition[918]: disks: disks passed May 14 18:08:01.962821 systemd[1]: Reached target local-fs-pre.target - Preparation for Local File Systems. May 14 18:08:01.957458 ignition[918]: Ignition finished successfully May 14 18:08:01.963439 systemd[1]: Reached target local-fs.target - Local File Systems. May 14 18:08:01.963462 systemd[1]: Reached target sysinit.target - System Initialization. May 14 18:08:01.963480 systemd[1]: Reached target basic.target - Basic System. May 14 18:08:01.965065 systemd[1]: Starting systemd-fsck-root.service - File System Check on /dev/disk/by-label/ROOT... May 14 18:08:02.044808 systemd-fsck[927]: ROOT: clean, 15/7326000 files, 477845/7359488 blocks May 14 18:08:02.049096 systemd[1]: Finished systemd-fsck-root.service - File System Check on /dev/disk/by-label/ROOT. May 14 18:08:02.055053 systemd[1]: Mounting sysroot.mount - /sysroot... May 14 18:08:02.154210 systemd-networkd[896]: eth0: Gained IPv6LL May 14 18:08:02.282282 systemd-networkd[896]: enP30832s1: Gained IPv6LL May 14 18:08:02.349143 kernel: EXT4-fs (nvme0n1p9): mounted filesystem d6072e19-4548-4806-a012-87bb17c59f4c r/w with ordered data mode. Quota mode: none. May 14 18:08:02.349752 systemd[1]: Mounted sysroot.mount - /sysroot. May 14 18:08:02.351023 systemd[1]: Reached target initrd-root-fs.target - Initrd Root File System. May 14 18:08:02.368948 systemd[1]: Mounting sysroot-oem.mount - /sysroot/oem... May 14 18:08:02.370724 systemd[1]: Mounting sysroot-usr.mount - /sysroot/usr... May 14 18:08:02.384245 systemd[1]: Starting flatcar-metadata-hostname.service - Flatcar Metadata Hostname Agent... May 14 18:08:02.386028 systemd[1]: ignition-remount-sysroot.service - Remount /sysroot read-write for Ignition was skipped because of an unmet condition check (ConditionPathIsReadWrite=!/sysroot). May 14 18:08:02.386054 systemd[1]: Reached target ignition-diskful.target - Ignition Boot Disk Setup. May 14 18:08:02.390532 systemd[1]: Mounted sysroot-usr.mount - /sysroot/usr. May 14 18:08:02.402238 kernel: BTRFS: device label OEM devid 1 transid 15 /dev/nvme0n1p6 (259:5) scanned by mount (936) May 14 18:08:02.402307 systemd[1]: Starting initrd-setup-root.service - Root filesystem setup... May 14 18:08:02.407763 kernel: BTRFS info (device nvme0n1p6): first mount of filesystem 9b1e3c61-417b-43c0-b064-c7db19a42998 May 14 18:08:02.407781 kernel: BTRFS info (device nvme0n1p6): using crc32c (crc32c-intel) checksum algorithm May 14 18:08:02.407795 kernel: BTRFS info (device nvme0n1p6): using free-space-tree May 14 18:08:02.411616 systemd[1]: Mounted sysroot-oem.mount - /sysroot/oem. May 14 18:08:04.144492 initrd-setup-root[961]: cut: /sysroot/etc/passwd: No such file or directory May 14 18:08:04.168162 initrd-setup-root[968]: cut: /sysroot/etc/group: No such file or directory May 14 18:08:04.172561 initrd-setup-root[975]: cut: /sysroot/etc/shadow: No such file or directory May 14 18:08:04.177382 initrd-setup-root[982]: cut: /sysroot/etc/gshadow: No such file or directory May 14 18:08:05.240256 coreos-metadata[938]: May 14 18:08:05.240 INFO Fetching http://168.63.129.16/?comp=versions: Attempt #1 May 14 18:08:05.248520 coreos-metadata[938]: May 14 18:08:05.248 INFO Fetch successful May 14 18:08:05.250237 coreos-metadata[938]: May 14 18:08:05.248 INFO Fetching http://169.254.169.254/metadata/instance/compute/name?api-version=2017-08-01&format=text: Attempt #1 May 14 18:08:05.261808 coreos-metadata[938]: May 14 18:08:05.261 INFO Fetch successful May 14 18:08:05.261808 coreos-metadata[938]: May 14 18:08:05.261 INFO wrote hostname ci-4334.0.0-a-ec82bf957b to /sysroot/etc/hostname May 14 18:08:05.264819 systemd[1]: Finished flatcar-metadata-hostname.service - Flatcar Metadata Hostname Agent. May 14 18:08:05.429494 systemd[1]: Finished initrd-setup-root.service - Root filesystem setup. May 14 18:08:05.431095 systemd[1]: Starting ignition-mount.service - Ignition (mount)... May 14 18:08:05.434244 systemd[1]: Starting sysroot-boot.service - /sysroot/boot... May 14 18:08:05.451279 systemd[1]: sysroot-oem.mount: Deactivated successfully. May 14 18:08:05.456589 kernel: BTRFS info (device nvme0n1p6): last unmount of filesystem 9b1e3c61-417b-43c0-b064-c7db19a42998 May 14 18:08:05.471810 systemd[1]: Finished sysroot-boot.service - /sysroot/boot. May 14 18:08:05.481144 ignition[1055]: INFO : Ignition 2.21.0 May 14 18:08:05.481144 ignition[1055]: INFO : Stage: mount May 14 18:08:05.481144 ignition[1055]: INFO : no configs at "/usr/lib/ignition/base.d" May 14 18:08:05.490803 ignition[1055]: INFO : no config dir at "/usr/lib/ignition/base.platform.d/azure" May 14 18:08:05.490803 ignition[1055]: INFO : mount: mount passed May 14 18:08:05.490803 ignition[1055]: INFO : Ignition finished successfully May 14 18:08:05.484603 systemd[1]: Finished ignition-mount.service - Ignition (mount). May 14 18:08:05.489806 systemd[1]: Starting ignition-files.service - Ignition (files)... May 14 18:08:05.502053 systemd[1]: Mounting sysroot-oem.mount - /sysroot/oem... May 14 18:08:05.520187 kernel: BTRFS: device label OEM devid 1 transid 15 /dev/nvme0n1p6 (259:5) scanned by mount (1069) May 14 18:08:05.522549 kernel: BTRFS info (device nvme0n1p6): first mount of filesystem 9b1e3c61-417b-43c0-b064-c7db19a42998 May 14 18:08:05.522575 kernel: BTRFS info (device nvme0n1p6): using crc32c (crc32c-intel) checksum algorithm May 14 18:08:05.522585 kernel: BTRFS info (device nvme0n1p6): using free-space-tree May 14 18:08:05.527459 systemd[1]: Mounted sysroot-oem.mount - /sysroot/oem. May 14 18:08:05.549853 ignition[1086]: INFO : Ignition 2.21.0 May 14 18:08:05.549853 ignition[1086]: INFO : Stage: files May 14 18:08:05.553745 ignition[1086]: INFO : no configs at "/usr/lib/ignition/base.d" May 14 18:08:05.553745 ignition[1086]: INFO : no config dir at "/usr/lib/ignition/base.platform.d/azure" May 14 18:08:05.553745 ignition[1086]: DEBUG : files: compiled without relabeling support, skipping May 14 18:08:05.566155 ignition[1086]: INFO : files: ensureUsers: op(1): [started] creating or modifying user "core" May 14 18:08:05.566155 ignition[1086]: DEBUG : files: ensureUsers: op(1): executing: "usermod" "--root" "/sysroot" "core" May 14 18:08:05.582077 ignition[1086]: INFO : files: ensureUsers: op(1): [finished] creating or modifying user "core" May 14 18:08:05.585260 ignition[1086]: INFO : files: ensureUsers: op(2): [started] adding ssh keys to user "core" May 14 18:08:05.585260 ignition[1086]: INFO : files: ensureUsers: op(2): [finished] adding ssh keys to user "core" May 14 18:08:05.583961 unknown[1086]: wrote ssh authorized keys file for user: core May 14 18:08:05.745062 ignition[1086]: INFO : files: createFilesystemsFiles: createFiles: op(3): [started] writing file "/sysroot/etc/flatcar/update.conf" May 14 18:08:05.750611 ignition[1086]: INFO : files: createFilesystemsFiles: createFiles: op(3): [finished] writing file "/sysroot/etc/flatcar/update.conf" May 14 18:08:05.750611 ignition[1086]: INFO : files: createResultFile: createFiles: op(4): [started] writing file "/sysroot/etc/.ignition-result.json" May 14 18:08:05.750611 ignition[1086]: INFO : files: createResultFile: createFiles: op(4): [finished] writing file "/sysroot/etc/.ignition-result.json" May 14 18:08:05.750611 ignition[1086]: INFO : files: files passed May 14 18:08:05.750611 ignition[1086]: INFO : Ignition finished successfully May 14 18:08:05.746899 systemd[1]: Finished ignition-files.service - Ignition (files). May 14 18:08:05.757715 systemd[1]: Starting ignition-quench.service - Ignition (record completion)... May 14 18:08:05.768845 systemd[1]: Starting initrd-setup-root-after-ignition.service - Root filesystem completion... May 14 18:08:05.771113 systemd[1]: ignition-quench.service: Deactivated successfully. May 14 18:08:05.775585 systemd[1]: Finished ignition-quench.service - Ignition (record completion). May 14 18:08:05.786096 initrd-setup-root-after-ignition[1116]: grep: /sysroot/etc/flatcar/enabled-sysext.conf: No such file or directory May 14 18:08:05.786096 initrd-setup-root-after-ignition[1116]: grep: /sysroot/usr/share/flatcar/enabled-sysext.conf: No such file or directory May 14 18:08:05.790845 initrd-setup-root-after-ignition[1120]: grep: /sysroot/etc/flatcar/enabled-sysext.conf: No such file or directory May 14 18:08:05.791762 systemd[1]: Finished initrd-setup-root-after-ignition.service - Root filesystem completion. May 14 18:08:05.797414 systemd[1]: Reached target ignition-complete.target - Ignition Complete. May 14 18:08:05.802638 systemd[1]: Starting initrd-parse-etc.service - Mountpoints Configured in the Real Root... May 14 18:08:05.838377 systemd[1]: initrd-parse-etc.service: Deactivated successfully. May 14 18:08:05.838456 systemd[1]: Finished initrd-parse-etc.service - Mountpoints Configured in the Real Root. May 14 18:08:05.841430 systemd[1]: Reached target initrd-fs.target - Initrd File Systems. May 14 18:08:05.843479 systemd[1]: Reached target initrd.target - Initrd Default Target. May 14 18:08:05.843548 systemd[1]: dracut-mount.service - dracut mount hook was skipped because no trigger condition checks were met. May 14 18:08:05.844233 systemd[1]: Starting dracut-pre-pivot.service - dracut pre-pivot and cleanup hook... May 14 18:08:05.873118 systemd[1]: Finished dracut-pre-pivot.service - dracut pre-pivot and cleanup hook. May 14 18:08:05.877123 systemd[1]: Starting initrd-cleanup.service - Cleaning Up and Shutting Down Daemons... May 14 18:08:05.893531 systemd[1]: Stopped target nss-lookup.target - Host and Network Name Lookups. May 14 18:08:05.894013 systemd[1]: Stopped target remote-cryptsetup.target - Remote Encrypted Volumes. May 14 18:08:05.894374 systemd[1]: Stopped target timers.target - Timer Units. May 14 18:08:05.894650 systemd[1]: dracut-pre-pivot.service: Deactivated successfully. May 14 18:08:05.894738 systemd[1]: Stopped dracut-pre-pivot.service - dracut pre-pivot and cleanup hook. May 14 18:08:05.902502 systemd[1]: Stopped target initrd.target - Initrd Default Target. May 14 18:08:05.904018 systemd[1]: Stopped target basic.target - Basic System. May 14 18:08:05.907717 systemd[1]: Stopped target ignition-complete.target - Ignition Complete. May 14 18:08:05.911040 systemd[1]: Stopped target ignition-diskful.target - Ignition Boot Disk Setup. May 14 18:08:05.917377 systemd[1]: Stopped target initrd-root-device.target - Initrd Root Device. May 14 18:08:05.918657 systemd[1]: Stopped target initrd-usr-fs.target - Initrd /usr File System. May 14 18:08:05.922273 systemd[1]: Stopped target remote-fs.target - Remote File Systems. May 14 18:08:05.924739 systemd[1]: Stopped target remote-fs-pre.target - Preparation for Remote File Systems. May 14 18:08:05.927823 systemd[1]: Stopped target sysinit.target - System Initialization. May 14 18:08:05.928053 systemd[1]: Stopped target local-fs.target - Local File Systems. May 14 18:08:05.928291 systemd[1]: Stopped target swap.target - Swaps. May 14 18:08:05.928478 systemd[1]: dracut-pre-mount.service: Deactivated successfully. May 14 18:08:05.928592 systemd[1]: Stopped dracut-pre-mount.service - dracut pre-mount hook. May 14 18:08:05.935301 systemd[1]: Stopped target cryptsetup.target - Local Encrypted Volumes. May 14 18:08:05.937889 systemd[1]: Stopped target cryptsetup-pre.target - Local Encrypted Volumes (Pre). May 14 18:08:05.941239 systemd[1]: clevis-luks-askpass.path: Deactivated successfully. May 14 18:08:05.941966 systemd[1]: Stopped clevis-luks-askpass.path - Forward Password Requests to Clevis Directory Watch. May 14 18:08:05.945262 systemd[1]: dracut-initqueue.service: Deactivated successfully. May 14 18:08:05.945374 systemd[1]: Stopped dracut-initqueue.service - dracut initqueue hook. May 14 18:08:05.949230 systemd[1]: initrd-setup-root-after-ignition.service: Deactivated successfully. May 14 18:08:05.949361 systemd[1]: Stopped initrd-setup-root-after-ignition.service - Root filesystem completion. May 14 18:08:05.955974 systemd[1]: ignition-files.service: Deactivated successfully. May 14 18:08:05.956069 systemd[1]: Stopped ignition-files.service - Ignition (files). May 14 18:08:05.960296 systemd[1]: flatcar-metadata-hostname.service: Deactivated successfully. May 14 18:08:05.960398 systemd[1]: Stopped flatcar-metadata-hostname.service - Flatcar Metadata Hostname Agent. May 14 18:08:05.964326 systemd[1]: Stopping ignition-mount.service - Ignition (mount)... May 14 18:08:05.966228 systemd[1]: Stopping sysroot-boot.service - /sysroot/boot... May 14 18:08:05.969127 systemd[1]: systemd-udev-trigger.service: Deactivated successfully. May 14 18:08:05.969258 systemd[1]: Stopped systemd-udev-trigger.service - Coldplug All udev Devices. May 14 18:08:05.972006 systemd[1]: dracut-pre-trigger.service: Deactivated successfully. May 14 18:08:05.972093 systemd[1]: Stopped dracut-pre-trigger.service - dracut pre-trigger hook. May 14 18:08:05.993447 ignition[1140]: INFO : Ignition 2.21.0 May 14 18:08:05.993447 ignition[1140]: INFO : Stage: umount May 14 18:08:05.993447 ignition[1140]: INFO : no configs at "/usr/lib/ignition/base.d" May 14 18:08:05.993447 ignition[1140]: INFO : no config dir at "/usr/lib/ignition/base.platform.d/azure" May 14 18:08:05.993447 ignition[1140]: INFO : umount: umount passed May 14 18:08:05.993447 ignition[1140]: INFO : Ignition finished successfully May 14 18:08:05.995829 systemd[1]: ignition-mount.service: Deactivated successfully. May 14 18:08:05.995902 systemd[1]: Stopped ignition-mount.service - Ignition (mount). May 14 18:08:06.003248 systemd[1]: ignition-disks.service: Deactivated successfully. May 14 18:08:06.003317 systemd[1]: Stopped ignition-disks.service - Ignition (disks). May 14 18:08:06.006229 systemd[1]: ignition-kargs.service: Deactivated successfully. May 14 18:08:06.006271 systemd[1]: Stopped ignition-kargs.service - Ignition (kargs). May 14 18:08:06.009196 systemd[1]: ignition-fetch.service: Deactivated successfully. May 14 18:08:06.009233 systemd[1]: Stopped ignition-fetch.service - Ignition (fetch). May 14 18:08:06.012190 systemd[1]: Stopped target network.target - Network. May 14 18:08:06.015180 systemd[1]: ignition-fetch-offline.service: Deactivated successfully. May 14 18:08:06.015219 systemd[1]: Stopped ignition-fetch-offline.service - Ignition (fetch-offline). May 14 18:08:06.017352 systemd[1]: Stopped target paths.target - Path Units. May 14 18:08:06.019161 systemd[1]: systemd-ask-password-console.path: Deactivated successfully. May 14 18:08:06.019295 systemd[1]: Stopped systemd-ask-password-console.path - Dispatch Password Requests to Console Directory Watch. May 14 18:08:06.023163 systemd[1]: Stopped target slices.target - Slice Units. May 14 18:08:06.024668 systemd[1]: Stopped target sockets.target - Socket Units. May 14 18:08:06.028183 systemd[1]: iscsid.socket: Deactivated successfully. May 14 18:08:06.028218 systemd[1]: Closed iscsid.socket - Open-iSCSI iscsid Socket. May 14 18:08:06.031185 systemd[1]: iscsiuio.socket: Deactivated successfully. May 14 18:08:06.031210 systemd[1]: Closed iscsiuio.socket - Open-iSCSI iscsiuio Socket. May 14 18:08:06.033149 systemd[1]: ignition-setup.service: Deactivated successfully. May 14 18:08:06.033190 systemd[1]: Stopped ignition-setup.service - Ignition (setup). May 14 18:08:06.037188 systemd[1]: ignition-setup-pre.service: Deactivated successfully. May 14 18:08:06.037219 systemd[1]: Stopped ignition-setup-pre.service - Ignition env setup. May 14 18:08:06.041253 systemd[1]: Stopping systemd-networkd.service - Network Configuration... May 14 18:08:06.044693 systemd[1]: Stopping systemd-resolved.service - Network Name Resolution... May 14 18:08:06.052237 systemd[1]: sysroot-boot.mount: Deactivated successfully. May 14 18:08:06.052645 systemd[1]: systemd-resolved.service: Deactivated successfully. May 14 18:08:06.052708 systemd[1]: Stopped systemd-resolved.service - Network Name Resolution. May 14 18:08:06.064220 systemd[1]: systemd-networkd.service: Deactivated successfully. May 14 18:08:06.064318 systemd[1]: Stopped systemd-networkd.service - Network Configuration. May 14 18:08:06.070560 systemd[1]: initrd-cleanup.service: Deactivated successfully. May 14 18:08:06.070634 systemd[1]: Finished initrd-cleanup.service - Cleaning Up and Shutting Down Daemons. May 14 18:08:06.077440 systemd[1]: Stopped target network-pre.target - Preparation for Network. May 14 18:08:06.078891 systemd[1]: systemd-networkd.socket: Deactivated successfully. May 14 18:08:06.078936 systemd[1]: Closed systemd-networkd.socket - Network Service Netlink Socket. May 14 18:08:06.135555 kernel: hv_netvsc f8615163-0000-1000-2000-6045bde03002 eth0: Data path switched from VF: enP30832s1 May 14 18:08:06.135711 kernel: mana 7870:00:00.0 enP30832s1: Configured steering vPort 0 entries 64 May 14 18:08:06.080185 systemd[1]: Stopping network-cleanup.service - Network Cleanup... May 14 18:08:06.090455 systemd[1]: parse-ip-for-networkd.service: Deactivated successfully. May 14 18:08:06.090514 systemd[1]: Stopped parse-ip-for-networkd.service - Write systemd-networkd units from cmdline. May 14 18:08:06.093216 systemd[1]: systemd-sysctl.service: Deactivated successfully. May 14 18:08:06.094066 systemd[1]: Stopped systemd-sysctl.service - Apply Kernel Variables. May 14 18:08:06.099315 systemd[1]: systemd-modules-load.service: Deactivated successfully. May 14 18:08:06.099351 systemd[1]: Stopped systemd-modules-load.service - Load Kernel Modules. May 14 18:08:06.101634 systemd[1]: systemd-tmpfiles-setup.service: Deactivated successfully. May 14 18:08:06.101681 systemd[1]: Stopped systemd-tmpfiles-setup.service - Create System Files and Directories. May 14 18:08:06.106864 systemd[1]: Stopping systemd-udevd.service - Rule-based Manager for Device Events and Files... May 14 18:08:06.111740 systemd[1]: sysroot-boot.service: Deactivated successfully. May 14 18:08:06.111821 systemd[1]: Stopped sysroot-boot.service - /sysroot/boot. May 14 18:08:06.119642 systemd[1]: initrd-setup-root.service: Deactivated successfully. May 14 18:08:06.119724 systemd[1]: Stopped initrd-setup-root.service - Root filesystem setup. May 14 18:08:06.124188 systemd[1]: systemd-udevd.service: Deactivated successfully. May 14 18:08:06.126075 systemd[1]: Stopped systemd-udevd.service - Rule-based Manager for Device Events and Files. May 14 18:08:06.126339 systemd[1]: systemd-udevd-control.socket: Deactivated successfully. May 14 18:08:06.126366 systemd[1]: Closed systemd-udevd-control.socket - udev Control Socket. May 14 18:08:06.126433 systemd[1]: systemd-udevd-kernel.socket: Deactivated successfully. May 14 18:08:06.126450 systemd[1]: Closed systemd-udevd-kernel.socket - udev Kernel Socket. May 14 18:08:06.126474 systemd[1]: dracut-pre-udev.service: Deactivated successfully. May 14 18:08:06.126499 systemd[1]: Stopped dracut-pre-udev.service - dracut pre-udev hook. May 14 18:08:06.126735 systemd[1]: dracut-cmdline.service: Deactivated successfully. May 14 18:08:06.126761 systemd[1]: Stopped dracut-cmdline.service - dracut cmdline hook. May 14 18:08:06.135764 systemd[1]: dracut-cmdline-ask.service: Deactivated successfully. May 14 18:08:06.135817 systemd[1]: Stopped dracut-cmdline-ask.service - dracut ask for additional cmdline parameters. May 14 18:08:06.140238 systemd[1]: Starting initrd-udevadm-cleanup-db.service - Cleanup udev Database... May 14 18:08:06.140490 systemd[1]: systemd-network-generator.service: Deactivated successfully. May 14 18:08:06.140538 systemd[1]: Stopped systemd-network-generator.service - Generate network units from Kernel command line. May 14 18:08:06.141046 systemd[1]: systemd-tmpfiles-setup-dev.service: Deactivated successfully. May 14 18:08:06.141076 systemd[1]: Stopped systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev. May 14 18:08:06.142891 systemd[1]: systemd-tmpfiles-setup-dev-early.service: Deactivated successfully. May 14 18:08:06.142934 systemd[1]: Stopped systemd-tmpfiles-setup-dev-early.service - Create Static Device Nodes in /dev gracefully. May 14 18:08:06.143869 systemd[1]: kmod-static-nodes.service: Deactivated successfully. May 14 18:08:06.143913 systemd[1]: Stopped kmod-static-nodes.service - Create List of Static Device Nodes. May 14 18:08:06.147084 systemd[1]: systemd-vconsole-setup.service: Deactivated successfully. May 14 18:08:06.147125 systemd[1]: Stopped systemd-vconsole-setup.service - Virtual Console Setup. May 14 18:08:06.154468 systemd[1]: network-cleanup.service: Deactivated successfully. May 14 18:08:06.154537 systemd[1]: Stopped network-cleanup.service - Network Cleanup. May 14 18:08:06.159664 systemd[1]: initrd-udevadm-cleanup-db.service: Deactivated successfully. May 14 18:08:06.159977 systemd[1]: Finished initrd-udevadm-cleanup-db.service - Cleanup udev Database. May 14 18:08:06.163977 systemd[1]: Reached target initrd-switch-root.target - Switch Root. May 14 18:08:06.170242 systemd[1]: Starting initrd-switch-root.service - Switch Root... May 14 18:08:06.208460 systemd[1]: Switching root. May 14 18:08:06.306998 systemd-journald[204]: Journal stopped May 14 18:08:10.411182 systemd-journald[204]: Received SIGTERM from PID 1 (systemd). May 14 18:08:10.411990 kernel: SELinux: policy capability network_peer_controls=1 May 14 18:08:10.412013 kernel: SELinux: policy capability open_perms=1 May 14 18:08:10.412022 kernel: SELinux: policy capability extended_socket_class=1 May 14 18:08:10.412030 kernel: SELinux: policy capability always_check_network=0 May 14 18:08:10.412038 kernel: SELinux: policy capability cgroup_seclabel=1 May 14 18:08:10.412049 kernel: SELinux: policy capability nnp_nosuid_transition=1 May 14 18:08:10.412833 kernel: SELinux: policy capability genfs_seclabel_symlinks=0 May 14 18:08:10.412844 kernel: SELinux: policy capability ioctl_skip_cloexec=0 May 14 18:08:10.412852 kernel: SELinux: policy capability userspace_initial_context=0 May 14 18:08:10.412861 kernel: audit: type=1403 audit(1747246087.274:2): auid=4294967295 ses=4294967295 lsm=selinux res=1 May 14 18:08:10.412871 systemd[1]: Successfully loaded SELinux policy in 129.887ms. May 14 18:08:10.412881 systemd[1]: Relabeled /dev/, /dev/shm/, /run/ in 6.025ms. May 14 18:08:10.412895 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) May 14 18:08:10.412905 systemd[1]: Detected virtualization microsoft. May 14 18:08:10.412915 systemd[1]: Detected architecture x86-64. May 14 18:08:10.412923 systemd[1]: Detected first boot. May 14 18:08:10.412932 systemd[1]: Hostname set to . May 14 18:08:10.412942 systemd[1]: Initializing machine ID from random generator. May 14 18:08:10.412951 zram_generator::config[1183]: No configuration found. May 14 18:08:10.412961 kernel: Guest personality initialized and is inactive May 14 18:08:10.412969 kernel: VMCI host device registered (name=vmci, major=10, minor=124) May 14 18:08:10.412976 kernel: Initialized host personality May 14 18:08:10.412984 kernel: NET: Registered PF_VSOCK protocol family May 14 18:08:10.412992 systemd[1]: Populated /etc with preset unit settings. May 14 18:08:10.413004 systemd[1]: run-credentials-systemd\x2djournald.service.mount: Deactivated successfully. May 14 18:08:10.413013 systemd[1]: initrd-switch-root.service: Deactivated successfully. May 14 18:08:10.413023 systemd[1]: Stopped initrd-switch-root.service - Switch Root. May 14 18:08:10.413032 systemd[1]: systemd-journald.service: Scheduled restart job, restart counter is at 1. May 14 18:08:10.413042 systemd[1]: Created slice system-addon\x2dconfig.slice - Slice /system/addon-config. May 14 18:08:10.413052 systemd[1]: Created slice system-addon\x2drun.slice - Slice /system/addon-run. May 14 18:08:10.413062 systemd[1]: Created slice system-getty.slice - Slice /system/getty. May 14 18:08:10.413072 systemd[1]: Created slice system-modprobe.slice - Slice /system/modprobe. May 14 18:08:10.413081 systemd[1]: Created slice system-serial\x2dgetty.slice - Slice /system/serial-getty. May 14 18:08:10.413090 systemd[1]: Created slice system-system\x2dcloudinit.slice - Slice /system/system-cloudinit. May 14 18:08:10.413099 systemd[1]: Created slice system-systemd\x2dfsck.slice - Slice /system/systemd-fsck. May 14 18:08:10.413107 systemd[1]: Created slice user.slice - User and Session Slice. May 14 18:08:10.413116 systemd[1]: Started clevis-luks-askpass.path - Forward Password Requests to Clevis Directory Watch. May 14 18:08:10.413125 systemd[1]: Started systemd-ask-password-console.path - Dispatch Password Requests to Console Directory Watch. May 14 18:08:10.413147 systemd[1]: Started systemd-ask-password-wall.path - Forward Password Requests to Wall Directory Watch. May 14 18:08:10.413157 systemd[1]: Set up automount boot.automount - Boot partition Automount Point. May 14 18:08:10.413167 systemd[1]: Set up automount proc-sys-fs-binfmt_misc.automount - Arbitrary Executable File Formats File System Automount Point. May 14 18:08:10.413177 systemd[1]: Expecting device dev-disk-by\x2dlabel-OEM.device - /dev/disk/by-label/OEM... May 14 18:08:10.413186 systemd[1]: Expecting device dev-ttyS0.device - /dev/ttyS0... May 14 18:08:10.413195 systemd[1]: Reached target cryptsetup-pre.target - Local Encrypted Volumes (Pre). May 14 18:08:10.413205 systemd[1]: Reached target cryptsetup.target - Local Encrypted Volumes. May 14 18:08:10.413214 systemd[1]: Stopped target initrd-switch-root.target - Switch Root. May 14 18:08:10.413224 systemd[1]: Stopped target initrd-fs.target - Initrd File Systems. May 14 18:08:10.413234 systemd[1]: Stopped target initrd-root-fs.target - Initrd Root File System. May 14 18:08:10.413244 systemd[1]: Reached target integritysetup.target - Local Integrity Protected Volumes. May 14 18:08:10.413253 systemd[1]: Reached target remote-cryptsetup.target - Remote Encrypted Volumes. May 14 18:08:10.413264 systemd[1]: Reached target remote-fs.target - Remote File Systems. May 14 18:08:10.413273 systemd[1]: Reached target slices.target - Slice Units. May 14 18:08:10.413282 systemd[1]: Reached target swap.target - Swaps. May 14 18:08:10.413292 systemd[1]: Reached target veritysetup.target - Local Verity Protected Volumes. May 14 18:08:10.413301 systemd[1]: Listening on systemd-coredump.socket - Process Core Dump Socket. May 14 18:08:10.413312 systemd[1]: Listening on systemd-creds.socket - Credential Encryption/Decryption. May 14 18:08:10.413322 systemd[1]: Listening on systemd-networkd.socket - Network Service Netlink Socket. May 14 18:08:10.413331 systemd[1]: Listening on systemd-udevd-control.socket - udev Control Socket. May 14 18:08:10.413340 systemd[1]: Listening on systemd-udevd-kernel.socket - udev Kernel Socket. May 14 18:08:10.413349 systemd[1]: Listening on systemd-userdbd.socket - User Database Manager Socket. May 14 18:08:10.413360 systemd[1]: Mounting dev-hugepages.mount - Huge Pages File System... May 14 18:08:10.413369 systemd[1]: Mounting dev-mqueue.mount - POSIX Message Queue File System... May 14 18:08:10.413379 systemd[1]: Mounting media.mount - External Media Directory... May 14 18:08:10.413388 systemd[1]: proc-xen.mount - /proc/xen was skipped because of an unmet condition check (ConditionVirtualization=xen). May 14 18:08:10.413397 systemd[1]: Mounting sys-kernel-debug.mount - Kernel Debug File System... May 14 18:08:10.413407 systemd[1]: Mounting sys-kernel-tracing.mount - Kernel Trace File System... May 14 18:08:10.413416 systemd[1]: Mounting tmp.mount - Temporary Directory /tmp... May 14 18:08:10.413426 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). May 14 18:08:10.413436 systemd[1]: Reached target machines.target - Containers. May 14 18:08:10.413446 systemd[1]: Starting flatcar-tmpfiles.service - Create missing system files... May 14 18:08:10.413456 systemd[1]: ignition-delete-config.service - Ignition (delete config) was skipped because no trigger condition checks were met. May 14 18:08:10.413466 systemd[1]: Starting kmod-static-nodes.service - Create List of Static Device Nodes... May 14 18:08:10.413475 systemd[1]: Starting modprobe@configfs.service - Load Kernel Module configfs... May 14 18:08:10.413484 systemd[1]: Starting modprobe@dm_mod.service - Load Kernel Module dm_mod... May 14 18:08:10.413493 systemd[1]: Starting modprobe@drm.service - Load Kernel Module drm... May 14 18:08:10.413503 systemd[1]: Starting modprobe@efi_pstore.service - Load Kernel Module efi_pstore... May 14 18:08:10.413513 systemd[1]: Starting modprobe@fuse.service - Load Kernel Module fuse... May 14 18:08:10.413522 systemd[1]: Starting modprobe@loop.service - Load Kernel Module loop... May 14 18:08:10.413532 systemd[1]: setup-nsswitch.service - Create /etc/nsswitch.conf was skipped because of an unmet condition check (ConditionPathExists=!/etc/nsswitch.conf). May 14 18:08:10.413541 systemd[1]: systemd-fsck-root.service: Deactivated successfully. May 14 18:08:10.413551 systemd[1]: Stopped systemd-fsck-root.service - File System Check on Root Device. May 14 18:08:10.413560 systemd[1]: systemd-fsck-usr.service: Deactivated successfully. May 14 18:08:10.413569 systemd[1]: Stopped systemd-fsck-usr.service. May 14 18:08:10.413579 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). May 14 18:08:10.413590 systemd[1]: Starting systemd-journald.service - Journal Service... May 14 18:08:10.413599 systemd[1]: Starting systemd-modules-load.service - Load Kernel Modules... May 14 18:08:10.413609 systemd[1]: Starting systemd-network-generator.service - Generate network units from Kernel command line... May 14 18:08:10.413618 systemd[1]: Starting systemd-remount-fs.service - Remount Root and Kernel File Systems... May 14 18:08:10.413627 systemd[1]: Starting systemd-udev-load-credentials.service - Load udev Rules from Credentials... May 14 18:08:10.413637 systemd[1]: Starting systemd-udev-trigger.service - Coldplug All udev Devices... May 14 18:08:10.413645 systemd[1]: verity-setup.service: Deactivated successfully. May 14 18:08:10.413668 systemd[1]: Stopped verity-setup.service. May 14 18:08:10.413678 systemd[1]: xenserver-pv-version.service - Set fake PV driver version for XenServer was skipped because of an unmet condition check (ConditionVirtualization=xen). May 14 18:08:10.413689 systemd[1]: Mounted dev-hugepages.mount - Huge Pages File System. May 14 18:08:10.413698 kernel: loop: module loaded May 14 18:08:10.413729 systemd-journald[1261]: Collecting audit messages is disabled. May 14 18:08:10.413751 systemd[1]: Mounted dev-mqueue.mount - POSIX Message Queue File System. May 14 18:08:10.413761 systemd[1]: Mounted media.mount - External Media Directory. May 14 18:08:10.413771 systemd-journald[1261]: Journal started May 14 18:08:10.413793 systemd-journald[1261]: Runtime Journal (/run/log/journal/ee6f5692bb14440584fd3cba1d27885f) is 8M, max 159M, 151M free. May 14 18:08:10.039340 systemd[1]: Queued start job for default target multi-user.target. May 14 18:08:10.053501 systemd[1]: Unnecessary job was removed for dev-nvme0n1p6.device - /dev/nvme0n1p6. May 14 18:08:10.053811 systemd[1]: systemd-journald.service: Deactivated successfully. May 14 18:08:10.419585 systemd[1]: Started systemd-journald.service - Journal Service. May 14 18:08:10.420105 systemd[1]: Mounted sys-kernel-debug.mount - Kernel Debug File System. May 14 18:08:10.423306 systemd[1]: Mounted sys-kernel-tracing.mount - Kernel Trace File System. May 14 18:08:10.426329 systemd[1]: Mounted tmp.mount - Temporary Directory /tmp. May 14 18:08:10.429448 systemd[1]: Finished kmod-static-nodes.service - Create List of Static Device Nodes. May 14 18:08:10.433431 systemd[1]: modprobe@configfs.service: Deactivated successfully. May 14 18:08:10.433593 systemd[1]: Finished modprobe@configfs.service - Load Kernel Module configfs. May 14 18:08:10.438669 systemd[1]: modprobe@dm_mod.service: Deactivated successfully. May 14 18:08:10.438803 systemd[1]: Finished modprobe@dm_mod.service - Load Kernel Module dm_mod. May 14 18:08:10.440740 systemd[1]: modprobe@efi_pstore.service: Deactivated successfully. May 14 18:08:10.440898 systemd[1]: Finished modprobe@efi_pstore.service - Load Kernel Module efi_pstore. May 14 18:08:10.443059 systemd[1]: modprobe@loop.service: Deactivated successfully. May 14 18:08:10.443243 systemd[1]: Finished modprobe@loop.service - Load Kernel Module loop. May 14 18:08:10.446915 systemd[1]: Finished systemd-modules-load.service - Load Kernel Modules. May 14 18:08:10.449204 systemd[1]: Finished systemd-network-generator.service - Generate network units from Kernel command line. May 14 18:08:10.452420 systemd[1]: Finished systemd-remount-fs.service - Remount Root and Kernel File Systems. May 14 18:08:10.454430 systemd[1]: Finished systemd-udev-load-credentials.service - Load udev Rules from Credentials. May 14 18:08:10.467154 systemd[1]: Reached target network-pre.target - Preparation for Network. May 14 18:08:10.472220 systemd[1]: Mounting sys-kernel-config.mount - Kernel Configuration File System... May 14 18:08:10.474145 systemd[1]: remount-root.service - Remount Root File System was skipped because of an unmet condition check (ConditionPathIsReadWrite=!/). May 14 18:08:10.474178 systemd[1]: Reached target local-fs.target - Local File Systems. May 14 18:08:10.477427 systemd[1]: Listening on systemd-sysext.socket - System Extension Image Management. May 14 18:08:10.485241 systemd[1]: Starting ldconfig.service - Rebuild Dynamic Linker Cache... May 14 18:08:10.487009 systemd[1]: systemd-binfmt.service - Set Up Additional Binary Formats was skipped because no trigger condition checks were met. May 14 18:08:10.488923 systemd[1]: Starting systemd-hwdb-update.service - Rebuild Hardware Database... May 14 18:08:10.500245 systemd[1]: Starting systemd-journal-flush.service - Flush Journal to Persistent Storage... May 14 18:08:10.502474 systemd[1]: systemd-pstore.service - Platform Persistent Storage Archival was skipped because of an unmet condition check (ConditionDirectoryNotEmpty=/sys/fs/pstore). May 14 18:08:10.504229 systemd[1]: Starting systemd-random-seed.service - Load/Save OS Random Seed... May 14 18:08:10.506518 systemd[1]: systemd-repart.service - Repartition Root Disk was skipped because no trigger condition checks were met. May 14 18:08:10.507266 systemd[1]: Starting systemd-sysctl.service - Apply Kernel Variables... May 14 18:08:10.512937 systemd[1]: Starting systemd-sysext.service - Merge System Extension Images into /usr/ and /opt/... May 14 18:08:10.520664 systemd[1]: Starting systemd-tmpfiles-setup-dev-early.service - Create Static Device Nodes in /dev gracefully... May 14 18:08:10.525184 systemd[1]: Finished flatcar-tmpfiles.service - Create missing system files. May 14 18:08:10.527532 systemd[1]: Finished systemd-udev-trigger.service - Coldplug All udev Devices. May 14 18:08:10.529998 systemd[1]: Mounted sys-kernel-config.mount - Kernel Configuration File System. May 14 18:08:10.543156 kernel: ACPI: bus type drm_connector registered May 14 18:08:10.544011 systemd[1]: modprobe@drm.service: Deactivated successfully. May 14 18:08:10.544327 systemd[1]: Finished modprobe@drm.service - Load Kernel Module drm. May 14 18:08:10.710125 systemd-journald[1261]: Time spent on flushing to /var/log/journal/ee6f5692bb14440584fd3cba1d27885f is 27.732ms for 948 entries. May 14 18:08:10.710125 systemd-journald[1261]: System Journal (/var/log/journal/ee6f5692bb14440584fd3cba1d27885f) is 11.8M, max 2.6G, 2.6G free. May 14 18:08:11.449889 kernel: fuse: init (API version 7.41) May 14 18:08:11.449926 systemd-journald[1261]: Received client request to flush runtime journal. May 14 18:08:11.449957 systemd-journald[1261]: /var/log/journal/ee6f5692bb14440584fd3cba1d27885f/system.journal: Realtime clock jumped backwards relative to last journal entry, rotating. May 14 18:08:11.449981 systemd-journald[1261]: Rotating system journal. May 14 18:08:11.450003 kernel: loop0: detected capacity change from 0 to 146240 May 14 18:08:10.712263 systemd[1]: modprobe@fuse.service: Deactivated successfully. May 14 18:08:10.712459 systemd[1]: Finished modprobe@fuse.service - Load Kernel Module fuse. May 14 18:08:10.716344 systemd[1]: Mounting sys-fs-fuse-connections.mount - FUSE Control File System... May 14 18:08:10.734221 systemd[1]: Finished systemd-random-seed.service - Load/Save OS Random Seed. May 14 18:08:10.735858 systemd[1]: Reached target first-boot-complete.target - First Boot Complete. May 14 18:08:10.742277 systemd[1]: Starting systemd-machine-id-commit.service - Save Transient machine-id to Disk... May 14 18:08:10.749718 systemd[1]: Mounted sys-fs-fuse-connections.mount - FUSE Control File System. May 14 18:08:10.753473 systemd[1]: Finished systemd-sysctl.service - Apply Kernel Variables. May 14 18:08:10.763391 systemd-tmpfiles[1321]: ACLs are not supported, ignoring. May 14 18:08:10.763402 systemd-tmpfiles[1321]: ACLs are not supported, ignoring. May 14 18:08:10.768327 systemd[1]: Finished systemd-tmpfiles-setup-dev-early.service - Create Static Device Nodes in /dev gracefully. May 14 18:08:10.772040 systemd[1]: Starting systemd-sysusers.service - Create System Users... May 14 18:08:11.443065 systemd[1]: Finished systemd-sysusers.service - Create System Users. May 14 18:08:11.447236 systemd[1]: Starting systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev... May 14 18:08:11.450913 systemd[1]: Finished systemd-journal-flush.service - Flush Journal to Persistent Storage. May 14 18:08:11.460936 systemd[1]: etc-machine\x2did.mount: Deactivated successfully. May 14 18:08:11.461767 systemd[1]: Finished systemd-machine-id-commit.service - Save Transient machine-id to Disk. May 14 18:08:11.468515 systemd-tmpfiles[1338]: ACLs are not supported, ignoring. May 14 18:08:11.468529 systemd-tmpfiles[1338]: ACLs are not supported, ignoring. May 14 18:08:11.471024 systemd[1]: Finished systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev. May 14 18:08:11.915161 kernel: squashfs: version 4.0 (2009/01/31) Phillip Lougher May 14 18:08:11.948152 kernel: loop1: detected capacity change from 0 to 113872 May 14 18:08:13.257170 kernel: loop2: detected capacity change from 0 to 28536 May 14 18:08:13.867989 systemd[1]: Finished systemd-hwdb-update.service - Rebuild Hardware Database. May 14 18:08:13.873366 systemd[1]: Starting systemd-udevd.service - Rule-based Manager for Device Events and Files... May 14 18:08:13.898555 systemd-udevd[1350]: Using default interface naming scheme 'v255'. May 14 18:08:14.470148 kernel: loop3: detected capacity change from 0 to 146240 May 14 18:08:14.495174 kernel: loop4: detected capacity change from 0 to 113872 May 14 18:08:14.512162 kernel: loop5: detected capacity change from 0 to 28536 May 14 18:08:14.518738 systemd[1]: Started systemd-udevd.service - Rule-based Manager for Device Events and Files. May 14 18:08:14.524303 systemd[1]: Starting systemd-networkd.service - Network Configuration... May 14 18:08:14.531868 (sd-merge)[1352]: Using extensions 'containerd-flatcar', 'docker-flatcar', 'oem-azure'. May 14 18:08:14.532187 (sd-merge)[1352]: Merged extensions into '/usr'. May 14 18:08:14.545658 systemd[1]: Finished systemd-sysext.service - Merge System Extension Images into /usr/ and /opt/. May 14 18:08:14.553145 systemd[1]: Starting ensure-sysext.service... May 14 18:08:14.556038 systemd[1]: Starting systemd-tmpfiles-setup.service - Create System Files and Directories... May 14 18:08:14.583854 systemd[1]: Condition check resulted in dev-ttyS0.device - /dev/ttyS0 being skipped. May 14 18:08:14.606178 kernel: hv_storvsc f8b3781a-1e82-4818-a1c3-63d806ec15bb: tag#85 cmd 0x85 status: scsi 0x2 srb 0x6 hv 0xc0000001 May 14 18:08:14.635148 kernel: hv_vmbus: registering driver hyperv_fb May 14 18:08:14.638128 kernel: hyperv_fb: Synthvid Version major 3, minor 5 May 14 18:08:14.638182 kernel: hyperv_fb: Screen resolution: 1024x768, Color depth: 32, Frame buffer size: 8388608 May 14 18:08:14.638196 kernel: Console: switching to colour dummy device 80x25 May 14 18:08:14.644061 kernel: Console: switching to colour frame buffer device 128x48 May 14 18:08:14.849113 systemd-tmpfiles[1384]: /usr/lib/tmpfiles.d/nfs-utils.conf:6: Duplicate line for path "/var/lib/nfs/sm", ignoring. May 14 18:08:14.849398 systemd-tmpfiles[1384]: /usr/lib/tmpfiles.d/nfs-utils.conf:7: Duplicate line for path "/var/lib/nfs/sm.bak", ignoring. May 14 18:08:14.849579 systemd-tmpfiles[1384]: /usr/lib/tmpfiles.d/provision.conf:20: Duplicate line for path "/root", ignoring. May 14 18:08:14.850282 systemd-tmpfiles[1384]: /usr/lib/tmpfiles.d/systemd-flatcar.conf:6: Duplicate line for path "/var/log/journal", ignoring. May 14 18:08:14.850898 systemd-tmpfiles[1384]: /usr/lib/tmpfiles.d/systemd.conf:29: Duplicate line for path "/var/lib/systemd", ignoring. May 14 18:08:14.851113 systemd-tmpfiles[1384]: ACLs are not supported, ignoring. May 14 18:08:14.851173 systemd-tmpfiles[1384]: ACLs are not supported, ignoring. May 14 18:08:14.853170 kernel: mousedev: PS/2 mouse device common for all mice May 14 18:08:14.859150 kernel: hv_vmbus: registering driver hv_balloon May 14 18:08:14.859218 systemd-tmpfiles[1384]: Detected autofs mount point /boot during canonicalization of boot. May 14 18:08:14.859225 systemd-tmpfiles[1384]: Skipping /boot May 14 18:08:14.860179 kernel: hv_balloon: Using Dynamic Memory protocol version 2.0 May 14 18:08:14.864631 systemd-tmpfiles[1384]: Detected autofs mount point /boot during canonicalization of boot. May 14 18:08:14.864641 systemd-tmpfiles[1384]: Skipping /boot May 14 18:08:14.946478 systemd[1]: Starting systemd-userdbd.service - User Database Manager... May 14 18:08:14.965166 systemd[1]: Starting systemd-vconsole-setup.service - Virtual Console Setup... May 14 18:08:14.967041 systemd[1]: Reload requested from client PID 1383 ('systemctl') (unit ensure-sysext.service)... May 14 18:08:14.967056 systemd[1]: Reloading... May 14 18:08:15.065470 zram_generator::config[1452]: No configuration found. May 14 18:08:15.241425 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. May 14 18:08:15.246143 kernel: kvm_intel: Using Hyper-V Enlightened VMCS May 14 18:08:15.313019 systemd[1]: Reloading finished in 345 ms. May 14 18:08:15.351199 systemd[1]: Started systemd-userdbd.service - User Database Manager. May 14 18:08:15.367994 systemd[1]: Finished systemd-tmpfiles-setup.service - Create System Files and Directories. May 14 18:08:15.379655 systemd[1]: proc-xen.mount - /proc/xen was skipped because of an unmet condition check (ConditionVirtualization=xen). May 14 18:08:15.380736 systemd[1]: Starting audit-rules.service - Load Audit Rules... May 14 18:08:15.383380 systemd[1]: Starting clean-ca-certificates.service - Clean up broken links in /etc/ssl/certs... May 14 18:08:15.385818 systemd[1]: ignition-delete-config.service - Ignition (delete config) was skipped because no trigger condition checks were met. May 14 18:08:15.393579 systemd[1]: Starting modprobe@dm_mod.service - Load Kernel Module dm_mod... May 14 18:08:15.396393 systemd[1]: Starting modprobe@efi_pstore.service - Load Kernel Module efi_pstore... May 14 18:08:15.399522 systemd[1]: Starting modprobe@loop.service - Load Kernel Module loop... May 14 18:08:15.401808 systemd[1]: systemd-binfmt.service - Set Up Additional Binary Formats was skipped because no trigger condition checks were met. May 14 18:08:15.402105 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). May 14 18:08:15.403371 systemd[1]: Starting systemd-journal-catalog-update.service - Rebuild Journal Catalog... May 14 18:08:15.409453 systemd[1]: Starting systemd-resolved.service - Network Name Resolution... May 14 18:08:15.414077 systemd[1]: Starting systemd-update-utmp.service - Record System Boot/Shutdown in UTMP... May 14 18:08:15.417674 systemd[1]: xenserver-pv-version.service - Set fake PV driver version for XenServer was skipped because of an unmet condition check (ConditionVirtualization=xen). May 14 18:08:15.420849 systemd[1]: systemd-vconsole-setup.service: Deactivated successfully. May 14 18:08:15.421093 systemd[1]: Stopped systemd-vconsole-setup.service - Virtual Console Setup. May 14 18:08:15.425102 systemd[1]: run-credentials-systemd\x2dvconsole\x2dsetup.service.mount: Deactivated successfully. May 14 18:08:15.425700 systemd[1]: modprobe@dm_mod.service: Deactivated successfully. May 14 18:08:15.425826 systemd[1]: Finished modprobe@dm_mod.service - Load Kernel Module dm_mod. May 14 18:08:15.428554 systemd[1]: modprobe@efi_pstore.service: Deactivated successfully. May 14 18:08:15.428667 systemd[1]: Finished modprobe@efi_pstore.service - Load Kernel Module efi_pstore. May 14 18:08:15.430443 systemd[1]: modprobe@loop.service: Deactivated successfully. May 14 18:08:15.430561 systemd[1]: Finished modprobe@loop.service - Load Kernel Module loop. May 14 18:08:15.440384 systemd[1]: Finished ensure-sysext.service. May 14 18:08:15.444481 systemd[1]: proc-xen.mount - /proc/xen was skipped because of an unmet condition check (ConditionVirtualization=xen). May 14 18:08:15.444639 systemd[1]: ignition-delete-config.service - Ignition (delete config) was skipped because no trigger condition checks were met. May 14 18:08:15.446339 systemd[1]: Starting modprobe@dm_mod.service - Load Kernel Module dm_mod... May 14 18:08:15.450235 systemd[1]: Starting modprobe@drm.service - Load Kernel Module drm... May 14 18:08:15.456703 systemd[1]: Starting modprobe@efi_pstore.service - Load Kernel Module efi_pstore... May 14 18:08:15.461310 systemd[1]: Starting modprobe@loop.service - Load Kernel Module loop... May 14 18:08:15.463422 systemd[1]: systemd-binfmt.service - Set Up Additional Binary Formats was skipped because no trigger condition checks were met. May 14 18:08:15.463525 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). May 14 18:08:15.463627 systemd[1]: Reached target time-set.target - System Time Set. May 14 18:08:15.468986 systemd[1]: Starting systemd-vconsole-setup.service - Virtual Console Setup... May 14 18:08:15.471052 systemd[1]: xenserver-pv-version.service - Set fake PV driver version for XenServer was skipped because of an unmet condition check (ConditionVirtualization=xen). May 14 18:08:15.472366 systemd[1]: modprobe@dm_mod.service: Deactivated successfully. May 14 18:08:15.472497 systemd[1]: Finished modprobe@dm_mod.service - Load Kernel Module dm_mod. May 14 18:08:15.476425 systemd[1]: modprobe@drm.service: Deactivated successfully. May 14 18:08:15.476563 systemd[1]: Finished modprobe@drm.service - Load Kernel Module drm. May 14 18:08:15.479388 systemd[1]: modprobe@efi_pstore.service: Deactivated successfully. May 14 18:08:15.480162 systemd[1]: Finished modprobe@efi_pstore.service - Load Kernel Module efi_pstore. May 14 18:08:15.483004 systemd[1]: modprobe@loop.service: Deactivated successfully. May 14 18:08:15.483262 systemd[1]: Finished modprobe@loop.service - Load Kernel Module loop. May 14 18:08:15.487031 systemd[1]: systemd-pstore.service - Platform Persistent Storage Archival was skipped because of an unmet condition check (ConditionDirectoryNotEmpty=/sys/fs/pstore). May 14 18:08:15.487113 systemd[1]: systemd-repart.service - Repartition Root Disk was skipped because no trigger condition checks were met. May 14 18:08:15.556183 systemd[1]: Finished systemd-update-utmp.service - Record System Boot/Shutdown in UTMP. May 14 18:08:15.567080 systemd[1]: Finished systemd-journal-catalog-update.service - Rebuild Journal Catalog. May 14 18:08:15.643536 systemd-resolved[1525]: Positive Trust Anchors: May 14 18:08:15.643546 systemd-resolved[1525]: . IN DS 20326 8 2 e06d44b80b8f1d39a95c0b0d7c65d08458e880409bbc683457104237c7f8ec8d May 14 18:08:15.643578 systemd-resolved[1525]: 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 May 14 18:08:15.647159 systemd-resolved[1525]: Using system hostname 'ci-4334.0.0-a-ec82bf957b'. May 14 18:08:15.648470 systemd[1]: Started systemd-resolved.service - Network Name Resolution. May 14 18:08:15.648889 systemd[1]: Reached target nss-lookup.target - Host and Network Name Lookups. May 14 18:08:15.693018 systemd-networkd[1357]: lo: Link UP May 14 18:08:15.693026 systemd-networkd[1357]: lo: Gained carrier May 14 18:08:15.696735 systemd-networkd[1357]: Enumeration completed May 14 18:08:15.696809 systemd[1]: Started systemd-networkd.service - Network Configuration. May 14 18:08:15.697350 systemd[1]: Reached target network.target - Network. May 14 18:08:15.699854 systemd-networkd[1357]: eth0: found matching network '/usr/lib/systemd/network/zz-default.network', based on potentially unpredictable interface name. May 14 18:08:15.699857 systemd-networkd[1357]: eth0: Configuring with /usr/lib/systemd/network/zz-default.network. May 14 18:08:15.701202 systemd[1]: Starting systemd-networkd-persistent-storage.service - Enable Persistent Storage in systemd-networkd... May 14 18:08:15.706172 kernel: mana 7870:00:00.0 enP30832s1: Configured vPort 0 PD 18 DB 16 May 14 18:08:15.703796 systemd[1]: Starting systemd-networkd-wait-online.service - Wait for Network to be Configured... May 14 18:08:15.708152 kernel: mana 7870:00:00.0 enP30832s1: Configured steering vPort 0 entries 64 May 14 18:08:15.710195 kernel: hv_netvsc f8615163-0000-1000-2000-6045bde03002 eth0: Data path switched to VF: enP30832s1 May 14 18:08:15.710720 systemd-networkd[1357]: enP30832s1: Link UP May 14 18:08:15.710778 systemd-networkd[1357]: eth0: Link UP May 14 18:08:15.710781 systemd-networkd[1357]: eth0: Gained carrier May 14 18:08:15.710794 systemd-networkd[1357]: eth0: found matching network '/usr/lib/systemd/network/zz-default.network', based on potentially unpredictable interface name. May 14 18:08:15.720929 systemd-networkd[1357]: enP30832s1: Gained carrier May 14 18:08:15.731167 systemd-networkd[1357]: eth0: DHCPv4 address 10.200.8.19/24, gateway 10.200.8.1 acquired from 168.63.129.16 May 14 18:08:15.842417 systemd[1]: Found device dev-disk-by\x2dlabel-OEM.device - MSFT NVMe Accelerator v1.0 OEM. May 14 18:08:15.843717 systemd[1]: Starting systemd-fsck@dev-disk-by\x2dlabel-OEM.service - File System Check on /dev/disk/by-label/OEM... May 14 18:08:16.105245 systemd[1]: Finished systemd-fsck@dev-disk-by\x2dlabel-OEM.service - File System Check on /dev/disk/by-label/OEM. May 14 18:08:16.107868 systemd[1]: Finished systemd-networkd-persistent-storage.service - Enable Persistent Storage in systemd-networkd. May 14 18:08:16.299403 augenrules[1583]: No rules May 14 18:08:16.300221 systemd[1]: audit-rules.service: Deactivated successfully. May 14 18:08:16.300425 systemd[1]: Finished audit-rules.service - Load Audit Rules. May 14 18:08:16.855089 systemd[1]: Finished systemd-vconsole-setup.service - Virtual Console Setup. May 14 18:08:17.277320 systemd[1]: Finished clean-ca-certificates.service - Clean up broken links in /etc/ssl/certs. May 14 18:08:17.280351 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). May 14 18:08:17.386309 systemd-networkd[1357]: eth0: Gained IPv6LL May 14 18:08:17.388545 systemd[1]: Finished systemd-networkd-wait-online.service - Wait for Network to be Configured. May 14 18:08:17.390901 systemd[1]: Reached target network-online.target - Network is Online. May 14 18:08:17.642357 systemd-networkd[1357]: enP30832s1: Gained IPv6LL May 14 18:08:20.292330 ldconfig[1315]: /sbin/ldconfig: /usr/lib/ld.so.conf is not an ELF file - it has the wrong magic bytes at the start. May 14 18:08:20.302947 systemd[1]: Finished ldconfig.service - Rebuild Dynamic Linker Cache. May 14 18:08:20.308281 systemd[1]: Starting systemd-update-done.service - Update is Completed... May 14 18:08:20.330813 systemd[1]: Finished systemd-update-done.service - Update is Completed. May 14 18:08:20.334361 systemd[1]: Reached target sysinit.target - System Initialization. May 14 18:08:20.335592 systemd[1]: Started motdgen.path - Watch for update engine configuration changes. May 14 18:08:20.336923 systemd[1]: Started user-cloudinit@var-lib-flatcar\x2dinstall-user_data.path - Watch for a cloud-config at /var/lib/flatcar-install/user_data. May 14 18:08:20.338379 systemd[1]: Started google-oslogin-cache.timer - NSS cache refresh timer. May 14 18:08:20.339754 systemd[1]: Started logrotate.timer - Daily rotation of log files. May 14 18:08:20.342236 systemd[1]: Started mdadm.timer - Weekly check for MD array's redundancy information.. May 14 18:08:20.345196 systemd[1]: Started systemd-tmpfiles-clean.timer - Daily Cleanup of Temporary Directories. May 14 18:08:20.348169 systemd[1]: update-engine-stub.timer - Update Engine Stub Timer was skipped because of an unmet condition check (ConditionPathExists=/usr/.noupdate). May 14 18:08:20.348202 systemd[1]: Reached target paths.target - Path Units. May 14 18:08:20.349299 systemd[1]: Reached target timers.target - Timer Units. May 14 18:08:20.350820 systemd[1]: Listening on dbus.socket - D-Bus System Message Bus Socket. May 14 18:08:20.353964 systemd[1]: Starting docker.socket - Docker Socket for the API... May 14 18:08:20.358852 systemd[1]: Listening on sshd-unix-local.socket - OpenSSH Server Socket (systemd-ssh-generator, AF_UNIX Local). May 14 18:08:20.360695 systemd[1]: Listening on sshd-vsock.socket - OpenSSH Server Socket (systemd-ssh-generator, AF_VSOCK). May 14 18:08:20.362354 systemd[1]: Reached target ssh-access.target - SSH Access Available. May 14 18:08:20.365272 systemd[1]: Listening on sshd.socket - OpenSSH Server Socket. May 14 18:08:20.367081 systemd[1]: Listening on systemd-hostnamed.socket - Hostname Service Socket. May 14 18:08:20.368995 systemd[1]: Listening on docker.socket - Docker Socket for the API. May 14 18:08:20.372773 systemd[1]: Reached target sockets.target - Socket Units. May 14 18:08:20.374177 systemd[1]: Reached target basic.target - Basic System. May 14 18:08:20.375242 systemd[1]: addon-config@oem.service - Configure Addon /oem was skipped because no trigger condition checks were met. May 14 18:08:20.375264 systemd[1]: addon-run@oem.service - Run Addon /oem was skipped because no trigger condition checks were met. May 14 18:08:20.376981 systemd[1]: Starting chronyd.service - NTP client/server... May 14 18:08:20.380418 systemd[1]: Starting containerd.service - containerd container runtime... May 14 18:08:20.384948 systemd[1]: Starting coreos-metadata.service - Flatcar Metadata Agent... May 14 18:08:20.389257 systemd[1]: Starting dbus.service - D-Bus System Message Bus... May 14 18:08:20.393779 systemd[1]: Starting dracut-shutdown.service - Restore /run/initramfs on shutdown... May 14 18:08:20.398224 systemd[1]: Starting enable-oem-cloudinit.service - Enable cloudinit... May 14 18:08:20.400754 systemd[1]: Starting extend-filesystems.service - Extend Filesystems... May 14 18:08:20.402320 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). May 14 18:08:20.404572 systemd[1]: Starting google-oslogin-cache.service - NSS cache refresh... May 14 18:08:20.411828 systemd[1]: Starting motdgen.service - Generate /run/flatcar/motd... May 14 18:08:20.416287 systemd[1]: Starting nvidia.service - NVIDIA Configure Service... May 14 18:08:20.419642 jq[1604]: false May 14 18:08:20.421271 systemd[1]: Starting ssh-key-proc-cmdline.service - Install an ssh key from /proc/cmdline... May 14 18:08:20.424741 systemd[1]: Starting sshd-keygen.service - Generate sshd host keys... May 14 18:08:20.431693 systemd[1]: Starting systemd-logind.service - User Login Management... May 14 18:08:20.434201 systemd[1]: tcsd.service - TCG Core Services Daemon was skipped because of an unmet condition check (ConditionPathExists=/dev/tpm0). May 14 18:08:20.436589 systemd[1]: cgroup compatibility translation between legacy and unified hierarchy settings activated. See cgroup-compat debug messages for details. May 14 18:08:20.439864 systemd[1]: Starting update-engine.service - Update Engine... May 14 18:08:20.445270 systemd[1]: Starting update-ssh-keys-after-ignition.service - Run update-ssh-keys once after Ignition... May 14 18:08:20.450512 systemd[1]: enable-oem-cloudinit.service: Skipped due to 'exec-condition'. May 14 18:08:20.450693 systemd[1]: Condition check resulted in enable-oem-cloudinit.service - Enable cloudinit being skipped. May 14 18:08:20.450891 systemd[1]: ssh-key-proc-cmdline.service: Deactivated successfully. May 14 18:08:20.451023 systemd[1]: Finished ssh-key-proc-cmdline.service - Install an ssh key from /proc/cmdline. May 14 18:08:20.464214 jq[1619]: true May 14 18:08:20.472587 (chronyd)[1599]: chronyd.service: Referenced but unset environment variable evaluates to an empty string: OPTIONS May 14 18:08:20.478039 jq[1628]: true May 14 18:08:20.554913 systemd[1]: Finished dracut-shutdown.service - Restore /run/initramfs on shutdown. May 14 18:08:20.564396 (ntainerd)[1647]: containerd.service: Referenced but unset environment variable evaluates to an empty string: TORCX_IMAGEDIR, TORCX_UNPACKDIR May 14 18:08:20.565407 extend-filesystems[1608]: Found loop3 May 14 18:08:20.566462 extend-filesystems[1608]: Found loop4 May 14 18:08:20.566462 extend-filesystems[1608]: Found loop5 May 14 18:08:20.566462 extend-filesystems[1608]: Found sr0 May 14 18:08:20.566462 extend-filesystems[1608]: Found nvme0n1 May 14 18:08:20.566462 extend-filesystems[1608]: Found nvme0n1p1 May 14 18:08:20.566462 extend-filesystems[1608]: Found nvme0n1p2 May 14 18:08:20.566462 extend-filesystems[1608]: Found nvme0n1p3 May 14 18:08:20.566462 extend-filesystems[1608]: Found usr May 14 18:08:20.566462 extend-filesystems[1608]: Found nvme0n1p4 May 14 18:08:20.566462 extend-filesystems[1608]: Found nvme0n1p6 May 14 18:08:20.566462 extend-filesystems[1608]: Found nvme0n1p7 May 14 18:08:20.566462 extend-filesystems[1608]: Found nvme0n1p9 May 14 18:08:20.566462 extend-filesystems[1608]: Checking size of /dev/nvme0n1p9 May 14 18:08:20.568615 systemd[1]: motdgen.service: Deactivated successfully. May 14 18:08:20.568750 systemd[1]: Finished motdgen.service - Generate /run/flatcar/motd. May 14 18:08:20.603964 chronyd[1658]: chronyd version 4.6.1 starting (+CMDMON +NTP +REFCLOCK +RTC +PRIVDROP +SCFILTER -SIGND +ASYNCDNS +NTS +SECHASH +IPV6 -DEBUG) May 14 18:08:20.605617 chronyd[1658]: Timezone right/UTC failed leap second check, ignoring May 14 18:08:20.605852 chronyd[1658]: Loaded seccomp filter (level 2) May 14 18:08:20.606839 systemd[1]: Started chronyd.service - NTP client/server. May 14 18:08:20.650416 google_oslogin_nss_cache[1609]: oslogin_cache_refresh[1609]: Refreshing passwd entry cache May 14 18:08:20.650420 oslogin_cache_refresh[1609]: Refreshing passwd entry cache May 14 18:08:20.656934 systemd[1]: Finished nvidia.service - NVIDIA Configure Service. May 14 18:08:20.676640 google_oslogin_nss_cache[1609]: oslogin_cache_refresh[1609]: Failure getting users, quitting May 14 18:08:20.676632 oslogin_cache_refresh[1609]: Failure getting users, quitting May 14 18:08:20.676723 google_oslogin_nss_cache[1609]: oslogin_cache_refresh[1609]: Produced empty passwd cache file, removing /etc/oslogin_passwd.cache.bak. May 14 18:08:20.676723 google_oslogin_nss_cache[1609]: oslogin_cache_refresh[1609]: Refreshing group entry cache May 14 18:08:20.676647 oslogin_cache_refresh[1609]: Produced empty passwd cache file, removing /etc/oslogin_passwd.cache.bak. May 14 18:08:20.676680 oslogin_cache_refresh[1609]: Refreshing group entry cache May 14 18:08:20.684049 google_oslogin_nss_cache[1609]: oslogin_cache_refresh[1609]: Failure getting groups, quitting May 14 18:08:20.684049 google_oslogin_nss_cache[1609]: oslogin_cache_refresh[1609]: Produced empty group cache file, removing /etc/oslogin_group.cache.bak. May 14 18:08:20.684040 oslogin_cache_refresh[1609]: Failure getting groups, quitting May 14 18:08:20.684047 oslogin_cache_refresh[1609]: Produced empty group cache file, removing /etc/oslogin_group.cache.bak. May 14 18:08:20.685005 systemd[1]: google-oslogin-cache.service: Deactivated successfully. May 14 18:08:20.685225 systemd[1]: Finished google-oslogin-cache.service - NSS cache refresh. May 14 18:08:20.780380 update_engine[1615]: I20250514 18:08:20.780320 1615 main.cc:92] Flatcar Update Engine starting May 14 18:08:20.798016 systemd-logind[1614]: New seat seat0. May 14 18:08:21.143451 systemd-logind[1614]: Watching system buttons on /dev/input/event0 (AT Translated Set 2 keyboard) May 14 18:08:21.143973 systemd[1]: Started systemd-logind.service - User Login Management. May 14 18:08:21.152053 extend-filesystems[1608]: Old size kept for /dev/nvme0n1p9 May 14 18:08:21.151881 systemd[1]: extend-filesystems.service: Deactivated successfully. May 14 18:08:21.152057 systemd[1]: Finished extend-filesystems.service - Extend Filesystems. May 14 18:08:21.202909 dbus-daemon[1602]: [system] SELinux support is enabled May 14 18:08:21.203296 systemd[1]: Started dbus.service - D-Bus System Message Bus. May 14 18:08:21.206992 update_engine[1615]: I20250514 18:08:21.206643 1615 update_check_scheduler.cc:74] Next update check in 3m38s May 14 18:08:21.209272 bash[1645]: Updated "/home/core/.ssh/authorized_keys" May 14 18:08:21.210311 systemd[1]: Finished update-ssh-keys-after-ignition.service - Run update-ssh-keys once after Ignition. May 14 18:08:21.213940 systemd[1]: sshkeys.service was skipped because no trigger condition checks were met. May 14 18:08:21.214002 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). May 14 18:08:21.214023 systemd[1]: Reached target system-config.target - Load system-provided cloud configs. May 14 18:08:21.217040 dbus-daemon[1602]: [system] Successfully activated service 'org.freedesktop.systemd1' May 14 18:08:21.218238 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). May 14 18:08:21.218260 systemd[1]: Reached target user-config.target - Load user-provided cloud configs. May 14 18:08:21.234087 systemd[1]: Started update-engine.service - Update Engine. May 14 18:08:21.240353 systemd[1]: Started locksmithd.service - Cluster reboot manager. May 14 18:08:21.256835 coreos-metadata[1601]: May 14 18:08:21.256 INFO Fetching http://168.63.129.16/?comp=versions: Attempt #1 May 14 18:08:21.259495 coreos-metadata[1601]: May 14 18:08:21.259 INFO Fetch successful May 14 18:08:21.259495 coreos-metadata[1601]: May 14 18:08:21.259 INFO Fetching http://168.63.129.16/machine/?comp=goalstate: Attempt #1 May 14 18:08:21.262337 coreos-metadata[1601]: May 14 18:08:21.262 INFO Fetch successful May 14 18:08:21.262737 coreos-metadata[1601]: May 14 18:08:21.262 INFO Fetching http://168.63.129.16/machine/fd412938-6526-416d-9ca6-d993bc6e2e67/0ede0f23%2D9a78%2D493f%2Daf4b%2D8e92d46266f6.%5Fci%2D4334.0.0%2Da%2Dec82bf957b?comp=config&type=sharedConfig&incarnation=1: Attempt #1 May 14 18:08:21.263848 coreos-metadata[1601]: May 14 18:08:21.263 INFO Fetch successful May 14 18:08:21.264102 coreos-metadata[1601]: May 14 18:08:21.264 INFO Fetching http://169.254.169.254/metadata/instance/compute/vmSize?api-version=2017-08-01&format=text: Attempt #1 May 14 18:08:21.270516 coreos-metadata[1601]: May 14 18:08:21.270 INFO Fetch successful May 14 18:08:21.301047 systemd[1]: Finished coreos-metadata.service - Flatcar Metadata Agent. May 14 18:08:21.304483 systemd[1]: packet-phone-home.service - Report Success to Packet was skipped because no trigger condition checks were met. May 14 18:08:21.329157 sshd_keygen[1629]: ssh-keygen: generating new host keys: RSA ECDSA ED25519 May 14 18:08:21.344258 systemd[1]: Finished sshd-keygen.service - Generate sshd host keys. May 14 18:08:21.348871 systemd[1]: Starting issuegen.service - Generate /run/issue... May 14 18:08:21.351853 systemd[1]: Starting waagent.service - Microsoft Azure Linux Agent... May 14 18:08:21.362781 systemd[1]: issuegen.service: Deactivated successfully. May 14 18:08:21.363067 systemd[1]: Finished issuegen.service - Generate /run/issue. May 14 18:08:21.366945 systemd[1]: Starting systemd-user-sessions.service - Permit User Sessions... May 14 18:08:21.387095 systemd[1]: Started waagent.service - Microsoft Azure Linux Agent. May 14 18:08:21.394418 systemd[1]: Finished systemd-user-sessions.service - Permit User Sessions. May 14 18:08:21.399796 systemd[1]: Started getty@tty1.service - Getty on tty1. May 14 18:08:21.403384 systemd[1]: Started serial-getty@ttyS0.service - Serial Getty on ttyS0. May 14 18:08:21.406014 systemd[1]: Reached target getty.target - Login Prompts. May 14 18:08:21.819180 locksmithd[1690]: locksmithd starting currentOperation="UPDATE_STATUS_IDLE" strategy="reboot" May 14 18:08:22.346853 containerd[1647]: time="2025-05-14T18:08:22Z" level=warning msg="Ignoring unknown key in TOML" column=1 error="strict mode: fields in the document are missing in the target struct" file=/usr/share/containerd/config.toml key=subreaper row=8 May 14 18:08:22.347613 containerd[1647]: time="2025-05-14T18:08:22.347568185Z" level=info msg="starting containerd" revision=06b99ca80cdbfbc6cc8bd567021738c9af2b36ce version=v2.0.4 May 14 18:08:22.354573 containerd[1647]: time="2025-05-14T18:08:22.354543669Z" level=warning msg="Configuration migrated from version 2, use `containerd config migrate` to avoid migration" t="6.927µs" May 14 18:08:22.354573 containerd[1647]: time="2025-05-14T18:08:22.354565869Z" level=info msg="loading plugin" id=io.containerd.image-verifier.v1.bindir type=io.containerd.image-verifier.v1 May 14 18:08:22.354658 containerd[1647]: time="2025-05-14T18:08:22.354582560Z" level=info msg="loading plugin" id=io.containerd.internal.v1.opt type=io.containerd.internal.v1 May 14 18:08:22.354719 containerd[1647]: time="2025-05-14T18:08:22.354704778Z" level=info msg="loading plugin" id=io.containerd.warning.v1.deprecations type=io.containerd.warning.v1 May 14 18:08:22.354746 containerd[1647]: time="2025-05-14T18:08:22.354718065Z" level=info msg="loading plugin" id=io.containerd.content.v1.content type=io.containerd.content.v1 May 14 18:08:22.354746 containerd[1647]: time="2025-05-14T18:08:22.354737221Z" level=info msg="loading plugin" id=io.containerd.snapshotter.v1.blockfile type=io.containerd.snapshotter.v1 May 14 18:08:22.354804 containerd[1647]: time="2025-05-14T18:08:22.354778937Z" level=info msg="skip loading plugin" error="no scratch file generator: skip plugin" id=io.containerd.snapshotter.v1.blockfile type=io.containerd.snapshotter.v1 May 14 18:08:22.354804 containerd[1647]: time="2025-05-14T18:08:22.354801263Z" level=info msg="loading plugin" id=io.containerd.snapshotter.v1.btrfs type=io.containerd.snapshotter.v1 May 14 18:08:22.354978 containerd[1647]: time="2025-05-14T18:08:22.354963496Z" level=info msg="skip loading plugin" error="path /var/lib/containerd/io.containerd.snapshotter.v1.btrfs (ext4) must be a btrfs filesystem to be used with the btrfs snapshotter: skip plugin" id=io.containerd.snapshotter.v1.btrfs type=io.containerd.snapshotter.v1 May 14 18:08:22.354978 containerd[1647]: time="2025-05-14T18:08:22.354973545Z" level=info msg="loading plugin" id=io.containerd.snapshotter.v1.devmapper type=io.containerd.snapshotter.v1 May 14 18:08:22.355026 containerd[1647]: time="2025-05-14T18:08:22.354984959Z" level=info msg="skip loading plugin" error="devmapper not configured: skip plugin" id=io.containerd.snapshotter.v1.devmapper type=io.containerd.snapshotter.v1 May 14 18:08:22.355026 containerd[1647]: time="2025-05-14T18:08:22.354991841Z" level=info msg="loading plugin" id=io.containerd.snapshotter.v1.native type=io.containerd.snapshotter.v1 May 14 18:08:22.355068 containerd[1647]: time="2025-05-14T18:08:22.355040605Z" level=info msg="loading plugin" id=io.containerd.snapshotter.v1.overlayfs type=io.containerd.snapshotter.v1 May 14 18:08:22.355216 containerd[1647]: time="2025-05-14T18:08:22.355203745Z" level=info msg="loading plugin" id=io.containerd.snapshotter.v1.zfs type=io.containerd.snapshotter.v1 May 14 18:08:22.355240 containerd[1647]: time="2025-05-14T18:08:22.355223245Z" level=info msg="skip loading plugin" error="lstat /var/lib/containerd/io.containerd.snapshotter.v1.zfs: no such file or directory: skip plugin" id=io.containerd.snapshotter.v1.zfs type=io.containerd.snapshotter.v1 May 14 18:08:22.355240 containerd[1647]: time="2025-05-14T18:08:22.355231062Z" level=info msg="loading plugin" id=io.containerd.event.v1.exchange type=io.containerd.event.v1 May 14 18:08:22.355280 containerd[1647]: time="2025-05-14T18:08:22.355258229Z" level=info msg="loading plugin" id=io.containerd.monitor.task.v1.cgroups type=io.containerd.monitor.task.v1 May 14 18:08:22.355494 containerd[1647]: time="2025-05-14T18:08:22.355467768Z" level=info msg="loading plugin" id=io.containerd.metadata.v1.bolt type=io.containerd.metadata.v1 May 14 18:08:22.355532 containerd[1647]: time="2025-05-14T18:08:22.355521273Z" level=info msg="metadata content store policy set" policy=shared May 14 18:08:22.695354 containerd[1647]: time="2025-05-14T18:08:22.695272131Z" level=info msg="loading plugin" id=io.containerd.gc.v1.scheduler type=io.containerd.gc.v1 May 14 18:08:22.695354 containerd[1647]: time="2025-05-14T18:08:22.695343475Z" level=info msg="loading plugin" id=io.containerd.differ.v1.walking type=io.containerd.differ.v1 May 14 18:08:22.696236 containerd[1647]: time="2025-05-14T18:08:22.695364804Z" level=info msg="loading plugin" id=io.containerd.lease.v1.manager type=io.containerd.lease.v1 May 14 18:08:22.696236 containerd[1647]: time="2025-05-14T18:08:22.695378273Z" level=info msg="loading plugin" id=io.containerd.service.v1.containers-service type=io.containerd.service.v1 May 14 18:08:22.696236 containerd[1647]: time="2025-05-14T18:08:22.695393554Z" level=info msg="loading plugin" id=io.containerd.service.v1.content-service type=io.containerd.service.v1 May 14 18:08:22.696236 containerd[1647]: time="2025-05-14T18:08:22.695406711Z" level=info msg="loading plugin" id=io.containerd.service.v1.diff-service type=io.containerd.service.v1 May 14 18:08:22.696236 containerd[1647]: time="2025-05-14T18:08:22.695419487Z" level=info msg="loading plugin" id=io.containerd.service.v1.images-service type=io.containerd.service.v1 May 14 18:08:22.696236 containerd[1647]: time="2025-05-14T18:08:22.695434334Z" level=info msg="loading plugin" id=io.containerd.service.v1.introspection-service type=io.containerd.service.v1 May 14 18:08:22.696236 containerd[1647]: time="2025-05-14T18:08:22.695446653Z" level=info msg="loading plugin" id=io.containerd.service.v1.namespaces-service type=io.containerd.service.v1 May 14 18:08:22.696236 containerd[1647]: time="2025-05-14T18:08:22.695462319Z" level=info msg="loading plugin" id=io.containerd.service.v1.snapshots-service type=io.containerd.service.v1 May 14 18:08:22.696236 containerd[1647]: time="2025-05-14T18:08:22.695475118Z" level=info msg="loading plugin" id=io.containerd.shim.v1.manager type=io.containerd.shim.v1 May 14 18:08:22.696236 containerd[1647]: time="2025-05-14T18:08:22.695491020Z" level=info msg="loading plugin" id=io.containerd.runtime.v2.task type=io.containerd.runtime.v2 May 14 18:08:22.696236 containerd[1647]: time="2025-05-14T18:08:22.695614618Z" level=info msg="loading plugin" id=io.containerd.service.v1.tasks-service type=io.containerd.service.v1 May 14 18:08:22.696236 containerd[1647]: time="2025-05-14T18:08:22.695635368Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.containers type=io.containerd.grpc.v1 May 14 18:08:22.696236 containerd[1647]: time="2025-05-14T18:08:22.695654073Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.content type=io.containerd.grpc.v1 May 14 18:08:22.696236 containerd[1647]: time="2025-05-14T18:08:22.695668641Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.diff type=io.containerd.grpc.v1 May 14 18:08:22.696476 containerd[1647]: time="2025-05-14T18:08:22.695682498Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.events type=io.containerd.grpc.v1 May 14 18:08:22.696476 containerd[1647]: time="2025-05-14T18:08:22.695693683Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.images type=io.containerd.grpc.v1 May 14 18:08:22.696476 containerd[1647]: time="2025-05-14T18:08:22.695708893Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.introspection type=io.containerd.grpc.v1 May 14 18:08:22.696476 containerd[1647]: time="2025-05-14T18:08:22.695721605Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.leases type=io.containerd.grpc.v1 May 14 18:08:22.696476 containerd[1647]: time="2025-05-14T18:08:22.695736488Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.namespaces type=io.containerd.grpc.v1 May 14 18:08:22.696476 containerd[1647]: time="2025-05-14T18:08:22.695746852Z" level=info msg="loading plugin" id=io.containerd.sandbox.store.v1.local type=io.containerd.sandbox.store.v1 May 14 18:08:22.696476 containerd[1647]: time="2025-05-14T18:08:22.695760594Z" level=info msg="loading plugin" id=io.containerd.cri.v1.images type=io.containerd.cri.v1 May 14 18:08:22.696476 containerd[1647]: time="2025-05-14T18:08:22.695828802Z" level=info msg="Get image filesystem path \"/var/lib/containerd/io.containerd.snapshotter.v1.overlayfs\" for snapshotter \"overlayfs\"" May 14 18:08:22.696476 containerd[1647]: time="2025-05-14T18:08:22.695840791Z" level=info msg="Start snapshots syncer" May 14 18:08:22.696476 containerd[1647]: time="2025-05-14T18:08:22.695859859Z" level=info msg="loading plugin" id=io.containerd.cri.v1.runtime type=io.containerd.cri.v1 May 14 18:08:22.696674 containerd[1647]: time="2025-05-14T18:08:22.696172996Z" level=info msg="starting cri plugin" config="{\"containerd\":{\"defaultRuntimeName\":\"runc\",\"runtimes\":{\"runc\":{\"runtimeType\":\"io.containerd.runc.v2\",\"runtimePath\":\"\",\"PodAnnotations\":null,\"ContainerAnnotations\":null,\"options\":{\"BinaryName\":\"\",\"CriuImagePath\":\"\",\"CriuWorkPath\":\"\",\"IoGid\":0,\"IoUid\":0,\"NoNewKeyring\":false,\"Root\":\"\",\"ShimCgroup\":\"\",\"SystemdCgroup\":true},\"privileged_without_host_devices\":false,\"privileged_without_host_devices_all_devices_allowed\":false,\"baseRuntimeSpec\":\"\",\"cniConfDir\":\"\",\"cniMaxConfNum\":0,\"snapshotter\":\"\",\"sandboxer\":\"podsandbox\",\"io_type\":\"\"}},\"ignoreBlockIONotEnabledErrors\":false,\"ignoreRdtNotEnabledErrors\":false},\"cni\":{\"binDir\":\"/opt/cni/bin\",\"confDir\":\"/etc/cni/net.d\",\"maxConfNum\":1,\"setupSerially\":false,\"confTemplate\":\"\",\"ipPref\":\"\",\"useInternalLoopback\":false},\"enableSelinux\":true,\"selinuxCategoryRange\":1024,\"maxContainerLogSize\":16384,\"disableApparmor\":false,\"restrictOOMScoreAdj\":false,\"disableProcMount\":false,\"unsetSeccompProfile\":\"\",\"tolerateMissingHugetlbController\":true,\"disableHugetlbController\":true,\"device_ownership_from_security_context\":false,\"ignoreImageDefinedVolumes\":false,\"netnsMountsUnderStateDir\":false,\"enableUnprivilegedPorts\":true,\"enableUnprivilegedICMP\":true,\"enableCDI\":true,\"cdiSpecDirs\":[\"/etc/cdi\",\"/var/run/cdi\"],\"drainExecSyncIOTimeout\":\"0s\",\"ignoreDeprecationWarnings\":null,\"containerdRootDir\":\"/var/lib/containerd\",\"containerdEndpoint\":\"/run/containerd/containerd.sock\",\"rootDir\":\"/var/lib/containerd/io.containerd.grpc.v1.cri\",\"stateDir\":\"/run/containerd/io.containerd.grpc.v1.cri\"}" May 14 18:08:22.696674 containerd[1647]: time="2025-05-14T18:08:22.696226760Z" level=info msg="loading plugin" id=io.containerd.podsandbox.controller.v1.podsandbox type=io.containerd.podsandbox.controller.v1 May 14 18:08:22.696789 containerd[1647]: time="2025-05-14T18:08:22.696764146Z" level=info msg="loading plugin" id=io.containerd.sandbox.controller.v1.shim type=io.containerd.sandbox.controller.v1 May 14 18:08:22.697057 containerd[1647]: time="2025-05-14T18:08:22.697035689Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.sandbox-controllers type=io.containerd.grpc.v1 May 14 18:08:22.697095 containerd[1647]: time="2025-05-14T18:08:22.697067236Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.sandboxes type=io.containerd.grpc.v1 May 14 18:08:22.697095 containerd[1647]: time="2025-05-14T18:08:22.697079106Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.snapshots type=io.containerd.grpc.v1 May 14 18:08:22.697095 containerd[1647]: time="2025-05-14T18:08:22.697089019Z" level=info msg="loading plugin" id=io.containerd.streaming.v1.manager type=io.containerd.streaming.v1 May 14 18:08:22.697156 containerd[1647]: time="2025-05-14T18:08:22.697100864Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.streaming type=io.containerd.grpc.v1 May 14 18:08:22.697156 containerd[1647]: time="2025-05-14T18:08:22.697110678Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.tasks type=io.containerd.grpc.v1 May 14 18:08:22.697156 containerd[1647]: time="2025-05-14T18:08:22.697120737Z" level=info msg="loading plugin" id=io.containerd.transfer.v1.local type=io.containerd.transfer.v1 May 14 18:08:22.697209 containerd[1647]: time="2025-05-14T18:08:22.697157290Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.transfer type=io.containerd.grpc.v1 May 14 18:08:22.697209 containerd[1647]: time="2025-05-14T18:08:22.697168084Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.version type=io.containerd.grpc.v1 May 14 18:08:22.697209 containerd[1647]: time="2025-05-14T18:08:22.697177497Z" level=info msg="loading plugin" id=io.containerd.monitor.container.v1.restart type=io.containerd.monitor.container.v1 May 14 18:08:22.697209 containerd[1647]: time="2025-05-14T18:08:22.697198778Z" level=info msg="loading plugin" id=io.containerd.tracing.processor.v1.otlp type=io.containerd.tracing.processor.v1 May 14 18:08:22.697277 containerd[1647]: time="2025-05-14T18:08:22.697211117Z" level=info msg="skip loading plugin" error="skip plugin: tracing endpoint not configured" id=io.containerd.tracing.processor.v1.otlp type=io.containerd.tracing.processor.v1 May 14 18:08:22.697277 containerd[1647]: time="2025-05-14T18:08:22.697219002Z" level=info msg="loading plugin" id=io.containerd.internal.v1.tracing type=io.containerd.internal.v1 May 14 18:08:22.697277 containerd[1647]: time="2025-05-14T18:08:22.697228103Z" level=info msg="skip loading plugin" error="skip plugin: tracing endpoint not configured" id=io.containerd.internal.v1.tracing type=io.containerd.internal.v1 May 14 18:08:22.697277 containerd[1647]: time="2025-05-14T18:08:22.697236592Z" level=info msg="loading plugin" id=io.containerd.ttrpc.v1.otelttrpc type=io.containerd.ttrpc.v1 May 14 18:08:22.697277 containerd[1647]: time="2025-05-14T18:08:22.697245198Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.healthcheck type=io.containerd.grpc.v1 May 14 18:08:22.697277 containerd[1647]: time="2025-05-14T18:08:22.697253960Z" level=info msg="loading plugin" id=io.containerd.nri.v1.nri type=io.containerd.nri.v1 May 14 18:08:22.697277 containerd[1647]: time="2025-05-14T18:08:22.697268183Z" level=info msg="runtime interface created" May 14 18:08:22.697277 containerd[1647]: time="2025-05-14T18:08:22.697273082Z" level=info msg="created NRI interface" May 14 18:08:22.697405 containerd[1647]: time="2025-05-14T18:08:22.697280534Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.cri type=io.containerd.grpc.v1 May 14 18:08:22.697405 containerd[1647]: time="2025-05-14T18:08:22.697292776Z" level=info msg="Connect containerd service" May 14 18:08:22.697405 containerd[1647]: time="2025-05-14T18:08:22.697320385Z" level=info msg="using experimental NRI integration - disable nri plugin to prevent this" May 14 18:08:22.697901 containerd[1647]: time="2025-05-14T18:08:22.697873516Z" 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" May 14 18:08:23.536464 containerd[1647]: time="2025-05-14T18:08:23.536296555Z" level=info msg="Start subscribing containerd event" May 14 18:08:23.536464 containerd[1647]: time="2025-05-14T18:08:23.536348262Z" level=info msg="Start recovering state" May 14 18:08:23.536464 containerd[1647]: time="2025-05-14T18:08:23.536468387Z" level=info msg=serving... address=/run/containerd/containerd.sock.ttrpc May 14 18:08:23.536903 containerd[1647]: time="2025-05-14T18:08:23.536507671Z" level=info msg="Start event monitor" May 14 18:08:23.536903 containerd[1647]: time="2025-05-14T18:08:23.536521412Z" level=info msg="Start cni network conf syncer for default" May 14 18:08:23.536903 containerd[1647]: time="2025-05-14T18:08:23.536528248Z" level=info msg="Start streaming server" May 14 18:08:23.536903 containerd[1647]: time="2025-05-14T18:08:23.536539892Z" level=info msg="Registered namespace \"k8s.io\" with NRI" May 14 18:08:23.536903 containerd[1647]: time="2025-05-14T18:08:23.536546299Z" level=info msg="runtime interface starting up..." May 14 18:08:23.536903 containerd[1647]: time="2025-05-14T18:08:23.536551326Z" level=info msg="starting plugins..." May 14 18:08:23.536903 containerd[1647]: time="2025-05-14T18:08:23.536564329Z" level=info msg="Synchronizing NRI (plugin) with current runtime state" May 14 18:08:23.536903 containerd[1647]: time="2025-05-14T18:08:23.536660146Z" level=info msg=serving... address=/run/containerd/containerd.sock May 14 18:08:23.536801 systemd[1]: Started containerd.service - containerd container runtime. May 14 18:08:23.538578 containerd[1647]: time="2025-05-14T18:08:23.538511054Z" level=info msg="containerd successfully booted in 1.192038s" May 14 18:08:23.539632 systemd[1]: Reached target multi-user.target - Multi-User System. May 14 18:08:23.542193 systemd[1]: Startup finished in 2.907s (kernel) + 9.881s (initrd) + 16.396s (userspace) = 29.185s. May 14 18:08:23.667581 waagent[1716]: 2025-05-14T18:08:23.667523Z INFO Daemon Daemon Azure Linux Agent Version: 2.12.0.4 May 14 18:08:23.669044 waagent[1716]: 2025-05-14T18:08:23.669003Z INFO Daemon Daemon OS: flatcar 4334.0.0 May 14 18:08:23.669772 waagent[1716]: 2025-05-14T18:08:23.669604Z INFO Daemon Daemon Python: 3.11.12 May 14 18:08:23.671215 waagent[1716]: 2025-05-14T18:08:23.670971Z INFO Daemon Daemon Run daemon May 14 18:08:23.672119 waagent[1716]: 2025-05-14T18:08:23.672079Z INFO Daemon Daemon No RDMA handler exists for distro='Flatcar Container Linux by Kinvolk' version='4334.0.0' May 14 18:08:23.674396 waagent[1716]: 2025-05-14T18:08:23.674365Z INFO Daemon Daemon Using waagent for provisioning May 14 18:08:23.675463 waagent[1716]: 2025-05-14T18:08:23.675438Z INFO Daemon Daemon Activate resource disk May 14 18:08:23.676387 waagent[1716]: 2025-05-14T18:08:23.676361Z INFO Daemon Daemon Searching gen1 prefix 00000000-0001 or gen2 f8b3781a-1e82-4818-a1c3-63d806ec15bb May 14 18:08:23.678934 waagent[1716]: 2025-05-14T18:08:23.678897Z INFO Daemon Daemon Found device: None May 14 18:08:23.679919 waagent[1716]: 2025-05-14T18:08:23.679890Z ERROR Daemon Daemon Failed to mount resource disk [ResourceDiskError] unable to detect disk topology May 14 18:08:23.681467 waagent[1716]: 2025-05-14T18:08:23.680605Z ERROR Daemon Daemon Event: name=WALinuxAgent, op=ActivateResourceDisk, message=[ResourceDiskError] unable to detect disk topology, duration=0 May 14 18:08:23.684042 waagent[1716]: 2025-05-14T18:08:23.684006Z INFO Daemon Daemon Clean protocol and wireserver endpoint May 14 18:08:23.685658 waagent[1716]: 2025-05-14T18:08:23.685631Z INFO Daemon Daemon Running default provisioning handler May 14 18:08:23.691288 waagent[1716]: 2025-05-14T18:08:23.691084Z 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. May 14 18:08:23.693352 waagent[1716]: 2025-05-14T18:08:23.692226Z INFO Daemon Daemon Unable to get cloud-init enabled status from service: [Errno 2] No such file or directory: 'service' May 14 18:08:23.693352 waagent[1716]: 2025-05-14T18:08:23.692490Z INFO Daemon Daemon cloud-init is enabled: False May 14 18:08:23.693352 waagent[1716]: 2025-05-14T18:08:23.692787Z INFO Daemon Daemon Copying ovf-env.xml May 14 18:08:23.740390 waagent[1716]: 2025-05-14T18:08:23.740348Z INFO Daemon Daemon Successfully mounted dvd May 14 18:08:23.749914 systemd[1]: mnt-cdrom-secure.mount: Deactivated successfully. May 14 18:08:23.750875 waagent[1716]: 2025-05-14T18:08:23.750828Z INFO Daemon Daemon Detect protocol endpoint May 14 18:08:23.756378 waagent[1716]: 2025-05-14T18:08:23.751627Z INFO Daemon Daemon Clean protocol and wireserver endpoint May 14 18:08:23.756378 waagent[1716]: 2025-05-14T18:08:23.751914Z INFO Daemon Daemon WireServer endpoint is not found. Rerun dhcp handler May 14 18:08:23.756378 waagent[1716]: 2025-05-14T18:08:23.752171Z INFO Daemon Daemon Test for route to 168.63.129.16 May 14 18:08:23.756378 waagent[1716]: 2025-05-14T18:08:23.752312Z INFO Daemon Daemon Route to 168.63.129.16 exists May 14 18:08:23.756378 waagent[1716]: 2025-05-14T18:08:23.752510Z INFO Daemon Daemon Wire server endpoint:168.63.129.16 May 14 18:08:23.762731 waagent[1716]: 2025-05-14T18:08:23.762644Z INFO Daemon Daemon Fabric preferred wire protocol version:2015-04-05 May 14 18:08:23.764524 waagent[1716]: 2025-05-14T18:08:23.763340Z INFO Daemon Daemon Wire protocol version:2012-11-30 May 14 18:08:23.764524 waagent[1716]: 2025-05-14T18:08:23.763808Z INFO Daemon Daemon Server preferred version:2015-04-05 May 14 18:08:23.764259 login[1718]: pam_unix(login:session): session opened for user core(uid=500) by LOGIN(uid=0) May 14 18:08:23.766202 login[1719]: pam_unix(login:session): session opened for user core(uid=500) by LOGIN(uid=0) May 14 18:08:23.771723 systemd[1]: Created slice user-500.slice - User Slice of UID 500. May 14 18:08:23.772528 systemd[1]: Starting user-runtime-dir@500.service - User Runtime Directory /run/user/500... May 14 18:08:23.778891 systemd-logind[1614]: New session 1 of user core. May 14 18:08:23.782500 systemd-logind[1614]: New session 2 of user core. May 14 18:08:23.789346 systemd[1]: Finished user-runtime-dir@500.service - User Runtime Directory /run/user/500. May 14 18:08:23.791260 systemd[1]: Starting user@500.service - User Manager for UID 500... May 14 18:08:23.800543 (systemd)[1759]: pam_unix(systemd-user:session): session opened for user core(uid=500) by (uid=0) May 14 18:08:23.802450 systemd-logind[1614]: New session c1 of user core. May 14 18:08:23.888411 waagent[1716]: 2025-05-14T18:08:23.887575Z INFO Daemon Daemon Initializing goal state during protocol detection May 14 18:08:23.888411 waagent[1716]: 2025-05-14T18:08:23.888126Z INFO Daemon Daemon Forcing an update of the goal state. May 14 18:08:23.894419 waagent[1716]: 2025-05-14T18:08:23.893397Z INFO Daemon Fetched a new incarnation for the WireServer goal state [incarnation 1] May 14 18:08:23.909962 waagent[1716]: 2025-05-14T18:08:23.909932Z INFO Daemon Daemon HostGAPlugin version: 1.0.8.164 May 14 18:08:23.912162 waagent[1716]: 2025-05-14T18:08:23.912118Z INFO Daemon May 14 18:08:23.913389 waagent[1716]: 2025-05-14T18:08:23.913317Z INFO Daemon Fetched new vmSettings [HostGAPlugin correlation ID: ff39d114-3a97-4509-af83-214483f2a75d eTag: 14855040215899961631 source: Fabric] May 14 18:08:23.917549 waagent[1716]: 2025-05-14T18:08:23.917526Z INFO Daemon The vmSettings originated via Fabric; will ignore them. May 14 18:08:23.919946 waagent[1716]: 2025-05-14T18:08:23.919921Z INFO Daemon May 14 18:08:23.921045 waagent[1716]: 2025-05-14T18:08:23.920976Z INFO Daemon Fetching full goal state from the WireServer [incarnation 1] May 14 18:08:23.928001 waagent[1716]: 2025-05-14T18:08:23.927979Z INFO Daemon Daemon Downloading artifacts profile blob May 14 18:08:23.950029 systemd[1759]: Queued start job for default target default.target. May 14 18:08:23.955755 systemd[1759]: Created slice app.slice - User Application Slice. May 14 18:08:23.955786 systemd[1759]: Reached target paths.target - Paths. May 14 18:08:23.955814 systemd[1759]: Reached target timers.target - Timers. May 14 18:08:23.956662 systemd[1759]: Starting dbus.socket - D-Bus User Message Bus Socket... May 14 18:08:23.964608 systemd[1759]: Listening on dbus.socket - D-Bus User Message Bus Socket. May 14 18:08:23.964735 systemd[1759]: Reached target sockets.target - Sockets. May 14 18:08:23.964816 systemd[1759]: Reached target basic.target - Basic System. May 14 18:08:23.964929 systemd[1759]: Reached target default.target - Main User Target. May 14 18:08:23.964999 systemd[1]: Started user@500.service - User Manager for UID 500. May 14 18:08:23.965507 systemd[1759]: Startup finished in 158ms. May 14 18:08:23.965911 systemd[1]: Started session-1.scope - Session 1 of User core. May 14 18:08:23.966986 systemd[1]: Started session-2.scope - Session 2 of User core. May 14 18:08:24.012149 waagent[1716]: 2025-05-14T18:08:24.010488Z INFO Daemon Downloaded certificate {'thumbprint': '7FECC9235DF830CB315CB74FDE3A1F4C7496DDAD', 'hasPrivateKey': False} May 14 18:08:24.012149 waagent[1716]: 2025-05-14T18:08:24.011206Z INFO Daemon Downloaded certificate {'thumbprint': '630B7FE97506BE9EA9C95D65C27E9A7B7F7B6487', 'hasPrivateKey': True} May 14 18:08:24.012149 waagent[1716]: 2025-05-14T18:08:24.011762Z INFO Daemon Fetch goal state completed May 14 18:08:24.017152 waagent[1716]: 2025-05-14T18:08:24.016983Z INFO Daemon Daemon Starting provisioning May 14 18:08:24.017743 waagent[1716]: 2025-05-14T18:08:24.017708Z INFO Daemon Daemon Handle ovf-env.xml. May 14 18:08:24.018047 waagent[1716]: 2025-05-14T18:08:24.018017Z INFO Daemon Daemon Set hostname [ci-4334.0.0-a-ec82bf957b] May 14 18:08:24.032969 waagent[1716]: 2025-05-14T18:08:24.032936Z INFO Daemon Daemon Publish hostname [ci-4334.0.0-a-ec82bf957b] May 14 18:08:24.033350 waagent[1716]: 2025-05-14T18:08:24.033320Z INFO Daemon Daemon Examine /proc/net/route for primary interface May 14 18:08:24.033673 waagent[1716]: 2025-05-14T18:08:24.033652Z INFO Daemon Daemon Primary interface is [eth0] May 14 18:08:24.043611 systemd-networkd[1357]: eth0: found matching network '/usr/lib/systemd/network/zz-default.network', based on potentially unpredictable interface name. May 14 18:08:24.043855 systemd-networkd[1357]: eth0: Configuring with /usr/lib/systemd/network/zz-default.network. May 14 18:08:24.043879 systemd-networkd[1357]: eth0: DHCP lease lost May 14 18:08:24.044357 waagent[1716]: 2025-05-14T18:08:24.044316Z INFO Daemon Daemon Create user account if not exists May 14 18:08:24.044919 waagent[1716]: 2025-05-14T18:08:24.044731Z INFO Daemon Daemon User core already exists, skip useradd May 14 18:08:24.047075 waagent[1716]: 2025-05-14T18:08:24.044923Z INFO Daemon Daemon Configure sudoer May 14 18:08:24.048669 waagent[1716]: 2025-05-14T18:08:24.048632Z INFO Daemon Daemon Configure sshd May 14 18:08:24.052927 waagent[1716]: 2025-05-14T18:08:24.052891Z INFO Daemon Daemon Added a configuration snippet disabling SSH password-based authentication methods. It also configures SSH client probing to keep connections alive. May 14 18:08:24.058220 waagent[1716]: 2025-05-14T18:08:24.053318Z INFO Daemon Daemon Deploy ssh public key. May 14 18:08:24.060221 systemd-networkd[1357]: eth0: DHCPv4 address 10.200.8.19/24, gateway 10.200.8.1 acquired from 168.63.129.16 May 14 18:08:25.120568 waagent[1716]: 2025-05-14T18:08:25.120483Z INFO Daemon Daemon Provisioning complete May 14 18:08:25.130552 waagent[1716]: 2025-05-14T18:08:25.130520Z INFO Daemon Daemon RDMA capabilities are not enabled, skipping May 14 18:08:25.131825 waagent[1716]: 2025-05-14T18:08:25.131798Z INFO Daemon Daemon End of log to /dev/console. The agent will now check for updates and then will process extensions. May 14 18:08:25.133736 waagent[1716]: 2025-05-14T18:08:25.133712Z INFO Daemon Daemon Installed Agent WALinuxAgent-2.12.0.4 is the most current agent May 14 18:08:25.222670 waagent[1805]: 2025-05-14T18:08:25.222610Z INFO ExtHandler ExtHandler Azure Linux Agent (Goal State Agent version 2.12.0.4) May 14 18:08:25.222911 waagent[1805]: 2025-05-14T18:08:25.222692Z INFO ExtHandler ExtHandler OS: flatcar 4334.0.0 May 14 18:08:25.222911 waagent[1805]: 2025-05-14T18:08:25.222725Z INFO ExtHandler ExtHandler Python: 3.11.12 May 14 18:08:25.222911 waagent[1805]: 2025-05-14T18:08:25.222758Z INFO ExtHandler ExtHandler CPU Arch: x86_64 May 14 18:08:25.261112 waagent[1805]: 2025-05-14T18:08:25.261064Z INFO ExtHandler ExtHandler Distro: flatcar-4334.0.0; OSUtil: FlatcarUtil; AgentService: waagent; Python: 3.11.12; Arch: x86_64; systemd: True; LISDrivers: Absent; logrotate: logrotate 3.22.0; May 14 18:08:25.261258 waagent[1805]: 2025-05-14T18:08:25.261232Z INFO ExtHandler ExtHandler WireServer endpoint 168.63.129.16 read from file May 14 18:08:25.261319 waagent[1805]: 2025-05-14T18:08:25.261286Z INFO ExtHandler ExtHandler Wire server endpoint:168.63.129.16 May 14 18:08:25.267562 waagent[1805]: 2025-05-14T18:08:25.267512Z INFO ExtHandler Fetched a new incarnation for the WireServer goal state [incarnation 1] May 14 18:08:25.275163 waagent[1805]: 2025-05-14T18:08:25.275125Z INFO ExtHandler ExtHandler HostGAPlugin version: 1.0.8.164 May 14 18:08:25.275453 waagent[1805]: 2025-05-14T18:08:25.275424Z INFO ExtHandler May 14 18:08:25.275491 waagent[1805]: 2025-05-14T18:08:25.275472Z INFO ExtHandler Fetched new vmSettings [HostGAPlugin correlation ID: 58397328-8d49-40ce-9d93-b22608a0ad22 eTag: 14855040215899961631 source: Fabric] May 14 18:08:25.275680 waagent[1805]: 2025-05-14T18:08:25.275657Z INFO ExtHandler The vmSettings originated via Fabric; will ignore them. May 14 18:08:25.275966 waagent[1805]: 2025-05-14T18:08:25.275942Z INFO ExtHandler May 14 18:08:25.275999 waagent[1805]: 2025-05-14T18:08:25.275978Z INFO ExtHandler Fetching full goal state from the WireServer [incarnation 1] May 14 18:08:25.288022 waagent[1805]: 2025-05-14T18:08:25.287994Z INFO ExtHandler ExtHandler Downloading artifacts profile blob May 14 18:08:25.450325 waagent[1805]: 2025-05-14T18:08:25.450255Z INFO ExtHandler Downloaded certificate {'thumbprint': '7FECC9235DF830CB315CB74FDE3A1F4C7496DDAD', 'hasPrivateKey': False} May 14 18:08:25.450549 waagent[1805]: 2025-05-14T18:08:25.450525Z INFO ExtHandler Downloaded certificate {'thumbprint': '630B7FE97506BE9EA9C95D65C27E9A7B7F7B6487', 'hasPrivateKey': True} May 14 18:08:25.450783 waagent[1805]: 2025-05-14T18:08:25.450761Z INFO ExtHandler Fetch goal state completed May 14 18:08:25.462768 waagent[1805]: 2025-05-14T18:08:25.462727Z INFO ExtHandler ExtHandler OpenSSL version: OpenSSL 3.3.3 11 Feb 2025 (Library: OpenSSL 3.3.3 11 Feb 2025) May 14 18:08:25.466068 waagent[1805]: 2025-05-14T18:08:25.466018Z INFO ExtHandler ExtHandler WALinuxAgent-2.12.0.4 running as process 1805 May 14 18:08:25.466169 waagent[1805]: 2025-05-14T18:08:25.466123Z INFO ExtHandler ExtHandler ******** AutoUpdate.Enabled is set to False, not processing the operation ******** May 14 18:08:25.466373 waagent[1805]: 2025-05-14T18:08:25.466353Z INFO ExtHandler ExtHandler ******** AutoUpdate.UpdateToLatestVersion is set to False, not processing the operation ******** May 14 18:08:25.467232 waagent[1805]: 2025-05-14T18:08:25.467205Z INFO ExtHandler ExtHandler [CGI] Cgroup monitoring is not supported on ['flatcar', '4334.0.0', '', 'Flatcar Container Linux by Kinvolk'] May 14 18:08:25.467490 waagent[1805]: 2025-05-14T18:08:25.467468Z INFO ExtHandler ExtHandler [CGI] Agent will reset the quotas in case distro: ['flatcar', '4334.0.0', '', 'Flatcar Container Linux by Kinvolk'] went from supported to unsupported May 14 18:08:25.467575 waagent[1805]: 2025-05-14T18:08:25.467558Z INFO ExtHandler ExtHandler [CGI] Agent cgroups enabled: False May 14 18:08:25.467912 waagent[1805]: 2025-05-14T18:08:25.467892Z INFO ExtHandler ExtHandler Starting setup for Persistent firewall rules May 14 18:08:25.503730 waagent[1805]: 2025-05-14T18:08:25.503708Z INFO ExtHandler ExtHandler Firewalld service not running/unavailable, trying to set up waagent-network-setup.service May 14 18:08:25.503845 waagent[1805]: 2025-05-14T18:08:25.503828Z INFO ExtHandler ExtHandler Successfully updated the Binary file /var/lib/waagent/waagent-network-setup.py for firewall setup May 14 18:08:25.508536 waagent[1805]: 2025-05-14T18:08:25.508451Z INFO ExtHandler ExtHandler Service: waagent-network-setup.service not enabled. Adding it now May 14 18:08:25.513243 systemd[1]: Reload requested from client PID 1822 ('systemctl') (unit waagent.service)... May 14 18:08:25.513258 systemd[1]: Reloading... May 14 18:08:25.578212 zram_generator::config[1859]: No configuration found. May 14 18:08:25.649680 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. May 14 18:08:25.729435 systemd[1]: Reloading finished in 215 ms. May 14 18:08:25.750923 waagent[1805]: 2025-05-14T18:08:25.750878Z INFO ExtHandler ExtHandler Successfully added and enabled the waagent-network-setup.service May 14 18:08:25.750988 waagent[1805]: 2025-05-14T18:08:25.750970Z INFO ExtHandler ExtHandler Persistent firewall rules setup successfully May 14 18:08:26.030322 waagent[1805]: 2025-05-14T18:08:26.030236Z INFO ExtHandler ExtHandler DROP rule is not available which implies no firewall rules are set yet. Environment thread will set it up. May 14 18:08:26.030519 waagent[1805]: 2025-05-14T18:08:26.030493Z INFO ExtHandler ExtHandler Checking if log collection is allowed at this time [False]. All three conditions must be met: 1. configuration enabled [True], 2. cgroups v1 enabled [False] OR cgroups v2 is in use and v2 resource limiting configuration enabled [False], 3. python supported: [True] May 14 18:08:26.031143 waagent[1805]: 2025-05-14T18:08:26.031103Z INFO ExtHandler ExtHandler Starting env monitor service. May 14 18:08:26.031314 waagent[1805]: 2025-05-14T18:08:26.031278Z INFO MonitorHandler ExtHandler WireServer endpoint 168.63.129.16 read from file May 14 18:08:26.031366 waagent[1805]: 2025-05-14T18:08:26.031345Z INFO MonitorHandler ExtHandler Wire server endpoint:168.63.129.16 May 14 18:08:26.031534 waagent[1805]: 2025-05-14T18:08:26.031511Z INFO ExtHandler ExtHandler Start SendTelemetryHandler service. May 14 18:08:26.031823 waagent[1805]: 2025-05-14T18:08:26.031790Z INFO EnvHandler ExtHandler WireServer endpoint 168.63.129.16 read from file May 14 18:08:26.031870 waagent[1805]: 2025-05-14T18:08:26.031845Z INFO SendTelemetryHandler ExtHandler Successfully started the SendTelemetryHandler thread May 14 18:08:26.032031 waagent[1805]: 2025-05-14T18:08:26.032013Z INFO MonitorHandler ExtHandler Monitor.NetworkConfigurationChanges is disabled. May 14 18:08:26.032224 waagent[1805]: 2025-05-14T18:08:26.032206Z INFO ExtHandler ExtHandler Start Extension Telemetry service. May 14 18:08:26.032379 waagent[1805]: 2025-05-14T18:08:26.032360Z INFO EnvHandler ExtHandler Wire server endpoint:168.63.129.16 May 14 18:08:26.032549 waagent[1805]: 2025-05-14T18:08:26.032508Z INFO MonitorHandler ExtHandler Routing table from /proc/net/route: May 14 18:08:26.032549 waagent[1805]: Iface Destination Gateway Flags RefCnt Use Metric Mask MTU Window IRTT May 14 18:08:26.032549 waagent[1805]: eth0 00000000 0108C80A 0003 0 0 1024 00000000 0 0 0 May 14 18:08:26.032549 waagent[1805]: eth0 0008C80A 00000000 0001 0 0 1024 00FFFFFF 0 0 0 May 14 18:08:26.032549 waagent[1805]: eth0 0108C80A 00000000 0005 0 0 1024 FFFFFFFF 0 0 0 May 14 18:08:26.032549 waagent[1805]: eth0 10813FA8 0108C80A 0007 0 0 1024 FFFFFFFF 0 0 0 May 14 18:08:26.032549 waagent[1805]: eth0 FEA9FEA9 0108C80A 0007 0 0 1024 FFFFFFFF 0 0 0 May 14 18:08:26.032696 waagent[1805]: 2025-05-14T18:08:26.032660Z INFO EnvHandler ExtHandler Configure routes May 14 18:08:26.032718 waagent[1805]: 2025-05-14T18:08:26.032700Z INFO EnvHandler ExtHandler Gateway:None May 14 18:08:26.032739 waagent[1805]: 2025-05-14T18:08:26.032726Z INFO EnvHandler ExtHandler Routes:None May 14 18:08:26.032944 waagent[1805]: 2025-05-14T18:08:26.032893Z INFO TelemetryEventsCollector ExtHandler Extension Telemetry pipeline enabled: True May 14 18:08:26.033307 waagent[1805]: 2025-05-14T18:08:26.033288Z INFO ExtHandler ExtHandler Goal State Period: 6 sec. This indicates how often the agent checks for new goal states and reports status. May 14 18:08:26.033990 waagent[1805]: 2025-05-14T18:08:26.033938Z INFO TelemetryEventsCollector ExtHandler Successfully started the TelemetryEventsCollector thread May 14 18:08:26.040224 waagent[1805]: 2025-05-14T18:08:26.040197Z INFO ExtHandler ExtHandler May 14 18:08:26.040288 waagent[1805]: 2025-05-14T18:08:26.040246Z INFO ExtHandler ExtHandler ProcessExtensionsGoalState started [incarnation_1 channel: WireServer source: Fabric activity: f26db5ae-d84f-43dc-9215-193c50f64c4a correlation d00f5414-8523-4025-9572-229537d26284 created: 2025-05-14T18:07:01.283699Z] May 14 18:08:26.040472 waagent[1805]: 2025-05-14T18:08:26.040452Z INFO ExtHandler ExtHandler No extension handlers found, not processing anything. May 14 18:08:26.040795 waagent[1805]: 2025-05-14T18:08:26.040775Z INFO ExtHandler ExtHandler ProcessExtensionsGoalState completed [incarnation_1 0 ms] May 14 18:08:26.201828 waagent[1805]: 2025-05-14T18:08:26.201433Z WARNING ExtHandler ExtHandler Failed to get firewall packets: 'iptables -w -t security -L OUTPUT --zero OUTPUT -nxv' failed: 2 (iptables v1.8.11 (nf_tables): Illegal option `--numeric' with this command May 14 18:08:26.201828 waagent[1805]: Try `iptables -h' or 'iptables --help' for more information.) May 14 18:08:26.201828 waagent[1805]: 2025-05-14T18:08:26.201769Z INFO ExtHandler ExtHandler [HEARTBEAT] Agent WALinuxAgent-2.12.0.4 is running as the goal state agent [DEBUG HeartbeatCounter: 0;HeartbeatId: 00BEDA10-4F6C-4C18-8AB6-E1AA2A682D70;DroppedPackets: -1;UpdateGSErrors: 0;AutoUpdate: 0;UpdateMode: SelfUpdate;] May 14 18:08:26.222080 waagent[1805]: 2025-05-14T18:08:26.222038Z INFO MonitorHandler ExtHandler Network interfaces: May 14 18:08:26.222080 waagent[1805]: Executing ['ip', '-a', '-o', 'link']: May 14 18:08:26.222080 waagent[1805]: 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 May 14 18:08:26.222080 waagent[1805]: 2: eth0: mtu 1500 qdisc mq state UP mode DEFAULT group default qlen 1000\ link/ether 60:45:bd:e0:30:02 brd ff:ff:ff:ff:ff:ff\ alias Network Device May 14 18:08:26.222080 waagent[1805]: 3: enP30832s1: mtu 1500 qdisc mq master eth0 state UP mode DEFAULT group default qlen 1000\ link/ether 60:45:bd:e0:30:02 brd ff:ff:ff:ff:ff:ff\ altname enP30832p0s0 May 14 18:08:26.222080 waagent[1805]: Executing ['ip', '-4', '-a', '-o', 'address']: May 14 18:08:26.222080 waagent[1805]: 1: lo inet 127.0.0.1/8 scope host lo\ valid_lft forever preferred_lft forever May 14 18:08:26.222080 waagent[1805]: 2: eth0 inet 10.200.8.19/24 metric 1024 brd 10.200.8.255 scope global eth0\ valid_lft forever preferred_lft forever May 14 18:08:26.222080 waagent[1805]: Executing ['ip', '-6', '-a', '-o', 'address']: May 14 18:08:26.222080 waagent[1805]: 1: lo inet6 ::1/128 scope host noprefixroute \ valid_lft forever preferred_lft forever May 14 18:08:26.222080 waagent[1805]: 2: eth0 inet6 fe80::6245:bdff:fee0:3002/64 scope link proto kernel_ll \ valid_lft forever preferred_lft forever May 14 18:08:26.222080 waagent[1805]: 3: enP30832s1 inet6 fe80::6245:bdff:fee0:3002/64 scope link proto kernel_ll \ valid_lft forever preferred_lft forever May 14 18:08:26.648364 waagent[1805]: 2025-05-14T18:08:26.648319Z INFO EnvHandler ExtHandler Created firewall rules for the Azure Fabric: May 14 18:08:26.648364 waagent[1805]: Chain INPUT (policy ACCEPT 0 packets, 0 bytes) May 14 18:08:26.648364 waagent[1805]: pkts bytes target prot opt in out source destination May 14 18:08:26.648364 waagent[1805]: Chain FORWARD (policy ACCEPT 0 packets, 0 bytes) May 14 18:08:26.648364 waagent[1805]: pkts bytes target prot opt in out source destination May 14 18:08:26.648364 waagent[1805]: Chain OUTPUT (policy ACCEPT 0 packets, 0 bytes) May 14 18:08:26.648364 waagent[1805]: pkts bytes target prot opt in out source destination May 14 18:08:26.648364 waagent[1805]: 0 0 ACCEPT tcp -- * * 0.0.0.0/0 168.63.129.16 tcp dpt:53 May 14 18:08:26.648364 waagent[1805]: 0 0 ACCEPT tcp -- * * 0.0.0.0/0 168.63.129.16 owner UID match 0 May 14 18:08:26.648364 waagent[1805]: 0 0 DROP tcp -- * * 0.0.0.0/0 168.63.129.16 ctstate INVALID,NEW May 14 18:08:26.650903 waagent[1805]: 2025-05-14T18:08:26.650858Z INFO EnvHandler ExtHandler Current Firewall rules: May 14 18:08:26.650903 waagent[1805]: Chain INPUT (policy ACCEPT 0 packets, 0 bytes) May 14 18:08:26.650903 waagent[1805]: pkts bytes target prot opt in out source destination May 14 18:08:26.650903 waagent[1805]: Chain FORWARD (policy ACCEPT 0 packets, 0 bytes) May 14 18:08:26.650903 waagent[1805]: pkts bytes target prot opt in out source destination May 14 18:08:26.650903 waagent[1805]: Chain OUTPUT (policy ACCEPT 0 packets, 0 bytes) May 14 18:08:26.650903 waagent[1805]: pkts bytes target prot opt in out source destination May 14 18:08:26.650903 waagent[1805]: 0 0 ACCEPT tcp -- * * 0.0.0.0/0 168.63.129.16 tcp dpt:53 May 14 18:08:26.650903 waagent[1805]: 0 0 ACCEPT tcp -- * * 0.0.0.0/0 168.63.129.16 owner UID match 0 May 14 18:08:26.650903 waagent[1805]: 0 0 DROP tcp -- * * 0.0.0.0/0 168.63.129.16 ctstate INVALID,NEW May 14 18:08:44.387757 chronyd[1658]: Selected source PHC0 May 14 18:08:51.259789 systemd[1]: Created slice system-sshd.slice - Slice /system/sshd. May 14 18:08:51.260809 systemd[1]: Started sshd@0-10.200.8.19:22-10.200.16.10:52294.service - OpenSSH per-connection server daemon (10.200.16.10:52294). May 14 18:08:51.972616 sshd[1950]: Accepted publickey for core from 10.200.16.10 port 52294 ssh2: RSA SHA256:Hd5PQzbog4WemQvfyzJrpsOqYyUj2ZNV4jY0cJYqkm4 May 14 18:08:51.973885 sshd-session[1950]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) May 14 18:08:51.978108 systemd-logind[1614]: New session 3 of user core. May 14 18:08:51.984265 systemd[1]: Started session-3.scope - Session 3 of User core. May 14 18:08:52.541019 systemd[1]: Started sshd@1-10.200.8.19:22-10.200.16.10:52768.service - OpenSSH per-connection server daemon (10.200.16.10:52768). May 14 18:08:53.175068 sshd[1955]: Accepted publickey for core from 10.200.16.10 port 52768 ssh2: RSA SHA256:Hd5PQzbog4WemQvfyzJrpsOqYyUj2ZNV4jY0cJYqkm4 May 14 18:08:53.176394 sshd-session[1955]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) May 14 18:08:53.180468 systemd-logind[1614]: New session 4 of user core. May 14 18:08:53.191245 systemd[1]: Started session-4.scope - Session 4 of User core. May 14 18:08:53.624511 sshd[1957]: Connection closed by 10.200.16.10 port 52768 May 14 18:08:53.625080 sshd-session[1955]: pam_unix(sshd:session): session closed for user core May 14 18:08:53.628040 systemd[1]: sshd@1-10.200.8.19:22-10.200.16.10:52768.service: Deactivated successfully. May 14 18:08:53.629440 systemd[1]: session-4.scope: Deactivated successfully. May 14 18:08:53.630979 systemd-logind[1614]: Session 4 logged out. Waiting for processes to exit. May 14 18:08:53.631818 systemd-logind[1614]: Removed session 4. May 14 18:08:53.744102 systemd[1]: Started sshd@2-10.200.8.19:22-10.200.16.10:52778.service - OpenSSH per-connection server daemon (10.200.16.10:52778). May 14 18:08:54.385943 sshd[1963]: Accepted publickey for core from 10.200.16.10 port 52778 ssh2: RSA SHA256:Hd5PQzbog4WemQvfyzJrpsOqYyUj2ZNV4jY0cJYqkm4 May 14 18:08:54.387310 sshd-session[1963]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) May 14 18:08:54.391613 systemd-logind[1614]: New session 5 of user core. May 14 18:08:54.397268 systemd[1]: Started session-5.scope - Session 5 of User core. May 14 18:08:54.839632 sshd[1965]: Connection closed by 10.200.16.10 port 52778 May 14 18:08:54.840215 sshd-session[1963]: pam_unix(sshd:session): session closed for user core May 14 18:08:54.843088 systemd[1]: sshd@2-10.200.8.19:22-10.200.16.10:52778.service: Deactivated successfully. May 14 18:08:54.844632 systemd[1]: session-5.scope: Deactivated successfully. May 14 18:08:54.845228 systemd-logind[1614]: Session 5 logged out. Waiting for processes to exit. May 14 18:08:54.846608 systemd-logind[1614]: Removed session 5. May 14 18:08:54.958035 systemd[1]: Started sshd@3-10.200.8.19:22-10.200.16.10:52786.service - OpenSSH per-connection server daemon (10.200.16.10:52786). May 14 18:08:55.594858 sshd[1971]: Accepted publickey for core from 10.200.16.10 port 52786 ssh2: RSA SHA256:Hd5PQzbog4WemQvfyzJrpsOqYyUj2ZNV4jY0cJYqkm4 May 14 18:08:55.596185 sshd-session[1971]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) May 14 18:08:55.600275 systemd-logind[1614]: New session 6 of user core. May 14 18:08:55.606263 systemd[1]: Started session-6.scope - Session 6 of User core. May 14 18:08:56.044701 sshd[1973]: Connection closed by 10.200.16.10 port 52786 May 14 18:08:56.045215 sshd-session[1971]: pam_unix(sshd:session): session closed for user core May 14 18:08:56.048524 systemd[1]: sshd@3-10.200.8.19:22-10.200.16.10:52786.service: Deactivated successfully. May 14 18:08:56.049869 systemd[1]: session-6.scope: Deactivated successfully. May 14 18:08:56.050549 systemd-logind[1614]: Session 6 logged out. Waiting for processes to exit. May 14 18:08:56.051594 systemd-logind[1614]: Removed session 6. May 14 18:08:56.188217 systemd[1]: Started sshd@4-10.200.8.19:22-10.200.16.10:52798.service - OpenSSH per-connection server daemon (10.200.16.10:52798). May 14 18:08:56.825514 sshd[1979]: Accepted publickey for core from 10.200.16.10 port 52798 ssh2: RSA SHA256:Hd5PQzbog4WemQvfyzJrpsOqYyUj2ZNV4jY0cJYqkm4 May 14 18:08:56.826779 sshd-session[1979]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) May 14 18:08:56.831218 systemd-logind[1614]: New session 7 of user core. May 14 18:08:56.841239 systemd[1]: Started session-7.scope - Session 7 of User core. May 14 18:08:57.258029 sudo[1982]: core : PWD=/home/core ; USER=root ; COMMAND=/usr/sbin/setenforce 1 May 14 18:08:57.258244 sudo[1982]: pam_unix(sudo:session): session opened for user root(uid=0) by core(uid=500) May 14 18:08:57.289963 sudo[1982]: pam_unix(sudo:session): session closed for user root May 14 18:08:57.393553 sshd[1981]: Connection closed by 10.200.16.10 port 52798 May 14 18:08:57.394229 sshd-session[1979]: pam_unix(sshd:session): session closed for user core May 14 18:08:57.397216 systemd[1]: sshd@4-10.200.8.19:22-10.200.16.10:52798.service: Deactivated successfully. May 14 18:08:57.398794 systemd[1]: session-7.scope: Deactivated successfully. May 14 18:08:57.399995 systemd-logind[1614]: Session 7 logged out. Waiting for processes to exit. May 14 18:08:57.401280 systemd-logind[1614]: Removed session 7. May 14 18:08:57.519945 systemd[1]: Started sshd@5-10.200.8.19:22-10.200.16.10:52812.service - OpenSSH per-connection server daemon (10.200.16.10:52812). May 14 18:08:58.158649 sshd[1988]: Accepted publickey for core from 10.200.16.10 port 52812 ssh2: RSA SHA256:Hd5PQzbog4WemQvfyzJrpsOqYyUj2ZNV4jY0cJYqkm4 May 14 18:08:58.159906 sshd-session[1988]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) May 14 18:08:58.164112 systemd-logind[1614]: New session 8 of user core. May 14 18:08:58.170282 systemd[1]: Started session-8.scope - Session 8 of User core. May 14 18:08:58.507127 sudo[1995]: 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 May 14 18:08:58.507343 sudo[1995]: pam_unix(sudo:session): session opened for user root(uid=0) by core(uid=500) May 14 18:08:58.514549 sudo[1995]: pam_unix(sudo:session): session closed for user root May 14 18:08:58.518068 sudo[1994]: core : PWD=/home/core ; USER=root ; COMMAND=/usr/sbin/systemctl restart audit-rules May 14 18:08:58.518271 sudo[1994]: pam_unix(sudo:session): session opened for user root(uid=0) by core(uid=500) May 14 18:08:58.524949 systemd[1]: Starting audit-rules.service - Load Audit Rules... May 14 18:08:58.551949 augenrules[2017]: No rules May 14 18:08:58.552394 systemd[1]: audit-rules.service: Deactivated successfully. May 14 18:08:58.552562 systemd[1]: Finished audit-rules.service - Load Audit Rules. May 14 18:08:58.553385 sudo[1994]: pam_unix(sudo:session): session closed for user root May 14 18:08:58.661241 sshd[1990]: Connection closed by 10.200.16.10 port 52812 May 14 18:08:58.661705 sshd-session[1988]: pam_unix(sshd:session): session closed for user core May 14 18:08:58.664252 systemd[1]: sshd@5-10.200.8.19:22-10.200.16.10:52812.service: Deactivated successfully. May 14 18:08:58.665523 systemd[1]: session-8.scope: Deactivated successfully. May 14 18:08:58.666954 systemd-logind[1614]: Session 8 logged out. Waiting for processes to exit. May 14 18:08:58.667691 systemd-logind[1614]: Removed session 8. May 14 18:08:58.772781 systemd[1]: Started sshd@6-10.200.8.19:22-10.200.16.10:42264.service - OpenSSH per-connection server daemon (10.200.16.10:42264). May 14 18:08:59.418742 sshd[2026]: Accepted publickey for core from 10.200.16.10 port 42264 ssh2: RSA SHA256:Hd5PQzbog4WemQvfyzJrpsOqYyUj2ZNV4jY0cJYqkm4 May 14 18:08:59.419955 sshd-session[2026]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) May 14 18:08:59.424086 systemd-logind[1614]: New session 9 of user core. May 14 18:08:59.433249 systemd[1]: Started session-9.scope - Session 9 of User core. May 14 18:08:59.766414 sudo[2029]: core : PWD=/home/core ; USER=root ; COMMAND=/usr/sbin/mkdir -p . May 14 18:08:59.766616 sudo[2029]: pam_unix(sudo:session): session opened for user root(uid=0) by core(uid=500) May 14 18:08:59.768930 sudo[2029]: pam_unix(sudo:session): session closed for user root May 14 18:08:59.870004 sshd[2028]: Connection closed by 10.200.16.10 port 42264 May 14 18:08:59.870475 sshd-session[2026]: pam_unix(sshd:session): session closed for user core May 14 18:08:59.873585 systemd[1]: sshd@6-10.200.8.19:22-10.200.16.10:42264.service: Deactivated successfully. May 14 18:08:59.874916 systemd[1]: session-9.scope: Deactivated successfully. May 14 18:08:59.875640 systemd-logind[1614]: Session 9 logged out. Waiting for processes to exit. May 14 18:08:59.876601 systemd-logind[1614]: Removed session 9. May 14 18:08:59.987489 systemd[1]: Started sshd@7-10.200.8.19:22-10.200.16.10:42268.service - OpenSSH per-connection server daemon (10.200.16.10:42268). May 14 18:09:00.633083 sshd[2035]: Accepted publickey for core from 10.200.16.10 port 42268 ssh2: RSA SHA256:Hd5PQzbog4WemQvfyzJrpsOqYyUj2ZNV4jY0cJYqkm4 May 14 18:09:00.634358 sshd-session[2035]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) May 14 18:09:00.638555 systemd-logind[1614]: New session 10 of user core. May 14 18:09:00.646285 systemd[1]: Started session-10.scope - Session 10 of User core. May 14 18:09:00.980940 sudo[2038]: core : PWD=/home/core ; USER=root ; COMMAND=/usr/sbin/install -m 0755 /dev/stdin kolet May 14 18:09:00.981150 sudo[2038]: pam_unix(sudo:session): session opened for user root(uid=0) by core(uid=500) May 14 18:09:03.005846 kernel: hv_balloon: Max. dynamic memory size: 8192 MB May 14 18:09:04.363648 sudo[2038]: pam_unix(sudo:session): session closed for user root May 14 18:09:04.464990 sshd[2037]: Connection closed by 10.200.16.10 port 42268 May 14 18:09:04.465550 sshd-session[2035]: pam_unix(sshd:session): session closed for user core May 14 18:09:04.469263 systemd[1]: sshd@7-10.200.8.19:22-10.200.16.10:42268.service: Deactivated successfully. May 14 18:09:04.470583 systemd[1]: session-10.scope: Deactivated successfully. May 14 18:09:04.471668 systemd-logind[1614]: Session 10 logged out. Waiting for processes to exit. May 14 18:09:04.472585 systemd-logind[1614]: Removed session 10. May 14 18:09:04.582036 systemd[1]: Started sshd@8-10.200.8.19:22-10.200.16.10:42274.service - OpenSSH per-connection server daemon (10.200.16.10:42274). May 14 18:09:05.221646 sshd[2044]: Accepted publickey for core from 10.200.16.10 port 42274 ssh2: RSA SHA256:Hd5PQzbog4WemQvfyzJrpsOqYyUj2ZNV4jY0cJYqkm4 May 14 18:09:05.222890 sshd-session[2044]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) May 14 18:09:05.227012 systemd-logind[1614]: New session 11 of user core. May 14 18:09:05.233250 systemd[1]: Started session-11.scope - Session 11 of User core. May 14 18:09:06.358475 update_engine[1615]: I20250514 18:09:06.358386 1615 update_attempter.cc:509] Updating boot flags... May 14 18:09:06.529934 systemd[1]: Starting docker.service - Docker Application Container Engine... May 14 18:09:06.542384 (dockerd)[2064]: 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 May 14 18:09:09.225300 dockerd[2064]: time="2025-05-14T18:09:09.225254640Z" level=info msg="Starting up" May 14 18:09:09.226180 dockerd[2064]: time="2025-05-14T18:09:09.226151707Z" level=info msg="OTEL tracing is not configured, using no-op tracer provider" May 14 18:09:12.231737 dockerd[2064]: time="2025-05-14T18:09:12.231678524Z" level=info msg="Loading containers: start." May 14 18:09:12.318164 kernel: Initializing XFRM netlink socket May 14 18:09:12.767037 systemd-networkd[1357]: docker0: Link UP May 14 18:09:13.080944 dockerd[2064]: time="2025-05-14T18:09:13.080750780Z" level=info msg="Loading containers: done." May 14 18:09:13.837277 dockerd[2064]: time="2025-05-14T18:09:13.837219554Z" 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 May 14 18:09:13.837708 dockerd[2064]: time="2025-05-14T18:09:13.837340521Z" level=info msg="Docker daemon" commit=bbd0a17ccc67e48d4a69393287b7fcc4f0578683 containerd-snapshotter=false storage-driver=overlay2 version=28.0.1 May 14 18:09:13.837708 dockerd[2064]: time="2025-05-14T18:09:13.837476079Z" level=info msg="Initializing buildkit" May 14 18:09:14.279804 dockerd[2064]: time="2025-05-14T18:09:14.279766813Z" level=info msg="Completed buildkit initialization" May 14 18:09:14.285649 dockerd[2064]: time="2025-05-14T18:09:14.285605679Z" level=info msg="Daemon has completed initialization" May 14 18:09:14.285794 systemd[1]: Started docker.service - Docker Application Container Engine. May 14 18:09:14.286027 dockerd[2064]: time="2025-05-14T18:09:14.285775880Z" level=info msg="API listen on /run/docker.sock" May 14 18:09:18.736155 containerd[1647]: time="2025-05-14T18:09:18.735595991Z" level=info msg="connecting to shim 247cc42d2de4a5c838305060180635d875eca186e33e2de80a41540b7c6c56ca" address="unix:///run/containerd/s/7f85996e203b39248b487ff2d033968c03664870f0e916dfa3fb317853445b75" namespace=moby protocol=ttrpc version=3 May 14 18:09:18.755287 systemd[1]: Started docker-247cc42d2de4a5c838305060180635d875eca186e33e2de80a41540b7c6c56ca.scope - libcontainer container 247cc42d2de4a5c838305060180635d875eca186e33e2de80a41540b7c6c56ca. May 14 18:09:19.119899 kernel: docker0: port 1(vethc4999ec) entered blocking state May 14 18:09:19.119982 kernel: docker0: port 1(vethc4999ec) entered disabled state May 14 18:09:19.119998 kernel: vethc4999ec: entered allmulticast mode May 14 18:09:19.121021 kernel: vethc4999ec: entered promiscuous mode May 14 18:09:19.122072 systemd-networkd[1357]: vethc4999ec: Link UP May 14 18:09:19.441153 kernel: eth0: renamed from vethda4044a May 14 18:09:19.442879 kernel: docker0: port 1(vethc4999ec) entered blocking state May 14 18:09:19.443154 kernel: docker0: port 1(vethc4999ec) entered forwarding state May 14 18:09:19.443050 systemd-networkd[1357]: vethc4999ec: Gained carrier May 14 18:09:19.443265 systemd-networkd[1357]: docker0: Gained carrier May 14 18:09:20.618339 systemd-networkd[1357]: docker0: Gained IPv6LL May 14 18:09:21.514363 systemd-networkd[1357]: vethc4999ec: Gained IPv6LL May 14 18:09:22.648448 systemd[1]: docker-247cc42d2de4a5c838305060180635d875eca186e33e2de80a41540b7c6c56ca.scope: Deactivated successfully. May 14 18:09:22.660773 containerd[1647]: time="2025-05-14T18:09:22.660738858Z" level=info msg="shim disconnected" id=247cc42d2de4a5c838305060180635d875eca186e33e2de80a41540b7c6c56ca namespace=moby May 14 18:09:22.661021 dockerd[2064]: time="2025-05-14T18:09:22.660763050Z" level=info msg="ignoring event" container=247cc42d2de4a5c838305060180635d875eca186e33e2de80a41540b7c6c56ca module=libcontainerd namespace=moby topic=/tasks/delete type="*events.TaskDelete" May 14 18:09:22.661176 containerd[1647]: time="2025-05-14T18:09:22.661050056Z" level=warning msg="cleaning up after shim disconnected" id=247cc42d2de4a5c838305060180635d875eca186e33e2de80a41540b7c6c56ca namespace=moby May 14 18:09:22.661176 containerd[1647]: time="2025-05-14T18:09:22.661066936Z" level=info msg="cleaning up dead shim" namespace=moby May 14 18:09:22.682077 systemd-networkd[1357]: vethc4999ec: Lost carrier May 14 18:09:22.682838 kernel: docker0: port 1(vethc4999ec) entered disabled state May 14 18:09:22.682862 kernel: vethda4044a: renamed from eth0 May 14 18:09:22.697460 systemd-networkd[1357]: vethc4999ec: Link DOWN May 14 18:09:22.699150 kernel: docker0: port 1(vethc4999ec) entered disabled state May 14 18:09:22.700791 kernel: vethc4999ec (unregistering): left allmulticast mode May 14 18:09:22.700833 kernel: vethc4999ec (unregistering): left promiscuous mode May 14 18:09:22.700848 kernel: docker0: port 1(vethc4999ec) entered disabled state May 14 18:09:22.714829 systemd[1]: run-docker-netns-f826026c8866.mount: Deactivated successfully. May 14 18:09:22.718417 systemd[1]: var-lib-docker-overlay2-bebf4646ee62699b90189783340dfa7ff9ff13b3ef8ff685db0af905ada41112-merged.mount: Deactivated successfully. May 14 18:09:23.690527 systemd-networkd[1357]: docker0: Lost carrier May 14 18:09:23.880861 sshd[2046]: Connection closed by 10.200.16.10 port 42274 May 14 18:09:23.881527 sshd-session[2044]: pam_unix(sshd:session): session closed for user core May 14 18:09:23.884621 systemd[1]: sshd@8-10.200.8.19:22-10.200.16.10:42274.service: Deactivated successfully. May 14 18:09:23.886415 systemd[1]: session-11.scope: Deactivated successfully. May 14 18:09:23.887555 systemd-logind[1614]: Session 11 logged out. Waiting for processes to exit. May 14 18:09:23.888491 systemd-logind[1614]: Removed session 11. May 14 18:09:23.994988 systemd[1]: Started sshd@9-10.200.8.19:22-10.200.16.10:43556.service - OpenSSH per-connection server daemon (10.200.16.10:43556). May 14 18:09:24.628960 sshd[2383]: Accepted publickey for core from 10.200.16.10 port 43556 ssh2: RSA SHA256:Hd5PQzbog4WemQvfyzJrpsOqYyUj2ZNV4jY0cJYqkm4 May 14 18:09:24.630288 sshd-session[2383]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) May 14 18:09:24.634501 systemd-logind[1614]: New session 12 of user core. May 14 18:09:24.639275 systemd[1]: Started session-12.scope - Session 12 of User core. May 14 18:09:27.689254 containerd[1647]: time="2025-05-14T18:09:27.689127232Z" level=info msg="connecting to shim 8a46a3d807c7cb57bbaa664c1aa208662c395aaf0adf32a343edbe843c0c1445" address="unix:///run/containerd/s/f41181bd6ca98d32b45d04ec3945c07a30000722179c4d6e22d621b8931b5969" namespace=moby protocol=ttrpc version=3 May 14 18:09:27.712284 systemd[1]: Started docker-8a46a3d807c7cb57bbaa664c1aa208662c395aaf0adf32a343edbe843c0c1445.scope - libcontainer container 8a46a3d807c7cb57bbaa664c1aa208662c395aaf0adf32a343edbe843c0c1445. May 14 18:09:27.743408 kernel: docker0: port 1(veth3adeb3f) entered blocking state May 14 18:09:27.743471 kernel: docker0: port 1(veth3adeb3f) entered disabled state May 14 18:09:27.744181 kernel: veth3adeb3f: entered allmulticast mode May 14 18:09:27.745626 kernel: veth3adeb3f: entered promiscuous mode May 14 18:09:27.745067 systemd-networkd[1357]: veth3adeb3f: Link UP May 14 18:09:27.885156 kernel: eth0: renamed from vethdc89617 May 14 18:09:27.886957 systemd-networkd[1357]: veth3adeb3f: Gained carrier May 14 18:09:27.887350 kernel: docker0: port 1(veth3adeb3f) entered blocking state May 14 18:09:27.887393 kernel: docker0: port 1(veth3adeb3f) entered forwarding state May 14 18:09:27.887270 systemd-networkd[1357]: docker0: Gained carrier May 14 18:09:27.992321 systemd[1]: docker-8a46a3d807c7cb57bbaa664c1aa208662c395aaf0adf32a343edbe843c0c1445.scope: Deactivated successfully. May 14 18:09:28.039321 containerd[1647]: time="2025-05-14T18:09:28.039235823Z" level=info msg="shim disconnected" id=8a46a3d807c7cb57bbaa664c1aa208662c395aaf0adf32a343edbe843c0c1445 namespace=moby May 14 18:09:28.039321 containerd[1647]: time="2025-05-14T18:09:28.039266482Z" level=warning msg="cleaning up after shim disconnected" id=8a46a3d807c7cb57bbaa664c1aa208662c395aaf0adf32a343edbe843c0c1445 namespace=moby May 14 18:09:28.039321 containerd[1647]: time="2025-05-14T18:09:28.039274088Z" level=info msg="cleaning up dead shim" namespace=moby May 14 18:09:28.039528 dockerd[2064]: time="2025-05-14T18:09:28.039500339Z" level=info msg="ignoring event" container=8a46a3d807c7cb57bbaa664c1aa208662c395aaf0adf32a343edbe843c0c1445 module=libcontainerd namespace=moby topic=/tasks/delete type="*events.TaskDelete" May 14 18:09:28.083152 kernel: docker0: port 1(veth3adeb3f) entered disabled state May 14 18:09:28.083198 kernel: vethdc89617: renamed from eth0 May 14 18:09:28.083326 systemd-networkd[1357]: veth3adeb3f: Lost carrier May 14 18:09:28.185761 systemd-networkd[1357]: veth3adeb3f: Link DOWN May 14 18:09:28.187148 kernel: docker0: port 1(veth3adeb3f) entered disabled state May 14 18:09:28.189583 kernel: veth3adeb3f (unregistering): left allmulticast mode May 14 18:09:28.189632 kernel: veth3adeb3f (unregistering): left promiscuous mode May 14 18:09:28.189662 kernel: docker0: port 1(veth3adeb3f) entered disabled state May 14 18:09:28.281071 systemd[1]: run-docker-netns-5d7d7f172eb7.mount: Deactivated successfully. May 14 18:09:28.284758 systemd[1]: var-lib-docker-overlay2-5da6d0622b8da48ed9e590735c07c25b862db638f8cf83e66322cbc94a3aa1f5-merged.mount: Deactivated successfully. May 14 18:09:28.746473 systemd-networkd[1357]: docker0: Lost carrier May 14 18:09:29.240580 sshd[2385]: Connection closed by 10.200.16.10 port 43556 May 14 18:09:29.241386 sshd-session[2383]: pam_unix(sshd:session): session closed for user core May 14 18:09:29.244380 systemd[1]: sshd@9-10.200.8.19:22-10.200.16.10:43556.service: Deactivated successfully. May 14 18:09:29.245660 systemd[1]: session-12.scope: Deactivated successfully. May 14 18:09:29.246810 systemd-logind[1614]: Session 12 logged out. Waiting for processes to exit. May 14 18:09:29.247868 systemd-logind[1614]: Removed session 12. May 14 18:09:29.358000 systemd[1]: Started sshd@10-10.200.8.19:22-10.200.16.10:36742.service - OpenSSH per-connection server daemon (10.200.16.10:36742). May 14 18:09:29.993396 sshd[2475]: Accepted publickey for core from 10.200.16.10 port 36742 ssh2: RSA SHA256:Hd5PQzbog4WemQvfyzJrpsOqYyUj2ZNV4jY0cJYqkm4 May 14 18:09:29.994565 sshd-session[2475]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) May 14 18:09:29.998629 systemd-logind[1614]: New session 13 of user core. May 14 18:09:30.007262 systemd[1]: Started session-13.scope - Session 13 of User core. May 14 18:09:30.420524 ntpdate[2485]: ntpdate 4.2.8p17@1.4004-o Wed May 14 16:07:00 UTC 2025 (1) May 14 18:09:37.158226 ntpdate[2485]: adjust time server 89.234.64.77 offset -0.015795 sec May 14 18:09:37.266265 sshd[2477]: Connection closed by 10.200.16.10 port 36742 May 14 18:09:37.266927 sshd-session[2475]: pam_unix(sshd:session): session closed for user core May 14 18:09:37.270126 systemd[1]: sshd@10-10.200.8.19:22-10.200.16.10:36742.service: Deactivated successfully. May 14 18:09:37.271606 systemd[1]: session-13.scope: Deactivated successfully. May 14 18:09:37.272789 systemd-logind[1614]: Session 13 logged out. Waiting for processes to exit. May 14 18:09:37.273786 systemd-logind[1614]: Removed session 13. May 14 18:09:37.381514 systemd[1]: Started sshd@11-10.200.8.19:22-10.200.16.10:36756.service - OpenSSH per-connection server daemon (10.200.16.10:36756). May 14 18:09:38.016600 sshd[2490]: Accepted publickey for core from 10.200.16.10 port 36756 ssh2: RSA SHA256:Hd5PQzbog4WemQvfyzJrpsOqYyUj2ZNV4jY0cJYqkm4 May 14 18:09:38.017796 sshd-session[2490]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) May 14 18:09:38.022004 systemd-logind[1614]: New session 14 of user core. May 14 18:09:38.028235 systemd[1]: Started session-14.scope - Session 14 of User core. May 14 18:09:38.550331 sshd[2492]: Connection closed by 10.200.16.10 port 36756 May 14 18:09:38.550811 sshd-session[2490]: pam_unix(sshd:session): session closed for user core May 14 18:09:38.553894 systemd[1]: sshd@11-10.200.8.19:22-10.200.16.10:36756.service: Deactivated successfully. May 14 18:09:38.555050 systemd[1]: session-14.scope: Deactivated successfully. May 14 18:09:38.555665 systemd-logind[1614]: Session 14 logged out. Waiting for processes to exit. May 14 18:09:38.556676 systemd-logind[1614]: Removed session 14.