Jan 23 00:05:52.084179 kernel: Booting Linux on physical CPU 0x0000000000 [0x410fd490] Jan 23 00:05:52.084196 kernel: Linux version 6.12.66-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 Thu Jan 22 22:21:53 -00 2026 Jan 23 00:05:52.084202 kernel: KASLR enabled Jan 23 00:05:52.084207 kernel: earlycon: pl11 at MMIO 0x00000000effec000 (options '') Jan 23 00:05:52.084210 kernel: printk: legacy bootconsole [pl11] enabled Jan 23 00:05:52.084215 kernel: efi: EFI v2.7 by EDK II Jan 23 00:05:52.084220 kernel: efi: ACPI 2.0=0x3f979018 SMBIOS=0x3f8a0000 SMBIOS 3.0=0x3f880000 MEMATTR=0x3e89d018 RNG=0x3f979998 MEMRESERVE=0x3db83598 Jan 23 00:05:52.084224 kernel: random: crng init done Jan 23 00:05:52.084228 kernel: secureboot: Secure boot disabled Jan 23 00:05:52.084232 kernel: ACPI: Early table checksum verification disabled Jan 23 00:05:52.084236 kernel: ACPI: RSDP 0x000000003F979018 000024 (v02 VRTUAL) Jan 23 00:05:52.084240 kernel: ACPI: XSDT 0x000000003F979F18 00006C (v01 VRTUAL MICROSFT 00000001 MSFT 00000001) Jan 23 00:05:52.084244 kernel: ACPI: FACP 0x000000003F979C18 000114 (v06 VRTUAL MICROSFT 00000001 MSFT 00000001) Jan 23 00:05:52.084248 kernel: ACPI: DSDT 0x000000003F95A018 01E046 (v02 MSFTVM DSDT01 00000001 INTL 20230628) Jan 23 00:05:52.084254 kernel: ACPI: DBG2 0x000000003F979B18 000072 (v00 VRTUAL MICROSFT 00000001 MSFT 00000001) Jan 23 00:05:52.084258 kernel: ACPI: GTDT 0x000000003F979D98 000060 (v02 VRTUAL MICROSFT 00000001 MSFT 00000001) Jan 23 00:05:52.084262 kernel: ACPI: OEM0 0x000000003F979098 000064 (v01 VRTUAL MICROSFT 00000001 MSFT 00000001) Jan 23 00:05:52.084267 kernel: ACPI: SPCR 0x000000003F979A98 000050 (v02 VRTUAL MICROSFT 00000001 MSFT 00000001) Jan 23 00:05:52.084271 kernel: ACPI: APIC 0x000000003F979818 0000FC (v04 VRTUAL MICROSFT 00000001 MSFT 00000001) Jan 23 00:05:52.084276 kernel: ACPI: SRAT 0x000000003F979198 000234 (v03 VRTUAL MICROSFT 00000001 MSFT 00000001) Jan 23 00:05:52.084292 kernel: ACPI: PPTT 0x000000003F979418 000120 (v01 VRTUAL MICROSFT 00000000 MSFT 00000000) Jan 23 00:05:52.084297 kernel: ACPI: BGRT 0x000000003F979E98 000038 (v01 VRTUAL MICROSFT 00000001 MSFT 00000001) Jan 23 00:05:52.084301 kernel: ACPI: SPCR: console: pl011,mmio32,0xeffec000,115200 Jan 23 00:05:52.084305 kernel: ACPI: Use ACPI SPCR as default console: Yes Jan 23 00:05:52.084309 kernel: ACPI: SRAT: Node 0 PXM 0 [mem 0x00000000-0x3fffffff] hotplug Jan 23 00:05:52.084313 kernel: ACPI: SRAT: Node 0 PXM 0 [mem 0x100000000-0x1bfffffff] hotplug Jan 23 00:05:52.084318 kernel: ACPI: SRAT: Node 0 PXM 0 [mem 0x1c0000000-0xfbfffffff] hotplug Jan 23 00:05:52.084322 kernel: ACPI: SRAT: Node 0 PXM 0 [mem 0x1000000000-0xffffffffff] hotplug Jan 23 00:05:52.084326 kernel: ACPI: SRAT: Node 0 PXM 0 [mem 0x10000000000-0x1ffffffffff] hotplug Jan 23 00:05:52.084330 kernel: ACPI: SRAT: Node 0 PXM 0 [mem 0x20000000000-0x3ffffffffff] hotplug Jan 23 00:05:52.084336 kernel: ACPI: SRAT: Node 0 PXM 0 [mem 0x40000000000-0x7ffffffffff] hotplug Jan 23 00:05:52.084340 kernel: ACPI: SRAT: Node 0 PXM 0 [mem 0x80000000000-0xfffffffffff] hotplug Jan 23 00:05:52.084344 kernel: ACPI: SRAT: Node 0 PXM 0 [mem 0x100000000000-0x1fffffffffff] hotplug Jan 23 00:05:52.084348 kernel: ACPI: SRAT: Node 0 PXM 0 [mem 0x200000000000-0x3fffffffffff] hotplug Jan 23 00:05:52.084353 kernel: ACPI: SRAT: Node 0 PXM 0 [mem 0x400000000000-0x7fffffffffff] hotplug Jan 23 00:05:52.084357 kernel: ACPI: SRAT: Node 0 PXM 0 [mem 0x800000000000-0xffffffffffff] hotplug Jan 23 00:05:52.084361 kernel: NUMA: Node 0 [mem 0x00000000-0x3fffffff] + [mem 0x100000000-0x1bfffffff] -> [mem 0x00000000-0x1bfffffff] Jan 23 00:05:52.084365 kernel: NODE_DATA(0) allocated [mem 0x1bf7ffa00-0x1bf806fff] Jan 23 00:05:52.084370 kernel: Zone ranges: Jan 23 00:05:52.084374 kernel: DMA [mem 0x0000000000000000-0x00000000ffffffff] Jan 23 00:05:52.084381 kernel: DMA32 empty Jan 23 00:05:52.084385 kernel: Normal [mem 0x0000000100000000-0x00000001bfffffff] Jan 23 00:05:52.084390 kernel: Device empty Jan 23 00:05:52.084394 kernel: Movable zone start for each node Jan 23 00:05:52.084398 kernel: Early memory node ranges Jan 23 00:05:52.084403 kernel: node 0: [mem 0x0000000000000000-0x00000000007fffff] Jan 23 00:05:52.084408 kernel: node 0: [mem 0x0000000000824000-0x000000003f38ffff] Jan 23 00:05:52.084412 kernel: node 0: [mem 0x000000003f390000-0x000000003f93ffff] Jan 23 00:05:52.084416 kernel: node 0: [mem 0x000000003f940000-0x000000003f9effff] Jan 23 00:05:52.084421 kernel: node 0: [mem 0x000000003f9f0000-0x000000003fdeffff] Jan 23 00:05:52.084425 kernel: node 0: [mem 0x000000003fdf0000-0x000000003fffffff] Jan 23 00:05:52.084429 kernel: node 0: [mem 0x0000000100000000-0x00000001bfffffff] Jan 23 00:05:52.084434 kernel: Initmem setup node 0 [mem 0x0000000000000000-0x00000001bfffffff] Jan 23 00:05:52.084438 kernel: On node 0, zone DMA: 36 pages in unavailable ranges Jan 23 00:05:52.084443 kernel: cma: Reserved 16 MiB at 0x000000003ca00000 on node -1 Jan 23 00:05:52.084447 kernel: psci: probing for conduit method from ACPI. Jan 23 00:05:52.084451 kernel: psci: PSCIv1.3 detected in firmware. Jan 23 00:05:52.084456 kernel: psci: Using standard PSCI v0.2 function IDs Jan 23 00:05:52.084461 kernel: psci: MIGRATE_INFO_TYPE not supported. Jan 23 00:05:52.084465 kernel: psci: SMC Calling Convention v1.4 Jan 23 00:05:52.084470 kernel: ACPI: NUMA: SRAT: PXM 0 -> MPIDR 0x0 -> Node 0 Jan 23 00:05:52.084474 kernel: ACPI: NUMA: SRAT: PXM 0 -> MPIDR 0x1 -> Node 0 Jan 23 00:05:52.084478 kernel: percpu: Embedded 33 pages/cpu s98200 r8192 d28776 u135168 Jan 23 00:05:52.084483 kernel: pcpu-alloc: s98200 r8192 d28776 u135168 alloc=33*4096 Jan 23 00:05:52.084487 kernel: pcpu-alloc: [0] 0 [0] 1 Jan 23 00:05:52.084492 kernel: Detected PIPT I-cache on CPU0 Jan 23 00:05:52.084496 kernel: CPU features: detected: Address authentication (architected QARMA5 algorithm) Jan 23 00:05:52.084500 kernel: CPU features: detected: GIC system register CPU interface Jan 23 00:05:52.084505 kernel: CPU features: detected: Spectre-v4 Jan 23 00:05:52.084509 kernel: CPU features: detected: Spectre-BHB Jan 23 00:05:52.084514 kernel: CPU features: kernel page table isolation forced ON by KASLR Jan 23 00:05:52.084519 kernel: CPU features: detected: Kernel page table isolation (KPTI) Jan 23 00:05:52.084523 kernel: CPU features: detected: ARM erratum 2067961 or 2054223 Jan 23 00:05:52.084527 kernel: CPU features: detected: SSBS not fully self-synchronizing Jan 23 00:05:52.084532 kernel: alternatives: applying boot alternatives Jan 23 00:05:52.084537 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=38aa0560e146398cb8c3378a56d449784f1c7652139d7b61279d764fcc4c793a Jan 23 00:05:52.084542 kernel: Dentry cache hash table entries: 524288 (order: 10, 4194304 bytes, linear) Jan 23 00:05:52.084546 kernel: Inode-cache hash table entries: 262144 (order: 9, 2097152 bytes, linear) Jan 23 00:05:52.084551 kernel: Fallback order for Node 0: 0 Jan 23 00:05:52.084555 kernel: Built 1 zonelists, mobility grouping on. Total pages: 1048540 Jan 23 00:05:52.084560 kernel: Policy zone: Normal Jan 23 00:05:52.084564 kernel: mem auto-init: stack:off, heap alloc:off, heap free:off Jan 23 00:05:52.084569 kernel: software IO TLB: area num 2. Jan 23 00:05:52.084573 kernel: software IO TLB: mapped [mem 0x0000000035900000-0x0000000039900000] (64MB) Jan 23 00:05:52.084577 kernel: SLUB: HWalign=64, Order=0-3, MinObjects=0, CPUs=2, Nodes=1 Jan 23 00:05:52.084582 kernel: rcu: Preemptible hierarchical RCU implementation. Jan 23 00:05:52.084587 kernel: rcu: RCU event tracing is enabled. Jan 23 00:05:52.084591 kernel: rcu: RCU restricting CPUs from NR_CPUS=512 to nr_cpu_ids=2. Jan 23 00:05:52.084596 kernel: Trampoline variant of Tasks RCU enabled. Jan 23 00:05:52.084600 kernel: Tracing variant of Tasks RCU enabled. Jan 23 00:05:52.084604 kernel: rcu: RCU calculated value of scheduler-enlistment delay is 100 jiffies. Jan 23 00:05:52.084609 kernel: rcu: Adjusting geometry for rcu_fanout_leaf=16, nr_cpu_ids=2 Jan 23 00:05:52.084614 kernel: RCU Tasks: Setting shift to 1 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=2. Jan 23 00:05:52.084619 kernel: RCU Tasks Trace: Setting shift to 1 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=2. Jan 23 00:05:52.084623 kernel: NR_IRQS: 64, nr_irqs: 64, preallocated irqs: 0 Jan 23 00:05:52.084628 kernel: GICv3: 960 SPIs implemented Jan 23 00:05:52.084632 kernel: GICv3: 0 Extended SPIs implemented Jan 23 00:05:52.084636 kernel: Root IRQ handler: gic_handle_irq Jan 23 00:05:52.084641 kernel: GICv3: GICv3 features: 16 PPIs, RSS Jan 23 00:05:52.084645 kernel: GICv3: GICD_CTRL.DS=0, SCR_EL3.FIQ=0 Jan 23 00:05:52.084649 kernel: GICv3: CPU0: found redistributor 0 region 0:0x00000000effee000 Jan 23 00:05:52.084654 kernel: ITS: No ITS available, not enabling LPIs Jan 23 00:05:52.084658 kernel: rcu: srcu_init: Setting srcu_struct sizes based on contention. Jan 23 00:05:52.084663 kernel: arch_timer: cp15 timer(s) running at 1000.00MHz (virt). Jan 23 00:05:52.084668 kernel: clocksource: arch_sys_counter: mask: 0x1fffffffffffffff max_cycles: 0x1cd42e4dffb, max_idle_ns: 881590591483 ns Jan 23 00:05:52.084672 kernel: sched_clock: 61 bits at 1000MHz, resolution 1ns, wraps every 4398046511103ns Jan 23 00:05:52.084677 kernel: Console: colour dummy device 80x25 Jan 23 00:05:52.084681 kernel: printk: legacy console [tty1] enabled Jan 23 00:05:52.084686 kernel: ACPI: Core revision 20240827 Jan 23 00:05:52.084691 kernel: Calibrating delay loop (skipped), value calculated using timer frequency.. 2000.00 BogoMIPS (lpj=1000000) Jan 23 00:05:52.084695 kernel: pid_max: default: 32768 minimum: 301 Jan 23 00:05:52.084700 kernel: LSM: initializing lsm=lockdown,capability,landlock,selinux,ima Jan 23 00:05:52.084704 kernel: landlock: Up and running. Jan 23 00:05:52.084710 kernel: SELinux: Initializing. Jan 23 00:05:52.084714 kernel: Mount-cache hash table entries: 8192 (order: 4, 65536 bytes, linear) Jan 23 00:05:52.084719 kernel: Mountpoint-cache hash table entries: 8192 (order: 4, 65536 bytes, linear) Jan 23 00:05:52.084723 kernel: Hyper-V: privilege flags low 0x2e7f, high 0x3b8030, hints 0xa0000e, misc 0x31e1 Jan 23 00:05:52.084728 kernel: Hyper-V: Host Build 10.0.26102.1172-1-0 Jan 23 00:05:52.084736 kernel: Hyper-V: enabling crash_kexec_post_notifiers Jan 23 00:05:52.084742 kernel: rcu: Hierarchical SRCU implementation. Jan 23 00:05:52.084747 kernel: rcu: Max phase no-delay instances is 400. Jan 23 00:05:52.084752 kernel: Timer migration: 1 hierarchy levels; 8 children per group; 1 crossnode level Jan 23 00:05:52.084756 kernel: Remapping and enabling EFI services. Jan 23 00:05:52.084761 kernel: smp: Bringing up secondary CPUs ... Jan 23 00:05:52.084766 kernel: Detected PIPT I-cache on CPU1 Jan 23 00:05:52.084772 kernel: GICv3: CPU1: found redistributor 1 region 1:0x00000000f000e000 Jan 23 00:05:52.084776 kernel: CPU1: Booted secondary processor 0x0000000001 [0x410fd490] Jan 23 00:05:52.084781 kernel: smp: Brought up 1 node, 2 CPUs Jan 23 00:05:52.084786 kernel: SMP: Total of 2 processors activated. Jan 23 00:05:52.084791 kernel: CPU: All CPU(s) started at EL1 Jan 23 00:05:52.084796 kernel: CPU features: detected: 32-bit EL0 Support Jan 23 00:05:52.084801 kernel: CPU features: detected: Instruction cache invalidation not required for I/D coherence Jan 23 00:05:52.084806 kernel: CPU features: detected: Data cache clean to the PoU not required for I/D coherence Jan 23 00:05:52.084811 kernel: CPU features: detected: Common not Private translations Jan 23 00:05:52.084815 kernel: CPU features: detected: CRC32 instructions Jan 23 00:05:52.084820 kernel: CPU features: detected: Generic authentication (architected QARMA5 algorithm) Jan 23 00:05:52.084825 kernel: CPU features: detected: RCpc load-acquire (LDAPR) Jan 23 00:05:52.084830 kernel: CPU features: detected: LSE atomic instructions Jan 23 00:05:52.084835 kernel: CPU features: detected: Privileged Access Never Jan 23 00:05:52.084840 kernel: CPU features: detected: Speculation barrier (SB) Jan 23 00:05:52.084845 kernel: CPU features: detected: TLB range maintenance instructions Jan 23 00:05:52.084850 kernel: CPU features: detected: Speculative Store Bypassing Safe (SSBS) Jan 23 00:05:52.084854 kernel: CPU features: detected: Scalable Vector Extension Jan 23 00:05:52.084859 kernel: alternatives: applying system-wide alternatives Jan 23 00:05:52.084864 kernel: CPU features: detected: Hardware dirty bit management on CPU0-1 Jan 23 00:05:52.084869 kernel: SVE: maximum available vector length 16 bytes per vector Jan 23 00:05:52.084873 kernel: SVE: default vector length 16 bytes per vector Jan 23 00:05:52.084879 kernel: Memory: 3952828K/4194160K available (11200K kernel code, 2458K rwdata, 9088K rodata, 39552K init, 1038K bss, 220144K reserved, 16384K cma-reserved) Jan 23 00:05:52.084885 kernel: devtmpfs: initialized Jan 23 00:05:52.084889 kernel: clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1911260446275000 ns Jan 23 00:05:52.084894 kernel: futex hash table entries: 512 (order: 3, 32768 bytes, linear) Jan 23 00:05:52.084899 kernel: 2G module region forced by RANDOMIZE_MODULE_REGION_FULL Jan 23 00:05:52.084904 kernel: 0 pages in range for non-PLT usage Jan 23 00:05:52.084908 kernel: 508400 pages in range for PLT usage Jan 23 00:05:52.084913 kernel: pinctrl core: initialized pinctrl subsystem Jan 23 00:05:52.084918 kernel: SMBIOS 3.1.0 present. Jan 23 00:05:52.084924 kernel: DMI: Microsoft Corporation Virtual Machine/Virtual Machine, BIOS Hyper-V UEFI Release v4.1 06/10/2025 Jan 23 00:05:52.084928 kernel: DMI: Memory slots populated: 2/2 Jan 23 00:05:52.084933 kernel: NET: Registered PF_NETLINK/PF_ROUTE protocol family Jan 23 00:05:52.084938 kernel: DMA: preallocated 512 KiB GFP_KERNEL pool for atomic allocations Jan 23 00:05:52.084943 kernel: DMA: preallocated 512 KiB GFP_KERNEL|GFP_DMA pool for atomic allocations Jan 23 00:05:52.084948 kernel: DMA: preallocated 512 KiB GFP_KERNEL|GFP_DMA32 pool for atomic allocations Jan 23 00:05:52.084952 kernel: audit: initializing netlink subsys (disabled) Jan 23 00:05:52.084957 kernel: audit: type=2000 audit(0.059:1): state=initialized audit_enabled=0 res=1 Jan 23 00:05:52.084962 kernel: thermal_sys: Registered thermal governor 'step_wise' Jan 23 00:05:52.084967 kernel: cpuidle: using governor menu Jan 23 00:05:52.084972 kernel: hw-breakpoint: found 6 breakpoint and 4 watchpoint registers. Jan 23 00:05:52.084977 kernel: ASID allocator initialised with 32768 entries Jan 23 00:05:52.084982 kernel: acpiphp: ACPI Hot Plug PCI Controller Driver version: 0.5 Jan 23 00:05:52.084987 kernel: Serial: AMBA PL011 UART driver Jan 23 00:05:52.084991 kernel: HugeTLB: registered 1.00 GiB page size, pre-allocated 0 pages Jan 23 00:05:52.084996 kernel: HugeTLB: 0 KiB vmemmap can be freed for a 1.00 GiB page Jan 23 00:05:52.085001 kernel: HugeTLB: registered 32.0 MiB page size, pre-allocated 0 pages Jan 23 00:05:52.085006 kernel: HugeTLB: 0 KiB vmemmap can be freed for a 32.0 MiB page Jan 23 00:05:52.085011 kernel: HugeTLB: registered 2.00 MiB page size, pre-allocated 0 pages Jan 23 00:05:52.085016 kernel: HugeTLB: 0 KiB vmemmap can be freed for a 2.00 MiB page Jan 23 00:05:52.085021 kernel: HugeTLB: registered 64.0 KiB page size, pre-allocated 0 pages Jan 23 00:05:52.085026 kernel: HugeTLB: 0 KiB vmemmap can be freed for a 64.0 KiB page Jan 23 00:05:52.085030 kernel: ACPI: Added _OSI(Module Device) Jan 23 00:05:52.085035 kernel: ACPI: Added _OSI(Processor Device) Jan 23 00:05:52.085040 kernel: ACPI: Added _OSI(Processor Aggregator Device) Jan 23 00:05:52.085044 kernel: ACPI: 1 ACPI AML tables successfully acquired and loaded Jan 23 00:05:52.085049 kernel: ACPI: Interpreter enabled Jan 23 00:05:52.085055 kernel: ACPI: Using GIC for interrupt routing Jan 23 00:05:52.085060 kernel: ARMH0011:00: ttyAMA0 at MMIO 0xeffec000 (irq = 12, base_baud = 0) is a SBSA Jan 23 00:05:52.085064 kernel: printk: legacy console [ttyAMA0] enabled Jan 23 00:05:52.085069 kernel: printk: legacy bootconsole [pl11] disabled Jan 23 00:05:52.085074 kernel: ARMH0011:01: ttyAMA1 at MMIO 0xeffeb000 (irq = 13, base_baud = 0) is a SBSA Jan 23 00:05:52.085079 kernel: ACPI: CPU0 has been hot-added Jan 23 00:05:52.085083 kernel: ACPI: CPU1 has been hot-added Jan 23 00:05:52.085088 kernel: iommu: Default domain type: Translated Jan 23 00:05:52.085093 kernel: iommu: DMA domain TLB invalidation policy: strict mode Jan 23 00:05:52.085098 kernel: efivars: Registered efivars operations Jan 23 00:05:52.085103 kernel: vgaarb: loaded Jan 23 00:05:52.085108 kernel: clocksource: Switched to clocksource arch_sys_counter Jan 23 00:05:52.085112 kernel: VFS: Disk quotas dquot_6.6.0 Jan 23 00:05:52.085117 kernel: VFS: Dquot-cache hash table entries: 512 (order 0, 4096 bytes) Jan 23 00:05:52.085122 kernel: pnp: PnP ACPI init Jan 23 00:05:52.085127 kernel: pnp: PnP ACPI: found 0 devices Jan 23 00:05:52.085131 kernel: NET: Registered PF_INET protocol family Jan 23 00:05:52.085136 kernel: IP idents hash table entries: 65536 (order: 7, 524288 bytes, linear) Jan 23 00:05:52.085141 kernel: tcp_listen_portaddr_hash hash table entries: 2048 (order: 3, 32768 bytes, linear) Jan 23 00:05:52.085147 kernel: Table-perturb hash table entries: 65536 (order: 6, 262144 bytes, linear) Jan 23 00:05:52.085152 kernel: TCP established hash table entries: 32768 (order: 6, 262144 bytes, linear) Jan 23 00:05:52.085156 kernel: TCP bind hash table entries: 32768 (order: 8, 1048576 bytes, linear) Jan 23 00:05:52.085161 kernel: TCP: Hash tables configured (established 32768 bind 32768) Jan 23 00:05:52.085166 kernel: UDP hash table entries: 2048 (order: 4, 65536 bytes, linear) Jan 23 00:05:52.085171 kernel: UDP-Lite hash table entries: 2048 (order: 4, 65536 bytes, linear) Jan 23 00:05:52.085175 kernel: NET: Registered PF_UNIX/PF_LOCAL protocol family Jan 23 00:05:52.085180 kernel: PCI: CLS 0 bytes, default 64 Jan 23 00:05:52.085185 kernel: kvm [1]: HYP mode not available Jan 23 00:05:52.085190 kernel: Initialise system trusted keyrings Jan 23 00:05:52.085195 kernel: workingset: timestamp_bits=39 max_order=20 bucket_order=0 Jan 23 00:05:52.085200 kernel: Key type asymmetric registered Jan 23 00:05:52.085204 kernel: Asymmetric key parser 'x509' registered Jan 23 00:05:52.085209 kernel: Block layer SCSI generic (bsg) driver version 0.4 loaded (major 249) Jan 23 00:05:52.085214 kernel: io scheduler mq-deadline registered Jan 23 00:05:52.085219 kernel: io scheduler kyber registered Jan 23 00:05:52.085223 kernel: io scheduler bfq registered Jan 23 00:05:52.085228 kernel: Serial: 8250/16550 driver, 4 ports, IRQ sharing enabled Jan 23 00:05:52.085234 kernel: thunder_xcv, ver 1.0 Jan 23 00:05:52.085239 kernel: thunder_bgx, ver 1.0 Jan 23 00:05:52.085243 kernel: nicpf, ver 1.0 Jan 23 00:05:52.085248 kernel: nicvf, ver 1.0 Jan 23 00:05:52.085366 kernel: rtc-efi rtc-efi.0: registered as rtc0 Jan 23 00:05:52.085419 kernel: rtc-efi rtc-efi.0: setting system clock to 2026-01-23T00:05:51 UTC (1769126751) Jan 23 00:05:52.085426 kernel: efifb: probing for efifb Jan 23 00:05:52.085432 kernel: efifb: framebuffer at 0x40000000, using 3072k, total 3072k Jan 23 00:05:52.085437 kernel: efifb: mode is 1024x768x32, linelength=4096, pages=1 Jan 23 00:05:52.085442 kernel: efifb: scrolling: redraw Jan 23 00:05:52.085446 kernel: efifb: Truecolor: size=8:8:8:8, shift=24:16:8:0 Jan 23 00:05:52.085451 kernel: Console: switching to colour frame buffer device 128x48 Jan 23 00:05:52.085456 kernel: fb0: EFI VGA frame buffer device Jan 23 00:05:52.085461 kernel: SMCCC: SOC_ID: ARCH_SOC_ID not implemented, skipping .... Jan 23 00:05:52.085465 kernel: hid: raw HID events driver (C) Jiri Kosina Jan 23 00:05:52.085470 kernel: hw perfevents: enabled with armv8_pmuv3_0 PMU driver, 7 (0,8000003f) counters available Jan 23 00:05:52.085476 kernel: watchdog: NMI not fully supported Jan 23 00:05:52.085481 kernel: watchdog: Hard watchdog permanently disabled Jan 23 00:05:52.085485 kernel: NET: Registered PF_INET6 protocol family Jan 23 00:05:52.085490 kernel: Segment Routing with IPv6 Jan 23 00:05:52.085495 kernel: In-situ OAM (IOAM) with IPv6 Jan 23 00:05:52.085500 kernel: NET: Registered PF_PACKET protocol family Jan 23 00:05:52.085504 kernel: Key type dns_resolver registered Jan 23 00:05:52.085509 kernel: registered taskstats version 1 Jan 23 00:05:52.085514 kernel: Loading compiled-in X.509 certificates Jan 23 00:05:52.085519 kernel: Loaded X.509 cert 'Kinvolk GmbH: Module signing key for 6.12.66-flatcar: 380753d9165686712e58c1d21e00c0268e70f18f' Jan 23 00:05:52.085524 kernel: Demotion targets for Node 0: null Jan 23 00:05:52.085529 kernel: Key type .fscrypt registered Jan 23 00:05:52.085533 kernel: Key type fscrypt-provisioning registered Jan 23 00:05:52.085538 kernel: ima: No TPM chip found, activating TPM-bypass! Jan 23 00:05:52.085543 kernel: ima: Allocated hash algorithm: sha1 Jan 23 00:05:52.085548 kernel: ima: No architecture policies found Jan 23 00:05:52.085552 kernel: alg: No test for fips(ansi_cprng) (fips_ansi_cprng) Jan 23 00:05:52.085557 kernel: clk: Disabling unused clocks Jan 23 00:05:52.085562 kernel: PM: genpd: Disabling unused power domains Jan 23 00:05:52.085567 kernel: Warning: unable to open an initial console. Jan 23 00:05:52.085572 kernel: Freeing unused kernel memory: 39552K Jan 23 00:05:52.085577 kernel: Run /init as init process Jan 23 00:05:52.085582 kernel: with arguments: Jan 23 00:05:52.085586 kernel: /init Jan 23 00:05:52.085591 kernel: with environment: Jan 23 00:05:52.085595 kernel: HOME=/ Jan 23 00:05:52.085600 kernel: TERM=linux Jan 23 00:05:52.085606 systemd[1]: Successfully made /usr/ read-only. Jan 23 00:05:52.085613 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) Jan 23 00:05:52.085619 systemd[1]: Detected virtualization microsoft. Jan 23 00:05:52.085624 systemd[1]: Detected architecture arm64. Jan 23 00:05:52.085629 systemd[1]: Running in initrd. Jan 23 00:05:52.085634 systemd[1]: No hostname configured, using default hostname. Jan 23 00:05:52.085639 systemd[1]: Hostname set to . Jan 23 00:05:52.085644 systemd[1]: Initializing machine ID from random generator. Jan 23 00:05:52.085651 systemd[1]: Queued start job for default target initrd.target. Jan 23 00:05:52.085656 systemd[1]: Started clevis-luks-askpass.path - Forward Password Requests to Clevis Directory Watch. Jan 23 00:05:52.085661 systemd[1]: Started systemd-ask-password-console.path - Dispatch Password Requests to Console Directory Watch. Jan 23 00:05:52.085667 systemd[1]: Expecting device dev-disk-by\x2dlabel-EFI\x2dSYSTEM.device - /dev/disk/by-label/EFI-SYSTEM... Jan 23 00:05:52.085672 systemd[1]: Expecting device dev-disk-by\x2dlabel-OEM.device - /dev/disk/by-label/OEM... Jan 23 00:05:52.085677 systemd[1]: Expecting device dev-disk-by\x2dlabel-ROOT.device - /dev/disk/by-label/ROOT... Jan 23 00:05:52.085683 systemd[1]: Expecting device dev-disk-by\x2dpartlabel-USR\x2dA.device - /dev/disk/by-partlabel/USR-A... Jan 23 00:05:52.085690 systemd[1]: Expecting device dev-disk-by\x2dpartuuid-7130c94a\x2d213a\x2d4e5a\x2d8e26\x2d6cce9662f132.device - /dev/disk/by-partuuid/7130c94a-213a-4e5a-8e26-6cce9662f132... Jan 23 00:05:52.085695 systemd[1]: Expecting device dev-mapper-usr.device - /dev/mapper/usr... Jan 23 00:05:52.085700 systemd[1]: Reached target cryptsetup-pre.target - Local Encrypted Volumes (Pre). Jan 23 00:05:52.085706 systemd[1]: Reached target cryptsetup.target - Local Encrypted Volumes. Jan 23 00:05:52.085711 systemd[1]: Reached target paths.target - Path Units. Jan 23 00:05:52.085716 systemd[1]: Reached target slices.target - Slice Units. Jan 23 00:05:52.085721 systemd[1]: Reached target swap.target - Swaps. Jan 23 00:05:52.085726 systemd[1]: Reached target timers.target - Timer Units. Jan 23 00:05:52.085732 systemd[1]: Listening on iscsid.socket - Open-iSCSI iscsid Socket. Jan 23 00:05:52.085738 systemd[1]: Listening on iscsiuio.socket - Open-iSCSI iscsiuio Socket. Jan 23 00:05:52.085743 systemd[1]: Listening on systemd-journald-dev-log.socket - Journal Socket (/dev/log). Jan 23 00:05:52.085748 systemd[1]: Listening on systemd-journald.socket - Journal Sockets. Jan 23 00:05:52.085753 systemd[1]: Listening on systemd-networkd.socket - Network Service Netlink Socket. Jan 23 00:05:52.085759 systemd[1]: Listening on systemd-udevd-control.socket - udev Control Socket. Jan 23 00:05:52.085764 systemd[1]: Listening on systemd-udevd-kernel.socket - udev Kernel Socket. Jan 23 00:05:52.085769 systemd[1]: Reached target sockets.target - Socket Units. Jan 23 00:05:52.085774 systemd[1]: Starting ignition-setup-pre.service - Ignition env setup... Jan 23 00:05:52.085780 systemd[1]: Starting kmod-static-nodes.service - Create List of Static Device Nodes... Jan 23 00:05:52.085785 systemd[1]: Finished network-cleanup.service - Network Cleanup. Jan 23 00:05:52.085791 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). Jan 23 00:05:52.085796 systemd[1]: Starting systemd-fsck-usr.service... Jan 23 00:05:52.085801 systemd[1]: Starting systemd-journald.service - Journal Service... Jan 23 00:05:52.085806 systemd[1]: Starting systemd-modules-load.service - Load Kernel Modules... Jan 23 00:05:52.085823 systemd-journald[225]: Collecting audit messages is disabled. Jan 23 00:05:52.085838 systemd-journald[225]: Journal started Jan 23 00:05:52.085852 systemd-journald[225]: Runtime Journal (/run/log/journal/b0d1b32adce34678b929c25bd5164a08) is 8M, max 78.3M, 70.3M free. Jan 23 00:05:52.093318 systemd[1]: Starting systemd-vconsole-setup.service - Virtual Console Setup... Jan 23 00:05:52.098604 systemd-modules-load[227]: Inserted module 'overlay' Jan 23 00:05:52.120622 kernel: bridge: filtering via arp/ip/ip6tables is no longer available by default. Update your scripts to load br_netfilter if you need this. Jan 23 00:05:52.120661 kernel: Bridge firewalling registered Jan 23 00:05:52.120670 systemd[1]: Started systemd-journald.service - Journal Service. Jan 23 00:05:52.120734 systemd-modules-load[227]: Inserted module 'br_netfilter' Jan 23 00:05:52.132718 systemd[1]: Finished ignition-setup-pre.service - Ignition env setup. Jan 23 00:05:52.138777 systemd[1]: Finished kmod-static-nodes.service - Create List of Static Device Nodes. Jan 23 00:05:52.148817 systemd[1]: Finished systemd-fsck-usr.service. Jan 23 00:05:52.157118 systemd[1]: Finished systemd-modules-load.service - Load Kernel Modules. Jan 23 00:05:52.165011 systemd[1]: Finished systemd-vconsole-setup.service - Virtual Console Setup. Jan 23 00:05:52.176791 systemd[1]: Starting dracut-cmdline-ask.service - dracut ask for additional cmdline parameters... Jan 23 00:05:52.192490 systemd[1]: Starting systemd-sysctl.service - Apply Kernel Variables... Jan 23 00:05:52.205404 systemd[1]: Starting systemd-tmpfiles-setup-dev-early.service - Create Static Device Nodes in /dev gracefully... Jan 23 00:05:52.219666 systemd[1]: Starting systemd-tmpfiles-setup.service - Create System Files and Directories... Jan 23 00:05:52.235788 systemd[1]: Finished systemd-sysctl.service - Apply Kernel Variables. Jan 23 00:05:52.243829 systemd-tmpfiles[246]: /usr/lib/tmpfiles.d/var.conf:14: Duplicate line for path "/var/log", ignoring. Jan 23 00:05:52.246401 systemd[1]: Finished dracut-cmdline-ask.service - dracut ask for additional cmdline parameters. Jan 23 00:05:52.254299 systemd[1]: Finished systemd-tmpfiles-setup-dev-early.service - Create Static Device Nodes in /dev gracefully. Jan 23 00:05:52.264435 systemd[1]: Finished systemd-tmpfiles-setup.service - Create System Files and Directories. Jan 23 00:05:52.276893 systemd[1]: Starting dracut-cmdline.service - dracut cmdline hook... Jan 23 00:05:52.299131 systemd[1]: Starting systemd-resolved.service - Network Name Resolution... Jan 23 00:05:52.311879 systemd[1]: Starting systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev... Jan 23 00:05:52.330679 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=38aa0560e146398cb8c3378a56d449784f1c7652139d7b61279d764fcc4c793a Jan 23 00:05:52.357115 systemd[1]: Finished systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev. Jan 23 00:05:52.360218 systemd-resolved[262]: Positive Trust Anchors: Jan 23 00:05:52.360227 systemd-resolved[262]: . IN DS 20326 8 2 e06d44b80b8f1d39a95c0b0d7c65d08458e880409bbc683457104237c7f8ec8d Jan 23 00:05:52.360247 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 Jan 23 00:05:52.361847 systemd-resolved[262]: Defaulting to hostname 'linux'. Jan 23 00:05:52.368369 systemd[1]: Started systemd-resolved.service - Network Name Resolution. Jan 23 00:05:52.374561 systemd[1]: Reached target nss-lookup.target - Host and Network Name Lookups. Jan 23 00:05:52.481308 kernel: SCSI subsystem initialized Jan 23 00:05:52.487294 kernel: Loading iSCSI transport class v2.0-870. Jan 23 00:05:52.495314 kernel: iscsi: registered transport (tcp) Jan 23 00:05:52.508102 kernel: iscsi: registered transport (qla4xxx) Jan 23 00:05:52.508113 kernel: QLogic iSCSI HBA Driver Jan 23 00:05:52.522274 systemd[1]: Starting systemd-network-generator.service - Generate network units from Kernel command line... Jan 23 00:05:52.540093 systemd[1]: Finished systemd-network-generator.service - Generate network units from Kernel command line. Jan 23 00:05:52.546828 systemd[1]: Reached target network-pre.target - Preparation for Network. Jan 23 00:05:52.599826 systemd[1]: Finished dracut-cmdline.service - dracut cmdline hook. Jan 23 00:05:52.605647 systemd[1]: Starting dracut-pre-udev.service - dracut pre-udev hook... Jan 23 00:05:52.675298 kernel: raid6: neonx8 gen() 18544 MB/s Jan 23 00:05:52.694286 kernel: raid6: neonx4 gen() 18550 MB/s Jan 23 00:05:52.713287 kernel: raid6: neonx2 gen() 17069 MB/s Jan 23 00:05:52.733286 kernel: raid6: neonx1 gen() 14997 MB/s Jan 23 00:05:52.752285 kernel: raid6: int64x8 gen() 10521 MB/s Jan 23 00:05:52.771286 kernel: raid6: int64x4 gen() 10606 MB/s Jan 23 00:05:52.791286 kernel: raid6: int64x2 gen() 8964 MB/s Jan 23 00:05:52.812957 kernel: raid6: int64x1 gen() 7009 MB/s Jan 23 00:05:52.812965 kernel: raid6: using algorithm neonx4 gen() 18550 MB/s Jan 23 00:05:52.834835 kernel: raid6: .... xor() 15145 MB/s, rmw enabled Jan 23 00:05:52.834842 kernel: raid6: using neon recovery algorithm Jan 23 00:05:52.843390 kernel: xor: measuring software checksum speed Jan 23 00:05:52.843398 kernel: 8regs : 28595 MB/sec Jan 23 00:05:52.846286 kernel: 32regs : 28789 MB/sec Jan 23 00:05:52.852735 kernel: arm64_neon : 34681 MB/sec Jan 23 00:05:52.852742 kernel: xor: using function: arm64_neon (34681 MB/sec) Jan 23 00:05:52.891305 kernel: Btrfs loaded, zoned=no, fsverity=no Jan 23 00:05:52.897335 systemd[1]: Finished dracut-pre-udev.service - dracut pre-udev hook. Jan 23 00:05:52.906805 systemd[1]: Starting systemd-udevd.service - Rule-based Manager for Device Events and Files... Jan 23 00:05:52.934598 systemd-udevd[473]: Using default interface naming scheme 'v255'. Jan 23 00:05:52.939732 systemd[1]: Started systemd-udevd.service - Rule-based Manager for Device Events and Files. Jan 23 00:05:52.954127 systemd[1]: Starting dracut-pre-trigger.service - dracut pre-trigger hook... Jan 23 00:05:52.990943 dracut-pre-trigger[482]: rd.md=0: removing MD RAID activation Jan 23 00:05:53.011502 systemd[1]: Finished dracut-pre-trigger.service - dracut pre-trigger hook. Jan 23 00:05:53.023035 systemd[1]: Starting systemd-udev-trigger.service - Coldplug All udev Devices... Jan 23 00:05:53.069661 systemd[1]: Finished systemd-udev-trigger.service - Coldplug All udev Devices. Jan 23 00:05:53.081779 systemd[1]: Starting dracut-initqueue.service - dracut initqueue hook... Jan 23 00:05:53.142299 kernel: hv_vmbus: Vmbus version:5.3 Jan 23 00:05:53.145066 systemd[1]: systemd-vconsole-setup.service: Deactivated successfully. Jan 23 00:05:53.149992 systemd[1]: Stopped systemd-vconsole-setup.service - Virtual Console Setup. Jan 23 00:05:53.167392 systemd[1]: Stopping systemd-vconsole-setup.service - Virtual Console Setup... Jan 23 00:05:53.184321 kernel: hv_vmbus: registering driver hyperv_keyboard Jan 23 00:05:53.184342 kernel: pps_core: LinuxPPS API ver. 1 registered Jan 23 00:05:53.184348 kernel: pps_core: Software ver. 5.3.6 - Copyright 2005-2007 Rodolfo Giometti Jan 23 00:05:53.195410 systemd[1]: Starting systemd-vconsole-setup.service - Virtual Console Setup... Jan 23 00:05:53.216431 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 Jan 23 00:05:53.216455 kernel: hv_vmbus: registering driver hid_hyperv Jan 23 00:05:53.216462 kernel: input: Microsoft Vmbus HID-compliant Mouse as /devices/0006:045E:0621.0001/input/input1 Jan 23 00:05:53.216469 kernel: hv_vmbus: registering driver hv_netvsc Jan 23 00:05:53.216475 kernel: hid-hyperv 0006:045E:0621.0001: input: VIRTUAL HID v0.01 Mouse [Microsoft Vmbus HID-compliant Mouse] on Jan 23 00:05:53.228344 kernel: PTP clock support registered Jan 23 00:05:53.238249 systemd[1]: Finished systemd-vconsole-setup.service - Virtual Console Setup. Jan 23 00:05:53.248531 kernel: hv_utils: Registering HyperV Utility Driver Jan 23 00:05:53.248553 kernel: hv_vmbus: registering driver hv_utils Jan 23 00:05:53.256316 kernel: hv_vmbus: registering driver hv_storvsc Jan 23 00:05:53.260198 systemd[1]: systemd-vconsole-setup.service: Deactivated successfully. Jan 23 00:05:53.265836 kernel: scsi host0: storvsc_host_t Jan 23 00:05:53.265876 kernel: hv_utils: Heartbeat IC version 3.0 Jan 23 00:05:53.270368 kernel: hv_utils: Shutdown IC version 3.2 Jan 23 00:05:53.201954 kernel: hv_utils: TimeSync IC version 4.0 Jan 23 00:05:53.208396 kernel: scsi 0:0:0:0: Direct-Access Msft Virtual Disk 1.0 PQ: 0 ANSI: 5 Jan 23 00:05:53.208427 systemd-journald[225]: Time jumped backwards, rotating. Jan 23 00:05:53.208457 kernel: scsi host1: storvsc_host_t Jan 23 00:05:53.193687 systemd-resolved[262]: Clock change detected. Flushing caches. Jan 23 00:05:53.219570 kernel: scsi 0:0:0:2: CD-ROM Msft Virtual DVD-ROM 1.0 PQ: 0 ANSI: 5 Jan 23 00:05:53.197107 systemd[1]: Stopped systemd-vconsole-setup.service - Virtual Console Setup. Jan 23 00:05:53.219556 systemd[1]: Stopping systemd-vconsole-setup.service - Virtual Console Setup... Jan 23 00:05:53.227194 systemd[1]: Starting systemd-vconsole-setup.service - Virtual Console Setup... Jan 23 00:05:53.239546 systemd[1]: run-credentials-systemd\x2dvconsole\x2dsetup.service.mount: Deactivated successfully. Jan 23 00:05:53.257128 kernel: hv_netvsc 000d3af9-8b1b-000d-3af9-8b1b000d3af9 eth0: VF slot 1 added Jan 23 00:05:53.275879 kernel: sd 0:0:0:0: [sda] 63737856 512-byte logical blocks: (32.6 GB/30.4 GiB) Jan 23 00:05:53.276114 kernel: hv_vmbus: registering driver hv_pci Jan 23 00:05:53.276131 kernel: sr 0:0:0:2: [sr0] scsi-1 drive Jan 23 00:05:53.276211 kernel: sd 0:0:0:0: [sda] 4096-byte physical blocks Jan 23 00:05:53.282033 kernel: cdrom: Uniform CD-ROM driver Revision: 3.20 Jan 23 00:05:53.282050 kernel: hv_pci 930b0c66-2d73-47d4-8073-d13c30504be0: PCI VMBus probing: Using version 0x10004 Jan 23 00:05:53.289516 systemd[1]: Finished systemd-vconsole-setup.service - Virtual Console Setup. Jan 23 00:05:53.306603 kernel: sd 0:0:0:0: [sda] Write Protect is off Jan 23 00:05:53.306751 kernel: sd 0:0:0:0: [sda] Mode Sense: 0f 00 10 00 Jan 23 00:05:53.306817 kernel: sr 0:0:0:2: Attached scsi CD-ROM sr0 Jan 23 00:05:53.306883 kernel: hv_pci 930b0c66-2d73-47d4-8073-d13c30504be0: PCI host bridge to bus 2d73:00 Jan 23 00:05:53.306955 kernel: pci_bus 2d73:00: root bus resource [mem 0xfc0000000-0xfc00fffff window] Jan 23 00:05:53.307026 kernel: pci_bus 2d73:00: No busn resource found for root bus, will use [bus 00-ff] Jan 23 00:05:53.322188 kernel: sd 0:0:0:0: [sda] Write cache: disabled, read cache: enabled, supports DPO and FUA Jan 23 00:05:53.322377 kernel: pci 2d73:00:02.0: [15b3:101a] type 00 class 0x020000 PCIe Endpoint Jan 23 00:05:53.333082 kernel: hv_storvsc f8b3781a-1e82-4818-a1c3-63d806ec15bb: tag#62 cmd 0x5a status: scsi 0x2 srb 0x86 hv 0xc0000001 Jan 23 00:05:53.333234 kernel: pci 2d73:00:02.0: BAR 0 [mem 0xfc0000000-0xfc00fffff 64bit pref] Jan 23 00:05:53.345083 kernel: hv_storvsc f8b3781a-1e82-4818-a1c3-63d806ec15bb: tag#5 cmd 0x5a status: scsi 0x2 srb 0x86 hv 0xc0000001 Jan 23 00:05:53.345260 kernel: pci 2d73:00:02.0: enabling Extended Tags Jan 23 00:05:53.361680 kernel: sda: sda1 sda2 sda3 sda4 sda6 sda7 sda9 Jan 23 00:05:53.361716 kernel: sd 0:0:0:0: [sda] Attached SCSI disk Jan 23 00:05:53.374211 kernel: pci 2d73:00:02.0: 0.000 Gb/s available PCIe bandwidth, limited by Unknown x0 link at 2d73:00:02.0 (capable of 252.048 Gb/s with 16.0 GT/s PCIe x16 link) Jan 23 00:05:53.393040 kernel: pci_bus 2d73:00: busn_res: [bus 00-ff] end is updated to 00 Jan 23 00:05:53.393206 kernel: pci 2d73:00:02.0: BAR 0 [mem 0xfc0000000-0xfc00fffff 64bit pref]: assigned Jan 23 00:05:53.393309 kernel: hv_storvsc f8b3781a-1e82-4818-a1c3-63d806ec15bb: tag#179 cmd 0x85 status: scsi 0x2 srb 0x6 hv 0xc0000001 Jan 23 00:05:53.420109 kernel: hv_storvsc f8b3781a-1e82-4818-a1c3-63d806ec15bb: tag#155 cmd 0x85 status: scsi 0x2 srb 0x6 hv 0xc0000001 Jan 23 00:05:53.448020 kernel: mlx5_core 2d73:00:02.0: enabling device (0000 -> 0002) Jan 23 00:05:53.453083 kernel: mlx5_core 2d73:00:02.0: PTM is not supported by PCIe Jan 23 00:05:53.453189 kernel: mlx5_core 2d73:00:02.0: firmware version: 16.30.5026 Jan 23 00:05:53.636302 kernel: hv_netvsc 000d3af9-8b1b-000d-3af9-8b1b000d3af9 eth0: VF registering: eth1 Jan 23 00:05:53.636528 kernel: mlx5_core 2d73:00:02.0 eth1: joined to eth0 Jan 23 00:05:53.642407 kernel: mlx5_core 2d73:00:02.0: MLX5E: StrdRq(1) RqSz(8) StrdSz(2048) RxCqeCmprss(0 basic) Jan 23 00:05:53.654100 kernel: mlx5_core 2d73:00:02.0 enP11635s1: renamed from eth1 Jan 23 00:05:53.850967 systemd[1]: Found device dev-disk-by\x2dlabel-EFI\x2dSYSTEM.device - Virtual_Disk EFI-SYSTEM. Jan 23 00:05:53.979216 systemd[1]: Found device dev-disk-by\x2dlabel-ROOT.device - Virtual_Disk ROOT. Jan 23 00:05:54.006372 systemd[1]: Found device dev-disk-by\x2dlabel-OEM.device - Virtual_Disk OEM. Jan 23 00:05:54.082081 systemd[1]: Found device dev-disk-by\x2dpartuuid-7130c94a\x2d213a\x2d4e5a\x2d8e26\x2d6cce9662f132.device - Virtual_Disk USR-A. Jan 23 00:05:54.088498 systemd[1]: Found device dev-disk-by\x2dpartlabel-USR\x2dA.device - Virtual_Disk USR-A. Jan 23 00:05:54.102431 systemd[1]: Finished dracut-initqueue.service - dracut initqueue hook. Jan 23 00:05:54.113589 systemd[1]: Reached target remote-fs-pre.target - Preparation for Remote File Systems. Jan 23 00:05:54.124113 systemd[1]: Reached target remote-cryptsetup.target - Remote Encrypted Volumes. Jan 23 00:05:54.135555 systemd[1]: Reached target remote-fs.target - Remote File Systems. Jan 23 00:05:54.146933 systemd[1]: Starting disk-uuid.service - Generate new UUID for disk GPT if necessary... Jan 23 00:05:54.169851 systemd[1]: Starting dracut-pre-mount.service - dracut pre-mount hook... Jan 23 00:05:54.193252 kernel: hv_storvsc f8b3781a-1e82-4818-a1c3-63d806ec15bb: tag#23 cmd 0x5a status: scsi 0x2 srb 0x86 hv 0xc0000001 Jan 23 00:05:54.198109 systemd[1]: Finished dracut-pre-mount.service - dracut pre-mount hook. Jan 23 00:05:54.215213 kernel: sda: sda1 sda2 sda3 sda4 sda6 sda7 sda9 Jan 23 00:05:55.229300 kernel: hv_storvsc f8b3781a-1e82-4818-a1c3-63d806ec15bb: tag#43 cmd 0x5a status: scsi 0x2 srb 0x86 hv 0xc0000001 Jan 23 00:05:55.242144 kernel: sda: sda1 sda2 sda3 sda4 sda6 sda7 sda9 Jan 23 00:05:55.242193 disk-uuid[660]: The operation has completed successfully. Jan 23 00:05:55.310064 systemd[1]: disk-uuid.service: Deactivated successfully. Jan 23 00:05:55.314179 systemd[1]: Finished disk-uuid.service - Generate new UUID for disk GPT if necessary. Jan 23 00:05:55.354813 systemd[1]: Starting verity-setup.service - Verity Setup for /dev/mapper/usr... Jan 23 00:05:55.373508 sh[826]: Success Jan 23 00:05:55.409654 kernel: device-mapper: core: CONFIG_IMA_DISABLE_HTABLE is disabled. Duplicate IMA measurements will not be recorded in the IMA log. Jan 23 00:05:55.409721 kernel: device-mapper: uevent: version 1.0.3 Jan 23 00:05:55.415938 kernel: device-mapper: ioctl: 4.48.0-ioctl (2023-03-01) initialised: dm-devel@lists.linux.dev Jan 23 00:05:55.426093 kernel: device-mapper: verity: sha256 using shash "sha256-ce" Jan 23 00:05:55.698099 systemd[1]: Found device dev-mapper-usr.device - /dev/mapper/usr. Jan 23 00:05:55.703474 systemd[1]: Mounting sysusr-usr.mount - /sysusr/usr... Jan 23 00:05:55.728374 systemd[1]: Finished verity-setup.service - Verity Setup for /dev/mapper/usr. Jan 23 00:05:55.748088 kernel: BTRFS: device fsid 97a43946-ed04-45c1-a355-c0350e8b973e devid 1 transid 38 /dev/mapper/usr (254:0) scanned by mount (851) Jan 23 00:05:55.758403 kernel: BTRFS info (device dm-0): first mount of filesystem 97a43946-ed04-45c1-a355-c0350e8b973e Jan 23 00:05:55.758423 kernel: BTRFS info (device dm-0): using crc32c (crc32c-generic) checksum algorithm Jan 23 00:05:56.028466 kernel: BTRFS info (device dm-0): disabling log replay at mount time Jan 23 00:05:56.028549 kernel: BTRFS info (device dm-0): enabling free space tree Jan 23 00:05:56.079951 systemd[1]: Mounted sysusr-usr.mount - /sysusr/usr. Jan 23 00:05:56.084026 systemd[1]: Reached target initrd-usr-fs.target - Initrd /usr File System. Jan 23 00:05:56.092253 systemd[1]: afterburn-network-kargs.service - Afterburn Initrd Setup Network Kernel Arguments was skipped because no trigger condition checks were met. Jan 23 00:05:56.092930 systemd[1]: Starting ignition-setup.service - Ignition (setup)... Jan 23 00:05:56.115384 systemd[1]: Starting parse-ip-for-networkd.service - Write systemd-networkd units from cmdline... Jan 23 00:05:56.154159 kernel: BTRFS: device label OEM devid 1 transid 12 /dev/sda6 (8:6) scanned by mount (879) Jan 23 00:05:56.154207 kernel: BTRFS info (device sda6): first mount of filesystem e9ae44b3-0aec-43ca-ad8b-9cf4e242132f Jan 23 00:05:56.159653 kernel: BTRFS info (device sda6): using crc32c (crc32c-generic) checksum algorithm Jan 23 00:05:56.187624 kernel: BTRFS info (device sda6): turning on async discard Jan 23 00:05:56.187687 kernel: BTRFS info (device sda6): enabling free space tree Jan 23 00:05:56.197157 kernel: BTRFS info (device sda6): last unmount of filesystem e9ae44b3-0aec-43ca-ad8b-9cf4e242132f Jan 23 00:05:56.198042 systemd[1]: Finished ignition-setup.service - Ignition (setup). Jan 23 00:05:56.206238 systemd[1]: Starting ignition-fetch-offline.service - Ignition (fetch-offline)... Jan 23 00:05:56.240706 systemd[1]: Finished parse-ip-for-networkd.service - Write systemd-networkd units from cmdline. Jan 23 00:05:56.251800 systemd[1]: Starting systemd-networkd.service - Network Configuration... Jan 23 00:05:56.288309 systemd-networkd[1020]: lo: Link UP Jan 23 00:05:56.291101 systemd-networkd[1020]: lo: Gained carrier Jan 23 00:05:56.291930 systemd-networkd[1020]: Enumeration completed Jan 23 00:05:56.292314 systemd[1]: Started systemd-networkd.service - Network Configuration. Jan 23 00:05:56.299591 systemd-networkd[1020]: eth0: found matching network '/usr/lib/systemd/network/zz-default.network', based on potentially unpredictable interface name. Jan 23 00:05:56.299594 systemd-networkd[1020]: eth0: Configuring with /usr/lib/systemd/network/zz-default.network. Jan 23 00:05:56.300272 systemd[1]: Reached target network.target - Network. Jan 23 00:05:56.373095 kernel: mlx5_core 2d73:00:02.0 enP11635s1: Link up Jan 23 00:05:56.411734 systemd-networkd[1020]: enP11635s1: Link UP Jan 23 00:05:56.415721 kernel: hv_netvsc 000d3af9-8b1b-000d-3af9-8b1b000d3af9 eth0: Data path switched to VF: enP11635s1 Jan 23 00:05:56.411794 systemd-networkd[1020]: eth0: Link UP Jan 23 00:05:56.411885 systemd-networkd[1020]: eth0: Gained carrier Jan 23 00:05:56.411899 systemd-networkd[1020]: eth0: found matching network '/usr/lib/systemd/network/zz-default.network', based on potentially unpredictable interface name. Jan 23 00:05:56.423291 systemd-networkd[1020]: enP11635s1: Gained carrier Jan 23 00:05:56.443118 systemd-networkd[1020]: eth0: DHCPv4 address 10.200.20.31/24, gateway 10.200.20.1 acquired from 168.63.129.16 Jan 23 00:05:57.422443 ignition[971]: Ignition 2.22.0 Jan 23 00:05:57.425302 ignition[971]: Stage: fetch-offline Jan 23 00:05:57.425436 ignition[971]: no configs at "/usr/lib/ignition/base.d" Jan 23 00:05:57.430390 systemd[1]: Finished ignition-fetch-offline.service - Ignition (fetch-offline). Jan 23 00:05:57.425442 ignition[971]: no config dir at "/usr/lib/ignition/base.platform.d/azure" Jan 23 00:05:57.438196 systemd[1]: Starting ignition-fetch.service - Ignition (fetch)... Jan 23 00:05:57.425529 ignition[971]: parsed url from cmdline: "" Jan 23 00:05:57.425531 ignition[971]: no config URL provided Jan 23 00:05:57.425534 ignition[971]: reading system config file "/usr/lib/ignition/user.ign" Jan 23 00:05:57.425540 ignition[971]: no config at "/usr/lib/ignition/user.ign" Jan 23 00:05:57.425544 ignition[971]: failed to fetch config: resource requires networking Jan 23 00:05:57.425676 ignition[971]: Ignition finished successfully Jan 23 00:05:57.487915 ignition[1030]: Ignition 2.22.0 Jan 23 00:05:57.487932 ignition[1030]: Stage: fetch Jan 23 00:05:57.488152 ignition[1030]: no configs at "/usr/lib/ignition/base.d" Jan 23 00:05:57.488160 ignition[1030]: no config dir at "/usr/lib/ignition/base.platform.d/azure" Jan 23 00:05:57.488215 ignition[1030]: parsed url from cmdline: "" Jan 23 00:05:57.488217 ignition[1030]: no config URL provided Jan 23 00:05:57.488220 ignition[1030]: reading system config file "/usr/lib/ignition/user.ign" Jan 23 00:05:57.488225 ignition[1030]: no config at "/usr/lib/ignition/user.ign" Jan 23 00:05:57.488243 ignition[1030]: GET http://169.254.169.254/metadata/instance/compute/userData?api-version=2021-01-01&format=text: attempt #1 Jan 23 00:05:57.564467 ignition[1030]: GET result: OK Jan 23 00:05:57.564519 ignition[1030]: config has been read from IMDS userdata Jan 23 00:05:57.567287 unknown[1030]: fetched base config from "system" Jan 23 00:05:57.564535 ignition[1030]: parsing config with SHA512: 54e6d0d03c62b295ce473cfcbc0b1b5e212ec004371a84aaa396dfe0861cc5daad97a50b698d8abdca9deb746db976bc1ec936c0ac65d10d3fd6e4698f433555 Jan 23 00:05:57.567292 unknown[1030]: fetched base config from "system" Jan 23 00:05:57.567390 ignition[1030]: fetch: fetch complete Jan 23 00:05:57.567298 unknown[1030]: fetched user config from "azure" Jan 23 00:05:57.567394 ignition[1030]: fetch: fetch passed Jan 23 00:05:57.569597 systemd[1]: Finished ignition-fetch.service - Ignition (fetch). Jan 23 00:05:57.567428 ignition[1030]: Ignition finished successfully Jan 23 00:05:57.578721 systemd[1]: Starting ignition-kargs.service - Ignition (kargs)... Jan 23 00:05:57.610280 systemd-networkd[1020]: eth0: Gained IPv6LL Jan 23 00:05:57.624929 ignition[1036]: Ignition 2.22.0 Jan 23 00:05:57.624940 ignition[1036]: Stage: kargs Jan 23 00:05:57.625167 ignition[1036]: no configs at "/usr/lib/ignition/base.d" Jan 23 00:05:57.631632 systemd[1]: Finished ignition-kargs.service - Ignition (kargs). Jan 23 00:05:57.625175 ignition[1036]: no config dir at "/usr/lib/ignition/base.platform.d/azure" Jan 23 00:05:57.641228 systemd[1]: Starting ignition-disks.service - Ignition (disks)... Jan 23 00:05:57.625555 ignition[1036]: kargs: kargs passed Jan 23 00:05:57.625594 ignition[1036]: Ignition finished successfully Jan 23 00:05:57.673919 ignition[1043]: Ignition 2.22.0 Jan 23 00:05:57.673938 ignition[1043]: Stage: disks Jan 23 00:05:57.678312 systemd[1]: Finished ignition-disks.service - Ignition (disks). Jan 23 00:05:57.674141 ignition[1043]: no configs at "/usr/lib/ignition/base.d" Jan 23 00:05:57.686020 systemd[1]: Reached target initrd-root-device.target - Initrd Root Device. Jan 23 00:05:57.674149 ignition[1043]: no config dir at "/usr/lib/ignition/base.platform.d/azure" Jan 23 00:05:57.695781 systemd[1]: Reached target local-fs-pre.target - Preparation for Local File Systems. Jan 23 00:05:57.674453 ignition[1043]: disks: disks passed Jan 23 00:05:57.705533 systemd[1]: Reached target local-fs.target - Local File Systems. Jan 23 00:05:57.674490 ignition[1043]: Ignition finished successfully Jan 23 00:05:57.715068 systemd[1]: Reached target sysinit.target - System Initialization. Jan 23 00:05:57.724254 systemd[1]: Reached target basic.target - Basic System. Jan 23 00:05:57.734048 systemd[1]: Starting systemd-fsck-root.service - File System Check on /dev/disk/by-label/ROOT... Jan 23 00:05:57.823152 systemd-fsck[1051]: ROOT: clean, 15/7326000 files, 477845/7359488 blocks Jan 23 00:05:57.831214 systemd[1]: Finished systemd-fsck-root.service - File System Check on /dev/disk/by-label/ROOT. Jan 23 00:05:57.837775 systemd[1]: Mounting sysroot.mount - /sysroot... Jan 23 00:05:58.118106 kernel: EXT4-fs (sda9): mounted filesystem f31390ab-27e9-47d9-a374-053913301d53 r/w with ordered data mode. Quota mode: none. Jan 23 00:05:58.117737 systemd[1]: Mounted sysroot.mount - /sysroot. Jan 23 00:05:58.121583 systemd[1]: Reached target initrd-root-fs.target - Initrd Root File System. Jan 23 00:05:58.146251 systemd[1]: Mounting sysroot-oem.mount - /sysroot/oem... Jan 23 00:05:58.151283 systemd[1]: Mounting sysroot-usr.mount - /sysroot/usr... Jan 23 00:05:58.167015 systemd[1]: Starting flatcar-metadata-hostname.service - Flatcar Metadata Hostname Agent... Jan 23 00:05:58.179067 systemd[1]: ignition-remount-sysroot.service - Remount /sysroot read-write for Ignition was skipped because of an unmet condition check (ConditionPathIsReadWrite=!/sysroot). Jan 23 00:05:58.179206 systemd[1]: Reached target ignition-diskful.target - Ignition Boot Disk Setup. Jan 23 00:05:58.195592 systemd[1]: Mounted sysroot-usr.mount - /sysroot/usr. Jan 23 00:05:58.204990 systemd[1]: Starting initrd-setup-root.service - Root filesystem setup... Jan 23 00:05:58.233101 kernel: BTRFS: device label OEM devid 1 transid 12 /dev/sda6 (8:6) scanned by mount (1065) Jan 23 00:05:58.244016 kernel: BTRFS info (device sda6): first mount of filesystem e9ae44b3-0aec-43ca-ad8b-9cf4e242132f Jan 23 00:05:58.244079 kernel: BTRFS info (device sda6): using crc32c (crc32c-generic) checksum algorithm Jan 23 00:05:58.254765 kernel: BTRFS info (device sda6): turning on async discard Jan 23 00:05:58.254826 kernel: BTRFS info (device sda6): enabling free space tree Jan 23 00:05:58.256452 systemd[1]: Mounted sysroot-oem.mount - /sysroot/oem. Jan 23 00:05:58.763863 coreos-metadata[1067]: Jan 23 00:05:58.763 INFO Fetching http://168.63.129.16/?comp=versions: Attempt #1 Jan 23 00:05:58.773597 coreos-metadata[1067]: Jan 23 00:05:58.773 INFO Fetch successful Jan 23 00:05:58.773597 coreos-metadata[1067]: Jan 23 00:05:58.773 INFO Fetching http://169.254.169.254/metadata/instance/compute/name?api-version=2017-08-01&format=text: Attempt #1 Jan 23 00:05:58.786928 coreos-metadata[1067]: Jan 23 00:05:58.786 INFO Fetch successful Jan 23 00:05:58.801740 coreos-metadata[1067]: Jan 23 00:05:58.801 INFO wrote hostname ci-4459.2.2-n-156f37d5b5 to /sysroot/etc/hostname Jan 23 00:05:58.810294 systemd[1]: Finished flatcar-metadata-hostname.service - Flatcar Metadata Hostname Agent. Jan 23 00:05:58.951749 initrd-setup-root[1096]: cut: /sysroot/etc/passwd: No such file or directory Jan 23 00:05:58.990860 initrd-setup-root[1103]: cut: /sysroot/etc/group: No such file or directory Jan 23 00:05:59.012624 initrd-setup-root[1110]: cut: /sysroot/etc/shadow: No such file or directory Jan 23 00:05:59.019956 initrd-setup-root[1117]: cut: /sysroot/etc/gshadow: No such file or directory Jan 23 00:05:59.936983 systemd[1]: Finished initrd-setup-root.service - Root filesystem setup. Jan 23 00:05:59.942305 systemd[1]: Starting ignition-mount.service - Ignition (mount)... Jan 23 00:05:59.964754 systemd[1]: Starting sysroot-boot.service - /sysroot/boot... Jan 23 00:05:59.979194 kernel: BTRFS info (device sda6): last unmount of filesystem e9ae44b3-0aec-43ca-ad8b-9cf4e242132f Jan 23 00:05:59.971103 systemd[1]: sysroot-oem.mount: Deactivated successfully. Jan 23 00:06:00.002951 ignition[1189]: INFO : Ignition 2.22.0 Jan 23 00:06:00.002951 ignition[1189]: INFO : Stage: mount Jan 23 00:06:00.013525 ignition[1189]: INFO : no configs at "/usr/lib/ignition/base.d" Jan 23 00:06:00.013525 ignition[1189]: INFO : no config dir at "/usr/lib/ignition/base.platform.d/azure" Jan 23 00:06:00.013525 ignition[1189]: INFO : mount: mount passed Jan 23 00:06:00.013525 ignition[1189]: INFO : Ignition finished successfully Jan 23 00:06:00.005489 systemd[1]: Finished sysroot-boot.service - /sysroot/boot. Jan 23 00:06:00.010931 systemd[1]: Finished ignition-mount.service - Ignition (mount). Jan 23 00:06:00.019429 systemd[1]: Starting ignition-files.service - Ignition (files)... Jan 23 00:06:00.047189 systemd[1]: Mounting sysroot-oem.mount - /sysroot/oem... Jan 23 00:06:00.075093 kernel: BTRFS: device label OEM devid 1 transid 12 /dev/sda6 (8:6) scanned by mount (1200) Jan 23 00:06:00.086022 kernel: BTRFS info (device sda6): first mount of filesystem e9ae44b3-0aec-43ca-ad8b-9cf4e242132f Jan 23 00:06:00.086069 kernel: BTRFS info (device sda6): using crc32c (crc32c-generic) checksum algorithm Jan 23 00:06:00.096204 kernel: BTRFS info (device sda6): turning on async discard Jan 23 00:06:00.096256 kernel: BTRFS info (device sda6): enabling free space tree Jan 23 00:06:00.097748 systemd[1]: Mounted sysroot-oem.mount - /sysroot/oem. Jan 23 00:06:00.130099 ignition[1218]: INFO : Ignition 2.22.0 Jan 23 00:06:00.130099 ignition[1218]: INFO : Stage: files Jan 23 00:06:00.130099 ignition[1218]: INFO : no configs at "/usr/lib/ignition/base.d" Jan 23 00:06:00.130099 ignition[1218]: INFO : no config dir at "/usr/lib/ignition/base.platform.d/azure" Jan 23 00:06:00.130099 ignition[1218]: DEBUG : files: compiled without relabeling support, skipping Jan 23 00:06:00.150013 ignition[1218]: INFO : files: ensureUsers: op(1): [started] creating or modifying user "core" Jan 23 00:06:00.150013 ignition[1218]: DEBUG : files: ensureUsers: op(1): executing: "usermod" "--root" "/sysroot" "core" Jan 23 00:06:00.197719 ignition[1218]: INFO : files: ensureUsers: op(1): [finished] creating or modifying user "core" Jan 23 00:06:00.203308 ignition[1218]: INFO : files: ensureUsers: op(2): [started] adding ssh keys to user "core" Jan 23 00:06:00.203308 ignition[1218]: INFO : files: ensureUsers: op(2): [finished] adding ssh keys to user "core" Jan 23 00:06:00.198611 unknown[1218]: wrote ssh authorized keys file for user: core Jan 23 00:06:00.217678 ignition[1218]: INFO : files: createFilesystemsFiles: createFiles: op(3): [started] writing file "/sysroot/etc/flatcar/update.conf" Jan 23 00:06:00.217678 ignition[1218]: INFO : files: createFilesystemsFiles: createFiles: op(3): [finished] writing file "/sysroot/etc/flatcar/update.conf" Jan 23 00:06:00.217678 ignition[1218]: INFO : files: op(4): [started] processing unit "docker.service" Jan 23 00:06:00.217678 ignition[1218]: INFO : files: op(4): [finished] processing unit "docker.service" Jan 23 00:06:00.217678 ignition[1218]: INFO : files: op(5): [started] setting preset to enabled for "docker.service" Jan 23 00:06:00.249516 ignition[1218]: INFO : files: op(5): [finished] setting preset to enabled for "docker.service" Jan 23 00:06:00.249516 ignition[1218]: INFO : files: createResultFile: createFiles: op(6): [started] writing file "/sysroot/etc/.ignition-result.json" Jan 23 00:06:00.249516 ignition[1218]: INFO : files: createResultFile: createFiles: op(6): [finished] writing file "/sysroot/etc/.ignition-result.json" Jan 23 00:06:00.249516 ignition[1218]: INFO : files: files passed Jan 23 00:06:00.249516 ignition[1218]: INFO : Ignition finished successfully Jan 23 00:06:00.250840 systemd[1]: Finished ignition-files.service - Ignition (files). Jan 23 00:06:00.260630 systemd[1]: Starting ignition-quench.service - Ignition (record completion)... Jan 23 00:06:00.291233 systemd[1]: Starting initrd-setup-root-after-ignition.service - Root filesystem completion... Jan 23 00:06:00.297575 systemd[1]: ignition-quench.service: Deactivated successfully. Jan 23 00:06:00.297663 systemd[1]: Finished ignition-quench.service - Ignition (record completion). Jan 23 00:06:00.332962 initrd-setup-root-after-ignition[1247]: grep: /sysroot/etc/flatcar/enabled-sysext.conf: No such file or directory Jan 23 00:06:00.332962 initrd-setup-root-after-ignition[1247]: grep: /sysroot/usr/share/flatcar/enabled-sysext.conf: No such file or directory Jan 23 00:06:00.346824 initrd-setup-root-after-ignition[1251]: grep: /sysroot/etc/flatcar/enabled-sysext.conf: No such file or directory Jan 23 00:06:00.340806 systemd[1]: Finished initrd-setup-root-after-ignition.service - Root filesystem completion. Jan 23 00:06:00.352441 systemd[1]: Reached target ignition-complete.target - Ignition Complete. Jan 23 00:06:00.365170 systemd[1]: Starting initrd-parse-etc.service - Mountpoints Configured in the Real Root... Jan 23 00:06:00.413894 systemd[1]: initrd-parse-etc.service: Deactivated successfully. Jan 23 00:06:00.414008 systemd[1]: Finished initrd-parse-etc.service - Mountpoints Configured in the Real Root. Jan 23 00:06:00.423010 systemd[1]: Reached target initrd-fs.target - Initrd File Systems. Jan 23 00:06:00.432334 systemd[1]: Reached target initrd.target - Initrd Default Target. Jan 23 00:06:00.440708 systemd[1]: dracut-mount.service - dracut mount hook was skipped because no trigger condition checks were met. Jan 23 00:06:00.441471 systemd[1]: Starting dracut-pre-pivot.service - dracut pre-pivot and cleanup hook... Jan 23 00:06:00.476391 systemd[1]: Finished dracut-pre-pivot.service - dracut pre-pivot and cleanup hook. Jan 23 00:06:00.482729 systemd[1]: Starting initrd-cleanup.service - Cleaning Up and Shutting Down Daemons... Jan 23 00:06:00.505816 systemd[1]: Stopped target nss-lookup.target - Host and Network Name Lookups. Jan 23 00:06:00.511121 systemd[1]: Stopped target remote-cryptsetup.target - Remote Encrypted Volumes. Jan 23 00:06:00.520399 systemd[1]: Stopped target timers.target - Timer Units. Jan 23 00:06:00.528470 systemd[1]: dracut-pre-pivot.service: Deactivated successfully. Jan 23 00:06:00.528584 systemd[1]: Stopped dracut-pre-pivot.service - dracut pre-pivot and cleanup hook. Jan 23 00:06:00.540320 systemd[1]: Stopped target initrd.target - Initrd Default Target. Jan 23 00:06:00.544476 systemd[1]: Stopped target basic.target - Basic System. Jan 23 00:06:00.552594 systemd[1]: Stopped target ignition-complete.target - Ignition Complete. Jan 23 00:06:00.561092 systemd[1]: Stopped target ignition-diskful.target - Ignition Boot Disk Setup. Jan 23 00:06:00.569204 systemd[1]: Stopped target initrd-root-device.target - Initrd Root Device. Jan 23 00:06:00.578106 systemd[1]: Stopped target initrd-usr-fs.target - Initrd /usr File System. Jan 23 00:06:00.587095 systemd[1]: Stopped target remote-fs.target - Remote File Systems. Jan 23 00:06:00.595726 systemd[1]: Stopped target remote-fs-pre.target - Preparation for Remote File Systems. Jan 23 00:06:00.605280 systemd[1]: Stopped target sysinit.target - System Initialization. Jan 23 00:06:00.613696 systemd[1]: Stopped target local-fs.target - Local File Systems. Jan 23 00:06:00.622973 systemd[1]: Stopped target swap.target - Swaps. Jan 23 00:06:00.630109 systemd[1]: dracut-pre-mount.service: Deactivated successfully. Jan 23 00:06:00.630263 systemd[1]: Stopped dracut-pre-mount.service - dracut pre-mount hook. Jan 23 00:06:00.642579 systemd[1]: Stopped target cryptsetup.target - Local Encrypted Volumes. Jan 23 00:06:00.651281 systemd[1]: Stopped target cryptsetup-pre.target - Local Encrypted Volumes (Pre). Jan 23 00:06:00.660260 systemd[1]: clevis-luks-askpass.path: Deactivated successfully. Jan 23 00:06:00.664104 systemd[1]: Stopped clevis-luks-askpass.path - Forward Password Requests to Clevis Directory Watch. Jan 23 00:06:00.669413 systemd[1]: dracut-initqueue.service: Deactivated successfully. Jan 23 00:06:00.669556 systemd[1]: Stopped dracut-initqueue.service - dracut initqueue hook. Jan 23 00:06:00.682066 systemd[1]: initrd-setup-root-after-ignition.service: Deactivated successfully. Jan 23 00:06:00.682216 systemd[1]: Stopped initrd-setup-root-after-ignition.service - Root filesystem completion. Jan 23 00:06:00.693446 systemd[1]: ignition-files.service: Deactivated successfully. Jan 23 00:06:00.693552 systemd[1]: Stopped ignition-files.service - Ignition (files). Jan 23 00:06:00.701771 systemd[1]: flatcar-metadata-hostname.service: Deactivated successfully. Jan 23 00:06:00.701884 systemd[1]: Stopped flatcar-metadata-hostname.service - Flatcar Metadata Hostname Agent. Jan 23 00:06:00.712315 systemd[1]: Stopping ignition-mount.service - Ignition (mount)... Jan 23 00:06:00.775195 ignition[1271]: INFO : Ignition 2.22.0 Jan 23 00:06:00.775195 ignition[1271]: INFO : Stage: umount Jan 23 00:06:00.775195 ignition[1271]: INFO : no configs at "/usr/lib/ignition/base.d" Jan 23 00:06:00.775195 ignition[1271]: INFO : no config dir at "/usr/lib/ignition/base.platform.d/azure" Jan 23 00:06:00.775195 ignition[1271]: INFO : umount: umount passed Jan 23 00:06:00.775195 ignition[1271]: INFO : Ignition finished successfully Jan 23 00:06:00.727498 systemd[1]: kmod-static-nodes.service: Deactivated successfully. Jan 23 00:06:00.727709 systemd[1]: Stopped kmod-static-nodes.service - Create List of Static Device Nodes. Jan 23 00:06:00.739177 systemd[1]: Stopping sysroot-boot.service - /sysroot/boot... Jan 23 00:06:00.750787 systemd[1]: systemd-udev-trigger.service: Deactivated successfully. Jan 23 00:06:00.750964 systemd[1]: Stopped systemd-udev-trigger.service - Coldplug All udev Devices. Jan 23 00:06:00.769952 systemd[1]: dracut-pre-trigger.service: Deactivated successfully. Jan 23 00:06:00.770048 systemd[1]: Stopped dracut-pre-trigger.service - dracut pre-trigger hook. Jan 23 00:06:00.785192 systemd[1]: ignition-mount.service: Deactivated successfully. Jan 23 00:06:00.785293 systemd[1]: Stopped ignition-mount.service - Ignition (mount). Jan 23 00:06:00.793737 systemd[1]: ignition-disks.service: Deactivated successfully. Jan 23 00:06:00.793963 systemd[1]: Stopped ignition-disks.service - Ignition (disks). Jan 23 00:06:00.808877 systemd[1]: ignition-kargs.service: Deactivated successfully. Jan 23 00:06:00.808948 systemd[1]: Stopped ignition-kargs.service - Ignition (kargs). Jan 23 00:06:00.817085 systemd[1]: ignition-fetch.service: Deactivated successfully. Jan 23 00:06:00.817124 systemd[1]: Stopped ignition-fetch.service - Ignition (fetch). Jan 23 00:06:00.825635 systemd[1]: Stopped target network.target - Network. Jan 23 00:06:00.834664 systemd[1]: ignition-fetch-offline.service: Deactivated successfully. Jan 23 00:06:00.834714 systemd[1]: Stopped ignition-fetch-offline.service - Ignition (fetch-offline). Jan 23 00:06:00.846425 systemd[1]: Stopped target paths.target - Path Units. Jan 23 00:06:00.854413 systemd[1]: systemd-ask-password-console.path: Deactivated successfully. Jan 23 00:06:00.858093 systemd[1]: Stopped systemd-ask-password-console.path - Dispatch Password Requests to Console Directory Watch. Jan 23 00:06:00.864203 systemd[1]: Stopped target slices.target - Slice Units. Jan 23 00:06:00.872790 systemd[1]: Stopped target sockets.target - Socket Units. Jan 23 00:06:00.880369 systemd[1]: iscsid.socket: Deactivated successfully. Jan 23 00:06:00.880414 systemd[1]: Closed iscsid.socket - Open-iSCSI iscsid Socket. Jan 23 00:06:00.888642 systemd[1]: iscsiuio.socket: Deactivated successfully. Jan 23 00:06:00.888672 systemd[1]: Closed iscsiuio.socket - Open-iSCSI iscsiuio Socket. Jan 23 00:06:00.896580 systemd[1]: ignition-setup.service: Deactivated successfully. Jan 23 00:06:00.896634 systemd[1]: Stopped ignition-setup.service - Ignition (setup). Jan 23 00:06:00.904350 systemd[1]: ignition-setup-pre.service: Deactivated successfully. Jan 23 00:06:00.904381 systemd[1]: Stopped ignition-setup-pre.service - Ignition env setup. Jan 23 00:06:00.912695 systemd[1]: Stopping systemd-networkd.service - Network Configuration... Jan 23 00:06:00.920900 systemd[1]: Stopping systemd-resolved.service - Network Name Resolution... Jan 23 00:06:00.930021 systemd[1]: sysroot-boot.mount: Deactivated successfully. Jan 23 00:06:00.930538 systemd[1]: initrd-cleanup.service: Deactivated successfully. Jan 23 00:06:00.930632 systemd[1]: Finished initrd-cleanup.service - Cleaning Up and Shutting Down Daemons. Jan 23 00:06:01.130604 kernel: hv_netvsc 000d3af9-8b1b-000d-3af9-8b1b000d3af9 eth0: Data path switched from VF: enP11635s1 Jan 23 00:06:00.939990 systemd[1]: sysroot-boot.service: Deactivated successfully. Jan 23 00:06:00.940069 systemd[1]: Stopped sysroot-boot.service - /sysroot/boot. Jan 23 00:06:00.949704 systemd[1]: initrd-setup-root.service: Deactivated successfully. Jan 23 00:06:00.949774 systemd[1]: Stopped initrd-setup-root.service - Root filesystem setup. Jan 23 00:06:00.958570 systemd[1]: systemd-resolved.service: Deactivated successfully. Jan 23 00:06:00.958674 systemd[1]: Stopped systemd-resolved.service - Network Name Resolution. Jan 23 00:06:00.971593 systemd[1]: run-credentials-systemd\x2dresolved.service.mount: Deactivated successfully. Jan 23 00:06:00.971779 systemd[1]: systemd-networkd.service: Deactivated successfully. Jan 23 00:06:00.971878 systemd[1]: Stopped systemd-networkd.service - Network Configuration. Jan 23 00:06:00.983609 systemd[1]: run-credentials-systemd\x2dnetworkd.service.mount: Deactivated successfully. Jan 23 00:06:00.984318 systemd[1]: Stopped target network-pre.target - Preparation for Network. Jan 23 00:06:00.991824 systemd[1]: systemd-networkd.socket: Deactivated successfully. Jan 23 00:06:00.991870 systemd[1]: Closed systemd-networkd.socket - Network Service Netlink Socket. Jan 23 00:06:01.003791 systemd[1]: Stopping network-cleanup.service - Network Cleanup... Jan 23 00:06:01.014021 systemd[1]: parse-ip-for-networkd.service: Deactivated successfully. Jan 23 00:06:01.014215 systemd[1]: Stopped parse-ip-for-networkd.service - Write systemd-networkd units from cmdline. Jan 23 00:06:01.023103 systemd[1]: systemd-sysctl.service: Deactivated successfully. Jan 23 00:06:01.023157 systemd[1]: Stopped systemd-sysctl.service - Apply Kernel Variables. Jan 23 00:06:01.034418 systemd[1]: systemd-modules-load.service: Deactivated successfully. Jan 23 00:06:01.034455 systemd[1]: Stopped systemd-modules-load.service - Load Kernel Modules. Jan 23 00:06:01.039474 systemd[1]: systemd-tmpfiles-setup.service: Deactivated successfully. Jan 23 00:06:01.039519 systemd[1]: Stopped systemd-tmpfiles-setup.service - Create System Files and Directories. Jan 23 00:06:01.048835 systemd[1]: Stopping systemd-udevd.service - Rule-based Manager for Device Events and Files... Jan 23 00:06:01.057599 systemd[1]: run-credentials-systemd\x2dsysctl.service.mount: Deactivated successfully. Jan 23 00:06:01.057650 systemd[1]: run-credentials-systemd\x2dtmpfiles\x2dsetup.service.mount: Deactivated successfully. Jan 23 00:06:01.080569 systemd[1]: systemd-udevd.service: Deactivated successfully. Jan 23 00:06:01.080724 systemd[1]: Stopped systemd-udevd.service - Rule-based Manager for Device Events and Files. Jan 23 00:06:01.091350 systemd[1]: systemd-udevd-control.socket: Deactivated successfully. Jan 23 00:06:01.091388 systemd[1]: Closed systemd-udevd-control.socket - udev Control Socket. Jan 23 00:06:01.100424 systemd[1]: systemd-udevd-kernel.socket: Deactivated successfully. Jan 23 00:06:01.100449 systemd[1]: Closed systemd-udevd-kernel.socket - udev Kernel Socket. Jan 23 00:06:01.109123 systemd[1]: dracut-pre-udev.service: Deactivated successfully. Jan 23 00:06:01.109169 systemd[1]: Stopped dracut-pre-udev.service - dracut pre-udev hook. Jan 23 00:06:01.130678 systemd[1]: dracut-cmdline.service: Deactivated successfully. Jan 23 00:06:01.130739 systemd[1]: Stopped dracut-cmdline.service - dracut cmdline hook. Jan 23 00:06:01.139735 systemd[1]: dracut-cmdline-ask.service: Deactivated successfully. Jan 23 00:06:01.139782 systemd[1]: Stopped dracut-cmdline-ask.service - dracut ask for additional cmdline parameters. Jan 23 00:06:01.155280 systemd[1]: Starting initrd-udevadm-cleanup-db.service - Cleanup udev Database... Jan 23 00:06:01.172045 systemd[1]: systemd-network-generator.service: Deactivated successfully. Jan 23 00:06:01.172192 systemd[1]: Stopped systemd-network-generator.service - Generate network units from Kernel command line. Jan 23 00:06:01.189117 systemd[1]: systemd-tmpfiles-setup-dev.service: Deactivated successfully. Jan 23 00:06:01.189192 systemd[1]: Stopped systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev. Jan 23 00:06:01.198209 systemd[1]: systemd-vconsole-setup.service: Deactivated successfully. Jan 23 00:06:01.406467 systemd-journald[225]: Received SIGTERM from PID 1 (systemd). Jan 23 00:06:01.198272 systemd[1]: Stopped systemd-vconsole-setup.service - Virtual Console Setup. Jan 23 00:06:01.208225 systemd[1]: run-credentials-systemd\x2dnetwork\x2dgenerator.service.mount: Deactivated successfully. Jan 23 00:06:01.208272 systemd[1]: run-credentials-systemd\x2dtmpfiles\x2dsetup\x2ddev.service.mount: Deactivated successfully. Jan 23 00:06:01.208296 systemd[1]: run-credentials-systemd\x2dvconsole\x2dsetup.service.mount: Deactivated successfully. Jan 23 00:06:01.208568 systemd[1]: initrd-udevadm-cleanup-db.service: Deactivated successfully. Jan 23 00:06:01.208650 systemd[1]: Finished initrd-udevadm-cleanup-db.service - Cleanup udev Database. Jan 23 00:06:01.237560 systemd[1]: network-cleanup.service: Deactivated successfully. Jan 23 00:06:01.237907 systemd[1]: Stopped network-cleanup.service - Network Cleanup. Jan 23 00:06:01.246764 systemd[1]: Reached target initrd-switch-root.target - Switch Root. Jan 23 00:06:01.257962 systemd[1]: Starting initrd-switch-root.service - Switch Root... Jan 23 00:06:01.278157 systemd[1]: Switching root. Jan 23 00:06:01.432346 systemd-journald[225]: Journal stopped Jan 23 00:06:06.116164 kernel: SELinux: policy capability network_peer_controls=1 Jan 23 00:06:06.116186 kernel: SELinux: policy capability open_perms=1 Jan 23 00:06:06.116194 kernel: SELinux: policy capability extended_socket_class=1 Jan 23 00:06:06.116199 kernel: SELinux: policy capability always_check_network=0 Jan 23 00:06:06.116204 kernel: SELinux: policy capability cgroup_seclabel=1 Jan 23 00:06:06.116211 kernel: SELinux: policy capability nnp_nosuid_transition=1 Jan 23 00:06:06.116217 kernel: SELinux: policy capability genfs_seclabel_symlinks=0 Jan 23 00:06:06.116222 kernel: SELinux: policy capability ioctl_skip_cloexec=0 Jan 23 00:06:06.116228 kernel: SELinux: policy capability userspace_initial_context=0 Jan 23 00:06:06.116233 kernel: audit: type=1403 audit(1769126762.253:2): auid=4294967295 ses=4294967295 lsm=selinux res=1 Jan 23 00:06:06.116240 systemd[1]: Successfully loaded SELinux policy in 194.332ms. Jan 23 00:06:06.116247 systemd[1]: Relabeled /dev/, /dev/shm/, /run/ in 4.434ms. Jan 23 00:06:06.116254 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) Jan 23 00:06:06.116262 systemd[1]: Detected virtualization microsoft. Jan 23 00:06:06.116268 systemd[1]: Detected architecture arm64. Jan 23 00:06:06.116274 systemd[1]: Detected first boot. Jan 23 00:06:06.116281 systemd[1]: Hostname set to . Jan 23 00:06:06.116287 systemd[1]: Initializing machine ID from random generator. Jan 23 00:06:06.116293 zram_generator::config[1313]: No configuration found. Jan 23 00:06:06.116299 kernel: NET: Registered PF_VSOCK protocol family Jan 23 00:06:06.116305 systemd[1]: Populated /etc with preset unit settings. Jan 23 00:06:06.116312 systemd[1]: run-credentials-systemd\x2djournald.service.mount: Deactivated successfully. Jan 23 00:06:06.116317 systemd[1]: initrd-switch-root.service: Deactivated successfully. Jan 23 00:06:06.116324 systemd[1]: Stopped initrd-switch-root.service - Switch Root. Jan 23 00:06:06.116330 systemd[1]: systemd-journald.service: Scheduled restart job, restart counter is at 1. Jan 23 00:06:06.116336 systemd[1]: Created slice system-addon\x2dconfig.slice - Slice /system/addon-config. Jan 23 00:06:06.116342 systemd[1]: Created slice system-addon\x2drun.slice - Slice /system/addon-run. Jan 23 00:06:06.116348 systemd[1]: Created slice system-getty.slice - Slice /system/getty. Jan 23 00:06:06.116354 systemd[1]: Created slice system-modprobe.slice - Slice /system/modprobe. Jan 23 00:06:06.116360 systemd[1]: Created slice system-serial\x2dgetty.slice - Slice /system/serial-getty. Jan 23 00:06:06.116367 systemd[1]: Created slice system-system\x2dcloudinit.slice - Slice /system/system-cloudinit. Jan 23 00:06:06.116373 systemd[1]: Created slice system-systemd\x2dfsck.slice - Slice /system/systemd-fsck. Jan 23 00:06:06.116379 systemd[1]: Created slice user.slice - User and Session Slice. Jan 23 00:06:06.116385 systemd[1]: Started clevis-luks-askpass.path - Forward Password Requests to Clevis Directory Watch. Jan 23 00:06:06.116393 systemd[1]: Started systemd-ask-password-console.path - Dispatch Password Requests to Console Directory Watch. Jan 23 00:06:06.116399 systemd[1]: Started systemd-ask-password-wall.path - Forward Password Requests to Wall Directory Watch. Jan 23 00:06:06.116405 systemd[1]: Set up automount boot.automount - Boot partition Automount Point. Jan 23 00:06:06.116411 systemd[1]: Set up automount proc-sys-fs-binfmt_misc.automount - Arbitrary Executable File Formats File System Automount Point. Jan 23 00:06:06.116419 systemd[1]: Expecting device dev-disk-by\x2dlabel-OEM.device - /dev/disk/by-label/OEM... Jan 23 00:06:06.116425 systemd[1]: Expecting device dev-ttyAMA0.device - /dev/ttyAMA0... Jan 23 00:06:06.116433 systemd[1]: Reached target cryptsetup-pre.target - Local Encrypted Volumes (Pre). Jan 23 00:06:06.116439 systemd[1]: Reached target cryptsetup.target - Local Encrypted Volumes. Jan 23 00:06:06.116445 systemd[1]: Stopped target initrd-switch-root.target - Switch Root. Jan 23 00:06:06.116451 systemd[1]: Stopped target initrd-fs.target - Initrd File Systems. Jan 23 00:06:06.116457 systemd[1]: Stopped target initrd-root-fs.target - Initrd Root File System. Jan 23 00:06:06.116463 systemd[1]: Reached target integritysetup.target - Local Integrity Protected Volumes. Jan 23 00:06:06.116470 systemd[1]: Reached target remote-cryptsetup.target - Remote Encrypted Volumes. Jan 23 00:06:06.116476 systemd[1]: Reached target remote-fs.target - Remote File Systems. Jan 23 00:06:06.116482 systemd[1]: Reached target slices.target - Slice Units. Jan 23 00:06:06.116488 systemd[1]: Reached target swap.target - Swaps. Jan 23 00:06:06.116494 systemd[1]: Reached target veritysetup.target - Local Verity Protected Volumes. Jan 23 00:06:06.116500 systemd[1]: Listening on systemd-coredump.socket - Process Core Dump Socket. Jan 23 00:06:06.116508 systemd[1]: Listening on systemd-creds.socket - Credential Encryption/Decryption. Jan 23 00:06:06.116514 systemd[1]: Listening on systemd-networkd.socket - Network Service Netlink Socket. Jan 23 00:06:06.116521 systemd[1]: Listening on systemd-udevd-control.socket - udev Control Socket. Jan 23 00:06:06.116528 systemd[1]: Listening on systemd-udevd-kernel.socket - udev Kernel Socket. Jan 23 00:06:06.116534 systemd[1]: Listening on systemd-userdbd.socket - User Database Manager Socket. Jan 23 00:06:06.116540 systemd[1]: Mounting dev-hugepages.mount - Huge Pages File System... Jan 23 00:06:06.116546 systemd[1]: Mounting dev-mqueue.mount - POSIX Message Queue File System... Jan 23 00:06:06.116553 systemd[1]: Mounting media.mount - External Media Directory... Jan 23 00:06:06.116559 systemd[1]: Mounting sys-kernel-debug.mount - Kernel Debug File System... Jan 23 00:06:06.116565 systemd[1]: Mounting sys-kernel-tracing.mount - Kernel Trace File System... Jan 23 00:06:06.116571 systemd[1]: Mounting tmp.mount - Temporary Directory /tmp... Jan 23 00:06:06.116578 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). Jan 23 00:06:06.116584 systemd[1]: Reached target machines.target - Containers. Jan 23 00:06:06.116591 systemd[1]: Starting flatcar-tmpfiles.service - Create missing system files... Jan 23 00:06:06.116597 systemd[1]: ignition-delete-config.service - Ignition (delete config) was skipped because no trigger condition checks were met. Jan 23 00:06:06.116604 systemd[1]: Starting kmod-static-nodes.service - Create List of Static Device Nodes... Jan 23 00:06:06.116610 systemd[1]: Starting modprobe@configfs.service - Load Kernel Module configfs... Jan 23 00:06:06.116616 systemd[1]: Starting modprobe@dm_mod.service - Load Kernel Module dm_mod... Jan 23 00:06:06.116623 systemd[1]: Starting modprobe@drm.service - Load Kernel Module drm... Jan 23 00:06:06.116629 systemd[1]: Starting modprobe@efi_pstore.service - Load Kernel Module efi_pstore... Jan 23 00:06:06.116635 systemd[1]: Starting modprobe@fuse.service - Load Kernel Module fuse... Jan 23 00:06:06.116641 systemd[1]: Starting modprobe@loop.service - Load Kernel Module loop... Jan 23 00:06:06.116648 systemd[1]: setup-nsswitch.service - Create /etc/nsswitch.conf was skipped because of an unmet condition check (ConditionPathExists=!/etc/nsswitch.conf). Jan 23 00:06:06.116654 systemd[1]: systemd-fsck-root.service: Deactivated successfully. Jan 23 00:06:06.116663 systemd[1]: Stopped systemd-fsck-root.service - File System Check on Root Device. Jan 23 00:06:06.116669 systemd[1]: systemd-fsck-usr.service: Deactivated successfully. Jan 23 00:06:06.116675 systemd[1]: Stopped systemd-fsck-usr.service. Jan 23 00:06:06.116682 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). Jan 23 00:06:06.116688 systemd[1]: Starting systemd-journald.service - Journal Service... Jan 23 00:06:06.116694 kernel: fuse: init (API version 7.41) Jan 23 00:06:06.116700 kernel: loop: module loaded Jan 23 00:06:06.116705 kernel: ACPI: bus type drm_connector registered Jan 23 00:06:06.116727 systemd-journald[1414]: Collecting audit messages is disabled. Jan 23 00:06:06.116742 systemd-journald[1414]: Journal started Jan 23 00:06:06.116758 systemd-journald[1414]: Runtime Journal (/run/log/journal/96acb00b362a4321aef195fa5aa72d54) is 8M, max 78.3M, 70.3M free. Jan 23 00:06:05.298108 systemd[1]: Queued start job for default target multi-user.target. Jan 23 00:06:05.302603 systemd[1]: Unnecessary job was removed for dev-sda6.device - /dev/sda6. Jan 23 00:06:05.303014 systemd[1]: systemd-journald.service: Deactivated successfully. Jan 23 00:06:05.303318 systemd[1]: systemd-journald.service: Consumed 2.380s CPU time. Jan 23 00:06:06.133775 systemd[1]: Starting systemd-modules-load.service - Load Kernel Modules... Jan 23 00:06:06.153513 systemd[1]: Starting systemd-network-generator.service - Generate network units from Kernel command line... Jan 23 00:06:06.168899 systemd[1]: Starting systemd-remount-fs.service - Remount Root and Kernel File Systems... Jan 23 00:06:06.186093 systemd[1]: Starting systemd-udev-load-credentials.service - Load udev Rules from Credentials... Jan 23 00:06:06.212538 systemd[1]: Starting systemd-udev-trigger.service - Coldplug All udev Devices... Jan 23 00:06:06.218091 systemd[1]: verity-setup.service: Deactivated successfully. Jan 23 00:06:06.218161 systemd[1]: Stopped verity-setup.service. Jan 23 00:06:06.239476 systemd[1]: Started systemd-journald.service - Journal Service. Jan 23 00:06:06.240162 systemd[1]: Mounted dev-hugepages.mount - Huge Pages File System. Jan 23 00:06:06.245581 systemd[1]: Mounted dev-mqueue.mount - POSIX Message Queue File System. Jan 23 00:06:06.251740 systemd[1]: Mounted media.mount - External Media Directory. Jan 23 00:06:06.256778 systemd[1]: Mounted sys-kernel-debug.mount - Kernel Debug File System. Jan 23 00:06:06.262271 systemd[1]: Mounted sys-kernel-tracing.mount - Kernel Trace File System. Jan 23 00:06:06.267957 systemd[1]: Mounted tmp.mount - Temporary Directory /tmp. Jan 23 00:06:06.274140 systemd[1]: Finished flatcar-tmpfiles.service - Create missing system files. Jan 23 00:06:06.282685 systemd[1]: Finished kmod-static-nodes.service - Create List of Static Device Nodes. Jan 23 00:06:06.289685 systemd[1]: modprobe@configfs.service: Deactivated successfully. Jan 23 00:06:06.289832 systemd[1]: Finished modprobe@configfs.service - Load Kernel Module configfs. Jan 23 00:06:06.296539 systemd[1]: modprobe@dm_mod.service: Deactivated successfully. Jan 23 00:06:06.296681 systemd[1]: Finished modprobe@dm_mod.service - Load Kernel Module dm_mod. Jan 23 00:06:06.303250 systemd[1]: modprobe@drm.service: Deactivated successfully. Jan 23 00:06:06.303404 systemd[1]: Finished modprobe@drm.service - Load Kernel Module drm. Jan 23 00:06:06.309167 systemd[1]: modprobe@efi_pstore.service: Deactivated successfully. Jan 23 00:06:06.309294 systemd[1]: Finished modprobe@efi_pstore.service - Load Kernel Module efi_pstore. Jan 23 00:06:06.316283 systemd[1]: modprobe@fuse.service: Deactivated successfully. Jan 23 00:06:06.316410 systemd[1]: Finished modprobe@fuse.service - Load Kernel Module fuse. Jan 23 00:06:06.322664 systemd[1]: modprobe@loop.service: Deactivated successfully. Jan 23 00:06:06.322795 systemd[1]: Finished modprobe@loop.service - Load Kernel Module loop. Jan 23 00:06:06.330112 systemd[1]: Finished systemd-modules-load.service - Load Kernel Modules. Jan 23 00:06:06.336569 systemd[1]: Finished systemd-network-generator.service - Generate network units from Kernel command line. Jan 23 00:06:06.344036 systemd[1]: Finished systemd-remount-fs.service - Remount Root and Kernel File Systems. Jan 23 00:06:06.350984 systemd[1]: Finished systemd-udev-load-credentials.service - Load udev Rules from Credentials. Jan 23 00:06:06.357776 systemd[1]: Finished systemd-udev-trigger.service - Coldplug All udev Devices. Jan 23 00:06:06.373239 systemd[1]: Reached target network-pre.target - Preparation for Network. Jan 23 00:06:06.380971 systemd[1]: Mounting sys-fs-fuse-connections.mount - FUSE Control File System... Jan 23 00:06:06.397207 systemd[1]: Mounting sys-kernel-config.mount - Kernel Configuration File System... Jan 23 00:06:06.403277 systemd[1]: remount-root.service - Remount Root File System was skipped because of an unmet condition check (ConditionPathIsReadWrite=!/). Jan 23 00:06:06.403314 systemd[1]: Reached target local-fs.target - Local File Systems. Jan 23 00:06:06.409557 systemd[1]: Listening on systemd-sysext.socket - System Extension Image Management. Jan 23 00:06:06.418211 systemd[1]: Starting ldconfig.service - Rebuild Dynamic Linker Cache... Jan 23 00:06:06.424924 systemd[1]: systemd-binfmt.service - Set Up Additional Binary Formats was skipped because no trigger condition checks were met. Jan 23 00:06:06.443699 systemd[1]: Starting systemd-hwdb-update.service - Rebuild Hardware Database... Jan 23 00:06:06.458858 systemd[1]: Starting systemd-journal-flush.service - Flush Journal to Persistent Storage... Jan 23 00:06:06.464965 systemd[1]: systemd-pstore.service - Platform Persistent Storage Archival was skipped because of an unmet condition check (ConditionDirectoryNotEmpty=/sys/fs/pstore). Jan 23 00:06:06.465873 systemd[1]: Starting systemd-random-seed.service - Load/Save OS Random Seed... Jan 23 00:06:06.471919 systemd[1]: systemd-repart.service - Repartition Root Disk was skipped because no trigger condition checks were met. Jan 23 00:06:06.472868 systemd[1]: Starting systemd-sysctl.service - Apply Kernel Variables... Jan 23 00:06:06.480227 systemd[1]: Starting systemd-sysext.service - Merge System Extension Images into /usr/ and /opt/... Jan 23 00:06:06.488254 systemd[1]: Starting systemd-sysusers.service - Create System Users... Jan 23 00:06:06.495246 systemd[1]: Mounted sys-fs-fuse-connections.mount - FUSE Control File System. Jan 23 00:06:06.501885 systemd[1]: Mounted sys-kernel-config.mount - Kernel Configuration File System. Jan 23 00:06:06.514106 systemd[1]: Finished systemd-random-seed.service - Load/Save OS Random Seed. Jan 23 00:06:06.520928 systemd[1]: Reached target first-boot-complete.target - First Boot Complete. Jan 23 00:06:06.530118 systemd-journald[1414]: Time spent on flushing to /var/log/journal/96acb00b362a4321aef195fa5aa72d54 is 47.571ms for 919 entries. Jan 23 00:06:06.530118 systemd-journald[1414]: System Journal (/var/log/journal/96acb00b362a4321aef195fa5aa72d54) is 11.8M, max 2.6G, 2.6G free. Jan 23 00:06:06.618476 systemd-journald[1414]: Received client request to flush runtime journal. Jan 23 00:06:06.618553 kernel: loop0: detected capacity change from 0 to 27936 Jan 23 00:06:06.618570 systemd-journald[1414]: /var/log/journal/96acb00b362a4321aef195fa5aa72d54/system.journal: Realtime clock jumped backwards relative to last journal entry, rotating. Jan 23 00:06:06.618588 systemd-journald[1414]: Rotating system journal. Jan 23 00:06:06.538239 systemd[1]: Starting systemd-machine-id-commit.service - Save Transient machine-id to Disk... Jan 23 00:06:06.602658 systemd[1]: Finished systemd-sysctl.service - Apply Kernel Variables. Jan 23 00:06:06.619088 systemd[1]: etc-machine\x2did.mount: Deactivated successfully. Jan 23 00:06:06.620716 systemd[1]: Finished systemd-journal-flush.service - Flush Journal to Persistent Storage. Jan 23 00:06:06.626893 systemd[1]: Finished systemd-machine-id-commit.service - Save Transient machine-id to Disk. Jan 23 00:06:06.671947 systemd[1]: Finished systemd-sysusers.service - Create System Users. Jan 23 00:06:06.678249 systemd[1]: Starting systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev... Jan 23 00:06:06.752233 systemd-tmpfiles[1469]: ACLs are not supported, ignoring. Jan 23 00:06:06.752246 systemd-tmpfiles[1469]: ACLs are not supported, ignoring. Jan 23 00:06:06.755257 systemd[1]: Finished systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev. Jan 23 00:06:06.942101 kernel: squashfs: version 4.0 (2009/01/31) Phillip Lougher Jan 23 00:06:07.043111 kernel: loop1: detected capacity change from 0 to 100632 Jan 23 00:06:07.141412 systemd[1]: Finished systemd-hwdb-update.service - Rebuild Hardware Database. Jan 23 00:06:07.149380 systemd[1]: Starting systemd-udevd.service - Rule-based Manager for Device Events and Files... Jan 23 00:06:07.176835 systemd-udevd[1476]: Using default interface naming scheme 'v255'. Jan 23 00:06:07.499242 systemd[1]: Started systemd-udevd.service - Rule-based Manager for Device Events and Files. Jan 23 00:06:07.510229 systemd[1]: Starting systemd-networkd.service - Network Configuration... Jan 23 00:06:07.524105 kernel: loop2: detected capacity change from 0 to 119840 Jan 23 00:06:07.583454 systemd[1]: Condition check resulted in dev-ttyAMA0.device - /dev/ttyAMA0 being skipped. Jan 23 00:06:07.612698 systemd[1]: Starting systemd-userdbd.service - User Database Manager... Jan 23 00:06:07.661537 kernel: mousedev: PS/2 mouse device common for all mice Jan 23 00:06:07.661651 kernel: hv_storvsc f8b3781a-1e82-4818-a1c3-63d806ec15bb: tag#168 cmd 0x85 status: scsi 0x2 srb 0x6 hv 0xc0000001 Jan 23 00:06:07.669461 systemd[1]: Started systemd-userdbd.service - User Database Manager. Jan 23 00:06:07.710122 kernel: hv_vmbus: registering driver hv_balloon Jan 23 00:06:07.720179 kernel: hv_balloon: Using Dynamic Memory protocol version 2.0 Jan 23 00:06:07.720261 kernel: hv_balloon: Memory hot add disabled on ARM64 Jan 23 00:06:07.766102 kernel: hv_vmbus: registering driver hyperv_fb Jan 23 00:06:07.776116 kernel: hyperv_fb: Synthvid Version major 3, minor 5 Jan 23 00:06:07.777513 kernel: hyperv_fb: Screen resolution: 1024x768, Color depth: 32, Frame buffer size: 8388608 Jan 23 00:06:07.777557 kernel: Console: switching to colour dummy device 80x25 Jan 23 00:06:07.787400 kernel: Console: switching to colour frame buffer device 128x48 Jan 23 00:06:07.808325 systemd[1]: Starting systemd-vconsole-setup.service - Virtual Console Setup... Jan 23 00:06:07.822127 systemd[1]: systemd-vconsole-setup.service: Deactivated successfully. Jan 23 00:06:07.824146 systemd[1]: Stopped systemd-vconsole-setup.service - Virtual Console Setup. Jan 23 00:06:07.835292 systemd[1]: Starting systemd-vconsole-setup.service - Virtual Console Setup... Jan 23 00:06:07.844616 systemd[1]: systemd-vconsole-setup.service: Deactivated successfully. Jan 23 00:06:07.844787 systemd[1]: Stopped systemd-vconsole-setup.service - Virtual Console Setup. Jan 23 00:06:07.851768 systemd[1]: Starting systemd-vconsole-setup.service - Virtual Console Setup... Jan 23 00:06:07.876856 systemd-networkd[1490]: lo: Link UP Jan 23 00:06:07.877382 systemd-networkd[1490]: lo: Gained carrier Jan 23 00:06:07.878733 systemd-networkd[1490]: Enumeration completed Jan 23 00:06:07.879141 systemd[1]: Started systemd-networkd.service - Network Configuration. Jan 23 00:06:07.880196 systemd-networkd[1490]: eth0: found matching network '/usr/lib/systemd/network/zz-default.network', based on potentially unpredictable interface name. Jan 23 00:06:07.880266 systemd-networkd[1490]: eth0: Configuring with /usr/lib/systemd/network/zz-default.network. Jan 23 00:06:07.888220 systemd[1]: Starting systemd-networkd-persistent-storage.service - Enable Persistent Storage in systemd-networkd... Jan 23 00:06:07.897671 systemd[1]: Starting systemd-networkd-wait-online.service - Wait for Network to be Configured... Jan 23 00:06:07.935286 kernel: loop3: detected capacity change from 0 to 27936 Jan 23 00:06:07.935376 kernel: mlx5_core 2d73:00:02.0 enP11635s1: Link up Jan 23 00:06:07.952098 kernel: loop4: detected capacity change from 0 to 100632 Jan 23 00:06:07.969096 kernel: hv_netvsc 000d3af9-8b1b-000d-3af9-8b1b000d3af9 eth0: Data path switched to VF: enP11635s1 Jan 23 00:06:07.969316 kernel: loop5: detected capacity change from 0 to 119840 Jan 23 00:06:07.967932 systemd-networkd[1490]: enP11635s1: Link UP Jan 23 00:06:07.968821 systemd-networkd[1490]: eth0: Link UP Jan 23 00:06:07.968824 systemd-networkd[1490]: eth0: Gained carrier Jan 23 00:06:07.968845 systemd-networkd[1490]: eth0: found matching network '/usr/lib/systemd/network/zz-default.network', based on potentially unpredictable interface name. Jan 23 00:06:07.974176 systemd[1]: Finished systemd-networkd-persistent-storage.service - Enable Persistent Storage in systemd-networkd. Jan 23 00:06:07.974500 systemd-networkd[1490]: enP11635s1: Gained carrier Jan 23 00:06:07.997149 systemd-networkd[1490]: eth0: DHCPv4 address 10.200.20.31/24, gateway 10.200.20.1 acquired from 168.63.129.16 Jan 23 00:06:07.997261 (sd-merge)[1585]: Using extensions 'containerd-flatcar', 'docker-flatcar', 'oem-azure'. Jan 23 00:06:07.997617 (sd-merge)[1585]: Merged extensions into '/usr'. Jan 23 00:06:08.002523 systemd[1]: Finished systemd-sysext.service - Merge System Extension Images into /usr/ and /opt/. Jan 23 00:06:08.011435 systemd[1]: Found device dev-disk-by\x2dlabel-OEM.device - Virtual_Disk OEM. Jan 23 00:06:08.018043 systemd[1]: Starting ensure-sysext.service... Jan 23 00:06:08.023218 systemd[1]: Starting systemd-fsck@dev-disk-by\x2dlabel-OEM.service - File System Check on /dev/disk/by-label/OEM... Jan 23 00:06:08.033621 systemd[1]: Starting systemd-tmpfiles-setup.service - Create System Files and Directories... Jan 23 00:06:08.036099 kernel: MACsec IEEE 802.1AE Jan 23 00:06:08.053151 systemd[1]: Reload requested from client PID 1618 ('systemctl') (unit ensure-sysext.service)... Jan 23 00:06:08.053164 systemd[1]: Reloading... Jan 23 00:06:08.088215 systemd-tmpfiles[1620]: /usr/lib/tmpfiles.d/nfs-utils.conf:6: Duplicate line for path "/var/lib/nfs/sm", ignoring. Jan 23 00:06:08.089013 systemd-tmpfiles[1620]: /usr/lib/tmpfiles.d/nfs-utils.conf:7: Duplicate line for path "/var/lib/nfs/sm.bak", ignoring. Jan 23 00:06:08.089326 systemd-tmpfiles[1620]: /usr/lib/tmpfiles.d/provision.conf:20: Duplicate line for path "/root", ignoring. Jan 23 00:06:08.089462 systemd-tmpfiles[1620]: /usr/lib/tmpfiles.d/systemd-flatcar.conf:6: Duplicate line for path "/var/log/journal", ignoring. Jan 23 00:06:08.089884 systemd-tmpfiles[1620]: /usr/lib/tmpfiles.d/systemd.conf:29: Duplicate line for path "/var/lib/systemd", ignoring. Jan 23 00:06:08.090019 systemd-tmpfiles[1620]: ACLs are not supported, ignoring. Jan 23 00:06:08.090046 systemd-tmpfiles[1620]: ACLs are not supported, ignoring. Jan 23 00:06:08.095658 systemd-tmpfiles[1620]: Detected autofs mount point /boot during canonicalization of boot. Jan 23 00:06:08.095755 systemd-tmpfiles[1620]: Skipping /boot Jan 23 00:06:08.103644 systemd-tmpfiles[1620]: Detected autofs mount point /boot during canonicalization of boot. Jan 23 00:06:08.103752 systemd-tmpfiles[1620]: Skipping /boot Jan 23 00:06:08.128224 zram_generator::config[1655]: No configuration found. Jan 23 00:06:08.279511 systemd[1]: Reloading finished in 226 ms. Jan 23 00:06:08.308591 systemd[1]: Finished systemd-fsck@dev-disk-by\x2dlabel-OEM.service - File System Check on /dev/disk/by-label/OEM. Jan 23 00:06:08.315843 systemd[1]: Finished systemd-tmpfiles-setup.service - Create System Files and Directories. Jan 23 00:06:08.331131 systemd[1]: Finished systemd-vconsole-setup.service - Virtual Console Setup. Jan 23 00:06:08.340307 systemd[1]: Starting audit-rules.service - Load Audit Rules... Jan 23 00:06:08.362634 systemd[1]: Starting clean-ca-certificates.service - Clean up broken links in /etc/ssl/certs... Jan 23 00:06:08.368613 systemd[1]: ignition-delete-config.service - Ignition (delete config) was skipped because no trigger condition checks were met. Jan 23 00:06:08.381603 systemd[1]: Starting modprobe@dm_mod.service - Load Kernel Module dm_mod... Jan 23 00:06:08.390224 systemd[1]: Starting modprobe@efi_pstore.service - Load Kernel Module efi_pstore... Jan 23 00:06:08.398319 systemd[1]: Starting modprobe@loop.service - Load Kernel Module loop... Jan 23 00:06:08.405337 systemd[1]: systemd-binfmt.service - Set Up Additional Binary Formats was skipped because no trigger condition checks were met. Jan 23 00:06:08.405627 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). Jan 23 00:06:08.408872 systemd[1]: Starting systemd-journal-catalog-update.service - Rebuild Journal Catalog... Jan 23 00:06:08.418870 systemd[1]: Starting systemd-resolved.service - Network Name Resolution... Jan 23 00:06:08.428029 systemd[1]: Starting systemd-update-utmp.service - Record System Boot/Shutdown in UTMP... Jan 23 00:06:08.437672 systemd[1]: modprobe@dm_mod.service: Deactivated successfully. Jan 23 00:06:08.438256 systemd[1]: Finished modprobe@dm_mod.service - Load Kernel Module dm_mod. Jan 23 00:06:08.447739 systemd[1]: modprobe@efi_pstore.service: Deactivated successfully. Jan 23 00:06:08.448125 systemd[1]: Finished modprobe@efi_pstore.service - Load Kernel Module efi_pstore. Jan 23 00:06:08.455437 systemd[1]: modprobe@loop.service: Deactivated successfully. Jan 23 00:06:08.455601 systemd[1]: Finished modprobe@loop.service - Load Kernel Module loop. Jan 23 00:06:08.473695 systemd[1]: Finished systemd-update-utmp.service - Record System Boot/Shutdown in UTMP. Jan 23 00:06:08.484883 systemd[1]: ignition-delete-config.service - Ignition (delete config) was skipped because no trigger condition checks were met. Jan 23 00:06:08.485895 systemd[1]: Starting modprobe@dm_mod.service - Load Kernel Module dm_mod... Jan 23 00:06:08.504732 systemd[1]: Starting modprobe@drm.service - Load Kernel Module drm... Jan 23 00:06:08.512330 systemd[1]: Starting modprobe@efi_pstore.service - Load Kernel Module efi_pstore... Jan 23 00:06:08.520010 systemd[1]: Starting modprobe@loop.service - Load Kernel Module loop... Jan 23 00:06:08.526449 systemd[1]: systemd-binfmt.service - Set Up Additional Binary Formats was skipped because no trigger condition checks were met. Jan 23 00:06:08.526553 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). Jan 23 00:06:08.526656 systemd[1]: Reached target time-set.target - System Time Set. Jan 23 00:06:08.533370 systemd[1]: modprobe@dm_mod.service: Deactivated successfully. Jan 23 00:06:08.536818 systemd[1]: Finished modprobe@dm_mod.service - Load Kernel Module dm_mod. Jan 23 00:06:08.550832 systemd[1]: Finished ensure-sysext.service. Jan 23 00:06:08.555662 systemd[1]: modprobe@drm.service: Deactivated successfully. Jan 23 00:06:08.555806 systemd[1]: Finished modprobe@drm.service - Load Kernel Module drm. Jan 23 00:06:08.562748 systemd[1]: modprobe@efi_pstore.service: Deactivated successfully. Jan 23 00:06:08.562881 systemd[1]: Finished modprobe@efi_pstore.service - Load Kernel Module efi_pstore. Jan 23 00:06:08.563346 systemd-resolved[1723]: Positive Trust Anchors: Jan 23 00:06:08.563354 systemd-resolved[1723]: . IN DS 20326 8 2 e06d44b80b8f1d39a95c0b0d7c65d08458e880409bbc683457104237c7f8ec8d Jan 23 00:06:08.563374 systemd-resolved[1723]: 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 Jan 23 00:06:08.570068 systemd[1]: modprobe@loop.service: Deactivated successfully. Jan 23 00:06:08.570220 systemd[1]: Finished modprobe@loop.service - Load Kernel Module loop. Jan 23 00:06:08.577758 systemd[1]: systemd-pstore.service - Platform Persistent Storage Archival was skipped because of an unmet condition check (ConditionDirectoryNotEmpty=/sys/fs/pstore). Jan 23 00:06:08.577827 systemd[1]: systemd-repart.service - Repartition Root Disk was skipped because no trigger condition checks were met. Jan 23 00:06:08.592613 systemd-resolved[1723]: Using system hostname 'ci-4459.2.2-n-156f37d5b5'. Jan 23 00:06:08.594523 systemd[1]: Started systemd-resolved.service - Network Name Resolution. Jan 23 00:06:08.600148 systemd[1]: Reached target network.target - Network. Jan 23 00:06:08.604178 systemd[1]: Reached target nss-lookup.target - Host and Network Name Lookups. Jan 23 00:06:08.639129 systemd[1]: Finished systemd-journal-catalog-update.service - Rebuild Journal Catalog. Jan 23 00:06:08.651996 augenrules[1758]: No rules Jan 23 00:06:08.652977 systemd[1]: audit-rules.service: Deactivated successfully. Jan 23 00:06:08.655268 systemd[1]: Finished audit-rules.service - Load Audit Rules. Jan 23 00:06:09.192469 systemd[1]: Finished clean-ca-certificates.service - Clean up broken links in /etc/ssl/certs. Jan 23 00:06:09.198643 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). Jan 23 00:06:09.640244 systemd-networkd[1490]: eth0: Gained IPv6LL Jan 23 00:06:09.645423 systemd[1]: Finished systemd-networkd-wait-online.service - Wait for Network to be Configured. Jan 23 00:06:09.651169 systemd[1]: Reached target network-online.target - Network is Online. Jan 23 00:06:12.074016 ldconfig[1447]: /sbin/ldconfig: /usr/lib/ld.so.conf is not an ELF file - it has the wrong magic bytes at the start. Jan 23 00:06:12.092154 systemd[1]: Finished ldconfig.service - Rebuild Dynamic Linker Cache. Jan 23 00:06:12.098696 systemd[1]: Starting systemd-update-done.service - Update is Completed... Jan 23 00:06:12.111786 systemd[1]: Finished systemd-update-done.service - Update is Completed. Jan 23 00:06:12.116594 systemd[1]: Reached target sysinit.target - System Initialization. Jan 23 00:06:12.121421 systemd[1]: Started motdgen.path - Watch for update engine configuration changes. Jan 23 00:06:12.126410 systemd[1]: Started user-cloudinit@var-lib-flatcar\x2dinstall-user_data.path - Watch for a cloud-config at /var/lib/flatcar-install/user_data. Jan 23 00:06:12.131833 systemd[1]: Started logrotate.timer - Daily rotation of log files. Jan 23 00:06:12.137395 systemd[1]: Started mdadm.timer - Weekly check for MD array's redundancy information.. Jan 23 00:06:12.143294 systemd[1]: Started systemd-tmpfiles-clean.timer - Daily Cleanup of Temporary Directories. Jan 23 00:06:12.148559 systemd[1]: update-engine-stub.timer - Update Engine Stub Timer was skipped because of an unmet condition check (ConditionPathExists=/usr/.noupdate). Jan 23 00:06:12.148590 systemd[1]: Reached target paths.target - Path Units. Jan 23 00:06:12.152489 systemd[1]: Reached target timers.target - Timer Units. Jan 23 00:06:12.159161 systemd[1]: Listening on dbus.socket - D-Bus System Message Bus Socket. Jan 23 00:06:12.166260 systemd[1]: Starting docker.socket - Docker Socket for the API... Jan 23 00:06:12.172324 systemd[1]: Listening on sshd-unix-local.socket - OpenSSH Server Socket (systemd-ssh-generator, AF_UNIX Local). Jan 23 00:06:12.178107 systemd[1]: Listening on sshd-vsock.socket - OpenSSH Server Socket (systemd-ssh-generator, AF_VSOCK). Jan 23 00:06:12.184600 systemd[1]: Reached target ssh-access.target - SSH Access Available. Jan 23 00:06:12.201764 systemd[1]: Listening on sshd.socket - OpenSSH Server Socket. Jan 23 00:06:12.206733 systemd[1]: Listening on systemd-hostnamed.socket - Hostname Service Socket. Jan 23 00:06:12.212635 systemd[1]: Listening on docker.socket - Docker Socket for the API. Jan 23 00:06:12.218210 systemd[1]: Reached target sockets.target - Socket Units. Jan 23 00:06:12.222920 systemd[1]: Reached target basic.target - Basic System. Jan 23 00:06:12.227488 systemd[1]: addon-config@oem.service - Configure Addon /oem was skipped because no trigger condition checks were met. Jan 23 00:06:12.227513 systemd[1]: addon-run@oem.service - Run Addon /oem was skipped because no trigger condition checks were met. Jan 23 00:06:12.229771 systemd[1]: Starting chronyd.service - NTP client/server... Jan 23 00:06:12.249186 systemd[1]: Starting containerd.service - containerd container runtime... Jan 23 00:06:12.255219 systemd[1]: Starting coreos-metadata.service - Flatcar Metadata Agent... Jan 23 00:06:12.263376 systemd[1]: Starting dbus.service - D-Bus System Message Bus... Jan 23 00:06:12.276147 systemd[1]: Starting dracut-shutdown.service - Restore /run/initramfs on shutdown... Jan 23 00:06:12.295037 systemd[1]: Starting enable-oem-cloudinit.service - Enable cloudinit... Jan 23 00:06:12.300973 systemd[1]: Starting extend-filesystems.service - Extend Filesystems... Jan 23 00:06:12.303247 jq[1780]: false Jan 23 00:06:12.308383 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). Jan 23 00:06:12.309458 systemd[1]: Started hv_kvp_daemon.service - Hyper-V KVP daemon. Jan 23 00:06:12.316940 chronyd[1772]: chronyd version 4.7 starting (+CMDMON +REFCLOCK +RTC +PRIVDROP +SCFILTER -SIGND +NTS +SECHASH +IPV6 -DEBUG) Jan 23 00:06:12.317534 systemd[1]: hv_vss_daemon.service - Hyper-V VSS daemon was skipped because of an unmet condition check (ConditionPathExists=/dev/vmbus/hv_vss). Jan 23 00:06:12.318873 systemd[1]: Starting motdgen.service - Generate /run/flatcar/motd... Jan 23 00:06:12.321174 KVP[1782]: KVP starting; pid is:1782 Jan 23 00:06:12.328250 systemd[1]: Starting nvidia.service - NVIDIA Configure Service... Jan 23 00:06:12.336835 systemd[1]: Starting ssh-key-proc-cmdline.service - Install an ssh key from /proc/cmdline... Jan 23 00:06:12.343308 chronyd[1772]: Timezone right/UTC failed leap second check, ignoring Jan 23 00:06:12.343463 chronyd[1772]: Loaded seccomp filter (level 2) Jan 23 00:06:12.346217 systemd[1]: Starting sshd-keygen.service - Generate sshd host keys... Jan 23 00:06:12.346795 KVP[1782]: KVP LIC Version: 3.1 Jan 23 00:06:12.347088 kernel: hv_utils: KVP IC version 4.0 Jan 23 00:06:12.355226 systemd[1]: Starting systemd-logind.service - User Login Management... Jan 23 00:06:12.363144 systemd[1]: tcsd.service - TCG Core Services Daemon was skipped because of an unmet condition check (ConditionPathExists=/dev/tpm0). Jan 23 00:06:12.363658 systemd[1]: cgroup compatibility translation between legacy and unified hierarchy settings activated. See cgroup-compat debug messages for details. Jan 23 00:06:12.364502 systemd[1]: Starting update-engine.service - Update Engine... Jan 23 00:06:12.371203 systemd[1]: Starting update-ssh-keys-after-ignition.service - Run update-ssh-keys once after Ignition... Jan 23 00:06:12.380288 systemd[1]: Started chronyd.service - NTP client/server. Jan 23 00:06:12.388317 extend-filesystems[1781]: Found /dev/sda6 Jan 23 00:06:12.394323 jq[1796]: true Jan 23 00:06:12.394799 systemd[1]: Finished dracut-shutdown.service - Restore /run/initramfs on shutdown. Jan 23 00:06:12.402616 systemd[1]: enable-oem-cloudinit.service: Skipped due to 'exec-condition'. Jan 23 00:06:12.402801 systemd[1]: Condition check resulted in enable-oem-cloudinit.service - Enable cloudinit being skipped. Jan 23 00:06:12.403006 systemd[1]: motdgen.service: Deactivated successfully. Jan 23 00:06:12.403365 systemd[1]: Finished motdgen.service - Generate /run/flatcar/motd. Jan 23 00:06:12.410456 systemd[1]: ssh-key-proc-cmdline.service: Deactivated successfully. Jan 23 00:06:12.410621 systemd[1]: Finished ssh-key-proc-cmdline.service - Install an ssh key from /proc/cmdline. Jan 23 00:06:12.419622 extend-filesystems[1781]: Found /dev/sda9 Jan 23 00:06:12.438194 extend-filesystems[1781]: Checking size of /dev/sda9 Jan 23 00:06:12.437449 (ntainerd)[1818]: containerd.service: Referenced but unset environment variable evaluates to an empty string: TORCX_IMAGEDIR, TORCX_UNPACKDIR Jan 23 00:06:12.448757 jq[1806]: true Jan 23 00:06:12.452918 update_engine[1795]: I20260123 00:06:12.452837 1795 main.cc:92] Flatcar Update Engine starting Jan 23 00:06:12.460254 systemd[1]: Finished nvidia.service - NVIDIA Configure Service. Jan 23 00:06:12.481127 extend-filesystems[1781]: Old size kept for /dev/sda9 Jan 23 00:06:12.472531 systemd[1]: extend-filesystems.service: Deactivated successfully. Jan 23 00:06:12.473893 systemd[1]: Finished extend-filesystems.service - Extend Filesystems. Jan 23 00:06:12.493711 systemd-logind[1792]: New seat seat0. Jan 23 00:06:12.495616 systemd-logind[1792]: Watching system buttons on /dev/input/event0 (AT Translated Set 2 keyboard) Jan 23 00:06:12.495774 systemd[1]: Started systemd-logind.service - User Login Management. Jan 23 00:06:12.559561 bash[1842]: Updated "/home/core/.ssh/authorized_keys" Jan 23 00:06:12.562992 systemd[1]: Finished update-ssh-keys-after-ignition.service - Run update-ssh-keys once after Ignition. Jan 23 00:06:12.570474 systemd[1]: sshkeys.service was skipped because no trigger condition checks were met. Jan 23 00:06:12.642612 sshd_keygen[1797]: ssh-keygen: generating new host keys: RSA ECDSA ED25519 Jan 23 00:06:12.660355 systemd[1]: Finished sshd-keygen.service - Generate sshd host keys. Jan 23 00:06:12.666361 systemd[1]: Starting issuegen.service - Generate /run/issue... Jan 23 00:06:12.673719 systemd[1]: Starting waagent.service - Microsoft Azure Linux Agent... Jan 23 00:06:12.679645 systemd[1]: issuegen.service: Deactivated successfully. Jan 23 00:06:12.679921 systemd[1]: Finished issuegen.service - Generate /run/issue. Jan 23 00:06:12.685976 dbus-daemon[1775]: [system] SELinux support is enabled Jan 23 00:06:12.689097 update_engine[1795]: I20260123 00:06:12.689006 1795 update_check_scheduler.cc:74] Next update check in 4m35s Jan 23 00:06:12.691951 systemd[1]: Starting systemd-user-sessions.service - Permit User Sessions... Jan 23 00:06:12.697690 systemd[1]: Started dbus.service - D-Bus System Message Bus. Jan 23 00:06:12.717623 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). Jan 23 00:06:12.718564 dbus-daemon[1775]: [system] Successfully activated service 'org.freedesktop.systemd1' Jan 23 00:06:12.717666 systemd[1]: Reached target system-config.target - Load system-provided cloud configs. Jan 23 00:06:12.723840 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). Jan 23 00:06:12.723859 systemd[1]: Reached target user-config.target - Load user-provided cloud configs. Jan 23 00:06:12.733899 coreos-metadata[1774]: Jan 23 00:06:12.733 INFO Fetching http://168.63.129.16/?comp=versions: Attempt #1 Jan 23 00:06:12.736257 systemd[1]: Finished systemd-user-sessions.service - Permit User Sessions. Jan 23 00:06:12.743390 systemd[1]: Started update-engine.service - Update Engine. Jan 23 00:06:12.743596 coreos-metadata[1774]: Jan 23 00:06:12.743 INFO Fetch successful Jan 23 00:06:12.743803 coreos-metadata[1774]: Jan 23 00:06:12.743 INFO Fetching http://168.63.129.16/machine/?comp=goalstate: Attempt #1 Jan 23 00:06:12.749402 systemd[1]: Started waagent.service - Microsoft Azure Linux Agent. Jan 23 00:06:12.754921 coreos-metadata[1774]: Jan 23 00:06:12.754 INFO Fetch successful Jan 23 00:06:12.755005 coreos-metadata[1774]: Jan 23 00:06:12.754 INFO Fetching http://168.63.129.16/machine/14d03ebd-811c-4466-92f7-abc5b7a402a2/bb36a84a%2D2564%2D4ff3%2D9227%2De55d0c3ecf93.%5Fci%2D4459.2.2%2Dn%2D156f37d5b5?comp=config&type=sharedConfig&incarnation=1: Attempt #1 Jan 23 00:06:12.757025 coreos-metadata[1774]: Jan 23 00:06:12.756 INFO Fetch successful Jan 23 00:06:12.757133 coreos-metadata[1774]: Jan 23 00:06:12.757 INFO Fetching http://169.254.169.254/metadata/instance/compute/vmSize?api-version=2017-08-01&format=text: Attempt #1 Jan 23 00:06:12.758934 systemd[1]: Started getty@tty1.service - Getty on tty1. Jan 23 00:06:12.766060 coreos-metadata[1774]: Jan 23 00:06:12.765 INFO Fetch successful Jan 23 00:06:12.768403 systemd[1]: Started serial-getty@ttyAMA0.service - Serial Getty on ttyAMA0. Jan 23 00:06:12.774493 systemd[1]: Reached target getty.target - Login Prompts. Jan 23 00:06:12.780880 systemd[1]: Started locksmithd.service - Cluster reboot manager. Jan 23 00:06:12.802131 systemd[1]: Finished coreos-metadata.service - Flatcar Metadata Agent. Jan 23 00:06:12.808153 systemd[1]: packet-phone-home.service - Report Success to Packet was skipped because no trigger condition checks were met. Jan 23 00:06:12.945876 locksmithd[1931]: locksmithd starting currentOperation="UPDATE_STATUS_IDLE" strategy="reboot" Jan 23 00:06:13.132084 containerd[1818]: time="2026-01-23T00:06:13Z" 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 Jan 23 00:06:13.132562 containerd[1818]: time="2026-01-23T00:06:13.132528996Z" level=info msg="starting containerd" revision=4ac6c20c7bbf8177f29e46bbdc658fec02ffb8ad version=v2.0.7 Jan 23 00:06:13.139007 containerd[1818]: time="2026-01-23T00:06:13.138961604Z" level=warning msg="Configuration migrated from version 2, use `containerd config migrate` to avoid migration" t="8.496µs" Jan 23 00:06:13.139007 containerd[1818]: time="2026-01-23T00:06:13.138999732Z" level=info msg="loading plugin" id=io.containerd.image-verifier.v1.bindir type=io.containerd.image-verifier.v1 Jan 23 00:06:13.139007 containerd[1818]: time="2026-01-23T00:06:13.139018284Z" level=info msg="loading plugin" id=io.containerd.internal.v1.opt type=io.containerd.internal.v1 Jan 23 00:06:13.139443 containerd[1818]: time="2026-01-23T00:06:13.139419404Z" level=info msg="loading plugin" id=io.containerd.warning.v1.deprecations type=io.containerd.warning.v1 Jan 23 00:06:13.139492 containerd[1818]: time="2026-01-23T00:06:13.139449060Z" level=info msg="loading plugin" id=io.containerd.content.v1.content type=io.containerd.content.v1 Jan 23 00:06:13.139492 containerd[1818]: time="2026-01-23T00:06:13.139470532Z" level=info msg="loading plugin" id=io.containerd.snapshotter.v1.blockfile type=io.containerd.snapshotter.v1 Jan 23 00:06:13.139536 containerd[1818]: time="2026-01-23T00:06:13.139519796Z" level=info msg="skip loading plugin" error="no scratch file generator: skip plugin" id=io.containerd.snapshotter.v1.blockfile type=io.containerd.snapshotter.v1 Jan 23 00:06:13.139536 containerd[1818]: time="2026-01-23T00:06:13.139531140Z" level=info msg="loading plugin" id=io.containerd.snapshotter.v1.btrfs type=io.containerd.snapshotter.v1 Jan 23 00:06:13.139757 containerd[1818]: time="2026-01-23T00:06:13.139740548Z" 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 Jan 23 00:06:13.139775 containerd[1818]: time="2026-01-23T00:06:13.139756748Z" level=info msg="loading plugin" id=io.containerd.snapshotter.v1.devmapper type=io.containerd.snapshotter.v1 Jan 23 00:06:13.139775 containerd[1818]: time="2026-01-23T00:06:13.139764868Z" level=info msg="skip loading plugin" error="devmapper not configured: skip plugin" id=io.containerd.snapshotter.v1.devmapper type=io.containerd.snapshotter.v1 Jan 23 00:06:13.139775 containerd[1818]: time="2026-01-23T00:06:13.139769916Z" level=info msg="loading plugin" id=io.containerd.snapshotter.v1.native type=io.containerd.snapshotter.v1 Jan 23 00:06:13.139865 containerd[1818]: time="2026-01-23T00:06:13.139852404Z" level=info msg="loading plugin" id=io.containerd.snapshotter.v1.overlayfs type=io.containerd.snapshotter.v1 Jan 23 00:06:13.140033 containerd[1818]: time="2026-01-23T00:06:13.140017476Z" level=info msg="loading plugin" id=io.containerd.snapshotter.v1.zfs type=io.containerd.snapshotter.v1 Jan 23 00:06:13.140053 containerd[1818]: time="2026-01-23T00:06:13.140044124Z" 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 Jan 23 00:06:13.140068 containerd[1818]: time="2026-01-23T00:06:13.140052876Z" level=info msg="loading plugin" id=io.containerd.event.v1.exchange type=io.containerd.event.v1 Jan 23 00:06:13.140446 containerd[1818]: time="2026-01-23T00:06:13.140071380Z" level=info msg="loading plugin" id=io.containerd.monitor.task.v1.cgroups type=io.containerd.monitor.task.v1 Jan 23 00:06:13.140446 containerd[1818]: time="2026-01-23T00:06:13.140256380Z" level=info msg="loading plugin" id=io.containerd.metadata.v1.bolt type=io.containerd.metadata.v1 Jan 23 00:06:13.140446 containerd[1818]: time="2026-01-23T00:06:13.140319700Z" level=info msg="metadata content store policy set" policy=shared Jan 23 00:06:13.155681 containerd[1818]: time="2026-01-23T00:06:13.155629308Z" level=info msg="loading plugin" id=io.containerd.gc.v1.scheduler type=io.containerd.gc.v1 Jan 23 00:06:13.155750 containerd[1818]: time="2026-01-23T00:06:13.155699036Z" level=info msg="loading plugin" id=io.containerd.differ.v1.walking type=io.containerd.differ.v1 Jan 23 00:06:13.155750 containerd[1818]: time="2026-01-23T00:06:13.155712012Z" level=info msg="loading plugin" id=io.containerd.lease.v1.manager type=io.containerd.lease.v1 Jan 23 00:06:13.155750 containerd[1818]: time="2026-01-23T00:06:13.155721076Z" level=info msg="loading plugin" id=io.containerd.service.v1.containers-service type=io.containerd.service.v1 Jan 23 00:06:13.155750 containerd[1818]: time="2026-01-23T00:06:13.155730076Z" level=info msg="loading plugin" id=io.containerd.service.v1.content-service type=io.containerd.service.v1 Jan 23 00:06:13.155750 containerd[1818]: time="2026-01-23T00:06:13.155738316Z" level=info msg="loading plugin" id=io.containerd.service.v1.diff-service type=io.containerd.service.v1 Jan 23 00:06:13.155750 containerd[1818]: time="2026-01-23T00:06:13.155748788Z" level=info msg="loading plugin" id=io.containerd.service.v1.images-service type=io.containerd.service.v1 Jan 23 00:06:13.155838 containerd[1818]: time="2026-01-23T00:06:13.155762028Z" level=info msg="loading plugin" id=io.containerd.service.v1.introspection-service type=io.containerd.service.v1 Jan 23 00:06:13.155838 containerd[1818]: time="2026-01-23T00:06:13.155770804Z" level=info msg="loading plugin" id=io.containerd.service.v1.namespaces-service type=io.containerd.service.v1 Jan 23 00:06:13.155838 containerd[1818]: time="2026-01-23T00:06:13.155780804Z" level=info msg="loading plugin" id=io.containerd.service.v1.snapshots-service type=io.containerd.service.v1 Jan 23 00:06:13.155838 containerd[1818]: time="2026-01-23T00:06:13.155787476Z" level=info msg="loading plugin" id=io.containerd.shim.v1.manager type=io.containerd.shim.v1 Jan 23 00:06:13.155838 containerd[1818]: time="2026-01-23T00:06:13.155795940Z" level=info msg="loading plugin" id=io.containerd.runtime.v2.task type=io.containerd.runtime.v2 Jan 23 00:06:13.156325 containerd[1818]: time="2026-01-23T00:06:13.156116972Z" level=info msg="loading plugin" id=io.containerd.service.v1.tasks-service type=io.containerd.service.v1 Jan 23 00:06:13.156325 containerd[1818]: time="2026-01-23T00:06:13.156142068Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.containers type=io.containerd.grpc.v1 Jan 23 00:06:13.156325 containerd[1818]: time="2026-01-23T00:06:13.156152852Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.content type=io.containerd.grpc.v1 Jan 23 00:06:13.156325 containerd[1818]: time="2026-01-23T00:06:13.156163380Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.diff type=io.containerd.grpc.v1 Jan 23 00:06:13.156325 containerd[1818]: time="2026-01-23T00:06:13.156170244Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.events type=io.containerd.grpc.v1 Jan 23 00:06:13.156325 containerd[1818]: time="2026-01-23T00:06:13.156176996Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.images type=io.containerd.grpc.v1 Jan 23 00:06:13.156325 containerd[1818]: time="2026-01-23T00:06:13.156183908Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.introspection type=io.containerd.grpc.v1 Jan 23 00:06:13.156325 containerd[1818]: time="2026-01-23T00:06:13.156190076Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.leases type=io.containerd.grpc.v1 Jan 23 00:06:13.156325 containerd[1818]: time="2026-01-23T00:06:13.156198348Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.namespaces type=io.containerd.grpc.v1 Jan 23 00:06:13.156325 containerd[1818]: time="2026-01-23T00:06:13.156204484Z" level=info msg="loading plugin" id=io.containerd.sandbox.store.v1.local type=io.containerd.sandbox.store.v1 Jan 23 00:06:13.156325 containerd[1818]: time="2026-01-23T00:06:13.156211092Z" level=info msg="loading plugin" id=io.containerd.cri.v1.images type=io.containerd.cri.v1 Jan 23 00:06:13.156325 containerd[1818]: time="2026-01-23T00:06:13.156259444Z" level=info msg="Get image filesystem path \"/var/lib/containerd/io.containerd.snapshotter.v1.overlayfs\" for snapshotter \"overlayfs\"" Jan 23 00:06:13.156325 containerd[1818]: time="2026-01-23T00:06:13.156269940Z" level=info msg="Start snapshots syncer" Jan 23 00:06:13.156325 containerd[1818]: time="2026-01-23T00:06:13.156284332Z" level=info msg="loading plugin" id=io.containerd.cri.v1.runtime type=io.containerd.cri.v1 Jan 23 00:06:13.156551 containerd[1818]: time="2026-01-23T00:06:13.156483932Z" 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\"}" Jan 23 00:06:13.156551 containerd[1818]: time="2026-01-23T00:06:13.156520908Z" level=info msg="loading plugin" id=io.containerd.podsandbox.controller.v1.podsandbox type=io.containerd.podsandbox.controller.v1 Jan 23 00:06:13.156634 containerd[1818]: time="2026-01-23T00:06:13.156550692Z" level=info msg="loading plugin" id=io.containerd.sandbox.controller.v1.shim type=io.containerd.sandbox.controller.v1 Jan 23 00:06:13.156647 containerd[1818]: time="2026-01-23T00:06:13.156638724Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.sandbox-controllers type=io.containerd.grpc.v1 Jan 23 00:06:13.156661 containerd[1818]: time="2026-01-23T00:06:13.156651540Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.sandboxes type=io.containerd.grpc.v1 Jan 23 00:06:13.156661 containerd[1818]: time="2026-01-23T00:06:13.156658756Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.snapshots type=io.containerd.grpc.v1 Jan 23 00:06:13.156690 containerd[1818]: time="2026-01-23T00:06:13.156670524Z" level=info msg="loading plugin" id=io.containerd.streaming.v1.manager type=io.containerd.streaming.v1 Jan 23 00:06:13.156690 containerd[1818]: time="2026-01-23T00:06:13.156678076Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.streaming type=io.containerd.grpc.v1 Jan 23 00:06:13.156690 containerd[1818]: time="2026-01-23T00:06:13.156686004Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.tasks type=io.containerd.grpc.v1 Jan 23 00:06:13.156725 containerd[1818]: time="2026-01-23T00:06:13.156694412Z" level=info msg="loading plugin" id=io.containerd.transfer.v1.local type=io.containerd.transfer.v1 Jan 23 00:06:13.156725 containerd[1818]: time="2026-01-23T00:06:13.156715884Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.transfer type=io.containerd.grpc.v1 Jan 23 00:06:13.156749 containerd[1818]: time="2026-01-23T00:06:13.156724340Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.version type=io.containerd.grpc.v1 Jan 23 00:06:13.156749 containerd[1818]: time="2026-01-23T00:06:13.156731308Z" level=info msg="loading plugin" id=io.containerd.monitor.container.v1.restart type=io.containerd.monitor.container.v1 Jan 23 00:06:13.156798 containerd[1818]: time="2026-01-23T00:06:13.156754532Z" level=info msg="loading plugin" id=io.containerd.tracing.processor.v1.otlp type=io.containerd.tracing.processor.v1 Jan 23 00:06:13.156798 containerd[1818]: time="2026-01-23T00:06:13.156766324Z" 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 Jan 23 00:06:13.156798 containerd[1818]: time="2026-01-23T00:06:13.156771876Z" level=info msg="loading plugin" id=io.containerd.internal.v1.tracing type=io.containerd.internal.v1 Jan 23 00:06:13.156798 containerd[1818]: time="2026-01-23T00:06:13.156778108Z" level=info msg="skip loading plugin" error="skip plugin: tracing endpoint not configured" id=io.containerd.internal.v1.tracing type=io.containerd.internal.v1 Jan 23 00:06:13.156798 containerd[1818]: time="2026-01-23T00:06:13.156782564Z" level=info msg="loading plugin" id=io.containerd.ttrpc.v1.otelttrpc type=io.containerd.ttrpc.v1 Jan 23 00:06:13.156798 containerd[1818]: time="2026-01-23T00:06:13.156787764Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.healthcheck type=io.containerd.grpc.v1 Jan 23 00:06:13.156798 containerd[1818]: time="2026-01-23T00:06:13.156794468Z" level=info msg="loading plugin" id=io.containerd.nri.v1.nri type=io.containerd.nri.v1 Jan 23 00:06:13.156878 containerd[1818]: time="2026-01-23T00:06:13.156806132Z" level=info msg="runtime interface created" Jan 23 00:06:13.156878 containerd[1818]: time="2026-01-23T00:06:13.156809916Z" level=info msg="created NRI interface" Jan 23 00:06:13.156878 containerd[1818]: time="2026-01-23T00:06:13.156814820Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.cri type=io.containerd.grpc.v1 Jan 23 00:06:13.156878 containerd[1818]: time="2026-01-23T00:06:13.156822884Z" level=info msg="Connect containerd service" Jan 23 00:06:13.156878 containerd[1818]: time="2026-01-23T00:06:13.156836076Z" level=info msg="using experimental NRI integration - disable nri plugin to prevent this" Jan 23 00:06:13.157706 containerd[1818]: time="2026-01-23T00:06:13.157439652Z" 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" Jan 23 00:06:13.570455 containerd[1818]: time="2026-01-23T00:06:13.570386164Z" level=info msg="Start subscribing containerd event" Jan 23 00:06:13.570688 containerd[1818]: time="2026-01-23T00:06:13.570670388Z" level=info msg="Start recovering state" Jan 23 00:06:13.570967 containerd[1818]: time="2026-01-23T00:06:13.570933660Z" level=info msg="Start event monitor" Jan 23 00:06:13.570967 containerd[1818]: time="2026-01-23T00:06:13.570958524Z" level=info msg="Start cni network conf syncer for default" Jan 23 00:06:13.570967 containerd[1818]: time="2026-01-23T00:06:13.570968596Z" level=info msg="Start streaming server" Jan 23 00:06:13.571154 containerd[1818]: time="2026-01-23T00:06:13.570975660Z" level=info msg="Registered namespace \"k8s.io\" with NRI" Jan 23 00:06:13.571154 containerd[1818]: time="2026-01-23T00:06:13.570981188Z" level=info msg="runtime interface starting up..." Jan 23 00:06:13.571154 containerd[1818]: time="2026-01-23T00:06:13.570985116Z" level=info msg="starting plugins..." Jan 23 00:06:13.571154 containerd[1818]: time="2026-01-23T00:06:13.570996444Z" level=info msg="Synchronizing NRI (plugin) with current runtime state" Jan 23 00:06:13.571154 containerd[1818]: time="2026-01-23T00:06:13.570946660Z" level=info msg=serving... address=/run/containerd/containerd.sock.ttrpc Jan 23 00:06:13.576689 containerd[1818]: time="2026-01-23T00:06:13.571238452Z" level=info msg=serving... address=/run/containerd/containerd.sock Jan 23 00:06:13.571393 systemd[1]: Started containerd.service - containerd container runtime. Jan 23 00:06:13.577099 containerd[1818]: time="2026-01-23T00:06:13.576796036Z" level=info msg="containerd successfully booted in 0.445048s" Jan 23 00:06:13.578337 systemd[1]: Reached target multi-user.target - Multi-User System. Jan 23 00:06:13.589142 systemd[1]: Startup finished in 1.711s (kernel) + 10.517s (initrd) + 11.528s (userspace) = 23.757s. Jan 23 00:06:13.788735 login[1929]: pam_lastlog(login:session): file /var/log/lastlog is locked/write, retrying Jan 23 00:06:13.789738 login[1930]: pam_unix(login:session): session opened for user core(uid=500) by core(uid=0) Jan 23 00:06:13.817160 systemd[1]: Created slice user-500.slice - User Slice of UID 500. Jan 23 00:06:13.817326 systemd-logind[1792]: New session 1 of user core. Jan 23 00:06:13.819105 systemd[1]: Starting user-runtime-dir@500.service - User Runtime Directory /run/user/500... Jan 23 00:06:13.854681 systemd[1]: Finished user-runtime-dir@500.service - User Runtime Directory /run/user/500. Jan 23 00:06:13.856853 systemd[1]: Starting user@500.service - User Manager for UID 500... Jan 23 00:06:13.890043 (systemd)[1966]: pam_unix(systemd-user:session): session opened for user core(uid=500) by (uid=0) Jan 23 00:06:13.892284 systemd-logind[1792]: New session c1 of user core. Jan 23 00:06:14.012280 systemd[1966]: Queued start job for default target default.target. Jan 23 00:06:14.026920 systemd[1966]: Created slice app.slice - User Application Slice. Jan 23 00:06:14.027121 systemd[1966]: Reached target paths.target - Paths. Jan 23 00:06:14.027230 systemd[1966]: Reached target timers.target - Timers. Jan 23 00:06:14.028461 systemd[1966]: Starting dbus.socket - D-Bus User Message Bus Socket... Jan 23 00:06:14.036593 systemd[1966]: Listening on dbus.socket - D-Bus User Message Bus Socket. Jan 23 00:06:14.036748 systemd[1966]: Reached target sockets.target - Sockets. Jan 23 00:06:14.036849 systemd[1966]: Reached target basic.target - Basic System. Jan 23 00:06:14.036990 systemd[1966]: Reached target default.target - Main User Target. Jan 23 00:06:14.037136 systemd[1]: Started user@500.service - User Manager for UID 500. Jan 23 00:06:14.038056 systemd[1]: Started session-1.scope - Session 1 of User core. Jan 23 00:06:14.038221 systemd[1966]: Startup finished in 140ms. Jan 23 00:06:14.460327 waagent[1927]: 2026-01-23T00:06:14.460258Z INFO Daemon Daemon Azure Linux Agent Version: 2.12.0.4 Jan 23 00:06:14.465287 waagent[1927]: 2026-01-23T00:06:14.465239Z INFO Daemon Daemon OS: flatcar 4459.2.2 Jan 23 00:06:14.469011 waagent[1927]: 2026-01-23T00:06:14.468980Z INFO Daemon Daemon Python: 3.11.13 Jan 23 00:06:14.473769 waagent[1927]: 2026-01-23T00:06:14.473709Z INFO Daemon Daemon Run daemon Jan 23 00:06:14.477459 waagent[1927]: 2026-01-23T00:06:14.477357Z INFO Daemon Daemon No RDMA handler exists for distro='Flatcar Container Linux by Kinvolk' version='4459.2.2' Jan 23 00:06:14.484596 waagent[1927]: 2026-01-23T00:06:14.484563Z INFO Daemon Daemon Using waagent for provisioning Jan 23 00:06:14.488959 waagent[1927]: 2026-01-23T00:06:14.488925Z INFO Daemon Daemon Activate resource disk Jan 23 00:06:14.493196 waagent[1927]: 2026-01-23T00:06:14.493158Z INFO Daemon Daemon Searching gen1 prefix 00000000-0001 or gen2 f8b3781a-1e82-4818-a1c3-63d806ec15bb Jan 23 00:06:14.502312 waagent[1927]: 2026-01-23T00:06:14.502266Z INFO Daemon Daemon Found device: None Jan 23 00:06:14.505851 waagent[1927]: 2026-01-23T00:06:14.505816Z ERROR Daemon Daemon Failed to mount resource disk [ResourceDiskError] unable to detect disk topology Jan 23 00:06:14.513093 waagent[1927]: 2026-01-23T00:06:14.513055Z ERROR Daemon Daemon Event: name=WALinuxAgent, op=ActivateResourceDisk, message=[ResourceDiskError] unable to detect disk topology, duration=0 Jan 23 00:06:14.522665 waagent[1927]: 2026-01-23T00:06:14.522628Z INFO Daemon Daemon Clean protocol and wireserver endpoint Jan 23 00:06:14.527878 waagent[1927]: 2026-01-23T00:06:14.527848Z INFO Daemon Daemon Running default provisioning handler Jan 23 00:06:14.537799 waagent[1927]: 2026-01-23T00:06:14.537751Z 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. Jan 23 00:06:14.549344 waagent[1927]: 2026-01-23T00:06:14.549298Z INFO Daemon Daemon Unable to get cloud-init enabled status from service: [Errno 2] No such file or directory: 'service' Jan 23 00:06:14.557869 waagent[1927]: 2026-01-23T00:06:14.557829Z INFO Daemon Daemon cloud-init is enabled: False Jan 23 00:06:14.561927 waagent[1927]: 2026-01-23T00:06:14.561898Z INFO Daemon Daemon Copying ovf-env.xml Jan 23 00:06:14.655261 waagent[1927]: 2026-01-23T00:06:14.654793Z INFO Daemon Daemon Successfully mounted dvd Jan 23 00:06:14.687200 systemd[1]: mnt-cdrom-secure.mount: Deactivated successfully. Jan 23 00:06:14.691103 waagent[1927]: 2026-01-23T00:06:14.689328Z INFO Daemon Daemon Detect protocol endpoint Jan 23 00:06:14.693364 waagent[1927]: 2026-01-23T00:06:14.693319Z INFO Daemon Daemon Clean protocol and wireserver endpoint Jan 23 00:06:14.698099 waagent[1927]: 2026-01-23T00:06:14.698048Z INFO Daemon Daemon WireServer endpoint is not found. Rerun dhcp handler Jan 23 00:06:14.703479 waagent[1927]: 2026-01-23T00:06:14.703443Z INFO Daemon Daemon Test for route to 168.63.129.16 Jan 23 00:06:14.708076 waagent[1927]: 2026-01-23T00:06:14.708040Z INFO Daemon Daemon Route to 168.63.129.16 exists Jan 23 00:06:14.712390 waagent[1927]: 2026-01-23T00:06:14.712322Z INFO Daemon Daemon Wire server endpoint:168.63.129.16 Jan 23 00:06:14.758014 waagent[1927]: 2026-01-23T00:06:14.757967Z INFO Daemon Daemon Fabric preferred wire protocol version:2015-04-05 Jan 23 00:06:14.763833 waagent[1927]: 2026-01-23T00:06:14.763804Z INFO Daemon Daemon Wire protocol version:2012-11-30 Jan 23 00:06:14.768824 waagent[1927]: 2026-01-23T00:06:14.768792Z INFO Daemon Daemon Server preferred version:2015-04-05 Jan 23 00:06:14.789403 login[1929]: pam_unix(login:session): session opened for user core(uid=500) by core(uid=0) Jan 23 00:06:14.792902 systemd-logind[1792]: New session 2 of user core. Jan 23 00:06:14.799250 systemd[1]: Started session-2.scope - Session 2 of User core. Jan 23 00:06:14.900904 waagent[1927]: 2026-01-23T00:06:14.900819Z INFO Daemon Daemon Initializing goal state during protocol detection Jan 23 00:06:14.906380 waagent[1927]: 2026-01-23T00:06:14.906324Z INFO Daemon Daemon Forcing an update of the goal state. Jan 23 00:06:14.914721 waagent[1927]: 2026-01-23T00:06:14.914680Z INFO Daemon Fetched a new incarnation for the WireServer goal state [incarnation 1] Jan 23 00:06:14.939199 waagent[1927]: 2026-01-23T00:06:14.939164Z INFO Daemon Daemon HostGAPlugin version: 1.0.8.177 Jan 23 00:06:14.943879 waagent[1927]: 2026-01-23T00:06:14.943846Z INFO Daemon Jan 23 00:06:14.946192 waagent[1927]: 2026-01-23T00:06:14.946162Z INFO Daemon Fetched new vmSettings [HostGAPlugin correlation ID: d7df930f-b340-4ec6-bd3a-7374e2d7c73a eTag: 14304891853787439518 source: Fabric] Jan 23 00:06:14.955777 waagent[1927]: 2026-01-23T00:06:14.955746Z INFO Daemon The vmSettings originated via Fabric; will ignore them. Jan 23 00:06:14.961356 waagent[1927]: 2026-01-23T00:06:14.961327Z INFO Daemon Jan 23 00:06:14.963991 waagent[1927]: 2026-01-23T00:06:14.963936Z INFO Daemon Fetching full goal state from the WireServer [incarnation 1] Jan 23 00:06:14.973532 waagent[1927]: 2026-01-23T00:06:14.973504Z INFO Daemon Daemon Downloading artifacts profile blob Jan 23 00:06:15.037688 waagent[1927]: 2026-01-23T00:06:15.037612Z INFO Daemon Downloaded certificate {'thumbprint': 'AD8103BDE902EF685FA3AEC32D5B807A8458C8A9', 'hasPrivateKey': True} Jan 23 00:06:15.046641 waagent[1927]: 2026-01-23T00:06:15.046600Z INFO Daemon Fetch goal state completed Jan 23 00:06:15.057551 waagent[1927]: 2026-01-23T00:06:15.057510Z INFO Daemon Daemon Starting provisioning Jan 23 00:06:15.061867 waagent[1927]: 2026-01-23T00:06:15.061832Z INFO Daemon Daemon Handle ovf-env.xml. Jan 23 00:06:15.065765 waagent[1927]: 2026-01-23T00:06:15.065738Z INFO Daemon Daemon Set hostname [ci-4459.2.2-n-156f37d5b5] Jan 23 00:06:15.071986 waagent[1927]: 2026-01-23T00:06:15.071943Z INFO Daemon Daemon Publish hostname [ci-4459.2.2-n-156f37d5b5] Jan 23 00:06:15.077320 waagent[1927]: 2026-01-23T00:06:15.077280Z INFO Daemon Daemon Examine /proc/net/route for primary interface Jan 23 00:06:15.082029 waagent[1927]: 2026-01-23T00:06:15.081993Z INFO Daemon Daemon Primary interface is [eth0] Jan 23 00:06:15.092306 systemd-networkd[1490]: eth0: found matching network '/usr/lib/systemd/network/zz-default.network', based on potentially unpredictable interface name. Jan 23 00:06:15.092312 systemd-networkd[1490]: eth0: Configuring with /usr/lib/systemd/network/zz-default.network. Jan 23 00:06:15.092343 systemd-networkd[1490]: eth0: DHCP lease lost Jan 23 00:06:15.093139 waagent[1927]: 2026-01-23T00:06:15.093093Z INFO Daemon Daemon Create user account if not exists Jan 23 00:06:15.097410 waagent[1927]: 2026-01-23T00:06:15.097371Z INFO Daemon Daemon User core already exists, skip useradd Jan 23 00:06:15.101570 waagent[1927]: 2026-01-23T00:06:15.101537Z INFO Daemon Daemon Configure sudoer Jan 23 00:06:15.109383 waagent[1927]: 2026-01-23T00:06:15.109328Z INFO Daemon Daemon Configure sshd Jan 23 00:06:15.117088 waagent[1927]: 2026-01-23T00:06:15.117031Z INFO Daemon Daemon Added a configuration snippet disabling SSH password-based authentication methods. It also configures SSH client probing to keep connections alive. Jan 23 00:06:15.118126 systemd-networkd[1490]: eth0: DHCPv4 address 10.200.20.31/24, gateway 10.200.20.1 acquired from 168.63.129.16 Jan 23 00:06:15.127785 waagent[1927]: 2026-01-23T00:06:15.127723Z INFO Daemon Daemon Deploy ssh public key. Jan 23 00:06:16.222982 waagent[1927]: 2026-01-23T00:06:16.222929Z INFO Daemon Daemon Provisioning complete Jan 23 00:06:16.236616 waagent[1927]: 2026-01-23T00:06:16.236577Z INFO Daemon Daemon RDMA capabilities are not enabled, skipping Jan 23 00:06:16.241504 waagent[1927]: 2026-01-23T00:06:16.241470Z INFO Daemon Daemon End of log to /dev/console. The agent will now check for updates and then will process extensions. Jan 23 00:06:16.248824 waagent[1927]: 2026-01-23T00:06:16.248790Z INFO Daemon Daemon Installed Agent WALinuxAgent-2.12.0.4 is the most current agent Jan 23 00:06:16.351122 waagent[2016]: 2026-01-23T00:06:16.350178Z INFO ExtHandler ExtHandler Azure Linux Agent (Goal State Agent version 2.12.0.4) Jan 23 00:06:16.351122 waagent[2016]: 2026-01-23T00:06:16.350318Z INFO ExtHandler ExtHandler OS: flatcar 4459.2.2 Jan 23 00:06:16.351122 waagent[2016]: 2026-01-23T00:06:16.350356Z INFO ExtHandler ExtHandler Python: 3.11.13 Jan 23 00:06:16.351122 waagent[2016]: 2026-01-23T00:06:16.350390Z INFO ExtHandler ExtHandler CPU Arch: aarch64 Jan 23 00:06:16.401563 waagent[2016]: 2026-01-23T00:06:16.401483Z 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; Jan 23 00:06:16.401725 waagent[2016]: 2026-01-23T00:06:16.401697Z INFO ExtHandler ExtHandler WireServer endpoint 168.63.129.16 read from file Jan 23 00:06:16.401769 waagent[2016]: 2026-01-23T00:06:16.401752Z INFO ExtHandler ExtHandler Wire server endpoint:168.63.129.16 Jan 23 00:06:16.408281 waagent[2016]: 2026-01-23T00:06:16.408228Z INFO ExtHandler Fetched a new incarnation for the WireServer goal state [incarnation 1] Jan 23 00:06:16.413641 waagent[2016]: 2026-01-23T00:06:16.413608Z INFO ExtHandler ExtHandler HostGAPlugin version: 1.0.8.177 Jan 23 00:06:16.414042 waagent[2016]: 2026-01-23T00:06:16.414014Z INFO ExtHandler Jan 23 00:06:16.414112 waagent[2016]: 2026-01-23T00:06:16.414093Z INFO ExtHandler Fetched new vmSettings [HostGAPlugin correlation ID: fc1bde13-f09f-4c21-b6b7-33156f4575cb eTag: 14304891853787439518 source: Fabric] Jan 23 00:06:16.414338 waagent[2016]: 2026-01-23T00:06:16.414313Z INFO ExtHandler The vmSettings originated via Fabric; will ignore them. Jan 23 00:06:16.414751 waagent[2016]: 2026-01-23T00:06:16.414722Z INFO ExtHandler Jan 23 00:06:16.414788 waagent[2016]: 2026-01-23T00:06:16.414771Z INFO ExtHandler Fetching full goal state from the WireServer [incarnation 1] Jan 23 00:06:16.418230 waagent[2016]: 2026-01-23T00:06:16.418203Z INFO ExtHandler ExtHandler Downloading artifacts profile blob Jan 23 00:06:16.472364 waagent[2016]: 2026-01-23T00:06:16.472285Z INFO ExtHandler Downloaded certificate {'thumbprint': 'AD8103BDE902EF685FA3AEC32D5B807A8458C8A9', 'hasPrivateKey': True} Jan 23 00:06:16.472773 waagent[2016]: 2026-01-23T00:06:16.472737Z INFO ExtHandler Fetch goal state completed Jan 23 00:06:16.484649 waagent[2016]: 2026-01-23T00:06:16.484547Z INFO ExtHandler ExtHandler OpenSSL version: OpenSSL 3.4.2 1 Jul 2025 (Library: OpenSSL 3.4.2 1 Jul 2025) Jan 23 00:06:16.488044 waagent[2016]: 2026-01-23T00:06:16.487992Z INFO ExtHandler ExtHandler WALinuxAgent-2.12.0.4 running as process 2016 Jan 23 00:06:16.488168 waagent[2016]: 2026-01-23T00:06:16.488141Z INFO ExtHandler ExtHandler ******** AutoUpdate.Enabled is set to False, not processing the operation ******** Jan 23 00:06:16.488418 waagent[2016]: 2026-01-23T00:06:16.488391Z INFO ExtHandler ExtHandler ******** AutoUpdate.UpdateToLatestVersion is set to False, not processing the operation ******** Jan 23 00:06:16.489543 waagent[2016]: 2026-01-23T00:06:16.489509Z INFO ExtHandler ExtHandler [CGI] Cgroup monitoring is not supported on ['flatcar', '4459.2.2', '', 'Flatcar Container Linux by Kinvolk'] Jan 23 00:06:16.489856 waagent[2016]: 2026-01-23T00:06:16.489827Z 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 Jan 23 00:06:16.489964 waagent[2016]: 2026-01-23T00:06:16.489944Z INFO ExtHandler ExtHandler [CGI] Agent cgroups enabled: False Jan 23 00:06:16.490400 waagent[2016]: 2026-01-23T00:06:16.490372Z INFO ExtHandler ExtHandler Starting setup for Persistent firewall rules Jan 23 00:06:16.547896 waagent[2016]: 2026-01-23T00:06:16.547855Z INFO ExtHandler ExtHandler Firewalld service not running/unavailable, trying to set up waagent-network-setup.service Jan 23 00:06:16.548124 waagent[2016]: 2026-01-23T00:06:16.548099Z INFO ExtHandler ExtHandler Successfully updated the Binary file /var/lib/waagent/waagent-network-setup.py for firewall setup Jan 23 00:06:16.552936 waagent[2016]: 2026-01-23T00:06:16.552890Z INFO ExtHandler ExtHandler Service: waagent-network-setup.service not enabled. Adding it now Jan 23 00:06:16.568602 systemd[1]: Reload requested from client PID 2031 ('systemctl') (unit waagent.service)... Jan 23 00:06:16.568617 systemd[1]: Reloading... Jan 23 00:06:16.645106 zram_generator::config[2072]: No configuration found. Jan 23 00:06:16.795584 systemd[1]: Reloading finished in 226 ms. Jan 23 00:06:16.823043 waagent[2016]: 2026-01-23T00:06:16.822887Z INFO ExtHandler ExtHandler Successfully added and enabled the waagent-network-setup.service Jan 23 00:06:16.823158 waagent[2016]: 2026-01-23T00:06:16.823046Z INFO ExtHandler ExtHandler Persistent firewall rules setup successfully Jan 23 00:06:17.115796 waagent[2016]: 2026-01-23T00:06:17.115658Z INFO ExtHandler ExtHandler DROP rule is not available which implies no firewall rules are set yet. Environment thread will set it up. Jan 23 00:06:17.116003 waagent[2016]: 2026-01-23T00:06:17.115971Z 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] Jan 23 00:06:17.116698 waagent[2016]: 2026-01-23T00:06:17.116657Z INFO ExtHandler ExtHandler Starting env monitor service. Jan 23 00:06:17.116974 waagent[2016]: 2026-01-23T00:06:17.116937Z INFO ExtHandler ExtHandler Start SendTelemetryHandler service. Jan 23 00:06:17.117795 waagent[2016]: 2026-01-23T00:06:17.117175Z INFO MonitorHandler ExtHandler WireServer endpoint 168.63.129.16 read from file Jan 23 00:06:17.117795 waagent[2016]: 2026-01-23T00:06:17.117251Z INFO MonitorHandler ExtHandler Wire server endpoint:168.63.129.16 Jan 23 00:06:17.117795 waagent[2016]: 2026-01-23T00:06:17.117421Z INFO MonitorHandler ExtHandler Monitor.NetworkConfigurationChanges is disabled. Jan 23 00:06:17.117795 waagent[2016]: 2026-01-23T00:06:17.117561Z INFO MonitorHandler ExtHandler Routing table from /proc/net/route: Jan 23 00:06:17.117795 waagent[2016]: Iface Destination Gateway Flags RefCnt Use Metric Mask MTU Window IRTT Jan 23 00:06:17.117795 waagent[2016]: eth0 00000000 0114C80A 0003 0 0 1024 00000000 0 0 0 Jan 23 00:06:17.117795 waagent[2016]: eth0 0014C80A 00000000 0001 0 0 1024 00FFFFFF 0 0 0 Jan 23 00:06:17.117795 waagent[2016]: eth0 0114C80A 00000000 0005 0 0 1024 FFFFFFFF 0 0 0 Jan 23 00:06:17.117795 waagent[2016]: eth0 10813FA8 0114C80A 0007 0 0 1024 FFFFFFFF 0 0 0 Jan 23 00:06:17.117795 waagent[2016]: eth0 FEA9FEA9 0114C80A 0007 0 0 1024 FFFFFFFF 0 0 0 Jan 23 00:06:17.118140 waagent[2016]: 2026-01-23T00:06:17.118097Z INFO SendTelemetryHandler ExtHandler Successfully started the SendTelemetryHandler thread Jan 23 00:06:17.118190 waagent[2016]: 2026-01-23T00:06:17.118151Z INFO ExtHandler ExtHandler Start Extension Telemetry service. Jan 23 00:06:17.118455 waagent[2016]: 2026-01-23T00:06:17.118422Z INFO TelemetryEventsCollector ExtHandler Extension Telemetry pipeline enabled: True Jan 23 00:06:17.118567 waagent[2016]: 2026-01-23T00:06:17.118531Z INFO ExtHandler ExtHandler Goal State Period: 6 sec. This indicates how often the agent checks for new goal states and reports status. Jan 23 00:06:17.119013 waagent[2016]: 2026-01-23T00:06:17.118980Z INFO TelemetryEventsCollector ExtHandler Successfully started the TelemetryEventsCollector thread Jan 23 00:06:17.119193 waagent[2016]: 2026-01-23T00:06:17.119165Z INFO EnvHandler ExtHandler WireServer endpoint 168.63.129.16 read from file Jan 23 00:06:17.120328 waagent[2016]: 2026-01-23T00:06:17.120290Z INFO EnvHandler ExtHandler Wire server endpoint:168.63.129.16 Jan 23 00:06:17.120452 waagent[2016]: 2026-01-23T00:06:17.120421Z INFO EnvHandler ExtHandler Configure routes Jan 23 00:06:17.120496 waagent[2016]: 2026-01-23T00:06:17.120478Z INFO EnvHandler ExtHandler Gateway:None Jan 23 00:06:17.120523 waagent[2016]: 2026-01-23T00:06:17.120509Z INFO EnvHandler ExtHandler Routes:None Jan 23 00:06:17.126595 waagent[2016]: 2026-01-23T00:06:17.126543Z INFO ExtHandler ExtHandler Jan 23 00:06:17.126653 waagent[2016]: 2026-01-23T00:06:17.126623Z INFO ExtHandler ExtHandler ProcessExtensionsGoalState started [incarnation_1 channel: WireServer source: Fabric activity: b82b26cf-7674-4d97-830e-29300ee4a473 correlation 15fded59-6cc6-490b-b4a3-cde777259f17 created: 2026-01-23T00:05:18.859482Z] Jan 23 00:06:17.126939 waagent[2016]: 2026-01-23T00:06:17.126904Z INFO ExtHandler ExtHandler No extension handlers found, not processing anything. Jan 23 00:06:17.127362 waagent[2016]: 2026-01-23T00:06:17.127334Z INFO ExtHandler ExtHandler ProcessExtensionsGoalState completed [incarnation_1 0 ms] Jan 23 00:06:17.153874 waagent[2016]: 2026-01-23T00:06:17.153816Z 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 Jan 23 00:06:17.153874 waagent[2016]: Try `iptables -h' or 'iptables --help' for more information.) Jan 23 00:06:17.154243 waagent[2016]: 2026-01-23T00:06:17.154210Z INFO ExtHandler ExtHandler [HEARTBEAT] Agent WALinuxAgent-2.12.0.4 is running as the goal state agent [DEBUG HeartbeatCounter: 0;HeartbeatId: F9A23045-D4B1-4D61-BEA8-8E4E3FD180C5;DroppedPackets: -1;UpdateGSErrors: 0;AutoUpdate: 0;UpdateMode: SelfUpdate;] Jan 23 00:06:17.186741 waagent[2016]: 2026-01-23T00:06:17.186368Z INFO MonitorHandler ExtHandler Network interfaces: Jan 23 00:06:17.186741 waagent[2016]: Executing ['ip', '-a', '-o', 'link']: Jan 23 00:06:17.186741 waagent[2016]: 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 Jan 23 00:06:17.186741 waagent[2016]: 2: eth0: mtu 1500 qdisc mq state UP mode DEFAULT group default qlen 1000\ link/ether 00:0d:3a:f9:8b:1b brd ff:ff:ff:ff:ff:ff Jan 23 00:06:17.186741 waagent[2016]: 3: enP11635s1: mtu 1500 qdisc mq master eth0 state UP mode DEFAULT group default qlen 1000\ link/ether 00:0d:3a:f9:8b:1b brd ff:ff:ff:ff:ff:ff\ altname enP11635p0s2 Jan 23 00:06:17.186741 waagent[2016]: Executing ['ip', '-4', '-a', '-o', 'address']: Jan 23 00:06:17.186741 waagent[2016]: 1: lo inet 127.0.0.1/8 scope host lo\ valid_lft forever preferred_lft forever Jan 23 00:06:17.186741 waagent[2016]: 2: eth0 inet 10.200.20.31/24 metric 1024 brd 10.200.20.255 scope global eth0\ valid_lft forever preferred_lft forever Jan 23 00:06:17.186741 waagent[2016]: Executing ['ip', '-6', '-a', '-o', 'address']: Jan 23 00:06:17.186741 waagent[2016]: 1: lo inet6 ::1/128 scope host noprefixroute \ valid_lft forever preferred_lft forever Jan 23 00:06:17.186741 waagent[2016]: 2: eth0 inet6 fe80::20d:3aff:fef9:8b1b/64 scope link proto kernel_ll \ valid_lft forever preferred_lft forever Jan 23 00:06:17.220248 waagent[2016]: 2026-01-23T00:06:17.220191Z INFO EnvHandler ExtHandler Created firewall rules for the Azure Fabric: Jan 23 00:06:17.220248 waagent[2016]: Chain INPUT (policy ACCEPT 0 packets, 0 bytes) Jan 23 00:06:17.220248 waagent[2016]: pkts bytes target prot opt in out source destination Jan 23 00:06:17.220248 waagent[2016]: Chain FORWARD (policy ACCEPT 0 packets, 0 bytes) Jan 23 00:06:17.220248 waagent[2016]: pkts bytes target prot opt in out source destination Jan 23 00:06:17.220248 waagent[2016]: Chain OUTPUT (policy ACCEPT 5 packets, 646 bytes) Jan 23 00:06:17.220248 waagent[2016]: pkts bytes target prot opt in out source destination Jan 23 00:06:17.220248 waagent[2016]: 0 0 ACCEPT tcp -- * * 0.0.0.0/0 168.63.129.16 tcp dpt:53 Jan 23 00:06:17.220248 waagent[2016]: 0 0 ACCEPT tcp -- * * 0.0.0.0/0 168.63.129.16 owner UID match 0 Jan 23 00:06:17.220248 waagent[2016]: 0 0 DROP tcp -- * * 0.0.0.0/0 168.63.129.16 ctstate INVALID,NEW Jan 23 00:06:17.223805 waagent[2016]: 2026-01-23T00:06:17.223756Z INFO EnvHandler ExtHandler Current Firewall rules: Jan 23 00:06:17.223805 waagent[2016]: Chain INPUT (policy ACCEPT 0 packets, 0 bytes) Jan 23 00:06:17.223805 waagent[2016]: pkts bytes target prot opt in out source destination Jan 23 00:06:17.223805 waagent[2016]: Chain FORWARD (policy ACCEPT 0 packets, 0 bytes) Jan 23 00:06:17.223805 waagent[2016]: pkts bytes target prot opt in out source destination Jan 23 00:06:17.223805 waagent[2016]: Chain OUTPUT (policy ACCEPT 5 packets, 646 bytes) Jan 23 00:06:17.223805 waagent[2016]: pkts bytes target prot opt in out source destination Jan 23 00:06:17.223805 waagent[2016]: 0 0 ACCEPT tcp -- * * 0.0.0.0/0 168.63.129.16 tcp dpt:53 Jan 23 00:06:17.223805 waagent[2016]: 5 468 ACCEPT tcp -- * * 0.0.0.0/0 168.63.129.16 owner UID match 0 Jan 23 00:06:17.223805 waagent[2016]: 0 0 DROP tcp -- * * 0.0.0.0/0 168.63.129.16 ctstate INVALID,NEW Jan 23 00:06:17.224010 waagent[2016]: 2026-01-23T00:06:17.223985Z INFO EnvHandler ExtHandler Set block dev timeout: sda with timeout: 300 Jan 23 00:06:35.084825 systemd[1]: Created slice system-sshd.slice - Slice /system/sshd. Jan 23 00:06:35.085688 systemd[1]: Started sshd@0-10.200.20.31:22-10.200.16.10:53368.service - OpenSSH per-connection server daemon (10.200.16.10:53368). Jan 23 00:06:35.705096 sshd[2158]: Accepted publickey for core from 10.200.16.10 port 53368 ssh2: RSA SHA256:kRQEAzNVhqU4Fmpx84sKU93gp2nZjfuJ8Tlyw3EYXBc Jan 23 00:06:35.705845 sshd-session[2158]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Jan 23 00:06:35.709281 systemd-logind[1792]: New session 3 of user core. Jan 23 00:06:35.720445 systemd[1]: Started session-3.scope - Session 3 of User core. Jan 23 00:06:36.135295 systemd[1]: Started sshd@1-10.200.20.31:22-10.200.16.10:53372.service - OpenSSH per-connection server daemon (10.200.16.10:53372). Jan 23 00:06:36.142879 chronyd[1772]: Selected source PHC0 Jan 23 00:06:36.595972 sshd[2164]: Accepted publickey for core from 10.200.16.10 port 53372 ssh2: RSA SHA256:kRQEAzNVhqU4Fmpx84sKU93gp2nZjfuJ8Tlyw3EYXBc Jan 23 00:06:36.597047 sshd-session[2164]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Jan 23 00:06:36.600270 systemd-logind[1792]: New session 4 of user core. Jan 23 00:06:36.608381 systemd[1]: Started session-4.scope - Session 4 of User core. Jan 23 00:06:36.930660 sshd[2167]: Connection closed by 10.200.16.10 port 53372 Jan 23 00:06:36.930552 sshd-session[2164]: pam_unix(sshd:session): session closed for user core Jan 23 00:06:36.934425 systemd[1]: sshd@1-10.200.20.31:22-10.200.16.10:53372.service: Deactivated successfully. Jan 23 00:06:36.936393 systemd[1]: session-4.scope: Deactivated successfully. Jan 23 00:06:36.938751 systemd-logind[1792]: Session 4 logged out. Waiting for processes to exit. Jan 23 00:06:36.940528 systemd-logind[1792]: Removed session 4. Jan 23 00:06:37.016019 systemd[1]: Started sshd@2-10.200.20.31:22-10.200.16.10:53378.service - OpenSSH per-connection server daemon (10.200.16.10:53378). Jan 23 00:06:37.468225 sshd[2173]: Accepted publickey for core from 10.200.16.10 port 53378 ssh2: RSA SHA256:kRQEAzNVhqU4Fmpx84sKU93gp2nZjfuJ8Tlyw3EYXBc Jan 23 00:06:37.469374 sshd-session[2173]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Jan 23 00:06:37.472832 systemd-logind[1792]: New session 5 of user core. Jan 23 00:06:37.483225 systemd[1]: Started session-5.scope - Session 5 of User core. Jan 23 00:06:37.796103 sshd[2176]: Connection closed by 10.200.16.10 port 53378 Jan 23 00:06:37.795937 sshd-session[2173]: pam_unix(sshd:session): session closed for user core Jan 23 00:06:37.798847 systemd-logind[1792]: Session 5 logged out. Waiting for processes to exit. Jan 23 00:06:37.799127 systemd[1]: sshd@2-10.200.20.31:22-10.200.16.10:53378.service: Deactivated successfully. Jan 23 00:06:37.800555 systemd[1]: session-5.scope: Deactivated successfully. Jan 23 00:06:37.803637 systemd-logind[1792]: Removed session 5. Jan 23 00:06:37.895597 systemd[1]: Started sshd@3-10.200.20.31:22-10.200.16.10:53384.service - OpenSSH per-connection server daemon (10.200.16.10:53384). Jan 23 00:06:38.396104 sshd[2182]: Accepted publickey for core from 10.200.16.10 port 53384 ssh2: RSA SHA256:kRQEAzNVhqU4Fmpx84sKU93gp2nZjfuJ8Tlyw3EYXBc Jan 23 00:06:38.396848 sshd-session[2182]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Jan 23 00:06:38.401120 systemd-logind[1792]: New session 6 of user core. Jan 23 00:06:38.407245 systemd[1]: Started session-6.scope - Session 6 of User core. Jan 23 00:06:38.749105 sshd[2185]: Connection closed by 10.200.16.10 port 53384 Jan 23 00:06:38.746954 sshd-session[2182]: pam_unix(sshd:session): session closed for user core Jan 23 00:06:38.750540 systemd-logind[1792]: Session 6 logged out. Waiting for processes to exit. Jan 23 00:06:38.751342 systemd[1]: sshd@3-10.200.20.31:22-10.200.16.10:53384.service: Deactivated successfully. Jan 23 00:06:38.752852 systemd[1]: session-6.scope: Deactivated successfully. Jan 23 00:06:38.754275 systemd-logind[1792]: Removed session 6. Jan 23 00:06:38.834803 systemd[1]: Started sshd@4-10.200.20.31:22-10.200.16.10:53396.service - OpenSSH per-connection server daemon (10.200.16.10:53396). Jan 23 00:06:39.326419 sshd[2191]: Accepted publickey for core from 10.200.16.10 port 53396 ssh2: RSA SHA256:kRQEAzNVhqU4Fmpx84sKU93gp2nZjfuJ8Tlyw3EYXBc Jan 23 00:06:39.327527 sshd-session[2191]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Jan 23 00:06:39.331130 systemd-logind[1792]: New session 7 of user core. Jan 23 00:06:39.338443 systemd[1]: Started session-7.scope - Session 7 of User core. Jan 23 00:06:39.746798 sudo[2195]: core : PWD=/home/core ; USER=root ; COMMAND=/usr/sbin/setenforce 1 Jan 23 00:06:39.747018 sudo[2195]: pam_unix(sudo:session): session opened for user root(uid=0) by core(uid=500) Jan 23 00:06:39.773752 sudo[2195]: pam_unix(sudo:session): session closed for user root Jan 23 00:06:39.850977 sshd[2194]: Connection closed by 10.200.16.10 port 53396 Jan 23 00:06:39.851664 sshd-session[2191]: pam_unix(sshd:session): session closed for user core Jan 23 00:06:39.855369 systemd[1]: sshd@4-10.200.20.31:22-10.200.16.10:53396.service: Deactivated successfully. Jan 23 00:06:39.857106 systemd[1]: session-7.scope: Deactivated successfully. Jan 23 00:06:39.857958 systemd-logind[1792]: Session 7 logged out. Waiting for processes to exit. Jan 23 00:06:39.859556 systemd-logind[1792]: Removed session 7. Jan 23 00:06:39.943280 systemd[1]: Started sshd@5-10.200.20.31:22-10.200.16.10:36480.service - OpenSSH per-connection server daemon (10.200.16.10:36480). Jan 23 00:06:40.441646 sshd[2201]: Accepted publickey for core from 10.200.16.10 port 36480 ssh2: RSA SHA256:kRQEAzNVhqU4Fmpx84sKU93gp2nZjfuJ8Tlyw3EYXBc Jan 23 00:06:40.442796 sshd-session[2201]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Jan 23 00:06:40.446361 systemd-logind[1792]: New session 8 of user core. Jan 23 00:06:40.454391 systemd[1]: Started session-8.scope - Session 8 of User core. Jan 23 00:06:40.717240 sudo[2206]: 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 Jan 23 00:06:40.717465 sudo[2206]: pam_unix(sudo:session): session opened for user root(uid=0) by core(uid=500) Jan 23 00:06:40.724029 sudo[2206]: pam_unix(sudo:session): session closed for user root Jan 23 00:06:40.728131 sudo[2205]: core : PWD=/home/core ; USER=root ; COMMAND=/usr/sbin/systemctl restart audit-rules Jan 23 00:06:40.728344 sudo[2205]: pam_unix(sudo:session): session opened for user root(uid=0) by core(uid=500) Jan 23 00:06:40.736952 systemd[1]: Starting audit-rules.service - Load Audit Rules... Jan 23 00:06:40.765679 augenrules[2228]: No rules Jan 23 00:06:40.766928 systemd[1]: audit-rules.service: Deactivated successfully. Jan 23 00:06:40.767173 systemd[1]: Finished audit-rules.service - Load Audit Rules. Jan 23 00:06:40.769267 sudo[2205]: pam_unix(sudo:session): session closed for user root Jan 23 00:06:40.847336 sshd[2204]: Connection closed by 10.200.16.10 port 36480 Jan 23 00:06:40.847894 sshd-session[2201]: pam_unix(sshd:session): session closed for user core Jan 23 00:06:40.851682 systemd[1]: sshd@5-10.200.20.31:22-10.200.16.10:36480.service: Deactivated successfully. Jan 23 00:06:40.853475 systemd[1]: session-8.scope: Deactivated successfully. Jan 23 00:06:40.855763 systemd-logind[1792]: Session 8 logged out. Waiting for processes to exit. Jan 23 00:06:40.857667 systemd-logind[1792]: Removed session 8. Jan 23 00:06:40.940835 systemd[1]: Started sshd@6-10.200.20.31:22-10.200.16.10:36486.service - OpenSSH per-connection server daemon (10.200.16.10:36486). Jan 23 00:06:41.433552 sshd[2237]: Accepted publickey for core from 10.200.16.10 port 36486 ssh2: RSA SHA256:kRQEAzNVhqU4Fmpx84sKU93gp2nZjfuJ8Tlyw3EYXBc Jan 23 00:06:41.434674 sshd-session[2237]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Jan 23 00:06:41.438301 systemd-logind[1792]: New session 9 of user core. Jan 23 00:06:41.448453 systemd[1]: Started session-9.scope - Session 9 of User core. Jan 23 00:06:41.746311 systemd[1]: Starting docker.service - Docker Application Container Engine... Jan 23 00:06:41.757436 (dockerd)[2242]: 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 Jan 23 00:06:42.851011 dockerd[2242]: time="2026-01-23T00:06:42.850953275Z" level=info msg="Starting up" Jan 23 00:06:42.852261 dockerd[2242]: time="2026-01-23T00:06:42.852231835Z" level=info msg="OTEL tracing is not configured, using no-op tracer provider" Jan 23 00:06:42.862194 dockerd[2242]: time="2026-01-23T00:06:42.862136379Z" level=info msg="Creating a containerd client" address=/var/run/docker/libcontainerd/docker-containerd.sock timeout=1m0s Jan 23 00:06:42.958677 dockerd[2242]: time="2026-01-23T00:06:42.958492947Z" level=info msg="Loading containers: start." Jan 23 00:06:43.010105 kernel: Initializing XFRM netlink socket Jan 23 00:06:43.359835 systemd-networkd[1490]: docker0: Link UP Jan 23 00:06:43.373915 dockerd[2242]: time="2026-01-23T00:06:43.373807115Z" level=info msg="Loading containers: done." Jan 23 00:06:43.384139 systemd[1]: var-lib-docker-overlay2-opaque\x2dbug\x2dcheck4053775070-merged.mount: Deactivated successfully. Jan 23 00:06:43.397657 dockerd[2242]: time="2026-01-23T00:06:43.397305891Z" 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 Jan 23 00:06:43.397657 dockerd[2242]: time="2026-01-23T00:06:43.397401347Z" level=info msg="Docker daemon" commit=6430e49a55babd9b8f4d08e70ecb2b68900770fe containerd-snapshotter=false storage-driver=overlay2 version=28.0.4 Jan 23 00:06:43.397657 dockerd[2242]: time="2026-01-23T00:06:43.397499019Z" level=info msg="Initializing buildkit" Jan 23 00:06:43.441516 dockerd[2242]: time="2026-01-23T00:06:43.441468171Z" level=info msg="Completed buildkit initialization" Jan 23 00:06:43.447107 dockerd[2242]: time="2026-01-23T00:06:43.447062115Z" level=info msg="Daemon has completed initialization" Jan 23 00:06:43.447347 dockerd[2242]: time="2026-01-23T00:06:43.447259715Z" level=info msg="API listen on /run/docker.sock" Jan 23 00:06:43.448214 systemd[1]: Started docker.service - Docker Application Container Engine. Jan 23 00:06:43.531456 sshd[2240]: Connection closed by 10.200.16.10 port 36486 Jan 23 00:06:43.531328 sshd-session[2237]: pam_unix(sshd:session): session closed for user core Jan 23 00:06:43.535806 systemd-logind[1792]: Session 9 logged out. Waiting for processes to exit. Jan 23 00:06:43.535872 systemd[1]: sshd@6-10.200.20.31:22-10.200.16.10:36486.service: Deactivated successfully. Jan 23 00:06:43.537357 systemd[1]: session-9.scope: Deactivated successfully. Jan 23 00:06:43.538712 systemd-logind[1792]: Removed session 9. Jan 23 00:06:43.617756 systemd[1]: Started sshd@7-10.200.20.31:22-10.200.16.10:36502.service - OpenSSH per-connection server daemon (10.200.16.10:36502). Jan 23 00:06:44.109577 sshd[2446]: Accepted publickey for core from 10.200.16.10 port 36502 ssh2: RSA SHA256:kRQEAzNVhqU4Fmpx84sKU93gp2nZjfuJ8Tlyw3EYXBc Jan 23 00:06:44.110681 sshd-session[2446]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Jan 23 00:06:44.114057 systemd-logind[1792]: New session 10 of user core. Jan 23 00:06:44.121404 systemd[1]: Started session-10.scope - Session 10 of User core. Jan 23 00:06:45.949160 systemd[1]: var-lib-docker-overlay2-23c75a0d4b2fb9c9eb91aee17af5d8e250f0e3bd932a22693b505f82c1f94ae1-merged.mount: Deactivated successfully. Jan 23 00:06:46.010091 containerd[1818]: time="2026-01-23T00:06:46.009235699Z" level=info msg="connecting to shim b98909004952f8fde1e1c000618c60511ac5680b76e2013a593cf683347e0322" address="unix:///run/containerd/s/04ef698942e4d31be9594530189fc79d070cd48e698325b71abe39cdc2276755" namespace=moby protocol=ttrpc version=3 Jan 23 00:06:46.030217 systemd[1]: Started docker-b98909004952f8fde1e1c000618c60511ac5680b76e2013a593cf683347e0322.scope - libcontainer container b98909004952f8fde1e1c000618c60511ac5680b76e2013a593cf683347e0322. Jan 23 00:06:46.082421 kernel: docker0: port 1(veth97f457a) entered blocking state Jan 23 00:06:46.082522 kernel: docker0: port 1(veth97f457a) entered disabled state Jan 23 00:06:46.085231 kernel: veth97f457a: entered allmulticast mode Jan 23 00:06:46.088049 kernel: veth97f457a: entered promiscuous mode Jan 23 00:06:46.088983 systemd-networkd[1490]: veth97f457a: Link UP Jan 23 00:06:46.119557 kernel: eth0: renamed from vethd0874db Jan 23 00:06:46.119659 kernel: docker0: port 1(veth97f457a) entered blocking state Jan 23 00:06:46.119672 kernel: docker0: port 1(veth97f457a) entered forwarding state Jan 23 00:06:46.122916 systemd-networkd[1490]: veth97f457a: Gained carrier Jan 23 00:06:46.123192 systemd-networkd[1490]: docker0: Gained carrier Jan 23 00:06:46.254390 sshd[2449]: Connection closed by 10.200.16.10 port 36502 Jan 23 00:06:46.255281 sshd-session[2446]: pam_unix(sshd:session): session closed for user core Jan 23 00:06:46.258627 systemd-logind[1792]: Session 10 logged out. Waiting for processes to exit. Jan 23 00:06:46.259060 systemd[1]: sshd@7-10.200.20.31:22-10.200.16.10:36502.service: Deactivated successfully. Jan 23 00:06:46.260490 systemd[1]: session-10.scope: Deactivated successfully. Jan 23 00:06:46.261872 systemd-logind[1792]: Removed session 10. Jan 23 00:06:46.344737 systemd[1]: Started sshd@8-10.200.20.31:22-10.200.16.10:36518.service - OpenSSH per-connection server daemon (10.200.16.10:36518). Jan 23 00:06:46.841117 sshd[2520]: Accepted publickey for core from 10.200.16.10 port 36518 ssh2: RSA SHA256:kRQEAzNVhqU4Fmpx84sKU93gp2nZjfuJ8Tlyw3EYXBc Jan 23 00:06:46.841869 sshd-session[2520]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Jan 23 00:06:46.845735 systemd-logind[1792]: New session 11 of user core. Jan 23 00:06:46.854233 systemd[1]: Started session-11.scope - Session 11 of User core. Jan 23 00:06:47.194214 sshd[2523]: Connection closed by 10.200.16.10 port 36518 Jan 23 00:06:47.194744 sshd-session[2520]: pam_unix(sshd:session): session closed for user core Jan 23 00:06:47.197886 systemd[1]: sshd@8-10.200.20.31:22-10.200.16.10:36518.service: Deactivated successfully. Jan 23 00:06:47.199255 systemd[1]: session-11.scope: Deactivated successfully. Jan 23 00:06:47.199848 systemd-logind[1792]: Session 11 logged out. Waiting for processes to exit. Jan 23 00:06:47.200848 systemd-logind[1792]: Removed session 11. Jan 23 00:06:47.282716 systemd[1]: Started sshd@9-10.200.20.31:22-10.200.16.10:36532.service - OpenSSH per-connection server daemon (10.200.16.10:36532). Jan 23 00:06:47.592270 systemd-networkd[1490]: docker0: Gained IPv6LL Jan 23 00:06:47.781341 sshd[2529]: Accepted publickey for core from 10.200.16.10 port 36532 ssh2: RSA SHA256:kRQEAzNVhqU4Fmpx84sKU93gp2nZjfuJ8Tlyw3EYXBc Jan 23 00:06:47.782449 sshd-session[2529]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Jan 23 00:06:47.785972 systemd-logind[1792]: New session 12 of user core. Jan 23 00:06:47.795248 systemd[1]: Started session-12.scope - Session 12 of User core. Jan 23 00:06:47.912431 systemd-networkd[1490]: veth97f457a: Gained IPv6LL Jan 23 00:06:48.073787 sudo[2533]: core : PWD=/home/core ; USER=root ; COMMAND=/usr/sbin/kill -SIGTERM 1818 Jan 23 00:06:48.074462 sudo[2533]: pam_unix(sudo:session): session opened for user root(uid=0) by core(uid=500) Jan 23 00:06:48.078811 containerd[1818]: time="2026-01-23T00:06:48.077960019Z" level=info msg="Stop CRI service" Jan 23 00:06:48.079032 dockerd[2242]: time="2026-01-23T00:06:48.078380017Z" level=error msg="Failed to get event" error="rpc error: code = Unavailable desc = error reading from server: EOF" module=libcontainerd namespace=plugins.moby Jan 23 00:06:48.079032 dockerd[2242]: time="2026-01-23T00:06:48.078410866Z" level=info msg="Waiting for containerd to be ready to restart event processing" module=libcontainerd namespace=plugins.moby Jan 23 00:06:48.079032 dockerd[2242]: time="2026-01-23T00:06:48.078617565Z" level=error msg="Failed to get event" error="rpc error: code = Unavailable desc = error reading from server: EOF" module=libcontainerd namespace=moby Jan 23 00:06:48.079032 dockerd[2242]: time="2026-01-23T00:06:48.078627941Z" level=info msg="Waiting for containerd to be ready to restart event processing" module=libcontainerd namespace=moby Jan 23 00:06:48.078175 sudo[2533]: pam_unix(sudo:session): session closed for user root Jan 23 00:06:48.082152 systemd[1]: containerd.service: Deactivated successfully. Jan 23 00:06:48.082273 systemd[1]: containerd.service: Unit process 2472 (containerd-shim) remains running after unit stopped. Jan 23 00:06:48.082490 systemd[1]: containerd.service: Consumed 203ms CPU time, 121.7M memory peak. Jan 23 00:06:48.156667 sshd[2532]: Connection closed by 10.200.16.10 port 36532 Jan 23 00:06:48.157232 sshd-session[2529]: pam_unix(sshd:session): session closed for user core Jan 23 00:06:48.161210 systemd[1]: sshd@9-10.200.20.31:22-10.200.16.10:36532.service: Deactivated successfully. Jan 23 00:06:48.163012 systemd[1]: session-12.scope: Deactivated successfully. Jan 23 00:06:48.164285 systemd-logind[1792]: Session 12 logged out. Waiting for processes to exit. Jan 23 00:06:48.165787 systemd-logind[1792]: Removed session 12. Jan 23 00:06:48.247589 systemd[1]: Started sshd@10-10.200.20.31:22-10.200.16.10:36546.service - OpenSSH per-connection server daemon (10.200.16.10:36546). Jan 23 00:06:48.739112 sshd[2540]: Accepted publickey for core from 10.200.16.10 port 36546 ssh2: RSA SHA256:kRQEAzNVhqU4Fmpx84sKU93gp2nZjfuJ8Tlyw3EYXBc Jan 23 00:06:48.739962 sshd-session[2540]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Jan 23 00:06:48.743618 systemd-logind[1792]: New session 13 of user core. Jan 23 00:06:48.751339 systemd[1]: Started session-13.scope - Session 13 of User core. Jan 23 00:06:49.090787 sshd[2543]: Connection closed by 10.200.16.10 port 36546 Jan 23 00:06:49.090699 sshd-session[2540]: pam_unix(sshd:session): session closed for user core Jan 23 00:06:49.093456 systemd[1]: sshd@10-10.200.20.31:22-10.200.16.10:36546.service: Deactivated successfully. Jan 23 00:06:49.094756 systemd[1]: session-13.scope: Deactivated successfully. Jan 23 00:06:49.096378 systemd-logind[1792]: Session 13 logged out. Waiting for processes to exit. Jan 23 00:06:49.097071 systemd-logind[1792]: Removed session 13. Jan 23 00:06:53.261897 systemd[1]: containerd.service: Scheduled restart job, restart counter is at 1. Jan 23 00:06:53.262214 systemd[1]: Stopping docker.service - Docker Application Container Engine... Jan 23 00:06:53.262938 dockerd[2242]: time="2026-01-23T00:06:53.262639530Z" level=info msg="Processing signal 'terminated'" Jan 23 00:06:55.187817 systemd[1]: Started sshd@11-10.200.20.31:22-10.200.16.10:40812.service - OpenSSH per-connection server daemon (10.200.16.10:40812). Jan 23 00:06:55.678800 sshd[2549]: Accepted publickey for core from 10.200.16.10 port 40812 ssh2: RSA SHA256:kRQEAzNVhqU4Fmpx84sKU93gp2nZjfuJ8Tlyw3EYXBc Jan 23 00:06:55.680029 sshd-session[2549]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Jan 23 00:06:55.683652 systemd-logind[1792]: New session 14 of user core. Jan 23 00:06:55.694443 systemd[1]: Started session-14.scope - Session 14 of User core. Jan 23 00:06:55.838193 kernel: hv_balloon: Max. dynamic memory size: 4096 MB Jan 23 00:06:56.029823 sshd[2552]: Connection closed by 10.200.16.10 port 40812 Jan 23 00:06:56.029737 sshd-session[2549]: pam_unix(sshd:session): session closed for user core Jan 23 00:06:56.033691 systemd[1]: sshd@11-10.200.20.31:22-10.200.16.10:40812.service: Deactivated successfully. Jan 23 00:06:56.035693 systemd[1]: session-14.scope: Deactivated successfully. Jan 23 00:06:56.036656 systemd-logind[1792]: Session 14 logged out. Waiting for processes to exit. Jan 23 00:06:56.038622 systemd-logind[1792]: Removed session 14. Jan 23 00:06:57.834093 update_engine[1795]: I20260123 00:06:57.834005 1795 update_attempter.cc:509] Updating boot flags... Jan 23 00:07:02.119786 systemd[1]: Started sshd@12-10.200.20.31:22-10.200.16.10:52336.service - OpenSSH per-connection server daemon (10.200.16.10:52336). Jan 23 00:07:02.623636 sshd[2622]: Accepted publickey for core from 10.200.16.10 port 52336 ssh2: RSA SHA256:kRQEAzNVhqU4Fmpx84sKU93gp2nZjfuJ8Tlyw3EYXBc Jan 23 00:07:02.624735 sshd-session[2622]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Jan 23 00:07:02.628145 systemd-logind[1792]: New session 15 of user core. Jan 23 00:07:02.639453 systemd[1]: Started session-15.scope - Session 15 of User core. Jan 23 00:07:02.978381 sshd[2625]: Connection closed by 10.200.16.10 port 52336 Jan 23 00:07:02.979027 sshd-session[2622]: pam_unix(sshd:session): session closed for user core Jan 23 00:07:02.982326 systemd[1]: sshd@12-10.200.20.31:22-10.200.16.10:52336.service: Deactivated successfully. Jan 23 00:07:02.983924 systemd[1]: session-15.scope: Deactivated successfully. Jan 23 00:07:02.984602 systemd-logind[1792]: Session 15 logged out. Waiting for processes to exit. Jan 23 00:07:02.987886 systemd-logind[1792]: Removed session 15. Jan 23 00:07:08.263113 dockerd[2242]: time="2026-01-23T00:07:08.263057882Z" level=error msg="Force shutdown daemon" Jan 23 00:07:08.263600 dockerd[2242]: time="2026-01-23T00:07:08.263545530Z" level=info msg="Daemon shutdown complete" Jan 23 00:07:08.266147 systemd[1]: docker.service: Deactivated successfully. Jan 23 00:07:08.266643 systemd[1]: Stopped docker.service - Docker Application Container Engine. Jan 23 00:07:08.268158 systemd[1]: docker.service: Consumed 521ms CPU time, 120.8M memory peak. Jan 23 00:07:08.268544 systemd[1]: docker.socket: Deactivated successfully. Jan 23 00:07:08.269261 systemd[1]: Closed docker.socket - Docker Socket for the API. Jan 23 00:07:08.269354 systemd[1]: Stopping docker.socket - Docker Socket for the API... Jan 23 00:07:08.270674 systemd[1]: Starting docker.socket - Docker Socket for the API... Jan 23 00:07:08.270829 systemd[1]: containerd.service: Found left-over process 2472 (containerd-shim) in control group while starting unit. Ignoring. Jan 23 00:07:08.270831 systemd[1]: containerd.service: This usually indicates unclean termination of a previous run, or service implementation deficiencies. Jan 23 00:07:08.278290 systemd[1]: Starting containerd.service - containerd container runtime... Jan 23 00:07:08.278522 systemd[1]: Listening on docker.socket - Docker Socket for the API. Jan 23 00:07:08.288471 systemd[1]: containerd.service: Found left-over process 2472 (containerd-shim) in control group while starting unit. Ignoring. Jan 23 00:07:08.288479 systemd[1]: containerd.service: This usually indicates unclean termination of a previous run, or service implementation deficiencies. Jan 23 00:07:08.292147 (ntainerd)[2636]: containerd.service: Referenced but unset environment variable evaluates to an empty string: TORCX_IMAGEDIR, TORCX_UNPACKDIR Jan 23 00:07:08.304368 containerd[2636]: time="2026-01-23T00:07:08Z" 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 Jan 23 00:07:08.304979 containerd[2636]: time="2026-01-23T00:07:08.304945714Z" level=info msg="starting containerd" revision=4ac6c20c7bbf8177f29e46bbdc658fec02ffb8ad version=v2.0.7 Jan 23 00:07:08.311479 containerd[2636]: time="2026-01-23T00:07:08.311437933Z" level=warning msg="Configuration migrated from version 2, use `containerd config migrate` to avoid migration" t="7.92µs" Jan 23 00:07:08.311479 containerd[2636]: time="2026-01-23T00:07:08.311474022Z" level=info msg="loading plugin" id=io.containerd.image-verifier.v1.bindir type=io.containerd.image-verifier.v1 Jan 23 00:07:08.311586 containerd[2636]: time="2026-01-23T00:07:08.311490742Z" level=info msg="loading plugin" id=io.containerd.internal.v1.opt type=io.containerd.internal.v1 Jan 23 00:07:08.311586 containerd[2636]: time="2026-01-23T00:07:08.311521231Z" level=info msg="loading plugin" id=io.containerd.warning.v1.deprecations type=io.containerd.warning.v1 Jan 23 00:07:08.311586 containerd[2636]: time="2026-01-23T00:07:08.311530007Z" level=info msg="loading plugin" id=io.containerd.content.v1.content type=io.containerd.content.v1 Jan 23 00:07:08.311746 containerd[2636]: time="2026-01-23T00:07:08.311725474Z" level=info msg="loading plugin" id=io.containerd.snapshotter.v1.blockfile type=io.containerd.snapshotter.v1 Jan 23 00:07:08.311763 containerd[2636]: time="2026-01-23T00:07:08.311750635Z" level=info msg="skip loading plugin" error="no scratch file generator: skip plugin" id=io.containerd.snapshotter.v1.blockfile type=io.containerd.snapshotter.v1 Jan 23 00:07:08.311763 containerd[2636]: time="2026-01-23T00:07:08.311758243Z" level=info msg="loading plugin" id=io.containerd.snapshotter.v1.btrfs type=io.containerd.snapshotter.v1 Jan 23 00:07:08.312017 containerd[2636]: time="2026-01-23T00:07:08.311996439Z" 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 Jan 23 00:07:08.312017 containerd[2636]: time="2026-01-23T00:07:08.312014303Z" level=info msg="loading plugin" id=io.containerd.snapshotter.v1.devmapper type=io.containerd.snapshotter.v1 Jan 23 00:07:08.312053 containerd[2636]: time="2026-01-23T00:07:08.312022823Z" level=info msg="skip loading plugin" error="devmapper not configured: skip plugin" id=io.containerd.snapshotter.v1.devmapper type=io.containerd.snapshotter.v1 Jan 23 00:07:08.312053 containerd[2636]: time="2026-01-23T00:07:08.312029184Z" level=info msg="loading plugin" id=io.containerd.snapshotter.v1.native type=io.containerd.snapshotter.v1 Jan 23 00:07:08.312053 containerd[2636]: time="2026-01-23T00:07:08.312044728Z" level=info msg="loading plugin" id=io.containerd.snapshotter.v1.overlayfs type=io.containerd.snapshotter.v1 Jan 23 00:07:08.312147 containerd[2636]: time="2026-01-23T00:07:08.312131961Z" level=info msg="loading plugin" id=io.containerd.snapshotter.v1.zfs type=io.containerd.snapshotter.v1 Jan 23 00:07:08.312163 containerd[2636]: time="2026-01-23T00:07:08.312152330Z" 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 Jan 23 00:07:08.312163 containerd[2636]: time="2026-01-23T00:07:08.312158698Z" level=info msg="loading plugin" id=io.containerd.event.v1.exchange type=io.containerd.event.v1 Jan 23 00:07:08.312195 containerd[2636]: time="2026-01-23T00:07:08.312186418Z" level=info msg="loading plugin" id=io.containerd.monitor.task.v1.cgroups type=io.containerd.monitor.task.v1 Jan 23 00:07:08.312369 containerd[2636]: time="2026-01-23T00:07:08.312354445Z" level=info msg="loading plugin" id=io.containerd.metadata.v1.bolt type=io.containerd.metadata.v1 Jan 23 00:07:08.312401 containerd[2636]: time="2026-01-23T00:07:08.312376686Z" level=info msg="metadata content store policy set" policy=shared Jan 23 00:07:08.312491 containerd[2636]: time="2026-01-23T00:07:08.312474167Z" level=info msg="loading plugin" id=io.containerd.gc.v1.scheduler type=io.containerd.gc.v1 Jan 23 00:07:08.312520 containerd[2636]: time="2026-01-23T00:07:08.312498480Z" level=info msg="loading plugin" id=io.containerd.differ.v1.walking type=io.containerd.differ.v1 Jan 23 00:07:08.312520 containerd[2636]: time="2026-01-23T00:07:08.312506904Z" level=info msg="loading plugin" id=io.containerd.lease.v1.manager type=io.containerd.lease.v1 Jan 23 00:07:08.312520 containerd[2636]: time="2026-01-23T00:07:08.312513928Z" level=info msg="loading plugin" id=io.containerd.service.v1.containers-service type=io.containerd.service.v1 Jan 23 00:07:08.312564 containerd[2636]: time="2026-01-23T00:07:08.312521304Z" level=info msg="loading plugin" id=io.containerd.service.v1.content-service type=io.containerd.service.v1 Jan 23 00:07:08.312564 containerd[2636]: time="2026-01-23T00:07:08.312528096Z" level=info msg="loading plugin" id=io.containerd.service.v1.diff-service type=io.containerd.service.v1 Jan 23 00:07:08.312564 containerd[2636]: time="2026-01-23T00:07:08.312536369Z" level=info msg="loading plugin" id=io.containerd.service.v1.images-service type=io.containerd.service.v1 Jan 23 00:07:08.312564 containerd[2636]: time="2026-01-23T00:07:08.312544433Z" level=info msg="loading plugin" id=io.containerd.service.v1.introspection-service type=io.containerd.service.v1 Jan 23 00:07:08.312564 containerd[2636]: time="2026-01-23T00:07:08.312550817Z" level=info msg="loading plugin" id=io.containerd.service.v1.namespaces-service type=io.containerd.service.v1 Jan 23 00:07:08.312564 containerd[2636]: time="2026-01-23T00:07:08.312556465Z" level=info msg="loading plugin" id=io.containerd.service.v1.snapshots-service type=io.containerd.service.v1 Jan 23 00:07:08.312564 containerd[2636]: time="2026-01-23T00:07:08.312561897Z" level=info msg="loading plugin" id=io.containerd.shim.v1.manager type=io.containerd.shim.v1 Jan 23 00:07:08.312653 containerd[2636]: time="2026-01-23T00:07:08.312570561Z" level=info msg="loading plugin" id=io.containerd.runtime.v2.task type=io.containerd.runtime.v2 Jan 23 00:07:08.312762 containerd[2636]: time="2026-01-23T00:07:08.312740252Z" level=info msg="connecting to shim b98909004952f8fde1e1c000618c60511ac5680b76e2013a593cf683347e0322" address="unix:///run/containerd/s/04ef698942e4d31be9594530189fc79d070cd48e698325b71abe39cdc2276755" namespace=moby protocol=ttrpc version=3 Jan 23 00:07:08.318696 containerd[2636]: time="2026-01-23T00:07:08.318658389Z" level=info msg="loading plugin" id=io.containerd.service.v1.tasks-service type=io.containerd.service.v1 Jan 23 00:07:08.318696 containerd[2636]: time="2026-01-23T00:07:08.318703494Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.containers type=io.containerd.grpc.v1 Jan 23 00:07:08.318793 containerd[2636]: time="2026-01-23T00:07:08.318715262Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.content type=io.containerd.grpc.v1 Jan 23 00:07:08.318793 containerd[2636]: time="2026-01-23T00:07:08.318724983Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.diff type=io.containerd.grpc.v1 Jan 23 00:07:08.318793 containerd[2636]: time="2026-01-23T00:07:08.318732543Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.events type=io.containerd.grpc.v1 Jan 23 00:07:08.318793 containerd[2636]: time="2026-01-23T00:07:08.318740303Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.images type=io.containerd.grpc.v1 Jan 23 00:07:08.318793 containerd[2636]: time="2026-01-23T00:07:08.318747455Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.introspection type=io.containerd.grpc.v1 Jan 23 00:07:08.318793 containerd[2636]: time="2026-01-23T00:07:08.318753903Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.leases type=io.containerd.grpc.v1 Jan 23 00:07:08.318793 containerd[2636]: time="2026-01-23T00:07:08.318761127Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.namespaces type=io.containerd.grpc.v1 Jan 23 00:07:08.318793 containerd[2636]: time="2026-01-23T00:07:08.318769159Z" level=info msg="loading plugin" id=io.containerd.sandbox.store.v1.local type=io.containerd.sandbox.store.v1 Jan 23 00:07:08.318793 containerd[2636]: time="2026-01-23T00:07:08.318775912Z" level=info msg="loading plugin" id=io.containerd.cri.v1.images type=io.containerd.cri.v1 Jan 23 00:07:08.318960 containerd[2636]: time="2026-01-23T00:07:08.318816008Z" level=info msg="Get image filesystem path \"/var/lib/containerd/io.containerd.snapshotter.v1.overlayfs\" for snapshotter \"overlayfs\"" Jan 23 00:07:08.318960 containerd[2636]: time="2026-01-23T00:07:08.318829424Z" level=info msg="Start snapshots syncer" Jan 23 00:07:08.318960 containerd[2636]: time="2026-01-23T00:07:08.318845689Z" level=info msg="loading plugin" id=io.containerd.cri.v1.runtime type=io.containerd.cri.v1 Jan 23 00:07:08.319044 containerd[2636]: time="2026-01-23T00:07:08.319012300Z" 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\"}" Jan 23 00:07:08.319172 containerd[2636]: time="2026-01-23T00:07:08.319057365Z" level=info msg="loading plugin" id=io.containerd.podsandbox.controller.v1.podsandbox type=io.containerd.podsandbox.controller.v1 Jan 23 00:07:08.319172 containerd[2636]: time="2026-01-23T00:07:08.319109653Z" level=info msg="loading plugin" id=io.containerd.sandbox.controller.v1.shim type=io.containerd.sandbox.controller.v1 Jan 23 00:07:08.319172 containerd[2636]: time="2026-01-23T00:07:08.319155046Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.sandbox-controllers type=io.containerd.grpc.v1 Jan 23 00:07:08.319172 containerd[2636]: time="2026-01-23T00:07:08.319167822Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.sandboxes type=io.containerd.grpc.v1 Jan 23 00:07:08.319248 containerd[2636]: time="2026-01-23T00:07:08.319174767Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.snapshots type=io.containerd.grpc.v1 Jan 23 00:07:08.319248 containerd[2636]: time="2026-01-23T00:07:08.319189823Z" level=info msg="loading plugin" id=io.containerd.streaming.v1.manager type=io.containerd.streaming.v1 Jan 23 00:07:08.319248 containerd[2636]: time="2026-01-23T00:07:08.319202255Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.streaming type=io.containerd.grpc.v1 Jan 23 00:07:08.319248 containerd[2636]: time="2026-01-23T00:07:08.319212511Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.tasks type=io.containerd.grpc.v1 Jan 23 00:07:08.319248 containerd[2636]: time="2026-01-23T00:07:08.319220807Z" level=info msg="loading plugin" id=io.containerd.transfer.v1.local type=io.containerd.transfer.v1 Jan 23 00:07:08.319248 containerd[2636]: time="2026-01-23T00:07:08.319238904Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.transfer type=io.containerd.grpc.v1 Jan 23 00:07:08.319358 containerd[2636]: time="2026-01-23T00:07:08.319250120Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.version type=io.containerd.grpc.v1 Jan 23 00:07:08.319358 containerd[2636]: time="2026-01-23T00:07:08.319257760Z" level=info msg="loading plugin" id=io.containerd.monitor.container.v1.restart type=io.containerd.monitor.container.v1 Jan 23 00:07:08.319358 containerd[2636]: time="2026-01-23T00:07:08.319279744Z" level=info msg="loading plugin" id=io.containerd.tracing.processor.v1.otlp type=io.containerd.tracing.processor.v1 Jan 23 00:07:08.319358 containerd[2636]: time="2026-01-23T00:07:08.319288393Z" 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 Jan 23 00:07:08.319358 containerd[2636]: time="2026-01-23T00:07:08.319293497Z" level=info msg="loading plugin" id=io.containerd.internal.v1.tracing type=io.containerd.internal.v1 Jan 23 00:07:08.319358 containerd[2636]: time="2026-01-23T00:07:08.319299105Z" level=info msg="skip loading plugin" error="skip plugin: tracing endpoint not configured" id=io.containerd.internal.v1.tracing type=io.containerd.internal.v1 Jan 23 00:07:08.319358 containerd[2636]: time="2026-01-23T00:07:08.319303673Z" level=info msg="loading plugin" id=io.containerd.ttrpc.v1.otelttrpc type=io.containerd.ttrpc.v1 Jan 23 00:07:08.319358 containerd[2636]: time="2026-01-23T00:07:08.319309817Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.healthcheck type=io.containerd.grpc.v1 Jan 23 00:07:08.319358 containerd[2636]: time="2026-01-23T00:07:08.319316561Z" level=info msg="loading plugin" id=io.containerd.nri.v1.nri type=io.containerd.nri.v1 Jan 23 00:07:08.319358 containerd[2636]: time="2026-01-23T00:07:08.319328625Z" level=info msg="runtime interface created" Jan 23 00:07:08.319358 containerd[2636]: time="2026-01-23T00:07:08.319331777Z" level=info msg="created NRI interface" Jan 23 00:07:08.319358 containerd[2636]: time="2026-01-23T00:07:08.319336561Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.cri type=io.containerd.grpc.v1 Jan 23 00:07:08.319358 containerd[2636]: time="2026-01-23T00:07:08.319344554Z" level=info msg="Connect containerd service" Jan 23 00:07:08.319358 containerd[2636]: time="2026-01-23T00:07:08.319357738Z" level=info msg="using experimental NRI integration - disable nri plugin to prevent this" Jan 23 00:07:08.319787 containerd[2636]: time="2026-01-23T00:07:08.319761057Z" 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" Jan 23 00:07:08.327879 containerd[2636]: time="2026-01-23T00:07:08.327503155Z" level=info msg="Start subscribing containerd event" Jan 23 00:07:08.327879 containerd[2636]: time="2026-01-23T00:07:08.327562316Z" level=info msg="Start recovering state" Jan 23 00:07:08.327879 containerd[2636]: time="2026-01-23T00:07:08.327625397Z" level=info msg="Start event monitor" Jan 23 00:07:08.327879 containerd[2636]: time="2026-01-23T00:07:08.327633997Z" level=info msg="Start cni network conf syncer for default" Jan 23 00:07:08.327879 containerd[2636]: time="2026-01-23T00:07:08.327632749Z" level=info msg=serving... address=/run/containerd/containerd.sock.ttrpc Jan 23 00:07:08.327879 containerd[2636]: time="2026-01-23T00:07:08.327641829Z" level=info msg="Start streaming server" Jan 23 00:07:08.327879 containerd[2636]: time="2026-01-23T00:07:08.327681542Z" level=info msg="Registered namespace \"k8s.io\" with NRI" Jan 23 00:07:08.327879 containerd[2636]: time="2026-01-23T00:07:08.327686390Z" level=info msg="runtime interface starting up..." Jan 23 00:07:08.327879 containerd[2636]: time="2026-01-23T00:07:08.327690334Z" level=info msg="starting plugins..." Jan 23 00:07:08.327879 containerd[2636]: time="2026-01-23T00:07:08.327697470Z" level=info msg="Synchronizing NRI (plugin) with current runtime state" Jan 23 00:07:08.327879 containerd[2636]: time="2026-01-23T00:07:08.327675470Z" level=info msg=serving... address=/run/containerd/containerd.sock Jan 23 00:07:08.327879 containerd[2636]: time="2026-01-23T00:07:08.327817720Z" level=info msg="containerd successfully booted in 0.023701s" Jan 23 00:07:08.328229 systemd[1]: Started containerd.service - containerd container runtime. Jan 23 00:07:08.331302 systemd[1]: Starting docker.service - Docker Application Container Engine... Jan 23 00:07:08.345510 (dockerd)[2660]: 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 Jan 23 00:07:08.368094 dockerd[2660]: time="2026-01-23T00:07:08.367934241Z" level=info msg="Starting up" Jan 23 00:07:08.369843 dockerd[2660]: time="2026-01-23T00:07:08.369657320Z" level=info msg="OTEL tracing is not configured, using no-op tracer provider" Jan 23 00:07:08.377646 dockerd[2660]: time="2026-01-23T00:07:08.377575172Z" level=info msg="Creating a containerd client" address=/var/run/docker/libcontainerd/docker-containerd.sock timeout=1m0s Jan 23 00:07:08.455190 systemd[1]: var-lib-docker-overlay2-metacopy\x2dcheck1794054600-merged.mount: Deactivated successfully. Jan 23 00:07:08.463194 dockerd[2660]: time="2026-01-23T00:07:08.463148421Z" level=info msg="[graphdriver] using prior storage driver: overlay2" Jan 23 00:07:08.468845 dockerd[2660]: time="2026-01-23T00:07:08.468810674Z" level=info msg="Loading containers: start." Jan 23 00:07:09.060919 systemd[1]: Started sshd@13-10.200.20.31:22-10.200.16.10:52350.service - OpenSSH per-connection server daemon (10.200.16.10:52350). Jan 23 00:07:09.519161 sshd[2688]: Accepted publickey for core from 10.200.16.10 port 52350 ssh2: RSA SHA256:kRQEAzNVhqU4Fmpx84sKU93gp2nZjfuJ8Tlyw3EYXBc Jan 23 00:07:09.520265 sshd-session[2688]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Jan 23 00:07:09.523771 systemd-logind[1792]: New session 16 of user core. Jan 23 00:07:09.534438 systemd[1]: Started session-16.scope - Session 16 of User core. Jan 23 00:07:09.854593 sshd[2691]: Connection closed by 10.200.16.10 port 52350 Jan 23 00:07:09.854367 sshd-session[2688]: pam_unix(sshd:session): session closed for user core Jan 23 00:07:09.858227 systemd[1]: sshd@13-10.200.20.31:22-10.200.16.10:52350.service: Deactivated successfully. Jan 23 00:07:09.860151 systemd[1]: session-16.scope: Deactivated successfully. Jan 23 00:07:09.861054 systemd-logind[1792]: Session 16 logged out. Waiting for processes to exit. Jan 23 00:07:09.862669 systemd-logind[1792]: Removed session 16. Jan 23 00:07:09.940838 systemd[1]: Started sshd@14-10.200.20.31:22-10.200.16.10:40356.service - OpenSSH per-connection server daemon (10.200.16.10:40356). Jan 23 00:07:10.431872 sshd[2697]: Accepted publickey for core from 10.200.16.10 port 40356 ssh2: RSA SHA256:kRQEAzNVhqU4Fmpx84sKU93gp2nZjfuJ8Tlyw3EYXBc Jan 23 00:07:10.432640 sshd-session[2697]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Jan 23 00:07:10.436043 systemd-logind[1792]: New session 17 of user core. Jan 23 00:07:10.442389 systemd[1]: Started session-17.scope - Session 17 of User core. Jan 23 00:07:10.780119 sshd[2700]: Connection closed by 10.200.16.10 port 40356 Jan 23 00:07:10.780670 sshd-session[2697]: pam_unix(sshd:session): session closed for user core Jan 23 00:07:10.784008 systemd[1]: sshd@14-10.200.20.31:22-10.200.16.10:40356.service: Deactivated successfully. Jan 23 00:07:10.785375 systemd[1]: session-17.scope: Deactivated successfully. Jan 23 00:07:10.785925 systemd-logind[1792]: Session 17 logged out. Waiting for processes to exit. Jan 23 00:07:10.787009 systemd-logind[1792]: Removed session 17. Jan 23 00:07:10.865996 systemd[1]: Started sshd@15-10.200.20.31:22-10.200.16.10:40358.service - OpenSSH per-connection server daemon (10.200.16.10:40358). Jan 23 00:07:11.325285 sshd[2706]: Accepted publickey for core from 10.200.16.10 port 40358 ssh2: RSA SHA256:kRQEAzNVhqU4Fmpx84sKU93gp2nZjfuJ8Tlyw3EYXBc Jan 23 00:07:11.326361 sshd-session[2706]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Jan 23 00:07:11.330142 systemd-logind[1792]: New session 18 of user core. Jan 23 00:07:11.338349 systemd[1]: Started session-18.scope - Session 18 of User core. Jan 23 00:07:18.518172 dockerd[2660]: time="2026-01-23T00:07:18.517649953Z" level=info msg="Container failed to exit within 10s of signal 15 - using the force" container=b98909004952f8fde1e1c000618c60511ac5680b76e2013a593cf683347e0322 Jan 23 00:07:18.535026 systemd[1]: docker-b98909004952f8fde1e1c000618c60511ac5680b76e2013a593cf683347e0322.scope: Deactivated successfully. Jan 23 00:07:18.546605 dockerd[2660]: time="2026-01-23T00:07:18.546491991Z" level=info msg="ignoring event" container=b98909004952f8fde1e1c000618c60511ac5680b76e2013a593cf683347e0322 module=libcontainerd namespace=moby topic=/tasks/delete type="*events.TaskDelete" Jan 23 00:07:18.547189 containerd[2636]: time="2026-01-23T00:07:18.547148195Z" level=info msg="shim disconnected" id=b98909004952f8fde1e1c000618c60511ac5680b76e2013a593cf683347e0322 namespace=moby Jan 23 00:07:18.547531 containerd[2636]: time="2026-01-23T00:07:18.547184252Z" level=warning msg="cleaning up after shim disconnected" id=b98909004952f8fde1e1c000618c60511ac5680b76e2013a593cf683347e0322 namespace=moby Jan 23 00:07:18.547531 containerd[2636]: time="2026-01-23T00:07:18.547211828Z" level=info msg="cleaning up dead shim" namespace=moby Jan 23 00:07:18.562265 systemd[1]: var-lib-docker-overlay2-23c75a0d4b2fb9c9eb91aee17af5d8e250f0e3bd932a22693b505f82c1f94ae1-merged.mount: Deactivated successfully. Jan 23 00:07:18.940071 systemd[1]: run-docker-netns-8104180ef735.mount: Deactivated successfully. Jan 23 00:07:18.944791 systemd-networkd[1490]: veth97f457a: Link DOWN Jan 23 00:07:18.945235 kernel: docker0: port 1(veth97f457a) entered disabled state Jan 23 00:07:18.944798 systemd-networkd[1490]: veth97f457a: Lost carrier Jan 23 00:07:18.952578 kernel: veth97f457a (unregistering): left allmulticast mode Jan 23 00:07:18.952669 kernel: veth97f457a (unregistering): left promiscuous mode Jan 23 00:07:18.956083 kernel: docker0: port 1(veth97f457a) entered disabled state Jan 23 00:07:18.958285 systemd-networkd[1490]: docker0: Lost carrier Jan 23 00:07:18.961043 dockerd[2660]: time="2026-01-23T00:07:18.961004773Z" level=info msg="Removing stale sandbox 8104180ef735924d85ba685de0df18e0fe96547fdf5bc3375c70fdc73d780872 (b98909004952f8fde1e1c000618c60511ac5680b76e2013a593cf683347e0322)" Jan 23 00:07:18.971260 dockerd[2660]: time="2026-01-23T00:07:18.971215183Z" level=warning msg="Failed deleting service host entries to the running container: open : no such file or directory" Jan 23 00:07:18.971362 dockerd[2660]: time="2026-01-23T00:07:18.971270832Z" level=warning msg="Error (Unable to complete atomic operation, key modified) deleting object [endpoint fb3f63a5c8bbf685624541ac8a429bd700d8306026c5895bb1666c83783c30fa f4150b4b325b42c9ec4c43c00d971c7594810ba24d961cda3982ab1d09d33c2e], retrying...." Jan 23 00:07:18.981714 systemd[1]: run-docker-netns-8104180ef735.mount: Deactivated successfully. Jan 23 00:07:19.152009 dockerd[2660]: time="2026-01-23T00:07:19.151949236Z" level=warning msg="error locating sandbox id 8104180ef735924d85ba685de0df18e0fe96547fdf5bc3375c70fdc73d780872: sandbox 8104180ef735924d85ba685de0df18e0fe96547fdf5bc3375c70fdc73d780872 not found" Jan 23 00:07:19.152311 dockerd[2660]: time="2026-01-23T00:07:19.152190129Z" level=info msg="Loading containers: done." Jan 23 00:07:19.175691 dockerd[2660]: time="2026-01-23T00:07:19.175422244Z" 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 Jan 23 00:07:19.175691 dockerd[2660]: time="2026-01-23T00:07:19.175519110Z" level=info msg="Docker daemon" commit=6430e49a55babd9b8f4d08e70ecb2b68900770fe containerd-snapshotter=false storage-driver=overlay2 version=28.0.4 Jan 23 00:07:19.175691 dockerd[2660]: time="2026-01-23T00:07:19.175557495Z" level=info msg="Initializing buildkit" Jan 23 00:07:19.185699 dockerd[2660]: time="2026-01-23T00:07:19.185627318Z" level=info msg="Completed buildkit initialization" Jan 23 00:07:19.191753 dockerd[2660]: time="2026-01-23T00:07:19.190750231Z" level=info msg="Daemon has completed initialization" Jan 23 00:07:19.191753 dockerd[2660]: time="2026-01-23T00:07:19.191146878Z" level=info msg="API listen on /run/docker.sock" Jan 23 00:07:19.192150 systemd[1]: Started docker.service - Docker Application Container Engine. Jan 23 00:07:19.275979 sshd[2709]: Connection closed by 10.200.16.10 port 40358 Jan 23 00:07:19.275231 sshd-session[2706]: pam_unix(sshd:session): session closed for user core Jan 23 00:07:19.278520 systemd[1]: sshd@15-10.200.20.31:22-10.200.16.10:40358.service: Deactivated successfully. Jan 23 00:07:19.280424 systemd[1]: session-18.scope: Deactivated successfully. Jan 23 00:07:19.282135 systemd-logind[1792]: Session 18 logged out. Waiting for processes to exit. Jan 23 00:07:19.282876 systemd-logind[1792]: Removed session 18. Jan 23 00:07:19.365984 systemd[1]: Started sshd@16-10.200.20.31:22-10.200.16.10:40364.service - OpenSSH per-connection server daemon (10.200.16.10:40364). Jan 23 00:07:19.860560 sshd[2961]: Accepted publickey for core from 10.200.16.10 port 40364 ssh2: RSA SHA256:kRQEAzNVhqU4Fmpx84sKU93gp2nZjfuJ8Tlyw3EYXBc Jan 23 00:07:19.861668 sshd-session[2961]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Jan 23 00:07:19.865682 systemd-logind[1792]: New session 19 of user core. Jan 23 00:07:19.876260 systemd[1]: Started session-19.scope - Session 19 of User core. Jan 23 00:07:20.251109 containerd[2636]: time="2026-01-23T00:07:20.250941724Z" level=info msg="connecting to shim c8d8ae225b00ca6d32ad5dd6e9ac6048a95402d3a1414c7cfb4bc65f639894d2" address="unix:///run/containerd/s/d8826126126d29ba1d5cd73cd9b165d05967b9195bf3e173b2f65875a6988cda" namespace=moby protocol=ttrpc version=3 Jan 23 00:07:20.274223 systemd[1]: Started docker-c8d8ae225b00ca6d32ad5dd6e9ac6048a95402d3a1414c7cfb4bc65f639894d2.scope - libcontainer container c8d8ae225b00ca6d32ad5dd6e9ac6048a95402d3a1414c7cfb4bc65f639894d2. Jan 23 00:07:20.303628 kernel: docker0: port 1(vethbba6379) entered blocking state Jan 23 00:07:20.303719 kernel: docker0: port 1(vethbba6379) entered disabled state Jan 23 00:07:20.307171 kernel: vethbba6379: entered allmulticast mode Jan 23 00:07:20.310084 kernel: vethbba6379: entered promiscuous mode Jan 23 00:07:20.310792 systemd-networkd[1490]: vethbba6379: Link UP Jan 23 00:07:20.337097 kernel: eth0: renamed from vethbaf3734 Jan 23 00:07:20.344457 kernel: docker0: port 1(vethbba6379) entered blocking state Jan 23 00:07:20.344722 kernel: docker0: port 1(vethbba6379) entered forwarding state Jan 23 00:07:20.345122 systemd-networkd[1490]: vethbba6379: Gained carrier Jan 23 00:07:20.345373 systemd-networkd[1490]: docker0: Gained carrier Jan 23 00:07:20.460220 sshd[2964]: Connection closed by 10.200.16.10 port 40364 Jan 23 00:07:20.460835 sshd-session[2961]: pam_unix(sshd:session): session closed for user core Jan 23 00:07:20.464273 systemd[1]: sshd@16-10.200.20.31:22-10.200.16.10:40364.service: Deactivated successfully. Jan 23 00:07:20.465582 systemd[1]: session-19.scope: Deactivated successfully. Jan 23 00:07:20.466212 systemd-logind[1792]: Session 19 logged out. Waiting for processes to exit. Jan 23 00:07:20.468224 systemd-logind[1792]: Removed session 19. Jan 23 00:07:20.555681 systemd[1]: Started sshd@17-10.200.20.31:22-10.200.16.10:50144.service - OpenSSH per-connection server daemon (10.200.16.10:50144). Jan 23 00:07:21.051070 sshd[3027]: Accepted publickey for core from 10.200.16.10 port 50144 ssh2: RSA SHA256:kRQEAzNVhqU4Fmpx84sKU93gp2nZjfuJ8Tlyw3EYXBc Jan 23 00:07:21.051848 sshd-session[3027]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Jan 23 00:07:21.055647 systemd-logind[1792]: New session 20 of user core. Jan 23 00:07:21.066419 systemd[1]: Started session-20.scope - Session 20 of User core. Jan 23 00:07:21.402264 sshd[3030]: Connection closed by 10.200.16.10 port 50144 Jan 23 00:07:21.402890 sshd-session[3027]: pam_unix(sshd:session): session closed for user core Jan 23 00:07:21.406032 systemd[1]: sshd@17-10.200.20.31:22-10.200.16.10:50144.service: Deactivated successfully. Jan 23 00:07:21.407418 systemd[1]: session-20.scope: Deactivated successfully. Jan 23 00:07:21.407992 systemd-logind[1792]: Session 20 logged out. Waiting for processes to exit. Jan 23 00:07:21.409177 systemd-logind[1792]: Removed session 20. Jan 23 00:07:21.483852 systemd[1]: Started sshd@18-10.200.20.31:22-10.200.16.10:50148.service - OpenSSH per-connection server daemon (10.200.16.10:50148). Jan 23 00:07:21.896288 systemd-networkd[1490]: vethbba6379: Gained IPv6LL Jan 23 00:07:21.941060 sshd[3036]: Accepted publickey for core from 10.200.16.10 port 50148 ssh2: RSA SHA256:kRQEAzNVhqU4Fmpx84sKU93gp2nZjfuJ8Tlyw3EYXBc Jan 23 00:07:21.942240 sshd-session[3036]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Jan 23 00:07:21.946071 systemd-logind[1792]: New session 21 of user core. Jan 23 00:07:21.954260 systemd[1]: Started session-21.scope - Session 21 of User core. Jan 23 00:07:22.197454 sudo[3040]: core : PWD=/home/core ; USER=root ; COMMAND=/usr/sbin/kill -SIGHUP 2636 Jan 23 00:07:22.197664 sudo[3040]: pam_unix(sudo:session): session opened for user root(uid=0) by core(uid=500) Jan 23 00:07:22.200389 sudo[3040]: pam_unix(sudo:session): session closed for user root Jan 23 00:07:22.204945 systemd[1]: containerd.service: Deactivated successfully. Jan 23 00:07:22.205058 systemd[1]: containerd.service: Unit process 2984 (containerd-shim) remains running after unit stopped. Jan 23 00:07:22.205305 systemd[1]: containerd.service: Consumed 133ms CPU time, 123.5M memory peak. Jan 23 00:07:22.205723 dockerd[2660]: time="2026-01-23T00:07:22.205674756Z" level=error msg="Failed to get event" error="rpc error: code = Unavailable desc = error reading from server: EOF" module=libcontainerd namespace=moby Jan 23 00:07:22.205723 dockerd[2660]: time="2026-01-23T00:07:22.205711028Z" level=info msg="Waiting for containerd to be ready to restart event processing" module=libcontainerd namespace=moby Jan 23 00:07:22.206053 dockerd[2660]: time="2026-01-23T00:07:22.205678284Z" level=error msg="Failed to get event" error="rpc error: code = Unavailable desc = error reading from server: EOF" module=libcontainerd namespace=plugins.moby Jan 23 00:07:22.206053 dockerd[2660]: time="2026-01-23T00:07:22.205805182Z" level=info msg="Waiting for containerd to be ready to restart event processing" module=libcontainerd namespace=plugins.moby Jan 23 00:07:22.278062 sshd[3039]: Connection closed by 10.200.16.10 port 50148 Jan 23 00:07:22.278336 sshd-session[3036]: pam_unix(sshd:session): session closed for user core Jan 23 00:07:22.282297 systemd[1]: sshd@18-10.200.20.31:22-10.200.16.10:50148.service: Deactivated successfully. Jan 23 00:07:22.284231 systemd[1]: session-21.scope: Deactivated successfully. Jan 23 00:07:22.285141 systemd-logind[1792]: Session 21 logged out. Waiting for processes to exit. Jan 23 00:07:22.286842 systemd-logind[1792]: Removed session 21. Jan 23 00:07:22.365129 systemd[1]: Started sshd@19-10.200.20.31:22-10.200.16.10:50156.service - OpenSSH per-connection server daemon (10.200.16.10:50156). Jan 23 00:07:22.859908 sshd[3047]: Accepted publickey for core from 10.200.16.10 port 50156 ssh2: RSA SHA256:kRQEAzNVhqU4Fmpx84sKU93gp2nZjfuJ8Tlyw3EYXBc Jan 23 00:07:22.860659 sshd-session[3047]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Jan 23 00:07:22.864328 systemd-logind[1792]: New session 22 of user core. Jan 23 00:07:22.871264 systemd[1]: Started session-22.scope - Session 22 of User core. Jan 23 00:07:23.211143 sshd[3050]: Connection closed by 10.200.16.10 port 50156 Jan 23 00:07:23.210965 sshd-session[3047]: pam_unix(sshd:session): session closed for user core Jan 23 00:07:23.214802 systemd[1]: sshd@19-10.200.20.31:22-10.200.16.10:50156.service: Deactivated successfully. Jan 23 00:07:23.216588 systemd[1]: session-22.scope: Deactivated successfully. Jan 23 00:07:23.218004 systemd-logind[1792]: Session 22 logged out. Waiting for processes to exit. Jan 23 00:07:23.219741 systemd-logind[1792]: Removed session 22. Jan 23 00:07:27.262042 systemd[1]: containerd.service: Scheduled restart job, restart counter is at 2. Jan 23 00:07:27.262379 systemd[1]: Stopping docker.service - Docker Application Container Engine... Jan 23 00:07:27.262716 dockerd[2660]: time="2026-01-23T00:07:27.262629384Z" level=info msg="Processing signal 'terminated'" Jan 23 00:07:29.264293 dockerd[2660]: time="2026-01-23T00:07:29.264048800Z" level=error msg="Error sending stop (signal 15) to container" container=c8d8ae225b00ca6d32ad5dd6e9ac6048a95402d3a1414c7cfb4bc65f639894d2 error="Cannot kill container c8d8ae225b00ca6d32ad5dd6e9ac6048a95402d3a1414c7cfb4bc65f639894d2: Unavailable: connection error: desc = \"transport: Error while dialing: dial unix /var/run/docker/libcontainerd/docker-containerd.sock: connect: connection refused\"" Jan 23 00:07:29.264293 dockerd[2660]: time="2026-01-23T00:07:29.264140113Z" level=info msg="Container failed to exit within 2s of signal 15 - using the force" container=c8d8ae225b00ca6d32ad5dd6e9ac6048a95402d3a1414c7cfb4bc65f639894d2 Jan 23 00:07:29.304164 systemd[1]: Started sshd@20-10.200.20.31:22-10.200.16.10:50166.service - OpenSSH per-connection server daemon (10.200.16.10:50166). Jan 23 00:07:29.333854 waagent[2016]: 2026-01-23T00:07:29.333796Z INFO ExtHandler Fetched a new incarnation for the WireServer goal state [incarnation 2] Jan 23 00:07:29.341032 waagent[2016]: 2026-01-23T00:07:29.340987Z INFO ExtHandler Jan 23 00:07:29.341317 waagent[2016]: 2026-01-23T00:07:29.341288Z INFO ExtHandler Fetched new vmSettings [HostGAPlugin correlation ID: 5b0d0043-395c-497d-b785-d97a6253cc45 eTag: 14969692230409920467 source: Fabric] Jan 23 00:07:29.341709 waagent[2016]: 2026-01-23T00:07:29.341678Z INFO ExtHandler The vmSettings originated via Fabric; will ignore them. Jan 23 00:07:29.342349 waagent[2016]: 2026-01-23T00:07:29.342306Z INFO ExtHandler Jan 23 00:07:29.342499 waagent[2016]: 2026-01-23T00:07:29.342475Z INFO ExtHandler Fetching full goal state from the WireServer [incarnation 2] Jan 23 00:07:29.408594 waagent[2016]: 2026-01-23T00:07:29.408545Z INFO ExtHandler ExtHandler Downloading artifacts profile blob Jan 23 00:07:29.461152 waagent[2016]: 2026-01-23T00:07:29.461067Z INFO ExtHandler Downloaded certificate {'thumbprint': 'AD8103BDE902EF685FA3AEC32D5B807A8458C8A9', 'hasPrivateKey': True} Jan 23 00:07:29.461722 waagent[2016]: 2026-01-23T00:07:29.461687Z INFO ExtHandler Fetch goal state completed Jan 23 00:07:29.462150 waagent[2016]: 2026-01-23T00:07:29.462118Z INFO ExtHandler ExtHandler Jan 23 00:07:29.462282 waagent[2016]: 2026-01-23T00:07:29.462259Z INFO ExtHandler ExtHandler ProcessExtensionsGoalState started [incarnation_2 channel: WireServer source: Fabric activity: eb1c0487-4ab6-462d-8d79-c242aca947c9 correlation 15fded59-6cc6-490b-b4a3-cde777259f17 created: 2026-01-23T00:07:19.438347Z] Jan 23 00:07:29.462660 waagent[2016]: 2026-01-23T00:07:29.462615Z INFO ExtHandler ExtHandler No extension handlers found, not processing anything. Jan 23 00:07:29.463140 waagent[2016]: 2026-01-23T00:07:29.463112Z INFO ExtHandler ExtHandler ProcessExtensionsGoalState completed [incarnation_2 0 ms] Jan 23 00:07:29.798987 sshd[3056]: Accepted publickey for core from 10.200.16.10 port 50166 ssh2: RSA SHA256:kRQEAzNVhqU4Fmpx84sKU93gp2nZjfuJ8Tlyw3EYXBc Jan 23 00:07:29.800101 sshd-session[3056]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Jan 23 00:07:29.803618 systemd-logind[1792]: New session 23 of user core. Jan 23 00:07:29.814444 systemd[1]: Started session-23.scope - Session 23 of User core. Jan 23 00:07:30.152154 sshd[3064]: Connection closed by 10.200.16.10 port 50166 Jan 23 00:07:30.152655 sshd-session[3056]: pam_unix(sshd:session): session closed for user core Jan 23 00:07:30.156097 systemd[1]: sshd@20-10.200.20.31:22-10.200.16.10:50166.service: Deactivated successfully. Jan 23 00:07:30.157791 systemd[1]: session-23.scope: Deactivated successfully. Jan 23 00:07:30.158411 systemd-logind[1792]: Session 23 logged out. Waiting for processes to exit. Jan 23 00:07:30.159603 systemd-logind[1792]: Removed session 23. Jan 23 00:07:36.244333 systemd[1]: Started sshd@21-10.200.20.31:22-10.200.16.10:51062.service - OpenSSH per-connection server daemon (10.200.16.10:51062). Jan 23 00:07:36.746694 sshd[3070]: Accepted publickey for core from 10.200.16.10 port 51062 ssh2: RSA SHA256:kRQEAzNVhqU4Fmpx84sKU93gp2nZjfuJ8Tlyw3EYXBc Jan 23 00:07:36.747788 sshd-session[3070]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Jan 23 00:07:36.751187 systemd-logind[1792]: New session 24 of user core. Jan 23 00:07:36.758264 systemd[1]: Started session-24.scope - Session 24 of User core. Jan 23 00:07:37.099049 sshd[3073]: Connection closed by 10.200.16.10 port 51062 Jan 23 00:07:37.099829 sshd-session[3070]: pam_unix(sshd:session): session closed for user core Jan 23 00:07:37.102890 systemd[1]: sshd@21-10.200.20.31:22-10.200.16.10:51062.service: Deactivated successfully. Jan 23 00:07:37.104585 systemd[1]: session-24.scope: Deactivated successfully. Jan 23 00:07:37.105424 systemd-logind[1792]: Session 24 logged out. Waiting for processes to exit. Jan 23 00:07:37.106810 systemd-logind[1792]: Removed session 24. Jan 23 00:07:39.264579 dockerd[2660]: time="2026-01-23T00:07:39.264495869Z" level=warning msg="Container failed to exit within 10s of kill - trying direct SIGKILL" container=c8d8ae225b00ca6d32ad5dd6e9ac6048a95402d3a1414c7cfb4bc65f639894d2 error="context deadline exceeded" Jan 23 00:07:39.265838 systemd[1]: docker-c8d8ae225b00ca6d32ad5dd6e9ac6048a95402d3a1414c7cfb4bc65f639894d2.scope: Deactivated successfully. Jan 23 00:07:42.263117 dockerd[2660]: time="2026-01-23T00:07:42.262961936Z" level=error msg="Force shutdown daemon" Jan 23 00:07:42.264090 dockerd[2660]: time="2026-01-23T00:07:42.263480928Z" level=info msg="Daemon shutdown complete" Jan 23 00:07:42.266940 systemd[1]: docker.service: Deactivated successfully. Jan 23 00:07:42.267252 systemd[1]: Stopped docker.service - Docker Application Container Engine. Jan 23 00:07:42.267673 systemd[1]: docker.socket: Deactivated successfully. Jan 23 00:07:42.267879 systemd[1]: Closed docker.socket - Docker Socket for the API. Jan 23 00:07:42.267912 systemd[1]: Stopping docker.socket - Docker Socket for the API... Jan 23 00:07:42.269931 systemd[1]: Starting docker.socket - Docker Socket for the API... Jan 23 00:07:42.270136 systemd[1]: containerd.service: Found left-over process 2984 (containerd-shim) in control group while starting unit. Ignoring. Jan 23 00:07:42.270142 systemd[1]: containerd.service: This usually indicates unclean termination of a previous run, or service implementation deficiencies. Jan 23 00:07:42.276113 systemd[1]: Starting containerd.service - containerd container runtime... Jan 23 00:07:42.276391 systemd[1]: Listening on docker.socket - Docker Socket for the API. Jan 23 00:07:42.288916 systemd[1]: containerd.service: Found left-over process 2984 (containerd-shim) in control group while starting unit. Ignoring. Jan 23 00:07:42.288926 systemd[1]: containerd.service: This usually indicates unclean termination of a previous run, or service implementation deficiencies. Jan 23 00:07:42.295372 (ntainerd)[3084]: containerd.service: Referenced but unset environment variable evaluates to an empty string: TORCX_IMAGEDIR, TORCX_UNPACKDIR Jan 23 00:07:42.307423 containerd[3084]: time="2026-01-23T00:07:42Z" 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 Jan 23 00:07:42.309104 containerd[3084]: time="2026-01-23T00:07:42.308112748Z" level=info msg="starting containerd" revision=4ac6c20c7bbf8177f29e46bbdc658fec02ffb8ad version=v2.0.7 Jan 23 00:07:42.313790 containerd[3084]: time="2026-01-23T00:07:42.313745037Z" level=warning msg="Configuration migrated from version 2, use `containerd config migrate` to avoid migration" t="8.409µs" Jan 23 00:07:42.313938 containerd[3084]: time="2026-01-23T00:07:42.313921895Z" level=info msg="loading plugin" id=io.containerd.image-verifier.v1.bindir type=io.containerd.image-verifier.v1 Jan 23 00:07:42.313990 containerd[3084]: time="2026-01-23T00:07:42.313979344Z" level=info msg="loading plugin" id=io.containerd.internal.v1.opt type=io.containerd.internal.v1 Jan 23 00:07:42.314056 containerd[3084]: time="2026-01-23T00:07:42.314046209Z" level=info msg="loading plugin" id=io.containerd.warning.v1.deprecations type=io.containerd.warning.v1 Jan 23 00:07:42.314136 containerd[3084]: time="2026-01-23T00:07:42.314123123Z" level=info msg="loading plugin" id=io.containerd.content.v1.content type=io.containerd.content.v1 Jan 23 00:07:42.314394 containerd[3084]: time="2026-01-23T00:07:42.314376526Z" level=info msg="loading plugin" id=io.containerd.snapshotter.v1.blockfile type=io.containerd.snapshotter.v1 Jan 23 00:07:42.314466 containerd[3084]: time="2026-01-23T00:07:42.314454576Z" level=info msg="skip loading plugin" error="no scratch file generator: skip plugin" id=io.containerd.snapshotter.v1.blockfile type=io.containerd.snapshotter.v1 Jan 23 00:07:42.314504 containerd[3084]: time="2026-01-23T00:07:42.314494016Z" level=info msg="loading plugin" id=io.containerd.snapshotter.v1.btrfs type=io.containerd.snapshotter.v1 Jan 23 00:07:42.314737 containerd[3084]: time="2026-01-23T00:07:42.314718428Z" 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 Jan 23 00:07:42.314797 containerd[3084]: time="2026-01-23T00:07:42.314785557Z" level=info msg="loading plugin" id=io.containerd.snapshotter.v1.devmapper type=io.containerd.snapshotter.v1 Jan 23 00:07:42.314850 containerd[3084]: time="2026-01-23T00:07:42.314837398Z" level=info msg="skip loading plugin" error="devmapper not configured: skip plugin" id=io.containerd.snapshotter.v1.devmapper type=io.containerd.snapshotter.v1 Jan 23 00:07:42.314893 containerd[3084]: time="2026-01-23T00:07:42.314882110Z" level=info msg="loading plugin" id=io.containerd.snapshotter.v1.native type=io.containerd.snapshotter.v1 Jan 23 00:07:42.314948 containerd[3084]: time="2026-01-23T00:07:42.314938215Z" level=info msg="loading plugin" id=io.containerd.snapshotter.v1.overlayfs type=io.containerd.snapshotter.v1 Jan 23 00:07:42.315104 containerd[3084]: time="2026-01-23T00:07:42.315070769Z" level=info msg="loading plugin" id=io.containerd.snapshotter.v1.zfs type=io.containerd.snapshotter.v1 Jan 23 00:07:42.315164 containerd[3084]: time="2026-01-23T00:07:42.315154195Z" 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 Jan 23 00:07:42.315221 containerd[3084]: time="2026-01-23T00:07:42.315209091Z" level=info msg="loading plugin" id=io.containerd.event.v1.exchange type=io.containerd.event.v1 Jan 23 00:07:42.315294 containerd[3084]: time="2026-01-23T00:07:42.315282229Z" level=info msg="loading plugin" id=io.containerd.monitor.task.v1.cgroups type=io.containerd.monitor.task.v1 Jan 23 00:07:42.315569 containerd[3084]: time="2026-01-23T00:07:42.315523200Z" level=info msg="loading plugin" id=io.containerd.metadata.v1.bolt type=io.containerd.metadata.v1 Jan 23 00:07:42.315612 containerd[3084]: time="2026-01-23T00:07:42.315574537Z" level=info msg="metadata content store policy set" policy=shared Jan 23 00:07:42.315745 containerd[3084]: time="2026-01-23T00:07:42.315728204Z" level=info msg="loading plugin" id=io.containerd.gc.v1.scheduler type=io.containerd.gc.v1 Jan 23 00:07:42.315770 containerd[3084]: time="2026-01-23T00:07:42.315758028Z" level=info msg="loading plugin" id=io.containerd.differ.v1.walking type=io.containerd.differ.v1 Jan 23 00:07:42.315800 containerd[3084]: time="2026-01-23T00:07:42.315769300Z" level=info msg="loading plugin" id=io.containerd.lease.v1.manager type=io.containerd.lease.v1 Jan 23 00:07:42.315800 containerd[3084]: time="2026-01-23T00:07:42.315777804Z" level=info msg="loading plugin" id=io.containerd.service.v1.containers-service type=io.containerd.service.v1 Jan 23 00:07:42.315800 containerd[3084]: time="2026-01-23T00:07:42.315785653Z" level=info msg="loading plugin" id=io.containerd.service.v1.content-service type=io.containerd.service.v1 Jan 23 00:07:42.315800 containerd[3084]: time="2026-01-23T00:07:42.315792869Z" level=info msg="loading plugin" id=io.containerd.service.v1.diff-service type=io.containerd.service.v1 Jan 23 00:07:42.315854 containerd[3084]: time="2026-01-23T00:07:42.315806461Z" level=info msg="loading plugin" id=io.containerd.service.v1.images-service type=io.containerd.service.v1 Jan 23 00:07:42.315854 containerd[3084]: time="2026-01-23T00:07:42.315814149Z" level=info msg="loading plugin" id=io.containerd.service.v1.introspection-service type=io.containerd.service.v1 Jan 23 00:07:42.315854 containerd[3084]: time="2026-01-23T00:07:42.315820597Z" level=info msg="loading plugin" id=io.containerd.service.v1.namespaces-service type=io.containerd.service.v1 Jan 23 00:07:42.315854 containerd[3084]: time="2026-01-23T00:07:42.315826653Z" level=info msg="loading plugin" id=io.containerd.service.v1.snapshots-service type=io.containerd.service.v1 Jan 23 00:07:42.315854 containerd[3084]: time="2026-01-23T00:07:42.315832181Z" level=info msg="loading plugin" id=io.containerd.shim.v1.manager type=io.containerd.shim.v1 Jan 23 00:07:42.315854 containerd[3084]: time="2026-01-23T00:07:42.315841021Z" level=info msg="loading plugin" id=io.containerd.runtime.v2.task type=io.containerd.runtime.v2 Jan 23 00:07:42.316058 containerd[3084]: time="2026-01-23T00:07:42.316031368Z" level=info msg="connecting to shim c8d8ae225b00ca6d32ad5dd6e9ac6048a95402d3a1414c7cfb4bc65f639894d2" address="unix:///run/containerd/s/d8826126126d29ba1d5cd73cd9b165d05967b9195bf3e173b2f65875a6988cda" namespace=moby protocol=ttrpc version=3 Jan 23 00:07:42.322590 containerd[3084]: time="2026-01-23T00:07:42.322549887Z" level=info msg="cleaning leaked shim process" id=c8d8ae225b00ca6d32ad5dd6e9ac6048a95402d3a1414c7cfb4bc65f639894d2 namespace=moby Jan 23 00:07:42.332245 containerd[3084]: time="2026-01-23T00:07:42.332046763Z" level=info msg="shim disconnected" id=c8d8ae225b00ca6d32ad5dd6e9ac6048a95402d3a1414c7cfb4bc65f639894d2 namespace=moby Jan 23 00:07:42.332245 containerd[3084]: time="2026-01-23T00:07:42.332123181Z" level=warning msg="cleaning up after shim disconnected" id=c8d8ae225b00ca6d32ad5dd6e9ac6048a95402d3a1414c7cfb4bc65f639894d2 namespace=moby Jan 23 00:07:42.332245 containerd[3084]: time="2026-01-23T00:07:42.332159125Z" level=info msg="cleaning up dead shim" namespace=moby Jan 23 00:07:42.341457 containerd[3084]: time="2026-01-23T00:07:42.341410502Z" level=info msg="loading plugin" id=io.containerd.service.v1.tasks-service type=io.containerd.service.v1 Jan 23 00:07:42.342098 containerd[3084]: time="2026-01-23T00:07:42.341608977Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.containers type=io.containerd.grpc.v1 Jan 23 00:07:42.342098 containerd[3084]: time="2026-01-23T00:07:42.341630594Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.content type=io.containerd.grpc.v1 Jan 23 00:07:42.342098 containerd[3084]: time="2026-01-23T00:07:42.341650762Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.diff type=io.containerd.grpc.v1 Jan 23 00:07:42.342098 containerd[3084]: time="2026-01-23T00:07:42.341659546Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.events type=io.containerd.grpc.v1 Jan 23 00:07:42.342098 containerd[3084]: time="2026-01-23T00:07:42.341666690Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.images type=io.containerd.grpc.v1 Jan 23 00:07:42.342098 containerd[3084]: time="2026-01-23T00:07:42.341675106Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.introspection type=io.containerd.grpc.v1 Jan 23 00:07:42.342098 containerd[3084]: time="2026-01-23T00:07:42.341683586Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.leases type=io.containerd.grpc.v1 Jan 23 00:07:42.342098 containerd[3084]: time="2026-01-23T00:07:42.341691698Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.namespaces type=io.containerd.grpc.v1 Jan 23 00:07:42.342098 containerd[3084]: time="2026-01-23T00:07:42.341698395Z" level=info msg="loading plugin" id=io.containerd.sandbox.store.v1.local type=io.containerd.sandbox.store.v1 Jan 23 00:07:42.342098 containerd[3084]: time="2026-01-23T00:07:42.341709555Z" level=info msg="loading plugin" id=io.containerd.cri.v1.images type=io.containerd.cri.v1 Jan 23 00:07:42.342098 containerd[3084]: time="2026-01-23T00:07:42.341755963Z" level=info msg="Get image filesystem path \"/var/lib/containerd/io.containerd.snapshotter.v1.overlayfs\" for snapshotter \"overlayfs\"" Jan 23 00:07:42.342098 containerd[3084]: time="2026-01-23T00:07:42.341766940Z" level=info msg="Start snapshots syncer" Jan 23 00:07:42.342098 containerd[3084]: time="2026-01-23T00:07:42.341795316Z" level=info msg="loading plugin" id=io.containerd.cri.v1.runtime type=io.containerd.cri.v1 Jan 23 00:07:42.342332 containerd[3084]: time="2026-01-23T00:07:42.341981503Z" 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\"}" Jan 23 00:07:42.342332 containerd[3084]: time="2026-01-23T00:07:42.342019032Z" level=info msg="loading plugin" id=io.containerd.podsandbox.controller.v1.podsandbox type=io.containerd.podsandbox.controller.v1 Jan 23 00:07:42.342403 containerd[3084]: time="2026-01-23T00:07:42.342062504Z" level=info msg="loading plugin" id=io.containerd.sandbox.controller.v1.shim type=io.containerd.sandbox.controller.v1 Jan 23 00:07:42.342491 containerd[3084]: time="2026-01-23T00:07:42.342472007Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.sandbox-controllers type=io.containerd.grpc.v1 Jan 23 00:07:42.342550 containerd[3084]: time="2026-01-23T00:07:42.342538200Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.sandboxes type=io.containerd.grpc.v1 Jan 23 00:07:42.342605 containerd[3084]: time="2026-01-23T00:07:42.342594009Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.snapshots type=io.containerd.grpc.v1 Jan 23 00:07:42.342649 containerd[3084]: time="2026-01-23T00:07:42.342639689Z" level=info msg="loading plugin" id=io.containerd.streaming.v1.manager type=io.containerd.streaming.v1 Jan 23 00:07:42.342697 containerd[3084]: time="2026-01-23T00:07:42.342686914Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.streaming type=io.containerd.grpc.v1 Jan 23 00:07:42.342751 containerd[3084]: time="2026-01-23T00:07:42.342741179Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.tasks type=io.containerd.grpc.v1 Jan 23 00:07:42.342794 containerd[3084]: time="2026-01-23T00:07:42.342785860Z" level=info msg="loading plugin" id=io.containerd.transfer.v1.local type=io.containerd.transfer.v1 Jan 23 00:07:42.342863 containerd[3084]: time="2026-01-23T00:07:42.342852453Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.transfer type=io.containerd.grpc.v1 Jan 23 00:07:42.342914 containerd[3084]: time="2026-01-23T00:07:42.342903805Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.version type=io.containerd.grpc.v1 Jan 23 00:07:42.342965 containerd[3084]: time="2026-01-23T00:07:42.342954374Z" level=info msg="loading plugin" id=io.containerd.monitor.container.v1.restart type=io.containerd.monitor.container.v1 Jan 23 00:07:42.343052 containerd[3084]: time="2026-01-23T00:07:42.343039416Z" level=info msg="loading plugin" id=io.containerd.tracing.processor.v1.otlp type=io.containerd.tracing.processor.v1 Jan 23 00:07:42.343166 containerd[3084]: time="2026-01-23T00:07:42.343150345Z" 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 Jan 23 00:07:42.343226 containerd[3084]: time="2026-01-23T00:07:42.343214058Z" level=info msg="loading plugin" id=io.containerd.internal.v1.tracing type=io.containerd.internal.v1 Jan 23 00:07:42.343267 containerd[3084]: time="2026-01-23T00:07:42.343256339Z" level=info msg="skip loading plugin" error="skip plugin: tracing endpoint not configured" id=io.containerd.internal.v1.tracing type=io.containerd.internal.v1 Jan 23 00:07:42.343305 containerd[3084]: time="2026-01-23T00:07:42.343295060Z" level=info msg="loading plugin" id=io.containerd.ttrpc.v1.otelttrpc type=io.containerd.ttrpc.v1 Jan 23 00:07:42.344160 containerd[3084]: time="2026-01-23T00:07:42.343385253Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.healthcheck type=io.containerd.grpc.v1 Jan 23 00:07:42.344160 containerd[3084]: time="2026-01-23T00:07:42.343401797Z" level=info msg="loading plugin" id=io.containerd.nri.v1.nri type=io.containerd.nri.v1 Jan 23 00:07:42.344160 containerd[3084]: time="2026-01-23T00:07:42.343417910Z" level=info msg="runtime interface created" Jan 23 00:07:42.344160 containerd[3084]: time="2026-01-23T00:07:42.343421878Z" level=info msg="created NRI interface" Jan 23 00:07:42.344160 containerd[3084]: time="2026-01-23T00:07:42.343427774Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.cri type=io.containerd.grpc.v1 Jan 23 00:07:42.344160 containerd[3084]: time="2026-01-23T00:07:42.343439006Z" level=info msg="Connect containerd service" Jan 23 00:07:42.344160 containerd[3084]: time="2026-01-23T00:07:42.343465878Z" level=info msg="using experimental NRI integration - disable nri plugin to prevent this" Jan 23 00:07:42.344160 containerd[3084]: time="2026-01-23T00:07:42.343940358Z" 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" Jan 23 00:07:42.351657 containerd[3084]: time="2026-01-23T00:07:42.351619678Z" level=info msg=serving... address=/run/containerd/containerd.sock.ttrpc Jan 23 00:07:42.351861 containerd[3084]: time="2026-01-23T00:07:42.351845770Z" level=info msg=serving... address=/run/containerd/containerd.sock Jan 23 00:07:42.351956 containerd[3084]: time="2026-01-23T00:07:42.351787753Z" level=info msg="Start subscribing containerd event" Jan 23 00:07:42.352015 containerd[3084]: time="2026-01-23T00:07:42.352005820Z" level=info msg="Start recovering state" Jan 23 00:07:42.352148 containerd[3084]: time="2026-01-23T00:07:42.352136230Z" level=info msg="Start event monitor" Jan 23 00:07:42.352212 containerd[3084]: time="2026-01-23T00:07:42.352201015Z" level=info msg="Start cni network conf syncer for default" Jan 23 00:07:42.352271 containerd[3084]: time="2026-01-23T00:07:42.352258488Z" level=info msg="Start streaming server" Jan 23 00:07:42.352309 containerd[3084]: time="2026-01-23T00:07:42.352300033Z" level=info msg="Registered namespace \"k8s.io\" with NRI" Jan 23 00:07:42.352343 containerd[3084]: time="2026-01-23T00:07:42.352335641Z" level=info msg="runtime interface starting up..." Jan 23 00:07:42.352376 containerd[3084]: time="2026-01-23T00:07:42.352367594Z" level=info msg="starting plugins..." Jan 23 00:07:42.352414 containerd[3084]: time="2026-01-23T00:07:42.352406362Z" level=info msg="Synchronizing NRI (plugin) with current runtime state" Jan 23 00:07:42.352566 containerd[3084]: time="2026-01-23T00:07:42.352556597Z" level=info msg="containerd successfully booted in 0.045322s" Jan 23 00:07:42.352788 systemd[1]: Started containerd.service - containerd container runtime. Jan 23 00:07:42.355281 systemd[1]: Starting docker.service - Docker Application Container Engine... Jan 23 00:07:42.376547 (dockerd)[3129]: 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 Jan 23 00:07:42.397727 dockerd[3129]: time="2026-01-23T00:07:42.397668799Z" level=info msg="Starting up" Jan 23 00:07:42.398403 dockerd[3129]: time="2026-01-23T00:07:42.398377787Z" level=info msg="OTEL tracing is not configured, using no-op tracer provider" Jan 23 00:07:42.407192 dockerd[3129]: time="2026-01-23T00:07:42.407147284Z" level=info msg="Creating a containerd client" address=/var/run/docker/libcontainerd/docker-containerd.sock timeout=1m0s Jan 23 00:07:42.420835 systemd[1]: var-lib-docker-overlay2-check\x2doverlayfs\x2dsupport4118831046-merged.mount: Deactivated successfully. Jan 23 00:07:42.459795 dockerd[3129]: time="2026-01-23T00:07:42.459750148Z" level=info msg="[graphdriver] using prior storage driver: overlay2" Jan 23 00:07:42.465669 dockerd[3129]: time="2026-01-23T00:07:42.465625784Z" level=info msg="Loading containers: start." Jan 23 00:07:42.544545 systemd[1]: var-lib-docker-overlay2-7b86e9db604717b0d81ee1933ed67aa5223f5bcfb28c23a091147bddd913fac8-merged.mount: Deactivated successfully. Jan 23 00:07:42.901201 systemd-networkd[1490]: vethbba6379: Link DOWN Jan 23 00:07:42.901206 systemd-networkd[1490]: vethbba6379: Lost carrier Jan 23 00:07:42.902107 kernel: docker0: port 1(vethbba6379) entered disabled state Jan 23 00:07:42.909292 kernel: vethbba6379 (unregistering): left allmulticast mode Jan 23 00:07:42.909395 kernel: vethbba6379 (unregistering): left promiscuous mode Jan 23 00:07:42.912870 kernel: docker0: port 1(vethbba6379) entered disabled state Jan 23 00:07:42.915380 systemd-networkd[1490]: docker0: Lost carrier Jan 23 00:07:42.916122 dockerd[3129]: time="2026-01-23T00:07:42.916084050Z" level=info msg="Removing stale sandbox 270a67297a4f170dbdcdc31a54d3234c5f5d4ef93fcd4532359309a035faadff (c8d8ae225b00ca6d32ad5dd6e9ac6048a95402d3a1414c7cfb4bc65f639894d2)" Jan 23 00:07:42.927801 dockerd[3129]: time="2026-01-23T00:07:42.927667447Z" level=warning msg="Failed deleting service host entries to the running container: open : no such file or directory" Jan 23 00:07:42.927801 dockerd[3129]: time="2026-01-23T00:07:42.927730120Z" level=warning msg="Error (Unable to complete atomic operation, key modified) deleting object [endpoint 2a51854d6b77081e82f0130beab04c0f1e98db7e98d4f038d33eebfaa480307f d88c58142dd35b7c4d04ced0a140be0569663bf756f01bbcc7c18d08fc4ba429], retrying...." Jan 23 00:07:43.082116 dockerd[3129]: time="2026-01-23T00:07:43.082053578Z" level=warning msg="error locating sandbox id 8104180ef735924d85ba685de0df18e0fe96547fdf5bc3375c70fdc73d780872: sandbox 8104180ef735924d85ba685de0df18e0fe96547fdf5bc3375c70fdc73d780872 not found" Jan 23 00:07:43.082116 dockerd[3129]: time="2026-01-23T00:07:43.082113179Z" level=warning msg="error locating sandbox id 270a67297a4f170dbdcdc31a54d3234c5f5d4ef93fcd4532359309a035faadff: sandbox 270a67297a4f170dbdcdc31a54d3234c5f5d4ef93fcd4532359309a035faadff not found" Jan 23 00:07:43.082349 dockerd[3129]: time="2026-01-23T00:07:43.082232469Z" level=info msg="Loading containers: done." Jan 23 00:07:43.103825 dockerd[3129]: time="2026-01-23T00:07:43.103770310Z" 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 Jan 23 00:07:43.104035 dockerd[3129]: time="2026-01-23T00:07:43.103871960Z" level=info msg="Docker daemon" commit=6430e49a55babd9b8f4d08e70ecb2b68900770fe containerd-snapshotter=false storage-driver=overlay2 version=28.0.4 Jan 23 00:07:43.104035 dockerd[3129]: time="2026-01-23T00:07:43.103911953Z" level=info msg="Initializing buildkit" Jan 23 00:07:43.114716 dockerd[3129]: time="2026-01-23T00:07:43.114628057Z" level=info msg="Completed buildkit initialization" Jan 23 00:07:43.120182 dockerd[3129]: time="2026-01-23T00:07:43.120065310Z" level=info msg="Daemon has completed initialization" Jan 23 00:07:43.120696 dockerd[3129]: time="2026-01-23T00:07:43.120304409Z" level=info msg="API listen on /run/docker.sock" Jan 23 00:07:43.120426 systemd[1]: Started docker.service - Docker Application Container Engine. Jan 23 00:07:43.191302 systemd[1]: Started sshd@22-10.200.20.31:22-10.200.16.10:55792.service - OpenSSH per-connection server daemon (10.200.16.10:55792). Jan 23 00:07:43.419974 systemd[1]: run-docker-netns-270a67297a4f.mount: Deactivated successfully. Jan 23 00:07:43.685957 sshd[3360]: Accepted publickey for core from 10.200.16.10 port 55792 ssh2: RSA SHA256:kRQEAzNVhqU4Fmpx84sKU93gp2nZjfuJ8Tlyw3EYXBc Jan 23 00:07:43.687188 sshd-session[3360]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Jan 23 00:07:43.690966 systemd-logind[1792]: New session 25 of user core. Jan 23 00:07:43.699279 systemd[1]: Started session-25.scope - Session 25 of User core. Jan 23 00:07:44.038281 sshd[3363]: Connection closed by 10.200.16.10 port 55792 Jan 23 00:07:44.038876 sshd-session[3360]: pam_unix(sshd:session): session closed for user core Jan 23 00:07:44.042712 systemd[1]: sshd@22-10.200.20.31:22-10.200.16.10:55792.service: Deactivated successfully. Jan 23 00:07:44.044220 systemd[1]: session-25.scope: Deactivated successfully. Jan 23 00:07:44.044829 systemd-logind[1792]: Session 25 logged out. Waiting for processes to exit. Jan 23 00:07:44.046140 systemd-logind[1792]: Removed session 25. Jan 23 00:07:44.130163 systemd[1]: Started sshd@23-10.200.20.31:22-10.200.16.10:55794.service - OpenSSH per-connection server daemon (10.200.16.10:55794). Jan 23 00:07:44.625941 sshd[3369]: Accepted publickey for core from 10.200.16.10 port 55794 ssh2: RSA SHA256:kRQEAzNVhqU4Fmpx84sKU93gp2nZjfuJ8Tlyw3EYXBc Jan 23 00:07:44.626728 sshd-session[3369]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Jan 23 00:07:44.630510 systemd-logind[1792]: New session 26 of user core. Jan 23 00:07:44.638237 systemd[1]: Started session-26.scope - Session 26 of User core. Jan 23 00:07:44.979175 sshd[3372]: Connection closed by 10.200.16.10 port 55794 Jan 23 00:07:44.979050 sshd-session[3369]: pam_unix(sshd:session): session closed for user core Jan 23 00:07:44.982012 systemd[1]: sshd@23-10.200.20.31:22-10.200.16.10:55794.service: Deactivated successfully. Jan 23 00:07:44.983411 systemd[1]: session-26.scope: Deactivated successfully. Jan 23 00:07:44.984404 systemd-logind[1792]: Session 26 logged out. Waiting for processes to exit. Jan 23 00:07:44.986269 systemd-logind[1792]: Removed session 26. Jan 23 00:07:45.061299 systemd[1]: Started sshd@24-10.200.20.31:22-10.200.16.10:55800.service - OpenSSH per-connection server daemon (10.200.16.10:55800). Jan 23 00:07:45.531015 sshd[3378]: Accepted publickey for core from 10.200.16.10 port 55800 ssh2: RSA SHA256:kRQEAzNVhqU4Fmpx84sKU93gp2nZjfuJ8Tlyw3EYXBc Jan 23 00:07:45.532042 sshd-session[3378]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Jan 23 00:07:45.535687 systemd-logind[1792]: New session 27 of user core. Jan 23 00:07:45.545225 systemd[1]: Started session-27.scope - Session 27 of User core. Jan 23 00:07:45.866838 sshd[3381]: Connection closed by 10.200.16.10 port 55800 Jan 23 00:07:45.867498 sshd-session[3378]: pam_unix(sshd:session): session closed for user core Jan 23 00:07:45.871003 systemd-logind[1792]: Session 27 logged out. Waiting for processes to exit. Jan 23 00:07:45.871340 systemd[1]: sshd@24-10.200.20.31:22-10.200.16.10:55800.service: Deactivated successfully. Jan 23 00:07:45.872834 systemd[1]: session-27.scope: Deactivated successfully. Jan 23 00:07:45.875585 systemd-logind[1792]: Removed session 27. Jan 23 00:07:45.962613 systemd[1]: Started sshd@25-10.200.20.31:22-10.200.16.10:55816.service - OpenSSH per-connection server daemon (10.200.16.10:55816). Jan 23 00:07:46.465409 sshd[3393]: Accepted publickey for core from 10.200.16.10 port 55816 ssh2: RSA SHA256:kRQEAzNVhqU4Fmpx84sKU93gp2nZjfuJ8Tlyw3EYXBc Jan 23 00:07:46.466419 sshd-session[3393]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Jan 23 00:07:46.469775 systemd-logind[1792]: New session 28 of user core. Jan 23 00:07:46.473193 systemd[1]: Started session-28.scope - Session 28 of User core. Jan 23 00:07:46.876641 containerd[3084]: time="2026-01-23T00:07:46.876468747Z" level=info msg="connecting to shim b334a7f104687051d1676da9de0ab9df75abaf8128c591f3119aad7eb4671a16" address="unix:///run/containerd/s/3ff2603dae159bfcce4f6b7a3c78dd4eaba320ad000cefc9fd509ff21c41f414" namespace=moby protocol=ttrpc version=3 Jan 23 00:07:46.897213 systemd[1]: Started docker-b334a7f104687051d1676da9de0ab9df75abaf8128c591f3119aad7eb4671a16.scope - libcontainer container b334a7f104687051d1676da9de0ab9df75abaf8128c591f3119aad7eb4671a16. Jan 23 00:07:46.926838 kernel: docker0: port 1(veth9845319) entered blocking state Jan 23 00:07:46.926936 kernel: docker0: port 1(veth9845319) entered disabled state Jan 23 00:07:46.929765 kernel: veth9845319: entered allmulticast mode Jan 23 00:07:46.932576 kernel: veth9845319: entered promiscuous mode Jan 23 00:07:46.933544 systemd-networkd[1490]: veth9845319: Link UP Jan 23 00:07:46.958881 kernel: eth0: renamed from veth596222b Jan 23 00:07:46.958963 kernel: docker0: port 1(veth9845319) entered blocking state Jan 23 00:07:46.958976 kernel: docker0: port 1(veth9845319) entered forwarding state Jan 23 00:07:46.958675 systemd-networkd[1490]: veth9845319: Gained carrier Jan 23 00:07:46.959361 systemd-networkd[1490]: docker0: Gained carrier Jan 23 00:07:47.073488 sshd[3396]: Connection closed by 10.200.16.10 port 55816 Jan 23 00:07:47.072741 sshd-session[3393]: pam_unix(sshd:session): session closed for user core Jan 23 00:07:47.076224 systemd[1]: sshd@25-10.200.20.31:22-10.200.16.10:55816.service: Deactivated successfully. Jan 23 00:07:47.077489 systemd[1]: session-28.scope: Deactivated successfully. Jan 23 00:07:47.078057 systemd-logind[1792]: Session 28 logged out. Waiting for processes to exit. Jan 23 00:07:47.079119 systemd-logind[1792]: Removed session 28. Jan 23 00:07:48.904461 systemd-networkd[1490]: veth9845319: Gained IPv6LL