Oct 22 23:10:28.274135 kernel: Booting Linux on physical CPU 0x0000000000 [0x410fd490] Oct 22 23:10:28.274157 kernel: Linux version 6.12.113-flatcar (build@pony-truck.infra.kinvolk.io) (aarch64-cros-linux-gnu-gcc (Gentoo Hardened 15.2.1_p20260214 p5) 15.2.1 20260214, GNU ld (Gentoo 2.46.0 p1) 2.46.0) #1 SMP PREEMPT Thu Oct 22 21:51:27 -00 2026 Oct 22 23:10:28.274164 kernel: KASLR enabled Oct 22 23:10:28.274168 kernel: earlycon: pl11 at MMIO 0x00000000effec000 (options '') Oct 22 23:10:28.274172 kernel: printk: legacy bootconsole [pl11] enabled Oct 22 23:10:28.274175 kernel: efi: EFI v2.7 by EDK II Oct 22 23:10:28.274182 kernel: efi: ACPI 2.0=0x3f979018 SMBIOS=0x3f8a0000 SMBIOS 3.0=0x3f880000 MEMATTR=0x3e879018 RNG=0x3f979718 MEMRESERVE=0x3decaf98 Oct 22 23:10:28.274186 kernel: random: crng init done Oct 22 23:10:28.274190 kernel: secureboot: Secure boot disabled Oct 22 23:10:28.274194 kernel: ACPI: Early table checksum verification disabled Oct 22 23:10:28.274198 kernel: ACPI: RSDP 0x000000003F979018 000024 (v02 VRTUAL) Oct 22 23:10:28.274202 kernel: ACPI: XSDT 0x000000003F979F18 00006C (v01 VRTUAL MICROSFT 00000001 MSFT 00000001) Oct 22 23:10:28.274206 kernel: ACPI: FACP 0x000000003F979C18 000114 (v06 VRTUAL MICROSFT 00000001 MSFT 00000001) Oct 22 23:10:28.274210 kernel: ACPI: DSDT 0x000000003F95A018 01E046 (v02 MSFTVM DSDT01 00000001 INTL 20230628) Oct 22 23:10:28.274216 kernel: ACPI: DBG2 0x000000003F979B18 000072 (v00 VRTUAL MICROSFT 00000001 MSFT 00000001) Oct 22 23:10:28.274221 kernel: ACPI: GTDT 0x000000003F979D98 000060 (v02 VRTUAL MICROSFT 00000001 MSFT 00000001) Oct 22 23:10:28.274225 kernel: ACPI: OEM0 0x000000003F979098 000064 (v01 VRTUAL MICROSFT 00000001 MSFT 00000001) Oct 22 23:10:28.274229 kernel: ACPI: SPCR 0x000000003F979A98 000050 (v02 VRTUAL MICROSFT 00000001 MSFT 00000001) Oct 22 23:10:28.274234 kernel: ACPI: APIC 0x000000003F979818 0000EE (v05 HVLITE HVLITETB 00000000 MSHV 00000000) Oct 22 23:10:28.274238 kernel: ACPI: SRAT 0x000000003F979998 0000A4 (v03 HVLITE HVLITETB 00000000 MSHV 00000000) Oct 22 23:10:28.274243 kernel: ACPI: PPTT 0x000000003F979198 00012C (v01 VRTUAL MICROSFT 00000000 MSFT 00000000) Oct 22 23:10:28.274248 kernel: ACPI: BGRT 0x000000003F979E98 000038 (v01 VRTUAL MICROSFT 00000001 MSFT 00000001) Oct 22 23:10:28.274252 kernel: ACPI: SPCR: console: pl011,mmio32,0xeffec000,115200 Oct 22 23:10:28.274256 kernel: ACPI: Use ACPI SPCR as default console: Yes Oct 22 23:10:28.274261 kernel: ACPI: SRAT: Node 0 PXM 0 [mem 0x00000000-0x3fffffff] Oct 22 23:10:28.274265 kernel: ACPI: SRAT: Node 0 PXM 0 [mem 0x100000000-0x1bfffffff] Oct 22 23:10:28.274269 kernel: NUMA: Node 0 [mem 0x00000000-0x3fffffff] + [mem 0x100000000-0x1bfffffff] -> [mem 0x00000000-0x1bfffffff] Oct 22 23:10:28.274274 kernel: NODE_DATA(0) allocated [mem 0x1bf800a00-0x1bf807fff] Oct 22 23:10:28.274278 kernel: Zone ranges: Oct 22 23:10:28.274282 kernel: DMA [mem 0x0000000000000000-0x00000000ffffffff] Oct 22 23:10:28.274287 kernel: DMA32 empty Oct 22 23:10:28.274292 kernel: Normal [mem 0x0000000100000000-0x00000001bfffffff] Oct 22 23:10:28.274296 kernel: Device empty Oct 22 23:10:28.274300 kernel: Movable zone start for each node Oct 22 23:10:28.274305 kernel: Early memory node ranges Oct 22 23:10:28.274309 kernel: node 0: [mem 0x0000000000000000-0x00000000007fffff] Oct 22 23:10:28.274313 kernel: node 0: [mem 0x0000000000824000-0x000000003f38ffff] Oct 22 23:10:28.274318 kernel: node 0: [mem 0x000000003f390000-0x000000003f943fff] Oct 22 23:10:28.274322 kernel: node 0: [mem 0x000000003f944000-0x000000003f9effff] Oct 22 23:10:28.274326 kernel: node 0: [mem 0x000000003f9f0000-0x000000003fdeffff] Oct 22 23:10:28.274333 kernel: node 0: [mem 0x000000003fdf0000-0x000000003fffffff] Oct 22 23:10:28.274338 kernel: node 0: [mem 0x0000000100000000-0x00000001bfffffff] Oct 22 23:10:28.274343 kernel: Initmem setup node 0 [mem 0x0000000000000000-0x00000001bfffffff] Oct 22 23:10:28.274347 kernel: On node 0, zone DMA: 36 pages in unavailable ranges Oct 22 23:10:28.274352 kernel: cma: Reserved 16 MiB at 0x000000003ce00000 on node -1 Oct 22 23:10:28.274357 kernel: psci: probing for conduit method from ACPI. Oct 22 23:10:28.274362 kernel: psci: PSCIv1.3 detected in firmware. Oct 22 23:10:28.274366 kernel: psci: Using standard PSCI v0.2 function IDs Oct 22 23:10:28.274370 kernel: psci: MIGRATE_INFO_TYPE not supported. Oct 22 23:10:28.274375 kernel: psci: SMC Calling Convention v1.4 Oct 22 23:10:28.274379 kernel: ACPI: NUMA: SRAT: PXM 0 -> MPIDR 0x0 -> Node 0 Oct 22 23:10:28.274384 kernel: ACPI: NUMA: SRAT: PXM 0 -> MPIDR 0x1 -> Node 0 Oct 22 23:10:28.274388 kernel: percpu: Embedded 34 pages/cpu s98968 r8192 d32104 u139264 Oct 22 23:10:28.274393 kernel: pcpu-alloc: s98968 r8192 d32104 u139264 alloc=34*4096 Oct 22 23:10:28.274397 kernel: pcpu-alloc: [0] 0 [0] 1 Oct 22 23:10:28.274402 kernel: Detected PIPT I-cache on CPU0 Oct 22 23:10:28.274407 kernel: CPU features: detected: Address authentication (architected QARMA5 algorithm) Oct 22 23:10:28.274412 kernel: CPU features: detected: GIC system register CPU interface Oct 22 23:10:28.274416 kernel: CPU features: detected: Spectre-v4 Oct 22 23:10:28.274421 kernel: CPU features: detected: Spectre-BHB Oct 22 23:10:28.274425 kernel: CPU features: kernel page table isolation forced ON by KASLR Oct 22 23:10:28.274430 kernel: CPU features: detected: Kernel page table isolation (KPTI) Oct 22 23:10:28.274434 kernel: CPU features: detected: ARM erratum 2067961 or 2054223 Oct 22 23:10:28.274439 kernel: CPU features: detected: Broken broadcast TLBI completion Oct 22 23:10:28.274443 kernel: CPU features: detected: SSBS not fully self-synchronizing Oct 22 23:10:28.274448 kernel: alternatives: applying boot alternatives Oct 22 23:10:28.274453 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=a4f294c2f4d3ba7f3e6f9dcc29f5bdb8ef7e69c86ff204343f35e3ac468d53d2 Oct 22 23:10:28.274459 kernel: Dentry cache hash table entries: 524288 (order: 10, 4194304 bytes, linear) Oct 22 23:10:28.274463 kernel: Inode-cache hash table entries: 262144 (order: 9, 2097152 bytes, linear) Oct 22 23:10:28.274468 kernel: Fallback order for Node 0: 0 Oct 22 23:10:28.274472 kernel: Built 1 zonelists, mobility grouping on. Total pages: 1048540 Oct 22 23:10:28.274477 kernel: Policy zone: Normal Oct 22 23:10:28.274481 kernel: mem auto-init: stack:off, heap alloc:off, heap free:off Oct 22 23:10:28.274486 kernel: software IO TLB: area num 2. Oct 22 23:10:28.274490 kernel: software IO TLB: mapped [mem 0x0000000038e00000-0x000000003ce00000] (64MB) Oct 22 23:10:28.274495 kernel: SLUB: HWalign=64, Order=0-3, MinObjects=0, CPUs=2, Nodes=1 Oct 22 23:10:28.274499 kernel: ftrace: allocating 41419 entries in 164 pages Oct 22 23:10:28.274504 kernel: ftrace: allocated 164 pages with 3 groups Oct 22 23:10:28.274509 kernel: rcu: Preemptible hierarchical RCU implementation. Oct 22 23:10:28.274514 kernel: rcu: RCU event tracing is enabled. Oct 22 23:10:28.274519 kernel: rcu: RCU restricting CPUs from NR_CPUS=512 to nr_cpu_ids=2. Oct 22 23:10:28.274523 kernel: Trampoline variant of Tasks RCU enabled. Oct 22 23:10:28.274528 kernel: Rude variant of Tasks RCU enabled. Oct 22 23:10:28.274532 kernel: Tracing variant of Tasks RCU enabled. Oct 22 23:10:28.274537 kernel: rcu: RCU calculated value of scheduler-enlistment delay is 100 jiffies. Oct 22 23:10:28.274541 kernel: rcu: Adjusting geometry for rcu_fanout_leaf=16, nr_cpu_ids=2 Oct 22 23:10:28.274546 kernel: RCU Tasks: Setting shift to 1 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=2. Oct 22 23:10:28.274551 kernel: RCU Tasks Rude: Setting shift to 1 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=2. Oct 22 23:10:28.274555 kernel: RCU Tasks Trace: Setting shift to 1 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=2. Oct 22 23:10:28.274561 kernel: NR_IRQS: 64, nr_irqs: 64, preallocated irqs: 0 Oct 22 23:10:28.274565 kernel: GICv3: 960 SPIs implemented Oct 22 23:10:28.274569 kernel: GICv3: 0 Extended SPIs implemented Oct 22 23:10:28.274574 kernel: Root IRQ handler: gic_handle_irq Oct 22 23:10:28.274578 kernel: GICv3: GICv3 features: 16 PPIs, RSS Oct 22 23:10:28.274583 kernel: GICv3: GICD_CTRL.DS=0, SCR_EL3.FIQ=0 Oct 22 23:10:28.274587 kernel: GICv3: CPU0: found redistributor 0 region 0:0x00000000effee000 Oct 22 23:10:28.274592 kernel: ITS: No ITS available, not enabling LPIs Oct 22 23:10:28.274596 kernel: rcu: srcu_init: Setting srcu_struct sizes based on contention. Oct 22 23:10:28.274601 kernel: clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1911260446275000 ns Oct 22 23:10:28.274605 kernel: arch_timer: cp15 timer(s) running at 1000.00MHz (virt). Oct 22 23:10:28.274611 kernel: clocksource: arch_sys_counter: mask: 0x1fffffffffffffff max_cycles: 0x1cd42e4dffb, max_idle_ns: 881590591483 ns Oct 22 23:10:28.274615 kernel: sched_clock: 61 bits at 1000MHz, resolution 1ns, wraps every 4398046511103ns Oct 22 23:10:28.274620 kernel: Console: colour dummy device 80x25 Oct 22 23:10:28.274625 kernel: printk: legacy console [tty1] enabled Oct 22 23:10:28.274630 kernel: ACPI: Core revision 20240827 Oct 22 23:10:28.274635 kernel: Calibrating delay loop (skipped), value calculated using timer frequency.. 2000.00 BogoMIPS (lpj=1000000) Oct 22 23:10:28.274640 kernel: pid_max: default: 32768 minimum: 301 Oct 22 23:10:28.274644 kernel: LSM: initializing lsm=lockdown,capability,landlock,selinux,ima Oct 22 23:10:28.274650 kernel: landlock: Up and running. Oct 22 23:10:28.274655 kernel: SELinux: Initializing. Oct 22 23:10:28.274659 kernel: Mount-cache hash table entries: 8192 (order: 4, 65536 bytes, linear) Oct 22 23:10:28.274664 kernel: Mountpoint-cache hash table entries: 8192 (order: 4, 65536 bytes, linear) Oct 22 23:10:28.274669 kernel: Hyper-V: privilege flags low 0x2e7f, high 0x3b8030, hints 0xa0000e, misc 0x31e1 Oct 22 23:10:28.274674 kernel: Hyper-V: Host Build 10.0.26102.3704-3-0 Oct 22 23:10:28.274678 kernel: Hyper-V: enabling crash_kexec_post_notifiers Oct 22 23:10:28.274684 kernel: rcu: Hierarchical SRCU implementation. Oct 22 23:10:28.274689 kernel: rcu: Max phase no-delay instances is 400. Oct 22 23:10:28.274694 kernel: Timer migration: 1 hierarchy levels; 8 children per group; 1 crossnode level Oct 22 23:10:28.274702 kernel: Remapping and enabling EFI services. Oct 22 23:10:28.274708 kernel: smp: Bringing up secondary CPUs ... Oct 22 23:10:28.274713 kernel: Detected PIPT I-cache on CPU1 Oct 22 23:10:28.274718 kernel: GICv3: CPU1: found redistributor 1 region 1:0x00000000f000e000 Oct 22 23:10:28.274723 kernel: CPU1: Booted secondary processor 0x0000000001 [0x410fd490] Oct 22 23:10:28.274728 kernel: smp: Brought up 1 node, 2 CPUs Oct 22 23:10:28.274733 kernel: SMP: Total of 2 processors activated. Oct 22 23:10:28.274738 kernel: CPU: All CPU(s) started at EL1 Oct 22 23:10:28.274743 kernel: CPU features: detected: 32-bit EL0 Support Oct 22 23:10:28.274748 kernel: CPU features: detected: Instruction cache invalidation not required for I/D coherence Oct 22 23:10:28.275802 kernel: CPU features: detected: Data cache clean to the PoU not required for I/D coherence Oct 22 23:10:28.275809 kernel: CPU features: detected: Common not Private translations Oct 22 23:10:28.275814 kernel: CPU features: detected: CRC32 instructions Oct 22 23:10:28.275820 kernel: CPU features: detected: Generic authentication (architected QARMA5 algorithm) Oct 22 23:10:28.275825 kernel: CPU features: detected: RCpc load-acquire (LDAPR) Oct 22 23:10:28.275830 kernel: CPU features: detected: LSE atomic instructions Oct 22 23:10:28.275835 kernel: CPU features: detected: Privileged Access Never Oct 22 23:10:28.275841 kernel: CPU features: detected: Speculation barrier (SB) Oct 22 23:10:28.275847 kernel: CPU features: detected: TLB range maintenance instructions Oct 22 23:10:28.275852 kernel: CPU features: detected: Speculative Store Bypassing Safe (SSBS) Oct 22 23:10:28.275857 kernel: CPU features: detected: Scalable Vector Extension Oct 22 23:10:28.275862 kernel: alternatives: applying system-wide alternatives Oct 22 23:10:28.275867 kernel: CPU features: detected: Hardware dirty bit management on CPU0-1 Oct 22 23:10:28.275872 kernel: SVE: maximum available vector length 16 bytes per vector Oct 22 23:10:28.275878 kernel: SVE: default vector length 16 bytes per vector Oct 22 23:10:28.275884 kernel: Memory: 3976344K/4194160K available (12544K kernel code, 2480K rwdata, 9560K rodata, 13376K init, 1040K bss, 195864K reserved, 16384K cma-reserved) Oct 22 23:10:28.275889 kernel: devtmpfs: initialized Oct 22 23:10:28.275894 kernel: futex hash table entries: 512 (order: 3, 32768 bytes, linear) Oct 22 23:10:28.275899 kernel: 2G module region forced by RANDOMIZE_MODULE_REGION_FULL Oct 22 23:10:28.275904 kernel: 0 pages in range for non-PLT usage Oct 22 23:10:28.275909 kernel: 514480 pages in range for PLT usage Oct 22 23:10:28.275914 kernel: pinctrl core: initialized pinctrl subsystem Oct 22 23:10:28.275920 kernel: SMBIOS 3.1.0 present. Oct 22 23:10:28.275926 kernel: DMI: Microsoft Corporation Virtual Machine/Virtual Machine, BIOS Hyper-V UEFI Release v4.1 04/22/2026 Oct 22 23:10:28.275931 kernel: DMI: Memory slots populated: 2/2 Oct 22 23:10:28.275936 kernel: NET: Registered PF_NETLINK/PF_ROUTE protocol family Oct 22 23:10:28.275941 kernel: DMA: preallocated 512 KiB GFP_KERNEL pool for atomic allocations Oct 22 23:10:28.275946 kernel: DMA: preallocated 512 KiB GFP_KERNEL|GFP_DMA pool for atomic allocations Oct 22 23:10:28.275951 kernel: DMA: preallocated 512 KiB GFP_KERNEL|GFP_DMA32 pool for atomic allocations Oct 22 23:10:28.275957 kernel: audit: initializing netlink subsys (disabled) Oct 22 23:10:28.275963 kernel: audit: type=2000 audit(0.059:1): state=initialized audit_enabled=0 res=1 Oct 22 23:10:28.275968 kernel: thermal_sys: Registered thermal governor 'step_wise' Oct 22 23:10:28.275973 kernel: cpuidle: using governor menu Oct 22 23:10:28.275978 kernel: hw-breakpoint: found 6 breakpoint and 4 watchpoint registers. Oct 22 23:10:28.275983 kernel: ASID allocator initialised with 32768 entries Oct 22 23:10:28.275988 kernel: acpiphp: ACPI Hot Plug PCI Controller Driver version: 0.5 Oct 22 23:10:28.275994 kernel: Serial: AMBA PL011 UART driver Oct 22 23:10:28.275999 kernel: HugeTLB: registered 1.00 GiB page size, pre-allocated 0 pages Oct 22 23:10:28.276004 kernel: HugeTLB: 0 KiB vmemmap can be freed for a 1.00 GiB page Oct 22 23:10:28.276009 kernel: HugeTLB: registered 32.0 MiB page size, pre-allocated 0 pages Oct 22 23:10:28.276014 kernel: HugeTLB: 0 KiB vmemmap can be freed for a 32.0 MiB page Oct 22 23:10:28.276019 kernel: HugeTLB: registered 2.00 MiB page size, pre-allocated 0 pages Oct 22 23:10:28.276024 kernel: HugeTLB: 0 KiB vmemmap can be freed for a 2.00 MiB page Oct 22 23:10:28.276030 kernel: HugeTLB: registered 64.0 KiB page size, pre-allocated 0 pages Oct 22 23:10:28.276035 kernel: HugeTLB: 0 KiB vmemmap can be freed for a 64.0 KiB page Oct 22 23:10:28.276040 kernel: ACPI: Added _OSI(Module Device) Oct 22 23:10:28.276045 kernel: ACPI: Added _OSI(Processor Device) Oct 22 23:10:28.276050 kernel: ACPI: Added _OSI(Processor Aggregator Device) Oct 22 23:10:28.276055 kernel: ACPI: 1 ACPI AML tables successfully acquired and loaded Oct 22 23:10:28.276060 kernel: ACPI: Interpreter enabled Oct 22 23:10:28.276066 kernel: ACPI: Using GIC for interrupt routing Oct 22 23:10:28.276071 kernel: ARMH0011:00: ttyAMA0 at MMIO 0xeffec000 (irq = 12, base_baud = 0) is a SBSA Oct 22 23:10:28.276076 kernel: printk: legacy console [ttyAMA0] enabled Oct 22 23:10:28.276081 kernel: printk: legacy bootconsole [pl11] disabled Oct 22 23:10:28.276086 kernel: ARMH0011:01: ttyAMA1 at MMIO 0xeffeb000 (irq = 13, base_baud = 0) is a SBSA Oct 22 23:10:28.276091 kernel: ACPI: CPU0 has been hot-added Oct 22 23:10:28.276096 kernel: ACPI: CPU1 has been hot-added Oct 22 23:10:28.276102 kernel: iommu: Default domain type: Translated Oct 22 23:10:28.276107 kernel: iommu: DMA domain TLB invalidation policy: strict mode Oct 22 23:10:28.276112 kernel: efivars: Registered efivars operations Oct 22 23:10:28.276117 kernel: vgaarb: loaded Oct 22 23:10:28.276122 kernel: clocksource: Switched to clocksource arch_sys_counter Oct 22 23:10:28.276127 kernel: VFS: Disk quotas dquot_6.6.0 Oct 22 23:10:28.276132 kernel: VFS: Dquot-cache hash table entries: 512 (order 0, 4096 bytes) Oct 22 23:10:28.276137 kernel: pnp: PnP ACPI init Oct 22 23:10:28.276143 kernel: pnp: PnP ACPI: found 0 devices Oct 22 23:10:28.276148 kernel: NET: Registered PF_INET protocol family Oct 22 23:10:28.276153 kernel: IP idents hash table entries: 65536 (order: 7, 524288 bytes, linear) Oct 22 23:10:28.276158 kernel: tcp_listen_portaddr_hash hash table entries: 2048 (order: 3, 32768 bytes, linear) Oct 22 23:10:28.276164 kernel: Table-perturb hash table entries: 65536 (order: 6, 262144 bytes, linear) Oct 22 23:10:28.276169 kernel: TCP established hash table entries: 32768 (order: 6, 262144 bytes, linear) Oct 22 23:10:28.276174 kernel: TCP bind hash table entries: 32768 (order: 8, 1048576 bytes, linear) Oct 22 23:10:28.276179 kernel: TCP: Hash tables configured (established 32768 bind 32768) Oct 22 23:10:28.276185 kernel: UDP hash table entries: 2048 (order: 4, 65536 bytes, linear) Oct 22 23:10:28.276190 kernel: UDP-Lite hash table entries: 2048 (order: 4, 65536 bytes, linear) Oct 22 23:10:28.276195 kernel: NET: Registered PF_UNIX/PF_LOCAL protocol family Oct 22 23:10:28.276200 kernel: PCI: CLS 0 bytes, default 64 Oct 22 23:10:28.276205 kernel: kvm [1]: HYP mode not available Oct 22 23:10:28.276210 kernel: Initialise system trusted keyrings Oct 22 23:10:28.276216 kernel: workingset: timestamp_bits=39 max_order=20 bucket_order=0 Oct 22 23:10:28.276221 kernel: Key type asymmetric registered Oct 22 23:10:28.276226 kernel: Asymmetric key parser 'x509' registered Oct 22 23:10:28.276231 kernel: Block layer SCSI generic (bsg) driver version 0.4 loaded (major 249) Oct 22 23:10:28.276236 kernel: io scheduler mq-deadline registered Oct 22 23:10:28.276241 kernel: io scheduler kyber registered Oct 22 23:10:28.276246 kernel: io scheduler bfq registered Oct 22 23:10:28.276252 kernel: Serial: 8250/16550 driver, 4 ports, IRQ sharing enabled Oct 22 23:10:28.276257 kernel: ACPI: bus type drm_connector registered Oct 22 23:10:28.276262 kernel: thunder_xcv, ver 1.0 Oct 22 23:10:28.276267 kernel: thunder_bgx, ver 1.0 Oct 22 23:10:28.276272 kernel: nicpf, ver 1.0 Oct 22 23:10:28.276277 kernel: nicvf, ver 1.0 Oct 22 23:10:28.276468 kernel: rtc-efi rtc-efi.0: registered as rtc0 Oct 22 23:10:28.276558 kernel: rtc-efi rtc-efi.0: setting system clock to 2026-10-22T23:10:23 UTC (1792710623) Oct 22 23:10:28.276565 kernel: efifb: probing for efifb Oct 22 23:10:28.276570 kernel: efifb: framebuffer at 0x40000000, using 3072k, total 3072k Oct 22 23:10:28.276575 kernel: efifb: mode is 1024x768x32, linelength=4096, pages=1 Oct 22 23:10:28.276580 kernel: efifb: scrolling: redraw Oct 22 23:10:28.276585 kernel: efifb: Truecolor: size=8:8:8:8, shift=24:16:8:0 Oct 22 23:10:28.276591 kernel: Console: switching to colour frame buffer device 128x48 Oct 22 23:10:28.276596 kernel: fb0: EFI VGA frame buffer device Oct 22 23:10:28.276601 kernel: SMCCC: SOC_ID: ARCH_SOC_ID not implemented, skipping .... Oct 22 23:10:28.276606 kernel: hid: raw HID events driver (C) Jiri Kosina Oct 22 23:10:28.276611 kernel: hw perfevents: enabled with armv8_pmuv3_0 PMU driver, 7 (0,8000003f) counters available Oct 22 23:10:28.276616 kernel: watchdog: NMI not fully supported Oct 22 23:10:28.276621 kernel: NET: Registered PF_INET6 protocol family Oct 22 23:10:28.276628 kernel: watchdog: Hard watchdog permanently disabled Oct 22 23:10:28.276633 kernel: Segment Routing with IPv6 Oct 22 23:10:28.276638 kernel: In-situ OAM (IOAM) with IPv6 Oct 22 23:10:28.276643 kernel: NET: Registered PF_PACKET protocol family Oct 22 23:10:28.276648 kernel: Key type dns_resolver registered Oct 22 23:10:28.276653 kernel: registered taskstats version 1 Oct 22 23:10:28.276657 kernel: Loading compiled-in X.509 certificates Oct 22 23:10:28.276663 kernel: Loaded X.509 cert 'Kinvolk GmbH: Module signing key for 6.12.113-flatcar: 77e0a404dfde641b3b119edc94c604689bf33008' Oct 22 23:10:28.276668 kernel: Demotion targets for Node 0: null Oct 22 23:10:28.276673 kernel: Key type .fscrypt registered Oct 22 23:10:28.276678 kernel: Key type fscrypt-provisioning registered Oct 22 23:10:28.276683 kernel: integrity: secureboot mode disabled Oct 22 23:10:28.276688 kernel: ima: No TPM chip found, activating TPM-bypass! Oct 22 23:10:28.276693 kernel: ima: Allocated hash algorithm: sha1 Oct 22 23:10:28.276698 kernel: ima: No architecture policies found Oct 22 23:10:28.276704 kernel: alg: No test for fips(ansi_cprng) (fips_ansi_cprng) Oct 22 23:10:28.276709 kernel: clk: Disabling unused clocks Oct 22 23:10:28.276714 kernel: PM: genpd: Disabling unused power domains Oct 22 23:10:28.276719 kernel: Freeing unused kernel memory: 13376K Oct 22 23:10:28.276724 kernel: Run /init as init process Oct 22 23:10:28.276729 kernel: with arguments: Oct 22 23:10:28.276734 kernel: /init Oct 22 23:10:28.276740 kernel: with environment: Oct 22 23:10:28.276745 kernel: HOME=/ Oct 22 23:10:28.276764 kernel: TERM=linux Oct 22 23:10:28.276769 kernel: hv_vmbus: hv_mmio=[mem 0x40000000-0xfed3ffff],[mem 0xfc0000000-0xfffffffff] fb=[mem 0x40000000-0x47ffffff] Oct 22 23:10:28.276774 kernel: hv_vmbus: Vmbus version:5.3 Oct 22 23:10:28.276779 kernel: pps_core: LinuxPPS API ver. 1 registered Oct 22 23:10:28.276784 kernel: pps_core: Software ver. 5.3.6 - Copyright 2005-2007 Rodolfo Giometti Oct 22 23:10:28.276791 kernel: SCSI subsystem initialized Oct 22 23:10:28.276796 kernel: PTP clock support registered Oct 22 23:10:28.276801 kernel: hv_utils: Registering HyperV Utility Driver Oct 22 23:10:28.276806 kernel: hv_vmbus: registering driver hv_utils Oct 22 23:10:28.276811 kernel: hv_utils: Shutdown IC version 3.2 Oct 22 23:10:28.276816 kernel: hv_utils: Heartbeat IC version 3.0 Oct 22 23:10:28.276820 kernel: hv_utils: TimeSync IC version 4.0 Oct 22 23:10:28.276826 kernel: hv_vmbus: registering driver hv_storvsc Oct 22 23:10:28.276959 kernel: scsi host1: storvsc_host_t Oct 22 23:10:28.277063 kernel: scsi host0: storvsc_host_t Oct 22 23:10:28.277175 kernel: scsi 0:0:0:0: Direct-Access Msft Virtual Disk 1.0 PQ: 0 ANSI: 5 Oct 22 23:10:28.277289 kernel: scsi 0:0:0:2: CD-ROM Msft Virtual DVD-ROM 1.0 PQ: 0 ANSI: 0 Oct 22 23:10:28.277393 kernel: sd 0:0:0:0: [sda] 63737856 512-byte logical blocks: (32.6 GB/30.4 GiB) Oct 22 23:10:28.277505 kernel: sd 0:0:0:0: [sda] 4096-byte physical blocks Oct 22 23:10:28.277604 kernel: sd 0:0:0:0: [sda] Write Protect is off Oct 22 23:10:28.277703 kernel: sd 0:0:0:0: [sda] Mode Sense: 0f 00 10 00 Oct 22 23:10:28.278931 kernel: sd 0:0:0:0: [sda] Write cache: disabled, read cache: enabled, supports DPO and FUA Oct 22 23:10:28.278948 kernel: sda: sda1 sda2 sda3 sda4 sda6 sda7 sda9 Oct 22 23:10:28.279056 kernel: sd 0:0:0:0: [sda] Attached SCSI disk Oct 22 23:10:28.279068 kernel: hv_vmbus: registering driver hid_hyperv Oct 22 23:10:28.279074 kernel: input: Microsoft Vmbus HID-compliant Mouse as /devices/0006:045E:0621.0001/input/input0 Oct 22 23:10:28.279173 kernel: hid-hyperv 0006:045E:0621.0001: input: VIRTUAL HID v0.01 Mouse [Microsoft Vmbus HID-compliant Mouse] on Oct 22 23:10:28.279180 kernel: hv_vmbus: registering driver hyperv_keyboard Oct 22 23:10:28.279186 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 22 23:10:28.279191 kernel: device-mapper: core: CONFIG_IMA_DISABLE_HTABLE is disabled. Duplicate IMA measurements will not be recorded in the IMA log. Oct 22 23:10:28.279198 kernel: device-mapper: uevent: version 1.0.3 Oct 22 23:10:28.279203 kernel: device-mapper: ioctl: 4.48.0-ioctl (2023-03-01) initialised: dm-devel@lists.linux.dev Oct 22 23:10:28.279306 kernel: sr 0:0:0:2: [sr0] scsi-1 drive Oct 22 23:10:28.279312 kernel: cdrom: Uniform CD-ROM driver Revision: 3.20 Oct 22 23:10:28.279410 kernel: sr 0:0:0:2: Attached scsi CD-ROM sr0 Oct 22 23:10:28.279417 kernel: device-mapper: verity: sha256 using shash "sha256-ce" Oct 22 23:10:28.279423 kernel: raid6: neonx8 gen() 18421 MB/s Oct 22 23:10:28.279428 kernel: raid6: neonx4 gen() 18547 MB/s Oct 22 23:10:28.279433 kernel: raid6: neonx2 gen() 16914 MB/s Oct 22 23:10:28.279438 kernel: raid6: neonx1 gen() 15077 MB/s Oct 22 23:10:28.279444 kernel: raid6: int64x8 gen() 8992 MB/s Oct 22 23:10:28.279449 kernel: raid6: int64x4 gen() 10757 MB/s Oct 22 23:10:28.279454 kernel: raid6: int64x2 gen() 8837 MB/s Oct 22 23:10:28.279458 kernel: raid6: int64x1 gen() 7066 MB/s Oct 22 23:10:28.279465 kernel: raid6: using algorithm neonx4 gen() 18547 MB/s Oct 22 23:10:28.279470 kernel: raid6: .... xor() 15139 MB/s, rmw enabled Oct 22 23:10:28.279475 kernel: raid6: using neon recovery algorithm Oct 22 23:10:28.279480 kernel: xor: measuring software checksum speed Oct 22 23:10:28.279485 kernel: 8regs : 29212 MB/sec Oct 22 23:10:28.279490 kernel: 32regs : 29506 MB/sec Oct 22 23:10:28.279495 kernel: arm64_neon : 33494 MB/sec Oct 22 23:10:28.279502 kernel: xor: using function: arm64_neon (33494 MB/sec) Oct 22 23:10:28.279507 kernel: Btrfs loaded, zoned=no, fsverity=no Oct 22 23:10:28.279512 kernel: BTRFS: device fsid 230079d3-281b-4070-93e9-c3be5c5385fa devid 1 transid 39 /dev/mapper/usr (254:0) scanned by mount (296) Oct 22 23:10:28.279518 kernel: BTRFS info (device dm-0): first mount of filesystem 230079d3-281b-4070-93e9-c3be5c5385fa Oct 22 23:10:28.279523 kernel: BTRFS info (device dm-0): using crc32c (crc32c-generic) checksum algorithm Oct 22 23:10:28.279528 kernel: BTRFS info (device dm-0 state E): disabling log replay at mount time Oct 22 23:10:28.279533 kernel: BTRFS info (device dm-0 state E): enabling free space tree Oct 22 23:10:28.279539 kernel: loop: module loaded Oct 22 23:10:28.279544 kernel: loop0: detected capacity change from 0 to 100192 Oct 22 23:10:28.279549 kernel: squashfs: version 4.0 (2009/01/31) Phillip Lougher Oct 22 23:10:28.279555 systemd[1]: Successfully made /usr/ read-only. Oct 22 23:10:28.279563 systemd[1]: systemd 260.4 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 22 23:10:28.279568 systemd[1]: Detected virtualization microsoft. Oct 22 23:10:28.279575 systemd[1]: Detected architecture arm64. Oct 22 23:10:28.279580 systemd[1]: Running in initrd. Oct 22 23:10:28.279586 systemd[1]: Initializing machine ID from random generator. Oct 22 23:10:28.279591 systemd[1]: No hostname configured, using default hostname. Oct 22 23:10:28.279596 systemd[1]: Hostname set to . Oct 22 23:10:28.279602 systemd[1]: Queued start job for default target initrd.target. Oct 22 23:10:28.279607 systemd[1]: Started clevis-luks-askpass.path - Forward Password Requests to Clevis Directory Watch. Oct 22 23:10:28.279614 systemd[1]: Started systemd-ask-password-console.path - Dispatch Password Requests to Console Directory Watch. Oct 22 23:10:28.279620 systemd[1]: Expecting device dev-disk-by\x2dlabel-EFI\x2dSYSTEM.device - /dev/disk/by-label/EFI-SYSTEM... Oct 22 23:10:28.279625 systemd[1]: Expecting device dev-disk-by\x2dlabel-OEM.device - /dev/disk/by-label/OEM... Oct 22 23:10:28.279631 systemd[1]: Expecting device dev-disk-by\x2dlabel-ROOT.device - /dev/disk/by-label/ROOT... Oct 22 23:10:28.279637 systemd[1]: Expecting device dev-disk-by\x2dpartlabel-USR\x2dA.device - /dev/disk/by-partlabel/USR-A... Oct 22 23:10:28.279644 systemd[1]: Expecting device dev-mapper-usr.device - /dev/mapper/usr... Oct 22 23:10:28.279649 systemd[1]: Reached target cryptsetup-pre.target - Local Encrypted Volumes (Pre). Oct 22 23:10:28.279655 systemd[1]: Reached target cryptsetup.target - Local Encrypted Volumes. Oct 22 23:10:28.279660 systemd[1]: Reached target initrd-usr-fs.target - Initrd /usr File System. Oct 22 23:10:28.279666 systemd[1]: Reached target paths.target - Path Units. Oct 22 23:10:28.279671 systemd[1]: Reached target slices.target - Slice Units. Oct 22 23:10:28.279677 systemd[1]: Reached target swap.target - Swaps. Oct 22 23:10:28.279683 systemd[1]: Reached target timers.target - Timer Units. Oct 22 23:10:28.279688 systemd[1]: Listening on iscsid.socket - Open-iSCSI iscsid Socket. Oct 22 23:10:28.279694 systemd[1]: Listening on iscsiuio.socket - Open-iSCSI iscsiuio Socket. Oct 22 23:10:28.279699 systemd[1]: Listening on systemd-coredump.socket - Process Core Dump Socket. Oct 22 23:10:28.279704 systemd[1]: Listening on systemd-journald-audit.socket - Journal Audit Socket. Oct 22 23:10:28.279710 systemd[1]: Listening on systemd-journald-dev-log.socket - Journal Socket (/dev/log). Oct 22 23:10:28.279716 systemd[1]: Listening on systemd-journald.socket - Journal Sockets. Oct 22 23:10:28.279722 systemd[1]: Listening on systemd-networkd-resolve-hook.socket - Network Management Resolve Hook Socket. Oct 22 23:10:28.279728 systemd[1]: Listening on systemd-networkd.socket - Network Management Netlink Socket. Oct 22 23:10:28.279733 systemd[1]: Listening on systemd-udevd-control.socket - udev Control Socket. Oct 22 23:10:28.279739 systemd[1]: Listening on systemd-udevd-kernel.socket - udev Kernel Socket. Oct 22 23:10:28.279769 systemd[1]: Reached target sockets.target - Socket Units. Oct 22 23:10:28.279778 systemd[1]: afterburn-network-kargs.service - Afterburn Initrd Setup Network Kernel Arguments skipped, no trigger condition checks were met. Oct 22 23:10:28.279784 systemd[1]: Starting ignition-setup-pre.service - Ignition env setup... Oct 22 23:10:28.279789 systemd[1]: Starting kmod-static-nodes.service - Create List of Static Device Nodes... Oct 22 23:10:28.279795 systemd[1]: Finished network-cleanup.service - Network Cleanup. Oct 22 23:10:28.279801 systemd[1]: systemd-battery-check.service - Early Battery Level Check skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/class/power_supply Oct 22 23:10:28.279806 systemd[1]: Starting systemd-journald.service - Journal Service... Oct 22 23:10:28.279813 systemd[1]: Starting systemd-modules-load.service - Load Kernel Modules... Oct 22 23:10:28.279839 systemd-journald[408]: Collecting audit messages is enabled. Oct 22 23:10:28.279853 systemd[1]: Starting systemd-vconsole-setup.service - Virtual Console Setup... Oct 22 23:10:28.279861 systemd-journald[408]: Journal started Oct 22 23:10:28.279874 systemd-journald[408]: Runtime Journal (/run/log/journal/8efd7fce22ae49ff99f5f00be39e211e) is 8M, max 78.3M, 70.3M free. Oct 22 23:10:28.276714 systemd-modules-load[410]: Using 2 probe threads Oct 22 23:10:28.294606 systemd[1]: Started systemd-journald.service - Journal Service. Oct 22 23:10:28.295000 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 22 23:10:28.299040 systemd[1]: Finished ignition-setup-pre.service - Ignition env setup. Oct 22 23:10:28.302000 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 22 23:10:28.307068 systemd[1]: Finished kmod-static-nodes.service - Create List of Static Device Nodes. Oct 22 23:10:28.313000 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 22 23:10:28.323910 kernel: audit: type=1130 audit(1792710628.295: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 22 23:10:28.322742 systemd[1]: Starting systemd-tmpfiles-setup-dev-early.service - Create Static Device Nodes in /dev gracefully... Oct 22 23:10:28.326568 kernel: audit: type=1130 audit(1792710628.302: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 22 23:10:28.326584 kernel: audit: type=1130 audit(1792710628.313: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 22 23:10:28.340773 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 22 23:10:28.346905 systemd[1]: Starting systemd-tmpfiles-setup.service - Create System Files and Directories... Oct 22 23:10:28.347458 systemd-modules-load[410]: Inserted module 'br_netfilter' Oct 22 23:10:28.353731 kernel: Bridge firewalling registered Oct 22 23:10:28.359001 systemd[1]: Finished systemd-modules-load.service - Load Kernel Modules. Oct 22 23:10:28.361000 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 22 23:10:28.367596 systemd[1]: Starting systemd-sysctl.service - Apply Kernel Variables... Oct 22 23:10:28.375412 kernel: audit: type=1130 audit(1792710628.361:5): 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 22 23:10:28.392559 systemd-tmpfiles[418]: /usr/lib/tmpfiles.d/systemd.conf:30: Duplicate line for path "/var/lib/systemd", ignoring. Oct 22 23:10:28.392607 systemd-tmpfiles[418]: /usr/lib/tmpfiles.d/var.conf:14: Duplicate line for path "/var/log", ignoring. Oct 22 23:10:28.403000 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 22 23:10:28.395705 systemd[1]: Finished systemd-tmpfiles-setup-dev-early.service - Create Static Device Nodes in /dev gracefully. Oct 22 23:10:28.414179 kernel: audit: type=1130 audit(1792710628.403:6): pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=systemd-tmpfiles-setup-dev-early comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Oct 22 23:10:28.402742 systemd-vconsole-setup[411]: Configuration of first virtual console was skipped, ignoring remaining ones. Oct 22 23:10:28.417000 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 22 23:10:28.411792 systemd[1]: Finished systemd-vconsole-setup.service - Virtual Console Setup. Oct 22 23:10:28.429000 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 22 23:10:28.425365 systemd[1]: Finished systemd-tmpfiles-setup.service - Create System Files and Directories. Oct 22 23:10:28.440000 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 22 23:10:28.440000 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 22 23:10:28.452172 kernel: audit: type=1130 audit(1792710628.417: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 22 23:10:28.432926 systemd[1]: systemd-sysctl.service: Deactivated successfully. Oct 22 23:10:28.453819 kernel: audit: type=1130 audit(1792710628.429:8): 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 22 23:10:28.434036 systemd[1]: Finished systemd-sysctl.service - Apply Kernel Variables. Oct 22 23:10:28.455472 kernel: audit: type=1130 audit(1792710628.440:9): pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=systemd-sysctl comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Oct 22 23:10:28.452025 systemd[1]: Starting dracut-cmdline-ask.service - dracut ask for additional cmdline parameters... Oct 22 23:10:28.457606 kernel: audit: type=1131 audit(1792710628.440:10): pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=systemd-sysctl comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Oct 22 23:10:28.461000 audit: BPF prog-id=5 op=LOAD Oct 22 23:10:28.464085 systemd[1]: Starting systemd-resolved.service - Network Name Resolution... Oct 22 23:10:28.472791 kernel: audit: type=1334 audit(1792710628.461:11): prog-id=5 op=LOAD Oct 22 23:10:28.474604 systemd[1]: Starting systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev... Oct 22 23:10:28.500003 systemd[1]: Finished systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev. Oct 22 23:10:28.504000 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 22 23:10:28.539501 systemd[1]: Finished dracut-cmdline-ask.service - dracut ask for additional cmdline parameters. Oct 22 23:10:28.545000 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 22 23:10:28.566834 systemd[1]: Starting dracut-cmdline.service - dracut cmdline hook... Oct 22 23:10:28.572481 systemd-resolved[427]: Positive Trust Anchors: Oct 22 23:10:28.572488 systemd-resolved[427]: . IN DS 20326 8 2 e06d44b80b8f1d39a95c0b0d7c65d08458e880409bbc683457104237c7f8ec8d Oct 22 23:10:28.572490 systemd-resolved[427]: . IN DS 38696 8 2 683d2d0acb8c9b712a1948b27f741219298d0a450d612c483af444a4c0fb2b16 Oct 22 23:10:28.572510 systemd-resolved[427]: 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 22 23:10:28.621654 dracut-cmdline[440]: dracut-110 Oct 22 23:10:28.621654 dracut-cmdline[440]: 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=a4f294c2f4d3ba7f3e6f9dcc29f5bdb8ef7e69c86ff204343f35e3ac468d53d2 Oct 22 23:10:28.629967 systemd-resolved[427]: Defaulting to hostname 'linux'. Oct 22 23:10:28.634977 systemd[1]: Started systemd-resolved.service - Network Name Resolution. Oct 22 23:10:28.641000 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 22 23:10:28.641896 systemd[1]: Reached target nss-lookup.target - Host and Network Name Lookups. Oct 22 23:10:28.756779 kernel: Loading iSCSI transport class v2.0-870. Oct 22 23:10:28.794970 kernel: iscsi: registered transport (tcp) Oct 22 23:10:28.822320 kernel: iscsi: registered transport (qla4xxx) Oct 22 23:10:28.822376 kernel: QLogic iSCSI HBA Driver Oct 22 23:10:28.879898 systemd[1]: Starting systemd-network-generator.service - Generate Network Units from Kernel Command Line... Oct 22 23:10:28.896256 systemd[1]: Finished systemd-network-generator.service - Generate Network Units from Kernel Command Line. Oct 22 23:10:28.897000 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 22 23:10:28.898681 systemd[1]: Reached target network-pre.target - Preparation for Network. Oct 22 23:10:28.969638 systemd[1]: Finished dracut-cmdline.service - dracut cmdline hook. Oct 22 23:10:28.969000 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 22 23:10:28.971952 systemd[1]: Starting dracut-pre-udev.service - dracut pre-udev hook... Oct 22 23:10:28.981593 systemd[1]: Starting parse-ip-for-networkd.service - Write systemd-networkd units from cmdline... Oct 22 23:10:29.010490 systemd[1]: Finished dracut-pre-udev.service - dracut pre-udev hook. Oct 22 23:10:29.014000 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 22 23:10:29.015000 audit: BPF prog-id=6 op=LOAD Oct 22 23:10:29.015000 audit: BPF prog-id=7 op=LOAD Oct 22 23:10:29.016565 systemd[1]: Starting systemd-udevd.service - Rule-based Manager for Device Events and Files... Oct 22 23:10:29.122838 systemd[1]: Finished parse-ip-for-networkd.service - Write systemd-networkd units from cmdline. Oct 22 23:10:29.124000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=parse-ip-for-networkd comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Oct 22 23:10:29.140122 systemd-udevd[672]: Using default interface naming scheme 'v260'. Oct 22 23:10:29.222391 systemd[1]: Started systemd-udevd.service - Rule-based Manager for Device Events and Files. Oct 22 23:10:29.228000 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 22 23:10:29.231841 systemd[1]: Starting dracut-pre-trigger.service - dracut pre-trigger hook... Oct 22 23:10:29.245000 audit: BPF prog-id=8 op=LOAD Oct 22 23:10:29.247061 systemd[1]: Starting systemd-networkd.service - Network Management... Oct 22 23:10:29.262557 dracut-pre-trigger[775]: rd.md=0: removing MD RAID activation Oct 22 23:10:29.279717 systemd-networkd[791]: Failed to open nftables netlink socket. IPMasquerade= and NFTSet= settings will not be applied. Ignoring: Protocol not supported Oct 22 23:10:29.288196 systemd-networkd[791]: lo: Link UP Oct 22 23:10:29.290000 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 22 23:10:29.288201 systemd-networkd[791]: lo: Gained carrier Oct 22 23:10:29.288652 systemd[1]: Started systemd-networkd.service - Network Management. Oct 22 23:10:29.290891 systemd[1]: Reached target network.target - Network. Oct 22 23:10:29.304804 systemd[1]: Finished dracut-pre-trigger.service - dracut pre-trigger hook. Oct 22 23:10:29.306000 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 22 23:10:29.308843 systemd[1]: Starting systemd-udev-trigger.service - Coldplug All udev Devices... Oct 22 23:10:29.390025 systemd[1]: Finished systemd-udev-trigger.service - Coldplug All udev Devices. Oct 22 23:10:29.395000 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 22 23:10:29.399071 systemd[1]: Starting dracut-initqueue.service - dracut initqueue hook... Oct 22 23:10:29.532091 systemd[1]: systemd-vconsole-setup.service: Deactivated successfully. Oct 22 23:10:29.532227 systemd[1]: Stopped systemd-vconsole-setup.service - Virtual Console Setup. Oct 22 23:10:29.540000 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 22 23:10:29.541258 systemd[1]: Stopping systemd-vconsole-setup.service - Virtual Console Setup... Oct 22 23:10:29.547017 kernel: hv_vmbus: registering driver hv_netvsc Oct 22 23:10:29.547126 systemd[1]: Starting systemd-vconsole-setup.service - Virtual Console Setup... Oct 22 23:10:29.559143 kernel: hv_netvsc f8615163-0000-1000-2000-000d3ac3ec1d (unnamed net_device) (uninitialized): VF slot 1 added Oct 22 23:10:29.571881 systemd-networkd[791]: eth0: Found matching .network file, based on potentially unpredictable interface name: /usr/lib/systemd/network/zz-default.network Oct 22 23:10:29.571891 systemd-networkd[791]: eth0: Configuring with /usr/lib/systemd/network/zz-default.network. Oct 22 23:10:29.577576 systemd-vconsole-setup[864]: Configuration of first virtual console was skipped, ignoring remaining ones. Oct 22 23:10:29.587000 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 22 23:10:29.577952 systemd-networkd[791]: eth0: Link UP Oct 22 23:10:29.578046 systemd-networkd[791]: eth0: Gained carrier Oct 22 23:10:29.578059 systemd-networkd[791]: eth0: Found matching .network file, based on potentially unpredictable interface name: /usr/lib/systemd/network/zz-default.network Oct 22 23:10:29.580027 systemd[1]: Finished systemd-vconsole-setup.service - Virtual Console Setup. Oct 22 23:10:29.598852 systemd-networkd[791]: eth0: DHCPv4 address 10.0.0.22/24, gateway 10.0.0.1 acquired from 168.63.129.16 Oct 22 23:10:29.626771 kernel: hv_storvsc f8b3781a-1e82-4818-a1c3-63d806ec15bb: tag#281 cmd 0x85 status: scsi 0x2 srb 0x84 hv 0xc0000185 Oct 22 23:10:30.047323 systemd[1]: Found device dev-disk-by\x2dpartlabel-USR\x2dA.device - Virtual_Disk USR-A. Oct 22 23:10:30.053742 systemd[1]: Starting disk-uuid.service - Generate new UUID for disk GPT if necessary... Oct 22 23:10:30.145890 systemd[1]: Found device dev-disk-by\x2dlabel-OEM.device - Virtual_Disk OEM. Oct 22 23:10:30.155396 systemd[1]: Mounting oem.mount - /oem... Oct 22 23:10:30.233405 systemd[1]: Found device dev-disk-by\x2dlabel-ROOT.device - Virtual_Disk ROOT. Oct 22 23:10:30.241852 kernel: BTRFS: device label OEM devid 1 transid 11 /dev/sda6 (8:6) scanned by mount (904) Oct 22 23:10:30.283134 systemd[1]: Found device dev-disk-by\x2dlabel-EFI\x2dSYSTEM.device - Virtual_Disk EFI-SYSTEM. Oct 22 23:10:30.296434 kernel: BTRFS info (device sda6): first mount of filesystem 72a875bc-6929-4d1b-85de-1b0e74cf7ff0 Oct 22 23:10:30.296455 kernel: BTRFS info (device sda6): using crc32c (crc32c-generic) checksum algorithm Oct 22 23:10:30.347241 kernel: BTRFS info (device sda6): turning on async discard Oct 22 23:10:30.347304 kernel: BTRFS info (device sda6): enabling free space tree Oct 22 23:10:30.352287 systemd[1]: Mounted oem.mount - /oem. Oct 22 23:10:30.358982 systemd[1]: Starting ignition-fetch-offline.service - Ignition (fetch-offline)... Oct 22 23:10:30.436024 systemd[1]: Finished dracut-initqueue.service - dracut initqueue hook. Oct 22 23:10:30.441000 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 22 23:10:30.442984 systemd[1]: Reached target remote-fs-pre.target - Preparation for Remote File Systems. Oct 22 23:10:30.447334 systemd[1]: Reached target remote-cryptsetup.target - Remote Encrypted Volumes. Oct 22 23:10:30.453440 systemd[1]: Reached target remote-fs.target - Remote File Systems. Oct 22 23:10:30.461001 systemd[1]: Starting dracut-pre-mount.service - dracut pre-mount hook... Oct 22 23:10:30.487479 systemd[1]: Finished dracut-pre-mount.service - dracut pre-mount hook. Oct 22 23:10:30.493000 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 22 23:10:30.657616 kernel: hv_vmbus: registering driver hv_pci Oct 22 23:10:30.657668 kernel: hv_pci 00000001-7870-47b5-b203-907d12ca697e: PCI VMBus probing: Using version 0x10004 Oct 22 23:10:30.666370 kernel: hv_pci 00000001-7870-47b5-b203-907d12ca697e: PCI host bridge to bus 7870:00 Oct 22 23:10:30.666578 kernel: pci_bus 7870:00: root bus resource [mem 0xfc0000000-0xfc2007fff window] Oct 22 23:10:30.666726 kernel: pci_bus 7870:00: No busn resource found for root bus, will use [bus 00-ff] Oct 22 23:10:30.675844 kernel: pci 7870:00:00.0: [1414:00ba] type 00 class 0x020000 PCIe Endpoint Oct 22 23:10:30.680787 kernel: pci 7870:00:00.0: BAR 0 [mem 0xfc0000000-0xfc1ffffff 64bit pref] Oct 22 23:10:30.686677 kernel: pci 7870:00:00.0: BAR 4 [mem 0xfc2000000-0xfc2007fff 64bit pref] Oct 22 23:10:30.686821 kernel: pci 7870:00:00.0: enabling Extended Tags Oct 22 23:10:30.699836 kernel: pci 7870:00:00.0: 0.000 Gb/s available PCIe bandwidth, limited by Unknown x0 link at 7870:00:00.0 (capable of 252.048 Gb/s with 16.0 GT/s PCIe x16 link) Oct 22 23:10:30.707224 kernel: pci_bus 7870:00: busn_res: [bus 00-ff] end is updated to 00 Oct 22 23:10:30.707411 kernel: pci 7870:00:00.0: BAR 0 [mem 0xfc0000000-0xfc1ffffff 64bit pref]: assigned Oct 22 23:10:30.711882 kernel: pci 7870:00:00.0: BAR 4 [mem 0xfc2000000-0xfc2007fff 64bit pref]: assigned Oct 22 23:10:30.746205 kernel: mana 7870:00:00.0: enabling device (0000 -> 0002) Oct 22 23:10:30.761727 kernel: mana 7870:00:00.0: Microsoft Azure Network Adapter protocol version: 0.1.1 Oct 22 23:10:30.761948 kernel: hv_netvsc f8615163-0000-1000-2000-000d3ac3ec1d eth0: VF registering: eth1 Oct 22 23:10:30.764565 kernel: mana 7870:00:00.0 eth1: joined to eth0 Oct 22 23:10:30.771011 systemd-networkd[791]: eth1: Interface name change detected, renamed to enP30832s1. Oct 22 23:10:30.773097 kernel: mana 7870:00:00.0 enP30832s1: renamed from eth1 Oct 22 23:10:30.866774 kernel: mana 7870:00:00.0 enP30832s1: Configured vPort 0 PD 18 DB 16 Oct 22 23:10:30.872853 kernel: mana 7870:00:00.0 enP30832s1: Configured steering vPort 0 entries 64 Oct 22 23:10:30.873112 kernel: hv_netvsc f8615163-0000-1000-2000-000d3ac3ec1d eth0: Data path switched to VF: enP30832s1 Oct 22 23:10:30.873332 systemd-networkd[791]: enP30832s1: Link UP Oct 22 23:10:30.873510 systemd-networkd[791]: enP30832s1: Gained carrier Oct 22 23:10:31.349497 disk-uuid[896]: Warning: The kernel is still using the old partition table. Oct 22 23:10:31.349497 disk-uuid[896]: The new table will be used at the next reboot or after you Oct 22 23:10:31.349497 disk-uuid[896]: run partprobe(8) or kpartx(8) Oct 22 23:10:31.349497 disk-uuid[896]: The operation has completed successfully. Oct 22 23:10:31.358722 systemd[1]: disk-uuid.service: Deactivated successfully. Oct 22 23:10:31.358871 systemd[1]: Finished disk-uuid.service - Generate new UUID for disk GPT if necessary. Oct 22 23:10:31.364000 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 22 23:10:31.364000 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 22 23:10:31.368032 systemd[1]: Mounting boot.mount - Boot partition... Oct 22 23:10:31.391932 systemd-networkd[791]: eth0: Gained IPv6LL Oct 22 23:10:31.505034 systemd[1]: Mounted boot.mount - Boot partition. Oct 22 23:10:31.590436 ignition[970]: Ignition 2.24.0 Oct 22 23:10:31.590448 ignition[970]: Stage: fetch-offline Oct 22 23:10:31.592440 ignition[970]: no config dir at "/usr/lib/ignition/base.d" Oct 22 23:10:31.599000 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 22 23:10:31.594977 systemd[1]: Finished ignition-fetch-offline.service - Ignition (fetch-offline). Oct 22 23:10:31.592450 ignition[970]: no config dir at "/usr/lib/ignition/base.platform.d/azure" Oct 22 23:10:31.602342 systemd[1]: Starting ignition-fetch.service - Ignition (fetch)... Oct 22 23:10:31.592539 ignition[970]: parsed url from cmdline: "" Oct 22 23:10:31.592541 ignition[970]: no config URL provided Oct 22 23:10:31.592545 ignition[970]: reading system config file "/usr/lib/ignition/user.ign" Oct 22 23:10:31.592569 ignition[970]: no config at "/usr/lib/ignition/user.ign" Oct 22 23:10:31.592573 ignition[970]: failed to fetch config: resource requires networking Oct 22 23:10:31.592717 ignition[970]: Ignition finished successfully Oct 22 23:10:31.630954 ignition[1025]: Ignition 2.24.0 Oct 22 23:10:31.630959 ignition[1025]: Stage: fetch Oct 22 23:10:31.631110 ignition[1025]: no config dir at "/usr/lib/ignition/base.d" Oct 22 23:10:31.631117 ignition[1025]: no config dir at "/usr/lib/ignition/base.platform.d/azure" Oct 22 23:10:31.631168 ignition[1025]: parsed url from cmdline: "" Oct 22 23:10:31.631171 ignition[1025]: no config URL provided Oct 22 23:10:31.631174 ignition[1025]: reading system config file "/usr/lib/ignition/user.ign" Oct 22 23:10:31.631181 ignition[1025]: no config at "/usr/lib/ignition/user.ign" Oct 22 23:10:31.631194 ignition[1025]: GET http://169.254.169.254/metadata/instance/compute/userData?api-version=2021-01-01&format=text: attempt #1 Oct 22 23:10:31.695549 ignition[1025]: GET result: OK Oct 22 23:10:31.695599 ignition[1025]: config has been read from IMDS userdata Oct 22 23:10:31.695607 ignition[1025]: parsing config with SHA512: 4a009105b1920c17b2a1f4d482182a6b3c5313184132a7eb183a1035cd97b4ff6e72d560065dce29becada71e36d1f807236870a336c62e016996262fa4fb8f3 Oct 22 23:10:31.698573 unknown[1025]: fetched base config from "system" Oct 22 23:10:31.706000 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 22 23:10:31.699077 ignition[1025]: fetch: fetch complete Oct 22 23:10:31.698584 unknown[1025]: fetched base config from "system" Oct 22 23:10:31.699085 ignition[1025]: fetch: fetch passed Oct 22 23:10:31.698596 unknown[1025]: fetched user config from "azure" Oct 22 23:10:31.699139 ignition[1025]: Ignition finished successfully Oct 22 23:10:31.703244 systemd[1]: Finished ignition-fetch.service - Ignition (fetch). Oct 22 23:10:31.710652 systemd[1]: Starting ignition-kargs.service - Ignition (kargs)... Oct 22 23:10:31.736977 ignition[1032]: Ignition 2.24.0 Oct 22 23:10:31.736988 ignition[1032]: Stage: kargs Oct 22 23:10:31.742000 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 22 23:10:31.740362 systemd[1]: Finished ignition-kargs.service - Ignition (kargs). Oct 22 23:10:31.737170 ignition[1032]: no config dir at "/usr/lib/ignition/base.d" Oct 22 23:10:31.746539 systemd[1]: Starting ignition-disks.service - Ignition (disks)... Oct 22 23:10:31.737177 ignition[1032]: no config dir at "/usr/lib/ignition/base.platform.d/azure" Oct 22 23:10:31.737550 ignition[1032]: kargs: kargs passed Oct 22 23:10:31.737588 ignition[1032]: Ignition finished successfully Oct 22 23:10:31.779607 systemd[1]: ignition-kargs.service: Deactivated successfully. Oct 22 23:10:31.779702 systemd[1]: Stopped ignition-kargs.service - Ignition (kargs). Oct 22 23:10:31.784000 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 22 23:10:31.786161 systemd[1]: ignition-fetch.service: Deactivated successfully. Oct 22 23:10:31.790000 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 22 23:10:31.786428 systemd[1]: Stopped ignition-fetch.service - Ignition (fetch). Oct 22 23:10:31.795000 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 22 23:10:31.790911 systemd[1]: ignition-fetch-offline.service: Deactivated successfully. Oct 22 23:10:31.791429 systemd[1]: Stopped ignition-fetch-offline.service - Ignition (fetch-offline). Oct 22 23:10:31.798989 systemd[1]: Unmounting oem.mount - /oem... Oct 22 23:10:31.821793 kernel: BTRFS info (device sda6): last unmount of filesystem 72a875bc-6929-4d1b-85de-1b0e74cf7ff0 Oct 22 23:10:31.822329 systemd[1]: oem.mount: Deactivated successfully. Oct 22 23:10:31.822459 systemd[1]: Unmounted oem.mount - /oem. Oct 22 23:10:31.844790 ignition[1043]: Ignition 2.24.0 Oct 22 23:10:31.844803 ignition[1043]: Stage: disks Oct 22 23:10:31.844971 ignition[1043]: no config dir at "/usr/lib/ignition/base.d" Oct 22 23:10:31.851000 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 22 23:10:31.848140 systemd[1]: Finished ignition-disks.service - Ignition (disks). Oct 22 23:10:31.844977 ignition[1043]: no config dir at "/usr/lib/ignition/base.platform.d/azure" Oct 22 23:10:31.853835 systemd[1]: Reached target initrd-root-device.target - Initrd Root Device. Oct 22 23:10:31.846058 ignition[1043]: disks: disks passed Oct 22 23:10:31.859668 systemd[1]: Reached target local-fs-pre.target - Preparation for Local File Systems. Oct 22 23:10:31.846168 ignition[1043]: Ignition finished successfully Oct 22 23:10:31.865761 systemd[1]: Reached target local-fs.target - Local File Systems. Oct 22 23:10:31.871197 systemd[1]: Reached target sysinit.target - System Initialization. Oct 22 23:10:31.876975 systemd[1]: Reached target basic.target - Basic System. Oct 22 23:10:31.884332 systemd[1]: Starting systemd-fsck-root.service - File System Check on /dev/disk/by-label/ROOT... Oct 22 23:10:32.018324 systemd-fsck[1052]: ROOT: clean, 15/6361680 files, 408771/6359552 blocks Oct 22 23:10:32.024743 systemd[1]: Finished systemd-fsck-root.service - File System Check on /dev/disk/by-label/ROOT. Oct 22 23:10:32.030000 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 22 23:10:32.032824 systemd[1]: Mounting sysroot.mount - /sysroot... Oct 22 23:10:32.296789 kernel: EXT4-fs (sda9): mounted filesystem 42107894-5c77-43ad-95d6-68d26fa9e47b r/w with ordered data mode. Quota mode: none. Oct 22 23:10:32.297490 systemd[1]: Mounted sysroot.mount - /sysroot. Oct 22 23:10:32.303332 systemd[1]: Reached target initrd-root-fs.target - Initrd Root File System. Oct 22 23:10:32.319634 systemd[1]: Mounting sysroot-usr.mount - /sysroot/usr... Oct 22 23:10:32.326634 systemd[1]: Starting flatcar-metadata-hostname.service - Flatcar Metadata Hostname Agent... Oct 22 23:10:32.332829 systemd[1]: ignition-remount-sysroot.service - Remount /sysroot read-write for Ignition skipped, unmet condition check ConditionPathIsReadWrite=!/sysroot Oct 22 23:10:32.332864 systemd[1]: Reached target ignition-diskful.target - Ignition Boot Disk Setup. Oct 22 23:10:32.341951 systemd[1]: Mounted sysroot-usr.mount - /sysroot/usr. Oct 22 23:10:32.346266 systemd[1]: Starting initrd-setup-root.service - Root filesystem setup... Oct 22 23:10:32.929020 systemd-tmpfiles[1087]: /sysroot/usr/lib/tmpfiles.d/base_image_var.conf:1: Duplicate line for path "/sysroot/var", ignoring. Oct 22 23:10:32.929047 systemd-tmpfiles[1087]: /sysroot/usr/lib/tmpfiles.d/base_image_var.conf:7: Duplicate line for path "/sysroot/var/empty", ignoring. Oct 22 23:10:32.929104 systemd-tmpfiles[1087]: /sysroot/usr/lib/tmpfiles.d/base_image_var.conf:28: Duplicate line for path "/sysroot/var/log", ignoring. Oct 22 23:10:33.211382 coreos-metadata[1067]: Oct 22 23:10:33.210 INFO Fetching http://168.63.129.16/?comp=versions: Attempt #1 Oct 22 23:10:33.218873 coreos-metadata[1067]: Oct 22 23:10:33.216 INFO Fetch successful Oct 22 23:10:33.218873 coreos-metadata[1067]: Oct 22 23:10:33.216 INFO Fetching http://169.254.169.254/metadata/instance/compute/name?api-version=2017-08-01&format=text: Attempt #1 Oct 22 23:10:33.230534 coreos-metadata[1067]: Oct 22 23:10:33.230 INFO Fetch successful Oct 22 23:10:33.230534 coreos-metadata[1067]: Oct 22 23:10:33.230 INFO wrote hostname ci-4757.2.1-n-5e1d953876 to /sysroot/etc/hostname Oct 22 23:10:33.235172 systemd[1]: Finished flatcar-metadata-hostname.service - Flatcar Metadata Hostname Agent. Oct 22 23:10:33.244000 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 22 23:10:34.120789 kernel: loop1: detected capacity change from 0 to 44360 Oct 22 23:10:34.163772 kernel: loop1: p1 p2 p3 Oct 22 23:10:34.443936 kernel: device-mapper: verity: sha256 using shash "sha256-ce" Oct 22 23:10:34.443989 kernel: device-mapper: verity: Unrecognized verity feature request: root_hash_sig_key_desc Oct 22 23:10:34.446118 kernel: device-mapper: table: 254:1: verity: Unrecognized verity feature request (-EINVAL) Oct 22 23:10:34.447520 kernel: device-mapper: ioctl: error adding target to table Oct 22 23:10:34.447578 systemd-confext[1146]: device-mapper: reload ioctl on loop1p1-14-verity (254:1) failed: Invalid argument Oct 22 23:10:34.471780 kernel: device-mapper: verity: sha256 using shash "sha256-ce" Oct 22 23:10:34.538776 kernel: erofs: (device dm-1): mounted with root inode @ nid 40. Oct 22 23:10:34.559780 kernel: loop2: detected capacity change from 0 to 44360 Oct 22 23:10:34.566807 kernel: loop2: p1 p2 p3 Oct 22 23:10:34.574965 kernel: device-mapper: verity: sha256 using shash "sha256-ce" Oct 22 23:10:34.575014 kernel: device-mapper: verity: Unrecognized verity feature request: root_hash_sig_key_desc Oct 22 23:10:34.577078 kernel: device-mapper: table: 254:1: verity: Unrecognized verity feature request (-EINVAL) Oct 22 23:10:34.581909 kernel: device-mapper: ioctl: error adding target to table Oct 22 23:10:34.581555 (sd-merge)[1156]: device-mapper: reload ioctl on loop2p1-18-verity (254:1) failed: Invalid argument Oct 22 23:10:34.590831 kernel: device-mapper: verity: sha256 using shash "sha256-ce" Oct 22 23:10:34.604611 (sd-merge)[1156]: Using extensions '00-flatcar-default.raw'. Oct 22 23:10:34.608391 (sd-merge)[1156]: Merged extensions into '/sysroot/etc'. Oct 22 23:10:34.614888 kernel: erofs: (device dm-1): mounted with root inode @ nid 40. Oct 22 23:10:34.615859 initrd-setup-root[1163]: /etc 00-flatcar-default Thu 2026-10-22 23:10:28 UTC Oct 22 23:10:34.619000 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 22 23:10:34.618801 systemd[1]: Finished initrd-setup-root.service - Root filesystem setup. Oct 22 23:10:34.629677 systemd[1]: Starting ignition-mount.service - Ignition (mount)... Oct 22 23:10:34.634814 kernel: kauditd_printk_skb: 29 callbacks suppressed Oct 22 23:10:34.634834 kernel: audit: type=1130 audit(1792710634.619:41): pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=initrd-setup-root comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Oct 22 23:10:34.666944 ignition[1168]: INFO : Ignition 2.24.0 Oct 22 23:10:34.666944 ignition[1168]: INFO : Stage: mount Oct 22 23:10:34.670847 ignition[1168]: INFO : no config dir at "/usr/lib/ignition/base.d" Oct 22 23:10:34.670847 ignition[1168]: INFO : no config dir at "/usr/lib/ignition/base.platform.d/azure" Oct 22 23:10:34.670847 ignition[1168]: INFO : mount: mount passed Oct 22 23:10:34.670847 ignition[1168]: INFO : Ignition finished successfully Oct 22 23:10:34.676000 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 22 23:10:34.670262 systemd[1]: Finished ignition-mount.service - Ignition (mount). Oct 22 23:10:34.701489 kernel: audit: type=1130 audit(1792710634.676:42): 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 22 23:10:34.688359 systemd[1]: Starting ignition-files.service - Ignition (files)... Oct 22 23:10:34.705928 systemd[1]: Mounting oem.mount - /oem... Oct 22 23:10:34.721772 kernel: BTRFS: device label OEM devid 1 transid 11 /dev/sda6 (8:6) scanned by mount (1175) Oct 22 23:10:34.731313 kernel: BTRFS info (device sda6): first mount of filesystem 72a875bc-6929-4d1b-85de-1b0e74cf7ff0 Oct 22 23:10:34.731361 kernel: BTRFS info (device sda6): using crc32c (crc32c-generic) checksum algorithm Oct 22 23:10:34.741794 kernel: BTRFS info (device sda6): turning on async discard Oct 22 23:10:34.741848 kernel: BTRFS info (device sda6): enabling free space tree Oct 22 23:10:34.743876 systemd[1]: Mounted oem.mount - /oem. Oct 22 23:10:34.748101 systemd[1]: Mounting sysroot-oem.mount - /sysroot/oem... Oct 22 23:10:34.764526 systemd[1]: Mounted sysroot-oem.mount - /sysroot/oem. Oct 22 23:10:34.790193 ignition[1192]: INFO : Ignition 2.24.0 Oct 22 23:10:34.792353 ignition[1192]: INFO : Stage: files Oct 22 23:10:34.792353 ignition[1192]: INFO : no config dir at "/usr/lib/ignition/base.d" Oct 22 23:10:34.792353 ignition[1192]: INFO : no config dir at "/usr/lib/ignition/base.platform.d/azure" Oct 22 23:10:34.792353 ignition[1192]: DEBUG : files: compiled without relabeling support, skipping Oct 22 23:10:34.956782 ignition[1192]: INFO : files: ensureUsers: op(1): [started] creating or modifying user "flatcar" Oct 22 23:10:34.956782 ignition[1192]: DEBUG : files: ensureUsers: op(1): executing: "useradd" "--root" "/sysroot" "--create-home" "--password" "*" "--groups" "systemd-journal,sudo" "flatcar" Oct 22 23:10:36.350028 ignition[1192]: INFO : files: ensureUsers: op(1): [finished] creating or modifying user "flatcar" Oct 22 23:10:36.356787 ignition[1192]: INFO : files: ensureUsers: op(2): [started] adding ssh keys to user "flatcar" Oct 22 23:10:36.356787 ignition[1192]: INFO : files: ensureUsers: op(2): [finished] adding ssh keys to user "flatcar" Oct 22 23:10:36.350426 unknown[1192]: wrote ssh authorized keys file for user: flatcar Oct 22 23:10:36.382406 ignition[1192]: INFO : files: createFilesystemsFiles: createFiles: op(3): [started] writing file "/sysroot/etc/flatcar/update.conf" Oct 22 23:10:36.391825 ignition[1192]: INFO : files: createFilesystemsFiles: createFiles: op(3): [finished] writing file "/sysroot/etc/flatcar/update.conf" Oct 22 23:10:36.391825 ignition[1192]: INFO : files: createFilesystemsFiles: createFiles: op(4): [started] writing file "/sysroot/etc/systemd/user/hello.service" Oct 22 23:10:36.391825 ignition[1192]: INFO : files: createFilesystemsFiles: createFiles: op(4): [finished] writing file "/sysroot/etc/systemd/user/hello.service" Oct 22 23:10:36.391825 ignition[1192]: INFO : files: createFilesystemsFiles: createFiles: op(5): [started] writing file "/sysroot/var/lib/systemd/linger/flatcar" Oct 22 23:10:36.391825 ignition[1192]: INFO : files: createFilesystemsFiles: createFiles: op(5): [finished] writing file "/sysroot/var/lib/systemd/linger/flatcar" Oct 22 23:10:36.391825 ignition[1192]: INFO : files: createFilesystemsFiles: createFiles: op(6): [started] writing link "/sysroot/etc/systemd/user/default.target.wants/hello.service" -> "/etc/systemd/user/hello.service" Oct 22 23:10:36.391825 ignition[1192]: INFO : files: createFilesystemsFiles: createFiles: op(6): [finished] writing link "/sysroot/etc/systemd/user/default.target.wants/hello.service" -> "/etc/systemd/user/hello.service" Oct 22 23:10:36.391825 ignition[1192]: INFO : files: createResultFile: createFiles: op(7): [started] writing file "/sysroot/etc/.ignition-result.json" Oct 22 23:10:36.391825 ignition[1192]: INFO : files: createResultFile: createFiles: op(7): [finished] writing file "/sysroot/etc/.ignition-result.json" Oct 22 23:10:36.391825 ignition[1192]: INFO : files: files passed Oct 22 23:10:36.391825 ignition[1192]: INFO : Ignition finished successfully Oct 22 23:10:36.392000 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 22 23:10:36.438000 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 22 23:10:36.438000 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 22 23:10:36.389872 systemd[1]: Finished ignition-files.service - Ignition (files). Oct 22 23:10:36.478793 kernel: audit: type=1130 audit(1792710636.392:43): 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 22 23:10:36.404822 systemd[1]: Starting ignition-quench.service - Ignition (record completion)... Oct 22 23:10:36.482851 kernel: audit: type=1130 audit(1792710636.438: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 22 23:10:36.422245 systemd[1]: Starting initrd-setup-root-after-ignition.service - Root filesystem completion... Oct 22 23:10:36.486839 kernel: audit: type=1131 audit(1792710636.438:45): pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=ignition-quench comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Oct 22 23:10:36.431970 systemd[1]: ignition-quench.service: Deactivated successfully. Oct 22 23:10:36.433104 systemd[1]: Finished ignition-quench.service - Ignition (record completion). Oct 22 23:10:36.499792 initrd-setup-root-after-ignition[1232]: grep: /sysroot/etc/flatcar/enabled-sysext.conf: No such file or directory Oct 22 23:10:36.502715 initrd-setup-root-after-ignition[1232]: grep: /sysroot/usr/share/flatcar/enabled-sysext.conf: No such file or directory Oct 22 23:10:36.508878 initrd-setup-root-after-ignition[1236]: grep: /sysroot/etc/flatcar/enabled-sysext.conf: No such file or directory Oct 22 23:10:36.513783 kernel: loop3: detected capacity change from 0 to 44360 Oct 22 23:10:36.523802 kernel: loop3: p1 p2 p3 Oct 22 23:10:36.535230 kernel: device-mapper: verity: sha256 using shash "sha256-ce" Oct 22 23:10:36.535261 kernel: device-mapper: verity: Unrecognized verity feature request: root_hash_sig_key_desc Oct 22 23:10:36.540722 kernel: device-mapper: table: 254:2: verity: Unrecognized verity feature request (-EINVAL) Oct 22 23:10:36.543507 kernel: device-mapper: ioctl: error adding target to table Oct 22 23:10:36.543788 systemd-confext[1238]: device-mapper: reload ioctl on loop3p1-21-verity (254:2) failed: Invalid argument Oct 22 23:10:36.551782 kernel: device-mapper: verity: sha256 using shash "sha256-ce" Oct 22 23:10:36.568794 kernel: erofs: (device dm-2): mounted with root inode @ nid 40. Oct 22 23:10:36.591783 kernel: loop4: detected capacity change from 0 to 44360 Oct 22 23:10:36.598936 kernel: loop4: p1 p2 p3 Oct 22 23:10:36.611587 kernel: device-mapper: verity: sha256 using shash "sha256-ce" Oct 22 23:10:36.611617 kernel: device-mapper: verity: Unrecognized verity feature request: root_hash_sig_key_desc Oct 22 23:10:36.616472 kernel: device-mapper: table: 254:2: verity: Unrecognized verity feature request (-EINVAL) Oct 22 23:10:36.619738 kernel: device-mapper: ioctl: error adding target to table Oct 22 23:10:36.620087 (sd-merge)[1246]: device-mapper: reload ioctl on loop4p1-25-verity (254:2) failed: Invalid argument Oct 22 23:10:36.625822 kernel: device-mapper: verity: sha256 using shash "sha256-ce" Oct 22 23:10:36.645355 (sd-merge)[1246]: Skipping extension refresh because no change was found, use --always-refresh=yes to always do a refresh. Oct 22 23:10:36.649884 kernel: erofs: (device dm-2): mounted with root inode @ nid 40. Oct 22 23:10:36.679784 kernel: loop4: detected capacity change from 0 to 172608 Oct 22 23:10:36.740294 kernel: loop4: p1 p2 p3 Oct 22 23:10:37.013119 kernel: device-mapper: verity: sha256 using shash "sha256-ce" Oct 22 23:10:37.013191 kernel: device-mapper: verity: Unrecognized verity feature request: root_hash_sig_key_desc Oct 22 23:10:37.017083 kernel: device-mapper: table: 254:2: verity: Unrecognized verity feature request (-EINVAL) Oct 22 23:10:37.019640 kernel: device-mapper: ioctl: error adding target to table Oct 22 23:10:37.019946 systemd-sysext[1254]: device-mapper: reload ioctl on loop4p1-29-verity (254:2) failed: Invalid argument Oct 22 23:10:37.026872 kernel: device-mapper: verity: sha256 using shash "sha256-ce" Oct 22 23:10:37.344823 kernel: erofs: (device dm-2): mounted with root inode @ nid 39. Oct 22 23:10:37.407774 kernel: loop5: detected capacity change from 0 to 142648 Oct 22 23:10:37.441923 kernel: loop5: p1 p2 p3 Oct 22 23:10:37.643026 kernel: device-mapper: verity: sha256 using shash "sha256-ce" Oct 22 23:10:37.643100 kernel: device-mapper: verity: Unrecognized verity feature request: root_hash_sig_key_desc Oct 22 23:10:37.644909 kernel: device-mapper: table: 254:2: verity: Unrecognized verity feature request (-EINVAL) Oct 22 23:10:37.646238 kernel: device-mapper: ioctl: error adding target to table Oct 22 23:10:37.646425 systemd-sysext[1254]: device-mapper: reload ioctl on loop5p1-33-verity (254:2) failed: Invalid argument Oct 22 23:10:37.654776 kernel: device-mapper: verity: sha256 using shash "sha256-ce" Oct 22 23:10:37.769774 kernel: erofs: (device dm-2): mounted with root inode @ nid 39. Oct 22 23:10:37.804775 kernel: loop6: detected capacity change from 0 to 364712 Oct 22 23:10:37.851789 kernel: loop6: p1 p2 p3 Oct 22 23:10:38.085998 kernel: device-mapper: verity: sha256 using shash "sha256-ce" Oct 22 23:10:38.086048 kernel: device-mapper: verity: Unrecognized verity feature request: root_hash_sig_key_desc Oct 22 23:10:38.089746 kernel: device-mapper: table: 254:2: verity: Unrecognized verity feature request (-EINVAL) Oct 22 23:10:38.092591 kernel: device-mapper: ioctl: error adding target to table Oct 22 23:10:38.092717 systemd-sysext[1254]: device-mapper: reload ioctl on loop6p1-37-verity (254:2) failed: Invalid argument Oct 22 23:10:38.104775 kernel: device-mapper: verity: sha256 using shash "sha256-ce" Oct 22 23:10:38.318771 kernel: erofs: (device dm-2): mounted with root inode @ nid 39. Oct 22 23:10:38.406788 kernel: loop7: detected capacity change from 0 to 172608 Oct 22 23:10:38.416775 kernel: loop7: p1 p2 p3 Oct 22 23:10:38.431899 kernel: device-mapper: verity: sha256 using shash "sha256-ce" Oct 22 23:10:38.432387 kernel: device-mapper: verity: Unrecognized verity feature request: root_hash_sig_key_desc Oct 22 23:10:38.432519 kernel: device-mapper: table: 254:2: verity: Unrecognized verity feature request (-EINVAL) Oct 22 23:10:38.434958 kernel: device-mapper: ioctl: error adding target to table Oct 22 23:10:38.435115 (sd-merge)[1277]: device-mapper: reload ioctl on loop7p1-41-verity (254:2) failed: Invalid argument Oct 22 23:10:38.445948 kernel: device-mapper: verity: sha256 using shash "sha256-ce" Oct 22 23:10:38.536780 kernel: erofs: (device dm-2): mounted with root inode @ nid 39. Oct 22 23:10:38.542787 kernel: loop1: detected capacity change from 0 to 142648 Oct 22 23:10:38.551779 kernel: loop1: p1 p2 p3 Oct 22 23:10:38.568259 kernel: device-mapper: verity: sha256 using shash "sha256-ce" Oct 22 23:10:38.568305 kernel: device-mapper: verity: Unrecognized verity feature request: root_hash_sig_key_desc Oct 22 23:10:38.571834 kernel: device-mapper: table: 254:3: verity: Unrecognized verity feature request (-EINVAL) Oct 22 23:10:38.574440 kernel: device-mapper: ioctl: error adding target to table Oct 22 23:10:38.575104 (sd-merge)[1277]: device-mapper: reload ioctl on loop1p1-45-verity (254:3) failed: Invalid argument Oct 22 23:10:38.584876 kernel: device-mapper: verity: sha256 using shash "sha256-ce" Oct 22 23:10:38.613782 kernel: erofs: (device dm-3): mounted with root inode @ nid 39. Oct 22 23:10:38.617776 kernel: loop3: detected capacity change from 0 to 364712 Oct 22 23:10:38.627771 kernel: loop3: p1 p2 p3 Oct 22 23:10:38.639345 kernel: device-mapper: verity: sha256 using shash "sha256-ce" Oct 22 23:10:38.639388 kernel: device-mapper: verity: Unrecognized verity feature request: root_hash_sig_key_desc Oct 22 23:10:38.642899 kernel: device-mapper: table: 254:4: verity: Unrecognized verity feature request (-EINVAL) Oct 22 23:10:38.645464 kernel: device-mapper: ioctl: error adding target to table Oct 22 23:10:38.645830 (sd-merge)[1277]: device-mapper: reload ioctl on loop3p1-49-verity (254:4) failed: Invalid argument Oct 22 23:10:38.652886 kernel: device-mapper: verity: sha256 using shash "sha256-ce" Oct 22 23:10:38.728808 kernel: erofs: (device dm-4): mounted with root inode @ nid 39. Oct 22 23:10:38.729128 (sd-merge)[1277]: Using extensions 'containerd-flatcar.raw', 'docker-flatcar.raw', 'oem-azure-4757.2.1+nightly-20261022-2100.raw'. Oct 22 23:10:38.732222 (sd-merge)[1277]: Merged extensions into '/sysroot/usr'. Oct 22 23:10:38.735708 systemd[1]: Finished initrd-setup-root-after-ignition.service - Root filesystem completion. Oct 22 23:10:38.739000 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 22 23:10:38.744341 systemd[1]: Starting initrd-parse-etc.service - Mountpoints Configured in the Real Root... Oct 22 23:10:38.750554 kernel: audit: type=1130 audit(1792710638.739:46): 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 22 23:10:38.776099 systemd[1]: initrd-parse-etc.service: Deactivated successfully. Oct 22 23:10:38.776228 systemd[1]: Finished initrd-parse-etc.service - Mountpoints Configured in the Real Root. Oct 22 23:10:38.781000 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 22 23:10:38.782574 systemd[1]: initrd-parse-etc.service: Triggering OnSuccess= dependencies. Oct 22 23:10:38.781000 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 22 23:10:38.797592 kernel: audit: type=1130 audit(1792710638.781: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 22 23:10:38.786742 systemd[1]: Reached target initrd-fs.target - Initrd File Systems. Oct 22 23:10:38.803814 kernel: audit: type=1131 audit(1792710638.781:48): pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=initrd-parse-etc comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Oct 22 23:10:38.799521 systemd[1]: Starting dracut-mount.service - dracut mount hook... Oct 22 23:10:39.197590 systemd[1]: Finished dracut-mount.service - dracut mount hook. Oct 22 23:10:39.198000 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 22 23:10:39.208756 kernel: audit: type=1130 audit(1792710639.198:49): 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 22 23:10:39.209262 systemd[1]: Starting dracut-pre-pivot.service - dracut pre-pivot and cleanup hook... Oct 22 23:10:39.234713 systemd[1]: Finished dracut-pre-pivot.service - dracut pre-pivot and cleanup hook. Oct 22 23:10:39.240000 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 22 23:10:39.242108 systemd[1]: Starting initrd-cleanup.service - Cleaning Up and Shutting Down Daemons... Oct 22 23:10:39.255013 kernel: audit: type=1130 audit(1792710639.240: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 22 23:10:39.269601 systemd[1]: Stopped target basic.target - Basic System. Oct 22 23:10:39.273890 systemd[1]: Stopped target ignition-diskful.target - Ignition Boot Disk Setup. Oct 22 23:10:39.278330 systemd[1]: Stopped target initrd-root-device.target - Initrd Root Device. Oct 22 23:10:39.283518 systemd[1]: Stopped target initrd-usr-fs.target - Initrd /usr File System. Oct 22 23:10:39.288995 systemd[1]: Stopped target nss-lookup.target - Host and Network Name Lookups. Oct 22 23:10:39.294553 systemd[1]: Stopped target paths.target - Path Units. Oct 22 23:10:39.298563 systemd[1]: Stopped target remote-cryptsetup.target - Remote Encrypted Volumes. Oct 22 23:10:39.303572 systemd[1]: Stopped target slices.target - Slice Units. Oct 22 23:10:39.309096 systemd[1]: Stopped target sockets.target - Socket Units. Oct 22 23:10:39.313302 systemd[1]: Stopped target sysinit.target - System Initialization. Oct 22 23:10:39.317849 systemd[1]: Stopped target local-fs.target - Local File Systems. Oct 22 23:10:39.322572 systemd[1]: Stopped target local-fs-pre.target - Preparation for Local File Systems. Oct 22 23:10:39.327924 systemd[1]: Stopped target swap.target - Swaps. Oct 22 23:10:39.332210 systemd[1]: Stopped target timers.target - Timer Units. Oct 22 23:10:39.335827 systemd[1]: iscsid.socket: Deactivated successfully. Oct 22 23:10:39.335975 systemd[1]: Closed iscsid.socket - Open-iSCSI iscsid Socket. Oct 22 23:10:39.340022 systemd[1]: iscsiuio.socket: Deactivated successfully. Oct 22 23:10:39.340128 systemd[1]: Closed iscsiuio.socket - Open-iSCSI iscsiuio Socket. Oct 22 23:10:39.344076 systemd[1]: systemd-coredump.socket: Deactivated successfully. Oct 22 23:10:39.358000 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 22 23:10:39.344180 systemd[1]: Closed systemd-coredump.socket - Process Core Dump Socket. Oct 22 23:10:39.348968 systemd[1]: systemd-journald-audit.socket: Deactivated successfully. Oct 22 23:10:39.349061 systemd[1]: Closed systemd-journald-audit.socket - Journal Audit Socket. Oct 22 23:10:39.377000 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 22 23:10:39.353743 systemd[1]: dracut-pre-pivot.service: Deactivated successfully. Oct 22 23:10:39.382000 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 22 23:10:39.353895 systemd[1]: Stopped dracut-pre-pivot.service - dracut pre-pivot and cleanup hook. Oct 22 23:10:39.359297 systemd[1]: Stopped target remote-fs.target - Remote File Systems. Oct 22 23:10:39.362569 systemd[1]: Stopped target remote-fs-pre.target - Preparation for Remote File Systems. Oct 22 23:10:39.373635 systemd[1]: dracut-mount.service: Deactivated successfully. Oct 22 23:10:39.373779 systemd[1]: Stopped dracut-mount.service - dracut mount hook. Oct 22 23:10:39.378122 systemd[1]: dracut-pre-mount.service: Deactivated successfully. Oct 22 23:10:39.411000 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 22 23:10:39.378237 systemd[1]: Stopped dracut-pre-mount.service - dracut pre-mount hook. Oct 22 23:10:39.417000 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 22 23:10:39.383036 systemd[1]: Stopped target cryptsetup.target - Local Encrypted Volumes. Oct 22 23:10:39.422000 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 22 23:10:39.387726 systemd[1]: systemd-ask-password-console.path: Deactivated successfully. Oct 22 23:10:39.427000 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 22 23:10:39.388123 systemd[1]: Stopped systemd-ask-password-console.path - Dispatch Password Requests to Console Directory Watch. Oct 22 23:10:39.396338 systemd[1]: Stopped target cryptsetup-pre.target - Local Encrypted Volumes (Pre). Oct 22 23:10:39.441000 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 22 23:10:39.402160 systemd[1]: clevis-luks-askpass.path: Deactivated successfully. Oct 22 23:10:39.447000 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 22 23:10:39.402483 systemd[1]: Stopped clevis-luks-askpass.path - Forward Password Requests to Clevis Directory Watch. Oct 22 23:10:39.454000 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 22 23:10:39.456000 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 22 23:10:39.407931 systemd[1]: dracut-initqueue.service: Deactivated successfully. Oct 22 23:10:39.469000 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 22 23:10:39.469000 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 22 23:10:39.408108 systemd[1]: Stopped dracut-initqueue.service - dracut initqueue hook. Oct 22 23:10:39.412795 systemd[1]: initrd-setup-root-after-ignition.service: Deactivated successfully. Oct 22 23:10:39.482192 ignition[1319]: INFO : Ignition 2.24.0 Oct 22 23:10:39.482192 ignition[1319]: INFO : Stage: umount Oct 22 23:10:39.482192 ignition[1319]: INFO : no config dir at "/usr/lib/ignition/base.d" Oct 22 23:10:39.482192 ignition[1319]: INFO : no config dir at "/usr/lib/ignition/base.platform.d/azure" Oct 22 23:10:39.482192 ignition[1319]: INFO : umount: umount passed Oct 22 23:10:39.482192 ignition[1319]: INFO : Ignition finished successfully Oct 22 23:10:39.484000 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 22 23:10:39.491000 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 22 23:10:39.496000 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 22 23:10:39.502000 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 22 23:10:39.412932 systemd[1]: Stopped initrd-setup-root-after-ignition.service - Root filesystem completion. Oct 22 23:10:39.417876 systemd[1]: ignition-files.service: Deactivated successfully. Oct 22 23:10:39.518000 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 22 23:10:39.418011 systemd[1]: Stopped ignition-files.service - Ignition (files). Oct 22 23:10:39.423131 systemd[1]: flatcar-metadata-hostname.service: Deactivated successfully. Oct 22 23:10:39.423250 systemd[1]: Stopped flatcar-metadata-hostname.service - Flatcar Metadata Hostname Agent. Oct 22 23:10:39.533000 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 22 23:10:39.430866 systemd[1]: Stopping ignition-mount.service - Ignition (mount)... Oct 22 23:10:39.536000 audit: BPF prog-id=5 op=UNLOAD Oct 22 23:10:39.540000 audit: BPF prog-id=8 op=UNLOAD Oct 22 23:10:39.435787 systemd[1]: systemd-modules-load.service: Deactivated successfully. Oct 22 23:10:39.435995 systemd[1]: Stopped systemd-modules-load.service - Load Kernel Modules. Oct 22 23:10:39.442346 systemd[1]: systemd-tmpfiles-setup.service: Deactivated successfully. Oct 22 23:10:39.442459 systemd[1]: Stopped systemd-tmpfiles-setup.service - Create System Files and Directories. Oct 22 23:10:39.563000 audit[1]: SERVICE_STOP pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=parse-ip-for-networkd comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Oct 22 23:10:39.448343 systemd[1]: systemd-udev-trigger.service: Deactivated successfully. Oct 22 23:10:39.448454 systemd[1]: Stopped systemd-udev-trigger.service - Coldplug All udev Devices. Oct 22 23:10:39.454874 systemd[1]: dracut-pre-trigger.service: Deactivated successfully. Oct 22 23:10:39.454950 systemd[1]: Stopped dracut-pre-trigger.service - dracut pre-trigger hook. Oct 22 23:10:39.461553 systemd[1]: initrd-cleanup.service: Deactivated successfully. Oct 22 23:10:39.591000 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 22 23:10:39.462788 systemd[1]: Finished initrd-cleanup.service - Cleaning Up and Shutting Down Daemons. Oct 22 23:10:39.478437 systemd[1]: ignition-mount.service: Deactivated successfully. Oct 22 23:10:39.601000 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 22 23:10:39.478627 systemd[1]: Stopped ignition-mount.service - Ignition (mount). Oct 22 23:10:39.606000 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 22 23:10:39.485129 systemd[1]: Stopped target network.target - Network. Oct 22 23:10:39.611000 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 22 23:10:39.488198 systemd[1]: ignition-disks.service: Deactivated successfully. Oct 22 23:10:39.488246 systemd[1]: Stopped ignition-disks.service - Ignition (disks). Oct 22 23:10:39.492256 systemd[1]: ignition-setup-pre.service: Deactivated successfully. Oct 22 23:10:39.629000 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 22 23:10:39.641902 kernel: kauditd_printk_skb: 26 callbacks suppressed Oct 22 23:10:39.492289 systemd[1]: Stopped ignition-setup-pre.service - Ignition env setup. Oct 22 23:10:39.642000 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 22 23:10:39.652501 kernel: audit: type=1131 audit(1792710639.629:77): 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 22 23:10:39.497357 systemd[1]: initrd-setup-root.service: Deactivated successfully. Oct 22 23:10:39.651000 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 22 23:10:39.658000 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 22 23:10:39.666507 kernel: audit: type=1131 audit(1792710639.642:78): 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 22 23:10:39.497393 systemd[1]: Stopped initrd-setup-root.service - Root filesystem setup. Oct 22 23:10:39.673000 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 22 23:10:39.679412 kernel: audit: type=1131 audit(1792710639.651:79): 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 22 23:10:39.503063 systemd[1]: Stopping systemd-networkd.service - Network Management... Oct 22 23:10:39.687852 kernel: audit: type=1131 audit(1792710639.658:80): 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 22 23:10:39.509764 systemd[1]: Stopping systemd-resolved.service - Network Name Resolution... Oct 22 23:10:39.690000 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 22 23:10:39.690000 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 22 23:10:39.701991 kernel: audit: type=1131 audit(1792710639.673:81): 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 22 23:10:39.517205 systemd[1]: systemd-networkd.service: Deactivated successfully. Oct 22 23:10:39.705458 kernel: audit: type=1130 audit(1792710639.690:82): 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 22 23:10:39.517316 systemd[1]: Stopped systemd-networkd.service - Network Management. Oct 22 23:10:39.708720 kernel: audit: type=1131 audit(1792710639.690:83): 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 22 23:10:39.527722 systemd[1]: systemd-resolved.service: Deactivated successfully. Oct 22 23:10:39.527831 systemd[1]: Stopped systemd-resolved.service - Network Name Resolution. Oct 22 23:10:39.539452 systemd[1]: systemd-networkd-resolve-hook.socket: Deactivated successfully. Oct 22 23:10:39.729829 kernel: hv_netvsc f8615163-0000-1000-2000-000d3ac3ec1d eth0: Data path switched from VF: enP30832s1 Oct 22 23:10:39.539551 systemd[1]: Closed systemd-networkd-resolve-hook.socket - Network Management Resolve Hook Socket. Oct 22 23:10:39.737702 kernel: mana 7870:00:00.0 enP30832s1: Configured steering vPort 0 entries 64 Oct 22 23:10:39.543810 systemd[1]: Stopped target network-pre.target - Preparation for Network. Oct 22 23:10:39.737000 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 22 23:10:39.548824 systemd[1]: systemd-networkd.socket: Deactivated successfully. Oct 22 23:10:39.548882 systemd[1]: Closed systemd-networkd.socket - Network Management Netlink Socket. Oct 22 23:10:39.757421 kernel: audit: type=1131 audit(1792710639.737:84): 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 22 23:10:39.557867 systemd[1]: Stopping network-cleanup.service - Network Cleanup... Oct 22 23:10:39.561915 systemd[1]: parse-ip-for-networkd.service: Deactivated successfully. Oct 22 23:10:39.561982 systemd[1]: Stopped parse-ip-for-networkd.service - Write systemd-networkd units from cmdline. Oct 22 23:10:39.566327 systemd[1]: Stopping systemd-udevd.service - Rule-based Manager for Device Events and Files... Oct 22 23:10:39.588205 systemd[1]: systemd-udevd.service: Deactivated successfully. Oct 22 23:10:39.588347 systemd[1]: Stopped systemd-udevd.service - Rule-based Manager for Device Events and Files. Oct 22 23:10:39.592168 systemd[1]: systemd-udevd-control.socket: Deactivated successfully. Oct 22 23:10:39.592208 systemd[1]: Closed systemd-udevd-control.socket - udev Control Socket. Oct 22 23:10:39.597163 systemd[1]: dracut-pre-udev.service: Deactivated successfully. Oct 22 23:10:39.597200 systemd[1]: Stopped dracut-pre-udev.service - dracut pre-udev hook. Oct 22 23:10:39.602655 systemd[1]: dracut-cmdline.service: Deactivated successfully. Oct 22 23:10:39.602691 systemd[1]: Stopped dracut-cmdline.service - dracut cmdline hook. Oct 22 23:10:39.607703 systemd[1]: dracut-cmdline-ask.service: Deactivated successfully. Oct 22 23:10:39.607745 systemd[1]: Stopped dracut-cmdline-ask.service - dracut ask for additional cmdline parameters. Oct 22 23:10:39.615734 systemd[1]: Starting initrd-udevadm-cleanup-db.service - Cleanup udev Database... Oct 22 23:10:39.622823 systemd[1]: systemd-network-generator.service: Deactivated successfully. Oct 22 23:10:39.622869 systemd[1]: Stopped systemd-network-generator.service - Generate Network Units from Kernel Command Line. Oct 22 23:10:39.639162 systemd[1]: systemd-tmpfiles-setup-dev.service: Deactivated successfully. Oct 22 23:10:39.639212 systemd[1]: Stopped systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev. Oct 22 23:10:39.642907 systemd[1]: systemd-tmpfiles-setup-dev-early.service: Deactivated successfully. Oct 22 23:10:39.642945 systemd[1]: Stopped systemd-tmpfiles-setup-dev-early.service - Create Static Device Nodes in /dev gracefully. Oct 22 23:10:39.652381 systemd[1]: kmod-static-nodes.service: Deactivated successfully. Oct 22 23:10:39.652424 systemd[1]: Stopped kmod-static-nodes.service - Create List of Static Device Nodes. Oct 22 23:10:39.659561 systemd[1]: systemd-vconsole-setup.service: Deactivated successfully. Oct 22 23:10:39.659934 systemd[1]: Stopped systemd-vconsole-setup.service - Virtual Console Setup. Oct 22 23:10:39.683281 systemd[1]: initrd-udevadm-cleanup-db.service: Deactivated successfully. Oct 22 23:10:39.846822 systemd-journald[408]: Received SIGTERM from PID 1 (systemd). Oct 22 23:10:39.683378 systemd[1]: Finished initrd-udevadm-cleanup-db.service - Cleanup udev Database. Oct 22 23:10:39.723876 systemd[1]: network-cleanup.service: Deactivated successfully. Oct 22 23:10:39.724030 systemd[1]: Stopped network-cleanup.service - Network Cleanup. Oct 22 23:10:39.738123 systemd[1]: Reached target initrd-switch-root.target - Switch Root. Oct 22 23:10:39.754807 systemd[1]: Starting initrd-switch-root.service - Switch Root... Oct 22 23:10:39.769672 systemd[1]: Switching root. Oct 22 23:10:39.861823 systemd-journald[408]: Journal stopped Oct 22 23:10:45.787808 kernel: audit: type=1335 audit(1792710639.867:85): pid=408 uid=0 auid=4294967295 tty=(none) ses=4294967295 subj=kernel comm="systemd-journal" exe="/usr/lib/systemd/systemd-journald" nl-mcgrp=1 op=disconnect res=1 Oct 22 23:10:45.787834 kernel: SELinux: policy capability network_peer_controls=1 Oct 22 23:10:45.787843 kernel: SELinux: policy capability open_perms=1 Oct 22 23:10:45.787849 kernel: SELinux: policy capability extended_socket_class=1 Oct 22 23:10:45.787854 kernel: SELinux: policy capability always_check_network=0 Oct 22 23:10:45.787860 kernel: SELinux: policy capability cgroup_seclabel=1 Oct 22 23:10:45.787867 kernel: SELinux: policy capability nnp_nosuid_transition=1 Oct 22 23:10:45.787873 kernel: SELinux: policy capability genfs_seclabel_symlinks=0 Oct 22 23:10:45.787878 kernel: SELinux: policy capability ioctl_skip_cloexec=0 Oct 22 23:10:45.787884 kernel: SELinux: policy capability userspace_initial_context=0 Oct 22 23:10:45.787889 kernel: audit: type=1403 audit(1792710640.359:86): auid=4294967295 ses=4294967295 lsm=selinux res=1 Oct 22 23:10:45.787897 systemd[1]: Successfully loaded SELinux policy in 157.353ms. Oct 22 23:10:45.787904 systemd[1]: Relabeled /dev/, /dev/shm/, /run/ in 6.101ms. Oct 22 23:10:45.787911 systemd[1]: systemd 260.4 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 22 23:10:45.787918 systemd[1]: Detected virtualization microsoft. Oct 22 23:10:45.787925 systemd[1]: Detected architecture arm64. Oct 22 23:10:45.787931 systemd[1]: Detected first boot. Oct 22 23:10:45.787938 systemd[1]: Initializing machine ID from random generator. Oct 22 23:10:45.787944 systemd[1]: Hostname set to . Oct 22 23:10:45.787952 zram_generator::config[1359]: No configuration found. Oct 22 23:10:45.787958 kernel: NET: Registered PF_VSOCK protocol family Oct 22 23:10:45.787965 systemd[1]: Applying preset policy. Oct 22 23:10:45.787971 systemd[1]: Populated /etc with preset unit settings. Oct 22 23:10:45.787977 kernel: kauditd_printk_skb: 2 callbacks suppressed Oct 22 23:10:45.787983 kernel: audit: type=1334 audit(1792710645.038:89): prog-id=10 op=LOAD Oct 22 23:10:45.787989 kernel: audit: type=1334 audit(1792710645.042:90): prog-id=2 op=UNLOAD Oct 22 23:10:45.787994 kernel: audit: type=1334 audit(1792710645.042:91): prog-id=11 op=LOAD Oct 22 23:10:45.788001 kernel: audit: type=1334 audit(1792710645.044:92): prog-id=12 op=LOAD Oct 22 23:10:45.788007 kernel: audit: type=1334 audit(1792710645.044:93): prog-id=3 op=UNLOAD Oct 22 23:10:45.788013 kernel: audit: type=1334 audit(1792710645.044:94): prog-id=4 op=UNLOAD Oct 22 23:10:45.788018 kernel: audit: type=1334 audit(1792710645.049:95): prog-id=13 op=LOAD Oct 22 23:10:45.788024 kernel: audit: type=1334 audit(1792710645.049:96): prog-id=10 op=UNLOAD Oct 22 23:10:45.788030 kernel: audit: type=1334 audit(1792710645.051:97): prog-id=14 op=LOAD Oct 22 23:10:45.788035 kernel: audit: type=1334 audit(1792710645.052:98): prog-id=15 op=LOAD Oct 22 23:10:45.788042 systemd[1]: initrd-switch-root.service: Deactivated successfully. Oct 22 23:10:45.788048 systemd[1]: Stopped initrd-switch-root.service - Switch Root. Oct 22 23:10:45.788054 systemd[1]: systemd-journald.service: Scheduled restart job, restart counter is at 1. Oct 22 23:10:45.788061 systemd[1]: Created slice system-addon\x2dconfig.slice - Slice /system/addon-config. Oct 22 23:10:45.788068 systemd[1]: Created slice system-addon\x2drun.slice - Slice /system/addon-run. Oct 22 23:10:45.788075 systemd[1]: Created slice system-getty.slice - Slice /system/getty. Oct 22 23:10:45.788083 systemd[1]: Created slice system-modprobe.slice - Slice /system/modprobe. Oct 22 23:10:45.788090 systemd[1]: Created slice system-serial\x2dgetty.slice - Slice /system/serial-getty. Oct 22 23:10:45.788096 systemd[1]: Created slice system-system\x2dcloudinit.slice - Slice /system/system-cloudinit. Oct 22 23:10:45.788103 systemd[1]: Created slice system-systemd\x2dfsck.slice - Slice /system/systemd-fsck. Oct 22 23:10:45.788109 systemd[1]: Created slice user.slice - User and Session Slice. Oct 22 23:10:45.788116 systemd[1]: Started clevis-luks-askpass.path - Forward Password Requests to Clevis Directory Watch. Oct 22 23:10:45.788123 systemd[1]: Started systemd-ask-password-console.path - Dispatch Password Requests to Console Directory Watch. Oct 22 23:10:45.788129 systemd[1]: Started systemd-ask-password-wall.path - Forward Password Requests to Wall Directory Watch. Oct 22 23:10:45.788136 systemd[1]: Set up automount boot.automount - Boot partition Automount Point. Oct 22 23:10:45.788142 systemd[1]: Set up automount proc-sys-fs-binfmt_misc.automount - Arbitrary Executable File Formats File System Automount Point. Oct 22 23:10:45.788149 systemd[1]: Expecting device dev-disk-by\x2dlabel-OEM.device - /dev/disk/by-label/OEM... Oct 22 23:10:45.788155 systemd[1]: Expecting device dev-ptp_hyperv.device - /dev/ptp_hyperv... Oct 22 23:10:45.788162 systemd[1]: Expecting device dev-ttyAMA0.device - /dev/ttyAMA0... Oct 22 23:10:45.788169 systemd[1]: Reached target cryptsetup-pre.target - Local Encrypted Volumes (Pre). Oct 22 23:10:45.788176 systemd[1]: Reached target cryptsetup.target - Local Encrypted Volumes. Oct 22 23:10:45.788182 systemd[1]: Reached target imports.target - Image Downloads. Oct 22 23:10:45.788188 systemd[1]: Stopped target initrd-switch-root.target - Switch Root. Oct 22 23:10:45.788195 systemd[1]: Stopped target initrd-fs.target - Initrd File Systems. Oct 22 23:10:45.788201 systemd[1]: Stopped target initrd-root-fs.target - Initrd Root File System. Oct 22 23:10:45.788209 systemd[1]: Reached target integritysetup.target - Local Integrity Protected Volumes. Oct 22 23:10:45.788215 systemd[1]: Reached target remote-cryptsetup.target - Remote Encrypted Volumes. Oct 22 23:10:45.788222 systemd[1]: Reached target remote-fs.target - Remote File Systems. Oct 22 23:10:45.788229 systemd[1]: Reached target remote-integritysetup.target - Remote Integrity Protected Volumes. Oct 22 23:10:45.788235 systemd[1]: Reached target remote-veritysetup.target - Remote Verity Protected Volumes. Oct 22 23:10:45.788243 systemd[1]: Reached target slices.target - Slice Units. Oct 22 23:10:45.788249 systemd[1]: Reached target swap.target - Swaps. Oct 22 23:10:45.788256 systemd[1]: Reached target veritysetup.target - Local Verity Protected Volumes. Oct 22 23:10:45.788263 systemd[1]: Listening on systemd-ask-password.socket - Query the User Interactively for a Password. Oct 22 23:10:45.788269 systemd[1]: Listening on systemd-coredump.socket - Process Core Dump Socket. Oct 22 23:10:45.788276 systemd[1]: Listening on systemd-creds.socket - Credential Encryption/Decryption. Oct 22 23:10:45.788283 systemd[1]: Listening on systemd-factory-reset.socket - Factory Reset Management. Oct 22 23:10:45.788289 systemd[1]: Listening on systemd-journald-audit.socket - Journal Audit Socket. Oct 22 23:10:45.788296 systemd[1]: Listening on systemd-mountfsd.socket - DDI File System Mounter Socket. Oct 22 23:10:45.788302 systemd[1]: Listening on systemd-mute-console.socket - Console Output Muting Service Socket. Oct 22 23:10:45.788309 systemd[1]: Listening on systemd-networkd-varlink-metrics.socket - Network Management Metrics Varlink Socket. Oct 22 23:10:45.788315 systemd[1]: Listening on systemd-networkd-varlink.socket - Network Management Varlink Socket. Oct 22 23:10:45.788323 systemd[1]: Listening on systemd-networkd.socket - Network Management Netlink Socket. Oct 22 23:10:45.788329 systemd[1]: Listening on systemd-nsresourced.socket - Namespace Resource Manager Socket. Oct 22 23:10:45.788336 systemd[1]: Listening on systemd-oomd.socket - Userspace Out-Of-Memory (OOM) Killer Socket. Oct 22 23:10:45.788342 systemd[1]: Listening on systemd-repart.socket - Disk Repartitioning Service Socket. Oct 22 23:10:45.788349 systemd[1]: Listening on systemd-resolved-monitor.socket - Resolve Monitor Varlink Socket. Oct 22 23:10:45.788355 systemd[1]: Listening on systemd-resolved-varlink.socket - Resolve Service Varlink Socket. Oct 22 23:10:45.788363 systemd[1]: Listening on systemd-udevd-control.socket - udev Control Socket. Oct 22 23:10:45.788370 systemd[1]: Listening on systemd-udevd-varlink.socket - udev Varlink Socket. Oct 22 23:10:45.788376 systemd[1]: Listening on systemd-userdbd.socket - User Database Manager Socket. Oct 22 23:10:45.788383 systemd[1]: Mounting dev-hugepages.mount - Huge Pages File System... Oct 22 23:10:45.788389 systemd[1]: Mounting dev-mqueue.mount - POSIX Message Queue File System... Oct 22 23:10:45.788395 systemd[1]: Mounting media.mount - External Media Directory... Oct 22 23:10:45.788402 systemd[1]: Mounting sys-kernel-debug.mount - Kernel Debug File System... Oct 22 23:10:45.788409 systemd[1]: Mounting sys-kernel-tracing.mount - Kernel Trace File System... Oct 22 23:10:45.788416 systemd[1]: tmp.mount: x-systemd.graceful-option=usrquota specified, but option is not available, suppressing. Oct 22 23:10:45.788422 systemd[1]: Mounting tmp.mount - Temporary Directory /tmp... Oct 22 23:10:45.788428 systemd[1]: Starting flatcar-tmpfiles.service - Create missing system files... Oct 22 23:10:45.788435 systemd[1]: ignition-delete-config.service - Ignition (delete config) skipped, no trigger condition checks were met. Oct 22 23:10:45.788441 systemd[1]: Starting kmod-static-nodes.service - Create List of Static Device Nodes... Oct 22 23:10:45.788448 systemd[1]: Starting modprobe@configfs.service - Load Kernel Module configfs... Oct 22 23:10:45.788455 systemd[1]: modprobe@drm.service - Load Kernel Module drm skipped, unmet condition check ConditionKernelModuleLoaded=!drm Oct 22 23:10:45.788493 systemd[1]: Starting modprobe@efi_pstore.service - Load Kernel Module efi_pstore... Oct 22 23:10:45.788501 systemd[1]: Starting modprobe@fuse.service - Load Kernel Module fuse... Oct 22 23:10:45.788509 systemd[1]: setup-nsswitch.service - Create /etc/nsswitch.conf skipped, unmet condition check ConditionPathExists=!/etc/nsswitch.conf Oct 22 23:10:45.788516 systemd[1]: systemd-fsck-root.service: Deactivated successfully. Oct 22 23:10:45.788522 systemd[1]: Stopped systemd-fsck-root.service - File System Check on Root Device. Oct 22 23:10:45.788529 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 22 23:10:45.788538 systemd[1]: Starting systemd-journald.service - Journal Service... Oct 22 23:10:45.788545 systemd[1]: Starting systemd-modules-load.service - Load Kernel Modules... Oct 22 23:10:45.788552 systemd[1]: Starting systemd-network-generator.service - Generate Network Units from Kernel Command Line... Oct 22 23:10:45.788577 systemd-journald[1435]: Collecting audit messages is enabled. Oct 22 23:10:45.788597 systemd-journald[1435]: Journal started Oct 22 23:10:45.788611 systemd-journald[1435]: Runtime Journal (/run/log/journal/cc4e3023c290438abad1eb974f7b4ccd) is 8M, max 78.3M, 70.3M free. Oct 22 23:10:45.432000 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 22 23:10:45.709000 audit[1]: SERVICE_STOP pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=systemd-fsck-root comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Oct 22 23:10:45.714000 audit: BPF prog-id=18 op=UNLOAD Oct 22 23:10:45.714000 audit: BPF prog-id=17 op=UNLOAD Oct 22 23:10:45.714000 audit: BPF prog-id=19 op=LOAD Oct 22 23:10:45.714000 audit: BPF prog-id=20 op=LOAD Oct 22 23:10:45.714000 audit: BPF prog-id=21 op=LOAD Oct 22 23:10:45.785000 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 22 23:10:45.785000 audit[1435]: SYSCALL arch=c00000b7 syscall=211 success=yes exit=60 a0=3 a1=ffffcfab0270 a2=4000 a3=0 items=0 ppid=1 pid=1435 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 22 23:10:45.785000 audit: PROCTITLE proctitle="/usr/lib/systemd/systemd-journald" Oct 22 23:10:45.029113 systemd[1]: Queued start job for default target multi-user.target. Oct 22 23:10:45.058414 systemd[1]: Unnecessary job was removed for dev-sda6.device - /dev/sda6. Oct 22 23:10:45.058893 systemd[1]: systemd-journald.service: Deactivated successfully. Oct 22 23:10:45.101621 systemd[1]: systemd-journald.service: Consumed 1.307s CPU time over 16.816s wall clock time. Oct 22 23:10:45.802326 systemd[1]: Reached target time-set.target - System Time Set. Oct 22 23:10:45.815017 systemd[1]: Starting systemd-remount-fs.service - Remount Root and Kernel File Systems... Oct 22 23:10:45.815069 kernel: fuse: init (API version 7.41) Oct 22 23:10:45.834497 systemd[1]: Starting systemd-udev-load-credentials.service - Load udev Rules from Credentials... Oct 22 23:10:45.832874 systemd-modules-load[1437]: Using 2 probe threads Oct 22 23:10:45.848867 systemd[1]: Starting systemd-udev-trigger.service - Coldplug All udev Devices... Oct 22 23:10:45.848936 systemd[1]: Started systemd-journald.service - Journal Service. Oct 22 23:10:45.853000 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 22 23:10:45.856638 systemd[1]: Mounted dev-hugepages.mount - Huge Pages File System. Oct 22 23:10:45.858576 systemd[1]: Mounted dev-mqueue.mount - POSIX Message Queue File System. Oct 22 23:10:45.861006 systemd[1]: Mounted media.mount - External Media Directory. Oct 22 23:10:45.865937 systemd[1]: Mounted sys-kernel-debug.mount - Kernel Debug File System. Oct 22 23:10:45.869000 systemd[1]: Mounted sys-kernel-tracing.mount - Kernel Trace File System. Oct 22 23:10:45.873031 systemd[1]: Mounted tmp.mount - Temporary Directory /tmp. Oct 22 23:10:45.878821 systemd[1]: Finished kmod-static-nodes.service - Create List of Static Device Nodes. Oct 22 23:10:45.882000 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 22 23:10:45.883969 systemd[1]: modprobe@configfs.service: Deactivated successfully. Oct 22 23:10:45.884122 systemd[1]: Finished modprobe@configfs.service - Load Kernel Module configfs. Oct 22 23:10:45.886000 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 22 23:10:45.886000 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 22 23:10:45.887439 systemd[1]: modprobe@efi_pstore.service: Deactivated successfully. Oct 22 23:10:45.888802 systemd[1]: Finished modprobe@efi_pstore.service - Load Kernel Module efi_pstore. Oct 22 23:10:45.893000 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 22 23:10:45.893000 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 22 23:10:45.894089 systemd[1]: modprobe@fuse.service: Deactivated successfully. Oct 22 23:10:45.894261 systemd[1]: Finished modprobe@fuse.service - Load Kernel Module fuse. Oct 22 23:10:45.895000 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 22 23:10:45.895000 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 22 23:10:45.896375 systemd[1]: Finished systemd-modules-load.service - Load Kernel Modules. Oct 22 23:10:45.897000 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 22 23:10:45.899842 systemd[1]: Finished systemd-network-generator.service - Generate Network Units from Kernel Command Line. Oct 22 23:10:45.901000 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 22 23:10:45.903273 systemd[1]: Finished systemd-remount-fs.service - Remount Root and Kernel File Systems. Oct 22 23:10:45.909000 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 22 23:10:45.915979 systemd[1]: Reached target network-pre.target - Preparation for Network. Oct 22 23:10:45.920657 systemd[1]: Listening on systemd-networkd-resolve-hook.socket - Network Management Resolve Hook Socket. Oct 22 23:10:45.924799 systemd[1]: Mounting sys-fs-fuse-connections.mount - FUSE Control File System... Oct 22 23:10:45.930878 systemd[1]: Mounting sys-kernel-config.mount - Kernel Configuration File System... Oct 22 23:10:45.933872 systemd[1]: remount-root.service - Remount Root File System skipped, unmet condition check ConditionPathIsReadWrite=!/ Oct 22 23:10:45.950711 systemd[1]: Starting systemd-hwdb-update.service - Rebuild Hardware Database... Oct 22 23:10:45.957916 systemd[1]: Starting systemd-journal-flush.service - Flush Journal to Persistent Storage... Oct 22 23:10:45.959816 systemd[1]: systemd-pstore.service - Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore Oct 22 23:10:45.961766 systemd[1]: Starting systemd-random-seed.service - Load/Save OS Random Seed... Oct 22 23:10:45.967941 systemd[1]: Starting systemd-sysctl.service - Apply Kernel Variables... Oct 22 23:10:45.974995 systemd[1]: Starting systemd-tmpfiles-setup-dev-early.service - Create Static Device Nodes in /dev gracefully... Oct 22 23:10:45.981664 systemd[1]: Finished flatcar-tmpfiles.service - Create missing system files. Oct 22 23:10:45.986000 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 22 23:10:45.989840 systemd[1]: Finished systemd-udev-load-credentials.service - Load udev Rules from Credentials. Oct 22 23:10:45.995000 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 22 23:10:45.996991 systemd[1]: Mounted sys-fs-fuse-connections.mount - FUSE Control File System. Oct 22 23:10:46.001043 systemd[1]: Mounted sys-kernel-config.mount - Kernel Configuration File System. Oct 22 23:10:46.019266 systemd[1]: Finished systemd-random-seed.service - Load/Save OS Random Seed. Oct 22 23:10:46.022647 systemd-journald[1435]: Time spent on flushing to /var/log/journal/cc4e3023c290438abad1eb974f7b4ccd is 12.299ms for 1138 entries. Oct 22 23:10:46.022647 systemd-journald[1435]: System Journal (/var/log/journal/cc4e3023c290438abad1eb974f7b4ccd) is 8M, max 2.2G, 2.2G free. Oct 22 23:10:46.024000 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 22 23:10:46.057000 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 22 23:10:46.025707 systemd[1]: Reached target first-boot-complete.target - First Boot Complete. Oct 22 23:10:46.163206 systemd-journald[1435]: Received client request to flush runtime journal. Oct 22 23:10:46.056220 systemd[1]: Finished systemd-udev-trigger.service - Coldplug All udev Devices. Oct 22 23:10:46.164465 systemd[1]: Finished systemd-journal-flush.service - Flush Journal to Persistent Storage. Oct 22 23:10:46.165000 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 22 23:10:46.174192 systemd[1]: Finished systemd-sysctl.service - Apply Kernel Variables. Oct 22 23:10:46.175000 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 22 23:10:46.234619 systemd-tmpfiles[1487]: ACLs are not supported, ignoring. Oct 22 23:10:46.234633 systemd-tmpfiles[1487]: ACLs are not supported, ignoring. Oct 22 23:10:46.237880 systemd[1]: Finished systemd-tmpfiles-setup-dev-early.service - Create Static Device Nodes in /dev gracefully. Oct 22 23:10:46.239000 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 22 23:10:46.242994 systemd[1]: Starting systemd-sysusers.service - Create System Users... Oct 22 23:10:46.410168 systemd[1]: Finished systemd-sysusers.service - Create System Users. Oct 22 23:10:46.411000 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 22 23:10:46.414669 systemd[1]: Starting systemd-journalctl.socket - Journal Log Access Socket... Oct 22 23:10:46.420000 audit: BPF prog-id=22 op=LOAD Oct 22 23:10:46.421000 audit: BPF prog-id=23 op=LOAD Oct 22 23:10:46.421000 audit: BPF prog-id=24 op=LOAD Oct 22 23:10:46.424908 systemd[1]: Starting systemd-oomd.service - Userspace Out-Of-Memory (OOM) Killer... Oct 22 23:10:46.426000 audit: BPF prog-id=25 op=LOAD Oct 22 23:10:46.429681 systemd[1]: Starting systemd-resolved.service - Network Name Resolution... Oct 22 23:10:46.433334 systemd[1]: Starting systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev... Oct 22 23:10:46.437362 systemd[1]: Listening on systemd-journalctl.socket - Journal Log Access Socket. Oct 22 23:10:46.446976 systemd[1]: Starting modprobe@tun.service - Load Kernel Module tun... Oct 22 23:10:46.451000 audit: BPF prog-id=26 op=LOAD Oct 22 23:10:46.451000 audit: BPF prog-id=27 op=LOAD Oct 22 23:10:46.451000 audit: BPF prog-id=28 op=LOAD Oct 22 23:10:46.453971 systemd[1]: Starting systemd-userdbd.service - User Database Manager... Oct 22 23:10:46.461668 systemd-tmpfiles[1505]: ACLs are not supported, ignoring. Oct 22 23:10:46.461684 systemd-tmpfiles[1505]: ACLs are not supported, ignoring. Oct 22 23:10:46.467221 systemd[1]: Finished systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev. Oct 22 23:10:46.472000 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 22 23:10:46.473781 systemd[1]: proc-sys-fs-binfmt_misc.automount: Got automount request for /proc/sys/fs/binfmt_misc, triggered by 1507 ((systemd-userd)) Oct 22 23:10:46.474042 systemd[1]: Reached target local-fs-pre.target - Preparation for Local File Systems. Oct 22 23:10:46.476281 systemd[1]: systemd-repart.service - Repartition Root Disk skipped, no trigger condition checks were met. Oct 22 23:10:46.682777 kernel: tun: Universal TUN/TAP device driver, 1.6 Oct 22 23:10:46.682998 systemd[1]: modprobe@tun.service: Deactivated successfully. Oct 22 23:10:46.683198 systemd[1]: Finished modprobe@tun.service - Load Kernel Module tun. Oct 22 23:10:46.689000 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 22 23:10:46.689000 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 22 23:10:46.690000 audit: BPF prog-id=29 op=LOAD Oct 22 23:10:46.690000 audit: BPF prog-id=30 op=LOAD Oct 22 23:10:46.690000 audit: BPF prog-id=31 op=LOAD Oct 22 23:10:46.691897 systemd[1]: Starting systemd-nsresourced.service - Namespace Resource Manager... Oct 22 23:10:47.101440 systemd[1]: Finished systemd-hwdb-update.service - Rebuild Hardware Database. Oct 22 23:10:47.104000 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 22 23:10:47.107483 systemd[1]: Mounting proc-sys-fs-binfmt_misc.mount - Arbitrary Executable File Formats File System... Oct 22 23:10:47.110843 systemd[1]: var-lib-machines.mount - Virtual Machine and Container Storage (Compatibility) skipped, unmet condition check ConditionPathExists=/var/lib/machines.raw Oct 22 23:10:47.110886 systemd[1]: Reached target local-fs.target - Local File Systems. Oct 22 23:10:47.112558 systemd[1]: Reached target machines.target - Virtual Machines and Containers. Oct 22 23:10:47.115366 systemd[1]: Listening on systemd-importd.socket - Disk Image Download Service Socket. Oct 22 23:10:47.118083 systemd[1]: Listening on systemd-sysext.socket - System Extension Image Management. Oct 22 23:10:47.127900 systemd[1]: Starting systemd-confext.service - Merge System Configuration Images into /etc/... Oct 22 23:10:47.134900 systemd[1]: Starting systemd-machine-id-commit.service - Save Transient machine-id to Disk... Oct 22 23:10:47.138000 audit: BPF prog-id=7 op=UNLOAD Oct 22 23:10:47.138000 audit: BPF prog-id=6 op=UNLOAD Oct 22 23:10:47.138000 audit: BPF prog-id=32 op=LOAD Oct 22 23:10:47.138000 audit: BPF prog-id=33 op=LOAD Oct 22 23:10:47.140911 systemd[1]: Starting systemd-udevd.service - Rule-based Manager for Device Events and Files... Oct 22 23:10:47.150018 systemd[1]: Starting systemd-userdb-load-credentials.service - Load JSON user/group Records from Credentials... Oct 22 23:10:47.163356 systemd[1]: Mounted proc-sys-fs-binfmt_misc.mount - Arbitrary Executable File Formats File System. Oct 22 23:10:47.171976 systemd[1]: systemd-binfmt.service - Set Up Additional Binary Formats skipped, no trigger condition checks were met. Oct 22 23:10:47.204558 systemd[1]: Finished systemd-userdb-load-credentials.service - Load JSON user/group Records from Credentials. Oct 22 23:10:47.207000 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 22 23:10:47.210509 systemd[1]: Started systemd-userdbd.service - User Database Manager. Oct 22 23:10:47.213000 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 22 23:10:47.245000 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 22 23:10:47.264351 kernel: loop4: detected capacity change from 0 to 44360 Oct 22 23:10:47.243068 systemd-nsresourced[1510]: Not setting up BPF subsystem, as functionality has been disabled at compile time. Oct 22 23:10:47.244336 systemd[1]: Started systemd-nsresourced.service - Namespace Resource Manager. Oct 22 23:10:47.266776 kernel: loop4: p1 p2 p3 Oct 22 23:10:47.328906 systemd-oomd[1503]: No swap; memory pressure usage will be degraded Oct 22 23:10:47.330000 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 22 23:10:47.329560 systemd[1]: Started systemd-oomd.service - Userspace Out-Of-Memory (OOM) Killer. Oct 22 23:10:47.349505 kernel: device-mapper: verity: sha256 using shash "sha256-ce" Oct 22 23:10:47.349443 systemd-resolved[1504]: Positive Trust Anchors: Oct 22 23:10:47.349939 kernel: device-mapper: verity: Unrecognized verity feature request: root_hash_sig_key_desc Oct 22 23:10:47.349451 systemd-resolved[1504]: . IN DS 20326 8 2 e06d44b80b8f1d39a95c0b0d7c65d08458e880409bbc683457104237c7f8ec8d Oct 22 23:10:47.349453 systemd-resolved[1504]: . IN DS 38696 8 2 683d2d0acb8c9b712a1948b27f741219298d0a450d612c483af444a4c0fb2b16 Oct 22 23:10:47.349476 systemd-resolved[1504]: 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 22 23:10:47.353709 kernel: device-mapper: table: 254:5: verity: Unrecognized verity feature request (-EINVAL) Oct 22 23:10:47.356439 kernel: device-mapper: ioctl: error adding target to table Oct 22 23:10:47.356528 systemd-confext[1519]: device-mapper: reload ioctl on loop4p1-53-verity (254:5) failed: Invalid argument Oct 22 23:10:47.362777 kernel: device-mapper: verity: sha256 using shash "sha256-ce" Oct 22 23:10:47.397639 systemd-resolved[1504]: Using system hostname 'ci-4757.2.1-n-5e1d953876'. Oct 22 23:10:47.399125 systemd[1]: Started systemd-resolved.service - Network Name Resolution. Oct 22 23:10:47.400000 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 22 23:10:47.401129 systemd[1]: Reached target nss-lookup.target - Host and Network Name Lookups. Oct 22 23:10:47.432073 systemd[1]: Finished systemd-machine-id-commit.service - Save Transient machine-id to Disk. Oct 22 23:10:47.434902 systemd-udevd[1517]: Using default interface naming scheme 'v260'. Oct 22 23:10:47.435000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=systemd-machine-id-commit comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Oct 22 23:10:47.642106 systemd[1]: Started systemd-udevd.service - Rule-based Manager for Device Events and Files. Oct 22 23:10:47.644000 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 22 23:10:47.645000 audit: BPF prog-id=34 op=LOAD Oct 22 23:10:47.648917 systemd[1]: Starting systemd-networkd.service - Network Management... Oct 22 23:10:47.773282 systemd[1]: Condition check resulted in dev-ttyAMA0.device - /dev/ttyAMA0 being skipped. Oct 22 23:10:47.867783 kernel: mousedev: PS/2 mouse device common for all mice Oct 22 23:10:47.895477 kernel: hv_vmbus: registering driver hv_balloon Oct 22 23:10:47.895558 kernel: hv_balloon: Using Dynamic Memory protocol version 2.0 Oct 22 23:10:47.898309 kernel: hv_balloon: Memory hot add disabled on ARM64 Oct 22 23:10:47.908021 systemd-networkd[1541]: lo: Link UP Oct 22 23:10:47.908027 systemd-networkd[1541]: lo: Gained carrier Oct 22 23:10:47.909877 systemd[1]: Started systemd-networkd.service - Network Management. Oct 22 23:10:47.913871 systemd-networkd[1541]: eth0: Found matching .network file, based on potentially unpredictable interface name: /usr/lib/systemd/network/zz-default.network Oct 22 23:10:47.913874 systemd-networkd[1541]: eth0: Configuring with /usr/lib/systemd/network/zz-default.network. Oct 22 23:10:47.917000 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 22 23:10:47.918130 systemd[1]: Reached target network.target - Network. Oct 22 23:10:47.921782 kernel: mana 7870:00:00.0 enP30832s1: Configured vPort 0 PD 18 DB 16 Oct 22 23:10:47.925900 systemd[1]: Starting systemd-networkd-persistent-storage.service - Enable Persistent Storage in systemd-networkd... Oct 22 23:10:47.939148 kernel: hv_vmbus: registering driver hyperv_fb Oct 22 23:10:47.935373 systemd[1]: Starting systemd-networkd-wait-online.service - Wait for Network to be Online... Oct 22 23:10:47.939286 kernel: mana 7870:00:00.0 enP30832s1: Configured steering vPort 0 entries 64 Oct 22 23:10:47.950832 kernel: hyperv_fb: Synthvid Version major 3, minor 5 Oct 22 23:10:47.951396 kernel: hv_netvsc f8615163-0000-1000-2000-000d3ac3ec1d eth0: Data path switched to VF: enP30832s1 Oct 22 23:10:47.952829 kernel: hyperv_fb: Screen resolution: 1024x768, Color depth: 32, Frame buffer size: 8388608 Oct 22 23:10:47.953464 systemd-networkd[1541]: enP30832s1: Link UP Oct 22 23:10:47.953675 systemd-networkd[1541]: eth0: Link UP Oct 22 23:10:47.953935 kernel: Console: switching to colour dummy device 80x25 Oct 22 23:10:47.954390 systemd-networkd[1541]: eth0: Gained carrier Oct 22 23:10:47.954958 systemd-networkd[1541]: eth0: Found matching .network file, based on potentially unpredictable interface name: /usr/lib/systemd/network/zz-default.network Oct 22 23:10:47.955590 systemd[1]: Condition check resulted in dev-ptp_hyperv.device - /dev/ptp_hyperv being skipped. Oct 22 23:10:47.958638 kernel: Console: switching to colour frame buffer device 128x48 Oct 22 23:10:47.959988 systemd-networkd[1541]: enP30832s1: Gained carrier Oct 22 23:10:47.968869 systemd-networkd[1541]: eth0: DHCPv4 address 10.0.0.22/24, gateway 10.0.0.1 acquired from 168.63.129.16 Oct 22 23:10:47.985975 systemd[1]: Starting systemd-vconsole-setup.service - Virtual Console Setup... Oct 22 23:10:48.002808 kernel: hv_storvsc f8b3781a-1e82-4818-a1c3-63d806ec15bb: tag#160 cmd 0x85 status: scsi 0x2 srb 0x84 hv 0xc0000185 Oct 22 23:10:48.004063 systemd[1]: Finished systemd-networkd-persistent-storage.service - Enable Persistent Storage in systemd-networkd. Oct 22 23:10:48.008000 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 22 23:10:48.064438 kernel: erofs: (device dm-5): mounted with root inode @ nid 40. Oct 22 23:10:48.082513 systemd[1]: systemd-vconsole-setup.service: Deactivated successfully. Oct 22 23:10:48.083345 systemd[1]: Stopped systemd-vconsole-setup.service - Virtual Console Setup. Oct 22 23:10:48.086000 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 22 23:10:48.086000 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 22 23:10:48.093773 kernel: loop4: detected capacity change from 0 to 44360 Oct 22 23:10:48.096912 systemd[1]: Starting systemd-vconsole-setup.service - Virtual Console Setup... Oct 22 23:10:48.105957 kernel: loop4: p1 p2 p3 Oct 22 23:10:48.106592 systemd[1]: etc-machine\x2did.mount: Deactivated successfully. Oct 22 23:10:48.117175 kernel: device-mapper: verity: sha256 using shash "sha256-ce" Oct 22 23:10:48.117259 kernel: device-mapper: verity: Unrecognized verity feature request: root_hash_sig_key_desc Oct 22 23:10:48.120507 kernel: device-mapper: table: 254:5: verity: Unrecognized verity feature request (-EINVAL) Oct 22 23:10:48.122948 kernel: device-mapper: ioctl: error adding target to table Oct 22 23:10:48.124206 (sd-merge)[1620]: device-mapper: reload ioctl on loop4p1-58-verity (254:5) failed: Invalid argument Oct 22 23:10:48.129781 kernel: device-mapper: verity: sha256 using shash "sha256-ce" Oct 22 23:10:48.168238 (sd-merge)[1620]: Skipping extension refresh because no change was found, use --always-refresh=yes to always do a refresh. Oct 22 23:10:48.168776 kernel: erofs: (device dm-5): mounted with root inode @ nid 40. Oct 22 23:10:48.179074 systemd[1]: Finished systemd-confext.service - Merge System Configuration Images into /etc/. Oct 22 23:10:48.185000 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 22 23:10:48.189456 systemd[1]: Starting systemd-sysext.service - Merge System Extension Images into /usr/ and /opt/... Oct 22 23:10:48.213919 systemd[1]: Found device dev-disk-by\x2dlabel-OEM.device - Virtual_Disk OEM. Oct 22 23:10:48.219848 kernel: loop4: detected capacity change from 0 to 364712 Oct 22 23:10:48.221612 systemd[1]: Starting systemd-fsck@dev-disk-by\x2dlabel-OEM.service - File System Check on /dev/disk/by-label/OEM... Oct 22 23:10:48.233835 kernel: loop4: p1 p2 p3 Oct 22 23:10:48.252293 kernel: device-mapper: verity: sha256 using shash "sha256-ce" Oct 22 23:10:48.252379 kernel: device-mapper: verity: Unrecognized verity feature request: root_hash_sig_key_desc Oct 22 23:10:48.254261 kernel: device-mapper: table: 254:5: verity: Unrecognized verity feature request (-EINVAL) Oct 22 23:10:48.255626 kernel: device-mapper: ioctl: error adding target to table Oct 22 23:10:48.255713 systemd-sysext[1659]: device-mapper: reload ioctl on loop4p1-62-verity (254:5) failed: Invalid argument Oct 22 23:10:48.261776 kernel: device-mapper: verity: sha256 using shash "sha256-ce" Oct 22 23:10:48.284390 systemd[1]: Finished systemd-fsck@dev-disk-by\x2dlabel-OEM.service - File System Check on /dev/disk/by-label/OEM. Oct 22 23:10:48.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 22 23:10:48.522019 kernel: erofs: (device dm-5): mounted with root inode @ nid 39. Oct 22 23:10:48.545807 kernel: loop4: detected capacity change from 0 to 172608 Oct 22 23:10:48.554774 kernel: loop4: p1 p2 p3 Oct 22 23:10:48.569664 systemd-vconsole-setup[1623]: Configuration of first virtual console was skipped, ignoring remaining ones. Oct 22 23:10:48.570965 kernel: device-mapper: verity: sha256 using shash "sha256-ce" Oct 22 23:10:48.571018 kernel: device-mapper: verity: Unrecognized verity feature request: root_hash_sig_key_desc Oct 22 23:10:48.573640 kernel: device-mapper: table: 254:5: verity: Unrecognized verity feature request (-EINVAL) Oct 22 23:10:48.575554 kernel: device-mapper: ioctl: error adding target to table Oct 22 23:10:48.575478 systemd[1]: Finished systemd-vconsole-setup.service - Virtual Console Setup. Oct 22 23:10:48.575715 systemd-sysext[1659]: device-mapper: reload ioctl on loop4p1-67-verity (254:5) failed: Invalid argument Oct 22 23:10:48.579000 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 22 23:10:48.584967 kernel: device-mapper: verity: sha256 using shash "sha256-ce" Oct 22 23:10:48.641805 kernel: erofs: (device dm-5): mounted with root inode @ nid 39. Oct 22 23:10:48.661798 kernel: loop4: detected capacity change from 0 to 142648 Oct 22 23:10:48.672774 kernel: loop4: p1 p2 p3 Oct 22 23:10:48.680075 kernel: device-mapper: verity: sha256 using shash "sha256-ce" Oct 22 23:10:48.680159 kernel: device-mapper: verity: Unrecognized verity feature request: root_hash_sig_key_desc Oct 22 23:10:48.682153 kernel: device-mapper: table: 254:5: verity: Unrecognized verity feature request (-EINVAL) Oct 22 23:10:48.683668 kernel: device-mapper: ioctl: error adding target to table Oct 22 23:10:48.683993 systemd-sysext[1659]: device-mapper: reload ioctl on loop4p1-72-verity (254:5) failed: Invalid argument Oct 22 23:10:48.688917 kernel: device-mapper: verity: sha256 using shash "sha256-ce" Oct 22 23:10:48.717937 kernel: erofs: (device dm-5): mounted with root inode @ nid 39. Oct 22 23:10:48.742769 kernel: loop4: detected capacity change from 0 to 364712 Oct 22 23:10:48.752818 kernel: loop4: p1 p2 p3 Oct 22 23:10:48.769187 kernel: device-mapper: verity: sha256 using shash "sha256-ce" Oct 22 23:10:48.769692 kernel: device-mapper: verity: Unrecognized verity feature request: root_hash_sig_key_desc Oct 22 23:10:48.770050 kernel: device-mapper: table: 254:5: verity: Unrecognized verity feature request (-EINVAL) Oct 22 23:10:48.771924 kernel: device-mapper: ioctl: error adding target to table Oct 22 23:10:48.773260 (sd-merge)[1704]: device-mapper: reload ioctl on loop4p1-77-verity (254:5) failed: Invalid argument Oct 22 23:10:48.783820 kernel: device-mapper: verity: sha256 using shash "sha256-ce" Oct 22 23:10:48.818783 kernel: erofs: (device dm-5): mounted with root inode @ nid 39. Oct 22 23:10:48.822778 kernel: loop5: detected capacity change from 0 to 172608 Oct 22 23:10:48.827768 kernel: loop5: p1 p2 p3 Oct 22 23:10:48.841805 kernel: device-mapper: verity: sha256 using shash "sha256-ce" Oct 22 23:10:48.845875 kernel: device-mapper: verity: Unrecognized verity feature request: root_hash_sig_key_desc Oct 22 23:10:48.845938 kernel: device-mapper: table: 254:6: verity: Unrecognized verity feature request (-EINVAL) Oct 22 23:10:48.847446 kernel: device-mapper: ioctl: error adding target to table Oct 22 23:10:48.847538 (sd-merge)[1704]: device-mapper: reload ioctl on loop5p1-81-verity (254:6) failed: Invalid argument Oct 22 23:10:48.851300 kernel: device-mapper: verity: sha256 using shash "sha256-ce" Oct 22 23:10:48.907797 kernel: erofs: (device dm-6): mounted with root inode @ nid 39. Oct 22 23:10:48.911786 kernel: loop6: detected capacity change from 0 to 142648 Oct 22 23:10:48.918785 kernel: loop6: p1 p2 p3 Oct 22 23:10:48.930091 kernel: device-mapper: verity: sha256 using shash "sha256-ce" Oct 22 23:10:48.930177 kernel: device-mapper: verity: Unrecognized verity feature request: root_hash_sig_key_desc Oct 22 23:10:48.934023 kernel: device-mapper: table: 254:7: verity: Unrecognized verity feature request (-EINVAL) Oct 22 23:10:48.936348 kernel: device-mapper: ioctl: error adding target to table Oct 22 23:10:48.936746 (sd-merge)[1704]: device-mapper: reload ioctl on loop6p1-85-verity (254:7) failed: Invalid argument Oct 22 23:10:48.942788 kernel: device-mapper: verity: sha256 using shash "sha256-ce" Oct 22 23:10:48.971790 kernel: erofs: (device dm-7): mounted with root inode @ nid 39. Oct 22 23:10:48.972208 (sd-merge)[1704]: Skipping extension refresh because no change was found, use --always-refresh=yes to always do a refresh. Oct 22 23:10:48.975039 systemd[1]: Finished systemd-sysext.service - Merge System Extension Images into /usr/ and /opt/. Oct 22 23:10:48.978000 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 22 23:10:48.980464 systemd[1]: Starting systemd-tmpfiles-setup.service - Create System Files and Directories... Oct 22 23:10:48.997250 systemd-tmpfiles[1727]: /usr/lib/tmpfiles.d/base_image_var.conf:29: Duplicate line for path "/var/log/audit", ignoring. Oct 22 23:10:48.999611 systemd-tmpfiles[1727]: /usr/lib/tmpfiles.d/base_image_var_late.conf:44: Duplicate line for path "/var/log/audit", ignoring. Oct 22 23:10:48.999939 systemd-tmpfiles[1727]: /usr/lib/tmpfiles.d/baselayout.conf:15: Duplicate line for path "/var", ignoring. Oct 22 23:10:49.000015 systemd-tmpfiles[1727]: /usr/lib/tmpfiles.d/baselayout.conf:16: Duplicate line for path "/var/empty", ignoring. Oct 22 23:10:49.000070 systemd-tmpfiles[1727]: /usr/lib/tmpfiles.d/baselayout.conf:21: Duplicate line for path "/var/log", ignoring. Oct 22 23:10:49.000237 systemd-tmpfiles[1727]: /usr/lib/tmpfiles.d/dbus.conf:5: Duplicate line for path "/var/lib/dbus", ignoring. Oct 22 23:10:49.000825 systemd-tmpfiles[1727]: /usr/lib/tmpfiles.d/nfs-utils.conf:2: Duplicate line for path "/var/lib/nfs/v4recovery", ignoring. Oct 22 23:10:49.002212 systemd-tmpfiles[1727]: /usr/lib/tmpfiles.d/nfs-utils.conf:6: Duplicate line for path "/var/lib/nfs/sm", ignoring. Oct 22 23:10:49.002339 systemd-tmpfiles[1727]: /usr/lib/tmpfiles.d/nfs-utils.conf:7: Duplicate line for path "/var/lib/nfs/sm.bak", ignoring. Oct 22 23:10:49.002576 systemd-tmpfiles[1727]: /usr/lib/tmpfiles.d/provision.conf:20: Duplicate line for path "/root", ignoring. Oct 22 23:10:49.003351 systemd-tmpfiles[1727]: /usr/lib/tmpfiles.d/tpm2-tss-fapi.conf:2: Duplicate line for path "/var/lib/tpm2-tss/system/keystore", ignoring. Oct 22 23:10:49.003440 systemd-tmpfiles[1727]: ACLs are not supported, ignoring. Oct 22 23:10:49.003539 systemd-tmpfiles[1727]: ACLs are not supported, ignoring. Oct 22 23:10:49.004716 systemd-tmpfiles[1727]: /usr/lib/tmpfiles.d/var.conf:10: Duplicate line for path "/var", ignoring. Oct 22 23:10:49.004858 systemd-tmpfiles[1727]: /usr/lib/tmpfiles.d/var.conf:14: Duplicate line for path "/var/log", ignoring. Oct 22 23:10:49.004992 systemd-tmpfiles[1727]: /usr/lib/tmpfiles.d/var.conf:21: Duplicate line for path "/var/lib", ignoring. Oct 22 23:10:49.008022 systemd-tmpfiles[1727]: Detected autofs mount point '/boot' during canonicalization of 'boot'. Oct 22 23:10:49.008125 systemd-tmpfiles[1727]: Skipping /boot Oct 22 23:10:49.015126 systemd-tmpfiles[1727]: Detected autofs mount point '/boot' during canonicalization of 'boot'. Oct 22 23:10:49.015228 systemd-tmpfiles[1727]: Skipping /boot Oct 22 23:10:49.023199 systemd[1]: Finished systemd-tmpfiles-setup.service - Create System Files and Directories. Oct 22 23:10:49.026000 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 22 23:10:49.028449 systemd[1]: Starting audit-rules.service - Load Audit Rules... Oct 22 23:10:49.040943 systemd[1]: Starting clean-ca-certificates.service - Clean up broken links in /etc/ssl/certs... Oct 22 23:10:49.047525 systemd[1]: Starting ldconfig.service - Rebuild Dynamic Linker Cache... Oct 22 23:10:49.054398 systemd[1]: Starting systemd-journal-catalog-update.service - Rebuild Journal Catalog... Oct 22 23:10:49.061884 systemd[1]: Starting systemd-update-utmp.service - Record System Boot/Shutdown in UTMP... Oct 22 23:10:49.096000 audit[1736]: AUDIT1127 pid=1736 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 22 23:10:49.100359 systemd[1]: Finished systemd-update-utmp.service - Record System Boot/Shutdown in UTMP. Oct 22 23:10:49.104000 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 22 23:10:49.344192 systemd[1]: Finished systemd-journal-catalog-update.service - Rebuild Journal Catalog. Oct 22 23:10:49.347000 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 22 23:10:49.377000 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 22 23:10:49.377000 audit[1759]: SYSCALL arch=c00000b7 syscall=206 success=yes exit=1056 a0=3 a1=fffffa8b5e60 a2=420 a3=0 items=0 ppid=1730 pid=1759 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 22 23:10:49.377000 audit: PROCTITLE proctitle=2F7362696E2F617564697463746C002D52002F6574632F61756469742F61756469742E72756C6573 Oct 22 23:10:49.378512 augenrules[1759]: No rules Oct 22 23:10:49.379699 systemd[1]: audit-rules.service: Deactivated successfully. Oct 22 23:10:49.380011 systemd[1]: Finished audit-rules.service - Load Audit Rules. Oct 22 23:10:49.631965 systemd-networkd[1541]: eth0: Gained IPv6LL Oct 22 23:10:49.633930 systemd[1]: Finished systemd-networkd-wait-online.service - Wait for Network to be Online. Oct 22 23:10:49.638732 systemd[1]: Reached target network-online.target - Network is Online. Oct 22 23:10:50.321316 systemd[1]: Finished clean-ca-certificates.service - Clean up broken links in /etc/ssl/certs. Oct 22 23:10:50.325645 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 22 23:10:54.732346 ldconfig[1733]: ldconfig: /usr/lib/ld.so.conf is not an ELF file - it has the wrong magic bytes at the start. Oct 22 23:10:54.775728 systemd[1]: Finished ldconfig.service - Rebuild Dynamic Linker Cache. Oct 22 23:10:54.783497 systemd[1]: Starting systemd-update-done.service - Update is Completed... Oct 22 23:10:54.806109 systemd[1]: Finished systemd-update-done.service - Update is Completed. Oct 22 23:10:54.810500 systemd[1]: Reached target sysinit.target - System Initialization. Oct 22 23:10:54.814899 systemd[1]: Started motdgen.path - Watch for update engine configuration changes. Oct 22 23:10:54.820298 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 22 23:10:54.825735 systemd[1]: Started logrotate.timer - Daily rotation of log files. Oct 22 23:10:54.830121 systemd[1]: Started mdadm.timer - Weekly check for MD array's redundancy information.. Oct 22 23:10:54.835234 systemd[1]: Started systemd-sysupdate-reboot.timer - Reboot Automatically After System Update. Oct 22 23:10:54.840322 systemd[1]: Started systemd-sysupdate.timer - Automatic System Update. Oct 22 23:10:54.844688 systemd[1]: Started systemd-tmpfiles-clean.timer - Daily Cleanup of Temporary Directories. Oct 22 23:10:54.848592 systemd[1]: update-engine-stub.timer - Update Engine Stub Timer skipped, unmet condition check ConditionPathExists=/usr/.noupdate Oct 22 23:10:54.848632 systemd[1]: Reached target paths.target - Path Units. Oct 22 23:10:54.852022 systemd[1]: Reached target timers.target - Timer Units. Oct 22 23:10:54.856622 systemd[1]: Listening on dbus.socket - D-Bus System Message Bus Socket. Oct 22 23:10:54.862666 systemd[1]: Starting docker.socket - Docker Socket for the API... Oct 22 23:10:54.867656 systemd[1]: Listening on sshd-unix-local.socket - OpenSSH Server Socket (systemd-ssh-generator, AF_UNIX Local). Oct 22 23:10:54.874090 systemd[1]: Listening on sshd.socket - OpenSSH Server Socket. Oct 22 23:10:54.880243 systemd[1]: Listening on systemd-hostnamed.socket - Hostname Service Socket. Oct 22 23:10:54.885373 systemd[1]: Listening on systemd-logind-varlink.socket - User Login Management Varlink Socket. Oct 22 23:10:54.890940 systemd[1]: Listening on systemd-machined.socket - Virtual Machine and Container Registration Service Socket. Oct 22 23:10:54.896063 systemd[1]: Listening on docker.socket - Docker Socket for the API. Oct 22 23:10:54.900283 systemd[1]: Reached target sockets.target - Socket Units. Oct 22 23:10:54.903771 systemd[1]: Reached target basic.target - Basic System. Oct 22 23:10:54.907503 systemd[1]: addon-config@oem.service - Configure Addon /oem skipped, no trigger condition checks were met. Oct 22 23:10:54.907534 systemd[1]: addon-run@oem.service - Run Addon /oem skipped, no trigger condition checks were met. Oct 22 23:10:54.909473 systemd[1]: Starting chronyd.service - NTP client/server... Oct 22 23:10:54.925176 systemd[1]: Starting containerd.service - containerd container runtime... Oct 22 23:10:54.928942 systemd[1]: Starting dbus.service - D-Bus System Message Bus... Oct 22 23:10:54.936964 systemd[1]: Starting dracut-shutdown.service - Restore /run/initramfs on shutdown... Oct 22 23:10:54.945039 systemd[1]: Starting enable-oem-cloudinit.service - Enable cloudinit... Oct 22 23:10:54.955489 systemd[1]: Starting extend-filesystems.service - Extend Filesystems... Oct 22 23:10:54.959398 chronyd[1772]: chronyd version 4.8 starting (+CMDMON +REFCLOCK +RTC +PRIVDROP +SCFILTER -SIGND +NTS +SECHASH +IPV6 -DEBUG) Oct 22 23:10:54.959412 systemd[1]: flatcar-setup-environment.service - Modifies /etc/environment for CoreOS skipped, unmet condition check ConditionPathExists=/oem/bin/flatcar-setup-environment Oct 22 23:10:54.960271 systemd[1]: Started hv_kvp_daemon.service - Hyper-V KVP daemon. Oct 22 23:10:54.968987 systemd[1]: hv_vss_daemon.service - Hyper-V VSS daemon skipped, unmet condition check ConditionPathExists=/dev/vmbus/hv_vss Oct 22 23:10:54.976918 chronyd[1772]: Timezone right/UTC failed leap second check, ignoring Oct 22 23:10:54.977085 chronyd[1772]: Loaded seccomp filter (level 2) Oct 22 23:10:54.980055 systemd[1]: Starting motdgen.service - Generate /run/flatcar/motd... Oct 22 23:10:54.981870 jq[1776]: false Oct 22 23:10:54.986472 systemd[1]: Starting nvidia.service - NVIDIA Configure Service... Oct 22 23:10:54.991719 systemd[1]: Starting ssh-key-proc-cmdline.service - Install an ssh key from /proc/cmdline... Oct 22 23:10:54.995178 KVP[1778]: KVP starting; pid is:1778 Oct 22 23:10:54.997874 KVP[1778]: KVP LIC Version: 3.1 Oct 22 23:10:54.999418 systemd[1]: Starting sshd-keygen.service - Generate sshd host keys... Oct 22 23:10:55.000996 kernel: hv_utils: KVP IC version 4.0 Oct 22 23:10:55.006747 systemd[1]: Starting systemd-logind.service - User Login Management... Oct 22 23:10:55.013266 systemd[1]: tcsd.service - TCG Core Services Daemon skipped, unmet condition check ConditionPathExists=/dev/tpm0 Oct 22 23:10:55.014950 systemd[1]: Starting update-engine.service - Update Engine... Oct 22 23:10:55.017816 extend-filesystems[1777]: Found /dev/sda6 Oct 22 23:10:55.024310 systemd[1]: Starting update-ssh-keys-after-ignition.service - Run update-ssh-keys once after Ignition... Oct 22 23:10:55.032349 systemd[1]: Started chronyd.service - NTP client/server. Oct 22 23:10:55.033398 jq[1794]: true Oct 22 23:10:55.038406 extend-filesystems[1777]: Found /dev/sda9 Oct 22 23:10:55.040402 systemd[1]: Finished dracut-shutdown.service - Restore /run/initramfs on shutdown. Oct 22 23:10:55.041447 extend-filesystems[1777]: Checking size of /dev/sda9 Oct 22 23:10:55.072043 motdgen[1805]: /oem/oem-release: line 2: Azure: command not found Oct 22 23:10:55.047473 systemd[1]: enable-oem-cloudinit.service: Skipped due to 'exec-condition'. Oct 22 23:10:55.047945 systemd[1]: Condition check resulted in enable-oem-cloudinit.service - Enable cloudinit being skipped. Oct 22 23:10:55.048157 systemd[1]: ssh-key-proc-cmdline.service: Deactivated successfully. Oct 22 23:10:55.049793 systemd[1]: Finished ssh-key-proc-cmdline.service - Install an ssh key from /proc/cmdline. Oct 22 23:10:55.069180 systemd[1]: motdgen.service: Deactivated successfully. Oct 22 23:10:55.070988 systemd[1]: Finished motdgen.service - Generate /run/flatcar/motd. Oct 22 23:10:55.080426 jq[1810]: true Oct 22 23:10:55.109430 extend-filesystems[1777]: Resized partition /dev/sda9 Oct 22 23:10:55.120854 systemd[1]: Finished nvidia.service - NVIDIA Configure Service. Oct 22 23:10:55.133774 update_engine[1789]: I20261022 23:10:55.133018 1789 main.cc:92] Flatcar Update Engine starting Oct 22 23:10:55.140523 systemd-logind[1786]: New seat seat0. Oct 22 23:10:55.144114 systemd-logind[1786]: Watching system buttons on /dev/input/event1 (AT Translated Set 2 keyboard) Oct 22 23:10:55.148675 extend-filesystems[1848]: resize2fs 1.47.4 (6-Mar-2025) Oct 22 23:10:55.321219 kernel: EXT4-fs (sda9): resizing filesystem from 6359552 to 6376955 blocks Oct 22 23:10:55.321302 kernel: EXT4-fs (sda9): resized filesystem to 6376955 Oct 22 23:10:55.337374 bash[1855]: Updated "/home/flatcar/.ssh/authorized_keys" Oct 22 23:10:55.342587 systemd[1]: Finished update-ssh-keys-after-ignition.service - Run update-ssh-keys once after Ignition. Oct 22 23:10:55.346562 systemd[1]: sshkeys.service skipped, no trigger condition checks were met. Oct 22 23:10:55.350154 sshd_keygen[1793]: ssh-keygen: generating new host keys: RSA ECDSA ED25519 MLDSA44-ED25519 Oct 22 23:10:55.370911 systemd[1]: Finished sshd-keygen.service - Generate sshd host keys. Oct 22 23:10:55.373897 update_engine[1789]: I20261022 23:10:55.373430 1789 update_check_scheduler.cc:74] Next update check in 4m53s Oct 22 23:10:55.371320 dbus-daemon[1774]: [system] SELinux support is enabled Oct 22 23:10:55.376045 systemd[1]: Started dbus.service - D-Bus System Message Bus. Oct 22 23:10:55.382907 systemd[1]: Starting issuegen.service - Generate /run/issue... Oct 22 23:10:55.385965 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 22 23:10:55.385995 systemd[1]: Reached target system-config.target - Load system-provided cloud configs. Oct 22 23:10:55.391181 extend-filesystems[1848]: Filesystem at /dev/sda9 is mounted on /; on-line resizing required Oct 22 23:10:55.391181 extend-filesystems[1848]: old_desc_blocks = 4, new_desc_blocks = 4 Oct 22 23:10:55.391181 extend-filesystems[1848]: The filesystem on /dev/sda9 is now 6376955 (4k) blocks long. Oct 22 23:10:55.417875 extend-filesystems[1777]: Resized filesystem in /dev/sda9 Oct 22 23:10:55.391505 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 22 23:10:55.392122 systemd[1]: Reached target user-config.target - Load user-provided cloud configs. Oct 22 23:10:55.403160 systemd[1]: Starting waagent.service - Microsoft Azure Linux Agent... Oct 22 23:10:55.408697 systemd[1]: extend-filesystems.service: Deactivated successfully. Oct 22 23:10:55.413820 systemd[1]: Finished extend-filesystems.service - Extend Filesystems. Oct 22 23:10:55.421135 systemd[1]: issuegen.service: Deactivated successfully. Oct 22 23:10:55.421330 systemd[1]: Finished issuegen.service - Generate /run/issue. Oct 22 23:10:55.436320 dbus-daemon[1774]: [system] Successfully activated service 'org.freedesktop.systemd1' Oct 22 23:10:55.437069 systemd[1]: Starting systemd-user-sessions.service - Permit User Sessions... Oct 22 23:10:55.443699 systemd[1]: Started waagent.service - Microsoft Azure Linux Agent. Oct 22 23:10:55.449027 systemd[1]: Started update-engine.service - Update Engine. Oct 22 23:10:55.459108 systemd[1]: Created slice user-1000.slice - User Slice of UID 1000. Oct 22 23:10:55.465448 systemd[1]: Started locksmithd.service - Cluster reboot manager. Oct 22 23:10:55.471901 systemd[1]: Finished systemd-user-sessions.service - Permit User Sessions. Oct 22 23:10:55.480381 systemd[1]: Started systemd-logind.service - User Login Management. Oct 22 23:10:55.487907 systemd[1]: Started getty@tty1.service - Getty on tty1. Oct 22 23:10:55.492862 systemd[1]: Started serial-getty@ttyAMA0.service - Serial Getty on ttyAMA0. Oct 22 23:10:55.497263 systemd[1]: Reached target getty.target - Login Prompts. Oct 22 23:10:55.501900 systemd[1]: Starting user-runtime-dir@1000.service - User Runtime Directory /run/user/1000... Oct 22 23:10:55.538978 systemd[1]: Finished user-runtime-dir@1000.service - User Runtime Directory /run/user/1000. Oct 22 23:10:55.545152 systemd[1]: Starting user@1000.service - User Manager for UID 1000... Oct 22 23:10:55.886247 locksmithd[1951]: locksmithd starting currentOperation="UPDATE_STATUS_IDLE" strategy="reboot" Oct 22 23:10:56.096050 (systemd)[1957]: pam_unix(systemd-user:session): session opened for user flatcar(uid=1000) by flatcar(uid=0) Oct 22 23:10:56.098409 systemd-logind[1786]: New session '1' of user 'flatcar' with class 'manager' and type 'unspecified'. Oct 22 23:10:56.311216 systemd[1957]: Queued start job for default target default.target. Oct 22 23:10:56.319426 systemd[1957]: Created slice app.slice - User Application Slice. Oct 22 23:10:56.319451 systemd[1957]: Started systemd-tmpfiles-clean.timer - Daily Cleanup of User's Temporary Directories. Oct 22 23:10:56.319462 systemd[1957]: Reached target machines.target - Virtual Machines and Containers. Oct 22 23:10:56.319508 systemd[1957]: Reached target paths.target - Paths. Oct 22 23:10:56.319526 systemd[1957]: Reached target timers.target - Timers. Oct 22 23:10:56.320594 systemd[1957]: Starting dbus.socket - D-Bus User Message Bus Socket... Oct 22 23:10:56.321723 systemd[1957]: Listening on systemd-ask-password.socket - Query the User Interactively for a Password. Oct 22 23:10:56.321873 systemd[1957]: Listening on systemd-importd.socket - Disk Image Download Service Socket. Oct 22 23:10:56.322498 systemd[1957]: Listening on systemd-journalctl.socket - Journal Log Access Socket. Oct 22 23:10:56.322671 systemd[1957]: Listening on systemd-machined.socket - Virtual Machine and Container Registration Service Socket. Oct 22 23:10:56.325895 systemd[1957]: Starting systemd-tmpfiles-setup.service - Create User Files and Directories... Oct 22 23:10:56.331955 systemd[1957]: Listening on dbus.socket - D-Bus User Message Bus Socket. Oct 22 23:10:56.332020 systemd[1957]: Reached target sockets.target - Sockets. Oct 22 23:10:56.334735 systemd[1957]: Finished systemd-tmpfiles-setup.service - Create User Files and Directories. Oct 22 23:10:56.334807 systemd[1957]: Reached target basic.target - Basic System. Oct 22 23:10:56.335334 systemd[1]: Started user@1000.service - User Manager for UID 1000. Oct 22 23:10:56.335436 systemd[1957]: Starting hello.service - A hello world unit!... Oct 22 23:10:56.857612 echo[1972]: Foo ! Oct 22 23:10:56.858139 systemd[1957]: Finished hello.service - A hello world unit!. Oct 22 23:10:56.858287 systemd[1957]: Reached target default.target - Main User Target. Oct 22 23:10:56.858334 systemd[1957]: Startup finished in 754ms. Oct 22 23:11:00.125864 waagent[1949]: 2026-10-22T23:11:00.124027Z INFO Daemon Daemon Azure Linux Agent Version: 2.12.0.4 Oct 22 23:11:00.127949 waagent[1949]: 2026-10-22T23:11:00.127878Z INFO Daemon Daemon OS: flatcar 4757.2.1 Oct 22 23:11:00.129628 waagent[1949]: 2026-10-22T23:11:00.129576Z INFO Daemon Daemon Python: 3.12.13 Oct 22 23:11:00.131996 waagent[1949]: 2026-10-22T23:11:00.131338Z INFO Daemon Daemon Run daemon Oct 22 23:11:00.133898 waagent[1949]: 2026-10-22T23:11:00.133858Z INFO Daemon Daemon No RDMA handler exists for distro='Flatcar Container Linux by Kinvolk' version='4757.2.1' Oct 22 23:11:00.136698 waagent[1949]: 2026-10-22T23:11:00.136646Z INFO Daemon Daemon Using waagent for provisioning Oct 22 23:11:00.138635 waagent[1949]: 2026-10-22T23:11:00.138588Z INFO Daemon Daemon Activate resource disk Oct 22 23:11:00.140242 waagent[1949]: 2026-10-22T23:11:00.140197Z INFO Daemon Daemon Searching gen1 prefix 00000000-0001 or gen2 f8b3781a-1e82-4818-a1c3-63d806ec15bb Oct 22 23:11:00.145243 waagent[1949]: 2026-10-22T23:11:00.145182Z INFO Daemon Daemon Found device: None Oct 22 23:11:00.146930 waagent[1949]: 2026-10-22T23:11:00.146878Z ERROR Daemon Daemon Failed to mount resource disk [ResourceDiskError] unable to detect disk topology Oct 22 23:11:00.149554 waagent[1949]: 2026-10-22T23:11:00.149505Z ERROR Daemon Daemon Event: name=WALinuxAgent, op=ActivateResourceDisk, message=[ResourceDiskError] unable to detect disk topology, duration=0 Oct 22 23:11:00.153470 waagent[1949]: 2026-10-22T23:11:00.153419Z INFO Daemon Daemon Clean protocol and wireserver endpoint Oct 22 23:11:00.155534 waagent[1949]: 2026-10-22T23:11:00.155487Z INFO Daemon Daemon Running default provisioning handler Oct 22 23:11:00.162039 waagent[1949]: 2026-10-22T23:11:00.161980Z 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 22 23:11:00.166524 waagent[1949]: 2026-10-22T23:11:00.166468Z INFO Daemon Daemon Unable to get cloud-init enabled status from service: [Errno 2] No such file or directory: 'service' Oct 22 23:11:00.169787 waagent[1949]: 2026-10-22T23:11:00.169586Z INFO Daemon Daemon cloud-init is enabled: False Oct 22 23:11:00.171734 waagent[1949]: 2026-10-22T23:11:00.171671Z INFO Daemon Daemon Copying ovf-env.xml Oct 22 23:11:00.221972 waagent[1949]: 2026-10-22T23:11:00.221894Z INFO Daemon Daemon Successfully mounted dvd Oct 22 23:11:00.410090 systemd[1]: mnt-cdrom-secure.mount: Deactivated successfully. Oct 22 23:11:00.414053 waagent[1949]: 2026-10-22T23:11:00.412535Z INFO Daemon Daemon Detect protocol endpoint Oct 22 23:11:00.414469 waagent[1949]: 2026-10-22T23:11:00.414407Z INFO Daemon Daemon Clean protocol and wireserver endpoint Oct 22 23:11:00.418959 waagent[1949]: 2026-10-22T23:11:00.418893Z INFO Daemon Daemon WireServer endpoint is not found. Rerun dhcp handler Oct 22 23:11:00.422902 waagent[1949]: 2026-10-22T23:11:00.422839Z INFO Daemon Daemon Test for route to 168.63.129.16 Oct 22 23:11:00.424999 waagent[1949]: 2026-10-22T23:11:00.424944Z INFO Daemon Daemon Route to 168.63.129.16 exists Oct 22 23:11:00.426858 waagent[1949]: 2026-10-22T23:11:00.426808Z INFO Daemon Daemon Wire server endpoint:168.63.129.16 Oct 22 23:11:00.473155 waagent[1949]: 2026-10-22T23:11:00.473108Z INFO Daemon Daemon Fabric preferred wire protocol version:2015-04-05 Oct 22 23:11:00.475588 waagent[1949]: 2026-10-22T23:11:00.475555Z INFO Daemon Daemon Wire protocol version:2012-11-30 Oct 22 23:11:00.477451 waagent[1949]: 2026-10-22T23:11:00.477403Z INFO Daemon Daemon Server preferred version:2015-04-05 Oct 22 23:11:00.547841 waagent[1949]: 2026-10-22T23:11:00.547741Z INFO Daemon Daemon Initializing goal state during protocol detection Oct 22 23:11:00.549957 waagent[1949]: 2026-10-22T23:11:00.549890Z INFO Daemon Daemon Forcing an update of the goal state. Oct 22 23:11:00.557199 waagent[1949]: 2026-10-22T23:11:00.557151Z INFO Daemon Fetched a new incarnation for the WireServer goal state [incarnation 1] Oct 22 23:11:00.578366 waagent[1949]: 2026-10-22T23:11:00.578313Z INFO Daemon Daemon HostGAPlugin version: 1.0.8.189 Oct 22 23:11:00.580679 waagent[1949]: 2026-10-22T23:11:00.580631Z INFO Daemon Oct 22 23:11:00.581774 waagent[1949]: 2026-10-22T23:11:00.581716Z INFO Daemon Fetched new vmSettings [HostGAPlugin correlation ID: a8472810-ca98-4ebd-8ee5-7238d66d84e3 eTag: 2283165091440292508 source: Fabric] Oct 22 23:11:00.585263 waagent[1949]: 2026-10-22T23:11:00.585226Z INFO Daemon The vmSettings originated via Fabric; will ignore them. Oct 22 23:11:00.587436 waagent[1949]: 2026-10-22T23:11:00.587401Z INFO Daemon Oct 22 23:11:00.588455 waagent[1949]: 2026-10-22T23:11:00.588416Z INFO Daemon Fetching full goal state from the WireServer [incarnation 1] Oct 22 23:11:00.596458 waagent[1949]: 2026-10-22T23:11:00.596420Z INFO Daemon Daemon Downloading artifacts profile blob Oct 22 23:11:00.701411 waagent[1949]: 2026-10-22T23:11:00.700446Z INFO Daemon Downloaded certificate {'thumbprint': '5444100DFFDD3DC6658BAED6CD1B3290B72091E6', 'hasPrivateKey': True} Oct 22 23:11:00.703951 waagent[1949]: 2026-10-22T23:11:00.703895Z INFO Daemon Fetch goal state completed Oct 22 23:11:00.716462 waagent[1949]: 2026-10-22T23:11:00.716387Z INFO Daemon Daemon Starting provisioning Oct 22 23:11:00.718001 waagent[1949]: 2026-10-22T23:11:00.717941Z INFO Daemon Daemon Handle ovf-env.xml. Oct 22 23:11:00.719386 waagent[1949]: 2026-10-22T23:11:00.719330Z INFO Daemon Daemon Set hostname [ci-4757.2.1-n-5e1d953876] Oct 22 23:11:00.722983 waagent[1949]: 2026-10-22T23:11:00.722928Z INFO Daemon Daemon Publish hostname [ci-4757.2.1-n-5e1d953876] Oct 22 23:11:00.724971 waagent[1949]: 2026-10-22T23:11:00.724923Z INFO Daemon Daemon Examine /proc/net/route for primary interface Oct 22 23:11:00.727071 waagent[1949]: 2026-10-22T23:11:00.727013Z INFO Daemon Daemon Primary interface is [eth0] Oct 22 23:11:00.736000 systemd-networkd[1541]: eth0: Found matching .network file, based on potentially unpredictable interface name: /usr/lib/systemd/network/zz-default.network Oct 22 23:11:00.736014 systemd-networkd[1541]: eth0: Reconfiguring with /usr/lib/systemd/network/zz-default.network. Oct 22 23:11:00.736054 systemd-networkd[1541]: eth0: DHCP lease lost Oct 22 23:11:00.745806 waagent[1949]: 2026-10-22T23:11:00.745709Z INFO Daemon Daemon Create user account if not exists Oct 22 23:11:00.747875 waagent[1949]: 2026-10-22T23:11:00.747814Z INFO Daemon Daemon User core already exists, skip useradd Oct 22 23:11:00.749829 waagent[1949]: 2026-10-22T23:11:00.749730Z INFO Daemon Daemon Configure sudoer Oct 22 23:11:00.751679 waagent[1949]: 2026-10-22T23:11:00.751625Z INFO Daemon Daemon Configure sshd Oct 22 23:11:00.753481 waagent[1949]: 2026-10-22T23:11:00.753429Z INFO Daemon Daemon Added a configuration snippet disabling SSH password-based authentication methods. It also configures SSH client probing to keep connections alive. Oct 22 23:11:00.757356 waagent[1949]: 2026-10-22T23:11:00.757265Z INFO Daemon Daemon Deploy ssh public key. Oct 22 23:11:00.758552 systemd-networkd[1541]: eth0: DHCPv4 address 10.0.0.22/24, gateway 10.0.0.1 acquired from 168.63.129.16 Oct 22 23:11:00.985405 login[1953]: pam_unix(login:session): session opened for user core(uid=500) by core(uid=0) Oct 22 23:11:00.993282 systemd-logind[1786]: New session '2' of user 'core' with class 'user-light' and type 'tty'. Oct 22 23:11:00.993680 systemd[1]: Created slice user-500.slice - User Slice of UID 500. Oct 22 23:11:00.994631 systemd[1]: Starting user-runtime-dir@500.service - User Runtime Directory /run/user/500... Oct 22 23:11:00.997566 containerd[1816]: time="2026-10-22T23:11:00Z" 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 22 23:11:01.020954 systemd[1]: Finished user-runtime-dir@500.service - User Runtime Directory /run/user/500. Oct 22 23:11:01.027502 containerd[1816]: time="2026-10-22T23:11:01.027446192Z" level=info msg="starting containerd" revision=e53c7c1516c3b2bff98eb76f1f4117477e6f4e66 version=v2.2.5 Oct 22 23:11:01.028054 systemd[1]: Started session-2.scope - Session 2 of User core. Oct 22 23:11:01.077793 containerd[1816]: time="2026-10-22T23:11:01.077102736Z" level=warning msg="Configuration migrated from version 2, use `containerd config migrate` to avoid migration" t="8.568µs" Oct 22 23:11:01.077793 containerd[1816]: time="2026-10-22T23:11:01.077151736Z" level=info msg="loading plugin" id=io.containerd.content.v1.content type=io.containerd.content.v1 Oct 22 23:11:01.077793 containerd[1816]: time="2026-10-22T23:11:01.077207744Z" level=info msg="loading plugin" id=io.containerd.image-verifier.v1.bindir type=io.containerd.image-verifier.v1 Oct 22 23:11:01.077793 containerd[1816]: time="2026-10-22T23:11:01.077221104Z" level=info msg="loading plugin" id=io.containerd.internal.v1.opt type=io.containerd.internal.v1 Oct 22 23:11:01.077793 containerd[1816]: time="2026-10-22T23:11:01.077458360Z" level=info msg="loading plugin" id=io.containerd.warning.v1.deprecations type=io.containerd.warning.v1 Oct 22 23:11:01.077793 containerd[1816]: time="2026-10-22T23:11:01.077473744Z" level=info msg="loading plugin" id=io.containerd.mount-handler.v1.erofs type=io.containerd.mount-handler.v1 Oct 22 23:11:01.077793 containerd[1816]: time="2026-10-22T23:11:01.077482104Z" level=info msg="loading plugin" id=io.containerd.snapshotter.v1.blockfile type=io.containerd.snapshotter.v1 Oct 22 23:11:01.077793 containerd[1816]: time="2026-10-22T23:11:01.077528224Z" 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 22 23:11:01.077793 containerd[1816]: time="2026-10-22T23:11:01.077537584Z" level=info msg="loading plugin" id=io.containerd.snapshotter.v1.btrfs type=io.containerd.snapshotter.v1 Oct 22 23:11:01.078080 containerd[1816]: time="2026-10-22T23:11:01.077742688Z" 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 22 23:11:01.078128 containerd[1816]: time="2026-10-22T23:11:01.078111016Z" level=info msg="loading plugin" id=io.containerd.snapshotter.v1.devmapper type=io.containerd.snapshotter.v1 Oct 22 23:11:01.078172 containerd[1816]: time="2026-10-22T23:11:01.078158776Z" level=info msg="skip loading plugin" error="devmapper not configured: skip plugin" id=io.containerd.snapshotter.v1.devmapper type=io.containerd.snapshotter.v1 Oct 22 23:11:01.078218 containerd[1816]: time="2026-10-22T23:11:01.078205872Z" level=info msg="loading plugin" id=io.containerd.snapshotter.v1.erofs type=io.containerd.snapshotter.v1 Oct 22 23:11:01.078541 containerd[1816]: time="2026-10-22T23:11:01.078513768Z" level=info msg="loading plugin" id=io.containerd.snapshotter.v1.native type=io.containerd.snapshotter.v1 Oct 22 23:11:01.078726 containerd[1816]: time="2026-10-22T23:11:01.078675152Z" level=info msg="loading plugin" id=io.containerd.snapshotter.v1.overlayfs type=io.containerd.snapshotter.v1 Oct 22 23:11:01.079002 containerd[1816]: time="2026-10-22T23:11:01.078980008Z" level=info msg="loading plugin" id=io.containerd.snapshotter.v1.zfs type=io.containerd.snapshotter.v1 Oct 22 23:11:01.079103 containerd[1816]: time="2026-10-22T23:11:01.079086704Z" 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 22 23:11:01.079158 containerd[1816]: time="2026-10-22T23:11:01.079146576Z" level=info msg="loading plugin" id=io.containerd.event.v1.exchange type=io.containerd.event.v1 Oct 22 23:11:01.079221 containerd[1816]: time="2026-10-22T23:11:01.079210824Z" level=info msg="loading plugin" id=io.containerd.monitor.task.v1.cgroups type=io.containerd.monitor.task.v1 Oct 22 23:11:01.099381 containerd[1816]: time="2026-10-22T23:11:01.099327064Z" level=info msg="loading plugin" id=io.containerd.metadata.v1.bolt type=io.containerd.metadata.v1 Oct 22 23:11:01.099686 containerd[1816]: time="2026-10-22T23:11:01.099668416Z" level=info msg="metadata content store policy set" policy=shared Oct 22 23:11:01.132161 containerd[1816]: time="2026-10-22T23:11:01.132111352Z" level=info msg="loading plugin" id=io.containerd.gc.v1.scheduler type=io.containerd.gc.v1 Oct 22 23:11:01.132342 containerd[1816]: time="2026-10-22T23:11:01.132327536Z" level=info msg="loading plugin" id=io.containerd.nri.v1.nri type=io.containerd.nri.v1 Oct 22 23:11:01.133047 containerd[1816]: time="2026-10-22T23:11:01.133020456Z" level=info msg="built-in NRI default validator is disabled" Oct 22 23:11:01.133137 containerd[1816]: time="2026-10-22T23:11:01.133125048Z" level=info msg="runtime interface created" Oct 22 23:11:01.133174 containerd[1816]: time="2026-10-22T23:11:01.133164640Z" level=info msg="created NRI interface" Oct 22 23:11:01.133221 containerd[1816]: time="2026-10-22T23:11:01.133208704Z" level=info msg="loading plugin" id=io.containerd.differ.v1.erofs type=io.containerd.differ.v1 Oct 22 23:11:01.163607 containerd[1816]: time="2026-10-22T23:11:01.163559304Z" level=info msg="loading plugin" id=io.containerd.mount-manager.v1.bolt type=io.containerd.mount-manager.v1 Oct 22 23:11:01.163928 containerd[1816]: time="2026-10-22T23:11:01.163907840Z" level=info msg="loading plugin" id=io.containerd.differ.v1.walking type=io.containerd.differ.v1 Oct 22 23:11:01.164026 containerd[1816]: time="2026-10-22T23:11:01.164011120Z" level=info msg="loading plugin" id=io.containerd.lease.v1.manager type=io.containerd.lease.v1 Oct 22 23:11:01.164094 containerd[1816]: time="2026-10-22T23:11:01.164074376Z" level=info msg="loading plugin" id=io.containerd.service.v1.containers-service type=io.containerd.service.v1 Oct 22 23:11:01.164150 containerd[1816]: time="2026-10-22T23:11:01.164137864Z" level=info msg="loading plugin" id=io.containerd.service.v1.content-service type=io.containerd.service.v1 Oct 22 23:11:01.164196 containerd[1816]: time="2026-10-22T23:11:01.164185272Z" level=info msg="loading plugin" id=io.containerd.service.v1.diff-service type=io.containerd.service.v1 Oct 22 23:11:01.164239 containerd[1816]: time="2026-10-22T23:11:01.164228528Z" level=info msg="loading plugin" id=io.containerd.service.v1.images-service type=io.containerd.service.v1 Oct 22 23:11:01.164287 containerd[1816]: time="2026-10-22T23:11:01.164276504Z" level=info msg="loading plugin" id=io.containerd.service.v1.introspection-service type=io.containerd.service.v1 Oct 22 23:11:01.164337 containerd[1816]: time="2026-10-22T23:11:01.164326240Z" level=info msg="loading plugin" id=io.containerd.service.v1.namespaces-service type=io.containerd.service.v1 Oct 22 23:11:01.164385 containerd[1816]: time="2026-10-22T23:11:01.164372600Z" level=info msg="loading plugin" id=io.containerd.service.v1.snapshots-service type=io.containerd.service.v1 Oct 22 23:11:01.164424 containerd[1816]: time="2026-10-22T23:11:01.164413648Z" level=info msg="loading plugin" id=io.containerd.shim.v1.manager type=io.containerd.shim.v1 Oct 22 23:11:01.164473 containerd[1816]: time="2026-10-22T23:11:01.164463152Z" level=info msg="loading plugin" id=io.containerd.runtime.v2.task type=io.containerd.runtime.v2 Oct 22 23:11:01.164654 containerd[1816]: time="2026-10-22T23:11:01.164635648Z" level=info msg="loading plugin" id=io.containerd.service.v1.tasks-service type=io.containerd.service.v1 Oct 22 23:11:01.164720 containerd[1816]: time="2026-10-22T23:11:01.164709056Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.containers type=io.containerd.grpc.v1 Oct 22 23:11:01.164787 containerd[1816]: time="2026-10-22T23:11:01.164777456Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.content type=io.containerd.grpc.v1 Oct 22 23:11:01.164854 containerd[1816]: time="2026-10-22T23:11:01.164842320Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.diff type=io.containerd.grpc.v1 Oct 22 23:11:01.164907 containerd[1816]: time="2026-10-22T23:11:01.164896800Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.events type=io.containerd.grpc.v1 Oct 22 23:11:01.164953 containerd[1816]: time="2026-10-22T23:11:01.164942800Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.images type=io.containerd.grpc.v1 Oct 22 23:11:01.164995 containerd[1816]: time="2026-10-22T23:11:01.164984752Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.introspection type=io.containerd.grpc.v1 Oct 22 23:11:01.165036 containerd[1816]: time="2026-10-22T23:11:01.165024608Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.leases type=io.containerd.grpc.v1 Oct 22 23:11:01.165081 containerd[1816]: time="2026-10-22T23:11:01.165070968Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.mounts type=io.containerd.grpc.v1 Oct 22 23:11:01.165120 containerd[1816]: time="2026-10-22T23:11:01.165109624Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.namespaces type=io.containerd.grpc.v1 Oct 22 23:11:01.165161 containerd[1816]: time="2026-10-22T23:11:01.165150440Z" level=info msg="loading plugin" id=io.containerd.sandbox.store.v1.local type=io.containerd.sandbox.store.v1 Oct 22 23:11:01.165203 containerd[1816]: time="2026-10-22T23:11:01.165193584Z" level=info msg="loading plugin" id=io.containerd.transfer.v1.local type=io.containerd.transfer.v1 Oct 22 23:11:01.165269 containerd[1816]: time="2026-10-22T23:11:01.165257960Z" level=info msg="loading plugin" id=io.containerd.cri.v1.images type=io.containerd.cri.v1 Oct 22 23:11:01.181111 containerd[1816]: time="2026-10-22T23:11:01.180305688Z" level=info msg="Get image filesystem path \"/var/lib/containerd/io.containerd.snapshotter.v1.overlayfs\" for snapshotter \"overlayfs\"" Oct 22 23:11:01.181111 containerd[1816]: time="2026-10-22T23:11:01.180351608Z" level=info msg="Start snapshots syncer" Oct 22 23:11:01.181111 containerd[1816]: time="2026-10-22T23:11:01.180370952Z" level=info msg="loading plugin" id=io.containerd.cri.v1.runtime type=io.containerd.cri.v1 Oct 22 23:11:01.181262 containerd[1816]: time="2026-10-22T23:11:01.180629120Z" level=info msg="starting cri plugin" config="{\"containerd\":{\"defaultRuntimeName\":\"runc\",\"runtimes\":{\"runc\":{\"runtimeType\":\"io.containerd.runc.v2\",\"runtimePath\":\"\",\"PodAnnotations\":null,\"ContainerAnnotations\":null,\"options\":{\"BinaryName\":\"\",\"CriuImagePath\":\"\",\"CriuWorkPath\":\"\",\"IoGid\":0,\"IoUid\":0,\"NoNewKeyring\":false,\"Root\":\"\",\"ShimCgroup\":\"\",\"SystemdCgroup\":true},\"privileged_without_host_devices\":false,\"privileged_without_host_devices_all_devices_allowed\":false,\"cgroupWritable\":false,\"baseRuntimeSpec\":\"\",\"cniConfDir\":\"\",\"cniMaxConfNum\":0,\"snapshotter\":\"\",\"sandboxer\":\"podsandbox\",\"io_type\":\"\"}},\"ignoreBlockIONotEnabledErrors\":false,\"ignoreRdtNotEnabledErrors\":false},\"cni\":{\"binDir\":\"\",\"binDirs\":[\"/opt/cni/bin\"],\"confDir\":\"/etc/cni/net.d\",\"maxConfNum\":1,\"setupSerially\":false,\"confTemplate\":\"\",\"ipPref\":\"\",\"useInternalLoopback\":false},\"enableSelinux\":true,\"selinuxCategoryRange\":1024,\"maxContainerLogLineSize\":16384,\"disableApparmor\":false,\"restrictOOMScoreAdj\":false,\"disableProcMount\":false,\"unsetSeccompProfile\":\"\",\"tolerateMissingHugetlbController\":true,\"disableHugetlbController\":true,\"device_ownership_from_security_context\":false,\"ignoreImageDefinedVolumes\":false,\"netnsMountsUnderStateDir\":false,\"enableUnprivilegedPorts\":true,\"enableUnprivilegedICMP\":true,\"enableCDI\":true,\"cdiSpecDirs\":[\"/etc/cdi\",\"/var/run/cdi\"],\"drainExecSyncIOTimeout\":\"0s\",\"ignoreDeprecationWarnings\":null,\"containerdRootDir\":\"/var/lib/containerd\",\"containerdEndpoint\":\"/run/containerd/containerd.sock\",\"rootDir\":\"/var/lib/containerd/io.containerd.grpc.v1.cri\",\"stateDir\":\"/run/containerd/io.containerd.grpc.v1.cri\"}" Oct 22 23:11:01.181262 containerd[1816]: time="2026-10-22T23:11:01.180675088Z" level=info msg="loading plugin" id=io.containerd.podsandbox.controller.v1.podsandbox type=io.containerd.podsandbox.controller.v1 Oct 22 23:11:01.181262 containerd[1816]: time="2026-10-22T23:11:01.180720000Z" level=info msg="loading plugin" id=io.containerd.sandbox.controller.v1.shim type=io.containerd.sandbox.controller.v1 Oct 22 23:11:01.181262 containerd[1816]: time="2026-10-22T23:11:01.180883520Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.sandbox-controllers type=io.containerd.grpc.v1 Oct 22 23:11:01.181262 containerd[1816]: time="2026-10-22T23:11:01.180903208Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.sandboxes type=io.containerd.grpc.v1 Oct 22 23:11:01.181262 containerd[1816]: time="2026-10-22T23:11:01.180913048Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.snapshots type=io.containerd.grpc.v1 Oct 22 23:11:01.181262 containerd[1816]: time="2026-10-22T23:11:01.180920568Z" level=info msg="loading plugin" id=io.containerd.streaming.v1.manager type=io.containerd.streaming.v1 Oct 22 23:11:01.181262 containerd[1816]: time="2026-10-22T23:11:01.180930792Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.streaming type=io.containerd.grpc.v1 Oct 22 23:11:01.181262 containerd[1816]: time="2026-10-22T23:11:01.180937912Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.tasks type=io.containerd.grpc.v1 Oct 22 23:11:01.181262 containerd[1816]: time="2026-10-22T23:11:01.180945216Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.transfer type=io.containerd.grpc.v1 Oct 22 23:11:01.181262 containerd[1816]: time="2026-10-22T23:11:01.180955224Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.version type=io.containerd.grpc.v1 Oct 22 23:11:01.181262 containerd[1816]: time="2026-10-22T23:11:01.180961056Z" level=info msg="loading plugin" id=io.containerd.monitor.container.v1.restart type=io.containerd.monitor.container.v1 Oct 22 23:11:01.181262 containerd[1816]: time="2026-10-22T23:11:01.180980808Z" level=info msg="loading plugin" id=io.containerd.tracing.processor.v1.otlp type=io.containerd.tracing.processor.v1 Oct 22 23:11:01.181262 containerd[1816]: time="2026-10-22T23:11:01.180994272Z" 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 22 23:11:01.181262 containerd[1816]: time="2026-10-22T23:11:01.181001200Z" level=info msg="loading plugin" id=io.containerd.internal.v1.tracing type=io.containerd.internal.v1 Oct 22 23:11:01.181262 containerd[1816]: time="2026-10-22T23:11:01.181006888Z" 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 22 23:11:01.181262 containerd[1816]: time="2026-10-22T23:11:01.181011960Z" level=info msg="loading plugin" id=io.containerd.ttrpc.v1.otelttrpc type=io.containerd.ttrpc.v1 Oct 22 23:11:01.181262 containerd[1816]: time="2026-10-22T23:11:01.181017600Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.healthcheck type=io.containerd.grpc.v1 Oct 22 23:11:01.181262 containerd[1816]: time="2026-10-22T23:11:01.181025736Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.cri type=io.containerd.grpc.v1 Oct 22 23:11:01.181262 containerd[1816]: time="2026-10-22T23:11:01.181034184Z" level=info msg="Connect containerd service" Oct 22 23:11:01.181262 containerd[1816]: time="2026-10-22T23:11:01.181051200Z" level=info msg="using experimental NRI integration - disable nri plugin to prevent this" Oct 22 23:11:01.206306 login[1954]: pam_unix(login:session): session opened for user core(uid=500) by core(uid=0) Oct 22 23:11:01.211645 systemd-logind[1786]: New session '3' of user 'core' with class 'user-light' and type 'tty'. Oct 22 23:11:01.215002 containerd[1816]: time="2026-10-22T23:11:01.214951536Z" level=error msg="failed to load cni during init, please check CRI plugin status before setting up network for pods" error="cni config load failed: no network config found in /etc/cni/net.d: cni plugin not initialized: failed to load cni config" Oct 22 23:11:01.215996 systemd[1]: Started session-3.scope - Session 3 of User core. Oct 22 23:11:01.877387 waagent[1949]: 2026-10-22T23:11:01.877333Z INFO Daemon Daemon Provisioning complete Oct 22 23:11:01.888905 waagent[1949]: 2026-10-22T23:11:01.888852Z INFO Daemon Daemon RDMA capabilities are not enabled, skipping Oct 22 23:11:01.890862 waagent[1949]: 2026-10-22T23:11:01.890811Z INFO Daemon Daemon End of log to /dev/console. The agent will now check for updates and then will process extensions. Oct 22 23:11:01.893806 waagent[1949]: 2026-10-22T23:11:01.893735Z INFO Daemon Daemon Installed Agent WALinuxAgent-2.12.0.4 is the most current agent Oct 22 23:11:02.009800 waagent[2045]: 2026-10-22T23:11:02.009586Z INFO ExtHandler ExtHandler Azure Linux Agent (Goal State Agent version 2.12.0.4) Oct 22 23:11:02.009800 waagent[2045]: 2026-10-22T23:11:02.009743Z INFO ExtHandler ExtHandler OS: flatcar 4757.2.1 Oct 22 23:11:02.010185 waagent[2045]: 2026-10-22T23:11:02.009833Z INFO ExtHandler ExtHandler Python: 3.12.13 Oct 22 23:11:02.010185 waagent[2045]: 2026-10-22T23:11:02.009873Z INFO ExtHandler ExtHandler CPU Arch: aarch64 Oct 22 23:11:02.104237 waagent[2045]: 2026-10-22T23:11:02.104150Z INFO ExtHandler ExtHandler Distro: flatcar-4757.2.1; OSUtil: FlatcarUtil; AgentService: waagent; Python: 3.12.13; Arch: aarch64; systemd: True; LISDrivers: Absent; logrotate: logrotate 3.22.0; Oct 22 23:11:02.104422 waagent[2045]: 2026-10-22T23:11:02.104391Z INFO ExtHandler ExtHandler WireServer endpoint 168.63.129.16 read from file Oct 22 23:11:02.104485 waagent[2045]: 2026-10-22T23:11:02.104466Z INFO ExtHandler ExtHandler Wire server endpoint:168.63.129.16 Oct 22 23:11:02.115370 waagent[2045]: 2026-10-22T23:11:02.115304Z INFO ExtHandler Fetched a new incarnation for the WireServer goal state [incarnation 1] Oct 22 23:11:02.128102 waagent[2045]: 2026-10-22T23:11:02.127981Z INFO ExtHandler ExtHandler HostGAPlugin version: 1.0.8.189 Oct 22 23:11:02.128616 waagent[2045]: 2026-10-22T23:11:02.128572Z INFO ExtHandler Oct 22 23:11:02.128676 waagent[2045]: 2026-10-22T23:11:02.128655Z INFO ExtHandler Fetched new vmSettings [HostGAPlugin correlation ID: 92e309e4-f986-46c9-822a-e30495e12d4b eTag: 2283165091440292508 source: Fabric] Oct 22 23:11:02.128997 waagent[2045]: 2026-10-22T23:11:02.128965Z INFO ExtHandler The vmSettings originated via Fabric; will ignore them. Oct 22 23:11:02.129446 waagent[2045]: 2026-10-22T23:11:02.129414Z INFO ExtHandler Oct 22 23:11:02.129491 waagent[2045]: 2026-10-22T23:11:02.129474Z INFO ExtHandler Fetching full goal state from the WireServer [incarnation 1] Oct 22 23:11:02.136069 waagent[2045]: 2026-10-22T23:11:02.136018Z INFO ExtHandler ExtHandler Downloading artifacts profile blob Oct 22 23:11:02.221525 waagent[2045]: 2026-10-22T23:11:02.221429Z INFO ExtHandler Downloaded certificate {'thumbprint': '5444100DFFDD3DC6658BAED6CD1B3290B72091E6', 'hasPrivateKey': True} Oct 22 23:11:02.221997 waagent[2045]: 2026-10-22T23:11:02.221958Z INFO ExtHandler Fetch goal state completed Oct 22 23:11:02.236650 waagent[2045]: 2026-10-22T23:11:02.236575Z INFO ExtHandler ExtHandler OpenSSL version: OpenSSL 3.5.9 29 Sep 2026 (Library: OpenSSL 3.5.9 29 Sep 2026) Oct 22 23:11:02.241042 waagent[2045]: 2026-10-22T23:11:02.240977Z INFO ExtHandler ExtHandler WALinuxAgent-2.12.0.4 running as process 2045 Oct 22 23:11:02.241177 waagent[2045]: 2026-10-22T23:11:02.241150Z INFO ExtHandler ExtHandler ******** AutoUpdate.Enabled is set to False, not processing the operation ******** Oct 22 23:11:02.241492 waagent[2045]: 2026-10-22T23:11:02.241456Z INFO ExtHandler ExtHandler ******** AutoUpdate.UpdateToLatestVersion is set to False, not processing the operation ******** Oct 22 23:11:02.242673 waagent[2045]: 2026-10-22T23:11:02.242632Z INFO ExtHandler ExtHandler [CGI] Cgroup monitoring is not supported on ['flatcar', '4757.2.1', '', 'Flatcar Container Linux by Kinvolk'] Oct 22 23:11:02.243066 waagent[2045]: 2026-10-22T23:11:02.243032Z INFO ExtHandler ExtHandler [CGI] Agent will reset the quotas in case distro: ['flatcar', '4757.2.1', '', 'Flatcar Container Linux by Kinvolk'] went from supported to unsupported Oct 22 23:11:02.243175 waagent[2045]: 2026-10-22T23:11:02.243153Z INFO ExtHandler ExtHandler [CGI] Agent cgroups enabled: False Oct 22 23:11:02.243613 waagent[2045]: 2026-10-22T23:11:02.243583Z INFO ExtHandler ExtHandler Starting setup for Persistent firewall rules Oct 22 23:11:02.282337 waagent[2045]: 2026-10-22T23:11:02.282293Z INFO ExtHandler ExtHandler Firewalld service not running/unavailable, trying to set up waagent-network-setup.service Oct 22 23:11:02.282536 waagent[2045]: 2026-10-22T23:11:02.282507Z INFO ExtHandler ExtHandler Successfully updated the Binary file /var/lib/waagent/waagent-network-setup.py for firewall setup Oct 22 23:11:02.287822 waagent[2045]: 2026-10-22T23:11:02.287328Z INFO ExtHandler ExtHandler Service: waagent-network-setup.service not enabled. Adding it now Oct 22 23:11:02.292713 systemd[1]: Reload requested from client PID 2063 ('systemctl') (unit waagent.service)... Oct 22 23:11:02.293064 systemd[1]: Reloading... Oct 22 23:11:02.396844 zram_generator::config[2116]: No configuration found. Oct 22 23:11:02.492891 kernel: hv_storvsc f8b3781a-1e82-4818-a1c3-63d806ec15bb: tag#184 cmd 0x85 status: scsi 0x2 srb 0x84 hv 0xc0000185 Oct 22 23:11:02.645184 systemd[1]: Reloading finished in 351 ms. Oct 22 23:11:02.664658 waagent[2045]: 2026-10-22T23:11:02.663855Z INFO ExtHandler ExtHandler Successfully added and enabled the waagent-network-setup.service Oct 22 23:11:02.664658 waagent[2045]: 2026-10-22T23:11:02.664027Z INFO ExtHandler ExtHandler Persistent firewall rules setup successfully Oct 22 23:11:03.050031 waagent[2045]: 2026-10-22T23:11:03.049892Z INFO ExtHandler ExtHandler DROP rule is not available which implies no firewall rules are set yet. Environment thread will set it up. Oct 22 23:11:03.050379 waagent[2045]: 2026-10-22T23:11:03.050226Z 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 22 23:11:03.051008 waagent[2045]: 2026-10-22T23:11:03.050928Z INFO ExtHandler ExtHandler Starting env monitor service. Oct 22 23:11:03.051374 waagent[2045]: 2026-10-22T23:11:03.051292Z INFO ExtHandler ExtHandler Start SendTelemetryHandler service. Oct 22 23:11:03.051777 waagent[2045]: 2026-10-22T23:11:03.051563Z INFO MonitorHandler ExtHandler WireServer endpoint 168.63.129.16 read from file Oct 22 23:11:03.051777 waagent[2045]: 2026-10-22T23:11:03.051645Z INFO MonitorHandler ExtHandler Wire server endpoint:168.63.129.16 Oct 22 23:11:03.052112 waagent[2045]: 2026-10-22T23:11:03.052054Z INFO SendTelemetryHandler ExtHandler Successfully started the SendTelemetryHandler thread Oct 22 23:11:03.052184 waagent[2045]: 2026-10-22T23:11:03.052105Z INFO ExtHandler ExtHandler Start Extension Telemetry service. Oct 22 23:11:03.052218 waagent[2045]: 2026-10-22T23:11:03.051961Z INFO MonitorHandler ExtHandler Monitor.NetworkConfigurationChanges is disabled. Oct 22 23:11:03.052358 waagent[2045]: 2026-10-22T23:11:03.052330Z INFO EnvHandler ExtHandler WireServer endpoint 168.63.129.16 read from file Oct 22 23:11:03.052493 waagent[2045]: 2026-10-22T23:11:03.052469Z INFO EnvHandler ExtHandler Wire server endpoint:168.63.129.16 Oct 22 23:11:03.053079 waagent[2045]: 2026-10-22T23:11:03.052746Z INFO MonitorHandler ExtHandler Routing table from /proc/net/route: Oct 22 23:11:03.053079 waagent[2045]: Iface Destination Gateway Flags RefCnt Use Metric Mask MTU Window IRTT Oct 22 23:11:03.053079 waagent[2045]: eth0 00000000 0100000A 0003 0 0 1024 00000000 0 0 0 Oct 22 23:11:03.053079 waagent[2045]: eth0 0000000A 00000000 0001 0 0 1024 00FFFFFF 0 0 0 Oct 22 23:11:03.053079 waagent[2045]: eth0 0100000A 00000000 0005 0 0 1024 FFFFFFFF 0 0 0 Oct 22 23:11:03.053079 waagent[2045]: eth0 10813FA8 0100000A 0007 0 0 1024 FFFFFFFF 0 0 0 Oct 22 23:11:03.053079 waagent[2045]: eth0 FEA9FEA9 0100000A 0007 0 0 1024 FFFFFFFF 0 0 0 Oct 22 23:11:03.053475 waagent[2045]: 2026-10-22T23:11:03.053425Z INFO TelemetryEventsCollector ExtHandler Extension Telemetry pipeline enabled: True Oct 22 23:11:03.053535 waagent[2045]: 2026-10-22T23:11:03.053493Z INFO ExtHandler ExtHandler Goal State Period: 6 sec. This indicates how often the agent checks for new goal states and reports status. Oct 22 23:11:03.054108 waagent[2045]: 2026-10-22T23:11:03.054078Z INFO TelemetryEventsCollector ExtHandler Successfully started the TelemetryEventsCollector thread Oct 22 23:11:03.054213 waagent[2045]: 2026-10-22T23:11:03.053950Z INFO EnvHandler ExtHandler Configure routes Oct 22 23:11:03.054924 waagent[2045]: 2026-10-22T23:11:03.054547Z INFO EnvHandler ExtHandler Gateway:None Oct 22 23:11:03.054924 waagent[2045]: 2026-10-22T23:11:03.054603Z INFO EnvHandler ExtHandler Routes:None Oct 22 23:11:03.065643 waagent[2045]: 2026-10-22T23:11:03.065584Z INFO ExtHandler ExtHandler Oct 22 23:11:03.065777 waagent[2045]: 2026-10-22T23:11:03.065686Z INFO ExtHandler ExtHandler ProcessExtensionsGoalState started [incarnation_1 channel: WireServer source: Fabric activity: 72d9ea03-9a83-44f5-a06c-58c4861e27dd correlation 052f5a4a-fcc1-4a0f-b062-0a07e92a30c1 created: 2026-10-22T23:10:02.037697Z] Oct 22 23:11:03.066061 waagent[2045]: 2026-10-22T23:11:03.066026Z INFO ExtHandler ExtHandler No extension handlers found, not processing anything. Oct 22 23:11:03.066542 waagent[2045]: 2026-10-22T23:11:03.066511Z INFO ExtHandler ExtHandler ProcessExtensionsGoalState completed [incarnation_1 0 ms] Oct 22 23:11:03.120569 waagent[2045]: 2026-10-22T23:11:03.120507Z INFO ExtHandler ExtHandler [HEARTBEAT] Agent WALinuxAgent-2.12.0.4 is running as the goal state agent [DEBUG HeartbeatCounter: 0;HeartbeatId: 20C0AF18-ECBC-49B0-8D94-5FB48623A18F;DroppedPackets: 0;UpdateGSErrors: 0;AutoUpdate: 0;UpdateMode: SelfUpdate;] Oct 22 23:11:03.202938 waagent[2045]: 2026-10-22T23:11:03.202488Z INFO MonitorHandler ExtHandler Network interfaces: Oct 22 23:11:03.202938 waagent[2045]: Executing ['ip', '-a', '-o', 'link']: Oct 22 23:11:03.202938 waagent[2045]: 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 22 23:11:03.202938 waagent[2045]: 2: eth0: mtu 1500 qdisc mq state UP mode DEFAULT group default qlen 1000\ link/ether 00:0d:3a:c3:ec:1d brd ff:ff:ff:ff:ff:ff\ alias Network Device\ altname enx000d3ac3ec1d Oct 22 23:11:03.202938 waagent[2045]: 3: enP30832s1: mtu 1500 qdisc mq master eth0 state UP mode DEFAULT group default qlen 1000\ link/ether 00:0d:3a:c3:ec:1d brd ff:ff:ff:ff:ff:ff\ altname enP30832p0s0\ altname enp0s0\ altname ens1 Oct 22 23:11:03.202938 waagent[2045]: Executing ['ip', '-4', '-a', '-o', 'address']: Oct 22 23:11:03.202938 waagent[2045]: 1: lo inet 127.0.0.1/8 scope host lo\ valid_lft forever preferred_lft forever Oct 22 23:11:03.202938 waagent[2045]: 2: eth0 inet 10.0.0.22/24 metric 1024 brd 10.0.0.255 scope global eth0\ valid_lft forever preferred_lft forever Oct 22 23:11:03.202938 waagent[2045]: Executing ['ip', '-6', '-a', '-o', 'address']: Oct 22 23:11:03.202938 waagent[2045]: 1: lo inet6 ::1/128 scope host noprefixroute \ valid_lft forever preferred_lft forever Oct 22 23:11:03.202938 waagent[2045]: 2: eth0 inet6 fe80::20d:3aff:fec3:ec1d/64 scope link proto kernel_ll \ valid_lft forever preferred_lft forever Oct 22 23:11:03.285161 waagent[2045]: 2026-10-22T23:11:03.284983Z INFO EnvHandler ExtHandler Created firewall rules for the Azure Fabric: Oct 22 23:11:03.285161 waagent[2045]: Chain INPUT (policy ACCEPT 0 packets, 0 bytes) Oct 22 23:11:03.285161 waagent[2045]: pkts bytes target prot opt in out source destination Oct 22 23:11:03.285161 waagent[2045]: Chain FORWARD (policy ACCEPT 0 packets, 0 bytes) Oct 22 23:11:03.285161 waagent[2045]: pkts bytes target prot opt in out source destination Oct 22 23:11:03.285161 waagent[2045]: Chain OUTPUT (policy ACCEPT 3 packets, 534 bytes) Oct 22 23:11:03.285161 waagent[2045]: pkts bytes target prot opt in out source destination Oct 22 23:11:03.285161 waagent[2045]: 0 0 ACCEPT tcp -- * * 0.0.0.0/0 168.63.129.16 tcp dpt:53 Oct 22 23:11:03.285161 waagent[2045]: 4 416 ACCEPT tcp -- * * 0.0.0.0/0 168.63.129.16 owner UID match 0 Oct 22 23:11:03.285161 waagent[2045]: 0 0 DROP tcp -- * * 0.0.0.0/0 168.63.129.16 ctstate INVALID,NEW Oct 22 23:11:03.289795 waagent[2045]: 2026-10-22T23:11:03.289443Z INFO EnvHandler ExtHandler Current Firewall rules: Oct 22 23:11:03.289795 waagent[2045]: Chain INPUT (policy ACCEPT 0 packets, 0 bytes) Oct 22 23:11:03.289795 waagent[2045]: pkts bytes target prot opt in out source destination Oct 22 23:11:03.289795 waagent[2045]: Chain FORWARD (policy ACCEPT 0 packets, 0 bytes) Oct 22 23:11:03.289795 waagent[2045]: pkts bytes target prot opt in out source destination Oct 22 23:11:03.289795 waagent[2045]: Chain OUTPUT (policy ACCEPT 3 packets, 534 bytes) Oct 22 23:11:03.289795 waagent[2045]: pkts bytes target prot opt in out source destination Oct 22 23:11:03.289795 waagent[2045]: 0 0 ACCEPT tcp -- * * 0.0.0.0/0 168.63.129.16 tcp dpt:53 Oct 22 23:11:03.289795 waagent[2045]: 7 580 ACCEPT tcp -- * * 0.0.0.0/0 168.63.129.16 owner UID match 0 Oct 22 23:11:03.289795 waagent[2045]: 0 0 DROP tcp -- * * 0.0.0.0/0 168.63.129.16 ctstate INVALID,NEW Oct 22 23:11:03.289795 waagent[2045]: 2026-10-22T23:11:03.289796Z INFO EnvHandler ExtHandler Set block dev timeout: sda with timeout: 300 Oct 22 23:11:04.439559 containerd[1816]: time="2026-10-22T23:11:04.439495128Z" level=info msg="Start subscribing containerd event" Oct 22 23:11:04.439559 containerd[1816]: time="2026-10-22T23:11:04.439570192Z" level=info msg="Start recovering state" Oct 22 23:11:04.440043 containerd[1816]: time="2026-10-22T23:11:04.439647648Z" level=info msg="Start event monitor" Oct 22 23:11:04.440043 containerd[1816]: time="2026-10-22T23:11:04.439658064Z" level=info msg="Start cni network conf syncer for default" Oct 22 23:11:04.440043 containerd[1816]: time="2026-10-22T23:11:04.439664536Z" level=info msg="Start streaming server" Oct 22 23:11:04.440043 containerd[1816]: time="2026-10-22T23:11:04.439670888Z" level=info msg="Registered namespace \"k8s.io\" with NRI" Oct 22 23:11:04.440043 containerd[1816]: time="2026-10-22T23:11:04.439675624Z" level=info msg="runtime interface starting up..." Oct 22 23:11:04.440043 containerd[1816]: time="2026-10-22T23:11:04.439680824Z" level=info msg="starting plugins..." Oct 22 23:11:04.440043 containerd[1816]: time="2026-10-22T23:11:04.439692472Z" level=info msg="Synchronizing NRI (plugin) with current runtime state" Oct 22 23:11:04.453219 containerd[1816]: time="2026-10-22T23:11:04.453174888Z" level=info msg=serving... address=/run/containerd/containerd.sock.ttrpc Oct 22 23:11:04.453317 containerd[1816]: time="2026-10-22T23:11:04.453246504Z" level=info msg=serving... address=/run/containerd/containerd.sock Oct 22 23:11:04.480199 containerd[1816]: time="2026-10-22T23:11:04.479963800Z" level=info msg="containerd successfully booted in 3.482663s" Oct 22 23:11:04.480214 systemd[1]: Started containerd.service - containerd container runtime. Oct 22 23:11:04.484624 systemd[1]: Reached target multi-user.target - Multi-User System. Oct 22 23:11:04.489245 systemd[1]: Startup finished in 2.640s (kernel) + 14.330s (initrd) + 24.285s (userspace) = 41.256s. Oct 22 23:11:11.938304 systemd[1]: Created slice system-sshd.slice - Slice /system/sshd. Oct 22 23:11:11.939785 systemd[1]: Started sshd@0-1-10.0.0.22:22-138.226.239.234:47990.service - OpenSSH per-connection server daemon (138.226.239.234:47990). Oct 22 23:11:14.063115 sshd[2215]: Invalid user ftpuser from 138.226.239.234 port 47990 Oct 22 23:11:14.683632 sshd[2215]: Connection closed by invalid user ftpuser 138.226.239.234 port 47990 [preauth] Oct 22 23:11:14.685312 systemd[1]: sshd@0-1-10.0.0.22:22-138.226.239.234:47990.service: Deactivated successfully. Oct 22 23:11:18.768391 chronyd[1772]: Selected source PHC0 Oct 22 23:11:20.058009 systemd[1]: Started sshd@1-2-10.0.0.22:22-20.31.226.197:46104.service - OpenSSH per-connection server daemon (20.31.226.197:46104). Oct 22 23:11:20.818706 sshd[2221]: Accepted publickey for flatcar from 20.31.226.197 port 46104 ssh2: RSA SHA256:mxHc9hXVEylf6/WOffxFZjahAcZLbHFJRIQUinwYGg8 Oct 22 23:11:20.819589 sshd-session[2221]: pam_unix(sshd:session): session opened for user flatcar(uid=1000) by flatcar(uid=0) Oct 22 23:11:20.823613 systemd-logind[1786]: New session '4' of user 'flatcar' with class 'user' and type 'tty'. Oct 22 23:11:20.830915 systemd[1]: Started session-4.scope - Session 4 of User flatcar. Oct 22 23:11:21.389980 systemd[1]: Started sshd@2-4097-10.0.0.22:22-20.31.226.197:46108.service - OpenSSH per-connection server daemon (20.31.226.197:46108). Oct 22 23:11:22.109776 sshd[2228]: Accepted publickey for flatcar from 20.31.226.197 port 46108 ssh2: RSA SHA256:mxHc9hXVEylf6/WOffxFZjahAcZLbHFJRIQUinwYGg8 Oct 22 23:11:22.110504 sshd-session[2228]: pam_unix(sshd:session): session opened for user flatcar(uid=1000) by flatcar(uid=0) Oct 22 23:11:22.114671 systemd-logind[1786]: New session '5' of user 'flatcar' with class 'user' and type 'tty'. Oct 22 23:11:22.122157 systemd[1]: Started session-5.scope - Session 5 of User flatcar. Oct 22 23:11:22.524729 sshd[2232]: Connection closed by 20.31.226.197 port 46108 Oct 22 23:11:22.523724 sshd-session[2228]: pam_unix(sshd:session): session closed for user flatcar Oct 22 23:11:22.526844 systemd[1]: sshd@2-4097-10.0.0.22:22-20.31.226.197:46108.service: Deactivated successfully. Oct 22 23:11:22.528487 systemd[1]: session-5.scope: Deactivated successfully. Oct 22 23:11:22.529910 systemd-logind[1786]: Session 5 logged out. Waiting for processes to exit. Oct 22 23:11:22.530681 systemd-logind[1786]: Removed session 5. Oct 22 23:11:22.672026 systemd[1]: Started sshd@3-4098-10.0.0.22:22-20.31.226.197:46110.service - OpenSSH per-connection server daemon (20.31.226.197:46110). Oct 22 23:11:23.398739 sshd[2238]: Accepted publickey for flatcar from 20.31.226.197 port 46110 ssh2: RSA SHA256:mxHc9hXVEylf6/WOffxFZjahAcZLbHFJRIQUinwYGg8 Oct 22 23:11:23.399890 sshd-session[2238]: pam_unix(sshd:session): session opened for user flatcar(uid=1000) by flatcar(uid=0) Oct 22 23:11:23.404571 systemd-logind[1786]: New session '6' of user 'flatcar' with class 'user' and type 'tty'. Oct 22 23:11:23.410989 systemd[1]: Started session-6.scope - Session 6 of User flatcar. Oct 22 23:11:23.810216 sshd[2242]: Connection closed by 20.31.226.197 port 46110 Oct 22 23:11:23.810891 sshd-session[2238]: pam_unix(sshd:session): session closed for user flatcar Oct 22 23:11:23.813500 systemd[1]: sshd@3-4098-10.0.0.22:22-20.31.226.197:46110.service: Deactivated successfully. Oct 22 23:11:23.815186 systemd[1]: session-6.scope: Deactivated successfully. Oct 22 23:11:23.817421 systemd-logind[1786]: Session 6 logged out. Waiting for processes to exit. Oct 22 23:11:23.818719 systemd-logind[1786]: Removed session 6. Oct 22 23:11:23.973340 systemd[1]: Started sshd@4-3-10.0.0.22:22-20.31.226.197:46122.service - OpenSSH per-connection server daemon (20.31.226.197:46122). Oct 22 23:11:24.730776 sshd[2248]: Accepted publickey for flatcar from 20.31.226.197 port 46122 ssh2: RSA SHA256:mxHc9hXVEylf6/WOffxFZjahAcZLbHFJRIQUinwYGg8 Oct 22 23:11:24.731922 sshd-session[2248]: pam_unix(sshd:session): session opened for user flatcar(uid=1000) by flatcar(uid=0) Oct 22 23:11:24.736227 systemd-logind[1786]: New session '7' of user 'flatcar' with class 'user' and type 'tty'. Oct 22 23:11:24.747097 systemd[1]: Started session-7.scope - Session 7 of User flatcar. Oct 22 23:11:25.167013 sshd[2252]: Connection closed by 20.31.226.197 port 46122 Oct 22 23:11:25.167598 sshd-session[2248]: pam_unix(sshd:session): session closed for user flatcar Oct 22 23:11:25.170736 systemd[1]: sshd@4-3-10.0.0.22:22-20.31.226.197:46122.service: Deactivated successfully. Oct 22 23:11:25.172808 systemd[1]: session-7.scope: Deactivated successfully. Oct 22 23:11:25.173650 systemd-logind[1786]: Session 7 logged out. Waiting for processes to exit. Oct 22 23:11:25.175286 systemd-logind[1786]: Removed session 7. Oct 22 23:11:25.323028 systemd[1]: Started sshd@5-4-10.0.0.22:22-20.31.226.197:46130.service - OpenSSH per-connection server daemon (20.31.226.197:46130). Oct 22 23:11:26.080805 sshd[2258]: Accepted publickey for flatcar from 20.31.226.197 port 46130 ssh2: RSA SHA256:mxHc9hXVEylf6/WOffxFZjahAcZLbHFJRIQUinwYGg8 Oct 22 23:11:26.081927 sshd-session[2258]: pam_unix(sshd:session): session opened for user flatcar(uid=1000) by flatcar(uid=0) Oct 22 23:11:26.085961 systemd-logind[1786]: New session '8' of user 'flatcar' with class 'user' and type 'tty'. Oct 22 23:11:26.092907 systemd[1]: Started session-8.scope - Session 8 of User flatcar. Oct 22 23:11:26.522552 sudo[2263]: flatcar : PWD=/home/flatcar ; USER=root ; COMMAND=/usr/sbin/setenforce 1 Oct 22 23:11:26.522801 sudo[2263]: pam_unix(sudo:session): session opened for user root(uid=0) by flatcar(uid=1000) Oct 22 23:11:26.533229 sudo[2263]: pam_unix(sudo:session): session closed for user root Oct 22 23:11:26.678192 sshd[2262]: Connection closed by 20.31.226.197 port 46130 Oct 22 23:11:26.678945 sshd-session[2258]: pam_unix(sshd:session): session closed for user flatcar Oct 22 23:11:26.682438 systemd[1]: sshd@5-4-10.0.0.22:22-20.31.226.197:46130.service: Deactivated successfully. Oct 22 23:11:26.684067 systemd[1]: session-8.scope: Deactivated successfully. Oct 22 23:11:26.685198 systemd-logind[1786]: Session 8 logged out. Waiting for processes to exit. Oct 22 23:11:26.686353 systemd-logind[1786]: Removed session 8. Oct 22 23:11:26.821819 systemd[1]: Started sshd@6-4099-10.0.0.22:22-20.31.226.197:46134.service - OpenSSH per-connection server daemon (20.31.226.197:46134). Oct 22 23:11:27.539888 sshd[2271]: Accepted publickey for flatcar from 20.31.226.197 port 46134 ssh2: RSA SHA256:mxHc9hXVEylf6/WOffxFZjahAcZLbHFJRIQUinwYGg8 Oct 22 23:11:27.541049 sshd-session[2271]: pam_unix(sshd:session): session opened for user flatcar(uid=1000) by flatcar(uid=0) Oct 22 23:11:27.544997 systemd-logind[1786]: New session '9' of user 'flatcar' with class 'user' and type 'tty'. Oct 22 23:11:27.554913 systemd[1]: Started session-9.scope - Session 9 of User flatcar. Oct 22 23:11:27.818543 sudo[2277]: flatcar : PWD=/home/flatcar ; USER=root ; COMMAND=/usr/sbin/rm -rf /etc/audit/rules.d/80-selinux.rules /etc/audit/rules.d/99-default.rules Oct 22 23:11:27.818952 sudo[2277]: pam_unix(sudo:session): session opened for user root(uid=0) by flatcar(uid=1000) Oct 22 23:11:27.820256 sudo[2277]: pam_unix(sudo:session): session closed for user root Oct 22 23:11:27.825372 sudo[2276]: flatcar : PWD=/home/flatcar ; USER=root ; COMMAND=/usr/sbin/systemctl restart audit-rules Oct 22 23:11:27.825561 sudo[2276]: pam_unix(sudo:session): session opened for user root(uid=0) by flatcar(uid=1000) Oct 22 23:11:27.831926 systemd[1]: Starting audit-rules.service - Load Audit Rules... Oct 22 23:11:27.879000 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 22 23:11:27.886947 augenrules[2301]: No rules Oct 22 23:11:27.888102 kernel: kauditd_printk_skb: 82 callbacks suppressed Oct 22 23:11:27.888155 kernel: audit: type=1305 audit(1792710687.879:177): auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 op=remove_rule key=(null) list=5 res=1 Oct 22 23:11:27.879000 audit[2301]: SYSCALL arch=c00000b7 syscall=206 success=yes exit=1056 a0=3 a1=ffffe602aa00 a2=420 a3=0 items=0 ppid=2282 pid=2301 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 22 23:11:27.896667 systemd[1]: audit-rules.service: Deactivated successfully. Oct 22 23:11:27.897531 systemd[1]: Finished audit-rules.service - Load Audit Rules. Oct 22 23:11:27.911856 kernel: audit: type=1300 audit(1792710687.879:177): arch=c00000b7 syscall=206 success=yes exit=1056 a0=3 a1=ffffe602aa00 a2=420 a3=0 items=0 ppid=2282 pid=2301 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 22 23:11:27.879000 audit: PROCTITLE proctitle=2F7362696E2F617564697463746C002D52002F6574632F61756469742F61756469742E72756C6573 Oct 22 23:11:27.912184 sudo[2276]: pam_unix(sudo:session): session closed for user root Oct 22 23:11:27.919259 kernel: audit: type=1327 audit(1792710687.879:177): proctitle=2F7362696E2F617564697463746C002D52002F6574632F61756469742F61756469742E72756C6573 Oct 22 23:11:27.897000 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 22 23:11:27.931155 kernel: audit: type=1130 audit(1792710687.897:178): 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 22 23:11:27.898000 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 22 23:11:27.942209 kernel: audit: type=1131 audit(1792710687.898:179): pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=audit-rules comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Oct 22 23:11:27.911000 audit[2276]: AUDIT1106 pid=2276 uid=1000 auid=1000 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 22 23:11:27.954619 kernel: audit: type=1106 audit(1792710687.911:180): pid=2276 uid=1000 auid=1000 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 22 23:11:27.911000 audit[2276]: AUDIT1104 pid=2276 uid=1000 auid=1000 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 22 23:11:27.965782 kernel: audit: type=1104 audit(1792710687.911:181): pid=2276 uid=1000 auid=1000 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 22 23:11:28.049725 sshd[2275]: Connection closed by 20.31.226.197 port 46134 Oct 22 23:11:28.050110 sshd-session[2271]: pam_unix(sshd:session): session closed for user flatcar Oct 22 23:11:28.050000 audit[2271]: AUDIT1106 pid=2271 uid=0 auid=1000 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="flatcar" exe="/usr/lib64/misc/sshd-session" hostname=20.31.226.197 addr=20.31.226.197 terminal=ssh res=success' Oct 22 23:11:28.057034 systemd[1]: sshd@6-4099-10.0.0.22:22-20.31.226.197:46134.service: Deactivated successfully. Oct 22 23:11:28.059366 systemd[1]: session-9.scope: Deactivated successfully. Oct 22 23:11:28.061129 systemd-logind[1786]: Session 9 logged out. Waiting for processes to exit. Oct 22 23:11:28.062372 systemd-logind[1786]: Removed session 9. Oct 22 23:11:28.050000 audit[2271]: AUDIT1104 pid=2271 uid=0 auid=1000 ses=9 subj=system_u:system_r:kernel_t:s0 msg='op=PAM:setcred grantors=pam_env,pam_faillock acct="flatcar" exe="/usr/lib64/misc/sshd-session" hostname=20.31.226.197 addr=20.31.226.197 terminal=ssh res=success' Oct 22 23:11:28.075190 kernel: audit: type=1106 audit(1792710688.050:182): pid=2271 uid=0 auid=1000 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="flatcar" exe="/usr/lib64/misc/sshd-session" hostname=20.31.226.197 addr=20.31.226.197 terminal=ssh res=success' Oct 22 23:11:28.075240 kernel: audit: type=1104 audit(1792710688.050:183): pid=2271 uid=0 auid=1000 ses=9 subj=system_u:system_r:kernel_t:s0 msg='op=PAM:setcred grantors=pam_env,pam_faillock acct="flatcar" exe="/usr/lib64/misc/sshd-session" hostname=20.31.226.197 addr=20.31.226.197 terminal=ssh res=success' Oct 22 23:11:28.056000 audit[1]: SERVICE_STOP pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=sshd@6-4099-10.0.0.22:22-20.31.226.197:46134 comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Oct 22 23:11:28.084606 kernel: audit: type=1131 audit(1792710688.056:184): pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=sshd@6-4099-10.0.0.22:22-20.31.226.197:46134 comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Oct 22 23:11:28.218456 systemd[1]: Started sshd@7-4100-10.0.0.22:22-20.31.226.197:46148.service - OpenSSH per-connection server daemon (20.31.226.197:46148). Oct 22 23:11:28.217000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=sshd@7-4100-10.0.0.22:22-20.31.226.197:46148 comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Oct 22 23:11:28.967000 audit[2310]: AUDIT1101 pid=2310 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="flatcar" exe="/usr/lib64/misc/sshd-session" hostname=20.31.226.197 addr=20.31.226.197 terminal=ssh res=success' Oct 22 23:11:28.968688 sshd[2310]: Accepted publickey for flatcar from 20.31.226.197 port 46148 ssh2: RSA SHA256:mxHc9hXVEylf6/WOffxFZjahAcZLbHFJRIQUinwYGg8 Oct 22 23:11:28.968000 audit[2310]: AUDIT1103 pid=2310 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='op=PAM:setcred grantors=pam_env,pam_faillock acct="flatcar" exe="/usr/lib64/misc/sshd-session" hostname=20.31.226.197 addr=20.31.226.197 terminal=ssh res=success' Oct 22 23:11:28.968000 audit[2310]: SYSCALL arch=c00000b7 syscall=64 success=yes exit=4 a0=8 a1=ffffe443ecd0 a2=4 a3=0 items=0 ppid=1 pid=2310 auid=1000 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 22 23:11:28.968000 audit: PROCTITLE proctitle=737368642D73657373696F6E3A20666C6174636172205B707269765D Oct 22 23:11:28.970044 sshd-session[2310]: pam_unix(sshd:session): session opened for user flatcar(uid=1000) by flatcar(uid=0) Oct 22 23:11:28.974819 systemd-logind[1786]: New session '10' of user 'flatcar' with class 'user' and type 'tty'. Oct 22 23:11:28.985974 systemd[1]: Started session-10.scope - Session 10 of User flatcar. Oct 22 23:11:28.987000 audit[2310]: AUDIT1105 pid=2310 uid=0 auid=1000 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="flatcar" exe="/usr/lib64/misc/sshd-session" hostname=20.31.226.197 addr=20.31.226.197 terminal=ssh res=success' Oct 22 23:11:28.989000 audit[2314]: AUDIT1103 pid=2314 uid=0 auid=1000 ses=10 subj=system_u:system_r:kernel_t:s0 msg='op=PAM:setcred grantors=pam_env,pam_faillock acct="flatcar" exe="/usr/lib64/misc/sshd-session" hostname=20.31.226.197 addr=20.31.226.197 terminal=ssh res=success' Oct 22 23:11:29.401535 sshd[2314]: Connection closed by 20.31.226.197 port 46148 Oct 22 23:11:29.402517 sshd-session[2310]: pam_unix(sshd:session): session closed for user flatcar Oct 22 23:11:29.402000 audit[2310]: AUDIT1106 pid=2310 uid=0 auid=1000 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="flatcar" exe="/usr/lib64/misc/sshd-session" hostname=20.31.226.197 addr=20.31.226.197 terminal=ssh res=success' Oct 22 23:11:29.402000 audit[2310]: AUDIT1104 pid=2310 uid=0 auid=1000 ses=10 subj=system_u:system_r:kernel_t:s0 msg='op=PAM:setcred grantors=pam_env,pam_faillock acct="flatcar" exe="/usr/lib64/misc/sshd-session" hostname=20.31.226.197 addr=20.31.226.197 terminal=ssh res=success' Oct 22 23:11:29.405294 systemd[1]: sshd@7-4100-10.0.0.22:22-20.31.226.197:46148.service: Deactivated successfully. Oct 22 23:11:29.404000 audit[1]: SERVICE_STOP pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=sshd@7-4100-10.0.0.22:22-20.31.226.197:46148 comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Oct 22 23:11:29.407268 systemd[1]: session-10.scope: Deactivated successfully. Oct 22 23:11:29.409232 systemd-logind[1786]: Session 10 logged out. Waiting for processes to exit. Oct 22 23:11:29.410154 systemd-logind[1786]: Removed session 10.