Oct 27 13:22:33.922276 kernel: Booting Linux on physical CPU 0x0000000000 [0x410fd490] Oct 27 13:22:33.922298 kernel: Linux version 6.12.114-flatcar (build@pony-truck.infra.kinvolk.io) (aarch64-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 Tue Oct 27 09:18:12 -00 2026 Oct 27 13:22:33.922304 kernel: KASLR enabled Oct 27 13:22:33.922309 kernel: earlycon: pl11 at MMIO 0x00000000effec000 (options '') Oct 27 13:22:33.922312 kernel: printk: legacy bootconsole [pl11] enabled Oct 27 13:22:33.922316 kernel: efi: EFI v2.7 by EDK II Oct 27 13:22:33.922322 kernel: efi: ACPI 2.0=0x3f979018 SMBIOS=0x3f8a0000 SMBIOS 3.0=0x3f880000 MEMATTR=0x3e879018 RNG=0x3f979998 MEMRESERVE=0x3db7d798 Oct 27 13:22:33.922327 kernel: random: crng init done Oct 27 13:22:33.922331 kernel: secureboot: Secure boot disabled Oct 27 13:22:33.922335 kernel: ACPI: Early table checksum verification disabled Oct 27 13:22:33.922339 kernel: ACPI: RSDP 0x000000003F979018 000024 (v02 VRTUAL) Oct 27 13:22:33.922343 kernel: ACPI: XSDT 0x000000003F979F18 00006C (v01 VRTUAL MICROSFT 00000001 MSFT 00000001) Oct 27 13:22:33.922347 kernel: ACPI: FACP 0x000000003F979C18 000114 (v06 VRTUAL MICROSFT 00000001 MSFT 00000001) Oct 27 13:22:33.922351 kernel: ACPI: DSDT 0x000000003F95A018 01E046 (v02 MSFTVM DSDT01 00000001 INTL 20230628) Oct 27 13:22:33.922357 kernel: ACPI: DBG2 0x000000003F979B18 000072 (v00 VRTUAL MICROSFT 00000001 MSFT 00000001) Oct 27 13:22:33.922362 kernel: ACPI: GTDT 0x000000003F979D98 000060 (v02 VRTUAL MICROSFT 00000001 MSFT 00000001) Oct 27 13:22:33.922366 kernel: ACPI: OEM0 0x000000003F979098 000064 (v01 VRTUAL MICROSFT 00000001 MSFT 00000001) Oct 27 13:22:33.922371 kernel: ACPI: SPCR 0x000000003F979A98 000050 (v02 VRTUAL MICROSFT 00000001 MSFT 00000001) Oct 27 13:22:33.922375 kernel: ACPI: APIC 0x000000003F979818 0000FC (v04 VRTUAL MICROSFT 00000001 MSFT 00000001) Oct 27 13:22:33.922379 kernel: ACPI: SRAT 0x000000003F979198 000234 (v03 VRTUAL MICROSFT 00000001 MSFT 00000001) Oct 27 13:22:33.922385 kernel: ACPI: PPTT 0x000000003F979418 00012C (v01 VRTUAL MICROSFT 00000000 MSFT 00000000) Oct 27 13:22:33.922389 kernel: ACPI: BGRT 0x000000003F979E98 000038 (v01 VRTUAL MICROSFT 00000001 MSFT 00000001) Oct 27 13:22:33.922393 kernel: ACPI: SPCR: console: pl011,mmio32,0xeffec000,115200 Oct 27 13:22:33.922398 kernel: ACPI: Use ACPI SPCR as default console: Yes Oct 27 13:22:33.922402 kernel: ACPI: SRAT: Node 0 PXM 0 [mem 0x00000000-0x3fffffff] hotplug Oct 27 13:22:33.922407 kernel: ACPI: SRAT: Node 0 PXM 0 [mem 0x100000000-0x1bfffffff] hotplug Oct 27 13:22:33.922411 kernel: ACPI: SRAT: Node 0 PXM 0 [mem 0x1c0000000-0xfbfffffff] hotplug Oct 27 13:22:33.922416 kernel: ACPI: SRAT: Node 0 PXM 0 [mem 0x1000000000-0xffffffffff] hotplug Oct 27 13:22:33.922420 kernel: ACPI: SRAT: Node 0 PXM 0 [mem 0x10000000000-0x1ffffffffff] hotplug Oct 27 13:22:33.922424 kernel: ACPI: SRAT: Node 0 PXM 0 [mem 0x20000000000-0x3ffffffffff] hotplug Oct 27 13:22:33.922429 kernel: ACPI: SRAT: Node 0 PXM 0 [mem 0x40000000000-0x7ffffffffff] hotplug Oct 27 13:22:33.922434 kernel: ACPI: SRAT: Node 0 PXM 0 [mem 0x80000000000-0xfffffffffff] hotplug Oct 27 13:22:33.922438 kernel: ACPI: SRAT: Node 0 PXM 0 [mem 0x100000000000-0x1fffffffffff] hotplug Oct 27 13:22:33.922442 kernel: ACPI: SRAT: Node 0 PXM 0 [mem 0x200000000000-0x3fffffffffff] hotplug Oct 27 13:22:33.922447 kernel: ACPI: SRAT: Node 0 PXM 0 [mem 0x400000000000-0x7fffffffffff] hotplug Oct 27 13:22:33.922451 kernel: ACPI: SRAT: Node 0 PXM 0 [mem 0x800000000000-0xffffffffffff] hotplug Oct 27 13:22:33.922455 kernel: NUMA: Node 0 [mem 0x00000000-0x3fffffff] + [mem 0x100000000-0x1bfffffff] -> [mem 0x00000000-0x1bfffffff] Oct 27 13:22:33.922460 kernel: NODE_DATA(0) allocated [mem 0x1bf800a00-0x1bf807fff] Oct 27 13:22:33.922464 kernel: Zone ranges: Oct 27 13:22:33.922469 kernel: DMA [mem 0x0000000000000000-0x00000000ffffffff] Oct 27 13:22:33.922476 kernel: DMA32 empty Oct 27 13:22:33.922480 kernel: Normal [mem 0x0000000100000000-0x00000001bfffffff] Oct 27 13:22:33.922485 kernel: Device empty Oct 27 13:22:33.922489 kernel: Movable zone start for each node Oct 27 13:22:33.922494 kernel: Early memory node ranges Oct 27 13:22:33.922499 kernel: node 0: [mem 0x0000000000000000-0x00000000007fffff] Oct 27 13:22:33.922504 kernel: node 0: [mem 0x0000000000824000-0x000000003f38ffff] Oct 27 13:22:33.922508 kernel: node 0: [mem 0x000000003f390000-0x000000003f943fff] Oct 27 13:22:33.922513 kernel: node 0: [mem 0x000000003f944000-0x000000003f9effff] Oct 27 13:22:33.922517 kernel: node 0: [mem 0x000000003f9f0000-0x000000003fdeffff] Oct 27 13:22:33.922575 kernel: node 0: [mem 0x000000003fdf0000-0x000000003fffffff] Oct 27 13:22:33.922580 kernel: node 0: [mem 0x0000000100000000-0x00000001bfffffff] Oct 27 13:22:33.922585 kernel: Initmem setup node 0 [mem 0x0000000000000000-0x00000001bfffffff] Oct 27 13:22:33.922590 kernel: On node 0, zone DMA: 36 pages in unavailable ranges Oct 27 13:22:33.922594 kernel: cma: Reserved 16 MiB at 0x000000003ca00000 on node -1 Oct 27 13:22:33.922599 kernel: psci: probing for conduit method from ACPI. Oct 27 13:22:33.922605 kernel: psci: PSCIv1.3 detected in firmware. Oct 27 13:22:33.922609 kernel: psci: Using standard PSCI v0.2 function IDs Oct 27 13:22:33.922614 kernel: psci: MIGRATE_INFO_TYPE not supported. Oct 27 13:22:33.922618 kernel: psci: SMC Calling Convention v1.4 Oct 27 13:22:33.922623 kernel: ACPI: NUMA: SRAT: PXM 0 -> MPIDR 0x0 -> Node 0 Oct 27 13:22:33.922627 kernel: ACPI: NUMA: SRAT: PXM 0 -> MPIDR 0x1 -> Node 0 Oct 27 13:22:33.922632 kernel: percpu: Embedded 34 pages/cpu s98968 r8192 d32104 u139264 Oct 27 13:22:33.922636 kernel: pcpu-alloc: s98968 r8192 d32104 u139264 alloc=34*4096 Oct 27 13:22:33.922641 kernel: pcpu-alloc: [0] 0 [0] 1 Oct 27 13:22:33.922646 kernel: Detected PIPT I-cache on CPU0 Oct 27 13:22:33.922650 kernel: CPU features: detected: Address authentication (architected QARMA5 algorithm) Oct 27 13:22:33.922656 kernel: CPU features: detected: GIC system register CPU interface Oct 27 13:22:33.922660 kernel: CPU features: detected: Spectre-v4 Oct 27 13:22:33.922665 kernel: CPU features: detected: Spectre-BHB Oct 27 13:22:33.922670 kernel: CPU features: kernel page table isolation forced ON by KASLR Oct 27 13:22:33.922674 kernel: CPU features: detected: Kernel page table isolation (KPTI) Oct 27 13:22:33.922679 kernel: CPU features: detected: ARM erratum 2067961 or 2054223 Oct 27 13:22:33.922683 kernel: CPU features: detected: Broken broadcast TLBI completion Oct 27 13:22:33.922688 kernel: CPU features: detected: SSBS not fully self-synchronizing Oct 27 13:22:33.922692 kernel: alternatives: applying boot alternatives Oct 27 13:22:33.922698 kernel: 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=ttyAMA0,115200n8 earlycon=pl011,0xeffec000 flatcar.first_boot=detected acpi=force flatcar.oem.id=azure flatcar.autologin verity.usrhash=6ae5c5ebc899cb7e26ff0cf052d73929ebb0340d53d537c96a4957eafa5184f4 Oct 27 13:22:33.922704 kernel: Dentry cache hash table entries: 524288 (order: 10, 4194304 bytes, linear) Oct 27 13:22:33.922709 kernel: Inode-cache hash table entries: 262144 (order: 9, 2097152 bytes, linear) Oct 27 13:22:33.922713 kernel: Fallback order for Node 0: 0 Oct 27 13:22:33.922718 kernel: Built 1 zonelists, mobility grouping on. Total pages: 1048540 Oct 27 13:22:33.922722 kernel: Policy zone: Normal Oct 27 13:22:33.922727 kernel: mem auto-init: stack:off, heap alloc:off, heap free:off Oct 27 13:22:33.922737 kernel: software IO TLB: area num 2. Oct 27 13:22:33.922742 kernel: software IO TLB: mapped [mem 0x0000000034b40000-0x0000000038b40000] (64MB) Oct 27 13:22:33.922746 kernel: SLUB: HWalign=64, Order=0-3, MinObjects=0, CPUs=2, Nodes=1 Oct 27 13:22:33.922751 kernel: ftrace: allocating 41447 entries in 164 pages Oct 27 13:22:33.922755 kernel: ftrace: allocated 164 pages with 3 groups Oct 27 13:22:33.922761 kernel: rcu: Preemptible hierarchical RCU implementation. Oct 27 13:22:33.922766 kernel: rcu: RCU event tracing is enabled. Oct 27 13:22:33.922771 kernel: rcu: RCU restricting CPUs from NR_CPUS=512 to nr_cpu_ids=2. Oct 27 13:22:33.922775 kernel: Trampoline variant of Tasks RCU enabled. Oct 27 13:22:33.922780 kernel: Rude variant of Tasks RCU enabled. Oct 27 13:22:33.922785 kernel: Tracing variant of Tasks RCU enabled. Oct 27 13:22:33.922789 kernel: rcu: RCU calculated value of scheduler-enlistment delay is 100 jiffies. Oct 27 13:22:33.922794 kernel: rcu: Adjusting geometry for rcu_fanout_leaf=16, nr_cpu_ids=2 Oct 27 13:22:33.922798 kernel: RCU Tasks: Setting shift to 1 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=2. Oct 27 13:22:33.922803 kernel: RCU Tasks Rude: Setting shift to 1 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=2. Oct 27 13:22:33.922808 kernel: RCU Tasks Trace: Setting shift to 1 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=2. Oct 27 13:22:33.922813 kernel: NR_IRQS: 64, nr_irqs: 64, preallocated irqs: 0 Oct 27 13:22:33.922818 kernel: GICv3: 960 SPIs implemented Oct 27 13:22:33.922822 kernel: GICv3: 0 Extended SPIs implemented Oct 27 13:22:33.922827 kernel: Root IRQ handler: gic_handle_irq Oct 27 13:22:33.922831 kernel: GICv3: GICv3 features: 16 PPIs, RSS Oct 27 13:22:33.922836 kernel: GICv3: GICD_CTRL.DS=0, SCR_EL3.FIQ=0 Oct 27 13:22:33.922840 kernel: GICv3: CPU0: found redistributor 0 region 0:0x00000000effee000 Oct 27 13:22:33.922845 kernel: ITS: No ITS available, not enabling LPIs Oct 27 13:22:33.922850 kernel: rcu: srcu_init: Setting srcu_struct sizes based on contention. Oct 27 13:22:33.922854 kernel: clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1911260446275000 ns Oct 27 13:22:33.922859 kernel: arch_timer: cp15 timer(s) running at 1000.00MHz (virt). Oct 27 13:22:33.922864 kernel: clocksource: arch_sys_counter: mask: 0x1fffffffffffffff max_cycles: 0x1cd42e4dffb, max_idle_ns: 881590591483 ns Oct 27 13:22:33.922869 kernel: sched_clock: 61 bits at 1000MHz, resolution 1ns, wraps every 4398046511103ns Oct 27 13:22:33.922874 kernel: Console: colour dummy device 80x25 Oct 27 13:22:33.922879 kernel: printk: legacy console [tty1] enabled Oct 27 13:22:33.922884 kernel: ACPI: Core revision 20240827 Oct 27 13:22:33.922889 kernel: Calibrating delay loop (skipped), value calculated using timer frequency.. 2000.00 BogoMIPS (lpj=1000000) Oct 27 13:22:33.922894 kernel: pid_max: default: 32768 minimum: 301 Oct 27 13:22:33.922899 kernel: LSM: initializing lsm=lockdown,capability,landlock,selinux,ima Oct 27 13:22:33.922909 kernel: landlock: Up and running. Oct 27 13:22:33.922914 kernel: SELinux: Initializing. Oct 27 13:22:33.922920 kernel: Mount-cache hash table entries: 8192 (order: 4, 65536 bytes, linear) Oct 27 13:22:33.922925 kernel: Mountpoint-cache hash table entries: 8192 (order: 4, 65536 bytes, linear) Oct 27 13:22:33.922930 kernel: Hyper-V: privilege flags low 0x2e7f, high 0x3b8030, hints 0xa0000e, misc 0x31e1 Oct 27 13:22:33.922935 kernel: Hyper-V: Host Build 10.0.26102.3704-3-0 Oct 27 13:22:33.922940 kernel: Hyper-V: enabling crash_kexec_post_notifiers Oct 27 13:22:33.922946 kernel: rcu: Hierarchical SRCU implementation. Oct 27 13:22:33.922951 kernel: rcu: Max phase no-delay instances is 400. Oct 27 13:22:33.922956 kernel: Timer migration: 1 hierarchy levels; 8 children per group; 1 crossnode level Oct 27 13:22:33.922961 kernel: Remapping and enabling EFI services. Oct 27 13:22:33.922966 kernel: smp: Bringing up secondary CPUs ... Oct 27 13:22:33.922971 kernel: Detected PIPT I-cache on CPU1 Oct 27 13:22:33.922976 kernel: GICv3: CPU1: found redistributor 1 region 1:0x00000000f000e000 Oct 27 13:22:33.922982 kernel: CPU1: Booted secondary processor 0x0000000001 [0x410fd490] Oct 27 13:22:33.922987 kernel: smp: Brought up 1 node, 2 CPUs Oct 27 13:22:33.922992 kernel: SMP: Total of 2 processors activated. Oct 27 13:22:33.922997 kernel: CPU: All CPU(s) started at EL1 Oct 27 13:22:33.923002 kernel: CPU features: detected: 32-bit EL0 Support Oct 27 13:22:33.923008 kernel: CPU features: detected: Instruction cache invalidation not required for I/D coherence Oct 27 13:22:33.923013 kernel: CPU features: detected: Data cache clean to the PoU not required for I/D coherence Oct 27 13:22:33.923019 kernel: CPU features: detected: Common not Private translations Oct 27 13:22:33.923024 kernel: CPU features: detected: CRC32 instructions Oct 27 13:22:33.923029 kernel: CPU features: detected: Generic authentication (architected QARMA5 algorithm) Oct 27 13:22:33.923034 kernel: CPU features: detected: RCpc load-acquire (LDAPR) Oct 27 13:22:33.923039 kernel: CPU features: detected: LSE atomic instructions Oct 27 13:22:33.923044 kernel: CPU features: detected: Privileged Access Never Oct 27 13:22:33.923049 kernel: CPU features: detected: Speculation barrier (SB) Oct 27 13:22:33.923055 kernel: CPU features: detected: TLB range maintenance instructions Oct 27 13:22:33.923060 kernel: CPU features: detected: Speculative Store Bypassing Safe (SSBS) Oct 27 13:22:33.923065 kernel: CPU features: detected: Scalable Vector Extension Oct 27 13:22:33.923070 kernel: alternatives: applying system-wide alternatives Oct 27 13:22:33.923075 kernel: CPU features: detected: Hardware dirty bit management on CPU0-1 Oct 27 13:22:33.923080 kernel: SVE: maximum available vector length 16 bytes per vector Oct 27 13:22:33.923085 kernel: SVE: default vector length 16 bytes per vector Oct 27 13:22:33.923091 kernel: Memory: 3976344K/4194160K available (12544K kernel code, 2482K rwdata, 9568K rodata, 13376K init, 1040K bss, 195864K reserved, 16384K cma-reserved) Oct 27 13:22:33.923097 kernel: devtmpfs: initialized Oct 27 13:22:33.923102 kernel: futex hash table entries: 512 (order: 3, 32768 bytes, linear) Oct 27 13:22:33.923107 kernel: 2G module region forced by RANDOMIZE_MODULE_REGION_FULL Oct 27 13:22:33.923112 kernel: 0 pages in range for non-PLT usage Oct 27 13:22:33.923117 kernel: 514480 pages in range for PLT usage Oct 27 13:22:33.923122 kernel: pinctrl core: initialized pinctrl subsystem Oct 27 13:22:33.923128 kernel: SMBIOS 3.1.0 present. Oct 27 13:22:33.923133 kernel: DMI: Microsoft Corporation Virtual Machine/Virtual Machine, BIOS Hyper-V UEFI Release v4.1 04/22/2026 Oct 27 13:22:33.923138 kernel: DMI: Memory slots populated: 2/2 Oct 27 13:22:33.923143 kernel: NET: Registered PF_NETLINK/PF_ROUTE protocol family Oct 27 13:22:33.923148 kernel: DMA: preallocated 512 KiB GFP_KERNEL pool for atomic allocations Oct 27 13:22:33.923153 kernel: DMA: preallocated 512 KiB GFP_KERNEL|GFP_DMA pool for atomic allocations Oct 27 13:22:33.923158 kernel: DMA: preallocated 512 KiB GFP_KERNEL|GFP_DMA32 pool for atomic allocations Oct 27 13:22:33.923164 kernel: audit: initializing netlink subsys (disabled) Oct 27 13:22:33.923169 kernel: audit: type=2000 audit(0.059:1): state=initialized audit_enabled=0 res=1 Oct 27 13:22:33.923174 kernel: thermal_sys: Registered thermal governor 'step_wise' Oct 27 13:22:33.923179 kernel: cpuidle: using governor menu Oct 27 13:22:33.923184 kernel: hw-breakpoint: found 6 breakpoint and 4 watchpoint registers. Oct 27 13:22:33.923189 kernel: ASID allocator initialised with 32768 entries Oct 27 13:22:33.923194 kernel: acpiphp: ACPI Hot Plug PCI Controller Driver version: 0.5 Oct 27 13:22:33.923200 kernel: Serial: AMBA PL011 UART driver Oct 27 13:22:33.923205 kernel: HugeTLB: registered 1.00 GiB page size, pre-allocated 0 pages Oct 27 13:22:33.923210 kernel: HugeTLB: 0 KiB vmemmap can be freed for a 1.00 GiB page Oct 27 13:22:33.923215 kernel: HugeTLB: registered 32.0 MiB page size, pre-allocated 0 pages Oct 27 13:22:33.923220 kernel: HugeTLB: 0 KiB vmemmap can be freed for a 32.0 MiB page Oct 27 13:22:33.923225 kernel: HugeTLB: registered 2.00 MiB page size, pre-allocated 0 pages Oct 27 13:22:33.923230 kernel: HugeTLB: 0 KiB vmemmap can be freed for a 2.00 MiB page Oct 27 13:22:33.923236 kernel: HugeTLB: registered 64.0 KiB page size, pre-allocated 0 pages Oct 27 13:22:33.923241 kernel: HugeTLB: 0 KiB vmemmap can be freed for a 64.0 KiB page Oct 27 13:22:33.923246 kernel: ACPI: Added _OSI(Module Device) Oct 27 13:22:33.923251 kernel: ACPI: Added _OSI(Processor Device) Oct 27 13:22:33.923256 kernel: ACPI: Added _OSI(Processor Aggregator Device) Oct 27 13:22:33.923261 kernel: ACPI: 1 ACPI AML tables successfully acquired and loaded Oct 27 13:22:33.923266 kernel: ACPI: Interpreter enabled Oct 27 13:22:33.923272 kernel: ACPI: Using GIC for interrupt routing Oct 27 13:22:33.923277 kernel: ARMH0011:00: ttyAMA0 at MMIO 0xeffec000 (irq = 12, base_baud = 0) is a SBSA Oct 27 13:22:33.923282 kernel: printk: legacy console [ttyAMA0] enabled Oct 27 13:22:33.923287 kernel: printk: legacy bootconsole [pl11] disabled Oct 27 13:22:33.923292 kernel: ARMH0011:01: ttyAMA1 at MMIO 0xeffeb000 (irq = 13, base_baud = 0) is a SBSA Oct 27 13:22:33.923297 kernel: ACPI: CPU0 has been hot-added Oct 27 13:22:33.923302 kernel: ACPI: CPU1 has been hot-added Oct 27 13:22:33.923307 kernel: iommu: Default domain type: Translated Oct 27 13:22:33.923313 kernel: iommu: DMA domain TLB invalidation policy: strict mode Oct 27 13:22:33.923318 kernel: efivars: Registered efivars operations Oct 27 13:22:33.923323 kernel: vgaarb: loaded Oct 27 13:22:33.923328 kernel: clocksource: Switched to clocksource arch_sys_counter Oct 27 13:22:33.923333 kernel: VFS: Disk quotas dquot_6.6.0 Oct 27 13:22:33.923338 kernel: VFS: Dquot-cache hash table entries: 512 (order 0, 4096 bytes) Oct 27 13:22:33.923343 kernel: pnp: PnP ACPI init Oct 27 13:22:33.923348 kernel: pnp: PnP ACPI: found 0 devices Oct 27 13:22:33.923353 kernel: NET: Registered PF_INET protocol family Oct 27 13:22:33.923358 kernel: IP idents hash table entries: 65536 (order: 7, 524288 bytes, linear) Oct 27 13:22:33.923364 kernel: tcp_listen_portaddr_hash hash table entries: 2048 (order: 3, 32768 bytes, linear) Oct 27 13:22:33.923369 kernel: Table-perturb hash table entries: 65536 (order: 6, 262144 bytes, linear) Oct 27 13:22:33.923374 kernel: TCP established hash table entries: 32768 (order: 6, 262144 bytes, linear) Oct 27 13:22:33.923379 kernel: TCP bind hash table entries: 32768 (order: 8, 1048576 bytes, linear) Oct 27 13:22:33.923385 kernel: TCP: Hash tables configured (established 32768 bind 32768) Oct 27 13:22:33.923390 kernel: UDP hash table entries: 2048 (order: 4, 65536 bytes, linear) Oct 27 13:22:33.923395 kernel: UDP-Lite hash table entries: 2048 (order: 4, 65536 bytes, linear) Oct 27 13:22:33.923400 kernel: NET: Registered PF_UNIX/PF_LOCAL protocol family Oct 27 13:22:33.923405 kernel: PCI: CLS 0 bytes, default 64 Oct 27 13:22:33.923410 kernel: kvm [1]: HYP mode not available Oct 27 13:22:33.923415 kernel: Initialise system trusted keyrings Oct 27 13:22:33.923421 kernel: workingset: timestamp_bits=39 max_order=20 bucket_order=0 Oct 27 13:22:33.923426 kernel: Key type asymmetric registered Oct 27 13:22:33.923431 kernel: Asymmetric key parser 'x509' registered Oct 27 13:22:33.923436 kernel: Block layer SCSI generic (bsg) driver version 0.4 loaded (major 249) Oct 27 13:22:33.923441 kernel: io scheduler mq-deadline registered Oct 27 13:22:33.923446 kernel: io scheduler kyber registered Oct 27 13:22:33.923451 kernel: io scheduler bfq registered Oct 27 13:22:33.923457 kernel: Serial: 8250/16550 driver, 4 ports, IRQ sharing enabled Oct 27 13:22:33.923462 kernel: ACPI: bus type drm_connector registered Oct 27 13:22:33.923467 kernel: thunder_xcv, ver 1.0 Oct 27 13:22:33.923472 kernel: thunder_bgx, ver 1.0 Oct 27 13:22:33.923476 kernel: nicpf, ver 1.0 Oct 27 13:22:33.923481 kernel: nicvf, ver 1.0 Oct 27 13:22:33.923666 kernel: rtc-efi rtc-efi.0: registered as rtc0 Oct 27 13:22:33.923756 kernel: rtc-efi rtc-efi.0: setting system clock to 2026-10-27T13:22:29 UTC (1793107349) Oct 27 13:22:33.923763 kernel: efifb: probing for efifb Oct 27 13:22:33.923768 kernel: efifb: framebuffer at 0x40000000, using 3072k, total 3072k Oct 27 13:22:33.923773 kernel: efifb: mode is 1024x768x32, linelength=4096, pages=1 Oct 27 13:22:33.923778 kernel: efifb: scrolling: redraw Oct 27 13:22:33.923783 kernel: efifb: Truecolor: size=8:8:8:8, shift=24:16:8:0 Oct 27 13:22:33.923788 kernel: Console: switching to colour frame buffer device 128x48 Oct 27 13:22:33.923794 kernel: fb0: EFI VGA frame buffer device Oct 27 13:22:33.923799 kernel: SMCCC: SOC_ID: ARCH_SOC_ID not implemented, skipping .... Oct 27 13:22:33.923804 kernel: hid: raw HID events driver (C) Jiri Kosina Oct 27 13:22:33.923809 kernel: hw perfevents: enabled with armv8_pmuv3_0 PMU driver, 7 (0,8000003f) counters available Oct 27 13:22:33.923814 kernel: watchdog: NMI not fully supported Oct 27 13:22:33.923819 kernel: NET: Registered PF_INET6 protocol family Oct 27 13:22:33.923824 kernel: watchdog: Hard watchdog permanently disabled Oct 27 13:22:33.923831 kernel: Segment Routing with IPv6 Oct 27 13:22:33.923836 kernel: In-situ OAM (IOAM) with IPv6 Oct 27 13:22:33.923841 kernel: NET: Registered PF_PACKET protocol family Oct 27 13:22:33.923846 kernel: Key type dns_resolver registered Oct 27 13:22:33.923851 kernel: registered taskstats version 1 Oct 27 13:22:33.923856 kernel: Loading compiled-in X.509 certificates Oct 27 13:22:33.923861 kernel: Loaded X.509 cert 'Kinvolk GmbH: Module signing key for 6.12.114-flatcar: ed62769400b81a0c6069a9a03a2299d9d4aef7c8' Oct 27 13:22:33.923867 kernel: Demotion targets for Node 0: null Oct 27 13:22:33.923872 kernel: Key type .fscrypt registered Oct 27 13:22:33.923877 kernel: Key type fscrypt-provisioning registered Oct 27 13:22:33.923881 kernel: integrity: secureboot mode disabled Oct 27 13:22:33.923886 kernel: ima: No TPM chip found, activating TPM-bypass! Oct 27 13:22:33.923891 kernel: ima: Allocated hash algorithm: sha1 Oct 27 13:22:33.923896 kernel: ima: No architecture policies found Oct 27 13:22:33.923902 kernel: alg: No test for fips(ansi_cprng) (fips_ansi_cprng) Oct 27 13:22:33.923907 kernel: clk: Disabling unused clocks Oct 27 13:22:33.923912 kernel: PM: genpd: Disabling unused power domains Oct 27 13:22:33.923917 kernel: Freeing unused kernel memory: 13376K Oct 27 13:22:33.923922 kernel: Run /init as init process Oct 27 13:22:33.923927 kernel: with arguments: Oct 27 13:22:33.923932 kernel: /init Oct 27 13:22:33.923937 kernel: with environment: Oct 27 13:22:33.923943 kernel: HOME=/ Oct 27 13:22:33.923948 kernel: TERM=linux Oct 27 13:22:33.923953 kernel: hv_vmbus: hv_mmio=[mem 0x40000000-0xfed3ffff],[mem 0xfc0000000-0xfffffffff] fb=[mem 0x40000000-0x47ffffff] Oct 27 13:22:33.923958 kernel: hv_vmbus: Vmbus version:5.3 Oct 27 13:22:33.923963 kernel: hv_vmbus: registering driver hid_hyperv Oct 27 13:22:33.923968 kernel: SCSI subsystem initialized Oct 27 13:22:33.923973 kernel: input: Microsoft Vmbus HID-compliant Mouse as /devices/0006:045E:0621.0001/input/input0 Oct 27 13:22:33.924071 kernel: hid-hyperv 0006:045E:0621.0001: input: VIRTUAL HID v0.01 Mouse [Microsoft Vmbus HID-compliant Mouse] on Oct 27 13:22:33.924079 kernel: hv_vmbus: registering driver hyperv_keyboard Oct 27 13:22:33.924084 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 Oct 27 13:22:33.924089 kernel: pps_core: LinuxPPS API ver. 1 registered Oct 27 13:22:33.924094 kernel: pps_core: Software ver. 5.3.6 - Copyright 2005-2007 Rodolfo Giometti Oct 27 13:22:33.924099 kernel: PTP clock support registered Oct 27 13:22:33.924106 kernel: hv_utils: Registering HyperV Utility Driver Oct 27 13:22:33.924111 kernel: hv_vmbus: registering driver hv_utils Oct 27 13:22:33.924116 kernel: hv_utils: Heartbeat IC version 3.0 Oct 27 13:22:33.924120 kernel: hv_utils: Shutdown IC version 3.2 Oct 27 13:22:33.924125 kernel: hv_utils: TimeSync IC version 4.0 Oct 27 13:22:33.924130 kernel: hv_vmbus: registering driver hv_storvsc Oct 27 13:22:33.924245 kernel: scsi host0: storvsc_host_t Oct 27 13:22:33.924348 kernel: scsi host1: storvsc_host_t Oct 27 13:22:33.924458 kernel: scsi 0:0:0:0: Direct-Access Msft Virtual Disk 1.0 PQ: 0 ANSI: 5 Oct 27 13:22:33.926672 kernel: scsi 0:0:0:2: CD-ROM Msft Virtual DVD-ROM 1.0 PQ: 0 ANSI: 5 Oct 27 13:22:33.926800 kernel: sd 0:0:0:0: [sda] 63737856 512-byte logical blocks: (32.6 GB/30.4 GiB) Oct 27 13:22:33.926904 kernel: sd 0:0:0:0: [sda] 4096-byte physical blocks Oct 27 13:22:33.927010 kernel: sd 0:0:0:0: [sda] Write Protect is off Oct 27 13:22:33.927109 kernel: sd 0:0:0:0: [sda] Mode Sense: 0f 00 10 00 Oct 27 13:22:33.927207 kernel: sd 0:0:0:0: [sda] Write cache: disabled, read cache: enabled, supports DPO and FUA Oct 27 13:22:33.927214 kernel: sda: sda1 sda2 sda3 sda4 sda6 sda7 sda9 Oct 27 13:22:33.927311 kernel: sd 0:0:0:0: [sda] Attached SCSI disk Oct 27 13:22:33.927411 kernel: sr 0:0:0:2: [sr0] scsi-1 drive Oct 27 13:22:33.927419 kernel: cdrom: Uniform CD-ROM driver Revision: 3.20 Oct 27 13:22:33.927517 kernel: sr 0:0:0:2: Attached scsi CD-ROM sr0 Oct 27 13:22:33.927538 kernel: device-mapper: core: CONFIG_IMA_DISABLE_HTABLE is disabled. Duplicate IMA measurements will not be recorded in the IMA log. Oct 27 13:22:33.927543 kernel: device-mapper: uevent: version 1.0.3 Oct 27 13:22:33.927549 kernel: device-mapper: ioctl: 4.48.0-ioctl (2023-03-01) initialised: dm-devel@lists.linux.dev Oct 27 13:22:33.927554 kernel: device-mapper: verity: sha256 using shash "sha256-ce" Oct 27 13:22:33.927559 kernel: raid6: neonx8 gen() 18591 MB/s Oct 27 13:22:33.927566 kernel: raid6: neonx4 gen() 18584 MB/s Oct 27 13:22:33.927571 kernel: raid6: neonx2 gen() 17040 MB/s Oct 27 13:22:33.927576 kernel: raid6: neonx1 gen() 15086 MB/s Oct 27 13:22:33.927581 kernel: raid6: int64x8 gen() 8878 MB/s Oct 27 13:22:33.927586 kernel: raid6: int64x4 gen() 10747 MB/s Oct 27 13:22:33.927591 kernel: raid6: int64x2 gen() 8828 MB/s Oct 27 13:22:33.927596 kernel: raid6: int64x1 gen() 7069 MB/s Oct 27 13:22:33.927602 kernel: raid6: using algorithm neonx8 gen() 18591 MB/s Oct 27 13:22:33.927607 kernel: raid6: .... xor() 15076 MB/s, rmw enabled Oct 27 13:22:33.927612 kernel: raid6: using neon recovery algorithm Oct 27 13:22:33.927617 kernel: xor: measuring software checksum speed Oct 27 13:22:33.927622 kernel: 8regs : 29470 MB/sec Oct 27 13:22:33.927627 kernel: 32regs : 29668 MB/sec Oct 27 13:22:33.927632 kernel: arm64_neon : 37023 MB/sec Oct 27 13:22:33.927637 kernel: xor: using function: arm64_neon (37023 MB/sec) Oct 27 13:22:33.927643 kernel: Btrfs loaded, zoned=no, fsverity=no Oct 27 13:22:33.927649 kernel: BTRFS: device fsid 3fcf614b-830c-406e-981b-5a3b77344914 devid 1 transid 40 /dev/mapper/usr (254:0) scanned by mount (385) Oct 27 13:22:33.927654 kernel: BTRFS info (device dm-0): first mount of filesystem 3fcf614b-830c-406e-981b-5a3b77344914 Oct 27 13:22:33.927659 kernel: BTRFS info (device dm-0): using crc32c (crc32c-generic) checksum algorithm Oct 27 13:22:33.927664 kernel: BTRFS info (device dm-0 state E): disabling log replay at mount time Oct 27 13:22:33.927669 kernel: BTRFS info (device dm-0 state E): enabling free space tree Oct 27 13:22:33.927674 kernel: loop: module loaded Oct 27 13:22:33.927680 kernel: loop0: detected capacity change from 0 to 100128 Oct 27 13:22:33.927685 kernel: squashfs: version 4.0 (2009/01/31) Phillip Lougher Oct 27 13:22:33.927692 systemd[1]: Successfully made /usr/ read-only. Oct 27 13:22:33.927700 systemd[1]: systemd 260.4 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) Oct 27 13:22:33.927705 systemd[1]: Detected virtualization microsoft. Oct 27 13:22:33.927712 systemd[1]: Detected architecture arm64. Oct 27 13:22:33.927717 systemd[1]: Running in initrd. Oct 27 13:22:33.927722 systemd[1]: Initializing machine ID from random generator. Oct 27 13:22:33.927728 systemd[1]: No hostname configured, using default hostname. Oct 27 13:22:33.927733 systemd[1]: Hostname set to . Oct 27 13:22:33.927738 systemd[1]: Queued start job for default target initrd.target. Oct 27 13:22:33.927744 systemd[1]: Started clevis-luks-askpass.path - Forward Password Requests to Clevis Directory Watch. Oct 27 13:22:33.927750 systemd[1]: Started systemd-ask-password-console.path - Dispatch Password Requests to Console Directory Watch. Oct 27 13:22:33.927756 systemd[1]: Expecting device dev-disk-by\x2dlabel-EFI\x2dSYSTEM.device - /dev/disk/by-label/EFI-SYSTEM... Oct 27 13:22:33.927762 systemd[1]: Expecting device dev-disk-by\x2dlabel-OEM.device - /dev/disk/by-label/OEM... Oct 27 13:22:33.927768 systemd[1]: Expecting device dev-disk-by\x2dlabel-ROOT.device - /dev/disk/by-label/ROOT... Oct 27 13:22:33.927774 systemd[1]: Expecting device dev-disk-by\x2dpartlabel-USR\x2dA.device - /dev/disk/by-partlabel/USR-A... Oct 27 13:22:33.927780 systemd[1]: Expecting device dev-mapper-usr.device - /dev/mapper/usr... Oct 27 13:22:33.927786 systemd[1]: Reached target cryptsetup-pre.target - Local Encrypted Volumes (Pre). Oct 27 13:22:33.927791 systemd[1]: Reached target cryptsetup.target - Local Encrypted Volumes. Oct 27 13:22:33.927797 systemd[1]: Reached target initrd-usr-fs.target - Initrd /usr File System. Oct 27 13:22:33.927802 systemd[1]: Reached target paths.target - Path Units. Oct 27 13:22:33.927807 systemd[1]: Reached target slices.target - Slice Units. Oct 27 13:22:33.927813 systemd[1]: Reached target swap.target - Swaps. Oct 27 13:22:33.927819 systemd[1]: Reached target timers.target - Timer Units. Oct 27 13:22:33.927830 systemd[1]: Listening on iscsid.socket - Open-iSCSI iscsid Socket. Oct 27 13:22:33.927836 systemd[1]: Listening on iscsiuio.socket - Open-iSCSI iscsiuio Socket. Oct 27 13:22:33.927842 systemd[1]: Listening on systemd-coredump.socket - Process Core Dump Socket. Oct 27 13:22:33.927847 systemd[1]: Listening on systemd-journald-audit.socket - Journal Audit Socket. Oct 27 13:22:33.927854 systemd[1]: Listening on systemd-journald-dev-log.socket - Journal Socket (/dev/log). Oct 27 13:22:33.927859 systemd[1]: Listening on systemd-journald.socket - Journal Sockets. Oct 27 13:22:33.927865 systemd[1]: Listening on systemd-networkd-resolve-hook.socket - Network Management Resolve Hook Socket. Oct 27 13:22:33.927871 systemd[1]: Listening on systemd-networkd.socket - Network Management Netlink Socket. Oct 27 13:22:33.927876 systemd[1]: Listening on systemd-udevd-control.socket - udev Control Socket. Oct 27 13:22:33.927882 systemd[1]: Listening on systemd-udevd-kernel.socket - udev Kernel Socket. Oct 27 13:22:33.927888 systemd[1]: Reached target sockets.target - Socket Units. Oct 27 13:22:33.927894 systemd[1]: afterburn-network-kargs.service - Afterburn Initrd Setup Network Kernel Arguments skipped, no trigger condition checks were met. Oct 27 13:22:33.927900 systemd[1]: Starting ignition-setup-pre.service - Ignition env setup... Oct 27 13:22:33.927905 systemd[1]: Starting kmod-static-nodes.service - Create List of Static Device Nodes... Oct 27 13:22:33.927911 systemd[1]: Finished network-cleanup.service - Network Cleanup. Oct 27 13:22:33.927917 systemd[1]: systemd-battery-check.service - Early Battery Level Check skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/class/power_supply Oct 27 13:22:33.927922 systemd[1]: Starting systemd-journald.service - Journal Service... Oct 27 13:22:33.927929 systemd[1]: Starting systemd-modules-load.service - Load Kernel Modules... Oct 27 13:22:33.927953 systemd-journald[497]: Collecting audit messages is enabled. Oct 27 13:22:33.927967 systemd[1]: Starting systemd-vconsole-setup.service - Virtual Console Setup... Oct 27 13:22:33.927975 systemd-journald[497]: Journal started Oct 27 13:22:33.927988 systemd-journald[497]: Runtime Journal (/run/log/journal/4df95970878d4a4ba6172db8b133e4d6) is 8M, max 78.3M, 70.3M free. Oct 27 13:22:33.931813 systemd-modules-load[499]: Using 2 probe threads Oct 27 13:22:33.959258 systemd[1]: Started systemd-journald.service - Journal Service. Oct 27 13:22:33.958000 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' Oct 27 13:22:33.959650 systemd[1]: Finished ignition-setup-pre.service - Ignition env setup. Oct 27 13:22:33.977000 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' Oct 27 13:22:33.989025 systemd[1]: Finished kmod-static-nodes.service - Create List of Static Device Nodes. Oct 27 13:22:34.005000 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' Oct 27 13:22:34.026440 kernel: audit: type=1130 audit(1793107353.958: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' Oct 27 13:22:34.008086 systemd[1]: Starting systemd-tmpfiles-setup-dev-early.service - Create Static Device Nodes in /dev gracefully... Oct 27 13:22:34.042115 kernel: audit: type=1130 audit(1793107353.977: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' Oct 27 13:22:34.042137 kernel: audit: type=1130 audit(1793107354.005: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' Oct 27 13:22:34.042145 kernel: bridge: filtering via arp/ip/ip6tables is no longer available by default. Update your scripts to load br_netfilter if you need this. Oct 27 13:22:34.043164 systemd[1]: Starting systemd-tmpfiles-setup.service - Create System Files and Directories... Oct 27 13:22:34.060704 systemd-modules-load[499]: Inserted module 'br_netfilter' Oct 27 13:22:34.061763 systemd[1]: Finished systemd-modules-load.service - Load Kernel Modules. Oct 27 13:22:34.079095 kernel: Bridge firewalling registered Oct 27 13:22:34.070000 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' Oct 27 13:22:34.075717 systemd[1]: Starting systemd-sysctl.service - Apply Kernel Variables... Oct 27 13:22:34.105060 systemd-tmpfiles[507]: /usr/lib/tmpfiles.d/systemd.conf:30: Duplicate line for path "/var/lib/systemd", ignoring. Oct 27 13:22:34.113958 kernel: audit: type=1130 audit(1793107354.070:5): 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' Oct 27 13:22:34.105104 systemd-tmpfiles[507]: /usr/lib/tmpfiles.d/var.conf:14: Duplicate line for path "/var/log", ignoring. Oct 27 13:22:34.110194 systemd-vconsole-setup[500]: Configuration of first virtual console was skipped, ignoring remaining ones. Oct 27 13:22:34.126000 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' Oct 27 13:22:34.112950 systemd[1]: Finished systemd-tmpfiles-setup-dev-early.service - Create Static Device Nodes in /dev gracefully. Oct 27 13:22:34.154897 kernel: audit: type=1130 audit(1793107354.126: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' Oct 27 13:22:34.155015 systemd[1]: Finished systemd-vconsole-setup.service - Virtual Console Setup. Oct 27 13:22:34.165000 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' Oct 27 13:22:34.170622 systemd[1]: Finished systemd-tmpfiles-setup.service - Create System Files and Directories. Oct 27 13:22:34.189838 systemd[1]: systemd-sysctl.service: Deactivated successfully. Oct 27 13:22:34.189000 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' Oct 27 13:22:34.206000 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' Oct 27 13:22:34.222531 kernel: audit: type=1130 audit(1793107354.165:7): 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' Oct 27 13:22:34.189938 systemd[1]: Finished systemd-sysctl.service - Apply Kernel Variables. Oct 27 13:22:34.206000 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' Oct 27 13:22:34.242012 kernel: audit: type=1130 audit(1793107354.189: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' Oct 27 13:22:34.224918 systemd[1]: Starting dracut-cmdline-ask.service - dracut ask for additional cmdline parameters... Oct 27 13:22:34.253149 kernel: audit: type=1130 audit(1793107354.206:9): 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' Oct 27 13:22:34.253166 kernel: audit: type=1131 audit(1793107354.206: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' Oct 27 13:22:34.252000 audit: BPF prog-id=5 op=LOAD Oct 27 13:22:34.257547 kernel: audit: type=1334 audit(1793107354.252:11): prog-id=5 op=LOAD Oct 27 13:22:34.261109 systemd[1]: Starting systemd-resolved.service - Network Name Resolution... Oct 27 13:22:34.269087 systemd[1]: Starting systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev... Oct 27 13:22:34.293973 systemd[1]: Finished systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev. Oct 27 13:22:34.307000 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' Oct 27 13:22:34.317575 systemd[1]: Finished dracut-cmdline-ask.service - dracut ask for additional cmdline parameters. Oct 27 13:22:34.323000 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' Oct 27 13:22:34.329704 systemd[1]: Starting dracut-cmdline.service - dracut cmdline hook... Oct 27 13:22:34.394995 systemd-resolved[516]: Positive Trust Anchors: Oct 27 13:22:34.395006 systemd-resolved[516]: . IN DS 20326 8 2 e06d44b80b8f1d39a95c0b0d7c65d08458e880409bbc683457104237c7f8ec8d Oct 27 13:22:34.413732 dracut-cmdline[529]: dracut-110 Oct 27 13:22:34.413732 dracut-cmdline[529]: Using kernel command line parameters: SYSTEMD_SULOGIN_FORCE=1 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=ttyAMA0,115200n8 earlycon=pl011,0xeffec000 flatcar.first_boot=detected acpi=force flatcar.oem.id=azure flatcar.autologin verity.usrhash=6ae5c5ebc899cb7e26ff0cf052d73929ebb0340d53d537c96a4957eafa5184f4 Oct 27 13:22:34.395008 systemd-resolved[516]: . IN DS 38696 8 2 683d2d0acb8c9b712a1948b27f741219298d0a450d612c483af444a4c0fb2b16 Oct 27 13:22:34.395027 systemd-resolved[516]: 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 Oct 27 13:22:34.511939 systemd-resolved[516]: Defaulting to hostname 'linux'. Oct 27 13:22:34.512912 systemd[1]: Started systemd-resolved.service - Network Name Resolution. Oct 27 13:22:34.520000 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' Oct 27 13:22:34.521204 systemd[1]: Reached target nss-lookup.target - Host and Network Name Lookups. Oct 27 13:22:34.620551 kernel: Loading iSCSI transport class v2.0-870. Oct 27 13:22:34.684535 kernel: iscsi: registered transport (tcp) Oct 27 13:22:34.727463 kernel: iscsi: registered transport (qla4xxx) Oct 27 13:22:34.727510 kernel: QLogic iSCSI HBA Driver Oct 27 13:22:34.767793 systemd[1]: Starting systemd-network-generator.service - Generate Network Units from Kernel Command Line... Oct 27 13:22:34.791603 systemd[1]: Finished systemd-network-generator.service - Generate Network Units from Kernel Command Line. Oct 27 13:22:34.796000 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' Oct 27 13:22:34.797277 systemd[1]: Reached target network-pre.target - Preparation for Network. Oct 27 13:22:34.878462 systemd[1]: Finished dracut-cmdline.service - dracut cmdline hook. Oct 27 13:22:34.883000 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' Oct 27 13:22:34.885211 systemd[1]: Starting dracut-pre-udev.service - dracut pre-udev hook... Oct 27 13:22:34.902995 systemd[1]: Starting parse-ip-for-networkd.service - Write systemd-networkd units from cmdline... Oct 27 13:22:34.935396 systemd[1]: Finished dracut-pre-udev.service - dracut pre-udev hook. Oct 27 13:22:34.939000 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' Oct 27 13:22:34.944000 audit: BPF prog-id=6 op=LOAD Oct 27 13:22:34.944000 audit: BPF prog-id=7 op=LOAD Oct 27 13:22:34.945704 systemd[1]: Starting systemd-udevd.service - Rule-based Manager for Device Events and Files... Oct 27 13:22:35.029738 systemd[1]: Finished parse-ip-for-networkd.service - Write systemd-networkd units from cmdline. Oct 27 13:22:35.035000 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' Oct 27 13:22:35.068278 systemd-udevd[751]: Using default interface naming scheme 'v260'. Oct 27 13:22:35.120741 systemd[1]: Started systemd-udevd.service - Rule-based Manager for Device Events and Files. Oct 27 13:22:35.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' Oct 27 13:22:35.130150 systemd[1]: Starting dracut-pre-trigger.service - dracut pre-trigger hook... Oct 27 13:22:35.152000 audit: BPF prog-id=8 op=LOAD Oct 27 13:22:35.153557 systemd[1]: Starting systemd-networkd.service - Network Management... Oct 27 13:22:35.172858 dracut-pre-trigger[879]: rd.md=0: removing MD RAID activation Oct 27 13:22:35.196948 systemd-networkd[880]: Failed to open nftables netlink socket. IPMasquerade= and NFTSet= settings will not be applied. Ignoring: Protocol not supported Oct 27 13:22:35.211836 systemd-networkd[880]: lo: Link UP Oct 27 13:22:35.211843 systemd-networkd[880]: lo: Gained carrier Oct 27 13:22:35.219000 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' Oct 27 13:22:35.213664 systemd[1]: Started systemd-networkd.service - Network Management. Oct 27 13:22:35.229000 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' Oct 27 13:22:35.220610 systemd[1]: Finished dracut-pre-trigger.service - dracut pre-trigger hook. Oct 27 13:22:35.230340 systemd[1]: Reached target network.target - Network. Oct 27 13:22:35.239438 systemd[1]: Starting systemd-udev-trigger.service - Coldplug All udev Devices... Oct 27 13:22:35.324224 systemd[1]: Finished systemd-udev-trigger.service - Coldplug All udev Devices. Oct 27 13:22:35.329000 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' Oct 27 13:22:35.336689 systemd[1]: Starting dracut-initqueue.service - dracut initqueue hook... Oct 27 13:22:35.453565 kernel: hv_storvsc f8b3781a-1e82-4818-a1c3-63d806ec15bb: tag#261 cmd 0x85 status: scsi 0x2 srb 0x6 hv 0xc0000001 Oct 27 13:22:35.464208 systemd[1]: systemd-vconsole-setup.service: Deactivated successfully. Oct 27 13:22:35.469720 systemd[1]: Stopped systemd-vconsole-setup.service - Virtual Console Setup. Oct 27 13:22:35.480000 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' Oct 27 13:22:35.487724 kernel: hv_vmbus: registering driver hv_netvsc Oct 27 13:22:35.481610 systemd[1]: Stopping systemd-vconsole-setup.service - Virtual Console Setup... Oct 27 13:22:35.493245 systemd[1]: Starting systemd-vconsole-setup.service - Virtual Console Setup... Oct 27 13:22:35.536339 systemd[1]: systemd-vconsole-setup.service: Deactivated successfully. Oct 27 13:22:35.538118 systemd[1]: Stopped systemd-vconsole-setup.service - Virtual Console Setup. Oct 27 13:22:35.545000 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' Oct 27 13:22:35.545000 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' Oct 27 13:22:35.555301 systemd[1]: Starting systemd-vconsole-setup.service - Virtual Console Setup... Oct 27 13:22:35.578053 systemd-vconsole-setup[961]: Configuration of first virtual console was skipped, ignoring remaining ones. Oct 27 13:22:35.589535 kernel: hv_netvsc 0022487c-b89d-0022-487c-b89d0022487c eth0: VF slot 1 added Oct 27 13:22:35.591971 systemd[1]: Finished systemd-vconsole-setup.service - Virtual Console Setup. Oct 27 13:22:35.599000 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' Oct 27 13:22:35.602755 systemd-networkd[880]: eth0: Found matching .network file, based on potentially unpredictable interface name: /usr/lib/systemd/network/zz-default.network Oct 27 13:22:35.602758 systemd-networkd[880]: eth0: Configuring with /usr/lib/systemd/network/zz-default.network. Oct 27 13:22:35.605009 systemd-networkd[880]: eth0: Link UP Oct 27 13:22:35.605110 systemd-networkd[880]: eth0: Gained carrier Oct 27 13:22:35.605120 systemd-networkd[880]: eth0: Found matching .network file, based on potentially unpredictable interface name: /usr/lib/systemd/network/zz-default.network Oct 27 13:22:35.639563 systemd-networkd[880]: eth0: DHCPv4 address 10.0.0.12/24, gateway 10.0.0.1 acquired from 168.63.129.16 Oct 27 13:22:35.749142 kernel: hv_vmbus: registering driver hv_pci Oct 27 13:22:35.749212 kernel: hv_pci 272f750f-acab-4ecd-b65c-c099ba4d2623: PCI VMBus probing: Using version 0x10004 Oct 27 13:22:35.759999 kernel: hv_pci 272f750f-acab-4ecd-b65c-c099ba4d2623: PCI host bridge to bus acab:00 Oct 27 13:22:35.760212 kernel: pci_bus acab:00: root bus resource [mem 0xfc0000000-0xfc00fffff window] Oct 27 13:22:35.760713 kernel: pci_bus acab:00: No busn resource found for root bus, will use [bus 00-ff] Oct 27 13:22:35.773006 kernel: pci acab:00:02.0: [15b3:101a] type 00 class 0x020000 PCIe Endpoint Oct 27 13:22:35.779566 kernel: pci acab:00:02.0: BAR 0 [mem 0xfc0000000-0xfc00fffff 64bit pref] Oct 27 13:22:35.784672 kernel: pci acab:00:02.0: enabling Extended Tags Oct 27 13:22:35.801804 kernel: pci acab:00:02.0: 0.000 Gb/s available PCIe bandwidth, limited by Unknown x0 link at acab:00:02.0 (capable of 252.048 Gb/s with 16.0 GT/s PCIe x16 link) Oct 27 13:22:35.812684 kernel: pci_bus acab:00: busn_res: [bus 00-ff] end is updated to 00 Oct 27 13:22:35.812875 kernel: pci acab:00:02.0: BAR 0 [mem 0xfc0000000-0xfc00fffff 64bit pref]: assigned Oct 27 13:22:35.981373 systemd[1]: Found device dev-disk-by\x2dpartlabel-USR\x2dA.device - Virtual_Disk USR-A. Oct 27 13:22:35.995439 systemd[1]: Starting disk-uuid.service - Generate new UUID for disk GPT if necessary... Oct 27 13:22:36.015487 kernel: mlx5_core acab:00:02.0: enabling device (0000 -> 0002) Oct 27 13:22:36.028177 kernel: mlx5_core acab:00:02.0: PTM is not supported by PCIe Oct 27 13:22:36.028436 kernel: mlx5_core acab:00:02.0: firmware version: 16.30.5026 Oct 27 13:22:36.182295 systemd[1]: Found device dev-disk-by\x2dlabel-ROOT.device - Virtual_Disk ROOT. Oct 27 13:22:36.206327 systemd[1]: Found device dev-disk-by\x2dlabel-EFI\x2dSYSTEM.device - Virtual_Disk EFI-SYSTEM. Oct 27 13:22:36.240211 systemd[1]: Found device dev-disk-by\x2dlabel-OEM.device - Virtual_Disk OEM. Oct 27 13:22:36.270797 kernel: hv_netvsc 0022487c-b89d-0022-487c-b89d0022487c eth0: VF registering: eth1 Oct 27 13:22:36.270992 kernel: mlx5_core acab:00:02.0 eth1: joined to eth0 Oct 27 13:22:36.271124 kernel: mlx5_core acab:00:02.0: MLX5E: StrdRq(1) RqSz(8) StrdSz(2048) RxCqeCmprss(0 basic) Oct 27 13:22:36.287543 kernel: mlx5_core acab:00:02.0 enP44203s1: renamed from eth1 Oct 27 13:22:36.288656 systemd-networkd[880]: eth1: Interface name change detected, renamed to enP44203s1. Oct 27 13:22:36.295768 systemd[1]: Mounting oem.mount - /oem... Oct 27 13:22:36.348842 kernel: BTRFS: device label OEM devid 1 transid 11 /dev/sda6 (8:6) scanned by mount (1040) Oct 27 13:22:36.348891 kernel: BTRFS info (device sda6): first mount of filesystem ea5ddb56-40f5-4347-9802-55b0b42a8eb7 Oct 27 13:22:36.355266 kernel: BTRFS info (device sda6): using crc32c (crc32c-generic) checksum algorithm Oct 27 13:22:36.410000 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' Oct 27 13:22:36.400489 systemd[1]: Finished dracut-initqueue.service - dracut initqueue hook. Oct 27 13:22:36.415989 kernel: mlx5_core acab:00:02.0 enP44203s1: Link up Oct 27 13:22:36.412162 systemd[1]: Reached target remote-fs-pre.target - Preparation for Remote File Systems. Oct 27 13:22:36.431723 kernel: BTRFS info (device sda6): turning on async discard Oct 27 13:22:36.421295 systemd[1]: Reached target remote-cryptsetup.target - Remote Encrypted Volumes. Oct 27 13:22:36.446921 kernel: BTRFS info (device sda6): enabling free space tree Oct 27 13:22:36.426878 systemd[1]: Reached target remote-fs.target - Remote File Systems. Oct 27 13:22:36.456259 kernel: hv_netvsc 0022487c-b89d-0022-487c-b89d0022487c eth0: Data path switched to VF: enP44203s1 Oct 27 13:22:36.446472 systemd-networkd[880]: enP44203s1: Link UP Oct 27 13:22:36.446933 systemd[1]: Starting dracut-pre-mount.service - dracut pre-mount hook... Oct 27 13:22:36.452307 systemd[1]: Mounted oem.mount - /oem. Oct 27 13:22:36.471120 systemd[1]: Starting ignition-fetch-offline.service - Ignition (fetch-offline)... Oct 27 13:22:36.490596 systemd[1]: Finished dracut-pre-mount.service - dracut pre-mount hook. Oct 27 13:22:36.495000 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' Oct 27 13:22:36.608688 systemd-networkd[880]: enP44203s1: Gained carrier Oct 27 13:22:37.056649 systemd-networkd[880]: eth0: Gained IPv6LL Oct 27 13:22:37.272051 disk-uuid[994]: Warning: The kernel is still using the old partition table. Oct 27 13:22:37.272051 disk-uuid[994]: The new table will be used at the next reboot or after you Oct 27 13:22:37.272051 disk-uuid[994]: run partprobe(8) or kpartx(8) Oct 27 13:22:37.272051 disk-uuid[994]: The operation has completed successfully. Oct 27 13:22:37.288274 systemd[1]: disk-uuid.service: Deactivated successfully. Oct 27 13:22:37.288637 systemd[1]: Finished disk-uuid.service - Generate new UUID for disk GPT if necessary. Oct 27 13:22:37.296000 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' Oct 27 13:22:37.296000 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' Oct 27 13:22:37.298275 systemd[1]: Mounting boot.mount - Boot partition... Oct 27 13:22:37.369035 systemd[1]: Mounted boot.mount - Boot partition. Oct 27 13:22:37.803681 ignition[1108]: Ignition 2.24.0 Oct 27 13:22:37.803691 ignition[1108]: Stage: fetch-offline Oct 27 13:22:37.806673 ignition[1108]: no config dir at "/usr/lib/ignition/base.d" Oct 27 13:22:37.810714 systemd[1]: Finished ignition-fetch-offline.service - Ignition (fetch-offline). Oct 27 13:22:37.818000 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' Oct 27 13:22:37.806684 ignition[1108]: no config dir at "/usr/lib/ignition/base.platform.d/azure" Oct 27 13:22:37.820477 systemd[1]: Starting ignition-fetch.service - Ignition (fetch)... Oct 27 13:22:37.806776 ignition[1108]: parsed url from cmdline: "" Oct 27 13:22:37.806778 ignition[1108]: no config URL provided Oct 27 13:22:37.806781 ignition[1108]: reading system config file "/usr/lib/ignition/user.ign" Oct 27 13:22:37.806798 ignition[1108]: no config at "/usr/lib/ignition/user.ign" Oct 27 13:22:37.806802 ignition[1108]: failed to fetch config: resource requires networking Oct 27 13:22:37.807081 ignition[1108]: Ignition finished successfully Oct 27 13:22:37.853652 ignition[1131]: Ignition 2.24.0 Oct 27 13:22:37.853657 ignition[1131]: Stage: fetch Oct 27 13:22:37.853818 ignition[1131]: no config dir at "/usr/lib/ignition/base.d" Oct 27 13:22:37.853825 ignition[1131]: no config dir at "/usr/lib/ignition/base.platform.d/azure" Oct 27 13:22:37.853880 ignition[1131]: parsed url from cmdline: "" Oct 27 13:22:37.853883 ignition[1131]: no config URL provided Oct 27 13:22:37.853886 ignition[1131]: reading system config file "/usr/lib/ignition/user.ign" Oct 27 13:22:37.853894 ignition[1131]: no config at "/usr/lib/ignition/user.ign" Oct 27 13:22:37.853907 ignition[1131]: GET http://169.254.169.254/metadata/instance/compute/userData?api-version=2021-01-01&format=text: attempt #1 Oct 27 13:22:37.923113 ignition[1131]: GET result: OK Oct 27 13:22:37.923183 ignition[1131]: config has been read from IMDS userdata Oct 27 13:22:37.923189 ignition[1131]: parsing config with SHA512: 2dad6162081ed17ea2b702dba87ea8c8786966ecb07617a435a0b2a1ab41f7836e0c00616881e7207a9c7ee6d0e7644294ea7ee31adf4e3cf783e9d4833278fb Oct 27 13:22:37.930781 unknown[1131]: fetched base config from "system" Oct 27 13:22:37.930897 ignition[1131]: fetch: fetch complete Oct 27 13:22:37.930788 unknown[1131]: fetched base config from "system" Oct 27 13:22:37.940000 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' Oct 27 13:22:37.930900 ignition[1131]: fetch: fetch passed Oct 27 13:22:37.930792 unknown[1131]: fetched user config from "azure" Oct 27 13:22:37.930936 ignition[1131]: Ignition finished successfully Oct 27 13:22:37.933159 systemd[1]: Finished ignition-fetch.service - Ignition (fetch). Oct 27 13:22:37.942472 systemd[1]: Starting ignition-kargs.service - Ignition (kargs)... Oct 27 13:22:37.973969 ignition[1137]: Ignition 2.24.0 Oct 27 13:22:37.973987 ignition[1137]: Stage: kargs Oct 27 13:22:37.978862 systemd[1]: Finished ignition-kargs.service - Ignition (kargs). Oct 27 13:22:37.983000 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' Oct 27 13:22:37.974160 ignition[1137]: no config dir at "/usr/lib/ignition/base.d" Oct 27 13:22:37.985647 systemd[1]: Starting ignition-disks.service - Ignition (disks)... Oct 27 13:22:37.974166 ignition[1137]: no config dir at "/usr/lib/ignition/base.platform.d/azure" Oct 27 13:22:37.974469 ignition[1137]: kargs: kargs passed Oct 27 13:22:37.974505 ignition[1137]: Ignition finished successfully Oct 27 13:22:38.039415 systemd[1]: ignition-kargs.service: Deactivated successfully. Oct 27 13:22:38.039551 systemd[1]: Stopped ignition-kargs.service - Ignition (kargs). Oct 27 13:22:38.047000 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' Oct 27 13:22:38.048241 systemd[1]: ignition-fetch.service: Deactivated successfully. Oct 27 13:22:38.056000 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' Oct 27 13:22:38.048359 systemd[1]: Stopped ignition-fetch.service - Ignition (fetch). Oct 27 13:22:38.064000 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' Oct 27 13:22:38.056651 systemd[1]: ignition-fetch-offline.service: Deactivated successfully. Oct 27 13:22:38.056767 systemd[1]: Stopped ignition-fetch-offline.service - Ignition (fetch-offline). Oct 27 13:22:38.067634 systemd[1]: Unmounting oem.mount - /oem... Oct 27 13:22:38.094606 kernel: BTRFS info (device sda6): last unmount of filesystem ea5ddb56-40f5-4347-9802-55b0b42a8eb7 Oct 27 13:22:38.095086 systemd[1]: oem.mount: Deactivated successfully. Oct 27 13:22:38.095242 systemd[1]: Unmounted oem.mount - /oem. Oct 27 13:22:38.121238 ignition[1148]: Ignition 2.24.0 Oct 27 13:22:38.121256 ignition[1148]: Stage: disks Oct 27 13:22:38.121427 ignition[1148]: no config dir at "/usr/lib/ignition/base.d" Oct 27 13:22:38.126799 systemd[1]: Finished ignition-disks.service - Ignition (disks). Oct 27 13:22:38.136000 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' Oct 27 13:22:38.121434 ignition[1148]: no config dir at "/usr/lib/ignition/base.platform.d/azure" Oct 27 13:22:38.137314 systemd[1]: Reached target initrd-root-device.target - Initrd Root Device. Oct 27 13:22:38.121763 ignition[1148]: disks: disks passed Oct 27 13:22:38.147121 systemd[1]: Reached target local-fs-pre.target - Preparation for Local File Systems. Oct 27 13:22:38.121807 ignition[1148]: Ignition finished successfully Oct 27 13:22:38.156908 systemd[1]: Reached target local-fs.target - Local File Systems. Oct 27 13:22:38.165859 systemd[1]: Reached target sysinit.target - System Initialization. Oct 27 13:22:38.172913 systemd[1]: Reached target basic.target - Basic System. Oct 27 13:22:38.182503 systemd[1]: Starting systemd-fsck-root.service - File System Check on /dev/disk/by-label/ROOT... Oct 27 13:22:38.365787 systemd-fsck[1156]: ROOT: clean, 15/6361680 files, 408771/6359552 blocks Oct 27 13:22:38.377085 systemd[1]: Finished systemd-fsck-root.service - File System Check on /dev/disk/by-label/ROOT. Oct 27 13:22:38.383000 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' Oct 27 13:22:38.387225 systemd[1]: Mounting sysroot.mount - /sysroot... Oct 27 13:22:38.757541 kernel: EXT4-fs (sda9): mounted filesystem 0413b0b8-736c-49c2-898c-b9e89574e8c7 r/w with ordered data mode. Quota mode: none. Oct 27 13:22:38.758269 systemd[1]: Mounted sysroot.mount - /sysroot. Oct 27 13:22:38.766309 systemd[1]: Reached target initrd-root-fs.target - Initrd Root File System. Oct 27 13:22:38.790976 systemd[1]: Mounting sysroot-usr.mount - /sysroot/usr... Oct 27 13:22:38.806690 systemd[1]: Starting flatcar-metadata-hostname.service - Flatcar Metadata Hostname Agent... Oct 27 13:22:38.818327 systemd[1]: ignition-remount-sysroot.service - Remount /sysroot read-write for Ignition skipped, unmet condition check ConditionPathIsReadWrite=!/sysroot Oct 27 13:22:38.818367 systemd[1]: Reached target ignition-diskful.target - Ignition Boot Disk Setup. Oct 27 13:22:38.825467 systemd[1]: Mounted sysroot-usr.mount - /sysroot/usr. Oct 27 13:22:38.847710 systemd[1]: Starting initrd-setup-root.service - Root filesystem setup... Oct 27 13:22:39.291302 systemd-tmpfiles[1190]: /sysroot/usr/lib/tmpfiles.d/base_image_var.conf:1: Duplicate line for path "/sysroot/var", ignoring. Oct 27 13:22:39.291329 systemd-tmpfiles[1190]: /sysroot/usr/lib/tmpfiles.d/base_image_var.conf:7: Duplicate line for path "/sysroot/var/empty", ignoring. Oct 27 13:22:39.291388 systemd-tmpfiles[1190]: /sysroot/usr/lib/tmpfiles.d/base_image_var.conf:28: Duplicate line for path "/sysroot/var/log", ignoring. Oct 27 13:22:39.462370 coreos-metadata[1171]: Oct 27 13:22:39.462 INFO Fetching http://168.63.129.16/?comp=versions: Attempt #1 Oct 27 13:22:39.469828 coreos-metadata[1171]: Oct 27 13:22:39.469 INFO Fetch successful Oct 27 13:22:39.474325 coreos-metadata[1171]: Oct 27 13:22:39.473 INFO Fetching http://169.254.169.254/metadata/instance/compute/name?api-version=2017-08-01&format=text: Attempt #1 Oct 27 13:22:39.487916 coreos-metadata[1171]: Oct 27 13:22:39.487 INFO Fetch successful Oct 27 13:22:39.520624 coreos-metadata[1171]: Oct 27 13:22:39.520 INFO wrote hostname ci-4757.2.3-a-3f79c203c6 to /sysroot/etc/hostname Oct 27 13:22:39.527722 systemd[1]: Finished flatcar-metadata-hostname.service - Flatcar Metadata Hostname Agent. Oct 27 13:22:39.532000 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' Oct 27 13:22:39.542101 kernel: kauditd_printk_skb: 30 callbacks suppressed Oct 27 13:22:39.542121 kernel: audit: type=1130 audit(1793107359.532:42): 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' Oct 27 13:22:40.520656 kernel: loop1: detected capacity change from 0 to 44328 Oct 27 13:22:40.554544 kernel: loop1: p1 p2 p3 Oct 27 13:22:41.199370 kernel: device-mapper: verity: sha256 using shash "sha256-ce" Oct 27 13:22:41.199433 kernel: device-mapper: verity: Unrecognized verity feature request: root_hash_sig_key_desc Oct 27 13:22:41.204314 kernel: device-mapper: table: 254:1: verity: Unrecognized verity feature request (-EINVAL) Oct 27 13:22:41.207799 kernel: device-mapper: ioctl: error adding target to table Oct 27 13:22:41.208020 systemd-confext[1252]: device-mapper: reload ioctl on loop1p1-14-verity (254:1) failed: Invalid argument Oct 27 13:22:41.235551 kernel: device-mapper: verity: sha256 using shash "sha256-ce" Oct 27 13:22:41.346842 kernel: erofs: (device dm-1): mounted with root inode @ nid 40. Oct 27 13:22:41.370546 kernel: loop2: detected capacity change from 0 to 44328 Oct 27 13:22:41.378541 kernel: loop2: p1 p2 p3 Oct 27 13:22:41.390165 kernel: device-mapper: verity: sha256 using shash "sha256-ce" Oct 27 13:22:41.390206 kernel: device-mapper: verity: Unrecognized verity feature request: root_hash_sig_key_desc Oct 27 13:22:41.394960 kernel: device-mapper: table: 254:1: verity: Unrecognized verity feature request (-EINVAL) Oct 27 13:22:41.398454 kernel: device-mapper: ioctl: error adding target to table Oct 27 13:22:41.398369 (sd-merge)[1262]: device-mapper: reload ioctl on loop2p1-18-verity (254:1) failed: Invalid argument Oct 27 13:22:41.413543 kernel: device-mapper: verity: sha256 using shash "sha256-ce" Oct 27 13:22:41.427951 (sd-merge)[1262]: Using extensions '00-flatcar-default.raw'. Oct 27 13:22:41.433128 kernel: erofs: (device dm-1): mounted with root inode @ nid 40. Oct 27 13:22:41.428715 (sd-merge)[1262]: Merged extensions into '/sysroot/etc'. Oct 27 13:22:41.438475 initrd-setup-root[1270]: /etc 00-flatcar-default Tue 2026-10-27 13:22:34 UTC Oct 27 13:22:41.441803 systemd[1]: Finished initrd-setup-root.service - Root filesystem setup. Oct 27 13:22:41.446000 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' Oct 27 13:22:41.463561 kernel: audit: type=1130 audit(1793107361.446:43): 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' Oct 27 13:22:41.464636 systemd[1]: Starting ignition-mount.service - Ignition (mount)... Oct 27 13:22:41.509384 ignition[1274]: INFO : Ignition 2.24.0 Oct 27 13:22:41.509384 ignition[1274]: INFO : Stage: mount Oct 27 13:22:41.515846 ignition[1274]: INFO : no config dir at "/usr/lib/ignition/base.d" Oct 27 13:22:41.515846 ignition[1274]: INFO : no config dir at "/usr/lib/ignition/base.platform.d/azure" Oct 27 13:22:41.515846 ignition[1274]: INFO : mount: mount passed Oct 27 13:22:41.515846 ignition[1274]: INFO : Ignition finished successfully Oct 27 13:22:41.519000 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' Oct 27 13:22:41.514857 systemd[1]: Finished ignition-mount.service - Ignition (mount). Oct 27 13:22:41.555767 kernel: audit: type=1130 audit(1793107361.519: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' Oct 27 13:22:41.540276 systemd[1]: Starting ignition-files.service - Ignition (files)... Oct 27 13:22:41.562145 systemd[1]: Mounting oem.mount - /oem... Oct 27 13:22:41.584025 kernel: BTRFS: device label OEM devid 1 transid 11 /dev/sda6 (8:6) scanned by mount (1282) Oct 27 13:22:41.594319 kernel: BTRFS info (device sda6): first mount of filesystem ea5ddb56-40f5-4347-9802-55b0b42a8eb7 Oct 27 13:22:41.594372 kernel: BTRFS info (device sda6): using crc32c (crc32c-generic) checksum algorithm Oct 27 13:22:41.608725 kernel: BTRFS info (device sda6): turning on async discard Oct 27 13:22:41.608784 kernel: BTRFS info (device sda6): enabling free space tree Oct 27 13:22:41.610708 systemd[1]: Mounted oem.mount - /oem. Oct 27 13:22:41.617075 systemd[1]: Mounting sysroot-oem.mount - /sysroot/oem... Oct 27 13:22:41.637455 systemd[1]: Mounted sysroot-oem.mount - /sysroot/oem. Oct 27 13:22:41.665061 ignition[1300]: INFO : Ignition 2.24.0 Oct 27 13:22:41.665061 ignition[1300]: INFO : Stage: files Oct 27 13:22:41.665061 ignition[1300]: INFO : no config dir at "/usr/lib/ignition/base.d" Oct 27 13:22:41.665061 ignition[1300]: INFO : no config dir at "/usr/lib/ignition/base.platform.d/azure" Oct 27 13:22:41.681408 ignition[1300]: DEBUG : files: compiled without relabeling support, skipping Oct 27 13:22:41.681408 ignition[1300]: INFO : files: ensureUsers: op(1): [started] creating or modifying user "core" Oct 27 13:22:41.681408 ignition[1300]: DEBUG : files: ensureUsers: op(1): executing: "usermod" "--root" "/sysroot" "core" Oct 27 13:22:41.698511 ignition[1300]: INFO : files: ensureUsers: op(1): [finished] creating or modifying user "core" Oct 27 13:22:41.698511 ignition[1300]: INFO : files: ensureUsers: op(2): [started] adding ssh keys to user "core" Oct 27 13:22:41.698511 ignition[1300]: INFO : files: ensureUsers: op(2): [finished] adding ssh keys to user "core" Oct 27 13:22:41.698511 ignition[1300]: INFO : files: createFilesystemsFiles: createFiles: op(3): [started] writing file "/sysroot/etc/flatcar/update.conf" Oct 27 13:22:41.698511 ignition[1300]: INFO : files: createFilesystemsFiles: createFiles: op(3): [finished] writing file "/sysroot/etc/flatcar/update.conf" Oct 27 13:22:41.698511 ignition[1300]: INFO : files: createResultFile: createFiles: op(4): [started] writing file "/sysroot/etc/.ignition-result.json" Oct 27 13:22:41.698511 ignition[1300]: INFO : files: createResultFile: createFiles: op(4): [finished] writing file "/sysroot/etc/.ignition-result.json" Oct 27 13:22:41.698511 ignition[1300]: INFO : files: files passed Oct 27 13:22:41.698511 ignition[1300]: INFO : Ignition finished successfully Oct 27 13:22:41.702000 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' Oct 27 13:22:41.779000 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' Oct 27 13:22:41.686856 unknown[1300]: wrote ssh authorized keys file for user: core Oct 27 13:22:41.779000 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' Oct 27 13:22:41.812776 kernel: audit: type=1130 audit(1793107361.702: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' Oct 27 13:22:41.693846 systemd[1]: Finished ignition-files.service - Ignition (files). Oct 27 13:22:41.817359 kernel: audit: type=1130 audit(1793107361.779: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' Oct 27 13:22:41.725113 systemd[1]: Starting ignition-quench.service - Ignition (record completion)... Oct 27 13:22:41.821861 kernel: audit: type=1131 audit(1793107361.779: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' Oct 27 13:22:41.743660 systemd[1]: Starting initrd-setup-root-after-ignition.service - Root filesystem completion... Oct 27 13:22:41.757803 systemd[1]: ignition-quench.service: Deactivated successfully. Oct 27 13:22:41.772672 systemd[1]: Finished ignition-quench.service - Ignition (record completion). Oct 27 13:22:41.843852 initrd-setup-root-after-ignition[1333]: grep: /sysroot/etc/flatcar/enabled-sysext.conf: No such file or directory Oct 27 13:22:41.843852 initrd-setup-root-after-ignition[1333]: grep: /sysroot/usr/share/flatcar/enabled-sysext.conf: No such file or directory Oct 27 13:22:41.857245 initrd-setup-root-after-ignition[1337]: grep: /sysroot/etc/flatcar/enabled-sysext.conf: No such file or directory Oct 27 13:22:41.868584 kernel: loop3: detected capacity change from 0 to 44328 Oct 27 13:22:41.877541 kernel: loop3: p1 p2 p3 Oct 27 13:22:41.894897 kernel: device-mapper: verity: sha256 using shash "sha256-ce" Oct 27 13:22:41.894952 kernel: device-mapper: verity: Unrecognized verity feature request: root_hash_sig_key_desc Oct 27 13:22:41.901030 kernel: device-mapper: table: 254:2: verity: Unrecognized verity feature request (-EINVAL) Oct 27 13:22:41.904291 kernel: device-mapper: ioctl: error adding target to table Oct 27 13:22:41.904545 systemd-confext[1339]: device-mapper: reload ioctl on loop3p1-21-verity (254:2) failed: Invalid argument Oct 27 13:22:41.918610 kernel: device-mapper: verity: sha256 using shash "sha256-ce" Oct 27 13:22:41.937545 kernel: erofs: (device dm-2): mounted with root inode @ nid 40. Oct 27 13:22:41.970554 kernel: loop4: detected capacity change from 0 to 44328 Oct 27 13:22:41.978544 kernel: loop4: p1 p2 p3 Oct 27 13:22:41.990999 kernel: device-mapper: verity: sha256 using shash "sha256-ce" Oct 27 13:22:41.991045 kernel: device-mapper: verity: Unrecognized verity feature request: root_hash_sig_key_desc Oct 27 13:22:41.996014 kernel: device-mapper: table: 254:2: verity: Unrecognized verity feature request (-EINVAL) Oct 27 13:22:41.999283 kernel: device-mapper: ioctl: error adding target to table Oct 27 13:22:41.999334 (sd-merge)[1347]: device-mapper: reload ioctl on loop4p1-25-verity (254:2) failed: Invalid argument Oct 27 13:22:42.017544 kernel: device-mapper: verity: sha256 using shash "sha256-ce" Oct 27 13:22:42.034196 (sd-merge)[1347]: Skipping extension refresh because no change was found, use --always-refresh=yes to always do a refresh. Oct 27 13:22:42.040921 kernel: erofs: (device dm-2): mounted with root inode @ nid 40. Oct 27 13:22:42.157568 kernel: loop4: detected capacity change from 0 to 172608 Oct 27 13:22:42.218658 kernel: loop4: p1 p2 p3 Oct 27 13:22:42.692633 kernel: device-mapper: verity: sha256 using shash "sha256-ce" Oct 27 13:22:42.692695 kernel: device-mapper: verity: Unrecognized verity feature request: root_hash_sig_key_desc Oct 27 13:22:42.697354 kernel: device-mapper: table: 254:2: verity: Unrecognized verity feature request (-EINVAL) Oct 27 13:22:42.700460 kernel: device-mapper: ioctl: error adding target to table Oct 27 13:22:42.700688 systemd-sysext[1355]: device-mapper: reload ioctl on loop4p1-29-verity (254:2) failed: Invalid argument Oct 27 13:22:42.715551 kernel: device-mapper: verity: sha256 using shash "sha256-ce" Oct 27 13:22:42.845542 kernel: erofs: (device dm-2): mounted with root inode @ nid 39. Oct 27 13:22:42.931554 kernel: loop5: detected capacity change from 0 to 142648 Oct 27 13:22:42.994580 kernel: loop5: p1 p2 p3 Oct 27 13:22:43.253831 kernel: device-mapper: verity: sha256 using shash "sha256-ce" Oct 27 13:22:43.253883 kernel: device-mapper: verity: Unrecognized verity feature request: root_hash_sig_key_desc Oct 27 13:22:43.258497 kernel: device-mapper: table: 254:2: verity: Unrecognized verity feature request (-EINVAL) Oct 27 13:22:43.261730 kernel: device-mapper: ioctl: error adding target to table Oct 27 13:22:43.261953 systemd-sysext[1355]: device-mapper: reload ioctl on loop5p1-33-verity (254:2) failed: Invalid argument Oct 27 13:22:43.271188 kernel: device-mapper: verity: sha256 using shash "sha256-ce" Oct 27 13:22:43.465546 kernel: erofs: (device dm-2): mounted with root inode @ nid 39. Oct 27 13:22:43.488541 kernel: loop6: detected capacity change from 0 to 364712 Oct 27 13:22:43.573653 kernel: loop6: p1 p2 p3 Oct 27 13:22:43.850076 kernel: device-mapper: verity: sha256 using shash "sha256-ce" Oct 27 13:22:43.850126 kernel: device-mapper: verity: Unrecognized verity feature request: root_hash_sig_key_desc Oct 27 13:22:43.855287 kernel: device-mapper: table: 254:2: verity: Unrecognized verity feature request (-EINVAL) Oct 27 13:22:43.858933 kernel: device-mapper: ioctl: error adding target to table Oct 27 13:22:43.859188 systemd-sysext[1355]: device-mapper: reload ioctl on loop6p1-37-verity (254:2) failed: Invalid argument Oct 27 13:22:43.872546 kernel: device-mapper: verity: sha256 using shash "sha256-ce" Oct 27 13:22:44.174580 kernel: erofs: (device dm-2): mounted with root inode @ nid 39. Oct 27 13:22:44.301553 kernel: loop7: detected capacity change from 0 to 172608 Oct 27 13:22:44.309533 kernel: loop7: p1 p2 p3 Oct 27 13:22:44.328578 kernel: device-mapper: verity: sha256 using shash "sha256-ce" Oct 27 13:22:44.328633 kernel: device-mapper: verity: Unrecognized verity feature request: root_hash_sig_key_desc Oct 27 13:22:44.333373 kernel: device-mapper: table: 254:2: verity: Unrecognized verity feature request (-EINVAL) Oct 27 13:22:44.336920 kernel: device-mapper: ioctl: error adding target to table Oct 27 13:22:44.336997 (sd-merge)[1378]: device-mapper: reload ioctl on loop7p1-41-verity (254:2) failed: Invalid argument Oct 27 13:22:44.347919 kernel: device-mapper: verity: sha256 using shash "sha256-ce" Oct 27 13:22:44.379536 kernel: erofs: (device dm-2): mounted with root inode @ nid 39. Oct 27 13:22:44.384547 kernel: loop1: detected capacity change from 0 to 142648 Oct 27 13:22:44.393557 kernel: loop1: p1 p2 p3 Oct 27 13:22:44.405764 kernel: device-mapper: verity: sha256 using shash "sha256-ce" Oct 27 13:22:44.405799 kernel: device-mapper: verity: Unrecognized verity feature request: root_hash_sig_key_desc Oct 27 13:22:44.414000 kernel: device-mapper: table: 254:3: verity: Unrecognized verity feature request (-EINVAL) Oct 27 13:22:44.417131 kernel: device-mapper: ioctl: error adding target to table Oct 27 13:22:44.417312 (sd-merge)[1378]: device-mapper: reload ioctl on loop1p1-45-verity (254:3) failed: Invalid argument Oct 27 13:22:44.429882 kernel: device-mapper: verity: sha256 using shash "sha256-ce" Oct 27 13:22:44.455688 kernel: erofs: (device dm-3): mounted with root inode @ nid 39. Oct 27 13:22:44.459543 kernel: loop3: detected capacity change from 0 to 364712 Oct 27 13:22:44.468553 kernel: loop3: p1 p2 p3 Oct 27 13:22:44.481089 kernel: device-mapper: verity: sha256 using shash "sha256-ce" Oct 27 13:22:44.481139 kernel: device-mapper: verity: Unrecognized verity feature request: root_hash_sig_key_desc Oct 27 13:22:44.486469 kernel: device-mapper: table: 254:4: verity: Unrecognized verity feature request (-EINVAL) Oct 27 13:22:44.489990 kernel: device-mapper: ioctl: error adding target to table Oct 27 13:22:44.490058 (sd-merge)[1378]: device-mapper: reload ioctl on loop3p1-49-verity (254:4) failed: Invalid argument Oct 27 13:22:44.500626 kernel: device-mapper: verity: sha256 using shash "sha256-ce" Oct 27 13:22:44.527577 kernel: erofs: (device dm-4): mounted with root inode @ nid 39. Oct 27 13:22:44.528216 (sd-merge)[1378]: Using extensions 'containerd-flatcar.raw', 'docker-flatcar.raw', 'oem-azure-4757.2.3.raw'. Oct 27 13:22:44.529030 (sd-merge)[1378]: Merged extensions into '/sysroot/usr'. Oct 27 13:22:44.541316 systemd[1]: Finished initrd-setup-root-after-ignition.service - Root filesystem completion. Oct 27 13:22:44.547000 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' Oct 27 13:22:44.554707 systemd[1]: Starting initrd-parse-etc.service - Mountpoints Configured in the Real Root... Oct 27 13:22:44.573988 kernel: audit: type=1130 audit(1793107364.547: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' Oct 27 13:22:44.591854 systemd[1]: initrd-parse-etc.service: Deactivated successfully. Oct 27 13:22:44.592577 systemd[1]: Finished initrd-parse-etc.service - Mountpoints Configured in the Real Root. Oct 27 13:22:44.600000 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' Oct 27 13:22:44.601400 systemd[1]: initrd-parse-etc.service: Triggering OnSuccess= dependencies. Oct 27 13:22:44.600000 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' Oct 27 13:22:44.646148 kernel: audit: type=1130 audit(1793107364.600: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' Oct 27 13:22:44.602085 systemd[1]: Reached target initrd-fs.target - Initrd File Systems. Oct 27 13:22:44.650797 kernel: audit: type=1131 audit(1793107364.600: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' Oct 27 13:22:44.636403 systemd[1]: Starting dracut-mount.service - dracut mount hook... Oct 27 13:22:45.111235 systemd[1]: Finished dracut-mount.service - dracut mount hook. Oct 27 13:22:45.115000 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' Oct 27 13:22:45.117921 systemd[1]: Starting dracut-pre-pivot.service - dracut pre-pivot and cleanup hook... Oct 27 13:22:45.142079 kernel: audit: type=1130 audit(1793107365.115: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' Oct 27 13:22:45.158200 systemd[1]: Finished dracut-pre-pivot.service - dracut pre-pivot and cleanup hook. Oct 27 13:22:45.162000 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' Oct 27 13:22:45.181145 systemd[1]: Starting initrd-cleanup.service - Cleaning Up and Shutting Down Daemons... Oct 27 13:22:45.191792 kernel: audit: type=1130 audit(1793107365.162:52): 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' Oct 27 13:22:45.205662 systemd[1]: Stopped target basic.target - Basic System. Oct 27 13:22:45.209622 systemd[1]: Stopped target ignition-diskful.target - Ignition Boot Disk Setup. Oct 27 13:22:45.218462 systemd[1]: Stopped target initrd-root-device.target - Initrd Root Device. Oct 27 13:22:45.227470 systemd[1]: Stopped target initrd-usr-fs.target - Initrd /usr File System. Oct 27 13:22:45.236379 systemd[1]: Stopped target nss-lookup.target - Host and Network Name Lookups. Oct 27 13:22:45.246131 systemd[1]: Stopped target paths.target - Path Units. Oct 27 13:22:45.254466 systemd[1]: Stopped target remote-cryptsetup.target - Remote Encrypted Volumes. Oct 27 13:22:45.262642 systemd[1]: Stopped target slices.target - Slice Units. Oct 27 13:22:45.271067 systemd[1]: Stopped target sockets.target - Socket Units. Oct 27 13:22:45.278339 systemd[1]: Stopped target sysinit.target - System Initialization. Oct 27 13:22:45.285964 systemd[1]: Stopped target local-fs.target - Local File Systems. Oct 27 13:22:45.294436 systemd[1]: Stopped target local-fs-pre.target - Preparation for Local File Systems. Oct 27 13:22:45.304609 systemd[1]: Stopped target swap.target - Swaps. Oct 27 13:22:45.313325 systemd[1]: Stopped target timers.target - Timer Units. Oct 27 13:22:45.320617 systemd[1]: iscsid.socket: Deactivated successfully. Oct 27 13:22:45.320760 systemd[1]: Closed iscsid.socket - Open-iSCSI iscsid Socket. Oct 27 13:22:45.328231 systemd[1]: iscsiuio.socket: Deactivated successfully. Oct 27 13:22:45.328347 systemd[1]: Closed iscsiuio.socket - Open-iSCSI iscsiuio Socket. Oct 27 13:22:45.335604 systemd[1]: systemd-coredump.socket: Deactivated successfully. Oct 27 13:22:45.359000 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' Oct 27 13:22:45.335707 systemd[1]: Closed systemd-coredump.socket - Process Core Dump Socket. Oct 27 13:22:45.343866 systemd[1]: systemd-journald-audit.socket: Deactivated successfully. Oct 27 13:22:45.343961 systemd[1]: Closed systemd-journald-audit.socket - Journal Audit Socket. Oct 27 13:22:45.351475 systemd[1]: dracut-pre-pivot.service: Deactivated successfully. Oct 27 13:22:45.401000 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' Oct 27 13:22:45.416229 kernel: audit: type=1131 audit(1793107365.359:53): 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' Oct 27 13:22:45.351628 systemd[1]: Stopped dracut-pre-pivot.service - dracut pre-pivot and cleanup hook. Oct 27 13:22:45.421060 kernel: audit: type=1131 audit(1793107365.401:54): 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' Oct 27 13:22:45.375906 systemd[1]: Stopped target remote-fs.target - Remote File Systems. Oct 27 13:22:45.424000 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' Oct 27 13:22:45.441546 kernel: audit: type=1131 audit(1793107365.424:55): 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' Oct 27 13:22:45.384455 systemd[1]: Stopped target remote-fs-pre.target - Preparation for Remote File Systems. Oct 27 13:22:45.393581 systemd[1]: dracut-mount.service: Deactivated successfully. Oct 27 13:22:45.393730 systemd[1]: Stopped dracut-mount.service - dracut mount hook. Oct 27 13:22:45.416492 systemd[1]: dracut-pre-mount.service: Deactivated successfully. Oct 27 13:22:45.416611 systemd[1]: Stopped dracut-pre-mount.service - dracut pre-mount hook. Oct 27 13:22:45.482000 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' Oct 27 13:22:45.425598 systemd[1]: Stopped target cryptsetup.target - Local Encrypted Volumes. Oct 27 13:22:45.446099 systemd[1]: systemd-ask-password-console.path: Deactivated successfully. Oct 27 13:22:45.509000 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' Oct 27 13:22:45.526144 kernel: audit: type=1131 audit(1793107365.482:56): 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' Oct 27 13:22:45.446507 systemd[1]: Stopped systemd-ask-password-console.path - Dispatch Password Requests to Console Directory Watch. Oct 27 13:22:45.532332 kernel: audit: type=1131 audit(1793107365.509:57): 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' Oct 27 13:22:45.456557 systemd[1]: Stopped target cryptsetup-pre.target - Local Encrypted Volumes (Pre). Oct 27 13:22:45.536000 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' Oct 27 13:22:45.465347 systemd[1]: clevis-luks-askpass.path: Deactivated successfully. Oct 27 13:22:45.546000 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' Oct 27 13:22:45.465779 systemd[1]: Stopped clevis-luks-askpass.path - Forward Password Requests to Clevis Directory Watch. Oct 27 13:22:45.475200 systemd[1]: dracut-initqueue.service: Deactivated successfully. Oct 27 13:22:45.475383 systemd[1]: Stopped dracut-initqueue.service - dracut initqueue hook. Oct 27 13:22:45.483650 systemd[1]: initrd-setup-root-after-ignition.service: Deactivated successfully. Oct 27 13:22:45.574000 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' Oct 27 13:22:45.500345 systemd[1]: Stopped initrd-setup-root-after-ignition.service - Root filesystem completion. Oct 27 13:22:45.584000 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' Oct 27 13:22:45.595000 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' Oct 27 13:22:45.510204 systemd[1]: ignition-files.service: Deactivated successfully. Oct 27 13:22:45.599000 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' Oct 27 13:22:45.526428 systemd[1]: Stopped ignition-files.service - Ignition (files). Oct 27 13:22:45.607000 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' Oct 27 13:22:45.612507 ignition[1420]: INFO : Ignition 2.24.0 Oct 27 13:22:45.612507 ignition[1420]: INFO : Stage: umount Oct 27 13:22:45.612507 ignition[1420]: INFO : no config dir at "/usr/lib/ignition/base.d" Oct 27 13:22:45.612507 ignition[1420]: INFO : no config dir at "/usr/lib/ignition/base.platform.d/azure" Oct 27 13:22:45.612507 ignition[1420]: INFO : umount: umount passed Oct 27 13:22:45.612507 ignition[1420]: INFO : Ignition finished successfully Oct 27 13:22:45.622000 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' Oct 27 13:22:45.629000 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' Oct 27 13:22:45.638000 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' Oct 27 13:22:45.536707 systemd[1]: flatcar-metadata-hostname.service: Deactivated successfully. Oct 27 13:22:45.664000 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' Oct 27 13:22:45.664000 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' Oct 27 13:22:45.536837 systemd[1]: Stopped flatcar-metadata-hostname.service - Flatcar Metadata Hostname Agent. Oct 27 13:22:45.551768 systemd[1]: Stopping ignition-mount.service - Ignition (mount)... Oct 27 13:22:45.678000 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' Oct 27 13:22:45.565660 systemd[1]: systemd-modules-load.service: Deactivated successfully. Oct 27 13:22:45.565837 systemd[1]: Stopped systemd-modules-load.service - Load Kernel Modules. Oct 27 13:22:45.574832 systemd[1]: systemd-tmpfiles-setup.service: Deactivated successfully. Oct 27 13:22:45.695000 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' Oct 27 13:22:45.574982 systemd[1]: Stopped systemd-tmpfiles-setup.service - Create System Files and Directories. Oct 27 13:22:45.705000 audit: BPF prog-id=8 op=UNLOAD Oct 27 13:22:45.705000 audit: BPF prog-id=5 op=UNLOAD Oct 27 13:22:45.590567 systemd[1]: systemd-udev-trigger.service: Deactivated successfully. Oct 27 13:22:45.590667 systemd[1]: Stopped systemd-udev-trigger.service - Coldplug All udev Devices. Oct 27 13:22:45.595685 systemd[1]: dracut-pre-trigger.service: Deactivated successfully. Oct 27 13:22:45.595780 systemd[1]: Stopped dracut-pre-trigger.service - dracut pre-trigger hook. Oct 27 13:22:45.601734 systemd[1]: ignition-mount.service: Deactivated successfully. Oct 27 13:22:45.603907 systemd[1]: Stopped ignition-mount.service - Ignition (mount). Oct 27 13:22:45.609257 systemd[1]: Stopped target network.target - Network. Oct 27 13:22:45.759000 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' Oct 27 13:22:45.616008 systemd[1]: ignition-disks.service: Deactivated successfully. Oct 27 13:22:45.616057 systemd[1]: Stopped ignition-disks.service - Ignition (disks). Oct 27 13:22:45.622862 systemd[1]: ignition-setup-pre.service: Deactivated successfully. Oct 27 13:22:45.622903 systemd[1]: Stopped ignition-setup-pre.service - Ignition env setup. Oct 27 13:22:45.629823 systemd[1]: initrd-setup-root.service: Deactivated successfully. Oct 27 13:22:45.629859 systemd[1]: Stopped initrd-setup-root.service - Root filesystem setup. Oct 27 13:22:45.638792 systemd[1]: Stopping systemd-networkd.service - Network Management... Oct 27 13:22:45.800000 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' Oct 27 13:22:45.647337 systemd[1]: Stopping systemd-resolved.service - Network Name Resolution... Oct 27 13:22:45.813000 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' Oct 27 13:22:45.656132 systemd[1]: initrd-cleanup.service: Deactivated successfully. Oct 27 13:22:45.821000 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' Oct 27 13:22:45.656236 systemd[1]: Finished initrd-cleanup.service - Cleaning Up and Shutting Down Daemons. Oct 27 13:22:45.831000 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' Oct 27 13:22:45.670159 systemd[1]: systemd-resolved.service: Deactivated successfully. Oct 27 13:22:45.670256 systemd[1]: Stopped systemd-resolved.service - Network Name Resolution. Oct 27 13:22:45.857152 kernel: hv_netvsc 0022487c-b89d-0022-487c-b89d0022487c eth0: Data path switched from VF: enP44203s1 Oct 27 13:22:45.687872 systemd[1]: systemd-networkd.service: Deactivated successfully. Oct 27 13:22:45.861000 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' Oct 27 13:22:45.688012 systemd[1]: Stopped systemd-networkd.service - Network Management. Oct 27 13:22:45.870000 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' Oct 27 13:22:45.704888 systemd[1]: systemd-networkd-resolve-hook.socket: Deactivated successfully. Oct 27 13:22:45.879000 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' Oct 27 13:22:45.704960 systemd[1]: Closed systemd-networkd-resolve-hook.socket - Network Management Resolve Hook Socket. Oct 27 13:22:45.892000 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' Oct 27 13:22:45.711831 systemd[1]: Stopped target network-pre.target - Preparation for Network. Oct 27 13:22:45.902000 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' Oct 27 13:22:45.720332 systemd[1]: systemd-networkd.socket: Deactivated successfully. Oct 27 13:22:45.720393 systemd[1]: Closed systemd-networkd.socket - Network Management Netlink Socket. Oct 27 13:22:45.916000 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' Oct 27 13:22:45.916000 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' Oct 27 13:22:45.731004 systemd[1]: Stopping network-cleanup.service - Network Cleanup... Oct 27 13:22:45.744446 systemd[1]: parse-ip-for-networkd.service: Deactivated successfully. Oct 27 13:22:45.744528 systemd[1]: Stopped parse-ip-for-networkd.service - Write systemd-networkd units from cmdline. Oct 27 13:22:45.761392 systemd[1]: Stopping systemd-udevd.service - Rule-based Manager for Device Events and Files... Oct 27 13:22:45.792823 systemd[1]: systemd-udevd.service: Deactivated successfully. Oct 27 13:22:45.793031 systemd[1]: Stopped systemd-udevd.service - Rule-based Manager for Device Events and Files. Oct 27 13:22:45.801222 systemd[1]: systemd-udevd.service: Consumed 1.005s CPU time over 10.847s wall clock time. Oct 27 13:22:45.801390 systemd[1]: systemd-udevd-control.socket: Deactivated successfully. Oct 27 13:22:45.801442 systemd[1]: Closed systemd-udevd-control.socket - udev Control Socket. Oct 27 13:22:45.809808 systemd[1]: dracut-pre-udev.service: Deactivated successfully. Oct 27 13:22:45.809854 systemd[1]: Stopped dracut-pre-udev.service - dracut pre-udev hook. Oct 27 13:22:45.814288 systemd[1]: dracut-cmdline.service: Deactivated successfully. Oct 27 13:22:45.814318 systemd[1]: Stopped dracut-cmdline.service - dracut cmdline hook. Oct 27 13:22:45.822426 systemd[1]: dracut-cmdline-ask.service: Deactivated successfully. Oct 27 13:22:45.822465 systemd[1]: Stopped dracut-cmdline-ask.service - dracut ask for additional cmdline parameters. Oct 27 13:22:45.837100 systemd[1]: Starting initrd-udevadm-cleanup-db.service - Cleanup udev Database... Oct 27 13:22:45.990000 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' Oct 27 13:22:45.852697 systemd[1]: systemd-network-generator.service: Deactivated successfully. Oct 27 13:22:45.852757 systemd[1]: Stopped systemd-network-generator.service - Generate Network Units from Kernel Command Line. Oct 27 13:22:45.862132 systemd[1]: systemd-tmpfiles-setup-dev.service: Deactivated successfully. Oct 27 13:22:45.862169 systemd[1]: Stopped systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev. Oct 27 13:22:45.870677 systemd[1]: systemd-tmpfiles-setup-dev-early.service: Deactivated successfully. Oct 27 13:22:45.870708 systemd[1]: Stopped systemd-tmpfiles-setup-dev-early.service - Create Static Device Nodes in /dev gracefully. Oct 27 13:22:45.879945 systemd[1]: kmod-static-nodes.service: Deactivated successfully. Oct 27 13:22:45.879972 systemd[1]: Stopped kmod-static-nodes.service - Create List of Static Device Nodes. Oct 27 13:22:45.892673 systemd[1]: systemd-vconsole-setup.service: Deactivated successfully. Oct 27 13:22:45.892721 systemd[1]: Stopped systemd-vconsole-setup.service - Virtual Console Setup. Oct 27 13:22:45.904012 systemd[1]: initrd-udevadm-cleanup-db.service: Deactivated successfully. Oct 27 13:22:45.905545 systemd[1]: Finished initrd-udevadm-cleanup-db.service - Cleanup udev Database. Oct 27 13:22:45.982472 systemd[1]: network-cleanup.service: Deactivated successfully. Oct 27 13:22:45.982646 systemd[1]: Stopped network-cleanup.service - Network Cleanup. Oct 27 13:22:45.991929 systemd[1]: Reached target initrd-switch-root.target - Switch Root. Oct 27 13:22:46.001027 systemd[1]: Starting initrd-switch-root.service - Switch Root... Oct 27 13:22:46.033939 systemd[1]: Switching root. Oct 27 13:22:46.118210 systemd-journald[497]: Journal stopped Oct 27 13:22:53.094696 systemd-journald[497]: Received SIGTERM from PID 1 (systemd). Oct 27 13:22:53.094736 kernel: SELinux: policy capability network_peer_controls=1 Oct 27 13:22:53.094747 kernel: SELinux: policy capability open_perms=1 Oct 27 13:22:53.094753 kernel: SELinux: policy capability extended_socket_class=1 Oct 27 13:22:53.094759 kernel: SELinux: policy capability always_check_network=0 Oct 27 13:22:53.094765 kernel: SELinux: policy capability cgroup_seclabel=1 Oct 27 13:22:53.094773 kernel: SELinux: policy capability nnp_nosuid_transition=1 Oct 27 13:22:53.094780 kernel: SELinux: policy capability genfs_seclabel_symlinks=0 Oct 27 13:22:53.094786 kernel: SELinux: policy capability ioctl_skip_cloexec=0 Oct 27 13:22:53.094791 kernel: SELinux: policy capability userspace_initial_context=0 Oct 27 13:22:53.094797 systemd[1]: Successfully loaded SELinux policy in 169.327ms. Oct 27 13:22:53.094805 systemd[1]: Relabeled /dev/, /dev/shm/, /run/ in 6.109ms. Oct 27 13:22:53.094812 systemd[1]: systemd 260.4 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) Oct 27 13:22:53.094818 systemd[1]: Detected virtualization microsoft. Oct 27 13:22:53.094825 systemd[1]: Detected architecture arm64. Oct 27 13:22:53.094832 systemd[1]: Detected first boot. Oct 27 13:22:53.094839 systemd[1]: Initializing machine ID from random generator. Oct 27 13:22:53.094845 systemd[1]: Hostname set to . Oct 27 13:22:53.094851 zram_generator::config[1462]: No configuration found. Oct 27 13:22:53.094858 kernel: NET: Registered PF_VSOCK protocol family Oct 27 13:22:53.094864 systemd[1]: Applying preset policy. Oct 27 13:22:53.094871 systemd[1]: Populated /etc with preset unit settings. Oct 27 13:22:53.094877 kernel: kauditd_printk_skb: 33 callbacks suppressed Oct 27 13:22:53.094883 kernel: audit: type=1334 audit(1793107371.941:91): prog-id=10 op=LOAD Oct 27 13:22:53.094889 kernel: audit: type=1334 audit(1793107371.941:92): prog-id=2 op=UNLOAD Oct 27 13:22:53.094894 kernel: audit: type=1334 audit(1793107371.944:93): prog-id=11 op=LOAD Oct 27 13:22:53.094900 kernel: audit: type=1334 audit(1793107371.945:94): prog-id=12 op=LOAD Oct 27 13:22:53.094907 kernel: audit: type=1334 audit(1793107371.945:95): prog-id=3 op=UNLOAD Oct 27 13:22:53.094913 kernel: audit: type=1334 audit(1793107371.945:96): prog-id=4 op=UNLOAD Oct 27 13:22:53.094919 kernel: audit: type=1334 audit(1793107371.949:97): prog-id=13 op=LOAD Oct 27 13:22:53.094925 kernel: audit: type=1334 audit(1793107371.949:98): prog-id=10 op=UNLOAD Oct 27 13:22:53.094931 kernel: audit: type=1334 audit(1793107371.952:99): prog-id=14 op=LOAD Oct 27 13:22:53.094936 kernel: audit: type=1334 audit(1793107371.956:100): prog-id=15 op=LOAD Oct 27 13:22:53.094944 systemd[1]: initrd-switch-root.service: Deactivated successfully. Oct 27 13:22:53.094950 systemd[1]: Stopped initrd-switch-root.service - Switch Root. Oct 27 13:22:53.094956 systemd[1]: systemd-journald.service: Scheduled restart job, restart counter is at 1. Oct 27 13:22:53.094963 systemd[1]: Created slice system-addon\x2dconfig.slice - Slice /system/addon-config. Oct 27 13:22:53.094970 systemd[1]: Created slice system-addon\x2drun.slice - Slice /system/addon-run. Oct 27 13:22:53.094976 systemd[1]: Created slice system-getty.slice - Slice /system/getty. Oct 27 13:22:53.094984 systemd[1]: Created slice system-modprobe.slice - Slice /system/modprobe. Oct 27 13:22:53.094992 systemd[1]: Created slice system-serial\x2dgetty.slice - Slice /system/serial-getty. Oct 27 13:22:53.094998 systemd[1]: Created slice system-system\x2dcloudinit.slice - Slice /system/system-cloudinit. Oct 27 13:22:53.095005 systemd[1]: Created slice system-systemd\x2dfsck.slice - Slice /system/systemd-fsck. Oct 27 13:22:53.095011 systemd[1]: Created slice user.slice - User and Session Slice. Oct 27 13:22:53.095018 systemd[1]: Started clevis-luks-askpass.path - Forward Password Requests to Clevis Directory Watch. Oct 27 13:22:53.095024 systemd[1]: Started systemd-ask-password-console.path - Dispatch Password Requests to Console Directory Watch. Oct 27 13:22:53.095032 systemd[1]: Started systemd-ask-password-wall.path - Forward Password Requests to Wall Directory Watch. Oct 27 13:22:53.095038 systemd[1]: Set up automount boot.automount - Boot partition Automount Point. Oct 27 13:22:53.095045 systemd[1]: Set up automount proc-sys-fs-binfmt_misc.automount - Arbitrary Executable File Formats File System Automount Point. Oct 27 13:22:53.095053 systemd[1]: Expecting device dev-disk-by\x2dlabel-OEM.device - /dev/disk/by-label/OEM... Oct 27 13:22:53.095059 systemd[1]: Expecting device dev-ptp_hyperv.device - /dev/ptp_hyperv... Oct 27 13:22:53.095065 systemd[1]: Expecting device dev-ttyAMA0.device - /dev/ttyAMA0... Oct 27 13:22:53.095072 systemd[1]: Reached target cryptsetup-pre.target - Local Encrypted Volumes (Pre). Oct 27 13:22:53.095079 systemd[1]: Reached target cryptsetup.target - Local Encrypted Volumes. Oct 27 13:22:53.095086 systemd[1]: Reached target imports.target - Image Downloads. Oct 27 13:22:53.095092 systemd[1]: Stopped target initrd-switch-root.target - Switch Root. Oct 27 13:22:53.095098 systemd[1]: Stopped target initrd-fs.target - Initrd File Systems. Oct 27 13:22:53.095105 systemd[1]: Stopped target initrd-root-fs.target - Initrd Root File System. Oct 27 13:22:53.095111 systemd[1]: Reached target integritysetup.target - Local Integrity Protected Volumes. Oct 27 13:22:53.095119 systemd[1]: Reached target remote-cryptsetup.target - Remote Encrypted Volumes. Oct 27 13:22:53.095125 systemd[1]: Reached target remote-fs.target - Remote File Systems. Oct 27 13:22:53.095131 systemd[1]: Reached target remote-integritysetup.target - Remote Integrity Protected Volumes. Oct 27 13:22:53.095138 systemd[1]: Reached target remote-veritysetup.target - Remote Verity Protected Volumes. Oct 27 13:22:53.095146 systemd[1]: Reached target slices.target - Slice Units. Oct 27 13:22:53.095152 systemd[1]: Reached target swap.target - Swaps. Oct 27 13:22:53.095158 systemd[1]: Reached target veritysetup.target - Local Verity Protected Volumes. Oct 27 13:22:53.095165 systemd[1]: Listening on systemd-ask-password.socket - Query the User Interactively for a Password. Oct 27 13:22:53.095171 systemd[1]: Listening on systemd-coredump.socket - Process Core Dump Socket. Oct 27 13:22:53.095178 systemd[1]: Listening on systemd-creds.socket - Credential Encryption/Decryption. Oct 27 13:22:53.095185 systemd[1]: Listening on systemd-factory-reset.socket - Factory Reset Management. Oct 27 13:22:53.095192 systemd[1]: Listening on systemd-journald-audit.socket - Journal Audit Socket. Oct 27 13:22:53.095199 systemd[1]: Listening on systemd-mountfsd.socket - DDI File System Mounter Socket. Oct 27 13:22:53.095205 systemd[1]: Listening on systemd-mute-console.socket - Console Output Muting Service Socket. Oct 27 13:22:53.095212 systemd[1]: Listening on systemd-networkd-varlink-metrics.socket - Network Management Metrics Varlink Socket. Oct 27 13:22:53.095218 systemd[1]: Listening on systemd-networkd-varlink.socket - Network Management Varlink Socket. Oct 27 13:22:53.095225 systemd[1]: Listening on systemd-networkd.socket - Network Management Netlink Socket. Oct 27 13:22:53.095232 systemd[1]: Listening on systemd-nsresourced.socket - Namespace Resource Manager Socket. Oct 27 13:22:53.095239 systemd[1]: Listening on systemd-oomd.socket - Userspace Out-Of-Memory (OOM) Killer Socket. Oct 27 13:22:53.095245 systemd[1]: Listening on systemd-repart.socket - Disk Repartitioning Service Socket. Oct 27 13:22:53.095252 systemd[1]: Listening on systemd-resolved-monitor.socket - Resolve Monitor Varlink Socket. Oct 27 13:22:53.095258 systemd[1]: Listening on systemd-resolved-varlink.socket - Resolve Service Varlink Socket. Oct 27 13:22:53.095265 systemd[1]: Listening on systemd-udevd-control.socket - udev Control Socket. Oct 27 13:22:53.095272 systemd[1]: Listening on systemd-udevd-varlink.socket - udev Varlink Socket. Oct 27 13:22:53.095279 systemd[1]: Listening on systemd-userdbd.socket - User Database Manager Socket. Oct 27 13:22:53.095285 systemd[1]: Mounting dev-hugepages.mount - Huge Pages File System... Oct 27 13:22:53.095292 systemd[1]: Mounting dev-mqueue.mount - POSIX Message Queue File System... Oct 27 13:22:53.095299 systemd[1]: Mounting media.mount - External Media Directory... Oct 27 13:22:53.095305 systemd[1]: Mounting sys-kernel-debug.mount - Kernel Debug File System... Oct 27 13:22:53.095311 systemd[1]: Mounting sys-kernel-tracing.mount - Kernel Trace File System... Oct 27 13:22:53.095319 systemd[1]: tmp.mount: x-systemd.graceful-option=usrquota specified, but option is not available, suppressing. Oct 27 13:22:53.095326 systemd[1]: Mounting tmp.mount - Temporary Directory /tmp... Oct 27 13:22:53.095333 systemd[1]: Starting flatcar-tmpfiles.service - Create missing system files... Oct 27 13:22:53.095339 systemd[1]: ignition-delete-config.service - Ignition (delete config) skipped, no trigger condition checks were met. Oct 27 13:22:53.095346 systemd[1]: Starting kmod-static-nodes.service - Create List of Static Device Nodes... Oct 27 13:22:53.095352 systemd[1]: Starting modprobe@configfs.service - Load Kernel Module configfs... Oct 27 13:22:53.095359 systemd[1]: modprobe@drm.service - Load Kernel Module drm skipped, unmet condition check ConditionKernelModuleLoaded=!drm Oct 27 13:22:53.095366 systemd[1]: Starting modprobe@efi_pstore.service - Load Kernel Module efi_pstore... Oct 27 13:22:53.095373 systemd[1]: Starting modprobe@fuse.service - Load Kernel Module fuse... Oct 27 13:22:53.095379 systemd[1]: setup-nsswitch.service - Create /etc/nsswitch.conf skipped, unmet condition check ConditionPathExists=!/etc/nsswitch.conf Oct 27 13:22:53.095386 systemd[1]: systemd-fsck-root.service: Deactivated successfully. Oct 27 13:22:53.095392 systemd[1]: Stopped systemd-fsck-root.service - File System Check on Root Device. Oct 27 13:22:53.095399 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 Oct 27 13:22:53.095407 systemd[1]: Starting systemd-journald.service - Journal Service... Oct 27 13:22:53.095413 systemd[1]: Starting systemd-modules-load.service - Load Kernel Modules... Oct 27 13:22:53.095420 systemd[1]: Starting systemd-network-generator.service - Generate Network Units from Kernel Command Line... Oct 27 13:22:53.095426 systemd[1]: Reached target time-set.target - System Time Set. Oct 27 13:22:53.095432 kernel: fuse: init (API version 7.41) Oct 27 13:22:53.095439 systemd[1]: Starting systemd-remount-fs.service - Remount Root and Kernel File Systems... Oct 27 13:22:53.095445 systemd[1]: Starting systemd-udev-load-credentials.service - Load udev Rules from Credentials... Oct 27 13:22:53.095479 systemd-journald[1540]: Collecting audit messages is enabled. Oct 27 13:22:53.095493 systemd[1]: Starting systemd-udev-trigger.service - Coldplug All udev Devices... Oct 27 13:22:53.095503 systemd-journald[1540]: Journal started Oct 27 13:22:53.095527 systemd-journald[1540]: Runtime Journal (/run/log/journal/b500ae8273514199848372809d9cbc20) is 8M, max 78.3M, 70.3M free. Oct 27 13:22:52.480000 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 Oct 27 13:22:52.985000 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' Oct 27 13:22:52.997000 audit: BPF prog-id=15 op=UNLOAD Oct 27 13:22:52.997000 audit: BPF prog-id=14 op=UNLOAD Oct 27 13:22:52.997000 audit: BPF prog-id=16 op=LOAD Oct 27 13:22:52.997000 audit: BPF prog-id=17 op=LOAD Oct 27 13:22:52.997000 audit: BPF prog-id=18 op=LOAD Oct 27 13:22:53.090000 audit: CONFIG_CHANGE op=set audit_enabled=1 old=1 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 res=1 Oct 27 13:22:53.090000 audit[1540]: SYSCALL arch=c00000b7 syscall=211 success=yes exit=60 a0=4 a1=ffffff203e90 a2=4000 a3=0 items=0 ppid=1 pid=1540 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) Oct 27 13:22:53.090000 audit: PROCTITLE proctitle="/usr/lib/systemd/systemd-journald" Oct 27 13:22:51.931360 systemd[1]: Queued start job for default target multi-user.target. Oct 27 13:22:51.957738 systemd[1]: Unnecessary job was removed for dev-sda6.device - /dev/sda6. Oct 27 13:22:51.961916 systemd[1]: systemd-journald.service: Deactivated successfully. Oct 27 13:22:52.063596 systemd[1]: systemd-journald.service: Consumed 2.569s CPU time over 18.074s wall clock time. Oct 27 13:22:53.057558 systemd-modules-load[1541]: Using 2 probe threads Oct 27 13:22:53.116194 systemd[1]: Started systemd-journald.service - Journal Service. Oct 27 13:22:53.117000 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' Oct 27 13:22:53.119391 systemd[1]: Mounted dev-hugepages.mount - Huge Pages File System. Oct 27 13:22:53.126585 systemd[1]: Mounted dev-mqueue.mount - POSIX Message Queue File System. Oct 27 13:22:53.131739 systemd[1]: Mounted media.mount - External Media Directory. Oct 27 13:22:53.136027 systemd[1]: Mounted sys-kernel-debug.mount - Kernel Debug File System. Oct 27 13:22:53.142703 systemd[1]: Mounted sys-kernel-tracing.mount - Kernel Trace File System. Oct 27 13:22:53.149120 systemd[1]: Mounted tmp.mount - Temporary Directory /tmp. Oct 27 13:22:53.155496 systemd[1]: Finished kmod-static-nodes.service - Create List of Static Device Nodes. Oct 27 13:22:53.160000 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' Oct 27 13:22:53.161223 systemd[1]: modprobe@configfs.service: Deactivated successfully. Oct 27 13:22:53.161445 systemd[1]: Finished modprobe@configfs.service - Load Kernel Module configfs. Oct 27 13:22:53.166000 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' Oct 27 13:22:53.166000 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' Oct 27 13:22:53.166879 systemd[1]: modprobe@efi_pstore.service: Deactivated successfully. Oct 27 13:22:53.167097 systemd[1]: Finished modprobe@efi_pstore.service - Load Kernel Module efi_pstore. Oct 27 13:22:53.172000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=modprobe@efi_pstore comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Oct 27 13:22:53.172000 audit[1]: SERVICE_STOP pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=modprobe@efi_pstore comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Oct 27 13:22:53.173034 systemd[1]: modprobe@fuse.service: Deactivated successfully. Oct 27 13:22:53.173243 systemd[1]: Finished modprobe@fuse.service - Load Kernel Module fuse. Oct 27 13:22:53.177000 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' Oct 27 13:22:53.177000 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' Oct 27 13:22:53.178797 systemd[1]: Finished systemd-modules-load.service - Load Kernel Modules. Oct 27 13:22:53.183000 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' Oct 27 13:22:53.184207 systemd[1]: Finished systemd-network-generator.service - Generate Network Units from Kernel Command Line. Oct 27 13:22:53.189000 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' Oct 27 13:22:53.191450 systemd[1]: Finished systemd-remount-fs.service - Remount Root and Kernel File Systems. Oct 27 13:22:53.196000 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' Oct 27 13:22:53.197284 systemd[1]: Finished systemd-udev-load-credentials.service - Load udev Rules from Credentials. Oct 27 13:22:53.202000 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' Oct 27 13:22:53.211126 systemd[1]: Reached target network-pre.target - Preparation for Network. Oct 27 13:22:53.216706 systemd[1]: Listening on systemd-networkd-resolve-hook.socket - Network Management Resolve Hook Socket. Oct 27 13:22:53.223255 systemd[1]: Mounting sys-fs-fuse-connections.mount - FUSE Control File System... Oct 27 13:22:53.237463 systemd[1]: Mounting sys-kernel-config.mount - Kernel Configuration File System... Oct 27 13:22:53.242594 systemd[1]: remount-root.service - Remount Root File System skipped, unmet condition check ConditionPathIsReadWrite=!/ Oct 27 13:22:53.255183 systemd[1]: Starting systemd-hwdb-update.service - Rebuild Hardware Database... Oct 27 13:22:53.262673 systemd[1]: Starting systemd-journal-flush.service - Flush Journal to Persistent Storage... Oct 27 13:22:53.268372 systemd[1]: systemd-pstore.service - Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore Oct 27 13:22:53.280696 systemd[1]: Starting systemd-random-seed.service - Load/Save OS Random Seed... Oct 27 13:22:53.292993 systemd[1]: Starting systemd-sysctl.service - Apply Kernel Variables... Oct 27 13:22:53.300871 systemd[1]: Starting systemd-tmpfiles-setup-dev-early.service - Create Static Device Nodes in /dev gracefully... Oct 27 13:22:53.307557 systemd[1]: Finished systemd-udev-trigger.service - Coldplug All udev Devices. Oct 27 13:22:53.313000 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' Oct 27 13:22:53.315057 systemd[1]: Mounted sys-fs-fuse-connections.mount - FUSE Control File System. Oct 27 13:22:53.320078 systemd[1]: Mounted sys-kernel-config.mount - Kernel Configuration File System. Oct 27 13:22:53.326574 systemd[1]: Finished systemd-random-seed.service - Load/Save OS Random Seed. Oct 27 13:22:53.333022 systemd[1]: Reached target first-boot-complete.target - First Boot Complete. Oct 27 13:22:53.330000 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' Oct 27 13:22:53.380553 systemd-journald[1540]: Time spent on flushing to /var/log/journal/b500ae8273514199848372809d9cbc20 is 10.683ms for 1143 entries. Oct 27 13:22:53.380553 systemd-journald[1540]: System Journal (/var/log/journal/b500ae8273514199848372809d9cbc20) is 8M, max 2.2G, 2.2G free. Oct 27 13:22:53.390000 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' Oct 27 13:22:53.431450 systemd-journald[1540]: Received client request to flush runtime journal. Oct 27 13:22:53.381898 systemd[1]: Finished flatcar-tmpfiles.service - Create missing system files. Oct 27 13:22:53.432437 systemd[1]: Finished systemd-journal-flush.service - Flush Journal to Persistent Storage. Oct 27 13:22:53.437000 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' Oct 27 13:22:53.457686 systemd[1]: Finished systemd-sysctl.service - Apply Kernel Variables. Oct 27 13:22:53.462000 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' Oct 27 13:22:53.494999 systemd-tmpfiles[1591]: ACLs are not supported, ignoring. Oct 27 13:22:53.495389 systemd-tmpfiles[1591]: ACLs are not supported, ignoring. Oct 27 13:22:53.498066 systemd[1]: Finished systemd-tmpfiles-setup-dev-early.service - Create Static Device Nodes in /dev gracefully. Oct 27 13:22:53.502000 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' Oct 27 13:22:53.504900 systemd[1]: Starting systemd-sysusers.service - Create System Users... Oct 27 13:22:53.631656 systemd[1]: Finished systemd-sysusers.service - Create System Users. Oct 27 13:22:53.635000 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' Oct 27 13:22:53.638498 systemd[1]: Starting systemd-journalctl.socket - Journal Log Access Socket... Oct 27 13:22:53.647000 audit: BPF prog-id=19 op=LOAD Oct 27 13:22:53.647000 audit: BPF prog-id=20 op=LOAD Oct 27 13:22:53.647000 audit: BPF prog-id=21 op=LOAD Oct 27 13:22:53.650682 systemd[1]: Starting systemd-oomd.service - Userspace Out-Of-Memory (OOM) Killer... Oct 27 13:22:53.656000 audit: BPF prog-id=22 op=LOAD Oct 27 13:22:53.659773 systemd[1]: Starting systemd-resolved.service - Network Name Resolution... Oct 27 13:22:53.666107 systemd[1]: Starting systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev... Oct 27 13:22:53.671493 systemd[1]: Listening on systemd-journalctl.socket - Journal Log Access Socket. Oct 27 13:22:53.679665 systemd[1]: Starting modprobe@tun.service - Load Kernel Module tun... Oct 27 13:22:53.685000 audit: BPF prog-id=23 op=LOAD Oct 27 13:22:53.685000 audit: BPF prog-id=24 op=LOAD Oct 27 13:22:53.685000 audit: BPF prog-id=25 op=LOAD Oct 27 13:22:53.688724 systemd[1]: Starting systemd-userdbd.service - User Database Manager... Oct 27 13:22:53.691270 systemd-tmpfiles[1607]: ACLs are not supported, ignoring. Oct 27 13:22:53.692602 systemd-tmpfiles[1607]: ACLs are not supported, ignoring. Oct 27 13:22:53.696188 systemd[1]: Finished systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev. Oct 27 13:22:53.702000 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' Oct 27 13:22:53.703967 systemd[1]: Reached target local-fs-pre.target - Preparation for Local File Systems. Oct 27 13:22:53.709700 systemd[1]: systemd-repart.service - Repartition Root Disk skipped, no trigger condition checks were met. Oct 27 13:22:53.715116 systemd[1]: proc-sys-fs-binfmt_misc.automount: Got automount request for /proc/sys/fs/binfmt_misc, triggered by 1609 ((systemd-userd)) Oct 27 13:22:53.857663 kernel: tun: Universal TUN/TAP device driver, 1.6 Oct 27 13:22:53.857946 systemd[1]: modprobe@tun.service: Deactivated successfully. Oct 27 13:22:53.858162 systemd[1]: Finished modprobe@tun.service - Load Kernel Module tun. Oct 27 13:22:53.862000 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' Oct 27 13:22:53.862000 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' Oct 27 13:22:53.863000 audit: BPF prog-id=26 op=LOAD Oct 27 13:22:53.863000 audit: BPF prog-id=27 op=LOAD Oct 27 13:22:53.863000 audit: BPF prog-id=28 op=LOAD Oct 27 13:22:53.864494 systemd[1]: Starting systemd-nsresourced.service - Namespace Resource Manager... Oct 27 13:22:54.107604 systemd[1]: Mounting proc-sys-fs-binfmt_misc.mount - Arbitrary Executable File Formats File System... Oct 27 13:22:54.112299 systemd[1]: var-lib-machines.mount - Virtual Machine and Container Storage (Compatibility) skipped, unmet condition check ConditionPathExists=/var/lib/machines.raw Oct 27 13:22:54.112336 systemd[1]: Reached target local-fs.target - Local File Systems. Oct 27 13:22:54.116647 systemd[1]: Reached target machines.target - Virtual Machines and Containers. Oct 27 13:22:54.121783 systemd[1]: Listening on systemd-importd.socket - Disk Image Download Service Socket. Oct 27 13:22:54.127632 systemd[1]: Listening on systemd-sysext.socket - System Extension Image Management. Oct 27 13:22:54.133658 systemd[1]: Starting systemd-confext.service - Merge System Configuration Images into /etc/... Oct 27 13:22:54.142781 systemd[1]: Starting systemd-machine-id-commit.service - Save Transient machine-id to Disk... Oct 27 13:22:54.152309 systemd[1]: Starting systemd-userdb-load-credentials.service - Load JSON user/group Records from Credentials... Oct 27 13:22:54.166213 systemd[1]: Finished systemd-hwdb-update.service - Rebuild Hardware Database. Oct 27 13:22:54.170000 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' Oct 27 13:22:54.172619 systemd[1]: Mounted proc-sys-fs-binfmt_misc.mount - Arbitrary Executable File Formats File System. Oct 27 13:22:54.181239 systemd[1]: systemd-binfmt.service - Set Up Additional Binary Formats skipped, no trigger condition checks were met. Oct 27 13:22:54.181000 audit: BPF prog-id=7 op=UNLOAD Oct 27 13:22:54.181000 audit: BPF prog-id=6 op=UNLOAD Oct 27 13:22:54.181000 audit: BPF prog-id=29 op=LOAD Oct 27 13:22:54.181000 audit: BPF prog-id=30 op=LOAD Oct 27 13:22:54.186446 systemd[1]: Starting systemd-udevd.service - Rule-based Manager for Device Events and Files... Oct 27 13:22:54.206663 systemd[1]: Finished systemd-userdb-load-credentials.service - Load JSON user/group Records from Credentials. Oct 27 13:22:54.211000 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' Oct 27 13:22:54.222545 kernel: loop4: detected capacity change from 0 to 44328 Oct 27 13:22:54.229536 kernel: loop4: p1 p2 p3 Oct 27 13:22:54.237118 systemd-nsresourced[1612]: Not setting up BPF subsystem, as functionality has been disabled at compile time. Oct 27 13:22:54.238283 systemd[1]: Started systemd-nsresourced.service - Namespace Resource Manager. Oct 27 13:22:54.243000 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' Oct 27 13:22:54.246131 systemd[1]: Started systemd-userdbd.service - User Database Manager. Oct 27 13:22:54.250000 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' Oct 27 13:22:54.281010 kernel: device-mapper: verity: sha256 using shash "sha256-ce" Oct 27 13:22:54.281344 kernel: device-mapper: verity: Unrecognized verity feature request: root_hash_sig_key_desc Oct 27 13:22:54.286542 kernel: device-mapper: table: 254:5: verity: Unrecognized verity feature request (-EINVAL) Oct 27 13:22:54.286817 kernel: device-mapper: ioctl: error adding target to table Oct 27 13:22:54.289850 systemd-confext[1619]: device-mapper: reload ioctl on loop4p1-53-verity (254:5) failed: Invalid argument Oct 27 13:22:54.299576 kernel: device-mapper: verity: sha256 using shash "sha256-ce" Oct 27 13:22:54.302786 systemd[1]: Finished systemd-machine-id-commit.service - Save Transient machine-id to Disk. Oct 27 13:22:54.311000 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' Oct 27 13:22:54.335713 systemd-oomd[1605]: No swap; memory pressure usage will be degraded Oct 27 13:22:54.336402 systemd[1]: Started systemd-oomd.service - Userspace Out-Of-Memory (OOM) Killer. Oct 27 13:22:54.342000 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' Oct 27 13:22:54.382036 systemd-resolved[1606]: Positive Trust Anchors: Oct 27 13:22:54.382057 systemd-resolved[1606]: . IN DS 20326 8 2 e06d44b80b8f1d39a95c0b0d7c65d08458e880409bbc683457104237c7f8ec8d Oct 27 13:22:54.382060 systemd-resolved[1606]: . IN DS 38696 8 2 683d2d0acb8c9b712a1948b27f741219298d0a450d612c483af444a4c0fb2b16 Oct 27 13:22:54.382083 systemd-resolved[1606]: 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 Oct 27 13:22:54.444693 systemd-resolved[1606]: Using system hostname 'ci-4757.2.3-a-3f79c203c6'. Oct 27 13:22:54.446201 systemd[1]: Started systemd-resolved.service - Network Name Resolution. Oct 27 13:22:54.450000 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' Oct 27 13:22:54.451218 systemd[1]: Reached target nss-lookup.target - Host and Network Name Lookups. Oct 27 13:22:54.462916 systemd-udevd[1623]: Using default interface naming scheme 'v260'. Oct 27 13:22:54.658291 systemd[1]: Started systemd-udevd.service - Rule-based Manager for Device Events and Files. Oct 27 13:22:54.663000 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' Oct 27 13:22:54.664000 audit: BPF prog-id=31 op=LOAD Oct 27 13:22:54.665489 systemd[1]: Starting systemd-networkd.service - Network Management... Oct 27 13:22:54.741055 systemd[1]: Condition check resulted in dev-ttyAMA0.device - /dev/ttyAMA0 being skipped. Oct 27 13:22:54.825947 systemd-networkd[1643]: lo: Link UP Oct 27 13:22:54.825959 systemd-networkd[1643]: lo: Gained carrier Oct 27 13:22:54.827575 systemd[1]: Started systemd-networkd.service - Network Management. Oct 27 13:22:54.832587 systemd-networkd[1643]: eth0: Found matching .network file, based on potentially unpredictable interface name: /usr/lib/systemd/network/zz-default.network Oct 27 13:22:54.832596 systemd-networkd[1643]: eth0: Configuring with /usr/lib/systemd/network/zz-default.network. Oct 27 13:22:54.834000 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' Oct 27 13:22:54.835618 systemd[1]: Reached target network.target - Network. Oct 27 13:22:54.843179 systemd[1]: Starting systemd-networkd-persistent-storage.service - Enable Persistent Storage in systemd-networkd... Oct 27 13:22:54.851635 systemd[1]: Starting systemd-networkd-wait-online.service - Wait for Network to be Online... Oct 27 13:22:54.871774 kernel: mousedev: PS/2 mouse device common for all mice Oct 27 13:22:54.871853 kernel: hv_storvsc f8b3781a-1e82-4818-a1c3-63d806ec15bb: tag#46 cmd 0x85 status: scsi 0x2 srb 0x6 hv 0xc0000001 Oct 27 13:22:54.891184 kernel: hv_vmbus: registering driver hv_balloon Oct 27 13:22:54.891256 kernel: hv_balloon: Using Dynamic Memory protocol version 2.0 Oct 27 13:22:54.895265 kernel: hv_balloon: Memory hot add disabled on ARM64 Oct 27 13:22:54.904937 kernel: mlx5_core acab:00:02.0 enP44203s1: Link up Oct 27 13:22:54.905232 kernel: hv_vmbus: registering driver hyperv_fb Oct 27 13:22:54.916220 kernel: hyperv_fb: Synthvid Version major 3, minor 5 Oct 27 13:22:54.916274 kernel: hyperv_fb: Screen resolution: 1024x768, Color depth: 32, Frame buffer size: 8388608 Oct 27 13:22:54.923163 kernel: Console: switching to colour dummy device 80x25 Oct 27 13:22:54.936441 kernel: hv_netvsc 0022487c-b89d-0022-487c-b89d0022487c eth0: Data path switched to VF: enP44203s1 Oct 27 13:22:54.936726 kernel: Console: switching to colour frame buffer device 128x48 Oct 27 13:22:54.938546 systemd-networkd[1643]: enP44203s1: Link UP Oct 27 13:22:54.938831 systemd-networkd[1643]: eth0: Link UP Oct 27 13:22:54.939028 systemd-networkd[1643]: eth0: Gained carrier Oct 27 13:22:54.939104 systemd-networkd[1643]: eth0: Found matching .network file, based on potentially unpredictable interface name: /usr/lib/systemd/network/zz-default.network Oct 27 13:22:54.943889 systemd-networkd[1643]: enP44203s1: Gained carrier Oct 27 13:22:54.945140 systemd[1]: Finished systemd-networkd-persistent-storage.service - Enable Persistent Storage in systemd-networkd. Oct 27 13:22:54.953000 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' Oct 27 13:22:54.955592 systemd-networkd[1643]: eth0: DHCPv4 address 10.0.0.12/24, gateway 10.0.0.1 acquired from 168.63.129.16 Oct 27 13:22:54.971200 systemd[1]: Condition check resulted in dev-ptp_hyperv.device - /dev/ptp_hyperv being skipped. Oct 27 13:22:55.005550 kernel: MACsec IEEE 802.1AE Oct 27 13:22:55.074801 systemd[1]: Starting systemd-vconsole-setup.service - Virtual Console Setup... Oct 27 13:22:55.106421 systemd[1]: etc-machine\x2did.mount: Deactivated successfully. Oct 27 13:22:55.155639 systemd[1]: Found device dev-disk-by\x2dlabel-OEM.device - Virtual_Disk OEM. Oct 27 13:22:55.169669 systemd[1]: Starting systemd-fsck@dev-disk-by\x2dlabel-OEM.service - File System Check on /dev/disk/by-label/OEM... Oct 27 13:22:55.178852 systemd[1]: systemd-vconsole-setup.service: Deactivated successfully. Oct 27 13:22:55.179698 systemd[1]: Stopped systemd-vconsole-setup.service - Virtual Console Setup. Oct 27 13:22:55.184000 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' Oct 27 13:22:55.184000 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' Oct 27 13:22:55.187242 systemd[1]: Starting systemd-vconsole-setup.service - Virtual Console Setup... Oct 27 13:22:55.230542 kernel: erofs: (device dm-5): mounted with root inode @ nid 40. Oct 27 13:22:55.260548 kernel: loop4: detected capacity change from 0 to 44328 Oct 27 13:22:55.266537 kernel: loop4: p1 p2 p3 Oct 27 13:22:55.280278 kernel: device-mapper: verity: sha256 using shash "sha256-ce" Oct 27 13:22:55.280382 kernel: device-mapper: verity: Unrecognized verity feature request: root_hash_sig_key_desc Oct 27 13:22:55.280380 systemd[1]: Finished systemd-fsck@dev-disk-by\x2dlabel-OEM.service - File System Check on /dev/disk/by-label/OEM. Oct 27 13:22:55.280478 kernel: device-mapper: table: 254:5: verity: Unrecognized verity feature request (-EINVAL) Oct 27 13:22:55.285718 (sd-merge)[1776]: device-mapper: reload ioctl on loop4p1-58-verity (254:5) failed: Invalid argument Oct 27 13:22:55.288862 kernel: device-mapper: ioctl: error adding target to table Oct 27 13:22:55.296000 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' Oct 27 13:22:55.305547 kernel: device-mapper: verity: sha256 using shash "sha256-ce" Oct 27 13:22:55.318416 (sd-merge)[1776]: Skipping extension refresh because no change was found, use --always-refresh=yes to always do a refresh. Oct 27 13:22:55.318817 kernel: erofs: (device dm-5): mounted with root inode @ nid 40. Oct 27 13:22:55.320801 systemd[1]: Finished systemd-confext.service - Merge System Configuration Images into /etc/. Oct 27 13:22:55.326000 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' Oct 27 13:22:55.329687 systemd[1]: Starting systemd-sysext.service - Merge System Extension Images into /usr/ and /opt/... Oct 27 13:22:55.349540 kernel: loop4: detected capacity change from 0 to 142648 Oct 27 13:22:55.356558 kernel: loop4: p1 p2 p3 Oct 27 13:22:55.372477 kernel: device-mapper: verity: sha256 using shash "sha256-ce" Oct 27 13:22:55.372566 kernel: device-mapper: verity: Unrecognized verity feature request: root_hash_sig_key_desc Oct 27 13:22:55.372589 kernel: device-mapper: table: 254:5: verity: Unrecognized verity feature request (-EINVAL) Oct 27 13:22:55.380090 kernel: device-mapper: ioctl: error adding target to table Oct 27 13:22:55.380078 systemd-sysext[1786]: device-mapper: reload ioctl on loop4p1-62-verity (254:5) failed: Invalid argument Oct 27 13:22:55.389626 kernel: device-mapper: verity: sha256 using shash "sha256-ce" Oct 27 13:22:55.408553 kernel: erofs: (device dm-5): mounted with root inode @ nid 39. Oct 27 13:22:55.432591 kernel: loop4: detected capacity change from 0 to 364712 Oct 27 13:22:55.441546 kernel: loop4: p1 p2 p3 Oct 27 13:22:55.454532 kernel: device-mapper: verity: sha256 using shash "sha256-ce" Oct 27 13:22:55.454586 kernel: device-mapper: verity: Unrecognized verity feature request: root_hash_sig_key_desc Oct 27 13:22:55.454655 kernel: device-mapper: table: 254:5: verity: Unrecognized verity feature request (-EINVAL) Oct 27 13:22:55.461233 kernel: device-mapper: ioctl: error adding target to table Oct 27 13:22:55.462214 systemd-sysext[1786]: device-mapper: reload ioctl on loop4p1-67-verity (254:5) failed: Invalid argument Oct 27 13:22:55.472593 kernel: device-mapper: verity: sha256 using shash "sha256-ce" Oct 27 13:22:55.493753 kernel: erofs: (device dm-5): mounted with root inode @ nid 39. Oct 27 13:22:55.516549 kernel: loop4: detected capacity change from 0 to 172608 Oct 27 13:22:55.523680 kernel: loop4: p1 p2 p3 Oct 27 13:22:55.541370 kernel: device-mapper: verity: sha256 using shash "sha256-ce" Oct 27 13:22:55.541444 kernel: device-mapper: verity: Unrecognized verity feature request: root_hash_sig_key_desc Oct 27 13:22:55.546678 kernel: device-mapper: table: 254:5: verity: Unrecognized verity feature request (-EINVAL) Oct 27 13:22:55.550000 kernel: device-mapper: ioctl: error adding target to table Oct 27 13:22:55.550079 systemd-sysext[1786]: device-mapper: reload ioctl on loop4p1-72-verity (254:5) failed: Invalid argument Oct 27 13:22:55.556567 kernel: device-mapper: verity: sha256 using shash "sha256-ce" Oct 27 13:22:55.579548 kernel: erofs: (device dm-5): mounted with root inode @ nid 39. Oct 27 13:22:55.605556 kernel: loop4: detected capacity change from 0 to 142648 Oct 27 13:22:55.614549 kernel: loop4: p1 p2 p3 Oct 27 13:22:55.628517 kernel: device-mapper: verity: sha256 using shash "sha256-ce" Oct 27 13:22:55.629268 kernel: device-mapper: verity: Unrecognized verity feature request: root_hash_sig_key_desc Oct 27 13:22:55.629302 kernel: device-mapper: table: 254:5: verity: Unrecognized verity feature request (-EINVAL) Oct 27 13:22:55.637972 kernel: device-mapper: ioctl: error adding target to table Oct 27 13:22:55.639885 (sd-merge)[1810]: device-mapper: reload ioctl on loop4p1-77-verity (254:5) failed: Invalid argument Oct 27 13:22:55.652634 kernel: device-mapper: verity: sha256 using shash "sha256-ce" Oct 27 13:22:55.678549 kernel: erofs: (device dm-5): mounted with root inode @ nid 39. Oct 27 13:22:55.684600 kernel: loop5: detected capacity change from 0 to 364712 Oct 27 13:22:55.691546 kernel: loop5: p1 p2 p3 Oct 27 13:22:55.696144 systemd-vconsole-setup[1770]: Configuration of first virtual console was skipped, ignoring remaining ones. Oct 27 13:22:55.704805 kernel: device-mapper: verity: sha256 using shash "sha256-ce" Oct 27 13:22:55.704900 kernel: device-mapper: verity: Unrecognized verity feature request: root_hash_sig_key_desc Oct 27 13:22:55.710089 kernel: device-mapper: table: 254:6: verity: Unrecognized verity feature request (-EINVAL) Oct 27 13:22:55.710687 systemd[1]: Finished systemd-vconsole-setup.service - Virtual Console Setup. Oct 27 13:22:55.713894 kernel: device-mapper: ioctl: error adding target to table Oct 27 13:22:55.714283 (sd-merge)[1810]: device-mapper: reload ioctl on loop5p1-81-verity (254:6) failed: Invalid argument Oct 27 13:22:55.718000 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' Oct 27 13:22:55.725576 kernel: device-mapper: verity: sha256 using shash "sha256-ce" Oct 27 13:22:55.751559 kernel: erofs: (device dm-6): mounted with root inode @ nid 39. Oct 27 13:22:55.757577 kernel: loop6: detected capacity change from 0 to 172608 Oct 27 13:22:55.770555 kernel: loop6: p1 p2 p3 Oct 27 13:22:55.785943 kernel: device-mapper: verity: sha256 using shash "sha256-ce" Oct 27 13:22:55.786019 kernel: device-mapper: verity: Unrecognized verity feature request: root_hash_sig_key_desc Oct 27 13:22:55.790934 kernel: device-mapper: table: 254:7: verity: Unrecognized verity feature request (-EINVAL) Oct 27 13:22:55.795551 kernel: device-mapper: ioctl: error adding target to table Oct 27 13:22:55.796679 (sd-merge)[1810]: device-mapper: reload ioctl on loop6p1-85-verity (254:7) failed: Invalid argument Oct 27 13:22:55.806544 kernel: device-mapper: verity: sha256 using shash "sha256-ce" Oct 27 13:22:55.830579 kernel: erofs: (device dm-7): mounted with root inode @ nid 39. Oct 27 13:22:55.831056 (sd-merge)[1810]: Skipping extension refresh because no change was found, use --always-refresh=yes to always do a refresh. Oct 27 13:22:55.835871 systemd[1]: Finished systemd-sysext.service - Merge System Extension Images into /usr/ and /opt/. Oct 27 13:22:55.840000 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' Oct 27 13:22:55.843287 systemd[1]: Starting systemd-tmpfiles-setup.service - Create System Files and Directories... Oct 27 13:22:55.869991 systemd-tmpfiles[1834]: /usr/lib/tmpfiles.d/base_image_var.conf:29: Duplicate line for path "/var/log/audit", ignoring. Oct 27 13:22:55.871788 systemd-tmpfiles[1834]: /usr/lib/tmpfiles.d/base_image_var_late.conf:44: Duplicate line for path "/var/log/audit", ignoring. Oct 27 13:22:55.871989 systemd-tmpfiles[1834]: /usr/lib/tmpfiles.d/baselayout.conf:15: Duplicate line for path "/var", ignoring. Oct 27 13:22:55.871997 systemd-tmpfiles[1834]: /usr/lib/tmpfiles.d/baselayout.conf:16: Duplicate line for path "/var/empty", ignoring. Oct 27 13:22:55.872007 systemd-tmpfiles[1834]: /usr/lib/tmpfiles.d/baselayout.conf:21: Duplicate line for path "/var/log", ignoring. Oct 27 13:22:55.872092 systemd-tmpfiles[1834]: /usr/lib/tmpfiles.d/dbus.conf:5: Duplicate line for path "/var/lib/dbus", ignoring. Oct 27 13:22:55.872295 systemd-tmpfiles[1834]: /usr/lib/tmpfiles.d/nfs-utils.conf:2: Duplicate line for path "/var/lib/nfs/v4recovery", ignoring. Oct 27 13:22:55.889955 systemd-tmpfiles[1834]: /usr/lib/tmpfiles.d/nfs-utils.conf:6: Duplicate line for path "/var/lib/nfs/sm", ignoring. Oct 27 13:22:55.889980 systemd-tmpfiles[1834]: /usr/lib/tmpfiles.d/nfs-utils.conf:7: Duplicate line for path "/var/lib/nfs/sm.bak", ignoring. Oct 27 13:22:55.890176 systemd-tmpfiles[1834]: /usr/lib/tmpfiles.d/provision.conf:20: Duplicate line for path "/root", ignoring. Oct 27 13:22:55.890883 systemd-tmpfiles[1834]: /usr/lib/tmpfiles.d/tpm2-tss-fapi.conf:2: Duplicate line for path "/var/lib/tpm2-tss/system/keystore", ignoring. Oct 27 13:22:55.890895 systemd-tmpfiles[1834]: ACLs are not supported, ignoring. Oct 27 13:22:55.890926 systemd-tmpfiles[1834]: ACLs are not supported, ignoring. Oct 27 13:22:55.892083 systemd-tmpfiles[1834]: /usr/lib/tmpfiles.d/var.conf:10: Duplicate line for path "/var", ignoring. Oct 27 13:22:55.892101 systemd-tmpfiles[1834]: /usr/lib/tmpfiles.d/var.conf:14: Duplicate line for path "/var/log", ignoring. Oct 27 13:22:55.892150 systemd-tmpfiles[1834]: /usr/lib/tmpfiles.d/var.conf:21: Duplicate line for path "/var/lib", ignoring. Oct 27 13:22:55.894802 systemd-tmpfiles[1834]: Detected autofs mount point '/boot' during canonicalization of 'boot'. Oct 27 13:22:55.894814 systemd-tmpfiles[1834]: Skipping /boot Oct 27 13:22:55.900479 systemd-tmpfiles[1834]: Detected autofs mount point '/boot' during canonicalization of 'boot'. Oct 27 13:22:55.900495 systemd-tmpfiles[1834]: Skipping /boot Oct 27 13:22:55.908259 systemd[1]: Finished systemd-tmpfiles-setup.service - Create System Files and Directories. Oct 27 13:22:55.914000 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' Oct 27 13:22:55.916231 systemd[1]: Starting audit-rules.service - Load Audit Rules... Oct 27 13:22:55.925768 systemd[1]: Starting clean-ca-certificates.service - Clean up broken links in /etc/ssl/certs... Oct 27 13:22:55.934481 systemd[1]: Starting ldconfig.service - Rebuild Dynamic Linker Cache... Oct 27 13:22:55.943704 systemd[1]: Starting systemd-journal-catalog-update.service - Rebuild Journal Catalog... Oct 27 13:22:55.950687 systemd[1]: Starting systemd-update-utmp.service - Record System Boot/Shutdown in UTMP... Oct 27 13:22:55.968000 audit[1840]: AUDIT1127 pid=1840 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' Oct 27 13:22:55.971940 systemd[1]: Finished systemd-update-utmp.service - Record System Boot/Shutdown in UTMP. Oct 27 13:22:55.976000 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' Oct 27 13:22:56.039699 systemd[1]: Finished systemd-journal-catalog-update.service - Rebuild Journal Catalog. Oct 27 13:22:56.044000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=systemd-journal-catalog-update comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Oct 27 13:22:56.145000 audit: CONFIG_CHANGE auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 op=add_rule key=(null) list=5 res=1 Oct 27 13:22:56.145000 audit[1864]: SYSCALL arch=c00000b7 syscall=206 success=yes exit=1056 a0=3 a1=ffffdcbfe170 a2=420 a3=0 items=0 ppid=1836 pid=1864 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) Oct 27 13:22:56.145000 audit: PROCTITLE proctitle=2F7362696E2F617564697463746C002D52002F6574632F61756469742F61756469742E72756C6573 Oct 27 13:22:56.146158 augenrules[1864]: No rules Oct 27 13:22:56.147674 systemd[1]: audit-rules.service: Deactivated successfully. Oct 27 13:22:56.147937 systemd[1]: Finished audit-rules.service - Load Audit Rules. Oct 27 13:22:56.371734 systemd[1]: Finished clean-ca-certificates.service - Clean up broken links in /etc/ssl/certs. Oct 27 13:22:56.377076 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 Oct 27 13:22:56.960699 systemd-networkd[1643]: eth0: Gained IPv6LL Oct 27 13:22:56.962840 systemd[1]: Finished systemd-networkd-wait-online.service - Wait for Network to be Online. Oct 27 13:22:56.968185 systemd[1]: Reached target network-online.target - Network is Online. Oct 27 13:23:02.721536 ldconfig[1838]: ldconfig: /usr/lib/ld.so.conf is not an ELF file - it has the wrong magic bytes at the start. Oct 27 13:23:02.737158 systemd[1]: Finished ldconfig.service - Rebuild Dynamic Linker Cache. Oct 27 13:23:02.745214 systemd[1]: Starting systemd-update-done.service - Update is Completed... Oct 27 13:23:02.763000 systemd[1]: Finished systemd-update-done.service - Update is Completed. Oct 27 13:23:02.767933 systemd[1]: Reached target sysinit.target - System Initialization. Oct 27 13:23:02.772982 systemd[1]: Started motdgen.path - Watch for update engine configuration changes. Oct 27 13:23:02.778926 systemd[1]: Started user-cloudinit@var-lib-flatcar\x2dinstall-user_data.path - Watch for a cloud-config at /var/lib/flatcar-install/user_data. Oct 27 13:23:02.784953 systemd[1]: Started logrotate.timer - Daily rotation of log files. Oct 27 13:23:02.790227 systemd[1]: Started mdadm.timer - Weekly check for MD array's redundancy information.. Oct 27 13:23:02.795774 systemd[1]: Started systemd-sysupdate-reboot.timer - Reboot Automatically After System Update. Oct 27 13:23:02.801072 systemd[1]: Started systemd-sysupdate.timer - Automatic System Update. Oct 27 13:23:02.806172 systemd[1]: Started systemd-tmpfiles-clean.timer - Daily Cleanup of Temporary Directories. Oct 27 13:23:02.811636 systemd[1]: update-engine-stub.timer - Update Engine Stub Timer skipped, unmet condition check ConditionPathExists=/usr/.noupdate Oct 27 13:23:02.811671 systemd[1]: Reached target paths.target - Path Units. Oct 27 13:23:02.815568 systemd[1]: Reached target timers.target - Timer Units. Oct 27 13:23:02.820872 systemd[1]: Listening on dbus.socket - D-Bus System Message Bus Socket. Oct 27 13:23:02.827356 systemd[1]: Starting docker.socket - Docker Socket for the API... Oct 27 13:23:02.832755 systemd[1]: Listening on sshd-unix-local.socket - OpenSSH Server Socket (systemd-ssh-generator, AF_UNIX Local). Oct 27 13:23:02.840926 systemd[1]: Listening on sshd.socket - OpenSSH Server Socket. Oct 27 13:23:02.846135 systemd[1]: Listening on systemd-hostnamed.socket - Hostname Service Socket. Oct 27 13:23:02.868451 systemd[1]: Listening on systemd-logind-varlink.socket - User Login Management Varlink Socket. Oct 27 13:23:02.874509 systemd[1]: Listening on systemd-machined.socket - Virtual Machine and Container Registration Service Socket. Oct 27 13:23:02.880727 systemd[1]: Listening on docker.socket - Docker Socket for the API. Oct 27 13:23:02.885965 systemd[1]: Reached target sockets.target - Socket Units. Oct 27 13:23:02.890005 systemd[1]: Reached target basic.target - Basic System. Oct 27 13:23:02.894593 systemd[1]: addon-config@oem.service - Configure Addon /oem skipped, no trigger condition checks were met. Oct 27 13:23:02.894620 systemd[1]: addon-run@oem.service - Run Addon /oem skipped, no trigger condition checks were met. Oct 27 13:23:02.896572 systemd[1]: Starting chronyd.service - NTP client/server... Oct 27 13:23:02.910658 systemd[1]: Starting containerd.service - containerd container runtime... Oct 27 13:23:02.921700 systemd[1]: Starting dbus.service - D-Bus System Message Bus... Oct 27 13:23:02.928082 systemd[1]: Starting dracut-shutdown.service - Restore /run/initramfs on shutdown... Oct 27 13:23:02.938999 chronyd[1878]: chronyd version 4.8 starting (+CMDMON +REFCLOCK +RTC +PRIVDROP +SCFILTER -SIGND +NTS +SECHASH +IPV6 -DEBUG) Oct 27 13:23:02.940455 chronyd[1878]: Timezone right/UTC failed leap second check, ignoring Oct 27 13:23:02.940938 chronyd[1878]: Loaded seccomp filter (level 2) Oct 27 13:23:02.942273 systemd[1]: Starting enable-oem-cloudinit.service - Enable cloudinit... Oct 27 13:23:02.947764 systemd[1]: Starting extend-filesystems.service - Extend Filesystems... Oct 27 13:23:02.952456 systemd[1]: flatcar-setup-environment.service - Modifies /etc/environment for CoreOS skipped, unmet condition check ConditionPathExists=/oem/bin/flatcar-setup-environment Oct 27 13:23:02.955721 systemd[1]: Started hv_kvp_daemon.service - Hyper-V KVP daemon. Oct 27 13:23:02.960475 systemd[1]: hv_vss_daemon.service - Hyper-V VSS daemon skipped, unmet condition check ConditionPathExists=/dev/vmbus/hv_vss Oct 27 13:23:02.962276 systemd[1]: Starting motdgen.service - Generate /run/flatcar/motd... Oct 27 13:23:02.967862 KVP[1884]: KVP starting; pid is:1884 Oct 27 13:23:02.970200 jq[1882]: false Oct 27 13:23:02.970160 KVP[1884]: KVP LIC Version: 3.1 Oct 27 13:23:02.973222 systemd[1]: Starting nvidia.service - NVIDIA Configure Service... Oct 27 13:23:02.977157 kernel: hv_utils: KVP IC version 4.0 Oct 27 13:23:02.979489 systemd[1]: Starting ssh-key-proc-cmdline.service - Install an ssh key from /proc/cmdline... Oct 27 13:23:02.987195 systemd[1]: Starting sshd-keygen.service - Generate sshd host keys... Oct 27 13:23:03.000262 systemd[1]: Starting systemd-logind.service - User Login Management... Oct 27 13:23:03.006869 systemd[1]: tcsd.service - TCG Core Services Daemon skipped, unmet condition check ConditionPathExists=/dev/tpm0 Oct 27 13:23:03.009753 systemd[1]: Starting update-engine.service - Update Engine... Oct 27 13:23:03.015397 systemd[1]: Starting update-ssh-keys-after-ignition.service - Run update-ssh-keys once after Ignition... Oct 27 13:23:03.018086 extend-filesystems[1883]: Found /dev/sda6 Oct 27 13:23:03.022672 systemd[1]: Started chronyd.service - NTP client/server. Oct 27 13:23:03.032855 motdgen[1909]: /oem/oem-release: line 2: Azure: command not found Oct 27 13:23:03.034902 systemd[1]: Finished dracut-shutdown.service - Restore /run/initramfs on shutdown. Oct 27 13:23:03.042784 jq[1900]: true Oct 27 13:23:03.043289 systemd[1]: enable-oem-cloudinit.service: Skipped due to 'exec-condition'. Oct 27 13:23:03.045665 extend-filesystems[1883]: Found /dev/sda9 Oct 27 13:23:03.043512 systemd[1]: Condition check resulted in enable-oem-cloudinit.service - Enable cloudinit being skipped. Oct 27 13:23:03.068199 extend-filesystems[1883]: Checking size of /dev/sda9 Oct 27 13:23:03.043714 systemd[1]: ssh-key-proc-cmdline.service: Deactivated successfully. Oct 27 13:23:03.043889 systemd[1]: Finished ssh-key-proc-cmdline.service - Install an ssh key from /proc/cmdline. Oct 27 13:23:03.059922 systemd[1]: motdgen.service: Deactivated successfully. Oct 27 13:23:03.060168 systemd[1]: Finished motdgen.service - Generate /run/flatcar/motd. Oct 27 13:23:03.092070 extend-filesystems[1883]: Resized partition /dev/sda9 Oct 27 13:23:03.101618 update_engine[1899]: I20261027 13:23:03.087239 1899 main.cc:92] Flatcar Update Engine starting Oct 27 13:23:03.086791 systemd[1]: Finished nvidia.service - NVIDIA Configure Service. Oct 27 13:23:03.101902 jq[1918]: true Oct 27 13:23:03.126674 extend-filesystems[1936]: resize2fs 1.47.4 (6-Mar-2025) Oct 27 13:23:03.137260 systemd-logind[1892]: New seat seat0. Oct 27 13:23:03.138541 systemd-logind[1892]: Watching system buttons on /dev/input/event1 (AT Translated Set 2 keyboard) Oct 27 13:23:03.138993 systemd[1]: Started systemd-logind.service - User Login Management. Oct 27 13:23:03.160750 kernel: EXT4-fs (sda9): resizing filesystem from 6359552 to 6376955 blocks Oct 27 13:23:03.160828 kernel: EXT4-fs (sda9): resized filesystem to 6376955 Oct 27 13:23:03.202268 extend-filesystems[1936]: Filesystem at /dev/sda9 is mounted on /; on-line resizing required Oct 27 13:23:03.202268 extend-filesystems[1936]: old_desc_blocks = 4, new_desc_blocks = 4 Oct 27 13:23:03.202268 extend-filesystems[1936]: The filesystem on /dev/sda9 is now 6376955 (4k) blocks long. Oct 27 13:23:03.230504 extend-filesystems[1883]: Resized filesystem in /dev/sda9 Oct 27 13:23:03.208997 systemd[1]: extend-filesystems.service: Deactivated successfully. Oct 27 13:23:03.211638 systemd[1]: Finished extend-filesystems.service - Extend Filesystems. Oct 27 13:23:03.235186 bash[1954]: Updated "/home/core/.ssh/authorized_keys" Oct 27 13:23:03.236440 systemd[1]: Finished update-ssh-keys-after-ignition.service - Run update-ssh-keys once after Ignition. Oct 27 13:23:03.242568 systemd[1]: sshkeys.service skipped, no trigger condition checks were met. Oct 27 13:23:03.258082 sshd_keygen[1898]: ssh-keygen: generating new host keys: RSA ECDSA ED25519 MLDSA44-ED25519 Oct 27 13:23:03.280042 dbus-daemon[1880]: [system] SELinux support is enabled Oct 27 13:23:03.280296 systemd[1]: Started dbus.service - D-Bus System Message Bus. Oct 27 13:23:03.285474 update_engine[1899]: I20261027 13:23:03.283820 1899 update_check_scheduler.cc:74] Next update check in 12m0s Oct 27 13:23:03.288890 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 Oct 27 13:23:03.288939 systemd[1]: Reached target system-config.target - Load system-provided cloud configs. Oct 27 13:23:03.297240 systemd[1]: user-cloudinit-proc-cmdline.service - Load cloud-config from url defined in /proc/cmdline skipped, unmet condition check ConditionKernelCommandLine=cloud-config-url Oct 27 13:23:03.297272 systemd[1]: Reached target user-config.target - Load user-provided cloud configs. Oct 27 13:23:03.306393 systemd[1]: Finished sshd-keygen.service - Generate sshd host keys. Oct 27 13:23:03.330398 dbus-daemon[1880]: [system] Successfully activated service 'org.freedesktop.systemd1' Oct 27 13:23:03.337295 systemd[1]: Started update-engine.service - Update Engine. Oct 27 13:23:03.356243 systemd[1]: Starting issuegen.service - Generate /run/issue... Oct 27 13:23:03.370904 systemd[1]: Starting waagent.service - Microsoft Azure Linux Agent... Oct 27 13:23:03.379178 systemd[1]: Started locksmithd.service - Cluster reboot manager. Oct 27 13:23:03.389469 systemd[1]: issuegen.service: Deactivated successfully. Oct 27 13:23:03.390614 systemd[1]: Finished issuegen.service - Generate /run/issue. Oct 27 13:23:03.399800 systemd[1]: Starting systemd-user-sessions.service - Permit User Sessions... Oct 27 13:23:03.412229 systemd[1]: Started waagent.service - Microsoft Azure Linux Agent. Oct 27 13:23:03.424773 systemd[1]: Finished systemd-user-sessions.service - Permit User Sessions. Oct 27 13:23:03.434878 systemd[1]: Started getty@tty1.service - Getty on tty1. Oct 27 13:23:03.441852 systemd[1]: Started serial-getty@ttyAMA0.service - Serial Getty on ttyAMA0. Oct 27 13:23:03.446965 systemd[1]: Reached target getty.target - Login Prompts. Oct 27 13:23:03.613852 locksmithd[2042]: locksmithd starting currentOperation="UPDATE_STATUS_IDLE" strategy="reboot" Oct 27 13:23:07.129548 waagent[2052]: 2026-10-27T13:23:07.129184Z INFO Daemon Daemon Azure Linux Agent Version: 2.12.0.4 Oct 27 13:23:07.134074 waagent[2052]: 2026-10-27T13:23:07.134026Z INFO Daemon Daemon OS: flatcar 4757.2.3 Oct 27 13:23:07.137591 waagent[2052]: 2026-10-27T13:23:07.137556Z INFO Daemon Daemon Python: 3.12.13 Oct 27 13:23:07.142072 waagent[2052]: 2026-10-27T13:23:07.141392Z INFO Daemon Daemon Run daemon Oct 27 13:23:07.145301 waagent[2052]: 2026-10-27T13:23:07.145169Z INFO Daemon Daemon No RDMA handler exists for distro='Flatcar Container Linux by Kinvolk' version='4757.2.3' Oct 27 13:23:07.152709 waagent[2052]: 2026-10-27T13:23:07.152665Z INFO Daemon Daemon Using waagent for provisioning Oct 27 13:23:07.157343 waagent[2052]: 2026-10-27T13:23:07.157306Z INFO Daemon Daemon Activate resource disk Oct 27 13:23:07.160985 waagent[2052]: 2026-10-27T13:23:07.160950Z INFO Daemon Daemon Searching gen1 prefix 00000000-0001 or gen2 f8b3781a-1e82-4818-a1c3-63d806ec15bb Oct 27 13:23:07.169881 waagent[2052]: 2026-10-27T13:23:07.169835Z INFO Daemon Daemon Found device: None Oct 27 13:23:07.173493 waagent[2052]: 2026-10-27T13:23:07.173457Z ERROR Daemon Daemon Failed to mount resource disk [ResourceDiskError] unable to detect disk topology Oct 27 13:23:07.180074 waagent[2052]: 2026-10-27T13:23:07.180040Z ERROR Daemon Daemon Event: name=WALinuxAgent, op=ActivateResourceDisk, message=[ResourceDiskError] unable to detect disk topology, duration=0 Oct 27 13:23:07.189750 waagent[2052]: 2026-10-27T13:23:07.189705Z INFO Daemon Daemon Clean protocol and wireserver endpoint Oct 27 13:23:07.194327 waagent[2052]: 2026-10-27T13:23:07.194295Z INFO Daemon Daemon Running default provisioning handler Oct 27 13:23:07.204641 waagent[2052]: 2026-10-27T13:23:07.204602Z 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. Oct 27 13:23:07.216070 waagent[2052]: 2026-10-27T13:23:07.216018Z INFO Daemon Daemon Unable to get cloud-init enabled status from service: [Errno 2] No such file or directory: 'service' Oct 27 13:23:07.223492 waagent[2052]: 2026-10-27T13:23:07.223452Z INFO Daemon Daemon cloud-init is enabled: False Oct 27 13:23:07.227915 waagent[2052]: 2026-10-27T13:23:07.227880Z INFO Daemon Daemon Copying ovf-env.xml Oct 27 13:23:07.351417 waagent[2052]: 2026-10-27T13:23:07.351331Z INFO Daemon Daemon Successfully mounted dvd Oct 27 13:23:07.512471 systemd[1]: mnt-cdrom-secure.mount: Deactivated successfully. Oct 27 13:23:07.515057 waagent[2052]: 2026-10-27T13:23:07.514989Z INFO Daemon Daemon Detect protocol endpoint Oct 27 13:23:07.519127 waagent[2052]: 2026-10-27T13:23:07.519087Z INFO Daemon Daemon Clean protocol and wireserver endpoint Oct 27 13:23:07.523616 waagent[2052]: 2026-10-27T13:23:07.523577Z INFO Daemon Daemon WireServer endpoint is not found. Rerun dhcp handler Oct 27 13:23:07.529219 waagent[2052]: 2026-10-27T13:23:07.529179Z INFO Daemon Daemon Test for route to 168.63.129.16 Oct 27 13:23:07.533858 waagent[2052]: 2026-10-27T13:23:07.533817Z INFO Daemon Daemon Route to 168.63.129.16 exists Oct 27 13:23:07.538279 waagent[2052]: 2026-10-27T13:23:07.538173Z INFO Daemon Daemon Wire server endpoint:168.63.129.16 Oct 27 13:23:07.565782 waagent[2052]: 2026-10-27T13:23:07.565743Z INFO Daemon Daemon Fabric preferred wire protocol version:2015-04-05 Oct 27 13:23:07.571065 waagent[2052]: 2026-10-27T13:23:07.571042Z INFO Daemon Daemon Wire protocol version:2012-11-30 Oct 27 13:23:07.575460 waagent[2052]: 2026-10-27T13:23:07.575419Z INFO Daemon Daemon Server preferred version:2015-04-05 Oct 27 13:23:07.649902 waagent[2052]: 2026-10-27T13:23:07.649820Z INFO Daemon Daemon Initializing goal state during protocol detection Oct 27 13:23:07.656452 waagent[2052]: 2026-10-27T13:23:07.655814Z INFO Daemon Daemon Forcing an update of the goal state. Oct 27 13:23:07.666008 waagent[2052]: 2026-10-27T13:23:07.665966Z INFO Daemon Fetched a new incarnation for the WireServer goal state [incarnation 1] Oct 27 13:23:07.704598 waagent[2052]: 2026-10-27T13:23:07.704543Z INFO Daemon Daemon HostGAPlugin version: 1.0.8.189 Oct 27 13:23:07.709756 waagent[2052]: 2026-10-27T13:23:07.709712Z INFO Daemon Oct 27 13:23:07.712316 waagent[2052]: 2026-10-27T13:23:07.712284Z INFO Daemon Fetched new vmSettings [HostGAPlugin correlation ID: e1f6a28a-a56b-463f-9c66-912d3eddc884 eTag: 17234179783940256159 source: Fabric] Oct 27 13:23:07.721592 waagent[2052]: 2026-10-27T13:23:07.721559Z INFO Daemon The vmSettings originated via Fabric; will ignore them. Oct 27 13:23:07.726876 waagent[2052]: 2026-10-27T13:23:07.726836Z INFO Daemon Oct 27 13:23:07.729402 waagent[2052]: 2026-10-27T13:23:07.729372Z INFO Daemon Fetching full goal state from the WireServer [incarnation 1] Oct 27 13:23:07.739166 waagent[2052]: 2026-10-27T13:23:07.739135Z INFO Daemon Daemon Downloading artifacts profile blob Oct 27 13:23:07.834894 waagent[2052]: 2026-10-27T13:23:07.834767Z INFO Daemon Downloaded certificate {'thumbprint': '3823663E5A3A575C97D977E74EFEBA13EDF23FD7', 'hasPrivateKey': True} Oct 27 13:23:07.843277 waagent[2052]: 2026-10-27T13:23:07.843231Z INFO Daemon Fetch goal state completed Oct 27 13:23:07.853326 waagent[2052]: 2026-10-27T13:23:07.853278Z INFO Daemon Daemon Starting provisioning Oct 27 13:23:07.857443 waagent[2052]: 2026-10-27T13:23:07.857404Z INFO Daemon Daemon Handle ovf-env.xml. Oct 27 13:23:07.861854 waagent[2052]: 2026-10-27T13:23:07.861824Z INFO Daemon Daemon Set hostname [ci-4757.2.3-a-3f79c203c6] Oct 27 13:23:07.868444 waagent[2052]: 2026-10-27T13:23:07.868398Z INFO Daemon Daemon Publish hostname [ci-4757.2.3-a-3f79c203c6] Oct 27 13:23:07.873585 waagent[2052]: 2026-10-27T13:23:07.873547Z INFO Daemon Daemon Examine /proc/net/route for primary interface Oct 27 13:23:07.878736 waagent[2052]: 2026-10-27T13:23:07.878703Z INFO Daemon Daemon Primary interface is [eth0] Oct 27 13:23:07.888560 systemd-networkd[1643]: eth0: Found matching .network file, based on potentially unpredictable interface name: /usr/lib/systemd/network/zz-default.network Oct 27 13:23:07.888571 systemd-networkd[1643]: eth0: Reconfiguring with /usr/lib/systemd/network/zz-default.network. Oct 27 13:23:07.888618 systemd-networkd[1643]: eth0: DHCP lease lost Oct 27 13:23:07.898630 waagent[2052]: 2026-10-27T13:23:07.897809Z INFO Daemon Daemon Create user account if not exists Oct 27 13:23:07.902607 waagent[2052]: 2026-10-27T13:23:07.902564Z INFO Daemon Daemon User core already exists, skip useradd Oct 27 13:23:07.907347 waagent[2052]: 2026-10-27T13:23:07.907303Z INFO Daemon Daemon Configure sudoer Oct 27 13:23:07.911369 waagent[2052]: 2026-10-27T13:23:07.911321Z INFO Daemon Daemon Configure sshd Oct 27 13:23:07.911584 systemd-networkd[1643]: eth0: DHCPv4 address 10.0.0.12/24, gateway 10.0.0.1 acquired from 168.63.129.16 Oct 27 13:23:07.915122 waagent[2052]: 2026-10-27T13:23:07.915076Z INFO Daemon Daemon Added a configuration snippet disabling SSH password-based authentication methods. It also configures SSH client probing to keep connections alive. Oct 27 13:23:07.926189 waagent[2052]: 2026-10-27T13:23:07.926138Z INFO Daemon Daemon Deploy ssh public key. Oct 27 13:23:09.070207 waagent[2052]: 2026-10-27T13:23:09.070159Z INFO Daemon Daemon Provisioning complete Oct 27 13:23:09.081787 waagent[2052]: 2026-10-27T13:23:09.081737Z INFO Daemon Daemon RDMA capabilities are not enabled, skipping Oct 27 13:23:09.087308 waagent[2052]: 2026-10-27T13:23:09.087268Z INFO Daemon Daemon End of log to /dev/console. The agent will now check for updates and then will process extensions. Oct 27 13:23:09.095536 waagent[2052]: 2026-10-27T13:23:09.095433Z INFO Daemon Daemon Installed Agent WALinuxAgent-2.12.0.4 is the most current agent Oct 27 13:23:09.189733 containerd[1920]: time="2026-10-27T13:23:09Z" 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 Oct 27 13:23:09.192683 containerd[1920]: time="2026-10-27T13:23:09.192642252Z" level=info msg="starting containerd" revision=e53c7c1516c3b2bff98eb76f1f4117477e6f4e66 version=v2.2.5 Oct 27 13:23:09.204808 containerd[1920]: time="2026-10-27T13:23:09.204759156Z" level=warning msg="Configuration migrated from version 2, use `containerd config migrate` to avoid migration" t="8.64µs" Oct 27 13:23:09.205276 containerd[1920]: time="2026-10-27T13:23:09.205011508Z" level=info msg="loading plugin" id=io.containerd.content.v1.content type=io.containerd.content.v1 Oct 27 13:23:09.205377 containerd[1920]: time="2026-10-27T13:23:09.205360092Z" level=info msg="loading plugin" id=io.containerd.image-verifier.v1.bindir type=io.containerd.image-verifier.v1 Oct 27 13:23:09.205431 containerd[1920]: time="2026-10-27T13:23:09.205420052Z" level=info msg="loading plugin" id=io.containerd.internal.v1.opt type=io.containerd.internal.v1 Oct 27 13:23:09.205698 containerd[1920]: time="2026-10-27T13:23:09.205678996Z" level=info msg="loading plugin" id=io.containerd.warning.v1.deprecations type=io.containerd.warning.v1 Oct 27 13:23:09.205769 containerd[1920]: time="2026-10-27T13:23:09.205757556Z" level=info msg="loading plugin" id=io.containerd.mount-handler.v1.erofs type=io.containerd.mount-handler.v1 Oct 27 13:23:09.205809 containerd[1920]: time="2026-10-27T13:23:09.205800556Z" level=info msg="loading plugin" id=io.containerd.snapshotter.v1.blockfile type=io.containerd.snapshotter.v1 Oct 27 13:23:09.205909 containerd[1920]: time="2026-10-27T13:23:09.205896548Z" level=info msg="skip loading plugin" error="no scratch file generator: skip plugin" id=io.containerd.snapshotter.v1.blockfile type=io.containerd.snapshotter.v1 Oct 27 13:23:09.205953 containerd[1920]: time="2026-10-27T13:23:09.205941556Z" level=info msg="loading plugin" id=io.containerd.snapshotter.v1.btrfs type=io.containerd.snapshotter.v1 Oct 27 13:23:09.206222 containerd[1920]: time="2026-10-27T13:23:09.206203452Z" 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 Oct 27 13:23:09.206749 containerd[1920]: time="2026-10-27T13:23:09.206276716Z" level=info msg="loading plugin" id=io.containerd.snapshotter.v1.devmapper type=io.containerd.snapshotter.v1 Oct 27 13:23:09.206749 containerd[1920]: time="2026-10-27T13:23:09.206295508Z" level=info msg="skip loading plugin" error="devmapper not configured: skip plugin" id=io.containerd.snapshotter.v1.devmapper type=io.containerd.snapshotter.v1 Oct 27 13:23:09.206749 containerd[1920]: time="2026-10-27T13:23:09.206303220Z" level=info msg="loading plugin" id=io.containerd.snapshotter.v1.erofs type=io.containerd.snapshotter.v1 Oct 27 13:23:09.206749 containerd[1920]: time="2026-10-27T13:23:09.206500076Z" level=info msg="loading plugin" id=io.containerd.snapshotter.v1.native type=io.containerd.snapshotter.v1 Oct 27 13:23:09.206749 containerd[1920]: time="2026-10-27T13:23:09.206575868Z" level=info msg="loading plugin" id=io.containerd.snapshotter.v1.overlayfs type=io.containerd.snapshotter.v1 Oct 27 13:23:09.206749 containerd[1920]: time="2026-10-27T13:23:09.206702180Z" level=info msg="loading plugin" id=io.containerd.snapshotter.v1.zfs type=io.containerd.snapshotter.v1 Oct 27 13:23:09.206749 containerd[1920]: time="2026-10-27T13:23:09.206722148Z" 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 Oct 27 13:23:09.206749 containerd[1920]: time="2026-10-27T13:23:09.206728596Z" level=info msg="loading plugin" id=io.containerd.event.v1.exchange type=io.containerd.event.v1 Oct 27 13:23:09.206923 containerd[1920]: time="2026-10-27T13:23:09.206910524Z" level=info msg="loading plugin" id=io.containerd.monitor.task.v1.cgroups type=io.containerd.monitor.task.v1 Oct 27 13:23:09.212727 login[2054]: pam_unix(login:session): session opened for user core(uid=500) by core(uid=0) Oct 27 13:23:09.213558 login[2055]: pam_unix(login:session): session opened for user core(uid=500) by core(uid=0) Oct 27 13:23:09.215574 waagent[2088]: 2026-10-27T13:23:09.215365Z INFO ExtHandler ExtHandler Azure Linux Agent (Goal State Agent version 2.12.0.4) Oct 27 13:23:09.215574 waagent[2088]: 2026-10-27T13:23:09.215496Z INFO ExtHandler ExtHandler OS: flatcar 4757.2.3 Oct 27 13:23:09.215786 waagent[2088]: 2026-10-27T13:23:09.215592Z INFO ExtHandler ExtHandler Python: 3.12.13 Oct 27 13:23:09.215786 waagent[2088]: 2026-10-27T13:23:09.215636Z INFO ExtHandler ExtHandler CPU Arch: aarch64 Oct 27 13:23:09.220806 systemd[1]: Created slice user-500.slice - User Slice of UID 500. Oct 27 13:23:09.221737 systemd[1]: Starting user-runtime-dir@500.service - User Runtime Directory /run/user/500... Oct 27 13:23:09.225224 systemd-logind[1892]: New session '1' of user 'core' with class 'user-light' and type 'tty'. Oct 27 13:23:09.229321 systemd-logind[1892]: New session '2' of user 'core' with class 'user-light' and type 'tty'. Oct 27 13:23:09.232369 containerd[1920]: time="2026-10-27T13:23:09.232323172Z" level=info msg="loading plugin" id=io.containerd.metadata.v1.bolt type=io.containerd.metadata.v1 Oct 27 13:23:09.233597 containerd[1920]: time="2026-10-27T13:23:09.233539364Z" level=info msg="metadata content store policy set" policy=shared Oct 27 13:23:09.246586 containerd[1920]: time="2026-10-27T13:23:09.246540108Z" level=info msg="loading plugin" id=io.containerd.gc.v1.scheduler type=io.containerd.gc.v1 Oct 27 13:23:09.246681 containerd[1920]: time="2026-10-27T13:23:09.246603132Z" level=info msg="loading plugin" id=io.containerd.nri.v1.nri type=io.containerd.nri.v1 Oct 27 13:23:09.247076 containerd[1920]: time="2026-10-27T13:23:09.247056380Z" level=info msg="built-in NRI default validator is disabled" Oct 27 13:23:09.247076 containerd[1920]: time="2026-10-27T13:23:09.247075332Z" level=info msg="runtime interface created" Oct 27 13:23:09.247123 containerd[1920]: time="2026-10-27T13:23:09.247081604Z" level=info msg="created NRI interface" Oct 27 13:23:09.247123 containerd[1920]: time="2026-10-27T13:23:09.247093028Z" level=info msg="loading plugin" id=io.containerd.differ.v1.erofs type=io.containerd.differ.v1 Oct 27 13:23:09.267561 systemd[1]: Finished user-runtime-dir@500.service - User Runtime Directory /run/user/500. Oct 27 13:23:09.274768 systemd[1]: Started session-1.scope - Session 1 of User core. Oct 27 13:23:09.275921 systemd[1]: Started session-2.scope - Session 2 of User core. Oct 27 13:23:09.299803 waagent[2088]: 2026-10-27T13:23:09.297670Z INFO ExtHandler ExtHandler Distro: flatcar-4757.2.3; OSUtil: FlatcarUtil; AgentService: waagent; Python: 3.12.13; Arch: aarch64; systemd: True; LISDrivers: Absent; logrotate: logrotate 3.22.0; Oct 27 13:23:09.299803 waagent[2088]: 2026-10-27T13:23:09.297899Z INFO ExtHandler ExtHandler WireServer endpoint 168.63.129.16 read from file Oct 27 13:23:09.299803 waagent[2088]: 2026-10-27T13:23:09.297960Z INFO ExtHandler ExtHandler Wire server endpoint:168.63.129.16 Oct 27 13:23:09.304416 waagent[2088]: 2026-10-27T13:23:09.304360Z INFO ExtHandler Fetched a new incarnation for the WireServer goal state [incarnation 1] Oct 27 13:23:09.310171 containerd[1920]: time="2026-10-27T13:23:09.309542252Z" level=info msg="loading plugin" id=io.containerd.mount-manager.v1.bolt type=io.containerd.mount-manager.v1 Oct 27 13:23:09.310171 containerd[1920]: time="2026-10-27T13:23:09.309722172Z" level=info msg="loading plugin" id=io.containerd.differ.v1.walking type=io.containerd.differ.v1 Oct 27 13:23:09.310171 containerd[1920]: time="2026-10-27T13:23:09.309736708Z" level=info msg="loading plugin" id=io.containerd.lease.v1.manager type=io.containerd.lease.v1 Oct 27 13:23:09.310171 containerd[1920]: time="2026-10-27T13:23:09.309745868Z" level=info msg="loading plugin" id=io.containerd.service.v1.containers-service type=io.containerd.service.v1 Oct 27 13:23:09.310171 containerd[1920]: time="2026-10-27T13:23:09.309757372Z" level=info msg="loading plugin" id=io.containerd.service.v1.content-service type=io.containerd.service.v1 Oct 27 13:23:09.310171 containerd[1920]: time="2026-10-27T13:23:09.309765636Z" level=info msg="loading plugin" id=io.containerd.service.v1.diff-service type=io.containerd.service.v1 Oct 27 13:23:09.310171 containerd[1920]: time="2026-10-27T13:23:09.309773892Z" level=info msg="loading plugin" id=io.containerd.service.v1.images-service type=io.containerd.service.v1 Oct 27 13:23:09.310171 containerd[1920]: time="2026-10-27T13:23:09.309782252Z" level=info msg="loading plugin" id=io.containerd.service.v1.introspection-service type=io.containerd.service.v1 Oct 27 13:23:09.310171 containerd[1920]: time="2026-10-27T13:23:09.309791084Z" level=info msg="loading plugin" id=io.containerd.service.v1.namespaces-service type=io.containerd.service.v1 Oct 27 13:23:09.310171 containerd[1920]: time="2026-10-27T13:23:09.309797572Z" level=info msg="loading plugin" id=io.containerd.service.v1.snapshots-service type=io.containerd.service.v1 Oct 27 13:23:09.310171 containerd[1920]: time="2026-10-27T13:23:09.309803844Z" level=info msg="loading plugin" id=io.containerd.shim.v1.manager type=io.containerd.shim.v1 Oct 27 13:23:09.310171 containerd[1920]: time="2026-10-27T13:23:09.309810636Z" level=info msg="loading plugin" id=io.containerd.runtime.v2.task type=io.containerd.runtime.v2 Oct 27 13:23:09.310171 containerd[1920]: time="2026-10-27T13:23:09.309930220Z" level=info msg="loading plugin" id=io.containerd.service.v1.tasks-service type=io.containerd.service.v1 Oct 27 13:23:09.310171 containerd[1920]: time="2026-10-27T13:23:09.309985940Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.containers type=io.containerd.grpc.v1 Oct 27 13:23:09.310416 containerd[1920]: time="2026-10-27T13:23:09.309998788Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.content type=io.containerd.grpc.v1 Oct 27 13:23:09.310416 containerd[1920]: time="2026-10-27T13:23:09.310007356Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.diff type=io.containerd.grpc.v1 Oct 27 13:23:09.310416 containerd[1920]: time="2026-10-27T13:23:09.310014996Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.events type=io.containerd.grpc.v1 Oct 27 13:23:09.310416 containerd[1920]: time="2026-10-27T13:23:09.310020860Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.images type=io.containerd.grpc.v1 Oct 27 13:23:09.310416 containerd[1920]: time="2026-10-27T13:23:09.310028796Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.introspection type=io.containerd.grpc.v1 Oct 27 13:23:09.310416 containerd[1920]: time="2026-10-27T13:23:09.310035596Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.leases type=io.containerd.grpc.v1 Oct 27 13:23:09.310416 containerd[1920]: time="2026-10-27T13:23:09.310042412Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.mounts type=io.containerd.grpc.v1 Oct 27 13:23:09.310416 containerd[1920]: time="2026-10-27T13:23:09.310048156Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.namespaces type=io.containerd.grpc.v1 Oct 27 13:23:09.310416 containerd[1920]: time="2026-10-27T13:23:09.310056324Z" level=info msg="loading plugin" id=io.containerd.sandbox.store.v1.local type=io.containerd.sandbox.store.v1 Oct 27 13:23:09.310416 containerd[1920]: time="2026-10-27T13:23:09.310062124Z" level=info msg="loading plugin" id=io.containerd.transfer.v1.local type=io.containerd.transfer.v1 Oct 27 13:23:09.310416 containerd[1920]: time="2026-10-27T13:23:09.310085596Z" level=info msg="loading plugin" id=io.containerd.cri.v1.images type=io.containerd.cri.v1 Oct 27 13:23:09.310612 waagent[2088]: 2026-10-27T13:23:09.310372Z INFO ExtHandler ExtHandler HostGAPlugin version: 1.0.8.189 Oct 27 13:23:09.310837 waagent[2088]: 2026-10-27T13:23:09.310799Z INFO ExtHandler Oct 27 13:23:09.310899 waagent[2088]: 2026-10-27T13:23:09.310878Z INFO ExtHandler Fetched new vmSettings [HostGAPlugin correlation ID: 8d42d0c5-2f53-45ca-81c7-d5262fc3c777 eTag: 17234179783940256159 source: Fabric] Oct 27 13:23:09.311118 waagent[2088]: 2026-10-27T13:23:09.311090Z INFO ExtHandler The vmSettings originated via Fabric; will ignore them. Oct 27 13:23:09.311539 waagent[2088]: 2026-10-27T13:23:09.311492Z INFO ExtHandler Oct 27 13:23:09.311674 waagent[2088]: 2026-10-27T13:23:09.311652Z INFO ExtHandler Fetching full goal state from the WireServer [incarnation 1] Oct 27 13:23:09.314589 waagent[2088]: 2026-10-27T13:23:09.314513Z INFO ExtHandler ExtHandler Downloading artifacts profile blob Oct 27 13:23:09.327426 containerd[1920]: time="2026-10-27T13:23:09.327318852Z" level=info msg="Get image filesystem path \"/var/lib/containerd/io.containerd.snapshotter.v1.overlayfs\" for snapshotter \"overlayfs\"" Oct 27 13:23:09.327660 containerd[1920]: time="2026-10-27T13:23:09.327536476Z" level=info msg="Start snapshots syncer" Oct 27 13:23:09.327660 containerd[1920]: time="2026-10-27T13:23:09.327571620Z" level=info msg="loading plugin" id=io.containerd.cri.v1.runtime type=io.containerd.cri.v1 Oct 27 13:23:09.328087 containerd[1920]: time="2026-10-27T13:23:09.328027508Z" 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\"}" Oct 27 13:23:09.328256 containerd[1920]: time="2026-10-27T13:23:09.328237788Z" level=info msg="loading plugin" id=io.containerd.podsandbox.controller.v1.podsandbox type=io.containerd.podsandbox.controller.v1 Oct 27 13:23:09.328340 containerd[1920]: time="2026-10-27T13:23:09.328327876Z" level=info msg="loading plugin" id=io.containerd.sandbox.controller.v1.shim type=io.containerd.sandbox.controller.v1 Oct 27 13:23:09.328962 containerd[1920]: time="2026-10-27T13:23:09.328690964Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.sandbox-controllers type=io.containerd.grpc.v1 Oct 27 13:23:09.328962 containerd[1920]: time="2026-10-27T13:23:09.328715284Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.sandboxes type=io.containerd.grpc.v1 Oct 27 13:23:09.328962 containerd[1920]: time="2026-10-27T13:23:09.328722884Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.snapshots type=io.containerd.grpc.v1 Oct 27 13:23:09.328962 containerd[1920]: time="2026-10-27T13:23:09.328729236Z" level=info msg="loading plugin" id=io.containerd.streaming.v1.manager type=io.containerd.streaming.v1 Oct 27 13:23:09.328962 containerd[1920]: time="2026-10-27T13:23:09.328737308Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.streaming type=io.containerd.grpc.v1 Oct 27 13:23:09.328962 containerd[1920]: time="2026-10-27T13:23:09.328747340Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.tasks type=io.containerd.grpc.v1 Oct 27 13:23:09.328962 containerd[1920]: time="2026-10-27T13:23:09.328760092Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.transfer type=io.containerd.grpc.v1 Oct 27 13:23:09.328962 containerd[1920]: time="2026-10-27T13:23:09.328770204Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.version type=io.containerd.grpc.v1 Oct 27 13:23:09.328962 containerd[1920]: time="2026-10-27T13:23:09.328775860Z" level=info msg="loading plugin" id=io.containerd.monitor.container.v1.restart type=io.containerd.monitor.container.v1 Oct 27 13:23:09.328962 containerd[1920]: time="2026-10-27T13:23:09.328796092Z" level=info msg="loading plugin" id=io.containerd.tracing.processor.v1.otlp type=io.containerd.tracing.processor.v1 Oct 27 13:23:09.328962 containerd[1920]: time="2026-10-27T13:23:09.328813884Z" 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 Oct 27 13:23:09.328962 containerd[1920]: time="2026-10-27T13:23:09.328820092Z" level=info msg="loading plugin" id=io.containerd.internal.v1.tracing type=io.containerd.internal.v1 Oct 27 13:23:09.328962 containerd[1920]: time="2026-10-27T13:23:09.328825596Z" level=info msg="skip loading plugin" error="skip plugin: tracing endpoint not configured" id=io.containerd.internal.v1.tracing type=io.containerd.internal.v1 Oct 27 13:23:09.328962 containerd[1920]: time="2026-10-27T13:23:09.328829964Z" level=info msg="loading plugin" id=io.containerd.ttrpc.v1.otelttrpc type=io.containerd.ttrpc.v1 Oct 27 13:23:09.329188 containerd[1920]: time="2026-10-27T13:23:09.328840052Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.healthcheck type=io.containerd.grpc.v1 Oct 27 13:23:09.329188 containerd[1920]: time="2026-10-27T13:23:09.328848900Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.cri type=io.containerd.grpc.v1 Oct 27 13:23:09.329188 containerd[1920]: time="2026-10-27T13:23:09.328858484Z" level=info msg="Connect containerd service" Oct 27 13:23:09.329188 containerd[1920]: time="2026-10-27T13:23:09.328875260Z" level=info msg="using experimental NRI integration - disable nri plugin to prevent this" Oct 27 13:23:09.330621 containerd[1920]: time="2026-10-27T13:23:09.330249396Z" 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" Oct 27 13:23:09.375517 waagent[2088]: 2026-10-27T13:23:09.375442Z INFO ExtHandler Downloaded certificate {'thumbprint': '3823663E5A3A575C97D977E74EFEBA13EDF23FD7', 'hasPrivateKey': True} Oct 27 13:23:09.375920 waagent[2088]: 2026-10-27T13:23:09.375884Z INFO ExtHandler Fetch goal state completed Oct 27 13:23:09.386270 waagent[2088]: 2026-10-27T13:23:09.386215Z INFO ExtHandler ExtHandler OpenSSL version: OpenSSL 3.5.9 29 Sep 2026 (Library: OpenSSL 3.5.9 29 Sep 2026) Oct 27 13:23:09.391021 waagent[2088]: 2026-10-27T13:23:09.390972Z INFO ExtHandler ExtHandler WALinuxAgent-2.12.0.4 running as process 2088 Oct 27 13:23:09.391130 waagent[2088]: 2026-10-27T13:23:09.391104Z INFO ExtHandler ExtHandler ******** AutoUpdate.Enabled is set to False, not processing the operation ******** Oct 27 13:23:09.391399 waagent[2088]: 2026-10-27T13:23:09.391365Z INFO ExtHandler ExtHandler ******** AutoUpdate.UpdateToLatestVersion is set to False, not processing the operation ******** Oct 27 13:23:09.392693 waagent[2088]: 2026-10-27T13:23:09.392498Z INFO ExtHandler ExtHandler [CGI] Cgroup monitoring is not supported on ['flatcar', '4757.2.3', '', 'Flatcar Container Linux by Kinvolk'] Oct 27 13:23:09.392892 waagent[2088]: 2026-10-27T13:23:09.392845Z INFO ExtHandler ExtHandler [CGI] Agent will reset the quotas in case distro: ['flatcar', '4757.2.3', '', 'Flatcar Container Linux by Kinvolk'] went from supported to unsupported Oct 27 13:23:09.392979 waagent[2088]: 2026-10-27T13:23:09.392957Z INFO ExtHandler ExtHandler [CGI] Agent cgroups enabled: False Oct 27 13:23:09.393554 waagent[2088]: 2026-10-27T13:23:09.393365Z INFO ExtHandler ExtHandler Starting setup for Persistent firewall rules Oct 27 13:23:09.429898 waagent[2088]: 2026-10-27T13:23:09.429853Z INFO ExtHandler ExtHandler Firewalld service not running/unavailable, trying to set up waagent-network-setup.service Oct 27 13:23:09.430084 waagent[2088]: 2026-10-27T13:23:09.430054Z INFO ExtHandler ExtHandler Successfully updated the Binary file /var/lib/waagent/waagent-network-setup.py for firewall setup Oct 27 13:23:09.434914 waagent[2088]: 2026-10-27T13:23:09.434874Z INFO ExtHandler ExtHandler Service: waagent-network-setup.service not enabled. Adding it now Oct 27 13:23:09.439612 systemd[1]: Reload requested from client PID 2137 ('systemctl') (unit waagent.service)... Oct 27 13:23:09.439629 systemd[1]: Reloading... Oct 27 13:23:09.522559 zram_generator::config[2193]: No configuration found. Oct 27 13:23:09.749027 systemd[1]: Reloading finished in 309 ms. Oct 27 13:23:09.773413 waagent[2088]: 2026-10-27T13:23:09.772208Z INFO ExtHandler ExtHandler Successfully added and enabled the waagent-network-setup.service Oct 27 13:23:09.773413 waagent[2088]: 2026-10-27T13:23:09.772354Z INFO ExtHandler ExtHandler Persistent firewall rules setup successfully Oct 27 13:23:10.128315 waagent[2088]: 2026-10-27T13:23:10.128190Z INFO ExtHandler ExtHandler DROP rule is not available which implies no firewall rules are set yet. Environment thread will set it up. Oct 27 13:23:10.128751 waagent[2088]: 2026-10-27T13:23:10.128715Z 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] Oct 27 13:23:10.129468 waagent[2088]: 2026-10-27T13:23:10.129430Z INFO ExtHandler ExtHandler Starting env monitor service. Oct 27 13:23:10.129590 waagent[2088]: 2026-10-27T13:23:10.129553Z INFO MonitorHandler ExtHandler WireServer endpoint 168.63.129.16 read from file Oct 27 13:23:10.129703 waagent[2088]: 2026-10-27T13:23:10.129675Z INFO MonitorHandler ExtHandler Wire server endpoint:168.63.129.16 Oct 27 13:23:10.129911 waagent[2088]: 2026-10-27T13:23:10.129878Z INFO MonitorHandler ExtHandler Monitor.NetworkConfigurationChanges is disabled. Oct 27 13:23:10.130250 waagent[2088]: 2026-10-27T13:23:10.130216Z INFO ExtHandler ExtHandler Start SendTelemetryHandler service. Oct 27 13:23:10.130383 waagent[2088]: 2026-10-27T13:23:10.130346Z INFO MonitorHandler ExtHandler Routing table from /proc/net/route: Oct 27 13:23:10.130383 waagent[2088]: Iface Destination Gateway Flags RefCnt Use Metric Mask MTU Window IRTT Oct 27 13:23:10.130383 waagent[2088]: eth0 00000000 0100000A 0003 0 0 1024 00000000 0 0 0 Oct 27 13:23:10.130383 waagent[2088]: eth0 0000000A 00000000 0001 0 0 1024 00FFFFFF 0 0 0 Oct 27 13:23:10.130383 waagent[2088]: eth0 0100000A 00000000 0005 0 0 1024 FFFFFFFF 0 0 0 Oct 27 13:23:10.130383 waagent[2088]: eth0 10813FA8 0100000A 0007 0 0 1024 FFFFFFFF 0 0 0 Oct 27 13:23:10.130383 waagent[2088]: eth0 FEA9FEA9 0100000A 0007 0 0 1024 FFFFFFFF 0 0 0 Oct 27 13:23:10.130835 waagent[2088]: 2026-10-27T13:23:10.130798Z INFO SendTelemetryHandler ExtHandler Successfully started the SendTelemetryHandler thread Oct 27 13:23:10.130967 waagent[2088]: 2026-10-27T13:23:10.130937Z INFO EnvHandler ExtHandler WireServer endpoint 168.63.129.16 read from file Oct 27 13:23:10.131017 waagent[2088]: 2026-10-27T13:23:10.130987Z INFO EnvHandler ExtHandler Wire server endpoint:168.63.129.16 Oct 27 13:23:10.131228 waagent[2088]: 2026-10-27T13:23:10.131081Z INFO EnvHandler ExtHandler Configure routes Oct 27 13:23:10.131228 waagent[2088]: 2026-10-27T13:23:10.131130Z INFO EnvHandler ExtHandler Gateway:None Oct 27 13:23:10.131228 waagent[2088]: 2026-10-27T13:23:10.131167Z INFO ExtHandler ExtHandler Start Extension Telemetry service. Oct 27 13:23:10.131301 waagent[2088]: 2026-10-27T13:23:10.131241Z INFO EnvHandler ExtHandler Routes:None Oct 27 13:23:10.131735 waagent[2088]: 2026-10-27T13:23:10.131703Z INFO TelemetryEventsCollector ExtHandler Extension Telemetry pipeline enabled: True Oct 27 13:23:10.131850 waagent[2088]: 2026-10-27T13:23:10.131811Z INFO ExtHandler ExtHandler Goal State Period: 6 sec. This indicates how often the agent checks for new goal states and reports status. Oct 27 13:23:10.131946 waagent[2088]: 2026-10-27T13:23:10.131920Z INFO TelemetryEventsCollector ExtHandler Successfully started the TelemetryEventsCollector thread Oct 27 13:23:10.137200 waagent[2088]: 2026-10-27T13:23:10.137165Z INFO ExtHandler ExtHandler Oct 27 13:23:10.137471 waagent[2088]: 2026-10-27T13:23:10.137437Z INFO ExtHandler ExtHandler ProcessExtensionsGoalState started [incarnation_1 channel: WireServer source: Fabric activity: 88ce7197-26c0-4687-885e-42041a59c8e0 correlation 0445ebfc-376e-41d8-a9bc-21a9ca0b7c50 created: 2026-10-27T13:21:48.277130Z] Oct 27 13:23:10.138832 waagent[2088]: 2026-10-27T13:23:10.137825Z INFO ExtHandler ExtHandler No extension handlers found, not processing anything. Oct 27 13:23:10.138832 waagent[2088]: 2026-10-27T13:23:10.138236Z INFO ExtHandler ExtHandler ProcessExtensionsGoalState completed [incarnation_1 1 ms] Oct 27 13:23:10.167636 waagent[2088]: 2026-10-27T13:23:10.167593Z INFO ExtHandler ExtHandler [HEARTBEAT] Agent WALinuxAgent-2.12.0.4 is running as the goal state agent [DEBUG HeartbeatCounter: 0;HeartbeatId: 7EC6BC50-02BB-4D78-A4FD-4DCF649A1645;DroppedPackets: 0;UpdateGSErrors: 0;AutoUpdate: 0;UpdateMode: SelfUpdate;] Oct 27 13:23:10.192827 waagent[2088]: 2026-10-27T13:23:10.192755Z INFO MonitorHandler ExtHandler Network interfaces: Oct 27 13:23:10.192827 waagent[2088]: Executing ['ip', '-a', '-o', 'link']: Oct 27 13:23:10.192827 waagent[2088]: 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 Oct 27 13:23:10.192827 waagent[2088]: 2: eth0: mtu 1500 qdisc mq state UP mode DEFAULT group default qlen 1000\ link/ether 00:22:48:7c:b8:9d brd ff:ff:ff:ff:ff:ff\ altname enx0022487cb89d Oct 27 13:23:10.192827 waagent[2088]: 3: enP44203s1: mtu 1500 qdisc mq master eth0 state UP mode DEFAULT group default qlen 1000\ link/ether 00:22:48:7c:b8:9d brd ff:ff:ff:ff:ff:ff\ altname enP44203p0s2 Oct 27 13:23:10.192827 waagent[2088]: Executing ['ip', '-4', '-a', '-o', 'address']: Oct 27 13:23:10.192827 waagent[2088]: 1: lo inet 127.0.0.1/8 scope host lo\ valid_lft forever preferred_lft forever Oct 27 13:23:10.192827 waagent[2088]: 2: eth0 inet 10.0.0.12/24 metric 1024 brd 10.0.0.255 scope global eth0\ valid_lft forever preferred_lft forever Oct 27 13:23:10.192827 waagent[2088]: Executing ['ip', '-6', '-a', '-o', 'address']: Oct 27 13:23:10.192827 waagent[2088]: 1: lo inet6 ::1/128 scope host noprefixroute \ valid_lft forever preferred_lft forever Oct 27 13:23:10.192827 waagent[2088]: 2: eth0 inet6 fe80::222:48ff:fe7c:b89d/64 scope link proto kernel_ll \ valid_lft forever preferred_lft forever Oct 27 13:23:10.338872 waagent[2088]: 2026-10-27T13:23:10.338806Z INFO EnvHandler ExtHandler Created firewall rules for the Azure Fabric: Oct 27 13:23:10.338872 waagent[2088]: Chain INPUT (policy ACCEPT 0 packets, 0 bytes) Oct 27 13:23:10.338872 waagent[2088]: pkts bytes target prot opt in out source destination Oct 27 13:23:10.338872 waagent[2088]: Chain FORWARD (policy ACCEPT 0 packets, 0 bytes) Oct 27 13:23:10.338872 waagent[2088]: pkts bytes target prot opt in out source destination Oct 27 13:23:10.338872 waagent[2088]: Chain OUTPUT (policy ACCEPT 0 packets, 0 bytes) Oct 27 13:23:10.338872 waagent[2088]: pkts bytes target prot opt in out source destination Oct 27 13:23:10.338872 waagent[2088]: 0 0 ACCEPT tcp -- * * 0.0.0.0/0 168.63.129.16 tcp dpt:53 Oct 27 13:23:10.338872 waagent[2088]: 0 0 ACCEPT tcp -- * * 0.0.0.0/0 168.63.129.16 owner UID match 0 Oct 27 13:23:10.338872 waagent[2088]: 0 0 DROP tcp -- * * 0.0.0.0/0 168.63.129.16 ctstate INVALID,NEW Oct 27 13:23:10.341284 waagent[2088]: 2026-10-27T13:23:10.341241Z INFO EnvHandler ExtHandler Current Firewall rules: Oct 27 13:23:10.341284 waagent[2088]: Chain INPUT (policy ACCEPT 0 packets, 0 bytes) Oct 27 13:23:10.341284 waagent[2088]: pkts bytes target prot opt in out source destination Oct 27 13:23:10.341284 waagent[2088]: Chain FORWARD (policy ACCEPT 0 packets, 0 bytes) Oct 27 13:23:10.341284 waagent[2088]: pkts bytes target prot opt in out source destination Oct 27 13:23:10.341284 waagent[2088]: Chain OUTPUT (policy ACCEPT 0 packets, 0 bytes) Oct 27 13:23:10.341284 waagent[2088]: pkts bytes target prot opt in out source destination Oct 27 13:23:10.341284 waagent[2088]: 0 0 ACCEPT tcp -- * * 0.0.0.0/0 168.63.129.16 tcp dpt:53 Oct 27 13:23:10.341284 waagent[2088]: 0 0 ACCEPT tcp -- * * 0.0.0.0/0 168.63.129.16 owner UID match 0 Oct 27 13:23:10.341284 waagent[2088]: 0 0 DROP tcp -- * * 0.0.0.0/0 168.63.129.16 ctstate INVALID,NEW Oct 27 13:23:10.341500 waagent[2088]: 2026-10-27T13:23:10.341473Z INFO EnvHandler ExtHandler Set block dev timeout: sda with timeout: 300 Oct 27 13:23:11.897565 containerd[1920]: time="2026-10-27T13:23:11.897436236Z" level=info msg="Start subscribing containerd event" Oct 27 13:23:11.897565 containerd[1920]: time="2026-10-27T13:23:11.897498900Z" level=info msg="Start recovering state" Oct 27 13:23:11.897954 containerd[1920]: time="2026-10-27T13:23:11.897592156Z" level=info msg="Start event monitor" Oct 27 13:23:11.897954 containerd[1920]: time="2026-10-27T13:23:11.897601796Z" level=info msg="Start cni network conf syncer for default" Oct 27 13:23:11.897954 containerd[1920]: time="2026-10-27T13:23:11.897611268Z" level=info msg="Start streaming server" Oct 27 13:23:11.897954 containerd[1920]: time="2026-10-27T13:23:11.897618340Z" level=info msg="Registered namespace \"k8s.io\" with NRI" Oct 27 13:23:11.897954 containerd[1920]: time="2026-10-27T13:23:11.897623036Z" level=info msg="runtime interface starting up..." Oct 27 13:23:11.897954 containerd[1920]: time="2026-10-27T13:23:11.897628380Z" level=info msg="starting plugins..." Oct 27 13:23:11.897954 containerd[1920]: time="2026-10-27T13:23:11.897639252Z" level=info msg="Synchronizing NRI (plugin) with current runtime state" Oct 27 13:23:11.914717 containerd[1920]: time="2026-10-27T13:23:11.914575188Z" level=info msg=serving... address=/run/containerd/containerd.sock.ttrpc Oct 27 13:23:11.914717 containerd[1920]: time="2026-10-27T13:23:11.914624780Z" level=info msg=serving... address=/run/containerd/containerd.sock Oct 27 13:23:11.930756 containerd[1920]: time="2026-10-27T13:23:11.930725876Z" level=info msg="containerd successfully booted in 2.741275s" Oct 27 13:23:11.930946 systemd[1]: Started containerd.service - containerd container runtime. Oct 27 13:23:11.938878 systemd[1]: Reached target multi-user.target - Multi-User System. Oct 27 13:23:11.946584 systemd[1]: Startup finished in 2.906s (kernel) + 15.368s (initrd) + 25.478s (userspace) = 43.754s. Oct 27 13:23:26.756847 chronyd[1878]: Selected source PHC0 Oct 27 13:23:37.968014 systemd[1]: Created slice system-sshd.slice - Slice /system/sshd. Oct 27 13:23:37.969537 systemd[1]: Started sshd@0-1-10.0.0.12:22-20.31.226.197:36222.service - OpenSSH per-connection server daemon (20.31.226.197:36222). Oct 27 13:23:38.956893 sshd[2293]: Accepted publickey for core from 20.31.226.197 port 36222 ssh2: RSA SHA256:BsNRVxk0Df/l+k97auxGU824qvUiIgxS1Xr4X1U/2b4 Oct 27 13:23:38.957777 sshd-session[2293]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Oct 27 13:23:38.971542 systemd[1]: Starting user@500.service - User Manager for UID 500... Oct 27 13:23:38.975030 systemd-logind[1892]: New session '3' of user 'core' with class 'user' and type 'tty'. Oct 27 13:23:38.980337 (systemd)[2297]: pam_unix(systemd-user:session): session opened for user core(uid=500) by core(uid=0) Oct 27 13:23:38.982374 systemd-logind[1892]: New session '4' of user 'core' with class 'manager-early' and type 'unspecified'. Oct 27 13:23:39.198998 systemd[2297]: Queued start job for default target default.target. Oct 27 13:23:39.210175 systemd[2297]: Created slice app.slice - User Application Slice. Oct 27 13:23:39.210203 systemd[2297]: Started systemd-tmpfiles-clean.timer - Daily Cleanup of User's Temporary Directories. Oct 27 13:23:39.210215 systemd[2297]: Reached target machines.target - Virtual Machines and Containers. Oct 27 13:23:39.210255 systemd[2297]: Reached target paths.target - Paths. Oct 27 13:23:39.210273 systemd[2297]: Reached target timers.target - Timers. Oct 27 13:23:39.211243 systemd[2297]: Starting dbus.socket - D-Bus User Message Bus Socket... Oct 27 13:23:39.212361 systemd[2297]: Listening on systemd-ask-password.socket - Query the User Interactively for a Password. Oct 27 13:23:39.212476 systemd[2297]: Listening on systemd-importd.socket - Disk Image Download Service Socket. Oct 27 13:23:39.213122 systemd[2297]: Listening on systemd-journalctl.socket - Journal Log Access Socket. Oct 27 13:23:39.213298 systemd[2297]: Listening on systemd-machined.socket - Virtual Machine and Container Registration Service Socket. Oct 27 13:23:39.216666 systemd[2297]: Starting systemd-tmpfiles-setup.service - Create User Files and Directories... Oct 27 13:23:39.221405 systemd[2297]: Listening on dbus.socket - D-Bus User Message Bus Socket. Oct 27 13:23:39.221450 systemd[2297]: Reached target sockets.target - Sockets. Oct 27 13:23:39.225870 systemd[2297]: Finished systemd-tmpfiles-setup.service - Create User Files and Directories. Oct 27 13:23:39.225955 systemd[2297]: Reached target basic.target - Basic System. Oct 27 13:23:39.225995 systemd[2297]: Reached target default.target - Main User Target. Oct 27 13:23:39.226015 systemd[2297]: Startup finished in 239ms. Oct 27 13:23:39.226327 systemd[1]: Started user@500.service - User Manager for UID 500. Oct 27 13:23:39.231676 systemd[1]: Started session-3.scope - Session 3 of User core. Oct 27 13:23:39.662915 systemd[1]: Started sshd@1-2-10.0.0.12:22-20.31.226.197:36230.service - OpenSSH per-connection server daemon (20.31.226.197:36230). Oct 27 13:23:40.379045 sshd[2311]: Accepted publickey for core from 20.31.226.197 port 36230 ssh2: RSA SHA256:BsNRVxk0Df/l+k97auxGU824qvUiIgxS1Xr4X1U/2b4 Oct 27 13:23:40.379905 sshd-session[2311]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Oct 27 13:23:40.384119 systemd-logind[1892]: New session '5' of user 'core' with class 'user' and type 'tty'. Oct 27 13:23:40.391962 systemd[1]: Started session-5.scope - Session 5 of User core. Oct 27 13:23:40.791551 sshd[2315]: Connection closed by 20.31.226.197 port 36230 Oct 27 13:23:40.791242 sshd-session[2311]: pam_unix(sshd:session): session closed for user core Oct 27 13:23:40.794097 systemd[1]: sshd@1-2-10.0.0.12:22-20.31.226.197:36230.service: Deactivated successfully. Oct 27 13:23:40.795986 systemd[1]: session-5.scope: Deactivated successfully. Oct 27 13:23:40.797631 systemd-logind[1892]: Session 5 logged out. Waiting for processes to exit. Oct 27 13:23:40.799191 systemd-logind[1892]: Removed session 5. Oct 27 13:23:40.945279 systemd[1]: Started sshd@2-3-10.0.0.12:22-20.31.226.197:57514.service - OpenSSH per-connection server daemon (20.31.226.197:57514). Oct 27 13:23:41.671037 sshd[2321]: Accepted publickey for core from 20.31.226.197 port 57514 ssh2: RSA SHA256:BsNRVxk0Df/l+k97auxGU824qvUiIgxS1Xr4X1U/2b4 Oct 27 13:23:41.672071 sshd-session[2321]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Oct 27 13:23:41.675897 systemd-logind[1892]: New session '6' of user 'core' with class 'user' and type 'tty'. Oct 27 13:23:41.686812 systemd[1]: Started session-6.scope - Session 6 of User core. Oct 27 13:23:42.085689 sshd[2325]: Connection closed by 20.31.226.197 port 57514 Oct 27 13:23:42.086112 sshd-session[2321]: pam_unix(sshd:session): session closed for user core Oct 27 13:23:42.089188 systemd[1]: sshd@2-3-10.0.0.12:22-20.31.226.197:57514.service: Deactivated successfully. Oct 27 13:23:42.090812 systemd[1]: session-6.scope: Deactivated successfully. Oct 27 13:23:42.092281 systemd-logind[1892]: Session 6 logged out. Waiting for processes to exit. Oct 27 13:23:42.093103 systemd-logind[1892]: Removed session 6. Oct 27 13:23:42.246252 systemd[1]: Started sshd@3-4097-10.0.0.12:22-20.31.226.197:57516.service - OpenSSH per-connection server daemon (20.31.226.197:57516). Oct 27 13:23:43.003301 sshd[2331]: Accepted publickey for core from 20.31.226.197 port 57516 ssh2: RSA SHA256:BsNRVxk0Df/l+k97auxGU824qvUiIgxS1Xr4X1U/2b4 Oct 27 13:23:43.004150 sshd-session[2331]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Oct 27 13:23:43.008003 systemd-logind[1892]: New session '7' of user 'core' with class 'user' and type 'tty'. Oct 27 13:23:43.018847 systemd[1]: Started session-7.scope - Session 7 of User core. Oct 27 13:23:43.030540 kernel: hv_balloon: Max. dynamic memory size: 4096 MB Oct 27 13:23:43.440564 sshd[2335]: Connection closed by 20.31.226.197 port 57516 Oct 27 13:23:43.439397 sshd-session[2331]: pam_unix(sshd:session): session closed for user core Oct 27 13:23:43.442180 systemd[1]: sshd@3-4097-10.0.0.12:22-20.31.226.197:57516.service: Deactivated successfully. Oct 27 13:23:43.445080 systemd[1]: session-7.scope: Deactivated successfully. Oct 27 13:23:43.446741 systemd-logind[1892]: Session 7 logged out. Waiting for processes to exit. Oct 27 13:23:43.447489 systemd-logind[1892]: Removed session 7. Oct 27 13:23:43.590391 systemd[1]: Started sshd@4-4-10.0.0.12:22-20.31.226.197:57520.service - OpenSSH per-connection server daemon (20.31.226.197:57520). Oct 27 13:23:44.342265 sshd[2341]: Accepted publickey for core from 20.31.226.197 port 57520 ssh2: RSA SHA256:BsNRVxk0Df/l+k97auxGU824qvUiIgxS1Xr4X1U/2b4 Oct 27 13:23:44.343297 sshd-session[2341]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Oct 27 13:23:44.347440 systemd-logind[1892]: New session '8' of user 'core' with class 'user' and type 'tty'. Oct 27 13:23:44.356662 systemd[1]: Started session-8.scope - Session 8 of User core. Oct 27 13:23:44.812210 sudo[2346]: core : PWD=/home/core ; USER=root ; COMMAND=/usr/sbin/setenforce 1 Oct 27 13:23:44.812438 sudo[2346]: pam_unix(sudo:session): session opened for user root(uid=0) by core(uid=500) Oct 27 13:23:44.839319 sudo[2346]: pam_unix(sudo:session): session closed for user root Oct 27 13:23:44.982800 sshd[2345]: Connection closed by 20.31.226.197 port 57520 Oct 27 13:23:44.983575 sshd-session[2341]: pam_unix(sshd:session): session closed for user core Oct 27 13:23:44.986307 systemd[1]: sshd@4-4-10.0.0.12:22-20.31.226.197:57520.service: Deactivated successfully. Oct 27 13:23:44.987759 systemd[1]: session-8.scope: Deactivated successfully. Oct 27 13:23:44.988512 systemd-logind[1892]: Session 8 logged out. Waiting for processes to exit. Oct 27 13:23:44.989599 systemd-logind[1892]: Removed session 8. Oct 27 13:23:45.140686 systemd[1]: Started sshd@5-5-10.0.0.12:22-20.31.226.197:57530.service - OpenSSH per-connection server daemon (20.31.226.197:57530). Oct 27 13:23:45.895576 sshd[2353]: Accepted publickey for core from 20.31.226.197 port 57530 ssh2: RSA SHA256:BsNRVxk0Df/l+k97auxGU824qvUiIgxS1Xr4X1U/2b4 Oct 27 13:23:45.896495 sshd-session[2353]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Oct 27 13:23:45.900346 systemd-logind[1892]: New session '9' of user 'core' with class 'user' and type 'tty'. Oct 27 13:23:45.909659 systemd[1]: Started session-9.scope - Session 9 of User core. Oct 27 13:23:46.188159 sudo[2359]: core : PWD=/home/core ; USER=root ; COMMAND=/usr/sbin/rm -rf /etc/audit/rules.d/80-selinux.rules /etc/audit/rules.d/99-default.rules Oct 27 13:23:46.188360 sudo[2359]: pam_unix(sudo:session): session opened for user root(uid=0) by core(uid=500) Oct 27 13:23:46.189469 sudo[2359]: pam_unix(sudo:session): session closed for user root Oct 27 13:23:46.194256 sudo[2358]: core : PWD=/home/core ; USER=root ; COMMAND=/usr/sbin/systemctl restart audit-rules Oct 27 13:23:46.194454 sudo[2358]: pam_unix(sudo:session): session opened for user root(uid=0) by core(uid=500) Oct 27 13:23:46.199872 systemd[1]: Starting audit-rules.service - Load Audit Rules... Oct 27 13:23:46.241000 audit: CONFIG_CHANGE auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 op=remove_rule key=(null) list=5 res=1 Oct 27 13:23:46.251966 kernel: kauditd_printk_skb: 76 callbacks suppressed Oct 27 13:23:46.252009 kernel: audit: type=1305 audit(1793107426.241:173): auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 op=remove_rule key=(null) list=5 res=1 Oct 27 13:23:46.241000 audit[2383]: SYSCALL arch=c00000b7 syscall=206 success=yes exit=1056 a0=3 a1=fffffd27caf0 a2=420 a3=0 items=0 ppid=2364 pid=2383 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) Oct 27 13:23:46.278170 kernel: audit: type=1300 audit(1793107426.241:173): arch=c00000b7 syscall=206 success=yes exit=1056 a0=3 a1=fffffd27caf0 a2=420 a3=0 items=0 ppid=2364 pid=2383 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) Oct 27 13:23:46.241000 audit: PROCTITLE proctitle=2F7362696E2F617564697463746C002D52002F6574632F61756469742F61756469742E72756C6573 Oct 27 13:23:46.285103 kernel: audit: type=1327 audit(1793107426.241:173): proctitle=2F7362696E2F617564697463746C002D52002F6574632F61756469742F61756469742E72756C6573 Oct 27 13:23:46.285271 augenrules[2383]: No rules Oct 27 13:23:46.286362 systemd[1]: audit-rules.service: Deactivated successfully. Oct 27 13:23:46.286654 systemd[1]: Finished audit-rules.service - Load Audit Rules. Oct 27 13:23:46.285000 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' Oct 27 13:23:46.289020 sudo[2358]: pam_unix(sudo:session): session closed for user root Oct 27 13:23:46.285000 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' Oct 27 13:23:46.316449 kernel: audit: type=1130 audit(1793107426.285:174): 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' Oct 27 13:23:46.287000 audit[2358]: AUDIT1106 pid=2358 uid=500 auid=500 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' Oct 27 13:23:46.316629 kernel: audit: type=1131 audit(1793107426.285: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' Oct 27 13:23:46.316654 kernel: audit: type=1106 audit(1793107426.287:176): pid=2358 uid=500 auid=500 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' Oct 27 13:23:46.287000 audit[2358]: AUDIT1104 pid=2358 uid=500 auid=500 ses=9 subj=system_u:system_r:kernel_t:s0 msg='op=PAM:setcred grantors=pam_env,pam_faillock acct="root" exe="/usr/bin/sudo" hostname=? addr=? terminal=? res=success' Oct 27 13:23:46.342097 kernel: audit: type=1104 audit(1793107426.287:177): pid=2358 uid=500 auid=500 ses=9 subj=system_u:system_r:kernel_t:s0 msg='op=PAM:setcred grantors=pam_env,pam_faillock acct="root" exe="/usr/bin/sudo" hostname=? addr=? terminal=? res=success' Oct 27 13:23:46.439497 sshd[2357]: Connection closed by 20.31.226.197 port 57530 Oct 27 13:23:46.439413 sshd-session[2353]: pam_unix(sshd:session): session closed for user core Oct 27 13:23:46.438000 audit[2353]: AUDIT1106 pid=2353 uid=0 auid=500 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="core" exe="/usr/lib64/misc/sshd-session" hostname=20.31.226.197 addr=20.31.226.197 terminal=ssh res=success' Oct 27 13:23:46.438000 audit[2353]: AUDIT1104 pid=2353 uid=0 auid=500 ses=9 subj=system_u:system_r:kernel_t:s0 msg='op=PAM:setcred grantors=pam_env,pam_faillock acct="core" exe="/usr/lib64/misc/sshd-session" hostname=20.31.226.197 addr=20.31.226.197 terminal=ssh res=success' Oct 27 13:23:46.463035 systemd[1]: sshd@5-5-10.0.0.12:22-20.31.226.197:57530.service: Deactivated successfully. Oct 27 13:23:46.465876 systemd[1]: session-9.scope: Deactivated successfully. Oct 27 13:23:46.475578 kernel: audit: type=1106 audit(1793107426.438:178): pid=2353 uid=0 auid=500 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="core" exe="/usr/lib64/misc/sshd-session" hostname=20.31.226.197 addr=20.31.226.197 terminal=ssh res=success' Oct 27 13:23:46.475642 kernel: audit: type=1104 audit(1793107426.438:179): pid=2353 uid=0 auid=500 ses=9 subj=system_u:system_r:kernel_t:s0 msg='op=PAM:setcred grantors=pam_env,pam_faillock acct="core" exe="/usr/lib64/misc/sshd-session" hostname=20.31.226.197 addr=20.31.226.197 terminal=ssh res=success' Oct 27 13:23:46.476291 systemd-logind[1892]: Session 9 logged out. Waiting for processes to exit. Oct 27 13:23:46.462000 audit[1]: SERVICE_STOP pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=sshd@5-5-10.0.0.12:22-20.31.226.197:57530 comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Oct 27 13:23:46.490989 kernel: audit: type=1131 audit(1793107426.462:180): pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=sshd@5-5-10.0.0.12:22-20.31.226.197:57530 comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Oct 27 13:23:46.491881 systemd-logind[1892]: Removed session 9. Oct 27 13:23:46.579000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=sshd@6-6-10.0.0.12:22-20.31.226.197:57532 comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Oct 27 13:23:46.580789 systemd[1]: Started sshd@6-6-10.0.0.12:22-20.31.226.197:57532.service - OpenSSH per-connection server daemon (20.31.226.197:57532). Oct 27 13:23:47.297000 audit[2392]: AUDIT1101 pid=2392 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 acct="core" exe="/usr/lib64/misc/sshd-session" hostname=20.31.226.197 addr=20.31.226.197 terminal=ssh res=success' Oct 27 13:23:47.300222 sshd[2392]: Accepted publickey for core from 20.31.226.197 port 57532 ssh2: RSA SHA256:BsNRVxk0Df/l+k97auxGU824qvUiIgxS1Xr4X1U/2b4 Oct 27 13:23:47.299000 audit[2392]: AUDIT1103 pid=2392 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='op=PAM:setcred grantors=pam_env,pam_faillock acct="core" exe="/usr/lib64/misc/sshd-session" hostname=20.31.226.197 addr=20.31.226.197 terminal=ssh res=success' Oct 27 13:23:47.299000 audit[2392]: SYSCALL arch=c00000b7 syscall=64 success=yes exit=3 a0=8 a1=ffffeba34130 a2=3 a3=0 items=0 ppid=1 pid=2392 auid=500 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) Oct 27 13:23:47.299000 audit: PROCTITLE proctitle=737368642D73657373696F6E3A20636F7265205B707269765D Oct 27 13:23:47.301005 sshd-session[2392]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Oct 27 13:23:47.306023 systemd-logind[1892]: New session '10' of user 'core' with class 'user' and type 'tty'. Oct 27 13:23:47.311686 systemd[1]: Started session-10.scope - Session 10 of User core. Oct 27 13:23:47.312000 audit[2392]: AUDIT1105 pid=2392 uid=0 auid=500 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="core" exe="/usr/lib64/misc/sshd-session" hostname=20.31.226.197 addr=20.31.226.197 terminal=ssh res=success' Oct 27 13:23:47.314000 audit[2396]: AUDIT1103 pid=2396 uid=0 auid=500 ses=10 subj=system_u:system_r:kernel_t:s0 msg='op=PAM:setcred grantors=pam_env,pam_faillock acct="core" exe="/usr/lib64/misc/sshd-session" hostname=20.31.226.197 addr=20.31.226.197 terminal=ssh res=success' Oct 27 13:23:47.576000 audit[2399]: AUDIT1101 pid=2399 uid=500 auid=500 ses=10 subj=system_u:system_r:kernel_t:s0 msg='op=PAM:accounting grantors=pam_unix,pam_faillock acct="core" exe="/usr/bin/sudo" hostname=? addr=? terminal=? res=success' Oct 27 13:23:47.578442 sudo[2399]: core : PWD=/home/core ; USER=root ; COMMAND=/usr/sbin/tee /etc/flatcar/update.conf Oct 27 13:23:47.577000 audit[2399]: AUDIT1110 pid=2399 uid=500 auid=500 ses=10 subj=system_u:system_r:kernel_t:s0 msg='op=PAM:setcred grantors=pam_env,pam_faillock acct="root" exe="/usr/bin/sudo" hostname=? addr=? terminal=? res=success' Oct 27 13:23:47.578923 sudo[2399]: pam_unix(sudo:session): session opened for user root(uid=0) by core(uid=500) Oct 27 13:23:47.577000 audit[2399]: AUDIT1105 pid=2399 uid=500 auid=500 ses=10 subj=system_u:system_r:kernel_t:s0 msg='op=PAM:session_open grantors=pam_limits,pam_env,pam_umask,pam_unix acct="root" exe="/usr/bin/sudo" hostname=? addr=? terminal=? res=success' Oct 27 13:23:47.659829 sudo[2399]: pam_unix(sudo:session): session closed for user root Oct 27 13:23:47.659000 audit[2399]: AUDIT1106 pid=2399 uid=500 auid=500 ses=10 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' Oct 27 13:23:47.659000 audit[2399]: AUDIT1104 pid=2399 uid=500 auid=500 ses=10 subj=system_u:system_r:kernel_t:s0 msg='op=PAM:setcred grantors=pam_env,pam_faillock acct="root" exe="/usr/bin/sudo" hostname=? addr=? terminal=? res=success' Oct 27 13:23:47.661754 systemd[1]: Starting motdgen.service - Generate /run/flatcar/motd... Oct 27 13:23:47.671502 motdgen[2407]: /oem/oem-release: line 2: Azure: command not found Oct 27 13:23:47.675203 systemd[1]: motdgen.service: Deactivated successfully. Oct 27 13:23:47.676000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=motdgen comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Oct 27 13:23:47.676000 audit[1]: SERVICE_STOP pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=motdgen comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Oct 27 13:23:47.676746 systemd[1]: Finished motdgen.service - Generate /run/flatcar/motd. Oct 27 13:23:47.797783 sshd[2396]: Connection closed by 20.31.226.197 port 57532 Oct 27 13:23:47.798000 audit[2392]: AUDIT1106 pid=2392 uid=0 auid=500 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="core" exe="/usr/lib64/misc/sshd-session" hostname=20.31.226.197 addr=20.31.226.197 terminal=ssh res=success' Oct 27 13:23:47.798708 sshd-session[2392]: pam_unix(sshd:session): session closed for user core Oct 27 13:23:47.798000 audit[2392]: AUDIT1104 pid=2392 uid=0 auid=500 ses=10 subj=system_u:system_r:kernel_t:s0 msg='op=PAM:setcred grantors=pam_env,pam_faillock acct="core" exe="/usr/lib64/misc/sshd-session" hostname=20.31.226.197 addr=20.31.226.197 terminal=ssh res=success' Oct 27 13:23:47.801694 systemd[1]: sshd@6-6-10.0.0.12:22-20.31.226.197:57532.service: Deactivated successfully. Oct 27 13:23:47.803000 audit[1]: SERVICE_STOP pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=sshd@6-6-10.0.0.12:22-20.31.226.197:57532 comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Oct 27 13:23:47.805295 systemd[1]: session-10.scope: Deactivated successfully. Oct 27 13:23:47.808368 systemd-logind[1892]: Session 10 logged out. Waiting for processes to exit. Oct 27 13:23:47.809998 systemd-logind[1892]: Removed session 10. Oct 27 13:23:48.194218 update_engine[1899]: I20261027 13:23:48.194054 1899 update_attempter.cc:509] Updating boot flags...