Oct 22 23:08:52.281522 kernel: Booting Linux on physical CPU 0x0000000000 [0x410fd490] Oct 22 23:08:52.281543 kernel: Linux version 6.12.113-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 Thu Oct 22 21:51:27 -00 2026 Oct 22 23:08:52.281550 kernel: KASLR enabled Oct 22 23:08:52.281554 kernel: earlycon: pl11 at MMIO 0x00000000effec000 (options '') Oct 22 23:08:52.281557 kernel: printk: legacy bootconsole [pl11] enabled Oct 22 23:08:52.281561 kernel: efi: EFI v2.7 by EDK II Oct 22 23:08:52.281568 kernel: efi: ACPI 2.0=0x3f979018 SMBIOS=0x3f8a0000 SMBIOS 3.0=0x3f880000 MEMATTR=0x3e878018 RNG=0x3f979998 MEMRESERVE=0x3db7b718 Oct 22 23:08:52.281572 kernel: random: crng init done Oct 22 23:08:52.281576 kernel: secureboot: Secure boot disabled Oct 22 23:08:52.281580 kernel: ACPI: Early table checksum verification disabled Oct 22 23:08:52.281584 kernel: ACPI: RSDP 0x000000003F979018 000024 (v02 VRTUAL) Oct 22 23:08:52.281588 kernel: ACPI: XSDT 0x000000003F979F18 00006C (v01 VRTUAL MICROSFT 00000001 MSFT 00000001) Oct 22 23:08:52.281592 kernel: ACPI: FACP 0x000000003F979C18 000114 (v06 VRTUAL MICROSFT 00000001 MSFT 00000001) Oct 22 23:08:52.281596 kernel: ACPI: DSDT 0x000000003F95A018 01E046 (v02 MSFTVM DSDT01 00000001 INTL 20230628) Oct 22 23:08:52.281602 kernel: ACPI: DBG2 0x000000003F979B18 000072 (v00 VRTUAL MICROSFT 00000001 MSFT 00000001) Oct 22 23:08:52.281606 kernel: ACPI: GTDT 0x000000003F979D98 000060 (v02 VRTUAL MICROSFT 00000001 MSFT 00000001) Oct 22 23:08:52.281611 kernel: ACPI: OEM0 0x000000003F979098 000064 (v01 VRTUAL MICROSFT 00000001 MSFT 00000001) Oct 22 23:08:52.281615 kernel: ACPI: SPCR 0x000000003F979A98 000050 (v02 VRTUAL MICROSFT 00000001 MSFT 00000001) Oct 22 23:08:52.281619 kernel: ACPI: APIC 0x000000003F979818 0000FC (v04 VRTUAL MICROSFT 00000001 MSFT 00000001) Oct 22 23:08:52.281624 kernel: ACPI: SRAT 0x000000003F979198 000234 (v03 VRTUAL MICROSFT 00000001 MSFT 00000001) Oct 22 23:08:52.281629 kernel: ACPI: PPTT 0x000000003F979418 00012C (v01 VRTUAL MICROSFT 00000000 MSFT 00000000) Oct 22 23:08:52.281633 kernel: ACPI: BGRT 0x000000003F979E98 000038 (v01 VRTUAL MICROSFT 00000001 MSFT 00000001) Oct 22 23:08:52.281638 kernel: ACPI: SPCR: console: pl011,mmio32,0xeffec000,115200 Oct 22 23:08:52.281642 kernel: ACPI: Use ACPI SPCR as default console: Yes Oct 22 23:08:52.281646 kernel: ACPI: SRAT: Node 0 PXM 0 [mem 0x00000000-0x3fffffff] hotplug Oct 22 23:08:52.281650 kernel: ACPI: SRAT: Node 0 PXM 0 [mem 0x100000000-0x1bfffffff] hotplug Oct 22 23:08:52.281655 kernel: ACPI: SRAT: Node 0 PXM 0 [mem 0x1c0000000-0xfbfffffff] hotplug Oct 22 23:08:52.281659 kernel: ACPI: SRAT: Node 0 PXM 0 [mem 0x1000000000-0xffffffffff] hotplug Oct 22 23:08:52.281663 kernel: ACPI: SRAT: Node 0 PXM 0 [mem 0x10000000000-0x1ffffffffff] hotplug Oct 22 23:08:52.281668 kernel: ACPI: SRAT: Node 0 PXM 0 [mem 0x20000000000-0x3ffffffffff] hotplug Oct 22 23:08:52.281672 kernel: ACPI: SRAT: Node 0 PXM 0 [mem 0x40000000000-0x7ffffffffff] hotplug Oct 22 23:08:52.281678 kernel: ACPI: SRAT: Node 0 PXM 0 [mem 0x80000000000-0xfffffffffff] hotplug Oct 22 23:08:52.281682 kernel: ACPI: SRAT: Node 0 PXM 0 [mem 0x100000000000-0x1fffffffffff] hotplug Oct 22 23:08:52.281687 kernel: ACPI: SRAT: Node 0 PXM 0 [mem 0x200000000000-0x3fffffffffff] hotplug Oct 22 23:08:52.281691 kernel: ACPI: SRAT: Node 0 PXM 0 [mem 0x400000000000-0x7fffffffffff] hotplug Oct 22 23:08:52.281695 kernel: ACPI: SRAT: Node 0 PXM 0 [mem 0x800000000000-0xffffffffffff] hotplug Oct 22 23:08:52.281699 kernel: NUMA: Node 0 [mem 0x00000000-0x3fffffff] + [mem 0x100000000-0x1bfffffff] -> [mem 0x00000000-0x1bfffffff] Oct 22 23:08:52.281704 kernel: NODE_DATA(0) allocated [mem 0x1bf800a00-0x1bf807fff] Oct 22 23:08:52.281708 kernel: Zone ranges: Oct 22 23:08:52.281712 kernel: DMA [mem 0x0000000000000000-0x00000000ffffffff] Oct 22 23:08:52.281719 kernel: DMA32 empty Oct 22 23:08:52.281724 kernel: Normal [mem 0x0000000100000000-0x00000001bfffffff] Oct 22 23:08:52.281728 kernel: Device empty Oct 22 23:08:52.281733 kernel: Movable zone start for each node Oct 22 23:08:52.281737 kernel: Early memory node ranges Oct 22 23:08:52.281743 kernel: node 0: [mem 0x0000000000000000-0x00000000007fffff] Oct 22 23:08:52.281747 kernel: node 0: [mem 0x0000000000824000-0x000000003f38ffff] Oct 22 23:08:52.281752 kernel: node 0: [mem 0x000000003f390000-0x000000003f943fff] Oct 22 23:08:52.281756 kernel: node 0: [mem 0x000000003f944000-0x000000003f9effff] Oct 22 23:08:52.281761 kernel: node 0: [mem 0x000000003f9f0000-0x000000003fdeffff] Oct 22 23:08:52.281765 kernel: node 0: [mem 0x000000003fdf0000-0x000000003fffffff] Oct 22 23:08:52.281769 kernel: node 0: [mem 0x0000000100000000-0x00000001bfffffff] Oct 22 23:08:52.281774 kernel: Initmem setup node 0 [mem 0x0000000000000000-0x00000001bfffffff] Oct 22 23:08:52.281778 kernel: On node 0, zone DMA: 36 pages in unavailable ranges Oct 22 23:08:52.281783 kernel: cma: Reserved 16 MiB at 0x000000003ca00000 on node -1 Oct 22 23:08:52.281787 kernel: psci: probing for conduit method from ACPI. Oct 22 23:08:52.281793 kernel: psci: PSCIv1.3 detected in firmware. Oct 22 23:08:52.281797 kernel: psci: Using standard PSCI v0.2 function IDs Oct 22 23:08:52.281802 kernel: psci: MIGRATE_INFO_TYPE not supported. Oct 22 23:08:52.281806 kernel: psci: SMC Calling Convention v1.4 Oct 22 23:08:52.281811 kernel: ACPI: NUMA: SRAT: PXM 0 -> MPIDR 0x0 -> Node 0 Oct 22 23:08:52.281815 kernel: ACPI: NUMA: SRAT: PXM 0 -> MPIDR 0x1 -> Node 0 Oct 22 23:08:52.281820 kernel: percpu: Embedded 34 pages/cpu s98968 r8192 d32104 u139264 Oct 22 23:08:52.281824 kernel: pcpu-alloc: s98968 r8192 d32104 u139264 alloc=34*4096 Oct 22 23:08:52.281829 kernel: pcpu-alloc: [0] 0 [0] 1 Oct 22 23:08:52.281833 kernel: Detected PIPT I-cache on CPU0 Oct 22 23:08:52.281838 kernel: CPU features: detected: Address authentication (architected QARMA5 algorithm) Oct 22 23:08:52.281843 kernel: CPU features: detected: GIC system register CPU interface Oct 22 23:08:52.281848 kernel: CPU features: detected: Spectre-v4 Oct 22 23:08:52.281852 kernel: CPU features: detected: Spectre-BHB Oct 22 23:08:52.281857 kernel: CPU features: kernel page table isolation forced ON by KASLR Oct 22 23:08:52.281861 kernel: CPU features: detected: Kernel page table isolation (KPTI) Oct 22 23:08:52.281866 kernel: CPU features: detected: ARM erratum 2067961 or 2054223 Oct 22 23:08:52.281870 kernel: CPU features: detected: Broken broadcast TLBI completion Oct 22 23:08:52.281875 kernel: CPU features: detected: SSBS not fully self-synchronizing Oct 22 23:08:52.281879 kernel: alternatives: applying boot alternatives Oct 22 23:08:52.281884 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=a4f294c2f4d3ba7f3e6f9dcc29f5bdb8ef7e69c86ff204343f35e3ac468d53d2 Oct 22 23:08:52.281890 kernel: Dentry cache hash table entries: 524288 (order: 10, 4194304 bytes, linear) Oct 22 23:08:52.281895 kernel: Inode-cache hash table entries: 262144 (order: 9, 2097152 bytes, linear) Oct 22 23:08:52.281899 kernel: Fallback order for Node 0: 0 Oct 22 23:08:52.281904 kernel: Built 1 zonelists, mobility grouping on. Total pages: 1048540 Oct 22 23:08:52.281908 kernel: Policy zone: Normal Oct 22 23:08:52.281913 kernel: mem auto-init: stack:off, heap alloc:off, heap free:off Oct 22 23:08:52.281917 kernel: software IO TLB: area num 2. Oct 22 23:08:52.281922 kernel: software IO TLB: mapped [mem 0x0000000034ae0000-0x0000000038ae0000] (64MB) Oct 22 23:08:52.281926 kernel: SLUB: HWalign=64, Order=0-3, MinObjects=0, CPUs=2, Nodes=1 Oct 22 23:08:52.281931 kernel: ftrace: allocating 41419 entries in 164 pages Oct 22 23:08:52.281935 kernel: ftrace: allocated 164 pages with 3 groups Oct 22 23:08:52.281940 kernel: rcu: Preemptible hierarchical RCU implementation. Oct 22 23:08:52.281946 kernel: rcu: RCU event tracing is enabled. Oct 22 23:08:52.281950 kernel: rcu: RCU restricting CPUs from NR_CPUS=512 to nr_cpu_ids=2. Oct 22 23:08:52.281955 kernel: Trampoline variant of Tasks RCU enabled. Oct 22 23:08:52.281960 kernel: Rude variant of Tasks RCU enabled. Oct 22 23:08:52.282003 kernel: Tracing variant of Tasks RCU enabled. Oct 22 23:08:52.282008 kernel: rcu: RCU calculated value of scheduler-enlistment delay is 100 jiffies. Oct 22 23:08:52.282012 kernel: rcu: Adjusting geometry for rcu_fanout_leaf=16, nr_cpu_ids=2 Oct 22 23:08:52.282017 kernel: RCU Tasks: Setting shift to 1 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=2. Oct 22 23:08:52.282022 kernel: RCU Tasks Rude: Setting shift to 1 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=2. Oct 22 23:08:52.282026 kernel: RCU Tasks Trace: Setting shift to 1 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=2. Oct 22 23:08:52.282032 kernel: NR_IRQS: 64, nr_irqs: 64, preallocated irqs: 0 Oct 22 23:08:52.282036 kernel: GICv3: 960 SPIs implemented Oct 22 23:08:52.282041 kernel: GICv3: 0 Extended SPIs implemented Oct 22 23:08:52.282045 kernel: Root IRQ handler: gic_handle_irq Oct 22 23:08:52.282050 kernel: GICv3: GICv3 features: 16 PPIs, RSS Oct 22 23:08:52.282054 kernel: GICv3: GICD_CTRL.DS=0, SCR_EL3.FIQ=0 Oct 22 23:08:52.282059 kernel: GICv3: CPU0: found redistributor 0 region 0:0x00000000effee000 Oct 22 23:08:52.282063 kernel: ITS: No ITS available, not enabling LPIs Oct 22 23:08:52.282068 kernel: rcu: srcu_init: Setting srcu_struct sizes based on contention. Oct 22 23:08:52.282073 kernel: clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1911260446275000 ns Oct 22 23:08:52.282077 kernel: arch_timer: cp15 timer(s) running at 1000.00MHz (virt). Oct 22 23:08:52.282083 kernel: clocksource: arch_sys_counter: mask: 0x1fffffffffffffff max_cycles: 0x1cd42e4dffb, max_idle_ns: 881590591483 ns Oct 22 23:08:52.282087 kernel: sched_clock: 61 bits at 1000MHz, resolution 1ns, wraps every 4398046511103ns Oct 22 23:08:52.282092 kernel: Console: colour dummy device 80x25 Oct 22 23:08:52.282097 kernel: printk: legacy console [tty1] enabled Oct 22 23:08:52.282102 kernel: ACPI: Core revision 20240827 Oct 22 23:08:52.282107 kernel: Calibrating delay loop (skipped), value calculated using timer frequency.. 2000.00 BogoMIPS (lpj=1000000) Oct 22 23:08:52.282112 kernel: pid_max: default: 32768 minimum: 301 Oct 22 23:08:52.282116 kernel: LSM: initializing lsm=lockdown,capability,landlock,selinux,ima Oct 22 23:08:52.282125 kernel: landlock: Up and running. Oct 22 23:08:52.282130 kernel: SELinux: Initializing. Oct 22 23:08:52.282136 kernel: Mount-cache hash table entries: 8192 (order: 4, 65536 bytes, linear) Oct 22 23:08:52.282141 kernel: Mountpoint-cache hash table entries: 8192 (order: 4, 65536 bytes, linear) Oct 22 23:08:52.282146 kernel: Hyper-V: privilege flags low 0x2e7f, high 0x3b8030, hints 0xa0000e, misc 0x31e1 Oct 22 23:08:52.282151 kernel: Hyper-V: Host Build 10.0.26102.3704-3-0 Oct 22 23:08:52.282156 kernel: Hyper-V: enabling crash_kexec_post_notifiers Oct 22 23:08:52.282162 kernel: rcu: Hierarchical SRCU implementation. Oct 22 23:08:52.282167 kernel: rcu: Max phase no-delay instances is 400. Oct 22 23:08:52.282172 kernel: Timer migration: 1 hierarchy levels; 8 children per group; 1 crossnode level Oct 22 23:08:52.282177 kernel: Remapping and enabling EFI services. Oct 22 23:08:52.282181 kernel: smp: Bringing up secondary CPUs ... Oct 22 23:08:52.282186 kernel: Detected PIPT I-cache on CPU1 Oct 22 23:08:52.282191 kernel: GICv3: CPU1: found redistributor 1 region 1:0x00000000f000e000 Oct 22 23:08:52.282197 kernel: CPU1: Booted secondary processor 0x0000000001 [0x410fd490] Oct 22 23:08:52.282202 kernel: smp: Brought up 1 node, 2 CPUs Oct 22 23:08:52.282207 kernel: SMP: Total of 2 processors activated. Oct 22 23:08:52.282212 kernel: CPU: All CPU(s) started at EL1 Oct 22 23:08:52.282217 kernel: CPU features: detected: 32-bit EL0 Support Oct 22 23:08:52.282222 kernel: CPU features: detected: Instruction cache invalidation not required for I/D coherence Oct 22 23:08:52.282227 kernel: CPU features: detected: Data cache clean to the PoU not required for I/D coherence Oct 22 23:08:52.282233 kernel: CPU features: detected: Common not Private translations Oct 22 23:08:52.282238 kernel: CPU features: detected: CRC32 instructions Oct 22 23:08:52.282243 kernel: CPU features: detected: Generic authentication (architected QARMA5 algorithm) Oct 22 23:08:52.282248 kernel: CPU features: detected: RCpc load-acquire (LDAPR) Oct 22 23:08:52.282253 kernel: CPU features: detected: LSE atomic instructions Oct 22 23:08:52.282258 kernel: CPU features: detected: Privileged Access Never Oct 22 23:08:52.282262 kernel: CPU features: detected: Speculation barrier (SB) Oct 22 23:08:52.282268 kernel: CPU features: detected: TLB range maintenance instructions Oct 22 23:08:52.282273 kernel: CPU features: detected: Speculative Store Bypassing Safe (SSBS) Oct 22 23:08:52.282278 kernel: CPU features: detected: Scalable Vector Extension Oct 22 23:08:52.282283 kernel: alternatives: applying system-wide alternatives Oct 22 23:08:52.282288 kernel: CPU features: detected: Hardware dirty bit management on CPU0-1 Oct 22 23:08:52.282293 kernel: SVE: maximum available vector length 16 bytes per vector Oct 22 23:08:52.282298 kernel: SVE: default vector length 16 bytes per vector Oct 22 23:08:52.282304 kernel: Memory: 3976344K/4194160K available (12544K kernel code, 2480K rwdata, 9560K rodata, 13376K init, 1040K bss, 195864K reserved, 16384K cma-reserved) Oct 22 23:08:52.282309 kernel: devtmpfs: initialized Oct 22 23:08:52.282314 kernel: futex hash table entries: 512 (order: 3, 32768 bytes, linear) Oct 22 23:08:52.282319 kernel: 2G module region forced by RANDOMIZE_MODULE_REGION_FULL Oct 22 23:08:52.282324 kernel: 0 pages in range for non-PLT usage Oct 22 23:08:52.282329 kernel: 514480 pages in range for PLT usage Oct 22 23:08:52.282334 kernel: pinctrl core: initialized pinctrl subsystem Oct 22 23:08:52.282340 kernel: SMBIOS 3.1.0 present. Oct 22 23:08:52.282345 kernel: DMI: Microsoft Corporation Virtual Machine/Virtual Machine, BIOS Hyper-V UEFI Release v4.1 04/22/2026 Oct 22 23:08:52.282350 kernel: DMI: Memory slots populated: 2/2 Oct 22 23:08:52.282355 kernel: NET: Registered PF_NETLINK/PF_ROUTE protocol family Oct 22 23:08:52.282360 kernel: DMA: preallocated 512 KiB GFP_KERNEL pool for atomic allocations Oct 22 23:08:52.282365 kernel: DMA: preallocated 512 KiB GFP_KERNEL|GFP_DMA pool for atomic allocations Oct 22 23:08:52.282370 kernel: DMA: preallocated 512 KiB GFP_KERNEL|GFP_DMA32 pool for atomic allocations Oct 22 23:08:52.282376 kernel: audit: initializing netlink subsys (disabled) Oct 22 23:08:52.282381 kernel: audit: type=2000 audit(0.059:1): state=initialized audit_enabled=0 res=1 Oct 22 23:08:52.282386 kernel: thermal_sys: Registered thermal governor 'step_wise' Oct 22 23:08:52.282390 kernel: cpuidle: using governor menu Oct 22 23:08:52.282395 kernel: hw-breakpoint: found 6 breakpoint and 4 watchpoint registers. Oct 22 23:08:52.282400 kernel: ASID allocator initialised with 32768 entries Oct 22 23:08:52.282405 kernel: acpiphp: ACPI Hot Plug PCI Controller Driver version: 0.5 Oct 22 23:08:52.282411 kernel: Serial: AMBA PL011 UART driver Oct 22 23:08:52.282416 kernel: HugeTLB: registered 1.00 GiB page size, pre-allocated 0 pages Oct 22 23:08:52.282421 kernel: HugeTLB: 0 KiB vmemmap can be freed for a 1.00 GiB page Oct 22 23:08:52.282426 kernel: HugeTLB: registered 32.0 MiB page size, pre-allocated 0 pages Oct 22 23:08:52.282431 kernel: HugeTLB: 0 KiB vmemmap can be freed for a 32.0 MiB page Oct 22 23:08:52.282436 kernel: HugeTLB: registered 2.00 MiB page size, pre-allocated 0 pages Oct 22 23:08:52.282441 kernel: HugeTLB: 0 KiB vmemmap can be freed for a 2.00 MiB page Oct 22 23:08:52.282446 kernel: HugeTLB: registered 64.0 KiB page size, pre-allocated 0 pages Oct 22 23:08:52.282451 kernel: HugeTLB: 0 KiB vmemmap can be freed for a 64.0 KiB page Oct 22 23:08:52.282456 kernel: ACPI: Added _OSI(Module Device) Oct 22 23:08:52.282461 kernel: ACPI: Added _OSI(Processor Device) Oct 22 23:08:52.282466 kernel: ACPI: Added _OSI(Processor Aggregator Device) Oct 22 23:08:52.282471 kernel: ACPI: 1 ACPI AML tables successfully acquired and loaded Oct 22 23:08:52.282476 kernel: ACPI: Interpreter enabled Oct 22 23:08:52.282481 kernel: ACPI: Using GIC for interrupt routing Oct 22 23:08:52.282487 kernel: ARMH0011:00: ttyAMA0 at MMIO 0xeffec000 (irq = 12, base_baud = 0) is a SBSA Oct 22 23:08:52.282492 kernel: printk: legacy console [ttyAMA0] enabled Oct 22 23:08:52.282496 kernel: printk: legacy bootconsole [pl11] disabled Oct 22 23:08:52.282501 kernel: ARMH0011:01: ttyAMA1 at MMIO 0xeffeb000 (irq = 13, base_baud = 0) is a SBSA Oct 22 23:08:52.282507 kernel: ACPI: CPU0 has been hot-added Oct 22 23:08:52.282511 kernel: ACPI: CPU1 has been hot-added Oct 22 23:08:52.282516 kernel: iommu: Default domain type: Translated Oct 22 23:08:52.282522 kernel: iommu: DMA domain TLB invalidation policy: strict mode Oct 22 23:08:52.282527 kernel: efivars: Registered efivars operations Oct 22 23:08:52.282532 kernel: vgaarb: loaded Oct 22 23:08:52.282537 kernel: clocksource: Switched to clocksource arch_sys_counter Oct 22 23:08:52.282542 kernel: VFS: Disk quotas dquot_6.6.0 Oct 22 23:08:52.282547 kernel: VFS: Dquot-cache hash table entries: 512 (order 0, 4096 bytes) Oct 22 23:08:52.282551 kernel: pnp: PnP ACPI init Oct 22 23:08:52.282557 kernel: pnp: PnP ACPI: found 0 devices Oct 22 23:08:52.282562 kernel: NET: Registered PF_INET protocol family Oct 22 23:08:52.282567 kernel: IP idents hash table entries: 65536 (order: 7, 524288 bytes, linear) Oct 22 23:08:52.282572 kernel: tcp_listen_portaddr_hash hash table entries: 2048 (order: 3, 32768 bytes, linear) Oct 22 23:08:52.282577 kernel: Table-perturb hash table entries: 65536 (order: 6, 262144 bytes, linear) Oct 22 23:08:52.282582 kernel: TCP established hash table entries: 32768 (order: 6, 262144 bytes, linear) Oct 22 23:08:52.282587 kernel: TCP bind hash table entries: 32768 (order: 8, 1048576 bytes, linear) Oct 22 23:08:52.282593 kernel: TCP: Hash tables configured (established 32768 bind 32768) Oct 22 23:08:52.282598 kernel: UDP hash table entries: 2048 (order: 4, 65536 bytes, linear) Oct 22 23:08:52.282603 kernel: UDP-Lite hash table entries: 2048 (order: 4, 65536 bytes, linear) Oct 22 23:08:52.282608 kernel: NET: Registered PF_UNIX/PF_LOCAL protocol family Oct 22 23:08:52.282613 kernel: PCI: CLS 0 bytes, default 64 Oct 22 23:08:52.282617 kernel: kvm [1]: HYP mode not available Oct 22 23:08:52.282622 kernel: Initialise system trusted keyrings Oct 22 23:08:52.282628 kernel: workingset: timestamp_bits=39 max_order=20 bucket_order=0 Oct 22 23:08:52.282633 kernel: Key type asymmetric registered Oct 22 23:08:52.282638 kernel: Asymmetric key parser 'x509' registered Oct 22 23:08:52.282643 kernel: Block layer SCSI generic (bsg) driver version 0.4 loaded (major 249) Oct 22 23:08:52.282648 kernel: io scheduler mq-deadline registered Oct 22 23:08:52.282653 kernel: io scheduler kyber registered Oct 22 23:08:52.282658 kernel: io scheduler bfq registered Oct 22 23:08:52.282664 kernel: Serial: 8250/16550 driver, 4 ports, IRQ sharing enabled Oct 22 23:08:52.282669 kernel: ACPI: bus type drm_connector registered Oct 22 23:08:52.282674 kernel: thunder_xcv, ver 1.0 Oct 22 23:08:52.282679 kernel: thunder_bgx, ver 1.0 Oct 22 23:08:52.282684 kernel: nicpf, ver 1.0 Oct 22 23:08:52.282688 kernel: nicvf, ver 1.0 Oct 22 23:08:52.282850 kernel: rtc-efi rtc-efi.0: registered as rtc0 Oct 22 23:08:52.282938 kernel: rtc-efi rtc-efi.0: setting system clock to 2026-10-22T23:08:47 UTC (1792710527) Oct 22 23:08:52.282945 kernel: efifb: probing for efifb Oct 22 23:08:52.282950 kernel: efifb: framebuffer at 0x40000000, using 3072k, total 3072k Oct 22 23:08:52.282956 kernel: efifb: mode is 1024x768x32, linelength=4096, pages=1 Oct 22 23:08:52.282971 kernel: efifb: scrolling: redraw Oct 22 23:08:52.282977 kernel: efifb: Truecolor: size=8:8:8:8, shift=24:16:8:0 Oct 22 23:08:52.282983 kernel: Console: switching to colour frame buffer device 128x48 Oct 22 23:08:52.282989 kernel: fb0: EFI VGA frame buffer device Oct 22 23:08:52.282994 kernel: SMCCC: SOC_ID: ARCH_SOC_ID not implemented, skipping .... Oct 22 23:08:52.282999 kernel: hid: raw HID events driver (C) Jiri Kosina Oct 22 23:08:52.283004 kernel: hw perfevents: enabled with armv8_pmuv3_0 PMU driver, 7 (0,8000003f) counters available Oct 22 23:08:52.283009 kernel: watchdog: NMI not fully supported Oct 22 23:08:52.283014 kernel: NET: Registered PF_INET6 protocol family Oct 22 23:08:52.283019 kernel: watchdog: Hard watchdog permanently disabled Oct 22 23:08:52.283025 kernel: Segment Routing with IPv6 Oct 22 23:08:52.283030 kernel: In-situ OAM (IOAM) with IPv6 Oct 22 23:08:52.283035 kernel: NET: Registered PF_PACKET protocol family Oct 22 23:08:52.283040 kernel: Key type dns_resolver registered Oct 22 23:08:52.283045 kernel: registered taskstats version 1 Oct 22 23:08:52.283050 kernel: Loading compiled-in X.509 certificates Oct 22 23:08:52.283055 kernel: Loaded X.509 cert 'Kinvolk GmbH: Module signing key for 6.12.113-flatcar: 77e0a404dfde641b3b119edc94c604689bf33008' Oct 22 23:08:52.283061 kernel: Demotion targets for Node 0: null Oct 22 23:08:52.283066 kernel: Key type .fscrypt registered Oct 22 23:08:52.283071 kernel: Key type fscrypt-provisioning registered Oct 22 23:08:52.283076 kernel: integrity: secureboot mode disabled Oct 22 23:08:52.283081 kernel: ima: No TPM chip found, activating TPM-bypass! Oct 22 23:08:52.283086 kernel: ima: Allocated hash algorithm: sha1 Oct 22 23:08:52.283091 kernel: ima: No architecture policies found Oct 22 23:08:52.283097 kernel: alg: No test for fips(ansi_cprng) (fips_ansi_cprng) Oct 22 23:08:52.283102 kernel: clk: Disabling unused clocks Oct 22 23:08:52.283107 kernel: PM: genpd: Disabling unused power domains Oct 22 23:08:52.283112 kernel: Freeing unused kernel memory: 13376K Oct 22 23:08:52.283117 kernel: Run /init as init process Oct 22 23:08:52.283121 kernel: with arguments: Oct 22 23:08:52.283126 kernel: /init Oct 22 23:08:52.283131 kernel: with environment: Oct 22 23:08:52.283137 kernel: HOME=/ Oct 22 23:08:52.283142 kernel: TERM=linux Oct 22 23:08:52.283147 kernel: hv_vmbus: hv_mmio=[mem 0x40000000-0xfed3ffff],[mem 0xfc0000000-0xfffffffff] fb=[mem 0x40000000-0x47ffffff] Oct 22 23:08:52.283152 kernel: hv_vmbus: Vmbus version:5.3 Oct 22 23:08:52.283157 kernel: SCSI subsystem initialized Oct 22 23:08:52.283162 kernel: hv_vmbus: registering driver hid_hyperv Oct 22 23:08:52.283167 kernel: input: Microsoft Vmbus HID-compliant Mouse as /devices/0006:045E:0621.0001/input/input0 Oct 22 23:08:52.283276 kernel: hid-hyperv 0006:045E:0621.0001: input: VIRTUAL HID v0.01 Mouse [Microsoft Vmbus HID-compliant Mouse] on Oct 22 23:08:52.283284 kernel: hv_vmbus: registering driver hyperv_keyboard Oct 22 23:08:52.283289 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 22 23:08:52.283294 kernel: pps_core: LinuxPPS API ver. 1 registered Oct 22 23:08:52.283299 kernel: pps_core: Software ver. 5.3.6 - Copyright 2005-2007 Rodolfo Giometti Oct 22 23:08:52.283304 kernel: PTP clock support registered Oct 22 23:08:52.283310 kernel: hv_utils: Registering HyperV Utility Driver Oct 22 23:08:52.283315 kernel: hv_vmbus: registering driver hv_utils Oct 22 23:08:52.283320 kernel: hv_utils: Heartbeat IC version 3.0 Oct 22 23:08:52.283325 kernel: hv_utils: Shutdown IC version 3.2 Oct 22 23:08:52.283330 kernel: hv_utils: TimeSync IC version 4.0 Oct 22 23:08:52.283335 kernel: hv_vmbus: registering driver hv_storvsc Oct 22 23:08:52.283450 kernel: scsi host0: storvsc_host_t Oct 22 23:08:52.283552 kernel: scsi host1: storvsc_host_t Oct 22 23:08:52.283664 kernel: scsi 0:0:0:0: Direct-Access Msft Virtual Disk 1.0 PQ: 0 ANSI: 5 Oct 22 23:08:52.283774 kernel: scsi 0:0:0:2: CD-ROM Msft Virtual DVD-ROM 1.0 PQ: 0 ANSI: 5 Oct 22 23:08:52.283873 kernel: sd 0:0:0:0: [sda] 63737856 512-byte logical blocks: (32.6 GB/30.4 GiB) Oct 22 23:08:52.286038 kernel: sd 0:0:0:0: [sda] 4096-byte physical blocks Oct 22 23:08:52.286202 kernel: sd 0:0:0:0: [sda] Write Protect is off Oct 22 23:08:52.286307 kernel: sd 0:0:0:0: [sda] Mode Sense: 0f 00 10 00 Oct 22 23:08:52.286407 kernel: sd 0:0:0:0: [sda] Write cache: disabled, read cache: enabled, supports DPO and FUA Oct 22 23:08:52.286413 kernel: sda: sda1 sda2 sda3 sda4 sda6 sda7 sda9 Oct 22 23:08:52.286511 kernel: sd 0:0:0:0: [sda] Attached SCSI disk Oct 22 23:08:52.286610 kernel: sr 0:0:0:2: [sr0] scsi-1 drive Oct 22 23:08:52.286619 kernel: cdrom: Uniform CD-ROM driver Revision: 3.20 Oct 22 23:08:52.286715 kernel: sr 0:0:0:2: Attached scsi CD-ROM sr0 Oct 22 23:08:52.286722 kernel: device-mapper: core: CONFIG_IMA_DISABLE_HTABLE is disabled. Duplicate IMA measurements will not be recorded in the IMA log. Oct 22 23:08:52.286727 kernel: device-mapper: uevent: version 1.0.3 Oct 22 23:08:52.286732 kernel: device-mapper: ioctl: 4.48.0-ioctl (2023-03-01) initialised: dm-devel@lists.linux.dev Oct 22 23:08:52.286737 kernel: device-mapper: verity: sha256 using shash "sha256-ce" Oct 22 23:08:52.286743 kernel: raid6: neonx8 gen() 18561 MB/s Oct 22 23:08:52.286749 kernel: raid6: neonx4 gen() 18575 MB/s Oct 22 23:08:52.286754 kernel: raid6: neonx2 gen() 17037 MB/s Oct 22 23:08:52.286759 kernel: raid6: neonx1 gen() 15106 MB/s Oct 22 23:08:52.286764 kernel: raid6: int64x8 gen() 9013 MB/s Oct 22 23:08:52.286769 kernel: raid6: int64x4 gen() 10753 MB/s Oct 22 23:08:52.286774 kernel: raid6: int64x2 gen() 8838 MB/s Oct 22 23:08:52.286779 kernel: raid6: int64x1 gen() 7082 MB/s Oct 22 23:08:52.286785 kernel: raid6: using algorithm neonx4 gen() 18575 MB/s Oct 22 23:08:52.286790 kernel: raid6: .... xor() 15164 MB/s, rmw enabled Oct 22 23:08:52.286795 kernel: raid6: using neon recovery algorithm Oct 22 23:08:52.286800 kernel: xor: measuring software checksum speed Oct 22 23:08:52.286805 kernel: 8regs : 29566 MB/sec Oct 22 23:08:52.286810 kernel: 32regs : 29662 MB/sec Oct 22 23:08:52.286815 kernel: arm64_neon : 37087 MB/sec Oct 22 23:08:52.286820 kernel: xor: using function: arm64_neon (37087 MB/sec) Oct 22 23:08:52.286826 kernel: Btrfs loaded, zoned=no, fsverity=no Oct 22 23:08:52.286832 kernel: BTRFS: device fsid 230079d3-281b-4070-93e9-c3be5c5385fa devid 1 transid 39 /dev/mapper/usr (254:0) scanned by mount (401) Oct 22 23:08:52.286837 kernel: BTRFS info (device dm-0): first mount of filesystem 230079d3-281b-4070-93e9-c3be5c5385fa Oct 22 23:08:52.286842 kernel: BTRFS info (device dm-0): using crc32c (crc32c-generic) checksum algorithm Oct 22 23:08:52.286847 kernel: BTRFS info (device dm-0 state E): disabling log replay at mount time Oct 22 23:08:52.286852 kernel: BTRFS info (device dm-0 state E): enabling free space tree Oct 22 23:08:52.286857 kernel: loop: module loaded Oct 22 23:08:52.286863 kernel: loop0: detected capacity change from 0 to 100192 Oct 22 23:08:52.286868 kernel: squashfs: version 4.0 (2009/01/31) Phillip Lougher Oct 22 23:08:52.286874 systemd[1]: Successfully made /usr/ read-only. Oct 22 23:08:52.286881 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 22 23:08:52.286887 systemd[1]: Detected virtualization microsoft. Oct 22 23:08:52.286893 systemd[1]: Detected architecture arm64. Oct 22 23:08:52.286898 systemd[1]: Running in initrd. Oct 22 23:08:52.286904 systemd[1]: Initializing machine ID from random generator. Oct 22 23:08:52.286910 systemd[1]: No hostname configured, using default hostname. Oct 22 23:08:52.286915 systemd[1]: Hostname set to . Oct 22 23:08:52.286920 systemd[1]: Queued start job for default target initrd.target. Oct 22 23:08:52.286926 systemd[1]: Started clevis-luks-askpass.path - Forward Password Requests to Clevis Directory Watch. Oct 22 23:08:52.286933 systemd[1]: Started systemd-ask-password-console.path - Dispatch Password Requests to Console Directory Watch. Oct 22 23:08:52.286939 systemd[1]: Expecting device dev-disk-by\x2dlabel-EFI\x2dSYSTEM.device - /dev/disk/by-label/EFI-SYSTEM... Oct 22 23:08:52.286944 systemd[1]: Expecting device dev-disk-by\x2dlabel-OEM.device - /dev/disk/by-label/OEM... Oct 22 23:08:52.286950 systemd[1]: Expecting device dev-disk-by\x2dlabel-ROOT.device - /dev/disk/by-label/ROOT... Oct 22 23:08:52.286956 systemd[1]: Expecting device dev-disk-by\x2dpartlabel-USR\x2dA.device - /dev/disk/by-partlabel/USR-A... Oct 22 23:08:52.286978 systemd[1]: Expecting device dev-mapper-usr.device - /dev/mapper/usr... Oct 22 23:08:52.286985 systemd[1]: Reached target cryptsetup-pre.target - Local Encrypted Volumes (Pre). Oct 22 23:08:52.286991 systemd[1]: Reached target cryptsetup.target - Local Encrypted Volumes. Oct 22 23:08:52.286997 systemd[1]: Reached target initrd-usr-fs.target - Initrd /usr File System. Oct 22 23:08:52.287002 systemd[1]: Reached target paths.target - Path Units. Oct 22 23:08:52.287007 systemd[1]: Reached target slices.target - Slice Units. Oct 22 23:08:52.287013 systemd[1]: Reached target swap.target - Swaps. Oct 22 23:08:52.287020 systemd[1]: Reached target timers.target - Timer Units. Oct 22 23:08:52.287030 systemd[1]: Listening on iscsid.socket - Open-iSCSI iscsid Socket. Oct 22 23:08:52.287037 systemd[1]: Listening on iscsiuio.socket - Open-iSCSI iscsiuio Socket. Oct 22 23:08:52.287043 systemd[1]: Listening on systemd-coredump.socket - Process Core Dump Socket. Oct 22 23:08:52.287048 systemd[1]: Listening on systemd-journald-audit.socket - Journal Audit Socket. Oct 22 23:08:52.287055 systemd[1]: Listening on systemd-journald-dev-log.socket - Journal Socket (/dev/log). Oct 22 23:08:52.287060 systemd[1]: Listening on systemd-journald.socket - Journal Sockets. Oct 22 23:08:52.287066 systemd[1]: Listening on systemd-networkd-resolve-hook.socket - Network Management Resolve Hook Socket. Oct 22 23:08:52.287072 systemd[1]: Listening on systemd-networkd.socket - Network Management Netlink Socket. Oct 22 23:08:52.287077 systemd[1]: Listening on systemd-udevd-control.socket - udev Control Socket. Oct 22 23:08:52.287083 systemd[1]: Listening on systemd-udevd-kernel.socket - udev Kernel Socket. Oct 22 23:08:52.287089 systemd[1]: Reached target sockets.target - Socket Units. Oct 22 23:08:52.287095 systemd[1]: afterburn-network-kargs.service - Afterburn Initrd Setup Network Kernel Arguments skipped, no trigger condition checks were met. Oct 22 23:08:52.287101 systemd[1]: Starting ignition-setup-pre.service - Ignition env setup... Oct 22 23:08:52.287107 systemd[1]: Starting kmod-static-nodes.service - Create List of Static Device Nodes... Oct 22 23:08:52.287112 systemd[1]: Finished network-cleanup.service - Network Cleanup. Oct 22 23:08:52.287118 systemd[1]: systemd-battery-check.service - Early Battery Level Check skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/class/power_supply Oct 22 23:08:52.287124 systemd[1]: Starting systemd-journald.service - Journal Service... Oct 22 23:08:52.287130 systemd[1]: Starting systemd-modules-load.service - Load Kernel Modules... Oct 22 23:08:52.287155 systemd-journald[513]: Collecting audit messages is enabled. Oct 22 23:08:52.287169 systemd[1]: Starting systemd-vconsole-setup.service - Virtual Console Setup... Oct 22 23:08:52.287177 systemd-journald[513]: Journal started Oct 22 23:08:52.287191 systemd-journald[513]: Runtime Journal (/run/log/journal/67f4055e16bf4b96b779e32bb1406ebf) is 8M, max 78.3M, 70.3M free. Oct 22 23:08:52.290710 systemd-modules-load[515]: Using 2 probe threads Oct 22 23:08:52.311583 systemd[1]: Started systemd-journald.service - Journal Service. Oct 22 23:08:52.310000 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 22 23:08:52.314213 systemd[1]: Finished ignition-setup-pre.service - Ignition env setup. Oct 22 23:08:52.333935 kernel: audit: type=1130 audit(1792710532.310: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 22 23:08:52.333000 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 22 23:08:52.334266 systemd[1]: Finished kmod-static-nodes.service - Create List of Static Device Nodes. Oct 22 23:08:52.358597 kernel: audit: type=1130 audit(1792710532.333: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 22 23:08:52.357000 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 22 23:08:52.360552 systemd[1]: Starting systemd-tmpfiles-setup-dev-early.service - Create Static Device Nodes in /dev gracefully... Oct 22 23:08:52.394008 kernel: audit: type=1130 audit(1792710532.357: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 22 23:08:52.394030 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 22 23:08:52.394039 kernel: Bridge firewalling registered Oct 22 23:08:52.398679 systemd-modules-load[515]: Inserted module 'br_netfilter' Oct 22 23:08:52.399618 systemd[1]: Starting systemd-tmpfiles-setup.service - Create System Files and Directories... Oct 22 23:08:52.416540 systemd[1]: Finished systemd-modules-load.service - Load Kernel Modules. Oct 22 23:08:52.422000 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 22 23:08:52.424626 systemd[1]: Starting systemd-sysctl.service - Apply Kernel Variables... Oct 22 23:08:52.447664 systemd-tmpfiles[523]: /usr/lib/tmpfiles.d/systemd.conf:30: Duplicate line for path "/var/lib/systemd", ignoring. Oct 22 23:08:52.457979 kernel: audit: type=1130 audit(1792710532.422: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 22 23:08:52.447721 systemd-tmpfiles[523]: /usr/lib/tmpfiles.d/var.conf:14: Duplicate line for path "/var/log", ignoring. Oct 22 23:08:52.463000 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 22 23:08:52.457475 systemd-vconsole-setup[516]: Configuration of first virtual console was skipped, ignoring remaining ones. Oct 22 23:08:52.489076 kernel: audit: type=1130 audit(1792710532.463:6): 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 22 23:08:52.457985 systemd[1]: Finished systemd-tmpfiles-setup.service - Create System Files and Directories. Oct 22 23:08:52.493000 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 22 23:08:52.482131 systemd[1]: Finished systemd-vconsole-setup.service - Virtual Console Setup. Oct 22 23:08:52.515550 systemd[1]: Finished systemd-tmpfiles-setup-dev-early.service - Create Static Device Nodes in /dev gracefully. Oct 22 23:08:52.521000 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 22 23:08:52.539434 kernel: audit: type=1130 audit(1792710532.493: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 22 23:08:52.521628 systemd[1]: systemd-sysctl.service: Deactivated successfully. Oct 22 23:08:52.543415 kernel: audit: type=1130 audit(1792710532.521:8): 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 22 23:08:52.539694 systemd[1]: Finished systemd-sysctl.service - Apply Kernel Variables. Oct 22 23:08:52.547000 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 22 23:08:52.562844 kernel: audit: type=1130 audit(1792710532.547: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 22 23:08:52.547000 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 22 23:08:52.574386 kernel: audit: type=1131 audit(1792710532.547: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 22 23:08:52.577863 systemd[1]: Starting dracut-cmdline-ask.service - dracut ask for additional cmdline parameters... Oct 22 23:08:52.587000 audit: BPF prog-id=5 op=LOAD Oct 22 23:08:52.588805 systemd[1]: Starting systemd-resolved.service - Network Name Resolution... Oct 22 23:08:52.602767 kernel: audit: type=1334 audit(1792710532.587:11): prog-id=5 op=LOAD Oct 22 23:08:52.603442 systemd[1]: Starting systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev... Oct 22 23:08:52.631687 systemd[1]: Finished systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev. Oct 22 23:08:52.644000 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 22 23:08:52.645948 systemd[1]: Finished dracut-cmdline-ask.service - dracut ask for additional cmdline parameters. Oct 22 23:08:52.650000 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 22 23:08:52.657537 systemd[1]: Starting dracut-cmdline.service - dracut cmdline hook... Oct 22 23:08:52.770470 systemd-resolved[532]: Positive Trust Anchors: Oct 22 23:08:52.770485 systemd-resolved[532]: . IN DS 20326 8 2 e06d44b80b8f1d39a95c0b0d7c65d08458e880409bbc683457104237c7f8ec8d Oct 22 23:08:52.770488 systemd-resolved[532]: . IN DS 38696 8 2 683d2d0acb8c9b712a1948b27f741219298d0a450d612c483af444a4c0fb2b16 Oct 22 23:08:52.770508 systemd-resolved[532]: 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 22 23:08:52.832621 dracut-cmdline[545]: dracut-110 Oct 22 23:08:52.832621 dracut-cmdline[545]: 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=a4f294c2f4d3ba7f3e6f9dcc29f5bdb8ef7e69c86ff204343f35e3ac468d53d2 Oct 22 23:08:52.839244 systemd-resolved[532]: Defaulting to hostname 'linux'. Oct 22 23:08:52.865000 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 22 23:08:52.841112 systemd[1]: Started systemd-resolved.service - Network Name Resolution. Oct 22 23:08:52.866972 systemd[1]: Reached target nss-lookup.target - Host and Network Name Lookups. Oct 22 23:08:52.998997 kernel: Loading iSCSI transport class v2.0-870. Oct 22 23:08:53.045002 kernel: iscsi: registered transport (tcp) Oct 22 23:08:53.076776 kernel: iscsi: registered transport (qla4xxx) Oct 22 23:08:53.076823 kernel: QLogic iSCSI HBA Driver Oct 22 23:08:53.162389 systemd[1]: Starting systemd-network-generator.service - Generate Network Units from Kernel Command Line... Oct 22 23:08:53.182043 systemd[1]: Finished systemd-network-generator.service - Generate Network Units from Kernel Command Line. Oct 22 23:08:53.186000 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 22 23:08:53.187598 systemd[1]: Reached target network-pre.target - Preparation for Network. Oct 22 23:08:53.259865 systemd[1]: Finished dracut-cmdline.service - dracut cmdline hook. Oct 22 23:08:53.264000 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 22 23:08:53.266680 systemd[1]: Starting dracut-pre-udev.service - dracut pre-udev hook... Oct 22 23:08:53.281318 systemd[1]: Starting parse-ip-for-networkd.service - Write systemd-networkd units from cmdline... Oct 22 23:08:53.312854 systemd[1]: Finished dracut-pre-udev.service - dracut pre-udev hook. Oct 22 23:08:53.317000 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 22 23:08:53.321000 audit: BPF prog-id=6 op=LOAD Oct 22 23:08:53.321000 audit: BPF prog-id=7 op=LOAD Oct 22 23:08:53.323985 systemd[1]: Starting systemd-udevd.service - Rule-based Manager for Device Events and Files... Oct 22 23:08:53.467143 systemd[1]: Finished parse-ip-for-networkd.service - Write systemd-networkd units from cmdline. Oct 22 23:08:53.472000 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 22 23:08:53.480260 systemd-udevd[776]: Using default interface naming scheme 'v260'. Oct 22 23:08:53.609079 systemd[1]: Started systemd-udevd.service - Rule-based Manager for Device Events and Files. Oct 22 23:08:53.614000 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 22 23:08:53.623095 systemd[1]: Starting dracut-pre-trigger.service - dracut pre-trigger hook... Oct 22 23:08:53.636000 audit: BPF prog-id=8 op=LOAD Oct 22 23:08:53.637755 systemd[1]: Starting systemd-networkd.service - Network Management... Oct 22 23:08:53.655444 dracut-pre-trigger[896]: rd.md=0: removing MD RAID activation Oct 22 23:08:53.681333 systemd[1]: Finished dracut-pre-trigger.service - dracut pre-trigger hook. Oct 22 23:08:53.691000 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 22 23:08:53.685831 systemd-networkd[897]: Failed to open nftables netlink socket. IPMasquerade= and NFTSet= settings will not be applied. Ignoring: Protocol not supported Oct 22 23:08:53.692078 systemd[1]: Starting systemd-udev-trigger.service - Coldplug All udev Devices... Oct 22 23:08:53.715000 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 22 23:08:53.696744 systemd-networkd[897]: lo: Link UP Oct 22 23:08:53.696747 systemd-networkd[897]: lo: Gained carrier Oct 22 23:08:53.706295 systemd[1]: Started systemd-networkd.service - Network Management. Oct 22 23:08:53.715458 systemd[1]: Reached target network.target - Network. Oct 22 23:08:53.777370 systemd[1]: Finished systemd-udev-trigger.service - Coldplug All udev Devices. Oct 22 23:08:53.784000 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 22 23:08:53.791177 systemd[1]: Starting dracut-initqueue.service - dracut initqueue hook... Oct 22 23:08:53.879984 kernel: hv_storvsc f8b3781a-1e82-4818-a1c3-63d806ec15bb: tag#108 cmd 0x85 status: scsi 0x2 srb 0x6 hv 0xc0000001 Oct 22 23:08:53.921575 systemd[1]: systemd-vconsole-setup.service: Deactivated successfully. Oct 22 23:08:53.922705 systemd[1]: Stopped systemd-vconsole-setup.service - Virtual Console Setup. Oct 22 23:08:53.934000 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 22 23:08:53.935094 systemd[1]: Stopping systemd-vconsole-setup.service - Virtual Console Setup... Oct 22 23:08:53.949451 systemd[1]: Starting systemd-vconsole-setup.service - Virtual Console Setup... Oct 22 23:08:53.966879 kernel: hv_vmbus: registering driver hv_netvsc Oct 22 23:08:53.979203 systemd-vconsole-setup[975]: Configuration of first virtual console was skipped, ignoring remaining ones. Oct 22 23:08:53.985932 systemd[1]: Finished systemd-vconsole-setup.service - Virtual Console Setup. Oct 22 23:08:53.990000 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 22 23:08:53.994190 systemd[1]: systemd-vconsole-setup.service: Deactivated successfully. Oct 22 23:08:54.000000 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 22 23:08:53.994326 systemd[1]: Stopped systemd-vconsole-setup.service - Virtual Console Setup. Oct 22 23:08:54.000557 systemd[1]: Stopping systemd-vconsole-setup.service - Virtual Console Setup... Oct 22 23:08:54.014210 systemd[1]: Starting systemd-vconsole-setup.service - Virtual Console Setup... Oct 22 23:08:54.038784 systemd-vconsole-setup[979]: Configuration of first virtual console was skipped, ignoring remaining ones. Oct 22 23:08:54.053323 kernel: hv_netvsc 7ced8dc0-7fba-7ced-8dc0-7fba7ced8dc0 eth0: VF slot 1 added Oct 22 23:08:54.051904 systemd[1]: Finished systemd-vconsole-setup.service - Virtual Console Setup. Oct 22 23:08:54.064000 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 22 23:08:54.065873 systemd-networkd[897]: eth0: Found matching .network file, based on potentially unpredictable interface name: /usr/lib/systemd/network/zz-default.network Oct 22 23:08:54.066997 systemd-networkd[897]: eth0: Configuring with /usr/lib/systemd/network/zz-default.network. Oct 22 23:08:54.075694 systemd-networkd[897]: eth0: Link UP Oct 22 23:08:54.075766 systemd-networkd[897]: eth0: Gained carrier Oct 22 23:08:54.075775 systemd-networkd[897]: eth0: Found matching .network file, based on potentially unpredictable interface name: /usr/lib/systemd/network/zz-default.network Oct 22 23:08:54.108013 systemd-networkd[897]: eth0: DHCPv4 address 10.0.0.14/24, gateway 10.0.0.1 acquired from 168.63.129.16 Oct 22 23:08:54.143702 kernel: hv_vmbus: registering driver hv_pci Oct 22 23:08:54.143751 kernel: hv_pci 2dce261d-5008-4779-906f-db4ee98441bf: PCI VMBus probing: Using version 0x10004 Oct 22 23:08:54.154172 kernel: hv_pci 2dce261d-5008-4779-906f-db4ee98441bf: PCI host bridge to bus 5008:00 Oct 22 23:08:54.154317 kernel: pci_bus 5008:00: root bus resource [mem 0xfc0000000-0xfc00fffff window] Oct 22 23:08:54.154449 kernel: pci_bus 5008:00: No busn resource found for root bus, will use [bus 00-ff] Oct 22 23:08:54.165215 kernel: pci 5008:00:02.0: [15b3:101a] type 00 class 0x020000 PCIe Endpoint Oct 22 23:08:54.171000 kernel: pci 5008:00:02.0: BAR 0 [mem 0xfc0000000-0xfc00fffff 64bit pref] Oct 22 23:08:54.175031 kernel: pci 5008:00:02.0: enabling Extended Tags Oct 22 23:08:54.190011 kernel: pci 5008:00:02.0: 0.000 Gb/s available PCIe bandwidth, limited by Unknown x0 link at 5008:00:02.0 (capable of 252.048 Gb/s with 16.0 GT/s PCIe x16 link) Oct 22 23:08:54.199485 kernel: pci_bus 5008:00: busn_res: [bus 00-ff] end is updated to 00 Oct 22 23:08:54.199692 kernel: pci 5008:00:02.0: BAR 0 [mem 0xfc0000000-0xfc00fffff 64bit pref]: assigned Oct 22 23:08:54.402076 systemd[1]: Found device dev-disk-by\x2dpartlabel-USR\x2dA.device - Virtual_Disk USR-A. Oct 22 23:08:54.416271 systemd[1]: Starting disk-uuid.service - Generate new UUID for disk GPT if necessary... Oct 22 23:08:54.429415 kernel: mlx5_core 5008:00:02.0: enabling device (0000 -> 0002) Oct 22 23:08:54.429649 kernel: mlx5_core 5008:00:02.0: PTM is not supported by PCIe Oct 22 23:08:54.429822 kernel: mlx5_core 5008:00:02.0: firmware version: 16.30.5026 Oct 22 23:08:54.477537 systemd[1]: Found device dev-disk-by\x2dlabel-OEM.device - Virtual_Disk OEM. Oct 22 23:08:54.506458 systemd[1]: Mounting oem.mount - /oem... Oct 22 23:08:54.525979 systemd[1]: Found device dev-disk-by\x2dlabel-EFI\x2dSYSTEM.device - Virtual_Disk EFI-SYSTEM. Oct 22 23:08:54.555701 systemd[1]: Found device dev-disk-by\x2dlabel-ROOT.device - Virtual_Disk ROOT. Oct 22 23:08:54.618596 kernel: BTRFS: device label OEM devid 1 transid 11 /dev/sda6 (8:6) scanned by mount (1031) Oct 22 23:08:54.628019 kernel: BTRFS info (device sda6): first mount of filesystem 72a875bc-6929-4d1b-85de-1b0e74cf7ff0 Oct 22 23:08:54.632856 kernel: BTRFS info (device sda6): using crc32c (crc32c-generic) checksum algorithm Oct 22 23:08:54.647900 kernel: hv_netvsc 7ced8dc0-7fba-7ced-8dc0-7fba7ced8dc0 eth0: VF registering: eth1 Oct 22 23:08:54.648140 kernel: mlx5_core 5008:00:02.0 eth1: joined to eth0 Oct 22 23:08:54.657054 kernel: mlx5_core 5008:00:02.0: MLX5E: StrdRq(1) RqSz(8) StrdSz(2048) RxCqeCmprss(0 basic) Oct 22 23:08:54.668807 systemd-networkd[897]: eth1: Interface name change detected, renamed to enP20488s1. Oct 22 23:08:54.674014 kernel: mlx5_core 5008:00:02.0 enP20488s1: renamed from eth1 Oct 22 23:08:54.708828 kernel: BTRFS info (device sda6): turning on async discard Oct 22 23:08:54.708870 kernel: BTRFS info (device sda6): enabling free space tree Oct 22 23:08:54.711726 systemd[1]: Mounted oem.mount - /oem. Oct 22 23:08:54.720594 systemd[1]: Starting ignition-fetch-offline.service - Ignition (fetch-offline)... Oct 22 23:08:54.792989 kernel: mlx5_core 5008:00:02.0 enP20488s1: Link up Oct 22 23:08:54.827977 kernel: hv_netvsc 7ced8dc0-7fba-7ced-8dc0-7fba7ced8dc0 eth0: Data path switched to VF: enP20488s1 Oct 22 23:08:54.828302 systemd-networkd[897]: enP20488s1: Link UP Oct 22 23:08:55.076185 systemd-networkd[897]: enP20488s1: Gained carrier Oct 22 23:08:55.726970 disk-uuid[1017]: Warning: The kernel is still using the old partition table. Oct 22 23:08:55.726970 disk-uuid[1017]: The new table will be used at the next reboot or after you Oct 22 23:08:55.726970 disk-uuid[1017]: run partprobe(8) or kpartx(8) Oct 22 23:08:55.726970 disk-uuid[1017]: The operation has completed successfully. Oct 22 23:08:55.772329 systemd-networkd[897]: eth0: Gained IPv6LL Oct 22 23:08:55.816706 systemd[1]: disk-uuid.service: Deactivated successfully. Oct 22 23:08:55.820540 systemd[1]: Finished disk-uuid.service - Generate new UUID for disk GPT if necessary. Oct 22 23:08:55.826000 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 22 23:08:55.826000 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 22 23:08:55.835049 systemd[1]: Finished dracut-initqueue.service - dracut initqueue hook. Oct 22 23:08:55.844000 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 22 23:08:55.845563 systemd[1]: Reached target remote-fs-pre.target - Preparation for Remote File Systems. Oct 22 23:08:55.856317 systemd[1]: Reached target remote-cryptsetup.target - Remote Encrypted Volumes. Oct 22 23:08:55.863667 systemd[1]: Reached target remote-fs.target - Remote File Systems. Oct 22 23:08:55.879195 systemd[1]: Mounting boot.mount - Boot partition... Oct 22 23:08:55.883100 systemd[1]: Starting dracut-pre-mount.service - dracut pre-mount hook... Oct 22 23:08:55.943804 systemd[1]: Finished dracut-pre-mount.service - dracut pre-mount hook. Oct 22 23:08:55.948000 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 22 23:08:55.964474 systemd[1]: Mounted boot.mount - Boot partition. Oct 22 23:08:56.056104 ignition[1118]: Ignition 2.24.0 Oct 22 23:08:56.056114 ignition[1118]: Stage: fetch-offline Oct 22 23:08:56.060819 systemd[1]: Finished ignition-fetch-offline.service - Ignition (fetch-offline). Oct 22 23:08:56.067000 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 22 23:08:56.058996 ignition[1118]: no config dir at "/usr/lib/ignition/base.d" Oct 22 23:08:56.068936 systemd[1]: Starting ignition-fetch.service - Ignition (fetch)... Oct 22 23:08:56.059006 ignition[1118]: no config dir at "/usr/lib/ignition/base.platform.d/azure" Oct 22 23:08:56.059087 ignition[1118]: parsed url from cmdline: "" Oct 22 23:08:56.059090 ignition[1118]: no config URL provided Oct 22 23:08:56.059093 ignition[1118]: reading system config file "/usr/lib/ignition/user.ign" Oct 22 23:08:56.059110 ignition[1118]: no config at "/usr/lib/ignition/user.ign" Oct 22 23:08:56.059113 ignition[1118]: failed to fetch config: resource requires networking Oct 22 23:08:56.059230 ignition[1118]: Ignition finished successfully Oct 22 23:08:56.100045 ignition[1199]: Ignition 2.24.0 Oct 22 23:08:56.100050 ignition[1199]: Stage: fetch Oct 22 23:08:56.100203 ignition[1199]: no config dir at "/usr/lib/ignition/base.d" Oct 22 23:08:56.100210 ignition[1199]: no config dir at "/usr/lib/ignition/base.platform.d/azure" Oct 22 23:08:56.100260 ignition[1199]: parsed url from cmdline: "" Oct 22 23:08:56.100263 ignition[1199]: no config URL provided Oct 22 23:08:56.100266 ignition[1199]: reading system config file "/usr/lib/ignition/user.ign" Oct 22 23:08:56.100273 ignition[1199]: no config at "/usr/lib/ignition/user.ign" Oct 22 23:08:56.100285 ignition[1199]: GET http://169.254.169.254/metadata/instance/compute/userData?api-version=2021-01-01&format=text: attempt #1 Oct 22 23:08:56.163070 ignition[1199]: GET result: OK Oct 22 23:08:56.163647 ignition[1199]: config has been read from IMDS userdata Oct 22 23:08:56.163656 ignition[1199]: parsing config with SHA512: bea4a4f9ff36e4504c91db9bfcfbc16694dd4071c138e53a4b62f10b2826e1d3d14112e1f8dd790125b1fd77c409dae3b7a3cdd64a58be0f848323df7226be1a Oct 22 23:08:56.169735 unknown[1199]: fetched base config from "system" Oct 22 23:08:56.169872 ignition[1199]: fetch: fetch complete Oct 22 23:08:56.177000 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 22 23:08:56.169741 unknown[1199]: fetched base config from "system" Oct 22 23:08:56.169876 ignition[1199]: fetch: fetch passed Oct 22 23:08:56.169744 unknown[1199]: fetched user config from "azure" Oct 22 23:08:56.169908 ignition[1199]: Ignition finished successfully Oct 22 23:08:56.171642 systemd[1]: Finished ignition-fetch.service - Ignition (fetch). Oct 22 23:08:56.178514 systemd[1]: Starting ignition-kargs.service - Ignition (kargs)... Oct 22 23:08:56.213241 ignition[1205]: Ignition 2.24.0 Oct 22 23:08:56.213257 ignition[1205]: Stage: kargs Oct 22 23:08:56.213422 ignition[1205]: no config dir at "/usr/lib/ignition/base.d" Oct 22 23:08:56.222000 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 22 23:08:56.218753 systemd[1]: Finished ignition-kargs.service - Ignition (kargs). Oct 22 23:08:56.213430 ignition[1205]: no config dir at "/usr/lib/ignition/base.platform.d/azure" Oct 22 23:08:56.223702 systemd[1]: Starting ignition-disks.service - Ignition (disks)... Oct 22 23:08:56.213744 ignition[1205]: kargs: kargs passed Oct 22 23:08:56.213775 ignition[1205]: Ignition finished successfully Oct 22 23:08:56.270992 systemd[1]: ignition-kargs.service: Deactivated successfully. Oct 22 23:08:56.271105 systemd[1]: Stopped ignition-kargs.service - Ignition (kargs). Oct 22 23:08:56.279000 audit[1]: SERVICE_STOP pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=ignition-kargs comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Oct 22 23:08:56.279842 systemd[1]: ignition-fetch.service: Deactivated successfully. Oct 22 23:08:56.287000 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 22 23:08:56.279981 systemd[1]: Stopped ignition-fetch.service - Ignition (fetch). Oct 22 23:08:56.296000 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 22 23:08:56.288314 systemd[1]: ignition-fetch-offline.service: Deactivated successfully. Oct 22 23:08:56.288440 systemd[1]: Stopped ignition-fetch-offline.service - Ignition (fetch-offline). Oct 22 23:08:56.299090 systemd[1]: Unmounting oem.mount - /oem... Oct 22 23:08:56.325046 kernel: BTRFS info (device sda6): last unmount of filesystem 72a875bc-6929-4d1b-85de-1b0e74cf7ff0 Oct 22 23:08:56.325594 systemd[1]: oem.mount: Deactivated successfully. Oct 22 23:08:56.328042 systemd[1]: Unmounted oem.mount - /oem. Oct 22 23:08:56.355129 ignition[1216]: Ignition 2.24.0 Oct 22 23:08:56.355145 ignition[1216]: Stage: disks Oct 22 23:08:56.355318 ignition[1216]: no config dir at "/usr/lib/ignition/base.d" Oct 22 23:08:56.355325 ignition[1216]: no config dir at "/usr/lib/ignition/base.platform.d/azure" Oct 22 23:08:56.355667 ignition[1216]: disks: createFilesystems: op(1): [started] waiting for devices [/dev/disk/by-partlabel/ROOT] Oct 22 23:08:56.362263 ignition[1216]: disks: createFilesystems: op(1): [finished] waiting for devices [/dev/disk/by-partlabel/ROOT] Oct 22 23:08:56.362336 ignition[1216]: disks: createFilesystems: created device alias for "/dev/disk/by-partlabel/ROOT": "/run/ignition/dev_aliases/dev/disk/by-partlabel/ROOT" -> "/dev/sda9" Oct 22 23:08:56.362358 ignition[1216]: disks: createFilesystems: op(2): [started] determining filesystem type of "/dev/disk/by-partlabel/ROOT" Oct 22 23:08:56.413298 ignition[1216]: disks: createFilesystems: op(2): [finished] determining filesystem type of "/dev/disk/by-partlabel/ROOT" Oct 22 23:08:56.413312 ignition[1216]: disks: createFilesystems: found ext4 filesystem at "/dev/disk/by-partlabel/ROOT" with uuid "42107894-5c77-43ad-95d6-68d26fa9e47b" and label "ROOT" Oct 22 23:08:56.422010 systemd[1]: Finished ignition-disks.service - Ignition (disks). Oct 22 23:08:56.433000 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 22 23:08:56.413315 ignition[1216]: disks: createFilesystems: filesystem at "/dev/disk/by-partlabel/ROOT" is already correctly formatted. Skipping mkfs... Oct 22 23:08:56.435938 systemd[1]: Reached target initrd-root-device.target - Initrd Root Device. Oct 22 23:08:56.413338 ignition[1216]: disks: disks passed Oct 22 23:08:56.441982 systemd[1]: Reached target local-fs-pre.target - Preparation for Local File Systems. Oct 22 23:08:56.413410 ignition[1216]: Ignition finished successfully Oct 22 23:08:56.454194 systemd[1]: Reached target local-fs.target - Local File Systems. Oct 22 23:08:56.463807 systemd[1]: Reached target sysinit.target - System Initialization. Oct 22 23:08:56.470870 systemd[1]: Reached target basic.target - Basic System. Oct 22 23:08:56.480748 systemd[1]: Starting systemd-fsck-root.service - File System Check on /dev/disk/by-label/ROOT... Oct 22 23:08:56.648233 systemd-fsck[1225]: ROOT: clean, 15/6361680 files, 408771/6359552 blocks Oct 22 23:08:56.657207 systemd[1]: Finished systemd-fsck-root.service - File System Check on /dev/disk/by-label/ROOT. Oct 22 23:08:56.662000 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 22 23:08:56.663842 systemd[1]: Mounting sysroot.mount - /sysroot... Oct 22 23:08:56.949061 kernel: EXT4-fs (sda9): mounted filesystem 42107894-5c77-43ad-95d6-68d26fa9e47b r/w with ordered data mode. Quota mode: none. Oct 22 23:08:56.949393 systemd[1]: Mounted sysroot.mount - /sysroot. Oct 22 23:08:56.953583 systemd[1]: Reached target initrd-root-fs.target - Initrd Root File System. Oct 22 23:08:56.976022 systemd[1]: Mounting sysroot-usr.mount - /sysroot/usr... Oct 22 23:08:56.980900 systemd[1]: Starting flatcar-metadata-hostname.service - Flatcar Metadata Hostname Agent... Oct 22 23:08:56.991059 systemd[1]: ignition-remount-sysroot.service - Remount /sysroot read-write for Ignition skipped, unmet condition check ConditionPathIsReadWrite=!/sysroot Oct 22 23:08:56.991097 systemd[1]: Reached target ignition-diskful.target - Ignition Boot Disk Setup. Oct 22 23:08:57.009082 systemd[1]: Mounted sysroot-usr.mount - /sysroot/usr. Oct 22 23:08:57.016082 systemd[1]: Starting initrd-setup-root.service - Root filesystem setup... Oct 22 23:08:57.363447 systemd-tmpfiles[1259]: /sysroot/usr/lib/tmpfiles.d/base_image_var.conf:1: Duplicate line for path "/sysroot/var", ignoring. Oct 22 23:08:57.363471 systemd-tmpfiles[1259]: /sysroot/usr/lib/tmpfiles.d/base_image_var.conf:7: Duplicate line for path "/sysroot/var/empty", ignoring. Oct 22 23:08:57.363529 systemd-tmpfiles[1259]: /sysroot/usr/lib/tmpfiles.d/base_image_var.conf:28: Duplicate line for path "/sysroot/var/log", ignoring. Oct 22 23:08:58.007490 coreos-metadata[1240]: Oct 22 23:08:58.007 INFO Fetching http://168.63.129.16/?comp=versions: Attempt #1 Oct 22 23:08:58.014667 coreos-metadata[1240]: Oct 22 23:08:58.014 INFO Fetch successful Oct 22 23:08:58.018673 coreos-metadata[1240]: Oct 22 23:08:58.018 INFO Fetching http://169.254.169.254/metadata/instance/compute/name?api-version=2017-08-01&format=text: Attempt #1 Oct 22 23:08:58.027051 coreos-metadata[1240]: Oct 22 23:08:58.026 INFO Fetch successful Oct 22 23:08:58.027051 coreos-metadata[1240]: Oct 22 23:08:58.026 INFO wrote hostname ci-4757.2.1-n-ebcd5c0479 to /sysroot/etc/hostname Oct 22 23:08:58.032278 systemd[1]: Finished flatcar-metadata-hostname.service - Flatcar Metadata Hostname Agent. Oct 22 23:08:58.043000 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 22 23:08:58.052815 kernel: kauditd_printk_skb: 30 callbacks suppressed Oct 22 23:08:58.052834 kernel: audit: type=1130 audit(1792710538.043: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 22 23:08:58.949991 kernel: loop1: detected capacity change from 0 to 44360 Oct 22 23:08:59.026001 kernel: loop1: p1 p2 p3 Oct 22 23:08:59.484943 kernel: device-mapper: verity: sha256 using shash "sha256-ce" Oct 22 23:08:59.485015 kernel: device-mapper: verity: Unrecognized verity feature request: root_hash_sig_key_desc Oct 22 23:08:59.489819 kernel: device-mapper: table: 254:1: verity: Unrecognized verity feature request (-EINVAL) Oct 22 23:08:59.493298 kernel: device-mapper: ioctl: error adding target to table Oct 22 23:08:59.493513 systemd-confext[1319]: device-mapper: reload ioctl on loop1p1-14-verity (254:1) failed: Invalid argument Oct 22 23:08:59.521000 kernel: device-mapper: verity: sha256 using shash "sha256-ce" Oct 22 23:08:59.593985 kernel: erofs: (device dm-1): mounted with root inode @ nid 40. Oct 22 23:08:59.614982 kernel: loop2: detected capacity change from 0 to 44360 Oct 22 23:08:59.628986 kernel: loop2: p1 p2 p3 Oct 22 23:08:59.642905 kernel: device-mapper: verity: sha256 using shash "sha256-ce" Oct 22 23:08:59.642939 kernel: device-mapper: verity: Unrecognized verity feature request: root_hash_sig_key_desc Oct 22 23:08:59.647846 kernel: device-mapper: table: 254:1: verity: Unrecognized verity feature request (-EINVAL) Oct 22 23:08:59.651481 kernel: device-mapper: ioctl: error adding target to table Oct 22 23:08:59.651692 (sd-merge)[1329]: device-mapper: reload ioctl on loop2p1-18-verity (254:1) failed: Invalid argument Oct 22 23:08:59.662401 kernel: device-mapper: verity: sha256 using shash "sha256-ce" Oct 22 23:08:59.682724 (sd-merge)[1329]: Using extensions '00-flatcar-default.raw'. Oct 22 23:08:59.687334 (sd-merge)[1329]: Merged extensions into '/sysroot/etc'. Oct 22 23:08:59.692023 kernel: erofs: (device dm-1): mounted with root inode @ nid 40. Oct 22 23:08:59.695283 initrd-setup-root[1336]: /etc 00-flatcar-default Thu 2026-10-22 23:08:52 UTC Oct 22 23:08:59.700597 systemd[1]: Finished initrd-setup-root.service - Root filesystem setup. Oct 22 23:08:59.704000 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 22 23:08:59.722934 kernel: audit: type=1130 audit(1792710539.704: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 22 23:08:59.721685 systemd[1]: Starting ignition-mount.service - Ignition (mount)... Oct 22 23:08:59.762846 ignition[1340]: INFO : Ignition 2.24.0 Oct 22 23:08:59.766297 ignition[1340]: INFO : Stage: mount Oct 22 23:08:59.766297 ignition[1340]: INFO : no config dir at "/usr/lib/ignition/base.d" Oct 22 23:08:59.766297 ignition[1340]: INFO : no config dir at "/usr/lib/ignition/base.platform.d/azure" Oct 22 23:08:59.766297 ignition[1340]: INFO : mount: op(1): [started] mounting "/dev/disk/by-partlabel/ROOT" at "/sysroot/tmp/_translate-filesystem-0-ign1" with type "ext4" and options "" Oct 22 23:08:59.766297 ignition[1340]: DEBUG : mount: op(1): executing: "mount" "-o" "" "-t" "ext4" "/dev/disk/by-partlabel/ROOT" "/sysroot/tmp/_translate-filesystem-0-ign1" Oct 22 23:09:00.541063 ignition[1340]: INFO : mount: op(1): [finished] mounting "/dev/disk/by-partlabel/ROOT" at "/sysroot/tmp/_translate-filesystem-0-ign1" with type "ext4" and options "" Oct 22 23:09:00.541063 ignition[1340]: INFO : mount: mount passed Oct 22 23:09:00.541063 ignition[1340]: INFO : Ignition finished successfully Oct 22 23:09:00.555000 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 22 23:09:00.577434 kernel: audit: type=1130 audit(1792710540.555: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 22 23:09:00.543225 systemd[1]: Finished ignition-mount.service - Ignition (mount). Oct 22 23:09:00.570204 systemd[1]: Starting ignition-files.service - Ignition (files)... Oct 22 23:09:00.599030 systemd[1]: Mounting oem.mount - /oem... Oct 22 23:09:00.619768 kernel: BTRFS: device label OEM devid 1 transid 11 /dev/sda6 (8:6) scanned by mount (1350) Oct 22 23:09:00.619802 kernel: BTRFS info (device sda6): first mount of filesystem 72a875bc-6929-4d1b-85de-1b0e74cf7ff0 Oct 22 23:09:00.624599 kernel: BTRFS info (device sda6): using crc32c (crc32c-generic) checksum algorithm Oct 22 23:09:00.641662 kernel: BTRFS info (device sda6): turning on async discard Oct 22 23:09:00.641709 kernel: BTRFS info (device sda6): enabling free space tree Oct 22 23:09:00.643596 systemd[1]: Mounted oem.mount - /oem. Oct 22 23:09:00.648350 systemd[1]: Mounting sysroot-oem.mount - /sysroot/oem... Oct 22 23:09:00.668566 systemd[1]: Mounted sysroot-oem.mount - /sysroot/oem. Oct 22 23:09:00.697187 ignition[1368]: INFO : Ignition 2.24.0 Oct 22 23:09:00.697187 ignition[1368]: INFO : Stage: files Oct 22 23:09:00.703574 ignition[1368]: INFO : no config dir at "/usr/lib/ignition/base.d" Oct 22 23:09:00.703574 ignition[1368]: INFO : no config dir at "/usr/lib/ignition/base.platform.d/azure" Oct 22 23:09:00.703574 ignition[1368]: DEBUG : files: compiled without relabeling support, skipping Oct 22 23:09:00.703574 ignition[1368]: INFO : files: ensureUsers: op(1): [started] creating or modifying user "core" Oct 22 23:09:00.703574 ignition[1368]: DEBUG : files: ensureUsers: op(1): executing: "usermod" "--root" "/sysroot" "core" Oct 22 23:09:00.703574 ignition[1368]: INFO : files: ensureUsers: op(1): [finished] creating or modifying user "core" Oct 22 23:09:00.703574 ignition[1368]: INFO : files: ensureUsers: op(2): [started] adding ssh keys to user "core" Oct 22 23:09:00.703574 ignition[1368]: INFO : files: ensureUsers: op(2): [finished] adding ssh keys to user "core" Oct 22 23:09:00.703574 ignition[1368]: INFO : files: createFilesystemsFiles: createFiles: op(3): [started] writing file "/sysroot/tmp/_translate-filesystem-0-ign1/etc/flatcar/update.conf" Oct 22 23:09:00.703574 ignition[1368]: INFO : files: createFilesystemsFiles: createFiles: op(3): [finished] writing file "/sysroot/tmp/_translate-filesystem-0-ign1/etc/flatcar/update.conf" Oct 22 23:09:00.703574 ignition[1368]: INFO : files: op(4): [started] processing unit "coreos-metadata.service" Oct 22 23:09:00.703574 ignition[1368]: INFO : files: op(4): [finished] processing unit "coreos-metadata.service" Oct 22 23:09:00.703574 ignition[1368]: INFO : files: op(5): [started] processing unit "metadata.target" Oct 22 23:09:00.740000 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 22 23:09:00.809000 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 22 23:09:00.700071 unknown[1368]: wrote ssh authorized keys file for user: core Oct 22 23:09:00.809000 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 22 23:09:00.847037 ignition[1368]: INFO : files: op(5): op(6): [started] writing unit "metadata.target" at "/sysroot/etc/systemd/system/metadata.target" Oct 22 23:09:00.847037 ignition[1368]: INFO : files: op(5): op(6): [finished] writing unit "metadata.target" at "/sysroot/etc/systemd/system/metadata.target" Oct 22 23:09:00.847037 ignition[1368]: INFO : files: op(5): [finished] processing unit "metadata.target" Oct 22 23:09:00.847037 ignition[1368]: INFO : files: op(7): [started] setting preset to enabled for "coreos-metadata.service" Oct 22 23:09:00.847037 ignition[1368]: INFO : files: op(7): [finished] setting preset to enabled for "coreos-metadata.service" Oct 22 23:09:00.847037 ignition[1368]: INFO : files: op(8): [started] setting preset to enabled for "metadata.target" Oct 22 23:09:00.847037 ignition[1368]: INFO : files: op(8): [finished] setting preset to enabled for "metadata.target" Oct 22 23:09:00.847037 ignition[1368]: INFO : files: createResultFile: createFiles: op(9): [started] writing file "/sysroot/etc/.ignition-result.json" Oct 22 23:09:00.847037 ignition[1368]: INFO : files: createResultFile: createFiles: op(9): [finished] writing file "/sysroot/etc/.ignition-result.json" Oct 22 23:09:00.847037 ignition[1368]: INFO : files: files passed Oct 22 23:09:00.847037 ignition[1368]: INFO : Ignition finished successfully Oct 22 23:09:00.919230 kernel: audit: type=1130 audit(1792710540.740: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 22 23:09:00.733300 systemd[1]: Finished ignition-files.service - Ignition (files). Oct 22 23:09:00.923763 kernel: audit: type=1130 audit(1792710540.809: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 22 23:09:00.742271 systemd[1]: Starting ignition-quench.service - Ignition (record completion)... Oct 22 23:09:00.930679 kernel: audit: type=1131 audit(1792710540.809: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 22 23:09:00.790111 systemd[1]: Starting initrd-setup-root-after-ignition.service - Root filesystem completion... Oct 22 23:09:00.938241 kernel: loop3: detected capacity change from 0 to 44360 Oct 22 23:09:00.800308 systemd[1]: ignition-quench.service: Deactivated successfully. Oct 22 23:09:00.945610 kernel: loop3: p1 p2 p3 Oct 22 23:09:00.945635 initrd-setup-root-after-ignition[1399]: grep: /sysroot/etc/flatcar/enabled-sysext.conf: No such file or directory Oct 22 23:09:00.945635 initrd-setup-root-after-ignition[1399]: grep: /sysroot/usr/share/flatcar/enabled-sysext.conf: No such file or directory Oct 22 23:09:00.800460 systemd[1]: Finished ignition-quench.service - Ignition (record completion). Oct 22 23:09:00.977910 kernel: device-mapper: verity: sha256 using shash "sha256-ce" Oct 22 23:09:00.977926 initrd-setup-root-after-ignition[1403]: grep: /sysroot/etc/flatcar/enabled-sysext.conf: No such file or directory Oct 22 23:09:00.984684 kernel: device-mapper: verity: Unrecognized verity feature request: root_hash_sig_key_desc Oct 22 23:09:00.977946 systemd-confext[1405]: device-mapper: reload ioctl on loop3p1-21-verity (254:2) failed: Invalid argument Oct 22 23:09:00.995237 kernel: device-mapper: table: 254:2: verity: Unrecognized verity feature request (-EINVAL) Oct 22 23:09:00.995253 kernel: device-mapper: ioctl: error adding target to table Oct 22 23:09:00.995271 kernel: device-mapper: verity: sha256 using shash "sha256-ce" Oct 22 23:09:01.011981 kernel: erofs: (device dm-2): mounted with root inode @ nid 40. Oct 22 23:09:01.037993 kernel: loop4: detected capacity change from 0 to 44360 Oct 22 23:09:01.045978 kernel: loop4: p1 p2 p3 Oct 22 23:09:01.063944 kernel: device-mapper: verity: sha256 using shash "sha256-ce" Oct 22 23:09:01.063983 kernel: device-mapper: verity: Unrecognized verity feature request: root_hash_sig_key_desc Oct 22 23:09:01.069189 kernel: device-mapper: table: 254:2: verity: Unrecognized verity feature request (-EINVAL) Oct 22 23:09:01.072635 kernel: device-mapper: ioctl: error adding target to table Oct 22 23:09:01.072863 (sd-merge)[1415]: device-mapper: reload ioctl on loop4p1-25-verity (254:2) failed: Invalid argument Oct 22 23:09:01.088040 kernel: device-mapper: verity: sha256 using shash "sha256-ce" Oct 22 23:09:01.104567 (sd-merge)[1415]: Skipping extension refresh because no change was found, use --always-refresh=yes to always do a refresh. Oct 22 23:09:01.112998 kernel: erofs: (device dm-2): mounted with root inode @ nid 40. Oct 22 23:09:01.159119 kernel: loop4: detected capacity change from 0 to 172608 Oct 22 23:09:01.222343 kernel: loop4: p1 p2 p3 Oct 22 23:09:01.441978 kernel: device-mapper: verity: sha256 using shash "sha256-ce" Oct 22 23:09:01.442050 kernel: device-mapper: verity: Unrecognized verity feature request: root_hash_sig_key_desc Oct 22 23:09:01.442060 kernel: device-mapper: table: 254:2: verity: Unrecognized verity feature request (-EINVAL) Oct 22 23:09:01.450597 kernel: device-mapper: ioctl: error adding target to table Oct 22 23:09:01.450922 systemd-sysext[1423]: device-mapper: reload ioctl on loop4p1-29-verity (254:2) failed: Invalid argument Oct 22 23:09:01.461561 kernel: device-mapper: verity: sha256 using shash "sha256-ce" Oct 22 23:09:01.675048 kernel: erofs: (device dm-2): mounted with root inode @ nid 39. Oct 22 23:09:01.723020 kernel: loop5: detected capacity change from 0 to 364712 Oct 22 23:09:01.812356 kernel: loop5: p1 p2 p3 Oct 22 23:09:02.064220 kernel: device-mapper: verity: sha256 using shash "sha256-ce" Oct 22 23:09:02.064270 kernel: device-mapper: verity: Unrecognized verity feature request: root_hash_sig_key_desc Oct 22 23:09:02.069514 kernel: device-mapper: table: 254:2: verity: Unrecognized verity feature request (-EINVAL) Oct 22 23:09:02.073026 kernel: device-mapper: ioctl: error adding target to table Oct 22 23:09:02.073084 systemd-sysext[1423]: device-mapper: reload ioctl on loop5p1-33-verity (254:2) failed: Invalid argument Oct 22 23:09:02.084928 kernel: device-mapper: verity: sha256 using shash "sha256-ce" Oct 22 23:09:02.479022 kernel: erofs: (device dm-2): mounted with root inode @ nid 39. Oct 22 23:09:02.616995 kernel: loop6: detected capacity change from 0 to 142648 Oct 22 23:09:02.661000 kernel: loop6: p1 p2 p3 Oct 22 23:09:02.959794 kernel: device-mapper: verity: sha256 using shash "sha256-ce" Oct 22 23:09:02.959853 kernel: device-mapper: verity: Unrecognized verity feature request: root_hash_sig_key_desc Oct 22 23:09:02.966208 kernel: device-mapper: table: 254:2: verity: Unrecognized verity feature request (-EINVAL) Oct 22 23:09:02.971601 kernel: device-mapper: ioctl: error adding target to table Oct 22 23:09:02.971528 systemd-sysext[1423]: device-mapper: reload ioctl on loop6p1-37-verity (254:2) failed: Invalid argument Oct 22 23:09:02.987215 kernel: device-mapper: verity: sha256 using shash "sha256-ce" Oct 22 23:09:03.102978 kernel: erofs: (device dm-2): mounted with root inode @ nid 39. Oct 22 23:09:03.122992 kernel: loop7: detected capacity change from 0 to 172608 Oct 22 23:09:03.129980 kernel: loop7: p1 p2 p3 Oct 22 23:09:03.151575 kernel: device-mapper: verity: sha256 using shash "sha256-ce" Oct 22 23:09:03.151607 kernel: device-mapper: verity: Unrecognized verity feature request: root_hash_sig_key_desc Oct 22 23:09:03.158151 kernel: device-mapper: table: 254:2: verity: Unrecognized verity feature request (-EINVAL) Oct 22 23:09:03.161714 kernel: device-mapper: ioctl: error adding target to table Oct 22 23:09:03.162086 (sd-merge)[1447]: device-mapper: reload ioctl on loop7p1-41-verity (254:2) failed: Invalid argument Oct 22 23:09:03.172309 kernel: device-mapper: verity: sha256 using shash "sha256-ce" Oct 22 23:09:03.214021 kernel: erofs: (device dm-2): mounted with root inode @ nid 39. Oct 22 23:09:03.222981 kernel: loop1: detected capacity change from 0 to 364712 Oct 22 23:09:03.233988 kernel: loop1: p1 p2 p3 Oct 22 23:09:03.242074 (sd-merge)[1447]: device-mapper: reload ioctl on loop1p1-45-verity (254:3) failed: Invalid argument Oct 22 23:09:03.281618 kernel: device-mapper: verity: sha256 using shash "sha256-ce" Oct 22 23:09:03.281640 kernel: device-mapper: verity: Unrecognized verity feature request: root_hash_sig_key_desc Oct 22 23:09:03.281648 kernel: device-mapper: table: 254:3: verity: Unrecognized verity feature request (-EINVAL) Oct 22 23:09:03.281655 kernel: device-mapper: ioctl: error adding target to table Oct 22 23:09:03.281662 kernel: device-mapper: verity: sha256 using shash "sha256-ce" Oct 22 23:09:03.300005 kernel: erofs: (device dm-3): mounted with root inode @ nid 39. Oct 22 23:09:03.305985 kernel: loop3: detected capacity change from 0 to 142648 Oct 22 23:09:03.317001 kernel: loop3: p1 p2 p3 Oct 22 23:09:03.334288 kernel: device-mapper: verity: sha256 using shash "sha256-ce" Oct 22 23:09:03.334318 kernel: device-mapper: verity: Unrecognized verity feature request: root_hash_sig_key_desc Oct 22 23:09:03.340498 kernel: device-mapper: table: 254:4: verity: Unrecognized verity feature request (-EINVAL) Oct 22 23:09:03.340531 kernel: device-mapper: ioctl: error adding target to table Oct 22 23:09:03.343449 (sd-merge)[1447]: device-mapper: reload ioctl on loop3p1-49-verity (254:4) failed: Invalid argument Oct 22 23:09:03.356998 kernel: device-mapper: verity: sha256 using shash "sha256-ce" Oct 22 23:09:03.381986 kernel: erofs: (device dm-4): mounted with root inode @ nid 39. Oct 22 23:09:03.382280 (sd-merge)[1447]: Using extensions 'containerd-flatcar.raw', 'docker-flatcar.raw', 'oem-azure-4757.2.1+nightly-20261022-2100.raw'. Oct 22 23:09:03.383196 (sd-merge)[1447]: Merged extensions into '/sysroot/usr'. Oct 22 23:09:03.394747 systemd[1]: Finished initrd-setup-root-after-ignition.service - Root filesystem completion. Oct 22 23:09:03.400000 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 22 23:09:03.402251 systemd[1]: Starting initrd-parse-etc.service - Mountpoints Configured in the Real Root... Oct 22 23:09:03.431590 kernel: audit: type=1130 audit(1792710543.400: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 22 23:09:03.451036 systemd[1]: initrd-parse-etc.service: Deactivated successfully. Oct 22 23:09:03.451164 systemd[1]: Finished initrd-parse-etc.service - Mountpoints Configured in the Real Root. Oct 22 23:09:03.460000 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 22 23:09:03.461282 systemd[1]: initrd-parse-etc.service: Triggering OnSuccess= dependencies. Oct 22 23:09:03.460000 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 22 23:09:03.504314 kernel: audit: type=1130 audit(1792710543.460: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 22 23:09:03.461789 systemd[1]: Reached target initrd-fs.target - Initrd File Systems. Oct 22 23:09:03.509173 kernel: audit: type=1131 audit(1792710543.460: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 22 23:09:03.495918 systemd[1]: Starting dracut-mount.service - dracut mount hook... Oct 22 23:09:03.882874 systemd[1]: Finished dracut-mount.service - dracut mount hook. Oct 22 23:09:03.887000 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 22 23:09:03.889355 systemd[1]: Starting dracut-pre-pivot.service - dracut pre-pivot and cleanup hook... Oct 22 23:09:03.912491 kernel: audit: type=1130 audit(1792710543.887: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 22 23:09:03.928550 systemd[1]: Finished dracut-pre-pivot.service - dracut pre-pivot and cleanup hook. Oct 22 23:09:03.933000 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 22 23:09:03.935411 systemd[1]: Starting initrd-cleanup.service - Cleaning Up and Shutting Down Daemons... Oct 22 23:09:03.961450 kernel: audit: type=1130 audit(1792710543.933: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 22 23:09:03.970333 systemd[1]: Stopped target basic.target - Basic System. Oct 22 23:09:03.978263 systemd[1]: Stopped target ignition-diskful.target - Ignition Boot Disk Setup. Oct 22 23:09:03.988456 systemd[1]: Stopped target initrd-root-device.target - Initrd Root Device. Oct 22 23:09:03.993130 systemd[1]: Stopped target initrd-usr-fs.target - Initrd /usr File System. Oct 22 23:09:04.002445 systemd[1]: Stopped target nss-lookup.target - Host and Network Name Lookups. Oct 22 23:09:04.011681 systemd[1]: Stopped target paths.target - Path Units. Oct 22 23:09:04.020404 systemd[1]: Stopped target remote-cryptsetup.target - Remote Encrypted Volumes. Oct 22 23:09:04.028781 systemd[1]: Stopped target slices.target - Slice Units. Oct 22 23:09:04.038548 systemd[1]: Stopped target sockets.target - Socket Units. Oct 22 23:09:04.047634 systemd[1]: Stopped target sysinit.target - System Initialization. Oct 22 23:09:04.056644 systemd[1]: Stopped target local-fs.target - Local File Systems. Oct 22 23:09:04.065589 systemd[1]: Stopped target local-fs-pre.target - Preparation for Local File Systems. Oct 22 23:09:04.074623 systemd[1]: Stopped target swap.target - Swaps. Oct 22 23:09:04.082749 systemd[1]: Stopped target timers.target - Timer Units. Oct 22 23:09:04.089596 systemd[1]: iscsid.socket: Deactivated successfully. Oct 22 23:09:04.089745 systemd[1]: Closed iscsid.socket - Open-iSCSI iscsid Socket. Oct 22 23:09:04.097303 systemd[1]: iscsiuio.socket: Deactivated successfully. Oct 22 23:09:04.097413 systemd[1]: Closed iscsiuio.socket - Open-iSCSI iscsiuio Socket. Oct 22 23:09:04.105062 systemd[1]: systemd-coredump.socket: Deactivated successfully. Oct 22 23:09:04.130000 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 22 23:09:04.105160 systemd[1]: Closed systemd-coredump.socket - Process Core Dump Socket. Oct 22 23:09:04.113735 systemd[1]: systemd-journald-audit.socket: Deactivated successfully. Oct 22 23:09:04.113824 systemd[1]: Closed systemd-journald-audit.socket - Journal Audit Socket. Oct 22 23:09:04.122015 systemd[1]: dracut-pre-pivot.service: Deactivated successfully. Oct 22 23:09:04.173000 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 22 23:09:04.188726 kernel: audit: type=1131 audit(1792710544.130: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 22 23:09:04.122145 systemd[1]: Stopped dracut-pre-pivot.service - dracut pre-pivot and cleanup hook. Oct 22 23:09:04.193739 kernel: audit: type=1131 audit(1792710544.173: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 22 23:09:04.147481 systemd[1]: Stopped target remote-fs.target - Remote File Systems. Oct 22 23:09:04.198000 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 22 23:09:04.215357 kernel: audit: type=1131 audit(1792710544.198: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 22 23:09:04.156701 systemd[1]: Stopped target remote-fs-pre.target - Preparation for Remote File Systems. Oct 22 23:09:04.165793 systemd[1]: dracut-mount.service: Deactivated successfully. Oct 22 23:09:04.165945 systemd[1]: Stopped dracut-mount.service - dracut mount hook. Oct 22 23:09:04.188995 systemd[1]: dracut-pre-mount.service: Deactivated successfully. Oct 22 23:09:04.189089 systemd[1]: Stopped dracut-pre-mount.service - dracut pre-mount hook. Oct 22 23:09:04.256000 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 22 23:09:04.199005 systemd[1]: Stopped target cryptsetup.target - Local Encrypted Volumes. Oct 22 23:09:04.219957 systemd[1]: systemd-ask-password-console.path: Deactivated successfully. Oct 22 23:09:04.283000 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 22 23:09:04.220349 systemd[1]: Stopped systemd-ask-password-console.path - Dispatch Password Requests to Console Directory Watch. Oct 22 23:09:04.305889 kernel: audit: type=1131 audit(1792710544.256: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 22 23:09:04.230613 systemd[1]: Stopped target cryptsetup-pre.target - Local Encrypted Volumes (Pre). Oct 22 23:09:04.310000 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 22 23:09:04.315292 kernel: audit: type=1131 audit(1792710544.283: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 22 23:09:04.239089 systemd[1]: clevis-luks-askpass.path: Deactivated successfully. Oct 22 23:09:04.320000 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 22 23:09:04.239457 systemd[1]: Stopped clevis-luks-askpass.path - Forward Password Requests to Clevis Directory Watch. Oct 22 23:09:04.248598 systemd[1]: dracut-initqueue.service: Deactivated successfully. Oct 22 23:09:04.341000 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 22 23:09:04.248791 systemd[1]: Stopped dracut-initqueue.service - dracut initqueue hook. Oct 22 23:09:04.350000 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 22 23:09:04.257061 systemd[1]: initrd-setup-root-after-ignition.service: Deactivated successfully. Oct 22 23:09:04.365000 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 22 23:09:04.273530 systemd[1]: Stopped initrd-setup-root-after-ignition.service - Root filesystem completion. Oct 22 23:09:04.372000 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 22 23:09:04.377740 ignition[1490]: INFO : Ignition 2.24.0 Oct 22 23:09:04.377740 ignition[1490]: INFO : Stage: umount Oct 22 23:09:04.377740 ignition[1490]: INFO : no config dir at "/usr/lib/ignition/base.d" Oct 22 23:09:04.377740 ignition[1490]: INFO : no config dir at "/usr/lib/ignition/base.platform.d/azure" Oct 22 23:09:04.377740 ignition[1490]: INFO : umount: op(1): [started] umounting "/sysroot/tmp/_translate-filesystem-0-ign1" Oct 22 23:09:04.377740 ignition[1490]: INFO : umount: op(1): [finished] umounting "/sysroot/tmp/_translate-filesystem-0-ign1" Oct 22 23:09:04.377740 ignition[1490]: INFO : umount: umount passed Oct 22 23:09:04.377740 ignition[1490]: INFO : Ignition finished successfully Oct 22 23:09:04.381000 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 22 23:09:04.395000 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 22 23:09:04.404000 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 22 23:09:04.413000 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 22 23:09:04.443000 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 22 23:09:04.443000 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 22 23:09:04.283743 systemd[1]: ignition-files.service: Deactivated successfully. Oct 22 23:09:04.452000 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 22 23:09:04.299795 systemd[1]: Stopped ignition-files.service - Ignition (files). Oct 22 23:09:04.310471 systemd[1]: flatcar-metadata-hostname.service: Deactivated successfully. Oct 22 23:09:04.465000 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 22 23:09:04.310596 systemd[1]: Stopped flatcar-metadata-hostname.service - Flatcar Metadata Hostname Agent. Oct 22 23:09:04.469000 audit: BPF prog-id=5 op=UNLOAD Oct 22 23:09:04.469000 audit: BPF prog-id=8 op=UNLOAD Oct 22 23:09:04.323074 systemd[1]: Stopping ignition-mount.service - Ignition (mount)... Oct 22 23:09:04.330689 systemd[1]: systemd-modules-load.service: Deactivated successfully. Oct 22 23:09:04.330896 systemd[1]: Stopped systemd-modules-load.service - Load Kernel Modules. Oct 22 23:09:04.341990 systemd[1]: systemd-tmpfiles-setup.service: Deactivated successfully. Oct 22 23:09:04.342107 systemd[1]: Stopped systemd-tmpfiles-setup.service - Create System Files and Directories. Oct 22 23:09:04.356269 systemd[1]: systemd-udev-trigger.service: Deactivated successfully. Oct 22 23:09:04.529000 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 22 23:09:04.356364 systemd[1]: Stopped systemd-udev-trigger.service - Coldplug All udev Devices. Oct 22 23:09:04.367001 systemd[1]: dracut-pre-trigger.service: Deactivated successfully. Oct 22 23:09:04.367100 systemd[1]: Stopped dracut-pre-trigger.service - dracut pre-trigger hook. Oct 22 23:09:04.374978 systemd[1]: sysroot-tmp-_translate\x2dfilesystem\x2d0\x2dign1.mount: Deactivated successfully. Oct 22 23:09:04.375707 systemd[1]: ignition-mount.service: Deactivated successfully. Oct 22 23:09:04.375818 systemd[1]: Stopped ignition-mount.service - Ignition (mount). Oct 22 23:09:04.382762 systemd[1]: Stopped target network.target - Network. Oct 22 23:09:04.580000 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 22 23:09:04.388932 systemd[1]: ignition-disks.service: Deactivated successfully. Oct 22 23:09:04.389019 systemd[1]: Stopped ignition-disks.service - Ignition (disks). Oct 22 23:09:04.597000 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 22 23:09:04.395793 systemd[1]: ignition-setup-pre.service: Deactivated successfully. Oct 22 23:09:04.606000 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 22 23:09:04.395823 systemd[1]: Stopped ignition-setup-pre.service - Ignition env setup. Oct 22 23:09:04.623000 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 22 23:09:04.404351 systemd[1]: initrd-setup-root.service: Deactivated successfully. Oct 22 23:09:04.404378 systemd[1]: Stopped initrd-setup-root.service - Root filesystem setup. Oct 22 23:09:04.639159 kernel: hv_netvsc 7ced8dc0-7fba-7ced-8dc0-7fba7ced8dc0 eth0: Data path switched from VF: enP20488s1 Oct 22 23:09:04.413585 systemd[1]: Stopping systemd-networkd.service - Network Management... Oct 22 23:09:04.425418 systemd[1]: Stopping systemd-resolved.service - Network Name Resolution... Oct 22 23:09:04.654000 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 22 23:09:04.662000 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 22 23:09:04.434465 systemd[1]: initrd-cleanup.service: Deactivated successfully. Oct 22 23:09:04.671000 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 22 23:09:04.434579 systemd[1]: Finished initrd-cleanup.service - Cleaning Up and Shutting Down Daemons. Oct 22 23:09:04.682000 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 22 23:09:04.443759 systemd[1]: systemd-resolved.service: Deactivated successfully. Oct 22 23:09:04.693000 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 22 23:09:04.443844 systemd[1]: Stopped systemd-resolved.service - Network Name Resolution. Oct 22 23:09:04.702000 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 22 23:09:04.702000 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 22 23:09:04.457975 systemd[1]: systemd-networkd.service: Deactivated successfully. Oct 22 23:09:04.458060 systemd[1]: Stopped systemd-networkd.service - Network Management. Oct 22 23:09:04.475326 systemd[1]: systemd-networkd-resolve-hook.socket: Deactivated successfully. Oct 22 23:09:04.475381 systemd[1]: Closed systemd-networkd-resolve-hook.socket - Network Management Resolve Hook Socket. Oct 22 23:09:04.480787 systemd[1]: Stopped target network-pre.target - Preparation for Network. Oct 22 23:09:04.489580 systemd[1]: systemd-networkd.socket: Deactivated successfully. Oct 22 23:09:04.737000 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 22 23:09:04.489625 systemd[1]: Closed systemd-networkd.socket - Network Management Netlink Socket. Oct 22 23:09:04.500249 systemd[1]: Stopping network-cleanup.service - Network Cleanup... Oct 22 23:09:04.513839 systemd[1]: parse-ip-for-networkd.service: Deactivated successfully. Oct 22 23:09:04.513906 systemd[1]: Stopped parse-ip-for-networkd.service - Write systemd-networkd units from cmdline. Oct 22 23:09:04.533103 systemd[1]: Stopping systemd-udevd.service - Rule-based Manager for Device Events and Files... Oct 22 23:09:04.561228 systemd[1]: systemd-udevd.service: Deactivated successfully. Oct 22 23:09:04.570166 systemd[1]: Stopped systemd-udevd.service - Rule-based Manager for Device Events and Files. Oct 22 23:09:04.581352 systemd[1]: systemd-udevd.service: Consumed 1.077s CPU time over 11.237s wall clock time. Oct 22 23:09:04.581920 systemd[1]: systemd-udevd-control.socket: Deactivated successfully. Oct 22 23:09:04.582072 systemd[1]: Closed systemd-udevd-control.socket - udev Control Socket. Oct 22 23:09:04.589682 systemd[1]: dracut-pre-udev.service: Deactivated successfully. Oct 22 23:09:04.589730 systemd[1]: Stopped dracut-pre-udev.service - dracut pre-udev hook. Oct 22 23:09:04.598298 systemd[1]: dracut-cmdline.service: Deactivated successfully. Oct 22 23:09:04.598339 systemd[1]: Stopped dracut-cmdline.service - dracut cmdline hook. Oct 22 23:09:04.606784 systemd[1]: dracut-cmdline-ask.service: Deactivated successfully. Oct 22 23:09:04.606827 systemd[1]: Stopped dracut-cmdline-ask.service - dracut ask for additional cmdline parameters. Oct 22 23:09:04.628575 systemd[1]: Starting initrd-udevadm-cleanup-db.service - Cleanup udev Database... Oct 22 23:09:04.644440 systemd[1]: systemd-network-generator.service: Deactivated successfully. Oct 22 23:09:04.644600 systemd[1]: Stopped systemd-network-generator.service - Generate Network Units from Kernel Command Line. Oct 22 23:09:04.655112 systemd[1]: systemd-tmpfiles-setup-dev.service: Deactivated successfully. Oct 22 23:09:04.655148 systemd[1]: Stopped systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev. Oct 22 23:09:04.663097 systemd[1]: systemd-tmpfiles-setup-dev-early.service: Deactivated successfully. Oct 22 23:09:04.663135 systemd[1]: Stopped systemd-tmpfiles-setup-dev-early.service - Create Static Device Nodes in /dev gracefully. Oct 22 23:09:04.874281 systemd-journald[513]: Received SIGTERM from PID 1 (systemd). Oct 22 23:09:04.672573 systemd[1]: kmod-static-nodes.service: Deactivated successfully. Oct 22 23:09:04.672615 systemd[1]: Stopped kmod-static-nodes.service - Create List of Static Device Nodes. Oct 22 23:09:04.682655 systemd[1]: systemd-vconsole-setup.service: Deactivated successfully. Oct 22 23:09:04.682715 systemd[1]: Stopped systemd-vconsole-setup.service - Virtual Console Setup. Oct 22 23:09:04.694712 systemd[1]: initrd-udevadm-cleanup-db.service: Deactivated successfully. Oct 22 23:09:04.694828 systemd[1]: Finished initrd-udevadm-cleanup-db.service - Cleanup udev Database. Oct 22 23:09:04.729169 systemd[1]: network-cleanup.service: Deactivated successfully. Oct 22 23:09:04.729338 systemd[1]: Stopped network-cleanup.service - Network Cleanup. Oct 22 23:09:04.738069 systemd[1]: Reached target initrd-switch-root.target - Switch Root. Oct 22 23:09:04.747907 systemd[1]: Starting initrd-switch-root.service - Switch Root... Oct 22 23:09:04.774240 systemd[1]: Switching root. Oct 22 23:09:04.920678 systemd-journald[513]: Journal stopped Oct 22 23:09:24.623927 kernel: SELinux: policy capability network_peer_controls=1 Oct 22 23:09:24.623950 kernel: SELinux: policy capability open_perms=1 Oct 22 23:09:24.623958 kernel: SELinux: policy capability extended_socket_class=1 Oct 22 23:09:24.624496 kernel: SELinux: policy capability always_check_network=0 Oct 22 23:09:24.624511 kernel: SELinux: policy capability cgroup_seclabel=1 Oct 22 23:09:24.624518 kernel: SELinux: policy capability nnp_nosuid_transition=1 Oct 22 23:09:24.624528 kernel: SELinux: policy capability genfs_seclabel_symlinks=0 Oct 22 23:09:24.624534 kernel: SELinux: policy capability ioctl_skip_cloexec=0 Oct 22 23:09:24.624542 kernel: SELinux: policy capability userspace_initial_context=0 Oct 22 23:09:24.624549 systemd[1]: Successfully loaded SELinux policy in 707.391ms. Oct 22 23:09:24.624556 systemd[1]: Relabeled /dev/, /dev/shm/, /run/ in 6.103ms. Oct 22 23:09:24.624564 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 22 23:09:24.624571 systemd[1]: Detected virtualization microsoft. Oct 22 23:09:24.624577 systemd[1]: Detected architecture arm64. Oct 22 23:09:24.624584 systemd[1]: Detected first boot. Oct 22 23:09:24.624591 systemd[1]: Initializing machine ID from random generator. Oct 22 23:09:24.624598 systemd[1]: Hostname set to . Oct 22 23:09:24.624604 kernel: kauditd_printk_skb: 31 callbacks suppressed Oct 22 23:09:24.624610 kernel: audit: type=1334 audit(1792710551.793:89): prog-id=9 op=LOAD Oct 22 23:09:24.624616 kernel: audit: type=1334 audit(1792710551.793:90): prog-id=9 op=UNLOAD Oct 22 23:09:24.624622 zram_generator::config[1530]: No configuration found. Oct 22 23:09:24.624630 kernel: NET: Registered PF_VSOCK protocol family Oct 22 23:09:24.624636 systemd[1]: Applying preset policy. Oct 22 23:09:24.624644 systemd[1]: Created symlink '/etc/systemd/system/multi-user.target.wants/metadata.target' → '/etc/systemd/system/metadata.target'. Oct 22 23:09:24.624650 systemd[1]: Created symlink '/etc/systemd/system/afterburn.service' → '/usr/lib/systemd/system/coreos-metadata.service'. Oct 22 23:09:24.624657 systemd[1]: Created symlink '/etc/systemd/system/metadata.target.requires/coreos-metadata.service' → '/usr/lib/systemd/system/coreos-metadata.service'. Oct 22 23:09:24.624664 systemd[1]: Populated /etc with preset unit settings. Oct 22 23:09:24.624671 kernel: audit: type=1334 audit(1792710563.704:91): prog-id=10 op=LOAD Oct 22 23:09:24.624677 kernel: audit: type=1334 audit(1792710563.704:92): prog-id=2 op=UNLOAD Oct 22 23:09:24.624683 kernel: audit: type=1334 audit(1792710563.709:93): prog-id=11 op=LOAD Oct 22 23:09:24.624689 kernel: audit: type=1334 audit(1792710563.713:94): prog-id=12 op=LOAD Oct 22 23:09:24.624695 kernel: audit: type=1334 audit(1792710563.713:95): prog-id=3 op=UNLOAD Oct 22 23:09:24.624701 kernel: audit: type=1334 audit(1792710563.713:96): prog-id=4 op=UNLOAD Oct 22 23:09:24.624707 kernel: audit: type=1334 audit(1792710563.717:97): prog-id=13 op=LOAD Oct 22 23:09:24.624714 kernel: audit: type=1334 audit(1792710563.717:98): prog-id=10 op=UNLOAD Oct 22 23:09:24.624719 kernel: audit: type=1334 audit(1792710563.717:99): prog-id=14 op=LOAD Oct 22 23:09:24.624725 kernel: audit: type=1334 audit(1792710563.721:100): prog-id=15 op=LOAD Oct 22 23:09:24.624731 systemd[1]: initrd-switch-root.service: Deactivated successfully. Oct 22 23:09:24.624738 systemd[1]: Stopped initrd-switch-root.service - Switch Root. Oct 22 23:09:24.624745 systemd[1]: systemd-journald.service: Scheduled restart job, restart counter is at 1. Oct 22 23:09:24.624753 systemd[1]: Created slice system-addon\x2dconfig.slice - Slice /system/addon-config. Oct 22 23:09:24.624760 systemd[1]: Created slice system-addon\x2drun.slice - Slice /system/addon-run. Oct 22 23:09:24.624767 systemd[1]: Created slice system-getty.slice - Slice /system/getty. Oct 22 23:09:24.624774 systemd[1]: Created slice system-modprobe.slice - Slice /system/modprobe. Oct 22 23:09:24.624780 systemd[1]: Created slice system-serial\x2dgetty.slice - Slice /system/serial-getty. Oct 22 23:09:24.624787 systemd[1]: Created slice system-system\x2dcloudinit.slice - Slice /system/system-cloudinit. Oct 22 23:09:24.624795 systemd[1]: Created slice system-systemd\x2dfsck.slice - Slice /system/systemd-fsck. Oct 22 23:09:24.624801 systemd[1]: Created slice user.slice - User and Session Slice. Oct 22 23:09:24.624808 systemd[1]: Started clevis-luks-askpass.path - Forward Password Requests to Clevis Directory Watch. Oct 22 23:09:24.624815 systemd[1]: Started systemd-ask-password-console.path - Dispatch Password Requests to Console Directory Watch. Oct 22 23:09:24.624822 systemd[1]: Started systemd-ask-password-wall.path - Forward Password Requests to Wall Directory Watch. Oct 22 23:09:24.624828 systemd[1]: Set up automount boot.automount - Boot partition Automount Point. Oct 22 23:09:24.624835 systemd[1]: Set up automount proc-sys-fs-binfmt_misc.automount - Arbitrary Executable File Formats File System Automount Point. Oct 22 23:09:24.624851 systemd[1]: Expecting device dev-disk-by\x2dlabel-OEM.device - /dev/disk/by-label/OEM... Oct 22 23:09:24.624857 systemd[1]: Expecting device dev-ptp_hyperv.device - /dev/ptp_hyperv... Oct 22 23:09:24.624864 systemd[1]: Expecting device dev-ttyAMA0.device - /dev/ttyAMA0... Oct 22 23:09:24.624870 systemd[1]: Reached target cryptsetup-pre.target - Local Encrypted Volumes (Pre). Oct 22 23:09:24.624877 systemd[1]: Reached target cryptsetup.target - Local Encrypted Volumes. Oct 22 23:09:24.624883 systemd[1]: Reached target imports.target - Image Downloads. Oct 22 23:09:24.624891 systemd[1]: Stopped target initrd-switch-root.target - Switch Root. Oct 22 23:09:24.624897 systemd[1]: Stopped target initrd-fs.target - Initrd File Systems. Oct 22 23:09:24.624904 systemd[1]: Stopped target initrd-root-fs.target - Initrd Root File System. Oct 22 23:09:24.624910 systemd[1]: Reached target integritysetup.target - Local Integrity Protected Volumes. Oct 22 23:09:24.624917 systemd[1]: Reached target remote-cryptsetup.target - Remote Encrypted Volumes. Oct 22 23:09:24.624925 systemd[1]: Reached target remote-fs.target - Remote File Systems. Oct 22 23:09:24.624932 systemd[1]: Reached target remote-integritysetup.target - Remote Integrity Protected Volumes. Oct 22 23:09:24.624938 systemd[1]: Reached target remote-veritysetup.target - Remote Verity Protected Volumes. Oct 22 23:09:24.624945 systemd[1]: Reached target slices.target - Slice Units. Oct 22 23:09:24.624952 systemd[1]: Reached target swap.target - Swaps. Oct 22 23:09:24.624959 systemd[1]: Reached target veritysetup.target - Local Verity Protected Volumes. Oct 22 23:09:24.624985 systemd[1]: Listening on systemd-ask-password.socket - Query the User Interactively for a Password. Oct 22 23:09:24.624993 systemd[1]: Listening on systemd-coredump.socket - Process Core Dump Socket. Oct 22 23:09:24.624999 systemd[1]: Listening on systemd-creds.socket - Credential Encryption/Decryption. Oct 22 23:09:24.625006 systemd[1]: Listening on systemd-factory-reset.socket - Factory Reset Management. Oct 22 23:09:24.625013 systemd[1]: Listening on systemd-journald-audit.socket - Journal Audit Socket. Oct 22 23:09:24.625019 systemd[1]: Listening on systemd-mountfsd.socket - DDI File System Mounter Socket. Oct 22 23:09:24.625027 systemd[1]: Listening on systemd-mute-console.socket - Console Output Muting Service Socket. Oct 22 23:09:24.625033 systemd[1]: Listening on systemd-networkd-varlink-metrics.socket - Network Management Metrics Varlink Socket. Oct 22 23:09:24.625040 systemd[1]: Listening on systemd-networkd-varlink.socket - Network Management Varlink Socket. Oct 22 23:09:24.625047 systemd[1]: Listening on systemd-networkd.socket - Network Management Netlink Socket. Oct 22 23:09:24.625053 systemd[1]: Listening on systemd-nsresourced.socket - Namespace Resource Manager Socket. Oct 22 23:09:24.625060 systemd[1]: Listening on systemd-oomd.socket - Userspace Out-Of-Memory (OOM) Killer Socket. Oct 22 23:09:24.625068 systemd[1]: Listening on systemd-repart.socket - Disk Repartitioning Service Socket. Oct 22 23:09:24.625074 systemd[1]: Listening on systemd-resolved-monitor.socket - Resolve Monitor Varlink Socket. Oct 22 23:09:24.625081 systemd[1]: Listening on systemd-resolved-varlink.socket - Resolve Service Varlink Socket. Oct 22 23:09:24.625087 systemd[1]: Listening on systemd-udevd-control.socket - udev Control Socket. Oct 22 23:09:24.625094 systemd[1]: Listening on systemd-udevd-varlink.socket - udev Varlink Socket. Oct 22 23:09:24.625101 systemd[1]: Listening on systemd-userdbd.socket - User Database Manager Socket. Oct 22 23:09:24.625107 systemd[1]: Mounting dev-hugepages.mount - Huge Pages File System... Oct 22 23:09:24.625115 systemd[1]: Mounting dev-mqueue.mount - POSIX Message Queue File System... Oct 22 23:09:24.625121 systemd[1]: Mounting media.mount - External Media Directory... Oct 22 23:09:24.625127 systemd[1]: Mounting sys-kernel-debug.mount - Kernel Debug File System... Oct 22 23:09:24.625135 systemd[1]: Mounting sys-kernel-tracing.mount - Kernel Trace File System... Oct 22 23:09:24.625141 systemd[1]: tmp.mount: Directory /tmp to mount over is not empty, mounting anyway. Oct 22 23:09:24.625148 systemd[1]: tmp.mount: x-systemd.graceful-option=usrquota specified, but option is not available, suppressing. Oct 22 23:09:24.625155 systemd[1]: Mounting tmp.mount - Temporary Directory /tmp... Oct 22 23:09:24.625162 systemd[1]: Starting flatcar-tmpfiles.service - Create missing system files... Oct 22 23:09:24.625169 systemd[1]: ignition-delete-config.service - Ignition (delete config) skipped, no trigger condition checks were met. Oct 22 23:09:24.625175 systemd[1]: Starting kmod-static-nodes.service - Create List of Static Device Nodes... Oct 22 23:09:24.625182 systemd[1]: Starting modprobe@configfs.service - Load Kernel Module configfs... Oct 22 23:09:24.625188 systemd[1]: modprobe@drm.service - Load Kernel Module drm skipped, unmet condition check ConditionKernelModuleLoaded=!drm Oct 22 23:09:24.625195 systemd[1]: Starting modprobe@efi_pstore.service - Load Kernel Module efi_pstore... Oct 22 23:09:24.625203 systemd[1]: Starting modprobe@fuse.service - Load Kernel Module fuse... Oct 22 23:09:24.625209 systemd[1]: setup-nsswitch.service - Create /etc/nsswitch.conf skipped, unmet condition check ConditionPathExists=!/etc/nsswitch.conf Oct 22 23:09:24.625216 systemd[1]: systemd-fsck-root.service: Deactivated successfully. Oct 22 23:09:24.625222 systemd[1]: Stopped systemd-fsck-root.service - File System Check on Root Device. Oct 22 23:09:24.625229 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 22 23:09:24.625236 systemd[1]: Starting systemd-journald.service - Journal Service... Oct 22 23:09:24.625242 systemd[1]: Starting systemd-modules-load.service - Load Kernel Modules... Oct 22 23:09:24.625250 kernel: fuse: init (API version 7.41) Oct 22 23:09:24.625256 systemd[1]: Starting systemd-network-generator.service - Generate Network Units from Kernel Command Line... Oct 22 23:09:24.625286 systemd-journald[1606]: Collecting audit messages is enabled. Oct 22 23:09:24.625306 systemd-journald[1606]: Journal started Oct 22 23:09:24.625321 systemd-journald[1606]: Runtime Journal (/run/log/journal/4a5112b8bddd49ac93bd4d53c29300d2) is 8M, max 78.3M, 70.3M free. Oct 22 23:09:24.168000 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 22 23:09:24.550000 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 22 23:09:24.564000 audit: BPF prog-id=18 op=UNLOAD Oct 22 23:09:24.564000 audit: BPF prog-id=17 op=UNLOAD Oct 22 23:09:24.564000 audit: BPF prog-id=19 op=LOAD Oct 22 23:09:24.564000 audit: BPF prog-id=20 op=LOAD Oct 22 23:09:24.564000 audit: BPF prog-id=21 op=LOAD Oct 22 23:09:24.621000 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 22 23:09:24.621000 audit[1606]: SYSCALL arch=c00000b7 syscall=211 success=yes exit=60 a0=3 a1=fffffa8b01f0 a2=4000 a3=0 items=0 ppid=1 pid=1606 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 22 23:09:24.621000 audit: PROCTITLE proctitle="/usr/lib/systemd/systemd-journald" Oct 22 23:09:23.689889 systemd[1]: Queued start job for default target multi-user.target. Oct 22 23:09:24.630239 systemd[1]: Reached target time-set.target - System Time Set. Oct 22 23:09:23.735211 systemd[1]: Unnecessary job was removed for dev-sda6.device - /dev/sda6. Oct 22 23:09:23.739846 systemd[1]: systemd-journald.service: Deactivated successfully. Oct 22 23:09:23.799586 systemd[1]: systemd-journald.service: Consumed 2.737s CPU time over 31.491s wall clock time. Oct 22 23:09:24.646010 systemd[1]: Starting systemd-remount-fs.service - Remount Root and Kernel File Systems... Oct 22 23:09:24.661194 systemd-modules-load[1610]: Using 2 probe threads Oct 22 23:09:24.667421 systemd[1]: Starting systemd-udev-load-credentials.service - Load udev Rules from Credentials... Oct 22 23:09:24.685084 systemd[1]: Starting systemd-udev-trigger.service - Coldplug All udev Devices... Oct 22 23:09:24.696232 systemd[1]: Started systemd-journald.service - Journal Service. Oct 22 23:09:24.695000 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 22 23:09:24.697190 systemd[1]: Mounted dev-hugepages.mount - Huge Pages File System. Oct 22 23:09:24.702008 systemd[1]: Mounted dev-mqueue.mount - POSIX Message Queue File System. Oct 22 23:09:24.708827 systemd[1]: Mounted media.mount - External Media Directory. Oct 22 23:09:24.714003 systemd[1]: Mounted sys-kernel-debug.mount - Kernel Debug File System. Oct 22 23:09:24.719697 systemd[1]: Mounted sys-kernel-tracing.mount - Kernel Trace File System. Oct 22 23:09:24.724819 systemd[1]: Mounted tmp.mount - Temporary Directory /tmp. Oct 22 23:09:24.729487 systemd[1]: Finished kmod-static-nodes.service - Create List of Static Device Nodes. Oct 22 23:09:24.734000 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 22 23:09:24.735761 systemd[1]: modprobe@configfs.service: Deactivated successfully. Oct 22 23:09:24.735914 systemd[1]: Finished modprobe@configfs.service - Load Kernel Module configfs. Oct 22 23:09:24.740000 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 22 23:09:24.740000 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 22 23:09:24.741465 systemd[1]: modprobe@efi_pstore.service: Deactivated successfully. Oct 22 23:09:24.741617 systemd[1]: Finished modprobe@efi_pstore.service - Load Kernel Module efi_pstore. Oct 22 23:09:24.746000 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 22 23:09:24.746000 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 22 23:09:24.747611 systemd[1]: modprobe@fuse.service: Deactivated successfully. Oct 22 23:09:24.747743 systemd[1]: Finished modprobe@fuse.service - Load Kernel Module fuse. Oct 22 23:09:24.751000 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 22 23:09:24.751000 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 22 23:09:24.753007 systemd[1]: Finished systemd-modules-load.service - Load Kernel Modules. Oct 22 23:09:24.757000 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 22 23:09:24.758905 systemd[1]: Finished systemd-network-generator.service - Generate Network Units from Kernel Command Line. Oct 22 23:09:24.764000 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 22 23:09:24.766413 systemd[1]: Finished systemd-remount-fs.service - Remount Root and Kernel File Systems. Oct 22 23:09:24.771000 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 22 23:09:24.773239 systemd[1]: Finished systemd-udev-load-credentials.service - Load udev Rules from Credentials. Oct 22 23:09:24.778000 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 22 23:09:24.787921 systemd[1]: Reached target network-pre.target - Preparation for Network. Oct 22 23:09:24.793956 systemd[1]: Listening on systemd-networkd-resolve-hook.socket - Network Management Resolve Hook Socket. Oct 22 23:09:24.800843 systemd[1]: Mounting sys-fs-fuse-connections.mount - FUSE Control File System... Oct 22 23:09:24.817106 systemd[1]: Mounting sys-kernel-config.mount - Kernel Configuration File System... Oct 22 23:09:24.824383 systemd[1]: remount-root.service - Remount Root File System skipped, unmet condition check ConditionPathIsReadWrite=!/ Oct 22 23:09:24.835212 systemd[1]: Starting systemd-hwdb-update.service - Rebuild Hardware Database... Oct 22 23:09:24.844107 systemd[1]: Starting systemd-journal-flush.service - Flush Journal to Persistent Storage... Oct 22 23:09:24.849015 systemd[1]: systemd-pstore.service - Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore Oct 22 23:09:24.850594 systemd[1]: Starting systemd-random-seed.service - Load/Save OS Random Seed... Oct 22 23:09:24.858040 systemd[1]: Starting systemd-sysctl.service - Apply Kernel Variables... Oct 22 23:09:24.867169 systemd[1]: Starting systemd-tmpfiles-setup-dev-early.service - Create Static Device Nodes in /dev gracefully... Oct 22 23:09:24.879115 systemd[1]: Finished systemd-udev-trigger.service - Coldplug All udev Devices. Oct 22 23:09:24.883000 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 22 23:09:24.885672 systemd[1]: Mounted sys-fs-fuse-connections.mount - FUSE Control File System. Oct 22 23:09:24.891563 systemd[1]: Mounted sys-kernel-config.mount - Kernel Configuration File System. Oct 22 23:09:24.897296 systemd[1]: Finished systemd-random-seed.service - Load/Save OS Random Seed. Oct 22 23:09:24.901000 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 22 23:09:24.904852 systemd[1]: Reached target first-boot-complete.target - First Boot Complete. Oct 22 23:09:24.914720 systemd-journald[1606]: Time spent on flushing to /var/log/journal/4a5112b8bddd49ac93bd4d53c29300d2 is 15.701ms for 1175 entries. Oct 22 23:09:24.914720 systemd-journald[1606]: System Journal (/var/log/journal/4a5112b8bddd49ac93bd4d53c29300d2) is 8M, max 2.2G, 2.2G free. Oct 22 23:09:24.945000 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 22 23:09:24.948622 systemd-journald[1606]: Received client request to flush runtime journal. Oct 22 23:09:24.941394 systemd[1]: Finished systemd-sysctl.service - Apply Kernel Variables. Oct 22 23:09:24.949394 systemd[1]: Finished systemd-journal-flush.service - Flush Journal to Persistent Storage. Oct 22 23:09:24.953000 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 22 23:09:24.974841 systemd[1]: Finished flatcar-tmpfiles.service - Create missing system files. Oct 22 23:09:24.979000 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 22 23:09:25.076295 systemd-tmpfiles[1659]: ACLs are not supported, ignoring. Oct 22 23:09:25.076307 systemd-tmpfiles[1659]: ACLs are not supported, ignoring. Oct 22 23:09:25.079226 systemd[1]: Finished systemd-tmpfiles-setup-dev-early.service - Create Static Device Nodes in /dev gracefully. Oct 22 23:09:25.083000 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 22 23:09:25.089116 systemd[1]: Starting systemd-sysusers.service - Create System Users... Oct 22 23:09:25.318116 systemd[1]: Finished systemd-sysusers.service - Create System Users. Oct 22 23:09:25.326000 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 22 23:09:25.329145 systemd[1]: Starting systemd-journalctl.socket - Journal Log Access Socket... Oct 22 23:09:25.335000 audit: BPF prog-id=22 op=LOAD Oct 22 23:09:25.336000 audit: BPF prog-id=23 op=LOAD Oct 22 23:09:25.336000 audit: BPF prog-id=24 op=LOAD Oct 22 23:09:25.339110 systemd[1]: Starting systemd-oomd.service - Userspace Out-Of-Memory (OOM) Killer... Oct 22 23:09:25.345000 audit: BPF prog-id=25 op=LOAD Oct 22 23:09:25.348236 systemd[1]: Starting systemd-resolved.service - Network Name Resolution... Oct 22 23:09:25.358102 systemd[1]: Starting systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev... Oct 22 23:09:25.364726 systemd[1]: Listening on systemd-journalctl.socket - Journal Log Access Socket. Oct 22 23:09:25.374097 systemd[1]: Starting modprobe@tun.service - Load Kernel Module tun... Oct 22 23:09:25.380000 audit: BPF prog-id=26 op=LOAD Oct 22 23:09:25.381000 audit: BPF prog-id=27 op=LOAD Oct 22 23:09:25.381000 audit: BPF prog-id=28 op=LOAD Oct 22 23:09:25.382727 systemd[1]: Starting systemd-userdbd.service - User Database Manager... Oct 22 23:09:25.389845 systemd-tmpfiles[1675]: ACLs are not supported, ignoring. Oct 22 23:09:25.390303 systemd-tmpfiles[1675]: ACLs are not supported, ignoring. Oct 22 23:09:25.392634 systemd[1]: Finished systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev. Oct 22 23:09:25.398000 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 22 23:09:25.398716 systemd[1]: proc-sys-fs-binfmt_misc.automount: Got automount request for /proc/sys/fs/binfmt_misc, triggered by 1677 ((systemd-userd)) Oct 22 23:09:25.398949 systemd[1]: Reached target local-fs-pre.target - Preparation for Local File Systems. Oct 22 23:09:25.404743 systemd[1]: systemd-repart.service - Repartition Root Disk skipped, no trigger condition checks were met. Oct 22 23:09:25.475989 kernel: tun: Universal TUN/TAP device driver, 1.6 Oct 22 23:09:25.476886 systemd[1]: modprobe@tun.service: Deactivated successfully. Oct 22 23:09:25.477110 systemd[1]: Finished modprobe@tun.service - Load Kernel Module tun. Oct 22 23:09:25.480000 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 22 23:09:25.480000 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 22 23:09:25.481000 audit: BPF prog-id=29 op=LOAD Oct 22 23:09:25.481000 audit: BPF prog-id=30 op=LOAD Oct 22 23:09:25.481000 audit: BPF prog-id=31 op=LOAD Oct 22 23:09:25.483587 systemd[1]: Starting systemd-nsresourced.service - Namespace Resource Manager... Oct 22 23:09:25.509053 systemd[1]: Finished systemd-hwdb-update.service - Rebuild Hardware Database. Oct 22 23:09:25.513000 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 22 23:09:25.513000 audit: BPF prog-id=7 op=UNLOAD Oct 22 23:09:25.513000 audit: BPF prog-id=6 op=UNLOAD Oct 22 23:09:25.514000 audit: BPF prog-id=32 op=LOAD Oct 22 23:09:25.514000 audit: BPF prog-id=33 op=LOAD Oct 22 23:09:25.517106 systemd[1]: Starting systemd-udevd.service - Rule-based Manager for Device Events and Files... Oct 22 23:09:25.750987 systemd-udevd[1682]: Using default interface naming scheme 'v260'. Oct 22 23:09:25.876885 systemd[1]: Mounting proc-sys-fs-binfmt_misc.mount - Arbitrary Executable File Formats File System... Oct 22 23:09:25.882158 systemd[1]: var-lib-machines.mount - Virtual Machine and Container Storage (Compatibility) skipped, unmet condition check ConditionPathExists=/var/lib/machines.raw Oct 22 23:09:25.882254 systemd[1]: Reached target local-fs.target - Local File Systems. Oct 22 23:09:25.886937 systemd[1]: Reached target machines.target - Virtual Machines and Containers. Oct 22 23:09:25.893156 systemd[1]: Listening on systemd-importd.socket - Disk Image Download Service Socket. Oct 22 23:09:25.899869 systemd[1]: Listening on systemd-sysext.socket - System Extension Image Management. Oct 22 23:09:25.906248 systemd[1]: Starting systemd-confext.service - Merge System Configuration Images into /etc/... Oct 22 23:09:25.912135 systemd[1]: Starting systemd-machine-id-commit.service - Save Transient machine-id to Disk... Oct 22 23:09:25.925130 systemd[1]: Starting systemd-userdb-load-credentials.service - Load JSON user/group Records from Credentials... Oct 22 23:09:25.956495 systemd[1]: Mounted proc-sys-fs-binfmt_misc.mount - Arbitrary Executable File Formats File System. Oct 22 23:09:25.962418 systemd[1]: Finished systemd-userdb-load-credentials.service - Load JSON user/group Records from Credentials. Oct 22 23:09:25.966000 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 22 23:09:25.969393 systemd[1]: systemd-binfmt.service - Set Up Additional Binary Formats skipped, no trigger condition checks were met. Oct 22 23:09:25.994985 kernel: loop4: detected capacity change from 0 to 44360 Oct 22 23:09:26.009276 kernel: loop4: p1 p2 p3 Oct 22 23:09:26.004516 systemd[1]: Started systemd-userdbd.service - User Database Manager. Oct 22 23:09:26.012160 systemd-nsresourced[1680]: Not setting up BPF subsystem, as functionality has been disabled at compile time. Oct 22 23:09:26.011000 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 22 23:09:26.018000 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 22 23:09:26.013594 systemd[1]: Started systemd-nsresourced.service - Namespace Resource Manager. Oct 22 23:09:26.042330 systemd[1]: etc-machine\x2did.mount: Deactivated successfully. Oct 22 23:09:26.045047 systemd[1]: Finished systemd-machine-id-commit.service - Save Transient machine-id to Disk. Oct 22 23:09:26.050000 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 22 23:09:26.095612 kernel: device-mapper: verity: sha256 using shash "sha256-ce" Oct 22 23:09:26.095713 kernel: device-mapper: verity: Unrecognized verity feature request: root_hash_sig_key_desc Oct 22 23:09:26.096624 systemd-oomd[1673]: No swap; memory pressure usage will be degraded Oct 22 23:09:26.100439 kernel: device-mapper: table: 254:5: verity: Unrecognized verity feature request (-EINVAL) Oct 22 23:09:26.104329 kernel: device-mapper: ioctl: error adding target to table Oct 22 23:09:26.104669 systemd[1]: Started systemd-oomd.service - Userspace Out-Of-Memory (OOM) Killer. Oct 22 23:09:26.109000 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 22 23:09:26.110072 systemd-confext[1689]: device-mapper: reload ioctl on loop4p1-53-verity (254:5) failed: Invalid argument Oct 22 23:09:26.116985 kernel: device-mapper: verity: sha256 using shash "sha256-ce" Oct 22 23:09:26.131138 systemd-resolved[1674]: Positive Trust Anchors: Oct 22 23:09:26.131151 systemd-resolved[1674]: . IN DS 20326 8 2 e06d44b80b8f1d39a95c0b0d7c65d08458e880409bbc683457104237c7f8ec8d Oct 22 23:09:26.131153 systemd-resolved[1674]: . IN DS 38696 8 2 683d2d0acb8c9b712a1948b27f741219298d0a450d612c483af444a4c0fb2b16 Oct 22 23:09:26.131173 systemd-resolved[1674]: 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 22 23:09:26.136939 systemd[1]: Started systemd-udevd.service - Rule-based Manager for Device Events and Files. Oct 22 23:09:26.141000 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 22 23:09:26.142000 audit: BPF prog-id=34 op=LOAD Oct 22 23:09:26.146123 systemd[1]: Starting systemd-networkd.service - Network Management... Oct 22 23:09:26.178822 systemd-resolved[1674]: Using system hostname 'ci-4757.2.1-n-ebcd5c0479'. Oct 22 23:09:26.181544 systemd[1]: Started systemd-resolved.service - Network Name Resolution. Oct 22 23:09:26.188000 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 22 23:09:26.189354 systemd[1]: Reached target nss-lookup.target - Host and Network Name Lookups. Oct 22 23:09:26.247829 systemd[1]: Condition check resulted in dev-ttyAMA0.device - /dev/ttyAMA0 being skipped. Oct 22 23:09:26.327020 kernel: hv_storvsc f8b3781a-1e82-4818-a1c3-63d806ec15bb: tag#69 cmd 0x85 status: scsi 0x2 srb 0x6 hv 0xc0000001 Oct 22 23:09:26.333450 systemd-networkd[1712]: lo: Link UP Oct 22 23:09:26.333456 systemd-networkd[1712]: lo: Gained carrier Oct 22 23:09:26.335564 systemd[1]: Started systemd-networkd.service - Network Management. Oct 22 23:09:26.336103 systemd-networkd[1712]: eth0: Found matching .network file, based on potentially unpredictable interface name: /usr/lib/systemd/network/zz-default.network Oct 22 23:09:26.336106 systemd-networkd[1712]: eth0: Configuring with /usr/lib/systemd/network/zz-default.network. Oct 22 23:09:26.340000 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 22 23:09:26.341424 systemd[1]: Reached target network.target - Network. Oct 22 23:09:26.349364 systemd[1]: Starting systemd-networkd-persistent-storage.service - Enable Persistent Storage in systemd-networkd... Oct 22 23:09:26.357327 systemd[1]: Starting systemd-networkd-wait-online.service - Wait for Network to be Online... Oct 22 23:09:26.371080 kernel: mousedev: PS/2 mouse device common for all mice Oct 22 23:09:26.412983 kernel: hv_vmbus: registering driver hv_balloon Oct 22 23:09:26.413057 kernel: mlx5_core 5008:00:02.0 enP20488s1: Link up Oct 22 23:09:26.418039 kernel: hv_balloon: Using Dynamic Memory protocol version 2.0 Oct 22 23:09:26.420040 kernel: hv_balloon: Memory hot add disabled on ARM64 Oct 22 23:09:26.424998 kernel: hv_vmbus: registering driver hyperv_fb Oct 22 23:09:26.438815 systemd[1]: Condition check resulted in dev-ptp_hyperv.device - /dev/ptp_hyperv being skipped. Oct 22 23:09:26.445541 kernel: hyperv_fb: Synthvid Version major 3, minor 5 Oct 22 23:09:26.445580 kernel: hyperv_fb: Screen resolution: 1024x768, Color depth: 32, Frame buffer size: 8388608 Oct 22 23:09:26.455124 kernel: hv_netvsc 7ced8dc0-7fba-7ced-8dc0-7fba7ced8dc0 eth0: Data path switched to VF: enP20488s1 Oct 22 23:09:26.455036 systemd-networkd[1712]: eth0: Found matching .network file, based on potentially unpredictable interface name: /usr/lib/systemd/network/zz-default.network Oct 22 23:09:26.455424 kernel: Console: switching to colour dummy device 80x25 Oct 22 23:09:26.455607 systemd-networkd[1712]: enP20488s1: Link UP Oct 22 23:09:26.456124 systemd-networkd[1712]: eth0: Link UP Oct 22 23:09:26.456132 systemd-networkd[1712]: eth0: Gained carrier Oct 22 23:09:26.456147 systemd-networkd[1712]: eth0: Found matching .network file, based on potentially unpredictable interface name: /usr/lib/systemd/network/zz-default.network Oct 22 23:09:26.463139 kernel: Console: switching to colour frame buffer device 128x48 Oct 22 23:09:26.464255 systemd-networkd[1712]: enP20488s1: Gained carrier Oct 22 23:09:26.468057 systemd[1]: Finished systemd-networkd-persistent-storage.service - Enable Persistent Storage in systemd-networkd. Oct 22 23:09:26.476100 systemd-networkd[1712]: eth0: DHCPv4 address 10.0.0.14/24, gateway 10.0.0.1 acquired from 168.63.129.16 Oct 22 23:09:26.476000 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 22 23:09:26.496946 systemd[1]: Starting systemd-vconsole-setup.service - Virtual Console Setup... Oct 22 23:09:26.571748 systemd[1]: Found device dev-disk-by\x2dlabel-OEM.device - Virtual_Disk OEM. Oct 22 23:09:26.583957 systemd[1]: Starting systemd-fsck@dev-disk-by\x2dlabel-OEM.service - File System Check on /dev/disk/by-label/OEM... Oct 22 23:09:26.621989 kernel: MACsec IEEE 802.1AE Oct 22 23:09:26.646674 systemd[1]: systemd-vconsole-setup.service: Deactivated successfully. Oct 22 23:09:26.648013 systemd[1]: Stopped systemd-vconsole-setup.service - Virtual Console Setup. Oct 22 23:09:26.652000 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 22 23:09:26.652000 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 22 23:09:26.655617 systemd[1]: Starting systemd-vconsole-setup.service - Virtual Console Setup... Oct 22 23:09:26.676998 kernel: erofs: (device dm-5): mounted with root inode @ nid 40. Oct 22 23:09:26.698052 kernel: loop4: detected capacity change from 0 to 44360 Oct 22 23:09:26.702987 kernel: loop4: p1 p2 p3 Oct 22 23:09:26.708126 systemd[1]: Finished systemd-fsck@dev-disk-by\x2dlabel-OEM.service - File System Check on /dev/disk/by-label/OEM. Oct 22 23:09:26.717000 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 22 23:09:26.725927 kernel: device-mapper: verity: sha256 using shash "sha256-ce" Oct 22 23:09:26.726016 kernel: device-mapper: verity: Unrecognized verity feature request: root_hash_sig_key_desc Oct 22 23:09:26.726038 kernel: device-mapper: table: 254:5: verity: Unrecognized verity feature request (-EINVAL) Oct 22 23:09:26.733636 kernel: device-mapper: ioctl: error adding target to table Oct 22 23:09:26.735567 (sd-merge)[1844]: device-mapper: reload ioctl on loop4p1-58-verity (254:5) failed: Invalid argument Oct 22 23:09:26.744988 kernel: device-mapper: verity: sha256 using shash "sha256-ce" Oct 22 23:09:26.761943 (sd-merge)[1844]: Skipping extension refresh because no change was found, use --always-refresh=yes to always do a refresh. Oct 22 23:09:26.763764 kernel: erofs: (device dm-5): mounted with root inode @ nid 40. Oct 22 23:09:26.766777 systemd[1]: Finished systemd-confext.service - Merge System Configuration Images into /etc/. Oct 22 23:09:26.771000 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 22 23:09:26.775493 systemd[1]: Starting systemd-sysext.service - Merge System Extension Images into /usr/ and /opt/... Oct 22 23:09:26.802986 kernel: loop4: detected capacity change from 0 to 142648 Oct 22 23:09:26.814998 kernel: loop4: p1 p2 p3 Oct 22 23:09:26.830243 kernel: device-mapper: verity: sha256 using shash "sha256-ce" Oct 22 23:09:26.830300 kernel: device-mapper: verity: Unrecognized verity feature request: root_hash_sig_key_desc Oct 22 23:09:26.835282 kernel: device-mapper: table: 254:5: verity: Unrecognized verity feature request (-EINVAL) Oct 22 23:09:26.840923 systemd-sysext[1853]: device-mapper: reload ioctl on loop4p1-62-verity (254:5) failed: Invalid argument Oct 22 23:09:26.841208 kernel: device-mapper: ioctl: error adding target to table Oct 22 23:09:26.850990 kernel: device-mapper: verity: sha256 using shash "sha256-ce" Oct 22 23:09:26.868103 kernel: erofs: (device dm-5): mounted with root inode @ nid 39. Oct 22 23:09:26.893039 kernel: loop4: detected capacity change from 0 to 172608 Oct 22 23:09:26.899004 kernel: loop4: p1 p2 p3 Oct 22 23:09:26.915161 kernel: device-mapper: verity: sha256 using shash "sha256-ce" Oct 22 23:09:26.915222 kernel: device-mapper: verity: Unrecognized verity feature request: root_hash_sig_key_desc Oct 22 23:09:26.920685 kernel: device-mapper: table: 254:5: verity: Unrecognized verity feature request (-EINVAL) Oct 22 23:09:26.924292 kernel: device-mapper: ioctl: error adding target to table Oct 22 23:09:26.924481 systemd-sysext[1853]: device-mapper: reload ioctl on loop4p1-67-verity (254:5) failed: Invalid argument Oct 22 23:09:26.934010 kernel: device-mapper: verity: sha256 using shash "sha256-ce" Oct 22 23:09:26.960985 kernel: erofs: (device dm-5): mounted with root inode @ nid 39. Oct 22 23:09:26.963312 systemd-vconsole-setup[1839]: Configuration of first virtual console was skipped, ignoring remaining ones. Oct 22 23:09:26.965651 systemd[1]: Finished systemd-vconsole-setup.service - Virtual Console Setup. Oct 22 23:09:26.970000 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 22 23:09:26.988992 kernel: loop4: detected capacity change from 0 to 364712 Oct 22 23:09:26.998046 kernel: loop4: p1 p2 p3 Oct 22 23:09:27.012559 kernel: device-mapper: verity: sha256 using shash "sha256-ce" Oct 22 23:09:27.018948 kernel: device-mapper: verity: Unrecognized verity feature request: root_hash_sig_key_desc Oct 22 23:09:27.019010 kernel: device-mapper: table: 254:5: verity: Unrecognized verity feature request (-EINVAL) Oct 22 23:09:27.023053 kernel: device-mapper: ioctl: error adding target to table Oct 22 23:09:27.023456 systemd-sysext[1853]: device-mapper: reload ioctl on loop4p1-72-verity (254:5) failed: Invalid argument Oct 22 23:09:27.030002 kernel: device-mapper: verity: sha256 using shash "sha256-ce" Oct 22 23:09:27.059986 kernel: erofs: (device dm-5): mounted with root inode @ nid 39. Oct 22 23:09:27.088112 kernel: loop4: detected capacity change from 0 to 142648 Oct 22 23:09:27.096981 kernel: loop4: p1 p2 p3 Oct 22 23:09:27.108934 kernel: device-mapper: verity: sha256 using shash "sha256-ce" Oct 22 23:09:27.109011 kernel: device-mapper: verity: Unrecognized verity feature request: root_hash_sig_key_desc Oct 22 23:09:27.114023 kernel: device-mapper: table: 254:5: verity: Unrecognized verity feature request (-EINVAL) Oct 22 23:09:27.117524 kernel: device-mapper: ioctl: error adding target to table Oct 22 23:09:27.117711 (sd-merge)[1879]: device-mapper: reload ioctl on loop4p1-77-verity (254:5) failed: Invalid argument Oct 22 23:09:27.126013 kernel: device-mapper: verity: sha256 using shash "sha256-ce" Oct 22 23:09:27.150990 kernel: erofs: (device dm-5): mounted with root inode @ nid 39. Oct 22 23:09:27.156082 kernel: loop5: detected capacity change from 0 to 172608 Oct 22 23:09:27.170041 kernel: loop5: p1 p2 p3 Oct 22 23:09:27.185924 kernel: device-mapper: verity: sha256 using shash "sha256-ce" Oct 22 23:09:27.186197 kernel: device-mapper: verity: Unrecognized verity feature request: root_hash_sig_key_desc Oct 22 23:09:27.186225 kernel: device-mapper: table: 254:6: verity: Unrecognized verity feature request (-EINVAL) Oct 22 23:09:27.194429 kernel: device-mapper: ioctl: error adding target to table Oct 22 23:09:27.194614 (sd-merge)[1879]: device-mapper: reload ioctl on loop5p1-81-verity (254:6) failed: Invalid argument Oct 22 23:09:27.205985 kernel: device-mapper: verity: sha256 using shash "sha256-ce" Oct 22 23:09:27.232988 kernel: erofs: (device dm-6): mounted with root inode @ nid 39. Oct 22 23:09:27.237979 kernel: loop6: detected capacity change from 0 to 364712 Oct 22 23:09:27.253989 kernel: loop6: p1 p2 p3 Oct 22 23:09:27.266860 kernel: device-mapper: verity: sha256 using shash "sha256-ce" Oct 22 23:09:27.266892 kernel: device-mapper: verity: Unrecognized verity feature request: root_hash_sig_key_desc Oct 22 23:09:27.272616 kernel: device-mapper: table: 254:7: verity: Unrecognized verity feature request (-EINVAL) Oct 22 23:09:27.272678 kernel: device-mapper: ioctl: error adding target to table Oct 22 23:09:27.276754 (sd-merge)[1879]: device-mapper: reload ioctl on loop6p1-85-verity (254:7) failed: Invalid argument Oct 22 23:09:27.286986 kernel: device-mapper: verity: sha256 using shash "sha256-ce" Oct 22 23:09:27.310010 kernel: erofs: (device dm-7): mounted with root inode @ nid 39. Oct 22 23:09:27.310268 (sd-merge)[1879]: Skipping extension refresh because no change was found, use --always-refresh=yes to always do a refresh. Oct 22 23:09:27.312039 systemd[1]: Finished systemd-sysext.service - Merge System Extension Images into /usr/ and /opt/. Oct 22 23:09:27.316000 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 22 23:09:27.319135 systemd[1]: Starting systemd-tmpfiles-setup.service - Create System Files and Directories... Oct 22 23:09:27.339426 systemd-tmpfiles[1902]: /usr/lib/tmpfiles.d/base_image_var.conf:29: Duplicate line for path "/var/log/audit", ignoring. Oct 22 23:09:27.340581 systemd-tmpfiles[1902]: /usr/lib/tmpfiles.d/base_image_var_late.conf:44: Duplicate line for path "/var/log/audit", ignoring. Oct 22 23:09:27.341669 systemd-tmpfiles[1902]: /usr/lib/tmpfiles.d/baselayout.conf:15: Duplicate line for path "/var", ignoring. Oct 22 23:09:27.341772 systemd-tmpfiles[1902]: /usr/lib/tmpfiles.d/baselayout.conf:16: Duplicate line for path "/var/empty", ignoring. Oct 22 23:09:27.341828 systemd-tmpfiles[1902]: /usr/lib/tmpfiles.d/baselayout.conf:21: Duplicate line for path "/var/log", ignoring. Oct 22 23:09:27.342016 systemd-tmpfiles[1902]: /usr/lib/tmpfiles.d/dbus.conf:5: Duplicate line for path "/var/lib/dbus", ignoring. Oct 22 23:09:27.342335 systemd-tmpfiles[1902]: /usr/lib/tmpfiles.d/nfs-utils.conf:2: Duplicate line for path "/var/lib/nfs/v4recovery", ignoring. Oct 22 23:09:27.347672 systemd-tmpfiles[1902]: /usr/lib/tmpfiles.d/nfs-utils.conf:6: Duplicate line for path "/var/lib/nfs/sm", ignoring. Oct 22 23:09:27.347812 systemd-tmpfiles[1902]: /usr/lib/tmpfiles.d/nfs-utils.conf:7: Duplicate line for path "/var/lib/nfs/sm.bak", ignoring. Oct 22 23:09:27.348092 systemd-tmpfiles[1902]: /usr/lib/tmpfiles.d/provision.conf:20: Duplicate line for path "/root", ignoring. Oct 22 23:09:27.348880 systemd-tmpfiles[1902]: /usr/lib/tmpfiles.d/tpm2-tss-fapi.conf:2: Duplicate line for path "/var/lib/tpm2-tss/system/keystore", ignoring. Oct 22 23:09:27.348977 systemd-tmpfiles[1902]: ACLs are not supported, ignoring. Oct 22 23:09:27.349097 systemd-tmpfiles[1902]: ACLs are not supported, ignoring. Oct 22 23:09:27.349987 systemd-tmpfiles[1902]: /usr/lib/tmpfiles.d/var.conf:10: Duplicate line for path "/var", ignoring. Oct 22 23:09:27.350089 systemd-tmpfiles[1902]: /usr/lib/tmpfiles.d/var.conf:14: Duplicate line for path "/var/log", ignoring. Oct 22 23:09:27.350216 systemd-tmpfiles[1902]: /usr/lib/tmpfiles.d/var.conf:21: Duplicate line for path "/var/lib", ignoring. Oct 22 23:09:27.353316 systemd-tmpfiles[1902]: Detected autofs mount point '/boot' during canonicalization of 'boot'. Oct 22 23:09:27.353421 systemd-tmpfiles[1902]: Skipping /boot Oct 22 23:09:27.359325 systemd-tmpfiles[1902]: Detected autofs mount point '/boot' during canonicalization of 'boot'. Oct 22 23:09:27.359411 systemd-tmpfiles[1902]: Skipping /boot Oct 22 23:09:27.371091 systemd[1]: Finished systemd-tmpfiles-setup.service - Create System Files and Directories. Oct 22 23:09:27.375000 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 22 23:09:27.378802 systemd[1]: Starting audit-rules.service - Load Audit Rules... Oct 22 23:09:27.390116 systemd[1]: Starting clean-ca-certificates.service - Clean up broken links in /etc/ssl/certs... Oct 22 23:09:27.398112 systemd[1]: Starting ldconfig.service - Rebuild Dynamic Linker Cache... Oct 22 23:09:27.407125 systemd[1]: Starting systemd-journal-catalog-update.service - Rebuild Journal Catalog... Oct 22 23:09:27.415154 systemd[1]: Starting systemd-update-utmp.service - Record System Boot/Shutdown in UTMP... Oct 22 23:09:27.423000 audit[1909]: AUDIT1127 pid=1909 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 22 23:09:27.426728 systemd[1]: Finished systemd-update-utmp.service - Record System Boot/Shutdown in UTMP. Oct 22 23:09:27.432000 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 22 23:09:27.542448 systemd[1]: Finished systemd-journal-catalog-update.service - Rebuild Journal Catalog. Oct 22 23:09:27.548000 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 22 23:09:27.580202 systemd-networkd[1712]: eth0: Gained IPv6LL Oct 22 23:09:27.585207 systemd[1]: Finished systemd-networkd-wait-online.service - Wait for Network to be Online. Oct 22 23:09:27.591000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=systemd-networkd-wait-online comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Oct 22 23:09:27.592482 systemd[1]: Reached target network-online.target - Network is Online. Oct 22 23:09:27.597000 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 22 23:09:27.597000 audit[1933]: SYSCALL arch=c00000b7 syscall=206 success=yes exit=1056 a0=3 a1=ffffe062ca90 a2=420 a3=0 items=0 ppid=1905 pid=1933 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 22 23:09:27.597000 audit: PROCTITLE proctitle=2F7362696E2F617564697463746C002D52002F6574632F61756469742F61756469742E72756C6573 Oct 22 23:09:27.599325 augenrules[1933]: No rules Oct 22 23:09:27.600514 systemd[1]: audit-rules.service: Deactivated successfully. Oct 22 23:09:27.600777 systemd[1]: Finished audit-rules.service - Load Audit Rules. Oct 22 23:09:27.996843 systemd[1]: Finished clean-ca-certificates.service - Clean up broken links in /etc/ssl/certs. Oct 22 23:09:28.002793 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 22 23:09:33.441500 ldconfig[1907]: ldconfig: /usr/lib/ld.so.conf is not an ELF file - it has the wrong magic bytes at the start. Oct 22 23:09:33.450823 systemd[1]: Finished ldconfig.service - Rebuild Dynamic Linker Cache. Oct 22 23:09:33.458308 systemd[1]: Starting systemd-update-done.service - Update is Completed... Oct 22 23:09:33.481693 systemd[1]: Finished systemd-update-done.service - Update is Completed. Oct 22 23:09:33.487376 systemd[1]: Reached target sysinit.target - System Initialization. Oct 22 23:09:33.492482 systemd[1]: Started motdgen.path - Watch for update engine configuration changes. Oct 22 23:09:33.498347 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 22 23:09:33.504903 systemd[1]: Started logrotate.timer - Daily rotation of log files. Oct 22 23:09:33.509719 systemd[1]: Started mdadm.timer - Weekly check for MD array's redundancy information.. Oct 22 23:09:33.515677 systemd[1]: Started systemd-sysupdate-reboot.timer - Reboot Automatically After System Update. Oct 22 23:09:33.521582 systemd[1]: Started systemd-sysupdate.timer - Automatic System Update. Oct 22 23:09:33.526597 systemd[1]: Started systemd-tmpfiles-clean.timer - Daily Cleanup of Temporary Directories. Oct 22 23:09:33.532473 systemd[1]: update-engine-stub.timer - Update Engine Stub Timer skipped, unmet condition check ConditionPathExists=/usr/.noupdate Oct 22 23:09:33.532508 systemd[1]: Reached target paths.target - Path Units. Oct 22 23:09:33.536928 systemd[1]: Reached target timers.target - Timer Units. Oct 22 23:09:33.542151 systemd[1]: Listening on dbus.socket - D-Bus System Message Bus Socket. Oct 22 23:09:33.548835 systemd[1]: Starting docker.socket - Docker Socket for the API... Oct 22 23:09:33.554877 systemd[1]: Listening on sshd-unix-local.socket - OpenSSH Server Socket (systemd-ssh-generator, AF_UNIX Local). Oct 22 23:09:33.563433 systemd[1]: Listening on sshd.socket - OpenSSH Server Socket. Oct 22 23:09:33.568576 systemd[1]: Listening on systemd-hostnamed.socket - Hostname Service Socket. Oct 22 23:09:33.574082 systemd[1]: Listening on systemd-logind-varlink.socket - User Login Management Varlink Socket. Oct 22 23:09:33.580295 systemd[1]: Listening on systemd-machined.socket - Virtual Machine and Container Registration Service Socket. Oct 22 23:09:33.587064 systemd[1]: Listening on docker.socket - Docker Socket for the API. Oct 22 23:09:33.592313 systemd[1]: Reached target sockets.target - Socket Units. Oct 22 23:09:33.596933 systemd[1]: Reached target basic.target - Basic System. Oct 22 23:09:33.601130 systemd[1]: addon-config@oem.service - Configure Addon /oem skipped, no trigger condition checks were met. Oct 22 23:09:33.601153 systemd[1]: addon-run@oem.service - Run Addon /oem skipped, no trigger condition checks were met. Oct 22 23:09:33.602957 systemd[1]: Starting chronyd.service - NTP client/server... Oct 22 23:09:33.618081 systemd[1]: Starting containerd.service - containerd container runtime... Oct 22 23:09:33.634122 systemd[1]: Starting coreos-metadata.service - Flatcar Metadata Agent... Oct 22 23:09:33.641207 systemd[1]: Starting dbus.service - D-Bus System Message Bus... Oct 22 23:09:33.647505 chronyd[1947]: chronyd version 4.8 starting (+CMDMON +REFCLOCK +RTC +PRIVDROP +SCFILTER -SIGND +NTS +SECHASH +IPV6 -DEBUG) Oct 22 23:09:33.652204 systemd[1]: Starting dracut-shutdown.service - Restore /run/initramfs on shutdown... Oct 22 23:09:33.659721 systemd[1]: Starting enable-oem-cloudinit.service - Enable cloudinit... Oct 22 23:09:33.666097 systemd[1]: Starting extend-filesystems.service - Extend Filesystems... Oct 22 23:09:33.671239 chronyd[1947]: Timezone right/UTC failed leap second check, ignoring Oct 22 23:09:33.671410 chronyd[1947]: Loaded seccomp filter (level 2) Oct 22 23:09:33.671910 systemd[1]: flatcar-setup-environment.service - Modifies /etc/environment for CoreOS skipped, unmet condition check ConditionPathExists=/oem/bin/flatcar-setup-environment Oct 22 23:09:33.675177 systemd[1]: Started hv_kvp_daemon.service - Hyper-V KVP daemon. Oct 22 23:09:33.680422 systemd[1]: hv_vss_daemon.service - Hyper-V VSS daemon skipped, unmet condition check ConditionPathExists=/dev/vmbus/hv_vss Oct 22 23:09:33.683143 systemd[1]: Starting motdgen.service - Generate /run/flatcar/motd... Oct 22 23:09:33.690979 jq[1955]: false Oct 22 23:09:33.690299 KVP[1957]: KVP starting; pid is:1957 Oct 22 23:09:33.695226 systemd[1]: Starting nvidia.service - NVIDIA Configure Service... Oct 22 23:09:33.699715 kernel: hv_utils: KVP IC version 4.0 Oct 22 23:09:33.695190 KVP[1957]: KVP LIC Version: 3.1 Oct 22 23:09:33.703136 systemd[1]: Starting ssh-key-proc-cmdline.service - Install an ssh key from /proc/cmdline... Oct 22 23:09:33.713737 systemd[1]: Starting sshd-keygen.service - Generate sshd host keys... Oct 22 23:09:33.723116 systemd[1]: Starting systemd-logind.service - User Login Management... Oct 22 23:09:33.727859 systemd[1]: tcsd.service - TCG Core Services Daemon skipped, unmet condition check ConditionPathExists=/dev/tpm0 Oct 22 23:09:33.730261 systemd[1]: Starting update-engine.service - Update Engine... Oct 22 23:09:33.735030 motdgen[1973]: /oem/oem-release: line 2: Azure: command not found Oct 22 23:09:33.735351 extend-filesystems[1956]: Found /dev/sda6 Oct 22 23:09:33.742628 systemd[1]: Starting update-ssh-keys-after-ignition.service - Run update-ssh-keys once after Ignition... Oct 22 23:09:33.754725 extend-filesystems[1956]: Found /dev/sda9 Oct 22 23:09:33.755723 systemd[1]: Started chronyd.service - NTP client/server. Oct 22 23:09:33.763837 extend-filesystems[1956]: Checking size of /dev/sda9 Oct 22 23:09:33.772010 systemd[1]: Finished dracut-shutdown.service - Restore /run/initramfs on shutdown. Oct 22 23:09:33.781601 jq[1979]: true Oct 22 23:09:33.782652 systemd[1]: enable-oem-cloudinit.service: Skipped due to 'exec-condition'. Oct 22 23:09:33.785799 systemd[1]: Condition check resulted in enable-oem-cloudinit.service - Enable cloudinit being skipped. Oct 22 23:09:33.786061 systemd[1]: motdgen.service: Deactivated successfully. Oct 22 23:09:33.786229 systemd[1]: Finished motdgen.service - Generate /run/flatcar/motd. Oct 22 23:09:33.792256 systemd[1]: ssh-key-proc-cmdline.service: Deactivated successfully. Oct 22 23:09:33.792493 systemd[1]: Finished ssh-key-proc-cmdline.service - Install an ssh key from /proc/cmdline. Oct 22 23:09:33.817100 extend-filesystems[1956]: Resized partition /dev/sda9 Oct 22 23:09:33.825035 systemd[1]: Finished nvidia.service - NVIDIA Configure Service. Oct 22 23:09:33.837087 extend-filesystems[2009]: resize2fs 1.47.4 (6-Mar-2025) Oct 22 23:09:33.846814 jq[1992]: true Oct 22 23:09:33.846899 update_engine[1971]: I20261022 23:09:33.845449 1971 main.cc:92] Flatcar Update Engine starting Oct 22 23:09:33.863851 kernel: EXT4-fs (sda9): resizing filesystem from 6359552 to 6376955 blocks Oct 22 23:09:33.863926 kernel: EXT4-fs (sda9): resized filesystem to 6376955 Oct 22 23:09:33.878760 systemd-logind[1967]: New seat seat0. Oct 22 23:09:33.880373 systemd-logind[1967]: Watching system buttons on /dev/input/event1 (AT Translated Set 2 keyboard) Oct 22 23:09:33.880821 systemd[1]: Started systemd-logind.service - User Login Management. Oct 22 23:09:33.896441 extend-filesystems[2009]: Filesystem at /dev/sda9 is mounted on /; on-line resizing required Oct 22 23:09:33.896441 extend-filesystems[2009]: old_desc_blocks = 4, new_desc_blocks = 4 Oct 22 23:09:33.896441 extend-filesystems[2009]: The filesystem on /dev/sda9 is now 6376955 (4k) blocks long. Oct 22 23:09:33.924594 extend-filesystems[1956]: Resized filesystem in /dev/sda9 Oct 22 23:09:33.903324 systemd[1]: extend-filesystems.service: Deactivated successfully. Oct 22 23:09:33.904045 systemd[1]: Finished extend-filesystems.service - Extend Filesystems. Oct 22 23:09:33.948046 bash[2035]: Updated "/home/core/.ssh/authorized_keys" Oct 22 23:09:33.951023 systemd[1]: Finished update-ssh-keys-after-ignition.service - Run update-ssh-keys once after Ignition. Oct 22 23:09:33.961618 systemd[1]: sshkeys.service skipped, no trigger condition checks were met. Oct 22 23:09:33.993758 dbus-daemon[1950]: [system] SELinux support is enabled Oct 22 23:09:33.994139 systemd[1]: Started dbus.service - D-Bus System Message Bus. Oct 22 23:09:33.997320 update_engine[1971]: I20261022 23:09:33.997139 1971 update_check_scheduler.cc:74] Next update check in 7m27s Oct 22 23:09:34.007474 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 22 23:09:34.007508 systemd[1]: Reached target system-config.target - Load system-provided cloud configs. Oct 22 23:09:34.019323 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 22 23:09:34.019350 systemd[1]: Reached target user-config.target - Load user-provided cloud configs. Oct 22 23:09:34.038035 dbus-daemon[1950]: [system] Successfully activated service 'org.freedesktop.systemd1' Oct 22 23:09:34.042903 systemd[1]: Started update-engine.service - Update Engine. Oct 22 23:09:34.059525 systemd[1]: Started locksmithd.service - Cluster reboot manager. Oct 22 23:09:34.082104 coreos-metadata[1949]: Oct 22 23:09:34.082 INFO Fetching http://168.63.129.16/?comp=versions: Attempt #1 Oct 22 23:09:34.084564 coreos-metadata[1949]: Oct 22 23:09:34.084 INFO Fetch successful Oct 22 23:09:34.084564 coreos-metadata[1949]: Oct 22 23:09:34.084 INFO Fetching http://168.63.129.16/machine/?comp=goalstate: Attempt #1 Oct 22 23:09:34.090284 coreos-metadata[1949]: Oct 22 23:09:34.090 INFO Fetch successful Oct 22 23:09:34.090284 coreos-metadata[1949]: Oct 22 23:09:34.090 INFO Fetching http://168.63.129.16/machine/914da143-8b9c-4968-a431-add13c12a344/73e649c9%2Dd38b%2D4103%2D9dfe%2Dace440b26c13.%5Fci%2D4757.2.1%2Dn%2Debcd5c0479?comp=config&type=sharedConfig&incarnation=1: Attempt #1 Oct 22 23:09:34.125285 coreos-metadata[1949]: Oct 22 23:09:34.125 INFO Fetch successful Oct 22 23:09:34.125285 coreos-metadata[1949]: Oct 22 23:09:34.125 INFO Fetching http://169.254.169.254/metadata/instance/compute/vmSize?api-version=2017-08-01&format=text: Attempt #1 Oct 22 23:09:34.132981 coreos-metadata[1949]: Oct 22 23:09:34.132 INFO Fetch successful Oct 22 23:09:34.153776 systemd[1]: Finished coreos-metadata.service - Flatcar Metadata Agent. Oct 22 23:09:34.161378 systemd[1]: Reached target metadata.target. Oct 22 23:09:34.293904 locksmithd[2096]: locksmithd starting currentOperation="UPDATE_STATUS_IDLE" strategy="reboot" Oct 22 23:09:34.313714 sshd_keygen[1970]: ssh-keygen: generating new host keys: RSA ECDSA ED25519 MLDSA44-ED25519 Oct 22 23:09:34.333687 systemd[1]: Finished sshd-keygen.service - Generate sshd host keys. Oct 22 23:09:34.342420 systemd[1]: Starting issuegen.service - Generate /run/issue... Oct 22 23:09:34.352125 systemd[1]: Starting waagent.service - Microsoft Azure Linux Agent... Oct 22 23:09:34.361426 systemd[1]: issuegen.service: Deactivated successfully. Oct 22 23:09:34.362058 systemd[1]: Finished issuegen.service - Generate /run/issue. Oct 22 23:09:34.372280 systemd[1]: Starting systemd-user-sessions.service - Permit User Sessions... Oct 22 23:09:34.387132 systemd[1]: Started waagent.service - Microsoft Azure Linux Agent. Oct 22 23:09:34.395284 systemd[1]: Finished systemd-user-sessions.service - Permit User Sessions. Oct 22 23:09:34.403881 systemd[1]: Started getty@tty1.service - Getty on tty1. Oct 22 23:09:34.409723 systemd[1]: Started serial-getty@ttyAMA0.service - Serial Getty on ttyAMA0. Oct 22 23:09:34.415582 systemd[1]: Reached target getty.target - Login Prompts. Oct 22 23:09:37.696236 waagent[2137]: 2026-10-22T23:09:37.696153Z INFO Daemon Daemon Azure Linux Agent Version: 2.12.0.4 Oct 22 23:09:37.701258 waagent[2137]: 2026-10-22T23:09:37.701206Z INFO Daemon Daemon OS: flatcar 4757.2.1 Oct 22 23:09:37.705039 waagent[2137]: 2026-10-22T23:09:37.704999Z INFO Daemon Daemon Python: 3.12.13 Oct 22 23:09:37.711718 waagent[2137]: 2026-10-22T23:09:37.708655Z INFO Daemon Daemon Run daemon Oct 22 23:09:37.712115 waagent[2137]: 2026-10-22T23:09:37.712082Z INFO Daemon Daemon No RDMA handler exists for distro='Flatcar Container Linux by Kinvolk' version='4757.2.1' Oct 22 23:09:37.719032 waagent[2137]: 2026-10-22T23:09:37.718997Z INFO Daemon Daemon Using waagent for provisioning Oct 22 23:09:37.723248 waagent[2137]: 2026-10-22T23:09:37.723212Z INFO Daemon Daemon Activate resource disk Oct 22 23:09:37.726911 waagent[2137]: 2026-10-22T23:09:37.726879Z INFO Daemon Daemon Searching gen1 prefix 00000000-0001 or gen2 f8b3781a-1e82-4818-a1c3-63d806ec15bb Oct 22 23:09:37.735542 waagent[2137]: 2026-10-22T23:09:37.735500Z INFO Daemon Daemon Found device: None Oct 22 23:09:37.739302 waagent[2137]: 2026-10-22T23:09:37.739267Z ERROR Daemon Daemon Failed to mount resource disk [ResourceDiskError] unable to detect disk topology Oct 22 23:09:37.745873 waagent[2137]: 2026-10-22T23:09:37.745840Z ERROR Daemon Daemon Event: name=WALinuxAgent, op=ActivateResourceDisk, message=[ResourceDiskError] unable to detect disk topology, duration=0 Oct 22 23:09:37.755037 waagent[2137]: 2026-10-22T23:09:37.754997Z INFO Daemon Daemon Clean protocol and wireserver endpoint Oct 22 23:09:37.759771 waagent[2137]: 2026-10-22T23:09:37.759737Z INFO Daemon Daemon Running default provisioning handler Oct 22 23:09:37.768930 waagent[2137]: 2026-10-22T23:09:37.768895Z 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 22 23:09:37.779445 waagent[2137]: 2026-10-22T23:09:37.779410Z INFO Daemon Daemon Unable to get cloud-init enabled status from service: [Errno 2] No such file or directory: 'service' Oct 22 23:09:37.787376 waagent[2137]: 2026-10-22T23:09:37.787343Z INFO Daemon Daemon cloud-init is enabled: False Oct 22 23:09:37.791426 waagent[2137]: 2026-10-22T23:09:37.791390Z INFO Daemon Daemon Copying ovf-env.xml Oct 22 23:09:37.847109 waagent[2137]: 2026-10-22T23:09:37.847047Z INFO Daemon Daemon Successfully mounted dvd Oct 22 23:09:37.944331 systemd[1]: mnt-cdrom-secure.mount: Deactivated successfully. Oct 22 23:09:37.945598 waagent[2137]: 2026-10-22T23:09:37.945547Z INFO Daemon Daemon Detect protocol endpoint Oct 22 23:09:37.949921 waagent[2137]: 2026-10-22T23:09:37.949828Z INFO Daemon Daemon Clean protocol and wireserver endpoint Oct 22 23:09:37.954868 waagent[2137]: 2026-10-22T23:09:37.954828Z INFO Daemon Daemon WireServer endpoint is not found. Rerun dhcp handler Oct 22 23:09:37.959944 waagent[2137]: 2026-10-22T23:09:37.959908Z INFO Daemon Daemon Test for route to 168.63.129.16 Oct 22 23:09:37.964585 waagent[2137]: 2026-10-22T23:09:37.964547Z INFO Daemon Daemon Route to 168.63.129.16 exists Oct 22 23:09:37.969025 waagent[2137]: 2026-10-22T23:09:37.968989Z INFO Daemon Daemon Wire server endpoint:168.63.129.16 Oct 22 23:09:37.994361 waagent[2137]: 2026-10-22T23:09:37.994321Z INFO Daemon Daemon Fabric preferred wire protocol version:2015-04-05 Oct 22 23:09:38.000012 waagent[2137]: 2026-10-22T23:09:37.999988Z INFO Daemon Daemon Wire protocol version:2012-11-30 Oct 22 23:09:38.004709 waagent[2137]: 2026-10-22T23:09:38.004676Z INFO Daemon Daemon Server preferred version:2015-04-05 Oct 22 23:09:38.133404 waagent[2137]: 2026-10-22T23:09:38.133329Z INFO Daemon Daemon Initializing goal state during protocol detection Oct 22 23:09:38.138905 waagent[2137]: 2026-10-22T23:09:38.138853Z INFO Daemon Daemon Forcing an update of the goal state. Oct 22 23:09:38.147790 waagent[2137]: 2026-10-22T23:09:38.147751Z INFO Daemon Fetched a new incarnation for the WireServer goal state [incarnation 1] Oct 22 23:09:38.184004 waagent[2137]: 2026-10-22T23:09:38.183928Z INFO Daemon Daemon HostGAPlugin version: 1.0.8.189 Oct 22 23:09:38.188732 waagent[2137]: 2026-10-22T23:09:38.188693Z INFO Daemon Oct 22 23:09:38.191090 waagent[2137]: 2026-10-22T23:09:38.191056Z INFO Daemon Fetched new vmSettings [HostGAPlugin correlation ID: 03a58c93-8211-4cd4-a675-4f350bad6f21 eTag: 6246453161290053378 source: Fabric] Oct 22 23:09:38.199911 waagent[2137]: 2026-10-22T23:09:38.199871Z INFO Daemon The vmSettings originated via Fabric; will ignore them. Oct 22 23:09:38.205748 waagent[2137]: 2026-10-22T23:09:38.205615Z INFO Daemon Oct 22 23:09:38.208178 waagent[2137]: 2026-10-22T23:09:38.208142Z INFO Daemon Fetching full goal state from the WireServer [incarnation 1] Oct 22 23:09:38.216539 waagent[2137]: 2026-10-22T23:09:38.216503Z INFO Daemon Daemon Downloading artifacts profile blob Oct 22 23:09:38.303509 waagent[2137]: 2026-10-22T23:09:38.303451Z INFO Daemon Downloaded certificate {'thumbprint': '71143B961E87622B09CBB6099465CBB2A3DD4C88', 'hasPrivateKey': True} Oct 22 23:09:38.311988 waagent[2137]: 2026-10-22T23:09:38.311924Z INFO Daemon Fetch goal state completed Oct 22 23:09:38.325014 waagent[2137]: 2026-10-22T23:09:38.321209Z INFO Daemon Daemon Starting provisioning Oct 22 23:09:38.325465 waagent[2137]: 2026-10-22T23:09:38.325427Z INFO Daemon Daemon Handle ovf-env.xml. Oct 22 23:09:38.330247 waagent[2137]: 2026-10-22T23:09:38.330212Z INFO Daemon Daemon Set hostname [ci-4757.2.1-n-ebcd5c0479] Oct 22 23:09:38.336939 waagent[2137]: 2026-10-22T23:09:38.336901Z INFO Daemon Daemon Publish hostname [ci-4757.2.1-n-ebcd5c0479] Oct 22 23:09:38.342720 waagent[2137]: 2026-10-22T23:09:38.342678Z INFO Daemon Daemon Examine /proc/net/route for primary interface Oct 22 23:09:38.348130 waagent[2137]: 2026-10-22T23:09:38.348091Z INFO Daemon Daemon Primary interface is [eth0] Oct 22 23:09:38.358506 systemd-networkd[1712]: eth0: Found matching .network file, based on potentially unpredictable interface name: /usr/lib/systemd/network/zz-default.network Oct 22 23:09:38.358522 systemd-networkd[1712]: eth0: Reconfiguring with /usr/lib/systemd/network/zz-default.network. Oct 22 23:09:38.358575 systemd-networkd[1712]: eth0: DHCP lease lost Oct 22 23:09:38.371538 waagent[2137]: 2026-10-22T23:09:38.367264Z INFO Daemon Daemon Create user account if not exists Oct 22 23:09:38.372298 waagent[2137]: 2026-10-22T23:09:38.372232Z INFO Daemon Daemon User core already exists, skip useradd Oct 22 23:09:38.376931 waagent[2137]: 2026-10-22T23:09:38.376892Z INFO Daemon Daemon Configure sudoer Oct 22 23:09:38.378011 systemd-networkd[1712]: eth0: DHCPv4 address 10.0.0.14/24, gateway 10.0.0.1 acquired from 168.63.129.16 Oct 22 23:09:38.381336 waagent[2137]: 2026-10-22T23:09:38.381293Z INFO Daemon Daemon Configure sshd Oct 22 23:09:38.385042 waagent[2137]: 2026-10-22T23:09:38.385000Z INFO Daemon Daemon Added a configuration snippet disabling SSH password-based authentication methods. It also configures SSH client probing to keep connections alive. Oct 22 23:09:38.396055 waagent[2137]: 2026-10-22T23:09:38.395999Z INFO Daemon Daemon Deploy ssh public key. Oct 22 23:09:39.377898 containerd[1994]: time="2026-10-22T23:09:39Z" 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 22 23:09:39.380200 containerd[1994]: time="2026-10-22T23:09:39.378833468Z" level=info msg="starting containerd" revision=e53c7c1516c3b2bff98eb76f1f4117477e6f4e66 version=v2.2.5 Oct 22 23:09:39.387595 containerd[1994]: time="2026-10-22T23:09:39.387559156Z" level=warning msg="Configuration migrated from version 2, use `containerd config migrate` to avoid migration" t="8.536µs" Oct 22 23:09:39.387712 containerd[1994]: time="2026-10-22T23:09:39.387695540Z" level=info msg="loading plugin" id=io.containerd.content.v1.content type=io.containerd.content.v1 Oct 22 23:09:39.387788 containerd[1994]: time="2026-10-22T23:09:39.387777620Z" level=info msg="loading plugin" id=io.containerd.image-verifier.v1.bindir type=io.containerd.image-verifier.v1 Oct 22 23:09:39.387842 containerd[1994]: time="2026-10-22T23:09:39.387830404Z" level=info msg="loading plugin" id=io.containerd.internal.v1.opt type=io.containerd.internal.v1 Oct 22 23:09:39.388086 containerd[1994]: time="2026-10-22T23:09:39.388064916Z" level=info msg="loading plugin" id=io.containerd.warning.v1.deprecations type=io.containerd.warning.v1 Oct 22 23:09:39.388148 containerd[1994]: time="2026-10-22T23:09:39.388137708Z" level=info msg="loading plugin" id=io.containerd.mount-handler.v1.erofs type=io.containerd.mount-handler.v1 Oct 22 23:09:39.388204 containerd[1994]: time="2026-10-22T23:09:39.388191236Z" level=info msg="loading plugin" id=io.containerd.snapshotter.v1.blockfile type=io.containerd.snapshotter.v1 Oct 22 23:09:39.388322 containerd[1994]: time="2026-10-22T23:09:39.388306020Z" 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 22 23:09:39.388380 containerd[1994]: time="2026-10-22T23:09:39.388366556Z" level=info msg="loading plugin" id=io.containerd.snapshotter.v1.btrfs type=io.containerd.snapshotter.v1 Oct 22 23:09:39.388618 containerd[1994]: time="2026-10-22T23:09:39.388598884Z" 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 22 23:09:39.388673 containerd[1994]: time="2026-10-22T23:09:39.388661052Z" level=info msg="loading plugin" id=io.containerd.snapshotter.v1.devmapper type=io.containerd.snapshotter.v1 Oct 22 23:09:39.388714 containerd[1994]: time="2026-10-22T23:09:39.388702204Z" level=info msg="skip loading plugin" error="devmapper not configured: skip plugin" id=io.containerd.snapshotter.v1.devmapper type=io.containerd.snapshotter.v1 Oct 22 23:09:39.388758 containerd[1994]: time="2026-10-22T23:09:39.388747868Z" level=info msg="loading plugin" id=io.containerd.snapshotter.v1.erofs type=io.containerd.snapshotter.v1 Oct 22 23:09:39.389016 containerd[1994]: time="2026-10-22T23:09:39.388999044Z" level=info msg="loading plugin" id=io.containerd.snapshotter.v1.native type=io.containerd.snapshotter.v1 Oct 22 23:09:39.389172 containerd[1994]: time="2026-10-22T23:09:39.389157172Z" level=info msg="loading plugin" id=io.containerd.snapshotter.v1.overlayfs type=io.containerd.snapshotter.v1 Oct 22 23:09:39.389415 containerd[1994]: time="2026-10-22T23:09:39.389394588Z" level=info msg="loading plugin" id=io.containerd.snapshotter.v1.zfs type=io.containerd.snapshotter.v1 Oct 22 23:09:39.389491 containerd[1994]: time="2026-10-22T23:09:39.389479156Z" 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 22 23:09:39.389544 containerd[1994]: time="2026-10-22T23:09:39.389534164Z" level=info msg="loading plugin" id=io.containerd.event.v1.exchange type=io.containerd.event.v1 Oct 22 23:09:39.389605 containerd[1994]: time="2026-10-22T23:09:39.389595020Z" level=info msg="loading plugin" id=io.containerd.monitor.task.v1.cgroups type=io.containerd.monitor.task.v1 Oct 22 23:09:39.408159 containerd[1994]: time="2026-10-22T23:09:39.408124900Z" level=info msg="loading plugin" id=io.containerd.metadata.v1.bolt type=io.containerd.metadata.v1 Oct 22 23:09:39.408372 containerd[1994]: time="2026-10-22T23:09:39.408355364Z" level=info msg="metadata content store policy set" policy=shared Oct 22 23:09:39.420817 containerd[1994]: time="2026-10-22T23:09:39.420775396Z" level=info msg="loading plugin" id=io.containerd.gc.v1.scheduler type=io.containerd.gc.v1 Oct 22 23:09:39.421018 containerd[1994]: time="2026-10-22T23:09:39.421004836Z" level=info msg="loading plugin" id=io.containerd.nri.v1.nri type=io.containerd.nri.v1 Oct 22 23:09:39.421590 containerd[1994]: time="2026-10-22T23:09:39.421568356Z" level=info msg="built-in NRI default validator is disabled" Oct 22 23:09:39.421665 containerd[1994]: time="2026-10-22T23:09:39.421654452Z" level=info msg="runtime interface created" Oct 22 23:09:39.421710 containerd[1994]: time="2026-10-22T23:09:39.421699940Z" level=info msg="created NRI interface" Oct 22 23:09:39.421750 containerd[1994]: time="2026-10-22T23:09:39.421738772Z" level=info msg="loading plugin" id=io.containerd.differ.v1.erofs type=io.containerd.differ.v1 Oct 22 23:09:39.461931 containerd[1994]: time="2026-10-22T23:09:39.461886020Z" level=info msg="loading plugin" id=io.containerd.mount-manager.v1.bolt type=io.containerd.mount-manager.v1 Oct 22 23:09:39.462259 containerd[1994]: time="2026-10-22T23:09:39.462235548Z" level=info msg="loading plugin" id=io.containerd.differ.v1.walking type=io.containerd.differ.v1 Oct 22 23:09:39.462344 containerd[1994]: time="2026-10-22T23:09:39.462332116Z" level=info msg="loading plugin" id=io.containerd.lease.v1.manager type=io.containerd.lease.v1 Oct 22 23:09:39.462491 containerd[1994]: time="2026-10-22T23:09:39.462406540Z" level=info msg="loading plugin" id=io.containerd.service.v1.containers-service type=io.containerd.service.v1 Oct 22 23:09:39.462491 containerd[1994]: time="2026-10-22T23:09:39.462423140Z" level=info msg="loading plugin" id=io.containerd.service.v1.content-service type=io.containerd.service.v1 Oct 22 23:09:39.462491 containerd[1994]: time="2026-10-22T23:09:39.462430164Z" level=info msg="loading plugin" id=io.containerd.service.v1.diff-service type=io.containerd.service.v1 Oct 22 23:09:39.462491 containerd[1994]: time="2026-10-22T23:09:39.462438868Z" level=info msg="loading plugin" id=io.containerd.service.v1.images-service type=io.containerd.service.v1 Oct 22 23:09:39.462491 containerd[1994]: time="2026-10-22T23:09:39.462447044Z" level=info msg="loading plugin" id=io.containerd.service.v1.introspection-service type=io.containerd.service.v1 Oct 22 23:09:39.462491 containerd[1994]: time="2026-10-22T23:09:39.462455740Z" level=info msg="loading plugin" id=io.containerd.service.v1.namespaces-service type=io.containerd.service.v1 Oct 22 23:09:39.462660 containerd[1994]: time="2026-10-22T23:09:39.462589380Z" level=info msg="loading plugin" id=io.containerd.service.v1.snapshots-service type=io.containerd.service.v1 Oct 22 23:09:39.462660 containerd[1994]: time="2026-10-22T23:09:39.462602940Z" level=info msg="loading plugin" id=io.containerd.shim.v1.manager type=io.containerd.shim.v1 Oct 22 23:09:39.462660 containerd[1994]: time="2026-10-22T23:09:39.462611916Z" level=info msg="loading plugin" id=io.containerd.runtime.v2.task type=io.containerd.runtime.v2 Oct 22 23:09:39.462881 containerd[1994]: time="2026-10-22T23:09:39.462848404Z" level=info msg="loading plugin" id=io.containerd.service.v1.tasks-service type=io.containerd.service.v1 Oct 22 23:09:39.462978 containerd[1994]: time="2026-10-22T23:09:39.462871564Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.containers type=io.containerd.grpc.v1 Oct 22 23:09:39.463018 containerd[1994]: time="2026-10-22T23:09:39.462956564Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.content type=io.containerd.grpc.v1 Oct 22 23:09:39.463062 containerd[1994]: time="2026-10-22T23:09:39.463051516Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.diff type=io.containerd.grpc.v1 Oct 22 23:09:39.463167 containerd[1994]: time="2026-10-22T23:09:39.463100244Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.events type=io.containerd.grpc.v1 Oct 22 23:09:39.463167 containerd[1994]: time="2026-10-22T23:09:39.463112492Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.images type=io.containerd.grpc.v1 Oct 22 23:09:39.463167 containerd[1994]: time="2026-10-22T23:09:39.463122260Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.introspection type=io.containerd.grpc.v1 Oct 22 23:09:39.463167 containerd[1994]: time="2026-10-22T23:09:39.463129604Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.leases type=io.containerd.grpc.v1 Oct 22 23:09:39.463167 containerd[1994]: time="2026-10-22T23:09:39.463136908Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.mounts type=io.containerd.grpc.v1 Oct 22 23:09:39.463167 containerd[1994]: time="2026-10-22T23:09:39.463142820Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.namespaces type=io.containerd.grpc.v1 Oct 22 23:09:39.463167 containerd[1994]: time="2026-10-22T23:09:39.463152644Z" level=info msg="loading plugin" id=io.containerd.sandbox.store.v1.local type=io.containerd.sandbox.store.v1 Oct 22 23:09:39.463355 containerd[1994]: time="2026-10-22T23:09:39.463279260Z" level=info msg="loading plugin" id=io.containerd.transfer.v1.local type=io.containerd.transfer.v1 Oct 22 23:09:39.463355 containerd[1994]: time="2026-10-22T23:09:39.463318556Z" level=info msg="loading plugin" id=io.containerd.cri.v1.images type=io.containerd.cri.v1 Oct 22 23:09:39.480378 containerd[1994]: time="2026-10-22T23:09:39.480337252Z" level=info msg="Get image filesystem path \"/var/lib/containerd/io.containerd.snapshotter.v1.overlayfs\" for snapshotter \"overlayfs\"" Oct 22 23:09:39.480551 containerd[1994]: time="2026-10-22T23:09:39.480462116Z" level=info msg="Start snapshots syncer" Oct 22 23:09:39.480551 containerd[1994]: time="2026-10-22T23:09:39.480492284Z" level=info msg="loading plugin" id=io.containerd.cri.v1.runtime type=io.containerd.cri.v1 Oct 22 23:09:39.481437 containerd[1994]: time="2026-10-22T23:09:39.481003412Z" 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 22 23:09:39.481437 containerd[1994]: time="2026-10-22T23:09:39.481060604Z" level=info msg="loading plugin" id=io.containerd.podsandbox.controller.v1.podsandbox type=io.containerd.podsandbox.controller.v1 Oct 22 23:09:39.481598 containerd[1994]: time="2026-10-22T23:09:39.481098092Z" level=info msg="loading plugin" id=io.containerd.sandbox.controller.v1.shim type=io.containerd.sandbox.controller.v1 Oct 22 23:09:39.481598 containerd[1994]: time="2026-10-22T23:09:39.481235092Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.sandbox-controllers type=io.containerd.grpc.v1 Oct 22 23:09:39.481598 containerd[1994]: time="2026-10-22T23:09:39.481251100Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.sandboxes type=io.containerd.grpc.v1 Oct 22 23:09:39.481598 containerd[1994]: time="2026-10-22T23:09:39.481258796Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.snapshots type=io.containerd.grpc.v1 Oct 22 23:09:39.481598 containerd[1994]: time="2026-10-22T23:09:39.481265980Z" level=info msg="loading plugin" id=io.containerd.streaming.v1.manager type=io.containerd.streaming.v1 Oct 22 23:09:39.481598 containerd[1994]: time="2026-10-22T23:09:39.481273516Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.streaming type=io.containerd.grpc.v1 Oct 22 23:09:39.481598 containerd[1994]: time="2026-10-22T23:09:39.481279932Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.tasks type=io.containerd.grpc.v1 Oct 22 23:09:39.481598 containerd[1994]: time="2026-10-22T23:09:39.481286468Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.transfer type=io.containerd.grpc.v1 Oct 22 23:09:39.481598 containerd[1994]: time="2026-10-22T23:09:39.481294204Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.version type=io.containerd.grpc.v1 Oct 22 23:09:39.481598 containerd[1994]: time="2026-10-22T23:09:39.481301004Z" level=info msg="loading plugin" id=io.containerd.monitor.container.v1.restart type=io.containerd.monitor.container.v1 Oct 22 23:09:39.481598 containerd[1994]: time="2026-10-22T23:09:39.481319484Z" level=info msg="loading plugin" id=io.containerd.tracing.processor.v1.otlp type=io.containerd.tracing.processor.v1 Oct 22 23:09:39.481598 containerd[1994]: time="2026-10-22T23:09:39.481333004Z" 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 22 23:09:39.481598 containerd[1994]: time="2026-10-22T23:09:39.481339204Z" level=info msg="loading plugin" id=io.containerd.internal.v1.tracing type=io.containerd.internal.v1 Oct 22 23:09:39.481742 containerd[1994]: time="2026-10-22T23:09:39.481345348Z" 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 22 23:09:39.481742 containerd[1994]: time="2026-10-22T23:09:39.481349820Z" level=info msg="loading plugin" id=io.containerd.ttrpc.v1.otelttrpc type=io.containerd.ttrpc.v1 Oct 22 23:09:39.481742 containerd[1994]: time="2026-10-22T23:09:39.481357308Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.healthcheck type=io.containerd.grpc.v1 Oct 22 23:09:39.481742 containerd[1994]: time="2026-10-22T23:09:39.481364940Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.cri type=io.containerd.grpc.v1 Oct 22 23:09:39.481742 containerd[1994]: time="2026-10-22T23:09:39.481373492Z" level=info msg="Connect containerd service" Oct 22 23:09:39.481742 containerd[1994]: time="2026-10-22T23:09:39.481389828Z" level=info msg="using experimental NRI integration - disable nri plugin to prevent this" Oct 22 23:09:39.483401 containerd[1994]: time="2026-10-22T23:09:39.483046940Z" 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 22 23:09:39.483799 waagent[2137]: 2026-10-22T23:09:39.483751Z INFO Daemon Daemon Provisioning complete Oct 22 23:09:39.494468 waagent[2137]: 2026-10-22T23:09:39.494424Z INFO Daemon Daemon RDMA capabilities are not enabled, skipping Oct 22 23:09:39.499348 waagent[2137]: 2026-10-22T23:09:39.499296Z INFO Daemon Daemon End of log to /dev/console. The agent will now check for updates and then will process extensions. Oct 22 23:09:39.507429 waagent[2137]: 2026-10-22T23:09:39.507389Z INFO Daemon Daemon Installed Agent WALinuxAgent-2.12.0.4 is the most current agent Oct 22 23:09:39.618157 waagent[2174]: 2026-10-22T23:09:39.618086Z INFO ExtHandler ExtHandler Azure Linux Agent (Goal State Agent version 2.12.0.4) Oct 22 23:09:39.618509 waagent[2174]: 2026-10-22T23:09:39.618228Z INFO ExtHandler ExtHandler OS: flatcar 4757.2.1 Oct 22 23:09:39.618509 waagent[2174]: 2026-10-22T23:09:39.618277Z INFO ExtHandler ExtHandler Python: 3.12.13 Oct 22 23:09:39.618509 waagent[2174]: 2026-10-22T23:09:39.618312Z INFO ExtHandler ExtHandler CPU Arch: aarch64 Oct 22 23:09:39.674997 waagent[2174]: 2026-10-22T23:09:39.674902Z INFO ExtHandler ExtHandler Distro: flatcar-4757.2.1; OSUtil: FlatcarUtil; AgentService: waagent; Python: 3.12.13; Arch: aarch64; systemd: True; LISDrivers: Absent; logrotate: logrotate 3.22.0; Oct 22 23:09:39.675161 waagent[2174]: 2026-10-22T23:09:39.675133Z INFO ExtHandler ExtHandler WireServer endpoint 168.63.129.16 read from file Oct 22 23:09:39.675215 waagent[2174]: 2026-10-22T23:09:39.675197Z INFO ExtHandler ExtHandler Wire server endpoint:168.63.129.16 Oct 22 23:09:39.680924 waagent[2174]: 2026-10-22T23:09:39.680706Z INFO ExtHandler Fetched a new incarnation for the WireServer goal state [incarnation 1] Oct 22 23:09:39.685157 waagent[2174]: 2026-10-22T23:09:39.685122Z INFO ExtHandler ExtHandler HostGAPlugin version: 1.0.8.189 Oct 22 23:09:39.685532 waagent[2174]: 2026-10-22T23:09:39.685497Z INFO ExtHandler Oct 22 23:09:39.685588 waagent[2174]: 2026-10-22T23:09:39.685569Z INFO ExtHandler Fetched new vmSettings [HostGAPlugin correlation ID: 4ac85210-21a3-4ad7-ad69-332d4587c109 eTag: 6246453161290053378 source: Fabric] Oct 22 23:09:39.685809 waagent[2174]: 2026-10-22T23:09:39.685783Z INFO ExtHandler The vmSettings originated via Fabric; will ignore them. Oct 22 23:09:39.686274 waagent[2174]: 2026-10-22T23:09:39.686244Z INFO ExtHandler Oct 22 23:09:39.686321 waagent[2174]: 2026-10-22T23:09:39.686304Z INFO ExtHandler Fetching full goal state from the WireServer [incarnation 1] Oct 22 23:09:39.688938 waagent[2174]: 2026-10-22T23:09:39.688911Z INFO ExtHandler ExtHandler Downloading artifacts profile blob Oct 22 23:09:39.740732 waagent[2174]: 2026-10-22T23:09:39.740665Z INFO ExtHandler Downloaded certificate {'thumbprint': '71143B961E87622B09CBB6099465CBB2A3DD4C88', 'hasPrivateKey': True} Oct 22 23:09:39.741127 waagent[2174]: 2026-10-22T23:09:39.741091Z INFO ExtHandler Fetch goal state completed Oct 22 23:09:39.750571 waagent[2174]: 2026-10-22T23:09:39.750524Z INFO ExtHandler ExtHandler OpenSSL version: OpenSSL 3.5.9 29 Sep 2026 (Library: OpenSSL 3.5.9 29 Sep 2026) Oct 22 23:09:39.757507 waagent[2174]: 2026-10-22T23:09:39.753772Z INFO ExtHandler ExtHandler WALinuxAgent-2.12.0.4 running as process 2174 Oct 22 23:09:39.757507 waagent[2174]: 2026-10-22T23:09:39.753888Z INFO ExtHandler ExtHandler ******** AutoUpdate.Enabled is set to False, not processing the operation ******** Oct 22 23:09:39.757507 waagent[2174]: 2026-10-22T23:09:39.754160Z INFO ExtHandler ExtHandler ******** AutoUpdate.UpdateToLatestVersion is set to False, not processing the operation ******** Oct 22 23:09:39.757507 waagent[2174]: 2026-10-22T23:09:39.756991Z INFO ExtHandler ExtHandler [CGI] Cgroup monitoring is not supported on ['flatcar', '4757.2.1', '', 'Flatcar Container Linux by Kinvolk'] Oct 22 23:09:39.757507 waagent[2174]: 2026-10-22T23:09:39.757338Z INFO ExtHandler ExtHandler [CGI] Agent will reset the quotas in case distro: ['flatcar', '4757.2.1', '', 'Flatcar Container Linux by Kinvolk'] went from supported to unsupported Oct 22 23:09:39.757507 waagent[2174]: 2026-10-22T23:09:39.757433Z INFO ExtHandler ExtHandler [CGI] Agent cgroups enabled: False Oct 22 23:09:39.757883 waagent[2174]: 2026-10-22T23:09:39.757844Z INFO ExtHandler ExtHandler Starting setup for Persistent firewall rules Oct 22 23:09:39.778533 waagent[2174]: 2026-10-22T23:09:39.778500Z INFO ExtHandler ExtHandler Firewalld service not running/unavailable, trying to set up waagent-network-setup.service Oct 22 23:09:39.778854 waagent[2174]: 2026-10-22T23:09:39.778820Z INFO ExtHandler ExtHandler Successfully updated the Binary file /var/lib/waagent/waagent-network-setup.py for firewall setup Oct 22 23:09:39.783154 waagent[2174]: 2026-10-22T23:09:39.783128Z INFO ExtHandler ExtHandler Service: waagent-network-setup.service not enabled. Adding it now Oct 22 23:09:39.788043 systemd[1]: Reload requested from client PID 2190 ('systemctl') (unit waagent.service)... Oct 22 23:09:39.788058 systemd[1]: Reloading... Oct 22 23:09:39.859992 zram_generator::config[2234]: No configuration found. Oct 22 23:09:40.091839 systemd[1]: Reloading finished in 303 ms. Oct 22 23:09:40.150181 waagent[2174]: 2026-10-22T23:09:40.150087Z INFO ExtHandler ExtHandler Successfully added and enabled the waagent-network-setup.service Oct 22 23:09:40.150264 waagent[2174]: 2026-10-22T23:09:40.150245Z INFO ExtHandler ExtHandler Persistent firewall rules setup successfully Oct 22 23:09:40.742773 login[2139]: pam_unix(login:session): session opened for user core(uid=500) by core(uid=0) Oct 22 23:09:40.742774 login[2140]: pam_unix(login:session): session opened for user core(uid=500) by core(uid=0) Oct 22 23:09:40.748898 systemd[1]: Created slice user-500.slice - User Slice of UID 500. Oct 22 23:09:40.754434 systemd[1]: Starting user-runtime-dir@500.service - User Runtime Directory /run/user/500... Oct 22 23:09:40.761465 systemd-logind[1967]: New session '1' of user 'core' with class 'user-light' and type 'tty'. Oct 22 23:09:40.764685 systemd-logind[1967]: New session '2' of user 'core' with class 'user-light' and type 'tty'. Oct 22 23:09:40.817464 systemd[1]: Finished user-runtime-dir@500.service - User Runtime Directory /run/user/500. Oct 22 23:09:40.832238 systemd[1]: Started session-1.scope - Session 1 of User core. Oct 22 23:09:40.837372 systemd[1]: Started session-2.scope - Session 2 of User core. Oct 22 23:09:41.194595 waagent[2174]: 2026-10-22T23:09:41.194507Z INFO ExtHandler ExtHandler DROP rule is not available which implies no firewall rules are set yet. Environment thread will set it up. Oct 22 23:09:41.195030 waagent[2174]: 2026-10-22T23:09:41.194839Z 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 22 23:09:41.195515 waagent[2174]: 2026-10-22T23:09:41.195472Z INFO ExtHandler ExtHandler Starting env monitor service. Oct 22 23:09:41.196050 waagent[2174]: 2026-10-22T23:09:41.195946Z INFO MonitorHandler ExtHandler WireServer endpoint 168.63.129.16 read from file Oct 22 23:09:41.196116 waagent[2174]: 2026-10-22T23:09:41.196093Z INFO MonitorHandler ExtHandler Wire server endpoint:168.63.129.16 Oct 22 23:09:41.196329 waagent[2174]: 2026-10-22T23:09:41.196287Z INFO MonitorHandler ExtHandler Monitor.NetworkConfigurationChanges is disabled. Oct 22 23:09:41.196473 waagent[2174]: 2026-10-22T23:09:41.196334Z INFO ExtHandler ExtHandler Start SendTelemetryHandler service. Oct 22 23:09:41.196473 waagent[2174]: 2026-10-22T23:09:41.196406Z INFO EnvHandler ExtHandler WireServer endpoint 168.63.129.16 read from file Oct 22 23:09:41.196863 waagent[2174]: 2026-10-22T23:09:41.196771Z INFO SendTelemetryHandler ExtHandler Successfully started the SendTelemetryHandler thread Oct 22 23:09:41.196976 waagent[2174]: 2026-10-22T23:09:41.196864Z INFO ExtHandler ExtHandler Start Extension Telemetry service. Oct 22 23:09:41.197013 waagent[2174]: 2026-10-22T23:09:41.196972Z INFO MonitorHandler ExtHandler Routing table from /proc/net/route: Oct 22 23:09:41.197013 waagent[2174]: Iface Destination Gateway Flags RefCnt Use Metric Mask MTU Window IRTT Oct 22 23:09:41.197013 waagent[2174]: eth0 00000000 0100000A 0003 0 0 1024 00000000 0 0 0 Oct 22 23:09:41.197013 waagent[2174]: eth0 0000000A 00000000 0001 0 0 1024 00FFFFFF 0 0 0 Oct 22 23:09:41.197013 waagent[2174]: eth0 0100000A 00000000 0005 0 0 1024 FFFFFFFF 0 0 0 Oct 22 23:09:41.197013 waagent[2174]: eth0 10813FA8 0100000A 0007 0 0 1024 FFFFFFFF 0 0 0 Oct 22 23:09:41.197013 waagent[2174]: eth0 FEA9FEA9 0100000A 0007 0 0 1024 FFFFFFFF 0 0 0 Oct 22 23:09:41.197338 waagent[2174]: 2026-10-22T23:09:41.197300Z INFO EnvHandler ExtHandler Wire server endpoint:168.63.129.16 Oct 22 23:09:41.197828 waagent[2174]: 2026-10-22T23:09:41.197788Z INFO EnvHandler ExtHandler Configure routes Oct 22 23:09:41.198071 waagent[2174]: 2026-10-22T23:09:41.198020Z INFO TelemetryEventsCollector ExtHandler Extension Telemetry pipeline enabled: True Oct 22 23:09:41.198138 waagent[2174]: 2026-10-22T23:09:41.198088Z INFO ExtHandler ExtHandler Goal State Period: 6 sec. This indicates how often the agent checks for new goal states and reports status. Oct 22 23:09:41.198408 waagent[2174]: 2026-10-22T23:09:41.198326Z INFO TelemetryEventsCollector ExtHandler Successfully started the TelemetryEventsCollector thread Oct 22 23:09:41.198851 waagent[2174]: 2026-10-22T23:09:41.198776Z INFO EnvHandler ExtHandler Gateway:None Oct 22 23:09:41.198988 waagent[2174]: 2026-10-22T23:09:41.198829Z INFO EnvHandler ExtHandler Routes:None Oct 22 23:09:41.203769 waagent[2174]: 2026-10-22T23:09:41.203559Z INFO ExtHandler ExtHandler Oct 22 23:09:41.203831 waagent[2174]: 2026-10-22T23:09:41.203805Z INFO ExtHandler ExtHandler ProcessExtensionsGoalState started [incarnation_1 channel: WireServer source: Fabric activity: af5c24b1-1790-4a9e-ab5a-7bb9b4638ba4 correlation eb160e10-7e96-4906-bb4a-fb5fcb3ddd02 created: 2026-10-22T23:08:21.117439Z] Oct 22 23:09:41.204547 waagent[2174]: 2026-10-22T23:09:41.204508Z INFO ExtHandler ExtHandler No extension handlers found, not processing anything. Oct 22 23:09:41.205674 waagent[2174]: 2026-10-22T23:09:41.205638Z INFO ExtHandler ExtHandler ProcessExtensionsGoalState completed [incarnation_1 2 ms] Oct 22 23:09:41.234863 waagent[2174]: 2026-10-22T23:09:41.234821Z INFO ExtHandler ExtHandler [HEARTBEAT] Agent WALinuxAgent-2.12.0.4 is running as the goal state agent [DEBUG HeartbeatCounter: 0;HeartbeatId: 98737EF7-F370-4B1A-983A-5D45FADDC031;DroppedPackets: 0;UpdateGSErrors: 0;AutoUpdate: 0;UpdateMode: SelfUpdate;] Oct 22 23:09:41.276297 waagent[2174]: 2026-10-22T23:09:41.276222Z INFO MonitorHandler ExtHandler Network interfaces: Oct 22 23:09:41.276297 waagent[2174]: Executing ['ip', '-a', '-o', 'link']: Oct 22 23:09:41.276297 waagent[2174]: 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 22 23:09:41.276297 waagent[2174]: 2: eth0: mtu 1500 qdisc mq state UP mode DEFAULT group default qlen 1000\ link/ether 7c:ed:8d:c0:7f:ba brd ff:ff:ff:ff:ff:ff\ altname enx7ced8dc07fba Oct 22 23:09:41.276297 waagent[2174]: 3: enP20488s1: mtu 1500 qdisc mq master eth0 state UP mode DEFAULT group default qlen 1000\ link/ether 7c:ed:8d:c0:7f:ba brd ff:ff:ff:ff:ff:ff\ altname enP20488p0s2 Oct 22 23:09:41.276297 waagent[2174]: Executing ['ip', '-4', '-a', '-o', 'address']: Oct 22 23:09:41.276297 waagent[2174]: 1: lo inet 127.0.0.1/8 scope host lo\ valid_lft forever preferred_lft forever Oct 22 23:09:41.276297 waagent[2174]: 2: eth0 inet 10.0.0.14/24 metric 1024 brd 10.0.0.255 scope global eth0\ valid_lft forever preferred_lft forever Oct 22 23:09:41.276297 waagent[2174]: Executing ['ip', '-6', '-a', '-o', 'address']: Oct 22 23:09:41.276297 waagent[2174]: 1: lo inet6 ::1/128 scope host noprefixroute \ valid_lft forever preferred_lft forever Oct 22 23:09:41.276297 waagent[2174]: 2: eth0 inet6 fe80::7eed:8dff:fec0:7fba/64 scope link proto kernel_ll \ valid_lft forever preferred_lft forever Oct 22 23:09:41.308212 waagent[2174]: 2026-10-22T23:09:41.308165Z INFO EnvHandler ExtHandler Created firewall rules for the Azure Fabric: Oct 22 23:09:41.308212 waagent[2174]: Chain INPUT (policy ACCEPT 0 packets, 0 bytes) Oct 22 23:09:41.308212 waagent[2174]: pkts bytes target prot opt in out source destination Oct 22 23:09:41.308212 waagent[2174]: Chain FORWARD (policy ACCEPT 0 packets, 0 bytes) Oct 22 23:09:41.308212 waagent[2174]: pkts bytes target prot opt in out source destination Oct 22 23:09:41.308212 waagent[2174]: Chain OUTPUT (policy ACCEPT 1 packets, 52 bytes) Oct 22 23:09:41.308212 waagent[2174]: pkts bytes target prot opt in out source destination Oct 22 23:09:41.308212 waagent[2174]: 0 0 ACCEPT tcp -- * * 0.0.0.0/0 168.63.129.16 tcp dpt:53 Oct 22 23:09:41.308212 waagent[2174]: 8 764 ACCEPT tcp -- * * 0.0.0.0/0 168.63.129.16 owner UID match 0 Oct 22 23:09:41.308212 waagent[2174]: 0 0 DROP tcp -- * * 0.0.0.0/0 168.63.129.16 ctstate INVALID,NEW Oct 22 23:09:41.310711 waagent[2174]: 2026-10-22T23:09:41.310662Z INFO EnvHandler ExtHandler Current Firewall rules: Oct 22 23:09:41.310711 waagent[2174]: Chain INPUT (policy ACCEPT 0 packets, 0 bytes) Oct 22 23:09:41.310711 waagent[2174]: pkts bytes target prot opt in out source destination Oct 22 23:09:41.310711 waagent[2174]: Chain FORWARD (policy ACCEPT 0 packets, 0 bytes) Oct 22 23:09:41.310711 waagent[2174]: pkts bytes target prot opt in out source destination Oct 22 23:09:41.310711 waagent[2174]: Chain OUTPUT (policy ACCEPT 1 packets, 52 bytes) Oct 22 23:09:41.310711 waagent[2174]: pkts bytes target prot opt in out source destination Oct 22 23:09:41.310711 waagent[2174]: 0 0 ACCEPT tcp -- * * 0.0.0.0/0 168.63.129.16 tcp dpt:53 Oct 22 23:09:41.310711 waagent[2174]: 13 1411 ACCEPT tcp -- * * 0.0.0.0/0 168.63.129.16 owner UID match 0 Oct 22 23:09:41.310711 waagent[2174]: 0 0 DROP tcp -- * * 0.0.0.0/0 168.63.129.16 ctstate INVALID,NEW Oct 22 23:09:41.310931 waagent[2174]: 2026-10-22T23:09:41.310904Z INFO EnvHandler ExtHandler Set block dev timeout: sda with timeout: 300 Oct 22 23:09:43.098359 containerd[1994]: time="2026-10-22T23:09:43.098296796Z" level=info msg="Start subscribing containerd event" Oct 22 23:09:43.098359 containerd[1994]: time="2026-10-22T23:09:43.098361492Z" level=info msg="Start recovering state" Oct 22 23:09:43.098721 containerd[1994]: time="2026-10-22T23:09:43.098446204Z" level=info msg="Start event monitor" Oct 22 23:09:43.098721 containerd[1994]: time="2026-10-22T23:09:43.098458044Z" level=info msg="Start cni network conf syncer for default" Oct 22 23:09:43.098721 containerd[1994]: time="2026-10-22T23:09:43.098463732Z" level=info msg="Start streaming server" Oct 22 23:09:43.098721 containerd[1994]: time="2026-10-22T23:09:43.098470132Z" level=info msg="Registered namespace \"k8s.io\" with NRI" Oct 22 23:09:43.098721 containerd[1994]: time="2026-10-22T23:09:43.098474932Z" level=info msg="runtime interface starting up..." Oct 22 23:09:43.098721 containerd[1994]: time="2026-10-22T23:09:43.098478260Z" level=info msg="starting plugins..." Oct 22 23:09:43.098721 containerd[1994]: time="2026-10-22T23:09:43.098489076Z" level=info msg="Synchronizing NRI (plugin) with current runtime state" Oct 22 23:09:43.114615 containerd[1994]: time="2026-10-22T23:09:43.113937300Z" level=info msg=serving... address=/run/containerd/containerd.sock.ttrpc Oct 22 23:09:43.114615 containerd[1994]: time="2026-10-22T23:09:43.114009732Z" level=info msg=serving... address=/run/containerd/containerd.sock Oct 22 23:09:43.132701 containerd[1994]: time="2026-10-22T23:09:43.132665956Z" level=info msg="containerd successfully booted in 3.755356s" Oct 22 23:09:43.134084 systemd[1]: Started containerd.service - containerd container runtime. Oct 22 23:09:43.143718 systemd[1]: Reached target multi-user.target - Multi-User System. Oct 22 23:09:43.152027 systemd[1]: Startup finished in 3.256s (kernel) + 15.923s (initrd) + 37.512s (userspace) = 56.692s. Oct 22 23:09:57.463175 chronyd[1947]: Selected source PHC0 Oct 22 23:10:10.007282 systemd[1]: Created slice system-sshd.slice - Slice /system/sshd. Oct 22 23:10:10.008731 systemd[1]: Started sshd@0-1-10.0.0.14:22-20.31.226.197:40528.service - OpenSSH per-connection server daemon (20.31.226.197:40528). Oct 22 23:10:10.985381 sshd[2376]: Accepted publickey for core from 20.31.226.197 port 40528 ssh2: RSA SHA256:mxHc9hXVEylf6/WOffxFZjahAcZLbHFJRIQUinwYGg8 Oct 22 23:10:10.986538 sshd-session[2376]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Oct 22 23:10:10.992801 systemd-logind[1967]: New session '3' of user 'core' with class 'user' and type 'tty'. Oct 22 23:10:11.005126 systemd[1]: Starting user@500.service - User Manager for UID 500... Oct 22 23:10:11.013300 (systemd)[2380]: pam_unix(systemd-user:session): session opened for user core(uid=500) by core(uid=0) Oct 22 23:10:11.015762 systemd-logind[1967]: New session '4' of user 'core' with class 'manager-early' and type 'unspecified'. Oct 22 23:10:11.225627 systemd[2380]: Queued start job for default target default.target. Oct 22 23:10:11.233942 systemd[2380]: Created slice app.slice - User Application Slice. Oct 22 23:10:11.234062 systemd[2380]: Started systemd-tmpfiles-clean.timer - Daily Cleanup of User's Temporary Directories. Oct 22 23:10:11.234074 systemd[2380]: Reached target machines.target - Virtual Machines and Containers. Oct 22 23:10:11.234120 systemd[2380]: Reached target paths.target - Paths. Oct 22 23:10:11.234138 systemd[2380]: Reached target timers.target - Timers. Oct 22 23:10:11.235126 systemd[2380]: Starting dbus.socket - D-Bus User Message Bus Socket... Oct 22 23:10:11.236256 systemd[2380]: Listening on systemd-ask-password.socket - Query the User Interactively for a Password. Oct 22 23:10:11.236385 systemd[2380]: Listening on systemd-importd.socket - Disk Image Download Service Socket. Oct 22 23:10:11.237028 systemd[2380]: Listening on systemd-journalctl.socket - Journal Log Access Socket. Oct 22 23:10:11.237188 systemd[2380]: Listening on systemd-machined.socket - Virtual Machine and Container Registration Service Socket. Oct 22 23:10:11.240114 systemd[2380]: Starting systemd-tmpfiles-setup.service - Create User Files and Directories... Oct 22 23:10:11.245105 systemd[2380]: Listening on dbus.socket - D-Bus User Message Bus Socket. Oct 22 23:10:11.245158 systemd[2380]: Reached target sockets.target - Sockets. Oct 22 23:10:11.249277 systemd[2380]: Finished systemd-tmpfiles-setup.service - Create User Files and Directories. Oct 22 23:10:11.249660 systemd[2380]: Reached target basic.target - Basic System. Oct 22 23:10:11.249940 systemd[1]: Started user@500.service - User Manager for UID 500. Oct 22 23:10:11.250226 systemd[2380]: Reached target default.target - Main User Target. Oct 22 23:10:11.250339 systemd[2380]: Startup finished in 229ms. Oct 22 23:10:11.253170 systemd[1]: Started session-3.scope - Session 3 of User core. Oct 22 23:10:11.692749 systemd[1]: Started sshd@1-2-10.0.0.14:22-20.31.226.197:40530.service - OpenSSH per-connection server daemon (20.31.226.197:40530). Oct 22 23:10:12.449695 sshd[2394]: Accepted publickey for core from 20.31.226.197 port 40530 ssh2: RSA SHA256:mxHc9hXVEylf6/WOffxFZjahAcZLbHFJRIQUinwYGg8 Oct 22 23:10:12.450797 sshd-session[2394]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Oct 22 23:10:12.454512 systemd-logind[1967]: New session '5' of user 'core' with class 'user' and type 'tty'. Oct 22 23:10:12.465101 systemd[1]: Started session-5.scope - Session 5 of User core. Oct 22 23:10:12.885986 sshd[2398]: Connection closed by 20.31.226.197 port 40530 Oct 22 23:10:12.886740 sshd-session[2394]: pam_unix(sshd:session): session closed for user core Oct 22 23:10:12.890416 systemd[1]: sshd@1-2-10.0.0.14:22-20.31.226.197:40530.service: Deactivated successfully. Oct 22 23:10:12.892452 systemd[1]: session-5.scope: Deactivated successfully. Oct 22 23:10:12.893451 systemd-logind[1967]: Session 5 logged out. Waiting for processes to exit. Oct 22 23:10:12.895095 systemd-logind[1967]: Removed session 5. Oct 22 23:10:13.025222 systemd[1]: Started sshd@2-3-10.0.0.14:22-20.31.226.197:40532.service - OpenSSH per-connection server daemon (20.31.226.197:40532). Oct 22 23:10:13.744999 sshd[2404]: Accepted publickey for core from 20.31.226.197 port 40532 ssh2: RSA SHA256:mxHc9hXVEylf6/WOffxFZjahAcZLbHFJRIQUinwYGg8 Oct 22 23:10:13.746082 sshd-session[2404]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Oct 22 23:10:13.750231 systemd-logind[1967]: New session '6' of user 'core' with class 'user' and type 'tty'. Oct 22 23:10:13.758201 systemd[1]: Started session-6.scope - Session 6 of User core. Oct 22 23:10:14.154253 sshd[2408]: Connection closed by 20.31.226.197 port 40532 Oct 22 23:10:14.154795 sshd-session[2404]: pam_unix(sshd:session): session closed for user core Oct 22 23:10:14.157747 systemd[1]: sshd@2-3-10.0.0.14:22-20.31.226.197:40532.service: Deactivated successfully. Oct 22 23:10:14.159622 systemd[1]: session-6.scope: Deactivated successfully. Oct 22 23:10:14.160571 systemd-logind[1967]: Session 6 logged out. Waiting for processes to exit. Oct 22 23:10:14.161828 systemd-logind[1967]: Removed session 6. Oct 22 23:10:14.301761 systemd[1]: Started sshd@3-4097-10.0.0.14:22-20.31.226.197:40548.service - OpenSSH per-connection server daemon (20.31.226.197:40548). Oct 22 23:10:14.543162 kernel: hv_balloon: Max. dynamic memory size: 4096 MB Oct 22 23:10:15.020701 sshd[2414]: Accepted publickey for core from 20.31.226.197 port 40548 ssh2: RSA SHA256:mxHc9hXVEylf6/WOffxFZjahAcZLbHFJRIQUinwYGg8 Oct 22 23:10:15.021803 sshd-session[2414]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Oct 22 23:10:15.026205 systemd-logind[1967]: New session '7' of user 'core' with class 'user' and type 'tty'. Oct 22 23:10:15.032110 systemd[1]: Started session-7.scope - Session 7 of User core. Oct 22 23:10:15.433018 sshd[2418]: Connection closed by 20.31.226.197 port 40548 Oct 22 23:10:15.433614 sshd-session[2414]: pam_unix(sshd:session): session closed for user core Oct 22 23:10:15.436230 systemd[1]: sshd@3-4097-10.0.0.14:22-20.31.226.197:40548.service: Deactivated successfully. Oct 22 23:10:15.437823 systemd[1]: session-7.scope: Deactivated successfully. Oct 22 23:10:15.438532 systemd-logind[1967]: Session 7 logged out. Waiting for processes to exit. Oct 22 23:10:15.439636 systemd-logind[1967]: Removed session 7. Oct 22 23:10:15.597115 systemd[1]: Started sshd@4-4098-10.0.0.14:22-20.31.226.197:40554.service - OpenSSH per-connection server daemon (20.31.226.197:40554). Oct 22 23:10:16.356034 sshd[2424]: Accepted publickey for core from 20.31.226.197 port 40554 ssh2: RSA SHA256:mxHc9hXVEylf6/WOffxFZjahAcZLbHFJRIQUinwYGg8 Oct 22 23:10:16.357571 sshd-session[2424]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Oct 22 23:10:16.361496 systemd-logind[1967]: New session '8' of user 'core' with class 'user' and type 'tty'. Oct 22 23:10:16.371096 systemd[1]: Started session-8.scope - Session 8 of User core. Oct 22 23:10:16.802623 sudo[2429]: core : PWD=/home/core ; USER=root ; COMMAND=/usr/sbin/setenforce 1 Oct 22 23:10:16.803297 sudo[2429]: pam_unix(sudo:session): session opened for user root(uid=0) by core(uid=500) Oct 22 23:10:16.815678 sudo[2429]: pam_unix(sudo:session): session closed for user root Oct 22 23:10:16.960402 sshd[2428]: Connection closed by 20.31.226.197 port 40554 Oct 22 23:10:16.961416 sshd-session[2424]: pam_unix(sshd:session): session closed for user core Oct 22 23:10:16.965277 systemd[1]: sshd@4-4098-10.0.0.14:22-20.31.226.197:40554.service: Deactivated successfully. Oct 22 23:10:16.967601 systemd[1]: session-8.scope: Deactivated successfully. Oct 22 23:10:16.969256 systemd-logind[1967]: Session 8 logged out. Waiting for processes to exit. Oct 22 23:10:16.970101 systemd-logind[1967]: Removed session 8. Oct 22 23:10:17.113212 systemd[1]: Started sshd@5-4099-10.0.0.14:22-20.31.226.197:40564.service - OpenSSH per-connection server daemon (20.31.226.197:40564). Oct 22 23:10:17.866505 sshd[2436]: Accepted publickey for core from 20.31.226.197 port 40564 ssh2: RSA SHA256:mxHc9hXVEylf6/WOffxFZjahAcZLbHFJRIQUinwYGg8 Oct 22 23:10:17.867641 sshd-session[2436]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Oct 22 23:10:17.871340 systemd-logind[1967]: New session '9' of user 'core' with class 'user' and type 'tty'. Oct 22 23:10:17.883102 systemd[1]: Started session-9.scope - Session 9 of User core. Oct 22 23:10:18.159160 sudo[2442]: 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 22 23:10:18.159383 sudo[2442]: pam_unix(sudo:session): session opened for user root(uid=0) by core(uid=500) Oct 22 23:10:18.160649 sudo[2442]: pam_unix(sudo:session): session closed for user root Oct 22 23:10:18.165699 sudo[2441]: core : PWD=/home/core ; USER=root ; COMMAND=/usr/sbin/systemctl restart audit-rules Oct 22 23:10:18.165891 sudo[2441]: pam_unix(sudo:session): session opened for user root(uid=0) by core(uid=500) Oct 22 23:10:18.171129 systemd[1]: Starting audit-rules.service - Load Audit Rules... Oct 22 23:10:18.218000 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 22 23:10:18.232127 kernel: kauditd_printk_skb: 83 callbacks suppressed Oct 22 23:10:18.232177 kernel: audit: type=1305 audit(1792710618.218:180): auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 op=remove_rule key=(null) list=5 res=1 Oct 22 23:10:18.218000 audit[2466]: SYSCALL arch=c00000b7 syscall=206 success=yes exit=1056 a0=3 a1=ffffe3e1fc50 a2=420 a3=0 items=0 ppid=2447 pid=2466 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 22 23:10:18.240522 augenrules[2466]: No rules Oct 22 23:10:18.257005 kernel: audit: type=1300 audit(1792710618.218:180): arch=c00000b7 syscall=206 success=yes exit=1056 a0=3 a1=ffffe3e1fc50 a2=420 a3=0 items=0 ppid=2447 pid=2466 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 22 23:10:18.257343 systemd[1]: audit-rules.service: Deactivated successfully. Oct 22 23:10:18.257560 systemd[1]: Finished audit-rules.service - Load Audit Rules. Oct 22 23:10:18.258438 sudo[2441]: pam_unix(sudo:session): session closed for user root Oct 22 23:10:18.218000 audit: PROCTITLE proctitle=2F7362696E2F617564697463746C002D52002F6574632F61756469742F61756469742E72756C6573 Oct 22 23:10:18.256000 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 22 23:10:18.266396 kernel: audit: type=1327 audit(1792710618.218:180): proctitle=2F7362696E2F617564697463746C002D52002F6574632F61756469742F61756469742E72756C6573 Oct 22 23:10:18.266431 kernel: audit: type=1130 audit(1792710618.256:181): 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 22 23:10:18.256000 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 22 23:10:18.290370 kernel: audit: type=1131 audit(1792710618.256:182): 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 22 23:10:18.257000 audit[2441]: AUDIT1106 pid=2441 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 22 23:10:18.304124 kernel: audit: type=1106 audit(1792710618.257:183): pid=2441 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 22 23:10:18.257000 audit[2441]: AUDIT1104 pid=2441 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 22 23:10:18.304268 kernel: audit: type=1104 audit(1792710618.257:184): pid=2441 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 22 23:10:18.410420 sshd[2440]: Connection closed by 20.31.226.197 port 40564 Oct 22 23:10:18.410223 sshd-session[2436]: pam_unix(sshd:session): session closed for user core Oct 22 23:10:18.410000 audit[2436]: AUDIT1106 pid=2436 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 22 23:10:18.414260 systemd[1]: session-9.scope: Deactivated successfully. Oct 22 23:10:18.416541 systemd[1]: sshd@5-4099-10.0.0.14:22-20.31.226.197:40564.service: Deactivated successfully. Oct 22 23:10:18.410000 audit[2436]: AUDIT1104 pid=2436 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 22 23:10:18.445506 kernel: audit: type=1106 audit(1792710618.410:185): pid=2436 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 22 23:10:18.445578 kernel: audit: type=1104 audit(1792710618.410:186): pid=2436 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 22 23:10:18.446134 systemd-logind[1967]: Session 9 logged out. Waiting for processes to exit. Oct 22 23:10:18.415000 audit[1]: SERVICE_STOP pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=sshd@5-4099-10.0.0.14:22-20.31.226.197:40564 comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Oct 22 23:10:18.459737 kernel: audit: type=1131 audit(1792710618.415:187): pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=sshd@5-4099-10.0.0.14:22-20.31.226.197:40564 comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Oct 22 23:10:18.460544 systemd-logind[1967]: Removed session 9. Oct 22 23:10:18.556985 systemd[1]: Started sshd@6-4-10.0.0.14:22-20.31.226.197:40568.service - OpenSSH per-connection server daemon (20.31.226.197:40568). Oct 22 23:10:18.556000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=sshd@6-4-10.0.0.14:22-20.31.226.197:40568 comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Oct 22 23:10:19.273000 audit[2475]: AUDIT1101 pid=2475 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 22 23:10:19.274825 sshd[2475]: Accepted publickey for core from 20.31.226.197 port 40568 ssh2: RSA SHA256:mxHc9hXVEylf6/WOffxFZjahAcZLbHFJRIQUinwYGg8 Oct 22 23:10:19.274000 audit[2475]: AUDIT1103 pid=2475 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 22 23:10:19.274000 audit[2475]: SYSCALL arch=c00000b7 syscall=64 success=yes exit=3 a0=8 a1=ffffd7eecdf0 a2=3 a3=0 items=0 ppid=1 pid=2475 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 22 23:10:19.274000 audit: PROCTITLE proctitle=737368642D73657373696F6E3A20636F7265205B707269765D Oct 22 23:10:19.276243 sshd-session[2475]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Oct 22 23:10:19.281535 systemd-logind[1967]: New session '10' of user 'core' with class 'user' and type 'tty'. Oct 22 23:10:19.288112 systemd[1]: Started session-10.scope - Session 10 of User core. Oct 22 23:10:19.290000 audit[2475]: AUDIT1105 pid=2475 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 22 23:10:19.291000 audit[2479]: AUDIT1103 pid=2479 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 22 23:10:19.464347 update_engine[1971]: I20261022 23:10:19.464258 1971 update_attempter.cc:509] Updating boot flags... Oct 22 23:10:19.687185 sshd[2479]: Connection closed by 20.31.226.197 port 40568 Oct 22 23:10:19.687128 sshd-session[2475]: pam_unix(sshd:session): session closed for user core Oct 22 23:10:19.686000 audit[2475]: AUDIT1106 pid=2475 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 22 23:10:19.687000 audit[2475]: AUDIT1104 pid=2475 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 22 23:10:19.691243 systemd[1]: sshd@6-4-10.0.0.14:22-20.31.226.197:40568.service: Deactivated successfully. Oct 22 23:10:19.690000 audit[1]: SERVICE_STOP pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=sshd@6-4-10.0.0.14:22-20.31.226.197:40568 comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Oct 22 23:10:19.692817 systemd[1]: session-10.scope: Deactivated successfully. Oct 22 23:10:19.694226 systemd-logind[1967]: Session 10 logged out. Waiting for processes to exit. Oct 22 23:10:19.695188 systemd-logind[1967]: Removed session 10.