Mar 13 09:45:36.625456 kernel: Booting Linux on physical CPU 0x0000000000 [0x410fd490] Mar 13 09:45:36.625489 kernel: Linux version 6.12.76-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 Fri Mar 13 07:58:54 -00 2026 Mar 13 09:45:36.625496 kernel: KASLR enabled Mar 13 09:45:36.625501 kernel: earlycon: pl11 at MMIO 0x00000000effec000 (options '') Mar 13 09:45:36.625506 kernel: printk: legacy bootconsole [pl11] enabled Mar 13 09:45:36.625511 kernel: efi: EFI v2.7 by EDK II Mar 13 09:45:36.625517 kernel: efi: ACPI 2.0=0x3f979018 SMBIOS=0x3f8a0000 SMBIOS 3.0=0x3f880000 MEMATTR=0x3e3ed698 RNG=0x3f979998 MEMRESERVE=0x3db84598 Mar 13 09:45:36.625522 kernel: random: crng init done Mar 13 09:45:36.625527 kernel: secureboot: Secure boot disabled Mar 13 09:45:36.625531 kernel: ACPI: Early table checksum verification disabled Mar 13 09:45:36.625537 kernel: ACPI: RSDP 0x000000003F979018 000024 (v02 VRTUAL) Mar 13 09:45:36.625540 kernel: ACPI: XSDT 0x000000003F979F18 00006C (v01 VRTUAL MICROSFT 00000001 MSFT 00000001) Mar 13 09:45:36.625546 kernel: ACPI: FACP 0x000000003F979C18 000114 (v06 VRTUAL MICROSFT 00000001 MSFT 00000001) Mar 13 09:45:36.625551 kernel: ACPI: DSDT 0x000000003F95A018 01E046 (v02 MSFTVM DSDT01 00000001 INTL 20230628) Mar 13 09:45:36.625558 kernel: ACPI: DBG2 0x000000003F979B18 000072 (v00 VRTUAL MICROSFT 00000001 MSFT 00000001) Mar 13 09:45:36.625564 kernel: ACPI: GTDT 0x000000003F979D98 000060 (v02 VRTUAL MICROSFT 00000001 MSFT 00000001) Mar 13 09:45:36.625569 kernel: ACPI: OEM0 0x000000003F979098 000064 (v01 VRTUAL MICROSFT 00000001 MSFT 00000001) Mar 13 09:45:36.625575 kernel: ACPI: SPCR 0x000000003F979A98 000050 (v02 VRTUAL MICROSFT 00000001 MSFT 00000001) Mar 13 09:45:36.625579 kernel: ACPI: APIC 0x000000003F979818 0000FC (v04 VRTUAL MICROSFT 00000001 MSFT 00000001) Mar 13 09:45:36.625583 kernel: ACPI: SRAT 0x000000003F979198 000234 (v03 VRTUAL MICROSFT 00000001 MSFT 00000001) Mar 13 09:45:36.625590 kernel: ACPI: PPTT 0x000000003F979418 000120 (v01 VRTUAL MICROSFT 00000000 MSFT 00000000) Mar 13 09:45:36.625595 kernel: ACPI: BGRT 0x000000003F979E98 000038 (v01 VRTUAL MICROSFT 00000001 MSFT 00000001) Mar 13 09:45:36.625601 kernel: ACPI: SPCR: console: pl011,mmio32,0xeffec000,115200 Mar 13 09:45:36.625605 kernel: ACPI: Use ACPI SPCR as default console: Yes Mar 13 09:45:36.625610 kernel: ACPI: SRAT: Node 0 PXM 0 [mem 0x00000000-0x3fffffff] hotplug Mar 13 09:45:36.625616 kernel: ACPI: SRAT: Node 0 PXM 0 [mem 0x100000000-0x1bfffffff] hotplug Mar 13 09:45:36.625620 kernel: ACPI: SRAT: Node 0 PXM 0 [mem 0x1c0000000-0xfbfffffff] hotplug Mar 13 09:45:36.625624 kernel: ACPI: SRAT: Node 0 PXM 0 [mem 0x1000000000-0xffffffffff] hotplug Mar 13 09:45:36.625628 kernel: ACPI: SRAT: Node 0 PXM 0 [mem 0x10000000000-0x1ffffffffff] hotplug Mar 13 09:45:36.625634 kernel: ACPI: SRAT: Node 0 PXM 0 [mem 0x20000000000-0x3ffffffffff] hotplug Mar 13 09:45:36.625639 kernel: ACPI: SRAT: Node 0 PXM 0 [mem 0x40000000000-0x7ffffffffff] hotplug Mar 13 09:45:36.625646 kernel: ACPI: SRAT: Node 0 PXM 0 [mem 0x80000000000-0xfffffffffff] hotplug Mar 13 09:45:36.625651 kernel: ACPI: SRAT: Node 0 PXM 0 [mem 0x100000000000-0x1fffffffffff] hotplug Mar 13 09:45:36.625656 kernel: ACPI: SRAT: Node 0 PXM 0 [mem 0x200000000000-0x3fffffffffff] hotplug Mar 13 09:45:36.625660 kernel: ACPI: SRAT: Node 0 PXM 0 [mem 0x400000000000-0x7fffffffffff] hotplug Mar 13 09:45:36.625664 kernel: ACPI: SRAT: Node 0 PXM 0 [mem 0x800000000000-0xffffffffffff] hotplug Mar 13 09:45:36.625668 kernel: NUMA: Node 0 [mem 0x00000000-0x3fffffff] + [mem 0x100000000-0x1bfffffff] -> [mem 0x00000000-0x1bfffffff] Mar 13 09:45:36.625674 kernel: NODE_DATA(0) allocated [mem 0x1bf800a00-0x1bf807fff] Mar 13 09:45:36.625679 kernel: Zone ranges: Mar 13 09:45:36.625684 kernel: DMA [mem 0x0000000000000000-0x00000000ffffffff] Mar 13 09:45:36.625692 kernel: DMA32 empty Mar 13 09:45:36.625697 kernel: Normal [mem 0x0000000100000000-0x00000001bfffffff] Mar 13 09:45:36.625703 kernel: Device empty Mar 13 09:45:36.625709 kernel: Movable zone start for each node Mar 13 09:45:36.625713 kernel: Early memory node ranges Mar 13 09:45:36.625720 kernel: node 0: [mem 0x0000000000000000-0x00000000007fffff] Mar 13 09:45:36.625726 kernel: node 0: [mem 0x0000000000824000-0x000000003f38ffff] Mar 13 09:45:36.625731 kernel: node 0: [mem 0x000000003f390000-0x000000003f93ffff] Mar 13 09:45:36.625736 kernel: node 0: [mem 0x000000003f940000-0x000000003f9effff] Mar 13 09:45:36.625740 kernel: node 0: [mem 0x000000003f9f0000-0x000000003fdeffff] Mar 13 09:45:36.625745 kernel: node 0: [mem 0x000000003fdf0000-0x000000003fffffff] Mar 13 09:45:36.625751 kernel: node 0: [mem 0x0000000100000000-0x00000001bfffffff] Mar 13 09:45:36.625755 kernel: Initmem setup node 0 [mem 0x0000000000000000-0x00000001bfffffff] Mar 13 09:45:36.625759 kernel: On node 0, zone DMA: 36 pages in unavailable ranges Mar 13 09:45:36.625764 kernel: cma: Reserved 16 MiB at 0x000000003ca00000 on node -1 Mar 13 09:45:36.625768 kernel: psci: probing for conduit method from ACPI. Mar 13 09:45:36.625773 kernel: psci: PSCIv1.3 detected in firmware. Mar 13 09:45:36.625778 kernel: psci: Using standard PSCI v0.2 function IDs Mar 13 09:45:36.625782 kernel: psci: MIGRATE_INFO_TYPE not supported. Mar 13 09:45:36.625786 kernel: psci: SMC Calling Convention v1.4 Mar 13 09:45:36.625791 kernel: ACPI: NUMA: SRAT: PXM 0 -> MPIDR 0x0 -> Node 0 Mar 13 09:45:36.625795 kernel: ACPI: NUMA: SRAT: PXM 0 -> MPIDR 0x1 -> Node 0 Mar 13 09:45:36.625800 kernel: percpu: Embedded 34 pages/cpu s98840 r8192 d32232 u139264 Mar 13 09:45:36.625804 kernel: pcpu-alloc: s98840 r8192 d32232 u139264 alloc=34*4096 Mar 13 09:45:36.625810 kernel: pcpu-alloc: [0] 0 [0] 1 Mar 13 09:45:36.625816 kernel: Detected PIPT I-cache on CPU0 Mar 13 09:45:36.625820 kernel: CPU features: detected: Address authentication (architected QARMA5 algorithm) Mar 13 09:45:36.625826 kernel: CPU features: detected: GIC system register CPU interface Mar 13 09:45:36.625830 kernel: CPU features: detected: Spectre-v4 Mar 13 09:45:36.625835 kernel: CPU features: detected: Spectre-BHB Mar 13 09:45:36.625840 kernel: CPU features: kernel page table isolation forced ON by KASLR Mar 13 09:45:36.625846 kernel: CPU features: detected: Kernel page table isolation (KPTI) Mar 13 09:45:36.625851 kernel: CPU features: detected: ARM erratum 2067961 or 2054223 Mar 13 09:45:36.625855 kernel: CPU features: detected: SSBS not fully self-synchronizing Mar 13 09:45:36.625859 kernel: alternatives: applying boot alternatives Mar 13 09:45:36.625866 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=5f9ba9fca0bd7496423588a0876ca61872bd78f585145c3ef7377567db95fe17 Mar 13 09:45:36.625871 kernel: Dentry cache hash table entries: 524288 (order: 10, 4194304 bytes, linear) Mar 13 09:45:36.625876 kernel: Inode-cache hash table entries: 262144 (order: 9, 2097152 bytes, linear) Mar 13 09:45:36.625882 kernel: Fallback order for Node 0: 0 Mar 13 09:45:36.625886 kernel: Built 1 zonelists, mobility grouping on. Total pages: 1048540 Mar 13 09:45:36.625891 kernel: Policy zone: Normal Mar 13 09:45:36.625895 kernel: mem auto-init: stack:off, heap alloc:off, heap free:off Mar 13 09:45:36.625899 kernel: software IO TLB: area num 2. Mar 13 09:45:36.625905 kernel: software IO TLB: mapped [mem 0x00000000371d0000-0x000000003b1d0000] (64MB) Mar 13 09:45:36.625910 kernel: SLUB: HWalign=64, Order=0-3, MinObjects=0, CPUs=2, Nodes=1 Mar 13 09:45:36.625914 kernel: ftrace: allocating 40009 entries in 157 pages Mar 13 09:45:36.625919 kernel: ftrace: allocated 157 pages with 5 groups Mar 13 09:45:36.625924 kernel: rcu: Preemptible hierarchical RCU implementation. Mar 13 09:45:36.625932 kernel: rcu: RCU event tracing is enabled. Mar 13 09:45:36.625938 kernel: rcu: RCU restricting CPUs from NR_CPUS=512 to nr_cpu_ids=2. Mar 13 09:45:36.625943 kernel: Trampoline variant of Tasks RCU enabled. Mar 13 09:45:36.625947 kernel: Rude variant of Tasks RCU enabled. Mar 13 09:45:36.625951 kernel: Tracing variant of Tasks RCU enabled. Mar 13 09:45:36.625956 kernel: rcu: RCU calculated value of scheduler-enlistment delay is 100 jiffies. Mar 13 09:45:36.625962 kernel: rcu: Adjusting geometry for rcu_fanout_leaf=16, nr_cpu_ids=2 Mar 13 09:45:36.625966 kernel: RCU Tasks: Setting shift to 1 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=2. Mar 13 09:45:36.625971 kernel: RCU Tasks Rude: Setting shift to 1 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=2. Mar 13 09:45:36.625975 kernel: RCU Tasks Trace: Setting shift to 1 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=2. Mar 13 09:45:36.625980 kernel: NR_IRQS: 64, nr_irqs: 64, preallocated irqs: 0 Mar 13 09:45:36.625985 kernel: GICv3: 960 SPIs implemented Mar 13 09:45:36.625990 kernel: GICv3: 0 Extended SPIs implemented Mar 13 09:45:36.625995 kernel: Root IRQ handler: gic_handle_irq Mar 13 09:45:36.626000 kernel: GICv3: GICv3 features: 16 PPIs, RSS Mar 13 09:45:36.626004 kernel: GICv3: GICD_CTRL.DS=0, SCR_EL3.FIQ=0 Mar 13 09:45:36.626008 kernel: GICv3: CPU0: found redistributor 0 region 0:0x00000000effee000 Mar 13 09:45:36.626013 kernel: ITS: No ITS available, not enabling LPIs Mar 13 09:45:36.626019 kernel: rcu: srcu_init: Setting srcu_struct sizes based on contention. Mar 13 09:45:36.626023 kernel: arch_timer: cp15 timer(s) running at 1000.00MHz (virt). Mar 13 09:45:36.626028 kernel: clocksource: arch_sys_counter: mask: 0x1fffffffffffffff max_cycles: 0x1cd42e4dffb, max_idle_ns: 881590591483 ns Mar 13 09:45:36.626032 kernel: sched_clock: 61 bits at 1000MHz, resolution 1ns, wraps every 4398046511103ns Mar 13 09:45:36.626038 kernel: Console: colour dummy device 80x25 Mar 13 09:45:36.626045 kernel: printk: legacy console [tty1] enabled Mar 13 09:45:36.626051 kernel: ACPI: Core revision 20240827 Mar 13 09:45:36.626487 kernel: Calibrating delay loop (skipped), value calculated using timer frequency.. 2000.00 BogoMIPS (lpj=1000000) Mar 13 09:45:36.626511 kernel: pid_max: default: 32768 minimum: 301 Mar 13 09:45:36.626517 kernel: LSM: initializing lsm=lockdown,capability,landlock,selinux,ima Mar 13 09:45:36.626522 kernel: landlock: Up and running. Mar 13 09:45:36.626527 kernel: SELinux: Initializing. Mar 13 09:45:36.626538 kernel: Mount-cache hash table entries: 8192 (order: 4, 65536 bytes, linear) Mar 13 09:45:36.626543 kernel: Mountpoint-cache hash table entries: 8192 (order: 4, 65536 bytes, linear) Mar 13 09:45:36.626551 kernel: Hyper-V: privilege flags low 0x2e7f, high 0x3b8030, hints 0xa0000e, misc 0x31e1 Mar 13 09:45:36.626558 kernel: Hyper-V: Host Build 10.0.26102.1212-1-0 Mar 13 09:45:36.626563 kernel: Hyper-V: enabling crash_kexec_post_notifiers Mar 13 09:45:36.626568 kernel: rcu: Hierarchical SRCU implementation. Mar 13 09:45:36.626573 kernel: rcu: Max phase no-delay instances is 400. Mar 13 09:45:36.626579 kernel: Timer migration: 1 hierarchy levels; 8 children per group; 1 crossnode level Mar 13 09:45:36.626584 kernel: Remapping and enabling EFI services. Mar 13 09:45:36.626589 kernel: smp: Bringing up secondary CPUs ... Mar 13 09:45:36.626594 kernel: Detected PIPT I-cache on CPU1 Mar 13 09:45:36.626599 kernel: GICv3: CPU1: found redistributor 1 region 1:0x00000000f000e000 Mar 13 09:45:36.626604 kernel: CPU1: Booted secondary processor 0x0000000001 [0x410fd490] Mar 13 09:45:36.626610 kernel: smp: Brought up 1 node, 2 CPUs Mar 13 09:45:36.626615 kernel: SMP: Total of 2 processors activated. Mar 13 09:45:36.626620 kernel: CPU: All CPU(s) started at EL1 Mar 13 09:45:36.626625 kernel: CPU features: detected: 32-bit EL0 Support Mar 13 09:45:36.626630 kernel: CPU features: detected: Instruction cache invalidation not required for I/D coherence Mar 13 09:45:36.626635 kernel: CPU features: detected: Data cache clean to the PoU not required for I/D coherence Mar 13 09:45:36.626640 kernel: CPU features: detected: Common not Private translations Mar 13 09:45:36.626646 kernel: CPU features: detected: CRC32 instructions Mar 13 09:45:36.626650 kernel: CPU features: detected: Generic authentication (architected QARMA5 algorithm) Mar 13 09:45:36.626656 kernel: CPU features: detected: RCpc load-acquire (LDAPR) Mar 13 09:45:36.626660 kernel: CPU features: detected: LSE atomic instructions Mar 13 09:45:36.626665 kernel: CPU features: detected: Privileged Access Never Mar 13 09:45:36.626670 kernel: CPU features: detected: Speculation barrier (SB) Mar 13 09:45:36.626675 kernel: CPU features: detected: TLB range maintenance instructions Mar 13 09:45:36.626681 kernel: CPU features: detected: Speculative Store Bypassing Safe (SSBS) Mar 13 09:45:36.626686 kernel: CPU features: detected: Scalable Vector Extension Mar 13 09:45:36.626691 kernel: alternatives: applying system-wide alternatives Mar 13 09:45:36.626698 kernel: CPU features: detected: Hardware dirty bit management on CPU0-1 Mar 13 09:45:36.626703 kernel: SVE: maximum available vector length 16 bytes per vector Mar 13 09:45:36.626708 kernel: SVE: default vector length 16 bytes per vector Mar 13 09:45:36.626713 kernel: Memory: 3977508K/4194160K available (12032K kernel code, 2468K rwdata, 9168K rodata, 13184K init, 1042K bss, 194740K reserved, 16384K cma-reserved) Mar 13 09:45:36.626719 kernel: devtmpfs: initialized Mar 13 09:45:36.626725 kernel: clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1911260446275000 ns Mar 13 09:45:36.626730 kernel: futex hash table entries: 512 (order: 3, 32768 bytes, linear) Mar 13 09:45:36.626735 kernel: 2G module region forced by RANDOMIZE_MODULE_REGION_FULL Mar 13 09:45:36.626740 kernel: 0 pages in range for non-PLT usage Mar 13 09:45:36.626745 kernel: 514752 pages in range for PLT usage Mar 13 09:45:36.626750 kernel: pinctrl core: initialized pinctrl subsystem Mar 13 09:45:36.626758 kernel: SMBIOS 3.1.0 present. Mar 13 09:45:36.626763 kernel: DMI: Microsoft Corporation Virtual Machine/Virtual Machine, BIOS Hyper-V UEFI Release v4.1 06/10/2025 Mar 13 09:45:36.626768 kernel: DMI: Memory slots populated: 2/2 Mar 13 09:45:36.626773 kernel: NET: Registered PF_NETLINK/PF_ROUTE protocol family Mar 13 09:45:36.626778 kernel: DMA: preallocated 512 KiB GFP_KERNEL pool for atomic allocations Mar 13 09:45:36.626783 kernel: DMA: preallocated 512 KiB GFP_KERNEL|GFP_DMA pool for atomic allocations Mar 13 09:45:36.626788 kernel: DMA: preallocated 512 KiB GFP_KERNEL|GFP_DMA32 pool for atomic allocations Mar 13 09:45:36.626793 kernel: audit: initializing netlink subsys (disabled) Mar 13 09:45:36.626800 kernel: audit: type=2000 audit(0.059:1): state=initialized audit_enabled=0 res=1 Mar 13 09:45:36.626805 kernel: thermal_sys: Registered thermal governor 'step_wise' Mar 13 09:45:36.626810 kernel: cpuidle: using governor menu Mar 13 09:45:36.626814 kernel: hw-breakpoint: found 6 breakpoint and 4 watchpoint registers. Mar 13 09:45:36.626819 kernel: ASID allocator initialised with 32768 entries Mar 13 09:45:36.626824 kernel: acpiphp: ACPI Hot Plug PCI Controller Driver version: 0.5 Mar 13 09:45:36.626830 kernel: Serial: AMBA PL011 UART driver Mar 13 09:45:36.626835 kernel: HugeTLB: registered 1.00 GiB page size, pre-allocated 0 pages Mar 13 09:45:36.626840 kernel: HugeTLB: 0 KiB vmemmap can be freed for a 1.00 GiB page Mar 13 09:45:36.626845 kernel: HugeTLB: registered 32.0 MiB page size, pre-allocated 0 pages Mar 13 09:45:36.626850 kernel: HugeTLB: 0 KiB vmemmap can be freed for a 32.0 MiB page Mar 13 09:45:36.626855 kernel: HugeTLB: registered 2.00 MiB page size, pre-allocated 0 pages Mar 13 09:45:36.626860 kernel: HugeTLB: 0 KiB vmemmap can be freed for a 2.00 MiB page Mar 13 09:45:36.626864 kernel: HugeTLB: registered 64.0 KiB page size, pre-allocated 0 pages Mar 13 09:45:36.626870 kernel: HugeTLB: 0 KiB vmemmap can be freed for a 64.0 KiB page Mar 13 09:45:36.626875 kernel: ACPI: Added _OSI(Module Device) Mar 13 09:45:36.626880 kernel: ACPI: Added _OSI(Processor Device) Mar 13 09:45:36.626885 kernel: ACPI: Added _OSI(Processor Aggregator Device) Mar 13 09:45:36.626890 kernel: ACPI: 1 ACPI AML tables successfully acquired and loaded Mar 13 09:45:36.626895 kernel: ACPI: Interpreter enabled Mar 13 09:45:36.626900 kernel: ACPI: Using GIC for interrupt routing Mar 13 09:45:36.626905 kernel: ARMH0011:00: ttyAMA0 at MMIO 0xeffec000 (irq = 12, base_baud = 0) is a SBSA Mar 13 09:45:36.626910 kernel: printk: legacy console [ttyAMA0] enabled Mar 13 09:45:36.626915 kernel: printk: legacy bootconsole [pl11] disabled Mar 13 09:45:36.626920 kernel: ARMH0011:01: ttyAMA1 at MMIO 0xeffeb000 (irq = 13, base_baud = 0) is a SBSA Mar 13 09:45:36.626925 kernel: ACPI: CPU0 has been hot-added Mar 13 09:45:36.626930 kernel: ACPI: CPU1 has been hot-added Mar 13 09:45:36.626935 kernel: iommu: Default domain type: Translated Mar 13 09:45:36.626941 kernel: iommu: DMA domain TLB invalidation policy: strict mode Mar 13 09:45:36.626945 kernel: efivars: Registered efivars operations Mar 13 09:45:36.626950 kernel: vgaarb: loaded Mar 13 09:45:36.626955 kernel: clocksource: Switched to clocksource arch_sys_counter Mar 13 09:45:36.626960 kernel: VFS: Disk quotas dquot_6.6.0 Mar 13 09:45:36.626965 kernel: VFS: Dquot-cache hash table entries: 512 (order 0, 4096 bytes) Mar 13 09:45:36.626970 kernel: pnp: PnP ACPI init Mar 13 09:45:36.626976 kernel: pnp: PnP ACPI: found 0 devices Mar 13 09:45:36.626980 kernel: NET: Registered PF_INET protocol family Mar 13 09:45:36.626986 kernel: IP idents hash table entries: 65536 (order: 7, 524288 bytes, linear) Mar 13 09:45:36.626990 kernel: tcp_listen_portaddr_hash hash table entries: 2048 (order: 3, 32768 bytes, linear) Mar 13 09:45:36.626995 kernel: Table-perturb hash table entries: 65536 (order: 6, 262144 bytes, linear) Mar 13 09:45:36.627001 kernel: TCP established hash table entries: 32768 (order: 6, 262144 bytes, linear) Mar 13 09:45:36.627005 kernel: TCP bind hash table entries: 32768 (order: 8, 1048576 bytes, linear) Mar 13 09:45:36.627011 kernel: TCP: Hash tables configured (established 32768 bind 32768) Mar 13 09:45:36.627016 kernel: UDP hash table entries: 2048 (order: 4, 65536 bytes, linear) Mar 13 09:45:36.627021 kernel: UDP-Lite hash table entries: 2048 (order: 4, 65536 bytes, linear) Mar 13 09:45:36.627026 kernel: NET: Registered PF_UNIX/PF_LOCAL protocol family Mar 13 09:45:36.627031 kernel: PCI: CLS 0 bytes, default 64 Mar 13 09:45:36.627036 kernel: kvm [1]: HYP mode not available Mar 13 09:45:36.627041 kernel: Initialise system trusted keyrings Mar 13 09:45:36.627046 kernel: workingset: timestamp_bits=39 max_order=20 bucket_order=0 Mar 13 09:45:36.627051 kernel: Key type asymmetric registered Mar 13 09:45:36.627078 kernel: Asymmetric key parser 'x509' registered Mar 13 09:45:36.627084 kernel: Block layer SCSI generic (bsg) driver version 0.4 loaded (major 249) Mar 13 09:45:36.627089 kernel: io scheduler mq-deadline registered Mar 13 09:45:36.627094 kernel: io scheduler kyber registered Mar 13 09:45:36.627099 kernel: io scheduler bfq registered Mar 13 09:45:36.627104 kernel: Serial: 8250/16550 driver, 4 ports, IRQ sharing enabled Mar 13 09:45:36.627110 kernel: thunder_xcv, ver 1.0 Mar 13 09:45:36.627115 kernel: thunder_bgx, ver 1.0 Mar 13 09:45:36.627120 kernel: nicpf, ver 1.0 Mar 13 09:45:36.627124 kernel: nicvf, ver 1.0 Mar 13 09:45:36.627313 kernel: rtc-efi rtc-efi.0: registered as rtc0 Mar 13 09:45:36.627400 kernel: rtc-efi rtc-efi.0: setting system clock to 2026-03-13T09:45:32 UTC (1773395132) Mar 13 09:45:36.627409 kernel: efifb: probing for efifb Mar 13 09:45:36.627414 kernel: efifb: framebuffer at 0x40000000, using 3072k, total 3072k Mar 13 09:45:36.627419 kernel: efifb: mode is 1024x768x32, linelength=4096, pages=1 Mar 13 09:45:36.627423 kernel: efifb: scrolling: redraw Mar 13 09:45:36.627428 kernel: efifb: Truecolor: size=8:8:8:8, shift=24:16:8:0 Mar 13 09:45:36.627433 kernel: Console: switching to colour frame buffer device 128x48 Mar 13 09:45:36.627438 kernel: fb0: EFI VGA frame buffer device Mar 13 09:45:36.627444 kernel: SMCCC: SOC_ID: ARCH_SOC_ID not implemented, skipping .... Mar 13 09:45:36.627449 kernel: hid: raw HID events driver (C) Jiri Kosina Mar 13 09:45:36.627454 kernel: hw perfevents: enabled with armv8_pmuv3_0 PMU driver, 7 (0,8000003f) counters available Mar 13 09:45:36.627459 kernel: watchdog: NMI not fully supported Mar 13 09:45:36.627464 kernel: watchdog: Hard watchdog permanently disabled Mar 13 09:45:36.627469 kernel: NET: Registered PF_INET6 protocol family Mar 13 09:45:36.627474 kernel: Segment Routing with IPv6 Mar 13 09:45:36.627480 kernel: In-situ OAM (IOAM) with IPv6 Mar 13 09:45:36.627488 kernel: NET: Registered PF_PACKET protocol family Mar 13 09:45:36.627493 kernel: Key type dns_resolver registered Mar 13 09:45:36.627498 kernel: registered taskstats version 1 Mar 13 09:45:36.627503 kernel: Loading compiled-in X.509 certificates Mar 13 09:45:36.627508 kernel: Loaded X.509 cert 'Kinvolk GmbH: Module signing key for 6.12.76-flatcar: a81fb8a7bceab79163ae9b8740e3321224d48285' Mar 13 09:45:36.627513 kernel: Demotion targets for Node 0: null Mar 13 09:45:36.627519 kernel: Key type .fscrypt registered Mar 13 09:45:36.627524 kernel: Key type fscrypt-provisioning registered Mar 13 09:45:36.627529 kernel: ima: No TPM chip found, activating TPM-bypass! Mar 13 09:45:36.627534 kernel: ima: Allocated hash algorithm: sha1 Mar 13 09:45:36.627538 kernel: ima: No architecture policies found Mar 13 09:45:36.627543 kernel: alg: No test for fips(ansi_cprng) (fips_ansi_cprng) Mar 13 09:45:36.627548 kernel: clk: Disabling unused clocks Mar 13 09:45:36.627553 kernel: PM: genpd: Disabling unused power domains Mar 13 09:45:36.627559 kernel: Freeing unused kernel memory: 13184K Mar 13 09:45:36.627564 kernel: Run /init as init process Mar 13 09:45:36.627569 kernel: with arguments: Mar 13 09:45:36.627574 kernel: /init Mar 13 09:45:36.627579 kernel: with environment: Mar 13 09:45:36.627583 kernel: HOME=/ Mar 13 09:45:36.627588 kernel: TERM=linux Mar 13 09:45:36.627594 kernel: hv_vmbus: Vmbus version:5.3 Mar 13 09:45:36.627599 kernel: hv_vmbus: registering driver hid_hyperv Mar 13 09:45:36.627604 kernel: SCSI subsystem initialized Mar 13 09:45:36.627609 kernel: input: Microsoft Vmbus HID-compliant Mouse as /devices/0006:045E:0621.0001/input/input0 Mar 13 09:45:36.627711 kernel: hid-hyperv 0006:045E:0621.0001: input: VIRTUAL HID v0.01 Mouse [Microsoft Vmbus HID-compliant Mouse] on Mar 13 09:45:36.627719 kernel: hv_vmbus: registering driver hyperv_keyboard Mar 13 09:45:36.627725 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 13 09:45:36.627730 kernel: pps_core: LinuxPPS API ver. 1 registered Mar 13 09:45:36.627735 kernel: pps_core: Software ver. 5.3.6 - Copyright 2005-2007 Rodolfo Giometti Mar 13 09:45:36.627740 kernel: PTP clock support registered Mar 13 09:45:36.627745 kernel: hv_utils: Registering HyperV Utility Driver Mar 13 09:45:36.627750 kernel: hv_vmbus: registering driver hv_utils Mar 13 09:45:36.627755 kernel: hv_utils: Heartbeat IC version 3.0 Mar 13 09:45:36.627761 kernel: hv_utils: Shutdown IC version 3.2 Mar 13 09:45:36.627766 kernel: hv_utils: TimeSync IC version 4.0 Mar 13 09:45:36.627771 kernel: hv_vmbus: registering driver hv_storvsc Mar 13 09:45:36.627883 kernel: scsi host1: storvsc_host_t Mar 13 09:45:36.627982 kernel: scsi host0: storvsc_host_t Mar 13 09:45:36.628121 kernel: scsi 0:0:0:0: Direct-Access Msft Virtual Disk 1.0 PQ: 0 ANSI: 5 Mar 13 09:45:36.628238 kernel: scsi 0:0:0:2: CD-ROM Msft Virtual DVD-ROM 1.0 PQ: 0 ANSI: 5 Mar 13 09:45:36.628336 kernel: sd 0:0:0:0: [sda] 63737856 512-byte logical blocks: (32.6 GB/30.4 GiB) Mar 13 09:45:36.628432 kernel: sd 0:0:0:0: [sda] 4096-byte physical blocks Mar 13 09:45:36.628532 kernel: sd 0:0:0:0: [sda] Write Protect is off Mar 13 09:45:36.628628 kernel: sd 0:0:0:0: [sda] Mode Sense: 0f 00 10 00 Mar 13 09:45:36.628724 kernel: sd 0:0:0:0: [sda] Write cache: disabled, read cache: enabled, supports DPO and FUA Mar 13 09:45:36.628732 kernel: sda: sda1 sda2 sda3 sda4 sda6 sda7 sda9 Mar 13 09:45:36.628826 kernel: sd 0:0:0:0: [sda] Attached SCSI disk Mar 13 09:45:36.628922 kernel: sr 0:0:0:2: [sr0] scsi-1 drive Mar 13 09:45:36.628928 kernel: cdrom: Uniform CD-ROM driver Revision: 3.20 Mar 13 09:45:36.629022 kernel: sr 0:0:0:2: Attached scsi CD-ROM sr0 Mar 13 09:45:36.629028 kernel: device-mapper: core: CONFIG_IMA_DISABLE_HTABLE is disabled. Duplicate IMA measurements will not be recorded in the IMA log. Mar 13 09:45:36.629034 kernel: device-mapper: uevent: version 1.0.3 Mar 13 09:45:36.629040 kernel: device-mapper: ioctl: 4.48.0-ioctl (2023-03-01) initialised: dm-devel@lists.linux.dev Mar 13 09:45:36.629045 kernel: device-mapper: verity: sha256 using shash "sha256-ce" Mar 13 09:45:36.629050 kernel: raid6: neonx8 gen() 18540 MB/s Mar 13 09:45:36.629055 kernel: raid6: neonx4 gen() 18568 MB/s Mar 13 09:45:36.629073 kernel: raid6: neonx2 gen() 16976 MB/s Mar 13 09:45:36.629079 kernel: raid6: neonx1 gen() 15196 MB/s Mar 13 09:45:36.629085 kernel: raid6: int64x8 gen() 8923 MB/s Mar 13 09:45:36.629090 kernel: raid6: int64x4 gen() 10747 MB/s Mar 13 09:45:36.629095 kernel: raid6: int64x2 gen() 8828 MB/s Mar 13 09:45:36.629100 kernel: raid6: int64x1 gen() 7108 MB/s Mar 13 09:45:36.629105 kernel: raid6: using algorithm neonx4 gen() 18568 MB/s Mar 13 09:45:36.629110 kernel: raid6: .... xor() 15149 MB/s, rmw enabled Mar 13 09:45:36.629115 kernel: raid6: using neon recovery algorithm Mar 13 09:45:36.629120 kernel: xor: measuring software checksum speed Mar 13 09:45:36.629126 kernel: 8regs : 29426 MB/sec Mar 13 09:45:36.629131 kernel: 32regs : 29675 MB/sec Mar 13 09:45:36.629136 kernel: arm64_neon : 36993 MB/sec Mar 13 09:45:36.629141 kernel: xor: using function: arm64_neon (36993 MB/sec) Mar 13 09:45:36.629146 kernel: Btrfs loaded, zoned=no, fsverity=no Mar 13 09:45:36.629151 kernel: BTRFS: device fsid 15c15fc3-6f5d-45d6-bcb1-e03205b55af5 devid 1 transid 41 /dev/mapper/usr (254:0) scanned by mount (364) Mar 13 09:45:36.629156 kernel: BTRFS info (device dm-0): first mount of filesystem 15c15fc3-6f5d-45d6-bcb1-e03205b55af5 Mar 13 09:45:36.629162 kernel: BTRFS info (device dm-0): using crc32c (crc32c-generic) checksum algorithm Mar 13 09:45:36.629167 kernel: BTRFS info (device dm-0 state E): disabling log replay at mount time Mar 13 09:45:36.629172 kernel: BTRFS info (device dm-0 state E): enabling free space tree Mar 13 09:45:36.629177 kernel: loop: module loaded Mar 13 09:45:36.629181 kernel: loop0: detected capacity change from 0 to 97448 Mar 13 09:45:36.629186 kernel: squashfs: version 4.0 (2009/01/31) Phillip Lougher Mar 13 09:45:36.629193 systemd[1]: /etc/systemd/system.conf.d/nocgroup.conf:2: Support for option DefaultCPUAccounting= has been removed and it is ignored Mar 13 09:45:36.629200 systemd[1]: /etc/systemd/system.conf.d/nocgroup.conf:5: Support for option DefaultBlockIOAccounting= has been removed and it is ignored Mar 13 09:45:36.629206 systemd[1]: Successfully made /usr/ read-only. Mar 13 09:45:36.629212 systemd[1]: systemd 258.2 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 13 09:45:36.629217 systemd[1]: Detected virtualization microsoft. Mar 13 09:45:36.629223 systemd[1]: Detected architecture arm64. Mar 13 09:45:36.629229 systemd[1]: Running in initrd. Mar 13 09:45:36.629234 systemd[1]: Initializing machine ID from random generator. Mar 13 09:45:36.629240 systemd[1]: No hostname configured, using default hostname. Mar 13 09:45:36.629245 systemd[1]: Hostname set to . Mar 13 09:45:36.629250 systemd[1]: Queued start job for default target initrd.target. Mar 13 09:45:36.629256 systemd[1]: Unnecessary job was removed for dev-mapper-usr.device - /dev/mapper/usr. Mar 13 09:45:36.629261 systemd[1]: Started clevis-luks-askpass.path - Forward Password Requests to Clevis Directory Watch. Mar 13 09:45:36.629268 systemd[1]: Started systemd-ask-password-console.path - Dispatch Password Requests to Console Directory Watch. Mar 13 09:45:36.629274 systemd[1]: Expecting device dev-disk-by\x2dlabel-EFI\x2dSYSTEM.device - /dev/disk/by-label/EFI-SYSTEM... Mar 13 09:45:36.629280 systemd[1]: Expecting device dev-disk-by\x2dlabel-OEM.device - /dev/disk/by-label/OEM... Mar 13 09:45:36.629285 systemd[1]: Expecting device dev-disk-by\x2dlabel-ROOT.device - /dev/disk/by-label/ROOT... Mar 13 09:45:36.629291 systemd[1]: Expecting device dev-disk-by\x2dpartlabel-USR\x2dA.device - /dev/disk/by-partlabel/USR-A... Mar 13 09:45:36.629297 systemd[1]: Reached target cryptsetup-pre.target - Local Encrypted Volumes (Pre). Mar 13 09:45:36.629302 systemd[1]: Reached target cryptsetup.target - Local Encrypted Volumes. Mar 13 09:45:36.629308 systemd[1]: Reached target initrd-usr-fs.target - Initrd /usr File System. Mar 13 09:45:36.629313 systemd[1]: Reached target paths.target - Path Units. Mar 13 09:45:36.629318 systemd[1]: Reached target slices.target - Slice Units. Mar 13 09:45:36.629324 systemd[1]: Reached target swap.target - Swaps. Mar 13 09:45:36.629329 systemd[1]: Reached target timers.target - Timer Units. Mar 13 09:45:36.629335 systemd[1]: Listening on iscsid.socket - Open-iSCSI iscsid Socket. Mar 13 09:45:36.629341 systemd[1]: Listening on iscsiuio.socket - Open-iSCSI iscsiuio Socket. Mar 13 09:45:36.629351 systemd[1]: Listening on systemd-journald-audit.socket - Journal Audit Socket. Mar 13 09:45:36.629358 systemd[1]: Listening on systemd-journald-dev-log.socket - Journal Socket (/dev/log). Mar 13 09:45:36.629363 systemd[1]: Listening on systemd-journald.socket - Journal Sockets. Mar 13 09:45:36.629370 systemd[1]: Listening on systemd-networkd.socket - Network Service Netlink Socket. Mar 13 09:45:36.629375 systemd[1]: Listening on systemd-udevd-control.socket - udev Control Socket. Mar 13 09:45:36.629381 systemd[1]: Listening on systemd-udevd-kernel.socket - udev Kernel Socket. Mar 13 09:45:36.629386 systemd[1]: Reached target sockets.target - Socket Units. Mar 13 09:45:36.629392 systemd[1]: afterburn-network-kargs.service - Afterburn Initrd Setup Network Kernel Arguments was skipped because no trigger condition checks were met. Mar 13 09:45:36.629397 systemd[1]: Starting ignition-setup-pre.service - Ignition env setup... Mar 13 09:45:36.629403 systemd[1]: Starting kmod-static-nodes.service - Create List of Static Device Nodes... Mar 13 09:45:36.629410 systemd[1]: Finished network-cleanup.service - Network Cleanup. Mar 13 09:45:36.629416 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 13 09:45:36.629421 systemd[1]: Starting systemd-fsck-usr.service... Mar 13 09:45:36.629427 systemd[1]: Starting systemd-journald.service - Journal Service... Mar 13 09:45:36.629433 systemd[1]: Starting systemd-modules-load.service - Load Kernel Modules... Mar 13 09:45:36.629439 systemd[1]: Starting systemd-vconsole-setup.service - Virtual Console Setup... Mar 13 09:45:36.629463 systemd-journald[501]: Collecting audit messages is enabled. Mar 13 09:45:36.629479 systemd[1]: Finished ignition-setup-pre.service - Ignition env setup. Mar 13 09:45:36.629485 kernel: audit: type=1130 audit(1773395136.626: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 13 09:45:36.629492 systemd-journald[501]: Journal started Mar 13 09:45:36.629505 systemd-journald[501]: Runtime Journal (/run/log/journal/b157d94d4fb641b4afc957a4693d2865) is 8M, max 78.3M, 70.3M free. Mar 13 09:45:36.626000 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 13 09:45:36.644953 systemd[1]: Finished kmod-static-nodes.service - Create List of Static Device Nodes. Mar 13 09:45:36.654000 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 13 09:45:36.665157 systemd[1]: Started systemd-journald.service - Journal Service. Mar 13 09:45:36.665190 kernel: audit: type=1130 audit(1773395136.654:3): 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 13 09:45:36.675000 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 13 09:45:36.676551 systemd[1]: Finished systemd-fsck-usr.service. Mar 13 09:45:36.694368 kernel: audit: type=1130 audit(1773395136.675:4): 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 13 09:45:36.693000 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 13 09:45:36.696771 systemd[1]: Starting systemd-tmpfiles-setup-dev-early.service - Create Static Device Nodes in /dev gracefully... Mar 13 09:45:36.721028 kernel: audit: type=1130 audit(1773395136.693: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 13 09:45:36.721053 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 13 09:45:36.728791 systemd-modules-load[504]: Inserted module 'br_netfilter' Mar 13 09:45:36.732737 kernel: Bridge firewalling registered Mar 13 09:45:36.736030 systemd[1]: Starting systemd-tmpfiles-setup.service - Create System Files and Directories... Mar 13 09:45:36.746760 systemd[1]: Finished systemd-modules-load.service - Load Kernel Modules. Mar 13 09:45:36.753000 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 13 09:45:36.757203 systemd[1]: Starting systemd-sysctl.service - Apply Kernel Variables... Mar 13 09:45:36.780153 systemd-tmpfiles[512]: /usr/lib/tmpfiles.d/var.conf:14: Duplicate line for path "/var/log", ignoring. Mar 13 09:45:36.790884 kernel: audit: type=1130 audit(1773395136.753: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 13 09:45:36.795331 systemd[1]: Finished systemd-tmpfiles-setup.service - Create System Files and Directories. Mar 13 09:45:36.800000 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 13 09:45:36.810172 systemd[1]: Finished systemd-vconsole-setup.service - Virtual Console Setup. Mar 13 09:45:36.822000 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 13 09:45:36.827582 systemd[1]: Finished systemd-tmpfiles-setup-dev-early.service - Create Static Device Nodes in /dev gracefully. Mar 13 09:45:36.845847 kernel: audit: type=1130 audit(1773395136.800:7): pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=systemd-tmpfiles-setup comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Mar 13 09:45:36.845868 kernel: audit: type=1130 audit(1773395136.822:8): 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 13 09:45:36.850000 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 13 09:45:36.863501 systemd[1]: Finished systemd-sysctl.service - Apply Kernel Variables. Mar 13 09:45:36.867000 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 13 09:45:36.883776 kernel: audit: type=1130 audit(1773395136.850:9): pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=systemd-tmpfiles-setup-dev-early comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Mar 13 09:45:36.870623 systemd[1]: Starting dracut-cmdline-ask.service - dracut ask for additional cmdline parameters... Mar 13 09:45:36.894640 kernel: audit: type=1130 audit(1773395136.867:10): pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=systemd-sysctl comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Mar 13 09:45:36.897000 audit: BPF prog-id=5 op=LOAD Mar 13 09:45:36.902912 systemd[1]: Starting systemd-resolved.service - Network Name Resolution... Mar 13 09:45:36.907932 systemd[1]: Starting systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev... Mar 13 09:45:36.922335 kernel: audit: type=1334 audit(1773395136.897:11): prog-id=5 op=LOAD Mar 13 09:45:36.944200 systemd[1]: Finished systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev. Mar 13 09:45:36.953000 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 13 09:45:36.955210 systemd[1]: Finished dracut-cmdline-ask.service - dracut ask for additional cmdline parameters. Mar 13 09:45:36.982220 systemd[1]: Starting dracut-cmdline.service - dracut cmdline hook... Mar 13 09:45:36.975000 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 13 09:45:37.002478 kernel: audit: type=1130 audit(1773395136.953:12): pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=systemd-tmpfiles-setup-dev comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Mar 13 09:45:37.002496 kernel: audit: type=1130 audit(1773395136.975:13): 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 13 09:45:37.054857 systemd-resolved[524]: Positive Trust Anchors: Mar 13 09:45:37.054877 systemd-resolved[524]: . IN DS 20326 8 2 e06d44b80b8f1d39a95c0b0d7c65d08458e880409bbc683457104237c7f8ec8d Mar 13 09:45:37.054879 systemd-resolved[524]: . IN DS 38696 8 2 683d2d0acb8c9b712a1948b27f741219298d0a450d612c483af444a4c0fb2b16 Mar 13 09:45:37.054899 systemd-resolved[524]: 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 13 09:45:37.080599 systemd-resolved[524]: Defaulting to hostname 'linux'. Mar 13 09:45:37.105000 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 13 09:45:37.081392 systemd[1]: Started systemd-resolved.service - Network Name Resolution. Mar 13 09:45:37.132461 dracut-cmdline[539]: dracut-109 Mar 13 09:45:37.106952 systemd[1]: Reached target nss-lookup.target - Host and Network Name Lookups. Mar 13 09:45:37.142131 kernel: audit: type=1130 audit(1773395137.105:14): 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 13 09:45:37.142153 dracut-cmdline[539]: 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=5f9ba9fca0bd7496423588a0876ca61872bd78f585145c3ef7377567db95fe17 Mar 13 09:45:37.269087 kernel: Loading iSCSI transport class v2.0-870. Mar 13 09:45:37.321106 kernel: iscsi: registered transport (tcp) Mar 13 09:45:37.354867 kernel: iscsi: registered transport (qla4xxx) Mar 13 09:45:37.354935 kernel: QLogic iSCSI HBA Driver Mar 13 09:45:37.425094 systemd[1]: Starting systemd-network-generator.service - Generate Network Units from Kernel Command Line... Mar 13 09:45:37.444768 systemd[1]: Finished systemd-network-generator.service - Generate Network Units from Kernel Command Line. Mar 13 09:45:37.449000 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 13 09:45:37.470250 kernel: audit: type=1130 audit(1773395137.449:15): pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=systemd-network-generator comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Mar 13 09:45:37.451336 systemd[1]: Reached target network-pre.target - Preparation for Network. Mar 13 09:45:37.512968 systemd[1]: Finished dracut-cmdline.service - dracut cmdline hook. Mar 13 09:45:37.517000 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 13 09:45:37.535127 kernel: audit: type=1130 audit(1773395137.517:16): pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=dracut-cmdline comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Mar 13 09:45:37.536279 systemd[1]: Starting dracut-pre-udev.service - dracut pre-udev hook... Mar 13 09:45:37.541107 systemd[1]: Starting parse-ip-for-networkd.service - Write systemd-networkd units from cmdline... Mar 13 09:45:37.575972 systemd[1]: Finished dracut-pre-udev.service - dracut pre-udev hook. Mar 13 09:45:37.580000 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 13 09:45:37.584000 audit: BPF prog-id=6 op=LOAD Mar 13 09:45:37.584000 audit: BPF prog-id=7 op=LOAD Mar 13 09:45:37.586608 systemd[1]: Starting systemd-udevd.service - Rule-based Manager for Device Events and Files... Mar 13 09:45:37.687882 systemd-udevd[764]: Using default interface naming scheme 'v258'. Mar 13 09:45:37.694149 systemd[1]: Finished parse-ip-for-networkd.service - Write systemd-networkd units from cmdline. Mar 13 09:45:37.698000 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 13 09:45:37.715252 systemd[1]: Started systemd-udevd.service - Rule-based Manager for Device Events and Files. Mar 13 09:45:37.723000 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 13 09:45:37.726346 systemd[1]: Starting dracut-pre-trigger.service - dracut pre-trigger hook... Mar 13 09:45:37.743000 audit: BPF prog-id=8 op=LOAD Mar 13 09:45:37.745176 systemd[1]: Starting systemd-networkd.service - Network Configuration... Mar 13 09:45:37.758893 dracut-pre-trigger[882]: rd.md=0: removing MD RAID activation Mar 13 09:45:37.793652 systemd-networkd[889]: lo: Link UP Mar 13 09:45:37.793659 systemd-networkd[889]: lo: Gained carrier Mar 13 09:45:37.803000 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 13 09:45:37.796404 systemd[1]: Started systemd-networkd.service - Network Configuration. Mar 13 09:45:37.804747 systemd[1]: Reached target network.target - Network. Mar 13 09:45:37.818000 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 13 09:45:37.813091 systemd[1]: Finished dracut-pre-trigger.service - dracut pre-trigger hook. Mar 13 09:45:37.821259 systemd[1]: Starting systemd-udev-trigger.service - Coldplug All udev Devices... Mar 13 09:45:37.893181 systemd[1]: Finished systemd-udev-trigger.service - Coldplug All udev Devices. Mar 13 09:45:37.902000 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 13 09:45:37.904387 systemd[1]: Starting dracut-initqueue.service - dracut initqueue hook... Mar 13 09:45:38.022815 systemd[1]: systemd-vconsole-setup.service: Deactivated successfully. Mar 13 09:45:38.027174 systemd[1]: Stopped systemd-vconsole-setup.service - Virtual Console Setup. Mar 13 09:45:38.042000 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 13 09:45:38.043671 systemd[1]: Stopping systemd-vconsole-setup.service - Virtual Console Setup... Mar 13 09:45:38.056934 kernel: hv_storvsc f8b3781a-1e82-4818-a1c3-63d806ec15bb: tag#171 cmd 0x85 status: scsi 0x2 srb 0x6 hv 0xc0000001 Mar 13 09:45:38.057190 kernel: hv_vmbus: registering driver hv_netvsc Mar 13 09:45:38.061358 systemd[1]: Starting systemd-vconsole-setup.service - Virtual Console Setup... Mar 13 09:45:38.078956 systemd[1]: systemd-vconsole-setup.service: Deactivated successfully. Mar 13 09:45:38.079821 systemd[1]: Stopped systemd-vconsole-setup.service - Virtual Console Setup. Mar 13 09:45:38.092000 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 13 09:45:38.092000 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 13 09:45:38.099372 systemd[1]: Starting systemd-vconsole-setup.service - Virtual Console Setup... Mar 13 09:45:38.129101 systemd[1]: Finished systemd-vconsole-setup.service - Virtual Console Setup. Mar 13 09:45:38.140000 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 13 09:45:38.147627 kernel: hv_netvsc 002248c2-0bfc-0022-48c2-0bfc002248c2 eth0: VF slot 1 added Mar 13 09:45:38.162876 systemd-networkd[889]: eth0: Found matching .network file, based on potentially unpredictable interface name: /usr/lib/systemd/network/zz-default.network Mar 13 09:45:38.162892 systemd-networkd[889]: eth0: Configuring with /usr/lib/systemd/network/zz-default.network. Mar 13 09:45:38.172295 systemd-networkd[889]: eth0: Link UP Mar 13 09:45:38.172425 systemd-networkd[889]: eth0: Gained carrier Mar 13 09:45:38.172438 systemd-networkd[889]: eth0: Found matching .network file, based on potentially unpredictable interface name: /usr/lib/systemd/network/zz-default.network Mar 13 09:45:38.202475 kernel: hv_vmbus: registering driver hv_pci Mar 13 09:45:38.202528 kernel: hv_pci 74b19ca0-bedd-4f2c-a012-b06f68892236: PCI VMBus probing: Using version 0x10004 Mar 13 09:45:38.205131 systemd-networkd[889]: eth0: DHCPv4 address 10.200.20.13/24, gateway 10.200.20.1 acquired from 168.63.129.16 Mar 13 09:45:38.219867 kernel: hv_pci 74b19ca0-bedd-4f2c-a012-b06f68892236: PCI host bridge to bus bedd:00 Mar 13 09:45:38.220106 kernel: pci_bus bedd:00: root bus resource [mem 0xfc0000000-0xfc00fffff window] Mar 13 09:45:38.220237 kernel: pci_bus bedd:00: No busn resource found for root bus, will use [bus 00-ff] Mar 13 09:45:38.230541 kernel: pci bedd:00:02.0: [15b3:101a] type 00 class 0x020000 PCIe Endpoint Mar 13 09:45:38.236081 kernel: pci bedd:00:02.0: BAR 0 [mem 0xfc0000000-0xfc00fffff 64bit pref] Mar 13 09:45:38.240090 kernel: pci bedd:00:02.0: enabling Extended Tags Mar 13 09:45:38.257126 kernel: pci bedd:00:02.0: 0.000 Gb/s available PCIe bandwidth, limited by Unknown x0 link at bedd:00:02.0 (capable of 252.048 Gb/s with 16.0 GT/s PCIe x16 link) Mar 13 09:45:38.266281 kernel: pci_bus bedd:00: busn_res: [bus 00-ff] end is updated to 00 Mar 13 09:45:38.266482 kernel: pci bedd:00:02.0: BAR 0 [mem 0xfc0000000-0xfc00fffff 64bit pref]: assigned Mar 13 09:45:38.449854 kernel: mlx5_core bedd:00:02.0: enabling device (0000 -> 0002) Mar 13 09:45:38.458498 kernel: mlx5_core bedd:00:02.0: PTM is not supported by PCIe Mar 13 09:45:38.458744 kernel: mlx5_core bedd:00:02.0: firmware version: 16.30.5026 Mar 13 09:45:38.577716 systemd[1]: Found device dev-disk-by\x2dpartlabel-USR\x2dA.device - Virtual_Disk USR-A. Mar 13 09:45:38.583970 systemd[1]: Starting disk-uuid.service - Generate new UUID for disk GPT if necessary... Mar 13 09:45:38.663342 kernel: hv_netvsc 002248c2-0bfc-0022-48c2-0bfc002248c2 eth0: VF registering: eth1 Mar 13 09:45:38.663618 kernel: mlx5_core bedd:00:02.0 eth1: joined to eth0 Mar 13 09:45:38.671132 kernel: mlx5_core bedd:00:02.0: MLX5E: StrdRq(1) RqSz(8) StrdSz(2048) RxCqeCmprss(0 basic) Mar 13 09:45:38.680101 kernel: mlx5_core bedd:00:02.0 enP48861s1: renamed from eth1 Mar 13 09:45:38.681657 systemd-networkd[889]: eth1: Interface name change detected, renamed to enP48861s1. Mar 13 09:45:38.713637 systemd[1]: Found device dev-disk-by\x2dlabel-OEM.device - Virtual_Disk OEM. Mar 13 09:45:38.745978 systemd[1]: Found device dev-disk-by\x2dlabel-ROOT.device - Virtual_Disk ROOT. Mar 13 09:45:38.774523 systemd[1]: Found device dev-disk-by\x2dlabel-EFI\x2dSYSTEM.device - Virtual_Disk EFI-SYSTEM. Mar 13 09:45:38.833120 kernel: mlx5_core bedd:00:02.0 enP48861s1: Link up Mar 13 09:45:38.872543 systemd-networkd[889]: enP48861s1: Link UP Mar 13 09:45:38.877621 kernel: hv_netvsc 002248c2-0bfc-0022-48c2-0bfc002248c2 eth0: Data path switched to VF: enP48861s1 Mar 13 09:45:38.951114 systemd[1]: Finished dracut-initqueue.service - dracut initqueue hook. Mar 13 09:45:38.954000 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 13 09:45:38.956273 systemd[1]: Reached target remote-fs-pre.target - Preparation for Remote File Systems. Mar 13 09:45:38.964953 systemd[1]: Reached target remote-cryptsetup.target - Remote Encrypted Volumes. Mar 13 09:45:38.974808 systemd[1]: Reached target remote-fs.target - Remote File Systems. Mar 13 09:45:38.988217 systemd[1]: Starting dracut-pre-mount.service - dracut pre-mount hook... Mar 13 09:45:39.008143 systemd[1]: Finished dracut-pre-mount.service - dracut pre-mount hook. Mar 13 09:45:39.016000 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 13 09:45:39.176363 systemd-networkd[889]: enP48861s1: Gained carrier Mar 13 09:45:39.544458 systemd-networkd[889]: eth0: Gained IPv6LL Mar 13 09:45:39.816127 disk-uuid[1004]: Warning: The kernel is still using the old partition table. Mar 13 09:45:39.816127 disk-uuid[1004]: The new table will be used at the next reboot or after you Mar 13 09:45:39.816127 disk-uuid[1004]: run partprobe(8) or kpartx(8) Mar 13 09:45:39.816127 disk-uuid[1004]: The operation has completed successfully. Mar 13 09:45:39.833000 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 13 09:45:39.833000 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 13 09:45:39.822002 systemd[1]: disk-uuid.service: Deactivated successfully. Mar 13 09:45:39.822164 systemd[1]: Finished disk-uuid.service - Generate new UUID for disk GPT if necessary. Mar 13 09:45:39.835459 systemd[1]: Starting ignition-setup.service - Ignition (setup)... Mar 13 09:45:39.899666 kernel: BTRFS: device label OEM devid 1 transid 11 /dev/sda6 (8:6) scanned by mount (1159) Mar 13 09:45:39.899739 kernel: BTRFS info (device sda6): first mount of filesystem c52d923a-8fae-4151-a91b-22d06ca3dd45 Mar 13 09:45:39.904347 kernel: BTRFS info (device sda6): using crc32c (crc32c-generic) checksum algorithm Mar 13 09:45:39.982093 kernel: BTRFS info (device sda6): turning on async discard Mar 13 09:45:39.982119 kernel: BTRFS info (device sda6): enabling free space tree Mar 13 09:45:39.992119 kernel: BTRFS info (device sda6): last unmount of filesystem c52d923a-8fae-4151-a91b-22d06ca3dd45 Mar 13 09:45:39.992130 systemd[1]: Finished ignition-setup.service - Ignition (setup). Mar 13 09:45:39.995000 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 13 09:45:39.997982 systemd[1]: Starting ignition-fetch-offline.service - Ignition (fetch-offline)... Mar 13 09:45:41.396562 ignition[1178]: Ignition 2.24.0 Mar 13 09:45:41.396574 ignition[1178]: Stage: fetch-offline Mar 13 09:45:41.403000 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 13 09:45:41.399862 systemd[1]: Finished ignition-fetch-offline.service - Ignition (fetch-offline). Mar 13 09:45:41.396844 ignition[1178]: no configs at "/usr/lib/ignition/base.d" Mar 13 09:45:41.407207 systemd[1]: Starting ignition-fetch.service - Ignition (fetch)... Mar 13 09:45:41.396857 ignition[1178]: no config dir at "/usr/lib/ignition/base.platform.d/azure" Mar 13 09:45:41.397783 ignition[1178]: parsed url from cmdline: "" Mar 13 09:45:41.397787 ignition[1178]: no config URL provided Mar 13 09:45:41.397794 ignition[1178]: reading system config file "/usr/lib/ignition/user.ign" Mar 13 09:45:41.397808 ignition[1178]: no config at "/usr/lib/ignition/user.ign" Mar 13 09:45:41.397812 ignition[1178]: failed to fetch config: resource requires networking Mar 13 09:45:41.398008 ignition[1178]: Ignition finished successfully Mar 13 09:45:41.441717 ignition[1187]: Ignition 2.24.0 Mar 13 09:45:41.441722 ignition[1187]: Stage: fetch Mar 13 09:45:41.441989 ignition[1187]: no configs at "/usr/lib/ignition/base.d" Mar 13 09:45:41.441997 ignition[1187]: no config dir at "/usr/lib/ignition/base.platform.d/azure" Mar 13 09:45:41.442112 ignition[1187]: parsed url from cmdline: "" Mar 13 09:45:41.442114 ignition[1187]: no config URL provided Mar 13 09:45:41.442118 ignition[1187]: reading system config file "/usr/lib/ignition/user.ign" Mar 13 09:45:41.442124 ignition[1187]: no config at "/usr/lib/ignition/user.ign" Mar 13 09:45:41.442139 ignition[1187]: GET http://169.254.169.254/metadata/instance/compute/userData?api-version=2021-01-01&format=text: attempt #1 Mar 13 09:45:41.555899 ignition[1187]: GET result: OK Mar 13 09:45:41.555981 ignition[1187]: config has been read from IMDS userdata Mar 13 09:45:41.555989 ignition[1187]: parsing config with SHA512: 38495a7bb49c60bfa8e3df5f85b925a02351bb77219ea6566dd7fdb7c1d13f978bdb98437d60e56254fd062275720851e583f23eccea1afba77cf549028329b4 Mar 13 09:45:41.560488 unknown[1187]: fetched base config from "system" Mar 13 09:45:41.560698 ignition[1187]: fetch: fetch complete Mar 13 09:45:41.570000 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 13 09:45:41.560494 unknown[1187]: fetched base config from "system" Mar 13 09:45:41.560702 ignition[1187]: fetch: fetch passed Mar 13 09:45:41.560497 unknown[1187]: fetched user config from "azure" Mar 13 09:45:41.560747 ignition[1187]: Ignition finished successfully Mar 13 09:45:41.564041 systemd[1]: Finished ignition-fetch.service - Ignition (fetch). Mar 13 09:45:41.572120 systemd[1]: Starting ignition-kargs.service - Ignition (kargs)... Mar 13 09:45:41.604289 ignition[1194]: Ignition 2.24.0 Mar 13 09:45:41.604301 ignition[1194]: Stage: kargs Mar 13 09:45:41.608415 systemd[1]: Finished ignition-kargs.service - Ignition (kargs). Mar 13 09:45:41.613000 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 13 09:45:41.604490 ignition[1194]: no configs at "/usr/lib/ignition/base.d" Mar 13 09:45:41.615180 systemd[1]: Starting ignition-disks.service - Ignition (disks)... Mar 13 09:45:41.604498 ignition[1194]: no config dir at "/usr/lib/ignition/base.platform.d/azure" Mar 13 09:45:41.604953 ignition[1194]: kargs: kargs passed Mar 13 09:45:41.604993 ignition[1194]: Ignition finished successfully Mar 13 09:45:41.641887 ignition[1200]: Ignition 2.24.0 Mar 13 09:45:41.641900 ignition[1200]: Stage: disks Mar 13 09:45:41.642199 ignition[1200]: no configs at "/usr/lib/ignition/base.d" Mar 13 09:45:41.642207 ignition[1200]: no config dir at "/usr/lib/ignition/base.platform.d/azure" Mar 13 09:45:41.642708 ignition[1200]: disks: createLuks: op(1): [started] waiting for devices [/dev/disk/by-partlabel/USR-B] Mar 13 09:45:41.648863 ignition[1200]: disks: createLuks: op(1): [finished] waiting for devices [/dev/disk/by-partlabel/USR-B] Mar 13 09:45:41.648949 ignition[1200]: disks: createLuks: created device alias for "/dev/disk/by-partlabel/USR-B": "/run/ignition/dev_aliases/dev/disk/by-partlabel/USR-B" -> "/dev/sda4" Mar 13 09:45:41.649118 ignition[1200]: disks: createLuks: op(2): [started] checking if /dev/disk/by-partlabel/USR-B is a luks2 device Mar 13 09:45:41.651004 ignition[1200]: disks: createLuks: op(2): executing: "cryptsetup" "isLuks" "/run/ignition/dev_aliases/dev/disk/by-partlabel/USR-B" "--type" "luks2" Mar 13 09:45:42.927483 ignition[1200]: disks: createLuks: op(2): [finished] checking if /dev/disk/by-partlabel/USR-B is a luks2 device Mar 13 09:45:42.927500 ignition[1200]: disks: createLuks: op(3): [started] checking if /dev/disk/by-partlabel/USR-B is a luks device Mar 13 09:45:42.927536 ignition[1200]: disks: createLuks: op(3): executing: "cryptsetup" "isLuks" "/run/ignition/dev_aliases/dev/disk/by-partlabel/USR-B" Mar 13 09:45:42.942407 ignition[1200]: disks: createLuks: op(3): [finished] checking if /dev/disk/by-partlabel/USR-B is a luks device Mar 13 09:45:42.942419 ignition[1200]: disks: createLuks: op(4): [started] determining volume type of "/dev/disk/by-partlabel/USR-B" Mar 13 09:45:42.969558 ignition[1200]: disks: createLuks: op(4): [finished] determining volume type of "/dev/disk/by-partlabel/USR-B" Mar 13 09:45:42.969573 ignition[1200]: disks: createLuks: found at "/dev/disk/by-partlabel/USR-B" with uuid "" and label "" Mar 13 09:45:42.969616 ignition[1200]: disks: createLuks: op(5): [started] creating "data" Mar 13 09:45:42.969627 ignition[1200]: disks: createLuks: op(5): executing: "cryptsetup" "luksFormat" "--type" "luks2" "--key-file" "/tmp/ignition-luks-4116894715" "/run/ignition/dev_aliases/dev/disk/by-partlabel/USR-B" Mar 13 09:45:50.229830 ignition[1200]: disks: createLuks: op(5): [finished] creating "data" Mar 13 09:45:50.229872 ignition[1200]: disks: createLuks: op(6): [started] opening luks device data Mar 13 09:45:50.229879 ignition[1200]: disks: createLuks: op(6): executing: "cryptsetup" "luksOpen" "/run/ignition/dev_aliases/dev/disk/by-partlabel/USR-B" "data" "--key-file" "/tmp/ignition-luks-4116894715" "--persistent" Mar 13 09:45:52.157082 kernel: Key type encrypted registered Mar 13 09:45:52.503981 ignition[1200]: disks: createLuks: op(6): [finished] opening luks device data Mar 13 09:45:52.504048 ignition[1200]: disks: createLuks: op(7): [started] waiting for triggered uevent Mar 13 09:45:52.504053 ignition[1200]: disks: createLuks: op(7): executing: "udevadm" "trigger" "--settle" "/dev/sda4" Mar 13 09:45:53.319019 ignition[1200]: disks: createLuks: op(7): [finished] waiting for triggered uevent Mar 13 09:45:53.319093 ignition[1200]: disks: createFilesystems: op(8): [started] waiting for devices [/dev/disk/by-id/dm-name-data] Mar 13 09:45:53.330338 ignition[1200]: disks: createFilesystems: op(8): [finished] waiting for devices [/dev/disk/by-id/dm-name-data] Mar 13 09:45:53.330421 ignition[1200]: disks: createFilesystems: created device alias for "/dev/disk/by-id/dm-name-data": "/run/ignition/dev_aliases/dev/disk/by-id/dm-name-data" -> "/dev/dm-1" Mar 13 09:45:53.330454 ignition[1200]: disks: createFilesystems: op(9): [started] determining filesystem type of "/dev/disk/by-id/dm-name-data" Mar 13 09:45:53.373157 ignition[1200]: disks: createFilesystems: op(9): [finished] determining filesystem type of "/dev/disk/by-id/dm-name-data" Mar 13 09:45:53.373171 ignition[1200]: disks: createFilesystems: found filesystem at "/dev/disk/by-id/dm-name-data" with uuid "" and label "" Mar 13 09:45:53.373393 ignition[1200]: disks: createFilesystems: op(a): [started] wiping filesystem signatures from "/run/ignition/dev_aliases/dev/disk/by-id/dm-name-data" Mar 13 09:45:53.373398 ignition[1200]: disks: createFilesystems: op(a): executing: "wipefs" "-a" "/run/ignition/dev_aliases/dev/disk/by-id/dm-name-data" Mar 13 09:45:53.439156 ignition[1200]: disks: createFilesystems: op(a): [finished] wiping filesystem signatures from "/run/ignition/dev_aliases/dev/disk/by-id/dm-name-data" Mar 13 09:45:53.439481 ignition[1200]: disks: createFilesystems: op(b): [started] creating "ext4" filesystem on "/run/ignition/dev_aliases/dev/disk/by-id/dm-name-data" Mar 13 09:45:53.439488 ignition[1200]: disks: createFilesystems: op(b): executing: "mkfs.ext4" "-F" "-L" "DATA" "/run/ignition/dev_aliases/dev/disk/by-id/dm-name-data" Mar 13 09:45:53.779602 ignition[1200]: disks: createFilesystems: op(b): [finished] creating "ext4" filesystem on "/run/ignition/dev_aliases/dev/disk/by-id/dm-name-data" Mar 13 09:45:53.779740 ignition[1200]: disks: createFilesystems: op(c): [started] waiting for triggered uevent Mar 13 09:45:53.779753 ignition[1200]: disks: createFilesystems: op(c): executing: "udevadm" "trigger" "--settle" "/dev/dm-1" Mar 13 09:45:53.811134 ignition[1200]: disks: createFilesystems: op(c): [finished] waiting for triggered uevent Mar 13 09:45:53.811147 ignition[1200]: disks: disks passed Mar 13 09:45:53.819000 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 13 09:45:53.815336 systemd[1]: Finished ignition-disks.service - Ignition (disks). Mar 13 09:45:53.851022 kernel: kauditd_printk_skb: 21 callbacks suppressed Mar 13 09:45:53.811243 ignition[1200]: Ignition finished successfully Mar 13 09:45:53.820985 systemd[1]: Reached target initrd-root-device.target - Initrd Root Device. Mar 13 09:45:53.866754 kernel: audit: type=1130 audit(1773395153.819:38): 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 13 09:45:53.828572 systemd[1]: Reached target local-fs-pre.target - Preparation for Local File Systems. Mar 13 09:45:53.850884 systemd[1]: Reached target local-fs.target - Local File Systems. Mar 13 09:45:53.855126 systemd[1]: Reached target sysinit.target - System Initialization. Mar 13 09:45:53.862492 systemd[1]: Reached target basic.target - Basic System. Mar 13 09:45:53.871332 systemd[1]: Starting systemd-fsck-root.service - File System Check on /dev/disk/by-label/ROOT... Mar 13 09:45:53.963156 systemd-fsck[1701]: ROOT: clean, 15/6361680 files, 408771/6359552 blocks Mar 13 09:45:53.972457 systemd[1]: Finished systemd-fsck-root.service - File System Check on /dev/disk/by-label/ROOT. Mar 13 09:45:53.977000 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 13 09:45:53.995235 systemd[1]: Mounting sysroot.mount - /sysroot... Mar 13 09:45:54.001785 kernel: audit: type=1130 audit(1773395153.977:39): 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 13 09:45:54.281099 kernel: EXT4-fs (sda9): mounted filesystem b1383ab3-e272-43af-9bb5-932a995cd3c8 r/w with ordered data mode. Quota mode: none. Mar 13 09:45:54.281826 systemd[1]: Mounted sysroot.mount - /sysroot. Mar 13 09:45:54.288743 systemd[1]: Reached target initrd-root-fs.target - Initrd Root File System. Mar 13 09:45:54.329371 systemd[1]: Mounting sysroot-oem.mount - /sysroot/oem... Mar 13 09:45:54.334198 systemd[1]: Mounting sysroot-usr.mount - /sysroot/usr... Mar 13 09:45:54.353823 systemd[1]: Starting flatcar-metadata-hostname.service - Flatcar Metadata Hostname Agent... Mar 13 09:45:54.364366 systemd[1]: ignition-remount-sysroot.service - Remount /sysroot read-write for Ignition was skipped because of an unmet condition check (ConditionPathIsReadWrite=!/sysroot). Mar 13 09:45:54.364410 systemd[1]: Reached target ignition-diskful.target - Ignition Boot Disk Setup. Mar 13 09:45:54.370604 systemd[1]: Mounted sysroot-usr.mount - /sysroot/usr. Mar 13 09:45:54.383781 systemd[1]: Starting initrd-setup-root.service - Root filesystem setup... Mar 13 09:45:54.410077 kernel: BTRFS: device label OEM devid 1 transid 11 /dev/sda6 (8:6) scanned by mount (1715) Mar 13 09:45:54.420266 kernel: BTRFS info (device sda6): first mount of filesystem c52d923a-8fae-4151-a91b-22d06ca3dd45 Mar 13 09:45:54.420315 kernel: BTRFS info (device sda6): using crc32c (crc32c-generic) checksum algorithm Mar 13 09:45:54.430768 kernel: BTRFS info (device sda6): turning on async discard Mar 13 09:45:54.430826 kernel: BTRFS info (device sda6): enabling free space tree Mar 13 09:45:54.433256 systemd[1]: Mounted sysroot-oem.mount - /sysroot/oem. Mar 13 09:45:54.897522 coreos-metadata[1717]: Mar 13 09:45:54.897 INFO Fetching http://168.63.129.16/?comp=versions: Attempt #1 Mar 13 09:45:54.906522 coreos-metadata[1717]: Mar 13 09:45:54.906 INFO Fetch successful Mar 13 09:45:54.910854 coreos-metadata[1717]: Mar 13 09:45:54.908 INFO Fetching http://169.254.169.254/metadata/instance/compute/name?api-version=2017-08-01&format=text: Attempt #1 Mar 13 09:45:54.919221 coreos-metadata[1717]: Mar 13 09:45:54.914 INFO Fetch successful Mar 13 09:45:54.923279 coreos-metadata[1717]: Mar 13 09:45:54.922 INFO wrote hostname ci-4636.0.101-71662ec14e to /sysroot/etc/hostname Mar 13 09:45:54.930250 systemd[1]: Finished flatcar-metadata-hostname.service - Flatcar Metadata Hostname Agent. Mar 13 09:45:54.939000 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 13 09:45:54.954087 kernel: audit: type=1130 audit(1773395154.939:40): pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=flatcar-metadata-hostname comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Mar 13 09:45:55.646084 kernel: loop1: detected capacity change from 0 to 43200 Mar 13 09:45:55.684090 kernel: loop1: p1 p2 p3 Mar 13 09:45:56.242655 kernel: erofs: (device loop1p1): mounted with root inode @ nid 40. Mar 13 09:45:56.253089 kernel: loop2: detected capacity change from 0 to 43200 Mar 13 09:45:56.256077 kernel: loop2: p1 p2 p3 Mar 13 09:45:56.276753 kernel: device-mapper: verity: sha256 using shash "sha256-ce" Mar 13 09:45:56.276821 kernel: device-mapper: verity: Unrecognized verity feature request: root_hash_sig_key_desc Mar 13 09:45:56.283939 kernel: device-mapper: table: 254:2: verity: Unrecognized verity feature request (-EINVAL) Mar 13 09:45:56.287357 kernel: device-mapper: ioctl: error adding target to table Mar 13 09:45:56.287436 (sd-merge)[1821]: device-mapper: reload ioctl on 753e65900bfd77efd5e24eb5b4c44cef15ce761892366f172831145108bec538-verity (254:2) failed: Invalid argument Mar 13 09:45:56.308190 kernel: device-mapper: verity: sha256 using shash "sha256-ce" Mar 13 09:45:56.557112 kernel: erofs: (device dm-2): mounted with root inode @ nid 40. Mar 13 09:45:56.557592 (sd-merge)[1821]: Using extensions '00-flatcar-default.raw'. Mar 13 09:45:56.559897 (sd-merge)[1821]: Merged extensions into '/sysroot/etc'. Mar 13 09:45:56.568535 initrd-setup-root[1828]: /etc 00-flatcar-default Fri 2026-03-13 09:45:36 UTC Mar 13 09:45:56.572288 systemd[1]: Finished initrd-setup-root.service - Root filesystem setup. Mar 13 09:45:56.576000 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 13 09:45:56.578840 systemd[1]: Starting ignition-mount.service - Ignition (mount)... Mar 13 09:45:56.598380 systemd[1]: Starting sysroot-boot.service - /sysroot/boot... Mar 13 09:45:56.610504 kernel: audit: type=1130 audit(1773395156.576:41): pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=initrd-setup-root comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Mar 13 09:45:56.618871 systemd[1]: sysroot-oem.mount: Deactivated successfully. Mar 13 09:45:56.625541 kernel: BTRFS info (device sda6): last unmount of filesystem c52d923a-8fae-4151-a91b-22d06ca3dd45 Mar 13 09:45:56.644408 ignition[1836]: INFO : Ignition 2.24.0 Mar 13 09:45:56.652241 ignition[1836]: INFO : Stage: mount Mar 13 09:45:56.652241 ignition[1836]: INFO : no configs at "/usr/lib/ignition/base.d" Mar 13 09:45:56.652241 ignition[1836]: INFO : no config dir at "/usr/lib/ignition/base.platform.d/azure" Mar 13 09:45:56.652241 ignition[1836]: INFO : mount: op(1): [started] mounting "/dev/disk/by-id/dm-name-data" at "/sysroot/var/lib/data" with type "ext4" and options "" Mar 13 09:45:56.652241 ignition[1836]: DEBUG : mount: op(1): executing: "mount" "-o" "" "-t" "ext4" "/dev/disk/by-id/dm-name-data" "/sysroot/var/lib/data" Mar 13 09:45:56.651000 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 13 09:45:56.646105 systemd[1]: Finished sysroot-boot.service - /sysroot/boot. Mar 13 09:45:56.696603 kernel: audit: type=1130 audit(1773395156.651:42): 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 13 09:45:56.745707 kernel: EXT4-fs (dm-1): mounted filesystem c506216e-121d-4afd-a884-1f0c3c00ecf3 r/w with ordered data mode. Quota mode: none. Mar 13 09:45:56.746184 ignition[1836]: INFO : mount: op(1): [finished] mounting "/dev/disk/by-id/dm-name-data" at "/sysroot/var/lib/data" with type "ext4" and options "" Mar 13 09:45:56.746184 ignition[1836]: INFO : mount: mount passed Mar 13 09:45:56.762156 ignition[1836]: INFO : Ignition finished successfully Mar 13 09:45:56.761000 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 13 09:45:56.758088 systemd[1]: Finished ignition-mount.service - Ignition (mount). Mar 13 09:45:56.784464 kernel: audit: type=1130 audit(1773395156.761:43): 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 13 09:45:56.764802 systemd[1]: Starting ignition-files.service - Ignition (files)... Mar 13 09:45:56.794440 systemd[1]: Mounting sysroot-oem.mount - /sysroot/oem... Mar 13 09:45:56.826618 kernel: BTRFS: device label OEM devid 1 transid 11 /dev/sda6 (8:6) scanned by mount (1853) Mar 13 09:45:56.826677 kernel: BTRFS info (device sda6): first mount of filesystem c52d923a-8fae-4151-a91b-22d06ca3dd45 Mar 13 09:45:56.832049 kernel: BTRFS info (device sda6): using crc32c (crc32c-generic) checksum algorithm Mar 13 09:45:56.842165 kernel: BTRFS info (device sda6): turning on async discard Mar 13 09:45:56.842196 kernel: BTRFS info (device sda6): enabling free space tree Mar 13 09:45:56.844240 systemd[1]: Mounted sysroot-oem.mount - /sysroot/oem. Mar 13 09:45:56.872209 ignition[1870]: INFO : Ignition 2.24.0 Mar 13 09:45:56.872209 ignition[1870]: INFO : Stage: files Mar 13 09:45:56.878656 ignition[1870]: INFO : no configs at "/usr/lib/ignition/base.d" Mar 13 09:45:56.878656 ignition[1870]: INFO : no config dir at "/usr/lib/ignition/base.platform.d/azure" Mar 13 09:45:56.878656 ignition[1870]: DEBUG : files: compiled without relabeling support, skipping Mar 13 09:45:56.878656 ignition[1870]: INFO : files: ensureUsers: op(1): [started] creating or modifying user "core" Mar 13 09:45:56.878656 ignition[1870]: DEBUG : files: ensureUsers: op(1): executing: "usermod" "--root" "/sysroot" "core" Mar 13 09:45:56.903836 ignition[1870]: INFO : files: ensureUsers: op(1): [finished] creating or modifying user "core" Mar 13 09:45:56.903836 ignition[1870]: INFO : files: ensureUsers: op(2): [started] adding ssh keys to user "core" Mar 13 09:45:56.903836 ignition[1870]: INFO : files: ensureUsers: op(2): [finished] adding ssh keys to user "core" Mar 13 09:45:56.903836 ignition[1870]: INFO : files: createFilesystemsFiles: createFiles: op(3): [started] writing file "/sysroot/etc/flatcar/update.conf" Mar 13 09:45:56.882675 unknown[1870]: wrote ssh authorized keys file for user: core Mar 13 09:45:56.931077 ignition[1870]: INFO : files: createFilesystemsFiles: createFiles: op(3): [finished] writing file "/sysroot/etc/flatcar/update.conf" Mar 13 09:45:56.931077 ignition[1870]: INFO : files: op(4): [started] processing unit "var-lib-data.mount" Mar 13 09:45:56.931077 ignition[1870]: INFO : files: op(4): op(5): [started] writing unit "var-lib-data.mount" at "/sysroot/etc/systemd/system/var-lib-data.mount" Mar 13 09:45:56.952566 ignition[1870]: INFO : files: op(4): op(5): [finished] writing unit "var-lib-data.mount" at "/sysroot/etc/systemd/system/var-lib-data.mount" Mar 13 09:45:56.952566 ignition[1870]: INFO : files: op(4): [finished] processing unit "var-lib-data.mount" Mar 13 09:45:56.952566 ignition[1870]: INFO : files: op(6): [started] setting preset to enabled for "var-lib-data.mount" Mar 13 09:45:56.971277 ignition[1870]: INFO : files: op(6): [finished] setting preset to enabled for "var-lib-data.mount" Mar 13 09:45:56.978097 ignition[1870]: INFO : files: createCrypttabEntries: createFiles: op(7): [started] writing file "/sysroot/etc/luks/data" Mar 13 09:45:56.985623 ignition[1870]: INFO : files: createCrypttabEntries: createFiles: op(7): [finished] writing file "/sysroot/etc/luks/data" Mar 13 09:45:56.985623 ignition[1870]: INFO : files: createCrypttabEntries: createFiles: op(8): [started] writing file "/sysroot/etc/crypttab" Mar 13 09:45:56.985623 ignition[1870]: INFO : files: createCrypttabEntries: createFiles: op(8): [finished] writing file "/sysroot/etc/crypttab" Mar 13 09:45:56.985623 ignition[1870]: INFO : files: createCrypttabEntries: createFiles: op(9): [started] appending to file "/sysroot/etc/crypttab" Mar 13 09:45:56.985623 ignition[1870]: INFO : files: createCrypttabEntries: createFiles: op(9): [finished] appending to file "/sysroot/etc/crypttab" Mar 13 09:45:56.985623 ignition[1870]: INFO : files: createResultFile: createFiles: op(a): [started] writing file "/sysroot/etc/.ignition-result.json" Mar 13 09:45:56.985623 ignition[1870]: INFO : files: createResultFile: createFiles: op(a): [finished] writing file "/sysroot/etc/.ignition-result.json" Mar 13 09:45:56.985623 ignition[1870]: INFO : files: files passed Mar 13 09:45:56.985623 ignition[1870]: INFO : Ignition finished successfully Mar 13 09:45:56.995000 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 13 09:45:57.075000 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 13 09:45:57.087236 kernel: audit: type=1130 audit(1773395156.995:44): 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 13 09:45:56.986265 systemd[1]: Finished ignition-files.service - Ignition (files). Mar 13 09:45:57.075000 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 13 09:45:57.103894 kernel: audit: type=1130 audit(1773395157.075:45): pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=ignition-quench comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Mar 13 09:45:56.997562 systemd[1]: Starting ignition-quench.service - Ignition (record completion)... Mar 13 09:45:57.109952 kernel: audit: type=1131 audit(1773395157.075:46): pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=ignition-quench comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Mar 13 09:45:57.026257 systemd[1]: Starting initrd-setup-root-after-ignition.service - Root filesystem completion... Mar 13 09:45:57.055789 systemd[1]: ignition-quench.service: Deactivated successfully. Mar 13 09:45:57.122585 initrd-setup-root-after-ignition[1906]: grep: /sysroot/etc/flatcar/enabled-sysext.conf: No such file or directory Mar 13 09:45:57.063411 systemd[1]: Finished ignition-quench.service - Ignition (record completion). Mar 13 09:45:57.140293 initrd-setup-root-after-ignition[1903]: grep: /sysroot/etc/flatcar/enabled-sysext.conf: No such file or directory Mar 13 09:45:57.140293 initrd-setup-root-after-ignition[1903]: grep: /sysroot/usr/share/flatcar/enabled-sysext.conf: No such file or directory Mar 13 09:45:57.159689 kernel: loop3: detected capacity change from 0 to 43200 Mar 13 09:45:57.159710 kernel: loop3: p1 p2 p3 Mar 13 09:45:57.159718 kernel: erofs: (device loop3p1): mounted with root inode @ nid 40. Mar 13 09:45:57.188085 kernel: loop4: detected capacity change from 0 to 43200 Mar 13 09:45:57.190135 kernel: loop4: p1 p2 p3 Mar 13 09:45:57.210480 kernel: device-mapper: verity: sha256 using shash "sha256-ce" Mar 13 09:45:57.210525 kernel: device-mapper: verity: Unrecognized verity feature request: root_hash_sig_key_desc Mar 13 09:45:57.215481 kernel: device-mapper: table: 254:3: verity: Unrecognized verity feature request (-EINVAL) Mar 13 09:45:57.218877 kernel: device-mapper: ioctl: error adding target to table Mar 13 09:45:57.219130 (sd-merge)[1911]: device-mapper: reload ioctl on loop4p1-verity (254:3) failed: Invalid argument Mar 13 09:45:57.231068 kernel: device-mapper: verity: sha256 using shash "sha256-ce" Mar 13 09:45:57.269774 (sd-merge)[1911]: Skipping extension refresh because no change was found, use --always-refresh=yes to always do a refresh. Mar 13 09:45:57.276809 kernel: erofs: (device dm-3): mounted with root inode @ nid 40. Mar 13 09:45:57.287210 kernel: device-mapper: ioctl: remove_all left 3 open device(s) Mar 13 09:45:57.343109 kernel: loop4: detected capacity change from 0 to 142456 Mar 13 09:45:57.362080 kernel: loop4: p1 p2 p3 Mar 13 09:45:57.846101 kernel: erofs: (device loop4p1): mounted with root inode @ nid 39. Mar 13 09:45:57.866094 kernel: loop5: detected capacity change from 0 to 355640 Mar 13 09:45:57.941097 kernel: loop5: p1 p2 p3 Mar 13 09:45:58.496082 kernel: erofs: (device loop5p1): mounted with root inode @ nid 39. Mar 13 09:45:58.547148 kernel: loop6: detected capacity change from 0 to 166960 Mar 13 09:45:58.590086 kernel: loop6: p1 p2 p3 Mar 13 09:45:59.095083 kernel: erofs: (device loop6p1): mounted with root inode @ nid 39. Mar 13 09:45:59.131623 kernel: loop7: detected capacity change from 0 to 142456 Mar 13 09:45:59.131693 kernel: loop7: p1 p2 p3 Mar 13 09:45:59.153321 kernel: device-mapper: verity: sha256 using shash "sha256-ce" Mar 13 09:45:59.153386 kernel: device-mapper: verity: Unrecognized verity feature request: root_hash_sig_key_desc Mar 13 09:45:59.158364 kernel: device-mapper: table: 254:3: verity: Unrecognized verity feature request (-EINVAL) Mar 13 09:45:59.161595 kernel: device-mapper: ioctl: error adding target to table Mar 13 09:45:59.161835 (sd-merge)[1924]: device-mapper: reload ioctl on 87ad59fee720dad120b57946ee8c27c90046857da35b0e1b4c0c41468adbc450-verity (254:3) failed: Invalid argument Mar 13 09:45:59.174407 kernel: device-mapper: verity: sha256 using shash "sha256-ce" Mar 13 09:45:59.275084 kernel: erofs: (device dm-3): mounted with root inode @ nid 39. Mar 13 09:45:59.279079 kernel: loop1: detected capacity change from 0 to 355640 Mar 13 09:45:59.283086 kernel: loop1: p1 p2 p3 Mar 13 09:45:59.287076 kernel: loop1: p1 p2 p3 Mar 13 09:45:59.310082 kernel: device-mapper: verity: sha256 using shash "sha256-ce" Mar 13 09:45:59.310137 kernel: device-mapper: verity: Unrecognized verity feature request: root_hash_sig_key_desc Mar 13 09:45:59.316070 kernel: device-mapper: table: 254:4: verity: Unrecognized verity feature request (-EINVAL) Mar 13 09:45:59.321086 kernel: device-mapper: ioctl: error adding target to table Mar 13 09:45:59.321115 (sd-merge)[1924]: device-mapper: reload ioctl on 0d08f6868ccb81c29857cf38eebb6e0c821013d0d16d6ed9efd0a04095f33e4a-verity (254:4) failed: Invalid argument Mar 13 09:45:59.335072 kernel: device-mapper: verity: sha256 using shash "sha256-ce" Mar 13 09:45:59.483136 kernel: erofs: (device dm-4): mounted with root inode @ nid 39. Mar 13 09:45:59.489721 kernel: loop3: detected capacity change from 0 to 166960 Mar 13 09:45:59.489776 kernel: loop3: p1 p2 p3 Mar 13 09:45:59.493090 kernel: loop3: p1 p2 p3 Mar 13 09:45:59.530445 kernel: device-mapper: verity: sha256 using shash "sha256-ce" Mar 13 09:45:59.530496 kernel: device-mapper: verity: Unrecognized verity feature request: root_hash_sig_key_desc Mar 13 09:45:59.539090 kernel: device-mapper: table: 254:5: verity: Unrecognized verity feature request (-EINVAL) Mar 13 09:45:59.543570 kernel: device-mapper: ioctl: error adding target to table Mar 13 09:45:59.543662 (sd-merge)[1924]: device-mapper: reload ioctl on dfe1ff08d6150bb647bc93addb89889cbc88e3151da4bbe62e3e2be8baf7cc45-verity (254:5) failed: Invalid argument Mar 13 09:45:59.560159 kernel: device-mapper: verity: sha256 using shash "sha256-ce" Mar 13 09:45:59.668080 kernel: erofs: (device dm-5): mounted with root inode @ nid 39. Mar 13 09:45:59.668835 (sd-merge)[1924]: Using extensions 'containerd-flatcar.raw', 'docker-flatcar.raw', 'oem-azure-4636.0.101+linux-6.12.76-main.raw'. Mar 13 09:45:59.669690 (sd-merge)[1924]: Merged extensions into '/sysroot/usr'. Mar 13 09:45:59.678528 systemd[1]: Finished initrd-setup-root-after-ignition.service - Root filesystem completion. Mar 13 09:45:59.689000 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 13 09:45:59.690565 systemd[1]: Reached target ignition-complete.target - Ignition Complete. Mar 13 09:45:59.707704 systemd[1]: Starting initrd-parse-etc.service - Mountpoints Configured in the Real Root... Mar 13 09:45:59.723032 kernel: audit: type=1130 audit(1773395159.689:47): 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 13 09:45:59.731931 systemd[1]: initrd-parse-etc.service: Deactivated successfully. Mar 13 09:45:59.732090 systemd[1]: Finished initrd-parse-etc.service - Mountpoints Configured in the Real Root. Mar 13 09:45:59.741206 systemd[1]: initrd-parse-etc.service: Triggering OnSuccess= dependencies. Mar 13 09:45:59.740000 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 13 09:45:59.741454 systemd[1]: Reached target initrd-fs.target - Initrd File Systems. Mar 13 09:45:59.740000 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 13 09:45:59.788531 kernel: audit: type=1130 audit(1773395159.740:48): pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=initrd-parse-etc comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Mar 13 09:45:59.762335 systemd[1]: Reached target initrd.target - Initrd Default Target. Mar 13 09:45:59.797333 kernel: audit: type=1131 audit(1773395159.740:49): pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=initrd-parse-etc comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Mar 13 09:45:59.781984 systemd[1]: dracut-mount.service - dracut mount hook was skipped because no trigger condition checks were met. Mar 13 09:45:59.782847 systemd[1]: Starting dracut-pre-pivot.service - dracut pre-pivot and cleanup hook... Mar 13 09:45:59.821821 systemd[1]: Finished dracut-pre-pivot.service - dracut pre-pivot and cleanup hook. Mar 13 09:45:59.826000 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 13 09:45:59.845110 kernel: audit: type=1130 audit(1773395159.826:50): pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=dracut-pre-pivot comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Mar 13 09:45:59.845205 systemd[1]: Starting initrd-cleanup.service - Cleaning Up and Shutting Down Daemons... Mar 13 09:45:59.866818 systemd[1]: Stopped target nss-lookup.target - Host and Network Name Lookups. Mar 13 09:45:59.871881 systemd[1]: Stopped target remote-cryptsetup.target - Remote Encrypted Volumes. Mar 13 09:45:59.881068 systemd[1]: Stopped target timers.target - Timer Units. Mar 13 09:45:59.889528 systemd[1]: dracut-pre-pivot.service: Deactivated successfully. Mar 13 09:45:59.897000 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 13 09:45:59.889645 systemd[1]: Stopped dracut-pre-pivot.service - dracut pre-pivot and cleanup hook. Mar 13 09:45:59.898324 systemd[1]: Stopped target initrd.target - Initrd Default Target. Mar 13 09:45:59.919249 systemd[1]: Stopped target basic.target - Basic System. Mar 13 09:45:59.940913 kernel: audit: type=1131 audit(1773395159.897:51): 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 13 09:45:59.927903 systemd[1]: Stopped target ignition-complete.target - Ignition Complete. Mar 13 09:45:59.937359 systemd[1]: Stopped target ignition-diskful.target - Ignition Boot Disk Setup. Mar 13 09:45:59.946016 systemd[1]: Stopped target initrd-root-device.target - Initrd Root Device. Mar 13 09:45:59.955192 systemd[1]: Stopped target initrd-usr-fs.target - Initrd /usr File System. Mar 13 09:45:59.964526 systemd[1]: Stopped target remote-fs.target - Remote File Systems. Mar 13 09:45:59.973227 systemd[1]: Stopped target remote-fs-pre.target - Preparation for Remote File Systems. Mar 13 09:45:59.982861 systemd[1]: Stopped target sysinit.target - System Initialization. Mar 13 09:45:59.991079 systemd[1]: Stopped target local-fs.target - Local File Systems. Mar 13 09:46:00.000308 systemd[1]: Stopped target swap.target - Swaps. Mar 13 09:46:00.015000 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 13 09:46:00.007655 systemd[1]: dracut-pre-mount.service: Deactivated successfully. Mar 13 09:46:00.007765 systemd[1]: Stopped dracut-pre-mount.service - dracut pre-mount hook. Mar 13 09:46:00.031028 systemd[1]: Stopped target cryptsetup.target - Local Encrypted Volumes. Mar 13 09:46:00.052996 kernel: audit: type=1131 audit(1773395160.015:52): pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=dracut-pre-mount comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Mar 13 09:46:00.039366 systemd[1]: Stopped target cryptsetup-pre.target - Local Encrypted Volumes (Pre). Mar 13 09:46:00.048807 systemd[1]: clevis-luks-askpass.path: Deactivated successfully. Mar 13 09:46:00.067000 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 13 09:46:00.049214 systemd[1]: Stopped clevis-luks-askpass.path - Forward Password Requests to Clevis Directory Watch. Mar 13 09:46:00.088000 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 13 09:46:00.107047 kernel: audit: type=1131 audit(1773395160.067:53): pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=dracut-initqueue comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Mar 13 09:46:00.058869 systemd[1]: dracut-initqueue.service: Deactivated successfully. Mar 13 09:46:00.110000 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 13 09:46:00.126114 kernel: audit: type=1131 audit(1773395160.088:54): pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=initrd-setup-root-after-ignition comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Mar 13 09:46:00.059007 systemd[1]: Stopped dracut-initqueue.service - dracut initqueue hook. Mar 13 09:46:00.130000 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 13 09:46:00.147771 kernel: audit: type=1131 audit(1773395160.110:55): 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 13 09:46:00.068241 systemd[1]: initrd-setup-root-after-ignition.service: Deactivated successfully. Mar 13 09:46:00.153527 kernel: audit: type=1131 audit(1773395160.130:56): 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 13 09:46:00.068346 systemd[1]: Stopped initrd-setup-root-after-ignition.service - Root filesystem completion. Mar 13 09:46:00.089653 systemd[1]: ignition-files.service: Deactivated successfully. Mar 13 09:46:00.089739 systemd[1]: Stopped ignition-files.service - Ignition (files). Mar 13 09:46:00.111197 systemd[1]: flatcar-metadata-hostname.service: Deactivated successfully. Mar 13 09:46:00.111286 systemd[1]: Stopped flatcar-metadata-hostname.service - Flatcar Metadata Hostname Agent. Mar 13 09:46:00.154264 systemd[1]: Stopping ignition-mount.service - Ignition (mount)... Mar 13 09:46:00.200111 ignition[1960]: INFO : Ignition 2.24.0 Mar 13 09:46:00.200111 ignition[1960]: INFO : Stage: umount Mar 13 09:46:00.200111 ignition[1960]: INFO : no configs at "/usr/lib/ignition/base.d" Mar 13 09:46:00.200111 ignition[1960]: INFO : no config dir at "/usr/lib/ignition/base.platform.d/azure" Mar 13 09:46:00.200111 ignition[1960]: INFO : umount: op(1): [started] umounting "/sysroot/var/lib/data" Mar 13 09:46:00.205000 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 13 09:46:00.217000 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 13 09:46:00.227000 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 13 09:46:00.238000 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 13 09:46:00.178275 systemd[1]: Stopping sysroot-boot.service - /sysroot/boot... Mar 13 09:46:00.250000 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 13 09:46:00.250000 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 13 09:46:00.255013 kernel: EXT4-fs (dm-1): unmounting filesystem c506216e-121d-4afd-a884-1f0c3c00ecf3. Mar 13 09:46:00.255033 ignition[1960]: INFO : umount: op(1): [finished] umounting "/sysroot/var/lib/data" Mar 13 09:46:00.255033 ignition[1960]: INFO : umount: umount passed Mar 13 09:46:00.255033 ignition[1960]: INFO : Ignition finished successfully Mar 13 09:46:00.258000 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 13 09:46:00.262000 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 13 09:46:00.271000 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 13 09:46:00.283000 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 13 09:46:00.194132 systemd[1]: systemd-tmpfiles-setup.service: Deactivated successfully. Mar 13 09:46:00.194291 systemd[1]: Stopped systemd-tmpfiles-setup.service - Create System Files and Directories. Mar 13 09:46:00.206490 systemd[1]: systemd-udev-trigger.service: Deactivated successfully. Mar 13 09:46:00.206584 systemd[1]: Stopped systemd-udev-trigger.service - Coldplug All udev Devices. Mar 13 09:46:00.218356 systemd[1]: dracut-pre-trigger.service: Deactivated successfully. Mar 13 09:46:00.218452 systemd[1]: Stopped dracut-pre-trigger.service - dracut pre-trigger hook. Mar 13 09:46:00.231319 systemd[1]: sysroot-var-lib-data.mount: Deactivated successfully. Mar 13 09:46:00.348000 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 13 09:46:00.232257 systemd[1]: ignition-mount.service: Deactivated successfully. Mar 13 09:46:00.357000 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 13 09:46:00.234117 systemd[1]: Stopped ignition-mount.service - Ignition (mount). Mar 13 09:46:00.242371 systemd[1]: initrd-cleanup.service: Deactivated successfully. Mar 13 09:46:00.244082 systemd[1]: Finished initrd-cleanup.service - Cleaning Up and Shutting Down Daemons. Mar 13 09:46:00.385000 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 13 09:46:00.251716 systemd[1]: ignition-disks.service: Deactivated successfully. Mar 13 09:46:00.251787 systemd[1]: Stopped ignition-disks.service - Ignition (disks). Mar 13 09:46:00.399000 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 13 09:46:00.259241 systemd[1]: ignition-disks.service: Consumed 15.937s CPU time. Mar 13 09:46:00.259292 systemd[1]: ignition-kargs.service: Deactivated successfully. Mar 13 09:46:00.411000 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 13 09:46:00.415000 audit: BPF prog-id=8 op=UNLOAD Mar 13 09:46:00.415000 audit: BPF prog-id=5 op=UNLOAD Mar 13 09:46:00.259334 systemd[1]: Stopped ignition-kargs.service - Ignition (kargs). Mar 13 09:46:00.263530 systemd[1]: ignition-fetch.service: Deactivated successfully. Mar 13 09:46:00.263557 systemd[1]: Stopped ignition-fetch.service - Ignition (fetch). Mar 13 09:46:00.439000 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 13 09:46:00.272496 systemd[1]: Stopped target network.target - Network. Mar 13 09:46:00.279564 systemd[1]: ignition-fetch-offline.service: Deactivated successfully. Mar 13 09:46:00.459000 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 13 09:46:00.279633 systemd[1]: Stopped ignition-fetch-offline.service - Ignition (fetch-offline). Mar 13 09:46:00.468000 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 13 09:46:00.473000 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 13 09:46:00.284597 systemd[1]: Stopped target paths.target - Path Units. Mar 13 09:46:00.291647 systemd[1]: systemd-ask-password-console.path: Deactivated successfully. Mar 13 09:46:00.291988 systemd[1]: Stopped systemd-ask-password-console.path - Dispatch Password Requests to Console Directory Watch. Mar 13 09:46:00.301236 systemd[1]: Stopped target slices.target - Slice Units. Mar 13 09:46:00.305424 systemd[1]: Stopped target sockets.target - Socket Units. Mar 13 09:46:00.315341 systemd[1]: iscsid.socket: Deactivated successfully. Mar 13 09:46:00.315446 systemd[1]: Closed iscsid.socket - Open-iSCSI iscsid Socket. Mar 13 09:46:00.324069 systemd[1]: iscsiuio.socket: Deactivated successfully. Mar 13 09:46:00.324137 systemd[1]: Closed iscsiuio.socket - Open-iSCSI iscsiuio Socket. Mar 13 09:46:00.332729 systemd[1]: systemd-journald-audit.socket: Deactivated successfully. Mar 13 09:46:00.532000 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 13 09:46:00.332773 systemd[1]: Closed systemd-journald-audit.socket - Journal Audit Socket. Mar 13 09:46:00.341499 systemd[1]: ignition-setup.service: Deactivated successfully. Mar 13 09:46:00.549000 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 13 09:46:00.341550 systemd[1]: Stopped ignition-setup.service - Ignition (setup). Mar 13 09:46:00.557000 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 13 09:46:00.349717 systemd[1]: ignition-setup-pre.service: Deactivated successfully. Mar 13 09:46:00.573000 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 13 09:46:00.349749 systemd[1]: Stopped ignition-setup-pre.service - Ignition env setup. Mar 13 09:46:00.358289 systemd[1]: Stopping systemd-networkd.service - Network Configuration... Mar 13 09:46:00.589955 kernel: hv_netvsc 002248c2-0bfc-0022-48c2-0bfc002248c2 eth0: Data path switched from VF: enP48861s1 Mar 13 09:46:00.365998 systemd[1]: Stopping systemd-resolved.service - Network Name Resolution... Mar 13 09:46:00.378309 systemd[1]: sysroot-boot.mount: Deactivated successfully. Mar 13 09:46:00.378850 systemd[1]: systemd-resolved.service: Deactivated successfully. Mar 13 09:46:00.607000 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 13 09:46:00.378962 systemd[1]: Stopped systemd-resolved.service - Network Name Resolution. Mar 13 09:46:00.621000 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 13 09:46:00.392955 systemd[1]: systemd-networkd.service: Deactivated successfully. Mar 13 09:46:00.635000 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 13 09:46:00.393070 systemd[1]: Stopped systemd-networkd.service - Network Configuration. Mar 13 09:46:00.644000 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 13 09:46:00.406847 systemd[1]: sysroot-boot.service: Deactivated successfully. Mar 13 09:46:00.653000 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 13 09:46:00.408356 systemd[1]: Stopped sysroot-boot.service - /sysroot/boot. Mar 13 09:46:00.662000 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 13 09:46:00.414106 systemd[1]: Stopped target network-pre.target - Preparation for Network. Mar 13 09:46:00.672000 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 13 09:46:00.672000 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 13 09:46:00.421780 systemd[1]: systemd-networkd.socket: Deactivated successfully. Mar 13 09:46:00.421876 systemd[1]: Closed systemd-networkd.socket - Network Service Netlink Socket. Mar 13 09:46:00.430023 systemd[1]: initrd-setup-root.service: Deactivated successfully. Mar 13 09:46:00.433471 systemd[1]: Stopped initrd-setup-root.service - Root filesystem setup. Mar 13 09:46:00.444218 systemd[1]: Stopping network-cleanup.service - Network Cleanup... Mar 13 09:46:00.451427 systemd[1]: parse-ip-for-networkd.service: Deactivated successfully. Mar 13 09:46:00.451481 systemd[1]: Stopped parse-ip-for-networkd.service - Write systemd-networkd units from cmdline. Mar 13 09:46:00.460017 systemd[1]: systemd-sysctl.service: Deactivated successfully. Mar 13 09:46:00.460053 systemd[1]: Stopped systemd-sysctl.service - Apply Kernel Variables. Mar 13 09:46:00.469319 systemd[1]: systemd-modules-load.service: Deactivated successfully. Mar 13 09:46:00.469360 systemd[1]: Stopped systemd-modules-load.service - Load Kernel Modules. Mar 13 09:46:00.474325 systemd[1]: Stopping systemd-udevd.service - Rule-based Manager for Device Events and Files... Mar 13 09:46:00.517120 systemd[1]: systemd-udevd.service: Deactivated successfully. Mar 13 09:46:00.522306 systemd[1]: Stopped systemd-udevd.service - Rule-based Manager for Device Events and Files. Mar 13 09:46:00.533478 systemd[1]: systemd-udevd.service: Consumed 1.176s CPU time. Mar 13 09:46:00.533832 systemd[1]: systemd-udevd-control.socket: Deactivated successfully. Mar 13 09:46:00.762153 systemd-journald[501]: Received SIGTERM from PID 1 (systemd). Mar 13 09:46:00.533882 systemd[1]: Closed systemd-udevd-control.socket - udev Control Socket. Mar 13 09:46:00.541953 systemd[1]: dracut-pre-udev.service: Deactivated successfully. Mar 13 09:46:00.541994 systemd[1]: Stopped dracut-pre-udev.service - dracut pre-udev hook. Mar 13 09:46:00.550691 systemd[1]: dracut-cmdline.service: Deactivated successfully. Mar 13 09:46:00.550731 systemd[1]: Stopped dracut-cmdline.service - dracut cmdline hook. Mar 13 09:46:00.558583 systemd[1]: dracut-cmdline-ask.service: Deactivated successfully. Mar 13 09:46:00.558618 systemd[1]: Stopped dracut-cmdline-ask.service - dracut ask for additional cmdline parameters. Mar 13 09:46:00.583243 systemd[1]: Starting initrd-udevadm-cleanup-db.service - Cleanup udev Database... Mar 13 09:46:00.599318 systemd[1]: systemd-network-generator.service: Deactivated successfully. Mar 13 09:46:00.599402 systemd[1]: Stopped systemd-network-generator.service - Generate Network Units from Kernel Command Line. Mar 13 09:46:00.608468 systemd[1]: systemd-tmpfiles-setup-dev.service: Deactivated successfully. Mar 13 09:46:00.608523 systemd[1]: Stopped systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev. Mar 13 09:46:00.622627 systemd[1]: systemd-tmpfiles-setup-dev-early.service: Deactivated successfully. Mar 13 09:46:00.622679 systemd[1]: Stopped systemd-tmpfiles-setup-dev-early.service - Create Static Device Nodes in /dev gracefully. Mar 13 09:46:00.635859 systemd[1]: kmod-static-nodes.service: Deactivated successfully. Mar 13 09:46:00.635916 systemd[1]: Stopped kmod-static-nodes.service - Create List of Static Device Nodes. Mar 13 09:46:00.645730 systemd[1]: systemd-vconsole-setup.service: Deactivated successfully. Mar 13 09:46:00.645788 systemd[1]: Stopped systemd-vconsole-setup.service - Virtual Console Setup. Mar 13 09:46:00.655170 systemd[1]: network-cleanup.service: Deactivated successfully. Mar 13 09:46:00.655270 systemd[1]: Stopped network-cleanup.service - Network Cleanup. Mar 13 09:46:00.663273 systemd[1]: initrd-udevadm-cleanup-db.service: Deactivated successfully. Mar 13 09:46:00.663376 systemd[1]: Finished initrd-udevadm-cleanup-db.service - Cleanup udev Database. Mar 13 09:46:00.673704 systemd[1]: Reached target initrd-switch-root.target - Switch Root. Mar 13 09:46:00.680217 systemd[1]: Starting initrd-switch-root.service - Switch Root... Mar 13 09:46:00.703164 systemd[1]: Switching root. Mar 13 09:46:00.872038 systemd-journald[501]: Journal stopped Mar 13 09:46:07.159430 kernel: SELinux: policy capability network_peer_controls=1 Mar 13 09:46:07.159469 kernel: SELinux: policy capability open_perms=1 Mar 13 09:46:07.159479 kernel: SELinux: policy capability extended_socket_class=1 Mar 13 09:46:07.159490 kernel: SELinux: policy capability always_check_network=0 Mar 13 09:46:07.159499 kernel: SELinux: policy capability cgroup_seclabel=1 Mar 13 09:46:07.159507 kernel: SELinux: policy capability nnp_nosuid_transition=1 Mar 13 09:46:07.159517 kernel: SELinux: policy capability genfs_seclabel_symlinks=0 Mar 13 09:46:07.159523 kernel: SELinux: policy capability ioctl_skip_cloexec=0 Mar 13 09:46:07.159529 kernel: SELinux: policy capability userspace_initial_context=0 Mar 13 09:46:07.159539 systemd[1]: Successfully loaded SELinux policy in 388.487ms. Mar 13 09:46:07.159551 systemd[1]: Relabeled /dev/, /dev/shm/, /run/ in 6.125ms. Mar 13 09:46:07.159560 systemd[1]: systemd 258.2 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 13 09:46:07.159568 systemd[1]: Detected virtualization microsoft. Mar 13 09:46:07.159576 systemd[1]: Detected architecture arm64. Mar 13 09:46:07.159583 systemd[1]: Detected first boot. Mar 13 09:46:07.159592 systemd[1]: Initializing machine ID from random generator. Mar 13 09:46:07.159601 systemd[1]: Hostname set to . Mar 13 09:46:07.159610 zram_generator::config[2006]: No configuration found. Mar 13 09:46:07.159617 kernel: NET: Registered PF_VSOCK protocol family Mar 13 09:46:07.159624 systemd[1]: Applying preset policy. Mar 13 09:46:07.159633 systemd[1]: Created symlink '/etc/systemd/system/local-fs.target.requires/var-lib-data.mount' → '/etc/systemd/system/var-lib-data.mount'. Mar 13 09:46:07.159641 systemd[1]: Populated /etc with preset unit settings. Mar 13 09:46:07.159648 systemd[1]: /usr/lib/systemd/system/update-engine.service:10: Support for option BlockIOWeight= has been removed and it is ignored Mar 13 09:46:07.159655 kernel: kauditd_printk_skb: 37 callbacks suppressed Mar 13 09:46:07.159663 kernel: audit: type=1334 audit(1773395166.116:94): prog-id=10 op=LOAD Mar 13 09:46:07.159672 kernel: audit: type=1334 audit(1773395166.117:95): prog-id=2 op=UNLOAD Mar 13 09:46:07.159679 kernel: audit: type=1334 audit(1773395166.119:96): prog-id=11 op=LOAD Mar 13 09:46:07.159686 kernel: audit: type=1334 audit(1773395166.124:97): prog-id=12 op=LOAD Mar 13 09:46:07.159694 kernel: audit: type=1334 audit(1773395166.124:98): prog-id=3 op=UNLOAD Mar 13 09:46:07.159700 kernel: audit: type=1334 audit(1773395166.124:99): prog-id=4 op=UNLOAD Mar 13 09:46:07.159708 systemd[1]: initrd-switch-root.service: Deactivated successfully. Mar 13 09:46:07.159718 kernel: audit: type=1334 audit(1773395166.128:100): prog-id=13 op=LOAD Mar 13 09:46:07.159727 kernel: audit: type=1334 audit(1773395166.128:101): prog-id=10 op=UNLOAD Mar 13 09:46:07.159736 kernel: audit: type=1334 audit(1773395166.132:102): prog-id=14 op=LOAD Mar 13 09:46:07.159745 kernel: audit: type=1334 audit(1773395166.136:103): prog-id=15 op=LOAD Mar 13 09:46:07.159754 systemd[1]: Stopped initrd-switch-root.service - Switch Root. Mar 13 09:46:07.159762 systemd[1]: systemd-journald.service: Scheduled restart job, restart counter is at 1. Mar 13 09:46:07.159773 systemd[1]: Created slice system-addon\x2dconfig.slice - Slice /system/addon-config. Mar 13 09:46:07.159782 systemd[1]: Created slice system-addon\x2drun.slice - Slice /system/addon-run. Mar 13 09:46:07.159793 systemd[1]: Created slice system-getty.slice - Slice /system/getty. Mar 13 09:46:07.159804 systemd[1]: Created slice system-modprobe.slice - Slice /system/modprobe. Mar 13 09:46:07.159816 systemd[1]: Created slice system-serial\x2dgetty.slice - Slice /system/serial-getty. Mar 13 09:46:07.159825 systemd[1]: Created slice system-system\x2dcloudinit.slice - Slice /system/system-cloudinit. Mar 13 09:46:07.159835 systemd[1]: Created slice system-systemd\x2dcryptsetup.slice - Encrypted Volume Units Service Slice. Mar 13 09:46:07.159842 systemd[1]: Created slice system-systemd\x2dfsck.slice - Slice /system/systemd-fsck. Mar 13 09:46:07.159894 systemd[1]: Created slice user.slice - User and Session Slice. Mar 13 09:46:07.159903 systemd[1]: Started clevis-luks-askpass.path - Forward Password Requests to Clevis Directory Watch. Mar 13 09:46:07.159913 systemd[1]: Started systemd-ask-password-console.path - Dispatch Password Requests to Console Directory Watch. Mar 13 09:46:07.159922 systemd[1]: Started systemd-ask-password-wall.path - Forward Password Requests to Wall Directory Watch. Mar 13 09:46:07.159932 systemd[1]: Set up automount boot.automount - Boot partition Automount Point. Mar 13 09:46:07.159943 systemd[1]: Set up automount proc-sys-fs-binfmt_misc.automount - Arbitrary Executable File Formats File System Automount Point. Mar 13 09:46:07.159950 systemd[1]: Expecting device dev-disk-by\x2dlabel-OEM.device - /dev/disk/by-label/OEM... Mar 13 09:46:07.159957 systemd[1]: Expecting device dev-disk-by\x2duuid-2367dbdc\x2d5adb\x2d4394\x2db330\x2d7e87f0011b27.device - /dev/disk/by-uuid/2367dbdc-5adb-4394-b330-7e87f0011b27... Mar 13 09:46:07.159964 systemd[1]: Expecting device dev-ptp_hyperv.device - /dev/ptp_hyperv... Mar 13 09:46:07.159972 systemd[1]: Expecting device dev-ttyAMA0.device - /dev/ttyAMA0... Mar 13 09:46:07.159978 systemd[1]: Reached target cryptsetup-pre.target - Local Encrypted Volumes (Pre). Mar 13 09:46:07.159984 systemd[1]: Reached target imports.target - Image Downloads. Mar 13 09:46:07.159991 systemd[1]: Stopped target initrd-switch-root.target - Switch Root. Mar 13 09:46:07.159997 systemd[1]: Stopped target initrd-fs.target - Initrd File Systems. Mar 13 09:46:07.160004 systemd[1]: Stopped target initrd-root-fs.target - Initrd Root File System. Mar 13 09:46:07.160011 systemd[1]: Reached target integritysetup.target - Local Integrity Protected Volumes. Mar 13 09:46:07.160019 systemd[1]: Reached target remote-cryptsetup.target - Remote Encrypted Volumes. Mar 13 09:46:07.160026 systemd[1]: Reached target remote-fs.target - Remote File Systems. Mar 13 09:46:07.160034 systemd[1]: Reached target remote-integritysetup.target - Remote Integrity Protected Volumes. Mar 13 09:46:07.160041 systemd[1]: Reached target remote-veritysetup.target - Remote Verity Protected Volumes. Mar 13 09:46:07.160049 systemd[1]: Reached target slices.target - Slice Units. Mar 13 09:46:07.165722 systemd[1]: Reached target swap.target - Swaps. Mar 13 09:46:07.165754 systemd[1]: Reached target veritysetup.target - Local Verity Protected Volumes. Mar 13 09:46:07.165763 systemd[1]: Listening on systemd-ask-password.socket - Query the User Interactively for a Password. Mar 13 09:46:07.165776 systemd[1]: Listening on systemd-coredump.socket - Process Core Dump Socket. Mar 13 09:46:07.165783 systemd[1]: Listening on systemd-creds.socket - Credential Encryption/Decryption. Mar 13 09:46:07.165790 systemd[1]: Listening on systemd-factory-reset.socket - Factory Reset Management. Mar 13 09:46:07.165799 systemd[1]: Listening on systemd-journald-audit.socket - Journal Audit Socket. Mar 13 09:46:07.165806 systemd[1]: Listening on systemd-mountfsd.socket - DDI File System Mounter Socket. Mar 13 09:46:07.165813 systemd[1]: Listening on systemd-networkd-varlink.socket - Network Service Varlink Socket. Mar 13 09:46:07.165820 systemd[1]: Listening on systemd-networkd.socket - Network Service Netlink Socket. Mar 13 09:46:07.165827 systemd[1]: Listening on systemd-nsresourced.socket - Namespace Resource Manager Socket. Mar 13 09:46:07.165834 systemd[1]: Listening on systemd-oomd.socket - Userspace Out-Of-Memory (OOM) Killer Socket. Mar 13 09:46:07.165841 systemd[1]: Listening on systemd-resolved-monitor.socket - Resolve Monitor Varlink Socket. Mar 13 09:46:07.165849 systemd[1]: Listening on systemd-resolved-varlink.socket - Resolve Service Varlink Socket. Mar 13 09:46:07.165856 systemd[1]: Listening on systemd-udevd-control.socket - udev Control Socket. Mar 13 09:46:07.165863 systemd[1]: Listening on systemd-udevd-varlink.socket - udev Varlink Socket. Mar 13 09:46:07.165871 systemd[1]: Listening on systemd-userdbd.socket - User Database Manager Socket. Mar 13 09:46:07.165879 systemd[1]: Mounting dev-hugepages.mount - Huge Pages File System... Mar 13 09:46:07.165886 systemd[1]: Mounting dev-mqueue.mount - POSIX Message Queue File System... Mar 13 09:46:07.165892 systemd[1]: Mounting media.mount - External Media Directory... Mar 13 09:46:07.165899 systemd[1]: Mounting sys-kernel-debug.mount - Kernel Debug File System... Mar 13 09:46:07.165906 systemd[1]: Mounting sys-kernel-tracing.mount - Kernel Trace File System... Mar 13 09:46:07.165912 systemd[1]: tmp.mount: x-systemd.graceful-option=usrquota specified, but option is not available, suppressing. Mar 13 09:46:07.165920 systemd[1]: Mounting tmp.mount - Temporary Directory /tmp... Mar 13 09:46:07.165927 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 13 09:46:07.165934 systemd[1]: Reached target machines.target - Virtual Machines and Containers. Mar 13 09:46:07.165940 systemd[1]: Starting flatcar-tmpfiles.service - Create missing system files... Mar 13 09:46:07.165947 systemd[1]: ignition-delete-config.service - Ignition (delete config) was skipped because no trigger condition checks were met. Mar 13 09:46:07.165956 systemd[1]: Starting kmod-static-nodes.service - Create List of Static Device Nodes... Mar 13 09:46:07.165966 systemd[1]: Starting modprobe@configfs.service - Load Kernel Module configfs... Mar 13 09:46:07.165974 systemd[1]: modprobe@dm_mod.service - Load Kernel Module dm_mod was skipped because of an unmet condition check (ConditionKernelModuleLoaded=!dm_mod). Mar 13 09:46:07.165981 systemd[1]: Starting modprobe@drm.service - Load Kernel Module drm... Mar 13 09:46:07.165988 systemd[1]: Starting modprobe@efi_pstore.service - Load Kernel Module efi_pstore... Mar 13 09:46:07.165994 systemd[1]: Starting modprobe@fuse.service - Load Kernel Module fuse... Mar 13 09:46:07.166001 systemd[1]: modprobe@loop.service - Load Kernel Module loop was skipped because of an unmet condition check (ConditionKernelModuleLoaded=!loop). Mar 13 09:46:07.166008 systemd[1]: setup-nsswitch.service - Create /etc/nsswitch.conf was skipped because of an unmet condition check (ConditionPathExists=!/etc/nsswitch.conf). Mar 13 09:46:07.166016 systemd[1]: systemd-fsck-root.service: Deactivated successfully. Mar 13 09:46:07.166022 systemd[1]: Stopped systemd-fsck-root.service - File System Check on Root Device. Mar 13 09:46:07.166029 systemd[1]: systemd-fsck-usr.service: Deactivated successfully. Mar 13 09:46:07.166035 systemd[1]: Stopped systemd-fsck-usr.service. Mar 13 09:46:07.166043 systemd[1]: Starting systemd-fsck@dev-disk-by\x2did-dm\x2dname\x2ddata.service - File System Check on /dev/disk/by-id/dm-name-data... Mar 13 09:46:07.166050 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 13 09:46:07.166080 systemd[1]: Starting systemd-journald.service - Journal Service... Mar 13 09:46:07.166088 systemd[1]: Starting systemd-modules-load.service - Load Kernel Modules... Mar 13 09:46:07.166095 kernel: fuse: init (API version 7.41) Mar 13 09:46:07.166102 systemd[1]: Starting systemd-network-generator.service - Generate Network Units from Kernel Command Line... Mar 13 09:46:07.166108 systemd[1]: systemd-repart.service - Repartition Root Disk was skipped because no trigger condition checks were met. Mar 13 09:46:07.166115 systemd[1]: Reached target time-set.target - System Time Set. Mar 13 09:46:07.166122 systemd[1]: Starting systemd-remount-fs.service - Remount Root and Kernel File Systems... Mar 13 09:46:07.166167 systemd-journald[2087]: Collecting audit messages is enabled. Mar 13 09:46:07.166185 kernel: ACPI: bus type drm_connector registered Mar 13 09:46:07.166192 systemd[1]: Starting systemd-udev-load-credentials.service - Load udev Rules from Credentials... Mar 13 09:46:07.166204 systemd-journald[2087]: Journal started Mar 13 09:46:07.166220 systemd-journald[2087]: Runtime Journal (/run/log/journal/d9839a76a94444c4a16b10859b4d0684) is 8M, max 78.3M, 70.3M free. Mar 13 09:46:06.568000 audit[1]: EVENT_LISTENER pid=1 uid=0 auid=4294967295 tty=(none) ses=4294967295 subj=system_u:system_r:kernel_t:s0 comm="systemd" exe="/usr/lib/systemd/systemd" nl-mcgrp=1 op=connect res=1 Mar 13 09:46:07.011000 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 13 09:46:07.024000 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 13 09:46:07.051000 audit: BPF prog-id=15 op=UNLOAD Mar 13 09:46:07.051000 audit: BPF prog-id=14 op=UNLOAD Mar 13 09:46:07.052000 audit: BPF prog-id=16 op=LOAD Mar 13 09:46:07.052000 audit: BPF prog-id=17 op=LOAD Mar 13 09:46:07.052000 audit: BPF prog-id=18 op=LOAD Mar 13 09:46:07.156000 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 13 09:46:07.156000 audit[2087]: SYSCALL arch=c00000b7 syscall=211 success=yes exit=60 a0=5 a1=ffffcf0935d0 a2=4000 a3=0 items=0 ppid=1 pid=2087 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 13 09:46:07.156000 audit: PROCTITLE proctitle="/usr/lib/systemd/systemd-journald" Mar 13 09:46:06.112154 systemd[1]: Queued start job for default target multi-user.target. Mar 13 09:46:06.138132 systemd[1]: Unnecessary job was removed for dev-sda6.device - /dev/sda6. Mar 13 09:46:06.138623 systemd[1]: systemd-journald.service: Deactivated successfully. Mar 13 09:46:06.140259 systemd[1]: systemd-journald.service: Consumed 2.656s CPU time. Mar 13 09:46:07.180984 systemd[1]: Starting systemd-udev-trigger.service - Coldplug All udev Devices... Mar 13 09:46:07.197691 systemd[1]: Started systemd-journald.service - Journal Service. Mar 13 09:46:07.198000 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 13 09:46:07.202037 systemd[1]: Mounted dev-hugepages.mount - Huge Pages File System. Mar 13 09:46:07.206776 systemd[1]: Mounted dev-mqueue.mount - POSIX Message Queue File System. Mar 13 09:46:07.212181 systemd[1]: Mounted media.mount - External Media Directory. Mar 13 09:46:07.217001 systemd[1]: Mounted sys-kernel-debug.mount - Kernel Debug File System. Mar 13 09:46:07.222270 systemd[1]: Mounted sys-kernel-tracing.mount - Kernel Trace File System. Mar 13 09:46:07.228162 systemd[1]: Mounted tmp.mount - Temporary Directory /tmp. Mar 13 09:46:07.233842 systemd[1]: Finished kmod-static-nodes.service - Create List of Static Device Nodes. Mar 13 09:46:07.238000 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 13 09:46:07.240259 systemd[1]: modprobe@configfs.service: Deactivated successfully. Mar 13 09:46:07.240451 systemd[1]: Finished modprobe@configfs.service - Load Kernel Module configfs. Mar 13 09:46:07.244000 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 13 09:46:07.244000 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 13 09:46:07.245904 systemd[1]: modprobe@drm.service: Deactivated successfully. Mar 13 09:46:07.246099 systemd[1]: Finished modprobe@drm.service - Load Kernel Module drm. Mar 13 09:46:07.251000 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 13 09:46:07.251000 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 13 09:46:07.252513 systemd[1]: modprobe@efi_pstore.service: Deactivated successfully. Mar 13 09:46:07.252670 systemd[1]: Finished modprobe@efi_pstore.service - Load Kernel Module efi_pstore. Mar 13 09:46:07.256000 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 13 09:46:07.256000 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 13 09:46:07.258289 systemd[1]: modprobe@fuse.service: Deactivated successfully. Mar 13 09:46:07.258429 systemd[1]: Finished modprobe@fuse.service - Load Kernel Module fuse. Mar 13 09:46:07.262000 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 13 09:46:07.262000 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 13 09:46:07.263425 systemd[1]: Finished systemd-modules-load.service - Load Kernel Modules. Mar 13 09:46:07.267000 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 13 09:46:07.268600 systemd[1]: Finished systemd-network-generator.service - Generate Network Units from Kernel Command Line. Mar 13 09:46:07.274000 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 13 09:46:07.278109 systemd[1]: Finished systemd-remount-fs.service - Remount Root and Kernel File Systems. Mar 13 09:46:07.283194 systemd-fsck[2122]: DATA: clean, 12/130048 files, 18015/520192 blocks Mar 13 09:46:07.282000 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 13 09:46:07.284751 systemd[1]: Finished systemd-udev-load-credentials.service - Load udev Rules from Credentials. Mar 13 09:46:07.289000 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 13 09:46:07.295207 systemd[1]: Finished systemd-fsck@dev-disk-by\x2did-dm\x2dname\x2ddata.service - File System Check on /dev/disk/by-id/dm-name-data. Mar 13 09:46:07.301000 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\x2did-dm\x2dname\x2ddata comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Mar 13 09:46:07.311553 systemd[1]: Reached target network-pre.target - Preparation for Network. Mar 13 09:46:07.316996 systemd[1]: Listening on systemd-importd.socket - Disk Image Download Service Socket. Mar 13 09:46:07.326226 systemd[1]: Mounting sys-fs-fuse-connections.mount - FUSE Control File System... Mar 13 09:46:07.335167 systemd[1]: Mounting sys-kernel-config.mount - Kernel Configuration File System... Mar 13 09:46:07.357382 systemd[1]: Mounting var-lib-data.mount - /var/lib/data... Mar 13 09:46:07.361169 systemd[1]: remount-root.service - Remount Root File System was skipped because of an unmet condition check (ConditionPathIsReadWrite=!/). Mar 13 09:46:07.370632 systemd[1]: Starting systemd-hwdb-update.service - Rebuild Hardware Database... Mar 13 09:46:07.378820 systemd[1]: Starting systemd-journal-flush.service - Flush Journal to Persistent Storage... Mar 13 09:46:07.384130 systemd[1]: systemd-pstore.service - Platform Persistent Storage Archival was skipped because of an unmet condition check (ConditionDirectoryNotEmpty=/sys/fs/pstore). Mar 13 09:46:07.390491 systemd[1]: Starting systemd-random-seed.service - Load/Save OS Random Seed... Mar 13 09:46:07.396421 systemd[1]: Starting systemd-sysctl.service - Apply Kernel Variables... Mar 13 09:46:07.405250 systemd[1]: Starting systemd-tmpfiles-setup-dev-early.service - Create Static Device Nodes in /dev gracefully... Mar 13 09:46:07.414939 systemd[1]: Finished systemd-udev-trigger.service - Coldplug All udev Devices. Mar 13 09:46:07.425000 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 13 09:46:07.427360 systemd[1]: Mounted sys-fs-fuse-connections.mount - FUSE Control File System. Mar 13 09:46:07.430560 kernel: EXT4-fs (dm-1): mounted filesystem c506216e-121d-4afd-a884-1f0c3c00ecf3 r/w with ordered data mode. Quota mode: none. Mar 13 09:46:07.434249 systemd[1]: Mounted sys-kernel-config.mount - Kernel Configuration File System. Mar 13 09:46:07.440396 systemd[1]: Mounted var-lib-data.mount - /var/lib/data. Mar 13 09:46:07.444500 systemd[1]: Finished systemd-random-seed.service - Load/Save OS Random Seed. Mar 13 09:46:07.449746 systemd-journald[2087]: Time spent on flushing to /var/log/journal/d9839a76a94444c4a16b10859b4d0684 is 14.879ms for 1199 entries. Mar 13 09:46:07.449746 systemd-journald[2087]: System Journal (/var/log/journal/d9839a76a94444c4a16b10859b4d0684) is 8M, max 2.2G, 2.2G free. Mar 13 09:46:07.454000 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 13 09:46:07.479618 systemd-journald[2087]: Received client request to flush runtime journal. Mar 13 09:46:07.459536 systemd[1]: Reached target first-boot-complete.target - First Boot Complete. Mar 13 09:46:07.465931 systemd[1]: Reached target local-fs.target - Local File Systems. Mar 13 09:46:07.471350 systemd[1]: Listening on systemd-sysext.socket - System Extension Image Management. Mar 13 09:46:07.478109 systemd[1]: systemd-binfmt.service - Set Up Additional Binary Formats was skipped because no trigger condition checks were met. Mar 13 09:46:07.481199 systemd[1]: Starting systemd-confext.service - Merge System Configuration Images into /etc/... Mar 13 09:46:07.492226 systemd[1]: Starting systemd-machine-id-commit.service - Save Transient machine-id to Disk... Mar 13 09:46:07.499812 systemd[1]: Starting systemd-userdb-load-credentials.service - Load JSON user/group Records from Credentials... Mar 13 09:46:07.509387 systemd[1]: Finished flatcar-tmpfiles.service - Create missing system files. Mar 13 09:46:07.515000 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 13 09:46:07.518103 systemd[1]: Finished systemd-journal-flush.service - Flush Journal to Persistent Storage. Mar 13 09:46:07.523000 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 13 09:46:07.529278 systemd[1]: Finished systemd-sysctl.service - Apply Kernel Variables. Mar 13 09:46:07.538000 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 13 09:46:07.554361 systemd[1]: Finished systemd-userdb-load-credentials.service - Load JSON user/group Records from Credentials. Mar 13 09:46:07.561000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=systemd-userdb-load-credentials comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Mar 13 09:46:07.586484 systemd[1]: Finished systemd-machine-id-commit.service - Save Transient machine-id to Disk. Mar 13 09:46:07.590000 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 13 09:46:07.619076 kernel: loop4: detected capacity change from 0 to 43200 Mar 13 09:46:07.622081 kernel: loop4: p1 p2 p3 Mar 13 09:46:07.638351 kernel: erofs: (device loop4p1): mounted with root inode @ nid 40. Mar 13 09:46:07.660096 kernel: loop4: detected capacity change from 0 to 43200 Mar 13 09:46:07.660200 kernel: loop4: p1 p2 p3 Mar 13 09:46:07.660452 systemd-tmpfiles[2148]: ACLs are not supported, ignoring. Mar 13 09:46:07.660801 systemd-tmpfiles[2148]: ACLs are not supported, ignoring. Mar 13 09:46:07.664571 systemd[1]: Finished systemd-tmpfiles-setup-dev-early.service - Create Static Device Nodes in /dev gracefully. Mar 13 09:46:07.669000 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 13 09:46:07.674046 systemd[1]: Starting systemd-sysusers.service - Create System Users... Mar 13 09:46:07.783419 kernel: device-mapper: verity: sha256 using shash "sha256-ce" Mar 13 09:46:07.783503 kernel: device-mapper: verity: Unrecognized verity feature request: root_hash_sig_key_desc Mar 13 09:46:07.788359 kernel: device-mapper: table: 254:6: verity: Unrecognized verity feature request (-EINVAL) Mar 13 09:46:07.788436 kernel: device-mapper: ioctl: error adding target to table Mar 13 09:46:07.791644 (sd-merge)[2172]: device-mapper: reload ioctl on loop4p1-verity (254:6) failed: Invalid argument Mar 13 09:46:07.794079 kernel: device-mapper: verity: sha256 using shash "sha256-ce" Mar 13 09:46:07.827237 systemd[1]: Finished systemd-sysusers.service - Create System Users. Mar 13 09:46:07.830000 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 13 09:46:07.831000 audit: BPF prog-id=19 op=LOAD Mar 13 09:46:07.832000 audit: BPF prog-id=20 op=LOAD Mar 13 09:46:07.832000 audit: BPF prog-id=21 op=LOAD Mar 13 09:46:07.834222 systemd[1]: Starting systemd-oomd.service - Userspace Out-Of-Memory (OOM) Killer... Mar 13 09:46:07.841000 audit: BPF prog-id=22 op=LOAD Mar 13 09:46:07.845342 systemd[1]: Starting systemd-resolved.service - Network Name Resolution... Mar 13 09:46:07.851038 systemd[1]: Starting systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev... Mar 13 09:46:07.870135 systemd[1]: Starting modprobe@tun.service - Load Kernel Module tun... Mar 13 09:46:07.876000 audit: BPF prog-id=23 op=LOAD Mar 13 09:46:07.876000 audit: BPF prog-id=24 op=LOAD Mar 13 09:46:07.876000 audit: BPF prog-id=25 op=LOAD Mar 13 09:46:07.879243 systemd[1]: Starting systemd-userdbd.service - User Database Manager... Mar 13 09:46:07.890557 systemd-tmpfiles[2182]: ACLs are not supported, ignoring. Mar 13 09:46:07.893119 systemd-tmpfiles[2182]: ACLs are not supported, ignoring. Mar 13 09:46:07.897306 systemd[1]: Finished systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev. Mar 13 09:46:07.902000 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 13 09:46:07.936289 systemd[1]: Started systemd-userdbd.service - User Database Manager. Mar 13 09:46:07.940000 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 13 09:46:07.951665 kernel: tun: Universal TUN/TAP device driver, 1.6 Mar 13 09:46:07.952266 systemd[1]: modprobe@tun.service: Deactivated successfully. Mar 13 09:46:07.952589 systemd[1]: Finished modprobe@tun.service - Load Kernel Module tun. Mar 13 09:46:07.957000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=modprobe@tun comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Mar 13 09:46:07.957000 audit[1]: SERVICE_STOP pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=modprobe@tun comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Mar 13 09:46:07.959000 audit: BPF prog-id=26 op=LOAD Mar 13 09:46:07.959000 audit: BPF prog-id=27 op=LOAD Mar 13 09:46:07.959000 audit: BPF prog-id=28 op=LOAD Mar 13 09:46:07.962260 systemd[1]: Starting systemd-nsresourced.service - Namespace Resource Manager... Mar 13 09:46:08.010459 systemd-nsresourced[2192]: Not setting up BPF subsystem, as functionality has been disabled at compile time. Mar 13 09:46:08.012207 systemd[1]: Started systemd-nsresourced.service - Namespace Resource Manager. Mar 13 09:46:08.016000 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 13 09:46:08.104616 systemd-oomd[2180]: No swap; memory pressure usage will be degraded Mar 13 09:46:08.105283 systemd[1]: Started systemd-oomd.service - Userspace Out-Of-Memory (OOM) Killer. Mar 13 09:46:08.115000 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 13 09:46:08.124153 systemd-resolved[2181]: Positive Trust Anchors: Mar 13 09:46:08.124177 systemd-resolved[2181]: . IN DS 20326 8 2 e06d44b80b8f1d39a95c0b0d7c65d08458e880409bbc683457104237c7f8ec8d Mar 13 09:46:08.124180 systemd-resolved[2181]: . IN DS 38696 8 2 683d2d0acb8c9b712a1948b27f741219298d0a450d612c483af444a4c0fb2b16 Mar 13 09:46:08.124199 systemd-resolved[2181]: 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 13 09:46:08.185325 systemd[1]: etc-machine\x2did.mount: Deactivated successfully. Mar 13 09:46:08.204900 systemd[1]: Finished systemd-hwdb-update.service - Rebuild Hardware Database. Mar 13 09:46:08.208000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=systemd-hwdb-update comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Mar 13 09:46:08.209000 audit: BPF prog-id=7 op=UNLOAD Mar 13 09:46:08.209000 audit: BPF prog-id=6 op=UNLOAD Mar 13 09:46:08.209000 audit: BPF prog-id=29 op=LOAD Mar 13 09:46:08.209000 audit: BPF prog-id=30 op=LOAD Mar 13 09:46:08.211465 systemd[1]: Starting systemd-udevd.service - Rule-based Manager for Device Events and Files... Mar 13 09:46:08.233286 systemd-resolved[2181]: Using system hostname 'ci-4636.0.101-71662ec14e'. Mar 13 09:46:08.234685 systemd[1]: Started systemd-resolved.service - Network Name Resolution. Mar 13 09:46:08.238000 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 13 09:46:08.239686 systemd[1]: Reached target nss-lookup.target - Host and Network Name Lookups. Mar 13 09:46:08.248271 systemd-udevd[2204]: Using default interface naming scheme 'v258'. Mar 13 09:46:08.543328 systemd[1]: Started systemd-udevd.service - Rule-based Manager for Device Events and Files. Mar 13 09:46:08.547000 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 13 09:46:08.548000 audit: BPF prog-id=31 op=LOAD Mar 13 09:46:08.552241 systemd[1]: Starting systemd-networkd.service - Network Configuration... Mar 13 09:46:08.648876 systemd[1]: Condition check resulted in dev-ttyAMA0.device - /dev/ttyAMA0 being skipped. Mar 13 09:46:08.686433 systemd-networkd[2206]: lo: Link UP Mar 13 09:46:08.686446 systemd-networkd[2206]: lo: Gained carrier Mar 13 09:46:08.687674 systemd[1]: Started systemd-networkd.service - Network Configuration. Mar 13 09:46:08.693000 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 13 09:46:08.694279 systemd[1]: Reached target network.target - Network. Mar 13 09:46:08.701223 systemd[1]: Starting systemd-networkd-persistent-storage.service - Enable Persistent Storage in systemd-networkd... Mar 13 09:46:08.710213 systemd[1]: Starting systemd-networkd-wait-online.service - Wait for Network to be Configured... Mar 13 09:46:08.725078 kernel: hv_storvsc f8b3781a-1e82-4818-a1c3-63d806ec15bb: tag#183 cmd 0x85 status: scsi 0x2 srb 0x6 hv 0xc0000001 Mar 13 09:46:08.742614 systemd-networkd[2206]: eth0: Found matching .network file, based on potentially unpredictable interface name: /usr/lib/systemd/network/zz-default.network Mar 13 09:46:08.742622 systemd-networkd[2206]: eth0: Configuring with /usr/lib/systemd/network/zz-default.network. Mar 13 09:46:08.782126 kernel: hv_vmbus: registering driver hyperv_fb Mar 13 09:46:08.782234 kernel: hyperv_fb: Synthvid Version major 3, minor 5 Mar 13 09:46:08.789240 kernel: hyperv_fb: Screen resolution: 1024x768, Color depth: 32, Frame buffer size: 8388608 Mar 13 09:46:08.798164 kernel: mlx5_core bedd:00:02.0 enP48861s1: Link up Mar 13 09:46:08.798612 kernel: Console: switching to colour dummy device 80x25 Mar 13 09:46:08.808470 kernel: mousedev: PS/2 mouse device common for all mice Mar 13 09:46:08.808562 kernel: hv_vmbus: registering driver hv_balloon Mar 13 09:46:08.813928 kernel: Console: switching to colour frame buffer device 128x48 Mar 13 09:46:08.825099 kernel: hv_netvsc 002248c2-0bfc-0022-48c2-0bfc002248c2 eth0: Data path switched to VF: enP48861s1 Mar 13 09:46:08.826998 systemd-networkd[2206]: enP48861s1: Link UP Mar 13 09:46:08.827286 systemd-networkd[2206]: eth0: Link UP Mar 13 09:46:08.827289 systemd-networkd[2206]: eth0: Gained carrier Mar 13 09:46:08.827310 systemd-networkd[2206]: eth0: Found matching .network file, based on potentially unpredictable interface name: /usr/lib/systemd/network/zz-default.network Mar 13 09:46:08.832399 systemd-networkd[2206]: enP48861s1: Gained carrier Mar 13 09:46:08.833860 systemd[1]: Finished systemd-networkd-persistent-storage.service - Enable Persistent Storage in systemd-networkd. Mar 13 09:46:08.841988 kernel: hv_balloon: Using Dynamic Memory protocol version 2.0 Mar 13 09:46:08.842080 kernel: hv_balloon: Memory hot add disabled on ARM64 Mar 13 09:46:08.843000 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 13 09:46:08.846539 systemd-networkd[2206]: eth0: DHCPv4 address 10.200.20.13/24, gateway 10.200.20.1 acquired from 168.63.129.16 Mar 13 09:46:08.860146 systemd[1]: Condition check resulted in dev-ptp_hyperv.device - /dev/ptp_hyperv being skipped. Mar 13 09:46:08.869461 kernel: MACsec IEEE 802.1AE Mar 13 09:46:08.891454 systemd[1]: Starting systemd-vconsole-setup.service - Virtual Console Setup... Mar 13 09:46:08.920317 systemd[1]: systemd-vconsole-setup.service: Deactivated successfully. Mar 13 09:46:08.922165 systemd[1]: Stopped systemd-vconsole-setup.service - Virtual Console Setup. Mar 13 09:46:08.928000 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 13 09:46:08.928000 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 13 09:46:08.932272 systemd[1]: Starting systemd-vconsole-setup.service - Virtual Console Setup... Mar 13 09:46:09.005156 systemd[1]: systemd-vconsole-setup.service: Deactivated successfully. Mar 13 09:46:09.006138 systemd[1]: Stopped systemd-vconsole-setup.service - Virtual Console Setup. Mar 13 09:46:09.016000 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 13 09:46:09.016000 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 13 09:46:09.025267 systemd[1]: Starting systemd-vconsole-setup.service - Virtual Console Setup... Mar 13 09:46:09.073634 (sd-merge)[2172]: Skipping extension refresh because no change was found, use --always-refresh=yes to always do a refresh. Mar 13 09:46:09.074158 kernel: erofs: (device dm-6): mounted with root inode @ nid 40. Mar 13 09:46:09.078833 systemd[1]: Finished systemd-confext.service - Merge System Configuration Images into /etc/. Mar 13 09:46:09.087000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=systemd-confext comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Mar 13 09:46:09.097072 kernel: device-mapper: ioctl: remove_all left 6 open device(s) Mar 13 09:46:09.100311 systemd[1]: Starting systemd-sysext.service - Merge System Extension Images into /usr/ and /opt/... Mar 13 09:46:09.134309 kernel: loop4: detected capacity change from 0 to 142456 Mar 13 09:46:09.134427 kernel: loop4: p1 p2 p3 Mar 13 09:46:09.159092 kernel: erofs: (device loop4p1): mounted with root inode @ nid 39. Mar 13 09:46:09.159715 systemd[1]: Condition check resulted in dev-disk-by\x2duuid-2367dbdc\x2d5adb\x2d4394\x2db330\x2d7e87f0011b27.device - Virtual_Disk USR-B being skipped. Mar 13 09:46:09.161342 systemd[1]: Starting systemd-cryptsetup@data.service - Cryptography Setup for data... Mar 13 09:46:09.193081 kernel: loop4: detected capacity change from 0 to 355640 Mar 13 09:46:09.205404 systemd-cryptsetup[2338]: Volume data already active. Mar 13 09:46:09.208510 kernel: loop4: p1 p2 p3 Mar 13 09:46:09.208477 systemd[1]: Finished systemd-cryptsetup@data.service - Cryptography Setup for data. Mar 13 09:46:09.214000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=systemd-cryptsetup@data comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Mar 13 09:46:09.218648 systemd[1]: Found device dev-disk-by\x2dlabel-OEM.device - Virtual_Disk OEM. Mar 13 09:46:09.219077 kernel: loop4: p1 p2 p3 Mar 13 09:46:09.224012 systemd[1]: Reached target blockdev@dev-mapper-data.target - Block Device Preparation for /dev/mapper/data. Mar 13 09:46:09.229398 systemd[1]: Reached target cryptsetup.target - Local Encrypted Volumes. Mar 13 09:46:09.235745 systemd[1]: Starting systemd-fsck@dev-disk-by\x2dlabel-OEM.service - File System Check on /dev/disk/by-label/OEM... Mar 13 09:46:09.256112 kernel: erofs: (device loop4p1): mounted with root inode @ nid 39. Mar 13 09:46:09.274520 kernel: loop4: detected capacity change from 0 to 166960 Mar 13 09:46:09.274657 kernel: loop4: p1 p2 p3 Mar 13 09:46:09.278614 kernel: loop4: p1 p2 p3 Mar 13 09:46:09.288203 systemd[1]: Finished systemd-fsck@dev-disk-by\x2dlabel-OEM.service - File System Check on /dev/disk/by-label/OEM. Mar 13 09:46:09.292000 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 13 09:46:09.300081 kernel: erofs: (device loop4p1): mounted with root inode @ nid 39. Mar 13 09:46:09.320084 kernel: loop4: detected capacity change from 0 to 142456 Mar 13 09:46:09.320149 kernel: loop4: p1 p2 p3 Mar 13 09:46:09.325425 kernel: loop4: p1 p2 p3 Mar 13 09:46:09.352366 kernel: device-mapper: verity: sha256 using shash "sha256-ce" Mar 13 09:46:09.352438 kernel: device-mapper: verity: Unrecognized verity feature request: root_hash_sig_key_desc Mar 13 09:46:09.359086 kernel: device-mapper: table: 254:6: verity: Unrecognized verity feature request (-EINVAL) Mar 13 09:46:09.363001 kernel: device-mapper: ioctl: error adding target to table Mar 13 09:46:09.365128 (sd-merge)[2353]: device-mapper: reload ioctl on loop4p1-verity (254:6) failed: Invalid argument Mar 13 09:46:09.376094 kernel: device-mapper: verity: sha256 using shash "sha256-ce" Mar 13 09:46:09.411093 kernel: erofs: (device dm-6): mounted with root inode @ nid 39. Mar 13 09:46:09.419106 kernel: loop5: detected capacity change from 0 to 355640 Mar 13 09:46:09.429090 kernel: loop5: p1 p2 p3 Mar 13 09:46:09.450131 kernel: device-mapper: verity: sha256 using shash "sha256-ce" Mar 13 09:46:09.450258 kernel: device-mapper: verity: Unrecognized verity feature request: root_hash_sig_key_desc Mar 13 09:46:09.450284 kernel: device-mapper: table: 254:7: verity: Unrecognized verity feature request (-EINVAL) Mar 13 09:46:09.458472 kernel: device-mapper: ioctl: error adding target to table Mar 13 09:46:09.458699 (sd-merge)[2353]: device-mapper: reload ioctl on loop5p1-verity (254:7) failed: Invalid argument Mar 13 09:46:09.464112 kernel: device-mapper: verity: sha256 using shash "sha256-ce" Mar 13 09:46:09.495090 kernel: erofs: (device dm-7): mounted with root inode @ nid 39. Mar 13 09:46:09.500094 kernel: loop6: detected capacity change from 0 to 166960 Mar 13 09:46:09.505235 kernel: loop6: p1 p2 p3 Mar 13 09:46:09.508082 kernel: loop6: p1 p2 p3 Mar 13 09:46:09.529086 kernel: device-mapper: verity: sha256 using shash "sha256-ce" Mar 13 09:46:09.529186 kernel: device-mapper: verity: Unrecognized verity feature request: root_hash_sig_key_desc Mar 13 09:46:09.536101 kernel: device-mapper: table: 254:8: verity: Unrecognized verity feature request (-EINVAL) Mar 13 09:46:09.539561 kernel: device-mapper: ioctl: error adding target to table Mar 13 09:46:09.542394 (sd-merge)[2353]: device-mapper: reload ioctl on loop6p1-verity (254:8) failed: Invalid argument Mar 13 09:46:09.553083 kernel: device-mapper: verity: sha256 using shash "sha256-ce" Mar 13 09:46:09.556195 systemd[1]: Finished systemd-vconsole-setup.service - Virtual Console Setup. Mar 13 09:46:09.560000 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 13 09:46:09.592140 kernel: erofs: (device dm-8): mounted with root inode @ nid 39. Mar 13 09:46:09.592360 (sd-merge)[2353]: Skipping extension refresh because no change was found, use --always-refresh=yes to always do a refresh. Mar 13 09:46:09.594903 systemd[1]: Finished systemd-sysext.service - Merge System Extension Images into /usr/ and /opt/. Mar 13 09:46:09.599000 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 13 09:46:09.601961 systemd[1]: Starting systemd-tmpfiles-setup.service - Create System Files and Directories... Mar 13 09:46:09.632238 systemd-tmpfiles[2377]: /usr/lib/tmpfiles.d/nfs-utils.conf:6: Duplicate line for path "/var/lib/nfs/sm", ignoring. Mar 13 09:46:09.632834 systemd-tmpfiles[2377]: /usr/lib/tmpfiles.d/nfs-utils.conf:7: Duplicate line for path "/var/lib/nfs/sm.bak", ignoring. Mar 13 09:46:09.633155 systemd-tmpfiles[2377]: /usr/lib/tmpfiles.d/provision.conf:20: Duplicate line for path "/root", ignoring. Mar 13 09:46:09.633850 systemd-tmpfiles[2377]: ACLs are not supported, ignoring. Mar 13 09:46:09.634021 systemd-tmpfiles[2377]: ACLs are not supported, ignoring. Mar 13 09:46:09.634334 kernel: device-mapper: ioctl: remove_all left 6 open device(s) Mar 13 09:46:09.634370 kernel: device-mapper: ioctl: remove_all left 6 open device(s) Mar 13 09:46:09.670603 systemd-tmpfiles[2377]: Detected autofs mount point /boot during canonicalization of boot. Mar 13 09:46:09.670618 systemd-tmpfiles[2377]: Skipping /boot Mar 13 09:46:09.676112 systemd-tmpfiles[2377]: Detected autofs mount point /boot during canonicalization of boot. Mar 13 09:46:09.676128 systemd-tmpfiles[2377]: Skipping /boot Mar 13 09:46:09.684380 systemd[1]: Finished systemd-tmpfiles-setup.service - Create System Files and Directories. Mar 13 09:46:09.688000 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 13 09:46:09.691651 systemd[1]: Starting audit-rules.service - Load Audit Rules... Mar 13 09:46:09.703105 systemd[1]: Starting clean-ca-certificates.service - Clean up broken links in /etc/ssl/certs... Mar 13 09:46:09.710239 systemd[1]: Starting ldconfig.service - Rebuild Dynamic Linker Cache... Mar 13 09:46:09.715833 systemd[1]: Starting systemd-journal-catalog-update.service - Rebuild Journal Catalog... Mar 13 09:46:09.728255 systemd[1]: Starting systemd-update-utmp.service - Record System Boot/Shutdown in UTMP... Mar 13 09:46:09.738000 audit[2387]: AUDIT1127 pid=2387 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 13 09:46:09.744190 systemd[1]: Finished systemd-update-utmp.service - Record System Boot/Shutdown in UTMP. Mar 13 09:46:09.751000 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 13 09:46:09.822377 systemd[1]: Finished systemd-journal-catalog-update.service - Rebuild Journal Catalog. Mar 13 09:46:09.826000 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 13 09:46:10.083279 systemd[1]: Finished clean-ca-certificates.service - Clean up broken links in /etc/ssl/certs. Mar 13 09:46:10.088000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=clean-ca-certificates comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Mar 13 09:46:10.089403 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 13 09:46:10.240000 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 13 09:46:10.240000 audit[2410]: SYSCALL arch=c00000b7 syscall=206 success=yes exit=1056 a0=3 a1=ffffca49b8c0 a2=420 a3=0 items=0 ppid=2383 pid=2410 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 13 09:46:10.240000 audit: PROCTITLE proctitle=2F7362696E2F617564697463746C002D52002F6574632F61756469742F61756469742E72756C6573 Mar 13 09:46:10.241636 augenrules[2410]: No rules Mar 13 09:46:10.243282 systemd[1]: audit-rules.service: Deactivated successfully. Mar 13 09:46:10.243540 systemd[1]: Finished audit-rules.service - Load Audit Rules. Mar 13 09:46:10.520286 systemd-networkd[2206]: eth0: Gained IPv6LL Mar 13 09:46:10.524132 systemd[1]: Finished systemd-networkd-wait-online.service - Wait for Network to be Configured. Mar 13 09:46:10.529758 systemd[1]: Reached target network-online.target - Network is Online. Mar 13 09:46:16.232047 ldconfig[2385]: /sbin/ldconfig: /usr/lib/ld.so.conf is not an ELF file - it has the wrong magic bytes at the start. Mar 13 09:46:16.241983 systemd[1]: Finished ldconfig.service - Rebuild Dynamic Linker Cache. Mar 13 09:46:16.248994 systemd[1]: Starting systemd-update-done.service - Update is Completed... Mar 13 09:46:16.264811 systemd[1]: Finished systemd-update-done.service - Update is Completed. Mar 13 09:46:16.270214 systemd[1]: Reached target sysinit.target - System Initialization. Mar 13 09:46:16.274689 systemd[1]: Started motdgen.path - Watch for update engine configuration changes. Mar 13 09:46:16.281935 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 13 09:46:16.287887 systemd[1]: Started logrotate.timer - Daily rotation of log files. Mar 13 09:46:16.292350 systemd[1]: Started mdadm.timer - Weekly check for MD array's redundancy information.. Mar 13 09:46:16.298741 systemd[1]: Started systemd-sysupdate-reboot.timer - Reboot Automatically After System Update. Mar 13 09:46:16.304014 systemd[1]: Started systemd-sysupdate.timer - Automatic System Update. Mar 13 09:46:16.308537 systemd[1]: Started systemd-tmpfiles-clean.timer - Daily Cleanup of Temporary Directories. Mar 13 09:46:16.314129 systemd[1]: update-engine-stub.timer - Update Engine Stub Timer was skipped because of an unmet condition check (ConditionPathExists=/usr/.noupdate). Mar 13 09:46:16.314253 systemd[1]: Reached target paths.target - Path Units. Mar 13 09:46:16.318289 systemd[1]: Reached target timers.target - Timer Units. Mar 13 09:46:16.323009 systemd[1]: Listening on dbus.socket - D-Bus System Message Bus Socket. Mar 13 09:46:16.345589 systemd[1]: Starting docker.socket - Docker Socket for the API... Mar 13 09:46:16.351122 systemd[1]: Listening on sshd-unix-local.socket - OpenSSH Server Socket (systemd-ssh-generator, AF_UNIX Local). Mar 13 09:46:16.359028 systemd[1]: Starting sshd-vsock.socket - OpenSSH Server Socket (systemd-ssh-generator, AF_VSOCK)... Mar 13 09:46:16.365823 systemd[1]: Listening on sshd.socket - OpenSSH Server Socket. Mar 13 09:46:16.370415 systemd[1]: Listening on systemd-hostnamed.socket - Hostname Service Socket. Mar 13 09:46:16.376614 systemd[1]: Listening on systemd-logind-varlink.socket - User Login Management Varlink Socket. Mar 13 09:46:16.382700 systemd[1]: Listening on systemd-machined.socket - Virtual Machine and Container Registration Service Socket. Mar 13 09:46:16.389565 systemd[1]: Listening on docker.socket - Docker Socket for the API. Mar 13 09:46:16.394565 systemd[1]: Listening on sshd-vsock.socket - OpenSSH Server Socket (systemd-ssh-generator, AF_VSOCK). Mar 13 09:46:16.401005 systemd[1]: Reached target sockets.target - Socket Units. Mar 13 09:46:16.405512 systemd[1]: Reached target basic.target - Basic System. Mar 13 09:46:16.409735 systemd[1]: Reached target ssh-access.target - SSH Access Available. Mar 13 09:46:16.414998 systemd[1]: addon-config@oem.service - Configure Addon /oem was skipped because no trigger condition checks were met. Mar 13 09:46:16.415030 systemd[1]: addon-run@oem.service - Run Addon /oem was skipped because no trigger condition checks were met. Mar 13 09:46:16.417208 systemd[1]: Starting chronyd.service - NTP client/server... Mar 13 09:46:16.429192 systemd[1]: Starting containerd.service - containerd container runtime... Mar 13 09:46:16.437291 systemd[1]: Starting coreos-metadata.service - Flatcar Metadata Agent... Mar 13 09:46:16.448133 systemd[1]: Starting dbus.service - D-Bus System Message Bus... Mar 13 09:46:16.455236 systemd[1]: Starting dracut-shutdown.service - Restore /run/initramfs on shutdown... Mar 13 09:46:16.464038 systemd[1]: Starting enable-oem-cloudinit.service - Enable cloudinit... Mar 13 09:46:16.464293 chronyd[2424]: chronyd version 4.8 starting (+CMDMON +REFCLOCK +RTC +PRIVDROP +SCFILTER -SIGND +NTS +SECHASH +IPV6 -DEBUG) Mar 13 09:46:16.480252 systemd[1]: Starting extend-filesystems.service - Extend Filesystems... Mar 13 09:46:16.485447 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 13 09:46:16.488335 systemd[1]: Started hv_kvp_daemon.service - Hyper-V KVP daemon. Mar 13 09:46:16.493415 systemd[1]: hv_vss_daemon.service - Hyper-V VSS daemon was skipped because of an unmet condition check (ConditionPathExists=/dev/vmbus/hv_vss). Mar 13 09:46:16.497355 jq[2432]: false Mar 13 09:46:16.504186 KVP[2434]: KVP starting; pid is:2434 Mar 13 09:46:16.504931 systemd[1]: Starting motdgen.service - Generate /run/flatcar/motd... Mar 13 09:46:16.506006 KVP[2434]: KVP LIC Version: 3.1 Mar 13 09:46:16.512080 kernel: hv_utils: KVP IC version 4.0 Mar 13 09:46:16.514881 chronyd[2424]: Timezone right/UTC failed leap second check, ignoring Mar 13 09:46:16.515031 chronyd[2424]: Loaded seccomp filter (level 2) Mar 13 09:46:16.518480 systemd[1]: Starting nvidia.service - NVIDIA Configure Service... Mar 13 09:46:16.525876 systemd[1]: Starting ssh-key-proc-cmdline.service - Install an ssh key from /proc/cmdline... Mar 13 09:46:16.534642 extend-filesystems[2433]: Found /dev/mapper/data Mar 13 09:46:16.540276 systemd[1]: Starting sshd-keygen.service - Generate sshd host keys... Mar 13 09:46:16.557933 extend-filesystems[2444]: ERROR: cgpt show: GptSanityCheck() returned 4: GPT_ERROR_INVALID_SECTOR_SIZE Mar 13 09:46:16.572969 extend-filesystems[2433]: Found /dev/sda6 Mar 13 09:46:16.572969 extend-filesystems[2433]: Found /dev/sda9 Mar 13 09:46:16.572969 extend-filesystems[2433]: Checking size of /dev/sda9 Mar 13 09:46:16.566276 systemd[1]: Starting systemd-logind.service - User Login Management... Mar 13 09:46:16.575217 systemd[1]: tcsd.service - TCG Core Services Daemon was skipped because of an unmet condition check (ConditionPathExists=/dev/tpm0). Mar 13 09:46:16.583649 systemd[1]: Starting update-engine.service - Update Engine... Mar 13 09:46:16.591425 systemd[1]: Starting update-ssh-keys-after-ignition.service - Run update-ssh-keys once after Ignition... Mar 13 09:46:16.602111 systemd[1]: Started chronyd.service - NTP client/server. Mar 13 09:46:16.613090 systemd[1]: Finished dracut-shutdown.service - Restore /run/initramfs on shutdown. Mar 13 09:46:16.621414 extend-filesystems[2433]: Resized partition /dev/sda9 Mar 13 09:46:16.622669 systemd[1]: enable-oem-cloudinit.service: Skipped due to 'exec-condition'. Mar 13 09:46:16.635561 jq[2459]: true Mar 13 09:46:16.627084 systemd[1]: Condition check resulted in enable-oem-cloudinit.service - Enable cloudinit being skipped. Mar 13 09:46:16.627362 systemd[1]: motdgen.service: Deactivated successfully. Mar 13 09:46:16.627548 systemd[1]: Finished motdgen.service - Generate /run/flatcar/motd. Mar 13 09:46:16.636571 systemd[1]: ssh-key-proc-cmdline.service: Deactivated successfully. Mar 13 09:46:16.647806 extend-filesystems[2472]: resize2fs 1.47.3 (8-Jul-2025) Mar 13 09:46:16.637210 systemd[1]: Finished ssh-key-proc-cmdline.service - Install an ssh key from /proc/cmdline. Mar 13 09:46:16.662637 systemd[1]: Finished nvidia.service - NVIDIA Configure Service. Mar 13 09:46:16.676089 update_engine[2458]: I20260313 09:46:16.675976 2458 main.cc:92] Flatcar Update Engine starting Mar 13 09:46:16.686124 jq[2477]: true Mar 13 09:46:16.686332 kernel: EXT4-fs (sda9): resizing filesystem from 6359552 to 6376955 blocks Mar 13 09:46:16.686407 kernel: EXT4-fs (sda9): resized filesystem to 6376955 Mar 13 09:46:16.718907 extend-filesystems[2472]: Filesystem at /dev/sda9 is mounted on /; on-line resizing required Mar 13 09:46:16.718907 extend-filesystems[2472]: old_desc_blocks = 4, new_desc_blocks = 4 Mar 13 09:46:16.718907 extend-filesystems[2472]: The filesystem on /dev/sda9 is now 6376955 (4k) blocks long. Mar 13 09:46:16.778210 extend-filesystems[2433]: Resized filesystem in /dev/sda9 Mar 13 09:46:16.727337 systemd[1]: extend-filesystems.service: Deactivated successfully. Mar 13 09:46:16.727616 systemd[1]: Finished extend-filesystems.service - Extend Filesystems. Mar 13 09:46:16.727784 systemd-logind[2450]: New seat seat0. Mar 13 09:46:16.730438 systemd-logind[2450]: Watching system buttons on /dev/input/event1 (AT Translated Set 2 keyboard) Mar 13 09:46:16.744323 systemd[1]: Started systemd-logind.service - User Login Management. Mar 13 09:46:16.822260 bash[2524]: Updated "/home/core/.ssh/authorized_keys" Mar 13 09:46:16.823442 systemd[1]: Finished update-ssh-keys-after-ignition.service - Run update-ssh-keys once after Ignition. Mar 13 09:46:16.838369 dbus-daemon[2427]: [system] SELinux support is enabled Mar 13 09:46:16.841763 systemd[1]: Started dbus.service - D-Bus System Message Bus. Mar 13 09:46:16.846312 update_engine[2458]: I20260313 09:46:16.841219 2458 update_check_scheduler.cc:74] Next update check in 6m39s Mar 13 09:46:16.851433 dbus-daemon[2427]: [system] Successfully activated service 'org.freedesktop.systemd1' Mar 13 09:46:16.859144 systemd[1]: Started update-engine.service - Update Engine. Mar 13 09:46:16.869964 systemd[1]: sshkeys.service was skipped because no trigger condition checks were met. Mar 13 09:46:16.870508 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 13 09:46:16.870631 systemd[1]: Reached target system-config.target - Load system-provided cloud configs. Mar 13 09:46:16.875992 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 13 09:46:16.876091 systemd[1]: Reached target user-config.target - Load user-provided cloud configs. Mar 13 09:46:16.886015 systemd[1]: Started locksmithd.service - Cluster reboot manager. Mar 13 09:46:16.903017 coreos-metadata[2426]: Mar 13 09:46:16.902 INFO Fetching http://168.63.129.16/?comp=versions: Attempt #1 Mar 13 09:46:16.908394 coreos-metadata[2426]: Mar 13 09:46:16.908 INFO Fetch successful Mar 13 09:46:16.908394 coreos-metadata[2426]: Mar 13 09:46:16.908 INFO Fetching http://168.63.129.16/machine/?comp=goalstate: Attempt #1 Mar 13 09:46:16.913266 coreos-metadata[2426]: Mar 13 09:46:16.913 INFO Fetch successful Mar 13 09:46:16.917695 coreos-metadata[2426]: Mar 13 09:46:16.917 INFO Fetching http://168.63.129.16/machine/aa47ac63-37c7-48e2-9536-1748cb9d85eb/bb0beee6%2D7023%2D4477%2Da8e9%2D0e2cbe29e70f.%5Fci%2D4636.0.101%2D71662ec14e?comp=config&type=sharedConfig&incarnation=1: Attempt #1 Mar 13 09:46:16.922661 coreos-metadata[2426]: Mar 13 09:46:16.922 INFO Fetch successful Mar 13 09:46:16.922661 coreos-metadata[2426]: Mar 13 09:46:16.922 INFO Fetching http://169.254.169.254/metadata/instance/compute/vmSize?api-version=2017-08-01&format=text: Attempt #1 Mar 13 09:46:16.933071 coreos-metadata[2426]: Mar 13 09:46:16.932 INFO Fetch successful Mar 13 09:46:16.962257 systemd[1]: Finished coreos-metadata.service - Flatcar Metadata Agent. Mar 13 09:46:16.968857 systemd[1]: packet-phone-home.service - Report Success to Packet was skipped because no trigger condition checks were met. Mar 13 09:46:17.031234 sshd_keygen[2456]: ssh-keygen: generating new host keys: RSA ECDSA ED25519 Mar 13 09:46:17.047573 systemd[1]: Finished sshd-keygen.service - Generate sshd host keys. Mar 13 09:46:17.059349 systemd[1]: Starting issuegen.service - Generate /run/issue... Mar 13 09:46:17.068701 locksmithd[2585]: locksmithd starting currentOperation="UPDATE_STATUS_IDLE" strategy="reboot" Mar 13 09:46:17.068904 systemd[1]: Starting waagent.service - Microsoft Azure Linux Agent... Mar 13 09:46:17.082534 systemd[1]: issuegen.service: Deactivated successfully. Mar 13 09:46:17.082790 systemd[1]: Finished issuegen.service - Generate /run/issue. Mar 13 09:46:17.097862 systemd[1]: Starting systemd-user-sessions.service - Permit User Sessions... Mar 13 09:46:17.108281 systemd[1]: Started waagent.service - Microsoft Azure Linux Agent. Mar 13 09:46:17.122101 systemd[1]: Finished systemd-user-sessions.service - Permit User Sessions. Mar 13 09:46:17.128848 systemd[1]: Started getty@tty1.service - Getty on tty1. Mar 13 09:46:17.135454 systemd[1]: Started serial-getty@ttyAMA0.service - Serial Getty on ttyAMA0. Mar 13 09:46:17.140541 systemd[1]: Reached target getty.target - Login Prompts. Mar 13 09:46:19.852683 containerd[2478]: time="2026-03-13T09:46:19Z" 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 13 09:46:19.854292 containerd[2478]: time="2026-03-13T09:46:19.854245012Z" level=info msg="starting containerd" revision=1c4457e00facac03ce1d75f7b6777a7a851e5c41 version=v2.2.0 Mar 13 09:46:19.863748 containerd[2478]: time="2026-03-13T09:46:19.863427428Z" level=warning msg="Configuration migrated from version 2, use `containerd config migrate` to avoid migration" t="9.68µs" Mar 13 09:46:19.863748 containerd[2478]: time="2026-03-13T09:46:19.863472652Z" level=info msg="loading plugin" id=io.containerd.content.v1.content type=io.containerd.content.v1 Mar 13 09:46:19.863748 containerd[2478]: time="2026-03-13T09:46:19.863523236Z" level=info msg="loading plugin" id=io.containerd.image-verifier.v1.bindir type=io.containerd.image-verifier.v1 Mar 13 09:46:19.863748 containerd[2478]: time="2026-03-13T09:46:19.863533796Z" level=info msg="loading plugin" id=io.containerd.internal.v1.opt type=io.containerd.internal.v1 Mar 13 09:46:19.863748 containerd[2478]: time="2026-03-13T09:46:19.863696612Z" level=info msg="loading plugin" id=io.containerd.warning.v1.deprecations type=io.containerd.warning.v1 Mar 13 09:46:19.863748 containerd[2478]: time="2026-03-13T09:46:19.863713212Z" level=info msg="loading plugin" id=io.containerd.mount-handler.v1.erofs type=io.containerd.mount-handler.v1 Mar 13 09:46:19.863969 containerd[2478]: time="2026-03-13T09:46:19.863943228Z" level=info msg="loading plugin" id=io.containerd.snapshotter.v1.blockfile type=io.containerd.snapshotter.v1 Mar 13 09:46:19.864136 containerd[2478]: time="2026-03-13T09:46:19.864111028Z" 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 13 09:46:19.864207 containerd[2478]: time="2026-03-13T09:46:19.864194756Z" level=info msg="loading plugin" id=io.containerd.snapshotter.v1.btrfs type=io.containerd.snapshotter.v1 Mar 13 09:46:19.864536 containerd[2478]: time="2026-03-13T09:46:19.864512404Z" level=info msg="skip loading plugin" error="path /var/lib/containerd/io.containerd.snapshotter.v1.btrfs (ext4) must be a btrfs filesystem to be used with the btrfs snapshotter: skip plugin" id=io.containerd.snapshotter.v1.btrfs type=io.containerd.snapshotter.v1 Mar 13 09:46:19.864596 containerd[2478]: time="2026-03-13T09:46:19.864583092Z" level=info msg="loading plugin" id=io.containerd.snapshotter.v1.devmapper type=io.containerd.snapshotter.v1 Mar 13 09:46:19.864646 containerd[2478]: time="2026-03-13T09:46:19.864633988Z" level=info msg="skip loading plugin" error="devmapper not configured: skip plugin" id=io.containerd.snapshotter.v1.devmapper type=io.containerd.snapshotter.v1 Mar 13 09:46:19.864679 containerd[2478]: time="2026-03-13T09:46:19.864668060Z" level=info msg="loading plugin" id=io.containerd.snapshotter.v1.erofs type=io.containerd.snapshotter.v1 Mar 13 09:46:19.864927 containerd[2478]: time="2026-03-13T09:46:19.864905084Z" level=info msg="loading plugin" id=io.containerd.snapshotter.v1.native type=io.containerd.snapshotter.v1 Mar 13 09:46:19.865105 containerd[2478]: time="2026-03-13T09:46:19.865086236Z" level=info msg="loading plugin" id=io.containerd.snapshotter.v1.overlayfs type=io.containerd.snapshotter.v1 Mar 13 09:46:19.865357 containerd[2478]: time="2026-03-13T09:46:19.865335492Z" level=info msg="loading plugin" id=io.containerd.snapshotter.v1.zfs type=io.containerd.snapshotter.v1 Mar 13 09:46:19.865434 containerd[2478]: time="2026-03-13T09:46:19.865423716Z" 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 13 09:46:19.865471 containerd[2478]: time="2026-03-13T09:46:19.865463108Z" level=info msg="loading plugin" id=io.containerd.event.v1.exchange type=io.containerd.event.v1 Mar 13 09:46:19.865800 containerd[2478]: time="2026-03-13T09:46:19.865682356Z" level=info msg="loading plugin" id=io.containerd.monitor.task.v1.cgroups type=io.containerd.monitor.task.v1 Mar 13 09:46:19.866096 containerd[2478]: time="2026-03-13T09:46:19.866048772Z" level=info msg="loading plugin" id=io.containerd.metadata.v1.bolt type=io.containerd.metadata.v1 Mar 13 09:46:19.866283 containerd[2478]: time="2026-03-13T09:46:19.866251996Z" level=info msg="metadata content store policy set" policy=shared Mar 13 09:46:19.881332 containerd[2478]: time="2026-03-13T09:46:19.881287356Z" level=info msg="loading plugin" id=io.containerd.gc.v1.scheduler type=io.containerd.gc.v1 Mar 13 09:46:19.881375 containerd[2478]: time="2026-03-13T09:46:19.881354716Z" level=info msg="loading plugin" id=io.containerd.nri.v1.nri type=io.containerd.nri.v1 Mar 13 09:46:19.881389 containerd[2478]: time="2026-03-13T09:46:19.881383860Z" level=info msg="built-in NRI default validator is disabled" Mar 13 09:46:19.881402 containerd[2478]: time="2026-03-13T09:46:19.881389404Z" level=info msg="runtime interface created" Mar 13 09:46:19.881402 containerd[2478]: time="2026-03-13T09:46:19.881393636Z" level=info msg="created NRI interface" Mar 13 09:46:19.881446 containerd[2478]: time="2026-03-13T09:46:19.881413508Z" level=info msg="loading plugin" id=io.containerd.differ.v1.erofs type=io.containerd.differ.v1 Mar 13 09:46:19.881558 containerd[2478]: time="2026-03-13T09:46:19.881533500Z" 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 13 09:46:19.881558 containerd[2478]: time="2026-03-13T09:46:19.881551828Z" level=info msg="loading plugin" id=io.containerd.differ.v1.walking type=io.containerd.differ.v1 Mar 13 09:46:19.881599 containerd[2478]: time="2026-03-13T09:46:19.881562948Z" level=info msg="loading plugin" id=io.containerd.lease.v1.manager type=io.containerd.lease.v1 Mar 13 09:46:19.881599 containerd[2478]: time="2026-03-13T09:46:19.881572020Z" level=info msg="loading plugin" id=io.containerd.mount-manager.v1.bolt type=io.containerd.mount-manager.v1 Mar 13 09:46:19.881745 containerd[2478]: time="2026-03-13T09:46:19.881725260Z" level=info msg="loading plugin" id=io.containerd.service.v1.containers-service type=io.containerd.service.v1 Mar 13 09:46:19.881759 containerd[2478]: time="2026-03-13T09:46:19.881748956Z" level=info msg="loading plugin" id=io.containerd.service.v1.content-service type=io.containerd.service.v1 Mar 13 09:46:19.881775 containerd[2478]: time="2026-03-13T09:46:19.881762556Z" level=info msg="loading plugin" id=io.containerd.service.v1.diff-service type=io.containerd.service.v1 Mar 13 09:46:19.881775 containerd[2478]: time="2026-03-13T09:46:19.881771468Z" level=info msg="loading plugin" id=io.containerd.service.v1.images-service type=io.containerd.service.v1 Mar 13 09:46:19.881802 containerd[2478]: time="2026-03-13T09:46:19.881780844Z" level=info msg="loading plugin" id=io.containerd.service.v1.introspection-service type=io.containerd.service.v1 Mar 13 09:46:19.881802 containerd[2478]: time="2026-03-13T09:46:19.881788148Z" level=info msg="loading plugin" id=io.containerd.service.v1.namespaces-service type=io.containerd.service.v1 Mar 13 09:46:19.881802 containerd[2478]: time="2026-03-13T09:46:19.881794996Z" level=info msg="loading plugin" id=io.containerd.service.v1.snapshots-service type=io.containerd.service.v1 Mar 13 09:46:19.881802 containerd[2478]: time="2026-03-13T09:46:19.881801260Z" level=info msg="loading plugin" id=io.containerd.shim.v1.manager type=io.containerd.shim.v1 Mar 13 09:46:19.881849 containerd[2478]: time="2026-03-13T09:46:19.881810700Z" level=info msg="loading plugin" id=io.containerd.runtime.v2.task type=io.containerd.runtime.v2 Mar 13 09:46:19.881950 containerd[2478]: time="2026-03-13T09:46:19.881932764Z" level=info msg="loading plugin" id=io.containerd.service.v1.tasks-service type=io.containerd.service.v1 Mar 13 09:46:19.881963 containerd[2478]: time="2026-03-13T09:46:19.881956804Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.containers type=io.containerd.grpc.v1 Mar 13 09:46:19.881975 containerd[2478]: time="2026-03-13T09:46:19.881965476Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.content type=io.containerd.grpc.v1 Mar 13 09:46:19.881975 containerd[2478]: time="2026-03-13T09:46:19.881974300Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.diff type=io.containerd.grpc.v1 Mar 13 09:46:19.882000 containerd[2478]: time="2026-03-13T09:46:19.881981788Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.events type=io.containerd.grpc.v1 Mar 13 09:46:19.882000 containerd[2478]: time="2026-03-13T09:46:19.881988348Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.images type=io.containerd.grpc.v1 Mar 13 09:46:19.882000 containerd[2478]: time="2026-03-13T09:46:19.881995188Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.introspection type=io.containerd.grpc.v1 Mar 13 09:46:19.882033 containerd[2478]: time="2026-03-13T09:46:19.882001524Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.leases type=io.containerd.grpc.v1 Mar 13 09:46:19.882033 containerd[2478]: time="2026-03-13T09:46:19.882010956Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.mounts type=io.containerd.grpc.v1 Mar 13 09:46:19.882033 containerd[2478]: time="2026-03-13T09:46:19.882023756Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.namespaces type=io.containerd.grpc.v1 Mar 13 09:46:19.882033 containerd[2478]: time="2026-03-13T09:46:19.882031668Z" level=info msg="loading plugin" id=io.containerd.sandbox.store.v1.local type=io.containerd.sandbox.store.v1 Mar 13 09:46:19.882094 containerd[2478]: time="2026-03-13T09:46:19.882038260Z" level=info msg="loading plugin" id=io.containerd.transfer.v1.local type=io.containerd.transfer.v1 Mar 13 09:46:19.882112 containerd[2478]: time="2026-03-13T09:46:19.882094532Z" level=info msg="loading plugin" id=io.containerd.cri.v1.images type=io.containerd.cri.v1 Mar 13 09:46:19.908614 containerd[2478]: time="2026-03-13T09:46:19.908572836Z" level=info msg="Get image filesystem path \"/var/lib/containerd/io.containerd.snapshotter.v1.overlayfs\" for snapshotter \"overlayfs\"" Mar 13 09:46:19.908652 containerd[2478]: time="2026-03-13T09:46:19.908625540Z" level=info msg="Start snapshots syncer" Mar 13 09:46:19.908682 containerd[2478]: time="2026-03-13T09:46:19.908651020Z" level=info msg="loading plugin" id=io.containerd.cri.v1.runtime type=io.containerd.cri.v1 Mar 13 09:46:19.908976 containerd[2478]: time="2026-03-13T09:46:19.908936700Z" 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 13 09:46:19.909109 containerd[2478]: time="2026-03-13T09:46:19.908990876Z" level=info msg="loading plugin" id=io.containerd.podsandbox.controller.v1.podsandbox type=io.containerd.podsandbox.controller.v1 Mar 13 09:46:19.909171 containerd[2478]: time="2026-03-13T09:46:19.909150236Z" level=info msg="loading plugin" id=io.containerd.sandbox.controller.v1.shim type=io.containerd.sandbox.controller.v1 Mar 13 09:46:19.909330 containerd[2478]: time="2026-03-13T09:46:19.909309100Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.sandbox-controllers type=io.containerd.grpc.v1 Mar 13 09:46:19.909361 containerd[2478]: time="2026-03-13T09:46:19.909332292Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.sandboxes type=io.containerd.grpc.v1 Mar 13 09:46:19.909361 containerd[2478]: time="2026-03-13T09:46:19.909341348Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.snapshots type=io.containerd.grpc.v1 Mar 13 09:46:19.909361 containerd[2478]: time="2026-03-13T09:46:19.909350572Z" level=info msg="loading plugin" id=io.containerd.streaming.v1.manager type=io.containerd.streaming.v1 Mar 13 09:46:19.909361 containerd[2478]: time="2026-03-13T09:46:19.909360236Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.streaming type=io.containerd.grpc.v1 Mar 13 09:46:19.909419 containerd[2478]: time="2026-03-13T09:46:19.909367236Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.tasks type=io.containerd.grpc.v1 Mar 13 09:46:19.909419 containerd[2478]: time="2026-03-13T09:46:19.909374668Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.transfer type=io.containerd.grpc.v1 Mar 13 09:46:19.909419 containerd[2478]: time="2026-03-13T09:46:19.909384532Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.version type=io.containerd.grpc.v1 Mar 13 09:46:19.909419 containerd[2478]: time="2026-03-13T09:46:19.909391764Z" level=info msg="loading plugin" id=io.containerd.monitor.container.v1.restart type=io.containerd.monitor.container.v1 Mar 13 09:46:19.909419 containerd[2478]: time="2026-03-13T09:46:19.909415940Z" level=info msg="loading plugin" id=io.containerd.tracing.processor.v1.otlp type=io.containerd.tracing.processor.v1 Mar 13 09:46:19.909482 containerd[2478]: time="2026-03-13T09:46:19.909427260Z" 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 13 09:46:19.909482 containerd[2478]: time="2026-03-13T09:46:19.909433268Z" level=info msg="loading plugin" id=io.containerd.internal.v1.tracing type=io.containerd.internal.v1 Mar 13 09:46:19.909482 containerd[2478]: time="2026-03-13T09:46:19.909439924Z" 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 13 09:46:19.909482 containerd[2478]: time="2026-03-13T09:46:19.909444628Z" level=info msg="loading plugin" id=io.containerd.ttrpc.v1.otelttrpc type=io.containerd.ttrpc.v1 Mar 13 09:46:19.909482 containerd[2478]: time="2026-03-13T09:46:19.909450884Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.healthcheck type=io.containerd.grpc.v1 Mar 13 09:46:19.909482 containerd[2478]: time="2026-03-13T09:46:19.909459684Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.cri type=io.containerd.grpc.v1 Mar 13 09:46:19.909482 containerd[2478]: time="2026-03-13T09:46:19.909469532Z" level=info msg="Connect containerd service" Mar 13 09:46:19.909627 containerd[2478]: time="2026-03-13T09:46:19.909487196Z" level=info msg="using experimental NRI integration - disable nri plugin to prevent this" Mar 13 09:46:19.910399 containerd[2478]: time="2026-03-13T09:46:19.910366860Z" 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 13 09:46:20.921097 containerd[2478]: time="2026-03-13T09:46:20.920299012Z" level=info msg="Start subscribing containerd event" Mar 13 09:46:20.921097 containerd[2478]: time="2026-03-13T09:46:20.920363460Z" level=info msg="Start recovering state" Mar 13 09:46:20.921097 containerd[2478]: time="2026-03-13T09:46:20.920438900Z" level=info msg="Start event monitor" Mar 13 09:46:20.921097 containerd[2478]: time="2026-03-13T09:46:20.920449988Z" level=info msg="Start cni network conf syncer for default" Mar 13 09:46:20.921097 containerd[2478]: time="2026-03-13T09:46:20.920455132Z" level=info msg="Start streaming server" Mar 13 09:46:20.921097 containerd[2478]: time="2026-03-13T09:46:20.920465020Z" level=info msg="Registered namespace \"k8s.io\" with NRI" Mar 13 09:46:20.921097 containerd[2478]: time="2026-03-13T09:46:20.920470260Z" level=info msg="runtime interface starting up..." Mar 13 09:46:20.921097 containerd[2478]: time="2026-03-13T09:46:20.920474148Z" level=info msg="starting plugins..." Mar 13 09:46:20.921097 containerd[2478]: time="2026-03-13T09:46:20.920488444Z" level=info msg="Synchronizing NRI (plugin) with current runtime state" Mar 13 09:46:20.941655 containerd[2478]: time="2026-03-13T09:46:20.941048124Z" level=info msg=serving... address=/run/containerd/containerd.sock.ttrpc Mar 13 09:46:20.941655 containerd[2478]: time="2026-03-13T09:46:20.941141700Z" level=info msg=serving... address=/run/containerd/containerd.sock Mar 13 09:46:20.946092 containerd[2478]: time="2026-03-13T09:46:20.943848380Z" level=info msg="containerd successfully booted in 1.091707s" Mar 13 09:46:20.944101 systemd[1]: Started containerd.service - containerd container runtime. Mar 13 09:46:20.949354 systemd[1]: Reached target multi-user.target - Multi-User System. Mar 13 09:46:20.957131 systemd[1]: Startup finished in 2.990s (kernel) + 26.394s (initrd) + 19.867s (userspace) = 49.253s. Mar 13 09:46:21.359619 login[2619]: pam_unix(login:session): session opened for user core(uid=500) by core(uid=0) Mar 13 09:46:21.367973 systemd-logind[2450]: New session '1' of user 'core' with class 'user-light' and type 'tty'. Mar 13 09:46:21.370343 systemd[1]: Created slice user-500.slice - User Slice of UID 500. Mar 13 09:46:21.373291 systemd[1]: Starting user-runtime-dir@500.service - User Runtime Directory /run/user/500... Mar 13 09:46:21.417639 systemd[1]: Finished user-runtime-dir@500.service - User Runtime Directory /run/user/500. Mar 13 09:46:21.427674 systemd[1]: Started session-1.scope - Session 1 of User core. Mar 13 09:46:21.488418 waagent[2617]: 2026-03-13T09:46:21.488334Z INFO Daemon Daemon Azure Linux Agent Version: 2.12.0.4 Mar 13 09:46:21.497094 waagent[2617]: 2026-03-13T09:46:21.493133Z INFO Daemon Daemon OS: flatcar 4636.0.101 Mar 13 09:46:21.497460 waagent[2617]: 2026-03-13T09:46:21.497412Z INFO Daemon Daemon Python: 3.12.12 Mar 13 09:46:21.501030 waagent[2617]: 2026-03-13T09:46:21.500972Z INFO Daemon Daemon Run daemon Mar 13 09:46:21.504752 waagent[2617]: 2026-03-13T09:46:21.504704Z INFO Daemon Daemon No RDMA handler exists for distro='Flatcar Container Linux by Kinvolk' version='4636.0.101' Mar 13 09:46:21.511953 waagent[2617]: 2026-03-13T09:46:21.511887Z INFO Daemon Daemon Using waagent for provisioning Mar 13 09:46:21.516466 waagent[2617]: 2026-03-13T09:46:21.516402Z INFO Daemon Daemon Activate resource disk Mar 13 09:46:21.520167 waagent[2617]: 2026-03-13T09:46:21.520112Z INFO Daemon Daemon Searching gen1 prefix 00000000-0001 or gen2 f8b3781a-1e82-4818-a1c3-63d806ec15bb Mar 13 09:46:21.528740 waagent[2617]: 2026-03-13T09:46:21.528678Z INFO Daemon Daemon Found device: None Mar 13 09:46:21.532224 waagent[2617]: 2026-03-13T09:46:21.532167Z ERROR Daemon Daemon Failed to mount resource disk [ResourceDiskError] unable to detect disk topology Mar 13 09:46:21.538519 waagent[2617]: 2026-03-13T09:46:21.538458Z ERROR Daemon Daemon Event: name=WALinuxAgent, op=ActivateResourceDisk, message=[ResourceDiskError] unable to detect disk topology, duration=0 Mar 13 09:46:21.547669 waagent[2617]: 2026-03-13T09:46:21.547613Z INFO Daemon Daemon Clean protocol and wireserver endpoint Mar 13 09:46:21.552127 waagent[2617]: 2026-03-13T09:46:21.552082Z INFO Daemon Daemon Running default provisioning handler Mar 13 09:46:21.562375 waagent[2617]: 2026-03-13T09:46:21.562320Z 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 13 09:46:21.572786 waagent[2617]: 2026-03-13T09:46:21.572729Z INFO Daemon Daemon Unable to get cloud-init enabled status from service: [Errno 2] No such file or directory: 'service' Mar 13 09:46:21.580098 waagent[2617]: 2026-03-13T09:46:21.580024Z INFO Daemon Daemon cloud-init is enabled: False Mar 13 09:46:21.584294 waagent[2617]: 2026-03-13T09:46:21.584230Z INFO Daemon Daemon Copying ovf-env.xml Mar 13 09:46:21.644968 waagent[2617]: 2026-03-13T09:46:21.641573Z INFO Daemon Daemon Successfully mounted dvd Mar 13 09:46:21.698526 login[2620]: pam_unix(login:session): session opened for user core(uid=500) by core(uid=0) Mar 13 09:46:21.703960 systemd-logind[2450]: New session '2' of user 'core' with class 'user-light' and type 'tty'. Mar 13 09:46:21.707238 systemd[1]: Started session-2.scope - Session 2 of User core. Mar 13 09:46:21.769553 systemd[1]: mnt-cdrom-secure.mount: Deactivated successfully. Mar 13 09:46:21.773600 waagent[2617]: 2026-03-13T09:46:21.773342Z INFO Daemon Daemon Detect protocol endpoint Mar 13 09:46:21.778106 waagent[2617]: 2026-03-13T09:46:21.777961Z INFO Daemon Daemon Clean protocol and wireserver endpoint Mar 13 09:46:21.782937 waagent[2617]: 2026-03-13T09:46:21.782876Z INFO Daemon Daemon WireServer endpoint is not found. Rerun dhcp handler Mar 13 09:46:21.789090 waagent[2617]: 2026-03-13T09:46:21.788966Z INFO Daemon Daemon Test for route to 168.63.129.16 Mar 13 09:46:21.794924 waagent[2617]: 2026-03-13T09:46:21.794616Z INFO Daemon Daemon Route to 168.63.129.16 exists Mar 13 09:46:21.799650 waagent[2617]: 2026-03-13T09:46:21.799341Z INFO Daemon Daemon Wire server endpoint:168.63.129.16 Mar 13 09:46:21.871742 waagent[2617]: 2026-03-13T09:46:21.866971Z INFO Daemon Daemon Fabric preferred wire protocol version:2015-04-05 Mar 13 09:46:21.872214 waagent[2617]: 2026-03-13T09:46:21.872190Z INFO Daemon Daemon Wire protocol version:2012-11-30 Mar 13 09:46:21.876541 waagent[2617]: 2026-03-13T09:46:21.876499Z INFO Daemon Daemon Server preferred version:2015-04-05 Mar 13 09:46:21.988115 waagent[2617]: 2026-03-13T09:46:21.987851Z INFO Daemon Daemon Initializing goal state during protocol detection Mar 13 09:46:21.992817 waagent[2617]: 2026-03-13T09:46:21.992768Z INFO Daemon Daemon Forcing an update of the goal state. Mar 13 09:46:22.000568 waagent[2617]: 2026-03-13T09:46:22.000522Z INFO Daemon Fetched a new incarnation for the WireServer goal state [incarnation 1] Mar 13 09:46:22.043622 waagent[2617]: 2026-03-13T09:46:22.043571Z INFO Daemon Daemon HostGAPlugin version: 1.0.8.179 Mar 13 09:46:22.048067 waagent[2617]: 2026-03-13T09:46:22.048024Z INFO Daemon Mar 13 09:46:22.050399 waagent[2617]: 2026-03-13T09:46:22.050365Z INFO Daemon Fetched new vmSettings [HostGAPlugin correlation ID: a9689fd0-1ae9-43fd-9f2d-9da830c7369e eTag: 1975321812980765102 source: Fabric] Mar 13 09:46:22.059225 waagent[2617]: 2026-03-13T09:46:22.059188Z INFO Daemon The vmSettings originated via Fabric; will ignore them. Mar 13 09:46:22.064197 waagent[2617]: 2026-03-13T09:46:22.064161Z INFO Daemon Mar 13 09:46:22.067298 waagent[2617]: 2026-03-13T09:46:22.067267Z INFO Daemon Fetching full goal state from the WireServer [incarnation 1] Mar 13 09:46:22.076680 waagent[2617]: 2026-03-13T09:46:22.076647Z INFO Daemon Daemon Downloading artifacts profile blob Mar 13 09:46:22.201651 waagent[2617]: 2026-03-13T09:46:22.201572Z INFO Daemon Downloaded certificate {'thumbprint': '2D353E12151306C106EBAEB4BA5522E9808EA81A', 'hasPrivateKey': True} Mar 13 09:46:22.209704 waagent[2617]: 2026-03-13T09:46:22.209648Z INFO Daemon Fetch goal state completed Mar 13 09:46:22.248246 waagent[2617]: 2026-03-13T09:46:22.248111Z INFO Daemon Daemon Starting provisioning Mar 13 09:46:22.252494 waagent[2617]: 2026-03-13T09:46:22.252444Z INFO Daemon Daemon Handle ovf-env.xml. Mar 13 09:46:22.256179 waagent[2617]: 2026-03-13T09:46:22.256144Z INFO Daemon Daemon Set hostname [ci-4636.0.101-71662ec14e] Mar 13 09:46:22.262386 waagent[2617]: 2026-03-13T09:46:22.262333Z INFO Daemon Daemon Publish hostname [ci-4636.0.101-71662ec14e] Mar 13 09:46:22.267151 waagent[2617]: 2026-03-13T09:46:22.267110Z INFO Daemon Daemon Examine /proc/net/route for primary interface Mar 13 09:46:22.272160 waagent[2617]: 2026-03-13T09:46:22.272123Z INFO Daemon Daemon Primary interface is [eth0] Mar 13 09:46:22.281982 systemd-networkd[2206]: eth0: Found matching .network file, based on potentially unpredictable interface name: /usr/lib/systemd/network/zz-default.network Mar 13 09:46:22.281991 systemd-networkd[2206]: eth0: Reconfiguring with /usr/lib/systemd/network/zz-default.network. Mar 13 09:46:22.282095 systemd-networkd[2206]: eth0: DHCP lease lost Mar 13 09:46:22.292372 waagent[2617]: 2026-03-13T09:46:22.292295Z INFO Daemon Daemon Create user account if not exists Mar 13 09:46:22.296909 waagent[2617]: 2026-03-13T09:46:22.296852Z INFO Daemon Daemon User core already exists, skip useradd Mar 13 09:46:22.301826 waagent[2617]: 2026-03-13T09:46:22.301776Z INFO Daemon Daemon Configure sudoer Mar 13 09:46:22.308813 waagent[2617]: 2026-03-13T09:46:22.308759Z INFO Daemon Daemon Configure sshd Mar 13 09:46:22.315310 waagent[2617]: 2026-03-13T09:46:22.315256Z INFO Daemon Daemon Added a configuration snippet disabling SSH password-based authentication methods. It also configures SSH client probing to keep connections alive. Mar 13 09:46:22.324733 waagent[2617]: 2026-03-13T09:46:22.324683Z INFO Daemon Daemon Deploy ssh public key. Mar 13 09:46:22.328111 systemd-networkd[2206]: eth0: DHCPv4 address 10.200.20.13/24, gateway 10.200.20.1 acquired from 168.63.129.16 Mar 13 09:46:23.496406 waagent[2617]: 2026-03-13T09:46:23.496357Z INFO Daemon Daemon Provisioning complete Mar 13 09:46:23.509725 waagent[2617]: 2026-03-13T09:46:23.509673Z INFO Daemon Daemon RDMA capabilities are not enabled, skipping Mar 13 09:46:23.514515 waagent[2617]: 2026-03-13T09:46:23.514470Z INFO Daemon Daemon End of log to /dev/console. The agent will now check for updates and then will process extensions. Mar 13 09:46:23.522125 waagent[2617]: 2026-03-13T09:46:23.522081Z INFO Daemon Daemon Installed Agent WALinuxAgent-2.12.0.4 is the most current agent Mar 13 09:46:23.632705 waagent[2704]: 2026-03-13T09:46:23.632179Z INFO ExtHandler ExtHandler Azure Linux Agent (Goal State Agent version 2.12.0.4) Mar 13 09:46:23.632705 waagent[2704]: 2026-03-13T09:46:23.632333Z INFO ExtHandler ExtHandler OS: flatcar 4636.0.101 Mar 13 09:46:23.632705 waagent[2704]: 2026-03-13T09:46:23.632382Z INFO ExtHandler ExtHandler Python: 3.12.12 Mar 13 09:46:23.632705 waagent[2704]: 2026-03-13T09:46:23.632420Z INFO ExtHandler ExtHandler CPU Arch: aarch64 Mar 13 09:46:23.703711 waagent[2704]: 2026-03-13T09:46:23.703645Z INFO ExtHandler ExtHandler Distro: flatcar-4636.0.101; OSUtil: FlatcarUtil; AgentService: waagent; Python: 3.12.12; Arch: aarch64; systemd: True; LISDrivers: Absent; logrotate: logrotate 3.22.0; Mar 13 09:46:23.704096 waagent[2704]: 2026-03-13T09:46:23.704039Z INFO ExtHandler ExtHandler WireServer endpoint 168.63.129.16 read from file Mar 13 09:46:23.704246 waagent[2704]: 2026-03-13T09:46:23.704221Z INFO ExtHandler ExtHandler Wire server endpoint:168.63.129.16 Mar 13 09:46:23.710682 waagent[2704]: 2026-03-13T09:46:23.710632Z INFO ExtHandler Fetched a new incarnation for the WireServer goal state [incarnation 1] Mar 13 09:46:23.717107 waagent[2704]: 2026-03-13T09:46:23.716117Z INFO ExtHandler ExtHandler HostGAPlugin version: 1.0.8.179 Mar 13 09:46:23.717107 waagent[2704]: 2026-03-13T09:46:23.716546Z INFO ExtHandler Mar 13 09:46:23.717107 waagent[2704]: 2026-03-13T09:46:23.716609Z INFO ExtHandler Fetched new vmSettings [HostGAPlugin correlation ID: 8aaf3ec8-d36f-4453-b89f-203b1bce90e3 eTag: 1975321812980765102 source: Fabric] Mar 13 09:46:23.717107 waagent[2704]: 2026-03-13T09:46:23.716814Z INFO ExtHandler The vmSettings originated via Fabric; will ignore them. Mar 13 09:46:23.717322 waagent[2704]: 2026-03-13T09:46:23.717284Z INFO ExtHandler Mar 13 09:46:23.717365 waagent[2704]: 2026-03-13T09:46:23.717348Z INFO ExtHandler Fetching full goal state from the WireServer [incarnation 1] Mar 13 09:46:23.720902 waagent[2704]: 2026-03-13T09:46:23.720872Z INFO ExtHandler ExtHandler Downloading artifacts profile blob Mar 13 09:46:23.785633 waagent[2704]: 2026-03-13T09:46:23.785494Z INFO ExtHandler Downloaded certificate {'thumbprint': '2D353E12151306C106EBAEB4BA5522E9808EA81A', 'hasPrivateKey': True} Mar 13 09:46:23.786000 waagent[2704]: 2026-03-13T09:46:23.785959Z INFO ExtHandler Fetch goal state completed Mar 13 09:46:23.798139 waagent[2704]: 2026-03-13T09:46:23.798066Z INFO ExtHandler ExtHandler OpenSSL version: OpenSSL 3.5.5 27 Jan 2026 (Library: OpenSSL 3.5.5 27 Jan 2026) Mar 13 09:46:23.801331 waagent[2704]: 2026-03-13T09:46:23.801274Z INFO ExtHandler ExtHandler WALinuxAgent-2.12.0.4 running as process 2704 Mar 13 09:46:23.801458 waagent[2704]: 2026-03-13T09:46:23.801428Z INFO ExtHandler ExtHandler ******** AutoUpdate.Enabled is set to False, not processing the operation ******** Mar 13 09:46:23.801740 waagent[2704]: 2026-03-13T09:46:23.801707Z INFO ExtHandler ExtHandler ******** AutoUpdate.UpdateToLatestVersion is set to False, not processing the operation ******** Mar 13 09:46:23.802898 waagent[2704]: 2026-03-13T09:46:23.802858Z INFO ExtHandler ExtHandler [CGI] Cgroup monitoring is not supported on ['flatcar', '4636.0.101', '', 'Flatcar Container Linux by Kinvolk'] Mar 13 09:46:23.803292 waagent[2704]: 2026-03-13T09:46:23.803256Z INFO ExtHandler ExtHandler [CGI] Agent will reset the quotas in case distro: ['flatcar', '4636.0.101', '', 'Flatcar Container Linux by Kinvolk'] went from supported to unsupported Mar 13 09:46:23.803399 waagent[2704]: 2026-03-13T09:46:23.803376Z INFO ExtHandler ExtHandler [CGI] Agent cgroups enabled: False Mar 13 09:46:23.803852 waagent[2704]: 2026-03-13T09:46:23.803819Z INFO ExtHandler ExtHandler Starting setup for Persistent firewall rules Mar 13 09:46:23.838556 waagent[2704]: 2026-03-13T09:46:23.838511Z INFO ExtHandler ExtHandler Firewalld service not running/unavailable, trying to set up waagent-network-setup.service Mar 13 09:46:23.838752 waagent[2704]: 2026-03-13T09:46:23.838721Z INFO ExtHandler ExtHandler Successfully updated the Binary file /var/lib/waagent/waagent-network-setup.py for firewall setup Mar 13 09:46:23.843599 waagent[2704]: 2026-03-13T09:46:23.843554Z INFO ExtHandler ExtHandler Service: waagent-network-setup.service not enabled. Adding it now Mar 13 09:46:23.848550 systemd[1]: Reload requested from client PID 2719 ('systemctl') (unit waagent.service)... Mar 13 09:46:23.848566 systemd[1]: Reloading... Mar 13 09:46:23.938103 zram_generator::config[2770]: No configuration found. Mar 13 09:46:24.092480 systemd[1]: /usr/lib/systemd/system/update-engine.service:10: Support for option BlockIOWeight= has been removed and it is ignored Mar 13 09:46:24.149344 systemd[1]: Reloading finished in 300 ms. Mar 13 09:46:24.172787 waagent[2704]: 2026-03-13T09:46:24.171841Z INFO ExtHandler ExtHandler Successfully added and enabled the waagent-network-setup.service Mar 13 09:46:24.172787 waagent[2704]: 2026-03-13T09:46:24.172013Z INFO ExtHandler ExtHandler Persistent firewall rules setup successfully Mar 13 09:46:24.506044 waagent[2704]: 2026-03-13T09:46:24.505235Z INFO ExtHandler ExtHandler DROP rule is not available which implies no firewall rules are set yet. Environment thread will set it up. Mar 13 09:46:24.506044 waagent[2704]: 2026-03-13T09:46:24.505549Z 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 13 09:46:24.506296 waagent[2704]: 2026-03-13T09:46:24.506248Z INFO ExtHandler ExtHandler Starting env monitor service. Mar 13 09:46:24.506401 waagent[2704]: 2026-03-13T09:46:24.506360Z INFO MonitorHandler ExtHandler WireServer endpoint 168.63.129.16 read from file Mar 13 09:46:24.506518 waagent[2704]: 2026-03-13T09:46:24.506492Z INFO MonitorHandler ExtHandler Wire server endpoint:168.63.129.16 Mar 13 09:46:24.506732 waagent[2704]: 2026-03-13T09:46:24.506701Z INFO MonitorHandler ExtHandler Monitor.NetworkConfigurationChanges is disabled. Mar 13 09:46:24.507141 waagent[2704]: 2026-03-13T09:46:24.507101Z INFO ExtHandler ExtHandler Start SendTelemetryHandler service. Mar 13 09:46:24.507473 waagent[2704]: 2026-03-13T09:46:24.507437Z INFO EnvHandler ExtHandler WireServer endpoint 168.63.129.16 read from file Mar 13 09:46:24.507517 waagent[2704]: 2026-03-13T09:46:24.507506Z INFO EnvHandler ExtHandler Wire server endpoint:168.63.129.16 Mar 13 09:46:24.507635 waagent[2704]: 2026-03-13T09:46:24.507605Z INFO EnvHandler ExtHandler Configure routes Mar 13 09:46:24.507675 waagent[2704]: 2026-03-13T09:46:24.507660Z INFO EnvHandler ExtHandler Gateway:None Mar 13 09:46:24.507707 waagent[2704]: 2026-03-13T09:46:24.507692Z INFO EnvHandler ExtHandler Routes:None Mar 13 09:46:24.508247 waagent[2704]: 2026-03-13T09:46:24.508214Z INFO SendTelemetryHandler ExtHandler Successfully started the SendTelemetryHandler thread Mar 13 09:46:24.508353 waagent[2704]: 2026-03-13T09:46:24.508305Z INFO ExtHandler ExtHandler Start Extension Telemetry service. Mar 13 09:46:24.508433 waagent[2704]: 2026-03-13T09:46:24.508402Z INFO MonitorHandler ExtHandler Routing table from /proc/net/route: Mar 13 09:46:24.508433 waagent[2704]: Iface Destination Gateway Flags RefCnt Use Metric Mask MTU Window IRTT Mar 13 09:46:24.508433 waagent[2704]: eth0 00000000 0114C80A 0003 0 0 1024 00000000 0 0 0 Mar 13 09:46:24.508433 waagent[2704]: eth0 0014C80A 00000000 0001 0 0 1024 00FFFFFF 0 0 0 Mar 13 09:46:24.508433 waagent[2704]: eth0 0114C80A 00000000 0005 0 0 1024 FFFFFFFF 0 0 0 Mar 13 09:46:24.508433 waagent[2704]: eth0 10813FA8 0114C80A 0007 0 0 1024 FFFFFFFF 0 0 0 Mar 13 09:46:24.508433 waagent[2704]: eth0 FEA9FEA9 0114C80A 0007 0 0 1024 FFFFFFFF 0 0 0 Mar 13 09:46:24.509007 waagent[2704]: 2026-03-13T09:46:24.508771Z INFO TelemetryEventsCollector ExtHandler Extension Telemetry pipeline enabled: True Mar 13 09:46:24.509219 waagent[2704]: 2026-03-13T09:46:24.509081Z INFO TelemetryEventsCollector ExtHandler Successfully started the TelemetryEventsCollector thread Mar 13 09:46:24.509219 waagent[2704]: 2026-03-13T09:46:24.509144Z INFO ExtHandler ExtHandler Goal State Period: 6 sec. This indicates how often the agent checks for new goal states and reports status. Mar 13 09:46:24.517284 waagent[2704]: 2026-03-13T09:46:24.517242Z INFO ExtHandler ExtHandler Mar 13 09:46:24.517339 waagent[2704]: 2026-03-13T09:46:24.517325Z INFO ExtHandler ExtHandler ProcessExtensionsGoalState started [incarnation_1 channel: WireServer source: Fabric activity: 170c511b-8065-4e24-ada4-f9fed79ef978 correlation 81140df3-9766-487d-aa58-0c013b37c64e created: 2026-03-13T09:45:05.321289Z] Mar 13 09:46:24.517637 waagent[2704]: 2026-03-13T09:46:24.517597Z INFO ExtHandler ExtHandler No extension handlers found, not processing anything. Mar 13 09:46:24.518092 waagent[2704]: 2026-03-13T09:46:24.518036Z INFO ExtHandler ExtHandler ProcessExtensionsGoalState completed [incarnation_1 0 ms] Mar 13 09:46:24.541675 waagent[2704]: 2026-03-13T09:46:24.541614Z 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 13 09:46:24.541675 waagent[2704]: Try `iptables -h' or 'iptables --help' for more information.) Mar 13 09:46:24.542036 waagent[2704]: 2026-03-13T09:46:24.541997Z INFO ExtHandler ExtHandler [HEARTBEAT] Agent WALinuxAgent-2.12.0.4 is running as the goal state agent [DEBUG HeartbeatCounter: 0;HeartbeatId: 2FF218FF-4F71-4EE2-871D-665CD957A86A;DroppedPackets: -1;UpdateGSErrors: 0;AutoUpdate: 0;UpdateMode: SelfUpdate;] Mar 13 09:46:24.554818 waagent[2704]: 2026-03-13T09:46:24.554755Z INFO MonitorHandler ExtHandler Network interfaces: Mar 13 09:46:24.554818 waagent[2704]: Executing ['ip', '-a', '-o', 'link']: Mar 13 09:46:24.554818 waagent[2704]: 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 13 09:46:24.554818 waagent[2704]: 2: eth0: mtu 1500 qdisc mq state UP mode DEFAULT group default qlen 1000\ link/ether 00:22:48:c2:0b:fc brd ff:ff:ff:ff:ff:ff\ altname enx002248c20bfc Mar 13 09:46:24.554818 waagent[2704]: 3: enP48861s1: mtu 1500 qdisc mq master eth0 state UP mode DEFAULT group default qlen 1000\ link/ether 00:22:48:c2:0b:fc brd ff:ff:ff:ff:ff:ff\ altname enP48861p0s2 Mar 13 09:46:24.554818 waagent[2704]: Executing ['ip', '-4', '-a', '-o', 'address']: Mar 13 09:46:24.554818 waagent[2704]: 1: lo inet 127.0.0.1/8 scope host lo\ valid_lft forever preferred_lft forever Mar 13 09:46:24.554818 waagent[2704]: 2: eth0 inet 10.200.20.13/24 metric 1024 brd 10.200.20.255 scope global eth0\ valid_lft forever preferred_lft forever Mar 13 09:46:24.554818 waagent[2704]: Executing ['ip', '-6', '-a', '-o', 'address']: Mar 13 09:46:24.554818 waagent[2704]: 1: lo inet6 ::1/128 scope host noprefixroute \ valid_lft forever preferred_lft forever Mar 13 09:46:24.554818 waagent[2704]: 2: eth0 inet6 fe80::222:48ff:fec2:bfc/64 scope link proto kernel_ll \ valid_lft forever preferred_lft forever Mar 13 09:46:24.688003 waagent[2704]: 2026-03-13T09:46:24.687926Z INFO EnvHandler ExtHandler Created firewall rules for the Azure Fabric: Mar 13 09:46:24.688003 waagent[2704]: Chain INPUT (policy ACCEPT 0 packets, 0 bytes) Mar 13 09:46:24.688003 waagent[2704]: pkts bytes target prot opt in out source destination Mar 13 09:46:24.688003 waagent[2704]: Chain FORWARD (policy ACCEPT 0 packets, 0 bytes) Mar 13 09:46:24.688003 waagent[2704]: pkts bytes target prot opt in out source destination Mar 13 09:46:24.688003 waagent[2704]: Chain OUTPUT (policy ACCEPT 0 packets, 0 bytes) Mar 13 09:46:24.688003 waagent[2704]: pkts bytes target prot opt in out source destination Mar 13 09:46:24.688003 waagent[2704]: 0 0 ACCEPT tcp -- * * 0.0.0.0/0 168.63.129.16 tcp dpt:53 Mar 13 09:46:24.688003 waagent[2704]: 0 0 ACCEPT tcp -- * * 0.0.0.0/0 168.63.129.16 owner UID match 0 Mar 13 09:46:24.688003 waagent[2704]: 0 0 DROP tcp -- * * 0.0.0.0/0 168.63.129.16 ctstate INVALID,NEW Mar 13 09:46:24.690724 waagent[2704]: 2026-03-13T09:46:24.690671Z INFO EnvHandler ExtHandler Current Firewall rules: Mar 13 09:46:24.690724 waagent[2704]: Chain INPUT (policy ACCEPT 0 packets, 0 bytes) Mar 13 09:46:24.690724 waagent[2704]: pkts bytes target prot opt in out source destination Mar 13 09:46:24.690724 waagent[2704]: Chain FORWARD (policy ACCEPT 0 packets, 0 bytes) Mar 13 09:46:24.690724 waagent[2704]: pkts bytes target prot opt in out source destination Mar 13 09:46:24.690724 waagent[2704]: Chain OUTPUT (policy ACCEPT 0 packets, 0 bytes) Mar 13 09:46:24.690724 waagent[2704]: pkts bytes target prot opt in out source destination Mar 13 09:46:24.690724 waagent[2704]: 0 0 ACCEPT tcp -- * * 0.0.0.0/0 168.63.129.16 tcp dpt:53 Mar 13 09:46:24.690724 waagent[2704]: 0 0 ACCEPT tcp -- * * 0.0.0.0/0 168.63.129.16 owner UID match 0 Mar 13 09:46:24.690724 waagent[2704]: 0 0 DROP tcp -- * * 0.0.0.0/0 168.63.129.16 ctstate INVALID,NEW Mar 13 09:46:24.690980 waagent[2704]: 2026-03-13T09:46:24.690947Z INFO EnvHandler ExtHandler Set block dev timeout: sda with timeout: 300 Mar 13 09:46:40.314385 chronyd[2424]: Selected source PHC0 Mar 13 09:46:51.714572 systemd[1]: Created slice system-sshd.slice - Slice /system/sshd. Mar 13 09:46:51.716168 systemd[1]: Started sshd@0-1-10.200.20.13:22-10.200.16.10:54288.service - OpenSSH per-connection server daemon (10.200.16.10:54288). Mar 13 09:46:52.299384 sshd[2858]: Accepted publickey for core from 10.200.16.10 port 54288 ssh2: RSA SHA256:ceWmYu/7Gp9vJNmI1H7wRrA5lIMdNmAUJ2tUUJgaBbc Mar 13 09:46:52.300543 sshd-session[2858]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Mar 13 09:46:52.319267 systemd[1]: Starting user@500.service - User Manager for UID 500... Mar 13 09:46:52.321788 systemd-logind[2450]: New session '3' of user 'core' with class 'user' and type 'tty'. Mar 13 09:46:52.327284 (systemd)[2862]: pam_unix(systemd-user:session): session opened for user core(uid=500) by core(uid=0) Mar 13 09:46:52.329039 systemd-logind[2450]: New session '4' of user 'core' with class 'manager-early' and type 'unspecified'. Mar 13 09:46:52.513893 systemd[2862]: Queued start job for default target default.target. Mar 13 09:46:52.523833 systemd[2862]: Created slice app.slice - User Application Slice. Mar 13 09:46:52.523865 systemd[2862]: Started systemd-tmpfiles-clean.timer - Daily Cleanup of User's Temporary Directories. Mar 13 09:46:52.523875 systemd[2862]: Reached target machines.target - Virtual Machines and Containers. Mar 13 09:46:52.523919 systemd[2862]: Reached target paths.target - Paths. Mar 13 09:46:52.523935 systemd[2862]: Reached target timers.target - Timers. Mar 13 09:46:52.525131 systemd[2862]: Starting dbus.socket - D-Bus User Message Bus Socket... Mar 13 09:46:52.526014 systemd[2862]: Listening on systemd-ask-password.socket - Query the User Interactively for a Password. Mar 13 09:46:52.528229 systemd[2862]: Starting systemd-tmpfiles-setup.service - Create User Files and Directories... Mar 13 09:46:52.536259 systemd[2862]: Listening on dbus.socket - D-Bus User Message Bus Socket. Mar 13 09:46:52.536323 systemd[2862]: Reached target sockets.target - Sockets. Mar 13 09:46:52.538029 systemd[2862]: Finished systemd-tmpfiles-setup.service - Create User Files and Directories. Mar 13 09:46:52.538131 systemd[2862]: Reached target basic.target - Basic System. Mar 13 09:46:52.538171 systemd[2862]: Reached target default.target - Main User Target. Mar 13 09:46:52.538192 systemd[2862]: Startup finished in 205ms. Mar 13 09:46:52.538358 systemd[1]: Started user@500.service - User Manager for UID 500. Mar 13 09:46:52.541035 systemd[1]: Started session-3.scope - Session 3 of User core. Mar 13 09:46:52.786420 systemd[1]: Started sshd@1-2-10.200.20.13:22-10.200.16.10:54304.service - OpenSSH per-connection server daemon (10.200.16.10:54304). Mar 13 09:46:53.211720 sshd[2876]: Accepted publickey for core from 10.200.16.10 port 54304 ssh2: RSA SHA256:ceWmYu/7Gp9vJNmI1H7wRrA5lIMdNmAUJ2tUUJgaBbc Mar 13 09:46:53.212950 sshd-session[2876]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Mar 13 09:46:53.216932 systemd-logind[2450]: New session '5' of user 'core' with class 'user' and type 'tty'. Mar 13 09:46:53.227235 systemd[1]: Started session-5.scope - Session 5 of User core. Mar 13 09:46:53.449996 sshd[2880]: Connection closed by 10.200.16.10 port 54304 Mar 13 09:46:53.450596 sshd-session[2876]: pam_unix(sshd:session): session closed for user core Mar 13 09:46:53.454248 systemd[1]: sshd@1-2-10.200.20.13:22-10.200.16.10:54304.service: Deactivated successfully. Mar 13 09:46:53.455795 systemd[1]: session-5.scope: Deactivated successfully. Mar 13 09:46:53.457279 systemd-logind[2450]: Session 5 logged out. Waiting for processes to exit. Mar 13 09:46:53.458010 systemd-logind[2450]: Removed session 5. Mar 13 09:46:53.542325 systemd[1]: Started sshd@2-3-10.200.20.13:22-10.200.16.10:54320.service - OpenSSH per-connection server daemon (10.200.16.10:54320). Mar 13 09:46:53.963154 sshd[2886]: Accepted publickey for core from 10.200.16.10 port 54320 ssh2: RSA SHA256:ceWmYu/7Gp9vJNmI1H7wRrA5lIMdNmAUJ2tUUJgaBbc Mar 13 09:46:53.964184 sshd-session[2886]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Mar 13 09:46:53.967952 systemd-logind[2450]: New session '6' of user 'core' with class 'user' and type 'tty'. Mar 13 09:46:53.980445 systemd[1]: Started session-6.scope - Session 6 of User core. Mar 13 09:46:54.194188 sshd[2890]: Connection closed by 10.200.16.10 port 54320 Mar 13 09:46:54.194783 sshd-session[2886]: pam_unix(sshd:session): session closed for user core Mar 13 09:46:54.197881 systemd[1]: sshd@2-3-10.200.20.13:22-10.200.16.10:54320.service: Deactivated successfully. Mar 13 09:46:54.199721 systemd[1]: session-6.scope: Deactivated successfully. Mar 13 09:46:54.200736 systemd-logind[2450]: Session 6 logged out. Waiting for processes to exit. Mar 13 09:46:54.202372 systemd-logind[2450]: Removed session 6. Mar 13 09:46:54.285244 systemd[1]: Started sshd@3-4-10.200.20.13:22-10.200.16.10:54324.service - OpenSSH per-connection server daemon (10.200.16.10:54324). Mar 13 09:46:54.704867 sshd[2896]: Accepted publickey for core from 10.200.16.10 port 54324 ssh2: RSA SHA256:ceWmYu/7Gp9vJNmI1H7wRrA5lIMdNmAUJ2tUUJgaBbc Mar 13 09:46:54.705755 sshd-session[2896]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Mar 13 09:46:54.709500 systemd-logind[2450]: New session '7' of user 'core' with class 'user' and type 'tty'. Mar 13 09:46:54.717404 systemd[1]: Started session-7.scope - Session 7 of User core. Mar 13 09:46:54.938091 sshd[2900]: Connection closed by 10.200.16.10 port 54324 Mar 13 09:46:54.938675 sshd-session[2896]: pam_unix(sshd:session): session closed for user core Mar 13 09:46:54.941698 systemd[1]: sshd@3-4-10.200.20.13:22-10.200.16.10:54324.service: Deactivated successfully. Mar 13 09:46:54.943449 systemd[1]: session-7.scope: Deactivated successfully. Mar 13 09:46:54.944381 systemd-logind[2450]: Session 7 logged out. Waiting for processes to exit. Mar 13 09:46:54.945791 systemd-logind[2450]: Removed session 7. Mar 13 09:46:55.030288 systemd[1]: Started sshd@4-5-10.200.20.13:22-10.200.16.10:54328.service - OpenSSH per-connection server daemon (10.200.16.10:54328). Mar 13 09:46:55.449911 sshd[2906]: Accepted publickey for core from 10.200.16.10 port 54328 ssh2: RSA SHA256:ceWmYu/7Gp9vJNmI1H7wRrA5lIMdNmAUJ2tUUJgaBbc Mar 13 09:46:55.450910 sshd-session[2906]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Mar 13 09:46:55.454490 systemd-logind[2450]: New session '8' of user 'core' with class 'user' and type 'tty'. Mar 13 09:46:55.465225 systemd[1]: Started session-8.scope - Session 8 of User core. Mar 13 09:46:55.765579 sudo[2911]: core : PWD=/home/core ; USER=root ; COMMAND=/usr/sbin/setenforce 1 Mar 13 09:46:55.765801 sudo[2911]: pam_unix(sudo:session): session opened for user root(uid=0) by core(uid=500) Mar 13 09:46:55.793517 sudo[2911]: pam_unix(sudo:session): session closed for user root Mar 13 09:46:55.872269 sshd[2910]: Connection closed by 10.200.16.10 port 54328 Mar 13 09:46:55.871289 sshd-session[2906]: pam_unix(sshd:session): session closed for user core Mar 13 09:46:55.874261 systemd[1]: sshd@4-5-10.200.20.13:22-10.200.16.10:54328.service: Deactivated successfully. Mar 13 09:46:55.876218 systemd[1]: session-8.scope: Deactivated successfully. Mar 13 09:46:55.877774 systemd-logind[2450]: Session 8 logged out. Waiting for processes to exit. Mar 13 09:46:55.879597 systemd-logind[2450]: Removed session 8. Mar 13 09:46:55.972287 systemd[1]: Started sshd@5-6-10.200.20.13:22-10.200.16.10:54338.service - OpenSSH per-connection server daemon (10.200.16.10:54338). Mar 13 09:46:56.396087 sshd[2918]: Accepted publickey for core from 10.200.16.10 port 54338 ssh2: RSA SHA256:ceWmYu/7Gp9vJNmI1H7wRrA5lIMdNmAUJ2tUUJgaBbc Mar 13 09:46:56.397106 sshd-session[2918]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Mar 13 09:46:56.401136 systemd-logind[2450]: New session '9' of user 'core' with class 'user' and type 'tty'. Mar 13 09:46:56.410217 systemd[1]: Started session-9.scope - Session 9 of User core. Mar 13 09:46:56.556732 sudo[2924]: 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 13 09:46:56.556960 sudo[2924]: pam_unix(sudo:session): session opened for user root(uid=0) by core(uid=500) Mar 13 09:46:56.561466 sudo[2924]: pam_unix(sudo:session): session closed for user root Mar 13 09:46:56.567692 sudo[2923]: core : PWD=/home/core ; USER=root ; COMMAND=/usr/sbin/systemctl restart audit-rules Mar 13 09:46:56.567903 sudo[2923]: pam_unix(sudo:session): session opened for user root(uid=0) by core(uid=500) Mar 13 09:46:56.573718 systemd[1]: Starting audit-rules.service - Load Audit Rules... Mar 13 09:46:56.603000 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 13 09:46:56.613264 kernel: kauditd_printk_skb: 84 callbacks suppressed Mar 13 09:46:56.613311 augenrules[2948]: No rules Mar 13 09:46:56.613526 kernel: audit: type=1305 audit(1773395216.603:184): auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 op=remove_rule key=(null) list=5 res=1 Mar 13 09:46:56.603000 audit[2948]: SYSCALL arch=c00000b7 syscall=206 success=yes exit=1056 a0=3 a1=ffffee529520 a2=420 a3=0 items=0 ppid=2929 pid=2948 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 13 09:46:56.616508 systemd[1]: audit-rules.service: Deactivated successfully. Mar 13 09:46:56.616801 systemd[1]: Finished audit-rules.service - Load Audit Rules. Mar 13 09:46:56.631694 kernel: audit: type=1300 audit(1773395216.603:184): arch=c00000b7 syscall=206 success=yes exit=1056 a0=3 a1=ffffee529520 a2=420 a3=0 items=0 ppid=2929 pid=2948 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 13 09:46:56.632990 sudo[2923]: pam_unix(sudo:session): session closed for user root Mar 13 09:46:56.603000 audit: PROCTITLE proctitle=2F7362696E2F617564697463746C002D52002F6574632F61756469742F61756469742E72756C6573 Mar 13 09:46:56.640947 kernel: audit: type=1327 audit(1773395216.603:184): proctitle=2F7362696E2F617564697463746C002D52002F6574632F61756469742F61756469742E72756C6573 Mar 13 09:46:56.614000 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 13 09:46:56.614000 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 13 09:46:56.652670 kernel: audit: type=1130 audit(1773395216.614:185): 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 13 09:46:56.652691 kernel: audit: type=1131 audit(1773395216.614:186): 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 13 09:46:56.631000 audit[2923]: AUDIT1106 pid=2923 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 13 09:46:56.677632 kernel: audit: type=1106 audit(1773395216.631:187): pid=2923 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 13 09:46:56.632000 audit[2923]: AUDIT1104 pid=2923 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 13 09:46:56.690273 kernel: audit: type=1104 audit(1773395216.632:188): pid=2923 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 13 09:46:56.710000 audit[2918]: AUDIT1106 pid=2918 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 13 09:46:56.712034 sshd[2922]: Connection closed by 10.200.16.10 port 54338 Mar 13 09:46:56.710746 sshd-session[2918]: pam_unix(sshd:session): session closed for user core Mar 13 09:46:56.732186 systemd[1]: sshd@5-6-10.200.20.13:22-10.200.16.10:54338.service: Deactivated successfully. Mar 13 09:46:56.710000 audit[2918]: AUDIT1104 pid=2918 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 13 09:46:56.734490 systemd[1]: session-9.scope: Deactivated successfully. Mar 13 09:46:56.745946 kernel: audit: type=1106 audit(1773395216.710:189): pid=2918 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 13 09:46:56.746033 kernel: audit: type=1104 audit(1773395216.710:190): pid=2918 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 13 09:46:56.731000 audit[1]: SERVICE_STOP pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=sshd@5-6-10.200.20.13:22-10.200.16.10:54338 comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Mar 13 09:46:56.760182 kernel: audit: type=1131 audit(1773395216.731:191): pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=sshd@5-6-10.200.20.13:22-10.200.16.10:54338 comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Mar 13 09:46:56.761212 systemd-logind[2450]: Session 9 logged out. Waiting for processes to exit. Mar 13 09:46:56.762142 systemd-logind[2450]: Removed session 9. Mar 13 09:46:56.801000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=sshd@6-7-10.200.20.13:22-10.200.16.10:54348 comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Mar 13 09:46:56.802110 systemd[1]: Started sshd@6-7-10.200.20.13:22-10.200.16.10:54348.service - OpenSSH per-connection server daemon (10.200.16.10:54348). Mar 13 09:46:56.969730 kernel: hv_balloon: Max. dynamic memory size: 4096 MB Mar 13 09:46:57.219000 audit[2957]: AUDIT1101 pid=2957 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 13 09:46:57.221087 sshd[2957]: Accepted publickey for core from 10.200.16.10 port 54348 ssh2: RSA SHA256:ceWmYu/7Gp9vJNmI1H7wRrA5lIMdNmAUJ2tUUJgaBbc Mar 13 09:46:57.220000 audit[2957]: AUDIT1103 pid=2957 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 13 09:46:57.220000 audit[2957]: SYSCALL arch=c00000b7 syscall=64 success=yes exit=3 a0=8 a1=ffffef22f8f0 a2=3 a3=0 items=0 ppid=1 pid=2957 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 13 09:46:57.220000 audit: PROCTITLE proctitle=737368642D73657373696F6E3A20636F7265205B707269765D Mar 13 09:46:57.221933 sshd-session[2957]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Mar 13 09:46:57.225625 systemd-logind[2450]: New session '10' of user 'core' with class 'user' and type 'tty'. Mar 13 09:46:57.240246 systemd[1]: Started session-10.scope - Session 10 of User core. Mar 13 09:46:57.242000 audit[2957]: AUDIT1105 pid=2957 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 13 09:46:57.243000 audit[2961]: AUDIT1103 pid=2961 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 13 09:46:57.379000 audit[2962]: AUDIT1101 pid=2962 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 13 09:46:57.380605 sudo[2962]: core : PWD=/home/core ; USER=root ; COMMAND=/usr/sbin/cryptsetup isLuks /dev/disk/by-partlabel/USR-B Mar 13 09:46:57.379000 audit[2962]: AUDIT1110 pid=2962 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 13 09:46:57.381407 sudo[2962]: pam_unix(sudo:session): session opened for user root(uid=0) by core(uid=500) Mar 13 09:46:57.380000 audit[2962]: AUDIT1105 pid=2962 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 13 09:46:57.464029 sudo[2962]: pam_unix(sudo:session): session closed for user root Mar 13 09:46:57.464000 audit[2962]: AUDIT1106 pid=2962 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 13 09:46:57.464000 audit[2962]: AUDIT1104 pid=2962 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 13 09:46:57.542957 sshd[2961]: Connection closed by 10.200.16.10 port 54348 Mar 13 09:46:57.541907 sshd-session[2957]: pam_unix(sshd:session): session closed for user core Mar 13 09:46:57.542000 audit[2957]: AUDIT1106 pid=2957 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 13 09:46:57.542000 audit[2957]: AUDIT1104 pid=2957 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 13 09:46:57.544807 systemd[1]: sshd@6-7-10.200.20.13:22-10.200.16.10:54348.service: Deactivated successfully. Mar 13 09:46:57.545000 audit[1]: SERVICE_STOP pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=sshd@6-7-10.200.20.13:22-10.200.16.10:54348 comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Mar 13 09:46:57.546966 systemd[1]: session-10.scope: Deactivated successfully. Mar 13 09:46:57.549005 systemd-logind[2450]: Session 10 logged out. Waiting for processes to exit. Mar 13 09:46:57.549994 systemd-logind[2450]: Removed session 10. Mar 13 09:46:57.633143 systemd[1]: Started sshd@7-8-10.200.20.13:22-10.200.16.10:54358.service - OpenSSH per-connection server daemon (10.200.16.10:54358). Mar 13 09:46:57.633000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=sshd@7-8-10.200.20.13:22-10.200.16.10:54358 comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Mar 13 09:46:58.055000 audit[2969]: AUDIT1101 pid=2969 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 13 09:46:58.055318 sshd[2969]: Accepted publickey for core from 10.200.16.10 port 54358 ssh2: RSA SHA256:ceWmYu/7Gp9vJNmI1H7wRrA5lIMdNmAUJ2tUUJgaBbc Mar 13 09:46:58.056000 audit[2969]: AUDIT1103 pid=2969 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 13 09:46:58.056000 audit[2969]: SYSCALL arch=c00000b7 syscall=64 success=yes exit=3 a0=8 a1=ffffd2b15ae0 a2=3 a3=0 items=0 ppid=1 pid=2969 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 13 09:46:58.056000 audit: PROCTITLE proctitle=737368642D73657373696F6E3A20636F7265205B707269765D Mar 13 09:46:58.056772 sshd-session[2969]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Mar 13 09:46:58.060493 systemd-logind[2450]: New session '11' of user 'core' with class 'user' and type 'tty'. Mar 13 09:46:58.068394 systemd[1]: Started session-11.scope - Session 11 of User core. Mar 13 09:46:58.070000 audit[2969]: AUDIT1105 pid=2969 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 13 09:46:58.072000 audit[2973]: AUDIT1103 pid=2973 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 13 09:46:58.291055 sshd[2973]: Connection closed by 10.200.16.10 port 54358 Mar 13 09:46:58.291854 sshd-session[2969]: pam_unix(sshd:session): session closed for user core Mar 13 09:46:58.292000 audit[2969]: AUDIT1106 pid=2969 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 13 09:46:58.292000 audit[2969]: AUDIT1104 pid=2969 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 13 09:46:58.294582 systemd[1]: sshd@7-8-10.200.20.13:22-10.200.16.10:54358.service: Deactivated successfully. Mar 13 09:46:58.294000 audit[1]: SERVICE_STOP pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=sshd@7-8-10.200.20.13:22-10.200.16.10:54358 comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Mar 13 09:46:58.296769 systemd[1]: session-11.scope: Deactivated successfully. Mar 13 09:46:58.298836 systemd-logind[2450]: Session 11 logged out. Waiting for processes to exit. Mar 13 09:46:58.299909 systemd-logind[2450]: Removed session 11.