Sep 4 00:07:43.021784 kernel: Booting Linux on physical CPU 0x0000000000 [0x410fd490] Sep 4 00:07:43.021815 kernel: Linux version 6.12.108-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 Sep 3 22:25:37 -00 2026 Sep 4 00:07:43.021823 kernel: KASLR enabled Sep 4 00:07:43.021828 kernel: earlycon: pl11 at MMIO 0x00000000effec000 (options '') Sep 4 00:07:43.021832 kernel: printk: legacy bootconsole [pl11] enabled Sep 4 00:07:43.021837 kernel: efi: EFI v2.7 by EDK II Sep 4 00:07:43.021844 kernel: efi: ACPI 2.0=0x3f979018 SMBIOS=0x3f8a0000 SMBIOS 3.0=0x3f880000 MEMATTR=0x3e89c018 RNG=0x3f979998 MEMRESERVE=0x3db7b718 Sep 4 00:07:43.021850 kernel: random: crng init done Sep 4 00:07:43.021855 kernel: secureboot: Secure boot disabled Sep 4 00:07:43.021860 kernel: ACPI: Early table checksum verification disabled Sep 4 00:07:43.021865 kernel: ACPI: RSDP 0x000000003F979018 000024 (v02 VRTUAL) Sep 4 00:07:43.021870 kernel: ACPI: XSDT 0x000000003F979F18 00006C (v01 VRTUAL MICROSFT 00000001 MSFT 00000001) Sep 4 00:07:43.021876 kernel: ACPI: FACP 0x000000003F979C18 000114 (v06 VRTUAL MICROSFT 00000001 MSFT 00000001) Sep 4 00:07:43.021880 kernel: ACPI: DSDT 0x000000003F95A018 01E046 (v02 MSFTVM DSDT01 00000001 INTL 20230628) Sep 4 00:07:43.021886 kernel: ACPI: DBG2 0x000000003F979B18 000072 (v00 VRTUAL MICROSFT 00000001 MSFT 00000001) Sep 4 00:07:43.021892 kernel: ACPI: GTDT 0x000000003F979D98 000060 (v02 VRTUAL MICROSFT 00000001 MSFT 00000001) Sep 4 00:07:43.021897 kernel: ACPI: OEM0 0x000000003F979098 000064 (v01 VRTUAL MICROSFT 00000001 MSFT 00000001) Sep 4 00:07:43.021902 kernel: ACPI: SPCR 0x000000003F979A98 000050 (v02 VRTUAL MICROSFT 00000001 MSFT 00000001) Sep 4 00:07:43.021907 kernel: ACPI: APIC 0x000000003F979818 0000FC (v04 VRTUAL MICROSFT 00000001 MSFT 00000001) Sep 4 00:07:43.021913 kernel: ACPI: SRAT 0x000000003F979198 000234 (v03 VRTUAL MICROSFT 00000001 MSFT 00000001) Sep 4 00:07:43.021920 kernel: ACPI: PPTT 0x000000003F979418 000120 (v01 VRTUAL MICROSFT 00000000 MSFT 00000000) Sep 4 00:07:43.021925 kernel: ACPI: BGRT 0x000000003F979E98 000038 (v01 VRTUAL MICROSFT 00000001 MSFT 00000001) Sep 4 00:07:43.021929 kernel: ACPI: SPCR: console: pl011,mmio32,0xeffec000,115200 Sep 4 00:07:43.021933 kernel: ACPI: Use ACPI SPCR as default console: Yes Sep 4 00:07:43.021938 kernel: ACPI: SRAT: Node 0 PXM 0 [mem 0x00000000-0x3fffffff] hotplug Sep 4 00:07:43.021943 kernel: ACPI: SRAT: Node 0 PXM 0 [mem 0x100000000-0x1bfffffff] hotplug Sep 4 00:07:43.021949 kernel: ACPI: SRAT: Node 0 PXM 0 [mem 0x1c0000000-0xfbfffffff] hotplug Sep 4 00:07:43.021955 kernel: ACPI: SRAT: Node 0 PXM 0 [mem 0x1000000000-0xffffffffff] hotplug Sep 4 00:07:43.021960 kernel: ACPI: SRAT: Node 0 PXM 0 [mem 0x10000000000-0x1ffffffffff] hotplug Sep 4 00:07:43.021966 kernel: ACPI: SRAT: Node 0 PXM 0 [mem 0x20000000000-0x3ffffffffff] hotplug Sep 4 00:07:43.021972 kernel: ACPI: SRAT: Node 0 PXM 0 [mem 0x40000000000-0x7ffffffffff] hotplug Sep 4 00:07:43.021977 kernel: ACPI: SRAT: Node 0 PXM 0 [mem 0x80000000000-0xfffffffffff] hotplug Sep 4 00:07:43.021982 kernel: ACPI: SRAT: Node 0 PXM 0 [mem 0x100000000000-0x1fffffffffff] hotplug Sep 4 00:07:43.021988 kernel: ACPI: SRAT: Node 0 PXM 0 [mem 0x200000000000-0x3fffffffffff] hotplug Sep 4 00:07:43.021993 kernel: ACPI: SRAT: Node 0 PXM 0 [mem 0x400000000000-0x7fffffffffff] hotplug Sep 4 00:07:43.021997 kernel: ACPI: SRAT: Node 0 PXM 0 [mem 0x800000000000-0xffffffffffff] hotplug Sep 4 00:07:43.022001 kernel: NUMA: Node 0 [mem 0x00000000-0x3fffffff] + [mem 0x100000000-0x1bfffffff] -> [mem 0x00000000-0x1bfffffff] Sep 4 00:07:43.022007 kernel: NODE_DATA(0) allocated [mem 0x1bf800a00-0x1bf807fff] Sep 4 00:07:43.022013 kernel: Zone ranges: Sep 4 00:07:43.022017 kernel: DMA [mem 0x0000000000000000-0x00000000ffffffff] Sep 4 00:07:43.022026 kernel: DMA32 empty Sep 4 00:07:43.022030 kernel: Normal [mem 0x0000000100000000-0x00000001bfffffff] Sep 4 00:07:43.022035 kernel: Device empty Sep 4 00:07:43.022039 kernel: Movable zone start for each node Sep 4 00:07:43.022044 kernel: Early memory node ranges Sep 4 00:07:43.022049 kernel: node 0: [mem 0x0000000000000000-0x00000000007fffff] Sep 4 00:07:43.022055 kernel: node 0: [mem 0x0000000000824000-0x000000003f38ffff] Sep 4 00:07:43.022060 kernel: node 0: [mem 0x000000003f390000-0x000000003f93ffff] Sep 4 00:07:43.022064 kernel: node 0: [mem 0x000000003f940000-0x000000003f9effff] Sep 4 00:07:43.022069 kernel: node 0: [mem 0x000000003f9f0000-0x000000003fdeffff] Sep 4 00:07:43.022073 kernel: node 0: [mem 0x000000003fdf0000-0x000000003fffffff] Sep 4 00:07:43.022079 kernel: node 0: [mem 0x0000000100000000-0x00000001bfffffff] Sep 4 00:07:43.022085 kernel: Initmem setup node 0 [mem 0x0000000000000000-0x00000001bfffffff] Sep 4 00:07:43.022089 kernel: On node 0, zone DMA: 36 pages in unavailable ranges Sep 4 00:07:43.022095 kernel: cma: Reserved 16 MiB at 0x000000003ca00000 on node -1 Sep 4 00:07:43.022100 kernel: psci: probing for conduit method from ACPI. Sep 4 00:07:43.022106 kernel: psci: PSCIv1.3 detected in firmware. Sep 4 00:07:43.022112 kernel: psci: Using standard PSCI v0.2 function IDs Sep 4 00:07:43.022118 kernel: psci: MIGRATE_INFO_TYPE not supported. Sep 4 00:07:43.022122 kernel: psci: SMC Calling Convention v1.4 Sep 4 00:07:43.022128 kernel: ACPI: NUMA: SRAT: PXM 0 -> MPIDR 0x0 -> Node 0 Sep 4 00:07:43.022134 kernel: ACPI: NUMA: SRAT: PXM 0 -> MPIDR 0x1 -> Node 0 Sep 4 00:07:43.022140 kernel: percpu: Embedded 34 pages/cpu s98904 r8192 d32168 u139264 Sep 4 00:07:43.022144 kernel: pcpu-alloc: s98904 r8192 d32168 u139264 alloc=34*4096 Sep 4 00:07:43.022149 kernel: pcpu-alloc: [0] 0 [0] 1 Sep 4 00:07:43.022153 kernel: Detected PIPT I-cache on CPU0 Sep 4 00:07:43.022158 kernel: CPU features: detected: Address authentication (architected QARMA5 algorithm) Sep 4 00:07:43.022163 kernel: CPU features: detected: GIC system register CPU interface Sep 4 00:07:43.022169 kernel: CPU features: detected: Spectre-v4 Sep 4 00:07:43.022174 kernel: CPU features: detected: Spectre-BHB Sep 4 00:07:43.022178 kernel: CPU features: kernel page table isolation forced ON by KASLR Sep 4 00:07:43.022184 kernel: CPU features: detected: Kernel page table isolation (KPTI) Sep 4 00:07:43.022190 kernel: CPU features: detected: ARM erratum 2067961 or 2054223 Sep 4 00:07:43.022195 kernel: CPU features: detected: Broken broadcast TLBI completion Sep 4 00:07:43.022199 kernel: CPU features: detected: SSBS not fully self-synchronizing Sep 4 00:07:43.022205 kernel: alternatives: applying boot alternatives Sep 4 00:07:43.022212 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=bcfe44ce4b0956179a040e182aa390fdc12a5258aaf209e6524a34a7042177eb Sep 4 00:07:43.022218 kernel: Dentry cache hash table entries: 524288 (order: 10, 4194304 bytes, linear) Sep 4 00:07:43.022222 kernel: Inode-cache hash table entries: 262144 (order: 9, 2097152 bytes, linear) Sep 4 00:07:43.022242 kernel: Fallback order for Node 0: 0 Sep 4 00:07:43.022248 kernel: Built 1 zonelists, mobility grouping on. Total pages: 1048540 Sep 4 00:07:43.022253 kernel: Policy zone: Normal Sep 4 00:07:43.022257 kernel: mem auto-init: stack:off, heap alloc:off, heap free:off Sep 4 00:07:43.022262 kernel: software IO TLB: area num 2. Sep 4 00:07:43.022266 kernel: software IO TLB: mapped [mem 0x0000000034b00000-0x0000000038b00000] (64MB) Sep 4 00:07:43.022271 kernel: SLUB: HWalign=64, Order=0-3, MinObjects=0, CPUs=2, Nodes=1 Sep 4 00:07:43.022275 kernel: ftrace: allocating 41357 entries in 162 pages Sep 4 00:07:43.022282 kernel: ftrace: allocated 162 pages with 3 groups Sep 4 00:07:43.022288 kernel: rcu: Preemptible hierarchical RCU implementation. Sep 4 00:07:43.022294 kernel: rcu: RCU event tracing is enabled. Sep 4 00:07:43.022300 kernel: rcu: RCU restricting CPUs from NR_CPUS=512 to nr_cpu_ids=2. Sep 4 00:07:43.022306 kernel: Trampoline variant of Tasks RCU enabled. Sep 4 00:07:43.022310 kernel: Rude variant of Tasks RCU enabled. Sep 4 00:07:43.022315 kernel: Tracing variant of Tasks RCU enabled. Sep 4 00:07:43.022319 kernel: rcu: RCU calculated value of scheduler-enlistment delay is 100 jiffies. Sep 4 00:07:43.022324 kernel: rcu: Adjusting geometry for rcu_fanout_leaf=16, nr_cpu_ids=2 Sep 4 00:07:43.022329 kernel: RCU Tasks: Setting shift to 1 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=2. Sep 4 00:07:43.022334 kernel: RCU Tasks Rude: Setting shift to 1 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=2. Sep 4 00:07:43.022339 kernel: RCU Tasks Trace: Setting shift to 1 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=2. Sep 4 00:07:43.022344 kernel: NR_IRQS: 64, nr_irqs: 64, preallocated irqs: 0 Sep 4 00:07:43.022350 kernel: GICv3: 960 SPIs implemented Sep 4 00:07:43.022355 kernel: GICv3: 0 Extended SPIs implemented Sep 4 00:07:43.022359 kernel: Root IRQ handler: gic_handle_irq Sep 4 00:07:43.022365 kernel: GICv3: GICv3 features: 16 PPIs, RSS Sep 4 00:07:43.022370 kernel: GICv3: GICD_CTRL.DS=0, SCR_EL3.FIQ=0 Sep 4 00:07:43.022375 kernel: GICv3: CPU0: found redistributor 0 region 0:0x00000000effee000 Sep 4 00:07:43.022379 kernel: ITS: No ITS available, not enabling LPIs Sep 4 00:07:43.022384 kernel: rcu: srcu_init: Setting srcu_struct sizes based on contention. Sep 4 00:07:43.022388 kernel: clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1911260446275000 ns Sep 4 00:07:43.022394 kernel: arch_timer: cp15 timer(s) running at 1000.00MHz (virt). Sep 4 00:07:43.022400 kernel: clocksource: arch_sys_counter: mask: 0x1fffffffffffffff max_cycles: 0x1cd42e4dffb, max_idle_ns: 881590591483 ns Sep 4 00:07:43.022404 kernel: sched_clock: 61 bits at 1000MHz, resolution 1ns, wraps every 4398046511103ns Sep 4 00:07:43.022409 kernel: Console: colour dummy device 80x25 Sep 4 00:07:43.022414 kernel: printk: legacy console [tty1] enabled Sep 4 00:07:43.022419 kernel: ACPI: Core revision 20240827 Sep 4 00:07:43.022424 kernel: Calibrating delay loop (skipped), value calculated using timer frequency.. 2000.00 BogoMIPS (lpj=1000000) Sep 4 00:07:43.022429 kernel: pid_max: default: 32768 minimum: 301 Sep 4 00:07:43.022434 kernel: LSM: initializing lsm=lockdown,capability,landlock,selinux,ima Sep 4 00:07:43.022444 kernel: landlock: Up and running. Sep 4 00:07:43.022449 kernel: SELinux: Initializing. Sep 4 00:07:43.022455 kernel: Mount-cache hash table entries: 8192 (order: 4, 65536 bytes, linear) Sep 4 00:07:43.022460 kernel: Mountpoint-cache hash table entries: 8192 (order: 4, 65536 bytes, linear) Sep 4 00:07:43.022465 kernel: Hyper-V: privilege flags low 0x2e7f, high 0x3b8030, hints 0xa0000e, misc 0x31e1 Sep 4 00:07:43.022470 kernel: Hyper-V: Host Build 10.0.26102.1405-1-0 Sep 4 00:07:43.022475 kernel: Hyper-V: enabling crash_kexec_post_notifiers Sep 4 00:07:43.022481 kernel: rcu: Hierarchical SRCU implementation. Sep 4 00:07:43.022486 kernel: rcu: Max phase no-delay instances is 400. Sep 4 00:07:43.022491 kernel: Timer migration: 1 hierarchy levels; 8 children per group; 1 crossnode level Sep 4 00:07:43.022496 kernel: Remapping and enabling EFI services. Sep 4 00:07:43.022501 kernel: smp: Bringing up secondary CPUs ... Sep 4 00:07:43.022507 kernel: Detected PIPT I-cache on CPU1 Sep 4 00:07:43.022512 kernel: GICv3: CPU1: found redistributor 1 region 1:0x00000000f000e000 Sep 4 00:07:43.022518 kernel: CPU1: Booted secondary processor 0x0000000001 [0x410fd490] Sep 4 00:07:43.022523 kernel: smp: Brought up 1 node, 2 CPUs Sep 4 00:07:43.022528 kernel: SMP: Total of 2 processors activated. Sep 4 00:07:43.022533 kernel: CPU: All CPU(s) started at EL1 Sep 4 00:07:43.022538 kernel: CPU features: detected: 32-bit EL0 Support Sep 4 00:07:43.022544 kernel: CPU features: detected: Instruction cache invalidation not required for I/D coherence Sep 4 00:07:43.022551 kernel: CPU features: detected: Data cache clean to the PoU not required for I/D coherence Sep 4 00:07:43.022557 kernel: CPU features: detected: Common not Private translations Sep 4 00:07:43.022562 kernel: CPU features: detected: CRC32 instructions Sep 4 00:07:43.022567 kernel: CPU features: detected: Generic authentication (architected QARMA5 algorithm) Sep 4 00:07:43.022572 kernel: CPU features: detected: RCpc load-acquire (LDAPR) Sep 4 00:07:43.022578 kernel: CPU features: detected: LSE atomic instructions Sep 4 00:07:43.022584 kernel: CPU features: detected: Privileged Access Never Sep 4 00:07:43.022589 kernel: CPU features: detected: Speculation barrier (SB) Sep 4 00:07:43.022594 kernel: CPU features: detected: TLB range maintenance instructions Sep 4 00:07:43.022600 kernel: CPU features: detected: Speculative Store Bypassing Safe (SSBS) Sep 4 00:07:43.022604 kernel: CPU features: detected: Scalable Vector Extension Sep 4 00:07:43.022609 kernel: alternatives: applying system-wide alternatives Sep 4 00:07:43.022614 kernel: CPU features: detected: Hardware dirty bit management on CPU0-1 Sep 4 00:07:43.022619 kernel: SVE: maximum available vector length 16 bytes per vector Sep 4 00:07:43.022624 kernel: SVE: default vector length 16 bytes per vector Sep 4 00:07:43.022631 kernel: Memory: 3976452K/4194160K available (12544K kernel code, 2480K rwdata, 9568K rodata, 13312K init, 1040K bss, 195764K reserved, 16384K cma-reserved) Sep 4 00:07:43.022636 kernel: devtmpfs: initialized Sep 4 00:07:43.022641 kernel: futex hash table entries: 512 (order: 3, 32768 bytes, linear) Sep 4 00:07:43.022646 kernel: 2G module region forced by RANDOMIZE_MODULE_REGION_FULL Sep 4 00:07:43.022651 kernel: 0 pages in range for non-PLT usage Sep 4 00:07:43.022656 kernel: 514496 pages in range for PLT usage Sep 4 00:07:43.022660 kernel: pinctrl core: initialized pinctrl subsystem Sep 4 00:07:43.022667 kernel: SMBIOS 3.1.0 present. Sep 4 00:07:43.022672 kernel: DMI: Microsoft Corporation Virtual Machine/Virtual Machine, BIOS Hyper-V UEFI Release v4.1 01/08/2026 Sep 4 00:07:43.022677 kernel: DMI: Memory slots populated: 2/2 Sep 4 00:07:43.022683 kernel: NET: Registered PF_NETLINK/PF_ROUTE protocol family Sep 4 00:07:43.022688 kernel: DMA: preallocated 512 KiB GFP_KERNEL pool for atomic allocations Sep 4 00:07:43.022693 kernel: DMA: preallocated 512 KiB GFP_KERNEL|GFP_DMA pool for atomic allocations Sep 4 00:07:43.022698 kernel: DMA: preallocated 512 KiB GFP_KERNEL|GFP_DMA32 pool for atomic allocations Sep 4 00:07:43.022704 kernel: audit: initializing netlink subsys (disabled) Sep 4 00:07:43.022709 kernel: audit: type=2000 audit(0.059:1): state=initialized audit_enabled=0 res=1 Sep 4 00:07:43.022714 kernel: thermal_sys: Registered thermal governor 'step_wise' Sep 4 00:07:43.022719 kernel: cpuidle: using governor menu Sep 4 00:07:43.022724 kernel: hw-breakpoint: found 6 breakpoint and 4 watchpoint registers. Sep 4 00:07:43.022729 kernel: ASID allocator initialised with 32768 entries Sep 4 00:07:43.022734 kernel: acpiphp: ACPI Hot Plug PCI Controller Driver version: 0.5 Sep 4 00:07:43.022740 kernel: Serial: AMBA PL011 UART driver Sep 4 00:07:43.022745 kernel: HugeTLB: registered 1.00 GiB page size, pre-allocated 0 pages Sep 4 00:07:43.022750 kernel: HugeTLB: 0 KiB vmemmap can be freed for a 1.00 GiB page Sep 4 00:07:43.022755 kernel: HugeTLB: registered 32.0 MiB page size, pre-allocated 0 pages Sep 4 00:07:43.022760 kernel: HugeTLB: 0 KiB vmemmap can be freed for a 32.0 MiB page Sep 4 00:07:43.022765 kernel: HugeTLB: registered 2.00 MiB page size, pre-allocated 0 pages Sep 4 00:07:43.022770 kernel: HugeTLB: 0 KiB vmemmap can be freed for a 2.00 MiB page Sep 4 00:07:43.022776 kernel: HugeTLB: registered 64.0 KiB page size, pre-allocated 0 pages Sep 4 00:07:43.022781 kernel: HugeTLB: 0 KiB vmemmap can be freed for a 64.0 KiB page Sep 4 00:07:43.022786 kernel: ACPI: Added _OSI(Module Device) Sep 4 00:07:43.022791 kernel: ACPI: Added _OSI(Processor Device) Sep 4 00:07:43.022796 kernel: ACPI: Added _OSI(Processor Aggregator Device) Sep 4 00:07:43.022801 kernel: ACPI: 1 ACPI AML tables successfully acquired and loaded Sep 4 00:07:43.022806 kernel: ACPI: Interpreter enabled Sep 4 00:07:43.022811 kernel: ACPI: Using GIC for interrupt routing Sep 4 00:07:43.022818 kernel: ARMH0011:00: ttyAMA0 at MMIO 0xeffec000 (irq = 12, base_baud = 0) is a SBSA Sep 4 00:07:43.022823 kernel: printk: legacy console [ttyAMA0] enabled Sep 4 00:07:43.022829 kernel: printk: legacy bootconsole [pl11] disabled Sep 4 00:07:43.022834 kernel: ARMH0011:01: ttyAMA1 at MMIO 0xeffeb000 (irq = 13, base_baud = 0) is a SBSA Sep 4 00:07:43.022839 kernel: ACPI: CPU0 has been hot-added Sep 4 00:07:43.022843 kernel: ACPI: CPU1 has been hot-added Sep 4 00:07:43.022848 kernel: iommu: Default domain type: Translated Sep 4 00:07:43.022854 kernel: iommu: DMA domain TLB invalidation policy: strict mode Sep 4 00:07:43.022859 kernel: efivars: Registered efivars operations Sep 4 00:07:43.022864 kernel: vgaarb: loaded Sep 4 00:07:43.022869 kernel: clocksource: Switched to clocksource arch_sys_counter Sep 4 00:07:43.022874 kernel: VFS: Disk quotas dquot_6.6.0 Sep 4 00:07:43.022879 kernel: VFS: Dquot-cache hash table entries: 512 (order 0, 4096 bytes) Sep 4 00:07:43.022884 kernel: pnp: PnP ACPI init Sep 4 00:07:43.022890 kernel: pnp: PnP ACPI: found 0 devices Sep 4 00:07:43.022895 kernel: NET: Registered PF_INET protocol family Sep 4 00:07:43.022900 kernel: IP idents hash table entries: 65536 (order: 7, 524288 bytes, linear) Sep 4 00:07:43.022905 kernel: tcp_listen_portaddr_hash hash table entries: 2048 (order: 3, 32768 bytes, linear) Sep 4 00:07:43.022910 kernel: Table-perturb hash table entries: 65536 (order: 6, 262144 bytes, linear) Sep 4 00:07:43.022915 kernel: TCP established hash table entries: 32768 (order: 6, 262144 bytes, linear) Sep 4 00:07:43.022920 kernel: TCP bind hash table entries: 32768 (order: 8, 1048576 bytes, linear) Sep 4 00:07:43.022926 kernel: TCP: Hash tables configured (established 32768 bind 32768) Sep 4 00:07:43.022931 kernel: UDP hash table entries: 2048 (order: 4, 65536 bytes, linear) Sep 4 00:07:43.022936 kernel: UDP-Lite hash table entries: 2048 (order: 4, 65536 bytes, linear) Sep 4 00:07:43.022941 kernel: NET: Registered PF_UNIX/PF_LOCAL protocol family Sep 4 00:07:43.022946 kernel: PCI: CLS 0 bytes, default 64 Sep 4 00:07:43.022951 kernel: kvm [1]: HYP mode not available Sep 4 00:07:43.022956 kernel: Initialise system trusted keyrings Sep 4 00:07:43.022962 kernel: workingset: timestamp_bits=39 max_order=20 bucket_order=0 Sep 4 00:07:43.022967 kernel: Key type asymmetric registered Sep 4 00:07:43.022972 kernel: Asymmetric key parser 'x509' registered Sep 4 00:07:43.022977 kernel: Block layer SCSI generic (bsg) driver version 0.4 loaded (major 249) Sep 4 00:07:43.022982 kernel: io scheduler mq-deadline registered Sep 4 00:07:43.022987 kernel: io scheduler kyber registered Sep 4 00:07:43.022992 kernel: io scheduler bfq registered Sep 4 00:07:43.022998 kernel: Serial: 8250/16550 driver, 4 ports, IRQ sharing enabled Sep 4 00:07:43.023003 kernel: ACPI: bus type drm_connector registered Sep 4 00:07:43.023008 kernel: thunder_xcv, ver 1.0 Sep 4 00:07:43.023013 kernel: thunder_bgx, ver 1.0 Sep 4 00:07:43.023018 kernel: nicpf, ver 1.0 Sep 4 00:07:43.023023 kernel: nicvf, ver 1.0 Sep 4 00:07:43.023194 kernel: rtc-efi rtc-efi.0: registered as rtc0 Sep 4 00:07:43.023730 kernel: rtc-efi rtc-efi.0: setting system clock to 2026-09-04T00:07:39 UTC (1788480459) Sep 4 00:07:43.023747 kernel: efifb: probing for efifb Sep 4 00:07:43.023752 kernel: efifb: framebuffer at 0x40000000, using 3072k, total 3072k Sep 4 00:07:43.023758 kernel: efifb: mode is 1024x768x32, linelength=4096, pages=1 Sep 4 00:07:43.023763 kernel: efifb: scrolling: redraw Sep 4 00:07:43.023768 kernel: efifb: Truecolor: size=8:8:8:8, shift=24:16:8:0 Sep 4 00:07:43.023773 kernel: Console: switching to colour frame buffer device 128x48 Sep 4 00:07:43.023784 kernel: fb0: EFI VGA frame buffer device Sep 4 00:07:43.023789 kernel: SMCCC: SOC_ID: ARCH_SOC_ID not implemented, skipping .... Sep 4 00:07:43.023794 kernel: hid: raw HID events driver (C) Jiri Kosina Sep 4 00:07:43.023800 kernel: hw perfevents: enabled with armv8_pmuv3_0 PMU driver, 7 (0,8000003f) counters available Sep 4 00:07:43.023805 kernel: watchdog: NMI not fully supported Sep 4 00:07:43.023810 kernel: NET: Registered PF_INET6 protocol family Sep 4 00:07:43.023815 kernel: watchdog: Hard watchdog permanently disabled Sep 4 00:07:43.023821 kernel: Segment Routing with IPv6 Sep 4 00:07:43.023826 kernel: In-situ OAM (IOAM) with IPv6 Sep 4 00:07:43.023831 kernel: NET: Registered PF_PACKET protocol family Sep 4 00:07:43.023836 kernel: Key type dns_resolver registered Sep 4 00:07:43.023841 kernel: registered taskstats version 1 Sep 4 00:07:43.023846 kernel: Loading compiled-in X.509 certificates Sep 4 00:07:43.023851 kernel: Loaded X.509 cert 'Kinvolk GmbH: Module signing key for 6.12.108-flatcar: e7b9788574ddbe4d9def818899989ca66a428be5' Sep 4 00:07:43.023858 kernel: Demotion targets for Node 0: null Sep 4 00:07:43.023863 kernel: Key type .fscrypt registered Sep 4 00:07:43.023868 kernel: Key type fscrypt-provisioning registered Sep 4 00:07:43.023873 kernel: ima: No TPM chip found, activating TPM-bypass! Sep 4 00:07:43.023878 kernel: ima: Allocated hash algorithm: sha1 Sep 4 00:07:43.023883 kernel: ima: No architecture policies found Sep 4 00:07:43.023888 kernel: alg: No test for fips(ansi_cprng) (fips_ansi_cprng) Sep 4 00:07:43.023894 kernel: clk: Disabling unused clocks Sep 4 00:07:43.023899 kernel: PM: genpd: Disabling unused power domains Sep 4 00:07:43.023904 kernel: Freeing unused kernel memory: 13312K Sep 4 00:07:43.023909 kernel: Run /init as init process Sep 4 00:07:43.023914 kernel: with arguments: Sep 4 00:07:43.023920 kernel: /init Sep 4 00:07:43.023925 kernel: with environment: Sep 4 00:07:43.023929 kernel: HOME=/ Sep 4 00:07:43.023936 kernel: TERM=linux Sep 4 00:07:43.023941 kernel: hv_vmbus: hv_mmio=[mem 0x40000000-0xfed3ffff],[mem 0xfc0000000-0xfffffffff] fb=[mem 0x40000000-0x47ffffff] Sep 4 00:07:43.023946 kernel: hv_vmbus: Vmbus version:5.3 Sep 4 00:07:43.023951 kernel: hv_vmbus: registering driver hid_hyperv Sep 4 00:07:43.023956 kernel: SCSI subsystem initialized Sep 4 00:07:43.023961 kernel: input: Microsoft Vmbus HID-compliant Mouse as /devices/0006:045E:0621.0001/input/input0 Sep 4 00:07:43.024075 kernel: hid-hyperv 0006:045E:0621.0001: input: VIRTUAL HID v0.01 Mouse [Microsoft Vmbus HID-compliant Mouse] on Sep 4 00:07:43.024085 kernel: hv_vmbus: registering driver hyperv_keyboard Sep 4 00:07:43.024090 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 Sep 4 00:07:43.024095 kernel: pps_core: LinuxPPS API ver. 1 registered Sep 4 00:07:43.024101 kernel: pps_core: Software ver. 5.3.6 - Copyright 2005-2007 Rodolfo Giometti Sep 4 00:07:43.024106 kernel: PTP clock support registered Sep 4 00:07:43.024111 kernel: hv_utils: Registering HyperV Utility Driver Sep 4 00:07:43.024117 kernel: hv_vmbus: registering driver hv_utils Sep 4 00:07:43.024122 kernel: hv_utils: Heartbeat IC version 3.0 Sep 4 00:07:43.024127 kernel: hv_utils: Shutdown IC version 3.2 Sep 4 00:07:43.024133 kernel: hv_utils: TimeSync IC version 4.0 Sep 4 00:07:43.024138 kernel: hv_vmbus: registering driver hv_storvsc Sep 4 00:07:43.024320 kernel: scsi host0: storvsc_host_t Sep 4 00:07:43.024444 kernel: scsi 0:0:0:0: Direct-Access Msft Virtual Disk 1.0 PQ: 0 ANSI: 5 Sep 4 00:07:43.024550 kernel: scsi host1: storvsc_host_t Sep 4 00:07:43.024665 kernel: scsi 0:0:0:2: CD-ROM Msft Virtual DVD-ROM 1.0 PQ: 0 ANSI: 5 Sep 4 00:07:43.024768 kernel: sd 0:0:0:0: [sda] 63737856 512-byte logical blocks: (32.6 GB/30.4 GiB) Sep 4 00:07:43.024866 kernel: sd 0:0:0:0: [sda] 4096-byte physical blocks Sep 4 00:07:43.024964 kernel: sd 0:0:0:0: [sda] Write Protect is off Sep 4 00:07:43.025063 kernel: sd 0:0:0:0: [sda] Mode Sense: 0f 00 10 00 Sep 4 00:07:43.025160 kernel: sd 0:0:0:0: [sda] Write cache: disabled, read cache: enabled, supports DPO and FUA Sep 4 00:07:43.025167 kernel: sda: sda1 sda2 sda3 sda4 sda6 sda7 sda9 Sep 4 00:07:43.025278 kernel: sd 0:0:0:0: [sda] Attached SCSI disk Sep 4 00:07:43.025379 kernel: sr 0:0:0:2: [sr0] scsi-1 drive Sep 4 00:07:43.025385 kernel: cdrom: Uniform CD-ROM driver Revision: 3.20 Sep 4 00:07:43.025486 kernel: sr 0:0:0:2: Attached scsi CD-ROM sr0 Sep 4 00:07:43.025493 kernel: device-mapper: core: CONFIG_IMA_DISABLE_HTABLE is disabled. Duplicate IMA measurements will not be recorded in the IMA log. Sep 4 00:07:43.025498 kernel: device-mapper: uevent: version 1.0.3 Sep 4 00:07:43.025504 kernel: device-mapper: ioctl: 4.48.0-ioctl (2023-03-01) initialised: dm-devel@lists.linux.dev Sep 4 00:07:43.025509 kernel: device-mapper: verity: sha256 using shash "sha256-ce" Sep 4 00:07:43.025514 kernel: raid6: neonx8 gen() 18575 MB/s Sep 4 00:07:43.025519 kernel: raid6: neonx4 gen() 18549 MB/s Sep 4 00:07:43.025526 kernel: raid6: neonx2 gen() 17047 MB/s Sep 4 00:07:43.025531 kernel: raid6: neonx1 gen() 15123 MB/s Sep 4 00:07:43.025536 kernel: raid6: int64x8 gen() 8925 MB/s Sep 4 00:07:43.025541 kernel: raid6: int64x4 gen() 10751 MB/s Sep 4 00:07:43.025546 kernel: raid6: int64x2 gen() 8844 MB/s Sep 4 00:07:43.025551 kernel: raid6: int64x1 gen() 7100 MB/s Sep 4 00:07:43.025556 kernel: raid6: using algorithm neonx8 gen() 18575 MB/s Sep 4 00:07:43.025562 kernel: raid6: .... xor() 15075 MB/s, rmw enabled Sep 4 00:07:43.025567 kernel: raid6: using neon recovery algorithm Sep 4 00:07:43.025572 kernel: xor: measuring software checksum speed Sep 4 00:07:43.025578 kernel: 8regs : 29481 MB/sec Sep 4 00:07:43.025583 kernel: 32regs : 29694 MB/sec Sep 4 00:07:43.025587 kernel: arm64_neon : 37097 MB/sec Sep 4 00:07:43.025592 kernel: xor: using function: arm64_neon (37097 MB/sec) Sep 4 00:07:43.025597 kernel: Btrfs loaded, zoned=no, fsverity=no Sep 4 00:07:43.025604 kernel: BTRFS: device fsid adc64d41-c4dc-465f-9d27-d4862faaab6e devid 1 transid 42 /dev/mapper/usr (254:0) scanned by mount (384) Sep 4 00:07:43.025609 kernel: BTRFS info (device dm-0): first mount of filesystem adc64d41-c4dc-465f-9d27-d4862faaab6e Sep 4 00:07:43.025614 kernel: BTRFS info (device dm-0): using crc32c (crc32c-generic) checksum algorithm Sep 4 00:07:43.025619 kernel: BTRFS info (device dm-0 state E): disabling log replay at mount time Sep 4 00:07:43.025625 kernel: BTRFS info (device dm-0 state E): enabling free space tree Sep 4 00:07:43.025630 kernel: loop: module loaded Sep 4 00:07:43.025635 kernel: loop0: detected capacity change from 0 to 99832 Sep 4 00:07:43.025641 kernel: squashfs: version 4.0 (2009/01/31) Phillip Lougher Sep 4 00:07:43.025647 systemd[1]: Successfully made /usr/ read-only. Sep 4 00:07:43.025654 systemd[1]: systemd 260.1 running in system mode (+PAM +AUDIT +SELINUX -APPARMOR +IMA +IPE +SMACK +SECCOMP -GCRYPT -GNUTLS +OPENSSL -ACL +BLKID +CURL +ELFUTILS -FIDO2 +IDN2 +KMOD +LIBCRYPTSETUP +LIBCRYPTSETUP_PLUGINS +LIBFDISK +PCRE2 -PWQUALITY -P11KIT -QRENCODE +TPM2 +BZIP2 +LZ4 +XZ +ZLIB +ZSTD -BPF_FRAMEWORK -BTF -XKBCOMMON +UTMP +LIBARCHIVE) Sep 4 00:07:43.025660 systemd[1]: Detected virtualization microsoft. Sep 4 00:07:43.025665 systemd[1]: Detected architecture arm64. Sep 4 00:07:43.025671 systemd[1]: Running in initrd. Sep 4 00:07:43.025677 systemd[1]: Initializing machine ID from random generator. Sep 4 00:07:43.025682 systemd[1]: No hostname configured, using default hostname. Sep 4 00:07:43.025688 systemd[1]: Hostname set to . Sep 4 00:07:43.025693 systemd[1]: Queued start job for default target initrd.target. Sep 4 00:07:43.025699 systemd[1]: Started clevis-luks-askpass.path - Forward Password Requests to Clevis Directory Watch. Sep 4 00:07:43.025704 systemd[1]: Started systemd-ask-password-console.path - Dispatch Password Requests to Console Directory Watch. Sep 4 00:07:43.025712 systemd[1]: Expecting device dev-disk-by\x2dlabel-EFI\x2dSYSTEM.device - /dev/disk/by-label/EFI-SYSTEM... Sep 4 00:07:43.025717 systemd[1]: Expecting device dev-disk-by\x2dlabel-OEM.device - /dev/disk/by-label/OEM... Sep 4 00:07:43.025723 systemd[1]: Expecting device dev-disk-by\x2dlabel-ROOT.device - /dev/disk/by-label/ROOT... Sep 4 00:07:43.025729 systemd[1]: Expecting device dev-disk-by\x2dpartlabel-USR\x2dA.device - /dev/disk/by-partlabel/USR-A... Sep 4 00:07:43.025735 systemd[1]: Expecting device dev-mapper-usr.device - /dev/mapper/usr... Sep 4 00:07:43.025741 systemd[1]: Reached target cryptsetup-pre.target - Local Encrypted Volumes (Pre). Sep 4 00:07:43.025747 systemd[1]: Reached target cryptsetup.target - Local Encrypted Volumes. Sep 4 00:07:43.025752 systemd[1]: Reached target initrd-usr-fs.target - Initrd /usr File System. Sep 4 00:07:43.025758 systemd[1]: Reached target paths.target - Path Units. Sep 4 00:07:43.025763 systemd[1]: Reached target slices.target - Slice Units. Sep 4 00:07:43.025768 systemd[1]: Reached target swap.target - Swaps. Sep 4 00:07:43.025774 systemd[1]: Reached target timers.target - Timer Units. Sep 4 00:07:43.025780 systemd[1]: Listening on iscsid.socket - Open-iSCSI iscsid Socket. Sep 4 00:07:43.025791 systemd[1]: Listening on iscsiuio.socket - Open-iSCSI iscsiuio Socket. Sep 4 00:07:43.025797 systemd[1]: Listening on systemd-coredump.socket - Process Core Dump Socket. Sep 4 00:07:43.025803 systemd[1]: Listening on systemd-journald-audit.socket - Journal Audit Socket. Sep 4 00:07:43.025808 systemd[1]: Listening on systemd-journald-dev-log.socket - Journal Socket (/dev/log). Sep 4 00:07:43.025815 systemd[1]: Listening on systemd-journald.socket - Journal Sockets. Sep 4 00:07:43.025820 systemd[1]: Listening on systemd-networkd-resolve-hook.socket - Network Management Resolve Hook Socket. Sep 4 00:07:43.025874 systemd[1]: Listening on systemd-networkd.socket - Network Management Netlink Socket. Sep 4 00:07:43.025881 systemd[1]: Listening on systemd-udevd-control.socket - udev Control Socket. Sep 4 00:07:43.025887 systemd[1]: Listening on systemd-udevd-kernel.socket - udev Kernel Socket. Sep 4 00:07:43.025893 systemd[1]: Reached target sockets.target - Socket Units. Sep 4 00:07:43.025899 systemd[1]: afterburn-network-kargs.service - Afterburn Initrd Setup Network Kernel Arguments skipped, no trigger condition checks were met. Sep 4 00:07:43.025906 systemd[1]: Starting ignition-setup-pre.service - Ignition env setup... Sep 4 00:07:43.025912 systemd[1]: Starting kmod-static-nodes.service - Create List of Static Device Nodes... Sep 4 00:07:43.025917 systemd[1]: Finished network-cleanup.service - Network Cleanup. Sep 4 00:07:43.025923 systemd[1]: systemd-battery-check.service - Early Battery Level Check skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/class/power_supply Sep 4 00:07:43.025929 systemd[1]: Starting systemd-journald.service - Journal Service... Sep 4 00:07:43.025936 systemd[1]: Starting systemd-modules-load.service - Load Kernel Modules... Sep 4 00:07:43.025941 systemd[1]: Starting systemd-vconsole-setup.service - Virtual Console Setup... Sep 4 00:07:43.025967 systemd-journald[559]: Collecting audit messages is enabled. Sep 4 00:07:43.025984 systemd-journald[559]: Journal started Sep 4 00:07:43.025997 systemd-journald[559]: Runtime Journal (/run/log/journal/500281c9d5b449fc8907238e1d987a3b) is 8M, max 78.3M, 70.3M free. Sep 4 00:07:43.008451 systemd-modules-load[562]: Using 2 probe threads Sep 4 00:07:43.040000 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' Sep 4 00:07:43.053531 systemd[1]: Started systemd-journald.service - Journal Service. Sep 4 00:07:43.053552 kernel: audit: type=1130 audit(1788480463.040: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' Sep 4 00:07:43.071995 systemd[1]: Finished ignition-setup-pre.service - Ignition env setup. Sep 4 00:07:43.082000 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' Sep 4 00:07:43.104124 systemd[1]: Finished kmod-static-nodes.service - Create List of Static Device Nodes. Sep 4 00:07:43.113777 systemd-modules-load[562]: Inserted module 'br_netfilter' Sep 4 00:07:43.117000 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' Sep 4 00:07:43.135022 kernel: audit: type=1130 audit(1788480463.082: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' Sep 4 00:07:43.135042 kernel: bridge: filtering via arp/ip/ip6tables is no longer available by default. Update your scripts to load br_netfilter if you need this. Sep 4 00:07:43.135050 kernel: Bridge firewalling registered Sep 4 00:07:43.135057 kernel: audit: type=1130 audit(1788480463.117: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' Sep 4 00:07:43.137213 systemd[1]: Finished systemd-modules-load.service - Load Kernel Modules. Sep 4 00:07:43.141000 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' Sep 4 00:07:43.147139 systemd-vconsole-setup[564]: Configuration of first virtual console was skipped, ignoring remaining ones. Sep 4 00:07:43.171422 kernel: audit: type=1130 audit(1788480463.141: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' Sep 4 00:07:43.160477 systemd[1]: Starting systemd-sysctl.service - Apply Kernel Variables... Sep 4 00:07:43.179104 systemd[1]: Starting systemd-tmpfiles-setup-dev-early.service - Create Static Device Nodes in /dev gracefully... Sep 4 00:07:43.197504 systemd[1]: Starting systemd-tmpfiles-setup.service - Create System Files and Directories... Sep 4 00:07:43.209324 systemd[1]: Finished systemd-vconsole-setup.service - Virtual Console Setup. Sep 4 00:07:43.219000 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' Sep 4 00:07:43.221916 systemd-tmpfiles[594]: /usr/lib/tmpfiles.d/systemd.conf:30: Duplicate line for path "/var/lib/systemd", ignoring. Sep 4 00:07:43.238000 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' Sep 4 00:07:43.221981 systemd-tmpfiles[594]: /usr/lib/tmpfiles.d/var.conf:14: Duplicate line for path "/var/log", ignoring. Sep 4 00:07:43.238000 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' Sep 4 00:07:43.277421 kernel: audit: type=1130 audit(1788480463.219:6): 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' Sep 4 00:07:43.228936 systemd[1]: systemd-sysctl.service: Deactivated successfully. Sep 4 00:07:43.282787 kernel: audit: type=1130 audit(1788480463.238:7): 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' Sep 4 00:07:43.232104 systemd[1]: Finished systemd-sysctl.service - Apply Kernel Variables. Sep 4 00:07:43.287390 kernel: audit: type=1131 audit(1788480463.238:8): 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' Sep 4 00:07:43.282326 systemd[1]: Finished systemd-tmpfiles-setup-dev-early.service - Create Static Device Nodes in /dev gracefully. Sep 4 00:07:43.291000 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' Sep 4 00:07:43.312494 systemd[1]: Finished systemd-tmpfiles-setup.service - Create System Files and Directories. Sep 4 00:07:43.316000 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' Sep 4 00:07:43.334914 kernel: audit: type=1130 audit(1788480463.291:9): 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' Sep 4 00:07:43.334933 kernel: audit: type=1130 audit(1788480463.316:10): 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' Sep 4 00:07:43.337543 systemd[1]: Starting dracut-cmdline-ask.service - dracut ask for additional cmdline parameters... Sep 4 00:07:43.349000 audit: BPF prog-id=5 op=LOAD Sep 4 00:07:43.361404 systemd[1]: Starting systemd-resolved.service - Network Name Resolution... Sep 4 00:07:43.391690 systemd[1]: Starting systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev... Sep 4 00:07:43.409455 systemd-resolved[608]: Positive Trust Anchors: Sep 4 00:07:43.409469 systemd-resolved[608]: . IN DS 20326 8 2 e06d44b80b8f1d39a95c0b0d7c65d08458e880409bbc683457104237c7f8ec8d Sep 4 00:07:43.409472 systemd-resolved[608]: . IN DS 38696 8 2 683d2d0acb8c9b712a1948b27f741219298d0a450d612c483af444a4c0fb2b16 Sep 4 00:07:43.432000 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' Sep 4 00:07:43.440114 kernel: kauditd_printk_skb: 1 callbacks suppressed Sep 4 00:07:43.409492 systemd-resolved[608]: 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 Sep 4 00:07:43.485000 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' Sep 4 00:07:43.499035 kernel: audit: type=1130 audit(1788480463.432:12): 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' Sep 4 00:07:43.424451 systemd[1]: Finished systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev. Sep 4 00:07:43.509000 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' Sep 4 00:07:43.527918 kernel: audit: type=1130 audit(1788480463.485:13): 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' Sep 4 00:07:43.426541 systemd-resolved[608]: Defaulting to hostname 'linux'. Sep 4 00:07:43.532281 kernel: audit: type=1130 audit(1788480463.509:14): 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' Sep 4 00:07:43.446536 systemd[1]: Started systemd-resolved.service - Network Name Resolution. Sep 4 00:07:43.505500 systemd[1]: Finished dracut-cmdline-ask.service - dracut ask for additional cmdline parameters. Sep 4 00:07:43.510905 systemd[1]: Reached target nss-lookup.target - Host and Network Name Lookups. Sep 4 00:07:43.529729 systemd[1]: Starting dracut-cmdline.service - dracut cmdline hook... Sep 4 00:07:43.560411 dracut-cmdline[627]: dracut-110 Sep 4 00:07:43.563572 dracut-cmdline[627]: 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=bcfe44ce4b0956179a040e182aa390fdc12a5258aaf209e6524a34a7042177eb Sep 4 00:07:43.682261 kernel: Loading iSCSI transport class v2.0-870. Sep 4 00:07:43.721264 kernel: iscsi: registered transport (tcp) Sep 4 00:07:43.755213 kernel: iscsi: registered transport (qla4xxx) Sep 4 00:07:43.755289 kernel: QLogic iSCSI HBA Driver Sep 4 00:07:43.817015 systemd[1]: Starting systemd-network-generator.service - Generate Network Units from Kernel Command Line... Sep 4 00:07:43.840333 systemd[1]: Finished systemd-network-generator.service - Generate Network Units from Kernel Command Line. Sep 4 00:07:43.848000 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' Sep 4 00:07:43.850564 systemd[1]: Reached target network-pre.target - Preparation for Network. Sep 4 00:07:43.875314 kernel: audit: type=1130 audit(1788480463.848:15): 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' Sep 4 00:07:43.943313 systemd[1]: Finished dracut-cmdline.service - dracut cmdline hook. Sep 4 00:07:43.948000 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' Sep 4 00:07:43.968321 kernel: audit: type=1130 audit(1788480463.948:16): 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' Sep 4 00:07:43.968380 systemd[1]: Starting dracut-pre-udev.service - dracut pre-udev hook... Sep 4 00:07:43.974758 systemd[1]: Starting parse-ip-for-networkd.service - Write systemd-networkd units from cmdline... Sep 4 00:07:44.013524 systemd[1]: Finished dracut-pre-udev.service - dracut pre-udev hook. Sep 4 00:07:44.016000 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' Sep 4 00:07:44.017000 audit: BPF prog-id=6 op=LOAD Sep 4 00:07:44.040001 kernel: audit: type=1130 audit(1788480464.016:17): 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' Sep 4 00:07:44.039387 systemd[1]: Starting systemd-udevd.service - Rule-based Manager for Device Events and Files... Sep 4 00:07:44.017000 audit: BPF prog-id=7 op=LOAD Sep 4 00:07:44.062803 kernel: audit: type=1334 audit(1788480464.017:18): prog-id=6 op=LOAD Sep 4 00:07:44.062823 kernel: audit: type=1334 audit(1788480464.017:19): prog-id=7 op=LOAD Sep 4 00:07:44.144364 systemd-udevd[868]: Using default interface naming scheme 'v260'. Sep 4 00:07:44.148645 systemd[1]: Finished parse-ip-for-networkd.service - Write systemd-networkd units from cmdline. Sep 4 00:07:44.158000 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' Sep 4 00:07:44.175259 kernel: audit: type=1130 audit(1788480464.158:20): 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' Sep 4 00:07:44.181746 systemd[1]: Started systemd-udevd.service - Rule-based Manager for Device Events and Files. Sep 4 00:07:44.186000 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' Sep 4 00:07:44.204946 systemd[1]: Starting dracut-pre-trigger.service - dracut pre-trigger hook... Sep 4 00:07:44.220000 audit: BPF prog-id=8 op=LOAD Sep 4 00:07:44.221636 kernel: audit: type=1130 audit(1788480464.186:21): 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' Sep 4 00:07:44.230390 systemd[1]: Starting systemd-networkd.service - Network Management... Sep 4 00:07:44.244997 dracut-pre-trigger[982]: rd.md=0: removing MD RAID activation Sep 4 00:07:44.275744 systemd-networkd[988]: Failed to open nftables netlink socket. IPMasquerade= and NFTSet= settings will not be applied. Ignoring: Protocol not supported Sep 4 00:07:44.285965 systemd[1]: Finished dracut-pre-trigger.service - dracut pre-trigger hook. Sep 4 00:07:44.289000 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' Sep 4 00:07:44.296749 systemd[1]: Starting systemd-udev-trigger.service - Coldplug All udev Devices... Sep 4 00:07:44.303848 systemd-networkd[988]: lo: Link UP Sep 4 00:07:44.312000 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' Sep 4 00:07:44.303851 systemd-networkd[988]: lo: Gained carrier Sep 4 00:07:44.306406 systemd[1]: Started systemd-networkd.service - Network Management. Sep 4 00:07:44.314426 systemd[1]: Reached target network.target - Network. Sep 4 00:07:44.385451 systemd[1]: Finished systemd-udev-trigger.service - Coldplug All udev Devices. Sep 4 00:07:44.391000 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' Sep 4 00:07:44.399888 systemd[1]: Starting dracut-initqueue.service - dracut initqueue hook... Sep 4 00:07:44.489256 kernel: hv_storvsc f8b3781a-1e82-4818-a1c3-63d806ec15bb: tag#51 cmd 0x85 status: scsi 0x2 srb 0x6 hv 0xc0000001 Sep 4 00:07:44.538414 systemd[1]: systemd-vconsole-setup.service: Deactivated successfully. Sep 4 00:07:44.542578 systemd[1]: Stopped systemd-vconsole-setup.service - Virtual Console Setup. Sep 4 00:07:44.552000 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' Sep 4 00:07:44.562260 kernel: hv_vmbus: registering driver hv_netvsc Sep 4 00:07:44.572518 systemd[1]: Stopping systemd-vconsole-setup.service - Virtual Console Setup... Sep 4 00:07:44.583668 systemd[1]: Starting systemd-vconsole-setup.service - Virtual Console Setup... Sep 4 00:07:44.603124 systemd-vconsole-setup[1076]: Configuration of first virtual console was skipped, ignoring remaining ones. Sep 4 00:07:44.610280 systemd[1]: Finished systemd-vconsole-setup.service - Virtual Console Setup. Sep 4 00:07:44.614000 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' Sep 4 00:07:44.640245 kernel: hv_netvsc 0022487b-8ce2-0022-487b-8ce20022487b eth0: VF slot 1 added Sep 4 00:07:44.676064 systemd-networkd[988]: eth0: Found matching .network file, based on potentially unpredictable interface name: /usr/lib/systemd/network/zz-default.network Sep 4 00:07:44.676074 systemd-networkd[988]: eth0: Configuring with /usr/lib/systemd/network/zz-default.network. Sep 4 00:07:44.692556 systemd-networkd[988]: eth0: Link UP Sep 4 00:07:44.692627 systemd-networkd[988]: eth0: Gained carrier Sep 4 00:07:44.708146 kernel: hv_vmbus: registering driver hv_pci Sep 4 00:07:44.692638 systemd-networkd[988]: eth0: Found matching .network file, based on potentially unpredictable interface name: /usr/lib/systemd/network/zz-default.network Sep 4 00:07:44.721402 kernel: hv_pci 6445c822-8a7b-4421-9277-36a9e17c6ad6: PCI VMBus probing: Using version 0x10004 Sep 4 00:07:44.721612 kernel: hv_pci 6445c822-8a7b-4421-9277-36a9e17c6ad6: PCI host bridge to bus 8a7b:00 Sep 4 00:07:44.725691 kernel: pci_bus 8a7b:00: root bus resource [mem 0xfc0000000-0xfc00fffff window] Sep 4 00:07:44.729982 kernel: pci_bus 8a7b:00: No busn resource found for root bus, will use [bus 00-ff] Sep 4 00:07:44.736272 kernel: pci 8a7b:00:02.0: [15b3:101a] type 00 class 0x020000 PCIe Endpoint Sep 4 00:07:44.741331 kernel: pci 8a7b:00:02.0: BAR 0 [mem 0xfc0000000-0xfc00fffff 64bit pref] Sep 4 00:07:44.746318 kernel: pci 8a7b:00:02.0: enabling Extended Tags Sep 4 00:07:44.763261 kernel: pci 8a7b:00:02.0: 0.000 Gb/s available PCIe bandwidth, limited by Unknown x0 link at 8a7b:00:02.0 (capable of 252.048 Gb/s with 16.0 GT/s PCIe x16 link) Sep 4 00:07:44.773153 kernel: pci_bus 8a7b:00: busn_res: [bus 00-ff] end is updated to 00 Sep 4 00:07:44.773375 kernel: pci 8a7b:00:02.0: BAR 0 [mem 0xfc0000000-0xfc00fffff 64bit pref]: assigned Sep 4 00:07:44.779288 systemd-networkd[988]: eth0: DHCPv4 address 10.0.0.20/24, gateway 10.0.0.1 acquired from 168.63.129.16 Sep 4 00:07:44.948837 kernel: mlx5_core 8a7b:00:02.0: enabling device (0000 -> 0002) Sep 4 00:07:44.957336 kernel: mlx5_core 8a7b:00:02.0: PTM is not supported by PCIe Sep 4 00:07:44.957577 kernel: mlx5_core 8a7b:00:02.0: firmware version: 16.30.5026 Sep 4 00:07:45.094813 systemd[1]: Found device dev-disk-by\x2dlabel-EFI\x2dSYSTEM.device - Virtual_Disk EFI-SYSTEM. Sep 4 00:07:45.122058 systemd[1]: Found device dev-disk-by\x2dlabel-OEM.device - Virtual_Disk OEM. Sep 4 00:07:45.149895 systemd[1]: Found device dev-disk-by\x2dlabel-ROOT.device - Virtual_Disk ROOT. Sep 4 00:07:45.163334 systemd[1]: Mounting oem.mount - /oem... Sep 4 00:07:45.175710 kernel: hv_netvsc 0022487b-8ce2-0022-487b-8ce20022487b eth0: VF registering: eth1 Sep 4 00:07:45.181485 kernel: mlx5_core 8a7b:00:02.0 eth1: joined to eth0 Sep 4 00:07:45.181629 kernel: mlx5_core 8a7b:00:02.0: MLX5E: StrdRq(1) RqSz(8) StrdSz(2048) RxCqeCmprss(0 basic) Sep 4 00:07:45.195243 kernel: mlx5_core 8a7b:00:02.0 enP35451s1: renamed from eth1 Sep 4 00:07:45.196316 systemd-networkd[988]: eth1: Interface name change detected, renamed to enP35451s1. Sep 4 00:07:45.216285 kernel: BTRFS: device label OEM devid 1 transid 11 /dev/sda6 (8:6) scanned by mount (1138) Sep 4 00:07:45.228686 kernel: BTRFS info (device sda6): first mount of filesystem 5699fa27-50b4-4cbc-8a33-b216a94fd2a3 Sep 4 00:07:45.228735 kernel: BTRFS info (device sda6): using crc32c (crc32c-generic) checksum algorithm Sep 4 00:07:45.266944 kernel: BTRFS info (device sda6): turning on async discard Sep 4 00:07:45.267012 kernel: BTRFS info (device sda6): enabling free space tree Sep 4 00:07:45.268175 systemd[1]: Mounted oem.mount - /oem. Sep 4 00:07:45.273159 systemd[1]: Starting ignition-fetch-offline.service - Ignition (fetch-offline)... Sep 4 00:07:45.325266 kernel: mlx5_core 8a7b:00:02.0 enP35451s1: Link up Sep 4 00:07:45.359684 systemd-networkd[988]: enP35451s1: Link UP Sep 4 00:07:45.363488 kernel: hv_netvsc 0022487b-8ce2-0022-487b-8ce20022487b eth0: Data path switched to VF: enP35451s1 Sep 4 00:07:45.371189 systemd[1]: Found device dev-disk-by\x2dpartlabel-USR\x2dA.device - Virtual_Disk USR-A. Sep 4 00:07:45.379386 systemd[1]: Starting disk-uuid.service - Generate new UUID for disk GPT if necessary... Sep 4 00:07:45.394355 systemd[1]: Finished dracut-initqueue.service - dracut initqueue hook. Sep 4 00:07:45.404000 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' Sep 4 00:07:45.406053 systemd[1]: Reached target remote-fs-pre.target - Preparation for Remote File Systems. Sep 4 00:07:45.418414 systemd[1]: Reached target remote-cryptsetup.target - Remote Encrypted Volumes. Sep 4 00:07:45.427471 systemd[1]: Reached target remote-fs.target - Remote File Systems. Sep 4 00:07:45.441913 systemd[1]: Starting dracut-pre-mount.service - dracut pre-mount hook... Sep 4 00:07:45.550889 systemd[1]: Finished dracut-pre-mount.service - dracut pre-mount hook. Sep 4 00:07:45.560000 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' Sep 4 00:07:45.690408 systemd-networkd[988]: enP35451s1: Gained carrier Sep 4 00:07:46.547341 ignition[1156]: Ignition 2.24.0 Sep 4 00:07:46.547359 ignition[1156]: Stage: fetch-offline Sep 4 00:07:46.550619 ignition[1156]: no config dir at "/usr/lib/ignition/base.d" Sep 4 00:07:46.561032 disk-uuid[1175]: Warning: The kernel is still using the old partition table. Sep 4 00:07:46.561032 disk-uuid[1175]: The new table will be used at the next reboot or after you Sep 4 00:07:46.561032 disk-uuid[1175]: run partprobe(8) or kpartx(8) Sep 4 00:07:46.561032 disk-uuid[1175]: The operation has completed successfully. Sep 4 00:07:46.562000 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' Sep 4 00:07:46.556676 systemd-networkd[988]: eth0: Gained IPv6LL Sep 4 00:07:46.550629 ignition[1156]: no config dir at "/usr/lib/ignition/base.platform.d/azure" Sep 4 00:07:46.557994 systemd[1]: Finished ignition-fetch-offline.service - Ignition (fetch-offline). Sep 4 00:07:46.550713 ignition[1156]: parsed url from cmdline: "" Sep 4 00:07:46.565439 systemd[1]: Starting ignition-fetch.service - Ignition (fetch)... Sep 4 00:07:46.550715 ignition[1156]: no config URL provided Sep 4 00:07:46.550719 ignition[1156]: reading system config file "/usr/lib/ignition/user.ign" Sep 4 00:07:46.550736 ignition[1156]: no config at "/usr/lib/ignition/user.ign" Sep 4 00:07:46.550740 ignition[1156]: failed to fetch config: resource requires networking Sep 4 00:07:46.550870 ignition[1156]: Ignition finished successfully Sep 4 00:07:46.595661 ignition[1250]: Ignition 2.24.0 Sep 4 00:07:46.595666 ignition[1250]: Stage: fetch Sep 4 00:07:46.595874 ignition[1250]: no config dir at "/usr/lib/ignition/base.d" Sep 4 00:07:46.595881 ignition[1250]: no config dir at "/usr/lib/ignition/base.platform.d/azure" Sep 4 00:07:46.595953 ignition[1250]: parsed url from cmdline: "" Sep 4 00:07:46.595956 ignition[1250]: no config URL provided Sep 4 00:07:46.595959 ignition[1250]: reading system config file "/usr/lib/ignition/user.ign" Sep 4 00:07:46.595967 ignition[1250]: no config at "/usr/lib/ignition/user.ign" Sep 4 00:07:46.686124 systemd[1]: disk-uuid.service: Deactivated successfully. Sep 4 00:07:46.695000 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' Sep 4 00:07:46.695000 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' Sep 4 00:07:46.595981 ignition[1250]: GET http://169.254.169.254/metadata/instance/compute/userData?api-version=2021-01-01&format=text: attempt #1 Sep 4 00:07:46.687173 systemd[1]: Finished disk-uuid.service - Generate new UUID for disk GPT if necessary. Sep 4 00:07:46.662113 ignition[1250]: GET result: OK Sep 4 00:07:46.709474 systemd[1]: Mounting boot.mount - Boot partition... Sep 4 00:07:46.662142 ignition[1250]: failed to retrieve userdata from IMDS, falling back to custom data: not a config (empty) Sep 4 00:07:46.741861 ignition[1250]: opening config device: "/dev/sr0" Sep 4 00:07:46.742261 ignition[1250]: getting drive status for "/dev/sr0" Sep 4 00:07:46.742297 ignition[1250]: drive status: OK Sep 4 00:07:46.742394 ignition[1250]: mounting config device Sep 4 00:07:46.742404 ignition[1250]: op(1): [started] mounting "/dev/sr0" at "/tmp/ignition-azure863277967" Sep 4 00:07:46.779128 ignition[1250]: op(1): [finished] mounting "/dev/sr0" at "/tmp/ignition-azure863277967" Sep 4 00:07:46.779138 ignition[1250]: checking for config drive Sep 4 00:07:46.784421 kernel: UDF-fs: INFO Mounting volume 'UDF Volume', timestamp 2026/09/05 00:00 (1000) Sep 4 00:07:46.785496 ignition[1250]: reading config Sep 4 00:07:46.785520 ignition[1250]: op(2): [started] unmounting "/dev/sr0" at "/tmp/ignition-azure863277967" Sep 4 00:07:46.790882 ignition[1250]: op(2): [finished] unmounting "/dev/sr0" at "/tmp/ignition-azure863277967" Sep 4 00:07:46.786760 systemd[1]: tmp-ignition\x2dazure863277967.mount: Deactivated successfully. Sep 4 00:07:46.790911 ignition[1250]: config has been read from custom data Sep 4 00:07:46.805000 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' Sep 4 00:07:46.791386 unknown[1250]: fetched base config from "system" Sep 4 00:07:46.790922 ignition[1250]: parsing config with SHA512: cf83e1357eefb8bdf1542850d66d8007d620e4050b5715dc83f4a921d36ce9ce47d0d13c5d85f2b0ff8318d2877eec2f63b931bd47417a81a538327af927da3e Sep 4 00:07:46.791390 unknown[1250]: fetched base config from "system" Sep 4 00:07:46.790928 ignition[1250]: not a config (empty): provider config was empty, continuing with empty cache config Sep 4 00:07:46.799643 systemd[1]: Finished ignition-fetch.service - Ignition (fetch). Sep 4 00:07:46.796137 ignition[1250]: fetch: fetch complete Sep 4 00:07:46.808542 systemd[1]: Starting ignition-kargs.service - Ignition (kargs)... Sep 4 00:07:46.796142 ignition[1250]: fetch: fetch passed Sep 4 00:07:46.816546 systemd[1]: Mounted boot.mount - Boot partition. Sep 4 00:07:46.796197 ignition[1250]: Ignition finished successfully Sep 4 00:07:46.861098 ignition[1322]: Ignition 2.24.0 Sep 4 00:07:46.861115 ignition[1322]: Stage: kargs Sep 4 00:07:46.861306 ignition[1322]: no config dir at "/usr/lib/ignition/base.d" Sep 4 00:07:46.869343 systemd[1]: Finished ignition-kargs.service - Ignition (kargs). Sep 4 00:07:46.874000 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' Sep 4 00:07:46.861313 ignition[1322]: no config dir at "/usr/lib/ignition/base.platform.d/azure" Sep 4 00:07:46.877496 systemd[1]: Starting ignition-disks.service - Ignition (disks)... Sep 4 00:07:46.861576 ignition[1322]: kargs: kargs passed Sep 4 00:07:46.861617 ignition[1322]: Ignition finished successfully Sep 4 00:07:46.921293 systemd[1]: ignition-kargs.service: Deactivated successfully. Sep 4 00:07:46.921443 systemd[1]: Stopped ignition-kargs.service - Ignition (kargs). Sep 4 00:07:46.928000 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' Sep 4 00:07:46.931371 systemd[1]: ignition-fetch.service: Deactivated successfully. Sep 4 00:07:46.936000 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' Sep 4 00:07:46.931479 systemd[1]: Stopped ignition-fetch.service - Ignition (fetch). Sep 4 00:07:46.945000 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' Sep 4 00:07:46.939395 systemd[1]: ignition-fetch-offline.service: Deactivated successfully. Sep 4 00:07:46.939544 systemd[1]: Stopped ignition-fetch-offline.service - Ignition (fetch-offline). Sep 4 00:07:46.950344 systemd[1]: Unmounting oem.mount - /oem... Sep 4 00:07:46.976282 kernel: BTRFS info (device sda6): last unmount of filesystem 5699fa27-50b4-4cbc-8a33-b216a94fd2a3 Sep 4 00:07:46.976615 systemd[1]: oem.mount: Deactivated successfully. Sep 4 00:07:46.980141 systemd[1]: Unmounted oem.mount - /oem. Sep 4 00:07:47.005842 ignition[1344]: Ignition 2.24.0 Sep 4 00:07:47.008710 ignition[1344]: Stage: disks Sep 4 00:07:47.008920 ignition[1344]: no config dir at "/usr/lib/ignition/base.d" Sep 4 00:07:47.008927 ignition[1344]: no config dir at "/usr/lib/ignition/base.platform.d/azure" Sep 4 00:07:47.009181 ignition[1344]: disks: disks passed Sep 4 00:07:47.023000 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' Sep 4 00:07:47.017291 systemd[1]: Finished ignition-disks.service - Ignition (disks). Sep 4 00:07:47.009219 ignition[1344]: Ignition finished successfully Sep 4 00:07:47.025594 systemd[1]: Reached target initrd-root-device.target - Initrd Root Device. Sep 4 00:07:47.032159 systemd[1]: Reached target local-fs-pre.target - Preparation for Local File Systems. Sep 4 00:07:47.041243 systemd[1]: Reached target local-fs.target - Local File Systems. Sep 4 00:07:47.048419 systemd[1]: Reached target sysinit.target - System Initialization. Sep 4 00:07:47.057626 systemd[1]: Reached target basic.target - Basic System. Sep 4 00:07:47.068128 systemd[1]: Starting systemd-fsck-root.service - File System Check on /dev/disk/by-label/ROOT... Sep 4 00:07:47.204730 systemd-fsck[1355]: ROOT: clean, 15/6361680 files, 408771/6359552 blocks Sep 4 00:07:47.214207 systemd[1]: Finished systemd-fsck-root.service - File System Check on /dev/disk/by-label/ROOT. Sep 4 00:07:47.218000 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' Sep 4 00:07:47.781606 systemd[1]: Mounting sysroot.mount - /sysroot... Sep 4 00:07:48.033265 kernel: EXT4-fs (sda9): mounted filesystem 49011b77-792b-4ab9-a640-3c5f9964b5e2 r/w with ordered data mode. Quota mode: none. Sep 4 00:07:48.033921 systemd[1]: Mounted sysroot.mount - /sysroot. Sep 4 00:07:48.038163 systemd[1]: Reached target initrd-root-fs.target - Initrd Root File System. Sep 4 00:07:48.062862 systemd[1]: Mounting sysroot-usr.mount - /sysroot/usr... Sep 4 00:07:48.077414 systemd[1]: Starting flatcar-metadata-hostname.service - Flatcar Metadata Hostname Agent... Sep 4 00:07:48.083576 systemd[1]: ignition-remount-sysroot.service - Remount /sysroot read-write for Ignition skipped, unmet condition check ConditionPathIsReadWrite=!/sysroot Sep 4 00:07:48.083618 systemd[1]: Reached target ignition-diskful.target - Ignition Boot Disk Setup. Sep 4 00:07:48.095438 systemd[1]: Mounted sysroot-usr.mount - /sysroot/usr. Sep 4 00:07:48.120671 systemd[1]: Starting initrd-setup-root.service - Root filesystem setup... Sep 4 00:07:48.409394 systemd-tmpfiles[1394]: /sysroot/usr/lib/tmpfiles.d/base_image_var.conf:1: Duplicate line for path "/sysroot/var", ignoring. Sep 4 00:07:48.409419 systemd-tmpfiles[1394]: /sysroot/usr/lib/tmpfiles.d/base_image_var.conf:7: Duplicate line for path "/sysroot/var/empty", ignoring. Sep 4 00:07:48.409476 systemd-tmpfiles[1394]: /sysroot/usr/lib/tmpfiles.d/base_image_var.conf:28: Duplicate line for path "/sysroot/var/log", ignoring. Sep 4 00:07:48.614708 coreos-metadata[1374]: Sep 04 00:07:48.614 INFO Fetching http://168.63.129.16/?comp=versions: Attempt #1 Sep 4 00:07:48.623212 coreos-metadata[1374]: Sep 04 00:07:48.623 INFO Fetch successful Sep 4 00:07:48.627518 coreos-metadata[1374]: Sep 04 00:07:48.627 INFO Fetching http://169.254.169.254/metadata/instance/compute/name?api-version=2017-08-01&format=text: Attempt #1 Sep 4 00:07:48.637838 coreos-metadata[1374]: Sep 04 00:07:48.637 INFO Fetch successful Sep 4 00:07:48.691875 coreos-metadata[1374]: Sep 04 00:07:48.691 INFO wrote hostname ci-4757.1.0-n-5186669828 to /sysroot/etc/hostname Sep 4 00:07:48.700518 systemd[1]: Finished flatcar-metadata-hostname.service - Flatcar Metadata Hostname Agent. Sep 4 00:07:48.706000 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' Sep 4 00:07:48.729914 kernel: kauditd_printk_skb: 18 callbacks suppressed Sep 4 00:07:48.729933 kernel: audit: type=1130 audit(1788480468.706:40): 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' Sep 4 00:07:49.749252 kernel: loop1: detected capacity change from 0 to 43976 Sep 4 00:07:49.779256 kernel: loop1: p1 p2 p3 Sep 4 00:07:50.116886 kernel: device-mapper: verity: sha256 using shash "sha256-ce" Sep 4 00:07:50.116937 kernel: device-mapper: verity: Unrecognized verity feature request: root_hash_sig_key_desc Sep 4 00:07:50.121784 kernel: device-mapper: table: 254:1: verity: Unrecognized verity feature request (-EINVAL) Sep 4 00:07:50.125150 kernel: device-mapper: ioctl: error adding target to table Sep 4 00:07:50.125204 systemd-confext[1454]: device-mapper: reload ioctl on loop1p1-14-verity (254:1) failed: Invalid argument Sep 4 00:07:50.141248 kernel: device-mapper: verity: sha256 using shash "sha256-ce" Sep 4 00:07:50.278258 kernel: erofs: (device dm-1): mounted with root inode @ nid 40. Sep 4 00:07:50.299252 kernel: loop2: detected capacity change from 0 to 43976 Sep 4 00:07:50.302277 kernel: loop2: p1 p2 p3 Sep 4 00:07:50.315843 kernel: device-mapper: verity: sha256 using shash "sha256-ce" Sep 4 00:07:50.315893 kernel: device-mapper: verity: Unrecognized verity feature request: root_hash_sig_key_desc Sep 4 00:07:50.322975 kernel: device-mapper: table: 254:1: verity: Unrecognized verity feature request (-EINVAL) Sep 4 00:07:50.326338 kernel: device-mapper: ioctl: error adding target to table Sep 4 00:07:50.326279 (sd-merge)[1464]: device-mapper: reload ioctl on loop2p1-18-verity (254:1) failed: Invalid argument Sep 4 00:07:50.342033 kernel: device-mapper: verity: sha256 using shash "sha256-ce" Sep 4 00:07:50.356779 (sd-merge)[1464]: Using extensions '00-flatcar-default.raw'. Sep 4 00:07:50.357647 (sd-merge)[1464]: Merged extensions into '/sysroot/etc'. Sep 4 00:07:50.366421 kernel: erofs: (device dm-1): mounted with root inode @ nid 40. Sep 4 00:07:50.366443 initrd-setup-root[1471]: /etc 00-flatcar-default Fri 2026-09-04 00:07:43 UTC Sep 4 00:07:50.370290 systemd[1]: Finished initrd-setup-root.service - Root filesystem setup. Sep 4 00:07:50.375000 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' Sep 4 00:07:50.378295 systemd[1]: Starting ignition-mount.service - Ignition (mount)... Sep 4 00:07:50.401264 kernel: audit: type=1130 audit(1788480470.375:41): 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' Sep 4 00:07:50.440032 ignition[1477]: INFO : Ignition 2.24.0 Sep 4 00:07:50.444130 ignition[1477]: INFO : Stage: mount Sep 4 00:07:50.444130 ignition[1477]: INFO : no config dir at "/usr/lib/ignition/base.d" Sep 4 00:07:50.444130 ignition[1477]: INFO : no config dir at "/usr/lib/ignition/base.platform.d/azure" Sep 4 00:07:50.444130 ignition[1477]: INFO : mount: mount passed Sep 4 00:07:50.444130 ignition[1477]: INFO : Ignition finished successfully Sep 4 00:07:50.449000 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' Sep 4 00:07:50.485039 kernel: audit: type=1130 audit(1788480470.449:42): 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' Sep 4 00:07:50.446362 systemd[1]: Finished ignition-mount.service - Ignition (mount). Sep 4 00:07:50.468046 systemd[1]: Starting ignition-files.service - Ignition (files)... Sep 4 00:07:50.498912 systemd[1]: Mounting oem.mount - /oem... Sep 4 00:07:50.519244 kernel: BTRFS: device label OEM devid 1 transid 11 /dev/sda6 (8:6) scanned by mount (1488) Sep 4 00:07:50.530782 kernel: BTRFS info (device sda6): first mount of filesystem 5699fa27-50b4-4cbc-8a33-b216a94fd2a3 Sep 4 00:07:50.530843 kernel: BTRFS info (device sda6): using crc32c (crc32c-generic) checksum algorithm Sep 4 00:07:50.540140 kernel: BTRFS info (device sda6): turning on async discard Sep 4 00:07:50.540199 kernel: BTRFS info (device sda6): enabling free space tree Sep 4 00:07:50.542078 systemd[1]: Mounted oem.mount - /oem. Sep 4 00:07:50.549352 systemd[1]: Mounting sysroot-oem.mount - /sysroot/oem... Sep 4 00:07:50.565112 systemd[1]: Mounted sysroot-oem.mount - /sysroot/oem. Sep 4 00:07:50.591397 ignition[1507]: INFO : Ignition 2.24.0 Sep 4 00:07:50.594582 ignition[1507]: INFO : Stage: files Sep 4 00:07:50.594582 ignition[1507]: INFO : no config dir at "/usr/lib/ignition/base.d" Sep 4 00:07:50.594582 ignition[1507]: INFO : no config dir at "/usr/lib/ignition/base.platform.d/azure" Sep 4 00:07:50.594582 ignition[1507]: DEBUG : files: compiled without relabeling support, skipping Sep 4 00:07:50.594582 ignition[1507]: INFO : files: createResultFile: createFiles: op(1): [started] writing file "/sysroot/etc/.ignition-result.json" Sep 4 00:07:50.594582 ignition[1507]: INFO : files: createResultFile: createFiles: op(1): [finished] writing file "/sysroot/etc/.ignition-result.json" Sep 4 00:07:50.594582 ignition[1507]: INFO : files: files passed Sep 4 00:07:50.594582 ignition[1507]: INFO : Ignition finished successfully Sep 4 00:07:50.600000 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' Sep 4 00:07:50.657520 kernel: audit: type=1130 audit(1788480470.600:43): 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' Sep 4 00:07:50.595318 systemd[1]: Finished ignition-files.service - Ignition (files). Sep 4 00:07:50.618540 systemd[1]: Starting ignition-quench.service - Ignition (record completion)... Sep 4 00:07:50.648492 systemd[1]: Starting initrd-setup-root-after-ignition.service - Root filesystem completion... Sep 4 00:07:50.676000 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' Sep 4 00:07:50.676000 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' Sep 4 00:07:50.662466 systemd[1]: ignition-quench.service: Deactivated successfully. Sep 4 00:07:50.711958 kernel: audit: type=1130 audit(1788480470.676:44): 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' Sep 4 00:07:50.669365 systemd[1]: Finished ignition-quench.service - Ignition (record completion). Sep 4 00:07:50.717858 kernel: audit: type=1131 audit(1788480470.676:45): 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' Sep 4 00:07:50.729067 initrd-setup-root-after-ignition[1537]: grep: /sysroot/etc/flatcar/enabled-sysext.conf: No such file or directory Sep 4 00:07:50.729067 initrd-setup-root-after-ignition[1537]: grep: /sysroot/usr/share/flatcar/enabled-sysext.conf: No such file or directory Sep 4 00:07:50.743546 initrd-setup-root-after-ignition[1541]: grep: /sysroot/etc/flatcar/enabled-sysext.conf: No such file or directory Sep 4 00:07:50.754369 kernel: loop3: detected capacity change from 0 to 43976 Sep 4 00:07:50.757255 kernel: loop3: p1 p2 p3 Sep 4 00:07:50.771713 kernel: device-mapper: verity: sha256 using shash "sha256-ce" Sep 4 00:07:50.771753 kernel: device-mapper: verity: Unrecognized verity feature request: root_hash_sig_key_desc Sep 4 00:07:50.779024 kernel: device-mapper: table: 254:2: verity: Unrecognized verity feature request (-EINVAL) Sep 4 00:07:50.783935 kernel: device-mapper: ioctl: error adding target to table Sep 4 00:07:50.784180 systemd-confext[1543]: device-mapper: reload ioctl on loop3p1-21-verity (254:2) failed: Invalid argument Sep 4 00:07:50.801251 kernel: device-mapper: verity: sha256 using shash "sha256-ce" Sep 4 00:07:50.817264 kernel: erofs: (device dm-2): mounted with root inode @ nid 40. Sep 4 00:07:50.837255 kernel: loop4: detected capacity change from 0 to 43976 Sep 4 00:07:50.840837 kernel: loop4: p1 p2 p3 Sep 4 00:07:50.850778 kernel: device-mapper: verity: sha256 using shash "sha256-ce" Sep 4 00:07:50.850831 kernel: device-mapper: verity: Unrecognized verity feature request: root_hash_sig_key_desc Sep 4 00:07:50.856328 kernel: device-mapper: table: 254:2: verity: Unrecognized verity feature request (-EINVAL) Sep 4 00:07:50.859785 kernel: device-mapper: ioctl: error adding target to table Sep 4 00:07:50.859846 (sd-merge)[1552]: device-mapper: reload ioctl on loop4p1-25-verity (254:2) failed: Invalid argument Sep 4 00:07:50.871864 kernel: device-mapper: verity: sha256 using shash "sha256-ce" Sep 4 00:07:50.889859 (sd-merge)[1552]: Skipping extension refresh because no change was found, use --always-refresh=yes to always do a refresh. Sep 4 00:07:50.896813 kernel: erofs: (device dm-2): mounted with root inode @ nid 40. Sep 4 00:07:50.981305 kernel: loop4: detected capacity change from 0 to 142648 Sep 4 00:07:51.012018 kernel: loop4: p1 p2 p3 Sep 4 00:07:51.399251 kernel: device-mapper: verity: sha256 using shash "sha256-ce" Sep 4 00:07:51.399306 kernel: device-mapper: verity: Unrecognized verity feature request: root_hash_sig_key_desc Sep 4 00:07:51.405251 kernel: device-mapper: table: 254:2: verity: Unrecognized verity feature request (-EINVAL) Sep 4 00:07:51.408635 kernel: device-mapper: ioctl: error adding target to table Sep 4 00:07:51.408862 systemd-sysext[1560]: device-mapper: reload ioctl on loop4p1-29-verity (254:2) failed: Invalid argument Sep 4 00:07:51.421423 kernel: device-mapper: verity: sha256 using shash "sha256-ce" Sep 4 00:07:51.486263 kernel: erofs: (device dm-2): mounted with root inode @ nid 39. Sep 4 00:07:51.545349 kernel: loop5: detected capacity change from 0 to 364432 Sep 4 00:07:51.609260 kernel: loop5: p1 p2 p3 Sep 4 00:07:51.902314 kernel: device-mapper: verity: sha256 using shash "sha256-ce" Sep 4 00:07:51.902352 kernel: device-mapper: verity: Unrecognized verity feature request: root_hash_sig_key_desc Sep 4 00:07:51.907155 kernel: device-mapper: table: 254:2: verity: Unrecognized verity feature request (-EINVAL) Sep 4 00:07:51.910468 kernel: device-mapper: ioctl: error adding target to table Sep 4 00:07:51.910691 systemd-sysext[1560]: device-mapper: reload ioctl on loop5p1-33-verity (254:2) failed: Invalid argument Sep 4 00:07:51.921233 kernel: device-mapper: verity: sha256 using shash "sha256-ce" Sep 4 00:07:52.069254 kernel: erofs: (device dm-2): mounted with root inode @ nid 39. Sep 4 00:07:52.191284 kernel: loop6: detected capacity change from 0 to 172472 Sep 4 00:07:52.225252 kernel: loop6: p1 p2 p3 Sep 4 00:07:52.483274 kernel: device-mapper: verity: sha256 using shash "sha256-ce" Sep 4 00:07:52.483328 kernel: device-mapper: verity: Unrecognized verity feature request: root_hash_sig_key_desc Sep 4 00:07:52.488205 kernel: device-mapper: table: 254:2: verity: Unrecognized verity feature request (-EINVAL) Sep 4 00:07:52.491550 kernel: device-mapper: ioctl: error adding target to table Sep 4 00:07:52.491889 systemd-sysext[1560]: device-mapper: reload ioctl on loop6p1-37-verity (254:2) failed: Invalid argument Sep 4 00:07:52.504236 kernel: device-mapper: verity: sha256 using shash "sha256-ce" Sep 4 00:07:52.660247 kernel: erofs: (device dm-2): mounted with root inode @ nid 39. Sep 4 00:07:52.689247 kernel: loop7: detected capacity change from 0 to 142648 Sep 4 00:07:52.692527 kernel: loop7: p1 p2 p3 Sep 4 00:07:52.704510 kernel: device-mapper: verity: sha256 using shash "sha256-ce" Sep 4 00:07:52.704552 kernel: device-mapper: verity: Unrecognized verity feature request: root_hash_sig_key_desc Sep 4 00:07:52.715248 kernel: device-mapper: table: 254:2: verity: Unrecognized verity feature request (-EINVAL) Sep 4 00:07:52.718983 kernel: device-mapper: ioctl: error adding target to table Sep 4 00:07:52.719177 (sd-merge)[1584]: device-mapper: reload ioctl on loop7p1-41-verity (254:2) failed: Invalid argument Sep 4 00:07:52.736026 kernel: device-mapper: verity: sha256 using shash "sha256-ce" Sep 4 00:07:52.758253 kernel: erofs: (device dm-2): mounted with root inode @ nid 39. Sep 4 00:07:52.763251 kernel: loop1: detected capacity change from 0 to 364432 Sep 4 00:07:52.767382 kernel: loop1: p1 p2 p3 Sep 4 00:07:52.781361 kernel: device-mapper: verity: sha256 using shash "sha256-ce" Sep 4 00:07:52.781408 kernel: device-mapper: verity: Unrecognized verity feature request: root_hash_sig_key_desc Sep 4 00:07:52.786677 kernel: device-mapper: table: 254:3: verity: Unrecognized verity feature request (-EINVAL) Sep 4 00:07:52.790027 kernel: device-mapper: ioctl: error adding target to table Sep 4 00:07:52.790079 (sd-merge)[1584]: device-mapper: reload ioctl on loop1p1-45-verity (254:3) failed: Invalid argument Sep 4 00:07:52.801153 kernel: device-mapper: verity: sha256 using shash "sha256-ce" Sep 4 00:07:52.830268 kernel: erofs: (device dm-3): mounted with root inode @ nid 39. Sep 4 00:07:52.836286 kernel: loop3: detected capacity change from 0 to 172472 Sep 4 00:07:52.839435 kernel: loop3: p1 p2 p3 Sep 4 00:07:52.857189 kernel: device-mapper: verity: sha256 using shash "sha256-ce" Sep 4 00:07:52.857239 kernel: device-mapper: verity: Unrecognized verity feature request: root_hash_sig_key_desc Sep 4 00:07:52.864616 kernel: device-mapper: table: 254:4: verity: Unrecognized verity feature request (-EINVAL) Sep 4 00:07:52.868004 kernel: device-mapper: ioctl: error adding target to table Sep 4 00:07:52.868178 (sd-merge)[1584]: device-mapper: reload ioctl on loop3p1-49-verity (254:4) failed: Invalid argument Sep 4 00:07:52.880811 kernel: device-mapper: verity: sha256 using shash "sha256-ce" Sep 4 00:07:52.911256 kernel: erofs: (device dm-4): mounted with root inode @ nid 39. Sep 4 00:07:52.911381 (sd-merge)[1584]: Using extensions 'containerd-flatcar.raw', 'docker-flatcar.raw', 'oem-azure-4757.1.0+nightly-20260903-2100.raw'. Sep 4 00:07:52.912267 (sd-merge)[1584]: Merged extensions into '/sysroot/usr'. Sep 4 00:07:52.926277 systemd[1]: Finished initrd-setup-root-after-ignition.service - Root filesystem completion. Sep 4 00:07:52.930000 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' Sep 4 00:07:52.933420 systemd[1]: Starting initrd-parse-etc.service - Mountpoints Configured in the Real Root... Sep 4 00:07:52.960315 kernel: audit: type=1130 audit(1788480472.930:46): 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' Sep 4 00:07:52.980525 systemd[1]: initrd-parse-etc.service: Deactivated successfully. Sep 4 00:07:52.984392 systemd[1]: Finished initrd-parse-etc.service - Mountpoints Configured in the Real Root. Sep 4 00:07:52.988000 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' Sep 4 00:07:52.990237 systemd[1]: initrd-parse-etc.service: Triggering OnSuccess= dependencies. Sep 4 00:07:52.988000 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' Sep 4 00:07:53.025561 kernel: audit: type=1130 audit(1788480472.988:47): 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' Sep 4 00:07:52.991969 systemd[1]: Reached target initrd-fs.target - Initrd File Systems. Sep 4 00:07:53.031018 kernel: audit: type=1131 audit(1788480472.988:48): 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' Sep 4 00:07:53.026417 systemd[1]: Starting dracut-mount.service - dracut mount hook... Sep 4 00:07:53.373286 systemd[1]: Finished dracut-mount.service - dracut mount hook. Sep 4 00:07:53.376000 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' Sep 4 00:07:53.394284 kernel: audit: type=1130 audit(1788480473.376:49): 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' Sep 4 00:07:53.394646 systemd[1]: Starting dracut-pre-pivot.service - dracut pre-pivot and cleanup hook... Sep 4 00:07:53.421314 systemd[1]: Finished dracut-pre-pivot.service - dracut pre-pivot and cleanup hook. Sep 4 00:07:53.425000 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' Sep 4 00:07:53.430416 systemd[1]: Starting initrd-cleanup.service - Cleaning Up and Shutting Down Daemons... Sep 4 00:07:53.454219 systemd[1]: Stopped target basic.target - Basic System. Sep 4 00:07:53.461910 systemd[1]: Stopped target ignition-diskful.target - Ignition Boot Disk Setup. Sep 4 00:07:53.467174 systemd[1]: Stopped target initrd-root-device.target - Initrd Root Device. Sep 4 00:07:53.476087 systemd[1]: Stopped target initrd-usr-fs.target - Initrd /usr File System. Sep 4 00:07:53.485038 systemd[1]: Stopped target nss-lookup.target - Host and Network Name Lookups. Sep 4 00:07:53.493779 systemd[1]: Stopped target paths.target - Path Units. Sep 4 00:07:53.503018 systemd[1]: Stopped target remote-cryptsetup.target - Remote Encrypted Volumes. Sep 4 00:07:53.511434 systemd[1]: Stopped target slices.target - Slice Units. Sep 4 00:07:53.520290 systemd[1]: Stopped target sockets.target - Socket Units. Sep 4 00:07:53.527367 systemd[1]: Stopped target sysinit.target - System Initialization. Sep 4 00:07:53.535597 systemd[1]: Stopped target local-fs.target - Local File Systems. Sep 4 00:07:53.544292 systemd[1]: Stopped target local-fs-pre.target - Preparation for Local File Systems. Sep 4 00:07:53.553321 systemd[1]: Stopped target swap.target - Swaps. Sep 4 00:07:53.561742 systemd[1]: Stopped target timers.target - Timer Units. Sep 4 00:07:53.568369 systemd[1]: iscsid.socket: Deactivated successfully. Sep 4 00:07:53.568516 systemd[1]: Closed iscsid.socket - Open-iSCSI iscsid Socket. Sep 4 00:07:53.579699 systemd[1]: iscsiuio.socket: Deactivated successfully. Sep 4 00:07:53.579819 systemd[1]: Closed iscsiuio.socket - Open-iSCSI iscsiuio Socket. Sep 4 00:07:53.590930 systemd[1]: systemd-coredump.socket: Deactivated successfully. Sep 4 00:07:53.591044 systemd[1]: Closed systemd-coredump.socket - Process Core Dump Socket. Sep 4 00:07:53.612000 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' Sep 4 00:07:53.597905 systemd[1]: systemd-journald-audit.socket: Deactivated successfully. Sep 4 00:07:53.598043 systemd[1]: Closed systemd-journald-audit.socket - Journal Audit Socket. Sep 4 00:07:53.605926 systemd[1]: dracut-pre-pivot.service: Deactivated successfully. Sep 4 00:07:53.640000 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' Sep 4 00:07:53.606087 systemd[1]: Stopped dracut-pre-pivot.service - dracut pre-pivot and cleanup hook. Sep 4 00:07:53.617936 systemd[1]: Stopped target remote-fs.target - Remote File Systems. Sep 4 00:07:53.657000 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' Sep 4 00:07:53.622764 systemd[1]: Stopped target remote-fs-pre.target - Preparation for Remote File Systems. Sep 4 00:07:53.632852 systemd[1]: dracut-mount.service: Deactivated successfully. Sep 4 00:07:53.633153 systemd[1]: Stopped dracut-mount.service - dracut mount hook. Sep 4 00:07:53.647036 systemd[1]: dracut-pre-mount.service: Deactivated successfully. Sep 4 00:07:53.647187 systemd[1]: Stopped dracut-pre-mount.service - dracut pre-mount hook. Sep 4 00:07:53.711000 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' Sep 4 00:07:53.719772 kernel: kauditd_printk_skb: 4 callbacks suppressed Sep 4 00:07:53.661963 systemd[1]: Stopped target cryptsetup.target - Local Encrypted Volumes. Sep 4 00:07:53.741841 kernel: audit: type=1131 audit(1788480473.711:54): 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' Sep 4 00:07:53.667573 systemd[1]: systemd-ask-password-console.path: Deactivated successfully. Sep 4 00:07:53.740000 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' Sep 4 00:07:53.667942 systemd[1]: Stopped systemd-ask-password-console.path - Dispatch Password Requests to Console Directory Watch. Sep 4 00:07:53.687671 systemd[1]: Stopped target cryptsetup-pre.target - Local Encrypted Volumes (Pre). Sep 4 00:07:53.769000 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' Sep 4 00:07:53.786487 kernel: audit: type=1131 audit(1788480473.740:55): 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' Sep 4 00:07:53.695328 systemd[1]: clevis-luks-askpass.path: Deactivated successfully. Sep 4 00:07:53.790690 kernel: audit: type=1131 audit(1788480473.769:56): 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' Sep 4 00:07:53.695704 systemd[1]: Stopped clevis-luks-askpass.path - Forward Password Requests to Clevis Directory Watch. Sep 4 00:07:53.704337 systemd[1]: dracut-initqueue.service: Deactivated successfully. Sep 4 00:07:53.801000 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' Sep 4 00:07:53.704520 systemd[1]: Stopped dracut-initqueue.service - dracut initqueue hook. Sep 4 00:07:53.727066 systemd[1]: initrd-setup-root-after-ignition.service: Deactivated successfully. Sep 4 00:07:53.828596 kernel: audit: type=1131 audit(1788480473.801:57): 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' Sep 4 00:07:53.727216 systemd[1]: Stopped initrd-setup-root-after-ignition.service - Root filesystem completion. Sep 4 00:07:53.760494 systemd[1]: ignition-files.service: Deactivated successfully. Sep 4 00:07:53.760639 systemd[1]: Stopped ignition-files.service - Ignition (files). Sep 4 00:07:53.791411 systemd[1]: flatcar-metadata-hostname.service: Deactivated successfully. Sep 4 00:07:53.850000 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' Sep 4 00:07:53.791598 systemd[1]: Stopped flatcar-metadata-hostname.service - Flatcar Metadata Hostname Agent. Sep 4 00:07:53.878172 kernel: audit: type=1131 audit(1788480473.850:58): 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' Sep 4 00:07:53.829512 systemd[1]: Stopping ignition-mount.service - Ignition (mount)... Sep 4 00:07:53.881000 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' Sep 4 00:07:53.893652 ignition[1659]: INFO : Ignition 2.24.0 Sep 4 00:07:53.893652 ignition[1659]: INFO : Stage: umount Sep 4 00:07:53.893652 ignition[1659]: INFO : no config dir at "/usr/lib/ignition/base.d" Sep 4 00:07:53.893652 ignition[1659]: INFO : no config dir at "/usr/lib/ignition/base.platform.d/azure" Sep 4 00:07:53.893652 ignition[1659]: INFO : umount: umount passed Sep 4 00:07:53.893652 ignition[1659]: INFO : Ignition finished successfully Sep 4 00:07:53.905000 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' Sep 4 00:07:53.936000 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' Sep 4 00:07:53.843182 systemd[1]: systemd-modules-load.service: Deactivated successfully. Sep 4 00:07:53.957687 kernel: audit: type=1131 audit(1788480473.881:59): 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' Sep 4 00:07:53.843383 systemd[1]: Stopped systemd-modules-load.service - Load Kernel Modules. Sep 4 00:07:53.962335 kernel: audit: type=1131 audit(1788480473.905:60): 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' Sep 4 00:07:53.872314 systemd[1]: systemd-tmpfiles-setup.service: Deactivated successfully. Sep 4 00:07:53.966685 kernel: audit: type=1131 audit(1788480473.936:61): 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' Sep 4 00:07:53.872450 systemd[1]: Stopped systemd-tmpfiles-setup.service - Create System Files and Directories. Sep 4 00:07:53.970000 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' Sep 4 00:07:53.900411 systemd[1]: systemd-udev-trigger.service: Deactivated successfully. Sep 4 00:07:53.900549 systemd[1]: Stopped systemd-udev-trigger.service - Coldplug All udev Devices. Sep 4 00:07:53.998159 kernel: audit: type=1131 audit(1788480473.970:62): 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' Sep 4 00:07:53.929842 systemd[1]: dracut-pre-trigger.service: Deactivated successfully. Sep 4 00:07:53.930086 systemd[1]: Stopped dracut-pre-trigger.service - dracut pre-trigger hook. Sep 4 00:07:54.007000 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' Sep 4 00:07:53.961574 systemd[1]: ignition-mount.service: Deactivated successfully. Sep 4 00:07:54.007000 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' Sep 4 00:07:54.029472 kernel: audit: type=1130 audit(1788480474.007:63): 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' Sep 4 00:07:53.962825 systemd[1]: Stopped ignition-mount.service - Ignition (mount). Sep 4 00:07:53.999379 systemd[1]: initrd-cleanup.service: Deactivated successfully. Sep 4 00:07:54.002261 systemd[1]: Finished initrd-cleanup.service - Cleaning Up and Shutting Down Daemons. Sep 4 00:07:54.045000 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' Sep 4 00:07:54.031461 systemd[1]: Stopped target network.target - Network. Sep 4 00:07:54.055000 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' Sep 4 00:07:54.038329 systemd[1]: ignition-disks.service: Deactivated successfully. Sep 4 00:07:54.064000 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' Sep 4 00:07:54.038402 systemd[1]: Stopped ignition-disks.service - Ignition (disks). Sep 4 00:07:54.051969 systemd[1]: ignition-setup-pre.service: Deactivated successfully. Sep 4 00:07:54.052030 systemd[1]: Stopped ignition-setup-pre.service - Ignition env setup. Sep 4 00:07:54.058655 systemd[1]: initrd-setup-root.service: Deactivated successfully. Sep 4 00:07:54.099000 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' Sep 4 00:07:54.104000 audit: BPF prog-id=8 op=UNLOAD Sep 4 00:07:54.058707 systemd[1]: Stopped initrd-setup-root.service - Root filesystem setup. Sep 4 00:07:54.069286 systemd[1]: Stopping systemd-networkd.service - Network Management... Sep 4 00:07:54.077322 systemd[1]: Stopping systemd-resolved.service - Network Name Resolution... Sep 4 00:07:54.118000 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' Sep 4 00:07:54.090855 systemd[1]: systemd-networkd.service: Deactivated successfully. Sep 4 00:07:54.093131 systemd[1]: Stopped systemd-networkd.service - Network Management. Sep 4 00:07:54.132000 audit: BPF prog-id=5 op=UNLOAD Sep 4 00:07:54.111093 systemd[1]: systemd-resolved.service: Deactivated successfully. Sep 4 00:07:54.113277 systemd[1]: Stopped systemd-resolved.service - Network Name Resolution. Sep 4 00:07:54.127558 systemd[1]: Stopped target network-pre.target - Preparation for Network. Sep 4 00:07:54.133501 systemd[1]: systemd-networkd-resolve-hook.socket: Deactivated successfully. Sep 4 00:07:54.133591 systemd[1]: Closed systemd-networkd-resolve-hook.socket - Network Management Resolve Hook Socket. Sep 4 00:07:54.145903 systemd[1]: systemd-networkd.socket: Deactivated successfully. Sep 4 00:07:54.145956 systemd[1]: Closed systemd-networkd.socket - Network Management Netlink Socket. Sep 4 00:07:54.184000 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' Sep 4 00:07:54.156347 systemd[1]: Stopping network-cleanup.service - Network Cleanup... Sep 4 00:07:54.169927 systemd[1]: parse-ip-for-networkd.service: Deactivated successfully. Sep 4 00:07:54.169987 systemd[1]: Stopped parse-ip-for-networkd.service - Write systemd-networkd units from cmdline. Sep 4 00:07:54.186814 systemd[1]: Stopping systemd-udevd.service - Rule-based Manager for Device Events and Files... Sep 4 00:07:54.221202 systemd[1]: systemd-udevd.service: Deactivated successfully. Sep 4 00:07:54.225387 systemd[1]: Stopped systemd-udevd.service - Rule-based Manager for Device Events and Files. Sep 4 00:07:54.230000 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' Sep 4 00:07:54.231910 systemd[1]: systemd-udevd.service: Consumed 1.121s CPU time over 10.181s wall clock time. Sep 4 00:07:54.233555 systemd[1]: systemd-udevd-control.socket: Deactivated successfully. Sep 4 00:07:54.251000 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' Sep 4 00:07:54.233601 systemd[1]: Closed systemd-udevd-control.socket - udev Control Socket. Sep 4 00:07:54.259000 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' Sep 4 00:07:54.244093 systemd[1]: dracut-pre-udev.service: Deactivated successfully. Sep 4 00:07:54.269000 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' Sep 4 00:07:54.244143 systemd[1]: Stopped dracut-pre-udev.service - dracut pre-udev hook. Sep 4 00:07:54.255915 systemd[1]: dracut-cmdline.service: Deactivated successfully. Sep 4 00:07:54.255962 systemd[1]: Stopped dracut-cmdline.service - dracut cmdline hook. Sep 4 00:07:54.263887 systemd[1]: dracut-cmdline-ask.service: Deactivated successfully. Sep 4 00:07:54.304157 kernel: hv_netvsc 0022487b-8ce2-0022-487b-8ce20022487b eth0: Data path switched from VF: enP35451s1 Sep 4 00:07:54.263936 systemd[1]: Stopped dracut-cmdline-ask.service - dracut ask for additional cmdline parameters. Sep 4 00:07:54.310000 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' Sep 4 00:07:54.279419 systemd[1]: Starting initrd-udevadm-cleanup-db.service - Cleanup udev Database... Sep 4 00:07:54.300012 systemd[1]: systemd-network-generator.service: Deactivated successfully. Sep 4 00:07:54.325000 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' Sep 4 00:07:54.300070 systemd[1]: Stopped systemd-network-generator.service - Generate Network Units from Kernel Command Line. Sep 4 00:07:54.335000 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' Sep 4 00:07:54.316341 systemd[1]: systemd-tmpfiles-setup-dev.service: Deactivated successfully. Sep 4 00:07:54.345000 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' Sep 4 00:07:54.316386 systemd[1]: Stopped systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev. Sep 4 00:07:54.355000 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' Sep 4 00:07:54.329957 systemd[1]: systemd-tmpfiles-setup-dev-early.service: Deactivated successfully. Sep 4 00:07:54.330008 systemd[1]: Stopped systemd-tmpfiles-setup-dev-early.service - Create Static Device Nodes in /dev gracefully. Sep 4 00:07:54.369000 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' Sep 4 00:07:54.369000 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' Sep 4 00:07:54.339918 systemd[1]: kmod-static-nodes.service: Deactivated successfully. Sep 4 00:07:54.339966 systemd[1]: Stopped kmod-static-nodes.service - Create List of Static Device Nodes. Sep 4 00:07:54.349913 systemd[1]: systemd-vconsole-setup.service: Deactivated successfully. Sep 4 00:07:54.349964 systemd[1]: Stopped systemd-vconsole-setup.service - Virtual Console Setup. Sep 4 00:07:54.360188 systemd[1]: initrd-udevadm-cleanup-db.service: Deactivated successfully. Sep 4 00:07:54.363268 systemd[1]: Finished initrd-udevadm-cleanup-db.service - Cleanup udev Database. Sep 4 00:07:54.403000 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' Sep 4 00:07:54.395587 systemd[1]: network-cleanup.service: Deactivated successfully. Sep 4 00:07:54.396619 systemd[1]: Stopped network-cleanup.service - Network Cleanup. Sep 4 00:07:54.406114 systemd[1]: Reached target initrd-switch-root.target - Switch Root. Sep 4 00:07:54.414863 systemd[1]: Starting initrd-switch-root.service - Switch Root... Sep 4 00:07:54.444438 systemd[1]: Switching root. Sep 4 00:07:54.619348 systemd-journald[559]: Journal stopped Sep 4 00:08:00.338909 systemd-journald[559]: Received SIGTERM from PID 1 (systemd). Sep 4 00:08:00.338945 kernel: SELinux: policy capability network_peer_controls=1 Sep 4 00:08:00.338958 kernel: SELinux: policy capability open_perms=1 Sep 4 00:08:00.338968 kernel: SELinux: policy capability extended_socket_class=1 Sep 4 00:08:00.338974 kernel: SELinux: policy capability always_check_network=0 Sep 4 00:08:00.338984 kernel: SELinux: policy capability cgroup_seclabel=1 Sep 4 00:08:00.338993 kernel: SELinux: policy capability nnp_nosuid_transition=1 Sep 4 00:08:00.338999 kernel: SELinux: policy capability genfs_seclabel_symlinks=0 Sep 4 00:08:00.339006 kernel: SELinux: policy capability ioctl_skip_cloexec=0 Sep 4 00:08:00.339014 kernel: SELinux: policy capability userspace_initial_context=0 Sep 4 00:08:00.339021 systemd[1]: Successfully loaded SELinux policy in 169.035ms. Sep 4 00:08:00.339031 systemd[1]: Relabeled /dev/, /dev/shm/, /run/ in 5.981ms. Sep 4 00:08:00.339039 systemd[1]: systemd 260.1 running in system mode (+PAM +AUDIT +SELINUX -APPARMOR +IMA +IPE +SMACK +SECCOMP -GCRYPT -GNUTLS +OPENSSL -ACL +BLKID +CURL +ELFUTILS -FIDO2 +IDN2 +KMOD +LIBCRYPTSETUP +LIBCRYPTSETUP_PLUGINS +LIBFDISK +PCRE2 -PWQUALITY -P11KIT -QRENCODE +TPM2 +BZIP2 +LZ4 +XZ +ZLIB +ZSTD -BPF_FRAMEWORK -BTF -XKBCOMMON +UTMP +LIBARCHIVE) Sep 4 00:08:00.339047 systemd[1]: Detected virtualization microsoft. Sep 4 00:08:00.339055 systemd[1]: Detected architecture arm64. Sep 4 00:08:00.339063 systemd[1]: Detected first boot. Sep 4 00:08:00.339071 systemd[1]: Initializing machine ID from random generator. Sep 4 00:08:00.339080 systemd[1]: Hostname set to . Sep 4 00:08:00.339087 zram_generator::config[1947]: No configuration found. Sep 4 00:08:00.339098 kernel: NET: Registered PF_VSOCK protocol family Sep 4 00:08:00.339103 systemd[1]: Applying preset policy. Sep 4 00:08:00.339111 systemd[1]: Populated /etc with preset unit settings. Sep 4 00:08:00.339117 kernel: kauditd_printk_skb: 25 callbacks suppressed Sep 4 00:08:00.339127 kernel: audit: type=1334 audit(1788480479.376:89): prog-id=10 op=LOAD Sep 4 00:08:00.339134 kernel: audit: type=1334 audit(1788480479.376:90): prog-id=2 op=UNLOAD Sep 4 00:08:00.339139 kernel: audit: type=1334 audit(1788480479.376:91): prog-id=11 op=LOAD Sep 4 00:08:00.339147 kernel: audit: type=1334 audit(1788480479.376:92): prog-id=12 op=LOAD Sep 4 00:08:00.339154 kernel: audit: type=1334 audit(1788480479.376:93): prog-id=3 op=UNLOAD Sep 4 00:08:00.339161 kernel: audit: type=1334 audit(1788480479.376:94): prog-id=4 op=UNLOAD Sep 4 00:08:00.339169 kernel: audit: type=1334 audit(1788480479.392:95): prog-id=10 op=UNLOAD Sep 4 00:08:00.339177 kernel: audit: type=1131 audit(1788480479.484:96): 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' Sep 4 00:08:00.339184 systemd[1]: initrd-switch-root.service: Deactivated successfully. Sep 4 00:08:00.339191 systemd[1]: Stopped initrd-switch-root.service - Switch Root. Sep 4 00:08:00.339198 kernel: audit: type=1130 audit(1788480479.509:97): pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=initrd-switch-root comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Sep 4 00:08:00.339206 systemd[1]: systemd-journald.service: Scheduled restart job, restart counter is at 1. Sep 4 00:08:00.339212 kernel: audit: type=1131 audit(1788480479.509:98): pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=initrd-switch-root comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Sep 4 00:08:00.339220 systemd[1]: Created slice system-addon\x2dconfig.slice - Slice /system/addon-config. Sep 4 00:08:00.339251 systemd[1]: Created slice system-addon\x2drun.slice - Slice /system/addon-run. Sep 4 00:08:00.339259 systemd[1]: Created slice system-getty.slice - Slice /system/getty. Sep 4 00:08:00.339265 systemd[1]: Created slice system-modprobe.slice - Slice /system/modprobe. Sep 4 00:08:00.339273 systemd[1]: Created slice system-serial\x2dgetty.slice - Slice /system/serial-getty. Sep 4 00:08:00.339279 systemd[1]: Created slice system-system\x2dcloudinit.slice - Slice /system/system-cloudinit. Sep 4 00:08:00.339286 systemd[1]: Created slice system-systemd\x2dfsck.slice - Slice /system/systemd-fsck. Sep 4 00:08:00.339292 systemd[1]: Created slice user.slice - User and Session Slice. Sep 4 00:08:00.339298 systemd[1]: Started clevis-luks-askpass.path - Forward Password Requests to Clevis Directory Watch. Sep 4 00:08:00.339306 systemd[1]: Started systemd-ask-password-console.path - Dispatch Password Requests to Console Directory Watch. Sep 4 00:08:00.339312 systemd[1]: Started systemd-ask-password-wall.path - Forward Password Requests to Wall Directory Watch. Sep 4 00:08:00.339319 systemd[1]: Set up automount boot.automount - Boot partition Automount Point. Sep 4 00:08:00.339325 systemd[1]: Set up automount proc-sys-fs-binfmt_misc.automount - Arbitrary Executable File Formats File System Automount Point. Sep 4 00:08:00.339334 systemd[1]: Expecting device dev-disk-by\x2dlabel-OEM.device - /dev/disk/by-label/OEM... Sep 4 00:08:00.339340 systemd[1]: Expecting device dev-ptp_hyperv.device - /dev/ptp_hyperv... Sep 4 00:08:00.339348 systemd[1]: Expecting device dev-ttyAMA0.device - /dev/ttyAMA0... Sep 4 00:08:00.339355 systemd[1]: Reached target cryptsetup-pre.target - Local Encrypted Volumes (Pre). Sep 4 00:08:00.339361 systemd[1]: Reached target cryptsetup.target - Local Encrypted Volumes. Sep 4 00:08:00.339367 systemd[1]: Reached target imports.target - Image Downloads. Sep 4 00:08:00.339374 systemd[1]: Stopped target initrd-switch-root.target - Switch Root. Sep 4 00:08:00.339380 systemd[1]: Stopped target initrd-fs.target - Initrd File Systems. Sep 4 00:08:00.339386 systemd[1]: Stopped target initrd-root-fs.target - Initrd Root File System. Sep 4 00:08:00.339393 systemd[1]: Reached target integritysetup.target - Local Integrity Protected Volumes. Sep 4 00:08:00.339403 systemd[1]: Reached target remote-cryptsetup.target - Remote Encrypted Volumes. Sep 4 00:08:00.339409 systemd[1]: Reached target remote-fs.target - Remote File Systems. Sep 4 00:08:00.339415 systemd[1]: Reached target remote-integritysetup.target - Remote Integrity Protected Volumes. Sep 4 00:08:00.339421 systemd[1]: Reached target remote-veritysetup.target - Remote Verity Protected Volumes. Sep 4 00:08:00.339429 systemd[1]: Reached target slices.target - Slice Units. Sep 4 00:08:00.339435 systemd[1]: Reached target swap.target - Swaps. Sep 4 00:08:00.339441 systemd[1]: Reached target veritysetup.target - Local Verity Protected Volumes. Sep 4 00:08:00.339448 systemd[1]: Listening on systemd-ask-password.socket - Query the User Interactively for a Password. Sep 4 00:08:00.339454 systemd[1]: Listening on systemd-coredump.socket - Process Core Dump Socket. Sep 4 00:08:00.339462 systemd[1]: Listening on systemd-creds.socket - Credential Encryption/Decryption. Sep 4 00:08:00.339468 systemd[1]: Listening on systemd-factory-reset.socket - Factory Reset Management. Sep 4 00:08:00.339475 systemd[1]: Listening on systemd-journald-audit.socket - Journal Audit Socket. Sep 4 00:08:00.339481 systemd[1]: Listening on systemd-mountfsd.socket - DDI File System Mounter Socket. Sep 4 00:08:00.339488 systemd[1]: Listening on systemd-mute-console.socket - Console Output Muting Service Socket. Sep 4 00:08:00.339494 systemd[1]: Listening on systemd-networkd-resolve-hook.socket - Network Management Resolve Hook Socket. Sep 4 00:08:00.339501 systemd[1]: Listening on systemd-networkd-varlink-metrics.socket - Network Management Metrics Varlink Socket. Sep 4 00:08:00.339508 systemd[1]: Listening on systemd-networkd-varlink.socket - Network Management Varlink Socket. Sep 4 00:08:00.339516 systemd[1]: Listening on systemd-networkd.socket - Network Management Netlink Socket. Sep 4 00:08:00.339522 systemd[1]: Listening on systemd-nsresourced.socket - Namespace Resource Manager Socket. Sep 4 00:08:00.339530 systemd[1]: Listening on systemd-oomd.socket - Userspace Out-Of-Memory (OOM) Killer Socket. Sep 4 00:08:00.339536 systemd[1]: Listening on systemd-repart.socket - Disk Repartitioning Service Socket. Sep 4 00:08:00.339543 systemd[1]: Listening on systemd-resolved-monitor.socket - Resolve Monitor Varlink Socket. Sep 4 00:08:00.339550 systemd[1]: Listening on systemd-resolved-varlink.socket - Resolve Service Varlink Socket. Sep 4 00:08:00.339557 systemd[1]: Listening on systemd-udevd-control.socket - udev Control Socket. Sep 4 00:08:00.339563 systemd[1]: Listening on systemd-udevd-varlink.socket - udev Varlink Socket. Sep 4 00:08:00.339569 systemd[1]: Listening on systemd-userdbd.socket - User Database Manager Socket. Sep 4 00:08:00.339576 systemd[1]: Mounting dev-hugepages.mount - Huge Pages File System... Sep 4 00:08:00.339582 systemd[1]: Mounting dev-mqueue.mount - POSIX Message Queue File System... Sep 4 00:08:00.339588 systemd[1]: Mounting media.mount - External Media Directory... Sep 4 00:08:00.339596 systemd[1]: Mounting sys-kernel-debug.mount - Kernel Debug File System... Sep 4 00:08:00.339603 systemd[1]: Mounting sys-kernel-tracing.mount - Kernel Trace File System... Sep 4 00:08:00.339610 systemd[1]: tmp.mount: x-systemd.graceful-option=usrquota specified, but option is not available, suppressing. Sep 4 00:08:00.339616 systemd[1]: Mounting tmp.mount - Temporary Directory /tmp... Sep 4 00:08:00.339623 systemd[1]: Starting flatcar-tmpfiles.service - Create missing system files... Sep 4 00:08:00.339629 systemd[1]: ignition-delete-config.service - Ignition (delete config) skipped, no trigger condition checks were met. Sep 4 00:08:00.339636 systemd[1]: Starting kmod-static-nodes.service - Create List of Static Device Nodes... Sep 4 00:08:00.339643 systemd[1]: Starting modprobe@configfs.service - Load Kernel Module configfs... Sep 4 00:08:00.339650 systemd[1]: modprobe@drm.service - Load Kernel Module drm skipped, unmet condition check ConditionKernelModuleLoaded=!drm Sep 4 00:08:00.339656 systemd[1]: Starting modprobe@efi_pstore.service - Load Kernel Module efi_pstore... Sep 4 00:08:00.339663 systemd[1]: Starting modprobe@fuse.service - Load Kernel Module fuse... Sep 4 00:08:00.339669 systemd[1]: setup-nsswitch.service - Create /etc/nsswitch.conf skipped, unmet condition check ConditionPathExists=!/etc/nsswitch.conf Sep 4 00:08:00.339677 systemd[1]: systemd-fsck-root.service: Deactivated successfully. Sep 4 00:08:00.339685 systemd[1]: Stopped systemd-fsck-root.service - File System Check on Root Device. Sep 4 00:08:00.339691 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 Sep 4 00:08:00.339698 systemd[1]: Starting systemd-journald.service - Journal Service... Sep 4 00:08:00.339704 systemd[1]: Starting systemd-modules-load.service - Load Kernel Modules... Sep 4 00:08:00.339730 systemd-journald[2024]: Collecting audit messages is enabled. Sep 4 00:08:00.339747 systemd-journald[2024]: Journal started Sep 4 00:08:00.339762 systemd-journald[2024]: Runtime Journal (/run/log/journal/4a7084ed639a4dc992640b769b32f4df) is 8M, max 78.3M, 70.3M free. Sep 4 00:07:59.891000 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 Sep 4 00:08:00.275000 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' Sep 4 00:08:00.287000 audit: BPF prog-id=12 op=UNLOAD Sep 4 00:08:00.287000 audit: BPF prog-id=11 op=UNLOAD Sep 4 00:08:00.287000 audit: BPF prog-id=13 op=LOAD Sep 4 00:08:00.287000 audit: BPF prog-id=14 op=LOAD Sep 4 00:08:00.287000 audit: BPF prog-id=15 op=LOAD Sep 4 00:08:00.335000 audit: CONFIG_CHANGE op=set audit_enabled=1 old=1 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 res=1 Sep 4 00:08:00.335000 audit[2024]: SYSCALL arch=c00000b7 syscall=211 success=yes exit=60 a0=5 a1=ffffd1c76f30 a2=4000 a3=0 items=0 ppid=1 pid=2024 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) Sep 4 00:08:00.335000 audit: PROCTITLE proctitle="/usr/lib/systemd/systemd-journald" Sep 4 00:07:59.276813 systemd[1]: Queued start job for default target multi-user.target. Sep 4 00:08:00.343496 systemd[1]: Starting systemd-network-generator.service - Generate Network Units from Kernel Command Line... Sep 4 00:07:59.378104 systemd[1]: Unnecessary job was removed for dev-sda6.device - /dev/sda6. Sep 4 00:07:59.382917 systemd[1]: systemd-journald.service: Deactivated successfully. Sep 4 00:07:59.485584 systemd[1]: systemd-journald.service: Consumed 2.670s CPU time over 16.409s wall clock time. Sep 4 00:08:00.352253 kernel: fuse: init (API version 7.41) Sep 4 00:08:00.368368 systemd[1]: Reached target time-set.target - System Time Set. Sep 4 00:08:00.369090 systemd-modules-load[2028]: Using 2 probe threads Sep 4 00:08:00.376251 systemd[1]: Starting systemd-remount-fs.service - Remount Root and Kernel File Systems... Sep 4 00:08:00.404610 systemd[1]: Starting systemd-udev-load-credentials.service - Load udev Rules from Credentials... Sep 4 00:08:00.417636 systemd[1]: Starting systemd-udev-trigger.service - Coldplug All udev Devices... Sep 4 00:08:00.434273 systemd[1]: Started systemd-journald.service - Journal Service. Sep 4 00:08:00.433000 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' Sep 4 00:08:00.435102 systemd[1]: Mounted dev-hugepages.mount - Huge Pages File System. Sep 4 00:08:00.439428 systemd[1]: Mounted dev-mqueue.mount - POSIX Message Queue File System. Sep 4 00:08:00.443828 systemd[1]: Mounted media.mount - External Media Directory. Sep 4 00:08:00.448459 systemd[1]: Mounted sys-kernel-debug.mount - Kernel Debug File System. Sep 4 00:08:00.454629 systemd[1]: Mounted sys-kernel-tracing.mount - Kernel Trace File System. Sep 4 00:08:00.459394 systemd[1]: Mounted tmp.mount - Temporary Directory /tmp. Sep 4 00:08:00.465590 systemd[1]: Finished kmod-static-nodes.service - Create List of Static Device Nodes. Sep 4 00:08:00.469000 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' Sep 4 00:08:00.470976 systemd[1]: modprobe@configfs.service: Deactivated successfully. Sep 4 00:08:00.471127 systemd[1]: Finished modprobe@configfs.service - Load Kernel Module configfs. Sep 4 00:08:00.475000 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' Sep 4 00:08:00.475000 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' Sep 4 00:08:00.476570 systemd[1]: modprobe@efi_pstore.service: Deactivated successfully. Sep 4 00:08:00.476718 systemd[1]: Finished modprobe@efi_pstore.service - Load Kernel Module efi_pstore. Sep 4 00:08:00.480000 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' Sep 4 00:08:00.480000 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' Sep 4 00:08:00.482583 systemd[1]: modprobe@fuse.service: Deactivated successfully. Sep 4 00:08:00.482735 systemd[1]: Finished modprobe@fuse.service - Load Kernel Module fuse. Sep 4 00:08:00.487000 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' Sep 4 00:08:00.487000 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' Sep 4 00:08:00.488680 systemd[1]: Finished systemd-modules-load.service - Load Kernel Modules. Sep 4 00:08:00.492000 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' Sep 4 00:08:00.494651 systemd[1]: Finished systemd-network-generator.service - Generate Network Units from Kernel Command Line. Sep 4 00:08:00.499000 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' Sep 4 00:08:00.501525 systemd[1]: Finished systemd-remount-fs.service - Remount Root and Kernel File Systems. Sep 4 00:08:00.505000 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' Sep 4 00:08:00.506993 systemd[1]: Finished systemd-udev-load-credentials.service - Load udev Rules from Credentials. Sep 4 00:08:00.510000 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' Sep 4 00:08:00.520774 systemd[1]: Reached target network-pre.target - Preparation for Network. Sep 4 00:08:00.527043 systemd[1]: Mounting sys-fs-fuse-connections.mount - FUSE Control File System... Sep 4 00:08:00.540422 systemd[1]: Mounting sys-kernel-config.mount - Kernel Configuration File System... Sep 4 00:08:00.545131 systemd[1]: remount-root.service - Remount Root File System skipped, unmet condition check ConditionPathIsReadWrite=!/ Sep 4 00:08:00.548384 systemd[1]: Starting systemd-hwdb-update.service - Rebuild Hardware Database... Sep 4 00:08:00.555659 systemd[1]: Starting systemd-journal-flush.service - Flush Journal to Persistent Storage... Sep 4 00:08:00.562511 systemd[1]: systemd-pstore.service - Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore Sep 4 00:08:00.563847 systemd[1]: Starting systemd-random-seed.service - Load/Save OS Random Seed... Sep 4 00:08:00.579059 systemd[1]: Starting systemd-sysctl.service - Apply Kernel Variables... Sep 4 00:08:00.586365 systemd[1]: Starting systemd-tmpfiles-setup-dev-early.service - Create Static Device Nodes in /dev gracefully... Sep 4 00:08:00.592967 systemd[1]: Finished systemd-udev-trigger.service - Coldplug All udev Devices. Sep 4 00:08:00.596000 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' Sep 4 00:08:00.599061 systemd[1]: Mounted sys-fs-fuse-connections.mount - FUSE Control File System. Sep 4 00:08:00.604059 systemd[1]: Mounted sys-kernel-config.mount - Kernel Configuration File System. Sep 4 00:08:00.611852 systemd[1]: Finished systemd-random-seed.service - Load/Save OS Random Seed. Sep 4 00:08:00.616000 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' Sep 4 00:08:00.619712 systemd[1]: Reached target first-boot-complete.target - First Boot Complete. Sep 4 00:08:00.627303 systemd-journald[2024]: Time spent on flushing to /var/log/journal/4a7084ed639a4dc992640b769b32f4df is 13.038ms for 1157 entries. Sep 4 00:08:00.627303 systemd-journald[2024]: System Journal (/var/log/journal/4a7084ed639a4dc992640b769b32f4df) is 8M, max 2.2G, 2.2G free. Sep 4 00:08:00.663466 systemd-journald[2024]: Received client request to flush runtime journal. Sep 4 00:08:00.664702 systemd[1]: Finished systemd-journal-flush.service - Flush Journal to Persistent Storage. Sep 4 00:08:00.668000 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' Sep 4 00:08:00.673087 systemd[1]: Finished systemd-sysctl.service - Apply Kernel Variables. Sep 4 00:08:00.676000 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' Sep 4 00:08:00.683246 systemd[1]: Finished flatcar-tmpfiles.service - Create missing system files. Sep 4 00:08:00.686000 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' Sep 4 00:08:00.850398 systemd-tmpfiles[2077]: ACLs are not supported, ignoring. Sep 4 00:08:00.850411 systemd-tmpfiles[2077]: ACLs are not supported, ignoring. Sep 4 00:08:00.853370 systemd[1]: Finished systemd-tmpfiles-setup-dev-early.service - Create Static Device Nodes in /dev gracefully. Sep 4 00:08:00.857000 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' Sep 4 00:08:00.860308 systemd[1]: Starting systemd-sysusers.service - Create System Users... Sep 4 00:08:00.967479 systemd[1]: Finished systemd-sysusers.service - Create System Users. Sep 4 00:08:00.970000 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' Sep 4 00:08:00.974173 systemd[1]: Starting systemd-journalctl.socket - Journal Log Access Socket... Sep 4 00:08:00.983000 audit: BPF prog-id=16 op=LOAD Sep 4 00:08:00.983000 audit: BPF prog-id=17 op=LOAD Sep 4 00:08:00.983000 audit: BPF prog-id=18 op=LOAD Sep 4 00:08:00.986410 systemd[1]: Starting systemd-oomd.service - Userspace Out-Of-Memory (OOM) Killer... Sep 4 00:08:00.993000 audit: BPF prog-id=19 op=LOAD Sep 4 00:08:00.995183 systemd[1]: Starting systemd-resolved.service - Network Name Resolution... Sep 4 00:08:01.000775 systemd[1]: Starting systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev... Sep 4 00:08:01.007985 systemd[1]: Listening on systemd-journalctl.socket - Journal Log Access Socket. Sep 4 00:08:01.016389 systemd[1]: Starting modprobe@tun.service - Load Kernel Module tun... Sep 4 00:08:01.019000 audit: BPF prog-id=20 op=LOAD Sep 4 00:08:01.020000 audit: BPF prog-id=21 op=LOAD Sep 4 00:08:01.020000 audit: BPF prog-id=22 op=LOAD Sep 4 00:08:01.021778 systemd[1]: Starting systemd-userdbd.service - User Database Manager... Sep 4 00:08:01.028675 systemd-tmpfiles[2093]: ACLs are not supported, ignoring. Sep 4 00:08:01.031304 systemd-tmpfiles[2093]: ACLs are not supported, ignoring. Sep 4 00:08:01.035415 systemd[1]: Finished systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev. Sep 4 00:08:01.041000 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' Sep 4 00:08:01.043016 systemd[1]: Reached target local-fs-pre.target - Preparation for Local File Systems. Sep 4 00:08:01.049800 systemd[1]: systemd-repart.service - Repartition Root Disk skipped, no trigger condition checks were met. Sep 4 00:08:01.049889 systemd[1]: proc-sys-fs-binfmt_misc.automount: Got automount request for /proc/sys/fs/binfmt_misc, triggered by 2095 ((systemd-userd)) Sep 4 00:08:01.106258 kernel: tun: Universal TUN/TAP device driver, 1.6 Sep 4 00:08:01.107192 systemd[1]: modprobe@tun.service: Deactivated successfully. Sep 4 00:08:01.107406 systemd[1]: Finished modprobe@tun.service - Load Kernel Module tun. Sep 4 00:08:01.111000 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' Sep 4 00:08:01.111000 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' Sep 4 00:08:01.112000 audit: BPF prog-id=23 op=LOAD Sep 4 00:08:01.112000 audit: BPF prog-id=24 op=LOAD Sep 4 00:08:01.112000 audit: BPF prog-id=25 op=LOAD Sep 4 00:08:01.114156 systemd[1]: Starting systemd-nsresourced.service - Namespace Resource Manager... Sep 4 00:08:01.132410 systemd[1]: Finished systemd-hwdb-update.service - Rebuild Hardware Database. Sep 4 00:08:01.136000 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' Sep 4 00:08:01.136000 audit: BPF prog-id=7 op=UNLOAD Sep 4 00:08:01.136000 audit: BPF prog-id=6 op=UNLOAD Sep 4 00:08:01.137000 audit: BPF prog-id=26 op=LOAD Sep 4 00:08:01.137000 audit: BPF prog-id=27 op=LOAD Sep 4 00:08:01.139218 systemd[1]: Starting systemd-udevd.service - Rule-based Manager for Device Events and Files... Sep 4 00:08:01.334497 systemd-udevd[2100]: Using default interface naming scheme 'v260'. Sep 4 00:08:01.502674 systemd[1]: Mounting proc-sys-fs-binfmt_misc.mount - Arbitrary Executable File Formats File System... Sep 4 00:08:01.507576 systemd[1]: var-lib-machines.mount - Virtual Machine and Container Storage (Compatibility) skipped, unmet condition check ConditionPathExists=/var/lib/machines.raw Sep 4 00:08:01.507616 systemd[1]: Reached target local-fs.target - Local File Systems. Sep 4 00:08:01.512010 systemd[1]: Reached target machines.target - Virtual Machines and Containers. Sep 4 00:08:01.516902 systemd[1]: Listening on systemd-importd.socket - Disk Image Download Service Socket. Sep 4 00:08:01.523069 systemd[1]: Listening on systemd-sysext.socket - System Extension Image Management. Sep 4 00:08:01.529188 systemd[1]: Starting systemd-confext.service - Merge System Configuration Images into /etc/... Sep 4 00:08:01.536381 systemd[1]: Starting systemd-machine-id-commit.service - Save Transient machine-id to Disk... Sep 4 00:08:01.543372 systemd[1]: Starting systemd-userdb-load-credentials.service - Load JSON user/group Records from Credentials... Sep 4 00:08:01.560667 systemd[1]: Mounted proc-sys-fs-binfmt_misc.mount - Arbitrary Executable File Formats File System. Sep 4 00:08:01.568109 systemd[1]: proc-sys-fs-binfmt_misc.automount: Got automount request for /proc/sys/fs/binfmt_misc, triggered by 2098 ((systemd-nsres)) Sep 4 00:08:01.568189 systemd[1]: proc-sys-fs-binfmt_misc.automount: Automount point already active? Sep 4 00:08:01.568428 systemd[1]: systemd-binfmt.service - Set Up Additional Binary Formats skipped, no trigger condition checks were met. Sep 4 00:08:01.575662 systemd[1]: Finished systemd-userdb-load-credentials.service - Load JSON user/group Records from Credentials. Sep 4 00:08:01.579000 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' Sep 4 00:08:01.615128 systemd[1]: Started systemd-userdbd.service - User Database Manager. Sep 4 00:08:01.618085 systemd-nsresourced[2098]: Not setting up BPF subsystem, as functionality has been disabled at compile time. Sep 4 00:08:01.618000 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' Sep 4 00:08:01.620396 systemd[1]: Started systemd-nsresourced.service - Namespace Resource Manager. Sep 4 00:08:01.626000 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' Sep 4 00:08:01.629495 systemd[1]: etc-machine\x2did.mount: Deactivated successfully. Sep 4 00:08:01.630169 systemd[1]: Finished systemd-machine-id-commit.service - Save Transient machine-id to Disk. Sep 4 00:08:01.640244 kernel: loop4: detected capacity change from 0 to 43976 Sep 4 00:08:01.640337 kernel: loop4: p1 p2 p3 Sep 4 00:08:01.641000 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' Sep 4 00:08:01.707448 kernel: device-mapper: verity: sha256 using shash "sha256-ce" Sep 4 00:08:01.707552 kernel: device-mapper: verity: Unrecognized verity feature request: root_hash_sig_key_desc Sep 4 00:08:01.710685 systemd-oomd[2091]: No swap; memory pressure usage will be degraded Sep 4 00:08:01.711963 systemd[1]: Started systemd-oomd.service - Userspace Out-Of-Memory (OOM) Killer. Sep 4 00:08:01.712243 kernel: device-mapper: table: 254:5: verity: Unrecognized verity feature request (-EINVAL) Sep 4 00:08:01.712456 systemd-confext[2107]: device-mapper: reload ioctl on loop4p1-53-verity (254:5) failed: Invalid argument Sep 4 00:08:01.718560 kernel: device-mapper: ioctl: error adding target to table Sep 4 00:08:01.724000 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' Sep 4 00:08:01.726249 kernel: device-mapper: verity: sha256 using shash "sha256-ce" Sep 4 00:08:01.737642 systemd-resolved[2092]: Positive Trust Anchors: Sep 4 00:08:01.737657 systemd-resolved[2092]: . IN DS 20326 8 2 e06d44b80b8f1d39a95c0b0d7c65d08458e880409bbc683457104237c7f8ec8d Sep 4 00:08:01.737660 systemd-resolved[2092]: . IN DS 38696 8 2 683d2d0acb8c9b712a1948b27f741219298d0a450d612c483af444a4c0fb2b16 Sep 4 00:08:01.737680 systemd-resolved[2092]: 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 Sep 4 00:08:01.747513 systemd[1]: Started systemd-udevd.service - Rule-based Manager for Device Events and Files. Sep 4 00:08:01.753000 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' Sep 4 00:08:01.754000 audit: BPF prog-id=28 op=LOAD Sep 4 00:08:01.760412 systemd[1]: Starting systemd-networkd.service - Network Management... Sep 4 00:08:01.805510 systemd-resolved[2092]: Using system hostname 'ci-4757.1.0-n-5186669828'. Sep 4 00:08:01.808560 systemd[1]: Started systemd-resolved.service - Network Name Resolution. Sep 4 00:08:01.815000 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' Sep 4 00:08:01.816989 systemd[1]: Reached target nss-lookup.target - Host and Network Name Lookups. Sep 4 00:08:01.835288 systemd[1]: Condition check resulted in dev-ttyAMA0.device - /dev/ttyAMA0 being skipped. Sep 4 00:08:01.867911 systemd-networkd[2130]: lo: Link UP Sep 4 00:08:01.867924 systemd-networkd[2130]: lo: Gained carrier Sep 4 00:08:01.869281 systemd[1]: Started systemd-networkd.service - Network Management. Sep 4 00:08:01.876000 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' Sep 4 00:08:01.880363 systemd[1]: Reached target network.target - Network. Sep 4 00:08:01.888457 systemd[1]: Starting systemd-networkd-persistent-storage.service - Enable Persistent Storage in systemd-networkd... Sep 4 00:08:01.897349 systemd[1]: Starting systemd-networkd-wait-online.service - Wait for Network to be Online... Sep 4 00:08:01.938538 systemd[1]: Finished systemd-networkd-persistent-storage.service - Enable Persistent Storage in systemd-networkd. Sep 4 00:08:01.945000 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' Sep 4 00:08:01.955793 systemd-networkd[2130]: eth0: Found matching .network file, based on potentially unpredictable interface name: /usr/lib/systemd/network/zz-default.network Sep 4 00:08:01.956043 systemd-networkd[2130]: eth0: Configuring with /usr/lib/systemd/network/zz-default.network. Sep 4 00:08:01.988249 kernel: mousedev: PS/2 mouse device common for all mice Sep 4 00:08:01.988354 kernel: hv_storvsc f8b3781a-1e82-4818-a1c3-63d806ec15bb: tag#25 cmd 0x85 status: scsi 0x2 srb 0x6 hv 0xc0000001 Sep 4 00:08:02.003247 kernel: mlx5_core 8a7b:00:02.0 enP35451s1: Link up Sep 4 00:08:02.031248 kernel: hv_netvsc 0022487b-8ce2-0022-487b-8ce20022487b eth0: Data path switched to VF: enP35451s1 Sep 4 00:08:02.031552 kernel: hv_vmbus: registering driver hv_balloon Sep 4 00:08:02.033217 systemd-networkd[2130]: enP35451s1: Link UP Sep 4 00:08:02.033702 systemd-networkd[2130]: eth0: Link UP Sep 4 00:08:02.034331 kernel: hv_balloon: Using Dynamic Memory protocol version 2.0 Sep 4 00:08:02.033707 systemd-networkd[2130]: eth0: Gained carrier Sep 4 00:08:02.033732 systemd-networkd[2130]: eth0: Found matching .network file, based on potentially unpredictable interface name: /usr/lib/systemd/network/zz-default.network Sep 4 00:08:02.042256 kernel: hv_balloon: Memory hot add disabled on ARM64 Sep 4 00:08:02.055866 systemd-networkd[2130]: enP35451s1: Gained carrier Sep 4 00:08:02.062270 systemd-networkd[2130]: eth0: DHCPv4 address 10.0.0.20/24, gateway 10.0.0.1 acquired from 168.63.129.16 Sep 4 00:08:02.075167 systemd[1]: Condition check resulted in dev-ptp_hyperv.device - /dev/ptp_hyperv being skipped. Sep 4 00:08:02.126885 systemd[1]: Starting systemd-vconsole-setup.service - Virtual Console Setup... Sep 4 00:08:02.139967 systemd[1]: systemd-vconsole-setup.service: Deactivated successfully. Sep 4 00:08:02.141420 systemd[1]: Stopped systemd-vconsole-setup.service - Virtual Console Setup. Sep 4 00:08:02.145000 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' Sep 4 00:08:02.145000 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' Sep 4 00:08:02.154473 systemd[1]: Starting systemd-vconsole-setup.service - Virtual Console Setup... Sep 4 00:08:02.168764 kernel: hv_vmbus: registering driver hyperv_fb Sep 4 00:08:02.168841 kernel: hyperv_fb: Synthvid Version major 3, minor 5 Sep 4 00:08:02.173894 kernel: hyperv_fb: Screen resolution: 1024x768, Color depth: 32, Frame buffer size: 8388608 Sep 4 00:08:02.177587 kernel: Console: switching to colour dummy device 80x25 Sep 4 00:08:02.183564 kernel: Console: switching to colour frame buffer device 128x48 Sep 4 00:08:02.225437 systemd[1]: Found device dev-disk-by\x2dlabel-OEM.device - Virtual_Disk OEM. Sep 4 00:08:02.233406 systemd[1]: Starting systemd-fsck@dev-disk-by\x2dlabel-OEM.service - File System Check on /dev/disk/by-label/OEM... Sep 4 00:08:02.257287 kernel: MACsec IEEE 802.1AE Sep 4 00:08:02.268442 systemd[1]: systemd-vconsole-setup.service: Deactivated successfully. Sep 4 00:08:02.268669 systemd[1]: Stopped systemd-vconsole-setup.service - Virtual Console Setup. Sep 4 00:08:02.274000 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' Sep 4 00:08:02.274000 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' Sep 4 00:08:02.277914 systemd[1]: Starting systemd-vconsole-setup.service - Virtual Console Setup... Sep 4 00:08:02.300269 kernel: erofs: (device dm-5): mounted with root inode @ nid 40. Sep 4 00:08:02.323884 systemd[1]: Finished systemd-fsck@dev-disk-by\x2dlabel-OEM.service - File System Check on /dev/disk/by-label/OEM. Sep 4 00:08:02.327000 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' Sep 4 00:08:02.334249 kernel: loop4: detected capacity change from 0 to 43976 Sep 4 00:08:02.336279 kernel: loop4: p1 p2 p3 Sep 4 00:08:02.349003 kernel: device-mapper: verity: sha256 using shash "sha256-ce" Sep 4 00:08:02.349078 kernel: device-mapper: verity: Unrecognized verity feature request: root_hash_sig_key_desc Sep 4 00:08:02.354032 kernel: device-mapper: table: 254:5: verity: Unrecognized verity feature request (-EINVAL) Sep 4 00:08:02.354107 kernel: device-mapper: ioctl: error adding target to table Sep 4 00:08:02.357113 (sd-merge)[2264]: device-mapper: reload ioctl on loop4p1-58-verity (254:5) failed: Invalid argument Sep 4 00:08:02.366322 kernel: device-mapper: verity: sha256 using shash "sha256-ce" Sep 4 00:08:02.380242 kernel: erofs: (device dm-5): mounted with root inode @ nid 40. Sep 4 00:08:02.380603 (sd-merge)[2264]: Skipping extension refresh because no change was found, use --always-refresh=yes to always do a refresh. Sep 4 00:08:02.384049 systemd[1]: Finished systemd-confext.service - Merge System Configuration Images into /etc/. Sep 4 00:08:02.387000 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' Sep 4 00:08:02.391816 systemd[1]: Starting systemd-sysext.service - Merge System Extension Images into /usr/ and /opt/... Sep 4 00:08:02.412274 kernel: loop4: detected capacity change from 0 to 142648 Sep 4 00:08:02.415610 kernel: loop4: p1 p2 p3 Sep 4 00:08:02.431870 kernel: device-mapper: verity: sha256 using shash "sha256-ce" Sep 4 00:08:02.431954 kernel: device-mapper: verity: Unrecognized verity feature request: root_hash_sig_key_desc Sep 4 00:08:02.436692 kernel: device-mapper: table: 254:5: verity: Unrecognized verity feature request (-EINVAL) Sep 4 00:08:02.440014 kernel: device-mapper: ioctl: error adding target to table Sep 4 00:08:02.440099 systemd-sysext[2271]: device-mapper: reload ioctl on loop4p1-62-verity (254:5) failed: Invalid argument Sep 4 00:08:02.449327 kernel: device-mapper: verity: sha256 using shash "sha256-ce" Sep 4 00:08:02.473253 kernel: erofs: (device dm-5): mounted with root inode @ nid 39. Sep 4 00:08:02.507270 kernel: loop4: detected capacity change from 0 to 364432 Sep 4 00:08:02.510253 kernel: loop4: p1 p2 p3 Sep 4 00:08:02.523842 kernel: device-mapper: verity: sha256 using shash "sha256-ce" Sep 4 00:08:02.523940 kernel: device-mapper: verity: Unrecognized verity feature request: root_hash_sig_key_desc Sep 4 00:08:02.523960 kernel: device-mapper: table: 254:5: verity: Unrecognized verity feature request (-EINVAL) Sep 4 00:08:02.532276 kernel: device-mapper: ioctl: error adding target to table Sep 4 00:08:02.532673 systemd-sysext[2271]: device-mapper: reload ioctl on loop4p1-67-verity (254:5) failed: Invalid argument Sep 4 00:08:02.537243 kernel: device-mapper: verity: sha256 using shash "sha256-ce" Sep 4 00:08:02.560402 kernel: erofs: (device dm-5): mounted with root inode @ nid 39. Sep 4 00:08:02.579296 kernel: loop4: detected capacity change from 0 to 172472 Sep 4 00:08:02.583245 kernel: loop4: p1 p2 p3 Sep 4 00:08:02.604393 kernel: device-mapper: verity: sha256 using shash "sha256-ce" Sep 4 00:08:02.604478 kernel: device-mapper: verity: Unrecognized verity feature request: root_hash_sig_key_desc Sep 4 00:08:02.609602 kernel: device-mapper: table: 254:5: verity: Unrecognized verity feature request (-EINVAL) Sep 4 00:08:02.613417 kernel: device-mapper: ioctl: error adding target to table Sep 4 00:08:02.613828 systemd-sysext[2271]: device-mapper: reload ioctl on loop4p1-72-verity (254:5) failed: Invalid argument Sep 4 00:08:02.623260 kernel: device-mapper: verity: sha256 using shash "sha256-ce" Sep 4 00:08:02.651298 kernel: erofs: (device dm-5): mounted with root inode @ nid 39. Sep 4 00:08:02.653198 systemd-vconsole-setup[2256]: Configuration of first virtual console was skipped, ignoring remaining ones. Sep 4 00:08:02.655359 systemd[1]: Finished systemd-vconsole-setup.service - Virtual Console Setup. Sep 4 00:08:02.659000 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' Sep 4 00:08:02.681249 kernel: loop4: detected capacity change from 0 to 142648 Sep 4 00:08:02.684269 kernel: loop4: p1 p2 p3 Sep 4 00:08:02.700742 kernel: device-mapper: verity: sha256 using shash "sha256-ce" Sep 4 00:08:02.700803 kernel: device-mapper: verity: Unrecognized verity feature request: root_hash_sig_key_desc Sep 4 00:08:02.705713 kernel: device-mapper: table: 254:5: verity: Unrecognized verity feature request (-EINVAL) Sep 4 00:08:02.709307 kernel: device-mapper: ioctl: error adding target to table Sep 4 00:08:02.709597 (sd-merge)[2296]: device-mapper: reload ioctl on loop4p1-77-verity (254:5) failed: Invalid argument Sep 4 00:08:02.716307 kernel: device-mapper: verity: sha256 using shash "sha256-ce" Sep 4 00:08:02.736250 kernel: erofs: (device dm-5): mounted with root inode @ nid 39. Sep 4 00:08:02.736325 kernel: loop5: detected capacity change from 0 to 364432 Sep 4 00:08:02.743270 kernel: loop5: p1 p2 p3 Sep 4 00:08:02.762864 kernel: device-mapper: verity: sha256 using shash "sha256-ce" Sep 4 00:08:02.762925 kernel: device-mapper: verity: Unrecognized verity feature request: root_hash_sig_key_desc Sep 4 00:08:02.767768 kernel: device-mapper: table: 254:6: verity: Unrecognized verity feature request (-EINVAL) Sep 4 00:08:02.771386 kernel: device-mapper: ioctl: error adding target to table Sep 4 00:08:02.771578 (sd-merge)[2296]: device-mapper: reload ioctl on loop5p1-81-verity (254:6) failed: Invalid argument Sep 4 00:08:02.778285 kernel: device-mapper: verity: sha256 using shash "sha256-ce" Sep 4 00:08:02.808296 kernel: erofs: (device dm-6): mounted with root inode @ nid 39. Sep 4 00:08:02.813263 kernel: loop6: detected capacity change from 0 to 172472 Sep 4 00:08:02.817314 kernel: loop6: p1 p2 p3 Sep 4 00:08:02.831664 kernel: device-mapper: verity: sha256 using shash "sha256-ce" Sep 4 00:08:02.831765 kernel: device-mapper: verity: Unrecognized verity feature request: root_hash_sig_key_desc Sep 4 00:08:02.836578 kernel: device-mapper: table: 254:7: verity: Unrecognized verity feature request (-EINVAL) Sep 4 00:08:02.840381 kernel: device-mapper: ioctl: error adding target to table Sep 4 00:08:02.840619 (sd-merge)[2296]: device-mapper: reload ioctl on loop6p1-85-verity (254:7) failed: Invalid argument Sep 4 00:08:02.845250 kernel: device-mapper: verity: sha256 using shash "sha256-ce" Sep 4 00:08:02.866254 kernel: erofs: (device dm-7): mounted with root inode @ nid 39. Sep 4 00:08:02.866742 (sd-merge)[2296]: Skipping extension refresh because no change was found, use --always-refresh=yes to always do a refresh. Sep 4 00:08:02.870817 systemd[1]: Finished systemd-sysext.service - Merge System Extension Images into /usr/ and /opt/. Sep 4 00:08:02.875000 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' Sep 4 00:08:02.879759 systemd[1]: Starting systemd-tmpfiles-setup.service - Create System Files and Directories... Sep 4 00:08:02.903940 systemd-tmpfiles[2319]: /usr/lib/tmpfiles.d/base_image_var.conf:29: Duplicate line for path "/var/log/audit", ignoring. Sep 4 00:08:02.904991 systemd-tmpfiles[2319]: /usr/lib/tmpfiles.d/base_image_var_late.conf:44: Duplicate line for path "/var/log/audit", ignoring. Sep 4 00:08:02.905167 systemd-tmpfiles[2319]: /usr/lib/tmpfiles.d/baselayout.conf:15: Duplicate line for path "/var", ignoring. Sep 4 00:08:02.905172 systemd-tmpfiles[2319]: /usr/lib/tmpfiles.d/baselayout.conf:16: Duplicate line for path "/var/empty", ignoring. Sep 4 00:08:02.905182 systemd-tmpfiles[2319]: /usr/lib/tmpfiles.d/baselayout.conf:21: Duplicate line for path "/var/log", ignoring. Sep 4 00:08:02.905293 systemd-tmpfiles[2319]: /usr/lib/tmpfiles.d/dbus.conf:5: Duplicate line for path "/var/lib/dbus", ignoring. Sep 4 00:08:02.905509 systemd-tmpfiles[2319]: /usr/lib/tmpfiles.d/nfs-utils.conf:2: Duplicate line for path "/var/lib/nfs/v4recovery", ignoring. Sep 4 00:08:02.906321 systemd-tmpfiles[2319]: /usr/lib/tmpfiles.d/nfs-utils.conf:6: Duplicate line for path "/var/lib/nfs/sm", ignoring. Sep 4 00:08:02.906337 systemd-tmpfiles[2319]: /usr/lib/tmpfiles.d/nfs-utils.conf:7: Duplicate line for path "/var/lib/nfs/sm.bak", ignoring. Sep 4 00:08:02.906487 systemd-tmpfiles[2319]: /usr/lib/tmpfiles.d/provision.conf:20: Duplicate line for path "/root", ignoring. Sep 4 00:08:02.907134 systemd-tmpfiles[2319]: /usr/lib/tmpfiles.d/tpm2-tss-fapi.conf:2: Duplicate line for path "/var/lib/tpm2-tss/system/keystore", ignoring. Sep 4 00:08:02.907147 systemd-tmpfiles[2319]: ACLs are not supported, ignoring. Sep 4 00:08:02.907177 systemd-tmpfiles[2319]: ACLs are not supported, ignoring. Sep 4 00:08:02.907813 systemd-tmpfiles[2319]: /usr/lib/tmpfiles.d/var.conf:10: Duplicate line for path "/var", ignoring. Sep 4 00:08:02.907826 systemd-tmpfiles[2319]: /usr/lib/tmpfiles.d/var.conf:14: Duplicate line for path "/var/log", ignoring. Sep 4 00:08:02.907878 systemd-tmpfiles[2319]: /usr/lib/tmpfiles.d/var.conf:21: Duplicate line for path "/var/lib", ignoring. Sep 4 00:08:02.910840 systemd-tmpfiles[2319]: Detected autofs mount point '/boot' during canonicalization of 'boot'. Sep 4 00:08:02.910848 systemd-tmpfiles[2319]: Skipping /boot Sep 4 00:08:02.918661 systemd-tmpfiles[2319]: Detected autofs mount point '/boot' during canonicalization of 'boot'. Sep 4 00:08:02.918679 systemd-tmpfiles[2319]: Skipping /boot Sep 4 00:08:02.933335 systemd[1]: Finished systemd-tmpfiles-setup.service - Create System Files and Directories. Sep 4 00:08:02.937000 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' Sep 4 00:08:02.941770 systemd[1]: Starting audit-rules.service - Load Audit Rules... Sep 4 00:08:02.951405 systemd[1]: Starting clean-ca-certificates.service - Clean up broken links in /etc/ssl/certs... Sep 4 00:08:02.958250 systemd[1]: Starting ldconfig.service - Rebuild Dynamic Linker Cache... Sep 4 00:08:02.965481 systemd[1]: Starting systemd-journal-catalog-update.service - Rebuild Journal Catalog... Sep 4 00:08:02.973415 systemd[1]: Starting systemd-update-utmp.service - Record System Boot/Shutdown in UTMP... Sep 4 00:08:02.988000 audit[2328]: AUDIT1127 pid=2328 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' Sep 4 00:08:02.992143 systemd[1]: Finished systemd-update-utmp.service - Record System Boot/Shutdown in UTMP. Sep 4 00:08:02.997000 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' Sep 4 00:08:03.100549 systemd[1]: Finished systemd-journal-catalog-update.service - Rebuild Journal Catalog. Sep 4 00:08:03.106000 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' Sep 4 00:08:03.142000 audit: CONFIG_CHANGE auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 op=add_rule key=(null) list=5 res=1 Sep 4 00:08:03.142000 audit[2352]: SYSCALL arch=c00000b7 syscall=206 success=yes exit=1056 a0=3 a1=fffff4e6edf0 a2=420 a3=0 items=0 ppid=2324 pid=2352 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) Sep 4 00:08:03.142000 audit: PROCTITLE proctitle=2F7362696E2F617564697463746C002D52002F6574632F61756469742F61756469742E72756C6573 Sep 4 00:08:03.144553 augenrules[2352]: No rules Sep 4 00:08:03.145843 systemd[1]: audit-rules.service: Deactivated successfully. Sep 4 00:08:03.146205 systemd[1]: Finished audit-rules.service - Load Audit Rules. Sep 4 00:08:03.367208 systemd[1]: Finished clean-ca-certificates.service - Clean up broken links in /etc/ssl/certs. Sep 4 00:08:03.373830 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 Sep 4 00:08:04.026453 systemd-networkd[2130]: eth0: Gained IPv6LL Sep 4 00:08:04.031457 systemd[1]: Finished systemd-networkd-wait-online.service - Wait for Network to be Online. Sep 4 00:08:04.037424 systemd[1]: Reached target network-online.target - Network is Online. Sep 4 00:08:08.131931 ldconfig[2326]: ldconfig: /usr/lib/ld.so.conf is not an ELF file - it has the wrong magic bytes at the start. Sep 4 00:08:08.140375 systemd[1]: Finished ldconfig.service - Rebuild Dynamic Linker Cache. Sep 4 00:08:08.148389 systemd[1]: Starting systemd-update-done.service - Update is Completed... Sep 4 00:08:08.174040 systemd[1]: Finished systemd-update-done.service - Update is Completed. Sep 4 00:08:08.178946 systemd[1]: Reached target sysinit.target - System Initialization. Sep 4 00:08:08.183359 systemd[1]: Started motdgen.path - Watch for update engine configuration changes. Sep 4 00:08:08.188666 systemd[1]: Started user-cloudinit@var-lib-flatcar\x2dinstall-user_data.path - Watch for a cloud-config at /var/lib/flatcar-install/user_data. Sep 4 00:08:08.193980 systemd[1]: Started logrotate.timer - Daily rotation of log files. Sep 4 00:08:08.198354 systemd[1]: Started mdadm.timer - Weekly check for MD array's redundancy information.. Sep 4 00:08:08.203440 systemd[1]: Started systemd-sysupdate-reboot.timer - Reboot Automatically After System Update. Sep 4 00:08:08.208586 systemd[1]: Started systemd-sysupdate.timer - Automatic System Update. Sep 4 00:08:08.213075 systemd[1]: Started systemd-tmpfiles-clean.timer - Daily Cleanup of Temporary Directories. Sep 4 00:08:08.218007 systemd[1]: update-engine-stub.timer - Update Engine Stub Timer skipped, unmet condition check ConditionPathExists=/usr/.noupdate Sep 4 00:08:08.218044 systemd[1]: Reached target paths.target - Path Units. Sep 4 00:08:08.222020 systemd[1]: Reached target timers.target - Timer Units. Sep 4 00:08:08.227019 systemd[1]: Listening on dbus.socket - D-Bus System Message Bus Socket. Sep 4 00:08:08.232610 systemd[1]: Starting docker.socket - Docker Socket for the API... Sep 4 00:08:08.238137 systemd[1]: Listening on sshd-unix-local.socket - OpenSSH Server Socket (systemd-ssh-generator, AF_UNIX Local). Sep 4 00:08:08.245610 systemd[1]: Listening on sshd.socket - OpenSSH Server Socket. Sep 4 00:08:08.250076 systemd[1]: Listening on systemd-hostnamed.socket - Hostname Service Socket. Sep 4 00:08:08.255436 systemd[1]: Listening on systemd-logind-varlink.socket - User Login Management Varlink Socket. Sep 4 00:08:08.260588 systemd[1]: Listening on systemd-machined.socket - Virtual Machine and Container Registration Service Socket. Sep 4 00:08:08.266354 systemd[1]: Listening on docker.socket - Docker Socket for the API. Sep 4 00:08:08.270885 systemd[1]: Reached target sockets.target - Socket Units. Sep 4 00:08:08.274713 systemd[1]: Reached target basic.target - Basic System. Sep 4 00:08:08.278833 systemd[1]: addon-config@oem.service - Configure Addon /oem skipped, no trigger condition checks were met. Sep 4 00:08:08.278858 systemd[1]: addon-run@oem.service - Run Addon /oem skipped, no trigger condition checks were met. Sep 4 00:08:08.280692 systemd[1]: Starting chronyd.service - NTP client/server... Sep 4 00:08:08.291355 systemd[1]: Starting containerd.service - containerd container runtime... Sep 4 00:08:08.298420 systemd[1]: Starting dbus.service - D-Bus System Message Bus... Sep 4 00:08:08.303410 systemd[1]: Starting dracut-shutdown.service - Restore /run/initramfs on shutdown... Sep 4 00:08:08.314661 systemd[1]: Starting enable-oem-cloudinit.service - Enable cloudinit... Sep 4 00:08:08.323306 systemd[1]: Starting extend-filesystems.service - Extend Filesystems... Sep 4 00:08:08.328452 systemd[1]: flatcar-setup-environment.service - Modifies /etc/environment for CoreOS skipped, unmet condition check ConditionPathExists=/oem/bin/flatcar-setup-environment Sep 4 00:08:08.330199 systemd[1]: Started hv_kvp_daemon.service - Hyper-V KVP daemon. Sep 4 00:08:08.334514 systemd[1]: hv_vss_daemon.service - Hyper-V VSS daemon skipped, unmet condition check ConditionPathExists=/dev/vmbus/hv_vss Sep 4 00:08:08.339665 chronyd[2368]: chronyd version 4.8 starting (+CMDMON +REFCLOCK +RTC +PRIVDROP +SCFILTER -SIGND +NTS +SECHASH +IPV6 -DEBUG) Sep 4 00:08:08.340687 systemd[1]: Starting motdgen.service - Generate /run/flatcar/motd... Sep 4 00:08:08.345012 KVP[2374]: KVP starting; pid is:2374 Sep 4 00:08:08.345023 chronyd[2368]: Timezone right/UTC failed leap second check, ignoring Sep 4 00:08:08.345174 chronyd[2368]: Loaded seccomp filter (level 2) Sep 4 00:08:08.348894 jq[2372]: true Sep 4 00:08:08.349573 systemd[1]: Starting nvidia.service - NVIDIA Configure Service... Sep 4 00:08:08.355747 KVP[2374]: KVP LIC Version: 3.1 Sep 4 00:08:08.356241 kernel: hv_utils: KVP IC version 4.0 Sep 4 00:08:08.360128 systemd[1]: Starting ssh-key-proc-cmdline.service - Install an ssh key from /proc/cmdline... Sep 4 00:08:08.366510 systemd[1]: Starting sshd-keygen.service - Generate sshd host keys... Sep 4 00:08:08.378336 systemd[1]: Starting systemd-logind.service - User Login Management... Sep 4 00:08:08.384874 systemd[1]: tcsd.service - TCG Core Services Daemon skipped, unmet condition check ConditionPathExists=/dev/tpm0 Sep 4 00:08:08.387489 systemd[1]: Starting update-engine.service - Update Engine... Sep 4 00:08:08.392697 motdgen[2391]: /oem/oem-release: line 2: Azure: command not found Sep 4 00:08:08.397822 systemd[1]: Starting update-ssh-keys-after-ignition.service - Run update-ssh-keys once after Ignition... Sep 4 00:08:08.411019 extend-filesystems[2373]: Found /dev/sda6 Sep 4 00:08:08.411019 extend-filesystems[2373]: Found /dev/sda9 Sep 4 00:08:08.428018 jq[2395]: false Sep 4 00:08:08.405631 systemd[1]: Started chronyd.service - NTP client/server. Sep 4 00:08:08.440462 extend-filesystems[2373]: Checking size of /dev/sda9 Sep 4 00:08:08.415453 systemd[1]: Finished dracut-shutdown.service - Restore /run/initramfs on shutdown. Sep 4 00:08:08.428724 systemd[1]: motdgen.service: Deactivated successfully. Sep 4 00:08:08.460124 jq[2407]: true Sep 4 00:08:08.428929 systemd[1]: Finished motdgen.service - Generate /run/flatcar/motd. Sep 4 00:08:08.434566 systemd[1]: ssh-key-proc-cmdline.service: Deactivated successfully. Sep 4 00:08:08.434809 systemd[1]: Finished ssh-key-proc-cmdline.service - Install an ssh key from /proc/cmdline. Sep 4 00:08:08.443794 systemd[1]: update-ssh-keys-after-ignition.service: Skipped due to 'exec-condition'. Sep 4 00:08:08.448040 systemd[1]: Condition check resulted in update-ssh-keys-after-ignition.service - Run update-ssh-keys once after Ignition being skipped. Sep 4 00:08:08.456441 systemd[1]: sshkeys.service skipped, no trigger condition checks were met. Sep 4 00:08:08.470258 extend-filesystems[2373]: Resized partition /dev/sda9 Sep 4 00:08:08.497156 update_engine[2387]: I20260904 00:08:08.494831 2387 main.cc:92] Flatcar Update Engine starting Sep 4 00:08:08.475486 systemd[1]: Finished nvidia.service - NVIDIA Configure Service. Sep 4 00:08:08.501344 systemctl[2426]: Created symlink '/etc/systemd/system/multi-user.target.wants/oem-cloudinit.service' → '/usr/lib/systemd/system/oem-cloudinit.service'. Sep 4 00:08:08.501670 systemd[1]: Reload requested from client PID 2426 ('systemctl') (unit enable-oem-cloudinit.service)... Sep 4 00:08:08.501733 systemd[1]: Reloading... Sep 4 00:08:08.537739 extend-filesystems[2440]: resize2fs 1.47.4 (6-Mar-2025) Sep 4 00:08:08.553325 systemd-logind[2384]: New seat seat0. Sep 4 00:08:08.557928 systemd-logind[2384]: Watching system buttons on /dev/input/event1 (AT Translated Set 2 keyboard) Sep 4 00:08:08.560177 kernel: EXT4-fs (sda9): resizing filesystem from 6359552 to 6376955 blocks Sep 4 00:08:08.560265 kernel: EXT4-fs (sda9): resized filesystem to 6376955 Sep 4 00:08:08.596253 extend-filesystems[2440]: Filesystem at /dev/sda9 is mounted on /; on-line resizing required Sep 4 00:08:08.596253 extend-filesystems[2440]: old_desc_blocks = 4, new_desc_blocks = 4 Sep 4 00:08:08.596253 extend-filesystems[2440]: The filesystem on /dev/sda9 is now 6376955 (4k) blocks long. Sep 4 00:08:08.595925 dbus-daemon[2370]: [system] SELinux support is enabled Sep 4 00:08:08.661536 extend-filesystems[2373]: Resized filesystem in /dev/sda9 Sep 4 00:08:08.668543 update_engine[2387]: I20260904 00:08:08.600353 2387 update_check_scheduler.cc:74] Next update check in 6m48s Sep 4 00:08:08.668574 zram_generator::config[2503]: No configuration found. Sep 4 00:08:08.917486 sshd_keygen[2388]: ssh-keygen: generating new host keys: RSA ECDSA ED25519 MLDSA44-ED25519 Sep 4 00:08:08.961823 systemd[1]: Reloading finished in 459 ms. Sep 4 00:08:08.983460 systemd[1]: Started systemd-logind.service - User Login Management. Sep 4 00:08:08.988030 systemd[1]: Started dbus.service - D-Bus System Message Bus. Sep 4 00:08:08.995014 dbus-daemon[2370]: [system] Successfully activated service 'org.freedesktop.systemd1' Sep 4 00:08:08.995742 systemd[1]: extend-filesystems.service: Deactivated successfully. Sep 4 00:08:08.995992 systemd[1]: Finished extend-filesystems.service - Extend Filesystems. Sep 4 00:08:09.000916 systemd[1]: Finished sshd-keygen.service - Generate sshd host keys. Sep 4 00:08:09.030988 systemd[1]: Started update-engine.service - Update Engine. Sep 4 00:08:09.037973 systemd[1]: Starting issuegen.service - Generate /run/issue... Sep 4 00:08:09.050464 systemd[1]: Starting oem-cloudinit.service - Run cloudinit... Sep 4 00:08:09.054189 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 Sep 4 00:08:09.054385 systemd[1]: Reached target system-config.target - Load system-provided cloud configs. Sep 4 00:08:09.061874 systemd[1]: user-cloudinit-proc-cmdline.service - Load cloud-config from url defined in /proc/cmdline skipped, unmet condition check ConditionKernelCommandLine=cloud-config-url Sep 4 00:08:09.062016 systemd[1]: Reached target user-config.target - Load user-provided cloud configs. Sep 4 00:08:09.065080 bash[2618]: + OEMS=(aws gcp azure cloudsigma vmware digitalocean openstack) Sep 4 00:08:09.065893 bash[2622]: + echo aws gcp azure cloudsigma vmware digitalocean openstack Sep 4 00:08:09.066475 bash[2623]: + tr ' ' $'\n' Sep 4 00:08:09.067334 bash[2624]: + grep -q -x -F azure Sep 4 00:08:09.069445 systemd[1]: Starting waagent.service - Microsoft Azure Linux Agent... Sep 4 00:08:09.085464 systemd[1]: Started locksmithd.service - Cluster reboot manager. Sep 4 00:08:09.092631 systemd[1]: issuegen.service: Deactivated successfully. Sep 4 00:08:09.098375 systemd[1]: Finished issuegen.service - Generate /run/issue. Sep 4 00:08:09.115611 systemd[1]: Starting systemd-user-sessions.service - Permit User Sessions... Sep 4 00:08:09.122607 bash[2636]: ++ '[' azure = aws -o azure = openstack ']' Sep 4 00:08:09.122607 bash[2636]: ++ '[' azure = gcp ']' Sep 4 00:08:09.122891 bash[2636]: ++ echo azure Sep 4 00:08:09.123599 bash[2629]: + /usr/bin/coreos-cloudinit --oem=azure Sep 4 00:08:09.126309 systemd[1]: Started waagent.service - Microsoft Azure Linux Agent. Sep 4 00:08:09.135288 systemd[1]: Finished systemd-user-sessions.service - Permit User Sessions. Sep 4 00:08:09.143636 systemd[1]: Started getty@tty1.service - Getty on tty1. Sep 4 00:08:09.149591 systemd[1]: Started serial-getty@ttyAMA0.service - Serial Getty on ttyAMA0. Sep 4 00:08:09.156484 systemd[1]: Reached target getty.target - Login Prompts. Sep 4 00:08:09.263207 locksmithd[2626]: locksmithd starting currentOperation="UPDATE_STATUS_IDLE" strategy="reboot" Sep 4 00:08:09.268136 bash[2629]: 2026/09/04 00:08:09 Checking availability of "waagent" Sep 4 00:08:09.368379 bash[2629]: 2026/09/04 00:08:09 Checking availability of "waagent" Sep 4 00:08:09.568799 bash[2629]: 2026/09/04 00:08:09 Checking availability of "waagent" Sep 4 00:08:09.969280 bash[2629]: 2026/09/04 00:08:09 Checking availability of "waagent" Sep 4 00:08:10.770232 bash[2629]: 2026/09/04 00:08:10 Checking availability of "waagent" Sep 4 00:08:11.299089 containerd[2420]: time="2026-09-04T00:08:11Z" 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 Sep 4 00:08:11.300670 containerd[2420]: time="2026-09-04T00:08:11.300529896Z" level=info msg="starting containerd" revision=e53c7c1516c3b2bff98eb76f1f4117477e6f4e66 version=v2.2.5 Sep 4 00:08:11.309267 containerd[2420]: time="2026-09-04T00:08:11.308833576Z" level=warning msg="Configuration migrated from version 2, use `containerd config migrate` to avoid migration" t="8.024µs" Sep 4 00:08:11.309267 containerd[2420]: time="2026-09-04T00:08:11.308866584Z" level=info msg="loading plugin" id=io.containerd.content.v1.content type=io.containerd.content.v1 Sep 4 00:08:11.309267 containerd[2420]: time="2026-09-04T00:08:11.308906632Z" level=info msg="loading plugin" id=io.containerd.image-verifier.v1.bindir type=io.containerd.image-verifier.v1 Sep 4 00:08:11.309267 containerd[2420]: time="2026-09-04T00:08:11.308915952Z" level=info msg="loading plugin" id=io.containerd.internal.v1.opt type=io.containerd.internal.v1 Sep 4 00:08:11.309267 containerd[2420]: time="2026-09-04T00:08:11.309078064Z" level=info msg="loading plugin" id=io.containerd.warning.v1.deprecations type=io.containerd.warning.v1 Sep 4 00:08:11.309267 containerd[2420]: time="2026-09-04T00:08:11.309092648Z" level=info msg="loading plugin" id=io.containerd.mount-handler.v1.erofs type=io.containerd.mount-handler.v1 Sep 4 00:08:11.309267 containerd[2420]: time="2026-09-04T00:08:11.309100656Z" level=info msg="loading plugin" id=io.containerd.snapshotter.v1.blockfile type=io.containerd.snapshotter.v1 Sep 4 00:08:11.309267 containerd[2420]: time="2026-09-04T00:08:11.309142848Z" level=info msg="skip loading plugin" error="no scratch file generator: skip plugin" id=io.containerd.snapshotter.v1.blockfile type=io.containerd.snapshotter.v1 Sep 4 00:08:11.309267 containerd[2420]: time="2026-09-04T00:08:11.309149544Z" level=info msg="loading plugin" id=io.containerd.snapshotter.v1.btrfs type=io.containerd.snapshotter.v1 Sep 4 00:08:11.309844 containerd[2420]: time="2026-09-04T00:08:11.309815832Z" 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 Sep 4 00:08:11.309844 containerd[2420]: time="2026-09-04T00:08:11.309838520Z" level=info msg="loading plugin" id=io.containerd.snapshotter.v1.devmapper type=io.containerd.snapshotter.v1 Sep 4 00:08:11.309874 containerd[2420]: time="2026-09-04T00:08:11.309847864Z" level=info msg="skip loading plugin" error="devmapper not configured: skip plugin" id=io.containerd.snapshotter.v1.devmapper type=io.containerd.snapshotter.v1 Sep 4 00:08:11.309874 containerd[2420]: time="2026-09-04T00:08:11.309854808Z" level=info msg="loading plugin" id=io.containerd.snapshotter.v1.erofs type=io.containerd.snapshotter.v1 Sep 4 00:08:11.310039 containerd[2420]: time="2026-09-04T00:08:11.310021208Z" level=info msg="loading plugin" id=io.containerd.snapshotter.v1.native type=io.containerd.snapshotter.v1 Sep 4 00:08:11.310086 containerd[2420]: time="2026-09-04T00:08:11.310073784Z" level=info msg="loading plugin" id=io.containerd.snapshotter.v1.overlayfs type=io.containerd.snapshotter.v1 Sep 4 00:08:11.310238 containerd[2420]: time="2026-09-04T00:08:11.310214344Z" level=info msg="loading plugin" id=io.containerd.snapshotter.v1.zfs type=io.containerd.snapshotter.v1 Sep 4 00:08:11.310270 containerd[2420]: time="2026-09-04T00:08:11.310256992Z" 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 Sep 4 00:08:11.310283 containerd[2420]: time="2026-09-04T00:08:11.310268336Z" level=info msg="loading plugin" id=io.containerd.event.v1.exchange type=io.containerd.event.v1 Sep 4 00:08:11.310306 containerd[2420]: time="2026-09-04T00:08:11.310296096Z" level=info msg="loading plugin" id=io.containerd.monitor.task.v1.cgroups type=io.containerd.monitor.task.v1 Sep 4 00:08:11.310633 containerd[2420]: time="2026-09-04T00:08:11.310611232Z" level=info msg="loading plugin" id=io.containerd.metadata.v1.bolt type=io.containerd.metadata.v1 Sep 4 00:08:11.311012 containerd[2420]: time="2026-09-04T00:08:11.310685480Z" level=info msg="metadata content store policy set" policy=shared Sep 4 00:08:11.324483 containerd[2420]: time="2026-09-04T00:08:11.324448880Z" level=info msg="loading plugin" id=io.containerd.gc.v1.scheduler type=io.containerd.gc.v1 Sep 4 00:08:11.324562 containerd[2420]: time="2026-09-04T00:08:11.324497376Z" level=info msg="loading plugin" id=io.containerd.nri.v1.nri type=io.containerd.nri.v1 Sep 4 00:08:11.324929 containerd[2420]: time="2026-09-04T00:08:11.324909824Z" level=info msg="built-in NRI default validator is disabled" Sep 4 00:08:11.324929 containerd[2420]: time="2026-09-04T00:08:11.324927008Z" level=info msg="runtime interface created" Sep 4 00:08:11.324929 containerd[2420]: time="2026-09-04T00:08:11.324931224Z" level=info msg="created NRI interface" Sep 4 00:08:11.325001 containerd[2420]: time="2026-09-04T00:08:11.324940584Z" level=info msg="loading plugin" id=io.containerd.differ.v1.erofs type=io.containerd.differ.v1 Sep 4 00:08:11.344365 containerd[2420]: time="2026-09-04T00:08:11.344192560Z" level=info msg="loading plugin" id=io.containerd.mount-manager.v1.bolt type=io.containerd.mount-manager.v1 Sep 4 00:08:11.344455 containerd[2420]: time="2026-09-04T00:08:11.344385944Z" level=info msg="loading plugin" id=io.containerd.differ.v1.walking type=io.containerd.differ.v1 Sep 4 00:08:11.344455 containerd[2420]: time="2026-09-04T00:08:11.344401024Z" level=info msg="loading plugin" id=io.containerd.lease.v1.manager type=io.containerd.lease.v1 Sep 4 00:08:11.344455 containerd[2420]: time="2026-09-04T00:08:11.344412024Z" level=info msg="loading plugin" id=io.containerd.service.v1.containers-service type=io.containerd.service.v1 Sep 4 00:08:11.344455 containerd[2420]: time="2026-09-04T00:08:11.344422080Z" level=info msg="loading plugin" id=io.containerd.service.v1.content-service type=io.containerd.service.v1 Sep 4 00:08:11.344455 containerd[2420]: time="2026-09-04T00:08:11.344428160Z" level=info msg="loading plugin" id=io.containerd.service.v1.diff-service type=io.containerd.service.v1 Sep 4 00:08:11.344455 containerd[2420]: time="2026-09-04T00:08:11.344436488Z" level=info msg="loading plugin" id=io.containerd.service.v1.images-service type=io.containerd.service.v1 Sep 4 00:08:11.344455 containerd[2420]: time="2026-09-04T00:08:11.344445136Z" level=info msg="loading plugin" id=io.containerd.service.v1.introspection-service type=io.containerd.service.v1 Sep 4 00:08:11.344455 containerd[2420]: time="2026-09-04T00:08:11.344452328Z" level=info msg="loading plugin" id=io.containerd.service.v1.namespaces-service type=io.containerd.service.v1 Sep 4 00:08:11.344570 containerd[2420]: time="2026-09-04T00:08:11.344458624Z" level=info msg="loading plugin" id=io.containerd.service.v1.snapshots-service type=io.containerd.service.v1 Sep 4 00:08:11.344570 containerd[2420]: time="2026-09-04T00:08:11.344465792Z" level=info msg="loading plugin" id=io.containerd.shim.v1.manager type=io.containerd.shim.v1 Sep 4 00:08:11.344570 containerd[2420]: time="2026-09-04T00:08:11.344472464Z" level=info msg="loading plugin" id=io.containerd.runtime.v2.task type=io.containerd.runtime.v2 Sep 4 00:08:11.344607 containerd[2420]: time="2026-09-04T00:08:11.344582664Z" level=info msg="loading plugin" id=io.containerd.service.v1.tasks-service type=io.containerd.service.v1 Sep 4 00:08:11.344607 containerd[2420]: time="2026-09-04T00:08:11.344602064Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.containers type=io.containerd.grpc.v1 Sep 4 00:08:11.344632 containerd[2420]: time="2026-09-04T00:08:11.344609816Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.content type=io.containerd.grpc.v1 Sep 4 00:08:11.344632 containerd[2420]: time="2026-09-04T00:08:11.344618032Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.diff type=io.containerd.grpc.v1 Sep 4 00:08:11.344632 containerd[2420]: time="2026-09-04T00:08:11.344625120Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.events type=io.containerd.grpc.v1 Sep 4 00:08:11.344665 containerd[2420]: time="2026-09-04T00:08:11.344632952Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.images type=io.containerd.grpc.v1 Sep 4 00:08:11.344665 containerd[2420]: time="2026-09-04T00:08:11.344640016Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.introspection type=io.containerd.grpc.v1 Sep 4 00:08:11.344665 containerd[2420]: time="2026-09-04T00:08:11.344647528Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.leases type=io.containerd.grpc.v1 Sep 4 00:08:11.344665 containerd[2420]: time="2026-09-04T00:08:11.344654448Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.mounts type=io.containerd.grpc.v1 Sep 4 00:08:11.344665 containerd[2420]: time="2026-09-04T00:08:11.344660664Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.namespaces type=io.containerd.grpc.v1 Sep 4 00:08:11.344723 containerd[2420]: time="2026-09-04T00:08:11.344668336Z" level=info msg="loading plugin" id=io.containerd.sandbox.store.v1.local type=io.containerd.sandbox.store.v1 Sep 4 00:08:11.344723 containerd[2420]: time="2026-09-04T00:08:11.344674608Z" level=info msg="loading plugin" id=io.containerd.transfer.v1.local type=io.containerd.transfer.v1 Sep 4 00:08:11.344723 containerd[2420]: time="2026-09-04T00:08:11.344697064Z" level=info msg="loading plugin" id=io.containerd.cri.v1.images type=io.containerd.cri.v1 Sep 4 00:08:11.345324 containerd[2420]: time="2026-09-04T00:08:11.345293808Z" level=info msg="Get image filesystem path \"/var/lib/containerd/io.containerd.snapshotter.v1.overlayfs\" for snapshotter \"overlayfs\"" Sep 4 00:08:11.345324 containerd[2420]: time="2026-09-04T00:08:11.345318992Z" level=info msg="Start snapshots syncer" Sep 4 00:08:11.345412 containerd[2420]: time="2026-09-04T00:08:11.345337400Z" level=info msg="loading plugin" id=io.containerd.cri.v1.runtime type=io.containerd.cri.v1 Sep 4 00:08:11.345717 containerd[2420]: time="2026-09-04T00:08:11.345553704Z" 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\"}" Sep 4 00:08:11.345717 containerd[2420]: time="2026-09-04T00:08:11.345601792Z" level=info msg="loading plugin" id=io.containerd.podsandbox.controller.v1.podsandbox type=io.containerd.podsandbox.controller.v1 Sep 4 00:08:11.345819 containerd[2420]: time="2026-09-04T00:08:11.345674576Z" level=info msg="loading plugin" id=io.containerd.sandbox.controller.v1.shim type=io.containerd.sandbox.controller.v1 Sep 4 00:08:11.345819 containerd[2420]: time="2026-09-04T00:08:11.345775928Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.sandbox-controllers type=io.containerd.grpc.v1 Sep 4 00:08:11.345819 containerd[2420]: time="2026-09-04T00:08:11.345790680Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.sandboxes type=io.containerd.grpc.v1 Sep 4 00:08:11.345819 containerd[2420]: time="2026-09-04T00:08:11.345798848Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.snapshots type=io.containerd.grpc.v1 Sep 4 00:08:11.345819 containerd[2420]: time="2026-09-04T00:08:11.345805272Z" level=info msg="loading plugin" id=io.containerd.streaming.v1.manager type=io.containerd.streaming.v1 Sep 4 00:08:11.345819 containerd[2420]: time="2026-09-04T00:08:11.345812168Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.streaming type=io.containerd.grpc.v1 Sep 4 00:08:11.345819 containerd[2420]: time="2026-09-04T00:08:11.345818336Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.tasks type=io.containerd.grpc.v1 Sep 4 00:08:11.345909 containerd[2420]: time="2026-09-04T00:08:11.345824880Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.transfer type=io.containerd.grpc.v1 Sep 4 00:08:11.345909 containerd[2420]: time="2026-09-04T00:08:11.345840832Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.version type=io.containerd.grpc.v1 Sep 4 00:08:11.345909 containerd[2420]: time="2026-09-04T00:08:11.345846280Z" level=info msg="loading plugin" id=io.containerd.monitor.container.v1.restart type=io.containerd.monitor.container.v1 Sep 4 00:08:11.345909 containerd[2420]: time="2026-09-04T00:08:11.345865232Z" level=info msg="loading plugin" id=io.containerd.tracing.processor.v1.otlp type=io.containerd.tracing.processor.v1 Sep 4 00:08:11.345909 containerd[2420]: time="2026-09-04T00:08:11.345875328Z" 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 Sep 4 00:08:11.345909 containerd[2420]: time="2026-09-04T00:08:11.345880624Z" level=info msg="loading plugin" id=io.containerd.internal.v1.tracing type=io.containerd.internal.v1 Sep 4 00:08:11.345909 containerd[2420]: time="2026-09-04T00:08:11.345886336Z" level=info msg="skip loading plugin" error="skip plugin: tracing endpoint not configured" id=io.containerd.internal.v1.tracing type=io.containerd.internal.v1 Sep 4 00:08:11.345909 containerd[2420]: time="2026-09-04T00:08:11.345890952Z" level=info msg="loading plugin" id=io.containerd.ttrpc.v1.otelttrpc type=io.containerd.ttrpc.v1 Sep 4 00:08:11.345909 containerd[2420]: time="2026-09-04T00:08:11.345899064Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.healthcheck type=io.containerd.grpc.v1 Sep 4 00:08:11.345909 containerd[2420]: time="2026-09-04T00:08:11.345905712Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.cri type=io.containerd.grpc.v1 Sep 4 00:08:11.346023 containerd[2420]: time="2026-09-04T00:08:11.345914560Z" level=info msg="Connect containerd service" Sep 4 00:08:11.346023 containerd[2420]: time="2026-09-04T00:08:11.345933920Z" level=info msg="using experimental NRI integration - disable nri plugin to prevent this" Sep 4 00:08:11.346937 containerd[2420]: time="2026-09-04T00:08:11.346907584Z" 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" Sep 4 00:08:12.160703 waagent[2638]: 2026-09-04T00:08:12.155805Z INFO Daemon Daemon Azure Linux Agent Version: 2.12.0.4 Sep 4 00:08:12.161374 waagent[2638]: 2026-09-04T00:08:12.161326Z INFO Daemon Daemon OS: flatcar 4757.1.0 Sep 4 00:08:12.164901 waagent[2638]: 2026-09-04T00:08:12.164866Z INFO Daemon Daemon Python: 3.12.13 Sep 4 00:08:12.169086 waagent[2638]: 2026-09-04T00:08:12.168329Z INFO Daemon Daemon Run daemon Sep 4 00:08:12.172374 waagent[2638]: 2026-09-04T00:08:12.172340Z INFO Daemon Daemon No RDMA handler exists for distro='Flatcar Container Linux by Kinvolk' version='4757.1.0' Sep 4 00:08:12.179351 waagent[2638]: 2026-09-04T00:08:12.179314Z INFO Daemon Daemon Using waagent for provisioning Sep 4 00:08:12.183304 waagent[2638]: 2026-09-04T00:08:12.183264Z INFO Daemon Daemon Activate resource disk Sep 4 00:08:12.186934 waagent[2638]: 2026-09-04T00:08:12.186896Z INFO Daemon Daemon Searching gen1 prefix 00000000-0001 or gen2 f8b3781a-1e82-4818-a1c3-63d806ec15bb Sep 4 00:08:12.195539 waagent[2638]: 2026-09-04T00:08:12.195494Z INFO Daemon Daemon Found device: None Sep 4 00:08:12.198956 waagent[2638]: 2026-09-04T00:08:12.198922Z ERROR Daemon Daemon Failed to mount resource disk [ResourceDiskError] unable to detect disk topology Sep 4 00:08:12.205356 waagent[2638]: 2026-09-04T00:08:12.205321Z ERROR Daemon Daemon Event: name=WALinuxAgent, op=ActivateResourceDisk, message=[ResourceDiskError] unable to detect disk topology, duration=0 Sep 4 00:08:12.214791 waagent[2638]: 2026-09-04T00:08:12.214748Z INFO Daemon Daemon Clean protocol and wireserver endpoint Sep 4 00:08:12.219375 waagent[2638]: 2026-09-04T00:08:12.219340Z INFO Daemon Daemon Running default provisioning handler Sep 4 00:08:12.228736 waagent[2638]: 2026-09-04T00:08:12.228417Z 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. Sep 4 00:08:12.238781 waagent[2638]: 2026-09-04T00:08:12.238744Z INFO Daemon Daemon Unable to get cloud-init enabled status from service: [Errno 2] No such file or directory: 'service' Sep 4 00:08:12.245934 waagent[2638]: 2026-09-04T00:08:12.245893Z INFO Daemon Daemon cloud-init is enabled: False Sep 4 00:08:12.249701 waagent[2638]: 2026-09-04T00:08:12.249667Z INFO Daemon Daemon Copying ovf-env.xml Sep 4 00:08:12.267605 waagent[2638]: 2026-09-04T00:08:12.267554Z INFO Daemon Daemon Successfully mounted dvd Sep 4 00:08:12.354276 systemd[1]: mnt-cdrom-secure.mount: Deactivated successfully. Sep 4 00:08:12.355066 waagent[2638]: 2026-09-04T00:08:12.355013Z INFO Daemon Daemon Detect protocol endpoint Sep 4 00:08:12.358979 waagent[2638]: 2026-09-04T00:08:12.358936Z INFO Daemon Daemon Clean protocol and wireserver endpoint Sep 4 00:08:12.363580 waagent[2638]: 2026-09-04T00:08:12.363543Z INFO Daemon Daemon WireServer endpoint is not found. Rerun dhcp handler Sep 4 00:08:12.368528 waagent[2638]: 2026-09-04T00:08:12.368493Z INFO Daemon Daemon Test for route to 168.63.129.16 Sep 4 00:08:12.372453 bash[2629]: 2026/09/04 00:08:12 Checking availability of "waagent" Sep 4 00:08:12.372949 waagent[2638]: 2026-09-04T00:08:12.372912Z INFO Daemon Daemon Route to 168.63.129.16 exists Sep 4 00:08:12.377036 waagent[2638]: 2026-09-04T00:08:12.377004Z INFO Daemon Daemon Wire server endpoint:168.63.129.16 Sep 4 00:08:12.402663 waagent[2638]: 2026-09-04T00:08:12.402624Z INFO Daemon Daemon Fabric preferred wire protocol version:2015-04-05 Sep 4 00:08:12.408164 waagent[2638]: 2026-09-04T00:08:12.408143Z INFO Daemon Daemon Wire protocol version:2012-11-30 Sep 4 00:08:12.412433 waagent[2638]: 2026-09-04T00:08:12.412357Z INFO Daemon Daemon Server preferred version:2015-04-05 Sep 4 00:08:12.523154 waagent[2638]: 2026-09-04T00:08:12.523080Z INFO Daemon Daemon Initializing goal state during protocol detection Sep 4 00:08:12.528558 waagent[2638]: 2026-09-04T00:08:12.528491Z INFO Daemon Daemon Forcing an update of the goal state. Sep 4 00:08:12.538826 waagent[2638]: 2026-09-04T00:08:12.538780Z INFO Daemon Fetched a new incarnation for the WireServer goal state [incarnation 1] Sep 4 00:08:12.560976 waagent[2638]: 2026-09-04T00:08:12.560926Z INFO Daemon Daemon HostGAPlugin version: 1.0.8.184 Sep 4 00:08:12.565800 waagent[2638]: 2026-09-04T00:08:12.565758Z INFO Daemon Sep 4 00:08:12.568126 waagent[2638]: 2026-09-04T00:08:12.568093Z INFO Daemon Fetched new vmSettings [HostGAPlugin correlation ID: 39144692-6758-48b7-a11f-422c8b40ebea eTag: 11823851459885331976 source: Fabric] Sep 4 00:08:12.578704 waagent[2638]: 2026-09-04T00:08:12.578654Z INFO Daemon The vmSettings originated via Fabric; will ignore them. Sep 4 00:08:12.584090 waagent[2638]: 2026-09-04T00:08:12.584050Z INFO Daemon Sep 4 00:08:12.586517 waagent[2638]: 2026-09-04T00:08:12.586486Z INFO Daemon Fetching full goal state from the WireServer [incarnation 1] Sep 4 00:08:12.595639 waagent[2638]: 2026-09-04T00:08:12.595602Z INFO Daemon Daemon Downloading artifacts profile blob Sep 4 00:08:12.690458 waagent[2638]: 2026-09-04T00:08:12.690342Z INFO Daemon Downloaded certificate {'thumbprint': '72F2C15BB0E7914F70C4BC6AD13964B9960AD9EE', 'hasPrivateKey': True} Sep 4 00:08:12.698602 waagent[2638]: 2026-09-04T00:08:12.698552Z INFO Daemon Fetch goal state completed Sep 4 00:08:12.709144 waagent[2638]: 2026-09-04T00:08:12.709101Z INFO Daemon Daemon Starting provisioning Sep 4 00:08:12.713447 waagent[2638]: 2026-09-04T00:08:12.713403Z INFO Daemon Daemon Handle ovf-env.xml. Sep 4 00:08:12.717622 waagent[2638]: 2026-09-04T00:08:12.717580Z INFO Daemon Daemon Set hostname [ci-4757.1.0-n-5186669828] Sep 4 00:08:12.724757 waagent[2638]: 2026-09-04T00:08:12.724713Z INFO Daemon Daemon Publish hostname [ci-4757.1.0-n-5186669828] Sep 4 00:08:12.730194 waagent[2638]: 2026-09-04T00:08:12.730145Z INFO Daemon Daemon Examine /proc/net/route for primary interface Sep 4 00:08:12.735612 waagent[2638]: 2026-09-04T00:08:12.735568Z INFO Daemon Daemon Primary interface is [eth0] Sep 4 00:08:12.746263 systemd-networkd[2130]: eth0: Found matching .network file, based on potentially unpredictable interface name: /usr/lib/systemd/network/zz-default.network Sep 4 00:08:12.746271 systemd-networkd[2130]: eth0: Reconfiguring with /usr/lib/systemd/network/zz-default.network. Sep 4 00:08:12.746322 systemd-networkd[2130]: eth0: DHCP lease lost Sep 4 00:08:12.766245 waagent[2638]: 2026-09-04T00:08:12.763517Z INFO Daemon Daemon Create user account if not exists Sep 4 00:08:12.768162 waagent[2638]: 2026-09-04T00:08:12.768111Z INFO Daemon Daemon User core already exists, skip useradd Sep 4 00:08:12.773050 waagent[2638]: 2026-09-04T00:08:12.773002Z INFO Daemon Daemon Configure sudoer Sep 4 00:08:12.773296 systemd-networkd[2130]: eth0: DHCPv4 address 10.0.0.20/24, gateway 10.0.0.1 acquired from 168.63.129.16 Sep 4 00:08:12.777661 waagent[2638]: 2026-09-04T00:08:12.777612Z INFO Daemon Daemon Configure sshd Sep 4 00:08:12.781528 waagent[2638]: 2026-09-04T00:08:12.781484Z INFO Daemon Daemon Added a configuration snippet disabling SSH password-based authentication methods. It also configures SSH client probing to keep connections alive. Sep 4 00:08:12.791739 waagent[2638]: 2026-09-04T00:08:12.791692Z INFO Daemon Daemon Deploy ssh public key. Sep 4 00:08:12.816760 containerd[2420]: time="2026-09-04T00:08:12.816701776Z" level=info msg="Start subscribing containerd event" Sep 4 00:08:12.817614 containerd[2420]: time="2026-09-04T00:08:12.817255184Z" level=info msg="Start recovering state" Sep 4 00:08:12.817614 containerd[2420]: time="2026-09-04T00:08:12.817506432Z" level=info msg="Start event monitor" Sep 4 00:08:12.817614 containerd[2420]: time="2026-09-04T00:08:12.817535896Z" level=info msg="Start cni network conf syncer for default" Sep 4 00:08:12.817614 containerd[2420]: time="2026-09-04T00:08:12.817547312Z" level=info msg="Start streaming server" Sep 4 00:08:12.817614 containerd[2420]: time="2026-09-04T00:08:12.817559648Z" level=info msg="Registered namespace \"k8s.io\" with NRI" Sep 4 00:08:12.817614 containerd[2420]: time="2026-09-04T00:08:12.817564608Z" level=info msg="runtime interface starting up..." Sep 4 00:08:12.817614 containerd[2420]: time="2026-09-04T00:08:12.817568520Z" level=info msg="starting plugins..." Sep 4 00:08:12.817614 containerd[2420]: time="2026-09-04T00:08:12.817580920Z" level=info msg="Synchronizing NRI (plugin) with current runtime state" Sep 4 00:08:12.840310 containerd[2420]: time="2026-09-04T00:08:12.840158704Z" level=info msg=serving... address=/run/containerd/containerd.sock.ttrpc Sep 4 00:08:12.840310 containerd[2420]: time="2026-09-04T00:08:12.840221312Z" level=info msg=serving... address=/run/containerd/containerd.sock Sep 4 00:08:12.845700 containerd[2420]: time="2026-09-04T00:08:12.840824440Z" level=info msg="containerd successfully booted in 1.541971s" Sep 4 00:08:12.841103 systemd[1]: Started containerd.service - containerd container runtime. Sep 4 00:08:13.891166 waagent[2638]: 2026-09-04T00:08:13.891118Z INFO Daemon Daemon Provisioning complete Sep 4 00:08:13.901450 waagent[2638]: 2026-09-04T00:08:13.901413Z INFO Daemon Daemon RDMA capabilities are not enabled, skipping Sep 4 00:08:13.906276 waagent[2638]: 2026-09-04T00:08:13.906241Z INFO Daemon Daemon End of log to /dev/console. The agent will now check for updates and then will process extensions. Sep 4 00:08:13.913447 waagent[2638]: 2026-09-04T00:08:13.913414Z INFO Daemon Daemon Installed Agent WALinuxAgent-2.12.0.4 is the most current agent Sep 4 00:08:14.020033 waagent[2695]: 2026-09-04T00:08:14.019964Z INFO ExtHandler ExtHandler Azure Linux Agent (Goal State Agent version 2.12.0.4) Sep 4 00:08:14.020887 waagent[2695]: 2026-09-04T00:08:14.020544Z INFO ExtHandler ExtHandler OS: flatcar 4757.1.0 Sep 4 00:08:14.020887 waagent[2695]: 2026-09-04T00:08:14.020609Z INFO ExtHandler ExtHandler Python: 3.12.13 Sep 4 00:08:14.020887 waagent[2695]: 2026-09-04T00:08:14.020643Z INFO ExtHandler ExtHandler CPU Arch: aarch64 Sep 4 00:08:14.071274 waagent[2695]: 2026-09-04T00:08:14.071026Z INFO ExtHandler ExtHandler Distro: flatcar-4757.1.0; OSUtil: FlatcarUtil; AgentService: waagent; Python: 3.12.13; Arch: aarch64; systemd: True; LISDrivers: Absent; logrotate: logrotate 3.22.0; Sep 4 00:08:14.071400 waagent[2695]: 2026-09-04T00:08:14.071284Z INFO ExtHandler ExtHandler WireServer endpoint 168.63.129.16 read from file Sep 4 00:08:14.071400 waagent[2695]: 2026-09-04T00:08:14.071350Z INFO ExtHandler ExtHandler Wire server endpoint:168.63.129.16 Sep 4 00:08:14.077084 waagent[2695]: 2026-09-04T00:08:14.077032Z INFO ExtHandler Fetched a new incarnation for the WireServer goal state [incarnation 1] Sep 4 00:08:14.081817 waagent[2695]: 2026-09-04T00:08:14.081783Z INFO ExtHandler ExtHandler HostGAPlugin version: 1.0.8.184 Sep 4 00:08:14.082233 waagent[2695]: 2026-09-04T00:08:14.082201Z INFO ExtHandler Sep 4 00:08:14.082323 waagent[2695]: 2026-09-04T00:08:14.082300Z INFO ExtHandler Fetched new vmSettings [HostGAPlugin correlation ID: d1ba6db6-a2cb-4759-8a82-f2975cbf51dd eTag: 11823851459885331976 source: Fabric] Sep 4 00:08:14.082555 waagent[2695]: 2026-09-04T00:08:14.082527Z INFO ExtHandler The vmSettings originated via Fabric; will ignore them. Sep 4 00:08:14.082996 waagent[2695]: 2026-09-04T00:08:14.082964Z INFO ExtHandler Sep 4 00:08:14.083040 waagent[2695]: 2026-09-04T00:08:14.083024Z INFO ExtHandler Fetching full goal state from the WireServer [incarnation 1] Sep 4 00:08:14.086122 waagent[2695]: 2026-09-04T00:08:14.086091Z INFO ExtHandler ExtHandler Downloading artifacts profile blob Sep 4 00:08:14.141677 waagent[2695]: 2026-09-04T00:08:14.141549Z INFO ExtHandler Downloaded certificate {'thumbprint': '72F2C15BB0E7914F70C4BC6AD13964B9960AD9EE', 'hasPrivateKey': True} Sep 4 00:08:14.142033 waagent[2695]: 2026-09-04T00:08:14.141992Z INFO ExtHandler Fetch goal state completed Sep 4 00:08:14.151878 waagent[2695]: 2026-09-04T00:08:14.151821Z INFO ExtHandler ExtHandler OpenSSL version: OpenSSL 3.5.7 9 Jun 2026 (Library: OpenSSL 3.5.7 9 Jun 2026) Sep 4 00:08:14.157487 waagent[2695]: 2026-09-04T00:08:14.157427Z INFO ExtHandler ExtHandler WALinuxAgent-2.12.0.4 running as process 2695 Sep 4 00:08:14.157609 waagent[2695]: 2026-09-04T00:08:14.157579Z INFO ExtHandler ExtHandler ******** AutoUpdate.Enabled is set to False, not processing the operation ******** Sep 4 00:08:14.157871 waagent[2695]: 2026-09-04T00:08:14.157842Z INFO ExtHandler ExtHandler ******** AutoUpdate.UpdateToLatestVersion is set to False, not processing the operation ******** Sep 4 00:08:14.159040 waagent[2695]: 2026-09-04T00:08:14.159001Z INFO ExtHandler ExtHandler [CGI] Cgroup monitoring is not supported on ['flatcar', '4757.1.0', '', 'Flatcar Container Linux by Kinvolk'] Sep 4 00:08:14.159421 waagent[2695]: 2026-09-04T00:08:14.159388Z INFO ExtHandler ExtHandler [CGI] Agent will reset the quotas in case distro: ['flatcar', '4757.1.0', '', 'Flatcar Container Linux by Kinvolk'] went from supported to unsupported Sep 4 00:08:14.159525 waagent[2695]: 2026-09-04T00:08:14.159505Z INFO ExtHandler ExtHandler [CGI] Agent cgroups enabled: False Sep 4 00:08:14.159969 waagent[2695]: 2026-09-04T00:08:14.159938Z INFO ExtHandler ExtHandler Starting setup for Persistent firewall rules Sep 4 00:08:14.206003 waagent[2695]: 2026-09-04T00:08:14.205960Z INFO ExtHandler ExtHandler Firewalld service not running/unavailable, trying to set up waagent-network-setup.service Sep 4 00:08:14.206206 waagent[2695]: 2026-09-04T00:08:14.206176Z INFO ExtHandler ExtHandler Successfully updated the Binary file /var/lib/waagent/waagent-network-setup.py for firewall setup Sep 4 00:08:14.210465 waagent[2695]: 2026-09-04T00:08:14.210426Z INFO ExtHandler ExtHandler Service: waagent-network-setup.service not enabled. Adding it now Sep 4 00:08:14.215093 systemd[1]: Reload requested from client PID 2710 ('systemctl') (unit waagent.service)... Sep 4 00:08:14.215110 systemd[1]: Reloading... Sep 4 00:08:14.304257 zram_generator::config[2758]: No configuration found. Sep 4 00:08:14.508859 systemd[1]: Reloading finished in 293 ms. Sep 4 00:08:14.530500 waagent[2695]: 2026-09-04T00:08:14.530423Z INFO ExtHandler ExtHandler Successfully added and enabled the waagent-network-setup.service Sep 4 00:08:14.530600 waagent[2695]: 2026-09-04T00:08:14.530573Z INFO ExtHandler ExtHandler Persistent firewall rules setup successfully Sep 4 00:08:14.797759 login[2640]: pam_unix(login:session): session opened for user core(uid=500) by core(uid=0) Sep 4 00:08:14.806061 systemd-logind[2384]: New session '1' of user 'core' with class 'user-light' and type 'tty'. Sep 4 00:08:14.808075 systemd[1]: Created slice user-500.slice - User Slice of UID 500. Sep 4 00:08:14.813509 systemd[1]: Starting user-runtime-dir@500.service - User Runtime Directory /run/user/500... Sep 4 00:08:14.856909 waagent[2695]: 2026-09-04T00:08:14.856838Z INFO ExtHandler ExtHandler DROP rule is not available which implies no firewall rules are set yet. Environment thread will set it up. Sep 4 00:08:14.857201 waagent[2695]: 2026-09-04T00:08:14.857163Z 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] Sep 4 00:08:14.858689 waagent[2695]: 2026-09-04T00:08:14.858006Z INFO MonitorHandler ExtHandler WireServer endpoint 168.63.129.16 read from file Sep 4 00:08:14.858689 waagent[2695]: 2026-09-04T00:08:14.858091Z INFO MonitorHandler ExtHandler Wire server endpoint:168.63.129.16 Sep 4 00:08:14.858689 waagent[2695]: 2026-09-04T00:08:14.858302Z INFO MonitorHandler ExtHandler Monitor.NetworkConfigurationChanges is disabled. Sep 4 00:08:14.858689 waagent[2695]: 2026-09-04T00:08:14.858460Z INFO MonitorHandler ExtHandler Routing table from /proc/net/route: Sep 4 00:08:14.858689 waagent[2695]: Iface Destination Gateway Flags RefCnt Use Metric Mask MTU Window IRTT Sep 4 00:08:14.858689 waagent[2695]: eth0 00000000 0100000A 0003 0 0 1024 00000000 0 0 0 Sep 4 00:08:14.858689 waagent[2695]: eth0 0000000A 00000000 0001 0 0 1024 00FFFFFF 0 0 0 Sep 4 00:08:14.858689 waagent[2695]: eth0 0100000A 00000000 0005 0 0 1024 FFFFFFFF 0 0 0 Sep 4 00:08:14.858689 waagent[2695]: eth0 10813FA8 0100000A 0007 0 0 1024 FFFFFFFF 0 0 0 Sep 4 00:08:14.858689 waagent[2695]: eth0 FEA9FEA9 0100000A 0007 0 0 1024 FFFFFFFF 0 0 0 Sep 4 00:08:14.863062 waagent[2695]: 2026-09-04T00:08:14.861315Z INFO ExtHandler ExtHandler Starting env monitor service. Sep 4 00:08:14.863062 waagent[2695]: 2026-09-04T00:08:14.861702Z INFO EnvHandler ExtHandler WireServer endpoint 168.63.129.16 read from file Sep 4 00:08:14.863062 waagent[2695]: 2026-09-04T00:08:14.861762Z INFO EnvHandler ExtHandler Wire server endpoint:168.63.129.16 Sep 4 00:08:14.863062 waagent[2695]: 2026-09-04T00:08:14.861855Z INFO ExtHandler ExtHandler Start SendTelemetryHandler service. Sep 4 00:08:14.863062 waagent[2695]: 2026-09-04T00:08:14.862192Z INFO SendTelemetryHandler ExtHandler Successfully started the SendTelemetryHandler thread Sep 4 00:08:14.863062 waagent[2695]: 2026-09-04T00:08:14.862402Z INFO EnvHandler ExtHandler Configure routes Sep 4 00:08:14.863062 waagent[2695]: 2026-09-04T00:08:14.862461Z INFO EnvHandler ExtHandler Gateway:None Sep 4 00:08:14.863062 waagent[2695]: 2026-09-04T00:08:14.862491Z INFO EnvHandler ExtHandler Routes:None Sep 4 00:08:14.863062 waagent[2695]: 2026-09-04T00:08:14.863026Z INFO ExtHandler ExtHandler Start Extension Telemetry service. Sep 4 00:08:14.864570 systemd[1]: Finished user-runtime-dir@500.service - User Runtime Directory /run/user/500. Sep 4 00:08:14.867094 waagent[2695]: 2026-09-04T00:08:14.867061Z INFO ExtHandler ExtHandler Goal State Period: 6 sec. This indicates how often the agent checks for new goal states and reports status. Sep 4 00:08:14.867877 waagent[2695]: 2026-09-04T00:08:14.867022Z INFO TelemetryEventsCollector ExtHandler Extension Telemetry pipeline enabled: True Sep 4 00:08:14.867877 waagent[2695]: 2026-09-04T00:08:14.867571Z INFO TelemetryEventsCollector ExtHandler Successfully started the TelemetryEventsCollector thread Sep 4 00:08:14.877698 waagent[2695]: 2026-09-04T00:08:14.877653Z INFO ExtHandler ExtHandler Sep 4 00:08:14.877919 waagent[2695]: 2026-09-04T00:08:14.877888Z INFO ExtHandler ExtHandler ProcessExtensionsGoalState started [incarnation_1 channel: WireServer source: Fabric activity: d3eaa71b-0dc6-45a7-a4bb-c59bef269282 correlation 73d5ce96-054e-4d15-9561-4a1ad91c114d created: 2026-09-04T00:07:14.251389Z] Sep 4 00:08:14.878505 waagent[2695]: 2026-09-04T00:08:14.878402Z INFO ExtHandler ExtHandler No extension handlers found, not processing anything. Sep 4 00:08:14.879055 waagent[2695]: 2026-09-04T00:08:14.879020Z INFO ExtHandler ExtHandler ProcessExtensionsGoalState completed [incarnation_1 1 ms] Sep 4 00:08:14.903735 login[2641]: pam_unix(login:session): session opened for user core(uid=500) by core(uid=0) Sep 4 00:08:14.905775 systemd[1]: Started session-1.scope - Session 1 of User core. Sep 4 00:08:14.920665 waagent[2695]: 2026-09-04T00:08:14.919468Z INFO MonitorHandler ExtHandler Network interfaces: Sep 4 00:08:14.920665 waagent[2695]: Executing ['ip', '-a', '-o', 'link']: Sep 4 00:08:14.920665 waagent[2695]: 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 Sep 4 00:08:14.920665 waagent[2695]: 2: eth0: mtu 1500 qdisc mq state UP mode DEFAULT group default qlen 1000\ link/ether 00:22:48:7b:8c:e2 brd ff:ff:ff:ff:ff:ff\ altname enx0022487b8ce2 Sep 4 00:08:14.920665 waagent[2695]: 3: enP35451s1: mtu 1500 qdisc mq master eth0 state UP mode DEFAULT group default qlen 1000\ link/ether 00:22:48:7b:8c:e2 brd ff:ff:ff:ff:ff:ff\ altname enP35451p0s2 Sep 4 00:08:14.920665 waagent[2695]: Executing ['ip', '-4', '-a', '-o', 'address']: Sep 4 00:08:14.920665 waagent[2695]: 1: lo inet 127.0.0.1/8 scope host lo\ valid_lft forever preferred_lft forever Sep 4 00:08:14.920665 waagent[2695]: 2: eth0 inet 10.0.0.20/24 metric 1024 brd 10.0.0.255 scope global eth0\ valid_lft forever preferred_lft forever Sep 4 00:08:14.920665 waagent[2695]: Executing ['ip', '-6', '-a', '-o', 'address']: Sep 4 00:08:14.920665 waagent[2695]: 1: lo inet6 ::1/128 scope host noprefixroute \ valid_lft forever preferred_lft forever Sep 4 00:08:14.920665 waagent[2695]: 2: eth0 inet6 fe80::222:48ff:fe7b:8ce2/64 scope link proto kernel_ll \ valid_lft forever preferred_lft forever Sep 4 00:08:14.924552 systemd-logind[2384]: New session '2' of user 'core' with class 'user-light' and type 'tty'. Sep 4 00:08:14.926502 waagent[2695]: 2026-09-04T00:08:14.926460Z INFO ExtHandler ExtHandler [HEARTBEAT] Agent WALinuxAgent-2.12.0.4 is running as the goal state agent [DEBUG HeartbeatCounter: 0;HeartbeatId: 942A990C-5B93-44B4-8C4C-EFAED8A3F29A;DroppedPackets: 0;UpdateGSErrors: 0;AutoUpdate: 0;UpdateMode: SelfUpdate;] Sep 4 00:08:14.929433 systemd[1]: Started session-2.scope - Session 2 of User core. Sep 4 00:08:15.019889 waagent[2695]: 2026-09-04T00:08:15.019819Z INFO EnvHandler ExtHandler Created firewall rules for the Azure Fabric: Sep 4 00:08:15.019889 waagent[2695]: Chain INPUT (policy ACCEPT 0 packets, 0 bytes) Sep 4 00:08:15.019889 waagent[2695]: pkts bytes target prot opt in out source destination Sep 4 00:08:15.019889 waagent[2695]: Chain FORWARD (policy ACCEPT 0 packets, 0 bytes) Sep 4 00:08:15.019889 waagent[2695]: pkts bytes target prot opt in out source destination Sep 4 00:08:15.019889 waagent[2695]: Chain OUTPUT (policy ACCEPT 0 packets, 0 bytes) Sep 4 00:08:15.019889 waagent[2695]: pkts bytes target prot opt in out source destination Sep 4 00:08:15.019889 waagent[2695]: 0 0 ACCEPT tcp -- * * 0.0.0.0/0 168.63.129.16 tcp dpt:53 Sep 4 00:08:15.019889 waagent[2695]: 0 0 ACCEPT tcp -- * * 0.0.0.0/0 168.63.129.16 owner UID match 0 Sep 4 00:08:15.019889 waagent[2695]: 0 0 DROP tcp -- * * 0.0.0.0/0 168.63.129.16 ctstate INVALID,NEW Sep 4 00:08:15.022292 waagent[2695]: 2026-09-04T00:08:15.022247Z INFO EnvHandler ExtHandler Current Firewall rules: Sep 4 00:08:15.022292 waagent[2695]: Chain INPUT (policy ACCEPT 0 packets, 0 bytes) Sep 4 00:08:15.022292 waagent[2695]: pkts bytes target prot opt in out source destination Sep 4 00:08:15.022292 waagent[2695]: Chain FORWARD (policy ACCEPT 0 packets, 0 bytes) Sep 4 00:08:15.022292 waagent[2695]: pkts bytes target prot opt in out source destination Sep 4 00:08:15.022292 waagent[2695]: Chain OUTPUT (policy ACCEPT 0 packets, 0 bytes) Sep 4 00:08:15.022292 waagent[2695]: pkts bytes target prot opt in out source destination Sep 4 00:08:15.022292 waagent[2695]: 0 0 ACCEPT tcp -- * * 0.0.0.0/0 168.63.129.16 tcp dpt:53 Sep 4 00:08:15.022292 waagent[2695]: 0 0 ACCEPT tcp -- * * 0.0.0.0/0 168.63.129.16 owner UID match 0 Sep 4 00:08:15.022292 waagent[2695]: 0 0 DROP tcp -- * * 0.0.0.0/0 168.63.129.16 ctstate INVALID,NEW Sep 4 00:08:15.022645 waagent[2695]: 2026-09-04T00:08:15.022481Z INFO EnvHandler ExtHandler Set block dev timeout: sda with timeout: 300 Sep 4 00:08:15.575370 bash[2629]: 2026/09/04 00:08:15 Checking availability of "waagent" Sep 4 00:08:15.575370 bash[2629]: 2026/09/04 00:08:15 Fetching meta-data from datasource of type "waagent" Sep 4 00:08:15.575370 bash[2629]: 2026/09/04 00:08:15 Attempting to read from "/var/lib/waagent/SharedConfig.xml" Sep 4 00:08:15.575370 bash[2629]: 2026/09/04 00:08:15 Fetching user-data from datasource of type "waagent" Sep 4 00:08:15.575370 bash[2629]: 2026/09/04 00:08:15 Attempting to read from "/var/lib/waagent/CustomData" Sep 4 00:08:15.576493 systemd[1]: oem-cloudinit.service: Deactivated successfully. Sep 4 00:08:15.576773 systemd[1]: Finished oem-cloudinit.service - Run cloudinit. Sep 4 00:08:15.582838 systemd[1]: Finished enable-oem-cloudinit.service - Enable cloudinit. Sep 4 00:08:15.588199 systemd[1]: Reached target multi-user.target - Multi-User System. Sep 4 00:08:15.592918 systemd[1]: Startup finished in 2.536s (kernel) + 14.038s (initrd) + 20.686s (userspace) = 37.261s. Sep 4 00:08:32.071313 systemd[1]: Created slice system-sshd.slice - Slice /system/sshd. Sep 4 00:08:32.072783 systemd[1]: Started sshd@0-1-10.0.0.20:22-20.61.25.254:38650.service - OpenSSH per-connection server daemon (20.61.25.254:38650). Sep 4 00:08:32.132324 chronyd[2368]: Selected source PHC0 Sep 4 00:08:32.959266 sshd[2888]: Accepted publickey for core from 20.61.25.254 port 38650 ssh2: RSA SHA256:tbjv1+r4j9eDOBuGN+IdTOTnP31nluCgkOTwCxL9qlM Sep 4 00:08:32.960417 sshd-session[2888]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Sep 4 00:08:32.966364 systemd-logind[2384]: New session '3' of user 'core' with class 'user' and type 'tty'. Sep 4 00:08:32.973336 systemd[1]: Starting user@500.service - User Manager for UID 500... Sep 4 00:08:32.980829 (systemd)[2892]: pam_unix(systemd-user:session): session opened for user core(uid=500) by core(uid=0) Sep 4 00:08:32.982863 systemd-logind[2384]: New session '4' of user 'core' with class 'manager-early' and type 'unspecified'. Sep 4 00:08:33.188672 systemd[2892]: Queued start job for default target default.target. Sep 4 00:08:33.197963 systemd[2892]: Created slice app.slice - User Application Slice. Sep 4 00:08:33.197994 systemd[2892]: Started systemd-tmpfiles-clean.timer - Daily Cleanup of User's Temporary Directories. Sep 4 00:08:33.198005 systemd[2892]: Reached target machines.target - Virtual Machines and Containers. Sep 4 00:08:33.198049 systemd[2892]: Reached target paths.target - Paths. Sep 4 00:08:33.198070 systemd[2892]: Reached target timers.target - Timers. Sep 4 00:08:33.199118 systemd[2892]: Starting dbus.socket - D-Bus User Message Bus Socket... Sep 4 00:08:33.200270 systemd[2892]: Listening on systemd-ask-password.socket - Query the User Interactively for a Password. Sep 4 00:08:33.200406 systemd[2892]: Listening on systemd-importd.socket - Disk Image Download Service Socket. Sep 4 00:08:33.201035 systemd[2892]: Listening on systemd-journalctl.socket - Journal Log Access Socket. Sep 4 00:08:33.201203 systemd[2892]: Listening on systemd-machined.socket - Virtual Machine and Container Registration Service Socket. Sep 4 00:08:33.204391 systemd[2892]: Starting systemd-tmpfiles-setup.service - Create User Files and Directories... Sep 4 00:08:33.209328 systemd[2892]: Listening on dbus.socket - D-Bus User Message Bus Socket. Sep 4 00:08:33.209414 systemd[2892]: Reached target sockets.target - Sockets. Sep 4 00:08:33.213876 systemd[2892]: Finished systemd-tmpfiles-setup.service - Create User Files and Directories. Sep 4 00:08:33.213965 systemd[2892]: Reached target basic.target - Basic System. Sep 4 00:08:33.214007 systemd[2892]: Reached target default.target - Main User Target. Sep 4 00:08:33.214029 systemd[2892]: Startup finished in 227ms. Sep 4 00:08:33.214328 systemd[1]: Started user@500.service - User Manager for UID 500. Sep 4 00:08:33.220394 systemd[1]: Started session-3.scope - Session 3 of User core. Sep 4 00:08:33.656483 systemd[1]: Started sshd@1-2-10.0.0.20:22-20.61.25.254:38660.service - OpenSSH per-connection server daemon (20.61.25.254:38660). Sep 4 00:08:34.388251 sshd[2906]: Accepted publickey for core from 20.61.25.254 port 38660 ssh2: RSA SHA256:tbjv1+r4j9eDOBuGN+IdTOTnP31nluCgkOTwCxL9qlM Sep 4 00:08:34.389282 sshd-session[2906]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Sep 4 00:08:34.393010 systemd-logind[2384]: New session '5' of user 'core' with class 'user' and type 'tty'. Sep 4 00:08:34.403524 systemd[1]: Started session-5.scope - Session 5 of User core. Sep 4 00:08:34.809347 sshd[2910]: Connection closed by 20.61.25.254 port 38660 Sep 4 00:08:34.809977 sshd-session[2906]: pam_unix(sshd:session): session closed for user core Sep 4 00:08:34.812828 systemd[1]: sshd@1-2-10.0.0.20:22-20.61.25.254:38660.service: Deactivated successfully. Sep 4 00:08:34.814752 systemd[1]: session-5.scope: Deactivated successfully. Sep 4 00:08:34.815489 systemd-logind[2384]: Session 5 logged out. Waiting for processes to exit. Sep 4 00:08:34.816528 systemd-logind[2384]: Removed session 5. Sep 4 00:08:34.959395 systemd[1]: Started sshd@2-4097-10.0.0.20:22-20.61.25.254:38664.service - OpenSSH per-connection server daemon (20.61.25.254:38664). Sep 4 00:08:35.694200 sshd[2916]: Accepted publickey for core from 20.61.25.254 port 38664 ssh2: RSA SHA256:tbjv1+r4j9eDOBuGN+IdTOTnP31nluCgkOTwCxL9qlM Sep 4 00:08:35.695324 sshd-session[2916]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Sep 4 00:08:35.698919 systemd-logind[2384]: New session '6' of user 'core' with class 'user' and type 'tty'. Sep 4 00:08:35.705369 systemd[1]: Started session-6.scope - Session 6 of User core. Sep 4 00:08:36.113842 sshd[2920]: Connection closed by 20.61.25.254 port 38664 Sep 4 00:08:36.114591 sshd-session[2916]: pam_unix(sshd:session): session closed for user core Sep 4 00:08:36.117388 systemd[1]: sshd@2-4097-10.0.0.20:22-20.61.25.254:38664.service: Deactivated successfully. Sep 4 00:08:36.118998 systemd[1]: session-6.scope: Deactivated successfully. Sep 4 00:08:36.120373 systemd-logind[2384]: Session 6 logged out. Waiting for processes to exit. Sep 4 00:08:36.121177 systemd-logind[2384]: Removed session 6. Sep 4 00:08:36.267178 systemd[1]: Started sshd@3-4098-10.0.0.20:22-20.61.25.254:38124.service - OpenSSH per-connection server daemon (20.61.25.254:38124). Sep 4 00:08:37.002429 sshd[2926]: Accepted publickey for core from 20.61.25.254 port 38124 ssh2: RSA SHA256:tbjv1+r4j9eDOBuGN+IdTOTnP31nluCgkOTwCxL9qlM Sep 4 00:08:37.003524 sshd-session[2926]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Sep 4 00:08:37.007456 systemd-logind[2384]: New session '7' of user 'core' with class 'user' and type 'tty'. Sep 4 00:08:37.014541 systemd[1]: Started session-7.scope - Session 7 of User core. Sep 4 00:08:37.425004 sshd[2930]: Connection closed by 20.61.25.254 port 38124 Sep 4 00:08:37.425682 sshd-session[2926]: pam_unix(sshd:session): session closed for user core Sep 4 00:08:37.428396 systemd[1]: sshd@3-4098-10.0.0.20:22-20.61.25.254:38124.service: Deactivated successfully. Sep 4 00:08:37.431000 systemd[1]: session-7.scope: Deactivated successfully. Sep 4 00:08:37.432894 systemd-logind[2384]: Session 7 logged out. Waiting for processes to exit. Sep 4 00:08:37.434124 systemd-logind[2384]: Removed session 7. Sep 4 00:08:37.576062 systemd[1]: Started sshd@4-3-10.0.0.20:22-20.61.25.254:38134.service - OpenSSH per-connection server daemon (20.61.25.254:38134). Sep 4 00:08:38.311109 sshd[2936]: Accepted publickey for core from 20.61.25.254 port 38134 ssh2: RSA SHA256:tbjv1+r4j9eDOBuGN+IdTOTnP31nluCgkOTwCxL9qlM Sep 4 00:08:38.311985 sshd-session[2936]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Sep 4 00:08:38.316297 systemd-logind[2384]: New session '8' of user 'core' with class 'user' and type 'tty'. Sep 4 00:08:38.326393 systemd[1]: Started session-8.scope - Session 8 of User core. Sep 4 00:08:38.706976 sudo[2941]: core : PWD=/home/core ; USER=root ; COMMAND=/usr/sbin/setenforce 1 Sep 4 00:08:38.707205 sudo[2941]: pam_unix(sudo:session): session opened for user root(uid=0) by core(uid=500) Sep 4 00:08:38.737714 sudo[2941]: pam_unix(sudo:session): session closed for user root Sep 4 00:08:38.878857 sshd[2940]: Connection closed by 20.61.25.254 port 38134 Sep 4 00:08:38.877912 sshd-session[2936]: pam_unix(sshd:session): session closed for user core Sep 4 00:08:38.880565 systemd[1]: sshd@4-3-10.0.0.20:22-20.61.25.254:38134.service: Deactivated successfully. Sep 4 00:08:38.882422 systemd[1]: session-8.scope: Deactivated successfully. Sep 4 00:08:38.884445 systemd-logind[2384]: Session 8 logged out. Waiting for processes to exit. Sep 4 00:08:38.885341 systemd-logind[2384]: Removed session 8. Sep 4 00:08:39.027464 systemd[1]: Started sshd@5-4-10.0.0.20:22-20.61.25.254:38138.service - OpenSSH per-connection server daemon (20.61.25.254:38138). Sep 4 00:08:39.763451 sshd[2948]: Accepted publickey for core from 20.61.25.254 port 38138 ssh2: RSA SHA256:tbjv1+r4j9eDOBuGN+IdTOTnP31nluCgkOTwCxL9qlM Sep 4 00:08:39.764641 sshd-session[2948]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Sep 4 00:08:39.768849 systemd-logind[2384]: New session '9' of user 'core' with class 'user' and type 'tty'. Sep 4 00:08:39.779377 systemd[1]: Started session-9.scope - Session 9 of User core. Sep 4 00:08:40.048613 sudo[2954]: 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 Sep 4 00:08:40.048834 sudo[2954]: pam_unix(sudo:session): session opened for user root(uid=0) by core(uid=500) Sep 4 00:08:40.050221 sudo[2954]: pam_unix(sudo:session): session closed for user root Sep 4 00:08:40.055200 sudo[2953]: core : PWD=/home/core ; USER=root ; COMMAND=/usr/sbin/systemctl restart audit-rules Sep 4 00:08:40.055788 sudo[2953]: pam_unix(sudo:session): session opened for user root(uid=0) by core(uid=500) Sep 4 00:08:40.061828 systemd[1]: Starting audit-rules.service - Load Audit Rules... Sep 4 00:08:40.106000 audit: CONFIG_CHANGE auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 op=remove_rule key=(null) list=5 res=1 Sep 4 00:08:40.118172 kernel: kauditd_printk_skb: 72 callbacks suppressed Sep 4 00:08:40.118251 augenrules[2978]: No rules Sep 4 00:08:40.118377 kernel: audit: type=1305 audit(1788480520.106:167): auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 op=remove_rule key=(null) list=5 res=1 Sep 4 00:08:40.119111 systemd[1]: audit-rules.service: Deactivated successfully. Sep 4 00:08:40.119593 systemd[1]: Finished audit-rules.service - Load Audit Rules. Sep 4 00:08:40.124254 sudo[2953]: pam_unix(sudo:session): session closed for user root Sep 4 00:08:40.106000 audit[2978]: SYSCALL arch=c00000b7 syscall=206 success=yes exit=1056 a0=3 a1=fffff6a162c0 a2=420 a3=0 items=0 ppid=2959 pid=2978 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) Sep 4 00:08:40.141001 kernel: audit: type=1300 audit(1788480520.106:167): arch=c00000b7 syscall=206 success=yes exit=1056 a0=3 a1=fffff6a162c0 a2=420 a3=0 items=0 ppid=2959 pid=2978 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) Sep 4 00:08:40.106000 audit: PROCTITLE proctitle=2F7362696E2F617564697463746C002D52002F6574632F61756469742F61756469742E72756C6573 Sep 4 00:08:40.141103 kernel: audit: type=1327 audit(1788480520.106:167): proctitle=2F7362696E2F617564697463746C002D52002F6574632F61756469742F61756469742E72756C6573 Sep 4 00:08:40.119000 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' Sep 4 00:08:40.159440 kernel: audit: type=1130 audit(1788480520.119:168): 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' Sep 4 00:08:40.119000 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' Sep 4 00:08:40.171357 kernel: audit: type=1131 audit(1788480520.119:169): 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' Sep 4 00:08:40.123000 audit[2953]: AUDIT1106 pid=2953 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' Sep 4 00:08:40.171481 kernel: audit: type=1106 audit(1788480520.123:170): pid=2953 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' Sep 4 00:08:40.123000 audit[2953]: AUDIT1104 pid=2953 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' Sep 4 00:08:40.195120 kernel: audit: type=1104 audit(1788480520.123:171): pid=2953 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' Sep 4 00:08:40.265987 sshd[2952]: Connection closed by 20.61.25.254 port 38138 Sep 4 00:08:40.266401 sshd-session[2948]: pam_unix(sshd:session): session closed for user core Sep 4 00:08:40.265000 audit[2948]: AUDIT1106 pid=2948 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.61.25.254 addr=20.61.25.254 terminal=ssh res=success' Sep 4 00:08:40.285940 systemd[1]: sshd@5-4-10.0.0.20:22-20.61.25.254:38138.service: Deactivated successfully. Sep 4 00:08:40.266000 audit[2948]: AUDIT1104 pid=2948 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.61.25.254 addr=20.61.25.254 terminal=ssh res=success' Sep 4 00:08:40.288400 systemd[1]: session-9.scope: Deactivated successfully. Sep 4 00:08:40.299728 kernel: audit: type=1106 audit(1788480520.265:172): pid=2948 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.61.25.254 addr=20.61.25.254 terminal=ssh res=success' Sep 4 00:08:40.299490 systemd-logind[2384]: Session 9 logged out. Waiting for processes to exit. Sep 4 00:08:40.299841 kernel: audit: type=1104 audit(1788480520.266:173): pid=2948 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.61.25.254 addr=20.61.25.254 terminal=ssh res=success' Sep 4 00:08:40.284000 audit[1]: SERVICE_STOP pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=sshd@5-4-10.0.0.20:22-20.61.25.254:38138 comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Sep 4 00:08:40.312392 kernel: audit: type=1131 audit(1788480520.284:174): pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=sshd@5-4-10.0.0.20:22-20.61.25.254:38138 comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Sep 4 00:08:40.313731 systemd-logind[2384]: Removed session 9. Sep 4 00:08:40.417804 systemd[1]: Started sshd@6-5-10.0.0.20:22-20.61.25.254:38152.service - OpenSSH per-connection server daemon (20.61.25.254:38152). Sep 4 00:08:40.416000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=sshd@6-5-10.0.0.20:22-20.61.25.254:38152 comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Sep 4 00:08:41.154000 audit[2987]: AUDIT1101 pid=2987 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.61.25.254 addr=20.61.25.254 terminal=ssh res=success' Sep 4 00:08:41.155448 sshd[2987]: Accepted publickey for core from 20.61.25.254 port 38152 ssh2: RSA SHA256:tbjv1+r4j9eDOBuGN+IdTOTnP31nluCgkOTwCxL9qlM Sep 4 00:08:41.155000 audit[2987]: AUDIT1103 pid=2987 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.61.25.254 addr=20.61.25.254 terminal=ssh res=success' Sep 4 00:08:41.155000 audit[2987]: SYSCALL arch=c00000b7 syscall=64 success=yes exit=3 a0=8 a1=ffffedd86cb0 a2=3 a3=0 items=0 ppid=1 pid=2987 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) Sep 4 00:08:41.155000 audit: PROCTITLE proctitle=737368642D73657373696F6E3A20636F7265205B707269765D Sep 4 00:08:41.156903 sshd-session[2987]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Sep 4 00:08:41.160836 systemd-logind[2384]: New session '10' of user 'core' with class 'user' and type 'tty'. Sep 4 00:08:41.169388 systemd[1]: Started session-10.scope - Session 10 of User core. Sep 4 00:08:41.171000 audit[2987]: AUDIT1105 pid=2987 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.61.25.254 addr=20.61.25.254 terminal=ssh res=success' Sep 4 00:08:41.172000 audit[2991]: AUDIT1103 pid=2991 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.61.25.254 addr=20.61.25.254 terminal=ssh res=success' Sep 4 00:08:41.456054 sudo[2994]: core : PWD=/home/core ; USER=root ; COMMAND=/usr/sbin/tee /etc/flatcar/update.conf Sep 4 00:08:41.454000 audit[2994]: AUDIT1101 pid=2994 uid=500 auid=500 ses=10 subj=system_u:system_r:kernel_t:s0 msg='op=PAM:accounting grantors=pam_unix,pam_faillock acct="core" exe="/usr/bin/sudo" hostname=? addr=? terminal=? res=success' Sep 4 00:08:41.454000 audit[2994]: AUDIT1110 pid=2994 uid=500 auid=500 ses=10 subj=system_u:system_r:kernel_t:s0 msg='op=PAM:setcred grantors=pam_env,pam_faillock acct="root" exe="/usr/bin/sudo" hostname=? addr=? terminal=? res=success' Sep 4 00:08:41.455000 audit[2994]: AUDIT1105 pid=2994 uid=500 auid=500 ses=10 subj=system_u:system_r:kernel_t:s0 msg='op=PAM:session_open grantors=pam_limits,pam_env,pam_umask,pam_unix acct="root" exe="/usr/bin/sudo" hostname=? addr=? terminal=? res=success' Sep 4 00:08:41.456332 sudo[2994]: pam_unix(sudo:session): session opened for user root(uid=0) by core(uid=500) Sep 4 00:08:41.640000 audit[2994]: AUDIT1106 pid=2994 uid=500 auid=500 ses=10 subj=system_u:system_r:kernel_t:s0 msg='op=PAM:session_close grantors=pam_limits,pam_env,pam_umask,pam_unix acct="root" exe="/usr/bin/sudo" hostname=? addr=? terminal=? res=success' Sep 4 00:08:41.640000 audit[2994]: AUDIT1104 pid=2994 uid=500 auid=500 ses=10 subj=system_u:system_r:kernel_t:s0 msg='op=PAM:setcred grantors=pam_env,pam_faillock acct="root" exe="/usr/bin/sudo" hostname=? addr=? terminal=? res=success' Sep 4 00:08:41.641730 sudo[2994]: pam_unix(sudo:session): session closed for user root Sep 4 00:08:41.645137 systemd[1]: Starting motdgen.service - Generate /run/flatcar/motd... Sep 4 00:08:41.659784 motdgen[3002]: /oem/oem-release: line 2: Azure: command not found Sep 4 00:08:41.664222 systemd[1]: motdgen.service: Deactivated successfully. Sep 4 00:08:41.664545 systemd[1]: Finished motdgen.service - Generate /run/flatcar/motd. Sep 4 00:08:41.663000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=motdgen comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Sep 4 00:08:41.663000 audit[1]: SERVICE_STOP pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=motdgen comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Sep 4 00:08:41.782340 sshd[2991]: Connection closed by 20.61.25.254 port 38152 Sep 4 00:08:41.782888 sshd-session[2987]: pam_unix(sshd:session): session closed for user core Sep 4 00:08:41.782000 audit[2987]: AUDIT1106 pid=2987 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.61.25.254 addr=20.61.25.254 terminal=ssh res=success' Sep 4 00:08:41.782000 audit[2987]: AUDIT1104 pid=2987 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.61.25.254 addr=20.61.25.254 terminal=ssh res=success' Sep 4 00:08:41.786215 systemd[1]: sshd@6-5-10.0.0.20:22-20.61.25.254:38152.service: Deactivated successfully. Sep 4 00:08:41.785000 audit[1]: SERVICE_STOP pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=sshd@6-5-10.0.0.20:22-20.61.25.254:38152 comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Sep 4 00:08:41.788006 systemd[1]: session-10.scope: Deactivated successfully. Sep 4 00:08:41.788835 systemd-logind[2384]: Session 10 logged out. Waiting for processes to exit. Sep 4 00:08:41.790175 systemd-logind[2384]: Removed session 10.