Mar 2 11:38:21.004269 kernel: Booting Linux on physical CPU 0x0000000000 [0x410fd490] Mar 2 11:38:21.004287 kernel: Linux version 6.12.73-flatcar (build@pony-truck.infra.kinvolk.io) (aarch64-cros-linux-gnu-gcc (Gentoo Hardened 15.2.1_p20251122 p4) 15.2.1 20251122, GNU ld (Gentoo 2.45.1 p1) 2.45.1) #1 SMP PREEMPT Mon Mar 2 09:51:59 -00 2026 Mar 2 11:38:21.004293 kernel: KASLR enabled Mar 2 11:38:21.004297 kernel: earlycon: pl11 at MMIO 0x00000000effec000 (options '') Mar 2 11:38:21.004301 kernel: printk: legacy bootconsole [pl11] enabled Mar 2 11:38:21.004306 kernel: efi: EFI v2.7 by EDK II Mar 2 11:38:21.004311 kernel: efi: ACPI 2.0=0x3f979018 SMBIOS=0x3f8a0000 SMBIOS 3.0=0x3f880000 MEMATTR=0x3e89d018 RNG=0x3f979998 MEMRESERVE=0x3db84598 Mar 2 11:38:21.004315 kernel: random: crng init done Mar 2 11:38:21.004319 kernel: secureboot: Secure boot disabled Mar 2 11:38:21.004323 kernel: ACPI: Early table checksum verification disabled Mar 2 11:38:21.004327 kernel: ACPI: RSDP 0x000000003F979018 000024 (v02 VRTUAL) Mar 2 11:38:21.004331 kernel: ACPI: XSDT 0x000000003F979F18 00006C (v01 VRTUAL MICROSFT 00000001 MSFT 00000001) Mar 2 11:38:21.004335 kernel: ACPI: FACP 0x000000003F979C18 000114 (v06 VRTUAL MICROSFT 00000001 MSFT 00000001) Mar 2 11:38:21.004340 kernel: ACPI: DSDT 0x000000003F95A018 01E046 (v02 MSFTVM DSDT01 00000001 INTL 20230628) Mar 2 11:38:21.004346 kernel: ACPI: DBG2 0x000000003F979B18 000072 (v00 VRTUAL MICROSFT 00000001 MSFT 00000001) Mar 2 11:38:21.004350 kernel: ACPI: GTDT 0x000000003F979D98 000060 (v02 VRTUAL MICROSFT 00000001 MSFT 00000001) Mar 2 11:38:21.004355 kernel: ACPI: OEM0 0x000000003F979098 000064 (v01 VRTUAL MICROSFT 00000001 MSFT 00000001) Mar 2 11:38:21.004360 kernel: ACPI: SPCR 0x000000003F979A98 000050 (v02 VRTUAL MICROSFT 00000001 MSFT 00000001) Mar 2 11:38:21.004364 kernel: ACPI: APIC 0x000000003F979818 0000FC (v04 VRTUAL MICROSFT 00000001 MSFT 00000001) Mar 2 11:38:21.004369 kernel: ACPI: SRAT 0x000000003F979198 000234 (v03 VRTUAL MICROSFT 00000001 MSFT 00000001) Mar 2 11:38:21.004373 kernel: ACPI: PPTT 0x000000003F979418 000120 (v01 VRTUAL MICROSFT 00000000 MSFT 00000000) Mar 2 11:38:21.004377 kernel: ACPI: BGRT 0x000000003F979E98 000038 (v01 VRTUAL MICROSFT 00000001 MSFT 00000001) Mar 2 11:38:21.004381 kernel: ACPI: SPCR: console: pl011,mmio32,0xeffec000,115200 Mar 2 11:38:21.004386 kernel: ACPI: Use ACPI SPCR as default console: Yes Mar 2 11:38:21.004390 kernel: ACPI: SRAT: Node 0 PXM 0 [mem 0x00000000-0x3fffffff] hotplug Mar 2 11:38:21.004394 kernel: ACPI: SRAT: Node 0 PXM 0 [mem 0x100000000-0x1bfffffff] hotplug Mar 2 11:38:21.004398 kernel: ACPI: SRAT: Node 0 PXM 0 [mem 0x1c0000000-0xfbfffffff] hotplug Mar 2 11:38:21.004404 kernel: ACPI: SRAT: Node 0 PXM 0 [mem 0x1000000000-0xffffffffff] hotplug Mar 2 11:38:21.004408 kernel: ACPI: SRAT: Node 0 PXM 0 [mem 0x10000000000-0x1ffffffffff] hotplug Mar 2 11:38:21.004412 kernel: ACPI: SRAT: Node 0 PXM 0 [mem 0x20000000000-0x3ffffffffff] hotplug Mar 2 11:38:21.004416 kernel: ACPI: SRAT: Node 0 PXM 0 [mem 0x40000000000-0x7ffffffffff] hotplug Mar 2 11:38:21.004437 kernel: ACPI: SRAT: Node 0 PXM 0 [mem 0x80000000000-0xfffffffffff] hotplug Mar 2 11:38:21.004441 kernel: ACPI: SRAT: Node 0 PXM 0 [mem 0x100000000000-0x1fffffffffff] hotplug Mar 2 11:38:21.004445 kernel: ACPI: SRAT: Node 0 PXM 0 [mem 0x200000000000-0x3fffffffffff] hotplug Mar 2 11:38:21.004450 kernel: ACPI: SRAT: Node 0 PXM 0 [mem 0x400000000000-0x7fffffffffff] hotplug Mar 2 11:38:21.004454 kernel: ACPI: SRAT: Node 0 PXM 0 [mem 0x800000000000-0xffffffffffff] hotplug Mar 2 11:38:21.004458 kernel: NUMA: Node 0 [mem 0x00000000-0x3fffffff] + [mem 0x100000000-0x1bfffffff] -> [mem 0x00000000-0x1bfffffff] Mar 2 11:38:21.004462 kernel: NODE_DATA(0) allocated [mem 0x1bf7ffa00-0x1bf806fff] Mar 2 11:38:21.004468 kernel: Zone ranges: Mar 2 11:38:21.004472 kernel: DMA [mem 0x0000000000000000-0x00000000ffffffff] Mar 2 11:38:21.004478 kernel: DMA32 empty Mar 2 11:38:21.004483 kernel: Normal [mem 0x0000000100000000-0x00000001bfffffff] Mar 2 11:38:21.004487 kernel: Device empty Mar 2 11:38:21.004492 kernel: Movable zone start for each node Mar 2 11:38:21.004497 kernel: Early memory node ranges Mar 2 11:38:21.004501 kernel: node 0: [mem 0x0000000000000000-0x00000000007fffff] Mar 2 11:38:21.004506 kernel: node 0: [mem 0x0000000000824000-0x000000003f38ffff] Mar 2 11:38:21.004510 kernel: node 0: [mem 0x000000003f390000-0x000000003f93ffff] Mar 2 11:38:21.004514 kernel: node 0: [mem 0x000000003f940000-0x000000003f9effff] Mar 2 11:38:21.004519 kernel: node 0: [mem 0x000000003f9f0000-0x000000003fdeffff] Mar 2 11:38:21.004523 kernel: node 0: [mem 0x000000003fdf0000-0x000000003fffffff] Mar 2 11:38:21.004527 kernel: node 0: [mem 0x0000000100000000-0x00000001bfffffff] Mar 2 11:38:21.004532 kernel: Initmem setup node 0 [mem 0x0000000000000000-0x00000001bfffffff] Mar 2 11:38:21.004537 kernel: On node 0, zone DMA: 36 pages in unavailable ranges Mar 2 11:38:21.004542 kernel: cma: Reserved 16 MiB at 0x000000003ca00000 on node -1 Mar 2 11:38:21.004546 kernel: psci: probing for conduit method from ACPI. Mar 2 11:38:21.004551 kernel: psci: PSCIv1.3 detected in firmware. Mar 2 11:38:21.004555 kernel: psci: Using standard PSCI v0.2 function IDs Mar 2 11:38:21.004560 kernel: psci: MIGRATE_INFO_TYPE not supported. Mar 2 11:38:21.004564 kernel: psci: SMC Calling Convention v1.4 Mar 2 11:38:21.004568 kernel: ACPI: NUMA: SRAT: PXM 0 -> MPIDR 0x0 -> Node 0 Mar 2 11:38:21.004573 kernel: ACPI: NUMA: SRAT: PXM 0 -> MPIDR 0x1 -> Node 0 Mar 2 11:38:21.004577 kernel: percpu: Embedded 34 pages/cpu s98584 r8192 d32488 u139264 Mar 2 11:38:21.004582 kernel: pcpu-alloc: s98584 r8192 d32488 u139264 alloc=34*4096 Mar 2 11:38:21.004587 kernel: pcpu-alloc: [0] 0 [0] 1 Mar 2 11:38:21.004591 kernel: Detected PIPT I-cache on CPU0 Mar 2 11:38:21.004596 kernel: CPU features: detected: Address authentication (architected QARMA5 algorithm) Mar 2 11:38:21.004600 kernel: CPU features: detected: GIC system register CPU interface Mar 2 11:38:21.004605 kernel: CPU features: detected: Spectre-v4 Mar 2 11:38:21.004609 kernel: CPU features: detected: Spectre-BHB Mar 2 11:38:21.004614 kernel: CPU features: kernel page table isolation forced ON by KASLR Mar 2 11:38:21.004618 kernel: CPU features: detected: Kernel page table isolation (KPTI) Mar 2 11:38:21.004623 kernel: CPU features: detected: ARM erratum 2067961 or 2054223 Mar 2 11:38:21.004627 kernel: CPU features: detected: SSBS not fully self-synchronizing Mar 2 11:38:21.004631 kernel: alternatives: applying boot alternatives Mar 2 11:38:21.004637 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=e623746597ba418b3a52820ac96c047772e1184cf7a15653efffd08c53838c94 Mar 2 11:38:21.004642 kernel: Dentry cache hash table entries: 524288 (order: 10, 4194304 bytes, linear) Mar 2 11:38:21.004647 kernel: Inode-cache hash table entries: 262144 (order: 9, 2097152 bytes, linear) Mar 2 11:38:21.004651 kernel: Fallback order for Node 0: 0 Mar 2 11:38:21.004656 kernel: Built 1 zonelists, mobility grouping on. Total pages: 1048540 Mar 2 11:38:21.004660 kernel: Policy zone: Normal Mar 2 11:38:21.004664 kernel: mem auto-init: stack:off, heap alloc:off, heap free:off Mar 2 11:38:21.004669 kernel: software IO TLB: area num 2. Mar 2 11:38:21.004673 kernel: software IO TLB: mapped [mem 0x0000000037230000-0x000000003b230000] (64MB) Mar 2 11:38:21.004677 kernel: SLUB: HWalign=64, Order=0-3, MinObjects=0, CPUs=2, Nodes=1 Mar 2 11:38:21.004683 kernel: ftrace: allocating 39807 entries in 156 pages Mar 2 11:38:21.004687 kernel: ftrace: allocated 156 pages with 4 groups Mar 2 11:38:21.004691 kernel: rcu: Preemptible hierarchical RCU implementation. Mar 2 11:38:21.004696 kernel: rcu: RCU event tracing is enabled. Mar 2 11:38:21.004701 kernel: rcu: RCU restricting CPUs from NR_CPUS=512 to nr_cpu_ids=2. Mar 2 11:38:21.004705 kernel: Trampoline variant of Tasks RCU enabled. Mar 2 11:38:21.004710 kernel: Rude variant of Tasks RCU enabled. Mar 2 11:38:21.004714 kernel: Tracing variant of Tasks RCU enabled. Mar 2 11:38:21.004719 kernel: rcu: RCU calculated value of scheduler-enlistment delay is 100 jiffies. Mar 2 11:38:21.004723 kernel: rcu: Adjusting geometry for rcu_fanout_leaf=16, nr_cpu_ids=2 Mar 2 11:38:21.004727 kernel: RCU Tasks: Setting shift to 1 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=2. Mar 2 11:38:21.004733 kernel: RCU Tasks Rude: Setting shift to 1 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=2. Mar 2 11:38:21.004738 kernel: RCU Tasks Trace: Setting shift to 1 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=2. Mar 2 11:38:21.004742 kernel: NR_IRQS: 64, nr_irqs: 64, preallocated irqs: 0 Mar 2 11:38:21.004746 kernel: GICv3: 960 SPIs implemented Mar 2 11:38:21.004751 kernel: GICv3: 0 Extended SPIs implemented Mar 2 11:38:21.004755 kernel: Root IRQ handler: gic_handle_irq Mar 2 11:38:21.004759 kernel: GICv3: GICv3 features: 16 PPIs, RSS Mar 2 11:38:21.004764 kernel: GICv3: GICD_CTRL.DS=0, SCR_EL3.FIQ=0 Mar 2 11:38:21.004768 kernel: GICv3: CPU0: found redistributor 0 region 0:0x00000000effee000 Mar 2 11:38:21.004773 kernel: ITS: No ITS available, not enabling LPIs Mar 2 11:38:21.004777 kernel: rcu: srcu_init: Setting srcu_struct sizes based on contention. Mar 2 11:38:21.004782 kernel: arch_timer: cp15 timer(s) running at 1000.00MHz (virt). Mar 2 11:38:21.004787 kernel: clocksource: arch_sys_counter: mask: 0x1fffffffffffffff max_cycles: 0x1cd42e4dffb, max_idle_ns: 881590591483 ns Mar 2 11:38:21.004792 kernel: sched_clock: 61 bits at 1000MHz, resolution 1ns, wraps every 4398046511103ns Mar 2 11:38:21.004796 kernel: Console: colour dummy device 80x25 Mar 2 11:38:21.004801 kernel: printk: legacy console [tty1] enabled Mar 2 11:38:21.004806 kernel: ACPI: Core revision 20240827 Mar 2 11:38:21.004811 kernel: Calibrating delay loop (skipped), value calculated using timer frequency.. 2000.00 BogoMIPS (lpj=1000000) Mar 2 11:38:21.004815 kernel: pid_max: default: 32768 minimum: 301 Mar 2 11:38:21.004821 kernel: LSM: initializing lsm=lockdown,capability,landlock,selinux,ima Mar 2 11:38:21.004826 kernel: landlock: Up and running. Mar 2 11:38:21.004830 kernel: SELinux: Initializing. Mar 2 11:38:21.004838 kernel: Mount-cache hash table entries: 8192 (order: 4, 65536 bytes, linear) Mar 2 11:38:21.004844 kernel: Mountpoint-cache hash table entries: 8192 (order: 4, 65536 bytes, linear) Mar 2 11:38:21.004849 kernel: Hyper-V: privilege flags low 0x2e7f, high 0x3b8030, hints 0xa0000e, misc 0x31e1 Mar 2 11:38:21.004854 kernel: Hyper-V: Host Build 10.0.26102.1212-1-0 Mar 2 11:38:21.004859 kernel: Hyper-V: enabling crash_kexec_post_notifiers Mar 2 11:38:21.004863 kernel: rcu: Hierarchical SRCU implementation. Mar 2 11:38:21.004868 kernel: rcu: Max phase no-delay instances is 400. Mar 2 11:38:21.004874 kernel: Timer migration: 1 hierarchy levels; 8 children per group; 1 crossnode level Mar 2 11:38:21.004879 kernel: Remapping and enabling EFI services. Mar 2 11:38:21.004884 kernel: smp: Bringing up secondary CPUs ... Mar 2 11:38:21.004888 kernel: Detected PIPT I-cache on CPU1 Mar 2 11:38:21.004894 kernel: GICv3: CPU1: found redistributor 1 region 1:0x00000000f000e000 Mar 2 11:38:21.004899 kernel: CPU1: Booted secondary processor 0x0000000001 [0x410fd490] Mar 2 11:38:21.004904 kernel: smp: Brought up 1 node, 2 CPUs Mar 2 11:38:21.004909 kernel: SMP: Total of 2 processors activated. Mar 2 11:38:21.004914 kernel: CPU: All CPU(s) started at EL1 Mar 2 11:38:21.004918 kernel: CPU features: detected: 32-bit EL0 Support Mar 2 11:38:21.004923 kernel: CPU features: detected: Instruction cache invalidation not required for I/D coherence Mar 2 11:38:21.004929 kernel: CPU features: detected: Data cache clean to the PoU not required for I/D coherence Mar 2 11:38:21.004934 kernel: CPU features: detected: Common not Private translations Mar 2 11:38:21.004939 kernel: CPU features: detected: CRC32 instructions Mar 2 11:38:21.004944 kernel: CPU features: detected: Generic authentication (architected QARMA5 algorithm) Mar 2 11:38:21.004949 kernel: CPU features: detected: RCpc load-acquire (LDAPR) Mar 2 11:38:21.004954 kernel: CPU features: detected: LSE atomic instructions Mar 2 11:38:21.004959 kernel: CPU features: detected: Privileged Access Never Mar 2 11:38:21.004964 kernel: CPU features: detected: Speculation barrier (SB) Mar 2 11:38:21.004969 kernel: CPU features: detected: TLB range maintenance instructions Mar 2 11:38:21.004974 kernel: CPU features: detected: Speculative Store Bypassing Safe (SSBS) Mar 2 11:38:21.004979 kernel: CPU features: detected: Scalable Vector Extension Mar 2 11:38:21.004984 kernel: alternatives: applying system-wide alternatives Mar 2 11:38:21.004989 kernel: CPU features: detected: Hardware dirty bit management on CPU0-1 Mar 2 11:38:21.004993 kernel: SVE: maximum available vector length 16 bytes per vector Mar 2 11:38:21.004999 kernel: SVE: default vector length 16 bytes per vector Mar 2 11:38:21.005004 kernel: Memory: 3977892K/4194160K available (11968K kernel code, 2462K rwdata, 9136K rodata, 12928K init, 1038K bss, 194360K reserved, 16384K cma-reserved) Mar 2 11:38:21.005009 kernel: devtmpfs: initialized Mar 2 11:38:21.005014 kernel: clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1911260446275000 ns Mar 2 11:38:21.005019 kernel: futex hash table entries: 512 (order: 3, 32768 bytes, linear) Mar 2 11:38:21.005024 kernel: 2G module region forced by RANDOMIZE_MODULE_REGION_FULL Mar 2 11:38:21.005029 kernel: 0 pages in range for non-PLT usage Mar 2 11:38:21.005034 kernel: 514848 pages in range for PLT usage Mar 2 11:38:21.005039 kernel: pinctrl core: initialized pinctrl subsystem Mar 2 11:38:21.005044 kernel: SMBIOS 3.1.0 present. Mar 2 11:38:21.005049 kernel: DMI: Microsoft Corporation Virtual Machine/Virtual Machine, BIOS Hyper-V UEFI Release v4.1 06/10/2025 Mar 2 11:38:21.005054 kernel: DMI: Memory slots populated: 2/2 Mar 2 11:38:21.005058 kernel: NET: Registered PF_NETLINK/PF_ROUTE protocol family Mar 2 11:38:21.005063 kernel: DMA: preallocated 512 KiB GFP_KERNEL pool for atomic allocations Mar 2 11:38:21.005069 kernel: DMA: preallocated 512 KiB GFP_KERNEL|GFP_DMA pool for atomic allocations Mar 2 11:38:21.005074 kernel: DMA: preallocated 512 KiB GFP_KERNEL|GFP_DMA32 pool for atomic allocations Mar 2 11:38:21.005079 kernel: audit: initializing netlink subsys (disabled) Mar 2 11:38:21.005084 kernel: audit: type=2000 audit(0.059:1): state=initialized audit_enabled=0 res=1 Mar 2 11:38:21.005089 kernel: thermal_sys: Registered thermal governor 'step_wise' Mar 2 11:38:21.005093 kernel: cpuidle: using governor menu Mar 2 11:38:21.005098 kernel: hw-breakpoint: found 6 breakpoint and 4 watchpoint registers. Mar 2 11:38:21.005104 kernel: ASID allocator initialised with 32768 entries Mar 2 11:38:21.005109 kernel: acpiphp: ACPI Hot Plug PCI Controller Driver version: 0.5 Mar 2 11:38:21.005114 kernel: Serial: AMBA PL011 UART driver Mar 2 11:38:21.005119 kernel: HugeTLB: registered 1.00 GiB page size, pre-allocated 0 pages Mar 2 11:38:21.005124 kernel: HugeTLB: 0 KiB vmemmap can be freed for a 1.00 GiB page Mar 2 11:38:21.005128 kernel: HugeTLB: registered 32.0 MiB page size, pre-allocated 0 pages Mar 2 11:38:21.005133 kernel: HugeTLB: 0 KiB vmemmap can be freed for a 32.0 MiB page Mar 2 11:38:21.005139 kernel: HugeTLB: registered 2.00 MiB page size, pre-allocated 0 pages Mar 2 11:38:21.005144 kernel: HugeTLB: 0 KiB vmemmap can be freed for a 2.00 MiB page Mar 2 11:38:21.005149 kernel: HugeTLB: registered 64.0 KiB page size, pre-allocated 0 pages Mar 2 11:38:21.005154 kernel: HugeTLB: 0 KiB vmemmap can be freed for a 64.0 KiB page Mar 2 11:38:21.005158 kernel: ACPI: Added _OSI(Module Device) Mar 2 11:38:21.005163 kernel: ACPI: Added _OSI(Processor Device) Mar 2 11:38:21.005168 kernel: ACPI: Added _OSI(Processor Aggregator Device) Mar 2 11:38:21.005173 kernel: ACPI: 1 ACPI AML tables successfully acquired and loaded Mar 2 11:38:21.005179 kernel: ACPI: Interpreter enabled Mar 2 11:38:21.005183 kernel: ACPI: Using GIC for interrupt routing Mar 2 11:38:21.005188 kernel: ARMH0011:00: ttyAMA0 at MMIO 0xeffec000 (irq = 12, base_baud = 0) is a SBSA Mar 2 11:38:21.005193 kernel: printk: legacy console [ttyAMA0] enabled Mar 2 11:38:21.005198 kernel: printk: legacy bootconsole [pl11] disabled Mar 2 11:38:21.005203 kernel: ARMH0011:01: ttyAMA1 at MMIO 0xeffeb000 (irq = 13, base_baud = 0) is a SBSA Mar 2 11:38:21.005208 kernel: ACPI: CPU0 has been hot-added Mar 2 11:38:21.005213 kernel: ACPI: CPU1 has been hot-added Mar 2 11:38:21.005218 kernel: iommu: Default domain type: Translated Mar 2 11:38:21.005223 kernel: iommu: DMA domain TLB invalidation policy: strict mode Mar 2 11:38:21.005228 kernel: efivars: Registered efivars operations Mar 2 11:38:21.005233 kernel: vgaarb: loaded Mar 2 11:38:21.005238 kernel: clocksource: Switched to clocksource arch_sys_counter Mar 2 11:38:21.005242 kernel: VFS: Disk quotas dquot_6.6.0 Mar 2 11:38:21.005248 kernel: VFS: Dquot-cache hash table entries: 512 (order 0, 4096 bytes) Mar 2 11:38:21.005253 kernel: pnp: PnP ACPI init Mar 2 11:38:21.005258 kernel: pnp: PnP ACPI: found 0 devices Mar 2 11:38:21.005263 kernel: NET: Registered PF_INET protocol family Mar 2 11:38:21.005267 kernel: IP idents hash table entries: 65536 (order: 7, 524288 bytes, linear) Mar 2 11:38:21.005272 kernel: tcp_listen_portaddr_hash hash table entries: 2048 (order: 3, 32768 bytes, linear) Mar 2 11:38:21.005277 kernel: Table-perturb hash table entries: 65536 (order: 6, 262144 bytes, linear) Mar 2 11:38:21.005283 kernel: TCP established hash table entries: 32768 (order: 6, 262144 bytes, linear) Mar 2 11:38:21.005288 kernel: TCP bind hash table entries: 32768 (order: 8, 1048576 bytes, linear) Mar 2 11:38:21.005293 kernel: TCP: Hash tables configured (established 32768 bind 32768) Mar 2 11:38:21.005297 kernel: UDP hash table entries: 2048 (order: 4, 65536 bytes, linear) Mar 2 11:38:21.005302 kernel: UDP-Lite hash table entries: 2048 (order: 4, 65536 bytes, linear) Mar 2 11:38:21.005307 kernel: NET: Registered PF_UNIX/PF_LOCAL protocol family Mar 2 11:38:21.005312 kernel: PCI: CLS 0 bytes, default 64 Mar 2 11:38:21.005318 kernel: kvm [1]: HYP mode not available Mar 2 11:38:21.005323 kernel: Initialise system trusted keyrings Mar 2 11:38:21.005327 kernel: workingset: timestamp_bits=39 max_order=20 bucket_order=0 Mar 2 11:38:21.005332 kernel: Key type asymmetric registered Mar 2 11:38:21.005337 kernel: Asymmetric key parser 'x509' registered Mar 2 11:38:21.005342 kernel: Block layer SCSI generic (bsg) driver version 0.4 loaded (major 249) Mar 2 11:38:21.005347 kernel: io scheduler mq-deadline registered Mar 2 11:38:21.005352 kernel: io scheduler kyber registered Mar 2 11:38:21.005357 kernel: io scheduler bfq registered Mar 2 11:38:21.005362 kernel: Serial: 8250/16550 driver, 4 ports, IRQ sharing enabled Mar 2 11:38:21.005367 kernel: thunder_xcv, ver 1.0 Mar 2 11:38:21.005371 kernel: thunder_bgx, ver 1.0 Mar 2 11:38:21.005376 kernel: nicpf, ver 1.0 Mar 2 11:38:21.005381 kernel: nicvf, ver 1.0 Mar 2 11:38:21.005515 kernel: rtc-efi rtc-efi.0: registered as rtc0 Mar 2 11:38:21.005586 kernel: rtc-efi rtc-efi.0: setting system clock to 2026-03-02T11:38:19 UTC (1772451499) Mar 2 11:38:21.005593 kernel: efifb: probing for efifb Mar 2 11:38:21.005598 kernel: efifb: framebuffer at 0x40000000, using 3072k, total 3072k Mar 2 11:38:21.005603 kernel: efifb: mode is 1024x768x32, linelength=4096, pages=1 Mar 2 11:38:21.005608 kernel: efifb: scrolling: redraw Mar 2 11:38:21.005613 kernel: efifb: Truecolor: size=8:8:8:8, shift=24:16:8:0 Mar 2 11:38:21.005619 kernel: Console: switching to colour frame buffer device 128x48 Mar 2 11:38:21.005624 kernel: fb0: EFI VGA frame buffer device Mar 2 11:38:21.005629 kernel: SMCCC: SOC_ID: ARCH_SOC_ID not implemented, skipping .... Mar 2 11:38:21.005633 kernel: hid: raw HID events driver (C) Jiri Kosina Mar 2 11:38:21.005638 kernel: hw perfevents: enabled with armv8_pmuv3_0 PMU driver, 7 (0,8000003f) counters available Mar 2 11:38:21.005643 kernel: watchdog: NMI not fully supported Mar 2 11:38:21.005648 kernel: watchdog: Hard watchdog permanently disabled Mar 2 11:38:21.005654 kernel: NET: Registered PF_INET6 protocol family Mar 2 11:38:21.005659 kernel: Segment Routing with IPv6 Mar 2 11:38:21.005664 kernel: In-situ OAM (IOAM) with IPv6 Mar 2 11:38:21.005669 kernel: NET: Registered PF_PACKET protocol family Mar 2 11:38:21.005674 kernel: Key type dns_resolver registered Mar 2 11:38:21.005678 kernel: registered taskstats version 1 Mar 2 11:38:21.005683 kernel: Loading compiled-in X.509 certificates Mar 2 11:38:21.005689 kernel: Loaded X.509 cert 'Kinvolk GmbH: Module signing key for 6.12.73-flatcar: 63d736c9b855c96c43658c5da7410b46738c76a1' Mar 2 11:38:21.005694 kernel: Demotion targets for Node 0: null Mar 2 11:38:21.005699 kernel: Key type .fscrypt registered Mar 2 11:38:21.005704 kernel: Key type fscrypt-provisioning registered Mar 2 11:38:21.005709 kernel: ima: No TPM chip found, activating TPM-bypass! Mar 2 11:38:21.005713 kernel: ima: Allocated hash algorithm: sha1 Mar 2 11:38:21.005718 kernel: ima: No architecture policies found Mar 2 11:38:21.005724 kernel: alg: No test for fips(ansi_cprng) (fips_ansi_cprng) Mar 2 11:38:21.005729 kernel: clk: Disabling unused clocks Mar 2 11:38:21.005734 kernel: PM: genpd: Disabling unused power domains Mar 2 11:38:21.005739 kernel: Freeing unused kernel memory: 12928K Mar 2 11:38:21.005744 kernel: Run /init as init process Mar 2 11:38:21.005748 kernel: with arguments: Mar 2 11:38:21.005753 kernel: /init Mar 2 11:38:21.005758 kernel: with environment: Mar 2 11:38:21.005764 kernel: HOME=/ Mar 2 11:38:21.005768 kernel: TERM=linux Mar 2 11:38:21.005773 kernel: hv_vmbus: Vmbus version:5.3 Mar 2 11:38:21.005778 kernel: hv_vmbus: registering driver hid_hyperv Mar 2 11:38:21.005783 kernel: SCSI subsystem initialized Mar 2 11:38:21.005788 kernel: input: Microsoft Vmbus HID-compliant Mouse as /devices/0006:045E:0621.0001/input/input0 Mar 2 11:38:21.005872 kernel: hid-hyperv 0006:045E:0621.0001: input: VIRTUAL HID v0.01 Mouse [Microsoft Vmbus HID-compliant Mouse] on Mar 2 11:38:21.005880 kernel: hv_vmbus: registering driver hyperv_keyboard Mar 2 11:38:21.005885 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 Mar 2 11:38:21.005890 kernel: pps_core: LinuxPPS API ver. 1 registered Mar 2 11:38:21.005895 kernel: pps_core: Software ver. 5.3.6 - Copyright 2005-2007 Rodolfo Giometti Mar 2 11:38:21.005900 kernel: PTP clock support registered Mar 2 11:38:21.005905 kernel: hv_utils: Registering HyperV Utility Driver Mar 2 11:38:21.005911 kernel: hv_vmbus: registering driver hv_utils Mar 2 11:38:21.005916 kernel: hv_utils: Shutdown IC version 3.2 Mar 2 11:38:21.005921 kernel: hv_utils: Heartbeat IC version 3.0 Mar 2 11:38:21.005925 kernel: hv_utils: TimeSync IC version 4.0 Mar 2 11:38:21.005930 kernel: hv_vmbus: registering driver hv_storvsc Mar 2 11:38:21.006019 kernel: scsi host1: storvsc_host_t Mar 2 11:38:21.006098 kernel: scsi host0: storvsc_host_t Mar 2 11:38:21.006185 kernel: scsi 0:0:0:0: Direct-Access Msft Virtual Disk 1.0 PQ: 0 ANSI: 5 Mar 2 11:38:21.006264 kernel: scsi 0:0:0:2: CD-ROM Msft Virtual DVD-ROM 1.0 PQ: 0 ANSI: 5 Mar 2 11:38:21.006337 kernel: sd 0:0:0:0: [sda] 63737856 512-byte logical blocks: (32.6 GB/30.4 GiB) Mar 2 11:38:21.006410 kernel: sd 0:0:0:0: [sda] 4096-byte physical blocks Mar 2 11:38:21.008700 kernel: sd 0:0:0:0: [sda] Write Protect is off Mar 2 11:38:21.008782 kernel: sd 0:0:0:0: [sda] Mode Sense: 0f 00 10 00 Mar 2 11:38:21.008856 kernel: sd 0:0:0:0: [sda] Write cache: disabled, read cache: enabled, supports DPO and FUA Mar 2 11:38:21.008863 kernel: sda: sda1 sda2 sda3 sda4 sda6 sda7 sda9 Mar 2 11:38:21.008936 kernel: sd 0:0:0:0: [sda] Attached SCSI disk Mar 2 11:38:21.009013 kernel: sr 0:0:0:2: [sr0] scsi-1 drive Mar 2 11:38:21.009019 kernel: cdrom: Uniform CD-ROM driver Revision: 3.20 Mar 2 11:38:21.009026 kernel: device-mapper: core: CONFIG_IMA_DISABLE_HTABLE is disabled. Duplicate IMA measurements will not be recorded in the IMA log. Mar 2 11:38:21.009032 kernel: device-mapper: uevent: version 1.0.3 Mar 2 11:38:21.009037 kernel: device-mapper: ioctl: 4.48.0-ioctl (2023-03-01) initialised: dm-devel@lists.linux.dev Mar 2 11:38:21.009122 kernel: sr 0:0:0:2: Attached scsi CD-ROM sr0 Mar 2 11:38:21.009128 kernel: device-mapper: verity: sha256 using shash "sha256-ce" Mar 2 11:38:21.009133 kernel: raid6: neonx8 gen() 18556 MB/s Mar 2 11:38:21.009138 kernel: raid6: neonx4 gen() 18584 MB/s Mar 2 11:38:21.009144 kernel: raid6: neonx2 gen() 17018 MB/s Mar 2 11:38:21.009148 kernel: raid6: neonx1 gen() 15136 MB/s Mar 2 11:38:21.009153 kernel: raid6: int64x8 gen() 8935 MB/s Mar 2 11:38:21.009158 kernel: raid6: int64x4 gen() 10737 MB/s Mar 2 11:38:21.009163 kernel: raid6: int64x2 gen() 8847 MB/s Mar 2 11:38:21.009168 kernel: raid6: int64x1 gen() 7110 MB/s Mar 2 11:38:21.009173 kernel: raid6: using algorithm neonx4 gen() 18584 MB/s Mar 2 11:38:21.009179 kernel: raid6: .... xor() 15162 MB/s, rmw enabled Mar 2 11:38:21.009183 kernel: raid6: using neon recovery algorithm Mar 2 11:38:21.009188 kernel: xor: measuring software checksum speed Mar 2 11:38:21.009193 kernel: 8regs : 29559 MB/sec Mar 2 11:38:21.009198 kernel: 32regs : 29549 MB/sec Mar 2 11:38:21.009203 kernel: arm64_neon : 37050 MB/sec Mar 2 11:38:21.009208 kernel: xor: using function: arm64_neon (37050 MB/sec) Mar 2 11:38:21.009213 kernel: Btrfs loaded, zoned=no, fsverity=no Mar 2 11:38:21.009219 kernel: BTRFS: device fsid f4e0c293-c9fd-4f8a-ac6e-6df38d42ef98 devid 1 transid 42 /dev/mapper/usr (254:0) scanned by mount (369) Mar 2 11:38:21.009224 kernel: BTRFS info (device dm-0): first mount of filesystem f4e0c293-c9fd-4f8a-ac6e-6df38d42ef98 Mar 2 11:38:21.009229 kernel: BTRFS info (device dm-0): using crc32c (crc32c-generic) checksum algorithm Mar 2 11:38:21.009234 kernel: BTRFS info (device dm-0 state E): disabling log replay at mount time Mar 2 11:38:21.009239 kernel: BTRFS info (device dm-0 state E): enabling free space tree Mar 2 11:38:21.009244 kernel: loop: module loaded Mar 2 11:38:21.009249 kernel: loop0: detected capacity change from 0 to 92008 Mar 2 11:38:21.009254 kernel: squashfs: version 4.0 (2009/01/31) Phillip Lougher Mar 2 11:38:21.009260 systemd[1]: Successfully made /usr/ read-only. Mar 2 11:38:21.009268 systemd[1]: systemd 257.10 running in system mode (+PAM +AUDIT +SELINUX -APPARMOR +IMA +IPE +SMACK +SECCOMP -GCRYPT -GNUTLS +OPENSSL -ACL +BLKID +CURL +ELFUTILS -FIDO2 +IDN2 -IDN +IPTC +KMOD +LIBCRYPTSETUP +LIBCRYPTSETUP_PLUGINS +LIBFDISK +PCRE2 -PWQUALITY -P11KIT -QRENCODE +TPM2 +BZIP2 +LZ4 +XZ +ZLIB +ZSTD -BPF_FRAMEWORK -BTF -XKBCOMMON +UTMP -SYSVINIT +LIBARCHIVE) Mar 2 11:38:21.009273 systemd[1]: Detected virtualization microsoft. Mar 2 11:38:21.009279 systemd[1]: Detected architecture arm64. Mar 2 11:38:21.009285 systemd[1]: Running in initrd. Mar 2 11:38:21.009290 systemd[1]: No hostname configured, using default hostname. Mar 2 11:38:21.009295 systemd[1]: Hostname set to . Mar 2 11:38:21.009300 systemd[1]: Initializing machine ID from random generator. Mar 2 11:38:21.009305 systemd[1]: Queued start job for default target initrd.target. Mar 2 11:38:21.009311 systemd[1]: Unnecessary job was removed for dev-mapper-usr.device - /dev/mapper/usr. Mar 2 11:38:21.009316 systemd[1]: Started clevis-luks-askpass.path - Forward Password Requests to Clevis Directory Watch. Mar 2 11:38:21.009322 systemd[1]: Started systemd-ask-password-console.path - Dispatch Password Requests to Console Directory Watch. Mar 2 11:38:21.009328 systemd[1]: Expecting device dev-disk-by\x2dlabel-EFI\x2dSYSTEM.device - /dev/disk/by-label/EFI-SYSTEM... Mar 2 11:38:21.009334 systemd[1]: Expecting device dev-disk-by\x2dlabel-OEM.device - /dev/disk/by-label/OEM... Mar 2 11:38:21.009339 systemd[1]: Expecting device dev-disk-by\x2dlabel-ROOT.device - /dev/disk/by-label/ROOT... Mar 2 11:38:21.009345 systemd[1]: Expecting device dev-disk-by\x2dpartlabel-USR\x2dA.device - /dev/disk/by-partlabel/USR-A... Mar 2 11:38:21.009351 systemd[1]: Reached target cryptsetup-pre.target - Local Encrypted Volumes (Pre). Mar 2 11:38:21.009357 systemd[1]: Reached target cryptsetup.target - Local Encrypted Volumes. Mar 2 11:38:21.009362 systemd[1]: Reached target initrd-usr-fs.target - Initrd /usr File System. Mar 2 11:38:21.009367 systemd[1]: Reached target paths.target - Path Units. Mar 2 11:38:21.009372 systemd[1]: Reached target slices.target - Slice Units. Mar 2 11:38:21.009378 systemd[1]: Reached target swap.target - Swaps. Mar 2 11:38:21.009383 systemd[1]: Reached target timers.target - Timer Units. Mar 2 11:38:21.009389 systemd[1]: Listening on iscsid.socket - Open-iSCSI iscsid Socket. Mar 2 11:38:21.009394 systemd[1]: Listening on iscsiuio.socket - Open-iSCSI iscsiuio Socket. Mar 2 11:38:21.009400 systemd[1]: Listening on systemd-journald-audit.socket - Journal Audit Socket. Mar 2 11:38:21.009405 systemd[1]: Listening on systemd-journald-dev-log.socket - Journal Socket (/dev/log). Mar 2 11:38:21.009415 systemd[1]: Listening on systemd-journald.socket - Journal Sockets. Mar 2 11:38:21.009452 systemd[1]: Listening on systemd-networkd.socket - Network Service Netlink Socket. Mar 2 11:38:21.009458 systemd[1]: Listening on systemd-udevd-control.socket - udev Control Socket. Mar 2 11:38:21.009463 systemd[1]: Listening on systemd-udevd-kernel.socket - udev Kernel Socket. Mar 2 11:38:21.009469 systemd[1]: Reached target sockets.target - Socket Units. Mar 2 11:38:21.009475 systemd[1]: afterburn-network-kargs.service - Afterburn Initrd Setup Network Kernel Arguments was skipped because no trigger condition checks were met. Mar 2 11:38:21.009480 systemd[1]: Starting ignition-setup-pre.service - Ignition env setup... Mar 2 11:38:21.009486 systemd[1]: Starting kmod-static-nodes.service - Create List of Static Device Nodes... Mar 2 11:38:21.009492 systemd[1]: Finished network-cleanup.service - Network Cleanup. Mar 2 11:38:21.009498 systemd[1]: systemd-battery-check.service - Check battery level during early boot was skipped because of an unmet condition check (ConditionDirectoryNotEmpty=/sys/class/power_supply). Mar 2 11:38:21.009504 systemd[1]: Starting systemd-fsck-usr.service... Mar 2 11:38:21.009509 systemd[1]: Starting systemd-journald.service - Journal Service... Mar 2 11:38:21.009514 systemd[1]: Starting systemd-modules-load.service - Load Kernel Modules... Mar 2 11:38:21.009521 systemd[1]: Starting systemd-vconsole-setup.service - Virtual Console Setup... Mar 2 11:38:21.009543 systemd-journald[506]: Collecting audit messages is enabled. Mar 2 11:38:21.009557 systemd[1]: Finished ignition-setup-pre.service - Ignition env setup. Mar 2 11:38:21.009564 systemd-journald[506]: Journal started Mar 2 11:38:21.009578 systemd-journald[506]: Runtime Journal (/run/log/journal/b5caad94ef2e419885d2b2b64e692d21) is 8M, max 78.3M, 70.3M free. Mar 2 11:38:21.012000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=ignition-setup-pre comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Mar 2 11:38:21.028438 kernel: audit: type=1130 audit(1772451501.012:2): 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' Mar 2 11:38:21.028477 systemd[1]: Started systemd-journald.service - Journal Service. Mar 2 11:38:21.035000 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' Mar 2 11:38:21.036545 systemd[1]: Finished kmod-static-nodes.service - Create List of Static Device Nodes. Mar 2 11:38:21.075365 kernel: audit: type=1130 audit(1772451501.035: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' Mar 2 11:38:21.075389 kernel: audit: type=1130 audit(1772451501.055:4): pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=kmod-static-nodes comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Mar 2 11:38:21.055000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=kmod-static-nodes comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Mar 2 11:38:21.056929 systemd[1]: Finished systemd-fsck-usr.service. Mar 2 11:38:21.080671 systemd[1]: Starting systemd-tmpfiles-setup-dev-early.service - Create Static Device Nodes in /dev gracefully... Mar 2 11:38:21.110680 kernel: bridge: filtering via arp/ip/ip6tables is no longer available by default. Update your scripts to load br_netfilter if you need this. Mar 2 11:38:21.110704 kernel: audit: type=1130 audit(1772451501.077:5): pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=systemd-fsck-usr comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Mar 2 11:38:21.110713 kernel: Bridge firewalling registered Mar 2 11:38:21.077000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=systemd-fsck-usr comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Mar 2 11:38:21.115792 systemd-modules-load[508]: Inserted module 'br_netfilter' Mar 2 11:38:21.118869 systemd[1]: Starting systemd-tmpfiles-setup.service - Create System Files and Directories... Mar 2 11:38:21.129455 systemd[1]: Finished systemd-modules-load.service - Load Kernel Modules. Mar 2 11:38:21.141000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=systemd-modules-load comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Mar 2 11:38:21.160522 kernel: audit: type=1130 audit(1772451501.141:6): 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' Mar 2 11:38:21.155151 systemd[1]: Finished systemd-vconsole-setup.service - Virtual Console Setup. Mar 2 11:38:21.161997 systemd-tmpfiles[519]: /usr/lib/tmpfiles.d/var.conf:14: Duplicate line for path "/var/log", ignoring. Mar 2 11:38:21.170000 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' Mar 2 11:38:21.184445 kernel: audit: type=1130 audit(1772451501.170:7): pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=systemd-vconsole-setup comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Mar 2 11:38:21.184577 systemd[1]: Finished systemd-tmpfiles-setup-dev-early.service - Create Static Device Nodes in /dev gracefully. Mar 2 11:38:21.194000 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' Mar 2 11:38:21.214342 kernel: audit: type=1130 audit(1772451501.194:8): pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=systemd-tmpfiles-setup-dev-early comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Mar 2 11:38:21.209417 systemd[1]: Finished systemd-tmpfiles-setup.service - Create System Files and Directories. Mar 2 11:38:21.213000 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' Mar 2 11:38:21.231216 systemd[1]: Starting dracut-cmdline-ask.service - dracut ask for additional cmdline parameters... Mar 2 11:38:21.248509 kernel: audit: type=1130 audit(1772451501.213:9): 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' Mar 2 11:38:21.238836 systemd[1]: Starting systemd-sysctl.service - Apply Kernel Variables... Mar 2 11:38:21.253079 systemd[1]: Starting systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev... Mar 2 11:38:21.279531 systemd[1]: Finished systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev. Mar 2 11:38:21.284000 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' Mar 2 11:38:21.303365 systemd[1]: Finished systemd-sysctl.service - Apply Kernel Variables. Mar 2 11:38:21.311964 kernel: audit: type=1130 audit(1772451501.284:10): 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' Mar 2 11:38:21.306000 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' Mar 2 11:38:21.308031 systemd[1]: Finished dracut-cmdline-ask.service - dracut ask for additional cmdline parameters. Mar 2 11:38:21.316000 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' Mar 2 11:38:21.319595 systemd[1]: Starting dracut-cmdline.service - dracut cmdline hook... Mar 2 11:38:21.351483 systemd[1]: Starting systemd-resolved.service - Network Name Resolution... Mar 2 11:38:21.349000 audit: BPF prog-id=6 op=LOAD Mar 2 11:38:21.366951 dracut-cmdline[543]: dracut-109 Mar 2 11:38:21.374215 dracut-cmdline[543]: 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=e623746597ba418b3a52820ac96c047772e1184cf7a15653efffd08c53838c94 Mar 2 11:38:21.432754 systemd-resolved[545]: Positive Trust Anchors: Mar 2 11:38:21.432769 systemd-resolved[545]: . IN DS 20326 8 2 e06d44b80b8f1d39a95c0b0d7c65d08458e880409bbc683457104237c7f8ec8d Mar 2 11:38:21.432772 systemd-resolved[545]: . IN DS 38696 8 2 683d2d0acb8c9b712a1948b27f741219298d0a450d612c483af444a4c0fb2b16 Mar 2 11:38:21.432791 systemd-resolved[545]: 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 Mar 2 11:38:21.450142 systemd-resolved[545]: Defaulting to hostname 'linux'. Mar 2 11:38:21.480000 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' Mar 2 11:38:21.450907 systemd[1]: Started systemd-resolved.service - Network Name Resolution. Mar 2 11:38:21.481853 systemd[1]: Reached target nss-lookup.target - Host and Network Name Lookups. Mar 2 11:38:21.551447 kernel: Loading iSCSI transport class v2.0-870. Mar 2 11:38:21.571449 kernel: iscsi: registered transport (tcp) Mar 2 11:38:21.591218 kernel: iscsi: registered transport (qla4xxx) Mar 2 11:38:21.591233 kernel: QLogic iSCSI HBA Driver Mar 2 11:38:21.622474 systemd[1]: Starting systemd-network-generator.service - Generate network units from Kernel command line... Mar 2 11:38:21.645601 systemd[1]: Finished systemd-network-generator.service - Generate network units from Kernel command line. Mar 2 11:38:21.650000 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' Mar 2 11:38:21.651928 systemd[1]: Reached target network-pre.target - Preparation for Network. Mar 2 11:38:21.704619 systemd[1]: Finished dracut-cmdline.service - dracut cmdline hook. Mar 2 11:38:21.711000 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' Mar 2 11:38:21.714593 systemd[1]: Starting dracut-pre-udev.service - dracut pre-udev hook... Mar 2 11:38:21.725341 systemd[1]: Starting parse-ip-for-networkd.service - Write systemd-networkd units from cmdline... Mar 2 11:38:21.757138 systemd[1]: Finished dracut-pre-udev.service - dracut pre-udev hook. Mar 2 11:38:21.765000 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' Mar 2 11:38:21.766000 audit: BPF prog-id=7 op=LOAD Mar 2 11:38:21.766000 audit: BPF prog-id=8 op=LOAD Mar 2 11:38:21.768189 systemd[1]: Starting systemd-udevd.service - Rule-based Manager for Device Events and Files... Mar 2 11:38:21.817601 systemd-udevd[792]: Using default interface naming scheme 'v257'. Mar 2 11:38:21.821870 systemd[1]: Finished parse-ip-for-networkd.service - Write systemd-networkd units from cmdline. Mar 2 11:38:21.831000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=parse-ip-for-networkd comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Mar 2 11:38:21.832673 systemd[1]: Started systemd-udevd.service - Rule-based Manager for Device Events and Files. Mar 2 11:38:21.836000 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' Mar 2 11:38:21.840511 systemd[1]: Starting dracut-pre-trigger.service - dracut pre-trigger hook... Mar 2 11:38:21.857000 audit: BPF prog-id=9 op=LOAD Mar 2 11:38:21.859611 systemd[1]: Starting systemd-networkd.service - Network Configuration... Mar 2 11:38:21.869625 dracut-pre-trigger[877]: rd.md=0: removing MD RAID activation Mar 2 11:38:21.890499 systemd[1]: Finished dracut-pre-trigger.service - dracut pre-trigger hook. Mar 2 11:38:21.895000 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' Mar 2 11:38:21.901991 systemd[1]: Starting systemd-udev-trigger.service - Coldplug All udev Devices... Mar 2 11:38:21.921529 systemd-networkd[878]: lo: Link UP Mar 2 11:38:21.921535 systemd-networkd[878]: lo: Gained carrier Mar 2 11:38:21.930000 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' Mar 2 11:38:21.924227 systemd[1]: Started systemd-networkd.service - Network Configuration. Mar 2 11:38:21.931681 systemd[1]: Reached target network.target - Network. Mar 2 11:38:21.954249 systemd[1]: Finished systemd-udev-trigger.service - Coldplug All udev Devices. Mar 2 11:38:21.964000 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' Mar 2 11:38:21.967223 systemd[1]: Starting dracut-initqueue.service - dracut initqueue hook... Mar 2 11:38:22.044449 kernel: hv_vmbus: registering driver hv_netvsc Mar 2 11:38:22.051436 kernel: hv_storvsc f8b3781a-1e82-4818-a1c3-63d806ec15bb: tag#67 cmd 0x85 status: scsi 0x2 srb 0x6 hv 0xc0000001 Mar 2 11:38:22.066646 systemd[1]: systemd-vconsole-setup.service: Deactivated successfully. Mar 2 11:38:22.072630 systemd[1]: Stopped systemd-vconsole-setup.service - Virtual Console Setup. Mar 2 11:38:22.077000 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' Mar 2 11:38:22.079350 systemd[1]: Stopping systemd-vconsole-setup.service - Virtual Console Setup... Mar 2 11:38:22.091618 systemd[1]: Starting systemd-vconsole-setup.service - Virtual Console Setup... Mar 2 11:38:22.117664 systemd[1]: Finished systemd-vconsole-setup.service - Virtual Console Setup. Mar 2 11:38:22.130000 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' Mar 2 11:38:22.134254 kernel: hv_netvsc 000d3afb-860e-000d-3afb-860e000d3afb eth0: VF slot 1 added Mar 2 11:38:22.143947 systemd-networkd[878]: eth0: Found matching .network file, based on potentially unpredictable interface name: /usr/lib/systemd/network/zz-default.network Mar 2 11:38:22.157751 kernel: hv_vmbus: registering driver hv_pci Mar 2 11:38:22.157772 kernel: hv_pci 84ada0f0-f3af-423b-9de3-3aac2bdc9e53: PCI VMBus probing: Using version 0x10004 Mar 2 11:38:22.143954 systemd-networkd[878]: eth0: Configuring with /usr/lib/systemd/network/zz-default.network. Mar 2 11:38:22.156743 systemd-networkd[878]: eth0: Link UP Mar 2 11:38:22.156872 systemd-networkd[878]: eth0: Gained carrier Mar 2 11:38:22.190582 kernel: hv_pci 84ada0f0-f3af-423b-9de3-3aac2bdc9e53: PCI host bridge to bus f3af:00 Mar 2 11:38:22.190932 kernel: pci_bus f3af:00: root bus resource [mem 0xfc0000000-0xfc00fffff window] Mar 2 11:38:22.191135 kernel: pci_bus f3af:00: No busn resource found for root bus, will use [bus 00-ff] Mar 2 11:38:22.156884 systemd-networkd[878]: eth0: Found matching .network file, based on potentially unpredictable interface name: /usr/lib/systemd/network/zz-default.network Mar 2 11:38:22.204600 kernel: pci f3af:00:02.0: [15b3:101a] type 00 class 0x020000 PCIe Endpoint Mar 2 11:38:22.191529 systemd-networkd[878]: eth0: DHCPv4 address 10.200.20.34/24, gateway 10.200.20.1 acquired from 168.63.129.16 Mar 2 11:38:22.220677 kernel: pci f3af:00:02.0: BAR 0 [mem 0xfc0000000-0xfc00fffff 64bit pref] Mar 2 11:38:22.225470 kernel: pci f3af:00:02.0: enabling Extended Tags Mar 2 11:38:22.240743 kernel: pci f3af:00:02.0: 0.000 Gb/s available PCIe bandwidth, limited by Unknown x0 link at f3af:00:02.0 (capable of 252.048 Gb/s with 16.0 GT/s PCIe x16 link) Mar 2 11:38:22.252435 kernel: pci_bus f3af:00: busn_res: [bus 00-ff] end is updated to 00 Mar 2 11:38:22.252612 kernel: pci f3af:00:02.0: BAR 0 [mem 0xfc0000000-0xfc00fffff 64bit pref]: assigned Mar 2 11:38:22.265858 systemd[1]: Found device dev-disk-by\x2dpartlabel-USR\x2dA.device - Virtual_Disk USR-A. Mar 2 11:38:22.280000 systemd[1]: Starting disk-uuid.service - Generate new UUID for disk GPT if necessary... Mar 2 11:38:22.327737 systemd[1]: Found device dev-disk-by\x2dlabel-EFI\x2dSYSTEM.device - Virtual_Disk EFI-SYSTEM. Mar 2 11:38:22.357562 systemd[1]: Found device dev-disk-by\x2dlabel-OEM.device - Virtual_Disk OEM. Mar 2 11:38:22.382388 systemd[1]: Found device dev-disk-by\x2dlabel-ROOT.device - Virtual_Disk ROOT. Mar 2 11:38:22.495488 kernel: mlx5_core f3af:00:02.0: enabling device (0000 -> 0002) Mar 2 11:38:22.509707 kernel: mlx5_core f3af:00:02.0: PTM is not supported by PCIe Mar 2 11:38:22.509920 kernel: mlx5_core f3af:00:02.0: firmware version: 16.30.5026 Mar 2 11:38:22.687267 kernel: hv_netvsc 000d3afb-860e-000d-3afb-860e000d3afb eth0: VF registering: eth1 Mar 2 11:38:22.687518 kernel: mlx5_core f3af:00:02.0 eth1: joined to eth0 Mar 2 11:38:22.694449 kernel: mlx5_core f3af:00:02.0: MLX5E: StrdRq(1) RqSz(8) StrdSz(2048) RxCqeCmprss(0 basic) Mar 2 11:38:22.706455 kernel: mlx5_core f3af:00:02.0 enP62383s1: renamed from eth1 Mar 2 11:38:22.706720 systemd-networkd[878]: eth1: Interface name change detected, renamed to enP62383s1. Mar 2 11:38:22.725468 systemd[1]: Finished dracut-initqueue.service - dracut initqueue hook. Mar 2 11:38:22.729000 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' Mar 2 11:38:22.730962 systemd[1]: Reached target remote-fs-pre.target - Preparation for Remote File Systems. Mar 2 11:38:22.740130 systemd[1]: Reached target remote-cryptsetup.target - Remote Encrypted Volumes. Mar 2 11:38:22.751143 systemd[1]: Reached target remote-fs.target - Remote File Systems. Mar 2 11:38:22.762313 systemd[1]: Starting dracut-pre-mount.service - dracut pre-mount hook... Mar 2 11:38:22.791604 systemd[1]: Finished dracut-pre-mount.service - dracut pre-mount hook. Mar 2 11:38:22.799000 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' Mar 2 11:38:22.842446 kernel: mlx5_core f3af:00:02.0 enP62383s1: Link up Mar 2 11:38:22.877874 systemd-networkd[878]: enP62383s1: Link UP Mar 2 11:38:22.881191 kernel: hv_netvsc 000d3afb-860e-000d-3afb-860e000d3afb eth0: Data path switched to VF: enP62383s1 Mar 2 11:38:23.159696 systemd-networkd[878]: enP62383s1: Gained carrier Mar 2 11:38:23.419576 disk-uuid[1013]: Warning: The kernel is still using the old partition table. Mar 2 11:38:23.419576 disk-uuid[1013]: The new table will be used at the next reboot or after you Mar 2 11:38:23.419576 disk-uuid[1013]: run partprobe(8) or kpartx(8) Mar 2 11:38:23.419576 disk-uuid[1013]: The operation has completed successfully. Mar 2 11:38:23.433000 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' Mar 2 11:38:23.433000 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' Mar 2 11:38:23.425911 systemd[1]: disk-uuid.service: Deactivated successfully. Mar 2 11:38:23.426207 systemd[1]: Finished disk-uuid.service - Generate new UUID for disk GPT if necessary. Mar 2 11:38:23.435734 systemd[1]: Starting ignition-setup.service - Ignition (setup)... Mar 2 11:38:23.485613 kernel: BTRFS: device label OEM devid 1 transid 11 /dev/sda6 (8:6) scanned by mount (1147) Mar 2 11:38:23.485663 kernel: BTRFS info (device sda6): first mount of filesystem ded0fcf5-478b-40d5-ab09-e0f1e80cd10e Mar 2 11:38:23.494703 kernel: BTRFS info (device sda6): using crc32c (crc32c-generic) checksum algorithm Mar 2 11:38:23.522182 kernel: BTRFS info (device sda6): turning on async discard Mar 2 11:38:23.522231 kernel: BTRFS info (device sda6): enabling free space tree Mar 2 11:38:23.533450 kernel: BTRFS info (device sda6): last unmount of filesystem ded0fcf5-478b-40d5-ab09-e0f1e80cd10e Mar 2 11:38:23.534446 systemd[1]: Finished ignition-setup.service - Ignition (setup). Mar 2 11:38:23.537000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=ignition-setup comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Mar 2 11:38:23.539586 systemd[1]: Starting ignition-fetch-offline.service - Ignition (fetch-offline)... Mar 2 11:38:23.819834 ignition[1166]: Ignition 2.24.0 Mar 2 11:38:23.822557 ignition[1166]: Stage: fetch-offline Mar 2 11:38:23.822716 ignition[1166]: no configs at "/usr/lib/ignition/base.d" Mar 2 11:38:23.839708 kernel: kauditd_printk_skb: 22 callbacks suppressed Mar 2 11:38:23.839730 kernel: audit: type=1130 audit(1772451503.831:33): 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' Mar 2 11:38:23.831000 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' Mar 2 11:38:23.826324 systemd[1]: Finished ignition-fetch-offline.service - Ignition (fetch-offline). Mar 2 11:38:23.822725 ignition[1166]: no config dir at "/usr/lib/ignition/base.platform.d/azure" Mar 2 11:38:23.834260 systemd[1]: Starting ignition-fetch.service - Ignition (fetch)... Mar 2 11:38:23.823878 ignition[1166]: parsed url from cmdline: "" Mar 2 11:38:23.823882 ignition[1166]: no config URL provided Mar 2 11:38:23.823888 ignition[1166]: reading system config file "/usr/lib/ignition/user.ign" Mar 2 11:38:23.823902 ignition[1166]: no config at "/usr/lib/ignition/user.ign" Mar 2 11:38:23.823906 ignition[1166]: failed to fetch config: resource requires networking Mar 2 11:38:23.824211 ignition[1166]: Ignition finished successfully Mar 2 11:38:23.884817 ignition[1174]: Ignition 2.24.0 Mar 2 11:38:23.884822 ignition[1174]: Stage: fetch Mar 2 11:38:23.885040 ignition[1174]: no configs at "/usr/lib/ignition/base.d" Mar 2 11:38:23.885047 ignition[1174]: no config dir at "/usr/lib/ignition/base.platform.d/azure" Mar 2 11:38:23.885118 ignition[1174]: parsed url from cmdline: "" Mar 2 11:38:23.885120 ignition[1174]: no config URL provided Mar 2 11:38:23.885124 ignition[1174]: reading system config file "/usr/lib/ignition/user.ign" Mar 2 11:38:23.885129 ignition[1174]: no config at "/usr/lib/ignition/user.ign" Mar 2 11:38:23.885142 ignition[1174]: GET http://169.254.169.254/metadata/instance/compute/userData?api-version=2021-01-01&format=text: attempt #1 Mar 2 11:38:23.935710 systemd-networkd[878]: eth0: Gained IPv6LL Mar 2 11:38:23.962022 ignition[1174]: GET result: OK Mar 2 11:38:23.963151 ignition[1174]: config has been read from IMDS userdata Mar 2 11:38:23.963163 ignition[1174]: parsing config with SHA512: 246f04dd32205ef2a60f97e2df238961a9caea3f532fcf1dd02eb696f5c6fcd8a8ec3acd0865bf351b3a0ea6e7de7c0e26271a589c1864bbb540bde07d2c378a Mar 2 11:38:23.969694 unknown[1174]: fetched base config from "system" Mar 2 11:38:23.975000 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' Mar 2 11:38:23.969829 ignition[1174]: fetch: fetch complete Mar 2 11:38:24.000209 kernel: audit: type=1130 audit(1772451503.975:34): 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' Mar 2 11:38:23.969699 unknown[1174]: fetched base config from "system" Mar 2 11:38:23.969832 ignition[1174]: fetch: fetch passed Mar 2 11:38:23.969703 unknown[1174]: fetched user config from "azure" Mar 2 11:38:23.969865 ignition[1174]: Ignition finished successfully Mar 2 11:38:23.971506 systemd[1]: Finished ignition-fetch.service - Ignition (fetch). Mar 2 11:38:23.977789 systemd[1]: Starting ignition-kargs.service - Ignition (kargs)... Mar 2 11:38:24.026958 ignition[1180]: Ignition 2.24.0 Mar 2 11:38:24.026974 ignition[1180]: Stage: kargs Mar 2 11:38:24.032660 systemd[1]: Finished ignition-kargs.service - Ignition (kargs). Mar 2 11:38:24.036000 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' Mar 2 11:38:24.027165 ignition[1180]: no configs at "/usr/lib/ignition/base.d" Mar 2 11:38:24.062779 kernel: audit: type=1130 audit(1772451504.036:35): 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' Mar 2 11:38:24.038733 systemd[1]: Starting ignition-disks.service - Ignition (disks)... Mar 2 11:38:24.027171 ignition[1180]: no config dir at "/usr/lib/ignition/base.platform.d/azure" Mar 2 11:38:24.027645 ignition[1180]: kargs: kargs passed Mar 2 11:38:24.027684 ignition[1180]: Ignition finished successfully Mar 2 11:38:24.074375 ignition[1186]: Ignition 2.24.0 Mar 2 11:38:24.074380 ignition[1186]: Stage: disks Mar 2 11:38:24.074604 ignition[1186]: no configs at "/usr/lib/ignition/base.d" Mar 2 11:38:24.074612 ignition[1186]: no config dir at "/usr/lib/ignition/base.platform.d/azure" Mar 2 11:38:24.075095 ignition[1186]: disks: createFilesystems: op(1): [started] waiting for devices [/dev/disk/by-partlabel/ROOT] Mar 2 11:38:24.087210 ignition[1186]: disks: createFilesystems: op(1): [finished] waiting for devices [/dev/disk/by-partlabel/ROOT] Mar 2 11:38:24.087283 ignition[1186]: disks: createFilesystems: created device alias for "/dev/disk/by-partlabel/ROOT": "/run/ignition/dev_aliases/dev/disk/by-partlabel/ROOT" -> "/dev/sda9" Mar 2 11:38:24.087313 ignition[1186]: disks: createFilesystems: op(2): [started] determining filesystem type of "/dev/disk/by-partlabel/ROOT" Mar 2 11:38:24.107501 ignition[1186]: disks: createFilesystems: op(2): [finished] determining filesystem type of "/dev/disk/by-partlabel/ROOT" Mar 2 11:38:24.107507 ignition[1186]: disks: createFilesystems: found ext4 filesystem at "/dev/disk/by-partlabel/ROOT" with uuid "afeb0cce-cfb8-440e-81ac-fda78fed3434" and label "ROOT" Mar 2 11:38:24.107664 ignition[1186]: disks: createFilesystems: op(3): [started] wiping filesystem signatures from "/run/ignition/dev_aliases/dev/disk/by-partlabel/ROOT" Mar 2 11:38:24.107669 ignition[1186]: disks: createFilesystems: op(3): executing: "wipefs" "-a" "/run/ignition/dev_aliases/dev/disk/by-partlabel/ROOT" Mar 2 11:38:24.139500 ignition[1186]: disks: createFilesystems: op(3): [finished] wiping filesystem signatures from "/run/ignition/dev_aliases/dev/disk/by-partlabel/ROOT" Mar 2 11:38:24.139566 ignition[1186]: disks: createFilesystems: op(4): [started] creating "btrfs" filesystem on "/run/ignition/dev_aliases/dev/disk/by-partlabel/ROOT" Mar 2 11:38:24.139577 ignition[1186]: disks: createFilesystems: op(4): executing: "mkfs.btrfs" "--label=ROOT" "--uuid=9aa5237a-ab6b-458b-a7e8-f25e2baef1a3" "--force" "/run/ignition/dev_aliases/dev/disk/by-partlabel/ROOT" Mar 2 11:38:44.280545 ignition[1186]: disks: createFilesystems: op(4): [finished] creating "btrfs" filesystem on "/run/ignition/dev_aliases/dev/disk/by-partlabel/ROOT" Mar 2 11:38:44.280594 ignition[1186]: disks: createFilesystems: op(5): [started] waiting for triggered uevent Mar 2 11:38:44.280603 ignition[1186]: disks: createFilesystems: op(5): executing: "udevadm" "trigger" "--settle" "/dev/sda9" Mar 2 11:38:44.577526 ignition[1186]: disks: createFilesystems: op(5): [finished] waiting for triggered uevent Mar 2 11:38:44.577594 ignition[1186]: disks: disks passed Mar 2 11:38:44.583929 ignition[1186]: Ignition finished successfully Mar 2 11:38:44.589000 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' Mar 2 11:38:44.584993 systemd[1]: Finished ignition-disks.service - Ignition (disks). Mar 2 11:38:44.613583 kernel: audit: type=1130 audit(1772451524.589:36): 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' Mar 2 11:38:44.593404 systemd[1]: Reached target initrd-root-device.target - Initrd Root Device. Mar 2 11:38:44.609740 systemd[1]: Reached target local-fs-pre.target - Preparation for Local File Systems. Mar 2 11:38:44.618438 systemd[1]: Reached target local-fs.target - Local File Systems. Mar 2 11:38:44.626567 systemd[1]: Reached target sysinit.target - System Initialization. Mar 2 11:38:44.635323 systemd[1]: Reached target basic.target - Basic System. Mar 2 11:38:44.643465 systemd[1]: Starting systemd-fsck-root.service - File System Check on /dev/disk/by-label/ROOT... Mar 2 11:38:44.676580 systemd[1]: Finished systemd-fsck-root.service - File System Check on /dev/disk/by-label/ROOT. Mar 2 11:38:44.680000 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' Mar 2 11:38:44.682609 systemd[1]: Mounting sysroot.mount - /sysroot... Mar 2 11:38:44.706025 kernel: audit: type=1130 audit(1772451524.680:37): 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' Mar 2 11:38:44.719451 kernel: BTRFS: device label ROOT devid 1 transid 8 /dev/sda9 (8:9) scanned by mount (1230) Mar 2 11:38:44.719494 kernel: BTRFS info (device sda9): first mount of filesystem 9aa5237a-ab6b-458b-a7e8-f25e2baef1a3 Mar 2 11:38:44.728926 kernel: BTRFS info (device sda9): using crc32c (crc32c-generic) checksum algorithm Mar 2 11:38:44.738099 kernel: BTRFS info (device sda9): checking UUID tree Mar 2 11:38:44.738141 kernel: BTRFS info (device sda9): turning on async discard Mar 2 11:38:44.741534 kernel: BTRFS info (device sda9): enabling free space tree Mar 2 11:38:44.742709 systemd[1]: Mounted sysroot.mount - /sysroot. Mar 2 11:38:44.746292 systemd[1]: Reached target initrd-root-fs.target - Initrd Root File System. Mar 2 11:38:44.754107 systemd[1]: Mounting sysroot-oem.mount - /sysroot/oem... Mar 2 11:38:44.770117 systemd[1]: Mounting sysroot-usr.mount - /sysroot/usr... Mar 2 11:38:44.784106 systemd[1]: Starting flatcar-metadata-hostname.service - Flatcar Metadata Hostname Agent... Mar 2 11:38:44.795753 systemd[1]: ignition-remount-sysroot.service - Remount /sysroot read-write for Ignition was skipped because of an unmet condition check (ConditionPathIsReadWrite=!/sysroot). Mar 2 11:38:44.810123 kernel: BTRFS: device label OEM devid 1 transid 11 /dev/sda6 (8:6) scanned by mount (1248) Mar 2 11:38:44.795792 systemd[1]: Reached target ignition-diskful.target - Ignition Boot Disk Setup. Mar 2 11:38:44.815963 systemd[1]: Mounted sysroot-usr.mount - /sysroot/usr. Mar 2 11:38:44.836391 kernel: BTRFS info (device sda6): first mount of filesystem ded0fcf5-478b-40d5-ab09-e0f1e80cd10e Mar 2 11:38:44.836447 kernel: BTRFS info (device sda6): using crc32c (crc32c-generic) checksum algorithm Mar 2 11:38:44.838488 systemd[1]: Starting initrd-setup-root.service - Root filesystem setup... Mar 2 11:38:44.857016 kernel: BTRFS info (device sda6): turning on async discard Mar 2 11:38:44.857039 kernel: BTRFS info (device sda6): enabling free space tree Mar 2 11:38:44.858865 systemd[1]: Mounted sysroot-oem.mount - /sysroot/oem. Mar 2 11:38:44.936048 coreos-metadata[1250]: Mar 02 11:38:44.935 INFO Fetching http://168.63.129.16/?comp=versions: Attempt #1 Mar 2 11:38:44.944600 coreos-metadata[1250]: Mar 02 11:38:44.944 INFO Fetch successful Mar 2 11:38:44.949007 coreos-metadata[1250]: Mar 02 11:38:44.948 INFO Fetching http://169.254.169.254/metadata/instance/compute/name?api-version=2017-08-01&format=text: Attempt #1 Mar 2 11:38:44.958094 coreos-metadata[1250]: Mar 02 11:38:44.957 INFO Fetch successful Mar 2 11:38:44.958094 coreos-metadata[1250]: Mar 02 11:38:44.957 INFO wrote hostname ci-9999.9.9-m-93217899aa to /sysroot/etc/hostname Mar 2 11:38:44.966000 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' Mar 2 11:38:44.960678 systemd[1]: Finished flatcar-metadata-hostname.service - Flatcar Metadata Hostname Agent. Mar 2 11:38:44.991698 kernel: audit: type=1130 audit(1772451524.966:38): 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' Mar 2 11:38:45.129387 systemd[1]: Finished initrd-setup-root.service - Root filesystem setup. Mar 2 11:38:45.133000 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' Mar 2 11:38:45.151325 systemd[1]: Starting ignition-mount.service - Ignition (mount)... Mar 2 11:38:45.162540 kernel: audit: type=1130 audit(1772451525.133:39): 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' Mar 2 11:38:45.156311 systemd[1]: Starting sysroot-boot.service - /sysroot/boot... Mar 2 11:38:45.180983 systemd[1]: sysroot-oem.mount: Deactivated successfully. Mar 2 11:38:45.190442 kernel: BTRFS info (device sda6): last unmount of filesystem ded0fcf5-478b-40d5-ab09-e0f1e80cd10e Mar 2 11:38:45.209630 ignition[1352]: INFO : Ignition 2.24.0 Mar 2 11:38:45.209630 ignition[1352]: INFO : Stage: mount Mar 2 11:38:45.218733 ignition[1352]: INFO : no configs at "/usr/lib/ignition/base.d" Mar 2 11:38:45.218733 ignition[1352]: INFO : no config dir at "/usr/lib/ignition/base.platform.d/azure" Mar 2 11:38:45.218733 ignition[1352]: INFO : mount: op(1): [started] mounting "/dev/disk/by-partlabel/ROOT" at "/sysroot/tmp/_translate-filesystem-0-ign1" with type "btrfs" and options "" Mar 2 11:38:45.218733 ignition[1352]: DEBUG : mount: op(1): executing: "mount" "-o" "" "-t" "btrfs" "/dev/disk/by-partlabel/ROOT" "/sysroot/tmp/_translate-filesystem-0-ign1" Mar 2 11:38:45.218733 ignition[1352]: INFO : mount: op(1): [finished] mounting "/dev/disk/by-partlabel/ROOT" at "/sysroot/tmp/_translate-filesystem-0-ign1" with type "btrfs" and options "" Mar 2 11:38:45.218733 ignition[1352]: INFO : mount: mount passed Mar 2 11:38:45.218733 ignition[1352]: INFO : Ignition finished successfully Mar 2 11:38:45.303355 kernel: audit: type=1130 audit(1772451525.221:40): 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' Mar 2 11:38:45.303379 kernel: audit: type=1130 audit(1772451525.242:41): pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=sysroot-boot comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Mar 2 11:38:45.221000 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' Mar 2 11:38:45.242000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=sysroot-boot comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Mar 2 11:38:45.216337 systemd[1]: Finished ignition-mount.service - Ignition (mount). Mar 2 11:38:45.223398 systemd[1]: Finished sysroot-boot.service - /sysroot/boot. Mar 2 11:38:45.244645 systemd[1]: Starting ignition-files.service - Ignition (files)... Mar 2 11:38:45.745613 systemd[1]: Mounting sysroot-oem.mount - /sysroot/oem... Mar 2 11:38:45.778435 kernel: BTRFS: device label OEM devid 1 transid 11 /dev/sda6 (8:6) scanned by mount (1365) Mar 2 11:38:45.789436 kernel: BTRFS info (device sda6): first mount of filesystem ded0fcf5-478b-40d5-ab09-e0f1e80cd10e Mar 2 11:38:45.789492 kernel: BTRFS info (device sda6): using crc32c (crc32c-generic) checksum algorithm Mar 2 11:38:45.800211 kernel: BTRFS info (device sda6): turning on async discard Mar 2 11:38:45.800274 kernel: BTRFS info (device sda6): enabling free space tree Mar 2 11:38:45.802285 systemd[1]: Mounted sysroot-oem.mount - /sysroot/oem. Mar 2 11:38:45.830930 ignition[1383]: INFO : Ignition 2.24.0 Mar 2 11:38:45.830930 ignition[1383]: INFO : Stage: files Mar 2 11:38:45.837344 ignition[1383]: INFO : no configs at "/usr/lib/ignition/base.d" Mar 2 11:38:45.837344 ignition[1383]: INFO : no config dir at "/usr/lib/ignition/base.platform.d/azure" Mar 2 11:38:45.837344 ignition[1383]: DEBUG : files: compiled without relabeling support, skipping Mar 2 11:38:45.837344 ignition[1383]: INFO : files: ensureUsers: op(1): [started] creating or modifying user "core" Mar 2 11:38:45.837344 ignition[1383]: DEBUG : files: ensureUsers: op(1): executing: "usermod" "--root" "/sysroot" "core" Mar 2 11:38:45.865572 ignition[1383]: INFO : files: ensureUsers: op(1): [finished] creating or modifying user "core" Mar 2 11:38:45.865572 ignition[1383]: INFO : files: ensureUsers: op(2): [started] adding ssh keys to user "core" Mar 2 11:38:45.865572 ignition[1383]: INFO : files: ensureUsers: op(2): [finished] adding ssh keys to user "core" Mar 2 11:38:45.865572 ignition[1383]: INFO : files: createFilesystemsFiles: createFiles: op(3): [started] writing file "/sysroot/tmp/_translate-filesystem-0-ign1/etc/flatcar/update.conf" Mar 2 11:38:45.865572 ignition[1383]: INFO : files: createFilesystemsFiles: createFiles: op(3): [finished] writing file "/sysroot/tmp/_translate-filesystem-0-ign1/etc/flatcar/update.conf" Mar 2 11:38:45.865572 ignition[1383]: INFO : files: createResultFile: createFiles: op(4): [started] writing file "/sysroot/etc/.ignition-result.json" Mar 2 11:38:45.865572 ignition[1383]: INFO : files: createResultFile: createFiles: op(4): [finished] writing file "/sysroot/etc/.ignition-result.json" Mar 2 11:38:45.865572 ignition[1383]: INFO : files: files passed Mar 2 11:38:45.865572 ignition[1383]: INFO : Ignition finished successfully Mar 2 11:38:45.956180 kernel: audit: type=1130 audit(1772451525.874:42): pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=ignition-files comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Mar 2 11:38:45.874000 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' Mar 2 11:38:45.858511 unknown[1383]: wrote ssh authorized keys file for user: core Mar 2 11:38:45.960000 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' Mar 2 11:38:45.867690 systemd[1]: Finished ignition-files.service - Ignition (files). Mar 2 11:38:45.994008 kernel: audit: type=1130 audit(1772451525.960:43): pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=ignition-quench comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Mar 2 11:38:45.994036 kernel: audit: type=1131 audit(1772451525.976:44): pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=ignition-quench comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Mar 2 11:38:45.976000 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' Mar 2 11:38:45.894130 systemd[1]: Starting ignition-quench.service - Ignition (record completion)... Mar 2 11:38:45.935453 systemd[1]: Starting initrd-setup-root-after-ignition.service - Root filesystem completion... Mar 2 11:38:45.952675 systemd[1]: ignition-quench.service: Deactivated successfully. Mar 2 11:38:45.954446 systemd[1]: Finished ignition-quench.service - Ignition (record completion). Mar 2 11:38:46.023443 kernel: BTRFS info (device sda9): setting incompat feature flag for COMPRESS_ZSTD (0x10) Mar 2 11:38:46.029091 initrd-setup-root-after-ignition[1414]: grep: /sysroot/etc/flatcar/enabled-sysext.conf: No such file or directory Mar 2 11:38:46.041522 initrd-setup-root-after-ignition[1418]: grep: /sysroot/etc/flatcar/enabled-sysext.conf: No such file or directory Mar 2 11:38:46.041000 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' Mar 2 11:38:46.037131 systemd[1]: Finished initrd-setup-root-after-ignition.service - Root filesystem completion. Mar 2 11:38:46.072107 kernel: audit: type=1130 audit(1772451526.041:45): pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=initrd-setup-root-after-ignition comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Mar 2 11:38:46.072135 initrd-setup-root-after-ignition[1414]: grep: /sysroot/usr/share/flatcar/enabled-sysext.conf: No such file or directory Mar 2 11:38:46.042797 systemd[1]: Reached target ignition-complete.target - Ignition Complete. Mar 2 11:38:46.073604 systemd[1]: Starting initrd-parse-etc.service - Mountpoints Configured in the Real Root... Mar 2 11:38:46.127045 systemd[1]: initrd-parse-etc.service: Deactivated successfully. Mar 2 11:38:46.131000 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' Mar 2 11:38:46.131000 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' Mar 2 11:38:46.127141 systemd[1]: Finished initrd-parse-etc.service - Mountpoints Configured in the Real Root. Mar 2 11:38:46.133391 systemd[1]: Reached target initrd-fs.target - Initrd File Systems. Mar 2 11:38:46.141907 systemd[1]: Reached target initrd.target - Initrd Default Target. Mar 2 11:38:46.152451 systemd[1]: dracut-mount.service - dracut mount hook was skipped because no trigger condition checks were met. Mar 2 11:38:46.153301 systemd[1]: Starting dracut-pre-pivot.service - dracut pre-pivot and cleanup hook... Mar 2 11:38:46.192097 systemd[1]: Finished dracut-pre-pivot.service - dracut pre-pivot and cleanup hook. Mar 2 11:38:46.196000 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' Mar 2 11:38:46.199356 systemd[1]: Starting initrd-cleanup.service - Cleaning Up and Shutting Down Daemons... Mar 2 11:38:46.226011 systemd[1]: Unnecessary job was removed for dev-mapper-usr.device - /dev/mapper/usr. Mar 2 11:38:46.226111 systemd[1]: Stopped target nss-lookup.target - Host and Network Name Lookups. Mar 2 11:38:46.236221 systemd[1]: Stopped target remote-cryptsetup.target - Remote Encrypted Volumes. Mar 2 11:38:46.246469 systemd[1]: Stopped target timers.target - Timer Units. Mar 2 11:38:46.254647 systemd[1]: dracut-pre-pivot.service: Deactivated successfully. Mar 2 11:38:46.262000 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' Mar 2 11:38:46.254777 systemd[1]: Stopped dracut-pre-pivot.service - dracut pre-pivot and cleanup hook. Mar 2 11:38:46.267035 systemd[1]: Stopped target initrd.target - Initrd Default Target. Mar 2 11:38:46.271309 systemd[1]: Stopped target basic.target - Basic System. Mar 2 11:38:46.280015 systemd[1]: Stopped target ignition-complete.target - Ignition Complete. Mar 2 11:38:46.288520 systemd[1]: Stopped target ignition-diskful.target - Ignition Boot Disk Setup. Mar 2 11:38:46.296786 systemd[1]: Stopped target initrd-root-device.target - Initrd Root Device. Mar 2 11:38:46.305667 systemd[1]: Stopped target initrd-usr-fs.target - Initrd /usr File System. Mar 2 11:38:46.315750 systemd[1]: Stopped target remote-fs.target - Remote File Systems. Mar 2 11:38:46.325479 systemd[1]: Stopped target remote-fs-pre.target - Preparation for Remote File Systems. Mar 2 11:38:46.334797 systemd[1]: Stopped target sysinit.target - System Initialization. Mar 2 11:38:46.343293 systemd[1]: Stopped target local-fs.target - Local File Systems. Mar 2 11:38:46.352668 systemd[1]: Stopped target swap.target - Swaps. Mar 2 11:38:46.367000 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' Mar 2 11:38:46.360099 systemd[1]: dracut-pre-mount.service: Deactivated successfully. Mar 2 11:38:46.360217 systemd[1]: Stopped dracut-pre-mount.service - dracut pre-mount hook. Mar 2 11:38:46.371251 systemd[1]: Stopped target cryptsetup.target - Local Encrypted Volumes. Mar 2 11:38:46.376082 systemd[1]: Stopped target cryptsetup-pre.target - Local Encrypted Volumes (Pre). Mar 2 11:38:46.402000 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' Mar 2 11:38:46.385021 systemd[1]: clevis-luks-askpass.path: Deactivated successfully. Mar 2 11:38:46.385093 systemd[1]: Stopped clevis-luks-askpass.path - Forward Password Requests to Clevis Directory Watch. Mar 2 11:38:46.416000 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' Mar 2 11:38:46.394335 systemd[1]: dracut-initqueue.service: Deactivated successfully. Mar 2 11:38:46.426000 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' Mar 2 11:38:46.394453 systemd[1]: Stopped dracut-initqueue.service - dracut initqueue hook. Mar 2 11:38:46.436000 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' Mar 2 11:38:46.408372 systemd[1]: initrd-setup-root-after-ignition.service: Deactivated successfully. Mar 2 11:38:46.408486 systemd[1]: Stopped initrd-setup-root-after-ignition.service - Root filesystem completion. Mar 2 11:38:46.418072 systemd[1]: ignition-files.service: Deactivated successfully. Mar 2 11:38:46.418142 systemd[1]: Stopped ignition-files.service - Ignition (files). Mar 2 11:38:46.479546 ignition[1438]: INFO : Ignition 2.24.0 Mar 2 11:38:46.479546 ignition[1438]: INFO : Stage: umount Mar 2 11:38:46.479546 ignition[1438]: INFO : no configs at "/usr/lib/ignition/base.d" Mar 2 11:38:46.479546 ignition[1438]: INFO : no config dir at "/usr/lib/ignition/base.platform.d/azure" Mar 2 11:38:46.479546 ignition[1438]: INFO : umount: op(1): [started] umounting "/sysroot/tmp/_translate-filesystem-0-ign1" Mar 2 11:38:46.479546 ignition[1438]: INFO : umount: op(1): [finished] umounting "/sysroot/tmp/_translate-filesystem-0-ign1" Mar 2 11:38:46.479546 ignition[1438]: INFO : umount: umount passed Mar 2 11:38:46.479546 ignition[1438]: INFO : Ignition finished successfully Mar 2 11:38:46.481000 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' Mar 2 11:38:46.487000 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' Mar 2 11:38:46.495000 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' Mar 2 11:38:46.504000 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' Mar 2 11:38:46.522000 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' Mar 2 11:38:46.522000 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' Mar 2 11:38:46.531000 audit[1]: SERVICE_STOP pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=sysroot-boot comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Mar 2 11:38:46.539000 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' Mar 2 11:38:46.428078 systemd[1]: flatcar-metadata-hostname.service: Deactivated successfully. Mar 2 11:38:46.546000 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' Mar 2 11:38:46.428156 systemd[1]: Stopped flatcar-metadata-hostname.service - Flatcar Metadata Hostname Agent. Mar 2 11:38:46.554000 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' Mar 2 11:38:46.438120 systemd[1]: Stopping ignition-mount.service - Ignition (mount)... Mar 2 11:38:46.462387 systemd[1]: Stopping sysroot-boot.service - /sysroot/boot... Mar 2 11:38:46.572000 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' Mar 2 11:38:46.469732 systemd[1]: systemd-tmpfiles-setup.service: Deactivated successfully. Mar 2 11:38:46.473714 systemd[1]: Stopped systemd-tmpfiles-setup.service - Create System Files and Directories. Mar 2 11:38:46.482879 systemd[1]: systemd-udev-trigger.service: Deactivated successfully. Mar 2 11:38:46.483014 systemd[1]: Stopped systemd-udev-trigger.service - Coldplug All udev Devices. Mar 2 11:38:46.488437 systemd[1]: dracut-pre-trigger.service: Deactivated successfully. Mar 2 11:38:46.488563 systemd[1]: Stopped dracut-pre-trigger.service - dracut pre-trigger hook. Mar 2 11:38:46.498705 systemd[1]: sysroot-tmp-_translate\x2dfilesystem\x2d0\x2dign1.mount: Deactivated successfully. Mar 2 11:38:46.499478 systemd[1]: ignition-mount.service: Deactivated successfully. Mar 2 11:38:46.501013 systemd[1]: Stopped ignition-mount.service - Ignition (mount). Mar 2 11:38:46.506749 systemd[1]: sysroot-boot.mount: Deactivated successfully. Mar 2 11:38:46.648000 audit[1]: SERVICE_STOP pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=ignition-setup comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Mar 2 11:38:46.509887 systemd[1]: initrd-cleanup.service: Deactivated successfully. Mar 2 11:38:46.656000 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' Mar 2 11:38:46.510458 systemd[1]: Finished initrd-cleanup.service - Cleaning Up and Shutting Down Daemons. Mar 2 11:38:46.665000 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' Mar 2 11:38:46.523557 systemd[1]: sysroot-boot.service: Deactivated successfully. Mar 2 11:38:46.523635 systemd[1]: Stopped sysroot-boot.service - /sysroot/boot. Mar 2 11:38:46.533193 systemd[1]: ignition-disks.service: Deactivated successfully. Mar 2 11:38:46.533243 systemd[1]: Stopped ignition-disks.service - Ignition (disks). Mar 2 11:38:46.540334 systemd[1]: ignition-kargs.service: Deactivated successfully. Mar 2 11:38:46.700000 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' Mar 2 11:38:46.540379 systemd[1]: Stopped ignition-kargs.service - Ignition (kargs). Mar 2 11:38:46.708000 audit: BPF prog-id=6 op=UNLOAD Mar 2 11:38:46.547677 systemd[1]: ignition-fetch.service: Deactivated successfully. Mar 2 11:38:46.713000 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' Mar 2 11:38:46.547713 systemd[1]: Stopped ignition-fetch.service - Ignition (fetch). Mar 2 11:38:46.555923 systemd[1]: Stopped target network.target - Network. Mar 2 11:38:46.725000 audit: BPF prog-id=9 op=UNLOAD Mar 2 11:38:46.564216 systemd[1]: ignition-fetch-offline.service: Deactivated successfully. Mar 2 11:38:46.564264 systemd[1]: Stopped ignition-fetch-offline.service - Ignition (fetch-offline). Mar 2 11:38:46.573184 systemd[1]: Stopped target paths.target - Path Units. Mar 2 11:38:46.580627 systemd[1]: systemd-ask-password-console.path: Deactivated successfully. Mar 2 11:38:46.757000 audit[1]: SERVICE_STOP pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=parse-ip-for-networkd comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Mar 2 11:38:46.762000 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' Mar 2 11:38:46.594002 systemd[1]: Stopped systemd-ask-password-console.path - Dispatch Password Requests to Console Directory Watch. Mar 2 11:38:46.771000 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' Mar 2 11:38:46.599159 systemd[1]: Stopped target slices.target - Slice Units. Mar 2 11:38:46.607776 systemd[1]: Stopped target sockets.target - Socket Units. Mar 2 11:38:46.615905 systemd[1]: iscsid.socket: Deactivated successfully. Mar 2 11:38:46.615955 systemd[1]: Closed iscsid.socket - Open-iSCSI iscsid Socket. Mar 2 11:38:46.624290 systemd[1]: iscsiuio.socket: Deactivated successfully. Mar 2 11:38:46.624316 systemd[1]: Closed iscsiuio.socket - Open-iSCSI iscsiuio Socket. Mar 2 11:38:46.633659 systemd[1]: systemd-journald-audit.socket: Deactivated successfully. Mar 2 11:38:46.633675 systemd[1]: Closed systemd-journald-audit.socket - Journal Audit Socket. Mar 2 11:38:46.641744 systemd[1]: ignition-setup.service: Deactivated successfully. Mar 2 11:38:46.820000 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' Mar 2 11:38:46.641792 systemd[1]: Stopped ignition-setup.service - Ignition (setup). Mar 2 11:38:46.649908 systemd[1]: ignition-setup-pre.service: Deactivated successfully. Mar 2 11:38:46.649943 systemd[1]: Stopped ignition-setup-pre.service - Ignition env setup. Mar 2 11:38:46.845000 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' Mar 2 11:38:46.657605 systemd[1]: initrd-setup-root.service: Deactivated successfully. Mar 2 11:38:46.657639 systemd[1]: Stopped initrd-setup-root.service - Root filesystem setup. Mar 2 11:38:46.864614 kernel: hv_netvsc 000d3afb-860e-000d-3afb-860e000d3afb eth0: Data path switched from VF: enP62383s1 Mar 2 11:38:46.666399 systemd[1]: Stopping systemd-networkd.service - Network Configuration... Mar 2 11:38:46.867000 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' Mar 2 11:38:46.675134 systemd[1]: Stopping systemd-resolved.service - Network Name Resolution... Mar 2 11:38:46.692840 systemd[1]: systemd-resolved.service: Deactivated successfully. Mar 2 11:38:46.881000 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' Mar 2 11:38:46.692982 systemd[1]: Stopped systemd-resolved.service - Network Name Resolution. Mar 2 11:38:46.706943 systemd[1]: systemd-networkd.service: Deactivated successfully. Mar 2 11:38:46.707037 systemd[1]: Stopped systemd-networkd.service - Network Configuration. Mar 2 11:38:46.718919 systemd[1]: Stopped target network-pre.target - Preparation for Network. Mar 2 11:38:46.909000 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' Mar 2 11:38:46.726948 systemd[1]: systemd-networkd.socket: Deactivated successfully. Mar 2 11:38:46.924000 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' Mar 2 11:38:46.727002 systemd[1]: Closed systemd-networkd.socket - Network Service Netlink Socket. Mar 2 11:38:46.933000 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' Mar 2 11:38:46.735915 systemd[1]: Stopping network-cleanup.service - Network Cleanup... Mar 2 11:38:46.943000 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' Mar 2 11:38:46.750057 systemd[1]: parse-ip-for-networkd.service: Deactivated successfully. Mar 2 11:38:46.952000 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' Mar 2 11:38:46.750137 systemd[1]: Stopped parse-ip-for-networkd.service - Write systemd-networkd units from cmdline. Mar 2 11:38:46.960000 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' Mar 2 11:38:46.758695 systemd[1]: systemd-sysctl.service: Deactivated successfully. Mar 2 11:38:46.971000 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' Mar 2 11:38:46.971000 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' Mar 2 11:38:46.758742 systemd[1]: Stopped systemd-sysctl.service - Apply Kernel Variables. Mar 2 11:38:46.763380 systemd[1]: systemd-modules-load.service: Deactivated successfully. Mar 2 11:38:46.763416 systemd[1]: Stopped systemd-modules-load.service - Load Kernel Modules. Mar 2 11:38:46.773288 systemd[1]: Stopping systemd-udevd.service - Rule-based Manager for Device Events and Files... Mar 2 11:38:46.812253 systemd[1]: systemd-udevd.service: Deactivated successfully. Mar 2 11:38:46.813638 systemd[1]: Stopped systemd-udevd.service - Rule-based Manager for Device Events and Files. Mar 2 11:38:46.821945 systemd[1]: systemd-udevd-control.socket: Deactivated successfully. Mar 2 11:38:46.821982 systemd[1]: Closed systemd-udevd-control.socket - udev Control Socket. Mar 2 11:38:46.830001 systemd[1]: systemd-udevd-kernel.socket: Deactivated successfully. Mar 2 11:38:46.830041 systemd[1]: Closed systemd-udevd-kernel.socket - udev Kernel Socket. Mar 2 11:38:46.837994 systemd[1]: dracut-pre-udev.service: Deactivated successfully. Mar 2 11:38:46.838040 systemd[1]: Stopped dracut-pre-udev.service - dracut pre-udev hook. Mar 2 11:38:46.850550 systemd[1]: dracut-cmdline.service: Deactivated successfully. Mar 2 11:38:46.850602 systemd[1]: Stopped dracut-cmdline.service - dracut cmdline hook. Mar 2 11:38:46.873310 systemd[1]: dracut-cmdline-ask.service: Deactivated successfully. Mar 2 11:38:46.873382 systemd[1]: Stopped dracut-cmdline-ask.service - dracut ask for additional cmdline parameters. Mar 2 11:38:46.887353 systemd[1]: Starting initrd-udevadm-cleanup-db.service - Cleanup udev Database... Mar 2 11:38:47.072059 systemd-journald[506]: Received SIGTERM from PID 1 (systemd). Mar 2 11:38:46.901820 systemd[1]: systemd-network-generator.service: Deactivated successfully. Mar 2 11:38:46.901898 systemd[1]: Stopped systemd-network-generator.service - Generate network units from Kernel command line. Mar 2 11:38:46.911392 systemd[1]: systemd-tmpfiles-setup-dev.service: Deactivated successfully. Mar 2 11:38:46.911456 systemd[1]: Stopped systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev. Mar 2 11:38:46.925549 systemd[1]: systemd-tmpfiles-setup-dev-early.service: Deactivated successfully. Mar 2 11:38:46.925599 systemd[1]: Stopped systemd-tmpfiles-setup-dev-early.service - Create Static Device Nodes in /dev gracefully. Mar 2 11:38:46.935314 systemd[1]: kmod-static-nodes.service: Deactivated successfully. Mar 2 11:38:46.935362 systemd[1]: Stopped kmod-static-nodes.service - Create List of Static Device Nodes. Mar 2 11:38:46.944966 systemd[1]: systemd-vconsole-setup.service: Deactivated successfully. Mar 2 11:38:46.945008 systemd[1]: Stopped systemd-vconsole-setup.service - Virtual Console Setup. Mar 2 11:38:46.954295 systemd[1]: network-cleanup.service: Deactivated successfully. Mar 2 11:38:46.954400 systemd[1]: Stopped network-cleanup.service - Network Cleanup. Mar 2 11:38:46.961798 systemd[1]: initrd-udevadm-cleanup-db.service: Deactivated successfully. Mar 2 11:38:46.961860 systemd[1]: Finished initrd-udevadm-cleanup-db.service - Cleanup udev Database. Mar 2 11:38:46.973344 systemd[1]: Reached target initrd-switch-root.target - Switch Root. Mar 2 11:38:46.982547 systemd[1]: Starting initrd-switch-root.service - Switch Root... Mar 2 11:38:47.020807 systemd[1]: Switching root. Mar 2 11:38:47.155019 systemd-journald[506]: Journal stopped Mar 2 11:38:48.859455 kernel: SELinux: policy capability network_peer_controls=1 Mar 2 11:38:48.859475 kernel: SELinux: policy capability open_perms=1 Mar 2 11:38:48.859483 kernel: SELinux: policy capability extended_socket_class=1 Mar 2 11:38:48.859488 kernel: SELinux: policy capability always_check_network=0 Mar 2 11:38:48.859495 kernel: SELinux: policy capability cgroup_seclabel=1 Mar 2 11:38:48.859500 kernel: SELinux: policy capability nnp_nosuid_transition=1 Mar 2 11:38:48.859506 kernel: SELinux: policy capability genfs_seclabel_symlinks=0 Mar 2 11:38:48.859512 kernel: SELinux: policy capability ioctl_skip_cloexec=0 Mar 2 11:38:48.859517 kernel: SELinux: policy capability userspace_initial_context=0 Mar 2 11:38:48.859524 systemd[1]: Successfully loaded SELinux policy in 94.160ms. Mar 2 11:38:48.859532 systemd[1]: Relabeled /dev/, /dev/shm/, /run/ in 4.679ms. Mar 2 11:38:48.859538 systemd[1]: systemd 257.10 running in system mode (+PAM +AUDIT +SELINUX -APPARMOR +IMA +IPE +SMACK +SECCOMP -GCRYPT -GNUTLS +OPENSSL -ACL +BLKID +CURL +ELFUTILS -FIDO2 +IDN2 -IDN +IPTC +KMOD +LIBCRYPTSETUP +LIBCRYPTSETUP_PLUGINS +LIBFDISK +PCRE2 -PWQUALITY -P11KIT -QRENCODE +TPM2 +BZIP2 +LZ4 +XZ +ZLIB +ZSTD -BPF_FRAMEWORK -BTF -XKBCOMMON +UTMP -SYSVINIT +LIBARCHIVE) Mar 2 11:38:48.859544 systemd[1]: Detected virtualization microsoft. Mar 2 11:38:48.859552 systemd[1]: Detected architecture arm64. Mar 2 11:38:48.859560 systemd[1]: Detected first boot. Mar 2 11:38:48.859566 systemd[1]: Hostname set to . Mar 2 11:38:48.859572 systemd[1]: Initializing machine ID from random generator. Mar 2 11:38:48.859578 zram_generator::config[1480]: No configuration found. Mar 2 11:38:48.859584 kernel: NET: Registered PF_VSOCK protocol family Mar 2 11:38:48.859591 systemd[1]: Populated /etc with preset unit settings. Mar 2 11:38:48.859597 systemd[1]: initrd-switch-root.service: Deactivated successfully. Mar 2 11:38:48.859603 systemd[1]: Stopped initrd-switch-root.service - Switch Root. Mar 2 11:38:48.859609 systemd[1]: systemd-journald.service: Scheduled restart job, restart counter is at 1. Mar 2 11:38:48.859622 systemd[1]: Created slice system-addon\x2dconfig.slice - Slice /system/addon-config. Mar 2 11:38:48.859629 systemd[1]: Created slice system-addon\x2drun.slice - Slice /system/addon-run. Mar 2 11:38:48.859636 systemd[1]: Created slice system-getty.slice - Slice /system/getty. Mar 2 11:38:48.859642 systemd[1]: Created slice system-modprobe.slice - Slice /system/modprobe. Mar 2 11:38:48.859648 systemd[1]: Created slice system-serial\x2dgetty.slice - Slice /system/serial-getty. Mar 2 11:38:48.859655 systemd[1]: Created slice system-system\x2dcloudinit.slice - Slice /system/system-cloudinit. Mar 2 11:38:48.859661 systemd[1]: Created slice system-systemd\x2dfsck.slice - Slice /system/systemd-fsck. Mar 2 11:38:48.859667 systemd[1]: Created slice user.slice - User and Session Slice. Mar 2 11:38:48.859674 systemd[1]: Started clevis-luks-askpass.path - Forward Password Requests to Clevis Directory Watch. Mar 2 11:38:48.859680 systemd[1]: Started systemd-ask-password-console.path - Dispatch Password Requests to Console Directory Watch. Mar 2 11:38:48.859686 systemd[1]: Started systemd-ask-password-wall.path - Forward Password Requests to Wall Directory Watch. Mar 2 11:38:48.859693 systemd[1]: Set up automount boot.automount - Boot partition Automount Point. Mar 2 11:38:48.859699 systemd[1]: Set up automount proc-sys-fs-binfmt_misc.automount - Arbitrary Executable File Formats File System Automount Point. Mar 2 11:38:48.859706 systemd[1]: Expecting device dev-disk-by\x2dlabel-OEM.device - /dev/disk/by-label/OEM... Mar 2 11:38:48.859712 systemd[1]: Expecting device dev-ttyAMA0.device - /dev/ttyAMA0... Mar 2 11:38:48.859719 systemd[1]: Reached target cryptsetup-pre.target - Local Encrypted Volumes (Pre). Mar 2 11:38:48.859725 systemd[1]: Reached target cryptsetup.target - Local Encrypted Volumes. Mar 2 11:38:48.859733 systemd[1]: Stopped target initrd-switch-root.target - Switch Root. Mar 2 11:38:48.859739 systemd[1]: Stopped target initrd-fs.target - Initrd File Systems. Mar 2 11:38:48.859745 systemd[1]: Stopped target initrd-root-fs.target - Initrd Root File System. Mar 2 11:38:48.859752 systemd[1]: Reached target integritysetup.target - Local Integrity Protected Volumes. Mar 2 11:38:48.859759 systemd[1]: Reached target remote-cryptsetup.target - Remote Encrypted Volumes. Mar 2 11:38:48.859765 systemd[1]: Reached target remote-fs.target - Remote File Systems. Mar 2 11:38:48.859771 systemd[1]: Reached target remote-veritysetup.target - Remote Verity Protected Volumes. Mar 2 11:38:48.859777 systemd[1]: Reached target slices.target - Slice Units. Mar 2 11:38:48.859783 systemd[1]: Reached target swap.target - Swaps. Mar 2 11:38:48.859789 systemd[1]: Reached target veritysetup.target - Local Verity Protected Volumes. Mar 2 11:38:48.859796 systemd[1]: Listening on systemd-coredump.socket - Process Core Dump Socket. Mar 2 11:38:48.859803 systemd[1]: Listening on systemd-creds.socket - Credential Encryption/Decryption. Mar 2 11:38:48.859809 systemd[1]: Listening on systemd-journald-audit.socket - Journal Audit Socket. Mar 2 11:38:48.859815 systemd[1]: Listening on systemd-mountfsd.socket - DDI File System Mounter Socket. Mar 2 11:38:48.859822 systemd[1]: Listening on systemd-networkd.socket - Network Service Netlink Socket. Mar 2 11:38:48.859830 systemd[1]: Listening on systemd-nsresourced.socket - Namespace Resource Manager Socket. Mar 2 11:38:48.859836 systemd[1]: Listening on systemd-oomd.socket - Userspace Out-Of-Memory (OOM) Killer Socket. Mar 2 11:38:48.859842 systemd[1]: Listening on systemd-udevd-control.socket - udev Control Socket. Mar 2 11:38:48.859848 systemd[1]: Listening on systemd-udevd-kernel.socket - udev Kernel Socket. Mar 2 11:38:48.859854 systemd[1]: Listening on systemd-userdbd.socket - User Database Manager Socket. Mar 2 11:38:48.859861 systemd[1]: Mounting dev-hugepages.mount - Huge Pages File System... Mar 2 11:38:48.859868 systemd[1]: Mounting dev-mqueue.mount - POSIX Message Queue File System... Mar 2 11:38:48.859874 systemd[1]: Mounting media.mount - External Media Directory... Mar 2 11:38:48.859881 systemd[1]: Mounting sys-kernel-debug.mount - Kernel Debug File System... Mar 2 11:38:48.859887 systemd[1]: Mounting sys-kernel-tracing.mount - Kernel Trace File System... Mar 2 11:38:48.859893 systemd[1]: tmp.mount: Directory /tmp to mount over is not empty, mounting anyway. Mar 2 11:38:48.859899 systemd[1]: Mounting tmp.mount - Temporary Directory /tmp... Mar 2 11:38:48.859906 systemd[1]: var-lib-machines.mount - Virtual Machine and Container Storage (Compatibility) was skipped because of an unmet condition check (ConditionPathExists=/var/lib/machines.raw). Mar 2 11:38:48.859913 systemd[1]: Reached target machines.target - Containers. Mar 2 11:38:48.859920 systemd[1]: Starting flatcar-tmpfiles.service - Create missing system files... Mar 2 11:38:48.859926 systemd[1]: ignition-delete-config.service - Ignition (delete config) was skipped because no trigger condition checks were met. Mar 2 11:38:48.859932 systemd[1]: Starting kmod-static-nodes.service - Create List of Static Device Nodes... Mar 2 11:38:48.859939 systemd[1]: Starting modprobe@configfs.service - Load Kernel Module configfs... Mar 2 11:38:48.859945 systemd[1]: Starting modprobe@dm_mod.service - Load Kernel Module dm_mod... Mar 2 11:38:48.859952 systemd[1]: Starting modprobe@drm.service - Load Kernel Module drm... Mar 2 11:38:48.859959 systemd[1]: Starting modprobe@efi_pstore.service - Load Kernel Module efi_pstore... Mar 2 11:38:48.859965 systemd[1]: Starting modprobe@fuse.service - Load Kernel Module fuse... Mar 2 11:38:48.859972 systemd[1]: Starting modprobe@loop.service - Load Kernel Module loop... Mar 2 11:38:48.859978 systemd[1]: setup-nsswitch.service - Create /etc/nsswitch.conf was skipped because of an unmet condition check (ConditionPathExists=!/etc/nsswitch.conf). Mar 2 11:38:48.859984 systemd[1]: systemd-fsck-root.service: Deactivated successfully. Mar 2 11:38:48.859991 systemd[1]: Stopped systemd-fsck-root.service - File System Check on Root Device. Mar 2 11:38:48.859998 kernel: fuse: init (API version 7.41) Mar 2 11:38:48.860003 systemd[1]: systemd-fsck-usr.service: Deactivated successfully. Mar 2 11:38:48.860010 systemd[1]: Stopped systemd-fsck-usr.service. Mar 2 11:38:48.860017 systemd[1]: systemd-hibernate-clear.service - Clear Stale Hibernate Storage Info was skipped because of an unmet condition check (ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67). Mar 2 11:38:48.860023 kernel: ACPI: bus type drm_connector registered Mar 2 11:38:48.860029 systemd[1]: Starting systemd-journald.service - Journal Service... Mar 2 11:38:48.860035 systemd[1]: Starting systemd-modules-load.service - Load Kernel Modules... Mar 2 11:38:48.860043 systemd[1]: Starting systemd-network-generator.service - Generate network units from Kernel command line... Mar 2 11:38:48.860062 systemd-journald[1585]: Collecting audit messages is enabled. Mar 2 11:38:48.860077 systemd-journald[1585]: Journal started Mar 2 11:38:48.860093 systemd-journald[1585]: Runtime Journal (/run/log/journal/8a79ed048e2f4a54962a188489520536) is 8M, max 78.3M, 70.3M free. Mar 2 11:38:48.783000 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' Mar 2 11:38:48.794000 audit[1]: SERVICE_STOP pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=systemd-fsck-usr comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Mar 2 11:38:48.806000 audit: BPF prog-id=14 op=UNLOAD Mar 2 11:38:48.806000 audit: BPF prog-id=13 op=UNLOAD Mar 2 11:38:48.809000 audit: BPF prog-id=15 op=LOAD Mar 2 11:38:48.810000 audit: BPF prog-id=16 op=LOAD Mar 2 11:38:48.810000 audit: BPF prog-id=17 op=LOAD Mar 2 11:38:48.856000 audit: CONFIG_CHANGE op=set audit_enabled=1 old=1 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 res=1 Mar 2 11:38:48.856000 audit[1585]: SYSCALL arch=c00000b7 syscall=211 success=yes exit=60 a0=6 a1=ffffd5b55a60 a2=4000 a3=0 items=0 ppid=1 pid=1585 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) Mar 2 11:38:48.856000 audit: PROCTITLE proctitle="/usr/lib/systemd/systemd-journald" Mar 2 11:38:48.148239 systemd[1]: Queued start job for default target multi-user.target. Mar 2 11:38:48.152969 systemd[1]: Unnecessary job was removed for dev-sda6.device - /dev/sda6. Mar 2 11:38:48.153409 systemd[1]: systemd-journald.service: Deactivated successfully. Mar 2 11:38:48.153730 systemd[1]: systemd-journald.service: Consumed 2.418s CPU time. Mar 2 11:38:48.874822 systemd[1]: Starting systemd-remount-fs.service - Remount Root and Kernel File Systems... Mar 2 11:38:48.889620 systemd[1]: Starting systemd-udev-load-credentials.service - Load udev Rules from Credentials... Mar 2 11:38:48.903027 systemd[1]: Starting systemd-udev-trigger.service - Coldplug All udev Devices... Mar 2 11:38:48.915555 systemd[1]: Started systemd-journald.service - Journal Service. Mar 2 11:38:48.914000 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' Mar 2 11:38:48.916642 systemd[1]: Mounted dev-hugepages.mount - Huge Pages File System. Mar 2 11:38:48.921195 systemd[1]: Mounted dev-mqueue.mount - POSIX Message Queue File System. Mar 2 11:38:48.925675 systemd[1]: Mounted media.mount - External Media Directory. Mar 2 11:38:48.929644 systemd[1]: Mounted sys-kernel-debug.mount - Kernel Debug File System. Mar 2 11:38:48.934068 systemd[1]: Mounted sys-kernel-tracing.mount - Kernel Trace File System. Mar 2 11:38:48.938889 systemd[1]: Mounted tmp.mount - Temporary Directory /tmp. Mar 2 11:38:48.942897 systemd[1]: Finished flatcar-tmpfiles.service - Create missing system files. Mar 2 11:38:48.946000 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' Mar 2 11:38:48.949457 systemd[1]: Finished kmod-static-nodes.service - Create List of Static Device Nodes. Mar 2 11:38:48.955000 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' Mar 2 11:38:48.956958 systemd[1]: modprobe@configfs.service: Deactivated successfully. Mar 2 11:38:48.957114 systemd[1]: Finished modprobe@configfs.service - Load Kernel Module configfs. Mar 2 11:38:48.961000 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' Mar 2 11:38:48.961000 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' Mar 2 11:38:48.962752 systemd[1]: modprobe@dm_mod.service: Deactivated successfully. Mar 2 11:38:48.962883 systemd[1]: Finished modprobe@dm_mod.service - Load Kernel Module dm_mod. Mar 2 11:38:48.966000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=modprobe@dm_mod comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Mar 2 11:38:48.966000 audit[1]: SERVICE_STOP pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=modprobe@dm_mod comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Mar 2 11:38:48.968000 systemd[1]: modprobe@drm.service: Deactivated successfully. Mar 2 11:38:48.968135 systemd[1]: Finished modprobe@drm.service - Load Kernel Module drm. Mar 2 11:38:48.971000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=modprobe@drm comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Mar 2 11:38:48.971000 audit[1]: SERVICE_STOP pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=modprobe@drm comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Mar 2 11:38:48.972849 systemd[1]: modprobe@efi_pstore.service: Deactivated successfully. Mar 2 11:38:48.972966 systemd[1]: Finished modprobe@efi_pstore.service - Load Kernel Module efi_pstore. Mar 2 11:38:48.976000 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' Mar 2 11:38:48.976000 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' Mar 2 11:38:48.978404 systemd[1]: modprobe@fuse.service: Deactivated successfully. Mar 2 11:38:48.978652 systemd[1]: Finished modprobe@fuse.service - Load Kernel Module fuse. Mar 2 11:38:48.982000 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' Mar 2 11:38:48.982000 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' Mar 2 11:38:48.983955 systemd[1]: modprobe@loop.service: Deactivated successfully. Mar 2 11:38:48.984071 systemd[1]: Finished modprobe@loop.service - Load Kernel Module loop. Mar 2 11:38:48.988000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=modprobe@loop comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Mar 2 11:38:48.988000 audit[1]: SERVICE_STOP pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=modprobe@loop comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Mar 2 11:38:48.990066 systemd[1]: Finished systemd-modules-load.service - Load Kernel Modules. Mar 2 11:38:48.993000 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' Mar 2 11:38:48.994930 systemd[1]: Finished systemd-network-generator.service - Generate network units from Kernel command line. Mar 2 11:38:48.999000 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' Mar 2 11:38:49.001116 systemd[1]: Finished systemd-remount-fs.service - Remount Root and Kernel File Systems. Mar 2 11:38:49.005000 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' Mar 2 11:38:49.006923 systemd[1]: Finished systemd-udev-load-credentials.service - Load udev Rules from Credentials. Mar 2 11:38:49.010000 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' Mar 2 11:38:49.012842 systemd[1]: Finished systemd-udev-trigger.service - Coldplug All udev Devices. Mar 2 11:38:49.016000 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' Mar 2 11:38:49.027611 systemd[1]: Reached target network-pre.target - Preparation for Network. Mar 2 11:38:49.038115 systemd[1]: Listening on systemd-importd.socket - Disk Image Download Service Socket. Mar 2 11:38:49.044699 systemd[1]: Mounting sys-fs-fuse-connections.mount - FUSE Control File System... Mar 2 11:38:49.052978 systemd[1]: Mounting sys-kernel-config.mount - Kernel Configuration File System... Mar 2 11:38:49.060641 systemd[1]: remount-root.service - Remount Root File System was skipped because of an unmet condition check (ConditionPathIsReadWrite=!/). Mar 2 11:38:49.060677 systemd[1]: Reached target local-fs.target - Local File Systems. Mar 2 11:38:49.067504 systemd[1]: Listening on systemd-sysext.socket - System Extension Image Management. Mar 2 11:38:49.073663 systemd[1]: systemd-binfmt.service - Set Up Additional Binary Formats was skipped because no trigger condition checks were met. Mar 2 11:38:49.073757 systemd[1]: systemd-confext.service - Merge System Configuration Images into /etc/ was skipped because no trigger condition checks were met. Mar 2 11:38:49.079341 systemd[1]: Starting systemd-hwdb-update.service - Rebuild Hardware Database... Mar 2 11:38:49.091131 systemd[1]: Starting systemd-journal-flush.service - Flush Journal to Persistent Storage... Mar 2 11:38:49.096648 systemd[1]: systemd-pstore.service - Platform Persistent Storage Archival was skipped because of an unmet condition check (ConditionDirectoryNotEmpty=/sys/fs/pstore). Mar 2 11:38:49.099587 systemd[1]: Starting systemd-random-seed.service - Load/Save OS Random Seed... Mar 2 11:38:49.104167 systemd[1]: systemd-repart.service - Repartition Root Disk was skipped because no trigger condition checks were met. Mar 2 11:38:49.115222 systemd[1]: Starting systemd-sysctl.service - Apply Kernel Variables... Mar 2 11:38:49.122570 systemd[1]: Starting systemd-sysext.service - Merge System Extension Images into /usr/ and /opt/... Mar 2 11:38:49.129143 systemd-journald[1585]: Time spent on flushing to /var/log/journal/8a79ed048e2f4a54962a188489520536 is 28.284ms for 1059 entries. Mar 2 11:38:49.129143 systemd-journald[1585]: System Journal (/var/log/journal/8a79ed048e2f4a54962a188489520536) is 8M, max 2.4G, 2.4G free. Mar 2 11:38:49.206643 systemd-journald[1585]: Received client request to flush runtime journal. Mar 2 11:38:49.206675 systemd-journald[1585]: Creating journal file /var/log/journal/8a79ed048e2f4a54962a188489520536/system.journal on a btrfs file system, and copy-on-write is enabled. This is likely to slow down journal access substantially, please consider turning off the copy-on-write file attribute on the journal directory, using chattr +C. Mar 2 11:38:49.206689 kernel: loop1: detected capacity change from 0 to 166960 Mar 2 11:38:49.206697 kernel: loop1: p1 p2 p3 Mar 2 11:38:49.190000 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' Mar 2 11:38:49.152996 systemd[1]: Starting systemd-tmpfiles-setup-dev-early.service - Create Static Device Nodes in /dev gracefully... Mar 2 11:38:49.163634 systemd[1]: Mounted sys-fs-fuse-connections.mount - FUSE Control File System. Mar 2 11:38:49.170791 systemd[1]: Mounted sys-kernel-config.mount - Kernel Configuration File System. Mar 2 11:38:49.179795 systemd[1]: Finished systemd-random-seed.service - Load/Save OS Random Seed. Mar 2 11:38:49.194314 systemd[1]: Reached target first-boot-complete.target - First Boot Complete. Mar 2 11:38:49.210581 systemd[1]: Starting systemd-machine-id-commit.service - Save Transient machine-id to Disk... Mar 2 11:38:49.220495 systemd[1]: Finished systemd-journal-flush.service - Flush Journal to Persistent Storage. Mar 2 11:38:49.229000 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' Mar 2 11:38:49.236000 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' Mar 2 11:38:49.258000 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' Mar 2 11:38:49.231477 systemd[1]: Finished systemd-sysctl.service - Apply Kernel Variables. Mar 2 11:38:49.251211 systemd-tmpfiles[1621]: ACLs are not supported, ignoring. Mar 2 11:38:49.251220 systemd-tmpfiles[1621]: ACLs are not supported, ignoring. Mar 2 11:38:49.254307 systemd[1]: Finished systemd-tmpfiles-setup-dev-early.service - Create Static Device Nodes in /dev gracefully. Mar 2 11:38:49.261742 systemd[1]: Starting systemd-sysusers.service - Create System Users... Mar 2 11:38:49.298046 systemd[1]: Finished systemd-machine-id-commit.service - Save Transient machine-id to Disk. Mar 2 11:38:49.302000 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' Mar 2 11:38:49.335520 systemd[1]: Finished systemd-sysusers.service - Create System Users. Mar 2 11:38:49.339000 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' Mar 2 11:38:49.340000 audit: BPF prog-id=18 op=LOAD Mar 2 11:38:49.340000 audit: BPF prog-id=19 op=LOAD Mar 2 11:38:49.340000 audit: BPF prog-id=20 op=LOAD Mar 2 11:38:49.344622 systemd[1]: Starting systemd-oomd.service - Userspace Out-Of-Memory (OOM) Killer... Mar 2 11:38:49.352000 audit: BPF prog-id=21 op=LOAD Mar 2 11:38:49.354606 systemd[1]: Starting systemd-resolved.service - Network Name Resolution... Mar 2 11:38:49.373000 audit: BPF prog-id=22 op=LOAD Mar 2 11:38:49.373000 audit: BPF prog-id=23 op=LOAD Mar 2 11:38:49.373000 audit: BPF prog-id=24 op=LOAD Mar 2 11:38:49.364638 systemd[1]: Starting systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev... Mar 2 11:38:49.382556 kernel: erofs: (device loop1p1): mounted with root inode @ nid 39. Mar 2 11:38:49.377659 systemd[1]: Starting systemd-nsresourced.service - Namespace Resource Manager... Mar 2 11:38:49.386000 audit: BPF prog-id=25 op=LOAD Mar 2 11:38:49.388000 audit: BPF prog-id=26 op=LOAD Mar 2 11:38:49.388000 audit: BPF prog-id=27 op=LOAD Mar 2 11:38:49.390290 systemd[1]: Starting systemd-userdbd.service - User Database Manager... Mar 2 11:38:49.419250 systemd-tmpfiles[1642]: ACLs are not supported, ignoring. Mar 2 11:38:49.420470 systemd-tmpfiles[1642]: ACLs are not supported, ignoring. Mar 2 11:38:49.427446 kernel: loop2: detected capacity change from 0 to 355640 Mar 2 11:38:49.428007 systemd[1]: Finished systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev. Mar 2 11:38:49.435000 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' Mar 2 11:38:49.441445 kernel: loop2: p1 p2 p3 Mar 2 11:38:49.449567 systemd-nsresourced[1643]: Not setting up BPF subsystem, as functionality has been disabled at compile time. Mar 2 11:38:49.450301 systemd[1]: Started systemd-userdbd.service - User Database Manager. Mar 2 11:38:49.456000 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' Mar 2 11:38:49.458475 systemd[1]: Started systemd-nsresourced.service - Namespace Resource Manager. Mar 2 11:38:49.466000 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' Mar 2 11:38:49.514730 systemd-oomd[1638]: No swap; memory pressure usage will be degraded Mar 2 11:38:49.517095 systemd[1]: Started systemd-oomd.service - Userspace Out-Of-Memory (OOM) Killer. Mar 2 11:38:49.523000 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' Mar 2 11:38:49.539445 systemd-resolved[1641]: Positive Trust Anchors: Mar 2 11:38:49.539460 systemd-resolved[1641]: . IN DS 20326 8 2 e06d44b80b8f1d39a95c0b0d7c65d08458e880409bbc683457104237c7f8ec8d Mar 2 11:38:49.539463 systemd-resolved[1641]: . IN DS 38696 8 2 683d2d0acb8c9b712a1948b27f741219298d0a450d612c483af444a4c0fb2b16 Mar 2 11:38:49.539482 systemd-resolved[1641]: 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 Mar 2 11:38:49.559197 systemd-resolved[1641]: Using system hostname 'ci-9999.9.9-m-93217899aa'. Mar 2 11:38:49.560431 systemd[1]: Started systemd-resolved.service - Network Name Resolution. Mar 2 11:38:49.569000 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' Mar 2 11:38:49.571436 systemd[1]: Reached target nss-lookup.target - Host and Network Name Lookups. Mar 2 11:38:49.610484 systemd[1]: Finished systemd-hwdb-update.service - Rebuild Hardware Database. Mar 2 11:38:49.618000 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' Mar 2 11:38:49.622686 kernel: erofs: (device loop2p1): mounted with root inode @ nid 39. Mar 2 11:38:49.622734 kernel: kauditd_printk_skb: 110 callbacks suppressed Mar 2 11:38:49.622760 kernel: audit: type=1130 audit(1772451529.618:154): 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' Mar 2 11:38:49.618000 audit: BPF prog-id=8 op=UNLOAD Mar 2 11:38:49.639140 kernel: audit: type=1334 audit(1772451529.618:155): prog-id=8 op=UNLOAD Mar 2 11:38:49.639217 kernel: audit: type=1334 audit(1772451529.618:156): prog-id=7 op=UNLOAD Mar 2 11:38:49.639238 kernel: audit: type=1334 audit(1772451529.621:157): prog-id=28 op=LOAD Mar 2 11:38:49.639253 kernel: audit: type=1334 audit(1772451529.633:158): prog-id=29 op=LOAD Mar 2 11:38:49.618000 audit: BPF prog-id=7 op=UNLOAD Mar 2 11:38:49.621000 audit: BPF prog-id=28 op=LOAD Mar 2 11:38:49.633000 audit: BPF prog-id=29 op=LOAD Mar 2 11:38:49.637606 systemd[1]: Starting systemd-udevd.service - Rule-based Manager for Device Events and Files... Mar 2 11:38:49.674475 kernel: loop3: detected capacity change from 0 to 142464 Mar 2 11:38:49.676245 systemd-udevd[1664]: Using default interface naming scheme 'v257'. Mar 2 11:38:49.681443 kernel: loop3: p1 p2 p3 Mar 2 11:38:49.735150 systemd[1]: Started systemd-udevd.service - Rule-based Manager for Device Events and Files. Mar 2 11:38:49.739000 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' Mar 2 11:38:49.764679 kernel: audit: type=1130 audit(1772451529.739:159): 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' Mar 2 11:38:49.764788 kernel: audit: type=1334 audit(1772451529.758:160): prog-id=30 op=LOAD Mar 2 11:38:49.758000 audit: BPF prog-id=30 op=LOAD Mar 2 11:38:49.761511 systemd[1]: Starting systemd-networkd.service - Network Configuration... Mar 2 11:38:49.804544 kernel: erofs: (device loop3p1): mounted with root inode @ nid 39. Mar 2 11:38:49.824250 systemd[1]: Condition check resulted in dev-ttyAMA0.device - /dev/ttyAMA0 being skipped. Mar 2 11:38:49.845069 systemd-networkd[1687]: lo: Link UP Mar 2 11:38:49.845082 systemd-networkd[1687]: lo: Gained carrier Mar 2 11:38:49.846804 systemd[1]: Started systemd-networkd.service - Network Configuration. Mar 2 11:38:49.849000 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' Mar 2 11:38:49.851517 systemd[1]: Reached target network.target - Network. Mar 2 11:38:49.866525 kernel: audit: type=1130 audit(1772451529.849:161): 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' Mar 2 11:38:49.869868 systemd[1]: Starting systemd-networkd-persistent-storage.service - Enable Persistent Storage in systemd-networkd... Mar 2 11:38:49.879860 systemd[1]: Starting systemd-networkd-wait-online.service - Wait for Network to be Configured... Mar 2 11:38:49.886466 kernel: loop4: detected capacity change from 0 to 166960 Mar 2 11:38:49.886651 kernel: loop4: p1 p2 p3 Mar 2 11:38:49.905129 systemd-networkd[1687]: eth0: Found matching .network file, based on potentially unpredictable interface name: /usr/lib/systemd/network/zz-default.network Mar 2 11:38:49.905430 kernel: mousedev: PS/2 mouse device common for all mice Mar 2 11:38:49.905137 systemd-networkd[1687]: eth0: Configuring with /usr/lib/systemd/network/zz-default.network. Mar 2 11:38:49.926705 kernel: device-mapper: verity: sha256 using shash "sha256-ce" Mar 2 11:38:49.926828 kernel: device-mapper: verity: Unrecognized verity feature request: root_hash_sig_key_desc Mar 2 11:38:49.933948 kernel: device-mapper: table: 254:1: verity: Unrecognized verity feature request (-EINVAL) Mar 2 11:38:49.941429 kernel: device-mapper: ioctl: error adding target to table Mar 2 11:38:49.941518 kernel: hv_vmbus: registering driver hv_balloon Mar 2 11:38:49.941601 (sd-merge)[1694]: device-mapper: reload ioctl on 5b9de012db26739a711e2a459ae1aa83cce9f8daa095f7c2873c44b7b991c4e8-verity (254:1) failed: Invalid argument Mar 2 11:38:49.955144 kernel: hv_balloon: Using Dynamic Memory protocol version 2.0 Mar 2 11:38:49.955242 kernel: hv_vmbus: registering driver hyperv_fb Mar 2 11:38:49.955263 kernel: hv_balloon: Memory hot add disabled on ARM64 Mar 2 11:38:49.964472 kernel: device-mapper: verity: sha256 using shash "sha256-ce" Mar 2 11:38:49.974446 kernel: mlx5_core f3af:00:02.0 enP62383s1: Link up Mar 2 11:38:49.998450 kernel: hv_netvsc 000d3afb-860e-000d-3afb-860e000d3afb eth0: Data path switched to VF: enP62383s1 Mar 2 11:38:49.998981 systemd-networkd[1687]: enP62383s1: Link UP Mar 2 11:38:49.999272 systemd-networkd[1687]: eth0: Link UP Mar 2 11:38:49.999276 systemd-networkd[1687]: eth0: Gained carrier Mar 2 11:38:49.999296 systemd-networkd[1687]: eth0: Found matching .network file, based on potentially unpredictable interface name: /usr/lib/systemd/network/zz-default.network Mar 2 11:38:50.004168 kernel: hyperv_fb: Synthvid Version major 3, minor 5 Mar 2 11:38:50.009113 kernel: hyperv_fb: Screen resolution: 1024x768, Color depth: 32, Frame buffer size: 8388608 Mar 2 11:38:50.014752 kernel: Console: switching to colour dummy device 80x25 Mar 2 11:38:50.014201 systemd-networkd[1687]: enP62383s1: Gained carrier Mar 2 11:38:50.020778 kernel: hv_storvsc f8b3781a-1e82-4818-a1c3-63d806ec15bb: tag#114 cmd 0x85 status: scsi 0x2 srb 0x6 hv 0xc0000001 Mar 2 11:38:50.022685 systemd[1]: Finished systemd-networkd-persistent-storage.service - Enable Persistent Storage in systemd-networkd. Mar 2 11:38:50.032449 kernel: Console: switching to colour frame buffer device 128x48 Mar 2 11:38:50.036000 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' Mar 2 11:38:50.038445 kernel: audit: type=1130 audit(1772451530.036:162): 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' Mar 2 11:38:50.042657 systemd-networkd[1687]: eth0: DHCPv4 address 10.200.20.34/24, gateway 10.200.20.1 acquired from 168.63.129.16 Mar 2 11:38:50.099543 systemd[1]: Starting systemd-vconsole-setup.service - Virtual Console Setup... Mar 2 11:38:50.123196 systemd[1]: systemd-vconsole-setup.service: Deactivated successfully. Mar 2 11:38:50.123382 systemd[1]: Stopped systemd-vconsole-setup.service - Virtual Console Setup. Mar 2 11:38:50.131000 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' Mar 2 11:38:50.140435 kernel: MACsec IEEE 802.1AE Mar 2 11:38:50.140518 kernel: audit: type=1130 audit(1772451530.131:163): 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' Mar 2 11:38:50.131000 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' Mar 2 11:38:50.145668 systemd[1]: Starting systemd-vconsole-setup.service - Virtual Console Setup... Mar 2 11:38:50.164560 systemd[1]: etc-machine\x2did.mount: Deactivated successfully. Mar 2 11:38:50.173856 systemd[1]: systemd-vconsole-setup.service: Deactivated successfully. Mar 2 11:38:50.174065 systemd[1]: Stopped systemd-vconsole-setup.service - Virtual Console Setup. Mar 2 11:38:50.182000 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' Mar 2 11:38:50.182000 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' Mar 2 11:38:50.192636 systemd[1]: Starting systemd-vconsole-setup.service - Virtual Console Setup... Mar 2 11:38:50.202452 kernel: erofs: (device dm-1): mounted with root inode @ nid 39. Mar 2 11:38:50.217479 kernel: loop5: detected capacity change from 0 to 355640 Mar 2 11:38:50.223472 kernel: loop5: p1 p2 p3 Mar 2 11:38:50.251485 systemd[1]: Found device dev-disk-by\x2dlabel-OEM.device - Virtual_Disk OEM. Mar 2 11:38:50.261096 kernel: device-mapper: verity: sha256 using shash "sha256-ce" Mar 2 11:38:50.261170 kernel: device-mapper: verity: Unrecognized verity feature request: root_hash_sig_key_desc Mar 2 11:38:50.271059 kernel: device-mapper: table: 254:2: verity: Unrecognized verity feature request (-EINVAL) Mar 2 11:38:50.271147 kernel: device-mapper: ioctl: error adding target to table Mar 2 11:38:50.266363 systemd[1]: Starting systemd-fsck@dev-disk-by\x2dlabel-OEM.service - File System Check on /dev/disk/by-label/OEM... Mar 2 11:38:50.274574 (sd-merge)[1694]: device-mapper: reload ioctl on 40b4e27daf6193e783aa3b6d89b01cab068dda74aa3815d8c2160ee8e7b85b12-verity (254:2) failed: Invalid argument Mar 2 11:38:50.286461 kernel: device-mapper: verity: sha256 using shash "sha256-ce" Mar 2 11:38:50.301041 systemd[1]: Finished systemd-fsck@dev-disk-by\x2dlabel-OEM.service - File System Check on /dev/disk/by-label/OEM. Mar 2 11:38:50.304000 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' Mar 2 11:38:50.342449 kernel: erofs: (device dm-2): mounted with root inode @ nid 39. Mar 2 11:38:50.352227 kernel: loop6: detected capacity change from 0 to 142464 Mar 2 11:38:50.352318 kernel: loop6: p1 p2 p3 Mar 2 11:38:50.368566 kernel: device-mapper: verity: sha256 using shash "sha256-ce" Mar 2 11:38:50.368663 kernel: device-mapper: verity: Unrecognized verity feature request: root_hash_sig_key_desc Mar 2 11:38:50.368686 kernel: device-mapper: table: 254:3: verity: Unrecognized verity feature request (-EINVAL) Mar 2 11:38:50.373403 kernel: device-mapper: ioctl: error adding target to table Mar 2 11:38:50.376784 (sd-merge)[1694]: device-mapper: reload ioctl on c0ff586f38941ffdd117e5e5723d23d15bc4548799ca02121321688db76f3cab-verity (254:3) failed: Invalid argument Mar 2 11:38:50.383445 kernel: device-mapper: verity: sha256 using shash "sha256-ce" Mar 2 11:38:50.392382 systemd[1]: Finished systemd-vconsole-setup.service - Virtual Console Setup. Mar 2 11:38:50.396000 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' Mar 2 11:38:50.417217 (sd-merge)[1694]: Using extensions 'containerd-flatcar.raw', 'docker-flatcar.raw', 'oem-azure.raw'. Mar 2 11:38:50.417455 kernel: erofs: (device dm-3): mounted with root inode @ nid 39. Mar 2 11:38:50.419508 (sd-merge)[1694]: Merged extensions into '/usr'. Mar 2 11:38:50.421805 systemd[1]: Finished systemd-sysext.service - Merge System Extension Images into /usr/ and /opt/. Mar 2 11:38:50.426000 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' Mar 2 11:38:50.429257 systemd[1]: Starting ensure-sysext.service... Mar 2 11:38:50.439600 systemd[1]: Starting systemd-tmpfiles-setup.service - Create System Files and Directories... Mar 2 11:38:50.447562 systemd[1]: Reload requested from client PID 1821 ('systemctl') (unit ensure-sysext.service)... Mar 2 11:38:50.447578 systemd[1]: Reloading... Mar 2 11:38:50.479163 systemd-tmpfiles[1822]: /usr/lib/tmpfiles.d/nfs-utils.conf:6: Duplicate line for path "/var/lib/nfs/sm", ignoring. Mar 2 11:38:50.479186 systemd-tmpfiles[1822]: /usr/lib/tmpfiles.d/nfs-utils.conf:7: Duplicate line for path "/var/lib/nfs/sm.bak", ignoring. Mar 2 11:38:50.479338 systemd-tmpfiles[1822]: /usr/lib/tmpfiles.d/provision.conf:20: Duplicate line for path "/root", ignoring. Mar 2 11:38:50.479985 systemd-tmpfiles[1822]: ACLs are not supported, ignoring. Mar 2 11:38:50.480014 systemd-tmpfiles[1822]: ACLs are not supported, ignoring. Mar 2 11:38:50.493449 zram_generator::config[1854]: No configuration found. Mar 2 11:38:50.503722 systemd-tmpfiles[1822]: Detected autofs mount point /boot during canonicalization of boot. Mar 2 11:38:50.503732 systemd-tmpfiles[1822]: Skipping /boot Mar 2 11:38:50.510972 systemd-tmpfiles[1822]: Detected autofs mount point /boot during canonicalization of boot. Mar 2 11:38:50.511395 systemd-tmpfiles[1822]: Skipping /boot Mar 2 11:38:50.741370 systemd[1]: Reloading finished in 293 ms. Mar 2 11:38:50.770588 systemd[1]: Finished systemd-tmpfiles-setup.service - Create System Files and Directories. Mar 2 11:38:50.774000 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' Mar 2 11:38:50.782000 audit: BPF prog-id=31 op=LOAD Mar 2 11:38:50.782000 audit: BPF prog-id=22 op=UNLOAD Mar 2 11:38:50.782000 audit: BPF prog-id=32 op=LOAD Mar 2 11:38:50.783000 audit: BPF prog-id=33 op=LOAD Mar 2 11:38:50.783000 audit: BPF prog-id=23 op=UNLOAD Mar 2 11:38:50.783000 audit: BPF prog-id=24 op=UNLOAD Mar 2 11:38:50.783000 audit: BPF prog-id=34 op=LOAD Mar 2 11:38:50.783000 audit: BPF prog-id=35 op=LOAD Mar 2 11:38:50.783000 audit: BPF prog-id=28 op=UNLOAD Mar 2 11:38:50.783000 audit: BPF prog-id=29 op=UNLOAD Mar 2 11:38:50.783000 audit: BPF prog-id=36 op=LOAD Mar 2 11:38:50.783000 audit: BPF prog-id=30 op=UNLOAD Mar 2 11:38:50.784000 audit: BPF prog-id=37 op=LOAD Mar 2 11:38:50.784000 audit: BPF prog-id=21 op=UNLOAD Mar 2 11:38:50.784000 audit: BPF prog-id=38 op=LOAD Mar 2 11:38:50.784000 audit: BPF prog-id=25 op=UNLOAD Mar 2 11:38:50.784000 audit: BPF prog-id=39 op=LOAD Mar 2 11:38:50.784000 audit: BPF prog-id=40 op=LOAD Mar 2 11:38:50.784000 audit: BPF prog-id=26 op=UNLOAD Mar 2 11:38:50.784000 audit: BPF prog-id=27 op=UNLOAD Mar 2 11:38:50.784000 audit: BPF prog-id=41 op=LOAD Mar 2 11:38:50.784000 audit: BPF prog-id=15 op=UNLOAD Mar 2 11:38:50.785000 audit: BPF prog-id=42 op=LOAD Mar 2 11:38:50.785000 audit: BPF prog-id=43 op=LOAD Mar 2 11:38:50.785000 audit: BPF prog-id=16 op=UNLOAD Mar 2 11:38:50.785000 audit: BPF prog-id=17 op=UNLOAD Mar 2 11:38:50.785000 audit: BPF prog-id=44 op=LOAD Mar 2 11:38:50.785000 audit: BPF prog-id=18 op=UNLOAD Mar 2 11:38:50.785000 audit: BPF prog-id=45 op=LOAD Mar 2 11:38:50.785000 audit: BPF prog-id=46 op=LOAD Mar 2 11:38:50.785000 audit: BPF prog-id=19 op=UNLOAD Mar 2 11:38:50.785000 audit: BPF prog-id=20 op=UNLOAD Mar 2 11:38:50.801173 systemd[1]: Starting audit-rules.service - Load Audit Rules... Mar 2 11:38:50.812177 systemd[1]: Starting clean-ca-certificates.service - Clean up broken links in /etc/ssl/certs... Mar 2 11:38:50.817112 systemd[1]: ignition-delete-config.service - Ignition (delete config) was skipped because no trigger condition checks were met. Mar 2 11:38:50.819629 systemd[1]: Starting modprobe@dm_mod.service - Load Kernel Module dm_mod... Mar 2 11:38:50.826653 systemd[1]: Starting modprobe@efi_pstore.service - Load Kernel Module efi_pstore... Mar 2 11:38:50.839604 systemd[1]: Starting modprobe@loop.service - Load Kernel Module loop... Mar 2 11:38:50.844824 systemd[1]: systemd-binfmt.service - Set Up Additional Binary Formats was skipped because no trigger condition checks were met. Mar 2 11:38:50.845120 systemd[1]: systemd-confext.service - Merge System Configuration Images into /etc/ was skipped because no trigger condition checks were met. Mar 2 11:38:50.847600 systemd[1]: Starting ldconfig.service - Rebuild Dynamic Linker Cache... Mar 2 11:38:50.853313 systemd[1]: systemd-hibernate-clear.service - Clear Stale Hibernate Storage Info was skipped because of an unmet condition check (ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67). Mar 2 11:38:50.855646 systemd[1]: Starting systemd-journal-catalog-update.service - Rebuild Journal Catalog... Mar 2 11:38:50.869955 systemd[1]: Starting systemd-update-utmp.service - Record System Boot/Shutdown in UTMP... Mar 2 11:38:50.878053 systemd[1]: modprobe@dm_mod.service: Deactivated successfully. Mar 2 11:38:50.878371 systemd[1]: Finished modprobe@dm_mod.service - Load Kernel Module dm_mod. Mar 2 11:38:50.877000 audit[1933]: SYSTEM_BOOT pid=1933 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' Mar 2 11:38:50.883000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=modprobe@dm_mod comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Mar 2 11:38:50.883000 audit[1]: SERVICE_STOP pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=modprobe@dm_mod comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Mar 2 11:38:50.885193 systemd[1]: modprobe@efi_pstore.service: Deactivated successfully. Mar 2 11:38:50.885694 systemd[1]: Finished modprobe@efi_pstore.service - Load Kernel Module efi_pstore. Mar 2 11:38:50.890000 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' Mar 2 11:38:50.890000 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' Mar 2 11:38:50.892166 systemd[1]: modprobe@loop.service: Deactivated successfully. Mar 2 11:38:50.893474 systemd[1]: Finished modprobe@loop.service - Load Kernel Module loop. Mar 2 11:38:50.897000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=modprobe@loop comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Mar 2 11:38:50.897000 audit[1]: SERVICE_STOP pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=modprobe@loop comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Mar 2 11:38:50.906072 systemd[1]: ignition-delete-config.service - Ignition (delete config) was skipped because no trigger condition checks were met. Mar 2 11:38:50.908141 systemd[1]: Starting modprobe@dm_mod.service - Load Kernel Module dm_mod... Mar 2 11:38:50.917266 systemd[1]: Starting modprobe@efi_pstore.service - Load Kernel Module efi_pstore... Mar 2 11:38:50.929630 systemd[1]: Starting modprobe@loop.service - Load Kernel Module loop... Mar 2 11:38:50.935765 systemd[1]: systemd-binfmt.service - Set Up Additional Binary Formats was skipped because no trigger condition checks were met. Mar 2 11:38:50.935967 systemd[1]: systemd-confext.service - Merge System Configuration Images into /etc/ was skipped because no trigger condition checks were met. Mar 2 11:38:50.936073 systemd[1]: systemd-hibernate-clear.service - Clear Stale Hibernate Storage Info was skipped because of an unmet condition check (ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67). Mar 2 11:38:50.940595 systemd[1]: Finished systemd-journal-catalog-update.service - Rebuild Journal Catalog. Mar 2 11:38:50.945000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=systemd-journal-catalog-update comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Mar 2 11:38:50.947257 systemd[1]: modprobe@dm_mod.service: Deactivated successfully. Mar 2 11:38:50.947467 systemd[1]: Finished modprobe@dm_mod.service - Load Kernel Module dm_mod. Mar 2 11:38:50.951000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=modprobe@dm_mod comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Mar 2 11:38:50.951000 audit[1]: SERVICE_STOP pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=modprobe@dm_mod comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Mar 2 11:38:50.953698 systemd[1]: modprobe@efi_pstore.service: Deactivated successfully. Mar 2 11:38:50.954079 systemd[1]: Finished modprobe@efi_pstore.service - Load Kernel Module efi_pstore. Mar 2 11:38:50.958000 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' Mar 2 11:38:50.958000 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' Mar 2 11:38:50.960083 systemd[1]: modprobe@loop.service: Deactivated successfully. Mar 2 11:38:50.960248 systemd[1]: Finished modprobe@loop.service - Load Kernel Module loop. Mar 2 11:38:50.963000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=modprobe@loop comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Mar 2 11:38:50.963000 audit[1]: SERVICE_STOP pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=modprobe@loop comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Mar 2 11:38:50.966534 systemd[1]: Finished systemd-update-utmp.service - Record System Boot/Shutdown in UTMP. Mar 2 11:38:50.971000 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' Mar 2 11:38:50.973000 audit: CONFIG_CHANGE auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 op=add_rule key=(null) list=5 res=1 Mar 2 11:38:50.973000 audit[1947]: SYSCALL arch=c00000b7 syscall=206 success=yes exit=1056 a0=3 a1=ffffe85f9710 a2=420 a3=0 items=0 ppid=1913 pid=1947 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) Mar 2 11:38:50.973000 audit: PROCTITLE proctitle=2F7362696E2F617564697463746C002D52002F6574632F61756469742F61756469742E72756C6573 Mar 2 11:38:50.975394 augenrules[1947]: No rules Mar 2 11:38:50.978291 systemd[1]: audit-rules.service: Deactivated successfully. Mar 2 11:38:50.978698 systemd[1]: Finished audit-rules.service - Load Audit Rules. Mar 2 11:38:50.987873 systemd[1]: ignition-delete-config.service - Ignition (delete config) was skipped because no trigger condition checks were met. Mar 2 11:38:50.988932 systemd[1]: Starting modprobe@dm_mod.service - Load Kernel Module dm_mod... Mar 2 11:38:50.998081 systemd[1]: Starting modprobe@drm.service - Load Kernel Module drm... Mar 2 11:38:51.005510 systemd[1]: Starting modprobe@efi_pstore.service - Load Kernel Module efi_pstore... Mar 2 11:38:51.012352 systemd[1]: Starting modprobe@loop.service - Load Kernel Module loop... Mar 2 11:38:51.016616 systemd[1]: systemd-binfmt.service - Set Up Additional Binary Formats was skipped because no trigger condition checks were met. Mar 2 11:38:51.016699 systemd[1]: systemd-confext.service - Merge System Configuration Images into /etc/ was skipped because no trigger condition checks were met. Mar 2 11:38:51.016730 systemd[1]: systemd-hibernate-clear.service - Clear Stale Hibernate Storage Info was skipped because of an unmet condition check (ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67). Mar 2 11:38:51.016787 systemd[1]: Reached target time-set.target - System Time Set. Mar 2 11:38:51.023649 systemd[1]: Finished ensure-sysext.service. Mar 2 11:38:51.027276 systemd[1]: modprobe@dm_mod.service: Deactivated successfully. Mar 2 11:38:51.027464 systemd[1]: Finished modprobe@dm_mod.service - Load Kernel Module dm_mod. Mar 2 11:38:51.032233 systemd[1]: modprobe@drm.service: Deactivated successfully. Mar 2 11:38:51.032387 systemd[1]: Finished modprobe@drm.service - Load Kernel Module drm. Mar 2 11:38:51.037225 systemd[1]: modprobe@efi_pstore.service: Deactivated successfully. Mar 2 11:38:51.037411 systemd[1]: Finished modprobe@efi_pstore.service - Load Kernel Module efi_pstore. Mar 2 11:38:51.042892 systemd[1]: modprobe@loop.service: Deactivated successfully. Mar 2 11:38:51.043057 systemd[1]: Finished modprobe@loop.service - Load Kernel Module loop. Mar 2 11:38:51.052670 systemd[1]: systemd-pstore.service - Platform Persistent Storage Archival was skipped because of an unmet condition check (ConditionDirectoryNotEmpty=/sys/fs/pstore). Mar 2 11:38:51.052738 systemd[1]: systemd-repart.service - Repartition Root Disk was skipped because no trigger condition checks were met. Mar 2 11:38:51.153460 systemd[1]: Finished clean-ca-certificates.service - Clean up broken links in /etc/ssl/certs. Mar 2 11:38:51.159013 systemd[1]: update-ca-certificates.service - Update CA bundle at /etc/ssl/certs/ca-certificates.crt was skipped because of an unmet condition check (ConditionPathIsSymbolicLink=!/etc/ssl/certs/ca-certificates.crt). Mar 2 11:38:51.967588 systemd-networkd[1687]: eth0: Gained IPv6LL Mar 2 11:38:51.970232 systemd[1]: Finished systemd-networkd-wait-online.service - Wait for Network to be Configured. Mar 2 11:38:51.976604 systemd[1]: Reached target network-online.target - Network is Online. Mar 2 11:38:52.329163 ldconfig[1926]: /sbin/ldconfig: /usr/lib/ld.so.conf is not an ELF file - it has the wrong magic bytes at the start. Mar 2 11:38:52.346850 systemd[1]: Finished ldconfig.service - Rebuild Dynamic Linker Cache. Mar 2 11:38:52.353703 systemd[1]: Starting systemd-update-done.service - Update is Completed... Mar 2 11:38:52.372596 systemd[1]: Finished systemd-update-done.service - Update is Completed. Mar 2 11:38:52.377592 systemd[1]: Reached target sysinit.target - System Initialization. Mar 2 11:38:52.382282 systemd[1]: Started motdgen.path - Watch for update engine configuration changes. Mar 2 11:38:52.387378 systemd[1]: Started user-cloudinit@var-lib-flatcar\x2dinstall-user_data.path - Watch for a cloud-config at /var/lib/flatcar-install/user_data. Mar 2 11:38:52.392711 systemd[1]: Started logrotate.timer - Daily rotation of log files. Mar 2 11:38:52.397294 systemd[1]: Started mdadm.timer - Weekly check for MD array's redundancy information.. Mar 2 11:38:52.402495 systemd[1]: Started systemd-sysupdate-reboot.timer - Reboot Automatically After System Update. Mar 2 11:38:52.407705 systemd[1]: Started systemd-sysupdate.timer - Automatic System Update. Mar 2 11:38:52.412442 systemd[1]: Started systemd-tmpfiles-clean.timer - Daily Cleanup of Temporary Directories. Mar 2 11:38:52.417722 systemd[1]: update-engine-stub.timer - Update Engine Stub Timer was skipped because of an unmet condition check (ConditionPathExists=/usr/.noupdate). Mar 2 11:38:52.417750 systemd[1]: Reached target paths.target - Path Units. Mar 2 11:38:52.421439 systemd[1]: Reached target timers.target - Timer Units. Mar 2 11:38:52.426714 systemd[1]: Listening on dbus.socket - D-Bus System Message Bus Socket. Mar 2 11:38:52.433631 systemd[1]: Starting docker.socket - Docker Socket for the API... Mar 2 11:38:52.439007 systemd[1]: Listening on sshd-unix-local.socket - OpenSSH Server Socket (systemd-ssh-generator, AF_UNIX Local). Mar 2 11:38:52.444409 systemd[1]: Listening on sshd-vsock.socket - OpenSSH Server Socket (systemd-ssh-generator, AF_VSOCK). Mar 2 11:38:52.450495 systemd[1]: Reached target ssh-access.target - SSH Access Available. Mar 2 11:38:52.456873 systemd[1]: Listening on sshd.socket - OpenSSH Server Socket. Mar 2 11:38:52.461628 systemd[1]: Listening on systemd-hostnamed.socket - Hostname Service Socket. Mar 2 11:38:52.467333 systemd[1]: Listening on docker.socket - Docker Socket for the API. Mar 2 11:38:52.471959 systemd[1]: Reached target sockets.target - Socket Units. Mar 2 11:38:52.476140 systemd[1]: Reached target basic.target - Basic System. Mar 2 11:38:52.480077 systemd[1]: addon-config@oem.service - Configure Addon /oem was skipped because no trigger condition checks were met. Mar 2 11:38:52.480100 systemd[1]: addon-run@oem.service - Run Addon /oem was skipped because no trigger condition checks were met. Mar 2 11:38:52.486446 systemd[1]: Starting chronyd.service - NTP client/server... Mar 2 11:38:52.499538 systemd[1]: Starting containerd.service - containerd container runtime... Mar 2 11:38:52.504920 systemd[1]: Starting coreos-metadata.service - Flatcar Metadata Agent... Mar 2 11:38:52.513629 systemd[1]: Starting dbus.service - D-Bus System Message Bus... Mar 2 11:38:52.520468 systemd[1]: Starting dracut-shutdown.service - Restore /run/initramfs on shutdown... Mar 2 11:38:52.527558 systemd[1]: Starting enable-oem-cloudinit.service - Enable cloudinit... Mar 2 11:38:52.533631 systemd[1]: Starting extend-filesystems.service - Extend Filesystems... Mar 2 11:38:52.534376 chronyd[1974]: chronyd version 4.8 starting (+CMDMON +REFCLOCK +RTC +PRIVDROP +SCFILTER -SIGND +NTS +SECHASH +IPV6 -DEBUG) Mar 2 11:38:52.539726 systemd[1]: flatcar-setup-environment.service - Modifies /etc/environment for CoreOS was skipped because of an unmet condition check (ConditionPathExists=/oem/bin/flatcar-setup-environment). Mar 2 11:38:52.541914 systemd[1]: Started hv_kvp_daemon.service - Hyper-V KVP daemon. Mar 2 11:38:52.548279 systemd[1]: hv_vss_daemon.service - Hyper-V VSS daemon was skipped because of an unmet condition check (ConditionPathExists=/dev/vmbus/hv_vss). Mar 2 11:38:52.549816 systemd[1]: Starting motdgen.service - Generate /run/flatcar/motd... Mar 2 11:38:52.553845 jq[1982]: false Mar 2 11:38:52.554167 chronyd[1974]: Timezone right/UTC failed leap second check, ignoring Mar 2 11:38:52.554335 chronyd[1974]: Loaded seccomp filter (level 2) Mar 2 11:38:52.555116 KVP[1984]: KVP starting; pid is:1984 Mar 2 11:38:52.566488 kernel: hv_utils: KVP IC version 4.0 Mar 2 11:38:52.561553 KVP[1984]: KVP LIC Version: 3.1 Mar 2 11:38:52.557578 systemd[1]: Starting nvidia.service - NVIDIA Configure Service... Mar 2 11:38:52.565652 systemd[1]: Starting ssh-key-proc-cmdline.service - Install an ssh key from /proc/cmdline... Mar 2 11:38:52.574098 systemd[1]: Starting sshd-keygen.service - Generate sshd host keys... Mar 2 11:38:52.588252 systemd[1]: Starting systemd-logind.service - User Login Management... Mar 2 11:38:52.592514 extend-filesystems[1983]: Found /dev/sda6 Mar 2 11:38:52.594738 systemd[1]: tcsd.service - TCG Core Services Daemon was skipped because of an unmet condition check (ConditionPathExists=/dev/tpm0). Mar 2 11:38:52.601402 extend-filesystems[1983]: Found /dev/sda9 Mar 2 11:38:52.595163 systemd[1]: cgroup compatibility translation between legacy and unified hierarchy settings activated. See cgroup-compat debug messages for details. Mar 2 11:38:52.609000 extend-filesystems[1983]: Checking size of /dev/sda9 Mar 2 11:38:52.597998 systemd[1]: Starting update-engine.service - Update Engine... Mar 2 11:38:52.613231 systemd[1]: Starting update-ssh-keys-after-ignition.service - Run update-ssh-keys once after Ignition... Mar 2 11:38:52.621988 jq[2012]: true Mar 2 11:38:52.622435 systemd[1]: Started chronyd.service - NTP client/server. Mar 2 11:38:52.629906 systemd[1]: Finished dracut-shutdown.service - Restore /run/initramfs on shutdown. Mar 2 11:38:52.638088 systemd[1]: enable-oem-cloudinit.service: Skipped due to 'exec-condition'. Mar 2 11:38:52.638308 systemd[1]: Condition check resulted in enable-oem-cloudinit.service - Enable cloudinit being skipped. Mar 2 11:38:52.638556 systemd[1]: motdgen.service: Deactivated successfully. Mar 2 11:38:52.638962 systemd[1]: Finished motdgen.service - Generate /run/flatcar/motd. Mar 2 11:38:52.647129 systemd[1]: Finished nvidia.service - NVIDIA Configure Service. Mar 2 11:38:52.653411 update_engine[2007]: I20260302 11:38:52.653317 2007 main.cc:92] Flatcar Update Engine starting Mar 2 11:38:52.655071 systemd[1]: ssh-key-proc-cmdline.service: Deactivated successfully. Mar 2 11:38:52.656630 systemd[1]: Finished ssh-key-proc-cmdline.service - Install an ssh key from /proc/cmdline. Mar 2 11:38:52.662463 extend-filesystems[1983]: Resized partition /dev/sda9 Mar 2 11:38:52.682462 jq[2027]: true Mar 2 11:38:52.736353 systemd-logind[2001]: New seat seat0. Mar 2 11:38:52.740586 systemd-logind[2001]: Watching system buttons on /dev/input/event1 (AT Translated Set 2 keyboard) Mar 2 11:38:52.740823 systemd[1]: Started systemd-logind.service - User Login Management. Mar 2 11:38:52.751558 dbus-daemon[1977]: [system] SELinux support is enabled Mar 2 11:38:52.751794 systemd[1]: Started dbus.service - D-Bus System Message Bus. Mar 2 11:38:52.759707 bash[2060]: Updated "/home/core/.ssh/authorized_keys" Mar 2 11:38:52.762926 systemd[1]: Finished update-ssh-keys-after-ignition.service - Run update-ssh-keys once after Ignition. Mar 2 11:38:52.775032 update_engine[2007]: I20260302 11:38:52.774969 2007 update_check_scheduler.cc:74] Next update check in 9m30s Mar 2 11:38:52.776986 systemd[1]: sshkeys.service was skipped because no trigger condition checks were met. Mar 2 11:38:52.777095 systemd[1]: system-cloudinit@usr-share-oem-cloud\x2dconfig.yml.service - Load cloud-config from /usr/share/oem/cloud-config.yml was skipped because of an unmet condition check (ConditionFileNotEmpty=/usr/share/oem/cloud-config.yml). Mar 2 11:38:52.777124 systemd[1]: Reached target system-config.target - Load system-provided cloud configs. Mar 2 11:38:52.783605 dbus-daemon[1977]: [system] Successfully activated service 'org.freedesktop.systemd1' Mar 2 11:38:52.787865 systemd[1]: user-cloudinit-proc-cmdline.service - Load cloud-config from url defined in /proc/cmdline was skipped because of an unmet condition check (ConditionKernelCommandLine=cloud-config-url). Mar 2 11:38:52.787888 systemd[1]: Reached target user-config.target - Load user-provided cloud configs. Mar 2 11:38:52.799037 systemd[1]: Started update-engine.service - Update Engine. Mar 2 11:38:52.811963 systemd[1]: Started locksmithd.service - Cluster reboot manager. Mar 2 11:38:52.842075 coreos-metadata[1976]: Mar 02 11:38:52.841 INFO Fetching http://168.63.129.16/?comp=versions: Attempt #1 Mar 2 11:38:52.848852 coreos-metadata[1976]: Mar 02 11:38:52.848 INFO Fetch successful Mar 2 11:38:52.848957 coreos-metadata[1976]: Mar 02 11:38:52.848 INFO Fetching http://168.63.129.16/machine/?comp=goalstate: Attempt #1 Mar 2 11:38:52.853976 coreos-metadata[1976]: Mar 02 11:38:52.853 INFO Fetch successful Mar 2 11:38:52.855084 coreos-metadata[1976]: Mar 02 11:38:52.854 INFO Fetching http://168.63.129.16/machine/c79df8f0-17d8-438f-ab1c-bbe1dc85022f/66a4aab8%2D7c5c%2D4cde%2D8809%2Dc05b3affc9cf.%5Fci%2D9999.9.9%2Dm%2D93217899aa?comp=config&type=sharedConfig&incarnation=1: Attempt #1 Mar 2 11:38:52.857469 coreos-metadata[1976]: Mar 02 11:38:52.857 INFO Fetch successful Mar 2 11:38:52.857840 coreos-metadata[1976]: Mar 02 11:38:52.857 INFO Fetching http://169.254.169.254/metadata/instance/compute/vmSize?api-version=2017-08-01&format=text: Attempt #1 Mar 2 11:38:52.866334 coreos-metadata[1976]: Mar 02 11:38:52.865 INFO Fetch successful Mar 2 11:38:52.939874 systemd[1]: Finished coreos-metadata.service - Flatcar Metadata Agent. Mar 2 11:38:52.947412 systemd[1]: packet-phone-home.service - Report Success to Packet was skipped because no trigger condition checks were met. Mar 2 11:38:52.957135 locksmithd[2094]: locksmithd starting currentOperation="UPDATE_STATUS_IDLE" strategy="reboot" Mar 2 11:38:52.967446 kernel: BTRFS info (device sda9): resizing devid 1 Mar 2 11:38:52.978992 extend-filesystems[2141]: Resize device id 1 (/dev/sda9) from 24.26GiB to max Mar 2 11:38:52.985765 kernel: BTRFS info (device sda9): resize device /dev/sda9 (devid 1) from 26048724992 to 26120007680 Mar 2 11:38:52.980864 systemd[1]: extend-filesystems.service: Deactivated successfully. Mar 2 11:38:52.985987 extend-filesystems[1983]: Resized filesystem in /dev/sda9 Mar 2 11:38:52.981159 systemd[1]: Finished extend-filesystems.service - Extend Filesystems. Mar 2 11:38:53.080054 sshd_keygen[2009]: ssh-keygen: generating new host keys: RSA ECDSA ED25519 Mar 2 11:38:53.095964 systemd[1]: Finished sshd-keygen.service - Generate sshd host keys. Mar 2 11:38:53.105148 systemd[1]: Starting issuegen.service - Generate /run/issue... Mar 2 11:38:53.115993 systemd[1]: Starting waagent.service - Microsoft Azure Linux Agent... Mar 2 11:38:53.121570 systemd[1]: issuegen.service: Deactivated successfully. Mar 2 11:38:53.121785 systemd[1]: Finished issuegen.service - Generate /run/issue. Mar 2 11:38:53.129695 systemd[1]: Starting systemd-user-sessions.service - Permit User Sessions... Mar 2 11:38:53.142288 systemd[1]: Finished systemd-user-sessions.service - Permit User Sessions. Mar 2 11:38:53.149786 systemd[1]: Started waagent.service - Microsoft Azure Linux Agent. Mar 2 11:38:53.160897 systemd[1]: Started getty@tty1.service - Getty on tty1. Mar 2 11:38:53.168507 systemd[1]: Started serial-getty@ttyAMA0.service - Serial Getty on ttyAMA0. Mar 2 11:38:53.174656 systemd[1]: Reached target getty.target - Login Prompts. Mar 2 11:38:53.436162 containerd[2033]: time="2026-03-02T11:38:53Z" 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 Mar 2 11:38:53.437379 containerd[2033]: time="2026-03-02T11:38:53.436906728Z" level=info msg="starting containerd" revision=1c4457e00facac03ce1d75f7b6777a7a851e5c41 version=v2.2.0 Mar 2 11:38:53.446884 containerd[2033]: time="2026-03-02T11:38:53.446848560Z" level=warning msg="Configuration migrated from version 2, use `containerd config migrate` to avoid migration" t="8.144µs" Mar 2 11:38:53.447724 containerd[2033]: time="2026-03-02T11:38:53.446959064Z" level=info msg="loading plugin" id=io.containerd.content.v1.content type=io.containerd.content.v1 Mar 2 11:38:53.447724 containerd[2033]: time="2026-03-02T11:38:53.447000648Z" level=info msg="loading plugin" id=io.containerd.image-verifier.v1.bindir type=io.containerd.image-verifier.v1 Mar 2 11:38:53.447724 containerd[2033]: time="2026-03-02T11:38:53.447010144Z" level=info msg="loading plugin" id=io.containerd.internal.v1.opt type=io.containerd.internal.v1 Mar 2 11:38:53.447724 containerd[2033]: time="2026-03-02T11:38:53.447105408Z" level=info msg="loading plugin" id=io.containerd.warning.v1.deprecations type=io.containerd.warning.v1 Mar 2 11:38:53.447724 containerd[2033]: time="2026-03-02T11:38:53.447115904Z" level=info msg="loading plugin" id=io.containerd.mount-handler.v1.erofs type=io.containerd.mount-handler.v1 Mar 2 11:38:53.447724 containerd[2033]: time="2026-03-02T11:38:53.447122944Z" level=info msg="loading plugin" id=io.containerd.snapshotter.v1.blockfile type=io.containerd.snapshotter.v1 Mar 2 11:38:53.447724 containerd[2033]: time="2026-03-02T11:38:53.447150120Z" level=info msg="skip loading plugin" error="no scratch file generator: skip plugin" id=io.containerd.snapshotter.v1.blockfile type=io.containerd.snapshotter.v1 Mar 2 11:38:53.447724 containerd[2033]: time="2026-03-02T11:38:53.447159856Z" level=info msg="loading plugin" id=io.containerd.snapshotter.v1.btrfs type=io.containerd.snapshotter.v1 Mar 2 11:38:53.447724 containerd[2033]: time="2026-03-02T11:38:53.447346248Z" level=info msg="loading plugin" id=io.containerd.snapshotter.v1.devmapper type=io.containerd.snapshotter.v1 Mar 2 11:38:53.447724 containerd[2033]: time="2026-03-02T11:38:53.447357208Z" level=info msg="skip loading plugin" error="devmapper not configured: skip plugin" id=io.containerd.snapshotter.v1.devmapper type=io.containerd.snapshotter.v1 Mar 2 11:38:53.447724 containerd[2033]: time="2026-03-02T11:38:53.447362528Z" level=info msg="loading plugin" id=io.containerd.snapshotter.v1.erofs type=io.containerd.snapshotter.v1 Mar 2 11:38:53.447724 containerd[2033]: time="2026-03-02T11:38:53.447497560Z" level=info msg="loading plugin" id=io.containerd.snapshotter.v1.native type=io.containerd.snapshotter.v1 Mar 2 11:38:53.447724 containerd[2033]: time="2026-03-02T11:38:53.447527904Z" level=info msg="loading plugin" id=io.containerd.snapshotter.v1.overlayfs type=io.containerd.snapshotter.v1 Mar 2 11:38:53.447924 containerd[2033]: time="2026-03-02T11:38:53.447642072Z" level=info msg="loading plugin" id=io.containerd.snapshotter.v1.zfs type=io.containerd.snapshotter.v1 Mar 2 11:38:53.447924 containerd[2033]: time="2026-03-02T11:38:53.447660624Z" 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 Mar 2 11:38:53.447924 containerd[2033]: time="2026-03-02T11:38:53.447666800Z" level=info msg="loading plugin" id=io.containerd.event.v1.exchange type=io.containerd.event.v1 Mar 2 11:38:53.448122 containerd[2033]: time="2026-03-02T11:38:53.448104920Z" level=info msg="loading plugin" id=io.containerd.monitor.task.v1.cgroups type=io.containerd.monitor.task.v1 Mar 2 11:38:53.448509 containerd[2033]: time="2026-03-02T11:38:53.448489776Z" level=info msg="loading plugin" id=io.containerd.metadata.v1.bolt type=io.containerd.metadata.v1 Mar 2 11:38:53.448616 containerd[2033]: time="2026-03-02T11:38:53.448602760Z" level=info msg="metadata content store policy set" policy=shared Mar 2 11:38:53.469137 containerd[2033]: time="2026-03-02T11:38:53.469092992Z" level=info msg="loading plugin" id=io.containerd.gc.v1.scheduler type=io.containerd.gc.v1 Mar 2 11:38:53.469302 containerd[2033]: time="2026-03-02T11:38:53.469287800Z" level=info msg="loading plugin" id=io.containerd.nri.v1.nri type=io.containerd.nri.v1 Mar 2 11:38:53.469395 containerd[2033]: time="2026-03-02T11:38:53.469385184Z" level=info msg="built-in NRI default validator is disabled" Mar 2 11:38:53.469484 containerd[2033]: time="2026-03-02T11:38:53.469471968Z" level=info msg="runtime interface created" Mar 2 11:38:53.469531 containerd[2033]: time="2026-03-02T11:38:53.469511872Z" level=info msg="created NRI interface" Mar 2 11:38:53.469608 containerd[2033]: time="2026-03-02T11:38:53.469595400Z" level=info msg="loading plugin" id=io.containerd.differ.v1.erofs type=io.containerd.differ.v1 Mar 2 11:38:53.469742 containerd[2033]: time="2026-03-02T11:38:53.469719520Z" level=info msg="skip loading plugin" error="failed to check mkfs.erofs availability: failed to run mkfs.erofs --help: exec: \"mkfs.erofs\": executable file not found in $PATH: skip plugin" id=io.containerd.differ.v1.erofs type=io.containerd.differ.v1 Mar 2 11:38:53.469802 containerd[2033]: time="2026-03-02T11:38:53.469791240Z" level=info msg="loading plugin" id=io.containerd.differ.v1.walking type=io.containerd.differ.v1 Mar 2 11:38:53.469856 containerd[2033]: time="2026-03-02T11:38:53.469845296Z" level=info msg="loading plugin" id=io.containerd.lease.v1.manager type=io.containerd.lease.v1 Mar 2 11:38:53.469901 containerd[2033]: time="2026-03-02T11:38:53.469890752Z" level=info msg="loading plugin" id=io.containerd.mount-manager.v1.bolt type=io.containerd.mount-manager.v1 Mar 2 11:38:53.470176 containerd[2033]: time="2026-03-02T11:38:53.470155280Z" level=info msg="loading plugin" id=io.containerd.service.v1.containers-service type=io.containerd.service.v1 Mar 2 11:38:53.470248 containerd[2033]: time="2026-03-02T11:38:53.470234624Z" level=info msg="loading plugin" id=io.containerd.service.v1.content-service type=io.containerd.service.v1 Mar 2 11:38:53.470322 containerd[2033]: time="2026-03-02T11:38:53.470309104Z" level=info msg="loading plugin" id=io.containerd.service.v1.diff-service type=io.containerd.service.v1 Mar 2 11:38:53.470389 containerd[2033]: time="2026-03-02T11:38:53.470376552Z" level=info msg="loading plugin" id=io.containerd.service.v1.images-service type=io.containerd.service.v1 Mar 2 11:38:53.470454 containerd[2033]: time="2026-03-02T11:38:53.470442832Z" level=info msg="loading plugin" id=io.containerd.service.v1.introspection-service type=io.containerd.service.v1 Mar 2 11:38:53.470507 containerd[2033]: time="2026-03-02T11:38:53.470497824Z" level=info msg="loading plugin" id=io.containerd.service.v1.namespaces-service type=io.containerd.service.v1 Mar 2 11:38:53.470548 containerd[2033]: time="2026-03-02T11:38:53.470539016Z" level=info msg="loading plugin" id=io.containerd.service.v1.snapshots-service type=io.containerd.service.v1 Mar 2 11:38:53.470597 containerd[2033]: time="2026-03-02T11:38:53.470585728Z" level=info msg="loading plugin" id=io.containerd.shim.v1.manager type=io.containerd.shim.v1 Mar 2 11:38:53.470676 containerd[2033]: time="2026-03-02T11:38:53.470666008Z" level=info msg="loading plugin" id=io.containerd.runtime.v2.task type=io.containerd.runtime.v2 Mar 2 11:38:53.470822 containerd[2033]: time="2026-03-02T11:38:53.470807456Z" level=info msg="loading plugin" id=io.containerd.service.v1.tasks-service type=io.containerd.service.v1 Mar 2 11:38:53.470884 containerd[2033]: time="2026-03-02T11:38:53.470874088Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.containers type=io.containerd.grpc.v1 Mar 2 11:38:53.470922 containerd[2033]: time="2026-03-02T11:38:53.470914184Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.content type=io.containerd.grpc.v1 Mar 2 11:38:53.470984 containerd[2033]: time="2026-03-02T11:38:53.470974120Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.diff type=io.containerd.grpc.v1 Mar 2 11:38:53.471024 containerd[2033]: time="2026-03-02T11:38:53.471015920Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.events type=io.containerd.grpc.v1 Mar 2 11:38:53.471081 containerd[2033]: time="2026-03-02T11:38:53.471070720Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.images type=io.containerd.grpc.v1 Mar 2 11:38:53.471123 containerd[2033]: time="2026-03-02T11:38:53.471114288Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.introspection type=io.containerd.grpc.v1 Mar 2 11:38:53.471179 containerd[2033]: time="2026-03-02T11:38:53.471168736Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.leases type=io.containerd.grpc.v1 Mar 2 11:38:53.471236 containerd[2033]: time="2026-03-02T11:38:53.471220248Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.mounts type=io.containerd.grpc.v1 Mar 2 11:38:53.471339 containerd[2033]: time="2026-03-02T11:38:53.471272624Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.namespaces type=io.containerd.grpc.v1 Mar 2 11:38:53.471339 containerd[2033]: time="2026-03-02T11:38:53.471289168Z" level=info msg="loading plugin" id=io.containerd.sandbox.store.v1.local type=io.containerd.sandbox.store.v1 Mar 2 11:38:53.471339 containerd[2033]: time="2026-03-02T11:38:53.471297072Z" level=info msg="loading plugin" id=io.containerd.transfer.v1.local type=io.containerd.transfer.v1 Mar 2 11:38:53.471339 containerd[2033]: time="2026-03-02T11:38:53.471319976Z" level=info msg="loading plugin" id=io.containerd.cri.v1.images type=io.containerd.cri.v1 Mar 2 11:38:53.475617 containerd[2033]: time="2026-03-02T11:38:53.475593560Z" level=info msg="Get image filesystem path \"/var/lib/containerd/io.containerd.snapshotter.v1.overlayfs\" for snapshotter \"overlayfs\"" Mar 2 11:38:53.476095 containerd[2033]: time="2026-03-02T11:38:53.475700672Z" level=info msg="Start snapshots syncer" Mar 2 11:38:53.476095 containerd[2033]: time="2026-03-02T11:38:53.475729584Z" level=info msg="loading plugin" id=io.containerd.cri.v1.runtime type=io.containerd.cri.v1 Mar 2 11:38:53.476095 containerd[2033]: time="2026-03-02T11:38:53.475960584Z" level=info msg="starting cri plugin" config="{\"containerd\":{\"defaultRuntimeName\":\"runc\",\"runtimes\":{\"runc\":{\"runtimeType\":\"io.containerd.runc.v2\",\"runtimePath\":\"\",\"PodAnnotations\":null,\"ContainerAnnotations\":null,\"options\":{\"BinaryName\":\"\",\"CriuImagePath\":\"\",\"CriuWorkPath\":\"\",\"IoGid\":0,\"IoUid\":0,\"NoNewKeyring\":false,\"Root\":\"\",\"ShimCgroup\":\"\",\"SystemdCgroup\":true},\"privileged_without_host_devices\":false,\"privileged_without_host_devices_all_devices_allowed\":false,\"cgroupWritable\":false,\"baseRuntimeSpec\":\"\",\"cniConfDir\":\"\",\"cniMaxConfNum\":0,\"snapshotter\":\"\",\"sandboxer\":\"podsandbox\",\"io_type\":\"\"}},\"ignoreBlockIONotEnabledErrors\":false,\"ignoreRdtNotEnabledErrors\":false},\"cni\":{\"binDir\":\"\",\"binDirs\":[\"/opt/cni/bin\"],\"confDir\":\"/etc/cni/net.d\",\"maxConfNum\":1,\"setupSerially\":false,\"confTemplate\":\"\",\"ipPref\":\"\",\"useInternalLoopback\":false},\"enableSelinux\":true,\"selinuxCategoryRange\":1024,\"maxContainerLogLineSize\":16384,\"disableApparmor\":false,\"restrictOOMScoreAdj\":false,\"disableProcMount\":false,\"unsetSeccompProfile\":\"\",\"tolerateMissingHugetlbController\":true,\"disableHugetlbController\":true,\"device_ownership_from_security_context\":false,\"ignoreImageDefinedVolumes\":false,\"netnsMountsUnderStateDir\":false,\"enableUnprivilegedPorts\":true,\"enableUnprivilegedICMP\":true,\"enableCDI\":true,\"cdiSpecDirs\":[\"/etc/cdi\",\"/var/run/cdi\"],\"drainExecSyncIOTimeout\":\"0s\",\"ignoreDeprecationWarnings\":null,\"containerdRootDir\":\"/var/lib/containerd\",\"containerdEndpoint\":\"/run/containerd/containerd.sock\",\"rootDir\":\"/var/lib/containerd/io.containerd.grpc.v1.cri\",\"stateDir\":\"/run/containerd/io.containerd.grpc.v1.cri\"}" Mar 2 11:38:53.476222 containerd[2033]: time="2026-03-02T11:38:53.476000736Z" level=info msg="loading plugin" id=io.containerd.podsandbox.controller.v1.podsandbox type=io.containerd.podsandbox.controller.v1 Mar 2 11:38:53.476396 containerd[2033]: time="2026-03-02T11:38:53.476376496Z" level=info msg="loading plugin" id=io.containerd.sandbox.controller.v1.shim type=io.containerd.sandbox.controller.v1 Mar 2 11:38:53.476593 containerd[2033]: time="2026-03-02T11:38:53.476576488Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.sandbox-controllers type=io.containerd.grpc.v1 Mar 2 11:38:53.476656 containerd[2033]: time="2026-03-02T11:38:53.476642864Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.sandboxes type=io.containerd.grpc.v1 Mar 2 11:38:53.476716 containerd[2033]: time="2026-03-02T11:38:53.476705416Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.snapshots type=io.containerd.grpc.v1 Mar 2 11:38:53.476767 containerd[2033]: time="2026-03-02T11:38:53.476756456Z" level=info msg="loading plugin" id=io.containerd.streaming.v1.manager type=io.containerd.streaming.v1 Mar 2 11:38:53.476807 containerd[2033]: time="2026-03-02T11:38:53.476797792Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.streaming type=io.containerd.grpc.v1 Mar 2 11:38:53.476851 containerd[2033]: time="2026-03-02T11:38:53.476841040Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.tasks type=io.containerd.grpc.v1 Mar 2 11:38:53.476897 containerd[2033]: time="2026-03-02T11:38:53.476886208Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.transfer type=io.containerd.grpc.v1 Mar 2 11:38:53.476936 containerd[2033]: time="2026-03-02T11:38:53.476925824Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.version type=io.containerd.grpc.v1 Mar 2 11:38:53.476972 containerd[2033]: time="2026-03-02T11:38:53.476962104Z" level=info msg="loading plugin" id=io.containerd.monitor.container.v1.restart type=io.containerd.monitor.container.v1 Mar 2 11:38:53.477036 containerd[2033]: time="2026-03-02T11:38:53.477024136Z" level=info msg="loading plugin" id=io.containerd.tracing.processor.v1.otlp type=io.containerd.tracing.processor.v1 Mar 2 11:38:53.477097 containerd[2033]: time="2026-03-02T11:38:53.477083208Z" 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 Mar 2 11:38:53.477134 containerd[2033]: time="2026-03-02T11:38:53.477125128Z" level=info msg="loading plugin" id=io.containerd.internal.v1.tracing type=io.containerd.internal.v1 Mar 2 11:38:53.477179 containerd[2033]: time="2026-03-02T11:38:53.477167992Z" level=info msg="skip loading plugin" error="skip plugin: tracing endpoint not configured" id=io.containerd.internal.v1.tracing type=io.containerd.internal.v1 Mar 2 11:38:53.477212 containerd[2033]: time="2026-03-02T11:38:53.477204136Z" level=info msg="loading plugin" id=io.containerd.ttrpc.v1.otelttrpc type=io.containerd.ttrpc.v1 Mar 2 11:38:53.477247 containerd[2033]: time="2026-03-02T11:38:53.477237368Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.healthcheck type=io.containerd.grpc.v1 Mar 2 11:38:53.477283 containerd[2033]: time="2026-03-02T11:38:53.477274232Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.cri type=io.containerd.grpc.v1 Mar 2 11:38:53.477320 containerd[2033]: time="2026-03-02T11:38:53.477310648Z" level=info msg="Connect containerd service" Mar 2 11:38:53.477370 containerd[2033]: time="2026-03-02T11:38:53.477359592Z" level=info msg="using experimental NRI integration - disable nri plugin to prevent this" Mar 2 11:38:53.478268 containerd[2033]: time="2026-03-02T11:38:53.478242504Z" level=error msg="failed to load cni during init, please check CRI plugin status before setting up network for pods" error="cni config load failed: no network config found in /etc/cni/net.d: cni plugin not initialized: failed to load cni config" Mar 2 11:38:53.696860 containerd[2033]: time="2026-03-02T11:38:53.696647960Z" level=info msg="Start subscribing containerd event" Mar 2 11:38:53.696860 containerd[2033]: time="2026-03-02T11:38:53.696745272Z" level=info msg="Start recovering state" Mar 2 11:38:53.697232 containerd[2033]: time="2026-03-02T11:38:53.697102248Z" level=info msg="Start event monitor" Mar 2 11:38:53.697232 containerd[2033]: time="2026-03-02T11:38:53.697122912Z" level=info msg="Start cni network conf syncer for default" Mar 2 11:38:53.697232 containerd[2033]: time="2026-03-02T11:38:53.697130072Z" level=info msg="Start streaming server" Mar 2 11:38:53.697232 containerd[2033]: time="2026-03-02T11:38:53.697145016Z" level=info msg="Registered namespace \"k8s.io\" with NRI" Mar 2 11:38:53.697232 containerd[2033]: time="2026-03-02T11:38:53.697158984Z" level=info msg="runtime interface starting up..." Mar 2 11:38:53.697232 containerd[2033]: time="2026-03-02T11:38:53.697163408Z" level=info msg="starting plugins..." Mar 2 11:38:53.697232 containerd[2033]: time="2026-03-02T11:38:53.697178008Z" level=info msg="Synchronizing NRI (plugin) with current runtime state" Mar 2 11:38:53.701255 containerd[2033]: time="2026-03-02T11:38:53.701144424Z" level=info msg=serving... address=/run/containerd/containerd.sock.ttrpc Mar 2 11:38:53.701255 containerd[2033]: time="2026-03-02T11:38:53.701192720Z" level=info msg=serving... address=/run/containerd/containerd.sock Mar 2 11:38:53.704277 containerd[2033]: time="2026-03-02T11:38:53.704249392Z" level=info msg="containerd successfully booted in 0.268594s" Mar 2 11:38:53.704430 systemd[1]: Started containerd.service - containerd container runtime. Mar 2 11:38:53.710049 systemd[1]: Reached target multi-user.target - Multi-User System. Mar 2 11:38:53.715578 systemd[1]: Startup finished in 1.754s (kernel) + 26.800s (initrd) + 6.567s (userspace) = 35.123s. Mar 2 11:38:54.170677 login[2165]: pam_unix(login:session): session opened for user core(uid=500) by core(uid=0) Mar 2 11:38:54.170678 login[2166]: pam_unix(login:session): session opened for user core(uid=500) by core(uid=0) Mar 2 11:38:54.180962 systemd[1]: Created slice user-500.slice - User Slice of UID 500. Mar 2 11:38:54.182855 systemd[1]: Starting user-runtime-dir@500.service - User Runtime Directory /run/user/500... Mar 2 11:38:54.187645 systemd-logind[2001]: New session 2 of user core. Mar 2 11:38:54.192118 systemd-logind[2001]: New session 1 of user core. Mar 2 11:38:54.205469 systemd[1]: Finished user-runtime-dir@500.service - User Runtime Directory /run/user/500. Mar 2 11:38:54.208609 systemd[1]: Starting user@500.service - User Manager for UID 500... Mar 2 11:38:54.218240 (systemd)[2194]: pam_unix(systemd-user:session): session opened for user core(uid=500) by core(uid=0) Mar 2 11:38:54.220891 systemd-logind[2001]: New session 3 of user core. Mar 2 11:38:54.300263 waagent[2163]: 2026-03-02T11:38:54.295996Z INFO Daemon Daemon Azure Linux Agent Version: 2.12.0.4 Mar 2 11:38:54.300833 waagent[2163]: 2026-03-02T11:38:54.300781Z INFO Daemon Daemon OS: flatcar 9999.9.9 Mar 2 11:38:54.304437 waagent[2163]: 2026-03-02T11:38:54.304388Z INFO Daemon Daemon Python: 3.12.12 Mar 2 11:38:54.308029 waagent[2163]: 2026-03-02T11:38:54.307881Z INFO Daemon Daemon Run daemon Mar 2 11:38:54.311166 waagent[2163]: 2026-03-02T11:38:54.311127Z INFO Daemon Daemon No RDMA handler exists for distro='Flatcar Container Linux by Kinvolk' version='9999.9.9' Mar 2 11:38:54.317975 waagent[2163]: 2026-03-02T11:38:54.317934Z INFO Daemon Daemon Using waagent for provisioning Mar 2 11:38:54.322166 waagent[2163]: 2026-03-02T11:38:54.322126Z INFO Daemon Daemon Activate resource disk Mar 2 11:38:54.325632 waagent[2163]: 2026-03-02T11:38:54.325600Z INFO Daemon Daemon Searching gen1 prefix 00000000-0001 or gen2 f8b3781a-1e82-4818-a1c3-63d806ec15bb Mar 2 11:38:54.333851 waagent[2163]: 2026-03-02T11:38:54.333812Z INFO Daemon Daemon Found device: None Mar 2 11:38:54.337105 waagent[2163]: 2026-03-02T11:38:54.337070Z ERROR Daemon Daemon Failed to mount resource disk [ResourceDiskError] unable to detect disk topology Mar 2 11:38:54.343191 waagent[2163]: 2026-03-02T11:38:54.343156Z ERROR Daemon Daemon Event: name=WALinuxAgent, op=ActivateResourceDisk, message=[ResourceDiskError] unable to detect disk topology, duration=0 Mar 2 11:38:54.352019 waagent[2163]: 2026-03-02T11:38:54.351978Z INFO Daemon Daemon Clean protocol and wireserver endpoint Mar 2 11:38:54.356247 waagent[2163]: 2026-03-02T11:38:54.356212Z INFO Daemon Daemon Running default provisioning handler Mar 2 11:38:54.366048 waagent[2163]: 2026-03-02T11:38:54.366005Z 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. Mar 2 11:38:54.376092 waagent[2163]: 2026-03-02T11:38:54.376056Z INFO Daemon Daemon Unable to get cloud-init enabled status from service: [Errno 2] No such file or directory: 'service' Mar 2 11:38:54.376118 systemd[2194]: Queued start job for default target default.target. Mar 2 11:38:54.383269 waagent[2163]: 2026-03-02T11:38:54.383226Z INFO Daemon Daemon cloud-init is enabled: False Mar 2 11:38:54.384208 systemd[2194]: Created slice app.slice - User Application Slice. Mar 2 11:38:54.384233 systemd[2194]: Started systemd-tmpfiles-clean.timer - Daily Cleanup of User's Temporary Directories. Mar 2 11:38:54.384242 systemd[2194]: Reached target paths.target - Paths. Mar 2 11:38:54.384283 systemd[2194]: Reached target timers.target - Timers. Mar 2 11:38:54.387701 waagent[2163]: 2026-03-02T11:38:54.387662Z INFO Daemon Daemon Copying ovf-env.xml Mar 2 11:38:54.388549 systemd[2194]: Starting dbus.socket - D-Bus User Message Bus Socket... Mar 2 11:38:54.392583 systemd[2194]: Starting systemd-tmpfiles-setup.service - Create User Files and Directories... Mar 2 11:38:54.399822 systemd[2194]: Listening on dbus.socket - D-Bus User Message Bus Socket. Mar 2 11:38:54.399887 systemd[2194]: Reached target sockets.target - Sockets. Mar 2 11:38:54.417405 systemd[2194]: Finished systemd-tmpfiles-setup.service - Create User Files and Directories. Mar 2 11:38:54.417545 systemd[2194]: Reached target basic.target - Basic System. Mar 2 11:38:54.417595 systemd[2194]: Reached target default.target - Main User Target. Mar 2 11:38:54.417614 systemd[2194]: Startup finished in 192ms. Mar 2 11:38:54.417887 systemd[1]: Started user@500.service - User Manager for UID 500. Mar 2 11:38:54.424601 systemd[1]: Started session-1.scope - Session 1 of User core. Mar 2 11:38:54.425229 systemd[1]: Started session-2.scope - Session 2 of User core. Mar 2 11:38:54.431458 waagent[2163]: 2026-03-02T11:38:54.428610Z INFO Daemon Daemon Successfully mounted dvd Mar 2 11:38:54.466866 systemd[1]: mnt-cdrom-secure.mount: Deactivated successfully. Mar 2 11:38:54.468147 waagent[2163]: 2026-03-02T11:38:54.467944Z INFO Daemon Daemon Detect protocol endpoint Mar 2 11:38:54.472603 waagent[2163]: 2026-03-02T11:38:54.472547Z INFO Daemon Daemon Clean protocol and wireserver endpoint Mar 2 11:38:54.480449 waagent[2163]: 2026-03-02T11:38:54.477981Z INFO Daemon Daemon WireServer endpoint is not found. Rerun dhcp handler Mar 2 11:38:54.484374 waagent[2163]: 2026-03-02T11:38:54.484048Z INFO Daemon Daemon Test for route to 168.63.129.16 Mar 2 11:38:54.491558 waagent[2163]: 2026-03-02T11:38:54.491489Z INFO Daemon Daemon Route to 168.63.129.16 exists Mar 2 11:38:54.495446 waagent[2163]: 2026-03-02T11:38:54.495365Z INFO Daemon Daemon Wire server endpoint:168.63.129.16 Mar 2 11:38:54.523027 waagent[2163]: 2026-03-02T11:38:54.522985Z INFO Daemon Daemon Fabric preferred wire protocol version:2015-04-05 Mar 2 11:38:54.529520 waagent[2163]: 2026-03-02T11:38:54.529488Z INFO Daemon Daemon Wire protocol version:2012-11-30 Mar 2 11:38:54.534225 waagent[2163]: 2026-03-02T11:38:54.534192Z INFO Daemon Daemon Server preferred version:2015-04-05 Mar 2 11:38:54.701853 waagent[2163]: 2026-03-02T11:38:54.701704Z INFO Daemon Daemon Initializing goal state during protocol detection Mar 2 11:38:54.706892 waagent[2163]: 2026-03-02T11:38:54.706838Z INFO Daemon Daemon Forcing an update of the goal state. Mar 2 11:38:54.714613 waagent[2163]: 2026-03-02T11:38:54.714573Z INFO Daemon Fetched a new incarnation for the WireServer goal state [incarnation 1] Mar 2 11:38:54.732426 waagent[2163]: 2026-03-02T11:38:54.732384Z INFO Daemon Daemon HostGAPlugin version: 1.0.8.179 Mar 2 11:38:54.736974 waagent[2163]: 2026-03-02T11:38:54.736937Z INFO Daemon Mar 2 11:38:54.739125 waagent[2163]: 2026-03-02T11:38:54.739093Z INFO Daemon Fetched new vmSettings [HostGAPlugin correlation ID: 339612e0-98ff-4dd0-95c9-86731358d0d5 eTag: 2088798257965762475 source: Fabric] Mar 2 11:38:54.747487 waagent[2163]: 2026-03-02T11:38:54.747452Z INFO Daemon The vmSettings originated via Fabric; will ignore them. Mar 2 11:38:54.752554 waagent[2163]: 2026-03-02T11:38:54.752522Z INFO Daemon Mar 2 11:38:54.754705 waagent[2163]: 2026-03-02T11:38:54.754673Z INFO Daemon Fetching full goal state from the WireServer [incarnation 1] Mar 2 11:38:54.763721 waagent[2163]: 2026-03-02T11:38:54.763690Z INFO Daemon Daemon Downloading artifacts profile blob Mar 2 11:38:54.835457 waagent[2163]: 2026-03-02T11:38:54.835366Z INFO Daemon Downloaded certificate {'thumbprint': '84D9E0BF45B93943A982D09205B26C517BCEEC39', 'hasPrivateKey': True} Mar 2 11:38:54.843047 waagent[2163]: 2026-03-02T11:38:54.842999Z INFO Daemon Fetch goal state completed Mar 2 11:38:54.853839 waagent[2163]: 2026-03-02T11:38:54.853801Z INFO Daemon Daemon Starting provisioning Mar 2 11:38:54.857861 waagent[2163]: 2026-03-02T11:38:54.857822Z INFO Daemon Daemon Handle ovf-env.xml. Mar 2 11:38:54.861491 waagent[2163]: 2026-03-02T11:38:54.861461Z INFO Daemon Daemon Set hostname [ci-9999.9.9-m-93217899aa] Mar 2 11:38:54.870437 waagent[2163]: 2026-03-02T11:38:54.867879Z INFO Daemon Daemon Publish hostname [ci-9999.9.9-m-93217899aa] Mar 2 11:38:54.872467 waagent[2163]: 2026-03-02T11:38:54.872407Z INFO Daemon Daemon Examine /proc/net/route for primary interface Mar 2 11:38:54.877178 waagent[2163]: 2026-03-02T11:38:54.877140Z INFO Daemon Daemon Primary interface is [eth0] Mar 2 11:38:54.887025 systemd-networkd[1687]: eth0: Found matching .network file, based on potentially unpredictable interface name: /usr/lib/systemd/network/zz-default.network Mar 2 11:38:54.887034 systemd-networkd[1687]: eth0: Reconfiguring with /usr/lib/systemd/network/zz-default.network. Mar 2 11:38:54.887123 systemd-networkd[1687]: eth0: DHCP lease lost Mar 2 11:38:54.900458 waagent[2163]: 2026-03-02T11:38:54.900371Z INFO Daemon Daemon Create user account if not exists Mar 2 11:38:54.904782 waagent[2163]: 2026-03-02T11:38:54.904728Z INFO Daemon Daemon User core already exists, skip useradd Mar 2 11:38:54.909135 waagent[2163]: 2026-03-02T11:38:54.909095Z INFO Daemon Daemon Configure sudoer Mar 2 11:38:54.916477 systemd-networkd[1687]: eth0: DHCPv4 address 10.200.20.34/24, gateway 10.200.20.1 acquired from 168.63.129.16 Mar 2 11:38:54.917270 waagent[2163]: 2026-03-02T11:38:54.916776Z INFO Daemon Daemon Configure sshd Mar 2 11:38:54.928240 waagent[2163]: 2026-03-02T11:38:54.928168Z INFO Daemon Daemon Added a configuration snippet disabling SSH password-based authentication methods. It also configures SSH client probing to keep connections alive. Mar 2 11:38:54.937528 waagent[2163]: 2026-03-02T11:38:54.937481Z INFO Daemon Daemon Deploy ssh public key. Mar 2 11:38:56.012815 waagent[2163]: 2026-03-02T11:38:56.012754Z INFO Daemon Daemon Provisioning complete Mar 2 11:38:56.026663 waagent[2163]: 2026-03-02T11:38:56.026621Z INFO Daemon Daemon RDMA capabilities are not enabled, skipping Mar 2 11:38:56.031510 waagent[2163]: 2026-03-02T11:38:56.031470Z INFO Daemon Daemon End of log to /dev/console. The agent will now check for updates and then will process extensions. Mar 2 11:38:56.038612 waagent[2163]: 2026-03-02T11:38:56.038579Z INFO Daemon Daemon Installed Agent WALinuxAgent-2.12.0.4 is the most current agent Mar 2 11:38:56.146147 waagent[2245]: 2026-03-02T11:38:56.145638Z INFO ExtHandler ExtHandler Azure Linux Agent (Goal State Agent version 2.12.0.4) Mar 2 11:38:56.146147 waagent[2245]: 2026-03-02T11:38:56.145787Z INFO ExtHandler ExtHandler OS: flatcar 9999.9.9 Mar 2 11:38:56.146147 waagent[2245]: 2026-03-02T11:38:56.145840Z INFO ExtHandler ExtHandler Python: 3.12.12 Mar 2 11:38:56.146147 waagent[2245]: 2026-03-02T11:38:56.145879Z INFO ExtHandler ExtHandler CPU Arch: aarch64 Mar 2 11:38:56.160614 waagent[2245]: 2026-03-02T11:38:56.160564Z INFO ExtHandler ExtHandler Distro: flatcar-9999.9.9; OSUtil: FlatcarUtil; AgentService: waagent; Python: 3.12.12; Arch: aarch64; systemd: True; LISDrivers: Absent; logrotate: logrotate 3.22.0; Mar 2 11:38:56.160930 waagent[2245]: 2026-03-02T11:38:56.160900Z INFO ExtHandler ExtHandler WireServer endpoint 168.63.129.16 read from file Mar 2 11:38:56.161076 waagent[2245]: 2026-03-02T11:38:56.161050Z INFO ExtHandler ExtHandler Wire server endpoint:168.63.129.16 Mar 2 11:38:56.168207 waagent[2245]: 2026-03-02T11:38:56.167473Z INFO ExtHandler Fetched a new incarnation for the WireServer goal state [incarnation 1] Mar 2 11:38:56.175319 waagent[2245]: 2026-03-02T11:38:56.175282Z INFO ExtHandler ExtHandler HostGAPlugin version: 1.0.8.179 Mar 2 11:38:56.175876 waagent[2245]: 2026-03-02T11:38:56.175838Z INFO ExtHandler Mar 2 11:38:56.176053 waagent[2245]: 2026-03-02T11:38:56.176024Z INFO ExtHandler Fetched new vmSettings [HostGAPlugin correlation ID: 8311a157-c041-43d5-9ba5-9f5ed234b26d eTag: 2088798257965762475 source: Fabric] Mar 2 11:38:56.176494 waagent[2245]: 2026-03-02T11:38:56.176380Z INFO ExtHandler The vmSettings originated via Fabric; will ignore them. Mar 2 11:38:56.177047 waagent[2245]: 2026-03-02T11:38:56.177012Z INFO ExtHandler Mar 2 11:38:56.177192 waagent[2245]: 2026-03-02T11:38:56.177156Z INFO ExtHandler Fetching full goal state from the WireServer [incarnation 1] Mar 2 11:38:56.180844 waagent[2245]: 2026-03-02T11:38:56.180813Z INFO ExtHandler ExtHandler Downloading artifacts profile blob Mar 2 11:38:56.242644 waagent[2245]: 2026-03-02T11:38:56.242586Z INFO ExtHandler Downloaded certificate {'thumbprint': '84D9E0BF45B93943A982D09205B26C517BCEEC39', 'hasPrivateKey': True} Mar 2 11:38:56.243206 waagent[2245]: 2026-03-02T11:38:56.243170Z INFO ExtHandler Fetch goal state completed Mar 2 11:38:56.254631 waagent[2245]: 2026-03-02T11:38:56.254595Z INFO ExtHandler ExtHandler OpenSSL version: OpenSSL 3.5.5 27 Jan 2026 (Library: OpenSSL 3.5.5 27 Jan 2026) Mar 2 11:38:56.258457 waagent[2245]: 2026-03-02T11:38:56.257738Z INFO ExtHandler ExtHandler WALinuxAgent-2.12.0.4 running as process 2245 Mar 2 11:38:56.258457 waagent[2245]: 2026-03-02T11:38:56.257869Z INFO ExtHandler ExtHandler ******** AutoUpdate.Enabled is set to False, not processing the operation ******** Mar 2 11:38:56.258457 waagent[2245]: 2026-03-02T11:38:56.258140Z INFO ExtHandler ExtHandler ******** AutoUpdate.UpdateToLatestVersion is set to False, not processing the operation ******** Mar 2 11:38:56.259511 waagent[2245]: 2026-03-02T11:38:56.259478Z INFO ExtHandler ExtHandler [CGI] Cgroup monitoring is not supported on ['flatcar', '9999.9.9', '', 'Flatcar Container Linux by Kinvolk'] Mar 2 11:38:56.259961 waagent[2245]: 2026-03-02T11:38:56.259923Z INFO ExtHandler ExtHandler [CGI] Agent will reset the quotas in case distro: ['flatcar', '9999.9.9', '', 'Flatcar Container Linux by Kinvolk'] went from supported to unsupported Mar 2 11:38:56.260171 waagent[2245]: 2026-03-02T11:38:56.260139Z INFO ExtHandler ExtHandler [CGI] Agent cgroups enabled: False Mar 2 11:38:56.260841 waagent[2245]: 2026-03-02T11:38:56.260807Z INFO ExtHandler ExtHandler Starting setup for Persistent firewall rules Mar 2 11:38:56.277323 waagent[2245]: 2026-03-02T11:38:56.276930Z INFO ExtHandler ExtHandler Firewalld service not running/unavailable, trying to set up waagent-network-setup.service Mar 2 11:38:56.277323 waagent[2245]: 2026-03-02T11:38:56.277114Z INFO ExtHandler ExtHandler Successfully updated the Binary file /var/lib/waagent/waagent-network-setup.py for firewall setup Mar 2 11:38:56.281720 waagent[2245]: 2026-03-02T11:38:56.281686Z INFO ExtHandler ExtHandler Service: waagent-network-setup.service not enabled. Adding it now Mar 2 11:38:56.297406 systemd[1]: Reload requested from client PID 2260 ('systemctl') (unit waagent.service)... Mar 2 11:38:56.297481 systemd[1]: Reloading... Mar 2 11:38:56.368457 zram_generator::config[2302]: No configuration found. Mar 2 11:38:56.550105 systemd[1]: Reloading finished in 252 ms. Mar 2 11:38:56.561480 waagent[2245]: 2026-03-02T11:38:56.560745Z INFO ExtHandler ExtHandler Successfully added and enabled the waagent-network-setup.service Mar 2 11:38:56.561480 waagent[2245]: 2026-03-02T11:38:56.560900Z INFO ExtHandler ExtHandler Persistent firewall rules setup successfully Mar 2 11:38:56.627881 waagent[2245]: 2026-03-02T11:38:56.627817Z INFO ExtHandler ExtHandler DROP rule is not available which implies no firewall rules are set yet. Environment thread will set it up. Mar 2 11:38:56.628296 waagent[2245]: 2026-03-02T11:38:56.628260Z 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] Mar 2 11:38:56.629136 waagent[2245]: 2026-03-02T11:38:56.629095Z INFO ExtHandler ExtHandler Starting env monitor service. Mar 2 11:38:56.629547 waagent[2245]: 2026-03-02T11:38:56.629507Z INFO ExtHandler ExtHandler Start SendTelemetryHandler service. Mar 2 11:38:56.629622 waagent[2245]: 2026-03-02T11:38:56.629581Z INFO MonitorHandler ExtHandler WireServer endpoint 168.63.129.16 read from file Mar 2 11:38:56.629760 waagent[2245]: 2026-03-02T11:38:56.629734Z INFO MonitorHandler ExtHandler Wire server endpoint:168.63.129.16 Mar 2 11:38:56.630115 waagent[2245]: 2026-03-02T11:38:56.630074Z INFO SendTelemetryHandler ExtHandler Successfully started the SendTelemetryHandler thread Mar 2 11:38:56.630314 waagent[2245]: 2026-03-02T11:38:56.630203Z INFO ExtHandler ExtHandler Start Extension Telemetry service. Mar 2 11:38:56.630358 waagent[2245]: 2026-03-02T11:38:56.630321Z INFO EnvHandler ExtHandler WireServer endpoint 168.63.129.16 read from file Mar 2 11:38:56.630407 waagent[2245]: 2026-03-02T11:38:56.630386Z INFO EnvHandler ExtHandler Wire server endpoint:168.63.129.16 Mar 2 11:38:56.630565 waagent[2245]: 2026-03-02T11:38:56.630531Z INFO EnvHandler ExtHandler Configure routes Mar 2 11:38:56.630768 waagent[2245]: 2026-03-02T11:38:56.630740Z INFO MonitorHandler ExtHandler Monitor.NetworkConfigurationChanges is disabled. Mar 2 11:38:56.631038 waagent[2245]: 2026-03-02T11:38:56.631017Z INFO EnvHandler ExtHandler Gateway:None Mar 2 11:38:56.631038 waagent[2245]: 2026-03-02T11:38:56.630972Z INFO TelemetryEventsCollector ExtHandler Extension Telemetry pipeline enabled: True Mar 2 11:38:56.631181 waagent[2245]: 2026-03-02T11:38:56.631142Z INFO ExtHandler ExtHandler Goal State Period: 6 sec. This indicates how often the agent checks for new goal states and reports status. Mar 2 11:38:56.631329 waagent[2245]: 2026-03-02T11:38:56.631304Z INFO TelemetryEventsCollector ExtHandler Successfully started the TelemetryEventsCollector thread Mar 2 11:38:56.631493 waagent[2245]: 2026-03-02T11:38:56.631430Z INFO EnvHandler ExtHandler Routes:None Mar 2 11:38:56.631784 waagent[2245]: 2026-03-02T11:38:56.631752Z INFO MonitorHandler ExtHandler Routing table from /proc/net/route: Mar 2 11:38:56.631784 waagent[2245]: Iface Destination Gateway Flags RefCnt Use Metric Mask MTU Window IRTT Mar 2 11:38:56.631784 waagent[2245]: eth0 00000000 0114C80A 0003 0 0 1024 00000000 0 0 0 Mar 2 11:38:56.631784 waagent[2245]: eth0 0014C80A 00000000 0001 0 0 1024 00FFFFFF 0 0 0 Mar 2 11:38:56.631784 waagent[2245]: eth0 0114C80A 00000000 0005 0 0 1024 FFFFFFFF 0 0 0 Mar 2 11:38:56.631784 waagent[2245]: eth0 10813FA8 0114C80A 0007 0 0 1024 FFFFFFFF 0 0 0 Mar 2 11:38:56.631784 waagent[2245]: eth0 FEA9FEA9 0114C80A 0007 0 0 1024 FFFFFFFF 0 0 0 Mar 2 11:38:56.644512 waagent[2245]: 2026-03-02T11:38:56.644024Z INFO ExtHandler ExtHandler Mar 2 11:38:56.644512 waagent[2245]: 2026-03-02T11:38:56.644114Z INFO ExtHandler ExtHandler ProcessExtensionsGoalState started [incarnation_1 channel: WireServer source: Fabric activity: f044d9de-1256-4758-afd1-b1022bb5e69f correlation 7f3b40ba-9838-4c25-84e0-3230e0a86689 created: 2026-03-02T11:38:02.151543Z] Mar 2 11:38:56.644512 waagent[2245]: 2026-03-02T11:38:56.644401Z INFO ExtHandler ExtHandler No extension handlers found, not processing anything. Mar 2 11:38:56.645209 waagent[2245]: 2026-03-02T11:38:56.645175Z INFO ExtHandler ExtHandler ProcessExtensionsGoalState completed [incarnation_1 1 ms] Mar 2 11:38:56.656441 waagent[2245]: 2026-03-02T11:38:56.656374Z INFO MonitorHandler ExtHandler Network interfaces: Mar 2 11:38:56.656441 waagent[2245]: Executing ['ip', '-a', '-o', 'link']: Mar 2 11:38:56.656441 waagent[2245]: 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 Mar 2 11:38:56.656441 waagent[2245]: 2: eth0: mtu 1500 qdisc mq state UP mode DEFAULT group default qlen 1000\ link/ether 00:0d:3a:fb:86:0e brd ff:ff:ff:ff:ff:ff\ altname enx000d3afb860e Mar 2 11:38:56.656441 waagent[2245]: 3: enP62383s1: mtu 1500 qdisc mq master eth0 state UP mode DEFAULT group default qlen 1000\ link/ether 00:0d:3a:fb:86:0e brd ff:ff:ff:ff:ff:ff\ altname enP62383p0s2 Mar 2 11:38:56.656441 waagent[2245]: Executing ['ip', '-4', '-a', '-o', 'address']: Mar 2 11:38:56.656441 waagent[2245]: 1: lo inet 127.0.0.1/8 scope host lo\ valid_lft forever preferred_lft forever Mar 2 11:38:56.656441 waagent[2245]: 2: eth0 inet 10.200.20.34/24 metric 1024 brd 10.200.20.255 scope global eth0\ valid_lft forever preferred_lft forever Mar 2 11:38:56.656441 waagent[2245]: Executing ['ip', '-6', '-a', '-o', 'address']: Mar 2 11:38:56.656441 waagent[2245]: 1: lo inet6 ::1/128 scope host noprefixroute \ valid_lft forever preferred_lft forever Mar 2 11:38:56.656441 waagent[2245]: 2: eth0 inet6 fe80::20d:3aff:fefb:860e/64 scope link proto kernel_ll \ valid_lft forever preferred_lft forever Mar 2 11:38:56.673515 waagent[2245]: 2026-03-02T11:38:56.673470Z WARNING ExtHandler ExtHandler Failed to get firewall packets: 'iptables -w -t security -L OUTPUT --zero OUTPUT -nxv' failed: 2 (iptables v1.8.11 (nf_tables): Illegal option `--numeric' with this command Mar 2 11:38:56.673515 waagent[2245]: Try `iptables -h' or 'iptables --help' for more information.) Mar 2 11:38:56.675099 waagent[2245]: 2026-03-02T11:38:56.674997Z INFO ExtHandler ExtHandler [HEARTBEAT] Agent WALinuxAgent-2.12.0.4 is running as the goal state agent [DEBUG HeartbeatCounter: 0;HeartbeatId: F6DD2A66-6B0D-4C3C-86B8-5033454FC7EB;DroppedPackets: -1;UpdateGSErrors: 0;AutoUpdate: 0;UpdateMode: SelfUpdate;] Mar 2 11:38:56.685288 waagent[2245]: 2026-03-02T11:38:56.685230Z INFO EnvHandler ExtHandler Created firewall rules for the Azure Fabric: Mar 2 11:38:56.685288 waagent[2245]: Chain INPUT (policy ACCEPT 0 packets, 0 bytes) Mar 2 11:38:56.685288 waagent[2245]: pkts bytes target prot opt in out source destination Mar 2 11:38:56.685288 waagent[2245]: Chain FORWARD (policy ACCEPT 0 packets, 0 bytes) Mar 2 11:38:56.685288 waagent[2245]: pkts bytes target prot opt in out source destination Mar 2 11:38:56.685288 waagent[2245]: Chain OUTPUT (policy ACCEPT 1 packets, 184 bytes) Mar 2 11:38:56.685288 waagent[2245]: pkts bytes target prot opt in out source destination Mar 2 11:38:56.685288 waagent[2245]: 0 0 ACCEPT tcp -- * * 0.0.0.0/0 168.63.129.16 tcp dpt:53 Mar 2 11:38:56.685288 waagent[2245]: 5 647 ACCEPT tcp -- * * 0.0.0.0/0 168.63.129.16 owner UID match 0 Mar 2 11:38:56.685288 waagent[2245]: 0 0 DROP tcp -- * * 0.0.0.0/0 168.63.129.16 ctstate INVALID,NEW Mar 2 11:38:56.688658 waagent[2245]: 2026-03-02T11:38:56.688604Z INFO EnvHandler ExtHandler Current Firewall rules: Mar 2 11:38:56.688658 waagent[2245]: Chain INPUT (policy ACCEPT 0 packets, 0 bytes) Mar 2 11:38:56.688658 waagent[2245]: pkts bytes target prot opt in out source destination Mar 2 11:38:56.688658 waagent[2245]: Chain FORWARD (policy ACCEPT 0 packets, 0 bytes) Mar 2 11:38:56.688658 waagent[2245]: pkts bytes target prot opt in out source destination Mar 2 11:38:56.688658 waagent[2245]: Chain OUTPUT (policy ACCEPT 4 packets, 533 bytes) Mar 2 11:38:56.688658 waagent[2245]: pkts bytes target prot opt in out source destination Mar 2 11:38:56.688658 waagent[2245]: 0 0 ACCEPT tcp -- * * 0.0.0.0/0 168.63.129.16 tcp dpt:53 Mar 2 11:38:56.688658 waagent[2245]: 6 699 ACCEPT tcp -- * * 0.0.0.0/0 168.63.129.16 owner UID match 0 Mar 2 11:38:56.688658 waagent[2245]: 0 0 DROP tcp -- * * 0.0.0.0/0 168.63.129.16 ctstate INVALID,NEW Mar 2 11:38:56.688901 waagent[2245]: 2026-03-02T11:38:56.688871Z INFO EnvHandler ExtHandler Set block dev timeout: sda with timeout: 300 Mar 2 11:39:16.344830 chronyd[1974]: Selected source PHC0 Mar 2 11:39:18.496705 systemd[1]: Created slice system-sshd.slice - Slice /system/sshd. Mar 2 11:39:18.498056 systemd[1]: Started sshd@0-10.200.20.34:22-10.200.16.10:43534.service - OpenSSH per-connection server daemon (10.200.16.10:43534). Mar 2 11:39:18.962249 sshd[2390]: Accepted publickey for core from 10.200.16.10 port 43534 ssh2: RSA SHA256:n3Lw5sFAsJGzOiIrRorc2tE6ZBYhabvyk2gB1aHOzWQ Mar 2 11:39:18.963442 sshd-session[2390]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Mar 2 11:39:18.967358 systemd-logind[2001]: New session 4 of user core. Mar 2 11:39:18.977582 systemd[1]: Started session-4.scope - Session 4 of User core. Mar 2 11:39:19.281082 systemd[1]: Started sshd@1-10.200.20.34:22-10.200.16.10:43540.service - OpenSSH per-connection server daemon (10.200.16.10:43540). Mar 2 11:39:19.703374 sshd[2397]: Accepted publickey for core from 10.200.16.10 port 43540 ssh2: RSA SHA256:n3Lw5sFAsJGzOiIrRorc2tE6ZBYhabvyk2gB1aHOzWQ Mar 2 11:39:19.704508 sshd-session[2397]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Mar 2 11:39:19.708143 systemd-logind[2001]: New session 5 of user core. Mar 2 11:39:19.717580 systemd[1]: Started session-5.scope - Session 5 of User core. Mar 2 11:39:19.940335 sshd[2401]: Connection closed by 10.200.16.10 port 43540 Mar 2 11:39:19.939181 sshd-session[2397]: pam_unix(sshd:session): session closed for user core Mar 2 11:39:19.942248 systemd[1]: sshd@1-10.200.20.34:22-10.200.16.10:43540.service: Deactivated successfully. Mar 2 11:39:19.944172 systemd[1]: session-5.scope: Deactivated successfully. Mar 2 11:39:19.946031 systemd-logind[2001]: Session 5 logged out. Waiting for processes to exit. Mar 2 11:39:19.946870 systemd-logind[2001]: Removed session 5. Mar 2 11:39:20.026734 systemd[1]: Started sshd@2-10.200.20.34:22-10.200.16.10:43694.service - OpenSSH per-connection server daemon (10.200.16.10:43694). Mar 2 11:39:20.451535 sshd[2407]: Accepted publickey for core from 10.200.16.10 port 43694 ssh2: RSA SHA256:n3Lw5sFAsJGzOiIrRorc2tE6ZBYhabvyk2gB1aHOzWQ Mar 2 11:39:20.452465 sshd-session[2407]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Mar 2 11:39:20.456807 systemd-logind[2001]: New session 6 of user core. Mar 2 11:39:20.462565 systemd[1]: Started session-6.scope - Session 6 of User core. Mar 2 11:39:20.682341 sshd[2411]: Connection closed by 10.200.16.10 port 43694 Mar 2 11:39:20.682936 sshd-session[2407]: pam_unix(sshd:session): session closed for user core Mar 2 11:39:20.686632 systemd[1]: sshd@2-10.200.20.34:22-10.200.16.10:43694.service: Deactivated successfully. Mar 2 11:39:20.688191 systemd[1]: session-6.scope: Deactivated successfully. Mar 2 11:39:20.689514 systemd-logind[2001]: Session 6 logged out. Waiting for processes to exit. Mar 2 11:39:20.690185 systemd-logind[2001]: Removed session 6. Mar 2 11:39:20.771225 systemd[1]: Started sshd@3-10.200.20.34:22-10.200.16.10:43698.service - OpenSSH per-connection server daemon (10.200.16.10:43698). Mar 2 11:39:21.194574 sshd[2417]: Accepted publickey for core from 10.200.16.10 port 43698 ssh2: RSA SHA256:n3Lw5sFAsJGzOiIrRorc2tE6ZBYhabvyk2gB1aHOzWQ Mar 2 11:39:21.195743 sshd-session[2417]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Mar 2 11:39:21.200396 systemd-logind[2001]: New session 7 of user core. Mar 2 11:39:21.205748 systemd[1]: Started session-7.scope - Session 7 of User core. Mar 2 11:39:21.430471 sshd[2421]: Connection closed by 10.200.16.10 port 43698 Mar 2 11:39:21.431095 sshd-session[2417]: pam_unix(sshd:session): session closed for user core Mar 2 11:39:21.435128 systemd[1]: sshd@3-10.200.20.34:22-10.200.16.10:43698.service: Deactivated successfully. Mar 2 11:39:21.436927 systemd[1]: session-7.scope: Deactivated successfully. Mar 2 11:39:21.439154 systemd-logind[2001]: Session 7 logged out. Waiting for processes to exit. Mar 2 11:39:21.440568 systemd-logind[2001]: Removed session 7. Mar 2 11:39:21.522147 systemd[1]: Started sshd@4-10.200.20.34:22-10.200.16.10:43706.service - OpenSSH per-connection server daemon (10.200.16.10:43706). Mar 2 11:39:21.943092 sshd[2427]: Accepted publickey for core from 10.200.16.10 port 43706 ssh2: RSA SHA256:n3Lw5sFAsJGzOiIrRorc2tE6ZBYhabvyk2gB1aHOzWQ Mar 2 11:39:21.944266 sshd-session[2427]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Mar 2 11:39:21.948020 systemd-logind[2001]: New session 8 of user core. Mar 2 11:39:21.956574 systemd[1]: Started session-8.scope - Session 8 of User core. Mar 2 11:39:22.127582 sudo[2432]: core : PWD=/home/core ; USER=root ; COMMAND=/usr/sbin/setenforce 1 Mar 2 11:39:22.127804 sudo[2432]: pam_unix(sudo:session): session opened for user root(uid=0) by core(uid=500) Mar 2 11:39:22.135870 sudo[2432]: pam_unix(sudo:session): session closed for user root Mar 2 11:39:22.213229 sshd[2431]: Connection closed by 10.200.16.10 port 43706 Mar 2 11:39:22.214056 sshd-session[2427]: pam_unix(sshd:session): session closed for user core Mar 2 11:39:22.218226 systemd[1]: sshd@4-10.200.20.34:22-10.200.16.10:43706.service: Deactivated successfully. Mar 2 11:39:22.219729 systemd[1]: session-8.scope: Deactivated successfully. Mar 2 11:39:22.220969 systemd-logind[2001]: Session 8 logged out. Waiting for processes to exit. Mar 2 11:39:22.221819 systemd-logind[2001]: Removed session 8. Mar 2 11:39:22.302492 systemd[1]: Started sshd@5-10.200.20.34:22-10.200.16.10:43714.service - OpenSSH per-connection server daemon (10.200.16.10:43714). Mar 2 11:39:22.726117 sshd[2439]: Accepted publickey for core from 10.200.16.10 port 43714 ssh2: RSA SHA256:n3Lw5sFAsJGzOiIrRorc2tE6ZBYhabvyk2gB1aHOzWQ Mar 2 11:39:22.727291 sshd-session[2439]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Mar 2 11:39:22.730994 systemd-logind[2001]: New session 9 of user core. Mar 2 11:39:22.739600 systemd[1]: Started session-9.scope - Session 9 of User core. Mar 2 11:39:22.886502 sudo[2445]: core : PWD=/home/core ; USER=root ; COMMAND=/usr/sbin/rm -rf /etc/audit/rules.d/80-selinux.rules /etc/audit/rules.d/99-default.rules Mar 2 11:39:22.886714 sudo[2445]: pam_unix(sudo:session): session opened for user root(uid=0) by core(uid=500) Mar 2 11:39:22.893911 sudo[2445]: pam_unix(sudo:session): session closed for user root Mar 2 11:39:22.899300 sudo[2444]: core : PWD=/home/core ; USER=root ; COMMAND=/usr/sbin/systemctl restart audit-rules Mar 2 11:39:22.899548 sudo[2444]: pam_unix(sudo:session): session opened for user root(uid=0) by core(uid=500) Mar 2 11:39:22.906091 systemd[1]: Starting audit-rules.service - Load Audit Rules... Mar 2 11:39:22.937489 kernel: kauditd_printk_skb: 57 callbacks suppressed Mar 2 11:39:22.937648 kernel: audit: type=1305 audit(1772451562.932:219): auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 op=remove_rule key=(null) list=5 res=1 Mar 2 11:39:22.932000 audit: CONFIG_CHANGE auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 op=remove_rule key=(null) list=5 res=1 Mar 2 11:39:22.932000 audit[2469]: SYSCALL arch=c00000b7 syscall=206 success=yes exit=1056 a0=3 a1=ffffcb915ac0 a2=420 a3=0 items=0 ppid=2450 pid=2469 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) Mar 2 11:39:22.944681 augenrules[2469]: No rules Mar 2 11:39:22.961120 kernel: audit: type=1300 audit(1772451562.932:219): arch=c00000b7 syscall=206 success=yes exit=1056 a0=3 a1=ffffcb915ac0 a2=420 a3=0 items=0 ppid=2450 pid=2469 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) Mar 2 11:39:22.961618 systemd[1]: audit-rules.service: Deactivated successfully. Mar 2 11:39:22.961845 systemd[1]: Finished audit-rules.service - Load Audit Rules. Mar 2 11:39:22.932000 audit: PROCTITLE proctitle=2F7362696E2F617564697463746C002D52002F6574632F61756469742F61756469742E72756C6573 Mar 2 11:39:22.969526 kernel: audit: type=1327 audit(1772451562.932:219): proctitle=2F7362696E2F617564697463746C002D52002F6574632F61756469742F61756469742E72756C6573 Mar 2 11:39:22.969601 kernel: audit: type=1130 audit(1772451562.960:220): pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=audit-rules comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Mar 2 11:39:22.960000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=audit-rules comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Mar 2 11:39:22.970633 sudo[2444]: pam_unix(sudo:session): session closed for user root Mar 2 11:39:22.960000 audit[1]: SERVICE_STOP pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=audit-rules comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Mar 2 11:39:22.993449 kernel: audit: type=1131 audit(1772451562.960:221): pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=audit-rules comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Mar 2 11:39:22.968000 audit[2444]: USER_END pid=2444 uid=500 auid=500 ses=9 subj=system_u:system_r:kernel_t:s0 msg='op=PAM:session_close grantors=pam_limits,pam_env,pam_umask,pam_unix acct="root" exe="/usr/bin/sudo" hostname=? addr=? terminal=? res=success' Mar 2 11:39:23.007233 kernel: audit: type=1106 audit(1772451562.968:222): pid=2444 uid=500 auid=500 ses=9 subj=system_u:system_r:kernel_t:s0 msg='op=PAM:session_close grantors=pam_limits,pam_env,pam_umask,pam_unix acct="root" exe="/usr/bin/sudo" hostname=? addr=? terminal=? res=success' Mar 2 11:39:23.007303 kernel: audit: type=1104 audit(1772451562.968:223): pid=2444 uid=500 auid=500 ses=9 subj=system_u:system_r:kernel_t:s0 msg='op=PAM:setcred grantors=pam_env,pam_faillock acct="root" exe="/usr/bin/sudo" hostname=? addr=? terminal=? res=success' Mar 2 11:39:22.968000 audit[2444]: CRED_DISP pid=2444 uid=500 auid=500 ses=9 subj=system_u:system_r:kernel_t:s0 msg='op=PAM:setcred grantors=pam_env,pam_faillock acct="root" exe="/usr/bin/sudo" hostname=? addr=? terminal=? res=success' Mar 2 11:39:23.048448 sshd[2443]: Connection closed by 10.200.16.10 port 43714 Mar 2 11:39:23.048614 sshd-session[2439]: pam_unix(sshd:session): session closed for user core Mar 2 11:39:23.048000 audit[2439]: USER_END pid=2439 uid=0 auid=500 ses=9 subj=system_u:system_r:kernel_t:s0 msg='op=PAM:session_close grantors=pam_loginuid,pam_env,pam_namespace,pam_keyinit,pam_limits,pam_env,pam_umask,pam_unix,pam_systemd,pam_lastlog,pam_mail acct="core" exe="/usr/lib64/misc/sshd-session" hostname=10.200.16.10 addr=10.200.16.10 terminal=ssh res=success' Mar 2 11:39:23.053990 systemd[1]: sshd@5-10.200.20.34:22-10.200.16.10:43714.service: Deactivated successfully. Mar 2 11:39:23.054296 systemd-logind[2001]: Session 9 logged out. Waiting for processes to exit. Mar 2 11:39:23.056299 systemd[1]: session-9.scope: Deactivated successfully. Mar 2 11:39:23.062266 systemd-logind[2001]: Removed session 9. Mar 2 11:39:23.048000 audit[2439]: CRED_DISP pid=2439 uid=0 auid=500 ses=9 subj=system_u:system_r:kernel_t:s0 msg='op=PAM:setcred grantors=pam_env,pam_faillock acct="core" exe="/usr/lib64/misc/sshd-session" hostname=10.200.16.10 addr=10.200.16.10 terminal=ssh res=success' Mar 2 11:39:23.084456 kernel: audit: type=1106 audit(1772451563.048:224): pid=2439 uid=0 auid=500 ses=9 subj=system_u:system_r:kernel_t:s0 msg='op=PAM:session_close grantors=pam_loginuid,pam_env,pam_namespace,pam_keyinit,pam_limits,pam_env,pam_umask,pam_unix,pam_systemd,pam_lastlog,pam_mail acct="core" exe="/usr/lib64/misc/sshd-session" hostname=10.200.16.10 addr=10.200.16.10 terminal=ssh res=success' Mar 2 11:39:23.084534 kernel: audit: type=1104 audit(1772451563.048:225): pid=2439 uid=0 auid=500 ses=9 subj=system_u:system_r:kernel_t:s0 msg='op=PAM:setcred grantors=pam_env,pam_faillock acct="core" exe="/usr/lib64/misc/sshd-session" hostname=10.200.16.10 addr=10.200.16.10 terminal=ssh res=success' Mar 2 11:39:23.084565 kernel: audit: type=1131 audit(1772451563.053:226): pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=sshd@5-10.200.20.34:22-10.200.16.10:43714 comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Mar 2 11:39:23.053000 audit[1]: SERVICE_STOP pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=sshd@5-10.200.20.34:22-10.200.16.10:43714 comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Mar 2 11:39:23.140000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=sshd@6-10.200.20.34:22-10.200.16.10:43728 comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Mar 2 11:39:23.141187 systemd[1]: Started sshd@6-10.200.20.34:22-10.200.16.10:43728.service - OpenSSH per-connection server daemon (10.200.16.10:43728). Mar 2 11:39:23.561000 audit[2478]: USER_ACCT pid=2478 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='op=PAM:accounting grantors=pam_access,pam_time,pam_unix,pam_faillock acct="core" exe="/usr/lib64/misc/sshd-session" hostname=10.200.16.10 addr=10.200.16.10 terminal=ssh res=success' Mar 2 11:39:23.563580 sshd[2478]: Accepted publickey for core from 10.200.16.10 port 43728 ssh2: RSA SHA256:n3Lw5sFAsJGzOiIrRorc2tE6ZBYhabvyk2gB1aHOzWQ Mar 2 11:39:23.563000 audit[2478]: CRED_ACQ pid=2478 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='op=PAM:setcred grantors=pam_env,pam_faillock acct="core" exe="/usr/lib64/misc/sshd-session" hostname=10.200.16.10 addr=10.200.16.10 terminal=ssh res=success' Mar 2 11:39:23.563000 audit[2478]: SYSCALL arch=c00000b7 syscall=64 success=yes exit=3 a0=8 a1=ffffe456b500 a2=3 a3=0 items=0 ppid=1 pid=2478 auid=500 uid=0 gid=0 euid=0 suid=0 fsuid=0 egid=0 sgid=0 fsgid=0 tty=(none) ses=10 comm="sshd-session" exe="/usr/lib64/misc/sshd-session" subj=system_u:system_r:kernel_t:s0 key=(null) Mar 2 11:39:23.563000 audit: PROCTITLE proctitle=737368642D73657373696F6E3A20636F7265205B707269765D Mar 2 11:39:23.565023 sshd-session[2478]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Mar 2 11:39:23.569588 systemd-logind[2001]: New session 10 of user core. Mar 2 11:39:23.576573 systemd[1]: Started session-10.scope - Session 10 of User core. Mar 2 11:39:23.577000 audit[2478]: USER_START pid=2478 uid=0 auid=500 ses=10 subj=system_u:system_r:kernel_t:s0 msg='op=PAM:session_open grantors=pam_loginuid,pam_env,pam_namespace,pam_keyinit,pam_limits,pam_env,pam_umask,pam_unix,pam_systemd,pam_lastlog,pam_mail acct="core" exe="/usr/lib64/misc/sshd-session" hostname=10.200.16.10 addr=10.200.16.10 terminal=ssh res=success' Mar 2 11:39:23.579000 audit[2482]: CRED_ACQ pid=2482 uid=0 auid=500 ses=10 subj=system_u:system_r:kernel_t:s0 msg='op=PAM:setcred grantors=pam_env,pam_faillock acct="core" exe="/usr/lib64/misc/sshd-session" hostname=10.200.16.10 addr=10.200.16.10 terminal=ssh res=success' Mar 2 11:39:23.726000 audit[2483]: USER_ACCT pid=2483 uid=500 auid=500 ses=10 subj=system_u:system_r:kernel_t:s0 msg='op=PAM:accounting grantors=pam_unix,pam_faillock acct="core" exe="/usr/bin/sudo" hostname=? addr=? terminal=? res=success' Mar 2 11:39:23.728752 sudo[2483]: core : PWD=/home/core ; USER=root ; COMMAND=/usr/sbin/blkid -s UUID -o value /dev/disk/by-label/ROOT Mar 2 11:39:23.727000 audit[2483]: CRED_REFR pid=2483 uid=500 auid=500 ses=10 subj=system_u:system_r:kernel_t:s0 msg='op=PAM:setcred grantors=pam_env,pam_faillock acct="root" exe="/usr/bin/sudo" hostname=? addr=? terminal=? res=success' Mar 2 11:39:23.727000 audit[2483]: USER_START pid=2483 uid=500 auid=500 ses=10 subj=system_u:system_r:kernel_t:s0 msg='op=PAM:session_open grantors=pam_limits,pam_env,pam_umask,pam_unix acct="root" exe="/usr/bin/sudo" hostname=? addr=? terminal=? res=success' Mar 2 11:39:23.729280 sudo[2483]: pam_unix(sudo:session): session opened for user root(uid=0) by core(uid=500) Mar 2 11:39:23.741623 sudo[2483]: pam_unix(sudo:session): session closed for user root Mar 2 11:39:23.740000 audit[2483]: USER_END pid=2483 uid=500 auid=500 ses=10 subj=system_u:system_r:kernel_t:s0 msg='op=PAM:session_close grantors=pam_limits,pam_env,pam_umask,pam_unix acct="root" exe="/usr/bin/sudo" hostname=? addr=? terminal=? res=success' Mar 2 11:39:23.740000 audit[2483]: CRED_DISP pid=2483 uid=500 auid=500 ses=10 subj=system_u:system_r:kernel_t:s0 msg='op=PAM:setcred grantors=pam_env,pam_faillock acct="root" exe="/usr/bin/sudo" hostname=? addr=? terminal=? res=success' Mar 2 11:39:23.819062 sshd[2482]: Connection closed by 10.200.16.10 port 43728 Mar 2 11:39:23.819902 sshd-session[2478]: pam_unix(sshd:session): session closed for user core Mar 2 11:39:23.819000 audit[2478]: USER_END pid=2478 uid=0 auid=500 ses=10 subj=system_u:system_r:kernel_t:s0 msg='op=PAM:session_close grantors=pam_loginuid,pam_env,pam_namespace,pam_keyinit,pam_limits,pam_env,pam_umask,pam_unix,pam_systemd,pam_lastlog,pam_mail acct="core" exe="/usr/lib64/misc/sshd-session" hostname=10.200.16.10 addr=10.200.16.10 terminal=ssh res=success' Mar 2 11:39:23.819000 audit[2478]: CRED_DISP pid=2478 uid=0 auid=500 ses=10 subj=system_u:system_r:kernel_t:s0 msg='op=PAM:setcred grantors=pam_env,pam_faillock acct="core" exe="/usr/lib64/misc/sshd-session" hostname=10.200.16.10 addr=10.200.16.10 terminal=ssh res=success' Mar 2 11:39:23.823092 systemd[1]: sshd@6-10.200.20.34:22-10.200.16.10:43728.service: Deactivated successfully. Mar 2 11:39:23.822000 audit[1]: SERVICE_STOP pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=sshd@6-10.200.20.34:22-10.200.16.10:43728 comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Mar 2 11:39:23.825668 systemd[1]: session-10.scope: Deactivated successfully. Mar 2 11:39:23.827738 systemd-logind[2001]: Session 10 logged out. Waiting for processes to exit. Mar 2 11:39:23.829002 systemd-logind[2001]: Removed session 10. Mar 2 11:39:23.907641 systemd[1]: Started sshd@7-10.200.20.34:22-10.200.16.10:43730.service - OpenSSH per-connection server daemon (10.200.16.10:43730). Mar 2 11:39:23.906000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=sshd@7-10.200.20.34:22-10.200.16.10:43730 comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Mar 2 11:39:24.328000 audit[2490]: USER_ACCT pid=2490 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='op=PAM:accounting grantors=pam_access,pam_time,pam_unix,pam_faillock acct="core" exe="/usr/lib64/misc/sshd-session" hostname=10.200.16.10 addr=10.200.16.10 terminal=ssh res=success' Mar 2 11:39:24.330518 sshd[2490]: Accepted publickey for core from 10.200.16.10 port 43730 ssh2: RSA SHA256:n3Lw5sFAsJGzOiIrRorc2tE6ZBYhabvyk2gB1aHOzWQ Mar 2 11:39:24.329000 audit[2490]: CRED_ACQ pid=2490 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='op=PAM:setcred grantors=pam_env,pam_faillock acct="core" exe="/usr/lib64/misc/sshd-session" hostname=10.200.16.10 addr=10.200.16.10 terminal=ssh res=success' Mar 2 11:39:24.329000 audit[2490]: SYSCALL arch=c00000b7 syscall=64 success=yes exit=3 a0=8 a1=ffffed810660 a2=3 a3=0 items=0 ppid=1 pid=2490 auid=500 uid=0 gid=0 euid=0 suid=0 fsuid=0 egid=0 sgid=0 fsgid=0 tty=(none) ses=11 comm="sshd-session" exe="/usr/lib64/misc/sshd-session" subj=system_u:system_r:kernel_t:s0 key=(null) Mar 2 11:39:24.329000 audit: PROCTITLE proctitle=737368642D73657373696F6E3A20636F7265205B707269765D Mar 2 11:39:24.331681 sshd-session[2490]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Mar 2 11:39:24.336222 systemd-logind[2001]: New session 11 of user core. Mar 2 11:39:24.341770 systemd[1]: Started session-11.scope - Session 11 of User core. Mar 2 11:39:24.342000 audit[2490]: USER_START pid=2490 uid=0 auid=500 ses=11 subj=system_u:system_r:kernel_t:s0 msg='op=PAM:session_open grantors=pam_loginuid,pam_env,pam_namespace,pam_keyinit,pam_limits,pam_env,pam_umask,pam_unix,pam_systemd,pam_lastlog,pam_mail acct="core" exe="/usr/lib64/misc/sshd-session" hostname=10.200.16.10 addr=10.200.16.10 terminal=ssh res=success' Mar 2 11:39:24.344000 audit[2494]: CRED_ACQ pid=2494 uid=0 auid=500 ses=11 subj=system_u:system_r:kernel_t:s0 msg='op=PAM:setcred grantors=pam_env,pam_faillock acct="core" exe="/usr/lib64/misc/sshd-session" hostname=10.200.16.10 addr=10.200.16.10 terminal=ssh res=success' Mar 2 11:39:24.488000 audit[2495]: USER_ACCT pid=2495 uid=500 auid=500 ses=11 subj=system_u:system_r:kernel_t:s0 msg='op=PAM:accounting grantors=pam_unix,pam_faillock acct="core" exe="/usr/bin/sudo" hostname=? addr=? terminal=? res=success' Mar 2 11:39:24.490594 sudo[2495]: core : PWD=/home/core ; USER=root ; COMMAND=/usr/sbin/blkid -s TYPE -o value /dev/disk/by-label/ROOT Mar 2 11:39:24.489000 audit[2495]: CRED_REFR pid=2495 uid=500 auid=500 ses=11 subj=system_u:system_r:kernel_t:s0 msg='op=PAM:setcred grantors=pam_env,pam_faillock acct="root" exe="/usr/bin/sudo" hostname=? addr=? terminal=? res=success' Mar 2 11:39:24.491226 sudo[2495]: pam_unix(sudo:session): session opened for user root(uid=0) by core(uid=500) Mar 2 11:39:24.489000 audit[2495]: USER_START pid=2495 uid=500 auid=500 ses=11 subj=system_u:system_r:kernel_t:s0 msg='op=PAM:session_open grantors=pam_limits,pam_env,pam_umask,pam_unix acct="root" exe="/usr/bin/sudo" hostname=? addr=? terminal=? res=success' Mar 2 11:39:24.492912 sudo[2495]: pam_unix(sudo:session): session closed for user root Mar 2 11:39:24.491000 audit[2495]: USER_END pid=2495 uid=500 auid=500 ses=11 subj=system_u:system_r:kernel_t:s0 msg='op=PAM:session_close grantors=pam_limits,pam_env,pam_umask,pam_unix acct="root" exe="/usr/bin/sudo" hostname=? addr=? terminal=? res=success' Mar 2 11:39:24.491000 audit[2495]: CRED_DISP pid=2495 uid=500 auid=500 ses=11 subj=system_u:system_r:kernel_t:s0 msg='op=PAM:setcred grantors=pam_env,pam_faillock acct="root" exe="/usr/bin/sudo" hostname=? addr=? terminal=? res=success' Mar 2 11:39:24.570395 sshd[2494]: Connection closed by 10.200.16.10 port 43730 Mar 2 11:39:24.571262 sshd-session[2490]: pam_unix(sshd:session): session closed for user core Mar 2 11:39:24.571000 audit[2490]: USER_END pid=2490 uid=0 auid=500 ses=11 subj=system_u:system_r:kernel_t:s0 msg='op=PAM:session_close grantors=pam_loginuid,pam_env,pam_namespace,pam_keyinit,pam_limits,pam_env,pam_umask,pam_unix,pam_systemd,pam_lastlog,pam_mail acct="core" exe="/usr/lib64/misc/sshd-session" hostname=10.200.16.10 addr=10.200.16.10 terminal=ssh res=success' Mar 2 11:39:24.571000 audit[2490]: CRED_DISP pid=2490 uid=0 auid=500 ses=11 subj=system_u:system_r:kernel_t:s0 msg='op=PAM:setcred grantors=pam_env,pam_faillock acct="core" exe="/usr/lib64/misc/sshd-session" hostname=10.200.16.10 addr=10.200.16.10 terminal=ssh res=success' Mar 2 11:39:24.574733 systemd[1]: sshd@7-10.200.20.34:22-10.200.16.10:43730.service: Deactivated successfully. Mar 2 11:39:24.573000 audit[1]: SERVICE_STOP pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=sshd@7-10.200.20.34:22-10.200.16.10:43730 comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Mar 2 11:39:24.576760 systemd[1]: session-11.scope: Deactivated successfully. Mar 2 11:39:24.578182 systemd-logind[2001]: Session 11 logged out. Waiting for processes to exit. Mar 2 11:39:24.579211 systemd-logind[2001]: Removed session 11. Mar 2 11:39:24.657000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=sshd@8-10.200.20.34:22-10.200.16.10:43742 comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Mar 2 11:39:24.658448 systemd[1]: Started sshd@8-10.200.20.34:22-10.200.16.10:43742.service - OpenSSH per-connection server daemon (10.200.16.10:43742). Mar 2 11:39:25.083000 audit[2502]: USER_ACCT pid=2502 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='op=PAM:accounting grantors=pam_access,pam_time,pam_unix,pam_faillock acct="core" exe="/usr/lib64/misc/sshd-session" hostname=10.200.16.10 addr=10.200.16.10 terminal=ssh res=success' Mar 2 11:39:25.085281 sshd[2502]: Accepted publickey for core from 10.200.16.10 port 43742 ssh2: RSA SHA256:n3Lw5sFAsJGzOiIrRorc2tE6ZBYhabvyk2gB1aHOzWQ Mar 2 11:39:25.084000 audit[2502]: CRED_ACQ pid=2502 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='op=PAM:setcred grantors=pam_env,pam_faillock acct="core" exe="/usr/lib64/misc/sshd-session" hostname=10.200.16.10 addr=10.200.16.10 terminal=ssh res=success' Mar 2 11:39:25.084000 audit[2502]: SYSCALL arch=c00000b7 syscall=64 success=yes exit=3 a0=8 a1=ffffca08a7f0 a2=3 a3=0 items=0 ppid=1 pid=2502 auid=500 uid=0 gid=0 euid=0 suid=0 fsuid=0 egid=0 sgid=0 fsgid=0 tty=(none) ses=12 comm="sshd-session" exe="/usr/lib64/misc/sshd-session" subj=system_u:system_r:kernel_t:s0 key=(null) Mar 2 11:39:25.084000 audit: PROCTITLE proctitle=737368642D73657373696F6E3A20636F7265205B707269765D Mar 2 11:39:25.086362 sshd-session[2502]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Mar 2 11:39:25.090755 systemd-logind[2001]: New session 12 of user core. Mar 2 11:39:25.096585 systemd[1]: Started session-12.scope - Session 12 of User core. Mar 2 11:39:25.097000 audit[2502]: USER_START pid=2502 uid=0 auid=500 ses=12 subj=system_u:system_r:kernel_t:s0 msg='op=PAM:session_open grantors=pam_loginuid,pam_env,pam_namespace,pam_keyinit,pam_limits,pam_env,pam_umask,pam_unix,pam_systemd,pam_lastlog,pam_mail acct="core" exe="/usr/lib64/misc/sshd-session" hostname=10.200.16.10 addr=10.200.16.10 terminal=ssh res=success' Mar 2 11:39:25.099000 audit[2506]: CRED_ACQ pid=2506 uid=0 auid=500 ses=12 subj=system_u:system_r:kernel_t:s0 msg='op=PAM:setcred grantors=pam_env,pam_faillock acct="core" exe="/usr/lib64/misc/sshd-session" hostname=10.200.16.10 addr=10.200.16.10 terminal=ssh res=success' Mar 2 11:39:25.318668 sshd[2506]: Connection closed by 10.200.16.10 port 43742 Mar 2 11:39:25.319246 sshd-session[2502]: pam_unix(sshd:session): session closed for user core Mar 2 11:39:25.319000 audit[2502]: USER_END pid=2502 uid=0 auid=500 ses=12 subj=system_u:system_r:kernel_t:s0 msg='op=PAM:session_close grantors=pam_loginuid,pam_env,pam_namespace,pam_keyinit,pam_limits,pam_env,pam_umask,pam_unix,pam_systemd,pam_lastlog,pam_mail acct="core" exe="/usr/lib64/misc/sshd-session" hostname=10.200.16.10 addr=10.200.16.10 terminal=ssh res=success' Mar 2 11:39:25.319000 audit[2502]: CRED_DISP pid=2502 uid=0 auid=500 ses=12 subj=system_u:system_r:kernel_t:s0 msg='op=PAM:setcred grantors=pam_env,pam_faillock acct="core" exe="/usr/lib64/misc/sshd-session" hostname=10.200.16.10 addr=10.200.16.10 terminal=ssh res=success' Mar 2 11:39:25.323443 systemd[1]: sshd@8-10.200.20.34:22-10.200.16.10:43742.service: Deactivated successfully. Mar 2 11:39:25.322000 audit[1]: SERVICE_STOP pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=sshd@8-10.200.20.34:22-10.200.16.10:43742 comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Mar 2 11:39:25.326761 systemd[1]: session-12.scope: Deactivated successfully. Mar 2 11:39:25.327442 systemd-logind[2001]: Session 12 logged out. Waiting for processes to exit. Mar 2 11:39:25.328434 systemd-logind[2001]: Removed session 12.