Sep 3 19:16:27.177804 kernel: Booting Linux on physical CPU 0x0000000000 [0x410fd490] Sep 3 19:16:27.177834 kernel: Linux version 6.12.105-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 Thu Sep 3 16:27:57 -00 2026 Sep 3 19:16:27.177841 kernel: KASLR enabled Sep 3 19:16:27.177847 kernel: earlycon: pl11 at MMIO 0x00000000effec000 (options '') Sep 3 19:16:27.177852 kernel: printk: legacy bootconsole [pl11] enabled Sep 3 19:16:27.177857 kernel: efi: EFI v2.7 by EDK II Sep 3 19:16:27.177864 kernel: efi: ACPI 2.0=0x3f979018 SMBIOS=0x3f8a0000 SMBIOS 3.0=0x3f880000 MEMATTR=0x3e879018 RNG=0x3f979718 MEMRESERVE=0x3decaf98 Sep 3 19:16:27.177869 kernel: random: crng init done Sep 3 19:16:27.177874 kernel: secureboot: Secure boot disabled Sep 3 19:16:27.177878 kernel: ACPI: Early table checksum verification disabled Sep 3 19:16:27.177883 kernel: ACPI: RSDP 0x000000003F979018 000024 (v02 VRTUAL) Sep 3 19:16:27.177887 kernel: ACPI: XSDT 0x000000003F979F18 00006C (v01 VRTUAL MICROSFT 00000001 MSFT 00000001) Sep 3 19:16:27.177893 kernel: ACPI: FACP 0x000000003F979C18 000114 (v06 VRTUAL MICROSFT 00000001 MSFT 00000001) Sep 3 19:16:27.177897 kernel: ACPI: DSDT 0x000000003F95A018 01E046 (v02 MSFTVM DSDT01 00000001 INTL 20230628) Sep 3 19:16:27.177904 kernel: ACPI: DBG2 0x000000003F979B18 000072 (v00 VRTUAL MICROSFT 00000001 MSFT 00000001) Sep 3 19:16:27.177910 kernel: ACPI: GTDT 0x000000003F979D98 000060 (v02 VRTUAL MICROSFT 00000001 MSFT 00000001) Sep 3 19:16:27.177915 kernel: ACPI: OEM0 0x000000003F979098 000064 (v01 VRTUAL MICROSFT 00000001 MSFT 00000001) Sep 3 19:16:27.177921 kernel: ACPI: SPCR 0x000000003F979A98 000050 (v02 VRTUAL MICROSFT 00000001 MSFT 00000001) Sep 3 19:16:27.177926 kernel: ACPI: APIC 0x000000003F979818 0000EE (v05 HVLITE HVLITETB 00000000 MSHV 00000000) Sep 3 19:16:27.177932 kernel: ACPI: SRAT 0x000000003F979998 0000A4 (v03 HVLITE HVLITETB 00000000 MSHV 00000000) Sep 3 19:16:27.177938 kernel: ACPI: PPTT 0x000000003F979198 00012C (v01 VRTUAL MICROSFT 00000000 MSFT 00000000) Sep 3 19:16:27.177942 kernel: ACPI: BGRT 0x000000003F979E98 000038 (v01 VRTUAL MICROSFT 00000001 MSFT 00000001) Sep 3 19:16:27.177948 kernel: ACPI: SPCR: console: pl011,mmio32,0xeffec000,115200 Sep 3 19:16:27.177953 kernel: ACPI: Use ACPI SPCR as default console: Yes Sep 3 19:16:27.177958 kernel: ACPI: SRAT: Node 0 PXM 0 [mem 0x00000000-0x3fffffff] Sep 3 19:16:27.177963 kernel: ACPI: SRAT: Node 0 PXM 0 [mem 0x100000000-0x1bfffffff] Sep 3 19:16:27.177968 kernel: NUMA: Node 0 [mem 0x00000000-0x3fffffff] + [mem 0x100000000-0x1bfffffff] -> [mem 0x00000000-0x1bfffffff] Sep 3 19:16:27.177973 kernel: NODE_DATA(0) allocated [mem 0x1bf800a00-0x1bf807fff] Sep 3 19:16:27.177977 kernel: Zone ranges: Sep 3 19:16:27.177982 kernel: DMA [mem 0x0000000000000000-0x00000000ffffffff] Sep 3 19:16:27.177986 kernel: DMA32 empty Sep 3 19:16:27.177992 kernel: Normal [mem 0x0000000100000000-0x00000001bfffffff] Sep 3 19:16:27.177997 kernel: Device empty Sep 3 19:16:27.178002 kernel: Movable zone start for each node Sep 3 19:16:27.178007 kernel: Early memory node ranges Sep 3 19:16:27.178011 kernel: node 0: [mem 0x0000000000000000-0x00000000007fffff] Sep 3 19:16:27.178016 kernel: node 0: [mem 0x0000000000824000-0x000000003f38ffff] Sep 3 19:16:27.178020 kernel: node 0: [mem 0x000000003f390000-0x000000003f943fff] Sep 3 19:16:27.178025 kernel: node 0: [mem 0x000000003f944000-0x000000003f9effff] Sep 3 19:16:27.178031 kernel: node 0: [mem 0x000000003f9f0000-0x000000003fdeffff] Sep 3 19:16:27.178038 kernel: node 0: [mem 0x000000003fdf0000-0x000000003fffffff] Sep 3 19:16:27.178042 kernel: node 0: [mem 0x0000000100000000-0x00000001bfffffff] Sep 3 19:16:27.178048 kernel: Initmem setup node 0 [mem 0x0000000000000000-0x00000001bfffffff] Sep 3 19:16:27.178054 kernel: On node 0, zone DMA: 36 pages in unavailable ranges Sep 3 19:16:27.178060 kernel: cma: Reserved 16 MiB at 0x000000003ce00000 on node -1 Sep 3 19:16:27.178076 kernel: psci: probing for conduit method from ACPI. Sep 3 19:16:27.178081 kernel: psci: PSCIv1.3 detected in firmware. Sep 3 19:16:27.178087 kernel: psci: Using standard PSCI v0.2 function IDs Sep 3 19:16:27.178091 kernel: psci: MIGRATE_INFO_TYPE not supported. Sep 3 19:16:27.178095 kernel: psci: SMC Calling Convention v1.4 Sep 3 19:16:27.178101 kernel: ACPI: NUMA: SRAT: PXM 0 -> MPIDR 0x0 -> Node 0 Sep 3 19:16:27.178106 kernel: ACPI: NUMA: SRAT: PXM 0 -> MPIDR 0x1 -> Node 0 Sep 3 19:16:27.178110 kernel: percpu: Embedded 34 pages/cpu s98904 r8192 d32168 u139264 Sep 3 19:16:27.178114 kernel: pcpu-alloc: s98904 r8192 d32168 u139264 alloc=34*4096 Sep 3 19:16:27.178120 kernel: pcpu-alloc: [0] 0 [0] 1 Sep 3 19:16:27.178867 kernel: Detected PIPT I-cache on CPU0 Sep 3 19:16:27.181476 kernel: CPU features: detected: Address authentication (architected QARMA5 algorithm) Sep 3 19:16:27.181485 kernel: CPU features: detected: GIC system register CPU interface Sep 3 19:16:27.181490 kernel: CPU features: detected: Spectre-v4 Sep 3 19:16:27.181495 kernel: CPU features: detected: Spectre-BHB Sep 3 19:16:27.181500 kernel: CPU features: kernel page table isolation forced ON by KASLR Sep 3 19:16:27.181509 kernel: CPU features: detected: Kernel page table isolation (KPTI) Sep 3 19:16:27.181513 kernel: CPU features: detected: ARM erratum 2067961 or 2054223 Sep 3 19:16:27.181520 kernel: CPU features: detected: Broken broadcast TLBI completion Sep 3 19:16:27.181525 kernel: CPU features: detected: SSBS not fully self-synchronizing Sep 3 19:16:27.181529 kernel: alternatives: applying boot alternatives Sep 3 19:16:27.181535 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=91691620e17c613e2a1b1b256c96ab935f56b2251ee61ac620d2706fcec963d2 Sep 3 19:16:27.181543 kernel: Dentry cache hash table entries: 524288 (order: 10, 4194304 bytes, linear) Sep 3 19:16:27.181547 kernel: Inode-cache hash table entries: 262144 (order: 9, 2097152 bytes, linear) Sep 3 19:16:27.181552 kernel: Fallback order for Node 0: 0 Sep 3 19:16:27.181556 kernel: Built 1 zonelists, mobility grouping on. Total pages: 1048540 Sep 3 19:16:27.181563 kernel: Policy zone: Normal Sep 3 19:16:27.181567 kernel: mem auto-init: stack:off, heap alloc:off, heap free:off Sep 3 19:16:27.181573 kernel: software IO TLB: area num 2. Sep 3 19:16:27.181578 kernel: software IO TLB: mapped [mem 0x0000000038e00000-0x000000003ce00000] (64MB) Sep 3 19:16:27.181584 kernel: SLUB: HWalign=64, Order=0-3, MinObjects=0, CPUs=2, Nodes=1 Sep 3 19:16:27.181589 kernel: ftrace: allocating 41356 entries in 162 pages Sep 3 19:16:27.181637 kernel: ftrace: allocated 162 pages with 3 groups Sep 3 19:16:27.181645 kernel: rcu: Preemptible hierarchical RCU implementation. Sep 3 19:16:27.181651 kernel: rcu: RCU event tracing is enabled. Sep 3 19:16:27.181658 kernel: rcu: RCU restricting CPUs from NR_CPUS=512 to nr_cpu_ids=2. Sep 3 19:16:27.181663 kernel: Trampoline variant of Tasks RCU enabled. Sep 3 19:16:27.181667 kernel: Rude variant of Tasks RCU enabled. Sep 3 19:16:27.181674 kernel: Tracing variant of Tasks RCU enabled. Sep 3 19:16:27.181678 kernel: rcu: RCU calculated value of scheduler-enlistment delay is 100 jiffies. Sep 3 19:16:27.181683 kernel: rcu: Adjusting geometry for rcu_fanout_leaf=16, nr_cpu_ids=2 Sep 3 19:16:27.181689 kernel: RCU Tasks: Setting shift to 1 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=2. Sep 3 19:16:27.181694 kernel: RCU Tasks Rude: Setting shift to 1 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=2. Sep 3 19:16:27.181699 kernel: RCU Tasks Trace: Setting shift to 1 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=2. Sep 3 19:16:27.181704 kernel: NR_IRQS: 64, nr_irqs: 64, preallocated irqs: 0 Sep 3 19:16:27.181709 kernel: GICv3: 960 SPIs implemented Sep 3 19:16:27.181713 kernel: GICv3: 0 Extended SPIs implemented Sep 3 19:16:27.181718 kernel: Root IRQ handler: gic_handle_irq Sep 3 19:16:27.181724 kernel: GICv3: GICv3 features: 16 PPIs, RSS Sep 3 19:16:27.181728 kernel: GICv3: GICD_CTRL.DS=0, SCR_EL3.FIQ=0 Sep 3 19:16:27.181733 kernel: GICv3: CPU0: found redistributor 0 region 0:0x00000000effee000 Sep 3 19:16:27.181739 kernel: ITS: No ITS available, not enabling LPIs Sep 3 19:16:27.181745 kernel: rcu: srcu_init: Setting srcu_struct sizes based on contention. Sep 3 19:16:27.181750 kernel: clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1911260446275000 ns Sep 3 19:16:27.181755 kernel: arch_timer: cp15 timer(s) running at 1000.00MHz (virt). Sep 3 19:16:27.181762 kernel: clocksource: arch_sys_counter: mask: 0x1fffffffffffffff max_cycles: 0x1cd42e4dffb, max_idle_ns: 881590591483 ns Sep 3 19:16:27.181767 kernel: sched_clock: 61 bits at 1000MHz, resolution 1ns, wraps every 4398046511103ns Sep 3 19:16:27.181772 kernel: Console: colour dummy device 80x25 Sep 3 19:16:27.181778 kernel: printk: legacy console [tty1] enabled Sep 3 19:16:27.181783 kernel: ACPI: Core revision 20240827 Sep 3 19:16:27.181788 kernel: Calibrating delay loop (skipped), value calculated using timer frequency.. 2000.00 BogoMIPS (lpj=1000000) Sep 3 19:16:27.181793 kernel: pid_max: default: 32768 minimum: 301 Sep 3 19:16:27.181798 kernel: LSM: initializing lsm=lockdown,capability,landlock,selinux,ima Sep 3 19:16:27.181804 kernel: landlock: Up and running. Sep 3 19:16:27.181810 kernel: SELinux: Initializing. Sep 3 19:16:27.181815 kernel: Mount-cache hash table entries: 8192 (order: 4, 65536 bytes, linear) Sep 3 19:16:27.181819 kernel: Mountpoint-cache hash table entries: 8192 (order: 4, 65536 bytes, linear) Sep 3 19:16:27.181825 kernel: Hyper-V: privilege flags low 0x2e7f, high 0x3b8030, hints 0xa0000e, misc 0x31e1 Sep 3 19:16:27.181829 kernel: Hyper-V: Host Build 10.0.26102.3641-3-0 Sep 3 19:16:27.181834 kernel: Hyper-V: enabling crash_kexec_post_notifiers Sep 3 19:16:27.181840 kernel: rcu: Hierarchical SRCU implementation. Sep 3 19:16:27.181846 kernel: rcu: Max phase no-delay instances is 400. Sep 3 19:16:27.181852 kernel: Timer migration: 1 hierarchy levels; 8 children per group; 1 crossnode level Sep 3 19:16:27.181860 kernel: Remapping and enabling EFI services. Sep 3 19:16:27.181865 kernel: smp: Bringing up secondary CPUs ... Sep 3 19:16:27.181870 kernel: Detected PIPT I-cache on CPU1 Sep 3 19:16:27.181875 kernel: GICv3: CPU1: found redistributor 1 region 1:0x00000000f000e000 Sep 3 19:16:27.181882 kernel: CPU1: Booted secondary processor 0x0000000001 [0x410fd490] Sep 3 19:16:27.181887 kernel: smp: Brought up 1 node, 2 CPUs Sep 3 19:16:27.181892 kernel: SMP: Total of 2 processors activated. Sep 3 19:16:27.181898 kernel: CPU: All CPU(s) started at EL1 Sep 3 19:16:27.181903 kernel: CPU features: detected: 32-bit EL0 Support Sep 3 19:16:27.181908 kernel: CPU features: detected: Instruction cache invalidation not required for I/D coherence Sep 3 19:16:27.181914 kernel: CPU features: detected: Data cache clean to the PoU not required for I/D coherence Sep 3 19:16:27.181922 kernel: CPU features: detected: Common not Private translations Sep 3 19:16:27.181927 kernel: CPU features: detected: CRC32 instructions Sep 3 19:16:27.181932 kernel: CPU features: detected: Generic authentication (architected QARMA5 algorithm) Sep 3 19:16:27.181937 kernel: CPU features: detected: RCpc load-acquire (LDAPR) Sep 3 19:16:27.181942 kernel: CPU features: detected: LSE atomic instructions Sep 3 19:16:27.181947 kernel: CPU features: detected: Privileged Access Never Sep 3 19:16:27.181952 kernel: CPU features: detected: Speculation barrier (SB) Sep 3 19:16:27.181957 kernel: CPU features: detected: TLB range maintenance instructions Sep 3 19:16:27.181962 kernel: CPU features: detected: Speculative Store Bypassing Safe (SSBS) Sep 3 19:16:27.181969 kernel: CPU features: detected: Scalable Vector Extension Sep 3 19:16:27.181974 kernel: alternatives: applying system-wide alternatives Sep 3 19:16:27.181980 kernel: CPU features: detected: Hardware dirty bit management on CPU0-1 Sep 3 19:16:27.181985 kernel: SVE: maximum available vector length 16 bytes per vector Sep 3 19:16:27.181990 kernel: SVE: default vector length 16 bytes per vector Sep 3 19:16:27.181996 kernel: Memory: 3976352K/4194160K available (12480K kernel code, 2480K rwdata, 9568K rodata, 13440K init, 1040K bss, 195864K reserved, 16384K cma-reserved) Sep 3 19:16:27.182003 kernel: devtmpfs: initialized Sep 3 19:16:27.182008 kernel: futex hash table entries: 512 (order: 3, 32768 bytes, linear) Sep 3 19:16:27.182013 kernel: 2G module region forced by RANDOMIZE_MODULE_REGION_FULL Sep 3 19:16:27.182018 kernel: 0 pages in range for non-PLT usage Sep 3 19:16:27.182023 kernel: 514480 pages in range for PLT usage Sep 3 19:16:27.182028 kernel: pinctrl core: initialized pinctrl subsystem Sep 3 19:16:27.182033 kernel: SMBIOS 3.1.0 present. Sep 3 19:16:27.182038 kernel: DMI: Microsoft Corporation Virtual Machine/Virtual Machine, BIOS Hyper-V UEFI Release v4.1 04/22/2026 Sep 3 19:16:27.182044 kernel: DMI: Memory slots populated: 2/2 Sep 3 19:16:27.182048 kernel: NET: Registered PF_NETLINK/PF_ROUTE protocol family Sep 3 19:16:27.182054 kernel: DMA: preallocated 512 KiB GFP_KERNEL pool for atomic allocations Sep 3 19:16:27.182059 kernel: DMA: preallocated 512 KiB GFP_KERNEL|GFP_DMA pool for atomic allocations Sep 3 19:16:27.182117 kernel: DMA: preallocated 512 KiB GFP_KERNEL|GFP_DMA32 pool for atomic allocations Sep 3 19:16:27.182127 kernel: audit: initializing netlink subsys (disabled) Sep 3 19:16:27.182132 kernel: audit: type=2000 audit(0.059:1): state=initialized audit_enabled=0 res=1 Sep 3 19:16:27.182137 kernel: thermal_sys: Registered thermal governor 'step_wise' Sep 3 19:16:27.182142 kernel: cpuidle: using governor menu Sep 3 19:16:27.182147 kernel: hw-breakpoint: found 6 breakpoint and 4 watchpoint registers. Sep 3 19:16:27.182152 kernel: ASID allocator initialised with 32768 entries Sep 3 19:16:27.182158 kernel: acpiphp: ACPI Hot Plug PCI Controller Driver version: 0.5 Sep 3 19:16:27.182163 kernel: Serial: AMBA PL011 UART driver Sep 3 19:16:27.182169 kernel: HugeTLB: registered 1.00 GiB page size, pre-allocated 0 pages Sep 3 19:16:27.182174 kernel: HugeTLB: 0 KiB vmemmap can be freed for a 1.00 GiB page Sep 3 19:16:27.182179 kernel: HugeTLB: registered 32.0 MiB page size, pre-allocated 0 pages Sep 3 19:16:27.182185 kernel: HugeTLB: 0 KiB vmemmap can be freed for a 32.0 MiB page Sep 3 19:16:27.182190 kernel: HugeTLB: registered 2.00 MiB page size, pre-allocated 0 pages Sep 3 19:16:27.182195 kernel: HugeTLB: 0 KiB vmemmap can be freed for a 2.00 MiB page Sep 3 19:16:27.182202 kernel: HugeTLB: registered 64.0 KiB page size, pre-allocated 0 pages Sep 3 19:16:27.182207 kernel: HugeTLB: 0 KiB vmemmap can be freed for a 64.0 KiB page Sep 3 19:16:27.182212 kernel: ACPI: Added _OSI(Module Device) Sep 3 19:16:27.182217 kernel: ACPI: Added _OSI(Processor Device) Sep 3 19:16:27.182222 kernel: ACPI: Added _OSI(Processor Aggregator Device) Sep 3 19:16:27.182227 kernel: ACPI: 1 ACPI AML tables successfully acquired and loaded Sep 3 19:16:27.182232 kernel: ACPI: Interpreter enabled Sep 3 19:16:27.182238 kernel: ACPI: Using GIC for interrupt routing Sep 3 19:16:27.182244 kernel: ARMH0011:00: ttyAMA0 at MMIO 0xeffec000 (irq = 12, base_baud = 0) is a SBSA Sep 3 19:16:27.182249 kernel: printk: legacy console [ttyAMA0] enabled Sep 3 19:16:27.182254 kernel: printk: legacy bootconsole [pl11] disabled Sep 3 19:16:27.182259 kernel: ARMH0011:01: ttyAMA1 at MMIO 0xeffeb000 (irq = 13, base_baud = 0) is a SBSA Sep 3 19:16:27.182264 kernel: ACPI: CPU0 has been hot-added Sep 3 19:16:27.182270 kernel: ACPI: CPU1 has been hot-added Sep 3 19:16:27.182276 kernel: iommu: Default domain type: Translated Sep 3 19:16:27.182281 kernel: iommu: DMA domain TLB invalidation policy: strict mode Sep 3 19:16:27.182286 kernel: efivars: Registered efivars operations Sep 3 19:16:27.182291 kernel: vgaarb: loaded Sep 3 19:16:27.182296 kernel: clocksource: Switched to clocksource arch_sys_counter Sep 3 19:16:27.182301 kernel: VFS: Disk quotas dquot_6.6.0 Sep 3 19:16:27.182307 kernel: VFS: Dquot-cache hash table entries: 512 (order 0, 4096 bytes) Sep 3 19:16:27.182312 kernel: pnp: PnP ACPI init Sep 3 19:16:27.182318 kernel: pnp: PnP ACPI: found 0 devices Sep 3 19:16:27.182323 kernel: NET: Registered PF_INET protocol family Sep 3 19:16:27.182329 kernel: IP idents hash table entries: 65536 (order: 7, 524288 bytes, linear) Sep 3 19:16:27.182334 kernel: tcp_listen_portaddr_hash hash table entries: 2048 (order: 3, 32768 bytes, linear) Sep 3 19:16:27.182339 kernel: Table-perturb hash table entries: 65536 (order: 6, 262144 bytes, linear) Sep 3 19:16:27.182344 kernel: TCP established hash table entries: 32768 (order: 6, 262144 bytes, linear) Sep 3 19:16:27.182350 kernel: TCP bind hash table entries: 32768 (order: 8, 1048576 bytes, linear) Sep 3 19:16:27.182356 kernel: TCP: Hash tables configured (established 32768 bind 32768) Sep 3 19:16:27.182362 kernel: UDP hash table entries: 2048 (order: 4, 65536 bytes, linear) Sep 3 19:16:27.182367 kernel: UDP-Lite hash table entries: 2048 (order: 4, 65536 bytes, linear) Sep 3 19:16:27.182372 kernel: NET: Registered PF_UNIX/PF_LOCAL protocol family Sep 3 19:16:27.182378 kernel: PCI: CLS 0 bytes, default 64 Sep 3 19:16:27.182383 kernel: kvm [1]: HYP mode not available Sep 3 19:16:27.182388 kernel: Initialise system trusted keyrings Sep 3 19:16:27.182394 kernel: workingset: timestamp_bits=39 max_order=20 bucket_order=0 Sep 3 19:16:27.182400 kernel: Key type asymmetric registered Sep 3 19:16:27.182405 kernel: Asymmetric key parser 'x509' registered Sep 3 19:16:27.182410 kernel: Block layer SCSI generic (bsg) driver version 0.4 loaded (major 249) Sep 3 19:16:27.182415 kernel: io scheduler mq-deadline registered Sep 3 19:16:27.182421 kernel: io scheduler kyber registered Sep 3 19:16:27.182426 kernel: io scheduler bfq registered Sep 3 19:16:27.182432 kernel: Serial: 8250/16550 driver, 4 ports, IRQ sharing enabled Sep 3 19:16:27.182437 kernel: ACPI: bus type drm_connector registered Sep 3 19:16:27.182442 kernel: thunder_xcv, ver 1.0 Sep 3 19:16:27.182447 kernel: thunder_bgx, ver 1.0 Sep 3 19:16:27.182452 kernel: nicpf, ver 1.0 Sep 3 19:16:27.182457 kernel: nicvf, ver 1.0 Sep 3 19:16:27.182646 kernel: rtc-efi rtc-efi.0: registered as rtc0 Sep 3 19:16:27.182743 kernel: rtc-efi rtc-efi.0: setting system clock to 2026-09-03T19:16:20 UTC (1788462980) Sep 3 19:16:27.182751 kernel: efifb: probing for efifb Sep 3 19:16:27.182756 kernel: efifb: framebuffer at 0x40000000, using 3072k, total 3072k Sep 3 19:16:27.182762 kernel: efifb: mode is 1024x768x32, linelength=4096, pages=1 Sep 3 19:16:27.182767 kernel: efifb: scrolling: redraw Sep 3 19:16:27.182772 kernel: efifb: Truecolor: size=8:8:8:8, shift=24:16:8:0 Sep 3 19:16:27.182778 kernel: Console: switching to colour frame buffer device 128x48 Sep 3 19:16:27.182783 kernel: fb0: EFI VGA frame buffer device Sep 3 19:16:27.182789 kernel: SMCCC: SOC_ID: ARCH_SOC_ID not implemented, skipping .... Sep 3 19:16:27.182794 kernel: hid: raw HID events driver (C) Jiri Kosina Sep 3 19:16:27.182799 kernel: hw perfevents: enabled with armv8_pmuv3_0 PMU driver, 7 (0,8000003f) counters available Sep 3 19:16:27.182805 kernel: watchdog: NMI not fully supported Sep 3 19:16:27.182810 kernel: NET: Registered PF_INET6 protocol family Sep 3 19:16:27.182816 kernel: watchdog: Hard watchdog permanently disabled Sep 3 19:16:27.182821 kernel: Segment Routing with IPv6 Sep 3 19:16:27.182826 kernel: In-situ OAM (IOAM) with IPv6 Sep 3 19:16:27.182832 kernel: NET: Registered PF_PACKET protocol family Sep 3 19:16:27.182837 kernel: Key type dns_resolver registered Sep 3 19:16:27.182842 kernel: registered taskstats version 1 Sep 3 19:16:27.182847 kernel: Loading compiled-in X.509 certificates Sep 3 19:16:27.182853 kernel: Loaded X.509 cert 'Kinvolk GmbH: Module signing key for 6.12.105-flatcar: 4a1500c37c638946fc2b6b5c52fb875ecd804b4d' Sep 3 19:16:27.182859 kernel: Demotion targets for Node 0: null Sep 3 19:16:27.182864 kernel: Key type .fscrypt registered Sep 3 19:16:27.182869 kernel: Key type fscrypt-provisioning registered Sep 3 19:16:27.182874 kernel: ima: No TPM chip found, activating TPM-bypass! Sep 3 19:16:27.182880 kernel: ima: Allocated hash algorithm: sha1 Sep 3 19:16:27.182885 kernel: ima: No architecture policies found Sep 3 19:16:27.182890 kernel: alg: No test for fips(ansi_cprng) (fips_ansi_cprng) Sep 3 19:16:27.182896 kernel: clk: Disabling unused clocks Sep 3 19:16:27.182902 kernel: PM: genpd: Disabling unused power domains Sep 3 19:16:27.182907 kernel: Freeing unused kernel memory: 13440K Sep 3 19:16:27.182912 kernel: Run /init as init process Sep 3 19:16:27.182917 kernel: with arguments: Sep 3 19:16:27.182922 kernel: /init Sep 3 19:16:27.182927 kernel: with environment: Sep 3 19:16:27.182933 kernel: HOME=/ Sep 3 19:16:27.182939 kernel: TERM=linux Sep 3 19:16:27.182944 kernel: hv_vmbus: hv_mmio=[mem 0x40000000-0xfed3ffff],[mem 0xfc0000000-0xfffffffff] fb=[mem 0x40000000-0x47ffffff] Sep 3 19:16:27.182949 kernel: hv_vmbus: Vmbus version:5.3 Sep 3 19:16:27.182955 kernel: pps_core: LinuxPPS API ver. 1 registered Sep 3 19:16:27.182960 kernel: pps_core: Software ver. 5.3.6 - Copyright 2005-2007 Rodolfo Giometti Sep 3 19:16:27.182965 kernel: SCSI subsystem initialized Sep 3 19:16:27.182971 kernel: PTP clock support registered Sep 3 19:16:27.182976 kernel: hv_utils: Registering HyperV Utility Driver Sep 3 19:16:27.182981 kernel: hv_vmbus: registering driver hv_utils Sep 3 19:16:27.182986 kernel: hv_utils: Shutdown IC version 3.2 Sep 3 19:16:27.182991 kernel: hv_utils: Heartbeat IC version 3.0 Sep 3 19:16:27.182996 kernel: hv_utils: TimeSync IC version 4.0 Sep 3 19:16:27.183002 kernel: hv_vmbus: registering driver hv_storvsc Sep 3 19:16:27.185243 kernel: scsi host1: storvsc_host_t Sep 3 19:16:27.185373 kernel: scsi host0: storvsc_host_t Sep 3 19:16:27.185498 kernel: scsi 0:0:0:0: Direct-Access Msft Virtual Disk 1.0 PQ: 0 ANSI: 5 Sep 3 19:16:27.185615 kernel: scsi 0:0:0:2: CD-ROM Msft Virtual DVD-ROM 1.0 PQ: 0 ANSI: 0 Sep 3 19:16:27.185725 kernel: sd 0:0:0:0: [sda] 63737856 512-byte logical blocks: (32.6 GB/30.4 GiB) Sep 3 19:16:27.185839 kernel: sd 0:0:0:0: [sda] 4096-byte physical blocks Sep 3 19:16:27.185949 kernel: sd 0:0:0:0: [sda] Write Protect is off Sep 3 19:16:27.186076 kernel: sd 0:0:0:0: [sda] Mode Sense: 0f 00 10 00 Sep 3 19:16:27.186353 kernel: sd 0:0:0:0: [sda] Write cache: disabled, read cache: enabled, supports DPO and FUA Sep 3 19:16:27.186367 kernel: sda: sda1 sda2 sda3 sda4 sda6 sda7 sda9 Sep 3 19:16:27.186475 kernel: sd 0:0:0:0: [sda] Attached SCSI disk Sep 3 19:16:27.186486 kernel: hv_vmbus: registering driver hid_hyperv Sep 3 19:16:27.186492 kernel: input: Microsoft Vmbus HID-compliant Mouse as /devices/0006:045E:0621.0001/input/input0 Sep 3 19:16:27.186588 kernel: hid-hyperv 0006:045E:0621.0001: input: VIRTUAL HID v0.01 Mouse [Microsoft Vmbus HID-compliant Mouse] on Sep 3 19:16:27.186596 kernel: device-mapper: core: CONFIG_IMA_DISABLE_HTABLE is disabled. Duplicate IMA measurements will not be recorded in the IMA log. Sep 3 19:16:27.186602 kernel: device-mapper: uevent: version 1.0.3 Sep 3 19:16:27.186607 kernel: hv_vmbus: registering driver hyperv_keyboard Sep 3 19:16:27.186612 kernel: device-mapper: ioctl: 4.48.0-ioctl (2023-03-01) initialised: dm-devel@lists.linux.dev Sep 3 19:16:27.186619 kernel: input: AT Translated Set 2 keyboard as /devices/LNXSYSTM:00/LNXSYBUS:00/ACPI0004:00/MSFT1000:00/d34b2567-b9b6-42b9-8778-0a4ec0b955bf/serio0/input/input1 Sep 3 19:16:27.186624 kernel: device-mapper: verity: sha256 using shash "sha256-ce" Sep 3 19:16:27.186726 kernel: sr 0:0:0:2: [sr0] scsi-1 drive Sep 3 19:16:27.186733 kernel: cdrom: Uniform CD-ROM driver Revision: 3.20 Sep 3 19:16:27.186831 kernel: sr 0:0:0:2: Attached scsi CD-ROM sr0 Sep 3 19:16:27.186838 kernel: raid6: neonx8 gen() 18404 MB/s Sep 3 19:16:27.186844 kernel: raid6: neonx4 gen() 18514 MB/s Sep 3 19:16:27.186849 kernel: raid6: neonx2 gen() 16935 MB/s Sep 3 19:16:27.186854 kernel: raid6: neonx1 gen() 15055 MB/s Sep 3 19:16:27.186860 kernel: raid6: int64x8 gen() 9011 MB/s Sep 3 19:16:27.186865 kernel: raid6: int64x4 gen() 10762 MB/s Sep 3 19:16:27.186870 kernel: raid6: int64x2 gen() 8827 MB/s Sep 3 19:16:27.186875 kernel: raid6: int64x1 gen() 7053 MB/s Sep 3 19:16:27.186880 kernel: raid6: using algorithm neonx4 gen() 18514 MB/s Sep 3 19:16:27.186886 kernel: raid6: .... xor() 15142 MB/s, rmw enabled Sep 3 19:16:27.186890 kernel: raid6: using neon recovery algorithm Sep 3 19:16:27.186896 kernel: xor: measuring software checksum speed Sep 3 19:16:27.186901 kernel: 8regs : 29405 MB/sec Sep 3 19:16:27.186906 kernel: 32regs : 28097 MB/sec Sep 3 19:16:27.186911 kernel: arm64_neon : 36993 MB/sec Sep 3 19:16:27.186916 kernel: xor: using function: arm64_neon (36993 MB/sec) Sep 3 19:16:27.186922 kernel: Btrfs loaded, zoned=no, fsverity=no Sep 3 19:16:27.186927 kernel: BTRFS: device fsid fc891f2a-88ec-419a-930c-6d49fc5083bb devid 1 transid 41 /dev/mapper/usr (254:0) scanned by mount (261) Sep 3 19:16:27.186933 kernel: BTRFS info (device dm-0): first mount of filesystem fc891f2a-88ec-419a-930c-6d49fc5083bb Sep 3 19:16:27.186938 kernel: BTRFS info (device dm-0): using crc32c (crc32c-generic) checksum algorithm Sep 3 19:16:27.186943 kernel: BTRFS info (device dm-0 state E): disabling log replay at mount time Sep 3 19:16:27.186948 kernel: BTRFS info (device dm-0 state E): enabling free space tree Sep 3 19:16:27.186953 kernel: loop: module loaded Sep 3 19:16:27.186959 kernel: loop0: detected capacity change from 0 to 100536 Sep 3 19:16:27.186964 kernel: squashfs: version 4.0 (2009/01/31) Phillip Lougher Sep 3 19:16:27.186970 systemd[1]: Successfully made /usr/ read-only. Sep 3 19:16:27.186977 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 3 19:16:27.186983 systemd[1]: Detected virtualization microsoft. Sep 3 19:16:27.186988 systemd[1]: Detected architecture arm64. Sep 3 19:16:27.186995 systemd[1]: Running in initrd. Sep 3 19:16:27.187000 systemd[1]: Initializing machine ID from random generator. Sep 3 19:16:27.187006 systemd[1]: No hostname configured, using default hostname. Sep 3 19:16:27.187011 systemd[1]: Hostname set to . Sep 3 19:16:27.187016 (gene[295]: '/usr/lib/systemd/system-generators/dracut-crypt-generator' failed with exit status 2. Sep 3 19:16:27.187022 systemd[1]: Queued start job for default target initrd.target. Sep 3 19:16:27.187029 systemd[1]: Started clevis-luks-askpass.path - Forward Password Requests to Clevis Directory Watch. Sep 3 19:16:27.187034 systemd[1]: Started systemd-ask-password-console.path - Dispatch Password Requests to Console Directory Watch. Sep 3 19:16:27.187041 systemd[1]: Expecting device dev-disk-by\x2dlabel-EFI\x2dSYSTEM.device - /dev/disk/by-label/EFI-SYSTEM... Sep 3 19:16:27.187046 systemd[1]: Expecting device dev-disk-by\x2dlabel-OEM.device - /dev/disk/by-label/OEM... Sep 3 19:16:27.187052 systemd[1]: Expecting device dev-disk-by\x2dlabel-ROOT.device - /dev/disk/by-label/ROOT... Sep 3 19:16:27.187058 systemd[1]: Expecting device dev-disk-by\x2dpartlabel-USR\x2dA.device - /dev/disk/by-partlabel/USR-A... Sep 3 19:16:27.187081 systemd[1]: Expecting device dev-mapper-usr.device - /dev/mapper/usr... Sep 3 19:16:27.187088 systemd[1]: Reached target cryptsetup-pre.target - Local Encrypted Volumes (Pre). Sep 3 19:16:27.187094 systemd[1]: Reached target cryptsetup.target - Local Encrypted Volumes. Sep 3 19:16:27.187100 systemd[1]: Reached target initrd-usr-fs.target - Initrd /usr File System. Sep 3 19:16:27.187105 systemd[1]: Reached target paths.target - Path Units. Sep 3 19:16:27.187111 systemd[1]: Reached target slices.target - Slice Units. Sep 3 19:16:27.187117 systemd[1]: Reached target swap.target - Swaps. Sep 3 19:16:27.187123 systemd[1]: Reached target timers.target - Timer Units. Sep 3 19:16:27.187128 systemd[1]: Listening on iscsid.socket - Open-iSCSI iscsid Socket. Sep 3 19:16:27.187134 systemd[1]: Listening on iscsiuio.socket - Open-iSCSI iscsiuio Socket. Sep 3 19:16:27.187139 systemd[1]: Listening on systemd-coredump.socket - Process Core Dump Socket. Sep 3 19:16:27.187145 systemd[1]: Listening on systemd-journald-audit.socket - Journal Audit Socket. Sep 3 19:16:27.187150 systemd[1]: Listening on systemd-journald-dev-log.socket - Journal Socket (/dev/log). Sep 3 19:16:27.187156 systemd[1]: Listening on systemd-journald.socket - Journal Sockets. Sep 3 19:16:27.187162 systemd[1]: Listening on systemd-networkd-resolve-hook.socket - Network Management Resolve Hook Socket. Sep 3 19:16:27.187168 systemd[1]: Listening on systemd-networkd.socket - Network Management Netlink Socket. Sep 3 19:16:27.187173 systemd[1]: Listening on systemd-udevd-control.socket - udev Control Socket. Sep 3 19:16:27.187178 systemd[1]: Listening on systemd-udevd-kernel.socket - udev Kernel Socket. Sep 3 19:16:27.187188 systemd[1]: Reached target sockets.target - Socket Units. Sep 3 19:16:27.187195 systemd[1]: afterburn-network-kargs.service - Afterburn Initrd Setup Network Kernel Arguments skipped, no trigger condition checks were met. Sep 3 19:16:27.187201 systemd[1]: Starting ignition-setup-pre.service - Ignition env setup... Sep 3 19:16:27.187206 systemd[1]: Starting kmod-static-nodes.service - Create List of Static Device Nodes... Sep 3 19:16:27.187212 systemd[1]: Finished network-cleanup.service - Network Cleanup. Sep 3 19:16:27.187217 systemd[1]: systemd-battery-check.service - Early Battery Level Check skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/class/power_supply Sep 3 19:16:27.187223 systemd[1]: Starting systemd-journald.service - Journal Service... Sep 3 19:16:27.187230 systemd[1]: Starting systemd-modules-load.service - Load Kernel Modules... Sep 3 19:16:27.187236 systemd[1]: Starting systemd-network-generator.service - Generate Network Units from Kernel Command Line... Sep 3 19:16:27.187241 systemd[1]: Starting systemd-vconsole-setup.service - Virtual Console Setup... Sep 3 19:16:27.187248 systemd[1]: Finished ignition-setup-pre.service - Ignition env setup. Sep 3 19:16:27.187253 systemd[1]: Finished kmod-static-nodes.service - Create List of Static Device Nodes. Sep 3 19:16:27.187279 systemd-journald[448]: Collecting audit messages is enabled. Sep 3 19:16:27.187292 systemd[1]: Finished systemd-network-generator.service - Generate Network Units from Kernel Command Line. Sep 3 19:16:27.187299 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 3 19:16:27.187307 systemd-journald[448]: Journal started Sep 3 19:16:27.187321 systemd-journald[448]: Runtime Journal (/run/log/journal/7a5f820f49734894b8634938ee973cd0) is 8M, max 78.3M, 70.3M free. Sep 3 19:16:27.129261 systemd-modules-load[451]: Using 2 probe threads Sep 3 19:16:27.193000 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 3 19:16:27.202784 kernel: audit: type=1130 audit(1788462987.193:2): 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 3 19:16:27.202850 systemd[1]: Started systemd-journald.service - Journal Service. Sep 3 19:16:27.204000 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 3 19:16:27.212429 kernel: Bridge firewalling registered Sep 3 19:16:27.205557 systemd[1]: Reached target network-pre.target - Preparation for Network. Sep 3 19:16:27.217675 kernel: audit: type=1130 audit(1788462987.204: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 3 19:16:27.209751 systemd-modules-load[451]: Inserted module 'br_netfilter' Sep 3 19:16:27.221575 systemd[1]: Starting systemd-tmpfiles-setup-dev-early.service - Create Static Device Nodes in /dev gracefully... Sep 3 19:16:27.247533 systemd[1]: Starting systemd-tmpfiles-setup.service - Create System Files and Directories... Sep 3 19:16:27.261172 systemd[1]: Finished systemd-modules-load.service - Load Kernel Modules. Sep 3 19:16:27.269000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=systemd-modules-load comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Sep 3 19:16:27.284291 kernel: audit: type=1130 audit(1788462987.269:4): 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 3 19:16:27.277465 systemd-vconsole-setup[459]: Configuration of first virtual console was skipped, ignoring remaining ones. Sep 3 19:16:27.278166 systemd-tmpfiles[484]: /usr/lib/tmpfiles.d/systemd.conf:30: Duplicate line for path "/var/lib/systemd", ignoring. Sep 3 19:16:27.278212 systemd-tmpfiles[484]: /usr/lib/tmpfiles.d/var.conf:14: Duplicate line for path "/var/log", ignoring. Sep 3 19:16:27.280309 systemd[1]: Starting systemd-sysctl.service - Apply Kernel Variables... Sep 3 19:16:27.309215 systemd[1]: Finished systemd-vconsole-setup.service - Virtual Console Setup. Sep 3 19:16:27.310000 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 3 19:16:27.329929 kernel: audit: type=1130 audit(1788462987.310:5): 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 3 19:16:27.316944 systemd[1]: Finished systemd-tmpfiles-setup-dev-early.service - Create Static Device Nodes in /dev gracefully. Sep 3 19:16:27.329000 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 3 19:16:27.336934 systemd[1]: Finished systemd-tmpfiles-setup.service - Create System Files and Directories. Sep 3 19:16:27.350000 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 3 19:16:27.357237 kernel: audit: type=1130 audit(1788462987.329:6): pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=systemd-tmpfiles-setup-dev-early comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Sep 3 19:16:27.353417 systemd[1]: systemd-sysctl.service: Deactivated successfully. Sep 3 19:16:27.365517 kernel: audit: type=1130 audit(1788462987.350:7): 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 3 19:16:27.364241 systemd[1]: Finished systemd-sysctl.service - Apply Kernel Variables. Sep 3 19:16:27.369000 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 3 19:16:27.382774 kernel: audit: type=1130 audit(1788462987.369:8): pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=systemd-sysctl comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Sep 3 19:16:27.382000 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 3 19:16:27.393544 kernel: audit: type=1131 audit(1788462987.382:9): pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=systemd-sysctl comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Sep 3 19:16:27.397466 systemd[1]: Starting dracut-cmdline-ask.service - dracut ask for additional cmdline parameters... Sep 3 19:16:27.402000 audit: BPF prog-id=5 op=LOAD Sep 3 19:16:27.413225 kernel: audit: type=1334 audit(1788462987.402:10): prog-id=5 op=LOAD Sep 3 19:16:27.411525 systemd[1]: Starting systemd-resolved.service - Network Name Resolution... Sep 3 19:16:27.427613 systemd[1]: Starting systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev... Sep 3 19:16:27.518167 systemd[1]: Finished systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev. Sep 3 19:16:27.527000 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 3 19:16:27.535098 kernel: audit: type=1130 audit(1788462987.527:11): 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 3 19:16:27.542128 systemd[1]: Finished dracut-cmdline-ask.service - dracut ask for additional cmdline parameters. Sep 3 19:16:27.549000 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 3 19:16:27.565768 systemd[1]: Starting dracut-cmdline.service - dracut cmdline hook... Sep 3 19:16:27.567542 systemd-resolved[503]: Positive Trust Anchors: Sep 3 19:16:27.567549 systemd-resolved[503]: . IN DS 20326 8 2 e06d44b80b8f1d39a95c0b0d7c65d08458e880409bbc683457104237c7f8ec8d Sep 3 19:16:27.567551 systemd-resolved[503]: . IN DS 38696 8 2 683d2d0acb8c9b712a1948b27f741219298d0a450d612c483af444a4c0fb2b16 Sep 3 19:16:27.567571 systemd-resolved[503]: 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 3 19:16:27.623797 systemd-resolved[503]: Defaulting to hostname 'linux'. Sep 3 19:16:27.626893 systemd[1]: Started systemd-resolved.service - Network Name Resolution. Sep 3 19:16:27.636000 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 3 19:16:27.637704 systemd[1]: Reached target nss-lookup.target - Host and Network Name Lookups. Sep 3 19:16:27.647883 dracut-cmdline[522]: dracut-111 Sep 3 19:16:27.650639 dracut-cmdline[522]: 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=91691620e17c613e2a1b1b256c96ab935f56b2251ee61ac620d2706fcec963d2 Sep 3 19:16:27.777131 kernel: Loading iSCSI transport class v2.0-870. Sep 3 19:16:27.901100 kernel: iscsi: registered transport (tcp) Sep 3 19:16:27.941369 kernel: iscsi: registered transport (qla4xxx) Sep 3 19:16:27.941444 kernel: QLogic iSCSI HBA Driver Sep 3 19:16:28.002255 systemd[1]: afterburn-network-kargs.service - Afterburn Initrd Setup Network Kernel Arguments skipped, no trigger condition checks were met. Sep 3 19:16:28.054664 systemd[1]: Finished dracut-cmdline.service - dracut cmdline hook. Sep 3 19:16:28.059000 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 3 19:16:28.062337 systemd[1]: Starting dracut-pre-udev.service - dracut pre-udev hook... Sep 3 19:16:28.095700 systemd[1]: Finished dracut-pre-udev.service - dracut pre-udev hook. Sep 3 19:16:28.099000 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 3 19:16:28.101000 audit: BPF prog-id=6 op=LOAD Sep 3 19:16:28.101000 audit: BPF prog-id=7 op=LOAD Sep 3 19:16:28.104163 systemd[1]: Starting systemd-udevd.service - Rule-based Manager for Device Events and Files... Sep 3 19:16:28.230835 systemd-udevd[660]: Using default interface naming scheme 'v260'. Sep 3 19:16:28.242992 systemd[1]: Started systemd-udevd.service - Rule-based Manager for Device Events and Files. Sep 3 19:16:28.254000 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 3 19:16:28.257827 systemd[1]: Starting dracut-pre-trigger.service - dracut pre-trigger hook... Sep 3 19:16:28.271000 audit: BPF prog-id=8 op=LOAD Sep 3 19:16:28.274262 systemd[1]: Starting systemd-networkd.service - Network Management... Sep 3 19:16:28.291163 dracut-pre-trigger[683]: rd.md=0: removing MD RAID activation Sep 3 19:16:28.319164 systemd-networkd[685]: Failed to open nftables netlink socket. IPMasquerade= and NFTSet= settings will not be applied. Ignoring: Protocol not supported Sep 3 19:16:28.327462 systemd[1]: Finished dracut-pre-trigger.service - dracut pre-trigger hook. Sep 3 19:16:28.329000 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 3 19:16:28.332134 systemd-networkd[685]: lo: Link UP Sep 3 19:16:28.332137 systemd-networkd[685]: lo: Gained carrier Sep 3 19:16:28.339226 systemd[1]: Starting systemd-udev-trigger.service - Coldplug All udev Devices... Sep 3 19:16:28.346705 systemd[1]: Started systemd-networkd.service - Network Management. Sep 3 19:16:28.347000 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 3 19:16:28.349249 systemd[1]: Reached target network.target - Network. Sep 3 19:16:28.419043 systemd[1]: Finished systemd-udev-trigger.service - Coldplug All udev Devices. Sep 3 19:16:28.421000 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 3 19:16:28.424558 systemd[1]: Starting dracut-initqueue.service - dracut initqueue hook... Sep 3 19:16:28.574691 systemd[1]: systemd-vconsole-setup.service: Deactivated successfully. Sep 3 19:16:28.577000 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 3 19:16:28.574846 systemd[1]: Stopped systemd-vconsole-setup.service - Virtual Console Setup. Sep 3 19:16:28.582884 systemd[1]: Stopping systemd-vconsole-setup.service - Virtual Console Setup... Sep 3 19:16:28.591338 systemd[1]: Starting systemd-vconsole-setup.service - Virtual Console Setup... Sep 3 19:16:28.598702 kernel: hv_vmbus: registering driver hv_netvsc Sep 3 19:16:28.605110 kernel: hv_netvsc f8615163-0000-1000-2000-7ced8d8adccf (unnamed net_device) (uninitialized): VF slot 1 added Sep 3 19:16:28.615437 systemd-vconsole-setup[768]: Configuration of first virtual console was skipped, ignoring remaining ones. Sep 3 19:16:28.622328 systemd[1]: Finished systemd-vconsole-setup.service - Virtual Console Setup. Sep 3 19:16:28.628000 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 3 19:16:28.631796 systemd-networkd[685]: eth0: Configuring with /usr/lib/systemd/network/zz-default.network. Sep 3 19:16:28.635963 systemd-networkd[685]: eth0: Link UP Sep 3 19:16:28.636153 systemd-networkd[685]: eth0: Gained carrier Sep 3 19:16:28.649098 systemd-networkd[685]: eth0: DHCPv4 address 10.0.0.5/24, gateway 10.0.0.1 acquired from 168.63.129.16 Sep 3 19:16:28.664120 kernel: hv_storvsc f8b3781a-1e82-4818-a1c3-63d806ec15bb: tag#89 cmd 0x85 status: scsi 0x2 srb 0x84 hv 0xc0000185 Sep 3 19:16:28.984416 systemd[1]: Found device dev-disk-by\x2dpartlabel-USR\x2dA.device - Virtual_Disk USR-A. Sep 3 19:16:28.989937 systemd[1]: Starting disk-uuid.service - Generate new UUID for disk GPT if necessary... Sep 3 19:16:29.040496 systemd[1]: Found device dev-disk-by\x2dlabel-EFI\x2dSYSTEM.device - Virtual_Disk EFI-SYSTEM. Sep 3 19:16:29.070178 systemd[1]: Found device dev-disk-by\x2dlabel-OEM.device - Virtual_Disk OEM. Sep 3 19:16:29.095489 systemd[1]: Mounting oem.mount - /oem... Sep 3 19:16:29.136363 systemd[1]: Found device dev-disk-by\x2dlabel-ROOT.device - Virtual_Disk ROOT. Sep 3 19:16:29.210098 kernel: BTRFS: device label OEM devid 1 transid 11 /dev/sda6 (8:6) scanned by mount (823) Sep 3 19:16:29.240136 kernel: BTRFS info (device sda6): first mount of filesystem e16e03c9-1c56-4045-8449-a6b867e0a594 Sep 3 19:16:29.240208 kernel: BTRFS info (device sda6): using crc32c (crc32c-generic) checksum algorithm Sep 3 19:16:29.364243 systemd[1]: Finished dracut-initqueue.service - dracut initqueue hook. Sep 3 19:16:29.367000 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 3 19:16:29.368372 systemd[1]: Reached target remote-fs-pre.target - Preparation for Remote File Systems. Sep 3 19:16:29.371390 systemd[1]: Reached target remote-cryptsetup.target - Remote Encrypted Volumes. Sep 3 19:16:29.375614 systemd[1]: Reached target remote-fs.target - Remote File Systems. Sep 3 19:16:29.388753 systemd[1]: Starting dracut-pre-mount.service - dracut pre-mount hook... Sep 3 19:16:29.410347 kernel: BTRFS info (device sda6): turning on async discard Sep 3 19:16:29.410390 kernel: BTRFS info (device sda6): enabling free space tree Sep 3 19:16:29.412327 systemd[1]: Mounted oem.mount - /oem. Sep 3 19:16:29.420107 systemd[1]: Finished dracut-pre-mount.service - dracut pre-mount hook. Sep 3 19:16:29.423000 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 3 19:16:29.428460 systemd[1]: Starting ignition-fetch-offline.service - Ignition (fetch-offline)... Sep 3 19:16:29.661173 systemd-networkd[685]: eth0: Gained IPv6LL Sep 3 19:16:29.754111 kernel: hv_vmbus: registering driver hv_pci Sep 3 19:16:29.761582 kernel: hv_pci 00000001-7870-47b5-b203-907d12ca697e: PCI VMBus probing: Using version 0x10004 Sep 3 19:16:29.761823 kernel: hv_pci 00000001-7870-47b5-b203-907d12ca697e: PCI host bridge to bus 7870:00 Sep 3 19:16:29.777591 kernel: pci_bus 7870:00: root bus resource [mem 0xfc0000000-0xfc2007fff window] Sep 3 19:16:29.781370 kernel: pci_bus 7870:00: No busn resource found for root bus, will use [bus 00-ff] Sep 3 19:16:29.785243 kernel: pci 7870:00:00.0: [1414:00ba] type 00 class 0x020000 PCIe Endpoint Sep 3 19:16:29.789112 kernel: pci 7870:00:00.0: BAR 0 [mem 0xfc0000000-0xfc1ffffff 64bit pref] Sep 3 19:16:29.794151 kernel: pci 7870:00:00.0: BAR 4 [mem 0xfc2000000-0xfc2007fff 64bit pref] Sep 3 19:16:29.801141 kernel: pci 7870:00:00.0: enabling Extended Tags Sep 3 19:16:29.814171 kernel: pci 7870:00:00.0: 0.000 Gb/s available PCIe bandwidth, limited by Unknown x0 link at 7870:00:00.0 (capable of 252.048 Gb/s with 16.0 GT/s PCIe x16 link) Sep 3 19:16:29.819120 kernel: pci_bus 7870:00: busn_res: [bus 00-ff] end is updated to 00 Sep 3 19:16:29.819348 kernel: pci 7870:00:00.0: BAR 0 [mem 0xfc0000000-0xfc1ffffff 64bit pref]: assigned Sep 3 19:16:29.822157 kernel: pci 7870:00:00.0: BAR 4 [mem 0xfc2000000-0xfc2007fff 64bit pref]: assigned Sep 3 19:16:29.851886 kernel: mana 7870:00:00.0: enabling device (0000 -> 0002) Sep 3 19:16:29.863078 kernel: mana 7870:00:00.0: Microsoft Azure Network Adapter protocol version: 0.1.1 Sep 3 19:16:29.876669 kernel: hv_netvsc f8615163-0000-1000-2000-7ced8d8adccf eth0: VF registering: eth1 Sep 3 19:16:29.876875 kernel: mana 7870:00:00.0 eth1: joined to eth0 Sep 3 19:16:29.882791 systemd-networkd[685]: eth1: Interface name change detected, renamed to enP30832s1. Sep 3 19:16:29.884734 kernel: mana 7870:00:00.0 enP30832s1: renamed from eth1 Sep 3 19:16:29.995093 kernel: mana 7870:00:00.0 enP30832s1: Configured vPort 0 PD 18 DB 16 Sep 3 19:16:30.001077 kernel: mana 7870:00:00.0 enP30832s1: Configured steering vPort 0 entries 64 Sep 3 19:16:30.015655 systemd-networkd[685]: enP30832s1: Link UP Sep 3 19:16:30.015840 systemd-networkd[685]: enP30832s1: Gained carrier Sep 3 19:16:30.020129 kernel: hv_netvsc f8615163-0000-1000-2000-7ced8d8adccf eth0: Data path switched to VF: enP30832s1 Sep 3 19:16:30.412207 disk-uuid[808]: Warning: The kernel is still using the old partition table. Sep 3 19:16:30.412207 disk-uuid[808]: The new table will be used at the next reboot or after you Sep 3 19:16:30.412207 disk-uuid[808]: run partprobe(8) or kpartx(8) Sep 3 19:16:30.412207 disk-uuid[808]: The operation has completed successfully. Sep 3 19:16:30.425565 systemd[1]: disk-uuid.service: Deactivated successfully. Sep 3 19:16:30.429190 systemd[1]: Finished disk-uuid.service - Generate new UUID for disk GPT if necessary. Sep 3 19:16:30.432000 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 3 19:16:30.432000 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 3 19:16:30.438003 systemd[1]: Mounting boot.mount - Boot partition... Sep 3 19:16:30.581430 systemd[1]: Mounted boot.mount - Boot partition. Sep 3 19:16:30.638405 ignition[922]: Ignition 2.27.0 Sep 3 19:16:30.638424 ignition[922]: Stage: fetch-offline Sep 3 19:16:30.642559 systemd[1]: Finished ignition-fetch-offline.service - Ignition (fetch-offline). Sep 3 19:16:30.646000 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 3 19:16:30.638663 ignition[922]: no config dir at "/run/ignition/base.d" Sep 3 19:16:30.648703 systemd[1]: Starting ignition-fetch.service - Ignition (fetch)... Sep 3 19:16:30.638674 ignition[922]: no config dir at "/etc/ignition/base.d" Sep 3 19:16:30.638780 ignition[922]: no config dir at "/usr/lib/ignition/base.d" Sep 3 19:16:30.638783 ignition[922]: no configs found in "base.d" across system config directories Sep 3 19:16:30.638789 ignition[922]: no config dir at "/run/ignition/base.platform.d/azure" Sep 3 19:16:30.638793 ignition[922]: no config dir at "/etc/ignition/base.platform.d/azure" Sep 3 19:16:30.638799 ignition[922]: no config dir at "/usr/lib/ignition/base.platform.d/azure" Sep 3 19:16:30.638801 ignition[922]: no configs found in "base.platform.d/azure" across system config directories Sep 3 19:16:30.638920 ignition[922]: reading system config file "/run/ignition/user.ign" Sep 3 19:16:30.638925 ignition[922]: no config at "/run/ignition/user.ign" Sep 3 19:16:30.638929 ignition[922]: reading system config file "/etc/ignition/user.ign" Sep 3 19:16:30.638933 ignition[922]: no config at "/etc/ignition/user.ign" Sep 3 19:16:30.638935 ignition[922]: reading system config file "/usr/lib/ignition/user.ign" Sep 3 19:16:30.638950 ignition[922]: no config at "/usr/lib/ignition/user.ign" Sep 3 19:16:30.638953 ignition[922]: failed to fetch config: resource requires networking Sep 3 19:16:30.639296 ignition[922]: Ignition finished successfully Sep 3 19:16:30.675775 ignition[994]: Ignition 2.27.0 Sep 3 19:16:30.675780 ignition[994]: Stage: fetch Sep 3 19:16:30.675976 ignition[994]: no config dir at "/run/ignition/base.d" Sep 3 19:16:30.675981 ignition[994]: no config dir at "/etc/ignition/base.d" Sep 3 19:16:30.675993 ignition[994]: no config dir at "/usr/lib/ignition/base.d" Sep 3 19:16:30.675995 ignition[994]: no configs found in "base.d" across system config directories Sep 3 19:16:30.676000 ignition[994]: no config dir at "/run/ignition/base.platform.d/azure" Sep 3 19:16:30.676003 ignition[994]: no config dir at "/etc/ignition/base.platform.d/azure" Sep 3 19:16:30.676006 ignition[994]: no config dir at "/usr/lib/ignition/base.platform.d/azure" Sep 3 19:16:30.676008 ignition[994]: no configs found in "base.platform.d/azure" across system config directories Sep 3 19:16:30.676106 ignition[994]: reading system config file "/run/ignition/user.ign" Sep 3 19:16:30.676113 ignition[994]: no config at "/run/ignition/user.ign" Sep 3 19:16:30.676115 ignition[994]: reading system config file "/etc/ignition/user.ign" Sep 3 19:16:30.676118 ignition[994]: no config at "/etc/ignition/user.ign" Sep 3 19:16:30.676120 ignition[994]: reading system config file "/usr/lib/ignition/user.ign" Sep 3 19:16:30.676126 ignition[994]: no config at "/usr/lib/ignition/user.ign" Sep 3 19:16:30.676143 ignition[994]: GET http://169.254.169.254/metadata/instance/compute/userData?api-version=2021-01-01&format=text: attempt #1 Sep 3 19:16:30.745767 ignition[994]: GET result: OK Sep 3 19:16:30.745781 ignition[994]: failed to retrieve userdata from IMDS, falling back to custom data: not a config (empty) Sep 3 19:16:30.822333 ignition[994]: opening config device: "/dev/sr0" Sep 3 19:16:30.822653 ignition[994]: getting drive status for "/dev/sr0" Sep 3 19:16:30.822700 ignition[994]: drive status: OK Sep 3 19:16:30.822848 ignition[994]: mounting config device Sep 3 19:16:30.822856 ignition[994]: op(1): [started] mounting "/dev/sr0" at "/tmp/ignition-azure3332647000" Sep 3 19:16:30.850091 kernel: UDF-fs: INFO Mounting volume 'UDF Volume', timestamp 2026/09/04 00:00 (1000) Sep 3 19:16:30.851144 ignition[994]: op(1): [finished] mounting "/dev/sr0" at "/tmp/ignition-azure3332647000" Sep 3 19:16:30.851151 ignition[994]: checking for config drive Sep 3 19:16:30.855877 ignition[994]: reading config Sep 3 19:16:30.856336 ignition[994]: op(2): [started] unmounting "/dev/sr0" at "/tmp/ignition-azure3332647000" Sep 3 19:16:30.860960 ignition[994]: op(2): [finished] unmounting "/dev/sr0" at "/tmp/ignition-azure3332647000" Sep 3 19:16:30.857091 systemd[1]: tmp-ignition\x2dazure3332647000.mount: Deactivated successfully. Sep 3 19:16:30.869000 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 3 19:16:30.860987 ignition[994]: config has been read from custom data Sep 3 19:16:30.862171 unknown[994]: fetched base config from "system" Sep 3 19:16:30.861000 ignition[994]: parsing config with SHA512: 4bd16e4625362740291c84f73f3bd61d2425b3042b71b69df4dc481f5a98c20d32eaec5aa24417d67959d28b06543be599e14328900d7f46df7486c76180fa0d Sep 3 19:16:30.862177 unknown[994]: fetched base config from "system" Sep 3 19:16:30.861098 ignition[994]: not a config (empty): provider config was empty, continuing with empty cache config Sep 3 19:16:30.864305 systemd[1]: Finished ignition-fetch.service - Ignition (fetch). Sep 3 19:16:30.862244 ignition[994]: fetch: fetch complete Sep 3 19:16:30.871736 systemd[1]: Starting ignition-kargs.service - Ignition (kargs)... Sep 3 19:16:30.862246 ignition[994]: fetch: fetch passed Sep 3 19:16:30.862283 ignition[994]: Ignition finished successfully Sep 3 19:16:30.907060 ignition[1007]: Ignition 2.27.0 Sep 3 19:16:30.907091 ignition[1007]: Stage: kargs Sep 3 19:16:30.907301 ignition[1007]: no config dir at "/run/ignition/base.d" Sep 3 19:16:30.907306 ignition[1007]: no config dir at "/etc/ignition/base.d" Sep 3 19:16:30.919000 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 3 19:16:30.912941 systemd[1]: Finished ignition-kargs.service - Ignition (kargs). Sep 3 19:16:30.907318 ignition[1007]: no config dir at "/usr/lib/ignition/base.d" Sep 3 19:16:30.923892 systemd[1]: Starting ignition-disks.service - Ignition (disks)... Sep 3 19:16:30.907321 ignition[1007]: no configs found in "base.d" across system config directories Sep 3 19:16:30.907326 ignition[1007]: no config dir at "/run/ignition/base.platform.d/azure" Sep 3 19:16:30.907329 ignition[1007]: no config dir at "/etc/ignition/base.platform.d/azure" Sep 3 19:16:30.907332 ignition[1007]: no config dir at "/usr/lib/ignition/base.platform.d/azure" Sep 3 19:16:30.907334 ignition[1007]: no configs found in "base.platform.d/azure" across system config directories Sep 3 19:16:30.907608 ignition[1007]: kargs: kargs passed Sep 3 19:16:30.907645 ignition[1007]: Ignition finished successfully Sep 3 19:16:30.973032 systemd[1]: ignition-kargs.service: Deactivated successfully. Sep 3 19:16:30.973212 systemd[1]: Stopped ignition-kargs.service - Ignition (kargs). Sep 3 19:16:30.977000 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 3 19:16:30.979796 systemd[1]: ignition-fetch.service: Deactivated successfully. Sep 3 19:16:30.982000 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 3 19:16:30.979908 systemd[1]: Stopped ignition-fetch.service - Ignition (fetch). Sep 3 19:16:30.987000 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 3 19:16:30.984748 systemd[1]: ignition-fetch-offline.service: Deactivated successfully. Sep 3 19:16:30.984907 systemd[1]: Stopped ignition-fetch-offline.service - Ignition (fetch-offline). Sep 3 19:16:30.992208 systemd[1]: Unmounting oem.mount - /oem... Sep 3 19:16:31.019256 kernel: BTRFS info (device sda6): last unmount of filesystem e16e03c9-1c56-4045-8449-a6b867e0a594 Sep 3 19:16:31.019431 systemd[1]: oem.mount: Deactivated successfully. Sep 3 19:16:31.022976 systemd[1]: Unmounted oem.mount - /oem. Sep 3 19:16:31.042661 ignition[1028]: Ignition 2.27.0 Sep 3 19:16:31.042675 ignition[1028]: Stage: disks Sep 3 19:16:31.049135 systemd[1]: Finished ignition-disks.service - Ignition (disks). Sep 3 19:16:31.042900 ignition[1028]: no config dir at "/run/ignition/base.d" Sep 3 19:16:31.054000 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 3 19:16:31.055382 systemd[1]: Reached target initrd-root-device.target - Initrd Root Device. Sep 3 19:16:31.042904 ignition[1028]: no config dir at "/etc/ignition/base.d" Sep 3 19:16:31.060552 systemd[1]: Reached target local-fs-pre.target - Preparation for Local File Systems. Sep 3 19:16:31.042921 ignition[1028]: no config dir at "/usr/lib/ignition/base.d" Sep 3 19:16:31.064652 systemd[1]: Reached target local-fs.target - Local File Systems. Sep 3 19:16:31.042923 ignition[1028]: no configs found in "base.d" across system config directories Sep 3 19:16:31.068896 systemd[1]: Reached target sysinit.target - System Initialization. Sep 3 19:16:31.042928 ignition[1028]: no config dir at "/run/ignition/base.platform.d/azure" Sep 3 19:16:31.074324 systemd[1]: Reached target basic.target - Basic System. Sep 3 19:16:31.042931 ignition[1028]: no config dir at "/etc/ignition/base.platform.d/azure" Sep 3 19:16:31.080132 systemd[1]: Starting systemd-fsck-root.service - File System Check on /dev/disk/by-label/ROOT... Sep 3 19:16:31.042934 ignition[1028]: no config dir at "/usr/lib/ignition/base.platform.d/azure" Sep 3 19:16:31.042936 ignition[1028]: no configs found in "base.platform.d/azure" across system config directories Sep 3 19:16:31.043242 ignition[1028]: disks: disks passed Sep 3 19:16:31.043281 ignition[1028]: Ignition finished successfully Sep 3 19:16:31.313664 systemd-fsck[1040]: ROOT: clean, 15/6361680 files, 408771/6359552 blocks Sep 3 19:16:31.322814 systemd[1]: Finished systemd-fsck-root.service - File System Check on /dev/disk/by-label/ROOT. Sep 3 19:16:31.326000 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 3 19:16:31.582533 systemd[1]: Mounting sysroot.mount - /sysroot... Sep 3 19:16:31.876148 kernel: EXT4-fs (sda9): mounted filesystem 1a111ceb-5b45-4626-bc16-efd794ec670c r/w with ordered data mode. Quota mode: none. Sep 3 19:16:31.877027 systemd[1]: Mounted sysroot.mount - /sysroot. Sep 3 19:16:31.882398 systemd[1]: Reached target initrd-root-fs.target - Initrd Root File System. Sep 3 19:16:31.899741 systemd[1]: Mounting sysroot-usr.mount - /sysroot/usr... Sep 3 19:16:31.902576 systemd[1]: Starting flatcar-metadata-hostname.service - Flatcar Metadata Hostname Agent... Sep 3 19:16:31.909198 systemd[1]: ignition-remount-sysroot.service - Remount /sysroot read-write for Ignition skipped, unmet condition check ConditionPathIsReadWrite=!/sysroot Sep 3 19:16:31.909237 systemd[1]: Reached target ignition-diskful.target - Ignition Boot Disk Setup. Sep 3 19:16:31.933939 systemd[1]: Mounted sysroot-usr.mount - /sysroot/usr. Sep 3 19:16:31.936867 systemd[1]: Starting initrd-setup-root.service - Root filesystem setup... Sep 3 19:16:32.745608 coreos-metadata[1059]: Sep 03 19:16:32.745 INFO Fetching http://168.63.129.16/?comp=versions: Attempt #1 Sep 3 19:16:32.752817 coreos-metadata[1059]: Sep 03 19:16:32.752 INFO Fetch successful Sep 3 19:16:32.756521 coreos-metadata[1059]: Sep 03 19:16:32.756 INFO Fetching http://169.254.169.254/metadata/instance/compute/name?api-version=2017-08-01&format=text: Attempt #1 Sep 3 19:16:32.764870 coreos-metadata[1059]: Sep 03 19:16:32.764 INFO Fetch successful Sep 3 19:16:32.777977 coreos-metadata[1059]: Sep 03 19:16:32.777 INFO wrote hostname ci-9999.0.0-i-95488032b5 to /sysroot/etc/hostname Sep 3 19:16:32.787162 systemd[1]: Finished flatcar-metadata-hostname.service - Flatcar Metadata Hostname Agent. Sep 3 19:16:32.790000 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 3 19:16:32.792853 kernel: kauditd_printk_skb: 25 callbacks suppressed Sep 3 19:16:32.792871 kernel: audit: type=1130 audit(1788462992.790:37): 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 3 19:16:33.729083 kernel: loop1: detected capacity change from 0 to 44096 Sep 3 19:16:33.772446 kernel: loop1: p1 p2 p3 Sep 3 19:16:34.097481 kernel: device-mapper: verity: sha256 using shash "sha256-ce" Sep 3 19:16:34.097529 kernel: device-mapper: verity: Unrecognized verity feature request: root_hash_sig_key_desc Sep 3 19:16:34.101244 kernel: device-mapper: table: 254:1: verity: Unrecognized verity feature request (-EINVAL) Sep 3 19:16:34.104036 kernel: device-mapper: ioctl: error adding target to table Sep 3 19:16:34.104118 systemd-confext[1139]: device-mapper: reload ioctl on loop1p1-14-verity (254:1) failed: Invalid argument Sep 3 19:16:34.149107 kernel: device-mapper: verity: sha256 using shash "sha256-ce" Sep 3 19:16:34.232300 kernel: erofs: (device dm-1): mounted with root inode @ nid 40. Sep 3 19:16:34.267083 kernel: loop2: detected capacity change from 0 to 44096 Sep 3 19:16:34.269083 kernel: loop2: p1 p2 p3 Sep 3 19:16:34.279080 kernel: device-mapper: verity: sha256 using shash "sha256-ce" Sep 3 19:16:34.279119 kernel: device-mapper: verity: Unrecognized verity feature request: root_hash_sig_key_desc Sep 3 19:16:34.283124 kernel: device-mapper: table: 254:1: verity: Unrecognized verity feature request (-EINVAL) Sep 3 19:16:34.286297 kernel: device-mapper: ioctl: error adding target to table Sep 3 19:16:34.286565 (sd-merge)[1149]: device-mapper: reload ioctl on loop2p1-18-verity (254:1) failed: Invalid argument Sep 3 19:16:34.294072 kernel: device-mapper: verity: sha256 using shash "sha256-ce" Sep 3 19:16:34.307637 (sd-merge)[1149]: Using extensions '00-flatcar-default.raw'. Sep 3 19:16:34.313310 kernel: erofs: (device dm-1): mounted with root inode @ nid 40. Sep 3 19:16:34.308380 (sd-merge)[1149]: Merged extensions into '/sysroot/etc'. Sep 3 19:16:34.316761 initrd-setup-root[1157]: /etc 00-flatcar-default Thu 2026-09-03 19:16:27 UTC Sep 3 19:16:34.320786 systemd[1]: Finished initrd-setup-root.service - Root filesystem setup. Sep 3 19:16:34.328000 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 3 19:16:34.334126 kernel: audit: type=1130 audit(1788462994.328:38): 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 3 19:16:34.334945 systemd[1]: Starting ignition-mount.service - Ignition (mount)... Sep 3 19:16:34.371260 ignition[1163]: INFO : Ignition 2.27.0 Sep 3 19:16:34.375198 ignition[1163]: INFO : Stage: mount Sep 3 19:16:34.375198 ignition[1163]: INFO : no config dir at "/run/ignition/base.d" Sep 3 19:16:34.375198 ignition[1163]: INFO : no config dir at "/etc/ignition/base.d" Sep 3 19:16:34.375198 ignition[1163]: INFO : no config dir at "/usr/lib/ignition/base.d" Sep 3 19:16:34.375198 ignition[1163]: INFO : no configs found in "base.d" across system config directories Sep 3 19:16:34.375198 ignition[1163]: INFO : no config dir at "/run/ignition/base.platform.d/azure" Sep 3 19:16:34.375198 ignition[1163]: INFO : no config dir at "/etc/ignition/base.platform.d/azure" Sep 3 19:16:34.375198 ignition[1163]: INFO : no config dir at "/usr/lib/ignition/base.platform.d/azure" Sep 3 19:16:34.375198 ignition[1163]: INFO : no configs found in "base.platform.d/azure" across system config directories Sep 3 19:16:34.375198 ignition[1163]: INFO : mount: mount passed Sep 3 19:16:34.375198 ignition[1163]: INFO : Ignition finished successfully Sep 3 19:16:34.379000 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 3 19:16:34.374714 systemd[1]: Finished ignition-mount.service - Ignition (mount). Sep 3 19:16:34.434281 kernel: audit: type=1130 audit(1788462994.379:39): 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 3 19:16:34.386858 systemd[1]: Starting ignition-files.service - Ignition (files)... Sep 3 19:16:34.417285 systemd[1]: Mounting oem.mount - /oem... Sep 3 19:16:34.448182 kernel: BTRFS: device label OEM devid 1 transid 11 /dev/sda6 (8:6) scanned by mount (1175) Sep 3 19:16:34.448365 kernel: BTRFS info (device sda6): first mount of filesystem e16e03c9-1c56-4045-8449-a6b867e0a594 Sep 3 19:16:34.448383 kernel: BTRFS info (device sda6): using crc32c (crc32c-generic) checksum algorithm Sep 3 19:16:34.453776 kernel: BTRFS info (device sda6): turning on async discard Sep 3 19:16:34.453809 kernel: BTRFS info (device sda6): enabling free space tree Sep 3 19:16:34.455618 systemd[1]: Mounted oem.mount - /oem. Sep 3 19:16:34.463804 systemd[1]: Mounting sysroot-oem.mount - /sysroot/oem... Sep 3 19:16:34.484486 systemd[1]: Mounted sysroot-oem.mount - /sysroot/oem. Sep 3 19:16:34.509832 ignition[1194]: INFO : Ignition 2.27.0 Sep 3 19:16:34.512281 ignition[1194]: INFO : Stage: files Sep 3 19:16:34.512281 ignition[1194]: INFO : no config dir at "/run/ignition/base.d" Sep 3 19:16:34.512281 ignition[1194]: INFO : no config dir at "/etc/ignition/base.d" Sep 3 19:16:34.512281 ignition[1194]: INFO : no config dir at "/usr/lib/ignition/base.d" Sep 3 19:16:34.512281 ignition[1194]: INFO : no configs found in "base.d" across system config directories Sep 3 19:16:34.512281 ignition[1194]: INFO : no config dir at "/run/ignition/base.platform.d/azure" Sep 3 19:16:34.512281 ignition[1194]: INFO : no config dir at "/etc/ignition/base.platform.d/azure" Sep 3 19:16:34.512281 ignition[1194]: INFO : no config dir at "/usr/lib/ignition/base.platform.d/azure" Sep 3 19:16:34.512281 ignition[1194]: INFO : no configs found in "base.platform.d/azure" across system config directories Sep 3 19:16:34.512281 ignition[1194]: DEBUG : files: compiled without relabeling support, skipping Sep 3 19:16:34.512281 ignition[1194]: INFO : files: createResultFile: createFiles: op(1): [started] writing file "/sysroot/etc/.ignition-result.json" Sep 3 19:16:34.512281 ignition[1194]: INFO : files: createResultFile: createFiles: op(1): [finished] writing file "/sysroot/etc/.ignition-result.json" Sep 3 19:16:34.512281 ignition[1194]: INFO : files: files passed Sep 3 19:16:34.512281 ignition[1194]: INFO : Ignition finished successfully Sep 3 19:16:34.522000 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 3 19:16:34.570000 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 3 19:16:34.570000 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 3 19:16:34.586184 kernel: audit: type=1130 audit(1788462994.522:40): 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 3 19:16:34.515202 systemd[1]: Finished ignition-files.service - Ignition (files). Sep 3 19:16:34.588330 kernel: audit: type=1130 audit(1788462994.570:41): 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 3 19:16:34.532777 systemd[1]: Starting ignition-quench.service - Ignition (record completion)... Sep 3 19:16:34.591100 kernel: audit: type=1131 audit(1788462994.570:42): 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 3 19:16:34.546943 systemd[1]: Starting initrd-setup-root-after-ignition.service - Root filesystem completion... Sep 3 19:16:34.552291 systemd[1]: ignition-quench.service: Deactivated successfully. Sep 3 19:16:34.562593 systemd[1]: Finished ignition-quench.service - Ignition (record completion). Sep 3 19:16:34.620995 initrd-setup-root-after-ignition[1224]: grep: /sysroot/etc/flatcar/enabled-sysext.conf: No such file or directory Sep 3 19:16:34.620995 initrd-setup-root-after-ignition[1224]: grep: /sysroot/usr/share/flatcar/enabled-sysext.conf: No such file or directory Sep 3 19:16:34.630144 initrd-setup-root-after-ignition[1228]: grep: /sysroot/etc/flatcar/enabled-sysext.conf: No such file or directory Sep 3 19:16:34.639680 kernel: loop3: detected capacity change from 0 to 44096 Sep 3 19:16:34.639717 kernel: loop3: p1 p2 p3 Sep 3 19:16:34.650084 kernel: device-mapper: verity: sha256 using shash "sha256-ce" Sep 3 19:16:34.650123 kernel: device-mapper: verity: Unrecognized verity feature request: root_hash_sig_key_desc Sep 3 19:16:34.659894 kernel: device-mapper: table: 254:2: verity: Unrecognized verity feature request (-EINVAL) Sep 3 19:16:34.659927 kernel: device-mapper: ioctl: error adding target to table Sep 3 19:16:34.664190 systemd-confext[1230]: device-mapper: reload ioctl on loop3p1-21-verity (254:2) failed: Invalid argument Sep 3 19:16:34.678106 kernel: device-mapper: verity: sha256 using shash "sha256-ce" Sep 3 19:16:34.694103 kernel: erofs: (device dm-2): mounted with root inode @ nid 40. Sep 3 19:16:34.717127 kernel: loop4: detected capacity change from 0 to 44096 Sep 3 19:16:34.719090 kernel: loop4: p1 p2 p3 Sep 3 19:16:34.724321 kernel: device-mapper: verity: sha256 using shash "sha256-ce" Sep 3 19:16:34.724358 kernel: device-mapper: verity: Unrecognized verity feature request: root_hash_sig_key_desc Sep 3 19:16:34.726202 kernel: device-mapper: table: 254:2: verity: Unrecognized verity feature request (-EINVAL) Sep 3 19:16:34.727487 kernel: device-mapper: ioctl: error adding target to table Sep 3 19:16:34.727686 (sd-merge)[1238]: device-mapper: reload ioctl on loop4p1-25-verity (254:2) failed: Invalid argument Sep 3 19:16:34.736088 kernel: device-mapper: verity: sha256 using shash "sha256-ce" Sep 3 19:16:34.751092 kernel: erofs: (device dm-2): mounted with root inode @ nid 40. Sep 3 19:16:34.751580 (sd-merge)[1238]: Skipping extension refresh because no change was found, use --always-refresh=yes to always do a refresh. Sep 3 19:16:34.819094 kernel: loop4: detected capacity change from 0 to 158496 Sep 3 19:16:34.874086 kernel: loop4: p1 p2 p3 Sep 3 19:16:35.197391 kernel: device-mapper: verity: sha256 using shash "sha256-ce" Sep 3 19:16:35.197479 kernel: device-mapper: verity: Unrecognized verity feature request: root_hash_sig_key_desc Sep 3 19:16:35.197490 kernel: device-mapper: table: 254:2: verity: Unrecognized verity feature request (-EINVAL) Sep 3 19:16:35.201083 kernel: device-mapper: ioctl: error adding target to table Sep 3 19:16:35.200318 systemd-sysext[1246]: device-mapper: reload ioctl on loop4p1-29-verity (254:2) failed: Invalid argument Sep 3 19:16:35.208163 kernel: device-mapper: verity: sha256 using shash "sha256-ce" Sep 3 19:16:35.280101 kernel: erofs: (device dm-2): mounted with root inode @ nid 39. Sep 3 19:16:35.306090 kernel: loop5: detected capacity change from 0 to 388472 Sep 3 19:16:35.433141 kernel: loop5: p1 p2 p3 Sep 3 19:16:35.679603 kernel: device-mapper: verity: sha256 using shash "sha256-ce" Sep 3 19:16:35.679670 kernel: device-mapper: verity: Unrecognized verity feature request: root_hash_sig_key_desc Sep 3 19:16:35.683792 kernel: device-mapper: table: 254:2: verity: Unrecognized verity feature request (-EINVAL) Sep 3 19:16:35.686632 kernel: device-mapper: ioctl: error adding target to table Sep 3 19:16:35.686860 systemd-sysext[1246]: device-mapper: reload ioctl on loop5p1-33-verity (254:2) failed: Invalid argument Sep 3 19:16:35.693162 kernel: device-mapper: verity: sha256 using shash "sha256-ce" Sep 3 19:16:35.946132 kernel: erofs: (device dm-2): mounted with root inode @ nid 39. Sep 3 19:16:36.126091 kernel: loop6: detected capacity change from 0 to 140928 Sep 3 19:16:36.142211 kernel: loop6: p1 p2 p3 Sep 3 19:16:36.366069 kernel: device-mapper: verity: sha256 using shash "sha256-ce" Sep 3 19:16:36.366119 kernel: device-mapper: verity: Unrecognized verity feature request: root_hash_sig_key_desc Sep 3 19:16:36.368056 kernel: device-mapper: table: 254:2: verity: Unrecognized verity feature request (-EINVAL) Sep 3 19:16:36.369475 kernel: device-mapper: ioctl: error adding target to table Sep 3 19:16:36.369549 systemd-sysext[1246]: device-mapper: reload ioctl on loop6p1-37-verity (254:2) failed: Invalid argument Sep 3 19:16:36.378077 kernel: device-mapper: verity: sha256 using shash "sha256-ce" Sep 3 19:16:36.553084 kernel: erofs: (device dm-2): mounted with root inode @ nid 39. Sep 3 19:16:36.576097 kernel: loop7: detected capacity change from 0 to 158496 Sep 3 19:16:36.578092 kernel: loop7: p1 p2 p3 Sep 3 19:16:36.592054 kernel: device-mapper: verity: sha256 using shash "sha256-ce" Sep 3 19:16:36.592110 kernel: device-mapper: verity: Unrecognized verity feature request: root_hash_sig_key_desc Sep 3 19:16:36.593953 kernel: device-mapper: table: 254:2: verity: Unrecognized verity feature request (-EINVAL) Sep 3 19:16:36.598230 kernel: device-mapper: ioctl: error adding target to table Sep 3 19:16:36.598310 (sd-merge)[1269]: device-mapper: reload ioctl on loop7p1-41-verity (254:2) failed: Invalid argument Sep 3 19:16:36.620109 kernel: device-mapper: verity: sha256 using shash "sha256-ce" Sep 3 19:16:36.638095 kernel: erofs: (device dm-2): mounted with root inode @ nid 39. Sep 3 19:16:36.641127 kernel: loop1: detected capacity change from 0 to 388472 Sep 3 19:16:36.643083 kernel: loop1: p1 p2 p3 Sep 3 19:16:36.651894 kernel: device-mapper: verity: sha256 using shash "sha256-ce" Sep 3 19:16:36.651931 kernel: device-mapper: verity: Unrecognized verity feature request: root_hash_sig_key_desc Sep 3 19:16:36.653894 kernel: device-mapper: table: 254:3: verity: Unrecognized verity feature request (-EINVAL) Sep 3 19:16:36.655425 kernel: device-mapper: ioctl: error adding target to table Sep 3 19:16:36.655474 (sd-merge)[1269]: device-mapper: reload ioctl on loop1p1-45-verity (254:3) failed: Invalid argument Sep 3 19:16:36.660182 kernel: device-mapper: verity: sha256 using shash "sha256-ce" Sep 3 19:16:36.691084 kernel: erofs: (device dm-3): mounted with root inode @ nid 39. Sep 3 19:16:36.694565 kernel: loop3: detected capacity change from 0 to 140928 Sep 3 19:16:36.694602 kernel: loop3: p1 p2 p3 Sep 3 19:16:36.702554 kernel: device-mapper: verity: sha256 using shash "sha256-ce" Sep 3 19:16:36.702594 kernel: device-mapper: verity: Unrecognized verity feature request: root_hash_sig_key_desc Sep 3 19:16:36.704567 kernel: device-mapper: table: 254:4: verity: Unrecognized verity feature request (-EINVAL) Sep 3 19:16:36.706004 kernel: device-mapper: ioctl: error adding target to table Sep 3 19:16:36.706054 (sd-merge)[1269]: device-mapper: reload ioctl on loop3p1-49-verity (254:4) failed: Invalid argument Sep 3 19:16:36.712765 kernel: device-mapper: verity: sha256 using shash "sha256-ce" Sep 3 19:16:36.744576 (sd-merge)[1269]: Using extensions 'containerd-flatcar.raw', 'docker-flatcar.raw', 'oem-azure-9999.0.0+ignition-file-proto.raw'. Sep 3 19:16:36.747344 kernel: erofs: (device dm-4): mounted with root inode @ nid 39. Sep 3 19:16:36.747857 (sd-merge)[1269]: Merged extensions into '/sysroot/usr'. Sep 3 19:16:36.753230 systemd[1]: Finished initrd-setup-root-after-ignition.service - Root filesystem completion. Sep 3 19:16:36.757000 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 3 19:16:36.766229 kernel: audit: type=1130 audit(1788462996.757:43): 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 3 19:16:36.765714 systemd[1]: Starting initrd-parse-etc.service - Mountpoints Configured in the Real Root... Sep 3 19:16:36.797600 systemd[1]: initrd-parse-etc.service: Deactivated successfully. Sep 3 19:16:36.799916 systemd[1]: Finished initrd-parse-etc.service - Mountpoints Configured in the Real Root. Sep 3 19:16:36.803000 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 3 19:16:36.803000 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 3 19:16:36.815575 kernel: audit: type=1130 audit(1788462996.803:44): 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 3 19:16:36.804721 systemd[1]: initrd-parse-etc.service: Triggering OnSuccess= dependencies. Sep 3 19:16:36.821001 kernel: audit: type=1131 audit(1788462996.803:45): 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 3 19:16:36.812525 systemd[1]: Reached target initrd-fs.target - Initrd File Systems. Sep 3 19:16:36.823778 systemd[1]: Starting dracut-mount.service - dracut mount hook... Sep 3 19:16:37.139319 systemd[1]: Finished dracut-mount.service - dracut mount hook. Sep 3 19:16:37.142000 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 3 19:16:37.152260 kernel: audit: type=1130 audit(1788462997.142:46): 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 3 19:16:37.151183 systemd[1]: Starting dracut-pre-pivot.service - dracut pre-pivot and cleanup hook... Sep 3 19:16:37.180763 systemd[1]: Finished dracut-pre-pivot.service - dracut pre-pivot and cleanup hook. Sep 3 19:16:37.184000 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 3 19:16:37.189364 systemd[1]: Starting initrd-cleanup.service - Cleaning Up and Shutting Down Daemons... Sep 3 19:16:37.213498 systemd[1]: Stopped target basic.target - Basic System. Sep 3 19:16:37.216533 systemd[1]: Stopped target ignition-diskful.target - Ignition Boot Disk Setup. Sep 3 19:16:37.221408 systemd[1]: Stopped target initrd-root-device.target - Initrd Root Device. Sep 3 19:16:37.228239 systemd[1]: Stopped target initrd-usr-fs.target - Initrd /usr File System. Sep 3 19:16:37.233848 systemd[1]: Stopped target nss-lookup.target - Host and Network Name Lookups. Sep 3 19:16:37.240550 systemd[1]: Stopped target paths.target - Path Units. Sep 3 19:16:37.245788 systemd[1]: Stopped target remote-cryptsetup.target - Remote Encrypted Volumes. Sep 3 19:16:37.252565 systemd[1]: Stopped target slices.target - Slice Units. Sep 3 19:16:37.258287 systemd[1]: Stopped target sockets.target - Socket Units. Sep 3 19:16:37.263823 systemd[1]: Stopped target sysinit.target - System Initialization. Sep 3 19:16:37.269640 systemd[1]: Stopped target local-fs.target - Local File Systems. Sep 3 19:16:37.276745 systemd[1]: Stopped target local-fs-pre.target - Preparation for Local File Systems. Sep 3 19:16:37.283559 systemd[1]: Stopped target swap.target - Swaps. Sep 3 19:16:37.288286 systemd[1]: Stopped target timers.target - Timer Units. Sep 3 19:16:37.293717 systemd[1]: iscsid.socket: Deactivated successfully. Sep 3 19:16:37.294403 systemd[1]: Closed iscsid.socket - Open-iSCSI iscsid Socket. Sep 3 19:16:37.301518 systemd[1]: iscsiuio.socket: Deactivated successfully. Sep 3 19:16:37.301663 systemd[1]: Closed iscsiuio.socket - Open-iSCSI iscsiuio Socket. Sep 3 19:16:37.309970 systemd[1]: systemd-coredump.socket: Deactivated successfully. Sep 3 19:16:37.310130 systemd[1]: Closed systemd-coredump.socket - Process Core Dump Socket. Sep 3 19:16:37.319411 systemd[1]: systemd-journald-audit.socket: Deactivated successfully. Sep 3 19:16:37.319503 systemd[1]: Closed systemd-journald-audit.socket - Journal Audit Socket. Sep 3 19:16:37.328756 systemd[1]: dracut-pre-pivot.service: Deactivated successfully. Sep 3 19:16:37.328899 systemd[1]: Stopped dracut-pre-pivot.service - dracut pre-pivot and cleanup hook. Sep 3 19:16:37.335000 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 3 19:16:37.337352 systemd[1]: Stopped target remote-fs.target - Remote File Systems. Sep 3 19:16:37.342836 systemd[1]: Stopped target remote-fs-pre.target - Preparation for Remote File Systems. Sep 3 19:16:37.349486 systemd[1]: dracut-mount.service: Deactivated successfully. Sep 3 19:16:37.355000 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 3 19:16:37.350982 systemd[1]: Stopped dracut-mount.service - dracut mount hook. Sep 3 19:16:37.366000 audit[1]: SERVICE_STOP pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=dracut-pre-mount comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Sep 3 19:16:37.358842 systemd[1]: dracut-pre-mount.service: Deactivated successfully. Sep 3 19:16:37.358947 systemd[1]: Stopped dracut-pre-mount.service - dracut pre-mount hook. Sep 3 19:16:37.370057 systemd[1]: Stopped target cryptsetup.target - Local Encrypted Volumes. Sep 3 19:16:37.375765 systemd[1]: systemd-ask-password-console.path: Deactivated successfully. Sep 3 19:16:37.376492 systemd[1]: Stopped systemd-ask-password-console.path - Dispatch Password Requests to Console Directory Watch. Sep 3 19:16:37.385862 systemd[1]: Stopped target cryptsetup-pre.target - Local Encrypted Volumes (Pre). Sep 3 19:16:37.392279 systemd[1]: clevis-luks-askpass.path: Deactivated successfully. Sep 3 19:16:37.395474 systemd[1]: Stopped clevis-luks-askpass.path - Forward Password Requests to Clevis Directory Watch. Sep 3 19:16:37.409000 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 3 19:16:37.402827 systemd[1]: dracut-initqueue.service: Deactivated successfully. Sep 3 19:16:37.403010 systemd[1]: Stopped dracut-initqueue.service - dracut initqueue hook. Sep 3 19:16:37.414236 systemd[1]: initrd-setup-root-after-ignition.service: Deactivated successfully. Sep 3 19:16:37.415630 systemd[1]: Stopped initrd-setup-root-after-ignition.service - Root filesystem completion. Sep 3 19:16:37.423000 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 3 19:16:37.426235 systemd[1]: ignition-files.service: Deactivated successfully. Sep 3 19:16:37.426385 systemd[1]: Stopped ignition-files.service - Ignition (files). Sep 3 19:16:37.432000 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 3 19:16:37.435013 systemd[1]: flatcar-metadata-hostname.service: Deactivated successfully. Sep 3 19:16:37.435502 systemd[1]: Stopped flatcar-metadata-hostname.service - Flatcar Metadata Hostname Agent. Sep 3 19:16:37.441000 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 3 19:16:37.445549 systemd[1]: Stopping ignition-mount.service - Ignition (mount)... Sep 3 19:16:37.449592 systemd[1]: systemd-modules-load.service: Deactivated successfully. Sep 3 19:16:37.457000 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 3 19:16:37.451213 systemd[1]: Stopped systemd-modules-load.service - Load Kernel Modules. Sep 3 19:16:37.461494 systemd[1]: systemd-tmpfiles-setup.service: Deactivated successfully. Sep 3 19:16:37.461610 systemd[1]: Stopped systemd-tmpfiles-setup.service - Create System Files and Directories. Sep 3 19:16:37.471000 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 3 19:16:37.473856 systemd[1]: systemd-udev-trigger.service: Deactivated successfully. Sep 3 19:16:37.474010 systemd[1]: Stopped systemd-udev-trigger.service - Coldplug All udev Devices. Sep 3 19:16:37.482000 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 3 19:16:37.483829 ignition[1344]: INFO : Ignition 2.27.0 Sep 3 19:16:37.483829 ignition[1344]: INFO : Stage: umount Sep 3 19:16:37.483829 ignition[1344]: INFO : no config dir at "/run/ignition/base.d" Sep 3 19:16:37.483829 ignition[1344]: INFO : no config dir at "/etc/ignition/base.d" Sep 3 19:16:37.483829 ignition[1344]: INFO : no config dir at "/usr/lib/ignition/base.d" Sep 3 19:16:37.483829 ignition[1344]: INFO : no configs found in "base.d" across system config directories Sep 3 19:16:37.483829 ignition[1344]: INFO : no config dir at "/run/ignition/base.platform.d/azure" Sep 3 19:16:37.483829 ignition[1344]: INFO : no config dir at "/etc/ignition/base.platform.d/azure" Sep 3 19:16:37.483829 ignition[1344]: INFO : no config dir at "/usr/lib/ignition/base.platform.d/azure" Sep 3 19:16:37.483829 ignition[1344]: INFO : no configs found in "base.platform.d/azure" across system config directories Sep 3 19:16:37.483829 ignition[1344]: INFO : umount: umount passed Sep 3 19:16:37.483829 ignition[1344]: INFO : Ignition finished successfully Sep 3 19:16:37.496000 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 3 19:16:37.517000 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 3 19:16:37.489055 systemd[1]: dracut-pre-trigger.service: Deactivated successfully. Sep 3 19:16:37.489179 systemd[1]: Stopped dracut-pre-trigger.service - dracut pre-trigger hook. Sep 3 19:16:37.507881 systemd[1]: ignition-mount.service: Deactivated successfully. Sep 3 19:16:37.512118 systemd[1]: Stopped ignition-mount.service - Ignition (mount). Sep 3 19:16:37.534000 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 3 19:16:37.534000 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 3 19:16:37.524332 systemd[1]: initrd-cleanup.service: Deactivated successfully. Sep 3 19:16:37.526843 systemd[1]: Finished initrd-cleanup.service - Cleaning Up and Shutting Down Daemons. Sep 3 19:16:37.543286 systemd[1]: Stopped target network.target - Network. Sep 3 19:16:37.547343 systemd[1]: ignition-disks.service: Deactivated successfully. Sep 3 19:16:37.551000 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 3 19:16:37.547716 systemd[1]: Stopped ignition-disks.service - Ignition (disks). Sep 3 19:16:37.558000 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 3 19:16:37.555082 systemd[1]: ignition-setup-pre.service: Deactivated successfully. Sep 3 19:16:37.555137 systemd[1]: Stopped ignition-setup-pre.service - Ignition env setup. Sep 3 19:16:37.569000 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 3 19:16:37.563814 systemd[1]: initrd-setup-root.service: Deactivated successfully. Sep 3 19:16:37.563880 systemd[1]: Stopped initrd-setup-root.service - Root filesystem setup. Sep 3 19:16:37.573010 systemd-networkd[685]: eth0: DHCP lease lost Sep 3 19:16:37.573034 systemd[1]: Stopping systemd-networkd.service - Network Management... Sep 3 19:16:37.578984 systemd[1]: Stopping systemd-resolved.service - Network Name Resolution... Sep 3 19:16:37.588587 systemd[1]: systemd-networkd.service: Deactivated successfully. Sep 3 19:16:37.592424 systemd[1]: Stopped systemd-networkd.service - Network Management. Sep 3 19:16:37.602000 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 3 19:16:37.606936 systemd[1]: systemd-resolved.service: Deactivated successfully. Sep 3 19:16:37.609376 systemd[1]: Stopped systemd-resolved.service - Network Name Resolution. Sep 3 19:16:37.612000 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 3 19:16:37.617000 audit: BPF prog-id=8 op=UNLOAD Sep 3 19:16:37.617000 audit: BPF prog-id=5 op=UNLOAD Sep 3 19:16:37.619122 systemd[1]: Stopped target network-pre.target - Preparation for Network. Sep 3 19:16:37.623825 systemd[1]: systemd-networkd-resolve-hook.socket: Deactivated successfully. Sep 3 19:16:37.625160 systemd[1]: Closed systemd-networkd-resolve-hook.socket - Network Management Resolve Hook Socket. Sep 3 19:16:37.634598 systemd[1]: systemd-networkd.socket: Deactivated successfully. Sep 3 19:16:37.634660 systemd[1]: Closed systemd-networkd.socket - Network Management Netlink Socket. Sep 3 19:16:37.645549 systemd[1]: Stopping network-cleanup.service - Network Cleanup... Sep 3 19:16:37.649657 systemd[1]: Stopping systemd-udevd.service - Rule-based Manager for Device Events and Files... Sep 3 19:16:37.677567 systemd[1]: systemd-udevd.service: Deactivated successfully. Sep 3 19:16:37.682187 systemd[1]: Stopped systemd-udevd.service - Rule-based Manager for Device Events and Files. Sep 3 19:16:37.690000 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 3 19:16:37.691489 systemd[1]: systemd-udevd.service: Consumed 1.052s CPU time over 9.573s wall clock time. Sep 3 19:16:37.697724 kernel: hv_netvsc f8615163-0000-1000-2000-7ced8d8adccf eth0: Data path switched from VF: enP30832s1 Sep 3 19:16:37.697953 kernel: mana 7870:00:00.0 enP30832s1: Configured steering vPort 0 entries 64 Sep 3 19:16:37.698210 systemd[1]: systemd-udevd-control.socket: Deactivated successfully. Sep 3 19:16:37.698269 systemd[1]: Closed systemd-udevd-control.socket - udev Control Socket. Sep 3 19:16:37.707814 systemd[1]: dracut-pre-udev.service: Deactivated successfully. Sep 3 19:16:37.712000 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 3 19:16:37.707871 systemd[1]: Stopped dracut-pre-udev.service - dracut pre-udev hook. Sep 3 19:16:37.720000 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 3 19:16:37.716325 systemd[1]: dracut-cmdline.service: Deactivated successfully. Sep 3 19:16:37.716378 systemd[1]: Stopped dracut-cmdline.service - dracut cmdline hook. Sep 3 19:16:37.730000 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 3 19:16:37.725802 systemd[1]: dracut-cmdline-ask.service: Deactivated successfully. Sep 3 19:16:37.725856 systemd[1]: Stopped dracut-cmdline-ask.service - dracut ask for additional cmdline parameters. Sep 3 19:16:37.739397 systemd[1]: Starting initrd-udevadm-cleanup-db.service - Cleanup udev Database... Sep 3 19:16:37.752000 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 3 19:16:37.747741 systemd[1]: systemd-network-generator.service: Deactivated successfully. Sep 3 19:16:37.763000 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 3 19:16:37.747795 systemd[1]: Stopped systemd-network-generator.service - Generate Network Units from Kernel Command Line. Sep 3 19:16:37.756481 systemd[1]: systemd-tmpfiles-setup-dev.service: Deactivated successfully. Sep 3 19:16:37.756535 systemd[1]: Stopped systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev. Sep 3 19:16:37.770562 systemd[1]: systemd-tmpfiles-setup-dev-early.service: Deactivated successfully. Sep 3 19:16:37.770612 systemd[1]: Stopped systemd-tmpfiles-setup-dev-early.service - Create Static Device Nodes in /dev gracefully. Sep 3 19:16:37.781000 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 3 19:16:37.784424 systemd[1]: kmod-static-nodes.service: Deactivated successfully. Sep 3 19:16:37.784482 systemd[1]: Stopped kmod-static-nodes.service - Create List of Static Device Nodes. Sep 3 19:16:37.790000 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 3 19:16:37.794775 systemd[1]: systemd-vconsole-setup.service: Deactivated successfully. Sep 3 19:16:37.794826 systemd[1]: Stopped systemd-vconsole-setup.service - Virtual Console Setup. Sep 3 19:16:37.800000 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 3 19:16:37.805808 kernel: kauditd_printk_skb: 30 callbacks suppressed Sep 3 19:16:37.805826 kernel: audit: type=1131 audit(1788462997.800:77): 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 3 19:16:37.819509 systemd[1]: network-cleanup.service: Deactivated successfully. Sep 3 19:16:37.821754 systemd[1]: Stopped network-cleanup.service - Network Cleanup. Sep 3 19:16:37.828000 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 3 19:16:37.831582 systemd[1]: initrd-udevadm-cleanup-db.service: Deactivated successfully. Sep 3 19:16:37.844000 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 3 19:16:37.834771 systemd[1]: Finished initrd-udevadm-cleanup-db.service - Cleanup udev Database. Sep 3 19:16:37.844000 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 3 19:16:37.870808 kernel: audit: type=1131 audit(1788462997.828:78): 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 3 19:16:37.870657 systemd[1]: Reached target initrd-switch-root.target - Switch Root. Sep 3 19:16:37.874238 kernel: audit: type=1130 audit(1788462997.844:79): 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 3 19:16:37.874255 kernel: audit: type=1131 audit(1788462997.844:80): 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 3 19:16:37.877544 systemd[1]: Starting initrd-switch-root.service - Switch Root... Sep 3 19:16:37.892495 systemd[1]: Switching root. Sep 3 19:16:38.074587 systemd-journald[448]: Journal stopped Sep 3 19:16:43.837722 systemd-journald[448]: Received SIGTERM from PID 1 (systemd). Sep 3 19:16:43.837755 kernel: audit: type=1335 audit(1788462998.077:81): pid=448 uid=0 auid=4294967295 tty=(none) ses=4294967295 subj=kernel comm="systemd-journal" exe="/usr/lib/systemd/systemd-journald" nl-mcgrp=1 op=disconnect res=1 Sep 3 19:16:43.837768 kernel: SELinux: policy capability network_peer_controls=1 Sep 3 19:16:43.837776 kernel: SELinux: policy capability open_perms=1 Sep 3 19:16:43.837785 kernel: SELinux: policy capability extended_socket_class=1 Sep 3 19:16:43.837794 kernel: SELinux: policy capability always_check_network=0 Sep 3 19:16:43.837802 kernel: SELinux: policy capability cgroup_seclabel=1 Sep 3 19:16:43.837810 kernel: SELinux: policy capability nnp_nosuid_transition=1 Sep 3 19:16:43.837817 kernel: SELinux: policy capability genfs_seclabel_symlinks=0 Sep 3 19:16:43.837824 kernel: SELinux: policy capability ioctl_skip_cloexec=0 Sep 3 19:16:43.837832 kernel: SELinux: policy capability userspace_initial_context=0 Sep 3 19:16:43.837840 kernel: audit: type=1403 audit(1788462998.721:82): auid=4294967295 ses=4294967295 lsm=selinux res=1 Sep 3 19:16:43.837848 systemd[1]: Successfully loaded SELinux policy in 175.630ms. Sep 3 19:16:43.837858 systemd[1]: Relabeled /dev/, /dev/shm/, /run/ in 5.834ms. Sep 3 19:16:43.837867 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 3 19:16:43.837876 systemd[1]: Detected virtualization microsoft. Sep 3 19:16:43.837886 systemd[1]: Detected architecture arm64. Sep 3 19:16:43.837894 systemd[1]: Detected first boot. Sep 3 19:16:43.837902 systemd[1]: Initializing machine ID from random generator. Sep 3 19:16:43.837910 systemd[1]: Hostname set to . Sep 3 19:16:43.837916 kernel: audit: type=1334 audit(1788463000.609:83): prog-id=9 op=LOAD Sep 3 19:16:43.837924 kernel: audit: type=1334 audit(1788463000.609:84): prog-id=9 op=UNLOAD Sep 3 19:16:43.837931 zram_generator::config[1627]: No configuration found. Sep 3 19:16:43.837937 kernel: NET: Registered PF_VSOCK protocol family Sep 3 19:16:43.837945 systemd[1]: Applying preset policy. Sep 3 19:16:43.837951 systemd[1]: Populated /etc with preset unit settings. Sep 3 19:16:43.837960 kernel: audit: type=1334 audit(1788463003.132:85): prog-id=10 op=LOAD Sep 3 19:16:43.837967 kernel: audit: type=1334 audit(1788463003.132:86): prog-id=2 op=UNLOAD Sep 3 19:16:43.837975 kernel: audit: type=1334 audit(1788463003.135:87): prog-id=11 op=LOAD Sep 3 19:16:43.837981 kernel: audit: type=1334 audit(1788463003.136:88): prog-id=12 op=LOAD Sep 3 19:16:43.837987 kernel: audit: type=1334 audit(1788463003.136:89): prog-id=3 op=UNLOAD Sep 3 19:16:43.837992 kernel: audit: type=1334 audit(1788463003.136:90): prog-id=4 op=UNLOAD Sep 3 19:16:43.837998 kernel: audit: type=1334 audit(1788463003.140:91): prog-id=13 op=LOAD Sep 3 19:16:43.838005 kernel: audit: type=1334 audit(1788463003.140:92): prog-id=10 op=UNLOAD Sep 3 19:16:43.838011 kernel: audit: type=1334 audit(1788463003.140:93): prog-id=14 op=LOAD Sep 3 19:16:43.838018 kernel: audit: type=1334 audit(1788463003.143:94): prog-id=15 op=LOAD Sep 3 19:16:43.838024 systemd[1]: initrd-switch-root.service: Deactivated successfully. Sep 3 19:16:43.838031 systemd[1]: Stopped initrd-switch-root.service - Switch Root. Sep 3 19:16:43.838038 systemd[1]: systemd-journald.service: Scheduled restart job, restart counter is at 1. Sep 3 19:16:43.838045 systemd[1]: Created slice system-addon\x2dconfig.slice - Slice /system/addon-config. Sep 3 19:16:43.838054 systemd[1]: Created slice system-addon\x2drun.slice - Slice /system/addon-run. Sep 3 19:16:43.838071 systemd[1]: Created slice system-getty.slice - Slice /system/getty. Sep 3 19:16:43.838079 systemd[1]: Created slice system-modprobe.slice - Slice /system/modprobe. Sep 3 19:16:43.838085 systemd[1]: Created slice system-serial\x2dgetty.slice - Slice /system/serial-getty. Sep 3 19:16:43.838092 systemd[1]: Created slice system-system\x2dcloudinit.slice - Slice /system/system-cloudinit. Sep 3 19:16:43.838098 systemd[1]: Created slice system-systemd\x2dfsck.slice - Slice /system/systemd-fsck. Sep 3 19:16:43.838106 systemd[1]: Created slice user.slice - User and Session Slice. Sep 3 19:16:43.838113 systemd[1]: Started clevis-luks-askpass.path - Forward Password Requests to Clevis Directory Watch. Sep 3 19:16:43.838119 systemd[1]: Started systemd-ask-password-console.path - Dispatch Password Requests to Console Directory Watch. Sep 3 19:16:43.838127 systemd[1]: Started systemd-ask-password-wall.path - Forward Password Requests to Wall Directory Watch. Sep 3 19:16:43.838136 systemd[1]: Set up automount boot.automount - Boot partition Automount Point. Sep 3 19:16:43.838144 systemd[1]: Set up automount proc-sys-fs-binfmt_misc.automount - Arbitrary Executable File Formats File System Automount Point. Sep 3 19:16:43.838154 systemd[1]: Expecting device dev-disk-by\x2dlabel-OEM.device - /dev/disk/by-label/OEM... Sep 3 19:16:43.838161 systemd[1]: Expecting device dev-ptp_hyperv.device - /dev/ptp_hyperv... Sep 3 19:16:43.838168 systemd[1]: Expecting device dev-ttyAMA0.device - /dev/ttyAMA0... Sep 3 19:16:43.838174 systemd[1]: Reached target cryptsetup-pre.target - Local Encrypted Volumes (Pre). Sep 3 19:16:43.838180 systemd[1]: Reached target cryptsetup.target - Local Encrypted Volumes. Sep 3 19:16:43.838186 systemd[1]: Reached target imports.target - Image Downloads. Sep 3 19:16:43.838193 systemd[1]: Stopped target initrd-switch-root.target - Switch Root. Sep 3 19:16:43.838200 systemd[1]: Stopped target initrd-fs.target - Initrd File Systems. Sep 3 19:16:43.838206 systemd[1]: Stopped target initrd-root-fs.target - Initrd Root File System. Sep 3 19:16:43.838212 systemd[1]: Reached target integritysetup.target - Local Integrity Protected Volumes. Sep 3 19:16:43.838218 systemd[1]: Reached target remote-cryptsetup.target - Remote Encrypted Volumes. Sep 3 19:16:43.838225 systemd[1]: Reached target remote-fs.target - Remote File Systems. Sep 3 19:16:43.838231 systemd[1]: Reached target remote-integritysetup.target - Remote Integrity Protected Volumes. Sep 3 19:16:43.838239 systemd[1]: Reached target remote-veritysetup.target - Remote Verity Protected Volumes. Sep 3 19:16:43.838246 systemd[1]: Reached target slices.target - Slice Units. Sep 3 19:16:43.838252 systemd[1]: Reached target swap.target - Swaps. Sep 3 19:16:43.838260 systemd[1]: Reached target veritysetup.target - Local Verity Protected Volumes. Sep 3 19:16:43.838266 systemd[1]: Listening on systemd-ask-password.socket - Query the User Interactively for a Password. Sep 3 19:16:43.838273 systemd[1]: Listening on systemd-coredump.socket - Process Core Dump Socket. Sep 3 19:16:43.838279 systemd[1]: Listening on systemd-creds.socket - Credential Encryption/Decryption. Sep 3 19:16:43.838286 systemd[1]: Listening on systemd-factory-reset.socket - Factory Reset Management. Sep 3 19:16:43.838292 systemd[1]: Listening on systemd-journald-audit.socket - Journal Audit Socket. Sep 3 19:16:43.838298 systemd[1]: Listening on systemd-mountfsd.socket - DDI File System Mounter Socket. Sep 3 19:16:43.838306 systemd[1]: Listening on systemd-mute-console.socket - Console Output Muting Service Socket. Sep 3 19:16:43.838312 systemd[1]: Listening on systemd-networkd-resolve-hook.socket - Network Management Resolve Hook Socket. Sep 3 19:16:43.838319 systemd[1]: Listening on systemd-networkd-varlink-metrics.socket - Network Management Metrics Varlink Socket. Sep 3 19:16:43.838325 systemd[1]: Listening on systemd-networkd-varlink.socket - Network Management Varlink Socket. Sep 3 19:16:43.838331 systemd[1]: Listening on systemd-networkd.socket - Network Management Netlink Socket. Sep 3 19:16:43.838338 systemd[1]: Listening on systemd-nsresourced.socket - Namespace Resource Manager Socket. Sep 3 19:16:43.838344 systemd[1]: Listening on systemd-oomd.socket - Userspace Out-Of-Memory (OOM) Killer Socket. Sep 3 19:16:43.838351 systemd[1]: Listening on systemd-repart.socket - Disk Repartitioning Service Socket. Sep 3 19:16:43.838359 systemd[1]: Listening on systemd-resolved-monitor.socket - Resolve Monitor Varlink Socket. Sep 3 19:16:43.838365 systemd[1]: Listening on systemd-resolved-varlink.socket - Resolve Service Varlink Socket. Sep 3 19:16:43.838373 systemd[1]: Listening on systemd-udevd-control.socket - udev Control Socket. Sep 3 19:16:43.838380 systemd[1]: Listening on systemd-udevd-varlink.socket - udev Varlink Socket. Sep 3 19:16:43.838386 systemd[1]: Listening on systemd-userdbd.socket - User Database Manager Socket. Sep 3 19:16:43.838392 systemd[1]: Mounting dev-hugepages.mount - Huge Pages File System... Sep 3 19:16:43.838436 systemd[1]: Mounting dev-mqueue.mount - POSIX Message Queue File System... Sep 3 19:16:43.838443 systemd[1]: Mounting media.mount - External Media Directory... Sep 3 19:16:43.838449 systemd[1]: Mounting sys-kernel-debug.mount - Kernel Debug File System... Sep 3 19:16:43.838455 systemd[1]: Mounting sys-kernel-tracing.mount - Kernel Trace File System... Sep 3 19:16:43.838462 systemd[1]: tmp.mount: x-systemd.graceful-option=usrquota specified, but option is not available, suppressing. Sep 3 19:16:43.838468 systemd[1]: Mounting tmp.mount - Temporary Directory /tmp... Sep 3 19:16:43.838475 systemd[1]: Starting flatcar-tmpfiles.service - Create missing system files... Sep 3 19:16:43.838482 systemd[1]: ignition-delete-config.service - Ignition (delete config) skipped, no trigger condition checks were met. Sep 3 19:16:43.838488 systemd[1]: Starting kmod-static-nodes.service - Create List of Static Device Nodes... Sep 3 19:16:43.838494 systemd[1]: Starting modprobe@configfs.service - Load Kernel Module configfs... Sep 3 19:16:43.838501 systemd[1]: modprobe@drm.service - Load Kernel Module drm skipped, unmet condition check ConditionKernelModuleLoaded=!drm Sep 3 19:16:43.838507 systemd[1]: Starting modprobe@efi_pstore.service - Load Kernel Module efi_pstore... Sep 3 19:16:43.838514 systemd[1]: Starting modprobe@fuse.service - Load Kernel Module fuse... Sep 3 19:16:43.838521 systemd[1]: setup-nsswitch.service - Create /etc/nsswitch.conf skipped, unmet condition check ConditionPathExists=!/etc/nsswitch.conf Sep 3 19:16:43.838527 systemd[1]: systemd-fsck-root.service: Deactivated successfully. Sep 3 19:16:43.838535 systemd[1]: Stopped systemd-fsck-root.service - File System Check on Root Device. Sep 3 19:16:43.838542 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 3 19:16:43.838548 systemd[1]: Starting systemd-journald.service - Journal Service... Sep 3 19:16:43.838555 systemd[1]: Starting systemd-modules-load.service - Load Kernel Modules... Sep 3 19:16:43.838562 systemd[1]: Starting systemd-network-generator.service - Generate Network Units from Kernel Command Line... Sep 3 19:16:43.838568 systemd[1]: Reached target time-set.target - System Time Set. Sep 3 19:16:43.838575 systemd[1]: Starting systemd-remount-fs.service - Remount Root and Kernel File Systems... Sep 3 19:16:43.838581 systemd[1]: Starting systemd-udev-load-credentials.service - Load udev Rules from Credentials... Sep 3 19:16:43.838603 systemd-journald[1704]: Collecting audit messages is enabled. Sep 3 19:16:43.838617 systemd[1]: Starting systemd-udev-trigger.service - Coldplug All udev Devices... Sep 3 19:16:43.838627 systemd-journald[1704]: Journal started Sep 3 19:16:43.838641 systemd-journald[1704]: Runtime Journal (/run/log/journal/10730a17b23d48338fd7169030adc418) is 8M, max 78.3M, 70.3M free. Sep 3 19:16:43.426000 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 3 19:16:43.709000 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 3 19:16:43.721000 audit: BPF prog-id=18 op=UNLOAD Sep 3 19:16:43.721000 audit: BPF prog-id=17 op=UNLOAD Sep 3 19:16:43.722000 audit: BPF prog-id=19 op=LOAD Sep 3 19:16:43.722000 audit: BPF prog-id=20 op=LOAD Sep 3 19:16:43.722000 audit: BPF prog-id=21 op=LOAD Sep 3 19:16:43.046917 systemd[1]: Queued start job for default target multi-user.target. Sep 3 19:16:43.152941 systemd[1]: Unnecessary job was removed for dev-sda6.device - /dev/sda6. Sep 3 19:16:43.153288 systemd[1]: systemd-journald.service: Deactivated successfully. Sep 3 19:16:43.243325 systemd[1]: systemd-journald.service: Consumed 1.519s CPU time over 16.062s wall clock time. Sep 3 19:16:43.833028 systemd-modules-load[1706]: Using 2 probe threads Sep 3 19:16:43.834000 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 3 19:16:43.834000 audit[1704]: SYSCALL arch=c00000b7 syscall=211 success=yes exit=60 a0=3 a1=ffffe759b980 a2=4000 a3=0 items=0 ppid=1 pid=1704 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 3 19:16:43.834000 audit: PROCTITLE proctitle="/usr/lib/systemd/systemd-journald" Sep 3 19:16:43.863417 systemd[1]: Started systemd-journald.service - Journal Service. Sep 3 19:16:43.862000 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 3 19:16:43.864396 systemd[1]: Mounted dev-hugepages.mount - Huge Pages File System. Sep 3 19:16:43.868861 systemd[1]: Mounted dev-mqueue.mount - POSIX Message Queue File System. Sep 3 19:16:43.875082 kernel: fuse: init (API version 7.41) Sep 3 19:16:43.876297 systemd[1]: Mounted media.mount - External Media Directory. Sep 3 19:16:43.881283 systemd[1]: Mounted sys-kernel-debug.mount - Kernel Debug File System. Sep 3 19:16:43.885972 systemd[1]: Mounted sys-kernel-tracing.mount - Kernel Trace File System. Sep 3 19:16:43.890974 systemd[1]: Mounted tmp.mount - Temporary Directory /tmp. Sep 3 19:16:43.895253 systemd[1]: Finished kmod-static-nodes.service - Create List of Static Device Nodes. Sep 3 19:16:43.900000 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 3 19:16:43.901539 systemd[1]: modprobe@configfs.service: Deactivated successfully. Sep 3 19:16:43.901695 systemd[1]: Finished modprobe@configfs.service - Load Kernel Module configfs. Sep 3 19:16:43.905000 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 3 19:16:43.905000 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 3 19:16:43.906821 systemd[1]: modprobe@efi_pstore.service: Deactivated successfully. Sep 3 19:16:43.906971 systemd[1]: Finished modprobe@efi_pstore.service - Load Kernel Module efi_pstore. Sep 3 19:16:43.911000 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 3 19:16:43.911000 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 3 19:16:43.912129 systemd[1]: modprobe@fuse.service: Deactivated successfully. Sep 3 19:16:43.912271 systemd[1]: Finished modprobe@fuse.service - Load Kernel Module fuse. Sep 3 19:16:43.916000 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 3 19:16:43.916000 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 3 19:16:43.917427 systemd[1]: Finished systemd-network-generator.service - Generate Network Units from Kernel Command Line. Sep 3 19:16:43.922000 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 3 19:16:43.925837 systemd[1]: Finished systemd-remount-fs.service - Remount Root and Kernel File Systems. Sep 3 19:16:43.929000 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 3 19:16:43.937669 systemd[1]: Reached target network-pre.target - Preparation for Network. Sep 3 19:16:43.943461 systemd[1]: Mounting sys-fs-fuse-connections.mount - FUSE Control File System... Sep 3 19:16:43.959217 systemd[1]: Mounting sys-kernel-config.mount - Kernel Configuration File System... Sep 3 19:16:43.962405 systemd[1]: remount-root.service - Remount Root File System skipped, unmet condition check ConditionPathIsReadWrite=!/ Sep 3 19:16:43.982841 systemd[1]: Starting systemd-hwdb-update.service - Rebuild Hardware Database... Sep 3 19:16:43.992205 systemd[1]: Starting systemd-journal-flush.service - Flush Journal to Persistent Storage... Sep 3 19:16:44.001232 systemd[1]: systemd-pstore.service - Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore Sep 3 19:16:44.004282 systemd[1]: Starting systemd-random-seed.service - Load/Save OS Random Seed... Sep 3 19:16:44.012303 systemd[1]: Starting systemd-tmpfiles-setup-dev-early.service - Create Static Device Nodes in /dev gracefully... Sep 3 19:16:44.021709 systemd[1]: Finished systemd-modules-load.service - Load Kernel Modules. Sep 3 19:16:44.024000 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 3 19:16:44.026978 systemd[1]: Finished systemd-udev-load-credentials.service - Load udev Rules from Credentials. Sep 3 19:16:44.032000 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 3 19:16:44.034412 systemd[1]: Mounted sys-fs-fuse-connections.mount - FUSE Control File System. Sep 3 19:16:44.040293 systemd[1]: Mounted sys-kernel-config.mount - Kernel Configuration File System. Sep 3 19:16:44.052287 systemd[1]: Starting systemd-sysctl.service - Apply Kernel Variables... Sep 3 19:16:44.075529 systemd[1]: Finished systemd-udev-trigger.service - Coldplug All udev Devices. Sep 3 19:16:44.081000 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 3 19:16:44.092160 systemd-journald[1704]: Time spent on flushing to /var/log/journal/10730a17b23d48338fd7169030adc418 is 12.954ms for 1169 entries. Sep 3 19:16:44.092160 systemd-journald[1704]: System Journal (/var/log/journal/10730a17b23d48338fd7169030adc418) is 8M, max 2.2G, 2.2G free. Sep 3 19:16:44.138000 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 3 19:16:44.225430 systemd-journald[1704]: Received client request to flush runtime journal. Sep 3 19:16:44.134628 systemd[1]: Finished systemd-random-seed.service - Load/Save OS Random Seed. Sep 3 19:16:44.139496 systemd[1]: Reached target first-boot-complete.target - First Boot Complete. Sep 3 19:16:44.228300 systemd[1]: Finished systemd-journal-flush.service - Flush Journal to Persistent Storage. Sep 3 19:16:44.232000 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 3 19:16:44.266300 systemd[1]: Finished systemd-sysctl.service - Apply Kernel Variables. Sep 3 19:16:44.269000 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 3 19:16:44.298807 systemd[1]: Finished flatcar-tmpfiles.service - Create missing system files. Sep 3 19:16:44.302000 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 3 19:16:44.369793 systemd-tmpfiles[1753]: ACLs are not supported, ignoring. Sep 3 19:16:44.369812 systemd-tmpfiles[1753]: ACLs are not supported, ignoring. Sep 3 19:16:44.373171 systemd[1]: Finished systemd-tmpfiles-setup-dev-early.service - Create Static Device Nodes in /dev gracefully. Sep 3 19:16:44.381000 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 3 19:16:44.386223 systemd[1]: Starting systemd-sysusers.service - Create System Users... Sep 3 19:16:44.538771 systemd[1]: Finished systemd-sysusers.service - Create System Users. Sep 3 19:16:44.542000 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 3 19:16:44.546028 systemd[1]: Starting systemd-journalctl.socket - Journal Log Access Socket... Sep 3 19:16:44.553000 audit: BPF prog-id=22 op=LOAD Sep 3 19:16:44.553000 audit: BPF prog-id=23 op=LOAD Sep 3 19:16:44.553000 audit: BPF prog-id=24 op=LOAD Sep 3 19:16:44.555380 systemd[1]: Starting systemd-oomd.service - Userspace Out-Of-Memory (OOM) Killer... Sep 3 19:16:44.559000 audit: BPF prog-id=25 op=LOAD Sep 3 19:16:44.560854 systemd[1]: Starting systemd-resolved.service - Network Name Resolution... Sep 3 19:16:44.565921 systemd[1]: Starting systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev... Sep 3 19:16:44.571367 systemd[1]: Listening on systemd-journalctl.socket - Journal Log Access Socket. Sep 3 19:16:44.583211 systemd[1]: Starting modprobe@tun.service - Load Kernel Module tun... Sep 3 19:16:44.586000 audit: BPF prog-id=26 op=LOAD Sep 3 19:16:44.586000 audit: BPF prog-id=27 op=LOAD Sep 3 19:16:44.586000 audit: BPF prog-id=28 op=LOAD Sep 3 19:16:44.589554 systemd[1]: Starting systemd-userdbd.service - User Database Manager... Sep 3 19:16:44.595677 systemd-tmpfiles[1773]: ACLs are not supported, ignoring. Sep 3 19:16:44.598113 systemd-tmpfiles[1773]: ACLs are not supported, ignoring. Sep 3 19:16:44.608190 systemd[1]: Finished systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev. Sep 3 19:16:44.614000 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 3 19:16:44.615989 systemd[1]: Reached target local-fs-pre.target - Preparation for Local File Systems. Sep 3 19:16:44.623291 systemd[1]: systemd-repart.service - Repartition Root Disk skipped, no trigger condition checks were met. Sep 3 19:16:44.623492 systemd[1]: proc-sys-fs-binfmt_misc.automount: Got automount request for /proc/sys/fs/binfmt_misc, triggered by 1775 ((systemd-userd)) Sep 3 19:16:44.696583 systemd[1]: Finished systemd-hwdb-update.service - Rebuild Hardware Database. Sep 3 19:16:44.699000 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 3 19:16:44.701092 kernel: tun: Universal TUN/TAP device driver, 1.6 Sep 3 19:16:44.701399 systemd[1]: modprobe@tun.service: Deactivated successfully. Sep 3 19:16:44.701612 systemd[1]: Finished modprobe@tun.service - Load Kernel Module tun. Sep 3 19:16:44.704000 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 3 19:16:44.704000 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 3 19:16:44.706000 audit: BPF prog-id=29 op=LOAD Sep 3 19:16:44.706000 audit: BPF prog-id=30 op=LOAD Sep 3 19:16:44.706000 audit: BPF prog-id=31 op=LOAD Sep 3 19:16:44.708278 systemd[1]: Starting systemd-nsresourced.service - Namespace Resource Manager... Sep 3 19:16:44.720000 audit: BPF prog-id=7 op=UNLOAD Sep 3 19:16:44.720000 audit: BPF prog-id=6 op=UNLOAD Sep 3 19:16:44.720000 audit: BPF prog-id=32 op=LOAD Sep 3 19:16:44.720000 audit: BPF prog-id=33 op=LOAD Sep 3 19:16:44.722192 systemd[1]: Starting systemd-udevd.service - Rule-based Manager for Device Events and Files... Sep 3 19:16:44.940653 systemd-udevd[1782]: Using default interface naming scheme 'v260'. Sep 3 19:16:45.245947 systemd[1]: Mounting proc-sys-fs-binfmt_misc.mount - Arbitrary Executable File Formats File System... Sep 3 19:16:45.250156 systemd[1]: var-lib-machines.mount - Virtual Machine and Container Storage (Compatibility) skipped, unmet condition check ConditionPathExists=/var/lib/machines.raw Sep 3 19:16:45.250275 systemd[1]: Reached target local-fs.target - Local File Systems. Sep 3 19:16:45.253157 systemd[1]: Reached target machines.target - Virtual Machines and Containers. Sep 3 19:16:45.255285 systemd[1]: Listening on systemd-importd.socket - Disk Image Download Service Socket. Sep 3 19:16:45.258060 systemd[1]: Listening on systemd-sysext.socket - System Extension Image Management. Sep 3 19:16:45.264194 systemd[1]: Starting systemd-confext.service - Merge System Configuration Images into /etc/... Sep 3 19:16:45.279214 systemd[1]: Starting systemd-machine-id-commit.service - Save Transient machine-id to Disk... Sep 3 19:16:45.287315 systemd[1]: Starting systemd-userdb-load-credentials.service - Load JSON user/group Records from Credentials... Sep 3 19:16:45.293658 systemd[1]: Mounted proc-sys-fs-binfmt_misc.mount - Arbitrary Executable File Formats File System. Sep 3 19:16:45.304238 systemd[1]: systemd-binfmt.service - Set Up Additional Binary Formats skipped, no trigger condition checks were met. Sep 3 19:16:45.328356 systemd[1]: Finished systemd-userdb-load-credentials.service - Load JSON user/group Records from Credentials. Sep 3 19:16:45.334000 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 3 19:16:45.340929 systemd[1]: Started systemd-userdbd.service - User Database Manager. Sep 3 19:16:45.341636 systemd-nsresourced[1779]: Not setting up BPF subsystem, as functionality has been disabled at compile time. Sep 3 19:16:45.345000 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 3 19:16:45.347038 systemd[1]: Started systemd-nsresourced.service - Namespace Resource Manager. Sep 3 19:16:45.353215 kernel: loop4: detected capacity change from 0 to 44096 Sep 3 19:16:45.353000 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 3 19:16:45.367089 kernel: loop4: p1 p2 p3 Sep 3 19:16:45.417893 kernel: device-mapper: verity: sha256 using shash "sha256-ce" Sep 3 19:16:45.419860 kernel: device-mapper: verity: Unrecognized verity feature request: root_hash_sig_key_desc Sep 3 19:16:45.421878 kernel: device-mapper: table: 254:5: verity: Unrecognized verity feature request (-EINVAL) Sep 3 19:16:45.422994 systemd-oomd[1771]: No swap; memory pressure usage will be degraded Sep 3 19:16:45.425468 kernel: device-mapper: ioctl: error adding target to table Sep 3 19:16:45.425693 systemd-confext[1789]: device-mapper: reload ioctl on loop4p1-53-verity (254:5) failed: Invalid argument Sep 3 19:16:45.427006 systemd[1]: Started systemd-oomd.service - Userspace Out-Of-Memory (OOM) Killer. Sep 3 19:16:45.430000 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 3 19:16:45.435086 kernel: device-mapper: verity: sha256 using shash "sha256-ce" Sep 3 19:16:45.474153 systemd[1]: Finished systemd-machine-id-commit.service - Save Transient machine-id to Disk. Sep 3 19:16:45.478000 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 3 19:16:45.478610 systemd-resolved[1772]: Positive Trust Anchors: Sep 3 19:16:45.478621 systemd-resolved[1772]: . IN DS 20326 8 2 e06d44b80b8f1d39a95c0b0d7c65d08458e880409bbc683457104237c7f8ec8d Sep 3 19:16:45.478624 systemd-resolved[1772]: . IN DS 38696 8 2 683d2d0acb8c9b712a1948b27f741219298d0a450d612c483af444a4c0fb2b16 Sep 3 19:16:45.478645 systemd-resolved[1772]: 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 3 19:16:45.479361 systemd[1]: Started systemd-udevd.service - Rule-based Manager for Device Events and Files. Sep 3 19:16:45.484000 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 3 19:16:45.485000 audit: BPF prog-id=34 op=LOAD Sep 3 19:16:45.489230 systemd[1]: Starting systemd-networkd.service - Network Management... Sep 3 19:16:45.570960 systemd-resolved[1772]: Using system hostname 'ci-9999.0.0-i-95488032b5'. Sep 3 19:16:45.572957 systemd[1]: Started systemd-resolved.service - Network Name Resolution. Sep 3 19:16:45.575834 systemd-networkd[1811]: lo: Link UP Sep 3 19:16:45.575845 systemd-networkd[1811]: lo: Gained carrier Sep 3 19:16:45.578000 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 3 19:16:45.579991 systemd[1]: Started systemd-networkd.service - Network Management. Sep 3 19:16:45.583000 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 3 19:16:45.584396 systemd[1]: Reached target network.target - Network. Sep 3 19:16:45.590176 systemd[1]: Reached target nss-lookup.target - Host and Network Name Lookups. Sep 3 19:16:45.596312 systemd[1]: Starting systemd-networkd-persistent-storage.service - Enable Persistent Storage in systemd-networkd... Sep 3 19:16:45.602193 systemd[1]: Starting systemd-networkd-wait-online.service - Wait for Network to be Online... Sep 3 19:16:45.609903 systemd-networkd[1811]: eth0: Configuring with /usr/lib/systemd/network/zz-default.network. Sep 3 19:16:45.618102 kernel: mana 7870:00:00.0 enP30832s1: Configured vPort 0 PD 18 DB 16 Sep 3 19:16:45.628182 systemd[1]: Condition check resulted in dev-ttyAMA0.device - /dev/ttyAMA0 being skipped. Sep 3 19:16:45.640611 kernel: mana 7870:00:00.0 enP30832s1: Configured steering vPort 0 entries 64 Sep 3 19:16:45.640861 kernel: hv_netvsc f8615163-0000-1000-2000-7ced8d8adccf eth0: Data path switched to VF: enP30832s1 Sep 3 19:16:45.644936 systemd-networkd[1811]: enP30832s1: Link UP Sep 3 19:16:45.645004 systemd-networkd[1811]: eth0: Link UP Sep 3 19:16:45.645007 systemd-networkd[1811]: eth0: Gained carrier Sep 3 19:16:45.648267 systemd-networkd[1811]: enP30832s1: Gained carrier Sep 3 19:16:45.653122 systemd-networkd[1811]: eth0: DHCPv4 address 10.0.0.5/24, gateway 10.0.0.1 acquired from 168.63.129.16 Sep 3 19:16:45.686361 systemd[1]: Finished systemd-networkd-persistent-storage.service - Enable Persistent Storage in systemd-networkd. Sep 3 19:16:45.688000 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 3 19:16:45.731092 kernel: mousedev: PS/2 mouse device common for all mice Sep 3 19:16:45.759984 systemd[1]: Condition check resulted in dev-ptp_hyperv.device - /dev/ptp_hyperv being skipped. Sep 3 19:16:45.769163 kernel: hv_vmbus: registering driver hv_balloon Sep 3 19:16:45.772413 kernel: hv_balloon: Using Dynamic Memory protocol version 2.0 Sep 3 19:16:45.772473 kernel: hv_balloon: Memory hot add disabled on ARM64 Sep 3 19:16:45.807152 kernel: hv_storvsc f8b3781a-1e82-4818-a1c3-63d806ec15bb: tag#99 cmd 0x85 status: scsi 0x2 srb 0x84 hv 0xc0000185 Sep 3 19:16:45.815941 kernel: hv_vmbus: registering driver hyperv_fb Sep 3 19:16:45.816755 systemd[1]: Starting systemd-vconsole-setup.service - Virtual Console Setup... Sep 3 19:16:45.822149 kernel: hyperv_fb: Synthvid Version major 3, minor 5 Sep 3 19:16:45.822179 kernel: hyperv_fb: Screen resolution: 1024x768, Color depth: 32, Frame buffer size: 8388608 Sep 3 19:16:45.823741 kernel: Console: switching to colour dummy device 80x25 Sep 3 19:16:45.829380 kernel: Console: switching to colour frame buffer device 128x48 Sep 3 19:16:45.920097 kernel: erofs: (device dm-5): mounted with root inode @ nid 40. Sep 3 19:16:45.929376 systemd[1]: systemd-vconsole-setup.service: Deactivated successfully. Sep 3 19:16:45.931198 systemd[1]: Stopped systemd-vconsole-setup.service - Virtual Console Setup. Sep 3 19:16:45.936000 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 3 19:16:45.936000 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 3 19:16:45.941285 systemd[1]: Starting systemd-vconsole-setup.service - Virtual Console Setup... Sep 3 19:16:45.951084 kernel: loop4: detected capacity change from 0 to 44096 Sep 3 19:16:45.954781 kernel: loop4: p1 p2 p3 Sep 3 19:16:45.966770 kernel: device-mapper: verity: sha256 using shash "sha256-ce" Sep 3 19:16:45.966831 kernel: device-mapper: verity: Unrecognized verity feature request: root_hash_sig_key_desc Sep 3 19:16:45.969976 kernel: device-mapper: table: 254:5: verity: Unrecognized verity feature request (-EINVAL) Sep 3 19:16:45.974234 kernel: device-mapper: ioctl: error adding target to table Sep 3 19:16:45.974995 (sd-merge)[1891]: device-mapper: reload ioctl on loop4p1-58-verity (254:5) failed: Invalid argument Sep 3 19:16:45.983125 kernel: device-mapper: verity: sha256 using shash "sha256-ce" Sep 3 19:16:46.060879 (sd-merge)[1891]: Skipping extension refresh because no change was found, use --always-refresh=yes to always do a refresh. Sep 3 19:16:46.061079 kernel: erofs: (device dm-5): mounted with root inode @ nid 40. Sep 3 19:16:46.070488 systemd[1]: Finished systemd-confext.service - Merge System Configuration Images into /etc/. Sep 3 19:16:46.074000 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 3 19:16:46.081250 systemd[1]: Starting systemd-sysext.service - Merge System Extension Images into /usr/ and /opt/... Sep 3 19:16:46.104083 kernel: loop4: detected capacity change from 0 to 158496 Sep 3 19:16:46.104616 systemd[1]: Found device dev-disk-by\x2dlabel-OEM.device - Virtual_Disk OEM. Sep 3 19:16:46.109219 systemd[1]: Starting systemd-fsck@dev-disk-by\x2dlabel-OEM.service - File System Check on /dev/disk/by-label/OEM... Sep 3 19:16:46.120174 kernel: loop4: p1 p2 p3 Sep 3 19:16:46.154230 kernel: device-mapper: verity: sha256 using shash "sha256-ce" Sep 3 19:16:46.154332 kernel: device-mapper: verity: Unrecognized verity feature request: root_hash_sig_key_desc Sep 3 19:16:46.158947 kernel: device-mapper: table: 254:5: verity: Unrecognized verity feature request (-EINVAL) Sep 3 19:16:46.164089 kernel: device-mapper: ioctl: error adding target to table Sep 3 19:16:46.162277 systemd-sysext[1938]: device-mapper: reload ioctl on loop4p1-62-verity (254:5) failed: Invalid argument Sep 3 19:16:46.164406 kernel: device-mapper: verity: sha256 using shash "sha256-ce" Sep 3 19:16:46.218535 systemd[1]: Finished systemd-fsck@dev-disk-by\x2dlabel-OEM.service - File System Check on /dev/disk/by-label/OEM. Sep 3 19:16:46.223000 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 3 19:16:46.241104 kernel: erofs: (device dm-5): mounted with root inode @ nid 39. Sep 3 19:16:46.251499 systemd[1]: etc-machine\x2did.mount: Deactivated successfully. Sep 3 19:16:46.264094 kernel: loop4: detected capacity change from 0 to 388472 Sep 3 19:16:46.273120 kernel: loop4: p1 p2 p3 Sep 3 19:16:46.297938 kernel: device-mapper: verity: sha256 using shash "sha256-ce" Sep 3 19:16:46.298040 kernel: device-mapper: verity: Unrecognized verity feature request: root_hash_sig_key_desc Sep 3 19:16:46.303535 kernel: device-mapper: table: 254:5: verity: Unrecognized verity feature request (-EINVAL) Sep 3 19:16:46.304303 kernel: device-mapper: ioctl: error adding target to table Sep 3 19:16:46.307162 systemd-sysext[1938]: device-mapper: reload ioctl on loop4p1-67-verity (254:5) failed: Invalid argument Sep 3 19:16:46.311362 kernel: device-mapper: verity: sha256 using shash "sha256-ce" Sep 3 19:16:46.311644 systemd-vconsole-setup[1890]: Configuration of first virtual console was skipped, ignoring remaining ones. Sep 3 19:16:46.313725 systemd[1]: Finished systemd-vconsole-setup.service - Virtual Console Setup. Sep 3 19:16:46.317000 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 3 19:16:46.337082 kernel: erofs: (device dm-5): mounted with root inode @ nid 39. Sep 3 19:16:46.366130 kernel: loop4: detected capacity change from 0 to 140928 Sep 3 19:16:46.369093 kernel: loop4: p1 p2 p3 Sep 3 19:16:46.400667 kernel: device-mapper: verity: sha256 using shash "sha256-ce" Sep 3 19:16:46.400750 kernel: device-mapper: verity: Unrecognized verity feature request: root_hash_sig_key_desc Sep 3 19:16:46.406971 kernel: device-mapper: table: 254:5: verity: Unrecognized verity feature request (-EINVAL) Sep 3 19:16:46.410079 kernel: device-mapper: ioctl: error adding target to table Sep 3 19:16:46.410340 systemd-sysext[1938]: device-mapper: reload ioctl on loop4p1-72-verity (254:5) failed: Invalid argument Sep 3 19:16:46.417086 kernel: device-mapper: verity: sha256 using shash "sha256-ce" Sep 3 19:16:46.435089 kernel: erofs: (device dm-5): mounted with root inode @ nid 39. Sep 3 19:16:46.461133 kernel: loop4: detected capacity change from 0 to 158496 Sep 3 19:16:46.464084 kernel: loop4: p1 p2 p3 Sep 3 19:16:46.483117 kernel: device-mapper: verity: sha256 using shash "sha256-ce" Sep 3 19:16:46.483192 kernel: device-mapper: verity: Unrecognized verity feature request: root_hash_sig_key_desc Sep 3 19:16:46.487304 kernel: device-mapper: table: 254:5: verity: Unrecognized verity feature request (-EINVAL) Sep 3 19:16:46.490863 kernel: device-mapper: ioctl: error adding target to table Sep 3 19:16:46.491132 (sd-merge)[1973]: device-mapper: reload ioctl on loop4p1-77-verity (254:5) failed: Invalid argument Sep 3 19:16:46.498215 kernel: device-mapper: verity: sha256 using shash "sha256-ce" Sep 3 19:16:46.516083 kernel: erofs: (device dm-5): mounted with root inode @ nid 39. Sep 3 19:16:46.520116 kernel: loop5: detected capacity change from 0 to 388472 Sep 3 19:16:46.523241 kernel: loop5: p1 p2 p3 Sep 3 19:16:46.538781 kernel: device-mapper: verity: sha256 using shash "sha256-ce" Sep 3 19:16:46.538843 kernel: device-mapper: verity: Unrecognized verity feature request: root_hash_sig_key_desc Sep 3 19:16:46.544445 kernel: device-mapper: table: 254:6: verity: Unrecognized verity feature request (-EINVAL) Sep 3 19:16:46.548888 kernel: device-mapper: ioctl: error adding target to table Sep 3 19:16:46.549137 (sd-merge)[1973]: device-mapper: reload ioctl on loop5p1-81-verity (254:6) failed: Invalid argument Sep 3 19:16:46.558100 kernel: device-mapper: verity: sha256 using shash "sha256-ce" Sep 3 19:16:46.584083 kernel: erofs: (device dm-6): mounted with root inode @ nid 39. Sep 3 19:16:46.596109 kernel: loop6: detected capacity change from 0 to 140928 Sep 3 19:16:46.599159 kernel: loop6: p1 p2 p3 Sep 3 19:16:46.611398 kernel: device-mapper: verity: sha256 using shash "sha256-ce" Sep 3 19:16:46.611461 kernel: device-mapper: verity: Unrecognized verity feature request: root_hash_sig_key_desc Sep 3 19:16:46.617145 kernel: device-mapper: table: 254:7: verity: Unrecognized verity feature request (-EINVAL) Sep 3 19:16:46.619228 kernel: device-mapper: ioctl: error adding target to table Sep 3 19:16:46.619802 (sd-merge)[1973]: device-mapper: reload ioctl on loop6p1-85-verity (254:7) failed: Invalid argument Sep 3 19:16:46.624521 kernel: device-mapper: verity: sha256 using shash "sha256-ce" Sep 3 19:16:46.644053 (sd-merge)[1973]: Skipping extension refresh because no change was found, use --always-refresh=yes to always do a refresh. Sep 3 19:16:46.644184 kernel: erofs: (device dm-7): mounted with root inode @ nid 39. Sep 3 19:16:46.647170 systemd[1]: Finished systemd-sysext.service - Merge System Extension Images into /usr/ and /opt/. Sep 3 19:16:46.652000 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 3 19:16:46.656232 systemd[1]: Starting systemd-tmpfiles-setup.service - Create System Files and Directories... Sep 3 19:16:46.697230 systemd-tmpfiles[1996]: /usr/lib/tmpfiles.d/nfs-utils.conf:6: Duplicate line for path "/var/lib/nfs/sm", ignoring. Sep 3 19:16:46.697252 systemd-tmpfiles[1996]: /usr/lib/tmpfiles.d/nfs-utils.conf:7: Duplicate line for path "/var/lib/nfs/sm.bak", ignoring. Sep 3 19:16:46.697428 systemd-tmpfiles[1996]: /usr/lib/tmpfiles.d/provision.conf:20: Duplicate line for path "/root", ignoring. Sep 3 19:16:46.698053 systemd-tmpfiles[1996]: ACLs are not supported, ignoring. Sep 3 19:16:46.698543 systemd-tmpfiles[1996]: ACLs are not supported, ignoring. Sep 3 19:16:46.702136 systemd-tmpfiles[1996]: Detected autofs mount point '/boot' during canonicalization of 'boot'. Sep 3 19:16:46.702246 systemd-tmpfiles[1996]: Skipping /boot Sep 3 19:16:46.707249 systemd-tmpfiles[1996]: Detected autofs mount point '/boot' during canonicalization of 'boot'. Sep 3 19:16:46.707353 systemd-tmpfiles[1996]: Skipping /boot Sep 3 19:16:46.716702 systemd[1]: Finished systemd-tmpfiles-setup.service - Create System Files and Directories. Sep 3 19:16:46.723000 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 3 19:16:46.727007 systemd[1]: Starting audit-rules.service - Load Audit Rules... Sep 3 19:16:46.738740 systemd[1]: Starting clean-ca-certificates.service - Clean up broken links in /etc/ssl/certs... Sep 3 19:16:46.746209 systemd[1]: Starting ldconfig.service - Rebuild Dynamic Linker Cache... Sep 3 19:16:46.753198 systemd[1]: Starting systemd-journal-catalog-update.service - Rebuild Journal Catalog... Sep 3 19:16:46.759750 systemd[1]: Starting systemd-update-utmp.service - Record System Boot/Shutdown in UTMP... Sep 3 19:16:46.792000 audit[2005]: AUDIT1127 pid=2005 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 3 19:16:46.798102 systemd[1]: Finished systemd-update-utmp.service - Record System Boot/Shutdown in UTMP. Sep 3 19:16:46.799000 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 3 19:16:46.941517 systemd-networkd[1811]: eth0: Gained IPv6LL Sep 3 19:16:46.946134 systemd[1]: Finished systemd-networkd-wait-online.service - Wait for Network to be Online. Sep 3 19:16:46.948000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=systemd-networkd-wait-online comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Sep 3 19:16:46.949377 systemd[1]: Reached target network-online.target - Network is Online. Sep 3 19:16:47.007000 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 3 19:16:47.007000 audit[2029]: SYSCALL arch=c00000b7 syscall=206 success=yes exit=1056 a0=3 a1=ffffec0e5310 a2=420 a3=0 items=0 ppid=2001 pid=2029 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 3 19:16:47.007000 audit: PROCTITLE proctitle=2F7362696E2F617564697463746C002D52002F6574632F61756469742F61756469742E72756C6573 Sep 3 19:16:47.008665 augenrules[2029]: No rules Sep 3 19:16:47.009914 systemd[1]: audit-rules.service: Deactivated successfully. Sep 3 19:16:47.010203 systemd[1]: Finished audit-rules.service - Load Audit Rules. Sep 3 19:16:47.218164 systemd[1]: Finished systemd-journal-catalog-update.service - Rebuild Journal Catalog. Sep 3 19:16:47.683964 systemd[1]: Finished clean-ca-certificates.service - Clean up broken links in /etc/ssl/certs. Sep 3 19:16:47.689820 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 3 19:16:55.227302 ldconfig[2003]: ldconfig: /usr/lib/ld.so.conf is not an ELF file - it has the wrong magic bytes at the start. Sep 3 19:16:55.238957 systemd[1]: Finished ldconfig.service - Rebuild Dynamic Linker Cache. Sep 3 19:16:55.242867 systemd[1]: Starting systemd-update-done.service - Update is Completed... Sep 3 19:16:55.260646 systemd[1]: Finished systemd-update-done.service - Update is Completed. Sep 3 19:16:55.264356 systemd[1]: Reached target sysinit.target - System Initialization. Sep 3 19:16:55.267231 systemd[1]: Started motdgen.path - Watch for update engine configuration changes. Sep 3 19:16:55.271186 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 3 19:16:55.275312 systemd[1]: Started logrotate.timer - Daily rotation of log files. Sep 3 19:16:55.277131 systemd[1]: Started mdadm.timer - Weekly check for MD array's redundancy information.. Sep 3 19:16:55.281163 systemd[1]: Started systemd-sysupdate-reboot.timer - Reboot Automatically After System Update. Sep 3 19:16:55.283260 systemd[1]: Started systemd-sysupdate.timer - Automatic System Update. Sep 3 19:16:55.285042 systemd[1]: Started systemd-tmpfiles-clean.timer - Daily Cleanup of Temporary Directories. Sep 3 19:16:55.286979 systemd[1]: update-engine-stub.timer - Update Engine Stub Timer skipped, unmet condition check ConditionPathExists=/usr/.noupdate Sep 3 19:16:55.287014 systemd[1]: Reached target paths.target - Path Units. Sep 3 19:16:55.288441 systemd[1]: Reached target timers.target - Timer Units. Sep 3 19:16:55.300157 systemd[1]: Listening on dbus.socket - D-Bus System Message Bus Socket. Sep 3 19:16:55.305276 systemd[1]: Starting docker.socket - Docker Socket for the API... Sep 3 19:16:55.309675 systemd[1]: Listening on sshd-unix-local.socket - OpenSSH Server Socket (systemd-ssh-generator, AF_UNIX Local). Sep 3 19:16:55.313419 systemd[1]: Listening on sshd.socket - OpenSSH Server Socket. Sep 3 19:16:55.316511 systemd[1]: Listening on systemd-hostnamed.socket - Hostname Service Socket. Sep 3 19:16:55.320713 systemd[1]: Listening on systemd-logind-varlink.socket - User Login Management Varlink Socket. Sep 3 19:16:55.324379 systemd[1]: Listening on systemd-machined.socket - Virtual Machine and Container Registration Service Socket. Sep 3 19:16:55.327044 systemd[1]: Listening on docker.socket - Docker Socket for the API. Sep 3 19:16:55.330217 systemd[1]: Reached target sockets.target - Socket Units. Sep 3 19:16:55.333137 systemd[1]: Reached target basic.target - Basic System. Sep 3 19:16:55.334720 systemd[1]: addon-config@oem.service - Configure Addon /oem skipped, no trigger condition checks were met. Sep 3 19:16:55.334752 systemd[1]: addon-run@oem.service - Run Addon /oem skipped, no trigger condition checks were met. Sep 3 19:16:55.336381 systemd[1]: Starting chronyd.service - NTP client/server... Sep 3 19:16:55.339845 systemd[1]: Starting containerd.service - containerd container runtime... Sep 3 19:16:55.348539 systemd[1]: Starting dbus.service - D-Bus System Message Bus... Sep 3 19:16:55.350996 systemd[1]: Starting dracut-shutdown.service - Restore /run/initramfs on shutdown... Sep 3 19:16:55.357358 systemd[1]: Starting enable-oem-cloudinit.service - Enable cloudinit... Sep 3 19:16:55.362041 systemd[1]: Starting extend-filesystems.service - Extend Filesystems... Sep 3 19:16:55.369080 jq[2048]: true Sep 3 19:16:55.367625 systemd[1]: flatcar-setup-environment.service - Modifies /etc/environment for CoreOS skipped, unmet condition check ConditionPathExists=/oem/bin/flatcar-setup-environment Sep 3 19:16:55.369624 systemd[1]: Started hv_kvp_daemon.service - Hyper-V KVP daemon. Sep 3 19:16:55.373860 systemd[1]: hv_vss_daemon.service - Hyper-V VSS daemon skipped, unmet condition check ConditionPathExists=/dev/vmbus/hv_vss Sep 3 19:16:55.375291 systemd[1]: Starting motdgen.service - Generate /run/flatcar/motd... Sep 3 19:16:55.381882 systemd[1]: Starting nvidia.service - NVIDIA Configure Service... Sep 3 19:16:55.388219 systemd[1]: Starting ssh-key-proc-cmdline.service - Install an ssh key from /proc/cmdline... Sep 3 19:16:55.392361 KVP[2050]: KVP starting; pid is:2050 Sep 3 19:16:55.393264 systemd[1]: Starting sshd-keygen.service - Generate sshd host keys... Sep 3 19:16:55.398310 chronyd[2044]: chronyd version 4.8 starting (+CMDMON +REFCLOCK +RTC +PRIVDROP +SCFILTER -SIGND +NTS +SECHASH +IPV6 -DEBUG) Sep 3 19:16:55.401551 systemd[1]: Starting systemd-logind.service - User Login Management... Sep 3 19:16:55.406210 systemd[1]: tcsd.service - TCG Core Services Daemon skipped, unmet condition check ConditionPathExists=/dev/tpm0 Sep 3 19:16:55.408543 systemd[1]: Starting update-engine.service - Update Engine... Sep 3 19:16:55.413960 KVP[2050]: KVP LIC Version: 3.1 Sep 3 19:16:55.414071 kernel: hv_utils: KVP IC version 4.0 Sep 3 19:16:55.414607 systemd[1]: Starting update-ssh-keys-after-ignition.service - Run update-ssh-keys once after Ignition... Sep 3 19:16:55.424114 systemd[1]: Finished dracut-shutdown.service - Restore /run/initramfs on shutdown. Sep 3 19:16:55.431250 systemd[1]: ssh-key-proc-cmdline.service: Deactivated successfully. Sep 3 19:16:55.432179 systemd[1]: Finished ssh-key-proc-cmdline.service - Install an ssh key from /proc/cmdline. Sep 3 19:16:55.435416 jq[2061]: false Sep 3 19:16:55.436263 systemd[1]: update-ssh-keys-after-ignition.service: Skipped due to 'exec-condition'. Sep 3 19:16:55.436560 systemd[1]: Condition check resulted in update-ssh-keys-after-ignition.service - Run update-ssh-keys once after Ignition being skipped. Sep 3 19:16:55.440437 systemd[1]: sshkeys.service skipped, no trigger condition checks were met. Sep 3 19:16:55.451021 jq[2067]: true Sep 3 19:16:55.472440 systemctl[2081]: Created symlink '/etc/systemd/system/multi-user.target.wants/oem-cloudinit.service' → '/usr/lib/systemd/system/oem-cloudinit.service'. Sep 3 19:16:55.472551 systemd[1]: Reload requested from client PID 2081 ('systemctl') (unit enable-oem-cloudinit.service)... Sep 3 19:16:55.472559 systemd[1]: Reloading... Sep 3 19:16:55.488242 extend-filesystems[2049]: Found /dev/sda6 Sep 3 19:16:55.511288 chronyd[2044]: Timezone right/UTC failed leap second check, ignoring Sep 3 19:16:55.511524 chronyd[2044]: Loaded seccomp filter (level 2) Sep 3 19:16:55.514167 motdgen[2108]: /oem/oem-release: line 2: Azure: command not found Sep 3 19:16:55.530015 systemd-logind[2058]: New seat seat0. Sep 3 19:16:55.533297 extend-filesystems[2049]: Found /dev/sda9 Sep 3 19:16:55.555237 extend-filesystems[2049]: Checking size of /dev/sda9 Sep 3 19:16:55.546623 systemd-logind[2058]: Watching system buttons on /dev/input/event1 (AT Translated Set 2 keyboard) Sep 3 19:16:55.575606 update_engine[2060]: I20260903 19:16:55.564965 2060 main.cc:92] Flatcar Update Engine starting Sep 3 19:16:55.586965 sshd_keygen[2068]: ssh-keygen: generating new host keys: RSA ECDSA ED25519 MLDSA44-ED25519 Sep 3 19:16:55.597111 zram_generator::config[2143]: No configuration found. Sep 3 19:16:55.609192 extend-filesystems[2049]: Resized partition /dev/sda9 Sep 3 19:16:55.625114 extend-filesystems[2181]: resize2fs 1.47.4 (6-Mar-2025) Sep 3 19:16:55.641514 kernel: EXT4-fs (sda9): resizing filesystem from 6359552 to 6376955 blocks Sep 3 19:16:55.641593 kernel: EXT4-fs (sda9): resized filesystem to 6376955 Sep 3 19:16:55.702479 dbus-daemon[2046]: [system] SELinux support is enabled Sep 3 19:16:55.708947 extend-filesystems[2181]: Filesystem at /dev/sda9 is mounted on /; on-line resizing required Sep 3 19:16:55.708947 extend-filesystems[2181]: old_desc_blocks = 4, new_desc_blocks = 4 Sep 3 19:16:55.708947 extend-filesystems[2181]: The filesystem on /dev/sda9 is now 6376955 (4k) blocks long. Sep 3 19:16:55.730022 extend-filesystems[2049]: Resized filesystem in /dev/sda9 Sep 3 19:16:55.734350 update_engine[2060]: I20260903 19:16:55.716966 2060 update_check_scheduler.cc:74] Next update check in 3m23s Sep 3 19:16:55.893060 systemd[1]: Reloading finished in 420 ms. Sep 3 19:16:55.909522 systemd[1]: Started chronyd.service - NTP client/server. Sep 3 19:16:55.913416 systemd[1]: Started systemd-logind.service - User Login Management. Sep 3 19:16:55.916405 systemd[1]: Started dbus.service - D-Bus System Message Bus. Sep 3 19:16:55.922643 dbus-daemon[2046]: [system] Successfully activated service 'org.freedesktop.systemd1' Sep 3 19:16:55.923549 systemd[1]: extend-filesystems.service: Deactivated successfully. Sep 3 19:16:55.923758 systemd[1]: Finished extend-filesystems.service - Extend Filesystems. Sep 3 19:16:55.929500 systemd[1]: motdgen.service: Deactivated successfully. Sep 3 19:16:55.931187 systemd[1]: Finished motdgen.service - Generate /run/flatcar/motd. Sep 3 19:16:55.935551 systemd[1]: Finished nvidia.service - NVIDIA Configure Service. Sep 3 19:16:55.937636 systemd[1]: Finished sshd-keygen.service - Generate sshd host keys. Sep 3 19:16:55.970840 systemd[1]: Started update-engine.service - Update Engine. Sep 3 19:16:55.974356 systemd[1]: Starting issuegen.service - Generate /run/issue... Sep 3 19:16:55.976676 systemd[1]: Starting oem-cloudinit.service - Run cloudinit... Sep 3 19:16:55.980315 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 3 19:16:55.980505 systemd[1]: Reached target system-config.target - Load system-provided cloud configs. Sep 3 19:16:55.982714 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 3 19:16:55.982853 systemd[1]: Reached target user-config.target - Load user-provided cloud configs. Sep 3 19:16:55.987242 systemd[1]: Starting waagent.service - Microsoft Azure Linux Agent... Sep 3 19:16:55.993085 systemd[1]: Started locksmithd.service - Cluster reboot manager. Sep 3 19:16:56.001853 bash[2290]: + case azure in Sep 3 19:16:56.001853 bash[2290]: + true Sep 3 19:16:56.010561 systemd[1]: issuegen.service: Deactivated successfully. Sep 3 19:16:56.013748 systemd[1]: Finished issuegen.service - Generate /run/issue. Sep 3 19:16:56.019591 systemd[1]: Starting systemd-user-sessions.service - Permit User Sessions... Sep 3 19:16:56.023471 bash[2303]: ++ case azure in Sep 3 19:16:56.023471 bash[2303]: ++ printf /bin/bash azure Sep 3 19:16:56.023754 bash[2297]: + exec coreos-cloudinit --oem=/bin/bash Sep 3 19:16:56.027703 systemd[1]: Started waagent.service - Microsoft Azure Linux Agent. Sep 3 19:16:56.041531 systemd[1]: Finished systemd-user-sessions.service - Permit User Sessions. Sep 3 19:16:56.047460 systemd[1]: Started getty@tty1.service - Getty on tty1. Sep 3 19:16:56.052030 systemd[1]: Started serial-getty@ttyAMA0.service - Serial Getty on ttyAMA0. Sep 3 19:16:56.056375 systemd[1]: Reached target getty.target - Login Prompts. Sep 3 19:16:56.274208 bash[2297]: Invalid option to -oem: "/bin/bash". Supported options: ["azure" "cloudsigma" "vmware" "digitalocean" "ec2-compat" "gce"] Sep 3 19:16:56.275317 systemd[1]: oem-cloudinit.service: Main process exited, code=exited, status=2/INVALIDARGUMENT Sep 3 19:16:56.275408 systemd[1]: oem-cloudinit.service: Failed with result 'exit-code'. Sep 3 19:16:56.275746 systemd[1]: Failed to start oem-cloudinit.service - Run cloudinit. Sep 3 19:16:56.279353 systemctl[2081]: Job for oem-cloudinit.service failed because the control process exited with error code. Sep 3 19:16:56.279360 systemctl[2081]: See "systemctl status oem-cloudinit.service" and "journalctl -xeu oem-cloudinit.service" for details. Sep 3 19:16:56.281010 systemd[1]: enable-oem-cloudinit.service: Main process exited, code=exited, status=1/FAILURE Sep 3 19:16:56.281500 systemd[1]: enable-oem-cloudinit.service: Failed with result 'exit-code'. Sep 3 19:16:56.283109 systemd[1]: Failed to start enable-oem-cloudinit.service - Enable cloudinit. Sep 3 19:16:56.393118 locksmithd[2292]: locksmithd starting currentOperation="UPDATE_STATUS_IDLE" strategy="reboot" Sep 3 19:16:59.209448 containerd[2283]: time="2026-09-03T19:16:59Z" 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 3 19:16:59.210407 containerd[2283]: time="2026-09-03T19:16:59Z" level=warning msg="Configuration migrated from version 2, use `containerd config migrate` to avoid migration" t="21.12µs" Sep 3 19:16:59.214488 containerd[2283]: time="2026-09-03T19:16:59.214450084Z" level=info msg="starting containerd" revision=aad11006b869517fcd3009450b6f82da282e1a9b version=v2.3.3 Sep 3 19:16:59.214703 containerd[2283]: time="2026-09-03T19:16:59.214672508Z" level=info msg="loading plugin" id=io.containerd.content.v1.content type=io.containerd.content.v1 Sep 3 19:16:59.214886 containerd[2283]: time="2026-09-03T19:16:59.214835852Z" 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 3 19:16:59.214886 containerd[2283]: time="2026-09-03T19:16:59.214854996Z" level=info msg="loading plugin" id=io.containerd.image-verifier.v1.bindir type=io.containerd.image-verifier.v1 Sep 3 19:16:59.214886 containerd[2283]: time="2026-09-03T19:16:59.214863644Z" level=info msg="loading plugin" id=io.containerd.internal.v1.opt type=io.containerd.internal.v1 Sep 3 19:16:59.214985 containerd[2283]: time="2026-09-03T19:16:59.214957772Z" level=info msg="loading plugin" id=io.containerd.warning.v1.deprecations type=io.containerd.warning.v1 Sep 3 19:16:59.214985 containerd[2283]: time="2026-09-03T19:16:59.214966692Z" level=info msg="loading plugin" id=io.containerd.event.v1.exchange type=io.containerd.event.v1 Sep 3 19:16:59.215400 containerd[2283]: time="2026-09-03T19:16:59.215173636Z" level=info msg="loading plugin" id=io.containerd.mount-handler.v1.erofs type=io.containerd.mount-handler.v1 Sep 3 19:16:59.215400 containerd[2283]: time="2026-09-03T19:16:59.215189636Z" level=info msg="loading plugin" id=io.containerd.snapshotter.v1.blockfile type=io.containerd.snapshotter.v1 Sep 3 19:16:59.215400 containerd[2283]: time="2026-09-03T19:16:59.215259124Z" 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 3 19:16:59.215400 containerd[2283]: time="2026-09-03T19:16:59.215266900Z" level=info msg="loading plugin" id=io.containerd.snapshotter.v1.btrfs type=io.containerd.snapshotter.v1 Sep 3 19:16:59.215400 containerd[2283]: time="2026-09-03T19:16:59.215391284Z" 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 3 19:16:59.215400 containerd[2283]: time="2026-09-03T19:16:59.215400516Z" level=info msg="loading plugin" id=io.containerd.snapshotter.v1.devmapper type=io.containerd.snapshotter.v1 Sep 3 19:16:59.215507 containerd[2283]: time="2026-09-03T19:16:59.215414884Z" level=info msg="skip loading plugin" error="devmapper not configured: skip plugin" id=io.containerd.snapshotter.v1.devmapper type=io.containerd.snapshotter.v1 Sep 3 19:16:59.215507 containerd[2283]: time="2026-09-03T19:16:59.215419588Z" level=info msg="loading plugin" id=io.containerd.snapshotter.v1.erofs type=io.containerd.snapshotter.v1 Sep 3 19:16:59.215568 containerd[2283]: time="2026-09-03T19:16:59.215543572Z" level=info msg="loading plugin" id=io.containerd.snapshotter.v1.native type=io.containerd.snapshotter.v1 Sep 3 19:16:59.215663 containerd[2283]: time="2026-09-03T19:16:59.215613500Z" level=info msg="loading plugin" id=io.containerd.snapshotter.v1.overlayfs type=io.containerd.snapshotter.v1 Sep 3 19:16:59.215781 containerd[2283]: time="2026-09-03T19:16:59.215762300Z" level=info msg="loading plugin" id=io.containerd.snapshotter.v1.zfs type=io.containerd.snapshotter.v1 Sep 3 19:16:59.215809 containerd[2283]: time="2026-09-03T19:16:59.215787148Z" 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 3 19:16:59.215809 containerd[2283]: time="2026-09-03T19:16:59.215794860Z" level=info msg="loading plugin" id=io.containerd.monitor.task.v1.cgroups type=io.containerd.monitor.task.v1 Sep 3 19:16:59.216341 containerd[2283]: time="2026-09-03T19:16:59.216319860Z" level=info msg="loading plugin" id=io.containerd.metadata.v1.bolt type=io.containerd.metadata.v1 Sep 3 19:16:59.216423 containerd[2283]: time="2026-09-03T19:16:59.216402372Z" level=info msg="metadata content store policy set" policy=shared Sep 3 19:16:59.332987 containerd[2283]: time="2026-09-03T19:16:59.332922252Z" level=info msg="loading plugin" id=io.containerd.gc.v1.scheduler type=io.containerd.gc.v1 Sep 3 19:16:59.333109 containerd[2283]: time="2026-09-03T19:16:59.333016500Z" level=info msg="loading plugin" id=io.containerd.server.v1.metrics type=io.containerd.server.v1 Sep 3 19:16:59.333109 containerd[2283]: time="2026-09-03T19:16:59.333025836Z" level=info msg="skip loading plugin" error="skip plugin" id=io.containerd.server.v1.metrics type=io.containerd.server.v1 Sep 3 19:16:59.333109 containerd[2283]: time="2026-09-03T19:16:59.333032316Z" level=info msg="loading plugin" id=io.containerd.tracing.processor.v1.otlp type=io.containerd.tracing.processor.v1 Sep 3 19:16:59.333109 containerd[2283]: time="2026-09-03T19:16:59.333043068Z" 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 3 19:16:59.333109 containerd[2283]: time="2026-09-03T19:16:59.333048916Z" level=info msg="loading plugin" id=io.containerd.internal.v1.tracing type=io.containerd.internal.v1 Sep 3 19:16:59.333109 containerd[2283]: time="2026-09-03T19:16:59.333059644Z" 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 3 19:16:59.333109 containerd[2283]: time="2026-09-03T19:16:59.333089436Z" level=info msg="loading plugin" id=io.containerd.nri.v1.nri type=io.containerd.nri.v1 Sep 3 19:16:59.402229 containerd[2283]: time="2026-09-03T19:16:59.401965492Z" level=info msg="built-in NRI default validator is disabled" Sep 3 19:16:59.402229 containerd[2283]: time="2026-09-03T19:16:59.402013524Z" level=info msg="runtime interface created" Sep 3 19:16:59.402229 containerd[2283]: time="2026-09-03T19:16:59.402018948Z" level=info msg="created NRI interface" Sep 3 19:16:59.402229 containerd[2283]: time="2026-09-03T19:16:59.402031540Z" level=info msg="loading plugin" id=io.containerd.ttrpc.v1.otelttrpc type=io.containerd.ttrpc.v1 Sep 3 19:16:59.402229 containerd[2283]: time="2026-09-03T19:16:59.402047468Z" level=info msg="loading plugin" id=io.containerd.service.v1.containers-service type=io.containerd.service.v1 Sep 3 19:16:59.402229 containerd[2283]: time="2026-09-03T19:16:59.402059204Z" level=info msg="loading plugin" id=io.containerd.service.v1.content-service type=io.containerd.service.v1 Sep 3 19:16:59.402229 containerd[2283]: time="2026-09-03T19:16:59.402081300Z" level=info msg="loading plugin" id=io.containerd.differ.v1.erofs type=io.containerd.differ.v1 Sep 3 19:16:59.483337 containerd[2283]: time="2026-09-03T19:16:59.482674308Z" level=info msg="loading plugin" id=io.containerd.mount-manager.v1.bolt type=io.containerd.mount-manager.v1 Sep 3 19:16:59.483337 containerd[2283]: time="2026-09-03T19:16:59.482879268Z" level=info msg="loading plugin" id=io.containerd.differ.v1.walking type=io.containerd.differ.v1 Sep 3 19:16:59.483337 containerd[2283]: time="2026-09-03T19:16:59.482892748Z" level=info msg="loading plugin" id=io.containerd.service.v1.diff-service type=io.containerd.service.v1 Sep 3 19:16:59.483337 containerd[2283]: time="2026-09-03T19:16:59.482901012Z" level=info msg="loading plugin" id=io.containerd.service.v1.images-service type=io.containerd.service.v1 Sep 3 19:16:59.483337 containerd[2283]: time="2026-09-03T19:16:59.482911052Z" level=info msg="loading plugin" id=io.containerd.service.v1.introspection-service type=io.containerd.service.v1 Sep 3 19:16:59.483337 containerd[2283]: time="2026-09-03T19:16:59.482917436Z" level=info msg="loading plugin" id=io.containerd.service.v1.namespaces-service type=io.containerd.service.v1 Sep 3 19:16:59.483337 containerd[2283]: time="2026-09-03T19:16:59.482923884Z" level=info msg="loading plugin" id=io.containerd.service.v1.snapshots-service type=io.containerd.service.v1 Sep 3 19:16:59.483337 containerd[2283]: time="2026-09-03T19:16:59.482929700Z" level=info msg="loading plugin" id=io.containerd.shim.v1.manager type=io.containerd.shim.v1 Sep 3 19:16:59.483337 containerd[2283]: time="2026-09-03T19:16:59.482938292Z" level=info msg="loading plugin" id=io.containerd.runtime.v2.task type=io.containerd.runtime.v2 Sep 3 19:16:59.483337 containerd[2283]: time="2026-09-03T19:16:59.483059372Z" level=info msg="loading plugin" id=io.containerd.service.v1.tasks-service type=io.containerd.service.v1 Sep 3 19:16:59.483337 containerd[2283]: time="2026-09-03T19:16:59.483093388Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.containers type=io.containerd.grpc.v1 Sep 3 19:16:59.483337 containerd[2283]: time="2026-09-03T19:16:59.483100820Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.content type=io.containerd.grpc.v1 Sep 3 19:16:59.483337 containerd[2283]: time="2026-09-03T19:16:59.483106188Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.diff type=io.containerd.grpc.v1 Sep 3 19:16:59.483337 containerd[2283]: time="2026-09-03T19:16:59.483112116Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.events type=io.containerd.grpc.v1 Sep 3 19:16:59.483591 containerd[2283]: time="2026-09-03T19:16:59.483116932Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.images type=io.containerd.grpc.v1 Sep 3 19:16:59.483591 containerd[2283]: time="2026-09-03T19:16:59.483122524Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.introspection type=io.containerd.grpc.v1 Sep 3 19:16:59.483591 containerd[2283]: time="2026-09-03T19:16:59.483127892Z" level=info msg="loading plugin" id=io.containerd.lease.v1.manager type=io.containerd.lease.v1 Sep 3 19:16:59.483591 containerd[2283]: time="2026-09-03T19:16:59.483134564Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.leases type=io.containerd.grpc.v1 Sep 3 19:16:59.483591 containerd[2283]: time="2026-09-03T19:16:59.483141516Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.mounts type=io.containerd.grpc.v1 Sep 3 19:16:59.483591 containerd[2283]: time="2026-09-03T19:16:59.483146356Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.namespaces type=io.containerd.grpc.v1 Sep 3 19:16:59.483591 containerd[2283]: time="2026-09-03T19:16:59.483153580Z" level=info msg="loading plugin" id=io.containerd.sandbox.store.v1.local type=io.containerd.sandbox.store.v1 Sep 3 19:16:59.483591 containerd[2283]: time="2026-09-03T19:16:59.483158468Z" level=info msg="loading plugin" id=io.containerd.transfer.v1.local type=io.containerd.transfer.v1 Sep 3 19:16:59.483591 containerd[2283]: time="2026-09-03T19:16:59.483190620Z" level=info msg="loading plugin" id=io.containerd.cri.v1.images type=io.containerd.cri.v1 Sep 3 19:16:59.483908 containerd[2283]: time="2026-09-03T19:16:59.483854612Z" level=info msg="Get image filesystem path \"/var/lib/containerd/io.containerd.snapshotter.v1.overlayfs\" for snapshotter \"overlayfs\"" Sep 3 19:16:59.483990 containerd[2283]: time="2026-09-03T19:16:59.483976196Z" level=info msg="Start snapshots syncer" Sep 3 19:16:59.484044 containerd[2283]: time="2026-09-03T19:16:59.484031852Z" level=info msg="loading plugin" id=io.containerd.cri.v1.runtime type=io.containerd.cri.v1 Sep 3 19:16:59.484369 containerd[2283]: time="2026-09-03T19:16:59.484333596Z" 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 3 19:16:59.484651 containerd[2283]: time="2026-09-03T19:16:59.484601460Z" level=info msg="loading plugin" id=io.containerd.podsandbox.controller.v1.podsandbox type=io.containerd.podsandbox.controller.v1 Sep 3 19:16:59.484742 containerd[2283]: time="2026-09-03T19:16:59.484718852Z" level=info msg="loading plugin" id=io.containerd.sandbox.controller.v1.shim type=io.containerd.sandbox.controller.v1 Sep 3 19:16:59.484928 containerd[2283]: time="2026-09-03T19:16:59.484859124Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.sandbox-controllers type=io.containerd.grpc.v1 Sep 3 19:16:59.484928 containerd[2283]: time="2026-09-03T19:16:59.484898500Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.sandboxes type=io.containerd.grpc.v1 Sep 3 19:16:59.484928 containerd[2283]: time="2026-09-03T19:16:59.484905892Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.snapshots type=io.containerd.grpc.v1 Sep 3 19:16:59.484928 containerd[2283]: time="2026-09-03T19:16:59.484914860Z" level=info msg="loading plugin" id=io.containerd.streaming.v1.manager type=io.containerd.streaming.v1 Sep 3 19:16:59.484928 containerd[2283]: time="2026-09-03T19:16:59.484922068Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.streaming type=io.containerd.grpc.v1 Sep 3 19:16:59.484928 containerd[2283]: time="2026-09-03T19:16:59.484927812Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.tasks type=io.containerd.grpc.v1 Sep 3 19:16:59.485031 containerd[2283]: time="2026-09-03T19:16:59.484933308Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.transfer type=io.containerd.grpc.v1 Sep 3 19:16:59.485031 containerd[2283]: time="2026-09-03T19:16:59.484940988Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.version type=io.containerd.grpc.v1 Sep 3 19:16:59.485031 containerd[2283]: time="2026-09-03T19:16:59.484945788Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.healthcheck type=io.containerd.grpc.v1 Sep 3 19:16:59.485031 containerd[2283]: time="2026-09-03T19:16:59.484952276Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.cri type=io.containerd.grpc.v1 Sep 3 19:16:59.485031 containerd[2283]: time="2026-09-03T19:16:59.484964268Z" level=info msg="Connect containerd service" Sep 3 19:16:59.485031 containerd[2283]: time="2026-09-03T19:16:59.484982172Z" level=info msg="using experimental NRI integration - disable nri plugin to prevent this" Sep 3 19:16:59.486009 containerd[2283]: time="2026-09-03T19:16:59.485983580Z" 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 3 19:17:00.705684 containerd[2283]: time="2026-09-03T19:17:00.705633780Z" level=info msg="loading plugin" id=io.containerd.server.v1.ttrpc type=io.containerd.server.v1 Sep 3 19:17:00.706023 containerd[2283]: time="2026-09-03T19:17:00.705731148Z" level=info msg="loading plugin" id=io.containerd.monitor.container.v1.restart type=io.containerd.monitor.container.v1 Sep 3 19:17:00.706023 containerd[2283]: time="2026-09-03T19:17:00.705783980Z" level=info msg="loading plugin" id=io.containerd.metrics.v1.grpc-prometheus type=io.containerd.metrics.v1 Sep 3 19:17:00.706023 containerd[2283]: time="2026-09-03T19:17:00.705817180Z" level=info msg="loading plugin" id=io.containerd.metrics.v1.grpc-otel type=io.containerd.metrics.v1 Sep 3 19:17:00.706023 containerd[2283]: time="2026-09-03T19:17:00.705849100Z" level=info msg="loading plugin" id=io.containerd.server.v1.grpc type=io.containerd.server.v1 Sep 3 19:17:00.706398 containerd[2283]: time="2026-09-03T19:17:00.706169276Z" level=info msg="Start subscribing containerd event" Sep 3 19:17:00.706398 containerd[2283]: time="2026-09-03T19:17:00.706224908Z" level=info msg="Start stats collector" Sep 3 19:17:00.706398 containerd[2283]: time="2026-09-03T19:17:00.706231324Z" level=info msg="Start recovering state" Sep 3 19:17:00.707202 containerd[2283]: time="2026-09-03T19:17:00.706948668Z" level=info msg="Start event monitor" Sep 3 19:17:00.707202 containerd[2283]: time="2026-09-03T19:17:00.706974084Z" level=info msg="Start cni network conf syncer for default" Sep 3 19:17:00.707202 containerd[2283]: time="2026-09-03T19:17:00.706986180Z" level=info msg="Start streaming server" Sep 3 19:17:00.707202 containerd[2283]: time="2026-09-03T19:17:00.706993556Z" level=info msg="Registered namespace \"k8s.io\" with NRI" Sep 3 19:17:00.707202 containerd[2283]: time="2026-09-03T19:17:00.706999540Z" level=info msg="runtime interface starting up..." Sep 3 19:17:00.707202 containerd[2283]: time="2026-09-03T19:17:00.707006836Z" level=info msg="starting plugins..." Sep 3 19:17:00.707202 containerd[2283]: time="2026-09-03T19:17:00.707104780Z" level=info msg="Synchronizing NRI (plugin) with current runtime state" Sep 3 19:17:00.734539 containerd[2283]: time="2026-09-03T19:17:00.734491868Z" level=info msg="loading plugin" id=io.containerd.server.v1.grpc-tcp type=io.containerd.server.v1 Sep 3 19:17:00.734539 containerd[2283]: time="2026-09-03T19:17:00.734536812Z" level=info msg="skip loading plugin" error="skip plugin" id=io.containerd.server.v1.grpc-tcp type=io.containerd.server.v1 Sep 3 19:17:00.734539 containerd[2283]: time="2026-09-03T19:17:00.734544196Z" level=info msg="loading plugin" id=io.containerd.http.v1.pprof type=io.containerd.http.v1 Sep 3 19:17:00.734645 containerd[2283]: time="2026-09-03T19:17:00.734580692Z" level=info msg="loading plugin" id=io.containerd.server.v1.debug type=io.containerd.server.v1 Sep 3 19:17:00.734645 containerd[2283]: time="2026-09-03T19:17:00.734586884Z" level=info msg="skip loading plugin" error="skip plugin" id=io.containerd.server.v1.debug type=io.containerd.server.v1 Sep 3 19:17:00.734689 containerd[2283]: time="2026-09-03T19:17:00.734665260Z" level=info msg=serving... address=/run/containerd/containerd.sock.ttrpc Sep 3 19:17:00.734689 containerd[2283]: time="2026-09-03T19:17:00.734674788Z" level=info msg="starting GRPC server" address=/run/containerd/containerd.sock gid=0 uid=0 Sep 3 19:17:00.734759 containerd[2283]: time="2026-09-03T19:17:00.734697484Z" level=info msg=serving... address=/run/containerd/containerd.sock Sep 3 19:17:00.734759 containerd[2283]: time="2026-09-03T19:17:00.734743684Z" level=info msg="containerd successfully booted in 1.526019s" Sep 3 19:17:00.735023 systemd[1]: Started containerd.service - containerd container runtime. Sep 3 19:17:00.737320 systemd[1]: Reached target multi-user.target - Multi-User System. Sep 3 19:17:00.742817 systemd[1]: Startup finished in 2.771s (kernel) + 15.617s (initrd) + 22.196s (userspace) = 40.584s. Sep 3 19:17:01.493515 waagent[2305]: 2026-09-03T19:17:01.489295Z INFO Daemon Daemon Azure Linux Agent Version: 2.12.0.4 Sep 3 19:17:01.494205 waagent[2305]: 2026-09-03T19:17:01.494158Z INFO Daemon Daemon OS: flatcar 9999.0.0 Sep 3 19:17:01.497985 waagent[2305]: 2026-09-03T19:17:01.497945Z INFO Daemon Daemon Python: 3.13.14 Sep 3 19:17:01.501658 waagent[2305]: 2026-09-03T19:17:01.501616Z INFO Daemon Daemon Run daemon Sep 3 19:17:01.505113 waagent[2305]: 2026-09-03T19:17:01.505076Z INFO Daemon Daemon No RDMA handler exists for distro='Flatcar Container Linux by Kinvolk' version='9999.0.0' Sep 3 19:17:01.512135 waagent[2305]: 2026-09-03T19:17:01.512098Z INFO Daemon Daemon Using waagent for provisioning Sep 3 19:17:01.516136 waagent[2305]: 2026-09-03T19:17:01.516100Z INFO Daemon Daemon Activate resource disk Sep 3 19:17:01.519523 waagent[2305]: 2026-09-03T19:17:01.519482Z INFO Daemon Daemon Searching gen1 prefix 00000000-0001 or gen2 f8b3781a-1e82-4818-a1c3-63d806ec15bb Sep 3 19:17:01.528029 waagent[2305]: 2026-09-03T19:17:01.527985Z INFO Daemon Daemon Found device: None Sep 3 19:17:01.531704 waagent[2305]: 2026-09-03T19:17:01.531658Z ERROR Daemon Daemon Failed to mount resource disk [ResourceDiskError] unable to detect disk topology Sep 3 19:17:01.537431 waagent[2305]: 2026-09-03T19:17:01.537384Z ERROR Daemon Daemon Event: name=WALinuxAgent, op=ActivateResourceDisk, message=[ResourceDiskError] unable to detect disk topology, duration=0 Sep 3 19:17:01.546018 waagent[2305]: 2026-09-03T19:17:01.545968Z INFO Daemon Daemon Clean protocol and wireserver endpoint Sep 3 19:17:01.550693 waagent[2305]: 2026-09-03T19:17:01.550654Z INFO Daemon Daemon Running default provisioning handler Sep 3 19:17:01.559474 waagent[2305]: 2026-09-03T19:17:01.559439Z 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 3 19:17:01.564218 waagent[2305]: 2026-09-03T19:17:01.564183Z INFO Daemon Daemon Unable to get cloud-init enabled status from service: [Errno 2] No such file or directory: 'service' Sep 3 19:17:01.564480 waagent[2305]: 2026-09-03T19:17:01.564447Z INFO Daemon Daemon cloud-init is enabled: False Sep 3 19:17:01.564704 waagent[2305]: 2026-09-03T19:17:01.564674Z INFO Daemon Daemon Copying ovf-env.xml Sep 3 19:17:01.675899 waagent[2305]: 2026-09-03T19:17:01.675821Z INFO Daemon Daemon Successfully mounted dvd Sep 3 19:17:01.724552 login[2308]: pam_unix(login:session): session opened for user core(uid=500) by core(uid=0) Sep 3 19:17:01.724554 login[2309]: pam_unix(login:session): session opened for user core(uid=500) by core(uid=0) Sep 3 19:17:01.729581 systemd[1]: mnt-cdrom-secure.mount: Deactivated successfully. Sep 3 19:17:01.730720 waagent[2305]: 2026-09-03T19:17:01.730668Z INFO Daemon Daemon Detect protocol endpoint Sep 3 19:17:01.734534 waagent[2305]: 2026-09-03T19:17:01.734491Z INFO Daemon Daemon Clean protocol and wireserver endpoint Sep 3 19:17:01.734605 systemd[1]: Created slice user-500.slice - User Slice of UID 500. Sep 3 19:17:01.737235 systemd[1]: Starting user-runtime-dir@500.service - User Runtime Directory /run/user/500... Sep 3 19:17:01.739848 waagent[2305]: 2026-09-03T19:17:01.739777Z INFO Daemon Daemon WireServer endpoint is not found. Rerun dhcp handler Sep 3 19:17:01.746625 systemd-logind[2058]: New session '1' of user 'core' with class 'user-light' and type 'tty'. Sep 3 19:17:01.750263 waagent[2305]: 2026-09-03T19:17:01.748595Z INFO Daemon Daemon Test for route to 168.63.129.16 Sep 3 19:17:01.751518 waagent[2305]: 2026-09-03T19:17:01.751476Z INFO Daemon Daemon Route to 168.63.129.16 exists Sep 3 19:17:01.756623 systemd-logind[2058]: New session '2' of user 'core' with class 'user-light' and type 'tty'. Sep 3 19:17:01.757538 waagent[2305]: 2026-09-03T19:17:01.757495Z INFO Daemon Daemon Wire server endpoint:168.63.129.16 Sep 3 19:17:01.782157 systemd[1]: Finished user-runtime-dir@500.service - User Runtime Directory /run/user/500. Sep 3 19:17:01.788363 systemd[1]: Started session-1.scope - Session 1 of User core. Sep 3 19:17:01.789788 systemd[1]: Started session-2.scope - Session 2 of User core. Sep 3 19:17:01.809919 login[2308]: pam_lastlog(login:session): file /var/log/lastlog is locked/read, retrying Sep 3 19:17:01.810249 waagent[2305]: 2026-09-03T19:17:01.810210Z INFO Daemon Daemon Fabric preferred wire protocol version:2015-04-05 Sep 3 19:17:01.815611 waagent[2305]: 2026-09-03T19:17:01.815581Z INFO Daemon Daemon Wire protocol version:2012-11-30 Sep 3 19:17:01.820553 waagent[2305]: 2026-09-03T19:17:01.819470Z INFO Daemon Daemon Server preferred version:2015-04-05 Sep 3 19:17:01.932939 waagent[2305]: 2026-09-03T19:17:01.932847Z INFO Daemon Daemon Initializing goal state during protocol detection Sep 3 19:17:01.938042 waagent[2305]: 2026-09-03T19:17:01.937974Z INFO Daemon Daemon Forcing an update of the goal state. Sep 3 19:17:01.949104 waagent[2305]: 2026-09-03T19:17:01.949017Z INFO Daemon Fetched a new incarnation for the WireServer goal state [incarnation 1] Sep 3 19:17:01.975346 waagent[2305]: 2026-09-03T19:17:01.974913Z INFO Daemon Daemon HostGAPlugin version: 1.0.8.184 Sep 3 19:17:01.979893 waagent[2305]: 2026-09-03T19:17:01.979849Z INFO Daemon Sep 3 19:17:01.982369 waagent[2305]: 2026-09-03T19:17:01.982322Z INFO Daemon Fetched new vmSettings [HostGAPlugin correlation ID: 12d1591b-1e00-4837-bef3-77034fd0f939 eTag: 6960583011332760899 source: Fabric] Sep 3 19:17:01.990998 waagent[2305]: 2026-09-03T19:17:01.990955Z INFO Daemon The vmSettings originated via Fabric; will ignore them. Sep 3 19:17:01.996261 waagent[2305]: 2026-09-03T19:17:01.995782Z INFO Daemon Sep 3 19:17:01.998104 waagent[2305]: 2026-09-03T19:17:01.998009Z INFO Daemon Fetching full goal state from the WireServer [incarnation 1] Sep 3 19:17:02.040839 waagent[2305]: 2026-09-03T19:17:02.040786Z INFO Daemon Daemon Downloading artifacts profile blob Sep 3 19:17:02.145850 waagent[2305]: 2026-09-03T19:17:02.143125Z INFO Daemon Downloaded certificate {'thumbprint': '516D7BCDF6902445A024604646A8E0227631CB52', 'hasPrivateKey': True} Sep 3 19:17:02.146403 waagent[2305]: 2026-09-03T19:17:02.146364Z INFO Daemon Fetch goal state completed Sep 3 19:17:02.153523 waagent[2305]: 2026-09-03T19:17:02.153491Z INFO Daemon Daemon Starting provisioning Sep 3 19:17:02.155229 waagent[2305]: 2026-09-03T19:17:02.155180Z INFO Daemon Daemon Handle ovf-env.xml. Sep 3 19:17:02.156643 waagent[2305]: 2026-09-03T19:17:02.156605Z INFO Daemon Daemon Set hostname [ci-9999.0.0-i-95488032b5] Sep 3 19:17:02.174488 waagent[2305]: 2026-09-03T19:17:02.174426Z INFO Daemon Daemon Publish hostname [ci-9999.0.0-i-95488032b5] Sep 3 19:17:02.179228 waagent[2305]: 2026-09-03T19:17:02.179186Z INFO Daemon Daemon Examine /proc/net/route for primary interface Sep 3 19:17:02.183869 waagent[2305]: 2026-09-03T19:17:02.183830Z INFO Daemon Daemon Primary interface is [eth0] Sep 3 19:17:02.194077 systemd-networkd[1811]: eth0: Reconfiguring with /usr/lib/systemd/network/zz-default.network. Sep 3 19:17:02.194112 systemd-networkd[1811]: eth0: DHCP lease lost Sep 3 19:17:02.210350 waagent[2305]: 2026-09-03T19:17:02.210281Z INFO Daemon Daemon Create user account if not exists Sep 3 19:17:02.213853 waagent[2305]: 2026-09-03T19:17:02.213795Z INFO Daemon Daemon User core already exists, skip useradd Sep 3 19:17:02.218250 waagent[2305]: 2026-09-03T19:17:02.218197Z INFO Daemon Daemon Configure sudoer Sep 3 19:17:02.222210 waagent[2305]: 2026-09-03T19:17:02.222166Z INFO Daemon Daemon Configure sshd Sep 3 19:17:02.225568 waagent[2305]: 2026-09-03T19:17:02.225520Z INFO Daemon Daemon Added a configuration snippet disabling SSH password-based authentication methods. It also configures SSH client probing to keep connections alive. Sep 3 19:17:02.234385 waagent[2305]: 2026-09-03T19:17:02.234337Z INFO Daemon Daemon Deploy ssh public key. Sep 3 19:17:02.240146 systemd-networkd[1811]: eth0: DHCPv4 address 10.0.0.5/24, gateway 10.0.0.1 acquired from 168.63.129.16 Sep 3 19:17:02.276135 waagent[2305]: 2026-09-03T19:17:02.275261Z INFO Daemon Daemon Decode custom data Sep 3 19:17:02.278640 waagent[2305]: 2026-09-03T19:17:02.278598Z INFO Daemon Daemon Save custom data Sep 3 19:17:03.337266 waagent[2305]: 2026-09-03T19:17:03.337207Z INFO Daemon Daemon Provisioning complete Sep 3 19:17:03.351643 waagent[2305]: 2026-09-03T19:17:03.351601Z INFO Daemon Daemon RDMA capabilities are not enabled, skipping Sep 3 19:17:03.355856 waagent[2305]: 2026-09-03T19:17:03.355812Z INFO Daemon Daemon End of log to /dev/console. The agent will now check for updates and then will process extensions. Sep 3 19:17:03.362243 waagent[2305]: 2026-09-03T19:17:03.362200Z INFO Daemon Daemon Installed Agent WALinuxAgent-2.12.0.4 is the most current agent Sep 3 19:17:03.460729 waagent[2409]: 2026-09-03T19:17:03.460660Z INFO ExtHandler ExtHandler Azure Linux Agent (Goal State Agent version 2.12.0.4) Sep 3 19:17:03.461526 waagent[2409]: 2026-09-03T19:17:03.461182Z INFO ExtHandler ExtHandler OS: flatcar 9999.0.0 Sep 3 19:17:03.461526 waagent[2409]: 2026-09-03T19:17:03.461250Z INFO ExtHandler ExtHandler Python: 3.13.14 Sep 3 19:17:03.461526 waagent[2409]: 2026-09-03T19:17:03.461288Z INFO ExtHandler ExtHandler CPU Arch: aarch64 Sep 3 19:17:03.483643 waagent[2409]: 2026-09-03T19:17:03.483601Z INFO ExtHandler ExtHandler Distro: flatcar-9999.0.0; OSUtil: FlatcarUtil; AgentService: waagent; Python: 3.13.14; Arch: aarch64; systemd: True; LISDrivers: Absent; logrotate: logrotate 3.22.0; Sep 3 19:17:03.483880 waagent[2409]: 2026-09-03T19:17:03.483852Z INFO ExtHandler ExtHandler WireServer endpoint 168.63.129.16 read from file Sep 3 19:17:03.484035 waagent[2409]: 2026-09-03T19:17:03.484009Z INFO ExtHandler ExtHandler Wire server endpoint:168.63.129.16 Sep 3 19:17:03.493110 waagent[2409]: 2026-09-03T19:17:03.492518Z INFO ExtHandler Fetched a new incarnation for the WireServer goal state [incarnation 1] Sep 3 19:17:03.507143 waagent[2409]: 2026-09-03T19:17:03.507109Z INFO ExtHandler ExtHandler HostGAPlugin version: 1.0.8.184 Sep 3 19:17:03.507550 waagent[2409]: 2026-09-03T19:17:03.507514Z INFO ExtHandler Sep 3 19:17:03.507616 waagent[2409]: 2026-09-03T19:17:03.507594Z INFO ExtHandler Fetched new vmSettings [HostGAPlugin correlation ID: ac55bebd-13e0-4178-9226-55db01464db5 eTag: 6960583011332760899 source: Fabric] Sep 3 19:17:03.507844 waagent[2409]: 2026-09-03T19:17:03.507815Z INFO ExtHandler The vmSettings originated via Fabric; will ignore them. Sep 3 19:17:03.508300 waagent[2409]: 2026-09-03T19:17:03.508267Z INFO ExtHandler Sep 3 19:17:03.508347 waagent[2409]: 2026-09-03T19:17:03.508329Z INFO ExtHandler Fetching full goal state from the WireServer [incarnation 1] Sep 3 19:17:03.512470 waagent[2409]: 2026-09-03T19:17:03.512442Z INFO ExtHandler ExtHandler Downloading artifacts profile blob Sep 3 19:17:03.590288 waagent[2409]: 2026-09-03T19:17:03.590171Z INFO ExtHandler Downloaded certificate {'thumbprint': '516D7BCDF6902445A024604646A8E0227631CB52', 'hasPrivateKey': True} Sep 3 19:17:03.590623 waagent[2409]: 2026-09-03T19:17:03.590587Z INFO ExtHandler Fetch goal state completed Sep 3 19:17:03.599877 waagent[2409]: 2026-09-03T19:17:03.599821Z INFO ExtHandler ExtHandler OpenSSL version: OpenSSL 3.5.7 9 Jun 2026 (Library: OpenSSL 3.5.7 9 Jun 2026) Sep 3 19:17:03.603535 waagent[2409]: 2026-09-03T19:17:03.603487Z INFO ExtHandler ExtHandler WALinuxAgent-2.12.0.4 running as process 2409 Sep 3 19:17:03.603643 waagent[2409]: 2026-09-03T19:17:03.603615Z INFO ExtHandler ExtHandler ******** AutoUpdate.Enabled is set to False, not processing the operation ******** Sep 3 19:17:03.603891 waagent[2409]: 2026-09-03T19:17:03.603862Z INFO ExtHandler ExtHandler ******** AutoUpdate.UpdateToLatestVersion is set to False, not processing the operation ******** Sep 3 19:17:03.604988 waagent[2409]: 2026-09-03T19:17:03.604951Z INFO ExtHandler ExtHandler [CGI] Cgroup monitoring is not supported on ['flatcar', '9999.0.0', '', 'Flatcar Container Linux by Kinvolk'] Sep 3 19:17:03.605353 waagent[2409]: 2026-09-03T19:17:03.605320Z INFO ExtHandler ExtHandler [CGI] Agent will reset the quotas in case distro: ['flatcar', '9999.0.0', '', 'Flatcar Container Linux by Kinvolk'] went from supported to unsupported Sep 3 19:17:03.605450 waagent[2409]: 2026-09-03T19:17:03.605428Z INFO ExtHandler ExtHandler [CGI] Agent cgroups enabled: False Sep 3 19:17:03.605870 waagent[2409]: 2026-09-03T19:17:03.605840Z INFO ExtHandler ExtHandler Starting setup for Persistent firewall rules Sep 3 19:17:03.643863 waagent[2409]: 2026-09-03T19:17:03.643818Z INFO ExtHandler ExtHandler Firewalld service not running/unavailable, trying to set up waagent-network-setup.service Sep 3 19:17:03.644074 waagent[2409]: 2026-09-03T19:17:03.644034Z INFO ExtHandler ExtHandler Successfully updated the Binary file /var/lib/waagent/waagent-network-setup.py for firewall setup Sep 3 19:17:03.648487 waagent[2409]: 2026-09-03T19:17:03.648449Z INFO ExtHandler ExtHandler Service: waagent-network-setup.service not enabled. Adding it now Sep 3 19:17:03.652870 systemd[1]: Reload requested from client PID 2424 ('systemctl') (unit waagent.service)... Sep 3 19:17:03.652884 systemd[1]: Reloading... Sep 3 19:17:03.765093 zram_generator::config[2496]: No configuration found. Sep 3 19:17:03.967939 systemd[1]: Reloading finished in 314 ms. Sep 3 19:17:03.990092 waagent[2409]: 2026-09-03T19:17:03.988188Z INFO ExtHandler ExtHandler Successfully added and enabled the waagent-network-setup.service Sep 3 19:17:03.990092 waagent[2409]: 2026-09-03T19:17:03.988338Z INFO ExtHandler ExtHandler Persistent firewall rules setup successfully Sep 3 19:17:04.336492 waagent[2409]: 2026-09-03T19:17:04.336353Z INFO ExtHandler ExtHandler DROP rule is not available which implies no firewall rules are set yet. Environment thread will set it up. Sep 3 19:17:04.336770 waagent[2409]: 2026-09-03T19:17:04.336658Z 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 3 19:17:04.340653 waagent[2409]: 2026-09-03T19:17:04.340600Z INFO ExtHandler ExtHandler Starting env monitor service. Sep 3 19:17:04.341030 waagent[2409]: 2026-09-03T19:17:04.340956Z INFO ExtHandler ExtHandler Start SendTelemetryHandler service. Sep 3 19:17:04.342042 waagent[2409]: 2026-09-03T19:17:04.341223Z INFO MonitorHandler ExtHandler WireServer endpoint 168.63.129.16 read from file Sep 3 19:17:04.342042 waagent[2409]: 2026-09-03T19:17:04.341356Z INFO MonitorHandler ExtHandler Wire server endpoint:168.63.129.16 Sep 3 19:17:04.342042 waagent[2409]: 2026-09-03T19:17:04.341576Z INFO MonitorHandler ExtHandler Monitor.NetworkConfigurationChanges is disabled. Sep 3 19:17:04.342042 waagent[2409]: 2026-09-03T19:17:04.341733Z INFO MonitorHandler ExtHandler Routing table from /proc/net/route: Sep 3 19:17:04.342042 waagent[2409]: Iface Destination Gateway Flags RefCnt Use Metric Mask MTU Window IRTT Sep 3 19:17:04.342042 waagent[2409]: eth0 00000000 0100000A 0003 0 0 1024 00000000 0 0 0 Sep 3 19:17:04.342042 waagent[2409]: eth0 0000000A 00000000 0001 0 0 1024 00FFFFFF 0 0 0 Sep 3 19:17:04.342042 waagent[2409]: eth0 0100000A 00000000 0005 0 0 1024 FFFFFFFF 0 0 0 Sep 3 19:17:04.342042 waagent[2409]: eth0 10813FA8 0100000A 0007 0 0 1024 FFFFFFFF 0 0 0 Sep 3 19:17:04.342042 waagent[2409]: eth0 FEA9FEA9 0100000A 0007 0 0 1024 FFFFFFFF 0 0 0 Sep 3 19:17:04.342452 waagent[2409]: 2026-09-03T19:17:04.342408Z INFO SendTelemetryHandler ExtHandler Successfully started the SendTelemetryHandler thread Sep 3 19:17:04.342493 waagent[2409]: 2026-09-03T19:17:04.342463Z INFO ExtHandler ExtHandler Start Extension Telemetry service. Sep 3 19:17:04.342748 waagent[2409]: 2026-09-03T19:17:04.342720Z INFO EnvHandler ExtHandler WireServer endpoint 168.63.129.16 read from file Sep 3 19:17:04.342967 waagent[2409]: 2026-09-03T19:17:04.342941Z INFO EnvHandler ExtHandler Wire server endpoint:168.63.129.16 Sep 3 19:17:04.343192 waagent[2409]: 2026-09-03T19:17:04.343162Z INFO EnvHandler ExtHandler Configure routes Sep 3 19:17:04.343333 waagent[2409]: 2026-09-03T19:17:04.343307Z INFO EnvHandler ExtHandler Gateway:None Sep 3 19:17:04.343437 waagent[2409]: 2026-09-03T19:17:04.343416Z INFO EnvHandler ExtHandler Routes:None Sep 3 19:17:04.343930 waagent[2409]: 2026-09-03T19:17:04.343890Z INFO TelemetryEventsCollector ExtHandler Extension Telemetry pipeline enabled: True Sep 3 19:17:04.343993 waagent[2409]: 2026-09-03T19:17:04.343938Z INFO ExtHandler ExtHandler Goal State Period: 6 sec. This indicates how often the agent checks for new goal states and reports status. Sep 3 19:17:04.344403 waagent[2409]: 2026-09-03T19:17:04.344366Z INFO TelemetryEventsCollector ExtHandler Successfully started the TelemetryEventsCollector thread Sep 3 19:17:04.351826 waagent[2409]: 2026-09-03T19:17:04.351785Z INFO ExtHandler ExtHandler Sep 3 19:17:04.351892 waagent[2409]: 2026-09-03T19:17:04.351857Z INFO ExtHandler ExtHandler ProcessExtensionsGoalState started [incarnation_1 channel: WireServer source: Fabric activity: acecb203-df12-488d-90c0-61ab210141e2 correlation 14fe3ae8-7045-446b-b368-95494ea96064 created: 2026-09-03T19:15:55.509224Z] Sep 3 19:17:04.352182 waagent[2409]: 2026-09-03T19:17:04.352149Z INFO ExtHandler ExtHandler No extension handlers found, not processing anything. Sep 3 19:17:04.352594 waagent[2409]: 2026-09-03T19:17:04.352567Z INFO ExtHandler ExtHandler ProcessExtensionsGoalState completed [incarnation_1 0 ms] Sep 3 19:17:04.382891 waagent[2409]: 2026-09-03T19:17:04.382788Z INFO ExtHandler ExtHandler [HEARTBEAT] Agent WALinuxAgent-2.12.0.4 is running as the goal state agent [DEBUG HeartbeatCounter: 0;HeartbeatId: 48C5598D-D3CA-4C64-8DC7-69A67CB3D65B;DroppedPackets: 0;UpdateGSErrors: 0;AutoUpdate: 0;UpdateMode: SelfUpdate;] Sep 3 19:17:04.427975 waagent[2409]: 2026-09-03T19:17:04.427598Z INFO MonitorHandler ExtHandler Network interfaces: Sep 3 19:17:04.427975 waagent[2409]: Executing ['ip', '-a', '-o', 'link']: Sep 3 19:17:04.427975 waagent[2409]: 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 3 19:17:04.427975 waagent[2409]: 2: eth0: mtu 1500 qdisc mq state UP mode DEFAULT group default qlen 1000\ link/ether 7c:ed:8d:8a:dc:cf brd ff:ff:ff:ff:ff:ff\ alias Network Device\ altname enx7ced8d8adccf Sep 3 19:17:04.427975 waagent[2409]: 3: enP30832s1: mtu 1500 qdisc mq master eth0 state UP mode DEFAULT group default qlen 1000\ link/ether 7c:ed:8d:8a:dc:cf brd ff:ff:ff:ff:ff:ff\ altname enP30832p0s0\ altname enp0s0\ altname ens1 Sep 3 19:17:04.427975 waagent[2409]: Executing ['ip', '-4', '-a', '-o', 'address']: Sep 3 19:17:04.427975 waagent[2409]: 1: lo inet 127.0.0.1/8 scope host lo\ valid_lft forever preferred_lft forever Sep 3 19:17:04.427975 waagent[2409]: 2: eth0 inet 10.0.0.5/24 metric 1024 brd 10.0.0.255 scope global eth0\ valid_lft forever preferred_lft forever Sep 3 19:17:04.427975 waagent[2409]: Executing ['ip', '-6', '-a', '-o', 'address']: Sep 3 19:17:04.427975 waagent[2409]: 1: lo inet6 ::1/128 scope host noprefixroute \ valid_lft forever preferred_lft forever Sep 3 19:17:04.427975 waagent[2409]: 2: eth0 inet6 fe80::7eed:8dff:fe8a:dccf/64 scope link proto kernel_ll \ valid_lft forever preferred_lft forever Sep 3 19:17:04.496735 waagent[2409]: 2026-09-03T19:17:04.496680Z INFO EnvHandler ExtHandler Created firewall rules for the Azure Fabric: Sep 3 19:17:04.496735 waagent[2409]: Chain INPUT (policy ACCEPT 0 packets, 0 bytes) Sep 3 19:17:04.496735 waagent[2409]: pkts bytes target prot opt in out source destination Sep 3 19:17:04.496735 waagent[2409]: Chain FORWARD (policy ACCEPT 0 packets, 0 bytes) Sep 3 19:17:04.496735 waagent[2409]: pkts bytes target prot opt in out source destination Sep 3 19:17:04.496735 waagent[2409]: Chain OUTPUT (policy ACCEPT 0 packets, 0 bytes) Sep 3 19:17:04.496735 waagent[2409]: pkts bytes target prot opt in out source destination Sep 3 19:17:04.496735 waagent[2409]: 0 0 ACCEPT tcp -- * * 0.0.0.0/0 168.63.129.16 tcp dpt:53 Sep 3 19:17:04.496735 waagent[2409]: 1 52 ACCEPT tcp -- * * 0.0.0.0/0 168.63.129.16 owner UID match 0 Sep 3 19:17:04.496735 waagent[2409]: 0 0 DROP tcp -- * * 0.0.0.0/0 168.63.129.16 ctstate INVALID,NEW Sep 3 19:17:04.499179 waagent[2409]: 2026-09-03T19:17:04.499135Z INFO EnvHandler ExtHandler Current Firewall rules: Sep 3 19:17:04.499179 waagent[2409]: Chain INPUT (policy ACCEPT 0 packets, 0 bytes) Sep 3 19:17:04.499179 waagent[2409]: pkts bytes target prot opt in out source destination Sep 3 19:17:04.499179 waagent[2409]: Chain FORWARD (policy ACCEPT 0 packets, 0 bytes) Sep 3 19:17:04.499179 waagent[2409]: pkts bytes target prot opt in out source destination Sep 3 19:17:04.499179 waagent[2409]: Chain OUTPUT (policy ACCEPT 0 packets, 0 bytes) Sep 3 19:17:04.499179 waagent[2409]: pkts bytes target prot opt in out source destination Sep 3 19:17:04.499179 waagent[2409]: 0 0 ACCEPT tcp -- * * 0.0.0.0/0 168.63.129.16 tcp dpt:53 Sep 3 19:17:04.499179 waagent[2409]: 1 52 ACCEPT tcp -- * * 0.0.0.0/0 168.63.129.16 owner UID match 0 Sep 3 19:17:04.499179 waagent[2409]: 0 0 DROP tcp -- * * 0.0.0.0/0 168.63.129.16 ctstate INVALID,NEW Sep 3 19:17:04.499391 waagent[2409]: 2026-09-03T19:17:04.499363Z INFO EnvHandler ExtHandler Set block dev timeout: sda with timeout: 300 Sep 3 19:17:05.832155 kernel: hv_storvsc f8b3781a-1e82-4818-a1c3-63d806ec15bb: tag#205 cmd 0x85 status: scsi 0x2 srb 0x84 hv 0xc0000185 Sep 3 19:17:13.773858 systemd[1]: Created slice system-sshd.slice - Slice /system/sshd. Sep 3 19:17:13.776290 systemd[1]: Started sshd@0-1-10.0.0.5:22-20.76.204.135:55690.service - OpenSSH per-connection server daemon (20.76.204.135:55690). Sep 3 19:17:14.798235 sshd[2567]: Accepted publickey for core from 20.76.204.135 port 55690 ssh2: RSA SHA256:HLC1eexl8tz1SbX4ND1+Hf5Hz55EGVNFkmwkC9b58aE Sep 3 19:17:14.799419 sshd-session[2567]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Sep 3 19:17:14.808145 systemd[1]: Starting user@500.service - User Manager for UID 500... Sep 3 19:17:14.822426 systemd-logind[2058]: New session '3' of user 'core' with class 'user' and type 'tty'. Sep 3 19:17:14.831121 (systemd)[2571]: pam_unix(systemd-user:session): session opened for user core(uid=500) by core(uid=0) Sep 3 19:17:14.833955 systemd-logind[2058]: New session '4' of user 'core' with class 'manager-early' and type 'unspecified'. Sep 3 19:17:15.035732 systemd[2571]: Queued start job for default target default.target. Sep 3 19:17:15.042818 systemd[2571]: Created slice app.slice - User Application Slice. Sep 3 19:17:15.043019 systemd[2571]: Started systemd-tmpfiles-clean.timer - Daily Cleanup of User's Temporary Directories. Sep 3 19:17:15.043032 systemd[2571]: Reached target machines.target - Virtual Machines and Containers. Sep 3 19:17:15.043102 systemd[2571]: Reached target paths.target - Paths. Sep 3 19:17:15.043120 systemd[2571]: Reached target timers.target - Timers. Sep 3 19:17:15.044426 systemd[2571]: Starting dbus.socket - D-Bus User Message Bus Socket... Sep 3 19:17:15.045732 systemd[2571]: Listening on systemd-ask-password.socket - Query the User Interactively for a Password. Sep 3 19:17:15.045986 systemd[2571]: Listening on systemd-importd.socket - Disk Image Download Service Socket. Sep 3 19:17:15.046800 systemd[2571]: Listening on systemd-journalctl.socket - Journal Log Access Socket. Sep 3 19:17:15.047098 systemd[2571]: Listening on systemd-machined.socket - Virtual Machine and Container Registration Service Socket. Sep 3 19:17:15.048315 systemd[2571]: Starting systemd-tmpfiles-setup.service - Create User Files and Directories... Sep 3 19:17:15.054429 systemd[2571]: Listening on dbus.socket - D-Bus User Message Bus Socket. Sep 3 19:17:15.054475 systemd[2571]: Reached target sockets.target - Sockets. Sep 3 19:17:15.060121 systemd[2571]: Finished systemd-tmpfiles-setup.service - Create User Files and Directories. Sep 3 19:17:15.060222 systemd[2571]: Reached target basic.target - Basic System. Sep 3 19:17:15.060266 systemd[2571]: Reached target default.target - Main User Target. Sep 3 19:17:15.060288 systemd[2571]: Startup finished in 220ms. Sep 3 19:17:15.060539 systemd[1]: Started user@500.service - User Manager for UID 500. Sep 3 19:17:15.072234 systemd[1]: Started session-3.scope - Session 3 of User core. Sep 3 19:17:15.508329 systemd[1]: Started sshd@1-2-10.0.0.5:22-20.76.204.135:55704.service - OpenSSH per-connection server daemon (20.76.204.135:55704). Sep 3 19:17:16.243348 sshd[2585]: Accepted publickey for core from 20.76.204.135 port 55704 ssh2: RSA SHA256:HLC1eexl8tz1SbX4ND1+Hf5Hz55EGVNFkmwkC9b58aE Sep 3 19:17:16.244475 sshd-session[2585]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Sep 3 19:17:16.250127 systemd-logind[2058]: New session '5' of user 'core' with class 'user' and type 'tty'. Sep 3 19:17:16.260239 systemd[1]: Started session-5.scope - Session 5 of User core. Sep 3 19:17:16.665234 sshd[2589]: Connection closed by 20.76.204.135 port 55704 Sep 3 19:17:16.665878 sshd-session[2585]: pam_unix(sshd:session): session closed for user core Sep 3 19:17:16.668816 systemd[1]: sshd@1-2-10.0.0.5:22-20.76.204.135:55704.service: Deactivated successfully. Sep 3 19:17:16.670662 systemd[1]: session-5.scope: Deactivated successfully. Sep 3 19:17:16.673560 systemd-logind[2058]: Session 5 logged out. Waiting for processes to exit. Sep 3 19:17:16.674905 systemd-logind[2058]: Removed session 5. Sep 3 19:17:16.826338 systemd[1]: Started sshd@2-4097-10.0.0.5:22-20.76.204.135:33120.service - OpenSSH per-connection server daemon (20.76.204.135:33120). Sep 3 19:17:17.564884 sshd[2595]: Accepted publickey for core from 20.76.204.135 port 33120 ssh2: RSA SHA256:HLC1eexl8tz1SbX4ND1+Hf5Hz55EGVNFkmwkC9b58aE Sep 3 19:17:17.565747 sshd-session[2595]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Sep 3 19:17:17.569865 systemd-logind[2058]: New session '6' of user 'core' with class 'user' and type 'tty'. Sep 3 19:17:17.574256 systemd[1]: Started session-6.scope - Session 6 of User core. Sep 3 19:17:17.983709 sshd[2599]: Connection closed by 20.76.204.135 port 33120 Sep 3 19:17:17.984600 sshd-session[2595]: pam_unix(sshd:session): session closed for user core Sep 3 19:17:17.988237 systemd[1]: sshd@2-4097-10.0.0.5:22-20.76.204.135:33120.service: Deactivated successfully. Sep 3 19:17:17.990912 systemd[1]: session-6.scope: Deactivated successfully. Sep 3 19:17:17.992820 systemd-logind[2058]: Session 6 logged out. Waiting for processes to exit. Sep 3 19:17:17.994453 systemd-logind[2058]: Removed session 6. Sep 3 19:17:18.135323 systemd[1]: Started sshd@3-3-10.0.0.5:22-20.76.204.135:33124.service - OpenSSH per-connection server daemon (20.76.204.135:33124). Sep 3 19:17:18.872160 sshd[2605]: Accepted publickey for core from 20.76.204.135 port 33124 ssh2: RSA SHA256:HLC1eexl8tz1SbX4ND1+Hf5Hz55EGVNFkmwkC9b58aE Sep 3 19:17:18.873279 sshd-session[2605]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Sep 3 19:17:18.878096 systemd-logind[2058]: New session '7' of user 'core' with class 'user' and type 'tty'. Sep 3 19:17:18.884214 systemd[1]: Started session-7.scope - Session 7 of User core. Sep 3 19:17:19.294256 sshd[2609]: Connection closed by 20.76.204.135 port 33124 Sep 3 19:17:19.294960 sshd-session[2605]: pam_unix(sshd:session): session closed for user core Sep 3 19:17:19.298530 systemd[1]: sshd@3-3-10.0.0.5:22-20.76.204.135:33124.service: Deactivated successfully. Sep 3 19:17:19.300578 systemd[1]: session-7.scope: Deactivated successfully. Sep 3 19:17:19.302217 chronyd[2044]: Selected source PHC0 Sep 3 19:17:19.302501 systemd-logind[2058]: Session 7 logged out. Waiting for processes to exit. Sep 3 19:17:19.303871 systemd-logind[2058]: Removed session 7. Sep 3 19:17:19.443288 systemd[1]: Started sshd@4-4-10.0.0.5:22-20.76.204.135:33128.service - OpenSSH per-connection server daemon (20.76.204.135:33128). Sep 3 19:17:20.176524 sshd[2615]: Accepted publickey for core from 20.76.204.135 port 33128 ssh2: RSA SHA256:HLC1eexl8tz1SbX4ND1+Hf5Hz55EGVNFkmwkC9b58aE Sep 3 19:17:20.177612 sshd-session[2615]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Sep 3 19:17:20.182533 systemd-logind[2058]: New session '8' of user 'core' with class 'user' and type 'tty'. Sep 3 19:17:20.190208 systemd[1]: Started session-8.scope - Session 8 of User core. Sep 3 19:17:20.598190 sshd[2619]: Connection closed by 20.76.204.135 port 33128 Sep 3 19:17:20.598851 sshd-session[2615]: pam_unix(sshd:session): session closed for user core Sep 3 19:17:20.601443 systemd[1]: sshd@4-4-10.0.0.5:22-20.76.204.135:33128.service: Deactivated successfully. Sep 3 19:17:20.603057 systemd[1]: session-8.scope: Deactivated successfully. Sep 3 19:17:20.605720 systemd-logind[2058]: Session 8 logged out. Waiting for processes to exit. Sep 3 19:17:20.607190 systemd-logind[2058]: Removed session 8. Sep 3 19:17:20.751314 systemd[1]: Started sshd@5-5-10.0.0.5:22-20.76.204.135:33134.service - OpenSSH per-connection server daemon (20.76.204.135:33134). Sep 3 19:17:21.487378 sshd[2625]: Accepted publickey for core from 20.76.204.135 port 33134 ssh2: RSA SHA256:HLC1eexl8tz1SbX4ND1+Hf5Hz55EGVNFkmwkC9b58aE Sep 3 19:17:21.488690 sshd-session[2625]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Sep 3 19:17:21.493983 systemd-logind[2058]: New session '9' of user 'core' with class 'user' and type 'tty'. Sep 3 19:17:21.499210 systemd[1]: Started session-9.scope - Session 9 of User core. Sep 3 19:17:21.911361 sshd[2629]: Connection closed by 20.76.204.135 port 33134 Sep 3 19:17:21.911213 sshd-session[2625]: pam_unix(sshd:session): session closed for user core Sep 3 19:17:21.914243 systemd[1]: sshd@5-5-10.0.0.5:22-20.76.204.135:33134.service: Deactivated successfully. Sep 3 19:17:21.915910 systemd[1]: session-9.scope: Deactivated successfully. Sep 3 19:17:21.917947 systemd-logind[2058]: Session 9 logged out. Waiting for processes to exit. Sep 3 19:17:21.919220 systemd-logind[2058]: Removed session 9.