May 27 17:44:13.225703 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 15:32:02 -00 2025
May 27 17:44:13.225731 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=daa3e2d55cc4a7ff0ec15aa9bb0c07df9999cb4e3041f3adad1b1101efdea101
May 27 17:44:13.225741 kernel: BIOS-provided physical RAM map:
May 27 17:44:13.225748 kernel: BIOS-e820: [mem 0x0000000000000000-0x000000000009ffff] usable
May 27 17:44:13.225755 kernel: BIOS-e820: [mem 0x00000000000c0000-0x00000000000fffff] reserved
May 27 17:44:13.225762 kernel: BIOS-e820: [mem 0x0000000000100000-0x000000003ff40fff] usable
May 27 17:44:13.225770 kernel: BIOS-e820: [mem 0x000000003ff41000-0x000000003ffc8fff] reserved
May 27 17:44:13.225780 kernel: BIOS-e820: [mem 0x000000003ffc9000-0x000000003fffafff] ACPI data
May 27 17:44:13.225787 kernel: BIOS-e820: [mem 0x000000003fffb000-0x000000003fffefff] ACPI NVS
May 27 17:44:13.225794 kernel: BIOS-e820: [mem 0x000000003ffff000-0x000000003fffffff] usable
May 27 17:44:13.225801 kernel: BIOS-e820: [mem 0x0000000100000000-0x0000000fdfffffff] usable
May 27 17:44:13.225808 kernel: BIOS-e820: [mem 0x0000004fe0000000-0x0000005cbfffffff] usable
May 27 17:44:13.225815 kernel: printk: legacy bootconsole [earlyser0] enabled
May 27 17:44:13.225823 kernel: NX (Execute Disable) protection: active
May 27 17:44:13.225834 kernel: APIC: Static calls initialized
May 27 17:44:13.225841 kernel: efi: EFI v2.7 by Microsoft
May 27 17:44:13.225850 kernel: efi: ACPI=0x3fffa000 ACPI 2.0=0x3fffa014 SMBIOS=0x3ff85000 SMBIOS 3.0=0x3ff83000 MEMATTR=0x3f5bfa98 RNG=0x3ffd1018 
May 27 17:44:13.225858 kernel: random: crng init done
May 27 17:44:13.225865 kernel: secureboot: Secure boot disabled
May 27 17:44:13.225873 kernel: SMBIOS 3.1.0 present.
May 27 17:44:13.225881 kernel: DMI: Microsoft Corporation Virtual Machine/Virtual Machine, BIOS Hyper-V UEFI Release v4.1 03/08/2024
May 27 17:44:13.225889 kernel: DMI: Memory slots populated: 3/3
May 27 17:44:13.225897 kernel: Hypervisor detected: Microsoft Hyper-V
May 27 17:44:13.225904 kernel: Hyper-V: privilege flags low 0x2e7f, high 0x3b8030, hints 0x62c2c, misc 0xed7b2
May 27 17:44:13.225914 kernel: Hyper-V: LAPIC Timer Frequency: 0x30d40
May 27 17:44:13.225922 kernel: Hyper-V: Using hypercall for remote TLB flush
May 27 17:44:13.225930 kernel: clocksource: hyperv_clocksource_tsc_page: mask: 0xffffffffffffffff max_cycles: 0x24e6a1710, max_idle_ns: 440795202120 ns
May 27 17:44:13.225938 kernel: clocksource: hyperv_clocksource_msr: mask: 0xffffffffffffffff max_cycles: 0x24e6a1710, max_idle_ns: 440795202120 ns
May 27 17:44:13.225947 kernel: tsc: Marking TSC unstable due to running on Hyper-V
May 27 17:44:13.225955 kernel: tsc: Detected 2593.990 MHz processor
May 27 17:44:13.225963 kernel: e820: update [mem 0x00000000-0x00000fff] usable ==> reserved
May 27 17:44:13.225971 kernel: e820: remove [mem 0x000a0000-0x000fffff] usable
May 27 17:44:13.225979 kernel: last_pfn = 0x5cc0000 max_arch_pfn = 0x400000000
May 27 17:44:13.225989 kernel: MTRR map: 5 entries (2 fixed + 3 variable; max 18), built from 8 variable MTRRs
May 27 17:44:13.225997 kernel: x86/PAT: Configuration [0-7]: WB  WC  UC- UC  WB  WP  UC- WT  
May 27 17:44:13.226006 kernel: e820: update [mem 0x40000000-0xffffffff] usable ==> reserved
May 27 17:44:13.226013 kernel: e820: update [mem 0x1100000000-0x4fdfffffff] usable ==> reserved
May 27 17:44:13.226021 kernel: last_pfn = 0x40000 max_arch_pfn = 0x400000000
May 27 17:44:13.226029 kernel: Using GB pages for direct mapping
May 27 17:44:13.226037 kernel: ACPI: Early table checksum verification disabled
May 27 17:44:13.226049 kernel: ACPI: RSDP 0x000000003FFFA014 000024 (v02 VRTUAL)
May 27 17:44:13.226060 kernel: ACPI: XSDT 0x000000003FFF90E8 000064 (v01 VRTUAL MICROSFT 00000001 MSFT 00000001)
May 27 17:44:13.226068 kernel: ACPI: FACP 0x000000003FFF8000 000114 (v06 VRTUAL MICROSFT 00000001 MSFT 00000001)
May 27 17:44:13.226077 kernel: ACPI: DSDT 0x000000003FFD6000 01E184 (v02 MSFTVM DSDT01   00000001 MSFT 05000000)
May 27 17:44:13.226085 kernel: ACPI: FACS 0x000000003FFFE000 000040
May 27 17:44:13.226094 kernel: ACPI: OEM0 0x000000003FFF7000 000064 (v01 VRTUAL MICROSFT 00000001 MSFT 00000001)
May 27 17:44:13.226103 kernel: ACPI: SPCR 0x000000003FFF6000 000050 (v02 VRTUAL MICROSFT 00000001 MSFT 00000001)
May 27 17:44:13.226129 kernel: ACPI: WAET 0x000000003FFF5000 000028 (v01 VRTUAL MICROSFT 00000001 MSFT 00000001)
May 27 17:44:13.226138 kernel: ACPI: APIC 0x000000003FFD5000 000078 (v04 VRTUAL MICROSFT 00000001 MSFT 00000001)
May 27 17:44:13.226147 kernel: ACPI: SRAT 0x000000003FFD4000 0001D0 (v02 VRTUAL MICROSFT 00000001 MSFT 00000001)
May 27 17:44:13.226155 kernel: ACPI: BGRT 0x000000003FFD3000 000038 (v01 VRTUAL MICROSFT 00000001 MSFT 00000001)
May 27 17:44:13.226164 kernel: ACPI: FPDT 0x000000003FFD2000 000034 (v01 VRTUAL MICROSFT 00000001 MSFT 00000001)
May 27 17:44:13.226172 kernel: ACPI: Reserving FACP table memory at [mem 0x3fff8000-0x3fff8113]
May 27 17:44:13.226181 kernel: ACPI: Reserving DSDT table memory at [mem 0x3ffd6000-0x3fff4183]
May 27 17:44:13.226189 kernel: ACPI: Reserving FACS table memory at [mem 0x3fffe000-0x3fffe03f]
May 27 17:44:13.226200 kernel: ACPI: Reserving OEM0 table memory at [mem 0x3fff7000-0x3fff7063]
May 27 17:44:13.226209 kernel: ACPI: Reserving SPCR table memory at [mem 0x3fff6000-0x3fff604f]
May 27 17:44:13.226217 kernel: ACPI: Reserving WAET table memory at [mem 0x3fff5000-0x3fff5027]
May 27 17:44:13.226225 kernel: ACPI: Reserving APIC table memory at [mem 0x3ffd5000-0x3ffd5077]
May 27 17:44:13.226234 kernel: ACPI: Reserving SRAT table memory at [mem 0x3ffd4000-0x3ffd41cf]
May 27 17:44:13.226242 kernel: ACPI: Reserving BGRT table memory at [mem 0x3ffd3000-0x3ffd3037]
May 27 17:44:13.226251 kernel: ACPI: Reserving FPDT table memory at [mem 0x3ffd2000-0x3ffd2033]
May 27 17:44:13.226259 kernel: ACPI: SRAT: Node 0 PXM 0 [mem 0x00000000-0x3fffffff] hotplug
May 27 17:44:13.226267 kernel: ACPI: SRAT: Node 0 PXM 0 [mem 0x100000000-0xfdfffffff] hotplug
May 27 17:44:13.226278 kernel: ACPI: SRAT: Node 0 PXM 0 [mem 0x4fe0000000-0x5cbfffffff] hotplug
May 27 17:44:13.226286 kernel: ACPI: SRAT: Node 0 PXM 0 [mem 0x5cc0200000-0xffffffffff] hotplug
May 27 17:44:13.226295 kernel: ACPI: SRAT: Node 0 PXM 0 [mem 0x10000200000-0x1ffffffffff] hotplug
May 27 17:44:13.226303 kernel: ACPI: SRAT: Node 0 PXM 0 [mem 0x20000200000-0x3ffffffffff] hotplug
May 27 17:44:13.226312 kernel: ACPI: SRAT: Node 0 PXM 0 [mem 0x40000200000-0x7ffffffffff] hotplug
May 27 17:44:13.226320 kernel: ACPI: SRAT: Node 0 PXM 0 [mem 0x80000200000-0xfffffffffff] hotplug
May 27 17:44:13.226329 kernel: NUMA: Node 0 [mem 0x00001000-0x3fffffff] + [mem 0x100000000-0xfdfffffff] -> [mem 0x00001000-0xfdfffffff]
May 27 17:44:13.226337 kernel: NUMA: Node 0 [mem 0x00001000-0xfdfffffff] + [mem 0x4fe0000000-0x5cbfffffff] -> [mem 0x00001000-0x5cbfffffff]
May 27 17:44:13.226346 kernel: NODE_DATA(0) allocated [mem 0x5cbfff7dc0-0x5cbfffefff]
May 27 17:44:13.226356 kernel: Zone ranges:
May 27 17:44:13.226365 kernel:   DMA      [mem 0x0000000000001000-0x0000000000ffffff]
May 27 17:44:13.226373 kernel:   DMA32    [mem 0x0000000001000000-0x00000000ffffffff]
May 27 17:44:13.226382 kernel:   Normal   [mem 0x0000000100000000-0x0000005cbfffffff]
May 27 17:44:13.226390 kernel:   Device   empty
May 27 17:44:13.226398 kernel: Movable zone start for each node
May 27 17:44:13.226407 kernel: Early memory node ranges
May 27 17:44:13.226415 kernel:   node   0: [mem 0x0000000000001000-0x000000000009ffff]
May 27 17:44:13.226424 kernel:   node   0: [mem 0x0000000000100000-0x000000003ff40fff]
May 27 17:44:13.226434 kernel:   node   0: [mem 0x000000003ffff000-0x000000003fffffff]
May 27 17:44:13.226443 kernel:   node   0: [mem 0x0000000100000000-0x0000000fdfffffff]
May 27 17:44:13.226451 kernel:   node   0: [mem 0x0000004fe0000000-0x0000005cbfffffff]
May 27 17:44:13.226459 kernel: Initmem setup node 0 [mem 0x0000000000001000-0x0000005cbfffffff]
May 27 17:44:13.226468 kernel: On node 0, zone DMA: 1 pages in unavailable ranges
May 27 17:44:13.226476 kernel: On node 0, zone DMA: 96 pages in unavailable ranges
May 27 17:44:13.226488 kernel: On node 0, zone DMA32: 190 pages in unavailable ranges
May 27 17:44:13.226496 kernel: ACPI: PM-Timer IO Port: 0x408
May 27 17:44:13.226505 kernel: ACPI: LAPIC_NMI (acpi_id[0x01] dfl dfl lint[0x1])
May 27 17:44:13.226516 kernel: IOAPIC[0]: apic_id 6, version 17, address 0xfec00000, GSI 0-23
May 27 17:44:13.226524 kernel: ACPI: INT_SRC_OVR (bus 0 bus_irq 9 global_irq 9 high level)
May 27 17:44:13.226543 kernel: ACPI: Using ACPI (MADT) for SMP configuration information
May 27 17:44:13.226552 kernel: ACPI: SPCR: console: uart,io,0x3f8,115200
May 27 17:44:13.226560 kernel: CPU topo: Max. logical packages:   1
May 27 17:44:13.226569 kernel: CPU topo: Max. logical dies:       1
May 27 17:44:13.226577 kernel: CPU topo: Max. dies per package:   1
May 27 17:44:13.226585 kernel: CPU topo: Max. threads per core:   1
May 27 17:44:13.226594 kernel: CPU topo: Num. cores per package:     6
May 27 17:44:13.226605 kernel: CPU topo: Num. threads per package:   6
May 27 17:44:13.226613 kernel: CPU topo: Allowing 6 present CPUs plus 0 hotplug CPUs
May 27 17:44:13.226622 kernel: [mem 0x40000000-0xffffffff] available for PCI devices
May 27 17:44:13.226630 kernel: Booting paravirtualized kernel on Hyper-V
May 27 17:44:13.226639 kernel: clocksource: refined-jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1910969940391419 ns
May 27 17:44:13.226647 kernel: setup_percpu: NR_CPUS:512 nr_cpumask_bits:6 nr_cpu_ids:6 nr_node_ids:1
May 27 17:44:13.226656 kernel: percpu: Embedded 60 pages/cpu s207832 r8192 d29736 u262144
May 27 17:44:13.226664 kernel: pcpu-alloc: s207832 r8192 d29736 u262144 alloc=1*2097152
May 27 17:44:13.226672 kernel: pcpu-alloc: [0] 0 1 2 3 4 5 - - 
May 27 17:44:13.226683 kernel: Hyper-V: PV spinlocks enabled
May 27 17:44:13.226692 kernel: PV qspinlock hash table entries: 256 (order: 0, 4096 bytes, linear)
May 27 17:44:13.226704 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=daa3e2d55cc4a7ff0ec15aa9bb0c07df9999cb4e3041f3adad1b1101efdea101
May 27 17:44:13.226713 kernel: Unknown kernel command line parameters "BOOT_IMAGE=/flatcar/vmlinuz-a", will be passed to user space.
May 27 17:44:13.226722 kernel: Dentry cache hash table entries: 8388608 (order: 14, 67108864 bytes, linear)
May 27 17:44:13.226730 kernel: Inode-cache hash table entries: 4194304 (order: 13, 33554432 bytes, linear)
May 27 17:44:13.226738 kernel: Fallback order for Node 0: 0 
May 27 17:44:13.226747 kernel: Built 1 zonelists, mobility grouping on.  Total pages: 29359841
May 27 17:44:13.226758 kernel: Policy zone: Normal
May 27 17:44:13.226774 kernel: mem auto-init: stack:off, heap alloc:off, heap free:off
May 27 17:44:13.226783 kernel: software IO TLB: area num 8.
May 27 17:44:13.226794 kernel: SLUB: HWalign=64, Order=0-3, MinObjects=0, CPUs=6, Nodes=1
May 27 17:44:13.226803 kernel: Kernel/User page tables isolation: enabled
May 27 17:44:13.226812 kernel: ftrace: allocating 40081 entries in 157 pages
May 27 17:44:13.226821 kernel: ftrace: allocated 157 pages with 5 groups
May 27 17:44:13.226829 kernel: Dynamic Preempt: voluntary
May 27 17:44:13.226838 kernel: rcu: Preemptible hierarchical RCU implementation.
May 27 17:44:13.226848 kernel: rcu:         RCU event tracing is enabled.
May 27 17:44:13.226857 kernel: rcu:         RCU restricting CPUs from NR_CPUS=512 to nr_cpu_ids=6.
May 27 17:44:13.226866 kernel:         Trampoline variant of Tasks RCU enabled.
May 27 17:44:13.226877 kernel:         Rude variant of Tasks RCU enabled.
May 27 17:44:13.226886 kernel:         Tracing variant of Tasks RCU enabled.
May 27 17:44:13.226895 kernel: rcu: RCU calculated value of scheduler-enlistment delay is 100 jiffies.
May 27 17:44:13.226904 kernel: rcu: Adjusting geometry for rcu_fanout_leaf=16, nr_cpu_ids=6
May 27 17:44:13.226913 kernel: RCU Tasks: Setting shift to 3 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=6.
May 27 17:44:13.226924 kernel: RCU Tasks Rude: Setting shift to 3 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=6.
May 27 17:44:13.226934 kernel: RCU Tasks Trace: Setting shift to 3 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=6.
May 27 17:44:13.226942 kernel: Using NULL legacy PIC
May 27 17:44:13.226951 kernel: NR_IRQS: 33024, nr_irqs: 472, preallocated irqs: 0
May 27 17:44:13.226960 kernel: rcu: srcu_init: Setting srcu_struct sizes based on contention.
May 27 17:44:13.226969 kernel: Console: colour dummy device 80x25
May 27 17:44:13.226978 kernel: printk: legacy console [tty1] enabled
May 27 17:44:13.226987 kernel: printk: legacy console [ttyS0] enabled
May 27 17:44:13.226996 kernel: printk: legacy bootconsole [earlyser0] disabled
May 27 17:44:13.227007 kernel: ACPI: Core revision 20240827
May 27 17:44:13.227016 kernel: Failed to register legacy timer interrupt
May 27 17:44:13.227024 kernel: APIC: Switch to symmetric I/O mode setup
May 27 17:44:13.227033 kernel: Hyper-V: Host Build 10.0.20348.1827-1-0
May 27 17:44:13.227042 kernel: Hyper-V: enabling crash_kexec_post_notifiers
May 27 17:44:13.227051 kernel: Hyper-V: Using IPI hypercalls
May 27 17:44:13.227060 kernel: APIC: send_IPI() replaced with hv_send_ipi()
May 27 17:44:13.227069 kernel: APIC: send_IPI_mask() replaced with hv_send_ipi_mask()
May 27 17:44:13.227078 kernel: APIC: send_IPI_mask_allbutself() replaced with hv_send_ipi_mask_allbutself()
May 27 17:44:13.227089 kernel: APIC: send_IPI_allbutself() replaced with hv_send_ipi_allbutself()
May 27 17:44:13.227098 kernel: APIC: send_IPI_all() replaced with hv_send_ipi_all()
May 27 17:44:13.227107 kernel: APIC: send_IPI_self() replaced with hv_send_ipi_self()
May 27 17:44:13.227115 kernel: Hyper-V: Using enlightened APIC (xapic mode)
May 27 17:44:13.227124 kernel: APIC: eoi() replaced with hv_apic_eoi_write()
May 27 17:44:13.227133 kernel: APIC: read() replaced with hv_apic_read()
May 27 17:44:13.227142 kernel: APIC: write() replaced with hv_apic_write()
May 27 17:44:13.227151 kernel: APIC: icr_write() replaced with hv_apic_icr_write()
May 27 17:44:13.227160 kernel: APIC: icr_read() replaced with hv_apic_icr_read()
May 27 17:44:13.227171 kernel: Calibrating delay loop (skipped), value calculated using timer frequency.. 5187.98 BogoMIPS (lpj=2593990)
May 27 17:44:13.227180 kernel: Last level iTLB entries: 4KB 128, 2MB 8, 4MB 8
May 27 17:44:13.227189 kernel: Last level dTLB entries: 4KB 64, 2MB 32, 4MB 32, 1GB 4
May 27 17:44:13.227198 kernel: Spectre V1 : Mitigation: usercopy/swapgs barriers and __user pointer sanitization
May 27 17:44:13.227206 kernel: Spectre V2 : Mitigation: Retpolines
May 27 17:44:13.227215 kernel: Spectre V2 : Spectre v2 / SpectreRSB: Filling RSB on context switch and VMEXIT
May 27 17:44:13.227224 kernel: Speculative Store Bypass: Vulnerable
May 27 17:44:13.227232 kernel: MDS: Mitigation: Clear CPU buffers
May 27 17:44:13.227241 kernel: TAA: Mitigation: Clear CPU buffers
May 27 17:44:13.227250 kernel: MMIO Stale Data: Vulnerable: Clear CPU buffers attempted, no microcode
May 27 17:44:13.227260 kernel: ITS: Mitigation: Aligned branch/return thunks
May 27 17:44:13.227269 kernel: x86/fpu: Supporting XSAVE feature 0x001: 'x87 floating point registers'
May 27 17:44:13.227278 kernel: x86/fpu: Supporting XSAVE feature 0x002: 'SSE registers'
May 27 17:44:13.227287 kernel: x86/fpu: Supporting XSAVE feature 0x004: 'AVX registers'
May 27 17:44:13.227295 kernel: x86/fpu: xstate_offset[2]:  576, xstate_sizes[2]:  256
May 27 17:44:13.227304 kernel: x86/fpu: Enabled xstate features 0x7, context size is 832 bytes, using 'standard' format.
May 27 17:44:13.227313 kernel: Freeing SMP alternatives memory: 32K
May 27 17:44:13.227322 kernel: pid_max: default: 32768 minimum: 301
May 27 17:44:13.227331 kernel: LSM: initializing lsm=lockdown,capability,landlock,selinux,ima
May 27 17:44:13.227339 kernel: landlock: Up and running.
May 27 17:44:13.227348 kernel: SELinux:  Initializing.
May 27 17:44:13.227359 kernel: Mount-cache hash table entries: 131072 (order: 8, 1048576 bytes, linear)
May 27 17:44:13.227368 kernel: Mountpoint-cache hash table entries: 131072 (order: 8, 1048576 bytes, linear)
May 27 17:44:13.227377 kernel: smpboot: CPU0: Intel(R) Xeon(R) CPU E5-2690 v4 @ 2.60GHz (family: 0x6, model: 0x4f, stepping: 0x1)
May 27 17:44:13.227386 kernel: Performance Events: unsupported p6 CPU model 79 no PMU driver, software events only.
May 27 17:44:13.227395 kernel: signal: max sigframe size: 1776
May 27 17:44:13.227403 kernel: rcu: Hierarchical SRCU implementation.
May 27 17:44:13.227412 kernel: rcu:         Max phase no-delay instances is 400.
May 27 17:44:13.227421 kernel: Timer migration: 1 hierarchy levels; 8 children per group; 1 crossnode level
May 27 17:44:13.227430 kernel: NMI watchdog: Perf NMI watchdog permanently disabled
May 27 17:44:13.227439 kernel: smp: Bringing up secondary CPUs ...
May 27 17:44:13.227450 kernel: smpboot: x86: Booting SMP configuration:
May 27 17:44:13.227459 kernel: .... node  #0, CPUs:      #1 #2 #3 #4 #5
May 27 17:44:13.227468 kernel: smp: Brought up 1 node, 6 CPUs
May 27 17:44:13.227477 kernel: smpboot: Total of 6 processors activated (31127.88 BogoMIPS)
May 27 17:44:13.227486 kernel: Memory: 115339092K/117439364K available (14336K kernel code, 2430K rwdata, 9952K rodata, 54416K init, 2552K bss, 2089996K reserved, 0K cma-reserved)
May 27 17:44:13.227495 kernel: devtmpfs: initialized
May 27 17:44:13.227504 kernel: x86/mm: Memory block size: 1024MB
May 27 17:44:13.227513 kernel: ACPI: PM: Registering ACPI NVS region [mem 0x3fffb000-0x3fffefff] (16384 bytes)
May 27 17:44:13.227522 kernel: clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1911260446275000 ns
May 27 17:44:13.227541 kernel: futex hash table entries: 2048 (order: 5, 131072 bytes, linear)
May 27 17:44:13.227550 kernel: pinctrl core: initialized pinctrl subsystem
May 27 17:44:13.227559 kernel: NET: Registered PF_NETLINK/PF_ROUTE protocol family
May 27 17:44:13.227568 kernel: audit: initializing netlink subsys (disabled)
May 27 17:44:13.227577 kernel: audit: type=2000 audit(1748367849.031:1): state=initialized audit_enabled=0 res=1
May 27 17:44:13.227586 kernel: thermal_sys: Registered thermal governor 'step_wise'
May 27 17:44:13.227595 kernel: thermal_sys: Registered thermal governor 'user_space'
May 27 17:44:13.227603 kernel: cpuidle: using governor menu
May 27 17:44:13.227612 kernel: acpiphp: ACPI Hot Plug PCI Controller Driver version: 0.5
May 27 17:44:13.227624 kernel: dca service started, version 1.12.1
May 27 17:44:13.227633 kernel: e820: reserve RAM buffer [mem 0x3ff41000-0x3fffffff]
May 27 17:44:13.227642 kernel: kprobes: kprobe jump-optimization is enabled. All kprobes are optimized if possible.
May 27 17:44:13.227651 kernel: HugeTLB: registered 1.00 GiB page size, pre-allocated 0 pages
May 27 17:44:13.227660 kernel: HugeTLB: 16380 KiB vmemmap can be freed for a 1.00 GiB page
May 27 17:44:13.227669 kernel: HugeTLB: registered 2.00 MiB page size, pre-allocated 0 pages
May 27 17:44:13.227678 kernel: HugeTLB: 28 KiB vmemmap can be freed for a 2.00 MiB page
May 27 17:44:13.227687 kernel: ACPI: Added _OSI(Module Device)
May 27 17:44:13.227695 kernel: ACPI: Added _OSI(Processor Device)
May 27 17:44:13.227706 kernel: ACPI: Added _OSI(3.0 _SCP Extensions)
May 27 17:44:13.227715 kernel: ACPI: Added _OSI(Processor Aggregator Device)
May 27 17:44:13.227724 kernel: ACPI: 1 ACPI AML tables successfully acquired and loaded
May 27 17:44:13.227733 kernel: ACPI: Interpreter enabled
May 27 17:44:13.227742 kernel: ACPI: PM: (supports S0 S5)
May 27 17:44:13.227751 kernel: ACPI: Using IOAPIC for interrupt routing
May 27 17:44:13.227760 kernel: PCI: Using host bridge windows from ACPI; if necessary, use "pci=nocrs" and report a bug
May 27 17:44:13.227768 kernel: PCI: Ignoring E820 reservations for host bridge windows
May 27 17:44:13.227778 kernel: ACPI: Enabled 1 GPEs in block 00 to 0F
May 27 17:44:13.227789 kernel: iommu: Default domain type: Translated
May 27 17:44:13.227798 kernel: iommu: DMA domain TLB invalidation policy: lazy mode
May 27 17:44:13.227807 kernel: efivars: Registered efivars operations
May 27 17:44:13.227815 kernel: PCI: Using ACPI for IRQ routing
May 27 17:44:13.227824 kernel: PCI: System does not support PCI
May 27 17:44:13.227833 kernel: vgaarb: loaded
May 27 17:44:13.227842 kernel: clocksource: Switched to clocksource hyperv_clocksource_tsc_page
May 27 17:44:13.227851 kernel: VFS: Disk quotas dquot_6.6.0
May 27 17:44:13.227860 kernel: VFS: Dquot-cache hash table entries: 512 (order 0, 4096 bytes)
May 27 17:44:13.227871 kernel: pnp: PnP ACPI init
May 27 17:44:13.227880 kernel: pnp: PnP ACPI: found 3 devices
May 27 17:44:13.227889 kernel: clocksource: acpi_pm: mask: 0xffffff max_cycles: 0xffffff, max_idle_ns: 2085701024 ns
May 27 17:44:13.227898 kernel: NET: Registered PF_INET protocol family
May 27 17:44:13.227906 kernel: IP idents hash table entries: 262144 (order: 9, 2097152 bytes, linear)
May 27 17:44:13.227916 kernel: tcp_listen_portaddr_hash hash table entries: 65536 (order: 8, 1048576 bytes, linear)
May 27 17:44:13.227924 kernel: Table-perturb hash table entries: 65536 (order: 6, 262144 bytes, linear)
May 27 17:44:13.227934 kernel: TCP established hash table entries: 524288 (order: 10, 4194304 bytes, linear)
May 27 17:44:13.227945 kernel: TCP bind hash table entries: 65536 (order: 9, 2097152 bytes, linear)
May 27 17:44:13.227954 kernel: TCP: Hash tables configured (established 524288 bind 65536)
May 27 17:44:13.227963 kernel: UDP hash table entries: 65536 (order: 9, 2097152 bytes, linear)
May 27 17:44:13.227972 kernel: UDP-Lite hash table entries: 65536 (order: 9, 2097152 bytes, linear)
May 27 17:44:13.227981 kernel: NET: Registered PF_UNIX/PF_LOCAL protocol family
May 27 17:44:13.227989 kernel: NET: Registered PF_XDP protocol family
May 27 17:44:13.227998 kernel: PCI: CLS 0 bytes, default 64
May 27 17:44:13.228007 kernel: PCI-DMA: Using software bounce buffering for IO (SWIOTLB)
May 27 17:44:13.228016 kernel: software IO TLB: mapped [mem 0x000000003ae61000-0x000000003ee61000] (64MB)
May 27 17:44:13.228027 kernel: RAPL PMU: API unit is 2^-32 Joules, 0 fixed counters, 10737418240 ms ovfl timer
May 27 17:44:13.228036 kernel: Initialise system trusted keyrings
May 27 17:44:13.228045 kernel: workingset: timestamp_bits=39 max_order=25 bucket_order=0
May 27 17:44:13.228054 kernel: Key type asymmetric registered
May 27 17:44:13.228062 kernel: Asymmetric key parser 'x509' registered
May 27 17:44:13.228071 kernel: Block layer SCSI generic (bsg) driver version 0.4 loaded (major 250)
May 27 17:44:13.228080 kernel: io scheduler mq-deadline registered
May 27 17:44:13.228089 kernel: io scheduler kyber registered
May 27 17:44:13.228097 kernel: io scheduler bfq registered
May 27 17:44:13.228106 kernel: ioatdma: Intel(R) QuickData Technology Driver 5.00
May 27 17:44:13.228117 kernel: Serial: 8250/16550 driver, 4 ports, IRQ sharing enabled
May 27 17:44:13.228126 kernel: 00:00: ttyS0 at I/O 0x3f8 (irq = 4, base_baud = 115200) is a 16550A
May 27 17:44:13.228135 kernel: 00:01: ttyS1 at I/O 0x2f8 (irq = 3, base_baud = 115200) is a 16550A
May 27 17:44:13.228144 kernel: i8042: PNP: No PS/2 controller found.
May 27 17:44:13.228305 kernel: rtc_cmos 00:02: registered as rtc0
May 27 17:44:13.228410 kernel: rtc_cmos 00:02: setting system clock to 2025-05-27T17:44:12 UTC (1748367852)
May 27 17:44:13.228506 kernel: rtc_cmos 00:02: alarms up to one month, 114 bytes nvram
May 27 17:44:13.228524 kernel: intel_pstate: CPU model not supported
May 27 17:44:13.228545 kernel: efifb: probing for efifb
May 27 17:44:13.228555 kernel: efifb: framebuffer at 0x40000000, using 3072k, total 3072k
May 27 17:44:13.228564 kernel: efifb: mode is 1024x768x32, linelength=4096, pages=1
May 27 17:44:13.228573 kernel: efifb: scrolling: redraw
May 27 17:44:13.228582 kernel: efifb: Truecolor: size=8:8:8:8, shift=24:16:8:0
May 27 17:44:13.228591 kernel: Console: switching to colour frame buffer device 128x48
May 27 17:44:13.228600 kernel: fb0: EFI VGA frame buffer device
May 27 17:44:13.228608 kernel: pstore: Using crash dump compression: deflate
May 27 17:44:13.228621 kernel: pstore: Registered efi_pstore as persistent store backend
May 27 17:44:13.228630 kernel: NET: Registered PF_INET6 protocol family
May 27 17:44:13.228638 kernel: Segment Routing with IPv6
May 27 17:44:13.228647 kernel: In-situ OAM (IOAM) with IPv6
May 27 17:44:13.228656 kernel: NET: Registered PF_PACKET protocol family
May 27 17:44:13.228665 kernel: Key type dns_resolver registered
May 27 17:44:13.228674 kernel: IPI shorthand broadcast: enabled
May 27 17:44:13.228683 kernel: sched_clock: Marking stable (3709005500, 107812500)->(4146604200, -329786200)
May 27 17:44:13.228692 kernel: registered taskstats version 1
May 27 17:44:13.228703 kernel: Loading compiled-in X.509 certificates
May 27 17:44:13.228712 kernel: Loaded X.509 cert 'Kinvolk GmbH: Module signing key for 6.12.30-flatcar: 9507e5c390e18536b38d58c90da64baf0ac9837c'
May 27 17:44:13.228721 kernel: Demotion targets for Node 0: null
May 27 17:44:13.228730 kernel: Key type .fscrypt registered
May 27 17:44:13.228738 kernel: Key type fscrypt-provisioning registered
May 27 17:44:13.228747 kernel: ima: No TPM chip found, activating TPM-bypass!
May 27 17:44:13.228756 kernel: ima: Allocated hash algorithm: sha1
May 27 17:44:13.228765 kernel: ima: No architecture policies found
May 27 17:44:13.228773 kernel: clk: Disabling unused clocks
May 27 17:44:13.228785 kernel: Warning: unable to open an initial console.
May 27 17:44:13.228794 kernel: Freeing unused kernel image (initmem) memory: 54416K
May 27 17:44:13.228803 kernel: Write protecting the kernel read-only data: 24576k
May 27 17:44:13.228812 kernel: Freeing unused kernel image (rodata/data gap) memory: 288K
May 27 17:44:13.228821 kernel: Run /init as init process
May 27 17:44:13.228829 kernel:   with arguments:
May 27 17:44:13.228838 kernel:     /init
May 27 17:44:13.228847 kernel:   with environment:
May 27 17:44:13.228855 kernel:     HOME=/
May 27 17:44:13.228866 kernel:     TERM=linux
May 27 17:44:13.228875 kernel:     BOOT_IMAGE=/flatcar/vmlinuz-a
May 27 17:44:13.228885 systemd[1]: Successfully made /usr/ read-only.
May 27 17:44:13.228897 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 17:44:13.228907 systemd[1]: Detected virtualization microsoft.
May 27 17:44:13.228916 systemd[1]: Detected architecture x86-64.
May 27 17:44:13.228925 systemd[1]: Running in initrd.
May 27 17:44:13.228937 systemd[1]: No hostname configured, using default hostname.
May 27 17:44:13.228946 systemd[1]: Hostname set to <localhost>.
May 27 17:44:13.228956 systemd[1]: Initializing machine ID from random generator.
May 27 17:44:13.228965 systemd[1]: Queued start job for default target initrd.target.
May 27 17:44:13.228974 systemd[1]: Started clevis-luks-askpass.path - Forward Password Requests to Clevis Directory Watch.
May 27 17:44:13.228984 systemd[1]: Started systemd-ask-password-console.path - Dispatch Password Requests to Console Directory Watch.
May 27 17:44:13.228994 systemd[1]: Expecting device dev-disk-by\x2dlabel-EFI\x2dSYSTEM.device - /dev/disk/by-label/EFI-SYSTEM...
May 27 17:44:13.229003 systemd[1]: Expecting device dev-disk-by\x2dlabel-OEM.device - /dev/disk/by-label/OEM...
May 27 17:44:13.229015 systemd[1]: Expecting device dev-disk-by\x2dlabel-ROOT.device - /dev/disk/by-label/ROOT...
May 27 17:44:13.229025 systemd[1]: Expecting device dev-disk-by\x2dpartlabel-USR\x2dA.device - /dev/disk/by-partlabel/USR-A...
May 27 17:44:13.229036 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 17:44:13.229046 systemd[1]: Expecting device dev-mapper-usr.device - /dev/mapper/usr...
May 27 17:44:13.229055 systemd[1]: Reached target cryptsetup-pre.target - Local Encrypted Volumes (Pre).
May 27 17:44:13.229065 systemd[1]: Reached target cryptsetup.target - Local Encrypted Volumes.
May 27 17:44:13.229074 systemd[1]: Reached target paths.target - Path Units.
May 27 17:44:13.229086 systemd[1]: Reached target slices.target - Slice Units.
May 27 17:44:13.229095 systemd[1]: Reached target swap.target - Swaps.
May 27 17:44:13.229105 systemd[1]: Reached target timers.target - Timer Units.
May 27 17:44:13.229114 systemd[1]: Listening on iscsid.socket - Open-iSCSI iscsid Socket.
May 27 17:44:13.229124 systemd[1]: Listening on iscsiuio.socket - Open-iSCSI iscsiuio Socket.
May 27 17:44:13.229133 systemd[1]: Listening on systemd-journald-dev-log.socket - Journal Socket (/dev/log).
May 27 17:44:13.229143 systemd[1]: Listening on systemd-journald.socket - Journal Sockets.
May 27 17:44:13.229152 systemd[1]: Listening on systemd-networkd.socket - Network Service Netlink Socket.
May 27 17:44:13.229162 systemd[1]: Listening on systemd-udevd-control.socket - udev Control Socket.
May 27 17:44:13.229174 systemd[1]: Listening on systemd-udevd-kernel.socket - udev Kernel Socket.
May 27 17:44:13.229183 systemd[1]: Reached target sockets.target - Socket Units.
May 27 17:44:13.229193 systemd[1]: Starting ignition-setup-pre.service - Ignition env setup...
May 27 17:44:13.229202 systemd[1]: Starting kmod-static-nodes.service - Create List of Static Device Nodes...
May 27 17:44:13.229212 systemd[1]: Finished network-cleanup.service - Network Cleanup.
May 27 17:44:13.229222 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 17:44:13.229231 systemd[1]: Starting systemd-fsck-usr.service...
May 27 17:44:13.229241 systemd[1]: Starting systemd-journald.service - Journal Service...
May 27 17:44:13.229253 systemd[1]: Starting systemd-modules-load.service - Load Kernel Modules...
May 27 17:44:13.229262 systemd[1]: Starting systemd-vconsole-setup.service - Virtual Console Setup...
May 27 17:44:13.229272 systemd[1]: Finished ignition-setup-pre.service - Ignition env setup.
May 27 17:44:13.229302 systemd-journald[232]: Collecting audit messages is disabled.
May 27 17:44:13.229328 systemd[1]: Finished kmod-static-nodes.service - Create List of Static Device Nodes.
May 27 17:44:13.229339 systemd[1]: Finished systemd-fsck-usr.service.
May 27 17:44:13.229360 systemd-journald[232]: Journal started
May 27 17:44:13.229383 systemd-journald[232]: Runtime Journal (/run/log/journal/58d6e8a61c1842e199d5108cede714fe) is 8M, max 2.2G, 2.1G free.
May 27 17:44:13.208965 systemd-modules-load[233]: Inserted module 'overlay'
May 27 17:44:13.234213 systemd[1]: Started systemd-journald.service - Journal Service.
May 27 17:44:13.236774 systemd[1]: Starting systemd-tmpfiles-setup-dev-early.service - Create Static Device Nodes in /dev gracefully...
May 27 17:44:13.238474 systemd[1]: Starting systemd-tmpfiles-setup.service - Create System Files and Directories...
May 27 17:44:13.272458 systemd[1]: Finished systemd-vconsole-setup.service - Virtual Console Setup.
May 27 17:44:13.280606 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 17:44:13.275699 systemd-tmpfiles[246]: /usr/lib/tmpfiles.d/var.conf:14: Duplicate line for path "/var/log", ignoring.
May 27 17:44:13.297486 kernel: Bridge firewalling registered
May 27 17:44:13.289687 systemd[1]: Finished systemd-tmpfiles-setup-dev-early.service - Create Static Device Nodes in /dev gracefully.
May 27 17:44:13.302578 systemd-modules-load[233]: Inserted module 'br_netfilter'
May 27 17:44:13.302803 systemd[1]: Finished systemd-tmpfiles-setup.service - Create System Files and Directories.
May 27 17:44:13.308891 systemd[1]: Finished systemd-modules-load.service - Load Kernel Modules.
May 27 17:44:13.319294 systemd[1]: Starting dracut-cmdline-ask.service - dracut ask for additional cmdline parameters...
May 27 17:44:13.335738 systemd[1]: Starting systemd-sysctl.service - Apply Kernel Variables...
May 27 17:44:13.368139 systemd[1]: Starting systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev...
May 27 17:44:13.383409 systemd[1]: Finished systemd-sysctl.service - Apply Kernel Variables.
May 27 17:44:13.383742 systemd[1]: Finished systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev.
May 27 17:44:13.391903 systemd[1]: Starting systemd-resolved.service - Network Name Resolution...
May 27 17:44:13.392247 systemd[1]: Finished dracut-cmdline-ask.service - dracut ask for additional cmdline parameters.
May 27 17:44:13.410497 systemd[1]: Starting dracut-cmdline.service - dracut cmdline hook...
May 27 17:44:13.432158 dracut-cmdline[273]: 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=daa3e2d55cc4a7ff0ec15aa9bb0c07df9999cb4e3041f3adad1b1101efdea101
May 27 17:44:13.447364 systemd-resolved[268]: Positive Trust Anchors:
May 27 17:44:13.447374 systemd-resolved[268]: . IN DS 20326 8 2 e06d44b80b8f1d39a95c0b0d7c65d08458e880409bbc683457104237c7f8ec8d
May 27 17:44:13.447405 systemd-resolved[268]: 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 17:44:13.450018 systemd-resolved[268]: Defaulting to hostname 'linux'.
May 27 17:44:13.451074 systemd[1]: Started systemd-resolved.service - Network Name Resolution.
May 27 17:44:13.461332 systemd[1]: Reached target nss-lookup.target - Host and Network Name Lookups.
May 27 17:44:13.591561 kernel: SCSI subsystem initialized
May 27 17:44:13.602551 kernel: Loading iSCSI transport class v2.0-870.
May 27 17:44:13.614554 kernel: iscsi: registered transport (tcp)
May 27 17:44:13.638863 kernel: iscsi: registered transport (qla4xxx)
May 27 17:44:13.638914 kernel: QLogic iSCSI HBA Driver
May 27 17:44:13.658207 systemd[1]: Starting systemd-network-generator.service - Generate network units from Kernel command line...
May 27 17:44:13.679037 systemd[1]: Finished systemd-network-generator.service - Generate network units from Kernel command line.
May 27 17:44:13.680181 systemd[1]: Reached target network-pre.target - Preparation for Network.
May 27 17:44:13.737648 systemd[1]: Finished dracut-cmdline.service - dracut cmdline hook.
May 27 17:44:13.739128 systemd[1]: Starting dracut-pre-udev.service - dracut pre-udev hook...
May 27 17:44:13.810563 kernel: raid6: avx2x4   gen() 30580 MB/s
May 27 17:44:13.829556 kernel: raid6: avx2x2   gen() 30618 MB/s
May 27 17:44:13.850595 kernel: raid6: avx2x1   gen() 27763 MB/s
May 27 17:44:13.850625 kernel: raid6: using algorithm avx2x2 gen() 30618 MB/s
May 27 17:44:13.873789 kernel: raid6: .... xor() 18032 MB/s, rmw enabled
May 27 17:44:13.873820 kernel: raid6: using avx2x2 recovery algorithm
May 27 17:44:13.896551 kernel: xor: automatically using best checksumming function   avx       
May 27 17:44:14.058568 kernel: Btrfs loaded, zoned=no, fsverity=no
May 27 17:44:14.065090 systemd[1]: Finished dracut-pre-udev.service - dracut pre-udev hook.
May 27 17:44:14.066686 systemd[1]: Starting systemd-udevd.service - Rule-based Manager for Device Events and Files...
May 27 17:44:14.106506 systemd-udevd[483]: Using default interface naming scheme 'v255'.
May 27 17:44:14.112624 systemd[1]: Started systemd-udevd.service - Rule-based Manager for Device Events and Files.
May 27 17:44:14.113584 systemd[1]: Starting dracut-pre-trigger.service - dracut pre-trigger hook...
May 27 17:44:14.147899 dracut-pre-trigger[487]: rd.md=0: removing MD RAID activation
May 27 17:44:14.175257 systemd[1]: Finished dracut-pre-trigger.service - dracut pre-trigger hook.
May 27 17:44:14.181307 systemd[1]: Starting systemd-udev-trigger.service - Coldplug All udev Devices...
May 27 17:44:14.262724 systemd[1]: Finished systemd-udev-trigger.service - Coldplug All udev Devices.
May 27 17:44:14.278083 systemd[1]: Starting dracut-initqueue.service - dracut initqueue hook...
May 27 17:44:14.291572 kernel: cryptd: max_cpu_qlen set to 1000
May 27 17:44:14.303938 kernel: AES CTR mode by8 optimization enabled
May 27 17:44:14.303976 kernel: hv_vmbus: Vmbus version:4.0
May 27 17:44:14.323651 kernel: pps_core: LinuxPPS API ver. 1 registered
May 27 17:44:14.323699 kernel: pps_core: Software ver. 5.3.6 - Copyright 2005-2007 Rodolfo Giometti <giometti@linux.it>
May 27 17:44:14.325169 systemd[1]: systemd-vconsole-setup.service: Deactivated successfully.
May 27 17:44:14.346641 kernel: hv_vmbus: registering driver hyperv_keyboard
May 27 17:44:14.346669 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 17:44:14.346683 kernel: PTP clock support registered
May 27 17:44:14.325343 systemd[1]: Stopped systemd-vconsole-setup.service - Virtual Console Setup.
May 27 17:44:14.351065 systemd[1]: Stopping systemd-vconsole-setup.service - Virtual Console Setup...
May 27 17:44:14.361406 systemd[1]: Starting systemd-vconsole-setup.service - Virtual Console Setup...
May 27 17:44:14.372734 kernel: hv_vmbus: registering driver hv_netvsc
May 27 17:44:14.373130 systemd[1]: run-credentials-systemd\x2dvconsole\x2dsetup.service.mount: Deactivated successfully.
May 27 17:44:14.381520 kernel: hid: raw HID events driver (C) Jiri Kosina
May 27 17:44:14.385553 kernel: hv_vmbus: registering driver hv_pci
May 27 17:44:14.385582 kernel: hv_vmbus: registering driver hid_hyperv
May 27 17:44:14.388442 kernel: hv_utils: Registering HyperV Utility Driver
May 27 17:44:14.388473 kernel: input: Microsoft Vmbus HID-compliant Mouse as /devices/0006:045E:0621.0001/input/input1
May 27 17:44:14.388487 kernel: hv_pci 47505500-0001-0000-3130-444531444234: PCI VMBus probing: Using version 0x10004
May 27 17:44:14.394675 kernel: hv_vmbus: registering driver hv_utils
May 27 17:44:14.398936 kernel: hid-hyperv 0006:045E:0621.0001: input: VIRTUAL HID v0.01 Mouse [Microsoft Vmbus HID-compliant Mouse] on 
May 27 17:44:14.410686 kernel: hv_pci 47505500-0001-0000-3130-444531444234: PCI host bridge to bus 0001:00
May 27 17:44:14.410882 kernel: hv_utils: Heartbeat IC version 3.0
May 27 17:44:14.410897 kernel: pci_bus 0001:00: root bus resource [mem 0x41000000-0x41ffffff window]
May 27 17:44:14.416596 kernel: hv_utils: Shutdown IC version 3.2
May 27 17:44:14.416628 kernel: pci_bus 0001:00: root bus resource [mem 0x1000000000-0x1401ffffff window]
May 27 17:44:14.426224 kernel: hv_utils: TimeSync IC version 4.0
May 27 17:44:14.426259 kernel: pci_bus 0001:00: No busn resource found for root bus, will use [bus 00-ff]
May 27 17:44:15.179563 systemd-resolved[268]: Clock change detected. Flushing caches.
May 27 17:44:15.191280 kernel: pci 0001:00:00.0: [10de:1db4] type 00 class 0x030200 PCIe Endpoint
May 27 17:44:15.191321 kernel: pci 0001:00:00.0: BAR 0 [mem 0x41000000-0x41ffffff]
May 27 17:44:15.196064 kernel: pci 0001:00:00.0: BAR 1 [mem 0x1000000000-0x13ffffffff 64bit pref]
May 27 17:44:15.196112 kernel: hv_vmbus: registering driver hv_storvsc
May 27 17:44:15.199064 kernel: pci 0001:00:00.0: BAR 3 [mem 0x1400000000-0x1401ffffff 64bit pref]
May 27 17:44:15.203767 kernel: scsi host0: storvsc_host_t
May 27 17:44:15.206072 kernel: scsi host1: storvsc_host_t
May 27 17:44:15.206118 kernel: pci 0001:00:00.0: Enabling HDA controller
May 27 17:44:15.207061 kernel: scsi 0:0:0:0: Direct-Access     Msft     Virtual Disk     1.0  PQ: 0 ANSI: 5
May 27 17:44:15.212118 kernel: scsi 0:0:0:1: Direct-Access     Msft     Virtual Disk     1.0  PQ: 0 ANSI: 5
May 27 17:44:15.223800 systemd[1]: Finished systemd-vconsole-setup.service - Virtual Console Setup.
May 27 17:44:15.252188 kernel: scsi 0:0:0:2: CD-ROM            Msft     Virtual DVD-ROM  1.0  PQ: 0 ANSI: 0
May 27 17:44:15.252414 kernel: pci_bus 0001:00: busn_res: [bus 00-ff] end is updated to 00
May 27 17:44:15.252571 kernel: pci 0001:00:00.0: BAR 1 [mem 0x1000000000-0x13ffffffff 64bit pref]: assigned
May 27 17:44:15.252733 kernel: pci 0001:00:00.0: BAR 3 [mem 0x1400000000-0x1401ffffff 64bit pref]: assigned
May 27 17:44:15.252871 kernel: pci 0001:00:00.0: BAR 0 [mem 0x41000000-0x41ffffff]: assigned
May 27 17:44:15.265676 kernel: sd 0:0:0:0: [sdb] 63737856 512-byte logical blocks: (32.6 GB/30.4 GiB)
May 27 17:44:15.265923 kernel: sd 0:0:0:1: [sda] 1543503872 512-byte logical blocks: (790 GB/736 GiB)
May 27 17:44:15.266144 kernel: sd 0:0:0:0: [sdb] 4096-byte physical blocks
May 27 17:44:15.266305 kernel: sd 0:0:0:1: [sda] 4096-byte physical blocks
May 27 17:44:15.266442 kernel: sd 0:0:0:1: [sda] Write Protect is off
May 27 17:44:15.274494 kernel: sd 0:0:0:0: [sdb] Write Protect is off
May 27 17:44:15.274660 kernel: sd 0:0:0:1: [sda] Mode Sense: 0f 00 10 00
May 27 17:44:15.274795 kernel: sd 0:0:0:0: [sdb] Mode Sense: 0f 00 10 00
May 27 17:44:15.277164 kernel: sd 0:0:0:1: [sda] Write cache: disabled, read cache: enabled, supports DPO and FUA
May 27 17:44:15.282061 kernel: sd 0:0:0:0: [sdb] Write cache: disabled, read cache: enabled, supports DPO and FUA
May 27 17:44:15.282216 kernel: hv_storvsc f8b3781a-1e82-4818-a1c3-63d806ec15bb: tag#259 cmd 0x5a status: scsi 0x2 srb 0x86 hv 0xc0000001
May 27 17:44:15.287059 kernel: hv_storvsc f8b3781a-1e82-4818-a1c3-63d806ec15bb: tag#69 cmd 0x5a status: scsi 0x2 srb 0x86 hv 0xc0000001
May 27 17:44:15.309860 kernel: hv_storvsc f8b3781a-1e82-4818-a1c3-63d806ec15bb: tag#76 cmd 0x5a status: scsi 0x2 srb 0x86 hv 0xc0000001
May 27 17:44:15.310105 kernel: hv_storvsc f8b3781a-1e82-4818-a1c3-63d806ec15bb: tag#3 cmd 0x5a status: scsi 0x2 srb 0x86 hv 0xc0000001
May 27 17:44:15.322060 kernel:  sdb: sdb1 sdb2 sdb3 sdb4 sdb6 sdb7 sdb9
May 27 17:44:15.322105 kernel:  sda: sda1
May 27 17:44:15.323059 kernel: sd 0:0:0:0: [sdb] Attached SCSI disk
May 27 17:44:15.323278 kernel: sd 0:0:0:1: [sda] Attached SCSI disk
May 27 17:44:15.329063 kernel: sr 0:0:0:2: [sr0] scsi-1 drive
May 27 17:44:15.333933 kernel: cdrom: Uniform CD-ROM driver Revision: 3.20
May 27 17:44:15.336084 kernel: sr 0:0:0:2: Attached scsi CD-ROM sr0
May 27 17:44:15.858026 systemd[1]: Found device dev-disk-by\x2dlabel-OEM.device - Virtual_Disk OEM.
May 27 17:44:15.885696 systemd[1]: Found device dev-disk-by\x2dlabel-EFI\x2dSYSTEM.device - Virtual_Disk EFI-SYSTEM.
May 27 17:44:15.911518 systemd[1]: Found device dev-disk-by\x2dlabel-ROOT.device - Virtual_Disk ROOT.
May 27 17:44:15.971374 systemd[1]: Found device dev-disk-by\x2dpartlabel-USR\x2dA.device - Virtual_Disk USR-A.
May 27 17:44:15.971558 systemd[1]: Found device dev-disk-by\x2dpartuuid-7130c94a\x2d213a\x2d4e5a\x2d8e26\x2d6cce9662f132.device - Virtual_Disk USR-A.
May 27 17:44:15.981972 systemd[1]: Starting disk-uuid.service - Generate new UUID for disk GPT if necessary...
May 27 17:44:16.026066 kernel: hv_storvsc f8b3781a-1e82-4818-a1c3-63d806ec15bb: tag#326 cmd 0x5a status: scsi 0x2 srb 0x86 hv 0xc0000001
May 27 17:44:16.040057 kernel:  sdb: sdb1 sdb2 sdb3 sdb4 sdb6 sdb7 sdb9
May 27 17:44:16.048061 kernel: hv_storvsc f8b3781a-1e82-4818-a1c3-63d806ec15bb: tag#343 cmd 0x5a status: scsi 0x2 srb 0x86 hv 0xc0000001
May 27 17:44:16.065061 kernel:  sdb: sdb1 sdb2 sdb3 sdb4 sdb6 sdb7 sdb9
May 27 17:44:17.073075 kernel: hv_storvsc f8b3781a-1e82-4818-a1c3-63d806ec15bb: tag#8 cmd 0x5a status: scsi 0x2 srb 0x86 hv 0xc0000001
May 27 17:44:17.083061 kernel:  sdb: sdb1 sdb2 sdb3 sdb4 sdb6 sdb7 sdb9
May 27 17:44:17.083478 disk-uuid[722]: The operation has completed successfully.
May 27 17:44:18.518019 systemd[1]: disk-uuid.service: Deactivated successfully.
May 27 17:44:18.518155 systemd[1]: Finished disk-uuid.service - Generate new UUID for disk GPT if necessary.
May 27 17:44:18.531975 systemd[1]: Starting verity-setup.service - Verity Setup for /dev/mapper/usr...
May 27 17:44:18.540812 systemd[1]: Finished dracut-initqueue.service - dracut initqueue hook.
May 27 17:44:18.541723 systemd[1]: Reached target remote-fs-pre.target - Preparation for Remote File Systems.
May 27 17:44:18.554993 systemd[1]: Reached target remote-cryptsetup.target - Remote Encrypted Volumes.
May 27 17:44:18.566184 systemd[1]: Reached target remote-fs.target - Remote File Systems.
May 27 17:44:18.575461 systemd[1]: Starting dracut-pre-mount.service - dracut pre-mount hook...
May 27 17:44:18.586447 sh[886]: Success
May 27 17:44:18.609455 kernel: device-mapper: core: CONFIG_IMA_DISABLE_HTABLE is disabled. Duplicate IMA measurements will not be recorded in the IMA log.
May 27 17:44:18.609502 kernel: device-mapper: uevent: version 1.0.3
May 27 17:44:18.614276 kernel: device-mapper: ioctl: 4.48.0-ioctl (2023-03-01) initialised: dm-devel@lists.linux.dev
May 27 17:44:18.627005 systemd[1]: Finished dracut-pre-mount.service - dracut pre-mount hook.
May 27 17:44:18.635556 kernel: device-mapper: verity: sha256 using shash "sha256-avx2"
May 27 17:44:18.796922 systemd[1]: Found device dev-mapper-usr.device - /dev/mapper/usr.
May 27 17:44:18.797815 systemd[1]: Mounting sysusr-usr.mount - /sysusr/usr...
May 27 17:44:18.825794 systemd[1]: Finished verity-setup.service - Verity Setup for /dev/mapper/usr.
May 27 17:44:18.846099 kernel: BTRFS info: 'norecovery' is for compatibility only, recommended to use 'rescue=nologreplay'
May 27 17:44:18.846124 kernel: BTRFS: device fsid 7caef027-0915-4c01-a3d5-28eff70f7ebd devid 1 transid 39 /dev/mapper/usr (254:0) scanned by mount (913)
May 27 17:44:18.851291 kernel: BTRFS info (device dm-0): first mount of filesystem 7caef027-0915-4c01-a3d5-28eff70f7ebd
May 27 17:44:18.855566 kernel: BTRFS info (device dm-0): using crc32c (crc32c-intel) checksum algorithm
May 27 17:44:18.858732 kernel: BTRFS info (device dm-0): using free-space-tree
May 27 17:44:19.224870 systemd[1]: Mounted sysusr-usr.mount - /sysusr/usr.
May 27 17:44:19.225548 systemd[1]: Reached target initrd-usr-fs.target - Initrd /usr File System.
May 27 17:44:19.236313 systemd[1]: afterburn-network-kargs.service - Afterburn Initrd Setup Network Kernel Arguments was skipped because no trigger condition checks were met.
May 27 17:44:19.237120 systemd[1]: Starting ignition-setup.service - Ignition (setup)...
May 27 17:44:19.241197 systemd[1]: Starting parse-ip-for-networkd.service - Write systemd-networkd units from cmdline...
May 27 17:44:19.294066 kernel: BTRFS: device label OEM devid 1 transid 16 /dev/sdb6 (8:22) scanned by mount (945)
May 27 17:44:19.302846 kernel: BTRFS info (device sdb6): first mount of filesystem be856aed-e34b-4b7b-be8a-0716b27db212
May 27 17:44:19.302883 kernel: BTRFS info (device sdb6): using crc32c (crc32c-intel) checksum algorithm
May 27 17:44:19.305988 kernel: BTRFS info (device sdb6): using free-space-tree
May 27 17:44:19.345063 kernel: BTRFS info (device sdb6): last unmount of filesystem be856aed-e34b-4b7b-be8a-0716b27db212
May 27 17:44:19.345757 systemd[1]: Finished ignition-setup.service - Ignition (setup).
May 27 17:44:19.356248 systemd[1]: Starting ignition-fetch-offline.service - Ignition (fetch-offline)...
May 27 17:44:19.370166 systemd[1]: Finished parse-ip-for-networkd.service - Write systemd-networkd units from cmdline.
May 27 17:44:19.371817 systemd[1]: Starting systemd-networkd.service - Network Configuration...
May 27 17:44:19.411421 systemd-networkd[1083]: lo: Link UP
May 27 17:44:19.411431 systemd-networkd[1083]: lo: Gained carrier
May 27 17:44:19.412528 systemd-networkd[1083]: Enumeration completed
May 27 17:44:19.412610 systemd[1]: Started systemd-networkd.service - Network Configuration.
May 27 17:44:19.412900 systemd-networkd[1083]: eth0: found matching network '/usr/lib/systemd/network/zz-default.network', based on potentially unpredictable interface name.
May 27 17:44:19.412905 systemd-networkd[1083]: eth0: Configuring with /usr/lib/systemd/network/zz-default.network.
May 27 17:44:19.413734 systemd-networkd[1083]: eth0: Link UP
May 27 17:44:19.413903 systemd-networkd[1083]: eth0: Gained carrier
May 27 17:44:19.413913 systemd-networkd[1083]: eth0: found matching network '/usr/lib/systemd/network/zz-default.network', based on potentially unpredictable interface name.
May 27 17:44:19.414342 systemd[1]: Reached target network.target - Network.
May 27 17:44:19.475111 systemd-networkd[1083]: eth0: DHCPv4 address 10.200.8.11/24, gateway 10.200.8.1 acquired from 168.63.129.16
May 27 17:44:20.382457 ignition[1077]: Ignition 2.21.0
May 27 17:44:20.382474 ignition[1077]: Stage: fetch-offline
May 27 17:44:20.382591 ignition[1077]: no configs at "/usr/lib/ignition/base.d"
May 27 17:44:20.382601 ignition[1077]: no config dir at "/usr/lib/ignition/base.platform.d/azure"
May 27 17:44:20.382707 ignition[1077]: parsed url from cmdline: ""
May 27 17:44:20.382711 ignition[1077]: no config URL provided
May 27 17:44:20.382717 ignition[1077]: reading system config file "/usr/lib/ignition/user.ign"
May 27 17:44:20.382725 ignition[1077]: no config at "/usr/lib/ignition/user.ign"
May 27 17:44:20.382731 ignition[1077]: failed to fetch config: resource requires networking
May 27 17:44:20.382895 ignition[1077]: Ignition finished successfully
May 27 17:44:20.414677 systemd[1]: Finished ignition-fetch-offline.service - Ignition (fetch-offline).
May 27 17:44:20.420524 systemd[1]: Starting ignition-fetch.service - Ignition (fetch)...
May 27 17:44:20.464477 ignition[1096]: Ignition 2.21.0
May 27 17:44:20.464503 ignition[1096]: Stage: fetch
May 27 17:44:20.464968 ignition[1096]: no configs at "/usr/lib/ignition/base.d"
May 27 17:44:20.464983 ignition[1096]: no config dir at "/usr/lib/ignition/base.platform.d/azure"
May 27 17:44:20.465135 ignition[1096]: parsed url from cmdline: ""
May 27 17:44:20.465139 ignition[1096]: no config URL provided
May 27 17:44:20.465149 ignition[1096]: reading system config file "/usr/lib/ignition/user.ign"
May 27 17:44:20.465159 ignition[1096]: no config at "/usr/lib/ignition/user.ign"
May 27 17:44:20.465189 ignition[1096]: GET http://169.254.169.254/metadata/instance/compute/userData?api-version=2021-01-01&format=text: attempt #1
May 27 17:44:20.551396 ignition[1096]: GET result: OK
May 27 17:44:20.551448 ignition[1096]: config has been read from IMDS userdata
May 27 17:44:20.551460 ignition[1096]: parsing config with SHA512: 9c65872c6a5cd3f0753009dd9cc3780db24afb22c1500e20cf608ef5ccaeaab40916e500d898f6af8bdf11a03f9aae15e2617953dde0812d83b5fb4d34cae634
May 27 17:44:20.554923 unknown[1096]: fetched base config from "system"
May 27 17:44:20.555138 ignition[1096]: fetch: fetch complete
May 27 17:44:20.554930 unknown[1096]: fetched base config from "system"
May 27 17:44:20.555157 ignition[1096]: fetch: fetch passed
May 27 17:44:20.554935 unknown[1096]: fetched user config from "azure"
May 27 17:44:20.555199 ignition[1096]: Ignition finished successfully
May 27 17:44:20.563442 systemd[1]: Finished ignition-fetch.service - Ignition (fetch).
May 27 17:44:20.565029 systemd[1]: Starting ignition-kargs.service - Ignition (kargs)...
May 27 17:44:20.616093 ignition[1105]: Ignition 2.21.0
May 27 17:44:20.616111 ignition[1105]: Stage: kargs
May 27 17:44:20.619130 systemd-networkd[1083]: eth0: Gained IPv6LL
May 27 17:44:20.616454 ignition[1105]: no configs at "/usr/lib/ignition/base.d"
May 27 17:44:20.622263 systemd[1]: Finished ignition-kargs.service - Ignition (kargs).
May 27 17:44:20.616471 ignition[1105]: no config dir at "/usr/lib/ignition/base.platform.d/azure"
May 27 17:44:20.632559 systemd[1]: Starting ignition-disks.service - Ignition (disks)...
May 27 17:44:20.617867 ignition[1105]: kargs: kargs passed
May 27 17:44:20.617918 ignition[1105]: Ignition finished successfully
May 27 17:44:20.687896 ignition[1114]: Ignition 2.21.0
May 27 17:44:20.687911 ignition[1114]: Stage: disks
May 27 17:44:20.688147 ignition[1114]: no configs at "/usr/lib/ignition/base.d"
May 27 17:44:20.688158 ignition[1114]: no config dir at "/usr/lib/ignition/base.platform.d/azure"
May 27 17:44:20.689231 ignition[1114]: disks: disks passed
May 27 17:44:20.697727 systemd[1]: Finished ignition-disks.service - Ignition (disks).
May 27 17:44:20.689283 ignition[1114]: Ignition finished successfully
May 27 17:44:20.700917 systemd[1]: Reached target initrd-root-device.target - Initrd Root Device.
May 27 17:44:20.707265 systemd[1]: Reached target local-fs-pre.target - Preparation for Local File Systems.
May 27 17:44:20.720712 systemd[1]: Reached target local-fs.target - Local File Systems.
May 27 17:44:20.727755 systemd[1]: Reached target sysinit.target - System Initialization.
May 27 17:44:20.736053 systemd[1]: Reached target basic.target - Basic System.
May 27 17:44:20.745226 systemd[1]: Starting systemd-fsck-root.service - File System Check on /dev/disk/by-label/ROOT...
May 27 17:44:20.822495 systemd-fsck[1126]: ROOT: clean, 15/7326000 files, 477845/7359488 blocks
May 27 17:44:20.829951 systemd[1]: Finished systemd-fsck-root.service - File System Check on /dev/disk/by-label/ROOT.
May 27 17:44:20.841794 systemd[1]: Mounting sysroot.mount - /sysroot...
May 27 17:44:21.071060 kernel: EXT4-fs (sdb9): mounted filesystem bf93e767-f532-4480-b210-a196f7ac181e r/w with ordered data mode. Quota mode: none.
May 27 17:44:21.071819 systemd[1]: Mounted sysroot.mount - /sysroot.
May 27 17:44:21.078530 systemd[1]: Reached target initrd-root-fs.target - Initrd Root File System.
May 27 17:44:21.100012 systemd[1]: Mounting sysroot-oem.mount - /sysroot/oem...
May 27 17:44:21.100906 systemd[1]: Mounting sysroot-usr.mount - /sysroot/usr...
May 27 17:44:21.127556 systemd[1]: Starting flatcar-metadata-hostname.service - Flatcar Metadata Hostname Agent...
May 27 17:44:21.151855 kernel: BTRFS: device label OEM devid 1 transid 16 /dev/sdb6 (8:22) scanned by mount (1140)
May 27 17:44:21.151879 kernel: BTRFS info (device sdb6): first mount of filesystem be856aed-e34b-4b7b-be8a-0716b27db212
May 27 17:44:21.151893 kernel: BTRFS info (device sdb6): using crc32c (crc32c-intel) checksum algorithm
May 27 17:44:21.151912 kernel: BTRFS info (device sdb6): using free-space-tree
May 27 17:44:21.127693 systemd[1]: ignition-remount-sysroot.service - Remount /sysroot read-write for Ignition was skipped because of an unmet condition check (ConditionPathIsReadWrite=!/sysroot).
May 27 17:44:21.127724 systemd[1]: Reached target ignition-diskful.target - Ignition Boot Disk Setup.
May 27 17:44:21.157955 systemd[1]: Mounted sysroot-usr.mount - /sysroot/usr.
May 27 17:44:21.179003 systemd[1]: Mounted sysroot-oem.mount - /sysroot/oem.
May 27 17:44:21.184601 systemd[1]: Starting initrd-setup-root.service - Root filesystem setup...
May 27 17:44:21.784866 coreos-metadata[1142]: May 27 17:44:21.784 INFO Fetching http://168.63.129.16/?comp=versions: Attempt #1
May 27 17:44:21.792869 coreos-metadata[1142]: May 27 17:44:21.792 INFO Fetch successful
May 27 17:44:21.796805 coreos-metadata[1142]: May 27 17:44:21.792 INFO Fetching http://169.254.169.254/metadata/instance/compute/name?api-version=2017-08-01&format=text: Attempt #1
May 27 17:44:21.805293 coreos-metadata[1142]: May 27 17:44:21.800 INFO Fetch successful
May 27 17:44:21.815645 coreos-metadata[1142]: May 27 17:44:21.815 INFO wrote hostname ci-4344.0.0-a-13e6b84161 to /sysroot/etc/hostname
May 27 17:44:21.823428 systemd[1]: Finished flatcar-metadata-hostname.service - Flatcar Metadata Hostname Agent.
May 27 17:44:21.980206 initrd-setup-root[1170]: cut: /sysroot/etc/passwd: No such file or directory
May 27 17:44:22.012782 initrd-setup-root[1177]: cut: /sysroot/etc/group: No such file or directory
May 27 17:44:22.031905 initrd-setup-root[1184]: cut: /sysroot/etc/shadow: No such file or directory
May 27 17:44:22.038957 initrd-setup-root[1191]: cut: /sysroot/etc/gshadow: No such file or directory
May 27 17:44:23.010934 systemd[1]: Finished initrd-setup-root.service - Root filesystem setup.
May 27 17:44:23.016745 systemd[1]: Starting ignition-mount.service - Ignition (mount)...
May 27 17:44:23.041312 systemd[1]: Starting sysroot-boot.service - /sysroot/boot...
May 27 17:44:23.053117 systemd[1]: sysroot-oem.mount: Deactivated successfully.
May 27 17:44:23.061926 kernel: BTRFS info (device sdb6): last unmount of filesystem be856aed-e34b-4b7b-be8a-0716b27db212
May 27 17:44:23.073014 systemd[1]: Finished sysroot-boot.service - /sysroot/boot.
May 27 17:44:23.087595 ignition[1260]: INFO     : Ignition 2.21.0
May 27 17:44:23.087595 ignition[1260]: INFO     : Stage: mount
May 27 17:44:23.093381 ignition[1260]: INFO     : no configs at "/usr/lib/ignition/base.d"
May 27 17:44:23.093381 ignition[1260]: INFO     : no config dir at "/usr/lib/ignition/base.platform.d/azure"
May 27 17:44:23.093381 ignition[1260]: INFO     : mount: mount passed
May 27 17:44:23.093381 ignition[1260]: INFO     : Ignition finished successfully
May 27 17:44:23.095004 systemd[1]: Finished ignition-mount.service - Ignition (mount).
May 27 17:44:23.102555 systemd[1]: Starting ignition-files.service - Ignition (files)...
May 27 17:44:23.132569 systemd[1]: Mounting sysroot-oem.mount - /sysroot/oem...
May 27 17:44:23.154094 kernel: BTRFS: device label OEM devid 1 transid 16 /dev/sdb6 (8:22) scanned by mount (1274)
May 27 17:44:23.154130 kernel: BTRFS info (device sdb6): first mount of filesystem be856aed-e34b-4b7b-be8a-0716b27db212
May 27 17:44:23.158391 kernel: BTRFS info (device sdb6): using crc32c (crc32c-intel) checksum algorithm
May 27 17:44:23.161612 kernel: BTRFS info (device sdb6): using free-space-tree
May 27 17:44:23.169279 systemd[1]: Mounted sysroot-oem.mount - /sysroot/oem.
May 27 17:44:23.207009 ignition[1291]: INFO     : Ignition 2.21.0
May 27 17:44:23.210288 ignition[1291]: INFO     : Stage: files
May 27 17:44:23.210288 ignition[1291]: INFO     : no configs at "/usr/lib/ignition/base.d"
May 27 17:44:23.210288 ignition[1291]: INFO     : no config dir at "/usr/lib/ignition/base.platform.d/azure"
May 27 17:44:23.210288 ignition[1291]: DEBUG    : files: compiled without relabeling support, skipping
May 27 17:44:23.254952 ignition[1291]: INFO     : files: ensureUsers: op(1): [started]  creating or modifying user "core"
May 27 17:44:23.254952 ignition[1291]: DEBUG    : files: ensureUsers: op(1): executing: "usermod" "--root" "/sysroot" "core"
May 27 17:44:23.289873 ignition[1291]: INFO     : files: ensureUsers: op(1): [finished] creating or modifying user "core"
May 27 17:44:23.295600 ignition[1291]: INFO     : files: ensureUsers: op(2): [started]  adding ssh keys to user "core"
May 27 17:44:23.300997 ignition[1291]: INFO     : files: ensureUsers: op(2): [finished] adding ssh keys to user "core"
May 27 17:44:23.296159 unknown[1291]: wrote ssh authorized keys file for user: core
May 27 17:44:23.319052 ignition[1291]: INFO     : files: createFilesystemsFiles: createFiles: op(3): [started]  writing file "/sysroot/etc/flatcar/update.conf"
May 27 17:44:23.326424 ignition[1291]: INFO     : files: createFilesystemsFiles: createFiles: op(3): [finished] writing file "/sysroot/etc/flatcar/update.conf"
May 27 17:44:23.326424 ignition[1291]: INFO     : files: createResultFile: createFiles: op(4): [started]  writing file "/sysroot/etc/.ignition-result.json"
May 27 17:44:23.326424 ignition[1291]: INFO     : files: createResultFile: createFiles: op(4): [finished] writing file "/sysroot/etc/.ignition-result.json"
May 27 17:44:23.326424 ignition[1291]: INFO     : files: files passed
May 27 17:44:23.326424 ignition[1291]: INFO     : Ignition finished successfully
May 27 17:44:23.342345 systemd[1]: Finished ignition-files.service - Ignition (files).
May 27 17:44:23.349431 systemd[1]: Starting ignition-quench.service - Ignition (record completion)...
May 27 17:44:23.380293 systemd[1]: Starting initrd-setup-root-after-ignition.service - Root filesystem completion...
May 27 17:44:23.383493 systemd[1]: ignition-quench.service: Deactivated successfully.
May 27 17:44:23.383594 systemd[1]: Finished ignition-quench.service - Ignition (record completion).
May 27 17:44:23.412752 initrd-setup-root-after-ignition[1324]: grep: /sysroot/etc/flatcar/enabled-sysext.conf: No such file or directory
May 27 17:44:23.412752 initrd-setup-root-after-ignition[1324]: grep: /sysroot/usr/share/flatcar/enabled-sysext.conf: No such file or directory
May 27 17:44:23.430444 initrd-setup-root-after-ignition[1328]: grep: /sysroot/etc/flatcar/enabled-sysext.conf: No such file or directory
May 27 17:44:23.415092 systemd[1]: Finished initrd-setup-root-after-ignition.service - Root filesystem completion.
May 27 17:44:23.419415 systemd[1]: Reached target ignition-complete.target - Ignition Complete.
May 27 17:44:23.435717 systemd[1]: Starting initrd-parse-etc.service - Mountpoints Configured in the Real Root...
May 27 17:44:23.484209 systemd[1]: initrd-parse-etc.service: Deactivated successfully.
May 27 17:44:23.484364 systemd[1]: Finished initrd-parse-etc.service - Mountpoints Configured in the Real Root.
May 27 17:44:23.488372 systemd[1]: Reached target initrd-fs.target - Initrd File Systems.
May 27 17:44:23.489842 systemd[1]: Reached target initrd.target - Initrd Default Target.
May 27 17:44:23.509330 systemd[1]: dracut-mount.service - dracut mount hook was skipped because no trigger condition checks were met.
May 27 17:44:23.510385 systemd[1]: Starting dracut-pre-pivot.service - dracut pre-pivot and cleanup hook...
May 27 17:44:23.562672 systemd[1]: Finished dracut-pre-pivot.service - dracut pre-pivot and cleanup hook.
May 27 17:44:23.564141 systemd[1]: Starting initrd-cleanup.service - Cleaning Up and Shutting Down Daemons...
May 27 17:44:23.600489 systemd[1]: Stopped target nss-lookup.target - Host and Network Name Lookups.
May 27 17:44:23.600743 systemd[1]: Stopped target remote-cryptsetup.target - Remote Encrypted Volumes.
May 27 17:44:23.614191 systemd[1]: Stopped target timers.target - Timer Units.
May 27 17:44:23.622376 systemd[1]: dracut-pre-pivot.service: Deactivated successfully.
May 27 17:44:23.622513 systemd[1]: Stopped dracut-pre-pivot.service - dracut pre-pivot and cleanup hook.
May 27 17:44:23.634169 systemd[1]: Stopped target initrd.target - Initrd Default Target.
May 27 17:44:23.638803 systemd[1]: Stopped target basic.target - Basic System.
May 27 17:44:23.646502 systemd[1]: Stopped target ignition-complete.target - Ignition Complete.
May 27 17:44:23.653373 systemd[1]: Stopped target ignition-diskful.target - Ignition Boot Disk Setup.
May 27 17:44:23.662681 systemd[1]: Stopped target initrd-root-device.target - Initrd Root Device.
May 27 17:44:23.671524 systemd[1]: Stopped target initrd-usr-fs.target - Initrd /usr File System.
May 27 17:44:23.680532 systemd[1]: Stopped target remote-fs.target - Remote File Systems.
May 27 17:44:23.688909 systemd[1]: Stopped target remote-fs-pre.target - Preparation for Remote File Systems.
May 27 17:44:23.696781 systemd[1]: Stopped target sysinit.target - System Initialization.
May 27 17:44:23.706355 systemd[1]: Stopped target local-fs.target - Local File Systems.
May 27 17:44:23.713995 systemd[1]: Stopped target swap.target - Swaps.
May 27 17:44:23.721537 systemd[1]: dracut-pre-mount.service: Deactivated successfully.
May 27 17:44:23.721686 systemd[1]: Stopped dracut-pre-mount.service - dracut pre-mount hook.
May 27 17:44:23.735452 systemd[1]: Stopped target cryptsetup.target - Local Encrypted Volumes.
May 27 17:44:23.739800 systemd[1]: Stopped target cryptsetup-pre.target - Local Encrypted Volumes (Pre).
May 27 17:44:23.749914 systemd[1]: clevis-luks-askpass.path: Deactivated successfully.
May 27 17:44:23.759006 systemd[1]: Stopped clevis-luks-askpass.path - Forward Password Requests to Clevis Directory Watch.
May 27 17:44:23.763067 systemd[1]: dracut-initqueue.service: Deactivated successfully.
May 27 17:44:23.763208 systemd[1]: Stopped dracut-initqueue.service - dracut initqueue hook.
May 27 17:44:23.787607 systemd[1]: initrd-setup-root-after-ignition.service: Deactivated successfully.
May 27 17:44:23.787753 systemd[1]: Stopped initrd-setup-root-after-ignition.service - Root filesystem completion.
May 27 17:44:23.792245 systemd[1]: ignition-files.service: Deactivated successfully.
May 27 17:44:23.792363 systemd[1]: Stopped ignition-files.service - Ignition (files).
May 27 17:44:23.802080 systemd[1]: flatcar-metadata-hostname.service: Deactivated successfully.
May 27 17:44:23.802193 systemd[1]: Stopped flatcar-metadata-hostname.service - Flatcar Metadata Hostname Agent.
May 27 17:44:23.810630 systemd[1]: Stopping ignition-mount.service - Ignition (mount)...
May 27 17:44:23.821358 systemd[1]: kmod-static-nodes.service: Deactivated successfully.
May 27 17:44:23.821490 systemd[1]: Stopped kmod-static-nodes.service - Create List of Static Device Nodes.
May 27 17:44:23.860028 ignition[1348]: INFO     : Ignition 2.21.0
May 27 17:44:23.860028 ignition[1348]: INFO     : Stage: umount
May 27 17:44:23.860028 ignition[1348]: INFO     : no configs at "/usr/lib/ignition/base.d"
May 27 17:44:23.860028 ignition[1348]: INFO     : no config dir at "/usr/lib/ignition/base.platform.d/azure"
May 27 17:44:23.840634 systemd[1]: Stopping sysroot-boot.service - /sysroot/boot...
May 27 17:44:23.884260 ignition[1348]: INFO     : umount: umount passed
May 27 17:44:23.884260 ignition[1348]: INFO     : Ignition finished successfully
May 27 17:44:23.842993 systemd[1]: systemd-udev-trigger.service: Deactivated successfully.
May 27 17:44:23.843139 systemd[1]: Stopped systemd-udev-trigger.service - Coldplug All udev Devices.
May 27 17:44:23.854823 systemd[1]: dracut-pre-trigger.service: Deactivated successfully.
May 27 17:44:23.854945 systemd[1]: Stopped dracut-pre-trigger.service - dracut pre-trigger hook.
May 27 17:44:23.867870 systemd[1]: sysroot-boot.mount: Deactivated successfully.
May 27 17:44:23.869660 systemd[1]: ignition-mount.service: Deactivated successfully.
May 27 17:44:23.869761 systemd[1]: Stopped ignition-mount.service - Ignition (mount).
May 27 17:44:23.879731 systemd[1]: ignition-disks.service: Deactivated successfully.
May 27 17:44:23.879839 systemd[1]: Stopped ignition-disks.service - Ignition (disks).
May 27 17:44:23.891610 systemd[1]: ignition-kargs.service: Deactivated successfully.
May 27 17:44:23.891666 systemd[1]: Stopped ignition-kargs.service - Ignition (kargs).
May 27 17:44:23.898756 systemd[1]: ignition-fetch.service: Deactivated successfully.
May 27 17:44:23.898805 systemd[1]: Stopped ignition-fetch.service - Ignition (fetch).
May 27 17:44:23.906221 systemd[1]: Stopped target network.target - Network.
May 27 17:44:23.913437 systemd[1]: ignition-fetch-offline.service: Deactivated successfully.
May 27 17:44:23.913487 systemd[1]: Stopped ignition-fetch-offline.service - Ignition (fetch-offline).
May 27 17:44:23.917841 systemd[1]: Stopped target paths.target - Path Units.
May 27 17:44:23.926220 systemd[1]: systemd-ask-password-console.path: Deactivated successfully.
May 27 17:44:23.930084 systemd[1]: Stopped systemd-ask-password-console.path - Dispatch Password Requests to Console Directory Watch.
May 27 17:44:23.933776 systemd[1]: Stopped target slices.target - Slice Units.
May 27 17:44:23.941872 systemd[1]: Stopped target sockets.target - Socket Units.
May 27 17:44:23.948991 systemd[1]: iscsid.socket: Deactivated successfully.
May 27 17:44:23.949055 systemd[1]: Closed iscsid.socket - Open-iSCSI iscsid Socket.
May 27 17:44:23.956214 systemd[1]: iscsiuio.socket: Deactivated successfully.
May 27 17:44:23.956262 systemd[1]: Closed iscsiuio.socket - Open-iSCSI iscsiuio Socket.
May 27 17:44:23.963453 systemd[1]: ignition-setup.service: Deactivated successfully.
May 27 17:44:23.963503 systemd[1]: Stopped ignition-setup.service - Ignition (setup).
May 27 17:44:23.978445 systemd[1]: ignition-setup-pre.service: Deactivated successfully.
May 27 17:44:23.978497 systemd[1]: Stopped ignition-setup-pre.service - Ignition env setup.
May 27 17:44:23.982219 systemd[1]: Stopping systemd-networkd.service - Network Configuration...
May 27 17:44:23.989707 systemd[1]: Stopping systemd-resolved.service - Network Name Resolution...
May 27 17:44:23.998885 systemd[1]: systemd-resolved.service: Deactivated successfully.
May 27 17:44:23.998995 systemd[1]: Stopped systemd-resolved.service - Network Name Resolution.
May 27 17:44:24.006850 systemd[1]: initrd-cleanup.service: Deactivated successfully.
May 27 17:44:24.006955 systemd[1]: Finished initrd-cleanup.service - Cleaning Up and Shutting Down Daemons.
May 27 17:44:24.020824 systemd[1]: run-credentials-systemd\x2dresolved.service.mount: Deactivated successfully.
May 27 17:44:24.021128 systemd[1]: systemd-networkd.service: Deactivated successfully.
May 27 17:44:24.021231 systemd[1]: Stopped systemd-networkd.service - Network Configuration.
May 27 17:44:24.033153 systemd[1]: run-credentials-systemd\x2dnetworkd.service.mount: Deactivated successfully.
May 27 17:44:24.033417 systemd[1]: sysroot-boot.service: Deactivated successfully.
May 27 17:44:24.033513 systemd[1]: Stopped sysroot-boot.service - /sysroot/boot.
May 27 17:44:24.043954 systemd[1]: Stopped target network-pre.target - Preparation for Network.
May 27 17:44:24.047191 systemd[1]: systemd-networkd.socket: Deactivated successfully.
May 27 17:44:24.047231 systemd[1]: Closed systemd-networkd.socket - Network Service Netlink Socket.
May 27 17:44:24.056968 systemd[1]: initrd-setup-root.service: Deactivated successfully.
May 27 17:44:24.057022 systemd[1]: Stopped initrd-setup-root.service - Root filesystem setup.
May 27 17:44:24.065783 systemd[1]: Stopping network-cleanup.service - Network Cleanup...
May 27 17:44:24.072486 systemd[1]: parse-ip-for-networkd.service: Deactivated successfully.
May 27 17:44:24.072539 systemd[1]: Stopped parse-ip-for-networkd.service - Write systemd-networkd units from cmdline.
May 27 17:44:24.079909 systemd[1]: systemd-sysctl.service: Deactivated successfully.
May 27 17:44:24.079954 systemd[1]: Stopped systemd-sysctl.service - Apply Kernel Variables.
May 27 17:44:24.098911 systemd[1]: systemd-modules-load.service: Deactivated successfully.
May 27 17:44:24.098968 systemd[1]: Stopped systemd-modules-load.service - Load Kernel Modules.
May 27 17:44:24.102621 systemd[1]: systemd-tmpfiles-setup.service: Deactivated successfully.
May 27 17:44:24.102670 systemd[1]: Stopped systemd-tmpfiles-setup.service - Create System Files and Directories.
May 27 17:44:24.122548 systemd[1]: Stopping systemd-udevd.service - Rule-based Manager for Device Events and Files...
May 27 17:44:24.128585 systemd[1]: run-credentials-systemd\x2dsysctl.service.mount: Deactivated successfully.
May 27 17:44:24.128657 systemd[1]: run-credentials-systemd\x2dtmpfiles\x2dsetup.service.mount: Deactivated successfully.
May 27 17:44:24.149608 systemd[1]: systemd-udevd.service: Deactivated successfully.
May 27 17:44:24.150162 systemd[1]: Stopped systemd-udevd.service - Rule-based Manager for Device Events and Files.
May 27 17:44:24.152102 systemd[1]: systemd-udevd-control.socket: Deactivated successfully.
May 27 17:44:24.152148 systemd[1]: Closed systemd-udevd-control.socket - udev Control Socket.
May 27 17:44:24.165644 systemd[1]: systemd-udevd-kernel.socket: Deactivated successfully.
May 27 17:44:24.165680 systemd[1]: Closed systemd-udevd-kernel.socket - udev Kernel Socket.
May 27 17:44:24.174726 systemd[1]: dracut-pre-udev.service: Deactivated successfully.
May 27 17:44:24.174772 systemd[1]: Stopped dracut-pre-udev.service - dracut pre-udev hook.
May 27 17:44:24.194800 systemd[1]: dracut-cmdline.service: Deactivated successfully.
May 27 17:44:24.194868 systemd[1]: Stopped dracut-cmdline.service - dracut cmdline hook.
May 27 17:44:24.206618 systemd[1]: dracut-cmdline-ask.service: Deactivated successfully.
May 27 17:44:24.206690 systemd[1]: Stopped dracut-cmdline-ask.service - dracut ask for additional cmdline parameters.
May 27 17:44:24.220335 systemd[1]: Starting initrd-udevadm-cleanup-db.service - Cleanup udev Database...
May 27 17:44:24.223379 systemd[1]: systemd-network-generator.service: Deactivated successfully.
May 27 17:44:24.223435 systemd[1]: Stopped systemd-network-generator.service - Generate network units from Kernel command line.
May 27 17:44:24.240321 systemd[1]: systemd-tmpfiles-setup-dev.service: Deactivated successfully.
May 27 17:44:24.240373 systemd[1]: Stopped systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev.
May 27 17:44:24.254225 systemd[1]: systemd-vconsole-setup.service: Deactivated successfully.
May 27 17:44:24.254269 systemd[1]: Stopped systemd-vconsole-setup.service - Virtual Console Setup.
May 27 17:44:24.267380 systemd[1]: run-credentials-systemd\x2dnetwork\x2dgenerator.service.mount: Deactivated successfully.
May 27 17:44:24.267435 systemd[1]: run-credentials-systemd\x2dtmpfiles\x2dsetup\x2ddev.service.mount: Deactivated successfully.
May 27 17:44:24.267478 systemd[1]: run-credentials-systemd\x2dvconsole\x2dsetup.service.mount: Deactivated successfully.
May 27 17:44:24.267833 systemd[1]: network-cleanup.service: Deactivated successfully.
May 27 17:44:24.424706 systemd-journald[232]: Received SIGTERM from PID 1 (systemd).
May 27 17:44:24.267928 systemd[1]: Stopped network-cleanup.service - Network Cleanup.
May 27 17:44:24.276021 systemd[1]: initrd-udevadm-cleanup-db.service: Deactivated successfully.
May 27 17:44:24.276129 systemd[1]: Finished initrd-udevadm-cleanup-db.service - Cleanup udev Database.
May 27 17:44:24.281129 systemd[1]: Reached target initrd-switch-root.target - Switch Root.
May 27 17:44:24.289576 systemd[1]: Starting initrd-switch-root.service - Switch Root...
May 27 17:44:24.333082 systemd[1]: Switching root.
May 27 17:44:24.437209 systemd-journald[232]: Journal stopped
May 27 17:44:29.471787 kernel: SELinux:  policy capability network_peer_controls=1
May 27 17:44:29.471820 kernel: SELinux:  policy capability open_perms=1
May 27 17:44:29.471833 kernel: SELinux:  policy capability extended_socket_class=1
May 27 17:44:29.471843 kernel: SELinux:  policy capability always_check_network=0
May 27 17:44:29.471852 kernel: SELinux:  policy capability cgroup_seclabel=1
May 27 17:44:29.471861 kernel: SELinux:  policy capability nnp_nosuid_transition=1
May 27 17:44:29.471871 kernel: SELinux:  policy capability genfs_seclabel_symlinks=0
May 27 17:44:29.471883 kernel: SELinux:  policy capability ioctl_skip_cloexec=0
May 27 17:44:29.471893 kernel: SELinux:  policy capability userspace_initial_context=0
May 27 17:44:29.471903 kernel: audit: type=1403 audit(1748367865.141:2): auid=4294967295 ses=4294967295 lsm=selinux res=1
May 27 17:44:29.471914 systemd[1]: Successfully loaded SELinux policy in 215.825ms.
May 27 17:44:29.471961 systemd[1]: Relabeled /dev/, /dev/shm/, /run/ in 15.356ms.
May 27 17:44:29.471975 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 17:44:29.471986 systemd[1]: Detected virtualization microsoft.
May 27 17:44:29.472002 systemd[1]: Detected architecture x86-64.
May 27 17:44:29.472013 systemd[1]: Detected first boot.
May 27 17:44:29.472024 systemd[1]: Hostname set to <ci-4344.0.0-a-13e6b84161>.
May 27 17:44:29.472038 systemd[1]: Initializing machine ID from random generator.
May 27 17:44:29.472070 zram_generator::config[1394]: No configuration found.
May 27 17:44:29.472086 kernel: Guest personality initialized and is inactive
May 27 17:44:29.472102 kernel: VMCI host device registered (name=vmci, major=10, minor=124)
May 27 17:44:29.472112 kernel: Initialized host personality
May 27 17:44:29.472122 kernel: NET: Registered PF_VSOCK protocol family
May 27 17:44:29.472132 systemd[1]: Populated /etc with preset unit settings.
May 27 17:44:29.472144 systemd[1]: run-credentials-systemd\x2djournald.service.mount: Deactivated successfully.
May 27 17:44:29.472154 systemd[1]: initrd-switch-root.service: Deactivated successfully.
May 27 17:44:29.472168 systemd[1]: Stopped initrd-switch-root.service - Switch Root.
May 27 17:44:29.472179 systemd[1]: systemd-journald.service: Scheduled restart job, restart counter is at 1.
May 27 17:44:29.472189 systemd[1]: Created slice system-addon\x2dconfig.slice - Slice /system/addon-config.
May 27 17:44:29.472201 systemd[1]: Created slice system-addon\x2drun.slice - Slice /system/addon-run.
May 27 17:44:29.472211 systemd[1]: Created slice system-getty.slice - Slice /system/getty.
May 27 17:44:29.472222 systemd[1]: Created slice system-modprobe.slice - Slice /system/modprobe.
May 27 17:44:29.472233 systemd[1]: Created slice system-serial\x2dgetty.slice - Slice /system/serial-getty.
May 27 17:44:29.472244 systemd[1]: Created slice system-system\x2dcloudinit.slice - Slice /system/system-cloudinit.
May 27 17:44:29.472257 systemd[1]: Created slice system-systemd\x2dfsck.slice - Slice /system/systemd-fsck.
May 27 17:44:29.472268 systemd[1]: Created slice user.slice - User and Session Slice.
May 27 17:44:29.472279 systemd[1]: Started clevis-luks-askpass.path - Forward Password Requests to Clevis Directory Watch.
May 27 17:44:29.472297 systemd[1]: Started systemd-ask-password-console.path - Dispatch Password Requests to Console Directory Watch.
May 27 17:44:29.472311 systemd[1]: Started systemd-ask-password-wall.path - Forward Password Requests to Wall Directory Watch.
May 27 17:44:29.472323 systemd[1]: Set up automount boot.automount - Boot partition Automount Point.
May 27 17:44:29.472338 systemd[1]: Set up automount proc-sys-fs-binfmt_misc.automount - Arbitrary Executable File Formats File System Automount Point.
May 27 17:44:29.472350 systemd[1]: Expecting device dev-disk-by\x2dlabel-OEM.device - /dev/disk/by-label/OEM...
May 27 17:44:29.472364 systemd[1]: Expecting device dev-ttyS0.device - /dev/ttyS0...
May 27 17:44:29.472375 systemd[1]: Reached target cryptsetup-pre.target - Local Encrypted Volumes (Pre).
May 27 17:44:29.472386 systemd[1]: Reached target cryptsetup.target - Local Encrypted Volumes.
May 27 17:44:29.472397 systemd[1]: Stopped target initrd-switch-root.target - Switch Root.
May 27 17:44:29.472408 systemd[1]: Stopped target initrd-fs.target - Initrd File Systems.
May 27 17:44:29.472420 systemd[1]: Stopped target initrd-root-fs.target - Initrd Root File System.
May 27 17:44:29.472431 systemd[1]: Reached target integritysetup.target - Local Integrity Protected Volumes.
May 27 17:44:29.472445 systemd[1]: Reached target remote-cryptsetup.target - Remote Encrypted Volumes.
May 27 17:44:29.472456 systemd[1]: Reached target remote-fs.target - Remote File Systems.
May 27 17:44:29.472467 systemd[1]: Reached target slices.target - Slice Units.
May 27 17:44:29.472478 systemd[1]: Reached target swap.target - Swaps.
May 27 17:44:29.472489 systemd[1]: Reached target veritysetup.target - Local Verity Protected Volumes.
May 27 17:44:29.472499 systemd[1]: Listening on systemd-coredump.socket - Process Core Dump Socket.
May 27 17:44:29.472514 systemd[1]: Listening on systemd-creds.socket - Credential Encryption/Decryption.
May 27 17:44:29.472525 systemd[1]: Listening on systemd-networkd.socket - Network Service Netlink Socket.
May 27 17:44:29.472536 systemd[1]: Listening on systemd-udevd-control.socket - udev Control Socket.
May 27 17:44:29.472548 systemd[1]: Listening on systemd-udevd-kernel.socket - udev Kernel Socket.
May 27 17:44:29.472563 systemd[1]: Listening on systemd-userdbd.socket - User Database Manager Socket.
May 27 17:44:29.472574 systemd[1]: Mounting dev-hugepages.mount - Huge Pages File System...
May 27 17:44:29.472586 systemd[1]: Mounting dev-mqueue.mount - POSIX Message Queue File System...
May 27 17:44:29.472600 systemd[1]: Mounting media.mount - External Media Directory...
May 27 17:44:29.472612 systemd[1]: proc-xen.mount - /proc/xen was skipped because of an unmet condition check (ConditionVirtualization=xen).
May 27 17:44:29.472624 systemd[1]: Mounting sys-kernel-debug.mount - Kernel Debug File System...
May 27 17:44:29.472635 systemd[1]: Mounting sys-kernel-tracing.mount - Kernel Trace File System...
May 27 17:44:29.472646 systemd[1]: Mounting tmp.mount - Temporary Directory /tmp...
May 27 17:44:29.472658 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 17:44:29.472669 systemd[1]: Reached target machines.target - Containers.
May 27 17:44:29.472680 systemd[1]: Starting flatcar-tmpfiles.service - Create missing system files...
May 27 17:44:29.472692 systemd[1]: ignition-delete-config.service - Ignition (delete config) was skipped because no trigger condition checks were met.
May 27 17:44:29.472706 systemd[1]: Starting kmod-static-nodes.service - Create List of Static Device Nodes...
May 27 17:44:29.472717 systemd[1]: Starting modprobe@configfs.service - Load Kernel Module configfs...
May 27 17:44:29.472729 systemd[1]: Starting modprobe@dm_mod.service - Load Kernel Module dm_mod...
May 27 17:44:29.472740 systemd[1]: Starting modprobe@drm.service - Load Kernel Module drm...
May 27 17:44:29.472751 systemd[1]: Starting modprobe@efi_pstore.service - Load Kernel Module efi_pstore...
May 27 17:44:29.472762 systemd[1]: Starting modprobe@fuse.service - Load Kernel Module fuse...
May 27 17:44:29.472773 systemd[1]: Starting modprobe@loop.service - Load Kernel Module loop...
May 27 17:44:29.472784 systemd[1]: setup-nsswitch.service - Create /etc/nsswitch.conf was skipped because of an unmet condition check (ConditionPathExists=!/etc/nsswitch.conf).
May 27 17:44:29.472799 systemd[1]: systemd-fsck-root.service: Deactivated successfully.
May 27 17:44:29.472814 systemd[1]: Stopped systemd-fsck-root.service - File System Check on Root Device.
May 27 17:44:29.472825 systemd[1]: systemd-fsck-usr.service: Deactivated successfully.
May 27 17:44:29.472836 systemd[1]: Stopped systemd-fsck-usr.service.
May 27 17:44:29.472848 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 17:44:29.472859 systemd[1]: Starting systemd-journald.service - Journal Service...
May 27 17:44:29.472870 kernel: loop: module loaded
May 27 17:44:29.472880 kernel: fuse: init (API version 7.41)
May 27 17:44:29.472894 systemd[1]: Starting systemd-modules-load.service - Load Kernel Modules...
May 27 17:44:29.472933 systemd-journald[1501]: Collecting audit messages is disabled.
May 27 17:44:29.472960 systemd-journald[1501]: Journal started
May 27 17:44:29.472987 systemd-journald[1501]: Runtime Journal (/run/log/journal/4bd6b603789341aea3ee7f62151fc145) is 8M, max 2.2G, 2.1G free.
May 27 17:44:28.710941 systemd[1]: Queued start job for default target multi-user.target.
May 27 17:44:28.737679 systemd[1]: Unnecessary job was removed for dev-sdb6.device - /dev/sdb6.
May 27 17:44:28.738238 systemd[1]: systemd-journald.service: Deactivated successfully.
May 27 17:44:29.489063 systemd[1]: Starting systemd-network-generator.service - Generate network units from Kernel command line...
May 27 17:44:29.504280 systemd[1]: Starting systemd-remount-fs.service - Remount Root and Kernel File Systems...
May 27 17:44:29.508059 kernel: ACPI: bus type drm_connector registered
May 27 17:44:29.508099 systemd[1]: Starting systemd-udev-load-credentials.service - Load udev Rules from Credentials...
May 27 17:44:29.525055 systemd[1]: Starting systemd-udev-trigger.service - Coldplug All udev Devices...
May 27 17:44:29.535339 systemd[1]: verity-setup.service: Deactivated successfully.
May 27 17:44:29.535397 systemd[1]: Stopped verity-setup.service.
May 27 17:44:29.548063 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 17:44:29.555062 systemd[1]: Started systemd-journald.service - Journal Service.
May 27 17:44:29.559071 systemd[1]: Mounted dev-hugepages.mount - Huge Pages File System.
May 27 17:44:29.563457 systemd[1]: Mounted dev-mqueue.mount - POSIX Message Queue File System.
May 27 17:44:29.568094 systemd[1]: Mounted media.mount - External Media Directory.
May 27 17:44:29.572232 systemd[1]: Mounted sys-kernel-debug.mount - Kernel Debug File System.
May 27 17:44:29.576821 systemd[1]: Mounted sys-kernel-tracing.mount - Kernel Trace File System.
May 27 17:44:29.581344 systemd[1]: Mounted tmp.mount - Temporary Directory /tmp.
May 27 17:44:29.585544 systemd[1]: Finished flatcar-tmpfiles.service - Create missing system files.
May 27 17:44:29.590494 systemd[1]: Finished kmod-static-nodes.service - Create List of Static Device Nodes.
May 27 17:44:29.595896 systemd[1]: modprobe@configfs.service: Deactivated successfully.
May 27 17:44:29.596108 systemd[1]: Finished modprobe@configfs.service - Load Kernel Module configfs.
May 27 17:44:29.601283 systemd[1]: modprobe@dm_mod.service: Deactivated successfully.
May 27 17:44:29.601487 systemd[1]: Finished modprobe@dm_mod.service - Load Kernel Module dm_mod.
May 27 17:44:29.606427 systemd[1]: modprobe@drm.service: Deactivated successfully.
May 27 17:44:29.606606 systemd[1]: Finished modprobe@drm.service - Load Kernel Module drm.
May 27 17:44:29.611254 systemd[1]: modprobe@efi_pstore.service: Deactivated successfully.
May 27 17:44:29.611434 systemd[1]: Finished modprobe@efi_pstore.service - Load Kernel Module efi_pstore.
May 27 17:44:29.616511 systemd[1]: modprobe@fuse.service: Deactivated successfully.
May 27 17:44:29.616699 systemd[1]: Finished modprobe@fuse.service - Load Kernel Module fuse.
May 27 17:44:29.621267 systemd[1]: modprobe@loop.service: Deactivated successfully.
May 27 17:44:29.621444 systemd[1]: Finished modprobe@loop.service - Load Kernel Module loop.
May 27 17:44:29.626067 systemd[1]: Finished systemd-modules-load.service - Load Kernel Modules.
May 27 17:44:29.631276 systemd[1]: Finished systemd-network-generator.service - Generate network units from Kernel command line.
May 27 17:44:29.636630 systemd[1]: Finished systemd-remount-fs.service - Remount Root and Kernel File Systems.
May 27 17:44:29.642192 systemd[1]: Finished systemd-udev-load-credentials.service - Load udev Rules from Credentials.
May 27 17:44:29.647709 systemd[1]: Finished systemd-udev-trigger.service - Coldplug All udev Devices.
May 27 17:44:29.662325 systemd[1]: Reached target network-pre.target - Preparation for Network.
May 27 17:44:29.668147 systemd[1]: Mounting sys-fs-fuse-connections.mount - FUSE Control File System...
May 27 17:44:29.688305 systemd[1]: Mounting sys-kernel-config.mount - Kernel Configuration File System...
May 27 17:44:29.692780 systemd[1]: remount-root.service - Remount Root File System was skipped because of an unmet condition check (ConditionPathIsReadWrite=!/).
May 27 17:44:29.692818 systemd[1]: Reached target local-fs.target - Local File Systems.
May 27 17:44:29.698148 systemd[1]: Listening on systemd-sysext.socket - System Extension Image Management.
May 27 17:44:29.704594 systemd[1]: Starting ldconfig.service - Rebuild Dynamic Linker Cache...
May 27 17:44:29.708804 systemd[1]: systemd-binfmt.service - Set Up Additional Binary Formats was skipped because no trigger condition checks were met.
May 27 17:44:29.720405 systemd[1]: Starting systemd-hwdb-update.service - Rebuild Hardware Database...
May 27 17:44:29.725799 systemd[1]: Starting systemd-journal-flush.service - Flush Journal to Persistent Storage...
May 27 17:44:29.730414 systemd[1]: systemd-pstore.service - Platform Persistent Storage Archival was skipped because of an unmet condition check (ConditionDirectoryNotEmpty=/sys/fs/pstore).
May 27 17:44:29.731449 systemd[1]: Starting systemd-random-seed.service - Load/Save OS Random Seed...
May 27 17:44:29.735716 systemd[1]: systemd-repart.service - Repartition Root Disk was skipped because no trigger condition checks were met.
May 27 17:44:29.736827 systemd[1]: Starting systemd-sysctl.service - Apply Kernel Variables...
May 27 17:44:29.742094 systemd[1]: Starting systemd-sysext.service - Merge System Extension Images into /usr/ and /opt/...
May 27 17:44:29.746087 systemd-journald[1501]: Time spent on flushing to /var/log/journal/4bd6b603789341aea3ee7f62151fc145 is 13.781ms for 946 entries.
May 27 17:44:29.746087 systemd-journald[1501]: System Journal (/var/log/journal/4bd6b603789341aea3ee7f62151fc145) is 8M, max 2.6G, 2.6G free.
May 27 17:44:29.793689 systemd-journald[1501]: Received client request to flush runtime journal.
May 27 17:44:29.751689 systemd[1]: Starting systemd-sysusers.service - Create System Users...
May 27 17:44:29.757916 systemd[1]: Mounted sys-fs-fuse-connections.mount - FUSE Control File System.
May 27 17:44:29.762804 systemd[1]: Mounted sys-kernel-config.mount - Kernel Configuration File System.
May 27 17:44:29.768068 systemd[1]: Finished systemd-random-seed.service - Load/Save OS Random Seed.
May 27 17:44:29.775473 systemd[1]: Reached target first-boot-complete.target - First Boot Complete.
May 27 17:44:29.781911 systemd[1]: Starting systemd-machine-id-commit.service - Save Transient machine-id to Disk...
May 27 17:44:29.794559 systemd[1]: Finished systemd-journal-flush.service - Flush Journal to Persistent Storage.
May 27 17:44:29.801335 systemd[1]: Finished systemd-sysctl.service - Apply Kernel Variables.
May 27 17:44:29.844061 kernel: loop0: detected capacity change from 0 to 146240
May 27 17:44:29.844314 systemd[1]: etc-machine\x2did.mount: Deactivated successfully.
May 27 17:44:29.844985 systemd[1]: Finished systemd-machine-id-commit.service - Save Transient machine-id to Disk.
May 27 17:44:29.919849 systemd[1]: Finished systemd-sysusers.service - Create System Users.
May 27 17:44:29.925687 systemd[1]: Starting systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev...
May 27 17:44:30.005749 systemd-tmpfiles[1551]: ACLs are not supported, ignoring.
May 27 17:44:30.005770 systemd-tmpfiles[1551]: ACLs are not supported, ignoring.
May 27 17:44:30.011502 systemd[1]: Finished systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev.
May 27 17:44:30.498266 kernel: squashfs: version 4.0 (2009/01/31) Phillip Lougher
May 27 17:44:30.572079 kernel: loop1: detected capacity change from 0 to 28496
May 27 17:44:31.138070 kernel: loop2: detected capacity change from 0 to 113872
May 27 17:44:31.172576 systemd[1]: Finished systemd-hwdb-update.service - Rebuild Hardware Database.
May 27 17:44:31.180310 systemd[1]: Starting systemd-udevd.service - Rule-based Manager for Device Events and Files...
May 27 17:44:31.220441 systemd-udevd[1559]: Using default interface naming scheme 'v255'.
May 27 17:44:31.368377 systemd[1]: Started systemd-udevd.service - Rule-based Manager for Device Events and Files.
May 27 17:44:31.381242 systemd[1]: Starting systemd-networkd.service - Network Configuration...
May 27 17:44:31.433645 systemd[1]: Condition check resulted in dev-ttyS0.device - /dev/ttyS0 being skipped.
May 27 17:44:31.460066 kernel: hv_vmbus: registering driver hyperv_fb
May 27 17:44:31.473480 kernel: hyperv_fb: Synthvid Version major 3, minor 5
May 27 17:44:31.473569 kernel: hyperv_fb: Screen resolution: 1024x768, Color depth: 32, Frame buffer size: 8388608
May 27 17:44:31.473605 kernel: Console: switching to colour dummy device 80x25
May 27 17:44:31.473247 systemd[1]: Starting systemd-userdbd.service - User Database Manager...
May 27 17:44:31.477620 kernel: Console: switching to colour frame buffer device 128x48
May 27 17:44:31.491059 kernel: hv_vmbus: registering driver hv_balloon
May 27 17:44:31.497060 kernel: hv_balloon: Using Dynamic Memory protocol version 2.0
May 27 17:44:31.502148 kernel: mousedev: PS/2 mouse device common for all mice
May 27 17:44:31.534261 systemd[1]: Starting systemd-vconsole-setup.service - Virtual Console Setup...
May 27 17:44:31.544063 kernel: EDAC MC: Ver: 3.0.0
May 27 17:44:31.546602 systemd[1]: Started systemd-userdbd.service - User Database Manager.
May 27 17:44:31.552557 systemd[1]: systemd-vconsole-setup.service: Deactivated successfully.
May 27 17:44:31.552801 systemd[1]: Stopped systemd-vconsole-setup.service - Virtual Console Setup.
May 27 17:44:31.558650 systemd[1]: Starting systemd-vconsole-setup.service - Virtual Console Setup...
May 27 17:44:31.679096 kernel: loop3: detected capacity change from 0 to 146240
May 27 17:44:31.689450 systemd-networkd[1585]: lo: Link UP
May 27 17:44:31.689459 systemd-networkd[1585]: lo: Gained carrier
May 27 17:44:31.690792 systemd-networkd[1585]: Enumeration completed
May 27 17:44:31.690901 systemd[1]: Started systemd-networkd.service - Network Configuration.
May 27 17:44:31.691199 systemd-networkd[1585]: eth0: found matching network '/usr/lib/systemd/network/zz-default.network', based on potentially unpredictable interface name.
May 27 17:44:31.691209 systemd-networkd[1585]: eth0: Configuring with /usr/lib/systemd/network/zz-default.network.
May 27 17:44:31.691749 systemd-networkd[1585]: eth0: Link UP
May 27 17:44:31.691758 systemd-networkd[1585]: eth0: Gained carrier
May 27 17:44:31.691772 systemd-networkd[1585]: eth0: found matching network '/usr/lib/systemd/network/zz-default.network', based on potentially unpredictable interface name.
May 27 17:44:31.693059 kernel: loop4: detected capacity change from 0 to 28496
May 27 17:44:31.698026 systemd[1]: Starting systemd-networkd-persistent-storage.service - Enable Persistent Storage in systemd-networkd...
May 27 17:44:31.705061 kernel: loop5: detected capacity change from 0 to 113872
May 27 17:44:31.709441 systemd[1]: Starting systemd-networkd-wait-online.service - Wait for Network to be Configured...
May 27 17:44:31.715709 (sd-merge)[1643]: Using extensions 'containerd-flatcar', 'docker-flatcar', 'oem-azure'.
May 27 17:44:31.716204 (sd-merge)[1643]: Merged extensions into '/usr'.
May 27 17:44:31.719002 systemd[1]: Finished systemd-sysext.service - Merge System Extension Images into /usr/ and /opt/.
May 27 17:44:31.721398 systemd[1]: Starting ensure-sysext.service...
May 27 17:44:31.725214 systemd[1]: Starting systemd-tmpfiles-setup.service - Create System Files and Directories...
May 27 17:44:31.732330 systemd[1]: Reload requested from client PID 1647 ('systemctl') (unit ensure-sysext.service)...
May 27 17:44:31.732354 systemd[1]: Reloading...
May 27 17:44:31.740246 systemd-networkd[1585]: eth0: DHCPv4 address 10.200.8.11/24, gateway 10.200.8.1 acquired from 168.63.129.16
May 27 17:44:31.755862 systemd-tmpfiles[1648]: /usr/lib/tmpfiles.d/nfs-utils.conf:6: Duplicate line for path "/var/lib/nfs/sm", ignoring.
May 27 17:44:31.755907 systemd-tmpfiles[1648]: /usr/lib/tmpfiles.d/nfs-utils.conf:7: Duplicate line for path "/var/lib/nfs/sm.bak", ignoring.
May 27 17:44:31.756238 systemd-tmpfiles[1648]: /usr/lib/tmpfiles.d/provision.conf:20: Duplicate line for path "/root", ignoring.
May 27 17:44:31.756522 systemd-tmpfiles[1648]: /usr/lib/tmpfiles.d/systemd-flatcar.conf:6: Duplicate line for path "/var/log/journal", ignoring.
May 27 17:44:31.758816 systemd-tmpfiles[1648]: /usr/lib/tmpfiles.d/systemd.conf:29: Duplicate line for path "/var/lib/systemd", ignoring.
May 27 17:44:31.759183 systemd-tmpfiles[1648]: ACLs are not supported, ignoring.
May 27 17:44:31.759245 systemd-tmpfiles[1648]: ACLs are not supported, ignoring.
May 27 17:44:31.786077 zram_generator::config[1724]: No configuration found.
May 27 17:44:31.836992 systemd-tmpfiles[1648]: Detected autofs mount point /boot during canonicalization of boot.
May 27 17:44:31.837008 systemd-tmpfiles[1648]: Skipping /boot
May 27 17:44:31.849147 systemd-tmpfiles[1648]: Detected autofs mount point /boot during canonicalization of boot.
May 27 17:44:31.849163 systemd-tmpfiles[1648]: Skipping /boot
May 27 17:44:31.918460 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 17:44:32.075285 systemd[1]: Found device dev-disk-by\x2dlabel-OEM.device - Virtual_Disk OEM.
May 27 17:44:32.080392 systemd[1]: Reloading finished in 347 ms.
May 27 17:44:32.114227 systemd[1]: Finished systemd-vconsole-setup.service - Virtual Console Setup.
May 27 17:44:32.119322 systemd[1]: Finished systemd-networkd-persistent-storage.service - Enable Persistent Storage in systemd-networkd.
May 27 17:44:32.147258 systemd[1]: Finished systemd-tmpfiles-setup.service - Create System Files and Directories.
May 27 17:44:32.196032 systemd[1]: proc-xen.mount - /proc/xen was skipped because of an unmet condition check (ConditionVirtualization=xen).
May 27 17:44:32.197408 systemd[1]: Starting audit-rules.service - Load Audit Rules...
May 27 17:44:32.222990 systemd[1]: Starting clean-ca-certificates.service - Clean up broken links in /etc/ssl/certs...
May 27 17:44:32.227797 systemd[1]: ignition-delete-config.service - Ignition (delete config) was skipped because no trigger condition checks were met.
May 27 17:44:32.228930 systemd[1]: Starting modprobe@dm_mod.service - Load Kernel Module dm_mod...
May 27 17:44:32.234137 systemd[1]: Starting modprobe@drm.service - Load Kernel Module drm...
May 27 17:44:32.239211 systemd[1]: Starting modprobe@efi_pstore.service - Load Kernel Module efi_pstore...
May 27 17:44:32.244978 systemd[1]: Starting modprobe@loop.service - Load Kernel Module loop...
May 27 17:44:32.250751 systemd[1]: systemd-binfmt.service - Set Up Additional Binary Formats was skipped because no trigger condition checks were met.
May 27 17:44:32.251834 systemd[1]: Starting systemd-fsck@dev-disk-by\x2dlabel-OEM.service - File System Check on /dev/disk/by-label/OEM...
May 27 17:44:32.256597 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 17:44:32.257858 systemd[1]: Starting systemd-journal-catalog-update.service - Rebuild Journal Catalog...
May 27 17:44:32.264475 systemd[1]: Starting systemd-resolved.service - Network Name Resolution...
May 27 17:44:32.268806 systemd[1]: Reached target time-set.target - System Time Set.
May 27 17:44:32.274182 systemd[1]: Starting systemd-update-utmp.service - Record System Boot/Shutdown in UTMP...
May 27 17:44:32.278719 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 17:44:32.281851 systemd[1]: modprobe@dm_mod.service: Deactivated successfully.
May 27 17:44:32.282055 systemd[1]: Finished modprobe@dm_mod.service - Load Kernel Module dm_mod.
May 27 17:44:32.287020 systemd[1]: modprobe@drm.service: Deactivated successfully.
May 27 17:44:32.287230 systemd[1]: Finished modprobe@drm.service - Load Kernel Module drm.
May 27 17:44:32.291942 systemd[1]: modprobe@efi_pstore.service: Deactivated successfully.
May 27 17:44:32.292133 systemd[1]: Finished modprobe@efi_pstore.service - Load Kernel Module efi_pstore.
May 27 17:44:32.297535 systemd[1]: modprobe@loop.service: Deactivated successfully.
May 27 17:44:32.297710 systemd[1]: Finished modprobe@loop.service - Load Kernel Module loop.
May 27 17:44:32.304512 systemd[1]: Finished ensure-sysext.service.
May 27 17:44:32.310262 systemd[1]: systemd-pstore.service - Platform Persistent Storage Archival was skipped because of an unmet condition check (ConditionDirectoryNotEmpty=/sys/fs/pstore).
May 27 17:44:32.310386 systemd[1]: systemd-repart.service - Repartition Root Disk was skipped because no trigger condition checks were met.
May 27 17:44:32.315188 systemd[1]: Finished systemd-update-utmp.service - Record System Boot/Shutdown in UTMP.
May 27 17:44:32.339163 systemd[1]: Finished systemd-fsck@dev-disk-by\x2dlabel-OEM.service - File System Check on /dev/disk/by-label/OEM.
May 27 17:44:32.392560 systemd[1]: Finished systemd-journal-catalog-update.service - Rebuild Journal Catalog.
May 27 17:44:32.419300 systemd-resolved[1818]: Positive Trust Anchors:
May 27 17:44:32.419317 systemd-resolved[1818]: . IN DS 20326 8 2 e06d44b80b8f1d39a95c0b0d7c65d08458e880409bbc683457104237c7f8ec8d
May 27 17:44:32.419350 systemd-resolved[1818]: 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 17:44:32.421862 augenrules[1848]: No rules
May 27 17:44:32.423198 systemd[1]: audit-rules.service: Deactivated successfully.
May 27 17:44:32.423451 systemd[1]: Finished audit-rules.service - Load Audit Rules.
May 27 17:44:32.423699 systemd-resolved[1818]: Using system hostname 'ci-4344.0.0-a-13e6b84161'.
May 27 17:44:32.427934 systemd[1]: Started systemd-resolved.service - Network Name Resolution.
May 27 17:44:32.432916 systemd[1]: Reached target network.target - Network.
May 27 17:44:32.436793 systemd[1]: Reached target nss-lookup.target - Host and Network Name Lookups.
May 27 17:44:32.862893 systemd[1]: Finished clean-ca-certificates.service - Clean up broken links in /etc/ssl/certs.
May 27 17:44:32.868629 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 17:44:33.738194 systemd-networkd[1585]: eth0: Gained IPv6LL
May 27 17:44:33.740919 systemd[1]: Finished systemd-networkd-wait-online.service - Wait for Network to be Configured.
May 27 17:44:33.746443 systemd[1]: Reached target network-online.target - Network is Online.
May 27 17:44:37.136282 ldconfig[1531]: /sbin/ldconfig: /usr/lib/ld.so.conf is not an ELF file - it has the wrong magic bytes at the start.
May 27 17:44:37.148133 systemd[1]: Finished ldconfig.service - Rebuild Dynamic Linker Cache.
May 27 17:44:37.154935 systemd[1]: Starting systemd-update-done.service - Update is Completed...
May 27 17:44:37.191903 systemd[1]: Finished systemd-update-done.service - Update is Completed.
May 27 17:44:37.196743 systemd[1]: Reached target sysinit.target - System Initialization.
May 27 17:44:37.201131 systemd[1]: Started motdgen.path - Watch for update engine configuration changes.
May 27 17:44:37.206299 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 17:44:37.211594 systemd[1]: Started google-oslogin-cache.timer - NSS cache refresh timer.
May 27 17:44:37.216610 systemd[1]: Started logrotate.timer - Daily rotation of log files.
May 27 17:44:37.221123 systemd[1]: Started mdadm.timer - Weekly check for MD array's redundancy information..
May 27 17:44:37.226430 systemd[1]: Started systemd-tmpfiles-clean.timer - Daily Cleanup of Temporary Directories.
May 27 17:44:37.231338 systemd[1]: update-engine-stub.timer - Update Engine Stub Timer was skipped because of an unmet condition check (ConditionPathExists=/usr/.noupdate).
May 27 17:44:37.231380 systemd[1]: Reached target paths.target - Path Units.
May 27 17:44:37.234992 systemd[1]: Reached target timers.target - Timer Units.
May 27 17:44:37.239797 systemd[1]: Listening on dbus.socket - D-Bus System Message Bus Socket.
May 27 17:44:37.245322 systemd[1]: Starting docker.socket - Docker Socket for the API...
May 27 17:44:37.251936 systemd[1]: Listening on sshd-unix-local.socket - OpenSSH Server Socket (systemd-ssh-generator, AF_UNIX Local).
May 27 17:44:37.257100 systemd[1]: Listening on sshd-vsock.socket - OpenSSH Server Socket (systemd-ssh-generator, AF_VSOCK).
May 27 17:44:37.262080 systemd[1]: Reached target ssh-access.target - SSH Access Available.
May 27 17:44:37.268105 systemd[1]: Listening on sshd.socket - OpenSSH Server Socket.
May 27 17:44:37.272519 systemd[1]: Listening on systemd-hostnamed.socket - Hostname Service Socket.
May 27 17:44:37.277769 systemd[1]: Listening on docker.socket - Docker Socket for the API.
May 27 17:44:37.283585 systemd[1]: Reached target sockets.target - Socket Units.
May 27 17:44:37.287443 systemd[1]: Reached target basic.target - Basic System.
May 27 17:44:37.291191 systemd[1]: addon-config@oem.service - Configure Addon /oem was skipped because no trigger condition checks were met.
May 27 17:44:37.291223 systemd[1]: addon-run@oem.service - Run Addon /oem was skipped because no trigger condition checks were met.
May 27 17:44:37.293719 systemd[1]: Starting chronyd.service - NTP client/server...
May 27 17:44:37.297988 systemd[1]: Starting containerd.service - containerd container runtime...
May 27 17:44:37.305277 systemd[1]: Starting coreos-metadata.service - Flatcar Metadata Agent...
May 27 17:44:37.310240 systemd[1]: Starting dbus.service - D-Bus System Message Bus...
May 27 17:44:37.315023 systemd[1]: Starting dracut-shutdown.service - Restore /run/initramfs on shutdown...
May 27 17:44:37.320620 systemd[1]: Starting enable-oem-cloudinit.service - Enable cloudinit...
May 27 17:44:37.325543 systemd[1]: Starting extend-filesystems.service - Extend Filesystems...
May 27 17:44:37.329716 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 17:44:37.330743 systemd[1]: Starting google-oslogin-cache.service - NSS cache refresh...
May 27 17:44:37.334770 systemd[1]: hv_fcopy_uio_daemon.service - Hyper-V FCOPY UIO daemon was skipped because of an unmet condition check (ConditionPathExists=/sys/bus/vmbus/devices/eb765408-105f-49b6-b4aa-c123b64d17d4/uio).
May 27 17:44:37.334889 jq[1869]: false
May 27 17:44:37.335772 systemd[1]: Started hv_kvp_daemon.service - Hyper-V KVP daemon.
May 27 17:44:37.339984 systemd[1]: hv_vss_daemon.service - Hyper-V VSS daemon was skipped because of an unmet condition check (ConditionPathExists=/dev/vmbus/hv_vss).
May 27 17:44:37.342175 systemd[1]: Starting motdgen.service - Generate /run/flatcar/motd...
May 27 17:44:37.342648 KVP[1873]: KVP starting; pid is:1873
May 27 17:44:37.347084 KVP[1873]: KVP LIC Version: 3.1
May 27 17:44:37.348098 kernel: hv_utils: KVP IC version 4.0
May 27 17:44:37.349432 systemd[1]: Starting nvidia.service - NVIDIA Configure Service...
May 27 17:44:37.349638 (chronyd)[1861]: chronyd.service: Referenced but unset environment variable evaluates to an empty string: OPTIONS
May 27 17:44:37.354654 systemd[1]: Starting ssh-key-proc-cmdline.service - Install an ssh key from /proc/cmdline...
May 27 17:44:37.359256 chronyd[1880]: chronyd version 4.6.1 starting (+CMDMON +NTP +REFCLOCK +RTC +PRIVDROP +SCFILTER -SIGND +ASYNCDNS +NTS +SECHASH +IPV6 -DEBUG)
May 27 17:44:37.360888 systemd[1]: Starting sshd-keygen.service - Generate sshd host keys...
May 27 17:44:37.367657 systemd[1]: Starting systemd-logind.service - User Login Management...
May 27 17:44:37.372985 systemd[1]: tcsd.service - TCG Core Services Daemon was skipped because of an unmet condition check (ConditionPathExists=/dev/tpm0).
May 27 17:44:37.373461 systemd[1]: cgroup compatibility translation between legacy and unified hierarchy settings activated. See cgroup-compat debug messages for details.
May 27 17:44:37.375095 systemd[1]: Starting update-engine.service - Update Engine...
May 27 17:44:37.379877 systemd[1]: Starting update-ssh-keys-after-ignition.service - Run update-ssh-keys once after Ignition...
May 27 17:44:37.381144 extend-filesystems[1870]: Found loop3
May 27 17:44:37.386338 systemd[1]: Finished dracut-shutdown.service - Restore /run/initramfs on shutdown.
May 27 17:44:37.387163 extend-filesystems[1870]: Found loop4
May 27 17:44:37.387163 extend-filesystems[1870]: Found loop5
May 27 17:44:37.387163 extend-filesystems[1870]: Found sda
May 27 17:44:37.387163 extend-filesystems[1870]: Found sda1
May 27 17:44:37.387163 extend-filesystems[1870]: Found sdb
May 27 17:44:37.387163 extend-filesystems[1870]: Found sdb1
May 27 17:44:37.387163 extend-filesystems[1870]: Found sdb2
May 27 17:44:37.387163 extend-filesystems[1870]: Found sdb3
May 27 17:44:37.387163 extend-filesystems[1870]: Found usr
May 27 17:44:37.387163 extend-filesystems[1870]: Found sdb4
May 27 17:44:37.387163 extend-filesystems[1870]: Found sdb6
May 27 17:44:37.387163 extend-filesystems[1870]: Found sdb7
May 27 17:44:37.387163 extend-filesystems[1870]: Found sdb9
May 27 17:44:37.387163 extend-filesystems[1870]: Checking size of /dev/sdb9
May 27 17:44:37.442796 jq[1889]: true
May 27 17:44:37.392165 systemd[1]: enable-oem-cloudinit.service: Skipped due to 'exec-condition'.
May 27 17:44:37.443114 google_oslogin_nss_cache[1871]: oslogin_cache_refresh[1871]: Refreshing passwd entry cache
May 27 17:44:37.443114 google_oslogin_nss_cache[1871]: oslogin_cache_refresh[1871]: Failure getting users, quitting
May 27 17:44:37.443114 google_oslogin_nss_cache[1871]: oslogin_cache_refresh[1871]: Produced empty passwd cache file, removing /etc/oslogin_passwd.cache.bak.
May 27 17:44:37.443114 google_oslogin_nss_cache[1871]: oslogin_cache_refresh[1871]: Refreshing group entry cache
May 27 17:44:37.443114 google_oslogin_nss_cache[1871]: oslogin_cache_refresh[1871]: Failure getting groups, quitting
May 27 17:44:37.443114 google_oslogin_nss_cache[1871]: oslogin_cache_refresh[1871]: Produced empty group cache file, removing /etc/oslogin_group.cache.bak.
May 27 17:44:37.401748 oslogin_cache_refresh[1871]: Refreshing passwd entry cache
May 27 17:44:37.392382 systemd[1]: Condition check resulted in enable-oem-cloudinit.service - Enable cloudinit being skipped.
May 27 17:44:37.422340 oslogin_cache_refresh[1871]: Failure getting users, quitting
May 27 17:44:37.392688 systemd[1]: motdgen.service: Deactivated successfully.
May 27 17:44:37.422360 oslogin_cache_refresh[1871]: Produced empty passwd cache file, removing /etc/oslogin_passwd.cache.bak.
May 27 17:44:37.392884 systemd[1]: Finished motdgen.service - Generate /run/flatcar/motd.
May 27 17:44:37.422412 oslogin_cache_refresh[1871]: Refreshing group entry cache
May 27 17:44:37.443999 jq[1894]: true
May 27 17:44:37.399009 systemd[1]: ssh-key-proc-cmdline.service: Deactivated successfully.
May 27 17:44:37.427181 oslogin_cache_refresh[1871]: Failure getting groups, quitting
May 27 17:44:37.399225 systemd[1]: Finished ssh-key-proc-cmdline.service - Install an ssh key from /proc/cmdline.
May 27 17:44:37.427191 oslogin_cache_refresh[1871]: Produced empty group cache file, removing /etc/oslogin_group.cache.bak.
May 27 17:44:37.427596 (ntainerd)[1895]: containerd.service: Referenced but unset environment variable evaluates to an empty string: TORCX_IMAGEDIR, TORCX_UNPACKDIR
May 27 17:44:37.439116 chronyd[1880]: Timezone right/UTC failed leap second check, ignoring
May 27 17:44:37.428300 systemd[1]: google-oslogin-cache.service: Deactivated successfully.
May 27 17:44:37.439365 chronyd[1880]: Loaded seccomp filter (level 2)
May 27 17:44:37.428550 systemd[1]: Finished google-oslogin-cache.service - NSS cache refresh.
May 27 17:44:37.440205 systemd[1]: Started chronyd.service - NTP client/server.
May 27 17:44:37.446471 extend-filesystems[1870]: Old size kept for /dev/sdb9
May 27 17:44:37.449940 extend-filesystems[1870]: Found sr0
May 27 17:44:37.447160 systemd[1]: extend-filesystems.service: Deactivated successfully.
May 27 17:44:37.447385 systemd[1]: Finished extend-filesystems.service - Extend Filesystems.
May 27 17:44:37.476925 update_engine[1888]: I20250527 17:44:37.476837  1888 main.cc:92] Flatcar Update Engine starting
May 27 17:44:37.519927 systemd-logind[1886]: New seat seat0.
May 27 17:44:37.523446 systemd-logind[1886]: Watching system buttons on /dev/input/event0 (AT Translated Set 2 keyboard)
May 27 17:44:37.525953 systemd[1]: Started systemd-logind.service - User Login Management.
May 27 17:44:37.600802 bash[1928]: Updated "/home/core/.ssh/authorized_keys"
May 27 17:44:37.602661 systemd[1]: Finished update-ssh-keys-after-ignition.service - Run update-ssh-keys once after Ignition.
May 27 17:44:37.608500 systemd[1]: sshkeys.service was skipped because no trigger condition checks were met.
May 27 17:44:37.630026 dbus-daemon[1864]: [system] SELinux support is enabled
May 27 17:44:37.630268 systemd[1]: Started dbus.service - D-Bus System Message Bus.
May 27 17:44:37.632970 update_engine[1888]: I20250527 17:44:37.632918  1888 update_check_scheduler.cc:74] Next update check in 3m0s
May 27 17:44:37.637020 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 17:44:37.637067 systemd[1]: Reached target system-config.target - Load system-provided cloud configs.
May 27 17:44:37.637843 dbus-daemon[1864]: [system] Successfully activated service 'org.freedesktop.systemd1'
May 27 17:44:37.643038 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 17:44:37.643081 systemd[1]: Reached target user-config.target - Load user-provided cloud configs.
May 27 17:44:37.648479 systemd[1]: Started update-engine.service - Update Engine.
May 27 17:44:37.654563 systemd[1]: Started locksmithd.service - Cluster reboot manager.
May 27 17:44:37.691977 setup-nvidia[1876]: Downloading Flatcar Container Linux Developer Container for version: 4344.0.0
May 27 17:44:37.726184 coreos-metadata[1863]: May 27 17:44:37.726 INFO Fetching http://168.63.129.16/?comp=versions: Attempt #1
May 27 17:44:37.728519 coreos-metadata[1863]: May 27 17:44:37.728 INFO Fetch successful
May 27 17:44:37.728687 coreos-metadata[1863]: May 27 17:44:37.728 INFO Fetching http://168.63.129.16/machine/?comp=goalstate: Attempt #1
May 27 17:44:37.732126 coreos-metadata[1863]: May 27 17:44:37.732 INFO Fetch successful
May 27 17:44:37.732472 coreos-metadata[1863]: May 27 17:44:37.732 INFO Fetching http://168.63.129.16/machine/986040ec-537d-4332-a43f-cd817337e587/ac42edb1%2D0afa%2D420d%2Dae1e%2Dfd285fd8a2d5.%5Fci%2D4344.0.0%2Da%2D13e6b84161?comp=config&type=sharedConfig&incarnation=1: Attempt #1
May 27 17:44:37.733933 coreos-metadata[1863]: May 27 17:44:37.733 INFO Fetch successful
May 27 17:44:37.734084 coreos-metadata[1863]: May 27 17:44:37.734 INFO Fetching http://169.254.169.254/metadata/instance/compute/vmSize?api-version=2017-08-01&format=text: Attempt #1
May 27 17:44:37.741126 coreos-metadata[1863]: May 27 17:44:37.741 INFO Fetch successful
May 27 17:44:37.767783 systemd[1]: Finished coreos-metadata.service - Flatcar Metadata Agent.
May 27 17:44:37.772659 systemd[1]: packet-phone-home.service - Report Success to Packet was skipped because no trigger condition checks were met.
May 27 17:44:37.903669 locksmithd[1997]: locksmithd starting currentOperation="UPDATE_STATUS_IDLE" strategy="reboot"
May 27 17:44:37.936260 sshd_keygen[1901]: ssh-keygen: generating new host keys: RSA ECDSA ED25519
May 27 17:44:37.959661 systemd[1]: Finished sshd-keygen.service - Generate sshd host keys.
May 27 17:44:37.965845 systemd[1]: Starting issuegen.service - Generate /run/issue...
May 27 17:44:37.984330 systemd[1]: Starting waagent.service - Microsoft Azure Linux Agent...
May 27 17:44:37.990617 systemd[1]: issuegen.service: Deactivated successfully.
May 27 17:44:37.990843 systemd[1]: Finished issuegen.service - Generate /run/issue.
May 27 17:44:37.997813 systemd[1]: Starting systemd-user-sessions.service - Permit User Sessions...
May 27 17:44:38.007419 systemd[1]: Started waagent.service - Microsoft Azure Linux Agent.
May 27 17:44:38.012176 systemd[1]: Finished systemd-user-sessions.service - Permit User Sessions.
May 27 17:44:38.019652 systemd[1]: Started getty@tty1.service - Getty on tty1.
May 27 17:44:38.024767 systemd[1]: Started serial-getty@ttyS0.service - Serial Getty on ttyS0.
May 27 17:44:38.029473 systemd[1]: Reached target getty.target - Login Prompts.
May 27 17:44:38.708866 containerd[1895]: time="2025-05-27T17:44:38Z" 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 17:44:38.709521 containerd[1895]: time="2025-05-27T17:44:38.709486500Z" level=info msg="starting containerd" revision=06b99ca80cdbfbc6cc8bd567021738c9af2b36ce version=v2.0.4
May 27 17:44:38.717027 containerd[1895]: time="2025-05-27T17:44:38.716995600Z" level=warning msg="Configuration migrated from version 2, use `containerd config migrate` to avoid migration" t="8.6µs"
May 27 17:44:38.717027 containerd[1895]: time="2025-05-27T17:44:38.717022700Z" level=info msg="loading plugin" id=io.containerd.image-verifier.v1.bindir type=io.containerd.image-verifier.v1
May 27 17:44:38.717124 containerd[1895]: time="2025-05-27T17:44:38.717056500Z" level=info msg="loading plugin" id=io.containerd.internal.v1.opt type=io.containerd.internal.v1
May 27 17:44:38.717217 containerd[1895]: time="2025-05-27T17:44:38.717194500Z" level=info msg="loading plugin" id=io.containerd.warning.v1.deprecations type=io.containerd.warning.v1
May 27 17:44:38.717251 containerd[1895]: time="2025-05-27T17:44:38.717218100Z" level=info msg="loading plugin" id=io.containerd.content.v1.content type=io.containerd.content.v1
May 27 17:44:38.717251 containerd[1895]: time="2025-05-27T17:44:38.717244000Z" level=info msg="loading plugin" id=io.containerd.snapshotter.v1.blockfile type=io.containerd.snapshotter.v1
May 27 17:44:38.717340 containerd[1895]: time="2025-05-27T17:44:38.717317400Z" 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 17:44:38.717340 containerd[1895]: time="2025-05-27T17:44:38.717336700Z" level=info msg="loading plugin" id=io.containerd.snapshotter.v1.btrfs type=io.containerd.snapshotter.v1
May 27 17:44:38.717561 containerd[1895]: time="2025-05-27T17:44:38.717539700Z" 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 17:44:38.717589 containerd[1895]: time="2025-05-27T17:44:38.717559200Z" level=info msg="loading plugin" id=io.containerd.snapshotter.v1.devmapper type=io.containerd.snapshotter.v1
May 27 17:44:38.717589 containerd[1895]: time="2025-05-27T17:44:38.717570900Z" 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 17:44:38.717589 containerd[1895]: time="2025-05-27T17:44:38.717579200Z" level=info msg="loading plugin" id=io.containerd.snapshotter.v1.native type=io.containerd.snapshotter.v1
May 27 17:44:38.717688 containerd[1895]: time="2025-05-27T17:44:38.717668100Z" level=info msg="loading plugin" id=io.containerd.snapshotter.v1.overlayfs type=io.containerd.snapshotter.v1
May 27 17:44:38.717936 containerd[1895]: time="2025-05-27T17:44:38.717915200Z" level=info msg="loading plugin" id=io.containerd.snapshotter.v1.zfs type=io.containerd.snapshotter.v1
May 27 17:44:38.717964 containerd[1895]: time="2025-05-27T17:44:38.717952300Z" 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 17:44:38.717996 containerd[1895]: time="2025-05-27T17:44:38.717963300Z" level=info msg="loading plugin" id=io.containerd.event.v1.exchange type=io.containerd.event.v1
May 27 17:44:38.718019 containerd[1895]: time="2025-05-27T17:44:38.717992900Z" level=info msg="loading plugin" id=io.containerd.monitor.task.v1.cgroups type=io.containerd.monitor.task.v1
May 27 17:44:38.718750 containerd[1895]: time="2025-05-27T17:44:38.718715100Z" level=info msg="loading plugin" id=io.containerd.metadata.v1.bolt type=io.containerd.metadata.v1
May 27 17:44:38.718821 containerd[1895]: time="2025-05-27T17:44:38.718806100Z" level=info msg="metadata content store policy set" policy=shared
May 27 17:44:38.737088 containerd[1895]: time="2025-05-27T17:44:38.737029800Z" level=info msg="loading plugin" id=io.containerd.gc.v1.scheduler type=io.containerd.gc.v1
May 27 17:44:38.737176 containerd[1895]: time="2025-05-27T17:44:38.737100800Z" level=info msg="loading plugin" id=io.containerd.differ.v1.walking type=io.containerd.differ.v1
May 27 17:44:38.737176 containerd[1895]: time="2025-05-27T17:44:38.737119300Z" level=info msg="loading plugin" id=io.containerd.lease.v1.manager type=io.containerd.lease.v1
May 27 17:44:38.737176 containerd[1895]: time="2025-05-27T17:44:38.737132300Z" level=info msg="loading plugin" id=io.containerd.service.v1.containers-service type=io.containerd.service.v1
May 27 17:44:38.737176 containerd[1895]: time="2025-05-27T17:44:38.737145800Z" level=info msg="loading plugin" id=io.containerd.service.v1.content-service type=io.containerd.service.v1
May 27 17:44:38.737176 containerd[1895]: time="2025-05-27T17:44:38.737157600Z" level=info msg="loading plugin" id=io.containerd.service.v1.diff-service type=io.containerd.service.v1
May 27 17:44:38.737176 containerd[1895]: time="2025-05-27T17:44:38.737171200Z" level=info msg="loading plugin" id=io.containerd.service.v1.images-service type=io.containerd.service.v1
May 27 17:44:38.737311 containerd[1895]: time="2025-05-27T17:44:38.737184200Z" level=info msg="loading plugin" id=io.containerd.service.v1.introspection-service type=io.containerd.service.v1
May 27 17:44:38.737311 containerd[1895]: time="2025-05-27T17:44:38.737198300Z" level=info msg="loading plugin" id=io.containerd.service.v1.namespaces-service type=io.containerd.service.v1
May 27 17:44:38.737311 containerd[1895]: time="2025-05-27T17:44:38.737209100Z" level=info msg="loading plugin" id=io.containerd.service.v1.snapshots-service type=io.containerd.service.v1
May 27 17:44:38.737311 containerd[1895]: time="2025-05-27T17:44:38.737218300Z" level=info msg="loading plugin" id=io.containerd.shim.v1.manager type=io.containerd.shim.v1
May 27 17:44:38.737311 containerd[1895]: time="2025-05-27T17:44:38.737231600Z" level=info msg="loading plugin" id=io.containerd.runtime.v2.task type=io.containerd.runtime.v2
May 27 17:44:38.737416 containerd[1895]: time="2025-05-27T17:44:38.737358300Z" level=info msg="loading plugin" id=io.containerd.service.v1.tasks-service type=io.containerd.service.v1
May 27 17:44:38.737416 containerd[1895]: time="2025-05-27T17:44:38.737381000Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.containers type=io.containerd.grpc.v1
May 27 17:44:38.737416 containerd[1895]: time="2025-05-27T17:44:38.737396400Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.content type=io.containerd.grpc.v1
May 27 17:44:38.737416 containerd[1895]: time="2025-05-27T17:44:38.737407600Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.diff type=io.containerd.grpc.v1
May 27 17:44:38.737500 containerd[1895]: time="2025-05-27T17:44:38.737434200Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.events type=io.containerd.grpc.v1
May 27 17:44:38.737500 containerd[1895]: time="2025-05-27T17:44:38.737448700Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.images type=io.containerd.grpc.v1
May 27 17:44:38.737500 containerd[1895]: time="2025-05-27T17:44:38.737460800Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.introspection type=io.containerd.grpc.v1
May 27 17:44:38.737500 containerd[1895]: time="2025-05-27T17:44:38.737472900Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.leases type=io.containerd.grpc.v1
May 27 17:44:38.737500 containerd[1895]: time="2025-05-27T17:44:38.737485200Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.namespaces type=io.containerd.grpc.v1
May 27 17:44:38.737500 containerd[1895]: time="2025-05-27T17:44:38.737497500Z" level=info msg="loading plugin" id=io.containerd.sandbox.store.v1.local type=io.containerd.sandbox.store.v1
May 27 17:44:38.737631 containerd[1895]: time="2025-05-27T17:44:38.737508200Z" level=info msg="loading plugin" id=io.containerd.cri.v1.images type=io.containerd.cri.v1
May 27 17:44:38.737631 containerd[1895]: time="2025-05-27T17:44:38.737571300Z" level=info msg="Get image filesystem path \"/var/lib/containerd/io.containerd.snapshotter.v1.overlayfs\" for snapshotter \"overlayfs\""
May 27 17:44:38.737631 containerd[1895]: time="2025-05-27T17:44:38.737586400Z" level=info msg="Start snapshots syncer"
May 27 17:44:38.737631 containerd[1895]: time="2025-05-27T17:44:38.737615400Z" level=info msg="loading plugin" id=io.containerd.cri.v1.runtime type=io.containerd.cri.v1
May 27 17:44:38.737888 containerd[1895]: time="2025-05-27T17:44:38.737847400Z" 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 17:44:38.738000 containerd[1895]: time="2025-05-27T17:44:38.737899400Z" level=info msg="loading plugin" id=io.containerd.podsandbox.controller.v1.podsandbox type=io.containerd.podsandbox.controller.v1
May 27 17:44:38.738033 containerd[1895]: time="2025-05-27T17:44:38.738010200Z" level=info msg="loading plugin" id=io.containerd.sandbox.controller.v1.shim type=io.containerd.sandbox.controller.v1
May 27 17:44:38.738160 containerd[1895]: time="2025-05-27T17:44:38.738136300Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.sandbox-controllers type=io.containerd.grpc.v1
May 27 17:44:38.738197 containerd[1895]: time="2025-05-27T17:44:38.738167500Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.sandboxes type=io.containerd.grpc.v1
May 27 17:44:38.738197 containerd[1895]: time="2025-05-27T17:44:38.738179600Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.snapshots type=io.containerd.grpc.v1
May 27 17:44:38.738197 containerd[1895]: time="2025-05-27T17:44:38.738190500Z" level=info msg="loading plugin" id=io.containerd.streaming.v1.manager type=io.containerd.streaming.v1
May 27 17:44:38.738263 containerd[1895]: time="2025-05-27T17:44:38.738201900Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.streaming type=io.containerd.grpc.v1
May 27 17:44:38.738263 containerd[1895]: time="2025-05-27T17:44:38.738213600Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.tasks type=io.containerd.grpc.v1
May 27 17:44:38.738263 containerd[1895]: time="2025-05-27T17:44:38.738224400Z" level=info msg="loading plugin" id=io.containerd.transfer.v1.local type=io.containerd.transfer.v1
May 27 17:44:38.738336 containerd[1895]: time="2025-05-27T17:44:38.738252600Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.transfer type=io.containerd.grpc.v1
May 27 17:44:38.738336 containerd[1895]: time="2025-05-27T17:44:38.738289400Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.version type=io.containerd.grpc.v1
May 27 17:44:38.738336 containerd[1895]: time="2025-05-27T17:44:38.738303300Z" level=info msg="loading plugin" id=io.containerd.monitor.container.v1.restart type=io.containerd.monitor.container.v1
May 27 17:44:38.738336 containerd[1895]: time="2025-05-27T17:44:38.738331300Z" level=info msg="loading plugin" id=io.containerd.tracing.processor.v1.otlp type=io.containerd.tracing.processor.v1
May 27 17:44:38.738425 containerd[1895]: time="2025-05-27T17:44:38.738347000Z" 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 17:44:38.738425 containerd[1895]: time="2025-05-27T17:44:38.738356100Z" level=info msg="loading plugin" id=io.containerd.internal.v1.tracing type=io.containerd.internal.v1
May 27 17:44:38.738425 containerd[1895]: time="2025-05-27T17:44:38.738366500Z" 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 17:44:38.738425 containerd[1895]: time="2025-05-27T17:44:38.738374500Z" level=info msg="loading plugin" id=io.containerd.ttrpc.v1.otelttrpc type=io.containerd.ttrpc.v1
May 27 17:44:38.738425 containerd[1895]: time="2025-05-27T17:44:38.738383500Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.healthcheck type=io.containerd.grpc.v1
May 27 17:44:38.738425 containerd[1895]: time="2025-05-27T17:44:38.738394500Z" level=info msg="loading plugin" id=io.containerd.nri.v1.nri type=io.containerd.nri.v1
May 27 17:44:38.738425 containerd[1895]: time="2025-05-27T17:44:38.738413000Z" level=info msg="runtime interface created"
May 27 17:44:38.738425 containerd[1895]: time="2025-05-27T17:44:38.738418700Z" level=info msg="created NRI interface"
May 27 17:44:38.738425 containerd[1895]: time="2025-05-27T17:44:38.738426600Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.cri type=io.containerd.grpc.v1
May 27 17:44:38.738607 containerd[1895]: time="2025-05-27T17:44:38.738439300Z" level=info msg="Connect containerd service"
May 27 17:44:38.738607 containerd[1895]: time="2025-05-27T17:44:38.738464300Z" level=info msg="using experimental NRI integration - disable nri plugin to prevent this"
May 27 17:44:38.739228 containerd[1895]: time="2025-05-27T17:44:38.739200600Z" 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 17:44:38.864565 setup-nvidia[2047]:   % Total    % Received % Xferd  Average Speed   Time    Time     Time  Current
May 27 17:44:38.864874 setup-nvidia[2047]:                                  Dload  Upload   Total   Spent    Left  Speed
May 27 17:44:39.660056 containerd[1895]: time="2025-05-27T17:44:39.659993800Z" level=info msg="Start subscribing containerd event"
May 27 17:44:39.660172 containerd[1895]: time="2025-05-27T17:44:39.660071000Z" level=info msg="Start recovering state"
May 27 17:44:39.660222 containerd[1895]: time="2025-05-27T17:44:39.660173400Z" level=info msg="Start event monitor"
May 27 17:44:39.660222 containerd[1895]: time="2025-05-27T17:44:39.660196200Z" level=info msg="Start cni network conf syncer for default"
May 27 17:44:39.660222 containerd[1895]: time="2025-05-27T17:44:39.660205400Z" level=info msg="Start streaming server"
May 27 17:44:39.660299 containerd[1895]: time="2025-05-27T17:44:39.660218600Z" level=info msg=serving... address=/run/containerd/containerd.sock.ttrpc
May 27 17:44:39.660299 containerd[1895]: time="2025-05-27T17:44:39.660225500Z" level=info msg="Registered namespace \"k8s.io\" with NRI"
May 27 17:44:39.660299 containerd[1895]: time="2025-05-27T17:44:39.660252000Z" level=info msg="runtime interface starting up..."
May 27 17:44:39.660299 containerd[1895]: time="2025-05-27T17:44:39.660258300Z" level=info msg="starting plugins..."
May 27 17:44:39.660299 containerd[1895]: time="2025-05-27T17:44:39.660274800Z" level=info msg="Synchronizing NRI (plugin) with current runtime state"
May 27 17:44:39.660299 containerd[1895]: time="2025-05-27T17:44:39.660284300Z" level=info msg=serving... address=/run/containerd/containerd.sock
May 27 17:44:39.660447 containerd[1895]: time="2025-05-27T17:44:39.660428800Z" level=info msg="containerd successfully booted in 0.951957s"
May 27 17:44:39.660545 systemd[1]: Started containerd.service - containerd container runtime.
May 27 17:44:40.018179 waagent[2031]: 2025-05-27T17:44:40.018094Z INFO Daemon Daemon Azure Linux Agent Version: 2.12.0.4
May 27 17:44:40.024164 waagent[2031]: 2025-05-27T17:44:40.024119Z INFO Daemon Daemon OS: flatcar 4344.0.0
May 27 17:44:40.027608 waagent[2031]: 2025-05-27T17:44:40.027566Z INFO Daemon Daemon Python: 3.11.12
May 27 17:44:40.031037 waagent[2031]: 2025-05-27T17:44:40.030976Z INFO Daemon Daemon Run daemon
May 27 17:44:40.034092 waagent[2031]: 2025-05-27T17:44:40.034030Z INFO Daemon Daemon No RDMA handler exists for distro='Flatcar Container Linux by Kinvolk' version='4344.0.0'
May 27 17:44:40.040643 waagent[2031]: 2025-05-27T17:44:40.040595Z INFO Daemon Daemon Using waagent for provisioning
May 27 17:44:40.044632 waagent[2031]: 2025-05-27T17:44:40.044586Z INFO Daemon Daemon Activate resource disk
May 27 17:44:40.048191 waagent[2031]: 2025-05-27T17:44:40.048145Z INFO Daemon Daemon Searching gen1 prefix 00000000-0001 or gen2 f8b3781a-1e82-4818-a1c3-63d806ec15bb
May 27 17:44:40.055514 waagent[2031]: 2025-05-27T17:44:40.055468Z INFO Daemon Daemon Found device: sda
May 27 17:44:40.066387 waagent[2031]: 2025-05-27T17:44:40.066341Z INFO Daemon Daemon Examining partition table
May 27 17:44:40.091697 waagent[2031]: 2025-05-27T17:44:40.091642Z INFO Daemon Daemon GPT not detected, determining filesystem
May 27 17:44:40.118170 waagent[2031]: 2025-05-27T17:44:40.118117Z INFO Daemon Daemon sfdisk --part-type -f /dev/sda 1 -n succeeded
May 27 17:44:40.122936 waagent[2031]: 2025-05-27T17:44:40.122886Z INFO Daemon Daemon The partition is formatted with ntfs, updating partition type to 83
May 27 17:44:40.469600 kernel: hv_storvsc f8b3781a-1e82-4818-a1c3-63d806ec15bb: tag#576 cmd 0x5a status: scsi 0x2 srb 0x86 hv 0xc0000001
May 27 17:44:40.481067 kernel:  sda: sda1
May 27 17:44:40.487906 kernel: hv_storvsc f8b3781a-1e82-4818-a1c3-63d806ec15bb: tag#136 cmd 0x5a status: scsi 0x2 srb 0x86 hv 0xc0000001
May 27 17:44:40.503346 waagent[2031]: 2025-05-27T17:44:40.503281Z INFO Daemon Daemon sfdisk --part-type  /dev/sda 1 83 succeeded
May 27 17:44:40.511068 kernel:  sda: sda1
May 27 17:44:40.525102 kernel: hv_storvsc f8b3781a-1e82-4818-a1c3-63d806ec15bb: tag#73 cmd 0x5a status: scsi 0x2 srb 0x86 hv 0xc0000001
May 27 17:44:40.542069 kernel:  sda: sda1
May 27 17:44:40.542135 waagent[2031]: 2025-05-27T17:44:40.542076Z INFO Daemon Daemon Format partition [mkfs.ext4 -F /dev/sda1]
May 27 17:44:45.704314 login[2034]: pam_lastlog(login:session): file /var/log/lastlog is locked/write, retrying
May 27 17:44:45.810506 login[2035]: pam_unix(login:session): session opened for user core(uid=500) by LOGIN(uid=0)
May 27 17:44:45.816898 systemd[1]: Created slice user-500.slice - User Slice of UID 500.
May 27 17:44:45.817994 systemd[1]: Starting user-runtime-dir@500.service - User Runtime Directory /run/user/500...
May 27 17:44:45.824247 systemd-logind[1886]: New session 1 of user core.
May 27 17:44:45.917649 systemd[1]: Finished user-runtime-dir@500.service - User Runtime Directory /run/user/500.
May 27 17:44:45.921158 systemd[1]: Starting user@500.service - User Manager for UID 500...
May 27 17:44:46.013902 (systemd)[2136]: pam_unix(systemd-user:session): session opened for user core(uid=500) by (uid=0)
May 27 17:44:46.016215 systemd-logind[1886]: New session c1 of user core.
May 27 17:44:46.245735 waagent[2031]: 2025-05-27T17:44:46.245651Z INFO Daemon Daemon Mount resource disk [mount -t ext4 /dev/sda1 /mnt/resource]
May 27 17:44:46.369080 kernel: EXT4-fs (sda1): mounted filesystem 4d9457d4-6721-4859-9f0d-1939bb534dec r/w with ordered data mode. Quota mode: none.
May 27 17:44:46.369205 waagent[2031]: 2025-05-27T17:44:46.368984Z INFO Daemon Daemon Resource disk /dev/sda is mounted at /mnt/resource with ext4
May 27 17:44:46.370009 waagent[2031]: 2025-05-27T17:44:46.369945Z INFO Daemon Daemon Clean protocol and wireserver endpoint
May 27 17:44:46.370898 waagent[2031]: 2025-05-27T17:44:46.370842Z INFO Daemon Daemon Running default provisioning handler
May 27 17:44:46.379103 waagent[2031]: 2025-05-27T17:44:46.379034Z 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 17:44:46.398522 waagent[2031]: 2025-05-27T17:44:46.398441Z INFO Daemon Daemon Unable to get cloud-init enabled status from service: [Errno 2] No such file or directory: 'service'
May 27 17:44:46.398768 waagent[2031]: 2025-05-27T17:44:46.398728Z INFO Daemon Daemon cloud-init is enabled: False
May 27 17:44:46.400255 waagent[2031]: 2025-05-27T17:44:46.400212Z INFO Daemon Daemon Copying ovf-env.xml
May 27 17:44:46.502666 waagent[2031]: 2025-05-27T17:44:46.502577Z INFO Daemon Daemon Successfully mounted dvd
May 27 17:44:46.607010 systemd[2136]: Queued start job for default target default.target.
May 27 17:44:46.610781 systemd[1]: mnt-cdrom-secure.mount: Deactivated successfully.
May 27 17:44:46.611219 waagent[2031]: 2025-05-27T17:44:46.611162Z INFO Daemon Daemon Detect protocol endpoint
May 27 17:44:46.647095 waagent[2031]: 2025-05-27T17:44:46.611585Z INFO Daemon Daemon Clean protocol and wireserver endpoint
May 27 17:44:46.647095 waagent[2031]: 2025-05-27T17:44:46.616232Z INFO Daemon Daemon WireServer endpoint is not found. Rerun dhcp handler
May 27 17:44:46.647095 waagent[2031]: 2025-05-27T17:44:46.616791Z INFO Daemon Daemon Test for route to 168.63.129.16
May 27 17:44:46.647095 waagent[2031]: 2025-05-27T17:44:46.618386Z INFO Daemon Daemon Route to 168.63.129.16 exists
May 27 17:44:46.647095 waagent[2031]: 2025-05-27T17:44:46.618984Z INFO Daemon Daemon Wire server endpoint:168.63.129.16
May 27 17:44:46.647095 waagent[2031]: 2025-05-27T17:44:46.631372Z INFO Daemon Daemon Fabric preferred wire protocol version:2015-04-05
May 27 17:44:46.647095 waagent[2031]: 2025-05-27T17:44:46.632118Z INFO Daemon Daemon Wire protocol version:2012-11-30
May 27 17:44:46.647095 waagent[2031]: 2025-05-27T17:44:46.632672Z INFO Daemon Daemon Server preferred version:2015-04-05
May 27 17:44:46.651201 systemd[2136]: Created slice app.slice - User Application Slice.
May 27 17:44:46.651233 systemd[2136]: Reached target paths.target - Paths.
May 27 17:44:46.651282 systemd[2136]: Reached target timers.target - Timers.
May 27 17:44:46.652666 systemd[2136]: Starting dbus.socket - D-Bus User Message Bus Socket...
May 27 17:44:46.663279 systemd[2136]: Listening on dbus.socket - D-Bus User Message Bus Socket.
May 27 17:44:46.663413 systemd[2136]: Reached target sockets.target - Sockets.
May 27 17:44:46.663468 systemd[2136]: Reached target basic.target - Basic System.
May 27 17:44:46.663513 systemd[2136]: Reached target default.target - Main User Target.
May 27 17:44:46.663546 systemd[2136]: Startup finished in 640ms.
May 27 17:44:46.663614 systemd[1]: Started user@500.service - User Manager for UID 500.
May 27 17:44:46.665027 systemd[1]: Started session-1.scope - Session 1 of User core.
May 27 17:44:46.704637 login[2034]: pam_unix(login:session): session opened for user core(uid=500) by LOGIN(uid=0)
May 27 17:44:46.708799 systemd-logind[1886]: New session 2 of user core.
May 27 17:44:46.714178 waagent[2031]: 2025-05-27T17:44:46.714111Z INFO Daemon Daemon Initializing goal state during protocol detection
May 27 17:44:46.714391 waagent[2031]: 2025-05-27T17:44:46.714350Z INFO Daemon Daemon Forcing an update of the goal state.
May 27 17:44:46.725259 waagent[2031]: 2025-05-27T17:44:46.725215Z INFO Daemon Fetched a new incarnation for the WireServer goal state [incarnation 1]
May 27 17:44:46.731175 systemd[1]: Started session-2.scope - Session 2 of User core.
May 27 17:44:46.755207 waagent[2031]: 2025-05-27T17:44:46.755158Z INFO Daemon Daemon HostGAPlugin version: 1.0.8.164
May 27 17:44:46.755930 waagent[2031]: 2025-05-27T17:44:46.755885Z INFO Daemon
May 27 17:44:46.756903 waagent[2031]: 2025-05-27T17:44:46.756851Z INFO Daemon Fetched new vmSettings [HostGAPlugin correlation ID: 13b46a03-1d09-4df2-bc14-1474319b880b eTag: 7858225767797455240 source: Fabric]
May 27 17:44:46.760399 waagent[2031]: 2025-05-27T17:44:46.760348Z INFO Daemon The vmSettings originated via Fabric; will ignore them.
May 27 17:44:46.761103 waagent[2031]: 2025-05-27T17:44:46.761062Z INFO Daemon
May 27 17:44:46.762327 waagent[2031]: 2025-05-27T17:44:46.762285Z INFO Daemon Fetching full goal state from the WireServer [incarnation 1]
May 27 17:44:46.767817 waagent[2031]: 2025-05-27T17:44:46.767772Z INFO Daemon Daemon Downloading artifacts profile blob
May 27 17:44:46.836588 waagent[2031]: 2025-05-27T17:44:46.836520Z INFO Daemon Downloaded certificate {'thumbprint': '9B5F836E8093970830FEB50E3DDF9084EE3B3DCE', 'hasPrivateKey': True}
May 27 17:44:46.837199 waagent[2031]: 2025-05-27T17:44:46.837156Z INFO Daemon Fetch goal state completed
May 27 17:44:46.884586 waagent[2031]: 2025-05-27T17:44:46.884521Z INFO Daemon Daemon Starting provisioning
May 27 17:44:46.884900 waagent[2031]: 2025-05-27T17:44:46.884858Z INFO Daemon Daemon Handle ovf-env.xml.
May 27 17:44:46.886431 waagent[2031]: 2025-05-27T17:44:46.886348Z INFO Daemon Daemon Set hostname [ci-4344.0.0-a-13e6b84161]
May 27 17:44:46.913396 waagent[2031]: 2025-05-27T17:44:46.913340Z INFO Daemon Daemon Publish hostname [ci-4344.0.0-a-13e6b84161]
May 27 17:44:46.913765 waagent[2031]: 2025-05-27T17:44:46.913725Z INFO Daemon Daemon Examine /proc/net/route for primary interface
May 27 17:44:46.915583 waagent[2031]: 2025-05-27T17:44:46.915536Z INFO Daemon Daemon Primary interface is [eth0]
May 27 17:44:46.934133 systemd-networkd[1585]: eth0: found matching network '/usr/lib/systemd/network/zz-default.network', based on potentially unpredictable interface name.
May 27 17:44:46.934144 systemd-networkd[1585]: eth0: Configuring with /usr/lib/systemd/network/zz-default.network.
May 27 17:44:46.934172 systemd-networkd[1585]: eth0: DHCP lease lost
May 27 17:44:46.934672 waagent[2031]: 2025-05-27T17:44:46.934625Z INFO Daemon Daemon Create user account if not exists
May 27 17:44:46.934912 waagent[2031]: 2025-05-27T17:44:46.934875Z INFO Daemon Daemon User core already exists, skip useradd
May 27 17:44:46.936361 waagent[2031]: 2025-05-27T17:44:46.936328Z INFO Daemon Daemon Configure sudoer
May 27 17:44:46.942625 waagent[2031]: 2025-05-27T17:44:46.942584Z INFO Daemon Daemon Configure sshd
May 27 17:44:46.946192 waagent[2031]: 2025-05-27T17:44:46.946152Z 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 17:44:46.946642 waagent[2031]: 2025-05-27T17:44:46.946609Z INFO Daemon Daemon Deploy ssh public key.
May 27 17:44:47.020101 systemd-networkd[1585]: eth0: DHCPv4 address 10.200.8.11/24, gateway 10.200.8.1 acquired from 168.63.129.16
May 27 17:44:48.112507 waagent[2031]: 2025-05-27T17:44:48.112436Z INFO Daemon Daemon Provisioning complete
May 27 17:44:48.121318 waagent[2031]: 2025-05-27T17:44:48.121277Z INFO Daemon Daemon RDMA capabilities are not enabled, skipping
May 27 17:44:48.121592 waagent[2031]: 2025-05-27T17:44:48.121553Z INFO Daemon Daemon End of log to /dev/console. The agent will now check for updates and then will process extensions.
May 27 17:44:48.122999 waagent[2031]: 2025-05-27T17:44:48.122965Z INFO Daemon Daemon Installed Agent WALinuxAgent-2.12.0.4 is the most current agent
May 27 17:44:48.268666 waagent[2192]: 2025-05-27T17:44:48.268588Z INFO ExtHandler ExtHandler Azure Linux Agent (Goal State Agent version 2.12.0.4)
May 27 17:44:48.269006 waagent[2192]: 2025-05-27T17:44:48.268731Z INFO ExtHandler ExtHandler OS: flatcar 4344.0.0
May 27 17:44:48.269006 waagent[2192]: 2025-05-27T17:44:48.268795Z INFO ExtHandler ExtHandler Python: 3.11.12
May 27 17:44:48.269006 waagent[2192]: 2025-05-27T17:44:48.268858Z INFO ExtHandler ExtHandler CPU Arch: x86_64
May 27 17:44:48.356103 waagent[2192]: 2025-05-27T17:44:48.356008Z 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 17:44:48.356316 waagent[2192]: 2025-05-27T17:44:48.356277Z INFO ExtHandler ExtHandler WireServer endpoint 168.63.129.16 read from file
May 27 17:44:48.356396 waagent[2192]: 2025-05-27T17:44:48.356364Z INFO ExtHandler ExtHandler Wire server endpoint:168.63.129.16
May 27 17:44:48.363529 waagent[2192]: 2025-05-27T17:44:48.363433Z INFO ExtHandler Fetched a new incarnation for the WireServer goal state [incarnation 1]
May 27 17:44:48.368713 waagent[2192]: 2025-05-27T17:44:48.368674Z INFO ExtHandler ExtHandler HostGAPlugin version: 1.0.8.164
May 27 17:44:48.369179 waagent[2192]: 2025-05-27T17:44:48.369141Z INFO ExtHandler
May 27 17:44:48.369260 waagent[2192]: 2025-05-27T17:44:48.369229Z INFO ExtHandler Fetched new vmSettings [HostGAPlugin correlation ID: ab67b116-d9d1-4193-9c05-cb72a777a512 eTag: 7858225767797455240 source: Fabric]
May 27 17:44:48.369576 waagent[2192]: 2025-05-27T17:44:48.369538Z INFO ExtHandler The vmSettings originated via Fabric; will ignore them.
May 27 17:44:48.370195 waagent[2192]: 2025-05-27T17:44:48.370157Z INFO ExtHandler
May 27 17:44:48.370268 waagent[2192]: 2025-05-27T17:44:48.370237Z INFO ExtHandler Fetching full goal state from the WireServer [incarnation 1]
May 27 17:44:48.374867 waagent[2192]: 2025-05-27T17:44:48.374837Z INFO ExtHandler ExtHandler Downloading artifacts profile blob
May 27 17:44:48.434775 waagent[2192]: 2025-05-27T17:44:48.434719Z INFO ExtHandler Downloaded certificate {'thumbprint': '9B5F836E8093970830FEB50E3DDF9084EE3B3DCE', 'hasPrivateKey': True}
May 27 17:44:48.435275 waagent[2192]: 2025-05-27T17:44:48.435236Z INFO ExtHandler Fetch goal state completed
May 27 17:44:48.446968 waagent[2192]: 2025-05-27T17:44:48.446747Z INFO ExtHandler ExtHandler OpenSSL version: OpenSSL 3.3.3 11 Feb 2025 (Library: OpenSSL 3.3.3 11 Feb 2025)
May 27 17:44:48.452745 waagent[2192]: 2025-05-27T17:44:48.452700Z INFO ExtHandler ExtHandler WALinuxAgent-2.12.0.4 running as process 2192
May 27 17:44:48.452884 waagent[2192]: 2025-05-27T17:44:48.452849Z INFO ExtHandler ExtHandler ******** AutoUpdate.Enabled is set to False, not processing the operation ********
May 27 17:44:48.453234 waagent[2192]: 2025-05-27T17:44:48.453198Z INFO ExtHandler ExtHandler ******** AutoUpdate.UpdateToLatestVersion is set to False, not processing the operation ********
May 27 17:44:48.454827 waagent[2192]: 2025-05-27T17:44:48.454788Z INFO ExtHandler ExtHandler [CGI] Cgroup monitoring is not supported on ['flatcar', '4344.0.0', '', 'Flatcar Container Linux by Kinvolk']
May 27 17:44:48.455280 waagent[2192]: 2025-05-27T17:44:48.455242Z 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 17:44:48.455443 waagent[2192]: 2025-05-27T17:44:48.455407Z INFO ExtHandler ExtHandler [CGI] Agent cgroups enabled: False
May 27 17:44:48.456045 waagent[2192]: 2025-05-27T17:44:48.456006Z INFO ExtHandler ExtHandler Starting setup for Persistent firewall rules
May 27 17:44:48.496896 waagent[2192]: 2025-05-27T17:44:48.496857Z INFO ExtHandler ExtHandler Firewalld service not running/unavailable, trying to set up waagent-network-setup.service
May 27 17:44:48.497088 waagent[2192]: 2025-05-27T17:44:48.497031Z INFO ExtHandler ExtHandler Successfully updated the Binary file /var/lib/waagent/waagent-network-setup.py for firewall setup
May 27 17:44:48.503355 waagent[2192]: 2025-05-27T17:44:48.503320Z INFO ExtHandler ExtHandler Service: waagent-network-setup.service not enabled. Adding it now
May 27 17:44:48.510579 systemd[1]: Reload requested from client PID 2207 ('systemctl') (unit waagent.service)...
May 27 17:44:48.510595 systemd[1]: Reloading...
May 27 17:44:48.571401 zram_generator::config[2246]: No configuration found.
May 27 17:44:48.683820 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 17:44:48.845954 systemd[1]: Reloading finished in 334 ms.
May 27 17:44:48.872451 waagent[2192]: 2025-05-27T17:44:48.872377Z INFO ExtHandler ExtHandler Successfully added and enabled the waagent-network-setup.service
May 27 17:44:48.872553 waagent[2192]: 2025-05-27T17:44:48.872525Z INFO ExtHandler ExtHandler Persistent firewall rules setup successfully
May 27 17:44:49.349497 waagent[2192]: 2025-05-27T17:44:49.349414Z INFO ExtHandler ExtHandler DROP rule is not available which implies no firewall rules are set yet. Environment thread will set it up.
May 27 17:44:49.349836 waagent[2192]: 2025-05-27T17:44:49.349757Z 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 17:44:49.350578 waagent[2192]: 2025-05-27T17:44:49.350533Z INFO ExtHandler ExtHandler Starting env monitor service.
May 27 17:44:49.350922 waagent[2192]: 2025-05-27T17:44:49.350876Z INFO MonitorHandler ExtHandler WireServer endpoint 168.63.129.16 read from file
May 27 17:44:49.351114 waagent[2192]: 2025-05-27T17:44:49.351073Z INFO ExtHandler ExtHandler Start SendTelemetryHandler service.
May 27 17:44:49.351338 waagent[2192]: 2025-05-27T17:44:49.351302Z INFO MonitorHandler ExtHandler Wire server endpoint:168.63.129.16
May 27 17:44:49.351790 waagent[2192]: 2025-05-27T17:44:49.351745Z INFO MonitorHandler ExtHandler Monitor.NetworkConfigurationChanges is disabled.
May 27 17:44:49.351860 waagent[2192]: 2025-05-27T17:44:49.351818Z INFO EnvHandler ExtHandler WireServer endpoint 168.63.129.16 read from file
May 27 17:44:49.352154 waagent[2192]: 2025-05-27T17:44:49.352103Z INFO SendTelemetryHandler ExtHandler Successfully started the SendTelemetryHandler thread
May 27 17:44:49.352266 waagent[2192]: 2025-05-27T17:44:49.352230Z INFO EnvHandler ExtHandler Wire server endpoint:168.63.129.16
May 27 17:44:49.352302 waagent[2192]: 2025-05-27T17:44:49.352268Z INFO ExtHandler ExtHandler Start Extension Telemetry service.
May 27 17:44:49.352679 waagent[2192]: 2025-05-27T17:44:49.352634Z INFO EnvHandler ExtHandler Configure routes
May 27 17:44:49.352878 waagent[2192]: 2025-05-27T17:44:49.352838Z INFO MonitorHandler ExtHandler Routing table from /proc/net/route:
May 27 17:44:49.352878 waagent[2192]: Iface        Destination        Gateway         Flags        RefCnt        Use        Metric        Mask                MTU        Window        IRTT
May 27 17:44:49.352878 waagent[2192]: eth0        00000000        0108C80A        0003        0        0        1024        00000000        0        0        0
May 27 17:44:49.352878 waagent[2192]: eth0        0008C80A        00000000        0001        0        0        1024        00FFFFFF        0        0        0
May 27 17:44:49.352878 waagent[2192]: eth0        0108C80A        00000000        0005        0        0        1024        FFFFFFFF        0        0        0
May 27 17:44:49.352878 waagent[2192]: eth0        10813FA8        0108C80A        0007        0        0        1024        FFFFFFFF        0        0        0
May 27 17:44:49.352878 waagent[2192]: eth0        FEA9FEA9        0108C80A        0007        0        0        1024        FFFFFFFF        0        0        0
May 27 17:44:49.353275 waagent[2192]: 2025-05-27T17:44:49.353219Z INFO TelemetryEventsCollector ExtHandler Extension Telemetry pipeline enabled: True
May 27 17:44:49.353344 waagent[2192]: 2025-05-27T17:44:49.353316Z INFO EnvHandler ExtHandler Gateway:None
May 27 17:44:49.353520 waagent[2192]: 2025-05-27T17:44:49.353479Z INFO ExtHandler ExtHandler Goal State Period: 6 sec. This indicates how often the agent checks for new goal states and reports status.
May 27 17:44:49.353930 waagent[2192]: 2025-05-27T17:44:49.353894Z INFO TelemetryEventsCollector ExtHandler Successfully started the TelemetryEventsCollector thread
May 27 17:44:49.354006 waagent[2192]: 2025-05-27T17:44:49.353973Z INFO EnvHandler ExtHandler Routes:None
May 27 17:44:49.359625 waagent[2192]: 2025-05-27T17:44:49.359577Z INFO ExtHandler ExtHandler
May 27 17:44:49.359755 waagent[2192]: 2025-05-27T17:44:49.359717Z INFO ExtHandler ExtHandler ProcessExtensionsGoalState started [incarnation_1 channel: WireServer source: Fabric activity: 67730b68-d463-4b7d-b827-b8db927826ff correlation 4f1fbdb5-f295-4708-b9f6-03a779d52499 created: 2025-05-27T17:43:18.357513Z]
May 27 17:44:49.361055 waagent[2192]: 2025-05-27T17:44:49.361005Z INFO ExtHandler ExtHandler No extension handlers found, not processing anything.
May 27 17:44:49.363181 waagent[2192]: 2025-05-27T17:44:49.363141Z INFO ExtHandler ExtHandler ProcessExtensionsGoalState completed [incarnation_1 3 ms]
May 27 17:44:49.388547 waagent[2192]: 2025-05-27T17:44:49.388487Z 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 17:44:49.388547 waagent[2192]: Try `iptables -h' or 'iptables --help' for more information.)
May 27 17:44:49.388930 waagent[2192]: 2025-05-27T17:44:49.388888Z INFO ExtHandler ExtHandler [HEARTBEAT] Agent WALinuxAgent-2.12.0.4 is running as the goal state agent [DEBUG HeartbeatCounter: 0;HeartbeatId: F520B6E7-A89D-4280-9693-91B6B65B51CA;DroppedPackets: -1;UpdateGSErrors: 0;AutoUpdate: 0;UpdateMode: SelfUpdate;]
May 27 17:44:49.425519 waagent[2192]: 2025-05-27T17:44:49.425433Z INFO MonitorHandler ExtHandler Network interfaces:
May 27 17:44:49.425519 waagent[2192]: Executing ['ip', '-a', '-o', 'link']:
May 27 17:44:49.425519 waagent[2192]: 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 17:44:49.425519 waagent[2192]: 2: eth0: <BROADCAST,MULTICAST,UP,LOWER_UP> mtu 1500 qdisc mq state UP mode DEFAULT group default qlen 1000\    link/ether 7c:ed:8d:41:81:e5 brd ff:ff:ff:ff:ff:ff
May 27 17:44:49.425519 waagent[2192]: Executing ['ip', '-4', '-a', '-o', 'address']:
May 27 17:44:49.425519 waagent[2192]: 1: lo    inet 127.0.0.1/8 scope host lo\       valid_lft forever preferred_lft forever
May 27 17:44:49.425519 waagent[2192]: 2: eth0    inet 10.200.8.11/24 metric 1024 brd 10.200.8.255 scope global eth0\       valid_lft forever preferred_lft forever
May 27 17:44:49.425519 waagent[2192]: Executing ['ip', '-6', '-a', '-o', 'address']:
May 27 17:44:49.425519 waagent[2192]: 1: lo    inet6 ::1/128 scope host noprefixroute \       valid_lft forever preferred_lft forever
May 27 17:44:49.425519 waagent[2192]: 2: eth0    inet6 fe80::7eed:8dff:fe41:81e5/64 scope link proto kernel_ll \       valid_lft forever preferred_lft forever
May 27 17:44:49.529772 waagent[2192]: 2025-05-27T17:44:49.529697Z INFO EnvHandler ExtHandler Created firewall rules for the Azure Fabric:
May 27 17:44:49.529772 waagent[2192]: Chain INPUT (policy ACCEPT 0 packets, 0 bytes)
May 27 17:44:49.529772 waagent[2192]:     pkts      bytes target     prot opt in     out     source               destination
May 27 17:44:49.529772 waagent[2192]: Chain FORWARD (policy ACCEPT 0 packets, 0 bytes)
May 27 17:44:49.529772 waagent[2192]:     pkts      bytes target     prot opt in     out     source               destination
May 27 17:44:49.529772 waagent[2192]: Chain OUTPUT (policy ACCEPT 0 packets, 0 bytes)
May 27 17:44:49.529772 waagent[2192]:     pkts      bytes target     prot opt in     out     source               destination
May 27 17:44:49.529772 waagent[2192]:        0        0 ACCEPT     tcp  --  *      *       0.0.0.0/0            168.63.129.16        tcp dpt:53
May 27 17:44:49.529772 waagent[2192]:        0        0 ACCEPT     tcp  --  *      *       0.0.0.0/0            168.63.129.16        owner UID match 0
May 27 17:44:49.529772 waagent[2192]:        0        0 DROP       tcp  --  *      *       0.0.0.0/0            168.63.129.16        ctstate INVALID,NEW
May 27 17:44:49.535624 waagent[2192]: 2025-05-27T17:44:49.535578Z INFO EnvHandler ExtHandler Current Firewall rules:
May 27 17:44:49.535624 waagent[2192]: Chain INPUT (policy ACCEPT 0 packets, 0 bytes)
May 27 17:44:49.535624 waagent[2192]:     pkts      bytes target     prot opt in     out     source               destination
May 27 17:44:49.535624 waagent[2192]: Chain FORWARD (policy ACCEPT 0 packets, 0 bytes)
May 27 17:44:49.535624 waagent[2192]:     pkts      bytes target     prot opt in     out     source               destination
May 27 17:44:49.535624 waagent[2192]: Chain OUTPUT (policy ACCEPT 0 packets, 0 bytes)
May 27 17:44:49.535624 waagent[2192]:     pkts      bytes target     prot opt in     out     source               destination
May 27 17:44:49.535624 waagent[2192]:        0        0 ACCEPT     tcp  --  *      *       0.0.0.0/0            168.63.129.16        tcp dpt:53
May 27 17:44:49.535624 waagent[2192]:        0        0 ACCEPT     tcp  --  *      *       0.0.0.0/0            168.63.129.16        owner UID match 0
May 27 17:44:49.535624 waagent[2192]:        0        0 DROP       tcp  --  *      *       0.0.0.0/0            168.63.129.16        ctstate INVALID,NEW
May 27 17:44:49.535867 waagent[2192]: 2025-05-27T17:44:49.535837Z INFO EnvHandler ExtHandler Set block dev timeout: sdb with timeout: 300
May 27 17:44:49.536013 waagent[2192]: 2025-05-27T17:44:49.535977Z INFO EnvHandler ExtHandler Set block dev timeout: sda with timeout: 300
May 27 17:45:00.575945 setup-nvidia[2047]: \u000d  0     0    0     0    0     0      0      0 --:--:-- --:--:-- --:--:--     0\u000d  0  485M    0  256k    0     0   250k      0  0:33:04  0:00:01  0:33:03  250k\u000d  2  485M    2 13.9M    0     0  7183k      0  0:01:09  0:00:01  0:01:08 7183k\u000d  7  485M    7 38.1M    0     0  12.8M      0  0:00:37  0:00:02  0:00:35 12.8M\u000d 13  485M   13 63.1M    0     0  15.9M      0  0:00:30  0:00:03  0:00:27 15.9M\u000d 18  485M   18 88.1M    0     0  17.7M      0  0:00:27  0:00:04  0:00:23 17.7M\u000d 22  485M   22  111M    0     0  18.7M      0  0:00:25  0:00:05  0:00:20 22.6M\u000d 28  485M   28  135M    0     0  19.2M      0  0:00:25  0:00:07  0:00:18 24.1M\u000d 32  485M   32  159M    0     0  19.9M      0  0:00:24  0:00:08  0:00:16 24.0M\u000d 37  485M   37  183M    0     0  20.3M      0  0:00:23  0:00:09  0:00:14 23.7M\u000d 42  485M   42  206M    0     0  20.6M      0  0:00:23  0:00:09  0:00:14 23.4M\u000d 46  485M   46  224M    0     0  20.3M      0  0:00:23  0:00:11  0:00:12 22.2M\u000d 51  485M   51  248M    0     0  20.7M      0  0:00:23  0:00:11  0:00:12 22.7M\u000d 56  485M   56  273M    0     0  21.0M      0  0:00:23  0:00:12  0:00:11 23.0M\u000d 61  485M   61  296M    0     0  21.2M      0  0:00:22  0:00:13  0:00:09 22.8M\u000d 65  485M   65  319M    0     0  21.3M      0  0:00:22  0:00:14  0:00:08 22.8M\u000d 70  485M   70  342M    0     0  21.5M      0  0:00:22  0:00:15  0:00:07 23.9M\u000d 75  485M   75  368M    0     0  21.7M      0  0:00:22  0:00:16  0:00:06 24.3M\u000d 81  485M   81  394M    0     0  21.8M      0  0:00:22  0:00:18  0:00:04 23.8M\u000d 86  485M   86  418M    0     0  21.9M      0  0:00:22  0:00:19  0:00:03 24.0M\u000d 91  485M   91  442M    0     0  22.1M      0  0:00:21  0:00:20  0:00:01 24.3M\u000d 96  485M   96  466M    0     0  22.2M      0  0:00:21  0:00:21 --:--:-- 24.5M\u000d100  485M  100  485M    0     0  22.3M      0  0:00:21  0:00:21 --:--:-- 24.3M
May 27 17:45:01.221445 chronyd[1880]: Selected source PHC0
May 27 17:45:10.549478 systemd[1]: Created slice system-sshd.slice - Slice /system/sshd.
May 27 17:45:10.552423 systemd[1]: Started sshd@0-10.200.8.11:22-10.200.16.10:36030.service - OpenSSH per-connection server daemon (10.200.16.10:36030).
May 27 17:45:12.551266 sshd[2347]: Accepted publickey for core from 10.200.16.10 port 36030 ssh2: RSA SHA256:43KLdvDzM7BELJcS29r3hKkL8hXR8u1eeLIPzvzInuc
May 27 17:45:12.551095 sshd-session[2347]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0)
May 27 17:45:12.557753 systemd-logind[1886]: New session 3 of user core.
May 27 17:45:12.565449 systemd[1]: Started session-3.scope - Session 3 of User core.
May 27 17:45:13.096790 systemd[1]: Started sshd@1-10.200.8.11:22-10.200.16.10:36036.service - OpenSSH per-connection server daemon (10.200.16.10:36036).
May 27 17:45:13.732197 sshd[2352]: Accepted publickey for core from 10.200.16.10 port 36036 ssh2: RSA SHA256:43KLdvDzM7BELJcS29r3hKkL8hXR8u1eeLIPzvzInuc
May 27 17:45:13.733531 sshd-session[2352]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0)
May 27 17:45:13.737901 systemd-logind[1886]: New session 4 of user core.
May 27 17:45:13.758241 systemd[1]: Started session-4.scope - Session 4 of User core.
May 27 17:45:14.179242 sshd[2354]: Connection closed by 10.200.16.10 port 36036
May 27 17:45:14.179611 sshd-session[2352]: pam_unix(sshd:session): session closed for user core
May 27 17:45:14.183087 systemd[1]: sshd@1-10.200.8.11:22-10.200.16.10:36036.service: Deactivated successfully.
May 27 17:45:14.184686 systemd[1]: session-4.scope: Deactivated successfully.
May 27 17:45:14.185376 systemd-logind[1886]: Session 4 logged out. Waiting for processes to exit.
May 27 17:45:14.186339 systemd-logind[1886]: Removed session 4.
May 27 17:45:14.300268 systemd[1]: Started sshd@2-10.200.8.11:22-10.200.16.10:36042.service - OpenSSH per-connection server daemon (10.200.16.10:36042).
May 27 17:45:14.794952 setup-nvidia[1876]: Downloading NVIDIA 535.230.02 Driver
May 27 17:45:14.799400 setup-nvidia[2363]:   % Total    % Received % Xferd  Average Speed   Time    Time     Time  Current
May 27 17:45:14.799599 setup-nvidia[2363]:                                  Dload  Upload   Total   Spent    Left  Speed
May 27 17:45:14.941977 sshd[2360]: Accepted publickey for core from 10.200.16.10 port 36042 ssh2: RSA SHA256:43KLdvDzM7BELJcS29r3hKkL8hXR8u1eeLIPzvzInuc
May 27 17:45:14.943353 sshd-session[2360]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0)
May 27 17:45:14.947782 systemd-logind[1886]: New session 5 of user core.
May 27 17:45:14.974198 systemd[1]: Started session-5.scope - Session 5 of User core.
May 27 17:45:15.404523 sshd[2364]: Connection closed by 10.200.16.10 port 36042
May 27 17:45:15.405037 sshd-session[2360]: pam_unix(sshd:session): session closed for user core
May 27 17:45:15.408506 systemd[1]: sshd@2-10.200.8.11:22-10.200.16.10:36042.service: Deactivated successfully.
May 27 17:45:15.410166 systemd[1]: session-5.scope: Deactivated successfully.
May 27 17:45:15.411026 systemd-logind[1886]: Session 5 logged out. Waiting for processes to exit.
May 27 17:45:15.412354 systemd-logind[1886]: Removed session 5.
May 27 17:45:16.210602 setup-nvidia[2363]: \u000d  0     0    0     0    0     0      0      0 --:--:-- --:--:-- --:--:--     0\u000d 70  326M   70  229M    0     0   231M      0  0:00:01 --:--:--  0:00:01  231M\u000d100  326M  100  326M    0     0   231M      0  0:00:01  0:00:01 --:--:--  231M
May 27 17:45:16.261430 setup-nvidia[1876]: Extract the NVIDIA Driver Installer 535.230.02
May 27 17:45:16.261591 setup-nvidia[1876]: /opt/nvidia/workdir/nvidia-workdir /
May 27 17:45:16.279556 setup-nvidia[2371]: Creating directory NVIDIA-Linux-x86_64-535.230.02
May 27 17:45:16.555302 setup-nvidia[2371]: Verifying archive integrity... OK
May 27 17:45:17.231071 setup-nvidia[2371]: Uncompressing NVIDIA Accelerated Graphics Driver for Linux-x86_64 535.230.02
May 27 17:45:19.032775 setup-nvidia[2397]: ........................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................
May 27 17:45:19.130925 setup-nvidia[1876]: /
May 27 17:45:19.130925 setup-nvidia[1876]: Spawn system-nspawn container to install the NVIDIA drivers
May 27 17:45:19.272622 sudo[2404]:     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 17:45:19.274368 sudo[2404]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=0)
May 27 17:45:19.280004 systemd[1]: Created slice user-0.slice - User Slice of UID 0.
May 27 17:45:19.281304 systemd[1]: Starting user-runtime-dir@0.service - User Runtime Directory /run/user/0...
May 27 17:45:19.315210 systemd[1]: Finished user-runtime-dir@0.service - User Runtime Directory /run/user/0.
May 27 17:45:19.317848 systemd[1]: Starting user@0.service - User Manager for UID 0...
May 27 17:45:19.335260 (systemd)[2407]: pam_unix(systemd-user:session): session opened for user root(uid=0) by (uid=0)
May 27 17:45:19.337555 systemd-logind[1886]: New session c3 of user root.
May 27 17:45:19.528102 systemd[2407]: Queued start job for default target default.target.
May 27 17:45:19.548184 systemd[2407]: Created slice app.slice - User Application Slice.
May 27 17:45:19.548214 systemd[2407]: Reached target paths.target - Paths.
May 27 17:45:19.548264 systemd[2407]: Reached target timers.target - Timers.
May 27 17:45:19.549439 systemd[2407]: Starting dbus.socket - D-Bus User Message Bus Socket...
May 27 17:45:19.560267 systemd[2407]: Listening on dbus.socket - D-Bus User Message Bus Socket.
May 27 17:45:19.560391 systemd[2407]: Reached target sockets.target - Sockets.
May 27 17:45:19.560446 systemd[2407]: Reached target basic.target - Basic System.
May 27 17:45:19.560491 systemd[2407]: Reached target default.target - Main User Target.
May 27 17:45:19.560522 systemd[2407]: Startup finished in 217ms.
May 27 17:45:19.560592 systemd[1]: Started user@0.service - User Manager for UID 0.
May 27 17:45:19.566567 systemd[1]: Started session-c2.scope - Session c2 of User root.
May 27 17:45:19.606080 kernel: loop6: detected capacity change from 0 to 12644352
May 27 17:45:19.606176 kernel: hv_balloon: Max. dynamic memory size: 114688 MB
May 27 17:45:19.613069 kernel:  loop6: p9
May 27 17:45:19.811330 setup-nvidia[2416]: ░ Spawning container flatcardevelopercontainer-4344.0.0.bin on /opt/nvidia/workdir/flatcar_developer_container-4344.0.0.bin.
May 27 17:45:21.190528 kernel: EXT4-fs (loop6p9): write access unavailable, skipping orphan cleanup
May 27 17:45:21.190650 kernel: EXT4-fs (loop6p9): mounted filesystem dd441403-e7f4-4782-b932-a2370dfaea27 ro without journal. Quota mode: none.
May 27 17:45:22.620466 update_engine[1888]: I20250527 17:45:22.620383  1888 update_attempter.cc:509] Updating boot flags...
May 27 17:45:25.521158 systemd[1]: Started sshd@3-10.200.8.11:22-10.200.16.10:33536.service - OpenSSH per-connection server daemon (10.200.16.10:33536).
May 27 17:45:26.175716 sshd[2594]: Accepted publickey for core from 10.200.16.10 port 33536 ssh2: RSA SHA256:43KLdvDzM7BELJcS29r3hKkL8hXR8u1eeLIPzvzInuc
May 27 17:45:26.177023 sshd-session[2594]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0)
May 27 17:45:26.181413 systemd-logind[1886]: New session 6 of user core.
May 27 17:45:26.201203 systemd[1]: Started session-6.scope - Session 6 of User core.
May 27 17:45:26.620457 sshd[2596]: Connection closed by 10.200.16.10 port 33536
May 27 17:45:26.620735 sshd-session[2594]: pam_unix(sshd:session): session closed for user core
May 27 17:45:26.624157 systemd[1]: sshd@3-10.200.8.11:22-10.200.16.10:33536.service: Deactivated successfully.
May 27 17:45:26.625801 systemd[1]: session-6.scope: Deactivated successfully.
May 27 17:45:26.626656 systemd-logind[1886]: Session 6 logged out. Waiting for processes to exit.
May 27 17:45:26.627614 systemd-logind[1886]: Removed session 6.
May 27 17:45:26.737652 systemd[1]: Started sshd@4-10.200.8.11:22-10.200.16.10:33552.service - OpenSSH per-connection server daemon (10.200.16.10:33552).
May 27 17:45:27.367441 sshd[2602]: Accepted publickey for core from 10.200.16.10 port 33552 ssh2: RSA SHA256:43KLdvDzM7BELJcS29r3hKkL8hXR8u1eeLIPzvzInuc
May 27 17:45:27.368791 sshd-session[2602]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0)
May 27 17:45:27.373303 systemd-logind[1886]: New session 7 of user core.
May 27 17:45:27.390158 systemd[1]: Started session-7.scope - Session 7 of User core.
May 27 17:45:27.809989 sshd[2604]: Connection closed by 10.200.16.10 port 33552
May 27 17:45:27.810352 sshd-session[2602]: pam_unix(sshd:session): session closed for user core
May 27 17:45:27.813780 systemd[1]: sshd@4-10.200.8.11:22-10.200.16.10:33552.service: Deactivated successfully.
May 27 17:45:27.815343 systemd[1]: session-7.scope: Deactivated successfully.
May 27 17:45:27.816006 systemd-logind[1886]: Session 7 logged out. Waiting for processes to exit.
May 27 17:45:27.816966 systemd-logind[1886]: Removed session 7.
May 27 17:45:37.925550 systemd[1]: Started sshd@5-10.200.8.11:22-10.200.16.10:47974.service - OpenSSH per-connection server daemon (10.200.16.10:47974).
May 27 17:45:38.557298 sshd[3312]: Accepted publickey for core from 10.200.16.10 port 47974 ssh2: RSA SHA256:43KLdvDzM7BELJcS29r3hKkL8hXR8u1eeLIPzvzInuc
May 27 17:45:38.558706 sshd-session[3312]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0)
May 27 17:45:38.563670 systemd-logind[1886]: New session 8 of user core.
May 27 17:45:38.582178 systemd[1]: Started session-8.scope - Session 8 of User core.
May 27 17:45:38.999191 sshd[3314]: Connection closed by 10.200.16.10 port 47974
May 27 17:45:38.999529 sshd-session[3312]: pam_unix(sshd:session): session closed for user core
May 27 17:45:39.002876 systemd[1]: sshd@5-10.200.8.11:22-10.200.16.10:47974.service: Deactivated successfully.
May 27 17:45:39.004413 systemd[1]: session-8.scope: Deactivated successfully.
May 27 17:45:39.005152 systemd-logind[1886]: Session 8 logged out. Waiting for processes to exit.
May 27 17:45:39.006240 systemd-logind[1886]: Removed session 8.
May 27 17:45:39.114826 systemd[1]: Started sshd@6-10.200.8.11:22-10.200.16.10:42658.service - OpenSSH per-connection server daemon (10.200.16.10:42658).
May 27 17:45:39.746135 sshd[3367]: Accepted publickey for core from 10.200.16.10 port 42658 ssh2: RSA SHA256:43KLdvDzM7BELJcS29r3hKkL8hXR8u1eeLIPzvzInuc
May 27 17:45:39.747490 sshd-session[3367]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0)
May 27 17:45:39.751857 systemd-logind[1886]: New session 9 of user core.
May 27 17:45:39.761183 systemd[1]: Started session-9.scope - Session 9 of User core.
May 27 17:45:40.189124 sshd[3369]: Connection closed by 10.200.16.10 port 42658
May 27 17:45:40.189484 sshd-session[3367]: pam_unix(sshd:session): session closed for user core
May 27 17:45:40.192900 systemd[1]: sshd@6-10.200.8.11:22-10.200.16.10:42658.service: Deactivated successfully.
May 27 17:45:40.194557 systemd[1]: session-9.scope: Deactivated successfully.
May 27 17:45:40.195368 systemd-logind[1886]: Session 9 logged out. Waiting for processes to exit.
May 27 17:45:40.196324 systemd-logind[1886]: Removed session 9.
May 27 17:45:50.300739 systemd[1]: Started sshd@7-10.200.8.11:22-10.200.16.10:48896.service - OpenSSH per-connection server daemon (10.200.16.10:48896).
May 27 17:45:50.944407 sshd[5853]: Accepted publickey for core from 10.200.16.10 port 48896 ssh2: RSA SHA256:43KLdvDzM7BELJcS29r3hKkL8hXR8u1eeLIPzvzInuc
May 27 17:45:50.944243 sshd-session[5853]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0)
May 27 17:45:50.949863 systemd-logind[1886]: New session 10 of user core.
May 27 17:45:50.964304 systemd[1]: Started session-10.scope - Session 10 of User core.
May 27 17:45:51.385057 sshd[6035]: Connection closed by 10.200.16.10 port 48896
May 27 17:45:51.386500 sshd-session[5853]: pam_unix(sshd:session): session closed for user core
May 27 17:45:51.392472 systemd-logind[1886]: Session 10 logged out. Waiting for processes to exit.
May 27 17:45:51.394253 systemd[1]: sshd@7-10.200.8.11:22-10.200.16.10:48896.service: Deactivated successfully.
May 27 17:45:51.396850 systemd[1]: session-10.scope: Deactivated successfully.
May 27 17:45:51.399908 systemd-logind[1886]: Removed session 10.
May 27 17:45:51.501953 systemd[1]: Started sshd@8-10.200.8.11:22-10.200.16.10:48902.service - OpenSSH per-connection server daemon (10.200.16.10:48902).
May 27 17:45:52.145322 sshd[6143]: Accepted publickey for core from 10.200.16.10 port 48902 ssh2: RSA SHA256:43KLdvDzM7BELJcS29r3hKkL8hXR8u1eeLIPzvzInuc
May 27 17:45:52.146681 sshd-session[6143]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0)
May 27 17:45:52.151394 systemd-logind[1886]: New session 11 of user core.
May 27 17:45:52.164181 systemd[1]: Started session-11.scope - Session 11 of User core.
May 27 17:45:52.607434 sshd[6259]: Connection closed by 10.200.16.10 port 48902
May 27 17:45:52.608153 sshd-session[6143]: pam_unix(sshd:session): session closed for user core
May 27 17:45:52.613707 systemd[1]: sshd@8-10.200.8.11:22-10.200.16.10:48902.service: Deactivated successfully.
May 27 17:45:52.616147 systemd[1]: session-11.scope: Deactivated successfully.
May 27 17:45:52.616928 systemd-logind[1886]: Session 11 logged out. Waiting for processes to exit.
May 27 17:45:52.618623 systemd-logind[1886]: Removed session 11.
May 27 17:46:02.719792 systemd[1]: Started sshd@9-10.200.8.11:22-10.200.16.10:35270.service - OpenSSH per-connection server daemon (10.200.16.10:35270).
May 27 17:46:03.356776 sshd[9491]: Accepted publickey for core from 10.200.16.10 port 35270 ssh2: RSA SHA256:43KLdvDzM7BELJcS29r3hKkL8hXR8u1eeLIPzvzInuc
May 27 17:46:03.358256 sshd-session[9491]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0)
May 27 17:46:03.365687 systemd-logind[1886]: New session 12 of user core.
May 27 17:46:03.376431 systemd[1]: Started session-12.scope - Session 12 of User core.
May 27 17:46:03.800847 sshd[9630]: Connection closed by 10.200.16.10 port 35270
May 27 17:46:03.801614 sshd-session[9491]: pam_unix(sshd:session): session closed for user core
May 27 17:46:03.806417 systemd-logind[1886]: Session 12 logged out. Waiting for processes to exit.
May 27 17:46:03.807245 systemd[1]: sshd@9-10.200.8.11:22-10.200.16.10:35270.service: Deactivated successfully.
May 27 17:46:03.808996 systemd[1]: session-12.scope: Deactivated successfully.
May 27 17:46:03.813577 systemd-logind[1886]: Removed session 12.
May 27 17:46:03.914277 systemd[1]: Started sshd@10-10.200.8.11:22-10.200.16.10:35282.service - OpenSSH per-connection server daemon (10.200.16.10:35282).
May 27 17:46:04.564753 sshd[9923]: Accepted publickey for core from 10.200.16.10 port 35282 ssh2: RSA SHA256:43KLdvDzM7BELJcS29r3hKkL8hXR8u1eeLIPzvzInuc
May 27 17:46:04.566807 sshd-session[9923]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0)
May 27 17:46:04.574448 systemd-logind[1886]: New session 13 of user core.
May 27 17:46:04.584566 systemd[1]: Started session-13.scope - Session 13 of User core.
May 27 17:46:05.011849 sshd[10118]: Connection closed by 10.200.16.10 port 35282
May 27 17:46:05.012530 sshd-session[9923]: pam_unix(sshd:session): session closed for user core
May 27 17:46:05.016033 systemd-logind[1886]: Session 13 logged out. Waiting for processes to exit.
May 27 17:46:05.017493 systemd[1]: sshd@10-10.200.8.11:22-10.200.16.10:35282.service: Deactivated successfully.
May 27 17:46:05.019930 systemd[1]: session-13.scope: Deactivated successfully.
May 27 17:46:05.024689 systemd-logind[1886]: Removed session 13.
May 27 17:46:15.127394 systemd[1]: Started sshd@11-10.200.8.11:22-10.200.16.10:42598.service - OpenSSH per-connection server daemon (10.200.16.10:42598).
May 27 17:46:15.782019 sshd[11641]: Accepted publickey for core from 10.200.16.10 port 42598 ssh2: RSA SHA256:43KLdvDzM7BELJcS29r3hKkL8hXR8u1eeLIPzvzInuc
May 27 17:46:15.783488 sshd-session[11641]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0)
May 27 17:46:15.792534 systemd-logind[1886]: New session 14 of user core.
May 27 17:46:15.802858 systemd[1]: Started session-14.scope - Session 14 of User core.
May 27 17:46:16.239787 sshd[11667]: Connection closed by 10.200.16.10 port 42598
May 27 17:46:16.240453 sshd-session[11641]: pam_unix(sshd:session): session closed for user core
May 27 17:46:16.245968 systemd-logind[1886]: Session 14 logged out. Waiting for processes to exit.
May 27 17:46:16.246789 systemd[1]: sshd@11-10.200.8.11:22-10.200.16.10:42598.service: Deactivated successfully.
May 27 17:46:16.249188 systemd[1]: session-14.scope: Deactivated successfully.
May 27 17:46:16.253279 systemd-logind[1886]: Removed session 14.
May 27 17:46:16.382712 systemd[1]: Started sshd@12-10.200.8.11:22-10.200.16.10:42604.service - OpenSSH per-connection server daemon (10.200.16.10:42604).
May 27 17:46:17.062137 sshd[11709]: Accepted publickey for core from 10.200.16.10 port 42604 ssh2: RSA SHA256:43KLdvDzM7BELJcS29r3hKkL8hXR8u1eeLIPzvzInuc
May 27 17:46:17.062974 sshd-session[11709]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0)
May 27 17:46:17.068064 systemd-logind[1886]: New session 15 of user core.
May 27 17:46:17.081220 systemd[1]: Started session-15.scope - Session 15 of User core.
May 27 17:46:17.513754 sshd[11723]: Connection closed by 10.200.16.10 port 42604
May 27 17:46:17.515473 sshd-session[11709]: pam_unix(sshd:session): session closed for user core
May 27 17:46:17.518965 systemd[1]: sshd@12-10.200.8.11:22-10.200.16.10:42604.service: Deactivated successfully.
May 27 17:46:17.520653 systemd[1]: session-15.scope: Deactivated successfully.
May 27 17:46:17.521205 systemd-logind[1886]: Session 15 logged out. Waiting for processes to exit.
May 27 17:46:17.525854 systemd-logind[1886]: Removed session 15.
May 27 17:46:27.628908 systemd[1]: Started sshd@13-10.200.8.11:22-10.200.16.10:34526.service - OpenSSH per-connection server daemon (10.200.16.10:34526).
May 27 17:46:28.283508 sshd[12047]: Accepted publickey for core from 10.200.16.10 port 34526 ssh2: RSA SHA256:43KLdvDzM7BELJcS29r3hKkL8hXR8u1eeLIPzvzInuc
May 27 17:46:28.284994 sshd-session[12047]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0)
May 27 17:46:28.293981 systemd-logind[1886]: New session 16 of user core.
May 27 17:46:28.300272 systemd[1]: Started session-16.scope - Session 16 of User core.
May 27 17:46:28.747868 sshd[12070]: Connection closed by 10.200.16.10 port 34526
May 27 17:46:28.748482 sshd-session[12047]: pam_unix(sshd:session): session closed for user core
May 27 17:46:28.754698 systemd-logind[1886]: Session 16 logged out. Waiting for processes to exit.
May 27 17:46:28.755541 systemd[1]: sshd@13-10.200.8.11:22-10.200.16.10:34526.service: Deactivated successfully.
May 27 17:46:28.757668 systemd[1]: session-16.scope: Deactivated successfully.
May 27 17:46:28.761661 systemd-logind[1886]: Removed session 16.
May 27 17:46:28.860759 systemd[1]: Started sshd@14-10.200.8.11:22-10.200.16.10:45786.service - OpenSSH per-connection server daemon (10.200.16.10:45786).
May 27 17:46:29.514670 sshd[12098]: Accepted publickey for core from 10.200.16.10 port 45786 ssh2: RSA SHA256:43KLdvDzM7BELJcS29r3hKkL8hXR8u1eeLIPzvzInuc
May 27 17:46:29.516181 sshd-session[12098]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0)
May 27 17:46:29.522472 systemd-logind[1886]: New session 17 of user core.
May 27 17:46:29.532148 systemd[1]: Started session-17.scope - Session 17 of User core.
May 27 17:46:29.980219 sshd[12129]: Connection closed by 10.200.16.10 port 45786
May 27 17:46:29.981924 sshd-session[12098]: pam_unix(sshd:session): session closed for user core
May 27 17:46:29.984974 systemd[1]: sshd@14-10.200.8.11:22-10.200.16.10:45786.service: Deactivated successfully.
May 27 17:46:29.986638 systemd[1]: session-17.scope: Deactivated successfully.
May 27 17:46:29.988091 systemd-logind[1886]: Session 17 logged out. Waiting for processes to exit.
May 27 17:46:29.991623 systemd-logind[1886]: Removed session 17.
May 27 17:46:40.102290 systemd[1]: Started sshd@15-10.200.8.11:22-10.200.16.10:52756.service - OpenSSH per-connection server daemon (10.200.16.10:52756).
May 27 17:46:40.755752 sshd[12453]: Accepted publickey for core from 10.200.16.10 port 52756 ssh2: RSA SHA256:43KLdvDzM7BELJcS29r3hKkL8hXR8u1eeLIPzvzInuc
May 27 17:46:40.757654 sshd-session[12453]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0)
May 27 17:46:40.764634 systemd-logind[1886]: New session 18 of user core.
May 27 17:46:40.771235 systemd[1]: Started session-18.scope - Session 18 of User core.
May 27 17:46:41.200391 sshd[12492]: Connection closed by 10.200.16.10 port 52756
May 27 17:46:41.200755 sshd-session[12453]: pam_unix(sshd:session): session closed for user core
May 27 17:46:41.205992 systemd[1]: sshd@15-10.200.8.11:22-10.200.16.10:52756.service: Deactivated successfully.
May 27 17:46:41.207602 systemd[1]: session-18.scope: Deactivated successfully.
May 27 17:46:41.208336 systemd-logind[1886]: Session 18 logged out. Waiting for processes to exit.
May 27 17:46:41.209287 systemd-logind[1886]: Removed session 18.
May 27 17:46:41.318895 systemd[1]: Started sshd@16-10.200.8.11:22-10.200.16.10:52768.service - OpenSSH per-connection server daemon (10.200.16.10:52768).
May 27 17:46:41.963767 sshd[12524]: Accepted publickey for core from 10.200.16.10 port 52768 ssh2: RSA SHA256:43KLdvDzM7BELJcS29r3hKkL8hXR8u1eeLIPzvzInuc
May 27 17:46:41.965237 sshd-session[12524]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0)
May 27 17:46:41.969681 systemd-logind[1886]: New session 19 of user core.
May 27 17:46:41.978236 systemd[1]: Started session-19.scope - Session 19 of User core.
May 27 17:46:42.406303 sshd[12526]: Connection closed by 10.200.16.10 port 52768
May 27 17:46:42.406591 sshd-session[12524]: pam_unix(sshd:session): session closed for user core
May 27 17:46:42.410107 systemd[1]: sshd@16-10.200.8.11:22-10.200.16.10:52768.service: Deactivated successfully.
May 27 17:46:42.411681 systemd[1]: session-19.scope: Deactivated successfully.
May 27 17:46:42.412448 systemd-logind[1886]: Session 19 logged out. Waiting for processes to exit.
May 27 17:46:42.413395 systemd-logind[1886]: Removed session 19.
May 27 17:46:50.404925 setup-nvidia[2416]: \u000d
May 27 17:46:50.404925 setup-nvidia[2416]: ERROR: Unable to load the kernel module 'nvidia.ko'.  This happens most
May 27 17:46:50.404925 setup-nvidia[2416]:        frequently when this kernel module was built against the wrong or
May 27 17:46:50.404925 setup-nvidia[2416]:        improperly configured kernel sources, with a version of gcc that differs
May 27 17:46:50.404925 setup-nvidia[2416]:        from the one used to build the target kernel, or if another driver, such
May 27 17:46:50.404925 setup-nvidia[2416]:        as nouveau, is present and prevents the NVIDIA kernel module from
May 27 17:46:50.404925 setup-nvidia[2416]:        obtaining ownership of the NVIDIA device(s), or no NVIDIA device
May 27 17:46:50.404925 setup-nvidia[2416]:        installed in this system is supported by this NVIDIA Linux graphics
May 27 17:46:50.404925 setup-nvidia[2416]:        driver release.
May 27 17:46:50.404925 setup-nvidia[2416]:        \u000d
May 27 17:46:50.404925 setup-nvidia[2416]:        Please see the log entries 'Kernel module load error' and 'Kernel
May 27 17:46:50.404925 setup-nvidia[2416]:        messages' at the end of the file
May 27 17:46:50.404925 setup-nvidia[2416]:        '/nvidia/NVIDIA-Linux-x86_64-535.230.02/nvidia-installer.log' for more
May 27 17:46:50.404925 setup-nvidia[2416]:        information.
May 27 17:46:50.404925 setup-nvidia[2416]: \u000d
May 27 17:46:50.421575 setup-nvidia[2416]: dmesg: read kernel buffer failed: Operation not permitted
May 27 17:46:50.440190 setup-nvidia[2416]: \u000d
May 27 17:46:50.440190 setup-nvidia[2416]: ERROR: Installation has failed.  Please see the file
May 27 17:46:50.440190 setup-nvidia[2416]:        '/nvidia/NVIDIA-Linux-x86_64-535.230.02/nvidia-installer.log' for
May 27 17:46:50.440190 setup-nvidia[2416]:        details.  You may find suggestions on fixing installation problems in
May 27 17:46:50.440190 setup-nvidia[2416]:        the README available on the Linux driver download page at
May 27 17:46:50.440190 setup-nvidia[2416]:        www.nvidia.com.
May 27 17:46:50.440190 setup-nvidia[2416]: \u000d
May 27 17:46:50.440632 setup-nvidia[2416]: Last 50 lines of nvidia-installer.log:
May 27 17:46:50.441529 setup-nvidia[2416]:    /nvidia/NVIDIA-Linux-x86_64-535.230.02/kernel/nvidia.o: warning: objtool: _nv039000rm+0x53: 'naked' return found in MITIGATION_RETHUNK build
May 27 17:46:50.441529 setup-nvidia[2416]:    /nvidia/NVIDIA-Linux-x86_64-535.230.02/kernel/nvidia.o: warning: objtool: _nv038997rm+0x90: 'naked' return found in MITIGATION_RETHUNK build
May 27 17:46:50.441529 setup-nvidia[2416]:    /nvidia/NVIDIA-Linux-x86_64-535.230.02/kernel/nvidia.o: warning: objtool: _nv038990rm+0x2b: 'naked' return found in MITIGATION_RETHUNK build
May 27 17:46:50.441529 setup-nvidia[2416]:    /nvidia/NVIDIA-Linux-x86_64-535.230.02/kernel/nvidia.o: warning: objtool: _nv039046rm+0x93: 'naked' return found in MITIGATION_RETHUNK build
May 27 17:46:50.441529 setup-nvidia[2416]:    /nvidia/NVIDIA-Linux-x86_64-535.230.02/kernel/nvidia.o: warning: objtool: _nv039042rm+0x36: 'naked' return found in MITIGATION_RETHUNK build
May 27 17:46:50.441529 setup-nvidia[2416]:    /nvidia/NVIDIA-Linux-x86_64-535.230.02/kernel/nvidia.o: warning: objtool: _nv039041rm+0x9d: 'naked' return found in MITIGATION_RETHUNK build
May 27 17:46:50.441529 setup-nvidia[2416]:    /nvidia/NVIDIA-Linux-x86_64-535.230.02/kernel/nvidia.o: warning: objtool: _nv039043rm+0x77: 'naked' return found in MITIGATION_RETHUNK build
May 27 17:46:50.441529 setup-nvidia[2416]:    /nvidia/NVIDIA-Linux-x86_64-535.230.02/kernel/nvidia.o: warning: objtool: _nv038987rm+0x7f: 'naked' return found in MITIGATION_RETHUNK build
May 27 17:46:50.441529 setup-nvidia[2416]:    /nvidia/NVIDIA-Linux-x86_64-535.230.02/kernel/nvidia.o: warning: objtool: _nv030558rm+0x3e: 'naked' return found in MITIGATION_RETHUNK build
May 27 17:46:50.441529 setup-nvidia[2416]:    /nvidia/NVIDIA-Linux-x86_64-535.230.02/kernel/nvidia.o: warning: objtool: _nv030557rm+0x27: 'naked' return found in MITIGATION_RETHUNK build
May 27 17:46:50.441529 setup-nvidia[2416]:    /nvidia/NVIDIA-Linux-x86_64-535.230.02/kernel/nvidia.o: warning: objtool: _nv030561rm+0x37: 'naked' return found in MITIGATION_RETHUNK build
May 27 17:46:50.441529 setup-nvidia[2416]:    /nvidia/NVIDIA-Linux-x86_64-535.230.02/kernel/nvidia.o: warning: objtool: _nv030560rm+0x24: 'naked' return found in MITIGATION_RETHUNK build
May 27 17:46:50.441529 setup-nvidia[2416]:    /nvidia/NVIDIA-Linux-x86_64-535.230.02/kernel/nvidia.o: warning: objtool: _nv030559rm+0xca: 'naked' return found in MITIGATION_RETHUNK build
May 27 17:46:50.441529 setup-nvidia[2416]:    /nvidia/NVIDIA-Linux-x86_64-535.230.02/kernel/nvidia.o: warning: objtool: _nv030562rm+0x193: 'naked' return found in MITIGATION_RETHUNK build
May 27 17:46:50.441529 setup-nvidia[2416]:    /nvidia/NVIDIA-Linux-x86_64-535.230.02/kernel/nvidia.o: warning: objtool: _nv030564rm+0x17f: 'naked' return found in MITIGATION_RETHUNK build
May 27 17:46:50.441529 setup-nvidia[2416]:    /nvidia/NVIDIA-Linux-x86_64-535.230.02/kernel/nvidia.o: warning: objtool: _nv011860rm+0x5d: 'naked' return found in MITIGATION_RETHUNK build
May 27 17:46:50.441529 setup-nvidia[2416]:    /nvidia/NVIDIA-Linux-x86_64-535.230.02/kernel/nvidia.o: warning: objtool: _nv039354rm+0x12f: 'naked' return found in MITIGATION_RETHUNK build
May 27 17:46:50.441529 setup-nvidia[2416]:      MODPOST /nvidia/NVIDIA-Linux-x86_64-535.230.02/kernel/Module.symvers
May 27 17:46:50.441529 setup-nvidia[2416]:      CC [M]  /nvidia/NVIDIA-Linux-x86_64-535.230.02/kernel/nvidia.mod.o
May 27 17:46:50.441529 setup-nvidia[2416]:      CC [M]  /nvidia/NVIDIA-Linux-x86_64-535.230.02/kernel/.module-common.o
May 27 17:46:50.441529 setup-nvidia[2416]:      CC [M]  /nvidia/NVIDIA-Linux-x86_64-535.230.02/kernel/nvidia-uvm.mod.o
May 27 17:46:50.441529 setup-nvidia[2416]:      CC [M]  /nvidia/NVIDIA-Linux-x86_64-535.230.02/kernel/nvidia-modeset.mod.o
May 27 17:46:50.441529 setup-nvidia[2416]:      CC [M]  /nvidia/NVIDIA-Linux-x86_64-535.230.02/kernel/nvidia-drm.mod.o
May 27 17:46:50.441529 setup-nvidia[2416]:      CC [M]  /nvidia/NVIDIA-Linux-x86_64-535.230.02/kernel/nvidia-peermem.mod.o
May 27 17:46:50.441529 setup-nvidia[2416]:      LD [M]  /nvidia/NVIDIA-Linux-x86_64-535.230.02/kernel/nvidia.ko
May 27 17:46:50.441529 setup-nvidia[2416]:      LD [M]  /nvidia/NVIDIA-Linux-x86_64-535.230.02/kernel/nvidia-uvm.ko
May 27 17:46:50.441529 setup-nvidia[2416]:      LD [M]  /nvidia/NVIDIA-Linux-x86_64-535.230.02/kernel/nvidia-drm.ko
May 27 17:46:50.441529 setup-nvidia[2416]:      LD [M]  /nvidia/NVIDIA-Linux-x86_64-535.230.02/kernel/nvidia-peermem.ko
May 27 17:46:50.441529 setup-nvidia[2416]:      LD [M]  /nvidia/NVIDIA-Linux-x86_64-535.230.02/kernel/nvidia-modeset.ko
May 27 17:46:50.441529 setup-nvidia[2416]:      BTF [M] /nvidia/NVIDIA-Linux-x86_64-535.230.02/kernel/nvidia-peermem.ko
May 27 17:46:50.441529 setup-nvidia[2416]:    Skipping BTF generation for /nvidia/NVIDIA-Linux-x86_64-535.230.02/kernel/nvidia-peermem.ko due to unavailability of vmlinux
May 27 17:46:50.441529 setup-nvidia[2416]:      BTF [M] /nvidia/NVIDIA-Linux-x86_64-535.230.02/kernel/nvidia-modeset.ko
May 27 17:46:50.441529 setup-nvidia[2416]:    Skipping BTF generation for /nvidia/NVIDIA-Linux-x86_64-535.230.02/kernel/nvidia-modeset.ko due to unavailability of vmlinux
May 27 17:46:50.441529 setup-nvidia[2416]:      BTF [M] /nvidia/NVIDIA-Linux-x86_64-535.230.02/kernel/nvidia-drm.ko
May 27 17:46:50.441529 setup-nvidia[2416]:    Skipping BTF generation for /nvidia/NVIDIA-Linux-x86_64-535.230.02/kernel/nvidia-drm.ko due to unavailability of vmlinux
May 27 17:46:50.441529 setup-nvidia[2416]:      BTF [M] /nvidia/NVIDIA-Linux-x86_64-535.230.02/kernel/nvidia-uvm.ko
May 27 17:46:50.441529 setup-nvidia[2416]:    Skipping BTF generation for /nvidia/NVIDIA-Linux-x86_64-535.230.02/kernel/nvidia-uvm.ko due to unavailability of vmlinux
May 27 17:46:50.441529 setup-nvidia[2416]:      BTF [M] /nvidia/NVIDIA-Linux-x86_64-535.230.02/kernel/nvidia.ko
May 27 17:46:50.441529 setup-nvidia[2416]:    Skipping BTF generation for /nvidia/NVIDIA-Linux-x86_64-535.230.02/kernel/nvidia.ko due to unavailability of vmlinux
May 27 17:46:50.441529 setup-nvidia[2416]:    make[2]: Leaving directory '/usr/lib/modules/6.12.30-flatcar/build'
May 27 17:46:50.441529 setup-nvidia[2416]:    make[1]: Leaving directory '/usr/lib/modules/6.12.30-flatcar/source'
May 27 17:46:50.441529 setup-nvidia[2416]: -> done.
May 27 17:46:50.441529 setup-nvidia[2416]: -> Kernel module compilation complete.
May 27 17:46:50.441529 setup-nvidia[2416]: -> Unable to determine if Secure Boot is enabled: No such file or directory
May 27 17:46:50.441529 setup-nvidia[2416]: 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 17:46:50.441529 setup-nvidia[2416]: \u000d
May 27 17:46:50.442699 setup-nvidia[2416]: 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 17:46:50.442699 setup-nvidia[2416]: -> Kernel module load error: Operation not permitted
May 27 17:46:50.442699 setup-nvidia[2416]: -> Kernel messages:
May 27 17:46:50.442699 setup-nvidia[2416]: 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 17:46:52.521442 systemd[1]: Started sshd@17-10.200.8.11:22-10.200.16.10:39514.service - OpenSSH per-connection server daemon (10.200.16.10:39514).
May 27 17:46:53.151603 sshd[12712]: Accepted publickey for core from 10.200.16.10 port 39514 ssh2: RSA SHA256:43KLdvDzM7BELJcS29r3hKkL8hXR8u1eeLIPzvzInuc
May 27 17:46:53.152949 sshd-session[12712]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0)
May 27 17:46:53.157248 systemd-logind[1886]: New session 20 of user core.
May 27 17:46:53.169176 systemd[1]: Started session-20.scope - Session 20 of User core.
May 27 17:46:53.595229 sshd[12714]: Connection closed by 10.200.16.10 port 39514
May 27 17:46:53.595603 sshd-session[12712]: pam_unix(sshd:session): session closed for user core
May 27 17:46:53.599114 systemd[1]: sshd@17-10.200.8.11:22-10.200.16.10:39514.service: Deactivated successfully.
May 27 17:46:53.600922 systemd[1]: session-20.scope: Deactivated successfully.
May 27 17:46:53.601647 systemd-logind[1886]: Session 20 logged out. Waiting for processes to exit.
May 27 17:46:53.602650 systemd-logind[1886]: Removed session 20.
May 27 17:46:53.709642 systemd[1]: Started sshd@18-10.200.8.11:22-10.200.16.10:39528.service - OpenSSH per-connection server daemon (10.200.16.10:39528).
May 27 17:46:54.338732 sshd[12720]: Accepted publickey for core from 10.200.16.10 port 39528 ssh2: RSA SHA256:43KLdvDzM7BELJcS29r3hKkL8hXR8u1eeLIPzvzInuc
May 27 17:46:54.340093 sshd-session[12720]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0)
May 27 17:46:54.344500 systemd-logind[1886]: New session 21 of user core.
May 27 17:46:54.358199 systemd[1]: Started session-21.scope - Session 21 of User core.
May 27 17:46:54.783771 sshd[12722]: Connection closed by 10.200.16.10 port 39528
May 27 17:46:54.784186 sshd-session[12720]: pam_unix(sshd:session): session closed for user core
May 27 17:46:54.787700 systemd[1]: sshd@18-10.200.8.11:22-10.200.16.10:39528.service: Deactivated successfully.
May 27 17:46:54.789296 systemd[1]: session-21.scope: Deactivated successfully.
May 27 17:46:54.789969 systemd-logind[1886]: Session 21 logged out. Waiting for processes to exit.
May 27 17:46:54.790929 systemd-logind[1886]: Removed session 21.
May 27 17:47:04.894228 systemd[1]: Started sshd@19-10.200.8.11:22-10.200.16.10:55852.service - OpenSSH per-connection server daemon (10.200.16.10:55852).
May 27 17:47:05.338065 kernel: EXT4-fs (loop6p9): unmounting filesystem dd441403-e7f4-4782-b932-a2370dfaea27.
May 27 17:47:05.338928 setup-nvidia[2416]: Container flatcardevelopercontainer-4344.0.0.bin exited successfully.
May 27 17:47:05.341030 systemd[1]: run-systemd-nspawn-unix\x2dexport-flatcardevelopercontainer\x2d4344.0.0.bin.mount: Deactivated successfully.
May 27 17:47:05.399919 sudo[2404]: pam_unix(sudo:session): session closed for user root
May 27 17:47:05.401831 systemd[1]: session-c2.scope: Deactivated successfully.
May 27 17:47:05.402124 systemd[1]: session-c2.scope: Consumed 5min 13.845s CPU time, 892.7M memory peak.
May 27 17:47:05.524069 sshd[12729]: Accepted publickey for core from 10.200.16.10 port 55852 ssh2: RSA SHA256:43KLdvDzM7BELJcS29r3hKkL8hXR8u1eeLIPzvzInuc
May 27 17:47:05.525452 sshd-session[12729]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0)
May 27 17:47:05.530361 systemd-logind[1886]: New session 22 of user core.
May 27 17:47:05.541225 systemd[1]: Started session-22.scope - Session 22 of User core.
May 27 17:47:05.830835 setup-nvidia[1876]: /opt/nvidia /
May 27 17:47:05.831830 setup-nvidia[1876]: /
May 27 17:47:05.842065 kernel: IPMI message handler: version 39.2
May 27 17:47:05.846062 kernel: ipmi device interface
May 27 17:47:05.858087 setup-nvidia[1876]: /opt/nvidia/current/usr/lib/modules/6.12.30-flatcar/video /
May 27 17:47:05.910348 kernel: nvidia: loading out-of-tree module taints kernel.
May 27 17:47:05.910476 kernel: nvidia: module license 'NVIDIA' taints kernel.
May 27 17:47:05.910499 kernel: Disabling lock debugging due to kernel taint
May 27 17:47:05.917684 kernel: nvidia: module verification failed: signature and/or required key missing - tainting kernel
May 27 17:47:05.917724 kernel: nvidia: module license taints kernel.
May 27 17:47:05.983975 sshd[12736]: Connection closed by 10.200.16.10 port 55852
May 27 17:47:05.984386 sshd-session[12729]: pam_unix(sshd:session): session closed for user core
May 27 17:47:05.987895 systemd[1]: sshd@19-10.200.8.11:22-10.200.16.10:55852.service: Deactivated successfully.
May 27 17:47:05.989507 systemd[1]: session-22.scope: Deactivated successfully.
May 27 17:47:05.990214 systemd-logind[1886]: Session 22 logged out. Waiting for processes to exit.
May 27 17:47:05.991175 systemd-logind[1886]: Removed session 22.
May 27 17:47:06.095542 systemd[1]: Started sshd@20-10.200.8.11:22-10.200.16.10:55862.service - OpenSSH per-connection server daemon (10.200.16.10:55862).
May 27 17:47:06.320077 kernel: nvidia-nvlink: Nvlink Core is being initialized, major device number 243
May 27 17:47:06.727243 kernel: 
May 27 17:47:06.727379 kernel: nvidia 0001:00:00.0: enabling device (0000 -> 0002)
May 27 17:47:06.745512 sshd[12762]: Accepted publickey for core from 10.200.16.10 port 55862 ssh2: RSA SHA256:43KLdvDzM7BELJcS29r3hKkL8hXR8u1eeLIPzvzInuc
May 27 17:47:06.746865 sshd-session[12762]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0)
May 27 17:47:06.751329 systemd-logind[1886]: New session 23 of user core.
May 27 17:47:06.763178 systemd[1]: Started session-23.scope - Session 23 of User core.
May 27 17:47:06.940066 kernel: NVRM: loading NVIDIA UNIX x86_64 Kernel Module  535.230.02  Fri Dec 20 21:42:05 UTC 2024
May 27 17:47:06.961074 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 17:47:06.983086 kernel: nvidia_uvm: module uses symbols nvUvmInterfaceDisableAccessCntr from proprietary module nvidia, inheriting taint.
May 27 17:47:07.030062 kernel: nvidia-uvm: Loaded the UVM driver, major device number 241.
May 27 17:47:07.030368 setup-nvidia[1876]: /
May 27 17:47:07.046299 setup-nvidia[12774]: ldconfig: /usr/lib/ld.so.conf is not an ELF file - it has the wrong magic bytes at the start.
May 27 17:47:07.206858 sshd[12766]: Connection closed by 10.200.16.10 port 55862
May 27 17:47:07.207254 sshd-session[12762]: pam_unix(sshd:session): session closed for user core
May 27 17:47:07.210773 systemd[1]: sshd@20-10.200.8.11:22-10.200.16.10:55862.service: Deactivated successfully.
May 27 17:47:07.212430 systemd[1]: session-23.scope: Deactivated successfully.
May 27 17:47:07.213140 systemd-logind[1886]: Session 23 logged out. Waiting for processes to exit.
May 27 17:47:07.214122 systemd-logind[1886]: Removed session 23.
May 27 17:47:08.820923 setup-nvidia[12792]: Tue May 27 17:47:08 2025
May 27 17:47:08.820923 setup-nvidia[12792]: +---------------------------------------------------------------------------------------+
May 27 17:47:08.820923 setup-nvidia[12792]: | NVIDIA-SMI 535.230.02             Driver Version: 535.230.02   CUDA Version: 12.2     |
May 27 17:47:08.820923 setup-nvidia[12792]: |-----------------------------------------+----------------------+----------------------+
May 27 17:47:08.820923 setup-nvidia[12792]: | GPU  Name                 Persistence-M | Bus-Id        Disp.A | Volatile Uncorr. ECC |
May 27 17:47:08.820923 setup-nvidia[12792]: | Fan  Temp   Perf          Pwr:Usage/Cap |         Memory-Usage | GPU-Util  Compute M. |
May 27 17:47:08.820923 setup-nvidia[12792]: |                                         |                      |               MIG M. |
May 27 17:47:08.820923 setup-nvidia[12792]: |=========================================+======================+======================|
May 27 17:47:08.824504 setup-nvidia[12792]: |   0  Tesla V100-PCIE-16GB           Off | 00000001:00:00.0 Off |                  Off |
May 27 17:47:08.824504 setup-nvidia[12792]: | N/A   25C    P0              37W / 250W |      0MiB / 16384MiB |      0%      Default |
May 27 17:47:08.824504 setup-nvidia[12792]: |                                         |                      |                  N/A |
May 27 17:47:08.824504 setup-nvidia[12792]: +-----------------------------------------+----------------------+----------------------+
May 27 17:47:08.824630 setup-nvidia[12792]:                                                                                          
May 27 17:47:08.824630 setup-nvidia[12792]: +---------------------------------------------------------------------------------------+
May 27 17:47:08.824630 setup-nvidia[12792]: | Processes:                                                                            |
May 27 17:47:08.824630 setup-nvidia[12792]: |  GPU   GI   CI        PID   Type   Process name                            GPU Memory |
May 27 17:47:08.824630 setup-nvidia[12792]: |        ID   ID                                                             Usage      |
May 27 17:47:08.824630 setup-nvidia[12792]: |=======================================================================================|
May 27 17:47:08.824759 setup-nvidia[12792]: |  No running processes found                                                           |
May 27 17:47:08.824759 setup-nvidia[12792]: +---------------------------------------------------------------------------------------+
May 27 17:47:09.200392 systemd[1]: Finished nvidia.service - NVIDIA Configure Service.
May 27 17:47:09.201004 systemd[1]: Reached target multi-user.target - Multi-User System.
May 27 17:47:09.202124 systemd[1]: Startup finished in 1.221s (firmware) + 30.391s (loader) + 3.840s (kernel) + 11.467s (initrd) + 2min 44.274s (userspace) = 3min 31.196s.
May 27 17:47:15.417727 systemd[1]: Stopping user@0.service - User Manager for UID 0...
May 27 17:47:15.418562 systemd[2407]: Activating special unit exit.target...
May 27 17:47:15.418647 systemd[2407]: Stopped target default.target - Main User Target.
May 27 17:47:15.418686 systemd[2407]: Stopped target basic.target - Basic System.
May 27 17:47:15.418714 systemd[2407]: Stopped target paths.target - Paths.
May 27 17:47:15.418740 systemd[2407]: Stopped target sockets.target - Sockets.
May 27 17:47:15.418771 systemd[2407]: Stopped target timers.target - Timers.
May 27 17:47:15.419137 systemd[2407]: Closed dbus.socket - D-Bus User Message Bus Socket.
May 27 17:47:15.419343 systemd[2407]: Removed slice app.slice - User Application Slice.
May 27 17:47:15.419375 systemd[2407]: Reached target shutdown.target - Shutdown.
May 27 17:47:15.419517 systemd[2407]: Finished systemd-exit.service - Exit the Session.
May 27 17:47:15.419553 systemd[2407]: Reached target exit.target - Exit the Session.
May 27 17:47:15.441159 (sd-pam)[2408]: pam_unix(systemd-user:session): session closed for user root
May 27 17:47:15.442479 systemd[1]: user@0.service: Deactivated successfully.
May 27 17:47:15.442844 systemd[1]: Stopped user@0.service - User Manager for UID 0.
May 27 17:47:15.445134 systemd[1]: Stopping user-runtime-dir@0.service - User Runtime Directory /run/user/0...
May 27 17:47:15.467396 systemd[1]: run-user-0.mount: Deactivated successfully.
May 27 17:47:15.468387 systemd[1]: user-runtime-dir@0.service: Deactivated successfully.
May 27 17:47:15.468594 systemd[1]: Stopped user-runtime-dir@0.service - User Runtime Directory /run/user/0.
May 27 17:47:15.470358 systemd[1]: Removed slice user-0.slice - User Slice of UID 0.
May 27 17:47:15.470451 systemd[1]: user-0.slice: Consumed 5min 14.124s CPU time, 901.8M memory peak.
May 27 17:47:15.470865 systemd-logind[1886]: Removed session c3.
May 27 17:47:17.322605 systemd[1]: Started sshd@21-10.200.8.11:22-10.200.16.10:33370.service - OpenSSH per-connection server daemon (10.200.16.10:33370).
May 27 17:47:17.968817 sshd[12806]: Accepted publickey for core from 10.200.16.10 port 33370 ssh2: RSA SHA256:43KLdvDzM7BELJcS29r3hKkL8hXR8u1eeLIPzvzInuc
May 27 17:47:19.101817 sshd-session[12806]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0)
May 27 17:47:19.106269 systemd-logind[1886]: New session 24 of user core.
May 27 17:47:19.120179 systemd[1]: Started session-24.scope - Session 24 of User core.
May 27 17:47:19.472699 sshd[12808]: Connection closed by 10.200.16.10 port 33370
May 27 17:47:19.473110 sshd-session[12806]: pam_unix(sshd:session): session closed for user core
May 27 17:47:19.476598 systemd[1]: sshd@21-10.200.8.11:22-10.200.16.10:33370.service: Deactivated successfully.
May 27 17:47:19.478391 systemd[1]: session-24.scope: Deactivated successfully.
May 27 17:47:19.479075 systemd-logind[1886]: Session 24 logged out. Waiting for processes to exit.
May 27 17:47:19.480005 systemd-logind[1886]: Removed session 24.
May 27 17:47:19.587558 systemd[1]: Started sshd@22-10.200.8.11:22-10.200.16.10:36102.service - OpenSSH per-connection server daemon (10.200.16.10:36102).
May 27 17:47:20.241502 sshd[12814]: Accepted publickey for core from 10.200.16.10 port 36102 ssh2: RSA SHA256:43KLdvDzM7BELJcS29r3hKkL8hXR8u1eeLIPzvzInuc
May 27 17:47:20.244702 sshd-session[12814]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0)
May 27 17:47:20.249066 systemd-logind[1886]: New session 25 of user core.
May 27 17:47:20.256222 systemd[1]: Started session-25.scope - Session 25 of User core.
May 27 17:47:20.681122 sshd[12816]: Connection closed by 10.200.16.10 port 36102
May 27 17:47:20.681481 sshd-session[12814]: pam_unix(sshd:session): session closed for user core
May 27 17:47:20.684844 systemd[1]: sshd@22-10.200.8.11:22-10.200.16.10:36102.service: Deactivated successfully.
May 27 17:47:20.686454 systemd[1]: session-25.scope: Deactivated successfully.
May 27 17:47:20.687119 systemd-logind[1886]: Session 25 logged out. Waiting for processes to exit.
May 27 17:47:20.688055 systemd-logind[1886]: Removed session 25.
May 27 17:47:20.798244 systemd[1]: Started sshd@23-10.200.8.11:22-10.200.16.10:36110.service - OpenSSH per-connection server daemon (10.200.16.10:36110).
May 27 17:47:21.454337 sshd[12822]: Accepted publickey for core from 10.200.16.10 port 36110 ssh2: RSA SHA256:43KLdvDzM7BELJcS29r3hKkL8hXR8u1eeLIPzvzInuc
May 27 17:47:21.455682 sshd-session[12822]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0)
May 27 17:47:21.464841 systemd-logind[1886]: New session 26 of user core.
May 27 17:47:21.481188 systemd[1]: Started session-26.scope - Session 26 of User core.
May 27 17:47:21.917529 sshd[12824]: Connection closed by 10.200.16.10 port 36110
May 27 17:47:21.917916 sshd-session[12822]: pam_unix(sshd:session): session closed for user core
May 27 17:47:21.921314 systemd[1]: sshd@23-10.200.8.11:22-10.200.16.10:36110.service: Deactivated successfully.
May 27 17:47:21.922916 systemd[1]: session-26.scope: Deactivated successfully.
May 27 17:47:21.923583 systemd-logind[1886]: Session 26 logged out. Waiting for processes to exit.
May 27 17:47:21.924596 systemd-logind[1886]: Removed session 26.
May 27 17:47:22.039387 systemd[1]: Started sshd@24-10.200.8.11:22-10.200.16.10:36124.service - OpenSSH per-connection server daemon (10.200.16.10:36124).
May 27 17:47:22.693013 sshd[12830]: Accepted publickey for core from 10.200.16.10 port 36124 ssh2: RSA SHA256:43KLdvDzM7BELJcS29r3hKkL8hXR8u1eeLIPzvzInuc
May 27 17:47:22.694478 sshd-session[12830]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0)
May 27 17:47:22.698780 systemd-logind[1886]: New session 27 of user core.
May 27 17:47:22.715160 systemd[1]: Started session-27.scope - Session 27 of User core.
May 27 17:47:23.139438 sshd[12832]: Connection closed by 10.200.16.10 port 36124
May 27 17:47:23.139796 sshd-session[12830]: pam_unix(sshd:session): session closed for user core
May 27 17:47:23.143614 systemd[1]: sshd@24-10.200.8.11:22-10.200.16.10:36124.service: Deactivated successfully.
May 27 17:47:23.145211 systemd[1]: session-27.scope: Deactivated successfully.
May 27 17:47:23.145865 systemd-logind[1886]: Session 27 logged out. Waiting for processes to exit.
May 27 17:47:23.146822 systemd-logind[1886]: Removed session 27.
May 27 17:47:23.253434 systemd[1]: Started sshd@25-10.200.8.11:22-10.200.16.10:36134.service - OpenSSH per-connection server daemon (10.200.16.10:36134).
May 27 17:47:23.907322 sshd[12838]: Accepted publickey for core from 10.200.16.10 port 36134 ssh2: RSA SHA256:43KLdvDzM7BELJcS29r3hKkL8hXR8u1eeLIPzvzInuc
May 27 17:47:23.908706 sshd-session[12838]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0)
May 27 17:47:23.913051 systemd-logind[1886]: New session 28 of user core.
May 27 17:47:23.922162 systemd[1]: Started session-28.scope - Session 28 of User core.
May 27 17:47:25.857810 sshd[12840]: Connection closed by 10.200.16.10 port 36134
May 27 17:47:25.858202 sshd-session[12838]: pam_unix(sshd:session): session closed for user core
May 27 17:47:25.861768 systemd[1]: sshd@25-10.200.8.11:22-10.200.16.10:36134.service: Deactivated successfully.
May 27 17:47:25.863343 systemd[1]: session-28.scope: Deactivated successfully.
May 27 17:47:25.863540 systemd[1]: session-28.scope: Consumed 1.447s CPU time, 14M memory peak.
May 27 17:47:25.864011 systemd-logind[1886]: Session 28 logged out. Waiting for processes to exit.
May 27 17:47:25.865006 systemd-logind[1886]: Removed session 28.