Sep 2 14:21:31.759715 kernel: Booting Linux on physical CPU 0x0000000000 [0x410fd490] Sep 2 14:21:31.759744 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 Wed Sep 2 12:40:14 -00 2026 Sep 2 14:21:31.759753 kernel: KASLR enabled Sep 2 14:21:31.759758 kernel: earlycon: pl11 at MMIO 0x00000000effec000 (options '') Sep 2 14:21:31.759762 kernel: printk: legacy bootconsole [pl11] enabled Sep 2 14:21:31.759767 kernel: efi: EFI v2.7 by EDK II Sep 2 14:21:31.759773 kernel: efi: ACPI 2.0=0x3f979018 SMBIOS=0x3f8a0000 SMBIOS 3.0=0x3f880000 MEMATTR=0x3e89b018 RNG=0x3f979998 MEMRESERVE=0x3db7b718 Sep 2 14:21:31.759778 kernel: random: crng init done Sep 2 14:21:31.759782 kernel: secureboot: Secure boot disabled Sep 2 14:21:31.759787 kernel: ACPI: Early table checksum verification disabled Sep 2 14:21:31.759792 kernel: ACPI: RSDP 0x000000003F979018 000024 (v02 VRTUAL) Sep 2 14:21:31.759797 kernel: ACPI: XSDT 0x000000003F979F18 00006C (v01 VRTUAL MICROSFT 00000001 MSFT 00000001) Sep 2 14:21:31.759802 kernel: ACPI: FACP 0x000000003F979C18 000114 (v06 VRTUAL MICROSFT 00000001 MSFT 00000001) Sep 2 14:21:31.759808 kernel: ACPI: DSDT 0x000000003F95A018 01E046 (v02 MSFTVM DSDT01 00000001 INTL 20230628) Sep 2 14:21:31.759815 kernel: ACPI: DBG2 0x000000003F979B18 000072 (v00 VRTUAL MICROSFT 00000001 MSFT 00000001) Sep 2 14:21:31.759819 kernel: ACPI: GTDT 0x000000003F979D98 000060 (v02 VRTUAL MICROSFT 00000001 MSFT 00000001) Sep 2 14:21:31.759823 kernel: ACPI: OEM0 0x000000003F979098 000064 (v01 VRTUAL MICROSFT 00000001 MSFT 00000001) Sep 2 14:21:31.759828 kernel: ACPI: SPCR 0x000000003F979A98 000050 (v02 VRTUAL MICROSFT 00000001 MSFT 00000001) Sep 2 14:21:31.759834 kernel: ACPI: APIC 0x000000003F979818 0000FC (v04 VRTUAL MICROSFT 00000001 MSFT 00000001) Sep 2 14:21:31.759839 kernel: ACPI: SRAT 0x000000003F979198 000234 (v03 VRTUAL MICROSFT 00000001 MSFT 00000001) Sep 2 14:21:31.759845 kernel: ACPI: PPTT 0x000000003F979418 000120 (v01 VRTUAL MICROSFT 00000000 MSFT 00000000) Sep 2 14:21:31.759849 kernel: ACPI: BGRT 0x000000003F979E98 000038 (v01 VRTUAL MICROSFT 00000001 MSFT 00000001) Sep 2 14:21:31.759855 kernel: ACPI: SPCR: console: pl011,mmio32,0xeffec000,115200 Sep 2 14:21:31.759860 kernel: ACPI: SRAT: Node 0 PXM 0 [mem 0x00000000-0x3fffffff] hotplug Sep 2 14:21:31.759864 kernel: ACPI: SRAT: Node 0 PXM 0 [mem 0x100000000-0x1bfffffff] hotplug Sep 2 14:21:31.759868 kernel: ACPI: SRAT: Node 0 PXM 0 [mem 0x1c0000000-0xfbfffffff] hotplug Sep 2 14:21:31.759873 kernel: ACPI: SRAT: Node 0 PXM 0 [mem 0x1000000000-0xffffffffff] hotplug Sep 2 14:21:31.759878 kernel: ACPI: SRAT: Node 0 PXM 0 [mem 0x10000000000-0x1ffffffffff] hotplug Sep 2 14:21:31.759882 kernel: ACPI: SRAT: Node 0 PXM 0 [mem 0x20000000000-0x3ffffffffff] hotplug Sep 2 14:21:31.759887 kernel: ACPI: SRAT: Node 0 PXM 0 [mem 0x40000000000-0x7ffffffffff] hotplug Sep 2 14:21:31.759892 kernel: ACPI: SRAT: Node 0 PXM 0 [mem 0x80000000000-0xfffffffffff] hotplug Sep 2 14:21:31.759898 kernel: ACPI: SRAT: Node 0 PXM 0 [mem 0x100000000000-0x1fffffffffff] hotplug Sep 2 14:21:31.759903 kernel: ACPI: SRAT: Node 0 PXM 0 [mem 0x200000000000-0x3fffffffffff] hotplug Sep 2 14:21:31.759908 kernel: ACPI: SRAT: Node 0 PXM 0 [mem 0x400000000000-0x7fffffffffff] hotplug Sep 2 14:21:31.759913 kernel: ACPI: SRAT: Node 0 PXM 0 [mem 0x800000000000-0xffffffffffff] hotplug Sep 2 14:21:31.759918 kernel: NUMA: Node 0 [mem 0x00000000-0x3fffffff] + [mem 0x100000000-0x1bfffffff] -> [mem 0x00000000-0x1bfffffff] Sep 2 14:21:31.759923 kernel: NODE_DATA(0) allocated [mem 0x1bf7ffa00-0x1bf806fff] Sep 2 14:21:31.759927 kernel: Zone ranges: Sep 2 14:21:31.759932 kernel: DMA [mem 0x0000000000000000-0x00000000ffffffff] Sep 2 14:21:31.759936 kernel: DMA32 empty Sep 2 14:21:31.759943 kernel: Normal [mem 0x0000000100000000-0x00000001bfffffff] Sep 2 14:21:31.759948 kernel: Device empty Sep 2 14:21:31.759954 kernel: Movable zone start for each node Sep 2 14:21:31.759958 kernel: Early memory node ranges Sep 2 14:21:31.759964 kernel: node 0: [mem 0x0000000000000000-0x00000000007fffff] Sep 2 14:21:31.759969 kernel: node 0: [mem 0x0000000000824000-0x000000003f38ffff] Sep 2 14:21:31.759974 kernel: node 0: [mem 0x000000003f390000-0x000000003f93ffff] Sep 2 14:21:31.759979 kernel: node 0: [mem 0x000000003f940000-0x000000003f9effff] Sep 2 14:21:31.759985 kernel: node 0: [mem 0x000000003f9f0000-0x000000003fdeffff] Sep 2 14:21:31.759989 kernel: node 0: [mem 0x000000003fdf0000-0x000000003fffffff] Sep 2 14:21:31.759993 kernel: node 0: [mem 0x0000000100000000-0x00000001bfffffff] Sep 2 14:21:31.759998 kernel: Initmem setup node 0 [mem 0x0000000000000000-0x00000001bfffffff] Sep 2 14:21:31.760002 kernel: On node 0, zone DMA: 36 pages in unavailable ranges Sep 2 14:21:31.760007 kernel: cma: Reserved 16 MiB at 0x000000003ca00000 Sep 2 14:21:31.760012 kernel: psci: probing for conduit method from ACPI. Sep 2 14:21:31.760018 kernel: psci: PSCIv1.3 detected in firmware. Sep 2 14:21:31.760024 kernel: psci: Using standard PSCI v0.2 function IDs Sep 2 14:21:31.760073 kernel: psci: MIGRATE_INFO_TYPE not supported. Sep 2 14:21:31.760080 kernel: psci: SMC Calling Convention v1.4 Sep 2 14:21:31.760084 kernel: ACPI: NUMA: SRAT: PXM 0 -> MPIDR 0x0 -> Node 0 Sep 2 14:21:31.760088 kernel: ACPI: NUMA: SRAT: PXM 0 -> MPIDR 0x1 -> Node 0 Sep 2 14:21:31.760093 kernel: percpu: Embedded 34 pages/cpu s98584 r8192 d32488 u139264 Sep 2 14:21:31.760097 kernel: pcpu-alloc: s98584 r8192 d32488 u139264 alloc=34*4096 Sep 2 14:21:31.760104 kernel: pcpu-alloc: [0] 0 [0] 1 Sep 2 14:21:31.760109 kernel: Detected PIPT I-cache on CPU0 Sep 2 14:21:31.760115 kernel: CPU features: detected: Address authentication (architected QARMA5 algorithm) Sep 2 14:21:31.760121 kernel: CPU features: detected: GICv3 CPU interface Sep 2 14:21:31.760126 kernel: CPU features: detected: Spectre-v4 Sep 2 14:21:31.760131 kernel: CPU features: detected: Spectre-BHB Sep 2 14:21:31.760135 kernel: CPU features: kernel page table isolation forced ON by KASLR Sep 2 14:21:31.760140 kernel: CPU features: detected: Kernel page table isolation (KPTI) Sep 2 14:21:31.760144 kernel: CPU features: detected: ARM erratum 2067961 or 2054223 Sep 2 14:21:31.760149 kernel: CPU features: detected: Broken broadcast TLBI completion Sep 2 14:21:31.760153 kernel: CPU features: detected: SSBS not fully self-synchronizing Sep 2 14:21:31.760159 kernel: alternatives: applying boot alternatives Sep 2 14:21:31.760164 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=c9cfd75639eb1edd6d4c7c3c2e9e1a0ca6073ef436b9c2fc91bd1360b566dd7f Sep 2 14:21:31.760169 kernel: printk: log buffer data + meta data: 262144 + 917504 = 1179648 bytes Sep 2 14:21:31.760175 kernel: Dentry cache hash table entries: 524288 (order: 10, 4194304 bytes, linear) Sep 2 14:21:31.760180 kernel: Inode-cache hash table entries: 262144 (order: 9, 2097152 bytes, linear) Sep 2 14:21:31.760184 kernel: software IO TLB: area num 2. Sep 2 14:21:31.760189 kernel: software IO TLB: mapped [mem 0x0000000034ce0000-0x0000000038ce0000] (64MB) Sep 2 14:21:31.760194 kernel: Fallback order for Node 0: 0 Sep 2 14:21:31.760200 kernel: Built 1 zonelists, mobility grouping on. Total pages: 1048540 Sep 2 14:21:31.760204 kernel: Policy zone: Normal Sep 2 14:21:31.760209 kernel: mem auto-init: stack:off, heap alloc:off, heap free:off Sep 2 14:21:31.760213 kernel: SLUB: HWalign=64, Order=0-3, MinObjects=0, CPUs=2, Nodes=1 Sep 2 14:21:31.760219 kernel: rcu: Preemptible hierarchical RCU implementation. Sep 2 14:21:31.760224 kernel: rcu: RCU event tracing is enabled. Sep 2 14:21:31.760230 kernel: rcu: RCU restricting CPUs from NR_CPUS=512 to nr_cpu_ids=2. Sep 2 14:21:31.760234 kernel: Trampoline variant of Tasks RCU enabled. Sep 2 14:21:31.760239 kernel: Tracing variant of Tasks RCU enabled. Sep 2 14:21:31.760243 kernel: rcu: RCU calculated value of scheduler-enlistment delay is 100 jiffies. Sep 2 14:21:31.760248 kernel: rcu: Adjusting geometry for rcu_fanout_leaf=16, nr_cpu_ids=2 Sep 2 14:21:31.760252 kernel: RCU Tasks: Setting shift to 1 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=2. Sep 2 14:21:31.760257 kernel: RCU Tasks Trace: Setting shift to 1 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=2. Sep 2 14:21:31.760262 kernel: NR_IRQS: 64, nr_irqs: 64, preallocated irqs: 0 Sep 2 14:21:31.760267 kernel: GICv3: 960 SPIs implemented Sep 2 14:21:31.760271 kernel: GICv3: 0 Extended SPIs implemented Sep 2 14:21:31.760276 kernel: Root IRQ handler: gic_handle_irq Sep 2 14:21:31.760280 kernel: GICv3: GICv3 features: 16 PPIs, RSS Sep 2 14:21:31.760287 kernel: GICv3: GICD_CTLR.DS=0, SCR_EL3.FIQ=0 Sep 2 14:21:31.760293 kernel: GICv3: CPU0: found redistributor 0 region 0:0x00000000effee000 Sep 2 14:21:31.760297 kernel: ITS: No ITS available, not enabling LPIs Sep 2 14:21:31.760302 kernel: rcu: srcu_init: Setting srcu_struct sizes based on contention. Sep 2 14:21:31.760306 kernel: clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1911260446275000 ns Sep 2 14:21:31.760311 kernel: arch_timer: cp15 timer running at 1000.00MHz (virt). Sep 2 14:21:31.760315 kernel: clocksource: arch_sys_counter: mask: 0x1fffffffffffffff max_cycles: 0x1cd42e4dffb, max_idle_ns: 881590591483 ns Sep 2 14:21:31.760320 kernel: sched_clock: 61 bits at 1000MHz, resolution 1ns, wraps every 4398046511103ns Sep 2 14:21:31.760325 kernel: Console: colour dummy device 80x25 Sep 2 14:21:31.760330 kernel: printk: legacy console [tty1] enabled Sep 2 14:21:31.760336 kernel: ACPI: Core revision 20250807 Sep 2 14:21:31.760342 kernel: Calibrating delay loop (skipped), value calculated using timer frequency.. 2000.00 BogoMIPS (lpj=1000000) Sep 2 14:21:31.760346 kernel: pid_max: default: 32768 minimum: 301 Sep 2 14:21:31.760352 kernel: LSM: initializing lsm=lockdown,capability,landlock,selinux,ima Sep 2 14:21:31.760357 kernel: landlock: Up and running. Sep 2 14:21:31.760362 kernel: SELinux: Initializing. Sep 2 14:21:31.760367 kernel: Mount-cache hash table entries: 8192 (order: 4, 65536 bytes, linear) Sep 2 14:21:31.760372 kernel: Mountpoint-cache hash table entries: 8192 (order: 4, 65536 bytes, linear) Sep 2 14:21:31.760382 kernel: Hyper-V: privilege flags low 0x2e7f, high 0x3b8030, hints 0xa0000e, misc 0x31e1 Sep 2 14:21:31.760387 kernel: Hyper-V: Host Build 10.0.26102.1405-1-0 Sep 2 14:21:31.760392 kernel: Hyper-V: enabling crash_kexec_post_notifiers Sep 2 14:21:31.760397 kernel: rcu: Hierarchical SRCU implementation. Sep 2 14:21:31.760403 kernel: rcu: Max phase no-delay instances is 400. Sep 2 14:21:31.760411 kernel: Timer migration: 1 hierarchy levels; 8 children per group; 1 crossnode level Sep 2 14:21:31.760416 kernel: Remapping and enabling EFI services. Sep 2 14:21:31.760421 kernel: smp: Bringing up secondary CPUs ... Sep 2 14:21:31.760426 kernel: Detected PIPT I-cache on CPU1 Sep 2 14:21:31.760431 kernel: GICv3: CPU1: found redistributor 1 region 1:0x00000000f000e000 Sep 2 14:21:31.760436 kernel: CPU1: Booted secondary processor 0x0000000001 [0x410fd490] Sep 2 14:21:31.760441 kernel: smp: Brought up 1 node, 2 CPUs Sep 2 14:21:31.760447 kernel: SMP: Total of 2 processors activated. Sep 2 14:21:31.760452 kernel: CPU: All CPU(s) started at EL1 Sep 2 14:21:31.760457 kernel: CPU features: detected: 32-bit EL0 Support Sep 2 14:21:31.760462 kernel: CPU features: detected: Instruction cache invalidation not required for I/D coherence Sep 2 14:21:31.760467 kernel: CPU features: detected: Data cache clean to the PoU not required for I/D coherence Sep 2 14:21:31.760472 kernel: CPU features: detected: Common not Private translations Sep 2 14:21:31.760477 kernel: CPU features: detected: CRC32 instructions Sep 2 14:21:31.760482 kernel: CPU features: detected: Generic authentication (architected QARMA5 algorithm) Sep 2 14:21:31.760489 kernel: CPU features: detected: RCpc load-acquire (LDAPR) Sep 2 14:21:31.760494 kernel: CPU features: detected: LSE atomic instructions Sep 2 14:21:31.760498 kernel: CPU features: detected: Privileged Access Never Sep 2 14:21:31.760503 kernel: CPU features: detected: PMUv3 Sep 2 14:21:31.760508 kernel: CPU features: detected: Speculation barrier (SB) Sep 2 14:21:31.760513 kernel: CPU features: detected: TLB range maintenance instructions Sep 2 14:21:31.760519 kernel: CPU features: detected: Speculative Store Bypassing Safe (SSBS) Sep 2 14:21:31.760525 kernel: CPU features: detected: Scalable Vector Extension Sep 2 14:21:31.760530 kernel: alternatives: applying system-wide alternatives Sep 2 14:21:31.760535 kernel: CPU features: detected: Hardware dirty bit management on CPU0-1 Sep 2 14:21:31.760539 kernel: SVE: maximum available vector length 16 bytes per vector Sep 2 14:21:31.760545 kernel: SVE: default vector length 16 bytes per vector Sep 2 14:21:31.760551 kernel: Memory: 3978036K/4194160K available (11968K kernel code, 2486K rwdata, 9588K rodata, 12928K init, 981K bss, 194808K reserved, 16384K cma-reserved) Sep 2 14:21:31.760557 kernel: devtmpfs: initialized Sep 2 14:21:31.760562 kernel: posixtimers hash table entries: 1024 (order: 2, 16384 bytes, linear) Sep 2 14:21:31.760567 kernel: futex hash table entries: 512 (32768 bytes on 1 NUMA nodes, total 32 KiB, linear). Sep 2 14:21:31.760572 kernel: 2G module region forced by RANDOMIZE_MODULE_REGION_FULL Sep 2 14:21:31.760576 kernel: 0 pages in range for non-PLT usage Sep 2 14:21:31.760581 kernel: 514736 pages in range for PLT usage Sep 2 14:21:31.760586 kernel: pinctrl core: initialized pinctrl subsystem Sep 2 14:21:31.760591 kernel: SMBIOS 3.1.0 present. Sep 2 14:21:31.760596 kernel: DMI: Microsoft Corporation Virtual Machine/Virtual Machine, BIOS Hyper-V UEFI Release v4.1 01/08/2026 Sep 2 14:21:31.760601 kernel: DMI: Memory slots populated: 2/2 Sep 2 14:21:31.760606 kernel: NET: Registered PF_NETLINK/PF_ROUTE protocol family Sep 2 14:21:31.760611 kernel: DMA: preallocated 512 KiB GFP_KERNEL pool for atomic allocations Sep 2 14:21:31.760616 kernel: DMA: preallocated 512 KiB GFP_KERNEL|GFP_DMA pool for atomic allocations Sep 2 14:21:31.760621 kernel: DMA: preallocated 512 KiB GFP_KERNEL|GFP_DMA32 pool for atomic allocations Sep 2 14:21:31.760626 kernel: audit: initializing netlink subsys (disabled) Sep 2 14:21:31.760632 kernel: audit: type=2000 audit(0.061:1): state=initialized audit_enabled=0 res=1 Sep 2 14:21:31.760636 kernel: thermal_sys: Registered thermal governor 'step_wise' Sep 2 14:21:31.760641 kernel: cpuidle: using governor menu Sep 2 14:21:31.760646 kernel: hw-breakpoint: found 6 breakpoint and 4 watchpoint registers. Sep 2 14:21:31.760651 kernel: ASID allocator initialised with 32768 entries Sep 2 14:21:31.760656 kernel: acpiphp: ACPI Hot Plug PCI Controller Driver version: 0.5 Sep 2 14:21:31.760661 kernel: Serial: AMBA PL011 UART driver Sep 2 14:21:31.760666 kernel: HugeTLB: registered 1.00 GiB page size, pre-allocated 0 pages Sep 2 14:21:31.760671 kernel: HugeTLB: 0 KiB vmemmap can be freed for a 1.00 GiB page Sep 2 14:21:31.760676 kernel: HugeTLB: registered 32.0 MiB page size, pre-allocated 0 pages Sep 2 14:21:31.760681 kernel: HugeTLB: 0 KiB vmemmap can be freed for a 32.0 MiB page Sep 2 14:21:31.760686 kernel: HugeTLB: registered 2.00 MiB page size, pre-allocated 0 pages Sep 2 14:21:31.760691 kernel: HugeTLB: 0 KiB vmemmap can be freed for a 2.00 MiB page Sep 2 14:21:31.760697 kernel: HugeTLB: registered 64.0 KiB page size, pre-allocated 0 pages Sep 2 14:21:31.760703 kernel: HugeTLB: 0 KiB vmemmap can be freed for a 64.0 KiB page Sep 2 14:21:31.760708 kernel: ACPI: Added _OSI(Module Device) Sep 2 14:21:31.760712 kernel: ACPI: Added _OSI(Processor Device) Sep 2 14:21:31.760717 kernel: ACPI: Added _OSI(Processor Aggregator Device) Sep 2 14:21:31.760722 kernel: ACPI: 1 ACPI AML tables successfully acquired and loaded Sep 2 14:21:31.760727 kernel: ACPI: Interpreter enabled Sep 2 14:21:31.760732 kernel: ACPI: Using GIC for interrupt routing Sep 2 14:21:31.760737 kernel: ARMH0011:00: ttyAMA0 at MMIO 0xeffec000 (irq = 12, base_baud = 0) is a SBSA Sep 2 14:21:31.760742 kernel: printk: console [ttyAMA0] enabled Sep 2 14:21:31.760747 kernel: printk: legacy bootconsole [pl11] disabled Sep 2 14:21:31.760752 kernel: ARMH0011:01: ttyAMA1 at MMIO 0xeffeb000 (irq = 13, base_baud = 0) is a SBSA Sep 2 14:21:31.760757 kernel: ACPI: CPU0 has been hot-added Sep 2 14:21:31.760762 kernel: ACPI: CPU1 has been hot-added Sep 2 14:21:31.760766 kernel: iommu: Default domain type: Translated Sep 2 14:21:31.760772 kernel: iommu: DMA domain TLB invalidation policy: strict mode Sep 2 14:21:31.760777 kernel: efivars: Registered efivars operations Sep 2 14:21:31.760782 kernel: hv_vmbus: hv_mmio=[mem 0x40000000-0xfed3ffff],[mem 0xfc0000000-0xfffffffff] fb=[mem 0x40000000-0x47ffffff] Sep 2 14:21:31.760787 kernel: hv_vmbus: Vmbus version:5.3 Sep 2 14:21:31.760792 kernel: vgaarb: loaded Sep 2 14:21:31.760797 kernel: clocksource: Switched to clocksource arch_sys_counter Sep 2 14:21:31.760801 kernel: VFS: Disk quotas dquot_6.6.0 Sep 2 14:21:31.760806 kernel: VFS: Dquot-cache hash table entries: 512 (order 0, 4096 bytes) Sep 2 14:21:31.760812 kernel: pnp: PnP ACPI init Sep 2 14:21:31.760816 kernel: pnp: PnP ACPI: found 0 devices Sep 2 14:21:31.760821 kernel: NET: Registered PF_INET protocol family Sep 2 14:21:31.760826 kernel: IP idents hash table entries: 65536 (order: 7, 524288 bytes, linear) Sep 2 14:21:31.760831 kernel: tcp_listen_portaddr_hash hash table entries: 2048 (order: 3, 32768 bytes, linear) Sep 2 14:21:31.760836 kernel: Table-perturb hash table entries: 65536 (order: 6, 262144 bytes, linear) Sep 2 14:21:31.760841 kernel: TCP established hash table entries: 32768 (order: 6, 262144 bytes, linear) Sep 2 14:21:31.760846 kernel: TCP bind hash table entries: 32768 (order: 8, 1048576 bytes, linear) Sep 2 14:21:31.760851 kernel: TCP: Hash tables configured (established 32768 bind 32768) Sep 2 14:21:31.760856 kernel: UDP hash table entries: 2048 (order: 5, 131072 bytes, linear) Sep 2 14:21:31.760861 kernel: UDP-Lite hash table entries: 2048 (order: 5, 131072 bytes, linear) Sep 2 14:21:31.760866 kernel: NET: Registered PF_UNIX/PF_LOCAL protocol family Sep 2 14:21:31.760871 kernel: PCI: CLS 0 bytes, default 64 Sep 2 14:21:31.760876 kernel: kvm [1]: HYP mode not available Sep 2 14:21:31.760881 kernel: Initialise system trusted keyrings Sep 2 14:21:31.760886 kernel: workingset: timestamp_bits=39 max_order=20 bucket_order=0 Sep 2 14:21:31.760891 kernel: Key type asymmetric registered Sep 2 14:21:31.760896 kernel: Asymmetric key parser 'x509' registered Sep 2 14:21:31.760901 kernel: Block layer SCSI generic (bsg) driver version 0.4 loaded (major 248) Sep 2 14:21:31.760905 kernel: io scheduler mq-deadline registered Sep 2 14:21:31.760910 kernel: io scheduler kyber registered Sep 2 14:21:31.760916 kernel: io scheduler bfq registered Sep 2 14:21:31.760921 kernel: Serial: 8250/16550 driver, 4 ports, IRQ sharing enabled Sep 2 14:21:31.760926 kernel: thunder_xcv, ver 1.0 Sep 2 14:21:31.760930 kernel: thunder_bgx, ver 1.0 Sep 2 14:21:31.760935 kernel: nicpf, ver 1.0 Sep 2 14:21:31.760940 kernel: nicvf, ver 1.0 Sep 2 14:21:31.760945 kernel: hv_vmbus: registering driver hyperv_keyboard Sep 2 14:21:31.761136 kernel: rtc-efi rtc-efi.0: registered as rtc0 Sep 2 14:21:31.761225 kernel: rtc-efi rtc-efi.0: setting system clock to 2026-09-02T14:21:24 UTC (1788358884) Sep 2 14:21:31.761232 kernel: efifb: probing for efifb Sep 2 14:21:31.761237 kernel: efifb: framebuffer at 0x40000000, using 3072k, total 3072k Sep 2 14:21:31.761242 kernel: efifb: mode is 1024x768x32, linelength=4096, pages=1 Sep 2 14:21:31.761246 kernel: efifb: scrolling: redraw Sep 2 14:21:31.761254 kernel: efifb: Truecolor: size=8:8:8:8, shift=24:16:8:0 Sep 2 14:21:31.761259 kernel: Console: switching to colour frame buffer device 128x48 Sep 2 14:21:31.761263 kernel: fb0: EFI VGA frame buffer device Sep 2 14:21:31.761268 kernel: SMCCC: SOC_ID: ARCH_SOC_ID not implemented, skipping .... Sep 2 14:21:31.761273 kernel: hid: raw HID events driver (C) Jiri Kosina Sep 2 14:21:31.761278 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 2 14:21:31.761283 kernel: hw perfevents: enabled with armv8_pmuv3_0 PMU driver, 7 (0,8000003f) counters available Sep 2 14:21:31.761289 kernel: watchdog: NMI not fully supported Sep 2 14:21:31.761294 kernel: watchdog: Hard watchdog permanently disabled Sep 2 14:21:31.761299 kernel: NET: Registered PF_INET6 protocol family Sep 2 14:21:31.761304 kernel: Segment Routing with IPv6 Sep 2 14:21:31.761309 kernel: In-situ OAM (IOAM) with IPv6 Sep 2 14:21:31.761314 kernel: NET: Registered PF_PACKET protocol family Sep 2 14:21:31.761319 kernel: Key type dns_resolver registered Sep 2 14:21:31.761323 kernel: registered taskstats version 1 Sep 2 14:21:31.761329 kernel: Loading compiled-in X.509 certificates Sep 2 14:21:31.761334 kernel: Loaded X.509 cert 'Kinvolk GmbH: Module signing key for 6.18.45-flatcar: 8298417029022bb3522d777abb0ea574563aa571' Sep 2 14:21:31.761339 kernel: Demotion targets for Node 0: null Sep 2 14:21:31.761344 kernel: Key type .fscrypt registered Sep 2 14:21:31.761349 kernel: Key type fscrypt-provisioning registered Sep 2 14:21:31.761354 kernel: ima: No TPM chip found, activating TPM-bypass! Sep 2 14:21:31.761359 kernel: ima: Allocated hash algorithm: sha1 Sep 2 14:21:31.761364 kernel: ima: No architecture policies found Sep 2 14:21:31.761369 kernel: alg: No test for fips(ansi_cprng) (fips_ansi_cprng) Sep 2 14:21:31.761374 kernel: clk: Disabling unused clocks Sep 2 14:21:31.761379 kernel: PM: genpd: Disabling unused power domains Sep 2 14:21:31.761384 kernel: Freeing unused kernel memory: 12928K Sep 2 14:21:31.761389 kernel: Run /init as init process Sep 2 14:21:31.761394 kernel: with arguments: Sep 2 14:21:31.761399 kernel: /init Sep 2 14:21:31.761404 kernel: with environment: Sep 2 14:21:31.761409 kernel: HOME=/ Sep 2 14:21:31.761414 kernel: TERM=linux Sep 2 14:21:31.761418 kernel: pps_core: LinuxPPS API ver. 1 registered Sep 2 14:21:31.761423 kernel: pps_core: Software ver. 5.3.6 - Copyright 2005-2007 Rodolfo Giometti Sep 2 14:21:31.761428 kernel: PTP clock support registered Sep 2 14:21:31.761434 kernel: hv_utils: Registering HyperV Utility Driver Sep 2 14:21:31.761439 kernel: hv_vmbus: registering driver hv_utils Sep 2 14:21:31.761443 kernel: hv_utils: Heartbeat IC version 3.0 Sep 2 14:21:31.761448 kernel: hv_utils: Shutdown IC version 3.2 Sep 2 14:21:31.761453 kernel: hv_utils: TimeSync IC version 4.0 Sep 2 14:21:31.761458 kernel: hv_vmbus: registering driver hid_hyperv Sep 2 14:21:31.761463 kernel: input: Microsoft Vmbus HID-compliant Mouse as /devices/0006:045E:0621.0001/input/input1 Sep 2 14:21:31.761561 kernel: hid-hyperv 0006:045E:0621.0001: input: VIRTUAL HID v0.01 Mouse [Microsoft Vmbus HID-compliant Mouse] on Sep 2 14:21:31.761568 kernel: SCSI subsystem initialized Sep 2 14:21:31.761573 kernel: hv_vmbus: registering driver hv_storvsc Sep 2 14:21:31.761683 kernel: scsi host0: storvsc_host_t Sep 2 14:21:31.761780 kernel: scsi host1: storvsc_host_t Sep 2 14:21:31.761887 kernel: scsi 1:0:0:0: Direct-Access Msft Virtual Disk 1.0 PQ: 0 ANSI: 5 Sep 2 14:21:31.761995 kernel: scsi 1:0:0:2: CD-ROM Msft Virtual DVD-ROM 1.0 PQ: 0 ANSI: 5 Sep 2 14:21:31.762107 kernel: sd 1:0:0:0: [sda] 63737856 512-byte logical blocks: (32.6 GB/30.4 GiB) Sep 2 14:21:31.762206 kernel: sd 1:0:0:0: [sda] 4096-byte physical blocks Sep 2 14:21:31.762304 kernel: sd 1:0:0:0: [sda] Write Protect is off Sep 2 14:21:31.762403 kernel: sd 1:0:0:0: [sda] Mode Sense: 0f 00 10 00 Sep 2 14:21:31.762504 kernel: sd 1:0:0:0: [sda] Write cache: disabled, read cache: enabled, supports DPO and FUA Sep 2 14:21:31.762511 kernel: sda: sda1 sda2 sda3 sda4 sda6 sda7 sda9 Sep 2 14:21:31.762606 kernel: sd 1:0:0:0: [sda] Attached SCSI disk Sep 2 14:21:31.762703 kernel: sr 1:0:0:2: [sr0] scsi-1 drive Sep 2 14:21:31.762710 kernel: cdrom: Uniform CD-ROM driver Revision: 3.20 Sep 2 14:21:31.762805 kernel: sr 1:0:0:2: Attached scsi CD-ROM sr0 Sep 2 14:21:31.762811 kernel: device-mapper: core: CONFIG_IMA_DISABLE_HTABLE is disabled. Duplicate IMA measurements will not be recorded in the IMA log. Sep 2 14:21:31.762818 kernel: device-mapper: uevent: version 1.0.3 Sep 2 14:21:31.762823 kernel: device-mapper: ioctl: 4.50.0-ioctl (2025-04-28) initialised: dm-devel@lists.linux.dev Sep 2 14:21:31.762828 kernel: device-mapper: verity: sha256 using "sha256-lib" Sep 2 14:21:31.762833 kernel: raid6: neonx8 gen() 18553 MB/s Sep 2 14:21:31.762838 kernel: raid6: neonx4 gen() 18590 MB/s Sep 2 14:21:31.762843 kernel: raid6: neonx2 gen() 17260 MB/s Sep 2 14:21:31.762847 kernel: raid6: neonx1 gen() 15095 MB/s Sep 2 14:21:31.762853 kernel: raid6: int64x8 gen() 8885 MB/s Sep 2 14:21:31.762858 kernel: raid6: int64x4 gen() 10450 MB/s Sep 2 14:21:31.762863 kernel: raid6: int64x2 gen() 8692 MB/s Sep 2 14:21:31.762868 kernel: raid6: int64x1 gen() 6641 MB/s Sep 2 14:21:31.762873 kernel: raid6: using algorithm neonx4 gen() 18590 MB/s Sep 2 14:21:31.762878 kernel: raid6: .... xor() 14764 MB/s, rmw enabled Sep 2 14:21:31.762883 kernel: raid6: using neon recovery algorithm Sep 2 14:21:31.762889 kernel: xor: measuring software checksum speed Sep 2 14:21:31.762893 kernel: 8regs : 29591 MB/sec Sep 2 14:21:31.762898 kernel: 32regs : 28238 MB/sec Sep 2 14:21:31.762903 kernel: arm64_neon : 37384 MB/sec Sep 2 14:21:31.762908 kernel: xor: using function: arm64_neon (37384 MB/sec) Sep 2 14:21:31.762913 kernel: Btrfs loaded, zoned=no, fsverity=no Sep 2 14:21:31.762918 kernel: BTRFS: device fsid 38c2e8cb-ee9d-41a6-a840-865be9c275e5 devid 1 transid 39 /dev/mapper/usr (254:0) scanned by mount (185) Sep 2 14:21:31.762924 kernel: BTRFS info (device dm-0): first mount of filesystem 38c2e8cb-ee9d-41a6-a840-865be9c275e5 Sep 2 14:21:31.762929 kernel: BTRFS info (device dm-0): using crc32c (crc32c-lib) checksum algorithm Sep 2 14:21:31.762934 kernel: BTRFS info (device dm-0 state E): disabling log replay at mount time Sep 2 14:21:31.762939 kernel: BTRFS info (device dm-0 state E): enabling free space tree Sep 2 14:21:31.762944 kernel: loop: module loaded Sep 2 14:21:31.762949 kernel: loop0: detected capacity change from 0 to 100648 Sep 2 14:21:31.762954 kernel: squashfs: version 4.0 (2009/01/31) Phillip Lougher Sep 2 14:21:31.762961 systemd[1]: Successfully made /usr/ read-only. Sep 2 14:21:31.762968 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 2 14:21:31.762974 systemd[1]: Detected virtualization microsoft. Sep 2 14:21:31.762979 systemd[1]: Detected architecture arm64. Sep 2 14:21:31.762984 systemd[1]: Running in initrd. Sep 2 14:21:31.762989 systemd[1]: Initializing machine ID from random generator. Sep 2 14:21:31.762996 systemd[1]: No hostname configured, using default hostname. Sep 2 14:21:31.763001 systemd[1]: Hostname set to . Sep 2 14:21:31.763006 (gene[219]: '/usr/lib/systemd/system-generators/dracut-crypt-generator' failed with exit status 2. Sep 2 14:21:31.763012 systemd[1]: Queued start job for default target initrd.target. Sep 2 14:21:31.763017 systemd[1]: Started clevis-luks-askpass.path - Forward Password Requests to Clevis Directory Watch. Sep 2 14:21:31.763023 systemd[1]: Started systemd-ask-password-console.path - Dispatch Password Requests to Console Directory Watch. Sep 2 14:21:31.763036 systemd[1]: Expecting device dev-disk-by\x2dlabel-EFI\x2dSYSTEM.device - /dev/disk/by-label/EFI-SYSTEM... Sep 2 14:21:31.763041 systemd[1]: Expecting device dev-disk-by\x2dlabel-OEM.device - /dev/disk/by-label/OEM... Sep 2 14:21:31.763047 systemd[1]: Expecting device dev-disk-by\x2dlabel-ROOT.device - /dev/disk/by-label/ROOT... Sep 2 14:21:31.763052 systemd[1]: Expecting device dev-disk-by\x2dpartlabel-USR\x2dA.device - /dev/disk/by-partlabel/USR-A... Sep 2 14:21:31.763058 systemd[1]: Expecting device dev-mapper-usr.device - /dev/mapper/usr... Sep 2 14:21:31.763064 systemd[1]: Reached target cryptsetup-pre.target - Local Encrypted Volumes (Pre). Sep 2 14:21:31.763070 systemd[1]: Reached target cryptsetup.target - Local Encrypted Volumes. Sep 2 14:21:31.763075 systemd[1]: Reached target initrd-usr-fs.target - Initrd /usr File System. Sep 2 14:21:31.763080 systemd[1]: Reached target paths.target - Path Units. Sep 2 14:21:31.763086 systemd[1]: Reached target slices.target - Slice Units. Sep 2 14:21:31.763091 systemd[1]: Reached target swap.target - Swaps. Sep 2 14:21:31.763096 systemd[1]: Reached target timers.target - Timer Units. Sep 2 14:21:31.763102 systemd[1]: Listening on iscsid.socket - Open-iSCSI iscsid Socket. Sep 2 14:21:31.763108 systemd[1]: Listening on iscsiuio.socket - Open-iSCSI iscsiuio Socket. Sep 2 14:21:31.763113 systemd[1]: Listening on systemd-coredump.socket - Process Core Dump Socket. Sep 2 14:21:31.763123 systemd[1]: Listening on systemd-journald-audit.socket - Journal Audit Socket. Sep 2 14:21:31.763129 systemd[1]: Listening on systemd-journald-dev-log.socket - Journal Socket (/dev/log). Sep 2 14:21:31.763135 systemd[1]: Listening on systemd-journald.socket - Journal Sockets. Sep 2 14:21:31.763141 systemd[1]: Listening on systemd-networkd-resolve-hook.socket - Network Management Resolve Hook Socket. Sep 2 14:21:31.763146 systemd[1]: Listening on systemd-networkd.socket - Network Management Netlink Socket. Sep 2 14:21:31.763152 systemd[1]: Listening on systemd-udevd-control.socket - udev Control Socket. Sep 2 14:21:31.763157 systemd[1]: Listening on systemd-udevd-kernel.socket - udev Kernel Socket. Sep 2 14:21:31.763164 systemd[1]: Reached target sockets.target - Socket Units. Sep 2 14:21:31.763169 systemd[1]: afterburn-network-kargs.service - Afterburn Initrd Setup Network Kernel Arguments skipped, no trigger condition checks were met. Sep 2 14:21:31.763176 systemd[1]: Starting ignition-setup-pre.service - Ignition env setup... Sep 2 14:21:31.763181 systemd[1]: Starting kmod-static-nodes.service - Create List of Static Device Nodes... Sep 2 14:21:31.763187 systemd[1]: Finished network-cleanup.service - Network Cleanup. Sep 2 14:21:31.763192 systemd[1]: systemd-battery-check.service - Early Battery Level Check skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/class/power_supply Sep 2 14:21:31.763198 systemd[1]: Starting systemd-journald.service - Journal Service... Sep 2 14:21:31.763205 systemd[1]: Starting systemd-modules-load.service - Load Kernel Modules... Sep 2 14:21:31.763210 systemd[1]: Starting systemd-vconsole-setup.service - Virtual Console Setup... Sep 2 14:21:31.763216 systemd[1]: Finished ignition-setup-pre.service - Ignition env setup. Sep 2 14:21:31.763221 systemd[1]: Finished kmod-static-nodes.service - Create List of Static Device Nodes. Sep 2 14:21:31.763227 systemd[1]: Starting systemd-tmpfiles-setup-dev-early.service - Create Static Device Nodes in /dev gracefully... Sep 2 14:21:31.763233 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 2 14:21:31.763238 kernel: Bridge firewalling registered Sep 2 14:21:31.763244 systemd[1]: Finished systemd-modules-load.service - Load Kernel Modules. Sep 2 14:21:31.763249 systemd[1]: Starting systemd-sysctl.service - Apply Kernel Variables... Sep 2 14:21:31.763269 systemd-journald[374]: Collecting audit messages is enabled. Sep 2 14:21:31.763285 systemd-journald[374]: Journal started Sep 2 14:21:31.763299 systemd-journald[374]: Runtime Journal (/run/log/journal/6ebaf897315e4534b935316178720b2a) is 8M, max 78.3M, 70.3M free. Sep 2 14:21:31.600068 systemd-modules-load[379]: Using 2 probe threads Sep 2 14:21:31.722570 systemd-modules-load[379]: Inserted module 'br_netfilter' Sep 2 14:21:31.787736 systemd[1]: Finished systemd-tmpfiles-setup-dev-early.service - Create Static Device Nodes in /dev gracefully. Sep 2 14:21:31.791114 systemd-vconsole-setup[382]: Configuration of first virtual console was skipped, ignoring remaining ones. Sep 2 14:21:31.793000 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 2 14:21:31.817815 systemd[1]: Started systemd-journald.service - Journal Service. Sep 2 14:21:31.817842 kernel: audit: type=1130 audit(1788358891.793:2): 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 2 14:21:31.822000 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 2 14:21:31.825037 kernel: audit: type=1130 audit(1788358891.822:3): 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 2 14:21:31.835318 systemd[1]: Finished systemd-vconsole-setup.service - Virtual Console Setup. Sep 2 14:21:31.840000 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 2 14:21:31.857456 kernel: audit: type=1130 audit(1788358891.840:4): 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 2 14:21:31.841388 systemd[1]: systemd-sysctl.service: Deactivated successfully. Sep 2 14:21:31.842811 systemd[1]: Finished systemd-sysctl.service - Apply Kernel Variables. Sep 2 14:21:31.870000 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 2 14:21:31.870000 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 2 14:21:31.896775 kernel: audit: type=1130 audit(1788358891.870:5): 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 2 14:21:31.896787 kernel: audit: type=1131 audit(1788358891.870:6): 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 2 14:21:31.901124 systemd[1]: Starting dracut-cmdline-ask.service - dracut ask for additional cmdline parameters... Sep 2 14:21:31.916000 audit: BPF prog-id=5 op=LOAD Sep 2 14:21:31.918046 kernel: audit: type=1334 audit(1788358891.916:7): prog-id=5 op=LOAD Sep 2 14:21:31.922109 systemd[1]: Starting systemd-resolved.service - Network Name Resolution... Sep 2 14:21:31.933106 systemd[1]: Starting systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev... Sep 2 14:21:31.955295 systemd[1]: Starting systemd-tmpfiles-setup.service - Create System Files and Directories... Sep 2 14:21:31.973201 systemd[1]: Finished systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev. Sep 2 14:21:31.979000 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 2 14:21:31.995393 kernel: audit: type=1130 audit(1788358891.979:8): 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 2 14:21:31.995290 systemd[1]: Finished dracut-cmdline-ask.service - dracut ask for additional cmdline parameters. Sep 2 14:21:31.999000 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 2 14:21:32.017050 kernel: audit: type=1130 audit(1788358891.999:9): 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 2 14:21:32.067405 systemd-tmpfiles[429]: /usr/lib/tmpfiles.d/systemd.conf:30: Duplicate line for path "/var/lib/systemd", ignoring. Sep 2 14:21:32.067462 systemd-tmpfiles[429]: /usr/lib/tmpfiles.d/var.conf:14: Duplicate line for path "/var/log", ignoring. Sep 2 14:21:32.154785 systemd[1]: Starting dracut-cmdline.service - dracut cmdline hook... Sep 2 14:21:32.170202 systemd[1]: Finished systemd-tmpfiles-setup.service - Create System Files and Directories. Sep 2 14:21:32.180000 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 2 14:21:32.186042 kernel: audit: type=1130 audit(1788358892.180:10): pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=systemd-tmpfiles-setup comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Sep 2 14:21:32.203255 dracut-cmdline[442]: dracut-111 Sep 2 14:21:32.206194 dracut-cmdline[442]: 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=c9cfd75639eb1edd6d4c7c3c2e9e1a0ca6073ef436b9c2fc91bd1360b566dd7f Sep 2 14:21:32.268413 systemd-resolved[421]: Positive Trust Anchors: Sep 2 14:21:32.268424 systemd-resolved[421]: . IN DS 20326 8 2 e06d44b80b8f1d39a95c0b0d7c65d08458e880409bbc683457104237c7f8ec8d Sep 2 14:21:32.268426 systemd-resolved[421]: . IN DS 38696 8 2 683d2d0acb8c9b712a1948b27f741219298d0a450d612c483af444a4c0fb2b16 Sep 2 14:21:32.268445 systemd-resolved[421]: 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 2 14:21:32.368392 systemd-resolved[421]: Defaulting to hostname 'linux'. Sep 2 14:21:32.372404 systemd[1]: Started systemd-resolved.service - Network Name Resolution. Sep 2 14:21:32.382094 systemd[1]: Reached target nss-lookup.target - Host and Network Name Lookups. Sep 2 14:21:32.381000 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 2 14:21:32.399043 kernel: audit: type=1130 audit(1788358892.381:11): 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 2 14:21:32.496054 kernel: Loading iSCSI transport class v2.0-870. Sep 2 14:21:32.546086 kernel: iscsi: registered transport (tcp) Sep 2 14:21:32.576055 kernel: iscsi: registered transport (qla4xxx) Sep 2 14:21:32.576110 kernel: QLogic iSCSI HBA Driver Sep 2 14:21:32.719456 systemd[1]: Starting systemd-network-generator.service - Generate Network Units from Kernel Command Line... Sep 2 14:21:32.738613 systemd[1]: Finished systemd-network-generator.service - Generate Network Units from Kernel Command Line. Sep 2 14:21:32.743000 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 2 14:21:32.745383 systemd[1]: Reached target network-pre.target - Preparation for Network. Sep 2 14:21:32.857574 systemd[1]: Finished dracut-cmdline.service - dracut cmdline hook. Sep 2 14:21:32.861000 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 2 14:21:32.864415 systemd[1]: Starting dracut-pre-udev.service - dracut pre-udev hook... Sep 2 14:21:32.873946 systemd[1]: Starting parse-ip-for-networkd.service - Write systemd-networkd units from cmdline... Sep 2 14:21:32.910397 systemd[1]: Finished dracut-pre-udev.service - dracut pre-udev hook. Sep 2 14:21:32.918000 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 2 14:21:32.919000 audit: BPF prog-id=6 op=LOAD Sep 2 14:21:32.919000 audit: BPF prog-id=7 op=LOAD Sep 2 14:21:32.921497 systemd[1]: Starting systemd-udevd.service - Rule-based Manager for Device Events and Files... Sep 2 14:21:32.989599 systemd[1]: Finished parse-ip-for-networkd.service - Write systemd-networkd units from cmdline. Sep 2 14:21:32.994000 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 2 14:21:33.075827 systemd-udevd[688]: Using default interface naming scheme 'v260'. Sep 2 14:21:33.089121 systemd[1]: Started systemd-udevd.service - Rule-based Manager for Device Events and Files. Sep 2 14:21:33.098000 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 2 14:21:33.102147 systemd[1]: Starting dracut-pre-trigger.service - dracut pre-trigger hook... Sep 2 14:21:33.109000 audit: BPF prog-id=8 op=LOAD Sep 2 14:21:33.119196 systemd[1]: Starting systemd-networkd.service - Network Management... Sep 2 14:21:33.137707 dracut-pre-trigger[804]: rd.md=0: removing MD RAID activation Sep 2 14:21:33.156965 systemd-networkd[806]: Failed to open nftables netlink socket. IPMasquerade= and NFTSet= settings will not be applied. Ignoring: Protocol not supported Sep 2 14:21:33.170409 systemd-networkd[806]: lo: Link UP Sep 2 14:21:33.170415 systemd-networkd[806]: lo: Gained carrier Sep 2 14:21:33.170764 systemd[1]: Started systemd-networkd.service - Network Management. Sep 2 14:21:33.180000 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 2 14:21:33.185667 systemd[1]: Finished dracut-pre-trigger.service - dracut pre-trigger hook. Sep 2 14:21:33.189000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=dracut-pre-trigger comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Sep 2 14:21:33.190858 systemd[1]: Reached target network.target - Network. Sep 2 14:21:33.202843 systemd[1]: Starting systemd-udev-trigger.service - Coldplug All udev Devices... Sep 2 14:21:33.279952 systemd[1]: Finished systemd-udev-trigger.service - Coldplug All udev Devices. Sep 2 14:21:33.285000 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 2 14:21:33.294111 systemd[1]: Starting dracut-initqueue.service - dracut initqueue hook... Sep 2 14:21:33.401047 systemd[1]: systemd-vconsole-setup.service: Deactivated successfully. Sep 2 14:21:33.405553 systemd[1]: Stopped systemd-vconsole-setup.service - Virtual Console Setup. Sep 2 14:21:33.421000 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 2 14:21:33.423024 kernel: hv_storvsc f8b3781a-1e82-4818-a1c3-63d806ec15bb: tag#213 cmd 0x85 status: scsi 0x2 srb 0x6 host 0xc0000001 Sep 2 14:21:33.438696 systemd[1]: Stopping systemd-vconsole-setup.service - Virtual Console Setup... Sep 2 14:21:33.453066 kernel: hv_vmbus: registering driver hv_netvsc Sep 2 14:21:33.453375 systemd[1]: Starting systemd-vconsole-setup.service - Virtual Console Setup... Sep 2 14:21:33.464365 systemd[1]: systemd-vconsole-setup.service: Deactivated successfully. Sep 2 14:21:33.488209 systemd[1]: Stopped systemd-vconsole-setup.service - Virtual Console Setup. Sep 2 14:21:33.498000 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 2 14:21:33.498000 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 2 14:21:33.506268 systemd[1]: Starting systemd-vconsole-setup.service - Virtual Console Setup... Sep 2 14:21:33.524245 systemd-vconsole-setup[900]: Configuration of first virtual console was skipped, ignoring remaining ones. Sep 2 14:21:33.531284 systemd[1]: Finished systemd-vconsole-setup.service - Virtual Console Setup. Sep 2 14:21:33.539000 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 2 14:21:33.545294 kernel: hv_netvsc 000d3afe-63f2-000d-3afe-63f2000d3afe eth0: VF slot 1 added Sep 2 14:21:33.564941 systemd-networkd[806]: eth0: Found matching .network file, based on potentially unpredictable interface name: /usr/lib/systemd/network/zz-default.network Sep 2 14:21:33.581623 kernel: hv_vmbus: registering driver hv_pci Sep 2 14:21:33.564949 systemd-networkd[806]: eth0: Configuring with /usr/lib/systemd/network/zz-default.network. Sep 2 14:21:33.587607 kernel: hv_pci 8019cc7e-35f6-47ec-baa5-5a3e257000b5: PCI VMBus probing: Using version 0x10004 Sep 2 14:21:33.567082 systemd-networkd[806]: eth0: Link UP Sep 2 14:21:33.567200 systemd-networkd[806]: eth0: Gained carrier Sep 2 14:21:33.567209 systemd-networkd[806]: eth0: Found matching .network file, based on potentially unpredictable interface name: /usr/lib/systemd/network/zz-default.network Sep 2 14:21:33.623805 kernel: hv_pci 8019cc7e-35f6-47ec-baa5-5a3e257000b5: PCI host bridge to bus 35f6:00 Sep 2 14:21:33.624008 kernel: pci_bus 35f6:00: root bus resource [mem 0xfc0000000-0xfc00fffff window] Sep 2 14:21:33.624153 kernel: pci_bus 35f6:00: No busn resource found for root bus, will use [bus 00-ff] Sep 2 14:21:33.624251 kernel: pci 35f6:00:02.0: [15b3:101a] type 00 class 0x020000 PCIe Endpoint Sep 2 14:21:33.628046 kernel: pci 35f6:00:02.0: BAR 0 [mem 0xfc0000000-0xfc00fffff 64bit pref] Sep 2 14:21:33.628134 kernel: pci 35f6:00:02.0: enabling Extended Tags Sep 2 14:21:33.636174 kernel: pci 35f6:00:02.0: 0.000 Gb/s available PCIe bandwidth, limited by Unknown x0 link at 35f6:00:02.0 (capable of 252.048 Gb/s with 16.0 GT/s PCIe x16 link) Sep 2 14:21:33.636367 kernel: pci_bus 35f6:00: busn_res: [bus 00-ff] end is updated to 00 Sep 2 14:21:33.637364 kernel: pci 35f6:00:02.0: BAR 0 [mem 0xfc0000000-0xfc00fffff 64bit pref]: assigned Sep 2 14:21:33.642542 systemd-networkd[806]: eth0: DHCPv4 address 10.0.0.36/24, gateway 10.0.0.1 acquired from 168.63.129.16 Sep 2 14:21:33.944372 kernel: mlx5_core 35f6:00:02.0: enabling device (0000 -> 0002) Sep 2 14:21:33.944622 kernel: mlx5_core 35f6:00:02.0: firmware version: 16.30.5026 Sep 2 14:21:33.957685 systemd[1]: Found device dev-disk-by\x2dpartlabel-USR\x2dA.device - Virtual_Disk USR-A. Sep 2 14:21:33.973125 systemd[1]: Starting disk-uuid.service - Generate new UUID for disk GPT if necessary... Sep 2 14:21:34.039933 systemd[1]: Found device dev-disk-by\x2dlabel-EFI\x2dSYSTEM.device - Virtual_Disk EFI-SYSTEM. Sep 2 14:21:34.065897 kernel: mlx5_core 35f6:00:02.0: Flow counters bulk query buffer size increased, bulk_query_len(8) Sep 2 14:21:34.077335 systemd[1]: Found device dev-disk-by\x2dlabel-OEM.device - Virtual_Disk OEM. Sep 2 14:21:34.115261 systemd[1]: Found device dev-disk-by\x2dlabel-ROOT.device - Virtual_Disk ROOT. Sep 2 14:21:34.135426 kernel: hv_netvsc 000d3afe-63f2-000d-3afe-63f2000d3afe eth0: VF registering: eth1 Sep 2 14:21:34.135619 kernel: mlx5_core 35f6:00:02.0 eth1: joined to eth0 Sep 2 14:21:34.135752 kernel: mlx5_core 35f6:00:02.0: MLX5E: StrdRq(1) RqSz(8) StrdSz(2048) RxCqeCmprss(0 basic) Sep 2 14:21:34.151117 systemd[1]: Mounting oem.mount - /oem... Sep 2 14:21:34.171072 kernel: mlx5_core 35f6:00:02.0 enP13814s1: renamed from eth1 Sep 2 14:21:34.176355 systemd-networkd[806]: eth1: Interface name change detected, renamed to enP13814s1. Sep 2 14:21:34.233169 kernel: BTRFS: device label OEM devid 1 transid 11 /dev/sda6 (8:6) scanned by mount (998) Sep 2 14:21:34.234460 systemd[1]: Finished dracut-initqueue.service - dracut initqueue hook. Sep 2 14:21:34.241818 kernel: BTRFS info (device sda6): first mount of filesystem aa4f5e6e-c55a-4573-bb4a-fa888ef9488c Sep 2 14:21:34.241847 kernel: BTRFS info (device sda6): using crc32c (crc32c-lib) checksum algorithm Sep 2 14:21:34.253000 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 2 14:21:34.254080 systemd[1]: Reached target remote-fs-pre.target - Preparation for Remote File Systems. Sep 2 14:21:34.259038 systemd[1]: Reached target remote-cryptsetup.target - Remote Encrypted Volumes. Sep 2 14:21:34.269060 systemd[1]: Reached target remote-fs.target - Remote File Systems. Sep 2 14:21:34.300663 systemd[1]: Starting dracut-pre-mount.service - dracut pre-mount hook... Sep 2 14:21:34.324042 kernel: mlx5_core 35f6:00:02.0 enP13814s1: Link up Sep 2 14:21:34.332104 systemd[1]: Finished dracut-pre-mount.service - dracut pre-mount hook. Sep 2 14:21:34.344000 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 2 14:21:34.357837 systemd-networkd[806]: enP13814s1: Link UP Sep 2 14:21:34.367854 kernel: hv_netvsc 000d3afe-63f2-000d-3afe-63f2000d3afe eth0: Data path switched to VF: enP13814s1 Sep 2 14:21:34.368632 kernel: BTRFS info (device sda6): turning on async discard Sep 2 14:21:34.368643 kernel: BTRFS info (device sda6): enabling free space tree Sep 2 14:21:34.379868 systemd[1]: Mounted oem.mount - /oem. Sep 2 14:21:34.391143 systemd[1]: Starting ignition-fetch-offline.service - Ignition (fetch-offline)... Sep 2 14:21:34.580263 systemd-networkd[806]: enP13814s1: Gained carrier Sep 2 14:21:34.612107 systemd-networkd[806]: eth0: Gained IPv6LL Sep 2 14:21:35.378562 disk-uuid[938]: Warning: The kernel is still using the old partition table. Sep 2 14:21:35.378562 disk-uuid[938]: The new table will be used at the next reboot or after you Sep 2 14:21:35.378562 disk-uuid[938]: run partprobe(8) or kpartx(8) Sep 2 14:21:35.378562 disk-uuid[938]: The operation has completed successfully. Sep 2 14:21:35.394000 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 2 14:21:35.394000 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 2 14:21:35.384509 systemd[1]: disk-uuid.service: Deactivated successfully. Sep 2 14:21:35.385451 systemd[1]: Finished disk-uuid.service - Generate new UUID for disk GPT if necessary. Sep 2 14:21:35.398430 systemd[1]: Mounting boot.mount - Boot partition... Sep 2 14:21:35.487243 systemd[1]: Mounted boot.mount - Boot partition. Sep 2 14:21:35.888280 ignition[1105]: Ignition 2.26.0 Sep 2 14:21:35.888291 ignition[1105]: Stage: fetch-offline Sep 2 14:21:35.891298 ignition[1105]: no config dir at "/usr/lib/ignition/base.d" Sep 2 14:21:35.894246 systemd[1]: Finished ignition-fetch-offline.service - Ignition (fetch-offline). Sep 2 14:21:35.902000 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 2 14:21:35.891308 ignition[1105]: no config dir at "/usr/lib/ignition/base.platform.d/azure" Sep 2 14:21:35.905100 systemd[1]: Starting ignition-fetch.service - Ignition (fetch)... Sep 2 14:21:35.891400 ignition[1105]: parsed url from cmdline: "" Sep 2 14:21:35.891403 ignition[1105]: no config URL provided Sep 2 14:21:35.891407 ignition[1105]: reading system config file "/usr/lib/ignition/user.ign" Sep 2 14:21:35.891421 ignition[1105]: no config at "/usr/lib/ignition/user.ign" Sep 2 14:21:35.891424 ignition[1105]: failed to fetch config: resource requires networking Sep 2 14:21:35.891789 ignition[1105]: Ignition finished successfully Sep 2 14:21:35.935317 ignition[1134]: Ignition 2.26.0 Sep 2 14:21:35.935322 ignition[1134]: Stage: fetch Sep 2 14:21:35.935508 ignition[1134]: no config dir at "/usr/lib/ignition/base.d" Sep 2 14:21:35.935514 ignition[1134]: no config dir at "/usr/lib/ignition/base.platform.d/azure" Sep 2 14:21:35.935592 ignition[1134]: parsed url from cmdline: "" Sep 2 14:21:35.935594 ignition[1134]: no config URL provided Sep 2 14:21:35.935598 ignition[1134]: reading system config file "/usr/lib/ignition/user.ign" Sep 2 14:21:35.935605 ignition[1134]: no config at "/usr/lib/ignition/user.ign" Sep 2 14:21:35.935618 ignition[1134]: GET http://169.254.169.254/metadata/instance/compute/userData?api-version=2021-01-01&format=text: attempt #1 Sep 2 14:21:36.004320 ignition[1134]: GET result: OK Sep 2 14:21:36.004361 ignition[1134]: config has been read from IMDS userdata Sep 2 14:21:36.004369 ignition[1134]: parsing config with SHA512: 5528ba8d342e8244d735ebb4862ed4ab2575804996537f1d1aee1fb9c6160b26557a41868846358bcea21161ab45cf2f0617c3efbcaa5f451820090dc8e340a4 Sep 2 14:21:36.007866 unknown[1134]: fetched base config from "system" Sep 2 14:21:36.008069 ignition[1134]: fetch: fetch complete Sep 2 14:21:36.017000 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 2 14:21:36.007876 unknown[1134]: fetched base config from "system" Sep 2 14:21:36.008072 ignition[1134]: fetch: fetch passed Sep 2 14:21:36.007880 unknown[1134]: fetched user config from "azure" Sep 2 14:21:36.008127 ignition[1134]: Ignition finished successfully Sep 2 14:21:36.010834 systemd[1]: Finished ignition-fetch.service - Ignition (fetch). Sep 2 14:21:36.019159 systemd[1]: Starting ignition-kargs.service - Ignition (kargs)... Sep 2 14:21:36.052356 ignition[1143]: Ignition 2.26.0 Sep 2 14:21:36.052369 ignition[1143]: Stage: kargs Sep 2 14:21:36.056168 systemd[1]: Finished ignition-kargs.service - Ignition (kargs). Sep 2 14:21:36.060000 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 2 14:21:36.052544 ignition[1143]: no config dir at "/usr/lib/ignition/base.d" Sep 2 14:21:36.064005 systemd[1]: Starting ignition-disks.service - Ignition (disks)... Sep 2 14:21:36.052551 ignition[1143]: no config dir at "/usr/lib/ignition/base.platform.d/azure" Sep 2 14:21:36.052896 ignition[1143]: kargs: kargs passed Sep 2 14:21:36.052929 ignition[1143]: Ignition finished successfully Sep 2 14:21:36.110411 systemd[1]: ignition-kargs.service: Deactivated successfully. Sep 2 14:21:36.110499 systemd[1]: Stopped ignition-kargs.service - Ignition (kargs). Sep 2 14:21:36.118000 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 2 14:21:36.122385 systemd[1]: ignition-fetch.service: Deactivated successfully. Sep 2 14:21:36.126000 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 2 14:21:36.122521 systemd[1]: Stopped ignition-fetch.service - Ignition (fetch). Sep 2 14:21:36.134000 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 2 14:21:36.127945 systemd[1]: ignition-fetch-offline.service: Deactivated successfully. Sep 2 14:21:36.128095 systemd[1]: Stopped ignition-fetch-offline.service - Ignition (fetch-offline). Sep 2 14:21:36.138140 systemd[1]: Unmounting oem.mount - /oem... Sep 2 14:21:36.166441 kernel: BTRFS info (device sda6): last unmount of filesystem aa4f5e6e-c55a-4573-bb4a-fa888ef9488c Sep 2 14:21:36.166317 systemd[1]: oem.mount: Deactivated successfully. Sep 2 14:21:36.170066 systemd[1]: Unmounted oem.mount - /oem. Sep 2 14:21:36.194645 ignition[1164]: Ignition 2.26.0 Sep 2 14:21:36.194661 ignition[1164]: Stage: disks Sep 2 14:21:36.199255 systemd[1]: Finished ignition-disks.service - Ignition (disks). Sep 2 14:21:36.203000 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 2 14:21:36.194825 ignition[1164]: no config dir at "/usr/lib/ignition/base.d" Sep 2 14:21:36.204513 systemd[1]: Reached target initrd-root-device.target - Initrd Root Device. Sep 2 14:21:36.194831 ignition[1164]: no config dir at "/usr/lib/ignition/base.platform.d/azure" Sep 2 14:21:36.213198 systemd[1]: Reached target local-fs-pre.target - Preparation for Local File Systems. Sep 2 14:21:36.195188 ignition[1164]: disks: disks passed Sep 2 14:21:36.221747 systemd[1]: Reached target local-fs.target - Local File Systems. Sep 2 14:21:36.195223 ignition[1164]: Ignition finished successfully Sep 2 14:21:36.230778 systemd[1]: Reached target sysinit.target - System Initialization. Sep 2 14:21:36.238901 systemd[1]: Reached target basic.target - Basic System. Sep 2 14:21:36.250128 systemd[1]: Starting systemd-fsck-root.service - File System Check on /dev/disk/by-label/ROOT... Sep 2 14:21:36.391596 systemd-fsck[1176]: ROOT: clean, 15/6361680 files, 408771/6359552 blocks Sep 2 14:21:36.401671 systemd[1]: Finished systemd-fsck-root.service - File System Check on /dev/disk/by-label/ROOT. Sep 2 14:21:36.412000 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 2 14:21:36.416109 systemd[1]: Mounting sysroot.mount - /sysroot... Sep 2 14:21:36.713052 kernel: EXT4-fs (sda9): mounted filesystem 260b8e70-87f7-4c17-9af1-dfd2bf35f8f0 r/w with ordered data mode. Quota mode: none. Sep 2 14:21:36.714450 systemd[1]: Mounted sysroot.mount - /sysroot. Sep 2 14:21:36.726468 systemd[1]: Reached target initrd-root-fs.target - Initrd Root File System. Sep 2 14:21:36.753090 systemd[1]: Mounting sysroot-usr.mount - /sysroot/usr... Sep 2 14:21:36.766299 systemd[1]: Starting flatcar-metadata-hostname.service - Flatcar Metadata Hostname Agent... Sep 2 14:21:36.777607 systemd[1]: ignition-remount-sysroot.service - Remount /sysroot read-write for Ignition skipped, unmet condition check ConditionPathIsReadWrite=!/sysroot Sep 2 14:21:36.777644 systemd[1]: Reached target ignition-diskful.target - Ignition Boot Disk Setup. Sep 2 14:21:36.793435 systemd[1]: Mounted sysroot-usr.mount - /sysroot/usr. Sep 2 14:21:36.803286 systemd[1]: Starting initrd-setup-root.service - Root filesystem setup... Sep 2 14:21:37.561812 coreos-metadata[1195]: Sep 02 14:21:37.561 INFO Fetching http://168.63.129.16/?comp=versions: Attempt #1 Sep 2 14:21:37.568395 coreos-metadata[1195]: Sep 02 14:21:37.563 INFO Fetch successful Sep 2 14:21:37.568395 coreos-metadata[1195]: Sep 02 14:21:37.563 INFO Fetching http://169.254.169.254/metadata/instance/compute/name?api-version=2017-08-01&format=text: Attempt #1 Sep 2 14:21:37.577000 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 2 14:21:37.601111 kernel: kauditd_printk_skb: 27 callbacks suppressed Sep 2 14:21:37.601128 coreos-metadata[1195]: Sep 02 14:21:37.568 INFO Fetch successful Sep 2 14:21:37.601128 coreos-metadata[1195]: Sep 02 14:21:37.568 INFO wrote hostname ci-9999.9.9-l-3581e2040b to /sysroot/etc/hostname Sep 2 14:21:37.571136 systemd[1]: Finished flatcar-metadata-hostname.service - Flatcar Metadata Hostname Agent. Sep 2 14:21:37.617820 kernel: audit: type=1130 audit(1788358897.577:39): 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 2 14:21:38.604063 kernel: loop1: detected capacity change from 0 to 44096 Sep 2 14:21:38.664134 kernel: loop1: p1 p2 p3 Sep 2 14:21:39.038658 systemd-confext[1275]: device-mapper: reload ioctl on loop1p1-14-verity (254:1) failed: Invalid argument Sep 2 14:21:39.060285 kernel: device-mapper: verity: sha256 using "sha256-lib" Sep 2 14:21:39.060304 kernel: device-mapper: verity: Unrecognized verity feature request: root_hash_sig_key_desc Sep 2 14:21:39.060312 kernel: device-mapper: table: 254:1: verity: Unrecognized verity feature request (-EINVAL) Sep 2 14:21:39.060324 kernel: device-mapper: ioctl: error adding target to table Sep 2 14:21:39.105046 kernel: device-mapper: verity: sha256 using "sha256-lib" Sep 2 14:21:39.211050 kernel: erofs (device dm-1): mounted with root inode @ nid 40. Sep 2 14:21:39.236050 kernel: loop2: detected capacity change from 0 to 44096 Sep 2 14:21:39.239058 kernel: loop2: p1 p2 p3 Sep 2 14:21:39.247398 kernel: device-mapper: verity: sha256 using "sha256-lib" Sep 2 14:21:39.247425 kernel: device-mapper: verity: Unrecognized verity feature request: root_hash_sig_key_desc Sep 2 14:21:39.254076 kernel: device-mapper: table: 254:1: verity: Unrecognized verity feature request (-EINVAL) Sep 2 14:21:39.256319 kernel: device-mapper: ioctl: error adding target to table Sep 2 14:21:39.259491 (sd-merge)[1286]: device-mapper: reload ioctl on loop2p1-18-verity (254:1) failed: Invalid argument Sep 2 14:21:39.269336 kernel: device-mapper: verity: sha256 using "sha256-lib" Sep 2 14:21:39.287047 kernel: erofs (device dm-1): mounted with root inode @ nid 40. Sep 2 14:21:39.286162 (sd-merge)[1286]: Using extensions '00-flatcar-default.raw'. Sep 2 14:21:39.286820 (sd-merge)[1286]: Merged extensions into '/sysroot/etc'. Sep 2 14:21:39.299105 initrd-setup-root[1293]: /etc 00-flatcar-default Wed 2026-09-02 14:21:32 UTC Sep 2 14:21:39.299796 systemd[1]: Finished initrd-setup-root.service - Root filesystem setup. Sep 2 14:21:39.308000 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 2 14:21:39.324608 kernel: audit: type=1130 audit(1788358899.308:40): 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 2 14:21:39.311102 systemd[1]: Starting ignition-mount.service - Ignition (mount)... Sep 2 14:21:39.362018 ignition[1299]: INFO : Ignition 2.26.0 Sep 2 14:21:39.362018 ignition[1299]: INFO : Stage: mount Sep 2 14:21:39.368000 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 2 14:21:39.388253 kernel: audit: type=1130 audit(1788358899.368:41): 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 2 14:21:39.388276 ignition[1299]: INFO : no config dir at "/usr/lib/ignition/base.d" Sep 2 14:21:39.388276 ignition[1299]: INFO : no config dir at "/usr/lib/ignition/base.platform.d/azure" Sep 2 14:21:39.388276 ignition[1299]: INFO : mount: mount passed Sep 2 14:21:39.388276 ignition[1299]: INFO : Ignition finished successfully Sep 2 14:21:39.365060 systemd[1]: Finished ignition-mount.service - Ignition (mount). Sep 2 14:21:39.372562 systemd[1]: Starting ignition-files.service - Ignition (files)... Sep 2 14:21:39.411200 systemd[1]: Mounting oem.mount - /oem... Sep 2 14:21:39.429043 kernel: BTRFS: device label OEM devid 1 transid 11 /dev/sda6 (8:6) scanned by mount (1310) Sep 2 14:21:39.432664 kernel: BTRFS info (device sda6): first mount of filesystem aa4f5e6e-c55a-4573-bb4a-fa888ef9488c Sep 2 14:21:39.432694 kernel: BTRFS info (device sda6): using crc32c (crc32c-lib) checksum algorithm Sep 2 14:21:39.446043 kernel: BTRFS info (device sda6): turning on async discard Sep 2 14:21:39.446081 kernel: BTRFS info (device sda6): enabling free space tree Sep 2 14:21:39.452746 systemd[1]: Mounted oem.mount - /oem. Sep 2 14:21:39.459196 systemd[1]: Mounting sysroot-oem.mount - /sysroot/oem... Sep 2 14:21:39.480914 systemd[1]: Mounted sysroot-oem.mount - /sysroot/oem. Sep 2 14:21:39.505962 ignition[1330]: INFO : Ignition 2.26.0 Sep 2 14:21:39.505962 ignition[1330]: INFO : Stage: files Sep 2 14:21:39.511789 ignition[1330]: INFO : no config dir at "/usr/lib/ignition/base.d" Sep 2 14:21:39.511789 ignition[1330]: INFO : no config dir at "/usr/lib/ignition/base.platform.d/azure" Sep 2 14:21:39.511789 ignition[1330]: DEBUG : files: compiled without relabeling support, skipping Sep 2 14:21:39.511789 ignition[1330]: INFO : files: ensureUsers: op(1): [started] creating or modifying user "core" Sep 2 14:21:39.511789 ignition[1330]: DEBUG : files: ensureUsers: op(1): executing: "usermod" "--root" "/sysroot" "core" Sep 2 14:21:39.537186 ignition[1330]: INFO : files: ensureUsers: op(1): [finished] creating or modifying user "core" Sep 2 14:21:39.537186 ignition[1330]: INFO : files: ensureUsers: op(2): [started] adding ssh keys to user "core" Sep 2 14:21:39.537186 ignition[1330]: INFO : files: ensureUsers: op(2): [finished] adding ssh keys to user "core" Sep 2 14:21:39.532884 unknown[1330]: wrote ssh authorized keys file for user: core Sep 2 14:21:39.557605 ignition[1330]: INFO : files: createFilesystemsFiles: createFiles: op(3): [started] writing file "/sysroot/etc/flatcar/update.conf" Sep 2 14:21:39.557605 ignition[1330]: INFO : files: createFilesystemsFiles: createFiles: op(3): [finished] writing file "/sysroot/etc/flatcar/update.conf" Sep 2 14:21:39.557605 ignition[1330]: INFO : files: createFilesystemsFiles: createFiles: op(4): [started] writing link "/sysroot/etc/systemd/system/multi-user.target.upholds/docker.service" -> "/usr/lib/systemd/system/docker.service" Sep 2 14:21:39.569000 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 2 14:21:39.603933 kernel: audit: type=1130 audit(1788358899.569:42): 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 2 14:21:39.564103 systemd[1]: Finished ignition-files.service - Ignition (files). Sep 2 14:21:39.608334 ignition[1330]: INFO : files: createFilesystemsFiles: createFiles: op(4): [finished] writing link "/sysroot/etc/systemd/system/multi-user.target.upholds/docker.service" -> "/usr/lib/systemd/system/docker.service" Sep 2 14:21:39.608334 ignition[1330]: INFO : files: op(5): [started] processing unit "docker.service" Sep 2 14:21:39.608334 ignition[1330]: INFO : files: op(5): [finished] processing unit "docker.service" Sep 2 14:21:39.608334 ignition[1330]: INFO : files: op(6): [started] setting preset to enabled for "docker.service" Sep 2 14:21:39.608334 ignition[1330]: INFO : files: op(6): [finished] setting preset to enabled for "docker.service" Sep 2 14:21:39.608334 ignition[1330]: INFO : files: createResultFile: createFiles: op(7): [started] writing file "/sysroot/etc/.ignition-result.json" Sep 2 14:21:39.608334 ignition[1330]: INFO : files: createResultFile: createFiles: op(7): [finished] writing file "/sysroot/etc/.ignition-result.json" Sep 2 14:21:39.608334 ignition[1330]: INFO : files: files passed Sep 2 14:21:39.608334 ignition[1330]: INFO : Ignition finished successfully Sep 2 14:21:39.647000 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 2 14:21:39.649000 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 2 14:21:39.572633 systemd[1]: Starting ignition-quench.service - Ignition (record completion)... Sep 2 14:21:39.705052 kernel: audit: type=1130 audit(1788358899.647:43): 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 2 14:21:39.608423 systemd[1]: Starting initrd-setup-root-after-ignition.service - Root filesystem completion... Sep 2 14:21:39.713743 kernel: audit: type=1131 audit(1788358899.649:44): pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=ignition-quench comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Sep 2 14:21:39.627280 systemd[1]: ignition-quench.service: Deactivated successfully. Sep 2 14:21:39.720446 kernel: loop3: detected capacity change from 0 to 44096 Sep 2 14:21:39.637058 systemd[1]: Finished ignition-quench.service - Ignition (record completion). Sep 2 14:21:39.741917 kernel: loop3: p1 p2 p3 Sep 2 14:21:39.741935 initrd-setup-root-after-ignition[1368]: grep: /sysroot/etc/flatcar/enabled-sysext.conf: No such file or directory Sep 2 14:21:39.741935 initrd-setup-root-after-ignition[1368]: grep: /sysroot/usr/share/flatcar/enabled-sysext.conf: No such file or directory Sep 2 14:21:39.723385 systemd-confext[1374]: device-mapper: reload ioctl on loop3p1-21-verity (254:2) failed: Invalid argument Sep 2 14:21:39.771274 kernel: device-mapper: verity: sha256 using "sha256-lib" Sep 2 14:21:39.771300 initrd-setup-root-after-ignition[1372]: grep: /sysroot/etc/flatcar/enabled-sysext.conf: No such file or directory Sep 2 14:21:39.778843 kernel: device-mapper: verity: Unrecognized verity feature request: root_hash_sig_key_desc Sep 2 14:21:39.778858 kernel: device-mapper: table: 254:2: verity: Unrecognized verity feature request (-EINVAL) Sep 2 14:21:39.778871 kernel: device-mapper: ioctl: error adding target to table Sep 2 14:21:39.778890 kernel: device-mapper: verity: sha256 using "sha256-lib" Sep 2 14:21:39.778897 kernel: erofs (device dm-2): mounted with root inode @ nid 40. Sep 2 14:21:39.802050 kernel: loop4: detected capacity change from 0 to 44096 Sep 2 14:21:39.896071 kernel: loop4: p1 p2 p3 Sep 2 14:21:39.904013 kernel: device-mapper: verity: sha256 using "sha256-lib" Sep 2 14:21:39.901045 (sd-merge)[1383]: device-mapper: reload ioctl on loop4p1-25-verity (254:2) failed: Invalid argument Sep 2 14:21:39.929377 kernel: device-mapper: verity: Unrecognized verity feature request: root_hash_sig_key_desc Sep 2 14:21:39.929392 kernel: device-mapper: table: 254:2: verity: Unrecognized verity feature request (-EINVAL) Sep 2 14:21:39.929400 kernel: device-mapper: ioctl: error adding target to table Sep 2 14:21:39.929407 kernel: device-mapper: verity: sha256 using "sha256-lib" Sep 2 14:21:39.941938 (sd-merge)[1383]: Skipping extension refresh because no change was found, use --always-refresh=yes to always do a refresh. Sep 2 14:21:39.952944 kernel: erofs (device dm-2): mounted with root inode @ nid 40. Sep 2 14:21:40.285068 kernel: loop4: detected capacity change from 0 to 158496 Sep 2 14:21:40.564129 kernel: loop4: p1 p2 p3 Sep 2 14:21:41.262063 kernel: device-mapper: verity: sha256 using "sha256-lib" Sep 2 14:21:41.262131 kernel: device-mapper: verity: Unrecognized verity feature request: root_hash_sig_key_desc Sep 2 14:21:41.262140 kernel: device-mapper: table: 254:2: verity: Unrecognized verity feature request (-EINVAL) Sep 2 14:21:41.262147 kernel: device-mapper: ioctl: error adding target to table Sep 2 14:21:41.262188 systemd-sysext[1391]: device-mapper: reload ioctl on loop4p1-29-verity (254:2) failed: Invalid argument Sep 2 14:21:41.287617 kernel: device-mapper: verity: sha256 using "sha256-lib" Sep 2 14:21:41.647078 kernel: erofs (device dm-2): mounted with root inode @ nid 39. Sep 2 14:21:42.253060 kernel: loop5: detected capacity change from 0 to 140944 Sep 2 14:21:42.274180 kernel: loop5: p1 p2 p3 Sep 2 14:21:43.268597 kernel: device-mapper: verity: sha256 using "sha256-lib" Sep 2 14:21:43.267091 systemd-sysext[1391]: device-mapper: reload ioctl on loop5p1-33-verity (254:2) failed: Invalid argument Sep 2 14:21:43.280131 kernel: device-mapper: verity: Unrecognized verity feature request: root_hash_sig_key_desc Sep 2 14:21:43.280146 kernel: device-mapper: table: 254:2: verity: Unrecognized verity feature request (-EINVAL) Sep 2 14:21:43.280162 kernel: device-mapper: ioctl: error adding target to table Sep 2 14:21:43.282605 kernel: device-mapper: verity: sha256 using "sha256-lib" Sep 2 14:21:43.663078 kernel: erofs (device dm-2): mounted with root inode @ nid 39. Sep 2 14:21:43.704050 kernel: loop6: detected capacity change from 0 to 388472 Sep 2 14:21:44.312057 kernel: loop6: p1 p2 p3 Sep 2 14:21:45.108923 kernel: device-mapper: verity: sha256 using "sha256-lib" Sep 2 14:21:45.108981 kernel: device-mapper: verity: Unrecognized verity feature request: root_hash_sig_key_desc Sep 2 14:21:45.115291 kernel: device-mapper: table: 254:2: verity: Unrecognized verity feature request (-EINVAL) Sep 2 14:21:45.115249 systemd-sysext[1391]: device-mapper: reload ioctl on loop6p1-37-verity (254:2) failed: Invalid argument Sep 2 14:21:45.137949 kernel: device-mapper: ioctl: error adding target to table Sep 2 14:21:45.137965 kernel: device-mapper: verity: sha256 using "sha256-lib" Sep 2 14:21:45.290051 kernel: erofs (device dm-2): mounted with root inode @ nid 39. Sep 2 14:21:45.391068 kernel: loop7: detected capacity change from 0 to 158496 Sep 2 14:21:45.394115 kernel: loop7: p1 p2 p3 Sep 2 14:21:45.406063 kernel: device-mapper: verity: sha256 using "sha256-lib" Sep 2 14:21:45.406090 kernel: device-mapper: verity: Unrecognized verity feature request: root_hash_sig_key_desc Sep 2 14:21:45.406210 kernel: device-mapper: table: 254:2: verity: Unrecognized verity feature request (-EINVAL) Sep 2 14:21:45.406339 kernel: device-mapper: ioctl: error adding target to table Sep 2 14:21:45.406480 (sd-merge)[1414]: device-mapper: reload ioctl on loop7p1-41-verity (254:2) failed: Invalid argument Sep 2 14:21:45.430090 kernel: device-mapper: verity: sha256 using "sha256-lib" Sep 2 14:21:45.455051 kernel: erofs (device dm-2): mounted with root inode @ nid 39. Sep 2 14:21:45.455077 kernel: loop1: detected capacity change from 0 to 140944 Sep 2 14:21:45.457290 kernel: loop1: p1 p2 p3 Sep 2 14:21:45.463548 (sd-merge)[1414]: device-mapper: reload ioctl on loop1p1-45-verity (254:3) failed: Invalid argument Sep 2 14:21:45.493096 kernel: device-mapper: verity: sha256 using "sha256-lib" Sep 2 14:21:45.493112 kernel: device-mapper: verity: Unrecognized verity feature request: root_hash_sig_key_desc Sep 2 14:21:45.493120 kernel: device-mapper: table: 254:3: verity: Unrecognized verity feature request (-EINVAL) Sep 2 14:21:45.493127 kernel: device-mapper: ioctl: error adding target to table Sep 2 14:21:45.493134 kernel: device-mapper: verity: sha256 using "sha256-lib" Sep 2 14:21:45.524050 kernel: erofs (device dm-3): mounted with root inode @ nid 39. Sep 2 14:21:45.528044 kernel: loop3: detected capacity change from 0 to 388472 Sep 2 14:21:45.530047 kernel: loop3: p1 p2 p3 Sep 2 14:21:45.535936 (sd-merge)[1414]: device-mapper: reload ioctl on loop3p1-49-verity (254:4) failed: Invalid argument Sep 2 14:21:45.563840 kernel: device-mapper: verity: sha256 using "sha256-lib" Sep 2 14:21:45.563859 kernel: device-mapper: verity: Unrecognized verity feature request: root_hash_sig_key_desc Sep 2 14:21:45.563868 kernel: device-mapper: table: 254:4: verity: Unrecognized verity feature request (-EINVAL) Sep 2 14:21:45.563875 kernel: device-mapper: ioctl: error adding target to table Sep 2 14:21:45.563888 kernel: device-mapper: verity: sha256 using "sha256-lib" Sep 2 14:21:45.592045 kernel: erofs (device dm-4): mounted with root inode @ nid 39. Sep 2 14:21:45.594913 (sd-merge)[1414]: Using extensions 'containerd-flatcar.raw', 'docker-flatcar.raw', 'oem-azure-9999.9.9+linux-main-6.18-w-nividia-13.raw'. Sep 2 14:21:45.595720 (sd-merge)[1414]: Merged extensions into '/sysroot/usr'. Sep 2 14:21:45.609761 systemd[1]: Finished initrd-setup-root-after-ignition.service - Root filesystem completion. Sep 2 14:21:45.616000 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 2 14:21:45.635942 kernel: audit: type=1130 audit(1788358905.616:45): 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 2 14:21:45.619558 systemd[1]: Starting initrd-parse-etc.service - Mountpoints Configured in the Real Root... Sep 2 14:21:45.666503 systemd[1]: initrd-parse-etc.service: Deactivated successfully. Sep 2 14:21:45.669072 systemd[1]: Finished initrd-parse-etc.service - Mountpoints Configured in the Real Root. Sep 2 14:21:45.675000 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 2 14:21:45.675999 systemd[1]: initrd-parse-etc.service: Triggering OnSuccess= dependencies. Sep 2 14:21:45.675000 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 2 14:21:45.707626 kernel: audit: type=1130 audit(1788358905.675:46): 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 2 14:21:45.692888 systemd[1]: Reached target initrd-fs.target - Initrd File Systems. Sep 2 14:21:45.716325 kernel: audit: type=1131 audit(1788358905.675:47): pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=initrd-parse-etc comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Sep 2 14:21:45.718125 systemd[1]: Starting dracut-mount.service - dracut mount hook... Sep 2 14:21:45.985848 systemd[1]: Finished dracut-mount.service - dracut mount hook. Sep 2 14:21:45.990000 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 2 14:21:46.005587 kernel: audit: type=1130 audit(1788358905.990:48): 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 2 14:21:46.007251 systemd[1]: Starting dracut-pre-pivot.service - dracut pre-pivot and cleanup hook... Sep 2 14:21:46.043608 systemd[1]: Finished dracut-pre-pivot.service - dracut pre-pivot and cleanup hook. Sep 2 14:21:46.048000 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 2 14:21:46.068459 systemd[1]: Starting initrd-cleanup.service - Cleaning Up and Shutting Down Daemons... Sep 2 14:21:46.077413 kernel: audit: type=1130 audit(1788358906.048:49): 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 2 14:21:46.093169 systemd[1]: Stopped target basic.target - Basic System. Sep 2 14:21:46.097600 systemd[1]: Stopped target ignition-diskful.target - Ignition Boot Disk Setup. Sep 2 14:21:46.107393 systemd[1]: Stopped target initrd-root-device.target - Initrd Root Device. Sep 2 14:21:46.118895 systemd[1]: Stopped target initrd-usr-fs.target - Initrd /usr File System. Sep 2 14:21:46.129203 systemd[1]: Stopped target nss-lookup.target - Host and Network Name Lookups. Sep 2 14:21:46.138790 systemd[1]: Stopped target paths.target - Path Units. Sep 2 14:21:46.146621 systemd[1]: Stopped target remote-cryptsetup.target - Remote Encrypted Volumes. Sep 2 14:21:46.155258 systemd[1]: Stopped target slices.target - Slice Units. Sep 2 14:21:46.164336 systemd[1]: Stopped target sockets.target - Socket Units. Sep 2 14:21:46.171708 systemd[1]: Stopped target sysinit.target - System Initialization. Sep 2 14:21:46.179244 systemd[1]: Stopped target local-fs.target - Local File Systems. Sep 2 14:21:46.188213 systemd[1]: Stopped target local-fs-pre.target - Preparation for Local File Systems. Sep 2 14:21:46.197025 systemd[1]: Stopped target swap.target - Swaps. Sep 2 14:21:46.205368 systemd[1]: Stopped target timers.target - Timer Units. Sep 2 14:21:46.212243 systemd[1]: iscsid.socket: Deactivated successfully. Sep 2 14:21:46.212381 systemd[1]: Closed iscsid.socket - Open-iSCSI iscsid Socket. Sep 2 14:21:46.221620 systemd[1]: iscsiuio.socket: Deactivated successfully. Sep 2 14:21:46.221768 systemd[1]: Closed iscsiuio.socket - Open-iSCSI iscsiuio Socket. Sep 2 14:21:46.233159 systemd[1]: systemd-coredump.socket: Deactivated successfully. Sep 2 14:21:46.233288 systemd[1]: Closed systemd-coredump.socket - Process Core Dump Socket. Sep 2 14:21:46.245455 systemd[1]: systemd-journald-audit.socket: Deactivated successfully. Sep 2 14:21:46.245581 systemd[1]: Closed systemd-journald-audit.socket - Journal Audit Socket. Sep 2 14:21:46.265000 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 2 14:21:46.258144 systemd[1]: dracut-pre-pivot.service: Deactivated successfully. Sep 2 14:21:46.258288 systemd[1]: Stopped dracut-pre-pivot.service - dracut pre-pivot and cleanup hook. Sep 2 14:21:46.297404 kernel: audit: type=1131 audit(1788358906.265:50): 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 2 14:21:46.287924 systemd[1]: Stopped target remote-fs.target - Remote File Systems. Sep 2 14:21:46.292794 systemd[1]: Stopped target remote-fs-pre.target - Preparation for Remote File Systems. Sep 2 14:21:46.311000 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 2 14:21:46.303230 systemd[1]: dracut-mount.service: Deactivated successfully. Sep 2 14:21:46.303339 systemd[1]: Stopped dracut-mount.service - dracut mount hook. Sep 2 14:21:46.339000 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 2 14:21:46.358750 kernel: audit: type=1131 audit(1788358906.311: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 2 14:21:46.330581 systemd[1]: dracut-pre-mount.service: Deactivated successfully. Sep 2 14:21:46.368200 kernel: audit: type=1131 audit(1788358906.339:52): 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 2 14:21:46.330707 systemd[1]: Stopped dracut-pre-mount.service - dracut pre-mount hook. Sep 2 14:21:46.357879 systemd[1]: Stopped target cryptsetup.target - Local Encrypted Volumes. Sep 2 14:21:46.363815 systemd[1]: systemd-ask-password-console.path: Deactivated successfully. Sep 2 14:21:46.364181 systemd[1]: Stopped systemd-ask-password-console.path - Dispatch Password Requests to Console Directory Watch. Sep 2 14:21:46.378845 systemd[1]: Stopped target cryptsetup-pre.target - Local Encrypted Volumes (Pre). Sep 2 14:21:46.410000 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 2 14:21:46.388644 systemd[1]: clevis-luks-askpass.path: Deactivated successfully. Sep 2 14:21:46.389327 systemd[1]: Stopped clevis-luks-askpass.path - Forward Password Requests to Clevis Directory Watch. Sep 2 14:21:46.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 2 14:21:46.456290 kernel: audit: type=1131 audit(1788358906.410:53): 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 2 14:21:46.399528 systemd[1]: dracut-initqueue.service: Deactivated successfully. Sep 2 14:21:46.460583 kernel: audit: type=1131 audit(1788358906.438:54): 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 2 14:21:46.399735 systemd[1]: Stopped dracut-initqueue.service - dracut initqueue hook. Sep 2 14:21:46.464000 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 2 14:21:46.429394 systemd[1]: initrd-setup-root-after-ignition.service: Deactivated successfully. Sep 2 14:21:46.474000 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 2 14:21:46.429508 systemd[1]: Stopped initrd-setup-root-after-ignition.service - Root filesystem completion. Sep 2 14:21:46.457326 systemd[1]: ignition-files.service: Deactivated successfully. Sep 2 14:21:46.457439 systemd[1]: Stopped ignition-files.service - Ignition (files). Sep 2 14:21:46.468692 systemd[1]: flatcar-metadata-hostname.service: Deactivated successfully. Sep 2 14:21:46.502000 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 2 14:21:46.468838 systemd[1]: Stopped flatcar-metadata-hostname.service - Flatcar Metadata Hostname Agent. Sep 2 14:21:46.482173 systemd[1]: Stopping ignition-mount.service - Ignition (mount)... Sep 2 14:21:46.525000 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 2 14:21:46.526369 ignition[1489]: INFO : Ignition 2.26.0 Sep 2 14:21:46.526369 ignition[1489]: INFO : Stage: umount Sep 2 14:21:46.526369 ignition[1489]: INFO : no config dir at "/usr/lib/ignition/base.d" Sep 2 14:21:46.526369 ignition[1489]: INFO : no config dir at "/usr/lib/ignition/base.platform.d/azure" Sep 2 14:21:46.537000 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 2 14:21:46.546000 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 2 14:21:46.493696 systemd[1]: systemd-modules-load.service: Deactivated successfully. Sep 2 14:21:46.555000 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 2 14:21:46.561000 ignition[1489]: INFO : umount: umount passed Sep 2 14:21:46.561000 ignition[1489]: INFO : Ignition finished successfully Sep 2 14:21:46.572000 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 2 14:21:46.493802 systemd[1]: Stopped systemd-modules-load.service - Load Kernel Modules. Sep 2 14:21:46.504424 systemd[1]: systemd-tmpfiles-setup.service: Deactivated successfully. Sep 2 14:21:46.585000 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 2 14:21:46.504519 systemd[1]: Stopped systemd-tmpfiles-setup.service - Create System Files and Directories. Sep 2 14:21:46.594000 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 2 14:21:46.531090 systemd[1]: systemd-udev-trigger.service: Deactivated successfully. Sep 2 14:21:46.531199 systemd[1]: Stopped systemd-udev-trigger.service - Coldplug All udev Devices. Sep 2 14:21:46.539059 systemd[1]: dracut-pre-trigger.service: Deactivated successfully. Sep 2 14:21:46.539164 systemd[1]: Stopped dracut-pre-trigger.service - dracut pre-trigger hook. Sep 2 14:21:46.630000 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 2 14:21:46.549767 systemd[1]: ignition-mount.service: Deactivated successfully. Sep 2 14:21:46.551816 systemd[1]: Stopped ignition-mount.service - Ignition (mount). Sep 2 14:21:46.558757 systemd[1]: Stopped target network.target - Network. Sep 2 14:21:46.649000 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 2 14:21:46.565468 systemd[1]: ignition-disks.service: Deactivated successfully. Sep 2 14:21:46.565529 systemd[1]: Stopped ignition-disks.service - Ignition (disks). Sep 2 14:21:46.577735 systemd[1]: ignition-setup-pre.service: Deactivated successfully. Sep 2 14:21:46.668000 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 2 14:21:46.668000 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 2 14:21:46.577788 systemd[1]: Stopped ignition-setup-pre.service - Ignition env setup. Sep 2 14:21:46.677000 audit: BPF prog-id=8 op=UNLOAD Sep 2 14:21:46.677000 audit: BPF prog-id=5 op=UNLOAD Sep 2 14:21:46.588461 systemd[1]: initrd-setup-root.service: Deactivated successfully. Sep 2 14:21:46.588506 systemd[1]: Stopped initrd-setup-root.service - Root filesystem setup. Sep 2 14:21:46.601090 systemd[1]: Stopping systemd-networkd.service - Network Management... Sep 2 14:21:46.609497 systemd[1]: Stopping systemd-resolved.service - Network Name Resolution... Sep 2 14:21:46.620763 systemd[1]: systemd-networkd.service: Deactivated successfully. Sep 2 14:21:46.621623 systemd[1]: Stopped systemd-networkd.service - Network Management. Sep 2 14:21:46.640045 systemd[1]: systemd-resolved.service: Deactivated successfully. Sep 2 14:21:46.642064 systemd[1]: Stopped systemd-resolved.service - Network Name Resolution. Sep 2 14:21:46.731000 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 2 14:21:46.658904 systemd[1]: initrd-cleanup.service: Deactivated successfully. Sep 2 14:21:46.660351 systemd[1]: Finished initrd-cleanup.service - Cleaning Up and Shutting Down Daemons. Sep 2 14:21:46.676447 systemd[1]: Stopped target network-pre.target - Preparation for Network. Sep 2 14:21:46.682365 systemd[1]: systemd-networkd-resolve-hook.socket: Deactivated successfully. Sep 2 14:21:46.682459 systemd[1]: Closed systemd-networkd-resolve-hook.socket - Network Management Resolve Hook Socket. Sep 2 14:21:46.693738 systemd[1]: systemd-networkd.socket: Deactivated successfully. Sep 2 14:21:46.693815 systemd[1]: Closed systemd-networkd.socket - Network Management Netlink Socket. Sep 2 14:21:46.711120 systemd[1]: Stopping network-cleanup.service - Network Cleanup... Sep 2 14:21:46.724108 systemd[1]: parse-ip-for-networkd.service: Deactivated successfully. Sep 2 14:21:46.724153 systemd[1]: Stopped parse-ip-for-networkd.service - Write systemd-networkd units from cmdline. Sep 2 14:21:46.742209 systemd[1]: Stopping systemd-udevd.service - Rule-based Manager for Device Events and Files... Sep 2 14:21:46.821039 kernel: hv_netvsc 000d3afe-63f2-000d-3afe-63f2000d3afe eth0: Data path switched from VF: enP13814s1 Sep 2 14:21:46.837897 systemd[1]: network-cleanup.service: Deactivated successfully. Sep 2 14:21:46.838890 systemd[1]: Stopped network-cleanup.service - Network Cleanup. Sep 2 14:21:46.845000 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 2 14:21:46.860632 systemd[1]: systemd-udevd.service: Deactivated successfully. Sep 2 14:21:46.864252 systemd[1]: Stopped systemd-udevd.service - Rule-based Manager for Device Events and Files. Sep 2 14:21:46.870000 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 2 14:21:46.876651 systemd[1]: systemd-udevd-control.socket: Deactivated successfully. Sep 2 14:21:46.876703 systemd[1]: Closed systemd-udevd-control.socket - udev Control Socket. Sep 2 14:21:46.890115 systemd[1]: dracut-pre-udev.service: Deactivated successfully. Sep 2 14:21:46.890170 systemd[1]: Stopped dracut-pre-udev.service - dracut pre-udev hook. Sep 2 14:21:46.898000 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 2 14:21:46.904567 systemd[1]: dracut-cmdline.service: Deactivated successfully. Sep 2 14:21:46.904624 systemd[1]: Stopped dracut-cmdline.service - dracut cmdline hook. Sep 2 14:21:46.913000 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 2 14:21:46.916433 systemd[1]: dracut-cmdline-ask.service: Deactivated successfully. Sep 2 14:21:46.923000 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 2 14:21:46.916476 systemd[1]: Stopped dracut-cmdline-ask.service - dracut ask for additional cmdline parameters. Sep 2 14:21:46.935112 systemd[1]: Starting initrd-udevadm-cleanup-db.service - Cleanup udev Database... Sep 2 14:21:46.941082 systemd[1]: systemd-network-generator.service: Deactivated successfully. Sep 2 14:21:46.949000 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 2 14:21:46.941125 systemd[1]: Stopped systemd-network-generator.service - Generate Network Units from Kernel Command Line. Sep 2 14:21:46.961798 systemd[1]: systemd-tmpfiles-setup-dev.service: Deactivated successfully. Sep 2 14:21:46.969000 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 2 14:21:46.961845 systemd[1]: Stopped systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev. Sep 2 14:21:46.977000 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 2 14:21:46.971401 systemd[1]: systemd-tmpfiles-setup-dev-early.service: Deactivated successfully. Sep 2 14:21:46.987000 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 2 14:21:46.971440 systemd[1]: Stopped systemd-tmpfiles-setup-dev-early.service - Create Static Device Nodes in /dev gracefully. Sep 2 14:21:46.997000 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 2 14:21:46.979296 systemd[1]: kmod-static-nodes.service: Deactivated successfully. Sep 2 14:21:46.979339 systemd[1]: Stopped kmod-static-nodes.service - Create List of Static Device Nodes. Sep 2 14:21:47.012000 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 2 14:21:47.012000 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 2 14:21:46.990662 systemd[1]: systemd-vconsole-setup.service: Deactivated successfully. Sep 2 14:21:46.990704 systemd[1]: Stopped systemd-vconsole-setup.service - Virtual Console Setup. Sep 2 14:21:47.002909 systemd[1]: initrd-udevadm-cleanup-db.service: Deactivated successfully. Sep 2 14:21:47.003632 systemd[1]: Finished initrd-udevadm-cleanup-db.service - Cleanup udev Database. Sep 2 14:21:47.016978 systemd[1]: Reached target initrd-switch-root.target - Switch Root. Sep 2 14:21:47.026117 systemd[1]: Starting initrd-switch-root.service - Switch Root... Sep 2 14:21:47.058955 systemd[1]: Switching root. Sep 2 14:21:47.333191 systemd-journald[374]: Journal stopped Sep 2 14:22:06.030831 systemd-journald[374]: Received SIGTERM from PID 1 (systemd). Sep 2 14:22:06.030872 kernel: SELinux: policy capability network_peer_controls=1 Sep 2 14:22:06.030886 kernel: SELinux: policy capability open_perms=1 Sep 2 14:22:06.030894 kernel: SELinux: policy capability extended_socket_class=1 Sep 2 14:22:06.030901 kernel: SELinux: policy capability always_check_network=0 Sep 2 14:22:06.030909 kernel: SELinux: policy capability cgroup_seclabel=1 Sep 2 14:22:06.030919 kernel: SELinux: policy capability nnp_nosuid_transition=1 Sep 2 14:22:06.030927 kernel: SELinux: policy capability genfs_seclabel_symlinks=0 Sep 2 14:22:06.030934 kernel: SELinux: policy capability ioctl_skip_cloexec=0 Sep 2 14:22:06.030942 kernel: SELinux: policy capability userspace_initial_context=0 Sep 2 14:22:06.030949 kernel: SELinux: policy capability netlink_xperm=0 Sep 2 14:22:06.030959 kernel: SELinux: policy capability netif_wildcard=0 Sep 2 14:22:06.030967 kernel: SELinux: policy capability genfs_seclabel_wildcard=0 Sep 2 14:22:06.030976 kernel: SELinux: policy capability functionfs_seclabel=0 Sep 2 14:22:06.030984 systemd[1]: Successfully loaded SELinux policy in 395.564ms. Sep 2 14:22:06.030993 systemd[1]: Relabeled /dev/, /dev/shm/, /run/ in 5.776ms. Sep 2 14:22:06.031000 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 2 14:22:06.031006 systemd[1]: Detected virtualization microsoft. Sep 2 14:22:06.031012 systemd[1]: Detected architecture arm64. Sep 2 14:22:06.031019 systemd[1]: Detected first boot. Sep 2 14:22:06.031025 systemd[1]: Initializing machine ID from random generator. Sep 2 14:22:06.031045 systemd[1]: Hostname set to . Sep 2 14:22:06.031051 kernel: kauditd_printk_skb: 31 callbacks suppressed Sep 2 14:22:06.031057 kernel: audit: type=1334 audit(1788358914.968:86): prog-id=9 op=LOAD Sep 2 14:22:06.031065 kernel: audit: type=1334 audit(1788358914.968:87): prog-id=9 op=UNLOAD Sep 2 14:22:06.031074 zram_generator::config[1776]: No configuration found. Sep 2 14:22:06.031084 kernel: NET: Registered PF_VSOCK protocol family Sep 2 14:22:06.031093 systemd[1]: Applying preset policy. Sep 2 14:22:06.031101 systemd[1]: Created symlink '/etc/systemd/system/multi-user.target.wants/docker.service' → '/usr/lib/systemd/system/docker.service'. Sep 2 14:22:06.031108 systemd[1]: Populated /etc with preset unit settings. Sep 2 14:22:06.031115 kernel: audit: type=1334 audit(1788358925.024:88): prog-id=10 op=LOAD Sep 2 14:22:06.031122 kernel: audit: type=1334 audit(1788358925.024:89): prog-id=2 op=UNLOAD Sep 2 14:22:06.031128 kernel: audit: type=1334 audit(1788358925.027:90): prog-id=11 op=LOAD Sep 2 14:22:06.031133 kernel: audit: type=1334 audit(1788358925.028:91): prog-id=12 op=LOAD Sep 2 14:22:06.031140 kernel: audit: type=1334 audit(1788358925.028:92): prog-id=3 op=UNLOAD Sep 2 14:22:06.031147 kernel: audit: type=1334 audit(1788358925.028:93): prog-id=4 op=UNLOAD Sep 2 14:22:06.031153 kernel: audit: type=1334 audit(1788358925.032:94): prog-id=13 op=LOAD Sep 2 14:22:06.031161 kernel: audit: type=1334 audit(1788358925.032:95): prog-id=10 op=UNLOAD Sep 2 14:22:06.031166 kernel: audit: type=1334 audit(1788358925.032:96): prog-id=14 op=LOAD Sep 2 14:22:06.031172 kernel: audit: type=1334 audit(1788358925.032:97): prog-id=15 op=LOAD Sep 2 14:22:06.031179 systemd[1]: initrd-switch-root.service: Deactivated successfully. Sep 2 14:22:06.031186 systemd[1]: Stopped initrd-switch-root.service - Switch Root. Sep 2 14:22:06.031194 systemd[1]: systemd-journald.service: Scheduled restart job, restart counter is at 1. Sep 2 14:22:06.031201 systemd[1]: Created slice system-addon\x2dconfig.slice - Slice /system/addon-config. Sep 2 14:22:06.031208 systemd[1]: Created slice system-addon\x2drun.slice - Slice /system/addon-run. Sep 2 14:22:06.031215 systemd[1]: Created slice system-getty.slice - Slice /system/getty. Sep 2 14:22:06.031223 systemd[1]: Created slice system-modprobe.slice - Slice /system/modprobe. Sep 2 14:22:06.031229 systemd[1]: Created slice system-serial\x2dgetty.slice - Slice /system/serial-getty. Sep 2 14:22:06.031238 systemd[1]: Created slice system-system\x2dcloudinit.slice - Slice /system/system-cloudinit. Sep 2 14:22:06.031244 systemd[1]: Created slice system-systemd\x2dfsck.slice - Slice /system/systemd-fsck. Sep 2 14:22:06.031251 systemd[1]: Created slice user.slice - User and Session Slice. Sep 2 14:22:06.031257 systemd[1]: Started clevis-luks-askpass.path - Forward Password Requests to Clevis Directory Watch. Sep 2 14:22:06.031263 systemd[1]: Started systemd-ask-password-console.path - Dispatch Password Requests to Console Directory Watch. Sep 2 14:22:06.031270 systemd[1]: Started systemd-ask-password-wall.path - Forward Password Requests to Wall Directory Watch. Sep 2 14:22:06.031276 systemd[1]: Set up automount boot.automount - Boot partition Automount Point. Sep 2 14:22:06.031284 systemd[1]: Set up automount proc-sys-fs-binfmt_misc.automount - Arbitrary Executable File Formats File System Automount Point. Sep 2 14:22:06.031290 systemd[1]: Expecting device dev-disk-by\x2dlabel-OEM.device - /dev/disk/by-label/OEM... Sep 2 14:22:06.031296 systemd[1]: Expecting device dev-ptp_hyperv.device - /dev/ptp_hyperv... Sep 2 14:22:06.031302 systemd[1]: Expecting device dev-ttyAMA0.device - /dev/ttyAMA0... Sep 2 14:22:06.031310 systemd[1]: Reached target cryptsetup-pre.target - Local Encrypted Volumes (Pre). Sep 2 14:22:06.031316 systemd[1]: Reached target cryptsetup.target - Local Encrypted Volumes. Sep 2 14:22:06.031322 systemd[1]: Reached target imports.target - Image Downloads. Sep 2 14:22:06.031328 systemd[1]: Stopped target initrd-switch-root.target - Switch Root. Sep 2 14:22:06.031334 systemd[1]: Stopped target initrd-fs.target - Initrd File Systems. Sep 2 14:22:06.031340 systemd[1]: Stopped target initrd-root-fs.target - Initrd Root File System. Sep 2 14:22:06.031347 systemd[1]: Reached target integritysetup.target - Local Integrity Protected Volumes. Sep 2 14:22:06.031354 systemd[1]: Reached target remote-cryptsetup.target - Remote Encrypted Volumes. Sep 2 14:22:06.031361 systemd[1]: Reached target remote-fs.target - Remote File Systems. Sep 2 14:22:06.031367 systemd[1]: Reached target remote-integritysetup.target - Remote Integrity Protected Volumes. Sep 2 14:22:06.031373 systemd[1]: Reached target remote-veritysetup.target - Remote Verity Protected Volumes. Sep 2 14:22:06.031381 systemd[1]: Reached target slices.target - Slice Units. Sep 2 14:22:06.031387 systemd[1]: Reached target swap.target - Swaps. Sep 2 14:22:06.031393 systemd[1]: Reached target veritysetup.target - Local Verity Protected Volumes. Sep 2 14:22:06.031399 systemd[1]: Listening on systemd-ask-password.socket - Query the User Interactively for a Password. Sep 2 14:22:06.031406 systemd[1]: Listening on systemd-coredump.socket - Process Core Dump Socket. Sep 2 14:22:06.031412 systemd[1]: Listening on systemd-creds.socket - Credential Encryption/Decryption. Sep 2 14:22:06.031419 systemd[1]: Listening on systemd-factory-reset.socket - Factory Reset Management. Sep 2 14:22:06.031425 systemd[1]: Listening on systemd-journald-audit.socket - Journal Audit Socket. Sep 2 14:22:06.031431 systemd[1]: Listening on systemd-mountfsd.socket - DDI File System Mounter Socket. Sep 2 14:22:06.031438 systemd[1]: Listening on systemd-mute-console.socket - Console Output Muting Service Socket. Sep 2 14:22:06.031444 systemd[1]: Listening on systemd-networkd-resolve-hook.socket - Network Management Resolve Hook Socket. Sep 2 14:22:06.031450 systemd[1]: Listening on systemd-networkd-varlink-metrics.socket - Network Management Metrics Varlink Socket. Sep 2 14:22:06.031456 systemd[1]: Listening on systemd-networkd-varlink.socket - Network Management Varlink Socket. Sep 2 14:22:06.031464 systemd[1]: Listening on systemd-networkd.socket - Network Management Netlink Socket. Sep 2 14:22:06.031470 systemd[1]: Listening on systemd-nsresourced.socket - Namespace Resource Manager Socket. Sep 2 14:22:06.031476 systemd[1]: Listening on systemd-oomd.socket - Userspace Out-Of-Memory (OOM) Killer Socket. Sep 2 14:22:06.031484 systemd[1]: Listening on systemd-repart.socket - Disk Repartitioning Service Socket. Sep 2 14:22:06.031490 systemd[1]: Listening on systemd-resolved-monitor.socket - Resolve Monitor Varlink Socket. Sep 2 14:22:06.031497 systemd[1]: Listening on systemd-resolved-varlink.socket - Resolve Service Varlink Socket. Sep 2 14:22:06.031504 systemd[1]: Listening on systemd-udevd-control.socket - udev Control Socket. Sep 2 14:22:06.031510 systemd[1]: Listening on systemd-udevd-varlink.socket - udev Varlink Socket. Sep 2 14:22:06.031517 systemd[1]: Listening on systemd-userdbd.socket - User Database Manager Socket. Sep 2 14:22:06.031523 systemd[1]: Mounting dev-hugepages.mount - Huge Pages File System... Sep 2 14:22:06.031529 systemd[1]: Mounting dev-mqueue.mount - POSIX Message Queue File System... Sep 2 14:22:06.031535 systemd[1]: Mounting media.mount - External Media Directory... Sep 2 14:22:06.031541 systemd[1]: Mounting sys-kernel-debug.mount - Kernel Debug File System... Sep 2 14:22:06.031549 systemd[1]: Mounting sys-kernel-tracing.mount - Kernel Trace File System... Sep 2 14:22:06.031555 systemd[1]: tmp.mount: x-systemd.graceful-option=usrquota specified, but option is not available, suppressing. Sep 2 14:22:06.031561 systemd[1]: Mounting tmp.mount - Temporary Directory /tmp... Sep 2 14:22:06.031567 systemd[1]: Starting flatcar-tmpfiles.service - Create missing system files... Sep 2 14:22:06.031574 systemd[1]: ignition-delete-config.service - Ignition (delete config) skipped, no trigger condition checks were met. Sep 2 14:22:06.031580 systemd[1]: Starting kmod-static-nodes.service - Create List of Static Device Nodes... Sep 2 14:22:06.031586 systemd[1]: Starting modprobe@configfs.service - Load Kernel Module configfs... Sep 2 14:22:06.031593 systemd[1]: Starting modprobe@drm.service - Load Kernel Module drm... Sep 2 14:22:06.031600 systemd[1]: Starting modprobe@efi_pstore.service - Load Kernel Module efi_pstore... Sep 2 14:22:06.031606 systemd[1]: Starting modprobe@fuse.service - Load Kernel Module fuse... Sep 2 14:22:06.031612 systemd[1]: setup-nsswitch.service - Create /etc/nsswitch.conf skipped, unmet condition check ConditionPathExists=!/etc/nsswitch.conf Sep 2 14:22:06.031619 systemd[1]: systemd-fsck-root.service: Deactivated successfully. Sep 2 14:22:06.031625 systemd[1]: Stopped systemd-fsck-root.service - File System Check on Root Device. Sep 2 14:22:06.031633 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 2 14:22:06.031640 systemd[1]: Starting systemd-journald.service - Journal Service... Sep 2 14:22:06.031646 systemd[1]: Starting systemd-modules-load.service - Load Kernel Modules... Sep 2 14:22:06.031652 systemd[1]: Starting systemd-network-generator.service - Generate Network Units from Kernel Command Line... Sep 2 14:22:06.031679 systemd-journald[1854]: Collecting audit messages is enabled. Sep 2 14:22:06.031695 systemd[1]: Reached target time-set.target - System Time Set. Sep 2 14:22:06.031701 kernel: fuse: init (API version 7.45) Sep 2 14:22:06.031710 systemd-journald[1854]: Journal started Sep 2 14:22:06.031725 systemd-journald[1854]: Runtime Journal (/run/log/journal/53d5bba2fe8e4129abddee93ee8feb0a) is 8M, max 78.3M, 70.3M free. Sep 2 14:22:05.547000 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 2 14:22:05.950000 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 2 14:22:05.953000 audit: BPF prog-id=18 op=UNLOAD Sep 2 14:22:05.953000 audit: BPF prog-id=17 op=UNLOAD Sep 2 14:22:05.961000 audit: BPF prog-id=19 op=LOAD Sep 2 14:22:05.961000 audit: BPF prog-id=20 op=LOAD Sep 2 14:22:05.962000 audit: BPF prog-id=21 op=LOAD Sep 2 14:22:06.025000 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 2 14:22:06.025000 audit[1854]: SYSCALL arch=c00000b7 syscall=211 success=yes exit=60 a0=6 a1=ffffedea3c00 a2=4000 a3=0 items=0 ppid=1 pid=1854 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 2 14:22:06.025000 audit: PROCTITLE proctitle="/usr/lib/systemd/systemd-journald" Sep 2 14:22:04.447066 systemd[1]: Queued start job for default target multi-user.target. Sep 2 14:22:05.044969 systemd[1]: Unnecessary job was removed for dev-sda6.device - /dev/sda6. Sep 2 14:22:05.045352 systemd[1]: systemd-journald.service: Deactivated successfully. Sep 2 14:22:05.207283 systemd[1]: systemd-journald.service: Consumed 2.592s CPU time over 33.470s wall clock time. Sep 2 14:22:06.043331 systemd[1]: Starting systemd-remount-fs.service - Remount Root and Kernel File Systems... Sep 2 14:22:06.054040 systemd[1]: Starting systemd-udev-load-credentials.service - Load udev Rules from Credentials... Sep 2 14:22:06.066130 systemd-modules-load[1859]: Using 2 probe threads Sep 2 14:22:06.080220 systemd[1]: Starting systemd-udev-trigger.service - Coldplug All udev Devices... Sep 2 14:22:06.088711 systemd[1]: Started systemd-journald.service - Journal Service. Sep 2 14:22:06.093000 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 2 14:22:06.094173 systemd[1]: Mounted dev-hugepages.mount - Huge Pages File System. Sep 2 14:22:06.099227 systemd[1]: Mounted dev-mqueue.mount - POSIX Message Queue File System. Sep 2 14:22:06.104739 systemd[1]: Mounted media.mount - External Media Directory. Sep 2 14:22:06.110057 systemd[1]: Mounted sys-kernel-debug.mount - Kernel Debug File System. Sep 2 14:22:06.114540 systemd[1]: Mounted sys-kernel-tracing.mount - Kernel Trace File System. Sep 2 14:22:06.119456 systemd[1]: Mounted tmp.mount - Temporary Directory /tmp. Sep 2 14:22:06.123684 systemd[1]: Finished kmod-static-nodes.service - Create List of Static Device Nodes. Sep 2 14:22:06.128000 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 2 14:22:06.129700 systemd[1]: modprobe@configfs.service: Deactivated successfully. Sep 2 14:22:06.132790 systemd[1]: Finished modprobe@configfs.service - Load Kernel Module configfs. Sep 2 14:22:06.137000 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 2 14:22:06.137000 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 2 14:22:06.138819 systemd[1]: modprobe@efi_pstore.service: Deactivated successfully. Sep 2 14:22:06.139021 systemd[1]: Finished modprobe@efi_pstore.service - Load Kernel Module efi_pstore. Sep 2 14:22:06.147205 kernel: ACPI: bus type drm_connector registered Sep 2 14:22:06.146000 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 2 14:22:06.146000 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 2 14:22:06.147757 systemd[1]: modprobe@drm.service: Deactivated successfully. Sep 2 14:22:06.148555 systemd[1]: Finished modprobe@drm.service - Load Kernel Module drm. Sep 2 14:22:06.154000 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 2 14:22:06.154000 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 2 14:22:06.155558 systemd[1]: modprobe@fuse.service: Deactivated successfully. Sep 2 14:22:06.155692 systemd[1]: Finished modprobe@fuse.service - Load Kernel Module fuse. Sep 2 14:22:06.159000 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 2 14:22:06.159000 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 2 14:22:06.160467 systemd[1]: Finished systemd-modules-load.service - Load Kernel Modules. Sep 2 14:22:06.164000 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 2 14:22:06.166116 systemd[1]: Finished systemd-network-generator.service - Generate Network Units from Kernel Command Line. Sep 2 14:22:06.170000 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 2 14:22:06.172827 systemd[1]: Finished systemd-remount-fs.service - Remount Root and Kernel File Systems. Sep 2 14:22:06.177000 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 2 14:22:06.179403 systemd[1]: Finished systemd-udev-load-credentials.service - Load udev Rules from Credentials. Sep 2 14:22:06.184000 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 2 14:22:06.192075 systemd[1]: Reached target network-pre.target - Preparation for Network. Sep 2 14:22:06.200122 systemd[1]: Mounting sys-fs-fuse-connections.mount - FUSE Control File System... Sep 2 14:22:06.212109 systemd[1]: Mounting sys-kernel-config.mount - Kernel Configuration File System... Sep 2 14:22:06.218317 systemd[1]: remount-root.service - Remount Root File System skipped, unmet condition check ConditionPathIsReadWrite=!/ Sep 2 14:22:06.223569 systemd[1]: Starting systemd-hwdb-update.service - Rebuild Hardware Database... Sep 2 14:22:06.232131 systemd[1]: Starting systemd-journal-flush.service - Flush Journal to Persistent Storage... Sep 2 14:22:06.237124 systemd[1]: systemd-pstore.service - Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore Sep 2 14:22:06.239120 systemd[1]: Starting systemd-random-seed.service - Load/Save OS Random Seed... Sep 2 14:22:06.245212 systemd[1]: Starting systemd-sysctl.service - Apply Kernel Variables... Sep 2 14:22:06.252759 systemd[1]: Starting systemd-tmpfiles-setup-dev-early.service - Create Static Device Nodes in /dev gracefully... Sep 2 14:22:06.259279 systemd[1]: Finished systemd-udev-trigger.service - Coldplug All udev Devices. Sep 2 14:22:06.264000 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 2 14:22:06.265258 systemd[1]: Mounted sys-fs-fuse-connections.mount - FUSE Control File System. Sep 2 14:22:06.270560 systemd[1]: Mounted sys-kernel-config.mount - Kernel Configuration File System. Sep 2 14:22:06.276345 systemd[1]: Finished systemd-random-seed.service - Load/Save OS Random Seed. Sep 2 14:22:06.280000 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 2 14:22:06.284763 systemd[1]: Reached target first-boot-complete.target - First Boot Complete. Sep 2 14:22:06.303020 systemd-journald[1854]: Time spent on flushing to /var/log/journal/53d5bba2fe8e4129abddee93ee8feb0a is 11.504ms for 1151 entries. Sep 2 14:22:06.303020 systemd-journald[1854]: System Journal (/var/log/journal/53d5bba2fe8e4129abddee93ee8feb0a) is 8M, max 2.2G, 2.2G free. Sep 2 14:22:06.358372 systemd-journald[1854]: Received client request to flush runtime journal. Sep 2 14:22:06.359312 systemd[1]: Finished systemd-journal-flush.service - Flush Journal to Persistent Storage. Sep 2 14:22:06.363000 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 2 14:22:06.382137 systemd[1]: Finished systemd-sysctl.service - Apply Kernel Variables. Sep 2 14:22:06.386000 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 2 14:22:06.433163 systemd[1]: Finished flatcar-tmpfiles.service - Create missing system files. Sep 2 14:22:06.437000 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 2 14:22:06.512696 systemd-tmpfiles[1908]: ACLs are not supported, ignoring. Sep 2 14:22:06.512717 systemd-tmpfiles[1908]: ACLs are not supported, ignoring. Sep 2 14:22:06.516103 systemd[1]: Finished systemd-tmpfiles-setup-dev-early.service - Create Static Device Nodes in /dev gracefully. Sep 2 14:22:06.520000 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 2 14:22:06.523662 systemd[1]: Starting systemd-sysusers.service - Create System Users... Sep 2 14:22:06.644396 systemd[1]: Finished systemd-sysusers.service - Create System Users. Sep 2 14:22:06.648000 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 2 14:22:06.651840 systemd[1]: Starting systemd-journalctl.socket - Journal Log Access Socket... Sep 2 14:22:06.657000 audit: BPF prog-id=22 op=LOAD Sep 2 14:22:06.657000 audit: BPF prog-id=23 op=LOAD Sep 2 14:22:06.657000 audit: BPF prog-id=24 op=LOAD Sep 2 14:22:06.658736 systemd[1]: Starting systemd-oomd.service - Userspace Out-Of-Memory (OOM) Killer... Sep 2 14:22:06.663000 audit: BPF prog-id=25 op=LOAD Sep 2 14:22:06.664500 systemd[1]: Starting systemd-resolved.service - Network Name Resolution... Sep 2 14:22:06.669339 systemd[1]: Starting systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev... Sep 2 14:22:06.674819 systemd[1]: Listening on systemd-journalctl.socket - Journal Log Access Socket. Sep 2 14:22:06.684109 systemd[1]: Starting modprobe@tun.service - Load Kernel Module tun... Sep 2 14:22:06.689907 systemd-tmpfiles[1924]: ACLs are not supported, ignoring. Sep 2 14:22:06.690158 systemd-tmpfiles[1924]: ACLs are not supported, ignoring. Sep 2 14:22:06.689000 audit: BPF prog-id=26 op=LOAD Sep 2 14:22:06.689000 audit: BPF prog-id=27 op=LOAD Sep 2 14:22:06.689000 audit: BPF prog-id=28 op=LOAD Sep 2 14:22:06.692089 systemd[1]: Starting systemd-userdbd.service - User Database Manager... Sep 2 14:22:06.696957 systemd[1]: Finished systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev. Sep 2 14:22:06.701000 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 2 14:22:06.702572 systemd[1]: Reached target local-fs-pre.target - Preparation for Local File Systems. Sep 2 14:22:06.708231 systemd[1]: systemd-repart.service - Repartition Root Disk skipped, no trigger condition checks were met. Sep 2 14:22:06.709781 systemd[1]: proc-sys-fs-binfmt_misc.automount: Got automount request for /proc/sys/fs/binfmt_misc, triggered by 1926 ((systemd-userd)) Sep 2 14:22:06.818118 kernel: tun: Universal TUN/TAP device driver, 1.6 Sep 2 14:22:06.818477 systemd[1]: modprobe@tun.service: Deactivated successfully. Sep 2 14:22:06.818652 systemd[1]: Finished modprobe@tun.service - Load Kernel Module tun. Sep 2 14:22:06.825000 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 2 14:22:06.825000 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 2 14:22:06.826000 audit: BPF prog-id=29 op=LOAD Sep 2 14:22:06.826000 audit: BPF prog-id=30 op=LOAD Sep 2 14:22:06.826000 audit: BPF prog-id=31 op=LOAD Sep 2 14:22:06.830128 systemd[1]: Starting systemd-nsresourced.service - Namespace Resource Manager... Sep 2 14:22:06.984078 systemd[1]: Finished systemd-hwdb-update.service - Rebuild Hardware Database. Sep 2 14:22:06.988000 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 2 14:22:06.988000 audit: BPF prog-id=32 op=LOAD Sep 2 14:22:06.988000 audit: BPF prog-id=33 op=LOAD Sep 2 14:22:06.990735 systemd[1]: Starting systemd-udevd.service - Rule-based Manager for Device Events and Files... Sep 2 14:22:07.259837 systemd[1]: Mounting proc-sys-fs-binfmt_misc.mount - Arbitrary Executable File Formats File System... Sep 2 14:22:07.265085 systemd[1]: var-lib-machines.mount - Virtual Machine and Container Storage (Compatibility) skipped, unmet condition check ConditionPathExists=/var/lib/machines.raw Sep 2 14:22:07.265189 systemd[1]: Reached target local-fs.target - Local File Systems. Sep 2 14:22:07.267918 systemd-udevd[1931]: Using default interface naming scheme 'v260'. Sep 2 14:22:07.269547 systemd[1]: Reached target machines.target - Virtual Machines and Containers. Sep 2 14:22:07.274970 systemd[1]: Listening on systemd-importd.socket - Disk Image Download Service Socket. Sep 2 14:22:07.280654 systemd[1]: Listening on systemd-sysext.socket - System Extension Image Management. Sep 2 14:22:07.286913 systemd[1]: Starting systemd-confext.service - Merge System Configuration Images into /etc/... Sep 2 14:22:07.295286 systemd[1]: Starting systemd-machine-id-commit.service - Save Transient machine-id to Disk... Sep 2 14:22:07.302827 systemd[1]: Starting systemd-userdb-load-credentials.service - Load JSON user/group Records from Credentials... Sep 2 14:22:07.322948 systemd[1]: Mounted proc-sys-fs-binfmt_misc.mount - Arbitrary Executable File Formats File System. Sep 2 14:22:07.330802 systemd[1]: systemd-binfmt.service - Set Up Additional Binary Formats skipped, no trigger condition checks were met. Sep 2 14:22:07.335150 systemd[1]: Finished systemd-userdb-load-credentials.service - Load JSON user/group Records from Credentials. Sep 2 14:22:07.339000 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 2 14:22:07.376817 systemd[1]: Started systemd-userdbd.service - User Database Manager. Sep 2 14:22:07.378008 systemd-nsresourced[1929]: Not setting up BPF subsystem, as functionality has been disabled at compile time. Sep 2 14:22:07.382000 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 2 14:22:07.383618 systemd[1]: Started systemd-nsresourced.service - Namespace Resource Manager. Sep 2 14:22:07.388000 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 2 14:22:07.416053 kernel: loop4: detected capacity change from 0 to 44096 Sep 2 14:22:07.419251 kernel: loop4: p1 p2 p3 Sep 2 14:22:07.427257 systemd[1]: Finished systemd-machine-id-commit.service - Save Transient machine-id to Disk. Sep 2 14:22:07.435000 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 2 14:22:07.459860 systemd-confext[1938]: device-mapper: reload ioctl on loop4p1-53-verity (254:5) failed: Invalid argument Sep 2 14:22:07.460197 kernel: device-mapper: verity: sha256 using "sha256-lib" Sep 2 14:22:07.460244 kernel: device-mapper: verity: Unrecognized verity feature request: root_hash_sig_key_desc Sep 2 14:22:07.460261 kernel: device-mapper: table: 254:5: verity: Unrecognized verity feature request (-EINVAL) Sep 2 14:22:07.460274 kernel: device-mapper: ioctl: error adding target to table Sep 2 14:22:07.467043 kernel: device-mapper: verity: sha256 using "sha256-lib" Sep 2 14:22:07.472927 systemd-oomd[1922]: No swap; memory pressure usage will be degraded Sep 2 14:22:07.475970 systemd[1]: Started systemd-oomd.service - Userspace Out-Of-Memory (OOM) Killer. Sep 2 14:22:07.487000 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 2 14:22:07.511491 systemd-resolved[1923]: Positive Trust Anchors: Sep 2 14:22:07.511503 systemd-resolved[1923]: . IN DS 20326 8 2 e06d44b80b8f1d39a95c0b0d7c65d08458e880409bbc683457104237c7f8ec8d Sep 2 14:22:07.511506 systemd-resolved[1923]: . IN DS 38696 8 2 683d2d0acb8c9b712a1948b27f741219298d0a450d612c483af444a4c0fb2b16 Sep 2 14:22:07.511525 systemd-resolved[1923]: 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 2 14:22:07.558164 systemd[1]: Started systemd-udevd.service - Rule-based Manager for Device Events and Files. Sep 2 14:22:07.562000 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 2 14:22:07.564000 audit: BPF prog-id=34 op=LOAD Sep 2 14:22:07.568000 audit: BPF prog-id=7 op=UNLOAD Sep 2 14:22:07.568000 audit: BPF prog-id=6 op=UNLOAD Sep 2 14:22:07.570126 systemd[1]: Starting systemd-networkd.service - Network Management... Sep 2 14:22:07.570132 systemd-resolved[1923]: Using system hostname 'ci-9999.9.9-l-3581e2040b'. Sep 2 14:22:07.575606 systemd[1]: Started systemd-resolved.service - Network Name Resolution. Sep 2 14:22:07.579000 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 2 14:22:07.581276 systemd[1]: Reached target nss-lookup.target - Host and Network Name Lookups. Sep 2 14:22:07.666155 systemd[1]: Condition check resulted in dev-ttyAMA0.device - /dev/ttyAMA0 being skipped. Sep 2 14:22:07.708470 systemd-networkd[1961]: lo: Link UP Sep 2 14:22:07.708484 systemd-networkd[1961]: lo: Gained carrier Sep 2 14:22:07.711173 systemd[1]: Started systemd-networkd.service - Network Management. Sep 2 14:22:07.716052 systemd-networkd[1961]: eth0: Found matching .network file, based on potentially unpredictable interface name: /usr/lib/systemd/network/zz-default.network Sep 2 14:22:07.716059 systemd-networkd[1961]: eth0: Configuring with /usr/lib/systemd/network/zz-default.network. Sep 2 14:22:07.718000 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 2 14:22:07.721609 systemd[1]: Reached target network.target - Network. Sep 2 14:22:07.730837 systemd[1]: Starting systemd-networkd-persistent-storage.service - Enable Persistent Storage in systemd-networkd... Sep 2 14:22:07.737609 systemd[1]: Starting systemd-networkd-wait-online.service - Wait for Network to be Online... Sep 2 14:22:07.756043 kernel: mousedev: PS/2 mouse device common for all mice Sep 2 14:22:07.772055 kernel: hv_storvsc f8b3781a-1e82-4818-a1c3-63d806ec15bb: tag#208 cmd 0x85 status: scsi 0x2 srb 0x6 host 0xc0000001 Sep 2 14:22:07.772291 kernel: mlx5_core 35f6:00:02.0 enP13814s1: Link up Sep 2 14:22:07.796048 kernel: hv_vmbus: registering driver hv_balloon Sep 2 14:22:07.805236 kernel: hv_netvsc 000d3afe-63f2-000d-3afe-63f2000d3afe eth0: Data path switched to VF: enP13814s1 Sep 2 14:22:07.805485 kernel: hv_balloon: Using Dynamic Memory protocol version 2.0 Sep 2 14:22:07.805503 kernel: hv_balloon: Memory hot add disabled on ARM64 Sep 2 14:22:07.806474 systemd-networkd[1961]: enP13814s1: Link UP Sep 2 14:22:07.806900 systemd-networkd[1961]: eth0: Link UP Sep 2 14:22:07.806977 systemd-networkd[1961]: eth0: Gained carrier Sep 2 14:22:07.807025 systemd-networkd[1961]: eth0: Found matching .network file, based on potentially unpredictable interface name: /usr/lib/systemd/network/zz-default.network Sep 2 14:22:07.820263 systemd-networkd[1961]: enP13814s1: Gained carrier Sep 2 14:22:07.824337 systemd[1]: Finished systemd-networkd-persistent-storage.service - Enable Persistent Storage in systemd-networkd. Sep 2 14:22:07.831000 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 2 14:22:07.835522 systemd-networkd[1961]: eth0: DHCPv4 address 10.0.0.36/24, gateway 10.0.0.1 acquired from 168.63.129.16 Sep 2 14:22:07.839078 systemd[1]: Condition check resulted in dev-ptp_hyperv.device - /dev/ptp_hyperv being skipped. Sep 2 14:22:07.846201 kernel: hyperv_fb: Deprecated: use Hyper-V DRM driver instead Sep 2 14:22:07.846271 kernel: hv_vmbus: registering driver hyperv_fb Sep 2 14:22:07.848044 kernel: hyperv_fb: Synthvid Version major 3, minor 5 Sep 2 14:22:07.848101 kernel: hyperv_fb: Screen resolution: 1024x768, Color depth: 32, Frame buffer size: 8388608 Sep 2 14:22:07.848119 kernel: Console: switching to colour dummy device 80x25 Sep 2 14:22:07.850047 kernel: Console: switching to colour frame buffer device 128x48 Sep 2 14:22:07.902043 kernel: MACsec IEEE 802.1AE Sep 2 14:22:07.908186 systemd[1]: Starting systemd-vconsole-setup.service - Virtual Console Setup... Sep 2 14:22:07.988055 kernel: erofs (device dm-5): mounted with root inode @ nid 40. Sep 2 14:22:08.027648 systemd[1]: Found device dev-disk-by\x2dlabel-OEM.device - Virtual_Disk OEM. Sep 2 14:22:08.033067 systemd[1]: systemd-vconsole-setup.service: Deactivated successfully. Sep 2 14:22:08.033258 systemd[1]: Stopped systemd-vconsole-setup.service - Virtual Console Setup. Sep 2 14:22:08.037000 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 2 14:22:08.037000 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 2 14:22:08.050303 kernel: loop4: detected capacity change from 0 to 44096 Sep 2 14:22:08.053041 kernel: loop4: p1 p2 p3 Sep 2 14:22:08.053115 systemd[1]: Starting systemd-fsck@dev-disk-by\x2dlabel-OEM.service - File System Check on /dev/disk/by-label/OEM... Sep 2 14:22:08.059313 systemd[1]: Starting systemd-vconsole-setup.service - Virtual Console Setup... Sep 2 14:22:08.073283 kernel: device-mapper: verity: sha256 using "sha256-lib" Sep 2 14:22:08.073349 kernel: device-mapper: verity: Unrecognized verity feature request: root_hash_sig_key_desc Sep 2 14:22:08.081316 kernel: device-mapper: table: 254:5: verity: Unrecognized verity feature request (-EINVAL) Sep 2 14:22:08.076097 (sd-merge)[2089]: device-mapper: reload ioctl on loop4p1-58-verity (254:5) failed: Invalid argument Sep 2 14:22:08.081638 kernel: device-mapper: ioctl: error adding target to table Sep 2 14:22:08.083209 kernel: device-mapper: verity: sha256 using "sha256-lib" Sep 2 14:22:08.101468 (sd-merge)[2089]: Skipping extension refresh because no change was found, use --always-refresh=yes to always do a refresh. Sep 2 14:22:08.102046 kernel: erofs (device dm-5): mounted with root inode @ nid 40. Sep 2 14:22:08.104985 systemd[1]: Finished systemd-confext.service - Merge System Configuration Images into /etc/. Sep 2 14:22:08.109000 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 2 14:22:08.113697 systemd[1]: Starting systemd-sysext.service - Merge System Extension Images into /usr/ and /opt/... Sep 2 14:22:08.127067 kernel: loop4: detected capacity change from 0 to 388472 Sep 2 14:22:08.132048 kernel: loop4: p1 p2 p3 Sep 2 14:22:08.140620 kernel: device-mapper: verity: sha256 using "sha256-lib" Sep 2 14:22:08.140586 systemd-sysext[2099]: device-mapper: reload ioctl on loop4p1-62-verity (254:5) failed: Invalid argument Sep 2 14:22:08.142197 kernel: device-mapper: verity: Unrecognized verity feature request: root_hash_sig_key_desc Sep 2 14:22:08.142221 kernel: device-mapper: table: 254:5: verity: Unrecognized verity feature request (-EINVAL) Sep 2 14:22:08.142233 kernel: device-mapper: ioctl: error adding target to table Sep 2 14:22:08.146049 kernel: device-mapper: verity: sha256 using "sha256-lib" Sep 2 14:22:08.179052 kernel: erofs (device dm-5): mounted with root inode @ nid 39. Sep 2 14:22:08.203938 systemd[1]: Finished systemd-fsck@dev-disk-by\x2dlabel-OEM.service - File System Check on /dev/disk/by-label/OEM. Sep 2 14:22:08.208000 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 2 14:22:08.216049 kernel: loop4: detected capacity change from 0 to 158496 Sep 2 14:22:08.220043 kernel: loop4: p1 p2 p3 Sep 2 14:22:08.223854 systemd-sysext[2099]: device-mapper: reload ioctl on loop4p1-67-verity (254:5) failed: Invalid argument Sep 2 14:22:08.224047 kernel: device-mapper: verity: sha256 using "sha256-lib" Sep 2 14:22:08.224076 kernel: device-mapper: verity: Unrecognized verity feature request: root_hash_sig_key_desc Sep 2 14:22:08.224089 kernel: device-mapper: table: 254:5: verity: Unrecognized verity feature request (-EINVAL) Sep 2 14:22:08.224097 kernel: device-mapper: ioctl: error adding target to table Sep 2 14:22:08.228052 kernel: device-mapper: verity: sha256 using "sha256-lib" Sep 2 14:22:08.259183 kernel: erofs (device dm-5): mounted with root inode @ nid 39. Sep 2 14:22:08.261909 systemd[1]: etc-machine\x2did.mount: Deactivated successfully. Sep 2 14:22:08.282215 kernel: loop4: detected capacity change from 0 to 140944 Sep 2 14:22:08.283243 kernel: loop4: p1 p2 p3 Sep 2 14:22:08.288683 systemd-sysext[2099]: device-mapper: reload ioctl on loop4p1-72-verity (254:5) failed: Invalid argument Sep 2 14:22:08.289060 kernel: device-mapper: verity: sha256 using "sha256-lib" Sep 2 14:22:08.289103 kernel: device-mapper: verity: Unrecognized verity feature request: root_hash_sig_key_desc Sep 2 14:22:08.289126 kernel: device-mapper: table: 254:5: verity: Unrecognized verity feature request (-EINVAL) Sep 2 14:22:08.289143 kernel: device-mapper: ioctl: error adding target to table Sep 2 14:22:08.297055 kernel: device-mapper: verity: sha256 using "sha256-lib" Sep 2 14:22:08.328110 kernel: erofs (device dm-5): mounted with root inode @ nid 39. Sep 2 14:22:08.365061 kernel: loop4: detected capacity change from 0 to 388472 Sep 2 14:22:08.366048 kernel: loop4: p1 p2 p3 Sep 2 14:22:08.374607 (sd-merge)[2125]: device-mapper: reload ioctl on loop4p1-77-verity (254:5) failed: Invalid argument Sep 2 14:22:08.375042 kernel: device-mapper: verity: sha256 using "sha256-lib" Sep 2 14:22:08.375081 kernel: device-mapper: verity: Unrecognized verity feature request: root_hash_sig_key_desc Sep 2 14:22:08.375096 kernel: device-mapper: table: 254:5: verity: Unrecognized verity feature request (-EINVAL) Sep 2 14:22:08.375109 kernel: device-mapper: ioctl: error adding target to table Sep 2 14:22:08.386083 kernel: device-mapper: verity: sha256 using "sha256-lib" Sep 2 14:22:08.410049 kernel: erofs (device dm-5): mounted with root inode @ nid 39. Sep 2 14:22:08.412055 kernel: loop5: detected capacity change from 0 to 158496 Sep 2 14:22:08.413296 kernel: loop5: p1 p2 p3 Sep 2 14:22:08.418241 kernel: device-mapper: verity: sha256 using "sha256-lib" Sep 2 14:22:08.418302 kernel: device-mapper: verity: Unrecognized verity feature request: root_hash_sig_key_desc Sep 2 14:22:08.418682 kernel: device-mapper: table: 254:6: verity: Unrecognized verity feature request (-EINVAL) Sep 2 14:22:08.419014 kernel: device-mapper: ioctl: error adding target to table Sep 2 14:22:08.419355 (sd-merge)[2125]: device-mapper: reload ioctl on loop5p1-81-verity (254:6) failed: Invalid argument Sep 2 14:22:08.440473 kernel: device-mapper: verity: sha256 using "sha256-lib" Sep 2 14:22:08.470059 kernel: erofs (device dm-6): mounted with root inode @ nid 39. Sep 2 14:22:08.471407 kernel: loop6: detected capacity change from 0 to 140944 Sep 2 14:22:08.471456 kernel: loop6: p1 p2 p3 Sep 2 14:22:08.476206 kernel: device-mapper: verity: sha256 using "sha256-lib" Sep 2 14:22:08.476268 kernel: device-mapper: verity: Unrecognized verity feature request: root_hash_sig_key_desc Sep 2 14:22:08.476624 (sd-merge)[2125]: device-mapper: reload ioctl on loop6p1-85-verity (254:7) failed: Invalid argument Sep 2 14:22:08.477053 kernel: device-mapper: table: 254:7: verity: Unrecognized verity feature request (-EINVAL) Sep 2 14:22:08.477084 kernel: device-mapper: ioctl: error adding target to table Sep 2 14:22:08.492054 kernel: device-mapper: verity: sha256 using "sha256-lib" Sep 2 14:22:08.503594 systemd-vconsole-setup[2091]: Configuration of first virtual console was skipped, ignoring remaining ones. Sep 2 14:22:08.507561 systemd[1]: Finished systemd-vconsole-setup.service - Virtual Console Setup. Sep 2 14:22:08.511000 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 2 14:22:08.523049 kernel: erofs (device dm-7): mounted with root inode @ nid 39. Sep 2 14:22:08.523502 (sd-merge)[2125]: Skipping extension refresh because no change was found, use --always-refresh=yes to always do a refresh. Sep 2 14:22:08.527746 systemd[1]: Finished systemd-sysext.service - Merge System Extension Images into /usr/ and /opt/. Sep 2 14:22:08.532000 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 2 14:22:08.534369 systemd[1]: Starting systemd-tmpfiles-setup.service - Create System Files and Directories... Sep 2 14:22:08.574964 systemd-tmpfiles[2149]: /usr/lib/tmpfiles.d/nfs-utils.conf:6: Duplicate line for path "/var/lib/nfs/sm", ignoring. Sep 2 14:22:08.575324 systemd-tmpfiles[2149]: /usr/lib/tmpfiles.d/nfs-utils.conf:7: Duplicate line for path "/var/lib/nfs/sm.bak", ignoring. Sep 2 14:22:08.575574 systemd-tmpfiles[2149]: /usr/lib/tmpfiles.d/provision.conf:20: Duplicate line for path "/root", ignoring. Sep 2 14:22:08.576322 systemd-tmpfiles[2149]: ACLs are not supported, ignoring. Sep 2 14:22:08.576459 systemd-tmpfiles[2149]: ACLs are not supported, ignoring. Sep 2 14:22:08.578911 systemd-tmpfiles[2149]: Detected autofs mount point '/boot' during canonicalization of 'boot'. Sep 2 14:22:08.579024 systemd-tmpfiles[2149]: Skipping /boot Sep 2 14:22:08.584265 systemd-tmpfiles[2149]: Detected autofs mount point '/boot' during canonicalization of 'boot'. Sep 2 14:22:08.584363 systemd-tmpfiles[2149]: Skipping /boot Sep 2 14:22:08.592823 systemd[1]: Finished systemd-tmpfiles-setup.service - Create System Files and Directories. Sep 2 14:22:08.597000 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 2 14:22:08.601051 systemd[1]: Starting audit-rules.service - Load Audit Rules... Sep 2 14:22:08.610127 systemd[1]: Starting clean-ca-certificates.service - Clean up broken links in /etc/ssl/certs... Sep 2 14:22:08.618121 systemd[1]: Starting ldconfig.service - Rebuild Dynamic Linker Cache... Sep 2 14:22:08.622960 systemd[1]: Starting systemd-journal-catalog-update.service - Rebuild Journal Catalog... Sep 2 14:22:08.631132 systemd[1]: Starting systemd-update-utmp.service - Record System Boot/Shutdown in UTMP... Sep 2 14:22:08.658000 audit[2158]: AUDIT1127 pid=2158 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 2 14:22:08.663072 systemd[1]: Finished systemd-update-utmp.service - Record System Boot/Shutdown in UTMP. Sep 2 14:22:08.667000 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 2 14:22:08.773188 systemd[1]: Finished systemd-journal-catalog-update.service - Rebuild Journal Catalog. Sep 2 14:22:08.777000 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 2 14:22:08.876000 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 2 14:22:08.876000 audit[2182]: SYSCALL arch=c00000b7 syscall=206 success=yes exit=1056 a0=3 a1=ffffd15f6b20 a2=420 a3=0 items=0 ppid=2154 pid=2182 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 2 14:22:08.876000 audit: PROCTITLE proctitle=2F7362696E2F617564697463746C002D52002F6574632F61756469742F61756469742E72756C6573 Sep 2 14:22:08.877419 augenrules[2182]: No rules Sep 2 14:22:08.878148 systemd[1]: audit-rules.service: Deactivated successfully. Sep 2 14:22:08.878409 systemd[1]: Finished audit-rules.service - Load Audit Rules. Sep 2 14:22:09.026444 systemd[1]: Finished clean-ca-certificates.service - Clean up broken links in /etc/ssl/certs. Sep 2 14:22:09.031788 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 2 14:22:09.748195 systemd-networkd[1961]: eth0: Gained IPv6LL Sep 2 14:22:09.750319 systemd[1]: Finished systemd-networkd-wait-online.service - Wait for Network to be Online. Sep 2 14:22:09.756197 systemd[1]: Reached target network-online.target - Network is Online. Sep 2 14:22:25.619797 ldconfig[2156]: ldconfig: /usr/lib/ld.so.conf is not an ELF file - it has the wrong magic bytes at the start. Sep 2 14:22:25.643487 systemd[1]: Finished ldconfig.service - Rebuild Dynamic Linker Cache. Sep 2 14:22:25.650209 systemd[1]: Starting systemd-update-done.service - Update is Completed... Sep 2 14:22:25.665985 systemd[1]: Finished systemd-update-done.service - Update is Completed. Sep 2 14:22:25.671103 systemd[1]: Reached target sysinit.target - System Initialization. Sep 2 14:22:25.675534 systemd[1]: Started motdgen.path - Watch for update engine configuration changes. Sep 2 14:22:25.681277 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 2 14:22:25.686771 systemd[1]: Started logrotate.timer - Daily rotation of log files. Sep 2 14:22:25.691124 systemd[1]: Started mdadm.timer - Weekly check for MD array's redundancy information.. Sep 2 14:22:25.696612 systemd[1]: Started systemd-sysupdate-reboot.timer - Reboot Automatically After System Update. Sep 2 14:22:25.702178 systemd[1]: Started systemd-sysupdate.timer - Automatic System Update. Sep 2 14:22:25.706643 systemd[1]: Started systemd-tmpfiles-clean.timer - Daily Cleanup of Temporary Directories. Sep 2 14:22:25.711697 systemd[1]: update-engine-stub.timer - Update Engine Stub Timer skipped, unmet condition check ConditionPathExists=/usr/.noupdate Sep 2 14:22:25.711721 systemd[1]: Reached target paths.target - Path Units. Sep 2 14:22:25.715353 systemd[1]: Reached target timers.target - Timer Units. Sep 2 14:22:25.719433 systemd[1]: Listening on dbus.socket - D-Bus System Message Bus Socket. Sep 2 14:22:25.724861 systemd[1]: Starting docker.socket - Docker Socket for the API... Sep 2 14:22:25.729949 systemd[1]: Listening on sshd-unix-local.socket - OpenSSH Server Socket (systemd-ssh-generator, AF_UNIX Local). Sep 2 14:22:25.736355 systemd[1]: Listening on sshd.socket - OpenSSH Server Socket. Sep 2 14:22:25.740744 systemd[1]: Listening on systemd-hostnamed.socket - Hostname Service Socket. Sep 2 14:22:25.945405 systemd[1]: Listening on systemd-logind-varlink.socket - User Login Management Varlink Socket. Sep 2 14:22:25.950946 systemd[1]: Listening on systemd-machined.socket - Virtual Machine and Container Registration Service Socket. Sep 2 14:22:25.956695 systemd[1]: Listening on docker.socket - Docker Socket for the API. Sep 2 14:22:25.961336 systemd[1]: Reached target sockets.target - Socket Units. Sep 2 14:22:25.965360 systemd[1]: Reached target basic.target - Basic System. Sep 2 14:22:25.969298 systemd[1]: addon-config@oem.service - Configure Addon /oem skipped, no trigger condition checks were met. Sep 2 14:22:25.969321 systemd[1]: addon-run@oem.service - Run Addon /oem skipped, no trigger condition checks were met. Sep 2 14:22:25.970952 systemd[1]: Starting chronyd.service - NTP client/server... Sep 2 14:22:25.983046 systemd[1]: Starting containerd.service - containerd container runtime... Sep 2 14:22:25.997282 systemd[1]: Starting dbus.service - D-Bus System Message Bus... Sep 2 14:22:26.003524 systemd[1]: Starting dracut-shutdown.service - Restore /run/initramfs on shutdown... Sep 2 14:22:26.008820 chronyd[2201]: chronyd version 4.8 starting (+CMDMON +REFCLOCK +RTC +PRIVDROP +SCFILTER -SIGND +NTS +SECHASH +IPV6 -DEBUG) Sep 2 14:22:26.010106 systemd[1]: Starting enable-oem-cloudinit.service - Enable cloudinit... Sep 2 14:22:26.016312 systemd[1]: Starting extend-filesystems.service - Extend Filesystems... Sep 2 14:22:26.020583 systemd[1]: flatcar-setup-environment.service - Modifies /etc/environment for CoreOS skipped, unmet condition check ConditionPathExists=/oem/bin/flatcar-setup-environment Sep 2 14:22:26.022164 systemd[1]: Started hv_kvp_daemon.service - Hyper-V KVP daemon. Sep 2 14:22:26.027167 systemd[1]: hv_vss_daemon.service - Hyper-V VSS daemon skipped, unmet condition check ConditionPathExists=/dev/vmbus/hv_vss Sep 2 14:22:26.029105 systemd[1]: Starting motdgen.service - Generate /run/flatcar/motd... Sep 2 14:22:26.036547 KVP[2207]: KVP starting; pid is:2207 Sep 2 14:22:26.037993 systemd[1]: Starting nvidia.service - NVIDIA Configure Service... Sep 2 14:22:26.038208 KVP[2207]: KVP LIC Version: 3.1 Sep 2 14:22:26.039047 kernel: hv_utils: KVP IC version 4.0 Sep 2 14:22:26.046114 systemd[1]: Starting ssh-key-proc-cmdline.service - Install an ssh key from /proc/cmdline... Sep 2 14:22:26.058800 systemd[1]: Starting sshd-keygen.service - Generate sshd host keys... Sep 2 14:22:26.069109 systemd[1]: Starting systemd-logind.service - User Login Management... Sep 2 14:22:26.073831 systemd[1]: tcsd.service - TCG Core Services Daemon skipped, unmet condition check ConditionPathExists=/dev/tpm0 Sep 2 14:22:26.079703 systemd[1]: Starting update-engine.service - Update Engine... Sep 2 14:22:26.086122 systemd[1]: Starting update-ssh-keys-after-ignition.service - Run update-ssh-keys once after Ignition... Sep 2 14:22:26.092898 systemd[1]: ssh-key-proc-cmdline.service: Deactivated successfully. Sep 2 14:22:26.093484 systemd[1]: Finished ssh-key-proc-cmdline.service - Install an ssh key from /proc/cmdline. Sep 2 14:22:26.121050 jq[2205]: false Sep 2 14:22:26.122037 jq[2226]: true Sep 2 14:22:26.122636 systemd[1]: enable-oem-cloudinit.service: Skipped due to 'exec-condition'. Sep 2 14:22:26.124070 systemd[1]: Condition check resulted in enable-oem-cloudinit.service - Enable cloudinit being skipped. Sep 2 14:22:26.133941 jq[2234]: true Sep 2 14:22:26.312761 systemd[1]: Finished dracut-shutdown.service - Restore /run/initramfs on shutdown. Sep 2 14:22:26.320953 motdgen[2256]: /oem/oem-release: line 2: Azure: command not found Sep 2 14:22:26.326560 systemd[1]: motdgen.service: Deactivated successfully. Sep 2 14:22:26.328207 systemd[1]: Finished motdgen.service - Generate /run/flatcar/motd. Sep 2 14:22:26.359598 extend-filesystems[2206]: Found /dev/sda6 Sep 2 14:22:26.363754 chronyd[2201]: Timezone right/UTC failed leap second check, ignoring Sep 2 14:22:26.364050 systemd[1]: Started chronyd.service - NTP client/server. Sep 2 14:22:26.363911 chronyd[2201]: Loaded seccomp filter (level 2) Sep 2 14:22:26.364599 systemd-logind[2218]: New seat seat0. Sep 2 14:22:26.373535 systemd-logind[2218]: Watching system buttons on /dev/input/event0 (AT Translated Set 2 keyboard) Sep 2 14:22:26.373872 systemd[1]: Started systemd-logind.service - User Login Management. Sep 2 14:22:26.691461 extend-filesystems[2206]: Found /dev/sda9 Sep 2 14:22:26.691461 extend-filesystems[2206]: Checking size of /dev/sda9 Sep 2 14:22:26.711760 update_engine[2222]: I20260902 14:22:26.711470 2222 main.cc:92] Flatcar Update Engine starting Sep 2 14:22:26.715662 systemd[1]: Finished nvidia.service - NVIDIA Configure Service. Sep 2 14:22:27.058843 bash[2251]: Updated "/home/core/.ssh/authorized_keys" Sep 2 14:22:27.059607 systemd[1]: Finished update-ssh-keys-after-ignition.service - Run update-ssh-keys once after Ignition. Sep 2 14:22:27.064527 extend-filesystems[2206]: Resized partition /dev/sda9 Sep 2 14:22:27.069869 sshd_keygen[2220]: ssh-keygen: generating new host keys: RSA ECDSA ED25519 MLDSA44-ED25519 Sep 2 14:22:27.066173 systemd[1]: sshkeys.service skipped, no trigger condition checks were met. Sep 2 14:22:27.086355 systemd[1]: Finished sshd-keygen.service - Generate sshd host keys. Sep 2 14:22:27.092190 systemd[1]: Starting issuegen.service - Generate /run/issue... Sep 2 14:22:27.102123 systemd[1]: Starting waagent.service - Microsoft Azure Linux Agent... Sep 2 14:22:27.106637 systemd[1]: issuegen.service: Deactivated successfully. Sep 2 14:22:27.106844 systemd[1]: Finished issuegen.service - Generate /run/issue. Sep 2 14:22:27.111347 extend-filesystems[2285]: resize2fs 1.47.4 (6-Mar-2025) Sep 2 14:22:27.119949 systemd[1]: Starting systemd-user-sessions.service - Permit User Sessions... Sep 2 14:22:27.132049 kernel: EXT4-fs (sda9): resizing filesystem from 6359552 to 6376955 blocks Sep 2 14:22:27.155395 kernel: EXT4-fs (sda9): resized filesystem to 6376955 Sep 2 14:22:27.141077 systemd[1]: Finished systemd-user-sessions.service - Permit User Sessions. Sep 2 14:22:27.153190 systemd[1]: Started getty@tty1.service - Getty on tty1. Sep 2 14:22:27.162067 systemd[1]: Started serial-getty@ttyAMA0.service - Serial Getty on ttyAMA0. Sep 2 14:22:27.170459 systemd[1]: Reached target getty.target - Login Prompts. Sep 2 14:22:27.175615 systemd[1]: Started waagent.service - Microsoft Azure Linux Agent. Sep 2 14:22:27.503132 extend-filesystems[2285]: Filesystem at /dev/sda9 is mounted on /; on-line resizing required Sep 2 14:22:27.503132 extend-filesystems[2285]: old_desc_blocks = 4, new_desc_blocks = 4 Sep 2 14:22:27.503132 extend-filesystems[2285]: The filesystem on /dev/sda9 is now 6376955 (4k) blocks long. Sep 2 14:22:27.526245 extend-filesystems[2206]: Resized filesystem in /dev/sda9 Sep 2 14:22:27.508461 systemd[1]: extend-filesystems.service: Deactivated successfully. Sep 2 14:22:27.508691 systemd[1]: Finished extend-filesystems.service - Extend Filesystems. Sep 2 14:22:27.843807 dbus-daemon[2203]: [system] SELinux support is enabled Sep 2 14:22:27.844230 systemd[1]: Started dbus.service - D-Bus System Message Bus. Sep 2 14:22:27.851196 update_engine[2222]: I20260902 14:22:27.851143 2222 update_check_scheduler.cc:74] Next update check in 5m9s Sep 2 14:22:27.852270 dbus-daemon[2203]: [system] Successfully activated service 'org.freedesktop.systemd1' Sep 2 14:22:27.852683 systemd[1]: Started update-engine.service - Update Engine. Sep 2 14:22:27.857175 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 2 14:22:27.857307 systemd[1]: Reached target system-config.target - Load system-provided cloud configs. Sep 2 14:22:27.863411 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 2 14:22:27.863497 systemd[1]: Reached target user-config.target - Load user-provided cloud configs. Sep 2 14:22:27.870311 systemd[1]: Started locksmithd.service - Cluster reboot manager. Sep 2 14:22:28.981380 locksmithd[2371]: locksmithd starting currentOperation="UPDATE_STATUS_IDLE" strategy="reboot" Sep 2 14:22:32.196433 containerd[2257]: time="2026-09-02T14:22:32Z" 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 2 14:22:32.197523 containerd[2257]: time="2026-09-02T14:22:32Z" level=warning msg="Configuration migrated from version 2, use `containerd config migrate` to avoid migration" t="11.36µs" Sep 2 14:22:32.198089 containerd[2257]: time="2026-09-02T14:22:32.198059352Z" level=info msg="starting containerd" revision=aad11006b869517fcd3009450b6f82da282e1a9b version=v2.3.3 Sep 2 14:22:32.198434 containerd[2257]: time="2026-09-02T14:22:32.198405224Z" level=info msg="loading plugin" id=io.containerd.content.v1.content type=io.containerd.content.v1 Sep 2 14:22:32.203283 containerd[2257]: time="2026-09-02T14:22:32.203252112Z" 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 2 14:22:32.203283 containerd[2257]: time="2026-09-02T14:22:32.203281712Z" level=info msg="loading plugin" id=io.containerd.image-verifier.v1.bindir type=io.containerd.image-verifier.v1 Sep 2 14:22:32.203358 containerd[2257]: time="2026-09-02T14:22:32.203290704Z" level=info msg="loading plugin" id=io.containerd.internal.v1.opt type=io.containerd.internal.v1 Sep 2 14:22:32.203391 containerd[2257]: time="2026-09-02T14:22:32.203375440Z" level=info msg="loading plugin" id=io.containerd.warning.v1.deprecations type=io.containerd.warning.v1 Sep 2 14:22:32.203391 containerd[2257]: time="2026-09-02T14:22:32.203388696Z" level=info msg="loading plugin" id=io.containerd.event.v1.exchange type=io.containerd.event.v1 Sep 2 14:22:32.203425 containerd[2257]: time="2026-09-02T14:22:32.203414472Z" level=info msg="loading plugin" id=io.containerd.mount-handler.v1.erofs type=io.containerd.mount-handler.v1 Sep 2 14:22:32.203443 containerd[2257]: time="2026-09-02T14:22:32.203425544Z" level=info msg="loading plugin" id=io.containerd.snapshotter.v1.blockfile type=io.containerd.snapshotter.v1 Sep 2 14:22:32.203496 containerd[2257]: time="2026-09-02T14:22:32.203481368Z" 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 2 14:22:32.203496 containerd[2257]: time="2026-09-02T14:22:32.203491120Z" level=info msg="loading plugin" id=io.containerd.snapshotter.v1.btrfs type=io.containerd.snapshotter.v1 Sep 2 14:22:32.203628 containerd[2257]: time="2026-09-02T14:22:32.203611176Z" 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 2 14:22:32.203628 containerd[2257]: time="2026-09-02T14:22:32.203625704Z" level=info msg="loading plugin" id=io.containerd.snapshotter.v1.devmapper type=io.containerd.snapshotter.v1 Sep 2 14:22:32.203658 containerd[2257]: time="2026-09-02T14:22:32.203632904Z" level=info msg="skip loading plugin" error="devmapper not configured: skip plugin" id=io.containerd.snapshotter.v1.devmapper type=io.containerd.snapshotter.v1 Sep 2 14:22:32.203658 containerd[2257]: time="2026-09-02T14:22:32.203638312Z" level=info msg="loading plugin" id=io.containerd.snapshotter.v1.erofs type=io.containerd.snapshotter.v1 Sep 2 14:22:32.203773 containerd[2257]: time="2026-09-02T14:22:32.203757872Z" level=info msg="loading plugin" id=io.containerd.snapshotter.v1.native type=io.containerd.snapshotter.v1 Sep 2 14:22:32.203810 containerd[2257]: time="2026-09-02T14:22:32.203799568Z" level=info msg="loading plugin" id=io.containerd.snapshotter.v1.overlayfs type=io.containerd.snapshotter.v1 Sep 2 14:22:32.203929 containerd[2257]: time="2026-09-02T14:22:32.203914992Z" level=info msg="loading plugin" id=io.containerd.snapshotter.v1.zfs type=io.containerd.snapshotter.v1 Sep 2 14:22:32.203949 containerd[2257]: time="2026-09-02T14:22:32.203938336Z" 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 2 14:22:32.203949 containerd[2257]: time="2026-09-02T14:22:32.203946376Z" level=info msg="loading plugin" id=io.containerd.monitor.task.v1.cgroups type=io.containerd.monitor.task.v1 Sep 2 14:22:32.204253 containerd[2257]: time="2026-09-02T14:22:32.204236360Z" level=info msg="loading plugin" id=io.containerd.metadata.v1.bolt type=io.containerd.metadata.v1 Sep 2 14:22:32.204311 containerd[2257]: time="2026-09-02T14:22:32.204297536Z" level=info msg="metadata content store policy set" policy=shared Sep 2 14:22:32.223383 containerd[2257]: time="2026-09-02T14:22:32.223355104Z" level=info msg="loading plugin" id=io.containerd.gc.v1.scheduler type=io.containerd.gc.v1 Sep 2 14:22:32.223442 containerd[2257]: time="2026-09-02T14:22:32.223393328Z" level=info msg="loading plugin" id=io.containerd.server.v1.metrics type=io.containerd.server.v1 Sep 2 14:22:32.223442 containerd[2257]: time="2026-09-02T14:22:32.223401000Z" level=info msg="skip loading plugin" error="skip plugin" id=io.containerd.server.v1.metrics type=io.containerd.server.v1 Sep 2 14:22:32.223442 containerd[2257]: time="2026-09-02T14:22:32.223409064Z" level=info msg="loading plugin" id=io.containerd.tracing.processor.v1.otlp type=io.containerd.tracing.processor.v1 Sep 2 14:22:32.223442 containerd[2257]: time="2026-09-02T14:22:32.223417264Z" 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 2 14:22:32.223442 containerd[2257]: time="2026-09-02T14:22:32.223422632Z" level=info msg="loading plugin" id=io.containerd.internal.v1.tracing type=io.containerd.internal.v1 Sep 2 14:22:32.223442 containerd[2257]: time="2026-09-02T14:22:32.223428352Z" 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 2 14:22:32.223442 containerd[2257]: time="2026-09-02T14:22:32.223432704Z" level=info msg="loading plugin" id=io.containerd.nri.v1.nri type=io.containerd.nri.v1 Sep 2 14:22:32.223608 containerd[2257]: time="2026-09-02T14:22:32.223498768Z" level=info msg="built-in NRI default validator is disabled" Sep 2 14:22:32.223608 containerd[2257]: time="2026-09-02T14:22:32.223503904Z" level=info msg="runtime interface created" Sep 2 14:22:32.223608 containerd[2257]: time="2026-09-02T14:22:32.223507376Z" level=info msg="created NRI interface" Sep 2 14:22:32.223608 containerd[2257]: time="2026-09-02T14:22:32.223511424Z" level=info msg="loading plugin" id=io.containerd.ttrpc.v1.otelttrpc type=io.containerd.ttrpc.v1 Sep 2 14:22:32.223608 containerd[2257]: time="2026-09-02T14:22:32.223516160Z" level=info msg="loading plugin" id=io.containerd.service.v1.containers-service type=io.containerd.service.v1 Sep 2 14:22:32.223608 containerd[2257]: time="2026-09-02T14:22:32.223522824Z" level=info msg="loading plugin" id=io.containerd.service.v1.content-service type=io.containerd.service.v1 Sep 2 14:22:32.223608 containerd[2257]: time="2026-09-02T14:22:32.223527664Z" level=info msg="loading plugin" id=io.containerd.differ.v1.erofs type=io.containerd.differ.v1 Sep 2 14:22:32.263952 containerd[2257]: time="2026-09-02T14:22:32.263908128Z" level=info msg="loading plugin" id=io.containerd.mount-manager.v1.bolt type=io.containerd.mount-manager.v1 Sep 2 14:22:32.264141 containerd[2257]: time="2026-09-02T14:22:32.264118344Z" level=info msg="loading plugin" id=io.containerd.differ.v1.walking type=io.containerd.differ.v1 Sep 2 14:22:32.264141 containerd[2257]: time="2026-09-02T14:22:32.264140032Z" level=info msg="loading plugin" id=io.containerd.service.v1.diff-service type=io.containerd.service.v1 Sep 2 14:22:32.264201 containerd[2257]: time="2026-09-02T14:22:32.264149608Z" level=info msg="loading plugin" id=io.containerd.service.v1.images-service type=io.containerd.service.v1 Sep 2 14:22:32.264201 containerd[2257]: time="2026-09-02T14:22:32.264157784Z" level=info msg="loading plugin" id=io.containerd.service.v1.introspection-service type=io.containerd.service.v1 Sep 2 14:22:32.264201 containerd[2257]: time="2026-09-02T14:22:32.264164616Z" level=info msg="loading plugin" id=io.containerd.service.v1.namespaces-service type=io.containerd.service.v1 Sep 2 14:22:32.264201 containerd[2257]: time="2026-09-02T14:22:32.264170688Z" level=info msg="loading plugin" id=io.containerd.service.v1.snapshots-service type=io.containerd.service.v1 Sep 2 14:22:32.264201 containerd[2257]: time="2026-09-02T14:22:32.264176408Z" level=info msg="loading plugin" id=io.containerd.shim.v1.manager type=io.containerd.shim.v1 Sep 2 14:22:32.264201 containerd[2257]: time="2026-09-02T14:22:32.264184728Z" level=info msg="loading plugin" id=io.containerd.runtime.v2.task type=io.containerd.runtime.v2 Sep 2 14:22:32.264309 containerd[2257]: time="2026-09-02T14:22:32.264292272Z" level=info msg="loading plugin" id=io.containerd.service.v1.tasks-service type=io.containerd.service.v1 Sep 2 14:22:32.264334 containerd[2257]: time="2026-09-02T14:22:32.264316368Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.containers type=io.containerd.grpc.v1 Sep 2 14:22:32.264334 containerd[2257]: time="2026-09-02T14:22:32.264324016Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.content type=io.containerd.grpc.v1 Sep 2 14:22:32.264334 containerd[2257]: time="2026-09-02T14:22:32.264329384Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.diff type=io.containerd.grpc.v1 Sep 2 14:22:32.264373 containerd[2257]: time="2026-09-02T14:22:32.264336272Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.events type=io.containerd.grpc.v1 Sep 2 14:22:32.264373 containerd[2257]: time="2026-09-02T14:22:32.264341384Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.images type=io.containerd.grpc.v1 Sep 2 14:22:32.264373 containerd[2257]: time="2026-09-02T14:22:32.264346776Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.introspection type=io.containerd.grpc.v1 Sep 2 14:22:32.264373 containerd[2257]: time="2026-09-02T14:22:32.264352656Z" level=info msg="loading plugin" id=io.containerd.lease.v1.manager type=io.containerd.lease.v1 Sep 2 14:22:32.264373 containerd[2257]: time="2026-09-02T14:22:32.264365136Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.leases type=io.containerd.grpc.v1 Sep 2 14:22:32.264373 containerd[2257]: time="2026-09-02T14:22:32.264370848Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.mounts type=io.containerd.grpc.v1 Sep 2 14:22:32.264453 containerd[2257]: time="2026-09-02T14:22:32.264375584Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.namespaces type=io.containerd.grpc.v1 Sep 2 14:22:32.264453 containerd[2257]: time="2026-09-02T14:22:32.264382352Z" level=info msg="loading plugin" id=io.containerd.sandbox.store.v1.local type=io.containerd.sandbox.store.v1 Sep 2 14:22:32.264453 containerd[2257]: time="2026-09-02T14:22:32.264387768Z" level=info msg="loading plugin" id=io.containerd.transfer.v1.local type=io.containerd.transfer.v1 Sep 2 14:22:32.264453 containerd[2257]: time="2026-09-02T14:22:32.264427144Z" level=info msg="loading plugin" id=io.containerd.cri.v1.images type=io.containerd.cri.v1 Sep 2 14:22:32.264527 containerd[2257]: time="2026-09-02T14:22:32.264457304Z" level=info msg="Get image filesystem path \"/var/lib/containerd/io.containerd.snapshotter.v1.overlayfs\" for snapshotter \"overlayfs\"" Sep 2 14:22:32.264527 containerd[2257]: time="2026-09-02T14:22:32.264466288Z" level=info msg="Start snapshots syncer" Sep 2 14:22:32.264527 containerd[2257]: time="2026-09-02T14:22:32.264485400Z" level=info msg="loading plugin" id=io.containerd.cri.v1.runtime type=io.containerd.cri.v1 Sep 2 14:22:32.264759 containerd[2257]: time="2026-09-02T14:22:32.264700680Z" 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 2 14:22:32.264759 containerd[2257]: time="2026-09-02T14:22:32.264733504Z" level=info msg="loading plugin" id=io.containerd.podsandbox.controller.v1.podsandbox type=io.containerd.podsandbox.controller.v1 Sep 2 14:22:32.264868 containerd[2257]: time="2026-09-02T14:22:32.264763752Z" level=info msg="loading plugin" id=io.containerd.sandbox.controller.v1.shim type=io.containerd.sandbox.controller.v1 Sep 2 14:22:32.264868 containerd[2257]: time="2026-09-02T14:22:32.264839648Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.sandbox-controllers type=io.containerd.grpc.v1 Sep 2 14:22:32.264868 containerd[2257]: time="2026-09-02T14:22:32.264852520Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.sandboxes type=io.containerd.grpc.v1 Sep 2 14:22:32.264868 containerd[2257]: time="2026-09-02T14:22:32.264857944Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.snapshots type=io.containerd.grpc.v1 Sep 2 14:22:32.264868 containerd[2257]: time="2026-09-02T14:22:32.264862792Z" level=info msg="loading plugin" id=io.containerd.streaming.v1.manager type=io.containerd.streaming.v1 Sep 2 14:22:32.264955 containerd[2257]: time="2026-09-02T14:22:32.264870648Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.streaming type=io.containerd.grpc.v1 Sep 2 14:22:32.264955 containerd[2257]: time="2026-09-02T14:22:32.264877136Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.tasks type=io.containerd.grpc.v1 Sep 2 14:22:32.264955 containerd[2257]: time="2026-09-02T14:22:32.264885744Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.transfer type=io.containerd.grpc.v1 Sep 2 14:22:32.264955 containerd[2257]: time="2026-09-02T14:22:32.264891696Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.version type=io.containerd.grpc.v1 Sep 2 14:22:32.264955 containerd[2257]: time="2026-09-02T14:22:32.264896096Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.healthcheck type=io.containerd.grpc.v1 Sep 2 14:22:32.264955 containerd[2257]: time="2026-09-02T14:22:32.264901616Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.cri type=io.containerd.grpc.v1 Sep 2 14:22:32.264955 containerd[2257]: time="2026-09-02T14:22:32.264911344Z" level=info msg="Connect containerd service" Sep 2 14:22:32.264955 containerd[2257]: time="2026-09-02T14:22:32.264927056Z" level=info msg="using experimental NRI integration - disable nri plugin to prevent this" Sep 2 14:22:32.265861 containerd[2257]: time="2026-09-02T14:22:32.265830904Z" 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 2 14:22:33.004281 login[2316]: pam_unix(login:session): session opened for user core(uid=500) by core(uid=0) Sep 2 14:22:33.004282 login[2314]: pam_unix(login:session): session opened for user core(uid=500) by core(uid=0) Sep 2 14:22:33.009929 systemd[1]: Created slice user-500.slice - User Slice of UID 500. Sep 2 14:22:33.011270 systemd[1]: Starting user-runtime-dir@500.service - User Runtime Directory /run/user/500... Sep 2 14:22:33.013154 systemd-logind[2218]: New session '2' of user 'core' with class 'user-light' and type 'tty'. Sep 2 14:22:33.016288 systemd-logind[2218]: New session '1' of user 'core' with class 'user-light' and type 'tty'. Sep 2 14:22:33.046872 systemd[1]: Finished user-runtime-dir@500.service - User Runtime Directory /run/user/500. Sep 2 14:22:33.050305 systemd[1]: Started session-1.scope - Session 1 of User core. Sep 2 14:22:33.050771 systemd[1]: Started session-2.scope - Session 2 of User core. Sep 2 14:22:33.378376 containerd[2257]: time="2026-09-02T14:22:33.378233368Z" level=info msg="loading plugin" id=io.containerd.server.v1.ttrpc type=io.containerd.server.v1 Sep 2 14:22:33.379367 containerd[2257]: time="2026-09-02T14:22:33.378272776Z" level=info msg="Start subscribing containerd event" Sep 2 14:22:33.379367 containerd[2257]: time="2026-09-02T14:22:33.378831320Z" level=info msg="Start stats collector" Sep 2 14:22:33.379367 containerd[2257]: time="2026-09-02T14:22:33.378838248Z" level=info msg="Start recovering state" Sep 2 14:22:33.379367 containerd[2257]: time="2026-09-02T14:22:33.378913568Z" level=info msg="Start event monitor" Sep 2 14:22:33.379367 containerd[2257]: time="2026-09-02T14:22:33.378922808Z" level=info msg="Start cni network conf syncer for default" Sep 2 14:22:33.379367 containerd[2257]: time="2026-09-02T14:22:33.378927288Z" level=info msg="Start streaming server" Sep 2 14:22:33.379367 containerd[2257]: time="2026-09-02T14:22:33.378932936Z" level=info msg="Registered namespace \"k8s.io\" with NRI" Sep 2 14:22:33.379367 containerd[2257]: time="2026-09-02T14:22:33.378937528Z" level=info msg="runtime interface starting up..." Sep 2 14:22:33.379367 containerd[2257]: time="2026-09-02T14:22:33.378941120Z" level=info msg="starting plugins..." Sep 2 14:22:33.379367 containerd[2257]: time="2026-09-02T14:22:33.378951584Z" level=info msg="Synchronizing NRI (plugin) with current runtime state" Sep 2 14:22:33.379367 containerd[2257]: time="2026-09-02T14:22:33.379063200Z" level=info msg="loading plugin" id=io.containerd.monitor.container.v1.restart type=io.containerd.monitor.container.v1 Sep 2 14:22:33.379367 containerd[2257]: time="2026-09-02T14:22:33.379103704Z" level=info msg="loading plugin" id=io.containerd.metrics.v1.grpc-prometheus type=io.containerd.metrics.v1 Sep 2 14:22:33.379367 containerd[2257]: time="2026-09-02T14:22:33.379134144Z" level=info msg="loading plugin" id=io.containerd.metrics.v1.grpc-otel type=io.containerd.metrics.v1 Sep 2 14:22:33.379367 containerd[2257]: time="2026-09-02T14:22:33.379151904Z" level=info msg="loading plugin" id=io.containerd.server.v1.grpc type=io.containerd.server.v1 Sep 2 14:22:33.387605 containerd[2257]: time="2026-09-02T14:22:33.387572304Z" level=info msg="loading plugin" id=io.containerd.server.v1.grpc-tcp type=io.containerd.server.v1 Sep 2 14:22:33.387605 containerd[2257]: time="2026-09-02T14:22:33.387605048Z" level=info msg="skip loading plugin" error="skip plugin" id=io.containerd.server.v1.grpc-tcp type=io.containerd.server.v1 Sep 2 14:22:33.387605 containerd[2257]: time="2026-09-02T14:22:33.387612304Z" level=info msg="loading plugin" id=io.containerd.http.v1.pprof type=io.containerd.http.v1 Sep 2 14:22:33.389383 containerd[2257]: time="2026-09-02T14:22:33.388020464Z" level=info msg="loading plugin" id=io.containerd.server.v1.debug type=io.containerd.server.v1 Sep 2 14:22:33.389383 containerd[2257]: time="2026-09-02T14:22:33.388047840Z" level=info msg="skip loading plugin" error="skip plugin" id=io.containerd.server.v1.debug type=io.containerd.server.v1 Sep 2 14:22:33.389383 containerd[2257]: time="2026-09-02T14:22:33.388131664Z" level=info msg=serving... address=/run/containerd/containerd.sock.ttrpc Sep 2 14:22:33.389383 containerd[2257]: time="2026-09-02T14:22:33.388147848Z" level=info msg="starting GRPC server" address=/run/containerd/containerd.sock gid=0 uid=0 Sep 2 14:22:33.389383 containerd[2257]: time="2026-09-02T14:22:33.388174376Z" level=info msg=serving... address=/run/containerd/containerd.sock Sep 2 14:22:33.388355 systemd[1]: Started containerd.service - containerd container runtime. Sep 2 14:22:33.390279 systemd[1]: Starting docker.service - Docker Application Container Engine... Sep 2 14:22:33.390470 containerd[2257]: time="2026-09-02T14:22:33.390444088Z" level=info msg="containerd successfully booted in 1.194255s" Sep 2 14:22:33.403330 (dockerd)[2437]: docker.service: Referenced but unset environment variable evaluates to an empty string: DOCKER_CGROUPS, DOCKER_OPTS, DOCKER_OPT_BIP, DOCKER_OPT_IPMASQ, DOCKER_OPT_MTU Sep 2 14:22:33.514079 waagent[2324]: 2026-09-02T14:22:33.513980Z INFO Daemon Daemon Azure Linux Agent Version: 2.12.0.4 Sep 2 14:22:33.518296 waagent[2324]: 2026-09-02T14:22:33.518256Z INFO Daemon Daemon OS: flatcar 9999.9.9 Sep 2 14:22:33.521950 waagent[2324]: 2026-09-02T14:22:33.521921Z INFO Daemon Daemon Python: 3.13.14 Sep 2 14:22:33.525920 waagent[2324]: 2026-09-02T14:22:33.525296Z INFO Daemon Daemon Run daemon Sep 2 14:22:33.528683 waagent[2324]: 2026-09-02T14:22:33.528641Z INFO Daemon Daemon No RDMA handler exists for distro='Flatcar Container Linux by Kinvolk' version='9999.9.9' Sep 2 14:22:33.535663 waagent[2324]: 2026-09-02T14:22:33.535635Z INFO Daemon Daemon Using waagent for provisioning Sep 2 14:22:33.540201 waagent[2324]: 2026-09-02T14:22:33.540166Z INFO Daemon Daemon Activate resource disk Sep 2 14:22:33.543940 waagent[2324]: 2026-09-02T14:22:33.543907Z INFO Daemon Daemon Searching gen1 prefix 00000000-0001 or gen2 f8b3781a-1e82-4818-a1c3-63d806ec15bb Sep 2 14:22:33.552384 waagent[2324]: 2026-09-02T14:22:33.552352Z INFO Daemon Daemon Found device: None Sep 2 14:22:33.555744 waagent[2324]: 2026-09-02T14:22:33.555711Z ERROR Daemon Daemon Failed to mount resource disk [ResourceDiskError] unable to detect disk topology Sep 2 14:22:33.562346 waagent[2324]: 2026-09-02T14:22:33.562314Z ERROR Daemon Daemon Event: name=WALinuxAgent, op=ActivateResourceDisk, message=[ResourceDiskError] unable to detect disk topology, duration=0 Sep 2 14:22:33.572277 waagent[2324]: 2026-09-02T14:22:33.572244Z INFO Daemon Daemon Clean protocol and wireserver endpoint Sep 2 14:22:33.577257 waagent[2324]: 2026-09-02T14:22:33.577227Z INFO Daemon Daemon Running default provisioning handler Sep 2 14:22:33.587062 waagent[2324]: 2026-09-02T14:22:33.586993Z 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 2 14:22:33.598232 waagent[2324]: 2026-09-02T14:22:33.598195Z INFO Daemon Daemon Unable to get cloud-init enabled status from service: [Errno 2] No such file or directory: 'service' Sep 2 14:22:33.605448 waagent[2324]: 2026-09-02T14:22:33.605415Z INFO Daemon Daemon cloud-init is enabled: False Sep 2 14:22:33.609382 waagent[2324]: 2026-09-02T14:22:33.609357Z INFO Daemon Daemon Copying ovf-env.xml Sep 2 14:22:33.711091 waagent[2324]: 2026-09-02T14:22:33.710200Z INFO Daemon Daemon Successfully mounted dvd Sep 2 14:22:33.785947 systemd[1]: mnt-cdrom-secure.mount: Deactivated successfully. Sep 2 14:22:33.788262 waagent[2324]: 2026-09-02T14:22:33.788178Z INFO Daemon Daemon Detect protocol endpoint Sep 2 14:22:33.792172 waagent[2324]: 2026-09-02T14:22:33.792136Z INFO Daemon Daemon Clean protocol and wireserver endpoint Sep 2 14:22:33.796242 waagent[2324]: 2026-09-02T14:22:33.796214Z INFO Daemon Daemon WireServer endpoint is not found. Rerun dhcp handler Sep 2 14:22:33.801200 waagent[2324]: 2026-09-02T14:22:33.801171Z INFO Daemon Daemon Test for route to 168.63.129.16 Sep 2 14:22:33.805401 waagent[2324]: 2026-09-02T14:22:33.805370Z INFO Daemon Daemon Route to 168.63.129.16 exists Sep 2 14:22:33.809623 waagent[2324]: 2026-09-02T14:22:33.809595Z INFO Daemon Daemon Wire server endpoint:168.63.129.16 Sep 2 14:22:33.896497 waagent[2324]: 2026-09-02T14:22:33.896448Z INFO Daemon Daemon Fabric preferred wire protocol version:2015-04-05 Sep 2 14:22:33.901814 waagent[2324]: 2026-09-02T14:22:33.901794Z INFO Daemon Daemon Wire protocol version:2012-11-30 Sep 2 14:22:33.905780 waagent[2324]: 2026-09-02T14:22:33.905756Z INFO Daemon Daemon Server preferred version:2015-04-05 Sep 2 14:22:34.014284 waagent[2324]: 2026-09-02T14:22:34.014205Z INFO Daemon Daemon Initializing goal state during protocol detection Sep 2 14:22:34.019299 waagent[2324]: 2026-09-02T14:22:34.019266Z INFO Daemon Daemon Forcing an update of the goal state. Sep 2 14:22:34.028312 waagent[2324]: 2026-09-02T14:22:34.028278Z INFO Daemon Fetched a new incarnation for the WireServer goal state [incarnation 1] Sep 2 14:22:34.043438 waagent[2324]: 2026-09-02T14:22:34.043405Z INFO Daemon Daemon HostGAPlugin version: 1.0.8.184 Sep 2 14:22:34.047732 waagent[2324]: 2026-09-02T14:22:34.047698Z INFO Daemon Sep 2 14:22:34.049853 waagent[2324]: 2026-09-02T14:22:34.049821Z INFO Daemon Fetched new vmSettings [HostGAPlugin correlation ID: 3c6cb290-319e-4769-bdee-7e41d8813512 eTag: 8885244386479313434 source: Fabric] Sep 2 14:22:34.058770 waagent[2324]: 2026-09-02T14:22:34.058733Z INFO Daemon The vmSettings originated via Fabric; will ignore them. Sep 2 14:22:34.063763 waagent[2324]: 2026-09-02T14:22:34.063735Z INFO Daemon Sep 2 14:22:34.065845 waagent[2324]: 2026-09-02T14:22:34.065821Z INFO Daemon Fetching full goal state from the WireServer [incarnation 1] Sep 2 14:22:34.072984 waagent[2324]: 2026-09-02T14:22:34.072958Z INFO Daemon Daemon Downloading artifacts profile blob Sep 2 14:22:34.179839 waagent[2324]: 2026-09-02T14:22:34.179784Z INFO Daemon Downloaded certificate {'thumbprint': '447BB200D997329B022045803E0EC6ACE2E3EA95', 'hasPrivateKey': True} Sep 2 14:22:34.187959 waagent[2324]: 2026-09-02T14:22:34.187924Z INFO Daemon Fetch goal state completed Sep 2 14:22:34.196290 waagent[2324]: 2026-09-02T14:22:34.196255Z INFO Daemon Daemon Starting provisioning Sep 2 14:22:34.200602 waagent[2324]: 2026-09-02T14:22:34.200569Z INFO Daemon Daemon Handle ovf-env.xml. Sep 2 14:22:34.204398 waagent[2324]: 2026-09-02T14:22:34.204374Z INFO Daemon Daemon Set hostname [ci-9999.9.9-l-3581e2040b] Sep 2 14:22:34.232114 waagent[2324]: 2026-09-02T14:22:34.232072Z INFO Daemon Daemon Publish hostname [ci-9999.9.9-l-3581e2040b] Sep 2 14:22:34.236884 waagent[2324]: 2026-09-02T14:22:34.236848Z INFO Daemon Daemon Examine /proc/net/route for primary interface Sep 2 14:22:34.241587 waagent[2324]: 2026-09-02T14:22:34.241555Z INFO Daemon Daemon Primary interface is [eth0] Sep 2 14:22:34.250525 systemd-networkd[1961]: eth0: Found matching .network file, based on potentially unpredictable interface name: /usr/lib/systemd/network/zz-default.network Sep 2 14:22:34.250533 systemd-networkd[1961]: eth0: Reconfiguring with /usr/lib/systemd/network/zz-default.network. Sep 2 14:22:34.250575 systemd-networkd[1961]: eth0: DHCP lease lost Sep 2 14:22:34.256145 waagent[2324]: 2026-09-02T14:22:34.256099Z INFO Daemon Daemon Create user account if not exists Sep 2 14:22:34.260428 waagent[2324]: 2026-09-02T14:22:34.260388Z INFO Daemon Daemon User core already exists, skip useradd Sep 2 14:22:34.265268 waagent[2324]: 2026-09-02T14:22:34.265193Z INFO Daemon Daemon Configure sudoer Sep 2 14:22:34.268664 waagent[2324]: 2026-09-02T14:22:34.268627Z INFO Daemon Daemon Configure sshd Sep 2 14:22:34.271900 waagent[2324]: 2026-09-02T14:22:34.271865Z INFO Daemon Daemon Added a configuration snippet disabling SSH password-based authentication methods. It also configures SSH client probing to keep connections alive. Sep 2 14:22:34.281539 waagent[2324]: 2026-09-02T14:22:34.281510Z INFO Daemon Daemon Deploy ssh public key. Sep 2 14:22:34.285666 systemd-networkd[1961]: eth0: DHCPv4 address 10.0.0.36/24, gateway 10.0.0.1 acquired from 168.63.129.16 Sep 2 14:22:35.405376 waagent[2324]: 2026-09-02T14:22:35.405330Z INFO Daemon Daemon Provisioning complete Sep 2 14:22:35.415229 waagent[2324]: 2026-09-02T14:22:35.415191Z INFO Daemon Daemon RDMA capabilities are not enabled, skipping Sep 2 14:22:35.419770 waagent[2324]: 2026-09-02T14:22:35.419739Z INFO Daemon Daemon End of log to /dev/console. The agent will now check for updates and then will process extensions. Sep 2 14:22:35.426854 waagent[2324]: 2026-09-02T14:22:35.426827Z INFO Daemon Daemon Installed Agent WALinuxAgent-2.12.0.4 is the most current agent Sep 2 14:22:35.520063 waagent[2463]: 2026-09-02T14:22:35.519999Z INFO ExtHandler ExtHandler Azure Linux Agent (Goal State Agent version 2.12.0.4) Sep 2 14:22:35.520309 waagent[2463]: 2026-09-02T14:22:35.520122Z INFO ExtHandler ExtHandler OS: flatcar 9999.9.9 Sep 2 14:22:35.520309 waagent[2463]: 2026-09-02T14:22:35.520169Z INFO ExtHandler ExtHandler Python: 3.13.14 Sep 2 14:22:35.520309 waagent[2463]: 2026-09-02T14:22:35.520203Z INFO ExtHandler ExtHandler CPU Arch: aarch64 Sep 2 14:22:35.560129 waagent[2463]: 2026-09-02T14:22:35.560079Z 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 2 14:22:35.560255 waagent[2463]: 2026-09-02T14:22:35.560228Z INFO ExtHandler ExtHandler WireServer endpoint 168.63.129.16 read from file Sep 2 14:22:35.560306 waagent[2463]: 2026-09-02T14:22:35.560288Z INFO ExtHandler ExtHandler Wire server endpoint:168.63.129.16 Sep 2 14:22:35.565554 waagent[2463]: 2026-09-02T14:22:35.565514Z INFO ExtHandler Fetched a new incarnation for the WireServer goal state [incarnation 1] Sep 2 14:22:35.569596 waagent[2463]: 2026-09-02T14:22:35.569567Z INFO ExtHandler ExtHandler HostGAPlugin version: 1.0.8.184 Sep 2 14:22:35.569917 waagent[2463]: 2026-09-02T14:22:35.569887Z INFO ExtHandler Sep 2 14:22:35.569973 waagent[2463]: 2026-09-02T14:22:35.569955Z INFO ExtHandler Fetched new vmSettings [HostGAPlugin correlation ID: 3413df94-7aec-4367-a0e0-d2d7c3e489b8 eTag: 8885244386479313434 source: Fabric] Sep 2 14:22:35.570206 waagent[2463]: 2026-09-02T14:22:35.570179Z INFO ExtHandler The vmSettings originated via Fabric; will ignore them. Sep 2 14:22:35.570587 waagent[2463]: 2026-09-02T14:22:35.570559Z INFO ExtHandler Sep 2 14:22:35.570633 waagent[2463]: 2026-09-02T14:22:35.570615Z INFO ExtHandler Fetching full goal state from the WireServer [incarnation 1] Sep 2 14:22:35.572752 waagent[2463]: 2026-09-02T14:22:35.572730Z INFO ExtHandler ExtHandler Downloading artifacts profile blob Sep 2 14:22:35.634857 waagent[2463]: 2026-09-02T14:22:35.634796Z INFO ExtHandler Downloaded certificate {'thumbprint': '447BB200D997329B022045803E0EC6ACE2E3EA95', 'hasPrivateKey': True} Sep 2 14:22:35.635235 waagent[2463]: 2026-09-02T14:22:35.635200Z INFO ExtHandler Fetch goal state completed Sep 2 14:22:35.643699 waagent[2463]: 2026-09-02T14:22:35.643652Z INFO ExtHandler ExtHandler OpenSSL version: OpenSSL 3.5.7 9 Jun 2026 (Library: OpenSSL 3.5.7 9 Jun 2026) Sep 2 14:22:35.646520 waagent[2463]: 2026-09-02T14:22:35.646475Z INFO ExtHandler ExtHandler WALinuxAgent-2.12.0.4 running as process 2463 Sep 2 14:22:35.646620 waagent[2463]: 2026-09-02T14:22:35.646596Z INFO ExtHandler ExtHandler ******** AutoUpdate.Enabled is set to False, not processing the operation ******** Sep 2 14:22:35.646857 waagent[2463]: 2026-09-02T14:22:35.646829Z INFO ExtHandler ExtHandler ******** AutoUpdate.UpdateToLatestVersion is set to False, not processing the operation ******** Sep 2 14:22:35.647865 waagent[2463]: 2026-09-02T14:22:35.647832Z INFO ExtHandler ExtHandler [CGI] Cgroup monitoring is not supported on ['flatcar', '9999.9.9', '', 'Flatcar Container Linux by Kinvolk'] Sep 2 14:22:35.648187 waagent[2463]: 2026-09-02T14:22:35.648158Z 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 2 14:22:35.648278 waagent[2463]: 2026-09-02T14:22:35.648256Z INFO ExtHandler ExtHandler [CGI] Agent cgroups enabled: False Sep 2 14:22:35.648655 waagent[2463]: 2026-09-02T14:22:35.648628Z INFO ExtHandler ExtHandler Starting setup for Persistent firewall rules Sep 2 14:22:35.738990 waagent[2463]: 2026-09-02T14:22:35.738910Z INFO ExtHandler ExtHandler Firewalld service not running/unavailable, trying to set up waagent-network-setup.service Sep 2 14:22:35.739123 waagent[2463]: 2026-09-02T14:22:35.739092Z INFO ExtHandler ExtHandler Successfully updated the Binary file /var/lib/waagent/waagent-network-setup.py for firewall setup Sep 2 14:22:35.743071 waagent[2463]: 2026-09-02T14:22:35.742791Z INFO ExtHandler ExtHandler Service: waagent-network-setup.service not enabled. Adding it now Sep 2 14:22:35.746874 systemd[1]: Reload requested from client PID 2478 ('systemctl') (unit waagent.service)... Sep 2 14:22:35.746889 systemd[1]: Reloading... Sep 2 14:22:35.820730 zram_generator::config[2530]: No configuration found. Sep 2 14:22:36.037694 systemd[1]: Reloading finished in 290 ms. Sep 2 14:22:36.061041 waagent[2463]: 2026-09-02T14:22:36.059462Z INFO ExtHandler ExtHandler Successfully added and enabled the waagent-network-setup.service Sep 2 14:22:36.061041 waagent[2463]: 2026-09-02T14:22:36.059600Z INFO ExtHandler ExtHandler Persistent firewall rules setup successfully Sep 2 14:22:36.380115 waagent[2463]: 2026-09-02T14:22:36.379980Z INFO ExtHandler ExtHandler DROP rule is not available which implies no firewall rules are set yet. Environment thread will set it up. Sep 2 14:22:36.380314 waagent[2463]: 2026-09-02T14:22:36.380279Z 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 2 14:22:36.380972 waagent[2463]: 2026-09-02T14:22:36.380931Z INFO ExtHandler ExtHandler Starting env monitor service. Sep 2 14:22:36.381194 waagent[2463]: 2026-09-02T14:22:36.381160Z INFO MonitorHandler ExtHandler WireServer endpoint 168.63.129.16 read from file Sep 2 14:22:36.381356 waagent[2463]: 2026-09-02T14:22:36.381228Z INFO MonitorHandler ExtHandler Wire server endpoint:168.63.129.16 Sep 2 14:22:36.381401 waagent[2463]: 2026-09-02T14:22:36.381362Z INFO ExtHandler ExtHandler Start SendTelemetryHandler service. Sep 2 14:22:36.381746 waagent[2463]: 2026-09-02T14:22:36.381709Z INFO MonitorHandler ExtHandler Monitor.NetworkConfigurationChanges is disabled. Sep 2 14:22:36.381900 waagent[2463]: 2026-09-02T14:22:36.381861Z INFO SendTelemetryHandler ExtHandler Successfully started the SendTelemetryHandler thread Sep 2 14:22:36.381972 waagent[2463]: 2026-09-02T14:22:36.381943Z INFO EnvHandler ExtHandler WireServer endpoint 168.63.129.16 read from file Sep 2 14:22:36.382022 waagent[2463]: 2026-09-02T14:22:36.382002Z INFO EnvHandler ExtHandler Wire server endpoint:168.63.129.16 Sep 2 14:22:36.382135 waagent[2463]: 2026-09-02T14:22:36.382114Z INFO EnvHandler ExtHandler Configure routes Sep 2 14:22:36.382218 waagent[2463]: 2026-09-02T14:22:36.382195Z INFO ExtHandler ExtHandler Start Extension Telemetry service. Sep 2 14:22:36.382390 waagent[2463]: 2026-09-02T14:22:36.382325Z INFO EnvHandler ExtHandler Gateway:None Sep 2 14:22:36.382445 waagent[2463]: 2026-09-02T14:22:36.382379Z INFO EnvHandler ExtHandler Routes:None Sep 2 14:22:36.382601 waagent[2463]: 2026-09-02T14:22:36.382565Z INFO TelemetryEventsCollector ExtHandler Extension Telemetry pipeline enabled: True Sep 2 14:22:36.382834 waagent[2463]: 2026-09-02T14:22:36.382778Z INFO MonitorHandler ExtHandler Routing table from /proc/net/route: Sep 2 14:22:36.382834 waagent[2463]: Iface Destination Gateway Flags RefCnt Use Metric Mask MTU Window IRTT Sep 2 14:22:36.382834 waagent[2463]: eth0 00000000 0100000A 0003 0 0 1024 00000000 0 0 0 Sep 2 14:22:36.382834 waagent[2463]: eth0 0000000A 00000000 0001 0 0 1024 00FFFFFF 0 0 0 Sep 2 14:22:36.382834 waagent[2463]: eth0 0100000A 00000000 0005 0 0 1024 FFFFFFFF 0 0 0 Sep 2 14:22:36.382834 waagent[2463]: eth0 10813FA8 0100000A 0007 0 0 1024 FFFFFFFF 0 0 0 Sep 2 14:22:36.382834 waagent[2463]: eth0 FEA9FEA9 0100000A 0007 0 0 1024 FFFFFFFF 0 0 0 Sep 2 14:22:36.383121 waagent[2463]: 2026-09-02T14:22:36.383071Z INFO ExtHandler ExtHandler Goal State Period: 6 sec. This indicates how often the agent checks for new goal states and reports status. Sep 2 14:22:36.383262 waagent[2463]: 2026-09-02T14:22:36.383234Z INFO TelemetryEventsCollector ExtHandler Successfully started the TelemetryEventsCollector thread Sep 2 14:22:36.388136 waagent[2463]: 2026-09-02T14:22:36.388101Z INFO ExtHandler ExtHandler Sep 2 14:22:36.388198 waagent[2463]: 2026-09-02T14:22:36.388172Z INFO ExtHandler ExtHandler ProcessExtensionsGoalState started [incarnation_1 channel: WireServer source: Fabric activity: 7cb054c0-9dc7-4696-bec8-9059d9b3ddae correlation 02d8985a-763c-40aa-8697-2fbe05936d16 created: 2026-09-02T14:20:59.911461Z] Sep 2 14:22:36.388444 waagent[2463]: 2026-09-02T14:22:36.388417Z INFO ExtHandler ExtHandler No extension handlers found, not processing anything. Sep 2 14:22:36.388810 waagent[2463]: 2026-09-02T14:22:36.388786Z INFO ExtHandler ExtHandler ProcessExtensionsGoalState completed [incarnation_1 0 ms] Sep 2 14:22:36.418216 waagent[2463]: 2026-09-02T14:22:36.418178Z INFO ExtHandler ExtHandler [HEARTBEAT] Agent WALinuxAgent-2.12.0.4 is running as the goal state agent [DEBUG HeartbeatCounter: 0;HeartbeatId: 7BE978D4-6FA4-4BC9-8EC4-DDB37AF294C3;DroppedPackets: 0;UpdateGSErrors: 0;AutoUpdate: 0;UpdateMode: SelfUpdate;] Sep 2 14:22:36.428357 waagent[2463]: 2026-09-02T14:22:36.428308Z INFO MonitorHandler ExtHandler Network interfaces: Sep 2 14:22:36.428357 waagent[2463]: Executing ['ip', '-a', '-o', 'link']: Sep 2 14:22:36.428357 waagent[2463]: 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 2 14:22:36.428357 waagent[2463]: 2: eth0: mtu 1500 qdisc mq state UP mode DEFAULT group default qlen 1000\ link/ether 00:0d:3a:fe:63:f2 brd ff:ff:ff:ff:ff:ff\ altname enx000d3afe63f2 Sep 2 14:22:36.428357 waagent[2463]: 3: enP13814s1: mtu 1500 qdisc mq master eth0 state UP mode DEFAULT group default qlen 1000\ link/ether 00:0d:3a:fe:63:f2 brd ff:ff:ff:ff:ff:ff\ altname enP13814p0s2 Sep 2 14:22:36.428357 waagent[2463]: Executing ['ip', '-4', '-a', '-o', 'address']: Sep 2 14:22:36.428357 waagent[2463]: 1: lo inet 127.0.0.1/8 scope host lo\ valid_lft forever preferred_lft forever Sep 2 14:22:36.428357 waagent[2463]: 2: eth0 inet 10.0.0.36/24 metric 1024 brd 10.0.0.255 scope global eth0\ valid_lft forever preferred_lft forever Sep 2 14:22:36.428357 waagent[2463]: Executing ['ip', '-6', '-a', '-o', 'address']: Sep 2 14:22:36.428357 waagent[2463]: 1: lo inet6 ::1/128 scope host noprefixroute \ valid_lft forever preferred_lft forever Sep 2 14:22:36.428357 waagent[2463]: 2: eth0 inet6 fe80::20d:3aff:fefe:63f2/64 scope link proto kernel_ll \ valid_lft forever preferred_lft forever Sep 2 14:22:36.503120 waagent[2463]: 2026-09-02T14:22:36.503069Z INFO EnvHandler ExtHandler Created firewall rules for the Azure Fabric: Sep 2 14:22:36.503120 waagent[2463]: Chain INPUT (policy ACCEPT 0 packets, 0 bytes) Sep 2 14:22:36.503120 waagent[2463]: pkts bytes target prot opt in out source destination Sep 2 14:22:36.503120 waagent[2463]: Chain FORWARD (policy ACCEPT 0 packets, 0 bytes) Sep 2 14:22:36.503120 waagent[2463]: pkts bytes target prot opt in out source destination Sep 2 14:22:36.503120 waagent[2463]: Chain OUTPUT (policy ACCEPT 0 packets, 0 bytes) Sep 2 14:22:36.503120 waagent[2463]: pkts bytes target prot opt in out source destination Sep 2 14:22:36.503120 waagent[2463]: 0 0 ACCEPT tcp -- * * 0.0.0.0/0 168.63.129.16 tcp dpt:53 Sep 2 14:22:36.503120 waagent[2463]: 0 0 ACCEPT tcp -- * * 0.0.0.0/0 168.63.129.16 owner UID match 0 Sep 2 14:22:36.503120 waagent[2463]: 0 0 DROP tcp -- * * 0.0.0.0/0 168.63.129.16 ctstate INVALID,NEW Sep 2 14:22:36.505381 waagent[2463]: 2026-09-02T14:22:36.505338Z INFO EnvHandler ExtHandler Current Firewall rules: Sep 2 14:22:36.505381 waagent[2463]: Chain INPUT (policy ACCEPT 0 packets, 0 bytes) Sep 2 14:22:36.505381 waagent[2463]: pkts bytes target prot opt in out source destination Sep 2 14:22:36.505381 waagent[2463]: Chain FORWARD (policy ACCEPT 0 packets, 0 bytes) Sep 2 14:22:36.505381 waagent[2463]: pkts bytes target prot opt in out source destination Sep 2 14:22:36.505381 waagent[2463]: Chain OUTPUT (policy ACCEPT 0 packets, 0 bytes) Sep 2 14:22:36.505381 waagent[2463]: pkts bytes target prot opt in out source destination Sep 2 14:22:36.505381 waagent[2463]: 0 0 ACCEPT tcp -- * * 0.0.0.0/0 168.63.129.16 tcp dpt:53 Sep 2 14:22:36.505381 waagent[2463]: 0 0 ACCEPT tcp -- * * 0.0.0.0/0 168.63.129.16 owner UID match 0 Sep 2 14:22:36.505381 waagent[2463]: 0 0 DROP tcp -- * * 0.0.0.0/0 168.63.129.16 ctstate INVALID,NEW Sep 2 14:22:36.505570 waagent[2463]: 2026-09-02T14:22:36.505544Z INFO EnvHandler ExtHandler Set block dev timeout: sda with timeout: 300 Sep 2 14:22:41.102797 dockerd[2437]: time="2026-09-02T14:22:41.102725256Z" level=info msg="Starting up" Sep 2 14:22:41.145493 dockerd[2437]: time="2026-09-02T14:22:41.145456280Z" level=info msg="OTEL tracing is not configured, using no-op tracer provider" Sep 2 14:22:41.145595 dockerd[2437]: time="2026-09-02T14:22:41.145546136Z" level=info msg="CDI directory does not exist, skipping" dir=/etc/cdi Sep 2 14:22:41.145595 dockerd[2437]: time="2026-09-02T14:22:41.145553800Z" level=info msg="CDI directory does not exist, skipping" dir=/var/run/cdi Sep 2 14:22:41.153918 dockerd[2437]: time="2026-09-02T14:22:41.153882952Z" level=info msg="Creating a containerd client" address=/var/run/docker/libcontainerd/docker-containerd.sock timeout=1m0s Sep 2 14:22:41.198765 dockerd[2437]: time="2026-09-02T14:22:41.198734816Z" level=info msg="Loading containers: start." Sep 2 14:22:41.199456 dockerd[2437]: time="2026-09-02T14:22:41.199431912Z" level=info msg="NRI is disabled" Sep 2 14:22:41.199456 dockerd[2437]: time="2026-09-02T14:22:41.199452768Z" level=info msg="Starting daemon with containerd snapshotter integration enabled" Sep 2 14:22:41.260959 dockerd[2437]: time="2026-09-02T14:22:41.260919880Z" level=info msg="Restoring containers: start." Sep 2 14:22:41.296362 dockerd[2437]: time="2026-09-02T14:22:41.296302568Z" level=info msg="Deleting nftables IPv4 rules" error="exit status 1" output="Error: Could not process rule: No such file or directory\ndelete table ip docker-bridges" Sep 2 14:22:41.302307 dockerd[2437]: time="2026-09-02T14:22:41.302270560Z" level=info msg="Deleting nftables IPv6 rules" error="exit status 1" output="Error: Could not process rule: No such file or directory\ndelete table ip6 docker-bridges" Sep 2 14:22:41.660059 kernel: Initializing XFRM netlink socket Sep 2 14:22:41.787939 systemd-networkd[1961]: docker0: Link UP Sep 2 14:22:41.806906 dockerd[2437]: time="2026-09-02T14:22:41.806870032Z" level=info msg="Loading containers: done." Sep 2 14:22:41.948221 dockerd[2437]: time="2026-09-02T14:22:41.948102720Z" level=info msg="Docker daemon" commit=568f755ebeb1ac9c6a8febbda6cd371ea0a9630b containerd-snapshotter=true storage-driver=overlayfs version=29.5.2 Sep 2 14:22:41.948337 dockerd[2437]: time="2026-09-02T14:22:41.948279704Z" level=info msg="Initializing buildkit" Sep 2 14:22:42.332379 dockerd[2437]: time="2026-09-02T14:22:42.332332568Z" level=info msg="Completed buildkit initialization" Sep 2 14:22:42.353586 dockerd[2437]: time="2026-09-02T14:22:42.353555768Z" level=info msg="Daemon has completed initialization" Sep 2 14:22:42.353759 dockerd[2437]: time="2026-09-02T14:22:42.353599848Z" level=info msg="API listen on /run/docker.sock" Sep 2 14:22:42.353912 systemd[1]: Started docker.service - Docker Application Container Engine. Sep 2 14:22:42.359711 systemd[1]: Reached target multi-user.target - Multi-User System. Sep 2 14:22:42.364259 systemd[1]: Startup finished in 3.510s (kernel) + 20.925s (initrd) + 53.202s (userspace) = 1min 17.639s. Sep 2 14:22:49.399617 systemd[1]: Created slice system-sshd.slice - Slice /system/sshd. Sep 2 14:22:49.400647 systemd[1]: Started sshd@0-1-10.0.0.36:22-20.76.204.135:39212.service - OpenSSH per-connection server daemon (20.76.204.135:39212). Sep 2 14:22:50.149991 chronyd[2201]: Selected source PHC0 Sep 2 14:22:50.321678 sshd[2781]: Accepted publickey for core from 20.76.204.135 port 39212 ssh2: RSA SHA256:qwKiGxZTk0pKCcgAQ40OuGA9LRk6qbFYVymbggdD6bE Sep 2 14:22:50.322765 sshd-session[2781]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Sep 2 14:22:50.329067 systemd[1]: Starting user@500.service - User Manager for UID 500... Sep 2 14:22:50.330935 systemd-logind[2218]: New session '3' of user 'core' with class 'user' and type 'tty'. Sep 2 14:22:50.336862 (systemd)[2785]: pam_unix(systemd-user:session): session opened for user core(uid=500) by core(uid=0) Sep 2 14:22:50.338586 systemd-logind[2218]: New session '4' of user 'core' with class 'manager-early' and type 'unspecified'. Sep 2 14:22:50.569840 systemd[2785]: Queued start job for default target default.target. Sep 2 14:22:50.575743 systemd[2785]: Created slice app.slice - User Application Slice. Sep 2 14:22:50.575772 systemd[2785]: Started systemd-tmpfiles-clean.timer - Daily Cleanup of User's Temporary Directories. Sep 2 14:22:50.575782 systemd[2785]: Reached target machines.target - Virtual Machines and Containers. Sep 2 14:22:50.575825 systemd[2785]: Reached target paths.target - Paths. Sep 2 14:22:50.575840 systemd[2785]: Reached target timers.target - Timers. Sep 2 14:22:50.576913 systemd[2785]: Starting dbus.socket - D-Bus User Message Bus Socket... Sep 2 14:22:50.578097 systemd[2785]: Listening on systemd-ask-password.socket - Query the User Interactively for a Password. Sep 2 14:22:50.578222 systemd[2785]: Listening on systemd-importd.socket - Disk Image Download Service Socket. Sep 2 14:22:50.578860 systemd[2785]: Listening on systemd-journalctl.socket - Journal Log Access Socket. Sep 2 14:22:50.579006 systemd[2785]: Listening on systemd-machined.socket - Virtual Machine and Container Registration Service Socket. Sep 2 14:22:50.580774 systemd[2785]: Starting systemd-tmpfiles-setup.service - Create User Files and Directories... Sep 2 14:22:50.585822 systemd[2785]: Listening on dbus.socket - D-Bus User Message Bus Socket. Sep 2 14:22:50.586388 systemd[2785]: Reached target sockets.target - Sockets. Sep 2 14:22:50.589471 systemd[2785]: Finished systemd-tmpfiles-setup.service - Create User Files and Directories. Sep 2 14:22:50.589546 systemd[2785]: Reached target basic.target - Basic System. Sep 2 14:22:50.589588 systemd[2785]: Reached target default.target - Main User Target. Sep 2 14:22:50.589607 systemd[2785]: Startup finished in 247ms. Sep 2 14:22:50.590056 systemd[1]: Started user@500.service - User Manager for UID 500. Sep 2 14:22:50.596189 systemd[1]: Started session-3.scope - Session 3 of User core. Sep 2 14:22:51.022576 systemd[1]: Started sshd@1-4097-10.0.0.36:22-20.76.204.135:39226.service - OpenSSH per-connection server daemon (20.76.204.135:39226). Sep 2 14:22:51.753642 sshd[2799]: Accepted publickey for core from 20.76.204.135 port 39226 ssh2: RSA SHA256:qwKiGxZTk0pKCcgAQ40OuGA9LRk6qbFYVymbggdD6bE Sep 2 14:22:51.754447 sshd-session[2799]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Sep 2 14:22:51.758449 systemd-logind[2218]: New session '5' of user 'core' with class 'user' and type 'tty'. Sep 2 14:22:51.763162 systemd[1]: Started session-5.scope - Session 5 of User core. Sep 2 14:22:52.174828 sshd[2803]: Connection closed by 20.76.204.135 port 39226 Sep 2 14:22:52.176213 sshd-session[2799]: pam_unix(sshd:session): session closed for user core Sep 2 14:22:52.178670 systemd[1]: sshd@1-4097-10.0.0.36:22-20.76.204.135:39226.service: Deactivated successfully. Sep 2 14:22:52.180552 systemd[1]: session-5.scope: Deactivated successfully. Sep 2 14:22:52.181702 systemd-logind[2218]: Session 5 logged out. Waiting for processes to exit. Sep 2 14:22:52.182492 systemd-logind[2218]: Removed session 5. Sep 2 14:22:52.328668 systemd[1]: Started sshd@2-4098-10.0.0.36:22-20.76.204.135:39236.service - OpenSSH per-connection server daemon (20.76.204.135:39236). Sep 2 14:22:53.069768 sshd[2809]: Accepted publickey for core from 20.76.204.135 port 39236 ssh2: RSA SHA256:qwKiGxZTk0pKCcgAQ40OuGA9LRk6qbFYVymbggdD6bE Sep 2 14:22:53.070852 sshd-session[2809]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Sep 2 14:22:53.074125 systemd-logind[2218]: New session '6' of user 'core' with class 'user' and type 'tty'. Sep 2 14:22:53.077168 systemd[1]: Started session-6.scope - Session 6 of User core. Sep 2 14:22:53.494703 sshd[2813]: Connection closed by 20.76.204.135 port 39236 Sep 2 14:22:53.496223 sshd-session[2809]: pam_unix(sshd:session): session closed for user core Sep 2 14:22:53.501733 systemd[1]: sshd@2-4098-10.0.0.36:22-20.76.204.135:39236.service: Deactivated successfully. Sep 2 14:22:53.503561 systemd[1]: session-6.scope: Deactivated successfully. Sep 2 14:22:53.504663 systemd-logind[2218]: Session 6 logged out. Waiting for processes to exit. Sep 2 14:22:53.505437 systemd-logind[2218]: Removed session 6. Sep 2 14:22:53.642849 systemd[1]: Started sshd@3-4099-10.0.0.36:22-20.76.204.135:39248.service - OpenSSH per-connection server daemon (20.76.204.135:39248). Sep 2 14:22:54.375782 sshd[2819]: Accepted publickey for core from 20.76.204.135 port 39248 ssh2: RSA SHA256:qwKiGxZTk0pKCcgAQ40OuGA9LRk6qbFYVymbggdD6bE Sep 2 14:22:54.376844 sshd-session[2819]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Sep 2 14:22:54.380548 systemd-logind[2218]: New session '7' of user 'core' with class 'user' and type 'tty'. Sep 2 14:22:54.383179 systemd[1]: Started session-7.scope - Session 7 of User core. Sep 2 14:22:54.798446 sshd[2823]: Connection closed by 20.76.204.135 port 39248 Sep 2 14:22:54.799244 sshd-session[2819]: pam_unix(sshd:session): session closed for user core Sep 2 14:22:54.802310 systemd[1]: sshd@3-4099-10.0.0.36:22-20.76.204.135:39248.service: Deactivated successfully. Sep 2 14:22:54.804616 systemd[1]: session-7.scope: Deactivated successfully. Sep 2 14:22:54.805310 systemd-logind[2218]: Session 7 logged out. Waiting for processes to exit. Sep 2 14:22:54.806267 systemd-logind[2218]: Removed session 7. Sep 2 14:22:54.946466 systemd[1]: Started sshd@4-2-10.0.0.36:22-20.76.204.135:39260.service - OpenSSH per-connection server daemon (20.76.204.135:39260). Sep 2 14:22:55.678332 sshd[2829]: Accepted publickey for core from 20.76.204.135 port 39260 ssh2: RSA SHA256:qwKiGxZTk0pKCcgAQ40OuGA9LRk6qbFYVymbggdD6bE Sep 2 14:22:55.679424 sshd-session[2829]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Sep 2 14:22:55.683122 systemd-logind[2218]: New session '8' of user 'core' with class 'user' and type 'tty'. Sep 2 14:22:55.691166 systemd[1]: Started session-8.scope - Session 8 of User core. Sep 2 14:22:55.937128 kernel: hv_balloon: Max. dynamic memory size: 4096 MB Sep 2 14:22:56.129672 sudo[2834]: core : PWD=/home/core ; USER=root ; COMMAND=/usr/sbin/setenforce 1 Sep 2 14:22:56.129882 sudo[2834]: pam_unix(sudo:session): session opened for user root(uid=0) by core(uid=500) Sep 2 14:22:56.180532 sudo[2834]: pam_unix(sudo:session): session closed for user root Sep 2 14:22:56.320751 sshd[2833]: Connection closed by 20.76.204.135 port 39260 Sep 2 14:22:56.322269 sshd-session[2829]: pam_unix(sshd:session): session closed for user core Sep 2 14:22:56.324983 systemd[1]: sshd@4-2-10.0.0.36:22-20.76.204.135:39260.service: Deactivated successfully. Sep 2 14:22:56.326617 systemd[1]: session-8.scope: Deactivated successfully. Sep 2 14:22:56.327351 systemd-logind[2218]: Session 8 logged out. Waiting for processes to exit. Sep 2 14:22:56.328518 systemd-logind[2218]: Removed session 8. Sep 2 14:22:56.472637 systemd[1]: Started sshd@5-3-10.0.0.36:22-20.76.204.135:60620.service - OpenSSH per-connection server daemon (20.76.204.135:60620). Sep 2 14:22:57.217830 sshd[2841]: Accepted publickey for core from 20.76.204.135 port 60620 ssh2: RSA SHA256:qwKiGxZTk0pKCcgAQ40OuGA9LRk6qbFYVymbggdD6bE Sep 2 14:22:57.218964 sshd-session[2841]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Sep 2 14:22:57.222613 systemd-logind[2218]: New session '9' of user 'core' with class 'user' and type 'tty'. Sep 2 14:22:57.227192 systemd[1]: Started session-9.scope - Session 9 of User core. Sep 2 14:22:57.506196 sudo[2847]: 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 2 14:22:57.506401 sudo[2847]: pam_unix(sudo:session): session opened for user root(uid=0) by core(uid=500) Sep 2 14:22:57.507564 sudo[2847]: pam_unix(sudo:session): session closed for user root Sep 2 14:22:57.512013 sudo[2846]: core : PWD=/home/core ; USER=root ; COMMAND=/usr/sbin/systemctl restart audit-rules Sep 2 14:22:57.512225 sudo[2846]: pam_unix(sudo:session): session opened for user root(uid=0) by core(uid=500) Sep 2 14:22:57.517141 systemd[1]: Starting audit-rules.service - Load Audit Rules... Sep 2 14:22:57.557000 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 2 14:22:57.557000 audit[2871]: SYSCALL arch=c00000b7 syscall=206 success=yes exit=1056 a0=3 a1=ffffe4bcfff0 a2=420 a3=0 items=0 ppid=2852 pid=2871 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 2 14:22:57.557000 audit: PROCTITLE proctitle=2F7362696E2F617564697463746C002D52002F6574632F61756469742F61756469742E72756C6573 Sep 2 14:22:57.569674 augenrules[2871]: No rules Sep 2 14:22:57.569840 kernel: kauditd_printk_skb: 84 callbacks suppressed Sep 2 14:22:57.569864 kernel: audit: type=1305 audit(1788358977.557:178): auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 op=remove_rule key=(null) list=5 res=1 Sep 2 14:22:57.569876 kernel: audit: type=1300 audit(1788358977.557:178): arch=c00000b7 syscall=206 success=yes exit=1056 a0=3 a1=ffffe4bcfff0 a2=420 a3=0 items=0 ppid=2852 pid=2871 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 2 14:22:57.569892 kernel: audit: type=1327 audit(1788358977.557:178): proctitle=2F7362696E2F617564697463746C002D52002F6574632F61756469742F61756469742E72756C6573 Sep 2 14:22:57.569000 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 2 14:22:57.569000 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 2 14:22:57.569000 audit[2846]: AUDIT1106 pid=2846 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 2 14:22:57.569000 audit[2846]: AUDIT1104 pid=2846 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 2 14:22:57.583376 kernel: audit: type=1130 audit(1788358977.569:179): 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 2 14:22:57.573768 sudo[2846]: pam_unix(sudo:session): session closed for user root Sep 2 14:22:57.571225 systemd[1]: audit-rules.service: Deactivated successfully. Sep 2 14:22:57.583474 kernel: audit: type=1131 audit(1788358977.569:180): 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 2 14:22:57.571513 systemd[1]: Finished audit-rules.service - Load Audit Rules. Sep 2 14:22:57.583512 kernel: audit: type=1106 audit(1788358977.569:181): pid=2846 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 2 14:22:57.583525 kernel: audit: type=1104 audit(1788358977.569:182): pid=2846 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 2 14:22:57.715857 sshd[2845]: Connection closed by 20.76.204.135 port 60620 Sep 2 14:22:57.717258 sshd-session[2841]: pam_unix(sshd:session): session closed for user core Sep 2 14:22:57.716000 audit[2841]: AUDIT1106 pid=2841 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.76.204.135 addr=20.76.204.135 terminal=ssh res=success' Sep 2 14:22:57.718046 kernel: audit: type=1106 audit(1788358977.716:183): pid=2841 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.76.204.135 addr=20.76.204.135 terminal=ssh res=success' Sep 2 14:22:57.718000 audit[2841]: AUDIT1104 pid=2841 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.76.204.135 addr=20.76.204.135 terminal=ssh res=success' Sep 2 14:22:57.721245 kernel: audit: type=1104 audit(1788358977.718:184): pid=2841 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.76.204.135 addr=20.76.204.135 terminal=ssh res=success' Sep 2 14:22:57.722354 systemd[1]: sshd@5-3-10.0.0.36:22-20.76.204.135:60620.service: Deactivated successfully. Sep 2 14:22:57.721000 audit[1]: SERVICE_STOP pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=sshd@5-3-10.0.0.36:22-20.76.204.135:60620 comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Sep 2 14:22:57.723046 kernel: audit: type=1131 audit(1788358977.721:185): pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=sshd@5-3-10.0.0.36:22-20.76.204.135:60620 comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Sep 2 14:22:57.724999 systemd[1]: session-9.scope: Deactivated successfully. Sep 2 14:22:57.726732 systemd-logind[2218]: Session 9 logged out. Waiting for processes to exit. Sep 2 14:22:57.728299 systemd-logind[2218]: Removed session 9. Sep 2 14:22:57.862099 systemd[1]: Started sshd@6-4-10.0.0.36:22-20.76.204.135:60634.service - OpenSSH per-connection server daemon (20.76.204.135:60634). Sep 2 14:22:57.861000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=sshd@6-4-10.0.0.36:22-20.76.204.135:60634 comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Sep 2 14:22:58.593000 audit[2880]: AUDIT1101 pid=2880 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.76.204.135 addr=20.76.204.135 terminal=ssh res=success' Sep 2 14:22:58.594296 sshd[2880]: Accepted publickey for core from 20.76.204.135 port 60634 ssh2: RSA SHA256:qwKiGxZTk0pKCcgAQ40OuGA9LRk6qbFYVymbggdD6bE Sep 2 14:22:58.594000 audit[2880]: AUDIT1103 pid=2880 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.76.204.135 addr=20.76.204.135 terminal=ssh res=success' Sep 2 14:22:58.594000 audit[2880]: SYSCALL arch=c00000b7 syscall=64 success=yes exit=3 a0=8 a1=ffffefd45ea0 a2=3 a3=0 items=0 ppid=1 pid=2880 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 2 14:22:58.594000 audit: PROCTITLE proctitle=737368642D73657373696F6E3A20636F7265205B707269765D Sep 2 14:22:58.595268 sshd-session[2880]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Sep 2 14:22:58.599084 systemd-logind[2218]: New session '10' of user 'core' with class 'user' and type 'tty'. Sep 2 14:22:58.608167 systemd[1]: Started session-10.scope - Session 10 of User core. Sep 2 14:22:58.609000 audit[2880]: AUDIT1105 pid=2880 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.76.204.135 addr=20.76.204.135 terminal=ssh res=success' Sep 2 14:22:58.611000 audit[2884]: AUDIT1103 pid=2884 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.76.204.135 addr=20.76.204.135 terminal=ssh res=success' Sep 2 14:22:59.016304 sshd[2884]: Connection closed by 20.76.204.135 port 60634 Sep 2 14:22:59.017201 sshd-session[2880]: pam_unix(sshd:session): session closed for user core Sep 2 14:22:59.016000 audit[2880]: AUDIT1106 pid=2880 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.76.204.135 addr=20.76.204.135 terminal=ssh res=success' Sep 2 14:22:59.016000 audit[2880]: AUDIT1104 pid=2880 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.76.204.135 addr=20.76.204.135 terminal=ssh res=success' Sep 2 14:22:59.019892 systemd[1]: sshd@6-4-10.0.0.36:22-20.76.204.135:60634.service: Deactivated successfully. Sep 2 14:22:59.019000 audit[1]: SERVICE_STOP pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=sshd@6-4-10.0.0.36:22-20.76.204.135:60634 comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Sep 2 14:22:59.021346 systemd[1]: session-10.scope: Deactivated successfully. Sep 2 14:22:59.022386 systemd-logind[2218]: Session 10 logged out. Waiting for processes to exit. Sep 2 14:22:59.023419 systemd-logind[2218]: Removed session 10.