Jul 23 00:12:32.204043 kernel: Linux version 6.12.96-flatcar (build@pony-truck.infra.kinvolk.io) (x86_64-cros-linux-gnu-gcc (Gentoo Hardened 15.2.1_p20260214 p5) 15.2.1 20260214, GNU ld (Gentoo 2.46.0 p1) 2.46.0) #1 SMP PREEMPT_DYNAMIC Wed Jul 22 21:58:32 -00 2026 Jul 23 00:12:32.204096 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=b90158b1b2baf5c0229b46ffa5bef3adacc5885f2f4f58b3368133b082ab2095 Jul 23 00:12:32.204110 kernel: BIOS-provided physical RAM map: Jul 23 00:12:32.204117 kernel: BIOS-e820: [mem 0x0000000000000000-0x000000000009ffff] usable Jul 23 00:12:32.204128 kernel: BIOS-e820: [mem 0x00000000000c0000-0x00000000000fffff] reserved Jul 23 00:12:32.204138 kernel: BIOS-e820: [mem 0x0000000000100000-0x00000000044fdfff] usable Jul 23 00:12:32.204147 kernel: BIOS-e820: [mem 0x00000000044fe000-0x00000000048fdfff] reserved Jul 23 00:12:32.204157 kernel: BIOS-e820: [mem 0x00000000048fe000-0x000000003ff1efff] usable Jul 23 00:12:32.204167 kernel: BIOS-e820: [mem 0x000000003ff1f000-0x000000003ffc8fff] reserved Jul 23 00:12:32.204175 kernel: BIOS-e820: [mem 0x000000003ffc9000-0x000000003fffafff] ACPI data Jul 23 00:12:32.204185 kernel: BIOS-e820: [mem 0x000000003fffb000-0x000000003fffefff] ACPI NVS Jul 23 00:12:32.204194 kernel: BIOS-e820: [mem 0x000000003ffff000-0x000000003fffffff] usable Jul 23 00:12:32.204202 kernel: BIOS-e820: [mem 0x0000000100000000-0x00000002bfffffff] usable Jul 23 00:12:32.204211 kernel: printk: legacy bootconsole [earlyser0] enabled Jul 23 00:12:32.204223 kernel: NX (Execute Disable) protection: active Jul 23 00:12:32.204231 kernel: APIC: Static calls initialized Jul 23 00:12:32.204239 kernel: efi: EFI v2.7 by Microsoft Jul 23 00:12:32.204251 kernel: efi: ACPI=0x3fffa000 ACPI 2.0=0x3fffa014 SMBIOS=0x3ff88000 SMBIOS 3.0=0x3ff86000 MEMATTR=0x3ea8c698 RNG=0x3ffd2018 Jul 23 00:12:32.204259 kernel: random: crng init done Jul 23 00:12:32.204269 kernel: secureboot: Secure boot disabled Jul 23 00:12:32.204280 kernel: SMBIOS 3.1.0 present. Jul 23 00:12:32.204291 kernel: DMI: Microsoft Corporation Virtual Machine/Virtual Machine, BIOS Hyper-V UEFI Release v4.1 04/22/2026 Jul 23 00:12:32.204301 kernel: DMI: Memory slots populated: 2/2 Jul 23 00:12:32.204311 kernel: Hypervisor detected: Microsoft Hyper-V Jul 23 00:12:32.204322 kernel: Hyper-V: privilege flags low 0xae7f, high 0x3b8030, hints 0x9e4e24, misc 0xe0bed7b2 Jul 23 00:12:32.204332 kernel: Hyper-V: Nested features: 0x3e0101 Jul 23 00:12:32.204340 kernel: Hyper-V: LAPIC Timer Frequency: 0x30d40 Jul 23 00:12:32.204350 kernel: Hyper-V: Using hypercall for remote TLB flush Jul 23 00:12:32.204362 kernel: clocksource: hyperv_clocksource_tsc_page: mask: 0xffffffffffffffff max_cycles: 0x24e6a1710, max_idle_ns: 440795202120 ns Jul 23 00:12:32.204373 kernel: clocksource: hyperv_clocksource_msr: mask: 0xffffffffffffffff max_cycles: 0x24e6a1710, max_idle_ns: 440795202120 ns Jul 23 00:12:32.204383 kernel: tsc: Detected 2300.000 MHz processor Jul 23 00:12:32.204394 kernel: e820: update [mem 0x00000000-0x00000fff] usable ==> reserved Jul 23 00:12:32.204412 kernel: e820: remove [mem 0x000a0000-0x000fffff] usable Jul 23 00:12:32.206498 kernel: last_pfn = 0x2c0000 max_arch_pfn = 0x10000000000 Jul 23 00:12:32.206518 kernel: MTRR map: 4 entries (2 fixed + 2 variable; max 18), built from 8 variable MTRRs Jul 23 00:12:32.206533 kernel: x86/PAT: Configuration [0-7]: WB WC UC- UC WB WP UC- WT Jul 23 00:12:32.206549 kernel: e820: update [mem 0x48000000-0xffffffff] usable ==> reserved Jul 23 00:12:32.206562 kernel: last_pfn = 0x40000 max_arch_pfn = 0x10000000000 Jul 23 00:12:32.206576 kernel: Using GB pages for direct mapping Jul 23 00:12:32.206590 kernel: ACPI: Early table checksum verification disabled Jul 23 00:12:32.206604 kernel: ACPI: RSDP 0x000000003FFFA014 000024 (v02 VRTUAL) Jul 23 00:12:32.206617 kernel: ACPI: XSDT 0x000000003FFF90E8 00005C (v01 VRTUAL MICROSFT 00000001 MSFT 00000001) Jul 23 00:12:32.206631 kernel: ACPI: FACP 0x000000003FFF8000 000114 (v06 VRTUAL MICROSFT 00000001 MSFT 00000001) Jul 23 00:12:32.206647 kernel: ACPI: DSDT 0x000000003FFD6000 01E22B (v02 MSFTVM DSDT01 00000001 INTL 20230628) Jul 23 00:12:32.206660 kernel: ACPI: FACS 0x000000003FFFE000 000040 Jul 23 00:12:32.206677 kernel: ACPI: OEM0 0x000000003FFF7000 000064 (v01 VRTUAL MICROSFT 00000001 MSFT 00000001) Jul 23 00:12:32.206689 kernel: ACPI: SPCR 0x000000003FFF6000 000050 (v02 VRTUAL MICROSFT 00000001 MSFT 00000001) Jul 23 00:12:32.206703 kernel: ACPI: WAET 0x000000003FFF5000 000028 (v01 VRTUAL MICROSFT 00000001 MSFT 00000001) Jul 23 00:12:32.206719 kernel: ACPI: APIC 0x000000003FFD5000 000058 (v05 HVLITE HVLITETB 00000000 MSHV 00000000) Jul 23 00:12:32.206733 kernel: ACPI: SRAT 0x000000003FFD4000 0000A0 (v03 HVLITE HVLITETB 00000000 MSHV 00000000) Jul 23 00:12:32.206747 kernel: ACPI: BGRT 0x000000003FFD3000 000038 (v01 VRTUAL MICROSFT 00000001 MSFT 00000001) Jul 23 00:12:32.206766 kernel: ACPI: Reserving FACP table memory at [mem 0x3fff8000-0x3fff8113] Jul 23 00:12:32.206777 kernel: ACPI: Reserving DSDT table memory at [mem 0x3ffd6000-0x3fff422a] Jul 23 00:12:32.206785 kernel: ACPI: Reserving FACS table memory at [mem 0x3fffe000-0x3fffe03f] Jul 23 00:12:32.206799 kernel: ACPI: Reserving OEM0 table memory at [mem 0x3fff7000-0x3fff7063] Jul 23 00:12:32.206813 kernel: ACPI: Reserving SPCR table memory at [mem 0x3fff6000-0x3fff604f] Jul 23 00:12:32.206826 kernel: ACPI: Reserving WAET table memory at [mem 0x3fff5000-0x3fff5027] Jul 23 00:12:32.206839 kernel: ACPI: Reserving APIC table memory at [mem 0x3ffd5000-0x3ffd5057] Jul 23 00:12:32.206850 kernel: ACPI: Reserving SRAT table memory at [mem 0x3ffd4000-0x3ffd409f] Jul 23 00:12:32.207863 kernel: ACPI: Reserving BGRT table memory at [mem 0x3ffd3000-0x3ffd3037] Jul 23 00:12:32.207883 kernel: ACPI: SRAT: Node 0 PXM 0 [mem 0x00000000-0x3fffffff] Jul 23 00:12:32.207895 kernel: ACPI: SRAT: Node 0 PXM 0 [mem 0x100000000-0x2bfffffff] Jul 23 00:12:32.207910 kernel: NUMA: Node 0 [mem 0x00001000-0x3fffffff] + [mem 0x100000000-0x2bfffffff] -> [mem 0x00001000-0x2bfffffff] Jul 23 00:12:32.207919 kernel: NODE_DATA(0) allocated [mem 0x2bfff6dc0-0x2bfffdfff] Jul 23 00:12:32.207927 kernel: Zone ranges: Jul 23 00:12:32.207939 kernel: DMA [mem 0x0000000000001000-0x0000000000ffffff] Jul 23 00:12:32.207952 kernel: DMA32 [mem 0x0000000001000000-0x00000000ffffffff] Jul 23 00:12:32.207963 kernel: Normal [mem 0x0000000100000000-0x00000002bfffffff] Jul 23 00:12:32.207973 kernel: Device empty Jul 23 00:12:32.207988 kernel: Movable zone start for each node Jul 23 00:12:32.207996 kernel: Early memory node ranges Jul 23 00:12:32.208007 kernel: node 0: [mem 0x0000000000001000-0x000000000009ffff] Jul 23 00:12:32.208019 kernel: node 0: [mem 0x0000000000100000-0x00000000044fdfff] Jul 23 00:12:32.208030 kernel: node 0: [mem 0x00000000048fe000-0x000000003ff1efff] Jul 23 00:12:32.208041 kernel: node 0: [mem 0x000000003ffff000-0x000000003fffffff] Jul 23 00:12:32.208051 kernel: node 0: [mem 0x0000000100000000-0x00000002bfffffff] Jul 23 00:12:32.208060 kernel: Initmem setup node 0 [mem 0x0000000000001000-0x00000002bfffffff] Jul 23 00:12:32.208073 kernel: On node 0, zone DMA: 1 pages in unavailable ranges Jul 23 00:12:32.208083 kernel: On node 0, zone DMA: 96 pages in unavailable ranges Jul 23 00:12:32.208091 kernel: On node 0, zone DMA32: 1024 pages in unavailable ranges Jul 23 00:12:32.208102 kernel: On node 0, zone DMA32: 224 pages in unavailable ranges Jul 23 00:12:32.208113 kernel: ACPI: PM-Timer IO Port: 0x408 Jul 23 00:12:32.208123 kernel: ACPI: LAPIC_NMI (acpi_id[0x01] dfl dfl lint[0x1]) Jul 23 00:12:32.208133 kernel: IOAPIC[0]: apic_id 0, version 17, address 0xfec00000, GSI 0-23 Jul 23 00:12:32.208141 kernel: ACPI: INT_SRC_OVR (bus 0 bus_irq 9 global_irq 9 high level) Jul 23 00:12:32.208150 kernel: ACPI: Using ACPI (MADT) for SMP configuration information Jul 23 00:12:32.208161 kernel: ACPI: SPCR: console: uart,io,0x3f8,115200 Jul 23 00:12:32.208168 kernel: TSC deadline timer available Jul 23 00:12:32.208178 kernel: CPU topo: Max. logical packages: 1 Jul 23 00:12:32.208284 kernel: CPU topo: Max. logical dies: 1 Jul 23 00:12:32.208294 kernel: CPU topo: Max. dies per package: 1 Jul 23 00:12:32.208302 kernel: CPU topo: Max. threads per core: 2 Jul 23 00:12:32.208316 kernel: CPU topo: Num. cores per package: 1 Jul 23 00:12:32.208328 kernel: CPU topo: Num. threads per package: 2 Jul 23 00:12:32.208337 kernel: CPU topo: Allowing 2 present CPUs plus 0 hotplug CPUs Jul 23 00:12:32.208344 kernel: [mem 0x40000000-0xffffffff] available for PCI devices Jul 23 00:12:32.208352 kernel: Booting paravirtualized kernel on Hyper-V Jul 23 00:12:32.208362 kernel: clocksource: refined-jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1910969940391419 ns Jul 23 00:12:32.208370 kernel: setup_percpu: NR_CPUS:512 nr_cpumask_bits:2 nr_cpu_ids:2 nr_node_ids:1 Jul 23 00:12:32.208380 kernel: percpu: Embedded 60 pages/cpu s208472 r8192 d29096 u1048576 Jul 23 00:12:32.208390 kernel: pcpu-alloc: s208472 r8192 d29096 u1048576 alloc=1*2097152 Jul 23 00:12:32.208398 kernel: pcpu-alloc: [0] 0 1 Jul 23 00:12:32.208405 kernel: Hyper-V: PV spinlocks enabled Jul 23 00:12:32.208413 kernel: PV qspinlock hash table entries: 256 (order: 0, 4096 bytes, linear) Jul 23 00:12:32.208440 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=b90158b1b2baf5c0229b46ffa5bef3adacc5885f2f4f58b3368133b082ab2095 Jul 23 00:12:32.208455 kernel: Dentry cache hash table entries: 1048576 (order: 11, 8388608 bytes, linear) Jul 23 00:12:32.208463 kernel: Inode-cache hash table entries: 524288 (order: 10, 4194304 bytes, linear) Jul 23 00:12:32.208471 kernel: Fallback order for Node 0: 0 Jul 23 00:12:32.208479 kernel: Built 1 zonelists, mobility grouping on. Total pages: 2095807 Jul 23 00:12:32.208486 kernel: Policy zone: Normal Jul 23 00:12:32.208496 kernel: mem auto-init: stack:off, heap alloc:off, heap free:off Jul 23 00:12:32.208505 kernel: software IO TLB: area num 2. Jul 23 00:12:32.208512 kernel: SLUB: HWalign=64, Order=0-3, MinObjects=0, CPUs=2, Nodes=1 Jul 23 00:12:32.208520 kernel: ftrace: allocating 41407 entries in 164 pages Jul 23 00:12:32.208525 kernel: ftrace: allocated 164 pages with 3 groups Jul 23 00:12:32.208533 kernel: Dynamic Preempt: voluntary Jul 23 00:12:32.208538 kernel: rcu: Preemptible hierarchical RCU implementation. Jul 23 00:12:32.208545 kernel: rcu: RCU event tracing is enabled. Jul 23 00:12:32.208558 kernel: rcu: RCU restricting CPUs from NR_CPUS=512 to nr_cpu_ids=2. Jul 23 00:12:32.208564 kernel: Trampoline variant of Tasks RCU enabled. Jul 23 00:12:32.208571 kernel: Rude variant of Tasks RCU enabled. Jul 23 00:12:32.208576 kernel: Tracing variant of Tasks RCU enabled. Jul 23 00:12:32.208582 kernel: rcu: RCU calculated value of scheduler-enlistment delay is 100 jiffies. Jul 23 00:12:32.208598 kernel: rcu: Adjusting geometry for rcu_fanout_leaf=16, nr_cpu_ids=2 Jul 23 00:12:32.208607 kernel: RCU Tasks: Setting shift to 1 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=2. Jul 23 00:12:32.208615 kernel: RCU Tasks Rude: Setting shift to 1 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=2. Jul 23 00:12:32.208624 kernel: RCU Tasks Trace: Setting shift to 1 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=2. Jul 23 00:12:32.208635 kernel: Using NULL legacy PIC Jul 23 00:12:32.208643 kernel: NR_IRQS: 33024, nr_irqs: 440, preallocated irqs: 0 Jul 23 00:12:32.208652 kernel: rcu: srcu_init: Setting srcu_struct sizes based on contention. Jul 23 00:12:32.208661 kernel: Console: colour dummy device 80x25 Jul 23 00:12:32.208671 kernel: printk: legacy console [tty1] enabled Jul 23 00:12:32.208680 kernel: printk: legacy console [ttyS0] enabled Jul 23 00:12:32.208689 kernel: printk: legacy bootconsole [earlyser0] disabled Jul 23 00:12:32.208698 kernel: ACPI: Core revision 20240827 Jul 23 00:12:32.208710 kernel: Failed to register legacy timer interrupt Jul 23 00:12:32.208721 kernel: APIC: Switch to symmetric I/O mode setup Jul 23 00:12:32.208729 kernel: x2apic enabled Jul 23 00:12:32.208741 kernel: APIC: Switched APIC routing to: physical x2apic Jul 23 00:12:32.208752 kernel: Hyper-V: Host Build 10.0.26102.1376-1-0 Jul 23 00:12:32.208760 kernel: Hyper-V: enabling crash_kexec_post_notifiers Jul 23 00:12:32.208769 kernel: Hyper-V: Disabling IBT because of Hyper-V bug Jul 23 00:12:32.208778 kernel: Hyper-V: Using IPI hypercalls Jul 23 00:12:32.208788 kernel: APIC: send_IPI() replaced with hv_send_ipi() Jul 23 00:12:32.208797 kernel: APIC: send_IPI_mask() replaced with hv_send_ipi_mask() Jul 23 00:12:32.208809 kernel: APIC: send_IPI_mask_allbutself() replaced with hv_send_ipi_mask_allbutself() Jul 23 00:12:32.208818 kernel: APIC: send_IPI_allbutself() replaced with hv_send_ipi_allbutself() Jul 23 00:12:32.208827 kernel: APIC: send_IPI_all() replaced with hv_send_ipi_all() Jul 23 00:12:32.208839 kernel: APIC: send_IPI_self() replaced with hv_send_ipi_self() Jul 23 00:12:32.208848 kernel: clocksource: tsc-early: mask: 0xffffffffffffffff max_cycles: 0x212735223b2, max_idle_ns: 440795277976 ns Jul 23 00:12:32.208857 kernel: Calibrating delay loop (skipped), value calculated using timer frequency.. 4600.00 BogoMIPS (lpj=2300000) Jul 23 00:12:32.208867 kernel: x86/cpu: User Mode Instruction Prevention (UMIP) activated Jul 23 00:12:32.208878 kernel: Last level iTLB entries: 4KB 0, 2MB 0, 4MB 0 Jul 23 00:12:32.208887 kernel: Last level dTLB entries: 4KB 0, 2MB 0, 4MB 0, 1GB 0 Jul 23 00:12:32.208896 kernel: Spectre V1 : Mitigation: usercopy/swapgs barriers and __user pointer sanitization Jul 23 00:12:32.208905 kernel: Spectre V2 : Mitigation: Retpolines Jul 23 00:12:32.208913 kernel: Spectre V2 : Spectre v2 / SpectreRSB: Filling RSB on context switch and VMEXIT Jul 23 00:12:32.208923 kernel: RETBleed: WARNING: Spectre v2 mitigation leaves CPU vulnerable to RETBleed attacks, data leaks possible! Jul 23 00:12:32.208932 kernel: RETBleed: Vulnerable Jul 23 00:12:32.208943 kernel: Speculative Store Bypass: Vulnerable Jul 23 00:12:32.208951 kernel: active return thunk: its_return_thunk Jul 23 00:12:32.208960 kernel: ITS: Mitigation: Aligned branch/return thunks Jul 23 00:12:32.208969 kernel: x86/fpu: Supporting XSAVE feature 0x001: 'x87 floating point registers' Jul 23 00:12:32.208977 kernel: x86/fpu: Supporting XSAVE feature 0x002: 'SSE registers' Jul 23 00:12:32.208985 kernel: x86/fpu: Supporting XSAVE feature 0x004: 'AVX registers' Jul 23 00:12:32.208994 kernel: x86/fpu: Supporting XSAVE feature 0x020: 'AVX-512 opmask' Jul 23 00:12:32.209002 kernel: x86/fpu: Supporting XSAVE feature 0x040: 'AVX-512 Hi256' Jul 23 00:12:32.209010 kernel: x86/fpu: Supporting XSAVE feature 0x080: 'AVX-512 ZMM_Hi256' Jul 23 00:12:32.209019 kernel: x86/fpu: Supporting XSAVE feature 0x800: 'Control-flow User registers' Jul 23 00:12:32.209028 kernel: x86/fpu: Supporting XSAVE feature 0x20000: 'AMX Tile config' Jul 23 00:12:32.209036 kernel: x86/fpu: Supporting XSAVE feature 0x40000: 'AMX Tile data' Jul 23 00:12:32.209045 kernel: x86/fpu: xstate_offset[2]: 576, xstate_sizes[2]: 256 Jul 23 00:12:32.209054 kernel: x86/fpu: xstate_offset[5]: 832, xstate_sizes[5]: 64 Jul 23 00:12:32.209062 kernel: x86/fpu: xstate_offset[6]: 896, xstate_sizes[6]: 512 Jul 23 00:12:32.209071 kernel: x86/fpu: xstate_offset[7]: 1408, xstate_sizes[7]: 1024 Jul 23 00:12:32.209079 kernel: x86/fpu: xstate_offset[11]: 2432, xstate_sizes[11]: 16 Jul 23 00:12:32.209087 kernel: x86/fpu: xstate_offset[17]: 2496, xstate_sizes[17]: 64 Jul 23 00:12:32.209095 kernel: x86/fpu: xstate_offset[18]: 2560, xstate_sizes[18]: 8192 Jul 23 00:12:32.209103 kernel: x86/fpu: Enabled xstate features 0x608e7, context size is 10752 bytes, using 'compacted' format. Jul 23 00:12:32.209112 kernel: Freeing SMP alternatives memory: 36K Jul 23 00:12:32.209120 kernel: pid_max: default: 32768 minimum: 301 Jul 23 00:12:32.209129 kernel: LSM: initializing lsm=lockdown,capability,landlock,selinux,ima Jul 23 00:12:32.209137 kernel: landlock: Up and running. Jul 23 00:12:32.209147 kernel: SELinux: Initializing. Jul 23 00:12:32.209156 kernel: Mount-cache hash table entries: 16384 (order: 5, 131072 bytes, linear) Jul 23 00:12:32.209165 kernel: Mountpoint-cache hash table entries: 16384 (order: 5, 131072 bytes, linear) Jul 23 00:12:32.209174 kernel: smpboot: CPU0: Intel INTEL(R) XEON(R) PLATINUM 8573C (family: 0x6, model: 0xcf, stepping: 0x2) Jul 23 00:12:32.209184 kernel: Performance Events: unsupported p6 CPU model 207 no PMU driver, software events only. Jul 23 00:12:32.209193 kernel: signal: max sigframe size: 11952 Jul 23 00:12:32.209205 kernel: rcu: Hierarchical SRCU implementation. Jul 23 00:12:32.209215 kernel: rcu: Max phase no-delay instances is 400. Jul 23 00:12:32.209226 kernel: Timer migration: 1 hierarchy levels; 8 children per group; 1 crossnode level Jul 23 00:12:32.209235 kernel: NMI watchdog: Perf NMI watchdog permanently disabled Jul 23 00:12:32.209244 kernel: smp: Bringing up secondary CPUs ... Jul 23 00:12:32.209254 kernel: smpboot: x86: Booting SMP configuration: Jul 23 00:12:32.209264 kernel: .... node #0, CPUs: #1 Jul 23 00:12:32.209272 kernel: smp: Brought up 1 node, 2 CPUs Jul 23 00:12:32.209281 kernel: smpboot: Total of 2 processors activated (9200.00 BogoMIPS) Jul 23 00:12:32.209292 kernel: Memory: 8073636K/8383228K available (14336K kernel code, 2475K rwdata, 32648K rodata, 16068K init, 1980K bss, 303588K reserved, 0K cma-reserved) Jul 23 00:12:32.209303 kernel: devtmpfs: initialized Jul 23 00:12:32.209312 kernel: x86/mm: Memory block size: 128MB Jul 23 00:12:32.209321 kernel: ACPI: PM: Registering ACPI NVS region [mem 0x3fffb000-0x3fffefff] (16384 bytes) Jul 23 00:12:32.209330 kernel: clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1911260446275000 ns Jul 23 00:12:32.209338 kernel: futex hash table entries: 512 (order: 3, 32768 bytes, linear) Jul 23 00:12:32.209347 kernel: pinctrl core: initialized pinctrl subsystem Jul 23 00:12:32.209355 kernel: NET: Registered PF_NETLINK/PF_ROUTE protocol family Jul 23 00:12:32.209366 kernel: audit: initializing netlink subsys (disabled) Jul 23 00:12:32.209375 kernel: audit: type=2000 audit(1784765545.071:1): state=initialized audit_enabled=0 res=1 Jul 23 00:12:32.209384 kernel: thermal_sys: Registered thermal governor 'step_wise' Jul 23 00:12:32.209393 kernel: thermal_sys: Registered thermal governor 'user_space' Jul 23 00:12:32.209402 kernel: cpuidle: using governor menu Jul 23 00:12:32.209411 kernel: efi: Freeing EFI boot services memory: 19980K Jul 23 00:12:32.209419 kernel: acpiphp: ACPI Hot Plug PCI Controller Driver version: 0.5 Jul 23 00:12:32.209468 kernel: dca service started, version 1.12.1 Jul 23 00:12:32.209478 kernel: e820: reserve RAM buffer [mem 0x044fe000-0x07ffffff] Jul 23 00:12:32.209485 kernel: e820: reserve RAM buffer [mem 0x3ff1f000-0x3fffffff] Jul 23 00:12:32.209491 kernel: kprobes: kprobe jump-optimization is enabled. All kprobes are optimized if possible. Jul 23 00:12:32.209497 kernel: HugeTLB: registered 1.00 GiB page size, pre-allocated 0 pages Jul 23 00:12:32.209503 kernel: HugeTLB: 16380 KiB vmemmap can be freed for a 1.00 GiB page Jul 23 00:12:32.209509 kernel: HugeTLB: registered 2.00 MiB page size, pre-allocated 0 pages Jul 23 00:12:32.209519 kernel: HugeTLB: 28 KiB vmemmap can be freed for a 2.00 MiB page Jul 23 00:12:32.209525 kernel: ACPI: Added _OSI(Module Device) Jul 23 00:12:32.209530 kernel: ACPI: Added _OSI(Processor Device) Jul 23 00:12:32.209536 kernel: ACPI: Added _OSI(Processor Aggregator Device) Jul 23 00:12:32.209542 kernel: ACPI: 1 ACPI AML tables successfully acquired and loaded Jul 23 00:12:32.209548 kernel: ACPI: Interpreter enabled Jul 23 00:12:32.209554 kernel: ACPI: PM: (supports S0 S5) Jul 23 00:12:32.209561 kernel: ACPI: Using IOAPIC for interrupt routing Jul 23 00:12:32.209566 kernel: PCI: Using host bridge windows from ACPI; if necessary, use "pci=nocrs" and report a bug Jul 23 00:12:32.209572 kernel: PCI: Ignoring E820 reservations for host bridge windows Jul 23 00:12:32.209578 kernel: ACPI: Enabled 1 GPEs in block 00 to 0F Jul 23 00:12:32.209584 kernel: iommu: Default domain type: Translated Jul 23 00:12:32.209590 kernel: iommu: DMA domain TLB invalidation policy: lazy mode Jul 23 00:12:32.209596 kernel: efivars: Registered efivars operations Jul 23 00:12:32.209605 kernel: PCI: Using ACPI for IRQ routing Jul 23 00:12:32.209611 kernel: PCI: System does not support PCI Jul 23 00:12:32.209616 kernel: vgaarb: loaded Jul 23 00:12:32.209622 kernel: clocksource: Switched to clocksource tsc-early Jul 23 00:12:32.209628 kernel: VFS: Disk quotas dquot_6.6.0 Jul 23 00:12:32.209634 kernel: VFS: Dquot-cache hash table entries: 512 (order 0, 4096 bytes) Jul 23 00:12:32.209640 kernel: pnp: PnP ACPI init Jul 23 00:12:32.209647 kernel: pnp: PnP ACPI: found 3 devices Jul 23 00:12:32.209653 kernel: clocksource: acpi_pm: mask: 0xffffff max_cycles: 0xffffff, max_idle_ns: 2085701024 ns Jul 23 00:12:32.209659 kernel: NET: Registered PF_INET protocol family Jul 23 00:12:32.209664 kernel: IP idents hash table entries: 131072 (order: 8, 1048576 bytes, linear) Jul 23 00:12:32.209670 kernel: tcp_listen_portaddr_hash hash table entries: 4096 (order: 4, 65536 bytes, linear) Jul 23 00:12:32.209676 kernel: Table-perturb hash table entries: 65536 (order: 6, 262144 bytes, linear) Jul 23 00:12:32.209681 kernel: TCP established hash table entries: 65536 (order: 7, 524288 bytes, linear) Jul 23 00:12:32.209688 kernel: TCP bind hash table entries: 65536 (order: 9, 2097152 bytes, linear) Jul 23 00:12:32.209694 kernel: TCP: Hash tables configured (established 65536 bind 65536) Jul 23 00:12:32.209700 kernel: UDP hash table entries: 4096 (order: 5, 131072 bytes, linear) Jul 23 00:12:32.209706 kernel: UDP-Lite hash table entries: 4096 (order: 5, 131072 bytes, linear) Jul 23 00:12:32.209712 kernel: NET: Registered PF_UNIX/PF_LOCAL protocol family Jul 23 00:12:32.209718 kernel: NET: Registered PF_XDP protocol family Jul 23 00:12:32.209723 kernel: PCI: CLS 0 bytes, default 64 Jul 23 00:12:32.209730 kernel: PCI-DMA: Using software bounce buffering for IO (SWIOTLB) Jul 23 00:12:32.209736 kernel: software IO TLB: mapped [mem 0x000000003a97e000-0x000000003e97e000] (64MB) Jul 23 00:12:32.209742 kernel: RAPL PMU: API unit is 2^-32 Joules, 1 fixed counters, 10737418240 ms ovfl timer Jul 23 00:12:32.209747 kernel: RAPL PMU: hw unit of domain psys 2^-0 Joules Jul 23 00:12:32.209753 kernel: clocksource: tsc: mask: 0xffffffffffffffff max_cycles: 0x212735223b2, max_idle_ns: 440795277976 ns Jul 23 00:12:32.209759 kernel: clocksource: Switched to clocksource tsc Jul 23 00:12:32.209765 kernel: Initialise system trusted keyrings Jul 23 00:12:32.209772 kernel: workingset: timestamp_bits=39 max_order=21 bucket_order=0 Jul 23 00:12:32.209778 kernel: Key type asymmetric registered Jul 23 00:12:32.209784 kernel: Asymmetric key parser 'x509' registered Jul 23 00:12:32.209790 kernel: Block layer SCSI generic (bsg) driver version 0.4 loaded (major 250) Jul 23 00:12:32.209795 kernel: io scheduler mq-deadline registered Jul 23 00:12:32.209801 kernel: io scheduler kyber registered Jul 23 00:12:32.209807 kernel: io scheduler bfq registered Jul 23 00:12:32.209815 kernel: ioatdma: Intel(R) QuickData Technology Driver 5.00 Jul 23 00:12:32.209822 kernel: Serial: 8250/16550 driver, 4 ports, IRQ sharing enabled Jul 23 00:12:32.209827 kernel: 00:00: ttyS0 at I/O 0x3f8 (irq = 4, base_baud = 115200) is a 16550A Jul 23 00:12:32.209833 kernel: 00:01: ttyS1 at I/O 0x2f8 (irq = 3, base_baud = 115200) is a 16550A Jul 23 00:12:32.209839 kernel: serial8250: ttyS2 at I/O 0x3e8 (irq = 4, base_baud = 115200) is a 16550A Jul 23 00:12:32.209844 kernel: ACPI: bus type drm_connector registered Jul 23 00:12:32.209850 kernel: i8042: PNP: No PS/2 controller found. Jul 23 00:12:32.210009 kernel: rtc_cmos 00:02: registered as rtc0 Jul 23 00:12:32.210099 kernel: rtc_cmos 00:02: setting system clock to 2026-07-23T00:12:27 UTC (1784765547) Jul 23 00:12:32.210181 kernel: rtc_cmos 00:02: alarms up to one month, 114 bytes nvram Jul 23 00:12:32.210188 kernel: intel_pstate: Intel P-state driver initializing Jul 23 00:12:32.210194 kernel: efifb: probing for efifb Jul 23 00:12:32.210200 kernel: efifb: framebuffer at 0x40000000, using 3072k, total 3072k Jul 23 00:12:32.210207 kernel: efifb: mode is 1024x768x32, linelength=4096, pages=1 Jul 23 00:12:32.210213 kernel: efifb: scrolling: redraw Jul 23 00:12:32.210219 kernel: efifb: Truecolor: size=8:8:8:8, shift=24:16:8:0 Jul 23 00:12:32.210224 kernel: Console: switching to colour frame buffer device 128x48 Jul 23 00:12:32.210230 kernel: fb0: EFI VGA frame buffer device Jul 23 00:12:32.210236 kernel: pstore: Using crash dump compression: deflate Jul 23 00:12:32.210242 kernel: pstore: Registered efi_pstore as persistent store backend Jul 23 00:12:32.210247 kernel: NET: Registered PF_INET6 protocol family Jul 23 00:12:32.210254 kernel: Segment Routing with IPv6 Jul 23 00:12:32.210260 kernel: In-situ OAM (IOAM) with IPv6 Jul 23 00:12:32.210266 kernel: NET: Registered PF_PACKET protocol family Jul 23 00:12:32.210272 kernel: Key type dns_resolver registered Jul 23 00:12:32.210277 kernel: IPI shorthand broadcast: enabled Jul 23 00:12:32.210283 kernel: sched_clock: Marking stable (1981004639, 93165264)->(2397659220, -323489317) Jul 23 00:12:32.210288 kernel: registered taskstats version 1 Jul 23 00:12:32.210295 kernel: Loading compiled-in X.509 certificates Jul 23 00:12:32.210301 kernel: Loaded X.509 cert 'Kinvolk GmbH: Module signing key for 6.12.96-flatcar: e6a2a44b7834c7f2eb823c69de69c0598741cd26' Jul 23 00:12:32.210307 kernel: Demotion targets for Node 0: null Jul 23 00:12:32.210313 kernel: Key type .fscrypt registered Jul 23 00:12:32.210318 kernel: Key type fscrypt-provisioning registered Jul 23 00:12:32.210324 kernel: ima: No TPM chip found, activating TPM-bypass! Jul 23 00:12:32.210330 kernel: ima: Allocated hash algorithm: sha1 Jul 23 00:12:32.210337 kernel: ima: No architecture policies found Jul 23 00:12:32.210343 kernel: clk: Disabling unused clocks Jul 23 00:12:32.210348 kernel: Freeing unused kernel image (initmem) memory: 16068K Jul 23 00:12:32.210354 kernel: Write protecting the kernel read-only data: 47104k Jul 23 00:12:32.210360 kernel: Freeing unused kernel image (rodata/data gap) memory: 120K Jul 23 00:12:32.210365 kernel: Run /init as init process Jul 23 00:12:32.210371 kernel: with arguments: Jul 23 00:12:32.210378 kernel: /init Jul 23 00:12:32.210383 kernel: with environment: Jul 23 00:12:32.210389 kernel: HOME=/ Jul 23 00:12:32.210394 kernel: TERM=linux Jul 23 00:12:32.210400 kernel: hv_vmbus: hv_mmio=[mem 0x40000000-0xfed3ffff],[mem 0xfc0000000-0xfffffffff] fb=[mem 0x40000000-0x47ffffff] Jul 23 00:12:32.210406 kernel: hv_vmbus: Vmbus version:5.3 Jul 23 00:12:32.210412 kernel: pps_core: LinuxPPS API ver. 1 registered Jul 23 00:12:32.210417 kernel: pps_core: Software ver. 5.3.6 - Copyright 2005-2007 Rodolfo Giometti Jul 23 00:12:32.210441 kernel: PTP clock support registered Jul 23 00:12:32.210451 kernel: hv_utils: Registering HyperV Utility Driver Jul 23 00:12:32.210459 kernel: SCSI subsystem initialized Jul 23 00:12:32.210468 kernel: hv_vmbus: registering driver hv_utils Jul 23 00:12:32.210476 kernel: hv_utils: Shutdown IC version 3.2 Jul 23 00:12:32.210486 kernel: hv_utils: Heartbeat IC version 3.0 Jul 23 00:12:32.210495 kernel: hv_utils: TimeSync IC version 4.0 Jul 23 00:12:32.210506 kernel: hv_vmbus: registering driver hv_pci Jul 23 00:12:32.210681 kernel: hv_pci 7ad35d50-c05b-47ab-b3a0-56a9a845852b: PCI VMBus probing: Using version 0x10004 Jul 23 00:12:32.210827 kernel: hv_pci 7ad35d50-c05b-47ab-b3a0-56a9a845852b: PCI host bridge to bus c05b:00 Jul 23 00:12:32.210988 kernel: pci_bus c05b:00: root bus resource [mem 0xfc0000000-0xfc007ffff window] Jul 23 00:12:32.211140 kernel: pci_bus c05b:00: No busn resource found for root bus, will use [bus 00-ff] Jul 23 00:12:32.211330 kernel: pci c05b:00:00.0: [1414:00a9] type 00 class 0x010802 PCIe Endpoint Jul 23 00:12:32.211518 kernel: pci c05b:00:00.0: BAR 0 [mem 0xfc0000000-0xfc007ffff 64bit] Jul 23 00:12:32.211672 kernel: pci_bus c05b:00: busn_res: [bus 00-ff] end is updated to 00 Jul 23 00:12:32.211829 kernel: pci c05b:00:00.0: BAR 0 [mem 0xfc0000000-0xfc007ffff 64bit]: assigned Jul 23 00:12:32.211841 kernel: hv_vmbus: registering driver hv_storvsc Jul 23 00:12:32.212004 kernel: scsi host0: storvsc_host_t Jul 23 00:12:32.212184 kernel: scsi 0:0:0:2: CD-ROM Msft Virtual DVD-ROM 1.0 PQ: 0 ANSI: 5 Jul 23 00:12:32.212200 kernel: hid: raw HID events driver (C) Jiri Kosina Jul 23 00:12:32.212209 kernel: hv_vmbus: registering driver hid_hyperv Jul 23 00:12:32.212219 kernel: input: Microsoft Vmbus HID-compliant Mouse as /devices/0006:045E:0621.0001/input/input0 Jul 23 00:12:32.212344 kernel: hid-hyperv 0006:045E:0621.0001: input: VIRTUAL HID v0.01 Mouse [Microsoft Vmbus HID-compliant Mouse] on Jul 23 00:12:32.212357 kernel: hv_vmbus: registering driver hyperv_keyboard Jul 23 00:12:32.212367 kernel: input: AT Translated Set 2 keyboard as /devices/LNXSYSTM:00/LNXSYBUS:00/ACPI0004:00/MSFT1000:00/d34b2567-b9b6-42b9-8778-0a4ec0b955bf/serio0/input/input1 Jul 23 00:12:32.212603 kernel: nvme nvme0: pci function c05b:00:00.0 Jul 23 00:12:32.212764 kernel: nvme c05b:00:00.0: enabling device (0000 -> 0002) Jul 23 00:12:32.212892 kernel: nvme nvme0: 2/0/0 default/read/poll queues Jul 23 00:12:32.212905 kernel: nvme0n1: p1 p2 p3 p4 p6 p7 p9 Jul 23 00:12:32.213070 kernel: sr 0:0:0:2: [sr0] scsi-1 drive Jul 23 00:12:32.213081 kernel: cdrom: Uniform CD-ROM driver Revision: 3.20 Jul 23 00:12:32.213229 kernel: sr 0:0:0:2: Attached scsi CD-ROM sr0 Jul 23 00:12:32.213241 kernel: device-mapper: core: CONFIG_IMA_DISABLE_HTABLE is disabled. Duplicate IMA measurements will not be recorded in the IMA log. Jul 23 00:12:32.213274 kernel: device-mapper: uevent: version 1.0.3 Jul 23 00:12:32.213285 kernel: device-mapper: ioctl: 4.48.0-ioctl (2023-03-01) initialised: dm-devel@lists.linux.dev Jul 23 00:12:32.213296 kernel: device-mapper: verity: sha256 using shash "sha256-generic" Jul 23 00:12:32.213305 kernel: raid6: avx512x4 gen() 43120 MB/s Jul 23 00:12:32.213314 kernel: raid6: avx512x2 gen() 43388 MB/s Jul 23 00:12:32.213322 kernel: raid6: avx512x1 gen() 27150 MB/s Jul 23 00:12:32.213331 kernel: raid6: avx2x4 gen() 39080 MB/s Jul 23 00:12:32.213340 kernel: raid6: avx2x2 gen() 39541 MB/s Jul 23 00:12:32.213348 kernel: raid6: avx2x1 gen() 29812 MB/s Jul 23 00:12:32.213358 kernel: raid6: using algorithm avx512x2 gen() 43388 MB/s Jul 23 00:12:32.213367 kernel: raid6: .... xor() 31586 MB/s, rmw enabled Jul 23 00:12:32.213375 kernel: raid6: using avx512x2 recovery algorithm Jul 23 00:12:32.213384 kernel: xor: automatically using best checksumming function avx Jul 23 00:12:32.213394 kernel: Btrfs loaded, zoned=no, fsverity=no Jul 23 00:12:32.213403 kernel: BTRFS: device fsid f63a59c9-91a4-40cd-8ac5-e73fa4652f4c devid 1 transid 41 /dev/mapper/usr (254:0) scanned by mount (951) Jul 23 00:12:32.213411 kernel: BTRFS info (device dm-0): first mount of filesystem f63a59c9-91a4-40cd-8ac5-e73fa4652f4c Jul 23 00:12:32.213422 kernel: BTRFS info (device dm-0): using crc32c (crc32c-intel) checksum algorithm Jul 23 00:12:32.213442 kernel: BTRFS info (device dm-0 state E): enabling ssd optimizations Jul 23 00:12:32.213450 kernel: BTRFS info (device dm-0 state E): disabling log replay at mount time Jul 23 00:12:32.213461 kernel: BTRFS info (device dm-0 state E): enabling free space tree Jul 23 00:12:32.213469 kernel: loop: module loaded Jul 23 00:12:32.213478 kernel: loop0: detected capacity change from 0 to 109400 Jul 23 00:12:32.213487 kernel: squashfs: version 4.0 (2009/01/31) Phillip Lougher Jul 23 00:12:32.213498 systemd[1]: Successfully made /usr/ read-only. Jul 23 00:12:32.213512 systemd[1]: systemd 260.1 running in system mode (+PAM +AUDIT +SELINUX -APPARMOR +IMA +IPE +SMACK +SECCOMP -GCRYPT -GNUTLS +OPENSSL -ACL +BLKID +CURL +ELFUTILS -FIDO2 +IDN2 +KMOD +LIBCRYPTSETUP +LIBCRYPTSETUP_PLUGINS +LIBFDISK +PCRE2 -PWQUALITY -P11KIT -QRENCODE +TPM2 +BZIP2 +LZ4 +XZ +ZLIB +ZSTD -BPF_FRAMEWORK -BTF -XKBCOMMON +UTMP +LIBARCHIVE) Jul 23 00:12:32.213522 systemd[1]: Detected virtualization microsoft. Jul 23 00:12:32.213531 systemd[1]: Detected architecture x86-64. Jul 23 00:12:32.213540 systemd[1]: Running in initrd. Jul 23 00:12:32.213549 systemd[1]: Initializing machine ID from random generator. Jul 23 00:12:32.213560 systemd[1]: No hostname configured, using default hostname. Jul 23 00:12:32.213569 systemd[1]: Hostname set to . Jul 23 00:12:32.213579 systemd[1]: Queued start job for default target initrd.target. Jul 23 00:12:32.213588 systemd[1]: Unnecessary job was removed for dev-mapper-usr.device - /dev/mapper/usr. Jul 23 00:12:32.213600 systemd[1]: Started clevis-luks-askpass.path - Forward Password Requests to Clevis Directory Watch. Jul 23 00:12:32.213610 systemd[1]: Started systemd-ask-password-console.path - Dispatch Password Requests to Console Directory Watch. Jul 23 00:12:32.213620 systemd[1]: Expecting device dev-disk-by\x2dlabel-EFI\x2dSYSTEM.device - /dev/disk/by-label/EFI-SYSTEM... Jul 23 00:12:32.213630 systemd[1]: Expecting device dev-disk-by\x2dlabel-OEM.device - /dev/disk/by-label/OEM... Jul 23 00:12:32.213640 systemd[1]: Expecting device dev-disk-by\x2dlabel-ROOT.device - /dev/disk/by-label/ROOT... Jul 23 00:12:32.213649 systemd[1]: Expecting device dev-disk-by\x2dpartlabel-USR\x2dA.device - /dev/disk/by-partlabel/USR-A... Jul 23 00:12:32.213659 systemd[1]: Reached target cryptsetup-pre.target - Local Encrypted Volumes (Pre). Jul 23 00:12:32.213668 systemd[1]: Reached target cryptsetup.target - Local Encrypted Volumes. Jul 23 00:12:32.213676 systemd[1]: Reached target initrd-usr-fs.target - Initrd /usr File System. Jul 23 00:12:32.213685 systemd[1]: Reached target paths.target - Path Units. Jul 23 00:12:32.213694 systemd[1]: Reached target slices.target - Slice Units. Jul 23 00:12:32.213703 systemd[1]: Reached target swap.target - Swaps. Jul 23 00:12:32.213712 systemd[1]: Reached target timers.target - Timer Units. Jul 23 00:12:32.213722 systemd[1]: Listening on iscsid.socket - Open-iSCSI iscsid Socket. Jul 23 00:12:32.213731 systemd[1]: Listening on iscsiuio.socket - Open-iSCSI iscsiuio Socket. Jul 23 00:12:32.213738 systemd[1]: Listening on systemd-coredump.socket - Process Core Dump Socket. Jul 23 00:12:32.213746 systemd[1]: Listening on systemd-journald-audit.socket - Journal Audit Socket. Jul 23 00:12:32.213759 systemd[1]: Listening on systemd-journald-dev-log.socket - Journal Socket (/dev/log). Jul 23 00:12:32.213768 systemd[1]: Listening on systemd-journald.socket - Journal Sockets. Jul 23 00:12:32.213780 systemd[1]: Listening on systemd-networkd-resolve-hook.socket - Network Management Resolve Hook Socket. Jul 23 00:12:32.213789 systemd[1]: Listening on systemd-networkd.socket - Network Management Netlink Socket. Jul 23 00:12:32.213798 systemd[1]: Listening on systemd-udevd-control.socket - udev Control Socket. Jul 23 00:12:32.213808 systemd[1]: Listening on systemd-udevd-kernel.socket - udev Kernel Socket. Jul 23 00:12:32.213818 systemd[1]: Reached target sockets.target - Socket Units. Jul 23 00:12:32.213827 systemd[1]: afterburn-network-kargs.service - Afterburn Initrd Setup Network Kernel Arguments skipped, no trigger condition checks were met. Jul 23 00:12:32.213836 systemd[1]: Starting ignition-setup-pre.service - Ignition env setup... Jul 23 00:12:32.213847 systemd[1]: Starting kmod-static-nodes.service - Create List of Static Device Nodes... Jul 23 00:12:32.213855 systemd[1]: Finished network-cleanup.service - Network Cleanup. Jul 23 00:12:32.213864 systemd[1]: systemd-battery-check.service - Early Battery Level Check skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/class/power_supply Jul 23 00:12:32.213872 systemd[1]: Starting systemd-fsck-usr.service... Jul 23 00:12:32.213881 systemd[1]: Starting systemd-journald.service - Journal Service... Jul 23 00:12:32.213891 systemd[1]: Starting systemd-modules-load.service - Load Kernel Modules... Jul 23 00:12:32.213899 systemd[1]: Starting systemd-vconsole-setup.service - Virtual Console Setup... Jul 23 00:12:32.213931 systemd-journald[1142]: Collecting audit messages is enabled. Jul 23 00:12:32.213957 systemd-journald[1142]: Journal started Jul 23 00:12:32.213979 systemd-journald[1142]: Runtime Journal (/run/log/journal/ce27000b75c54d51bcaf3205d35dbdc4) is 8M, max 158.5M, 150.5M free. Jul 23 00:12:32.206293 systemd-modules-load[1148]: Using 2 probe threads Jul 23 00:12:32.219548 systemd[1]: Started systemd-journald.service - Journal Service. Jul 23 00:12:32.217000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=systemd-journald comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Jul 23 00:12:32.223444 kernel: audit: type=1130 audit(1784765552.217:2): pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=systemd-journald comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Jul 23 00:12:32.224374 systemd[1]: Finished ignition-setup-pre.service - Ignition env setup. Jul 23 00:12:32.223000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=ignition-setup-pre comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Jul 23 00:12:32.229186 systemd[1]: Finished kmod-static-nodes.service - Create List of Static Device Nodes. Jul 23 00:12:32.229631 kernel: audit: type=1130 audit(1784765552.223:3): pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=ignition-setup-pre comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Jul 23 00:12:32.228000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=kmod-static-nodes comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Jul 23 00:12:32.233482 kernel: audit: type=1130 audit(1784765552.228:4): pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=kmod-static-nodes comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Jul 23 00:12:32.234000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=systemd-fsck-usr comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Jul 23 00:12:32.239495 kernel: audit: type=1130 audit(1784765552.234:5): pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=systemd-fsck-usr comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Jul 23 00:12:32.234548 systemd[1]: Finished systemd-fsck-usr.service. Jul 23 00:12:32.240579 systemd[1]: Starting systemd-tmpfiles-setup-dev-early.service - Create Static Device Nodes in /dev gracefully... Jul 23 00:12:32.249639 systemd[1]: Starting systemd-tmpfiles-setup.service - Create System Files and Directories... Jul 23 00:12:32.334446 kernel: bridge: filtering via arp/ip/ip6tables is no longer available by default. Update your scripts to load br_netfilter if you need this. Jul 23 00:12:32.336715 systemd-tmpfiles[1176]: /usr/lib/tmpfiles.d/systemd.conf:30: Duplicate line for path "/var/lib/systemd", ignoring. Jul 23 00:12:32.336810 systemd-tmpfiles[1176]: /usr/lib/tmpfiles.d/var.conf:14: Duplicate line for path "/var/log", ignoring. Jul 23 00:12:32.345102 kernel: Bridge firewalling registered Jul 23 00:12:32.345168 systemd-modules-load[1148]: Inserted module 'br_netfilter' Jul 23 00:12:32.364411 systemd[1]: Finished systemd-tmpfiles-setup-dev-early.service - Create Static Device Nodes in /dev gracefully. Jul 23 00:12:32.364000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=systemd-tmpfiles-setup-dev-early comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Jul 23 00:12:32.369915 systemd[1]: Finished systemd-modules-load.service - Load Kernel Modules. Jul 23 00:12:32.370450 kernel: audit: type=1130 audit(1784765552.364:6): pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=systemd-tmpfiles-setup-dev-early comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Jul 23 00:12:32.368000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=systemd-modules-load comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Jul 23 00:12:32.374451 kernel: audit: type=1130 audit(1784765552.368:7): pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=systemd-modules-load comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Jul 23 00:12:32.375129 systemd[1]: Finished systemd-tmpfiles-setup.service - Create System Files and Directories. Jul 23 00:12:32.375000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=systemd-tmpfiles-setup comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Jul 23 00:12:32.380582 systemd[1]: Starting systemd-sysctl.service - Apply Kernel Variables... Jul 23 00:12:32.383663 kernel: audit: type=1130 audit(1784765552.375:8): pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=systemd-tmpfiles-setup comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Jul 23 00:12:32.404551 systemd[1]: Starting systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev... Jul 23 00:12:32.406667 systemd-vconsole-setup[1150]: Configuration of first virtual console was skipped, ignoring remaining ones. Jul 23 00:12:32.412597 systemd[1]: Finished systemd-vconsole-setup.service - Virtual Console Setup. Jul 23 00:12:32.411000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=systemd-vconsole-setup comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Jul 23 00:12:32.420505 kernel: audit: type=1130 audit(1784765552.411:9): pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=systemd-vconsole-setup comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Jul 23 00:12:32.421388 systemd[1]: Starting dracut-cmdline-ask.service - dracut ask for additional cmdline parameters... Jul 23 00:12:32.427850 systemd[1]: systemd-sysctl.service: Deactivated successfully. Jul 23 00:12:32.428661 systemd[1]: Finished systemd-sysctl.service - Apply Kernel Variables. Jul 23 00:12:32.436000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=systemd-sysctl comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Jul 23 00:12:32.442459 kernel: audit: type=1130 audit(1784765552.436:10): pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=systemd-sysctl comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Jul 23 00:12:32.436000 audit[1]: SERVICE_STOP pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=systemd-sysctl comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Jul 23 00:12:32.447608 kernel: audit: type=1131 audit(1784765552.436:11): pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=systemd-sysctl comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Jul 23 00:12:32.448735 systemd[1]: Finished systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev. Jul 23 00:12:32.447000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=systemd-tmpfiles-setup-dev comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Jul 23 00:12:32.449000 audit: BPF prog-id=5 op=LOAD Jul 23 00:12:32.455325 systemd[1]: Starting systemd-resolved.service - Network Name Resolution... Jul 23 00:12:32.462762 systemd[1]: Finished dracut-cmdline-ask.service - dracut ask for additional cmdline parameters. Jul 23 00:12:32.468000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=dracut-cmdline-ask comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Jul 23 00:12:32.472213 systemd[1]: Starting dracut-cmdline.service - dracut cmdline hook... Jul 23 00:12:32.557510 systemd-resolved[1204]: Positive Trust Anchors: Jul 23 00:12:32.559118 systemd-resolved[1204]: . IN DS 20326 8 2 e06d44b80b8f1d39a95c0b0d7c65d08458e880409bbc683457104237c7f8ec8d Jul 23 00:12:32.559123 systemd-resolved[1204]: . IN DS 38696 8 2 683d2d0acb8c9b712a1948b27f741219298d0a450d612c483af444a4c0fb2b16 Jul 23 00:12:32.564879 dracut-cmdline[1215]: dracut-110 Jul 23 00:12:32.559159 systemd-resolved[1204]: 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 Jul 23 00:12:32.593843 dracut-cmdline[1215]: Using kernel command line parameters: 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=b90158b1b2baf5c0229b46ffa5bef3adacc5885f2f4f58b3368133b082ab2095 Jul 23 00:12:32.629341 systemd-resolved[1204]: Defaulting to hostname 'linux'. Jul 23 00:12:32.632000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=systemd-resolved comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Jul 23 00:12:32.631805 systemd[1]: Started systemd-resolved.service - Network Name Resolution. Jul 23 00:12:32.634225 systemd[1]: Reached target nss-lookup.target - Host and Network Name Lookups. Jul 23 00:12:32.748463 kernel: Loading iSCSI transport class v2.0-870. Jul 23 00:12:32.822445 kernel: iscsi: registered transport (tcp) Jul 23 00:12:32.871891 kernel: iscsi: registered transport (qla4xxx) Jul 23 00:12:32.871938 kernel: QLogic iSCSI HBA Driver Jul 23 00:12:32.923582 systemd[1]: Starting systemd-network-generator.service - Generate Network Units from Kernel Command Line... Jul 23 00:12:32.938389 systemd[1]: Finished systemd-network-generator.service - Generate Network Units from Kernel Command Line. Jul 23 00:12:32.941000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=systemd-network-generator comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Jul 23 00:12:32.942931 systemd[1]: Reached target network-pre.target - Preparation for Network. Jul 23 00:12:32.979153 systemd[1]: Finished dracut-cmdline.service - dracut cmdline hook. Jul 23 00:12:32.979000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=dracut-cmdline comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Jul 23 00:12:32.982612 systemd[1]: Starting dracut-pre-udev.service - dracut pre-udev hook... Jul 23 00:12:32.992695 systemd[1]: Starting parse-ip-for-networkd.service - Write systemd-networkd units from cmdline... Jul 23 00:12:33.014507 systemd[1]: Finished dracut-pre-udev.service - dracut pre-udev hook. Jul 23 00:12:33.018000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=dracut-pre-udev comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Jul 23 00:12:33.018000 audit: BPF prog-id=6 op=LOAD Jul 23 00:12:33.018000 audit: BPF prog-id=7 op=LOAD Jul 23 00:12:33.021570 systemd[1]: Starting systemd-udevd.service - Rule-based Manager for Device Events and Files... Jul 23 00:12:33.090384 systemd-udevd[1447]: Using default interface naming scheme 'v260'. Jul 23 00:12:33.097774 systemd[1]: Finished parse-ip-for-networkd.service - Write systemd-networkd units from cmdline. Jul 23 00:12:33.097000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=parse-ip-for-networkd comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Jul 23 00:12:33.124699 systemd[1]: Started systemd-udevd.service - Rule-based Manager for Device Events and Files. Jul 23 00:12:33.128000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=systemd-udevd comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Jul 23 00:12:33.132555 systemd[1]: Starting dracut-pre-trigger.service - dracut pre-trigger hook... Jul 23 00:12:33.135000 audit: BPF prog-id=8 op=LOAD Jul 23 00:12:33.140789 systemd[1]: Starting systemd-networkd.service - Network Management... Jul 23 00:12:33.160070 dracut-pre-trigger[1564]: rd.md=0: removing MD RAID activation Jul 23 00:12:33.181341 systemd-networkd[1576]: Failed to open nftables netlink socket. IPMasquerade= and NFTSet= settings will not be applied. Ignoring: Protocol not supported Jul 23 00:12:33.187145 systemd[1]: Finished dracut-pre-trigger.service - dracut pre-trigger hook. Jul 23 00:12:33.189000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=dracut-pre-trigger comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Jul 23 00:12:33.192230 systemd[1]: Starting systemd-udev-trigger.service - Coldplug All udev Devices... Jul 23 00:12:33.198271 systemd-networkd[1576]: lo: Link UP Jul 23 00:12:33.198649 systemd-networkd[1576]: lo: Gained carrier Jul 23 00:12:33.199812 systemd[1]: Started systemd-networkd.service - Network Management. Jul 23 00:12:33.201000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=systemd-networkd comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Jul 23 00:12:33.203330 systemd[1]: Reached target network.target - Network. Jul 23 00:12:33.262267 systemd[1]: Finished systemd-udev-trigger.service - Coldplug All udev Devices. Jul 23 00:12:33.261000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=systemd-udev-trigger comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Jul 23 00:12:33.269541 systemd[1]: Starting dracut-initqueue.service - dracut initqueue hook... Jul 23 00:12:33.374742 systemd[1]: systemd-vconsole-setup.service: Deactivated successfully. Jul 23 00:12:33.374891 systemd[1]: Stopped systemd-vconsole-setup.service - Virtual Console Setup. Jul 23 00:12:33.375000 audit[1]: SERVICE_STOP pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=systemd-vconsole-setup comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Jul 23 00:12:33.379529 systemd[1]: Stopping systemd-vconsole-setup.service - Virtual Console Setup... Jul 23 00:12:33.384898 systemd[1]: Starting systemd-vconsole-setup.service - Virtual Console Setup... Jul 23 00:12:33.417444 kernel: cryptd: max_cpu_qlen set to 1000 Jul 23 00:12:33.436465 kernel: hv_vmbus: registering driver hv_netvsc Jul 23 00:12:33.446445 kernel: hv_netvsc f8615163-0000-1000-2000-7ced8d77b541 (unnamed net_device) (uninitialized): VF slot 1 added Jul 23 00:12:33.461820 kernel: hv_storvsc f8b3781a-1e82-4818-a1c3-63d806ec15bb: tag#164 cmd 0x85 status: scsi 0x2 srb 0x6 hv 0xc0000001 Jul 23 00:12:33.462073 systemd-vconsole-setup[1657]: Configuration of first virtual console was skipped, ignoring remaining ones. Jul 23 00:12:33.467287 systemd[1]: Finished systemd-vconsole-setup.service - Virtual Console Setup. Jul 23 00:12:33.469000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=systemd-vconsole-setup comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Jul 23 00:12:33.479269 systemd-networkd[1576]: eth0: Found matching .network file, based on potentially unpredictable interface name: /usr/lib/systemd/network/zz-default.network Jul 23 00:12:33.479276 systemd-networkd[1576]: eth0: Configuring with /usr/lib/systemd/network/zz-default.network. Jul 23 00:12:33.488857 kernel: AES CTR mode by8 optimization enabled Jul 23 00:12:33.488696 systemd-networkd[1576]: eth0: Link UP Jul 23 00:12:33.488790 systemd-networkd[1576]: eth0: Gained carrier Jul 23 00:12:33.488802 systemd-networkd[1576]: eth0: Found matching .network file, based on potentially unpredictable interface name: /usr/lib/systemd/network/zz-default.network Jul 23 00:12:33.498505 systemd-networkd[1576]: eth0: DHCPv4 address 10.0.0.20/24, gateway 10.0.0.1 acquired from 168.63.129.16 Jul 23 00:12:33.607463 kernel: nvme nvme0: using unchecked data buffer Jul 23 00:12:33.715361 systemd[1]: Found device dev-disk-by\x2dpartlabel-USR\x2dA.device - MSFT NVMe Accelerator v1.0 USR-A. Jul 23 00:12:33.720926 systemd[1]: Starting disk-uuid.service - Generate new UUID for disk GPT if necessary... Jul 23 00:12:33.800688 systemd[1]: Found device dev-disk-by\x2dlabel-OEM.device - MSFT NVMe Accelerator v1.0 OEM. Jul 23 00:12:33.830091 systemd[1]: Found device dev-disk-by\x2dlabel-EFI\x2dSYSTEM.device - MSFT NVMe Accelerator v1.0 EFI-SYSTEM. Jul 23 00:12:33.856604 systemd[1]: Mounting oem.mount - /oem... Jul 23 00:12:33.926402 systemd[1]: Found device dev-disk-by\x2dlabel-ROOT.device - MSFT NVMe Accelerator v1.0 ROOT. Jul 23 00:12:33.940444 kernel: BTRFS: device label OEM devid 1 transid 11 /dev/nvme0n1p6 (259:5) scanned by mount (1774) Jul 23 00:12:33.943020 kernel: BTRFS info (device nvme0n1p6): first mount of filesystem 90034852-0c2e-40a9-a4a4-507d2faace84 Jul 23 00:12:33.943042 kernel: BTRFS info (device nvme0n1p6): using crc32c (crc32c-intel) checksum algorithm Jul 23 00:12:33.965056 systemd[1]: Finished dracut-initqueue.service - dracut initqueue hook. Jul 23 00:12:33.966000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=dracut-initqueue comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Jul 23 00:12:33.968488 systemd[1]: Reached target remote-fs-pre.target - Preparation for Remote File Systems. Jul 23 00:12:33.972331 systemd[1]: Reached target remote-cryptsetup.target - Remote Encrypted Volumes. Jul 23 00:12:33.974644 systemd[1]: Reached target remote-fs.target - Remote File Systems. Jul 23 00:12:33.981125 kernel: BTRFS info (device nvme0n1p6): enabling ssd optimizations Jul 23 00:12:33.981162 kernel: BTRFS info (device nvme0n1p6): turning on async discard Jul 23 00:12:33.982903 kernel: BTRFS info (device nvme0n1p6): enabling free space tree Jul 23 00:12:34.010602 systemd[1]: Starting dracut-pre-mount.service - dracut pre-mount hook... Jul 23 00:12:34.018052 systemd[1]: Mounted oem.mount - /oem. Jul 23 00:12:34.028589 systemd[1]: Starting ignition-fetch-offline.service - Ignition (fetch-offline)... Jul 23 00:12:34.041610 systemd[1]: Finished dracut-pre-mount.service - dracut pre-mount hook. Jul 23 00:12:34.040000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=dracut-pre-mount comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Jul 23 00:12:34.467128 kernel: hv_pci 00000001-7870-47b5-b203-907d12ca697e: PCI VMBus probing: Using version 0x10004 Jul 23 00:12:34.467407 kernel: hv_pci 00000001-7870-47b5-b203-907d12ca697e: PCI host bridge to bus 7870:00 Jul 23 00:12:34.470070 kernel: pci_bus 7870:00: root bus resource [mem 0xfc2000000-0xfc4007fff window] Jul 23 00:12:34.471639 kernel: pci_bus 7870:00: No busn resource found for root bus, will use [bus 00-ff] Jul 23 00:12:34.477456 kernel: pci 7870:00:00.0: [1414:00ba] type 00 class 0x020000 PCIe Endpoint Jul 23 00:12:34.481963 kernel: pci 7870:00:00.0: BAR 0 [mem 0xfc2000000-0xfc3ffffff 64bit pref] Jul 23 00:12:34.488132 kernel: pci 7870:00:00.0: BAR 4 [mem 0xfc4000000-0xfc4007fff 64bit pref] Jul 23 00:12:34.488235 kernel: pci 7870:00:00.0: enabling Extended Tags Jul 23 00:12:34.505309 kernel: pci_bus 7870:00: busn_res: [bus 00-ff] end is updated to 00 Jul 23 00:12:34.505554 kernel: pci 7870:00:00.0: BAR 0 [mem 0xfc2000000-0xfc3ffffff 64bit pref]: assigned Jul 23 00:12:34.510451 kernel: pci 7870:00:00.0: BAR 4 [mem 0xfc4000000-0xfc4007fff 64bit pref]: assigned Jul 23 00:12:34.558878 kernel: mana 7870:00:00.0: enabling device (0000 -> 0002) Jul 23 00:12:34.571479 kernel: mana 7870:00:00.0: Microsoft Azure Network Adapter protocol version: 0.1.1 Jul 23 00:12:34.571746 kernel: hv_netvsc f8615163-0000-1000-2000-7ced8d77b541 eth0: VF registering: eth1 Jul 23 00:12:34.573370 kernel: mana 7870:00:00.0 eth1: joined to eth0 Jul 23 00:12:34.578985 systemd-networkd[1576]: eth1: Interface name change detected, renamed to enP30832s1. Jul 23 00:12:34.580921 kernel: mana 7870:00:00.0 enP30832s1: renamed from eth1 Jul 23 00:12:34.681440 kernel: mana 7870:00:00.0 enP30832s1: Configured vPort 0 PD 18 DB 16 Jul 23 00:12:34.684455 kernel: mana 7870:00:00.0 enP30832s1: Configured steering vPort 0 entries 64 Jul 23 00:12:34.686736 systemd-networkd[1576]: enP30832s1: Link UP Jul 23 00:12:34.686875 systemd-networkd[1576]: enP30832s1: Gained carrier Jul 23 00:12:34.693466 kernel: hv_netvsc f8615163-0000-1000-2000-7ced8d77b541 eth0: Data path switched to VF: enP30832s1 Jul 23 00:12:34.790610 systemd-networkd[1576]: eth0: Gained IPv6LL Jul 23 00:12:35.027531 disk-uuid[1763]: Warning: The kernel is still using the old partition table. Jul 23 00:12:35.027531 disk-uuid[1763]: The new table will be used at the next reboot or after you Jul 23 00:12:35.027531 disk-uuid[1763]: run partprobe(8) or kpartx(8) Jul 23 00:12:35.027531 disk-uuid[1763]: The operation has completed successfully. Jul 23 00:12:35.033484 systemd[1]: disk-uuid.service: Deactivated successfully. Jul 23 00:12:35.035132 systemd[1]: Finished disk-uuid.service - Generate new UUID for disk GPT if necessary. Jul 23 00:12:35.043000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=disk-uuid comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Jul 23 00:12:35.043000 audit[1]: SERVICE_STOP pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=disk-uuid comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Jul 23 00:12:35.058979 ignition[1811]: Ignition 2.24.0 Jul 23 00:12:35.058991 ignition[1811]: Stage: fetch-offline Jul 23 00:12:35.060559 ignition[1811]: no config dir at "/usr/lib/ignition/base.d" Jul 23 00:12:35.063254 systemd[1]: Finished ignition-fetch-offline.service - Ignition (fetch-offline). Jul 23 00:12:35.066000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=ignition-fetch-offline comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Jul 23 00:12:35.060570 ignition[1811]: no config dir at "/usr/lib/ignition/base.platform.d/azure" Jul 23 00:12:35.060673 ignition[1811]: parsed url from cmdline: "" Jul 23 00:12:35.060679 ignition[1811]: no config URL provided Jul 23 00:12:35.060684 ignition[1811]: reading system config file "/usr/lib/ignition/user.ign" Jul 23 00:12:35.060699 ignition[1811]: no config at "/usr/lib/ignition/user.ign" Jul 23 00:12:35.071707 systemd[1]: Starting ignition-fetch.service - Ignition (fetch)... Jul 23 00:12:35.060704 ignition[1811]: failed to fetch config: resource requires networking Jul 23 00:12:35.060894 ignition[1811]: Ignition finished successfully Jul 23 00:12:35.095484 ignition[1845]: Ignition 2.24.0 Jul 23 00:12:35.095495 ignition[1845]: Stage: fetch Jul 23 00:12:35.095689 ignition[1845]: no config dir at "/usr/lib/ignition/base.d" Jul 23 00:12:35.095696 ignition[1845]: no config dir at "/usr/lib/ignition/base.platform.d/azure" Jul 23 00:12:35.095763 ignition[1845]: parsed url from cmdline: "" Jul 23 00:12:35.095766 ignition[1845]: no config URL provided Jul 23 00:12:35.095770 ignition[1845]: reading system config file "/usr/lib/ignition/user.ign" Jul 23 00:12:35.095776 ignition[1845]: no config at "/usr/lib/ignition/user.ign" Jul 23 00:12:35.095793 ignition[1845]: GET http://169.254.169.254/metadata/instance/compute/userData?api-version=2021-01-01&format=text: attempt #1 Jul 23 00:12:35.163707 ignition[1845]: GET result: OK Jul 23 00:12:35.163767 ignition[1845]: config has been read from IMDS userdata Jul 23 00:12:35.163781 ignition[1845]: parsing config with SHA512: cbc3d9710ecf58e8c2e9426ac73fa4d501250c38d303f761ff399c28253217f4273f32d8409166f7227917e5dd15595a497d7bd8874d8e81a8cd94d1f520a692 Jul 23 00:12:35.169848 unknown[1845]: fetched base config from "system" Jul 23 00:12:35.169860 unknown[1845]: fetched base config from "system" Jul 23 00:12:35.171018 ignition[1845]: fetch: fetch complete Jul 23 00:12:35.175000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=ignition-fetch comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Jul 23 00:12:35.169865 unknown[1845]: fetched user config from "azure" Jul 23 00:12:35.171021 ignition[1845]: fetch: fetch passed Jul 23 00:12:35.173475 systemd[1]: Finished ignition-fetch.service - Ignition (fetch). Jul 23 00:12:35.171072 ignition[1845]: Ignition finished successfully Jul 23 00:12:35.179567 systemd[1]: Starting ignition-kargs.service - Ignition (kargs)... Jul 23 00:12:35.201838 ignition[1854]: Ignition 2.24.0 Jul 23 00:12:35.201851 ignition[1854]: Stage: kargs Jul 23 00:12:35.204000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=ignition-kargs comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Jul 23 00:12:35.204916 systemd[1]: Finished ignition-kargs.service - Ignition (kargs). Jul 23 00:12:35.202048 ignition[1854]: no config dir at "/usr/lib/ignition/base.d" Jul 23 00:12:35.208878 systemd[1]: Starting ignition-disks.service - Ignition (disks)... Jul 23 00:12:35.202054 ignition[1854]: no config dir at "/usr/lib/ignition/base.platform.d/azure" Jul 23 00:12:35.202675 ignition[1854]: kargs: kargs passed Jul 23 00:12:35.202707 ignition[1854]: Ignition finished successfully Jul 23 00:12:35.275798 systemd[1]: ignition-kargs.service: Deactivated successfully. Jul 23 00:12:35.275901 systemd[1]: Stopped ignition-kargs.service - Ignition (kargs). Jul 23 00:12:35.279000 audit[1]: SERVICE_STOP pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=ignition-kargs comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Jul 23 00:12:35.281880 systemd[1]: ignition-fetch.service: Deactivated successfully. Jul 23 00:12:35.283000 audit[1]: SERVICE_STOP pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=ignition-fetch comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Jul 23 00:12:35.282016 systemd[1]: Stopped ignition-fetch.service - Ignition (fetch). Jul 23 00:12:35.286000 audit[1]: SERVICE_STOP pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=ignition-fetch-offline comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Jul 23 00:12:35.286180 systemd[1]: ignition-fetch-offline.service: Deactivated successfully. Jul 23 00:12:35.286309 systemd[1]: Stopped ignition-fetch-offline.service - Ignition (fetch-offline). Jul 23 00:12:35.291067 systemd[1]: Unmounting oem.mount - /oem... Jul 23 00:12:35.311443 kernel: BTRFS info (device nvme0n1p6): last unmount of filesystem 90034852-0c2e-40a9-a4a4-507d2faace84 Jul 23 00:12:35.312250 systemd[1]: oem.mount: Deactivated successfully. Jul 23 00:12:35.313379 systemd[1]: Unmounted oem.mount - /oem. Jul 23 00:12:35.334912 ignition[1875]: Ignition 2.24.0 Jul 23 00:12:35.334922 ignition[1875]: Stage: disks Jul 23 00:12:35.337598 systemd[1]: Finished ignition-disks.service - Ignition (disks). Jul 23 00:12:35.338000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=ignition-disks comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Jul 23 00:12:35.335103 ignition[1875]: no config dir at "/usr/lib/ignition/base.d" Jul 23 00:12:35.340044 systemd[1]: Reached target initrd-root-device.target - Initrd Root Device. Jul 23 00:12:35.335110 ignition[1875]: no config dir at "/usr/lib/ignition/base.platform.d/azure" Jul 23 00:12:35.340462 systemd[1]: Reached target local-fs-pre.target - Preparation for Local File Systems. Jul 23 00:12:35.335729 ignition[1875]: disks: disks passed Jul 23 00:12:35.340487 systemd[1]: Reached target local-fs.target - Local File Systems. Jul 23 00:12:35.335762 ignition[1875]: Ignition finished successfully Jul 23 00:12:35.340509 systemd[1]: Reached target sysinit.target - System Initialization. Jul 23 00:12:35.340751 systemd[1]: Reached target basic.target - Basic System. Jul 23 00:12:35.343569 systemd[1]: Starting systemd-fsck-root.service - File System Check on /dev/disk/by-label/ROOT... Jul 23 00:12:35.462692 systemd-fsck[1886]: ROOT: clean, 15/6361680 files, 408771/6359552 blocks Jul 23 00:12:35.467521 systemd[1]: Finished systemd-fsck-root.service - File System Check on /dev/disk/by-label/ROOT. Jul 23 00:12:35.469000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=systemd-fsck-root comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Jul 23 00:12:35.473234 systemd[1]: Mounting sysroot.mount - /sysroot... Jul 23 00:12:35.780441 kernel: EXT4-fs (nvme0n1p9): mounted filesystem ad9f9ad7-dd0b-4f9d-8823-4dea284e2376 r/w with ordered data mode. Quota mode: none. Jul 23 00:12:35.780791 systemd[1]: Mounted sysroot.mount - /sysroot. Jul 23 00:12:35.781517 systemd[1]: Reached target initrd-root-fs.target - Initrd Root File System. Jul 23 00:12:35.822336 systemd[1]: Mounting sysroot-usr.mount - /sysroot/usr... Jul 23 00:12:35.840574 systemd[1]: Starting flatcar-metadata-hostname.service - Flatcar Metadata Hostname Agent... Jul 23 00:12:35.844877 systemd[1]: ignition-remount-sysroot.service - Remount /sysroot read-write for Ignition skipped, unmet condition check ConditionPathIsReadWrite=!/sysroot Jul 23 00:12:35.844918 systemd[1]: Reached target ignition-diskful.target - Ignition Boot Disk Setup. Jul 23 00:12:35.847803 systemd[1]: Mounted sysroot-usr.mount - /sysroot/usr. Jul 23 00:12:35.855074 systemd[1]: Starting initrd-setup-root.service - Root filesystem setup... Jul 23 00:12:36.094673 systemd-tmpfiles[1920]: /sysroot/usr/lib/tmpfiles.d/base_image_var.conf:1: Duplicate line for path "/sysroot/var", ignoring. Jul 23 00:12:36.094710 systemd-tmpfiles[1920]: /sysroot/usr/lib/tmpfiles.d/base_image_var.conf:7: Duplicate line for path "/sysroot/var/empty", ignoring. Jul 23 00:12:36.094815 systemd-tmpfiles[1920]: /sysroot/usr/lib/tmpfiles.d/base_image_var.conf:28: Duplicate line for path "/sysroot/var/log", ignoring. Jul 23 00:12:36.366254 coreos-metadata[1900]: Jul 23 00:12:36.365 INFO Fetching http://168.63.129.16/?comp=versions: Attempt #1 Jul 23 00:12:36.373355 coreos-metadata[1900]: Jul 23 00:12:36.373 INFO Fetch successful Jul 23 00:12:36.374617 coreos-metadata[1900]: Jul 23 00:12:36.373 INFO Fetching http://169.254.169.254/metadata/instance/compute/name?api-version=2017-08-01&format=text: Attempt #1 Jul 23 00:12:36.381944 coreos-metadata[1900]: Jul 23 00:12:36.381 INFO Fetch successful Jul 23 00:12:36.383340 coreos-metadata[1900]: Jul 23 00:12:36.382 INFO wrote hostname ci-4722.1.0-n-b387f73b01 to /sysroot/etc/hostname Jul 23 00:12:36.387670 systemd[1]: Finished flatcar-metadata-hostname.service - Flatcar Metadata Hostname Agent. Jul 23 00:12:36.390000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=flatcar-metadata-hostname comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Jul 23 00:12:37.144448 kernel: loop1: detected capacity change from 0 to 44152 Jul 23 00:12:37.177737 kernel: loop1: p1 p2 p3 Jul 23 00:12:37.551343 kernel: device-mapper: verity: sha256 using shash "sha256-ni" Jul 23 00:12:37.551397 kernel: device-mapper: verity: Unrecognized verity feature request: root_hash_sig_key_desc Jul 23 00:12:37.551411 kernel: device-mapper: table: 254:1: verity: Unrecognized verity feature request (-EINVAL) Jul 23 00:12:37.556420 kernel: device-mapper: ioctl: error adding target to table Jul 23 00:12:37.557004 systemd-confext[1980]: device-mapper: reload ioctl on loop1p1-14-verity (254:1) failed: Invalid argument Jul 23 00:12:37.583448 kernel: device-mapper: verity: sha256 using shash "sha256-ni" Jul 23 00:12:37.671463 kernel: erofs: (device dm-1): mounted with root inode @ nid 40. Jul 23 00:12:37.702462 kernel: loop2: detected capacity change from 0 to 44152 Jul 23 00:12:37.703469 kernel: loop2: p1 p2 p3 Jul 23 00:12:37.712613 kernel: device-mapper: verity: sha256 using shash "sha256-ni" Jul 23 00:12:37.712652 kernel: device-mapper: verity: Unrecognized verity feature request: root_hash_sig_key_desc Jul 23 00:12:37.719687 kernel: device-mapper: table: 254:1: verity: Unrecognized verity feature request (-EINVAL) Jul 23 00:12:37.719013 (sd-merge)[1991]: device-mapper: reload ioctl on loop2p1-18-verity (254:1) failed: Invalid argument Jul 23 00:12:37.722696 kernel: device-mapper: ioctl: error adding target to table Jul 23 00:12:37.727442 kernel: device-mapper: verity: sha256 using shash "sha256-ni" Jul 23 00:12:37.743274 (sd-merge)[1991]: Using extensions '00-flatcar-default.raw'. Jul 23 00:12:37.744568 (sd-merge)[1991]: Merged extensions into '/sysroot/etc'. Jul 23 00:12:37.747265 kernel: erofs: (device dm-1): mounted with root inode @ nid 40. Jul 23 00:12:37.749454 initrd-setup-root[1998]: /etc 00-flatcar-default Thu 2026-07-23 00:12:32 UTC Jul 23 00:12:37.751987 systemd[1]: Finished initrd-setup-root.service - Root filesystem setup. Jul 23 00:12:37.754000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=initrd-setup-root comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Jul 23 00:12:37.757673 kernel: kauditd_printk_skb: 30 callbacks suppressed Jul 23 00:12:37.757695 kernel: audit: type=1130 audit(1784765557.754:42): pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=initrd-setup-root comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Jul 23 00:12:37.759460 systemd[1]: Starting ignition-mount.service - Ignition (mount)... Jul 23 00:12:37.762142 systemd[1]: Starting sysroot-boot.service - /sysroot/boot... Jul 23 00:12:37.798773 systemd[1]: Finished sysroot-boot.service - /sysroot/boot. Jul 23 00:12:37.801000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=sysroot-boot comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Jul 23 00:12:37.804949 ignition[2007]: INFO : Ignition 2.24.0 Jul 23 00:12:37.809565 ignition[2007]: INFO : Stage: mount Jul 23 00:12:37.809565 ignition[2007]: INFO : no config dir at "/usr/lib/ignition/base.d" Jul 23 00:12:37.809565 ignition[2007]: INFO : no config dir at "/usr/lib/ignition/base.platform.d/azure" Jul 23 00:12:37.809565 ignition[2007]: INFO : mount: mount passed Jul 23 00:12:37.809565 ignition[2007]: INFO : Ignition finished successfully Jul 23 00:12:37.819839 kernel: audit: type=1130 audit(1784765557.801:43): pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=sysroot-boot comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Jul 23 00:12:37.811754 systemd[1]: Finished ignition-mount.service - Ignition (mount). Jul 23 00:12:37.821000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=ignition-mount comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Jul 23 00:12:37.825532 systemd[1]: Starting ignition-files.service - Ignition (files)... Jul 23 00:12:37.828505 kernel: audit: type=1130 audit(1784765557.821:44): pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=ignition-mount comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Jul 23 00:12:37.842266 systemd[1]: Mounting oem.mount - /oem... Jul 23 00:12:37.858447 kernel: BTRFS: device label OEM devid 1 transid 11 /dev/nvme0n1p6 (259:5) scanned by mount (2022) Jul 23 00:12:37.858482 kernel: BTRFS info (device nvme0n1p6): first mount of filesystem 90034852-0c2e-40a9-a4a4-507d2faace84 Jul 23 00:12:37.860726 kernel: BTRFS info (device nvme0n1p6): using crc32c (crc32c-intel) checksum algorithm Jul 23 00:12:37.866466 kernel: BTRFS info (device nvme0n1p6): enabling ssd optimizations Jul 23 00:12:37.866498 kernel: BTRFS info (device nvme0n1p6): turning on async discard Jul 23 00:12:37.867648 kernel: BTRFS info (device nvme0n1p6): enabling free space tree Jul 23 00:12:37.869903 systemd[1]: Mounted oem.mount - /oem. Jul 23 00:12:37.872481 systemd[1]: Mounting sysroot-oem.mount - /sysroot/oem... Jul 23 00:12:37.890860 systemd[1]: Mounted sysroot-oem.mount - /sysroot/oem. Jul 23 00:12:37.913395 ignition[2042]: INFO : Ignition 2.24.0 Jul 23 00:12:37.913395 ignition[2042]: INFO : Stage: files Jul 23 00:12:37.917559 ignition[2042]: INFO : no config dir at "/usr/lib/ignition/base.d" Jul 23 00:12:37.917559 ignition[2042]: INFO : no config dir at "/usr/lib/ignition/base.platform.d/azure" Jul 23 00:12:37.917559 ignition[2042]: DEBUG : files: compiled without relabeling support, skipping Jul 23 00:12:38.163436 ignition[2042]: INFO : files: ensureUsers: op(1): [started] creating or modifying user "flatcar" Jul 23 00:12:38.163436 ignition[2042]: DEBUG : files: ensureUsers: op(1): executing: "useradd" "--root" "/sysroot" "--create-home" "--password" "*" "--groups" "systemd-journal,sudo" "flatcar" Jul 23 00:12:39.254227 ignition[2042]: INFO : files: ensureUsers: op(1): [finished] creating or modifying user "flatcar" Jul 23 00:12:39.257568 ignition[2042]: INFO : files: ensureUsers: op(2): [started] adding ssh keys to user "flatcar" Jul 23 00:12:39.257568 ignition[2042]: INFO : files: ensureUsers: op(2): [finished] adding ssh keys to user "flatcar" Jul 23 00:12:39.254567 unknown[2042]: wrote ssh authorized keys file for user: flatcar Jul 23 00:12:39.291237 ignition[2042]: INFO : files: createFilesystemsFiles: createFiles: op(3): [started] writing file "/sysroot/etc/flatcar/update.conf" Jul 23 00:12:39.294017 ignition[2042]: INFO : files: createFilesystemsFiles: createFiles: op(3): [finished] writing file "/sysroot/etc/flatcar/update.conf" Jul 23 00:12:39.294017 ignition[2042]: INFO : files: createFilesystemsFiles: createFiles: op(4): [started] writing file "/sysroot/etc/systemd/user/hello.service" Jul 23 00:12:39.294017 ignition[2042]: INFO : files: createFilesystemsFiles: createFiles: op(4): [finished] writing file "/sysroot/etc/systemd/user/hello.service" Jul 23 00:12:39.294017 ignition[2042]: INFO : files: createFilesystemsFiles: createFiles: op(5): [started] writing file "/sysroot/var/lib/systemd/linger/flatcar" Jul 23 00:12:39.294017 ignition[2042]: INFO : files: createFilesystemsFiles: createFiles: op(5): [finished] writing file "/sysroot/var/lib/systemd/linger/flatcar" Jul 23 00:12:39.294017 ignition[2042]: INFO : files: createFilesystemsFiles: createFiles: op(6): [started] writing link "/sysroot/etc/systemd/user/default.target.wants/hello.service" -> "/etc/systemd/user/hello.service" Jul 23 00:12:39.294017 ignition[2042]: INFO : files: createFilesystemsFiles: createFiles: op(6): [finished] writing link "/sysroot/etc/systemd/user/default.target.wants/hello.service" -> "/etc/systemd/user/hello.service" Jul 23 00:12:39.294017 ignition[2042]: INFO : files: createResultFile: createFiles: op(7): [started] writing file "/sysroot/etc/.ignition-result.json" Jul 23 00:12:39.294017 ignition[2042]: INFO : files: createResultFile: createFiles: op(7): [finished] writing file "/sysroot/etc/.ignition-result.json" Jul 23 00:12:39.294017 ignition[2042]: INFO : files: files passed Jul 23 00:12:39.294017 ignition[2042]: INFO : Ignition finished successfully Jul 23 00:12:39.305000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=ignition-files comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Jul 23 00:12:39.326273 kernel: audit: type=1130 audit(1784765559.305:45): pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=ignition-files comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Jul 23 00:12:39.298618 systemd[1]: Finished ignition-files.service - Ignition (files). Jul 23 00:12:39.313301 systemd[1]: Starting ignition-quench.service - Ignition (record completion)... Jul 23 00:12:39.325525 systemd[1]: Starting initrd-setup-root-after-ignition.service - Root filesystem completion... Jul 23 00:12:39.340093 systemd[1]: ignition-quench.service: Deactivated successfully. Jul 23 00:12:39.342116 systemd[1]: Finished ignition-quench.service - Ignition (record completion). Jul 23 00:12:39.343000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=ignition-quench comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Jul 23 00:12:39.343000 audit[1]: SERVICE_STOP pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=ignition-quench comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Jul 23 00:12:39.350168 kernel: audit: type=1130 audit(1784765559.343:46): pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=ignition-quench comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Jul 23 00:12:39.350189 kernel: audit: type=1131 audit(1784765559.343:47): pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=ignition-quench comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Jul 23 00:12:39.375797 initrd-setup-root-after-ignition[2087]: grep: /sysroot/etc/flatcar/enabled-sysext.conf: No such file or directory Jul 23 00:12:39.375797 initrd-setup-root-after-ignition[2087]: grep: /sysroot/usr/share/flatcar/enabled-sysext.conf: No such file or directory Jul 23 00:12:39.382557 initrd-setup-root-after-ignition[2091]: grep: /sysroot/etc/flatcar/enabled-sysext.conf: No such file or directory Jul 23 00:12:39.386450 kernel: loop3: detected capacity change from 0 to 44152 Jul 23 00:12:39.388459 kernel: loop3: p1 p2 p3 Jul 23 00:12:39.395559 kernel: device-mapper: verity: sha256 using shash "sha256-ni" Jul 23 00:12:39.395657 kernel: device-mapper: verity: Unrecognized verity feature request: root_hash_sig_key_desc Jul 23 00:12:39.398171 kernel: device-mapper: table: 254:2: verity: Unrecognized verity feature request (-EINVAL) Jul 23 00:12:39.398209 kernel: device-mapper: ioctl: error adding target to table Jul 23 00:12:39.398372 systemd-confext[2093]: device-mapper: reload ioctl on loop3p1-21-verity (254:2) failed: Invalid argument Jul 23 00:12:39.401972 kernel: device-mapper: verity: sha256 using shash "sha256-ni" Jul 23 00:12:39.424451 kernel: erofs: (device dm-2): mounted with root inode @ nid 40. Jul 23 00:12:39.455443 kernel: loop4: detected capacity change from 0 to 44152 Jul 23 00:12:39.457451 kernel: loop4: p1 p2 p3 Jul 23 00:12:39.460969 kernel: device-mapper: verity: sha256 using shash "sha256-ni" Jul 23 00:12:39.461015 kernel: device-mapper: verity: Unrecognized verity feature request: root_hash_sig_key_desc Jul 23 00:12:39.462108 kernel: device-mapper: table: 254:2: verity: Unrecognized verity feature request (-EINVAL) Jul 23 00:12:39.463444 kernel: device-mapper: ioctl: error adding target to table Jul 23 00:12:39.463460 (sd-merge)[2101]: device-mapper: reload ioctl on loop4p1-25-verity (254:2) failed: Invalid argument Jul 23 00:12:39.467509 kernel: device-mapper: verity: sha256 using shash "sha256-ni" Jul 23 00:12:39.482378 (sd-merge)[2101]: Skipping extension refresh because no change was found, use --always-refresh=yes to always do a refresh. Jul 23 00:12:39.485073 kernel: erofs: (device dm-2): mounted with root inode @ nid 40. Jul 23 00:12:39.519464 kernel: loop4: detected capacity change from 0 to 388272 Jul 23 00:12:39.606440 kernel: loop4: p1 p2 p3 Jul 23 00:12:39.841329 kernel: device-mapper: verity: sha256 using shash "sha256-ni" Jul 23 00:12:39.841373 kernel: device-mapper: verity: Unrecognized verity feature request: root_hash_sig_key_desc Jul 23 00:12:39.842951 kernel: device-mapper: table: 254:2: verity: Unrecognized verity feature request (-EINVAL) Jul 23 00:12:39.844129 kernel: device-mapper: ioctl: error adding target to table Jul 23 00:12:39.844609 systemd-sysext[2110]: device-mapper: reload ioctl on loop4p1-29-verity (254:2) failed: Invalid argument Jul 23 00:12:39.849014 kernel: device-mapper: verity: sha256 using shash "sha256-ni" Jul 23 00:12:40.032450 kernel: erofs: (device dm-2): mounted with root inode @ nid 39. Jul 23 00:12:40.116473 kernel: loop5: detected capacity change from 0 to 185336 Jul 23 00:12:40.146441 kernel: loop5: p1 p2 p3 Jul 23 00:12:40.418194 kernel: device-mapper: verity: sha256 using shash "sha256-ni" Jul 23 00:12:40.418254 kernel: device-mapper: verity: Unrecognized verity feature request: root_hash_sig_key_desc Jul 23 00:12:40.419850 kernel: device-mapper: table: 254:2: verity: Unrecognized verity feature request (-EINVAL) Jul 23 00:12:40.421098 kernel: device-mapper: ioctl: error adding target to table Jul 23 00:12:40.421581 systemd-sysext[2110]: device-mapper: reload ioctl on loop5p1-33-verity (254:2) failed: Invalid argument Jul 23 00:12:40.424868 kernel: device-mapper: verity: sha256 using shash "sha256-ni" Jul 23 00:12:40.553559 kernel: erofs: (device dm-2): mounted with root inode @ nid 39. Jul 23 00:12:40.625448 kernel: loop6: detected capacity change from 0 to 137048 Jul 23 00:12:40.655536 kernel: loop6: p1 p2 p3 Jul 23 00:12:40.999187 kernel: device-mapper: verity: sha256 using shash "sha256-ni" Jul 23 00:12:40.999249 kernel: device-mapper: verity: Unrecognized verity feature request: root_hash_sig_key_desc Jul 23 00:12:41.001646 kernel: device-mapper: table: 254:2: verity: Unrecognized verity feature request (-EINVAL) Jul 23 00:12:41.003364 kernel: device-mapper: ioctl: error adding target to table Jul 23 00:12:41.003453 systemd-sysext[2110]: device-mapper: reload ioctl on loop6p1-37-verity (254:2) failed: Invalid argument Jul 23 00:12:41.010456 kernel: device-mapper: verity: sha256 using shash "sha256-ni" Jul 23 00:12:41.068439 kernel: erofs: (device dm-2): mounted with root inode @ nid 39. Jul 23 00:12:41.096453 kernel: loop7: detected capacity change from 0 to 388272 Jul 23 00:12:41.098616 kernel: loop7: p1 p2 p3 Jul 23 00:12:41.114257 kernel: device-mapper: verity: sha256 using shash "sha256-ni" Jul 23 00:12:41.114291 kernel: device-mapper: verity: Unrecognized verity feature request: root_hash_sig_key_desc Jul 23 00:12:41.114303 kernel: device-mapper: table: 254:2: verity: Unrecognized verity feature request (-EINVAL) Jul 23 00:12:41.116806 kernel: device-mapper: ioctl: error adding target to table Jul 23 00:12:41.116843 (sd-merge)[2133]: device-mapper: reload ioctl on loop7p1-41-verity (254:2) failed: Invalid argument Jul 23 00:12:41.120816 kernel: device-mapper: verity: sha256 using shash "sha256-ni" Jul 23 00:12:41.152445 kernel: erofs: (device dm-2): mounted with root inode @ nid 39. Jul 23 00:12:41.156443 kernel: loop1: detected capacity change from 0 to 185336 Jul 23 00:12:41.158459 kernel: loop1: p1 p2 p3 Jul 23 00:12:41.166904 kernel: device-mapper: verity: sha256 using shash "sha256-ni" Jul 23 00:12:41.166951 kernel: device-mapper: verity: Unrecognized verity feature request: root_hash_sig_key_desc Jul 23 00:12:41.171776 kernel: device-mapper: table: 254:3: verity: Unrecognized verity feature request (-EINVAL) Jul 23 00:12:41.171810 kernel: device-mapper: ioctl: error adding target to table Jul 23 00:12:41.175465 (sd-merge)[2133]: device-mapper: reload ioctl on loop1p1-45-verity (254:3) failed: Invalid argument Jul 23 00:12:41.183195 kernel: device-mapper: verity: sha256 using shash "sha256-ni" Jul 23 00:12:41.211443 kernel: erofs: (device dm-3): mounted with root inode @ nid 39. Jul 23 00:12:41.213444 kernel: loop3: detected capacity change from 0 to 137048 Jul 23 00:12:41.215440 kernel: loop3: p1 p2 p3 Jul 23 00:12:41.228116 kernel: device-mapper: verity: sha256 using shash "sha256-ni" Jul 23 00:12:41.233020 kernel: device-mapper: verity: Unrecognized verity feature request: root_hash_sig_key_desc Jul 23 00:12:41.233053 kernel: device-mapper: table: 254:4: verity: Unrecognized verity feature request (-EINVAL) Jul 23 00:12:41.236104 kernel: device-mapper: ioctl: error adding target to table Jul 23 00:12:41.236157 (sd-merge)[2133]: device-mapper: reload ioctl on loop3p1-49-verity (254:4) failed: Invalid argument Jul 23 00:12:41.243582 kernel: device-mapper: verity: sha256 using shash "sha256-ni" Jul 23 00:12:41.271306 (sd-merge)[2133]: Using extensions 'containerd-flatcar.raw', 'docker-flatcar.raw', 'oem-azure-4722.1.0+nightly-20260722-2100.raw'. Jul 23 00:12:41.274201 (sd-merge)[2133]: Merged extensions into '/sysroot/usr'. Jul 23 00:12:41.276904 kernel: erofs: (device dm-4): mounted with root inode @ nid 39. Jul 23 00:12:41.278518 systemd[1]: Finished initrd-setup-root-after-ignition.service - Root filesystem completion. Jul 23 00:12:41.278000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=initrd-setup-root-after-ignition comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Jul 23 00:12:41.288599 kernel: audit: type=1130 audit(1784765561.278:48): pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=initrd-setup-root-after-ignition comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Jul 23 00:12:41.283562 systemd[1]: Starting initrd-parse-etc.service - Mountpoints Configured in the Real Root... Jul 23 00:12:41.313559 systemd[1]: initrd-parse-etc.service: Deactivated successfully. Jul 23 00:12:41.315718 systemd[1]: Finished initrd-parse-etc.service - Mountpoints Configured in the Real Root. Jul 23 00:12:41.317000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=initrd-parse-etc comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Jul 23 00:12:41.319284 systemd[1]: initrd-parse-etc.service: Triggering OnSuccess= dependencies. Jul 23 00:12:41.317000 audit[1]: SERVICE_STOP pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=initrd-parse-etc comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Jul 23 00:12:41.330070 kernel: audit: type=1130 audit(1784765561.317:49): pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=initrd-parse-etc comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Jul 23 00:12:41.321633 systemd[1]: Reached target initrd-fs.target - Initrd File Systems. Jul 23 00:12:41.333490 kernel: audit: type=1131 audit(1784765561.317:50): pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=initrd-parse-etc comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Jul 23 00:12:41.335995 systemd[1]: Starting dracut-mount.service - dracut mount hook... Jul 23 00:12:41.698739 systemd[1]: Finished dracut-mount.service - dracut mount hook. Jul 23 00:12:41.697000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=dracut-mount comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Jul 23 00:12:41.704028 kernel: audit: type=1130 audit(1784765561.697:51): pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=dracut-mount comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Jul 23 00:12:41.705302 systemd[1]: Starting dracut-pre-pivot.service - dracut pre-pivot and cleanup hook... Jul 23 00:12:41.721880 systemd[1]: Finished dracut-pre-pivot.service - dracut pre-pivot and cleanup hook. Jul 23 00:12:41.720000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=dracut-pre-pivot comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Jul 23 00:12:41.725026 systemd[1]: Starting initrd-cleanup.service - Cleaning Up and Shutting Down Daemons... Jul 23 00:12:41.745959 systemd[1]: Stopped target basic.target - Basic System. Jul 23 00:12:41.746540 systemd[1]: Stopped target ignition-diskful.target - Ignition Boot Disk Setup. Jul 23 00:12:41.746795 systemd[1]: Stopped target initrd-root-device.target - Initrd Root Device. Jul 23 00:12:41.752010 systemd[1]: Stopped target initrd-usr-fs.target - Initrd /usr File System. Jul 23 00:12:41.755607 systemd[1]: Stopped target nss-lookup.target - Host and Network Name Lookups. Jul 23 00:12:41.759575 systemd[1]: Stopped target paths.target - Path Units. Jul 23 00:12:41.763581 systemd[1]: Stopped target remote-cryptsetup.target - Remote Encrypted Volumes. Jul 23 00:12:41.767588 systemd[1]: Stopped target slices.target - Slice Units. Jul 23 00:12:41.769655 systemd[1]: Stopped target sockets.target - Socket Units. Jul 23 00:12:41.772219 systemd[1]: Stopped target sysinit.target - System Initialization. Jul 23 00:12:41.775577 systemd[1]: Stopped target local-fs.target - Local File Systems. Jul 23 00:12:41.778969 systemd[1]: Stopped target swap.target - Swaps. Jul 23 00:12:41.782812 systemd[1]: Stopped target timers.target - Timer Units. Jul 23 00:12:41.785364 systemd[1]: iscsid.socket: Deactivated successfully. Jul 23 00:12:41.785467 systemd[1]: Closed iscsid.socket - Open-iSCSI iscsid Socket. Jul 23 00:12:41.793947 systemd[1]: iscsiuio.socket: Deactivated successfully. Jul 23 00:12:41.794059 systemd[1]: Closed iscsiuio.socket - Open-iSCSI iscsiuio Socket. Jul 23 00:12:41.800142 systemd[1]: systemd-coredump.socket: Deactivated successfully. Jul 23 00:12:41.803000 audit[1]: SERVICE_STOP pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=dracut-pre-pivot comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Jul 23 00:12:41.806000 audit[1]: SERVICE_STOP pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=dracut-mount comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Jul 23 00:12:41.800287 systemd[1]: Closed systemd-coredump.socket - Process Core Dump Socket. Jul 23 00:12:41.814000 audit[1]: SERVICE_STOP pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=dracut-pre-mount comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Jul 23 00:12:41.802770 systemd[1]: systemd-journald-audit.socket: Deactivated successfully. Jul 23 00:12:41.802871 systemd[1]: Closed systemd-journald-audit.socket - Journal Audit Socket. Jul 23 00:12:41.804923 systemd[1]: dracut-pre-pivot.service: Deactivated successfully. Jul 23 00:12:41.805084 systemd[1]: Stopped dracut-pre-pivot.service - dracut pre-pivot and cleanup hook. Jul 23 00:12:41.807213 systemd[1]: Stopped target remote-fs.target - Remote File Systems. Jul 23 00:12:41.807481 systemd[1]: Stopped target remote-fs-pre.target - Preparation for Remote File Systems. Jul 23 00:12:41.807762 systemd[1]: dracut-mount.service: Deactivated successfully. Jul 23 00:12:41.807871 systemd[1]: Stopped dracut-mount.service - dracut mount hook. Jul 23 00:12:41.809898 systemd[1]: dracut-pre-mount.service: Deactivated successfully. Jul 23 00:12:41.810060 systemd[1]: Stopped dracut-pre-mount.service - dracut pre-mount hook. Jul 23 00:12:41.817236 systemd[1]: Stopped target cryptsetup.target - Local Encrypted Volumes. Jul 23 00:12:41.820609 systemd[1]: systemd-ask-password-console.path: Deactivated successfully. Jul 23 00:12:41.820892 systemd[1]: Stopped systemd-ask-password-console.path - Dispatch Password Requests to Console Directory Watch. Jul 23 00:12:41.836410 systemd[1]: Stopped target cryptsetup-pre.target - Local Encrypted Volumes (Pre). Jul 23 00:12:41.836906 systemd[1]: clevis-luks-askpass.path: Deactivated successfully. Jul 23 00:12:41.837150 systemd[1]: Stopped clevis-luks-askpass.path - Forward Password Requests to Clevis Directory Watch. Jul 23 00:12:41.843579 systemd[1]: dracut-initqueue.service: Deactivated successfully. Jul 23 00:12:41.846000 audit[1]: SERVICE_STOP pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=dracut-initqueue comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Jul 23 00:12:41.843688 systemd[1]: Stopped dracut-initqueue.service - dracut initqueue hook. Jul 23 00:12:41.849183 systemd[1]: initrd-setup-root-after-ignition.service: Deactivated successfully. Jul 23 00:12:41.850000 audit[1]: SERVICE_STOP pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=initrd-setup-root-after-ignition comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Jul 23 00:12:41.849350 systemd[1]: Stopped initrd-setup-root-after-ignition.service - Root filesystem completion. Jul 23 00:12:41.854347 systemd[1]: ignition-files.service: Deactivated successfully. Jul 23 00:12:41.855000 audit[1]: SERVICE_STOP pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=ignition-files comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Jul 23 00:12:41.858000 audit[1]: SERVICE_STOP pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=flatcar-metadata-hostname comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Jul 23 00:12:41.854516 systemd[1]: Stopped ignition-files.service - Ignition (files). Jul 23 00:12:41.858346 systemd[1]: flatcar-metadata-hostname.service: Deactivated successfully. Jul 23 00:12:41.858497 systemd[1]: Stopped flatcar-metadata-hostname.service - Flatcar Metadata Hostname Agent. Jul 23 00:12:41.863970 systemd[1]: Stopping ignition-mount.service - Ignition (mount)... Jul 23 00:12:41.879589 systemd[1]: Stopping sysroot-boot.service - /sysroot/boot... Jul 23 00:12:41.882604 systemd[1]: systemd-modules-load.service: Deactivated successfully. Jul 23 00:12:41.887000 audit[1]: SERVICE_STOP pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=systemd-modules-load comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Jul 23 00:12:41.882748 systemd[1]: Stopped systemd-modules-load.service - Load Kernel Modules. Jul 23 00:12:41.893514 systemd[1]: systemd-tmpfiles-setup.service: Deactivated successfully. Jul 23 00:12:41.893680 systemd[1]: Stopped systemd-tmpfiles-setup.service - Create System Files and Directories. Jul 23 00:12:41.894776 ignition[2208]: INFO : Ignition 2.24.0 Jul 23 00:12:41.894776 ignition[2208]: INFO : Stage: umount Jul 23 00:12:41.896078 ignition[2208]: INFO : no config dir at "/usr/lib/ignition/base.d" Jul 23 00:12:41.896078 ignition[2208]: INFO : no config dir at "/usr/lib/ignition/base.platform.d/azure" Jul 23 00:12:41.896078 ignition[2208]: INFO : umount: umount passed Jul 23 00:12:41.896078 ignition[2208]: INFO : Ignition finished successfully Jul 23 00:12:41.904000 audit[1]: SERVICE_STOP pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=systemd-tmpfiles-setup comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Jul 23 00:12:41.919182 systemd[1]: systemd-udev-trigger.service: Deactivated successfully. Jul 23 00:12:41.920784 systemd[1]: Stopped systemd-udev-trigger.service - Coldplug All udev Devices. Jul 23 00:12:41.923000 audit[1]: SERVICE_STOP pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=systemd-udev-trigger comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Jul 23 00:12:41.928315 systemd[1]: dracut-pre-trigger.service: Deactivated successfully. Jul 23 00:12:41.929890 systemd[1]: Stopped dracut-pre-trigger.service - dracut pre-trigger hook. Jul 23 00:12:41.931000 audit[1]: SERVICE_STOP pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=dracut-pre-trigger comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Jul 23 00:12:41.936540 systemd[1]: ignition-mount.service: Deactivated successfully. Jul 23 00:12:41.937564 systemd[1]: Stopped ignition-mount.service - Ignition (mount). Jul 23 00:12:41.939000 audit[1]: SERVICE_STOP pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=ignition-mount comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Jul 23 00:12:41.944738 systemd[1]: initrd-cleanup.service: Deactivated successfully. Jul 23 00:12:41.944000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=initrd-cleanup comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Jul 23 00:12:41.944000 audit[1]: SERVICE_STOP pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=initrd-cleanup comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Jul 23 00:12:41.946000 audit[1]: SERVICE_STOP pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=ignition-disks comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Jul 23 00:12:41.948000 audit[1]: SERVICE_STOP pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=ignition-setup-pre comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Jul 23 00:12:41.945690 systemd[1]: Finished initrd-cleanup.service - Cleaning Up and Shutting Down Daemons. Jul 23 00:12:41.947730 systemd[1]: Stopped target network.target - Network. Jul 23 00:12:41.961000 audit[1]: SERVICE_STOP pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=systemd-resolved comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Jul 23 00:12:41.947916 systemd[1]: ignition-disks.service: Deactivated successfully. Jul 23 00:12:41.963000 audit: BPF prog-id=5 op=UNLOAD Jul 23 00:12:41.947965 systemd[1]: Stopped ignition-disks.service - Ignition (disks). Jul 23 00:12:41.949948 systemd[1]: ignition-setup-pre.service: Deactivated successfully. Jul 23 00:12:41.949987 systemd[1]: Stopped ignition-setup-pre.service - Ignition env setup. Jul 23 00:12:41.952077 systemd[1]: Stopping systemd-networkd.service - Network Management... Jul 23 00:12:41.952415 systemd[1]: Stopping systemd-resolved.service - Network Name Resolution... Jul 23 00:12:41.960442 systemd[1]: systemd-resolved.service: Deactivated successfully. Jul 23 00:12:41.961373 systemd[1]: Stopped systemd-resolved.service - Network Name Resolution. Jul 23 00:12:41.976000 audit[1]: SERVICE_STOP pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=systemd-networkd comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Jul 23 00:12:41.970047 systemd[1]: systemd-networkd.service: Deactivated successfully. Jul 23 00:12:41.975975 systemd[1]: Stopped systemd-networkd.service - Network Management. Jul 23 00:12:41.983343 systemd[1]: sysroot-boot.mount: Deactivated successfully. Jul 23 00:12:41.985000 audit: BPF prog-id=8 op=UNLOAD Jul 23 00:12:41.987244 systemd[1]: Stopped target network-pre.target - Preparation for Network. Jul 23 00:12:41.990687 systemd[1]: systemd-networkd-resolve-hook.socket: Deactivated successfully. Jul 23 00:12:41.990739 systemd[1]: Closed systemd-networkd-resolve-hook.socket - Network Management Resolve Hook Socket. Jul 23 00:12:41.999211 systemd[1]: systemd-networkd.socket: Deactivated successfully. Jul 23 00:12:41.999257 systemd[1]: Closed systemd-networkd.socket - Network Management Netlink Socket. Jul 23 00:12:42.006897 systemd[1]: Stopping network-cleanup.service - Network Cleanup... Jul 23 00:12:42.009516 systemd[1]: parse-ip-for-networkd.service: Deactivated successfully. Jul 23 00:12:42.010756 systemd[1]: Stopped parse-ip-for-networkd.service - Write systemd-networkd units from cmdline. Jul 23 00:12:42.013000 audit[1]: SERVICE_STOP pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=parse-ip-for-networkd comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Jul 23 00:12:42.017312 systemd[1]: Stopping systemd-udevd.service - Rule-based Manager for Device Events and Files... Jul 23 00:12:42.023766 systemd[1]: sysroot-boot.service: Deactivated successfully. Jul 23 00:12:42.026847 systemd[1]: Stopped sysroot-boot.service - /sysroot/boot. Jul 23 00:12:42.030000 audit[1]: SERVICE_STOP pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=sysroot-boot comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Jul 23 00:12:42.066403 systemd[1]: initrd-setup-root.service: Deactivated successfully. Jul 23 00:12:42.066494 systemd[1]: Stopped initrd-setup-root.service - Root filesystem setup. Jul 23 00:12:42.068000 audit[1]: SERVICE_STOP pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=initrd-setup-root comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Jul 23 00:12:42.085351 systemd[1]: systemd-udevd.service: Deactivated successfully. Jul 23 00:12:42.087282 systemd[1]: Stopped systemd-udevd.service - Rule-based Manager for Device Events and Files. Jul 23 00:12:42.088000 audit[1]: SERVICE_STOP pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=systemd-udevd comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Jul 23 00:12:42.091591 systemd[1]: systemd-udevd-control.socket: Deactivated successfully. Jul 23 00:12:42.092088 systemd[1]: Closed systemd-udevd-control.socket - udev Control Socket. Jul 23 00:12:42.096890 systemd[1]: dracut-pre-udev.service: Deactivated successfully. Jul 23 00:12:42.096936 systemd[1]: Stopped dracut-pre-udev.service - dracut pre-udev hook. Jul 23 00:12:42.098000 audit[1]: SERVICE_STOP pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=dracut-pre-udev comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Jul 23 00:12:42.101730 systemd[1]: dracut-cmdline.service: Deactivated successfully. Jul 23 00:12:42.101775 systemd[1]: Stopped dracut-cmdline.service - dracut cmdline hook. Jul 23 00:12:42.104000 audit[1]: SERVICE_STOP pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=dracut-cmdline comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Jul 23 00:12:42.107895 systemd[1]: dracut-cmdline-ask.service: Deactivated successfully. Jul 23 00:12:42.107945 systemd[1]: Stopped dracut-cmdline-ask.service - dracut ask for additional cmdline parameters. Jul 23 00:12:42.112000 audit[1]: SERVICE_STOP pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=dracut-cmdline-ask comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Jul 23 00:12:42.118897 systemd[1]: Starting initrd-udevadm-cleanup-db.service - Cleanup udev Database... Jul 23 00:12:42.122650 systemd[1]: systemd-network-generator.service: Deactivated successfully. Jul 23 00:12:42.124000 audit[1]: SERVICE_STOP pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=systemd-network-generator comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Jul 23 00:12:42.122701 systemd[1]: Stopped systemd-network-generator.service - Generate Network Units from Kernel Command Line. Jul 23 00:12:42.130510 systemd[1]: systemd-tmpfiles-setup-dev.service: Deactivated successfully. Jul 23 00:12:42.133000 audit[1]: SERVICE_STOP pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=systemd-tmpfiles-setup-dev comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Jul 23 00:12:42.130559 systemd[1]: Stopped systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev. Jul 23 00:12:42.138857 systemd[1]: systemd-tmpfiles-setup-dev-early.service: Deactivated successfully. Jul 23 00:12:42.139000 audit[1]: SERVICE_STOP pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=systemd-tmpfiles-setup-dev-early comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Jul 23 00:12:42.138895 systemd[1]: Stopped systemd-tmpfiles-setup-dev-early.service - Create Static Device Nodes in /dev gracefully. Jul 23 00:12:42.144501 systemd[1]: kmod-static-nodes.service: Deactivated successfully. Jul 23 00:12:42.145000 audit[1]: SERVICE_STOP pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=kmod-static-nodes comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Jul 23 00:12:42.144542 systemd[1]: Stopped kmod-static-nodes.service - Create List of Static Device Nodes. Jul 23 00:12:42.149000 audit[1]: SERVICE_STOP pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=systemd-vconsole-setup comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Jul 23 00:12:42.148875 systemd[1]: systemd-vconsole-setup.service: Deactivated successfully. Jul 23 00:12:42.148916 systemd[1]: Stopped systemd-vconsole-setup.service - Virtual Console Setup. Jul 23 00:12:42.155353 systemd[1]: initrd-udevadm-cleanup-db.service: Deactivated successfully. Jul 23 00:12:42.158648 systemd[1]: Finished initrd-udevadm-cleanup-db.service - Cleanup udev Database. Jul 23 00:12:42.159000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=initrd-udevadm-cleanup-db comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Jul 23 00:12:42.159000 audit[1]: SERVICE_STOP pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=initrd-udevadm-cleanup-db comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Jul 23 00:12:42.178752 kernel: hv_netvsc f8615163-0000-1000-2000-7ced8d77b541 eth0: Data path switched from VF: enP30832s1 Jul 23 00:12:42.179068 kernel: mana 7870:00:00.0 enP30832s1: Configured steering vPort 0 entries 64 Jul 23 00:12:42.180813 systemd[1]: network-cleanup.service: Deactivated successfully. Jul 23 00:12:42.182799 systemd[1]: Stopped network-cleanup.service - Network Cleanup. Jul 23 00:12:42.181000 audit[1]: SERVICE_STOP pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=network-cleanup comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Jul 23 00:12:42.185288 systemd[1]: Reached target initrd-switch-root.target - Switch Root. Jul 23 00:12:42.188169 systemd[1]: Starting initrd-switch-root.service - Switch Root... Jul 23 00:12:42.202153 systemd[1]: Switching root. Jul 23 00:12:42.378215 systemd-journald[1142]: Journal stopped Jul 23 00:12:47.099372 systemd-journald[1142]: Received SIGTERM from PID 1 (systemd). Jul 23 00:12:47.099461 kernel: SELinux: policy capability network_peer_controls=1 Jul 23 00:12:47.099483 kernel: SELinux: policy capability open_perms=1 Jul 23 00:12:47.099498 kernel: SELinux: policy capability extended_socket_class=1 Jul 23 00:12:47.099513 kernel: SELinux: policy capability always_check_network=0 Jul 23 00:12:47.099527 kernel: SELinux: policy capability cgroup_seclabel=1 Jul 23 00:12:47.099539 kernel: SELinux: policy capability nnp_nosuid_transition=1 Jul 23 00:12:47.099555 kernel: SELinux: policy capability genfs_seclabel_symlinks=0 Jul 23 00:12:47.099568 kernel: SELinux: policy capability ioctl_skip_cloexec=0 Jul 23 00:12:47.099585 kernel: SELinux: policy capability userspace_initial_context=0 Jul 23 00:12:47.099605 systemd[1]: Successfully loaded SELinux policy in 122.966ms. Jul 23 00:12:47.099628 systemd[1]: Relabeled /dev/, /dev/shm/, /run/ in 5.681ms. Jul 23 00:12:47.099648 systemd[1]: systemd 260.1 running in system mode (+PAM +AUDIT +SELINUX -APPARMOR +IMA +IPE +SMACK +SECCOMP -GCRYPT -GNUTLS +OPENSSL -ACL +BLKID +CURL +ELFUTILS -FIDO2 +IDN2 +KMOD +LIBCRYPTSETUP +LIBCRYPTSETUP_PLUGINS +LIBFDISK +PCRE2 -PWQUALITY -P11KIT -QRENCODE +TPM2 +BZIP2 +LZ4 +XZ +ZLIB +ZSTD -BPF_FRAMEWORK -BTF -XKBCOMMON +UTMP +LIBARCHIVE) Jul 23 00:12:47.099665 systemd[1]: Detected virtualization microsoft. Jul 23 00:12:47.099682 systemd[1]: Detected architecture x86-64. Jul 23 00:12:47.099698 systemd[1]: Detected first boot. Jul 23 00:12:47.099714 systemd[1]: Initializing machine ID from random generator. Jul 23 00:12:47.099728 systemd[1]: Hostname set to . Jul 23 00:12:47.099742 kernel: kauditd_printk_skb: 38 callbacks suppressed Jul 23 00:12:47.099765 kernel: audit: type=1334 audit(1784765564.375:90): prog-id=9 op=LOAD Jul 23 00:12:47.099787 kernel: audit: type=1334 audit(1784765564.375:91): prog-id=9 op=UNLOAD Jul 23 00:12:47.099810 zram_generator::config[2510]: No configuration found. Jul 23 00:12:47.099835 kernel: Guest personality initialized and is inactive Jul 23 00:12:47.099847 kernel: VMCI host device registered (name=vmci, major=10, minor=259) Jul 23 00:12:47.099871 kernel: Initialized host personality Jul 23 00:12:47.099886 kernel: NET: Registered PF_VSOCK protocol family Jul 23 00:12:47.099908 systemd[1]: Applying preset policy. Jul 23 00:12:47.099926 systemd[1]: Created symlink '/etc/systemd/system/timers.target.wants/google-oslogin-cache.timer' → '/usr/lib/systemd/system/google-oslogin-cache.timer'. Jul 23 00:12:47.099950 systemd[1]: Populated /etc with preset unit settings. Jul 23 00:12:47.099964 kernel: audit: type=1334 audit(1784765566.516:92): prog-id=10 op=LOAD Jul 23 00:12:47.099980 kernel: audit: type=1334 audit(1784765566.516:93): prog-id=2 op=UNLOAD Jul 23 00:12:47.099996 kernel: audit: type=1334 audit(1784765566.516:94): prog-id=11 op=LOAD Jul 23 00:12:47.100012 kernel: audit: type=1334 audit(1784765566.516:95): prog-id=12 op=LOAD Jul 23 00:12:47.100025 kernel: audit: type=1334 audit(1784765566.516:96): prog-id=3 op=UNLOAD Jul 23 00:12:47.100038 kernel: audit: type=1334 audit(1784765566.516:97): prog-id=4 op=UNLOAD Jul 23 00:12:47.100058 kernel: audit: type=1334 audit(1784765566.518:98): prog-id=13 op=LOAD Jul 23 00:12:47.100070 kernel: audit: type=1334 audit(1784765566.518:99): prog-id=10 op=UNLOAD Jul 23 00:12:47.100089 systemd[1]: initrd-switch-root.service: Deactivated successfully. Jul 23 00:12:47.100103 systemd[1]: Stopped initrd-switch-root.service - Switch Root. Jul 23 00:12:47.100124 systemd[1]: systemd-journald.service: Scheduled restart job, restart counter is at 1. Jul 23 00:12:47.100147 systemd[1]: Created slice system-addon\x2dconfig.slice - Slice /system/addon-config. Jul 23 00:12:47.100164 systemd[1]: Created slice system-addon\x2drun.slice - Slice /system/addon-run. Jul 23 00:12:47.100184 systemd[1]: Created slice system-getty.slice - Slice /system/getty. Jul 23 00:12:47.100199 systemd[1]: Created slice system-modprobe.slice - Slice /system/modprobe. Jul 23 00:12:47.100216 systemd[1]: Created slice system-serial\x2dgetty.slice - Slice /system/serial-getty. Jul 23 00:12:47.100232 systemd[1]: Created slice system-system\x2dcloudinit.slice - Slice /system/system-cloudinit. Jul 23 00:12:47.100254 systemd[1]: Created slice system-systemd\x2dfsck.slice - Slice /system/systemd-fsck. Jul 23 00:12:47.100270 systemd[1]: Created slice user.slice - User and Session Slice. Jul 23 00:12:47.100281 systemd[1]: Started clevis-luks-askpass.path - Forward Password Requests to Clevis Directory Watch. Jul 23 00:12:47.100299 systemd[1]: Started systemd-ask-password-console.path - Dispatch Password Requests to Console Directory Watch. Jul 23 00:12:47.100321 systemd[1]: Started systemd-ask-password-wall.path - Forward Password Requests to Wall Directory Watch. Jul 23 00:12:47.100340 systemd[1]: Set up automount boot.automount - Boot partition Automount Point. Jul 23 00:12:47.100356 systemd[1]: Set up automount proc-sys-fs-binfmt_misc.automount - Arbitrary Executable File Formats File System Automount Point. Jul 23 00:12:47.100371 systemd[1]: Expecting device dev-disk-by\x2dlabel-OEM.device - /dev/disk/by-label/OEM... Jul 23 00:12:47.100383 systemd[1]: Expecting device dev-ptp_hyperv.device - /dev/ptp_hyperv... Jul 23 00:12:47.100396 systemd[1]: Expecting device dev-ttyS0.device - /dev/ttyS0... Jul 23 00:12:47.100408 systemd[1]: Reached target cryptsetup-pre.target - Local Encrypted Volumes (Pre). Jul 23 00:12:47.104967 systemd[1]: Reached target cryptsetup.target - Local Encrypted Volumes. Jul 23 00:12:47.104999 systemd[1]: Reached target imports.target - Image Downloads. Jul 23 00:12:47.105020 systemd[1]: Stopped target initrd-switch-root.target - Switch Root. Jul 23 00:12:47.105046 systemd[1]: Stopped target initrd-fs.target - Initrd File Systems. Jul 23 00:12:47.105068 systemd[1]: Stopped target initrd-root-fs.target - Initrd Root File System. Jul 23 00:12:47.105090 systemd[1]: Reached target integritysetup.target - Local Integrity Protected Volumes. Jul 23 00:12:47.105114 systemd[1]: Reached target remote-cryptsetup.target - Remote Encrypted Volumes. Jul 23 00:12:47.105134 systemd[1]: Reached target remote-fs.target - Remote File Systems. Jul 23 00:12:47.105154 systemd[1]: Reached target remote-integritysetup.target - Remote Integrity Protected Volumes. Jul 23 00:12:47.105169 systemd[1]: Reached target remote-veritysetup.target - Remote Verity Protected Volumes. Jul 23 00:12:47.105184 systemd[1]: Reached target slices.target - Slice Units. Jul 23 00:12:47.105205 systemd[1]: Reached target swap.target - Swaps. Jul 23 00:12:47.105226 systemd[1]: Reached target veritysetup.target - Local Verity Protected Volumes. Jul 23 00:12:47.105245 systemd[1]: Listening on systemd-ask-password.socket - Query the User Interactively for a Password. Jul 23 00:12:47.105264 systemd[1]: Listening on systemd-coredump.socket - Process Core Dump Socket. Jul 23 00:12:47.105279 systemd[1]: Listening on systemd-creds.socket - Credential Encryption/Decryption. Jul 23 00:12:47.105295 systemd[1]: Listening on systemd-factory-reset.socket - Factory Reset Management. Jul 23 00:12:47.105316 systemd[1]: Listening on systemd-journald-audit.socket - Journal Audit Socket. Jul 23 00:12:47.105330 systemd[1]: Listening on systemd-mountfsd.socket - DDI File System Mounter Socket. Jul 23 00:12:47.105350 systemd[1]: Listening on systemd-mute-console.socket - Console Output Muting Service Socket. Jul 23 00:12:47.105373 systemd[1]: Listening on systemd-networkd-resolve-hook.socket - Network Management Resolve Hook Socket. Jul 23 00:12:47.105386 systemd[1]: Listening on systemd-networkd-varlink-metrics.socket - Network Management Metrics Varlink Socket. Jul 23 00:12:47.105405 systemd[1]: Listening on systemd-networkd-varlink.socket - Network Management Varlink Socket. Jul 23 00:12:47.105421 systemd[1]: Listening on systemd-networkd.socket - Network Management Netlink Socket. Jul 23 00:12:47.105452 systemd[1]: Listening on systemd-nsresourced.socket - Namespace Resource Manager Socket. Jul 23 00:12:47.105469 systemd[1]: Listening on systemd-oomd.socket - Userspace Out-Of-Memory (OOM) Killer Socket. Jul 23 00:12:47.105483 systemd[1]: Listening on systemd-repart.socket - Disk Repartitioning Service Socket. Jul 23 00:12:47.105495 systemd[1]: Listening on systemd-resolved-monitor.socket - Resolve Monitor Varlink Socket. Jul 23 00:12:47.105508 systemd[1]: Listening on systemd-resolved-varlink.socket - Resolve Service Varlink Socket. Jul 23 00:12:47.105521 systemd[1]: Listening on systemd-udevd-control.socket - udev Control Socket. Jul 23 00:12:47.105537 systemd[1]: Listening on systemd-udevd-varlink.socket - udev Varlink Socket. Jul 23 00:12:47.105553 systemd[1]: Listening on systemd-userdbd.socket - User Database Manager Socket. Jul 23 00:12:47.105571 systemd[1]: Mounting dev-hugepages.mount - Huge Pages File System... Jul 23 00:12:47.105587 systemd[1]: Mounting dev-mqueue.mount - POSIX Message Queue File System... Jul 23 00:12:47.105603 systemd[1]: Mounting media.mount - External Media Directory... Jul 23 00:12:47.105616 systemd[1]: proc-xen.mount - /proc/xen skipped, unmet condition check ConditionVirtualization=xen Jul 23 00:12:47.105627 systemd[1]: Mounting sys-kernel-debug.mount - Kernel Debug File System... Jul 23 00:12:47.106230 systemd[1]: Mounting sys-kernel-tracing.mount - Kernel Trace File System... Jul 23 00:12:47.106247 systemd[1]: tmp.mount: x-systemd.graceful-option=usrquota specified, but option is not available, suppressing. Jul 23 00:12:47.106259 systemd[1]: Mounting tmp.mount - Temporary Directory /tmp... Jul 23 00:12:47.106272 systemd[1]: var-lib-machines.mount - Virtual Machine and Container Storage (Compatibility) skipped, unmet condition check ConditionPathExists=/var/lib/machines.raw Jul 23 00:12:47.106283 systemd[1]: Reached target machines.target - Virtual Machines and Containers. Jul 23 00:12:47.106294 systemd[1]: Starting flatcar-tmpfiles.service - Create missing system files... Jul 23 00:12:47.106305 systemd[1]: ignition-delete-config.service - Ignition (delete config) skipped, no trigger condition checks were met. Jul 23 00:12:47.106322 systemd[1]: Starting kmod-static-nodes.service - Create List of Static Device Nodes... Jul 23 00:12:47.106334 systemd[1]: Starting modprobe@configfs.service - Load Kernel Module configfs... Jul 23 00:12:47.106346 systemd[1]: modprobe@drm.service - Load Kernel Module drm skipped, unmet condition check ConditionKernelModuleLoaded=!drm Jul 23 00:12:47.106361 systemd[1]: modprobe@efi_pstore.service - Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore Jul 23 00:12:47.106372 systemd[1]: Starting modprobe@fuse.service - Load Kernel Module fuse... Jul 23 00:12:47.106383 systemd[1]: setup-nsswitch.service - Create /etc/nsswitch.conf skipped, unmet condition check ConditionPathExists=!/etc/nsswitch.conf Jul 23 00:12:47.106396 systemd[1]: systemd-fsck-root.service: Deactivated successfully. Jul 23 00:12:47.106408 systemd[1]: Stopped systemd-fsck-root.service - File System Check on Root Device. Jul 23 00:12:47.106420 systemd[1]: systemd-fsck-usr.service: Deactivated successfully. Jul 23 00:12:47.106481 systemd[1]: Stopped systemd-fsck-usr.service. Jul 23 00:12:47.106493 systemd[1]: systemd-hibernate-clear.service - Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 Jul 23 00:12:47.106504 systemd[1]: Starting systemd-journald.service - Journal Service... Jul 23 00:12:47.106514 systemd[1]: Starting systemd-modules-load.service - Load Kernel Modules... Jul 23 00:12:47.106527 systemd[1]: Starting systemd-network-generator.service - Generate Network Units from Kernel Command Line... Jul 23 00:12:47.106540 systemd[1]: Reached target time-set.target - System Time Set. Jul 23 00:12:47.106550 systemd[1]: Starting systemd-remount-fs.service - Remount Root and Kernel File Systems... Jul 23 00:12:47.106562 systemd[1]: Starting systemd-udev-load-credentials.service - Load udev Rules from Credentials... Jul 23 00:12:47.106580 systemd[1]: Starting systemd-udev-trigger.service - Coldplug All udev Devices... Jul 23 00:12:47.106593 systemd[1]: xenserver-pv-version.service - Set fake PV driver version for XenServer skipped, unmet condition check ConditionVirtualization=xen Jul 23 00:12:47.106603 systemd[1]: Mounted dev-hugepages.mount - Huge Pages File System. Jul 23 00:12:47.106614 systemd[1]: Mounted dev-mqueue.mount - POSIX Message Queue File System. Jul 23 00:12:47.106635 systemd[1]: Mounted media.mount - External Media Directory. Jul 23 00:12:47.106646 kernel: fuse: init (API version 7.41) Jul 23 00:12:47.106683 systemd-journald[2589]: Collecting audit messages is enabled. Jul 23 00:12:47.106722 systemd[1]: Mounted sys-kernel-debug.mount - Kernel Debug File System. Jul 23 00:12:47.106738 systemd[1]: Mounted sys-kernel-tracing.mount - Kernel Trace File System. Jul 23 00:12:47.106753 systemd[1]: Mounted tmp.mount - Temporary Directory /tmp. Jul 23 00:12:47.106765 systemd[1]: Finished kmod-static-nodes.service - Create List of Static Device Nodes. Jul 23 00:12:47.106778 systemd-journald[2589]: Journal started Jul 23 00:12:47.106805 systemd-journald[2589]: Runtime Journal (/run/log/journal/438d7bab67944431a503b0939dba9588) is 8M, max 158.5M, 150.5M free. Jul 23 00:12:46.747000 audit[1]: EVENT_LISTENER pid=1 uid=0 auid=4294967295 tty=(none) ses=4294967295 subj=system_u:system_r:kernel_t:s0 comm="systemd" exe="/usr/lib/systemd/systemd" nl-mcgrp=1 op=connect res=1 Jul 23 00:12:46.997000 audit[1]: SERVICE_STOP pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=systemd-fsck-root comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Jul 23 00:12:47.002000 audit[1]: SERVICE_STOP pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=systemd-fsck-usr comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Jul 23 00:12:47.005000 audit: BPF prog-id=15 op=UNLOAD Jul 23 00:12:47.005000 audit: BPF prog-id=14 op=UNLOAD Jul 23 00:12:47.005000 audit: BPF prog-id=16 op=LOAD Jul 23 00:12:47.005000 audit: BPF prog-id=17 op=LOAD Jul 23 00:12:47.005000 audit: BPF prog-id=18 op=LOAD Jul 23 00:12:47.091000 audit: CONFIG_CHANGE op=set audit_enabled=1 old=1 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 res=1 Jul 23 00:12:47.091000 audit[2589]: SYSCALL arch=c000003e syscall=46 success=yes exit=60 a0=6 a1=7ffc91ddeb70 a2=4000 a3=0 items=0 ppid=1 pid=2589 auid=4294967295 uid=0 gid=0 euid=0 suid=0 fsuid=0 egid=0 sgid=0 fsgid=0 tty=(none) ses=4294967295 comm="systemd-journal" exe="/usr/lib/systemd/systemd-journald" subj=system_u:system_r:kernel_t:s0 key=(null) Jul 23 00:12:47.091000 audit: PROCTITLE proctitle="/usr/lib/systemd/systemd-journald" Jul 23 00:12:46.429684 systemd[1]: Queued start job for default target multi-user.target. Jul 23 00:12:46.519538 systemd[1]: Unnecessary job was removed for dev-nvme0n1p6.device - /dev/nvme0n1p6. Jul 23 00:12:46.520007 systemd[1]: systemd-journald.service: Deactivated successfully. Jul 23 00:12:47.069390 systemd-modules-load[2590]: Using 2 probe threads Jul 23 00:12:47.106000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=kmod-static-nodes comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Jul 23 00:12:47.111657 systemd[1]: Started systemd-journald.service - Journal Service. Jul 23 00:12:47.113000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=systemd-journald comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Jul 23 00:12:47.116914 systemd[1]: modprobe@configfs.service: Deactivated successfully. Jul 23 00:12:47.117083 systemd[1]: Finished modprobe@configfs.service - Load Kernel Module configfs. Jul 23 00:12:47.119893 systemd[1]: modprobe@fuse.service: Deactivated successfully. Jul 23 00:12:47.120061 systemd[1]: Finished modprobe@fuse.service - Load Kernel Module fuse. Jul 23 00:12:47.118000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=modprobe@configfs comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Jul 23 00:12:47.118000 audit[1]: SERVICE_STOP pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=modprobe@configfs comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Jul 23 00:12:47.123000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=modprobe@fuse comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Jul 23 00:12:47.123000 audit[1]: SERVICE_STOP pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=modprobe@fuse comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Jul 23 00:12:47.124884 systemd[1]: Finished systemd-network-generator.service - Generate Network Units from Kernel Command Line. Jul 23 00:12:47.128000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=systemd-network-generator comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Jul 23 00:12:47.130458 systemd[1]: Finished systemd-remount-fs.service - Remount Root and Kernel File Systems. Jul 23 00:12:47.132000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=systemd-remount-fs comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Jul 23 00:12:47.134926 systemd[1]: Finished systemd-modules-load.service - Load Kernel Modules. Jul 23 00:12:47.136000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=systemd-modules-load comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Jul 23 00:12:47.140928 systemd[1]: Reached target network-pre.target - Preparation for Network. Jul 23 00:12:47.144090 systemd[1]: Listening on systemd-importd.socket - Disk Image Download Service Socket. Jul 23 00:12:47.145867 systemd[1]: Mounting sys-fs-fuse-connections.mount - FUSE Control File System... Jul 23 00:12:47.156621 systemd[1]: Mounting sys-kernel-config.mount - Kernel Configuration File System... Jul 23 00:12:47.160321 systemd[1]: remount-root.service - Remount Root File System skipped, unmet condition check ConditionPathIsReadWrite=!/ Jul 23 00:12:47.160352 systemd[1]: Reached target local-fs.target - Local File Systems. Jul 23 00:12:47.163257 systemd[1]: Listening on systemd-sysext.socket - System Extension Image Management. Jul 23 00:12:47.170260 systemd[1]: systemd-binfmt.service - Set Up Additional Binary Formats skipped, no trigger condition checks were met. Jul 23 00:12:47.179993 systemd[1]: Starting systemd-confext.service - Merge System Configuration Images into /etc/... Jul 23 00:12:47.184590 systemd[1]: Starting systemd-hwdb-update.service - Rebuild Hardware Database... Jul 23 00:12:47.190596 systemd[1]: Starting systemd-journal-flush.service - Flush Journal to Persistent Storage... Jul 23 00:12:47.193185 systemd[1]: systemd-pstore.service - Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore Jul 23 00:12:47.194655 systemd[1]: Starting systemd-random-seed.service - Load/Save OS Random Seed... Jul 23 00:12:47.199501 systemd[1]: Starting systemd-sysctl.service - Apply Kernel Variables... Jul 23 00:12:47.206876 systemd[1]: Starting systemd-tmpfiles-setup-dev-early.service - Create Static Device Nodes in /dev gracefully... Jul 23 00:12:47.210612 systemd[1]: Starting systemd-userdb-load-credentials.service - Load JSON user/group Records from Credentials... Jul 23 00:12:47.216015 systemd[1]: Finished flatcar-tmpfiles.service - Create missing system files. Jul 23 00:12:47.216000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=flatcar-tmpfiles comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Jul 23 00:12:47.218497 systemd[1]: Finished systemd-udev-load-credentials.service - Load udev Rules from Credentials. Jul 23 00:12:47.219000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=systemd-udev-load-credentials comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Jul 23 00:12:47.221992 systemd[1]: Mounted sys-fs-fuse-connections.mount - FUSE Control File System. Jul 23 00:12:47.222525 systemd[1]: Mounted sys-kernel-config.mount - Kernel Configuration File System. Jul 23 00:12:47.232350 systemd[1]: Finished systemd-random-seed.service - Load/Save OS Random Seed. Jul 23 00:12:47.233000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=systemd-random-seed comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Jul 23 00:12:47.234799 systemd[1]: Reached target first-boot-complete.target - First Boot Complete. Jul 23 00:12:47.240543 systemd[1]: Starting systemd-machine-id-commit.service - Save Transient machine-id to Disk... Jul 23 00:12:47.257572 systemd-journald[2589]: Time spent on flushing to /var/log/journal/438d7bab67944431a503b0939dba9588 is 55.645ms for 1209 entries. Jul 23 00:12:47.257572 systemd-journald[2589]: System Journal (/var/log/journal/438d7bab67944431a503b0939dba9588) is 8M, max 2.2G, 2.2G free. Jul 23 00:12:47.277000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=systemd-udev-trigger comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Jul 23 00:12:47.289000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=systemd-userdb-load-credentials comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Jul 23 00:12:47.295000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=systemd-sysctl comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Jul 23 00:12:47.415000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=systemd-tmpfiles-setup-dev-early comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Jul 23 00:12:47.418281 systemd-journald[2589]: Received client request to flush runtime journal. Jul 23 00:12:47.276514 systemd[1]: Finished systemd-udev-trigger.service - Coldplug All udev Devices. Jul 23 00:12:47.418417 kernel: loop4: detected capacity change from 0 to 44152 Jul 23 00:12:47.287312 systemd[1]: Finished systemd-userdb-load-credentials.service - Load JSON user/group Records from Credentials. Jul 23 00:12:47.418489 kernel: loop4: p1 p2 p3 Jul 23 00:12:47.292388 systemd[1]: Finished systemd-sysctl.service - Apply Kernel Variables. Jul 23 00:12:47.411774 systemd-tmpfiles[2642]: ACLs are not supported, ignoring. Jul 23 00:12:47.411787 systemd-tmpfiles[2642]: ACLs are not supported, ignoring. Jul 23 00:12:47.414877 systemd[1]: Finished systemd-tmpfiles-setup-dev-early.service - Create Static Device Nodes in /dev gracefully. Jul 23 00:12:47.417559 systemd[1]: Finished systemd-journal-flush.service - Flush Journal to Persistent Storage. Jul 23 00:12:47.417000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=systemd-journal-flush comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Jul 23 00:12:47.422044 systemd[1]: Starting systemd-sysusers.service - Create System Users... Jul 23 00:12:47.432644 systemd[1]: Finished systemd-machine-id-commit.service - Save Transient machine-id to Disk. Jul 23 00:12:47.433000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=systemd-machine-id-commit comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Jul 23 00:12:47.465847 kernel: device-mapper: verity: sha256 using shash "sha256-ni" Jul 23 00:12:47.465902 kernel: device-mapper: verity: Unrecognized verity feature request: root_hash_sig_key_desc Jul 23 00:12:47.468196 kernel: device-mapper: table: 254:5: verity: Unrecognized verity feature request (-EINVAL) Jul 23 00:12:47.470226 kernel: device-mapper: ioctl: error adding target to table Jul 23 00:12:47.471050 systemd-confext[2644]: device-mapper: reload ioctl on loop4p1-53-verity (254:5) failed: Invalid argument Jul 23 00:12:47.476446 kernel: device-mapper: verity: sha256 using shash "sha256-ni" Jul 23 00:12:47.596734 systemd[1]: etc-machine\x2did.mount: Deactivated successfully. Jul 23 00:12:47.620364 systemd[1]: Finished systemd-sysusers.service - Create System Users. Jul 23 00:12:47.622000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=systemd-sysusers comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Jul 23 00:12:47.626732 systemd[1]: Starting systemd-journalctl.socket - Journal Log Access Socket... Jul 23 00:12:47.630000 audit: BPF prog-id=19 op=LOAD Jul 23 00:12:47.630000 audit: BPF prog-id=20 op=LOAD Jul 23 00:12:47.630000 audit: BPF prog-id=21 op=LOAD Jul 23 00:12:47.633582 systemd[1]: Starting systemd-oomd.service - Userspace Out-Of-Memory (OOM) Killer... Jul 23 00:12:47.635000 audit: BPF prog-id=22 op=LOAD Jul 23 00:12:47.639314 systemd[1]: Starting systemd-resolved.service - Network Name Resolution... Jul 23 00:12:47.643042 systemd[1]: Starting systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev... Jul 23 00:12:47.645614 systemd[1]: Listening on systemd-journalctl.socket - Journal Log Access Socket. Jul 23 00:12:47.654031 systemd[1]: Starting modprobe@tun.service - Load Kernel Module tun... Jul 23 00:12:47.656000 audit: BPF prog-id=23 op=LOAD Jul 23 00:12:47.656000 audit: BPF prog-id=24 op=LOAD Jul 23 00:12:47.656000 audit: BPF prog-id=25 op=LOAD Jul 23 00:12:47.658839 systemd[1]: Starting systemd-userdbd.service - User Database Manager... Jul 23 00:12:47.676385 systemd-tmpfiles[2668]: ACLs are not supported, ignoring. Jul 23 00:12:47.678489 systemd-tmpfiles[2668]: ACLs are not supported, ignoring. Jul 23 00:12:47.683689 systemd[1]: Finished systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev. Jul 23 00:12:47.684000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=systemd-tmpfiles-setup-dev comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Jul 23 00:12:47.688131 systemd[1]: systemd-repart.service - Repartition Root Disk skipped, no trigger condition checks were met. Jul 23 00:12:47.690222 systemd[1]: proc-sys-fs-binfmt_misc.automount: Got automount request for /proc/sys/fs/binfmt_misc, triggered by 2670 ((systemd-userd)) Jul 23 00:12:47.691143 systemd[1]: Mounting proc-sys-fs-binfmt_misc.mount - Arbitrary Executable File Formats File System... Jul 23 00:12:47.723483 kernel: tun: Universal TUN/TAP device driver, 1.6 Jul 23 00:12:47.724302 systemd[1]: modprobe@tun.service: Deactivated successfully. Jul 23 00:12:47.724489 systemd[1]: Finished modprobe@tun.service - Load Kernel Module tun. Jul 23 00:12:47.725000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=modprobe@tun comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Jul 23 00:12:47.725000 audit[1]: SERVICE_STOP pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=modprobe@tun comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Jul 23 00:12:47.726000 audit: BPF prog-id=26 op=LOAD Jul 23 00:12:47.726000 audit: BPF prog-id=27 op=LOAD Jul 23 00:12:47.726000 audit: BPF prog-id=28 op=LOAD Jul 23 00:12:47.729010 systemd[1]: Starting systemd-nsresourced.service - Namespace Resource Manager... Jul 23 00:12:47.736965 systemd[1]: Mounted proc-sys-fs-binfmt_misc.mount - Arbitrary Executable File Formats File System. Jul 23 00:12:47.787223 systemd[1]: Started systemd-userdbd.service - User Database Manager. Jul 23 00:12:47.789854 systemd-nsresourced[2675]: Not setting up BPF subsystem, as functionality has been disabled at compile time. Jul 23 00:12:47.789000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=systemd-userdbd comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Jul 23 00:12:47.791422 systemd[1]: Started systemd-nsresourced.service - Namespace Resource Manager. Jul 23 00:12:47.792000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=systemd-nsresourced comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Jul 23 00:12:47.875520 systemd-oomd[2666]: No swap; memory pressure usage will be degraded Jul 23 00:12:47.877541 systemd[1]: Started systemd-oomd.service - Userspace Out-Of-Memory (OOM) Killer. Jul 23 00:12:47.880000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=systemd-oomd comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Jul 23 00:12:47.908640 systemd-resolved[2667]: Positive Trust Anchors: Jul 23 00:12:47.908652 systemd-resolved[2667]: . IN DS 20326 8 2 e06d44b80b8f1d39a95c0b0d7c65d08458e880409bbc683457104237c7f8ec8d Jul 23 00:12:47.908655 systemd-resolved[2667]: . IN DS 38696 8 2 683d2d0acb8c9b712a1948b27f741219298d0a450d612c483af444a4c0fb2b16 Jul 23 00:12:47.908685 systemd-resolved[2667]: 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 Jul 23 00:12:47.944803 systemd-resolved[2667]: Using system hostname 'ci-4722.1.0-n-b387f73b01'. Jul 23 00:12:47.945875 systemd[1]: Started systemd-resolved.service - Network Name Resolution. Jul 23 00:12:47.947000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=systemd-resolved comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Jul 23 00:12:47.948580 systemd[1]: Reached target nss-lookup.target - Host and Network Name Lookups. Jul 23 00:12:47.967469 systemd[1]: Finished systemd-hwdb-update.service - Rebuild Hardware Database. Jul 23 00:12:47.969000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=systemd-hwdb-update comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Jul 23 00:12:47.969000 audit: BPF prog-id=7 op=UNLOAD Jul 23 00:12:47.969000 audit: BPF prog-id=6 op=UNLOAD Jul 23 00:12:47.969000 audit: BPF prog-id=29 op=LOAD Jul 23 00:12:47.969000 audit: BPF prog-id=30 op=LOAD Jul 23 00:12:47.971792 systemd[1]: Starting systemd-udevd.service - Rule-based Manager for Device Events and Files... Jul 23 00:12:48.249926 systemd-udevd[2691]: Using default interface naming scheme 'v260'. Jul 23 00:12:48.573696 systemd[1]: Started systemd-udevd.service - Rule-based Manager for Device Events and Files. Jul 23 00:12:48.575000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=systemd-udevd comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Jul 23 00:12:48.576000 audit: BPF prog-id=31 op=LOAD Jul 23 00:12:48.579058 systemd[1]: Starting systemd-networkd.service - Network Management... Jul 23 00:12:48.663502 systemd[1]: Condition check resulted in dev-ttyS0.device - /dev/ttyS0 being skipped. Jul 23 00:12:48.690311 systemd-networkd[2693]: lo: Link UP Jul 23 00:12:48.690637 systemd-networkd[2693]: lo: Gained carrier Jul 23 00:12:48.692000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=systemd-networkd comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Jul 23 00:12:48.691909 systemd[1]: Started systemd-networkd.service - Network Management. Jul 23 00:12:48.694474 systemd[1]: Reached target network.target - Network. Jul 23 00:12:48.706754 systemd[1]: Starting systemd-networkd-persistent-storage.service - Enable Persistent Storage in systemd-networkd... Jul 23 00:12:48.712562 systemd[1]: Starting systemd-networkd-wait-online.service - Wait for Network to be Online... Jul 23 00:12:48.756457 kernel: mousedev: PS/2 mouse device common for all mice Jul 23 00:12:48.769386 systemd-networkd[2693]: eth0: Found matching .network file, based on potentially unpredictable interface name: /usr/lib/systemd/network/zz-default.network Jul 23 00:12:48.769401 systemd-networkd[2693]: eth0: Configuring with /usr/lib/systemd/network/zz-default.network. Jul 23 00:12:48.772448 kernel: mana 7870:00:00.0 enP30832s1: Configured vPort 0 PD 18 DB 16 Jul 23 00:12:48.783476 kernel: mana 7870:00:00.0 enP30832s1: Configured steering vPort 0 entries 64 Jul 23 00:12:48.787476 kernel: hv_netvsc f8615163-0000-1000-2000-7ced8d77b541 eth0: Data path switched to VF: enP30832s1 Jul 23 00:12:48.789852 systemd-networkd[2693]: enP30832s1: Link UP Jul 23 00:12:48.790749 systemd-networkd[2693]: eth0: Link UP Jul 23 00:12:48.790758 systemd-networkd[2693]: eth0: Gained carrier Jul 23 00:12:48.790775 systemd-networkd[2693]: eth0: Found matching .network file, based on potentially unpredictable interface name: /usr/lib/systemd/network/zz-default.network Jul 23 00:12:48.796550 systemd-networkd[2693]: enP30832s1: Gained carrier Jul 23 00:12:48.798110 systemd[1]: Finished systemd-networkd-persistent-storage.service - Enable Persistent Storage in systemd-networkd. Jul 23 00:12:48.798000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=systemd-networkd-persistent-storage comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Jul 23 00:12:48.803498 systemd-networkd[2693]: eth0: DHCPv4 address 10.0.0.20/24, gateway 10.0.0.1 acquired from 168.63.129.16 Jul 23 00:12:48.806537 kernel: hv_vmbus: registering driver hv_balloon Jul 23 00:12:48.816472 kernel: hv_balloon: Using Dynamic Memory protocol version 2.0 Jul 23 00:12:48.816635 kernel: hv_vmbus: registering driver hyperv_fb Jul 23 00:12:48.820725 kernel: hyperv_fb: Synthvid Version major 3, minor 5 Jul 23 00:12:48.821079 kernel: hyperv_fb: Screen resolution: 1024x768, Color depth: 32, Frame buffer size: 8388608 Jul 23 00:12:48.824449 kernel: Console: switching to colour dummy device 80x25 Jul 23 00:12:48.829117 kernel: Console: switching to colour frame buffer device 128x48 Jul 23 00:12:48.839441 kernel: hv_storvsc f8b3781a-1e82-4818-a1c3-63d806ec15bb: tag#156 cmd 0x85 status: scsi 0x2 srb 0x6 hv 0xc0000001 Jul 23 00:12:48.861593 systemd[1]: Condition check resulted in dev-ptp_hyperv.device - /dev/ptp_hyperv being skipped. Jul 23 00:12:48.915674 systemd[1]: Starting systemd-vconsole-setup.service - Virtual Console Setup... Jul 23 00:12:48.929911 systemd[1]: systemd-vconsole-setup.service: Deactivated successfully. Jul 23 00:12:48.930168 systemd[1]: Stopped systemd-vconsole-setup.service - Virtual Console Setup. Jul 23 00:12:48.934000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=systemd-vconsole-setup comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Jul 23 00:12:48.934000 audit[1]: SERVICE_STOP pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=systemd-vconsole-setup comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Jul 23 00:12:48.939620 systemd[1]: Starting systemd-vconsole-setup.service - Virtual Console Setup... Jul 23 00:12:49.014471 kernel: erofs: (device dm-5): mounted with root inode @ nid 40. Jul 23 00:12:49.033798 kernel: kvm_intel: Using Hyper-V Enlightened VMCS Jul 23 00:12:49.036493 kernel: cpu_based_exec_ctrl unsupported with eVMCS: 0x20000 Jul 23 00:12:49.121454 kernel: loop4: detected capacity change from 0 to 44152 Jul 23 00:12:49.124450 kernel: loop4: p1 p2 p3 Jul 23 00:12:49.127845 systemd[1]: Found device dev-disk-by\x2dlabel-OEM.device - MSFT NVMe Accelerator v1.0 OEM. Jul 23 00:12:49.132192 kernel: device-mapper: verity: sha256 using shash "sha256-ni" Jul 23 00:12:49.132246 kernel: device-mapper: verity: Unrecognized verity feature request: root_hash_sig_key_desc Jul 23 00:12:49.132967 kernel: device-mapper: table: 254:5: verity: Unrecognized verity feature request (-EINVAL) Jul 23 00:12:49.133718 kernel: device-mapper: ioctl: error adding target to table Jul 23 00:12:49.133774 (sd-merge)[2775]: device-mapper: reload ioctl on loop4p1-58-verity (254:5) failed: Invalid argument Jul 23 00:12:49.133888 systemd[1]: systemd-vconsole-setup.service: Deactivated successfully. Jul 23 00:12:49.134166 systemd[1]: Stopped systemd-vconsole-setup.service - Virtual Console Setup. Jul 23 00:12:49.137448 kernel: device-mapper: verity: sha256 using shash "sha256-ni" Jul 23 00:12:49.137000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=systemd-vconsole-setup comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Jul 23 00:12:49.137000 audit[1]: SERVICE_STOP pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=systemd-vconsole-setup comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Jul 23 00:12:49.147574 systemd[1]: Starting systemd-fsck@dev-disk-by\x2dlabel-OEM.service - File System Check on /dev/disk/by-label/OEM... Jul 23 00:12:49.151965 systemd[1]: Starting systemd-vconsole-setup.service - Virtual Console Setup... Jul 23 00:12:49.160508 kernel: erofs: (device dm-5): mounted with root inode @ nid 40. Jul 23 00:12:49.161920 (sd-merge)[2775]: Skipping extension refresh because no change was found, use --always-refresh=yes to always do a refresh. Jul 23 00:12:49.166114 systemd[1]: Finished systemd-confext.service - Merge System Configuration Images into /etc/. Jul 23 00:12:49.169000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=systemd-confext comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Jul 23 00:12:49.173579 systemd[1]: Starting systemd-sysext.service - Merge System Extension Images into /usr/ and /opt/... Jul 23 00:12:49.190458 kernel: loop4: detected capacity change from 0 to 185336 Jul 23 00:12:49.193452 kernel: loop4: p1 p2 p3 Jul 23 00:12:49.203844 kernel: device-mapper: verity: sha256 using shash "sha256-ni" Jul 23 00:12:49.203905 kernel: device-mapper: verity: Unrecognized verity feature request: root_hash_sig_key_desc Jul 23 00:12:49.205190 kernel: device-mapper: table: 254:5: verity: Unrecognized verity feature request (-EINVAL) Jul 23 00:12:49.206109 kernel: device-mapper: ioctl: error adding target to table Jul 23 00:12:49.206183 systemd-sysext[2785]: device-mapper: reload ioctl on loop4p1-62-verity (254:5) failed: Invalid argument Jul 23 00:12:49.209447 kernel: device-mapper: verity: sha256 using shash "sha256-ni" Jul 23 00:12:49.225446 kernel: erofs: (device dm-5): mounted with root inode @ nid 39. Jul 23 00:12:49.234215 systemd[1]: Finished systemd-fsck@dev-disk-by\x2dlabel-OEM.service - File System Check on /dev/disk/by-label/OEM. Jul 23 00:12:49.237000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=systemd-fsck@dev-disk-by\x2dlabel-OEM comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Jul 23 00:12:49.245444 kernel: loop4: detected capacity change from 0 to 137048 Jul 23 00:12:49.246455 kernel: loop4: p1 p2 p3 Jul 23 00:12:49.260568 kernel: device-mapper: verity: sha256 using shash "sha256-ni" Jul 23 00:12:49.260609 kernel: device-mapper: verity: Unrecognized verity feature request: root_hash_sig_key_desc Jul 23 00:12:49.262768 kernel: device-mapper: table: 254:5: verity: Unrecognized verity feature request (-EINVAL) Jul 23 00:12:49.264740 kernel: device-mapper: ioctl: error adding target to table Jul 23 00:12:49.264952 systemd-sysext[2785]: device-mapper: reload ioctl on loop4p1-67-verity (254:5) failed: Invalid argument Jul 23 00:12:49.268652 kernel: device-mapper: verity: sha256 using shash "sha256-ni" Jul 23 00:12:49.292444 kernel: erofs: (device dm-5): mounted with root inode @ nid 39. Jul 23 00:12:49.319448 kernel: loop4: detected capacity change from 0 to 388272 Jul 23 00:12:49.348446 kernel: loop4: p1 p2 p3 Jul 23 00:12:49.357711 kernel: device-mapper: verity: sha256 using shash "sha256-ni" Jul 23 00:12:49.357754 kernel: device-mapper: verity: Unrecognized verity feature request: root_hash_sig_key_desc Jul 23 00:12:49.357780 kernel: device-mapper: table: 254:5: verity: Unrecognized verity feature request (-EINVAL) Jul 23 00:12:49.359705 kernel: device-mapper: ioctl: error adding target to table Jul 23 00:12:49.359956 systemd-sysext[2785]: device-mapper: reload ioctl on loop4p1-72-verity (254:5) failed: Invalid argument Jul 23 00:12:49.362446 kernel: device-mapper: verity: sha256 using shash "sha256-ni" Jul 23 00:12:49.384481 kernel: erofs: (device dm-5): mounted with root inode @ nid 39. Jul 23 00:12:49.402286 systemd-vconsole-setup[2782]: Configuration of first virtual console was skipped, ignoring remaining ones. Jul 23 00:12:49.402915 systemd[1]: Finished systemd-vconsole-setup.service - Virtual Console Setup. Jul 23 00:12:49.403000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=systemd-vconsole-setup comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Jul 23 00:12:49.406359 kernel: kauditd_printk_skb: 70 callbacks suppressed Jul 23 00:12:49.406400 kernel: audit: type=1130 audit(1784765569.403:168): pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=systemd-vconsole-setup comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Jul 23 00:12:49.423447 kernel: loop4: detected capacity change from 0 to 185336 Jul 23 00:12:49.426445 kernel: loop4: p1 p2 p3 Jul 23 00:12:49.433592 kernel: device-mapper: verity: sha256 using shash "sha256-ni" Jul 23 00:12:49.433645 kernel: device-mapper: verity: Unrecognized verity feature request: root_hash_sig_key_desc Jul 23 00:12:49.434846 kernel: device-mapper: table: 254:5: verity: Unrecognized verity feature request (-EINVAL) Jul 23 00:12:49.435445 kernel: device-mapper: ioctl: error adding target to table Jul 23 00:12:49.436325 (sd-merge)[2813]: device-mapper: reload ioctl on loop4p1-77-verity (254:5) failed: Invalid argument Jul 23 00:12:49.438456 kernel: device-mapper: verity: sha256 using shash "sha256-ni" Jul 23 00:12:49.464486 kernel: erofs: (device dm-5): mounted with root inode @ nid 39. Jul 23 00:12:49.467141 kernel: loop5: detected capacity change from 0 to 137048 Jul 23 00:12:49.469456 kernel: loop5: p1 p2 p3 Jul 23 00:12:49.480520 kernel: device-mapper: verity: sha256 using shash "sha256-ni" Jul 23 00:12:49.480624 kernel: device-mapper: verity: Unrecognized verity feature request: root_hash_sig_key_desc Jul 23 00:12:49.483092 kernel: device-mapper: table: 254:6: verity: Unrecognized verity feature request (-EINVAL) Jul 23 00:12:49.483836 kernel: device-mapper: ioctl: error adding target to table Jul 23 00:12:49.484033 (sd-merge)[2813]: device-mapper: reload ioctl on loop5p1-81-verity (254:6) failed: Invalid argument Jul 23 00:12:49.486449 kernel: device-mapper: verity: sha256 using shash "sha256-ni" Jul 23 00:12:49.502455 kernel: erofs: (device dm-6): mounted with root inode @ nid 39. Jul 23 00:12:49.504452 kernel: loop6: detected capacity change from 0 to 388272 Jul 23 00:12:49.507564 kernel: loop6: p1 p2 p3 Jul 23 00:12:49.518257 kernel: device-mapper: verity: sha256 using shash "sha256-ni" Jul 23 00:12:49.518295 kernel: device-mapper: verity: Unrecognized verity feature request: root_hash_sig_key_desc Jul 23 00:12:49.520777 kernel: device-mapper: table: 254:7: verity: Unrecognized verity feature request (-EINVAL) Jul 23 00:12:49.522486 kernel: device-mapper: ioctl: error adding target to table Jul 23 00:12:49.522879 (sd-merge)[2813]: device-mapper: reload ioctl on loop6p1-85-verity (254:7) failed: Invalid argument Jul 23 00:12:49.526488 kernel: device-mapper: verity: sha256 using shash "sha256-ni" Jul 23 00:12:49.554130 kernel: erofs: (device dm-7): mounted with root inode @ nid 39. Jul 23 00:12:49.554723 (sd-merge)[2813]: Skipping extension refresh because no change was found, use --always-refresh=yes to always do a refresh. Jul 23 00:12:49.556868 systemd[1]: Finished systemd-sysext.service - Merge System Extension Images into /usr/ and /opt/. Jul 23 00:12:49.559000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=systemd-sysext comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Jul 23 00:12:49.564319 systemd[1]: Starting systemd-tmpfiles-setup.service - Create System Files and Directories... Jul 23 00:12:49.564446 kernel: audit: type=1130 audit(1784765569.559:169): pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=systemd-sysext comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Jul 23 00:12:49.590623 systemd-tmpfiles[2836]: /usr/lib/tmpfiles.d/base_image_var.conf:29: Duplicate line for path "/var/log/audit", ignoring. Jul 23 00:12:49.591482 systemd-tmpfiles[2836]: /usr/lib/tmpfiles.d/base_image_var_late.conf:44: Duplicate line for path "/var/log/audit", ignoring. Jul 23 00:12:49.591725 systemd-tmpfiles[2836]: /usr/lib/tmpfiles.d/baselayout.conf:15: Duplicate line for path "/var", ignoring. Jul 23 00:12:49.591740 systemd-tmpfiles[2836]: /usr/lib/tmpfiles.d/baselayout.conf:16: Duplicate line for path "/var/empty", ignoring. Jul 23 00:12:49.591760 systemd-tmpfiles[2836]: /usr/lib/tmpfiles.d/baselayout.conf:21: Duplicate line for path "/var/log", ignoring. Jul 23 00:12:49.591882 systemd-tmpfiles[2836]: /usr/lib/tmpfiles.d/dbus.conf:5: Duplicate line for path "/var/lib/dbus", ignoring. Jul 23 00:12:49.592134 systemd-tmpfiles[2836]: /usr/lib/tmpfiles.d/nfs-utils.conf:2: Duplicate line for path "/var/lib/nfs/v4recovery", ignoring. Jul 23 00:12:49.592692 systemd-tmpfiles[2836]: /usr/lib/tmpfiles.d/nfs-utils.conf:6: Duplicate line for path "/var/lib/nfs/sm", ignoring. Jul 23 00:12:49.592717 systemd-tmpfiles[2836]: /usr/lib/tmpfiles.d/nfs-utils.conf:7: Duplicate line for path "/var/lib/nfs/sm.bak", ignoring. Jul 23 00:12:49.592861 systemd-tmpfiles[2836]: /usr/lib/tmpfiles.d/provision.conf:20: Duplicate line for path "/root", ignoring. Jul 23 00:12:49.593637 systemd-tmpfiles[2836]: /usr/lib/tmpfiles.d/tpm2-tss-fapi.conf:2: Duplicate line for path "/var/lib/tpm2-tss/system/keystore", ignoring. Jul 23 00:12:49.593652 systemd-tmpfiles[2836]: ACLs are not supported, ignoring. Jul 23 00:12:49.593700 systemd-tmpfiles[2836]: ACLs are not supported, ignoring. Jul 23 00:12:49.610793 systemd-tmpfiles[2836]: /usr/lib/tmpfiles.d/var.conf:10: Duplicate line for path "/var", ignoring. Jul 23 00:12:49.610818 systemd-tmpfiles[2836]: /usr/lib/tmpfiles.d/var.conf:14: Duplicate line for path "/var/log", ignoring. Jul 23 00:12:49.610880 systemd-tmpfiles[2836]: /usr/lib/tmpfiles.d/var.conf:21: Duplicate line for path "/var/lib", ignoring. Jul 23 00:12:49.626806 systemd-tmpfiles[2836]: Detected autofs mount point '/boot' during canonicalization of 'boot'. Jul 23 00:12:49.626817 systemd-tmpfiles[2836]: Skipping /boot Jul 23 00:12:49.631626 systemd-tmpfiles[2836]: Detected autofs mount point '/boot' during canonicalization of 'boot'. Jul 23 00:12:49.631638 systemd-tmpfiles[2836]: Skipping /boot Jul 23 00:12:49.640580 systemd[1]: Finished systemd-tmpfiles-setup.service - Create System Files and Directories. Jul 23 00:12:49.640000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=systemd-tmpfiles-setup comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Jul 23 00:12:49.646483 kernel: audit: type=1130 audit(1784765569.640:170): pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=systemd-tmpfiles-setup comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Jul 23 00:12:49.646869 systemd[1]: Starting audit-rules.service - Load Audit Rules... Jul 23 00:12:49.649895 systemd[1]: Starting clean-ca-certificates.service - Clean up broken links in /etc/ssl/certs... Jul 23 00:12:49.656220 systemd[1]: Starting ldconfig.service - Rebuild Dynamic Linker Cache... Jul 23 00:12:49.659485 systemd[1]: Starting systemd-journal-catalog-update.service - Rebuild Journal Catalog... Jul 23 00:12:49.664566 systemd[1]: Starting systemd-update-utmp.service - Record System Boot/Shutdown in UTMP... Jul 23 00:12:49.674000 audit[2845]: AUDIT1127 pid=2845 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg=' comm="systemd-update-utmp" exe="/usr/lib/systemd/systemd-update-utmp" hostname=? addr=? terminal=? res=success' Jul 23 00:12:49.679877 kernel: audit: type=1127 audit(1784765569.674:171): pid=2845 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg=' comm="systemd-update-utmp" exe="/usr/lib/systemd/systemd-update-utmp" hostname=? addr=? terminal=? res=success' Jul 23 00:12:49.680620 systemd[1]: Finished systemd-update-utmp.service - Record System Boot/Shutdown in UTMP. Jul 23 00:12:49.680000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=systemd-update-utmp comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Jul 23 00:12:49.686541 kernel: audit: type=1130 audit(1784765569.680:172): pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=systemd-update-utmp comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Jul 23 00:12:49.796000 audit: CONFIG_CHANGE auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 op=add_rule key=(null) list=5 res=1 Jul 23 00:12:49.799385 systemd[1]: audit-rules.service: Deactivated successfully. Jul 23 00:12:49.799941 augenrules[2868]: No rules Jul 23 00:12:49.799778 systemd[1]: Finished audit-rules.service - Load Audit Rules. Jul 23 00:12:49.802190 kernel: audit: type=1305 audit(1784765569.796:173): auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 op=add_rule key=(null) list=5 res=1 Jul 23 00:12:49.796000 audit[2868]: SYSCALL arch=c000003e syscall=44 success=yes exit=1056 a0=3 a1=7ffc5d06afa0 a2=420 a3=0 items=0 ppid=2841 pid=2868 auid=4294967295 uid=0 gid=0 euid=0 suid=0 fsuid=0 egid=0 sgid=0 fsgid=0 tty=(none) ses=4294967295 comm="auditctl" exe="/usr/bin/auditctl" subj=system_u:system_r:kernel_t:s0 key=(null) Jul 23 00:12:49.796000 audit: PROCTITLE proctitle=2F7362696E2F617564697463746C002D52002F6574632F61756469742F61756469742E72756C6573 Jul 23 00:12:49.811841 kernel: audit: type=1300 audit(1784765569.796:173): arch=c000003e syscall=44 success=yes exit=1056 a0=3 a1=7ffc5d06afa0 a2=420 a3=0 items=0 ppid=2841 pid=2868 auid=4294967295 uid=0 gid=0 euid=0 suid=0 fsuid=0 egid=0 sgid=0 fsgid=0 tty=(none) ses=4294967295 comm="auditctl" exe="/usr/bin/auditctl" subj=system_u:system_r:kernel_t:s0 key=(null) Jul 23 00:12:49.811879 kernel: audit: type=1327 audit(1784765569.796:173): proctitle=2F7362696E2F617564697463746C002D52002F6574632F61756469742F61756469742E72756C6573 Jul 23 00:12:49.818348 systemd[1]: Finished systemd-journal-catalog-update.service - Rebuild Journal Catalog. Jul 23 00:12:50.090261 systemd[1]: Finished clean-ca-certificates.service - Clean up broken links in /etc/ssl/certs. Jul 23 00:12:50.092003 systemd[1]: update-ca-certificates.service - Update CA bundle at /etc/ssl/certs/ca-certificates.crt skipped, unmet condition check ConditionPathIsSymbolicLink=!/etc/ssl/certs/ca-certificates.crt Jul 23 00:12:50.342546 systemd-networkd[2693]: eth0: Gained IPv6LL Jul 23 00:12:50.344308 systemd[1]: Finished systemd-networkd-wait-online.service - Wait for Network to be Online. Jul 23 00:12:50.348670 systemd[1]: Reached target network-online.target - Network is Online. Jul 23 00:12:55.183014 ldconfig[2843]: ldconfig: /usr/lib/ld.so.conf is not an ELF file - it has the wrong magic bytes at the start. Jul 23 00:12:55.195746 systemd[1]: Finished ldconfig.service - Rebuild Dynamic Linker Cache. Jul 23 00:12:55.198507 systemd[1]: Starting systemd-update-done.service - Update is Completed... Jul 23 00:12:55.215895 systemd[1]: Finished systemd-update-done.service - Update is Completed. Jul 23 00:12:55.217527 systemd[1]: Reached target sysinit.target - System Initialization. Jul 23 00:12:55.218896 systemd[1]: Started motdgen.path - Watch for update engine configuration changes. Jul 23 00:12:55.220471 systemd[1]: Started user-cloudinit@var-lib-flatcar\x2dinstall-user_data.path - Watch for a cloud-config at /var/lib/flatcar-install/user_data. Jul 23 00:12:55.223557 systemd[1]: Started google-oslogin-cache.timer - NSS cache refresh timer. Jul 23 00:12:55.226618 systemd[1]: Started logrotate.timer - Daily rotation of log files. Jul 23 00:12:55.229550 systemd[1]: Started mdadm.timer - Weekly check for MD array's redundancy information.. Jul 23 00:12:55.232492 systemd[1]: Started systemd-sysupdate-reboot.timer - Reboot Automatically After System Update. Jul 23 00:12:55.235531 systemd[1]: Started systemd-sysupdate.timer - Automatic System Update. Jul 23 00:12:55.236967 systemd[1]: Started systemd-tmpfiles-clean.timer - Daily Cleanup of Temporary Directories. Jul 23 00:12:55.238458 systemd[1]: update-engine-stub.timer - Update Engine Stub Timer skipped, unmet condition check ConditionPathExists=/usr/.noupdate Jul 23 00:12:55.238493 systemd[1]: Reached target paths.target - Path Units. Jul 23 00:12:55.239501 systemd[1]: Reached target timers.target - Timer Units. Jul 23 00:12:55.241145 systemd[1]: Listening on dbus.socket - D-Bus System Message Bus Socket. Jul 23 00:12:55.243518 systemd[1]: Starting docker.socket - Docker Socket for the API... Jul 23 00:12:55.247820 systemd[1]: Listening on sshd-unix-local.socket - OpenSSH Server Socket (systemd-ssh-generator, AF_UNIX Local). Jul 23 00:12:55.250505 systemd[1]: Listening on sshd.socket - OpenSSH Server Socket. Jul 23 00:12:55.254750 systemd[1]: Listening on systemd-hostnamed.socket - Hostname Service Socket. Jul 23 00:12:55.256394 systemd[1]: Listening on systemd-logind-varlink.socket - User Login Management Varlink Socket. Jul 23 00:12:55.258047 systemd[1]: Listening on systemd-machined.socket - Virtual Machine and Container Registration Service Socket. Jul 23 00:12:55.260986 systemd[1]: Listening on docker.socket - Docker Socket for the API. Jul 23 00:12:55.262863 systemd[1]: Reached target sockets.target - Socket Units. Jul 23 00:12:55.265479 systemd[1]: Reached target basic.target - Basic System. Jul 23 00:12:55.266816 systemd[1]: addon-config@oem.service - Configure Addon /oem skipped, no trigger condition checks were met. Jul 23 00:12:55.266840 systemd[1]: addon-run@oem.service - Run Addon /oem skipped, no trigger condition checks were met. Jul 23 00:12:55.268615 systemd[1]: Starting chronyd.service - NTP client/server... Jul 23 00:12:55.273544 systemd[1]: Starting containerd.service - containerd container runtime... Jul 23 00:12:55.279603 systemd[1]: Starting dbus.service - D-Bus System Message Bus... Jul 23 00:12:55.285557 systemd[1]: Starting dracut-shutdown.service - Restore /run/initramfs on shutdown... Jul 23 00:12:55.289397 systemd[1]: Starting enable-oem-cloudinit.service - Enable cloudinit... Jul 23 00:12:55.292652 systemd[1]: Starting extend-filesystems.service - Extend Filesystems... Jul 23 00:12:55.294451 systemd[1]: flatcar-setup-environment.service - Modifies /etc/environment for CoreOS skipped, unmet condition check ConditionPathExists=/oem/bin/flatcar-setup-environment Jul 23 00:12:55.297495 systemd[1]: Starting google-oslogin-cache.service - NSS cache refresh... Jul 23 00:12:55.299281 systemd[1]: hv_fcopy_uio_daemon.service - Hyper-V FCOPY UIO daemon skipped, unmet condition check ConditionPathExists=/sys/bus/vmbus/devices/eb765408-105f-49b6-b4aa-c123b64d17d4/uio Jul 23 00:12:55.302123 systemd[1]: Started hv_kvp_daemon.service - Hyper-V KVP daemon. Jul 23 00:12:55.303997 systemd[1]: hv_vss_daemon.service - Hyper-V VSS daemon skipped, unmet condition check ConditionPathExists=/dev/vmbus/hv_vss Jul 23 00:12:55.307966 systemd[1]: Starting motdgen.service - Generate /run/flatcar/motd... Jul 23 00:12:55.312136 systemd[1]: Starting nvidia.service - NVIDIA Configure Service... Jul 23 00:12:55.317791 jq[2889]: false Jul 23 00:12:55.321946 systemd[1]: Starting ssh-key-proc-cmdline.service - Install an ssh key from /proc/cmdline... Jul 23 00:12:55.326996 systemd[1]: Starting sshd-keygen.service - Generate sshd host keys... Jul 23 00:12:55.331587 KVP[2892]: KVP starting; pid is:2892 Jul 23 00:12:55.332628 systemd[1]: Starting systemd-logind.service - User Login Management... Jul 23 00:12:55.334378 systemd[1]: tcsd.service - TCG Core Services Daemon skipped, unmet condition check ConditionPathExists=/dev/tpm0 Jul 23 00:12:55.338231 systemd[1]: Starting update-engine.service - Update Engine... Jul 23 00:12:55.342998 systemd[1]: Starting update-ssh-keys-after-ignition.service - Run update-ssh-keys once after Ignition... Jul 23 00:12:55.346850 kernel: hv_utils: KVP IC version 4.0 Jul 23 00:12:55.346632 KVP[2892]: KVP LIC Version: 3.1 Jul 23 00:12:55.363335 systemd[1]: Finished dracut-shutdown.service - Restore /run/initramfs on shutdown. Jul 23 00:12:55.368752 systemd[1]: enable-oem-cloudinit.service: Skipped due to 'exec-condition'. Jul 23 00:12:55.368988 systemd[1]: Condition check resulted in enable-oem-cloudinit.service - Enable cloudinit being skipped. Jul 23 00:12:55.370619 systemd[1]: ssh-key-proc-cmdline.service: Deactivated successfully. Jul 23 00:12:55.371122 systemd[1]: Finished ssh-key-proc-cmdline.service - Install an ssh key from /proc/cmdline. Jul 23 00:12:55.373162 extend-filesystems[2890]: Found /dev/nvme0n1p6 Jul 23 00:12:55.381209 google_oslogin_nss_cache[2891]: oslogin_cache_refresh[2891]: Refreshing passwd entry cache Jul 23 00:12:55.381219 oslogin_cache_refresh[2891]: Refreshing passwd entry cache Jul 23 00:12:55.384963 jq[2902]: true Jul 23 00:12:55.387854 chronyd[2885]: chronyd version 4.8 starting (+CMDMON +REFCLOCK +RTC +PRIVDROP +SCFILTER -SIGND +NTS +SECHASH +IPV6 -DEBUG) Jul 23 00:12:55.388083 motdgen[2919]: /oem/oem-release: line 2: Azure: command not found Jul 23 00:12:55.396287 extend-filesystems[2890]: Found /dev/nvme0n1p9 Jul 23 00:12:55.401185 extend-filesystems[2890]: Checking size of /dev/nvme0n1p9 Jul 23 00:12:55.409954 chronyd[2885]: Timezone right/UTC failed leap second check, ignoring Jul 23 00:12:55.410243 systemd[1]: Started chronyd.service - NTP client/server. Jul 23 00:12:55.410093 chronyd[2885]: Loaded seccomp filter (level 2) Jul 23 00:12:55.412896 systemd[1]: motdgen.service: Deactivated successfully. Jul 23 00:12:55.413158 systemd[1]: Finished motdgen.service - Generate /run/flatcar/motd. Jul 23 00:12:55.418095 google_oslogin_nss_cache[2891]: oslogin_cache_refresh[2891]: Failure getting users, quitting Jul 23 00:12:55.418095 google_oslogin_nss_cache[2891]: oslogin_cache_refresh[2891]: Produced empty passwd cache file, removing /etc/oslogin_passwd.cache.bak. Jul 23 00:12:55.418095 google_oslogin_nss_cache[2891]: oslogin_cache_refresh[2891]: Refreshing group entry cache Jul 23 00:12:55.417948 oslogin_cache_refresh[2891]: Failure getting users, quitting Jul 23 00:12:55.417962 oslogin_cache_refresh[2891]: Produced empty passwd cache file, removing /etc/oslogin_passwd.cache.bak. Jul 23 00:12:55.418001 oslogin_cache_refresh[2891]: Refreshing group entry cache Jul 23 00:12:55.420792 jq[2922]: true Jul 23 00:12:55.435757 systemd[1]: Finished nvidia.service - NVIDIA Configure Service. Jul 23 00:12:55.440813 update_engine[2901]: I20260723 00:12:55.440742 2901 main.cc:92] Flatcar Update Engine starting Jul 23 00:12:55.442489 google_oslogin_nss_cache[2891]: oslogin_cache_refresh[2891]: Failure getting groups, quitting Jul 23 00:12:55.442489 google_oslogin_nss_cache[2891]: oslogin_cache_refresh[2891]: Produced empty group cache file, removing /etc/oslogin_group.cache.bak. Jul 23 00:12:55.441977 oslogin_cache_refresh[2891]: Failure getting groups, quitting Jul 23 00:12:55.443024 systemd[1]: google-oslogin-cache.service: Deactivated successfully. Jul 23 00:12:55.441986 oslogin_cache_refresh[2891]: Produced empty group cache file, removing /etc/oslogin_group.cache.bak. Jul 23 00:12:55.443341 systemd[1]: Finished google-oslogin-cache.service - NSS cache refresh. Jul 23 00:12:55.450780 extend-filesystems[2890]: Resized partition /dev/nvme0n1p9 Jul 23 00:12:55.491412 extend-filesystems[2963]: resize2fs 1.47.4 (6-Mar-2025) Jul 23 00:12:55.500448 systemd-logind[2900]: New seat seat0. Jul 23 00:12:55.504219 kernel: EXT4-fs (nvme0n1p9): resizing filesystem from 6359552 to 6376955 blocks Jul 23 00:12:55.509451 kernel: EXT4-fs (nvme0n1p9): resized filesystem to 6376955 Jul 23 00:12:55.510446 systemd-logind[2900]: Watching system buttons on /dev/input/event1 (AT Translated Set 2 keyboard) Jul 23 00:12:55.520732 dbus-daemon[2887]: [system] SELinux support is enabled Jul 23 00:12:55.520909 systemd[1]: Started dbus.service - D-Bus System Message Bus. Jul 23 00:12:55.535227 update_engine[2901]: I20260723 00:12:55.535185 2901 update_check_scheduler.cc:74] Next update check in 5m19s Jul 23 00:12:55.536743 dbus-daemon[2887]: [system] Successfully activated service 'org.freedesktop.systemd1' Jul 23 00:12:55.539358 systemd[1]: Started update-engine.service - Update Engine. Jul 23 00:12:55.540977 extend-filesystems[2963]: Filesystem at /dev/nvme0n1p9 is mounted on /; on-line resizing required Jul 23 00:12:55.540977 extend-filesystems[2963]: old_desc_blocks = 4, new_desc_blocks = 4 Jul 23 00:12:55.540977 extend-filesystems[2963]: The filesystem on /dev/nvme0n1p9 is now 6376955 (4k) blocks long. Jul 23 00:12:55.550474 extend-filesystems[2890]: Resized filesystem in /dev/nvme0n1p9 Jul 23 00:12:55.547955 systemd[1]: Created slice user-1000.slice - User Slice of UID 1000. Jul 23 00:12:55.562672 systemd[1]: system-cloudinit@usr-share-coreos-cloud\x2dconfig.yml.service - Load cloud-config from /usr/share/coreos/cloud-config.yml skipped, unmet condition check ConditionFileNotEmpty=/usr/share/coreos/cloud-config.yml Jul 23 00:12:55.562832 systemd[1]: Reached target system-config.target - Load system-provided cloud configs. Jul 23 00:12:55.564807 systemd[1]: user-cloudinit-proc-cmdline.service - Load cloud-config from url defined in /proc/cmdline skipped, unmet condition check ConditionKernelCommandLine=cloud-config-url Jul 23 00:12:55.564909 systemd[1]: Reached target user-config.target - Load user-provided cloud configs. Jul 23 00:12:55.576690 systemd[1]: Started locksmithd.service - Cluster reboot manager. Jul 23 00:12:55.579236 systemd[1]: extend-filesystems.service: Deactivated successfully. Jul 23 00:12:55.582750 systemd[1]: Finished extend-filesystems.service - Extend Filesystems. Jul 23 00:12:55.591294 systemd[1]: Started systemd-logind.service - User Login Management. Jul 23 00:12:55.600708 systemd[1]: Starting user-runtime-dir@1000.service - User Runtime Directory /run/user/1000... Jul 23 00:12:55.625137 bash[2968]: Updated "/home/flatcar/.ssh/authorized_keys" Jul 23 00:12:55.626237 systemd[1]: Finished update-ssh-keys-after-ignition.service - Run update-ssh-keys once after Ignition. Jul 23 00:12:55.632743 systemd[1]: sshkeys.service skipped, no trigger condition checks were met. Jul 23 00:12:55.659766 systemd[1]: Finished user-runtime-dir@1000.service - User Runtime Directory /run/user/1000. Jul 23 00:12:55.826825 sshd_keygen[2936]: ssh-keygen: generating new host keys: RSA ECDSA ED25519 Jul 23 00:12:55.850239 systemd[1]: Finished sshd-keygen.service - Generate sshd host keys. Jul 23 00:12:55.853250 systemd[1]: Starting issuegen.service - Generate /run/issue... Jul 23 00:12:55.857624 systemd[1]: Starting waagent.service - Microsoft Azure Linux Agent... Jul 23 00:12:55.872850 systemd[1]: issuegen.service: Deactivated successfully. Jul 23 00:12:55.873489 systemd[1]: Finished issuegen.service - Generate /run/issue. Jul 23 00:12:55.883014 locksmithd[2988]: locksmithd starting currentOperation="UPDATE_STATUS_IDLE" strategy="reboot" Jul 23 00:12:55.885663 systemd[1]: Starting systemd-user-sessions.service - Permit User Sessions... Jul 23 00:12:55.894141 systemd[1]: Started waagent.service - Microsoft Azure Linux Agent. Jul 23 00:12:55.907397 systemd[1]: Finished systemd-user-sessions.service - Permit User Sessions. Jul 23 00:12:55.910589 systemd[1]: Started getty@tty1.service - Getty on tty1. Jul 23 00:12:55.914715 systemd[1]: Started serial-getty@ttyS0.service - Serial Getty on ttyS0. Jul 23 00:12:55.917780 systemd[1]: Reached target getty.target - Login Prompts. Jul 23 00:12:55.920406 systemd[1]: Starting user@1000.service - User Manager for UID 1000... Jul 23 00:12:56.125495 (systemd)[3032]: pam_unix(systemd-user:session): session opened for user flatcar(uid=1000) by flatcar(uid=0) Jul 23 00:12:56.127570 systemd-logind[2900]: New session '1' of user 'flatcar' with class 'manager' and type 'unspecified'. Jul 23 00:12:56.337581 systemd[3032]: Queued start job for default target default.target. Jul 23 00:12:56.345339 systemd[3032]: Created slice app.slice - User Application Slice. Jul 23 00:12:56.345387 systemd[3032]: Started systemd-tmpfiles-clean.timer - Daily Cleanup of User's Temporary Directories. Jul 23 00:12:56.345405 systemd[3032]: Reached target machines.target - Virtual Machines and Containers. Jul 23 00:12:56.345470 systemd[3032]: Reached target paths.target - Paths. Jul 23 00:12:56.345496 systemd[3032]: Reached target timers.target - Timers. Jul 23 00:12:56.346491 systemd[3032]: Starting dbus.socket - D-Bus User Message Bus Socket... Jul 23 00:12:56.348118 systemd[3032]: Listening on systemd-ask-password.socket - Query the User Interactively for a Password. Jul 23 00:12:56.348246 systemd[3032]: Listening on systemd-importd.socket - Disk Image Download Service Socket. Jul 23 00:12:56.349138 systemd[3032]: Listening on systemd-journalctl.socket - Journal Log Access Socket. Jul 23 00:12:56.349351 systemd[3032]: Listening on systemd-machined.socket - Virtual Machine and Container Registration Service Socket. Jul 23 00:12:56.350640 systemd[3032]: Starting systemd-tmpfiles-setup.service - Create User Files and Directories... Jul 23 00:12:56.357621 systemd[3032]: Listening on dbus.socket - D-Bus User Message Bus Socket. Jul 23 00:12:56.358864 systemd[3032]: Reached target sockets.target - Sockets. Jul 23 00:12:56.362067 systemd[3032]: Finished systemd-tmpfiles-setup.service - Create User Files and Directories. Jul 23 00:12:56.362167 systemd[3032]: Reached target basic.target - Basic System. Jul 23 00:12:56.362602 systemd[1]: Started user@1000.service - User Manager for UID 1000. Jul 23 00:12:56.365566 systemd[3032]: Starting hello.service - A hello world unit!... Jul 23 00:12:56.403349 echo[3045]: Foo ! Jul 23 00:12:56.404022 systemd[3032]: Finished hello.service - A hello world unit!. Jul 23 00:12:56.404158 systemd[3032]: Reached target default.target - Main User Target. Jul 23 00:12:56.404201 systemd[3032]: Startup finished in 272ms. Jul 23 00:12:57.051764 containerd[2916]: time="2026-07-23T00:12:57Z" 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 Jul 23 00:12:57.052910 containerd[2916]: time="2026-07-23T00:12:57.052872840Z" level=info msg="starting containerd" revision=301b2dac98f15c27117da5c8af12118a041a31d9 version=v2.2.2 Jul 23 00:12:57.063463 containerd[2916]: time="2026-07-23T00:12:57.062928682Z" level=warning msg="Configuration migrated from version 2, use `containerd config migrate` to avoid migration" t="14.396µs" Jul 23 00:12:57.063463 containerd[2916]: time="2026-07-23T00:12:57.062963642Z" level=info msg="loading plugin" id=io.containerd.content.v1.content type=io.containerd.content.v1 Jul 23 00:12:57.063463 containerd[2916]: time="2026-07-23T00:12:57.063001499Z" level=info msg="loading plugin" id=io.containerd.image-verifier.v1.bindir type=io.containerd.image-verifier.v1 Jul 23 00:12:57.063463 containerd[2916]: time="2026-07-23T00:12:57.063013602Z" level=info msg="loading plugin" id=io.containerd.internal.v1.opt type=io.containerd.internal.v1 Jul 23 00:12:57.063463 containerd[2916]: time="2026-07-23T00:12:57.063145339Z" level=info msg="loading plugin" id=io.containerd.warning.v1.deprecations type=io.containerd.warning.v1 Jul 23 00:12:57.063463 containerd[2916]: time="2026-07-23T00:12:57.063154287Z" level=info msg="loading plugin" id=io.containerd.mount-handler.v1.erofs type=io.containerd.mount-handler.v1 Jul 23 00:12:57.063463 containerd[2916]: time="2026-07-23T00:12:57.063161321Z" level=info msg="loading plugin" id=io.containerd.snapshotter.v1.blockfile type=io.containerd.snapshotter.v1 Jul 23 00:12:57.063463 containerd[2916]: time="2026-07-23T00:12:57.063192748Z" level=info msg="skip loading plugin" error="no scratch file generator: skip plugin" id=io.containerd.snapshotter.v1.blockfile type=io.containerd.snapshotter.v1 Jul 23 00:12:57.063463 containerd[2916]: time="2026-07-23T00:12:57.063199084Z" level=info msg="loading plugin" id=io.containerd.snapshotter.v1.btrfs type=io.containerd.snapshotter.v1 Jul 23 00:12:57.063463 containerd[2916]: time="2026-07-23T00:12:57.063364546Z" 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 Jul 23 00:12:57.063463 containerd[2916]: time="2026-07-23T00:12:57.063372466Z" level=info msg="loading plugin" id=io.containerd.snapshotter.v1.devmapper type=io.containerd.snapshotter.v1 Jul 23 00:12:57.063463 containerd[2916]: time="2026-07-23T00:12:57.063378538Z" level=info msg="skip loading plugin" error="devmapper not configured: skip plugin" id=io.containerd.snapshotter.v1.devmapper type=io.containerd.snapshotter.v1 Jul 23 00:12:57.063767 containerd[2916]: time="2026-07-23T00:12:57.063383978Z" level=info msg="loading plugin" id=io.containerd.snapshotter.v1.erofs type=io.containerd.snapshotter.v1 Jul 23 00:12:57.063767 containerd[2916]: time="2026-07-23T00:12:57.063527849Z" level=info msg="loading plugin" id=io.containerd.snapshotter.v1.native type=io.containerd.snapshotter.v1 Jul 23 00:12:57.063767 containerd[2916]: time="2026-07-23T00:12:57.063576328Z" level=info msg="loading plugin" id=io.containerd.snapshotter.v1.overlayfs type=io.containerd.snapshotter.v1 Jul 23 00:12:57.063767 containerd[2916]: time="2026-07-23T00:12:57.063708842Z" level=info msg="loading plugin" id=io.containerd.snapshotter.v1.zfs type=io.containerd.snapshotter.v1 Jul 23 00:12:57.063767 containerd[2916]: time="2026-07-23T00:12:57.063735271Z" 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 Jul 23 00:12:57.063767 containerd[2916]: time="2026-07-23T00:12:57.063745562Z" level=info msg="loading plugin" id=io.containerd.event.v1.exchange type=io.containerd.event.v1 Jul 23 00:12:57.064205 containerd[2916]: time="2026-07-23T00:12:57.064188084Z" level=info msg="loading plugin" id=io.containerd.monitor.task.v1.cgroups type=io.containerd.monitor.task.v1 Jul 23 00:12:57.065773 containerd[2916]: time="2026-07-23T00:12:57.065746821Z" level=info msg="loading plugin" id=io.containerd.metadata.v1.bolt type=io.containerd.metadata.v1 Jul 23 00:12:57.065854 containerd[2916]: time="2026-07-23T00:12:57.065834705Z" level=info msg="metadata content store policy set" policy=shared Jul 23 00:12:57.080005 containerd[2916]: time="2026-07-23T00:12:57.079976357Z" level=info msg="loading plugin" id=io.containerd.gc.v1.scheduler type=io.containerd.gc.v1 Jul 23 00:12:57.080092 containerd[2916]: time="2026-07-23T00:12:57.080016189Z" level=info msg="loading plugin" id=io.containerd.nri.v1.nri type=io.containerd.nri.v1 Jul 23 00:12:57.080092 containerd[2916]: time="2026-07-23T00:12:57.080043239Z" level=info msg="built-in NRI default validator is disabled" Jul 23 00:12:57.080092 containerd[2916]: time="2026-07-23T00:12:57.080050193Z" level=info msg="runtime interface created" Jul 23 00:12:57.080092 containerd[2916]: time="2026-07-23T00:12:57.080054623Z" level=info msg="created NRI interface" Jul 23 00:12:57.080092 containerd[2916]: time="2026-07-23T00:12:57.080069876Z" level=info msg="loading plugin" id=io.containerd.differ.v1.erofs type=io.containerd.differ.v1 Jul 23 00:12:57.098122 containerd[2916]: time="2026-07-23T00:12:57.098089289Z" level=info msg="loading plugin" id=io.containerd.differ.v1.walking type=io.containerd.differ.v1 Jul 23 00:12:57.098122 containerd[2916]: time="2026-07-23T00:12:57.098123127Z" level=info msg="loading plugin" id=io.containerd.lease.v1.manager type=io.containerd.lease.v1 Jul 23 00:12:57.098222 containerd[2916]: time="2026-07-23T00:12:57.098138889Z" level=info msg="loading plugin" id=io.containerd.mount-manager.v1.bolt type=io.containerd.mount-manager.v1 Jul 23 00:12:57.098267 containerd[2916]: time="2026-07-23T00:12:57.098248740Z" level=info msg="loading plugin" id=io.containerd.service.v1.containers-service type=io.containerd.service.v1 Jul 23 00:12:57.098291 containerd[2916]: time="2026-07-23T00:12:57.098271169Z" level=info msg="loading plugin" id=io.containerd.service.v1.content-service type=io.containerd.service.v1 Jul 23 00:12:57.098314 containerd[2916]: time="2026-07-23T00:12:57.098295184Z" level=info msg="loading plugin" id=io.containerd.service.v1.diff-service type=io.containerd.service.v1 Jul 23 00:12:57.098314 containerd[2916]: time="2026-07-23T00:12:57.098307180Z" level=info msg="loading plugin" id=io.containerd.service.v1.images-service type=io.containerd.service.v1 Jul 23 00:12:57.098359 containerd[2916]: time="2026-07-23T00:12:57.098319412Z" level=info msg="loading plugin" id=io.containerd.service.v1.introspection-service type=io.containerd.service.v1 Jul 23 00:12:57.098359 containerd[2916]: time="2026-07-23T00:12:57.098332523Z" level=info msg="loading plugin" id=io.containerd.service.v1.namespaces-service type=io.containerd.service.v1 Jul 23 00:12:57.098359 containerd[2916]: time="2026-07-23T00:12:57.098344060Z" level=info msg="loading plugin" id=io.containerd.service.v1.snapshots-service type=io.containerd.service.v1 Jul 23 00:12:57.098359 containerd[2916]: time="2026-07-23T00:12:57.098354076Z" level=info msg="loading plugin" id=io.containerd.shim.v1.manager type=io.containerd.shim.v1 Jul 23 00:12:57.098461 containerd[2916]: time="2026-07-23T00:12:57.098366249Z" level=info msg="loading plugin" id=io.containerd.runtime.v2.task type=io.containerd.runtime.v2 Jul 23 00:12:57.098662 containerd[2916]: time="2026-07-23T00:12:57.098644160Z" level=info msg="loading plugin" id=io.containerd.service.v1.tasks-service type=io.containerd.service.v1 Jul 23 00:12:57.098692 containerd[2916]: time="2026-07-23T00:12:57.098670633Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.containers type=io.containerd.grpc.v1 Jul 23 00:12:57.098692 containerd[2916]: time="2026-07-23T00:12:57.098685143Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.content type=io.containerd.grpc.v1 Jul 23 00:12:57.098735 containerd[2916]: time="2026-07-23T00:12:57.098703598Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.diff type=io.containerd.grpc.v1 Jul 23 00:12:57.098735 containerd[2916]: time="2026-07-23T00:12:57.098715923Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.events type=io.containerd.grpc.v1 Jul 23 00:12:57.098735 containerd[2916]: time="2026-07-23T00:12:57.098727323Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.images type=io.containerd.grpc.v1 Jul 23 00:12:57.098797 containerd[2916]: time="2026-07-23T00:12:57.098738956Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.introspection type=io.containerd.grpc.v1 Jul 23 00:12:57.098797 containerd[2916]: time="2026-07-23T00:12:57.098754655Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.leases type=io.containerd.grpc.v1 Jul 23 00:12:57.098797 containerd[2916]: time="2026-07-23T00:12:57.098765400Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.mounts type=io.containerd.grpc.v1 Jul 23 00:12:57.098797 containerd[2916]: time="2026-07-23T00:12:57.098775246Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.namespaces type=io.containerd.grpc.v1 Jul 23 00:12:57.098797 containerd[2916]: time="2026-07-23T00:12:57.098789726Z" level=info msg="loading plugin" id=io.containerd.sandbox.store.v1.local type=io.containerd.sandbox.store.v1 Jul 23 00:12:57.098890 containerd[2916]: time="2026-07-23T00:12:57.098799566Z" level=info msg="loading plugin" id=io.containerd.transfer.v1.local type=io.containerd.transfer.v1 Jul 23 00:12:57.098890 containerd[2916]: time="2026-07-23T00:12:57.098823465Z" level=info msg="loading plugin" id=io.containerd.cri.v1.images type=io.containerd.cri.v1 Jul 23 00:12:57.098929 containerd[2916]: time="2026-07-23T00:12:57.098906466Z" level=info msg="Get image filesystem path \"/var/lib/containerd/io.containerd.snapshotter.v1.overlayfs\" for snapshotter \"overlayfs\"" Jul 23 00:12:57.098929 containerd[2916]: time="2026-07-23T00:12:57.098918359Z" level=info msg="Start snapshots syncer" Jul 23 00:12:57.098972 containerd[2916]: time="2026-07-23T00:12:57.098935396Z" level=info msg="loading plugin" id=io.containerd.cri.v1.runtime type=io.containerd.cri.v1 Jul 23 00:12:57.099500 containerd[2916]: time="2026-07-23T00:12:57.099241097Z" 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,\"cgroupWritable\":false,\"baseRuntimeSpec\":\"\",\"cniConfDir\":\"\",\"cniMaxConfNum\":0,\"snapshotter\":\"\",\"sandboxer\":\"podsandbox\",\"io_type\":\"\"}},\"ignoreBlockIONotEnabledErrors\":false,\"ignoreRdtNotEnabledErrors\":false},\"cni\":{\"binDir\":\"\",\"binDirs\":[\"/opt/cni/bin\"],\"confDir\":\"/etc/cni/net.d\",\"maxConfNum\":1,\"setupSerially\":false,\"confTemplate\":\"\",\"ipPref\":\"\",\"useInternalLoopback\":false},\"enableSelinux\":true,\"selinuxCategoryRange\":1024,\"maxContainerLogLineSize\":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\"}" Jul 23 00:12:57.099500 containerd[2916]: time="2026-07-23T00:12:57.099299725Z" level=info msg="loading plugin" id=io.containerd.podsandbox.controller.v1.podsandbox type=io.containerd.podsandbox.controller.v1 Jul 23 00:12:57.099666 containerd[2916]: time="2026-07-23T00:12:57.099401625Z" level=info msg="loading plugin" id=io.containerd.sandbox.controller.v1.shim type=io.containerd.sandbox.controller.v1 Jul 23 00:12:57.099666 containerd[2916]: time="2026-07-23T00:12:57.099514950Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.sandbox-controllers type=io.containerd.grpc.v1 Jul 23 00:12:57.099666 containerd[2916]: time="2026-07-23T00:12:57.099531938Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.sandboxes type=io.containerd.grpc.v1 Jul 23 00:12:57.099666 containerd[2916]: time="2026-07-23T00:12:57.099544634Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.snapshots type=io.containerd.grpc.v1 Jul 23 00:12:57.099666 containerd[2916]: time="2026-07-23T00:12:57.099553972Z" level=info msg="loading plugin" id=io.containerd.streaming.v1.manager type=io.containerd.streaming.v1 Jul 23 00:12:57.099666 containerd[2916]: time="2026-07-23T00:12:57.099565395Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.streaming type=io.containerd.grpc.v1 Jul 23 00:12:57.099666 containerd[2916]: time="2026-07-23T00:12:57.099576850Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.tasks type=io.containerd.grpc.v1 Jul 23 00:12:57.099666 containerd[2916]: time="2026-07-23T00:12:57.099587859Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.transfer type=io.containerd.grpc.v1 Jul 23 00:12:57.099666 containerd[2916]: time="2026-07-23T00:12:57.099600756Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.version type=io.containerd.grpc.v1 Jul 23 00:12:57.099666 containerd[2916]: time="2026-07-23T00:12:57.099609669Z" level=info msg="loading plugin" id=io.containerd.monitor.container.v1.restart type=io.containerd.monitor.container.v1 Jul 23 00:12:57.099666 containerd[2916]: time="2026-07-23T00:12:57.099632792Z" level=info msg="loading plugin" id=io.containerd.tracing.processor.v1.otlp type=io.containerd.tracing.processor.v1 Jul 23 00:12:57.099666 containerd[2916]: time="2026-07-23T00:12:57.099646352Z" 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 Jul 23 00:12:57.099666 containerd[2916]: time="2026-07-23T00:12:57.099656765Z" level=info msg="loading plugin" id=io.containerd.internal.v1.tracing type=io.containerd.internal.v1 Jul 23 00:12:57.099917 containerd[2916]: time="2026-07-23T00:12:57.099666865Z" level=info msg="skip loading plugin" error="skip plugin: tracing endpoint not configured" id=io.containerd.internal.v1.tracing type=io.containerd.internal.v1 Jul 23 00:12:57.099917 containerd[2916]: time="2026-07-23T00:12:57.099675425Z" level=info msg="loading plugin" id=io.containerd.ttrpc.v1.otelttrpc type=io.containerd.ttrpc.v1 Jul 23 00:12:57.099917 containerd[2916]: time="2026-07-23T00:12:57.099685283Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.healthcheck type=io.containerd.grpc.v1 Jul 23 00:12:57.099917 containerd[2916]: time="2026-07-23T00:12:57.099696469Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.cri type=io.containerd.grpc.v1 Jul 23 00:12:57.099917 containerd[2916]: time="2026-07-23T00:12:57.099707718Z" level=info msg="Connect containerd service" Jul 23 00:12:57.099917 containerd[2916]: time="2026-07-23T00:12:57.099733497Z" level=info msg="using experimental NRI integration - disable nri plugin to prevent this" Jul 23 00:12:57.100656 containerd[2916]: time="2026-07-23T00:12:57.100617562Z" 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" Jul 23 00:12:58.080836 containerd[2916]: time="2026-07-23T00:12:58.080772151Z" level=info msg="Start subscribing containerd event" Jul 23 00:12:58.081673 containerd[2916]: time="2026-07-23T00:12:58.081091349Z" level=info msg="Start recovering state" Jul 23 00:12:58.081673 containerd[2916]: time="2026-07-23T00:12:58.081134889Z" level=info msg=serving... address=/run/containerd/containerd.sock.ttrpc Jul 23 00:12:58.081673 containerd[2916]: time="2026-07-23T00:12:58.081167371Z" level=info msg=serving... address=/run/containerd/containerd.sock Jul 23 00:12:58.081673 containerd[2916]: time="2026-07-23T00:12:58.081497557Z" level=info msg="Start event monitor" Jul 23 00:12:58.081673 containerd[2916]: time="2026-07-23T00:12:58.081518674Z" level=info msg="Start cni network conf syncer for default" Jul 23 00:12:58.081673 containerd[2916]: time="2026-07-23T00:12:58.081525893Z" level=info msg="Start streaming server" Jul 23 00:12:58.081673 containerd[2916]: time="2026-07-23T00:12:58.081534579Z" level=info msg="Registered namespace \"k8s.io\" with NRI" Jul 23 00:12:58.081673 containerd[2916]: time="2026-07-23T00:12:58.081541195Z" level=info msg="runtime interface starting up..." Jul 23 00:12:58.081673 containerd[2916]: time="2026-07-23T00:12:58.081546878Z" level=info msg="starting plugins..." Jul 23 00:12:58.081673 containerd[2916]: time="2026-07-23T00:12:58.081557585Z" level=info msg="Synchronizing NRI (plugin) with current runtime state" Jul 23 00:12:58.083152 systemd[1]: Started containerd.service - containerd container runtime. Jul 23 00:12:58.084324 containerd[2916]: time="2026-07-23T00:12:58.083186365Z" level=info msg="containerd successfully booted in 1.032178s" Jul 23 00:12:58.087023 systemd[1]: Reached target multi-user.target - Multi-User System. Jul 23 00:12:58.090732 systemd[1]: Startup finished in 4.247s (kernel) + 12.784s (initrd) + 15.477s (userspace) = 32.509s. Jul 23 00:12:58.525779 login[3030]: pam_unix(login:session): session opened for user core(uid=500) by LOGIN(uid=0) Jul 23 00:12:58.530736 systemd[1]: Created slice user-500.slice - User Slice of UID 500. Jul 23 00:12:58.531804 systemd[1]: Starting user-runtime-dir@500.service - User Runtime Directory /run/user/500... Jul 23 00:12:58.534284 systemd-logind[2900]: New session '2' of user 'core' with class 'user-light' and type 'tty'. Jul 23 00:12:58.550302 systemd[1]: Finished user-runtime-dir@500.service - User Runtime Directory /run/user/500. Jul 23 00:12:58.556682 systemd[1]: Started session-2.scope - Session 2 of User core. Jul 23 00:12:58.777270 login[3031]: pam_unix(login:session): session opened for user core(uid=500) by LOGIN(uid=0) Jul 23 00:12:58.789106 systemd-logind[2900]: New session '3' of user 'core' with class 'user-light' and type 'tty'. Jul 23 00:12:58.794615 systemd[1]: Started session-3.scope - Session 3 of User core. Jul 23 00:12:59.111734 waagent[3027]: 2026-07-23T00:12:59.111606Z INFO Daemon Daemon Azure Linux Agent Version: 2.12.0.4 Jul 23 00:12:59.125975 waagent[3027]: 2026-07-23T00:12:59.112372Z INFO Daemon Daemon OS: flatcar 4722.1.0 Jul 23 00:12:59.125975 waagent[3027]: 2026-07-23T00:12:59.112688Z INFO Daemon Daemon Python: 3.12.13 Jul 23 00:12:59.125975 waagent[3027]: 2026-07-23T00:12:59.113923Z INFO Daemon Daemon Run daemon Jul 23 00:12:59.125975 waagent[3027]: 2026-07-23T00:12:59.114260Z INFO Daemon Daemon No RDMA handler exists for distro='Flatcar Container Linux by Kinvolk' version='4722.1.0' Jul 23 00:12:59.125975 waagent[3027]: 2026-07-23T00:12:59.114542Z INFO Daemon Daemon Using waagent for provisioning Jul 23 00:12:59.125975 waagent[3027]: 2026-07-23T00:12:59.114952Z INFO Daemon Daemon Activate resource disk Jul 23 00:12:59.125975 waagent[3027]: 2026-07-23T00:12:59.115092Z INFO Daemon Daemon Searching gen1 prefix 00000000-0001 or gen2 f8b3781a-1e82-4818-a1c3-63d806ec15bb Jul 23 00:12:59.125975 waagent[3027]: 2026-07-23T00:12:59.117165Z INFO Daemon Daemon Found device: None Jul 23 00:12:59.125975 waagent[3027]: 2026-07-23T00:12:59.117518Z ERROR Daemon Daemon Failed to mount resource disk [ResourceDiskError] unable to detect disk topology Jul 23 00:12:59.125975 waagent[3027]: 2026-07-23T00:12:59.117781Z ERROR Daemon Daemon Event: name=WALinuxAgent, op=ActivateResourceDisk, message=[ResourceDiskError] unable to detect disk topology, duration=0 Jul 23 00:12:59.125975 waagent[3027]: 2026-07-23T00:12:59.118384Z INFO Daemon Daemon Clean protocol and wireserver endpoint Jul 23 00:12:59.125975 waagent[3027]: 2026-07-23T00:12:59.118768Z INFO Daemon Daemon Running default provisioning handler Jul 23 00:12:59.125975 waagent[3027]: 2026-07-23T00:12:59.124585Z 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. Jul 23 00:12:59.131675 waagent[3027]: 2026-07-23T00:12:59.131462Z INFO Daemon Daemon Unable to get cloud-init enabled status from service: [Errno 2] No such file or directory: 'service' Jul 23 00:12:59.131885 waagent[3027]: 2026-07-23T00:12:59.131694Z INFO Daemon Daemon cloud-init is enabled: False Jul 23 00:12:59.131885 waagent[3027]: 2026-07-23T00:12:59.131836Z INFO Daemon Daemon Copying ovf-env.xml Jul 23 00:12:59.216376 waagent[3027]: 2026-07-23T00:12:59.214625Z INFO Daemon Daemon Successfully mounted dvd Jul 23 00:12:59.271377 systemd[1]: mnt-cdrom-secure.mount: Deactivated successfully. Jul 23 00:12:59.274463 waagent[3027]: 2026-07-23T00:12:59.274071Z INFO Daemon Daemon Detect protocol endpoint Jul 23 00:12:59.275498 waagent[3027]: 2026-07-23T00:12:59.275367Z INFO Daemon Daemon Clean protocol and wireserver endpoint Jul 23 00:12:59.276732 waagent[3027]: 2026-07-23T00:12:59.276699Z INFO Daemon Daemon WireServer endpoint is not found. Rerun dhcp handler Jul 23 00:12:59.278100 waagent[3027]: 2026-07-23T00:12:59.278041Z INFO Daemon Daemon Test for route to 168.63.129.16 Jul 23 00:12:59.279158 waagent[3027]: 2026-07-23T00:12:59.279133Z INFO Daemon Daemon Route to 168.63.129.16 exists Jul 23 00:12:59.280088 waagent[3027]: 2026-07-23T00:12:59.280062Z INFO Daemon Daemon Wire server endpoint:168.63.129.16 Jul 23 00:12:59.322095 waagent[3027]: 2026-07-23T00:12:59.322056Z INFO Daemon Daemon Fabric preferred wire protocol version:2015-04-05 Jul 23 00:12:59.323992 waagent[3027]: 2026-07-23T00:12:59.322869Z INFO Daemon Daemon Wire protocol version:2012-11-30 Jul 23 00:12:59.323992 waagent[3027]: 2026-07-23T00:12:59.323011Z INFO Daemon Daemon Server preferred version:2015-04-05 Jul 23 00:12:59.420814 waagent[3027]: 2026-07-23T00:12:59.420746Z INFO Daemon Daemon Initializing goal state during protocol detection Jul 23 00:12:59.422260 waagent[3027]: 2026-07-23T00:12:59.422182Z INFO Daemon Daemon Forcing an update of the goal state. Jul 23 00:12:59.428102 waagent[3027]: 2026-07-23T00:12:59.428067Z INFO Daemon Fetched a new incarnation for the WireServer goal state [incarnation 1] Jul 23 00:12:59.443805 waagent[3027]: 2026-07-23T00:12:59.443778Z INFO Daemon Daemon HostGAPlugin version: 1.0.8.184 Jul 23 00:12:59.445213 waagent[3027]: 2026-07-23T00:12:59.445173Z INFO Daemon Jul 23 00:12:59.445869 waagent[3027]: 2026-07-23T00:12:59.445800Z INFO Daemon Fetched new vmSettings [HostGAPlugin correlation ID: d7e34089-ff4d-4d6c-9bd1-dbb3e1a49b4b eTag: 2086016416842544999 source: Fabric] Jul 23 00:12:59.446845 waagent[3027]: 2026-07-23T00:12:59.446818Z INFO Daemon The vmSettings originated via Fabric; will ignore them. Jul 23 00:12:59.447064 waagent[3027]: 2026-07-23T00:12:59.447043Z INFO Daemon Jul 23 00:12:59.447131 waagent[3027]: 2026-07-23T00:12:59.447112Z INFO Daemon Fetching full goal state from the WireServer [incarnation 1] Jul 23 00:12:59.449711 waagent[3027]: 2026-07-23T00:12:59.449683Z INFO Daemon Daemon Downloading artifacts profile blob Jul 23 00:12:59.511785 waagent[3027]: 2026-07-23T00:12:59.511737Z INFO Daemon Downloaded certificate {'thumbprint': '11A0D0B70E9EB86B78BDD541739B0A566DF9746C', 'hasPrivateKey': True} Jul 23 00:12:59.514042 waagent[3027]: 2026-07-23T00:12:59.514002Z INFO Daemon Fetch goal state completed Jul 23 00:12:59.520111 waagent[3027]: 2026-07-23T00:12:59.520059Z INFO Daemon Daemon Starting provisioning Jul 23 00:12:59.521046 waagent[3027]: 2026-07-23T00:12:59.521015Z INFO Daemon Daemon Handle ovf-env.xml. Jul 23 00:12:59.521351 waagent[3027]: 2026-07-23T00:12:59.521329Z INFO Daemon Daemon Set hostname [ci-4722.1.0-n-b387f73b01] Jul 23 00:12:59.524225 waagent[3027]: 2026-07-23T00:12:59.524185Z INFO Daemon Daemon Publish hostname [ci-4722.1.0-n-b387f73b01] Jul 23 00:12:59.525756 waagent[3027]: 2026-07-23T00:12:59.525721Z INFO Daemon Daemon Examine /proc/net/route for primary interface Jul 23 00:12:59.527252 waagent[3027]: 2026-07-23T00:12:59.527218Z INFO Daemon Daemon Primary interface is [eth0] Jul 23 00:12:59.534332 systemd-networkd[2693]: eth0: Found matching .network file, based on potentially unpredictable interface name: /usr/lib/systemd/network/zz-default.network Jul 23 00:12:59.534340 systemd-networkd[2693]: eth0: Reconfiguring with /usr/lib/systemd/network/zz-default.network. Jul 23 00:12:59.534362 systemd-networkd[2693]: eth0: DHCP lease lost Jul 23 00:12:59.548625 waagent[3027]: 2026-07-23T00:12:59.548582Z INFO Daemon Daemon Create user account if not exists Jul 23 00:12:59.554870 waagent[3027]: 2026-07-23T00:12:59.549267Z INFO Daemon Daemon User core already exists, skip useradd Jul 23 00:12:59.554870 waagent[3027]: 2026-07-23T00:12:59.549727Z INFO Daemon Daemon Configure sudoer Jul 23 00:12:59.554870 waagent[3027]: 2026-07-23T00:12:59.550439Z INFO Daemon Daemon Configure sshd Jul 23 00:12:59.554870 waagent[3027]: 2026-07-23T00:12:59.550728Z INFO Daemon Daemon Added a configuration snippet disabling SSH password-based authentication methods. It also configures SSH client probing to keep connections alive. Jul 23 00:12:59.554870 waagent[3027]: 2026-07-23T00:12:59.550904Z INFO Daemon Daemon Deploy ssh public key. Jul 23 00:12:59.566497 systemd-networkd[2693]: eth0: DHCPv4 address 10.0.0.20/24, gateway 10.0.0.1 acquired from 168.63.129.16 Jul 23 00:13:00.636949 waagent[3027]: 2026-07-23T00:13:00.636907Z INFO Daemon Daemon Provisioning complete Jul 23 00:13:00.644487 waagent[3027]: 2026-07-23T00:13:00.644414Z INFO Daemon Daemon RDMA capabilities are not enabled, skipping Jul 23 00:13:00.645834 waagent[3027]: 2026-07-23T00:13:00.645651Z INFO Daemon Daemon End of log to /dev/console. The agent will now check for updates and then will process extensions. Jul 23 00:13:00.647836 waagent[3027]: 2026-07-23T00:13:00.647767Z INFO Daemon Daemon Installed Agent WALinuxAgent-2.12.0.4 is the most current agent Jul 23 00:13:00.758454 waagent[3127]: 2026-07-23T00:13:00.758359Z INFO ExtHandler ExtHandler Azure Linux Agent (Goal State Agent version 2.12.0.4) Jul 23 00:13:00.758825 waagent[3127]: 2026-07-23T00:13:00.758496Z INFO ExtHandler ExtHandler OS: flatcar 4722.1.0 Jul 23 00:13:00.758825 waagent[3127]: 2026-07-23T00:13:00.758556Z INFO ExtHandler ExtHandler Python: 3.12.13 Jul 23 00:13:00.758825 waagent[3127]: 2026-07-23T00:13:00.758602Z INFO ExtHandler ExtHandler CPU Arch: x86_64 Jul 23 00:13:00.793761 waagent[3127]: 2026-07-23T00:13:00.793716Z INFO ExtHandler ExtHandler Distro: flatcar-4722.1.0; OSUtil: FlatcarUtil; AgentService: waagent; Python: 3.12.13; Arch: x86_64; systemd: True; LISDrivers: Absent; logrotate: logrotate 3.22.0; Jul 23 00:13:00.793887 waagent[3127]: 2026-07-23T00:13:00.793863Z INFO ExtHandler ExtHandler WireServer endpoint 168.63.129.16 read from file Jul 23 00:13:00.793955 waagent[3127]: 2026-07-23T00:13:00.793921Z INFO ExtHandler ExtHandler Wire server endpoint:168.63.129.16 Jul 23 00:13:00.798773 waagent[3127]: 2026-07-23T00:13:00.798726Z INFO ExtHandler Fetched a new incarnation for the WireServer goal state [incarnation 1] Jul 23 00:13:00.804173 waagent[3127]: 2026-07-23T00:13:00.804142Z INFO ExtHandler ExtHandler HostGAPlugin version: 1.0.8.184 Jul 23 00:13:00.804586 waagent[3127]: 2026-07-23T00:13:00.804551Z INFO ExtHandler Jul 23 00:13:00.804640 waagent[3127]: 2026-07-23T00:13:00.804622Z INFO ExtHandler Fetched new vmSettings [HostGAPlugin correlation ID: 89fb1d12-a3fe-4373-953d-c008beb7d9a4 eTag: 2086016416842544999 source: Fabric] Jul 23 00:13:00.804868 waagent[3127]: 2026-07-23T00:13:00.804843Z INFO ExtHandler The vmSettings originated via Fabric; will ignore them. Jul 23 00:13:00.805227 waagent[3127]: 2026-07-23T00:13:00.805202Z INFO ExtHandler Jul 23 00:13:00.805274 waagent[3127]: 2026-07-23T00:13:00.805253Z INFO ExtHandler Fetching full goal state from the WireServer [incarnation 1] Jul 23 00:13:00.814377 waagent[3127]: 2026-07-23T00:13:00.814349Z INFO ExtHandler ExtHandler Downloading artifacts profile blob Jul 23 00:13:00.882909 waagent[3127]: 2026-07-23T00:13:00.882860Z INFO ExtHandler Downloaded certificate {'thumbprint': '11A0D0B70E9EB86B78BDD541739B0A566DF9746C', 'hasPrivateKey': True} Jul 23 00:13:00.883225 waagent[3127]: 2026-07-23T00:13:00.883191Z INFO ExtHandler Fetch goal state completed Jul 23 00:13:00.891759 waagent[3127]: 2026-07-23T00:13:00.891679Z INFO ExtHandler ExtHandler OpenSSL version: OpenSSL 3.5.6 7 Apr 2026 (Library: OpenSSL 3.5.6 7 Apr 2026) Jul 23 00:13:00.894681 waagent[3127]: 2026-07-23T00:13:00.894640Z INFO ExtHandler ExtHandler WALinuxAgent-2.12.0.4 running as process 3127 Jul 23 00:13:00.894797 waagent[3127]: 2026-07-23T00:13:00.894773Z INFO ExtHandler ExtHandler ******** AutoUpdate.Enabled is set to False, not processing the operation ******** Jul 23 00:13:00.895031 waagent[3127]: 2026-07-23T00:13:00.895009Z INFO ExtHandler ExtHandler ******** AutoUpdate.UpdateToLatestVersion is set to False, not processing the operation ******** Jul 23 00:13:00.895985 waagent[3127]: 2026-07-23T00:13:00.895952Z INFO ExtHandler ExtHandler [CGI] Cgroup monitoring is not supported on ['flatcar', '4722.1.0', '', 'Flatcar Container Linux by Kinvolk'] Jul 23 00:13:00.896258 waagent[3127]: 2026-07-23T00:13:00.896232Z INFO ExtHandler ExtHandler [CGI] Agent will reset the quotas in case distro: ['flatcar', '4722.1.0', '', 'Flatcar Container Linux by Kinvolk'] went from supported to unsupported Jul 23 00:13:00.896353 waagent[3127]: 2026-07-23T00:13:00.896332Z INFO ExtHandler ExtHandler [CGI] Agent cgroups enabled: False Jul 23 00:13:00.896778 waagent[3127]: 2026-07-23T00:13:00.896755Z INFO ExtHandler ExtHandler Starting setup for Persistent firewall rules Jul 23 00:13:00.929361 waagent[3127]: 2026-07-23T00:13:00.929336Z INFO ExtHandler ExtHandler Firewalld service not running/unavailable, trying to set up waagent-network-setup.service Jul 23 00:13:00.929525 waagent[3127]: 2026-07-23T00:13:00.929504Z INFO ExtHandler ExtHandler Successfully updated the Binary file /var/lib/waagent/waagent-network-setup.py for firewall setup Jul 23 00:13:00.934046 waagent[3127]: 2026-07-23T00:13:00.933654Z INFO ExtHandler ExtHandler Service: waagent-network-setup.service not enabled. Adding it now Jul 23 00:13:00.938570 systemd[1]: Reload requested from client PID 3142 ('systemctl') (unit waagent.service)... Jul 23 00:13:00.938586 systemd[1]: Reloading... Jul 23 00:13:01.011458 zram_generator::config[3188]: No configuration found. Jul 23 00:13:01.236060 systemd[1]: Reloading finished in 297 ms. Jul 23 00:13:01.260405 waagent[3127]: 2026-07-23T00:13:01.259642Z INFO ExtHandler ExtHandler Successfully added and enabled the waagent-network-setup.service Jul 23 00:13:01.260405 waagent[3127]: 2026-07-23T00:13:01.259791Z INFO ExtHandler ExtHandler Persistent firewall rules setup successfully Jul 23 00:13:01.293463 kernel: hv_storvsc f8b3781a-1e82-4818-a1c3-63d806ec15bb: tag#189 cmd 0x4a status: scsi 0x0 srb 0x20 hv 0xc0000001 Jul 23 00:13:01.540570 waagent[3127]: 2026-07-23T00:13:01.540454Z INFO ExtHandler ExtHandler DROP rule is not available which implies no firewall rules are set yet. Environment thread will set it up. Jul 23 00:13:01.540827 waagent[3127]: 2026-07-23T00:13:01.540791Z 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] Jul 23 00:13:01.541532 waagent[3127]: 2026-07-23T00:13:01.541478Z INFO ExtHandler ExtHandler Starting env monitor service. Jul 23 00:13:01.541866 waagent[3127]: 2026-07-23T00:13:01.541816Z INFO ExtHandler ExtHandler Start SendTelemetryHandler service. Jul 23 00:13:01.542080 waagent[3127]: 2026-07-23T00:13:01.542051Z INFO EnvHandler ExtHandler WireServer endpoint 168.63.129.16 read from file Jul 23 00:13:01.542137 waagent[3127]: 2026-07-23T00:13:01.542098Z INFO MonitorHandler ExtHandler WireServer endpoint 168.63.129.16 read from file Jul 23 00:13:01.542310 waagent[3127]: 2026-07-23T00:13:01.542267Z INFO MonitorHandler ExtHandler Wire server endpoint:168.63.129.16 Jul 23 00:13:01.542594 waagent[3127]: 2026-07-23T00:13:01.542544Z INFO MonitorHandler ExtHandler Monitor.NetworkConfigurationChanges is disabled. Jul 23 00:13:01.542861 waagent[3127]: 2026-07-23T00:13:01.542832Z INFO SendTelemetryHandler ExtHandler Successfully started the SendTelemetryHandler thread Jul 23 00:13:01.543069 waagent[3127]: 2026-07-23T00:13:01.543014Z INFO EnvHandler ExtHandler Wire server endpoint:168.63.129.16 Jul 23 00:13:01.543104 waagent[3127]: 2026-07-23T00:13:01.543078Z INFO ExtHandler ExtHandler Start Extension Telemetry service. Jul 23 00:13:01.543227 waagent[3127]: 2026-07-23T00:13:01.543204Z INFO MonitorHandler ExtHandler Routing table from /proc/net/route: Jul 23 00:13:01.543227 waagent[3127]: Iface Destination Gateway Flags RefCnt Use Metric Mask MTU Window IRTT Jul 23 00:13:01.543227 waagent[3127]: eth0 00000000 0100000A 0003 0 0 1024 00000000 0 0 0 Jul 23 00:13:01.543227 waagent[3127]: eth0 0000000A 00000000 0001 0 0 1024 00FFFFFF 0 0 0 Jul 23 00:13:01.543227 waagent[3127]: eth0 0100000A 00000000 0005 0 0 1024 FFFFFFFF 0 0 0 Jul 23 00:13:01.543227 waagent[3127]: eth0 10813FA8 0100000A 0007 0 0 1024 FFFFFFFF 0 0 0 Jul 23 00:13:01.543227 waagent[3127]: eth0 FEA9FEA9 0100000A 0007 0 0 1024 FFFFFFFF 0 0 0 Jul 23 00:13:01.543803 waagent[3127]: 2026-07-23T00:13:01.543760Z INFO TelemetryEventsCollector ExtHandler Extension Telemetry pipeline enabled: True Jul 23 00:13:01.543932 waagent[3127]: 2026-07-23T00:13:01.543897Z INFO EnvHandler ExtHandler Configure routes Jul 23 00:13:01.544093 waagent[3127]: 2026-07-23T00:13:01.543995Z INFO EnvHandler ExtHandler Gateway:None Jul 23 00:13:01.544093 waagent[3127]: 2026-07-23T00:13:01.544040Z INFO ExtHandler ExtHandler Goal State Period: 6 sec. This indicates how often the agent checks for new goal states and reports status. Jul 23 00:13:01.544190 waagent[3127]: 2026-07-23T00:13:01.544167Z INFO TelemetryEventsCollector ExtHandler Successfully started the TelemetryEventsCollector thread Jul 23 00:13:01.544419 waagent[3127]: 2026-07-23T00:13:01.544397Z INFO EnvHandler ExtHandler Routes:None Jul 23 00:13:01.552328 waagent[3127]: 2026-07-23T00:13:01.552304Z INFO ExtHandler ExtHandler Jul 23 00:13:01.552460 waagent[3127]: 2026-07-23T00:13:01.552439Z INFO ExtHandler ExtHandler ProcessExtensionsGoalState started [incarnation_1 channel: WireServer source: Fabric activity: daa8510d-7234-4c68-9870-e89c96976ead correlation df5798dc-ce4f-4312-9c55-a9ade723cf55 created: 2026-07-23T00:12:04.086334Z] Jul 23 00:13:01.552713 waagent[3127]: 2026-07-23T00:13:01.552699Z INFO ExtHandler ExtHandler No extension handlers found, not processing anything. Jul 23 00:13:01.553078 waagent[3127]: 2026-07-23T00:13:01.553064Z INFO ExtHandler ExtHandler ProcessExtensionsGoalState completed [incarnation_1 0 ms] Jul 23 00:13:01.625749 waagent[3127]: 2026-07-23T00:13:01.625698Z INFO MonitorHandler ExtHandler Network interfaces: Jul 23 00:13:01.625749 waagent[3127]: Executing ['ip', '-a', '-o', 'link']: Jul 23 00:13:01.625749 waagent[3127]: 1: lo: mtu 65536 qdisc noqueue state UNKNOWN mode DEFAULT group default qlen 1000\ link/loopback 00:00:00:00:00:00 brd 00:00:00:00:00:00 Jul 23 00:13:01.625749 waagent[3127]: 2: eth0: mtu 1500 qdisc mq state UP mode DEFAULT group default qlen 1000\ link/ether 7c:ed:8d:77:b5:41 brd ff:ff:ff:ff:ff:ff\ alias Network Device\ altname enx7ced8d77b541 Jul 23 00:13:01.625749 waagent[3127]: 3: enP30832s1: mtu 1500 qdisc mq master eth0 state UP mode DEFAULT group default qlen 1000\ link/ether 7c:ed:8d:77:b5:41 brd ff:ff:ff:ff:ff:ff\ altname enP30832p0s0\ altname enp0s0\ altname ens1 Jul 23 00:13:01.625749 waagent[3127]: Executing ['ip', '-4', '-a', '-o', 'address']: Jul 23 00:13:01.625749 waagent[3127]: 1: lo inet 127.0.0.1/8 scope host lo\ valid_lft forever preferred_lft forever Jul 23 00:13:01.625749 waagent[3127]: 2: eth0 inet 10.0.0.20/24 metric 1024 brd 10.0.0.255 scope global eth0\ valid_lft forever preferred_lft forever Jul 23 00:13:01.625749 waagent[3127]: Executing ['ip', '-6', '-a', '-o', 'address']: Jul 23 00:13:01.625749 waagent[3127]: 1: lo inet6 ::1/128 scope host noprefixroute \ valid_lft forever preferred_lft forever Jul 23 00:13:01.625749 waagent[3127]: 2: eth0 inet6 fe80::7eed:8dff:fe77:b541/64 scope link proto kernel_ll \ valid_lft forever preferred_lft forever Jul 23 00:13:01.637625 waagent[3127]: 2026-07-23T00:13:01.637577Z INFO EnvHandler ExtHandler Created firewall rules for the Azure Fabric: Jul 23 00:13:01.637625 waagent[3127]: Chain INPUT (policy ACCEPT 0 packets, 0 bytes) Jul 23 00:13:01.637625 waagent[3127]: pkts bytes target prot opt in out source destination Jul 23 00:13:01.637625 waagent[3127]: Chain FORWARD (policy ACCEPT 0 packets, 0 bytes) Jul 23 00:13:01.637625 waagent[3127]: pkts bytes target prot opt in out source destination Jul 23 00:13:01.637625 waagent[3127]: Chain OUTPUT (policy ACCEPT 1 packets, 60 bytes) Jul 23 00:13:01.637625 waagent[3127]: pkts bytes target prot opt in out source destination Jul 23 00:13:01.637625 waagent[3127]: 0 0 ACCEPT tcp -- * * 0.0.0.0/0 168.63.129.16 tcp dpt:53 Jul 23 00:13:01.637625 waagent[3127]: 5 468 ACCEPT tcp -- * * 0.0.0.0/0 168.63.129.16 owner UID match 0 Jul 23 00:13:01.637625 waagent[3127]: 0 0 DROP tcp -- * * 0.0.0.0/0 168.63.129.16 ctstate INVALID,NEW Jul 23 00:13:01.640331 waagent[3127]: 2026-07-23T00:13:01.640282Z INFO EnvHandler ExtHandler Current Firewall rules: Jul 23 00:13:01.640331 waagent[3127]: Chain INPUT (policy ACCEPT 0 packets, 0 bytes) Jul 23 00:13:01.640331 waagent[3127]: pkts bytes target prot opt in out source destination Jul 23 00:13:01.640331 waagent[3127]: Chain FORWARD (policy ACCEPT 0 packets, 0 bytes) Jul 23 00:13:01.640331 waagent[3127]: pkts bytes target prot opt in out source destination Jul 23 00:13:01.640331 waagent[3127]: Chain OUTPUT (policy ACCEPT 1 packets, 60 bytes) Jul 23 00:13:01.640331 waagent[3127]: pkts bytes target prot opt in out source destination Jul 23 00:13:01.640331 waagent[3127]: 0 0 ACCEPT tcp -- * * 0.0.0.0/0 168.63.129.16 tcp dpt:53 Jul 23 00:13:01.640331 waagent[3127]: 7 762 ACCEPT tcp -- * * 0.0.0.0/0 168.63.129.16 owner UID match 0 Jul 23 00:13:01.640331 waagent[3127]: 0 0 DROP tcp -- * * 0.0.0.0/0 168.63.129.16 ctstate INVALID,NEW Jul 23 00:13:01.730131 waagent[3127]: 2026-07-23T00:13:01.730082Z INFO ExtHandler ExtHandler [HEARTBEAT] Agent WALinuxAgent-2.12.0.4 is running as the goal state agent [DEBUG HeartbeatCounter: 0;HeartbeatId: 3EA86D2C-5F81-46C8-B0E6-A56E74F70336;DroppedPackets: 0;UpdateGSErrors: 0;AutoUpdate: 0;UpdateMode: SelfUpdate;] Jul 23 00:13:19.194647 chronyd[2885]: Selected source PHC0 Jul 23 00:13:20.095614 systemd[1]: Created slice system-sshd.slice - Slice /system/sshd. Jul 23 00:13:20.096780 systemd[1]: Started sshd@0-1-10.0.0.20:22-20.76.1.115:40878.service - OpenSSH per-connection server daemon (20.76.1.115:40878). Jul 23 00:13:20.350302 sshd[3284]: Accepted publickey for flatcar from 20.76.1.115 port 40878 ssh2: RSA SHA256:1NM32mU/r3lCXMrhk9FaoY925DISACzEhGZ1FLbzLgk Jul 23 00:13:20.350763 sshd-session[3284]: pam_unix(sshd:session): session opened for user flatcar(uid=1000) by flatcar(uid=0) Jul 23 00:13:20.355167 systemd-logind[2900]: New session '4' of user 'flatcar' with class 'user' and type 'tty'. Jul 23 00:13:20.360612 systemd[1]: Started session-4.scope - Session 4 of User flatcar. Jul 23 00:13:20.419863 systemd[1]: Started sshd@1-2-10.0.0.20:22-20.76.1.115:40890.service - OpenSSH per-connection server daemon (20.76.1.115:40890). Jul 23 00:13:20.550690 sshd[3291]: Accepted publickey for flatcar from 20.76.1.115 port 40890 ssh2: RSA SHA256:1NM32mU/r3lCXMrhk9FaoY925DISACzEhGZ1FLbzLgk Jul 23 00:13:20.551719 sshd-session[3291]: pam_unix(sshd:session): session opened for user flatcar(uid=1000) by flatcar(uid=0) Jul 23 00:13:20.555737 systemd-logind[2900]: New session '5' of user 'flatcar' with class 'user' and type 'tty'. Jul 23 00:13:20.565587 systemd[1]: Started session-5.scope - Session 5 of User flatcar. Jul 23 00:13:20.603070 sshd[3295]: Connection closed by 20.76.1.115 port 40890 Jul 23 00:13:20.604299 sshd-session[3291]: pam_unix(sshd:session): session closed for user flatcar Jul 23 00:13:20.606162 systemd[1]: sshd@1-2-10.0.0.20:22-20.76.1.115:40890.service: Deactivated successfully. Jul 23 00:13:20.607496 systemd[1]: session-5.scope: Deactivated successfully. Jul 23 00:13:20.608193 systemd-logind[2900]: Session 5 logged out. Waiting for processes to exit. Jul 23 00:13:20.609274 systemd-logind[2900]: Removed session 5. Jul 23 00:13:20.626463 systemd[1]: Started sshd@2-3-10.0.0.20:22-20.76.1.115:40896.service - OpenSSH per-connection server daemon (20.76.1.115:40896). Jul 23 00:13:20.736835 sshd[3301]: Accepted publickey for flatcar from 20.76.1.115 port 40896 ssh2: RSA SHA256:1NM32mU/r3lCXMrhk9FaoY925DISACzEhGZ1FLbzLgk Jul 23 00:13:20.737780 sshd-session[3301]: pam_unix(sshd:session): session opened for user flatcar(uid=1000) by flatcar(uid=0) Jul 23 00:13:20.741872 systemd-logind[2900]: New session '6' of user 'flatcar' with class 'user' and type 'tty'. Jul 23 00:13:20.750590 systemd[1]: Started session-6.scope - Session 6 of User flatcar. Jul 23 00:13:20.785959 sshd[3305]: Connection closed by 20.76.1.115 port 40896 Jul 23 00:13:20.786350 sshd-session[3301]: pam_unix(sshd:session): session closed for user flatcar Jul 23 00:13:20.788173 systemd[1]: sshd@2-3-10.0.0.20:22-20.76.1.115:40896.service: Deactivated successfully. Jul 23 00:13:20.789416 systemd[1]: session-6.scope: Deactivated successfully. Jul 23 00:13:20.791006 systemd-logind[2900]: Session 6 logged out. Waiting for processes to exit. Jul 23 00:13:20.791836 systemd-logind[2900]: Removed session 6. Jul 23 00:13:20.816394 systemd[1]: Started sshd@3-4-10.0.0.20:22-20.76.1.115:40898.service - OpenSSH per-connection server daemon (20.76.1.115:40898). Jul 23 00:13:20.928826 sshd[3311]: Accepted publickey for flatcar from 20.76.1.115 port 40898 ssh2: RSA SHA256:1NM32mU/r3lCXMrhk9FaoY925DISACzEhGZ1FLbzLgk Jul 23 00:13:20.929487 sshd-session[3311]: pam_unix(sshd:session): session opened for user flatcar(uid=1000) by flatcar(uid=0) Jul 23 00:13:20.933666 systemd-logind[2900]: New session '7' of user 'flatcar' with class 'user' and type 'tty'. Jul 23 00:13:20.939597 systemd[1]: Started session-7.scope - Session 7 of User flatcar. Jul 23 00:13:20.976963 sshd[3315]: Connection closed by 20.76.1.115 port 40898 Jul 23 00:13:20.978178 sshd-session[3311]: pam_unix(sshd:session): session closed for user flatcar Jul 23 00:13:20.980000 systemd[1]: sshd@3-4-10.0.0.20:22-20.76.1.115:40898.service: Deactivated successfully. Jul 23 00:13:20.981279 systemd[1]: session-7.scope: Deactivated successfully. Jul 23 00:13:20.982011 systemd-logind[2900]: Session 7 logged out. Waiting for processes to exit. Jul 23 00:13:20.983054 systemd-logind[2900]: Removed session 7. Jul 23 00:13:21.002384 systemd[1]: Started sshd@4-5-10.0.0.20:22-20.76.1.115:40906.service - OpenSSH per-connection server daemon (20.76.1.115:40906). Jul 23 00:13:21.113323 sshd[3321]: Accepted publickey for flatcar from 20.76.1.115 port 40906 ssh2: RSA SHA256:1NM32mU/r3lCXMrhk9FaoY925DISACzEhGZ1FLbzLgk Jul 23 00:13:21.114186 sshd-session[3321]: pam_unix(sshd:session): session opened for user flatcar(uid=1000) by flatcar(uid=0) Jul 23 00:13:21.117908 systemd-logind[2900]: New session '8' of user 'flatcar' with class 'user' and type 'tty'. Jul 23 00:13:21.124570 systemd[1]: Started session-8.scope - Session 8 of User flatcar. Jul 23 00:13:21.259944 sudo[3326]: flatcar : PWD=/home/flatcar ; USER=root ; COMMAND=/usr/sbin/setenforce 1 Jul 23 00:13:21.260143 sudo[3326]: pam_unix(sudo:session): session opened for user root(uid=0) by flatcar(uid=1000) Jul 23 00:13:21.272307 sudo[3326]: pam_unix(sudo:session): session closed for user root Jul 23 00:13:21.288020 sshd[3325]: Connection closed by 20.76.1.115 port 40906 Jul 23 00:13:21.289315 sshd-session[3321]: pam_unix(sshd:session): session closed for user flatcar Jul 23 00:13:21.291666 systemd[1]: sshd@4-5-10.0.0.20:22-20.76.1.115:40906.service: Deactivated successfully. Jul 23 00:13:21.292976 systemd[1]: session-8.scope: Deactivated successfully. Jul 23 00:13:21.293706 systemd-logind[2900]: Session 8 logged out. Waiting for processes to exit. Jul 23 00:13:21.294728 systemd-logind[2900]: Removed session 8. Jul 23 00:13:21.312862 systemd[1]: Started sshd@5-6-10.0.0.20:22-20.76.1.115:40314.service - OpenSSH per-connection server daemon (20.76.1.115:40314). Jul 23 00:13:21.425471 sshd[3333]: Accepted publickey for flatcar from 20.76.1.115 port 40314 ssh2: RSA SHA256:1NM32mU/r3lCXMrhk9FaoY925DISACzEhGZ1FLbzLgk Jul 23 00:13:21.426276 sshd-session[3333]: pam_unix(sshd:session): session opened for user flatcar(uid=1000) by flatcar(uid=0) Jul 23 00:13:21.430727 systemd-logind[2900]: New session '9' of user 'flatcar' with class 'user' and type 'tty'. Jul 23 00:13:21.436584 systemd[1]: Started session-9.scope - Session 9 of User flatcar. Jul 23 00:13:21.461650 sudo[3339]: flatcar : PWD=/home/flatcar ; USER=root ; COMMAND=/usr/sbin/rm -rf /etc/audit/rules.d/80-selinux.rules /etc/audit/rules.d/99-default.rules Jul 23 00:13:21.461893 sudo[3339]: pam_unix(sudo:session): session opened for user root(uid=0) by flatcar(uid=1000) Jul 23 00:13:21.463100 sudo[3339]: pam_unix(sudo:session): session closed for user root Jul 23 00:13:21.467627 sudo[3338]: flatcar : PWD=/home/flatcar ; USER=root ; COMMAND=/usr/sbin/systemctl restart audit-rules Jul 23 00:13:21.467822 sudo[3338]: pam_unix(sudo:session): session opened for user root(uid=0) by flatcar(uid=1000) Jul 23 00:13:21.473037 systemd[1]: Starting audit-rules.service - Load Audit Rules... Jul 23 00:13:21.503000 audit: CONFIG_CHANGE auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 op=remove_rule key=(null) list=5 res=1 Jul 23 00:13:21.506083 augenrules[3363]: No rules Jul 23 00:13:21.506502 kernel: audit: type=1305 audit(1784765601.503:174): auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 op=remove_rule key=(null) list=5 res=1 Jul 23 00:13:21.503000 audit[3363]: SYSCALL arch=c000003e syscall=44 success=yes exit=1056 a0=3 a1=7ffd649db5f0 a2=420 a3=0 items=0 ppid=3344 pid=3363 auid=4294967295 uid=0 gid=0 euid=0 suid=0 fsuid=0 egid=0 sgid=0 fsgid=0 tty=(none) ses=4294967295 comm="auditctl" exe="/usr/bin/auditctl" subj=system_u:system_r:kernel_t:s0 key=(null) Jul 23 00:13:21.503000 audit: PROCTITLE proctitle=2F7362696E2F617564697463746C002D52002F6574632F61756469742F61756469742E72756C6573 Jul 23 00:13:21.510848 kernel: audit: type=1300 audit(1784765601.503:174): arch=c000003e syscall=44 success=yes exit=1056 a0=3 a1=7ffd649db5f0 a2=420 a3=0 items=0 ppid=3344 pid=3363 auid=4294967295 uid=0 gid=0 euid=0 suid=0 fsuid=0 egid=0 sgid=0 fsgid=0 tty=(none) ses=4294967295 comm="auditctl" exe="/usr/bin/auditctl" subj=system_u:system_r:kernel_t:s0 key=(null) Jul 23 00:13:21.510366 systemd[1]: audit-rules.service: Deactivated successfully. Jul 23 00:13:21.510926 kernel: audit: type=1327 audit(1784765601.503:174): proctitle=2F7362696E2F617564697463746C002D52002F6574632F61756469742F61756469742E72756C6573 Jul 23 00:13:21.511476 systemd[1]: Finished audit-rules.service - Load Audit Rules. Jul 23 00:13:21.510000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=audit-rules comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Jul 23 00:13:21.510000 audit[1]: SERVICE_STOP pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=audit-rules comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Jul 23 00:13:21.516009 kernel: audit: type=1130 audit(1784765601.510:175): pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=audit-rules comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Jul 23 00:13:21.516035 kernel: audit: type=1131 audit(1784765601.510:176): pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=audit-rules comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Jul 23 00:13:21.516651 sudo[3338]: pam_unix(sudo:session): session closed for user root Jul 23 00:13:21.515000 audit[3338]: AUDIT1106 pid=3338 uid=1000 auid=1000 ses=9 subj=system_u:system_r:kernel_t:s0 msg='op=PAM:session_close grantors=pam_limits,pam_env,pam_umask,pam_unix acct="root" exe="/usr/bin/sudo" hostname=? addr=? terminal=? res=success' Jul 23 00:13:21.515000 audit[3338]: AUDIT1104 pid=3338 uid=1000 auid=1000 ses=9 subj=system_u:system_r:kernel_t:s0 msg='op=PAM:setcred grantors=pam_env,pam_faillock,pam_unix acct="root" exe="/usr/bin/sudo" hostname=? addr=? terminal=? res=success' Jul 23 00:13:21.520937 kernel: audit: type=1106 audit(1784765601.515:177): pid=3338 uid=1000 auid=1000 ses=9 subj=system_u:system_r:kernel_t:s0 msg='op=PAM:session_close grantors=pam_limits,pam_env,pam_umask,pam_unix acct="root" exe="/usr/bin/sudo" hostname=? addr=? terminal=? res=success' Jul 23 00:13:21.520979 kernel: audit: type=1104 audit(1784765601.515:178): pid=3338 uid=1000 auid=1000 ses=9 subj=system_u:system_r:kernel_t:s0 msg='op=PAM:setcred grantors=pam_env,pam_faillock,pam_unix acct="root" exe="/usr/bin/sudo" hostname=? addr=? terminal=? res=success' Jul 23 00:13:21.535857 sshd[3337]: Connection closed by 20.76.1.115 port 40314 Jul 23 00:13:21.537047 sshd-session[3333]: pam_unix(sshd:session): session closed for user flatcar Jul 23 00:13:21.535000 audit[3333]: AUDIT1106 pid=3333 uid=0 auid=1000 ses=9 subj=system_u:system_r:kernel_t:s0 msg='op=PAM:session_close grantors=pam_loginuid,pam_env,pam_namespace,pam_keyinit,pam_limits,pam_env,pam_umask,pam_unix,pam_systemd,pam_lastlog,pam_mail acct="flatcar" exe="/usr/lib64/misc/sshd-session" hostname=20.76.1.115 addr=20.76.1.115 terminal=ssh res=success' Jul 23 00:13:21.535000 audit[3333]: AUDIT1104 pid=3333 uid=0 auid=1000 ses=9 subj=system_u:system_r:kernel_t:s0 msg='op=PAM:setcred grantors=pam_env,pam_faillock,pam_unix acct="flatcar" exe="/usr/lib64/misc/sshd-session" hostname=20.76.1.115 addr=20.76.1.115 terminal=ssh res=success' Jul 23 00:13:21.539707 systemd[1]: sshd@5-6-10.0.0.20:22-20.76.1.115:40314.service: Deactivated successfully. Jul 23 00:13:21.541374 systemd[1]: session-9.scope: Deactivated successfully. Jul 23 00:13:21.544615 systemd-logind[2900]: Session 9 logged out. Waiting for processes to exit. Jul 23 00:13:21.545444 systemd-logind[2900]: Removed session 9. Jul 23 00:13:21.547916 kernel: audit: type=1106 audit(1784765601.535:179): pid=3333 uid=0 auid=1000 ses=9 subj=system_u:system_r:kernel_t:s0 msg='op=PAM:session_close grantors=pam_loginuid,pam_env,pam_namespace,pam_keyinit,pam_limits,pam_env,pam_umask,pam_unix,pam_systemd,pam_lastlog,pam_mail acct="flatcar" exe="/usr/lib64/misc/sshd-session" hostname=20.76.1.115 addr=20.76.1.115 terminal=ssh res=success' Jul 23 00:13:21.547962 kernel: audit: type=1104 audit(1784765601.535:180): pid=3333 uid=0 auid=1000 ses=9 subj=system_u:system_r:kernel_t:s0 msg='op=PAM:setcred grantors=pam_env,pam_faillock,pam_unix acct="flatcar" exe="/usr/lib64/misc/sshd-session" hostname=20.76.1.115 addr=20.76.1.115 terminal=ssh res=success' Jul 23 00:13:21.535000 audit[1]: SERVICE_STOP pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=sshd@5-6-10.0.0.20:22-20.76.1.115:40314 comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Jul 23 00:13:21.550767 kernel: audit: type=1131 audit(1784765601.535:181): pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=sshd@5-6-10.0.0.20:22-20.76.1.115:40314 comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Jul 23 00:13:21.559000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=sshd@6-7-10.0.0.20:22-20.76.1.115:40328 comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Jul 23 00:13:21.560645 systemd[1]: Started sshd@6-7-10.0.0.20:22-20.76.1.115:40328.service - OpenSSH per-connection server daemon (20.76.1.115:40328). Jul 23 00:13:21.673000 audit[3372]: AUDIT1101 pid=3372 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='op=PAM:accounting grantors=pam_access,pam_time,pam_unix,pam_faillock,pam_permit acct="flatcar" exe="/usr/lib64/misc/sshd-session" hostname=20.76.1.115 addr=20.76.1.115 terminal=ssh res=success' Jul 23 00:13:21.675412 sshd[3372]: Accepted publickey for flatcar from 20.76.1.115 port 40328 ssh2: RSA SHA256:1NM32mU/r3lCXMrhk9FaoY925DISACzEhGZ1FLbzLgk Jul 23 00:13:21.674000 audit[3372]: AUDIT1103 pid=3372 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='op=PAM:setcred grantors=pam_env,pam_faillock,pam_unix acct="flatcar" exe="/usr/lib64/misc/sshd-session" hostname=20.76.1.115 addr=20.76.1.115 terminal=ssh res=success' Jul 23 00:13:21.674000 audit[3372]: SYSCALL arch=c000003e syscall=1 success=yes exit=4 a0=8 a1=7ffd7a3923a0 a2=4 a3=0 items=0 ppid=1 pid=3372 auid=1000 uid=0 gid=0 euid=0 suid=0 fsuid=0 egid=0 sgid=0 fsgid=0 tty=(none) ses=10 comm="sshd-session" exe="/usr/lib64/misc/sshd-session" subj=system_u:system_r:kernel_t:s0 key=(null) Jul 23 00:13:21.674000 audit: PROCTITLE proctitle=737368642D73657373696F6E3A20666C6174636172205B707269765D Jul 23 00:13:21.676356 sshd-session[3372]: pam_unix(sshd:session): session opened for user flatcar(uid=1000) by flatcar(uid=0) Jul 23 00:13:21.680303 systemd-logind[2900]: New session '10' of user 'flatcar' with class 'user' and type 'tty'. Jul 23 00:13:21.686584 systemd[1]: Started session-10.scope - Session 10 of User flatcar. Jul 23 00:13:21.687000 audit[3372]: AUDIT1105 pid=3372 uid=0 auid=1000 ses=10 subj=system_u:system_r:kernel_t:s0 msg='op=PAM:session_open grantors=pam_loginuid,pam_env,pam_namespace,pam_keyinit,pam_limits,pam_env,pam_umask,pam_unix,pam_systemd,pam_lastlog,pam_mail acct="flatcar" exe="/usr/lib64/misc/sshd-session" hostname=20.76.1.115 addr=20.76.1.115 terminal=ssh res=success' Jul 23 00:13:21.688000 audit[3376]: AUDIT1103 pid=3376 uid=0 auid=1000 ses=10 subj=system_u:system_r:kernel_t:s0 msg='op=PAM:setcred grantors=pam_env,pam_faillock,pam_unix acct="flatcar" exe="/usr/lib64/misc/sshd-session" hostname=20.76.1.115 addr=20.76.1.115 terminal=ssh res=success' Jul 23 00:13:21.723834 sshd[3376]: Connection closed by 20.76.1.115 port 40328 Jul 23 00:13:21.724973 sshd-session[3372]: pam_unix(sshd:session): session closed for user flatcar Jul 23 00:13:21.723000 audit[3372]: AUDIT1106 pid=3372 uid=0 auid=1000 ses=10 subj=system_u:system_r:kernel_t:s0 msg='op=PAM:session_close grantors=pam_loginuid,pam_env,pam_namespace,pam_keyinit,pam_limits,pam_env,pam_umask,pam_unix,pam_systemd,pam_lastlog,pam_mail acct="flatcar" exe="/usr/lib64/misc/sshd-session" hostname=20.76.1.115 addr=20.76.1.115 terminal=ssh res=success' Jul 23 00:13:21.723000 audit[3372]: AUDIT1104 pid=3372 uid=0 auid=1000 ses=10 subj=system_u:system_r:kernel_t:s0 msg='op=PAM:setcred grantors=pam_env,pam_faillock,pam_unix acct="flatcar" exe="/usr/lib64/misc/sshd-session" hostname=20.76.1.115 addr=20.76.1.115 terminal=ssh res=success' Jul 23 00:13:21.726890 systemd[1]: sshd@6-7-10.0.0.20:22-20.76.1.115:40328.service: Deactivated successfully. Jul 23 00:13:21.725000 audit[1]: SERVICE_STOP pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=sshd@6-7-10.0.0.20:22-20.76.1.115:40328 comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Jul 23 00:13:21.728087 systemd[1]: session-10.scope: Deactivated successfully. Jul 23 00:13:21.728817 systemd-logind[2900]: Session 10 logged out. Waiting for processes to exit. Jul 23 00:13:21.729910 systemd-logind[2900]: Removed session 10.