Sep 1 22:02:10.448700 kernel: Booting Linux on physical CPU 0x0000000000 [0x410fd490] Sep 1 22:02:10.448731 kernel: Linux version 6.18.45-flatcar (build@pony-truck.infra.kinvolk.io) (aarch64-cros-linux-gnu-gcc (Gentoo Hardened 15.3.0 p8) 15.3.0, GNU ld (Gentoo 2.46.0 p1) 2.46.0) #1 SMP PREEMPT Tue Sep 1 20:30:55 -00 2026 Sep 1 22:02:10.448739 kernel: KASLR enabled Sep 1 22:02:10.448744 kernel: earlycon: pl11 at MMIO 0x00000000effec000 (options '') Sep 1 22:02:10.448748 kernel: printk: legacy bootconsole [pl11] enabled Sep 1 22:02:10.448752 kernel: efi: EFI v2.7 by EDK II Sep 1 22:02:10.448758 kernel: efi: ACPI 2.0=0x3f979018 SMBIOS=0x3f8a0000 SMBIOS 3.0=0x3f880000 MEMATTR=0x3e881018 RNG=0x3f979998 MEMRESERVE=0x3db7b718 Sep 1 22:02:10.448763 kernel: random: crng init done Sep 1 22:02:10.448768 kernel: secureboot: Secure boot disabled Sep 1 22:02:10.448773 kernel: ACPI: Early table checksum verification disabled Sep 1 22:02:10.448778 kernel: ACPI: RSDP 0x000000003F979018 000024 (v02 VRTUAL) Sep 1 22:02:10.448783 kernel: ACPI: XSDT 0x000000003F979F18 00006C (v01 VRTUAL MICROSFT 00000001 MSFT 00000001) Sep 1 22:02:10.448789 kernel: ACPI: FACP 0x000000003F979C18 000114 (v06 VRTUAL MICROSFT 00000001 MSFT 00000001) Sep 1 22:02:10.448794 kernel: ACPI: DSDT 0x000000003F95A018 01E046 (v02 MSFTVM DSDT01 00000001 INTL 20230628) Sep 1 22:02:10.448800 kernel: ACPI: DBG2 0x000000003F979B18 000072 (v00 VRTUAL MICROSFT 00000001 MSFT 00000001) Sep 1 22:02:10.448805 kernel: ACPI: GTDT 0x000000003F979D98 000060 (v02 VRTUAL MICROSFT 00000001 MSFT 00000001) Sep 1 22:02:10.448810 kernel: ACPI: OEM0 0x000000003F979098 000064 (v01 VRTUAL MICROSFT 00000001 MSFT 00000001) Sep 1 22:02:10.448816 kernel: ACPI: SPCR 0x000000003F979A98 000050 (v02 VRTUAL MICROSFT 00000001 MSFT 00000001) Sep 1 22:02:10.448821 kernel: ACPI: APIC 0x000000003F979818 0000FC (v04 VRTUAL MICROSFT 00000001 MSFT 00000001) Sep 1 22:02:10.448825 kernel: ACPI: SRAT 0x000000003F979198 000234 (v03 VRTUAL MICROSFT 00000001 MSFT 00000001) Sep 1 22:02:10.448831 kernel: ACPI: PPTT 0x000000003F979418 00012C (v01 VRTUAL MICROSFT 00000000 MSFT 00000000) Sep 1 22:02:10.448837 kernel: ACPI: BGRT 0x000000003F979E98 000038 (v01 VRTUAL MICROSFT 00000001 MSFT 00000001) Sep 1 22:02:10.448842 kernel: ACPI: SPCR: console: pl011,mmio32,0xeffec000,115200 Sep 1 22:02:10.448848 kernel: ACPI: SRAT: Node 0 PXM 0 [mem 0x00000000-0x3fffffff] hotplug Sep 1 22:02:10.448852 kernel: ACPI: SRAT: Node 0 PXM 0 [mem 0x100000000-0x1bfffffff] hotplug Sep 1 22:02:10.448856 kernel: ACPI: SRAT: Node 0 PXM 0 [mem 0x1c0000000-0xfbfffffff] hotplug Sep 1 22:02:10.448861 kernel: ACPI: SRAT: Node 0 PXM 0 [mem 0x1000000000-0xffffffffff] hotplug Sep 1 22:02:10.448865 kernel: ACPI: SRAT: Node 0 PXM 0 [mem 0x10000000000-0x1ffffffffff] hotplug Sep 1 22:02:10.448870 kernel: ACPI: SRAT: Node 0 PXM 0 [mem 0x20000000000-0x3ffffffffff] hotplug Sep 1 22:02:10.448875 kernel: ACPI: SRAT: Node 0 PXM 0 [mem 0x40000000000-0x7ffffffffff] hotplug Sep 1 22:02:10.448879 kernel: ACPI: SRAT: Node 0 PXM 0 [mem 0x80000000000-0xfffffffffff] hotplug Sep 1 22:02:10.448884 kernel: ACPI: SRAT: Node 0 PXM 0 [mem 0x100000000000-0x1fffffffffff] hotplug Sep 1 22:02:10.448888 kernel: ACPI: SRAT: Node 0 PXM 0 [mem 0x200000000000-0x3fffffffffff] hotplug Sep 1 22:02:10.448894 kernel: ACPI: SRAT: Node 0 PXM 0 [mem 0x400000000000-0x7fffffffffff] hotplug Sep 1 22:02:10.448898 kernel: ACPI: SRAT: Node 0 PXM 0 [mem 0x800000000000-0xffffffffffff] hotplug Sep 1 22:02:10.448904 kernel: NUMA: Node 0 [mem 0x00000000-0x3fffffff] + [mem 0x100000000-0x1bfffffff] -> [mem 0x00000000-0x1bfffffff] Sep 1 22:02:10.448908 kernel: NODE_DATA(0) allocated [mem 0x1bf7ffa00-0x1bf806fff] Sep 1 22:02:10.448913 kernel: Zone ranges: Sep 1 22:02:10.448917 kernel: DMA [mem 0x0000000000000000-0x00000000ffffffff] Sep 1 22:02:10.448922 kernel: DMA32 empty Sep 1 22:02:10.448929 kernel: Normal [mem 0x0000000100000000-0x00000001bfffffff] Sep 1 22:02:10.448933 kernel: Device empty Sep 1 22:02:10.448938 kernel: Movable zone start for each node Sep 1 22:02:10.448943 kernel: Early memory node ranges Sep 1 22:02:10.448947 kernel: node 0: [mem 0x0000000000000000-0x00000000007fffff] Sep 1 22:02:10.448953 kernel: node 0: [mem 0x0000000000824000-0x000000003f38ffff] Sep 1 22:02:10.448958 kernel: node 0: [mem 0x000000003f390000-0x000000003f943fff] Sep 1 22:02:10.448963 kernel: node 0: [mem 0x000000003f944000-0x000000003f9effff] Sep 1 22:02:10.448967 kernel: node 0: [mem 0x000000003f9f0000-0x000000003fdeffff] Sep 1 22:02:10.448971 kernel: node 0: [mem 0x000000003fdf0000-0x000000003fffffff] Sep 1 22:02:10.448976 kernel: node 0: [mem 0x0000000100000000-0x00000001bfffffff] Sep 1 22:02:10.448980 kernel: Initmem setup node 0 [mem 0x0000000000000000-0x00000001bfffffff] Sep 1 22:02:10.448985 kernel: On node 0, zone DMA: 36 pages in unavailable ranges Sep 1 22:02:10.448989 kernel: cma: Reserved 16 MiB at 0x000000003ca00000 Sep 1 22:02:10.448993 kernel: psci: probing for conduit method from ACPI. Sep 1 22:02:10.448998 kernel: psci: PSCIv1.3 detected in firmware. Sep 1 22:02:10.449003 kernel: psci: Using standard PSCI v0.2 function IDs Sep 1 22:02:10.449007 kernel: psci: MIGRATE_INFO_TYPE not supported. Sep 1 22:02:10.449012 kernel: psci: SMC Calling Convention v1.4 Sep 1 22:02:10.449017 kernel: ACPI: NUMA: SRAT: PXM 0 -> MPIDR 0x0 -> Node 0 Sep 1 22:02:10.449023 kernel: ACPI: NUMA: SRAT: PXM 0 -> MPIDR 0x1 -> Node 0 Sep 1 22:02:10.449028 kernel: percpu: Embedded 34 pages/cpu s98584 r8192 d32488 u139264 Sep 1 22:02:10.449032 kernel: pcpu-alloc: s98584 r8192 d32488 u139264 alloc=34*4096 Sep 1 22:02:10.449037 kernel: pcpu-alloc: [0] 0 [0] 1 Sep 1 22:02:10.449042 kernel: Detected PIPT I-cache on CPU0 Sep 1 22:02:10.449047 kernel: CPU features: detected: Address authentication (architected QARMA5 algorithm) Sep 1 22:02:10.449051 kernel: CPU features: detected: GICv3 CPU interface Sep 1 22:02:10.449056 kernel: CPU features: detected: Spectre-v4 Sep 1 22:02:10.449062 kernel: CPU features: detected: Spectre-BHB Sep 1 22:02:10.449068 kernel: CPU features: kernel page table isolation forced ON by KASLR Sep 1 22:02:10.449072 kernel: CPU features: detected: Kernel page table isolation (KPTI) Sep 1 22:02:10.449076 kernel: CPU features: detected: ARM erratum 2067961 or 2054223 Sep 1 22:02:10.449082 kernel: CPU features: detected: Broken broadcast TLBI completion Sep 1 22:02:10.449087 kernel: CPU features: detected: SSBS not fully self-synchronizing Sep 1 22:02:10.449092 kernel: alternatives: applying boot alternatives Sep 1 22:02:10.449098 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=7a15d8fdbc798b70002930f4d7839927d879733556b63d6ef06f19ea3fed0168 Sep 1 22:02:10.449103 kernel: printk: log buffer data + meta data: 262144 + 917504 = 1179648 bytes Sep 1 22:02:10.449110 kernel: Dentry cache hash table entries: 524288 (order: 10, 4194304 bytes, linear) Sep 1 22:02:10.449114 kernel: Inode-cache hash table entries: 262144 (order: 9, 2097152 bytes, linear) Sep 1 22:02:10.449120 kernel: software IO TLB: area num 2. Sep 1 22:02:10.449126 kernel: software IO TLB: mapped [mem 0x0000000034ce0000-0x0000000038ce0000] (64MB) Sep 1 22:02:10.449131 kernel: Fallback order for Node 0: 0 Sep 1 22:02:10.449136 kernel: Built 1 zonelists, mobility grouping on. Total pages: 1048540 Sep 1 22:02:10.449140 kernel: Policy zone: Normal Sep 1 22:02:10.449144 kernel: mem auto-init: stack:off, heap alloc:off, heap free:off Sep 1 22:02:10.449149 kernel: SLUB: HWalign=64, Order=0-3, MinObjects=0, CPUs=2, Nodes=1 Sep 1 22:02:10.449154 kernel: rcu: Preemptible hierarchical RCU implementation. Sep 1 22:02:10.449161 kernel: rcu: RCU event tracing is enabled. Sep 1 22:02:10.449166 kernel: rcu: RCU restricting CPUs from NR_CPUS=512 to nr_cpu_ids=2. Sep 1 22:02:10.449171 kernel: Trampoline variant of Tasks RCU enabled. Sep 1 22:02:10.449175 kernel: Tracing variant of Tasks RCU enabled. Sep 1 22:02:10.449180 kernel: rcu: RCU calculated value of scheduler-enlistment delay is 100 jiffies. Sep 1 22:02:10.449184 kernel: rcu: Adjusting geometry for rcu_fanout_leaf=16, nr_cpu_ids=2 Sep 1 22:02:10.449190 kernel: RCU Tasks: Setting shift to 1 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=2. Sep 1 22:02:10.449195 kernel: RCU Tasks Trace: Setting shift to 1 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=2. Sep 1 22:02:10.449200 kernel: NR_IRQS: 64, nr_irqs: 64, preallocated irqs: 0 Sep 1 22:02:10.449206 kernel: GICv3: 960 SPIs implemented Sep 1 22:02:10.449210 kernel: GICv3: 0 Extended SPIs implemented Sep 1 22:02:10.449228 kernel: Root IRQ handler: gic_handle_irq Sep 1 22:02:10.449232 kernel: GICv3: GICv3 features: 16 PPIs, RSS Sep 1 22:02:10.449237 kernel: GICv3: GICD_CTLR.DS=0, SCR_EL3.FIQ=0 Sep 1 22:02:10.449242 kernel: GICv3: CPU0: found redistributor 0 region 0:0x00000000effee000 Sep 1 22:02:10.449246 kernel: ITS: No ITS available, not enabling LPIs Sep 1 22:02:10.449251 kernel: rcu: srcu_init: Setting srcu_struct sizes based on contention. Sep 1 22:02:10.449255 kernel: clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1911260446275000 ns Sep 1 22:02:10.449260 kernel: arch_timer: cp15 timer running at 1000.00MHz (virt). Sep 1 22:02:10.449264 kernel: clocksource: arch_sys_counter: mask: 0x1fffffffffffffff max_cycles: 0x1cd42e4dffb, max_idle_ns: 881590591483 ns Sep 1 22:02:10.449270 kernel: sched_clock: 61 bits at 1000MHz, resolution 1ns, wraps every 4398046511103ns Sep 1 22:02:10.449275 kernel: Console: colour dummy device 80x25 Sep 1 22:02:10.449281 kernel: printk: legacy console [tty1] enabled Sep 1 22:02:10.449287 kernel: ACPI: Core revision 20250807 Sep 1 22:02:10.449292 kernel: Calibrating delay loop (skipped), value calculated using timer frequency.. 2000.00 BogoMIPS (lpj=1000000) Sep 1 22:02:10.449296 kernel: pid_max: default: 32768 minimum: 301 Sep 1 22:02:10.449302 kernel: LSM: initializing lsm=lockdown,capability,landlock,selinux,ima Sep 1 22:02:10.449307 kernel: landlock: Up and running. Sep 1 22:02:10.449312 kernel: SELinux: Initializing. Sep 1 22:02:10.449316 kernel: Mount-cache hash table entries: 8192 (order: 4, 65536 bytes, linear) Sep 1 22:02:10.449323 kernel: Mountpoint-cache hash table entries: 8192 (order: 4, 65536 bytes, linear) Sep 1 22:02:10.449332 kernel: Hyper-V: privilege flags low 0x2e7f, high 0x3b8030, hints 0xa0000e, misc 0x31e1 Sep 1 22:02:10.449339 kernel: Hyper-V: Host Build 10.0.26102.3641-3-0 Sep 1 22:02:10.449344 kernel: Hyper-V: enabling crash_kexec_post_notifiers Sep 1 22:02:10.449349 kernel: rcu: Hierarchical SRCU implementation. Sep 1 22:02:10.449354 kernel: rcu: Max phase no-delay instances is 400. Sep 1 22:02:10.449360 kernel: Timer migration: 1 hierarchy levels; 8 children per group; 1 crossnode level Sep 1 22:02:10.449365 kernel: Remapping and enabling EFI services. Sep 1 22:02:10.449372 kernel: smp: Bringing up secondary CPUs ... Sep 1 22:02:10.449377 kernel: Detected PIPT I-cache on CPU1 Sep 1 22:02:10.449381 kernel: GICv3: CPU1: found redistributor 1 region 1:0x00000000f000e000 Sep 1 22:02:10.449386 kernel: CPU1: Booted secondary processor 0x0000000001 [0x410fd490] Sep 1 22:02:10.449391 kernel: smp: Brought up 1 node, 2 CPUs Sep 1 22:02:10.449397 kernel: SMP: Total of 2 processors activated. Sep 1 22:02:10.449402 kernel: CPU: All CPU(s) started at EL1 Sep 1 22:02:10.449406 kernel: CPU features: detected: 32-bit EL0 Support Sep 1 22:02:10.449412 kernel: CPU features: detected: Instruction cache invalidation not required for I/D coherence Sep 1 22:02:10.449416 kernel: CPU features: detected: Data cache clean to the PoU not required for I/D coherence Sep 1 22:02:10.449421 kernel: CPU features: detected: Common not Private translations Sep 1 22:02:10.449426 kernel: CPU features: detected: CRC32 instructions Sep 1 22:02:10.449432 kernel: CPU features: detected: Generic authentication (architected QARMA5 algorithm) Sep 1 22:02:10.449437 kernel: CPU features: detected: RCpc load-acquire (LDAPR) Sep 1 22:02:10.449442 kernel: CPU features: detected: LSE atomic instructions Sep 1 22:02:10.449446 kernel: CPU features: detected: Privileged Access Never Sep 1 22:02:10.449451 kernel: CPU features: detected: PMUv3 Sep 1 22:02:10.449456 kernel: CPU features: detected: Speculation barrier (SB) Sep 1 22:02:10.449462 kernel: CPU features: detected: TLB range maintenance instructions Sep 1 22:02:10.449470 kernel: CPU features: detected: Speculative Store Bypassing Safe (SSBS) Sep 1 22:02:10.449475 kernel: CPU features: detected: Scalable Vector Extension Sep 1 22:02:10.449480 kernel: alternatives: applying system-wide alternatives Sep 1 22:02:10.449485 kernel: CPU features: detected: Hardware dirty bit management on CPU0-1 Sep 1 22:02:10.449491 kernel: SVE: maximum available vector length 16 bytes per vector Sep 1 22:02:10.449496 kernel: SVE: default vector length 16 bytes per vector Sep 1 22:02:10.449501 kernel: Memory: 3978000K/4194160K available (11968K kernel code, 2486K rwdata, 9588K rodata, 12928K init, 981K bss, 194844K reserved, 16384K cma-reserved) Sep 1 22:02:10.449507 kernel: devtmpfs: initialized Sep 1 22:02:10.449513 kernel: posixtimers hash table entries: 1024 (order: 2, 16384 bytes, linear) Sep 1 22:02:10.449518 kernel: futex hash table entries: 512 (32768 bytes on 1 NUMA nodes, total 32 KiB, linear). Sep 1 22:02:10.449522 kernel: 2G module region forced by RANDOMIZE_MODULE_REGION_FULL Sep 1 22:02:10.449527 kernel: 0 pages in range for non-PLT usage Sep 1 22:02:10.449532 kernel: 514736 pages in range for PLT usage Sep 1 22:02:10.449537 kernel: pinctrl core: initialized pinctrl subsystem Sep 1 22:02:10.449543 kernel: SMBIOS 3.1.0 present. Sep 1 22:02:10.449549 kernel: DMI: Microsoft Corporation Virtual Machine/Virtual Machine, BIOS Hyper-V UEFI Release v4.1 04/22/2026 Sep 1 22:02:10.449554 kernel: DMI: Memory slots populated: 2/2 Sep 1 22:02:10.449558 kernel: NET: Registered PF_NETLINK/PF_ROUTE protocol family Sep 1 22:02:10.449563 kernel: DMA: preallocated 512 KiB GFP_KERNEL pool for atomic allocations Sep 1 22:02:10.449568 kernel: DMA: preallocated 512 KiB GFP_KERNEL|GFP_DMA pool for atomic allocations Sep 1 22:02:10.449573 kernel: DMA: preallocated 512 KiB GFP_KERNEL|GFP_DMA32 pool for atomic allocations Sep 1 22:02:10.449578 kernel: audit: initializing netlink subsys (disabled) Sep 1 22:02:10.449584 kernel: audit: type=2000 audit(0.061:1): state=initialized audit_enabled=0 res=1 Sep 1 22:02:10.449588 kernel: thermal_sys: Registered thermal governor 'step_wise' Sep 1 22:02:10.449594 kernel: cpuidle: using governor menu Sep 1 22:02:10.449599 kernel: hw-breakpoint: found 6 breakpoint and 4 watchpoint registers. Sep 1 22:02:10.449604 kernel: ASID allocator initialised with 32768 entries Sep 1 22:02:10.449609 kernel: acpiphp: ACPI Hot Plug PCI Controller Driver version: 0.5 Sep 1 22:02:10.449614 kernel: Serial: AMBA PL011 UART driver Sep 1 22:02:10.449619 kernel: HugeTLB: registered 1.00 GiB page size, pre-allocated 0 pages Sep 1 22:02:10.449624 kernel: HugeTLB: 0 KiB vmemmap can be freed for a 1.00 GiB page Sep 1 22:02:10.449629 kernel: HugeTLB: registered 32.0 MiB page size, pre-allocated 0 pages Sep 1 22:02:10.449634 kernel: HugeTLB: 0 KiB vmemmap can be freed for a 32.0 MiB page Sep 1 22:02:10.449639 kernel: HugeTLB: registered 2.00 MiB page size, pre-allocated 0 pages Sep 1 22:02:10.449644 kernel: HugeTLB: 0 KiB vmemmap can be freed for a 2.00 MiB page Sep 1 22:02:10.449648 kernel: HugeTLB: registered 64.0 KiB page size, pre-allocated 0 pages Sep 1 22:02:10.449654 kernel: HugeTLB: 0 KiB vmemmap can be freed for a 64.0 KiB page Sep 1 22:02:10.449659 kernel: ACPI: Added _OSI(Module Device) Sep 1 22:02:10.449664 kernel: ACPI: Added _OSI(Processor Device) Sep 1 22:02:10.449669 kernel: ACPI: Added _OSI(Processor Aggregator Device) Sep 1 22:02:10.449673 kernel: ACPI: 1 ACPI AML tables successfully acquired and loaded Sep 1 22:02:10.449678 kernel: ACPI: Interpreter enabled Sep 1 22:02:10.449683 kernel: ACPI: Using GIC for interrupt routing Sep 1 22:02:10.449689 kernel: ARMH0011:00: ttyAMA0 at MMIO 0xeffec000 (irq = 12, base_baud = 0) is a SBSA Sep 1 22:02:10.449694 kernel: printk: console [ttyAMA0] enabled Sep 1 22:02:10.449698 kernel: printk: legacy bootconsole [pl11] disabled Sep 1 22:02:10.449703 kernel: ARMH0011:01: ttyAMA1 at MMIO 0xeffeb000 (irq = 13, base_baud = 0) is a SBSA Sep 1 22:02:10.449708 kernel: ACPI: CPU0 has been hot-added Sep 1 22:02:10.449713 kernel: ACPI: CPU1 has been hot-added Sep 1 22:02:10.449718 kernel: iommu: Default domain type: Translated Sep 1 22:02:10.449723 kernel: iommu: DMA domain TLB invalidation policy: strict mode Sep 1 22:02:10.449728 kernel: efivars: Registered efivars operations Sep 1 22:02:10.449733 kernel: hv_vmbus: hv_mmio=[mem 0x40000000-0xfed3ffff],[mem 0xfc0000000-0xfffffffff] fb=[mem 0x40000000-0x47ffffff] Sep 1 22:02:10.449738 kernel: hv_vmbus: Vmbus version:5.3 Sep 1 22:02:10.449743 kernel: vgaarb: loaded Sep 1 22:02:10.449749 kernel: clocksource: Switched to clocksource arch_sys_counter Sep 1 22:02:10.449754 kernel: VFS: Disk quotas dquot_6.6.0 Sep 1 22:02:10.449759 kernel: VFS: Dquot-cache hash table entries: 512 (order 0, 4096 bytes) Sep 1 22:02:10.449764 kernel: pnp: PnP ACPI init Sep 1 22:02:10.449769 kernel: pnp: PnP ACPI: found 0 devices Sep 1 22:02:10.449774 kernel: NET: Registered PF_INET protocol family Sep 1 22:02:10.449779 kernel: IP idents hash table entries: 65536 (order: 7, 524288 bytes, linear) Sep 1 22:02:10.449784 kernel: tcp_listen_portaddr_hash hash table entries: 2048 (order: 3, 32768 bytes, linear) Sep 1 22:02:10.449789 kernel: Table-perturb hash table entries: 65536 (order: 6, 262144 bytes, linear) Sep 1 22:02:10.449793 kernel: TCP established hash table entries: 32768 (order: 6, 262144 bytes, linear) Sep 1 22:02:10.449799 kernel: TCP bind hash table entries: 32768 (order: 8, 1048576 bytes, linear) Sep 1 22:02:10.449804 kernel: TCP: Hash tables configured (established 32768 bind 32768) Sep 1 22:02:10.449809 kernel: UDP hash table entries: 2048 (order: 5, 131072 bytes, linear) Sep 1 22:02:10.449814 kernel: UDP-Lite hash table entries: 2048 (order: 5, 131072 bytes, linear) Sep 1 22:02:10.449819 kernel: NET: Registered PF_UNIX/PF_LOCAL protocol family Sep 1 22:02:10.449823 kernel: PCI: CLS 0 bytes, default 64 Sep 1 22:02:10.449828 kernel: kvm [1]: HYP mode not available Sep 1 22:02:10.449834 kernel: Initialise system trusted keyrings Sep 1 22:02:10.449839 kernel: workingset: timestamp_bits=39 max_order=20 bucket_order=0 Sep 1 22:02:10.449844 kernel: Key type asymmetric registered Sep 1 22:02:10.449848 kernel: Asymmetric key parser 'x509' registered Sep 1 22:02:10.449853 kernel: Block layer SCSI generic (bsg) driver version 0.4 loaded (major 248) Sep 1 22:02:10.449858 kernel: io scheduler mq-deadline registered Sep 1 22:02:10.449863 kernel: io scheduler kyber registered Sep 1 22:02:10.449869 kernel: io scheduler bfq registered Sep 1 22:02:10.449873 kernel: Serial: 8250/16550 driver, 4 ports, IRQ sharing enabled Sep 1 22:02:10.449878 kernel: thunder_xcv, ver 1.0 Sep 1 22:02:10.449883 kernel: thunder_bgx, ver 1.0 Sep 1 22:02:10.449888 kernel: nicpf, ver 1.0 Sep 1 22:02:10.449892 kernel: nicvf, ver 1.0 Sep 1 22:02:10.449897 kernel: hv_vmbus: registering driver hyperv_keyboard Sep 1 22:02:10.450074 kernel: rtc-efi rtc-efi.0: registered as rtc0 Sep 1 22:02:10.450160 kernel: rtc-efi rtc-efi.0: setting system clock to 2026-09-01T22:02:05 UTC (1788300125) Sep 1 22:02:10.450166 kernel: efifb: probing for efifb Sep 1 22:02:10.450172 kernel: efifb: framebuffer at 0x40000000, using 3072k, total 3072k Sep 1 22:02:10.450177 kernel: efifb: mode is 1024x768x32, linelength=4096, pages=1 Sep 1 22:02:10.450181 kernel: efifb: scrolling: redraw Sep 1 22:02:10.450188 kernel: efifb: Truecolor: size=8:8:8:8, shift=24:16:8:0 Sep 1 22:02:10.450193 kernel: Console: switching to colour frame buffer device 128x48 Sep 1 22:02:10.450197 kernel: fb0: EFI VGA frame buffer device Sep 1 22:02:10.450202 kernel: SMCCC: SOC_ID: ARCH_SOC_ID not implemented, skipping .... Sep 1 22:02:10.450207 kernel: hid: raw HID events driver (C) Jiri Kosina Sep 1 22:02:10.450226 kernel: hw perfevents: enabled with armv8_pmuv3_0 PMU driver, 7 (0,8000003f) counters available Sep 1 22:02:10.450233 kernel: NET: Registered PF_INET6 protocol family Sep 1 22:02:10.450240 kernel: watchdog: NMI not fully supported Sep 1 22:02:10.450245 kernel: watchdog: Hard watchdog permanently disabled Sep 1 22:02:10.450250 kernel: input: AT Translated Set 2 keyboard as /devices/LNXSYSTM:00/LNXSYBUS:00/ACPI0004:00/MSFT1000:00/d34b2567-b9b6-42b9-8778-0a4ec0b955bf/serio0/input/input0 Sep 1 22:02:10.450255 kernel: Segment Routing with IPv6 Sep 1 22:02:10.450260 kernel: In-situ OAM (IOAM) with IPv6 Sep 1 22:02:10.450265 kernel: NET: Registered PF_PACKET protocol family Sep 1 22:02:10.450269 kernel: Key type dns_resolver registered Sep 1 22:02:10.450275 kernel: registered taskstats version 1 Sep 1 22:02:10.450280 kernel: Loading compiled-in X.509 certificates Sep 1 22:02:10.450285 kernel: Loaded X.509 cert 'Kinvolk GmbH: Module signing key for 6.18.45-flatcar: 05e4114bf24bf7d3c40688d9254328400ac9e36c' Sep 1 22:02:10.450290 kernel: Demotion targets for Node 0: null Sep 1 22:02:10.450295 kernel: Key type .fscrypt registered Sep 1 22:02:10.450300 kernel: Key type fscrypt-provisioning registered Sep 1 22:02:10.450304 kernel: ima: No TPM chip found, activating TPM-bypass! Sep 1 22:02:10.450309 kernel: ima: Allocated hash algorithm: sha1 Sep 1 22:02:10.450315 kernel: ima: No architecture policies found Sep 1 22:02:10.450320 kernel: alg: No test for fips(ansi_cprng) (fips_ansi_cprng) Sep 1 22:02:10.450325 kernel: clk: Disabling unused clocks Sep 1 22:02:10.450330 kernel: PM: genpd: Disabling unused power domains Sep 1 22:02:10.450335 kernel: Freeing unused kernel memory: 12928K Sep 1 22:02:10.450340 kernel: Run /init as init process Sep 1 22:02:10.450344 kernel: with arguments: Sep 1 22:02:10.450350 kernel: /init Sep 1 22:02:10.450355 kernel: with environment: Sep 1 22:02:10.450360 kernel: HOME=/ Sep 1 22:02:10.450365 kernel: TERM=linux Sep 1 22:02:10.450370 kernel: pps_core: LinuxPPS API ver. 1 registered Sep 1 22:02:10.450375 kernel: pps_core: Software ver. 5.3.6 - Copyright 2005-2007 Rodolfo Giometti Sep 1 22:02:10.450380 kernel: PTP clock support registered Sep 1 22:02:10.450385 kernel: hv_utils: Registering HyperV Utility Driver Sep 1 22:02:10.450390 kernel: hv_vmbus: registering driver hv_utils Sep 1 22:02:10.450395 kernel: hv_utils: Heartbeat IC version 3.0 Sep 1 22:02:10.450400 kernel: hv_utils: Shutdown IC version 3.2 Sep 1 22:02:10.450405 kernel: hv_utils: TimeSync IC version 4.0 Sep 1 22:02:10.450410 kernel: hv_vmbus: registering driver hid_hyperv Sep 1 22:02:10.450415 kernel: input: Microsoft Vmbus HID-compliant Mouse as /devices/0006:045E:0621.0001/input/input1 Sep 1 22:02:10.450531 kernel: hid-hyperv 0006:045E:0621.0001: input: VIRTUAL HID v0.01 Mouse [Microsoft Vmbus HID-compliant Mouse] on Sep 1 22:02:10.450539 kernel: SCSI subsystem initialized Sep 1 22:02:10.450544 kernel: hv_vmbus: registering driver hv_storvsc Sep 1 22:02:10.450659 kernel: scsi host0: storvsc_host_t Sep 1 22:02:10.450757 kernel: scsi host1: storvsc_host_t Sep 1 22:02:10.450869 kernel: scsi 1:0:0:0: Direct-Access Msft Virtual Disk 1.0 PQ: 0 ANSI: 5 Sep 1 22:02:10.450973 kernel: scsi 1:0:0:2: CD-ROM Msft Virtual DVD-ROM 1.0 PQ: 0 ANSI: 5 Sep 1 22:02:10.451070 kernel: sd 1:0:0:0: [sda] 63737856 512-byte logical blocks: (32.6 GB/30.4 GiB) Sep 1 22:02:10.451168 kernel: sd 1:0:0:0: [sda] 4096-byte physical blocks Sep 1 22:02:10.451297 kernel: sd 1:0:0:0: [sda] Write Protect is off Sep 1 22:02:10.451400 kernel: sd 1:0:0:0: [sda] Mode Sense: 0f 00 10 00 Sep 1 22:02:10.451499 kernel: sd 1:0:0:0: [sda] Write cache: disabled, read cache: enabled, supports DPO and FUA Sep 1 22:02:10.451506 kernel: sda: sda1 sda2 sda3 sda4 sda6 sda7 sda9 Sep 1 22:02:10.451601 kernel: sd 1:0:0:0: [sda] Attached SCSI disk Sep 1 22:02:10.451698 kernel: sr 1:0:0:2: [sr0] scsi-1 drive Sep 1 22:02:10.451704 kernel: cdrom: Uniform CD-ROM driver Revision: 3.20 Sep 1 22:02:10.451798 kernel: sr 1:0:0:2: Attached scsi CD-ROM sr0 Sep 1 22:02:10.451806 kernel: device-mapper: core: CONFIG_IMA_DISABLE_HTABLE is disabled. Duplicate IMA measurements will not be recorded in the IMA log. Sep 1 22:02:10.451811 kernel: device-mapper: uevent: version 1.0.3 Sep 1 22:02:10.451816 kernel: device-mapper: ioctl: 4.50.0-ioctl (2025-04-28) initialised: dm-devel@lists.linux.dev Sep 1 22:02:10.451821 kernel: device-mapper: verity: sha256 using "sha256-lib" Sep 1 22:02:10.451826 kernel: raid6: neonx8 gen() 18572 MB/s Sep 1 22:02:10.451831 kernel: raid6: neonx4 gen() 18583 MB/s Sep 1 22:02:10.451836 kernel: raid6: neonx2 gen() 17178 MB/s Sep 1 22:02:10.451842 kernel: raid6: neonx1 gen() 15136 MB/s Sep 1 22:02:10.451847 kernel: raid6: int64x8 gen() 8882 MB/s Sep 1 22:02:10.451852 kernel: raid6: int64x4 gen() 10768 MB/s Sep 1 22:02:10.451857 kernel: raid6: int64x2 gen() 8964 MB/s Sep 1 22:02:10.451862 kernel: raid6: int64x1 gen() 7083 MB/s Sep 1 22:02:10.451867 kernel: raid6: using algorithm neonx4 gen() 18583 MB/s Sep 1 22:02:10.451872 kernel: raid6: .... xor() 15155 MB/s, rmw enabled Sep 1 22:02:10.451877 kernel: raid6: using neon recovery algorithm Sep 1 22:02:10.451882 kernel: xor: measuring software checksum speed Sep 1 22:02:10.451887 kernel: 8regs : 29493 MB/sec Sep 1 22:02:10.451892 kernel: 32regs : 29752 MB/sec Sep 1 22:02:10.451897 kernel: arm64_neon : 37313 MB/sec Sep 1 22:02:10.451902 kernel: xor: using function: arm64_neon (37313 MB/sec) Sep 1 22:02:10.451907 kernel: Btrfs loaded, zoned=no, fsverity=no Sep 1 22:02:10.451912 kernel: BTRFS: device fsid 45e45e04-c28d-47f6-aab2-62722a305da3 devid 1 transid 40 /dev/mapper/usr (254:0) scanned by mount (186) Sep 1 22:02:10.451918 kernel: BTRFS info (device dm-0): first mount of filesystem 45e45e04-c28d-47f6-aab2-62722a305da3 Sep 1 22:02:10.451923 kernel: BTRFS info (device dm-0): using crc32c (crc32c-lib) checksum algorithm Sep 1 22:02:10.451929 kernel: BTRFS info (device dm-0 state E): disabling log replay at mount time Sep 1 22:02:10.451934 kernel: BTRFS info (device dm-0 state E): enabling free space tree Sep 1 22:02:10.451938 kernel: loop: module loaded Sep 1 22:02:10.451943 kernel: loop0: detected capacity change from 0 to 100648 Sep 1 22:02:10.451949 kernel: squashfs: version 4.0 (2009/01/31) Phillip Lougher Sep 1 22:02:10.451956 systemd[1]: Successfully made /usr/ read-only. Sep 1 22:02:10.451963 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 1 22:02:10.451969 systemd[1]: Detected virtualization microsoft. Sep 1 22:02:10.451975 systemd[1]: Detected architecture arm64. Sep 1 22:02:10.451980 systemd[1]: Running in initrd. Sep 1 22:02:10.451985 systemd[1]: Initializing machine ID from random generator. Sep 1 22:02:10.451992 systemd[1]: No hostname configured, using default hostname. Sep 1 22:02:10.451997 systemd[1]: Hostname set to . Sep 1 22:02:10.452002 (gene[220]: '/usr/lib/systemd/system-generators/dracut-crypt-generator' failed with exit status 2. Sep 1 22:02:10.452008 systemd[1]: Queued start job for default target initrd.target. Sep 1 22:02:10.452013 systemd[1]: Started clevis-luks-askpass.path - Forward Password Requests to Clevis Directory Watch. Sep 1 22:02:10.452019 systemd[1]: Started systemd-ask-password-console.path - Dispatch Password Requests to Console Directory Watch. Sep 1 22:02:10.452025 systemd[1]: Expecting device dev-disk-by\x2dlabel-EFI\x2dSYSTEM.device - /dev/disk/by-label/EFI-SYSTEM... Sep 1 22:02:10.452031 systemd[1]: Expecting device dev-disk-by\x2dlabel-OEM.device - /dev/disk/by-label/OEM... Sep 1 22:02:10.452040 systemd[1]: Expecting device dev-disk-by\x2dlabel-ROOT.device - /dev/disk/by-label/ROOT... Sep 1 22:02:10.452046 systemd[1]: Expecting device dev-disk-by\x2dpartlabel-USR\x2dA.device - /dev/disk/by-partlabel/USR-A... Sep 1 22:02:10.452051 systemd[1]: Expecting device dev-mapper-usr.device - /dev/mapper/usr... Sep 1 22:02:10.452057 systemd[1]: Reached target cryptsetup-pre.target - Local Encrypted Volumes (Pre). Sep 1 22:02:10.452063 systemd[1]: Reached target cryptsetup.target - Local Encrypted Volumes. Sep 1 22:02:10.452068 systemd[1]: Reached target initrd-usr-fs.target - Initrd /usr File System. Sep 1 22:02:10.452073 systemd[1]: Reached target paths.target - Path Units. Sep 1 22:02:10.452079 systemd[1]: Reached target slices.target - Slice Units. Sep 1 22:02:10.452084 systemd[1]: Reached target swap.target - Swaps. Sep 1 22:02:10.452089 systemd[1]: Reached target timers.target - Timer Units. Sep 1 22:02:10.452095 systemd[1]: Listening on iscsid.socket - Open-iSCSI iscsid Socket. Sep 1 22:02:10.452101 systemd[1]: Listening on iscsiuio.socket - Open-iSCSI iscsiuio Socket. Sep 1 22:02:10.452106 systemd[1]: Listening on systemd-coredump.socket - Process Core Dump Socket. Sep 1 22:02:10.452116 systemd[1]: Listening on systemd-journald-audit.socket - Journal Audit Socket. Sep 1 22:02:10.452123 systemd[1]: Listening on systemd-journald-dev-log.socket - Journal Socket (/dev/log). Sep 1 22:02:10.452129 systemd[1]: Listening on systemd-journald.socket - Journal Sockets. Sep 1 22:02:10.452134 systemd[1]: Listening on systemd-networkd-resolve-hook.socket - Network Management Resolve Hook Socket. Sep 1 22:02:10.452140 systemd[1]: Listening on systemd-networkd.socket - Network Management Netlink Socket. Sep 1 22:02:10.452146 systemd[1]: Listening on systemd-udevd-control.socket - udev Control Socket. Sep 1 22:02:10.452151 systemd[1]: Listening on systemd-udevd-kernel.socket - udev Kernel Socket. Sep 1 22:02:10.452156 systemd[1]: Reached target sockets.target - Socket Units. Sep 1 22:02:10.452162 systemd[1]: afterburn-network-kargs.service - Afterburn Initrd Setup Network Kernel Arguments skipped, no trigger condition checks were met. Sep 1 22:02:10.452168 systemd[1]: Starting ignition-setup-pre.service - Ignition env setup... Sep 1 22:02:10.452174 systemd[1]: Starting kmod-static-nodes.service - Create List of Static Device Nodes... Sep 1 22:02:10.452180 systemd[1]: Finished network-cleanup.service - Network Cleanup. Sep 1 22:02:10.452185 systemd[1]: systemd-battery-check.service - Early Battery Level Check skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/class/power_supply Sep 1 22:02:10.452191 systemd[1]: Starting systemd-journald.service - Journal Service... Sep 1 22:02:10.452198 systemd[1]: Starting systemd-modules-load.service - Load Kernel Modules... Sep 1 22:02:10.452234 systemd-journald[374]: Collecting audit messages is enabled. Sep 1 22:02:10.452251 systemd-journald[374]: Journal started Sep 1 22:02:10.452265 systemd-journald[374]: Runtime Journal (/run/log/journal/1e216ce3f5044fc384121ad4a5425ffe) is 8M, max 78.3M, 70.3M free. Sep 1 22:02:10.458352 systemd[1]: Starting systemd-vconsole-setup.service - Virtual Console Setup... Sep 1 22:02:10.460175 systemd-modules-load[379]: Using 2 probe threads Sep 1 22:02:10.489712 systemd[1]: Started systemd-journald.service - Journal Service. Sep 1 22:02:10.488000 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 1 22:02:10.491247 systemd[1]: Finished ignition-setup-pre.service - Ignition env setup. Sep 1 22:02:10.506000 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 1 22:02:10.526083 systemd[1]: Finished kmod-static-nodes.service - Create List of Static Device Nodes. Sep 1 22:02:10.531000 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 1 22:02:10.551981 kernel: audit: type=1130 audit(1788300130.488: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 1 22:02:10.536010 systemd[1]: Starting systemd-tmpfiles-setup-dev-early.service - Create Static Device Nodes in /dev gracefully... Sep 1 22:02:10.558828 kernel: audit: type=1130 audit(1788300130.506: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 1 22:02:10.558846 kernel: audit: type=1130 audit(1788300130.531: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 1 22:02:10.568234 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 1 22:02:10.576346 systemd[1]: Starting systemd-tmpfiles-setup.service - Create System Files and Directories... Sep 1 22:02:10.632154 kernel: Bridge firewalling registered Sep 1 22:02:10.631236 systemd-modules-load[379]: Inserted module 'br_netfilter' Sep 1 22:02:10.638416 systemd[1]: Finished systemd-modules-load.service - Load Kernel Modules. Sep 1 22:02:10.645000 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 1 22:02:10.663555 kernel: audit: type=1130 audit(1788300130.645: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 1 22:02:10.643873 systemd-tmpfiles[405]: /usr/lib/tmpfiles.d/systemd.conf:30: Duplicate line for path "/var/lib/systemd", ignoring. Sep 1 22:02:10.643935 systemd-tmpfiles[405]: /usr/lib/tmpfiles.d/var.conf:14: Duplicate line for path "/var/log", ignoring. Sep 1 22:02:10.675000 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 1 22:02:10.695119 kernel: audit: type=1130 audit(1788300130.675:6): pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=systemd-tmpfiles-setup-dev-early comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Sep 1 22:02:10.666827 systemd-vconsole-setup[381]: Configuration of first virtual console was skipped, ignoring remaining ones. Sep 1 22:02:10.698000 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 1 22:02:10.717014 kernel: audit: type=1130 audit(1788300130.698:7): pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=systemd-vconsole-setup comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Sep 1 22:02:10.670973 systemd[1]: Finished systemd-tmpfiles-setup-dev-early.service - Create Static Device Nodes in /dev gracefully. Sep 1 22:02:10.695023 systemd[1]: Finished systemd-vconsole-setup.service - Virtual Console Setup. Sep 1 22:02:10.728000 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 1 22:02:10.745348 kernel: audit: type=1130 audit(1788300130.728:8): pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=systemd-tmpfiles-setup comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Sep 1 22:02:10.723145 systemd[1]: Finished systemd-tmpfiles-setup.service - Create System Files and Directories. Sep 1 22:02:10.752338 systemd[1]: Starting dracut-cmdline-ask.service - dracut ask for additional cmdline parameters... Sep 1 22:02:10.769645 systemd[1]: Starting systemd-sysctl.service - Apply Kernel Variables... Sep 1 22:02:10.796765 systemd[1]: Starting systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev... Sep 1 22:02:10.809347 systemd[1]: systemd-sysctl.service: Deactivated successfully. Sep 1 22:02:10.813459 systemd[1]: Finished systemd-sysctl.service - Apply Kernel Variables. Sep 1 22:02:10.823000 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 1 22:02:10.823000 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 1 22:02:10.837337 kernel: audit: type=1130 audit(1788300130.823:9): pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=systemd-sysctl comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Sep 1 22:02:10.837354 kernel: audit: type=1131 audit(1788300130.823:10): pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=systemd-sysctl comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Sep 1 22:02:10.848065 systemd[1]: Finished dracut-cmdline-ask.service - dracut ask for additional cmdline parameters. Sep 1 22:02:10.852000 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 1 22:02:10.869703 kernel: audit: type=1130 audit(1788300130.852:11): 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 1 22:02:10.869641 systemd[1]: Finished systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev. Sep 1 22:02:10.873000 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 1 22:02:10.880814 systemd[1]: Starting dracut-cmdline.service - dracut cmdline hook... Sep 1 22:02:10.889000 audit: BPF prog-id=5 op=LOAD Sep 1 22:02:10.895345 systemd[1]: Starting systemd-resolved.service - Network Name Resolution... Sep 1 22:02:10.909716 dracut-cmdline[438]: dracut-111 Sep 1 22:02:10.909716 dracut-cmdline[438]: 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=7a15d8fdbc798b70002930f4d7839927d879733556b63d6ef06f19ea3fed0168 Sep 1 22:02:11.025588 systemd-resolved[440]: Positive Trust Anchors: Sep 1 22:02:11.025601 systemd-resolved[440]: . IN DS 20326 8 2 e06d44b80b8f1d39a95c0b0d7c65d08458e880409bbc683457104237c7f8ec8d Sep 1 22:02:11.025603 systemd-resolved[440]: . IN DS 38696 8 2 683d2d0acb8c9b712a1948b27f741219298d0a450d612c483af444a4c0fb2b16 Sep 1 22:02:11.025624 systemd-resolved[440]: 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 1 22:02:11.129339 systemd-resolved[440]: Defaulting to hostname 'linux'. Sep 1 22:02:11.157254 systemd[1]: Started systemd-resolved.service - Network Name Resolution. Sep 1 22:02:11.169041 systemd[1]: Reached target nss-lookup.target - Host and Network Name Lookups. Sep 1 22:02:11.168000 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 1 22:02:11.178875 kernel: Loading iSCSI transport class v2.0-870. Sep 1 22:02:11.222359 kernel: iscsi: registered transport (tcp) Sep 1 22:02:11.263240 kernel: iscsi: registered transport (qla4xxx) Sep 1 22:02:11.263306 kernel: QLogic iSCSI HBA Driver Sep 1 22:02:11.309168 systemd[1]: Starting systemd-network-generator.service - Generate Network Units from Kernel Command Line... Sep 1 22:02:11.332330 systemd[1]: Finished systemd-network-generator.service - Generate Network Units from Kernel Command Line. Sep 1 22:02:11.336000 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 1 22:02:11.339067 systemd[1]: Reached target network-pre.target - Preparation for Network. Sep 1 22:02:11.414657 systemd[1]: Finished dracut-cmdline.service - dracut cmdline hook. Sep 1 22:02:11.417000 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 1 22:02:11.425347 systemd[1]: Starting dracut-pre-udev.service - dracut pre-udev hook... Sep 1 22:02:11.441312 systemd[1]: Starting parse-ip-for-networkd.service - Write systemd-networkd units from cmdline... Sep 1 22:02:11.461836 systemd[1]: Finished dracut-pre-udev.service - dracut pre-udev hook. Sep 1 22:02:11.466000 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 1 22:02:11.470000 audit: BPF prog-id=6 op=LOAD Sep 1 22:02:11.471000 audit: BPF prog-id=7 op=LOAD Sep 1 22:02:11.475328 systemd[1]: Starting systemd-udevd.service - Rule-based Manager for Device Events and Files... Sep 1 22:02:11.564717 systemd-udevd[659]: Using default interface naming scheme 'v260'. Sep 1 22:02:11.570396 systemd[1]: Finished parse-ip-for-networkd.service - Write systemd-networkd units from cmdline. Sep 1 22:02:11.575000 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 1 22:02:11.586527 systemd[1]: Started systemd-udevd.service - Rule-based Manager for Device Events and Files. Sep 1 22:02:11.597000 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 1 22:02:11.600356 systemd[1]: Starting dracut-pre-trigger.service - dracut pre-trigger hook... Sep 1 22:02:11.609000 audit: BPF prog-id=8 op=LOAD Sep 1 22:02:11.612366 systemd[1]: Starting systemd-networkd.service - Network Management... Sep 1 22:02:11.633760 dracut-pre-trigger[803]: rd.md=0: removing MD RAID activation Sep 1 22:02:11.652937 systemd-networkd[805]: Failed to open nftables netlink socket. IPMasquerade= and NFTSet= settings will not be applied. Ignoring: Protocol not supported Sep 1 22:02:11.666750 systemd-networkd[805]: lo: Link UP Sep 1 22:02:11.666763 systemd-networkd[805]: lo: Gained carrier Sep 1 22:02:11.673000 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 1 22:02:11.667209 systemd[1]: Started systemd-networkd.service - Network Management. Sep 1 22:02:11.675768 systemd[1]: Reached target network.target - Network. Sep 1 22:02:11.700324 systemd[1]: Finished dracut-pre-trigger.service - dracut pre-trigger hook. Sep 1 22:02:11.704000 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 1 22:02:11.707452 systemd[1]: Starting systemd-udev-trigger.service - Coldplug All udev Devices... Sep 1 22:02:11.784594 systemd[1]: Finished systemd-udev-trigger.service - Coldplug All udev Devices. Sep 1 22:02:11.795000 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 1 22:02:11.800348 systemd[1]: Starting dracut-initqueue.service - dracut initqueue hook... Sep 1 22:02:11.903799 kernel: hv_storvsc f8b3781a-1e82-4818-a1c3-63d806ec15bb: tag#17 cmd 0x85 status: scsi 0x2 srb 0x6 host 0xc0000001 Sep 1 22:02:11.914249 kernel: hv_vmbus: registering driver hv_netvsc Sep 1 22:02:11.929243 systemd[1]: systemd-vconsole-setup.service: Deactivated successfully. Sep 1 22:02:11.934158 systemd[1]: Stopped systemd-vconsole-setup.service - Virtual Console Setup. Sep 1 22:02:11.939000 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 1 22:02:11.968299 systemd[1]: Stopping systemd-vconsole-setup.service - Virtual Console Setup... Sep 1 22:02:11.977419 systemd[1]: Starting systemd-vconsole-setup.service - Virtual Console Setup... Sep 1 22:02:11.995605 systemd[1]: systemd-vconsole-setup.service: Deactivated successfully. Sep 1 22:02:12.000640 systemd[1]: Stopped systemd-vconsole-setup.service - Virtual Console Setup. Sep 1 22:02:12.005000 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 1 22:02:12.005000 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 1 22:02:12.019619 kernel: hv_netvsc 7ced8dc7-e335-7ced-8dc7-e3357ced8dc7 eth0: VF slot 1 added Sep 1 22:02:12.019450 systemd-networkd[805]: eth0: Found matching .network file, based on potentially unpredictable interface name: /usr/lib/systemd/network/zz-default.network Sep 1 22:02:12.019454 systemd-networkd[805]: eth0: Configuring with /usr/lib/systemd/network/zz-default.network. Sep 1 22:02:12.021809 systemd-networkd[805]: eth0: Link UP Sep 1 22:02:12.022117 systemd-networkd[805]: eth0: Gained carrier Sep 1 22:02:12.022130 systemd-networkd[805]: eth0: Found matching .network file, based on potentially unpredictable interface name: /usr/lib/systemd/network/zz-default.network Sep 1 22:02:12.056940 systemd[1]: Starting systemd-vconsole-setup.service - Virtual Console Setup... Sep 1 22:02:12.094741 systemd-networkd[805]: eth0: DHCPv4 address 10.0.0.4/24, gateway 10.0.0.1 acquired from 168.63.129.16 Sep 1 22:02:12.132363 kernel: hv_vmbus: registering driver hv_pci Sep 1 22:02:12.132490 kernel: hv_pci 70e9bdf9-6bbd-44b0-9ddc-e1aee75bea9e: PCI VMBus probing: Using version 0x10004 Sep 1 22:02:12.132662 kernel: hv_pci 70e9bdf9-6bbd-44b0-9ddc-e1aee75bea9e: PCI host bridge to bus 6bbd:00 Sep 1 22:02:12.132759 kernel: pci_bus 6bbd:00: root bus resource [mem 0xfc0000000-0xfc00fffff window] Sep 1 22:02:12.132870 kernel: pci_bus 6bbd:00: No busn resource found for root bus, will use [bus 00-ff] Sep 1 22:02:12.132964 kernel: pci 6bbd:00:02.0: [15b3:101a] type 00 class 0x020000 PCIe Endpoint Sep 1 22:02:12.133095 kernel: pci 6bbd:00:02.0: BAR 0 [mem 0xfc0000000-0xfc00fffff 64bit pref] Sep 1 22:02:12.133256 kernel: pci 6bbd:00:02.0: enabling Extended Tags Sep 1 22:02:12.133373 kernel: pci 6bbd:00:02.0: 0.000 Gb/s available PCIe bandwidth, limited by Unknown x0 link at 6bbd:00:02.0 (capable of 252.048 Gb/s with 16.0 GT/s PCIe x16 link) Sep 1 22:02:12.133479 kernel: pci_bus 6bbd:00: busn_res: [bus 00-ff] end is updated to 00 Sep 1 22:02:12.133576 kernel: pci 6bbd:00:02.0: BAR 0 [mem 0xfc0000000-0xfc00fffff 64bit pref]: assigned Sep 1 22:02:12.138105 systemd-vconsole-setup[900]: Configuration of first virtual console was skipped, ignoring remaining ones. Sep 1 22:02:12.192917 systemd[1]: Finished systemd-vconsole-setup.service - Virtual Console Setup. Sep 1 22:02:12.199000 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 1 22:02:12.281708 systemd[1]: Found device dev-disk-by\x2dpartlabel-USR\x2dA.device - Virtual_Disk USR-A. Sep 1 22:02:12.294532 systemd[1]: Starting disk-uuid.service - Generate new UUID for disk GPT if necessary... Sep 1 22:02:12.321247 kernel: mlx5_core 6bbd:00:02.0: enabling device (0000 -> 0002) Sep 1 22:02:12.321522 kernel: mlx5_core 6bbd:00:02.0: firmware version: 16.30.5026 Sep 1 22:02:12.355774 systemd[1]: Found device dev-disk-by\x2dlabel-EFI\x2dSYSTEM.device - Virtual_Disk EFI-SYSTEM. Sep 1 22:02:12.381955 systemd[1]: Found device dev-disk-by\x2dlabel-ROOT.device - Virtual_Disk ROOT. Sep 1 22:02:12.429573 systemd[1]: Found device dev-disk-by\x2dlabel-OEM.device - Virtual_Disk OEM. Sep 1 22:02:12.448263 kernel: mlx5_core 6bbd:00:02.0: Flow counters bulk query buffer size increased, bulk_query_len(8) Sep 1 22:02:12.496280 systemd[1]: Mounting oem.mount - /oem... Sep 1 22:02:12.527234 kernel: hv_netvsc 7ced8dc7-e335-7ced-8dc7-e3357ced8dc7 eth0: VF registering: eth1 Sep 1 22:02:12.527471 kernel: mlx5_core 6bbd:00:02.0 eth1: joined to eth0 Sep 1 22:02:12.533001 kernel: mlx5_core 6bbd:00:02.0: MLX5E: StrdRq(1) RqSz(8) StrdSz(2048) RxCqeCmprss(0 basic) Sep 1 22:02:12.553235 kernel: mlx5_core 6bbd:00:02.0 enP27581s1: renamed from eth1 Sep 1 22:02:12.558341 systemd-networkd[805]: eth1: Interface name change detected, renamed to enP27581s1. Sep 1 22:02:12.584009 kernel: BTRFS: device label OEM devid 1 transid 11 /dev/sda6 (8:6) scanned by mount (1012) Sep 1 22:02:12.584064 kernel: BTRFS info (device sda6): first mount of filesystem c5c8e3fb-ffce-48cb-94b6-a2356d50b663 Sep 1 22:02:12.584073 kernel: BTRFS info (device sda6): using crc32c (crc32c-lib) checksum algorithm Sep 1 22:02:12.623264 kernel: BTRFS info (device sda6): turning on async discard Sep 1 22:02:12.623322 kernel: BTRFS info (device sda6): enabling free space tree Sep 1 22:02:12.629053 systemd[1]: Mounted oem.mount - /oem. Sep 1 22:02:12.641510 systemd[1]: Starting ignition-fetch-offline.service - Ignition (fetch-offline)... Sep 1 22:02:12.703440 kernel: mlx5_core 6bbd:00:02.0 enP27581s1: Link up Sep 1 22:02:12.712873 systemd[1]: Finished dracut-initqueue.service - dracut initqueue hook. Sep 1 22:02:12.717000 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 1 22:02:12.718712 systemd[1]: Reached target remote-fs-pre.target - Preparation for Remote File Systems. Sep 1 22:02:12.729131 systemd[1]: Reached target remote-cryptsetup.target - Remote Encrypted Volumes. Sep 1 22:02:12.752711 kernel: hv_netvsc 7ced8dc7-e335-7ced-8dc7-e3357ced8dc7 eth0: Data path switched to VF: enP27581s1 Sep 1 22:02:12.735227 systemd-networkd[805]: enP27581s1: Link UP Sep 1 22:02:12.747157 systemd[1]: Reached target remote-fs.target - Remote File Systems. Sep 1 22:02:12.759712 systemd[1]: Starting dracut-pre-mount.service - dracut pre-mount hook... Sep 1 22:02:12.789822 systemd[1]: Finished dracut-pre-mount.service - dracut pre-mount hook. Sep 1 22:02:12.797000 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 1 22:02:13.028370 systemd-networkd[805]: enP27581s1: Gained carrier Sep 1 22:02:13.404385 systemd-networkd[805]: eth0: Gained IPv6LL Sep 1 22:02:13.508582 disk-uuid[937]: Warning: The kernel is still using the old partition table. Sep 1 22:02:13.508582 disk-uuid[937]: The new table will be used at the next reboot or after you Sep 1 22:02:13.508582 disk-uuid[937]: run partprobe(8) or kpartx(8) Sep 1 22:02:13.508582 disk-uuid[937]: The operation has completed successfully. Sep 1 22:02:13.519411 systemd[1]: disk-uuid.service: Deactivated successfully. Sep 1 22:02:13.531000 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 1 22:02:13.531000 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 1 22:02:13.520394 systemd[1]: Finished disk-uuid.service - Generate new UUID for disk GPT if necessary. Sep 1 22:02:13.539330 systemd[1]: Mounting boot.mount - Boot partition... Sep 1 22:02:13.605643 systemd[1]: Mounted boot.mount - Boot partition. Sep 1 22:02:13.933432 ignition[1083]: Ignition 2.26.0 Sep 1 22:02:13.933443 ignition[1083]: Stage: fetch-offline Sep 1 22:02:13.937156 systemd[1]: Finished ignition-fetch-offline.service - Ignition (fetch-offline). Sep 1 22:02:13.944000 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 1 22:02:13.934504 ignition[1083]: no config dir at "/usr/lib/ignition/base.d" Sep 1 22:02:13.948264 systemd[1]: Starting ignition-fetch.service - Ignition (fetch)... Sep 1 22:02:13.934512 ignition[1083]: no config dir at "/usr/lib/ignition/base.platform.d/azure" Sep 1 22:02:13.934609 ignition[1083]: parsed url from cmdline: "" Sep 1 22:02:13.934611 ignition[1083]: no config URL provided Sep 1 22:02:13.934615 ignition[1083]: reading system config file "/usr/lib/ignition/user.ign" Sep 1 22:02:13.934631 ignition[1083]: no config at "/usr/lib/ignition/user.ign" Sep 1 22:02:13.934635 ignition[1083]: failed to fetch config: resource requires networking Sep 1 22:02:13.934769 ignition[1083]: Ignition finished successfully Sep 1 22:02:13.987091 ignition[1132]: Ignition 2.26.0 Sep 1 22:02:13.987098 ignition[1132]: Stage: fetch Sep 1 22:02:13.987373 ignition[1132]: no config dir at "/usr/lib/ignition/base.d" Sep 1 22:02:13.987380 ignition[1132]: no config dir at "/usr/lib/ignition/base.platform.d/azure" Sep 1 22:02:13.987478 ignition[1132]: parsed url from cmdline: "" Sep 1 22:02:13.987481 ignition[1132]: no config URL provided Sep 1 22:02:13.987490 ignition[1132]: reading system config file "/usr/lib/ignition/user.ign" Sep 1 22:02:13.987498 ignition[1132]: no config at "/usr/lib/ignition/user.ign" Sep 1 22:02:13.987514 ignition[1132]: GET http://169.254.169.254/metadata/instance/compute/userData?api-version=2021-01-01&format=text: attempt #1 Sep 1 22:02:14.094210 ignition[1132]: GET result: OK Sep 1 22:02:14.094259 ignition[1132]: failed to retrieve userdata from IMDS, falling back to custom data: not a config (empty) Sep 1 22:02:14.118354 ignition[1132]: opening config device: "/dev/sr0" Sep 1 22:02:14.118647 ignition[1132]: getting drive status for "/dev/sr0" Sep 1 22:02:14.118681 ignition[1132]: drive status: OK Sep 1 22:02:14.118771 ignition[1132]: mounting config device Sep 1 22:02:14.118776 ignition[1132]: op(1): [started] mounting "/dev/sr0" at "/tmp/ignition-azure2272686981" Sep 1 22:02:14.158232 kernel: UDF-fs: INFO Mounting volume 'UDF Volume', timestamp 2026/09/02 00:00 (1000) Sep 1 22:02:14.160952 ignition[1132]: op(1): [finished] mounting "/dev/sr0" at "/tmp/ignition-azure2272686981" Sep 1 22:02:14.160959 ignition[1132]: checking for config drive Sep 1 22:02:14.163892 systemd[1]: tmp-ignition\x2dazure2272686981.mount: Deactivated successfully. Sep 1 22:02:14.162812 ignition[1132]: reading config Sep 1 22:02:14.163155 ignition[1132]: op(2): [started] unmounting "/dev/sr0" at "/tmp/ignition-azure2272686981" Sep 1 22:02:14.172709 ignition[1132]: op(2): [finished] unmounting "/dev/sr0" at "/tmp/ignition-azure2272686981" Sep 1 22:02:14.173268 unknown[1132]: fetched base config from "system" Sep 1 22:02:14.186000 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 1 22:02:14.172742 ignition[1132]: config has been read from custom data Sep 1 22:02:14.173273 unknown[1132]: fetched base config from "system" Sep 1 22:02:14.172749 ignition[1132]: parsing config with SHA512: 775bedca0543ccc280d01ffdfe70e81e21f6875650c5a9d6e7933ac0489103517e81f4d731f72b52a4fed14205e0959cdee2cd6da31e34d1f67f5ab982b43f5f Sep 1 22:02:14.180385 systemd[1]: Finished ignition-fetch.service - Ignition (fetch). Sep 1 22:02:14.172766 ignition[1132]: not a config (empty): provider config was empty, continuing with empty cache config Sep 1 22:02:14.190461 systemd[1]: Starting ignition-kargs.service - Ignition (kargs)... Sep 1 22:02:14.173340 ignition[1132]: fetch: fetch complete Sep 1 22:02:14.173343 ignition[1132]: fetch: fetch passed Sep 1 22:02:14.173375 ignition[1132]: Ignition finished successfully Sep 1 22:02:14.229100 ignition[1145]: Ignition 2.26.0 Sep 1 22:02:14.229108 ignition[1145]: Stage: kargs Sep 1 22:02:14.230417 ignition[1145]: no config dir at "/usr/lib/ignition/base.d" Sep 1 22:02:14.230424 ignition[1145]: no config dir at "/usr/lib/ignition/base.platform.d/azure" Sep 1 22:02:14.242000 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 1 22:02:14.235191 systemd[1]: Finished ignition-kargs.service - Ignition (kargs). Sep 1 22:02:14.230716 ignition[1145]: kargs: kargs passed Sep 1 22:02:14.244578 systemd[1]: Starting ignition-disks.service - Ignition (disks)... Sep 1 22:02:14.230755 ignition[1145]: Ignition finished successfully Sep 1 22:02:14.286656 systemd[1]: ignition-kargs.service: Deactivated successfully. Sep 1 22:02:14.286820 systemd[1]: Stopped ignition-kargs.service - Ignition (kargs). Sep 1 22:02:14.294000 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 1 22:02:14.297346 systemd[1]: ignition-fetch.service: Deactivated successfully. Sep 1 22:02:14.302000 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 1 22:02:14.297524 systemd[1]: Stopped ignition-fetch.service - Ignition (fetch). Sep 1 22:02:14.311000 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 1 22:02:14.305257 systemd[1]: ignition-fetch-offline.service: Deactivated successfully. Sep 1 22:02:14.305432 systemd[1]: Stopped ignition-fetch-offline.service - Ignition (fetch-offline). Sep 1 22:02:14.315330 systemd[1]: Unmounting oem.mount - /oem... Sep 1 22:02:14.341230 kernel: BTRFS info (device sda6): last unmount of filesystem c5c8e3fb-ffce-48cb-94b6-a2356d50b663 Sep 1 22:02:14.343230 systemd[1]: oem.mount: Deactivated successfully. Sep 1 22:02:14.344358 systemd[1]: Unmounted oem.mount - /oem. Sep 1 22:02:14.378021 ignition[1167]: Ignition 2.26.0 Sep 1 22:02:14.378036 ignition[1167]: Stage: disks Sep 1 22:02:14.383613 systemd[1]: Finished ignition-disks.service - Ignition (disks). Sep 1 22:02:14.388000 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 1 22:02:14.378262 ignition[1167]: no config dir at "/usr/lib/ignition/base.d" Sep 1 22:02:14.389428 systemd[1]: Reached target initrd-root-device.target - Initrd Root Device. Sep 1 22:02:14.378270 ignition[1167]: no config dir at "/usr/lib/ignition/base.platform.d/azure" Sep 1 22:02:14.398481 systemd[1]: Reached target local-fs-pre.target - Preparation for Local File Systems. Sep 1 22:02:14.378562 ignition[1167]: disks: disks passed Sep 1 22:02:14.408253 systemd[1]: Reached target local-fs.target - Local File Systems. Sep 1 22:02:14.378602 ignition[1167]: Ignition finished successfully Sep 1 22:02:14.417326 systemd[1]: Reached target sysinit.target - System Initialization. Sep 1 22:02:14.426632 systemd[1]: Reached target basic.target - Basic System. Sep 1 22:02:14.437316 systemd[1]: Starting systemd-fsck-root.service - File System Check on /dev/disk/by-label/ROOT... Sep 1 22:02:14.571668 systemd-fsck[1178]: ROOT: clean, 15/6361680 files, 408771/6359552 blocks Sep 1 22:02:14.581459 systemd[1]: Finished systemd-fsck-root.service - File System Check on /dev/disk/by-label/ROOT. Sep 1 22:02:14.586000 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 1 22:02:14.609741 systemd[1]: Mounting sysroot.mount - /sysroot... Sep 1 22:02:14.823231 kernel: EXT4-fs (sda9): mounted filesystem 681b3406-27b1-4bf0-a2db-ee88e1cbd565 r/w with ordered data mode. Quota mode: none. Sep 1 22:02:14.825086 systemd[1]: Mounted sysroot.mount - /sysroot. Sep 1 22:02:14.831375 systemd[1]: Reached target initrd-root-fs.target - Initrd Root File System. Sep 1 22:02:14.854080 systemd[1]: Mounting sysroot-usr.mount - /sysroot/usr... Sep 1 22:02:14.867642 systemd[1]: Starting flatcar-metadata-hostname.service - Flatcar Metadata Hostname Agent... Sep 1 22:02:14.875321 systemd[1]: ignition-remount-sysroot.service - Remount /sysroot read-write for Ignition skipped, unmet condition check ConditionPathIsReadWrite=!/sysroot Sep 1 22:02:14.875374 systemd[1]: Reached target ignition-diskful.target - Ignition Boot Disk Setup. Sep 1 22:02:14.890388 systemd[1]: Mounted sysroot-usr.mount - /sysroot/usr. Sep 1 22:02:14.901343 systemd[1]: Starting initrd-setup-root.service - Root filesystem setup... Sep 1 22:02:15.499583 coreos-metadata[1197]: Sep 01 22:02:15.499 INFO Fetching http://168.63.129.16/?comp=versions: Attempt #1 Sep 1 22:02:15.506779 coreos-metadata[1197]: Sep 01 22:02:15.506 INFO Fetch successful Sep 1 22:02:15.510815 coreos-metadata[1197]: Sep 01 22:02:15.510 INFO Fetching http://169.254.169.254/metadata/instance/compute/name?api-version=2017-08-01&format=text: Attempt #1 Sep 1 22:02:15.524948 coreos-metadata[1197]: Sep 01 22:02:15.524 INFO Fetch successful Sep 1 22:02:15.530127 coreos-metadata[1197]: Sep 01 22:02:15.528 INFO wrote hostname ci-9999.9.9-l-c95d858d68 to /sysroot/etc/hostname Sep 1 22:02:15.530365 systemd[1]: Finished flatcar-metadata-hostname.service - Flatcar Metadata Hostname Agent. Sep 1 22:02:15.540000 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 1 22:02:15.560643 kernel: kauditd_printk_skb: 30 callbacks suppressed Sep 1 22:02:15.560662 kernel: audit: type=1130 audit(1788300135.540:42): pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=flatcar-metadata-hostname comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Sep 1 22:02:16.589248 kernel: loop1: detected capacity change from 0 to 44096 Sep 1 22:02:16.704202 kernel: loop1: p1 p2 p3 Sep 1 22:02:16.981276 kernel: device-mapper: verity: sha256 using "sha256-lib" Sep 1 22:02:16.981321 kernel: device-mapper: verity: Unrecognized verity feature request: root_hash_sig_key_desc Sep 1 22:02:16.981330 kernel: device-mapper: table: 254:1: verity: Unrecognized verity feature request (-EINVAL) Sep 1 22:02:16.981337 kernel: device-mapper: ioctl: error adding target to table Sep 1 22:02:16.983100 systemd-confext[1278]: device-mapper: reload ioctl on loop1p1-14-verity (254:1) failed: Invalid argument Sep 1 22:02:17.025234 kernel: device-mapper: verity: sha256 using "sha256-lib" Sep 1 22:02:17.091229 kernel: erofs (device dm-1): mounted with root inode @ nid 40. Sep 1 22:02:17.123245 kernel: loop2: detected capacity change from 0 to 44096 Sep 1 22:02:17.128042 kernel: loop2: p1 p2 p3 Sep 1 22:02:17.131720 (sd-merge)[1289]: device-mapper: reload ioctl on loop2p1-18-verity (254:1) failed: Invalid argument Sep 1 22:02:17.160171 kernel: device-mapper: verity: sha256 using "sha256-lib" Sep 1 22:02:17.160193 kernel: device-mapper: verity: Unrecognized verity feature request: root_hash_sig_key_desc Sep 1 22:02:17.160202 kernel: device-mapper: table: 254:1: verity: Unrecognized verity feature request (-EINVAL) Sep 1 22:02:17.160209 kernel: device-mapper: ioctl: error adding target to table Sep 1 22:02:17.160243 kernel: device-mapper: verity: sha256 using "sha256-lib" Sep 1 22:02:17.176924 (sd-merge)[1289]: Using extensions '00-flatcar-default.raw'. Sep 1 22:02:17.186139 kernel: erofs (device dm-1): mounted with root inode @ nid 40. Sep 1 22:02:17.177688 (sd-merge)[1289]: Merged extensions into '/sysroot/etc'. Sep 1 22:02:17.192821 initrd-setup-root[1296]: /etc 00-flatcar-default Tue 2026-09-01 22:02:10 UTC Sep 1 22:02:17.198986 systemd[1]: Finished initrd-setup-root.service - Root filesystem setup. Sep 1 22:02:17.203000 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 1 22:02:17.219988 kernel: audit: type=1130 audit(1788300137.203:43): pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=initrd-setup-root comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Sep 1 22:02:17.207773 systemd[1]: Starting ignition-mount.service - Ignition (mount)... Sep 1 22:02:17.257355 ignition[1302]: INFO : Ignition 2.26.0 Sep 1 22:02:17.257355 ignition[1302]: INFO : Stage: mount Sep 1 22:02:17.263000 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 1 22:02:17.282294 kernel: audit: type=1130 audit(1788300137.263:44): pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=ignition-mount comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Sep 1 22:02:17.282313 ignition[1302]: INFO : no config dir at "/usr/lib/ignition/base.d" Sep 1 22:02:17.282313 ignition[1302]: INFO : no config dir at "/usr/lib/ignition/base.platform.d/azure" Sep 1 22:02:17.282313 ignition[1302]: INFO : mount: mount passed Sep 1 22:02:17.282313 ignition[1302]: INFO : Ignition finished successfully Sep 1 22:02:17.260448 systemd[1]: Finished ignition-mount.service - Ignition (mount). Sep 1 22:02:17.267660 systemd[1]: Starting ignition-files.service - Ignition (files)... Sep 1 22:02:17.302573 systemd[1]: Mounting oem.mount - /oem... Sep 1 22:02:17.325493 kernel: BTRFS: device label OEM devid 1 transid 11 /dev/sda6 (8:6) scanned by mount (1314) Sep 1 22:02:17.327239 kernel: BTRFS info (device sda6): first mount of filesystem c5c8e3fb-ffce-48cb-94b6-a2356d50b663 Sep 1 22:02:17.327286 kernel: BTRFS info (device sda6): using crc32c (crc32c-lib) checksum algorithm Sep 1 22:02:17.329227 kernel: BTRFS info (device sda6): turning on async discard Sep 1 22:02:17.329260 kernel: BTRFS info (device sda6): enabling free space tree Sep 1 22:02:17.333210 systemd[1]: Mounted oem.mount - /oem. Sep 1 22:02:17.350818 systemd[1]: Mounting sysroot-oem.mount - /sysroot/oem... Sep 1 22:02:17.370907 systemd[1]: Mounted sysroot-oem.mount - /sysroot/oem. Sep 1 22:02:17.400236 ignition[1334]: INFO : Ignition 2.26.0 Sep 1 22:02:17.403253 ignition[1334]: INFO : Stage: files Sep 1 22:02:17.403253 ignition[1334]: INFO : no config dir at "/usr/lib/ignition/base.d" Sep 1 22:02:17.403253 ignition[1334]: INFO : no config dir at "/usr/lib/ignition/base.platform.d/azure" Sep 1 22:02:17.403253 ignition[1334]: DEBUG : files: compiled without relabeling support, skipping Sep 1 22:02:17.403253 ignition[1334]: INFO : files: createResultFile: createFiles: op(1): [started] writing file "/sysroot/etc/.ignition-result.json" Sep 1 22:02:17.403253 ignition[1334]: INFO : files: createResultFile: createFiles: op(1): [finished] writing file "/sysroot/etc/.ignition-result.json" Sep 1 22:02:17.403253 ignition[1334]: INFO : files: files passed Sep 1 22:02:17.403253 ignition[1334]: INFO : Ignition finished successfully Sep 1 22:02:17.409000 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 1 22:02:17.467685 kernel: audit: type=1130 audit(1788300137.409:45): pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=ignition-files comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Sep 1 22:02:17.405258 systemd[1]: Finished ignition-files.service - Ignition (files). Sep 1 22:02:17.411834 systemd[1]: Starting ignition-quench.service - Ignition (record completion)... Sep 1 22:02:17.477000 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 1 22:02:17.477000 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 1 22:02:17.452332 systemd[1]: Starting initrd-setup-root-after-ignition.service - Root filesystem completion... Sep 1 22:02:17.511969 kernel: audit: type=1130 audit(1788300137.477:46): pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=ignition-quench comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Sep 1 22:02:17.462885 systemd[1]: ignition-quench.service: Deactivated successfully. Sep 1 22:02:17.516150 kernel: audit: type=1131 audit(1788300137.477:47): pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=ignition-quench comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Sep 1 22:02:17.471818 systemd[1]: Finished ignition-quench.service - Ignition (record completion). Sep 1 22:02:17.540615 initrd-setup-root-after-ignition[1364]: grep: /sysroot/etc/flatcar/enabled-sysext.conf: No such file or directory Sep 1 22:02:17.540615 initrd-setup-root-after-ignition[1364]: grep: /sysroot/usr/share/flatcar/enabled-sysext.conf: No such file or directory Sep 1 22:02:17.557301 initrd-setup-root-after-ignition[1368]: grep: /sysroot/etc/flatcar/enabled-sysext.conf: No such file or directory Sep 1 22:02:17.564381 kernel: loop3: detected capacity change from 0 to 44096 Sep 1 22:02:17.566671 kernel: loop3: p1 p2 p3 Sep 1 22:02:17.575099 kernel: device-mapper: verity: sha256 using "sha256-lib" Sep 1 22:02:17.575150 kernel: device-mapper: verity: Unrecognized verity feature request: root_hash_sig_key_desc Sep 1 22:02:17.578811 systemd-confext[1370]: device-mapper: reload ioctl on loop3p1-21-verity (254:2) failed: Invalid argument Sep 1 22:02:17.597543 kernel: device-mapper: table: 254:2: verity: Unrecognized verity feature request (-EINVAL) Sep 1 22:02:17.597564 kernel: device-mapper: ioctl: error adding target to table Sep 1 22:02:17.597572 kernel: device-mapper: verity: sha256 using "sha256-lib" Sep 1 22:02:17.616232 kernel: erofs (device dm-2): mounted with root inode @ nid 40. Sep 1 22:02:17.638238 kernel: loop4: detected capacity change from 0 to 44096 Sep 1 22:02:17.642237 kernel: loop4: p1 p2 p3 Sep 1 22:02:17.648342 kernel: device-mapper: verity: sha256 using "sha256-lib" Sep 1 22:02:17.648293 (sd-merge)[1378]: device-mapper: reload ioctl on loop4p1-25-verity (254:2) failed: Invalid argument Sep 1 22:02:17.674518 kernel: device-mapper: verity: Unrecognized verity feature request: root_hash_sig_key_desc Sep 1 22:02:17.674540 kernel: device-mapper: table: 254:2: verity: Unrecognized verity feature request (-EINVAL) Sep 1 22:02:17.674549 kernel: device-mapper: ioctl: error adding target to table Sep 1 22:02:17.674556 kernel: device-mapper: verity: sha256 using "sha256-lib" Sep 1 22:02:17.693246 kernel: erofs (device dm-2): mounted with root inode @ nid 40. Sep 1 22:02:17.692233 (sd-merge)[1378]: Skipping extension refresh because no change was found, use --always-refresh=yes to always do a refresh. Sep 1 22:02:17.816256 kernel: loop4: detected capacity change from 0 to 388472 Sep 1 22:02:17.898228 kernel: loop4: p1 p2 p3 Sep 1 22:02:18.267335 kernel: device-mapper: verity: sha256 using "sha256-lib" Sep 1 22:02:18.267384 kernel: device-mapper: verity: Unrecognized verity feature request: root_hash_sig_key_desc Sep 1 22:02:18.267392 kernel: device-mapper: table: 254:2: verity: Unrecognized verity feature request (-EINVAL) Sep 1 22:02:18.267400 kernel: device-mapper: ioctl: error adding target to table Sep 1 22:02:18.267456 systemd-sysext[1386]: device-mapper: reload ioctl on loop4p1-29-verity (254:2) failed: Invalid argument Sep 1 22:02:18.290589 kernel: device-mapper: verity: sha256 using "sha256-lib" Sep 1 22:02:18.440238 kernel: erofs (device dm-2): mounted with root inode @ nid 39. Sep 1 22:02:18.593268 kernel: loop5: detected capacity change from 0 to 158496 Sep 1 22:02:18.634535 kernel: loop5: p1 p2 p3 Sep 1 22:02:18.876455 kernel: device-mapper: verity: sha256 using "sha256-lib" Sep 1 22:02:18.876507 kernel: device-mapper: verity: Unrecognized verity feature request: root_hash_sig_key_desc Sep 1 22:02:18.876516 kernel: device-mapper: table: 254:2: verity: Unrecognized verity feature request (-EINVAL) Sep 1 22:02:18.880447 systemd-sysext[1386]: device-mapper: reload ioctl on loop5p1-33-verity (254:2) failed: Invalid argument Sep 1 22:02:18.898949 kernel: device-mapper: ioctl: error adding target to table Sep 1 22:02:18.898969 kernel: device-mapper: verity: sha256 using "sha256-lib" Sep 1 22:02:18.982232 kernel: erofs (device dm-2): mounted with root inode @ nid 39. Sep 1 22:02:19.031502 kernel: loop6: detected capacity change from 0 to 140944 Sep 1 22:02:19.051240 kernel: loop6: p1 p2 p3 Sep 1 22:02:19.206941 systemd-sysext[1386]: device-mapper: reload ioctl on loop6p1-37-verity (254:2) failed: Invalid argument Sep 1 22:02:19.229435 kernel: device-mapper: verity: sha256 using "sha256-lib" Sep 1 22:02:19.229459 kernel: device-mapper: verity: Unrecognized verity feature request: root_hash_sig_key_desc Sep 1 22:02:19.229468 kernel: device-mapper: table: 254:2: verity: Unrecognized verity feature request (-EINVAL) Sep 1 22:02:19.229476 kernel: device-mapper: ioctl: error adding target to table Sep 1 22:02:19.229482 kernel: device-mapper: verity: sha256 using "sha256-lib" Sep 1 22:02:19.338238 kernel: erofs (device dm-2): mounted with root inode @ nid 39. Sep 1 22:02:19.363241 kernel: loop7: detected capacity change from 0 to 388472 Sep 1 22:02:19.366239 kernel: loop7: p1 p2 p3 Sep 1 22:02:19.377832 (sd-merge)[1409]: device-mapper: reload ioctl on loop7p1-41-verity (254:2) failed: Invalid argument Sep 1 22:02:19.401193 kernel: device-mapper: verity: sha256 using "sha256-lib" Sep 1 22:02:19.401227 kernel: device-mapper: verity: Unrecognized verity feature request: root_hash_sig_key_desc Sep 1 22:02:19.401235 kernel: device-mapper: table: 254:2: verity: Unrecognized verity feature request (-EINVAL) Sep 1 22:02:19.401242 kernel: device-mapper: ioctl: error adding target to table Sep 1 22:02:19.401257 kernel: device-mapper: verity: sha256 using "sha256-lib" Sep 1 22:02:19.426232 kernel: erofs (device dm-2): mounted with root inode @ nid 39. Sep 1 22:02:19.430774 kernel: loop1: detected capacity change from 0 to 158496 Sep 1 22:02:19.436250 kernel: loop1: p1 p2 p3 Sep 1 22:02:19.447004 (sd-merge)[1409]: device-mapper: reload ioctl on loop1p1-45-verity (254:3) failed: Invalid argument Sep 1 22:02:19.464201 kernel: device-mapper: verity: sha256 using "sha256-lib" Sep 1 22:02:19.464231 kernel: device-mapper: verity: Unrecognized verity feature request: root_hash_sig_key_desc Sep 1 22:02:19.464240 kernel: device-mapper: table: 254:3: verity: Unrecognized verity feature request (-EINVAL) Sep 1 22:02:19.464247 kernel: device-mapper: ioctl: error adding target to table Sep 1 22:02:19.464253 kernel: device-mapper: verity: sha256 using "sha256-lib" Sep 1 22:02:19.497203 kernel: erofs (device dm-3): mounted with root inode @ nid 39. Sep 1 22:02:19.497268 kernel: loop3: detected capacity change from 0 to 140944 Sep 1 22:02:19.500762 kernel: loop3: p1 p2 p3 Sep 1 22:02:19.506265 kernel: device-mapper: verity: sha256 using "sha256-lib" Sep 1 22:02:19.506309 kernel: device-mapper: verity: Unrecognized verity feature request: root_hash_sig_key_desc Sep 1 22:02:19.506319 kernel: device-mapper: table: 254:4: verity: Unrecognized verity feature request (-EINVAL) Sep 1 22:02:19.506579 (sd-merge)[1409]: device-mapper: reload ioctl on loop3p1-49-verity (254:4) failed: Invalid argument Sep 1 22:02:19.519256 kernel: device-mapper: ioctl: error adding target to table Sep 1 22:02:19.519283 kernel: device-mapper: verity: sha256 using "sha256-lib" Sep 1 22:02:19.560052 (sd-merge)[1409]: Using extensions 'containerd-flatcar.raw', 'docker-flatcar.raw', 'oem-azure-9999.9.9+linux-main-6.18-w-nividia-111.raw'. Sep 1 22:02:19.570385 kernel: erofs (device dm-4): mounted with root inode @ nid 39. Sep 1 22:02:19.560879 (sd-merge)[1409]: Merged extensions into '/sysroot/usr'. Sep 1 22:02:19.572110 systemd[1]: Finished initrd-setup-root-after-ignition.service - Root filesystem completion. Sep 1 22:02:19.578000 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 1 22:02:19.596821 kernel: audit: type=1130 audit(1788300139.578:48): pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=initrd-setup-root-after-ignition comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Sep 1 22:02:19.581465 systemd[1]: Starting initrd-parse-etc.service - Mountpoints Configured in the Real Root... Sep 1 22:02:19.628198 systemd[1]: initrd-parse-etc.service: Deactivated successfully. Sep 1 22:02:19.629279 systemd[1]: Finished initrd-parse-etc.service - Mountpoints Configured in the Real Root. Sep 1 22:02:19.637000 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 1 22:02:19.653693 kernel: audit: type=1130 audit(1788300139.637:49): pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=initrd-parse-etc comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Sep 1 22:02:19.653626 systemd[1]: initrd-parse-etc.service: Triggering OnSuccess= dependencies. Sep 1 22:02:19.652000 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 1 22:02:19.669235 kernel: audit: type=1131 audit(1788300139.652:50): pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=initrd-parse-etc comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Sep 1 22:02:19.669860 systemd[1]: Reached target initrd-fs.target - Initrd File Systems. Sep 1 22:02:19.679769 systemd[1]: Starting dracut-mount.service - dracut mount hook... Sep 1 22:02:20.039556 systemd[1]: Finished dracut-mount.service - dracut mount hook. Sep 1 22:02:20.043000 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 1 22:02:20.060226 kernel: audit: type=1130 audit(1788300140.043:51): pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=dracut-mount comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Sep 1 22:02:20.061990 systemd[1]: Starting dracut-pre-pivot.service - dracut pre-pivot and cleanup hook... Sep 1 22:02:20.093663 systemd[1]: Finished dracut-pre-pivot.service - dracut pre-pivot and cleanup hook. Sep 1 22:02:20.098000 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 1 22:02:20.105787 systemd[1]: Starting initrd-cleanup.service - Cleaning Up and Shutting Down Daemons... Sep 1 22:02:20.131390 systemd[1]: Stopped target basic.target - Basic System. Sep 1 22:02:20.135653 systemd[1]: Stopped target ignition-diskful.target - Ignition Boot Disk Setup. Sep 1 22:02:20.147062 systemd[1]: Stopped target initrd-root-device.target - Initrd Root Device. Sep 1 22:02:20.157312 systemd[1]: Stopped target initrd-usr-fs.target - Initrd /usr File System. Sep 1 22:02:20.166809 systemd[1]: Stopped target nss-lookup.target - Host and Network Name Lookups. Sep 1 22:02:20.177042 systemd[1]: Stopped target paths.target - Path Units. Sep 1 22:02:20.186209 systemd[1]: Stopped target remote-cryptsetup.target - Remote Encrypted Volumes. Sep 1 22:02:20.195439 systemd[1]: Stopped target slices.target - Slice Units. Sep 1 22:02:20.205396 systemd[1]: Stopped target sockets.target - Socket Units. Sep 1 22:02:20.213552 systemd[1]: Stopped target sysinit.target - System Initialization. Sep 1 22:02:20.222410 systemd[1]: Stopped target local-fs.target - Local File Systems. Sep 1 22:02:20.231510 systemd[1]: Stopped target local-fs-pre.target - Preparation for Local File Systems. Sep 1 22:02:20.241391 systemd[1]: Stopped target swap.target - Swaps. Sep 1 22:02:20.250131 systemd[1]: Stopped target timers.target - Timer Units. Sep 1 22:02:20.257395 systemd[1]: iscsid.socket: Deactivated successfully. Sep 1 22:02:20.257540 systemd[1]: Closed iscsid.socket - Open-iSCSI iscsid Socket. Sep 1 22:02:20.270006 systemd[1]: iscsiuio.socket: Deactivated successfully. Sep 1 22:02:20.270187 systemd[1]: Closed iscsiuio.socket - Open-iSCSI iscsiuio Socket. Sep 1 22:02:20.283700 systemd[1]: systemd-coredump.socket: Deactivated successfully. Sep 1 22:02:20.283899 systemd[1]: Closed systemd-coredump.socket - Process Core Dump Socket. Sep 1 22:02:20.298334 systemd[1]: systemd-journald-audit.socket: Deactivated successfully. Sep 1 22:02:20.298518 systemd[1]: Closed systemd-journald-audit.socket - Journal Audit Socket. Sep 1 22:02:20.313107 systemd[1]: dracut-pre-pivot.service: Deactivated successfully. Sep 1 22:02:20.321000 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 1 22:02:20.313358 systemd[1]: Stopped dracut-pre-pivot.service - dracut pre-pivot and cleanup hook. Sep 1 22:02:20.326658 systemd[1]: Stopped target remote-fs.target - Remote File Systems. Sep 1 22:02:20.336300 systemd[1]: Stopped target remote-fs-pre.target - Preparation for Remote File Systems. Sep 1 22:02:20.345527 systemd[1]: dracut-mount.service: Deactivated successfully. Sep 1 22:02:20.353000 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 1 22:02:20.345677 systemd[1]: Stopped dracut-mount.service - dracut mount hook. Sep 1 22:02:20.358742 systemd[1]: dracut-pre-mount.service: Deactivated successfully. Sep 1 22:02:20.366000 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 1 22:02:20.358926 systemd[1]: Stopped dracut-pre-mount.service - dracut pre-mount hook. Sep 1 22:02:20.371844 systemd[1]: Stopped target cryptsetup.target - Local Encrypted Volumes. Sep 1 22:02:20.380888 systemd[1]: systemd-ask-password-console.path: Deactivated successfully. Sep 1 22:02:20.381333 systemd[1]: Stopped systemd-ask-password-console.path - Dispatch Password Requests to Console Directory Watch. Sep 1 22:02:20.393066 systemd[1]: Stopped target cryptsetup-pre.target - Local Encrypted Volumes (Pre). Sep 1 22:02:20.402441 systemd[1]: clevis-luks-askpass.path: Deactivated successfully. Sep 1 22:02:20.423000 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 1 22:02:20.402878 systemd[1]: Stopped clevis-luks-askpass.path - Forward Password Requests to Clevis Directory Watch. Sep 1 22:02:20.415452 systemd[1]: dracut-initqueue.service: Deactivated successfully. Sep 1 22:02:20.438000 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 1 22:02:20.415699 systemd[1]: Stopped dracut-initqueue.service - dracut initqueue hook. Sep 1 22:02:20.446000 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 1 22:02:20.428981 systemd[1]: initrd-setup-root-after-ignition.service: Deactivated successfully. Sep 1 22:02:20.429301 systemd[1]: Stopped initrd-setup-root-after-ignition.service - Root filesystem completion. Sep 1 22:02:20.459000 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 1 22:02:20.440959 systemd[1]: ignition-files.service: Deactivated successfully. Sep 1 22:02:20.441107 systemd[1]: Stopped ignition-files.service - Ignition (files). Sep 1 22:02:20.451440 systemd[1]: flatcar-metadata-hostname.service: Deactivated successfully. Sep 1 22:02:20.451700 systemd[1]: Stopped flatcar-metadata-hostname.service - Flatcar Metadata Hostname Agent. Sep 1 22:02:20.487000 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 1 22:02:20.470458 systemd[1]: Stopping ignition-mount.service - Ignition (mount)... Sep 1 22:02:20.479549 systemd[1]: systemd-modules-load.service: Deactivated successfully. Sep 1 22:02:20.479807 systemd[1]: Stopped systemd-modules-load.service - Load Kernel Modules. Sep 1 22:02:20.509000 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 1 22:02:20.492066 systemd[1]: systemd-tmpfiles-setup.service: Deactivated successfully. Sep 1 22:02:20.515954 ignition[1484]: INFO : Ignition 2.26.0 Sep 1 22:02:20.515954 ignition[1484]: INFO : Stage: umount Sep 1 22:02:20.515954 ignition[1484]: INFO : no config dir at "/usr/lib/ignition/base.d" Sep 1 22:02:20.515954 ignition[1484]: INFO : no config dir at "/usr/lib/ignition/base.platform.d/azure" Sep 1 22:02:20.515954 ignition[1484]: INFO : umount: umount passed Sep 1 22:02:20.515954 ignition[1484]: INFO : Ignition finished successfully Sep 1 22:02:20.520000 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 1 22:02:20.530000 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 1 22:02:20.547000 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 1 22:02:20.494313 systemd[1]: Stopped systemd-tmpfiles-setup.service - Create System Files and Directories. Sep 1 22:02:20.571328 kernel: kauditd_printk_skb: 12 callbacks suppressed Sep 1 22:02:20.512872 systemd[1]: systemd-udev-trigger.service: Deactivated successfully. Sep 1 22:02:20.576181 kernel: audit: type=1131 audit(1788300140.547:64): 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 1 22:02:20.513064 systemd[1]: Stopped systemd-udev-trigger.service - Coldplug All udev Devices. Sep 1 22:02:20.524582 systemd[1]: dracut-pre-trigger.service: Deactivated successfully. Sep 1 22:02:20.585000 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 1 22:02:20.599000 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 1 22:02:20.601662 kernel: audit: type=1130 audit(1788300140.585:65): 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 1 22:02:20.524777 systemd[1]: Stopped dracut-pre-trigger.service - dracut pre-trigger hook. Sep 1 22:02:20.615677 kernel: audit: type=1131 audit(1788300140.599:66): 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 1 22:02:20.538542 systemd[1]: ignition-mount.service: Deactivated successfully. Sep 1 22:02:20.541306 systemd[1]: Stopped ignition-mount.service - Ignition (mount). Sep 1 22:02:20.575594 systemd[1]: initrd-cleanup.service: Deactivated successfully. Sep 1 22:02:20.631000 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 1 22:02:20.646695 kernel: audit: type=1131 audit(1788300140.631:67): 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 1 22:02:20.578276 systemd[1]: Finished initrd-cleanup.service - Cleaning Up and Shutting Down Daemons. Sep 1 22:02:20.616743 systemd[1]: Stopped target network.target - Network. Sep 1 22:02:20.655000 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 1 22:02:20.669524 kernel: audit: type=1131 audit(1788300140.655:68): 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 1 22:02:20.622956 systemd[1]: ignition-disks.service: Deactivated successfully. Sep 1 22:02:20.623028 systemd[1]: Stopped ignition-disks.service - Ignition (disks). Sep 1 22:02:20.677000 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 1 22:02:20.693561 kernel: audit: type=1131 audit(1788300140.677:69): 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 1 22:02:20.651094 systemd[1]: ignition-setup-pre.service: Deactivated successfully. Sep 1 22:02:20.651161 systemd[1]: Stopped ignition-setup-pre.service - Ignition env setup. Sep 1 22:02:20.671139 systemd[1]: initrd-setup-root.service: Deactivated successfully. Sep 1 22:02:20.671208 systemd[1]: Stopped initrd-setup-root.service - Root filesystem setup. Sep 1 22:02:20.724000 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 1 22:02:20.738000 audit: BPF prog-id=5 op=UNLOAD Sep 1 22:02:20.695411 systemd[1]: Stopping systemd-networkd.service - Network Management... Sep 1 22:02:20.747946 kernel: audit: type=1131 audit(1788300140.724:70): 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 1 22:02:20.704324 systemd[1]: Stopping systemd-resolved.service - Network Name Resolution... Sep 1 22:02:20.752553 kernel: audit: type=1334 audit(1788300140.738:71): prog-id=5 op=UNLOAD Sep 1 22:02:20.716410 systemd[1]: systemd-resolved.service: Deactivated successfully. Sep 1 22:02:20.720302 systemd[1]: Stopped systemd-resolved.service - Network Name Resolution. Sep 1 22:02:20.759000 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 1 22:02:20.775112 kernel: audit: type=1131 audit(1788300140.759:72): 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 1 22:02:20.750923 systemd[1]: systemd-networkd.service: Deactivated successfully. Sep 1 22:02:20.753307 systemd[1]: Stopped systemd-networkd.service - Network Management. Sep 1 22:02:20.782000 audit: BPF prog-id=8 op=UNLOAD Sep 1 22:02:20.780133 systemd[1]: Stopped target network-pre.target - Preparation for Network. Sep 1 22:02:20.793065 kernel: audit: type=1334 audit(1788300140.782:73): prog-id=8 op=UNLOAD Sep 1 22:02:20.797439 systemd[1]: systemd-networkd-resolve-hook.socket: Deactivated successfully. Sep 1 22:02:20.797560 systemd[1]: Closed systemd-networkd-resolve-hook.socket - Network Management Resolve Hook Socket. Sep 1 22:02:20.813027 systemd[1]: systemd-networkd.socket: Deactivated successfully. Sep 1 22:02:20.813112 systemd[1]: Closed systemd-networkd.socket - Network Management Netlink Socket. Sep 1 22:02:20.827351 systemd[1]: Stopping network-cleanup.service - Network Cleanup... Sep 1 22:02:20.831136 systemd[1]: parse-ip-for-networkd.service: Deactivated successfully. Sep 1 22:02:20.841000 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 1 22:02:20.835382 systemd[1]: Stopped parse-ip-for-networkd.service - Write systemd-networkd units from cmdline. Sep 1 22:02:20.853193 systemd[1]: Stopping systemd-udevd.service - Rule-based Manager for Device Events and Files... Sep 1 22:02:20.873366 systemd[1]: systemd-udevd.service: Deactivated successfully. Sep 1 22:02:20.877936 systemd[1]: Stopped systemd-udevd.service - Rule-based Manager for Device Events and Files. Sep 1 22:02:20.883000 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 1 22:02:20.884093 systemd[1]: systemd-udevd.service: Consumed 1.089s CPU time over 9.398s wall clock time. Sep 1 22:02:20.886138 systemd[1]: systemd-udevd-control.socket: Deactivated successfully. Sep 1 22:02:20.886205 systemd[1]: Closed systemd-udevd-control.socket - udev Control Socket. Sep 1 22:02:20.906653 systemd[1]: dracut-pre-udev.service: Deactivated successfully. Sep 1 22:02:20.915000 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 1 22:02:20.906718 systemd[1]: Stopped dracut-pre-udev.service - dracut pre-udev hook. Sep 1 22:02:20.920618 systemd[1]: dracut-cmdline.service: Deactivated successfully. Sep 1 22:02:20.928000 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 1 22:02:20.920693 systemd[1]: Stopped dracut-cmdline.service - dracut cmdline hook. Sep 1 22:02:20.939000 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 1 22:02:20.931010 systemd[1]: dracut-cmdline-ask.service: Deactivated successfully. Sep 1 22:02:20.931080 systemd[1]: Stopped dracut-cmdline-ask.service - dracut ask for additional cmdline parameters. Sep 1 22:02:20.953335 systemd[1]: Starting initrd-udevadm-cleanup-db.service - Cleanup udev Database... Sep 1 22:02:20.962288 systemd[1]: systemd-network-generator.service: Deactivated successfully. Sep 1 22:02:20.970000 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 1 22:02:20.962352 systemd[1]: Stopped systemd-network-generator.service - Generate Network Units from Kernel Command Line. Sep 1 22:02:20.980000 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 1 22:02:20.975004 systemd[1]: systemd-tmpfiles-setup-dev.service: Deactivated successfully. Sep 1 22:02:20.994000 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 1 22:02:20.975063 systemd[1]: Stopped systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev. Sep 1 22:02:20.984002 systemd[1]: systemd-tmpfiles-setup-dev-early.service: Deactivated successfully. Sep 1 22:02:21.010000 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 1 22:02:20.984065 systemd[1]: Stopped systemd-tmpfiles-setup-dev-early.service - Create Static Device Nodes in /dev gracefully. Sep 1 22:02:21.002073 systemd[1]: kmod-static-nodes.service: Deactivated successfully. Sep 1 22:02:21.026000 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 1 22:02:21.002144 systemd[1]: Stopped kmod-static-nodes.service - Create List of Static Device Nodes. Sep 1 22:02:21.012813 systemd[1]: systemd-vconsole-setup.service: Deactivated successfully. Sep 1 22:02:21.012892 systemd[1]: Stopped systemd-vconsole-setup.service - Virtual Console Setup. Sep 1 22:02:21.049000 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 1 22:02:21.049000 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 1 22:02:21.032915 systemd[1]: initrd-udevadm-cleanup-db.service: Deactivated successfully. Sep 1 22:02:21.039422 systemd[1]: Finished initrd-udevadm-cleanup-db.service - Cleanup udev Database. Sep 1 22:02:21.106262 kernel: hv_netvsc 7ced8dc7-e335-7ced-8dc7-e3357ced8dc7 eth0: Data path switched from VF: enP27581s1 Sep 1 22:02:21.124665 systemd[1]: network-cleanup.service: Deactivated successfully. Sep 1 22:02:21.125811 systemd[1]: Stopped network-cleanup.service - Network Cleanup. Sep 1 22:02:21.131000 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 1 22:02:21.137665 systemd[1]: Reached target initrd-switch-root.target - Switch Root. Sep 1 22:02:21.148417 systemd[1]: Starting initrd-switch-root.service - Switch Root... Sep 1 22:02:21.169483 systemd[1]: Switching root. Sep 1 22:02:21.357692 systemd-journald[374]: Journal stopped Sep 1 22:02:27.020759 systemd-journald[374]: Received SIGTERM from PID 1 (systemd). Sep 1 22:02:27.020800 kernel: SELinux: policy capability network_peer_controls=1 Sep 1 22:02:27.020814 kernel: SELinux: policy capability open_perms=1 Sep 1 22:02:27.020823 kernel: SELinux: policy capability extended_socket_class=1 Sep 1 22:02:27.020832 kernel: SELinux: policy capability always_check_network=0 Sep 1 22:02:27.020839 kernel: SELinux: policy capability cgroup_seclabel=1 Sep 1 22:02:27.020849 kernel: SELinux: policy capability nnp_nosuid_transition=1 Sep 1 22:02:27.020854 kernel: SELinux: policy capability genfs_seclabel_symlinks=0 Sep 1 22:02:27.020863 kernel: SELinux: policy capability ioctl_skip_cloexec=0 Sep 1 22:02:27.020868 kernel: SELinux: policy capability userspace_initial_context=0 Sep 1 22:02:27.020875 kernel: SELinux: policy capability netlink_xperm=0 Sep 1 22:02:27.020883 kernel: SELinux: policy capability netif_wildcard=0 Sep 1 22:02:27.020890 kernel: SELinux: policy capability genfs_seclabel_wildcard=0 Sep 1 22:02:27.020896 kernel: SELinux: policy capability functionfs_seclabel=0 Sep 1 22:02:27.020905 systemd[1]: Successfully loaded SELinux policy in 280.138ms. Sep 1 22:02:27.020914 systemd[1]: Relabeled /dev/, /dev/shm/, /run/ in 6.241ms. Sep 1 22:02:27.020924 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 1 22:02:27.020933 systemd[1]: Detected virtualization microsoft. Sep 1 22:02:27.020940 systemd[1]: Detected architecture arm64. Sep 1 22:02:27.020948 systemd[1]: Detected first boot. Sep 1 22:02:27.020956 systemd[1]: Initializing machine ID from random generator. Sep 1 22:02:27.020965 systemd[1]: Hostname set to . Sep 1 22:02:27.020974 zram_generator::config[1771]: No configuration found. Sep 1 22:02:27.020983 kernel: NET: Registered PF_VSOCK protocol family Sep 1 22:02:27.020991 systemd[1]: Applying preset policy. Sep 1 22:02:27.020997 systemd[1]: Populated /etc with preset unit settings. Sep 1 22:02:27.021004 kernel: kauditd_printk_skb: 17 callbacks suppressed Sep 1 22:02:27.021012 kernel: audit: type=1334 audit(1788300146.011:91): prog-id=10 op=LOAD Sep 1 22:02:27.021020 kernel: audit: type=1334 audit(1788300146.011:92): prog-id=2 op=UNLOAD Sep 1 22:02:27.021025 kernel: audit: type=1334 audit(1788300146.011:93): prog-id=11 op=LOAD Sep 1 22:02:27.021031 kernel: audit: type=1334 audit(1788300146.011:94): prog-id=12 op=LOAD Sep 1 22:02:27.021038 kernel: audit: type=1334 audit(1788300146.011:95): prog-id=3 op=UNLOAD Sep 1 22:02:27.021045 kernel: audit: type=1334 audit(1788300146.011:96): prog-id=4 op=UNLOAD Sep 1 22:02:27.021050 kernel: audit: type=1334 audit(1788300146.012:97): prog-id=13 op=LOAD Sep 1 22:02:27.021056 kernel: audit: type=1334 audit(1788300146.012:98): prog-id=10 op=UNLOAD Sep 1 22:02:27.021063 kernel: audit: type=1334 audit(1788300146.013:99): prog-id=14 op=LOAD Sep 1 22:02:27.021070 kernel: audit: type=1334 audit(1788300146.013:100): prog-id=15 op=LOAD Sep 1 22:02:27.021077 systemd[1]: initrd-switch-root.service: Deactivated successfully. Sep 1 22:02:27.021082 systemd[1]: Stopped initrd-switch-root.service - Switch Root. Sep 1 22:02:27.021089 systemd[1]: systemd-journald.service: Scheduled restart job, restart counter is at 1. Sep 1 22:02:27.021097 systemd[1]: Created slice system-addon\x2dconfig.slice - Slice /system/addon-config. Sep 1 22:02:27.021105 systemd[1]: Created slice system-addon\x2drun.slice - Slice /system/addon-run. Sep 1 22:02:27.021111 systemd[1]: Created slice system-getty.slice - Slice /system/getty. Sep 1 22:02:27.021119 systemd[1]: Created slice system-modprobe.slice - Slice /system/modprobe. Sep 1 22:02:27.021125 systemd[1]: Created slice system-serial\x2dgetty.slice - Slice /system/serial-getty. Sep 1 22:02:27.021134 systemd[1]: Created slice system-system\x2dcloudinit.slice - Slice /system/system-cloudinit. Sep 1 22:02:27.021141 systemd[1]: Created slice system-systemd\x2dfsck.slice - Slice /system/systemd-fsck. Sep 1 22:02:27.021148 systemd[1]: Created slice user.slice - User and Session Slice. Sep 1 22:02:27.021155 systemd[1]: Started clevis-luks-askpass.path - Forward Password Requests to Clevis Directory Watch. Sep 1 22:02:27.021161 systemd[1]: Started systemd-ask-password-console.path - Dispatch Password Requests to Console Directory Watch. Sep 1 22:02:27.021167 systemd[1]: Started systemd-ask-password-wall.path - Forward Password Requests to Wall Directory Watch. Sep 1 22:02:27.021173 systemd[1]: Set up automount boot.automount - Boot partition Automount Point. Sep 1 22:02:27.021179 systemd[1]: Set up automount proc-sys-fs-binfmt_misc.automount - Arbitrary Executable File Formats File System Automount Point. Sep 1 22:02:27.021186 systemd[1]: Expecting device dev-disk-by\x2dlabel-OEM.device - /dev/disk/by-label/OEM... Sep 1 22:02:27.021192 systemd[1]: Expecting device dev-ptp_hyperv.device - /dev/ptp_hyperv... Sep 1 22:02:27.021199 systemd[1]: Expecting device dev-ttyAMA0.device - /dev/ttyAMA0... Sep 1 22:02:27.021205 systemd[1]: Reached target cryptsetup-pre.target - Local Encrypted Volumes (Pre). Sep 1 22:02:27.024246 systemd[1]: Reached target cryptsetup.target - Local Encrypted Volumes. Sep 1 22:02:27.024294 systemd[1]: Reached target imports.target - Image Downloads. Sep 1 22:02:27.024306 systemd[1]: Stopped target initrd-switch-root.target - Switch Root. Sep 1 22:02:27.024313 systemd[1]: Stopped target initrd-fs.target - Initrd File Systems. Sep 1 22:02:27.024320 systemd[1]: Stopped target initrd-root-fs.target - Initrd Root File System. Sep 1 22:02:27.024327 systemd[1]: Reached target integritysetup.target - Local Integrity Protected Volumes. Sep 1 22:02:27.024334 systemd[1]: Reached target remote-cryptsetup.target - Remote Encrypted Volumes. Sep 1 22:02:27.024340 systemd[1]: Reached target remote-fs.target - Remote File Systems. Sep 1 22:02:27.024347 systemd[1]: Reached target remote-integritysetup.target - Remote Integrity Protected Volumes. Sep 1 22:02:27.024355 systemd[1]: Reached target remote-veritysetup.target - Remote Verity Protected Volumes. Sep 1 22:02:27.024362 systemd[1]: Reached target slices.target - Slice Units. Sep 1 22:02:27.024368 systemd[1]: Reached target swap.target - Swaps. Sep 1 22:02:27.024377 systemd[1]: Reached target veritysetup.target - Local Verity Protected Volumes. Sep 1 22:02:27.024383 systemd[1]: Listening on systemd-ask-password.socket - Query the User Interactively for a Password. Sep 1 22:02:27.024389 systemd[1]: Listening on systemd-coredump.socket - Process Core Dump Socket. Sep 1 22:02:27.024396 systemd[1]: Listening on systemd-creds.socket - Credential Encryption/Decryption. Sep 1 22:02:27.024403 systemd[1]: Listening on systemd-factory-reset.socket - Factory Reset Management. Sep 1 22:02:27.024409 systemd[1]: Listening on systemd-journald-audit.socket - Journal Audit Socket. Sep 1 22:02:27.024416 systemd[1]: Listening on systemd-mountfsd.socket - DDI File System Mounter Socket. Sep 1 22:02:27.024426 systemd[1]: Listening on systemd-mute-console.socket - Console Output Muting Service Socket. Sep 1 22:02:27.024433 systemd[1]: Listening on systemd-networkd-resolve-hook.socket - Network Management Resolve Hook Socket. Sep 1 22:02:27.024440 systemd[1]: Listening on systemd-networkd-varlink-metrics.socket - Network Management Metrics Varlink Socket. Sep 1 22:02:27.024446 systemd[1]: Listening on systemd-networkd-varlink.socket - Network Management Varlink Socket. Sep 1 22:02:27.024453 systemd[1]: Listening on systemd-networkd.socket - Network Management Netlink Socket. Sep 1 22:02:27.024460 systemd[1]: Listening on systemd-nsresourced.socket - Namespace Resource Manager Socket. Sep 1 22:02:27.024467 systemd[1]: Listening on systemd-oomd.socket - Userspace Out-Of-Memory (OOM) Killer Socket. Sep 1 22:02:27.024474 systemd[1]: Listening on systemd-repart.socket - Disk Repartitioning Service Socket. Sep 1 22:02:27.024480 systemd[1]: Listening on systemd-resolved-monitor.socket - Resolve Monitor Varlink Socket. Sep 1 22:02:27.024487 systemd[1]: Listening on systemd-resolved-varlink.socket - Resolve Service Varlink Socket. Sep 1 22:02:27.024493 systemd[1]: Listening on systemd-udevd-control.socket - udev Control Socket. Sep 1 22:02:27.024499 systemd[1]: Listening on systemd-udevd-varlink.socket - udev Varlink Socket. Sep 1 22:02:27.024506 systemd[1]: Listening on systemd-userdbd.socket - User Database Manager Socket. Sep 1 22:02:27.024513 systemd[1]: Mounting dev-hugepages.mount - Huge Pages File System... Sep 1 22:02:27.024520 systemd[1]: Mounting dev-mqueue.mount - POSIX Message Queue File System... Sep 1 22:02:27.024526 systemd[1]: Mounting media.mount - External Media Directory... Sep 1 22:02:27.024532 systemd[1]: Mounting sys-kernel-debug.mount - Kernel Debug File System... Sep 1 22:02:27.024538 systemd[1]: Mounting sys-kernel-tracing.mount - Kernel Trace File System... Sep 1 22:02:27.024547 systemd[1]: tmp.mount: x-systemd.graceful-option=usrquota specified, but option is not available, suppressing. Sep 1 22:02:27.024553 systemd[1]: Mounting tmp.mount - Temporary Directory /tmp... Sep 1 22:02:27.024560 systemd[1]: Starting flatcar-tmpfiles.service - Create missing system files... Sep 1 22:02:27.024567 systemd[1]: ignition-delete-config.service - Ignition (delete config) skipped, no trigger condition checks were met. Sep 1 22:02:27.024574 systemd[1]: Starting kmod-static-nodes.service - Create List of Static Device Nodes... Sep 1 22:02:27.024581 systemd[1]: Starting modprobe@configfs.service - Load Kernel Module configfs... Sep 1 22:02:27.024587 systemd[1]: Starting modprobe@drm.service - Load Kernel Module drm... Sep 1 22:02:27.024594 systemd[1]: Starting modprobe@efi_pstore.service - Load Kernel Module efi_pstore... Sep 1 22:02:27.024600 systemd[1]: Starting modprobe@fuse.service - Load Kernel Module fuse... Sep 1 22:02:27.024608 systemd[1]: setup-nsswitch.service - Create /etc/nsswitch.conf skipped, unmet condition check ConditionPathExists=!/etc/nsswitch.conf Sep 1 22:02:27.024614 systemd[1]: systemd-fsck-root.service: Deactivated successfully. Sep 1 22:02:27.024621 systemd[1]: Stopped systemd-fsck-root.service - File System Check on Root Device. Sep 1 22:02:27.024628 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 1 22:02:27.024634 systemd[1]: Starting systemd-journald.service - Journal Service... Sep 1 22:02:27.024641 systemd[1]: Starting systemd-modules-load.service - Load Kernel Modules... Sep 1 22:02:27.024648 systemd[1]: Starting systemd-network-generator.service - Generate Network Units from Kernel Command Line... Sep 1 22:02:27.024654 systemd[1]: Reached target time-set.target - System Time Set. Sep 1 22:02:27.024661 systemd[1]: Starting systemd-remount-fs.service - Remount Root and Kernel File Systems... Sep 1 22:02:27.024667 kernel: fuse: init (API version 7.45) Sep 1 22:02:27.024674 systemd[1]: Starting systemd-udev-load-credentials.service - Load udev Rules from Credentials... Sep 1 22:02:27.024680 systemd[1]: Starting systemd-udev-trigger.service - Coldplug All udev Devices... Sep 1 22:02:27.024687 systemd[1]: Mounted dev-hugepages.mount - Huge Pages File System. Sep 1 22:02:27.024727 systemd-journald[1851]: Collecting audit messages is enabled. Sep 1 22:02:27.024746 systemd[1]: Mounted dev-mqueue.mount - POSIX Message Queue File System. Sep 1 22:02:27.024760 systemd-journald[1851]: Journal started Sep 1 22:02:27.024776 systemd-journald[1851]: Runtime Journal (/run/log/journal/9ce53fe3d27c470385c7e46f2a242c75) is 8M, max 78.3M, 70.3M free. Sep 1 22:02:26.434000 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 1 22:02:26.877000 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 1 22:02:26.878000 audit: BPF prog-id=15 op=UNLOAD Sep 1 22:02:26.878000 audit: BPF prog-id=14 op=UNLOAD Sep 1 22:02:26.889000 audit: BPF prog-id=16 op=LOAD Sep 1 22:02:26.889000 audit: BPF prog-id=17 op=LOAD Sep 1 22:02:26.889000 audit: BPF prog-id=18 op=LOAD Sep 1 22:02:27.016000 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 1 22:02:27.016000 audit[1851]: SYSCALL arch=c00000b7 syscall=211 success=yes exit=60 a0=6 a1=ffffe0b341a0 a2=4000 a3=0 items=0 ppid=1 pid=1851 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 1 22:02:27.016000 audit: PROCTITLE proctitle="/usr/lib/systemd/systemd-journald" Sep 1 22:02:25.960295 systemd[1]: Queued start job for default target multi-user.target. Sep 1 22:02:26.014717 systemd[1]: Unnecessary job was removed for dev-sda6.device - /dev/sda6. Sep 1 22:02:26.018532 systemd[1]: systemd-journald.service: Deactivated successfully. Sep 1 22:02:26.073184 systemd[1]: systemd-journald.service: Consumed 2.610s CPU time over 15.607s wall clock time. Sep 1 22:02:26.957871 systemd-modules-load[1852]: Using 2 probe threads Sep 1 22:02:27.036237 kernel: ACPI: bus type drm_connector registered Sep 1 22:02:27.041996 systemd[1]: Started systemd-journald.service - Journal Service. Sep 1 22:02:27.048000 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 1 22:02:27.050585 systemd[1]: Mounted media.mount - External Media Directory. Sep 1 22:02:27.056374 systemd[1]: Mounted sys-kernel-debug.mount - Kernel Debug File System. Sep 1 22:02:27.063124 systemd[1]: Mounted sys-kernel-tracing.mount - Kernel Trace File System. Sep 1 22:02:27.071839 systemd[1]: Mounted tmp.mount - Temporary Directory /tmp. Sep 1 22:02:27.079972 systemd[1]: Finished kmod-static-nodes.service - Create List of Static Device Nodes. Sep 1 22:02:27.084000 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 1 22:02:27.086399 systemd[1]: modprobe@configfs.service: Deactivated successfully. Sep 1 22:02:27.086555 systemd[1]: Finished modprobe@configfs.service - Load Kernel Module configfs. Sep 1 22:02:27.090000 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 1 22:02:27.090000 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 1 22:02:27.092293 systemd[1]: modprobe@drm.service: Deactivated successfully. Sep 1 22:02:27.092444 systemd[1]: Finished modprobe@drm.service - Load Kernel Module drm. Sep 1 22:02:27.096000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=modprobe@drm comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Sep 1 22:02:27.096000 audit[1]: SERVICE_STOP pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=modprobe@drm comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Sep 1 22:02:27.098117 systemd[1]: modprobe@efi_pstore.service: Deactivated successfully. Sep 1 22:02:27.098342 systemd[1]: Finished modprobe@efi_pstore.service - Load Kernel Module efi_pstore. Sep 1 22:02:27.103000 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 1 22:02:27.103000 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 1 22:02:27.104817 systemd[1]: modprobe@fuse.service: Deactivated successfully. Sep 1 22:02:27.105052 systemd[1]: Finished modprobe@fuse.service - Load Kernel Module fuse. Sep 1 22:02:27.110755 systemd[1]: Finished systemd-modules-load.service - Load Kernel Modules. Sep 1 22:02:27.109000 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 1 22:02:27.109000 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 1 22:02:27.115000 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 1 22:02:27.116779 systemd[1]: Finished systemd-network-generator.service - Generate Network Units from Kernel Command Line. Sep 1 22:02:27.121000 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 1 22:02:27.124135 systemd[1]: Finished systemd-remount-fs.service - Remount Root and Kernel File Systems. Sep 1 22:02:27.128000 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 1 22:02:27.130455 systemd[1]: Finished systemd-udev-load-credentials.service - Load udev Rules from Credentials. Sep 1 22:02:27.134000 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 1 22:02:27.143097 systemd[1]: Reached target network-pre.target - Preparation for Network. Sep 1 22:02:27.150871 systemd[1]: Mounting sys-fs-fuse-connections.mount - FUSE Control File System... Sep 1 22:02:27.165874 systemd[1]: Mounting sys-kernel-config.mount - Kernel Configuration File System... Sep 1 22:02:27.173962 systemd[1]: remount-root.service - Remount Root File System skipped, unmet condition check ConditionPathIsReadWrite=!/ Sep 1 22:02:27.181334 systemd[1]: Starting systemd-hwdb-update.service - Rebuild Hardware Database... Sep 1 22:02:27.189323 systemd[1]: Starting systemd-journal-flush.service - Flush Journal to Persistent Storage... Sep 1 22:02:27.194546 systemd[1]: systemd-pstore.service - Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore Sep 1 22:02:27.196412 systemd[1]: Starting systemd-random-seed.service - Load/Save OS Random Seed... Sep 1 22:02:27.204330 systemd[1]: Starting systemd-sysctl.service - Apply Kernel Variables... Sep 1 22:02:27.212309 systemd[1]: Starting systemd-tmpfiles-setup-dev-early.service - Create Static Device Nodes in /dev gracefully... Sep 1 22:02:27.220463 systemd[1]: Finished systemd-udev-trigger.service - Coldplug All udev Devices. Sep 1 22:02:27.225000 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 1 22:02:27.227645 systemd[1]: Mounted sys-fs-fuse-connections.mount - FUSE Control File System. Sep 1 22:02:27.234293 systemd[1]: Mounted sys-kernel-config.mount - Kernel Configuration File System. Sep 1 22:02:27.240509 systemd[1]: Finished systemd-random-seed.service - Load/Save OS Random Seed. Sep 1 22:02:27.246000 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 1 22:02:27.249693 systemd[1]: Reached target first-boot-complete.target - First Boot Complete. Sep 1 22:02:27.258055 systemd-journald[1851]: Time spent on flushing to /var/log/journal/9ce53fe3d27c470385c7e46f2a242c75 is 12.417ms for 1156 entries. Sep 1 22:02:27.258055 systemd-journald[1851]: System Journal (/var/log/journal/9ce53fe3d27c470385c7e46f2a242c75) is 8M, max 2.2G, 2.2G free. Sep 1 22:02:27.270000 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 1 22:02:27.307011 systemd-journald[1851]: Received client request to flush runtime journal. Sep 1 22:02:27.266761 systemd[1]: Finished flatcar-tmpfiles.service - Create missing system files. Sep 1 22:02:27.308609 systemd[1]: Finished systemd-journal-flush.service - Flush Journal to Persistent Storage. Sep 1 22:02:27.313000 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 1 22:02:27.349372 systemd[1]: Finished systemd-sysctl.service - Apply Kernel Variables. Sep 1 22:02:27.352000 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 1 22:02:27.377318 systemd-tmpfiles[1903]: ACLs are not supported, ignoring. Sep 1 22:02:27.377330 systemd-tmpfiles[1903]: ACLs are not supported, ignoring. Sep 1 22:02:27.380345 systemd[1]: Finished systemd-tmpfiles-setup-dev-early.service - Create Static Device Nodes in /dev gracefully. Sep 1 22:02:27.384000 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 1 22:02:27.387130 systemd[1]: Starting systemd-sysusers.service - Create System Users... Sep 1 22:02:27.512327 systemd[1]: Finished systemd-sysusers.service - Create System Users. Sep 1 22:02:27.515000 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 1 22:02:27.519446 systemd[1]: Starting systemd-journalctl.socket - Journal Log Access Socket... Sep 1 22:02:27.527000 audit: BPF prog-id=19 op=LOAD Sep 1 22:02:27.527000 audit: BPF prog-id=20 op=LOAD Sep 1 22:02:27.527000 audit: BPF prog-id=21 op=LOAD Sep 1 22:02:27.531330 systemd[1]: Starting systemd-oomd.service - Userspace Out-Of-Memory (OOM) Killer... Sep 1 22:02:27.538000 audit: BPF prog-id=22 op=LOAD Sep 1 22:02:27.541434 systemd[1]: Starting systemd-resolved.service - Network Name Resolution... Sep 1 22:02:27.551367 systemd[1]: Starting systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev... Sep 1 22:02:27.559437 systemd[1]: Listening on systemd-journalctl.socket - Journal Log Access Socket. Sep 1 22:02:27.570088 systemd[1]: Starting modprobe@tun.service - Load Kernel Module tun... Sep 1 22:02:27.577797 systemd-tmpfiles[1919]: ACLs are not supported, ignoring. Sep 1 22:02:27.577815 systemd-tmpfiles[1919]: ACLs are not supported, ignoring. Sep 1 22:02:27.576000 audit: BPF prog-id=23 op=LOAD Sep 1 22:02:27.576000 audit: BPF prog-id=24 op=LOAD Sep 1 22:02:27.576000 audit: BPF prog-id=25 op=LOAD Sep 1 22:02:27.579652 systemd[1]: Starting systemd-userdbd.service - User Database Manager... Sep 1 22:02:27.587865 systemd[1]: Finished systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev. Sep 1 22:02:27.594000 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 1 22:02:27.596314 systemd[1]: Reached target local-fs-pre.target - Preparation for Local File Systems. Sep 1 22:02:27.601845 systemd[1]: systemd-repart.service - Repartition Root Disk skipped, no trigger condition checks were met. Sep 1 22:02:27.606597 systemd[1]: proc-sys-fs-binfmt_misc.automount: Got automount request for /proc/sys/fs/binfmt_misc, triggered by 1921 ((systemd-userd)) Sep 1 22:02:27.648715 kernel: tun: Universal TUN/TAP device driver, 1.6 Sep 1 22:02:27.649760 systemd[1]: modprobe@tun.service: Deactivated successfully. Sep 1 22:02:27.649990 systemd[1]: Finished modprobe@tun.service - Load Kernel Module tun. Sep 1 22:02:27.653000 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 1 22:02:27.653000 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 1 22:02:27.654000 audit: BPF prog-id=26 op=LOAD Sep 1 22:02:27.654000 audit: BPF prog-id=27 op=LOAD Sep 1 22:02:27.654000 audit: BPF prog-id=28 op=LOAD Sep 1 22:02:27.656356 systemd[1]: Starting systemd-nsresourced.service - Namespace Resource Manager... Sep 1 22:02:27.771381 systemd[1]: Finished systemd-hwdb-update.service - Rebuild Hardware Database. Sep 1 22:02:27.775000 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 1 22:02:27.775000 audit: BPF prog-id=7 op=UNLOAD Sep 1 22:02:27.775000 audit: BPF prog-id=6 op=UNLOAD Sep 1 22:02:27.776000 audit: BPF prog-id=29 op=LOAD Sep 1 22:02:27.776000 audit: BPF prog-id=30 op=LOAD Sep 1 22:02:27.778145 systemd[1]: Starting systemd-udevd.service - Rule-based Manager for Device Events and Files... Sep 1 22:02:28.034204 systemd-udevd[1926]: Using default interface naming scheme 'v260'. Sep 1 22:02:28.124994 systemd[1]: Mounting proc-sys-fs-binfmt_misc.mount - Arbitrary Executable File Formats File System... Sep 1 22:02:28.130275 systemd[1]: var-lib-machines.mount - Virtual Machine and Container Storage (Compatibility) skipped, unmet condition check ConditionPathExists=/var/lib/machines.raw Sep 1 22:02:28.130390 systemd[1]: Reached target local-fs.target - Local File Systems. Sep 1 22:02:28.134796 systemd[1]: Reached target machines.target - Virtual Machines and Containers. Sep 1 22:02:28.140487 systemd[1]: Listening on systemd-importd.socket - Disk Image Download Service Socket. Sep 1 22:02:28.147025 systemd[1]: Listening on systemd-sysext.socket - System Extension Image Management. Sep 1 22:02:28.154889 systemd[1]: Starting systemd-confext.service - Merge System Configuration Images into /etc/... Sep 1 22:02:28.164501 systemd[1]: Starting systemd-machine-id-commit.service - Save Transient machine-id to Disk... Sep 1 22:02:28.170825 systemd[1]: Starting systemd-userdb-load-credentials.service - Load JSON user/group Records from Credentials... Sep 1 22:02:28.181985 systemd[1]: Mounted proc-sys-fs-binfmt_misc.mount - Arbitrary Executable File Formats File System. Sep 1 22:02:28.189808 systemd[1]: systemd-binfmt.service - Set Up Additional Binary Formats skipped, no trigger condition checks were met. Sep 1 22:02:28.203426 systemd[1]: Finished systemd-userdb-load-credentials.service - Load JSON user/group Records from Credentials. Sep 1 22:02:28.208000 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 1 22:02:28.258259 systemd[1]: Started systemd-userdbd.service - User Database Manager. Sep 1 22:02:28.262390 systemd-nsresourced[1924]: Not setting up BPF subsystem, as functionality has been disabled at compile time. Sep 1 22:02:28.267000 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 1 22:02:28.270108 systemd[1]: Started systemd-nsresourced.service - Namespace Resource Manager. Sep 1 22:02:28.275191 kernel: loop4: detected capacity change from 0 to 44096 Sep 1 22:02:28.276279 kernel: loop4: p1 p2 p3 Sep 1 22:02:28.275000 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 1 22:02:28.289430 systemd[1]: etc-machine\x2did.mount: Deactivated successfully. Sep 1 22:02:28.293651 systemd[1]: Finished systemd-machine-id-commit.service - Save Transient machine-id to Disk. Sep 1 22:02:28.300000 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 1 22:02:28.325229 kernel: device-mapper: verity: sha256 using "sha256-lib" Sep 1 22:02:28.325349 kernel: device-mapper: verity: Unrecognized verity feature request: root_hash_sig_key_desc Sep 1 22:02:28.327712 kernel: device-mapper: table: 254:5: verity: Unrecognized verity feature request (-EINVAL) Sep 1 22:02:28.335223 kernel: device-mapper: ioctl: error adding target to table Sep 1 22:02:28.336487 systemd-confext[1933]: device-mapper: reload ioctl on loop4p1-53-verity (254:5) failed: Invalid argument Sep 1 22:02:28.346229 kernel: device-mapper: verity: sha256 using "sha256-lib" Sep 1 22:02:28.362115 systemd-oomd[1917]: No swap; memory pressure usage will be degraded Sep 1 22:02:28.363245 systemd[1]: Started systemd-oomd.service - Userspace Out-Of-Memory (OOM) Killer. Sep 1 22:02:28.367000 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 1 22:02:28.382078 systemd-resolved[1918]: Positive Trust Anchors: Sep 1 22:02:28.382440 systemd-resolved[1918]: . IN DS 20326 8 2 e06d44b80b8f1d39a95c0b0d7c65d08458e880409bbc683457104237c7f8ec8d Sep 1 22:02:28.382447 systemd-resolved[1918]: . IN DS 38696 8 2 683d2d0acb8c9b712a1948b27f741219298d0a450d612c483af444a4c0fb2b16 Sep 1 22:02:28.382468 systemd-resolved[1918]: 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 1 22:02:28.402371 systemd[1]: Started systemd-udevd.service - Rule-based Manager for Device Events and Files. Sep 1 22:02:28.406000 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 1 22:02:28.408000 audit: BPF prog-id=31 op=LOAD Sep 1 22:02:28.411326 systemd[1]: Starting systemd-networkd.service - Network Management... Sep 1 22:02:28.425333 systemd-resolved[1918]: Using system hostname 'ci-9999.9.9-l-c95d858d68'. Sep 1 22:02:28.428196 systemd[1]: Started systemd-resolved.service - Network Name Resolution. Sep 1 22:02:28.437235 systemd[1]: Reached target nss-lookup.target - Host and Network Name Lookups. Sep 1 22:02:28.435000 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 1 22:02:28.520017 systemd[1]: Condition check resulted in dev-ttyAMA0.device - /dev/ttyAMA0 being skipped. Sep 1 22:02:28.522242 systemd-networkd[1956]: lo: Link UP Sep 1 22:02:28.522519 systemd-networkd[1956]: lo: Gained carrier Sep 1 22:02:28.523578 systemd[1]: Started systemd-networkd.service - Network Management. Sep 1 22:02:28.530000 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 1 22:02:28.533678 systemd[1]: Reached target network.target - Network. Sep 1 22:02:28.539783 systemd-networkd[1956]: eth0: Found matching .network file, based on potentially unpredictable interface name: /usr/lib/systemd/network/zz-default.network Sep 1 22:02:28.539791 systemd-networkd[1956]: eth0: Configuring with /usr/lib/systemd/network/zz-default.network. Sep 1 22:02:28.541575 systemd[1]: Starting systemd-networkd-persistent-storage.service - Enable Persistent Storage in systemd-networkd... Sep 1 22:02:28.550441 systemd[1]: Starting systemd-networkd-wait-online.service - Wait for Network to be Online... Sep 1 22:02:28.595327 kernel: hv_storvsc f8b3781a-1e82-4818-a1c3-63d806ec15bb: tag#8 cmd 0x85 status: scsi 0x2 srb 0x6 host 0xc0000001 Sep 1 22:02:28.602762 kernel: mlx5_core 6bbd:00:02.0 enP27581s1: Link up Sep 1 22:02:28.619468 kernel: mousedev: PS/2 mouse device common for all mice Sep 1 22:02:28.620851 systemd-networkd[1956]: enP27581s1: Link UP Sep 1 22:02:28.625715 kernel: hv_netvsc 7ced8dc7-e335-7ced-8dc7-e3357ced8dc7 eth0: Data path switched to VF: enP27581s1 Sep 1 22:02:28.620922 systemd-networkd[1956]: eth0: Link UP Sep 1 22:02:28.620925 systemd-networkd[1956]: eth0: Gained carrier Sep 1 22:02:28.620946 systemd-networkd[1956]: eth0: Found matching .network file, based on potentially unpredictable interface name: /usr/lib/systemd/network/zz-default.network Sep 1 22:02:28.634525 systemd-networkd[1956]: enP27581s1: Gained carrier Sep 1 22:02:28.638658 systemd[1]: Finished systemd-networkd-persistent-storage.service - Enable Persistent Storage in systemd-networkd. Sep 1 22:02:28.645467 systemd-networkd[1956]: eth0: DHCPv4 address 10.0.0.4/24, gateway 10.0.0.1 acquired from 168.63.129.16 Sep 1 22:02:28.646000 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 1 22:02:28.673236 kernel: hv_vmbus: registering driver hv_balloon Sep 1 22:02:28.673350 kernel: hv_balloon: Using Dynamic Memory protocol version 2.0 Sep 1 22:02:28.673372 kernel: hv_balloon: Memory hot add disabled on ARM64 Sep 1 22:02:28.712644 systemd[1]: Condition check resulted in dev-ptp_hyperv.device - /dev/ptp_hyperv being skipped. Sep 1 22:02:28.723580 kernel: hyperv_fb: Deprecated: use Hyper-V DRM driver instead Sep 1 22:02:28.723671 kernel: hv_vmbus: registering driver hyperv_fb Sep 1 22:02:28.728227 kernel: hyperv_fb: Synthvid Version major 3, minor 5 Sep 1 22:02:28.728576 kernel: hyperv_fb: Screen resolution: 1024x768, Color depth: 32, Frame buffer size: 8388608 Sep 1 22:02:28.731242 kernel: Console: switching to colour dummy device 80x25 Sep 1 22:02:28.735636 kernel: Console: switching to colour frame buffer device 128x48 Sep 1 22:02:28.753205 systemd[1]: Starting systemd-vconsole-setup.service - Virtual Console Setup... Sep 1 22:02:28.803314 kernel: MACsec IEEE 802.1AE Sep 1 22:02:28.847960 systemd[1]: Found device dev-disk-by\x2dlabel-OEM.device - Virtual_Disk OEM. Sep 1 22:02:28.869238 systemd[1]: Starting systemd-fsck@dev-disk-by\x2dlabel-OEM.service - File System Check on /dev/disk/by-label/OEM... Sep 1 22:02:28.898267 kernel: erofs (device dm-5): mounted with root inode @ nid 40. Sep 1 22:02:28.912952 systemd[1]: systemd-vconsole-setup.service: Deactivated successfully. Sep 1 22:02:28.913392 systemd[1]: Stopped systemd-vconsole-setup.service - Virtual Console Setup. Sep 1 22:02:28.918000 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 1 22:02:28.918000 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 1 22:02:28.924346 systemd[1]: Starting systemd-vconsole-setup.service - Virtual Console Setup... Sep 1 22:02:28.947140 systemd[1]: Finished systemd-fsck@dev-disk-by\x2dlabel-OEM.service - File System Check on /dev/disk/by-label/OEM. Sep 1 22:02:28.953406 kernel: loop4: detected capacity change from 0 to 44096 Sep 1 22:02:28.952000 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 1 22:02:28.958294 kernel: loop4: p1 p2 p3 Sep 1 22:02:28.963402 (sd-merge)[2088]: device-mapper: reload ioctl on loop4p1-58-verity (254:5) failed: Invalid argument Sep 1 22:02:28.964680 kernel: device-mapper: verity: sha256 using "sha256-lib" Sep 1 22:02:28.964749 kernel: device-mapper: verity: Unrecognized verity feature request: root_hash_sig_key_desc Sep 1 22:02:28.964776 kernel: device-mapper: table: 254:5: verity: Unrecognized verity feature request (-EINVAL) Sep 1 22:02:28.964794 kernel: device-mapper: ioctl: error adding target to table Sep 1 22:02:28.967250 kernel: device-mapper: verity: sha256 using "sha256-lib" Sep 1 22:02:29.000796 (sd-merge)[2088]: Skipping extension refresh because no change was found, use --always-refresh=yes to always do a refresh. Sep 1 22:02:29.001303 kernel: erofs (device dm-5): mounted with root inode @ nid 40. Sep 1 22:02:29.006380 systemd[1]: Finished systemd-confext.service - Merge System Configuration Images into /etc/. Sep 1 22:02:29.011000 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 1 22:02:29.013938 systemd[1]: Starting systemd-sysext.service - Merge System Extension Images into /usr/ and /opt/... Sep 1 22:02:29.033235 kernel: loop4: detected capacity change from 0 to 140944 Sep 1 22:02:29.033329 kernel: loop4: p1 p2 p3 Sep 1 22:02:29.040041 systemd-sysext[2096]: device-mapper: reload ioctl on loop4p1-62-verity (254:5) failed: Invalid argument Sep 1 22:02:29.040397 kernel: device-mapper: verity: sha256 using "sha256-lib" Sep 1 22:02:29.040439 kernel: device-mapper: verity: Unrecognized verity feature request: root_hash_sig_key_desc Sep 1 22:02:29.040454 kernel: device-mapper: table: 254:5: verity: Unrecognized verity feature request (-EINVAL) Sep 1 22:02:29.040469 kernel: device-mapper: ioctl: error adding target to table Sep 1 22:02:29.044255 kernel: device-mapper: verity: sha256 using "sha256-lib" Sep 1 22:02:29.078305 kernel: erofs (device dm-5): mounted with root inode @ nid 39. Sep 1 22:02:29.099321 kernel: loop4: detected capacity change from 0 to 158496 Sep 1 22:02:29.109656 kernel: loop4: p1 p2 p3 Sep 1 22:02:29.115901 systemd-sysext[2096]: device-mapper: reload ioctl on loop4p1-67-verity (254:5) failed: Invalid argument Sep 1 22:02:29.116252 kernel: device-mapper: verity: sha256 using "sha256-lib" Sep 1 22:02:29.116287 kernel: device-mapper: verity: Unrecognized verity feature request: root_hash_sig_key_desc Sep 1 22:02:29.116322 kernel: device-mapper: table: 254:5: verity: Unrecognized verity feature request (-EINVAL) Sep 1 22:02:29.116336 kernel: device-mapper: ioctl: error adding target to table Sep 1 22:02:29.121242 kernel: device-mapper: verity: sha256 using "sha256-lib" Sep 1 22:02:29.150422 kernel: erofs (device dm-5): mounted with root inode @ nid 39. Sep 1 22:02:29.181319 kernel: loop4: detected capacity change from 0 to 388472 Sep 1 22:02:29.185245 kernel: loop4: p1 p2 p3 Sep 1 22:02:29.195011 kernel: device-mapper: verity: sha256 using "sha256-lib" Sep 1 22:02:29.195110 kernel: device-mapper: verity: Unrecognized verity feature request: root_hash_sig_key_desc Sep 1 22:02:29.200315 kernel: device-mapper: table: 254:5: verity: Unrecognized verity feature request (-EINVAL) Sep 1 22:02:29.205867 kernel: device-mapper: ioctl: error adding target to table Sep 1 22:02:29.206274 systemd-sysext[2096]: device-mapper: reload ioctl on loop4p1-72-verity (254:5) failed: Invalid argument Sep 1 22:02:29.209240 kernel: device-mapper: verity: sha256 using "sha256-lib" Sep 1 22:02:29.230267 kernel: erofs (device dm-5): mounted with root inode @ nid 39. Sep 1 22:02:29.262102 kernel: loop4: detected capacity change from 0 to 140944 Sep 1 22:02:29.262171 kernel: loop4: p1 p2 p3 Sep 1 22:02:29.270007 (sd-merge)[2120]: device-mapper: reload ioctl on loop4p1-77-verity (254:5) failed: Invalid argument Sep 1 22:02:29.271560 kernel: device-mapper: verity: sha256 using "sha256-lib" Sep 1 22:02:29.271586 kernel: device-mapper: verity: Unrecognized verity feature request: root_hash_sig_key_desc Sep 1 22:02:29.271609 kernel: device-mapper: table: 254:5: verity: Unrecognized verity feature request (-EINVAL) Sep 1 22:02:29.271626 kernel: device-mapper: ioctl: error adding target to table Sep 1 22:02:29.277312 kernel: device-mapper: verity: sha256 using "sha256-lib" Sep 1 22:02:29.291305 systemd-vconsole-setup[2086]: Configuration of first virtual console was skipped, ignoring remaining ones. Sep 1 22:02:29.297352 systemd[1]: Finished systemd-vconsole-setup.service - Virtual Console Setup. Sep 1 22:02:29.302000 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 1 22:02:29.313247 kernel: erofs (device dm-5): mounted with root inode @ nid 39. Sep 1 22:02:29.319851 kernel: loop5: detected capacity change from 0 to 158496 Sep 1 22:02:29.322848 kernel: loop5: p1 p2 p3 Sep 1 22:02:29.326906 (sd-merge)[2120]: device-mapper: reload ioctl on loop5p1-81-verity (254:6) failed: Invalid argument Sep 1 22:02:29.329907 kernel: device-mapper: verity: sha256 using "sha256-lib" Sep 1 22:02:29.329929 kernel: device-mapper: verity: Unrecognized verity feature request: root_hash_sig_key_desc Sep 1 22:02:29.329944 kernel: device-mapper: table: 254:6: verity: Unrecognized verity feature request (-EINVAL) Sep 1 22:02:29.329956 kernel: device-mapper: ioctl: error adding target to table Sep 1 22:02:29.334241 kernel: device-mapper: verity: sha256 using "sha256-lib" Sep 1 22:02:29.369958 kernel: erofs (device dm-6): mounted with root inode @ nid 39. Sep 1 22:02:29.370070 kernel: loop6: detected capacity change from 0 to 388472 Sep 1 22:02:29.384242 kernel: loop6: p1 p2 p3 Sep 1 22:02:29.390367 kernel: device-mapper: verity: sha256 using "sha256-lib" Sep 1 22:02:29.390441 kernel: device-mapper: verity: Unrecognized verity feature request: root_hash_sig_key_desc Sep 1 22:02:29.390485 kernel: device-mapper: table: 254:7: verity: Unrecognized verity feature request (-EINVAL) Sep 1 22:02:29.390733 (sd-merge)[2120]: device-mapper: reload ioctl on loop6p1-85-verity (254:7) failed: Invalid argument Sep 1 22:02:29.391248 kernel: device-mapper: ioctl: error adding target to table Sep 1 22:02:29.395249 kernel: device-mapper: verity: sha256 using "sha256-lib" Sep 1 22:02:29.422256 kernel: erofs (device dm-7): mounted with root inode @ nid 39. Sep 1 22:02:29.425940 (sd-merge)[2120]: Skipping extension refresh because no change was found, use --always-refresh=yes to always do a refresh. Sep 1 22:02:29.429001 systemd[1]: Finished systemd-sysext.service - Merge System Extension Images into /usr/ and /opt/. Sep 1 22:02:29.433000 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 1 22:02:29.436167 systemd[1]: Starting systemd-tmpfiles-setup.service - Create System Files and Directories... Sep 1 22:02:29.487901 systemd-tmpfiles[2144]: /usr/lib/tmpfiles.d/nfs-utils.conf:6: Duplicate line for path "/var/lib/nfs/sm", ignoring. Sep 1 22:02:29.487956 systemd-tmpfiles[2144]: /usr/lib/tmpfiles.d/nfs-utils.conf:7: Duplicate line for path "/var/lib/nfs/sm.bak", ignoring. Sep 1 22:02:29.488173 systemd-tmpfiles[2144]: /usr/lib/tmpfiles.d/provision.conf:20: Duplicate line for path "/root", ignoring. Sep 1 22:02:29.488850 systemd-tmpfiles[2144]: ACLs are not supported, ignoring. Sep 1 22:02:29.488890 systemd-tmpfiles[2144]: ACLs are not supported, ignoring. Sep 1 22:02:29.505904 systemd-tmpfiles[2144]: Detected autofs mount point '/boot' during canonicalization of 'boot'. Sep 1 22:02:29.505917 systemd-tmpfiles[2144]: Skipping /boot Sep 1 22:02:29.510740 systemd-tmpfiles[2144]: Detected autofs mount point '/boot' during canonicalization of 'boot'. Sep 1 22:02:29.510759 systemd-tmpfiles[2144]: Skipping /boot Sep 1 22:02:29.518785 systemd[1]: Finished systemd-tmpfiles-setup.service - Create System Files and Directories. Sep 1 22:02:29.524000 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 1 22:02:29.529119 systemd[1]: Starting audit-rules.service - Load Audit Rules... Sep 1 22:02:29.542334 systemd[1]: Starting clean-ca-certificates.service - Clean up broken links in /etc/ssl/certs... Sep 1 22:02:29.553099 systemd[1]: Starting ldconfig.service - Rebuild Dynamic Linker Cache... Sep 1 22:02:29.561318 systemd[1]: Starting systemd-journal-catalog-update.service - Rebuild Journal Catalog... Sep 1 22:02:29.568316 systemd[1]: Starting systemd-update-utmp.service - Record System Boot/Shutdown in UTMP... Sep 1 22:02:29.595000 audit[2153]: AUDIT1127 pid=2153 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 1 22:02:29.598864 systemd[1]: Finished systemd-update-utmp.service - Record System Boot/Shutdown in UTMP. Sep 1 22:02:29.604000 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 1 22:02:29.671425 systemd[1]: Finished systemd-journal-catalog-update.service - Rebuild Journal Catalog. Sep 1 22:02:29.676000 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 1 22:02:29.740000 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 1 22:02:29.740000 audit[2177]: SYSCALL arch=c00000b7 syscall=206 success=yes exit=1056 a0=3 a1=fffff66f5920 a2=420 a3=0 items=0 ppid=2149 pid=2177 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 1 22:02:29.740000 audit: PROCTITLE proctitle=2F7362696E2F617564697463746C002D52002F6574632F61756469742F61756469742E72756C6573 Sep 1 22:02:29.741718 augenrules[2177]: No rules Sep 1 22:02:29.742660 systemd[1]: audit-rules.service: Deactivated successfully. Sep 1 22:02:29.743423 systemd[1]: Finished audit-rules.service - Load Audit Rules. Sep 1 22:02:29.873558 systemd[1]: Finished clean-ca-certificates.service - Clean up broken links in /etc/ssl/certs. Sep 1 22:02:29.879714 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 1 22:02:30.620375 systemd-networkd[1956]: eth0: Gained IPv6LL Sep 1 22:02:30.622608 systemd[1]: Finished systemd-networkd-wait-online.service - Wait for Network to be Online. Sep 1 22:02:30.627885 systemd[1]: Reached target network-online.target - Network is Online. Sep 1 22:02:34.756501 ldconfig[2151]: ldconfig: /usr/lib/ld.so.conf is not an ELF file - it has the wrong magic bytes at the start. Sep 1 22:02:34.776607 systemd[1]: Finished ldconfig.service - Rebuild Dynamic Linker Cache. Sep 1 22:02:34.783199 systemd[1]: Starting systemd-update-done.service - Update is Completed... Sep 1 22:02:34.800581 systemd[1]: Finished systemd-update-done.service - Update is Completed. Sep 1 22:02:34.805804 systemd[1]: Reached target sysinit.target - System Initialization. Sep 1 22:02:34.810298 systemd[1]: Started motdgen.path - Watch for update engine configuration changes. Sep 1 22:02:34.815102 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 1 22:02:34.820436 systemd[1]: Started logrotate.timer - Daily rotation of log files. Sep 1 22:02:34.824711 systemd[1]: Started mdadm.timer - Weekly check for MD array's redundancy information.. Sep 1 22:02:34.828965 systemd[1]: Started systemd-sysupdate-reboot.timer - Reboot Automatically After System Update. Sep 1 22:02:34.833923 systemd[1]: Started systemd-sysupdate.timer - Automatic System Update. Sep 1 22:02:34.838448 systemd[1]: Started systemd-tmpfiles-clean.timer - Daily Cleanup of Temporary Directories. Sep 1 22:02:34.843514 systemd[1]: update-engine-stub.timer - Update Engine Stub Timer skipped, unmet condition check ConditionPathExists=/usr/.noupdate Sep 1 22:02:34.843548 systemd[1]: Reached target paths.target - Path Units. Sep 1 22:02:34.847050 systemd[1]: Reached target timers.target - Timer Units. Sep 1 22:02:34.851926 systemd[1]: Listening on dbus.socket - D-Bus System Message Bus Socket. Sep 1 22:02:34.857706 systemd[1]: Starting docker.socket - Docker Socket for the API... Sep 1 22:02:34.863008 systemd[1]: Listening on sshd-unix-local.socket - OpenSSH Server Socket (systemd-ssh-generator, AF_UNIX Local). Sep 1 22:02:34.869755 systemd[1]: Listening on sshd.socket - OpenSSH Server Socket. Sep 1 22:02:34.874242 systemd[1]: Listening on systemd-hostnamed.socket - Hostname Service Socket. Sep 1 22:02:34.879665 systemd[1]: Listening on systemd-logind-varlink.socket - User Login Management Varlink Socket. Sep 1 22:02:34.885186 systemd[1]: Listening on systemd-machined.socket - Virtual Machine and Container Registration Service Socket. Sep 1 22:02:34.890918 systemd[1]: Listening on docker.socket - Docker Socket for the API. Sep 1 22:02:34.895401 systemd[1]: Reached target sockets.target - Socket Units. Sep 1 22:02:34.899428 systemd[1]: Reached target basic.target - Basic System. Sep 1 22:02:34.903473 systemd[1]: addon-config@oem.service - Configure Addon /oem skipped, no trigger condition checks were met. Sep 1 22:02:34.903502 systemd[1]: addon-run@oem.service - Run Addon /oem skipped, no trigger condition checks were met. Sep 1 22:02:34.905464 systemd[1]: Starting chronyd.service - NTP client/server... Sep 1 22:02:34.921329 systemd[1]: Starting containerd.service - containerd container runtime... Sep 1 22:02:34.927318 systemd[1]: Starting dbus.service - D-Bus System Message Bus... Sep 1 22:02:34.935906 systemd[1]: Starting dracut-shutdown.service - Restore /run/initramfs on shutdown... Sep 1 22:02:34.944363 systemd[1]: Starting enable-oem-cloudinit.service - Enable cloudinit... Sep 1 22:02:34.952701 systemd[1]: Starting extend-filesystems.service - Extend Filesystems... Sep 1 22:02:34.955283 chronyd[2193]: chronyd version 4.8 starting (+CMDMON +REFCLOCK +RTC +PRIVDROP +SCFILTER -SIGND +NTS +SECHASH +IPV6 -DEBUG) Sep 1 22:02:34.957660 systemd[1]: flatcar-setup-environment.service - Modifies /etc/environment for CoreOS skipped, unmet condition check ConditionPathExists=/oem/bin/flatcar-setup-environment Sep 1 22:02:34.960373 systemd[1]: Started hv_kvp_daemon.service - Hyper-V KVP daemon. Sep 1 22:02:34.964861 systemd[1]: hv_vss_daemon.service - Hyper-V VSS daemon skipped, unmet condition check ConditionPathExists=/dev/vmbus/hv_vss Sep 1 22:02:34.968346 jq[2197]: true Sep 1 22:02:34.969410 systemd[1]: Starting motdgen.service - Generate /run/flatcar/motd... Sep 1 22:02:34.977102 systemd[1]: Starting nvidia.service - NVIDIA Configure Service... Sep 1 22:02:34.981904 KVP[2199]: KVP starting; pid is:2199 Sep 1 22:02:34.984059 systemd[1]: Starting ssh-key-proc-cmdline.service - Install an ssh key from /proc/cmdline... Sep 1 22:02:34.989486 KVP[2199]: KVP LIC Version: 3.1 Sep 1 22:02:34.991795 kernel: hv_utils: KVP IC version 4.0 Sep 1 22:02:34.994982 systemd[1]: Starting sshd-keygen.service - Generate sshd host keys... Sep 1 22:02:35.004454 systemd[1]: Starting systemd-logind.service - User Login Management... Sep 1 22:02:35.009512 systemd[1]: tcsd.service - TCG Core Services Daemon skipped, unmet condition check ConditionPathExists=/dev/tpm0 Sep 1 22:02:35.012819 systemd[1]: Starting update-engine.service - Update Engine... Sep 1 22:02:35.016761 extend-filesystems[2198]: Found /dev/sda6 Sep 1 22:02:35.021125 systemd[1]: Starting update-ssh-keys-after-ignition.service - Run update-ssh-keys once after Ignition... Sep 1 22:02:35.022504 chronyd[2193]: Timezone right/UTC failed leap second check, ignoring Sep 1 22:02:35.022683 chronyd[2193]: Loaded seccomp filter (level 2) Sep 1 22:02:35.029061 motdgen[2219]: /oem/oem-release: line 2: Azure: command not found Sep 1 22:02:35.031685 systemd[1]: Started chronyd.service - NTP client/server. Sep 1 22:02:35.041803 systemd[1]: Finished dracut-shutdown.service - Restore /run/initramfs on shutdown. Sep 1 22:02:35.049690 systemd[1]: motdgen.service: Deactivated successfully. Sep 1 22:02:35.049887 systemd[1]: Finished motdgen.service - Generate /run/flatcar/motd. Sep 1 22:02:35.057474 systemd[1]: ssh-key-proc-cmdline.service: Deactivated successfully. Sep 1 22:02:35.057700 systemd[1]: Finished ssh-key-proc-cmdline.service - Install an ssh key from /proc/cmdline. Sep 1 22:02:35.063390 jq[2216]: false Sep 1 22:02:35.067230 extend-filesystems[2198]: Found /dev/sda9 Sep 1 22:02:35.065832 systemd[1]: update-ssh-keys-after-ignition.service: Skipped due to 'exec-condition'. Sep 1 22:02:35.066396 systemd[1]: Condition check resulted in update-ssh-keys-after-ignition.service - Run update-ssh-keys once after Ignition being skipped. Sep 1 22:02:35.075964 systemd[1]: sshkeys.service skipped, no trigger condition checks were met. Sep 1 22:02:35.078044 extend-filesystems[2198]: Checking size of /dev/sda9 Sep 1 22:02:35.085582 systemd[1]: Finished nvidia.service - NVIDIA Configure Service. Sep 1 22:02:35.087400 jq[2230]: true Sep 1 22:02:35.113371 systemctl[2248]: Created symlink '/etc/systemd/system/multi-user.target.wants/oem-cloudinit.service' → '/usr/lib/systemd/system/oem-cloudinit.service'. Sep 1 22:02:35.113755 systemd[1]: Reload requested from client PID 2248 ('systemctl') (unit enable-oem-cloudinit.service)... Sep 1 22:02:35.113767 systemd[1]: Reloading... Sep 1 22:02:35.124434 update_engine[2211]: I20260901 22:02:35.124357 2211 main.cc:92] Flatcar Update Engine starting Sep 1 22:02:35.128041 extend-filesystems[2198]: Resized partition /dev/sda9 Sep 1 22:02:35.145825 extend-filesystems[2270]: resize2fs 1.47.4 (6-Mar-2025) Sep 1 22:02:35.193653 kernel: EXT4-fs (sda9): resizing filesystem from 6359552 to 6376955 blocks Sep 1 22:02:35.177314 systemd-logind[2209]: New seat seat0. Sep 1 22:02:35.193950 kernel: EXT4-fs (sda9): resized filesystem to 6376955 Sep 1 22:02:35.195111 systemd-logind[2209]: Watching system buttons on /dev/input/event0 (AT Translated Set 2 keyboard) Sep 1 22:02:35.213237 extend-filesystems[2270]: Filesystem at /dev/sda9 is mounted on /; on-line resizing required Sep 1 22:02:35.213237 extend-filesystems[2270]: old_desc_blocks = 4, new_desc_blocks = 4 Sep 1 22:02:35.213237 extend-filesystems[2270]: The filesystem on /dev/sda9 is now 6376955 (4k) blocks long. Sep 1 22:02:35.281389 zram_generator::config[2319]: No configuration found. Sep 1 22:02:35.279857 dbus-daemon[2195]: [system] SELinux support is enabled Sep 1 22:02:35.281639 extend-filesystems[2198]: Resized filesystem in /dev/sda9 Sep 1 22:02:35.305790 update_engine[2211]: I20260901 22:02:35.305653 2211 update_check_scheduler.cc:74] Next update check in 3m43s Sep 1 22:02:35.643953 systemd[1]: Reloading finished in 529 ms. Sep 1 22:02:35.658831 systemd[1]: Started systemd-logind.service - User Login Management. Sep 1 22:02:35.664396 systemd[1]: Started dbus.service - D-Bus System Message Bus. Sep 1 22:02:35.673515 dbus-daemon[2195]: [system] Successfully activated service 'org.freedesktop.systemd1' Sep 1 22:02:35.674735 systemd[1]: extend-filesystems.service: Deactivated successfully. Sep 1 22:02:35.675087 systemd[1]: Finished extend-filesystems.service - Extend Filesystems. Sep 1 22:02:35.707097 systemd[1]: Started update-engine.service - Update Engine. Sep 1 22:02:35.715371 systemd[1]: Starting oem-cloudinit.service - Run cloudinit... Sep 1 22:02:35.720576 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 1 22:02:35.720772 systemd[1]: Reached target system-config.target - Load system-provided cloud configs. Sep 1 22:02:35.729535 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 1 22:02:35.730362 systemd[1]: Reached target user-config.target - Load user-provided cloud configs. Sep 1 22:02:35.740440 systemd[1]: Started locksmithd.service - Cluster reboot manager. Sep 1 22:02:35.744902 bash[2430]: + OEMS=(aws gcp azure cloudsigma vmware digitalocean openstack) Sep 1 22:02:35.745130 bash[2432]: + echo aws gcp azure cloudsigma vmware digitalocean openstack Sep 1 22:02:35.745270 bash[2433]: + tr ' ' $'\n' Sep 1 22:02:35.745376 bash[2434]: + grep -q -x -F azure Sep 1 22:02:35.768070 bash[2438]: ++ '[' azure = aws -o azure = openstack ']' Sep 1 22:02:35.768070 bash[2438]: ++ '[' azure = gcp ']' Sep 1 22:02:35.768070 bash[2438]: ++ echo azure Sep 1 22:02:35.768616 bash[2435]: + /usr/bin/coreos-cloudinit --oem=azure Sep 1 22:02:35.912761 sshd_keygen[2231]: ssh-keygen: generating new host keys: RSA ECDSA ED25519 MLDSA44-ED25519 Sep 1 22:02:35.931449 locksmithd[2431]: locksmithd starting currentOperation="UPDATE_STATUS_IDLE" strategy="reboot" Sep 1 22:02:35.935915 systemd[1]: Finished sshd-keygen.service - Generate sshd host keys. Sep 1 22:02:35.945873 systemd[1]: Starting issuegen.service - Generate /run/issue... Sep 1 22:02:35.956326 systemd[1]: Starting waagent.service - Microsoft Azure Linux Agent... Sep 1 22:02:35.967469 systemd[1]: issuegen.service: Deactivated successfully. Sep 1 22:02:35.967751 systemd[1]: Finished issuegen.service - Generate /run/issue. Sep 1 22:02:35.975897 bash[2435]: 2026/09/01 22:02:35 Checking availability of "waagent" Sep 1 22:02:35.979493 systemd[1]: Starting systemd-user-sessions.service - Permit User Sessions... Sep 1 22:02:35.998587 systemd[1]: Finished systemd-user-sessions.service - Permit User Sessions. Sep 1 22:02:36.007493 systemd[1]: Started waagent.service - Microsoft Azure Linux Agent. Sep 1 22:02:36.019402 systemd[1]: Started getty@tty1.service - Getty on tty1. Sep 1 22:02:36.025518 systemd[1]: Started serial-getty@ttyAMA0.service - Serial Getty on ttyAMA0. Sep 1 22:02:36.031597 systemd[1]: Reached target getty.target - Login Prompts. Sep 1 22:02:36.075648 bash[2435]: 2026/09/01 22:02:36 Checking availability of "waagent" Sep 1 22:02:36.276056 bash[2435]: 2026/09/01 22:02:36 Checking availability of "waagent" Sep 1 22:02:36.676572 bash[2435]: 2026/09/01 22:02:36 Checking availability of "waagent" Sep 1 22:02:37.477439 bash[2435]: 2026/09/01 22:02:37 Checking availability of "waagent" Sep 1 22:02:37.936283 containerd[2234]: time="2026-09-01T22:02:37Z" 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 1 22:02:37.936283 containerd[2234]: time="2026-09-01T22:02:37Z" level=warning msg="Configuration migrated from version 2, use `containerd config migrate` to avoid migration" t="13.6µs" Sep 1 22:02:37.937140 containerd[2234]: time="2026-09-01T22:02:37.937100924Z" level=info msg="starting containerd" revision=aad11006b869517fcd3009450b6f82da282e1a9b version=v2.3.3 Sep 1 22:02:37.938784 containerd[2234]: time="2026-09-01T22:02:37.938737164Z" level=info msg="loading plugin" id=io.containerd.content.v1.content type=io.containerd.content.v1 Sep 1 22:02:37.938958 containerd[2234]: time="2026-09-01T22:02:37.938935796Z" level=warning msg="failed check for fsverity support" error="enable fsverity failed: operation not supported" path=/var/lib/containerd/io.containerd.content.v1.content Sep 1 22:02:37.938983 containerd[2234]: time="2026-09-01T22:02:37.938957868Z" level=info msg="loading plugin" id=io.containerd.image-verifier.v1.bindir type=io.containerd.image-verifier.v1 Sep 1 22:02:37.938983 containerd[2234]: time="2026-09-01T22:02:37.938966804Z" level=info msg="loading plugin" id=io.containerd.internal.v1.opt type=io.containerd.internal.v1 Sep 1 22:02:37.939083 containerd[2234]: time="2026-09-01T22:02:37.939070268Z" level=info msg="loading plugin" id=io.containerd.warning.v1.deprecations type=io.containerd.warning.v1 Sep 1 22:02:37.939097 containerd[2234]: time="2026-09-01T22:02:37.939082916Z" level=info msg="loading plugin" id=io.containerd.event.v1.exchange type=io.containerd.event.v1 Sep 1 22:02:37.939448 containerd[2234]: time="2026-09-01T22:02:37.939281036Z" level=info msg="loading plugin" id=io.containerd.mount-handler.v1.erofs type=io.containerd.mount-handler.v1 Sep 1 22:02:37.939448 containerd[2234]: time="2026-09-01T22:02:37.939300764Z" level=info msg="loading plugin" id=io.containerd.snapshotter.v1.blockfile type=io.containerd.snapshotter.v1 Sep 1 22:02:37.939448 containerd[2234]: time="2026-09-01T22:02:37.939368060Z" 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 1 22:02:37.939448 containerd[2234]: time="2026-09-01T22:02:37.939375236Z" level=info msg="loading plugin" id=io.containerd.snapshotter.v1.btrfs type=io.containerd.snapshotter.v1 Sep 1 22:02:37.939560 containerd[2234]: time="2026-09-01T22:02:37.939534308Z" 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 1 22:02:37.939560 containerd[2234]: time="2026-09-01T22:02:37.939553204Z" level=info msg="loading plugin" id=io.containerd.snapshotter.v1.devmapper type=io.containerd.snapshotter.v1 Sep 1 22:02:37.939585 containerd[2234]: time="2026-09-01T22:02:37.939560308Z" level=info msg="skip loading plugin" error="devmapper not configured: skip plugin" id=io.containerd.snapshotter.v1.devmapper type=io.containerd.snapshotter.v1 Sep 1 22:02:37.939585 containerd[2234]: time="2026-09-01T22:02:37.939565348Z" level=info msg="loading plugin" id=io.containerd.snapshotter.v1.erofs type=io.containerd.snapshotter.v1 Sep 1 22:02:37.939709 containerd[2234]: time="2026-09-01T22:02:37.939693972Z" level=info msg="loading plugin" id=io.containerd.snapshotter.v1.native type=io.containerd.snapshotter.v1 Sep 1 22:02:37.939755 containerd[2234]: time="2026-09-01T22:02:37.939744804Z" level=info msg="loading plugin" id=io.containerd.snapshotter.v1.overlayfs type=io.containerd.snapshotter.v1 Sep 1 22:02:37.939890 containerd[2234]: time="2026-09-01T22:02:37.939875172Z" level=info msg="loading plugin" id=io.containerd.snapshotter.v1.zfs type=io.containerd.snapshotter.v1 Sep 1 22:02:37.939914 containerd[2234]: time="2026-09-01T22:02:37.939903052Z" 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 1 22:02:37.939914 containerd[2234]: time="2026-09-01T22:02:37.939911852Z" level=info msg="loading plugin" id=io.containerd.monitor.task.v1.cgroups type=io.containerd.monitor.task.v1 Sep 1 22:02:37.940264 containerd[2234]: time="2026-09-01T22:02:37.940242300Z" level=info msg="loading plugin" id=io.containerd.metadata.v1.bolt type=io.containerd.metadata.v1 Sep 1 22:02:37.940332 containerd[2234]: time="2026-09-01T22:02:37.940318100Z" level=info msg="metadata content store policy set" policy=shared Sep 1 22:02:37.958020 containerd[2234]: time="2026-09-01T22:02:37.957960164Z" level=info msg="loading plugin" id=io.containerd.gc.v1.scheduler type=io.containerd.gc.v1 Sep 1 22:02:37.958020 containerd[2234]: time="2026-09-01T22:02:37.958043036Z" level=info msg="loading plugin" id=io.containerd.server.v1.metrics type=io.containerd.server.v1 Sep 1 22:02:37.958207 containerd[2234]: time="2026-09-01T22:02:37.958054268Z" level=info msg="skip loading plugin" error="skip plugin" id=io.containerd.server.v1.metrics type=io.containerd.server.v1 Sep 1 22:02:37.958207 containerd[2234]: time="2026-09-01T22:02:37.958066068Z" level=info msg="loading plugin" id=io.containerd.tracing.processor.v1.otlp type=io.containerd.tracing.processor.v1 Sep 1 22:02:37.958207 containerd[2234]: time="2026-09-01T22:02:37.958075972Z" 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 1 22:02:37.958207 containerd[2234]: time="2026-09-01T22:02:37.958081964Z" level=info msg="loading plugin" id=io.containerd.internal.v1.tracing type=io.containerd.internal.v1 Sep 1 22:02:37.958207 containerd[2234]: time="2026-09-01T22:02:37.958087740Z" 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 1 22:02:37.958207 containerd[2234]: time="2026-09-01T22:02:37.958092180Z" level=info msg="loading plugin" id=io.containerd.nri.v1.nri type=io.containerd.nri.v1 Sep 1 22:02:37.958207 containerd[2234]: time="2026-09-01T22:02:37.958158660Z" level=info msg="built-in NRI default validator is disabled" Sep 1 22:02:37.958207 containerd[2234]: time="2026-09-01T22:02:37.958163860Z" level=info msg="runtime interface created" Sep 1 22:02:37.958207 containerd[2234]: time="2026-09-01T22:02:37.958166844Z" level=info msg="created NRI interface" Sep 1 22:02:37.958207 containerd[2234]: time="2026-09-01T22:02:37.958171084Z" level=info msg="loading plugin" id=io.containerd.ttrpc.v1.otelttrpc type=io.containerd.ttrpc.v1 Sep 1 22:02:37.958207 containerd[2234]: time="2026-09-01T22:02:37.958177228Z" level=info msg="loading plugin" id=io.containerd.service.v1.containers-service type=io.containerd.service.v1 Sep 1 22:02:37.958207 containerd[2234]: time="2026-09-01T22:02:37.958192204Z" level=info msg="loading plugin" id=io.containerd.service.v1.content-service type=io.containerd.service.v1 Sep 1 22:02:37.958207 containerd[2234]: time="2026-09-01T22:02:37.958197788Z" level=info msg="loading plugin" id=io.containerd.differ.v1.erofs type=io.containerd.differ.v1 Sep 1 22:02:37.974575 containerd[2234]: time="2026-09-01T22:02:37.974512684Z" level=info msg="loading plugin" id=io.containerd.mount-manager.v1.bolt type=io.containerd.mount-manager.v1 Sep 1 22:02:37.974727 containerd[2234]: time="2026-09-01T22:02:37.974705604Z" level=info msg="loading plugin" id=io.containerd.differ.v1.walking type=io.containerd.differ.v1 Sep 1 22:02:37.974749 containerd[2234]: time="2026-09-01T22:02:37.974726820Z" level=info msg="loading plugin" id=io.containerd.service.v1.diff-service type=io.containerd.service.v1 Sep 1 22:02:37.974749 containerd[2234]: time="2026-09-01T22:02:37.974736420Z" level=info msg="loading plugin" id=io.containerd.service.v1.images-service type=io.containerd.service.v1 Sep 1 22:02:37.974749 containerd[2234]: time="2026-09-01T22:02:37.974745276Z" level=info msg="loading plugin" id=io.containerd.service.v1.introspection-service type=io.containerd.service.v1 Sep 1 22:02:37.974781 containerd[2234]: time="2026-09-01T22:02:37.974752124Z" level=info msg="loading plugin" id=io.containerd.service.v1.namespaces-service type=io.containerd.service.v1 Sep 1 22:02:37.974781 containerd[2234]: time="2026-09-01T22:02:37.974758844Z" level=info msg="loading plugin" id=io.containerd.service.v1.snapshots-service type=io.containerd.service.v1 Sep 1 22:02:37.974781 containerd[2234]: time="2026-09-01T22:02:37.974765748Z" level=info msg="loading plugin" id=io.containerd.shim.v1.manager type=io.containerd.shim.v1 Sep 1 22:02:37.974781 containerd[2234]: time="2026-09-01T22:02:37.974780764Z" level=info msg="loading plugin" id=io.containerd.runtime.v2.task type=io.containerd.runtime.v2 Sep 1 22:02:37.974913 containerd[2234]: time="2026-09-01T22:02:37.974896388Z" level=info msg="loading plugin" id=io.containerd.service.v1.tasks-service type=io.containerd.service.v1 Sep 1 22:02:37.974932 containerd[2234]: time="2026-09-01T22:02:37.974924132Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.containers type=io.containerd.grpc.v1 Sep 1 22:02:37.974945 containerd[2234]: time="2026-09-01T22:02:37.974934172Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.content type=io.containerd.grpc.v1 Sep 1 22:02:37.974945 containerd[2234]: time="2026-09-01T22:02:37.974941796Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.diff type=io.containerd.grpc.v1 Sep 1 22:02:37.974966 containerd[2234]: time="2026-09-01T22:02:37.974947332Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.events type=io.containerd.grpc.v1 Sep 1 22:02:37.974966 containerd[2234]: time="2026-09-01T22:02:37.974952676Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.images type=io.containerd.grpc.v1 Sep 1 22:02:37.974966 containerd[2234]: time="2026-09-01T22:02:37.974959108Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.introspection type=io.containerd.grpc.v1 Sep 1 22:02:37.974966 containerd[2234]: time="2026-09-01T22:02:37.974964620Z" level=info msg="loading plugin" id=io.containerd.lease.v1.manager type=io.containerd.lease.v1 Sep 1 22:02:37.975014 containerd[2234]: time="2026-09-01T22:02:37.974970996Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.leases type=io.containerd.grpc.v1 Sep 1 22:02:37.975014 containerd[2234]: time="2026-09-01T22:02:37.974976740Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.mounts type=io.containerd.grpc.v1 Sep 1 22:02:37.975014 containerd[2234]: time="2026-09-01T22:02:37.974982628Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.namespaces type=io.containerd.grpc.v1 Sep 1 22:02:37.975014 containerd[2234]: time="2026-09-01T22:02:37.974989564Z" level=info msg="loading plugin" id=io.containerd.sandbox.store.v1.local type=io.containerd.sandbox.store.v1 Sep 1 22:02:37.975014 containerd[2234]: time="2026-09-01T22:02:37.974994100Z" level=info msg="loading plugin" id=io.containerd.transfer.v1.local type=io.containerd.transfer.v1 Sep 1 22:02:37.975064 containerd[2234]: time="2026-09-01T22:02:37.975025692Z" level=info msg="loading plugin" id=io.containerd.cri.v1.images type=io.containerd.cri.v1 Sep 1 22:02:37.975064 containerd[2234]: time="2026-09-01T22:02:37.975058780Z" level=info msg="Get image filesystem path \"/var/lib/containerd/io.containerd.snapshotter.v1.overlayfs\" for snapshotter \"overlayfs\"" Sep 1 22:02:37.975089 containerd[2234]: time="2026-09-01T22:02:37.975077268Z" level=info msg="Start snapshots syncer" Sep 1 22:02:37.975100 containerd[2234]: time="2026-09-01T22:02:37.975089308Z" level=info msg="loading plugin" id=io.containerd.cri.v1.runtime type=io.containerd.cri.v1 Sep 1 22:02:37.975365 containerd[2234]: time="2026-09-01T22:02:37.975330676Z" 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,\"statsCollectPeriod\":\"\",\"statsRetentionPeriod\":\"\",\"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 1 22:02:37.975436 containerd[2234]: time="2026-09-01T22:02:37.975376788Z" level=info msg="loading plugin" id=io.containerd.podsandbox.controller.v1.podsandbox type=io.containerd.podsandbox.controller.v1 Sep 1 22:02:37.975436 containerd[2234]: time="2026-09-01T22:02:37.975415644Z" level=info msg="loading plugin" id=io.containerd.sandbox.controller.v1.shim type=io.containerd.sandbox.controller.v1 Sep 1 22:02:37.975529 containerd[2234]: time="2026-09-01T22:02:37.975509380Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.sandbox-controllers type=io.containerd.grpc.v1 Sep 1 22:02:37.975543 containerd[2234]: time="2026-09-01T22:02:37.975530068Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.sandboxes type=io.containerd.grpc.v1 Sep 1 22:02:37.975543 containerd[2234]: time="2026-09-01T22:02:37.975537124Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.snapshots type=io.containerd.grpc.v1 Sep 1 22:02:37.975543 containerd[2234]: time="2026-09-01T22:02:37.975542172Z" level=info msg="loading plugin" id=io.containerd.streaming.v1.manager type=io.containerd.streaming.v1 Sep 1 22:02:37.975575 containerd[2234]: time="2026-09-01T22:02:37.975548724Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.streaming type=io.containerd.grpc.v1 Sep 1 22:02:37.975575 containerd[2234]: time="2026-09-01T22:02:37.975554012Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.tasks type=io.containerd.grpc.v1 Sep 1 22:02:37.975575 containerd[2234]: time="2026-09-01T22:02:37.975559212Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.transfer type=io.containerd.grpc.v1 Sep 1 22:02:37.975575 containerd[2234]: time="2026-09-01T22:02:37.975565612Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.version type=io.containerd.grpc.v1 Sep 1 22:02:37.975575 containerd[2234]: time="2026-09-01T22:02:37.975570252Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.healthcheck type=io.containerd.grpc.v1 Sep 1 22:02:37.975575 containerd[2234]: time="2026-09-01T22:02:37.975575732Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.cri type=io.containerd.grpc.v1 Sep 1 22:02:37.975647 containerd[2234]: time="2026-09-01T22:02:37.975586452Z" level=info msg="Connect containerd service" Sep 1 22:02:37.975647 containerd[2234]: time="2026-09-01T22:02:37.975603452Z" level=info msg="using experimental NRI integration - disable nri plugin to prevent this" Sep 1 22:02:37.976395 containerd[2234]: time="2026-09-01T22:02:37.976368092Z" level=warning 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 1 22:02:38.942318 containerd[2234]: time="2026-09-01T22:02:38.942264836Z" level=info msg="loading plugin" id=io.containerd.server.v1.ttrpc type=io.containerd.server.v1 Sep 1 22:02:38.942667 containerd[2234]: time="2026-09-01T22:02:38.942359716Z" level=info msg="loading plugin" id=io.containerd.monitor.container.v1.restart type=io.containerd.monitor.container.v1 Sep 1 22:02:38.942667 containerd[2234]: time="2026-09-01T22:02:38.942393044Z" level=info msg="loading plugin" id=io.containerd.metrics.v1.grpc-prometheus type=io.containerd.metrics.v1 Sep 1 22:02:38.942667 containerd[2234]: time="2026-09-01T22:02:38.942425740Z" level=info msg="loading plugin" id=io.containerd.metrics.v1.grpc-otel type=io.containerd.metrics.v1 Sep 1 22:02:38.942667 containerd[2234]: time="2026-09-01T22:02:38.942440564Z" level=info msg="loading plugin" id=io.containerd.server.v1.grpc type=io.containerd.server.v1 Sep 1 22:02:38.943007 containerd[2234]: time="2026-09-01T22:02:38.942771268Z" level=info msg="Start subscribing containerd event" Sep 1 22:02:38.943007 containerd[2234]: time="2026-09-01T22:02:38.942837172Z" level=info msg="Start stats collector" Sep 1 22:02:38.943007 containerd[2234]: time="2026-09-01T22:02:38.942845548Z" level=info msg="Start recovering state" Sep 1 22:02:38.943007 containerd[2234]: time="2026-09-01T22:02:38.942936204Z" level=info msg="Start event monitor" Sep 1 22:02:38.943007 containerd[2234]: time="2026-09-01T22:02:38.942947580Z" level=info msg="Start cni network conf syncer for default" Sep 1 22:02:38.943007 containerd[2234]: time="2026-09-01T22:02:38.942952908Z" level=info msg="Start streaming server" Sep 1 22:02:38.943007 containerd[2234]: time="2026-09-01T22:02:38.942959396Z" level=info msg="Registered namespace \"k8s.io\" with NRI" Sep 1 22:02:38.943007 containerd[2234]: time="2026-09-01T22:02:38.942966340Z" level=info msg="runtime interface starting up..." Sep 1 22:02:38.943007 containerd[2234]: time="2026-09-01T22:02:38.942969996Z" level=info msg="starting plugins..." Sep 1 22:02:38.943007 containerd[2234]: time="2026-09-01T22:02:38.942988980Z" level=info msg="Synchronizing NRI (plugin) with current runtime state" Sep 1 22:02:38.957573 containerd[2234]: time="2026-09-01T22:02:38.952200948Z" level=info msg="loading plugin" id=io.containerd.server.v1.grpc-tcp type=io.containerd.server.v1 Sep 1 22:02:38.957573 containerd[2234]: time="2026-09-01T22:02:38.952287276Z" level=info msg="skip loading plugin" error="skip plugin" id=io.containerd.server.v1.grpc-tcp type=io.containerd.server.v1 Sep 1 22:02:38.957573 containerd[2234]: time="2026-09-01T22:02:38.952295524Z" level=info msg="loading plugin" id=io.containerd.http.v1.pprof type=io.containerd.http.v1 Sep 1 22:02:38.957573 containerd[2234]: time="2026-09-01T22:02:38.952333132Z" level=info msg="loading plugin" id=io.containerd.server.v1.debug type=io.containerd.server.v1 Sep 1 22:02:38.957573 containerd[2234]: time="2026-09-01T22:02:38.952339220Z" level=info msg="skip loading plugin" error="skip plugin" id=io.containerd.server.v1.debug type=io.containerd.server.v1 Sep 1 22:02:38.957573 containerd[2234]: time="2026-09-01T22:02:38.952429628Z" level=info msg=serving... address=/run/containerd/containerd.sock.ttrpc Sep 1 22:02:38.957573 containerd[2234]: time="2026-09-01T22:02:38.952443748Z" level=info msg="starting GRPC server" address=/run/containerd/containerd.sock gid=0 uid=0 Sep 1 22:02:38.957573 containerd[2234]: time="2026-09-01T22:02:38.952472852Z" level=info msg=serving... address=/run/containerd/containerd.sock Sep 1 22:02:38.957573 containerd[2234]: time="2026-09-01T22:02:38.952529428Z" level=info msg="containerd successfully booted in 1.016737s" Sep 1 22:02:38.957783 waagent[2472]: 2026-09-01T22:02:38.954613Z INFO Daemon Daemon Azure Linux Agent Version: 2.12.0.4 Sep 1 22:02:38.952884 systemd[1]: Started containerd.service - containerd container runtime. Sep 1 22:02:38.963422 waagent[2472]: 2026-09-01T22:02:38.963346Z INFO Daemon Daemon OS: flatcar 9999.9.9 Sep 1 22:02:38.967106 waagent[2472]: 2026-09-01T22:02:38.967058Z INFO Daemon Daemon Python: 3.13.14 Sep 1 22:02:38.971537 waagent[2472]: 2026-09-01T22:02:38.970879Z INFO Daemon Daemon Run daemon Sep 1 22:02:38.974456 waagent[2472]: 2026-09-01T22:02:38.974392Z INFO Daemon Daemon No RDMA handler exists for distro='Flatcar Container Linux by Kinvolk' version='9999.9.9' Sep 1 22:02:38.981364 waagent[2472]: 2026-09-01T22:02:38.981317Z INFO Daemon Daemon Using waagent for provisioning Sep 1 22:02:38.985333 waagent[2472]: 2026-09-01T22:02:38.985293Z INFO Daemon Daemon Activate resource disk Sep 1 22:02:38.988929 waagent[2472]: 2026-09-01T22:02:38.988880Z INFO Daemon Daemon Searching gen1 prefix 00000000-0001 or gen2 f8b3781a-1e82-4818-a1c3-63d806ec15bb Sep 1 22:02:38.997136 waagent[2472]: 2026-09-01T22:02:38.997089Z INFO Daemon Daemon Found device: None Sep 1 22:02:39.000395 waagent[2472]: 2026-09-01T22:02:39.000356Z ERROR Daemon Daemon Failed to mount resource disk [ResourceDiskError] unable to detect disk topology Sep 1 22:02:39.006110 waagent[2472]: 2026-09-01T22:02:39.006074Z ERROR Daemon Daemon Event: name=WALinuxAgent, op=ActivateResourceDisk, message=[ResourceDiskError] unable to detect disk topology, duration=0 Sep 1 22:02:39.015375 waagent[2472]: 2026-09-01T22:02:39.015336Z INFO Daemon Daemon Clean protocol and wireserver endpoint Sep 1 22:02:39.019652 waagent[2472]: 2026-09-01T22:02:39.019616Z INFO Daemon Daemon Running default provisioning handler Sep 1 22:02:39.028540 waagent[2472]: 2026-09-01T22:02:39.028482Z 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 1 22:02:39.039291 waagent[2472]: 2026-09-01T22:02:39.039238Z INFO Daemon Daemon Unable to get cloud-init enabled status from service: [Errno 2] No such file or directory: 'service' Sep 1 22:02:39.046513 waagent[2472]: 2026-09-01T22:02:39.046464Z INFO Daemon Daemon cloud-init is enabled: False Sep 1 22:02:39.050320 waagent[2472]: 2026-09-01T22:02:39.050283Z INFO Daemon Daemon Copying ovf-env.xml Sep 1 22:02:39.065164 waagent[2472]: 2026-09-01T22:02:39.065096Z INFO Daemon Daemon Successfully mounted dvd Sep 1 22:02:39.077982 bash[2435]: 2026/09/01 22:02:39 Checking availability of "waagent" Sep 1 22:02:39.105690 systemd[1]: mnt-cdrom-secure.mount: Deactivated successfully. Sep 1 22:02:39.106765 waagent[2472]: 2026-09-01T22:02:39.106710Z INFO Daemon Daemon Detect protocol endpoint Sep 1 22:02:39.110933 waagent[2472]: 2026-09-01T22:02:39.110872Z INFO Daemon Daemon Clean protocol and wireserver endpoint Sep 1 22:02:39.115549 waagent[2472]: 2026-09-01T22:02:39.115498Z INFO Daemon Daemon WireServer endpoint is not found. Rerun dhcp handler Sep 1 22:02:39.120132 waagent[2472]: 2026-09-01T22:02:39.120094Z INFO Daemon Daemon Test for route to 168.63.129.16 Sep 1 22:02:39.124361 waagent[2472]: 2026-09-01T22:02:39.124320Z INFO Daemon Daemon Route to 168.63.129.16 exists Sep 1 22:02:39.128038 waagent[2472]: 2026-09-01T22:02:39.128002Z INFO Daemon Daemon Wire server endpoint:168.63.129.16 Sep 1 22:02:39.193855 waagent[2472]: 2026-09-01T22:02:39.193734Z INFO Daemon Daemon Fabric preferred wire protocol version:2015-04-05 Sep 1 22:02:39.199500 waagent[2472]: 2026-09-01T22:02:39.199474Z INFO Daemon Daemon Wire protocol version:2012-11-30 Sep 1 22:02:39.204820 waagent[2472]: 2026-09-01T22:02:39.203413Z INFO Daemon Daemon Server preferred version:2015-04-05 Sep 1 22:02:39.481872 waagent[2472]: 2026-09-01T22:02:39.481720Z INFO Daemon Daemon Initializing goal state during protocol detection Sep 1 22:02:39.487407 waagent[2472]: 2026-09-01T22:02:39.487349Z INFO Daemon Daemon Forcing an update of the goal state. Sep 1 22:02:39.497536 waagent[2472]: 2026-09-01T22:02:39.497496Z INFO Daemon Fetched a new incarnation for the WireServer goal state [incarnation 1] Sep 1 22:02:39.515872 waagent[2472]: 2026-09-01T22:02:39.515831Z INFO Daemon Daemon HostGAPlugin version: 1.0.8.185 Sep 1 22:02:39.520560 waagent[2472]: 2026-09-01T22:02:39.520522Z INFO Daemon Sep 1 22:02:39.522839 waagent[2472]: 2026-09-01T22:02:39.522805Z INFO Daemon Fetched new vmSettings [HostGAPlugin correlation ID: be7d77d6-3274-4360-ae92-bd377b69b57a eTag: 1032879743830775462 source: Fabric] Sep 1 22:02:39.531822 waagent[2472]: 2026-09-01T22:02:39.531781Z INFO Daemon The vmSettings originated via Fabric; will ignore them. Sep 1 22:02:39.537387 waagent[2472]: 2026-09-01T22:02:39.537348Z INFO Daemon Sep 1 22:02:39.539564 waagent[2472]: 2026-09-01T22:02:39.539527Z INFO Daemon Fetching full goal state from the WireServer [incarnation 1] Sep 1 22:02:39.552197 waagent[2472]: 2026-09-01T22:02:39.552162Z INFO Daemon Daemon Downloading artifacts profile blob Sep 1 22:02:39.618397 waagent[2472]: 2026-09-01T22:02:39.618320Z INFO Daemon Downloaded certificate {'thumbprint': '81D78302CF039A07C0CE87988951ABF4ADD3C842', 'hasPrivateKey': True} Sep 1 22:02:39.625568 waagent[2472]: 2026-09-01T22:02:39.625525Z INFO Daemon Fetch goal state completed Sep 1 22:02:39.635056 waagent[2472]: 2026-09-01T22:02:39.635021Z INFO Daemon Daemon Starting provisioning Sep 1 22:02:39.639045 waagent[2472]: 2026-09-01T22:02:39.639008Z INFO Daemon Daemon Handle ovf-env.xml. Sep 1 22:02:39.642547 waagent[2472]: 2026-09-01T22:02:39.642517Z INFO Daemon Daemon Set hostname [ci-9999.9.9-l-c95d858d68] Sep 1 22:02:39.649264 waagent[2472]: 2026-09-01T22:02:39.649190Z INFO Daemon Daemon Publish hostname [ci-9999.9.9-l-c95d858d68] Sep 1 22:02:39.654046 waagent[2472]: 2026-09-01T22:02:39.654000Z INFO Daemon Daemon Examine /proc/net/route for primary interface Sep 1 22:02:39.660524 waagent[2472]: 2026-09-01T22:02:39.660475Z INFO Daemon Daemon Primary interface is [eth0] Sep 1 22:02:39.670824 systemd-networkd[1956]: eth0: Found matching .network file, based on potentially unpredictable interface name: /usr/lib/systemd/network/zz-default.network Sep 1 22:02:39.670833 systemd-networkd[1956]: eth0: Reconfiguring with /usr/lib/systemd/network/zz-default.network. Sep 1 22:02:39.670888 systemd-networkd[1956]: eth0: DHCP lease lost Sep 1 22:02:39.677646 waagent[2472]: 2026-09-01T22:02:39.677568Z INFO Daemon Daemon Create user account if not exists Sep 1 22:02:39.681877 waagent[2472]: 2026-09-01T22:02:39.681823Z INFO Daemon Daemon User core already exists, skip useradd Sep 1 22:02:39.686025 waagent[2472]: 2026-09-01T22:02:39.685981Z INFO Daemon Daemon Configure sudoer Sep 1 22:02:39.689116 systemd-networkd[1956]: eth0: DHCPv4 address 10.0.0.4/24, gateway 10.0.0.1 acquired from 168.63.129.16 Sep 1 22:02:39.690381 waagent[2472]: 2026-09-01T22:02:39.689578Z INFO Daemon Daemon Configure sshd Sep 1 22:02:39.693216 waagent[2472]: 2026-09-01T22:02:39.693167Z INFO Daemon Daemon Added a configuration snippet disabling SSH password-based authentication methods. It also configures SSH client probing to keep connections alive. Sep 1 22:02:39.702561 waagent[2472]: 2026-09-01T22:02:39.702515Z INFO Daemon Daemon Deploy ssh public key. Sep 1 22:02:39.739506 waagent[2472]: 2026-09-01T22:02:39.739371Z INFO Daemon Daemon Decode custom data Sep 1 22:02:39.743377 waagent[2472]: 2026-09-01T22:02:39.743324Z INFO Daemon Daemon Save custom data Sep 1 22:02:40.796581 waagent[2472]: 2026-09-01T22:02:40.796534Z INFO Daemon Daemon Provisioning complete Sep 1 22:02:40.807198 waagent[2472]: 2026-09-01T22:02:40.807157Z INFO Daemon Daemon RDMA capabilities are not enabled, skipping Sep 1 22:02:40.811749 waagent[2472]: 2026-09-01T22:02:40.811707Z INFO Daemon Daemon End of log to /dev/console. The agent will now check for updates and then will process extensions. Sep 1 22:02:40.819279 waagent[2472]: 2026-09-01T22:02:40.819240Z INFO Daemon Daemon Installed Agent WALinuxAgent-2.12.0.4 is the most current agent Sep 1 22:02:40.919940 waagent[2516]: 2026-09-01T22:02:40.919853Z INFO ExtHandler ExtHandler Azure Linux Agent (Goal State Agent version 2.12.0.4) Sep 1 22:02:40.920311 waagent[2516]: 2026-09-01T22:02:40.920006Z INFO ExtHandler ExtHandler OS: flatcar 9999.9.9 Sep 1 22:02:40.920311 waagent[2516]: 2026-09-01T22:02:40.920059Z INFO ExtHandler ExtHandler Python: 3.13.14 Sep 1 22:02:40.920311 waagent[2516]: 2026-09-01T22:02:40.920096Z INFO ExtHandler ExtHandler CPU Arch: aarch64 Sep 1 22:02:40.938236 waagent[2516]: 2026-09-01T22:02:40.938142Z INFO ExtHandler ExtHandler Distro: flatcar-9999.9.9; OSUtil: FlatcarUtil; AgentService: waagent; Python: 3.13.14; Arch: aarch64; systemd: True; LISDrivers: Absent; logrotate: logrotate 3.22.0; Sep 1 22:02:40.938408 waagent[2516]: 2026-09-01T22:02:40.938377Z INFO ExtHandler ExtHandler WireServer endpoint 168.63.129.16 read from file Sep 1 22:02:40.938462 waagent[2516]: 2026-09-01T22:02:40.938442Z INFO ExtHandler ExtHandler Wire server endpoint:168.63.129.16 Sep 1 22:02:40.944769 waagent[2516]: 2026-09-01T22:02:40.944713Z INFO ExtHandler Fetched a new incarnation for the WireServer goal state [incarnation 1] Sep 1 22:02:40.949160 waagent[2516]: 2026-09-01T22:02:40.949127Z INFO ExtHandler ExtHandler HostGAPlugin version: 1.0.8.185 Sep 1 22:02:40.949590 waagent[2516]: 2026-09-01T22:02:40.949557Z INFO ExtHandler Sep 1 22:02:40.949649 waagent[2516]: 2026-09-01T22:02:40.949631Z INFO ExtHandler Fetched new vmSettings [HostGAPlugin correlation ID: 8035b9ac-0a2a-469a-adec-eb205ce15343 eTag: 1032879743830775462 source: Fabric] Sep 1 22:02:40.949864 waagent[2516]: 2026-09-01T22:02:40.949834Z INFO ExtHandler The vmSettings originated via Fabric; will ignore them. Sep 1 22:02:40.950317 waagent[2516]: 2026-09-01T22:02:40.950279Z INFO ExtHandler Sep 1 22:02:40.950369 waagent[2516]: 2026-09-01T22:02:40.950349Z INFO ExtHandler Fetching full goal state from the WireServer [incarnation 1] Sep 1 22:02:40.952956 waagent[2516]: 2026-09-01T22:02:40.952926Z INFO ExtHandler ExtHandler Downloading artifacts profile blob Sep 1 22:02:41.059928 waagent[2516]: 2026-09-01T22:02:41.059788Z INFO ExtHandler Downloaded certificate {'thumbprint': '81D78302CF039A07C0CE87988951ABF4ADD3C842', 'hasPrivateKey': True} Sep 1 22:02:41.060322 waagent[2516]: 2026-09-01T22:02:41.060284Z INFO ExtHandler Fetch goal state completed Sep 1 22:02:41.069739 waagent[2516]: 2026-09-01T22:02:41.069677Z INFO ExtHandler ExtHandler OpenSSL version: OpenSSL 3.5.7 9 Jun 2026 (Library: OpenSSL 3.5.7 9 Jun 2026) Sep 1 22:02:41.073009 waagent[2516]: 2026-09-01T22:02:41.072956Z INFO ExtHandler ExtHandler WALinuxAgent-2.12.0.4 running as process 2516 Sep 1 22:02:41.073124 waagent[2516]: 2026-09-01T22:02:41.073095Z INFO ExtHandler ExtHandler ******** AutoUpdate.Enabled is set to False, not processing the operation ******** Sep 1 22:02:41.073423 waagent[2516]: 2026-09-01T22:02:41.073389Z INFO ExtHandler ExtHandler ******** AutoUpdate.UpdateToLatestVersion is set to False, not processing the operation ******** Sep 1 22:02:41.074725 waagent[2516]: 2026-09-01T22:02:41.074499Z INFO ExtHandler ExtHandler [CGI] Cgroup monitoring is not supported on ['flatcar', '9999.9.9', '', 'Flatcar Container Linux by Kinvolk'] Sep 1 22:02:41.074866 waagent[2516]: 2026-09-01T22:02:41.074825Z INFO ExtHandler ExtHandler [CGI] Agent will reset the quotas in case distro: ['flatcar', '9999.9.9', '', 'Flatcar Container Linux by Kinvolk'] went from supported to unsupported Sep 1 22:02:41.074962 waagent[2516]: 2026-09-01T22:02:41.074938Z INFO ExtHandler ExtHandler [CGI] Agent cgroups enabled: False Sep 1 22:02:41.076259 waagent[2516]: 2026-09-01T22:02:41.076165Z INFO ExtHandler ExtHandler Starting setup for Persistent firewall rules Sep 1 22:02:41.128746 waagent[2516]: 2026-09-01T22:02:41.128699Z INFO ExtHandler ExtHandler Firewalld service not running/unavailable, trying to set up waagent-network-setup.service Sep 1 22:02:41.128940 waagent[2516]: 2026-09-01T22:02:41.128908Z INFO ExtHandler ExtHandler Successfully updated the Binary file /var/lib/waagent/waagent-network-setup.py for firewall setup Sep 1 22:02:41.133744 waagent[2516]: 2026-09-01T22:02:41.133347Z INFO ExtHandler ExtHandler Service: waagent-network-setup.service not enabled. Adding it now Sep 1 22:02:41.137928 systemd[1]: Reload requested from client PID 2532 ('systemctl') (unit waagent.service)... Sep 1 22:02:41.137944 systemd[1]: Reloading... Sep 1 22:02:41.251380 zram_generator::config[2586]: No configuration found. Sep 1 22:02:41.472307 systemd[1]: Reloading finished in 334 ms. Sep 1 22:02:41.499456 waagent[2516]: 2026-09-01T22:02:41.499253Z INFO ExtHandler ExtHandler Successfully added and enabled the waagent-network-setup.service Sep 1 22:02:41.499456 waagent[2516]: 2026-09-01T22:02:41.499441Z INFO ExtHandler ExtHandler Persistent firewall rules setup successfully Sep 1 22:02:41.529750 login[2474]: pam_unix(login:session): session opened for user core(uid=500) by core(uid=0) Sep 1 22:02:41.536022 systemd[1]: Created slice user-500.slice - User Slice of UID 500. Sep 1 22:02:41.541304 systemd[1]: Starting user-runtime-dir@500.service - User Runtime Directory /run/user/500... Sep 1 22:02:41.549674 systemd-logind[2209]: New session '1' of user 'core' with class 'user-light' and type 'tty'. Sep 1 22:02:41.576305 systemd[1]: Finished user-runtime-dir@500.service - User Runtime Directory /run/user/500. Sep 1 22:02:41.588594 systemd[1]: Started session-1.scope - Session 1 of User core. Sep 1 22:02:41.739029 login[2475]: pam_unix(login:session): session opened for user core(uid=500) by core(uid=0) Sep 1 22:02:41.745413 systemd-logind[2209]: New session '2' of user 'core' with class 'user-light' and type 'tty'. Sep 1 22:02:41.750464 systemd[1]: Started session-2.scope - Session 2 of User core. Sep 1 22:02:41.960978 waagent[2516]: 2026-09-01T22:02:41.960888Z INFO ExtHandler ExtHandler DROP rule is not available which implies no firewall rules are set yet. Environment thread will set it up. Sep 1 22:02:41.961334 waagent[2516]: 2026-09-01T22:02:41.961202Z 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 1 22:02:41.962005 waagent[2516]: 2026-09-01T22:02:41.961956Z INFO ExtHandler ExtHandler Starting env monitor service. Sep 1 22:02:41.962455 waagent[2516]: 2026-09-01T22:02:41.962313Z INFO ExtHandler ExtHandler Start SendTelemetryHandler service. Sep 1 22:02:41.962658 waagent[2516]: 2026-09-01T22:02:41.962611Z INFO MonitorHandler ExtHandler WireServer endpoint 168.63.129.16 read from file Sep 1 22:02:41.962745 waagent[2516]: 2026-09-01T22:02:41.962709Z INFO EnvHandler ExtHandler WireServer endpoint 168.63.129.16 read from file Sep 1 22:02:41.962832 waagent[2516]: 2026-09-01T22:02:41.962780Z INFO EnvHandler ExtHandler Wire server endpoint:168.63.129.16 Sep 1 22:02:41.962983 waagent[2516]: 2026-09-01T22:02:41.962948Z INFO EnvHandler ExtHandler Configure routes Sep 1 22:02:41.963118 waagent[2516]: 2026-09-01T22:02:41.963008Z INFO EnvHandler ExtHandler Gateway:None Sep 1 22:02:41.963118 waagent[2516]: 2026-09-01T22:02:41.963077Z INFO SendTelemetryHandler ExtHandler Successfully started the SendTelemetryHandler thread Sep 1 22:02:41.963160 waagent[2516]: 2026-09-01T22:02:41.963145Z INFO EnvHandler ExtHandler Routes:None Sep 1 22:02:41.963358 waagent[2516]: 2026-09-01T22:02:41.963320Z INFO ExtHandler ExtHandler Start Extension Telemetry service. Sep 1 22:02:41.963605 waagent[2516]: 2026-09-01T22:02:41.963573Z INFO MonitorHandler ExtHandler Wire server endpoint:168.63.129.16 Sep 1 22:02:41.964054 waagent[2516]: 2026-09-01T22:02:41.964017Z INFO MonitorHandler ExtHandler Monitor.NetworkConfigurationChanges is disabled. Sep 1 22:02:41.964441 waagent[2516]: 2026-09-01T22:02:41.964387Z INFO MonitorHandler ExtHandler Routing table from /proc/net/route: Sep 1 22:02:41.964441 waagent[2516]: Iface Destination Gateway Flags RefCnt Use Metric Mask MTU Window IRTT Sep 1 22:02:41.964441 waagent[2516]: eth0 00000000 0100000A 0003 0 0 1024 00000000 0 0 0 Sep 1 22:02:41.964441 waagent[2516]: eth0 0000000A 00000000 0001 0 0 1024 00FFFFFF 0 0 0 Sep 1 22:02:41.964441 waagent[2516]: eth0 0100000A 00000000 0005 0 0 1024 FFFFFFFF 0 0 0 Sep 1 22:02:41.964441 waagent[2516]: eth0 10813FA8 0100000A 0007 0 0 1024 FFFFFFFF 0 0 0 Sep 1 22:02:41.964441 waagent[2516]: eth0 FEA9FEA9 0100000A 0007 0 0 1024 FFFFFFFF 0 0 0 Sep 1 22:02:41.964766 waagent[2516]: 2026-09-01T22:02:41.964665Z INFO TelemetryEventsCollector ExtHandler Extension Telemetry pipeline enabled: True Sep 1 22:02:41.964862 waagent[2516]: 2026-09-01T22:02:41.964834Z INFO TelemetryEventsCollector ExtHandler Successfully started the TelemetryEventsCollector thread Sep 1 22:02:41.965313 waagent[2516]: 2026-09-01T22:02:41.965280Z INFO ExtHandler ExtHandler Goal State Period: 6 sec. This indicates how often the agent checks for new goal states and reports status. Sep 1 22:02:41.972814 waagent[2516]: 2026-09-01T22:02:41.972061Z INFO ExtHandler ExtHandler Sep 1 22:02:41.972814 waagent[2516]: 2026-09-01T22:02:41.972133Z INFO ExtHandler ExtHandler ProcessExtensionsGoalState started [incarnation_1 channel: WireServer source: Fabric activity: 6f0d733c-ab13-4855-8266-bf68c019b4e7 correlation f4cebe64-3d02-475c-8ceb-d6a89533d3e8 created: 2026-09-01T22:01:42.879768Z] Sep 1 22:02:41.972814 waagent[2516]: 2026-09-01T22:02:41.972429Z INFO ExtHandler ExtHandler No extension handlers found, not processing anything. Sep 1 22:02:41.972905 waagent[2516]: 2026-09-01T22:02:41.972821Z INFO ExtHandler ExtHandler ProcessExtensionsGoalState completed [incarnation_1 0 ms] Sep 1 22:02:41.998541 waagent[2516]: 2026-09-01T22:02:41.998439Z INFO ExtHandler ExtHandler [HEARTBEAT] Agent WALinuxAgent-2.12.0.4 is running as the goal state agent [DEBUG HeartbeatCounter: 0;HeartbeatId: 0219BB2C-ED06-4412-BA65-629FC0C8E5C0;DroppedPackets: 0;UpdateGSErrors: 0;AutoUpdate: 0;UpdateMode: SelfUpdate;] Sep 1 22:02:42.040146 waagent[2516]: 2026-09-01T22:02:42.040066Z INFO MonitorHandler ExtHandler Network interfaces: Sep 1 22:02:42.040146 waagent[2516]: Executing ['ip', '-a', '-o', 'link']: Sep 1 22:02:42.040146 waagent[2516]: 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 1 22:02:42.040146 waagent[2516]: 2: eth0: mtu 1500 qdisc mq state UP mode DEFAULT group default qlen 1000\ link/ether 7c:ed:8d:c7:e3:35 brd ff:ff:ff:ff:ff:ff\ altname enx7ced8dc7e335 Sep 1 22:02:42.040146 waagent[2516]: 3: enP27581s1: mtu 1500 qdisc mq master eth0 state UP mode DEFAULT group default qlen 1000\ link/ether 7c:ed:8d:c7:e3:35 brd ff:ff:ff:ff:ff:ff\ altname enP27581p0s2 Sep 1 22:02:42.040146 waagent[2516]: Executing ['ip', '-4', '-a', '-o', 'address']: Sep 1 22:02:42.040146 waagent[2516]: 1: lo inet 127.0.0.1/8 scope host lo\ valid_lft forever preferred_lft forever Sep 1 22:02:42.040146 waagent[2516]: 2: eth0 inet 10.0.0.4/24 metric 1024 brd 10.0.0.255 scope global eth0\ valid_lft forever preferred_lft forever Sep 1 22:02:42.040146 waagent[2516]: Executing ['ip', '-6', '-a', '-o', 'address']: Sep 1 22:02:42.040146 waagent[2516]: 1: lo inet6 ::1/128 scope host noprefixroute \ valid_lft forever preferred_lft forever Sep 1 22:02:42.040146 waagent[2516]: 2: eth0 inet6 fe80::7eed:8dff:fec7:e335/64 scope link proto kernel_ll \ valid_lft forever preferred_lft forever Sep 1 22:02:42.074371 waagent[2516]: 2026-09-01T22:02:42.074310Z INFO EnvHandler ExtHandler Created firewall rules for the Azure Fabric: Sep 1 22:02:42.074371 waagent[2516]: Chain INPUT (policy ACCEPT 0 packets, 0 bytes) Sep 1 22:02:42.074371 waagent[2516]: pkts bytes target prot opt in out source destination Sep 1 22:02:42.074371 waagent[2516]: Chain FORWARD (policy ACCEPT 0 packets, 0 bytes) Sep 1 22:02:42.074371 waagent[2516]: pkts bytes target prot opt in out source destination Sep 1 22:02:42.074371 waagent[2516]: Chain OUTPUT (policy ACCEPT 3 packets, 535 bytes) Sep 1 22:02:42.074371 waagent[2516]: pkts bytes target prot opt in out source destination Sep 1 22:02:42.074371 waagent[2516]: 0 0 ACCEPT tcp -- * * 0.0.0.0/0 168.63.129.16 tcp dpt:53 Sep 1 22:02:42.074371 waagent[2516]: 1 52 ACCEPT tcp -- * * 0.0.0.0/0 168.63.129.16 owner UID match 0 Sep 1 22:02:42.074371 waagent[2516]: 0 0 DROP tcp -- * * 0.0.0.0/0 168.63.129.16 ctstate INVALID,NEW Sep 1 22:02:42.076831 waagent[2516]: 2026-09-01T22:02:42.076776Z INFO EnvHandler ExtHandler Current Firewall rules: Sep 1 22:02:42.076831 waagent[2516]: Chain INPUT (policy ACCEPT 0 packets, 0 bytes) Sep 1 22:02:42.076831 waagent[2516]: pkts bytes target prot opt in out source destination Sep 1 22:02:42.076831 waagent[2516]: Chain FORWARD (policy ACCEPT 0 packets, 0 bytes) Sep 1 22:02:42.076831 waagent[2516]: pkts bytes target prot opt in out source destination Sep 1 22:02:42.076831 waagent[2516]: Chain OUTPUT (policy ACCEPT 3 packets, 535 bytes) Sep 1 22:02:42.076831 waagent[2516]: pkts bytes target prot opt in out source destination Sep 1 22:02:42.076831 waagent[2516]: 0 0 ACCEPT tcp -- * * 0.0.0.0/0 168.63.129.16 tcp dpt:53 Sep 1 22:02:42.076831 waagent[2516]: 1 52 ACCEPT tcp -- * * 0.0.0.0/0 168.63.129.16 owner UID match 0 Sep 1 22:02:42.076831 waagent[2516]: 0 0 DROP tcp -- * * 0.0.0.0/0 168.63.129.16 ctstate INVALID,NEW Sep 1 22:02:42.077048 waagent[2516]: 2026-09-01T22:02:42.077021Z INFO EnvHandler ExtHandler Set block dev timeout: sda with timeout: 300 Sep 1 22:02:42.278403 bash[2435]: 2026/09/01 22:02:42 Checking availability of "waagent" Sep 1 22:02:42.278403 bash[2435]: 2026/09/01 22:02:42 Fetching meta-data from datasource of type "waagent" Sep 1 22:02:42.278403 bash[2435]: 2026/09/01 22:02:42 Attempting to read from "/var/lib/waagent/SharedConfig.xml" Sep 1 22:02:42.278784 bash[2435]: 2026/09/01 22:02:42 Fetching user-data from datasource of type "waagent" Sep 1 22:02:42.278784 bash[2435]: 2026/09/01 22:02:42 Attempting to read from "/var/lib/waagent/CustomData" Sep 1 22:02:42.278784 bash[2435]: 2026/09/01 22:02:42 Running part "userdata.sh" (script) Sep 1 22:02:42.278912 bash[2435]: 2026/09/01 22:02:42 Writing file to "/var/lib/coreos-cloudinit/scripts/533223778" Sep 1 22:02:42.279046 bash[2435]: 2026/09/01 22:02:42 Wrote file to "/var/lib/coreos-cloudinit/scripts/533223778" Sep 1 22:02:42.279046 bash[2435]: 2026/09/01 22:02:42 Creating transient systemd unit 'coreos-cloudinit-533223778.service' Sep 1 22:02:42.285806 systemd[1]: Started coreos-cloudinit-533223778.service - Unit generated and executed by coreos-cloudinit on behalf of user. Sep 1 22:02:42.292457 bash[2435]: 2026/09/01 22:02:42 Writing file to "/var/lib/coreos-cloudinit/scripts/unit-name" Sep 1 22:02:42.292837 bash[2435]: 2026/09/01 22:02:42 Wrote file to "/var/lib/coreos-cloudinit/scripts/unit-name" Sep 1 22:02:42.294117 systemd[1]: oem-cloudinit.service: Deactivated successfully. Sep 1 22:02:42.294512 systemd[1]: Finished oem-cloudinit.service - Run cloudinit. Sep 1 22:02:42.301077 systemd[1]: Finished enable-oem-cloudinit.service - Enable cloudinit. Sep 1 22:02:42.309238 systemd[1]: Reached target multi-user.target - Multi-User System. Sep 1 22:02:42.313888 bash[2711]: chown: warning: '.' should be ':': ‘core.core’ Sep 1 22:02:42.318327 systemd[1]: Startup finished in 2.387s (kernel) + 13.868s (initrd) + 20.689s (userspace) = 36.945s. Sep 1 22:02:42.318605 systemd[1]: coreos-cloudinit-533223778.service: Deactivated successfully. Sep 1 22:02:42.323022 systemd[1]: Starting motdgen.service - Generate /run/flatcar/motd... Sep 1 22:02:42.338027 motdgen[2723]: /oem/oem-release: line 2: Azure: command not found Sep 1 22:02:42.342579 systemd[1]: motdgen.service: Deactivated successfully. Sep 1 22:02:42.342878 systemd[1]: Finished motdgen.service - Generate /run/flatcar/motd. Sep 1 22:02:58.812381 chronyd[2193]: Selected source PHC0 Sep 1 22:03:00.614184 systemd[1]: Created slice system-sshd.slice - Slice /system/sshd. Sep 1 22:03:00.617425 systemd[1]: Started sshd@0-1-10.0.0.4:22-20.101.212.173:41290.service - OpenSSH per-connection server daemon (20.101.212.173:41290). Sep 1 22:03:01.573269 sshd[2729]: Accepted publickey for core from 20.101.212.173 port 41290 ssh2: RSA SHA256:z//8xKO7q6WmpiDzeNxy9VX2F2npRi74QKwrRe5QJ3Y Sep 1 22:03:01.574502 sshd-session[2729]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Sep 1 22:03:01.583458 systemd[1]: Starting user@500.service - User Manager for UID 500... Sep 1 22:03:01.588308 systemd-logind[2209]: New session '3' of user 'core' with class 'user' and type 'tty'. Sep 1 22:03:01.594536 (systemd)[2733]: pam_unix(systemd-user:session): session opened for user core(uid=500) by core(uid=0) Sep 1 22:03:01.596734 systemd-logind[2209]: New session '4' of user 'core' with class 'manager-early' and type 'unspecified'. Sep 1 22:03:01.843865 systemd[2733]: Queued start job for default target default.target. Sep 1 22:03:01.850084 systemd[2733]: Created slice app.slice - User Application Slice. Sep 1 22:03:01.850120 systemd[2733]: Started systemd-tmpfiles-clean.timer - Daily Cleanup of User's Temporary Directories. Sep 1 22:03:01.850130 systemd[2733]: Reached target machines.target - Virtual Machines and Containers. Sep 1 22:03:01.850179 systemd[2733]: Reached target paths.target - Paths. Sep 1 22:03:01.850198 systemd[2733]: Reached target timers.target - Timers. Sep 1 22:03:01.851448 systemd[2733]: Starting dbus.socket - D-Bus User Message Bus Socket... Sep 1 22:03:01.852742 systemd[2733]: Listening on systemd-ask-password.socket - Query the User Interactively for a Password. Sep 1 22:03:01.852889 systemd[2733]: Listening on systemd-importd.socket - Disk Image Download Service Socket. Sep 1 22:03:01.853857 systemd[2733]: Listening on systemd-journalctl.socket - Journal Log Access Socket. Sep 1 22:03:01.854186 systemd[2733]: Listening on systemd-machined.socket - Virtual Machine and Container Registration Service Socket. Sep 1 22:03:01.857329 systemd[2733]: Starting systemd-tmpfiles-setup.service - Create User Files and Directories... Sep 1 22:03:01.860931 systemd[2733]: Listening on dbus.socket - D-Bus User Message Bus Socket. Sep 1 22:03:01.860987 systemd[2733]: Reached target sockets.target - Sockets. Sep 1 22:03:01.866329 systemd[2733]: Finished systemd-tmpfiles-setup.service - Create User Files and Directories. Sep 1 22:03:01.866439 systemd[2733]: Reached target basic.target - Basic System. Sep 1 22:03:01.866682 systemd[1]: Started user@500.service - User Manager for UID 500. Sep 1 22:03:01.867822 systemd[2733]: Reached target default.target - Main User Target. Sep 1 22:03:01.867853 systemd[2733]: Startup finished in 265ms. Sep 1 22:03:01.870409 systemd[1]: Started session-3.scope - Session 3 of User core. Sep 1 22:03:02.303626 systemd[1]: Started sshd@1-4097-10.0.0.4:22-20.101.212.173:41300.service - OpenSSH per-connection server daemon (20.101.212.173:41300). Sep 1 22:03:03.056771 sshd[2747]: Accepted publickey for core from 20.101.212.173 port 41300 ssh2: RSA SHA256:z//8xKO7q6WmpiDzeNxy9VX2F2npRi74QKwrRe5QJ3Y Sep 1 22:03:03.057680 sshd-session[2747]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Sep 1 22:03:03.063277 systemd-logind[2209]: New session '5' of user 'core' with class 'user' and type 'tty'. Sep 1 22:03:03.065439 systemd[1]: Started session-5.scope - Session 5 of User core. Sep 1 22:03:03.489625 sshd[2751]: Connection closed by 20.101.212.173 port 41300 Sep 1 22:03:03.490481 sshd-session[2747]: pam_unix(sshd:session): session closed for user core Sep 1 22:03:03.494442 systemd[1]: sshd@1-4097-10.0.0.4:22-20.101.212.173:41300.service: Deactivated successfully. Sep 1 22:03:03.496581 systemd[1]: session-5.scope: Deactivated successfully. Sep 1 22:03:03.498195 systemd-logind[2209]: Session 5 logged out. Waiting for processes to exit. Sep 1 22:03:03.500300 systemd-logind[2209]: Removed session 5. Sep 1 22:03:03.641457 systemd[1]: Started sshd@2-4098-10.0.0.4:22-20.101.212.173:41308.service - OpenSSH per-connection server daemon (20.101.212.173:41308). Sep 1 22:03:04.380237 sshd[2757]: Accepted publickey for core from 20.101.212.173 port 41308 ssh2: RSA SHA256:z//8xKO7q6WmpiDzeNxy9VX2F2npRi74QKwrRe5QJ3Y Sep 1 22:03:04.381059 sshd-session[2757]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Sep 1 22:03:04.386267 systemd-logind[2209]: New session '6' of user 'core' with class 'user' and type 'tty'. Sep 1 22:03:04.388385 systemd[1]: Started session-6.scope - Session 6 of User core. Sep 1 22:03:04.804048 sshd[2761]: Connection closed by 20.101.212.173 port 41308 Sep 1 22:03:04.805462 sshd-session[2757]: pam_unix(sshd:session): session closed for user core Sep 1 22:03:04.808485 systemd[1]: sshd@2-4098-10.0.0.4:22-20.101.212.173:41308.service: Deactivated successfully. Sep 1 22:03:04.810796 systemd[1]: session-6.scope: Deactivated successfully. Sep 1 22:03:04.812197 systemd-logind[2209]: Session 6 logged out. Waiting for processes to exit. Sep 1 22:03:04.815275 systemd-logind[2209]: Removed session 6. Sep 1 22:03:04.955624 systemd[1]: Started sshd@3-2-10.0.0.4:22-20.101.212.173:41312.service - OpenSSH per-connection server daemon (20.101.212.173:41312). Sep 1 22:03:05.698499 sshd[2767]: Accepted publickey for core from 20.101.212.173 port 41312 ssh2: RSA SHA256:z//8xKO7q6WmpiDzeNxy9VX2F2npRi74QKwrRe5QJ3Y Sep 1 22:03:05.699636 sshd-session[2767]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Sep 1 22:03:05.705273 systemd-logind[2209]: New session '7' of user 'core' with class 'user' and type 'tty'. Sep 1 22:03:05.707420 systemd[1]: Started session-7.scope - Session 7 of User core. Sep 1 22:03:06.124541 sshd[2771]: Connection closed by 20.101.212.173 port 41312 Sep 1 22:03:06.125191 sshd-session[2767]: pam_unix(sshd:session): session closed for user core Sep 1 22:03:06.128920 systemd[1]: sshd@3-2-10.0.0.4:22-20.101.212.173:41312.service: Deactivated successfully. Sep 1 22:03:06.130566 systemd[1]: session-7.scope: Deactivated successfully. Sep 1 22:03:06.133305 systemd-logind[2209]: Session 7 logged out. Waiting for processes to exit. Sep 1 22:03:06.134913 systemd-logind[2209]: Removed session 7. Sep 1 22:03:06.274446 systemd[1]: Started sshd@4-4099-10.0.0.4:22-20.101.212.173:41320.service - OpenSSH per-connection server daemon (20.101.212.173:41320). Sep 1 22:03:07.003488 sshd[2777]: Accepted publickey for core from 20.101.212.173 port 41320 ssh2: RSA SHA256:z//8xKO7q6WmpiDzeNxy9VX2F2npRi74QKwrRe5QJ3Y Sep 1 22:03:07.004680 sshd-session[2777]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Sep 1 22:03:07.010282 systemd-logind[2209]: New session '8' of user 'core' with class 'user' and type 'tty'. Sep 1 22:03:07.012419 systemd[1]: Started session-8.scope - Session 8 of User core. Sep 1 22:03:07.421306 sudo[2782]: core : PWD=/home/core ; USER=root ; COMMAND=/usr/sbin/setenforce 1 Sep 1 22:03:07.421538 sudo[2782]: pam_unix(sudo:session): session opened for user root(uid=0) by core(uid=500) Sep 1 22:03:07.432806 sudo[2782]: pam_unix(sudo:session): session closed for user root Sep 1 22:03:07.572336 sshd[2781]: Connection closed by 20.101.212.173 port 41320 Sep 1 22:03:07.573502 sshd-session[2777]: pam_unix(sshd:session): session closed for user core Sep 1 22:03:07.576826 systemd[1]: sshd@4-4099-10.0.0.4:22-20.101.212.173:41320.service: Deactivated successfully. Sep 1 22:03:07.579132 systemd[1]: session-8.scope: Deactivated successfully. Sep 1 22:03:07.580697 systemd-logind[2209]: Session 8 logged out. Waiting for processes to exit. Sep 1 22:03:07.582181 systemd-logind[2209]: Removed session 8. Sep 1 22:03:07.720565 systemd[1]: Started sshd@5-4100-10.0.0.4:22-20.101.212.173:41322.service - OpenSSH per-connection server daemon (20.101.212.173:41322). Sep 1 22:03:08.452235 sshd[2789]: Accepted publickey for core from 20.101.212.173 port 41322 ssh2: RSA SHA256:z//8xKO7q6WmpiDzeNxy9VX2F2npRi74QKwrRe5QJ3Y Sep 1 22:03:08.453469 sshd-session[2789]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Sep 1 22:03:08.459130 systemd-logind[2209]: New session '9' of user 'core' with class 'user' and type 'tty'. Sep 1 22:03:08.460402 systemd[1]: Started session-9.scope - Session 9 of User core. Sep 1 22:03:08.736580 sudo[2795]: 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 1 22:03:08.736802 sudo[2795]: pam_unix(sudo:session): session opened for user root(uid=0) by core(uid=500) Sep 1 22:03:08.738010 sudo[2795]: pam_unix(sudo:session): session closed for user root Sep 1 22:03:08.743464 sudo[2794]: core : PWD=/home/core ; USER=root ; COMMAND=/usr/sbin/systemctl restart audit-rules Sep 1 22:03:08.743689 sudo[2794]: pam_unix(sudo:session): session opened for user root(uid=0) by core(uid=500) Sep 1 22:03:08.749229 systemd[1]: Starting audit-rules.service - Load Audit Rules... Sep 1 22:03:08.793000 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 1 22:03:08.801409 augenrules[2819]: No rules Sep 1 22:03:08.801529 kernel: kauditd_printk_skb: 78 callbacks suppressed Sep 1 22:03:08.793000 audit[2819]: SYSCALL arch=c00000b7 syscall=206 success=yes exit=1056 a0=3 a1=fffff9826e00 a2=420 a3=0 items=0 ppid=2800 pid=2819 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 1 22:03:08.793000 audit: PROCTITLE proctitle=2F7362696E2F617564697463746C002D52002F6574632F61756469742F61756469742E72756C6573 Sep 1 22:03:08.801895 systemd[1]: audit-rules.service: Deactivated successfully. Sep 1 22:03:08.802153 systemd[1]: Finished audit-rules.service - Load Audit Rules. Sep 1 22:03:08.802231 kernel: audit: type=1305 audit(1788300188.793:175): auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 op=remove_rule key=(null) list=5 res=1 Sep 1 22:03:08.802268 kernel: audit: type=1300 audit(1788300188.793:175): arch=c00000b7 syscall=206 success=yes exit=1056 a0=3 a1=fffff9826e00 a2=420 a3=0 items=0 ppid=2800 pid=2819 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 1 22:03:08.802281 kernel: audit: type=1327 audit(1788300188.793:175): proctitle=2F7362696E2F617564697463746C002D52002F6574632F61756469742F61756469742E72756C6573 Sep 1 22:03:08.801000 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 1 22:03:08.801000 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 1 22:03:08.803618 kernel: audit: type=1130 audit(1788300188.801:176): pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=audit-rules comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Sep 1 22:03:08.803647 kernel: audit: type=1131 audit(1788300188.801:177): 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 1 22:03:08.804000 audit[2794]: AUDIT1106 pid=2794 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 1 22:03:08.805248 sudo[2794]: pam_unix(sudo:session): session closed for user root Sep 1 22:03:08.804000 audit[2794]: AUDIT1104 pid=2794 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 1 22:03:08.806233 kernel: audit: type=1106 audit(1788300188.804:178): pid=2794 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 1 22:03:08.806290 kernel: audit: type=1104 audit(1788300188.804:179): pid=2794 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 1 22:03:08.944977 sshd[2793]: Connection closed by 20.101.212.173 port 41322 Sep 1 22:03:08.945581 sshd-session[2789]: pam_unix(sshd:session): session closed for user core Sep 1 22:03:08.945000 audit[2789]: AUDIT1106 pid=2789 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.101.212.173 addr=20.101.212.173 terminal=ssh res=success' Sep 1 22:03:08.947230 kernel: audit: type=1106 audit(1788300188.945:180): pid=2789 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.101.212.173 addr=20.101.212.173 terminal=ssh res=success' Sep 1 22:03:08.947000 audit[2789]: AUDIT1104 pid=2789 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.101.212.173 addr=20.101.212.173 terminal=ssh res=success' Sep 1 22:03:08.950617 kernel: audit: type=1104 audit(1788300188.947:181): pid=2789 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.101.212.173 addr=20.101.212.173 terminal=ssh res=success' Sep 1 22:03:08.951712 systemd[1]: sshd@5-4100-10.0.0.4:22-20.101.212.173:41322.service: Deactivated successfully. Sep 1 22:03:08.950000 audit[1]: SERVICE_STOP pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=sshd@5-4100-10.0.0.4:22-20.101.212.173:41322 comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Sep 1 22:03:08.952306 kernel: audit: type=1131 audit(1788300188.950:182): pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=sshd@5-4100-10.0.0.4:22-20.101.212.173:41322 comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Sep 1 22:03:08.957044 systemd[1]: session-9.scope: Deactivated successfully. Sep 1 22:03:08.960831 systemd-logind[2209]: Session 9 logged out. Waiting for processes to exit. Sep 1 22:03:08.963098 systemd-logind[2209]: Removed session 9. Sep 1 22:03:09.100000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=sshd@6-4101-10.0.0.4:22-20.101.212.173:52602 comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Sep 1 22:03:09.101456 systemd[1]: Started sshd@6-4101-10.0.0.4:22-20.101.212.173:52602.service - OpenSSH per-connection server daemon (20.101.212.173:52602). Sep 1 22:03:09.852000 audit[2828]: AUDIT1101 pid=2828 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.101.212.173 addr=20.101.212.173 terminal=ssh res=success' Sep 1 22:03:09.853000 audit[2828]: AUDIT1103 pid=2828 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.101.212.173 addr=20.101.212.173 terminal=ssh res=success' Sep 1 22:03:09.853000 audit[2828]: SYSCALL arch=c00000b7 syscall=64 success=yes exit=3 a0=8 a1=fffff81f9d50 a2=3 a3=0 items=0 ppid=1 pid=2828 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 1 22:03:09.853000 audit: PROCTITLE proctitle=737368642D73657373696F6E3A20636F7265205B707269765D Sep 1 22:03:09.855492 sshd-session[2828]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Sep 1 22:03:09.855849 sshd[2828]: Accepted publickey for core from 20.101.212.173 port 52602 ssh2: RSA SHA256:z//8xKO7q6WmpiDzeNxy9VX2F2npRi74QKwrRe5QJ3Y Sep 1 22:03:09.860289 systemd-logind[2209]: New session '10' of user 'core' with class 'user' and type 'tty'. Sep 1 22:03:09.866378 systemd[1]: Started session-10.scope - Session 10 of User core. Sep 1 22:03:09.867000 audit[2828]: AUDIT1105 pid=2828 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.101.212.173 addr=20.101.212.173 terminal=ssh res=success' Sep 1 22:03:09.869000 audit[2832]: AUDIT1103 pid=2832 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.101.212.173 addr=20.101.212.173 terminal=ssh res=success' Sep 1 22:03:10.283610 sshd[2832]: Connection closed by 20.101.212.173 port 52602 Sep 1 22:03:10.284425 sshd-session[2828]: pam_unix(sshd:session): session closed for user core Sep 1 22:03:10.284000 audit[2828]: AUDIT1106 pid=2828 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.101.212.173 addr=20.101.212.173 terminal=ssh res=success' Sep 1 22:03:10.284000 audit[2828]: AUDIT1104 pid=2828 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.101.212.173 addr=20.101.212.173 terminal=ssh res=success' Sep 1 22:03:10.287799 systemd[1]: sshd@6-4101-10.0.0.4:22-20.101.212.173:52602.service: Deactivated successfully. Sep 1 22:03:10.286000 audit[1]: SERVICE_STOP pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=sshd@6-4101-10.0.0.4:22-20.101.212.173:52602 comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Sep 1 22:03:10.290304 systemd[1]: session-10.scope: Deactivated successfully. Sep 1 22:03:10.291603 systemd-logind[2209]: Session 10 logged out. Waiting for processes to exit. Sep 1 22:03:10.295438 systemd-logind[2209]: Removed session 10.