May 27 03:19:18.212884 kernel: Linux version 6.12.30-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 Tue May 27 01:09:43 -00 2025
May 27 03:19:18.212912 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=f6c186658a19d5a08471ef76df75f82494b37b46908f9237b2c3cf497da860c6
May 27 03:19:18.212922 kernel: BIOS-provided physical RAM map:
May 27 03:19:18.212929 kernel: BIOS-e820: [mem 0x0000000000000000-0x000000000009ffff] usable
May 27 03:19:18.212935 kernel: BIOS-e820: [mem 0x00000000000c0000-0x00000000000fffff] reserved
May 27 03:19:18.212942 kernel: BIOS-e820: [mem 0x0000000000100000-0x000000003ff40fff] usable
May 27 03:19:18.212950 kernel: BIOS-e820: [mem 0x000000003ff41000-0x000000003ffc8fff] reserved
May 27 03:19:18.212960 kernel: BIOS-e820: [mem 0x000000003ffc9000-0x000000003fffafff] ACPI data
May 27 03:19:18.212967 kernel: BIOS-e820: [mem 0x000000003fffb000-0x000000003fffefff] ACPI NVS
May 27 03:19:18.212973 kernel: BIOS-e820: [mem 0x000000003ffff000-0x000000003fffffff] usable
May 27 03:19:18.212980 kernel: BIOS-e820: [mem 0x0000000100000000-0x0000000fdfffffff] usable
May 27 03:19:18.212987 kernel: BIOS-e820: [mem 0x0000004fe0000000-0x0000005cbfffffff] usable
May 27 03:19:18.212994 kernel: printk: legacy bootconsole [earlyser0] enabled
May 27 03:19:18.213001 kernel: NX (Execute Disable) protection: active
May 27 03:19:18.213012 kernel: APIC: Static calls initialized
May 27 03:19:18.213020 kernel: efi: EFI v2.7 by Microsoft
May 27 03:19:18.213028 kernel: efi: ACPI=0x3fffa000 ACPI 2.0=0x3fffa014 SMBIOS=0x3ff85000 SMBIOS 3.0=0x3ff83000 MEMATTR=0x3f5bfa98 RNG=0x3ffd1018 
May 27 03:19:18.213035 kernel: random: crng init done
May 27 03:19:18.213043 kernel: secureboot: Secure boot disabled
May 27 03:19:18.213050 kernel: SMBIOS 3.1.0 present.
May 27 03:19:18.213058 kernel: DMI: Microsoft Corporation Virtual Machine/Virtual Machine, BIOS Hyper-V UEFI Release v4.1 03/08/2024
May 27 03:19:18.213066 kernel: DMI: Memory slots populated: 3/3
May 27 03:19:18.213073 kernel: Hypervisor detected: Microsoft Hyper-V
May 27 03:19:18.213081 kernel: Hyper-V: privilege flags low 0x2e7f, high 0x3b8030, hints 0x62c2c, misc 0xed7b2
May 27 03:19:18.213091 kernel: Hyper-V: LAPIC Timer Frequency: 0x30d40
May 27 03:19:18.213098 kernel: Hyper-V: Using hypercall for remote TLB flush
May 27 03:19:18.213106 kernel: clocksource: hyperv_clocksource_tsc_page: mask: 0xffffffffffffffff max_cycles: 0x24e6a1710, max_idle_ns: 440795202120 ns
May 27 03:19:18.213127 kernel: clocksource: hyperv_clocksource_msr: mask: 0xffffffffffffffff max_cycles: 0x24e6a1710, max_idle_ns: 440795202120 ns
May 27 03:19:18.213136 kernel: tsc: Marking TSC unstable due to running on Hyper-V
May 27 03:19:18.213144 kernel: tsc: Detected 2593.993 MHz processor
May 27 03:19:18.213152 kernel: e820: update [mem 0x00000000-0x00000fff] usable ==> reserved
May 27 03:19:18.213160 kernel: e820: remove [mem 0x000a0000-0x000fffff] usable
May 27 03:19:18.213168 kernel: last_pfn = 0x5cc0000 max_arch_pfn = 0x400000000
May 27 03:19:18.213179 kernel: MTRR map: 5 entries (2 fixed + 3 variable; max 18), built from 8 variable MTRRs
May 27 03:19:18.213187 kernel: x86/PAT: Configuration [0-7]: WB  WC  UC- UC  WB  WP  UC- WT  
May 27 03:19:18.213194 kernel: e820: update [mem 0x40000000-0xffffffff] usable ==> reserved
May 27 03:19:18.213202 kernel: e820: update [mem 0x1100000000-0x4fdfffffff] usable ==> reserved
May 27 03:19:18.213210 kernel: last_pfn = 0x40000 max_arch_pfn = 0x400000000
May 27 03:19:18.213218 kernel: Using GB pages for direct mapping
May 27 03:19:18.213226 kernel: ACPI: Early table checksum verification disabled
May 27 03:19:18.213237 kernel: ACPI: RSDP 0x000000003FFFA014 000024 (v02 VRTUAL)
May 27 03:19:18.213247 kernel: ACPI: XSDT 0x000000003FFF90E8 000064 (v01 VRTUAL MICROSFT 00000001 MSFT 00000001)
May 27 03:19:18.213256 kernel: ACPI: FACP 0x000000003FFF8000 000114 (v06 VRTUAL MICROSFT 00000001 MSFT 00000001)
May 27 03:19:18.213264 kernel: ACPI: DSDT 0x000000003FFD6000 01E184 (v02 MSFTVM DSDT01   00000001 MSFT 05000000)
May 27 03:19:18.213272 kernel: ACPI: FACS 0x000000003FFFE000 000040
May 27 03:19:18.213280 kernel: ACPI: OEM0 0x000000003FFF7000 000064 (v01 VRTUAL MICROSFT 00000001 MSFT 00000001)
May 27 03:19:18.213288 kernel: ACPI: SPCR 0x000000003FFF6000 000050 (v02 VRTUAL MICROSFT 00000001 MSFT 00000001)
May 27 03:19:18.213299 kernel: ACPI: WAET 0x000000003FFF5000 000028 (v01 VRTUAL MICROSFT 00000001 MSFT 00000001)
May 27 03:19:18.213307 kernel: ACPI: APIC 0x000000003FFD5000 000078 (v04 VRTUAL MICROSFT 00000001 MSFT 00000001)
May 27 03:19:18.213315 kernel: ACPI: SRAT 0x000000003FFD4000 0001D0 (v02 VRTUAL MICROSFT 00000001 MSFT 00000001)
May 27 03:19:18.213323 kernel: ACPI: BGRT 0x000000003FFD3000 000038 (v01 VRTUAL MICROSFT 00000001 MSFT 00000001)
May 27 03:19:18.213332 kernel: ACPI: FPDT 0x000000003FFD2000 000034 (v01 VRTUAL MICROSFT 00000001 MSFT 00000001)
May 27 03:19:18.213340 kernel: ACPI: Reserving FACP table memory at [mem 0x3fff8000-0x3fff8113]
May 27 03:19:18.213348 kernel: ACPI: Reserving DSDT table memory at [mem 0x3ffd6000-0x3fff4183]
May 27 03:19:18.213356 kernel: ACPI: Reserving FACS table memory at [mem 0x3fffe000-0x3fffe03f]
May 27 03:19:18.213366 kernel: ACPI: Reserving OEM0 table memory at [mem 0x3fff7000-0x3fff7063]
May 27 03:19:18.213375 kernel: ACPI: Reserving SPCR table memory at [mem 0x3fff6000-0x3fff604f]
May 27 03:19:18.213383 kernel: ACPI: Reserving WAET table memory at [mem 0x3fff5000-0x3fff5027]
May 27 03:19:18.213391 kernel: ACPI: Reserving APIC table memory at [mem 0x3ffd5000-0x3ffd5077]
May 27 03:19:18.213399 kernel: ACPI: Reserving SRAT table memory at [mem 0x3ffd4000-0x3ffd41cf]
May 27 03:19:18.213412 kernel: ACPI: Reserving BGRT table memory at [mem 0x3ffd3000-0x3ffd3037]
May 27 03:19:18.213427 kernel: ACPI: Reserving FPDT table memory at [mem 0x3ffd2000-0x3ffd2033]
May 27 03:19:18.213435 kernel: ACPI: SRAT: Node 0 PXM 0 [mem 0x00000000-0x3fffffff] hotplug
May 27 03:19:18.213448 kernel: ACPI: SRAT: Node 0 PXM 0 [mem 0x100000000-0xfdfffffff] hotplug
May 27 03:19:18.213460 kernel: ACPI: SRAT: Node 0 PXM 0 [mem 0x4fe0000000-0x5cbfffffff] hotplug
May 27 03:19:18.213468 kernel: ACPI: SRAT: Node 0 PXM 0 [mem 0x5cc0200000-0xffffffffff] hotplug
May 27 03:19:18.213481 kernel: ACPI: SRAT: Node 0 PXM 0 [mem 0x10000200000-0x1ffffffffff] hotplug
May 27 03:19:18.213494 kernel: ACPI: SRAT: Node 0 PXM 0 [mem 0x20000200000-0x3ffffffffff] hotplug
May 27 03:19:18.213502 kernel: ACPI: SRAT: Node 0 PXM 0 [mem 0x40000200000-0x7ffffffffff] hotplug
May 27 03:19:18.213511 kernel: ACPI: SRAT: Node 0 PXM 0 [mem 0x80000200000-0xfffffffffff] hotplug
May 27 03:19:18.213519 kernel: NUMA: Node 0 [mem 0x00001000-0x3fffffff] + [mem 0x100000000-0xfdfffffff] -> [mem 0x00001000-0xfdfffffff]
May 27 03:19:18.213528 kernel: NUMA: Node 0 [mem 0x00001000-0xfdfffffff] + [mem 0x4fe0000000-0x5cbfffffff] -> [mem 0x00001000-0x5cbfffffff]
May 27 03:19:18.213536 kernel: NODE_DATA(0) allocated [mem 0x5cbfff7dc0-0x5cbfffefff]
May 27 03:19:18.213547 kernel: Zone ranges:
May 27 03:19:18.213556 kernel:   DMA      [mem 0x0000000000001000-0x0000000000ffffff]
May 27 03:19:18.213564 kernel:   DMA32    [mem 0x0000000001000000-0x00000000ffffffff]
May 27 03:19:18.213572 kernel:   Normal   [mem 0x0000000100000000-0x0000005cbfffffff]
May 27 03:19:18.213580 kernel:   Device   empty
May 27 03:19:18.213588 kernel: Movable zone start for each node
May 27 03:19:18.213596 kernel: Early memory node ranges
May 27 03:19:18.213605 kernel:   node   0: [mem 0x0000000000001000-0x000000000009ffff]
May 27 03:19:18.213613 kernel:   node   0: [mem 0x0000000000100000-0x000000003ff40fff]
May 27 03:19:18.213624 kernel:   node   0: [mem 0x000000003ffff000-0x000000003fffffff]
May 27 03:19:18.213632 kernel:   node   0: [mem 0x0000000100000000-0x0000000fdfffffff]
May 27 03:19:18.213640 kernel:   node   0: [mem 0x0000004fe0000000-0x0000005cbfffffff]
May 27 03:19:18.213652 kernel: Initmem setup node 0 [mem 0x0000000000001000-0x0000005cbfffffff]
May 27 03:19:18.213660 kernel: On node 0, zone DMA: 1 pages in unavailable ranges
May 27 03:19:18.213668 kernel: On node 0, zone DMA: 96 pages in unavailable ranges
May 27 03:19:18.213676 kernel: On node 0, zone DMA32: 190 pages in unavailable ranges
May 27 03:19:18.213684 kernel: ACPI: PM-Timer IO Port: 0x408
May 27 03:19:18.213693 kernel: ACPI: LAPIC_NMI (acpi_id[0x01] dfl dfl lint[0x1])
May 27 03:19:18.213703 kernel: IOAPIC[0]: apic_id 6, version 17, address 0xfec00000, GSI 0-23
May 27 03:19:18.213712 kernel: ACPI: INT_SRC_OVR (bus 0 bus_irq 9 global_irq 9 high level)
May 27 03:19:18.213720 kernel: ACPI: Using ACPI (MADT) for SMP configuration information
May 27 03:19:18.213728 kernel: ACPI: SPCR: console: uart,io,0x3f8,115200
May 27 03:19:18.213736 kernel: CPU topo: Max. logical packages:   1
May 27 03:19:18.213744 kernel: CPU topo: Max. logical dies:       1
May 27 03:19:18.213753 kernel: CPU topo: Max. dies per package:   1
May 27 03:19:18.213761 kernel: CPU topo: Max. threads per core:   1
May 27 03:19:18.213769 kernel: CPU topo: Num. cores per package:     6
May 27 03:19:18.213779 kernel: CPU topo: Num. threads per package:   6
May 27 03:19:18.213788 kernel: CPU topo: Allowing 6 present CPUs plus 0 hotplug CPUs
May 27 03:19:18.213796 kernel: [mem 0x40000000-0xffffffff] available for PCI devices
May 27 03:19:18.213804 kernel: Booting paravirtualized kernel on Hyper-V
May 27 03:19:18.213812 kernel: clocksource: refined-jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1910969940391419 ns
May 27 03:19:18.213820 kernel: setup_percpu: NR_CPUS:512 nr_cpumask_bits:6 nr_cpu_ids:6 nr_node_ids:1
May 27 03:19:18.213829 kernel: percpu: Embedded 60 pages/cpu s207832 r8192 d29736 u262144
May 27 03:19:18.213837 kernel: pcpu-alloc: s207832 r8192 d29736 u262144 alloc=1*2097152
May 27 03:19:18.213845 kernel: pcpu-alloc: [0] 0 1 2 3 4 5 - - 
May 27 03:19:18.213855 kernel: Hyper-V: PV spinlocks enabled
May 27 03:19:18.213863 kernel: PV qspinlock hash table entries: 256 (order: 0, 4096 bytes, linear)
May 27 03:19:18.213873 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=f6c186658a19d5a08471ef76df75f82494b37b46908f9237b2c3cf497da860c6
May 27 03:19:18.213881 kernel: Unknown kernel command line parameters "BOOT_IMAGE=/flatcar/vmlinuz-a", will be passed to user space.
May 27 03:19:18.213889 kernel: Dentry cache hash table entries: 8388608 (order: 14, 67108864 bytes, linear)
May 27 03:19:18.213898 kernel: Inode-cache hash table entries: 4194304 (order: 13, 33554432 bytes, linear)
May 27 03:19:18.213906 kernel: Fallback order for Node 0: 0 
May 27 03:19:18.213914 kernel: Built 1 zonelists, mobility grouping on.  Total pages: 29359841
May 27 03:19:18.213925 kernel: Policy zone: Normal
May 27 03:19:18.213940 kernel: mem auto-init: stack:off, heap alloc:off, heap free:off
May 27 03:19:18.213949 kernel: software IO TLB: area num 8.
May 27 03:19:18.213960 kernel: SLUB: HWalign=64, Order=0-3, MinObjects=0, CPUs=6, Nodes=1
May 27 03:19:18.213969 kernel: Kernel/User page tables isolation: enabled
May 27 03:19:18.213977 kernel: ftrace: allocating 40081 entries in 157 pages
May 27 03:19:18.213986 kernel: ftrace: allocated 157 pages with 5 groups
May 27 03:19:18.213994 kernel: Dynamic Preempt: voluntary
May 27 03:19:18.214003 kernel: rcu: Preemptible hierarchical RCU implementation.
May 27 03:19:18.214016 kernel: rcu:         RCU event tracing is enabled.
May 27 03:19:18.214025 kernel: rcu:         RCU restricting CPUs from NR_CPUS=512 to nr_cpu_ids=6.
May 27 03:19:18.214033 kernel:         Trampoline variant of Tasks RCU enabled.
May 27 03:19:18.214045 kernel:         Rude variant of Tasks RCU enabled.
May 27 03:19:18.214053 kernel:         Tracing variant of Tasks RCU enabled.
May 27 03:19:18.214062 kernel: rcu: RCU calculated value of scheduler-enlistment delay is 100 jiffies.
May 27 03:19:18.214071 kernel: rcu: Adjusting geometry for rcu_fanout_leaf=16, nr_cpu_ids=6
May 27 03:19:18.214079 kernel: RCU Tasks: Setting shift to 3 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=6.
May 27 03:19:18.214090 kernel: RCU Tasks Rude: Setting shift to 3 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=6.
May 27 03:19:18.214099 kernel: RCU Tasks Trace: Setting shift to 3 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=6.
May 27 03:19:18.214116 kernel: Using NULL legacy PIC
May 27 03:19:18.214126 kernel: NR_IRQS: 33024, nr_irqs: 472, preallocated irqs: 0
May 27 03:19:18.214135 kernel: rcu: srcu_init: Setting srcu_struct sizes based on contention.
May 27 03:19:18.214143 kernel: Console: colour dummy device 80x25
May 27 03:19:18.214152 kernel: printk: legacy console [tty1] enabled
May 27 03:19:18.214161 kernel: printk: legacy console [ttyS0] enabled
May 27 03:19:18.214174 kernel: printk: legacy bootconsole [earlyser0] disabled
May 27 03:19:18.214219 kernel: ACPI: Core revision 20240827
May 27 03:19:18.214236 kernel: Failed to register legacy timer interrupt
May 27 03:19:18.214245 kernel: APIC: Switch to symmetric I/O mode setup
May 27 03:19:18.214253 kernel: Hyper-V: Host Build 10.0.20348.1827-1-0
May 27 03:19:18.214267 kernel: Hyper-V: enabling crash_kexec_post_notifiers
May 27 03:19:18.214278 kernel: Hyper-V: Using IPI hypercalls
May 27 03:19:18.214286 kernel: APIC: send_IPI() replaced with hv_send_ipi()
May 27 03:19:18.214295 kernel: APIC: send_IPI_mask() replaced with hv_send_ipi_mask()
May 27 03:19:18.214304 kernel: APIC: send_IPI_mask_allbutself() replaced with hv_send_ipi_mask_allbutself()
May 27 03:19:18.214317 kernel: APIC: send_IPI_allbutself() replaced with hv_send_ipi_allbutself()
May 27 03:19:18.214326 kernel: APIC: send_IPI_all() replaced with hv_send_ipi_all()
May 27 03:19:18.214334 kernel: APIC: send_IPI_self() replaced with hv_send_ipi_self()
May 27 03:19:18.214343 kernel: Hyper-V: Using enlightened APIC (xapic mode)
May 27 03:19:18.214352 kernel: APIC: eoi() replaced with hv_apic_eoi_write()
May 27 03:19:18.214360 kernel: APIC: read() replaced with hv_apic_read()
May 27 03:19:18.214369 kernel: APIC: write() replaced with hv_apic_write()
May 27 03:19:18.214378 kernel: APIC: icr_write() replaced with hv_apic_icr_write()
May 27 03:19:18.214386 kernel: APIC: icr_read() replaced with hv_apic_icr_read()
May 27 03:19:18.214397 kernel: Calibrating delay loop (skipped), value calculated using timer frequency.. 5187.98 BogoMIPS (lpj=2593993)
May 27 03:19:18.214406 kernel: Last level iTLB entries: 4KB 128, 2MB 8, 4MB 8
May 27 03:19:18.214415 kernel: Last level dTLB entries: 4KB 64, 2MB 32, 4MB 32, 1GB 4
May 27 03:19:18.214423 kernel: Spectre V1 : Mitigation: usercopy/swapgs barriers and __user pointer sanitization
May 27 03:19:18.214432 kernel: Spectre V2 : Mitigation: Retpolines
May 27 03:19:18.214447 kernel: Spectre V2 : Spectre v2 / SpectreRSB: Filling RSB on context switch and VMEXIT
May 27 03:19:18.214461 kernel: Speculative Store Bypass: Vulnerable
May 27 03:19:18.214470 kernel: MDS: Mitigation: Clear CPU buffers
May 27 03:19:18.214478 kernel: TAA: Mitigation: Clear CPU buffers
May 27 03:19:18.214486 kernel: MMIO Stale Data: Vulnerable: Clear CPU buffers attempted, no microcode
May 27 03:19:18.214498 kernel: ITS: Mitigation: Aligned branch/return thunks
May 27 03:19:18.214510 kernel: x86/fpu: Supporting XSAVE feature 0x001: 'x87 floating point registers'
May 27 03:19:18.214518 kernel: x86/fpu: Supporting XSAVE feature 0x002: 'SSE registers'
May 27 03:19:18.214527 kernel: x86/fpu: Supporting XSAVE feature 0x004: 'AVX registers'
May 27 03:19:18.214535 kernel: x86/fpu: xstate_offset[2]:  576, xstate_sizes[2]:  256
May 27 03:19:18.214544 kernel: x86/fpu: Enabled xstate features 0x7, context size is 832 bytes, using 'standard' format.
May 27 03:19:18.214553 kernel: Freeing SMP alternatives memory: 32K
May 27 03:19:18.214561 kernel: pid_max: default: 32768 minimum: 301
May 27 03:19:18.214570 kernel: LSM: initializing lsm=lockdown,capability,landlock,selinux,ima
May 27 03:19:18.214578 kernel: landlock: Up and running.
May 27 03:19:18.214587 kernel: SELinux:  Initializing.
May 27 03:19:18.214598 kernel: Mount-cache hash table entries: 131072 (order: 8, 1048576 bytes, linear)
May 27 03:19:18.214606 kernel: Mountpoint-cache hash table entries: 131072 (order: 8, 1048576 bytes, linear)
May 27 03:19:18.214615 kernel: smpboot: CPU0: Intel(R) Xeon(R) CPU E5-2690 v4 @ 2.60GHz (family: 0x6, model: 0x4f, stepping: 0x1)
May 27 03:19:18.214624 kernel: Performance Events: unsupported p6 CPU model 79 no PMU driver, software events only.
May 27 03:19:18.214632 kernel: signal: max sigframe size: 1776
May 27 03:19:18.214641 kernel: rcu: Hierarchical SRCU implementation.
May 27 03:19:18.214650 kernel: rcu:         Max phase no-delay instances is 400.
May 27 03:19:18.214659 kernel: Timer migration: 1 hierarchy levels; 8 children per group; 1 crossnode level
May 27 03:19:18.214668 kernel: NMI watchdog: Perf NMI watchdog permanently disabled
May 27 03:19:18.214676 kernel: smp: Bringing up secondary CPUs ...
May 27 03:19:18.214687 kernel: smpboot: x86: Booting SMP configuration:
May 27 03:19:18.214696 kernel: .... node  #0, CPUs:      #1 #2 #3 #4 #5
May 27 03:19:18.214705 kernel: smp: Brought up 1 node, 6 CPUs
May 27 03:19:18.214713 kernel: smpboot: Total of 6 processors activated (31127.91 BogoMIPS)
May 27 03:19:18.214722 kernel: Memory: 115339092K/117439364K available (14336K kernel code, 2430K rwdata, 9952K rodata, 54416K init, 2552K bss, 2089996K reserved, 0K cma-reserved)
May 27 03:19:18.214731 kernel: devtmpfs: initialized
May 27 03:19:18.214742 kernel: x86/mm: Memory block size: 1024MB
May 27 03:19:18.214751 kernel: ACPI: PM: Registering ACPI NVS region [mem 0x3fffb000-0x3fffefff] (16384 bytes)
May 27 03:19:18.214760 kernel: clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1911260446275000 ns
May 27 03:19:18.214772 kernel: futex hash table entries: 2048 (order: 5, 131072 bytes, linear)
May 27 03:19:18.214780 kernel: pinctrl core: initialized pinctrl subsystem
May 27 03:19:18.214789 kernel: NET: Registered PF_NETLINK/PF_ROUTE protocol family
May 27 03:19:18.214798 kernel: audit: initializing netlink subsys (disabled)
May 27 03:19:18.214806 kernel: audit: type=2000 audit(1748315954.031:1): state=initialized audit_enabled=0 res=1
May 27 03:19:18.214815 kernel: thermal_sys: Registered thermal governor 'step_wise'
May 27 03:19:18.214823 kernel: thermal_sys: Registered thermal governor 'user_space'
May 27 03:19:18.214832 kernel: cpuidle: using governor menu
May 27 03:19:18.214841 kernel: acpiphp: ACPI Hot Plug PCI Controller Driver version: 0.5
May 27 03:19:18.214852 kernel: dca service started, version 1.12.1
May 27 03:19:18.214861 kernel: e820: reserve RAM buffer [mem 0x3ff41000-0x3fffffff]
May 27 03:19:18.214869 kernel: kprobes: kprobe jump-optimization is enabled. All kprobes are optimized if possible.
May 27 03:19:18.214878 kernel: HugeTLB: registered 1.00 GiB page size, pre-allocated 0 pages
May 27 03:19:18.214887 kernel: HugeTLB: 16380 KiB vmemmap can be freed for a 1.00 GiB page
May 27 03:19:18.214895 kernel: HugeTLB: registered 2.00 MiB page size, pre-allocated 0 pages
May 27 03:19:18.214904 kernel: HugeTLB: 28 KiB vmemmap can be freed for a 2.00 MiB page
May 27 03:19:18.214913 kernel: ACPI: Added _OSI(Module Device)
May 27 03:19:18.214921 kernel: ACPI: Added _OSI(Processor Device)
May 27 03:19:18.214932 kernel: ACPI: Added _OSI(3.0 _SCP Extensions)
May 27 03:19:18.214941 kernel: ACPI: Added _OSI(Processor Aggregator Device)
May 27 03:19:18.214950 kernel: ACPI: 1 ACPI AML tables successfully acquired and loaded
May 27 03:19:18.214958 kernel: ACPI: Interpreter enabled
May 27 03:19:18.214967 kernel: ACPI: PM: (supports S0 S5)
May 27 03:19:18.214975 kernel: ACPI: Using IOAPIC for interrupt routing
May 27 03:19:18.214984 kernel: PCI: Using host bridge windows from ACPI; if necessary, use "pci=nocrs" and report a bug
May 27 03:19:18.214993 kernel: PCI: Ignoring E820 reservations for host bridge windows
May 27 03:19:18.215001 kernel: ACPI: Enabled 1 GPEs in block 00 to 0F
May 27 03:19:18.215012 kernel: iommu: Default domain type: Translated
May 27 03:19:18.215021 kernel: iommu: DMA domain TLB invalidation policy: lazy mode
May 27 03:19:18.215030 kernel: efivars: Registered efivars operations
May 27 03:19:18.215038 kernel: PCI: Using ACPI for IRQ routing
May 27 03:19:18.215047 kernel: PCI: System does not support PCI
May 27 03:19:18.215056 kernel: vgaarb: loaded
May 27 03:19:18.215065 kernel: clocksource: Switched to clocksource hyperv_clocksource_tsc_page
May 27 03:19:18.215073 kernel: VFS: Disk quotas dquot_6.6.0
May 27 03:19:18.215082 kernel: VFS: Dquot-cache hash table entries: 512 (order 0, 4096 bytes)
May 27 03:19:18.215093 kernel: pnp: PnP ACPI init
May 27 03:19:18.215102 kernel: pnp: PnP ACPI: found 3 devices
May 27 03:19:18.215122 kernel: clocksource: acpi_pm: mask: 0xffffff max_cycles: 0xffffff, max_idle_ns: 2085701024 ns
May 27 03:19:18.215131 kernel: NET: Registered PF_INET protocol family
May 27 03:19:18.215140 kernel: IP idents hash table entries: 262144 (order: 9, 2097152 bytes, linear)
May 27 03:19:18.215149 kernel: tcp_listen_portaddr_hash hash table entries: 65536 (order: 8, 1048576 bytes, linear)
May 27 03:19:18.215158 kernel: Table-perturb hash table entries: 65536 (order: 6, 262144 bytes, linear)
May 27 03:19:18.215445 kernel: TCP established hash table entries: 524288 (order: 10, 4194304 bytes, linear)
May 27 03:19:18.215517 kernel: TCP bind hash table entries: 65536 (order: 9, 2097152 bytes, linear)
May 27 03:19:18.215530 kernel: TCP: Hash tables configured (established 524288 bind 65536)
May 27 03:19:18.215538 kernel: UDP hash table entries: 65536 (order: 9, 2097152 bytes, linear)
May 27 03:19:18.215547 kernel: UDP-Lite hash table entries: 65536 (order: 9, 2097152 bytes, linear)
May 27 03:19:18.215556 kernel: NET: Registered PF_UNIX/PF_LOCAL protocol family
May 27 03:19:18.215565 kernel: NET: Registered PF_XDP protocol family
May 27 03:19:18.215573 kernel: PCI: CLS 0 bytes, default 64
May 27 03:19:18.215582 kernel: PCI-DMA: Using software bounce buffering for IO (SWIOTLB)
May 27 03:19:18.215591 kernel: software IO TLB: mapped [mem 0x000000003ae61000-0x000000003ee61000] (64MB)
May 27 03:19:18.215603 kernel: RAPL PMU: API unit is 2^-32 Joules, 0 fixed counters, 10737418240 ms ovfl timer
May 27 03:19:18.215612 kernel: Initialise system trusted keyrings
May 27 03:19:18.215621 kernel: workingset: timestamp_bits=39 max_order=25 bucket_order=0
May 27 03:19:18.215629 kernel: Key type asymmetric registered
May 27 03:19:18.215638 kernel: Asymmetric key parser 'x509' registered
May 27 03:19:18.215646 kernel: Block layer SCSI generic (bsg) driver version 0.4 loaded (major 250)
May 27 03:19:18.215655 kernel: io scheduler mq-deadline registered
May 27 03:19:18.215663 kernel: io scheduler kyber registered
May 27 03:19:18.215672 kernel: io scheduler bfq registered
May 27 03:19:18.215681 kernel: ioatdma: Intel(R) QuickData Technology Driver 5.00
May 27 03:19:18.215692 kernel: Serial: 8250/16550 driver, 4 ports, IRQ sharing enabled
May 27 03:19:18.215700 kernel: 00:00: ttyS0 at I/O 0x3f8 (irq = 4, base_baud = 115200) is a 16550A
May 27 03:19:18.215709 kernel: 00:01: ttyS1 at I/O 0x2f8 (irq = 3, base_baud = 115200) is a 16550A
May 27 03:19:18.215718 kernel: i8042: PNP: No PS/2 controller found.
May 27 03:19:18.215876 kernel: rtc_cmos 00:02: registered as rtc0
May 27 03:19:18.215979 kernel: rtc_cmos 00:02: setting system clock to 2025-05-27T03:19:17 UTC (1748315957)
May 27 03:19:18.216074 kernel: rtc_cmos 00:02: alarms up to one month, 114 bytes nvram
May 27 03:19:18.216091 kernel: intel_pstate: CPU model not supported
May 27 03:19:18.216100 kernel: efifb: probing for efifb
May 27 03:19:18.216139 kernel: efifb: framebuffer at 0x40000000, using 3072k, total 3072k
May 27 03:19:18.216150 kernel: efifb: mode is 1024x768x32, linelength=4096, pages=1
May 27 03:19:18.216159 kernel: efifb: scrolling: redraw
May 27 03:19:18.216168 kernel: efifb: Truecolor: size=8:8:8:8, shift=24:16:8:0
May 27 03:19:18.216177 kernel: Console: switching to colour frame buffer device 128x48
May 27 03:19:18.216185 kernel: fb0: EFI VGA frame buffer device
May 27 03:19:18.216194 kernel: pstore: Using crash dump compression: deflate
May 27 03:19:18.216206 kernel: pstore: Registered efi_pstore as persistent store backend
May 27 03:19:18.216215 kernel: NET: Registered PF_INET6 protocol family
May 27 03:19:18.216223 kernel: Segment Routing with IPv6
May 27 03:19:18.216232 kernel: In-situ OAM (IOAM) with IPv6
May 27 03:19:18.216241 kernel: NET: Registered PF_PACKET protocol family
May 27 03:19:18.216250 kernel: Key type dns_resolver registered
May 27 03:19:18.216258 kernel: IPI shorthand broadcast: enabled
May 27 03:19:18.216267 kernel: sched_clock: Marking stable (3728005800, 108567700)->(4094995700, -258422200)
May 27 03:19:18.216276 kernel: registered taskstats version 1
May 27 03:19:18.216287 kernel: Loading compiled-in X.509 certificates
May 27 03:19:18.216295 kernel: Loaded X.509 cert 'Kinvolk GmbH: Module signing key for 6.12.30-flatcar: ba9eddccb334a70147f3ddfe4fbde029feaa991d'
May 27 03:19:18.216304 kernel: Demotion targets for Node 0: null
May 27 03:19:18.216313 kernel: Key type .fscrypt registered
May 27 03:19:18.216321 kernel: Key type fscrypt-provisioning registered
May 27 03:19:18.216330 kernel: ima: No TPM chip found, activating TPM-bypass!
May 27 03:19:18.216338 kernel: ima: Allocated hash algorithm: sha1
May 27 03:19:18.216347 kernel: ima: No architecture policies found
May 27 03:19:18.216356 kernel: clk: Disabling unused clocks
May 27 03:19:18.216366 kernel: Warning: unable to open an initial console.
May 27 03:19:18.216375 kernel: Freeing unused kernel image (initmem) memory: 54416K
May 27 03:19:18.216384 kernel: Write protecting the kernel read-only data: 24576k
May 27 03:19:18.216393 kernel: Freeing unused kernel image (rodata/data gap) memory: 288K
May 27 03:19:18.216401 kernel: Run /init as init process
May 27 03:19:18.216410 kernel:   with arguments:
May 27 03:19:18.216419 kernel:     /init
May 27 03:19:18.216427 kernel:   with environment:
May 27 03:19:18.216435 kernel:     HOME=/
May 27 03:19:18.216446 kernel:     TERM=linux
May 27 03:19:18.216455 kernel:     BOOT_IMAGE=/flatcar/vmlinuz-a
May 27 03:19:18.216465 systemd[1]: Successfully made /usr/ read-only.
May 27 03:19:18.216476 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 27 03:19:18.216486 systemd[1]: Detected virtualization microsoft.
May 27 03:19:18.216495 systemd[1]: Detected architecture x86-64.
May 27 03:19:18.216504 systemd[1]: Running in initrd.
May 27 03:19:18.216515 systemd[1]: No hostname configured, using default hostname.
May 27 03:19:18.216525 systemd[1]: Hostname set to <localhost>.
May 27 03:19:18.216534 systemd[1]: Initializing machine ID from random generator.
May 27 03:19:18.216543 systemd[1]: Queued start job for default target initrd.target.
May 27 03:19:18.216552 systemd[1]: Started clevis-luks-askpass.path - Forward Password Requests to Clevis Directory Watch.
May 27 03:19:18.216561 systemd[1]: Started systemd-ask-password-console.path - Dispatch Password Requests to Console Directory Watch.
May 27 03:19:18.216571 systemd[1]: Expecting device dev-disk-by\x2dlabel-EFI\x2dSYSTEM.device - /dev/disk/by-label/EFI-SYSTEM...
May 27 03:19:18.216580 systemd[1]: Expecting device dev-disk-by\x2dlabel-OEM.device - /dev/disk/by-label/OEM...
May 27 03:19:18.216592 systemd[1]: Expecting device dev-disk-by\x2dlabel-ROOT.device - /dev/disk/by-label/ROOT...
May 27 03:19:18.216603 systemd[1]: Expecting device dev-disk-by\x2dpartlabel-USR\x2dA.device - /dev/disk/by-partlabel/USR-A...
May 27 03:19:18.216613 systemd[1]: Expecting device dev-disk-by\x2dpartuuid-7130c94a\x2d213a\x2d4e5a\x2d8e26\x2d6cce9662f132.device - /dev/disk/by-partuuid/7130c94a-213a-4e5a-8e26-6cce9662f132...
May 27 03:19:18.216622 systemd[1]: Expecting device dev-mapper-usr.device - /dev/mapper/usr...
May 27 03:19:18.216631 systemd[1]: Reached target cryptsetup-pre.target - Local Encrypted Volumes (Pre).
May 27 03:19:18.216641 systemd[1]: Reached target cryptsetup.target - Local Encrypted Volumes.
May 27 03:19:18.216650 systemd[1]: Reached target paths.target - Path Units.
May 27 03:19:18.216661 systemd[1]: Reached target slices.target - Slice Units.
May 27 03:19:18.216671 systemd[1]: Reached target swap.target - Swaps.
May 27 03:19:18.216680 systemd[1]: Reached target timers.target - Timer Units.
May 27 03:19:18.216689 systemd[1]: Listening on iscsid.socket - Open-iSCSI iscsid Socket.
May 27 03:19:18.216698 systemd[1]: Listening on iscsiuio.socket - Open-iSCSI iscsiuio Socket.
May 27 03:19:18.216708 systemd[1]: Listening on systemd-journald-dev-log.socket - Journal Socket (/dev/log).
May 27 03:19:18.216717 systemd[1]: Listening on systemd-journald.socket - Journal Sockets.
May 27 03:19:18.216726 systemd[1]: Listening on systemd-networkd.socket - Network Service Netlink Socket.
May 27 03:19:18.216735 systemd[1]: Listening on systemd-udevd-control.socket - udev Control Socket.
May 27 03:19:18.216747 systemd[1]: Listening on systemd-udevd-kernel.socket - udev Kernel Socket.
May 27 03:19:18.216756 systemd[1]: Reached target sockets.target - Socket Units.
May 27 03:19:18.216765 systemd[1]: Starting ignition-setup-pre.service - Ignition env setup...
May 27 03:19:18.216775 systemd[1]: Starting kmod-static-nodes.service - Create List of Static Device Nodes...
May 27 03:19:18.216784 systemd[1]: Finished network-cleanup.service - Network Cleanup.
May 27 03:19:18.216793 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 27 03:19:18.216803 systemd[1]: Starting systemd-fsck-usr.service...
May 27 03:19:18.216812 systemd[1]: Starting systemd-journald.service - Journal Service...
May 27 03:19:18.216823 systemd[1]: Starting systemd-modules-load.service - Load Kernel Modules...
May 27 03:19:18.216833 systemd[1]: Starting systemd-vconsole-setup.service - Virtual Console Setup...
May 27 03:19:18.216863 systemd-journald[232]: Collecting audit messages is disabled.
May 27 03:19:18.216885 systemd[1]: Finished ignition-setup-pre.service - Ignition env setup.
May 27 03:19:18.216899 systemd-journald[232]: Journal started
May 27 03:19:18.216925 systemd-journald[232]: Runtime Journal (/run/log/journal/0c39ddaf5b5946d9aa75d2a7fa49cebb) is 8M, max 2.2G, 2.1G free.
May 27 03:19:18.214480 systemd-modules-load[234]: Inserted module 'overlay'
May 27 03:19:18.225267 systemd[1]: Started systemd-journald.service - Journal Service.
May 27 03:19:18.225616 systemd[1]: Finished kmod-static-nodes.service - Create List of Static Device Nodes.
May 27 03:19:18.226182 systemd[1]: Finished systemd-fsck-usr.service.
May 27 03:19:18.251009 systemd[1]: Starting systemd-tmpfiles-setup-dev-early.service - Create Static Device Nodes in /dev gracefully...
May 27 03:19:18.253205 systemd[1]: Starting systemd-tmpfiles-setup.service - Create System Files and Directories...
May 27 03:19:18.278194 systemd-tmpfiles[245]: /usr/lib/tmpfiles.d/var.conf:14: Duplicate line for path "/var/log", ignoring.
May 27 03:19:18.284407 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 27 03:19:18.279352 systemd[1]: Finished systemd-tmpfiles-setup-dev-early.service - Create Static Device Nodes in /dev gracefully.
May 27 03:19:18.294169 systemd[1]: Finished systemd-vconsole-setup.service - Virtual Console Setup.
May 27 03:19:18.296194 systemd[1]: Finished systemd-tmpfiles-setup.service - Create System Files and Directories.
May 27 03:19:18.313412 kernel: Bridge firewalling registered
May 27 03:19:18.320362 systemd-modules-load[234]: Inserted module 'br_netfilter'
May 27 03:19:18.321122 systemd[1]: Finished systemd-modules-load.service - Load Kernel Modules.
May 27 03:19:18.332848 systemd[1]: Starting dracut-cmdline-ask.service - dracut ask for additional cmdline parameters...
May 27 03:19:18.343514 systemd[1]: Starting systemd-sysctl.service - Apply Kernel Variables...
May 27 03:19:18.365622 systemd[1]: Starting systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev...
May 27 03:19:18.380666 systemd[1]: Finished systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev.
May 27 03:19:18.386028 systemd[1]: Finished systemd-sysctl.service - Apply Kernel Variables.
May 27 03:19:18.395811 systemd[1]: Finished dracut-cmdline-ask.service - dracut ask for additional cmdline parameters.
May 27 03:19:18.398913 systemd[1]: Starting dracut-cmdline.service - dracut cmdline hook...
May 27 03:19:18.417484 systemd[1]: Starting systemd-resolved.service - Network Name Resolution...
May 27 03:19:18.457883 dracut-cmdline[272]: 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=f6c186658a19d5a08471ef76df75f82494b37b46908f9237b2c3cf497da860c6
May 27 03:19:18.473398 systemd-resolved[273]: Positive Trust Anchors:
May 27 03:19:18.473409 systemd-resolved[273]: . IN DS 20326 8 2 e06d44b80b8f1d39a95c0b0d7c65d08458e880409bbc683457104237c7f8ec8d
May 27 03:19:18.473441 systemd-resolved[273]: 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 27 03:19:18.476008 systemd-resolved[273]: Defaulting to hostname 'linux'.
May 27 03:19:18.477032 systemd[1]: Started systemd-resolved.service - Network Name Resolution.
May 27 03:19:18.483960 systemd[1]: Reached target nss-lookup.target - Host and Network Name Lookups.
May 27 03:19:18.617137 kernel: SCSI subsystem initialized
May 27 03:19:18.629133 kernel: Loading iSCSI transport class v2.0-870.
May 27 03:19:18.641132 kernel: iscsi: registered transport (tcp)
May 27 03:19:18.664828 kernel: iscsi: registered transport (qla4xxx)
May 27 03:19:18.664861 kernel: QLogic iSCSI HBA Driver
May 27 03:19:18.683590 systemd[1]: Starting systemd-network-generator.service - Generate network units from Kernel command line...
May 27 03:19:18.716643 systemd[1]: Finished systemd-network-generator.service - Generate network units from Kernel command line.
May 27 03:19:18.727724 systemd[1]: Reached target network-pre.target - Preparation for Network.
May 27 03:19:18.773516 systemd[1]: Finished dracut-cmdline.service - dracut cmdline hook.
May 27 03:19:18.776330 systemd[1]: Starting dracut-pre-udev.service - dracut pre-udev hook...
May 27 03:19:18.846137 kernel: raid6: avx2x4   gen() 31108 MB/s
May 27 03:19:18.865131 kernel: raid6: avx2x2   gen() 29062 MB/s
May 27 03:19:18.886317 kernel: raid6: avx2x1   gen() 27911 MB/s
May 27 03:19:18.886349 kernel: raid6: using algorithm avx2x4 gen() 31108 MB/s
May 27 03:19:18.909235 kernel: raid6: .... xor() 10783 MB/s, rmw enabled
May 27 03:19:18.909263 kernel: raid6: using avx2x2 recovery algorithm
May 27 03:19:18.932131 kernel: xor: automatically using best checksumming function   avx       
May 27 03:19:19.105141 kernel: Btrfs loaded, zoned=no, fsverity=no
May 27 03:19:19.111645 systemd[1]: Finished dracut-pre-udev.service - dracut pre-udev hook.
May 27 03:19:19.121384 systemd[1]: Starting systemd-udevd.service - Rule-based Manager for Device Events and Files...
May 27 03:19:19.154620 systemd-udevd[485]: Using default interface naming scheme 'v255'.
May 27 03:19:19.160644 systemd[1]: Started systemd-udevd.service - Rule-based Manager for Device Events and Files.
May 27 03:19:19.162883 systemd[1]: Starting dracut-pre-trigger.service - dracut pre-trigger hook...
May 27 03:19:19.204465 dracut-pre-trigger[493]: rd.md=0: removing MD RAID activation
May 27 03:19:19.231056 systemd[1]: Finished dracut-pre-trigger.service - dracut pre-trigger hook.
May 27 03:19:19.233579 systemd[1]: Starting systemd-udev-trigger.service - Coldplug All udev Devices...
May 27 03:19:19.312341 systemd[1]: Finished systemd-udev-trigger.service - Coldplug All udev Devices.
May 27 03:19:19.314960 systemd[1]: Starting dracut-initqueue.service - dracut initqueue hook...
May 27 03:19:19.342141 kernel: cryptd: max_cpu_qlen set to 1000
May 27 03:19:19.358143 kernel: AES CTR mode by8 optimization enabled
May 27 03:19:19.358183 kernel: hv_vmbus: Vmbus version:4.0
May 27 03:19:19.360455 systemd[1]: systemd-vconsole-setup.service: Deactivated successfully.
May 27 03:19:19.360625 systemd[1]: Stopped systemd-vconsole-setup.service - Virtual Console Setup.
May 27 03:19:19.374558 systemd[1]: Stopping systemd-vconsole-setup.service - Virtual Console Setup...
May 27 03:19:19.378208 systemd[1]: Starting systemd-vconsole-setup.service - Virtual Console Setup...
May 27 03:19:19.393178 systemd[1]: run-credentials-systemd\x2dvconsole\x2dsetup.service.mount: Deactivated successfully.
May 27 03:19:19.408734 kernel: hv_vmbus: registering driver hyperv_keyboard
May 27 03:19:19.408758 kernel: input: AT Translated Set 2 keyboard as /devices/LNXSYSTM:00/LNXSYBUS:00/ACPI0004:00/VMBUS:00/d34b2567-b9b6-42b9-8778-0a4ec0b955bf/serio0/input/input0
May 27 03:19:19.416570 kernel: pps_core: LinuxPPS API ver. 1 registered
May 27 03:19:19.416607 kernel: pps_core: Software ver. 5.3.6 - Copyright 2005-2007 Rodolfo Giometti <giometti@linux.it>
May 27 03:19:19.417137 kernel: hid: raw HID events driver (C) Jiri Kosina
May 27 03:19:19.422287 kernel: hv_vmbus: registering driver hv_pci
May 27 03:19:19.423131 kernel: hv_pci 47505500-0001-0000-3130-444531444234: PCI VMBus probing: Using version 0x10004
May 27 03:19:19.428128 kernel: hv_vmbus: registering driver hv_storvsc
May 27 03:19:19.428163 kernel: PTP clock support registered
May 27 03:19:19.430131 kernel: hv_pci 47505500-0001-0000-3130-444531444234: PCI host bridge to bus 0001:00
May 27 03:19:19.430296 kernel: scsi host0: storvsc_host_t
May 27 03:19:19.436309 kernel: scsi host1: storvsc_host_t
May 27 03:19:19.436352 kernel: pci_bus 0001:00: root bus resource [mem 0x41000000-0x41ffffff window]
May 27 03:19:19.440150 kernel: scsi 1:0:0:0: Direct-Access     Msft     Virtual Disk     1.0  PQ: 0 ANSI: 5
May 27 03:19:19.440209 kernel: pci_bus 0001:00: root bus resource [mem 0x1000000000-0x1401ffffff window]
May 27 03:19:19.447743 kernel: scsi 1:0:0:1: Direct-Access     Msft     Virtual Disk     1.0  PQ: 0 ANSI: 5
May 27 03:19:19.447783 kernel: pci_bus 0001:00: No busn resource found for root bus, will use [bus 00-ff]
May 27 03:19:19.452173 kernel: scsi 1:0:0:2: CD-ROM            Msft     Virtual DVD-ROM  1.0  PQ: 0 ANSI: 0
May 27 03:19:19.456124 kernel: pci 0001:00:00.0: [10de:1db4] type 00 class 0x030200 PCIe Endpoint
May 27 03:19:19.473039 kernel: pci 0001:00:00.0: BAR 0 [mem 0x41000000-0x41ffffff]
May 27 03:19:19.480172 kernel: pci 0001:00:00.0: BAR 1 [mem 0x1000000000-0x13ffffffff 64bit pref]
May 27 03:19:19.485188 kernel: pci 0001:00:00.0: BAR 3 [mem 0x1400000000-0x1401ffffff 64bit pref]
May 27 03:19:19.485464 systemd[1]: Finished systemd-vconsole-setup.service - Virtual Console Setup.
May 27 03:19:19.497318 kernel: pci 0001:00:00.0: Enabling HDA controller
May 27 03:19:19.506137 kernel: hv_vmbus: registering driver hv_netvsc
May 27 03:19:19.506177 kernel: hv_utils: Registering HyperV Utility Driver
May 27 03:19:19.506200 kernel: hv_vmbus: registering driver hid_hyperv
May 27 03:19:19.506215 kernel: sd 1:0:0:1: [sdb] 1543503872 512-byte logical blocks: (790 GB/736 GiB)
May 27 03:19:19.506416 kernel: sd 1:0:0:1: [sdb] 4096-byte physical blocks
May 27 03:19:19.506595 kernel: sd 1:0:0:0: [sda] 63737856 512-byte logical blocks: (32.6 GB/30.4 GiB)
May 27 03:19:19.506750 kernel: sd 1:0:0:0: [sda] 4096-byte physical blocks
May 27 03:19:19.506885 kernel: sd 1:0:0:1: [sdb] Write Protect is off
May 27 03:19:19.507013 kernel: sd 1:0:0:1: [sdb] Mode Sense: 0f 00 10 00
May 27 03:19:19.507164 kernel: sd 1:0:0:0: [sda] Write Protect is off
May 27 03:19:19.507296 kernel: sd 1:0:0:0: [sda] Mode Sense: 0f 00 10 00
May 27 03:19:19.507423 kernel: sd 1:0:0:0: [sda] Write cache: disabled, read cache: enabled, supports DPO and FUA
May 27 03:19:19.507551 kernel: input: Microsoft Vmbus HID-compliant Mouse as /devices/0006:045E:0621.0001/input/input1
May 27 03:19:19.507569 kernel: hid-hyperv 0006:045E:0621.0001: input: VIRTUAL HID v0.01 Mouse [Microsoft Vmbus HID-compliant Mouse] on 
May 27 03:19:19.507707 kernel: hv_storvsc f8b3781a-1e82-4818-a1c3-63d806ec15bb: tag#453 cmd 0x5a status: scsi 0x2 srb 0x86 hv 0xc0000001
May 27 03:19:19.507832 kernel: sd 1:0:0:1: [sdb] Write cache: disabled, read cache: enabled, supports DPO and FUA
May 27 03:19:19.507963 kernel: hv_vmbus: registering driver hv_utils
May 27 03:19:19.507976 kernel: hv_storvsc f8b3781a-1e82-4818-a1c3-63d806ec15bb: tag#517 cmd 0x5a status: scsi 0x2 srb 0x86 hv 0xc0000001
May 27 03:19:19.513144 kernel: hv_utils: Heartbeat IC version 3.0
May 27 03:19:19.518838 kernel: pci_bus 0001:00: busn_res: [bus 00-ff] end is updated to 00
May 27 03:19:19.519040 kernel: hv_utils: Shutdown IC version 3.2
May 27 03:19:19.519055 kernel: pci 0001:00:00.0: BAR 1 [mem 0x1000000000-0x13ffffffff 64bit pref]: assigned
May 27 03:19:19.521121 kernel: hv_storvsc f8b3781a-1e82-4818-a1c3-63d806ec15bb: tag#3 cmd 0x5a status: scsi 0x2 srb 0x86 hv 0xc0000001
May 27 03:19:19.524137 kernel: hv_storvsc f8b3781a-1e82-4818-a1c3-63d806ec15bb: tag#452 cmd 0x5a status: scsi 0x2 srb 0x86 hv 0xc0000001
May 27 03:19:19.524307 kernel: hv_utils: TimeSync IC version 4.0
May 27 03:19:20.053772 systemd-resolved[273]: Clock change detected. Flushing caches.
May 27 03:19:20.123223 kernel: pci 0001:00:00.0: BAR 3 [mem 0x1400000000-0x1401ffffff 64bit pref]: assigned
May 27 03:19:20.123404 kernel: pci 0001:00:00.0: BAR 0 [mem 0x41000000-0x41ffffff]: assigned
May 27 03:19:20.131880 kernel:  sda: sda1 sda2 sda3 sda4 sda6 sda7 sda9
May 27 03:19:20.134871 kernel: sd 1:0:0:0: [sda] Attached SCSI disk
May 27 03:19:20.135053 kernel:  sdb: sdb1
May 27 03:19:20.138715 kernel: sd 1:0:0:1: [sdb] Attached SCSI disk
May 27 03:19:20.147051 kernel: sr 1:0:0:2: [sr0] scsi-1 drive
May 27 03:19:20.147245 kernel: cdrom: Uniform CD-ROM driver Revision: 3.20
May 27 03:19:20.149885 kernel: sr 1:0:0:2: Attached scsi CD-ROM sr0
May 27 03:19:20.747784 systemd[1]: Found device dev-disk-by\x2dlabel-OEM.device - Virtual_Disk OEM.
May 27 03:19:20.848653 systemd[1]: Found device dev-disk-by\x2dlabel-ROOT.device - Virtual_Disk ROOT.
May 27 03:19:20.879152 systemd[1]: Found device dev-disk-by\x2dlabel-EFI\x2dSYSTEM.device - Virtual_Disk EFI-SYSTEM.
May 27 03:19:20.911439 systemd[1]: Found device dev-disk-by\x2dpartlabel-USR\x2dA.device - Virtual_Disk USR-A.
May 27 03:19:20.912979 systemd[1]: Found device dev-disk-by\x2dpartuuid-7130c94a\x2d213a\x2d4e5a\x2d8e26\x2d6cce9662f132.device - Virtual_Disk USR-A.
May 27 03:19:20.923551 systemd[1]: Starting disk-uuid.service - Generate new UUID for disk GPT if necessary...
May 27 03:19:20.967872 kernel: hv_storvsc f8b3781a-1e82-4818-a1c3-63d806ec15bb: tag#38 cmd 0x5a status: scsi 0x2 srb 0x86 hv 0xc0000001
May 27 03:19:20.978870 kernel:  sda: sda1 sda2 sda3 sda4 sda6 sda7 sda9
May 27 03:19:20.987877 kernel: hv_storvsc f8b3781a-1e82-4818-a1c3-63d806ec15bb: tag#55 cmd 0x5a status: scsi 0x2 srb 0x86 hv 0xc0000001
May 27 03:19:21.008877 kernel:  sda: sda1 sda2 sda3 sda4 sda6 sda7 sda9
May 27 03:19:22.016033 kernel: hv_storvsc f8b3781a-1e82-4818-a1c3-63d806ec15bb: tag#477 cmd 0x5a status: scsi 0x2 srb 0x86 hv 0xc0000001
May 27 03:19:22.031314 disk-uuid[721]: The operation has completed successfully.
May 27 03:19:22.034700 kernel:  sda: sda1 sda2 sda3 sda4 sda6 sda7 sda9
May 27 03:19:24.614594 systemd[1]: disk-uuid.service: Deactivated successfully.
May 27 03:19:24.614705 systemd[1]: Finished disk-uuid.service - Generate new UUID for disk GPT if necessary.
May 27 03:19:24.617379 systemd[1]: Starting verity-setup.service - Verity Setup for /dev/mapper/usr...
May 27 03:19:24.640999 systemd[1]: Finished dracut-initqueue.service - dracut initqueue hook.
May 27 03:19:24.642848 systemd[1]: Reached target remote-fs-pre.target - Preparation for Remote File Systems.
May 27 03:19:24.649536 systemd[1]: Reached target remote-cryptsetup.target - Remote Encrypted Volumes.
May 27 03:19:24.652176 sh[885]: Success
May 27 03:19:24.651538 systemd[1]: Reached target remote-fs.target - Remote File Systems.
May 27 03:19:24.671561 systemd[1]: Starting dracut-pre-mount.service - dracut pre-mount hook...
May 27 03:19:24.694895 kernel: device-mapper: core: CONFIG_IMA_DISABLE_HTABLE is disabled. Duplicate IMA measurements will not be recorded in the IMA log.
May 27 03:19:24.694933 kernel: device-mapper: uevent: version 1.0.3
May 27 03:19:24.699273 kernel: device-mapper: ioctl: 4.48.0-ioctl (2023-03-01) initialised: dm-devel@lists.linux.dev
May 27 03:19:24.716628 systemd[1]: Finished dracut-pre-mount.service - dracut pre-mount hook.
May 27 03:19:24.724994 kernel: device-mapper: verity: sha256 using shash "sha256-avx2"
May 27 03:19:24.891838 systemd[1]: Found device dev-mapper-usr.device - /dev/mapper/usr.
May 27 03:19:24.901877 systemd[1]: Mounting sysusr-usr.mount - /sysusr/usr...
May 27 03:19:24.922248 systemd[1]: Finished verity-setup.service - Verity Setup for /dev/mapper/usr.
May 27 03:19:24.941538 kernel: BTRFS info: 'norecovery' is for compatibility only, recommended to use 'rescue=nologreplay'
May 27 03:19:24.941570 kernel: BTRFS: device fsid f0f66fe8-3990-49eb-980e-559a3dfd3522 devid 1 transid 40 /dev/mapper/usr (254:0) scanned by mount (918)
May 27 03:19:24.947042 kernel: BTRFS info (device dm-0): first mount of filesystem f0f66fe8-3990-49eb-980e-559a3dfd3522
May 27 03:19:24.951334 kernel: BTRFS info (device dm-0): using crc32c (crc32c-intel) checksum algorithm
May 27 03:19:24.954432 kernel: BTRFS info (device dm-0): using free-space-tree
May 27 03:19:25.416787 systemd[1]: Mounted sysusr-usr.mount - /sysusr/usr.
May 27 03:19:25.418877 systemd[1]: Reached target initrd-usr-fs.target - Initrd /usr File System.
May 27 03:19:25.425189 systemd[1]: afterburn-network-kargs.service - Afterburn Initrd Setup Network Kernel Arguments was skipped because no trigger condition checks were met.
May 27 03:19:25.426085 systemd[1]: Starting ignition-setup.service - Ignition (setup)...
May 27 03:19:25.466437 systemd[1]: Starting parse-ip-for-networkd.service - Write systemd-networkd units from cmdline...
May 27 03:19:25.493902 kernel: BTRFS: device label OEM devid 1 transid 16 /dev/sda6 (8:6) scanned by mount (948)
May 27 03:19:25.503206 kernel: BTRFS info (device sda6): first mount of filesystem fd7bb961-7a0f-4c90-a609-3bffeb956d05
May 27 03:19:25.503237 kernel: BTRFS info (device sda6): using crc32c (crc32c-intel) checksum algorithm
May 27 03:19:25.506440 kernel: BTRFS info (device sda6): using free-space-tree
May 27 03:19:25.547876 kernel: BTRFS info (device sda6): last unmount of filesystem fd7bb961-7a0f-4c90-a609-3bffeb956d05
May 27 03:19:25.548203 systemd[1]: Finished ignition-setup.service - Ignition (setup).
May 27 03:19:25.550602 systemd[1]: Starting ignition-fetch-offline.service - Ignition (fetch-offline)...
May 27 03:19:25.592002 systemd[1]: Finished parse-ip-for-networkd.service - Write systemd-networkd units from cmdline.
May 27 03:19:25.594373 systemd[1]: Starting systemd-networkd.service - Network Configuration...
May 27 03:19:25.648176 systemd-networkd[1087]: lo: Link UP
May 27 03:19:25.648186 systemd-networkd[1087]: lo: Gained carrier
May 27 03:19:25.649200 systemd-networkd[1087]: Enumeration completed
May 27 03:19:25.649278 systemd[1]: Started systemd-networkd.service - Network Configuration.
May 27 03:19:25.649625 systemd-networkd[1087]: eth0: found matching network '/usr/lib/systemd/network/zz-default.network', based on potentially unpredictable interface name.
May 27 03:19:25.649629 systemd-networkd[1087]: eth0: Configuring with /usr/lib/systemd/network/zz-default.network.
May 27 03:19:25.650389 systemd-networkd[1087]: eth0: Link UP
May 27 03:19:25.650553 systemd-networkd[1087]: eth0: Gained carrier
May 27 03:19:25.650562 systemd-networkd[1087]: eth0: found matching network '/usr/lib/systemd/network/zz-default.network', based on potentially unpredictable interface name.
May 27 03:19:25.655203 systemd[1]: Reached target network.target - Network.
May 27 03:19:25.723889 systemd-networkd[1087]: eth0: DHCPv4 address 10.200.8.34/24, gateway 10.200.8.1 acquired from 168.63.129.16
May 27 03:19:26.785988 ignition[1071]: Ignition 2.21.0
May 27 03:19:26.786002 ignition[1071]: Stage: fetch-offline
May 27 03:19:26.786092 ignition[1071]: no configs at "/usr/lib/ignition/base.d"
May 27 03:19:26.786101 ignition[1071]: no config dir at "/usr/lib/ignition/base.platform.d/azure"
May 27 03:19:26.786188 ignition[1071]: parsed url from cmdline: ""
May 27 03:19:26.786191 ignition[1071]: no config URL provided
May 27 03:19:26.786197 ignition[1071]: reading system config file "/usr/lib/ignition/user.ign"
May 27 03:19:26.786205 ignition[1071]: no config at "/usr/lib/ignition/user.ign"
May 27 03:19:26.786210 ignition[1071]: failed to fetch config: resource requires networking
May 27 03:19:26.786382 ignition[1071]: Ignition finished successfully
May 27 03:19:26.817293 systemd[1]: Finished ignition-fetch-offline.service - Ignition (fetch-offline).
May 27 03:19:26.827076 systemd[1]: Starting ignition-fetch.service - Ignition (fetch)...
May 27 03:19:26.864056 ignition[1102]: Ignition 2.21.0
May 27 03:19:26.864070 ignition[1102]: Stage: fetch
May 27 03:19:26.867011 ignition[1102]: no configs at "/usr/lib/ignition/base.d"
May 27 03:19:26.867031 ignition[1102]: no config dir at "/usr/lib/ignition/base.platform.d/azure"
May 27 03:19:26.867144 ignition[1102]: parsed url from cmdline: ""
May 27 03:19:26.867152 ignition[1102]: no config URL provided
May 27 03:19:26.867161 ignition[1102]: reading system config file "/usr/lib/ignition/user.ign"
May 27 03:19:26.867174 ignition[1102]: no config at "/usr/lib/ignition/user.ign"
May 27 03:19:26.867208 ignition[1102]: GET http://169.254.169.254/metadata/instance/compute/userData?api-version=2021-01-01&format=text: attempt #1
May 27 03:19:26.948482 ignition[1102]: GET result: OK
May 27 03:19:26.948527 ignition[1102]: config has been read from IMDS userdata
May 27 03:19:26.948539 ignition[1102]: parsing config with SHA512: 78dd195da77b5814008ca0a9bc4357daa69585351175696aa89fe74585d09422e27a661f2fb295c9acec28242bc64284b50f53465fb105d1af79a9beba351718
May 27 03:19:26.951606 unknown[1102]: fetched base config from "system"
May 27 03:19:26.951769 ignition[1102]: fetch: fetch complete
May 27 03:19:26.951613 unknown[1102]: fetched base config from "system"
May 27 03:19:26.951774 ignition[1102]: fetch: fetch passed
May 27 03:19:26.951619 unknown[1102]: fetched user config from "azure"
May 27 03:19:26.951816 ignition[1102]: Ignition finished successfully
May 27 03:19:26.960082 systemd[1]: Finished ignition-fetch.service - Ignition (fetch).
May 27 03:19:26.962994 systemd[1]: Starting ignition-kargs.service - Ignition (kargs)...
May 27 03:19:27.006943 ignition[1112]: Ignition 2.21.0
May 27 03:19:27.006956 ignition[1112]: Stage: kargs
May 27 03:19:27.007202 ignition[1112]: no configs at "/usr/lib/ignition/base.d"
May 27 03:19:27.007214 ignition[1112]: no config dir at "/usr/lib/ignition/base.platform.d/azure"
May 27 03:19:27.015964 systemd[1]: Finished ignition-kargs.service - Ignition (kargs).
May 27 03:19:27.008414 ignition[1112]: kargs: kargs passed
May 27 03:19:27.008470 ignition[1112]: Ignition finished successfully
May 27 03:19:27.027931 systemd[1]: Starting ignition-disks.service - Ignition (disks)...
May 27 03:19:27.066350 ignition[1122]: Ignition 2.21.0
May 27 03:19:27.066364 ignition[1122]: Stage: disks
May 27 03:19:27.066790 ignition[1122]: no configs at "/usr/lib/ignition/base.d"
May 27 03:19:27.070214 systemd[1]: Finished ignition-disks.service - Ignition (disks).
May 27 03:19:27.066803 ignition[1122]: no config dir at "/usr/lib/ignition/base.platform.d/azure"
May 27 03:19:27.075311 systemd[1]: Reached target initrd-root-device.target - Initrd Root Device.
May 27 03:19:27.067666 ignition[1122]: disks: disks passed
May 27 03:19:27.083016 systemd[1]: Reached target local-fs-pre.target - Preparation for Local File Systems.
May 27 03:19:27.067720 ignition[1122]: Ignition finished successfully
May 27 03:19:27.084436 systemd[1]: Reached target local-fs.target - Local File Systems.
May 27 03:19:27.097547 systemd[1]: Reached target sysinit.target - System Initialization.
May 27 03:19:27.105898 systemd[1]: Reached target basic.target - Basic System.
May 27 03:19:27.112790 systemd[1]: Starting systemd-fsck-root.service - File System Check on /dev/disk/by-label/ROOT...
May 27 03:19:27.195547 systemd-fsck[1133]: ROOT: clean, 15/7326000 files, 477845/7359488 blocks
May 27 03:19:27.201284 systemd[1]: Finished systemd-fsck-root.service - File System Check on /dev/disk/by-label/ROOT.
May 27 03:19:27.212631 systemd[1]: Mounting sysroot.mount - /sysroot...
May 27 03:19:27.272960 systemd-networkd[1087]: eth0: Gained IPv6LL
May 27 03:19:27.454871 kernel: EXT4-fs (sda9): mounted filesystem 18301365-b380-45d7-9677-e42472a122bc r/w with ordered data mode. Quota mode: none.
May 27 03:19:27.455160 systemd[1]: Mounted sysroot.mount - /sysroot.
May 27 03:19:27.461950 systemd[1]: Reached target initrd-root-fs.target - Initrd Root File System.
May 27 03:19:27.484486 systemd[1]: Mounting sysroot-oem.mount - /sysroot/oem...
May 27 03:19:27.486823 systemd[1]: Mounting sysroot-usr.mount - /sysroot/usr...
May 27 03:19:27.513390 systemd[1]: Starting flatcar-metadata-hostname.service - Flatcar Metadata Hostname Agent...
May 27 03:19:27.514924 systemd[1]: ignition-remount-sysroot.service - Remount /sysroot read-write for Ignition was skipped because of an unmet condition check (ConditionPathIsReadWrite=!/sysroot).
May 27 03:19:27.540823 kernel: BTRFS: device label OEM devid 1 transid 16 /dev/sda6 (8:6) scanned by mount (1147)
May 27 03:19:27.514970 systemd[1]: Reached target ignition-diskful.target - Ignition Boot Disk Setup.
May 27 03:19:27.559598 kernel: BTRFS info (device sda6): first mount of filesystem fd7bb961-7a0f-4c90-a609-3bffeb956d05
May 27 03:19:27.559627 kernel: BTRFS info (device sda6): using crc32c (crc32c-intel) checksum algorithm
May 27 03:19:27.559643 kernel: BTRFS info (device sda6): using free-space-tree
May 27 03:19:27.530600 systemd[1]: Mounted sysroot-usr.mount - /sysroot/usr.
May 27 03:19:27.543404 systemd[1]: Starting initrd-setup-root.service - Root filesystem setup...
May 27 03:19:27.562394 systemd[1]: Mounted sysroot-oem.mount - /sysroot/oem.
May 27 03:19:29.081563 coreos-metadata[1149]: May 27 03:19:29.081 INFO Fetching http://168.63.129.16/?comp=versions: Attempt #1
May 27 03:19:29.089415 coreos-metadata[1149]: May 27 03:19:29.089 INFO Fetch successful
May 27 03:19:29.093547 coreos-metadata[1149]: May 27 03:19:29.093 INFO Fetching http://169.254.169.254/metadata/instance/compute/name?api-version=2017-08-01&format=text: Attempt #1
May 27 03:19:29.101817 coreos-metadata[1149]: May 27 03:19:29.101 INFO Fetch successful
May 27 03:19:29.107609 coreos-metadata[1149]: May 27 03:19:29.107 INFO wrote hostname ci-4344.0.0-a-eba636b31a to /sysroot/etc/hostname
May 27 03:19:29.109476 systemd[1]: Finished flatcar-metadata-hostname.service - Flatcar Metadata Hostname Agent.
May 27 03:19:29.367846 initrd-setup-root[1177]: cut: /sysroot/etc/passwd: No such file or directory
May 27 03:19:29.460977 initrd-setup-root[1184]: cut: /sysroot/etc/group: No such file or directory
May 27 03:19:29.495157 initrd-setup-root[1191]: cut: /sysroot/etc/shadow: No such file or directory
May 27 03:19:29.502517 initrd-setup-root[1198]: cut: /sysroot/etc/gshadow: No such file or directory
May 27 03:19:31.236889 systemd[1]: Finished initrd-setup-root.service - Root filesystem setup.
May 27 03:19:31.245823 systemd[1]: Starting ignition-mount.service - Ignition (mount)...
May 27 03:19:31.248019 systemd[1]: Starting sysroot-boot.service - /sysroot/boot...
May 27 03:19:31.285144 systemd[1]: sysroot-oem.mount: Deactivated successfully.
May 27 03:19:31.294163 kernel: BTRFS info (device sda6): last unmount of filesystem fd7bb961-7a0f-4c90-a609-3bffeb956d05
May 27 03:19:31.310968 systemd[1]: Finished sysroot-boot.service - /sysroot/boot.
May 27 03:19:31.327289 ignition[1271]: INFO     : Ignition 2.21.0
May 27 03:19:31.327289 ignition[1271]: INFO     : Stage: mount
May 27 03:19:31.333156 ignition[1271]: INFO     : no configs at "/usr/lib/ignition/base.d"
May 27 03:19:31.333156 ignition[1271]: INFO     : no config dir at "/usr/lib/ignition/base.platform.d/azure"
May 27 03:19:31.333156 ignition[1271]: INFO     : mount: mount passed
May 27 03:19:31.333156 ignition[1271]: INFO     : Ignition finished successfully
May 27 03:19:31.334407 systemd[1]: Finished ignition-mount.service - Ignition (mount).
May 27 03:19:31.342095 systemd[1]: Starting ignition-files.service - Ignition (files)...
May 27 03:19:31.371713 systemd[1]: Mounting sysroot-oem.mount - /sysroot/oem...
May 27 03:19:31.394945 kernel: BTRFS: device label OEM devid 1 transid 16 /dev/sda6 (8:6) scanned by mount (1284)
May 27 03:19:31.394980 kernel: BTRFS info (device sda6): first mount of filesystem fd7bb961-7a0f-4c90-a609-3bffeb956d05
May 27 03:19:31.399263 kernel: BTRFS info (device sda6): using crc32c (crc32c-intel) checksum algorithm
May 27 03:19:31.402499 kernel: BTRFS info (device sda6): using free-space-tree
May 27 03:19:31.406118 systemd[1]: Mounted sysroot-oem.mount - /sysroot/oem.
May 27 03:19:31.449624 ignition[1301]: INFO     : Ignition 2.21.0
May 27 03:19:31.452740 ignition[1301]: INFO     : Stage: files
May 27 03:19:31.452740 ignition[1301]: INFO     : no configs at "/usr/lib/ignition/base.d"
May 27 03:19:31.452740 ignition[1301]: INFO     : no config dir at "/usr/lib/ignition/base.platform.d/azure"
May 27 03:19:31.452740 ignition[1301]: DEBUG    : files: compiled without relabeling support, skipping
May 27 03:19:31.452740 ignition[1301]: INFO     : files: ensureUsers: op(1): [started]  creating or modifying user "core"
May 27 03:19:31.452740 ignition[1301]: DEBUG    : files: ensureUsers: op(1): executing: "usermod" "--root" "/sysroot" "core"
May 27 03:19:31.507648 ignition[1301]: INFO     : files: ensureUsers: op(1): [finished] creating or modifying user "core"
May 27 03:19:31.513224 ignition[1301]: INFO     : files: ensureUsers: op(2): [started]  adding ssh keys to user "core"
May 27 03:19:31.518966 unknown[1301]: wrote ssh authorized keys file for user: core
May 27 03:19:31.522871 ignition[1301]: INFO     : files: ensureUsers: op(2): [finished] adding ssh keys to user "core"
May 27 03:19:31.538385 ignition[1301]: INFO     : files: createFilesystemsFiles: createFiles: op(3): [started]  writing file "/sysroot/etc/flatcar/update.conf"
May 27 03:19:31.545513 ignition[1301]: INFO     : files: createFilesystemsFiles: createFiles: op(3): [finished] writing file "/sysroot/etc/flatcar/update.conf"
May 27 03:19:31.545513 ignition[1301]: INFO     : files: createResultFile: createFiles: op(4): [started]  writing file "/sysroot/etc/.ignition-result.json"
May 27 03:19:31.545513 ignition[1301]: INFO     : files: createResultFile: createFiles: op(4): [finished] writing file "/sysroot/etc/.ignition-result.json"
May 27 03:19:31.545513 ignition[1301]: INFO     : files: files passed
May 27 03:19:31.545513 ignition[1301]: INFO     : Ignition finished successfully
May 27 03:19:31.561278 systemd[1]: Finished ignition-files.service - Ignition (files).
May 27 03:19:31.572045 systemd[1]: Starting ignition-quench.service - Ignition (record completion)...
May 27 03:19:31.579031 systemd[1]: Starting initrd-setup-root-after-ignition.service - Root filesystem completion...
May 27 03:19:31.609086 systemd[1]: ignition-quench.service: Deactivated successfully.
May 27 03:19:31.609200 systemd[1]: Finished ignition-quench.service - Ignition (record completion).
May 27 03:19:31.655717 initrd-setup-root-after-ignition[1334]: grep: /sysroot/etc/flatcar/enabled-sysext.conf: No such file or directory
May 27 03:19:31.655717 initrd-setup-root-after-ignition[1334]: grep: /sysroot/usr/share/flatcar/enabled-sysext.conf: No such file or directory
May 27 03:19:31.663494 initrd-setup-root-after-ignition[1338]: grep: /sysroot/etc/flatcar/enabled-sysext.conf: No such file or directory
May 27 03:19:31.657415 systemd[1]: Finished initrd-setup-root-after-ignition.service - Root filesystem completion.
May 27 03:19:31.662961 systemd[1]: Reached target ignition-complete.target - Ignition Complete.
May 27 03:19:31.678916 systemd[1]: Starting initrd-parse-etc.service - Mountpoints Configured in the Real Root...
May 27 03:19:31.732797 systemd[1]: initrd-parse-etc.service: Deactivated successfully.
May 27 03:19:31.732917 systemd[1]: Finished initrd-parse-etc.service - Mountpoints Configured in the Real Root.
May 27 03:19:31.734634 systemd[1]: Reached target initrd-fs.target - Initrd File Systems.
May 27 03:19:31.751826 systemd[1]: Reached target initrd.target - Initrd Default Target.
May 27 03:19:31.764477 systemd[1]: dracut-mount.service - dracut mount hook was skipped because no trigger condition checks were met.
May 27 03:19:31.765412 systemd[1]: Starting dracut-pre-pivot.service - dracut pre-pivot and cleanup hook...
May 27 03:19:31.807205 systemd[1]: Finished dracut-pre-pivot.service - dracut pre-pivot and cleanup hook.
May 27 03:19:31.809820 systemd[1]: Starting initrd-cleanup.service - Cleaning Up and Shutting Down Daemons...
May 27 03:19:31.843848 systemd[1]: Stopped target nss-lookup.target - Host and Network Name Lookups.
May 27 03:19:31.845489 systemd[1]: Stopped target remote-cryptsetup.target - Remote Encrypted Volumes.
May 27 03:19:31.854932 systemd[1]: Stopped target timers.target - Timer Units.
May 27 03:19:31.864386 systemd[1]: dracut-pre-pivot.service: Deactivated successfully.
May 27 03:19:31.864501 systemd[1]: Stopped dracut-pre-pivot.service - dracut pre-pivot and cleanup hook.
May 27 03:19:31.878680 systemd[1]: Stopped target initrd.target - Initrd Default Target.
May 27 03:19:31.887393 systemd[1]: Stopped target basic.target - Basic System.
May 27 03:19:31.895015 systemd[1]: Stopped target ignition-complete.target - Ignition Complete.
May 27 03:19:31.896523 systemd[1]: Stopped target ignition-diskful.target - Ignition Boot Disk Setup.
May 27 03:19:31.897245 systemd[1]: Stopped target initrd-root-device.target - Initrd Root Device.
May 27 03:19:31.897979 systemd[1]: Stopped target initrd-usr-fs.target - Initrd /usr File System.
May 27 03:19:31.898735 systemd[1]: Stopped target remote-fs.target - Remote File Systems.
May 27 03:19:31.899472 systemd[1]: Stopped target remote-fs-pre.target - Preparation for Remote File Systems.
May 27 03:19:31.900235 systemd[1]: Stopped target sysinit.target - System Initialization.
May 27 03:19:31.901000 systemd[1]: Stopped target local-fs.target - Local File Systems.
May 27 03:19:32.037596 ignition[1360]: INFO     : Ignition 2.21.0
May 27 03:19:32.037596 ignition[1360]: INFO     : Stage: umount
May 27 03:19:32.037596 ignition[1360]: INFO     : no configs at "/usr/lib/ignition/base.d"
May 27 03:19:32.037596 ignition[1360]: INFO     : no config dir at "/usr/lib/ignition/base.platform.d/azure"
May 27 03:19:32.037596 ignition[1360]: INFO     : umount: umount passed
May 27 03:19:32.037596 ignition[1360]: INFO     : Ignition finished successfully
May 27 03:19:31.901689 systemd[1]: Stopped target swap.target - Swaps.
May 27 03:19:31.902392 systemd[1]: dracut-pre-mount.service: Deactivated successfully.
May 27 03:19:31.902512 systemd[1]: Stopped dracut-pre-mount.service - dracut pre-mount hook.
May 27 03:19:31.903893 systemd[1]: Stopped target cryptsetup.target - Local Encrypted Volumes.
May 27 03:19:31.904626 systemd[1]: Stopped target cryptsetup-pre.target - Local Encrypted Volumes (Pre).
May 27 03:19:31.905328 systemd[1]: clevis-luks-askpass.path: Deactivated successfully.
May 27 03:19:31.905440 systemd[1]: Stopped clevis-luks-askpass.path - Forward Password Requests to Clevis Directory Watch.
May 27 03:19:31.906092 systemd[1]: dracut-initqueue.service: Deactivated successfully.
May 27 03:19:31.906209 systemd[1]: Stopped dracut-initqueue.service - dracut initqueue hook.
May 27 03:19:31.907589 systemd[1]: initrd-setup-root-after-ignition.service: Deactivated successfully.
May 27 03:19:31.907708 systemd[1]: Stopped initrd-setup-root-after-ignition.service - Root filesystem completion.
May 27 03:19:31.908331 systemd[1]: ignition-files.service: Deactivated successfully.
May 27 03:19:31.908441 systemd[1]: Stopped ignition-files.service - Ignition (files).
May 27 03:19:31.909075 systemd[1]: flatcar-metadata-hostname.service: Deactivated successfully.
May 27 03:19:31.909183 systemd[1]: Stopped flatcar-metadata-hostname.service - Flatcar Metadata Hostname Agent.
May 27 03:19:31.910528 systemd[1]: Stopping ignition-mount.service - Ignition (mount)...
May 27 03:19:31.911197 systemd[1]: kmod-static-nodes.service: Deactivated successfully.
May 27 03:19:31.911312 systemd[1]: Stopped kmod-static-nodes.service - Create List of Static Device Nodes.
May 27 03:19:31.912665 systemd[1]: Stopping sysroot-boot.service - /sysroot/boot...
May 27 03:19:31.913425 systemd[1]: systemd-udev-trigger.service: Deactivated successfully.
May 27 03:19:31.913544 systemd[1]: Stopped systemd-udev-trigger.service - Coldplug All udev Devices.
May 27 03:19:31.914243 systemd[1]: dracut-pre-trigger.service: Deactivated successfully.
May 27 03:19:31.914352 systemd[1]: Stopped dracut-pre-trigger.service - dracut pre-trigger hook.
May 27 03:19:31.918677 systemd[1]: initrd-cleanup.service: Deactivated successfully.
May 27 03:19:32.014306 systemd[1]: Finished initrd-cleanup.service - Cleaning Up and Shutting Down Daemons.
May 27 03:19:32.029759 systemd[1]: sysroot-boot.mount: Deactivated successfully.
May 27 03:19:32.039042 systemd[1]: ignition-mount.service: Deactivated successfully.
May 27 03:19:32.039146 systemd[1]: Stopped ignition-mount.service - Ignition (mount).
May 27 03:19:32.044961 systemd[1]: ignition-disks.service: Deactivated successfully.
May 27 03:19:32.045009 systemd[1]: Stopped ignition-disks.service - Ignition (disks).
May 27 03:19:32.046997 systemd[1]: ignition-kargs.service: Deactivated successfully.
May 27 03:19:32.047043 systemd[1]: Stopped ignition-kargs.service - Ignition (kargs).
May 27 03:19:32.057140 systemd[1]: ignition-fetch.service: Deactivated successfully.
May 27 03:19:32.057210 systemd[1]: Stopped ignition-fetch.service - Ignition (fetch).
May 27 03:19:32.066138 systemd[1]: Stopped target network.target - Network.
May 27 03:19:32.074739 systemd[1]: ignition-fetch-offline.service: Deactivated successfully.
May 27 03:19:32.074792 systemd[1]: Stopped ignition-fetch-offline.service - Ignition (fetch-offline).
May 27 03:19:32.081820 systemd[1]: Stopped target paths.target - Path Units.
May 27 03:19:32.089434 systemd[1]: systemd-ask-password-console.path: Deactivated successfully.
May 27 03:19:32.092926 systemd[1]: Stopped systemd-ask-password-console.path - Dispatch Password Requests to Console Directory Watch.
May 27 03:19:32.096829 systemd[1]: Stopped target slices.target - Slice Units.
May 27 03:19:32.108150 systemd[1]: Stopped target sockets.target - Socket Units.
May 27 03:19:32.109686 systemd[1]: iscsid.socket: Deactivated successfully.
May 27 03:19:32.109728 systemd[1]: Closed iscsid.socket - Open-iSCSI iscsid Socket.
May 27 03:19:32.117583 systemd[1]: iscsiuio.socket: Deactivated successfully.
May 27 03:19:32.117618 systemd[1]: Closed iscsiuio.socket - Open-iSCSI iscsiuio Socket.
May 27 03:19:32.126049 systemd[1]: ignition-setup.service: Deactivated successfully.
May 27 03:19:32.126101 systemd[1]: Stopped ignition-setup.service - Ignition (setup).
May 27 03:19:32.133942 systemd[1]: ignition-setup-pre.service: Deactivated successfully.
May 27 03:19:32.133988 systemd[1]: Stopped ignition-setup-pre.service - Ignition env setup.
May 27 03:19:32.143403 systemd[1]: Stopping systemd-networkd.service - Network Configuration...
May 27 03:19:32.151395 systemd[1]: Stopping systemd-resolved.service - Network Name Resolution...
May 27 03:19:32.159032 systemd[1]: systemd-resolved.service: Deactivated successfully.
May 27 03:19:32.159129 systemd[1]: Stopped systemd-resolved.service - Network Name Resolution.
May 27 03:19:32.176095 systemd[1]: systemd-networkd.service: Deactivated successfully.
May 27 03:19:32.176203 systemd[1]: Stopped systemd-networkd.service - Network Configuration.
May 27 03:19:32.187679 systemd[1]: sysroot-boot.service: Deactivated successfully.
May 27 03:19:32.187775 systemd[1]: Stopped sysroot-boot.service - /sysroot/boot.
May 27 03:19:32.190769 systemd[1]: Stopped target network-pre.target - Preparation for Network.
May 27 03:19:32.201953 systemd[1]: systemd-networkd.socket: Deactivated successfully.
May 27 03:19:32.202009 systemd[1]: Closed systemd-networkd.socket - Network Service Netlink Socket.
May 27 03:19:32.210243 systemd[1]: initrd-setup-root.service: Deactivated successfully.
May 27 03:19:32.210302 systemd[1]: Stopped initrd-setup-root.service - Root filesystem setup.
May 27 03:19:32.219750 systemd[1]: Stopping network-cleanup.service - Network Cleanup...
May 27 03:19:32.227918 systemd[1]: parse-ip-for-networkd.service: Deactivated successfully.
May 27 03:19:32.227972 systemd[1]: Stopped parse-ip-for-networkd.service - Write systemd-networkd units from cmdline.
May 27 03:19:32.243002 systemd[1]: systemd-sysctl.service: Deactivated successfully.
May 27 03:19:32.243050 systemd[1]: Stopped systemd-sysctl.service - Apply Kernel Variables.
May 27 03:19:32.251896 systemd[1]: systemd-modules-load.service: Deactivated successfully.
May 27 03:19:32.251941 systemd[1]: Stopped systemd-modules-load.service - Load Kernel Modules.
May 27 03:19:32.253392 systemd[1]: systemd-tmpfiles-setup.service: Deactivated successfully.
May 27 03:19:32.253437 systemd[1]: Stopped systemd-tmpfiles-setup.service - Create System Files and Directories.
May 27 03:19:32.272792 systemd[1]: Stopping systemd-udevd.service - Rule-based Manager for Device Events and Files...
May 27 03:19:32.278481 systemd[1]: run-credentials-systemd\x2dsysctl.service.mount: Deactivated successfully.
May 27 03:19:32.278542 systemd[1]: run-credentials-systemd\x2dnetworkd.service.mount: Deactivated successfully.
May 27 03:19:32.278580 systemd[1]: run-credentials-systemd\x2dresolved.service.mount: Deactivated successfully.
May 27 03:19:32.278620 systemd[1]: run-credentials-systemd\x2dtmpfiles\x2dsetup.service.mount: Deactivated successfully.
May 27 03:19:32.294461 systemd[1]: systemd-udevd.service: Deactivated successfully.
May 27 03:19:32.297984 systemd[1]: Stopped systemd-udevd.service - Rule-based Manager for Device Events and Files.
May 27 03:19:32.299865 systemd[1]: systemd-udevd-control.socket: Deactivated successfully.
May 27 03:19:32.299909 systemd[1]: Closed systemd-udevd-control.socket - udev Control Socket.
May 27 03:19:32.311240 systemd[1]: systemd-udevd-kernel.socket: Deactivated successfully.
May 27 03:19:32.311280 systemd[1]: Closed systemd-udevd-kernel.socket - udev Kernel Socket.
May 27 03:19:32.325907 systemd[1]: dracut-pre-udev.service: Deactivated successfully.
May 27 03:19:32.325956 systemd[1]: Stopped dracut-pre-udev.service - dracut pre-udev hook.
May 27 03:19:32.337459 systemd[1]: dracut-cmdline.service: Deactivated successfully.
May 27 03:19:32.337512 systemd[1]: Stopped dracut-cmdline.service - dracut cmdline hook.
May 27 03:19:32.349980 systemd[1]: dracut-cmdline-ask.service: Deactivated successfully.
May 27 03:19:32.350029 systemd[1]: Stopped dracut-cmdline-ask.service - dracut ask for additional cmdline parameters.
May 27 03:19:32.363411 systemd[1]: Starting initrd-udevadm-cleanup-db.service - Cleanup udev Database...
May 27 03:19:32.373058 systemd[1]: systemd-network-generator.service: Deactivated successfully.
May 27 03:19:32.373111 systemd[1]: Stopped systemd-network-generator.service - Generate network units from Kernel command line.
May 27 03:19:32.384374 systemd[1]: systemd-tmpfiles-setup-dev.service: Deactivated successfully.
May 27 03:19:32.384429 systemd[1]: Stopped systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev.
May 27 03:19:32.393547 systemd[1]: systemd-vconsole-setup.service: Deactivated successfully.
May 27 03:19:32.642267 systemd-journald[232]: Received SIGTERM from PID 1 (systemd).
May 27 03:19:32.393592 systemd[1]: Stopped systemd-vconsole-setup.service - Virtual Console Setup.
May 27 03:19:32.402803 systemd[1]: run-credentials-systemd\x2dnetwork\x2dgenerator.service.mount: Deactivated successfully.
May 27 03:19:32.402883 systemd[1]: run-credentials-systemd\x2dtmpfiles\x2dsetup\x2ddev.service.mount: Deactivated successfully.
May 27 03:19:32.402931 systemd[1]: run-credentials-systemd\x2dvconsole\x2dsetup.service.mount: Deactivated successfully.
May 27 03:19:32.403275 systemd[1]: network-cleanup.service: Deactivated successfully.
May 27 03:19:32.403366 systemd[1]: Stopped network-cleanup.service - Network Cleanup.
May 27 03:19:32.406052 systemd[1]: initrd-udevadm-cleanup-db.service: Deactivated successfully.
May 27 03:19:32.406134 systemd[1]: Finished initrd-udevadm-cleanup-db.service - Cleanup udev Database.
May 27 03:19:32.414159 systemd[1]: Reached target initrd-switch-root.target - Switch Root.
May 27 03:19:32.428836 systemd[1]: Starting initrd-switch-root.service - Switch Root...
May 27 03:19:32.472737 systemd[1]: Switching root.
May 27 03:19:32.647364 systemd-journald[232]: Journal stopped
May 27 03:19:41.318978 kernel: SELinux:  policy capability network_peer_controls=1
May 27 03:19:41.319009 kernel: SELinux:  policy capability open_perms=1
May 27 03:19:41.319022 kernel: SELinux:  policy capability extended_socket_class=1
May 27 03:19:41.319032 kernel: SELinux:  policy capability always_check_network=0
May 27 03:19:41.319049 kernel: SELinux:  policy capability cgroup_seclabel=1
May 27 03:19:41.319060 kernel: SELinux:  policy capability nnp_nosuid_transition=1
May 27 03:19:41.319071 kernel: SELinux:  policy capability genfs_seclabel_symlinks=0
May 27 03:19:41.319084 kernel: SELinux:  policy capability ioctl_skip_cloexec=0
May 27 03:19:41.319093 kernel: SELinux:  policy capability userspace_initial_context=0
May 27 03:19:41.319102 kernel: audit: type=1403 audit(1748315973.982:2): auid=4294967295 ses=4294967295 lsm=selinux res=1
May 27 03:19:41.319114 systemd[1]: Successfully loaded SELinux policy in 192.514ms.
May 27 03:19:41.319126 systemd[1]: Relabeled /dev/, /dev/shm/, /run/ in 15.064ms.
May 27 03:19:41.319137 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 27 03:19:41.319147 systemd[1]: Detected virtualization microsoft.
May 27 03:19:41.319161 systemd[1]: Detected architecture x86-64.
May 27 03:19:41.319171 systemd[1]: Detected first boot.
May 27 03:19:41.319182 systemd[1]: Hostname set to <ci-4344.0.0-a-eba636b31a>.
May 27 03:19:41.319192 systemd[1]: Initializing machine ID from random generator.
May 27 03:19:41.319203 zram_generator::config[1406]: No configuration found.
May 27 03:19:41.319217 kernel: Guest personality initialized and is inactive
May 27 03:19:41.319227 kernel: VMCI host device registered (name=vmci, major=10, minor=124)
May 27 03:19:41.319237 kernel: Initialized host personality
May 27 03:19:41.319246 kernel: NET: Registered PF_VSOCK protocol family
May 27 03:19:41.319257 systemd[1]: Populated /etc with preset unit settings.
May 27 03:19:41.319268 systemd[1]: run-credentials-systemd\x2djournald.service.mount: Deactivated successfully.
May 27 03:19:41.319279 systemd[1]: initrd-switch-root.service: Deactivated successfully.
May 27 03:19:41.319292 systemd[1]: Stopped initrd-switch-root.service - Switch Root.
May 27 03:19:41.319303 systemd[1]: systemd-journald.service: Scheduled restart job, restart counter is at 1.
May 27 03:19:41.319314 systemd[1]: Created slice system-addon\x2dconfig.slice - Slice /system/addon-config.
May 27 03:19:41.319325 systemd[1]: Created slice system-addon\x2drun.slice - Slice /system/addon-run.
May 27 03:19:41.319335 systemd[1]: Created slice system-getty.slice - Slice /system/getty.
May 27 03:19:41.319346 systemd[1]: Created slice system-modprobe.slice - Slice /system/modprobe.
May 27 03:19:41.319357 systemd[1]: Created slice system-serial\x2dgetty.slice - Slice /system/serial-getty.
May 27 03:19:41.319368 systemd[1]: Created slice system-system\x2dcloudinit.slice - Slice /system/system-cloudinit.
May 27 03:19:41.319382 systemd[1]: Created slice system-systemd\x2dfsck.slice - Slice /system/systemd-fsck.
May 27 03:19:41.319392 systemd[1]: Created slice user.slice - User and Session Slice.
May 27 03:19:41.319404 systemd[1]: Started clevis-luks-askpass.path - Forward Password Requests to Clevis Directory Watch.
May 27 03:19:41.319415 systemd[1]: Started systemd-ask-password-console.path - Dispatch Password Requests to Console Directory Watch.
May 27 03:19:41.319426 systemd[1]: Started systemd-ask-password-wall.path - Forward Password Requests to Wall Directory Watch.
May 27 03:19:41.319437 systemd[1]: Set up automount boot.automount - Boot partition Automount Point.
May 27 03:19:41.319452 systemd[1]: Set up automount proc-sys-fs-binfmt_misc.automount - Arbitrary Executable File Formats File System Automount Point.
May 27 03:19:41.319463 systemd[1]: Expecting device dev-disk-by\x2dlabel-OEM.device - /dev/disk/by-label/OEM...
May 27 03:19:41.319477 systemd[1]: Expecting device dev-ttyS0.device - /dev/ttyS0...
May 27 03:19:41.319488 systemd[1]: Reached target cryptsetup-pre.target - Local Encrypted Volumes (Pre).
May 27 03:19:41.319499 systemd[1]: Reached target cryptsetup.target - Local Encrypted Volumes.
May 27 03:19:41.319510 systemd[1]: Stopped target initrd-switch-root.target - Switch Root.
May 27 03:19:41.319521 systemd[1]: Stopped target initrd-fs.target - Initrd File Systems.
May 27 03:19:41.319532 systemd[1]: Stopped target initrd-root-fs.target - Initrd Root File System.
May 27 03:19:41.319543 systemd[1]: Reached target integritysetup.target - Local Integrity Protected Volumes.
May 27 03:19:41.319556 systemd[1]: Reached target remote-cryptsetup.target - Remote Encrypted Volumes.
May 27 03:19:41.319568 systemd[1]: Reached target remote-fs.target - Remote File Systems.
May 27 03:19:41.319579 systemd[1]: Reached target slices.target - Slice Units.
May 27 03:19:41.319589 systemd[1]: Reached target swap.target - Swaps.
May 27 03:19:41.319600 systemd[1]: Reached target veritysetup.target - Local Verity Protected Volumes.
May 27 03:19:41.319611 systemd[1]: Listening on systemd-coredump.socket - Process Core Dump Socket.
May 27 03:19:41.319626 systemd[1]: Listening on systemd-creds.socket - Credential Encryption/Decryption.
May 27 03:19:41.319642 systemd[1]: Listening on systemd-networkd.socket - Network Service Netlink Socket.
May 27 03:19:41.319653 systemd[1]: Listening on systemd-udevd-control.socket - udev Control Socket.
May 27 03:19:41.319665 systemd[1]: Listening on systemd-udevd-kernel.socket - udev Kernel Socket.
May 27 03:19:41.319676 systemd[1]: Listening on systemd-userdbd.socket - User Database Manager Socket.
May 27 03:19:41.319687 systemd[1]: Mounting dev-hugepages.mount - Huge Pages File System...
May 27 03:19:41.319698 systemd[1]: Mounting dev-mqueue.mount - POSIX Message Queue File System...
May 27 03:19:41.319712 systemd[1]: Mounting media.mount - External Media Directory...
May 27 03:19:41.319724 systemd[1]: proc-xen.mount - /proc/xen was skipped because of an unmet condition check (ConditionVirtualization=xen).
May 27 03:19:41.319735 systemd[1]: Mounting sys-kernel-debug.mount - Kernel Debug File System...
May 27 03:19:41.319747 systemd[1]: Mounting sys-kernel-tracing.mount - Kernel Trace File System...
May 27 03:19:41.319758 systemd[1]: Mounting tmp.mount - Temporary Directory /tmp...
May 27 03:19:41.319769 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 27 03:19:41.319780 systemd[1]: Reached target machines.target - Containers.
May 27 03:19:41.319792 systemd[1]: Starting flatcar-tmpfiles.service - Create missing system files...
May 27 03:19:41.319803 systemd[1]: ignition-delete-config.service - Ignition (delete config) was skipped because no trigger condition checks were met.
May 27 03:19:41.319817 systemd[1]: Starting kmod-static-nodes.service - Create List of Static Device Nodes...
May 27 03:19:41.319828 systemd[1]: Starting modprobe@configfs.service - Load Kernel Module configfs...
May 27 03:19:41.319839 systemd[1]: Starting modprobe@dm_mod.service - Load Kernel Module dm_mod...
May 27 03:19:41.319850 systemd[1]: Starting modprobe@drm.service - Load Kernel Module drm...
May 27 03:19:41.319873 systemd[1]: Starting modprobe@efi_pstore.service - Load Kernel Module efi_pstore...
May 27 03:19:41.319885 systemd[1]: Starting modprobe@fuse.service - Load Kernel Module fuse...
May 27 03:19:41.319900 systemd[1]: Starting modprobe@loop.service - Load Kernel Module loop...
May 27 03:19:41.319912 systemd[1]: setup-nsswitch.service - Create /etc/nsswitch.conf was skipped because of an unmet condition check (ConditionPathExists=!/etc/nsswitch.conf).
May 27 03:19:41.319926 systemd[1]: systemd-fsck-root.service: Deactivated successfully.
May 27 03:19:41.319938 systemd[1]: Stopped systemd-fsck-root.service - File System Check on Root Device.
May 27 03:19:41.319949 systemd[1]: systemd-fsck-usr.service: Deactivated successfully.
May 27 03:19:41.319960 systemd[1]: Stopped systemd-fsck-usr.service.
May 27 03:19:41.319972 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 27 03:19:41.319983 systemd[1]: Starting systemd-journald.service - Journal Service...
May 27 03:19:41.319994 systemd[1]: Starting systemd-modules-load.service - Load Kernel Modules...
May 27 03:19:41.320005 systemd[1]: Starting systemd-network-generator.service - Generate network units from Kernel command line...
May 27 03:19:41.320019 systemd[1]: Starting systemd-remount-fs.service - Remount Root and Kernel File Systems...
May 27 03:19:41.320030 systemd[1]: Starting systemd-udev-load-credentials.service - Load udev Rules from Credentials...
May 27 03:19:41.320041 systemd[1]: Starting systemd-udev-trigger.service - Coldplug All udev Devices...
May 27 03:19:41.320052 systemd[1]: verity-setup.service: Deactivated successfully.
May 27 03:19:41.320063 systemd[1]: Stopped verity-setup.service.
May 27 03:19:41.320075 systemd[1]: xenserver-pv-version.service - Set fake PV driver version for XenServer was skipped because of an unmet condition check (ConditionVirtualization=xen).
May 27 03:19:41.320086 systemd[1]: Mounted dev-hugepages.mount - Huge Pages File System.
May 27 03:19:41.320097 systemd[1]: Mounted dev-mqueue.mount - POSIX Message Queue File System.
May 27 03:19:41.320110 systemd[1]: Mounted media.mount - External Media Directory.
May 27 03:19:41.320122 systemd[1]: Mounted sys-kernel-debug.mount - Kernel Debug File System.
May 27 03:19:41.320133 systemd[1]: Mounted sys-kernel-tracing.mount - Kernel Trace File System.
May 27 03:19:41.320149 systemd[1]: Mounted tmp.mount - Temporary Directory /tmp.
May 27 03:19:41.320160 systemd[1]: Finished kmod-static-nodes.service - Create List of Static Device Nodes.
May 27 03:19:41.320171 systemd[1]: modprobe@dm_mod.service: Deactivated successfully.
May 27 03:19:41.320182 systemd[1]: Finished modprobe@dm_mod.service - Load Kernel Module dm_mod.
May 27 03:19:41.320193 systemd[1]: modprobe@efi_pstore.service: Deactivated successfully.
May 27 03:19:41.320204 systemd[1]: Finished modprobe@efi_pstore.service - Load Kernel Module efi_pstore.
May 27 03:19:41.320219 systemd[1]: modprobe@configfs.service: Deactivated successfully.
May 27 03:19:41.320230 systemd[1]: Finished modprobe@configfs.service - Load Kernel Module configfs.
May 27 03:19:41.320241 kernel: loop: module loaded
May 27 03:19:41.320251 systemd[1]: Finished systemd-network-generator.service - Generate network units from Kernel command line.
May 27 03:19:41.320262 systemd[1]: Finished flatcar-tmpfiles.service - Create missing system files.
May 27 03:19:41.320273 systemd[1]: modprobe@loop.service: Deactivated successfully.
May 27 03:19:41.320309 systemd-journald[1489]: Collecting audit messages is disabled.
May 27 03:19:41.320337 systemd[1]: Finished modprobe@loop.service - Load Kernel Module loop.
May 27 03:19:41.320350 systemd-journald[1489]: Journal started
May 27 03:19:41.320372 systemd-journald[1489]: Runtime Journal (/run/log/journal/4d3fa17a8fab41fc851e7ddf30fb484e) is 8M, max 2.2G, 2.1G free.
May 27 03:19:40.340429 systemd[1]: Queued start job for default target multi-user.target.
May 27 03:19:40.353174 systemd[1]: Unnecessary job was removed for dev-sda6.device - /dev/sda6.
May 27 03:19:40.353643 systemd[1]: systemd-journald.service: Deactivated successfully.
May 27 03:19:41.329134 systemd[1]: Started systemd-journald.service - Journal Service.
May 27 03:19:41.334939 systemd[1]: Finished systemd-remount-fs.service - Remount Root and Kernel File Systems.
May 27 03:19:41.345717 systemd[1]: Reached target network-pre.target - Preparation for Network.
May 27 03:19:41.351471 systemd[1]: Mounting sys-kernel-config.mount - Kernel Configuration File System...
May 27 03:19:41.356099 systemd[1]: remount-root.service - Remount Root File System was skipped because of an unmet condition check (ConditionPathIsReadWrite=!/).
May 27 03:19:41.356143 systemd[1]: Reached target local-fs.target - Local File Systems.
May 27 03:19:41.361543 systemd[1]: Listening on systemd-sysext.socket - System Extension Image Management.
May 27 03:19:41.363870 kernel: fuse: init (API version 7.41)
May 27 03:19:41.378799 systemd[1]: Starting ldconfig.service - Rebuild Dynamic Linker Cache...
May 27 03:19:41.382912 systemd[1]: systemd-binfmt.service - Set Up Additional Binary Formats was skipped because no trigger condition checks were met.
May 27 03:19:41.384470 systemd[1]: Starting systemd-hwdb-update.service - Rebuild Hardware Database...
May 27 03:19:41.390002 systemd[1]: Starting systemd-journal-flush.service - Flush Journal to Persistent Storage...
May 27 03:19:41.394675 systemd[1]: systemd-pstore.service - Platform Persistent Storage Archival was skipped because of an unmet condition check (ConditionDirectoryNotEmpty=/sys/fs/pstore).
May 27 03:19:41.395673 systemd[1]: Starting systemd-random-seed.service - Load/Save OS Random Seed...
May 27 03:19:41.399996 systemd[1]: systemd-repart.service - Repartition Root Disk was skipped because no trigger condition checks were met.
May 27 03:19:41.401104 systemd[1]: Starting systemd-sysext.service - Merge System Extension Images into /usr/ and /opt/...
May 27 03:19:41.407300 systemd[1]: Starting systemd-sysusers.service - Create System Users...
May 27 03:19:41.413162 systemd[1]: modprobe@fuse.service: Deactivated successfully.
May 27 03:19:41.413349 systemd[1]: Finished modprobe@fuse.service - Load Kernel Module fuse.
May 27 03:19:41.417943 systemd[1]: Finished systemd-modules-load.service - Load Kernel Modules.
May 27 03:19:41.422814 systemd[1]: Finished systemd-udev-load-credentials.service - Load udev Rules from Credentials.
May 27 03:19:41.428794 systemd[1]: Mounted sys-kernel-config.mount - Kernel Configuration File System.
May 27 03:19:41.436834 systemd[1]: Mounting sys-fs-fuse-connections.mount - FUSE Control File System...
May 27 03:19:41.455115 systemd[1]: Starting systemd-sysctl.service - Apply Kernel Variables...
May 27 03:19:41.460662 systemd[1]: Finished systemd-udev-trigger.service - Coldplug All udev Devices.
May 27 03:19:41.465797 systemd[1]: Mounted sys-fs-fuse-connections.mount - FUSE Control File System.
May 27 03:19:41.695441 systemd[1]: Finished systemd-random-seed.service - Load/Save OS Random Seed.
May 27 03:19:41.700718 systemd[1]: Reached target first-boot-complete.target - First Boot Complete.
May 27 03:19:41.703334 systemd-journald[1489]: Time spent on flushing to /var/log/journal/4d3fa17a8fab41fc851e7ddf30fb484e is 13.739ms for 948 entries.
May 27 03:19:41.703334 systemd-journald[1489]: System Journal (/var/log/journal/4d3fa17a8fab41fc851e7ddf30fb484e) is 8M, max 2.6G, 2.6G free.
May 27 03:19:42.249043 systemd-journald[1489]: Received client request to flush runtime journal.
May 27 03:19:42.249133 kernel: loop0: detected capacity change from 0 to 28536
May 27 03:19:42.249162 kernel: ACPI: bus type drm_connector registered
May 27 03:19:41.711120 systemd[1]: Starting systemd-machine-id-commit.service - Save Transient machine-id to Disk...
May 27 03:19:41.923765 systemd[1]: Finished systemd-sysctl.service - Apply Kernel Variables.
May 27 03:19:41.961738 systemd[1]: modprobe@drm.service: Deactivated successfully.
May 27 03:19:41.961948 systemd[1]: Finished modprobe@drm.service - Load Kernel Module drm.
May 27 03:19:42.250161 systemd[1]: Finished systemd-journal-flush.service - Flush Journal to Persistent Storage.
May 27 03:19:42.354574 systemd[1]: Finished systemd-sysusers.service - Create System Users.
May 27 03:19:42.360673 systemd[1]: Starting systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev...
May 27 03:19:42.408078 systemd-tmpfiles[1562]: ACLs are not supported, ignoring.
May 27 03:19:42.408099 systemd-tmpfiles[1562]: ACLs are not supported, ignoring.
May 27 03:19:42.413343 systemd[1]: Finished systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev.
May 27 03:19:42.643922 systemd[1]: etc-machine\x2did.mount: Deactivated successfully.
May 27 03:19:42.644643 systemd[1]: Finished systemd-machine-id-commit.service - Save Transient machine-id to Disk.
May 27 03:19:43.875879 kernel: squashfs: version 4.0 (2009/01/31) Phillip Lougher
May 27 03:19:44.174890 kernel: loop1: detected capacity change from 0 to 146240
May 27 03:19:45.821642 systemd[1]: Finished systemd-hwdb-update.service - Rebuild Hardware Database.
May 27 03:19:45.828997 systemd[1]: Starting systemd-udevd.service - Rule-based Manager for Device Events and Files...
May 27 03:19:45.876541 systemd-udevd[1569]: Using default interface naming scheme 'v255'.
May 27 03:19:46.212344 systemd[1]: Started systemd-udevd.service - Rule-based Manager for Device Events and Files.
May 27 03:19:46.220672 systemd[1]: Starting systemd-networkd.service - Network Configuration...
May 27 03:19:46.243797 systemd[1]: Condition check resulted in dev-ttyS0.device - /dev/ttyS0 being skipped.
May 27 03:19:46.333572 systemd[1]: Starting systemd-userdbd.service - User Database Manager...
May 27 03:19:46.398896 kernel: hv_vmbus: registering driver hyperv_fb
May 27 03:19:46.407911 kernel: hyperv_fb: Synthvid Version major 3, minor 5
May 27 03:19:46.407973 kernel: hyperv_fb: Screen resolution: 1024x768, Color depth: 32, Frame buffer size: 8388608
May 27 03:19:46.411272 kernel: Console: switching to colour dummy device 80x25
May 27 03:19:46.411320 kernel: hv_vmbus: registering driver hv_balloon
May 27 03:19:46.417872 kernel: hv_balloon: Using Dynamic Memory protocol version 2.0
May 27 03:19:46.417925 kernel: mousedev: PS/2 mouse device common for all mice
May 27 03:19:46.420873 kernel: Console: switching to colour frame buffer device 128x48
May 27 03:19:46.463065 systemd[1]: Starting systemd-vconsole-setup.service - Virtual Console Setup...
May 27 03:19:46.467605 systemd[1]: Started systemd-userdbd.service - User Database Manager.
May 27 03:19:46.483361 systemd[1]: systemd-vconsole-setup.service: Deactivated successfully.
May 27 03:19:46.483558 systemd[1]: Stopped systemd-vconsole-setup.service - Virtual Console Setup.
May 27 03:19:46.489297 systemd[1]: Starting systemd-vconsole-setup.service - Virtual Console Setup...
May 27 03:19:46.623887 kernel: loop2: detected capacity change from 0 to 113872
May 27 03:19:46.760887 kernel: EDAC MC: Ver: 3.0.0
May 27 03:19:46.789665 systemd-networkd[1595]: lo: Link UP
May 27 03:19:46.789675 systemd-networkd[1595]: lo: Gained carrier
May 27 03:19:46.791075 systemd-networkd[1595]: Enumeration completed
May 27 03:19:46.791191 systemd[1]: Started systemd-networkd.service - Network Configuration.
May 27 03:19:46.791453 systemd-networkd[1595]: eth0: found matching network '/usr/lib/systemd/network/zz-default.network', based on potentially unpredictable interface name.
May 27 03:19:46.791463 systemd-networkd[1595]: eth0: Configuring with /usr/lib/systemd/network/zz-default.network.
May 27 03:19:46.792090 systemd-networkd[1595]: eth0: Link UP
May 27 03:19:46.792099 systemd-networkd[1595]: eth0: Gained carrier
May 27 03:19:46.792114 systemd-networkd[1595]: eth0: found matching network '/usr/lib/systemd/network/zz-default.network', based on potentially unpredictable interface name.
May 27 03:19:46.795104 systemd[1]: Starting systemd-networkd-persistent-storage.service - Enable Persistent Storage in systemd-networkd...
May 27 03:19:46.797315 systemd[1]: Starting systemd-networkd-wait-online.service - Wait for Network to be Configured...
May 27 03:19:46.835949 systemd-networkd[1595]: eth0: DHCPv4 address 10.200.8.34/24, gateway 10.200.8.1 acquired from 168.63.129.16
May 27 03:19:46.844071 systemd[1]: Found device dev-disk-by\x2dlabel-OEM.device - Virtual_Disk OEM.
May 27 03:19:46.850811 systemd[1]: Starting systemd-fsck@dev-disk-by\x2dlabel-OEM.service - File System Check on /dev/disk/by-label/OEM...
May 27 03:19:46.871997 systemd[1]: Finished systemd-networkd-persistent-storage.service - Enable Persistent Storage in systemd-networkd.
May 27 03:19:46.944682 systemd[1]: Finished systemd-fsck@dev-disk-by\x2dlabel-OEM.service - File System Check on /dev/disk/by-label/OEM.
May 27 03:19:47.747884 kernel: loop3: detected capacity change from 0 to 28536
May 27 03:19:47.756872 kernel: loop4: detected capacity change from 0 to 146240
May 27 03:19:47.769881 kernel: loop5: detected capacity change from 0 to 113872
May 27 03:19:47.776665 (sd-merge)[1726]: Using extensions 'containerd-flatcar', 'docker-flatcar', 'oem-azure'.
May 27 03:19:47.777148 (sd-merge)[1726]: Merged extensions into '/usr'.
May 27 03:19:47.780642 systemd[1]: Finished systemd-sysext.service - Merge System Extension Images into /usr/ and /opt/.
May 27 03:19:47.787375 systemd[1]: Starting ensure-sysext.service...
May 27 03:19:47.791211 systemd[1]: Starting systemd-tmpfiles-setup.service - Create System Files and Directories...
May 27 03:19:47.813800 systemd[1]: Finished systemd-vconsole-setup.service - Virtual Console Setup.
May 27 03:19:47.831281 systemd[1]: Reload requested from client PID 1728 ('systemctl') (unit ensure-sysext.service)...
May 27 03:19:47.831298 systemd[1]: Reloading...
May 27 03:19:47.877889 zram_generator::config[1761]: No configuration found.
May 27 03:19:47.912656 systemd-tmpfiles[1729]: /usr/lib/tmpfiles.d/nfs-utils.conf:6: Duplicate line for path "/var/lib/nfs/sm", ignoring.
May 27 03:19:47.912698 systemd-tmpfiles[1729]: /usr/lib/tmpfiles.d/nfs-utils.conf:7: Duplicate line for path "/var/lib/nfs/sm.bak", ignoring.
May 27 03:19:47.913030 systemd-tmpfiles[1729]: /usr/lib/tmpfiles.d/provision.conf:20: Duplicate line for path "/root", ignoring.
May 27 03:19:47.913314 systemd-tmpfiles[1729]: /usr/lib/tmpfiles.d/systemd-flatcar.conf:6: Duplicate line for path "/var/log/journal", ignoring.
May 27 03:19:47.914195 systemd-tmpfiles[1729]: /usr/lib/tmpfiles.d/systemd.conf:29: Duplicate line for path "/var/lib/systemd", ignoring.
May 27 03:19:47.914484 systemd-tmpfiles[1729]: ACLs are not supported, ignoring.
May 27 03:19:47.914550 systemd-tmpfiles[1729]: ACLs are not supported, ignoring.
May 27 03:19:47.930430 systemd-tmpfiles[1729]: Detected autofs mount point /boot during canonicalization of boot.
May 27 03:19:47.930444 systemd-tmpfiles[1729]: Skipping /boot
May 27 03:19:47.942230 systemd-tmpfiles[1729]: Detected autofs mount point /boot during canonicalization of boot.
May 27 03:19:47.942244 systemd-tmpfiles[1729]: Skipping /boot
May 27 03:19:47.986589 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 27 03:19:48.145672 systemd[1]: Reloading finished in 313 ms.
May 27 03:19:48.198823 systemd[1]: Finished systemd-tmpfiles-setup.service - Create System Files and Directories.
May 27 03:19:48.200960 systemd-networkd[1595]: eth0: Gained IPv6LL
May 27 03:19:48.208043 systemd[1]: Finished systemd-networkd-wait-online.service - Wait for Network to be Configured.
May 27 03:19:48.218575 systemd[1]: proc-xen.mount - /proc/xen was skipped because of an unmet condition check (ConditionVirtualization=xen).
May 27 03:19:48.220033 systemd[1]: Starting audit-rules.service - Load Audit Rules...
May 27 03:19:48.240686 systemd[1]: Starting clean-ca-certificates.service - Clean up broken links in /etc/ssl/certs...
May 27 03:19:48.245461 systemd[1]: ignition-delete-config.service - Ignition (delete config) was skipped because no trigger condition checks were met.
May 27 03:19:48.246659 systemd[1]: Starting modprobe@dm_mod.service - Load Kernel Module dm_mod...
May 27 03:19:48.252325 systemd[1]: Starting modprobe@efi_pstore.service - Load Kernel Module efi_pstore...
May 27 03:19:48.258094 systemd[1]: Starting modprobe@loop.service - Load Kernel Module loop...
May 27 03:19:48.262470 systemd[1]: systemd-binfmt.service - Set Up Additional Binary Formats was skipped because no trigger condition checks were met.
May 27 03:19:48.262591 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 27 03:19:48.263733 systemd[1]: Starting systemd-journal-catalog-update.service - Rebuild Journal Catalog...
May 27 03:19:48.271485 systemd[1]: Starting systemd-resolved.service - Network Name Resolution...
May 27 03:19:48.276722 systemd[1]: Starting systemd-update-utmp.service - Record System Boot/Shutdown in UTMP...
May 27 03:19:48.281744 systemd[1]: xenserver-pv-version.service - Set fake PV driver version for XenServer was skipped because of an unmet condition check (ConditionVirtualization=xen).
May 27 03:19:48.284249 systemd[1]: modprobe@dm_mod.service: Deactivated successfully.
May 27 03:19:48.284445 systemd[1]: Finished modprobe@dm_mod.service - Load Kernel Module dm_mod.
May 27 03:19:48.289667 systemd[1]: modprobe@efi_pstore.service: Deactivated successfully.
May 27 03:19:48.289840 systemd[1]: Finished modprobe@efi_pstore.service - Load Kernel Module efi_pstore.
May 27 03:19:48.295261 systemd[1]: modprobe@loop.service: Deactivated successfully.
May 27 03:19:48.295491 systemd[1]: Finished modprobe@loop.service - Load Kernel Module loop.
May 27 03:19:48.309699 systemd[1]: Finished systemd-update-utmp.service - Record System Boot/Shutdown in UTMP.
May 27 03:19:48.320090 systemd[1]: proc-xen.mount - /proc/xen was skipped because of an unmet condition check (ConditionVirtualization=xen).
May 27 03:19:48.320347 systemd[1]: ignition-delete-config.service - Ignition (delete config) was skipped because no trigger condition checks were met.
May 27 03:19:48.321696 systemd[1]: Starting modprobe@dm_mod.service - Load Kernel Module dm_mod...
May 27 03:19:48.332705 systemd[1]: Starting modprobe@drm.service - Load Kernel Module drm...
May 27 03:19:48.337937 systemd[1]: Starting modprobe@efi_pstore.service - Load Kernel Module efi_pstore...
May 27 03:19:48.343535 systemd[1]: Starting modprobe@loop.service - Load Kernel Module loop...
May 27 03:19:48.347725 systemd[1]: systemd-binfmt.service - Set Up Additional Binary Formats was skipped because no trigger condition checks were met.
May 27 03:19:48.347848 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 27 03:19:48.348039 systemd[1]: Reached target time-set.target - System Time Set.
May 27 03:19:48.352262 systemd[1]: xenserver-pv-version.service - Set fake PV driver version for XenServer was skipped because of an unmet condition check (ConditionVirtualization=xen).
May 27 03:19:48.353823 systemd[1]: modprobe@dm_mod.service: Deactivated successfully.
May 27 03:19:48.354020 systemd[1]: Finished modprobe@dm_mod.service - Load Kernel Module dm_mod.
May 27 03:19:48.359285 systemd[1]: modprobe@drm.service: Deactivated successfully.
May 27 03:19:48.359464 systemd[1]: Finished modprobe@drm.service - Load Kernel Module drm.
May 27 03:19:48.364217 systemd[1]: modprobe@efi_pstore.service: Deactivated successfully.
May 27 03:19:48.364389 systemd[1]: Finished modprobe@efi_pstore.service - Load Kernel Module efi_pstore.
May 27 03:19:48.369891 systemd[1]: modprobe@loop.service: Deactivated successfully.
May 27 03:19:48.370061 systemd[1]: Finished modprobe@loop.service - Load Kernel Module loop.
May 27 03:19:48.377188 systemd[1]: Finished ensure-sysext.service.
May 27 03:19:48.383761 systemd[1]: systemd-pstore.service - Platform Persistent Storage Archival was skipped because of an unmet condition check (ConditionDirectoryNotEmpty=/sys/fs/pstore).
May 27 03:19:48.383819 systemd[1]: systemd-repart.service - Repartition Root Disk was skipped because no trigger condition checks were met.
May 27 03:19:48.391770 systemd[1]: Finished systemd-journal-catalog-update.service - Rebuild Journal Catalog.
May 27 03:19:48.438331 systemd-resolved[1835]: Positive Trust Anchors:
May 27 03:19:48.438346 systemd-resolved[1835]: . IN DS 20326 8 2 e06d44b80b8f1d39a95c0b0d7c65d08458e880409bbc683457104237c7f8ec8d
May 27 03:19:48.438378 systemd-resolved[1835]: 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 27 03:19:48.698102 systemd-resolved[1835]: Using system hostname 'ci-4344.0.0-a-eba636b31a'.
May 27 03:19:48.700248 systemd[1]: Started systemd-resolved.service - Network Name Resolution.
May 27 03:19:48.704911 systemd[1]: Reached target network.target - Network.
May 27 03:19:48.708513 systemd[1]: Reached target network-online.target - Network is Online.
May 27 03:19:48.712970 systemd[1]: Reached target nss-lookup.target - Host and Network Name Lookups.
May 27 03:19:48.720279 augenrules[1865]: No rules
May 27 03:19:48.721548 systemd[1]: audit-rules.service: Deactivated successfully.
May 27 03:19:48.721790 systemd[1]: Finished audit-rules.service - Load Audit Rules.
May 27 03:19:49.644619 systemd[1]: Finished clean-ca-certificates.service - Clean up broken links in /etc/ssl/certs.
May 27 03:19:49.650150 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 27 03:19:58.243098 ldconfig[1537]: /sbin/ldconfig: /usr/lib/ld.so.conf is not an ELF file - it has the wrong magic bytes at the start.
May 27 03:19:58.257150 systemd[1]: Finished ldconfig.service - Rebuild Dynamic Linker Cache.
May 27 03:19:58.263658 systemd[1]: Starting systemd-update-done.service - Update is Completed...
May 27 03:19:58.295116 systemd[1]: Finished systemd-update-done.service - Update is Completed.
May 27 03:19:58.299834 systemd[1]: Reached target sysinit.target - System Initialization.
May 27 03:19:58.304225 systemd[1]: Started motdgen.path - Watch for update engine configuration changes.
May 27 03:19:58.309262 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 27 03:19:58.314386 systemd[1]: Started google-oslogin-cache.timer - NSS cache refresh timer.
May 27 03:19:58.319171 systemd[1]: Started logrotate.timer - Daily rotation of log files.
May 27 03:19:58.323651 systemd[1]: Started mdadm.timer - Weekly check for MD array's redundancy information..
May 27 03:19:58.328726 systemd[1]: Started systemd-tmpfiles-clean.timer - Daily Cleanup of Temporary Directories.
May 27 03:19:58.333929 systemd[1]: update-engine-stub.timer - Update Engine Stub Timer was skipped because of an unmet condition check (ConditionPathExists=/usr/.noupdate).
May 27 03:19:58.333964 systemd[1]: Reached target paths.target - Path Units.
May 27 03:19:58.337699 systemd[1]: Reached target timers.target - Timer Units.
May 27 03:19:58.342570 systemd[1]: Listening on dbus.socket - D-Bus System Message Bus Socket.
May 27 03:19:58.348400 systemd[1]: Starting docker.socket - Docker Socket for the API...
May 27 03:19:58.355550 systemd[1]: Listening on sshd-unix-local.socket - OpenSSH Server Socket (systemd-ssh-generator, AF_UNIX Local).
May 27 03:19:58.360919 systemd[1]: Listening on sshd-vsock.socket - OpenSSH Server Socket (systemd-ssh-generator, AF_VSOCK).
May 27 03:19:58.365820 systemd[1]: Reached target ssh-access.target - SSH Access Available.
May 27 03:19:58.371972 systemd[1]: Listening on sshd.socket - OpenSSH Server Socket.
May 27 03:19:58.376549 systemd[1]: Listening on systemd-hostnamed.socket - Hostname Service Socket.
May 27 03:19:58.381918 systemd[1]: Listening on docker.socket - Docker Socket for the API.
May 27 03:19:58.387248 systemd[1]: Reached target sockets.target - Socket Units.
May 27 03:19:58.391192 systemd[1]: Reached target basic.target - Basic System.
May 27 03:19:58.394983 systemd[1]: addon-config@oem.service - Configure Addon /oem was skipped because no trigger condition checks were met.
May 27 03:19:58.395010 systemd[1]: addon-run@oem.service - Run Addon /oem was skipped because no trigger condition checks were met.
May 27 03:19:58.397344 systemd[1]: Starting chronyd.service - NTP client/server...
May 27 03:19:58.401642 systemd[1]: Starting containerd.service - containerd container runtime...
May 27 03:19:58.419671 systemd[1]: Starting coreos-metadata.service - Flatcar Metadata Agent...
May 27 03:19:58.424900 systemd[1]: Starting dbus.service - D-Bus System Message Bus...
May 27 03:19:58.429761 systemd[1]: Starting dracut-shutdown.service - Restore /run/initramfs on shutdown...
May 27 03:19:58.435171 systemd[1]: Starting enable-oem-cloudinit.service - Enable cloudinit...
May 27 03:19:58.440301 systemd[1]: Starting extend-filesystems.service - Extend Filesystems...
May 27 03:19:58.444240 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 27 03:19:58.445979 systemd[1]: Starting google-oslogin-cache.service - NSS cache refresh...
May 27 03:19:58.449441 jq[1885]: false
May 27 03:19:58.450920 systemd[1]: Starting motdgen.service - Generate /run/flatcar/motd...
May 27 03:19:58.455747 systemd[1]: Starting nvidia.service - NVIDIA Configure Service...
May 27 03:19:58.460471 systemd[1]: Starting ssh-key-proc-cmdline.service - Install an ssh key from /proc/cmdline...
May 27 03:19:58.466267 systemd[1]: Starting sshd-keygen.service - Generate sshd host keys...
May 27 03:19:58.466680 (chronyd)[1877]: chronyd.service: Referenced but unset environment variable evaluates to an empty string: OPTIONS
May 27 03:19:58.472776 systemd[1]: Starting systemd-logind.service - User Login Management...
May 27 03:19:58.477564 systemd[1]: tcsd.service - TCG Core Services Daemon was skipped because of an unmet condition check (ConditionPathExists=/dev/tpm0).
May 27 03:19:58.478036 systemd[1]: cgroup compatibility translation between legacy and unified hierarchy settings activated. See cgroup-compat debug messages for details.
May 27 03:19:58.478824 systemd[1]: Starting update-engine.service - Update Engine...
May 27 03:19:58.483387 systemd[1]: Starting update-ssh-keys-after-ignition.service - Run update-ssh-keys once after Ignition...
May 27 03:19:58.490029 systemd[1]: enable-oem-cloudinit.service: Skipped due to 'exec-condition'.
May 27 03:19:58.490280 jq[1900]: true
May 27 03:19:58.490249 systemd[1]: Condition check resulted in enable-oem-cloudinit.service - Enable cloudinit being skipped.
May 27 03:19:58.490545 systemd[1]: ssh-key-proc-cmdline.service: Deactivated successfully.
May 27 03:19:58.490731 systemd[1]: Finished ssh-key-proc-cmdline.service - Install an ssh key from /proc/cmdline.
May 27 03:19:58.503146 jq[1902]: true
May 27 03:19:58.569987 systemd[1]: motdgen.service: Deactivated successfully.
May 27 03:19:58.570238 systemd[1]: Finished motdgen.service - Generate /run/flatcar/motd.
May 27 03:19:58.585190 (ntainerd)[1926]: containerd.service: Referenced but unset environment variable evaluates to an empty string: TORCX_IMAGEDIR, TORCX_UNPACKDIR
May 27 03:19:58.622084 chronyd[1931]: chronyd version 4.6.1 starting (+CMDMON +NTP +REFCLOCK +RTC +PRIVDROP +SCFILTER -SIGND +ASYNCDNS +NTS +SECHASH +IPV6 -DEBUG)
May 27 03:19:58.674037 google_oslogin_nss_cache[1887]: oslogin_cache_refresh[1887]: Refreshing passwd entry cache
May 27 03:19:58.674041 oslogin_cache_refresh[1887]: Refreshing passwd entry cache
May 27 03:19:58.681985 google_oslogin_nss_cache[1887]: oslogin_cache_refresh[1887]: Failure getting users, quitting
May 27 03:19:58.681985 google_oslogin_nss_cache[1887]: oslogin_cache_refresh[1887]: Produced empty passwd cache file, removing /etc/oslogin_passwd.cache.bak.
May 27 03:19:58.681975 oslogin_cache_refresh[1887]: Failure getting users, quitting
May 27 03:19:58.682113 google_oslogin_nss_cache[1887]: oslogin_cache_refresh[1887]: Refreshing group entry cache
May 27 03:19:58.681991 oslogin_cache_refresh[1887]: Produced empty passwd cache file, removing /etc/oslogin_passwd.cache.bak.
May 27 03:19:58.682029 oslogin_cache_refresh[1887]: Refreshing group entry cache
May 27 03:19:58.686581 google_oslogin_nss_cache[1887]: oslogin_cache_refresh[1887]: Failure getting groups, quitting
May 27 03:19:58.686581 google_oslogin_nss_cache[1887]: oslogin_cache_refresh[1887]: Produced empty group cache file, removing /etc/oslogin_group.cache.bak.
May 27 03:19:58.686566 oslogin_cache_refresh[1887]: Failure getting groups, quitting
May 27 03:19:58.686577 oslogin_cache_refresh[1887]: Produced empty group cache file, removing /etc/oslogin_group.cache.bak.
May 27 03:19:58.688063 systemd[1]: google-oslogin-cache.service: Deactivated successfully.
May 27 03:19:58.688302 systemd[1]: Finished google-oslogin-cache.service - NSS cache refresh.
May 27 03:19:58.693297 systemd[1]: Finished dracut-shutdown.service - Restore /run/initramfs on shutdown.
May 27 03:19:58.722144 extend-filesystems[1886]: Found loop3
May 27 03:19:58.725083 extend-filesystems[1886]: Found loop4
May 27 03:19:58.725083 extend-filesystems[1886]: Found loop5
May 27 03:19:58.725083 extend-filesystems[1886]: Found sda
May 27 03:19:58.725083 extend-filesystems[1886]: Found sda1
May 27 03:19:58.725083 extend-filesystems[1886]: Found sda2
May 27 03:19:58.725083 extend-filesystems[1886]: Found sda3
May 27 03:19:58.725083 extend-filesystems[1886]: Found usr
May 27 03:19:58.725083 extend-filesystems[1886]: Found sda4
May 27 03:19:58.725083 extend-filesystems[1886]: Found sda6
May 27 03:19:58.725083 extend-filesystems[1886]: Found sda7
May 27 03:19:58.725083 extend-filesystems[1886]: Found sda9
May 27 03:19:58.725083 extend-filesystems[1886]: Checking size of /dev/sda9
May 27 03:19:58.749400 systemd[1]: Started chronyd.service - NTP client/server.
May 27 03:19:58.747832 chronyd[1931]: Timezone right/UTC failed leap second check, ignoring
May 27 03:19:58.748045 chronyd[1931]: Loaded seccomp filter (level 2)
May 27 03:19:58.806761 systemd-logind[1896]: New seat seat0.
May 27 03:19:58.807945 systemd-logind[1896]: Watching system buttons on /dev/input/event0 (AT Translated Set 2 keyboard)
May 27 03:19:58.808115 systemd[1]: Started systemd-logind.service - User Login Management.
May 27 03:19:59.008693 extend-filesystems[1886]: Old size kept for /dev/sda9
May 27 03:19:59.010332 extend-filesystems[1886]: Found sdb
May 27 03:19:59.010332 extend-filesystems[1886]: Found sdb1
May 27 03:19:59.010332 extend-filesystems[1886]: Found sr0
May 27 03:19:59.009953 systemd[1]: extend-filesystems.service: Deactivated successfully.
May 27 03:19:59.010207 systemd[1]: Finished extend-filesystems.service - Extend Filesystems.
May 27 03:19:59.186870 update_engine[1899]: I20250527 03:19:59.186776  1899 main.cc:92] Flatcar Update Engine starting
May 27 03:19:59.197658 bash[1922]: Updated "/home/core/.ssh/authorized_keys"
May 27 03:19:59.199351 systemd[1]: Finished update-ssh-keys-after-ignition.service - Run update-ssh-keys once after Ignition.
May 27 03:19:59.205170 systemd[1]: sshkeys.service was skipped because no trigger condition checks were met.
May 27 03:19:59.285019 setup-nvidia[1890]: Downloading Flatcar Container Linux Developer Container for version: 4344.0.0
May 27 03:19:59.328516 dbus-daemon[1880]: [system] SELinux support is enabled
May 27 03:19:59.328712 systemd[1]: Started dbus.service - D-Bus System Message Bus.
May 27 03:19:59.331626 update_engine[1899]: I20250527 03:19:59.331575  1899 update_check_scheduler.cc:74] Next update check in 4m47s
May 27 03:19:59.335440 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 27 03:19:59.335474 systemd[1]: Reached target system-config.target - Load system-provided cloud configs.
May 27 03:19:59.336441 dbus-daemon[1880]: [system] Successfully activated service 'org.freedesktop.systemd1'
May 27 03:19:59.340512 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 27 03:19:59.340539 systemd[1]: Reached target user-config.target - Load user-provided cloud configs.
May 27 03:19:59.345557 systemd[1]: Started update-engine.service - Update Engine.
May 27 03:19:59.351499 systemd[1]: Started locksmithd.service - Cluster reboot manager.
May 27 03:19:59.388927 sshd_keygen[1932]: ssh-keygen: generating new host keys: RSA ECDSA ED25519
May 27 03:19:59.410329 systemd[1]: Finished sshd-keygen.service - Generate sshd host keys.
May 27 03:19:59.416338 systemd[1]: Starting issuegen.service - Generate /run/issue...
May 27 03:19:59.437200 systemd[1]: Starting waagent.service - Microsoft Azure Linux Agent...
May 27 03:19:59.447043 systemd[1]: issuegen.service: Deactivated successfully.
May 27 03:19:59.447247 systemd[1]: Finished issuegen.service - Generate /run/issue.
May 27 03:19:59.454147 systemd[1]: Starting systemd-user-sessions.service - Permit User Sessions...
May 27 03:19:59.459172 systemd[1]: Started waagent.service - Microsoft Azure Linux Agent.
May 27 03:19:59.468784 systemd[1]: Finished systemd-user-sessions.service - Permit User Sessions.
May 27 03:19:59.475001 systemd[1]: Started getty@tty1.service - Getty on tty1.
May 27 03:19:59.480002 systemd[1]: Started serial-getty@ttyS0.service - Serial Getty on ttyS0.
May 27 03:19:59.484662 systemd[1]: Reached target getty.target - Login Prompts.
May 27 03:19:59.719188 coreos-metadata[1879]: May 27 03:19:59.719 INFO Fetching http://168.63.129.16/?comp=versions: Attempt #1
May 27 03:19:59.721295 coreos-metadata[1879]: May 27 03:19:59.721 INFO Fetch successful
May 27 03:19:59.721447 coreos-metadata[1879]: May 27 03:19:59.721 INFO Fetching http://168.63.129.16/machine/?comp=goalstate: Attempt #1
May 27 03:19:59.724960 coreos-metadata[1879]: May 27 03:19:59.724 INFO Fetch successful
May 27 03:19:59.725237 coreos-metadata[1879]: May 27 03:19:59.725 INFO Fetching http://168.63.129.16/machine/69de298a-309e-4cde-8e10-aa8dbd1049f8/a4a3df06%2D1a4a%2D464e%2D80a2%2D7594cb5df6c5.%5Fci%2D4344.0.0%2Da%2Deba636b31a?comp=config&type=sharedConfig&incarnation=1: Attempt #1
May 27 03:19:59.750632 coreos-metadata[1879]: May 27 03:19:59.750 INFO Fetch successful
May 27 03:19:59.750782 coreos-metadata[1879]: May 27 03:19:59.750 INFO Fetching http://169.254.169.254/metadata/instance/compute/vmSize?api-version=2017-08-01&format=text: Attempt #1
May 27 03:19:59.758772 coreos-metadata[1879]: May 27 03:19:59.758 INFO Fetch successful
May 27 03:19:59.786232 systemd[1]: Finished coreos-metadata.service - Flatcar Metadata Agent.
May 27 03:19:59.792487 systemd[1]: packet-phone-home.service - Report Success to Packet was skipped because no trigger condition checks were met.
May 27 03:20:00.603383 locksmithd[2013]: locksmithd starting currentOperation="UPDATE_STATUS_IDLE" strategy="reboot"
May 27 03:20:00.733490 setup-nvidia[2046]:   % Total    % Received % Xferd  Average Speed   Time    Time     Time  Current
May 27 03:20:00.733798 setup-nvidia[2046]:                                  Dload  Upload   Total   Spent    Left  Speed
May 27 03:20:02.233649 containerd[1926]: time="2025-05-27T03:20:02Z" 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 27 03:20:02.234258 containerd[1926]: time="2025-05-27T03:20:02.234226400Z" level=info msg="starting containerd" revision=06b99ca80cdbfbc6cc8bd567021738c9af2b36ce version=v2.0.4
May 27 03:20:02.242378 containerd[1926]: time="2025-05-27T03:20:02.242342900Z" level=warning msg="Configuration migrated from version 2, use `containerd config migrate` to avoid migration" t="7.8µs"
May 27 03:20:02.242378 containerd[1926]: time="2025-05-27T03:20:02.242371200Z" level=info msg="loading plugin" id=io.containerd.image-verifier.v1.bindir type=io.containerd.image-verifier.v1
May 27 03:20:02.242446 containerd[1926]: time="2025-05-27T03:20:02.242389400Z" level=info msg="loading plugin" id=io.containerd.internal.v1.opt type=io.containerd.internal.v1
May 27 03:20:02.242553 containerd[1926]: time="2025-05-27T03:20:02.242531900Z" level=info msg="loading plugin" id=io.containerd.warning.v1.deprecations type=io.containerd.warning.v1
May 27 03:20:02.242591 containerd[1926]: time="2025-05-27T03:20:02.242555900Z" level=info msg="loading plugin" id=io.containerd.content.v1.content type=io.containerd.content.v1
May 27 03:20:02.242591 containerd[1926]: time="2025-05-27T03:20:02.242581100Z" level=info msg="loading plugin" id=io.containerd.snapshotter.v1.blockfile type=io.containerd.snapshotter.v1
May 27 03:20:02.242730 containerd[1926]: time="2025-05-27T03:20:02.242646900Z" 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 27 03:20:02.242730 containerd[1926]: time="2025-05-27T03:20:02.242660800Z" level=info msg="loading plugin" id=io.containerd.snapshotter.v1.btrfs type=io.containerd.snapshotter.v1
May 27 03:20:02.242949 containerd[1926]: time="2025-05-27T03:20:02.242912900Z" 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 27 03:20:02.242949 containerd[1926]: time="2025-05-27T03:20:02.242946000Z" level=info msg="loading plugin" id=io.containerd.snapshotter.v1.devmapper type=io.containerd.snapshotter.v1
May 27 03:20:02.243011 containerd[1926]: time="2025-05-27T03:20:02.242958600Z" level=info msg="skip loading plugin" error="devmapper not configured: skip plugin" id=io.containerd.snapshotter.v1.devmapper type=io.containerd.snapshotter.v1
May 27 03:20:02.243011 containerd[1926]: time="2025-05-27T03:20:02.242967200Z" level=info msg="loading plugin" id=io.containerd.snapshotter.v1.native type=io.containerd.snapshotter.v1
May 27 03:20:02.243070 containerd[1926]: time="2025-05-27T03:20:02.243047200Z" level=info msg="loading plugin" id=io.containerd.snapshotter.v1.overlayfs type=io.containerd.snapshotter.v1
May 27 03:20:02.243341 containerd[1926]: time="2025-05-27T03:20:02.243318800Z" level=info msg="loading plugin" id=io.containerd.snapshotter.v1.zfs type=io.containerd.snapshotter.v1
May 27 03:20:02.243369 containerd[1926]: time="2025-05-27T03:20:02.243357200Z" 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 27 03:20:02.243397 containerd[1926]: time="2025-05-27T03:20:02.243368200Z" level=info msg="loading plugin" id=io.containerd.event.v1.exchange type=io.containerd.event.v1
May 27 03:20:02.243420 containerd[1926]: time="2025-05-27T03:20:02.243395900Z" level=info msg="loading plugin" id=io.containerd.monitor.task.v1.cgroups type=io.containerd.monitor.task.v1
May 27 03:20:02.244711 containerd[1926]: time="2025-05-27T03:20:02.244680400Z" level=info msg="loading plugin" id=io.containerd.metadata.v1.bolt type=io.containerd.metadata.v1
May 27 03:20:02.244784 containerd[1926]: time="2025-05-27T03:20:02.244763300Z" level=info msg="metadata content store policy set" policy=shared
May 27 03:20:02.260749 containerd[1926]: time="2025-05-27T03:20:02.260693300Z" level=info msg="loading plugin" id=io.containerd.gc.v1.scheduler type=io.containerd.gc.v1
May 27 03:20:02.260809 containerd[1926]: time="2025-05-27T03:20:02.260752200Z" level=info msg="loading plugin" id=io.containerd.differ.v1.walking type=io.containerd.differ.v1
May 27 03:20:02.260809 containerd[1926]: time="2025-05-27T03:20:02.260767900Z" level=info msg="loading plugin" id=io.containerd.lease.v1.manager type=io.containerd.lease.v1
May 27 03:20:02.260809 containerd[1926]: time="2025-05-27T03:20:02.260780000Z" level=info msg="loading plugin" id=io.containerd.service.v1.containers-service type=io.containerd.service.v1
May 27 03:20:02.260809 containerd[1926]: time="2025-05-27T03:20:02.260791600Z" level=info msg="loading plugin" id=io.containerd.service.v1.content-service type=io.containerd.service.v1
May 27 03:20:02.260809 containerd[1926]: time="2025-05-27T03:20:02.260802200Z" level=info msg="loading plugin" id=io.containerd.service.v1.diff-service type=io.containerd.service.v1
May 27 03:20:02.260953 containerd[1926]: time="2025-05-27T03:20:02.260820000Z" level=info msg="loading plugin" id=io.containerd.service.v1.images-service type=io.containerd.service.v1
May 27 03:20:02.260953 containerd[1926]: time="2025-05-27T03:20:02.260831800Z" level=info msg="loading plugin" id=io.containerd.service.v1.introspection-service type=io.containerd.service.v1
May 27 03:20:02.260953 containerd[1926]: time="2025-05-27T03:20:02.260841900Z" level=info msg="loading plugin" id=io.containerd.service.v1.namespaces-service type=io.containerd.service.v1
May 27 03:20:02.260953 containerd[1926]: time="2025-05-27T03:20:02.260865400Z" level=info msg="loading plugin" id=io.containerd.service.v1.snapshots-service type=io.containerd.service.v1
May 27 03:20:02.260953 containerd[1926]: time="2025-05-27T03:20:02.260876700Z" level=info msg="loading plugin" id=io.containerd.shim.v1.manager type=io.containerd.shim.v1
May 27 03:20:02.260953 containerd[1926]: time="2025-05-27T03:20:02.260891400Z" level=info msg="loading plugin" id=io.containerd.runtime.v2.task type=io.containerd.runtime.v2
May 27 03:20:02.261082 containerd[1926]: time="2025-05-27T03:20:02.260998700Z" level=info msg="loading plugin" id=io.containerd.service.v1.tasks-service type=io.containerd.service.v1
May 27 03:20:02.261082 containerd[1926]: time="2025-05-27T03:20:02.261019400Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.containers type=io.containerd.grpc.v1
May 27 03:20:02.261082 containerd[1926]: time="2025-05-27T03:20:02.261032000Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.content type=io.containerd.grpc.v1
May 27 03:20:02.261082 containerd[1926]: time="2025-05-27T03:20:02.261041600Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.diff type=io.containerd.grpc.v1
May 27 03:20:02.261082 containerd[1926]: time="2025-05-27T03:20:02.261052100Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.events type=io.containerd.grpc.v1
May 27 03:20:02.261082 containerd[1926]: time="2025-05-27T03:20:02.261061800Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.images type=io.containerd.grpc.v1
May 27 03:20:02.261082 containerd[1926]: time="2025-05-27T03:20:02.261072200Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.introspection type=io.containerd.grpc.v1
May 27 03:20:02.261237 containerd[1926]: time="2025-05-27T03:20:02.261083100Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.leases type=io.containerd.grpc.v1
May 27 03:20:02.261237 containerd[1926]: time="2025-05-27T03:20:02.261109800Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.namespaces type=io.containerd.grpc.v1
May 27 03:20:02.261237 containerd[1926]: time="2025-05-27T03:20:02.261125700Z" level=info msg="loading plugin" id=io.containerd.sandbox.store.v1.local type=io.containerd.sandbox.store.v1
May 27 03:20:02.261237 containerd[1926]: time="2025-05-27T03:20:02.261135600Z" level=info msg="loading plugin" id=io.containerd.cri.v1.images type=io.containerd.cri.v1
May 27 03:20:02.261237 containerd[1926]: time="2025-05-27T03:20:02.261189400Z" level=info msg="Get image filesystem path \"/var/lib/containerd/io.containerd.snapshotter.v1.overlayfs\" for snapshotter \"overlayfs\""
May 27 03:20:02.261237 containerd[1926]: time="2025-05-27T03:20:02.261203300Z" level=info msg="Start snapshots syncer"
May 27 03:20:02.261237 containerd[1926]: time="2025-05-27T03:20:02.261226300Z" level=info msg="loading plugin" id=io.containerd.cri.v1.runtime type=io.containerd.cri.v1
May 27 03:20:02.261476 containerd[1926]: time="2025-05-27T03:20:02.261435300Z" 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 27 03:20:02.261594 containerd[1926]: time="2025-05-27T03:20:02.261493400Z" level=info msg="loading plugin" id=io.containerd.podsandbox.controller.v1.podsandbox type=io.containerd.podsandbox.controller.v1
May 27 03:20:02.261594 containerd[1926]: time="2025-05-27T03:20:02.261575500Z" level=info msg="loading plugin" id=io.containerd.sandbox.controller.v1.shim type=io.containerd.sandbox.controller.v1
May 27 03:20:02.261697 containerd[1926]: time="2025-05-27T03:20:02.261674000Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.sandbox-controllers type=io.containerd.grpc.v1
May 27 03:20:02.261727 containerd[1926]: time="2025-05-27T03:20:02.261702900Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.sandboxes type=io.containerd.grpc.v1
May 27 03:20:02.261727 containerd[1926]: time="2025-05-27T03:20:02.261713700Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.snapshots type=io.containerd.grpc.v1
May 27 03:20:02.261779 containerd[1926]: time="2025-05-27T03:20:02.261732900Z" level=info msg="loading plugin" id=io.containerd.streaming.v1.manager type=io.containerd.streaming.v1
May 27 03:20:02.261779 containerd[1926]: time="2025-05-27T03:20:02.261746700Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.streaming type=io.containerd.grpc.v1
May 27 03:20:02.261779 containerd[1926]: time="2025-05-27T03:20:02.261756100Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.tasks type=io.containerd.grpc.v1
May 27 03:20:02.261779 containerd[1926]: time="2025-05-27T03:20:02.261765800Z" level=info msg="loading plugin" id=io.containerd.transfer.v1.local type=io.containerd.transfer.v1
May 27 03:20:02.261873 containerd[1926]: time="2025-05-27T03:20:02.261786000Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.transfer type=io.containerd.grpc.v1
May 27 03:20:02.261873 containerd[1926]: time="2025-05-27T03:20:02.261797400Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.version type=io.containerd.grpc.v1
May 27 03:20:02.261873 containerd[1926]: time="2025-05-27T03:20:02.261823800Z" level=info msg="loading plugin" id=io.containerd.monitor.container.v1.restart type=io.containerd.monitor.container.v1
May 27 03:20:02.261873 containerd[1926]: time="2025-05-27T03:20:02.261865700Z" level=info msg="loading plugin" id=io.containerd.tracing.processor.v1.otlp type=io.containerd.tracing.processor.v1
May 27 03:20:02.261962 containerd[1926]: time="2025-05-27T03:20:02.261880000Z" 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 27 03:20:02.261962 containerd[1926]: time="2025-05-27T03:20:02.261888400Z" level=info msg="loading plugin" id=io.containerd.internal.v1.tracing type=io.containerd.internal.v1
May 27 03:20:02.261962 containerd[1926]: time="2025-05-27T03:20:02.261898000Z" 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 27 03:20:02.261962 containerd[1926]: time="2025-05-27T03:20:02.261905600Z" level=info msg="loading plugin" id=io.containerd.ttrpc.v1.otelttrpc type=io.containerd.ttrpc.v1
May 27 03:20:02.261962 containerd[1926]: time="2025-05-27T03:20:02.261913800Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.healthcheck type=io.containerd.grpc.v1
May 27 03:20:02.261962 containerd[1926]: time="2025-05-27T03:20:02.261923300Z" level=info msg="loading plugin" id=io.containerd.nri.v1.nri type=io.containerd.nri.v1
May 27 03:20:02.261962 containerd[1926]: time="2025-05-27T03:20:02.261949700Z" level=info msg="runtime interface created"
May 27 03:20:02.261962 containerd[1926]: time="2025-05-27T03:20:02.261957700Z" level=info msg="created NRI interface"
May 27 03:20:02.262127 containerd[1926]: time="2025-05-27T03:20:02.261966700Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.cri type=io.containerd.grpc.v1
May 27 03:20:02.262127 containerd[1926]: time="2025-05-27T03:20:02.261978600Z" level=info msg="Connect containerd service"
May 27 03:20:02.262127 containerd[1926]: time="2025-05-27T03:20:02.262002000Z" level=info msg="using experimental NRI integration - disable nri plugin to prevent this"
May 27 03:20:02.262680 containerd[1926]: time="2025-05-27T03:20:02.262649000Z" 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 27 03:20:06.111826 containerd[1926]: time="2025-05-27T03:20:06.111773300Z" level=info msg="Start subscribing containerd event"
May 27 03:20:06.112204 containerd[1926]: time="2025-05-27T03:20:06.111830900Z" level=info msg="Start recovering state"
May 27 03:20:06.112204 containerd[1926]: time="2025-05-27T03:20:06.111945900Z" level=info msg="Start event monitor"
May 27 03:20:06.112204 containerd[1926]: time="2025-05-27T03:20:06.111968100Z" level=info msg="Start cni network conf syncer for default"
May 27 03:20:06.112204 containerd[1926]: time="2025-05-27T03:20:06.111978000Z" level=info msg="Start streaming server"
May 27 03:20:06.112204 containerd[1926]: time="2025-05-27T03:20:06.111992500Z" level=info msg=serving... address=/run/containerd/containerd.sock.ttrpc
May 27 03:20:06.112204 containerd[1926]: time="2025-05-27T03:20:06.112057100Z" level=info msg=serving... address=/run/containerd/containerd.sock
May 27 03:20:06.112204 containerd[1926]: time="2025-05-27T03:20:06.111995900Z" level=info msg="Registered namespace \"k8s.io\" with NRI"
May 27 03:20:06.112204 containerd[1926]: time="2025-05-27T03:20:06.112082500Z" level=info msg="runtime interface starting up..."
May 27 03:20:06.112204 containerd[1926]: time="2025-05-27T03:20:06.112088500Z" level=info msg="starting plugins..."
May 27 03:20:06.112204 containerd[1926]: time="2025-05-27T03:20:06.112106200Z" level=info msg="Synchronizing NRI (plugin) with current runtime state"
May 27 03:20:06.112499 containerd[1926]: time="2025-05-27T03:20:06.112245100Z" level=info msg="containerd successfully booted in 3.879124s"
May 27 03:20:06.112355 systemd[1]: Started containerd.service - containerd container runtime.
May 27 03:20:06.439000 login[2036]: pam_lastlog(login:session): file /var/log/lastlog is locked/write, retrying
May 27 03:20:06.439509 login[2035]: pam_unix(login:session): session opened for user core(uid=500) by LOGIN(uid=0)
May 27 03:20:06.445915 systemd[1]: Created slice user-500.slice - User Slice of UID 500.
May 27 03:20:06.447085 systemd[1]: Starting user-runtime-dir@500.service - User Runtime Directory /run/user/500...
May 27 03:20:06.455204 systemd-logind[1896]: New session 2 of user core.
May 27 03:20:06.472432 systemd[1]: Finished user-runtime-dir@500.service - User Runtime Directory /run/user/500.
May 27 03:20:06.475009 systemd[1]: Starting user@500.service - User Manager for UID 500...
May 27 03:20:06.953423 (systemd)[2076]: pam_unix(systemd-user:session): session opened for user core(uid=500) by (uid=0)
May 27 03:20:06.955913 systemd-logind[1896]: New session c1 of user core.
May 27 03:20:07.643160 login[2036]: pam_unix(login:session): session opened for user core(uid=500) by LOGIN(uid=0)
May 27 03:20:07.647771 systemd-logind[1896]: New session 1 of user core.
May 27 03:20:07.704100 systemd[2076]: Queued start job for default target default.target.
May 27 03:20:07.716147 systemd[2076]: Created slice app.slice - User Application Slice.
May 27 03:20:07.716179 systemd[2076]: Reached target paths.target - Paths.
May 27 03:20:07.716226 systemd[2076]: Reached target timers.target - Timers.
May 27 03:20:07.717600 systemd[2076]: Starting dbus.socket - D-Bus User Message Bus Socket...
May 27 03:20:07.728136 systemd[2076]: Listening on dbus.socket - D-Bus User Message Bus Socket.
May 27 03:20:07.728255 systemd[2076]: Reached target sockets.target - Sockets.
May 27 03:20:07.728309 systemd[2076]: Reached target basic.target - Basic System.
May 27 03:20:07.728351 systemd[2076]: Reached target default.target - Main User Target.
May 27 03:20:07.728382 systemd[2076]: Startup finished in 765ms.
May 27 03:20:07.728445 systemd[1]: Started user@500.service - User Manager for UID 500.
May 27 03:20:07.729871 systemd[1]: Started session-1.scope - Session 1 of User core.
May 27 03:20:07.730589 systemd[1]: Started session-2.scope - Session 2 of User core.
May 27 03:20:08.278916 waagent[2032]: 2025-05-27T03:20:08.278822Z INFO Daemon Daemon Azure Linux Agent Version: 2.12.0.4
May 27 03:20:08.280651 waagent[2032]: 2025-05-27T03:20:08.280603Z INFO Daemon Daemon OS: flatcar 4344.0.0
May 27 03:20:08.282098 waagent[2032]: 2025-05-27T03:20:08.282055Z INFO Daemon Daemon Python: 3.11.12
May 27 03:20:08.299684 waagent[2032]: 2025-05-27T03:20:08.283748Z INFO Daemon Daemon Run daemon
May 27 03:20:08.299684 waagent[2032]: 2025-05-27T03:20:08.284375Z INFO Daemon Daemon No RDMA handler exists for distro='Flatcar Container Linux by Kinvolk' version='4344.0.0'
May 27 03:20:08.299684 waagent[2032]: 2025-05-27T03:20:08.285052Z INFO Daemon Daemon Using waagent for provisioning
May 27 03:20:08.299684 waagent[2032]: 2025-05-27T03:20:08.286667Z INFO Daemon Daemon Activate resource disk
May 27 03:20:08.299684 waagent[2032]: 2025-05-27T03:20:08.288015Z INFO Daemon Daemon Searching gen1 prefix 00000000-0001 or gen2 f8b3781a-1e82-4818-a1c3-63d806ec15bb
May 27 03:20:08.299684 waagent[2032]: 2025-05-27T03:20:08.293114Z INFO Daemon Daemon Found device: sdb
May 27 03:20:08.320088 waagent[2032]: 2025-05-27T03:20:08.302937Z INFO Daemon Daemon Examining partition table
May 27 03:20:08.327156 waagent[2032]: 2025-05-27T03:20:08.327106Z INFO Daemon Daemon GPT not detected, determining filesystem
May 27 03:20:08.358071 waagent[2032]: 2025-05-27T03:20:08.357998Z INFO Daemon Daemon sfdisk --part-type -f /dev/sdb 1 -n succeeded
May 27 03:20:08.359761 waagent[2032]: 2025-05-27T03:20:08.359711Z INFO Daemon Daemon The partition is formatted with ntfs, updating partition type to 83
May 27 03:20:13.622710 kernel: hv_storvsc f8b3781a-1e82-4818-a1c3-63d806ec15bb: tag#507 cmd 0x5a status: scsi 0x2 srb 0x86 hv 0xc0000001
May 27 03:20:13.635433 kernel:  sdb: sdb1
May 27 03:20:13.645926 kernel: hv_storvsc f8b3781a-1e82-4818-a1c3-63d806ec15bb: tag#528 cmd 0x5a status: scsi 0x2 srb 0x86 hv 0xc0000001
May 27 03:20:13.656875 kernel:  sdb: sdb1
May 27 03:20:14.146616 waagent[2032]: 2025-05-27T03:20:14.146456Z INFO Daemon Daemon sfdisk --part-type  /dev/sdb 1 83 succeeded
May 27 03:20:14.177028 kernel: hv_storvsc f8b3781a-1e82-4818-a1c3-63d806ec15bb: tag#587 cmd 0x5a status: scsi 0x2 srb 0x86 hv 0xc0000001
May 27 03:20:14.193553 waagent[2032]: 2025-05-27T03:20:14.193497Z INFO Daemon Daemon Format partition [mkfs.ext4 -F /dev/sdb1]
May 27 03:20:14.197835 kernel:  sdb: sdb1
May 27 03:20:19.986632 waagent[2032]: 2025-05-27T03:20:19.986550Z INFO Daemon Daemon Mount resource disk [mount -t ext4 /dev/sdb1 /mnt/resource]
May 27 03:20:20.100724 waagent[2032]: 2025-05-27T03:20:20.100636Z INFO Daemon Daemon Resource disk /dev/sdb is mounted at /mnt/resource with ext4
May 27 03:20:20.100869 kernel: EXT4-fs (sdb1): mounted filesystem 0e759485-bdd5-410e-81ff-087d7382c24c r/w with ordered data mode. Quota mode: none.
May 27 03:20:20.137791 waagent[2032]: 2025-05-27T03:20:20.102886Z INFO Daemon Daemon Clean protocol and wireserver endpoint
May 27 03:20:20.137791 waagent[2032]: 2025-05-27T03:20:20.103211Z INFO Daemon Daemon Running default provisioning handler
May 27 03:20:20.137791 waagent[2032]: 2025-05-27T03:20:20.110754Z 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 27 03:20:20.137791 waagent[2032]: 2025-05-27T03:20:20.112355Z INFO Daemon Daemon Unable to get cloud-init enabled status from service: [Errno 2] No such file or directory: 'service'
May 27 03:20:20.137791 waagent[2032]: 2025-05-27T03:20:20.112804Z INFO Daemon Daemon cloud-init is enabled: False
May 27 03:20:20.137791 waagent[2032]: 2025-05-27T03:20:20.113547Z INFO Daemon Daemon Copying ovf-env.xml
May 27 03:20:20.454078 waagent[2032]: 2025-05-27T03:20:20.453951Z INFO Daemon Daemon Successfully mounted dvd
May 27 03:20:20.491399 systemd[1]: mnt-cdrom-secure.mount: Deactivated successfully.
May 27 03:20:20.493529 waagent[2032]: 2025-05-27T03:20:20.493470Z INFO Daemon Daemon Detect protocol endpoint
May 27 03:20:20.495378 waagent[2032]: 2025-05-27T03:20:20.495333Z INFO Daemon Daemon Clean protocol and wireserver endpoint
May 27 03:20:20.496840 waagent[2032]: 2025-05-27T03:20:20.496801Z INFO Daemon Daemon WireServer endpoint is not found. Rerun dhcp handler
May 27 03:20:20.497536 waagent[2032]: 2025-05-27T03:20:20.497502Z INFO Daemon Daemon Test for route to 168.63.129.16
May 27 03:20:20.499061 waagent[2032]: 2025-05-27T03:20:20.499019Z INFO Daemon Daemon Route to 168.63.129.16 exists
May 27 03:20:20.500438 waagent[2032]: 2025-05-27T03:20:20.500394Z INFO Daemon Daemon Wire server endpoint:168.63.129.16
May 27 03:20:20.600642 waagent[2032]: 2025-05-27T03:20:20.600588Z INFO Daemon Daemon Fabric preferred wire protocol version:2015-04-05
May 27 03:20:20.602440 waagent[2032]: 2025-05-27T03:20:20.602411Z INFO Daemon Daemon Wire protocol version:2012-11-30
May 27 03:20:20.603910 waagent[2032]: 2025-05-27T03:20:20.603875Z INFO Daemon Daemon Server preferred version:2015-04-05
May 27 03:20:20.707685 waagent[2032]: 2025-05-27T03:20:20.707554Z INFO Daemon Daemon Initializing goal state during protocol detection
May 27 03:20:20.709306 waagent[2032]: 2025-05-27T03:20:20.709256Z INFO Daemon Daemon Forcing an update of the goal state.
May 27 03:20:20.713987 waagent[2032]: 2025-05-27T03:20:20.713939Z INFO Daemon Fetched a new incarnation for the WireServer goal state [incarnation 1]
May 27 03:20:20.759634 waagent[2032]: 2025-05-27T03:20:20.759586Z INFO Daemon Daemon HostGAPlugin version: 1.0.8.164
May 27 03:20:20.761751 waagent[2032]: 2025-05-27T03:20:20.761708Z INFO Daemon
May 27 03:20:20.762835 waagent[2032]: 2025-05-27T03:20:20.762797Z INFO Daemon Fetched new vmSettings [HostGAPlugin correlation ID: ff185bb0-4e05-42f7-88bf-e8fb1f4126c6 eTag: 16553710305939259925 source: Fabric]
May 27 03:20:20.763843 waagent[2032]: 2025-05-27T03:20:20.763801Z INFO Daemon The vmSettings originated via Fabric; will ignore them.
May 27 03:20:20.765351 waagent[2032]: 2025-05-27T03:20:20.765307Z INFO Daemon
May 27 03:20:20.766583 waagent[2032]: 2025-05-27T03:20:20.766539Z INFO Daemon Fetching full goal state from the WireServer [incarnation 1]
May 27 03:20:20.771815 waagent[2032]: 2025-05-27T03:20:20.771776Z INFO Daemon Daemon Downloading artifacts profile blob
May 27 03:20:20.905647 waagent[2032]: 2025-05-27T03:20:20.905579Z INFO Daemon Downloaded certificate {'thumbprint': '3179DE23DF58A11EF20604F533F0922DA5C603B7', 'hasPrivateKey': True}
May 27 03:20:20.907883 waagent[2032]: 2025-05-27T03:20:20.907823Z INFO Daemon Fetch goal state completed
May 27 03:20:20.944117 waagent[2032]: 2025-05-27T03:20:20.944077Z INFO Daemon Daemon Starting provisioning
May 27 03:20:20.945882 waagent[2032]: 2025-05-27T03:20:20.945827Z INFO Daemon Daemon Handle ovf-env.xml.
May 27 03:20:20.946551 waagent[2032]: 2025-05-27T03:20:20.946518Z INFO Daemon Daemon Set hostname [ci-4344.0.0-a-eba636b31a]
May 27 03:20:20.995891 waagent[2032]: 2025-05-27T03:20:20.995833Z INFO Daemon Daemon Publish hostname [ci-4344.0.0-a-eba636b31a]
May 27 03:20:20.997644 waagent[2032]: 2025-05-27T03:20:20.997596Z INFO Daemon Daemon Examine /proc/net/route for primary interface
May 27 03:20:20.999073 waagent[2032]: 2025-05-27T03:20:20.999037Z INFO Daemon Daemon Primary interface is [eth0]
May 27 03:20:21.016068 systemd-networkd[1595]: eth0: found matching network '/usr/lib/systemd/network/zz-default.network', based on potentially unpredictable interface name.
May 27 03:20:21.016078 systemd-networkd[1595]: eth0: Configuring with /usr/lib/systemd/network/zz-default.network.
May 27 03:20:21.016102 systemd-networkd[1595]: eth0: DHCP lease lost
May 27 03:20:21.016503 waagent[2032]: 2025-05-27T03:20:21.016460Z INFO Daemon Daemon Create user account if not exists
May 27 03:20:21.018174 waagent[2032]: 2025-05-27T03:20:21.018135Z INFO Daemon Daemon User core already exists, skip useradd
May 27 03:20:21.018889 waagent[2032]: 2025-05-27T03:20:21.018845Z INFO Daemon Daemon Configure sudoer
May 27 03:20:21.024021 waagent[2032]: 2025-05-27T03:20:21.023983Z INFO Daemon Daemon Configure sshd
May 27 03:20:21.031276 waagent[2032]: 2025-05-27T03:20:21.031231Z INFO Daemon Daemon Added a configuration snippet disabling SSH password-based authentication methods. It also configures SSH client probing to keep connections alive.
May 27 03:20:21.032895 waagent[2032]: 2025-05-27T03:20:21.032830Z INFO Daemon Daemon Deploy ssh public key.
May 27 03:20:21.114912 systemd-networkd[1595]: eth0: DHCPv4 address 10.200.8.34/24, gateway 10.200.8.1 acquired from 168.63.129.16
May 27 03:20:22.530577 chronyd[1931]: Selected source PHC0
May 27 03:20:22.873447 setup-nvidia[2046]: \u000d  0     0    0     0    0     0      0      0 --:--:-- --:--:-- --:--:--     0\u000d  0  486M    0 81920    0     0    99k      0  1:23:51 --:--:--  1:23:51   99k\u000d  1  486M    1 9776k    0     0  5126k      0  0:01:37  0:00:01  0:01:36 5126k\u000d  7  486M    7 34.9M    0     0  12.0M      0  0:00:40  0:00:02  0:00:38 12.0M\u000d 12  486M   12 60.2M    0     0  15.5M      0  0:00:31  0:00:03  0:00:28 15.5M\u000d 17  486M   17 85.6M    0     0  17.5M      0  0:00:27  0:00:04  0:00:23 17.5M\u000d 22  486M   22  111M    0     0  18.9M      0  0:00:25  0:00:05  0:00:20 21.9M\u000d 26  486M   26  129M    0     0  18.7M      0  0:00:25  0:00:06  0:00:19 23.9M\u000d 30  486M   30  149M    0     0  18.9M      0  0:00:25  0:00:07  0:00:18 23.0M\u000d 36  486M   36  175M    0     0  19.7M      0  0:00:24  0:00:08  0:00:16 22.9M\u000d 41  486M   41  200M    0     0  20.3M      0  0:00:23  0:00:09  0:00:14 23.0M\u000d 46  486M   46  225M    0     0  20.8M      0  0:00:23  0:00:10  0:00:13 23.0M\u000d 51  486M   51  251M    0     0  21.2M      0  0:00:22  0:00:11  0:00:11 24.7M\u000d 52  486M   52  254M    0     0  19.8M      0  0:00:24  0:00:12  0:00:12 21.1M\u000d 57  486M   57  277M    0     0  20.0M      0  0:00:24  0:00:13  0:00:11 20.6M\u000d 62  486M   62  303M    0     0  20.4M      0  0:00:23  0:00:14  0:00:09 20.6M\u000d 67  486M   67  328M    0     0  20.7M      0  0:00:23  0:00:15  0:00:08 20.6M\u000d 72  486M   72  354M    0     0  21.0M      0  0:00:23  0:00:16  0:00:07 20.6M\u000d 77  486M   77  379M    0     0  21.3M      0  0:00:22  0:00:17  0:00:05 25.2M\u000d 83  486M   83  404M    0     0  21.5M      0  0:00:22  0:00:18  0:00:04 25.5M\u000d 88  486M   88  430M    0     0  21.6M      0  0:00:22  0:00:19  0:00:03 25.1M\u000d 93  486M   93  452M    0     0  21.6M      0  0:00:22  0:00:20  0:00:02 24.5M\u000d 98  486M   98  477M    0     0  21.8M      0  0:00:22  0:00:21  0:00:01 24.5M\u000d100  486M  100  486M    0     0  21.9M      0  0:00:22  0:00:22 --:--:-- 24.6M
May 27 03:20:34.347113 setup-nvidia[1890]: Downloading NVIDIA 535.230.02 Driver
May 27 03:20:34.351641 setup-nvidia[2225]:   % Total    % Received % Xferd  Average Speed   Time    Time     Time  Current
May 27 03:20:34.351936 setup-nvidia[2225]:                                  Dload  Upload   Total   Spent    Left  Speed
May 27 03:20:34.523678 kernel: hv_balloon: Max. dynamic memory size: 114688 MB
May 27 03:20:35.446808 setup-nvidia[2225]: \u000d  0     0    0     0    0     0      0      0 --:--:-- --:--:-- --:--:--     0\u000d  8  326M    8 27.6M    0     0   156M      0  0:00:02 --:--:--  0:00:02  156M\u000d100  326M  100  326M    0     0   297M      0  0:00:01  0:00:01 --:--:--  297M
May 27 03:20:35.547568 setup-nvidia[1890]: Extract the NVIDIA Driver Installer 535.230.02
May 27 03:20:35.547834 setup-nvidia[1890]: /opt/nvidia/workdir/nvidia-workdir /
May 27 03:20:35.591581 setup-nvidia[2228]: Creating directory NVIDIA-Linux-x86_64-535.230.02
May 27 03:20:35.824888 setup-nvidia[2228]: Verifying archive integrity... OK
May 27 03:20:36.585247 setup-nvidia[2228]: Uncompressing NVIDIA Accelerated Graphics Driver for Linux-x86_64 535.230.02
May 27 03:20:38.352648 setup-nvidia[2254]: ........................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................
May 27 03:20:38.435355 setup-nvidia[1890]: /
May 27 03:20:38.435621 setup-nvidia[1890]: Spawn system-nspawn container to install the NVIDIA drivers
May 27 03:20:38.783500 sudo[2261]:     root : PWD=/ ; USER=root ; COMMAND=/usr/sbin/systemd-nspawn --keep-unit --register=no --read-only --volatile=overlay --image=/opt/nvidia/workdir/flatcar_developer_container-4344.0.0.bin --overlay=/usr/lib/modules::/usr/lib/modules --bind=/opt/nvidia/workdir/nvidia-workdir:/nvidia --bind=/usr/lib/nvidia/bin:/app/bin/ /app/bin/install-nvidia NVIDIA-Linux-x86_64-535.230.02
May 27 03:20:38.785256 sudo[2261]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=0)
May 27 03:20:38.790714 systemd[1]: Created slice user-0.slice - User Slice of UID 0.
May 27 03:20:38.791687 systemd[1]: Starting user-runtime-dir@0.service - User Runtime Directory /run/user/0...
May 27 03:20:38.819156 systemd[1]: Finished user-runtime-dir@0.service - User Runtime Directory /run/user/0.
May 27 03:20:38.821463 systemd[1]: Starting user@0.service - User Manager for UID 0...
May 27 03:20:38.838709 (systemd)[2264]: pam_unix(systemd-user:session): session opened for user root(uid=0) by (uid=0)
May 27 03:20:38.840918 systemd-logind[1896]: New session c3 of user root.
May 27 03:20:39.026308 systemd[2264]: Queued start job for default target default.target.
May 27 03:20:39.042927 systemd[2264]: Created slice app.slice - User Application Slice.
May 27 03:20:39.042956 systemd[2264]: Reached target paths.target - Paths.
May 27 03:20:39.043002 systemd[2264]: Reached target timers.target - Timers.
May 27 03:20:39.044151 systemd[2264]: Starting dbus.socket - D-Bus User Message Bus Socket...
May 27 03:20:39.054516 systemd[2264]: Listening on dbus.socket - D-Bus User Message Bus Socket.
May 27 03:20:39.054574 systemd[2264]: Reached target sockets.target - Sockets.
May 27 03:20:39.054627 systemd[2264]: Reached target basic.target - Basic System.
May 27 03:20:39.054671 systemd[2264]: Reached target default.target - Main User Target.
May 27 03:20:39.054709 systemd[2264]: Startup finished in 208ms.
May 27 03:20:39.054776 systemd[1]: Started user@0.service - User Manager for UID 0.
May 27 03:20:39.056199 systemd[1]: Started session-c2.scope - Session c2 of User root.
May 27 03:20:39.148876 kernel: loop6: detected capacity change from 0 to 12644352
May 27 03:20:39.185875 kernel:  loop6: p9
May 27 03:20:39.286835 setup-nvidia[2273]: ░ Spawning container flatcardevelopercontainer-4344.0.0.bin on /opt/nvidia/workdir/flatcar_developer_container-4344.0.0.bin.
May 27 03:20:40.796390 kernel: EXT4-fs (loop6p9): write access unavailable, skipping orphan cleanup
May 27 03:20:40.796513 kernel: EXT4-fs (loop6p9): mounted filesystem 7688ef19-dafb-42a7-9a4a-77f2194be168 ro without journal. Quota mode: none.
May 27 03:20:44.380410 update_engine[1899]: I20250527 03:20:44.380333  1899 update_attempter.cc:509] Updating boot flags...
May 27 03:20:51.131273 waagent[2032]: 2025-05-27T03:20:51.131198Z INFO Daemon Daemon Provisioning complete
May 27 03:20:51.141408 waagent[2032]: 2025-05-27T03:20:51.141355Z INFO Daemon Daemon RDMA capabilities are not enabled, skipping
May 27 03:20:51.142979 waagent[2032]: 2025-05-27T03:20:51.142937Z INFO Daemon Daemon End of log to /dev/console. The agent will now check for updates and then will process extensions.
May 27 03:20:51.143683 waagent[2032]: 2025-05-27T03:20:51.143647Z INFO Daemon Daemon Installed Agent WALinuxAgent-2.12.0.4 is the most current agent
May 27 03:20:51.296144 waagent[2496]: 2025-05-27T03:20:51.296064Z INFO ExtHandler ExtHandler Azure Linux Agent (Goal State Agent version 2.12.0.4)
May 27 03:20:51.296490 waagent[2496]: 2025-05-27T03:20:51.296212Z INFO ExtHandler ExtHandler OS: flatcar 4344.0.0
May 27 03:20:51.296490 waagent[2496]: 2025-05-27T03:20:51.296286Z INFO ExtHandler ExtHandler Python: 3.11.12
May 27 03:20:51.296490 waagent[2496]: 2025-05-27T03:20:51.296360Z INFO ExtHandler ExtHandler CPU Arch: x86_64
May 27 03:20:51.396843 waagent[2496]: 2025-05-27T03:20:51.396737Z INFO ExtHandler ExtHandler Distro: flatcar-4344.0.0; OSUtil: FlatcarUtil; AgentService: waagent; Python: 3.11.12; Arch: x86_64; systemd: True; LISDrivers: Absent; logrotate: logrotate 3.22.0;
May 27 03:20:51.397018 waagent[2496]: 2025-05-27T03:20:51.396979Z INFO ExtHandler ExtHandler WireServer endpoint 168.63.129.16 read from file
May 27 03:20:51.397102 waagent[2496]: 2025-05-27T03:20:51.397071Z INFO ExtHandler ExtHandler Wire server endpoint:168.63.129.16
May 27 03:20:51.403735 waagent[2496]: 2025-05-27T03:20:51.403689Z INFO ExtHandler Fetched a new incarnation for the WireServer goal state [incarnation 1]
May 27 03:20:51.413720 waagent[2496]: 2025-05-27T03:20:51.413671Z INFO ExtHandler ExtHandler HostGAPlugin version: 1.0.8.164
May 27 03:20:51.414176 waagent[2496]: 2025-05-27T03:20:51.414136Z INFO ExtHandler
May 27 03:20:51.414261 waagent[2496]: 2025-05-27T03:20:51.414229Z INFO ExtHandler Fetched new vmSettings [HostGAPlugin correlation ID: 48c7a324-0e53-4401-96d8-08b996339970 eTag: 16553710305939259925 source: Fabric]
May 27 03:20:51.414585 waagent[2496]: 2025-05-27T03:20:51.414547Z INFO ExtHandler The vmSettings originated via Fabric; will ignore them.
May 27 03:20:51.415227 waagent[2496]: 2025-05-27T03:20:51.415188Z INFO ExtHandler
May 27 03:20:51.415301 waagent[2496]: 2025-05-27T03:20:51.415270Z INFO ExtHandler Fetching full goal state from the WireServer [incarnation 1]
May 27 03:20:51.418518 waagent[2496]: 2025-05-27T03:20:51.418487Z INFO ExtHandler ExtHandler Downloading artifacts profile blob
May 27 03:20:51.477267 waagent[2496]: 2025-05-27T03:20:51.477177Z INFO ExtHandler Downloaded certificate {'thumbprint': '3179DE23DF58A11EF20604F533F0922DA5C603B7', 'hasPrivateKey': True}
May 27 03:20:51.477778 waagent[2496]: 2025-05-27T03:20:51.477698Z INFO ExtHandler Fetch goal state completed
May 27 03:20:51.489076 waagent[2496]: 2025-05-27T03:20:51.489032Z INFO ExtHandler ExtHandler OpenSSL version: OpenSSL 3.3.3 11 Feb 2025 (Library: OpenSSL 3.3.3 11 Feb 2025)
May 27 03:20:51.494071 waagent[2496]: 2025-05-27T03:20:51.494018Z INFO ExtHandler ExtHandler WALinuxAgent-2.12.0.4 running as process 2496
May 27 03:20:51.494213 waagent[2496]: 2025-05-27T03:20:51.494176Z INFO ExtHandler ExtHandler ******** AutoUpdate.Enabled is set to False, not processing the operation ********
May 27 03:20:51.494559 waagent[2496]: 2025-05-27T03:20:51.494522Z INFO ExtHandler ExtHandler ******** AutoUpdate.UpdateToLatestVersion is set to False, not processing the operation ********
May 27 03:20:51.496204 waagent[2496]: 2025-05-27T03:20:51.496164Z INFO ExtHandler ExtHandler [CGI] Cgroup monitoring is not supported on ['flatcar', '4344.0.0', '', 'Flatcar Container Linux by Kinvolk']
May 27 03:20:51.496647 waagent[2496]: 2025-05-27T03:20:51.496609Z INFO ExtHandler ExtHandler [CGI] Agent will reset the quotas in case distro: ['flatcar', '4344.0.0', '', 'Flatcar Container Linux by Kinvolk'] went from supported to unsupported
May 27 03:20:51.496804 waagent[2496]: 2025-05-27T03:20:51.496770Z INFO ExtHandler ExtHandler [CGI] Agent cgroups enabled: False
May 27 03:20:51.497465 waagent[2496]: 2025-05-27T03:20:51.497427Z INFO ExtHandler ExtHandler Starting setup for Persistent firewall rules
May 27 03:20:51.641429 waagent[2496]: 2025-05-27T03:20:51.641385Z INFO ExtHandler ExtHandler Firewalld service not running/unavailable, trying to set up waagent-network-setup.service
May 27 03:20:51.641622 waagent[2496]: 2025-05-27T03:20:51.641580Z INFO ExtHandler ExtHandler Successfully updated the Binary file /var/lib/waagent/waagent-network-setup.py for firewall setup
May 27 03:20:51.649134 waagent[2496]: 2025-05-27T03:20:51.649067Z INFO ExtHandler ExtHandler Service: waagent-network-setup.service not enabled. Adding it now
May 27 03:20:51.656102 systemd[1]: Reload requested from client PID 2604 ('systemctl') (unit waagent.service)...
May 27 03:20:51.656118 systemd[1]: Reloading...
May 27 03:20:51.720885 zram_generator::config[2655]: No configuration found.
May 27 03:20:51.830118 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 27 03:20:51.998155 systemd[1]: Reloading finished in 341 ms.
May 27 03:20:52.012682 waagent[2496]: 2025-05-27T03:20:52.012606Z INFO ExtHandler ExtHandler Successfully added and enabled the waagent-network-setup.service
May 27 03:20:52.012779 waagent[2496]: 2025-05-27T03:20:52.012752Z INFO ExtHandler ExtHandler Persistent firewall rules setup successfully
May 27 03:20:53.130946 waagent[2496]: 2025-05-27T03:20:53.130720Z INFO ExtHandler ExtHandler DROP rule is not available which implies no firewall rules are set yet. Environment thread will set it up.
May 27 03:20:53.130946 waagent[2496]: 2025-05-27T03:20:53.131182Z 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 27 03:20:53.132119 waagent[2496]: 2025-05-27T03:20:53.131967Z INFO ExtHandler ExtHandler Starting env monitor service.
May 27 03:20:53.132459 waagent[2496]: 2025-05-27T03:20:53.132402Z INFO MonitorHandler ExtHandler WireServer endpoint 168.63.129.16 read from file
May 27 03:20:53.133067 waagent[2496]: 2025-05-27T03:20:53.133019Z INFO ExtHandler ExtHandler Start SendTelemetryHandler service.
May 27 03:20:53.133175 waagent[2496]: 2025-05-27T03:20:53.133132Z INFO EnvHandler ExtHandler WireServer endpoint 168.63.129.16 read from file
May 27 03:20:53.133600 waagent[2496]: 2025-05-27T03:20:53.133561Z INFO MonitorHandler ExtHandler Wire server endpoint:168.63.129.16
May 27 03:20:53.133708 waagent[2496]: 2025-05-27T03:20:53.133669Z INFO EnvHandler ExtHandler Wire server endpoint:168.63.129.16
May 27 03:20:53.133961 waagent[2496]: 2025-05-27T03:20:53.133916Z INFO MonitorHandler ExtHandler Monitor.NetworkConfigurationChanges is disabled.
May 27 03:20:53.134755 waagent[2496]: 2025-05-27T03:20:53.134694Z INFO SendTelemetryHandler ExtHandler Successfully started the SendTelemetryHandler thread
May 27 03:20:53.134895 waagent[2496]: 2025-05-27T03:20:53.134834Z INFO EnvHandler ExtHandler Configure routes
May 27 03:20:53.135227 waagent[2496]: 2025-05-27T03:20:53.135093Z INFO ExtHandler ExtHandler Start Extension Telemetry service.
May 27 03:20:53.135670 waagent[2496]: 2025-05-27T03:20:53.135591Z INFO MonitorHandler ExtHandler Routing table from /proc/net/route:
May 27 03:20:53.135670 waagent[2496]: Iface        Destination        Gateway         Flags        RefCnt        Use        Metric        Mask                MTU        Window        IRTT
May 27 03:20:53.135670 waagent[2496]: eth0        00000000        0108C80A        0003        0        0        1024        00000000        0        0        0
May 27 03:20:53.135670 waagent[2496]: eth0        0008C80A        00000000        0001        0        0        1024        00FFFFFF        0        0        0
May 27 03:20:53.135670 waagent[2496]: eth0        0108C80A        00000000        0005        0        0        1024        FFFFFFFF        0        0        0
May 27 03:20:53.135670 waagent[2496]: eth0        10813FA8        0108C80A        0007        0        0        1024        FFFFFFFF        0        0        0
May 27 03:20:53.135670 waagent[2496]: eth0        FEA9FEA9        0108C80A        0007        0        0        1024        FFFFFFFF        0        0        0
May 27 03:20:53.135978 waagent[2496]: 2025-05-27T03:20:53.135938Z INFO EnvHandler ExtHandler Gateway:None
May 27 03:20:53.136329 waagent[2496]: 2025-05-27T03:20:53.136294Z INFO EnvHandler ExtHandler Routes:None
May 27 03:20:53.136453 waagent[2496]: 2025-05-27T03:20:53.136402Z INFO TelemetryEventsCollector ExtHandler Extension Telemetry pipeline enabled: True
May 27 03:20:53.136718 waagent[2496]: 2025-05-27T03:20:53.136665Z INFO ExtHandler ExtHandler Goal State Period: 6 sec. This indicates how often the agent checks for new goal states and reports status.
May 27 03:20:53.137441 waagent[2496]: 2025-05-27T03:20:53.137227Z INFO TelemetryEventsCollector ExtHandler Successfully started the TelemetryEventsCollector thread
May 27 03:20:53.143971 waagent[2496]: 2025-05-27T03:20:53.143924Z INFO ExtHandler ExtHandler
May 27 03:20:53.144370 waagent[2496]: 2025-05-27T03:20:53.144317Z INFO ExtHandler ExtHandler ProcessExtensionsGoalState started [incarnation_1 channel: WireServer source: Fabric activity: e34850e8-8387-4a29-9e81-2a4185e592c3 correlation b9b8fffb-651c-43f4-a6e1-ba8f71aeff96 created: 2025-05-27T03:18:15.401123Z]
May 27 03:20:53.145617 waagent[2496]: 2025-05-27T03:20:53.145570Z INFO ExtHandler ExtHandler No extension handlers found, not processing anything.
May 27 03:20:53.148208 waagent[2496]: 2025-05-27T03:20:53.148165Z INFO ExtHandler ExtHandler ProcessExtensionsGoalState completed [incarnation_1 4 ms]
May 27 03:20:53.173095 waagent[2496]: 2025-05-27T03:20:53.173038Z 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 27 03:20:53.173095 waagent[2496]: Try `iptables -h' or 'iptables --help' for more information.)
May 27 03:20:53.173512 waagent[2496]: 2025-05-27T03:20:53.173472Z INFO ExtHandler ExtHandler [HEARTBEAT] Agent WALinuxAgent-2.12.0.4 is running as the goal state agent [DEBUG HeartbeatCounter: 0;HeartbeatId: B0F94166-074D-48DA-A8B4-6C833AE81891;DroppedPackets: -1;UpdateGSErrors: 0;AutoUpdate: 0;UpdateMode: SelfUpdate;]
May 27 03:20:53.243684 waagent[2496]: 2025-05-27T03:20:53.243609Z INFO MonitorHandler ExtHandler Network interfaces:
May 27 03:20:53.243684 waagent[2496]: Executing ['ip', '-a', '-o', 'link']:
May 27 03:20:53.243684 waagent[2496]: 1: lo: <LOOPBACK,UP,LOWER_UP> 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 27 03:20:53.243684 waagent[2496]: 2: eth0: <BROADCAST,MULTICAST,UP,LOWER_UP> mtu 1500 qdisc mq state UP mode DEFAULT group default qlen 1000\    link/ether 00:0d:3a:df:13:ed brd ff:ff:ff:ff:ff:ff
May 27 03:20:53.243684 waagent[2496]: Executing ['ip', '-4', '-a', '-o', 'address']:
May 27 03:20:53.243684 waagent[2496]: 1: lo    inet 127.0.0.1/8 scope host lo\       valid_lft forever preferred_lft forever
May 27 03:20:53.243684 waagent[2496]: 2: eth0    inet 10.200.8.34/24 metric 1024 brd 10.200.8.255 scope global eth0\       valid_lft forever preferred_lft forever
May 27 03:20:53.243684 waagent[2496]: Executing ['ip', '-6', '-a', '-o', 'address']:
May 27 03:20:53.243684 waagent[2496]: 1: lo    inet6 ::1/128 scope host noprefixroute \       valid_lft forever preferred_lft forever
May 27 03:20:53.243684 waagent[2496]: 2: eth0    inet6 fe80::20d:3aff:fedf:13ed/64 scope link proto kernel_ll \       valid_lft forever preferred_lft forever
May 27 03:20:53.342221 waagent[2496]: 2025-05-27T03:20:53.342160Z INFO EnvHandler ExtHandler Created firewall rules for the Azure Fabric:
May 27 03:20:53.342221 waagent[2496]: Chain INPUT (policy ACCEPT 0 packets, 0 bytes)
May 27 03:20:53.342221 waagent[2496]:     pkts      bytes target     prot opt in     out     source               destination
May 27 03:20:53.342221 waagent[2496]: Chain FORWARD (policy ACCEPT 0 packets, 0 bytes)
May 27 03:20:53.342221 waagent[2496]:     pkts      bytes target     prot opt in     out     source               destination
May 27 03:20:53.342221 waagent[2496]: Chain OUTPUT (policy ACCEPT 0 packets, 0 bytes)
May 27 03:20:53.342221 waagent[2496]:     pkts      bytes target     prot opt in     out     source               destination
May 27 03:20:53.342221 waagent[2496]:        0        0 ACCEPT     tcp  --  *      *       0.0.0.0/0            168.63.129.16        tcp dpt:53
May 27 03:20:53.342221 waagent[2496]:        0        0 ACCEPT     tcp  --  *      *       0.0.0.0/0            168.63.129.16        owner UID match 0
May 27 03:20:53.342221 waagent[2496]:        0        0 DROP       tcp  --  *      *       0.0.0.0/0            168.63.129.16        ctstate INVALID,NEW
May 27 03:20:53.345581 waagent[2496]: 2025-05-27T03:20:53.345541Z INFO EnvHandler ExtHandler Current Firewall rules:
May 27 03:20:53.345581 waagent[2496]: Chain INPUT (policy ACCEPT 0 packets, 0 bytes)
May 27 03:20:53.345581 waagent[2496]:     pkts      bytes target     prot opt in     out     source               destination
May 27 03:20:53.345581 waagent[2496]: Chain FORWARD (policy ACCEPT 0 packets, 0 bytes)
May 27 03:20:53.345581 waagent[2496]:     pkts      bytes target     prot opt in     out     source               destination
May 27 03:20:53.345581 waagent[2496]: Chain OUTPUT (policy ACCEPT 0 packets, 0 bytes)
May 27 03:20:53.345581 waagent[2496]:     pkts      bytes target     prot opt in     out     source               destination
May 27 03:20:53.345581 waagent[2496]:        0        0 ACCEPT     tcp  --  *      *       0.0.0.0/0            168.63.129.16        tcp dpt:53
May 27 03:20:53.345581 waagent[2496]:        0        0 ACCEPT     tcp  --  *      *       0.0.0.0/0            168.63.129.16        owner UID match 0
May 27 03:20:53.345581 waagent[2496]:        0        0 DROP       tcp  --  *      *       0.0.0.0/0            168.63.129.16        ctstate INVALID,NEW
May 27 03:20:53.345834 waagent[2496]: 2025-05-27T03:20:53.345801Z INFO EnvHandler ExtHandler Set block dev timeout: sdb with timeout: 300
May 27 03:20:53.346006 waagent[2496]: 2025-05-27T03:20:53.345976Z INFO EnvHandler ExtHandler Set block dev timeout: sda with timeout: 300
May 27 03:21:02.895410 systemd[1]: Created slice system-sshd.slice - Slice /system/sshd.
May 27 03:21:02.898111 systemd[1]: Started sshd@0-10.200.8.34:22-10.200.16.10:47350.service - OpenSSH per-connection server daemon (10.200.16.10:47350).
May 27 03:21:05.046233 sshd[3349]: Accepted publickey for core from 10.200.16.10 port 47350 ssh2: RSA SHA256:4qrJWLsdicuYlAkd8Pkq9rLEez3YC6Ax2cIipYpsYNE
May 27 03:21:05.047516 sshd-session[3349]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0)
May 27 03:21:05.051770 systemd-logind[1896]: New session 3 of user core.
May 27 03:21:05.060975 systemd[1]: Started session-3.scope - Session 3 of User core.
May 27 03:21:05.603227 systemd[1]: Started sshd@1-10.200.8.34:22-10.200.16.10:47358.service - OpenSSH per-connection server daemon (10.200.16.10:47358).
May 27 03:21:06.230867 sshd[3404]: Accepted publickey for core from 10.200.16.10 port 47358 ssh2: RSA SHA256:4qrJWLsdicuYlAkd8Pkq9rLEez3YC6Ax2cIipYpsYNE
May 27 03:21:06.232162 sshd-session[3404]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0)
May 27 03:21:06.237416 systemd-logind[1896]: New session 4 of user core.
May 27 03:21:06.246977 systemd[1]: Started session-4.scope - Session 4 of User core.
May 27 03:21:06.939606 sshd[3406]: Connection closed by 10.200.16.10 port 47358
May 27 03:21:06.802247 systemd[1]: Started sshd@2-10.200.8.34:22-10.200.16.10:47364.service - OpenSSH per-connection server daemon (10.200.16.10:47364).
May 27 03:21:06.939683 sshd-session[3404]: pam_unix(sshd:session): session closed for user core
May 27 03:21:06.942951 systemd[1]: sshd@1-10.200.8.34:22-10.200.16.10:47358.service: Deactivated successfully.
May 27 03:21:06.944408 systemd[1]: session-4.scope: Deactivated successfully.
May 27 03:21:06.945156 systemd-logind[1896]: Session 4 logged out. Waiting for processes to exit.
May 27 03:21:06.946332 systemd-logind[1896]: Removed session 4.
May 27 03:21:07.427259 sshd[3409]: Accepted publickey for core from 10.200.16.10 port 47364 ssh2: RSA SHA256:4qrJWLsdicuYlAkd8Pkq9rLEez3YC6Ax2cIipYpsYNE
May 27 03:21:07.428709 sshd-session[3409]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0)
May 27 03:21:07.433226 systemd-logind[1896]: New session 5 of user core.
May 27 03:21:07.444985 systemd[1]: Started session-5.scope - Session 5 of User core.
May 27 03:21:07.868565 sshd[3414]: Connection closed by 10.200.16.10 port 47364
May 27 03:21:07.868922 sshd-session[3409]: pam_unix(sshd:session): session closed for user core
May 27 03:21:07.872271 systemd[1]: sshd@2-10.200.8.34:22-10.200.16.10:47364.service: Deactivated successfully.
May 27 03:21:07.873736 systemd[1]: session-5.scope: Deactivated successfully.
May 27 03:21:07.874409 systemd-logind[1896]: Session 5 logged out. Waiting for processes to exit.
May 27 03:21:07.875331 systemd-logind[1896]: Removed session 5.
May 27 03:21:17.984281 systemd[1]: Started sshd@3-10.200.8.34:22-10.200.16.10:57446.service - OpenSSH per-connection server daemon (10.200.16.10:57446).
May 27 03:21:18.610597 sshd[3445]: Accepted publickey for core from 10.200.16.10 port 57446 ssh2: RSA SHA256:4qrJWLsdicuYlAkd8Pkq9rLEez3YC6Ax2cIipYpsYNE
May 27 03:21:18.611927 sshd-session[3445]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0)
May 27 03:21:18.616230 systemd-logind[1896]: New session 6 of user core.
May 27 03:21:18.627982 systemd[1]: Started session-6.scope - Session 6 of User core.
May 27 03:21:19.051705 sshd[3447]: Connection closed by 10.200.16.10 port 57446
May 27 03:21:19.053504 sshd-session[3445]: pam_unix(sshd:session): session closed for user core
May 27 03:21:19.058583 systemd[1]: sshd@3-10.200.8.34:22-10.200.16.10:57446.service: Deactivated successfully.
May 27 03:21:19.060348 systemd[1]: session-6.scope: Deactivated successfully.
May 27 03:21:19.061202 systemd-logind[1896]: Session 6 logged out. Waiting for processes to exit.
May 27 03:21:19.062825 systemd-logind[1896]: Removed session 6.
May 27 03:21:19.161367 systemd[1]: Started sshd@4-10.200.8.34:22-10.200.16.10:59482.service - OpenSSH per-connection server daemon (10.200.16.10:59482).
May 27 03:21:19.796338 sshd[3642]: Accepted publickey for core from 10.200.16.10 port 59482 ssh2: RSA SHA256:4qrJWLsdicuYlAkd8Pkq9rLEez3YC6Ax2cIipYpsYNE
May 27 03:21:19.797604 sshd-session[3642]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0)
May 27 03:21:19.801919 systemd-logind[1896]: New session 7 of user core.
May 27 03:21:19.816994 systemd[1]: Started session-7.scope - Session 7 of User core.
May 27 03:21:20.239021 sshd[3940]: Connection closed by 10.200.16.10 port 59482
May 27 03:21:20.239388 sshd-session[3642]: pam_unix(sshd:session): session closed for user core
May 27 03:21:20.242888 systemd[1]: sshd@4-10.200.8.34:22-10.200.16.10:59482.service: Deactivated successfully.
May 27 03:21:20.244431 systemd[1]: session-7.scope: Deactivated successfully.
May 27 03:21:20.245143 systemd-logind[1896]: Session 7 logged out. Waiting for processes to exit.
May 27 03:21:20.246080 systemd-logind[1896]: Removed session 7.
May 27 03:21:30.356388 systemd[1]: Started sshd@5-10.200.8.34:22-10.200.16.10:43020.service - OpenSSH per-connection server daemon (10.200.16.10:43020).
May 27 03:21:31.002272 sshd-session[5452]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0)
May 27 03:21:31.006446 systemd-logind[1896]: New session 8 of user core.
May 27 03:21:37.436337 sshd[5452]: Accepted publickey for core from 10.200.16.10 port 43020 ssh2: RSA SHA256:4qrJWLsdicuYlAkd8Pkq9rLEez3YC6Ax2cIipYpsYNE
May 27 03:21:31.454871 sshd-session[5452]: pam_unix(sshd:session): session closed for user core
May 27 03:21:31.016985 systemd[1]: Started session-8.scope - Session 8 of User core.
May 27 03:21:37.436881 sshd[5454]: Connection closed by 10.200.16.10 port 43020
May 27 03:21:37.436975 sshd[5459]: Accepted publickey for core from 10.200.16.10 port 43034 ssh2: RSA SHA256:4qrJWLsdicuYlAkd8Pkq9rLEez3YC6Ax2cIipYpsYNE
May 27 03:21:32.232115 sshd-session[5459]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0)
May 27 03:21:31.457678 systemd[1]: sshd@5-10.200.8.34:22-10.200.16.10:43020.service: Deactivated successfully.
May 27 03:21:37.437295 sshd[5461]: Connection closed by 10.200.16.10 port 43034
May 27 03:21:32.675354 sshd-session[5459]: pam_unix(sshd:session): session closed for user core
May 27 03:21:31.459310 systemd[1]: session-8.scope: Deactivated successfully.
May 27 03:21:31.459981 systemd-logind[1896]: Session 8 logged out. Waiting for processes to exit.
May 27 03:21:31.460911 systemd-logind[1896]: Removed session 8.
May 27 03:21:31.585217 systemd[1]: Started sshd@6-10.200.8.34:22-10.200.16.10:43034.service - OpenSSH per-connection server daemon (10.200.16.10:43034).
May 27 03:21:32.236382 systemd-logind[1896]: New session 9 of user core.
May 27 03:21:32.252984 systemd[1]: Started session-9.scope - Session 9 of User core.
May 27 03:21:32.677941 systemd[1]: sshd@6-10.200.8.34:22-10.200.16.10:43034.service: Deactivated successfully.
May 27 03:21:32.679541 systemd[1]: session-9.scope: Deactivated successfully.
May 27 03:21:32.680213 systemd-logind[1896]: Session 9 logged out. Waiting for processes to exit.
May 27 03:21:32.681139 systemd-logind[1896]: Removed session 9.
May 27 03:21:42.794443 systemd[1]: Started sshd@7-10.200.8.34:22-10.200.16.10:34110.service - OpenSSH per-connection server daemon (10.200.16.10:34110).
May 27 03:21:43.454364 sshd[5766]: Accepted publickey for core from 10.200.16.10 port 34110 ssh2: RSA SHA256:4qrJWLsdicuYlAkd8Pkq9rLEez3YC6Ax2cIipYpsYNE
May 27 03:21:43.456205 sshd-session[5766]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0)
May 27 03:21:43.462533 systemd-logind[1896]: New session 10 of user core.
May 27 03:21:43.477242 systemd[1]: Started session-10.scope - Session 10 of User core.
May 27 03:21:43.899747 sshd[5904]: Connection closed by 10.200.16.10 port 34110
May 27 03:21:43.900385 sshd-session[5766]: pam_unix(sshd:session): session closed for user core
May 27 03:21:43.913593 systemd[1]: sshd@7-10.200.8.34:22-10.200.16.10:34110.service: Deactivated successfully.
May 27 03:21:43.915220 systemd[1]: session-10.scope: Deactivated successfully.
May 27 03:21:43.915893 systemd-logind[1896]: Session 10 logged out. Waiting for processes to exit.
May 27 03:21:43.917324 systemd-logind[1896]: Removed session 10.
May 27 03:21:44.012272 systemd[1]: Started sshd@8-10.200.8.34:22-10.200.16.10:34114.service - OpenSSH per-connection server daemon (10.200.16.10:34114).
May 27 03:21:44.639336 sshd[6032]: Accepted publickey for core from 10.200.16.10 port 34114 ssh2: RSA SHA256:4qrJWLsdicuYlAkd8Pkq9rLEez3YC6Ax2cIipYpsYNE
May 27 03:21:44.640690 sshd-session[6032]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0)
May 27 03:21:44.645023 systemd-logind[1896]: New session 11 of user core.
May 27 03:21:44.655989 systemd[1]: Started session-11.scope - Session 11 of User core.
May 27 03:21:45.094037 sshd[6107]: Connection closed by 10.200.16.10 port 34114
May 27 03:21:45.097030 sshd-session[6032]: pam_unix(sshd:session): session closed for user core
May 27 03:21:45.101613 systemd[1]: sshd@8-10.200.8.34:22-10.200.16.10:34114.service: Deactivated successfully.
May 27 03:21:45.103147 systemd[1]: session-11.scope: Deactivated successfully.
May 27 03:21:45.103928 systemd-logind[1896]: Session 11 logged out. Waiting for processes to exit.
May 27 03:21:45.105818 systemd-logind[1896]: Removed session 11.
May 27 03:21:55.212123 systemd[1]: Started sshd@9-10.200.8.34:22-10.200.16.10:54108.service - OpenSSH per-connection server daemon (10.200.16.10:54108).
May 27 03:21:55.852564 sshd[7826]: Accepted publickey for core from 10.200.16.10 port 54108 ssh2: RSA SHA256:4qrJWLsdicuYlAkd8Pkq9rLEez3YC6Ax2cIipYpsYNE
May 27 03:21:55.852475 sshd-session[7826]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0)
May 27 03:21:55.860795 systemd-logind[1896]: New session 12 of user core.
May 27 03:21:55.870052 systemd[1]: Started session-12.scope - Session 12 of User core.
May 27 03:21:56.296725 sshd[7985]: Connection closed by 10.200.16.10 port 54108
May 27 03:21:56.297315 sshd-session[7826]: pam_unix(sshd:session): session closed for user core
May 27 03:21:56.302108 systemd[1]: sshd@9-10.200.8.34:22-10.200.16.10:54108.service: Deactivated successfully.
May 27 03:21:56.304575 systemd[1]: session-12.scope: Deactivated successfully.
May 27 03:21:56.305787 systemd-logind[1896]: Session 12 logged out. Waiting for processes to exit.
May 27 03:21:56.308049 systemd-logind[1896]: Removed session 12.
May 27 03:21:56.413380 systemd[1]: Started sshd@10-10.200.8.34:22-10.200.16.10:54110.service - OpenSSH per-connection server daemon (10.200.16.10:54110).
May 27 03:21:57.055437 sshd[8221]: Accepted publickey for core from 10.200.16.10 port 54110 ssh2: RSA SHA256:4qrJWLsdicuYlAkd8Pkq9rLEez3YC6Ax2cIipYpsYNE
May 27 03:21:57.056702 sshd-session[8221]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0)
May 27 03:21:57.061568 systemd-logind[1896]: New session 13 of user core.
May 27 03:21:57.072000 systemd[1]: Started session-13.scope - Session 13 of User core.
May 27 03:21:57.512880 sshd[8683]: Connection closed by 10.200.16.10 port 54110
May 27 03:21:57.512762 sshd-session[8221]: pam_unix(sshd:session): session closed for user core
May 27 03:21:57.522081 systemd[1]: sshd@10-10.200.8.34:22-10.200.16.10:54110.service: Deactivated successfully.
May 27 03:21:57.525656 systemd[1]: session-13.scope: Deactivated successfully.
May 27 03:21:57.525850 systemd-logind[1896]: Session 13 logged out. Waiting for processes to exit.
May 27 03:21:57.528954 systemd-logind[1896]: Removed session 13.
May 27 03:22:07.636119 systemd[1]: Started sshd@11-10.200.8.34:22-10.200.16.10:46830.service - OpenSSH per-connection server daemon (10.200.16.10:46830).
May 27 03:22:08.283230 sshd[11443]: Accepted publickey for core from 10.200.16.10 port 46830 ssh2: RSA SHA256:4qrJWLsdicuYlAkd8Pkq9rLEez3YC6Ax2cIipYpsYNE
May 27 03:22:08.285173 sshd-session[11443]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0)
May 27 03:22:08.291793 systemd-logind[1896]: New session 14 of user core.
May 27 03:22:08.301382 systemd[1]: Started session-14.scope - Session 14 of User core.
May 27 03:22:08.728832 sshd[11461]: Connection closed by 10.200.16.10 port 46830
May 27 03:22:08.729406 sshd-session[11443]: pam_unix(sshd:session): session closed for user core
May 27 03:22:08.736343 systemd[1]: sshd@11-10.200.8.34:22-10.200.16.10:46830.service: Deactivated successfully.
May 27 03:22:08.736868 systemd-logind[1896]: Session 14 logged out. Waiting for processes to exit.
May 27 03:22:08.741049 systemd[1]: session-14.scope: Deactivated successfully.
May 27 03:22:08.743556 systemd-logind[1896]: Removed session 14.
May 27 03:22:08.841934 systemd[1]: Started sshd@12-10.200.8.34:22-10.200.16.10:40638.service - OpenSSH per-connection server daemon (10.200.16.10:40638).
May 27 03:22:09.490812 sshd[11491]: Accepted publickey for core from 10.200.16.10 port 40638 ssh2: RSA SHA256:4qrJWLsdicuYlAkd8Pkq9rLEez3YC6Ax2cIipYpsYNE
May 27 03:22:09.492651 sshd-session[11491]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0)
May 27 03:22:09.501305 systemd-logind[1896]: New session 15 of user core.
May 27 03:22:09.511008 systemd[1]: Started session-15.scope - Session 15 of User core.
May 27 03:22:09.940416 sshd[11529]: Connection closed by 10.200.16.10 port 40638
May 27 03:22:09.944061 sshd-session[11491]: pam_unix(sshd:session): session closed for user core
May 27 03:22:09.948187 systemd-logind[1896]: Session 15 logged out. Waiting for processes to exit.
May 27 03:22:09.948885 systemd[1]: sshd@12-10.200.8.34:22-10.200.16.10:40638.service: Deactivated successfully.
May 27 03:22:09.951700 systemd[1]: session-15.scope: Deactivated successfully.
May 27 03:22:09.954143 systemd-logind[1896]: Removed session 15.
May 27 03:22:20.060275 systemd[1]: Started sshd@13-10.200.8.34:22-10.200.16.10:41590.service - OpenSSH per-connection server daemon (10.200.16.10:41590).
May 27 03:22:20.729317 sshd[11926]: Accepted publickey for core from 10.200.16.10 port 41590 ssh2: RSA SHA256:4qrJWLsdicuYlAkd8Pkq9rLEez3YC6Ax2cIipYpsYNE
May 27 03:22:20.731963 sshd-session[11926]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0)
May 27 03:22:20.738414 systemd-logind[1896]: New session 16 of user core.
May 27 03:22:20.748951 systemd[1]: Started session-16.scope - Session 16 of User core.
May 27 03:22:21.182038 sshd[11951]: Connection closed by 10.200.16.10 port 41590
May 27 03:22:21.182804 sshd-session[11926]: pam_unix(sshd:session): session closed for user core
May 27 03:22:21.187889 systemd-logind[1896]: Session 16 logged out. Waiting for processes to exit.
May 27 03:22:21.189372 systemd[1]: sshd@13-10.200.8.34:22-10.200.16.10:41590.service: Deactivated successfully.
May 27 03:22:21.191334 systemd[1]: session-16.scope: Deactivated successfully.
May 27 03:22:21.195125 systemd-logind[1896]: Removed session 16.
May 27 03:22:21.294480 systemd[1]: Started sshd@14-10.200.8.34:22-10.200.16.10:41600.service - OpenSSH per-connection server daemon (10.200.16.10:41600).
May 27 03:22:21.959209 sshd[11975]: Accepted publickey for core from 10.200.16.10 port 41600 ssh2: RSA SHA256:4qrJWLsdicuYlAkd8Pkq9rLEez3YC6Ax2cIipYpsYNE
May 27 03:22:21.960072 sshd-session[11975]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0)
May 27 03:22:21.966392 systemd-logind[1896]: New session 17 of user core.
May 27 03:22:21.973941 systemd[1]: Started session-17.scope - Session 17 of User core.
May 27 03:22:22.411388 sshd[11996]: Connection closed by 10.200.16.10 port 41600
May 27 03:22:22.412038 sshd-session[11975]: pam_unix(sshd:session): session closed for user core
May 27 03:22:22.415514 systemd-logind[1896]: Session 17 logged out. Waiting for processes to exit.
May 27 03:22:22.417260 systemd[1]: sshd@14-10.200.8.34:22-10.200.16.10:41600.service: Deactivated successfully.
May 27 03:22:22.420831 systemd[1]: session-17.scope: Deactivated successfully.
May 27 03:22:22.423681 systemd-logind[1896]: Removed session 17.
May 27 03:22:32.534099 systemd[1]: Started sshd@15-10.200.8.34:22-10.200.16.10:50812.service - OpenSSH per-connection server daemon (10.200.16.10:50812).
May 27 03:22:33.190575 sshd[12338]: Accepted publickey for core from 10.200.16.10 port 50812 ssh2: RSA SHA256:4qrJWLsdicuYlAkd8Pkq9rLEez3YC6Ax2cIipYpsYNE
May 27 03:22:33.191827 sshd-session[12338]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0)
May 27 03:22:33.197197 systemd-logind[1896]: New session 18 of user core.
May 27 03:22:33.207001 systemd[1]: Started session-18.scope - Session 18 of User core.
May 27 03:22:33.651678 sshd[12352]: Connection closed by 10.200.16.10 port 50812
May 27 03:22:33.652287 sshd-session[12338]: pam_unix(sshd:session): session closed for user core
May 27 03:22:33.656642 systemd-logind[1896]: Session 18 logged out. Waiting for processes to exit.
May 27 03:22:33.658085 systemd[1]: sshd@15-10.200.8.34:22-10.200.16.10:50812.service: Deactivated successfully.
May 27 03:22:33.659642 systemd[1]: session-18.scope: Deactivated successfully.
May 27 03:22:33.661890 systemd-logind[1896]: Removed session 18.
May 27 03:22:33.767106 systemd[1]: Started sshd@16-10.200.8.34:22-10.200.16.10:50828.service - OpenSSH per-connection server daemon (10.200.16.10:50828).
May 27 03:22:34.421944 sshd[12376]: Accepted publickey for core from 10.200.16.10 port 50828 ssh2: RSA SHA256:4qrJWLsdicuYlAkd8Pkq9rLEez3YC6Ax2cIipYpsYNE
May 27 03:22:34.422794 sshd-session[12376]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0)
May 27 03:22:34.431682 systemd-logind[1896]: New session 19 of user core.
May 27 03:22:34.438980 systemd[1]: Started session-19.scope - Session 19 of User core.
May 27 03:22:34.885333 sshd[12407]: Connection closed by 10.200.16.10 port 50828
May 27 03:22:34.888043 sshd-session[12376]: pam_unix(sshd:session): session closed for user core
May 27 03:22:34.891227 systemd[1]: sshd@16-10.200.8.34:22-10.200.16.10:50828.service: Deactivated successfully.
May 27 03:22:34.893426 systemd[1]: session-19.scope: Deactivated successfully.
May 27 03:22:34.894761 systemd-logind[1896]: Session 19 logged out. Waiting for processes to exit.
May 27 03:22:34.899314 systemd-logind[1896]: Removed session 19.
May 27 03:22:45.004109 systemd[1]: Started sshd@17-10.200.8.34:22-10.200.16.10:55660.service - OpenSSH per-connection server daemon (10.200.16.10:55660).
May 27 03:22:45.643655 sshd[12592]: Accepted publickey for core from 10.200.16.10 port 55660 ssh2: RSA SHA256:4qrJWLsdicuYlAkd8Pkq9rLEez3YC6Ax2cIipYpsYNE
May 27 03:22:45.645011 sshd-session[12592]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0)
May 27 03:22:45.650945 systemd-logind[1896]: New session 20 of user core.
May 27 03:22:45.667157 systemd[1]: Started session-20.scope - Session 20 of User core.
May 27 03:22:46.092956 sshd[12644]: Connection closed by 10.200.16.10 port 55660
May 27 03:22:46.093328 sshd-session[12592]: pam_unix(sshd:session): session closed for user core
May 27 03:22:46.096668 systemd[1]: sshd@17-10.200.8.34:22-10.200.16.10:55660.service: Deactivated successfully.
May 27 03:22:46.098290 systemd[1]: session-20.scope: Deactivated successfully.
May 27 03:22:46.099068 systemd-logind[1896]: Session 20 logged out. Waiting for processes to exit.
May 27 03:22:46.100069 systemd-logind[1896]: Removed session 20.
May 27 03:22:46.209530 systemd[1]: Started sshd@18-10.200.8.34:22-10.200.16.10:55672.service - OpenSSH per-connection server daemon (10.200.16.10:55672).
May 27 03:22:46.863578 setup-nvidia[2273]: \u000d
May 27 03:22:46.863578 setup-nvidia[2273]: ERROR: Unable to load the kernel module 'nvidia.ko'.  This happens most
May 27 03:22:46.863578 setup-nvidia[2273]:        frequently when this kernel module was built against the wrong or
May 27 03:22:46.863578 setup-nvidia[2273]:        improperly configured kernel sources, with a version of gcc that differs
May 27 03:22:46.863578 setup-nvidia[2273]:        from the one used to build the target kernel, or if another driver, such
May 27 03:22:46.863578 setup-nvidia[2273]:        as nouveau, is present and prevents the NVIDIA kernel module from
May 27 03:22:46.863578 setup-nvidia[2273]:        obtaining ownership of the NVIDIA device(s), or no NVIDIA device
May 27 03:22:46.863578 setup-nvidia[2273]:        installed in this system is supported by this NVIDIA Linux graphics
May 27 03:22:46.863578 setup-nvidia[2273]:        driver release.
May 27 03:22:46.863578 setup-nvidia[2273]:        \u000d
May 27 03:22:46.863578 setup-nvidia[2273]:        Please see the log entries 'Kernel module load error' and 'Kernel
May 27 03:22:46.863578 setup-nvidia[2273]:        messages' at the end of the file
May 27 03:22:46.863578 setup-nvidia[2273]:        '/nvidia/NVIDIA-Linux-x86_64-535.230.02/nvidia-installer.log' for more
May 27 03:22:46.863578 setup-nvidia[2273]:        information.
May 27 03:22:46.863578 setup-nvidia[2273]: \u000d
May 27 03:22:46.869953 sshd[12673]: Accepted publickey for core from 10.200.16.10 port 55672 ssh2: RSA SHA256:4qrJWLsdicuYlAkd8Pkq9rLEez3YC6Ax2cIipYpsYNE
May 27 03:22:46.871243 sshd-session[12673]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0)
May 27 03:22:46.875619 systemd-logind[1896]: New session 21 of user core.
May 27 03:22:46.878449 setup-nvidia[2273]: dmesg: read kernel buffer failed: Operation not permitted
May 27 03:22:46.885994 systemd[1]: Started session-21.scope - Session 21 of User core.
May 27 03:22:46.900846 setup-nvidia[2273]: \u000d
May 27 03:22:46.900846 setup-nvidia[2273]: ERROR: Installation has failed.  Please see the file
May 27 03:22:46.900846 setup-nvidia[2273]:        '/nvidia/NVIDIA-Linux-x86_64-535.230.02/nvidia-installer.log' for
May 27 03:22:46.900846 setup-nvidia[2273]:        details.  You may find suggestions on fixing installation problems in
May 27 03:22:46.900846 setup-nvidia[2273]:        the README available on the Linux driver download page at
May 27 03:22:46.900846 setup-nvidia[2273]:        www.nvidia.com.
May 27 03:22:46.900846 setup-nvidia[2273]: \u000d
May 27 03:22:46.901408 setup-nvidia[2273]: Last 50 lines of nvidia-installer.log:
May 27 03:22:46.902211 setup-nvidia[2273]:    /nvidia/NVIDIA-Linux-x86_64-535.230.02/kernel/nvidia.o: warning: objtool: _nv039000rm+0x53: 'naked' return found in MITIGATION_RETHUNK build
May 27 03:22:46.902211 setup-nvidia[2273]:    /nvidia/NVIDIA-Linux-x86_64-535.230.02/kernel/nvidia.o: warning: objtool: _nv038997rm+0x90: 'naked' return found in MITIGATION_RETHUNK build
May 27 03:22:46.902211 setup-nvidia[2273]:    /nvidia/NVIDIA-Linux-x86_64-535.230.02/kernel/nvidia.o: warning: objtool: _nv038990rm+0x2b: 'naked' return found in MITIGATION_RETHUNK build
May 27 03:22:46.902211 setup-nvidia[2273]:    /nvidia/NVIDIA-Linux-x86_64-535.230.02/kernel/nvidia.o: warning: objtool: _nv039046rm+0x93: 'naked' return found in MITIGATION_RETHUNK build
May 27 03:22:46.902211 setup-nvidia[2273]:    /nvidia/NVIDIA-Linux-x86_64-535.230.02/kernel/nvidia.o: warning: objtool: _nv039042rm+0x36: 'naked' return found in MITIGATION_RETHUNK build
May 27 03:22:46.902211 setup-nvidia[2273]:    /nvidia/NVIDIA-Linux-x86_64-535.230.02/kernel/nvidia.o: warning: objtool: _nv039041rm+0x9d: 'naked' return found in MITIGATION_RETHUNK build
May 27 03:22:46.902211 setup-nvidia[2273]:    /nvidia/NVIDIA-Linux-x86_64-535.230.02/kernel/nvidia.o: warning: objtool: _nv039043rm+0x77: 'naked' return found in MITIGATION_RETHUNK build
May 27 03:22:46.902211 setup-nvidia[2273]:    /nvidia/NVIDIA-Linux-x86_64-535.230.02/kernel/nvidia.o: warning: objtool: _nv038987rm+0x7f: 'naked' return found in MITIGATION_RETHUNK build
May 27 03:22:46.902211 setup-nvidia[2273]:    /nvidia/NVIDIA-Linux-x86_64-535.230.02/kernel/nvidia.o: warning: objtool: _nv030558rm+0x3e: 'naked' return found in MITIGATION_RETHUNK build
May 27 03:22:46.902211 setup-nvidia[2273]:    /nvidia/NVIDIA-Linux-x86_64-535.230.02/kernel/nvidia.o: warning: objtool: _nv030557rm+0x27: 'naked' return found in MITIGATION_RETHUNK build
May 27 03:22:46.902211 setup-nvidia[2273]:    /nvidia/NVIDIA-Linux-x86_64-535.230.02/kernel/nvidia.o: warning: objtool: _nv030561rm+0x37: 'naked' return found in MITIGATION_RETHUNK build
May 27 03:22:46.902211 setup-nvidia[2273]:    /nvidia/NVIDIA-Linux-x86_64-535.230.02/kernel/nvidia.o: warning: objtool: _nv030560rm+0x24: 'naked' return found in MITIGATION_RETHUNK build
May 27 03:22:46.902211 setup-nvidia[2273]:    /nvidia/NVIDIA-Linux-x86_64-535.230.02/kernel/nvidia.o: warning: objtool: _nv030559rm+0xca: 'naked' return found in MITIGATION_RETHUNK build
May 27 03:22:46.902211 setup-nvidia[2273]:    /nvidia/NVIDIA-Linux-x86_64-535.230.02/kernel/nvidia.o: warning: objtool: _nv030562rm+0x193: 'naked' return found in MITIGATION_RETHUNK build
May 27 03:22:46.902211 setup-nvidia[2273]:    /nvidia/NVIDIA-Linux-x86_64-535.230.02/kernel/nvidia.o: warning: objtool: _nv030564rm+0x17f: 'naked' return found in MITIGATION_RETHUNK build
May 27 03:22:46.902211 setup-nvidia[2273]:    /nvidia/NVIDIA-Linux-x86_64-535.230.02/kernel/nvidia.o: warning: objtool: _nv011860rm+0x5d: 'naked' return found in MITIGATION_RETHUNK build
May 27 03:22:46.902211 setup-nvidia[2273]:    /nvidia/NVIDIA-Linux-x86_64-535.230.02/kernel/nvidia.o: warning: objtool: _nv039354rm+0x12f: 'naked' return found in MITIGATION_RETHUNK build
May 27 03:22:46.902211 setup-nvidia[2273]:      MODPOST /nvidia/NVIDIA-Linux-x86_64-535.230.02/kernel/Module.symvers
May 27 03:22:46.902211 setup-nvidia[2273]:      CC [M]  /nvidia/NVIDIA-Linux-x86_64-535.230.02/kernel/nvidia.mod.o
May 27 03:22:46.902211 setup-nvidia[2273]:      CC [M]  /nvidia/NVIDIA-Linux-x86_64-535.230.02/kernel/.module-common.o
May 27 03:22:46.902211 setup-nvidia[2273]:      CC [M]  /nvidia/NVIDIA-Linux-x86_64-535.230.02/kernel/nvidia-uvm.mod.o
May 27 03:22:46.902211 setup-nvidia[2273]:      CC [M]  /nvidia/NVIDIA-Linux-x86_64-535.230.02/kernel/nvidia-modeset.mod.o
May 27 03:22:46.902211 setup-nvidia[2273]:      CC [M]  /nvidia/NVIDIA-Linux-x86_64-535.230.02/kernel/nvidia-drm.mod.o
May 27 03:22:46.902211 setup-nvidia[2273]:      CC [M]  /nvidia/NVIDIA-Linux-x86_64-535.230.02/kernel/nvidia-peermem.mod.o
May 27 03:22:46.902211 setup-nvidia[2273]:      LD [M]  /nvidia/NVIDIA-Linux-x86_64-535.230.02/kernel/nvidia.ko
May 27 03:22:46.902211 setup-nvidia[2273]:      LD [M]  /nvidia/NVIDIA-Linux-x86_64-535.230.02/kernel/nvidia-uvm.ko
May 27 03:22:46.902211 setup-nvidia[2273]:      LD [M]  /nvidia/NVIDIA-Linux-x86_64-535.230.02/kernel/nvidia-modeset.ko
May 27 03:22:46.902211 setup-nvidia[2273]:      LD [M]  /nvidia/NVIDIA-Linux-x86_64-535.230.02/kernel/nvidia-drm.ko
May 27 03:22:46.902211 setup-nvidia[2273]:      LD [M]  /nvidia/NVIDIA-Linux-x86_64-535.230.02/kernel/nvidia-peermem.ko
May 27 03:22:46.902211 setup-nvidia[2273]:      BTF [M] /nvidia/NVIDIA-Linux-x86_64-535.230.02/kernel/nvidia-peermem.ko
May 27 03:22:46.902211 setup-nvidia[2273]:    Skipping BTF generation for /nvidia/NVIDIA-Linux-x86_64-535.230.02/kernel/nvidia-peermem.ko due to unavailability of vmlinux
May 27 03:22:46.902211 setup-nvidia[2273]:      BTF [M] /nvidia/NVIDIA-Linux-x86_64-535.230.02/kernel/nvidia-modeset.ko
May 27 03:22:46.902211 setup-nvidia[2273]:    Skipping BTF generation for /nvidia/NVIDIA-Linux-x86_64-535.230.02/kernel/nvidia-modeset.ko due to unavailability of vmlinux
May 27 03:22:46.902211 setup-nvidia[2273]:      BTF [M] /nvidia/NVIDIA-Linux-x86_64-535.230.02/kernel/nvidia-drm.ko
May 27 03:22:46.902211 setup-nvidia[2273]:    Skipping BTF generation for /nvidia/NVIDIA-Linux-x86_64-535.230.02/kernel/nvidia-drm.ko due to unavailability of vmlinux
May 27 03:22:46.902211 setup-nvidia[2273]:      BTF [M] /nvidia/NVIDIA-Linux-x86_64-535.230.02/kernel/nvidia-uvm.ko
May 27 03:22:46.902211 setup-nvidia[2273]:    Skipping BTF generation for /nvidia/NVIDIA-Linux-x86_64-535.230.02/kernel/nvidia-uvm.ko due to unavailability of vmlinux
May 27 03:22:46.902211 setup-nvidia[2273]:      BTF [M] /nvidia/NVIDIA-Linux-x86_64-535.230.02/kernel/nvidia.ko
May 27 03:22:46.903191 setup-nvidia[2273]:    Skipping BTF generation for /nvidia/NVIDIA-Linux-x86_64-535.230.02/kernel/nvidia.ko due to unavailability of vmlinux
May 27 03:22:46.903191 setup-nvidia[2273]:    make[2]: Leaving directory '/usr/lib/modules/6.12.30-flatcar/build'
May 27 03:22:46.903191 setup-nvidia[2273]:    make[1]: Leaving directory '/usr/lib/modules/6.12.30-flatcar/source'
May 27 03:22:46.903191 setup-nvidia[2273]: -> done.
May 27 03:22:46.903191 setup-nvidia[2273]: -> Kernel module compilation complete.
May 27 03:22:46.903191 setup-nvidia[2273]: -> Unable to determine if Secure Boot is enabled: No such file or directory
May 27 03:22:46.903191 setup-nvidia[2273]: ERROR: Unable to load the kernel module 'nvidia.ko'.  This happens most frequently when this kernel module was built against the wrong or improperly configured kernel sources, with a version of gcc that differs from the one used to build the target kernel, or if another driver, such as nouveau, is present and prevents the NVIDIA kernel module from obtaining ownership of the NVIDIA device(s), or no NVIDIA device installed in this system is supported by this NVIDIA Linux graphics driver release.
May 27 03:22:46.903191 setup-nvidia[2273]: \u000d
May 27 03:22:46.903191 setup-nvidia[2273]: Please see the log entries 'Kernel module load error' and 'Kernel messages' at the end of the file '/nvidia/NVIDIA-Linux-x86_64-535.230.02/nvidia-installer.log' for more information.
May 27 03:22:46.903191 setup-nvidia[2273]: -> Kernel module load error: Operation not permitted
May 27 03:22:46.903191 setup-nvidia[2273]: -> Kernel messages:
May 27 03:22:46.903191 setup-nvidia[2273]: ERROR: Installation has failed.  Please see the file '/nvidia/NVIDIA-Linux-x86_64-535.230.02/nvidia-installer.log' for details.  You may find suggestions on fixing installation problems in the README available on the Linux driver download page at www.nvidia.com.
May 27 03:22:47.320423 sshd[12737]: Connection closed by 10.200.16.10 port 55672
May 27 03:22:47.320766 sshd-session[12673]: pam_unix(sshd:session): session closed for user core
May 27 03:22:47.324092 systemd[1]: sshd@18-10.200.8.34:22-10.200.16.10:55672.service: Deactivated successfully.
May 27 03:22:47.325595 systemd[1]: session-21.scope: Deactivated successfully.
May 27 03:22:47.326267 systemd-logind[1896]: Session 21 logged out. Waiting for processes to exit.
May 27 03:22:47.327377 systemd-logind[1896]: Removed session 21.
May 27 03:22:57.439148 systemd[1]: Started sshd@19-10.200.8.34:22-10.200.16.10:34826.service - OpenSSH per-connection server daemon (10.200.16.10:34826).
May 27 03:22:58.077215 sshd[12756]: Accepted publickey for core from 10.200.16.10 port 34826 ssh2: RSA SHA256:4qrJWLsdicuYlAkd8Pkq9rLEez3YC6Ax2cIipYpsYNE
May 27 03:22:58.078509 sshd-session[12756]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0)
May 27 03:22:58.082627 systemd-logind[1896]: New session 22 of user core.
May 27 03:22:58.092970 systemd[1]: Started session-22.scope - Session 22 of User core.
May 27 03:22:58.527940 sshd[12758]: Connection closed by 10.200.16.10 port 34826
May 27 03:22:58.528283 sshd-session[12756]: pam_unix(sshd:session): session closed for user core
May 27 03:22:58.531465 systemd[1]: sshd@19-10.200.8.34:22-10.200.16.10:34826.service: Deactivated successfully.
May 27 03:22:58.532970 systemd[1]: session-22.scope: Deactivated successfully.
May 27 03:22:58.533621 systemd-logind[1896]: Session 22 logged out. Waiting for processes to exit.
May 27 03:22:58.534529 systemd-logind[1896]: Removed session 22.
May 27 03:22:58.649927 systemd[1]: Started sshd@20-10.200.8.34:22-10.200.16.10:37890.service - OpenSSH per-connection server daemon (10.200.16.10:37890).
May 27 03:22:59.285065 sshd[12764]: Accepted publickey for core from 10.200.16.10 port 37890 ssh2: RSA SHA256:4qrJWLsdicuYlAkd8Pkq9rLEez3YC6Ax2cIipYpsYNE
May 27 03:22:59.286365 sshd-session[12764]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0)
May 27 03:22:59.290711 systemd-logind[1896]: New session 23 of user core.
May 27 03:22:59.299985 systemd[1]: Started session-23.scope - Session 23 of User core.
May 27 03:22:59.735282 sshd[12766]: Connection closed by 10.200.16.10 port 37890
May 27 03:22:59.735663 sshd-session[12764]: pam_unix(sshd:session): session closed for user core
May 27 03:22:59.738847 systemd[1]: sshd@20-10.200.8.34:22-10.200.16.10:37890.service: Deactivated successfully.
May 27 03:22:59.740327 systemd[1]: session-23.scope: Deactivated successfully.
May 27 03:22:59.741061 systemd-logind[1896]: Session 23 logged out. Waiting for processes to exit.
May 27 03:22:59.742036 systemd-logind[1896]: Removed session 23.
May 27 03:23:09.861832 systemd[1]: Started sshd@21-10.200.8.34:22-10.200.16.10:35990.service - OpenSSH per-connection server daemon (10.200.16.10:35990).
May 27 03:23:10.514398 sshd[12773]: Accepted publickey for core from 10.200.16.10 port 35990 ssh2: RSA SHA256:4qrJWLsdicuYlAkd8Pkq9rLEez3YC6Ax2cIipYpsYNE
May 27 03:23:10.515773 sshd-session[12773]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0)
May 27 03:23:10.519945 systemd-logind[1896]: New session 24 of user core.
May 27 03:23:10.530976 systemd[1]: Started session-24.scope - Session 24 of User core.
May 27 03:23:10.922880 kernel: EXT4-fs (loop6p9): unmounting filesystem 7688ef19-dafb-42a7-9a4a-77f2194be168.
May 27 03:23:10.923259 setup-nvidia[2273]: Container flatcardevelopercontainer-4344.0.0.bin exited successfully.
May 27 03:23:10.925436 systemd[1]: run-systemd-nspawn-unix\x2dexport-flatcardevelopercontainer\x2d4344.0.0.bin.mount: Deactivated successfully.
May 27 03:23:10.968787 sshd[12775]: Connection closed by 10.200.16.10 port 35990
May 27 03:23:10.969158 sshd-session[12773]: pam_unix(sshd:session): session closed for user core
May 27 03:23:10.972400 systemd[1]: sshd@21-10.200.8.34:22-10.200.16.10:35990.service: Deactivated successfully.
May 27 03:23:10.973624 sudo[2261]: pam_unix(sudo:session): session closed for user root
May 27 03:23:10.974196 systemd[1]: session-24.scope: Deactivated successfully.
May 27 03:23:10.975054 systemd-logind[1896]: Session 24 logged out. Waiting for processes to exit.
May 27 03:23:10.976268 systemd-logind[1896]: Removed session 24.
May 27 03:23:10.976669 systemd[1]: session-c2.scope: Deactivated successfully.
May 27 03:23:10.976942 systemd[1]: session-c2.scope: Consumed 5min 7.408s CPU time, 892.6M memory peak.
May 27 03:23:11.098689 systemd[1]: Started sshd@22-10.200.8.34:22-10.200.16.10:36002.service - OpenSSH per-connection server daemon (10.200.16.10:36002).
May 27 03:23:11.400459 setup-nvidia[1890]: /opt/nvidia /
May 27 03:23:11.401431 setup-nvidia[1890]: /
May 27 03:23:11.410879 kernel: IPMI message handler: version 39.2
May 27 03:23:11.413873 kernel: ipmi device interface
May 27 03:23:11.426452 setup-nvidia[1890]: /opt/nvidia/current/usr/lib/modules/6.12.30-flatcar/video /
May 27 03:23:11.479670 kernel: nvidia: loading out-of-tree module taints kernel.
May 27 03:23:11.479795 kernel: nvidia: module license 'NVIDIA' taints kernel.
May 27 03:23:11.479818 kernel: Disabling lock debugging due to kernel taint
May 27 03:23:11.487132 kernel: nvidia: module verification failed: signature and/or required key missing - tainting kernel
May 27 03:23:11.487172 kernel: nvidia: module license taints kernel.
May 27 03:23:11.737172 sshd[12786]: Accepted publickey for core from 10.200.16.10 port 36002 ssh2: RSA SHA256:4qrJWLsdicuYlAkd8Pkq9rLEez3YC6Ax2cIipYpsYNE
May 27 03:23:11.738599 sshd-session[12786]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0)
May 27 03:23:11.742919 systemd-logind[1896]: New session 25 of user core.
May 27 03:23:11.758976 systemd[1]: Started session-25.scope - Session 25 of User core.
May 27 03:23:11.895893 kernel: nvidia-nvlink: Nvlink Core is being initialized, major device number 243
May 27 03:23:12.192233 sshd[12808]: Connection closed by 10.200.16.10 port 36002
May 27 03:23:12.192509 sshd-session[12786]: pam_unix(sshd:session): session closed for user core
May 27 03:23:12.195935 systemd[1]: sshd@22-10.200.8.34:22-10.200.16.10:36002.service: Deactivated successfully.
May 27 03:23:12.197442 systemd[1]: session-25.scope: Deactivated successfully.
May 27 03:23:12.198234 systemd-logind[1896]: Session 25 logged out. Waiting for processes to exit.
May 27 03:23:12.199187 systemd-logind[1896]: Removed session 25.
May 27 03:23:12.295929 kernel: 
May 27 03:23:12.296055 kernel: nvidia 0001:00:00.0: enabling device (0000 -> 0002)
May 27 03:23:12.508873 kernel: NVRM: loading NVIDIA UNIX x86_64 Kernel Module  535.230.02  Fri Dec 20 21:42:05 UTC 2024
May 27 03:23:12.529879 kernel: nvidia-modeset: Loading NVIDIA Kernel Mode Setting Driver for UNIX platforms  535.230.02  Fri Dec 20 21:52:34 UTC 2024
May 27 03:23:12.549895 kernel: nvidia_uvm: module uses symbols nvUvmInterfaceDisableAccessCntr from proprietary module nvidia, inheriting taint.
May 27 03:23:12.593665 setup-nvidia[1890]: /
May 27 03:23:12.594147 kernel: nvidia-uvm: Loaded the UVM driver, major device number 241.
May 27 03:23:12.608184 setup-nvidia[12822]: ldconfig: /usr/lib/ld.so.conf is not an ELF file - it has the wrong magic bytes at the start.
May 27 03:23:14.354685 setup-nvidia[12839]: Tue May 27 03:23:14 2025
May 27 03:23:14.354685 setup-nvidia[12839]: +---------------------------------------------------------------------------------------+
May 27 03:23:14.354685 setup-nvidia[12839]: | NVIDIA-SMI 535.230.02             Driver Version: 535.230.02   CUDA Version: 12.2     |
May 27 03:23:14.354685 setup-nvidia[12839]: |-----------------------------------------+----------------------+----------------------+
May 27 03:23:14.354685 setup-nvidia[12839]: | GPU  Name                 Persistence-M | Bus-Id        Disp.A | Volatile Uncorr. ECC |
May 27 03:23:14.354685 setup-nvidia[12839]: | Fan  Temp   Perf          Pwr:Usage/Cap |         Memory-Usage | GPU-Util  Compute M. |
May 27 03:23:14.354685 setup-nvidia[12839]: |                                         |                      |               MIG M. |
May 27 03:23:14.354685 setup-nvidia[12839]: |=========================================+======================+======================|
May 27 03:23:14.358188 setup-nvidia[12839]: |   0  Tesla V100-PCIE-16GB           Off | 00000001:00:00.0 Off |                  Off |
May 27 03:23:14.358188 setup-nvidia[12839]: | N/A   24C    P0              35W / 250W |      0MiB / 16384MiB |      0%      Default |
May 27 03:23:14.358188 setup-nvidia[12839]: |                                         |                      |                  N/A |
May 27 03:23:14.358188 setup-nvidia[12839]: +-----------------------------------------+----------------------+----------------------+
May 27 03:23:14.358188 setup-nvidia[12839]:                                                                                          
May 27 03:23:14.358188 setup-nvidia[12839]: +---------------------------------------------------------------------------------------+
May 27 03:23:14.358188 setup-nvidia[12839]: | Processes:                                                                            |
May 27 03:23:14.358188 setup-nvidia[12839]: |  GPU   GI   CI        PID   Type   Process name                            GPU Memory |
May 27 03:23:14.358188 setup-nvidia[12839]: |        ID   ID                                                             Usage      |
May 27 03:23:14.358188 setup-nvidia[12839]: |=======================================================================================|
May 27 03:23:14.358430 setup-nvidia[12839]: |  No running processes found                                                           |
May 27 03:23:14.358430 setup-nvidia[12839]: +---------------------------------------------------------------------------------------+
May 27 03:23:14.729979 systemd[1]: Finished nvidia.service - NVIDIA Configure Service.
May 27 03:23:14.731918 systemd[1]: Reached target multi-user.target - Multi-User System.
May 27 03:23:14.732203 systemd[1]: Startup finished in 1.678s (firmware) + 40.882s (loader) + 3.860s (kernel) + 15.553s (initrd) + 3min 40.940s (userspace) = 4min 42.916s.
May 27 03:23:21.222537 systemd[1]: Stopping user@0.service - User Manager for UID 0...
May 27 03:23:21.223338 systemd[2264]: Activating special unit exit.target...
May 27 03:23:21.223419 systemd[2264]: Stopped target default.target - Main User Target.
May 27 03:23:21.223458 systemd[2264]: Stopped target basic.target - Basic System.
May 27 03:23:21.223485 systemd[2264]: Stopped target paths.target - Paths.
May 27 03:23:21.223510 systemd[2264]: Stopped target sockets.target - Sockets.
May 27 03:23:21.223534 systemd[2264]: Stopped target timers.target - Timers.
May 27 03:23:21.223887 systemd[2264]: Closed dbus.socket - D-Bus User Message Bus Socket.
May 27 03:23:21.224096 systemd[2264]: Removed slice app.slice - User Application Slice.
May 27 03:23:21.224128 systemd[2264]: Reached target shutdown.target - Shutdown.
May 27 03:23:21.224268 systemd[2264]: Finished systemd-exit.service - Exit the Session.
May 27 03:23:21.224303 systemd[2264]: Reached target exit.target - Exit the Session.
May 27 03:23:21.247793 (sd-pam)[2265]: pam_unix(systemd-user:session): session closed for user root
May 27 03:23:21.249172 systemd[1]: user@0.service: Deactivated successfully.
May 27 03:23:21.249532 systemd[1]: Stopped user@0.service - User Manager for UID 0.
May 27 03:23:21.251712 systemd[1]: Stopping user-runtime-dir@0.service - User Runtime Directory /run/user/0...
May 27 03:23:21.276775 systemd[1]: run-user-0.mount: Deactivated successfully.
May 27 03:23:21.277715 systemd[1]: user-runtime-dir@0.service: Deactivated successfully.
May 27 03:23:21.277934 systemd[1]: Stopped user-runtime-dir@0.service - User Runtime Directory /run/user/0.
May 27 03:23:21.279543 systemd[1]: Removed slice user-0.slice - User Slice of UID 0.
May 27 03:23:21.279630 systemd[1]: user-0.slice: Consumed 5min 7.686s CPU time, 901.6M memory peak.
May 27 03:23:21.280058 systemd-logind[1896]: Removed session c3.
May 27 03:23:22.317156 systemd[1]: Started sshd@23-10.200.8.34:22-10.200.16.10:41326.service - OpenSSH per-connection server daemon (10.200.16.10:41326).
May 27 03:23:22.955158 sshd[12850]: Accepted publickey for core from 10.200.16.10 port 41326 ssh2: RSA SHA256:4qrJWLsdicuYlAkd8Pkq9rLEez3YC6Ax2cIipYpsYNE
May 27 03:23:22.956491 sshd-session[12850]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0)
May 27 03:23:22.960688 systemd-logind[1896]: New session 26 of user core.
May 27 03:23:22.974974 systemd[1]: Started session-26.scope - Session 26 of User core.
May 27 03:23:23.405356 sshd[12852]: Connection closed by 10.200.16.10 port 41326
May 27 03:23:23.405707 sshd-session[12850]: pam_unix(sshd:session): session closed for user core
May 27 03:23:23.409113 systemd[1]: sshd@23-10.200.8.34:22-10.200.16.10:41326.service: Deactivated successfully.
May 27 03:23:23.410696 systemd[1]: session-26.scope: Deactivated successfully.
May 27 03:23:23.411382 systemd-logind[1896]: Session 26 logged out. Waiting for processes to exit.
May 27 03:23:23.412388 systemd-logind[1896]: Removed session 26.
May 27 03:23:23.520874 systemd[1]: Started sshd@24-10.200.8.34:22-10.200.16.10:41340.service - OpenSSH per-connection server daemon (10.200.16.10:41340).
May 27 03:23:24.177531 sshd[12858]: Accepted publickey for core from 10.200.16.10 port 41340 ssh2: RSA SHA256:4qrJWLsdicuYlAkd8Pkq9rLEez3YC6Ax2cIipYpsYNE
May 27 03:23:24.178806 sshd-session[12858]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0)
May 27 03:23:24.182972 systemd-logind[1896]: New session 27 of user core.
May 27 03:23:24.192971 systemd[1]: Started session-27.scope - Session 27 of User core.
May 27 03:23:24.625361 sshd[12860]: Connection closed by 10.200.16.10 port 41340
May 27 03:23:24.625671 sshd-session[12858]: pam_unix(sshd:session): session closed for user core
May 27 03:23:24.629246 systemd[1]: sshd@24-10.200.8.34:22-10.200.16.10:41340.service: Deactivated successfully.
May 27 03:23:24.630811 systemd[1]: session-27.scope: Deactivated successfully.
May 27 03:23:24.631571 systemd-logind[1896]: Session 27 logged out. Waiting for processes to exit.
May 27 03:23:24.632742 systemd-logind[1896]: Removed session 27.
May 27 03:23:24.741948 systemd[1]: Started sshd@25-10.200.8.34:22-10.200.16.10:41344.service - OpenSSH per-connection server daemon (10.200.16.10:41344).
May 27 03:23:25.421219 sshd[12866]: Accepted publickey for core from 10.200.16.10 port 41344 ssh2: RSA SHA256:4qrJWLsdicuYlAkd8Pkq9rLEez3YC6Ax2cIipYpsYNE
May 27 03:23:25.424059 sshd-session[12866]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0)
May 27 03:23:25.428436 systemd-logind[1896]: New session 28 of user core.
May 27 03:23:25.437988 systemd[1]: Started session-28.scope - Session 28 of User core.
May 27 03:23:25.875007 sshd[12868]: Connection closed by 10.200.16.10 port 41344
May 27 03:23:25.875351 sshd-session[12866]: pam_unix(sshd:session): session closed for user core
May 27 03:23:25.878605 systemd[1]: sshd@25-10.200.8.34:22-10.200.16.10:41344.service: Deactivated successfully.
May 27 03:23:25.880177 systemd[1]: session-28.scope: Deactivated successfully.
May 27 03:23:25.880822 systemd-logind[1896]: Session 28 logged out. Waiting for processes to exit.
May 27 03:23:25.881789 systemd-logind[1896]: Removed session 28.
May 27 03:23:25.987885 systemd[1]: Started sshd@26-10.200.8.34:22-10.200.16.10:41346.service - OpenSSH per-connection server daemon (10.200.16.10:41346).
May 27 03:23:26.647639 sshd[12876]: Accepted publickey for core from 10.200.16.10 port 41346 ssh2: RSA SHA256:4qrJWLsdicuYlAkd8Pkq9rLEez3YC6Ax2cIipYpsYNE
May 27 03:23:26.648968 sshd-session[12876]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0)
May 27 03:23:26.653528 systemd-logind[1896]: New session 29 of user core.
May 27 03:23:26.663976 systemd[1]: Started session-29.scope - Session 29 of User core.
May 27 03:23:27.105341 sshd[12879]: Connection closed by 10.200.16.10 port 41346
May 27 03:23:27.105697 sshd-session[12876]: pam_unix(sshd:session): session closed for user core
May 27 03:23:27.109018 systemd[1]: sshd@26-10.200.8.34:22-10.200.16.10:41346.service: Deactivated successfully.
May 27 03:23:27.110567 systemd[1]: session-29.scope: Deactivated successfully.
May 27 03:23:27.111345 systemd-logind[1896]: Session 29 logged out. Waiting for processes to exit.
May 27 03:23:27.112267 systemd-logind[1896]: Removed session 29.
May 27 03:23:27.222112 systemd[1]: Started sshd@27-10.200.8.34:22-10.200.16.10:41354.service - OpenSSH per-connection server daemon (10.200.16.10:41354).
May 27 03:23:27.874555 sshd[12885]: Accepted publickey for core from 10.200.16.10 port 41354 ssh2: RSA SHA256:4qrJWLsdicuYlAkd8Pkq9rLEez3YC6Ax2cIipYpsYNE
May 27 03:23:27.875828 sshd-session[12885]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0)
May 27 03:23:27.880403 systemd-logind[1896]: New session 30 of user core.
May 27 03:23:27.895976 systemd[1]: Started session-30.scope - Session 30 of User core.
May 27 03:23:29.790315 sshd[12887]: Connection closed by 10.200.16.10 port 41354
May 27 03:23:29.790686 sshd-session[12885]: pam_unix(sshd:session): session closed for user core
May 27 03:23:29.794144 systemd[1]: sshd@27-10.200.8.34:22-10.200.16.10:41354.service: Deactivated successfully.
May 27 03:23:29.795685 systemd[1]: session-30.scope: Deactivated successfully.
May 27 03:23:29.795895 systemd[1]: session-30.scope: Consumed 1.402s CPU time, 14.1M memory peak.
May 27 03:23:29.796342 systemd-logind[1896]: Session 30 logged out. Waiting for processes to exit.
May 27 03:23:29.797274 systemd-logind[1896]: Removed session 30.