Oct 27 23:32:18.843701 kernel: Booting Linux on physical CPU 0x0000000000 [0x410fd490] Oct 27 23:32:18.843723 kernel: Linux version 6.12.114-flatcar (build@pony-truck.infra.kinvolk.io) (aarch64-cros-linux-gnu-gcc (Gentoo Hardened 15.3.0 p8) 15.3.0, GNU ld (Gentoo 2.46.1 p1) 2.46.1) #1 SMP PREEMPT Tue Oct 27 21:52:41 -00 2026 Oct 27 23:32:18.843730 kernel: KASLR enabled Oct 27 23:32:18.843734 kernel: earlycon: pl11 at MMIO 0x00000000effec000 (options '') Oct 27 23:32:18.843738 kernel: printk: legacy bootconsole [pl11] enabled Oct 27 23:32:18.843742 kernel: efi: EFI v2.7 by EDK II Oct 27 23:32:18.843748 kernel: efi: ACPI 2.0=0x3f979018 SMBIOS=0x3f8a0000 SMBIOS 3.0=0x3f880000 MEMATTR=0x3e3c7018 RNG=0x3f979998 MEMRESERVE=0x3db7b718 Oct 27 23:32:18.843752 kernel: random: crng init done Oct 27 23:32:18.843756 kernel: secureboot: Secure boot disabled Oct 27 23:32:18.843760 kernel: ACPI: Early table checksum verification disabled Oct 27 23:32:18.843764 kernel: ACPI: RSDP 0x000000003F979018 000024 (v02 VRTUAL) Oct 27 23:32:18.843768 kernel: ACPI: XSDT 0x000000003F979F18 00006C (v01 VRTUAL MICROSFT 00000001 MSFT 00000001) Oct 27 23:32:18.843773 kernel: ACPI: FACP 0x000000003F979C18 000114 (v06 VRTUAL MICROSFT 00000001 MSFT 00000001) Oct 27 23:32:18.843777 kernel: ACPI: DSDT 0x000000003F95A018 01E046 (v02 MSFTVM DSDT01 00000001 INTL 20230628) Oct 27 23:32:18.843783 kernel: ACPI: DBG2 0x000000003F979B18 000072 (v00 VRTUAL MICROSFT 00000001 MSFT 00000001) Oct 27 23:32:18.843787 kernel: ACPI: GTDT 0x000000003F979D98 000060 (v02 VRTUAL MICROSFT 00000001 MSFT 00000001) Oct 27 23:32:18.843792 kernel: ACPI: OEM0 0x000000003F979098 000064 (v01 VRTUAL MICROSFT 00000001 MSFT 00000001) Oct 27 23:32:18.843796 kernel: ACPI: SPCR 0x000000003F979A98 000050 (v02 VRTUAL MICROSFT 00000001 MSFT 00000001) Oct 27 23:32:18.843800 kernel: ACPI: APIC 0x000000003F979818 0000FC (v04 VRTUAL MICROSFT 00000001 MSFT 00000001) Oct 27 23:32:18.843804 kernel: ACPI: SRAT 0x000000003F979198 000234 (v03 VRTUAL MICROSFT 00000001 MSFT 00000001) Oct 27 23:32:18.843810 kernel: ACPI: PPTT 0x000000003F979418 00012C (v01 VRTUAL MICROSFT 00000000 MSFT 00000000) Oct 27 23:32:18.843814 kernel: ACPI: BGRT 0x000000003F979E98 000038 (v01 VRTUAL MICROSFT 00000001 MSFT 00000001) Oct 27 23:32:18.843818 kernel: ACPI: SPCR: console: pl011,mmio32,0xeffec000,115200 Oct 27 23:32:18.843823 kernel: ACPI: Use ACPI SPCR as default console: Yes Oct 27 23:32:18.843827 kernel: ACPI: SRAT: Node 0 PXM 0 [mem 0x00000000-0x3fffffff] hotplug Oct 27 23:32:18.843832 kernel: ACPI: SRAT: Node 0 PXM 0 [mem 0x100000000-0x1bfffffff] hotplug Oct 27 23:32:18.843836 kernel: ACPI: SRAT: Node 0 PXM 0 [mem 0x1c0000000-0xfbfffffff] hotplug Oct 27 23:32:18.843840 kernel: ACPI: SRAT: Node 0 PXM 0 [mem 0x1000000000-0xffffffffff] hotplug Oct 27 23:32:18.843845 kernel: ACPI: SRAT: Node 0 PXM 0 [mem 0x10000000000-0x1ffffffffff] hotplug Oct 27 23:32:18.843849 kernel: ACPI: SRAT: Node 0 PXM 0 [mem 0x20000000000-0x3ffffffffff] hotplug Oct 27 23:32:18.843853 kernel: ACPI: SRAT: Node 0 PXM 0 [mem 0x40000000000-0x7ffffffffff] hotplug Oct 27 23:32:18.843858 kernel: ACPI: SRAT: Node 0 PXM 0 [mem 0x80000000000-0xfffffffffff] hotplug Oct 27 23:32:18.843863 kernel: ACPI: SRAT: Node 0 PXM 0 [mem 0x100000000000-0x1fffffffffff] hotplug Oct 27 23:32:18.843867 kernel: ACPI: SRAT: Node 0 PXM 0 [mem 0x200000000000-0x3fffffffffff] hotplug Oct 27 23:32:18.843871 kernel: ACPI: SRAT: Node 0 PXM 0 [mem 0x400000000000-0x7fffffffffff] hotplug Oct 27 23:32:18.843876 kernel: ACPI: SRAT: Node 0 PXM 0 [mem 0x800000000000-0xffffffffffff] hotplug Oct 27 23:32:18.843880 kernel: NUMA: Node 0 [mem 0x00000000-0x3fffffff] + [mem 0x100000000-0x1bfffffff] -> [mem 0x00000000-0x1bfffffff] Oct 27 23:32:18.843884 kernel: NODE_DATA(0) allocated [mem 0x1bf800a00-0x1bf807fff] Oct 27 23:32:18.843889 kernel: Zone ranges: Oct 27 23:32:18.843893 kernel: DMA [mem 0x0000000000000000-0x00000000ffffffff] Oct 27 23:32:18.843900 kernel: DMA32 empty Oct 27 23:32:18.843905 kernel: Normal [mem 0x0000000100000000-0x00000001bfffffff] Oct 27 23:32:18.843909 kernel: Device empty Oct 27 23:32:18.843914 kernel: Movable zone start for each node Oct 27 23:32:18.843918 kernel: Early memory node ranges Oct 27 23:32:18.843924 kernel: node 0: [mem 0x0000000000000000-0x00000000007fffff] Oct 27 23:32:18.843928 kernel: node 0: [mem 0x0000000000824000-0x000000003f38ffff] Oct 27 23:32:18.843933 kernel: node 0: [mem 0x000000003f390000-0x000000003f943fff] Oct 27 23:32:18.843937 kernel: node 0: [mem 0x000000003f944000-0x000000003f9effff] Oct 27 23:32:18.843941 kernel: node 0: [mem 0x000000003f9f0000-0x000000003fdeffff] Oct 27 23:32:18.843946 kernel: node 0: [mem 0x000000003fdf0000-0x000000003fffffff] Oct 27 23:32:18.843950 kernel: node 0: [mem 0x0000000100000000-0x00000001bfffffff] Oct 27 23:32:18.843955 kernel: Initmem setup node 0 [mem 0x0000000000000000-0x00000001bfffffff] Oct 27 23:32:18.843959 kernel: On node 0, zone DMA: 36 pages in unavailable ranges Oct 27 23:32:18.843964 kernel: cma: Reserved 16 MiB at 0x000000003ca00000 on node -1 Oct 27 23:32:18.843968 kernel: psci: probing for conduit method from ACPI. Oct 27 23:32:18.843973 kernel: psci: PSCIv1.3 detected in firmware. Oct 27 23:32:18.843978 kernel: psci: Using standard PSCI v0.2 function IDs Oct 27 23:32:18.843982 kernel: psci: MIGRATE_INFO_TYPE not supported. Oct 27 23:32:18.843987 kernel: psci: SMC Calling Convention v1.4 Oct 27 23:32:18.843991 kernel: ACPI: NUMA: SRAT: PXM 0 -> MPIDR 0x0 -> Node 0 Oct 27 23:32:18.843996 kernel: ACPI: NUMA: SRAT: PXM 0 -> MPIDR 0x1 -> Node 0 Oct 27 23:32:18.844000 kernel: percpu: Embedded 34 pages/cpu s98968 r8192 d32104 u139264 Oct 27 23:32:18.844005 kernel: pcpu-alloc: s98968 r8192 d32104 u139264 alloc=34*4096 Oct 27 23:32:18.844009 kernel: pcpu-alloc: [0] 0 [0] 1 Oct 27 23:32:18.844014 kernel: Detected PIPT I-cache on CPU0 Oct 27 23:32:18.844018 kernel: CPU features: detected: Address authentication (architected QARMA5 algorithm) Oct 27 23:32:18.844023 kernel: CPU features: detected: GIC system register CPU interface Oct 27 23:32:18.844028 kernel: CPU features: detected: Spectre-v4 Oct 27 23:32:18.844032 kernel: CPU features: detected: Spectre-BHB Oct 27 23:32:18.844037 kernel: CPU features: kernel page table isolation forced ON by KASLR Oct 27 23:32:18.844041 kernel: CPU features: detected: Kernel page table isolation (KPTI) Oct 27 23:32:18.844046 kernel: CPU features: detected: ARM erratum 2067961 or 2054223 Oct 27 23:32:18.844050 kernel: CPU features: detected: Broken broadcast TLBI completion Oct 27 23:32:18.844055 kernel: CPU features: detected: SSBS not fully self-synchronizing Oct 27 23:32:18.844059 kernel: alternatives: applying boot alternatives Oct 27 23:32:18.844064 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=3b76b6334d5c2649de42cdb5c1f5f44f2461fa52aac368b65392fc748ae399d4 Oct 27 23:32:18.844070 kernel: Dentry cache hash table entries: 524288 (order: 10, 4194304 bytes, linear) Oct 27 23:32:18.844075 kernel: Inode-cache hash table entries: 262144 (order: 9, 2097152 bytes, linear) Oct 27 23:32:18.844079 kernel: Fallback order for Node 0: 0 Oct 27 23:32:18.844084 kernel: Built 1 zonelists, mobility grouping on. Total pages: 1048540 Oct 27 23:32:18.844088 kernel: Policy zone: Normal Oct 27 23:32:18.844092 kernel: mem auto-init: stack:off, heap alloc:off, heap free:off Oct 27 23:32:18.844097 kernel: software IO TLB: area num 2. Oct 27 23:32:18.844101 kernel: software IO TLB: mapped [mem 0x0000000034aa0000-0x0000000038aa0000] (64MB) Oct 27 23:32:18.844106 kernel: SLUB: HWalign=64, Order=0-3, MinObjects=0, CPUs=2, Nodes=1 Oct 27 23:32:18.844110 kernel: ftrace: allocating 41447 entries in 164 pages Oct 27 23:32:18.844115 kernel: ftrace: allocated 164 pages with 3 groups Oct 27 23:32:18.844120 kernel: rcu: Preemptible hierarchical RCU implementation. Oct 27 23:32:18.844126 kernel: rcu: RCU event tracing is enabled. Oct 27 23:32:18.844130 kernel: rcu: RCU restricting CPUs from NR_CPUS=512 to nr_cpu_ids=2. Oct 27 23:32:18.844135 kernel: Trampoline variant of Tasks RCU enabled. Oct 27 23:32:18.844139 kernel: Rude variant of Tasks RCU enabled. Oct 27 23:32:18.844144 kernel: Tracing variant of Tasks RCU enabled. Oct 27 23:32:18.844148 kernel: rcu: RCU calculated value of scheduler-enlistment delay is 100 jiffies. Oct 27 23:32:18.844153 kernel: rcu: Adjusting geometry for rcu_fanout_leaf=16, nr_cpu_ids=2 Oct 27 23:32:18.844157 kernel: RCU Tasks: Setting shift to 1 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=2. Oct 27 23:32:18.844162 kernel: RCU Tasks Rude: Setting shift to 1 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=2. Oct 27 23:32:18.844166 kernel: RCU Tasks Trace: Setting shift to 1 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=2. Oct 27 23:32:18.844172 kernel: NR_IRQS: 64, nr_irqs: 64, preallocated irqs: 0 Oct 27 23:32:18.844176 kernel: GICv3: 960 SPIs implemented Oct 27 23:32:18.844181 kernel: GICv3: 0 Extended SPIs implemented Oct 27 23:32:18.844185 kernel: Root IRQ handler: gic_handle_irq Oct 27 23:32:18.844190 kernel: GICv3: GICv3 features: 16 PPIs, RSS Oct 27 23:32:18.844194 kernel: GICv3: GICD_CTRL.DS=0, SCR_EL3.FIQ=0 Oct 27 23:32:18.844199 kernel: GICv3: CPU0: found redistributor 0 region 0:0x00000000effee000 Oct 27 23:32:18.844203 kernel: ITS: No ITS available, not enabling LPIs Oct 27 23:32:18.844208 kernel: rcu: srcu_init: Setting srcu_struct sizes based on contention. Oct 27 23:32:18.844212 kernel: clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1911260446275000 ns Oct 27 23:32:18.844217 kernel: arch_timer: cp15 timer(s) running at 1000.00MHz (virt). Oct 27 23:32:18.844222 kernel: clocksource: arch_sys_counter: mask: 0x1fffffffffffffff max_cycles: 0x1cd42e4dffb, max_idle_ns: 881590591483 ns Oct 27 23:32:18.844227 kernel: sched_clock: 61 bits at 1000MHz, resolution 1ns, wraps every 4398046511103ns Oct 27 23:32:18.844231 kernel: Console: colour dummy device 80x25 Oct 27 23:32:18.844236 kernel: printk: legacy console [tty1] enabled Oct 27 23:32:18.844241 kernel: ACPI: Core revision 20240827 Oct 27 23:32:18.844246 kernel: Calibrating delay loop (skipped), value calculated using timer frequency.. 2000.00 BogoMIPS (lpj=1000000) Oct 27 23:32:18.844251 kernel: pid_max: default: 32768 minimum: 301 Oct 27 23:32:18.844256 kernel: LSM: initializing lsm=lockdown,capability,landlock,selinux,ima Oct 27 23:32:18.844265 kernel: landlock: Up and running. Oct 27 23:32:18.844270 kernel: SELinux: Initializing. Oct 27 23:32:18.844276 kernel: Mount-cache hash table entries: 8192 (order: 4, 65536 bytes, linear) Oct 27 23:32:18.844281 kernel: Mountpoint-cache hash table entries: 8192 (order: 4, 65536 bytes, linear) Oct 27 23:32:18.844286 kernel: Hyper-V: privilege flags low 0x2e7f, high 0x3b8030, hints 0xa0000e, misc 0x31e1 Oct 27 23:32:18.844291 kernel: Hyper-V: Host Build 10.0.26102.3704-3-0 Oct 27 23:32:18.844296 kernel: Hyper-V: enabling crash_kexec_post_notifiers Oct 27 23:32:18.844302 kernel: rcu: Hierarchical SRCU implementation. Oct 27 23:32:18.844307 kernel: rcu: Max phase no-delay instances is 400. Oct 27 23:32:18.844312 kernel: Timer migration: 1 hierarchy levels; 8 children per group; 1 crossnode level Oct 27 23:32:18.844317 kernel: Remapping and enabling EFI services. Oct 27 23:32:18.844322 kernel: smp: Bringing up secondary CPUs ... Oct 27 23:32:18.844327 kernel: Detected PIPT I-cache on CPU1 Oct 27 23:32:18.844332 kernel: GICv3: CPU1: found redistributor 1 region 1:0x00000000f000e000 Oct 27 23:32:18.844338 kernel: CPU1: Booted secondary processor 0x0000000001 [0x410fd490] Oct 27 23:32:18.844343 kernel: smp: Brought up 1 node, 2 CPUs Oct 27 23:32:18.844347 kernel: SMP: Total of 2 processors activated. Oct 27 23:32:18.844352 kernel: CPU: All CPU(s) started at EL1 Oct 27 23:32:18.844357 kernel: CPU features: detected: 32-bit EL0 Support Oct 27 23:32:18.844362 kernel: CPU features: detected: Instruction cache invalidation not required for I/D coherence Oct 27 23:32:18.844367 kernel: CPU features: detected: Data cache clean to the PoU not required for I/D coherence Oct 27 23:32:18.844373 kernel: CPU features: detected: Common not Private translations Oct 27 23:32:18.844378 kernel: CPU features: detected: CRC32 instructions Oct 27 23:32:18.844383 kernel: CPU features: detected: Generic authentication (architected QARMA5 algorithm) Oct 27 23:32:18.844388 kernel: CPU features: detected: RCpc load-acquire (LDAPR) Oct 27 23:32:18.844393 kernel: CPU features: detected: LSE atomic instructions Oct 27 23:32:18.844398 kernel: CPU features: detected: Privileged Access Never Oct 27 23:32:18.844403 kernel: CPU features: detected: Speculation barrier (SB) Oct 27 23:32:18.844409 kernel: CPU features: detected: TLB range maintenance instructions Oct 27 23:32:18.844414 kernel: CPU features: detected: Speculative Store Bypassing Safe (SSBS) Oct 27 23:32:18.844419 kernel: CPU features: detected: Scalable Vector Extension Oct 27 23:32:18.844423 kernel: alternatives: applying system-wide alternatives Oct 27 23:32:18.844428 kernel: CPU features: detected: Hardware dirty bit management on CPU0-1 Oct 27 23:32:18.844433 kernel: SVE: maximum available vector length 16 bytes per vector Oct 27 23:32:18.844438 kernel: SVE: default vector length 16 bytes per vector Oct 27 23:32:18.844444 kernel: Memory: 3976216K/4194160K available (12544K kernel code, 2482K rwdata, 9544K rodata, 13504K init, 1040K bss, 195992K reserved, 16384K cma-reserved) Oct 27 23:32:18.844449 kernel: devtmpfs: initialized Oct 27 23:32:18.844454 kernel: futex hash table entries: 512 (order: 3, 32768 bytes, linear) Oct 27 23:32:18.844459 kernel: 2G module region forced by RANDOMIZE_MODULE_REGION_FULL Oct 27 23:32:18.844464 kernel: 0 pages in range for non-PLT usage Oct 27 23:32:18.844469 kernel: 514448 pages in range for PLT usage Oct 27 23:32:18.844474 kernel: pinctrl core: initialized pinctrl subsystem Oct 27 23:32:18.844480 kernel: SMBIOS 3.1.0 present. Oct 27 23:32:18.844485 kernel: DMI: Microsoft Corporation Virtual Machine/Virtual Machine, BIOS Hyper-V UEFI Release v4.1 04/22/2026 Oct 27 23:32:18.844490 kernel: DMI: Memory slots populated: 2/2 Oct 27 23:32:18.844495 kernel: NET: Registered PF_NETLINK/PF_ROUTE protocol family Oct 27 23:32:18.844499 kernel: DMA: preallocated 512 KiB GFP_KERNEL pool for atomic allocations Oct 27 23:32:18.844504 kernel: DMA: preallocated 512 KiB GFP_KERNEL|GFP_DMA pool for atomic allocations Oct 27 23:32:18.844510 kernel: DMA: preallocated 512 KiB GFP_KERNEL|GFP_DMA32 pool for atomic allocations Oct 27 23:32:18.844515 kernel: audit: initializing netlink subsys (disabled) Oct 27 23:32:18.844520 kernel: audit: type=2000 audit(0.059:1): state=initialized audit_enabled=0 res=1 Oct 27 23:32:18.844525 kernel: thermal_sys: Registered thermal governor 'step_wise' Oct 27 23:32:18.844530 kernel: cpuidle: using governor menu Oct 27 23:32:18.844535 kernel: hw-breakpoint: found 6 breakpoint and 4 watchpoint registers. Oct 27 23:32:18.844540 kernel: ASID allocator initialised with 32768 entries Oct 27 23:32:18.844545 kernel: acpiphp: ACPI Hot Plug PCI Controller Driver version: 0.5 Oct 27 23:32:18.844551 kernel: Serial: AMBA PL011 UART driver Oct 27 23:32:18.844556 kernel: HugeTLB: registered 1.00 GiB page size, pre-allocated 0 pages Oct 27 23:32:18.844561 kernel: HugeTLB: 0 KiB vmemmap can be freed for a 1.00 GiB page Oct 27 23:32:18.844566 kernel: HugeTLB: registered 32.0 MiB page size, pre-allocated 0 pages Oct 27 23:32:18.844571 kernel: HugeTLB: 0 KiB vmemmap can be freed for a 32.0 MiB page Oct 27 23:32:18.844576 kernel: HugeTLB: registered 2.00 MiB page size, pre-allocated 0 pages Oct 27 23:32:18.844581 kernel: HugeTLB: 0 KiB vmemmap can be freed for a 2.00 MiB page Oct 27 23:32:18.844586 kernel: HugeTLB: registered 64.0 KiB page size, pre-allocated 0 pages Oct 27 23:32:18.844591 kernel: HugeTLB: 0 KiB vmemmap can be freed for a 64.0 KiB page Oct 27 23:32:18.844596 kernel: ACPI: Added _OSI(Module Device) Oct 27 23:32:18.844611 kernel: ACPI: Added _OSI(Processor Device) Oct 27 23:32:18.844617 kernel: ACPI: Added _OSI(Processor Aggregator Device) Oct 27 23:32:18.844622 kernel: ACPI: 1 ACPI AML tables successfully acquired and loaded Oct 27 23:32:18.844626 kernel: ACPI: Interpreter enabled Oct 27 23:32:18.844631 kernel: ACPI: Using GIC for interrupt routing Oct 27 23:32:18.844638 kernel: ARMH0011:00: ttyAMA0 at MMIO 0xeffec000 (irq = 12, base_baud = 0) is a SBSA Oct 27 23:32:18.844643 kernel: printk: legacy console [ttyAMA0] enabled Oct 27 23:32:18.844648 kernel: printk: legacy bootconsole [pl11] disabled Oct 27 23:32:18.844653 kernel: ARMH0011:01: ttyAMA1 at MMIO 0xeffeb000 (irq = 13, base_baud = 0) is a SBSA Oct 27 23:32:18.844658 kernel: ACPI: CPU0 has been hot-added Oct 27 23:32:18.844662 kernel: ACPI: CPU1 has been hot-added Oct 27 23:32:18.844667 kernel: iommu: Default domain type: Translated Oct 27 23:32:18.844673 kernel: iommu: DMA domain TLB invalidation policy: strict mode Oct 27 23:32:18.844678 kernel: efivars: Registered efivars operations Oct 27 23:32:18.844683 kernel: vgaarb: loaded Oct 27 23:32:18.844688 kernel: clocksource: Switched to clocksource arch_sys_counter Oct 27 23:32:18.844693 kernel: VFS: Disk quotas dquot_6.6.0 Oct 27 23:32:18.844697 kernel: VFS: Dquot-cache hash table entries: 512 (order 0, 4096 bytes) Oct 27 23:32:18.844702 kernel: pnp: PnP ACPI init Oct 27 23:32:18.844708 kernel: pnp: PnP ACPI: found 0 devices Oct 27 23:32:18.844713 kernel: NET: Registered PF_INET protocol family Oct 27 23:32:18.844718 kernel: IP idents hash table entries: 65536 (order: 7, 524288 bytes, linear) Oct 27 23:32:18.844723 kernel: tcp_listen_portaddr_hash hash table entries: 2048 (order: 3, 32768 bytes, linear) Oct 27 23:32:18.844728 kernel: Table-perturb hash table entries: 65536 (order: 6, 262144 bytes, linear) Oct 27 23:32:18.844733 kernel: TCP established hash table entries: 32768 (order: 6, 262144 bytes, linear) Oct 27 23:32:18.844738 kernel: TCP bind hash table entries: 32768 (order: 8, 1048576 bytes, linear) Oct 27 23:32:18.844744 kernel: TCP: Hash tables configured (established 32768 bind 32768) Oct 27 23:32:18.844748 kernel: UDP hash table entries: 2048 (order: 4, 65536 bytes, linear) Oct 27 23:32:18.844753 kernel: UDP-Lite hash table entries: 2048 (order: 4, 65536 bytes, linear) Oct 27 23:32:18.844758 kernel: NET: Registered PF_UNIX/PF_LOCAL protocol family Oct 27 23:32:18.844763 kernel: PCI: CLS 0 bytes, default 64 Oct 27 23:32:18.844768 kernel: kvm [1]: HYP mode not available Oct 27 23:32:18.844773 kernel: Initialise system trusted keyrings Oct 27 23:32:18.844779 kernel: workingset: timestamp_bits=39 max_order=20 bucket_order=0 Oct 27 23:32:18.844784 kernel: Key type asymmetric registered Oct 27 23:32:18.844789 kernel: Asymmetric key parser 'x509' registered Oct 27 23:32:18.844794 kernel: Block layer SCSI generic (bsg) driver version 0.4 loaded (major 249) Oct 27 23:32:18.844799 kernel: io scheduler mq-deadline registered Oct 27 23:32:18.844804 kernel: io scheduler kyber registered Oct 27 23:32:18.844809 kernel: io scheduler bfq registered Oct 27 23:32:18.844814 kernel: Serial: 8250/16550 driver, 4 ports, IRQ sharing enabled Oct 27 23:32:18.844819 kernel: ACPI: bus type drm_connector registered Oct 27 23:32:18.844824 kernel: thunder_xcv, ver 1.0 Oct 27 23:32:18.844829 kernel: thunder_bgx, ver 1.0 Oct 27 23:32:18.844834 kernel: nicpf, ver 1.0 Oct 27 23:32:18.844839 kernel: nicvf, ver 1.0 Oct 27 23:32:18.844976 kernel: rtc-efi rtc-efi.0: registered as rtc0 Oct 27 23:32:18.845049 kernel: rtc-efi rtc-efi.0: setting system clock to 2026-10-27T23:32:14 UTC (1793143934) Oct 27 23:32:18.845055 kernel: efifb: probing for efifb Oct 27 23:32:18.845060 kernel: efifb: framebuffer at 0x40000000, using 3072k, total 3072k Oct 27 23:32:18.845065 kernel: efifb: mode is 1024x768x32, linelength=4096, pages=1 Oct 27 23:32:18.845070 kernel: efifb: scrolling: redraw Oct 27 23:32:18.845075 kernel: efifb: Truecolor: size=8:8:8:8, shift=24:16:8:0 Oct 27 23:32:18.845080 kernel: Console: switching to colour frame buffer device 128x48 Oct 27 23:32:18.845086 kernel: fb0: EFI VGA frame buffer device Oct 27 23:32:18.845091 kernel: SMCCC: SOC_ID: ARCH_SOC_ID not implemented, skipping .... Oct 27 23:32:18.845096 kernel: hid: raw HID events driver (C) Jiri Kosina Oct 27 23:32:18.845101 kernel: hw perfevents: enabled with armv8_pmuv3_0 PMU driver, 7 (0,8000003f) counters available Oct 27 23:32:18.845106 kernel: watchdog: NMI not fully supported Oct 27 23:32:18.845111 kernel: watchdog: Hard watchdog permanently disabled Oct 27 23:32:18.845116 kernel: NET: Registered PF_INET6 protocol family Oct 27 23:32:18.845122 kernel: Segment Routing with IPv6 Oct 27 23:32:18.845127 kernel: In-situ OAM (IOAM) with IPv6 Oct 27 23:32:18.845132 kernel: NET: Registered PF_PACKET protocol family Oct 27 23:32:18.845137 kernel: Key type dns_resolver registered Oct 27 23:32:18.845142 kernel: registered taskstats version 1 Oct 27 23:32:18.845147 kernel: Loading compiled-in X.509 certificates Oct 27 23:32:18.845152 kernel: Loaded X.509 cert 'Kinvolk GmbH: Module signing key for 6.12.114-flatcar: da60c54995d3d382bbc92c4e4fce2e5ead00b21d' Oct 27 23:32:18.845158 kernel: Demotion targets for Node 0: null Oct 27 23:32:18.845163 kernel: Key type .fscrypt registered Oct 27 23:32:18.845168 kernel: Key type fscrypt-provisioning registered Oct 27 23:32:18.845172 kernel: integrity: secureboot mode disabled Oct 27 23:32:18.845177 kernel: ima: No TPM chip found, activating TPM-bypass! Oct 27 23:32:18.845182 kernel: ima: Allocated hash algorithm: sha1 Oct 27 23:32:18.845187 kernel: ima: No architecture policies found Oct 27 23:32:18.845193 kernel: alg: No test for fips(ansi_cprng) (fips_ansi_cprng) Oct 27 23:32:18.845198 kernel: clk: Disabling unused clocks Oct 27 23:32:18.845203 kernel: PM: genpd: Disabling unused power domains Oct 27 23:32:18.845208 kernel: Freeing unused kernel memory: 13504K Oct 27 23:32:18.845213 kernel: Run /init as init process Oct 27 23:32:18.845218 kernel: with arguments: Oct 27 23:32:18.845223 kernel: /init Oct 27 23:32:18.845227 kernel: with environment: Oct 27 23:32:18.845233 kernel: HOME=/ Oct 27 23:32:18.845238 kernel: TERM=linux Oct 27 23:32:18.845243 kernel: hv_vmbus: hv_mmio=[mem 0x40000000-0xfed3ffff],[mem 0xfc0000000-0xfffffffff] fb=[mem 0x40000000-0x47ffffff] Oct 27 23:32:18.845248 kernel: hv_vmbus: Vmbus version:5.3 Oct 27 23:32:18.845253 kernel: hv_vmbus: registering driver hid_hyperv Oct 27 23:32:18.845258 kernel: SCSI subsystem initialized Oct 27 23:32:18.845263 kernel: input: Microsoft Vmbus HID-compliant Mouse as /devices/0006:045E:0621.0001/input/input0 Oct 27 23:32:18.845351 kernel: hid-hyperv 0006:045E:0621.0001: input: VIRTUAL HID v0.01 Mouse [Microsoft Vmbus HID-compliant Mouse] on Oct 27 23:32:18.845358 kernel: hv_vmbus: registering driver hyperv_keyboard Oct 27 23:32:18.845364 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 Oct 27 23:32:18.845369 kernel: pps_core: LinuxPPS API ver. 1 registered Oct 27 23:32:18.845374 kernel: pps_core: Software ver. 5.3.6 - Copyright 2005-2007 Rodolfo Giometti Oct 27 23:32:18.845379 kernel: PTP clock support registered Oct 27 23:32:18.845385 kernel: hv_utils: Registering HyperV Utility Driver Oct 27 23:32:18.845390 kernel: hv_vmbus: registering driver hv_utils Oct 27 23:32:18.845395 kernel: hv_utils: Heartbeat IC version 3.0 Oct 27 23:32:18.845400 kernel: hv_utils: Shutdown IC version 3.2 Oct 27 23:32:18.845405 kernel: hv_utils: TimeSync IC version 4.0 Oct 27 23:32:18.845410 kernel: hv_vmbus: registering driver hv_storvsc Oct 27 23:32:18.845509 kernel: scsi host1: storvsc_host_t Oct 27 23:32:18.845597 kernel: scsi host0: storvsc_host_t Oct 27 23:32:18.845735 kernel: scsi 0:0:0:0: Direct-Access Msft Virtual Disk 1.0 PQ: 0 ANSI: 5 Oct 27 23:32:18.845830 kernel: scsi 0:0:0:2: CD-ROM Msft Virtual DVD-ROM 1.0 PQ: 0 ANSI: 5 Oct 27 23:32:18.845916 kernel: sd 0:0:0:0: [sda] 63737856 512-byte logical blocks: (32.6 GB/30.4 GiB) Oct 27 23:32:18.846001 kernel: sd 0:0:0:0: [sda] 4096-byte physical blocks Oct 27 23:32:18.846088 kernel: sd 0:0:0:0: [sda] Write Protect is off Oct 27 23:32:18.846173 kernel: sd 0:0:0:0: [sda] Mode Sense: 0f 00 10 00 Oct 27 23:32:18.846258 kernel: sd 0:0:0:0: [sda] Write cache: disabled, read cache: enabled, supports DPO and FUA Oct 27 23:32:18.846264 kernel: sda: sda1 sda2 sda3 sda4 sda6 sda7 sda9 Oct 27 23:32:18.846348 kernel: sd 0:0:0:0: [sda] Attached SCSI disk Oct 27 23:32:18.846432 kernel: sr 0:0:0:2: [sr0] scsi-1 drive Oct 27 23:32:18.846439 kernel: cdrom: Uniform CD-ROM driver Revision: 3.20 Oct 27 23:32:18.846523 kernel: sr 0:0:0:2: Attached scsi CD-ROM sr0 Oct 27 23:32:18.846529 kernel: device-mapper: core: CONFIG_IMA_DISABLE_HTABLE is disabled. Duplicate IMA measurements will not be recorded in the IMA log. Oct 27 23:32:18.846534 kernel: device-mapper: uevent: version 1.0.3 Oct 27 23:32:18.846540 kernel: device-mapper: ioctl: 4.48.0-ioctl (2023-03-01) initialised: dm-devel@lists.linux.dev Oct 27 23:32:18.846545 kernel: device-mapper: verity: sha256 using shash "sha256-ce" Oct 27 23:32:18.846550 kernel: raid6: neonx8 gen() 18583 MB/s Oct 27 23:32:18.846556 kernel: raid6: neonx4 gen() 18580 MB/s Oct 27 23:32:18.846560 kernel: raid6: neonx2 gen() 17069 MB/s Oct 27 23:32:18.846565 kernel: raid6: neonx1 gen() 15089 MB/s Oct 27 23:32:18.846570 kernel: raid6: int64x8 gen() 8929 MB/s Oct 27 23:32:18.846575 kernel: raid6: int64x4 gen() 10747 MB/s Oct 27 23:32:18.846580 kernel: raid6: int64x2 gen() 8825 MB/s Oct 27 23:32:18.846585 kernel: raid6: int64x1 gen() 7056 MB/s Oct 27 23:32:18.846591 kernel: raid6: using algorithm neonx8 gen() 18583 MB/s Oct 27 23:32:18.846596 kernel: raid6: .... xor() 15051 MB/s, rmw enabled Oct 27 23:32:18.846632 kernel: raid6: using neon recovery algorithm Oct 27 23:32:18.846639 kernel: xor: measuring software checksum speed Oct 27 23:32:18.846644 kernel: 8regs : 29510 MB/sec Oct 27 23:32:18.846649 kernel: 32regs : 29683 MB/sec Oct 27 23:32:18.846654 kernel: arm64_neon : 37181 MB/sec Oct 27 23:32:18.846660 kernel: xor: using function: arm64_neon (37181 MB/sec) Oct 27 23:32:18.846665 kernel: Btrfs loaded, zoned=no, fsverity=no Oct 27 23:32:18.846670 kernel: BTRFS: device fsid c1bd6f99-0847-453b-b0de-c6abe7a4c909 devid 1 transid 39 /dev/mapper/usr (254:0) scanned by mount (387) Oct 27 23:32:18.846676 kernel: BTRFS info (device dm-0): first mount of filesystem c1bd6f99-0847-453b-b0de-c6abe7a4c909 Oct 27 23:32:18.846681 kernel: BTRFS info (device dm-0): using crc32c (crc32c-generic) checksum algorithm Oct 27 23:32:18.846686 kernel: BTRFS info (device dm-0 state E): disabling log replay at mount time Oct 27 23:32:18.846691 kernel: BTRFS info (device dm-0 state E): enabling free space tree Oct 27 23:32:18.846696 kernel: loop: module loaded Oct 27 23:32:18.846702 kernel: loop0: detected capacity change from 0 to 100808 Oct 27 23:32:18.846707 kernel: squashfs: version 4.0 (2009/01/31) Phillip Lougher Oct 27 23:32:18.846713 systemd[1]: Successfully made /usr/ read-only. Oct 27 23:32:18.846720 systemd[1]: systemd 261.2 running in system mode (+PAM +AUDIT +SELINUX -APPARMOR +IMA +IPE +SMACK +SECCOMP -GCRYPT -GNUTLS +OPENSSL -ACL +BLKID +CURL +ELFUTILS -FIDO2 +IDN2 +KMOD +LIBCRYPTSETUP +LIBCRYPTSETUP_PLUGINS +LIBFDISK +PCRE2 -PWQUALITY -P11KIT -QRENCODE +TPM2 +BZIP2 +LZ4 +XZ +ZLIB +ZSTD -BPF_FRAMEWORK -BTF -XKBCOMMON +UTMP +LIBARCHIVE) Oct 27 23:32:18.846726 systemd[1]: Detected virtualization microsoft. Oct 27 23:32:18.846732 systemd[1]: Detected architecture arm64. Oct 27 23:32:18.846738 systemd[1]: Running in initrd. Oct 27 23:32:18.846743 systemd[1]: Initializing machine ID from random generator. Oct 27 23:32:18.846749 systemd[1]: No hostname configured, using default hostname. Oct 27 23:32:18.846754 systemd[1]: Hostname set to . Oct 27 23:32:18.846760 (gene[420]: '/usr/lib/systemd/system-generators/dracut-crypt-generator' failed with exit status 2. Oct 27 23:32:18.846767 systemd[1]: Queued start job for default target initrd.target. Oct 27 23:32:18.846772 systemd[1]: Started clevis-luks-askpass.path - Forward Password Requests to Clevis Directory Watch. Oct 27 23:32:18.846778 systemd[1]: Started systemd-ask-password-console.path - Dispatch Password Requests to Console Directory Watch. Oct 27 23:32:18.846784 systemd[1]: Expecting device dev-disk-by\x2dlabel-EFI\x2dSYSTEM.device - /dev/disk/by-label/EFI-SYSTEM... Oct 27 23:32:18.846790 systemd[1]: Expecting device dev-disk-by\x2dlabel-OEM.device - /dev/disk/by-label/OEM... Oct 27 23:32:18.846795 systemd[1]: Expecting device dev-disk-by\x2dlabel-ROOT.device - /dev/disk/by-label/ROOT... Oct 27 23:32:18.846802 systemd[1]: Expecting device dev-disk-by\x2dpartlabel-USR\x2dA.device - /dev/disk/by-partlabel/USR-A... Oct 27 23:32:18.846808 systemd[1]: Expecting device dev-mapper-usr.device - /dev/mapper/usr... Oct 27 23:32:18.846813 systemd[1]: Reached target cryptsetup-pre.target - Local Encrypted Volumes (Pre). Oct 27 23:32:18.846819 systemd[1]: Reached target cryptsetup.target - Local Encrypted Volumes. Oct 27 23:32:18.846824 systemd[1]: Reached target initrd-usr-fs.target - Initrd /usr File System. Oct 27 23:32:18.846830 systemd[1]: Reached target paths.target - Path Units. Oct 27 23:32:18.846835 systemd[1]: Reached target slices.target - Slice Units. Oct 27 23:32:18.846841 systemd[1]: Reached target swap.target - Swaps. Oct 27 23:32:18.846851 systemd[1]: Reached target timers.target - Timer Units. Oct 27 23:32:18.846857 systemd[1]: Listening on iscsid.socket - Open-iSCSI iscsid Socket. Oct 27 23:32:18.846863 systemd[1]: Listening on iscsiuio.socket - Open-iSCSI iscsiuio Socket. Oct 27 23:32:18.846868 systemd[1]: Listening on systemd-coredump.socket - Process Core Dump Socket. Oct 27 23:32:18.846875 systemd[1]: Listening on systemd-journald-audit.socket - Journal Audit Socket. Oct 27 23:32:18.846880 systemd[1]: Listening on systemd-journald-dev-log.socket - Journal Socket (/dev/log). Oct 27 23:32:18.846886 systemd[1]: Listening on systemd-journald.socket - Journal Sockets. Oct 27 23:32:18.846891 systemd[1]: Listening on systemd-networkd.socket - Network Management Netlink Socket. Oct 27 23:32:18.846897 systemd[1]: Listening on systemd-udevd-control.socket - udev Control Socket. Oct 27 23:32:18.846903 systemd[1]: Listening on systemd-udevd-kernel.socket - udev Kernel Socket. Oct 27 23:32:18.846908 systemd[1]: Reached target sockets.target - Socket Units. Oct 27 23:32:18.846915 systemd[1]: afterburn-network-kargs.service - Afterburn Initrd Setup Network Kernel Arguments skipped, no trigger condition checks were met. Oct 27 23:32:18.846921 systemd[1]: Starting ignition-setup-pre.service - Ignition env setup... Oct 27 23:32:18.846927 systemd[1]: Starting kmod-static-nodes.service - Create List of Static Device Nodes... Oct 27 23:32:18.846932 systemd[1]: Finished network-cleanup.service - Network Cleanup. Oct 27 23:32:18.846938 systemd[1]: systemd-battery-check.service - Early Battery Level Check skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/class/power_supply Oct 27 23:32:18.846944 systemd[1]: Starting systemd-journald.service - Journal Service... Oct 27 23:32:18.846950 systemd[1]: Starting systemd-modules-load.service - Load Kernel Modules... Oct 27 23:32:18.846972 systemd-journald[514]: Collecting audit messages is enabled. Oct 27 23:32:18.846988 systemd-journald[514]: Journal started Oct 27 23:32:18.847001 systemd-journald[514]: Runtime Journal (/run/log/journal/1b335d06a7f94baca86153b3d44254cc) is 8M, max 78.3M, 70.3M free. Oct 27 23:32:18.857584 systemd-modules-load[516]: Using 2 probe threads Oct 27 23:32:18.861771 systemd[1]: Starting systemd-network-generator.service - Generate Network Units from Kernel Command Line... Oct 27 23:32:18.877965 systemd[1]: Starting systemd-vconsole-setup.service - Virtual Console Setup... Oct 27 23:32:18.889837 systemd[1]: Started systemd-journald.service - Journal Service. Oct 27 23:32:18.888000 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' Oct 27 23:32:18.892483 systemd[1]: Finished ignition-setup-pre.service - Ignition env setup. Oct 27 23:32:18.917000 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' Oct 27 23:32:18.918941 systemd[1]: Finished kmod-static-nodes.service - Create List of Static Device Nodes. Oct 27 23:32:18.951042 kernel: audit: type=1130 audit(1793143938.888:2): pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=systemd-journald comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Oct 27 23:32:18.951064 kernel: audit: type=1130 audit(1793143938.917:3): pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=ignition-setup-pre comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Oct 27 23:32:18.951082 kernel: bridge: filtering via arp/ip/ip6tables is no longer available by default. Update your scripts to load br_netfilter if you need this. Oct 27 23:32:18.951398 systemd[1]: Finished systemd-network-generator.service - Generate Network Units from Kernel Command Line. Oct 27 23:32:18.935000 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' Oct 27 23:32:18.961000 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' Oct 27 23:32:18.964315 systemd[1]: Reached target network-pre.target - Preparation for Network. Oct 27 23:32:18.995981 kernel: audit: type=1130 audit(1793143938.935:4): pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=kmod-static-nodes comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Oct 27 23:32:18.975122 systemd-modules-load[516]: Inserted module 'br_netfilter' Oct 27 23:32:19.005469 kernel: audit: type=1130 audit(1793143938.961:5): 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' Oct 27 23:32:18.977429 systemd-vconsole-setup[519]: Configuration of first virtual console was skipped, ignoring remaining ones. Oct 27 23:32:19.017384 kernel: Bridge firewalling registered Oct 27 23:32:19.002074 systemd[1]: Listening on systemd-networkd-resolve-hook.socket - Network Management Resolve Hook Socket. Oct 27 23:32:19.018771 systemd[1]: Starting systemd-tmpfiles-setup-dev-early.service - Create Static Device Nodes in /dev gracefully... Oct 27 23:32:19.043199 systemd[1]: Starting systemd-tmpfiles-setup.service - Create System Files and Directories... Oct 27 23:32:19.050382 systemd[1]: Finished systemd-modules-load.service - Load Kernel Modules. Oct 27 23:32:19.062000 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' Oct 27 23:32:19.082752 systemd[1]: Finished systemd-vconsole-setup.service - Virtual Console Setup. Oct 27 23:32:19.088128 kernel: audit: type=1130 audit(1793143939.062: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' Oct 27 23:32:19.094625 systemd-tmpfiles[525]: /usr/lib/tmpfiles.d/systemd.conf:30: Duplicate line for path "/var/lib/systemd", ignoring. Oct 27 23:32:19.093000 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' Oct 27 23:32:19.094674 systemd-tmpfiles[525]: /usr/lib/tmpfiles.d/var.conf:14: Duplicate line for path "/var/log", ignoring. Oct 27 23:32:19.123287 kernel: audit: type=1130 audit(1793143939.093:7): pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=systemd-vconsole-setup comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Oct 27 23:32:19.115986 systemd[1]: Finished systemd-tmpfiles-setup-dev-early.service - Create Static Device Nodes in /dev gracefully. Oct 27 23:32:19.128000 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' Oct 27 23:32:19.152906 systemd[1]: Finished systemd-tmpfiles-setup.service - Create System Files and Directories. Oct 27 23:32:19.158493 kernel: audit: type=1130 audit(1793143939.128:8): pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=systemd-tmpfiles-setup-dev-early comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Oct 27 23:32:19.162000 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' Oct 27 23:32:19.166436 systemd[1]: Starting dracut-cmdline-ask.service - dracut ask for additional cmdline parameters... Oct 27 23:32:19.191147 kernel: audit: type=1130 audit(1793143939.162:9): pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=systemd-tmpfiles-setup comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Oct 27 23:32:19.194583 systemd[1]: Starting systemd-sysctl.service - Apply Kernel Variables... Oct 27 23:32:19.201743 systemd[1]: Starting systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev... Oct 27 23:32:19.220901 systemd[1]: Finished systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev. Oct 27 23:32:19.226000 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' Oct 27 23:32:19.244455 systemd[1]: systemd-sysctl.service: Deactivated successfully. Oct 27 23:32:19.259034 kernel: audit: type=1130 audit(1793143939.226:10): pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=systemd-tmpfiles-setup-dev comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Oct 27 23:32:19.244578 systemd[1]: Finished systemd-sysctl.service - Apply Kernel Variables. Oct 27 23:32:19.252000 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' Oct 27 23:32:19.252000 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' Oct 27 23:32:19.257000 audit: BPF prog-id=5 op=LOAD Oct 27 23:32:19.285346 kernel: audit: type=1130 audit(1793143939.252:11): 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' Oct 27 23:32:19.259280 systemd[1]: Starting systemd-resolved.service - Network Name Resolution... Oct 27 23:32:19.293692 systemd[1]: Finished dracut-cmdline-ask.service - dracut ask for additional cmdline parameters. Oct 27 23:32:19.306000 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' Oct 27 23:32:19.309076 systemd[1]: Starting dracut-cmdline.service - dracut cmdline hook... Oct 27 23:32:19.328146 systemd-resolved[537]: Positive Trust Anchors: Oct 27 23:32:19.328156 systemd-resolved[537]: . IN DS 20326 8 2 e06d44b80b8f1d39a95c0b0d7c65d08458e880409bbc683457104237c7f8ec8d Oct 27 23:32:19.328160 systemd-resolved[537]: . IN DS 38696 8 2 683d2d0acb8c9b712a1948b27f741219298d0a450d612c483af444a4c0fb2b16 Oct 27 23:32:19.328179 systemd-resolved[537]: 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 Oct 27 23:32:19.353000 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' Oct 27 23:32:19.347558 systemd-resolved[537]: Defaulting to hostname 'linux'. Oct 27 23:32:19.348512 systemd[1]: Started systemd-resolved.service - Network Name Resolution. Oct 27 23:32:19.354745 systemd[1]: Reached target nss-lookup.target - Host and Network Name Lookups. Oct 27 23:32:19.403834 dracut-cmdline[547]: dracut-111 Oct 27 23:32:19.403834 dracut-cmdline[547]: 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=3b76b6334d5c2649de42cdb5c1f5f44f2461fa52aac368b65392fc748ae399d4 Oct 27 23:32:19.526762 kernel: Loading iSCSI transport class v2.0-870. Oct 27 23:32:19.574629 kernel: iscsi: registered transport (tcp) Oct 27 23:32:19.608446 kernel: iscsi: registered transport (qla4xxx) Oct 27 23:32:19.608504 kernel: QLogic iSCSI HBA Driver Oct 27 23:32:19.669654 systemd[1]: afterburn-network-kargs.service - Afterburn Initrd Setup Network Kernel Arguments skipped, no trigger condition checks were met. Oct 27 23:32:19.719662 systemd[1]: Finished dracut-cmdline.service - dracut cmdline hook. Oct 27 23:32:19.723000 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' Oct 27 23:32:19.726682 systemd[1]: Starting dracut-pre-udev.service - dracut pre-udev hook... Oct 27 23:32:19.761266 systemd[1]: Finished dracut-pre-udev.service - dracut pre-udev hook. Oct 27 23:32:19.764000 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' Oct 27 23:32:19.769000 audit: BPF prog-id=6 op=LOAD Oct 27 23:32:19.769000 audit: BPF prog-id=7 op=LOAD Oct 27 23:32:19.771220 systemd[1]: Starting systemd-udevd.service - Rule-based Manager for Device Events and Files... Oct 27 23:32:19.886328 systemd-udevd[681]: Using default interface naming scheme 'v261'. Oct 27 23:32:19.905000 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' Oct 27 23:32:19.898970 systemd[1]: Started systemd-udevd.service - Rule-based Manager for Device Events and Files. Oct 27 23:32:19.908160 systemd[1]: Starting dracut-pre-trigger.service - dracut pre-trigger hook... Oct 27 23:32:19.932000 audit: BPF prog-id=8 op=LOAD Oct 27 23:32:19.935951 systemd[1]: Starting systemd-networkd.service - Network Management... Oct 27 23:32:19.955964 dracut-pre-trigger[703]: rd.md=0: removing MD RAID activation Oct 27 23:32:19.982460 systemd-networkd[704]: Failed to open nftables netlink socket. IPMasquerade= and NFTSet= settings will not be applied. Ignoring: Protocol not supported Oct 27 23:32:19.988780 systemd[1]: Finished dracut-pre-trigger.service - dracut pre-trigger hook. Oct 27 23:32:20.001680 systemd-networkd[704]: lo: Link UP Oct 27 23:32:20.003000 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' Oct 27 23:32:20.001683 systemd-networkd[704]: lo: Gained carrier Oct 27 23:32:20.010000 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' Oct 27 23:32:20.004552 systemd[1]: Started systemd-networkd.service - Network Management. Oct 27 23:32:20.011565 systemd[1]: Reached target network.target - Network. Oct 27 23:32:20.019350 systemd[1]: Starting systemd-udev-trigger.service - Coldplug All udev Devices... Oct 27 23:32:20.097671 systemd[1]: Finished systemd-udev-trigger.service - Coldplug All udev Devices. Oct 27 23:32:20.107000 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' Oct 27 23:32:20.111379 systemd[1]: Starting dracut-initqueue.service - dracut initqueue hook... Oct 27 23:32:20.188664 kernel: hv_storvsc f8b3781a-1e82-4818-a1c3-63d806ec15bb: tag#311 cmd 0x85 status: scsi 0x2 srb 0x6 hv 0xc0000001 Oct 27 23:32:20.236181 systemd[1]: systemd-vconsole-setup.service: Deactivated successfully. Oct 27 23:32:20.241000 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' Oct 27 23:32:20.236310 systemd[1]: Stopped systemd-vconsole-setup.service - Virtual Console Setup. Oct 27 23:32:20.258694 kernel: hv_vmbus: registering driver hv_netvsc Oct 27 23:32:20.243417 systemd[1]: Stopping systemd-vconsole-setup.service - Virtual Console Setup... Oct 27 23:32:20.253801 systemd[1]: Starting systemd-vconsole-setup.service - Virtual Console Setup... Oct 27 23:32:20.286581 systemd-vconsole-setup[783]: Configuration of first virtual console was skipped, ignoring remaining ones. Oct 27 23:32:20.294291 systemd[1]: Finished systemd-vconsole-setup.service - Virtual Console Setup. Oct 27 23:32:20.297000 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' Oct 27 23:32:20.341621 kernel: hv_netvsc 000d3ac5-22bd-000d-3ac5-22bd000d3ac5 eth0: VF slot 1 added Oct 27 23:32:20.362082 systemd-networkd[704]: eth0: Configuring with /usr/lib/systemd/network/zz-default.network. Oct 27 23:32:20.364570 systemd-networkd[704]: eth0: Link UP Oct 27 23:32:20.364658 systemd-networkd[704]: eth0: Gained carrier Oct 27 23:32:20.386503 systemd-networkd[704]: eth0: DHCPv4 address 10.0.0.29/24, gateway 10.0.0.1 acquired from 168.63.129.16 Oct 27 23:32:20.407491 kernel: hv_vmbus: registering driver hv_pci Oct 27 23:32:20.407534 kernel: hv_pci 4c9148a9-5ec5-4f3f-95a4-04b324308c19: PCI VMBus probing: Using version 0x10004 Oct 27 23:32:20.420832 kernel: hv_pci 4c9148a9-5ec5-4f3f-95a4-04b324308c19: PCI host bridge to bus 5ec5:00 Oct 27 23:32:20.421037 kernel: pci_bus 5ec5:00: root bus resource [mem 0xfc0000000-0xfc00fffff window] Oct 27 23:32:20.425875 kernel: pci_bus 5ec5:00: No busn resource found for root bus, will use [bus 00-ff] Oct 27 23:32:20.435630 kernel: pci 5ec5:00:02.0: [15b3:101a] type 00 class 0x020000 PCIe Endpoint Oct 27 23:32:20.442653 kernel: pci 5ec5:00:02.0: BAR 0 [mem 0xfc0000000-0xfc00fffff 64bit pref] Oct 27 23:32:20.449773 kernel: pci 5ec5:00:02.0: enabling Extended Tags Oct 27 23:32:20.467698 kernel: pci 5ec5:00:02.0: 0.000 Gb/s available PCIe bandwidth, limited by Unknown x0 link at 5ec5:00:02.0 (capable of 252.048 Gb/s with 16.0 GT/s PCIe x16 link) Oct 27 23:32:20.478795 kernel: pci_bus 5ec5:00: busn_res: [bus 00-ff] end is updated to 00 Oct 27 23:32:20.478990 kernel: pci 5ec5:00:02.0: BAR 0 [mem 0xfc0000000-0xfc00fffff 64bit pref]: assigned Oct 27 23:32:20.573503 systemd[1]: Found device dev-disk-by\x2dlabel-OEM.device - Virtual_Disk OEM. Oct 27 23:32:20.592444 systemd[1]: Found device dev-disk-by\x2dlabel-EFI\x2dSYSTEM.device - Virtual_Disk EFI-SYSTEM. Oct 27 23:32:20.613270 systemd[1]: Mounting oem.mount - /oem... Oct 27 23:32:20.639213 systemd[1]: Found device dev-disk-by\x2dpartlabel-USR\x2dA.device - Virtual_Disk USR-A. Oct 27 23:32:20.666787 systemd[1]: Found device dev-disk-by\x2dlabel-ROOT.device - Virtual_Disk ROOT. Oct 27 23:32:20.683446 kernel: BTRFS: device label OEM devid 1 transid 11 /dev/sda6 (8:6) scanned by mount (839) Oct 27 23:32:20.683468 kernel: BTRFS info (device sda6): first mount of filesystem 686859ee-85ec-41c2-956a-a7c7a8530239 Oct 27 23:32:20.688390 kernel: BTRFS info (device sda6): using crc32c (crc32c-generic) checksum algorithm Oct 27 23:32:20.693751 systemd[1]: Starting disk-uuid.service - Generate new UUID for disk GPT if necessary... Oct 27 23:32:20.713349 kernel: mlx5_core 5ec5:00:02.0: enabling device (0000 -> 0002) Oct 27 23:32:20.713553 kernel: mlx5_core 5ec5:00:02.0: PTM is not supported by PCIe Oct 27 23:32:20.717592 kernel: mlx5_core 5ec5:00:02.0: firmware version: 16.30.5026 Oct 27 23:32:20.781266 kernel: BTRFS info (device sda6): turning on async discard Oct 27 23:32:20.781333 kernel: BTRFS info (device sda6): enabling free space tree Oct 27 23:32:20.783391 systemd[1]: Mounted oem.mount - /oem. Oct 27 23:32:20.790552 systemd[1]: Starting ignition-fetch-offline.service - Ignition (fetch-offline)... Oct 27 23:32:20.919300 kernel: hv_netvsc 000d3ac5-22bd-000d-3ac5-22bd000d3ac5 eth0: VF registering: eth1 Oct 27 23:32:20.919513 kernel: mlx5_core 5ec5:00:02.0 eth1: joined to eth0 Oct 27 23:32:20.931648 kernel: mlx5_core 5ec5:00:02.0: MLX5E: StrdRq(1) RqSz(8) StrdSz(2048) RxCqeCmprss(0 basic) Oct 27 23:32:20.963315 kernel: mlx5_core 5ec5:00:02.0 enP24261s1: renamed from eth1 Oct 27 23:32:20.963267 systemd-networkd[704]: eth1: Interface name change detected, renamed to enP24261s1. Oct 27 23:32:21.071620 kernel: mlx5_core 5ec5:00:02.0 enP24261s1: Link up Oct 27 23:32:21.075633 systemd[1]: Finished dracut-initqueue.service - dracut initqueue hook. Oct 27 23:32:21.080000 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' Oct 27 23:32:21.081984 systemd[1]: Reached target remote-fs-pre.target - Preparation for Remote File Systems. Oct 27 23:32:21.091892 systemd[1]: Reached target remote-cryptsetup.target - Remote Encrypted Volumes. Oct 27 23:32:21.111441 systemd[1]: Reached target remote-fs.target - Remote File Systems. Oct 27 23:32:21.122830 systemd[1]: Starting dracut-pre-mount.service - dracut pre-mount hook... Oct 27 23:32:21.139226 kernel: hv_netvsc 000d3ac5-22bd-000d-3ac5-22bd000d3ac5 eth0: Data path switched to VF: enP24261s1 Oct 27 23:32:21.126296 systemd-networkd[704]: enP24261s1: Link UP Oct 27 23:32:21.154935 systemd[1]: Finished dracut-pre-mount.service - dracut pre-mount hook. Oct 27 23:32:21.158000 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' Oct 27 23:32:21.367756 systemd-networkd[704]: enP24261s1: Gained carrier Oct 27 23:32:21.546694 ignition[864]: Ignition 2.27.0 Oct 27 23:32:21.546706 ignition[864]: Stage: fetch-offline Oct 27 23:32:21.551892 systemd[1]: Finished ignition-fetch-offline.service - Ignition (fetch-offline). Oct 27 23:32:21.558000 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' Oct 27 23:32:21.546839 ignition[864]: no config dir at "/run/ignition/base.d" Oct 27 23:32:21.560063 systemd[1]: Starting ignition-fetch.service - Ignition (fetch)... Oct 27 23:32:21.546850 ignition[864]: no config dir at "/etc/ignition/base.d" Oct 27 23:32:21.547000 ignition[864]: no config dir at "/usr/lib/ignition/base.d" Oct 27 23:32:21.547002 ignition[864]: no configs found in "base.d" across system config directories Oct 27 23:32:21.547009 ignition[864]: no config dir at "/run/ignition/base.platform.d/azure" Oct 27 23:32:21.547013 ignition[864]: no config dir at "/etc/ignition/base.platform.d/azure" Oct 27 23:32:21.547019 ignition[864]: no config dir at "/usr/lib/ignition/base.platform.d/azure" Oct 27 23:32:21.547021 ignition[864]: no configs found in "base.platform.d/azure" across system config directories Oct 27 23:32:21.547230 ignition[864]: reading system config file "/run/ignition/user.ign" Oct 27 23:32:21.547237 ignition[864]: no config at "/run/ignition/user.ign" Oct 27 23:32:21.547239 ignition[864]: reading system config file "/etc/ignition/user.ign" Oct 27 23:32:21.547243 ignition[864]: no config at "/etc/ignition/user.ign" Oct 27 23:32:21.547245 ignition[864]: reading system config file "/usr/lib/ignition/user.ign" Oct 27 23:32:21.547267 ignition[864]: no config at "/usr/lib/ignition/user.ign" Oct 27 23:32:21.547271 ignition[864]: failed to fetch config: resource requires networking Oct 27 23:32:21.547397 ignition[864]: Ignition finished successfully Oct 27 23:32:21.587295 ignition[996]: Ignition 2.27.0 Oct 27 23:32:21.587301 ignition[996]: Stage: fetch Oct 27 23:32:21.587580 ignition[996]: no config dir at "/run/ignition/base.d" Oct 27 23:32:21.587591 ignition[996]: no config dir at "/etc/ignition/base.d" Oct 27 23:32:21.587667 ignition[996]: no config dir at "/usr/lib/ignition/base.d" Oct 27 23:32:21.587669 ignition[996]: no configs found in "base.d" across system config directories Oct 27 23:32:21.587675 ignition[996]: no config dir at "/run/ignition/base.platform.d/azure" Oct 27 23:32:21.587678 ignition[996]: no config dir at "/etc/ignition/base.platform.d/azure" Oct 27 23:32:21.679000 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' Oct 27 23:32:21.672199 unknown[996]: fetched base config from "system" Oct 27 23:32:21.587682 ignition[996]: no config dir at "/usr/lib/ignition/base.platform.d/azure" Oct 27 23:32:21.672204 unknown[996]: fetched base config from "system" Oct 27 23:32:21.587684 ignition[996]: no configs found in "base.platform.d/azure" across system config directories Oct 27 23:32:21.672208 unknown[996]: fetched user config from "azure" Oct 27 23:32:21.587803 ignition[996]: reading system config file "/run/ignition/user.ign" Oct 27 23:32:21.675668 systemd[1]: Finished ignition-fetch.service - Ignition (fetch). Oct 27 23:32:21.587814 ignition[996]: no config at "/run/ignition/user.ign" Oct 27 23:32:21.681774 systemd[1]: Starting ignition-kargs.service - Ignition (kargs)... Oct 27 23:32:21.730000 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' Oct 27 23:32:21.587816 ignition[996]: reading system config file "/etc/ignition/user.ign" Oct 27 23:32:21.726701 systemd[1]: Finished ignition-kargs.service - Ignition (kargs). Oct 27 23:32:21.587821 ignition[996]: no config at "/etc/ignition/user.ign" Oct 27 23:32:21.587823 ignition[996]: reading system config file "/usr/lib/ignition/user.ign" Oct 27 23:32:21.587831 ignition[996]: no config at "/usr/lib/ignition/user.ign" Oct 27 23:32:21.587848 ignition[996]: GET http://169.254.169.254/metadata/instance/compute/userData?api-version=2021-01-01&format=text: attempt #1 Oct 27 23:32:21.669621 ignition[996]: GET result: OK Oct 27 23:32:21.669668 ignition[996]: config has been read from IMDS userdata Oct 27 23:32:21.669687 ignition[996]: parsing config with SHA512: 7f9d83f47ab52d7ecdb38a89c7671c75681b3e71c6fa4295bf30e5fbd3c0ea8fbe753d65986dac8b706624ca780acdbd822f034a21b648c116041f3ea3e558d5 Oct 27 23:32:21.672364 ignition[996]: fetch: fetch complete Oct 27 23:32:21.672366 ignition[996]: fetch: fetch passed Oct 27 23:32:21.672410 ignition[996]: Ignition finished successfully Oct 27 23:32:21.720775 ignition[1002]: Ignition 2.27.0 Oct 27 23:32:21.720782 ignition[1002]: Stage: kargs Oct 27 23:32:21.720991 ignition[1002]: no config dir at "/run/ignition/base.d" Oct 27 23:32:21.720997 ignition[1002]: no config dir at "/etc/ignition/base.d" Oct 27 23:32:21.721009 ignition[1002]: no config dir at "/usr/lib/ignition/base.d" Oct 27 23:32:21.721011 ignition[1002]: no configs found in "base.d" across system config directories Oct 27 23:32:21.721019 ignition[1002]: no config dir at "/run/ignition/base.platform.d/azure" Oct 27 23:32:21.721022 ignition[1002]: no config dir at "/etc/ignition/base.platform.d/azure" Oct 27 23:32:21.721025 ignition[1002]: no config dir at "/usr/lib/ignition/base.platform.d/azure" Oct 27 23:32:21.721027 ignition[1002]: no configs found in "base.platform.d/azure" across system config directories Oct 27 23:32:21.721470 ignition[1002]: kargs: kargs passed Oct 27 23:32:21.721515 ignition[1002]: Ignition finished successfully Oct 27 23:32:21.887445 disk-uuid[860]: Warning: The kernel is still using the old partition table. Oct 27 23:32:21.887445 disk-uuid[860]: The new table will be used at the next reboot or after you Oct 27 23:32:21.887445 disk-uuid[860]: run partprobe(8) or kpartx(8) Oct 27 23:32:21.887445 disk-uuid[860]: The operation has completed successfully. Oct 27 23:32:21.905834 systemd[1]: disk-uuid.service: Deactivated successfully. Oct 27 23:32:21.907646 systemd[1]: Finished disk-uuid.service - Generate new UUID for disk GPT if necessary. Oct 27 23:32:21.914000 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' Oct 27 23:32:21.914000 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' Oct 27 23:32:21.917007 systemd[1]: Mounting boot.mount - Boot partition... Oct 27 23:32:21.936005 systemd[1]: Starting ignition-disks.service - Ignition (disks)... Oct 27 23:32:21.945697 systemd-networkd[704]: eth0: Gained IPv6LL Oct 27 23:32:22.000811 systemd[1]: Mounted boot.mount - Boot partition. Oct 27 23:32:22.009197 systemd[1]: ignition-kargs.service: Deactivated successfully. Oct 27 23:32:22.009356 systemd[1]: Stopped ignition-kargs.service - Ignition (kargs). Oct 27 23:32:22.016000 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' Oct 27 23:32:22.017871 systemd[1]: ignition-fetch.service: Deactivated successfully. Oct 27 23:32:22.025000 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' Oct 27 23:32:22.017983 systemd[1]: Stopped ignition-fetch.service - Ignition (fetch). Oct 27 23:32:22.034000 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' Oct 27 23:32:22.026749 systemd[1]: ignition-fetch-offline.service: Deactivated successfully. Oct 27 23:32:22.026872 systemd[1]: Stopped ignition-fetch-offline.service - Ignition (fetch-offline). Oct 27 23:32:22.037718 systemd[1]: Unmounting oem.mount - /oem... Oct 27 23:32:22.070624 kernel: BTRFS info (device sda6): last unmount of filesystem 686859ee-85ec-41c2-956a-a7c7a8530239 Oct 27 23:32:22.071760 systemd[1]: oem.mount: Deactivated successfully. Oct 27 23:32:22.071960 systemd[1]: Unmounted oem.mount - /oem. Oct 27 23:32:22.097246 ignition[1020]: Ignition 2.27.0 Oct 27 23:32:22.097261 ignition[1020]: Stage: disks Oct 27 23:32:22.097463 ignition[1020]: no config dir at "/run/ignition/base.d" Oct 27 23:32:22.097468 ignition[1020]: no config dir at "/etc/ignition/base.d" Oct 27 23:32:22.097484 ignition[1020]: no config dir at "/usr/lib/ignition/base.d" Oct 27 23:32:22.097486 ignition[1020]: no configs found in "base.d" across system config directories Oct 27 23:32:22.097491 ignition[1020]: no config dir at "/run/ignition/base.platform.d/azure" Oct 27 23:32:22.097494 ignition[1020]: no config dir at "/etc/ignition/base.platform.d/azure" Oct 27 23:32:22.097498 ignition[1020]: no config dir at "/usr/lib/ignition/base.platform.d/azure" Oct 27 23:32:22.097500 ignition[1020]: no configs found in "base.platform.d/azure" across system config directories Oct 27 23:32:22.097883 ignition[1020]: disks: createLuks: op(1): [started] waiting for devices [/dev/disk/by-partlabel/USR-B] Oct 27 23:32:22.106271 ignition[1020]: disks: createLuks: op(1): [finished] waiting for devices [/dev/disk/by-partlabel/USR-B] Oct 27 23:32:22.106337 ignition[1020]: disks: createLuks: created device alias for "/dev/disk/by-partlabel/USR-B": "/run/ignition/dev_aliases/dev/disk/by-partlabel/USR-B" -> "/dev/sda4" Oct 27 23:32:22.106587 ignition[1020]: disks: createLuks: op(2): [started] checking if /dev/disk/by-partlabel/USR-B is a luks2 device Oct 27 23:32:22.106741 ignition[1020]: disks: createLuks: op(2): executing: "cryptsetup" "isLuks" "/run/ignition/dev_aliases/dev/disk/by-partlabel/USR-B" "--type" "luks2" Oct 27 23:32:22.927710 ignition[1020]: disks: createLuks: op(2): [finished] checking if /dev/disk/by-partlabel/USR-B is a luks2 device Oct 27 23:32:22.927721 ignition[1020]: disks: createLuks: op(3): [started] checking if /dev/disk/by-partlabel/USR-B is a luks device Oct 27 23:32:22.927753 ignition[1020]: disks: createLuks: op(3): executing: "cryptsetup" "isLuks" "/run/ignition/dev_aliases/dev/disk/by-partlabel/USR-B" Oct 27 23:32:22.942317 ignition[1020]: disks: createLuks: op(3): [finished] checking if /dev/disk/by-partlabel/USR-B is a luks device Oct 27 23:32:22.942343 ignition[1020]: disks: createLuks: op(4): [started] determining volume type of "/dev/disk/by-partlabel/USR-B" Oct 27 23:32:22.964225 ignition[1020]: disks: createLuks: op(4): [finished] determining volume type of "/dev/disk/by-partlabel/USR-B" Oct 27 23:32:22.964238 ignition[1020]: disks: createLuks: found at "/dev/disk/by-partlabel/USR-B" with uuid "" and label "" Oct 27 23:32:22.964273 ignition[1020]: disks: createLuks: op(5): [started] creating "data" Oct 27 23:32:22.964280 ignition[1020]: disks: createLuks: op(5): executing: "cryptsetup" "luksFormat" "--type" "luks2" "--key-file" "/tmp/ignition-luks-2578972185" "/run/ignition/dev_aliases/dev/disk/by-partlabel/USR-B" Oct 27 23:32:28.431477 ignition[1020]: disks: createLuks: op(5): [finished] creating "data" Oct 27 23:32:28.431530 ignition[1020]: disks: createLuks: op(6): [started] opening luks device data Oct 27 23:32:28.431538 ignition[1020]: disks: createLuks: op(6): executing: "cryptsetup" "luksOpen" "/run/ignition/dev_aliases/dev/disk/by-partlabel/USR-B" "data" "--key-file" "/tmp/ignition-luks-2578972185" "--persistent" Oct 27 23:32:30.372618 kernel: Key type encrypted registered Oct 27 23:32:30.609992 ignition[1020]: disks: createLuks: op(6): [finished] opening luks device data Oct 27 23:32:30.610119 ignition[1020]: disks: createLuks: op(7): [started] waiting for triggered uevent Oct 27 23:32:30.610125 ignition[1020]: disks: createLuks: op(7): executing: "udevadm" "trigger" "--settle" "/dev/sda4" Oct 27 23:32:30.756002 ignition[1020]: disks: createLuks: op(7): [finished] waiting for triggered uevent Oct 27 23:32:30.756056 ignition[1020]: disks: createFilesystems: op(8): [started] waiting for devices [/dev/disk/by-id/dm-name-data] Oct 27 23:32:30.772669 ignition[1020]: disks: createFilesystems: op(8): [finished] waiting for devices [/dev/disk/by-id/dm-name-data] Oct 27 23:32:30.772743 ignition[1020]: 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" Oct 27 23:32:30.772775 ignition[1020]: disks: createFilesystems: op(9): [started] determining filesystem type of "/dev/disk/by-id/dm-name-data" Oct 27 23:32:30.818094 ignition[1020]: disks: createFilesystems: op(9): [finished] determining filesystem type of "/dev/disk/by-id/dm-name-data" Oct 27 23:32:30.818108 ignition[1020]: disks: createFilesystems: found filesystem at "/dev/disk/by-id/dm-name-data" with uuid "" and label "" Oct 27 23:32:30.818345 ignition[1020]: disks: createFilesystems: op(a): [started] wiping filesystem signatures from "/run/ignition/dev_aliases/dev/disk/by-id/dm-name-data" Oct 27 23:32:30.818357 ignition[1020]: disks: createFilesystems: op(a): executing: "wipefs" "-a" "/run/ignition/dev_aliases/dev/disk/by-id/dm-name-data" Oct 27 23:32:30.922262 ignition[1020]: disks: createFilesystems: op(a): [finished] wiping filesystem signatures from "/run/ignition/dev_aliases/dev/disk/by-id/dm-name-data" Oct 27 23:32:30.922409 ignition[1020]: disks: createFilesystems: op(b): [started] creating "ext4" filesystem on "/run/ignition/dev_aliases/dev/disk/by-id/dm-name-data" Oct 27 23:32:30.922420 ignition[1020]: disks: createFilesystems: op(b): executing: "mkfs.ext4" "-F" "-L" "DATA" "/run/ignition/dev_aliases/dev/disk/by-id/dm-name-data" Oct 27 23:32:31.228083 ignition[1020]: disks: createFilesystems: op(b): [finished] creating "ext4" filesystem on "/run/ignition/dev_aliases/dev/disk/by-id/dm-name-data" Oct 27 23:32:31.228144 ignition[1020]: disks: createFilesystems: op(c): [started] waiting for triggered uevent Oct 27 23:32:31.228148 ignition[1020]: disks: createFilesystems: op(c): executing: "udevadm" "trigger" "--settle" "/dev/dm-1" Oct 27 23:32:31.259831 ignition[1020]: disks: createFilesystems: op(c): [finished] waiting for triggered uevent Oct 27 23:32:31.259845 ignition[1020]: disks: disks passed Oct 27 23:32:31.259933 ignition[1020]: Ignition finished successfully Oct 27 23:32:31.270920 systemd[1]: Finished ignition-disks.service - Ignition (disks). Oct 27 23:32:31.277000 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' Oct 27 23:32:31.286807 kernel: kauditd_printk_skb: 25 callbacks suppressed Oct 27 23:32:31.280004 systemd[1]: Reached target initrd-root-device.target - Initrd Root Device. Oct 27 23:32:31.315676 kernel: audit: type=1130 audit(1793143951.277:37): 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' Oct 27 23:32:31.304689 systemd[1]: Reached target local-fs-pre.target - Preparation for Local File Systems. Oct 27 23:32:31.314922 systemd[1]: Reached target local-fs.target - Local File Systems. Oct 27 23:32:31.320125 systemd[1]: Reached target sysinit.target - System Initialization. Oct 27 23:32:31.330414 systemd[1]: Reached target basic.target - Basic System. Oct 27 23:32:31.340120 systemd[1]: Starting systemd-fsck-root.service - File System Check on /dev/disk/by-label/ROOT... Oct 27 23:32:31.432692 systemd-fsck[1328]: ROOT: clean, 15/6361680 files, 408771/6359552 blocks Oct 27 23:32:31.444315 systemd[1]: Finished systemd-fsck-root.service - File System Check on /dev/disk/by-label/ROOT. Oct 27 23:32:31.449000 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' Oct 27 23:32:31.475682 kernel: audit: type=1130 audit(1793143951.449:38): 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' Oct 27 23:32:31.473645 systemd[1]: Mounting sysroot.mount - /sysroot... Oct 27 23:32:31.757624 kernel: EXT4-fs (sda9): mounted filesystem 1448ec52-ad1d-4b19-8c5b-31a2eb4bf419 r/w with ordered data mode. Quota mode: none. Oct 27 23:32:31.758743 systemd[1]: Mounted sysroot.mount - /sysroot. Oct 27 23:32:31.762688 systemd[1]: Reached target initrd-root-fs.target - Initrd Root File System. Oct 27 23:32:31.787716 systemd[1]: Mounting sysroot-usr.mount - /sysroot/usr... Oct 27 23:32:31.802266 systemd[1]: Starting flatcar-metadata-hostname.service - Flatcar Metadata Hostname Agent... Oct 27 23:32:31.813948 systemd[1]: ignition-remount-sysroot.service - Remount /sysroot read-write for Ignition skipped, unmet condition check ConditionPathIsReadWrite=!/sysroot Oct 27 23:32:31.814001 systemd[1]: Reached target ignition-diskful.target - Ignition Boot Disk Setup. Oct 27 23:32:31.831648 systemd[1]: Mounted sysroot-usr.mount - /sysroot/usr. Oct 27 23:32:31.842424 systemd[1]: Starting initrd-setup-root.service - Root filesystem setup... Oct 27 23:32:33.082623 kernel: loop1: detected capacity change from 0 to 44465 Oct 27 23:32:33.141942 kernel: loop1: p1 p2 p3 Oct 27 23:32:33.298340 kernel: device-mapper: verity: sha256 using shash "sha256-ce" Oct 27 23:32:33.298406 kernel: device-mapper: verity: Unrecognized verity feature request: root_hash_sig_key_desc Oct 27 23:32:33.304335 kernel: device-mapper: table: 254:2: verity: Unrecognized verity feature request (-EINVAL) Oct 27 23:32:33.308532 kernel: device-mapper: ioctl: error adding target to table Oct 27 23:32:33.308621 systemd-confext[1419]: device-mapper: reload ioctl on loop1p1-15-verity (254:2) failed: Invalid argument Oct 27 23:32:33.342631 kernel: device-mapper: verity: sha256 using shash "sha256-ce" Oct 27 23:32:33.674633 kernel: erofs: (device dm-2): mounted with root inode @ nid 40. Oct 27 23:32:33.702622 kernel: loop2: detected capacity change from 0 to 44465 Oct 27 23:32:33.711134 kernel: loop2: p1 p2 p3 Oct 27 23:32:33.723441 kernel: device-mapper: verity: sha256 using shash "sha256-ce" Oct 27 23:32:33.723500 kernel: device-mapper: verity: Unrecognized verity feature request: root_hash_sig_key_desc Oct 27 23:32:33.730009 kernel: device-mapper: table: 254:2: verity: Unrecognized verity feature request (-EINVAL) Oct 27 23:32:33.737618 kernel: device-mapper: ioctl: error adding target to table Oct 27 23:32:33.739650 (sd-merge)[1431]: device-mapper: reload ioctl on loop2p1-19-verity (254:2) failed: Invalid argument Oct 27 23:32:33.752614 kernel: device-mapper: verity: sha256 using shash "sha256-ce" Oct 27 23:32:33.768382 (sd-merge)[1431]: Using extensions '00-flatcar-default.raw'. Oct 27 23:32:33.772618 kernel: erofs: (device dm-2): mounted with root inode @ nid 40. Oct 27 23:32:33.772214 (sd-merge)[1431]: Merged extensions into '/sysroot/etc'. Oct 27 23:32:33.778725 initrd-setup-root[1439]: /etc 00-flatcar-default Tue 2026-10-27 23:32:19 UTC Oct 27 23:32:33.779963 systemd[1]: Finished initrd-setup-root.service - Root filesystem setup. Oct 27 23:32:33.788000 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' Oct 27 23:32:33.790351 systemd[1]: Starting ignition-mount.service - Ignition (mount)... Oct 27 23:32:33.815434 kernel: audit: type=1130 audit(1793143953.788:39): pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=initrd-setup-root comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Oct 27 23:32:33.835931 ignition[1444]: INFO : Ignition 2.27.0 Oct 27 23:32:33.840147 ignition[1444]: INFO : Stage: mount Oct 27 23:32:33.840147 ignition[1444]: INFO : no config dir at "/run/ignition/base.d" Oct 27 23:32:33.840147 ignition[1444]: INFO : no config dir at "/etc/ignition/base.d" Oct 27 23:32:33.840147 ignition[1444]: INFO : no config dir at "/usr/lib/ignition/base.d" Oct 27 23:32:33.840147 ignition[1444]: INFO : no configs found in "base.d" across system config directories Oct 27 23:32:33.840147 ignition[1444]: INFO : no config dir at "/run/ignition/base.platform.d/azure" Oct 27 23:32:33.840147 ignition[1444]: INFO : no config dir at "/etc/ignition/base.platform.d/azure" Oct 27 23:32:33.840147 ignition[1444]: INFO : no config dir at "/usr/lib/ignition/base.platform.d/azure" Oct 27 23:32:33.840147 ignition[1444]: INFO : no configs found in "base.platform.d/azure" across system config directories Oct 27 23:32:33.840147 ignition[1444]: INFO : mount: op(1): [started] mounting "/dev/disk/by-id/dm-name-data" at "/sysroot/var/lib/data" with type "ext4" and options "" Oct 27 23:32:33.840147 ignition[1444]: DEBUG : mount: op(1): executing: "mount" "-o" "" "-t" "ext4" "/dev/disk/by-id/dm-name-data" "/sysroot/var/lib/data" Oct 27 23:32:34.026672 kernel: EXT4-fs (dm-1): mounted filesystem 29aaab59-942c-481f-8d94-9ffe885e905c r/w with ordered data mode. Quota mode: none. Oct 27 23:32:34.027774 ignition[1444]: INFO : mount: op(1): [finished] mounting "/dev/disk/by-id/dm-name-data" at "/sysroot/var/lib/data" with type "ext4" and options "" Oct 27 23:32:34.027774 ignition[1444]: INFO : mount: mount passed Oct 27 23:32:34.041000 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' Oct 27 23:32:34.059663 ignition[1444]: INFO : Ignition finished successfully Oct 27 23:32:34.029052 systemd[1]: Finished ignition-mount.service - Ignition (mount). Oct 27 23:32:34.069241 kernel: audit: type=1130 audit(1793143954.041:40): pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=ignition-mount comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Oct 27 23:33:00.975440 coreos-metadata[1343]: Oct 27 23:33:00.975 WARN Failed to get fabric address from DHCP: maximum number of retries (60) reached Oct 27 23:33:00.975440 coreos-metadata[1343]: Oct 27 23:33:00.975 INFO using fallback address Oct 27 23:33:00.987413 coreos-metadata[1343]: Oct 27 23:33:00.987 INFO Fetching http://168.63.129.16/?comp=versions: Attempt #1 Oct 27 23:33:00.994540 coreos-metadata[1343]: Oct 27 23:33:00.994 INFO Fetch successful Oct 27 23:33:00.998779 coreos-metadata[1343]: Oct 27 23:33:00.994 INFO Fetching http://169.254.169.254/metadata/instance/compute/name?api-version=2017-08-01&format=text: Attempt #1 Oct 27 23:33:01.007566 coreos-metadata[1343]: Oct 27 23:33:01.007 INFO Fetch successful Oct 27 23:33:01.007566 coreos-metadata[1343]: Oct 27 23:33:01.007 INFO wrote hostname ci-4820.0.1-n-221886e4d9 to /sysroot/etc/hostname Oct 27 23:33:01.013144 systemd[1]: Finished flatcar-metadata-hostname.service - Flatcar Metadata Hostname Agent. Oct 27 23:33:01.022000 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' Oct 27 23:33:01.042626 kernel: audit: type=1130 audit(1793143981.022:41): 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' Oct 27 23:33:01.041742 systemd[1]: Starting ignition-files.service - Ignition (files)... Oct 27 23:33:01.062619 systemd[1]: Mounting oem.mount - /oem... Oct 27 23:33:01.085649 kernel: BTRFS: device label OEM devid 1 transid 11 /dev/sda6 (8:6) scanned by mount (1513) Oct 27 23:33:01.098215 kernel: BTRFS info (device sda6): first mount of filesystem 686859ee-85ec-41c2-956a-a7c7a8530239 Oct 27 23:33:01.098270 kernel: BTRFS info (device sda6): using crc32c (crc32c-generic) checksum algorithm Oct 27 23:33:01.107907 kernel: BTRFS info (device sda6): turning on async discard Oct 27 23:33:01.107967 kernel: BTRFS info (device sda6): enabling free space tree Oct 27 23:33:01.109856 systemd[1]: Mounted oem.mount - /oem. Oct 27 23:33:01.114726 systemd[1]: Mounting sysroot-oem.mount - /sysroot/oem... Oct 27 23:33:01.135037 systemd[1]: Mounted sysroot-oem.mount - /sysroot/oem. Oct 27 23:33:01.160658 ignition[1532]: INFO : Ignition 2.27.0 Oct 27 23:33:01.160658 ignition[1532]: INFO : Stage: files Oct 27 23:33:01.167555 ignition[1532]: INFO : no config dir at "/run/ignition/base.d" Oct 27 23:33:01.167555 ignition[1532]: INFO : no config dir at "/etc/ignition/base.d" Oct 27 23:33:01.167555 ignition[1532]: INFO : no config dir at "/usr/lib/ignition/base.d" Oct 27 23:33:01.167555 ignition[1532]: INFO : no configs found in "base.d" across system config directories Oct 27 23:33:01.167555 ignition[1532]: INFO : no config dir at "/run/ignition/base.platform.d/azure" Oct 27 23:33:01.167555 ignition[1532]: INFO : no config dir at "/etc/ignition/base.platform.d/azure" Oct 27 23:33:01.167555 ignition[1532]: INFO : no config dir at "/usr/lib/ignition/base.platform.d/azure" Oct 27 23:33:01.167555 ignition[1532]: INFO : no configs found in "base.platform.d/azure" across system config directories Oct 27 23:33:01.167555 ignition[1532]: DEBUG : files: compiled without relabeling support, skipping Oct 27 23:33:01.167555 ignition[1532]: INFO : files: ensureUsers: op(1): [started] creating or modifying user "core" Oct 27 23:33:01.167555 ignition[1532]: DEBUG : files: ensureUsers: op(1): executing: "usermod" "--root" "/sysroot" "core" Oct 27 23:33:01.167555 ignition[1532]: INFO : files: ensureUsers: op(1): [finished] creating or modifying user "core" Oct 27 23:33:01.167555 ignition[1532]: INFO : files: ensureUsers: op(2): [started] adding ssh keys to user "core" Oct 27 23:33:01.167555 ignition[1532]: INFO : files: ensureUsers: op(2): [finished] adding ssh keys to user "core" Oct 27 23:33:01.167555 ignition[1532]: INFO : files: createFilesystemsFiles: createFiles: op(3): [started] writing file "/sysroot/etc/flatcar/update.conf" Oct 27 23:33:01.210000 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' Oct 27 23:33:01.260000 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' Oct 27 23:33:01.260000 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' Oct 27 23:33:01.164816 unknown[1532]: wrote ssh authorized keys file for user: core Oct 27 23:33:01.307017 kernel: audit: type=1130 audit(1793143981.210:42): pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=ignition-files comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Oct 27 23:33:01.307036 ignition[1532]: INFO : files: createFilesystemsFiles: createFiles: op(3): [finished] writing file "/sysroot/etc/flatcar/update.conf" Oct 27 23:33:01.307036 ignition[1532]: INFO : files: op(4): [started] processing unit "var-lib-data.mount" Oct 27 23:33:01.307036 ignition[1532]: INFO : files: op(4): op(5): [started] writing unit "var-lib-data.mount" at "/sysroot/etc/systemd/system/var-lib-data.mount" Oct 27 23:33:01.307036 ignition[1532]: INFO : files: op(4): op(5): [finished] writing unit "var-lib-data.mount" at "/sysroot/etc/systemd/system/var-lib-data.mount" Oct 27 23:33:01.307036 ignition[1532]: INFO : files: op(4): [finished] processing unit "var-lib-data.mount" Oct 27 23:33:01.307036 ignition[1532]: INFO : files: op(6): [started] setting preset to enabled for "var-lib-data.mount" Oct 27 23:33:01.307036 ignition[1532]: INFO : files: op(6): [finished] setting preset to enabled for "var-lib-data.mount" Oct 27 23:33:01.307036 ignition[1532]: INFO : files: createCrypttabEntries: createFiles: op(7): [started] writing file "/sysroot/etc/luks/data" Oct 27 23:33:01.307036 ignition[1532]: INFO : files: createCrypttabEntries: createFiles: op(7): [finished] writing file "/sysroot/etc/luks/data" Oct 27 23:33:01.307036 ignition[1532]: INFO : files: createCrypttabEntries: createFiles: op(8): [started] writing file "/sysroot/etc/crypttab" Oct 27 23:33:01.307036 ignition[1532]: INFO : files: createCrypttabEntries: createFiles: op(8): [finished] writing file "/sysroot/etc/crypttab" Oct 27 23:33:01.307036 ignition[1532]: INFO : files: createCrypttabEntries: createFiles: op(9): [started] appending to file "/sysroot/etc/crypttab" Oct 27 23:33:01.307036 ignition[1532]: INFO : files: createCrypttabEntries: createFiles: op(9): [finished] appending to file "/sysroot/etc/crypttab" Oct 27 23:33:01.307036 ignition[1532]: INFO : files: createResultFile: createFiles: op(a): [started] writing file "/sysroot/etc/.ignition-result.json" Oct 27 23:33:01.307036 ignition[1532]: INFO : files: createResultFile: createFiles: op(a): [finished] writing file "/sysroot/etc/.ignition-result.json" Oct 27 23:33:01.307036 ignition[1532]: INFO : files: files passed Oct 27 23:33:01.307036 ignition[1532]: INFO : Ignition finished successfully Oct 27 23:33:01.207695 systemd[1]: Finished ignition-files.service - Ignition (files). Oct 27 23:33:01.485619 kernel: audit: type=1130 audit(1793143981.260:43): pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=ignition-quench comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Oct 27 23:33:01.213498 systemd[1]: Starting ignition-quench.service - Ignition (record completion)... Oct 27 23:33:01.491441 kernel: audit: type=1131 audit(1793143981.260:44): pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=ignition-quench comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Oct 27 23:33:01.237734 systemd[1]: Starting initrd-setup-root-after-ignition.service - Root filesystem completion... Oct 27 23:33:01.498262 kernel: loop3: detected capacity change from 0 to 44465 Oct 27 23:33:01.250827 systemd[1]: ignition-quench.service: Deactivated successfully. Oct 27 23:33:01.503092 kernel: loop3: p1 p2 p3 Oct 27 23:33:01.503105 initrd-setup-root-after-ignition[1564]: grep: /sysroot/etc/flatcar/enabled-sysext.conf: No such file or directory Oct 27 23:33:01.503105 initrd-setup-root-after-ignition[1564]: grep: /sysroot/usr/share/flatcar/enabled-sysext.conf: No such file or directory Oct 27 23:33:01.250943 systemd[1]: Finished ignition-quench.service - Ignition (record completion). Oct 27 23:33:01.525307 kernel: device-mapper: verity: sha256 using shash "sha256-ce" Oct 27 23:33:01.525327 initrd-setup-root-after-ignition[1568]: grep: /sysroot/etc/flatcar/enabled-sysext.conf: No such file or directory Oct 27 23:33:01.460662 systemd-confext[1570]: device-mapper: reload ioctl on loop3p1-22-verity (254:3) failed: Invalid argument Oct 27 23:33:01.545659 kernel: device-mapper: verity: Unrecognized verity feature request: root_hash_sig_key_desc Oct 27 23:33:01.545676 kernel: device-mapper: table: 254:3: verity: Unrecognized verity feature request (-EINVAL) Oct 27 23:33:01.545684 kernel: device-mapper: ioctl: error adding target to table Oct 27 23:33:01.545690 kernel: device-mapper: verity: sha256 using shash "sha256-ce" Oct 27 23:33:01.545697 kernel: erofs: (device dm-3): mounted with root inode @ nid 40. Oct 27 23:33:01.571642 kernel: loop4: detected capacity change from 0 to 44465 Oct 27 23:33:01.583668 kernel: loop4: p1 p2 p3 Oct 27 23:33:01.603760 kernel: device-mapper: verity: sha256 using shash "sha256-ce" Oct 27 23:33:01.603811 kernel: device-mapper: verity: Unrecognized verity feature request: root_hash_sig_key_desc Oct 27 23:33:01.611448 kernel: device-mapper: table: 254:3: verity: Unrecognized verity feature request (-EINVAL) Oct 27 23:33:01.615218 kernel: device-mapper: ioctl: error adding target to table Oct 27 23:33:01.615458 (sd-merge)[1583]: device-mapper: reload ioctl on loop4p1-26-verity (254:3) failed: Invalid argument Oct 27 23:33:01.628899 kernel: device-mapper: verity: sha256 using shash "sha256-ce" Oct 27 23:33:01.644440 (sd-merge)[1583]: Skipping extension refresh because no change was found, use --always-refresh=yes to always do a refresh. Oct 27 23:33:01.651625 kernel: erofs: (device dm-3): mounted with root inode @ nid 40. Oct 27 23:33:01.713722 kernel: loop4: detected capacity change from 0 to 404480 Oct 27 23:33:01.791637 kernel: loop4: p1 p2 p3 Oct 27 23:33:01.901130 kernel: device-mapper: verity: sha256 using shash "sha256-ce" Oct 27 23:33:01.901193 kernel: device-mapper: verity: Unrecognized verity feature request: root_hash_sig_key_desc Oct 27 23:33:01.906535 kernel: device-mapper: table: 254:3: verity: Unrecognized verity feature request (-EINVAL) Oct 27 23:33:01.910376 kernel: device-mapper: ioctl: error adding target to table Oct 27 23:33:01.910614 systemd-sysext[1591]: device-mapper: reload ioctl on loop4p1-30-verity (254:3) failed: Invalid argument Oct 27 23:33:01.922608 kernel: device-mapper: verity: sha256 using shash "sha256-ce" Oct 27 23:33:02.208656 kernel: erofs: (device dm-3): mounted with root inode @ nid 39. Oct 27 23:33:02.352630 kernel: loop5: detected capacity change from 0 to 158624 Oct 27 23:33:02.376708 kernel: loop5: p1 p2 p3 Oct 27 23:33:02.418344 kernel: device-mapper: verity: sha256 using shash "sha256-ce" Oct 27 23:33:02.418410 kernel: device-mapper: verity: Unrecognized verity feature request: root_hash_sig_key_desc Oct 27 23:33:02.423208 kernel: device-mapper: table: 254:3: verity: Unrecognized verity feature request (-EINVAL) Oct 27 23:33:02.426737 kernel: device-mapper: ioctl: error adding target to table Oct 27 23:33:02.427629 systemd-sysext[1591]: device-mapper: reload ioctl on loop5p1-34-verity (254:3) failed: Invalid argument Oct 27 23:33:02.438796 kernel: device-mapper: verity: sha256 using shash "sha256-ce" Oct 27 23:33:02.765844 kernel: erofs: (device dm-3): mounted with root inode @ nid 39. Oct 27 23:33:02.823671 kernel: loop6: detected capacity change from 0 to 141248 Oct 27 23:33:02.875628 kernel: loop6: p1 p2 p3 Oct 27 23:33:02.917941 kernel: device-mapper: verity: sha256 using shash "sha256-ce" Oct 27 23:33:02.918006 kernel: device-mapper: verity: Unrecognized verity feature request: root_hash_sig_key_desc Oct 27 23:33:02.923812 kernel: device-mapper: table: 254:3: verity: Unrecognized verity feature request (-EINVAL) Oct 27 23:33:02.927358 kernel: device-mapper: ioctl: error adding target to table Oct 27 23:33:02.927560 systemd-sysext[1591]: device-mapper: reload ioctl on loop6p1-38-verity (254:3) failed: Invalid argument Oct 27 23:33:02.938626 kernel: device-mapper: verity: sha256 using shash "sha256-ce" Oct 27 23:33:03.142627 kernel: erofs: (device dm-3): mounted with root inode @ nid 39. Oct 27 23:33:03.169622 kernel: loop7: detected capacity change from 0 to 404480 Oct 27 23:33:03.182627 kernel: loop7: p1 p2 p3 Oct 27 23:33:03.194378 kernel: device-mapper: verity: sha256 using shash "sha256-ce" Oct 27 23:33:03.194405 kernel: device-mapper: verity: Unrecognized verity feature request: root_hash_sig_key_desc Oct 27 23:33:03.199447 kernel: device-mapper: table: 254:3: verity: Unrecognized verity feature request (-EINVAL) Oct 27 23:33:03.203279 kernel: device-mapper: ioctl: error adding target to table Oct 27 23:33:03.203654 (sd-merge)[1615]: device-mapper: reload ioctl on loop7p1-42-verity (254:3) failed: Invalid argument Oct 27 23:33:03.219093 kernel: device-mapper: verity: sha256 using shash "sha256-ce" Oct 27 23:33:03.245628 kernel: erofs: (device dm-3): mounted with root inode @ nid 39. Oct 27 23:33:03.250647 kernel: loop1: detected capacity change from 0 to 158624 Oct 27 23:33:03.255778 kernel: loop1: p1 p2 p3 Oct 27 23:33:03.267239 kernel: device-mapper: verity: sha256 using shash "sha256-ce" Oct 27 23:33:03.267273 kernel: device-mapper: verity: Unrecognized verity feature request: root_hash_sig_key_desc Oct 27 23:33:03.274354 kernel: device-mapper: table: 254:4: verity: Unrecognized verity feature request (-EINVAL) Oct 27 23:33:03.277787 kernel: device-mapper: ioctl: error adding target to table Oct 27 23:33:03.278133 (sd-merge)[1615]: device-mapper: reload ioctl on loop1p1-46-verity (254:4) failed: Invalid argument Oct 27 23:33:03.298638 kernel: device-mapper: verity: sha256 using shash "sha256-ce" Oct 27 23:33:03.324627 kernel: erofs: (device dm-4): mounted with root inode @ nid 39. Oct 27 23:33:03.329646 kernel: loop3: detected capacity change from 0 to 141248 Oct 27 23:33:03.337697 kernel: loop3: p1 p2 p3 Oct 27 23:33:03.349971 kernel: device-mapper: verity: sha256 using shash "sha256-ce" Oct 27 23:33:03.350022 kernel: device-mapper: verity: Unrecognized verity feature request: root_hash_sig_key_desc Oct 27 23:33:03.354740 kernel: device-mapper: table: 254:5: verity: Unrecognized verity feature request (-EINVAL) Oct 27 23:33:03.359672 kernel: device-mapper: ioctl: error adding target to table Oct 27 23:33:03.358346 (sd-merge)[1615]: device-mapper: reload ioctl on loop3p1-50-verity (254:5) failed: Invalid argument Oct 27 23:33:03.377665 kernel: device-mapper: verity: sha256 using shash "sha256-ce" Oct 27 23:33:03.398652 kernel: erofs: (device dm-5): mounted with root inode @ nid 39. Oct 27 23:33:03.398809 (sd-merge)[1615]: Using extensions 'containerd-flatcar.raw', 'docker-flatcar.raw', 'oem-azure-4820.0.1+nightly-20261027-2100.raw'. Oct 27 23:33:03.399653 (sd-merge)[1615]: Merged extensions into '/sysroot/usr'. Oct 27 23:33:03.411559 systemd[1]: Finished initrd-setup-root-after-ignition.service - Root filesystem completion. Oct 27 23:33:03.416000 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' Oct 27 23:33:03.436624 kernel: audit: type=1130 audit(1793143983.416:45): pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=initrd-setup-root-after-ignition comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Oct 27 23:33:03.435753 systemd[1]: Starting initrd-parse-etc.service - Mountpoints Configured in the Real Root... Oct 27 23:33:03.478434 systemd[1]: initrd-parse-etc.service: Deactivated successfully. Oct 27 23:33:03.478581 systemd[1]: Finished initrd-parse-etc.service - Mountpoints Configured in the Real Root. Oct 27 23:33:03.487000 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' Oct 27 23:33:03.488942 systemd[1]: initrd-parse-etc.service: Triggering OnSuccess= dependencies. Oct 27 23:33:03.487000 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' Oct 27 23:33:03.533677 kernel: audit: type=1130 audit(1793143983.487:46): pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=initrd-parse-etc comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Oct 27 23:33:03.489226 systemd[1]: Reached target initrd-fs.target - Initrd File Systems. Oct 27 23:33:03.538416 kernel: audit: type=1131 audit(1793143983.487:47): pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=initrd-parse-etc comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Oct 27 23:33:03.533831 systemd[1]: Starting dracut-mount.service - dracut mount hook... Oct 27 23:33:03.831823 systemd[1]: Finished dracut-mount.service - dracut mount hook. Oct 27 23:33:03.835000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=dracut-mount comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Oct 27 23:33:03.853659 kernel: audit: type=1130 audit(1793143983.835:48): pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=dracut-mount comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Oct 27 23:33:03.854051 systemd[1]: Starting dracut-pre-pivot.service - dracut pre-pivot and cleanup hook... Oct 27 23:33:03.878362 systemd[1]: Finished dracut-pre-pivot.service - dracut pre-pivot and cleanup hook. Oct 27 23:33:03.883000 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' Oct 27 23:33:03.902668 kernel: audit: type=1130 audit(1793143983.883:49): pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=dracut-pre-pivot comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Oct 27 23:33:03.902768 systemd[1]: Starting initrd-cleanup.service - Cleaning Up and Shutting Down Daemons... Oct 27 23:33:03.927408 systemd[1]: Stopped target basic.target - Basic System. Oct 27 23:33:03.931783 systemd[1]: Stopped target ignition-diskful.target - Ignition Boot Disk Setup. Oct 27 23:33:03.940356 systemd[1]: Stopped target initrd-root-device.target - Initrd Root Device. Oct 27 23:33:03.950557 systemd[1]: Stopped target initrd-usr-fs.target - Initrd /usr File System. Oct 27 23:33:03.959462 systemd[1]: Stopped target nss-lookup.target - Host and Network Name Lookups. Oct 27 23:33:03.968616 systemd[1]: Stopped target paths.target - Path Units. Oct 27 23:33:03.977290 systemd[1]: Stopped target remote-cryptsetup.target - Remote Encrypted Volumes. Oct 27 23:33:03.985781 systemd[1]: Stopped target slices.target - Slice Units. Oct 27 23:33:03.994163 systemd[1]: Stopped target sockets.target - Socket Units. Oct 27 23:33:04.001199 systemd[1]: Stopped target sysinit.target - System Initialization. Oct 27 23:33:04.009682 systemd[1]: Stopped target local-fs.target - Local File Systems. Oct 27 23:33:04.018799 systemd[1]: Stopped target local-fs-pre.target - Preparation for Local File Systems. Oct 27 23:33:04.029193 systemd[1]: Stopped target swap.target - Swaps. Oct 27 23:33:04.039005 systemd[1]: Stopped target timers.target - Timer Units. Oct 27 23:33:04.046498 systemd[1]: iscsid.socket: Deactivated successfully. Oct 27 23:33:04.046619 systemd[1]: Closed iscsid.socket - Open-iSCSI iscsid Socket. Oct 27 23:33:04.054262 systemd[1]: iscsiuio.socket: Deactivated successfully. Oct 27 23:33:04.054315 systemd[1]: Closed iscsiuio.socket - Open-iSCSI iscsiuio Socket. Oct 27 23:33:04.064278 systemd[1]: systemd-coredump.socket: Deactivated successfully. Oct 27 23:33:04.089000 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' Oct 27 23:33:04.064341 systemd[1]: Closed systemd-coredump.socket - Process Core Dump Socket. Oct 27 23:33:04.073009 systemd[1]: systemd-journald-audit.socket: Deactivated successfully. Oct 27 23:33:04.073057 systemd[1]: Closed systemd-journald-audit.socket - Journal Audit Socket. Oct 27 23:33:04.130000 audit[1]: SERVICE_STOP pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=dracut-mount comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Oct 27 23:33:04.137933 kernel: audit: type=1131 audit(1793143984.089: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' Oct 27 23:33:04.081146 systemd[1]: dracut-pre-pivot.service: Deactivated successfully. Oct 27 23:33:04.142000 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' Oct 27 23:33:04.081217 systemd[1]: Stopped dracut-pre-pivot.service - dracut pre-pivot and cleanup hook. Oct 27 23:33:04.091113 systemd[1]: Stopped target remote-fs.target - Remote File Systems. Oct 27 23:33:04.113783 systemd[1]: Stopped target remote-fs-pre.target - Preparation for Remote File Systems. Oct 27 23:33:04.123800 systemd[1]: dracut-mount.service: Deactivated successfully. Oct 27 23:33:04.123894 systemd[1]: Stopped dracut-mount.service - dracut mount hook. Oct 27 23:33:04.131860 systemd[1]: dracut-pre-mount.service: Deactivated successfully. Oct 27 23:33:04.197000 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' Oct 27 23:33:04.131928 systemd[1]: Stopped dracut-pre-mount.service - dracut pre-mount hook. Oct 27 23:33:04.206000 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' Oct 27 23:33:04.143702 systemd[1]: Stopped target cryptsetup.target - Local Encrypted Volumes. Oct 27 23:33:04.215000 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' Oct 27 23:33:04.153324 systemd[1]: systemd-ask-password-console.path: Deactivated successfully. Oct 27 23:33:04.224000 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' Oct 27 23:33:04.153731 systemd[1]: Stopped systemd-ask-password-console.path - Dispatch Password Requests to Console Directory Watch. Oct 27 23:33:04.168697 systemd[1]: Stopped target cryptsetup-pre.target - Local Encrypted Volumes (Pre). Oct 27 23:33:04.248000 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' Oct 27 23:33:04.179224 systemd[1]: clevis-luks-askpass.path: Deactivated successfully. Oct 27 23:33:04.179640 systemd[1]: Stopped clevis-luks-askpass.path - Forward Password Requests to Clevis Directory Watch. Oct 27 23:33:04.271000 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' Oct 27 23:33:04.278937 ignition[1658]: INFO : Ignition 2.27.0 Oct 27 23:33:04.278937 ignition[1658]: INFO : Stage: umount Oct 27 23:33:04.278937 ignition[1658]: INFO : no config dir at "/run/ignition/base.d" Oct 27 23:33:04.278937 ignition[1658]: INFO : no config dir at "/etc/ignition/base.d" Oct 27 23:33:04.278937 ignition[1658]: INFO : no config dir at "/usr/lib/ignition/base.d" Oct 27 23:33:04.278937 ignition[1658]: INFO : no configs found in "base.d" across system config directories Oct 27 23:33:04.278937 ignition[1658]: INFO : no config dir at "/run/ignition/base.platform.d/azure" Oct 27 23:33:04.278937 ignition[1658]: INFO : no config dir at "/etc/ignition/base.platform.d/azure" Oct 27 23:33:04.278937 ignition[1658]: INFO : no config dir at "/usr/lib/ignition/base.platform.d/azure" Oct 27 23:33:04.278937 ignition[1658]: INFO : no configs found in "base.platform.d/azure" across system config directories Oct 27 23:33:04.278937 ignition[1658]: INFO : umount: op(1): [started] umounting "/sysroot/var/lib/data" Oct 27 23:33:04.285000 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' Oct 27 23:33:04.291000 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' Oct 27 23:33:04.303000 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' Oct 27 23:33:04.319000 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' Oct 27 23:33:04.329000 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' Oct 27 23:33:04.339000 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' Oct 27 23:33:04.370000 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' Oct 27 23:33:04.370000 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' Oct 27 23:33:04.189729 systemd[1]: dracut-initqueue.service: Deactivated successfully. Oct 27 23:33:04.380000 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' Oct 27 23:33:04.385218 kernel: EXT4-fs (dm-1): unmounting filesystem 29aaab59-942c-481f-8d94-9ffe885e905c. Oct 27 23:33:04.385235 ignition[1658]: INFO : umount: op(1): [finished] umounting "/sysroot/var/lib/data" Oct 27 23:33:04.385235 ignition[1658]: INFO : umount: umount passed Oct 27 23:33:04.385235 ignition[1658]: INFO : Ignition finished successfully Oct 27 23:33:04.393000 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' Oct 27 23:33:04.189866 systemd[1]: Stopped dracut-initqueue.service - dracut initqueue hook. Oct 27 23:33:04.404000 audit: BPF prog-id=5 op=UNLOAD Oct 27 23:33:04.198660 systemd[1]: initrd-setup-root-after-ignition.service: Deactivated successfully. Oct 27 23:33:04.198785 systemd[1]: Stopped initrd-setup-root-after-ignition.service - Root filesystem completion. Oct 27 23:33:04.208084 systemd[1]: ignition-files.service: Deactivated successfully. Oct 27 23:33:04.208162 systemd[1]: Stopped ignition-files.service - Ignition (files). Oct 27 23:33:04.216757 systemd[1]: flatcar-metadata-hostname.service: Deactivated successfully. Oct 27 23:33:04.216822 systemd[1]: Stopped flatcar-metadata-hostname.service - Flatcar Metadata Hostname Agent. Oct 27 23:33:04.226702 systemd[1]: Stopping ignition-mount.service - Ignition (mount)... Oct 27 23:33:04.236805 systemd[1]: systemd-modules-load.service: Deactivated successfully. Oct 27 23:33:04.236905 systemd[1]: Stopped systemd-modules-load.service - Load Kernel Modules. Oct 27 23:33:04.250298 systemd[1]: systemd-tmpfiles-setup.service: Deactivated successfully. Oct 27 23:33:04.490000 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' Oct 27 23:33:04.250377 systemd[1]: Stopped systemd-tmpfiles-setup.service - Create System Files and Directories. Oct 27 23:33:04.273539 systemd[1]: systemd-udev-trigger.service: Deactivated successfully. Oct 27 23:33:04.513000 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' Oct 27 23:33:04.273634 systemd[1]: Stopped systemd-udev-trigger.service - Coldplug All udev Devices. Oct 27 23:33:04.521000 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' Oct 27 23:33:04.287538 systemd[1]: dracut-pre-trigger.service: Deactivated successfully. Oct 27 23:33:04.537000 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' Oct 27 23:33:04.287640 systemd[1]: Stopped dracut-pre-trigger.service - dracut pre-trigger hook. Oct 27 23:33:04.295870 systemd[1]: sysroot-var-lib-data.mount: Deactivated successfully. Oct 27 23:33:04.557711 kernel: hv_netvsc 000d3ac5-22bd-000d-3ac5-22bd000d3ac5 eth0: Data path switched from VF: enP24261s1 Oct 27 23:33:04.296632 systemd[1]: ignition-mount.service: Deactivated successfully. Oct 27 23:33:04.561000 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' Oct 27 23:33:04.296738 systemd[1]: Stopped ignition-mount.service - Ignition (mount). Oct 27 23:33:04.570000 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' Oct 27 23:33:04.578000 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' Oct 27 23:33:04.305354 systemd[1]: Stopped target network.target - Network. Oct 27 23:33:04.590000 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' Oct 27 23:33:04.312874 systemd[1]: ignition-disks.service: Deactivated successfully. Oct 27 23:33:04.599000 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' Oct 27 23:33:04.312919 systemd[1]: Stopped ignition-disks.service - Ignition (disks). Oct 27 23:33:04.608000 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' Oct 27 23:33:04.608000 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' Oct 27 23:33:04.321141 systemd[1]: ignition-disks.service: Consumed 12.719s CPU time over 42.376s wall clock time. Oct 27 23:33:04.321188 systemd[1]: ignition-setup-pre.service: Deactivated successfully. Oct 27 23:33:04.321219 systemd[1]: Stopped ignition-setup-pre.service - Ignition env setup. Oct 27 23:33:04.331091 systemd[1]: initrd-setup-root.service: Deactivated successfully. Oct 27 23:33:04.331118 systemd[1]: Stopped initrd-setup-root.service - Root filesystem setup. Oct 27 23:33:04.340540 systemd[1]: Stopping systemd-networkd.service - Network Management... Oct 27 23:33:04.344980 systemd-networkd[704]: eth0: DHCP lease lost Oct 27 23:33:04.639000 audit: BPF prog-id=8 op=UNLOAD Oct 27 23:33:04.351559 systemd[1]: Stopping systemd-resolved.service - Network Name Resolution... Oct 27 23:33:04.360129 systemd[1]: initrd-cleanup.service: Deactivated successfully. Oct 27 23:33:04.652000 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' Oct 27 23:33:04.360233 systemd[1]: Finished initrd-cleanup.service - Cleaning Up and Shutting Down Daemons. Oct 27 23:33:04.372105 systemd[1]: systemd-resolved.service: Deactivated successfully. Oct 27 23:33:04.372212 systemd[1]: Stopped systemd-resolved.service - Network Name Resolution. Oct 27 23:33:04.386411 systemd[1]: systemd-networkd.service: Deactivated successfully. Oct 27 23:33:04.386545 systemd[1]: Stopped systemd-networkd.service - Network Management. Oct 27 23:33:04.402483 systemd[1]: systemd-networkd-resolve-hook.socket: Deactivated successfully. Oct 27 23:33:04.402585 systemd[1]: Closed systemd-networkd-resolve-hook.socket - Network Management Resolve Hook Socket. Oct 27 23:33:04.411788 systemd[1]: Stopped target network-pre.target - Preparation for Network. Oct 27 23:33:04.420894 systemd[1]: systemd-networkd.socket: Deactivated successfully. Oct 27 23:33:04.420961 systemd[1]: Closed systemd-networkd.socket - Network Management Netlink Socket. Oct 27 23:33:04.431471 systemd[1]: Stopping network-cleanup.service - Network Cleanup... Oct 27 23:33:04.441709 systemd[1]: Stopping systemd-udevd.service - Rule-based Manager for Device Events and Files... Oct 27 23:33:04.477611 systemd[1]: systemd-udevd.service: Deactivated successfully. Oct 27 23:33:04.478773 systemd[1]: Stopped systemd-udevd.service - Rule-based Manager for Device Events and Files. Oct 27 23:33:04.492365 systemd[1]: systemd-udevd.service: Consumed 1.136s CPU time over 44.706s wall clock time. Oct 27 23:33:04.492789 systemd[1]: systemd-udevd-control.socket: Deactivated successfully. Oct 27 23:33:04.492847 systemd[1]: Closed systemd-udevd-control.socket - udev Control Socket. Oct 27 23:33:04.503823 systemd[1]: dracut-pre-udev.service: Deactivated successfully. Oct 27 23:33:04.503871 systemd[1]: Stopped dracut-pre-udev.service - dracut pre-udev hook. Oct 27 23:33:04.514391 systemd[1]: dracut-cmdline.service: Deactivated successfully. Oct 27 23:33:04.514424 systemd[1]: Stopped dracut-cmdline.service - dracut cmdline hook. Oct 27 23:33:04.522561 systemd[1]: dracut-cmdline-ask.service: Deactivated successfully. Oct 27 23:33:04.522590 systemd[1]: Stopped dracut-cmdline-ask.service - dracut ask for additional cmdline parameters. Oct 27 23:33:04.544540 systemd[1]: Starting initrd-udevadm-cleanup-db.service - Cleanup udev Database... Oct 27 23:33:04.553957 systemd[1]: systemd-network-generator.service: Deactivated successfully. Oct 27 23:33:04.788489 systemd-journald[514]: Received SIGTERM from PID 1 (systemd). Oct 27 23:33:04.554006 systemd[1]: Stopped systemd-network-generator.service - Generate Network Units from Kernel Command Line. Oct 27 23:33:04.562839 systemd[1]: systemd-tmpfiles-setup-dev.service: Deactivated successfully. Oct 27 23:33:04.562877 systemd[1]: Stopped systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev. Oct 27 23:33:04.572131 systemd[1]: systemd-tmpfiles-setup-dev-early.service: Deactivated successfully. Oct 27 23:33:04.572169 systemd[1]: Stopped systemd-tmpfiles-setup-dev-early.service - Create Static Device Nodes in /dev gracefully. Oct 27 23:33:04.580393 systemd[1]: kmod-static-nodes.service: Deactivated successfully. Oct 27 23:33:04.580436 systemd[1]: Stopped kmod-static-nodes.service - Create List of Static Device Nodes. Oct 27 23:33:04.592014 systemd[1]: systemd-vconsole-setup.service: Deactivated successfully. Oct 27 23:33:04.592057 systemd[1]: Stopped systemd-vconsole-setup.service - Virtual Console Setup. Oct 27 23:33:04.600893 systemd[1]: initrd-udevadm-cleanup-db.service: Deactivated successfully. Oct 27 23:33:04.600999 systemd[1]: Finished initrd-udevadm-cleanup-db.service - Cleanup udev Database. Oct 27 23:33:04.644233 systemd[1]: network-cleanup.service: Deactivated successfully. Oct 27 23:33:04.649021 systemd[1]: Stopped network-cleanup.service - Network Cleanup. Oct 27 23:33:04.653940 systemd[1]: Reached target initrd-switch-root.target - Switch Root. Oct 27 23:33:04.662525 systemd[1]: Starting initrd-switch-root.service - Switch Root... Oct 27 23:33:04.691181 systemd[1]: Switching root. Oct 27 23:33:04.866748 systemd-journald[514]: Journal stopped Oct 27 23:33:10.240248 kernel: SELinux: policy capability network_peer_controls=1 Oct 27 23:33:10.240283 kernel: SELinux: policy capability open_perms=1 Oct 27 23:33:10.240291 kernel: SELinux: policy capability extended_socket_class=1 Oct 27 23:33:10.240298 kernel: SELinux: policy capability always_check_network=0 Oct 27 23:33:10.240303 kernel: SELinux: policy capability cgroup_seclabel=1 Oct 27 23:33:10.240309 kernel: SELinux: policy capability nnp_nosuid_transition=1 Oct 27 23:33:10.240317 kernel: SELinux: policy capability genfs_seclabel_symlinks=0 Oct 27 23:33:10.240322 kernel: SELinux: policy capability ioctl_skip_cloexec=0 Oct 27 23:33:10.240328 kernel: SELinux: policy capability userspace_initial_context=0 Oct 27 23:33:10.240334 systemd[1]: Successfully loaded SELinux policy in 141.901ms. Oct 27 23:33:10.240341 systemd[1]: Relabeled /dev/, /dev/shm/, /run/ in 6.495ms. Oct 27 23:33:10.240349 systemd[1]: systemd 261.2 running in system mode (+PAM +AUDIT +SELINUX -APPARMOR +IMA +IPE +SMACK +SECCOMP -GCRYPT -GNUTLS +OPENSSL -ACL +BLKID +CURL +ELFUTILS -FIDO2 +IDN2 +KMOD +LIBCRYPTSETUP +LIBCRYPTSETUP_PLUGINS +LIBFDISK +PCRE2 -PWQUALITY -P11KIT -QRENCODE +TPM2 +BZIP2 +LZ4 +XZ +ZLIB +ZSTD -BPF_FRAMEWORK -BTF -XKBCOMMON +UTMP +LIBARCHIVE) Oct 27 23:33:10.240355 systemd[1]: Detected virtualization microsoft. Oct 27 23:33:10.240363 systemd[1]: Detected architecture arm64. Oct 27 23:33:10.240370 systemd[1]: Detected first boot. Oct 27 23:33:10.240377 systemd[1]: Initializing machine ID from random generator. Oct 27 23:33:10.240384 systemd[1]: Hostname set to . Oct 27 23:33:10.240390 kernel: kauditd_printk_skb: 34 callbacks suppressed Oct 27 23:33:10.240396 kernel: audit: type=1334 audit(1793143986.849:85): prog-id=9 op=LOAD Oct 27 23:33:10.240402 kernel: audit: type=1334 audit(1793143986.849:86): prog-id=9 op=UNLOAD Oct 27 23:33:10.240408 zram_generator::config[1699]: No configuration found. Oct 27 23:33:10.240416 kernel: NET: Registered PF_VSOCK protocol family Oct 27 23:33:10.240422 systemd[1]: Applying preset policy. Oct 27 23:33:10.240429 systemd[1]: Created symlink '/etc/systemd/system/local-fs.target.requires/var-lib-data.mount' → '/etc/systemd/system/var-lib-data.mount'. Oct 27 23:33:10.240436 systemd[1]: Populated /etc with preset unit settings. Oct 27 23:33:10.240442 kernel: audit: type=1334 audit(1793143989.187:87): prog-id=10 op=LOAD Oct 27 23:33:10.240448 kernel: audit: type=1334 audit(1793143989.187:88): prog-id=2 op=UNLOAD Oct 27 23:33:10.240454 kernel: audit: type=1334 audit(1793143989.187:89): prog-id=11 op=LOAD Oct 27 23:33:10.240460 kernel: audit: type=1334 audit(1793143989.187:90): prog-id=12 op=LOAD Oct 27 23:33:10.240466 kernel: audit: type=1334 audit(1793143989.187:91): prog-id=3 op=UNLOAD Oct 27 23:33:10.240472 kernel: audit: type=1334 audit(1793143989.187:92): prog-id=4 op=UNLOAD Oct 27 23:33:10.240477 kernel: audit: type=1334 audit(1793143989.187:93): prog-id=13 op=LOAD Oct 27 23:33:10.240483 kernel: audit: type=1334 audit(1793143989.187:94): prog-id=10 op=UNLOAD Oct 27 23:33:10.240489 systemd[1]: initrd-switch-root.service: Deactivated successfully. Oct 27 23:33:10.240497 systemd[1]: Stopped initrd-switch-root.service - Switch Root. Oct 27 23:33:10.240503 systemd[1]: systemd-journald.service: Scheduled restart job, restart counter is at 1. Oct 27 23:33:10.240510 systemd[1]: Created slice system-addon\x2dconfig.slice - Slice /system/addon-config. Oct 27 23:33:10.240516 systemd[1]: Created slice system-addon\x2drun.slice - Slice /system/addon-run. Oct 27 23:33:10.240523 systemd[1]: Created slice system-getty.slice - Slice /system/getty. Oct 27 23:33:10.240530 systemd[1]: Created slice system-modprobe.slice - Slice /system/modprobe. Oct 27 23:33:10.240537 systemd[1]: Created slice system-serial\x2dgetty.slice - Slice /system/serial-getty. Oct 27 23:33:10.240545 systemd[1]: Created slice system-system\x2dcloudinit.slice - Slice /system/system-cloudinit. Oct 27 23:33:10.240551 systemd[1]: Created slice system-systemd\x2dcryptsetup.slice - Encrypted Volume Units Service Slice. Oct 27 23:33:10.240563 systemd[1]: Created slice system-systemd\x2dfsck.slice - Slice /system/systemd-fsck. Oct 27 23:33:10.240569 systemd[1]: Created slice user.slice - User and Session Slice. Oct 27 23:33:10.240576 systemd[1]: Started clevis-luks-askpass.path - Forward Password Requests to Clevis Directory Watch. Oct 27 23:33:10.240583 systemd[1]: Started systemd-ask-password-console.path - Dispatch Password Requests to Console Directory Watch. Oct 27 23:33:10.240590 systemd[1]: Started systemd-ask-password-wall.path - Forward Password Requests to Wall Directory Watch. Oct 27 23:33:10.240596 systemd[1]: Set up automount boot.automount - Boot partition Automount Point. Oct 27 23:33:10.240630 systemd[1]: Set up automount proc-sys-fs-binfmt_misc.automount - Arbitrary Executable File Formats File System Automount Point. Oct 27 23:33:10.240636 systemd[1]: Expecting device dev-disk-by\x2dlabel-OEM.device - /dev/disk/by-label/OEM... Oct 27 23:33:10.240643 systemd[1]: Expecting device dev-disk-by\x2duuid-40e3b59b\x2df68b\x2d451b\x2d9977\x2dfd516c6a1ccc.device - /dev/disk/by-uuid/40e3b59b-f68b-451b-9977-fd516c6a1ccc... Oct 27 23:33:10.240650 systemd[1]: Expecting device dev-ptp_hyperv.device - /dev/ptp_hyperv... Oct 27 23:33:10.240658 systemd[1]: Expecting device dev-ttyAMA0.device - /dev/ttyAMA0... Oct 27 23:33:10.240664 systemd[1]: Reached target cryptsetup-pre.target - Local Encrypted Volumes (Pre). Oct 27 23:33:10.240672 systemd[1]: Reached target imports.target - Image Downloads. Oct 27 23:33:10.240679 systemd[1]: Stopped target initrd-switch-root.target - Switch Root. Oct 27 23:33:10.240685 systemd[1]: Stopped target initrd-fs.target - Initrd File Systems. Oct 27 23:33:10.240691 systemd[1]: Stopped target initrd-root-fs.target - Initrd Root File System. Oct 27 23:33:10.240699 systemd[1]: Reached target integritysetup.target - Local Integrity Protected Volumes. Oct 27 23:33:10.240705 systemd[1]: Reached target remote-cryptsetup.target - Remote Encrypted Volumes. Oct 27 23:33:10.240712 systemd[1]: Reached target remote-fs.target - Remote File Systems. Oct 27 23:33:10.240718 systemd[1]: Reached target remote-integritysetup.target - Remote Integrity Protected Volumes. Oct 27 23:33:10.240726 systemd[1]: Reached target remote-veritysetup.target - Remote Verity Protected Volumes. Oct 27 23:33:10.240732 systemd[1]: Reached target slices.target - Slice Units. Oct 27 23:33:10.240739 systemd[1]: Reached target swap.target - Swaps. Oct 27 23:33:10.240745 systemd[1]: Reached target veritysetup.target - Local Verity Protected Volumes. Oct 27 23:33:10.240751 systemd[1]: Listening on systemd-ask-password.socket - Query the User Interactively for a Password. Oct 27 23:33:10.240758 systemd[1]: Listening on systemd-coredump.socket - Process Core Dump Socket. Oct 27 23:33:10.240765 systemd[1]: Listening on systemd-creds.socket - Credential Encryption/Decryption. Oct 27 23:33:10.240772 systemd[1]: Listening on systemd-factory-reset.socket - Factory Reset Management. Oct 27 23:33:10.240778 systemd[1]: Listening on systemd-hostnamed.socket - Hostname Service Socket. Oct 27 23:33:10.240784 systemd[1]: Listening on systemd-journald-audit.socket - Journal Audit Socket. Oct 27 23:33:10.240791 systemd[1]: Listening on systemd-mountfsd.socket - DDI File System Mounter Socket. Oct 27 23:33:10.240797 systemd[1]: Listening on systemd-mute-console.socket - Console Output Muting Service Socket. Oct 27 23:33:10.240804 systemd[1]: Listening on systemd-networkd-varlink-metrics.socket - Network Management Metrics Varlink Socket. Oct 27 23:33:10.240812 systemd[1]: Listening on systemd-networkd-varlink.socket - Network Management Varlink Socket. Oct 27 23:33:10.240819 systemd[1]: Listening on systemd-networkd.socket - Network Management Netlink Socket. Oct 27 23:33:10.240825 systemd[1]: Listening on systemd-nsresourced.socket - Namespace Resource Manager Socket. Oct 27 23:33:10.240831 systemd[1]: Listening on systemd-oomd.socket - Userspace Out-Of-Memory (OOM) Killer Socket. Oct 27 23:33:10.240838 systemd[1]: Listening on systemd-repart.socket - Disk Repartitioning Service Socket. Oct 27 23:33:10.240844 systemd[1]: Listening on systemd-report-basic.socket - Report System Basic Metrics Socket. Oct 27 23:33:10.240852 systemd[1]: Listening on systemd-report-cgroup.socket - CGroup Report Varlink Socket. Oct 27 23:33:10.240858 systemd[1]: Listening on systemd-resolved-monitor.socket - Resolve Monitor Varlink Socket. Oct 27 23:33:10.240864 systemd[1]: Listening on systemd-resolved-varlink.socket - Resolve Service Varlink Socket. Oct 27 23:33:10.240871 systemd[1]: Listening on systemd-storage-block.socket - Simple Block Device Backed Storage Provider. Oct 27 23:33:10.240877 systemd[1]: Listening on systemd-storage-fs.socket - Simple File System Backed Storage Provider. Oct 27 23:33:10.240884 systemd[1]: Listening on systemd-udevd-control.socket - udev Control Socket. Oct 27 23:33:10.240890 systemd[1]: Listening on systemd-udevd-varlink.socket - udev Varlink Socket. Oct 27 23:33:10.240898 systemd[1]: Listening on systemd-userdbd.socket - User Database Manager Socket. Oct 27 23:33:10.240904 systemd[1]: Mounting dev-hugepages.mount - Huge Pages File System... Oct 27 23:33:10.240911 systemd[1]: Mounting dev-mqueue.mount - POSIX Message Queue File System... Oct 27 23:33:10.240917 systemd[1]: Mounting media.mount - External Media Directory... Oct 27 23:33:10.240923 systemd[1]: Mounting sys-kernel-debug.mount - Kernel Debug File System... Oct 27 23:33:10.240930 systemd[1]: Mounting sys-kernel-tracing.mount - Kernel Trace File System... Oct 27 23:33:10.240936 systemd[1]: tmp.mount: x-systemd.graceful-option=usrquota specified, but option is not available, suppressing. Oct 27 23:33:10.240944 systemd[1]: Mounting tmp.mount - Temporary Directory /tmp... Oct 27 23:33:10.240951 systemd[1]: Starting flatcar-tmpfiles.service - Create missing system files... Oct 27 23:33:10.240957 systemd[1]: ignition-delete-config.service - Ignition (delete config) skipped, no trigger condition checks were met. Oct 27 23:33:10.240964 systemd[1]: Starting kmod-static-nodes.service - Create List of Static Device Nodes... Oct 27 23:33:10.240970 systemd[1]: Starting modprobe@configfs.service - Load Kernel Module configfs... Oct 27 23:33:10.240977 systemd[1]: modprobe@drm.service - Load Kernel Module drm skipped, unmet condition check ConditionKernelModuleLoaded=!drm Oct 27 23:33:10.240984 systemd[1]: Starting modprobe@efi_pstore.service - Load Kernel Module efi_pstore... Oct 27 23:33:10.240991 systemd[1]: Starting modprobe@fuse.service - Load Kernel Module fuse... Oct 27 23:33:10.240998 systemd[1]: setup-nsswitch.service - Create /etc/nsswitch.conf skipped, unmet condition check ConditionPathExists=!/etc/nsswitch.conf Oct 27 23:33:10.241004 systemd[1]: systemd-fsck-root.service: Deactivated successfully. Oct 27 23:33:10.241011 systemd[1]: Stopped systemd-fsck-root.service - File System Check on Root Device. Oct 27 23:33:10.241017 systemd[1]: systemd-hibernate-clear.service - Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 Oct 27 23:33:10.241024 systemd[1]: Starting systemd-journald.service - Journal Service... Oct 27 23:33:10.241031 systemd[1]: Starting systemd-modules-load.service - Load Kernel Modules... Oct 27 23:33:10.241038 systemd[1]: Starting systemd-network-generator.service - Generate Network Units from Kernel Command Line... Oct 27 23:33:10.241044 systemd[1]: Reached target time-set.target - System Time Set. Oct 27 23:33:10.241076 systemd-journald[1775]: Collecting audit messages is enabled. Oct 27 23:33:10.241094 kernel: fuse: init (API version 7.41) Oct 27 23:33:10.241103 systemd-journald[1775]: Journal started Oct 27 23:33:10.241118 systemd-journald[1775]: Runtime Journal (/run/log/journal/046e5e049d8a453cb08aeb9578ade096) is 8M, max 78.3M, 70.3M free. Oct 27 23:33:09.727000 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 Oct 27 23:33:10.158000 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' Oct 27 23:33:10.170000 audit: BPF prog-id=18 op=UNLOAD Oct 27 23:33:10.170000 audit: BPF prog-id=17 op=UNLOAD Oct 27 23:33:10.171000 audit: BPF prog-id=19 op=LOAD Oct 27 23:33:10.171000 audit: BPF prog-id=20 op=LOAD Oct 27 23:33:10.171000 audit: BPF prog-id=21 op=LOAD Oct 27 23:33:10.233000 audit: CONFIG_CHANGE op=set audit_enabled=1 old=1 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 res=1 Oct 27 23:33:10.233000 audit[1775]: SYSCALL arch=c00000b7 syscall=211 success=yes exit=60 a0=4 a1=ffffd17d4130 a2=4000 a3=0 items=0 ppid=1 pid=1775 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) Oct 27 23:33:10.233000 audit: PROCTITLE proctitle="/usr/lib/systemd/systemd-journald" Oct 27 23:33:09.177821 systemd[1]: Queued start job for default target multi-user.target. Oct 27 23:33:09.202272 systemd[1]: Unnecessary job was removed for dev-sda6.device - /dev/sda6. Oct 27 23:33:09.202790 systemd[1]: systemd-journald.service: Deactivated successfully. Oct 27 23:33:09.303365 systemd[1]: systemd-journald.service: Consumed 3.229s CPU time over 50.394s wall clock time. Oct 27 23:33:10.258282 systemd[1]: Starting systemd-remount-fs.service - Remount Root and Kernel File Systems... Oct 27 23:33:10.272832 systemd[1]: Starting systemd-udev-load-credentials.service - Load udev Rules from Credentials... Oct 27 23:33:10.273162 systemd-modules-load[1777]: Using 2 probe threads Oct 27 23:33:10.291675 systemd[1]: Starting systemd-udev-trigger.service - Coldplug All udev Devices... Oct 27 23:33:10.300926 systemd[1]: Started systemd-journald.service - Journal Service. Oct 27 23:33:10.299000 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' Oct 27 23:33:10.302003 systemd[1]: Mounted dev-hugepages.mount - Huge Pages File System. Oct 27 23:33:10.306742 systemd[1]: Mounted dev-mqueue.mount - POSIX Message Queue File System. Oct 27 23:33:10.312030 systemd[1]: Mounted media.mount - External Media Directory. Oct 27 23:33:10.316427 systemd[1]: Mounted sys-kernel-debug.mount - Kernel Debug File System. Oct 27 23:33:10.321129 systemd[1]: Mounted sys-kernel-tracing.mount - Kernel Trace File System. Oct 27 23:33:10.327260 systemd[1]: Mounted tmp.mount - Temporary Directory /tmp. Oct 27 23:33:10.332047 systemd[1]: Finished kmod-static-nodes.service - Create List of Static Device Nodes. Oct 27 23:33:10.335000 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' Oct 27 23:33:10.337307 systemd[1]: modprobe@configfs.service: Deactivated successfully. Oct 27 23:33:10.337507 systemd[1]: Finished modprobe@configfs.service - Load Kernel Module configfs. Oct 27 23:33:10.341000 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' Oct 27 23:33:10.341000 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' Oct 27 23:33:10.343856 systemd[1]: modprobe@efi_pstore.service: Deactivated successfully. Oct 27 23:33:10.344075 systemd[1]: Finished modprobe@efi_pstore.service - Load Kernel Module efi_pstore. Oct 27 23:33:10.349000 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' Oct 27 23:33:10.349000 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' Oct 27 23:33:10.351202 systemd[1]: modprobe@fuse.service: Deactivated successfully. Oct 27 23:33:10.351344 systemd[1]: Finished modprobe@fuse.service - Load Kernel Module fuse. Oct 27 23:33:10.354000 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' Oct 27 23:33:10.354000 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' Oct 27 23:33:10.356909 systemd[1]: Finished systemd-modules-load.service - Load Kernel Modules. Oct 27 23:33:10.360000 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' Oct 27 23:33:10.362781 systemd[1]: Finished systemd-network-generator.service - Generate Network Units from Kernel Command Line. Oct 27 23:33:10.366000 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' Oct 27 23:33:10.369276 systemd[1]: Finished systemd-remount-fs.service - Remount Root and Kernel File Systems. Oct 27 23:33:10.373000 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' Oct 27 23:33:10.375168 systemd[1]: Finished systemd-udev-load-credentials.service - Load udev Rules from Credentials. Oct 27 23:33:10.379000 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' Oct 27 23:33:10.381512 systemd[1]: Finished systemd-udev-trigger.service - Coldplug All udev Devices. Oct 27 23:33:10.385000 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' Oct 27 23:33:10.395513 systemd[1]: Reached target network-pre.target - Preparation for Network. Oct 27 23:33:10.400541 systemd[1]: Listening on systemd-networkd-resolve-hook.socket - Network Management Resolve Hook Socket. Oct 27 23:33:10.406821 systemd[1]: Mounting sys-fs-fuse-connections.mount - FUSE Control File System... Oct 27 23:33:10.415711 systemd[1]: Mounting sys-kernel-config.mount - Kernel Configuration File System... Oct 27 23:33:10.421111 systemd[1]: remount-root.service - Remount Root File System skipped, unmet condition check ConditionPathIsReadWrite=!/ Oct 27 23:33:10.422763 systemd[1]: Starting systemd-hwdb-update.service - Rebuild Hardware Database... Oct 27 23:33:10.428156 systemd[1]: Starting systemd-journal-flush.service - Flush Journal to Persistent Storage... Oct 27 23:33:10.433094 systemd[1]: systemd-pstore.service - Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore Oct 27 23:33:10.433984 systemd[1]: Starting systemd-random-seed.service - Load/Save OS Random Seed... Oct 27 23:33:10.440793 systemd[1]: Starting systemd-sysctl.service - Apply Kernel Variables... Oct 27 23:33:10.446202 systemd[1]: Starting systemd-tmpfiles-setup-dev-early.service - Create Static Device Nodes in /dev gracefully... Oct 27 23:33:10.453043 systemd[1]: Mounted sys-fs-fuse-connections.mount - FUSE Control File System. Oct 27 23:33:10.460588 systemd[1]: Mounted sys-kernel-config.mount - Kernel Configuration File System. Oct 27 23:33:10.469063 systemd[1]: Finished systemd-random-seed.service - Load/Save OS Random Seed. Oct 27 23:33:10.472000 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' Oct 27 23:33:10.474570 systemd[1]: Reached target first-boot-complete.target - First Boot Complete. Oct 27 23:33:10.511158 systemd-journald[1775]: Time spent on flushing to /var/log/journal/046e5e049d8a453cb08aeb9578ade096 is 13.189ms for 1241 entries. Oct 27 23:33:10.511158 systemd-journald[1775]: System Journal (/var/log/journal/046e5e049d8a453cb08aeb9578ade096) is 8M, max 2.2G, 2.2G free. Oct 27 23:33:10.533000 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' Oct 27 23:33:10.526432 systemd[1]: Finished systemd-sysctl.service - Apply Kernel Variables. Oct 27 23:33:10.560362 systemd-journald[1775]: Received client request to flush runtime journal. Oct 27 23:33:10.560922 systemd[1]: Finished systemd-journal-flush.service - Flush Journal to Persistent Storage. Oct 27 23:33:10.564000 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' Oct 27 23:33:10.634510 systemd[1]: Finished flatcar-tmpfiles.service - Create missing system files. Oct 27 23:33:10.637000 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' Oct 27 23:33:10.651271 systemd-tmpfiles[1829]: ACLs are not supported, ignoring. Oct 27 23:33:10.651589 systemd-tmpfiles[1829]: ACLs are not supported, ignoring. Oct 27 23:33:10.654019 systemd[1]: Finished systemd-tmpfiles-setup-dev-early.service - Create Static Device Nodes in /dev gracefully. Oct 27 23:33:10.657000 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' Oct 27 23:33:10.664751 systemd[1]: Starting systemd-sysusers.service - Create System Users... Oct 27 23:33:10.854760 systemd[1]: Finished systemd-sysusers.service - Create System Users. Oct 27 23:33:10.858000 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' Oct 27 23:33:10.862097 systemd[1]: Starting systemd-journalctl.socket - Journal Log Access Socket... Oct 27 23:33:10.867000 audit: BPF prog-id=22 op=LOAD Oct 27 23:33:10.867000 audit: BPF prog-id=23 op=LOAD Oct 27 23:33:10.867000 audit: BPF prog-id=24 op=LOAD Oct 27 23:33:10.870011 systemd[1]: Starting systemd-oomd.service - Userspace Out-Of-Memory (OOM) Killer... Oct 27 23:33:10.873000 audit: BPF prog-id=25 op=LOAD Oct 27 23:33:10.876163 systemd[1]: Starting systemd-resolved.service - Network Name Resolution... Oct 27 23:33:10.881653 systemd[1]: Starting systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev... Oct 27 23:33:10.887110 systemd[1]: Listening on systemd-journalctl.socket - Journal Log Access Socket. Oct 27 23:33:10.897302 systemd[1]: Starting modprobe@tun.service - Load Kernel Module tun... Oct 27 23:33:10.902000 audit: BPF prog-id=26 op=LOAD Oct 27 23:33:10.902000 audit: BPF prog-id=27 op=LOAD Oct 27 23:33:10.902000 audit: BPF prog-id=28 op=LOAD Oct 27 23:33:10.905545 systemd[1]: Starting systemd-userdbd.service - User Database Manager... Oct 27 23:33:10.913277 systemd-tmpfiles[1844]: ACLs are not supported, ignoring. Oct 27 23:33:10.913290 systemd-tmpfiles[1844]: ACLs are not supported, ignoring. Oct 27 23:33:10.918689 systemd[1]: Finished systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev. Oct 27 23:33:10.926000 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' Oct 27 23:33:10.928045 systemd[1]: Reached target local-fs-pre.target - Preparation for Local File Systems. Oct 27 23:33:10.938754 systemd[1]: Starting systemd-fsck@dev-disk-by\x2did-dm\x2dname\x2ddata.service - File System Check on /dev/disk/by-id/dm-name-data... Oct 27 23:33:10.943683 systemd[1]: systemd-repart.service - Repartition Root Disk skipped, no trigger condition checks were met. Oct 27 23:33:10.943959 systemd[1]: proc-sys-fs-binfmt_misc.automount: Got automount request for /proc/sys/fs/binfmt_misc, triggered by 1846 ((systemd-userd)) Oct 27 23:33:11.006620 kernel: tun: Universal TUN/TAP device driver, 1.6 Oct 27 23:33:11.008279 systemd[1]: modprobe@tun.service: Deactivated successfully. Oct 27 23:33:11.008450 systemd[1]: Finished modprobe@tun.service - Load Kernel Module tun. Oct 27 23:33:11.011000 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' Oct 27 23:33:11.011000 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' Oct 27 23:33:11.012000 audit: BPF prog-id=29 op=LOAD Oct 27 23:33:11.012000 audit: BPF prog-id=30 op=LOAD Oct 27 23:33:11.012000 audit: BPF prog-id=31 op=LOAD Oct 27 23:33:11.014731 systemd[1]: Starting systemd-nsresourced.service - Namespace Resource Manager... Oct 27 23:33:11.098943 systemd-fsck[1852]: DATA: clean, 12/130048 files, 18015/520192 blocks Oct 27 23:33:11.103671 systemd[1]: Finished systemd-hwdb-update.service - Rebuild Hardware Database. Oct 27 23:33:11.107000 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' Oct 27 23:33:11.109441 systemd[1]: Finished systemd-fsck@dev-disk-by\x2did-dm\x2dname\x2ddata.service - File System Check on /dev/disk/by-id/dm-name-data. Oct 27 23:33:11.113000 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' Oct 27 23:33:11.114000 audit: BPF prog-id=7 op=UNLOAD Oct 27 23:33:11.114000 audit: BPF prog-id=6 op=UNLOAD Oct 27 23:33:11.114000 audit: BPF prog-id=32 op=LOAD Oct 27 23:33:11.114000 audit: BPF prog-id=33 op=LOAD Oct 27 23:33:11.117184 systemd[1]: Starting systemd-udevd.service - Rule-based Manager for Device Events and Files... Oct 27 23:33:11.347438 systemd-udevd[1855]: Using default interface naming scheme 'v261'. Oct 27 23:33:11.370321 systemd[1]: Mounting proc-sys-fs-binfmt_misc.mount - Arbitrary Executable File Formats File System... Oct 27 23:33:11.386939 systemd[1]: Mounting var-lib-data.mount - /var/lib/data... Oct 27 23:33:11.390476 systemd[1]: var-lib-machines.mount - Virtual Machine and Container Storage (Compatibility) skipped, unmet condition check ConditionPathExists=/var/lib/machines.raw Oct 27 23:33:11.390511 systemd[1]: Reached target machines.target - Virtual Machines and Containers. Oct 27 23:33:11.395482 systemd[1]: Listening on systemd-importd.socket - Disk Image Download Service Socket. Oct 27 23:33:11.406144 systemd[1]: Mounted proc-sys-fs-binfmt_misc.mount - Arbitrary Executable File Formats File System. Oct 27 23:33:11.433657 kernel: EXT4-fs (dm-1): mounted filesystem 29aaab59-942c-481f-8d94-9ffe885e905c r/w with ordered data mode. Quota mode: none. Oct 27 23:33:11.435364 systemd[1]: Mounted var-lib-data.mount - /var/lib/data. Oct 27 23:33:11.439378 systemd[1]: Reached target local-fs.target - Local File Systems. Oct 27 23:33:11.444472 systemd[1]: Listening on systemd-sysext.socket - System Extension Image Management. Oct 27 23:33:11.449965 systemd[1]: systemd-binfmt.service - Set Up Additional Binary Formats skipped, no trigger condition checks were met. Oct 27 23:33:11.452862 systemd[1]: Starting systemd-confext.service - Merge System Configuration Images into /etc/... Oct 27 23:33:11.457876 systemd-nsresourced[1851]: Not setting up BPF subsystem, as functionality has been disabled at compile time. Oct 27 23:33:11.464853 systemd[1]: Starting systemd-machine-id-commit.service - Save Transient machine-id to Disk... Oct 27 23:33:11.471878 systemd[1]: Starting systemd-userdb-load-credentials.service - Load JSON user/group Records from Credentials... Oct 27 23:33:11.477393 systemd[1]: Started systemd-userdbd.service - User Database Manager. Oct 27 23:33:11.481000 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' Oct 27 23:33:11.485952 systemd[1]: Started systemd-nsresourced.service - Namespace Resource Manager. Oct 27 23:33:11.491000 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' Oct 27 23:33:11.507129 systemd[1]: Finished systemd-userdb-load-credentials.service - Load JSON user/group Records from Credentials. Oct 27 23:33:11.511000 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' Oct 27 23:33:11.531633 kernel: loop4: detected capacity change from 0 to 44465 Oct 27 23:33:11.537631 kernel: loop4: p1 p2 p3 Oct 27 23:33:11.551673 systemd[1]: Finished systemd-machine-id-commit.service - Save Transient machine-id to Disk. Oct 27 23:33:11.556000 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' Oct 27 23:33:11.566728 systemd-oomd[1842]: No swap; memory pressure usage will be degraded Oct 27 23:33:11.567359 systemd[1]: Started systemd-oomd.service - Userspace Out-Of-Memory (OOM) Killer. Oct 27 23:33:11.570000 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' Oct 27 23:33:11.586185 systemd-resolved[1843]: Positive Trust Anchors: Oct 27 23:33:11.586202 systemd-resolved[1843]: . IN DS 20326 8 2 e06d44b80b8f1d39a95c0b0d7c65d08458e880409bbc683457104237c7f8ec8d Oct 27 23:33:11.586206 systemd-resolved[1843]: . IN DS 38696 8 2 683d2d0acb8c9b712a1948b27f741219298d0a450d612c483af444a4c0fb2b16 Oct 27 23:33:11.586227 systemd-resolved[1843]: 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 Oct 27 23:33:11.597924 systemd[1]: Started systemd-udevd.service - Rule-based Manager for Device Events and Files. Oct 27 23:33:11.601000 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' Oct 27 23:33:11.602000 audit: BPF prog-id=34 op=LOAD Oct 27 23:33:11.604843 systemd[1]: Starting systemd-networkd.service - Network Management... Oct 27 23:33:11.624663 kernel: device-mapper: verity: sha256 using shash "sha256-ce" Oct 27 23:33:11.624741 kernel: device-mapper: verity: Unrecognized verity feature request: root_hash_sig_key_desc Oct 27 23:33:11.633556 kernel: device-mapper: table: 254:6: verity: Unrecognized verity feature request (-EINVAL) Oct 27 23:33:11.637127 kernel: device-mapper: ioctl: error adding target to table Oct 27 23:33:11.638267 systemd-confext[1881]: device-mapper: reload ioctl on loop4p1-54-verity (254:6) failed: Invalid argument Oct 27 23:33:11.641898 systemd-resolved[1843]: Using system hostname 'ci-4820.0.1-n-221886e4d9'. Oct 27 23:33:11.643111 systemd[1]: Started systemd-resolved.service - Network Name Resolution. Oct 27 23:33:11.647622 kernel: device-mapper: verity: sha256 using shash "sha256-ce" Oct 27 23:33:11.651000 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' Oct 27 23:33:11.653289 systemd[1]: Reached target nss-lookup.target - Host and Network Name Lookups. Oct 27 23:33:11.759218 systemd[1]: Condition check resulted in dev-ttyAMA0.device - /dev/ttyAMA0 being skipped. Oct 27 23:33:11.799373 systemd-networkd[1886]: lo: Link UP Oct 27 23:33:11.799379 systemd-networkd[1886]: lo: Gained carrier Oct 27 23:33:11.801743 systemd[1]: Started systemd-networkd.service - Network Management. Oct 27 23:33:11.807157 systemd-networkd[1886]: eth0: Configuring with /usr/lib/systemd/network/zz-default.network. Oct 27 23:33:11.806000 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' Oct 27 23:33:11.808279 systemd[1]: Reached target network.target - Network. Oct 27 23:33:11.815566 systemd[1]: Starting systemd-networkd-persistent-storage.service - Enable Persistent Storage in systemd-networkd... Oct 27 23:33:11.829621 kernel: hv_storvsc f8b3781a-1e82-4818-a1c3-63d806ec15bb: tag#281 cmd 0x85 status: scsi 0x2 srb 0x6 hv 0xc0000001 Oct 27 23:33:11.834213 systemd[1]: Starting systemd-networkd-wait-online.service - Wait for Network to be Online... Oct 27 23:33:11.846633 kernel: mousedev: PS/2 mouse device common for all mice Oct 27 23:33:11.869193 kernel: hv_vmbus: registering driver hv_balloon Oct 27 23:33:11.869277 kernel: hv_balloon: Using Dynamic Memory protocol version 2.0 Oct 27 23:33:11.873427 kernel: hv_balloon: Memory hot add disabled on ARM64 Oct 27 23:33:11.884651 kernel: hv_vmbus: registering driver hyperv_fb Oct 27 23:33:11.884696 kernel: mlx5_core 5ec5:00:02.0 enP24261s1: Link up Oct 27 23:33:11.892911 kernel: hyperv_fb: Synthvid Version major 3, minor 5 Oct 27 23:33:11.900011 kernel: hyperv_fb: Screen resolution: 1024x768, Color depth: 32, Frame buffer size: 8388608 Oct 27 23:33:11.908893 kernel: hv_netvsc 000d3ac5-22bd-000d-3ac5-22bd000d3ac5 eth0: Data path switched to VF: enP24261s1 Oct 27 23:33:11.912149 kernel: Console: switching to colour dummy device 80x25 Oct 27 23:33:11.920006 kernel: Console: switching to colour frame buffer device 128x48 Oct 27 23:33:11.923089 systemd-networkd[1886]: enP24261s1: Link UP Oct 27 23:33:11.923358 systemd-networkd[1886]: eth0: Link UP Oct 27 23:33:11.923366 systemd-networkd[1886]: eth0: Gained carrier Oct 27 23:33:11.931133 systemd[1]: Finished systemd-networkd-persistent-storage.service - Enable Persistent Storage in systemd-networkd. Oct 27 23:33:11.936573 systemd-networkd[1886]: enP24261s1: Gained carrier Oct 27 23:33:11.940000 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' Oct 27 23:33:11.957767 kernel: kauditd_printk_skb: 71 callbacks suppressed Oct 27 23:33:11.943646 systemd[1]: Condition check resulted in dev-ptp_hyperv.device - /dev/ptp_hyperv being skipped. Oct 27 23:33:11.957874 kernel: audit: type=1130 audit(1793143991.940:164): 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' Oct 27 23:33:11.957983 systemd-networkd[1886]: eth0: DHCPv4 address 10.0.0.29/24, gateway 10.0.0.1 acquired from 168.63.129.16 Oct 27 23:33:11.981220 systemd[1]: Starting systemd-vconsole-setup.service - Virtual Console Setup... Oct 27 23:33:11.994739 systemd[1]: systemd-vconsole-setup.service: Deactivated successfully. Oct 27 23:33:11.996916 systemd[1]: Stopped systemd-vconsole-setup.service - Virtual Console Setup. Oct 27 23:33:12.006000 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' Oct 27 23:33:12.009617 kernel: MACsec IEEE 802.1AE Oct 27 23:33:12.009671 kernel: audit: type=1130 audit(1793143992.006:165): 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' Oct 27 23:33:12.006000 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' Oct 27 23:33:12.030779 systemd[1]: Starting systemd-vconsole-setup.service - Virtual Console Setup... Oct 27 23:33:12.035302 kernel: audit: type=1131 audit(1793143992.006:166): 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' Oct 27 23:33:12.094631 kernel: erofs: (device dm-6): mounted with root inode @ nid 40. Oct 27 23:33:12.119936 systemd[1]: Condition check resulted in dev-disk-by\x2duuid-40e3b59b\x2df68b\x2d451b\x2d9977\x2dfd516c6a1ccc.device - Virtual_Disk USR-B being skipped. Oct 27 23:33:12.121798 systemd[1]: Starting systemd-cryptsetup@data.service - Cryptography Setup for data... Oct 27 23:33:12.155184 systemd[1]: Found device dev-disk-by\x2dlabel-OEM.device - Virtual_Disk OEM. Oct 27 23:33:12.163832 systemd[1]: Starting systemd-fsck@dev-disk-by\x2dlabel-OEM.service - File System Check on /dev/disk/by-label/OEM... Oct 27 23:33:12.182864 systemd[1]: systemd-vconsole-setup.service: Deactivated successfully. Oct 27 23:33:12.183704 systemd[1]: Stopped systemd-vconsole-setup.service - Virtual Console Setup. Oct 27 23:33:12.190000 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' Oct 27 23:33:12.190931 systemd-cryptsetup[2008]: Volume data already active. Oct 27 23:33:12.205624 kernel: loop4: detected capacity change from 0 to 44465 Oct 27 23:33:12.205701 kernel: audit: type=1130 audit(1793143992.190:167): 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' Oct 27 23:33:12.190000 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' Oct 27 23:33:12.206857 systemd[1]: Finished systemd-cryptsetup@data.service - Cryptography Setup for data. Oct 27 23:33:12.222618 kernel: audit: type=1131 audit(1793143992.190:168): 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' Oct 27 23:33:12.223000 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' Oct 27 23:33:12.226222 systemd[1]: Reached target blockdev@dev-mapper-data.target - Block Device Preparation for /dev/mapper/data. Oct 27 23:33:12.244575 kernel: audit: type=1130 audit(1793143992.223:169): 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' Oct 27 23:33:12.244667 kernel: loop4: p1 p2 p3 Oct 27 23:33:12.245442 systemd[1]: Reached target cryptsetup.target - Local Encrypted Volumes. Oct 27 23:33:12.259756 kernel: device-mapper: verity: sha256 using shash "sha256-ce" Oct 27 23:33:12.259839 kernel: device-mapper: verity: Unrecognized verity feature request: root_hash_sig_key_desc Oct 27 23:33:12.261783 systemd[1]: Starting systemd-vconsole-setup.service - Virtual Console Setup... Oct 27 23:33:12.266137 kernel: device-mapper: table: 254:6: verity: Unrecognized verity feature request (-EINVAL) Oct 27 23:33:12.269535 kernel: device-mapper: ioctl: error adding target to table Oct 27 23:33:12.269798 (sd-merge)[2022]: device-mapper: reload ioctl on loop4p1-59-verity (254:6) failed: Invalid argument Oct 27 23:33:12.278644 kernel: device-mapper: verity: sha256 using shash "sha256-ce" Oct 27 23:33:12.283122 systemd[1]: Finished systemd-fsck@dev-disk-by\x2dlabel-OEM.service - File System Check on /dev/disk/by-label/OEM. Oct 27 23:33:12.288000 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' Oct 27 23:33:12.312547 (sd-merge)[2022]: Skipping extension refresh because no change was found, use --always-refresh=yes to always do a refresh. Oct 27 23:33:12.312831 kernel: audit: type=1130 audit(1793143992.288:170): 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' Oct 27 23:33:12.312858 kernel: erofs: (device dm-6): mounted with root inode @ nid 40. Oct 27 23:33:12.315585 systemd[1]: Finished systemd-confext.service - Merge System Configuration Images into /etc/. Oct 27 23:33:12.319000 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' Oct 27 23:33:12.333952 systemd[1]: Starting systemd-sysext.service - Merge System Extension Images into /usr/ and /opt/... Oct 27 23:33:12.338618 kernel: audit: type=1130 audit(1793143992.319:171): 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' Oct 27 23:33:12.353635 kernel: loop4: detected capacity change from 0 to 404480 Oct 27 23:33:12.361946 kernel: loop4: p1 p2 p3 Oct 27 23:33:12.369590 systemd[1]: etc-machine\x2did.mount: Deactivated successfully. Oct 27 23:33:12.377484 kernel: device-mapper: verity: sha256 using shash "sha256-ce" Oct 27 23:33:12.377575 kernel: device-mapper: verity: Unrecognized verity feature request: root_hash_sig_key_desc Oct 27 23:33:12.383190 kernel: device-mapper: table: 254:6: verity: Unrecognized verity feature request (-EINVAL) Oct 27 23:33:12.387928 kernel: device-mapper: ioctl: error adding target to table Oct 27 23:33:12.388548 systemd-sysext[2037]: device-mapper: reload ioctl on loop4p1-63-verity (254:6) failed: Invalid argument Oct 27 23:33:12.399638 kernel: device-mapper: verity: sha256 using shash "sha256-ce" Oct 27 23:33:12.418705 kernel: erofs: (device dm-6): mounted with root inode @ nid 39. Oct 27 23:33:12.441640 kernel: loop4: detected capacity change from 0 to 158624 Oct 27 23:33:12.450641 kernel: loop4: p1 p2 p3 Oct 27 23:33:12.463231 kernel: device-mapper: verity: sha256 using shash "sha256-ce" Oct 27 23:33:12.463328 kernel: device-mapper: verity: Unrecognized verity feature request: root_hash_sig_key_desc Oct 27 23:33:12.468484 kernel: device-mapper: table: 254:6: verity: Unrecognized verity feature request (-EINVAL) Oct 27 23:33:12.472009 kernel: device-mapper: ioctl: error adding target to table Oct 27 23:33:12.472361 systemd-sysext[2037]: device-mapper: reload ioctl on loop4p1-68-verity (254:6) failed: Invalid argument Oct 27 23:33:12.482623 kernel: device-mapper: verity: sha256 using shash "sha256-ce" Oct 27 23:33:12.504619 kernel: erofs: (device dm-6): mounted with root inode @ nid 39. Oct 27 23:33:12.531626 kernel: loop4: detected capacity change from 0 to 141248 Oct 27 23:33:12.539627 kernel: loop4: p1 p2 p3 Oct 27 23:33:12.550413 kernel: device-mapper: verity: sha256 using shash "sha256-ce" Oct 27 23:33:12.550461 kernel: device-mapper: verity: Unrecognized verity feature request: root_hash_sig_key_desc Oct 27 23:33:12.556549 kernel: device-mapper: table: 254:6: verity: Unrecognized verity feature request (-EINVAL) Oct 27 23:33:12.560942 kernel: device-mapper: ioctl: error adding target to table Oct 27 23:33:12.565254 systemd-sysext[2037]: device-mapper: reload ioctl on loop4p1-73-verity (254:6) failed: Invalid argument Oct 27 23:33:12.573636 kernel: device-mapper: verity: sha256 using shash "sha256-ce" Oct 27 23:33:12.589691 kernel: erofs: (device dm-6): mounted with root inode @ nid 39. Oct 27 23:33:12.615630 kernel: loop4: detected capacity change from 0 to 404480 Oct 27 23:33:12.622030 kernel: loop4: p1 p2 p3 Oct 27 23:33:12.636629 kernel: device-mapper: verity: sha256 using shash "sha256-ce" Oct 27 23:33:12.637023 kernel: device-mapper: verity: Unrecognized verity feature request: root_hash_sig_key_desc Oct 27 23:33:12.641856 kernel: device-mapper: table: 254:6: verity: Unrecognized verity feature request (-EINVAL) Oct 27 23:33:12.645831 kernel: device-mapper: ioctl: error adding target to table Oct 27 23:33:12.646268 (sd-merge)[2061]: device-mapper: reload ioctl on loop4p1-78-verity (254:6) failed: Invalid argument Oct 27 23:33:12.657658 kernel: device-mapper: verity: sha256 using shash "sha256-ce" Oct 27 23:33:12.669850 systemd-vconsole-setup[2028]: Configuration of first virtual console was skipped, ignoring remaining ones. Oct 27 23:33:12.671740 systemd[1]: Finished systemd-vconsole-setup.service - Virtual Console Setup. Oct 27 23:33:12.679000 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' Oct 27 23:33:12.694645 kernel: erofs: (device dm-6): mounted with root inode @ nid 39. Oct 27 23:33:12.694726 kernel: audit: type=1130 audit(1793143992.679:172): 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' Oct 27 23:33:12.699646 kernel: loop5: detected capacity change from 0 to 158624 Oct 27 23:33:12.705618 kernel: loop5: p1 p2 p3 Oct 27 23:33:12.716842 kernel: device-mapper: verity: sha256 using shash "sha256-ce" Oct 27 23:33:12.716926 kernel: device-mapper: verity: Unrecognized verity feature request: root_hash_sig_key_desc Oct 27 23:33:12.721809 kernel: device-mapper: table: 254:7: verity: Unrecognized verity feature request (-EINVAL) Oct 27 23:33:12.725274 kernel: device-mapper: ioctl: error adding target to table Oct 27 23:33:12.725432 (sd-merge)[2061]: device-mapper: reload ioctl on loop5p1-82-verity (254:7) failed: Invalid argument Oct 27 23:33:12.736632 kernel: device-mapper: verity: sha256 using shash "sha256-ce" Oct 27 23:33:12.762632 kernel: erofs: (device dm-7): mounted with root inode @ nid 39. Oct 27 23:33:12.767636 kernel: loop6: detected capacity change from 0 to 141248 Oct 27 23:33:12.773620 kernel: loop6: p1 p2 p3 Oct 27 23:33:12.784390 kernel: device-mapper: verity: sha256 using shash "sha256-ce" Oct 27 23:33:12.784499 kernel: device-mapper: verity: Unrecognized verity feature request: root_hash_sig_key_desc Oct 27 23:33:12.792657 kernel: device-mapper: table: 254:8: verity: Unrecognized verity feature request (-EINVAL) Oct 27 23:33:12.792723 kernel: device-mapper: ioctl: error adding target to table Oct 27 23:33:12.792861 (sd-merge)[2061]: device-mapper: reload ioctl on loop6p1-86-verity (254:8) failed: Invalid argument Oct 27 23:33:12.804642 kernel: device-mapper: verity: sha256 using shash "sha256-ce" Oct 27 23:33:12.824309 (sd-merge)[2061]: Skipping extension refresh because no change was found, use --always-refresh=yes to always do a refresh. Oct 27 23:33:12.824652 kernel: erofs: (device dm-8): mounted with root inode @ nid 39. Oct 27 23:33:12.826754 systemd[1]: Finished systemd-sysext.service - Merge System Extension Images into /usr/ and /opt/. Oct 27 23:33:12.831000 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' Oct 27 23:33:12.839801 systemd[1]: Starting systemd-tmpfiles-setup.service - Create System Files and Directories... Oct 27 23:33:12.850545 kernel: audit: type=1130 audit(1793143992.831:173): 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' Oct 27 23:33:12.882951 systemd-tmpfiles[2085]: /usr/lib/tmpfiles.d/nfs-utils.conf:6: Duplicate line for path "/var/lib/nfs/sm", ignoring. Oct 27 23:33:12.883345 systemd-tmpfiles[2085]: /usr/lib/tmpfiles.d/nfs-utils.conf:7: Duplicate line for path "/var/lib/nfs/sm.bak", ignoring. Oct 27 23:33:12.883624 systemd-tmpfiles[2085]: /usr/lib/tmpfiles.d/provision.conf:20: Duplicate line for path "/root", ignoring. Oct 27 23:33:12.884385 systemd-tmpfiles[2085]: ACLs are not supported, ignoring. Oct 27 23:33:12.884517 systemd-tmpfiles[2085]: ACLs are not supported, ignoring. Oct 27 23:33:12.907546 systemd-tmpfiles[2085]: Detected autofs mount point '/boot' during canonicalization of 'boot'. Oct 27 23:33:12.907741 systemd-tmpfiles[2085]: Skipping /boot Oct 27 23:33:12.912180 systemd-tmpfiles[2085]: Detected autofs mount point '/boot' during canonicalization of 'boot'. Oct 27 23:33:12.912317 systemd-tmpfiles[2085]: Skipping /boot Oct 27 23:33:12.921803 systemd[1]: Finished systemd-tmpfiles-setup.service - Create System Files and Directories. Oct 27 23:33:12.926000 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' Oct 27 23:33:12.930319 systemd[1]: Starting audit-rules.service - Load Audit Rules... Oct 27 23:33:12.939728 systemd[1]: Starting clean-ca-certificates.service - Clean up broken links in /etc/ssl/certs... Oct 27 23:33:12.947800 systemd[1]: Starting ldconfig.service - Rebuild Dynamic Linker Cache... Oct 27 23:33:12.954376 systemd[1]: Starting systemd-journal-catalog-update.service - Rebuild Journal Catalog... Oct 27 23:33:12.961767 systemd[1]: Starting systemd-update-utmp.service - Record System Boot/Shutdown in UTMP... Oct 27 23:33:12.966000 audit[2091]: AUDIT1127 pid=2091 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' Oct 27 23:33:12.970871 systemd[1]: Finished systemd-update-utmp.service - Record System Boot/Shutdown in UTMP. Oct 27 23:33:12.975000 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' Oct 27 23:33:13.050036 systemd[1]: Finished systemd-journal-catalog-update.service - Rebuild Journal Catalog. Oct 27 23:33:13.056000 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' Oct 27 23:33:13.192038 augenrules[2115]: No rules Oct 27 23:33:13.190000 audit: CONFIG_CHANGE auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 op=add_rule key=(null) list=5 res=1 Oct 27 23:33:13.190000 audit[2115]: SYSCALL arch=c00000b7 syscall=206 success=yes exit=1056 a0=3 a1=fffffb5b6150 a2=420 a3=0 items=0 ppid=2087 pid=2115 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) Oct 27 23:33:13.190000 audit: PROCTITLE proctitle=2F7362696E2F617564697463746C002D52002F6574632F61756469742F61756469742E72756C6573 Oct 27 23:33:13.193511 systemd[1]: audit-rules.service: Deactivated successfully. Oct 27 23:33:13.193877 systemd[1]: Finished audit-rules.service - Load Audit Rules. Oct 27 23:33:13.241384 systemd[1]: Finished clean-ca-certificates.service - Clean up broken links in /etc/ssl/certs. Oct 27 23:33:13.247872 systemd[1]: update-ca-certificates.service - Update CA bundle at /etc/ssl/certs/ca-certificates.crt skipped, unmet condition check ConditionPathIsSymbolicLink=!/etc/ssl/certs/ca-certificates.crt Oct 27 23:33:13.335809 systemd-networkd[1886]: eth0: Gained IPv6LL Oct 27 23:33:13.337972 systemd[1]: Finished systemd-networkd-wait-online.service - Wait for Network to be Online. Oct 27 23:33:13.344259 systemd[1]: Reached target network-online.target - Network is Online. Oct 27 23:33:18.480120 ldconfig[2089]: ldconfig: /usr/lib/ld.so.conf is not an ELF file - it has the wrong magic bytes at the start. Oct 27 23:33:18.489267 systemd[1]: Finished ldconfig.service - Rebuild Dynamic Linker Cache. Oct 27 23:33:18.497993 systemd[1]: Starting systemd-update-done.service - Update is Completed... Oct 27 23:33:18.525072 systemd[1]: Finished systemd-update-done.service - Update is Completed. Oct 27 23:33:18.529971 systemd[1]: Reached target sysinit.target - System Initialization. Oct 27 23:33:18.534369 systemd[1]: Started motdgen.path - Watch for update engine configuration changes. Oct 27 23:33:18.540198 systemd[1]: Started user-cloudinit@var-lib-flatcar\x2dinstall-user_data.path - Watch for a cloud-config at /var/lib/flatcar-install/user_data. Oct 27 23:33:18.545878 systemd[1]: Started logrotate.timer - Daily rotation of log files. Oct 27 23:33:18.550378 systemd[1]: Started mdadm.timer - Weekly check for MD array's redundancy information.. Oct 27 23:33:18.556038 systemd[1]: Started systemd-sysupdate-reboot.timer - Reboot Automatically After System Update. Oct 27 23:33:18.561452 systemd[1]: Started systemd-sysupdate.timer - Automatic System Update. Oct 27 23:33:18.566476 systemd[1]: Started systemd-tmpfiles-clean.timer - Daily Cleanup of Temporary Directories. Oct 27 23:33:18.572757 systemd[1]: update-engine-stub.timer - Update Engine Stub Timer skipped, unmet condition check ConditionPathExists=/usr/.noupdate Oct 27 23:33:18.572791 systemd[1]: Reached target paths.target - Path Units. Oct 27 23:33:18.576758 systemd[1]: Reached target timers.target - Timer Units. Oct 27 23:33:18.581310 systemd[1]: Listening on dbus.socket - D-Bus System Message Bus Socket. Oct 27 23:33:18.587421 systemd[1]: Starting docker.socket - Docker Socket for the API... Oct 27 23:33:18.592908 systemd[1]: Listening on sshd-unix-local.socket - OpenSSH Server Socket (systemd-ssh-generator, AF_UNIX Local). Oct 27 23:33:18.601090 systemd[1]: Listening on sshd.socket - OpenSSH Server Socket. Oct 27 23:33:18.605849 systemd[1]: Listening on systemd-logind-varlink.socket - User Login Management Varlink Socket. Oct 27 23:33:18.611976 systemd[1]: Listening on systemd-machined.socket - Virtual Machine and Container Registration Service Socket. Oct 27 23:33:18.618887 systemd[1]: Listening on docker.socket - Docker Socket for the API. Oct 27 23:33:18.623920 systemd[1]: Reached target sockets.target - Socket Units. Oct 27 23:33:18.627955 systemd[1]: Reached target basic.target - Basic System. Oct 27 23:33:18.632808 systemd[1]: addon-config@oem.service - Configure Addon /oem skipped, no trigger condition checks were met. Oct 27 23:33:18.632829 systemd[1]: addon-run@oem.service - Run Addon /oem skipped, no trigger condition checks were met. Oct 27 23:33:18.634772 systemd[1]: Starting chronyd.service - NTP client/server... Oct 27 23:33:18.644715 systemd[1]: Starting containerd.service - containerd container runtime... Oct 27 23:33:18.653334 systemd[1]: Starting dbus.service - D-Bus System Message Bus... Oct 27 23:33:18.661858 systemd[1]: Starting dracut-shutdown.service - Restore /run/initramfs on shutdown... Oct 27 23:33:18.670807 systemd[1]: Starting enable-oem-cloudinit.service - Enable cloudinit... Oct 27 23:33:18.671091 chronyd[2129]: chronyd version 4.8 starting (+CMDMON +REFCLOCK +RTC +PRIVDROP +SCFILTER -SIGND +NTS +SECHASH +IPV6 -DEBUG) Oct 27 23:33:18.678196 systemd[1]: Starting extend-filesystems.service - Extend Filesystems... Oct 27 23:33:18.683319 systemd[1]: flatcar-setup-environment.service - Modifies /etc/environment for CoreOS skipped, unmet condition check ConditionPathExists=/oem/bin/flatcar-setup-environment Oct 27 23:33:18.684190 systemd[1]: Started hv_kvp_daemon.service - Hyper-V KVP daemon. Oct 27 23:33:18.689023 systemd[1]: hv_vss_daemon.service - Hyper-V VSS daemon skipped, unmet condition check ConditionPathExists=/dev/vmbus/hv_vss Oct 27 23:33:18.691741 systemd[1]: Starting motdgen.service - Generate /run/flatcar/motd... Oct 27 23:33:18.693945 KVP[2135]: KVP starting; pid is:2135 Oct 27 23:33:18.698739 systemd[1]: Starting nvidia.service - NVIDIA Configure Service... Oct 27 23:33:18.704663 KVP[2135]: KVP LIC Version: 3.1 Oct 27 23:33:18.705617 kernel: hv_utils: KVP IC version 4.0 Oct 27 23:33:18.706669 systemd[1]: Starting ssh-key-proc-cmdline.service - Install an ssh key from /proc/cmdline... Oct 27 23:33:18.708543 jq[2133]: false Oct 27 23:33:18.715563 systemd[1]: Starting sshd-keygen.service - Generate sshd host keys... Oct 27 23:33:18.715971 chronyd[2129]: Timezone right/UTC failed leap second check, ignoring Oct 27 23:33:18.723155 systemd[1]: Starting systemd-logind.service - User Login Management... Oct 27 23:33:18.729693 systemd[1]: tcsd.service - TCG Core Services Daemon skipped, unmet condition check ConditionPathExists=/dev/tpm0 Oct 27 23:33:18.731974 chronyd[2129]: Loaded seccomp filter (level 2) Oct 27 23:33:18.732883 systemd[1]: Starting update-engine.service - Update Engine... Oct 27 23:33:18.738230 motdgen[2149]: /oem/oem-release: line 2: Azure: command not found Oct 27 23:33:18.741935 systemd[1]: Starting update-ssh-keys-after-ignition.service - Run update-ssh-keys once after Ignition... Oct 27 23:33:18.750893 systemd[1]: Started chronyd.service - NTP client/server. Oct 27 23:33:18.755919 systemd[1]: Finished dracut-shutdown.service - Restore /run/initramfs on shutdown. Oct 27 23:33:18.758104 jq[2150]: true Oct 27 23:33:18.763184 extend-filesystems[2134]: Found /dev/mapper/data Oct 27 23:33:18.763667 systemd[1]: enable-oem-cloudinit.service: Skipped due to 'exec-condition'. Oct 27 23:33:18.765598 systemd[1]: Condition check resulted in enable-oem-cloudinit.service - Enable cloudinit being skipped. Oct 27 23:33:18.765834 systemd[1]: ssh-key-proc-cmdline.service: Deactivated successfully. Oct 27 23:33:18.765999 systemd[1]: Finished ssh-key-proc-cmdline.service - Install an ssh key from /proc/cmdline. Oct 27 23:33:18.777967 extend-filesystems[2158]: ERROR: cgpt show: GptSanityCheck() returned 4: GPT_ERROR_INVALID_SECTOR_SIZE Oct 27 23:33:18.791686 extend-filesystems[2134]: Found /dev/sda6 Oct 27 23:33:18.791686 extend-filesystems[2134]: Found /dev/sda9 Oct 27 23:33:18.791686 extend-filesystems[2134]: Checking size of /dev/sda9 Oct 27 23:33:18.779576 systemd[1]: motdgen.service: Deactivated successfully. Oct 27 23:33:18.779777 systemd[1]: Finished motdgen.service - Generate /run/flatcar/motd. Oct 27 23:33:18.833125 jq[2172]: true Oct 27 23:33:18.801132 systemd[1]: Finished nvidia.service - NVIDIA Configure Service. Oct 27 23:33:18.841058 extend-filesystems[2134]: Resized partition /dev/sda9 Oct 27 23:33:18.850361 update_engine[2146]: I20261027 23:33:18.840706 2146 main.cc:92] Flatcar Update Engine starting Oct 27 23:33:18.856378 extend-filesystems[2190]: resize2fs 1.47.4 (6-Mar-2025) Oct 27 23:33:18.879621 kernel: EXT4-fs (sda9): resizing filesystem from 6359552 to 6376955 blocks Oct 27 23:33:18.879694 kernel: EXT4-fs (sda9): resized filesystem to 6376955 Oct 27 23:33:18.883334 systemd-logind[2145]: New seat seat0. Oct 27 23:33:18.895342 systemd-logind[2145]: Watching system buttons on /dev/input/event1 (AT Translated Set 2 keyboard) Oct 27 23:33:18.895699 systemd[1]: Started systemd-logind.service - User Login Management. Oct 27 23:33:18.907286 extend-filesystems[2190]: Filesystem at /dev/sda9 is mounted on /; on-line resizing required Oct 27 23:33:18.907286 extend-filesystems[2190]: old_desc_blocks = 4, new_desc_blocks = 4 Oct 27 23:33:18.907286 extend-filesystems[2190]: The filesystem on /dev/sda9 is now 6376955 (4k) blocks long. Oct 27 23:33:18.950945 extend-filesystems[2134]: Resized filesystem in /dev/sda9 Oct 27 23:33:18.960040 bash[2218]: Updated "/home/core/.ssh/authorized_keys" Oct 27 23:33:18.918875 systemd[1]: extend-filesystems.service: Deactivated successfully. Oct 27 23:33:18.919198 systemd[1]: Finished extend-filesystems.service - Extend Filesystems. Oct 27 23:33:18.950982 systemd[1]: Finished update-ssh-keys-after-ignition.service - Run update-ssh-keys once after Ignition. Oct 27 23:33:18.969060 systemd[1]: sshkeys.service skipped, no trigger condition checks were met. Oct 27 23:33:19.037024 sshd_keygen[2159]: ssh-keygen: generating new host keys: RSA ECDSA ED25519 MLDSA44-ED25519 Oct 27 23:33:19.070743 dbus-daemon[2131]: [system] SELinux support is enabled Oct 27 23:33:19.071168 systemd[1]: Started dbus.service - D-Bus System Message Bus. Oct 27 23:33:19.078311 update_engine[2146]: I20261027 23:33:19.078188 2146 update_check_scheduler.cc:74] Next update check in 8m40s Oct 27 23:33:19.086134 dbus-daemon[2131]: [system] Successfully activated service 'org.freedesktop.systemd1' Oct 27 23:33:19.086533 systemd[1]: Finished sshd-keygen.service - Generate sshd host keys. Oct 27 23:33:19.092334 systemd[1]: Started update-engine.service - Update Engine. Oct 27 23:33:19.098489 systemd[1]: Starting issuegen.service - Generate /run/issue... Oct 27 23:33:19.102360 systemd[1]: system-cloudinit@usr-share-coreos-cloud\x2dconfig.yml.service - Load cloud-config from /usr/share/coreos/cloud-config.yml skipped, unmet condition check ConditionFileNotEmpty=/usr/share/coreos/cloud-config.yml Oct 27 23:33:19.102876 systemd[1]: Reached target system-config.target - Load system-provided cloud configs. Oct 27 23:33:19.108659 systemd[1]: user-cloudinit-proc-cmdline.service - Load cloud-config from url defined in /proc/cmdline skipped, unmet condition check ConditionKernelCommandLine=cloud-config-url Oct 27 23:33:19.108961 systemd[1]: Reached target user-config.target - Load user-provided cloud configs. Oct 27 23:33:19.117756 systemd[1]: Starting waagent.service - Microsoft Azure Linux Agent... Oct 27 23:33:19.124885 systemd[1]: Started locksmithd.service - Cluster reboot manager. Oct 27 23:33:19.132596 systemd[1]: issuegen.service: Deactivated successfully. Oct 27 23:33:19.132852 systemd[1]: Finished issuegen.service - Generate /run/issue. Oct 27 23:33:19.140357 systemd[1]: Starting systemd-user-sessions.service - Permit User Sessions... Oct 27 23:33:19.157851 systemd[1]: Started waagent.service - Microsoft Azure Linux Agent. Oct 27 23:33:19.165765 systemd[1]: Finished systemd-user-sessions.service - Permit User Sessions. Oct 27 23:33:19.173324 systemd[1]: Started getty@tty1.service - Getty on tty1. Oct 27 23:33:19.178657 systemd[1]: Started serial-getty@ttyAMA0.service - Serial Getty on ttyAMA0. Oct 27 23:33:19.183753 systemd[1]: Reached target getty.target - Login Prompts. Oct 27 23:33:19.263054 locksmithd[2299]: locksmithd starting currentOperation="UPDATE_STATUS_IDLE" strategy="reboot" Oct 27 23:33:21.190906 containerd[2173]: time="2026-10-27T23:33:21Z" 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 Oct 27 23:33:21.191261 containerd[2173]: time="2026-10-27T23:33:21Z" level=warning msg="Configuration migrated from version 2, use `containerd config migrate` to avoid migration" t="11.088µs" Oct 27 23:33:21.193268 containerd[2173]: time="2026-10-27T23:33:21.192521892Z" level=info msg="starting containerd" revision=db8809540e1a7a9da5d518876894933ff55692ab version=v2.3.4 Oct 27 23:33:21.193268 containerd[2173]: time="2026-10-27T23:33:21.192857940Z" level=info msg="loading plugin" id=io.containerd.content.v1.content type=io.containerd.content.v1 Oct 27 23:33:21.193268 containerd[2173]: time="2026-10-27T23:33:21.193023428Z" level=warning msg="failed check for fsverity support" error="enable fsverity failed: operation not supported" path=/var/lib/containerd/io.containerd.content.v1.content Oct 27 23:33:21.193268 containerd[2173]: time="2026-10-27T23:33:21.193036628Z" level=info msg="loading plugin" id=io.containerd.image-verifier.v1.bindir type=io.containerd.image-verifier.v1 Oct 27 23:33:21.193268 containerd[2173]: time="2026-10-27T23:33:21.193045100Z" level=info msg="loading plugin" id=io.containerd.internal.v1.opt type=io.containerd.internal.v1 Oct 27 23:33:21.193268 containerd[2173]: time="2026-10-27T23:33:21.193130156Z" level=info msg="loading plugin" id=io.containerd.warning.v1.deprecations type=io.containerd.warning.v1 Oct 27 23:33:21.193268 containerd[2173]: time="2026-10-27T23:33:21.193138372Z" level=info msg="loading plugin" id=io.containerd.event.v1.exchange type=io.containerd.event.v1 Oct 27 23:33:21.194100 containerd[2173]: time="2026-10-27T23:33:21.193445484Z" level=info msg="loading plugin" id=io.containerd.mount-handler.v1.erofs type=io.containerd.mount-handler.v1 Oct 27 23:33:21.194100 containerd[2173]: time="2026-10-27T23:33:21.193467996Z" level=info msg="loading plugin" id=io.containerd.snapshotter.v1.blockfile type=io.containerd.snapshotter.v1 Oct 27 23:33:21.194100 containerd[2173]: time="2026-10-27T23:33:21.193565380Z" level=info msg="skip loading plugin" error="no scratch file generator: skip plugin" id=io.containerd.snapshotter.v1.blockfile type=io.containerd.snapshotter.v1 Oct 27 23:33:21.194100 containerd[2173]: time="2026-10-27T23:33:21.193573916Z" level=info msg="loading plugin" id=io.containerd.snapshotter.v1.btrfs type=io.containerd.snapshotter.v1 Oct 27 23:33:21.194100 containerd[2173]: time="2026-10-27T23:33:21.193733820Z" 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 Oct 27 23:33:21.194100 containerd[2173]: time="2026-10-27T23:33:21.193747828Z" level=info msg="loading plugin" id=io.containerd.snapshotter.v1.devmapper type=io.containerd.snapshotter.v1 Oct 27 23:33:21.194100 containerd[2173]: time="2026-10-27T23:33:21.193756380Z" level=info msg="skip loading plugin" error="devmapper not configured: skip plugin" id=io.containerd.snapshotter.v1.devmapper type=io.containerd.snapshotter.v1 Oct 27 23:33:21.194100 containerd[2173]: time="2026-10-27T23:33:21.193761220Z" level=info msg="loading plugin" id=io.containerd.snapshotter.v1.erofs type=io.containerd.snapshotter.v1 Oct 27 23:33:21.194100 containerd[2173]: time="2026-10-27T23:33:21.193878812Z" level=info msg="loading plugin" id=io.containerd.snapshotter.v1.native type=io.containerd.snapshotter.v1 Oct 27 23:33:21.194100 containerd[2173]: time="2026-10-27T23:33:21.193924244Z" level=info msg="loading plugin" id=io.containerd.snapshotter.v1.overlayfs type=io.containerd.snapshotter.v1 Oct 27 23:33:21.194100 containerd[2173]: time="2026-10-27T23:33:21.194036164Z" level=info msg="loading plugin" id=io.containerd.snapshotter.v1.zfs type=io.containerd.snapshotter.v1 Oct 27 23:33:21.194262 containerd[2173]: time="2026-10-27T23:33:21.194052788Z" 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 Oct 27 23:33:21.194262 containerd[2173]: time="2026-10-27T23:33:21.194067316Z" level=info msg="loading plugin" id=io.containerd.monitor.task.v1.cgroups type=io.containerd.monitor.task.v1 Oct 27 23:33:21.194687 containerd[2173]: time="2026-10-27T23:33:21.194662780Z" level=info msg="loading plugin" id=io.containerd.metadata.v1.bolt type=io.containerd.metadata.v1 Oct 27 23:33:21.194808 containerd[2173]: time="2026-10-27T23:33:21.194794276Z" level=info msg="metadata content store policy set" policy=shared Oct 27 23:33:21.206397 containerd[2173]: time="2026-10-27T23:33:21.206360372Z" level=info msg="loading plugin" id=io.containerd.gc.v1.scheduler type=io.containerd.gc.v1 Oct 27 23:33:21.206555 containerd[2173]: time="2026-10-27T23:33:21.206539388Z" level=info msg="loading plugin" id=io.containerd.server.v1.metrics type=io.containerd.server.v1 Oct 27 23:33:21.206639 containerd[2173]: time="2026-10-27T23:33:21.206627660Z" level=info msg="skip loading plugin" error="skip plugin" id=io.containerd.server.v1.metrics type=io.containerd.server.v1 Oct 27 23:33:21.206685 containerd[2173]: time="2026-10-27T23:33:21.206671772Z" level=info msg="loading plugin" id=io.containerd.tracing.processor.v1.otlp type=io.containerd.tracing.processor.v1 Oct 27 23:33:21.206726 containerd[2173]: time="2026-10-27T23:33:21.206712660Z" 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 Oct 27 23:33:21.206768 containerd[2173]: time="2026-10-27T23:33:21.206748820Z" level=info msg="loading plugin" id=io.containerd.internal.v1.tracing type=io.containerd.internal.v1 Oct 27 23:33:21.206824 containerd[2173]: time="2026-10-27T23:33:21.206811828Z" level=info msg="skip loading plugin" error="skip plugin: tracing endpoint not configured" id=io.containerd.internal.v1.tracing type=io.containerd.internal.v1 Oct 27 23:33:21.206860 containerd[2173]: time="2026-10-27T23:33:21.206848668Z" level=info msg="loading plugin" id=io.containerd.nri.v1.nri type=io.containerd.nri.v1 Oct 27 23:33:21.206971 containerd[2173]: time="2026-10-27T23:33:21.206958028Z" level=info msg="built-in NRI default validator is disabled" Oct 27 23:33:21.207011 containerd[2173]: time="2026-10-27T23:33:21.207000812Z" level=info msg="runtime interface created" Oct 27 23:33:21.207046 containerd[2173]: time="2026-10-27T23:33:21.207036396Z" level=info msg="created NRI interface" Oct 27 23:33:21.207079 containerd[2173]: time="2026-10-27T23:33:21.207069188Z" level=info msg="loading plugin" id=io.containerd.ttrpc.v1.otelttrpc type=io.containerd.ttrpc.v1 Oct 27 23:33:21.207115 containerd[2173]: time="2026-10-27T23:33:21.207104980Z" level=info msg="loading plugin" id=io.containerd.service.v1.containers-service type=io.containerd.service.v1 Oct 27 23:33:21.207158 containerd[2173]: time="2026-10-27T23:33:21.207148372Z" level=info msg="loading plugin" id=io.containerd.service.v1.content-service type=io.containerd.service.v1 Oct 27 23:33:21.207209 containerd[2173]: time="2026-10-27T23:33:21.207195580Z" level=info msg="loading plugin" id=io.containerd.differ.v1.erofs type=io.containerd.differ.v1 Oct 27 23:33:21.239623 containerd[2173]: time="2026-10-27T23:33:21.239547052Z" level=info msg="loading plugin" id=io.containerd.mount-manager.v1.bolt type=io.containerd.mount-manager.v1 Oct 27 23:33:21.239909 containerd[2173]: time="2026-10-27T23:33:21.239890300Z" level=info msg="loading plugin" id=io.containerd.differ.v1.walking type=io.containerd.differ.v1 Oct 27 23:33:21.239977 containerd[2173]: time="2026-10-27T23:33:21.239964540Z" level=info msg="loading plugin" id=io.containerd.service.v1.diff-service type=io.containerd.service.v1 Oct 27 23:33:21.240025 containerd[2173]: time="2026-10-27T23:33:21.240014516Z" level=info msg="loading plugin" id=io.containerd.service.v1.images-service type=io.containerd.service.v1 Oct 27 23:33:21.240063 containerd[2173]: time="2026-10-27T23:33:21.240053804Z" level=info msg="loading plugin" id=io.containerd.service.v1.introspection-service type=io.containerd.service.v1 Oct 27 23:33:21.240096 containerd[2173]: time="2026-10-27T23:33:21.240086396Z" level=info msg="loading plugin" id=io.containerd.service.v1.namespaces-service type=io.containerd.service.v1 Oct 27 23:33:21.240129 containerd[2173]: time="2026-10-27T23:33:21.240119356Z" level=info msg="loading plugin" id=io.containerd.service.v1.snapshots-service type=io.containerd.service.v1 Oct 27 23:33:21.240171 containerd[2173]: time="2026-10-27T23:33:21.240161356Z" level=info msg="loading plugin" id=io.containerd.shim.v1.manager type=io.containerd.shim.v1 Oct 27 23:33:21.240208 containerd[2173]: time="2026-10-27T23:33:21.240198372Z" level=info msg="loading plugin" id=io.containerd.runtime.v2.task type=io.containerd.runtime.v2 Oct 27 23:33:21.240387 containerd[2173]: time="2026-10-27T23:33:21.240369908Z" level=info msg="loading plugin" id=io.containerd.service.v1.tasks-service type=io.containerd.service.v1 Oct 27 23:33:21.240468 containerd[2173]: time="2026-10-27T23:33:21.240453492Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.containers type=io.containerd.grpc.v1 Oct 27 23:33:21.240515 containerd[2173]: time="2026-10-27T23:33:21.240503708Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.content type=io.containerd.grpc.v1 Oct 27 23:33:21.240559 containerd[2173]: time="2026-10-27T23:33:21.240546556Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.diff type=io.containerd.grpc.v1 Oct 27 23:33:21.240622 containerd[2173]: time="2026-10-27T23:33:21.240588764Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.events type=io.containerd.grpc.v1 Oct 27 23:33:21.240668 containerd[2173]: time="2026-10-27T23:33:21.240656092Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.images type=io.containerd.grpc.v1 Oct 27 23:33:21.240707 containerd[2173]: time="2026-10-27T23:33:21.240695940Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.introspection type=io.containerd.grpc.v1 Oct 27 23:33:21.240757 containerd[2173]: time="2026-10-27T23:33:21.240744140Z" level=info msg="loading plugin" id=io.containerd.lease.v1.manager type=io.containerd.lease.v1 Oct 27 23:33:21.240796 containerd[2173]: time="2026-10-27T23:33:21.240785020Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.leases type=io.containerd.grpc.v1 Oct 27 23:33:21.240837 containerd[2173]: time="2026-10-27T23:33:21.240826140Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.mounts type=io.containerd.grpc.v1 Oct 27 23:33:21.240872 containerd[2173]: time="2026-10-27T23:33:21.240860724Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.namespaces type=io.containerd.grpc.v1 Oct 27 23:33:21.240915 containerd[2173]: time="2026-10-27T23:33:21.240904708Z" level=info msg="loading plugin" id=io.containerd.sandbox.store.v1.local type=io.containerd.sandbox.store.v1 Oct 27 23:33:21.240955 containerd[2173]: time="2026-10-27T23:33:21.240945004Z" level=info msg="loading plugin" id=io.containerd.transfer.v1.local type=io.containerd.transfer.v1 Oct 27 23:33:21.241030 containerd[2173]: time="2026-10-27T23:33:21.241018572Z" level=info msg="loading plugin" id=io.containerd.cri.v1.images type=io.containerd.cri.v1 Oct 27 23:33:21.241421 containerd[2173]: time="2026-10-27T23:33:21.241205540Z" level=info msg="Get image filesystem path \"/var/lib/containerd/io.containerd.snapshotter.v1.overlayfs\" for snapshotter \"overlayfs\"" Oct 27 23:33:21.241499 containerd[2173]: time="2026-10-27T23:33:21.241487828Z" level=info msg="Start snapshots syncer" Oct 27 23:33:21.241551 containerd[2173]: time="2026-10-27T23:33:21.241538636Z" level=info msg="loading plugin" id=io.containerd.cri.v1.runtime type=io.containerd.cri.v1 Oct 27 23:33:21.242546 containerd[2173]: time="2026-10-27T23:33:21.241889164Z" level=info msg="starting cri plugin" config="{\"containerd\":{\"defaultRuntimeName\":\"runc\",\"runtimes\":{\"runc\":{\"runtimeType\":\"io.containerd.runc.v2\",\"runtimePath\":\"\",\"PodAnnotations\":null,\"ContainerAnnotations\":null,\"options\":{\"BinaryName\":\"\",\"CriuImagePath\":\"\",\"CriuWorkPath\":\"\",\"IoGid\":0,\"IoUid\":0,\"NoNewKeyring\":false,\"Root\":\"\",\"ShimCgroup\":\"\",\"SystemdCgroup\":true},\"privileged_without_host_devices\":false,\"privileged_without_host_devices_all_devices_allowed\":false,\"cgroupWritable\":false,\"baseRuntimeSpec\":\"\",\"cniConfDir\":\"\",\"cniMaxConfNum\":0,\"snapshotter\":\"\",\"sandboxer\":\"podsandbox\",\"io_type\":\"\"}},\"ignoreBlockIONotEnabledErrors\":false,\"ignoreRdtNotEnabledErrors\":false},\"cni\":{\"binDir\":\"\",\"binDirs\":[\"/opt/cni/bin\"],\"confDir\":\"/etc/cni/net.d\",\"maxConfNum\":1,\"setupSerially\":false,\"confTemplate\":\"\",\"ipPref\":\"\",\"useInternalLoopback\":false},\"enableSelinux\":true,\"selinuxCategoryRange\":1024,\"maxContainerLogLineSize\":16384,\"disableApparmor\":false,\"restrictOOMScoreAdj\":false,\"disableProcMount\":false,\"unsetSeccompProfile\":\"\",\"tolerateMissingHugetlbController\":true,\"disableHugetlbController\":true,\"device_ownership_from_security_context\":false,\"ignoreImageDefinedVolumes\":false,\"netnsMountsUnderStateDir\":false,\"enableUnprivilegedPorts\":true,\"enableUnprivilegedICMP\":true,\"enableCDI\":true,\"cdiSpecDirs\":[\"/etc/cdi\",\"/var/run/cdi\"],\"drainExecSyncIOTimeout\":\"0s\",\"ignoreDeprecationWarnings\":null,\"statsCollectPeriod\":\"\",\"statsRetentionPeriod\":\"\",\"enableCRIU\":true,\"enableExperimentalRestoreViaCreate\":false,\"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\"}" Oct 27 23:33:21.242680 containerd[2173]: time="2026-10-27T23:33:21.241937380Z" level=info msg="loading plugin" id=io.containerd.podsandbox.controller.v1.podsandbox type=io.containerd.podsandbox.controller.v1 Oct 27 23:33:21.242680 containerd[2173]: time="2026-10-27T23:33:21.241976764Z" level=info msg="loading plugin" id=io.containerd.sandbox.controller.v1.shim type=io.containerd.sandbox.controller.v1 Oct 27 23:33:21.242680 containerd[2173]: time="2026-10-27T23:33:21.242085732Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.sandbox-controllers type=io.containerd.grpc.v1 Oct 27 23:33:21.242680 containerd[2173]: time="2026-10-27T23:33:21.242102196Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.sandboxes type=io.containerd.grpc.v1 Oct 27 23:33:21.242680 containerd[2173]: time="2026-10-27T23:33:21.242107916Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.snapshots type=io.containerd.grpc.v1 Oct 27 23:33:21.242680 containerd[2173]: time="2026-10-27T23:33:21.242113956Z" level=info msg="loading plugin" id=io.containerd.streaming.v1.manager type=io.containerd.streaming.v1 Oct 27 23:33:21.242680 containerd[2173]: time="2026-10-27T23:33:21.242120340Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.streaming type=io.containerd.grpc.v1 Oct 27 23:33:21.242680 containerd[2173]: time="2026-10-27T23:33:21.242125972Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.tasks type=io.containerd.grpc.v1 Oct 27 23:33:21.242680 containerd[2173]: time="2026-10-27T23:33:21.242130828Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.transfer type=io.containerd.grpc.v1 Oct 27 23:33:21.242680 containerd[2173]: time="2026-10-27T23:33:21.242137836Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.version type=io.containerd.grpc.v1 Oct 27 23:33:21.242680 containerd[2173]: time="2026-10-27T23:33:21.242144220Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.healthcheck type=io.containerd.grpc.v1 Oct 27 23:33:21.242680 containerd[2173]: time="2026-10-27T23:33:21.242150404Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.cri type=io.containerd.grpc.v1 Oct 27 23:33:21.242680 containerd[2173]: time="2026-10-27T23:33:21.242160524Z" level=info msg="Connect containerd service" Oct 27 23:33:21.242680 containerd[2173]: time="2026-10-27T23:33:21.242178588Z" level=info msg="using experimental NRI integration - disable nri plugin to prevent this" Oct 27 23:33:21.243806 containerd[2173]: time="2026-10-27T23:33:21.243777684Z" level=warning msg="failed to load cni during init, please check CRI plugin status before setting up network for pods" error="cni config load failed: no network config found in /etc/cni/net.d: cni plugin not initialized: failed to load cni config" Oct 27 23:33:22.330414 waagent[2307]: 2026-10-27T23:33:22.330332Z INFO Daemon Daemon Azure Linux Agent Version: 2.12.0.4 Oct 27 23:33:22.335196 waagent[2307]: 2026-10-27T23:33:22.335144Z INFO Daemon Daemon OS: flatcar 4820.0.1 Oct 27 23:33:22.339989 waagent[2307]: 2026-10-27T23:33:22.339953Z INFO Daemon Daemon Python: 3.13.15 Oct 27 23:33:22.344431 waagent[2307]: 2026-10-27T23:33:22.344388Z INFO Daemon Daemon Run daemon Oct 27 23:33:22.348394 waagent[2307]: 2026-10-27T23:33:22.348345Z INFO Daemon Daemon No RDMA handler exists for distro='Flatcar Container Linux by Kinvolk' version='4820.0.1' Oct 27 23:33:22.355392 waagent[2307]: 2026-10-27T23:33:22.355343Z INFO Daemon Daemon Using waagent for provisioning Oct 27 23:33:22.359355 waagent[2307]: 2026-10-27T23:33:22.359320Z INFO Daemon Daemon Activate resource disk Oct 27 23:33:22.362856 waagent[2307]: 2026-10-27T23:33:22.362825Z INFO Daemon Daemon Searching gen1 prefix 00000000-0001 or gen2 f8b3781a-1e82-4818-a1c3-63d806ec15bb Oct 27 23:33:22.370950 waagent[2307]: 2026-10-27T23:33:22.370912Z INFO Daemon Daemon Found device: None Oct 27 23:33:22.374248 waagent[2307]: 2026-10-27T23:33:22.374213Z ERROR Daemon Daemon Failed to mount resource disk [ResourceDiskError] unable to detect disk topology Oct 27 23:33:22.380540 waagent[2307]: 2026-10-27T23:33:22.380509Z ERROR Daemon Daemon Event: name=WALinuxAgent, op=ActivateResourceDisk, message=[ResourceDiskError] unable to detect disk topology, duration=0 Oct 27 23:33:22.389171 waagent[2307]: 2026-10-27T23:33:22.389126Z INFO Daemon Daemon Clean protocol and wireserver endpoint Oct 27 23:33:22.393649 waagent[2307]: 2026-10-27T23:33:22.393618Z INFO Daemon Daemon Running default provisioning handler Oct 27 23:33:22.402625 waagent[2307]: 2026-10-27T23:33:22.401720Z 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. Oct 27 23:33:22.411892 waagent[2307]: 2026-10-27T23:33:22.411850Z INFO Daemon Daemon Unable to get cloud-init enabled status from service: [Errno 2] No such file or directory: 'service' Oct 27 23:33:22.418994 waagent[2307]: 2026-10-27T23:33:22.418954Z INFO Daemon Daemon cloud-init is enabled: False Oct 27 23:33:22.422635 waagent[2307]: 2026-10-27T23:33:22.422580Z INFO Daemon Daemon Copying ovf-env.xml Oct 27 23:33:22.528795 waagent[2307]: 2026-10-27T23:33:22.528716Z INFO Daemon Daemon Successfully mounted dvd Oct 27 23:33:22.573339 systemd[1]: mnt-cdrom-secure.mount: Deactivated successfully. Oct 27 23:33:22.575243 waagent[2307]: 2026-10-27T23:33:22.575173Z INFO Daemon Daemon Detect protocol endpoint Oct 27 23:33:22.580015 waagent[2307]: 2026-10-27T23:33:22.579962Z INFO Daemon Daemon Clean protocol and wireserver endpoint Oct 27 23:33:22.584425 waagent[2307]: 2026-10-27T23:33:22.584340Z INFO Daemon Daemon WireServer endpoint is not found. Rerun dhcp handler Oct 27 23:33:22.589206 waagent[2307]: 2026-10-27T23:33:22.589172Z INFO Daemon Daemon Test for route to 168.63.129.16 Oct 27 23:33:22.593726 waagent[2307]: 2026-10-27T23:33:22.593692Z INFO Daemon Daemon Route to 168.63.129.16 exists Oct 27 23:33:22.599018 waagent[2307]: 2026-10-27T23:33:22.598973Z INFO Daemon Daemon Wire server endpoint:168.63.129.16 Oct 27 23:33:22.617259 containerd[2173]: time="2026-10-27T23:33:22.617147580Z" level=info msg="loading plugin" id=io.containerd.server.v1.ttrpc type=io.containerd.server.v1 Oct 27 23:33:22.617259 containerd[2173]: time="2026-10-27T23:33:22.617228652Z" level=info msg="Start subscribing containerd event" Oct 27 23:33:22.617581 containerd[2173]: time="2026-10-27T23:33:22.617275380Z" level=info msg="Start stats collector" Oct 27 23:33:22.617581 containerd[2173]: time="2026-10-27T23:33:22.617281420Z" level=info msg="Start recovering state" Oct 27 23:33:22.617581 containerd[2173]: time="2026-10-27T23:33:22.617362532Z" level=info msg="Start event monitor" Oct 27 23:33:22.617581 containerd[2173]: time="2026-10-27T23:33:22.617372692Z" level=info msg="Start cni network conf syncer for default" Oct 27 23:33:22.617581 containerd[2173]: time="2026-10-27T23:33:22.617377364Z" level=info msg="Start streaming server" Oct 27 23:33:22.617581 containerd[2173]: time="2026-10-27T23:33:22.617386644Z" level=info msg="Registered namespace \"k8s.io\" with NRI" Oct 27 23:33:22.617581 containerd[2173]: time="2026-10-27T23:33:22.617391572Z" level=info msg="runtime interface starting up..." Oct 27 23:33:22.617581 containerd[2173]: time="2026-10-27T23:33:22.617398516Z" level=info msg="starting plugins..." Oct 27 23:33:22.617581 containerd[2173]: time="2026-10-27T23:33:22.617409500Z" level=info msg="Synchronizing NRI (plugin) with current runtime state" Oct 27 23:33:22.618681 containerd[2173]: time="2026-10-27T23:33:22.617239420Z" level=info msg="loading plugin" id=io.containerd.monitor.container.v1.restart type=io.containerd.monitor.container.v1 Oct 27 23:33:22.618681 containerd[2173]: time="2026-10-27T23:33:22.617801372Z" level=info msg="loading plugin" id=io.containerd.metrics.v1.grpc-prometheus type=io.containerd.metrics.v1 Oct 27 23:33:22.618681 containerd[2173]: time="2026-10-27T23:33:22.617839228Z" level=info msg="loading plugin" id=io.containerd.metrics.v1.grpc-otel type=io.containerd.metrics.v1 Oct 27 23:33:22.618681 containerd[2173]: time="2026-10-27T23:33:22.617857004Z" level=info msg="loading plugin" id=io.containerd.server.v1.grpc type=io.containerd.server.v1 Oct 27 23:33:22.637536 containerd[2173]: time="2026-10-27T23:33:22.637491124Z" level=info msg="loading plugin" id=io.containerd.server.v1.grpc-tcp type=io.containerd.server.v1 Oct 27 23:33:22.637674 containerd[2173]: time="2026-10-27T23:33:22.637657620Z" level=info msg="skip loading plugin" error="skip plugin" id=io.containerd.server.v1.grpc-tcp type=io.containerd.server.v1 Oct 27 23:33:22.637720 containerd[2173]: time="2026-10-27T23:33:22.637708340Z" level=info msg="loading plugin" id=io.containerd.http.v1.pprof type=io.containerd.http.v1 Oct 27 23:33:22.637796 containerd[2173]: time="2026-10-27T23:33:22.637785748Z" level=info msg="loading plugin" id=io.containerd.server.v1.debug type=io.containerd.server.v1 Oct 27 23:33:22.637858 containerd[2173]: time="2026-10-27T23:33:22.637845612Z" level=info msg="skip loading plugin" error="skip plugin" id=io.containerd.server.v1.debug type=io.containerd.server.v1 Oct 27 23:33:22.638141 containerd[2173]: time="2026-10-27T23:33:22.638117628Z" level=info msg=serving... address=/run/containerd/containerd.sock.ttrpc Oct 27 23:33:22.638210 containerd[2173]: time="2026-10-27T23:33:22.638196900Z" level=info msg="starting GRPC server" address=/run/containerd/containerd.sock gid=0 uid=0 Oct 27 23:33:22.638286 containerd[2173]: time="2026-10-27T23:33:22.638275356Z" level=info msg=serving... address=/run/containerd/containerd.sock Oct 27 23:33:22.638507 containerd[2173]: time="2026-10-27T23:33:22.638362996Z" level=info msg="containerd successfully booted in 1.449269s" Oct 27 23:33:22.638685 systemd[1]: Started containerd.service - containerd container runtime. Oct 27 23:33:22.645195 systemd[1]: Reached target multi-user.target - Multi-User System. Oct 27 23:33:22.650671 waagent[2307]: 2026-10-27T23:33:22.645862Z INFO Daemon Daemon Fabric preferred wire protocol version:2015-04-05 Oct 27 23:33:22.656326 systemd[1]: Startup finished in 2.664s (kernel) + 48.791s (initrd) + 17.544s (userspace) = 1min 8.999s. Oct 27 23:33:22.657239 waagent[2307]: 2026-10-27T23:33:22.657205Z INFO Daemon Daemon Wire protocol version:2012-11-30 Oct 27 23:33:22.666271 waagent[2307]: 2026-10-27T23:33:22.664866Z INFO Daemon Daemon Server preferred version:2015-04-05 Oct 27 23:33:22.765521 waagent[2307]: 2026-10-27T23:33:22.765450Z INFO Daemon Daemon Initializing goal state during protocol detection Oct 27 23:33:22.770684 waagent[2307]: 2026-10-27T23:33:22.770633Z INFO Daemon Daemon Forcing an update of the goal state. Oct 27 23:33:22.780325 waagent[2307]: 2026-10-27T23:33:22.780284Z INFO Daemon Fetched a new incarnation for the WireServer goal state [incarnation 1] Oct 27 23:33:22.798944 waagent[2307]: 2026-10-27T23:33:22.798906Z INFO Daemon Daemon HostGAPlugin version: 1.0.8.189 Oct 27 23:33:22.804111 waagent[2307]: 2026-10-27T23:33:22.804072Z INFO Daemon Oct 27 23:33:22.806461 waagent[2307]: 2026-10-27T23:33:22.806428Z INFO Daemon Fetched new vmSettings [HostGAPlugin correlation ID: e720d391-31ce-4818-865a-1d3b8bf397bd eTag: 111797568349938267 source: Fabric] Oct 27 23:33:22.815923 waagent[2307]: 2026-10-27T23:33:22.815880Z INFO Daemon The vmSettings originated via Fabric; will ignore them. Oct 27 23:33:22.822395 waagent[2307]: 2026-10-27T23:33:22.822357Z INFO Daemon Oct 27 23:33:22.824749 waagent[2307]: 2026-10-27T23:33:22.824720Z INFO Daemon Fetching full goal state from the WireServer [incarnation 1] Oct 27 23:33:22.832687 waagent[2307]: 2026-10-27T23:33:22.832659Z INFO Daemon Daemon Downloading artifacts profile blob Oct 27 23:33:22.934193 waagent[2307]: 2026-10-27T23:33:22.934120Z INFO Daemon Downloaded certificate {'thumbprint': '801C06525C1C1F0BB40EA170120D9FDAF69140E3', 'hasPrivateKey': True} Oct 27 23:33:22.944637 waagent[2307]: 2026-10-27T23:33:22.944264Z INFO Daemon Fetch goal state completed Oct 27 23:33:22.954317 waagent[2307]: 2026-10-27T23:33:22.954258Z INFO Daemon Daemon Starting provisioning Oct 27 23:33:22.959066 waagent[2307]: 2026-10-27T23:33:22.959018Z INFO Daemon Daemon Handle ovf-env.xml. Oct 27 23:33:22.963249 waagent[2307]: 2026-10-27T23:33:22.963203Z INFO Daemon Daemon Set hostname [ci-4820.0.1-n-221886e4d9] Oct 27 23:33:22.984520 waagent[2307]: 2026-10-27T23:33:22.984462Z INFO Daemon Daemon Publish hostname [ci-4820.0.1-n-221886e4d9] Oct 27 23:33:22.989623 waagent[2307]: 2026-10-27T23:33:22.989551Z INFO Daemon Daemon Examine /proc/net/route for primary interface Oct 27 23:33:22.994405 waagent[2307]: 2026-10-27T23:33:22.994361Z INFO Daemon Daemon Primary interface is [eth0] Oct 27 23:33:23.002758 systemd-networkd[1886]: eth0: Reconfiguring with /usr/lib/systemd/network/zz-default.network. Oct 27 23:33:23.002879 systemd-networkd[1886]: eth0: DHCP lease lost Oct 27 23:33:23.013687 waagent[2307]: 2026-10-27T23:33:23.013626Z INFO Daemon Daemon Create user account if not exists Oct 27 23:33:23.018490 waagent[2307]: 2026-10-27T23:33:23.018441Z INFO Daemon Daemon User core already exists, skip useradd Oct 27 23:33:23.023631 waagent[2307]: 2026-10-27T23:33:23.023318Z INFO Daemon Daemon Configure sudoer Oct 27 23:33:23.027612 systemd-networkd[1886]: eth0: DHCPv4 address 10.0.0.29/24, gateway 10.0.0.1 acquired from 168.63.129.16 Oct 27 23:33:23.027799 waagent[2307]: 2026-10-27T23:33:23.027212Z INFO Daemon Daemon Configure sshd Oct 27 23:33:23.031060 waagent[2307]: 2026-10-27T23:33:23.031017Z INFO Daemon Daemon Added a configuration snippet disabling SSH password-based authentication methods. It also configures SSH client probing to keep connections alive. Oct 27 23:33:23.040797 waagent[2307]: 2026-10-27T23:33:23.040760Z INFO Daemon Daemon Deploy ssh public key. Oct 27 23:33:23.044547 login[2309]: pam_unix(login:session): session opened for user core(uid=500) by core(uid=0) Oct 27 23:33:23.052379 systemd[1]: Created slice user-500.slice - User Slice of UID 500. Oct 27 23:33:23.054028 systemd[1]: Starting user-runtime-dir@500.service - User Runtime Directory /run/user/500... Oct 27 23:33:23.057582 systemd-logind[2145]: New session '1' of user 'core' with class 'user-light' and type 'tty'. Oct 27 23:33:23.090144 systemd[1]: Finished user-runtime-dir@500.service - User Runtime Directory /run/user/500. Oct 27 23:33:23.093882 systemd[1]: Started session-1.scope - Session 1 of User core. Oct 27 23:33:23.377066 login[2310]: pam_unix(login:session): session opened for user core(uid=500) by core(uid=0) Oct 27 23:33:23.381445 systemd-logind[2145]: New session '2' of user 'core' with class 'user-light' and type 'tty'. Oct 27 23:33:23.388930 systemd[1]: Started session-2.scope - Session 2 of User core. Oct 27 23:33:24.145994 waagent[2307]: 2026-10-27T23:33:24.145946Z INFO Daemon Daemon Provisioning complete Oct 27 23:33:24.156912 waagent[2307]: 2026-10-27T23:33:24.156874Z INFO Daemon Daemon RDMA capabilities are not enabled, skipping Oct 27 23:33:24.161877 waagent[2307]: 2026-10-27T23:33:24.161841Z INFO Daemon Daemon End of log to /dev/console. The agent will now check for updates and then will process extensions. Oct 27 23:33:24.169260 waagent[2307]: 2026-10-27T23:33:24.169228Z INFO Daemon Daemon Installed Agent WALinuxAgent-2.12.0.4 is the most current agent Oct 27 23:33:24.268409 waagent[2398]: 2026-10-27T23:33:24.267931Z INFO ExtHandler ExtHandler Azure Linux Agent (Goal State Agent version 2.12.0.4) Oct 27 23:33:24.268409 waagent[2398]: 2026-10-27T23:33:24.268071Z INFO ExtHandler ExtHandler OS: flatcar 4820.0.1 Oct 27 23:33:24.268409 waagent[2398]: 2026-10-27T23:33:24.268116Z INFO ExtHandler ExtHandler Python: 3.13.15 Oct 27 23:33:24.268409 waagent[2398]: 2026-10-27T23:33:24.268151Z INFO ExtHandler ExtHandler CPU Arch: aarch64 Oct 27 23:33:24.337890 waagent[2398]: 2026-10-27T23:33:24.337812Z INFO ExtHandler ExtHandler Distro: flatcar-4820.0.1; OSUtil: FlatcarUtil; AgentService: waagent; Python: 3.13.15; Arch: aarch64; systemd: True; LISDrivers: Absent; logrotate: logrotate 3.22.0; Oct 27 23:33:24.338066 waagent[2398]: 2026-10-27T23:33:24.338033Z INFO ExtHandler ExtHandler WireServer endpoint 168.63.129.16 read from file Oct 27 23:33:24.338108 waagent[2398]: 2026-10-27T23:33:24.338089Z INFO ExtHandler ExtHandler Wire server endpoint:168.63.129.16 Oct 27 23:33:24.343960 waagent[2398]: 2026-10-27T23:33:24.343914Z INFO ExtHandler Fetched a new incarnation for the WireServer goal state [incarnation 1] Oct 27 23:33:24.348380 waagent[2398]: 2026-10-27T23:33:24.348348Z INFO ExtHandler ExtHandler HostGAPlugin version: 1.0.8.189 Oct 27 23:33:24.348776 waagent[2398]: 2026-10-27T23:33:24.348744Z INFO ExtHandler Oct 27 23:33:24.348834 waagent[2398]: 2026-10-27T23:33:24.348816Z INFO ExtHandler Fetched new vmSettings [HostGAPlugin correlation ID: 26cc2e17-6caa-45d0-885d-613d1b7cac43 eTag: 111797568349938267 source: Fabric] Oct 27 23:33:24.349044 waagent[2398]: 2026-10-27T23:33:24.349020Z INFO ExtHandler The vmSettings originated via Fabric; will ignore them. Oct 27 23:33:24.349448 waagent[2398]: 2026-10-27T23:33:24.349418Z INFO ExtHandler Oct 27 23:33:24.349500 waagent[2398]: 2026-10-27T23:33:24.349483Z INFO ExtHandler Fetching full goal state from the WireServer [incarnation 1] Oct 27 23:33:24.351995 waagent[2398]: 2026-10-27T23:33:24.351968Z INFO ExtHandler ExtHandler Downloading artifacts profile blob Oct 27 23:33:24.413373 waagent[2398]: 2026-10-27T23:33:24.413247Z INFO ExtHandler Downloaded certificate {'thumbprint': '801C06525C1C1F0BB40EA170120D9FDAF69140E3', 'hasPrivateKey': True} Oct 27 23:33:24.413707 waagent[2398]: 2026-10-27T23:33:24.413675Z INFO ExtHandler Fetch goal state completed Oct 27 23:33:24.422788 waagent[2398]: 2026-10-27T23:33:24.422742Z INFO ExtHandler ExtHandler OpenSSL version: OpenSSL 3.6.5 29 Sep 2026 (Library: OpenSSL 3.6.5 29 Sep 2026) Oct 27 23:33:24.425853 waagent[2398]: 2026-10-27T23:33:24.425813Z INFO ExtHandler ExtHandler WALinuxAgent-2.12.0.4 running as process 2398 Oct 27 23:33:24.425956 waagent[2398]: 2026-10-27T23:33:24.425932Z INFO ExtHandler ExtHandler ******** AutoUpdate.Enabled is set to False, not processing the operation ******** Oct 27 23:33:24.426190 waagent[2398]: 2026-10-27T23:33:24.426163Z INFO ExtHandler ExtHandler ******** AutoUpdate.UpdateToLatestVersion is set to False, not processing the operation ******** Oct 27 23:33:24.427239 waagent[2398]: 2026-10-27T23:33:24.427206Z INFO ExtHandler ExtHandler [CGI] Cgroup monitoring is not supported on ['flatcar', '4820.0.1', '', 'Flatcar Container Linux by Kinvolk'] Oct 27 23:33:24.427554 waagent[2398]: 2026-10-27T23:33:24.427525Z INFO ExtHandler ExtHandler [CGI] Agent will reset the quotas in case distro: ['flatcar', '4820.0.1', '', 'Flatcar Container Linux by Kinvolk'] went from supported to unsupported Oct 27 23:33:24.427664 waagent[2398]: 2026-10-27T23:33:24.427643Z INFO ExtHandler ExtHandler [CGI] Agent cgroups enabled: False Oct 27 23:33:24.428074 waagent[2398]: 2026-10-27T23:33:24.428045Z INFO ExtHandler ExtHandler Starting setup for Persistent firewall rules Oct 27 23:33:24.461594 waagent[2398]: 2026-10-27T23:33:24.461553Z INFO ExtHandler ExtHandler Firewalld service not running/unavailable, trying to set up waagent-network-setup.service Oct 27 23:33:24.461803 waagent[2398]: 2026-10-27T23:33:24.461773Z INFO ExtHandler ExtHandler Successfully updated the Binary file /var/lib/waagent/waagent-network-setup.py for firewall setup Oct 27 23:33:24.466159 waagent[2398]: 2026-10-27T23:33:24.465778Z INFO ExtHandler ExtHandler Service: waagent-network-setup.service not enabled. Adding it now Oct 27 23:33:24.470046 systemd[1]: Reload requested from client PID 2413 ('systemctl') (unit waagent.service)... Oct 27 23:33:24.470061 systemd[1]: Reloading... Oct 27 23:33:24.552682 zram_generator::config[2464]: No configuration found. Oct 27 23:33:24.789211 systemd[1]: Reloading finished in 318 ms. Oct 27 23:33:24.821112 waagent[2398]: 2026-10-27T23:33:24.818955Z INFO ExtHandler ExtHandler Successfully added and enabled the waagent-network-setup.service Oct 27 23:33:24.821112 waagent[2398]: 2026-10-27T23:33:24.819096Z INFO ExtHandler ExtHandler Persistent firewall rules setup successfully Oct 27 23:33:25.081380 waagent[2398]: 2026-10-27T23:33:25.081263Z INFO ExtHandler ExtHandler DROP rule is not available which implies no firewall rules are set yet. Environment thread will set it up. Oct 27 23:33:25.081763 waagent[2398]: 2026-10-27T23:33:25.081726Z 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] Oct 27 23:33:25.082571 waagent[2398]: 2026-10-27T23:33:25.082529Z INFO ExtHandler ExtHandler Starting env monitor service. Oct 27 23:33:25.082697 waagent[2398]: 2026-10-27T23:33:25.082662Z INFO MonitorHandler ExtHandler WireServer endpoint 168.63.129.16 read from file Oct 27 23:33:25.082843 waagent[2398]: 2026-10-27T23:33:25.082817Z INFO MonitorHandler ExtHandler Wire server endpoint:168.63.129.16 Oct 27 23:33:25.083222 waagent[2398]: 2026-10-27T23:33:25.083184Z INFO ExtHandler ExtHandler Start SendTelemetryHandler service. Oct 27 23:33:25.083400 waagent[2398]: 2026-10-27T23:33:25.083366Z INFO MonitorHandler ExtHandler Monitor.NetworkConfigurationChanges is disabled. Oct 27 23:33:25.083761 waagent[2398]: 2026-10-27T23:33:25.083717Z INFO EnvHandler ExtHandler WireServer endpoint 168.63.129.16 read from file Oct 27 23:33:25.083823 waagent[2398]: 2026-10-27T23:33:25.083786Z INFO EnvHandler ExtHandler Wire server endpoint:168.63.129.16 Oct 27 23:33:25.083909 waagent[2398]: 2026-10-27T23:33:25.083882Z INFO EnvHandler ExtHandler Configure routes Oct 27 23:33:25.083946 waagent[2398]: 2026-10-27T23:33:25.083931Z INFO EnvHandler ExtHandler Gateway:None Oct 27 23:33:25.083977 waagent[2398]: 2026-10-27T23:33:25.083964Z INFO EnvHandler ExtHandler Routes:None Oct 27 23:33:25.084087 waagent[2398]: 2026-10-27T23:33:25.084045Z INFO SendTelemetryHandler ExtHandler Successfully started the SendTelemetryHandler thread Oct 27 23:33:25.084202 waagent[2398]: 2026-10-27T23:33:25.084176Z INFO MonitorHandler ExtHandler Routing table from /proc/net/route: Oct 27 23:33:25.084202 waagent[2398]: Iface Destination Gateway Flags RefCnt Use Metric Mask MTU Window IRTT Oct 27 23:33:25.084202 waagent[2398]: eth0 00000000 0100000A 0003 0 0 1024 00000000 0 0 0 Oct 27 23:33:25.084202 waagent[2398]: eth0 0000000A 00000000 0001 0 0 1024 00FFFFFF 0 0 0 Oct 27 23:33:25.084202 waagent[2398]: eth0 0100000A 00000000 0005 0 0 1024 FFFFFFFF 0 0 0 Oct 27 23:33:25.084202 waagent[2398]: eth0 10813FA8 0100000A 0007 0 0 1024 FFFFFFFF 0 0 0 Oct 27 23:33:25.084202 waagent[2398]: eth0 FEA9FEA9 0100000A 0007 0 0 1024 FFFFFFFF 0 0 0 Oct 27 23:33:25.084202 waagent[2398]: 2026-10-27T23:33:25.084225Z INFO ExtHandler ExtHandler Start Extension Telemetry service. Oct 27 23:33:25.085068 waagent[2398]: 2026-10-27T23:33:25.085023Z INFO TelemetryEventsCollector ExtHandler Extension Telemetry pipeline enabled: True Oct 27 23:33:25.085536 waagent[2398]: 2026-10-27T23:33:25.085150Z INFO ExtHandler ExtHandler Goal State Period: 6 sec. This indicates how often the agent checks for new goal states and reports status. Oct 27 23:33:25.085714 waagent[2398]: 2026-10-27T23:33:25.085686Z INFO TelemetryEventsCollector ExtHandler Successfully started the TelemetryEventsCollector thread Oct 27 23:33:25.091659 waagent[2398]: 2026-10-27T23:33:25.091616Z INFO ExtHandler ExtHandler Oct 27 23:33:25.091731 waagent[2398]: 2026-10-27T23:33:25.091695Z INFO ExtHandler ExtHandler ProcessExtensionsGoalState started [incarnation_1 channel: WireServer source: Fabric activity: 6de8a570-5926-4563-bf5a-9e4559e1008b correlation 86b37301-7c1f-424b-a8e4-b39b863e76ef created: 2026-10-27T23:31:50.601562Z] Oct 27 23:33:25.091990 waagent[2398]: 2026-10-27T23:33:25.091955Z INFO ExtHandler ExtHandler No extension handlers found, not processing anything. Oct 27 23:33:25.092394 waagent[2398]: 2026-10-27T23:33:25.092368Z INFO ExtHandler ExtHandler ProcessExtensionsGoalState completed [incarnation_1 0 ms] Oct 27 23:33:25.116978 waagent[2398]: 2026-10-27T23:33:25.116934Z INFO ExtHandler ExtHandler [HEARTBEAT] Agent WALinuxAgent-2.12.0.4 is running as the goal state agent [DEBUG HeartbeatCounter: 0;HeartbeatId: 06623991-3A3D-42FC-9BF5-496153E27F2C;DroppedPackets: 0;UpdateGSErrors: 0;AutoUpdate: 0;UpdateMode: SelfUpdate;] Oct 27 23:33:25.143705 waagent[2398]: 2026-10-27T23:33:25.143637Z INFO MonitorHandler ExtHandler Network interfaces: Oct 27 23:33:25.143705 waagent[2398]: Executing ['ip', '-a', '-o', 'link']: Oct 27 23:33:25.143705 waagent[2398]: 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 Oct 27 23:33:25.143705 waagent[2398]: 2: eth0: mtu 1500 qdisc mq state UP mode DEFAULT group default qlen 1000\ link/ether 00:0d:3a:c5:22:bd brd ff:ff:ff:ff:ff:ff\ altname enx000d3ac522bd Oct 27 23:33:25.143705 waagent[2398]: 3: enP24261s1: mtu 1500 qdisc mq master eth0 state UP mode DEFAULT group default qlen 1000\ link/ether 00:0d:3a:c5:22:bd brd ff:ff:ff:ff:ff:ff\ altname enP24261p0s2 Oct 27 23:33:25.143705 waagent[2398]: Executing ['ip', '-4', '-a', '-o', 'address']: Oct 27 23:33:25.143705 waagent[2398]: 1: lo inet 127.0.0.1/8 scope host lo\ valid_lft forever preferred_lft forever Oct 27 23:33:25.143705 waagent[2398]: 2: eth0 inet 10.0.0.29/24 metric 1024 brd 10.0.0.255 scope global eth0\ valid_lft forever preferred_lft forever Oct 27 23:33:25.143705 waagent[2398]: Executing ['ip', '-6', '-a', '-o', 'address']: Oct 27 23:33:25.143705 waagent[2398]: 1: lo inet6 ::1/128 scope host noprefixroute \ valid_lft forever preferred_lft forever Oct 27 23:33:25.143705 waagent[2398]: 2: eth0 inet6 fe80::20d:3aff:fec5:22bd/64 scope link proto kernel_ll \ valid_lft forever preferred_lft forever Oct 27 23:33:25.172029 waagent[2398]: 2026-10-27T23:33:25.171974Z INFO EnvHandler ExtHandler Created firewall rules for the Azure Fabric: Oct 27 23:33:25.172029 waagent[2398]: Chain INPUT (policy ACCEPT 0 packets, 0 bytes) Oct 27 23:33:25.172029 waagent[2398]: pkts bytes target prot opt in out source destination Oct 27 23:33:25.172029 waagent[2398]: Chain FORWARD (policy ACCEPT 0 packets, 0 bytes) Oct 27 23:33:25.172029 waagent[2398]: pkts bytes target prot opt in out source destination Oct 27 23:33:25.172029 waagent[2398]: Chain OUTPUT (policy ACCEPT 3 packets, 534 bytes) Oct 27 23:33:25.172029 waagent[2398]: pkts bytes target prot opt in out source destination Oct 27 23:33:25.172029 waagent[2398]: 0 0 ACCEPT tcp -- * * 0.0.0.0/0 168.63.129.16 tcp dpt:53 Oct 27 23:33:25.172029 waagent[2398]: 4 416 ACCEPT tcp -- * * 0.0.0.0/0 168.63.129.16 owner UID match 0 Oct 27 23:33:25.172029 waagent[2398]: 0 0 DROP tcp -- * * 0.0.0.0/0 168.63.129.16 ctstate INVALID,NEW Oct 27 23:33:25.174750 waagent[2398]: 2026-10-27T23:33:25.174705Z INFO EnvHandler ExtHandler Current Firewall rules: Oct 27 23:33:25.174750 waagent[2398]: Chain INPUT (policy ACCEPT 0 packets, 0 bytes) Oct 27 23:33:25.174750 waagent[2398]: pkts bytes target prot opt in out source destination Oct 27 23:33:25.174750 waagent[2398]: Chain FORWARD (policy ACCEPT 0 packets, 0 bytes) Oct 27 23:33:25.174750 waagent[2398]: pkts bytes target prot opt in out source destination Oct 27 23:33:25.174750 waagent[2398]: Chain OUTPUT (policy ACCEPT 3 packets, 534 bytes) Oct 27 23:33:25.174750 waagent[2398]: pkts bytes target prot opt in out source destination Oct 27 23:33:25.174750 waagent[2398]: 0 0 ACCEPT tcp -- * * 0.0.0.0/0 168.63.129.16 tcp dpt:53 Oct 27 23:33:25.174750 waagent[2398]: 9 816 ACCEPT tcp -- * * 0.0.0.0/0 168.63.129.16 owner UID match 0 Oct 27 23:33:25.174750 waagent[2398]: 0 0 DROP tcp -- * * 0.0.0.0/0 168.63.129.16 ctstate INVALID,NEW Oct 27 23:33:25.175017 waagent[2398]: 2026-10-27T23:33:25.174985Z INFO EnvHandler ExtHandler Set block dev timeout: sda with timeout: 300 Oct 27 23:33:39.071284 systemd[1]: Created slice system-sshd.slice - Slice /system/sshd. Oct 27 23:33:39.072846 systemd[1]: Started sshd@0-1-10.0.0.29:22-20.76.155.168:45860.service - OpenSSH per-connection server daemon (20.76.155.168:45860). Oct 27 23:33:39.941628 sshd[2550]: Accepted publickey for core from 20.76.155.168 port 45860 ssh2: RSA SHA256:JMBN55BGL6GqgbjEBATOk4IqTpNZS0skXI6K0M7Gs48 Oct 27 23:33:39.942753 sshd-session[2550]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Oct 27 23:33:39.954783 systemd[1]: Starting user@500.service - User Manager for UID 500... Oct 27 23:33:39.957177 systemd-logind[2145]: New session '3' of user 'core' with class 'user' and type 'tty'. Oct 27 23:33:39.962592 (systemd)[2554]: pam_unix(systemd-user:session): session opened for user core(uid=500) by core(uid=0) Oct 27 23:33:39.965030 systemd-logind[2145]: New session '4' of user 'core' with class 'manager-early' and type 'unspecified'. Oct 27 23:33:40.178278 systemd[2554]: Queued start job for default target default.target. Oct 27 23:33:40.188472 systemd[2554]: Created slice app.slice - User Application Slice. Oct 27 23:33:40.188673 systemd[2554]: Started systemd-tmpfiles-clean.timer - Daily Cleanup of User's Temporary Directories. Oct 27 23:33:40.188765 systemd[2554]: Reached target machines.target - Virtual Machines and Containers. Oct 27 23:33:40.188879 systemd[2554]: Reached target paths.target - Paths. Oct 27 23:33:40.188974 systemd[2554]: Reached target timers.target - Timers. Oct 27 23:33:40.190029 systemd[2554]: Starting dbus.socket - D-Bus User Message Bus Socket... Oct 27 23:33:40.191311 systemd[2554]: Listening on systemd-ask-password.socket - Query the User Interactively for a Password. Oct 27 23:33:40.191572 systemd[2554]: Listening on systemd-importd.socket - Disk Image Download Service Socket. Oct 27 23:33:40.192386 systemd[2554]: Listening on systemd-journalctl.socket - Journal Log Access Socket. Oct 27 23:33:40.192735 systemd[2554]: Listening on systemd-machined.socket - Virtual Machine and Container Registration Service Socket. Oct 27 23:33:40.193994 systemd[2554]: Listening on systemd-storage-fs.socket - Simple File System Backed Storage Provider. Oct 27 23:33:40.196753 systemd[2554]: Starting systemd-tmpfiles-setup.service - Create User Files and Directories... Oct 27 23:33:40.199383 systemd[2554]: Listening on dbus.socket - D-Bus User Message Bus Socket. Oct 27 23:33:40.199521 systemd[2554]: Reached target sockets.target - Sockets. Oct 27 23:33:40.205733 systemd[2554]: Finished systemd-tmpfiles-setup.service - Create User Files and Directories. Oct 27 23:33:40.205815 systemd[2554]: Reached target basic.target - Basic System. Oct 27 23:33:40.205864 systemd[2554]: Reached target default.target - Main User Target. Oct 27 23:33:40.205887 systemd[2554]: Startup finished in 235ms. Oct 27 23:33:40.206129 systemd[1]: Started user@500.service - User Manager for UID 500. Oct 27 23:33:40.208745 systemd[1]: Started session-3.scope - Session 3 of User core. Oct 27 23:33:40.634221 systemd[1]: Started sshd@1-2-10.0.0.29:22-20.76.155.168:45870.service - OpenSSH per-connection server daemon (20.76.155.168:45870). Oct 27 23:33:41.350540 sshd[2568]: Accepted publickey for core from 20.76.155.168 port 45870 ssh2: RSA SHA256:JMBN55BGL6GqgbjEBATOk4IqTpNZS0skXI6K0M7Gs48 Oct 27 23:33:41.351674 sshd-session[2568]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Oct 27 23:33:41.355675 systemd-logind[2145]: New session '5' of user 'core' with class 'user' and type 'tty'. Oct 27 23:33:41.365791 systemd[1]: Started session-5.scope - Session 5 of User core. Oct 27 23:33:41.762163 sshd[2572]: Connection closed by 20.76.155.168 port 45870 Oct 27 23:33:41.762878 sshd-session[2568]: pam_unix(sshd:session): session closed for user core Oct 27 23:33:41.766341 systemd[1]: sshd@1-2-10.0.0.29:22-20.76.155.168:45870.service: Deactivated successfully. Oct 27 23:33:41.768732 systemd[1]: session-5.scope: Deactivated successfully. Oct 27 23:33:41.770455 systemd-logind[2145]: Session 5 logged out. Waiting for processes to exit. Oct 27 23:33:41.771370 systemd-logind[2145]: Removed session 5. Oct 27 23:33:41.909082 systemd[1]: Started sshd@2-3-10.0.0.29:22-20.76.155.168:45876.service - OpenSSH per-connection server daemon (20.76.155.168:45876). Oct 27 23:33:42.519625 chronyd[2129]: Selected source PHC0 Oct 27 23:33:42.627076 sshd[2578]: Accepted publickey for core from 20.76.155.168 port 45876 ssh2: RSA SHA256:JMBN55BGL6GqgbjEBATOk4IqTpNZS0skXI6K0M7Gs48 Oct 27 23:33:42.628261 sshd-session[2578]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Oct 27 23:33:42.632555 systemd-logind[2145]: New session '6' of user 'core' with class 'user' and type 'tty'. Oct 27 23:33:42.637758 systemd[1]: Started session-6.scope - Session 6 of User core. Oct 27 23:33:43.040640 sshd[2582]: Connection closed by 20.76.155.168 port 45876 Oct 27 23:33:43.039998 sshd-session[2578]: pam_unix(sshd:session): session closed for user core Oct 27 23:33:43.042823 systemd[1]: sshd@2-3-10.0.0.29:22-20.76.155.168:45876.service: Deactivated successfully. Oct 27 23:33:43.044732 systemd[1]: session-6.scope: Deactivated successfully. Oct 27 23:33:43.047046 systemd-logind[2145]: Session 6 logged out. Waiting for processes to exit. Oct 27 23:33:43.047896 systemd-logind[2145]: Removed session 6. Oct 27 23:33:43.187860 systemd[1]: Started sshd@3-4-10.0.0.29:22-20.76.155.168:45888.service - OpenSSH per-connection server daemon (20.76.155.168:45888). Oct 27 23:33:43.907745 sshd[2588]: Accepted publickey for core from 20.76.155.168 port 45888 ssh2: RSA SHA256:JMBN55BGL6GqgbjEBATOk4IqTpNZS0skXI6K0M7Gs48 Oct 27 23:33:43.908809 sshd-session[2588]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Oct 27 23:33:43.913439 systemd-logind[2145]: New session '7' of user 'core' with class 'user' and type 'tty'. Oct 27 23:33:43.922775 systemd[1]: Started session-7.scope - Session 7 of User core. Oct 27 23:33:44.319758 sshd[2592]: Connection closed by 20.76.155.168 port 45888 Oct 27 23:33:44.320391 sshd-session[2588]: pam_unix(sshd:session): session closed for user core Oct 27 23:33:44.323326 systemd[1]: sshd@3-4-10.0.0.29:22-20.76.155.168:45888.service: Deactivated successfully. Oct 27 23:33:44.325526 systemd[1]: session-7.scope: Deactivated successfully. Oct 27 23:33:44.327354 systemd-logind[2145]: Session 7 logged out. Waiting for processes to exit. Oct 27 23:33:44.328265 systemd-logind[2145]: Removed session 7. Oct 27 23:33:44.467490 systemd[1]: Started sshd@4-4097-10.0.0.29:22-20.76.155.168:45900.service - OpenSSH per-connection server daemon (20.76.155.168:45900). Oct 27 23:33:45.188401 sshd[2598]: Accepted publickey for core from 20.76.155.168 port 45900 ssh2: RSA SHA256:JMBN55BGL6GqgbjEBATOk4IqTpNZS0skXI6K0M7Gs48 Oct 27 23:33:45.189518 sshd-session[2598]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Oct 27 23:33:45.193481 systemd-logind[2145]: New session '8' of user 'core' with class 'user' and type 'tty'. Oct 27 23:33:45.199744 systemd[1]: Started session-8.scope - Session 8 of User core. Oct 27 23:33:45.614306 sudo[2603]: core : PWD=/home/core ; USER=root ; COMMAND=/usr/sbin/setenforce 1 Oct 27 23:33:45.614879 sudo[2603]: pam_unix(sudo:session): session opened for user root(uid=0) by core(uid=500) Oct 27 23:33:45.642421 sudo[2603]: pam_unix(sudo:session): session closed for user root Oct 27 23:33:45.779305 sshd[2602]: Connection closed by 20.76.155.168 port 45900 Oct 27 23:33:45.780393 sshd-session[2598]: pam_unix(sshd:session): session closed for user core Oct 27 23:33:45.783479 systemd[1]: sshd@4-4097-10.0.0.29:22-20.76.155.168:45900.service: Deactivated successfully. Oct 27 23:33:45.785357 systemd[1]: session-8.scope: Deactivated successfully. Oct 27 23:33:45.787502 systemd-logind[2145]: Session 8 logged out. Waiting for processes to exit. Oct 27 23:33:45.789256 systemd-logind[2145]: Removed session 8. Oct 27 23:33:45.927284 systemd[1]: Started sshd@5-5-10.0.0.29:22-20.76.155.168:45912.service - OpenSSH per-connection server daemon (20.76.155.168:45912). Oct 27 23:33:46.649449 sshd[2610]: Accepted publickey for core from 20.76.155.168 port 45912 ssh2: RSA SHA256:JMBN55BGL6GqgbjEBATOk4IqTpNZS0skXI6K0M7Gs48 Oct 27 23:33:46.650579 sshd-session[2610]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Oct 27 23:33:46.654247 systemd-logind[2145]: New session '9' of user 'core' with class 'user' and type 'tty'. Oct 27 23:33:46.659766 systemd[1]: Started session-9.scope - Session 9 of User core. Oct 27 23:33:46.928620 sudo[2616]: 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 Oct 27 23:33:46.928858 sudo[2616]: pam_unix(sudo:session): session opened for user root(uid=0) by core(uid=500) Oct 27 23:33:46.930305 sudo[2616]: pam_unix(sudo:session): session closed for user root Oct 27 23:33:46.935457 sudo[2615]: core : PWD=/home/core ; USER=root ; COMMAND=/usr/sbin/systemctl restart audit-rules Oct 27 23:33:46.935736 sudo[2615]: pam_unix(sudo:session): session opened for user root(uid=0) by core(uid=500) Oct 27 23:33:46.940850 systemd[1]: Starting audit-rules.service - Load Audit Rules... Oct 27 23:33:46.989000 audit: CONFIG_CHANGE auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 op=remove_rule key=(null) list=5 res=1 Oct 27 23:33:47.001952 kernel: kauditd_printk_skb: 7 callbacks suppressed Oct 27 23:33:47.001995 kernel: audit: type=1305 audit(1793144026.989:179): auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 op=remove_rule key=(null) list=5 res=1 Oct 27 23:33:47.002360 augenrules[2640]: No rules Oct 27 23:33:47.010750 systemd[1]: audit-rules.service: Deactivated successfully. Oct 27 23:33:47.010976 systemd[1]: Finished audit-rules.service - Load Audit Rules. Oct 27 23:33:47.011828 sudo[2615]: pam_unix(sudo:session): session closed for user root Oct 27 23:33:46.989000 audit[2640]: SYSCALL arch=c00000b7 syscall=206 success=yes exit=1056 a0=3 a1=ffffeb319430 a2=420 a3=0 items=0 ppid=2621 pid=2640 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) Oct 27 23:33:47.031295 kernel: audit: type=1300 audit(1793144026.989:179): arch=c00000b7 syscall=206 success=yes exit=1056 a0=3 a1=ffffeb319430 a2=420 a3=0 items=0 ppid=2621 pid=2640 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) Oct 27 23:33:46.989000 audit: PROCTITLE proctitle=2F7362696E2F617564697463746C002D52002F6574632F61756469742F61756469742E72756C6573 Oct 27 23:33:47.039118 kernel: audit: type=1327 audit(1793144026.989:179): proctitle=2F7362696E2F617564697463746C002D52002F6574632F61756469742F61756469742E72756C6573 Oct 27 23:33:47.009000 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' Oct 27 23:33:47.039249 kernel: audit: type=1130 audit(1793144027.009:180): pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=audit-rules comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Oct 27 23:33:47.009000 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' Oct 27 23:33:47.063026 kernel: audit: type=1131 audit(1793144027.009:181): 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' Oct 27 23:33:47.010000 audit[2615]: AUDIT1106 pid=2615 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' Oct 27 23:33:47.063301 kernel: audit: type=1106 audit(1793144027.010:182): pid=2615 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' Oct 27 23:33:47.010000 audit[2615]: AUDIT1104 pid=2615 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' Oct 27 23:33:47.077682 kernel: audit: type=1104 audit(1793144027.010:183): pid=2615 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' Oct 27 23:33:47.150228 sshd[2614]: Connection closed by 20.76.155.168 port 45912 Oct 27 23:33:47.150153 sshd-session[2610]: pam_unix(sshd:session): session closed for user core Oct 27 23:33:47.149000 audit[2610]: AUDIT1106 pid=2610 uid=0 auid=500 ses=9 subj=system_u:system_r:kernel_t:s0 msg='op=PAM:session_close grantors=pam_loginuid,pam_env,pam_namespace,pam_keyinit,pam_limits,pam_env,pam_umask,pam_unix,pam_systemd,pam_lastlog,pam_mail acct="core" exe="/usr/lib64/misc/sshd-session" hostname=20.76.155.168 addr=20.76.155.168 terminal=ssh res=success' Oct 27 23:33:47.149000 audit[2610]: AUDIT1104 pid=2610 uid=0 auid=500 ses=9 subj=system_u:system_r:kernel_t:s0 msg='op=PAM:setcred grantors=pam_env,pam_faillock acct="core" exe="/usr/lib64/misc/sshd-session" hostname=20.76.155.168 addr=20.76.155.168 terminal=ssh res=success' Oct 27 23:33:47.174888 systemd[1]: sshd@5-5-10.0.0.29:22-20.76.155.168:45912.service: Deactivated successfully. Oct 27 23:33:47.177232 systemd[1]: session-9.scope: Deactivated successfully. Oct 27 23:33:47.173000 audit[1]: SERVICE_STOP pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=sshd@5-5-10.0.0.29:22-20.76.155.168:45912 comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Oct 27 23:33:47.189665 kernel: audit: type=1106 audit(1793144027.149:184): pid=2610 uid=0 auid=500 ses=9 subj=system_u:system_r:kernel_t:s0 msg='op=PAM:session_close grantors=pam_loginuid,pam_env,pam_namespace,pam_keyinit,pam_limits,pam_env,pam_umask,pam_unix,pam_systemd,pam_lastlog,pam_mail acct="core" exe="/usr/lib64/misc/sshd-session" hostname=20.76.155.168 addr=20.76.155.168 terminal=ssh res=success' Oct 27 23:33:47.189697 kernel: audit: type=1104 audit(1793144027.149:185): pid=2610 uid=0 auid=500 ses=9 subj=system_u:system_r:kernel_t:s0 msg='op=PAM:setcred grantors=pam_env,pam_faillock acct="core" exe="/usr/lib64/misc/sshd-session" hostname=20.76.155.168 addr=20.76.155.168 terminal=ssh res=success' Oct 27 23:33:47.189721 kernel: audit: type=1131 audit(1793144027.173:186): pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=sshd@5-5-10.0.0.29:22-20.76.155.168:45912 comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Oct 27 23:33:47.194401 systemd-logind[2145]: Session 9 logged out. Waiting for processes to exit. Oct 27 23:33:47.195611 systemd-logind[2145]: Removed session 9. Oct 27 23:33:47.297482 systemd[1]: Started sshd@6-6-10.0.0.29:22-20.76.155.168:45928.service - OpenSSH per-connection server daemon (20.76.155.168:45928). Oct 27 23:33:47.296000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=sshd@6-6-10.0.0.29:22-20.76.155.168:45928 comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Oct 27 23:33:48.016000 audit[2649]: AUDIT1101 pid=2649 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='op=PAM:accounting grantors=pam_access,pam_time,pam_unix,pam_faillock acct="core" exe="/usr/lib64/misc/sshd-session" hostname=20.76.155.168 addr=20.76.155.168 terminal=ssh res=success' Oct 27 23:33:48.017853 sshd[2649]: Accepted publickey for core from 20.76.155.168 port 45928 ssh2: RSA SHA256:JMBN55BGL6GqgbjEBATOk4IqTpNZS0skXI6K0M7Gs48 Oct 27 23:33:48.017000 audit[2649]: AUDIT1103 pid=2649 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='op=PAM:setcred grantors=pam_env,pam_faillock acct="core" exe="/usr/lib64/misc/sshd-session" hostname=20.76.155.168 addr=20.76.155.168 terminal=ssh res=success' Oct 27 23:33:48.017000 audit[2649]: SYSCALL arch=c00000b7 syscall=64 success=yes exit=3 a0=8 a1=ffffd97d54e0 a2=3 a3=0 items=0 ppid=1 pid=2649 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) Oct 27 23:33:48.017000 audit: PROCTITLE proctitle=737368642D73657373696F6E3A20636F7265205B706F7374617574685D Oct 27 23:33:48.019291 sshd-session[2649]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Oct 27 23:33:48.023151 systemd-logind[2145]: New session '10' of user 'core' with class 'user' and type 'tty'. Oct 27 23:33:48.033795 systemd[1]: Started session-10.scope - Session 10 of User core. Oct 27 23:33:48.034000 audit[2649]: AUDIT1105 pid=2649 uid=0 auid=500 ses=10 subj=system_u:system_r:kernel_t:s0 msg='op=PAM:session_open grantors=pam_loginuid,pam_env,pam_namespace,pam_keyinit,pam_limits,pam_env,pam_umask,pam_unix,pam_systemd,pam_lastlog,pam_mail acct="core" exe="/usr/lib64/misc/sshd-session" hostname=20.76.155.168 addr=20.76.155.168 terminal=ssh res=success' Oct 27 23:33:48.036000 audit[2653]: AUDIT1103 pid=2653 uid=0 auid=500 ses=10 subj=system_u:system_r:kernel_t:s0 msg='op=PAM:setcred grantors=pam_env,pam_faillock acct="core" exe="/usr/lib64/misc/sshd-session" hostname=20.76.155.168 addr=20.76.155.168 terminal=ssh res=success' Oct 27 23:33:48.295000 audit[2654]: AUDIT1101 pid=2654 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' Oct 27 23:33:48.295000 audit[2654]: AUDIT1110 pid=2654 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' Oct 27 23:33:48.295000 audit[2654]: AUDIT1105 pid=2654 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' Oct 27 23:33:48.297067 sudo[2654]: core : PWD=/home/core ; USER=root ; COMMAND=/usr/sbin/cryptsetup isLuks /dev/disk/by-partlabel/USR-B Oct 27 23:33:48.297292 sudo[2654]: pam_unix(sudo:session): session opened for user root(uid=0) by core(uid=500) Oct 27 23:33:48.332000 audit[2654]: AUDIT1106 pid=2654 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' Oct 27 23:33:48.333957 sudo[2654]: pam_unix(sudo:session): session closed for user root Oct 27 23:33:48.332000 audit[2654]: AUDIT1104 pid=2654 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' Oct 27 23:33:48.470535 sshd[2653]: Connection closed by 20.76.155.168 port 45928 Oct 27 23:33:48.471072 sshd-session[2649]: pam_unix(sshd:session): session closed for user core Oct 27 23:33:48.470000 audit[2649]: AUDIT1106 pid=2649 uid=0 auid=500 ses=10 subj=system_u:system_r:kernel_t:s0 msg='op=PAM:session_close grantors=pam_loginuid,pam_env,pam_namespace,pam_keyinit,pam_limits,pam_env,pam_umask,pam_unix,pam_systemd,pam_lastlog,pam_mail acct="core" exe="/usr/lib64/misc/sshd-session" hostname=20.76.155.168 addr=20.76.155.168 terminal=ssh res=success' Oct 27 23:33:48.470000 audit[2649]: AUDIT1104 pid=2649 uid=0 auid=500 ses=10 subj=system_u:system_r:kernel_t:s0 msg='op=PAM:setcred grantors=pam_env,pam_faillock acct="core" exe="/usr/lib64/misc/sshd-session" hostname=20.76.155.168 addr=20.76.155.168 terminal=ssh res=success' Oct 27 23:33:48.474196 systemd[1]: sshd@6-6-10.0.0.29:22-20.76.155.168:45928.service: Deactivated successfully. Oct 27 23:33:48.472000 audit[1]: SERVICE_STOP pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=sshd@6-6-10.0.0.29:22-20.76.155.168:45928 comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Oct 27 23:33:48.476075 systemd[1]: session-10.scope: Deactivated successfully. Oct 27 23:33:48.477069 systemd-logind[2145]: Session 10 logged out. Waiting for processes to exit. Oct 27 23:33:48.478374 systemd-logind[2145]: Removed session 10. Oct 27 23:33:48.618713 systemd[1]: Started sshd@7-7-10.0.0.29:22-20.76.155.168:45930.service - OpenSSH per-connection server daemon (20.76.155.168:45930). Oct 27 23:33:48.617000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=sshd@7-7-10.0.0.29:22-20.76.155.168:45930 comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Oct 27 23:33:49.336000 audit[2661]: AUDIT1101 pid=2661 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='op=PAM:accounting grantors=pam_access,pam_time,pam_unix,pam_faillock acct="core" exe="/usr/lib64/misc/sshd-session" hostname=20.76.155.168 addr=20.76.155.168 terminal=ssh res=success' Oct 27 23:33:49.338878 sshd[2661]: Accepted publickey for core from 20.76.155.168 port 45930 ssh2: RSA SHA256:JMBN55BGL6GqgbjEBATOk4IqTpNZS0skXI6K0M7Gs48 Oct 27 23:33:49.337000 audit[2661]: AUDIT1103 pid=2661 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='op=PAM:setcred grantors=pam_env,pam_faillock acct="core" exe="/usr/lib64/misc/sshd-session" hostname=20.76.155.168 addr=20.76.155.168 terminal=ssh res=success' Oct 27 23:33:49.337000 audit[2661]: SYSCALL arch=c00000b7 syscall=64 success=yes exit=3 a0=8 a1=ffffee056f30 a2=3 a3=0 items=0 ppid=1 pid=2661 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) Oct 27 23:33:49.337000 audit: PROCTITLE proctitle=737368642D73657373696F6E3A20636F7265205B706F7374617574685D Oct 27 23:33:49.340112 sshd-session[2661]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Oct 27 23:33:49.344769 systemd-logind[2145]: New session '11' of user 'core' with class 'user' and type 'tty'. Oct 27 23:33:49.350913 systemd[1]: Started session-11.scope - Session 11 of User core. Oct 27 23:33:49.351000 audit[2661]: AUDIT1105 pid=2661 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=20.76.155.168 addr=20.76.155.168 terminal=ssh res=success' Oct 27 23:33:49.353000 audit[2665]: AUDIT1103 pid=2665 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=20.76.155.168 addr=20.76.155.168 terminal=ssh res=success' Oct 27 23:33:49.751306 sshd[2665]: Connection closed by 20.76.155.168 port 45930 Oct 27 23:33:49.751890 sshd-session[2661]: pam_unix(sshd:session): session closed for user core Oct 27 23:33:49.750000 audit[2661]: AUDIT1106 pid=2661 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=20.76.155.168 addr=20.76.155.168 terminal=ssh res=success' Oct 27 23:33:49.750000 audit[2661]: AUDIT1104 pid=2661 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=20.76.155.168 addr=20.76.155.168 terminal=ssh res=success' Oct 27 23:33:49.754651 systemd[1]: sshd@7-7-10.0.0.29:22-20.76.155.168:45930.service: Deactivated successfully. Oct 27 23:33:49.753000 audit[1]: SERVICE_STOP pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=sshd@7-7-10.0.0.29:22-20.76.155.168:45930 comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Oct 27 23:33:49.756219 systemd[1]: session-11.scope: Deactivated successfully. Oct 27 23:33:49.757516 systemd-logind[2145]: Session 11 logged out. Waiting for processes to exit. Oct 27 23:33:49.758355 systemd-logind[2145]: Removed session 11.