Dec 16 12:27:08.048880 kernel: Booting Linux on physical CPU 0x0000000000 [0x410fd490] Dec 16 12:27:08.048899 kernel: Linux version 6.12.61-flatcar (build@pony-truck.infra.kinvolk.io) (aarch64-cros-linux-gnu-gcc (Gentoo Hardened 14.3.0 p8) 14.3.0, GNU ld (Gentoo 2.44 p4) 2.44.0) #1 SMP PREEMPT Fri Dec 12 15:20:48 -00 2025 Dec 16 12:27:08.048905 kernel: KASLR enabled Dec 16 12:27:08.048909 kernel: earlycon: pl11 at MMIO 0x00000000effec000 (options '') Dec 16 12:27:08.048913 kernel: printk: legacy bootconsole [pl11] enabled Dec 16 12:27:08.048918 kernel: efi: EFI v2.7 by EDK II Dec 16 12:27:08.048923 kernel: efi: ACPI 2.0=0x3f979018 SMBIOS=0x3f8a0000 SMBIOS 3.0=0x3f880000 MEMATTR=0x3e3f9018 RNG=0x3f979998 MEMRESERVE=0x3db7d598 Dec 16 12:27:08.048927 kernel: random: crng init done Dec 16 12:27:08.048931 kernel: secureboot: Secure boot disabled Dec 16 12:27:08.048935 kernel: ACPI: Early table checksum verification disabled Dec 16 12:27:08.048939 kernel: ACPI: RSDP 0x000000003F979018 000024 (v02 VRTUAL) Dec 16 12:27:08.048943 kernel: ACPI: XSDT 0x000000003F979F18 00006C (v01 VRTUAL MICROSFT 00000001 MSFT 00000001) Dec 16 12:27:08.048947 kernel: ACPI: FACP 0x000000003F979C18 000114 (v06 VRTUAL MICROSFT 00000001 MSFT 00000001) Dec 16 12:27:08.048951 kernel: ACPI: DSDT 0x000000003F95A018 01E046 (v02 MSFTVM DSDT01 00000001 INTL 20230628) Dec 16 12:27:08.048957 kernel: ACPI: DBG2 0x000000003F979B18 000072 (v00 VRTUAL MICROSFT 00000001 MSFT 00000001) Dec 16 12:27:08.048961 kernel: ACPI: GTDT 0x000000003F979D98 000060 (v02 VRTUAL MICROSFT 00000001 MSFT 00000001) Dec 16 12:27:08.048965 kernel: ACPI: OEM0 0x000000003F979098 000064 (v01 VRTUAL MICROSFT 00000001 MSFT 00000001) Dec 16 12:27:08.048969 kernel: ACPI: SPCR 0x000000003F979A98 000050 (v02 VRTUAL MICROSFT 00000001 MSFT 00000001) Dec 16 12:27:08.048973 kernel: ACPI: APIC 0x000000003F979818 0000FC (v04 VRTUAL MICROSFT 00000001 MSFT 00000001) Dec 16 12:27:08.048979 kernel: ACPI: SRAT 0x000000003F979198 000234 (v03 VRTUAL MICROSFT 00000001 MSFT 00000001) Dec 16 12:27:08.048983 kernel: ACPI: PPTT 0x000000003F979418 000120 (v01 VRTUAL MICROSFT 00000000 MSFT 00000000) Dec 16 12:27:08.048987 kernel: ACPI: BGRT 0x000000003F979E98 000038 (v01 VRTUAL MICROSFT 00000001 MSFT 00000001) Dec 16 12:27:08.048991 kernel: ACPI: SPCR: console: pl011,mmio32,0xeffec000,115200 Dec 16 12:27:08.048995 kernel: ACPI: Use ACPI SPCR as default console: Yes Dec 16 12:27:08.048999 kernel: ACPI: SRAT: Node 0 PXM 0 [mem 0x00000000-0x3fffffff] hotplug Dec 16 12:27:08.049003 kernel: ACPI: SRAT: Node 0 PXM 0 [mem 0x100000000-0x1bfffffff] hotplug Dec 16 12:27:08.049007 kernel: ACPI: SRAT: Node 0 PXM 0 [mem 0x1c0000000-0xfbfffffff] hotplug Dec 16 12:27:08.049012 kernel: ACPI: SRAT: Node 0 PXM 0 [mem 0x1000000000-0xffffffffff] hotplug Dec 16 12:27:08.049016 kernel: ACPI: SRAT: Node 0 PXM 0 [mem 0x10000000000-0x1ffffffffff] hotplug Dec 16 12:27:08.049020 kernel: ACPI: SRAT: Node 0 PXM 0 [mem 0x20000000000-0x3ffffffffff] hotplug Dec 16 12:27:08.049025 kernel: ACPI: SRAT: Node 0 PXM 0 [mem 0x40000000000-0x7ffffffffff] hotplug Dec 16 12:27:08.049029 kernel: ACPI: SRAT: Node 0 PXM 0 [mem 0x80000000000-0xfffffffffff] hotplug Dec 16 12:27:08.049033 kernel: ACPI: SRAT: Node 0 PXM 0 [mem 0x100000000000-0x1fffffffffff] hotplug Dec 16 12:27:08.049037 kernel: ACPI: SRAT: Node 0 PXM 0 [mem 0x200000000000-0x3fffffffffff] hotplug Dec 16 12:27:08.049041 kernel: ACPI: SRAT: Node 0 PXM 0 [mem 0x400000000000-0x7fffffffffff] hotplug Dec 16 12:27:08.049046 kernel: ACPI: SRAT: Node 0 PXM 0 [mem 0x800000000000-0xffffffffffff] hotplug Dec 16 12:27:08.049050 kernel: NUMA: Node 0 [mem 0x00000000-0x3fffffff] + [mem 0x100000000-0x1bfffffff] -> [mem 0x00000000-0x1bfffffff] Dec 16 12:27:08.049054 kernel: NODE_DATA(0) allocated [mem 0x1bf7ffa00-0x1bf806fff] Dec 16 12:27:08.049058 kernel: Zone ranges: Dec 16 12:27:08.049062 kernel: DMA [mem 0x0000000000000000-0x00000000ffffffff] Dec 16 12:27:08.049069 kernel: DMA32 empty Dec 16 12:27:08.049074 kernel: Normal [mem 0x0000000100000000-0x00000001bfffffff] Dec 16 12:27:08.049078 kernel: Device empty Dec 16 12:27:08.049082 kernel: Movable zone start for each node Dec 16 12:27:08.049087 kernel: Early memory node ranges Dec 16 12:27:08.049091 kernel: node 0: [mem 0x0000000000000000-0x00000000007fffff] Dec 16 12:27:08.049096 kernel: node 0: [mem 0x0000000000824000-0x000000003f38ffff] Dec 16 12:27:08.049101 kernel: node 0: [mem 0x000000003f390000-0x000000003f93ffff] Dec 16 12:27:08.049105 kernel: node 0: [mem 0x000000003f940000-0x000000003f9effff] Dec 16 12:27:08.049109 kernel: node 0: [mem 0x000000003f9f0000-0x000000003fdeffff] Dec 16 12:27:08.049114 kernel: node 0: [mem 0x000000003fdf0000-0x000000003fffffff] Dec 16 12:27:08.049118 kernel: node 0: [mem 0x0000000100000000-0x00000001bfffffff] Dec 16 12:27:08.049122 kernel: Initmem setup node 0 [mem 0x0000000000000000-0x00000001bfffffff] Dec 16 12:27:08.049127 kernel: On node 0, zone DMA: 36 pages in unavailable ranges Dec 16 12:27:08.049131 kernel: cma: Reserved 16 MiB at 0x000000003ca00000 on node -1 Dec 16 12:27:08.049135 kernel: psci: probing for conduit method from ACPI. Dec 16 12:27:08.049140 kernel: psci: PSCIv1.3 detected in firmware. Dec 16 12:27:08.049144 kernel: psci: Using standard PSCI v0.2 function IDs Dec 16 12:27:08.049149 kernel: psci: MIGRATE_INFO_TYPE not supported. Dec 16 12:27:08.049153 kernel: psci: SMC Calling Convention v1.4 Dec 16 12:27:08.049158 kernel: ACPI: NUMA: SRAT: PXM 0 -> MPIDR 0x0 -> Node 0 Dec 16 12:27:08.049162 kernel: ACPI: NUMA: SRAT: PXM 0 -> MPIDR 0x1 -> Node 0 Dec 16 12:27:08.049167 kernel: percpu: Embedded 33 pages/cpu s98200 r8192 d28776 u135168 Dec 16 12:27:08.049171 kernel: pcpu-alloc: s98200 r8192 d28776 u135168 alloc=33*4096 Dec 16 12:27:08.049175 kernel: pcpu-alloc: [0] 0 [0] 1 Dec 16 12:27:08.049180 kernel: Detected PIPT I-cache on CPU0 Dec 16 12:27:08.049184 kernel: CPU features: detected: Address authentication (architected QARMA5 algorithm) Dec 16 12:27:08.049189 kernel: CPU features: detected: GIC system register CPU interface Dec 16 12:27:08.049193 kernel: CPU features: detected: Spectre-v4 Dec 16 12:27:08.049197 kernel: CPU features: detected: Spectre-BHB Dec 16 12:27:08.049203 kernel: CPU features: kernel page table isolation forced ON by KASLR Dec 16 12:27:08.049207 kernel: CPU features: detected: Kernel page table isolation (KPTI) Dec 16 12:27:08.049211 kernel: CPU features: detected: ARM erratum 2067961 or 2054223 Dec 16 12:27:08.049216 kernel: CPU features: detected: SSBS not fully self-synchronizing Dec 16 12:27:08.049220 kernel: alternatives: applying boot alternatives Dec 16 12:27:08.049225 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=361f5baddf90aee3bc7ee7e9be879bc0cc94314f224faa1e2791d9b44cd3ec52 Dec 16 12:27:08.049230 kernel: Dentry cache hash table entries: 524288 (order: 10, 4194304 bytes, linear) Dec 16 12:27:08.049234 kernel: Inode-cache hash table entries: 262144 (order: 9, 2097152 bytes, linear) Dec 16 12:27:08.049239 kernel: Fallback order for Node 0: 0 Dec 16 12:27:08.049243 kernel: Built 1 zonelists, mobility grouping on. Total pages: 1048540 Dec 16 12:27:08.049248 kernel: Policy zone: Normal Dec 16 12:27:08.049253 kernel: mem auto-init: stack:off, heap alloc:off, heap free:off Dec 16 12:27:08.049257 kernel: software IO TLB: area num 2. Dec 16 12:27:08.049261 kernel: software IO TLB: mapped [mem 0x0000000035900000-0x0000000039900000] (64MB) Dec 16 12:27:08.049266 kernel: SLUB: HWalign=64, Order=0-3, MinObjects=0, CPUs=2, Nodes=1 Dec 16 12:27:08.049270 kernel: rcu: Preemptible hierarchical RCU implementation. Dec 16 12:27:08.049275 kernel: rcu: RCU event tracing is enabled. Dec 16 12:27:08.049280 kernel: rcu: RCU restricting CPUs from NR_CPUS=512 to nr_cpu_ids=2. Dec 16 12:27:08.049284 kernel: Trampoline variant of Tasks RCU enabled. Dec 16 12:27:08.049288 kernel: Tracing variant of Tasks RCU enabled. Dec 16 12:27:08.049293 kernel: rcu: RCU calculated value of scheduler-enlistment delay is 100 jiffies. Dec 16 12:27:08.049297 kernel: rcu: Adjusting geometry for rcu_fanout_leaf=16, nr_cpu_ids=2 Dec 16 12:27:08.049303 kernel: RCU Tasks: Setting shift to 1 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=2. Dec 16 12:27:08.049307 kernel: RCU Tasks Trace: Setting shift to 1 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=2. Dec 16 12:27:08.049312 kernel: NR_IRQS: 64, nr_irqs: 64, preallocated irqs: 0 Dec 16 12:27:08.049316 kernel: GICv3: 960 SPIs implemented Dec 16 12:27:08.049320 kernel: GICv3: 0 Extended SPIs implemented Dec 16 12:27:08.049325 kernel: Root IRQ handler: gic_handle_irq Dec 16 12:27:08.049329 kernel: GICv3: GICv3 features: 16 PPIs, RSS Dec 16 12:27:08.049333 kernel: GICv3: GICD_CTRL.DS=0, SCR_EL3.FIQ=0 Dec 16 12:27:08.049338 kernel: GICv3: CPU0: found redistributor 0 region 0:0x00000000effee000 Dec 16 12:27:08.049342 kernel: ITS: No ITS available, not enabling LPIs Dec 16 12:27:08.049347 kernel: rcu: srcu_init: Setting srcu_struct sizes based on contention. Dec 16 12:27:08.049352 kernel: arch_timer: cp15 timer(s) running at 1000.00MHz (virt). Dec 16 12:27:08.049357 kernel: clocksource: arch_sys_counter: mask: 0x1fffffffffffffff max_cycles: 0x1cd42e4dffb, max_idle_ns: 881590591483 ns Dec 16 12:27:08.049361 kernel: sched_clock: 61 bits at 1000MHz, resolution 1ns, wraps every 4398046511103ns Dec 16 12:27:08.049366 kernel: Console: colour dummy device 80x25 Dec 16 12:27:08.049371 kernel: printk: legacy console [tty1] enabled Dec 16 12:27:08.049375 kernel: ACPI: Core revision 20240827 Dec 16 12:27:08.049380 kernel: Calibrating delay loop (skipped), value calculated using timer frequency.. 2000.00 BogoMIPS (lpj=1000000) Dec 16 12:27:08.049384 kernel: pid_max: default: 32768 minimum: 301 Dec 16 12:27:08.049389 kernel: LSM: initializing lsm=lockdown,capability,landlock,selinux,ima Dec 16 12:27:08.049393 kernel: landlock: Up and running. Dec 16 12:27:08.049399 kernel: SELinux: Initializing. Dec 16 12:27:08.049403 kernel: Mount-cache hash table entries: 8192 (order: 4, 65536 bytes, linear) Dec 16 12:27:08.049408 kernel: Mountpoint-cache hash table entries: 8192 (order: 4, 65536 bytes, linear) Dec 16 12:27:08.049412 kernel: Hyper-V: privilege flags low 0x2e7f, high 0x3b8030, hints 0xa0000e, misc 0x31e1 Dec 16 12:27:08.049417 kernel: Hyper-V: Host Build 10.0.26102.1172-1-0 Dec 16 12:27:08.049425 kernel: Hyper-V: enabling crash_kexec_post_notifiers Dec 16 12:27:08.049430 kernel: rcu: Hierarchical SRCU implementation. Dec 16 12:27:08.049435 kernel: rcu: Max phase no-delay instances is 400. Dec 16 12:27:08.049440 kernel: Timer migration: 1 hierarchy levels; 8 children per group; 1 crossnode level Dec 16 12:27:08.049445 kernel: Remapping and enabling EFI services. Dec 16 12:27:08.049450 kernel: smp: Bringing up secondary CPUs ... Dec 16 12:27:08.049454 kernel: Detected PIPT I-cache on CPU1 Dec 16 12:27:08.049460 kernel: GICv3: CPU1: found redistributor 1 region 1:0x00000000f000e000 Dec 16 12:27:08.049465 kernel: CPU1: Booted secondary processor 0x0000000001 [0x410fd490] Dec 16 12:27:08.049470 kernel: smp: Brought up 1 node, 2 CPUs Dec 16 12:27:08.049474 kernel: SMP: Total of 2 processors activated. Dec 16 12:27:08.049479 kernel: CPU: All CPU(s) started at EL1 Dec 16 12:27:08.049485 kernel: CPU features: detected: 32-bit EL0 Support Dec 16 12:27:08.049489 kernel: CPU features: detected: Instruction cache invalidation not required for I/D coherence Dec 16 12:27:08.049494 kernel: CPU features: detected: Data cache clean to the PoU not required for I/D coherence Dec 16 12:27:08.049499 kernel: CPU features: detected: Common not Private translations Dec 16 12:27:08.049504 kernel: CPU features: detected: CRC32 instructions Dec 16 12:27:08.049509 kernel: CPU features: detected: Generic authentication (architected QARMA5 algorithm) Dec 16 12:27:08.049513 kernel: CPU features: detected: RCpc load-acquire (LDAPR) Dec 16 12:27:08.049518 kernel: CPU features: detected: LSE atomic instructions Dec 16 12:27:08.049523 kernel: CPU features: detected: Privileged Access Never Dec 16 12:27:08.049528 kernel: CPU features: detected: Speculation barrier (SB) Dec 16 12:27:08.049533 kernel: CPU features: detected: TLB range maintenance instructions Dec 16 12:27:08.049538 kernel: CPU features: detected: Speculative Store Bypassing Safe (SSBS) Dec 16 12:27:08.049543 kernel: CPU features: detected: Scalable Vector Extension Dec 16 12:27:08.049547 kernel: alternatives: applying system-wide alternatives Dec 16 12:27:08.049552 kernel: CPU features: detected: Hardware dirty bit management on CPU0-1 Dec 16 12:27:08.049557 kernel: SVE: maximum available vector length 16 bytes per vector Dec 16 12:27:08.049562 kernel: SVE: default vector length 16 bytes per vector Dec 16 12:27:08.049567 kernel: Memory: 3952828K/4194160K available (11200K kernel code, 2456K rwdata, 9084K rodata, 39552K init, 1038K bss, 220144K reserved, 16384K cma-reserved) Dec 16 12:27:08.049572 kernel: devtmpfs: initialized Dec 16 12:27:08.049577 kernel: clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1911260446275000 ns Dec 16 12:27:08.049582 kernel: futex hash table entries: 512 (order: 3, 32768 bytes, linear) Dec 16 12:27:08.049587 kernel: 2G module region forced by RANDOMIZE_MODULE_REGION_FULL Dec 16 12:27:08.049592 kernel: 0 pages in range for non-PLT usage Dec 16 12:27:08.049596 kernel: 508400 pages in range for PLT usage Dec 16 12:27:08.049601 kernel: pinctrl core: initialized pinctrl subsystem Dec 16 12:27:08.049606 kernel: SMBIOS 3.1.0 present. Dec 16 12:27:08.049611 kernel: DMI: Microsoft Corporation Virtual Machine/Virtual Machine, BIOS Hyper-V UEFI Release v4.1 06/10/2025 Dec 16 12:27:08.049616 kernel: DMI: Memory slots populated: 2/2 Dec 16 12:27:08.049621 kernel: NET: Registered PF_NETLINK/PF_ROUTE protocol family Dec 16 12:27:08.049626 kernel: DMA: preallocated 512 KiB GFP_KERNEL pool for atomic allocations Dec 16 12:27:08.049630 kernel: DMA: preallocated 512 KiB GFP_KERNEL|GFP_DMA pool for atomic allocations Dec 16 12:27:08.049635 kernel: DMA: preallocated 512 KiB GFP_KERNEL|GFP_DMA32 pool for atomic allocations Dec 16 12:27:08.049640 kernel: audit: initializing netlink subsys (disabled) Dec 16 12:27:08.049645 kernel: audit: type=2000 audit(0.059:1): state=initialized audit_enabled=0 res=1 Dec 16 12:27:08.049650 kernel: thermal_sys: Registered thermal governor 'step_wise' Dec 16 12:27:08.049655 kernel: cpuidle: using governor menu Dec 16 12:27:08.049660 kernel: hw-breakpoint: found 6 breakpoint and 4 watchpoint registers. Dec 16 12:27:08.049665 kernel: ASID allocator initialised with 32768 entries Dec 16 12:27:08.049669 kernel: acpiphp: ACPI Hot Plug PCI Controller Driver version: 0.5 Dec 16 12:27:08.049674 kernel: Serial: AMBA PL011 UART driver Dec 16 12:27:08.049679 kernel: HugeTLB: registered 1.00 GiB page size, pre-allocated 0 pages Dec 16 12:27:08.049683 kernel: HugeTLB: 0 KiB vmemmap can be freed for a 1.00 GiB page Dec 16 12:27:08.049688 kernel: HugeTLB: registered 32.0 MiB page size, pre-allocated 0 pages Dec 16 12:27:08.049693 kernel: HugeTLB: 0 KiB vmemmap can be freed for a 32.0 MiB page Dec 16 12:27:08.049698 kernel: HugeTLB: registered 2.00 MiB page size, pre-allocated 0 pages Dec 16 12:27:08.049703 kernel: HugeTLB: 0 KiB vmemmap can be freed for a 2.00 MiB page Dec 16 12:27:08.049708 kernel: HugeTLB: registered 64.0 KiB page size, pre-allocated 0 pages Dec 16 12:27:08.049713 kernel: HugeTLB: 0 KiB vmemmap can be freed for a 64.0 KiB page Dec 16 12:27:08.049717 kernel: ACPI: Added _OSI(Module Device) Dec 16 12:27:08.049722 kernel: ACPI: Added _OSI(Processor Device) Dec 16 12:27:08.049727 kernel: ACPI: Added _OSI(Processor Aggregator Device) Dec 16 12:27:08.049731 kernel: ACPI: 1 ACPI AML tables successfully acquired and loaded Dec 16 12:27:08.049736 kernel: ACPI: Interpreter enabled Dec 16 12:27:08.049742 kernel: ACPI: Using GIC for interrupt routing Dec 16 12:27:08.049747 kernel: ARMH0011:00: ttyAMA0 at MMIO 0xeffec000 (irq = 12, base_baud = 0) is a SBSA Dec 16 12:27:08.049751 kernel: printk: legacy console [ttyAMA0] enabled Dec 16 12:27:08.049756 kernel: printk: legacy bootconsole [pl11] disabled Dec 16 12:27:08.049761 kernel: ARMH0011:01: ttyAMA1 at MMIO 0xeffeb000 (irq = 13, base_baud = 0) is a SBSA Dec 16 12:27:08.049766 kernel: ACPI: CPU0 has been hot-added Dec 16 12:27:08.049770 kernel: ACPI: CPU1 has been hot-added Dec 16 12:27:08.049775 kernel: iommu: Default domain type: Translated Dec 16 12:27:08.049780 kernel: iommu: DMA domain TLB invalidation policy: strict mode Dec 16 12:27:08.049785 kernel: efivars: Registered efivars operations Dec 16 12:27:08.049790 kernel: vgaarb: loaded Dec 16 12:27:08.049795 kernel: clocksource: Switched to clocksource arch_sys_counter Dec 16 12:27:08.049799 kernel: VFS: Disk quotas dquot_6.6.0 Dec 16 12:27:08.049804 kernel: VFS: Dquot-cache hash table entries: 512 (order 0, 4096 bytes) Dec 16 12:27:08.049809 kernel: pnp: PnP ACPI init Dec 16 12:27:08.049814 kernel: pnp: PnP ACPI: found 0 devices Dec 16 12:27:08.049818 kernel: NET: Registered PF_INET protocol family Dec 16 12:27:08.049823 kernel: IP idents hash table entries: 65536 (order: 7, 524288 bytes, linear) Dec 16 12:27:08.049828 kernel: tcp_listen_portaddr_hash hash table entries: 2048 (order: 3, 32768 bytes, linear) Dec 16 12:27:08.049834 kernel: Table-perturb hash table entries: 65536 (order: 6, 262144 bytes, linear) Dec 16 12:27:08.049848 kernel: TCP established hash table entries: 32768 (order: 6, 262144 bytes, linear) Dec 16 12:27:08.049854 kernel: TCP bind hash table entries: 32768 (order: 8, 1048576 bytes, linear) Dec 16 12:27:08.049858 kernel: TCP: Hash tables configured (established 32768 bind 32768) Dec 16 12:27:08.049863 kernel: UDP hash table entries: 2048 (order: 4, 65536 bytes, linear) Dec 16 12:27:08.049868 kernel: UDP-Lite hash table entries: 2048 (order: 4, 65536 bytes, linear) Dec 16 12:27:08.049873 kernel: NET: Registered PF_UNIX/PF_LOCAL protocol family Dec 16 12:27:08.049878 kernel: PCI: CLS 0 bytes, default 64 Dec 16 12:27:08.049882 kernel: kvm [1]: HYP mode not available Dec 16 12:27:08.049888 kernel: Initialise system trusted keyrings Dec 16 12:27:08.049893 kernel: workingset: timestamp_bits=39 max_order=20 bucket_order=0 Dec 16 12:27:08.049897 kernel: Key type asymmetric registered Dec 16 12:27:08.049902 kernel: Asymmetric key parser 'x509' registered Dec 16 12:27:08.049907 kernel: Block layer SCSI generic (bsg) driver version 0.4 loaded (major 249) Dec 16 12:27:08.049912 kernel: io scheduler mq-deadline registered Dec 16 12:27:08.049916 kernel: io scheduler kyber registered Dec 16 12:27:08.049921 kernel: io scheduler bfq registered Dec 16 12:27:08.049926 kernel: Serial: 8250/16550 driver, 4 ports, IRQ sharing enabled Dec 16 12:27:08.049931 kernel: thunder_xcv, ver 1.0 Dec 16 12:27:08.049936 kernel: thunder_bgx, ver 1.0 Dec 16 12:27:08.049941 kernel: nicpf, ver 1.0 Dec 16 12:27:08.049945 kernel: nicvf, ver 1.0 Dec 16 12:27:08.050055 kernel: rtc-efi rtc-efi.0: registered as rtc0 Dec 16 12:27:08.050106 kernel: rtc-efi rtc-efi.0: setting system clock to 2025-12-16T12:27:07 UTC (1765888027) Dec 16 12:27:08.050112 kernel: efifb: probing for efifb Dec 16 12:27:08.050118 kernel: efifb: framebuffer at 0x40000000, using 3072k, total 3072k Dec 16 12:27:08.050123 kernel: efifb: mode is 1024x768x32, linelength=4096, pages=1 Dec 16 12:27:08.050128 kernel: efifb: scrolling: redraw Dec 16 12:27:08.050133 kernel: efifb: Truecolor: size=8:8:8:8, shift=24:16:8:0 Dec 16 12:27:08.050137 kernel: Console: switching to colour frame buffer device 128x48 Dec 16 12:27:08.050142 kernel: fb0: EFI VGA frame buffer device Dec 16 12:27:08.050147 kernel: SMCCC: SOC_ID: ARCH_SOC_ID not implemented, skipping .... Dec 16 12:27:08.050152 kernel: hid: raw HID events driver (C) Jiri Kosina Dec 16 12:27:08.050157 kernel: hw perfevents: enabled with armv8_pmuv3_0 PMU driver, 7 (0,8000003f) counters available Dec 16 12:27:08.050162 kernel: watchdog: NMI not fully supported Dec 16 12:27:08.050167 kernel: watchdog: Hard watchdog permanently disabled Dec 16 12:27:08.050172 kernel: NET: Registered PF_INET6 protocol family Dec 16 12:27:08.050176 kernel: Segment Routing with IPv6 Dec 16 12:27:08.050181 kernel: In-situ OAM (IOAM) with IPv6 Dec 16 12:27:08.050186 kernel: NET: Registered PF_PACKET protocol family Dec 16 12:27:08.050190 kernel: Key type dns_resolver registered Dec 16 12:27:08.050195 kernel: registered taskstats version 1 Dec 16 12:27:08.050200 kernel: Loading compiled-in X.509 certificates Dec 16 12:27:08.050205 kernel: Loaded X.509 cert 'Kinvolk GmbH: Module signing key for 6.12.61-flatcar: 92f3a94fb747a7ba7cbcfde1535be91b86f9429a' Dec 16 12:27:08.050210 kernel: Demotion targets for Node 0: null Dec 16 12:27:08.050215 kernel: Key type .fscrypt registered Dec 16 12:27:08.050220 kernel: Key type fscrypt-provisioning registered Dec 16 12:27:08.050224 kernel: ima: No TPM chip found, activating TPM-bypass! Dec 16 12:27:08.050229 kernel: ima: Allocated hash algorithm: sha1 Dec 16 12:27:08.050234 kernel: ima: No architecture policies found Dec 16 12:27:08.050239 kernel: alg: No test for fips(ansi_cprng) (fips_ansi_cprng) Dec 16 12:27:08.050243 kernel: clk: Disabling unused clocks Dec 16 12:27:08.050248 kernel: PM: genpd: Disabling unused power domains Dec 16 12:27:08.050254 kernel: Warning: unable to open an initial console. Dec 16 12:27:08.050259 kernel: Freeing unused kernel memory: 39552K Dec 16 12:27:08.050263 kernel: Run /init as init process Dec 16 12:27:08.050268 kernel: with arguments: Dec 16 12:27:08.050273 kernel: /init Dec 16 12:27:08.050277 kernel: with environment: Dec 16 12:27:08.050282 kernel: HOME=/ Dec 16 12:27:08.050286 kernel: TERM=linux Dec 16 12:27:08.050292 systemd[1]: Successfully made /usr/ read-only. Dec 16 12:27:08.050300 systemd[1]: systemd 256.8 running in system mode (+PAM +AUDIT +SELINUX -APPARMOR +IMA +SMACK +SECCOMP -GCRYPT -GNUTLS +OPENSSL -ACL +BLKID +CURL +ELFUTILS -FIDO2 +IDN2 -IDN +IPTC +KMOD +LIBCRYPTSETUP +LIBCRYPTSETUP_PLUGINS +LIBFDISK +PCRE2 -PWQUALITY -P11KIT -QRENCODE +TPM2 +BZIP2 +LZ4 +XZ +ZLIB +ZSTD -BPF_FRAMEWORK -XKBCOMMON +UTMP -SYSVINIT +LIBARCHIVE) Dec 16 12:27:08.050306 systemd[1]: Detected virtualization microsoft. Dec 16 12:27:08.050311 systemd[1]: Detected architecture arm64. Dec 16 12:27:08.050316 systemd[1]: Running in initrd. Dec 16 12:27:08.050321 systemd[1]: No hostname configured, using default hostname. Dec 16 12:27:08.050326 systemd[1]: Hostname set to . Dec 16 12:27:08.050331 systemd[1]: Initializing machine ID from random generator. Dec 16 12:27:08.050337 systemd[1]: Queued start job for default target initrd.target. Dec 16 12:27:08.050342 systemd[1]: Started clevis-luks-askpass.path - Forward Password Requests to Clevis Directory Watch. Dec 16 12:27:08.050347 systemd[1]: Started systemd-ask-password-console.path - Dispatch Password Requests to Console Directory Watch. Dec 16 12:27:08.050353 systemd[1]: Expecting device dev-disk-by\x2dlabel-EFI\x2dSYSTEM.device - /dev/disk/by-label/EFI-SYSTEM... Dec 16 12:27:08.050358 systemd[1]: Expecting device dev-disk-by\x2dlabel-OEM.device - /dev/disk/by-label/OEM... Dec 16 12:27:08.050364 systemd[1]: Expecting device dev-disk-by\x2dlabel-ROOT.device - /dev/disk/by-label/ROOT... Dec 16 12:27:08.050369 systemd[1]: Expecting device dev-disk-by\x2dpartlabel-USR\x2dA.device - /dev/disk/by-partlabel/USR-A... Dec 16 12:27:08.050376 systemd[1]: Expecting device dev-disk-by\x2dpartuuid-7130c94a\x2d213a\x2d4e5a\x2d8e26\x2d6cce9662f132.device - /dev/disk/by-partuuid/7130c94a-213a-4e5a-8e26-6cce9662f132... Dec 16 12:27:08.050382 systemd[1]: Expecting device dev-mapper-usr.device - /dev/mapper/usr... Dec 16 12:27:08.050387 systemd[1]: Reached target cryptsetup-pre.target - Local Encrypted Volumes (Pre). Dec 16 12:27:08.050392 systemd[1]: Reached target cryptsetup.target - Local Encrypted Volumes. Dec 16 12:27:08.050397 systemd[1]: Reached target paths.target - Path Units. Dec 16 12:27:08.050402 systemd[1]: Reached target slices.target - Slice Units. Dec 16 12:27:08.050407 systemd[1]: Reached target swap.target - Swaps. Dec 16 12:27:08.050413 systemd[1]: Reached target timers.target - Timer Units. Dec 16 12:27:08.050419 systemd[1]: Listening on iscsid.socket - Open-iSCSI iscsid Socket. Dec 16 12:27:08.050424 systemd[1]: Listening on iscsiuio.socket - Open-iSCSI iscsiuio Socket. Dec 16 12:27:08.050429 systemd[1]: Listening on systemd-journald-dev-log.socket - Journal Socket (/dev/log). Dec 16 12:27:08.050434 systemd[1]: Listening on systemd-journald.socket - Journal Sockets. Dec 16 12:27:08.050440 systemd[1]: Listening on systemd-networkd.socket - Network Service Netlink Socket. Dec 16 12:27:08.050445 systemd[1]: Listening on systemd-udevd-control.socket - udev Control Socket. Dec 16 12:27:08.050450 systemd[1]: Listening on systemd-udevd-kernel.socket - udev Kernel Socket. Dec 16 12:27:08.050455 systemd[1]: Reached target sockets.target - Socket Units. Dec 16 12:27:08.050460 systemd[1]: Starting ignition-setup-pre.service - Ignition env setup... Dec 16 12:27:08.050467 systemd[1]: Starting kmod-static-nodes.service - Create List of Static Device Nodes... Dec 16 12:27:08.050472 systemd[1]: Finished network-cleanup.service - Network Cleanup. Dec 16 12:27:08.050477 systemd[1]: systemd-battery-check.service - Check battery level during early boot was skipped because of an unmet condition check (ConditionDirectoryNotEmpty=/sys/class/power_supply). Dec 16 12:27:08.050483 systemd[1]: Starting systemd-fsck-usr.service... Dec 16 12:27:08.050488 systemd[1]: Starting systemd-journald.service - Journal Service... Dec 16 12:27:08.050493 systemd[1]: Starting systemd-modules-load.service - Load Kernel Modules... Dec 16 12:27:08.050508 systemd-journald[226]: Collecting audit messages is disabled. Dec 16 12:27:08.050524 systemd-journald[226]: Journal started Dec 16 12:27:08.050537 systemd-journald[226]: Runtime Journal (/run/log/journal/f7dda99badf446adb27b096cd15b5cd8) is 8M, max 78.3M, 70.3M free. Dec 16 12:27:08.057882 systemd[1]: Starting systemd-vconsole-setup.service - Virtual Console Setup... Dec 16 12:27:08.063140 systemd-modules-load[228]: Inserted module 'overlay' Dec 16 12:27:08.082860 kernel: bridge: filtering via arp/ip/ip6tables is no longer available by default. Update your scripts to load br_netfilter if you need this. Dec 16 12:27:08.090785 systemd[1]: Started systemd-journald.service - Journal Service. Dec 16 12:27:08.093297 systemd-modules-load[228]: Inserted module 'br_netfilter' Dec 16 12:27:08.096746 kernel: Bridge firewalling registered Dec 16 12:27:08.094166 systemd[1]: Finished ignition-setup-pre.service - Ignition env setup. Dec 16 12:27:08.102104 systemd[1]: Finished kmod-static-nodes.service - Create List of Static Device Nodes. Dec 16 12:27:08.110339 systemd[1]: Finished systemd-fsck-usr.service. Dec 16 12:27:08.115548 systemd[1]: Finished systemd-modules-load.service - Load Kernel Modules. Dec 16 12:27:08.126263 systemd[1]: Finished systemd-vconsole-setup.service - Virtual Console Setup. Dec 16 12:27:08.135670 systemd[1]: Starting dracut-cmdline-ask.service - dracut ask for additional cmdline parameters... Dec 16 12:27:08.149422 systemd[1]: Starting systemd-sysctl.service - Apply Kernel Variables... Dec 16 12:27:08.164829 systemd[1]: Starting systemd-tmpfiles-setup-dev-early.service - Create Static Device Nodes in /dev gracefully... Dec 16 12:27:08.178540 systemd[1]: Starting systemd-tmpfiles-setup.service - Create System Files and Directories... Dec 16 12:27:08.189155 systemd[1]: Finished systemd-sysctl.service - Apply Kernel Variables. Dec 16 12:27:08.194548 systemd-tmpfiles[245]: /usr/lib/tmpfiles.d/var.conf:14: Duplicate line for path "/var/log", ignoring. Dec 16 12:27:08.206030 systemd[1]: Finished systemd-tmpfiles-setup-dev-early.service - Create Static Device Nodes in /dev gracefully. Dec 16 12:27:08.211683 systemd[1]: Finished systemd-tmpfiles-setup.service - Create System Files and Directories. Dec 16 12:27:08.216937 systemd[1]: Finished dracut-cmdline-ask.service - dracut ask for additional cmdline parameters. Dec 16 12:27:08.229646 systemd[1]: Starting dracut-cmdline.service - dracut cmdline hook... Dec 16 12:27:08.254664 systemd[1]: Starting systemd-resolved.service - Network Name Resolution... Dec 16 12:27:08.264950 systemd[1]: Starting systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev... Dec 16 12:27:08.282725 dracut-cmdline[261]: Using kernel command line parameters: rd.driver.pre=btrfs 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=361f5baddf90aee3bc7ee7e9be879bc0cc94314f224faa1e2791d9b44cd3ec52 Dec 16 12:27:08.307296 systemd[1]: Finished systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev. Dec 16 12:27:08.331188 systemd-resolved[262]: Positive Trust Anchors: Dec 16 12:27:08.331207 systemd-resolved[262]: . IN DS 20326 8 2 e06d44b80b8f1d39a95c0b0d7c65d08458e880409bbc683457104237c7f8ec8d Dec 16 12:27:08.331227 systemd-resolved[262]: 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 Dec 16 12:27:08.332914 systemd-resolved[262]: Defaulting to hostname 'linux'. Dec 16 12:27:08.334411 systemd[1]: Started systemd-resolved.service - Network Name Resolution. Dec 16 12:27:08.345539 systemd[1]: Reached target nss-lookup.target - Host and Network Name Lookups. Dec 16 12:27:08.424867 kernel: SCSI subsystem initialized Dec 16 12:27:08.430873 kernel: Loading iSCSI transport class v2.0-870. Dec 16 12:27:08.437857 kernel: iscsi: registered transport (tcp) Dec 16 12:27:08.451211 kernel: iscsi: registered transport (qla4xxx) Dec 16 12:27:08.451264 kernel: QLogic iSCSI HBA Driver Dec 16 12:27:08.465426 systemd[1]: Starting systemd-network-generator.service - Generate network units from Kernel command line... Dec 16 12:27:08.489857 systemd[1]: Finished systemd-network-generator.service - Generate network units from Kernel command line. Dec 16 12:27:08.496502 systemd[1]: Reached target network-pre.target - Preparation for Network. Dec 16 12:27:08.546722 systemd[1]: Finished dracut-cmdline.service - dracut cmdline hook. Dec 16 12:27:08.552481 systemd[1]: Starting dracut-pre-udev.service - dracut pre-udev hook... Dec 16 12:27:08.624859 kernel: raid6: neonx8 gen() 18544 MB/s Dec 16 12:27:08.638847 kernel: raid6: neonx4 gen() 18547 MB/s Dec 16 12:27:08.657847 kernel: raid6: neonx2 gen() 17102 MB/s Dec 16 12:27:08.677847 kernel: raid6: neonx1 gen() 15026 MB/s Dec 16 12:27:08.696847 kernel: raid6: int64x8 gen() 10533 MB/s Dec 16 12:27:08.715848 kernel: raid6: int64x4 gen() 10606 MB/s Dec 16 12:27:08.736860 kernel: raid6: int64x2 gen() 8964 MB/s Dec 16 12:27:08.757744 kernel: raid6: int64x1 gen() 7044 MB/s Dec 16 12:27:08.757757 kernel: raid6: using algorithm neonx4 gen() 18547 MB/s Dec 16 12:27:08.780468 kernel: raid6: .... xor() 15131 MB/s, rmw enabled Dec 16 12:27:08.780476 kernel: raid6: using neon recovery algorithm Dec 16 12:27:08.790459 kernel: xor: measuring software checksum speed Dec 16 12:27:08.790469 kernel: 8regs : 28637 MB/sec Dec 16 12:27:08.793301 kernel: 32regs : 28737 MB/sec Dec 16 12:27:08.796072 kernel: arm64_neon : 37580 MB/sec Dec 16 12:27:08.799462 kernel: xor: using function: arm64_neon (37580 MB/sec) Dec 16 12:27:08.838873 kernel: Btrfs loaded, zoned=no, fsverity=no Dec 16 12:27:08.845920 systemd[1]: Finished dracut-pre-udev.service - dracut pre-udev hook. Dec 16 12:27:08.856778 systemd[1]: Starting systemd-udevd.service - Rule-based Manager for Device Events and Files... Dec 16 12:27:08.889886 systemd-udevd[474]: Using default interface naming scheme 'v255'. Dec 16 12:27:08.894180 systemd[1]: Started systemd-udevd.service - Rule-based Manager for Device Events and Files. Dec 16 12:27:08.907933 systemd[1]: Starting dracut-pre-trigger.service - dracut pre-trigger hook... Dec 16 12:27:08.935369 dracut-pre-trigger[484]: rd.md=0: removing MD RAID activation Dec 16 12:27:08.955075 systemd[1]: Finished dracut-pre-trigger.service - dracut pre-trigger hook. Dec 16 12:27:08.962168 systemd[1]: Starting systemd-udev-trigger.service - Coldplug All udev Devices... Dec 16 12:27:09.009607 systemd[1]: Finished systemd-udev-trigger.service - Coldplug All udev Devices. Dec 16 12:27:09.022260 systemd[1]: Starting dracut-initqueue.service - dracut initqueue hook... Dec 16 12:27:09.076866 kernel: hv_vmbus: Vmbus version:5.3 Dec 16 12:27:09.094866 kernel: hv_vmbus: registering driver hyperv_keyboard Dec 16 12:27:09.094924 kernel: hv_vmbus: registering driver hid_hyperv Dec 16 12:27:09.098867 kernel: hv_vmbus: registering driver hv_storvsc Dec 16 12:27:09.098964 systemd[1]: systemd-vconsole-setup.service: Deactivated successfully. Dec 16 12:27:09.129924 kernel: input: AT Translated Set 2 keyboard as /devices/LNXSYSTM:00/LNXSYBUS:00/ACPI0004:00/MSFT1000:00/d34b2567-b9b6-42b9-8778-0a4ec0b955bf/serio0/input/input0 Dec 16 12:27:09.129947 kernel: pps_core: LinuxPPS API ver. 1 registered Dec 16 12:27:09.129966 kernel: scsi host0: storvsc_host_t Dec 16 12:27:09.130127 kernel: hv_vmbus: registering driver hv_netvsc Dec 16 12:27:09.130134 kernel: scsi 0:0:0:0: Direct-Access Msft Virtual Disk 1.0 PQ: 0 ANSI: 5 Dec 16 12:27:09.130152 kernel: scsi 0:0:0:2: CD-ROM Msft Virtual DVD-ROM 1.0 PQ: 0 ANSI: 5 Dec 16 12:27:09.112206 systemd[1]: Stopped systemd-vconsole-setup.service - Virtual Console Setup. Dec 16 12:27:09.157565 kernel: input: Microsoft Vmbus HID-compliant Mouse as /devices/0006:045E:0621.0001/input/input1 Dec 16 12:27:09.157591 kernel: scsi host1: storvsc_host_t Dec 16 12:27:09.157751 kernel: pps_core: Software ver. 5.3.6 - Copyright 2005-2007 Rodolfo Giometti Dec 16 12:27:09.157759 kernel: hid-hyperv 0006:045E:0621.0001: input: VIRTUAL HID v0.01 Mouse [Microsoft Vmbus HID-compliant Mouse] on Dec 16 12:27:09.157314 systemd[1]: Stopping systemd-vconsole-setup.service - Virtual Console Setup... Dec 16 12:27:09.167900 systemd[1]: Starting systemd-vconsole-setup.service - Virtual Console Setup... Dec 16 12:27:09.181453 systemd[1]: run-credentials-systemd\x2dvconsole\x2dsetup.service.mount: Deactivated successfully. Dec 16 12:27:09.187861 kernel: PTP clock support registered Dec 16 12:27:09.199856 kernel: sd 0:0:0:0: [sda] 63737856 512-byte logical blocks: (32.6 GB/30.4 GiB) Dec 16 12:27:09.200049 kernel: hv_utils: Registering HyperV Utility Driver Dec 16 12:27:09.200058 kernel: sd 0:0:0:0: [sda] 4096-byte physical blocks Dec 16 12:27:09.200126 kernel: hv_vmbus: registering driver hv_utils Dec 16 12:27:09.212011 kernel: hv_utils: Heartbeat IC version 3.0 Dec 16 12:27:09.212067 kernel: hv_utils: Shutdown IC version 3.2 Dec 16 12:27:09.212074 kernel: sd 0:0:0:0: [sda] Write Protect is off Dec 16 12:27:09.212256 kernel: hv_utils: TimeSync IC version 4.0 Dec 16 12:27:09.212264 kernel: sd 0:0:0:0: [sda] Mode Sense: 0f 00 10 00 Dec 16 12:27:09.212864 kernel: sd 0:0:0:0: [sda] Write cache: disabled, read cache: enabled, supports DPO and FUA Dec 16 12:27:08.875830 systemd-resolved[262]: Clock change detected. Flushing caches. Dec 16 12:27:08.902755 kernel: hv_storvsc f8b3781a-1e82-4818-a1c3-63d806ec15bb: tag#251 cmd 0x5a status: scsi 0x2 srb 0x86 hv 0xc0000001 Dec 16 12:27:08.902879 kernel: hv_storvsc f8b3781a-1e82-4818-a1c3-63d806ec15bb: tag#194 cmd 0x5a status: scsi 0x2 srb 0x86 hv 0xc0000001 Dec 16 12:27:08.902937 systemd-journald[226]: Time jumped backwards, rotating. Dec 16 12:27:08.882553 systemd[1]: systemd-vconsole-setup.service: Deactivated successfully. Dec 16 12:27:08.882653 systemd[1]: Stopped systemd-vconsole-setup.service - Virtual Console Setup. Dec 16 12:27:08.918272 kernel: hv_netvsc 002248b5-deeb-0022-48b5-deeb002248b5 eth0: VF slot 1 added Dec 16 12:27:08.901571 systemd[1]: run-credentials-systemd\x2dvconsole\x2dsetup.service.mount: Deactivated successfully. Dec 16 12:27:08.904299 systemd[1]: Starting systemd-vconsole-setup.service - Virtual Console Setup... Dec 16 12:27:08.937610 kernel: sda: sda1 sda2 sda3 sda4 sda6 sda7 sda9 Dec 16 12:27:08.937626 kernel: sd 0:0:0:0: [sda] Attached SCSI disk Dec 16 12:27:08.947035 kernel: sr 0:0:0:2: [sr0] scsi-1 drive Dec 16 12:27:08.947294 kernel: hv_vmbus: registering driver hv_pci Dec 16 12:27:08.947303 kernel: cdrom: Uniform CD-ROM driver Revision: 3.20 Dec 16 12:27:08.948212 kernel: hv_pci 79539479-4944-4bde-93e7-6c371fa306f4: PCI VMBus probing: Using version 0x10004 Dec 16 12:27:08.957949 kernel: hv_pci 79539479-4944-4bde-93e7-6c371fa306f4: PCI host bridge to bus 4944:00 Dec 16 12:27:08.958108 kernel: sr 0:0:0:2: Attached scsi CD-ROM sr0 Dec 16 12:27:08.958205 kernel: pci_bus 4944:00: root bus resource [mem 0xfc0000000-0xfc00fffff window] Dec 16 12:27:08.971237 kernel: pci_bus 4944:00: No busn resource found for root bus, will use [bus 00-ff] Dec 16 12:27:08.971410 kernel: pci 4944:00:02.0: [15b3:101a] type 00 class 0x020000 PCIe Endpoint Dec 16 12:27:08.982240 kernel: pci 4944:00:02.0: BAR 0 [mem 0xfc0000000-0xfc00fffff 64bit pref] Dec 16 12:27:08.983224 systemd[1]: Finished systemd-vconsole-setup.service - Virtual Console Setup. Dec 16 12:27:08.997231 kernel: pci 4944:00:02.0: enabling Extended Tags Dec 16 12:27:09.006323 kernel: pci 4944:00:02.0: 0.000 Gb/s available PCIe bandwidth, limited by Unknown x0 link at 4944:00:02.0 (capable of 252.048 Gb/s with 16.0 GT/s PCIe x16 link) Dec 16 12:27:09.017655 kernel: pci_bus 4944:00: busn_res: [bus 00-ff] end is updated to 00 Dec 16 12:27:09.017843 kernel: pci 4944:00:02.0: BAR 0 [mem 0xfc0000000-0xfc00fffff 64bit pref]: assigned Dec 16 12:27:09.018527 kernel: hv_storvsc f8b3781a-1e82-4818-a1c3-63d806ec15bb: tag#173 cmd 0x85 status: scsi 0x2 srb 0x6 hv 0xc0000001 Dec 16 12:27:09.051210 kernel: hv_storvsc f8b3781a-1e82-4818-a1c3-63d806ec15bb: tag#250 cmd 0x85 status: scsi 0x2 srb 0x6 hv 0xc0000001 Dec 16 12:27:09.082705 kernel: mlx5_core 4944:00:02.0: enabling device (0000 -> 0002) Dec 16 12:27:09.090917 kernel: mlx5_core 4944:00:02.0: PTM is not supported by PCIe Dec 16 12:27:09.091073 kernel: mlx5_core 4944:00:02.0: firmware version: 16.30.5006 Dec 16 12:27:09.267261 kernel: hv_netvsc 002248b5-deeb-0022-48b5-deeb002248b5 eth0: VF registering: eth1 Dec 16 12:27:09.267455 kernel: mlx5_core 4944:00:02.0 eth1: joined to eth0 Dec 16 12:27:09.272327 kernel: mlx5_core 4944:00:02.0: MLX5E: StrdRq(1) RqSz(8) StrdSz(2048) RxCqeCmprss(0 basic) Dec 16 12:27:09.282208 kernel: mlx5_core 4944:00:02.0 enP18756s1: renamed from eth1 Dec 16 12:27:09.434222 systemd[1]: Found device dev-disk-by\x2dlabel-EFI\x2dSYSTEM.device - Virtual_Disk EFI-SYSTEM. Dec 16 12:27:09.526592 systemd[1]: Found device dev-disk-by\x2dlabel-ROOT.device - Virtual_Disk ROOT. Dec 16 12:27:09.553376 systemd[1]: Found device dev-disk-by\x2dlabel-OEM.device - Virtual_Disk OEM. Dec 16 12:27:09.586542 systemd[1]: Found device dev-disk-by\x2dpartuuid-7130c94a\x2d213a\x2d4e5a\x2d8e26\x2d6cce9662f132.device - Virtual_Disk USR-A. Dec 16 12:27:09.591874 systemd[1]: Found device dev-disk-by\x2dpartlabel-USR\x2dA.device - Virtual_Disk USR-A. Dec 16 12:27:09.615794 systemd[1]: Finished dracut-initqueue.service - dracut initqueue hook. Dec 16 12:27:09.621010 systemd[1]: Reached target remote-fs-pre.target - Preparation for Remote File Systems. Dec 16 12:27:09.629742 systemd[1]: Reached target remote-cryptsetup.target - Remote Encrypted Volumes. Dec 16 12:27:09.639203 systemd[1]: Reached target remote-fs.target - Remote File Systems. Dec 16 12:27:09.648857 systemd[1]: Starting disk-uuid.service - Generate new UUID for disk GPT if necessary... Dec 16 12:27:09.671317 systemd[1]: Starting dracut-pre-mount.service - dracut pre-mount hook... Dec 16 12:27:09.691198 kernel: hv_storvsc f8b3781a-1e82-4818-a1c3-63d806ec15bb: tag#228 cmd 0x5a status: scsi 0x2 srb 0x86 hv 0xc0000001 Dec 16 12:27:09.706753 kernel: sda: sda1 sda2 sda3 sda4 sda6 sda7 sda9 Dec 16 12:27:09.708256 systemd[1]: Finished dracut-pre-mount.service - dracut pre-mount hook. Dec 16 12:27:10.720806 kernel: hv_storvsc f8b3781a-1e82-4818-a1c3-63d806ec15bb: tag#187 cmd 0x5a status: scsi 0x2 srb 0x86 hv 0xc0000001 Dec 16 12:27:10.734293 kernel: sda: sda1 sda2 sda3 sda4 sda6 sda7 sda9 Dec 16 12:27:10.734338 disk-uuid[658]: The operation has completed successfully. Dec 16 12:27:10.807303 systemd[1]: disk-uuid.service: Deactivated successfully. Dec 16 12:27:10.807401 systemd[1]: Finished disk-uuid.service - Generate new UUID for disk GPT if necessary. Dec 16 12:27:10.831840 systemd[1]: Starting verity-setup.service - Verity Setup for /dev/mapper/usr... Dec 16 12:27:10.854629 sh[823]: Success Dec 16 12:27:10.891150 kernel: device-mapper: core: CONFIG_IMA_DISABLE_HTABLE is disabled. Duplicate IMA measurements will not be recorded in the IMA log. Dec 16 12:27:10.891219 kernel: device-mapper: uevent: version 1.0.3 Dec 16 12:27:10.896715 kernel: device-mapper: ioctl: 4.48.0-ioctl (2023-03-01) initialised: dm-devel@lists.linux.dev Dec 16 12:27:10.907206 kernel: device-mapper: verity: sha256 using shash "sha256-ce" Dec 16 12:27:11.189914 systemd[1]: Found device dev-mapper-usr.device - /dev/mapper/usr. Dec 16 12:27:11.195789 systemd[1]: Mounting sysusr-usr.mount - /sysusr/usr... Dec 16 12:27:11.219261 systemd[1]: Finished verity-setup.service - Verity Setup for /dev/mapper/usr. Dec 16 12:27:11.241229 kernel: BTRFS: device fsid 6d6d314d-b8a1-4727-8a34-8525e276a248 devid 1 transid 38 /dev/mapper/usr (254:0) scanned by mount (841) Dec 16 12:27:11.251451 kernel: BTRFS info (device dm-0): first mount of filesystem 6d6d314d-b8a1-4727-8a34-8525e276a248 Dec 16 12:27:11.251489 kernel: BTRFS info (device dm-0): using crc32c (crc32c-generic) checksum algorithm Dec 16 12:27:11.494908 kernel: BTRFS info (device dm-0): disabling log replay at mount time Dec 16 12:27:11.494983 kernel: BTRFS info (device dm-0): enabling free space tree Dec 16 12:27:11.527562 systemd[1]: Mounted sysusr-usr.mount - /sysusr/usr. Dec 16 12:27:11.531731 systemd[1]: Reached target initrd-usr-fs.target - Initrd /usr File System. Dec 16 12:27:11.539107 systemd[1]: afterburn-network-kargs.service - Afterburn Initrd Setup Network Kernel Arguments was skipped because no trigger condition checks were met. Dec 16 12:27:11.539884 systemd[1]: Starting ignition-setup.service - Ignition (setup)... Dec 16 12:27:11.564981 systemd[1]: Starting parse-ip-for-networkd.service - Write systemd-networkd units from cmdline... Dec 16 12:27:11.599583 kernel: BTRFS: device label OEM devid 1 transid 12 /dev/sda6 (8:6) scanned by mount (864) Dec 16 12:27:11.599631 kernel: BTRFS info (device sda6): first mount of filesystem 4b8ce5a5-a2aa-4c44-bc9b-80e30d06d25f Dec 16 12:27:11.604340 kernel: BTRFS info (device sda6): using crc32c (crc32c-generic) checksum algorithm Dec 16 12:27:11.630467 kernel: BTRFS info (device sda6): turning on async discard Dec 16 12:27:11.630528 kernel: BTRFS info (device sda6): enabling free space tree Dec 16 12:27:11.639209 kernel: BTRFS info (device sda6): last unmount of filesystem 4b8ce5a5-a2aa-4c44-bc9b-80e30d06d25f Dec 16 12:27:11.641019 systemd[1]: Finished ignition-setup.service - Ignition (setup). Dec 16 12:27:11.646201 systemd[1]: Starting ignition-fetch-offline.service - Ignition (fetch-offline)... Dec 16 12:27:11.689446 systemd[1]: Finished parse-ip-for-networkd.service - Write systemd-networkd units from cmdline. Dec 16 12:27:11.700374 systemd[1]: Starting systemd-networkd.service - Network Configuration... Dec 16 12:27:11.734056 systemd-networkd[1010]: lo: Link UP Dec 16 12:27:11.734069 systemd-networkd[1010]: lo: Gained carrier Dec 16 12:27:11.735174 systemd-networkd[1010]: Enumeration completed Dec 16 12:27:11.736686 systemd[1]: Started systemd-networkd.service - Network Configuration. Dec 16 12:27:11.736976 systemd-networkd[1010]: eth0: found matching network '/usr/lib/systemd/network/zz-default.network', based on potentially unpredictable interface name. Dec 16 12:27:11.736979 systemd-networkd[1010]: eth0: Configuring with /usr/lib/systemd/network/zz-default.network. Dec 16 12:27:11.741098 systemd[1]: Reached target network.target - Network. Dec 16 12:27:11.799200 kernel: mlx5_core 4944:00:02.0 enP18756s1: Link up Dec 16 12:27:11.833870 systemd-networkd[1010]: enP18756s1: Link UP Dec 16 12:27:11.837556 kernel: hv_netvsc 002248b5-deeb-0022-48b5-deeb002248b5 eth0: Data path switched to VF: enP18756s1 Dec 16 12:27:11.833930 systemd-networkd[1010]: eth0: Link UP Dec 16 12:27:11.834035 systemd-networkd[1010]: eth0: Gained carrier Dec 16 12:27:11.834050 systemd-networkd[1010]: eth0: found matching network '/usr/lib/systemd/network/zz-default.network', based on potentially unpredictable interface name. Dec 16 12:27:11.844247 systemd-networkd[1010]: enP18756s1: Gained carrier Dec 16 12:27:11.861235 systemd-networkd[1010]: eth0: DHCPv4 address 10.200.20.16/24, gateway 10.200.20.1 acquired from 168.63.129.16 Dec 16 12:27:12.776454 ignition[955]: Ignition 2.22.0 Dec 16 12:27:12.778925 ignition[955]: Stage: fetch-offline Dec 16 12:27:12.779052 ignition[955]: no configs at "/usr/lib/ignition/base.d" Dec 16 12:27:12.782311 systemd[1]: Finished ignition-fetch-offline.service - Ignition (fetch-offline). Dec 16 12:27:12.779059 ignition[955]: no config dir at "/usr/lib/ignition/base.platform.d/azure" Dec 16 12:27:12.792481 systemd[1]: Starting ignition-fetch.service - Ignition (fetch)... Dec 16 12:27:12.779139 ignition[955]: parsed url from cmdline: "" Dec 16 12:27:12.779141 ignition[955]: no config URL provided Dec 16 12:27:12.779215 ignition[955]: reading system config file "/usr/lib/ignition/user.ign" Dec 16 12:27:12.779225 ignition[955]: no config at "/usr/lib/ignition/user.ign" Dec 16 12:27:12.779230 ignition[955]: failed to fetch config: resource requires networking Dec 16 12:27:12.779373 ignition[955]: Ignition finished successfully Dec 16 12:27:12.824799 ignition[1024]: Ignition 2.22.0 Dec 16 12:27:12.824804 ignition[1024]: Stage: fetch Dec 16 12:27:12.825068 ignition[1024]: no configs at "/usr/lib/ignition/base.d" Dec 16 12:27:12.825076 ignition[1024]: no config dir at "/usr/lib/ignition/base.platform.d/azure" Dec 16 12:27:12.825165 ignition[1024]: parsed url from cmdline: "" Dec 16 12:27:12.825167 ignition[1024]: no config URL provided Dec 16 12:27:12.825170 ignition[1024]: reading system config file "/usr/lib/ignition/user.ign" Dec 16 12:27:12.825175 ignition[1024]: no config at "/usr/lib/ignition/user.ign" Dec 16 12:27:12.825198 ignition[1024]: GET http://169.254.169.254/metadata/instance/compute/userData?api-version=2021-01-01&format=text: attempt #1 Dec 16 12:27:12.916716 ignition[1024]: GET result: OK Dec 16 12:27:12.916758 ignition[1024]: config has been read from IMDS userdata Dec 16 12:27:12.916771 ignition[1024]: parsing config with SHA512: c8a685192ca351873cb7be4716545c128229764593b4c4b02fda23d04f04db473f835262ba90c14083b6634d875fc5dc4d87a7baec704ba9a8adcd28e1d91c75 Dec 16 12:27:12.919331 unknown[1024]: fetched base config from "system" Dec 16 12:27:12.919447 ignition[1024]: fetch: fetch complete Dec 16 12:27:12.919337 unknown[1024]: fetched base config from "system" Dec 16 12:27:12.919450 ignition[1024]: fetch: fetch passed Dec 16 12:27:12.919340 unknown[1024]: fetched user config from "azure" Dec 16 12:27:12.919492 ignition[1024]: Ignition finished successfully Dec 16 12:27:12.921199 systemd[1]: Finished ignition-fetch.service - Ignition (fetch). Dec 16 12:27:12.927994 systemd[1]: Starting ignition-kargs.service - Ignition (kargs)... Dec 16 12:27:12.963566 ignition[1031]: Ignition 2.22.0 Dec 16 12:27:12.963582 ignition[1031]: Stage: kargs Dec 16 12:27:12.967370 systemd[1]: Finished ignition-kargs.service - Ignition (kargs). Dec 16 12:27:12.963749 ignition[1031]: no configs at "/usr/lib/ignition/base.d" Dec 16 12:27:12.974389 systemd[1]: Starting ignition-disks.service - Ignition (disks)... Dec 16 12:27:12.963758 ignition[1031]: no config dir at "/usr/lib/ignition/base.platform.d/azure" Dec 16 12:27:12.964066 ignition[1031]: kargs: kargs passed Dec 16 12:27:12.964105 ignition[1031]: Ignition finished successfully Dec 16 12:27:13.008726 ignition[1037]: Ignition 2.22.0 Dec 16 12:27:13.008741 ignition[1037]: Stage: disks Dec 16 12:27:13.008890 ignition[1037]: no configs at "/usr/lib/ignition/base.d" Dec 16 12:27:13.012521 systemd[1]: Finished ignition-disks.service - Ignition (disks). Dec 16 12:27:13.008896 ignition[1037]: no config dir at "/usr/lib/ignition/base.platform.d/azure" Dec 16 12:27:13.017774 systemd[1]: Reached target initrd-root-device.target - Initrd Root Device. Dec 16 12:27:13.009310 ignition[1037]: disks: disks passed Dec 16 12:27:13.026103 systemd[1]: Reached target local-fs-pre.target - Preparation for Local File Systems. Dec 16 12:27:13.009352 ignition[1037]: Ignition finished successfully Dec 16 12:27:13.035009 systemd[1]: Reached target local-fs.target - Local File Systems. Dec 16 12:27:13.043325 systemd[1]: Reached target sysinit.target - System Initialization. Dec 16 12:27:13.052157 systemd[1]: Reached target basic.target - Basic System. Dec 16 12:27:13.060295 systemd[1]: Starting systemd-fsck-root.service - File System Check on /dev/disk/by-label/ROOT... Dec 16 12:27:13.151314 systemd-fsck[1046]: ROOT: clean, 15/7326000 files, 477845/7359488 blocks Dec 16 12:27:13.156095 systemd[1]: Finished systemd-fsck-root.service - File System Check on /dev/disk/by-label/ROOT. Dec 16 12:27:13.162932 systemd[1]: Mounting sysroot.mount - /sysroot... Dec 16 12:27:13.304485 systemd-networkd[1010]: eth0: Gained IPv6LL Dec 16 12:27:13.487213 kernel: EXT4-fs (sda9): mounted filesystem 895d7845-d0e8-43ae-a778-7804b473b868 r/w with ordered data mode. Quota mode: none. Dec 16 12:27:13.487095 systemd[1]: Mounted sysroot.mount - /sysroot. Dec 16 12:27:13.491504 systemd[1]: Reached target initrd-root-fs.target - Initrd Root File System. Dec 16 12:27:13.515319 systemd[1]: Mounting sysroot-oem.mount - /sysroot/oem... Dec 16 12:27:13.533374 systemd[1]: Mounting sysroot-usr.mount - /sysroot/usr... Dec 16 12:27:13.543306 systemd[1]: Starting flatcar-metadata-hostname.service - Flatcar Metadata Hostname Agent... Dec 16 12:27:13.550223 systemd[1]: ignition-remount-sysroot.service - Remount /sysroot read-write for Ignition was skipped because of an unmet condition check (ConditionPathIsReadWrite=!/sysroot). Dec 16 12:27:13.550253 systemd[1]: Reached target ignition-diskful.target - Ignition Boot Disk Setup. Dec 16 12:27:13.560565 systemd[1]: Mounted sysroot-usr.mount - /sysroot/usr. Dec 16 12:27:13.578346 systemd[1]: Starting initrd-setup-root.service - Root filesystem setup... Dec 16 12:27:13.604246 kernel: BTRFS: device label OEM devid 1 transid 12 /dev/sda6 (8:6) scanned by mount (1060) Dec 16 12:27:13.604285 kernel: BTRFS info (device sda6): first mount of filesystem 4b8ce5a5-a2aa-4c44-bc9b-80e30d06d25f Dec 16 12:27:13.609295 kernel: BTRFS info (device sda6): using crc32c (crc32c-generic) checksum algorithm Dec 16 12:27:13.618834 kernel: BTRFS info (device sda6): turning on async discard Dec 16 12:27:13.618879 kernel: BTRFS info (device sda6): enabling free space tree Dec 16 12:27:13.620052 systemd[1]: Mounted sysroot-oem.mount - /sysroot/oem. Dec 16 12:27:14.013015 coreos-metadata[1062]: Dec 16 12:27:14.012 INFO Fetching http://168.63.129.16/?comp=versions: Attempt #1 Dec 16 12:27:14.022015 coreos-metadata[1062]: Dec 16 12:27:14.021 INFO Fetch successful Dec 16 12:27:14.026209 coreos-metadata[1062]: Dec 16 12:27:14.022 INFO Fetching http://169.254.169.254/metadata/instance/compute/name?api-version=2017-08-01&format=text: Attempt #1 Dec 16 12:27:14.034822 coreos-metadata[1062]: Dec 16 12:27:14.030 INFO Fetch successful Dec 16 12:27:14.045120 coreos-metadata[1062]: Dec 16 12:27:14.045 INFO wrote hostname ci-4459.2.2-a-0f7d42d5a2 to /sysroot/etc/hostname Dec 16 12:27:14.052346 systemd[1]: Finished flatcar-metadata-hostname.service - Flatcar Metadata Hostname Agent. Dec 16 12:27:14.593326 initrd-setup-root[1090]: cut: /sysroot/etc/passwd: No such file or directory Dec 16 12:27:14.636510 initrd-setup-root[1097]: cut: /sysroot/etc/group: No such file or directory Dec 16 12:27:14.656169 initrd-setup-root[1104]: cut: /sysroot/etc/shadow: No such file or directory Dec 16 12:27:14.677703 initrd-setup-root[1111]: cut: /sysroot/etc/gshadow: No such file or directory Dec 16 12:27:15.757329 systemd[1]: Finished initrd-setup-root.service - Root filesystem setup. Dec 16 12:27:15.764293 systemd[1]: Starting ignition-mount.service - Ignition (mount)... Dec 16 12:27:15.780809 systemd[1]: Starting sysroot-boot.service - /sysroot/boot... Dec 16 12:27:15.790716 systemd[1]: sysroot-oem.mount: Deactivated successfully. Dec 16 12:27:15.800204 kernel: BTRFS info (device sda6): last unmount of filesystem 4b8ce5a5-a2aa-4c44-bc9b-80e30d06d25f Dec 16 12:27:15.821922 systemd[1]: Finished sysroot-boot.service - /sysroot/boot. Dec 16 12:27:15.826413 ignition[1179]: INFO : Ignition 2.22.0 Dec 16 12:27:15.826413 ignition[1179]: INFO : Stage: mount Dec 16 12:27:15.826413 ignition[1179]: INFO : no configs at "/usr/lib/ignition/base.d" Dec 16 12:27:15.826413 ignition[1179]: INFO : no config dir at "/usr/lib/ignition/base.platform.d/azure" Dec 16 12:27:15.826413 ignition[1179]: INFO : mount: mount passed Dec 16 12:27:15.826413 ignition[1179]: INFO : Ignition finished successfully Dec 16 12:27:15.833269 systemd[1]: Finished ignition-mount.service - Ignition (mount). Dec 16 12:27:15.842606 systemd[1]: Starting ignition-files.service - Ignition (files)... Dec 16 12:27:15.872503 systemd[1]: Mounting sysroot-oem.mount - /sysroot/oem... Dec 16 12:27:15.897201 kernel: BTRFS: device label OEM devid 1 transid 12 /dev/sda6 (8:6) scanned by mount (1191) Dec 16 12:27:15.906531 kernel: BTRFS info (device sda6): first mount of filesystem 4b8ce5a5-a2aa-4c44-bc9b-80e30d06d25f Dec 16 12:27:15.906576 kernel: BTRFS info (device sda6): using crc32c (crc32c-generic) checksum algorithm Dec 16 12:27:15.915831 kernel: BTRFS info (device sda6): turning on async discard Dec 16 12:27:15.915848 kernel: BTRFS info (device sda6): enabling free space tree Dec 16 12:27:15.917419 systemd[1]: Mounted sysroot-oem.mount - /sysroot/oem. Dec 16 12:27:15.947765 ignition[1208]: INFO : Ignition 2.22.0 Dec 16 12:27:15.947765 ignition[1208]: INFO : Stage: files Dec 16 12:27:15.953456 ignition[1208]: INFO : no configs at "/usr/lib/ignition/base.d" Dec 16 12:27:15.953456 ignition[1208]: INFO : no config dir at "/usr/lib/ignition/base.platform.d/azure" Dec 16 12:27:15.953456 ignition[1208]: DEBUG : files: compiled without relabeling support, skipping Dec 16 12:27:15.967313 ignition[1208]: INFO : files: ensureUsers: op(1): [started] creating or modifying user "core" Dec 16 12:27:15.967313 ignition[1208]: DEBUG : files: ensureUsers: op(1): executing: "usermod" "--root" "/sysroot" "core" Dec 16 12:27:16.018968 ignition[1208]: INFO : files: ensureUsers: op(1): [finished] creating or modifying user "core" Dec 16 12:27:16.024722 ignition[1208]: INFO : files: ensureUsers: op(2): [started] adding ssh keys to user "core" Dec 16 12:27:16.024722 ignition[1208]: INFO : files: ensureUsers: op(2): [finished] adding ssh keys to user "core" Dec 16 12:27:16.019435 unknown[1208]: wrote ssh authorized keys file for user: core Dec 16 12:27:16.093921 ignition[1208]: INFO : files: createFilesystemsFiles: createFiles: op(3): [started] writing file "/sysroot/etc/flatcar/update.conf" Dec 16 12:27:16.100945 ignition[1208]: INFO : files: createFilesystemsFiles: createFiles: op(3): [finished] writing file "/sysroot/etc/flatcar/update.conf" Dec 16 12:27:16.100945 ignition[1208]: INFO : files: createResultFile: createFiles: op(4): [started] writing file "/sysroot/etc/.ignition-result.json" Dec 16 12:27:16.100945 ignition[1208]: INFO : files: createResultFile: createFiles: op(4): [finished] writing file "/sysroot/etc/.ignition-result.json" Dec 16 12:27:16.100945 ignition[1208]: INFO : files: files passed Dec 16 12:27:16.100945 ignition[1208]: INFO : Ignition finished successfully Dec 16 12:27:16.102440 systemd[1]: Finished ignition-files.service - Ignition (files). Dec 16 12:27:16.112845 systemd[1]: Starting ignition-quench.service - Ignition (record completion)... Dec 16 12:27:16.139774 systemd[1]: Starting initrd-setup-root-after-ignition.service - Root filesystem completion... Dec 16 12:27:16.154534 systemd[1]: ignition-quench.service: Deactivated successfully. Dec 16 12:27:16.165314 systemd[1]: Finished ignition-quench.service - Ignition (record completion). Dec 16 12:27:16.222700 initrd-setup-root-after-ignition[1237]: grep: /sysroot/etc/flatcar/enabled-sysext.conf: No such file or directory Dec 16 12:27:16.222700 initrd-setup-root-after-ignition[1237]: grep: /sysroot/usr/share/flatcar/enabled-sysext.conf: No such file or directory Dec 16 12:27:16.235960 initrd-setup-root-after-ignition[1241]: grep: /sysroot/etc/flatcar/enabled-sysext.conf: No such file or directory Dec 16 12:27:16.230400 systemd[1]: Finished initrd-setup-root-after-ignition.service - Root filesystem completion. Dec 16 12:27:16.240958 systemd[1]: Reached target ignition-complete.target - Ignition Complete. Dec 16 12:27:16.251915 systemd[1]: Starting initrd-parse-etc.service - Mountpoints Configured in the Real Root... Dec 16 12:27:16.294525 systemd[1]: initrd-parse-etc.service: Deactivated successfully. Dec 16 12:27:16.295388 systemd[1]: Finished initrd-parse-etc.service - Mountpoints Configured in the Real Root. Dec 16 12:27:16.304036 systemd[1]: Reached target initrd-fs.target - Initrd File Systems. Dec 16 12:27:16.313255 systemd[1]: Reached target initrd.target - Initrd Default Target. Dec 16 12:27:16.320936 systemd[1]: dracut-mount.service - dracut mount hook was skipped because no trigger condition checks were met. Dec 16 12:27:16.321711 systemd[1]: Starting dracut-pre-pivot.service - dracut pre-pivot and cleanup hook... Dec 16 12:27:16.349781 systemd[1]: Finished dracut-pre-pivot.service - dracut pre-pivot and cleanup hook. Dec 16 12:27:16.356264 systemd[1]: Starting initrd-cleanup.service - Cleaning Up and Shutting Down Daemons... Dec 16 12:27:16.384746 systemd[1]: Stopped target nss-lookup.target - Host and Network Name Lookups. Dec 16 12:27:16.389636 systemd[1]: Stopped target remote-cryptsetup.target - Remote Encrypted Volumes. Dec 16 12:27:16.398390 systemd[1]: Stopped target timers.target - Timer Units. Dec 16 12:27:16.406896 systemd[1]: dracut-pre-pivot.service: Deactivated successfully. Dec 16 12:27:16.407006 systemd[1]: Stopped dracut-pre-pivot.service - dracut pre-pivot and cleanup hook. Dec 16 12:27:16.418108 systemd[1]: Stopped target initrd.target - Initrd Default Target. Dec 16 12:27:16.422313 systemd[1]: Stopped target basic.target - Basic System. Dec 16 12:27:16.430159 systemd[1]: Stopped target ignition-complete.target - Ignition Complete. Dec 16 12:27:16.438039 systemd[1]: Stopped target ignition-diskful.target - Ignition Boot Disk Setup. Dec 16 12:27:16.445975 systemd[1]: Stopped target initrd-root-device.target - Initrd Root Device. Dec 16 12:27:16.454757 systemd[1]: Stopped target initrd-usr-fs.target - Initrd /usr File System. Dec 16 12:27:16.463854 systemd[1]: Stopped target remote-fs.target - Remote File Systems. Dec 16 12:27:16.472420 systemd[1]: Stopped target remote-fs-pre.target - Preparation for Remote File Systems. Dec 16 12:27:16.481201 systemd[1]: Stopped target sysinit.target - System Initialization. Dec 16 12:27:16.489273 systemd[1]: Stopped target local-fs.target - Local File Systems. Dec 16 12:27:16.498359 systemd[1]: Stopped target swap.target - Swaps. Dec 16 12:27:16.505388 systemd[1]: dracut-pre-mount.service: Deactivated successfully. Dec 16 12:27:16.505494 systemd[1]: Stopped dracut-pre-mount.service - dracut pre-mount hook. Dec 16 12:27:16.516626 systemd[1]: Stopped target cryptsetup.target - Local Encrypted Volumes. Dec 16 12:27:16.520986 systemd[1]: Stopped target cryptsetup-pre.target - Local Encrypted Volumes (Pre). Dec 16 12:27:16.529518 systemd[1]: clevis-luks-askpass.path: Deactivated successfully. Dec 16 12:27:16.533472 systemd[1]: Stopped clevis-luks-askpass.path - Forward Password Requests to Clevis Directory Watch. Dec 16 12:27:16.538664 systemd[1]: dracut-initqueue.service: Deactivated successfully. Dec 16 12:27:16.538764 systemd[1]: Stopped dracut-initqueue.service - dracut initqueue hook. Dec 16 12:27:16.553466 systemd[1]: initrd-setup-root-after-ignition.service: Deactivated successfully. Dec 16 12:27:16.553559 systemd[1]: Stopped initrd-setup-root-after-ignition.service - Root filesystem completion. Dec 16 12:27:16.558996 systemd[1]: ignition-files.service: Deactivated successfully. Dec 16 12:27:16.559070 systemd[1]: Stopped ignition-files.service - Ignition (files). Dec 16 12:27:16.568421 systemd[1]: flatcar-metadata-hostname.service: Deactivated successfully. Dec 16 12:27:16.568489 systemd[1]: Stopped flatcar-metadata-hostname.service - Flatcar Metadata Hostname Agent. Dec 16 12:27:16.584346 systemd[1]: Stopping ignition-mount.service - Ignition (mount)... Dec 16 12:27:16.640629 ignition[1261]: INFO : Ignition 2.22.0 Dec 16 12:27:16.640629 ignition[1261]: INFO : Stage: umount Dec 16 12:27:16.640629 ignition[1261]: INFO : no configs at "/usr/lib/ignition/base.d" Dec 16 12:27:16.640629 ignition[1261]: INFO : no config dir at "/usr/lib/ignition/base.platform.d/azure" Dec 16 12:27:16.640629 ignition[1261]: INFO : umount: umount passed Dec 16 12:27:16.640629 ignition[1261]: INFO : Ignition finished successfully Dec 16 12:27:16.598032 systemd[1]: kmod-static-nodes.service: Deactivated successfully. Dec 16 12:27:16.598173 systemd[1]: Stopped kmod-static-nodes.service - Create List of Static Device Nodes. Dec 16 12:27:16.616348 systemd[1]: Stopping sysroot-boot.service - /sysroot/boot... Dec 16 12:27:16.631696 systemd[1]: systemd-udev-trigger.service: Deactivated successfully. Dec 16 12:27:16.631838 systemd[1]: Stopped systemd-udev-trigger.service - Coldplug All udev Devices. Dec 16 12:27:16.636900 systemd[1]: dracut-pre-trigger.service: Deactivated successfully. Dec 16 12:27:16.637016 systemd[1]: Stopped dracut-pre-trigger.service - dracut pre-trigger hook. Dec 16 12:27:16.646977 systemd[1]: ignition-mount.service: Deactivated successfully. Dec 16 12:27:16.648721 systemd[1]: Stopped ignition-mount.service - Ignition (mount). Dec 16 12:27:16.663058 systemd[1]: ignition-disks.service: Deactivated successfully. Dec 16 12:27:16.663322 systemd[1]: Stopped ignition-disks.service - Ignition (disks). Dec 16 12:27:16.671756 systemd[1]: ignition-kargs.service: Deactivated successfully. Dec 16 12:27:16.671808 systemd[1]: Stopped ignition-kargs.service - Ignition (kargs). Dec 16 12:27:16.679096 systemd[1]: ignition-fetch.service: Deactivated successfully. Dec 16 12:27:16.679133 systemd[1]: Stopped ignition-fetch.service - Ignition (fetch). Dec 16 12:27:16.688830 systemd[1]: Stopped target network.target - Network. Dec 16 12:27:16.695824 systemd[1]: ignition-fetch-offline.service: Deactivated successfully. Dec 16 12:27:16.695873 systemd[1]: Stopped ignition-fetch-offline.service - Ignition (fetch-offline). Dec 16 12:27:16.705425 systemd[1]: Stopped target paths.target - Path Units. Dec 16 12:27:16.713994 systemd[1]: systemd-ask-password-console.path: Deactivated successfully. Dec 16 12:27:16.717578 systemd[1]: Stopped systemd-ask-password-console.path - Dispatch Password Requests to Console Directory Watch. Dec 16 12:27:16.724052 systemd[1]: Stopped target slices.target - Slice Units. Dec 16 12:27:16.732048 systemd[1]: Stopped target sockets.target - Socket Units. Dec 16 12:27:16.739996 systemd[1]: iscsid.socket: Deactivated successfully. Dec 16 12:27:16.740044 systemd[1]: Closed iscsid.socket - Open-iSCSI iscsid Socket. Dec 16 12:27:16.747909 systemd[1]: iscsiuio.socket: Deactivated successfully. Dec 16 12:27:16.747951 systemd[1]: Closed iscsiuio.socket - Open-iSCSI iscsiuio Socket. Dec 16 12:27:16.756108 systemd[1]: ignition-setup.service: Deactivated successfully. Dec 16 12:27:16.756159 systemd[1]: Stopped ignition-setup.service - Ignition (setup). Dec 16 12:27:16.763758 systemd[1]: ignition-setup-pre.service: Deactivated successfully. Dec 16 12:27:16.763787 systemd[1]: Stopped ignition-setup-pre.service - Ignition env setup. Dec 16 12:27:16.772154 systemd[1]: Stopping systemd-networkd.service - Network Configuration... Dec 16 12:27:16.779634 systemd[1]: Stopping systemd-resolved.service - Network Name Resolution... Dec 16 12:27:16.793414 systemd[1]: sysroot-boot.mount: Deactivated successfully. Dec 16 12:27:16.793919 systemd[1]: initrd-cleanup.service: Deactivated successfully. Dec 16 12:27:16.793994 systemd[1]: Finished initrd-cleanup.service - Cleaning Up and Shutting Down Daemons. Dec 16 12:27:16.802494 systemd[1]: systemd-resolved.service: Deactivated successfully. Dec 16 12:27:16.802590 systemd[1]: Stopped systemd-resolved.service - Network Name Resolution. Dec 16 12:27:16.815085 systemd[1]: run-credentials-systemd\x2dresolved.service.mount: Deactivated successfully. Dec 16 12:27:16.990975 kernel: hv_netvsc 002248b5-deeb-0022-48b5-deeb002248b5 eth0: Data path switched from VF: enP18756s1 Dec 16 12:27:16.815293 systemd[1]: systemd-networkd.service: Deactivated successfully. Dec 16 12:27:16.815387 systemd[1]: Stopped systemd-networkd.service - Network Configuration. Dec 16 12:27:16.827698 systemd[1]: run-credentials-systemd\x2dnetworkd.service.mount: Deactivated successfully. Dec 16 12:27:16.827922 systemd[1]: sysroot-boot.service: Deactivated successfully. Dec 16 12:27:16.828012 systemd[1]: Stopped sysroot-boot.service - /sysroot/boot. Dec 16 12:27:16.836610 systemd[1]: Stopped target network-pre.target - Preparation for Network. Dec 16 12:27:16.843792 systemd[1]: systemd-networkd.socket: Deactivated successfully. Dec 16 12:27:16.843830 systemd[1]: Closed systemd-networkd.socket - Network Service Netlink Socket. Dec 16 12:27:16.854264 systemd[1]: initrd-setup-root.service: Deactivated successfully. Dec 16 12:27:16.854329 systemd[1]: Stopped initrd-setup-root.service - Root filesystem setup. Dec 16 12:27:16.863019 systemd[1]: Stopping network-cleanup.service - Network Cleanup... Dec 16 12:27:16.871850 systemd[1]: parse-ip-for-networkd.service: Deactivated successfully. Dec 16 12:27:16.871910 systemd[1]: Stopped parse-ip-for-networkd.service - Write systemd-networkd units from cmdline. Dec 16 12:27:16.877027 systemd[1]: systemd-sysctl.service: Deactivated successfully. Dec 16 12:27:16.877065 systemd[1]: Stopped systemd-sysctl.service - Apply Kernel Variables. Dec 16 12:27:16.887780 systemd[1]: systemd-modules-load.service: Deactivated successfully. Dec 16 12:27:16.887819 systemd[1]: Stopped systemd-modules-load.service - Load Kernel Modules. Dec 16 12:27:16.893930 systemd[1]: systemd-tmpfiles-setup.service: Deactivated successfully. Dec 16 12:27:16.893987 systemd[1]: Stopped systemd-tmpfiles-setup.service - Create System Files and Directories. Dec 16 12:27:16.906501 systemd[1]: Stopping systemd-udevd.service - Rule-based Manager for Device Events and Files... Dec 16 12:27:16.914440 systemd[1]: run-credentials-systemd\x2dsysctl.service.mount: Deactivated successfully. Dec 16 12:27:16.914506 systemd[1]: run-credentials-systemd\x2dtmpfiles\x2dsetup.service.mount: Deactivated successfully. Dec 16 12:27:16.936941 systemd[1]: systemd-udevd.service: Deactivated successfully. Dec 16 12:27:16.938400 systemd[1]: Stopped systemd-udevd.service - Rule-based Manager for Device Events and Files. Dec 16 12:27:16.946090 systemd[1]: systemd-udevd-control.socket: Deactivated successfully. Dec 16 12:27:16.946128 systemd[1]: Closed systemd-udevd-control.socket - udev Control Socket. Dec 16 12:27:16.954481 systemd[1]: systemd-udevd-kernel.socket: Deactivated successfully. Dec 16 12:27:16.954508 systemd[1]: Closed systemd-udevd-kernel.socket - udev Kernel Socket. Dec 16 12:27:16.962417 systemd[1]: dracut-pre-udev.service: Deactivated successfully. Dec 16 12:27:16.962469 systemd[1]: Stopped dracut-pre-udev.service - dracut pre-udev hook. Dec 16 12:27:16.975481 systemd[1]: dracut-cmdline.service: Deactivated successfully. Dec 16 12:27:16.975522 systemd[1]: Stopped dracut-cmdline.service - dracut cmdline hook. Dec 16 12:27:16.999215 systemd[1]: dracut-cmdline-ask.service: Deactivated successfully. Dec 16 12:27:16.999271 systemd[1]: Stopped dracut-cmdline-ask.service - dracut ask for additional cmdline parameters. Dec 16 12:27:17.013668 systemd[1]: Starting initrd-udevadm-cleanup-db.service - Cleanup udev Database... Dec 16 12:27:17.027421 systemd[1]: systemd-network-generator.service: Deactivated successfully. Dec 16 12:27:17.027493 systemd[1]: Stopped systemd-network-generator.service - Generate network units from Kernel command line. Dec 16 12:27:17.040364 systemd[1]: systemd-tmpfiles-setup-dev.service: Deactivated successfully. Dec 16 12:27:17.040413 systemd[1]: Stopped systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev. Dec 16 12:27:17.050343 systemd[1]: systemd-vconsole-setup.service: Deactivated successfully. Dec 16 12:27:17.050385 systemd[1]: Stopped systemd-vconsole-setup.service - Virtual Console Setup. Dec 16 12:27:17.223205 systemd-journald[226]: Received SIGTERM from PID 1 (systemd). Dec 16 12:27:17.059796 systemd[1]: run-credentials-systemd\x2dnetwork\x2dgenerator.service.mount: Deactivated successfully. Dec 16 12:27:17.059838 systemd[1]: run-credentials-systemd\x2dtmpfiles\x2dsetup\x2ddev.service.mount: Deactivated successfully. Dec 16 12:27:17.059864 systemd[1]: run-credentials-systemd\x2dvconsole\x2dsetup.service.mount: Deactivated successfully. Dec 16 12:27:17.060062 systemd[1]: initrd-udevadm-cleanup-db.service: Deactivated successfully. Dec 16 12:27:17.060157 systemd[1]: Finished initrd-udevadm-cleanup-db.service - Cleanup udev Database. Dec 16 12:27:17.074030 systemd[1]: network-cleanup.service: Deactivated successfully. Dec 16 12:27:17.074143 systemd[1]: Stopped network-cleanup.service - Network Cleanup. Dec 16 12:27:17.081378 systemd[1]: Reached target initrd-switch-root.target - Switch Root. Dec 16 12:27:17.090818 systemd[1]: Starting initrd-switch-root.service - Switch Root... Dec 16 12:27:17.113392 systemd[1]: Switching root. Dec 16 12:27:17.228734 systemd-journald[226]: Journal stopped Dec 16 12:27:21.313967 kernel: SELinux: policy capability network_peer_controls=1 Dec 16 12:27:21.313986 kernel: SELinux: policy capability open_perms=1 Dec 16 12:27:21.313994 kernel: SELinux: policy capability extended_socket_class=1 Dec 16 12:27:21.313999 kernel: SELinux: policy capability always_check_network=0 Dec 16 12:27:21.314004 kernel: SELinux: policy capability cgroup_seclabel=1 Dec 16 12:27:21.314011 kernel: SELinux: policy capability nnp_nosuid_transition=1 Dec 16 12:27:21.314017 kernel: SELinux: policy capability genfs_seclabel_symlinks=0 Dec 16 12:27:21.314022 kernel: SELinux: policy capability ioctl_skip_cloexec=0 Dec 16 12:27:21.314027 kernel: SELinux: policy capability userspace_initial_context=0 Dec 16 12:27:21.314033 kernel: audit: type=1403 audit(1765888038.006:2): auid=4294967295 ses=4294967295 lsm=selinux res=1 Dec 16 12:27:21.314040 systemd[1]: Successfully loaded SELinux policy in 171.877ms. Dec 16 12:27:21.314047 systemd[1]: Relabeled /dev/, /dev/shm/, /run/ in 4.358ms. Dec 16 12:27:21.314054 systemd[1]: systemd 256.8 running in system mode (+PAM +AUDIT +SELINUX -APPARMOR +IMA +SMACK +SECCOMP -GCRYPT -GNUTLS +OPENSSL -ACL +BLKID +CURL +ELFUTILS -FIDO2 +IDN2 -IDN +IPTC +KMOD +LIBCRYPTSETUP +LIBCRYPTSETUP_PLUGINS +LIBFDISK +PCRE2 -PWQUALITY -P11KIT -QRENCODE +TPM2 +BZIP2 +LZ4 +XZ +ZLIB +ZSTD -BPF_FRAMEWORK -XKBCOMMON +UTMP -SYSVINIT +LIBARCHIVE) Dec 16 12:27:21.314060 systemd[1]: Detected virtualization microsoft. Dec 16 12:27:21.314066 systemd[1]: Detected architecture arm64. Dec 16 12:27:21.314074 systemd[1]: Detected first boot. Dec 16 12:27:21.314081 systemd[1]: Hostname set to . Dec 16 12:27:21.314087 systemd[1]: Initializing machine ID from random generator. Dec 16 12:27:21.314093 zram_generator::config[1305]: No configuration found. Dec 16 12:27:21.314099 kernel: NET: Registered PF_VSOCK protocol family Dec 16 12:27:21.314105 systemd[1]: Populated /etc with preset unit settings. Dec 16 12:27:21.314111 systemd[1]: run-credentials-systemd\x2djournald.service.mount: Deactivated successfully. Dec 16 12:27:21.314117 systemd[1]: initrd-switch-root.service: Deactivated successfully. Dec 16 12:27:21.314124 systemd[1]: Stopped initrd-switch-root.service - Switch Root. Dec 16 12:27:21.314130 systemd[1]: systemd-journald.service: Scheduled restart job, restart counter is at 1. Dec 16 12:27:21.314136 systemd[1]: Created slice system-addon\x2dconfig.slice - Slice /system/addon-config. Dec 16 12:27:21.314143 systemd[1]: Created slice system-addon\x2drun.slice - Slice /system/addon-run. Dec 16 12:27:21.314149 systemd[1]: Created slice system-getty.slice - Slice /system/getty. Dec 16 12:27:21.314155 systemd[1]: Created slice system-modprobe.slice - Slice /system/modprobe. Dec 16 12:27:21.314161 systemd[1]: Created slice system-serial\x2dgetty.slice - Slice /system/serial-getty. Dec 16 12:27:21.314168 systemd[1]: Created slice system-system\x2dcloudinit.slice - Slice /system/system-cloudinit. Dec 16 12:27:21.314174 systemd[1]: Created slice system-systemd\x2dfsck.slice - Slice /system/systemd-fsck. Dec 16 12:27:21.314180 systemd[1]: Created slice user.slice - User and Session Slice. Dec 16 12:27:21.314249 systemd[1]: Started clevis-luks-askpass.path - Forward Password Requests to Clevis Directory Watch. Dec 16 12:27:21.314257 systemd[1]: Started systemd-ask-password-console.path - Dispatch Password Requests to Console Directory Watch. Dec 16 12:27:21.314263 systemd[1]: Started systemd-ask-password-wall.path - Forward Password Requests to Wall Directory Watch. Dec 16 12:27:21.314269 systemd[1]: Set up automount boot.automount - Boot partition Automount Point. Dec 16 12:27:21.314275 systemd[1]: Set up automount proc-sys-fs-binfmt_misc.automount - Arbitrary Executable File Formats File System Automount Point. Dec 16 12:27:21.314406 systemd[1]: Expecting device dev-disk-by\x2dlabel-OEM.device - /dev/disk/by-label/OEM... Dec 16 12:27:21.314417 systemd[1]: Expecting device dev-ttyAMA0.device - /dev/ttyAMA0... Dec 16 12:27:21.314425 systemd[1]: Reached target cryptsetup-pre.target - Local Encrypted Volumes (Pre). Dec 16 12:27:21.314432 systemd[1]: Reached target cryptsetup.target - Local Encrypted Volumes. Dec 16 12:27:21.314438 systemd[1]: Stopped target initrd-switch-root.target - Switch Root. Dec 16 12:27:21.314444 systemd[1]: Stopped target initrd-fs.target - Initrd File Systems. Dec 16 12:27:21.314450 systemd[1]: Stopped target initrd-root-fs.target - Initrd Root File System. Dec 16 12:27:21.314457 systemd[1]: Reached target integritysetup.target - Local Integrity Protected Volumes. Dec 16 12:27:21.314464 systemd[1]: Reached target remote-cryptsetup.target - Remote Encrypted Volumes. Dec 16 12:27:21.314472 systemd[1]: Reached target remote-fs.target - Remote File Systems. Dec 16 12:27:21.314478 systemd[1]: Reached target slices.target - Slice Units. Dec 16 12:27:21.314485 systemd[1]: Reached target swap.target - Swaps. Dec 16 12:27:21.314491 systemd[1]: Reached target veritysetup.target - Local Verity Protected Volumes. Dec 16 12:27:21.314497 systemd[1]: Listening on systemd-coredump.socket - Process Core Dump Socket. Dec 16 12:27:21.314505 systemd[1]: Listening on systemd-creds.socket - Credential Encryption/Decryption. Dec 16 12:27:21.314511 systemd[1]: Listening on systemd-networkd.socket - Network Service Netlink Socket. Dec 16 12:27:21.314518 systemd[1]: Listening on systemd-udevd-control.socket - udev Control Socket. Dec 16 12:27:21.314524 systemd[1]: Listening on systemd-udevd-kernel.socket - udev Kernel Socket. Dec 16 12:27:21.314530 systemd[1]: Listening on systemd-userdbd.socket - User Database Manager Socket. Dec 16 12:27:21.314536 systemd[1]: Mounting dev-hugepages.mount - Huge Pages File System... Dec 16 12:27:21.314543 systemd[1]: Mounting dev-mqueue.mount - POSIX Message Queue File System... Dec 16 12:27:21.314550 systemd[1]: Mounting media.mount - External Media Directory... Dec 16 12:27:21.314556 systemd[1]: Mounting sys-kernel-debug.mount - Kernel Debug File System... Dec 16 12:27:21.314563 systemd[1]: Mounting sys-kernel-tracing.mount - Kernel Trace File System... Dec 16 12:27:21.314569 systemd[1]: Mounting tmp.mount - Temporary Directory /tmp... Dec 16 12:27:21.314575 systemd[1]: var-lib-machines.mount - Virtual Machine and Container Storage (Compatibility) was skipped because of an unmet condition check (ConditionPathExists=/var/lib/machines.raw). Dec 16 12:27:21.314582 systemd[1]: Reached target machines.target - Containers. Dec 16 12:27:21.314588 systemd[1]: Starting flatcar-tmpfiles.service - Create missing system files... Dec 16 12:27:21.314595 systemd[1]: ignition-delete-config.service - Ignition (delete config) was skipped because no trigger condition checks were met. Dec 16 12:27:21.314602 systemd[1]: Starting kmod-static-nodes.service - Create List of Static Device Nodes... Dec 16 12:27:21.314609 systemd[1]: Starting modprobe@configfs.service - Load Kernel Module configfs... Dec 16 12:27:21.314615 systemd[1]: Starting modprobe@dm_mod.service - Load Kernel Module dm_mod... Dec 16 12:27:21.314622 systemd[1]: Starting modprobe@drm.service - Load Kernel Module drm... Dec 16 12:27:21.314628 systemd[1]: Starting modprobe@efi_pstore.service - Load Kernel Module efi_pstore... Dec 16 12:27:21.314635 systemd[1]: Starting modprobe@fuse.service - Load Kernel Module fuse... Dec 16 12:27:21.314641 systemd[1]: Starting modprobe@loop.service - Load Kernel Module loop... Dec 16 12:27:21.314648 systemd[1]: setup-nsswitch.service - Create /etc/nsswitch.conf was skipped because of an unmet condition check (ConditionPathExists=!/etc/nsswitch.conf). Dec 16 12:27:21.314654 systemd[1]: systemd-fsck-root.service: Deactivated successfully. Dec 16 12:27:21.314662 systemd[1]: Stopped systemd-fsck-root.service - File System Check on Root Device. Dec 16 12:27:21.314668 systemd[1]: systemd-fsck-usr.service: Deactivated successfully. Dec 16 12:27:21.314674 systemd[1]: Stopped systemd-fsck-usr.service. Dec 16 12:27:21.314681 systemd[1]: systemd-hibernate-clear.service - Clear Stale Hibernate Storage Info was skipped because of an unmet condition check (ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67). Dec 16 12:27:21.314687 kernel: loop: module loaded Dec 16 12:27:21.314693 systemd[1]: Starting systemd-journald.service - Journal Service... Dec 16 12:27:21.314699 kernel: fuse: init (API version 7.41) Dec 16 12:27:21.314705 systemd[1]: Starting systemd-modules-load.service - Load Kernel Modules... Dec 16 12:27:21.314712 kernel: ACPI: bus type drm_connector registered Dec 16 12:27:21.314718 systemd[1]: Starting systemd-network-generator.service - Generate network units from Kernel command line... Dec 16 12:27:21.314724 systemd[1]: Starting systemd-remount-fs.service - Remount Root and Kernel File Systems... Dec 16 12:27:21.314750 systemd-journald[1402]: Collecting audit messages is disabled. Dec 16 12:27:21.314767 systemd-journald[1402]: Journal started Dec 16 12:27:21.314782 systemd-journald[1402]: Runtime Journal (/run/log/journal/5d835d3868b44c65b00c14cb3d7bc6fb) is 8M, max 78.3M, 70.3M free. Dec 16 12:27:20.583785 systemd[1]: Queued start job for default target multi-user.target. Dec 16 12:27:20.589684 systemd[1]: Unnecessary job was removed for dev-sda6.device - /dev/sda6. Dec 16 12:27:20.590066 systemd[1]: systemd-journald.service: Deactivated successfully. Dec 16 12:27:20.590348 systemd[1]: systemd-journald.service: Consumed 2.197s CPU time. Dec 16 12:27:21.326382 systemd[1]: Starting systemd-udev-load-credentials.service - Load udev Rules from Credentials... Dec 16 12:27:21.343295 systemd[1]: Starting systemd-udev-trigger.service - Coldplug All udev Devices... Dec 16 12:27:21.351240 systemd[1]: verity-setup.service: Deactivated successfully. Dec 16 12:27:21.351284 systemd[1]: Stopped verity-setup.service. Dec 16 12:27:21.364429 systemd[1]: Started systemd-journald.service - Journal Service. Dec 16 12:27:21.365205 systemd[1]: Mounted dev-hugepages.mount - Huge Pages File System. Dec 16 12:27:21.369742 systemd[1]: Mounted dev-mqueue.mount - POSIX Message Queue File System. Dec 16 12:27:21.374550 systemd[1]: Mounted media.mount - External Media Directory. Dec 16 12:27:21.378649 systemd[1]: Mounted sys-kernel-debug.mount - Kernel Debug File System. Dec 16 12:27:21.383139 systemd[1]: Mounted sys-kernel-tracing.mount - Kernel Trace File System. Dec 16 12:27:21.387732 systemd[1]: Mounted tmp.mount - Temporary Directory /tmp. Dec 16 12:27:21.392255 systemd[1]: Finished flatcar-tmpfiles.service - Create missing system files. Dec 16 12:27:21.397270 systemd[1]: Finished kmod-static-nodes.service - Create List of Static Device Nodes. Dec 16 12:27:21.402453 systemd[1]: modprobe@configfs.service: Deactivated successfully. Dec 16 12:27:21.402661 systemd[1]: Finished modprobe@configfs.service - Load Kernel Module configfs. Dec 16 12:27:21.408103 systemd[1]: modprobe@dm_mod.service: Deactivated successfully. Dec 16 12:27:21.408408 systemd[1]: Finished modprobe@dm_mod.service - Load Kernel Module dm_mod. Dec 16 12:27:21.413123 systemd[1]: modprobe@drm.service: Deactivated successfully. Dec 16 12:27:21.413371 systemd[1]: Finished modprobe@drm.service - Load Kernel Module drm. Dec 16 12:27:21.417925 systemd[1]: modprobe@efi_pstore.service: Deactivated successfully. Dec 16 12:27:21.418130 systemd[1]: Finished modprobe@efi_pstore.service - Load Kernel Module efi_pstore. Dec 16 12:27:21.423558 systemd[1]: modprobe@fuse.service: Deactivated successfully. Dec 16 12:27:21.423772 systemd[1]: Finished modprobe@fuse.service - Load Kernel Module fuse. Dec 16 12:27:21.428407 systemd[1]: modprobe@loop.service: Deactivated successfully. Dec 16 12:27:21.428603 systemd[1]: Finished modprobe@loop.service - Load Kernel Module loop. Dec 16 12:27:21.433161 systemd[1]: Finished systemd-modules-load.service - Load Kernel Modules. Dec 16 12:27:21.438594 systemd[1]: Finished systemd-network-generator.service - Generate network units from Kernel command line. Dec 16 12:27:21.443740 systemd[1]: Finished systemd-remount-fs.service - Remount Root and Kernel File Systems. Dec 16 12:27:21.448952 systemd[1]: Finished systemd-udev-load-credentials.service - Load udev Rules from Credentials. Dec 16 12:27:21.454688 systemd[1]: Finished systemd-udev-trigger.service - Coldplug All udev Devices. Dec 16 12:27:21.468136 systemd[1]: Reached target network-pre.target - Preparation for Network. Dec 16 12:27:21.473673 systemd[1]: Mounting sys-fs-fuse-connections.mount - FUSE Control File System... Dec 16 12:27:21.481276 systemd[1]: Mounting sys-kernel-config.mount - Kernel Configuration File System... Dec 16 12:27:21.486228 systemd[1]: remount-root.service - Remount Root File System was skipped because of an unmet condition check (ConditionPathIsReadWrite=!/). Dec 16 12:27:21.486260 systemd[1]: Reached target local-fs.target - Local File Systems. Dec 16 12:27:21.491113 systemd[1]: Listening on systemd-sysext.socket - System Extension Image Management. Dec 16 12:27:21.496984 systemd[1]: Starting ldconfig.service - Rebuild Dynamic Linker Cache... Dec 16 12:27:21.501332 systemd[1]: systemd-binfmt.service - Set Up Additional Binary Formats was skipped because no trigger condition checks were met. Dec 16 12:27:21.503323 systemd[1]: Starting systemd-hwdb-update.service - Rebuild Hardware Database... Dec 16 12:27:21.510014 systemd[1]: Starting systemd-journal-flush.service - Flush Journal to Persistent Storage... Dec 16 12:27:21.515341 systemd[1]: systemd-pstore.service - Platform Persistent Storage Archival was skipped because of an unmet condition check (ConditionDirectoryNotEmpty=/sys/fs/pstore). Dec 16 12:27:21.520138 systemd[1]: Starting systemd-random-seed.service - Load/Save OS Random Seed... Dec 16 12:27:21.525244 systemd[1]: systemd-repart.service - Repartition Root Disk was skipped because no trigger condition checks were met. Dec 16 12:27:21.526051 systemd[1]: Starting systemd-sysctl.service - Apply Kernel Variables... Dec 16 12:27:21.532315 systemd[1]: Starting systemd-sysext.service - Merge System Extension Images into /usr/ and /opt/... Dec 16 12:27:21.539799 systemd[1]: Starting systemd-sysusers.service - Create System Users... Dec 16 12:27:21.545729 systemd[1]: Mounted sys-fs-fuse-connections.mount - FUSE Control File System. Dec 16 12:27:21.550727 systemd[1]: Mounted sys-kernel-config.mount - Kernel Configuration File System. Dec 16 12:27:21.559543 systemd-journald[1402]: Time spent on flushing to /var/log/journal/5d835d3868b44c65b00c14cb3d7bc6fb is 47.668ms for 912 entries. Dec 16 12:27:21.559543 systemd-journald[1402]: System Journal (/var/log/journal/5d835d3868b44c65b00c14cb3d7bc6fb) is 11.8M, max 2.6G, 2.6G free. Dec 16 12:27:21.681671 systemd-journald[1402]: Received client request to flush runtime journal. Dec 16 12:27:21.681710 systemd-journald[1402]: /var/log/journal/5d835d3868b44c65b00c14cb3d7bc6fb/system.journal: Realtime clock jumped backwards relative to last journal entry, rotating. Dec 16 12:27:21.681733 kernel: loop0: detected capacity change from 0 to 100632 Dec 16 12:27:21.681749 systemd-journald[1402]: Rotating system journal. Dec 16 12:27:21.571244 systemd[1]: Finished systemd-random-seed.service - Load/Save OS Random Seed. Dec 16 12:27:21.577736 systemd[1]: Reached target first-boot-complete.target - First Boot Complete. Dec 16 12:27:21.585350 systemd[1]: Starting systemd-machine-id-commit.service - Save Transient machine-id to Disk... Dec 16 12:27:21.627638 systemd[1]: Finished systemd-sysctl.service - Apply Kernel Variables. Dec 16 12:27:21.683320 systemd[1]: Finished systemd-journal-flush.service - Flush Journal to Persistent Storage. Dec 16 12:27:21.696297 systemd[1]: etc-machine\x2did.mount: Deactivated successfully. Dec 16 12:27:21.697493 systemd[1]: Finished systemd-machine-id-commit.service - Save Transient machine-id to Disk. Dec 16 12:27:21.797639 systemd[1]: Finished systemd-sysusers.service - Create System Users. Dec 16 12:27:21.803062 systemd[1]: Starting systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev... Dec 16 12:27:21.882137 systemd-tmpfiles[1459]: ACLs are not supported, ignoring. Dec 16 12:27:21.882150 systemd-tmpfiles[1459]: ACLs are not supported, ignoring. Dec 16 12:27:21.885110 systemd[1]: Finished systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev. Dec 16 12:27:22.020215 kernel: squashfs: version 4.0 (2009/01/31) Phillip Lougher Dec 16 12:27:22.075217 kernel: loop1: detected capacity change from 0 to 119840 Dec 16 12:27:22.148501 systemd[1]: Finished systemd-hwdb-update.service - Rebuild Hardware Database. Dec 16 12:27:22.154905 systemd[1]: Starting systemd-udevd.service - Rule-based Manager for Device Events and Files... Dec 16 12:27:22.179352 systemd-udevd[1465]: Using default interface naming scheme 'v255'. Dec 16 12:27:22.379910 systemd[1]: Started systemd-udevd.service - Rule-based Manager for Device Events and Files. Dec 16 12:27:22.391379 systemd[1]: Starting systemd-networkd.service - Network Configuration... Dec 16 12:27:22.450488 systemd[1]: Condition check resulted in dev-ttyAMA0.device - /dev/ttyAMA0 being skipped. Dec 16 12:27:22.456012 systemd[1]: Starting systemd-userdbd.service - User Database Manager... Dec 16 12:27:22.471216 kernel: loop2: detected capacity change from 0 to 27936 Dec 16 12:27:22.535860 systemd[1]: Started systemd-userdbd.service - User Database Manager. Dec 16 12:27:22.543213 kernel: mousedev: PS/2 mouse device common for all mice Dec 16 12:27:22.569582 kernel: hv_vmbus: registering driver hv_balloon Dec 16 12:27:22.569674 kernel: hv_balloon: Using Dynamic Memory protocol version 2.0 Dec 16 12:27:22.574037 kernel: hv_balloon: Memory hot add disabled on ARM64 Dec 16 12:27:22.600852 kernel: hv_vmbus: registering driver hyperv_fb Dec 16 12:27:22.606035 kernel: hyperv_fb: Synthvid Version major 3, minor 5 Dec 16 12:27:22.606064 kernel: hyperv_fb: Screen resolution: 1024x768, Color depth: 32, Frame buffer size: 8388608 Dec 16 12:27:22.612513 kernel: Console: switching to colour dummy device 80x25 Dec 16 12:27:22.620756 kernel: Console: switching to colour frame buffer device 128x48 Dec 16 12:27:22.628539 kernel: hv_storvsc f8b3781a-1e82-4818-a1c3-63d806ec15bb: tag#227 cmd 0x85 status: scsi 0x2 srb 0x6 hv 0xc0000001 Dec 16 12:27:22.634781 systemd-networkd[1489]: lo: Link UP Dec 16 12:27:22.635040 systemd-networkd[1489]: lo: Gained carrier Dec 16 12:27:22.636057 systemd-networkd[1489]: Enumeration completed Dec 16 12:27:22.636289 systemd[1]: Started systemd-networkd.service - Network Configuration. Dec 16 12:27:22.636563 systemd-networkd[1489]: eth0: found matching network '/usr/lib/systemd/network/zz-default.network', based on potentially unpredictable interface name. Dec 16 12:27:22.636905 systemd-networkd[1489]: eth0: Configuring with /usr/lib/systemd/network/zz-default.network. Dec 16 12:27:22.644065 systemd[1]: Starting systemd-networkd-persistent-storage.service - Enable Persistent Storage in systemd-networkd... Dec 16 12:27:22.654425 systemd[1]: Starting systemd-networkd-wait-online.service - Wait for Network to be Configured... Dec 16 12:27:22.697321 systemd[1]: Starting systemd-vconsole-setup.service - Virtual Console Setup... Dec 16 12:27:22.710269 kernel: mlx5_core 4944:00:02.0 enP18756s1: Link up Dec 16 12:27:22.711432 systemd[1]: systemd-vconsole-setup.service: Deactivated successfully. Dec 16 12:27:22.713231 systemd[1]: Stopped systemd-vconsole-setup.service - Virtual Console Setup. Dec 16 12:27:22.720778 systemd[1]: Starting systemd-vconsole-setup.service - Virtual Console Setup... Dec 16 12:27:22.733533 systemd[1]: systemd-vconsole-setup.service: Deactivated successfully. Dec 16 12:27:22.733688 systemd[1]: Stopped systemd-vconsole-setup.service - Virtual Console Setup. Dec 16 12:27:22.735227 kernel: hv_netvsc 002248b5-deeb-0022-48b5-deeb002248b5 eth0: Data path switched to VF: enP18756s1 Dec 16 12:27:22.741599 systemd-networkd[1489]: enP18756s1: Link UP Dec 16 12:27:22.741761 systemd-networkd[1489]: eth0: Link UP Dec 16 12:27:22.741764 systemd-networkd[1489]: eth0: Gained carrier Dec 16 12:27:22.741792 systemd-networkd[1489]: eth0: found matching network '/usr/lib/systemd/network/zz-default.network', based on potentially unpredictable interface name. Dec 16 12:27:22.744084 systemd[1]: Starting systemd-vconsole-setup.service - Virtual Console Setup... Dec 16 12:27:22.753555 systemd-networkd[1489]: enP18756s1: Gained carrier Dec 16 12:27:22.754736 systemd[1]: Finished systemd-networkd-persistent-storage.service - Enable Persistent Storage in systemd-networkd. Dec 16 12:27:22.764263 systemd-networkd[1489]: eth0: DHCPv4 address 10.200.20.16/24, gateway 10.200.20.1 acquired from 168.63.129.16 Dec 16 12:27:22.777207 kernel: MACsec IEEE 802.1AE Dec 16 12:27:22.846976 systemd[1]: Found device dev-disk-by\x2dlabel-OEM.device - Virtual_Disk OEM. Dec 16 12:27:22.852804 systemd[1]: Starting systemd-fsck@dev-disk-by\x2dlabel-OEM.service - File System Check on /dev/disk/by-label/OEM... Dec 16 12:27:22.904142 systemd[1]: Finished systemd-fsck@dev-disk-by\x2dlabel-OEM.service - File System Check on /dev/disk/by-label/OEM. Dec 16 12:27:22.912356 kernel: loop3: detected capacity change from 0 to 100632 Dec 16 12:27:22.925218 kernel: loop4: detected capacity change from 0 to 119840 Dec 16 12:27:22.938226 kernel: loop5: detected capacity change from 0 to 27936 Dec 16 12:27:22.945940 (sd-merge)[1609]: Using extensions 'containerd-flatcar', 'docker-flatcar', 'oem-azure'. Dec 16 12:27:22.946395 (sd-merge)[1609]: Merged extensions into '/usr'. Dec 16 12:27:22.948707 systemd[1]: Finished systemd-sysext.service - Merge System Extension Images into /usr/ and /opt/. Dec 16 12:27:22.955718 systemd[1]: Starting ensure-sysext.service... Dec 16 12:27:22.967223 systemd[1]: Starting systemd-tmpfiles-setup.service - Create System Files and Directories... Dec 16 12:27:22.973457 systemd[1]: Reload requested from client PID 1611 ('systemctl') (unit ensure-sysext.service)... Dec 16 12:27:22.974495 systemd[1]: Reloading... Dec 16 12:27:23.025226 zram_generator::config[1644]: No configuration found. Dec 16 12:27:23.040251 systemd-tmpfiles[1612]: /usr/lib/tmpfiles.d/nfs-utils.conf:6: Duplicate line for path "/var/lib/nfs/sm", ignoring. Dec 16 12:27:23.040273 systemd-tmpfiles[1612]: /usr/lib/tmpfiles.d/nfs-utils.conf:7: Duplicate line for path "/var/lib/nfs/sm.bak", ignoring. Dec 16 12:27:23.040494 systemd-tmpfiles[1612]: /usr/lib/tmpfiles.d/provision.conf:20: Duplicate line for path "/root", ignoring. Dec 16 12:27:23.040632 systemd-tmpfiles[1612]: /usr/lib/tmpfiles.d/systemd-flatcar.conf:6: Duplicate line for path "/var/log/journal", ignoring. Dec 16 12:27:23.041062 systemd-tmpfiles[1612]: /usr/lib/tmpfiles.d/systemd.conf:29: Duplicate line for path "/var/lib/systemd", ignoring. Dec 16 12:27:23.041245 systemd-tmpfiles[1612]: ACLs are not supported, ignoring. Dec 16 12:27:23.041279 systemd-tmpfiles[1612]: ACLs are not supported, ignoring. Dec 16 12:27:23.070390 systemd-tmpfiles[1612]: Detected autofs mount point /boot during canonicalization of boot. Dec 16 12:27:23.070400 systemd-tmpfiles[1612]: Skipping /boot Dec 16 12:27:23.075418 systemd-tmpfiles[1612]: Detected autofs mount point /boot during canonicalization of boot. Dec 16 12:27:23.076259 systemd-tmpfiles[1612]: Skipping /boot Dec 16 12:27:23.185500 systemd[1]: Reloading finished in 210 ms. Dec 16 12:27:23.219575 systemd[1]: Finished systemd-tmpfiles-setup.service - Create System Files and Directories. Dec 16 12:27:23.230383 systemd[1]: Starting audit-rules.service - Load Audit Rules... Dec 16 12:27:23.241458 systemd[1]: Starting clean-ca-certificates.service - Clean up broken links in /etc/ssl/certs... Dec 16 12:27:23.248691 systemd[1]: Starting systemd-journal-catalog-update.service - Rebuild Journal Catalog... Dec 16 12:27:23.256457 systemd[1]: Starting systemd-resolved.service - Network Name Resolution... Dec 16 12:27:23.264454 systemd[1]: Starting systemd-update-utmp.service - Record System Boot/Shutdown in UTMP... Dec 16 12:27:23.273773 systemd[1]: ignition-delete-config.service - Ignition (delete config) was skipped because no trigger condition checks were met. Dec 16 12:27:23.275713 systemd[1]: Starting modprobe@dm_mod.service - Load Kernel Module dm_mod... Dec 16 12:27:23.286324 systemd[1]: Starting modprobe@efi_pstore.service - Load Kernel Module efi_pstore... Dec 16 12:27:23.294458 systemd[1]: Starting modprobe@loop.service - Load Kernel Module loop... Dec 16 12:27:23.303147 systemd[1]: systemd-binfmt.service - Set Up Additional Binary Formats was skipped because no trigger condition checks were met. Dec 16 12:27:23.303294 systemd[1]: systemd-hibernate-clear.service - Clear Stale Hibernate Storage Info was skipped because of an unmet condition check (ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67). Dec 16 12:27:23.318412 systemd[1]: Finished systemd-vconsole-setup.service - Virtual Console Setup. Dec 16 12:27:23.325259 systemd[1]: modprobe@dm_mod.service: Deactivated successfully. Dec 16 12:27:23.325424 systemd[1]: Finished modprobe@dm_mod.service - Load Kernel Module dm_mod. Dec 16 12:27:23.330690 systemd[1]: modprobe@efi_pstore.service: Deactivated successfully. Dec 16 12:27:23.330824 systemd[1]: Finished modprobe@efi_pstore.service - Load Kernel Module efi_pstore. Dec 16 12:27:23.336135 systemd[1]: modprobe@loop.service: Deactivated successfully. Dec 16 12:27:23.336285 systemd[1]: Finished modprobe@loop.service - Load Kernel Module loop. Dec 16 12:27:23.350642 systemd[1]: Finished systemd-update-utmp.service - Record System Boot/Shutdown in UTMP. Dec 16 12:27:23.358395 systemd[1]: ignition-delete-config.service - Ignition (delete config) was skipped because no trigger condition checks were met. Dec 16 12:27:23.361450 systemd[1]: Starting modprobe@dm_mod.service - Load Kernel Module dm_mod... Dec 16 12:27:23.372354 systemd[1]: Starting modprobe@drm.service - Load Kernel Module drm... Dec 16 12:27:23.377179 systemd-resolved[1705]: Positive Trust Anchors: Dec 16 12:27:23.377447 systemd-resolved[1705]: . IN DS 20326 8 2 e06d44b80b8f1d39a95c0b0d7c65d08458e880409bbc683457104237c7f8ec8d Dec 16 12:27:23.377521 systemd-resolved[1705]: 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 Dec 16 12:27:23.383462 systemd[1]: Starting modprobe@efi_pstore.service - Load Kernel Module efi_pstore... Dec 16 12:27:23.394268 systemd[1]: Starting modprobe@loop.service - Load Kernel Module loop... Dec 16 12:27:23.398502 systemd[1]: systemd-binfmt.service - Set Up Additional Binary Formats was skipped because no trigger condition checks were met. Dec 16 12:27:23.398656 systemd[1]: systemd-hibernate-clear.service - Clear Stale Hibernate Storage Info was skipped because of an unmet condition check (ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67). Dec 16 12:27:23.398836 systemd[1]: Reached target time-set.target - System Time Set. Dec 16 12:27:23.405237 systemd[1]: Finished systemd-journal-catalog-update.service - Rebuild Journal Catalog. Dec 16 12:27:23.411557 systemd[1]: modprobe@dm_mod.service: Deactivated successfully. Dec 16 12:27:23.411700 systemd[1]: Finished modprobe@dm_mod.service - Load Kernel Module dm_mod. Dec 16 12:27:23.416772 systemd[1]: modprobe@drm.service: Deactivated successfully. Dec 16 12:27:23.416918 systemd[1]: Finished modprobe@drm.service - Load Kernel Module drm. Dec 16 12:27:23.421675 systemd[1]: modprobe@efi_pstore.service: Deactivated successfully. Dec 16 12:27:23.421816 systemd[1]: Finished modprobe@efi_pstore.service - Load Kernel Module efi_pstore. Dec 16 12:27:23.423473 systemd-resolved[1705]: Using system hostname 'ci-4459.2.2-a-0f7d42d5a2'. Dec 16 12:27:23.427373 systemd[1]: Started systemd-resolved.service - Network Name Resolution. Dec 16 12:27:23.432504 systemd[1]: modprobe@loop.service: Deactivated successfully. Dec 16 12:27:23.432656 systemd[1]: Finished modprobe@loop.service - Load Kernel Module loop. Dec 16 12:27:23.441550 systemd[1]: Finished ensure-sysext.service. Dec 16 12:27:23.449520 systemd[1]: Reached target network.target - Network. Dec 16 12:27:23.453767 systemd[1]: Reached target nss-lookup.target - Host and Network Name Lookups. Dec 16 12:27:23.458517 systemd[1]: systemd-pstore.service - Platform Persistent Storage Archival was skipped because of an unmet condition check (ConditionDirectoryNotEmpty=/sys/fs/pstore). Dec 16 12:27:23.458587 systemd[1]: systemd-repart.service - Repartition Root Disk was skipped because no trigger condition checks were met. Dec 16 12:27:23.489669 augenrules[1746]: No rules Dec 16 12:27:23.491020 systemd[1]: audit-rules.service: Deactivated successfully. Dec 16 12:27:23.491235 systemd[1]: Finished audit-rules.service - Load Audit Rules. Dec 16 12:27:24.387553 systemd[1]: Finished clean-ca-certificates.service - Clean up broken links in /etc/ssl/certs. Dec 16 12:27:24.393453 systemd[1]: update-ca-certificates.service - Update CA bundle at /etc/ssl/certs/ca-certificates.crt was skipped because of an unmet condition check (ConditionPathIsSymbolicLink=!/etc/ssl/certs/ca-certificates.crt). Dec 16 12:27:24.696358 systemd-networkd[1489]: eth0: Gained IPv6LL Dec 16 12:27:24.698560 systemd[1]: Finished systemd-networkd-wait-online.service - Wait for Network to be Configured. Dec 16 12:27:24.703850 systemd[1]: Reached target network-online.target - Network is Online. Dec 16 12:27:27.379937 ldconfig[1439]: /sbin/ldconfig: /usr/lib/ld.so.conf is not an ELF file - it has the wrong magic bytes at the start. Dec 16 12:27:27.397913 systemd[1]: Finished ldconfig.service - Rebuild Dynamic Linker Cache. Dec 16 12:27:27.404619 systemd[1]: Starting systemd-update-done.service - Update is Completed... Dec 16 12:27:27.420912 systemd[1]: Finished systemd-update-done.service - Update is Completed. Dec 16 12:27:27.425676 systemd[1]: Reached target sysinit.target - System Initialization. Dec 16 12:27:27.430022 systemd[1]: Started motdgen.path - Watch for update engine configuration changes. Dec 16 12:27:27.434953 systemd[1]: Started user-cloudinit@var-lib-flatcar\x2dinstall-user_data.path - Watch for a cloud-config at /var/lib/flatcar-install/user_data. Dec 16 12:27:27.440002 systemd[1]: Started logrotate.timer - Daily rotation of log files. Dec 16 12:27:27.444654 systemd[1]: Started mdadm.timer - Weekly check for MD array's redundancy information.. Dec 16 12:27:27.449551 systemd[1]: Started systemd-tmpfiles-clean.timer - Daily Cleanup of Temporary Directories. Dec 16 12:27:27.454571 systemd[1]: update-engine-stub.timer - Update Engine Stub Timer was skipped because of an unmet condition check (ConditionPathExists=/usr/.noupdate). Dec 16 12:27:27.454606 systemd[1]: Reached target paths.target - Path Units. Dec 16 12:27:27.458266 systemd[1]: Reached target timers.target - Timer Units. Dec 16 12:27:27.478970 systemd[1]: Listening on dbus.socket - D-Bus System Message Bus Socket. Dec 16 12:27:27.484744 systemd[1]: Starting docker.socket - Docker Socket for the API... Dec 16 12:27:27.490178 systemd[1]: Listening on sshd-unix-local.socket - OpenSSH Server Socket (systemd-ssh-generator, AF_UNIX Local). Dec 16 12:27:27.495503 systemd[1]: Listening on sshd-vsock.socket - OpenSSH Server Socket (systemd-ssh-generator, AF_VSOCK). Dec 16 12:27:27.500467 systemd[1]: Reached target ssh-access.target - SSH Access Available. Dec 16 12:27:27.506832 systemd[1]: Listening on sshd.socket - OpenSSH Server Socket. Dec 16 12:27:27.511605 systemd[1]: Listening on systemd-hostnamed.socket - Hostname Service Socket. Dec 16 12:27:27.516947 systemd[1]: Listening on docker.socket - Docker Socket for the API. Dec 16 12:27:27.521303 systemd[1]: Reached target sockets.target - Socket Units. Dec 16 12:27:27.524960 systemd[1]: Reached target basic.target - Basic System. Dec 16 12:27:27.528547 systemd[1]: addon-config@oem.service - Configure Addon /oem was skipped because no trigger condition checks were met. Dec 16 12:27:27.528571 systemd[1]: addon-run@oem.service - Run Addon /oem was skipped because no trigger condition checks were met. Dec 16 12:27:27.530682 systemd[1]: Starting chronyd.service - NTP client/server... Dec 16 12:27:27.541287 systemd[1]: Starting containerd.service - containerd container runtime... Dec 16 12:27:27.547636 systemd[1]: Starting coreos-metadata.service - Flatcar Metadata Agent... Dec 16 12:27:27.563225 systemd[1]: Starting dbus.service - D-Bus System Message Bus... Dec 16 12:27:27.569263 systemd[1]: Starting dracut-shutdown.service - Restore /run/initramfs on shutdown... Dec 16 12:27:27.577422 systemd[1]: Starting enable-oem-cloudinit.service - Enable cloudinit... Dec 16 12:27:27.582275 systemd[1]: Starting extend-filesystems.service - Extend Filesystems... Dec 16 12:27:27.586652 systemd[1]: flatcar-setup-environment.service - Modifies /etc/environment for CoreOS was skipped because of an unmet condition check (ConditionPathExists=/oem/bin/flatcar-setup-environment). Dec 16 12:27:27.589329 systemd[1]: Started hv_kvp_daemon.service - Hyper-V KVP daemon. Dec 16 12:27:27.594249 systemd[1]: hv_vss_daemon.service - Hyper-V VSS daemon was skipped because of an unmet condition check (ConditionPathExists=/dev/vmbus/hv_vss). Dec 16 12:27:27.595071 systemd[1]: Starting motdgen.service - Generate /run/flatcar/motd... Dec 16 12:27:27.600471 jq[1767]: false Dec 16 12:27:27.601312 systemd[1]: Starting nvidia.service - NVIDIA Configure Service... Dec 16 12:27:27.605767 systemd[1]: Starting ssh-key-proc-cmdline.service - Install an ssh key from /proc/cmdline... Dec 16 12:27:27.611139 systemd[1]: Starting sshd-keygen.service - Generate sshd host keys... Dec 16 12:27:27.619418 systemd[1]: Starting systemd-logind.service - User Login Management... Dec 16 12:27:27.625824 systemd[1]: tcsd.service - TCG Core Services Daemon was skipped because of an unmet condition check (ConditionPathExists=/dev/tpm0). Dec 16 12:27:27.626744 extend-filesystems[1768]: Found /dev/sda6 Dec 16 12:27:27.637244 kernel: hv_utils: KVP IC version 4.0 Dec 16 12:27:27.626239 systemd[1]: cgroup compatibility translation between legacy and unified hierarchy settings activated. See cgroup-compat debug messages for details. Dec 16 12:27:27.629878 KVP[1769]: KVP starting; pid is:1769 Dec 16 12:27:27.627126 systemd[1]: Starting update-engine.service - Update Engine... Dec 16 12:27:27.634342 chronyd[1759]: chronyd version 4.7 starting (+CMDMON +REFCLOCK +RTC +PRIVDROP +SCFILTER -SIGND +NTS +SECHASH +IPV6 -DEBUG) Dec 16 12:27:27.640361 KVP[1769]: KVP LIC Version: 3.1 Dec 16 12:27:27.645514 systemd[1]: Starting update-ssh-keys-after-ignition.service - Run update-ssh-keys once after Ignition... Dec 16 12:27:27.652778 extend-filesystems[1768]: Found /dev/sda9 Dec 16 12:27:27.656660 extend-filesystems[1768]: Checking size of /dev/sda9 Dec 16 12:27:27.665733 chronyd[1759]: Timezone right/UTC failed leap second check, ignoring Dec 16 12:27:27.664269 systemd[1]: Finished dracut-shutdown.service - Restore /run/initramfs on shutdown. Dec 16 12:27:27.672041 jq[1787]: true Dec 16 12:27:27.674706 systemd[1]: enable-oem-cloudinit.service: Skipped due to 'exec-condition'. Dec 16 12:27:27.677296 chronyd[1759]: Loaded seccomp filter (level 2) Dec 16 12:27:27.677530 systemd[1]: Condition check resulted in enable-oem-cloudinit.service - Enable cloudinit being skipped. Dec 16 12:27:27.677702 systemd[1]: Started chronyd.service - NTP client/server. Dec 16 12:27:27.684309 systemd[1]: Finished nvidia.service - NVIDIA Configure Service. Dec 16 12:27:27.689755 systemd[1]: motdgen.service: Deactivated successfully. Dec 16 12:27:27.689919 systemd[1]: Finished motdgen.service - Generate /run/flatcar/motd. Dec 16 12:27:27.695846 systemd[1]: ssh-key-proc-cmdline.service: Deactivated successfully. Dec 16 12:27:27.695996 systemd[1]: Finished ssh-key-proc-cmdline.service - Install an ssh key from /proc/cmdline. Dec 16 12:27:27.720636 extend-filesystems[1768]: Old size kept for /dev/sda9 Dec 16 12:27:27.732651 update_engine[1780]: I20251216 12:27:27.720417 1780 main.cc:92] Flatcar Update Engine starting Dec 16 12:27:27.719703 systemd[1]: extend-filesystems.service: Deactivated successfully. Dec 16 12:27:27.727495 (ntainerd)[1804]: containerd.service: Referenced but unset environment variable evaluates to an empty string: TORCX_IMAGEDIR, TORCX_UNPACKDIR Dec 16 12:27:27.728268 systemd[1]: Finished extend-filesystems.service - Extend Filesystems. Dec 16 12:27:27.735840 systemd-logind[1778]: New seat seat0. Dec 16 12:27:27.736810 systemd-logind[1778]: Watching system buttons on /dev/input/event0 (AT Translated Set 2 keyboard) Dec 16 12:27:27.737011 systemd[1]: Started systemd-logind.service - User Login Management. Dec 16 12:27:27.743068 jq[1802]: true Dec 16 12:27:27.809109 sshd_keygen[1788]: ssh-keygen: generating new host keys: RSA ECDSA ED25519 Dec 16 12:27:27.851125 systemd[1]: Finished sshd-keygen.service - Generate sshd host keys. Dec 16 12:27:27.857936 dbus-daemon[1762]: [system] SELinux support is enabled Dec 16 12:27:27.859497 systemd[1]: Started dbus.service - D-Bus System Message Bus. Dec 16 12:27:27.864297 update_engine[1780]: I20251216 12:27:27.864243 1780 update_check_scheduler.cc:74] Next update check in 2m14s Dec 16 12:27:27.867390 bash[1862]: Updated "/home/core/.ssh/authorized_keys" Dec 16 12:27:27.868670 systemd[1]: Finished update-ssh-keys-after-ignition.service - Run update-ssh-keys once after Ignition. Dec 16 12:27:27.875336 dbus-daemon[1762]: [system] Successfully activated service 'org.freedesktop.systemd1' Dec 16 12:27:27.876369 systemd[1]: Starting issuegen.service - Generate /run/issue... Dec 16 12:27:27.880171 systemd[1]: sshkeys.service was skipped because no trigger condition checks were met. Dec 16 12:27:27.880276 systemd[1]: system-cloudinit@usr-share-oem-cloud\x2dconfig.yml.service - Load cloud-config from /usr/share/oem/cloud-config.yml was skipped because of an unmet condition check (ConditionFileNotEmpty=/usr/share/oem/cloud-config.yml). Dec 16 12:27:27.880292 systemd[1]: Reached target system-config.target - Load system-provided cloud configs. Dec 16 12:27:27.885751 systemd[1]: user-cloudinit-proc-cmdline.service - Load cloud-config from url defined in /proc/cmdline was skipped because of an unmet condition check (ConditionKernelCommandLine=cloud-config-url). Dec 16 12:27:27.885766 systemd[1]: Reached target user-config.target - Load user-provided cloud configs. Dec 16 12:27:27.897297 systemd[1]: Starting waagent.service - Microsoft Azure Linux Agent... Dec 16 12:27:27.901752 systemd[1]: issuegen.service: Deactivated successfully. Dec 16 12:27:27.901933 systemd[1]: Finished issuegen.service - Generate /run/issue. Dec 16 12:27:27.909006 systemd[1]: Started update-engine.service - Update Engine. Dec 16 12:27:27.914567 coreos-metadata[1761]: Dec 16 12:27:27.914 INFO Fetching http://168.63.129.16/?comp=versions: Attempt #1 Dec 16 12:27:27.917067 systemd[1]: Starting systemd-user-sessions.service - Permit User Sessions... Dec 16 12:27:27.921852 coreos-metadata[1761]: Dec 16 12:27:27.921 INFO Fetch successful Dec 16 12:27:27.921852 coreos-metadata[1761]: Dec 16 12:27:27.921 INFO Fetching http://168.63.129.16/machine/?comp=goalstate: Attempt #1 Dec 16 12:27:27.923947 coreos-metadata[1761]: Dec 16 12:27:27.923 INFO Fetch successful Dec 16 12:27:27.923947 coreos-metadata[1761]: Dec 16 12:27:27.923 INFO Fetching http://168.63.129.16/machine/105fc20a-8e0a-4ec6-8867-7d0b0d59ee36/b4c00206%2D1d1e%2D4d80%2D9e92%2De8e38f6ce9a5.%5Fci%2D4459.2.2%2Da%2D0f7d42d5a2?comp=config&type=sharedConfig&incarnation=1: Attempt #1 Dec 16 12:27:27.927397 systemd[1]: Started locksmithd.service - Cluster reboot manager. Dec 16 12:27:27.937413 systemd[1]: Finished systemd-user-sessions.service - Permit User Sessions. Dec 16 12:27:27.953095 systemd[1]: Started getty@tty1.service - Getty on tty1. Dec 16 12:27:27.957298 coreos-metadata[1761]: Dec 16 12:27:27.957 INFO Fetch successful Dec 16 12:27:27.958701 coreos-metadata[1761]: Dec 16 12:27:27.958 INFO Fetching http://169.254.169.254/metadata/instance/compute/vmSize?api-version=2017-08-01&format=text: Attempt #1 Dec 16 12:27:27.960467 systemd[1]: Started serial-getty@ttyAMA0.service - Serial Getty on ttyAMA0. Dec 16 12:27:27.967446 coreos-metadata[1761]: Dec 16 12:27:27.967 INFO Fetch successful Dec 16 12:27:27.967643 systemd[1]: Reached target getty.target - Login Prompts. Dec 16 12:27:27.974919 systemd[1]: Started waagent.service - Microsoft Azure Linux Agent. Dec 16 12:27:28.001737 systemd[1]: Finished coreos-metadata.service - Flatcar Metadata Agent. Dec 16 12:27:28.006582 systemd[1]: packet-phone-home.service - Report Success to Packet was skipped because no trigger condition checks were met. Dec 16 12:27:28.087766 locksmithd[1909]: locksmithd starting currentOperation="UPDATE_STATUS_IDLE" strategy="reboot" Dec 16 12:27:28.280557 containerd[1804]: time="2025-12-16T12:27:28Z" 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 Dec 16 12:27:28.282210 containerd[1804]: time="2025-12-16T12:27:28.281398212Z" level=info msg="starting containerd" revision=4ac6c20c7bbf8177f29e46bbdc658fec02ffb8ad version=v2.0.7 Dec 16 12:27:28.287192 containerd[1804]: time="2025-12-16T12:27:28.287149468Z" level=warning msg="Configuration migrated from version 2, use `containerd config migrate` to avoid migration" t="8.784µs" Dec 16 12:27:28.287192 containerd[1804]: time="2025-12-16T12:27:28.287181324Z" level=info msg="loading plugin" id=io.containerd.image-verifier.v1.bindir type=io.containerd.image-verifier.v1 Dec 16 12:27:28.287283 containerd[1804]: time="2025-12-16T12:27:28.287205620Z" level=info msg="loading plugin" id=io.containerd.internal.v1.opt type=io.containerd.internal.v1 Dec 16 12:27:28.287360 containerd[1804]: time="2025-12-16T12:27:28.287339532Z" level=info msg="loading plugin" id=io.containerd.warning.v1.deprecations type=io.containerd.warning.v1 Dec 16 12:27:28.287360 containerd[1804]: time="2025-12-16T12:27:28.287357948Z" level=info msg="loading plugin" id=io.containerd.content.v1.content type=io.containerd.content.v1 Dec 16 12:27:28.287385 containerd[1804]: time="2025-12-16T12:27:28.287375164Z" level=info msg="loading plugin" id=io.containerd.snapshotter.v1.blockfile type=io.containerd.snapshotter.v1 Dec 16 12:27:28.287433 containerd[1804]: time="2025-12-16T12:27:28.287419396Z" level=info msg="skip loading plugin" error="no scratch file generator: skip plugin" id=io.containerd.snapshotter.v1.blockfile type=io.containerd.snapshotter.v1 Dec 16 12:27:28.287433 containerd[1804]: time="2025-12-16T12:27:28.287431196Z" level=info msg="loading plugin" id=io.containerd.snapshotter.v1.btrfs type=io.containerd.snapshotter.v1 Dec 16 12:27:28.287630 containerd[1804]: time="2025-12-16T12:27:28.287610812Z" 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 Dec 16 12:27:28.287630 containerd[1804]: time="2025-12-16T12:27:28.287626756Z" level=info msg="loading plugin" id=io.containerd.snapshotter.v1.devmapper type=io.containerd.snapshotter.v1 Dec 16 12:27:28.287660 containerd[1804]: time="2025-12-16T12:27:28.287634972Z" level=info msg="skip loading plugin" error="devmapper not configured: skip plugin" id=io.containerd.snapshotter.v1.devmapper type=io.containerd.snapshotter.v1 Dec 16 12:27:28.287660 containerd[1804]: time="2025-12-16T12:27:28.287640892Z" level=info msg="loading plugin" id=io.containerd.snapshotter.v1.native type=io.containerd.snapshotter.v1 Dec 16 12:27:28.287724 containerd[1804]: time="2025-12-16T12:27:28.287708916Z" level=info msg="loading plugin" id=io.containerd.snapshotter.v1.overlayfs type=io.containerd.snapshotter.v1 Dec 16 12:27:28.287882 containerd[1804]: time="2025-12-16T12:27:28.287865188Z" level=info msg="loading plugin" id=io.containerd.snapshotter.v1.zfs type=io.containerd.snapshotter.v1 Dec 16 12:27:28.287905 containerd[1804]: time="2025-12-16T12:27:28.287893636Z" 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 Dec 16 12:27:28.287905 containerd[1804]: time="2025-12-16T12:27:28.287903060Z" level=info msg="loading plugin" id=io.containerd.event.v1.exchange type=io.containerd.event.v1 Dec 16 12:27:28.287935 containerd[1804]: time="2025-12-16T12:27:28.287924812Z" level=info msg="loading plugin" id=io.containerd.monitor.task.v1.cgroups type=io.containerd.monitor.task.v1 Dec 16 12:27:28.288093 containerd[1804]: time="2025-12-16T12:27:28.288076604Z" level=info msg="loading plugin" id=io.containerd.metadata.v1.bolt type=io.containerd.metadata.v1 Dec 16 12:27:28.288152 containerd[1804]: time="2025-12-16T12:27:28.288136332Z" level=info msg="metadata content store policy set" policy=shared Dec 16 12:27:28.308587 containerd[1804]: time="2025-12-16T12:27:28.308544052Z" level=info msg="loading plugin" id=io.containerd.gc.v1.scheduler type=io.containerd.gc.v1 Dec 16 12:27:28.308650 containerd[1804]: time="2025-12-16T12:27:28.308623028Z" level=info msg="loading plugin" id=io.containerd.differ.v1.walking type=io.containerd.differ.v1 Dec 16 12:27:28.308650 containerd[1804]: time="2025-12-16T12:27:28.308640108Z" level=info msg="loading plugin" id=io.containerd.lease.v1.manager type=io.containerd.lease.v1 Dec 16 12:27:28.308674 containerd[1804]: time="2025-12-16T12:27:28.308649100Z" level=info msg="loading plugin" id=io.containerd.service.v1.containers-service type=io.containerd.service.v1 Dec 16 12:27:28.308674 containerd[1804]: time="2025-12-16T12:27:28.308657372Z" level=info msg="loading plugin" id=io.containerd.service.v1.content-service type=io.containerd.service.v1 Dec 16 12:27:28.308751 containerd[1804]: time="2025-12-16T12:27:28.308708996Z" level=info msg="loading plugin" id=io.containerd.service.v1.diff-service type=io.containerd.service.v1 Dec 16 12:27:28.308751 containerd[1804]: time="2025-12-16T12:27:28.308722564Z" level=info msg="loading plugin" id=io.containerd.service.v1.images-service type=io.containerd.service.v1 Dec 16 12:27:28.308751 containerd[1804]: time="2025-12-16T12:27:28.308730196Z" level=info msg="loading plugin" id=io.containerd.service.v1.introspection-service type=io.containerd.service.v1 Dec 16 12:27:28.308751 containerd[1804]: time="2025-12-16T12:27:28.308741020Z" level=info msg="loading plugin" id=io.containerd.service.v1.namespaces-service type=io.containerd.service.v1 Dec 16 12:27:28.308751 containerd[1804]: time="2025-12-16T12:27:28.308747268Z" level=info msg="loading plugin" id=io.containerd.service.v1.snapshots-service type=io.containerd.service.v1 Dec 16 12:27:28.308751 containerd[1804]: time="2025-12-16T12:27:28.308753116Z" level=info msg="loading plugin" id=io.containerd.shim.v1.manager type=io.containerd.shim.v1 Dec 16 12:27:28.308837 containerd[1804]: time="2025-12-16T12:27:28.308765452Z" level=info msg="loading plugin" id=io.containerd.runtime.v2.task type=io.containerd.runtime.v2 Dec 16 12:27:28.308918 containerd[1804]: time="2025-12-16T12:27:28.308897116Z" level=info msg="loading plugin" id=io.containerd.service.v1.tasks-service type=io.containerd.service.v1 Dec 16 12:27:28.308933 containerd[1804]: time="2025-12-16T12:27:28.308920884Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.containers type=io.containerd.grpc.v1 Dec 16 12:27:28.308945 containerd[1804]: time="2025-12-16T12:27:28.308932084Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.content type=io.containerd.grpc.v1 Dec 16 12:27:28.308970 containerd[1804]: time="2025-12-16T12:27:28.308958996Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.diff type=io.containerd.grpc.v1 Dec 16 12:27:28.308985 containerd[1804]: time="2025-12-16T12:27:28.308972644Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.events type=io.containerd.grpc.v1 Dec 16 12:27:28.308985 containerd[1804]: time="2025-12-16T12:27:28.308979868Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.images type=io.containerd.grpc.v1 Dec 16 12:27:28.309012 containerd[1804]: time="2025-12-16T12:27:28.308987084Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.introspection type=io.containerd.grpc.v1 Dec 16 12:27:28.309012 containerd[1804]: time="2025-12-16T12:27:28.308993604Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.leases type=io.containerd.grpc.v1 Dec 16 12:27:28.309012 containerd[1804]: time="2025-12-16T12:27:28.309000572Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.namespaces type=io.containerd.grpc.v1 Dec 16 12:27:28.309012 containerd[1804]: time="2025-12-16T12:27:28.309006956Z" level=info msg="loading plugin" id=io.containerd.sandbox.store.v1.local type=io.containerd.sandbox.store.v1 Dec 16 12:27:28.309062 containerd[1804]: time="2025-12-16T12:27:28.309013164Z" level=info msg="loading plugin" id=io.containerd.cri.v1.images type=io.containerd.cri.v1 Dec 16 12:27:28.309077 containerd[1804]: time="2025-12-16T12:27:28.309061492Z" level=info msg="Get image filesystem path \"/var/lib/containerd/io.containerd.snapshotter.v1.overlayfs\" for snapshotter \"overlayfs\"" Dec 16 12:27:28.309089 containerd[1804]: time="2025-12-16T12:27:28.309077804Z" level=info msg="Start snapshots syncer" Dec 16 12:27:28.309121 containerd[1804]: time="2025-12-16T12:27:28.309109940Z" level=info msg="loading plugin" id=io.containerd.cri.v1.runtime type=io.containerd.cri.v1 Dec 16 12:27:28.309423 containerd[1804]: time="2025-12-16T12:27:28.309390444Z" 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,\"baseRuntimeSpec\":\"\",\"cniConfDir\":\"\",\"cniMaxConfNum\":0,\"snapshotter\":\"\",\"sandboxer\":\"podsandbox\",\"io_type\":\"\"}},\"ignoreBlockIONotEnabledErrors\":false,\"ignoreRdtNotEnabledErrors\":false},\"cni\":{\"binDir\":\"/opt/cni/bin\",\"confDir\":\"/etc/cni/net.d\",\"maxConfNum\":1,\"setupSerially\":false,\"confTemplate\":\"\",\"ipPref\":\"\",\"useInternalLoopback\":false},\"enableSelinux\":true,\"selinuxCategoryRange\":1024,\"maxContainerLogSize\":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\"}" Dec 16 12:27:28.309500 containerd[1804]: time="2025-12-16T12:27:28.309442180Z" level=info msg="loading plugin" id=io.containerd.podsandbox.controller.v1.podsandbox type=io.containerd.podsandbox.controller.v1 Dec 16 12:27:28.309500 containerd[1804]: time="2025-12-16T12:27:28.309488428Z" level=info msg="loading plugin" id=io.containerd.sandbox.controller.v1.shim type=io.containerd.sandbox.controller.v1 Dec 16 12:27:28.309644 containerd[1804]: time="2025-12-16T12:27:28.309625236Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.sandbox-controllers type=io.containerd.grpc.v1 Dec 16 12:27:28.309660 containerd[1804]: time="2025-12-16T12:27:28.309649604Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.sandboxes type=io.containerd.grpc.v1 Dec 16 12:27:28.309660 containerd[1804]: time="2025-12-16T12:27:28.309657332Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.snapshots type=io.containerd.grpc.v1 Dec 16 12:27:28.309685 containerd[1804]: time="2025-12-16T12:27:28.309667140Z" level=info msg="loading plugin" id=io.containerd.streaming.v1.manager type=io.containerd.streaming.v1 Dec 16 12:27:28.309685 containerd[1804]: time="2025-12-16T12:27:28.309675604Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.streaming type=io.containerd.grpc.v1 Dec 16 12:27:28.309685 containerd[1804]: time="2025-12-16T12:27:28.309682500Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.tasks type=io.containerd.grpc.v1 Dec 16 12:27:28.309719 containerd[1804]: time="2025-12-16T12:27:28.309690524Z" level=info msg="loading plugin" id=io.containerd.transfer.v1.local type=io.containerd.transfer.v1 Dec 16 12:27:28.309719 containerd[1804]: time="2025-12-16T12:27:28.309708572Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.transfer type=io.containerd.grpc.v1 Dec 16 12:27:28.309719 containerd[1804]: time="2025-12-16T12:27:28.309716564Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.version type=io.containerd.grpc.v1 Dec 16 12:27:28.309756 containerd[1804]: time="2025-12-16T12:27:28.309723844Z" level=info msg="loading plugin" id=io.containerd.monitor.container.v1.restart type=io.containerd.monitor.container.v1 Dec 16 12:27:28.309768 containerd[1804]: time="2025-12-16T12:27:28.309757068Z" level=info msg="loading plugin" id=io.containerd.tracing.processor.v1.otlp type=io.containerd.tracing.processor.v1 Dec 16 12:27:28.309779 containerd[1804]: time="2025-12-16T12:27:28.309768404Z" 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 Dec 16 12:27:28.309779 containerd[1804]: time="2025-12-16T12:27:28.309774908Z" level=info msg="loading plugin" id=io.containerd.internal.v1.tracing type=io.containerd.internal.v1 Dec 16 12:27:28.309802 containerd[1804]: time="2025-12-16T12:27:28.309781508Z" level=info msg="skip loading plugin" error="skip plugin: tracing endpoint not configured" id=io.containerd.internal.v1.tracing type=io.containerd.internal.v1 Dec 16 12:27:28.309802 containerd[1804]: time="2025-12-16T12:27:28.309786500Z" level=info msg="loading plugin" id=io.containerd.ttrpc.v1.otelttrpc type=io.containerd.ttrpc.v1 Dec 16 12:27:28.309802 containerd[1804]: time="2025-12-16T12:27:28.309791828Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.healthcheck type=io.containerd.grpc.v1 Dec 16 12:27:28.309802 containerd[1804]: time="2025-12-16T12:27:28.309798788Z" level=info msg="loading plugin" id=io.containerd.nri.v1.nri type=io.containerd.nri.v1 Dec 16 12:27:28.309859 containerd[1804]: time="2025-12-16T12:27:28.309845732Z" level=info msg="runtime interface created" Dec 16 12:27:28.309859 containerd[1804]: time="2025-12-16T12:27:28.309855236Z" level=info msg="created NRI interface" Dec 16 12:27:28.309886 containerd[1804]: time="2025-12-16T12:27:28.309861172Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.cri type=io.containerd.grpc.v1 Dec 16 12:27:28.309886 containerd[1804]: time="2025-12-16T12:27:28.309870244Z" level=info msg="Connect containerd service" Dec 16 12:27:28.309912 containerd[1804]: time="2025-12-16T12:27:28.309885868Z" level=info msg="using experimental NRI integration - disable nri plugin to prevent this" Dec 16 12:27:28.310575 containerd[1804]: time="2025-12-16T12:27:28.310547884Z" 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" Dec 16 12:27:28.626645 containerd[1804]: time="2025-12-16T12:27:28.626446404Z" level=info msg="Start subscribing containerd event" Dec 16 12:27:28.626645 containerd[1804]: time="2025-12-16T12:27:28.626546388Z" level=info msg="Start recovering state" Dec 16 12:27:28.626645 containerd[1804]: time="2025-12-16T12:27:28.626624692Z" level=info msg=serving... address=/run/containerd/containerd.sock.ttrpc Dec 16 12:27:28.626775 containerd[1804]: time="2025-12-16T12:27:28.626664564Z" level=info msg=serving... address=/run/containerd/containerd.sock Dec 16 12:27:28.626898 containerd[1804]: time="2025-12-16T12:27:28.626860612Z" level=info msg="Start event monitor" Dec 16 12:27:28.627127 containerd[1804]: time="2025-12-16T12:27:28.627103092Z" level=info msg="Start cni network conf syncer for default" Dec 16 12:27:28.627201 containerd[1804]: time="2025-12-16T12:27:28.627167468Z" level=info msg="Start streaming server" Dec 16 12:27:28.627322 containerd[1804]: time="2025-12-16T12:27:28.627252492Z" level=info msg="Registered namespace \"k8s.io\" with NRI" Dec 16 12:27:28.627322 containerd[1804]: time="2025-12-16T12:27:28.627267052Z" level=info msg="runtime interface starting up..." Dec 16 12:27:28.627322 containerd[1804]: time="2025-12-16T12:27:28.627273132Z" level=info msg="starting plugins..." Dec 16 12:27:28.627322 containerd[1804]: time="2025-12-16T12:27:28.627294564Z" level=info msg="Synchronizing NRI (plugin) with current runtime state" Dec 16 12:27:28.627737 systemd[1]: Started containerd.service - containerd container runtime. Dec 16 12:27:28.630399 containerd[1804]: time="2025-12-16T12:27:28.627834124Z" level=info msg="containerd successfully booted in 0.347630s" Dec 16 12:27:28.634050 systemd[1]: Reached target multi-user.target - Multi-User System. Dec 16 12:27:28.642302 systemd[1]: Startup finished in 1.620s (kernel) + 10.558s (initrd) + 10.805s (userspace) = 22.985s. Dec 16 12:27:28.869092 login[1915]: pam_lastlog(login:session): file /var/log/lastlog is locked/write, retrying Dec 16 12:27:28.869650 login[1913]: pam_unix(login:session): session opened for user core(uid=500) by core(uid=0) Dec 16 12:27:28.892051 systemd[1]: Created slice user-500.slice - User Slice of UID 500. Dec 16 12:27:28.892800 systemd[1]: Starting user-runtime-dir@500.service - User Runtime Directory /run/user/500... Dec 16 12:27:28.895329 systemd-logind[1778]: New session 2 of user core. Dec 16 12:27:28.907105 systemd[1]: Finished user-runtime-dir@500.service - User Runtime Directory /run/user/500. Dec 16 12:27:28.908991 systemd[1]: Starting user@500.service - User Manager for UID 500... Dec 16 12:27:28.920382 (systemd)[1951]: pam_unix(systemd-user:session): session opened for user core(uid=500) by (uid=0) Dec 16 12:27:28.922419 systemd-logind[1778]: New session c1 of user core. Dec 16 12:27:29.046101 systemd[1951]: Queued start job for default target default.target. Dec 16 12:27:29.051967 systemd[1951]: Created slice app.slice - User Application Slice. Dec 16 12:27:29.051992 systemd[1951]: Reached target paths.target - Paths. Dec 16 12:27:29.052025 systemd[1951]: Reached target timers.target - Timers. Dec 16 12:27:29.053030 systemd[1951]: Starting dbus.socket - D-Bus User Message Bus Socket... Dec 16 12:27:29.060725 systemd[1951]: Listening on dbus.socket - D-Bus User Message Bus Socket. Dec 16 12:27:29.060770 systemd[1951]: Reached target sockets.target - Sockets. Dec 16 12:27:29.060803 systemd[1951]: Reached target basic.target - Basic System. Dec 16 12:27:29.060825 systemd[1951]: Reached target default.target - Main User Target. Dec 16 12:27:29.060850 systemd[1951]: Startup finished in 133ms. Dec 16 12:27:29.061042 systemd[1]: Started user@500.service - User Manager for UID 500. Dec 16 12:27:29.069504 systemd[1]: Started session-2.scope - Session 2 of User core. Dec 16 12:27:29.461356 waagent[1917]: 2025-12-16T12:27:29.461283Z INFO Daemon Daemon Azure Linux Agent Version: 2.12.0.4 Dec 16 12:27:29.465853 waagent[1917]: 2025-12-16T12:27:29.465805Z INFO Daemon Daemon OS: flatcar 4459.2.2 Dec 16 12:27:29.469256 waagent[1917]: 2025-12-16T12:27:29.469224Z INFO Daemon Daemon Python: 3.11.13 Dec 16 12:27:29.472524 waagent[1917]: 2025-12-16T12:27:29.472490Z INFO Daemon Daemon Run daemon Dec 16 12:27:29.475416 waagent[1917]: 2025-12-16T12:27:29.475385Z INFO Daemon Daemon No RDMA handler exists for distro='Flatcar Container Linux by Kinvolk' version='4459.2.2' Dec 16 12:27:29.482570 waagent[1917]: 2025-12-16T12:27:29.482528Z INFO Daemon Daemon Using waagent for provisioning Dec 16 12:27:29.486422 waagent[1917]: 2025-12-16T12:27:29.486385Z INFO Daemon Daemon Activate resource disk Dec 16 12:27:29.489791 waagent[1917]: 2025-12-16T12:27:29.489761Z INFO Daemon Daemon Searching gen1 prefix 00000000-0001 or gen2 f8b3781a-1e82-4818-a1c3-63d806ec15bb Dec 16 12:27:29.497829 waagent[1917]: 2025-12-16T12:27:29.497787Z INFO Daemon Daemon Found device: None Dec 16 12:27:29.501026 waagent[1917]: 2025-12-16T12:27:29.500995Z ERROR Daemon Daemon Failed to mount resource disk [ResourceDiskError] unable to detect disk topology Dec 16 12:27:29.507056 waagent[1917]: 2025-12-16T12:27:29.507029Z ERROR Daemon Daemon Event: name=WALinuxAgent, op=ActivateResourceDisk, message=[ResourceDiskError] unable to detect disk topology, duration=0 Dec 16 12:27:29.516181 waagent[1917]: 2025-12-16T12:27:29.516141Z INFO Daemon Daemon Clean protocol and wireserver endpoint Dec 16 12:27:29.520584 waagent[1917]: 2025-12-16T12:27:29.520555Z INFO Daemon Daemon Running default provisioning handler Dec 16 12:27:29.529921 waagent[1917]: 2025-12-16T12:27:29.529876Z 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. Dec 16 12:27:29.539951 waagent[1917]: 2025-12-16T12:27:29.539912Z INFO Daemon Daemon Unable to get cloud-init enabled status from service: [Errno 2] No such file or directory: 'service' Dec 16 12:27:29.547730 waagent[1917]: 2025-12-16T12:27:29.547696Z INFO Daemon Daemon cloud-init is enabled: False Dec 16 12:27:29.551339 waagent[1917]: 2025-12-16T12:27:29.551314Z INFO Daemon Daemon Copying ovf-env.xml Dec 16 12:27:29.606902 waagent[1917]: 2025-12-16T12:27:29.606822Z INFO Daemon Daemon Successfully mounted dvd Dec 16 12:27:29.635054 systemd[1]: mnt-cdrom-secure.mount: Deactivated successfully. Dec 16 12:27:29.640860 waagent[1917]: 2025-12-16T12:27:29.637306Z INFO Daemon Daemon Detect protocol endpoint Dec 16 12:27:29.641238 waagent[1917]: 2025-12-16T12:27:29.641172Z INFO Daemon Daemon Clean protocol and wireserver endpoint Dec 16 12:27:29.645474 waagent[1917]: 2025-12-16T12:27:29.645432Z INFO Daemon Daemon WireServer endpoint is not found. Rerun dhcp handler Dec 16 12:27:29.650597 waagent[1917]: 2025-12-16T12:27:29.650561Z INFO Daemon Daemon Test for route to 168.63.129.16 Dec 16 12:27:29.654967 waagent[1917]: 2025-12-16T12:27:29.654926Z INFO Daemon Daemon Route to 168.63.129.16 exists Dec 16 12:27:29.659522 waagent[1917]: 2025-12-16T12:27:29.659485Z INFO Daemon Daemon Wire server endpoint:168.63.129.16 Dec 16 12:27:29.704219 waagent[1917]: 2025-12-16T12:27:29.704147Z INFO Daemon Daemon Fabric preferred wire protocol version:2015-04-05 Dec 16 12:27:29.709445 waagent[1917]: 2025-12-16T12:27:29.709421Z INFO Daemon Daemon Wire protocol version:2012-11-30 Dec 16 12:27:29.713685 waagent[1917]: 2025-12-16T12:27:29.713601Z INFO Daemon Daemon Server preferred version:2015-04-05 Dec 16 12:27:29.851507 waagent[1917]: 2025-12-16T12:27:29.851432Z INFO Daemon Daemon Initializing goal state during protocol detection Dec 16 12:27:29.856639 waagent[1917]: 2025-12-16T12:27:29.856584Z INFO Daemon Daemon Forcing an update of the goal state. Dec 16 12:27:29.870321 login[1915]: pam_unix(login:session): session opened for user core(uid=500) by core(uid=0) Dec 16 12:27:29.870851 waagent[1917]: 2025-12-16T12:27:29.870800Z INFO Daemon Fetched a new incarnation for the WireServer goal state [incarnation 1] Dec 16 12:27:29.880781 systemd-logind[1778]: New session 1 of user core. Dec 16 12:27:29.886321 systemd[1]: Started session-1.scope - Session 1 of User core. Dec 16 12:27:29.894200 waagent[1917]: 2025-12-16T12:27:29.892698Z INFO Daemon Daemon HostGAPlugin version: 1.0.8.177 Dec 16 12:27:29.897934 waagent[1917]: 2025-12-16T12:27:29.897585Z INFO Daemon Dec 16 12:27:29.899716 waagent[1917]: 2025-12-16T12:27:29.899675Z INFO Daemon Fetched new vmSettings [HostGAPlugin correlation ID: f0aa0797-e4ce-4d0e-90fd-09df358d4500 eTag: 3058521200947367729 source: Fabric] Dec 16 12:27:29.908716 waagent[1917]: 2025-12-16T12:27:29.908406Z INFO Daemon The vmSettings originated via Fabric; will ignore them. Dec 16 12:27:29.913643 waagent[1917]: 2025-12-16T12:27:29.913505Z INFO Daemon Dec 16 12:27:29.915518 waagent[1917]: 2025-12-16T12:27:29.915483Z INFO Daemon Fetching full goal state from the WireServer [incarnation 1] Dec 16 12:27:29.923934 waagent[1917]: 2025-12-16T12:27:29.923900Z INFO Daemon Daemon Downloading artifacts profile blob Dec 16 12:27:30.063469 waagent[1917]: 2025-12-16T12:27:30.063343Z INFO Daemon Downloaded certificate {'thumbprint': '5EA06E9F44AE41BF87F6DF0F6E8CBFD5328BC25B', 'hasPrivateKey': True} Dec 16 12:27:30.072404 waagent[1917]: 2025-12-16T12:27:30.072356Z INFO Daemon Fetch goal state completed Dec 16 12:27:30.113171 waagent[1917]: 2025-12-16T12:27:30.113100Z INFO Daemon Daemon Starting provisioning Dec 16 12:27:30.117008 waagent[1917]: 2025-12-16T12:27:30.116966Z INFO Daemon Daemon Handle ovf-env.xml. Dec 16 12:27:30.120519 waagent[1917]: 2025-12-16T12:27:30.120494Z INFO Daemon Daemon Set hostname [ci-4459.2.2-a-0f7d42d5a2] Dec 16 12:27:30.142180 waagent[1917]: 2025-12-16T12:27:30.142116Z INFO Daemon Daemon Publish hostname [ci-4459.2.2-a-0f7d42d5a2] Dec 16 12:27:30.147077 waagent[1917]: 2025-12-16T12:27:30.147029Z INFO Daemon Daemon Examine /proc/net/route for primary interface Dec 16 12:27:30.151565 waagent[1917]: 2025-12-16T12:27:30.151531Z INFO Daemon Daemon Primary interface is [eth0] Dec 16 12:27:30.161663 systemd-networkd[1489]: eth0: found matching network '/usr/lib/systemd/network/zz-default.network', based on potentially unpredictable interface name. Dec 16 12:27:30.161670 systemd-networkd[1489]: eth0: Configuring with /usr/lib/systemd/network/zz-default.network. Dec 16 12:27:30.161729 systemd-networkd[1489]: eth0: DHCP lease lost Dec 16 12:27:30.162643 waagent[1917]: 2025-12-16T12:27:30.162544Z INFO Daemon Daemon Create user account if not exists Dec 16 12:27:30.166914 waagent[1917]: 2025-12-16T12:27:30.166877Z INFO Daemon Daemon User core already exists, skip useradd Dec 16 12:27:30.171209 waagent[1917]: 2025-12-16T12:27:30.171080Z INFO Daemon Daemon Configure sudoer Dec 16 12:27:30.181589 waagent[1917]: 2025-12-16T12:27:30.181540Z INFO Daemon Daemon Configure sshd Dec 16 12:27:30.186231 systemd-networkd[1489]: eth0: DHCPv4 address 10.200.20.16/24, gateway 10.200.20.1 acquired from 168.63.129.16 Dec 16 12:27:30.189539 waagent[1917]: 2025-12-16T12:27:30.189493Z INFO Daemon Daemon Added a configuration snippet disabling SSH password-based authentication methods. It also configures SSH client probing to keep connections alive. Dec 16 12:27:30.199153 waagent[1917]: 2025-12-16T12:27:30.199113Z INFO Daemon Daemon Deploy ssh public key. Dec 16 12:27:31.305917 waagent[1917]: 2025-12-16T12:27:31.305863Z INFO Daemon Daemon Provisioning complete Dec 16 12:27:31.318383 waagent[1917]: 2025-12-16T12:27:31.318341Z INFO Daemon Daemon RDMA capabilities are not enabled, skipping Dec 16 12:27:31.322727 waagent[1917]: 2025-12-16T12:27:31.322689Z INFO Daemon Daemon End of log to /dev/console. The agent will now check for updates and then will process extensions. Dec 16 12:27:31.329382 waagent[1917]: 2025-12-16T12:27:31.329351Z INFO Daemon Daemon Installed Agent WALinuxAgent-2.12.0.4 is the most current agent Dec 16 12:27:31.428225 waagent[2001]: 2025-12-16T12:27:31.427734Z INFO ExtHandler ExtHandler Azure Linux Agent (Goal State Agent version 2.12.0.4) Dec 16 12:27:31.428225 waagent[2001]: 2025-12-16T12:27:31.427867Z INFO ExtHandler ExtHandler OS: flatcar 4459.2.2 Dec 16 12:27:31.428225 waagent[2001]: 2025-12-16T12:27:31.427904Z INFO ExtHandler ExtHandler Python: 3.11.13 Dec 16 12:27:31.428225 waagent[2001]: 2025-12-16T12:27:31.427938Z INFO ExtHandler ExtHandler CPU Arch: aarch64 Dec 16 12:27:31.466964 waagent[2001]: 2025-12-16T12:27:31.466895Z INFO ExtHandler ExtHandler Distro: flatcar-4459.2.2; OSUtil: FlatcarUtil; AgentService: waagent; Python: 3.11.13; Arch: aarch64; systemd: True; LISDrivers: Absent; logrotate: logrotate 3.22.0; Dec 16 12:27:31.467330 waagent[2001]: 2025-12-16T12:27:31.467297Z INFO ExtHandler ExtHandler WireServer endpoint 168.63.129.16 read from file Dec 16 12:27:31.467458 waagent[2001]: 2025-12-16T12:27:31.467432Z INFO ExtHandler ExtHandler Wire server endpoint:168.63.129.16 Dec 16 12:27:31.473502 waagent[2001]: 2025-12-16T12:27:31.473455Z INFO ExtHandler Fetched a new incarnation for the WireServer goal state [incarnation 1] Dec 16 12:27:31.479232 waagent[2001]: 2025-12-16T12:27:31.478681Z INFO ExtHandler ExtHandler HostGAPlugin version: 1.0.8.177 Dec 16 12:27:31.479232 waagent[2001]: 2025-12-16T12:27:31.479045Z INFO ExtHandler Dec 16 12:27:31.479232 waagent[2001]: 2025-12-16T12:27:31.479097Z INFO ExtHandler Fetched new vmSettings [HostGAPlugin correlation ID: bf79692c-4ef8-4af6-8638-a0846cc6712d eTag: 3058521200947367729 source: Fabric] Dec 16 12:27:31.479379 waagent[2001]: 2025-12-16T12:27:31.479339Z INFO ExtHandler The vmSettings originated via Fabric; will ignore them. Dec 16 12:27:31.479773 waagent[2001]: 2025-12-16T12:27:31.479743Z INFO ExtHandler Dec 16 12:27:31.479809 waagent[2001]: 2025-12-16T12:27:31.479794Z INFO ExtHandler Fetching full goal state from the WireServer [incarnation 1] Dec 16 12:27:31.483264 waagent[2001]: 2025-12-16T12:27:31.483238Z INFO ExtHandler ExtHandler Downloading artifacts profile blob Dec 16 12:27:31.538161 waagent[2001]: 2025-12-16T12:27:31.538085Z INFO ExtHandler Downloaded certificate {'thumbprint': '5EA06E9F44AE41BF87F6DF0F6E8CBFD5328BC25B', 'hasPrivateKey': True} Dec 16 12:27:31.538580 waagent[2001]: 2025-12-16T12:27:31.538543Z INFO ExtHandler Fetch goal state completed Dec 16 12:27:31.549721 waagent[2001]: 2025-12-16T12:27:31.549665Z INFO ExtHandler ExtHandler OpenSSL version: OpenSSL 3.4.2 1 Jul 2025 (Library: OpenSSL 3.4.2 1 Jul 2025) Dec 16 12:27:31.553047 waagent[2001]: 2025-12-16T12:27:31.553000Z INFO ExtHandler ExtHandler WALinuxAgent-2.12.0.4 running as process 2001 Dec 16 12:27:31.553149 waagent[2001]: 2025-12-16T12:27:31.553123Z INFO ExtHandler ExtHandler ******** AutoUpdate.Enabled is set to False, not processing the operation ******** Dec 16 12:27:31.553413 waagent[2001]: 2025-12-16T12:27:31.553384Z INFO ExtHandler ExtHandler ******** AutoUpdate.UpdateToLatestVersion is set to False, not processing the operation ******** Dec 16 12:27:31.554495 waagent[2001]: 2025-12-16T12:27:31.554459Z INFO ExtHandler ExtHandler [CGI] Cgroup monitoring is not supported on ['flatcar', '4459.2.2', '', 'Flatcar Container Linux by Kinvolk'] Dec 16 12:27:31.554799 waagent[2001]: 2025-12-16T12:27:31.554769Z INFO ExtHandler ExtHandler [CGI] Agent will reset the quotas in case distro: ['flatcar', '4459.2.2', '', 'Flatcar Container Linux by Kinvolk'] went from supported to unsupported Dec 16 12:27:31.554903 waagent[2001]: 2025-12-16T12:27:31.554882Z INFO ExtHandler ExtHandler [CGI] Agent cgroups enabled: False Dec 16 12:27:31.555328 waagent[2001]: 2025-12-16T12:27:31.555302Z INFO ExtHandler ExtHandler Starting setup for Persistent firewall rules Dec 16 12:27:31.592297 waagent[2001]: 2025-12-16T12:27:31.592201Z INFO ExtHandler ExtHandler Firewalld service not running/unavailable, trying to set up waagent-network-setup.service Dec 16 12:27:31.592421 waagent[2001]: 2025-12-16T12:27:31.592391Z INFO ExtHandler ExtHandler Successfully updated the Binary file /var/lib/waagent/waagent-network-setup.py for firewall setup Dec 16 12:27:31.596855 waagent[2001]: 2025-12-16T12:27:31.596828Z INFO ExtHandler ExtHandler Service: waagent-network-setup.service not enabled. Adding it now Dec 16 12:27:31.609650 systemd[1]: Reload requested from client PID 2016 ('systemctl') (unit waagent.service)... Dec 16 12:27:31.609664 systemd[1]: Reloading... Dec 16 12:27:31.693291 zram_generator::config[2067]: No configuration found. Dec 16 12:27:31.837356 systemd[1]: Reloading finished in 227 ms. Dec 16 12:27:31.850438 waagent[2001]: 2025-12-16T12:27:31.849659Z INFO ExtHandler ExtHandler Successfully added and enabled the waagent-network-setup.service Dec 16 12:27:31.850438 waagent[2001]: 2025-12-16T12:27:31.849813Z INFO ExtHandler ExtHandler Persistent firewall rules setup successfully Dec 16 12:27:32.067898 waagent[2001]: 2025-12-16T12:27:32.067833Z INFO ExtHandler ExtHandler DROP rule is not available which implies no firewall rules are set yet. Environment thread will set it up. Dec 16 12:27:32.068325 waagent[2001]: 2025-12-16T12:27:32.068288Z 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] Dec 16 12:27:32.069090 waagent[2001]: 2025-12-16T12:27:32.069049Z INFO ExtHandler ExtHandler Starting env monitor service. Dec 16 12:27:32.069241 waagent[2001]: 2025-12-16T12:27:32.069153Z INFO MonitorHandler ExtHandler WireServer endpoint 168.63.129.16 read from file Dec 16 12:27:32.069586 waagent[2001]: 2025-12-16T12:27:32.069549Z INFO ExtHandler ExtHandler Start SendTelemetryHandler service. Dec 16 12:27:32.069675 waagent[2001]: 2025-12-16T12:27:32.069644Z INFO MonitorHandler ExtHandler Wire server endpoint:168.63.129.16 Dec 16 12:27:32.069871 waagent[2001]: 2025-12-16T12:27:32.069842Z INFO MonitorHandler ExtHandler Monitor.NetworkConfigurationChanges is disabled. Dec 16 12:27:32.070133 waagent[2001]: 2025-12-16T12:27:32.070101Z INFO EnvHandler ExtHandler WireServer endpoint 168.63.129.16 read from file Dec 16 12:27:32.070173 waagent[2001]: 2025-12-16T12:27:32.070150Z INFO EnvHandler ExtHandler Wire server endpoint:168.63.129.16 Dec 16 12:27:32.070271 waagent[2001]: 2025-12-16T12:27:32.070244Z INFO EnvHandler ExtHandler Configure routes Dec 16 12:27:32.070312 waagent[2001]: 2025-12-16T12:27:32.070297Z INFO EnvHandler ExtHandler Gateway:None Dec 16 12:27:32.070378 waagent[2001]: 2025-12-16T12:27:32.070324Z INFO EnvHandler ExtHandler Routes:None Dec 16 12:27:32.070777 waagent[2001]: 2025-12-16T12:27:32.070751Z INFO SendTelemetryHandler ExtHandler Successfully started the SendTelemetryHandler thread Dec 16 12:27:32.070895 waagent[2001]: 2025-12-16T12:27:32.070851Z INFO ExtHandler ExtHandler Start Extension Telemetry service. Dec 16 12:27:32.071010 waagent[2001]: 2025-12-16T12:27:32.070980Z INFO MonitorHandler ExtHandler Routing table from /proc/net/route: Dec 16 12:27:32.071010 waagent[2001]: Iface Destination Gateway Flags RefCnt Use Metric Mask MTU Window IRTT Dec 16 12:27:32.071010 waagent[2001]: eth0 00000000 0114C80A 0003 0 0 1024 00000000 0 0 0 Dec 16 12:27:32.071010 waagent[2001]: eth0 0014C80A 00000000 0001 0 0 1024 00FFFFFF 0 0 0 Dec 16 12:27:32.071010 waagent[2001]: eth0 0114C80A 00000000 0005 0 0 1024 FFFFFFFF 0 0 0 Dec 16 12:27:32.071010 waagent[2001]: eth0 10813FA8 0114C80A 0007 0 0 1024 FFFFFFFF 0 0 0 Dec 16 12:27:32.071010 waagent[2001]: eth0 FEA9FEA9 0114C80A 0007 0 0 1024 FFFFFFFF 0 0 0 Dec 16 12:27:32.071604 waagent[2001]: 2025-12-16T12:27:32.071565Z INFO TelemetryEventsCollector ExtHandler Extension Telemetry pipeline enabled: True Dec 16 12:27:32.071649 waagent[2001]: 2025-12-16T12:27:32.071639Z INFO TelemetryEventsCollector ExtHandler Successfully started the TelemetryEventsCollector thread Dec 16 12:27:32.072454 waagent[2001]: 2025-12-16T12:27:32.072401Z INFO ExtHandler ExtHandler Goal State Period: 6 sec. This indicates how often the agent checks for new goal states and reports status. Dec 16 12:27:32.081412 waagent[2001]: 2025-12-16T12:27:32.081366Z INFO ExtHandler ExtHandler Dec 16 12:27:32.081469 waagent[2001]: 2025-12-16T12:27:32.081438Z INFO ExtHandler ExtHandler ProcessExtensionsGoalState started [incarnation_1 channel: WireServer source: Fabric activity: 9796742b-67da-4e5e-aa35-28899ea643b8 correlation 7282d0be-bc53-4901-a2cd-2b7669cd21cd created: 2025-12-16T12:26:32.249115Z] Dec 16 12:27:32.081733 waagent[2001]: 2025-12-16T12:27:32.081700Z INFO ExtHandler ExtHandler No extension handlers found, not processing anything. Dec 16 12:27:32.082118 waagent[2001]: 2025-12-16T12:27:32.082091Z INFO ExtHandler ExtHandler ProcessExtensionsGoalState completed [incarnation_1 0 ms] Dec 16 12:27:32.105373 waagent[2001]: 2025-12-16T12:27:32.105269Z WARNING ExtHandler ExtHandler Failed to get firewall packets: 'iptables -w -t security -L OUTPUT --zero OUTPUT -nxv' failed: 2 (iptables v1.8.11 (nf_tables): Illegal option `--numeric' with this command Dec 16 12:27:32.105373 waagent[2001]: Try `iptables -h' or 'iptables --help' for more information.) Dec 16 12:27:32.105635 waagent[2001]: 2025-12-16T12:27:32.105602Z INFO ExtHandler ExtHandler [HEARTBEAT] Agent WALinuxAgent-2.12.0.4 is running as the goal state agent [DEBUG HeartbeatCounter: 0;HeartbeatId: 8440786E-F278-44C1-8941-B7EC913C53DF;DroppedPackets: -1;UpdateGSErrors: 0;AutoUpdate: 0;UpdateMode: SelfUpdate;] Dec 16 12:27:32.142133 waagent[2001]: 2025-12-16T12:27:32.142060Z INFO MonitorHandler ExtHandler Network interfaces: Dec 16 12:27:32.142133 waagent[2001]: Executing ['ip', '-a', '-o', 'link']: Dec 16 12:27:32.142133 waagent[2001]: 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 Dec 16 12:27:32.142133 waagent[2001]: 2: eth0: mtu 1500 qdisc mq state UP mode DEFAULT group default qlen 1000\ link/ether 00:22:48:b5:de:eb brd ff:ff:ff:ff:ff:ff Dec 16 12:27:32.142133 waagent[2001]: 3: enP18756s1: mtu 1500 qdisc mq master eth0 state UP mode DEFAULT group default qlen 1000\ link/ether 00:22:48:b5:de:eb brd ff:ff:ff:ff:ff:ff\ altname enP18756p0s2 Dec 16 12:27:32.142133 waagent[2001]: Executing ['ip', '-4', '-a', '-o', 'address']: Dec 16 12:27:32.142133 waagent[2001]: 1: lo inet 127.0.0.1/8 scope host lo\ valid_lft forever preferred_lft forever Dec 16 12:27:32.142133 waagent[2001]: 2: eth0 inet 10.200.20.16/24 metric 1024 brd 10.200.20.255 scope global eth0\ valid_lft forever preferred_lft forever Dec 16 12:27:32.142133 waagent[2001]: Executing ['ip', '-6', '-a', '-o', 'address']: Dec 16 12:27:32.142133 waagent[2001]: 1: lo inet6 ::1/128 scope host noprefixroute \ valid_lft forever preferred_lft forever Dec 16 12:27:32.142133 waagent[2001]: 2: eth0 inet6 fe80::222:48ff:feb5:deeb/64 scope link proto kernel_ll \ valid_lft forever preferred_lft forever Dec 16 12:27:32.174251 waagent[2001]: 2025-12-16T12:27:32.173899Z INFO EnvHandler ExtHandler Created firewall rules for the Azure Fabric: Dec 16 12:27:32.174251 waagent[2001]: Chain INPUT (policy ACCEPT 0 packets, 0 bytes) Dec 16 12:27:32.174251 waagent[2001]: pkts bytes target prot opt in out source destination Dec 16 12:27:32.174251 waagent[2001]: Chain FORWARD (policy ACCEPT 0 packets, 0 bytes) Dec 16 12:27:32.174251 waagent[2001]: pkts bytes target prot opt in out source destination Dec 16 12:27:32.174251 waagent[2001]: Chain OUTPUT (policy ACCEPT 6 packets, 888 bytes) Dec 16 12:27:32.174251 waagent[2001]: pkts bytes target prot opt in out source destination Dec 16 12:27:32.174251 waagent[2001]: 0 0 ACCEPT tcp -- * * 0.0.0.0/0 168.63.129.16 tcp dpt:53 Dec 16 12:27:32.174251 waagent[2001]: 2 112 ACCEPT tcp -- * * 0.0.0.0/0 168.63.129.16 owner UID match 0 Dec 16 12:27:32.174251 waagent[2001]: 0 0 DROP tcp -- * * 0.0.0.0/0 168.63.129.16 ctstate INVALID,NEW Dec 16 12:27:32.177085 waagent[2001]: 2025-12-16T12:27:32.177038Z INFO EnvHandler ExtHandler Current Firewall rules: Dec 16 12:27:32.177085 waagent[2001]: Chain INPUT (policy ACCEPT 0 packets, 0 bytes) Dec 16 12:27:32.177085 waagent[2001]: pkts bytes target prot opt in out source destination Dec 16 12:27:32.177085 waagent[2001]: Chain FORWARD (policy ACCEPT 0 packets, 0 bytes) Dec 16 12:27:32.177085 waagent[2001]: pkts bytes target prot opt in out source destination Dec 16 12:27:32.177085 waagent[2001]: Chain OUTPUT (policy ACCEPT 6 packets, 888 bytes) Dec 16 12:27:32.177085 waagent[2001]: pkts bytes target prot opt in out source destination Dec 16 12:27:32.177085 waagent[2001]: 0 0 ACCEPT tcp -- * * 0.0.0.0/0 168.63.129.16 tcp dpt:53 Dec 16 12:27:32.177085 waagent[2001]: 4 416 ACCEPT tcp -- * * 0.0.0.0/0 168.63.129.16 owner UID match 0 Dec 16 12:27:32.177085 waagent[2001]: 0 0 DROP tcp -- * * 0.0.0.0/0 168.63.129.16 ctstate INVALID,NEW Dec 16 12:27:32.177311 waagent[2001]: 2025-12-16T12:27:32.177285Z INFO EnvHandler ExtHandler Set block dev timeout: sda with timeout: 300 Dec 16 12:27:48.522361 systemd[1]: Created slice system-sshd.slice - Slice /system/sshd. Dec 16 12:27:48.523373 systemd[1]: Started sshd@0-10.200.20.16:22-10.200.16.10:44538.service - OpenSSH per-connection server daemon (10.200.16.10:44538). Dec 16 12:27:49.152513 sshd[2143]: Accepted publickey for core from 10.200.16.10 port 44538 ssh2: RSA SHA256:0sW83PWlkN2oSGFUMV36+zNC2S3SSsFxfZRU5Tfj1Ag Dec 16 12:27:49.153605 sshd-session[2143]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Dec 16 12:27:49.157059 systemd-logind[1778]: New session 3 of user core. Dec 16 12:27:49.165320 systemd[1]: Started session-3.scope - Session 3 of User core. Dec 16 12:27:49.582472 systemd[1]: Started sshd@1-10.200.20.16:22-10.200.16.10:44554.service - OpenSSH per-connection server daemon (10.200.16.10:44554). Dec 16 12:27:50.065801 sshd[2149]: Accepted publickey for core from 10.200.16.10 port 44554 ssh2: RSA SHA256:0sW83PWlkN2oSGFUMV36+zNC2S3SSsFxfZRU5Tfj1Ag Dec 16 12:27:50.066857 sshd-session[2149]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Dec 16 12:27:50.070414 systemd-logind[1778]: New session 4 of user core. Dec 16 12:27:50.079335 systemd[1]: Started session-4.scope - Session 4 of User core. Dec 16 12:27:50.406320 sshd[2152]: Connection closed by 10.200.16.10 port 44554 Dec 16 12:27:50.406139 sshd-session[2149]: pam_unix(sshd:session): session closed for user core Dec 16 12:27:50.409091 systemd[1]: sshd@1-10.200.20.16:22-10.200.16.10:44554.service: Deactivated successfully. Dec 16 12:27:50.410588 systemd[1]: session-4.scope: Deactivated successfully. Dec 16 12:27:50.411804 systemd-logind[1778]: Session 4 logged out. Waiting for processes to exit. Dec 16 12:27:50.413403 systemd-logind[1778]: Removed session 4. Dec 16 12:27:50.493212 systemd[1]: Started sshd@2-10.200.20.16:22-10.200.16.10:52978.service - OpenSSH per-connection server daemon (10.200.16.10:52978). Dec 16 12:27:50.981901 sshd[2158]: Accepted publickey for core from 10.200.16.10 port 52978 ssh2: RSA SHA256:0sW83PWlkN2oSGFUMV36+zNC2S3SSsFxfZRU5Tfj1Ag Dec 16 12:27:50.983003 sshd-session[2158]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Dec 16 12:27:50.986679 systemd-logind[1778]: New session 5 of user core. Dec 16 12:27:50.993326 systemd[1]: Started session-5.scope - Session 5 of User core. Dec 16 12:27:51.328855 sshd[2161]: Connection closed by 10.200.16.10 port 52978 Dec 16 12:27:51.329341 sshd-session[2158]: pam_unix(sshd:session): session closed for user core Dec 16 12:27:51.333096 systemd-logind[1778]: Session 5 logged out. Waiting for processes to exit. Dec 16 12:27:51.333342 systemd[1]: sshd@2-10.200.20.16:22-10.200.16.10:52978.service: Deactivated successfully. Dec 16 12:27:51.334628 systemd[1]: session-5.scope: Deactivated successfully. Dec 16 12:27:51.337732 systemd-logind[1778]: Removed session 5. Dec 16 12:27:51.419758 systemd[1]: Started sshd@3-10.200.20.16:22-10.200.16.10:52984.service - OpenSSH per-connection server daemon (10.200.16.10:52984). Dec 16 12:27:51.471952 chronyd[1759]: Selected source PHC0 Dec 16 12:27:51.912231 sshd[2167]: Accepted publickey for core from 10.200.16.10 port 52984 ssh2: RSA SHA256:0sW83PWlkN2oSGFUMV36+zNC2S3SSsFxfZRU5Tfj1Ag Dec 16 12:27:51.913298 sshd-session[2167]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Dec 16 12:27:51.916879 systemd-logind[1778]: New session 6 of user core. Dec 16 12:27:51.927342 systemd[1]: Started session-6.scope - Session 6 of User core. Dec 16 12:27:52.261981 sshd[2170]: Connection closed by 10.200.16.10 port 52984 Dec 16 12:27:52.261401 sshd-session[2167]: pam_unix(sshd:session): session closed for user core Dec 16 12:27:52.264079 systemd[1]: sshd@3-10.200.20.16:22-10.200.16.10:52984.service: Deactivated successfully. Dec 16 12:27:52.265505 systemd[1]: session-6.scope: Deactivated successfully. Dec 16 12:27:52.267103 systemd-logind[1778]: Session 6 logged out. Waiting for processes to exit. Dec 16 12:27:52.268530 systemd-logind[1778]: Removed session 6. Dec 16 12:27:52.347019 systemd[1]: Started sshd@4-10.200.20.16:22-10.200.16.10:52986.service - OpenSSH per-connection server daemon (10.200.16.10:52986). Dec 16 12:27:52.806710 sshd[2176]: Accepted publickey for core from 10.200.16.10 port 52986 ssh2: RSA SHA256:0sW83PWlkN2oSGFUMV36+zNC2S3SSsFxfZRU5Tfj1Ag Dec 16 12:27:52.807783 sshd-session[2176]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Dec 16 12:27:52.811412 systemd-logind[1778]: New session 7 of user core. Dec 16 12:27:52.818490 systemd[1]: Started session-7.scope - Session 7 of User core. Dec 16 12:27:53.639635 sudo[2180]: core : PWD=/home/core ; USER=root ; COMMAND=/usr/sbin/setenforce 1 Dec 16 12:27:53.639861 sudo[2180]: pam_unix(sudo:session): session opened for user root(uid=0) by core(uid=500) Dec 16 12:27:53.666529 sudo[2180]: pam_unix(sudo:session): session closed for user root Dec 16 12:27:53.745347 sshd[2179]: Connection closed by 10.200.16.10 port 52986 Dec 16 12:27:53.744446 sshd-session[2176]: pam_unix(sshd:session): session closed for user core Dec 16 12:27:53.748296 systemd[1]: sshd@4-10.200.20.16:22-10.200.16.10:52986.service: Deactivated successfully. Dec 16 12:27:53.749822 systemd[1]: session-7.scope: Deactivated successfully. Dec 16 12:27:53.750455 systemd-logind[1778]: Session 7 logged out. Waiting for processes to exit. Dec 16 12:27:53.751576 systemd-logind[1778]: Removed session 7. Dec 16 12:27:53.843086 systemd[1]: Started sshd@5-10.200.20.16:22-10.200.16.10:52988.service - OpenSSH per-connection server daemon (10.200.16.10:52988). Dec 16 12:27:54.339255 sshd[2186]: Accepted publickey for core from 10.200.16.10 port 52988 ssh2: RSA SHA256:0sW83PWlkN2oSGFUMV36+zNC2S3SSsFxfZRU5Tfj1Ag Dec 16 12:27:54.340712 sshd-session[2186]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Dec 16 12:27:54.344039 systemd-logind[1778]: New session 8 of user core. Dec 16 12:27:54.354433 systemd[1]: Started session-8.scope - Session 8 of User core. Dec 16 12:27:54.612824 sudo[2191]: core : PWD=/home/core ; USER=root ; COMMAND=/usr/sbin/rm -rf /etc/audit/rules.d/80-selinux.rules /etc/audit/rules.d/99-default.rules Dec 16 12:27:54.613044 sudo[2191]: pam_unix(sudo:session): session opened for user root(uid=0) by core(uid=500) Dec 16 12:27:54.628530 sudo[2191]: pam_unix(sudo:session): session closed for user root Dec 16 12:27:54.632509 sudo[2190]: core : PWD=/home/core ; USER=root ; COMMAND=/usr/sbin/systemctl restart audit-rules Dec 16 12:27:54.632709 sudo[2190]: pam_unix(sudo:session): session opened for user root(uid=0) by core(uid=500) Dec 16 12:27:54.640494 systemd[1]: Starting audit-rules.service - Load Audit Rules... Dec 16 12:27:54.668356 augenrules[2213]: No rules Dec 16 12:27:54.669591 systemd[1]: audit-rules.service: Deactivated successfully. Dec 16 12:27:54.671250 systemd[1]: Finished audit-rules.service - Load Audit Rules. Dec 16 12:27:54.672672 sudo[2190]: pam_unix(sudo:session): session closed for user root Dec 16 12:27:54.749366 sshd[2189]: Connection closed by 10.200.16.10 port 52988 Dec 16 12:27:54.749886 sshd-session[2186]: pam_unix(sshd:session): session closed for user core Dec 16 12:27:54.753211 systemd[1]: sshd@5-10.200.20.16:22-10.200.16.10:52988.service: Deactivated successfully. Dec 16 12:27:54.754602 systemd[1]: session-8.scope: Deactivated successfully. Dec 16 12:27:54.755480 systemd-logind[1778]: Session 8 logged out. Waiting for processes to exit. Dec 16 12:27:54.756979 systemd-logind[1778]: Removed session 8. Dec 16 12:27:59.070913 systemd[1]: Started sshd@6-10.200.20.16:22-10.200.16.10:52996.service - OpenSSH per-connection server daemon (10.200.16.10:52996). Dec 16 12:27:59.559980 sshd[2222]: Accepted publickey for core from 10.200.16.10 port 52996 ssh2: RSA SHA256:0sW83PWlkN2oSGFUMV36+zNC2S3SSsFxfZRU5Tfj1Ag Dec 16 12:27:59.561040 sshd-session[2222]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Dec 16 12:27:59.564596 systemd-logind[1778]: New session 9 of user core. Dec 16 12:27:59.572332 systemd[1]: Started session-9.scope - Session 9 of User core. Dec 16 12:27:59.836309 sudo[2230]: core : PWD=/tmp/tmp.gOZB6HFXGe ; USER=root ; COMMAND=/usr/sbin/ldd /usr/bin/nc /usr/bin/timeout Dec 16 12:27:59.836522 sudo[2230]: pam_unix(sudo:session): session opened for user root(uid=0) by core(uid=500) Dec 16 12:27:59.887691 sudo[2230]: pam_unix(sudo:session): session closed for user root Dec 16 12:27:59.892507 sudo[2242]: core : PWD=/tmp/tmp.gOZB6HFXGe ; USER=root ; COMMAND=/usr/sbin/rsync -av --relative --copy-links /usr/bin/nc /usr/bin/timeout /lib/ld-linux-aarch64.so.1 /lib64/ld-linux-aarch64.so.1 /lib64/libbsd.so.0 /lib64/libc.so.6 /lib64/libmd.so.0 /lib64/libresolv.so.2 ./ Dec 16 12:27:59.892708 sudo[2242]: pam_unix(sudo:session): session opened for user root(uid=0) by core(uid=500) Dec 16 12:27:59.981817 sudo[2242]: pam_unix(sudo:session): session closed for user root Dec 16 12:27:59.986459 sudo[2226]: core : PWD=/tmp/tmp.gOZB6HFXGe ; USER=root ; COMMAND=/usr/sbin/docker build -t netcat . Dec 16 12:27:59.986678 sudo[2226]: pam_unix(sudo:session): session opened for user root(uid=0) by core(uid=500) Dec 16 12:28:00.413634 systemd[1]: Starting docker.service - Docker Application Container Engine... Dec 16 12:28:00.425494 (dockerd)[2253]: docker.service: Referenced but unset environment variable evaluates to an empty string: DOCKER_CGROUPS, DOCKER_OPTS, DOCKER_OPT_BIP, DOCKER_OPT_IPMASQ, DOCKER_OPT_MTU Dec 16 12:28:01.196411 dockerd[2253]: time="2025-12-16T12:28:01.196358410Z" level=info msg="Starting up" Dec 16 12:28:01.199156 dockerd[2253]: time="2025-12-16T12:28:01.198778464Z" level=info msg="OTEL tracing is not configured, using no-op tracer provider" Dec 16 12:28:01.207130 dockerd[2253]: time="2025-12-16T12:28:01.207097588Z" level=info msg="Creating a containerd client" address=/var/run/docker/libcontainerd/docker-containerd.sock timeout=1m0s Dec 16 12:28:01.242683 systemd[1]: var-lib-docker-check\x2doverlayfs\x2dsupport382414429-merged.mount: Deactivated successfully. Dec 16 12:28:01.283408 dockerd[2253]: time="2025-12-16T12:28:01.282739171Z" level=info msg="Loading containers: start." Dec 16 12:28:01.328204 kernel: Initializing XFRM netlink socket Dec 16 12:28:01.614110 systemd-networkd[1489]: docker0: Link UP Dec 16 12:28:01.630474 dockerd[2253]: time="2025-12-16T12:28:01.630423897Z" level=info msg="Loading containers: done." Dec 16 12:28:01.660072 dockerd[2253]: time="2025-12-16T12:28:01.660018961Z" level=warning msg="Not using native diff for overlay2, this may cause degraded performance for building images: kernel has CONFIG_OVERLAY_FS_REDIRECT_DIR enabled" storage-driver=overlay2 Dec 16 12:28:01.660262 dockerd[2253]: time="2025-12-16T12:28:01.660124316Z" level=info msg="Docker daemon" commit=6430e49a55babd9b8f4d08e70ecb2b68900770fe containerd-snapshotter=false storage-driver=overlay2 version=28.0.4 Dec 16 12:28:01.660262 dockerd[2253]: time="2025-12-16T12:28:01.660248015Z" level=info msg="Initializing buildkit" Dec 16 12:28:01.716069 dockerd[2253]: time="2025-12-16T12:28:01.716026949Z" level=info msg="Completed buildkit initialization" Dec 16 12:28:01.722034 dockerd[2253]: time="2025-12-16T12:28:01.721975156Z" level=info msg="Daemon has completed initialization" Dec 16 12:28:01.722169 dockerd[2253]: time="2025-12-16T12:28:01.722044302Z" level=info msg="API listen on /run/docker.sock" Dec 16 12:28:01.723210 systemd[1]: Started docker.service - Docker Application Container Engine. Dec 16 12:28:02.319037 dockerd[2253]: 2025/12/16 12:28:02 http2: server: error reading preface from client @: read unix /run/docker.sock->@: read: connection reset by peer Dec 16 12:28:03.050561 sudo[2226]: pam_unix(sudo:session): session closed for user root Dec 16 12:28:03.127829 sshd[2225]: Connection closed by 10.200.16.10 port 52996 Dec 16 12:28:03.128390 sshd-session[2222]: pam_unix(sshd:session): session closed for user core Dec 16 12:28:03.132102 systemd-logind[1778]: Session 9 logged out. Waiting for processes to exit. Dec 16 12:28:03.132667 systemd[1]: sshd@6-10.200.20.16:22-10.200.16.10:52996.service: Deactivated successfully. Dec 16 12:28:03.134686 systemd[1]: session-9.scope: Deactivated successfully. Dec 16 12:28:03.134959 systemd[1]: session-9.scope: Consumed 261ms CPU time, 123M memory peak. Dec 16 12:28:03.136530 systemd-logind[1778]: Removed session 9. Dec 16 12:28:03.211451 systemd[1]: Started sshd@7-10.200.20.16:22-10.200.16.10:34392.service - OpenSSH per-connection server daemon (10.200.16.10:34392). Dec 16 12:28:03.213358 systemd[1]: Started sshd@8-10.200.20.16:22-10.200.16.10:34390.service - OpenSSH per-connection server daemon (10.200.16.10:34390). Dec 16 12:28:03.658294 sshd[2483]: Accepted publickey for core from 10.200.16.10 port 34392 ssh2: RSA SHA256:0sW83PWlkN2oSGFUMV36+zNC2S3SSsFxfZRU5Tfj1Ag Dec 16 12:28:03.659451 sshd-session[2483]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Dec 16 12:28:03.662761 systemd-logind[1778]: New session 10 of user core. Dec 16 12:28:03.670316 systemd[1]: Started session-10.scope - Session 10 of User core. Dec 16 12:28:03.698488 sshd[2484]: Accepted publickey for core from 10.200.16.10 port 34390 ssh2: RSA SHA256:0sW83PWlkN2oSGFUMV36+zNC2S3SSsFxfZRU5Tfj1Ag Dec 16 12:28:03.699944 sshd-session[2484]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Dec 16 12:28:03.703649 systemd-logind[1778]: New session 11 of user core. Dec 16 12:28:03.708322 systemd[1]: Started session-11.scope - Session 11 of User core. Dec 16 12:28:03.972865 sudo[2501]: core : PWD=/home/core ; USER=root ; COMMAND=/usr/sbin/lsof -i TCP:9988 -s TCP:LISTEN Dec 16 12:28:03.973072 sudo[2501]: pam_unix(sudo:session): session opened for user root(uid=0) by core(uid=500) Dec 16 12:28:04.037071 sudo[2501]: pam_unix(sudo:session): session closed for user root Dec 16 12:28:04.082698 containerd[1804]: time="2025-12-16T12:28:04.082645059Z" level=info msg="connecting to shim 6a27ec53e1c043cae98c996754673f5d48934a419743ba16225746c2a503a74c" address="unix:///run/containerd/s/156f62b144ba1a5425c9fffe9221e2729a2eb0aead527d2f642caf7f98100339" namespace=moby protocol=ttrpc version=3 Dec 16 12:28:04.101534 systemd[1]: Started docker-6a27ec53e1c043cae98c996754673f5d48934a419743ba16225746c2a503a74c.scope - libcontainer container 6a27ec53e1c043cae98c996754673f5d48934a419743ba16225746c2a503a74c. Dec 16 12:28:04.114496 sshd[2490]: Connection closed by 10.200.16.10 port 34390 Dec 16 12:28:04.116372 sshd-session[2484]: pam_unix(sshd:session): session closed for user core Dec 16 12:28:04.120428 systemd[1]: sshd@8-10.200.20.16:22-10.200.16.10:34390.service: Deactivated successfully. Dec 16 12:28:04.122903 systemd[1]: session-11.scope: Deactivated successfully. Dec 16 12:28:04.126206 systemd-logind[1778]: Session 11 logged out. Waiting for processes to exit. Dec 16 12:28:04.128748 systemd-logind[1778]: Removed session 11. Dec 16 12:28:04.166226 kernel: docker0: port 1(vethe073bda) entered blocking state Dec 16 12:28:04.166349 kernel: docker0: port 1(vethe073bda) entered disabled state Dec 16 12:28:04.169640 kernel: vethe073bda: entered allmulticast mode Dec 16 12:28:04.170331 kernel: vethe073bda: entered promiscuous mode Dec 16 12:28:04.174579 systemd-networkd[1489]: vethe073bda: Link UP Dec 16 12:28:04.204212 kernel: eth0: renamed from veth065201b Dec 16 12:28:04.211151 kernel: docker0: port 1(vethe073bda) entered blocking state Dec 16 12:28:04.211237 kernel: docker0: port 1(vethe073bda) entered forwarding state Dec 16 12:28:04.211311 systemd-networkd[1489]: vethe073bda: Gained carrier Dec 16 12:28:04.212421 systemd-networkd[1489]: docker0: Gained carrier Dec 16 12:28:04.307743 systemd[1]: Started sshd@9-10.200.20.16:22-10.200.16.10:34406.service - OpenSSH per-connection server daemon (10.200.16.10:34406). Dec 16 12:28:04.793806 sshd[2564]: Accepted publickey for core from 10.200.16.10 port 34406 ssh2: RSA SHA256:0sW83PWlkN2oSGFUMV36+zNC2S3SSsFxfZRU5Tfj1Ag Dec 16 12:28:04.794847 sshd-session[2564]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Dec 16 12:28:04.798663 systemd-logind[1778]: New session 12 of user core. Dec 16 12:28:04.808519 systemd[1]: Started session-12.scope - Session 12 of User core. Dec 16 12:28:05.066851 sudo[2588]: core : PWD=/home/core ; USER=root ; COMMAND=/usr/sbin/lsof -i TCP:9988 -s TCP:LISTEN Dec 16 12:28:05.067066 sudo[2588]: pam_unix(sudo:session): session opened for user root(uid=0) by core(uid=500) Dec 16 12:28:05.089947 sudo[2588]: pam_unix(sudo:session): session closed for user root Dec 16 12:28:05.166866 sshd[2586]: Connection closed by 10.200.16.10 port 34406 Dec 16 12:28:05.167416 sshd-session[2564]: pam_unix(sshd:session): session closed for user core Dec 16 12:28:05.170813 systemd[1]: sshd@9-10.200.20.16:22-10.200.16.10:34406.service: Deactivated successfully. Dec 16 12:28:05.172159 systemd[1]: session-12.scope: Deactivated successfully. Dec 16 12:28:05.172780 systemd-logind[1778]: Session 12 logged out. Waiting for processes to exit. Dec 16 12:28:05.173751 systemd-logind[1778]: Removed session 12. Dec 16 12:28:05.720517 systemd-networkd[1489]: docker0: Gained IPv6LL Dec 16 12:28:06.168514 systemd-networkd[1489]: vethe073bda: Gained IPv6LL Dec 16 12:28:06.274299 systemd[1]: docker-6a27ec53e1c043cae98c996754673f5d48934a419743ba16225746c2a503a74c.scope: Deactivated successfully. Dec 16 12:28:06.287291 containerd[1804]: time="2025-12-16T12:28:06.287176285Z" level=info msg="shim disconnected" id=6a27ec53e1c043cae98c996754673f5d48934a419743ba16225746c2a503a74c namespace=moby Dec 16 12:28:06.287291 containerd[1804]: time="2025-12-16T12:28:06.287245303Z" level=warning msg="cleaning up after shim disconnected" id=6a27ec53e1c043cae98c996754673f5d48934a419743ba16225746c2a503a74c namespace=moby Dec 16 12:28:06.287291 containerd[1804]: time="2025-12-16T12:28:06.287268304Z" level=info msg="cleaning up dead shim" namespace=moby Dec 16 12:28:06.287826 dockerd[2253]: time="2025-12-16T12:28:06.287294705Z" level=info msg="ignoring event" container=6a27ec53e1c043cae98c996754673f5d48934a419743ba16225746c2a503a74c module=libcontainerd namespace=moby topic=/tasks/delete type="*events.TaskDelete" Dec 16 12:28:06.332259 kernel: docker0: port 1(vethe073bda) entered disabled state Dec 16 12:28:06.332346 kernel: veth065201b: renamed from eth0 Dec 16 12:28:06.331934 systemd-networkd[1489]: vethe073bda: Lost carrier Dec 16 12:28:06.361085 systemd-networkd[1489]: vethe073bda: Link DOWN Dec 16 12:28:06.365714 kernel: docker0: port 1(vethe073bda) entered disabled state Dec 16 12:28:06.365777 kernel: vethe073bda (unregistering): left allmulticast mode Dec 16 12:28:06.369873 kernel: vethe073bda (unregistering): left promiscuous mode Dec 16 12:28:06.374326 kernel: docker0: port 1(vethe073bda) entered disabled state Dec 16 12:28:06.394263 systemd[1]: run-docker-netns-de03ab333a78.mount: Deactivated successfully. Dec 16 12:28:06.400409 systemd[1]: var-lib-docker-overlay2-2bc5e6f6916af0038445ef90d438add3fbc786e9b384267dc7af7d5bf54e34bb-merged.mount: Deactivated successfully. Dec 16 12:28:06.527814 sshd[2489]: Connection closed by 10.200.16.10 port 34392 Dec 16 12:28:06.527279 sshd-session[2483]: pam_unix(sshd:session): session closed for user core Dec 16 12:28:06.530466 systemd[1]: sshd@7-10.200.20.16:22-10.200.16.10:34392.service: Deactivated successfully. Dec 16 12:28:06.531612 systemd-logind[1778]: Session 10 logged out. Waiting for processes to exit. Dec 16 12:28:06.532330 systemd[1]: session-10.scope: Deactivated successfully. Dec 16 12:28:06.535132 systemd-logind[1778]: Removed session 10. Dec 16 12:28:07.384431 systemd-networkd[1489]: docker0: Lost carrier