Aug 13 07:08:44.349897 kernel: Booting Linux on physical CPU 0x0000000000 [0x413fd0c1] Aug 13 07:08:44.349918 kernel: Linux version 6.6.100-flatcar (build@pony-truck.infra.kinvolk.io) (aarch64-cros-linux-gnu-gcc (Gentoo Hardened 14.2.1_p20241221 p7) 14.2.1 20241221, GNU ld (Gentoo 2.43 p3) 2.43.1) #1 SMP PREEMPT Tue Aug 12 21:42:02 -00 2025 Aug 13 07:08:44.349927 kernel: KASLR enabled Aug 13 07:08:44.349933 kernel: earlycon: pl11 at MMIO 0x00000000effec000 (options '') Aug 13 07:08:44.349940 kernel: printk: bootconsole [pl11] enabled Aug 13 07:08:44.349946 kernel: efi: EFI v2.7 by EDK II Aug 13 07:08:44.349953 kernel: efi: ACPI 2.0=0x3fd5f018 SMBIOS=0x3e580000 SMBIOS 3.0=0x3e560000 MEMATTR=0x3f20e698 RNG=0x3fd5f998 MEMRESERVE=0x3e477598 Aug 13 07:08:44.349960 kernel: random: crng init done Aug 13 07:08:44.349966 kernel: secureboot: Secure boot disabled Aug 13 07:08:44.349972 kernel: ACPI: Early table checksum verification disabled Aug 13 07:08:44.349978 kernel: ACPI: RSDP 0x000000003FD5F018 000024 (v02 VRTUAL) Aug 13 07:08:44.349984 kernel: ACPI: XSDT 0x000000003FD5FF18 00006C (v01 VRTUAL MICROSFT 00000001 MSFT 00000001) Aug 13 07:08:44.349990 kernel: ACPI: FACP 0x000000003FD5FC18 000114 (v06 VRTUAL MICROSFT 00000001 MSFT 00000001) Aug 13 07:08:44.349998 kernel: ACPI: DSDT 0x000000003FD41018 01DFCD (v02 MSFTVM DSDT01 00000001 INTL 20230628) Aug 13 07:08:44.350006 kernel: ACPI: DBG2 0x000000003FD5FB18 000072 (v00 VRTUAL MICROSFT 00000001 MSFT 00000001) Aug 13 07:08:44.350012 kernel: ACPI: GTDT 0x000000003FD5FD98 000060 (v02 VRTUAL MICROSFT 00000001 MSFT 00000001) Aug 13 07:08:44.350019 kernel: ACPI: OEM0 0x000000003FD5F098 000064 (v01 VRTUAL MICROSFT 00000001 MSFT 00000001) Aug 13 07:08:44.350027 kernel: ACPI: SPCR 0x000000003FD5FA98 000050 (v02 VRTUAL MICROSFT 00000001 MSFT 00000001) Aug 13 07:08:44.350034 kernel: ACPI: APIC 0x000000003FD5F818 0000FC (v04 VRTUAL MICROSFT 00000001 MSFT 00000001) Aug 13 07:08:44.350040 kernel: ACPI: SRAT 0x000000003FD5F198 000234 (v03 VRTUAL MICROSFT 00000001 MSFT 00000001) Aug 13 07:08:44.350047 kernel: ACPI: PPTT 0x000000003FD5F418 000120 (v01 VRTUAL MICROSFT 00000000 MSFT 00000000) Aug 13 07:08:44.350054 kernel: ACPI: BGRT 0x000000003FD5FE98 000038 (v01 VRTUAL MICROSFT 00000001 MSFT 00000001) Aug 13 07:08:44.350060 kernel: ACPI: SPCR: console: pl011,mmio32,0xeffec000,115200 Aug 13 07:08:44.350067 kernel: ACPI: SRAT: Node 0 PXM 0 [mem 0x00000000-0x3fffffff] Aug 13 07:08:44.350073 kernel: ACPI: SRAT: Node 0 PXM 0 [mem 0x100000000-0x1bfffffff] Aug 13 07:08:44.350080 kernel: ACPI: SRAT: Node 0 PXM 0 [mem 0x1c0000000-0xfbfffffff] Aug 13 07:08:44.350086 kernel: ACPI: SRAT: Node 0 PXM 0 [mem 0x1000000000-0xffffffffff] Aug 13 07:08:44.350093 kernel: ACPI: SRAT: Node 0 PXM 0 [mem 0x10000000000-0x1ffffffffff] Aug 13 07:08:44.350101 kernel: ACPI: SRAT: Node 0 PXM 0 [mem 0x20000000000-0x3ffffffffff] Aug 13 07:08:44.350107 kernel: ACPI: SRAT: Node 0 PXM 0 [mem 0x40000000000-0x7ffffffffff] Aug 13 07:08:44.350114 kernel: ACPI: SRAT: Node 0 PXM 0 [mem 0x80000000000-0xfffffffffff] Aug 13 07:08:44.350120 kernel: ACPI: SRAT: Node 0 PXM 0 [mem 0x100000000000-0x1fffffffffff] Aug 13 07:08:44.350127 kernel: ACPI: SRAT: Node 0 PXM 0 [mem 0x200000000000-0x3fffffffffff] Aug 13 07:08:44.350134 kernel: ACPI: SRAT: Node 0 PXM 0 [mem 0x400000000000-0x7fffffffffff] Aug 13 07:08:44.350140 kernel: ACPI: SRAT: Node 0 PXM 0 [mem 0x800000000000-0xffffffffffff] Aug 13 07:08:44.350146 kernel: NUMA: NODE_DATA [mem 0x1bf7ef800-0x1bf7f4fff] Aug 13 07:08:44.350153 kernel: Zone ranges: Aug 13 07:08:44.350160 kernel: DMA [mem 0x0000000000000000-0x00000000ffffffff] Aug 13 07:08:44.350166 kernel: DMA32 empty Aug 13 07:08:44.350173 kernel: Normal [mem 0x0000000100000000-0x00000001bfffffff] Aug 13 07:08:44.350184 kernel: Movable zone start for each node Aug 13 07:08:44.350191 kernel: Early memory node ranges Aug 13 07:08:44.350198 kernel: node 0: [mem 0x0000000000000000-0x00000000007fffff] Aug 13 07:08:44.350205 kernel: node 0: [mem 0x0000000000824000-0x000000003e45ffff] Aug 13 07:08:44.350212 kernel: node 0: [mem 0x000000003e460000-0x000000003e46ffff] Aug 13 07:08:44.350220 kernel: node 0: [mem 0x000000003e470000-0x000000003e54ffff] Aug 13 07:08:44.350227 kernel: node 0: [mem 0x000000003e550000-0x000000003e87ffff] Aug 13 07:08:44.350234 kernel: node 0: [mem 0x000000003e880000-0x000000003fc7ffff] Aug 13 07:08:44.350241 kernel: node 0: [mem 0x000000003fc80000-0x000000003fcfffff] Aug 13 07:08:44.350247 kernel: node 0: [mem 0x000000003fd00000-0x000000003fffffff] Aug 13 07:08:44.350255 kernel: node 0: [mem 0x0000000100000000-0x00000001bfffffff] Aug 13 07:08:44.350262 kernel: Initmem setup node 0 [mem 0x0000000000000000-0x00000001bfffffff] Aug 13 07:08:44.350276 kernel: On node 0, zone DMA: 36 pages in unavailable ranges Aug 13 07:08:44.350283 kernel: psci: probing for conduit method from ACPI. Aug 13 07:08:44.350290 kernel: psci: PSCIv1.1 detected in firmware. Aug 13 07:08:44.350297 kernel: psci: Using standard PSCI v0.2 function IDs Aug 13 07:08:44.350304 kernel: psci: MIGRATE_INFO_TYPE not supported. Aug 13 07:08:44.350313 kernel: psci: SMC Calling Convention v1.4 Aug 13 07:08:44.350320 kernel: ACPI: NUMA: SRAT: PXM 0 -> MPIDR 0x0 -> Node 0 Aug 13 07:08:44.350327 kernel: ACPI: NUMA: SRAT: PXM 0 -> MPIDR 0x1 -> Node 0 Aug 13 07:08:44.350334 kernel: percpu: Embedded 31 pages/cpu s86696 r8192 d32088 u126976 Aug 13 07:08:44.350341 kernel: pcpu-alloc: s86696 r8192 d32088 u126976 alloc=31*4096 Aug 13 07:08:44.350348 kernel: pcpu-alloc: [0] 0 [0] 1 Aug 13 07:08:44.350355 kernel: Detected PIPT I-cache on CPU0 Aug 13 07:08:44.350362 kernel: CPU features: detected: GIC system register CPU interface Aug 13 07:08:44.352403 kernel: CPU features: detected: Hardware dirty bit management Aug 13 07:08:44.352418 kernel: CPU features: detected: Spectre-BHB Aug 13 07:08:44.352426 kernel: CPU features: kernel page table isolation forced ON by KASLR Aug 13 07:08:44.352437 kernel: CPU features: detected: Kernel page table isolation (KPTI) Aug 13 07:08:44.352444 kernel: CPU features: detected: ARM erratum 1418040 Aug 13 07:08:44.352451 kernel: CPU features: detected: ARM erratum 1542419 (kernel portion) Aug 13 07:08:44.352459 kernel: CPU features: detected: SSBS not fully self-synchronizing Aug 13 07:08:44.352466 kernel: alternatives: applying boot alternatives Aug 13 07:08:44.352474 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=c44ba8b4c0c81c1bcadc13a1606b9de202ee4e4226c47e1c865eaa5fc436b169 Aug 13 07:08:44.352483 kernel: Unknown kernel command line parameters "BOOT_IMAGE=/flatcar/vmlinuz-a", will be passed to user space. Aug 13 07:08:44.352490 kernel: Dentry cache hash table entries: 524288 (order: 10, 4194304 bytes, linear) Aug 13 07:08:44.352497 kernel: Inode-cache hash table entries: 262144 (order: 9, 2097152 bytes, linear) Aug 13 07:08:44.352504 kernel: Fallback order for Node 0: 0 Aug 13 07:08:44.352511 kernel: Built 1 zonelists, mobility grouping on. Total pages: 1032156 Aug 13 07:08:44.352519 kernel: Policy zone: Normal Aug 13 07:08:44.352526 kernel: mem auto-init: stack:off, heap alloc:off, heap free:off Aug 13 07:08:44.352533 kernel: software IO TLB: area num 2. Aug 13 07:08:44.352540 kernel: software IO TLB: mapped [mem 0x0000000036530000-0x000000003a530000] (64MB) Aug 13 07:08:44.352547 kernel: Memory: 3983528K/4194160K available (10368K kernel code, 2186K rwdata, 8104K rodata, 38400K init, 897K bss, 210632K reserved, 0K cma-reserved) Aug 13 07:08:44.352554 kernel: SLUB: HWalign=64, Order=0-3, MinObjects=0, CPUs=2, Nodes=1 Aug 13 07:08:44.352561 kernel: rcu: Preemptible hierarchical RCU implementation. Aug 13 07:08:44.352568 kernel: rcu: RCU event tracing is enabled. Aug 13 07:08:44.352576 kernel: rcu: RCU restricting CPUs from NR_CPUS=512 to nr_cpu_ids=2. Aug 13 07:08:44.352583 kernel: Trampoline variant of Tasks RCU enabled. Aug 13 07:08:44.352590 kernel: Tracing variant of Tasks RCU enabled. Aug 13 07:08:44.352599 kernel: rcu: RCU calculated value of scheduler-enlistment delay is 100 jiffies. Aug 13 07:08:44.352606 kernel: rcu: Adjusting geometry for rcu_fanout_leaf=16, nr_cpu_ids=2 Aug 13 07:08:44.352613 kernel: NR_IRQS: 64, nr_irqs: 64, preallocated irqs: 0 Aug 13 07:08:44.352620 kernel: GICv3: 960 SPIs implemented Aug 13 07:08:44.352627 kernel: GICv3: 0 Extended SPIs implemented Aug 13 07:08:44.352634 kernel: Root IRQ handler: gic_handle_irq Aug 13 07:08:44.352641 kernel: GICv3: GICv3 features: 16 PPIs, DirectLPI Aug 13 07:08:44.352648 kernel: GICv3: CPU0: found redistributor 0 region 0:0x00000000effee000 Aug 13 07:08:44.352655 kernel: ITS: No ITS available, not enabling LPIs Aug 13 07:08:44.352662 kernel: rcu: srcu_init: Setting srcu_struct sizes based on contention. Aug 13 07:08:44.352669 kernel: arch_timer: Enabling local workaround for ARM erratum 1418040 Aug 13 07:08:44.352676 kernel: arch_timer: cp15 timer(s) running at 25.00MHz (virt). Aug 13 07:08:44.352685 kernel: clocksource: arch_sys_counter: mask: 0xffffffffffffff max_cycles: 0x5c40939b5, max_idle_ns: 440795202646 ns Aug 13 07:08:44.352693 kernel: sched_clock: 56 bits at 25MHz, resolution 40ns, wraps every 4398046511100ns Aug 13 07:08:44.352701 kernel: Console: colour dummy device 80x25 Aug 13 07:08:44.352710 kernel: printk: console [tty1] enabled Aug 13 07:08:44.352718 kernel: ACPI: Core revision 20230628 Aug 13 07:08:44.352727 kernel: Calibrating delay loop (skipped), value calculated using timer frequency.. 50.00 BogoMIPS (lpj=25000) Aug 13 07:08:44.352736 kernel: pid_max: default: 32768 minimum: 301 Aug 13 07:08:44.352744 kernel: LSM: initializing lsm=lockdown,capability,landlock,selinux,integrity Aug 13 07:08:44.352753 kernel: landlock: Up and running. Aug 13 07:08:44.352764 kernel: SELinux: Initializing. Aug 13 07:08:44.352773 kernel: Mount-cache hash table entries: 8192 (order: 4, 65536 bytes, linear) Aug 13 07:08:44.352782 kernel: Mountpoint-cache hash table entries: 8192 (order: 4, 65536 bytes, linear) Aug 13 07:08:44.352791 kernel: RCU Tasks: Setting shift to 1 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=2. Aug 13 07:08:44.352799 kernel: RCU Tasks Trace: Setting shift to 1 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=2. Aug 13 07:08:44.352808 kernel: Hyper-V: privilege flags low 0x2e7f, high 0x3a8030, hints 0xe, misc 0x31e1 Aug 13 07:08:44.352816 kernel: Hyper-V: Host Build 10.0.22477.1619-1-0 Aug 13 07:08:44.352833 kernel: Hyper-V: enabling crash_kexec_post_notifiers Aug 13 07:08:44.352842 kernel: rcu: Hierarchical SRCU implementation. Aug 13 07:08:44.352850 kernel: rcu: Max phase no-delay instances is 400. Aug 13 07:08:44.352858 kernel: Remapping and enabling EFI services. Aug 13 07:08:44.352866 kernel: smp: Bringing up secondary CPUs ... Aug 13 07:08:44.352876 kernel: Detected PIPT I-cache on CPU1 Aug 13 07:08:44.352885 kernel: GICv3: CPU1: found redistributor 1 region 1:0x00000000f000e000 Aug 13 07:08:44.352895 kernel: arch_timer: Enabling local workaround for ARM erratum 1418040 Aug 13 07:08:44.352904 kernel: CPU1: Booted secondary processor 0x0000000001 [0x413fd0c1] Aug 13 07:08:44.352912 kernel: smp: Brought up 1 node, 2 CPUs Aug 13 07:08:44.352923 kernel: SMP: Total of 2 processors activated. Aug 13 07:08:44.352932 kernel: CPU features: detected: 32-bit EL0 Support Aug 13 07:08:44.352942 kernel: CPU features: detected: Instruction cache invalidation not required for I/D coherence Aug 13 07:08:44.352951 kernel: CPU features: detected: Data cache clean to the PoU not required for I/D coherence Aug 13 07:08:44.352960 kernel: CPU features: detected: CRC32 instructions Aug 13 07:08:44.352968 kernel: CPU features: detected: RCpc load-acquire (LDAPR) Aug 13 07:08:44.352976 kernel: CPU features: detected: LSE atomic instructions Aug 13 07:08:44.352983 kernel: CPU features: detected: Privileged Access Never Aug 13 07:08:44.352991 kernel: CPU: All CPU(s) started at EL1 Aug 13 07:08:44.353000 kernel: alternatives: applying system-wide alternatives Aug 13 07:08:44.353008 kernel: devtmpfs: initialized Aug 13 07:08:44.353015 kernel: clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1911260446275000 ns Aug 13 07:08:44.353023 kernel: futex hash table entries: 512 (order: 3, 32768 bytes, linear) Aug 13 07:08:44.353031 kernel: pinctrl core: initialized pinctrl subsystem Aug 13 07:08:44.353038 kernel: SMBIOS 3.1.0 present. Aug 13 07:08:44.353046 kernel: DMI: Microsoft Corporation Virtual Machine/Virtual Machine, BIOS Hyper-V UEFI Release v4.1 09/28/2024 Aug 13 07:08:44.353054 kernel: NET: Registered PF_NETLINK/PF_ROUTE protocol family Aug 13 07:08:44.353061 kernel: DMA: preallocated 512 KiB GFP_KERNEL pool for atomic allocations Aug 13 07:08:44.353071 kernel: DMA: preallocated 512 KiB GFP_KERNEL|GFP_DMA pool for atomic allocations Aug 13 07:08:44.353078 kernel: DMA: preallocated 512 KiB GFP_KERNEL|GFP_DMA32 pool for atomic allocations Aug 13 07:08:44.353086 kernel: audit: initializing netlink subsys (disabled) Aug 13 07:08:44.353094 kernel: audit: type=2000 audit(0.046:1): state=initialized audit_enabled=0 res=1 Aug 13 07:08:44.353102 kernel: thermal_sys: Registered thermal governor 'step_wise' Aug 13 07:08:44.353110 kernel: cpuidle: using governor menu Aug 13 07:08:44.353117 kernel: hw-breakpoint: found 6 breakpoint and 4 watchpoint registers. Aug 13 07:08:44.353125 kernel: ASID allocator initialised with 32768 entries Aug 13 07:08:44.353133 kernel: acpiphp: ACPI Hot Plug PCI Controller Driver version: 0.5 Aug 13 07:08:44.353142 kernel: Serial: AMBA PL011 UART driver Aug 13 07:08:44.353150 kernel: Modules: 2G module region forced by RANDOMIZE_MODULE_REGION_FULL Aug 13 07:08:44.353157 kernel: Modules: 0 pages in range for non-PLT usage Aug 13 07:08:44.353165 kernel: Modules: 509248 pages in range for PLT usage Aug 13 07:08:44.353173 kernel: HugeTLB: registered 1.00 GiB page size, pre-allocated 0 pages Aug 13 07:08:44.353181 kernel: HugeTLB: 0 KiB vmemmap can be freed for a 1.00 GiB page Aug 13 07:08:44.353188 kernel: HugeTLB: registered 32.0 MiB page size, pre-allocated 0 pages Aug 13 07:08:44.353196 kernel: HugeTLB: 0 KiB vmemmap can be freed for a 32.0 MiB page Aug 13 07:08:44.353204 kernel: HugeTLB: registered 2.00 MiB page size, pre-allocated 0 pages Aug 13 07:08:44.353213 kernel: HugeTLB: 0 KiB vmemmap can be freed for a 2.00 MiB page Aug 13 07:08:44.353221 kernel: HugeTLB: registered 64.0 KiB page size, pre-allocated 0 pages Aug 13 07:08:44.353228 kernel: HugeTLB: 0 KiB vmemmap can be freed for a 64.0 KiB page Aug 13 07:08:44.353236 kernel: ACPI: Added _OSI(Module Device) Aug 13 07:08:44.353243 kernel: ACPI: Added _OSI(Processor Device) Aug 13 07:08:44.353251 kernel: ACPI: Added _OSI(Processor Aggregator Device) Aug 13 07:08:44.353258 kernel: ACPI: 1 ACPI AML tables successfully acquired and loaded Aug 13 07:08:44.353266 kernel: ACPI: Interpreter enabled Aug 13 07:08:44.353273 kernel: ACPI: Using GIC for interrupt routing Aug 13 07:08:44.353282 kernel: ARMH0011:00: ttyAMA0 at MMIO 0xeffec000 (irq = 12, base_baud = 0) is a SBSA Aug 13 07:08:44.353290 kernel: printk: console [ttyAMA0] enabled Aug 13 07:08:44.353297 kernel: printk: bootconsole [pl11] disabled Aug 13 07:08:44.353305 kernel: ARMH0011:01: ttyAMA1 at MMIO 0xeffeb000 (irq = 13, base_baud = 0) is a SBSA Aug 13 07:08:44.353313 kernel: iommu: Default domain type: Translated Aug 13 07:08:44.353320 kernel: iommu: DMA domain TLB invalidation policy: strict mode Aug 13 07:08:44.353328 kernel: efivars: Registered efivars operations Aug 13 07:08:44.353335 kernel: vgaarb: loaded Aug 13 07:08:44.353343 kernel: clocksource: Switched to clocksource arch_sys_counter Aug 13 07:08:44.353352 kernel: VFS: Disk quotas dquot_6.6.0 Aug 13 07:08:44.353360 kernel: VFS: Dquot-cache hash table entries: 512 (order 0, 4096 bytes) Aug 13 07:08:44.353378 kernel: pnp: PnP ACPI init Aug 13 07:08:44.353387 kernel: pnp: PnP ACPI: found 0 devices Aug 13 07:08:44.353395 kernel: NET: Registered PF_INET protocol family Aug 13 07:08:44.353402 kernel: IP idents hash table entries: 65536 (order: 7, 524288 bytes, linear) Aug 13 07:08:44.353410 kernel: tcp_listen_portaddr_hash hash table entries: 2048 (order: 3, 32768 bytes, linear) Aug 13 07:08:44.353418 kernel: Table-perturb hash table entries: 65536 (order: 6, 262144 bytes, linear) Aug 13 07:08:44.353426 kernel: TCP established hash table entries: 32768 (order: 6, 262144 bytes, linear) Aug 13 07:08:44.353441 kernel: TCP bind hash table entries: 32768 (order: 8, 1048576 bytes, linear) Aug 13 07:08:44.353449 kernel: TCP: Hash tables configured (established 32768 bind 32768) Aug 13 07:08:44.353456 kernel: UDP hash table entries: 2048 (order: 4, 65536 bytes, linear) Aug 13 07:08:44.353464 kernel: UDP-Lite hash table entries: 2048 (order: 4, 65536 bytes, linear) Aug 13 07:08:44.353472 kernel: NET: Registered PF_UNIX/PF_LOCAL protocol family Aug 13 07:08:44.353479 kernel: PCI: CLS 0 bytes, default 64 Aug 13 07:08:44.353487 kernel: kvm [1]: HYP mode not available Aug 13 07:08:44.353494 kernel: Initialise system trusted keyrings Aug 13 07:08:44.353502 kernel: workingset: timestamp_bits=39 max_order=20 bucket_order=0 Aug 13 07:08:44.353511 kernel: Key type asymmetric registered Aug 13 07:08:44.353519 kernel: Asymmetric key parser 'x509' registered Aug 13 07:08:44.353526 kernel: Block layer SCSI generic (bsg) driver version 0.4 loaded (major 250) Aug 13 07:08:44.353534 kernel: io scheduler mq-deadline registered Aug 13 07:08:44.353541 kernel: io scheduler kyber registered Aug 13 07:08:44.353549 kernel: io scheduler bfq registered Aug 13 07:08:44.353556 kernel: Serial: 8250/16550 driver, 4 ports, IRQ sharing enabled Aug 13 07:08:44.353564 kernel: thunder_xcv, ver 1.0 Aug 13 07:08:44.353572 kernel: thunder_bgx, ver 1.0 Aug 13 07:08:44.353581 kernel: nicpf, ver 1.0 Aug 13 07:08:44.353589 kernel: nicvf, ver 1.0 Aug 13 07:08:44.353736 kernel: rtc-efi rtc-efi.0: registered as rtc0 Aug 13 07:08:44.353815 kernel: rtc-efi rtc-efi.0: setting system clock to 2025-08-13T07:08:43 UTC (1755068923) Aug 13 07:08:44.353826 kernel: efifb: probing for efifb Aug 13 07:08:44.353834 kernel: efifb: framebuffer at 0x40000000, using 3072k, total 3072k Aug 13 07:08:44.353841 kernel: efifb: mode is 1024x768x32, linelength=4096, pages=1 Aug 13 07:08:44.353849 kernel: efifb: scrolling: redraw Aug 13 07:08:44.353859 kernel: efifb: Truecolor: size=8:8:8:8, shift=24:16:8:0 Aug 13 07:08:44.353867 kernel: Console: switching to colour frame buffer device 128x48 Aug 13 07:08:44.353874 kernel: fb0: EFI VGA frame buffer device Aug 13 07:08:44.353881 kernel: SMCCC: SOC_ID: ARCH_SOC_ID not implemented, skipping .... Aug 13 07:08:44.353889 kernel: hid: raw HID events driver (C) Jiri Kosina Aug 13 07:08:44.353897 kernel: No ACPI PMU IRQ for CPU0 Aug 13 07:08:44.353904 kernel: No ACPI PMU IRQ for CPU1 Aug 13 07:08:44.353911 kernel: hw perfevents: enabled with armv8_pmuv3_0 PMU driver, 1 counters available Aug 13 07:08:44.353919 kernel: watchdog: Delayed init of the lockup detector failed: -19 Aug 13 07:08:44.353928 kernel: watchdog: Hard watchdog permanently disabled Aug 13 07:08:44.353936 kernel: NET: Registered PF_INET6 protocol family Aug 13 07:08:44.353944 kernel: Segment Routing with IPv6 Aug 13 07:08:44.353951 kernel: In-situ OAM (IOAM) with IPv6 Aug 13 07:08:44.353959 kernel: NET: Registered PF_PACKET protocol family Aug 13 07:08:44.353966 kernel: Key type dns_resolver registered Aug 13 07:08:44.353974 kernel: registered taskstats version 1 Aug 13 07:08:44.353981 kernel: Loading compiled-in X.509 certificates Aug 13 07:08:44.353989 kernel: Loaded X.509 cert 'Kinvolk GmbH: Module signing key for 6.6.100-flatcar: b805f03ae64b71ea1aa3cf76d07ec816116f6d0c' Aug 13 07:08:44.353998 kernel: Key type .fscrypt registered Aug 13 07:08:44.354005 kernel: Key type fscrypt-provisioning registered Aug 13 07:08:44.354013 kernel: ima: No TPM chip found, activating TPM-bypass! Aug 13 07:08:44.354020 kernel: ima: Allocated hash algorithm: sha1 Aug 13 07:08:44.354028 kernel: ima: No architecture policies found Aug 13 07:08:44.354035 kernel: alg: No test for fips(ansi_cprng) (fips_ansi_cprng) Aug 13 07:08:44.354043 kernel: clk: Disabling unused clocks Aug 13 07:08:44.354050 kernel: Freeing unused kernel memory: 38400K Aug 13 07:08:44.354058 kernel: Run /init as init process Aug 13 07:08:44.354067 kernel: with arguments: Aug 13 07:08:44.354075 kernel: /init Aug 13 07:08:44.354082 kernel: with environment: Aug 13 07:08:44.354089 kernel: HOME=/ Aug 13 07:08:44.354100 kernel: TERM=linux Aug 13 07:08:44.354110 kernel: BOOT_IMAGE=/flatcar/vmlinuz-a Aug 13 07:08:44.354119 systemd[1]: Successfully made /usr/ read-only. Aug 13 07:08:44.354129 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) Aug 13 07:08:44.354140 systemd[1]: Detected virtualization microsoft. Aug 13 07:08:44.354148 systemd[1]: Detected architecture arm64. Aug 13 07:08:44.354156 systemd[1]: Running in initrd. Aug 13 07:08:44.354164 systemd[1]: No hostname configured, using default hostname. Aug 13 07:08:44.354172 systemd[1]: Hostname set to . Aug 13 07:08:44.354180 systemd[1]: Initializing machine ID from random generator. Aug 13 07:08:44.354188 systemd[1]: Queued start job for default target initrd.target. Aug 13 07:08:44.354197 systemd[1]: Started clevis-luks-askpass.path - Forward Password Requests to Clevis Directory Watch. Aug 13 07:08:44.354207 systemd[1]: Started systemd-ask-password-console.path - Dispatch Password Requests to Console Directory Watch. Aug 13 07:08:44.354216 systemd[1]: Expecting device dev-disk-by\x2dlabel-EFI\x2dSYSTEM.device - /dev/disk/by-label/EFI-SYSTEM... Aug 13 07:08:44.354224 systemd[1]: Expecting device dev-disk-by\x2dlabel-OEM.device - /dev/disk/by-label/OEM... Aug 13 07:08:44.354233 systemd[1]: Expecting device dev-disk-by\x2dlabel-ROOT.device - /dev/disk/by-label/ROOT... Aug 13 07:08:44.354241 systemd[1]: Expecting device dev-disk-by\x2dpartlabel-USR\x2dA.device - /dev/disk/by-partlabel/USR-A... Aug 13 07:08:44.354251 systemd[1]: Expecting device dev-disk-by\x2dpartuuid-7130c94a\x2d213a\x2d4e5a\x2d8e26\x2d6cce9662f132.device - /dev/disk/by-partuuid/7130c94a-213a-4e5a-8e26-6cce9662f132... Aug 13 07:08:44.354260 systemd[1]: Expecting device dev-mapper-usr.device - /dev/mapper/usr... Aug 13 07:08:44.354276 systemd[1]: Reached target cryptsetup-pre.target - Local Encrypted Volumes (Pre). Aug 13 07:08:44.354287 systemd[1]: Reached target cryptsetup.target - Local Encrypted Volumes. Aug 13 07:08:44.354295 systemd[1]: Reached target paths.target - Path Units. Aug 13 07:08:44.354303 systemd[1]: Reached target slices.target - Slice Units. Aug 13 07:08:44.354311 systemd[1]: Reached target swap.target - Swaps. Aug 13 07:08:44.354322 systemd[1]: Reached target timers.target - Timer Units. Aug 13 07:08:44.354332 systemd[1]: Listening on iscsid.socket - Open-iSCSI iscsid Socket. Aug 13 07:08:44.354341 systemd[1]: Listening on iscsiuio.socket - Open-iSCSI iscsiuio Socket. Aug 13 07:08:44.354352 systemd[1]: Listening on systemd-journald-dev-log.socket - Journal Socket (/dev/log). Aug 13 07:08:44.354360 systemd[1]: Listening on systemd-journald.socket - Journal Sockets. Aug 13 07:08:44.356403 systemd[1]: Listening on systemd-networkd.socket - Network Service Netlink Socket. Aug 13 07:08:44.356418 systemd[1]: Listening on systemd-udevd-control.socket - udev Control Socket. Aug 13 07:08:44.356428 systemd[1]: Listening on systemd-udevd-kernel.socket - udev Kernel Socket. Aug 13 07:08:44.356436 systemd[1]: Reached target sockets.target - Socket Units. Aug 13 07:08:44.356445 systemd[1]: Starting ignition-setup-pre.service - Ignition env setup... Aug 13 07:08:44.356454 systemd[1]: Starting kmod-static-nodes.service - Create List of Static Device Nodes... Aug 13 07:08:44.356462 systemd[1]: Finished network-cleanup.service - Network Cleanup. Aug 13 07:08:44.356475 systemd[1]: Starting systemd-fsck-usr.service... Aug 13 07:08:44.356484 systemd[1]: Starting systemd-journald.service - Journal Service... Aug 13 07:08:44.356492 systemd[1]: Starting systemd-modules-load.service - Load Kernel Modules... Aug 13 07:08:44.356528 systemd-journald[218]: Collecting audit messages is disabled. Aug 13 07:08:44.356552 systemd[1]: Starting systemd-vconsole-setup.service - Virtual Console Setup... Aug 13 07:08:44.356561 systemd-journald[218]: Journal started Aug 13 07:08:44.356579 systemd-journald[218]: Runtime Journal (/run/log/journal/33cfc783cebd4861bf7a399752b19a34) is 8M, max 78.5M, 70.5M free. Aug 13 07:08:44.365042 systemd-modules-load[220]: Inserted module 'overlay' Aug 13 07:08:44.379494 systemd[1]: Started systemd-journald.service - Journal Service. Aug 13 07:08:44.385575 systemd[1]: Finished ignition-setup-pre.service - Ignition env setup. Aug 13 07:08:44.418400 kernel: bridge: filtering via arp/ip/ip6tables is no longer available by default. Update your scripts to load br_netfilter if you need this. Aug 13 07:08:44.418426 kernel: Bridge firewalling registered Aug 13 07:08:44.409204 systemd-modules-load[220]: Inserted module 'br_netfilter' Aug 13 07:08:44.411406 systemd[1]: Finished kmod-static-nodes.service - Create List of Static Device Nodes. Aug 13 07:08:44.439237 systemd[1]: Finished systemd-fsck-usr.service. Aug 13 07:08:44.444606 systemd[1]: Finished systemd-modules-load.service - Load Kernel Modules. Aug 13 07:08:44.455841 systemd[1]: Finished systemd-vconsole-setup.service - Virtual Console Setup. Aug 13 07:08:44.479635 systemd[1]: Starting dracut-cmdline-ask.service - dracut ask for additional cmdline parameters... Aug 13 07:08:44.487499 systemd[1]: Starting systemd-sysctl.service - Apply Kernel Variables... Aug 13 07:08:44.513841 systemd[1]: Starting systemd-tmpfiles-setup-dev-early.service - Create Static Device Nodes in /dev gracefully... Aug 13 07:08:44.537623 systemd[1]: Starting systemd-tmpfiles-setup.service - Create System Files and Directories... Aug 13 07:08:44.553549 systemd[1]: Finished dracut-cmdline-ask.service - dracut ask for additional cmdline parameters. Aug 13 07:08:44.569894 systemd[1]: Finished systemd-sysctl.service - Apply Kernel Variables. Aug 13 07:08:44.577155 systemd[1]: Finished systemd-tmpfiles-setup-dev-early.service - Create Static Device Nodes in /dev gracefully. Aug 13 07:08:44.592790 systemd[1]: Finished systemd-tmpfiles-setup.service - Create System Files and Directories. Aug 13 07:08:44.622634 systemd[1]: Starting dracut-cmdline.service - dracut cmdline hook... Aug 13 07:08:44.639542 dracut-cmdline[253]: dracut-dracut-053 Aug 13 07:08:44.657789 dracut-cmdline[253]: Using kernel command line parameters: rd.driver.pre=btrfs 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=c44ba8b4c0c81c1bcadc13a1606b9de202ee4e4226c47e1c865eaa5fc436b169 Aug 13 07:08:44.642882 systemd[1]: Starting systemd-resolved.service - Network Name Resolution... Aug 13 07:08:44.652536 systemd[1]: Starting systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev... Aug 13 07:08:44.719527 systemd[1]: Finished systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev. Aug 13 07:08:44.723250 systemd-resolved[260]: Positive Trust Anchors: Aug 13 07:08:44.723260 systemd-resolved[260]: . IN DS 20326 8 2 e06d44b80b8f1d39a95c0b0d7c65d08458e880409bbc683457104237c7f8ec8d Aug 13 07:08:44.723290 systemd-resolved[260]: 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 Aug 13 07:08:44.725439 systemd-resolved[260]: Defaulting to hostname 'linux'. Aug 13 07:08:44.735856 systemd[1]: Started systemd-resolved.service - Network Name Resolution. Aug 13 07:08:44.747606 systemd[1]: Reached target nss-lookup.target - Host and Network Name Lookups. Aug 13 07:08:44.855392 kernel: SCSI subsystem initialized Aug 13 07:08:44.863382 kernel: Loading iSCSI transport class v2.0-870. Aug 13 07:08:44.873381 kernel: iscsi: registered transport (tcp) Aug 13 07:08:44.892360 kernel: iscsi: registered transport (qla4xxx) Aug 13 07:08:44.892412 kernel: QLogic iSCSI HBA Driver Aug 13 07:08:44.925031 systemd[1]: Finished dracut-cmdline.service - dracut cmdline hook. Aug 13 07:08:44.939654 systemd[1]: Starting dracut-pre-udev.service - dracut pre-udev hook... Aug 13 07:08:44.970385 kernel: device-mapper: core: CONFIG_IMA_DISABLE_HTABLE is disabled. Duplicate IMA measurements will not be recorded in the IMA log. Aug 13 07:08:44.970439 kernel: device-mapper: uevent: version 1.0.3 Aug 13 07:08:44.977102 kernel: device-mapper: ioctl: 4.48.0-ioctl (2023-03-01) initialised: dm-devel@redhat.com Aug 13 07:08:45.027395 kernel: raid6: neonx8 gen() 15776 MB/s Aug 13 07:08:45.045380 kernel: raid6: neonx4 gen() 15832 MB/s Aug 13 07:08:45.065382 kernel: raid6: neonx2 gen() 13267 MB/s Aug 13 07:08:45.086379 kernel: raid6: neonx1 gen() 10524 MB/s Aug 13 07:08:45.106377 kernel: raid6: int64x8 gen() 6789 MB/s Aug 13 07:08:45.126377 kernel: raid6: int64x4 gen() 7357 MB/s Aug 13 07:08:45.148380 kernel: raid6: int64x2 gen() 6112 MB/s Aug 13 07:08:45.172619 kernel: raid6: int64x1 gen() 5059 MB/s Aug 13 07:08:45.172632 kernel: raid6: using algorithm neonx4 gen() 15832 MB/s Aug 13 07:08:45.198764 kernel: raid6: .... xor() 12525 MB/s, rmw enabled Aug 13 07:08:45.198779 kernel: raid6: using neon recovery algorithm Aug 13 07:08:45.210530 kernel: xor: measuring software checksum speed Aug 13 07:08:45.210546 kernel: 8regs : 21636 MB/sec Aug 13 07:08:45.214613 kernel: 32regs : 21670 MB/sec Aug 13 07:08:45.218577 kernel: arm64_neon : 28003 MB/sec Aug 13 07:08:45.224185 kernel: xor: using function: arm64_neon (28003 MB/sec) Aug 13 07:08:45.274389 kernel: Btrfs loaded, zoned=no, fsverity=no Aug 13 07:08:45.283291 systemd[1]: Finished dracut-pre-udev.service - dracut pre-udev hook. Aug 13 07:08:45.301494 systemd[1]: Starting systemd-udevd.service - Rule-based Manager for Device Events and Files... Aug 13 07:08:45.324169 systemd-udevd[440]: Using default interface naming scheme 'v255'. Aug 13 07:08:45.329212 systemd[1]: Started systemd-udevd.service - Rule-based Manager for Device Events and Files. Aug 13 07:08:45.347501 systemd[1]: Starting dracut-pre-trigger.service - dracut pre-trigger hook... Aug 13 07:08:45.374607 dracut-pre-trigger[453]: rd.md=0: removing MD RAID activation Aug 13 07:08:45.404466 systemd[1]: Finished dracut-pre-trigger.service - dracut pre-trigger hook. Aug 13 07:08:45.421654 systemd[1]: Starting systemd-udev-trigger.service - Coldplug All udev Devices... Aug 13 07:08:45.458456 systemd[1]: Finished systemd-udev-trigger.service - Coldplug All udev Devices. Aug 13 07:08:45.478823 systemd[1]: Starting dracut-initqueue.service - dracut initqueue hook... Aug 13 07:08:45.504893 systemd[1]: Finished dracut-initqueue.service - dracut initqueue hook. Aug 13 07:08:45.518811 systemd[1]: Reached target remote-fs-pre.target - Preparation for Remote File Systems. Aug 13 07:08:45.532529 systemd[1]: Reached target remote-cryptsetup.target - Remote Encrypted Volumes. Aug 13 07:08:45.539622 systemd[1]: Reached target remote-fs.target - Remote File Systems. Aug 13 07:08:45.562570 systemd[1]: Starting dracut-pre-mount.service - dracut pre-mount hook... Aug 13 07:08:45.579909 systemd[1]: Finished dracut-pre-mount.service - dracut pre-mount hook. Aug 13 07:08:45.601098 systemd[1]: dracut-cmdline-ask.service: Deactivated successfully. Aug 13 07:08:45.601209 systemd[1]: Stopped dracut-cmdline-ask.service - dracut ask for additional cmdline parameters. Aug 13 07:08:45.647318 kernel: hv_vmbus: Vmbus version:5.3 Aug 13 07:08:45.647340 kernel: pps_core: LinuxPPS API ver. 1 registered Aug 13 07:08:45.647350 kernel: hv_vmbus: registering driver hid_hyperv Aug 13 07:08:45.647360 kernel: pps_core: Software ver. 5.3.6 - Copyright 2005-2007 Rodolfo Giometti Aug 13 07:08:45.624921 systemd[1]: Stopping dracut-cmdline-ask.service - dracut ask for additional cmdline parameters... Aug 13 07:08:45.631633 systemd[1]: systemd-vconsole-setup.service: Deactivated successfully. Aug 13 07:08:45.631791 systemd[1]: Stopped systemd-vconsole-setup.service - Virtual Console Setup. Aug 13 07:08:45.704594 kernel: input: Microsoft Vmbus HID-compliant Mouse as /devices/0006:045E:0621.0001/input/input0 Aug 13 07:08:45.704620 kernel: hv_vmbus: registering driver hv_storvsc Aug 13 07:08:45.704630 kernel: hv_vmbus: registering driver hyperv_keyboard Aug 13 07:08:45.704640 kernel: hid-hyperv 0006:045E:0621.0001: input: VIRTUAL HID v0.01 Mouse [Microsoft Vmbus HID-compliant Mouse] on Aug 13 07:08:45.704816 kernel: PTP clock support registered Aug 13 07:08:45.661781 systemd[1]: Stopping systemd-vconsole-setup.service - Virtual Console Setup... Aug 13 07:08:45.738451 kernel: hv_vmbus: registering driver hv_netvsc Aug 13 07:08:45.738487 kernel: scsi host0: storvsc_host_t Aug 13 07:08:45.738706 kernel: scsi 0:0:0:0: Direct-Access Msft Virtual Disk 1.0 PQ: 0 ANSI: 5 Aug 13 07:08:45.738730 kernel: input: AT Translated Set 2 keyboard as /devices/LNXSYSTM:00/LNXSYBUS:00/ACPI0004:00/MSFT1000:00/d34b2567-b9b6-42b9-8778-0a4ec0b955bf/serio0/input/input1 Aug 13 07:08:45.706755 systemd[1]: Starting systemd-vconsole-setup.service - Virtual Console Setup... Aug 13 07:08:45.769742 kernel: scsi host1: storvsc_host_t Aug 13 07:08:45.769987 kernel: scsi 0:0:0:2: CD-ROM Msft Virtual DVD-ROM 1.0 PQ: 0 ANSI: 0 Aug 13 07:08:45.763097 systemd[1]: Finished systemd-vconsole-setup.service - Virtual Console Setup. Aug 13 07:08:45.781966 systemd[1]: systemd-vconsole-setup.service: Deactivated successfully. Aug 13 07:08:45.782068 systemd[1]: Stopped systemd-vconsole-setup.service - Virtual Console Setup. Aug 13 07:08:45.817535 kernel: hv_utils: Registering HyperV Utility Driver Aug 13 07:08:45.817559 kernel: hv_vmbus: registering driver hv_utils Aug 13 07:08:45.817569 kernel: hv_utils: Heartbeat IC version 3.0 Aug 13 07:08:45.804475 systemd[1]: Stopping systemd-vconsole-setup.service - Virtual Console Setup... Aug 13 07:08:45.809416 kernel: hv_utils: Shutdown IC version 3.2 Aug 13 07:08:45.842856 kernel: hv_utils: TimeSync IC version 4.0 Aug 13 07:08:45.842875 kernel: hv_netvsc 000d3afb-062a-000d-3afb-062a000d3afb eth0: VF slot 1 added Aug 13 07:08:45.843042 kernel: sr 0:0:0:2: [sr0] scsi-1 drive Aug 13 07:08:45.843160 kernel: hv_vmbus: registering driver hv_pci Aug 13 07:08:45.843169 systemd-journald[218]: Time jumped backwards, rotating. Aug 13 07:08:45.843209 kernel: cdrom: Uniform CD-ROM driver Revision: 3.20 Aug 13 07:08:45.843218 kernel: hv_pci cc0d5ee2-54b6-4d80-b2bb-fd269af4f423: PCI VMBus probing: Using version 0x10004 Aug 13 07:08:45.805994 systemd-resolved[260]: Clock change detected. Flushing caches. Aug 13 07:08:45.811278 systemd[1]: Starting systemd-vconsole-setup.service - Virtual Console Setup... Aug 13 07:08:45.828737 systemd[1]: run-credentials-systemd\x2dvconsole\x2dsetup.service.mount: Deactivated successfully. Aug 13 07:08:45.853587 systemd[1]: Finished systemd-vconsole-setup.service - Virtual Console Setup. Aug 13 07:08:46.399710 kernel: hv_pci cc0d5ee2-54b6-4d80-b2bb-fd269af4f423: PCI host bridge to bus 54b6:00 Aug 13 07:08:46.399910 kernel: pci_bus 54b6:00: root bus resource [mem 0xfc0000000-0xfc00fffff window] Aug 13 07:08:46.400040 kernel: pci_bus 54b6:00: No busn resource found for root bus, will use [bus 00-ff] Aug 13 07:08:46.403782 kernel: sr 0:0:0:2: Attached scsi CD-ROM sr0 Aug 13 07:08:46.403940 kernel: pci 54b6:00:02.0: [15b3:1018] type 00 class 0x020000 Aug 13 07:08:46.409148 systemd[1]: Starting dracut-cmdline-ask.service - dracut ask for additional cmdline parameters... Aug 13 07:08:46.424475 kernel: pci 54b6:00:02.0: reg 0x10: [mem 0xfc0000000-0xfc00fffff 64bit pref] Aug 13 07:08:46.437253 kernel: pci 54b6:00:02.0: enabling Extended Tags Aug 13 07:08:46.461040 kernel: pci 54b6:00:02.0: 0.000 Gb/s available PCIe bandwidth, limited by Unknown x0 link at 54b6:00:02.0 (capable of 126.016 Gb/s with 8.0 GT/s PCIe x16 link) Aug 13 07:08:46.461108 kernel: sd 0:0:0:0: [sda] 63737856 512-byte logical blocks: (32.6 GB/30.4 GiB) Aug 13 07:08:46.471171 kernel: pci_bus 54b6:00: busn_res: [bus 00-ff] end is updated to 00 Aug 13 07:08:46.471356 kernel: sd 0:0:0:0: [sda] 4096-byte physical blocks Aug 13 07:08:46.479980 kernel: pci 54b6:00:02.0: BAR 0: assigned [mem 0xfc0000000-0xfc00fffff 64bit pref] Aug 13 07:08:46.485268 kernel: sd 0:0:0:0: [sda] Write Protect is off Aug 13 07:08:46.494060 kernel: sd 0:0:0:0: [sda] Mode Sense: 0f 00 10 00 Aug 13 07:08:46.494263 kernel: sd 0:0:0:0: [sda] Write cache: disabled, read cache: enabled, supports DPO and FUA Aug 13 07:08:46.495260 systemd[1]: Finished dracut-cmdline-ask.service - dracut ask for additional cmdline parameters. Aug 13 07:08:46.516984 kernel: sda: sda1 sda2 sda3 sda4 sda6 sda7 sda9 Aug 13 07:08:46.521975 kernel: sd 0:0:0:0: [sda] Attached SCSI disk Aug 13 07:08:46.563804 kernel: mlx5_core 54b6:00:02.0: enabling device (0000 -> 0002) Aug 13 07:08:46.572969 kernel: mlx5_core 54b6:00:02.0: firmware version: 16.31.2424 Aug 13 07:08:46.851907 kernel: hv_netvsc 000d3afb-062a-000d-3afb-062a000d3afb eth0: VF registering: eth1 Aug 13 07:08:46.852150 kernel: mlx5_core 54b6:00:02.0 eth1: joined to eth0 Aug 13 07:08:46.863042 kernel: mlx5_core 54b6:00:02.0: MLX5E: StrdRq(1) RqSz(8) StrdSz(2048) RxCqeCmprss(0 basic) Aug 13 07:08:46.872974 kernel: mlx5_core 54b6:00:02.0 enP21686s1: renamed from eth1 Aug 13 07:08:46.999349 systemd[1]: Found device dev-disk-by\x2dlabel-EFI\x2dSYSTEM.device - Virtual_Disk EFI-SYSTEM. Aug 13 07:08:47.093980 kernel: BTRFS: device label OEM devid 1 transid 12 /dev/sda6 scanned by (udev-worker) (498) Aug 13 07:08:47.109963 systemd[1]: Found device dev-disk-by\x2dlabel-OEM.device - Virtual_Disk OEM. Aug 13 07:08:47.131190 kernel: BTRFS: device fsid 66ef7c2c-768e-46b2-8baa-a2b24df44a90 devid 1 transid 42 /dev/sda3 scanned by (udev-worker) (493) Aug 13 07:08:47.140463 systemd[1]: Found device dev-disk-by\x2dlabel-ROOT.device - Virtual_Disk ROOT. Aug 13 07:08:47.155382 systemd[1]: Found device dev-disk-by\x2dpartlabel-USR\x2dA.device - Virtual_Disk USR-A. Aug 13 07:08:47.170475 systemd[1]: Found device dev-disk-by\x2dpartuuid-7130c94a\x2d213a\x2d4e5a\x2d8e26\x2d6cce9662f132.device - Virtual_Disk USR-A. Aug 13 07:08:47.195171 systemd[1]: Starting disk-uuid.service - Generate new UUID for disk GPT if necessary... Aug 13 07:08:47.217083 kernel: sda: sda1 sda2 sda3 sda4 sda6 sda7 sda9 Aug 13 07:08:48.230988 kernel: sda: sda1 sda2 sda3 sda4 sda6 sda7 sda9 Aug 13 07:08:48.231041 disk-uuid[610]: The operation has completed successfully. Aug 13 07:08:48.285219 systemd[1]: disk-uuid.service: Deactivated successfully. Aug 13 07:08:48.285335 systemd[1]: Finished disk-uuid.service - Generate new UUID for disk GPT if necessary. Aug 13 07:08:48.340091 systemd[1]: Starting verity-setup.service - Verity Setup for /dev/mapper/usr... Aug 13 07:08:48.353475 sh[696]: Success Aug 13 07:08:48.384071 kernel: device-mapper: verity: sha256 using implementation "sha256-ce" Aug 13 07:08:48.568658 systemd[1]: Found device dev-mapper-usr.device - /dev/mapper/usr. Aug 13 07:08:48.584685 systemd[1]: Mounting sysusr-usr.mount - /sysusr/usr... Aug 13 07:08:48.594335 systemd[1]: Finished verity-setup.service - Verity Setup for /dev/mapper/usr. Aug 13 07:08:48.626869 kernel: BTRFS info (device dm-0): first mount of filesystem 66ef7c2c-768e-46b2-8baa-a2b24df44a90 Aug 13 07:08:48.626917 kernel: BTRFS info (device dm-0): using crc32c (crc32c-generic) checksum algorithm Aug 13 07:08:48.633674 kernel: BTRFS warning (device dm-0): 'nologreplay' is deprecated, use 'rescue=nologreplay' instead Aug 13 07:08:48.633954 kernel: BTRFS info (device dm-0): disabling log replay at mount time Aug 13 07:08:48.642629 kernel: BTRFS info (device dm-0): using free space tree Aug 13 07:08:48.892480 systemd[1]: Mounted sysusr-usr.mount - /sysusr/usr. Aug 13 07:08:48.897714 systemd[1]: afterburn-network-kargs.service - Afterburn Initrd Setup Network Kernel Arguments was skipped because no trigger condition checks were met. Aug 13 07:08:48.918181 systemd[1]: Starting ignition-setup.service - Ignition (setup)... Aug 13 07:08:48.932123 systemd[1]: Starting parse-ip-for-networkd.service - Write systemd-networkd units from cmdline... Aug 13 07:08:48.961713 kernel: BTRFS info (device sda6): first mount of filesystem 5832a3b0-f866-4304-b935-a4d38424b8f9 Aug 13 07:08:48.961773 kernel: BTRFS info (device sda6): using crc32c (crc32c-generic) checksum algorithm Aug 13 07:08:48.966054 kernel: BTRFS info (device sda6): using free space tree Aug 13 07:08:48.993160 kernel: BTRFS info (device sda6): auto enabling async discard Aug 13 07:08:49.003010 kernel: BTRFS info (device sda6): last unmount of filesystem 5832a3b0-f866-4304-b935-a4d38424b8f9 Aug 13 07:08:49.009511 systemd[1]: Finished ignition-setup.service - Ignition (setup). Aug 13 07:08:49.029110 systemd[1]: Starting ignition-fetch-offline.service - Ignition (fetch-offline)... Aug 13 07:08:49.043642 systemd[1]: Finished parse-ip-for-networkd.service - Write systemd-networkd units from cmdline. Aug 13 07:08:49.062107 systemd[1]: Starting systemd-networkd.service - Network Configuration... Aug 13 07:08:49.105529 systemd-networkd[877]: lo: Link UP Aug 13 07:08:49.105542 systemd-networkd[877]: lo: Gained carrier Aug 13 07:08:49.107345 systemd-networkd[877]: Enumeration completed Aug 13 07:08:49.107447 systemd[1]: Started systemd-networkd.service - Network Configuration. Aug 13 07:08:49.116904 systemd[1]: Reached target network.target - Network. Aug 13 07:08:49.120740 systemd-networkd[877]: eth0: found matching network '/usr/lib/systemd/network/zz-default.network', based on potentially unpredictable interface name. Aug 13 07:08:49.120744 systemd-networkd[877]: eth0: Configuring with /usr/lib/systemd/network/zz-default.network. Aug 13 07:08:49.211976 kernel: mlx5_core 54b6:00:02.0 enP21686s1: Link up Aug 13 07:08:49.290975 kernel: hv_netvsc 000d3afb-062a-000d-3afb-062a000d3afb eth0: Data path switched to VF: enP21686s1 Aug 13 07:08:49.291412 systemd-networkd[877]: enP21686s1: Link UP Aug 13 07:08:49.291493 systemd-networkd[877]: eth0: Link UP Aug 13 07:08:49.291586 systemd-networkd[877]: eth0: Gained carrier Aug 13 07:08:49.291594 systemd-networkd[877]: eth0: found matching network '/usr/lib/systemd/network/zz-default.network', based on potentially unpredictable interface name. Aug 13 07:08:49.300201 systemd-networkd[877]: enP21686s1: Gained carrier Aug 13 07:08:49.323059 systemd-networkd[877]: eth0: DHCPv4 address 10.200.20.45/24, gateway 10.200.20.1 acquired from 168.63.129.16 Aug 13 07:08:49.817522 ignition[870]: Ignition 2.20.0 Aug 13 07:08:49.817542 ignition[870]: Stage: fetch-offline Aug 13 07:08:49.823969 systemd[1]: Finished ignition-fetch-offline.service - Ignition (fetch-offline). Aug 13 07:08:49.817579 ignition[870]: no configs at "/usr/lib/ignition/base.d" Aug 13 07:08:49.817587 ignition[870]: no config dir at "/usr/lib/ignition/base.platform.d/azure" Aug 13 07:08:49.818185 ignition[870]: parsed url from cmdline: "" Aug 13 07:08:49.818190 ignition[870]: no config URL provided Aug 13 07:08:49.818196 ignition[870]: reading system config file "/usr/lib/ignition/user.ign" Aug 13 07:08:49.853205 systemd[1]: Starting ignition-fetch.service - Ignition (fetch)... Aug 13 07:08:49.818209 ignition[870]: no config at "/usr/lib/ignition/user.ign" Aug 13 07:08:49.818214 ignition[870]: failed to fetch config: resource requires networking Aug 13 07:08:49.818443 ignition[870]: Ignition finished successfully Aug 13 07:08:49.877282 ignition[888]: Ignition 2.20.0 Aug 13 07:08:49.877289 ignition[888]: Stage: fetch Aug 13 07:08:49.877450 ignition[888]: no configs at "/usr/lib/ignition/base.d" Aug 13 07:08:49.877460 ignition[888]: no config dir at "/usr/lib/ignition/base.platform.d/azure" Aug 13 07:08:49.877579 ignition[888]: parsed url from cmdline: "" Aug 13 07:08:49.877583 ignition[888]: no config URL provided Aug 13 07:08:49.877587 ignition[888]: reading system config file "/usr/lib/ignition/user.ign" Aug 13 07:08:49.877595 ignition[888]: no config at "/usr/lib/ignition/user.ign" Aug 13 07:08:49.877622 ignition[888]: GET http://169.254.169.254/metadata/instance/compute/userData?api-version=2021-01-01&format=text: attempt #1 Aug 13 07:08:49.961465 ignition[888]: GET result: OK Aug 13 07:08:49.962092 ignition[888]: config has been read from IMDS userdata Aug 13 07:08:49.962115 ignition[888]: parsing config with SHA512: 8d385f61a82d3493bc43b047f0e6362b84b60eb937099f6270c679d99840727e04936ab6ac25b9d65cc8cfaba5bfe852908817c6f8076b1aa8627056dd8d84eb Aug 13 07:08:49.966649 unknown[888]: fetched base config from "system" Aug 13 07:08:49.966863 ignition[888]: fetch: fetch complete Aug 13 07:08:49.966656 unknown[888]: fetched base config from "system" Aug 13 07:08:49.966867 ignition[888]: fetch: fetch passed Aug 13 07:08:49.966661 unknown[888]: fetched user config from "azure" Aug 13 07:08:49.966910 ignition[888]: Ignition finished successfully Aug 13 07:08:49.971818 systemd[1]: Finished ignition-fetch.service - Ignition (fetch). Aug 13 07:08:49.996196 systemd[1]: Starting ignition-kargs.service - Ignition (kargs)... Aug 13 07:08:50.024231 ignition[895]: Ignition 2.20.0 Aug 13 07:08:50.024242 ignition[895]: Stage: kargs Aug 13 07:08:50.024419 ignition[895]: no configs at "/usr/lib/ignition/base.d" Aug 13 07:08:50.031137 systemd[1]: Finished ignition-kargs.service - Ignition (kargs). Aug 13 07:08:50.024430 ignition[895]: no config dir at "/usr/lib/ignition/base.platform.d/azure" Aug 13 07:08:50.025069 ignition[895]: kargs: kargs passed Aug 13 07:08:50.025114 ignition[895]: Ignition finished successfully Aug 13 07:08:50.061502 systemd[1]: Starting ignition-disks.service - Ignition (disks)... Aug 13 07:08:50.082246 ignition[901]: Ignition 2.20.0 Aug 13 07:08:50.082259 ignition[901]: Stage: disks Aug 13 07:08:50.086658 systemd[1]: Finished ignition-disks.service - Ignition (disks). Aug 13 07:08:50.082447 ignition[901]: no configs at "/usr/lib/ignition/base.d" Aug 13 07:08:50.094780 systemd[1]: Reached target initrd-root-device.target - Initrd Root Device. Aug 13 07:08:50.082457 ignition[901]: no config dir at "/usr/lib/ignition/base.platform.d/azure" Aug 13 07:08:50.105827 systemd[1]: Reached target local-fs-pre.target - Preparation for Local File Systems. Aug 13 07:08:50.083219 ignition[901]: disks: disks passed Aug 13 07:08:50.117517 systemd[1]: Reached target local-fs.target - Local File Systems. Aug 13 07:08:50.083263 ignition[901]: Ignition finished successfully Aug 13 07:08:50.129286 systemd[1]: Reached target sysinit.target - System Initialization. Aug 13 07:08:50.141569 systemd[1]: Reached target basic.target - Basic System. Aug 13 07:08:50.169165 systemd[1]: Starting systemd-fsck-root.service - File System Check on /dev/disk/by-label/ROOT... Aug 13 07:08:50.234234 systemd-fsck[909]: ROOT: clean, 14/7326000 files, 477710/7359488 blocks Aug 13 07:08:50.243709 systemd[1]: Finished systemd-fsck-root.service - File System Check on /dev/disk/by-label/ROOT. Aug 13 07:08:50.263216 systemd[1]: Mounting sysroot.mount - /sysroot... Aug 13 07:08:50.323966 kernel: EXT4-fs (sda9): mounted filesystem 4e885a6c-f4f3-43a5-b152-e0e8bd6b099d r/w with ordered data mode. Quota mode: none. Aug 13 07:08:50.324802 systemd[1]: Mounted sysroot.mount - /sysroot. Aug 13 07:08:50.330380 systemd[1]: Reached target initrd-root-fs.target - Initrd Root File System. Aug 13 07:08:50.374065 systemd[1]: Mounting sysroot-oem.mount - /sysroot/oem... Aug 13 07:08:50.382073 systemd[1]: Mounting sysroot-usr.mount - /sysroot/usr... Aug 13 07:08:50.413169 kernel: BTRFS: device label OEM devid 1 transid 13 /dev/sda6 scanned by mount (920) Aug 13 07:08:50.413203 kernel: BTRFS info (device sda6): first mount of filesystem 5832a3b0-f866-4304-b935-a4d38424b8f9 Aug 13 07:08:50.401178 systemd[1]: Starting flatcar-metadata-hostname.service - Flatcar Metadata Hostname Agent... Aug 13 07:08:50.439472 kernel: BTRFS info (device sda6): using crc32c (crc32c-generic) checksum algorithm Aug 13 07:08:50.439496 kernel: BTRFS info (device sda6): using free space tree Aug 13 07:08:50.431836 systemd[1]: ignition-remount-sysroot.service - Remount /sysroot read-write for Ignition was skipped because of an unmet condition check (ConditionPathIsReadWrite=!/sysroot). Aug 13 07:08:50.431890 systemd[1]: Reached target ignition-diskful.target - Ignition Boot Disk Setup. Aug 13 07:08:50.472505 kernel: BTRFS info (device sda6): auto enabling async discard Aug 13 07:08:50.468627 systemd[1]: Mounted sysroot-usr.mount - /sysroot/usr. Aug 13 07:08:50.478820 systemd[1]: Mounted sysroot-oem.mount - /sysroot/oem. Aug 13 07:08:50.491193 systemd[1]: Starting initrd-setup-root.service - Root filesystem setup... Aug 13 07:08:50.645056 systemd-networkd[877]: eth0: Gained IPv6LL Aug 13 07:08:51.026051 coreos-metadata[922]: Aug 13 07:08:51.025 INFO Fetching http://168.63.129.16/?comp=versions: Attempt #1 Aug 13 07:08:51.062201 coreos-metadata[922]: Aug 13 07:08:51.062 INFO Fetch successful Aug 13 07:08:51.062201 coreos-metadata[922]: Aug 13 07:08:51.062 INFO Fetching http://169.254.169.254/metadata/instance/compute/name?api-version=2017-08-01&format=text: Attempt #1 Aug 13 07:08:51.079348 coreos-metadata[922]: Aug 13 07:08:51.078 INFO Fetch successful Aug 13 07:08:51.092916 coreos-metadata[922]: Aug 13 07:08:51.092 INFO wrote hostname ci-4230.2.2-a-8f178afe22 to /sysroot/etc/hostname Aug 13 07:08:51.094255 systemd[1]: Finished flatcar-metadata-hostname.service - Flatcar Metadata Hostname Agent. Aug 13 07:08:51.221925 initrd-setup-root[950]: cut: /sysroot/etc/passwd: No such file or directory Aug 13 07:08:51.244391 initrd-setup-root[957]: cut: /sysroot/etc/group: No such file or directory Aug 13 07:08:51.253404 initrd-setup-root[964]: cut: /sysroot/etc/shadow: No such file or directory Aug 13 07:08:51.262267 initrd-setup-root[971]: cut: /sysroot/etc/gshadow: No such file or directory Aug 13 07:08:52.011524 systemd[1]: Finished initrd-setup-root.service - Root filesystem setup. Aug 13 07:08:52.027266 systemd[1]: Starting ignition-mount.service - Ignition (mount)... Aug 13 07:08:52.035412 systemd[1]: Starting sysroot-boot.service - /sysroot/boot... Aug 13 07:08:52.064653 kernel: BTRFS info (device sda6): last unmount of filesystem 5832a3b0-f866-4304-b935-a4d38424b8f9 Aug 13 07:08:52.063552 systemd[1]: sysroot-oem.mount: Deactivated successfully. Aug 13 07:08:52.090989 ignition[1039]: INFO : Ignition 2.20.0 Aug 13 07:08:52.090989 ignition[1039]: INFO : Stage: mount Aug 13 07:08:52.090989 ignition[1039]: INFO : no configs at "/usr/lib/ignition/base.d" Aug 13 07:08:52.090989 ignition[1039]: INFO : no config dir at "/usr/lib/ignition/base.platform.d/azure" Aug 13 07:08:52.125280 ignition[1039]: INFO : mount: mount passed Aug 13 07:08:52.125280 ignition[1039]: INFO : Ignition finished successfully Aug 13 07:08:52.091981 systemd[1]: Finished sysroot-boot.service - /sysroot/boot. Aug 13 07:08:52.107974 systemd[1]: Finished ignition-mount.service - Ignition (mount). Aug 13 07:08:52.135164 systemd[1]: Starting ignition-files.service - Ignition (files)... Aug 13 07:08:52.150251 systemd[1]: Mounting sysroot-oem.mount - /sysroot/oem... Aug 13 07:08:52.180987 kernel: BTRFS: device label OEM devid 1 transid 14 /dev/sda6 scanned by mount (1050) Aug 13 07:08:52.195178 kernel: BTRFS info (device sda6): first mount of filesystem 5832a3b0-f866-4304-b935-a4d38424b8f9 Aug 13 07:08:52.195227 kernel: BTRFS info (device sda6): using crc32c (crc32c-generic) checksum algorithm Aug 13 07:08:52.199594 kernel: BTRFS info (device sda6): using free space tree Aug 13 07:08:52.206967 kernel: BTRFS info (device sda6): auto enabling async discard Aug 13 07:08:52.209244 systemd[1]: Mounted sysroot-oem.mount - /sysroot/oem. Aug 13 07:08:52.237883 ignition[1068]: INFO : Ignition 2.20.0 Aug 13 07:08:52.237883 ignition[1068]: INFO : Stage: files Aug 13 07:08:52.246128 ignition[1068]: INFO : no configs at "/usr/lib/ignition/base.d" Aug 13 07:08:52.246128 ignition[1068]: INFO : no config dir at "/usr/lib/ignition/base.platform.d/azure" Aug 13 07:08:52.246128 ignition[1068]: DEBUG : files: compiled without relabeling support, skipping Aug 13 07:08:52.264184 ignition[1068]: INFO : files: ensureUsers: op(1): [started] creating or modifying user "core" Aug 13 07:08:52.264184 ignition[1068]: DEBUG : files: ensureUsers: op(1): executing: "usermod" "--root" "/sysroot" "core" Aug 13 07:08:52.282262 ignition[1068]: INFO : files: ensureUsers: op(1): [finished] creating or modifying user "core" Aug 13 07:08:52.289718 ignition[1068]: INFO : files: ensureUsers: op(2): [started] adding ssh keys to user "core" Aug 13 07:08:52.289718 ignition[1068]: INFO : files: ensureUsers: op(2): [finished] adding ssh keys to user "core" Aug 13 07:08:52.289718 ignition[1068]: INFO : files: createFilesystemsFiles: createFiles: op(3): [started] writing file "/sysroot/etc/flatcar/update.conf" Aug 13 07:08:52.289718 ignition[1068]: INFO : files: createFilesystemsFiles: createFiles: op(3): [finished] writing file "/sysroot/etc/flatcar/update.conf" Aug 13 07:08:52.289718 ignition[1068]: INFO : files: op(4): [started] processing unit "etcd-member.service" Aug 13 07:08:52.282717 unknown[1068]: wrote ssh authorized keys file for user: core Aug 13 07:08:52.341822 ignition[1068]: INFO : files: op(4): op(5): [started] writing systemd drop-in "20-clct-etcd-member.conf" at "/sysroot/etc/systemd/system/etcd-member.service.d/20-clct-etcd-member.conf" Aug 13 07:08:52.341822 ignition[1068]: INFO : files: op(4): op(5): [finished] writing systemd drop-in "20-clct-etcd-member.conf" at "/sysroot/etc/systemd/system/etcd-member.service.d/20-clct-etcd-member.conf" Aug 13 07:08:52.341822 ignition[1068]: INFO : files: op(4): [finished] processing unit "etcd-member.service" Aug 13 07:08:52.341822 ignition[1068]: INFO : files: op(6): [started] setting preset to enabled for "etcd-member.service" Aug 13 07:08:52.341822 ignition[1068]: INFO : files: op(6): [finished] setting preset to enabled for "etcd-member.service" Aug 13 07:08:52.341822 ignition[1068]: INFO : files: createResultFile: createFiles: op(7): [started] writing file "/sysroot/etc/.ignition-result.json" Aug 13 07:08:52.341822 ignition[1068]: INFO : files: createResultFile: createFiles: op(7): [finished] writing file "/sysroot/etc/.ignition-result.json" Aug 13 07:08:52.341822 ignition[1068]: INFO : files: files passed Aug 13 07:08:52.341822 ignition[1068]: INFO : Ignition finished successfully Aug 13 07:08:52.315162 systemd[1]: Finished ignition-files.service - Ignition (files). Aug 13 07:08:52.356217 systemd[1]: Starting ignition-quench.service - Ignition (record completion)... Aug 13 07:08:52.377173 systemd[1]: Starting initrd-setup-root-after-ignition.service - Root filesystem completion... Aug 13 07:08:52.405277 systemd[1]: ignition-quench.service: Deactivated successfully. Aug 13 07:08:52.492939 initrd-setup-root-after-ignition[1094]: grep: /sysroot/etc/flatcar/enabled-sysext.conf: No such file or directory Aug 13 07:08:52.492939 initrd-setup-root-after-ignition[1094]: grep: /sysroot/usr/share/flatcar/enabled-sysext.conf: No such file or directory Aug 13 07:08:52.405369 systemd[1]: Finished ignition-quench.service - Ignition (record completion). Aug 13 07:08:52.518289 initrd-setup-root-after-ignition[1098]: grep: /sysroot/etc/flatcar/enabled-sysext.conf: No such file or directory Aug 13 07:08:52.416410 systemd[1]: Finished initrd-setup-root-after-ignition.service - Root filesystem completion. Aug 13 07:08:52.429797 systemd[1]: Reached target ignition-complete.target - Ignition Complete. Aug 13 07:08:52.463186 systemd[1]: Starting initrd-parse-etc.service - Mountpoints Configured in the Real Root... Aug 13 07:08:52.514317 systemd[1]: initrd-parse-etc.service: Deactivated successfully. Aug 13 07:08:52.514442 systemd[1]: Finished initrd-parse-etc.service - Mountpoints Configured in the Real Root. Aug 13 07:08:52.525406 systemd[1]: Reached target initrd-fs.target - Initrd File Systems. Aug 13 07:08:52.540321 systemd[1]: Reached target initrd.target - Initrd Default Target. Aug 13 07:08:52.553621 systemd[1]: dracut-mount.service - dracut mount hook was skipped because no trigger condition checks were met. Aug 13 07:08:52.556140 systemd[1]: Starting dracut-pre-pivot.service - dracut pre-pivot and cleanup hook... Aug 13 07:08:52.601470 systemd[1]: Finished dracut-pre-pivot.service - dracut pre-pivot and cleanup hook. Aug 13 07:08:52.633232 systemd[1]: Starting initrd-cleanup.service - Cleaning Up and Shutting Down Daemons... Aug 13 07:08:52.653053 systemd[1]: Stopped target nss-lookup.target - Host and Network Name Lookups. Aug 13 07:08:52.659900 systemd[1]: Stopped target remote-cryptsetup.target - Remote Encrypted Volumes. Aug 13 07:08:52.673293 systemd[1]: Stopped target timers.target - Timer Units. Aug 13 07:08:52.684602 systemd[1]: dracut-pre-pivot.service: Deactivated successfully. Aug 13 07:08:52.684725 systemd[1]: Stopped dracut-pre-pivot.service - dracut pre-pivot and cleanup hook. Aug 13 07:08:52.701664 systemd[1]: Stopped target initrd.target - Initrd Default Target. Aug 13 07:08:52.707913 systemd[1]: Stopped target basic.target - Basic System. Aug 13 07:08:52.719315 systemd[1]: Stopped target ignition-complete.target - Ignition Complete. Aug 13 07:08:52.730764 systemd[1]: Stopped target ignition-diskful.target - Ignition Boot Disk Setup. Aug 13 07:08:52.742993 systemd[1]: Stopped target initrd-root-device.target - Initrd Root Device. Aug 13 07:08:52.755061 systemd[1]: Stopped target remote-fs.target - Remote File Systems. Aug 13 07:08:52.767345 systemd[1]: Stopped target remote-fs-pre.target - Preparation for Remote File Systems. Aug 13 07:08:52.780443 systemd[1]: Stopped target sysinit.target - System Initialization. Aug 13 07:08:52.792413 systemd[1]: Stopped target local-fs.target - Local File Systems. Aug 13 07:08:52.805994 systemd[1]: Stopped target swap.target - Swaps. Aug 13 07:08:52.817455 systemd[1]: dracut-pre-mount.service: Deactivated successfully. Aug 13 07:08:52.817594 systemd[1]: Stopped dracut-pre-mount.service - dracut pre-mount hook. Aug 13 07:08:52.835110 systemd[1]: Stopped target cryptsetup.target - Local Encrypted Volumes. Aug 13 07:08:52.841645 systemd[1]: Stopped target cryptsetup-pre.target - Local Encrypted Volumes (Pre). Aug 13 07:08:52.854271 systemd[1]: clevis-luks-askpass.path: Deactivated successfully. Aug 13 07:08:52.860277 systemd[1]: Stopped clevis-luks-askpass.path - Forward Password Requests to Clevis Directory Watch. Aug 13 07:08:52.867984 systemd[1]: dracut-initqueue.service: Deactivated successfully. Aug 13 07:08:52.868104 systemd[1]: Stopped dracut-initqueue.service - dracut initqueue hook. Aug 13 07:08:52.887832 systemd[1]: initrd-setup-root-after-ignition.service: Deactivated successfully. Aug 13 07:08:52.887963 systemd[1]: Stopped initrd-setup-root-after-ignition.service - Root filesystem completion. Aug 13 07:08:52.895231 systemd[1]: ignition-files.service: Deactivated successfully. Aug 13 07:08:52.895343 systemd[1]: Stopped ignition-files.service - Ignition (files). Aug 13 07:08:52.906540 systemd[1]: flatcar-metadata-hostname.service: Deactivated successfully. Aug 13 07:08:52.906657 systemd[1]: Stopped flatcar-metadata-hostname.service - Flatcar Metadata Hostname Agent. Aug 13 07:08:52.939403 systemd[1]: Stopping ignition-mount.service - Ignition (mount)... Aug 13 07:08:53.005929 ignition[1119]: INFO : Ignition 2.20.0 Aug 13 07:08:53.005929 ignition[1119]: INFO : Stage: umount Aug 13 07:08:53.005929 ignition[1119]: INFO : no configs at "/usr/lib/ignition/base.d" Aug 13 07:08:53.005929 ignition[1119]: INFO : no config dir at "/usr/lib/ignition/base.platform.d/azure" Aug 13 07:08:53.005929 ignition[1119]: INFO : umount: umount passed Aug 13 07:08:53.005929 ignition[1119]: INFO : Ignition finished successfully Aug 13 07:08:52.958335 systemd[1]: Stopping sysroot-boot.service - /sysroot/boot... Aug 13 07:08:52.964090 systemd[1]: systemd-udev-trigger.service: Deactivated successfully. Aug 13 07:08:52.964354 systemd[1]: Stopped systemd-udev-trigger.service - Coldplug All udev Devices. Aug 13 07:08:52.984368 systemd[1]: dracut-pre-trigger.service: Deactivated successfully. Aug 13 07:08:52.984549 systemd[1]: Stopped dracut-pre-trigger.service - dracut pre-trigger hook. Aug 13 07:08:53.001404 systemd[1]: ignition-mount.service: Deactivated successfully. Aug 13 07:08:53.001515 systemd[1]: Stopped ignition-mount.service - Ignition (mount). Aug 13 07:08:53.013627 systemd[1]: initrd-cleanup.service: Deactivated successfully. Aug 13 07:08:53.013739 systemd[1]: Finished initrd-cleanup.service - Cleaning Up and Shutting Down Daemons. Aug 13 07:08:53.030695 systemd[1]: ignition-disks.service: Deactivated successfully. Aug 13 07:08:53.030782 systemd[1]: Stopped ignition-disks.service - Ignition (disks). Aug 13 07:08:53.041529 systemd[1]: ignition-kargs.service: Deactivated successfully. Aug 13 07:08:53.041592 systemd[1]: Stopped ignition-kargs.service - Ignition (kargs). Aug 13 07:08:53.054423 systemd[1]: ignition-fetch.service: Deactivated successfully. Aug 13 07:08:53.054482 systemd[1]: Stopped ignition-fetch.service - Ignition (fetch). Aug 13 07:08:53.066730 systemd[1]: Stopped target network.target - Network. Aug 13 07:08:53.082815 systemd[1]: ignition-fetch-offline.service: Deactivated successfully. Aug 13 07:08:53.082906 systemd[1]: Stopped ignition-fetch-offline.service - Ignition (fetch-offline). Aug 13 07:08:53.096151 systemd[1]: Stopped target paths.target - Path Units. Aug 13 07:08:53.107935 systemd[1]: systemd-ask-password-console.path: Deactivated successfully. Aug 13 07:08:53.114989 systemd[1]: Stopped systemd-ask-password-console.path - Dispatch Password Requests to Console Directory Watch. Aug 13 07:08:53.128393 systemd[1]: Stopped target slices.target - Slice Units. Aug 13 07:08:53.140609 systemd[1]: Stopped target sockets.target - Socket Units. Aug 13 07:08:53.151872 systemd[1]: iscsid.socket: Deactivated successfully. Aug 13 07:08:53.151959 systemd[1]: Closed iscsid.socket - Open-iSCSI iscsid Socket. Aug 13 07:08:53.163563 systemd[1]: iscsiuio.socket: Deactivated successfully. Aug 13 07:08:53.163607 systemd[1]: Closed iscsiuio.socket - Open-iSCSI iscsiuio Socket. Aug 13 07:08:53.175335 systemd[1]: ignition-setup.service: Deactivated successfully. Aug 13 07:08:53.175391 systemd[1]: Stopped ignition-setup.service - Ignition (setup). Aug 13 07:08:53.188319 systemd[1]: ignition-setup-pre.service: Deactivated successfully. Aug 13 07:08:53.188372 systemd[1]: Stopped ignition-setup-pre.service - Ignition env setup. Aug 13 07:08:53.201531 systemd[1]: Stopping systemd-networkd.service - Network Configuration... Aug 13 07:08:53.213247 systemd[1]: Stopping systemd-resolved.service - Network Name Resolution... Aug 13 07:08:53.227669 systemd[1]: sysroot-boot.mount: Deactivated successfully. Aug 13 07:08:53.228274 systemd[1]: systemd-resolved.service: Deactivated successfully. Aug 13 07:08:53.228381 systemd[1]: Stopped systemd-resolved.service - Network Name Resolution. Aug 13 07:08:53.245688 systemd[1]: run-credentials-systemd\x2dresolved.service.mount: Deactivated successfully. Aug 13 07:08:53.245899 systemd[1]: systemd-networkd.service: Deactivated successfully. Aug 13 07:08:53.506961 kernel: hv_netvsc 000d3afb-062a-000d-3afb-062a000d3afb eth0: Data path switched from VF: enP21686s1 Aug 13 07:08:53.246127 systemd[1]: Stopped systemd-networkd.service - Network Configuration. Aug 13 07:08:53.258555 systemd[1]: run-credentials-systemd\x2dnetworkd.service.mount: Deactivated successfully. Aug 13 07:08:53.258773 systemd[1]: sysroot-boot.service: Deactivated successfully. Aug 13 07:08:53.258863 systemd[1]: Stopped sysroot-boot.service - /sysroot/boot. Aug 13 07:08:53.265923 systemd[1]: systemd-networkd.socket: Deactivated successfully. Aug 13 07:08:53.266005 systemd[1]: Closed systemd-networkd.socket - Network Service Netlink Socket. Aug 13 07:08:53.277453 systemd[1]: initrd-setup-root.service: Deactivated successfully. Aug 13 07:08:53.277525 systemd[1]: Stopped initrd-setup-root.service - Root filesystem setup. Aug 13 07:08:53.311127 systemd[1]: Stopping network-cleanup.service - Network Cleanup... Aug 13 07:08:53.324551 systemd[1]: parse-ip-for-networkd.service: Deactivated successfully. Aug 13 07:08:53.324636 systemd[1]: Stopped parse-ip-for-networkd.service - Write systemd-networkd units from cmdline. Aug 13 07:08:53.336640 systemd[1]: systemd-sysctl.service: Deactivated successfully. Aug 13 07:08:53.336693 systemd[1]: Stopped systemd-sysctl.service - Apply Kernel Variables. Aug 13 07:08:53.353005 systemd[1]: systemd-modules-load.service: Deactivated successfully. Aug 13 07:08:53.353063 systemd[1]: Stopped systemd-modules-load.service - Load Kernel Modules. Aug 13 07:08:53.359510 systemd[1]: systemd-tmpfiles-setup.service: Deactivated successfully. Aug 13 07:08:53.359563 systemd[1]: Stopped systemd-tmpfiles-setup.service - Create System Files and Directories. Aug 13 07:08:53.378907 systemd[1]: Stopping systemd-udevd.service - Rule-based Manager for Device Events and Files... Aug 13 07:08:53.390060 systemd[1]: run-credentials-systemd\x2dsysctl.service.mount: Deactivated successfully. Aug 13 07:08:53.390134 systemd[1]: run-credentials-systemd\x2dtmpfiles\x2dsetup.service.mount: Deactivated successfully. Aug 13 07:08:53.408645 systemd[1]: systemd-udevd.service: Deactivated successfully. Aug 13 07:08:53.408850 systemd[1]: Stopped systemd-udevd.service - Rule-based Manager for Device Events and Files. Aug 13 07:08:53.420289 systemd[1]: systemd-udevd-control.socket: Deactivated successfully. Aug 13 07:08:53.420338 systemd[1]: Closed systemd-udevd-control.socket - udev Control Socket. Aug 13 07:08:53.432479 systemd[1]: systemd-udevd-kernel.socket: Deactivated successfully. Aug 13 07:08:53.432519 systemd[1]: Closed systemd-udevd-kernel.socket - udev Kernel Socket. Aug 13 07:08:53.444544 systemd[1]: dracut-pre-udev.service: Deactivated successfully. Aug 13 07:08:53.444599 systemd[1]: Stopped dracut-pre-udev.service - dracut pre-udev hook. Aug 13 07:08:53.461230 systemd[1]: dracut-cmdline.service: Deactivated successfully. Aug 13 07:08:53.461293 systemd[1]: Stopped dracut-cmdline.service - dracut cmdline hook. Aug 13 07:08:53.477833 systemd[1]: dracut-cmdline-ask.service: Deactivated successfully. Aug 13 07:08:53.477890 systemd[1]: Stopped dracut-cmdline-ask.service - dracut ask for additional cmdline parameters. Aug 13 07:08:53.531121 systemd[1]: Starting initrd-udevadm-cleanup-db.service - Cleanup udev Database... Aug 13 07:08:53.547125 systemd[1]: systemd-tmpfiles-setup-dev.service: Deactivated successfully. Aug 13 07:08:53.547209 systemd[1]: Stopped systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev. Aug 13 07:08:53.567560 systemd[1]: systemd-tmpfiles-setup-dev-early.service: Deactivated successfully. Aug 13 07:08:53.807365 systemd-journald[218]: Received SIGTERM from PID 1 (systemd). Aug 13 07:08:53.567617 systemd[1]: Stopped systemd-tmpfiles-setup-dev-early.service - Create Static Device Nodes in /dev gracefully. Aug 13 07:08:53.575521 systemd[1]: kmod-static-nodes.service: Deactivated successfully. Aug 13 07:08:53.575569 systemd[1]: Stopped kmod-static-nodes.service - Create List of Static Device Nodes. Aug 13 07:08:53.587991 systemd[1]: systemd-vconsole-setup.service: Deactivated successfully. Aug 13 07:08:53.588045 systemd[1]: Stopped systemd-vconsole-setup.service - Virtual Console Setup. Aug 13 07:08:53.606295 systemd[1]: run-credentials-systemd\x2dtmpfiles\x2dsetup\x2ddev.service.mount: Deactivated successfully. Aug 13 07:08:53.606359 systemd[1]: run-credentials-systemd\x2dvconsole\x2dsetup.service.mount: Deactivated successfully. Aug 13 07:08:53.606706 systemd[1]: network-cleanup.service: Deactivated successfully. Aug 13 07:08:53.606806 systemd[1]: Stopped network-cleanup.service - Network Cleanup. Aug 13 07:08:53.619655 systemd[1]: initrd-udevadm-cleanup-db.service: Deactivated successfully. Aug 13 07:08:53.619745 systemd[1]: Finished initrd-udevadm-cleanup-db.service - Cleanup udev Database. Aug 13 07:08:53.631682 systemd[1]: Reached target initrd-switch-root.target - Switch Root. Aug 13 07:08:53.659534 systemd[1]: Starting initrd-switch-root.service - Switch Root... Aug 13 07:08:53.695509 systemd[1]: Switching root. Aug 13 07:08:53.862273 systemd-journald[218]: Journal stopped Aug 13 07:08:57.849322 kernel: SELinux: policy capability network_peer_controls=1 Aug 13 07:08:57.849347 kernel: SELinux: policy capability open_perms=1 Aug 13 07:08:57.849357 kernel: SELinux: policy capability extended_socket_class=1 Aug 13 07:08:57.849365 kernel: SELinux: policy capability always_check_network=0 Aug 13 07:08:57.849374 kernel: SELinux: policy capability cgroup_seclabel=1 Aug 13 07:08:57.849382 kernel: SELinux: policy capability nnp_nosuid_transition=1 Aug 13 07:08:57.849390 kernel: SELinux: policy capability genfs_seclabel_symlinks=0 Aug 13 07:08:57.849398 kernel: SELinux: policy capability ioctl_skip_cloexec=0 Aug 13 07:08:57.849406 kernel: audit: type=1403 audit(1755068934.436:2): auid=4294967295 ses=4294967295 lsm=selinux res=1 Aug 13 07:08:57.849415 systemd[1]: Successfully loaded SELinux policy in 166.348ms. Aug 13 07:08:57.849426 systemd[1]: Relabeled /dev/, /dev/shm/, /run/ in 10.511ms. Aug 13 07:08:57.849436 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) Aug 13 07:08:57.849445 systemd[1]: Detected virtualization microsoft. Aug 13 07:08:57.849453 systemd[1]: Detected architecture arm64. Aug 13 07:08:57.849462 systemd[1]: Detected first boot. Aug 13 07:08:57.849473 systemd[1]: Hostname set to . Aug 13 07:08:57.849482 systemd[1]: Initializing machine ID from random generator. Aug 13 07:08:57.849491 zram_generator::config[1163]: No configuration found. Aug 13 07:08:57.849500 kernel: NET: Registered PF_VSOCK protocol family Aug 13 07:08:57.849509 systemd[1]: Populated /etc with preset unit settings. Aug 13 07:08:57.849518 systemd[1]: run-credentials-systemd\x2djournald.service.mount: Deactivated successfully. Aug 13 07:08:57.849527 systemd[1]: initrd-switch-root.service: Deactivated successfully. Aug 13 07:08:57.849537 systemd[1]: Stopped initrd-switch-root.service - Switch Root. Aug 13 07:08:57.849546 systemd[1]: systemd-journald.service: Scheduled restart job, restart counter is at 1. Aug 13 07:08:57.849555 systemd[1]: Created slice system-addon\x2dconfig.slice - Slice /system/addon-config. Aug 13 07:08:57.849564 systemd[1]: Created slice system-addon\x2drun.slice - Slice /system/addon-run. Aug 13 07:08:57.849573 systemd[1]: Created slice system-getty.slice - Slice /system/getty. Aug 13 07:08:57.849583 systemd[1]: Created slice system-modprobe.slice - Slice /system/modprobe. Aug 13 07:08:57.849592 systemd[1]: Created slice system-serial\x2dgetty.slice - Slice /system/serial-getty. Aug 13 07:08:57.849603 systemd[1]: Created slice system-system\x2dcloudinit.slice - Slice /system/system-cloudinit. Aug 13 07:08:57.849612 systemd[1]: Created slice system-systemd\x2dfsck.slice - Slice /system/systemd-fsck. Aug 13 07:08:57.849621 systemd[1]: Created slice user.slice - User and Session Slice. Aug 13 07:08:57.849630 systemd[1]: Started clevis-luks-askpass.path - Forward Password Requests to Clevis Directory Watch. Aug 13 07:08:57.849639 systemd[1]: Started systemd-ask-password-console.path - Dispatch Password Requests to Console Directory Watch. Aug 13 07:08:57.849647 systemd[1]: Started systemd-ask-password-wall.path - Forward Password Requests to Wall Directory Watch. Aug 13 07:08:57.849656 systemd[1]: Set up automount boot.automount - Boot partition Automount Point. Aug 13 07:08:57.849665 systemd[1]: Set up automount proc-sys-fs-binfmt_misc.automount - Arbitrary Executable File Formats File System Automount Point. Aug 13 07:08:57.849676 systemd[1]: Expecting device dev-disk-by\x2dlabel-OEM.device - /dev/disk/by-label/OEM... Aug 13 07:08:57.849685 systemd[1]: Expecting device dev-ttyAMA0.device - /dev/ttyAMA0... Aug 13 07:08:57.849694 systemd[1]: Reached target cryptsetup-pre.target - Local Encrypted Volumes (Pre). Aug 13 07:08:57.849705 systemd[1]: Stopped target initrd-switch-root.target - Switch Root. Aug 13 07:08:57.849715 systemd[1]: Stopped target initrd-fs.target - Initrd File Systems. Aug 13 07:08:57.849724 systemd[1]: Stopped target initrd-root-fs.target - Initrd Root File System. Aug 13 07:08:57.849733 systemd[1]: Reached target integritysetup.target - Local Integrity Protected Volumes. Aug 13 07:08:57.849743 systemd[1]: Reached target remote-cryptsetup.target - Remote Encrypted Volumes. Aug 13 07:08:57.849753 systemd[1]: Reached target remote-fs.target - Remote File Systems. Aug 13 07:08:57.849762 systemd[1]: Reached target slices.target - Slice Units. Aug 13 07:08:57.849771 systemd[1]: Reached target swap.target - Swaps. Aug 13 07:08:57.849782 systemd[1]: Reached target veritysetup.target - Local Verity Protected Volumes. Aug 13 07:08:57.849791 systemd[1]: Listening on systemd-coredump.socket - Process Core Dump Socket. Aug 13 07:08:57.849800 systemd[1]: Listening on systemd-creds.socket - Credential Encryption/Decryption. Aug 13 07:08:57.849811 systemd[1]: Listening on systemd-networkd.socket - Network Service Netlink Socket. Aug 13 07:08:57.849820 systemd[1]: Listening on systemd-udevd-control.socket - udev Control Socket. Aug 13 07:08:57.849830 systemd[1]: Listening on systemd-udevd-kernel.socket - udev Kernel Socket. Aug 13 07:08:57.849839 systemd[1]: Listening on systemd-userdbd.socket - User Database Manager Socket. Aug 13 07:08:57.849848 systemd[1]: Mounting dev-hugepages.mount - Huge Pages File System... Aug 13 07:08:57.849858 systemd[1]: Mounting dev-mqueue.mount - POSIX Message Queue File System... Aug 13 07:08:57.849867 systemd[1]: Mounting media.mount - External Media Directory... Aug 13 07:08:57.849878 systemd[1]: Mounting sys-kernel-debug.mount - Kernel Debug File System... Aug 13 07:08:57.849887 systemd[1]: Mounting sys-kernel-tracing.mount - Kernel Trace File System... Aug 13 07:08:57.849897 systemd[1]: Mounting tmp.mount - Temporary Directory /tmp... Aug 13 07:08:57.849906 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). Aug 13 07:08:57.849915 systemd[1]: Reached target machines.target - Containers. Aug 13 07:08:57.849924 systemd[1]: Starting flatcar-tmpfiles.service - Create missing system files... Aug 13 07:08:57.849934 systemd[1]: ignition-delete-config.service - Ignition (delete config) was skipped because no trigger condition checks were met. Aug 13 07:08:57.849952 systemd[1]: Starting kmod-static-nodes.service - Create List of Static Device Nodes... Aug 13 07:08:57.849964 systemd[1]: Starting modprobe@configfs.service - Load Kernel Module configfs... Aug 13 07:08:57.849974 systemd[1]: Starting modprobe@dm_mod.service - Load Kernel Module dm_mod... Aug 13 07:08:57.849983 systemd[1]: Starting modprobe@drm.service - Load Kernel Module drm... Aug 13 07:08:57.849993 systemd[1]: Starting modprobe@efi_pstore.service - Load Kernel Module efi_pstore... Aug 13 07:08:57.850003 systemd[1]: Starting modprobe@fuse.service - Load Kernel Module fuse... Aug 13 07:08:57.850012 systemd[1]: Starting modprobe@loop.service - Load Kernel Module loop... Aug 13 07:08:57.850022 systemd[1]: setup-nsswitch.service - Create /etc/nsswitch.conf was skipped because of an unmet condition check (ConditionPathExists=!/etc/nsswitch.conf). Aug 13 07:08:57.850031 systemd[1]: systemd-fsck-root.service: Deactivated successfully. Aug 13 07:08:57.850042 systemd[1]: Stopped systemd-fsck-root.service - File System Check on Root Device. Aug 13 07:08:57.850051 systemd[1]: systemd-fsck-usr.service: Deactivated successfully. Aug 13 07:08:57.850061 kernel: fuse: init (API version 7.39) Aug 13 07:08:57.850069 systemd[1]: Stopped systemd-fsck-usr.service. Aug 13 07:08:57.850079 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). Aug 13 07:08:57.850088 kernel: loop: module loaded Aug 13 07:08:57.850097 systemd[1]: Starting systemd-journald.service - Journal Service... Aug 13 07:08:57.850106 systemd[1]: Starting systemd-modules-load.service - Load Kernel Modules... Aug 13 07:08:57.850116 systemd[1]: Starting systemd-network-generator.service - Generate network units from Kernel command line... Aug 13 07:08:57.850126 kernel: ACPI: bus type drm_connector registered Aug 13 07:08:57.850135 systemd[1]: Starting systemd-remount-fs.service - Remount Root and Kernel File Systems... Aug 13 07:08:57.850163 systemd-journald[1267]: Collecting audit messages is disabled. Aug 13 07:08:57.850184 systemd-journald[1267]: Journal started Aug 13 07:08:57.850205 systemd-journald[1267]: Runtime Journal (/run/log/journal/19209727f5a047d2861c873cb16cb69f) is 8M, max 78.5M, 70.5M free. Aug 13 07:08:56.877871 systemd[1]: Queued start job for default target multi-user.target. Aug 13 07:08:56.885793 systemd[1]: Unnecessary job was removed for dev-sda6.device - /dev/sda6. Aug 13 07:08:56.886196 systemd[1]: systemd-journald.service: Deactivated successfully. Aug 13 07:08:56.886527 systemd[1]: systemd-journald.service: Consumed 3.222s CPU time. Aug 13 07:08:57.876403 systemd[1]: Starting systemd-udev-load-credentials.service - Load udev Rules from Credentials... Aug 13 07:08:57.902678 systemd[1]: Starting systemd-udev-trigger.service - Coldplug All udev Devices... Aug 13 07:08:57.912076 systemd[1]: verity-setup.service: Deactivated successfully. Aug 13 07:08:57.916021 systemd[1]: Stopped verity-setup.service. Aug 13 07:08:57.931158 systemd[1]: Started systemd-journald.service - Journal Service. Aug 13 07:08:57.932215 systemd[1]: Mounted dev-hugepages.mount - Huge Pages File System. Aug 13 07:08:57.939214 systemd[1]: Mounted dev-mqueue.mount - POSIX Message Queue File System. Aug 13 07:08:57.946188 systemd[1]: Mounted media.mount - External Media Directory. Aug 13 07:08:57.951808 systemd[1]: Mounted sys-kernel-debug.mount - Kernel Debug File System. Aug 13 07:08:57.958114 systemd[1]: Mounted sys-kernel-tracing.mount - Kernel Trace File System. Aug 13 07:08:57.964566 systemd[1]: Mounted tmp.mount - Temporary Directory /tmp. Aug 13 07:08:57.972035 systemd[1]: Finished flatcar-tmpfiles.service - Create missing system files. Aug 13 07:08:57.980529 systemd[1]: Finished kmod-static-nodes.service - Create List of Static Device Nodes. Aug 13 07:08:57.987915 systemd[1]: modprobe@configfs.service: Deactivated successfully. Aug 13 07:08:57.988114 systemd[1]: Finished modprobe@configfs.service - Load Kernel Module configfs. Aug 13 07:08:57.995228 systemd[1]: modprobe@dm_mod.service: Deactivated successfully. Aug 13 07:08:57.995392 systemd[1]: Finished modprobe@dm_mod.service - Load Kernel Module dm_mod. Aug 13 07:08:58.002342 systemd[1]: modprobe@drm.service: Deactivated successfully. Aug 13 07:08:58.002506 systemd[1]: Finished modprobe@drm.service - Load Kernel Module drm. Aug 13 07:08:58.009229 systemd[1]: modprobe@efi_pstore.service: Deactivated successfully. Aug 13 07:08:58.009392 systemd[1]: Finished modprobe@efi_pstore.service - Load Kernel Module efi_pstore. Aug 13 07:08:58.016683 systemd[1]: modprobe@fuse.service: Deactivated successfully. Aug 13 07:08:58.016839 systemd[1]: Finished modprobe@fuse.service - Load Kernel Module fuse. Aug 13 07:08:58.025440 systemd[1]: modprobe@loop.service: Deactivated successfully. Aug 13 07:08:58.025606 systemd[1]: Finished modprobe@loop.service - Load Kernel Module loop. Aug 13 07:08:58.032284 systemd[1]: Finished systemd-modules-load.service - Load Kernel Modules. Aug 13 07:08:58.039612 systemd[1]: Finished systemd-network-generator.service - Generate network units from Kernel command line. Aug 13 07:08:58.047621 systemd[1]: Finished systemd-remount-fs.service - Remount Root and Kernel File Systems. Aug 13 07:08:58.055817 systemd[1]: Finished systemd-udev-load-credentials.service - Load udev Rules from Credentials. Aug 13 07:08:58.063298 systemd[1]: Finished systemd-udev-trigger.service - Coldplug All udev Devices. Aug 13 07:08:58.085159 systemd[1]: Reached target network-pre.target - Preparation for Network. Aug 13 07:08:58.099063 systemd[1]: Mounting sys-fs-fuse-connections.mount - FUSE Control File System... Aug 13 07:08:58.106916 systemd[1]: Mounting sys-kernel-config.mount - Kernel Configuration File System... Aug 13 07:08:58.113797 systemd[1]: remount-root.service - Remount Root File System was skipped because of an unmet condition check (ConditionPathIsReadWrite=!/). Aug 13 07:08:58.113839 systemd[1]: Reached target local-fs.target - Local File Systems. Aug 13 07:08:58.121902 systemd[1]: Listening on systemd-sysext.socket - System Extension Image Management. Aug 13 07:08:58.130559 systemd[1]: Starting dracut-shutdown.service - Restore /run/initramfs on shutdown... Aug 13 07:08:58.139350 systemd[1]: Starting ldconfig.service - Rebuild Dynamic Linker Cache... Aug 13 07:08:58.145226 systemd[1]: systemd-binfmt.service - Set Up Additional Binary Formats was skipped because no trigger condition checks were met. Aug 13 07:08:58.146648 systemd[1]: Starting systemd-hwdb-update.service - Rebuild Hardware Database... Aug 13 07:08:58.154628 systemd[1]: Starting systemd-journal-flush.service - Flush Journal to Persistent Storage... Aug 13 07:08:58.161352 systemd[1]: systemd-pstore.service - Platform Persistent Storage Archival was skipped because of an unmet condition check (ConditionDirectoryNotEmpty=/sys/fs/pstore). Aug 13 07:08:58.163141 systemd[1]: Starting systemd-random-seed.service - Load/Save OS Random Seed... Aug 13 07:08:58.169862 systemd[1]: systemd-repart.service - Repartition Root Disk was skipped because no trigger condition checks were met. Aug 13 07:08:58.171200 systemd[1]: Starting systemd-sysctl.service - Apply Kernel Variables... Aug 13 07:08:58.181171 systemd[1]: Starting systemd-sysext.service - Merge System Extension Images into /usr/ and /opt/... Aug 13 07:08:58.196669 systemd-journald[1267]: Time spent on flushing to /var/log/journal/19209727f5a047d2861c873cb16cb69f is 71.805ms for 893 entries. Aug 13 07:08:58.196669 systemd-journald[1267]: System Journal (/var/log/journal/19209727f5a047d2861c873cb16cb69f) is 11.8M, max 2.6G, 2.6G free. Aug 13 07:08:58.407620 systemd-journald[1267]: Received client request to flush runtime journal. Aug 13 07:08:58.407678 kernel: loop0: detected capacity change from 0 to 28720 Aug 13 07:08:58.407698 systemd-journald[1267]: /var/log/journal/19209727f5a047d2861c873cb16cb69f/system.journal: Realtime clock jumped backwards relative to last journal entry, rotating. Aug 13 07:08:58.407723 systemd-journald[1267]: Rotating system journal. Aug 13 07:08:58.208198 systemd[1]: Starting systemd-tmpfiles-setup-dev-early.service - Create Static Device Nodes in /dev gracefully... Aug 13 07:08:58.218158 systemd[1]: Starting systemd-udev-settle.service - Wait for udev To Complete Device Initialization... Aug 13 07:08:58.226589 systemd[1]: Mounted sys-fs-fuse-connections.mount - FUSE Control File System. Aug 13 07:08:58.235032 systemd[1]: Mounted sys-kernel-config.mount - Kernel Configuration File System. Aug 13 07:08:58.250781 systemd[1]: Finished dracut-shutdown.service - Restore /run/initramfs on shutdown. Aug 13 07:08:58.259324 systemd[1]: Finished systemd-random-seed.service - Load/Save OS Random Seed. Aug 13 07:08:58.271401 systemd[1]: Reached target first-boot-complete.target - First Boot Complete. Aug 13 07:08:58.302649 systemd[1]: Starting systemd-machine-id-commit.service - Save Transient machine-id to Disk... Aug 13 07:08:58.311982 systemd[1]: Finished systemd-sysctl.service - Apply Kernel Variables. Aug 13 07:08:58.320868 udevadm[1307]: systemd-udev-settle.service is deprecated. Please fix lvm2-activation.service, lvm2-activation-early.service not to pull it in. Aug 13 07:08:58.394530 systemd-tmpfiles[1305]: ACLs are not supported, ignoring. Aug 13 07:08:58.394541 systemd-tmpfiles[1305]: ACLs are not supported, ignoring. Aug 13 07:08:58.398797 systemd[1]: Finished systemd-tmpfiles-setup-dev-early.service - Create Static Device Nodes in /dev gracefully. Aug 13 07:08:58.412221 systemd[1]: Starting systemd-sysusers.service - Create System Users... Aug 13 07:08:58.420299 systemd[1]: Finished systemd-journal-flush.service - Flush Journal to Persistent Storage. Aug 13 07:08:58.435183 systemd[1]: etc-machine\x2did.mount: Deactivated successfully. Aug 13 07:08:58.435821 systemd[1]: Finished systemd-machine-id-commit.service - Save Transient machine-id to Disk. Aug 13 07:08:58.631986 kernel: squashfs: version 4.0 (2009/01/31) Phillip Lougher Aug 13 07:08:58.697014 systemd[1]: Finished systemd-sysusers.service - Create System Users. Aug 13 07:08:58.710142 systemd[1]: Starting systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev... Aug 13 07:08:58.724205 systemd-tmpfiles[1325]: ACLs are not supported, ignoring. Aug 13 07:08:58.724220 systemd-tmpfiles[1325]: ACLs are not supported, ignoring. Aug 13 07:08:58.728839 systemd[1]: Finished systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev. Aug 13 07:08:58.760087 kernel: loop1: detected capacity change from 0 to 113512 Aug 13 07:08:59.121979 kernel: loop2: detected capacity change from 0 to 123192 Aug 13 07:08:59.343366 systemd[1]: Finished systemd-hwdb-update.service - Rebuild Hardware Database. Aug 13 07:08:59.357119 systemd[1]: Starting systemd-udevd.service - Rule-based Manager for Device Events and Files... Aug 13 07:08:59.383036 systemd-udevd[1331]: Using default interface naming scheme 'v255'. Aug 13 07:08:59.453994 kernel: loop3: detected capacity change from 0 to 28720 Aug 13 07:08:59.462971 kernel: loop4: detected capacity change from 0 to 113512 Aug 13 07:08:59.472973 kernel: loop5: detected capacity change from 0 to 123192 Aug 13 07:08:59.477302 (sd-merge)[1333]: Using extensions 'containerd-flatcar', 'docker-flatcar', 'oem-azure'. Aug 13 07:08:59.477713 (sd-merge)[1333]: Merged extensions into '/usr'. Aug 13 07:08:59.481830 systemd[1]: Finished systemd-sysext.service - Merge System Extension Images into /usr/ and /opt/. Aug 13 07:08:59.505274 systemd[1]: Starting ensure-sysext.service... Aug 13 07:08:59.512399 systemd[1]: Starting systemd-tmpfiles-setup.service - Create System Files and Directories... Aug 13 07:08:59.543085 systemd[1]: Reload requested from client PID 1335 ('systemctl') (unit ensure-sysext.service)... Aug 13 07:08:59.543102 systemd[1]: Reloading... Aug 13 07:08:59.566165 systemd-tmpfiles[1336]: /usr/lib/tmpfiles.d/provision.conf:20: Duplicate line for path "/root", ignoring. Aug 13 07:08:59.566379 systemd-tmpfiles[1336]: /usr/lib/tmpfiles.d/systemd-flatcar.conf:6: Duplicate line for path "/var/log/journal", ignoring. Aug 13 07:08:59.567517 systemd-tmpfiles[1336]: /usr/lib/tmpfiles.d/systemd.conf:29: Duplicate line for path "/var/lib/systemd", ignoring. Aug 13 07:08:59.567841 systemd-tmpfiles[1336]: ACLs are not supported, ignoring. Aug 13 07:08:59.567990 systemd-tmpfiles[1336]: ACLs are not supported, ignoring. Aug 13 07:08:59.584869 systemd-tmpfiles[1336]: Detected autofs mount point /boot during canonicalization of boot. Aug 13 07:08:59.585196 systemd-tmpfiles[1336]: Skipping /boot Aug 13 07:08:59.600193 systemd-tmpfiles[1336]: Detected autofs mount point /boot during canonicalization of boot. Aug 13 07:08:59.600369 systemd-tmpfiles[1336]: Skipping /boot Aug 13 07:08:59.630024 zram_generator::config[1375]: No configuration found. Aug 13 07:08:59.742864 systemd[1]: /usr/lib/systemd/system/docker.socket:6: ListenStream= references a path below legacy directory /var/run/, updating /var/run/docker.sock → /run/docker.sock; please update the unit file accordingly. Aug 13 07:08:59.841056 systemd[1]: Reloading finished in 297 ms. Aug 13 07:08:59.852578 systemd[1]: Started systemd-udevd.service - Rule-based Manager for Device Events and Files. Aug 13 07:08:59.877376 systemd[1]: Finished systemd-tmpfiles-setup.service - Create System Files and Directories. Aug 13 07:08:59.911984 kernel: mousedev: PS/2 mouse device common for all mice Aug 13 07:08:59.912892 systemd[1]: Condition check resulted in dev-ttyAMA0.device - /dev/ttyAMA0 being skipped. Aug 13 07:08:59.924667 systemd[1]: Starting audit-rules.service - Load Audit Rules... Aug 13 07:08:59.945732 systemd[1]: Starting clean-ca-certificates.service - Clean up broken links in /etc/ssl/certs... Aug 13 07:08:59.957150 systemd[1]: ignition-delete-config.service - Ignition (delete config) was skipped because no trigger condition checks were met. Aug 13 07:08:59.958911 systemd[1]: Starting modprobe@dm_mod.service - Load Kernel Module dm_mod... Aug 13 07:08:59.979816 kernel: hv_vmbus: registering driver hv_balloon Aug 13 07:08:59.979909 kernel: hv_vmbus: registering driver hyperv_fb Aug 13 07:08:59.979934 kernel: hv_balloon: Using Dynamic Memory protocol version 2.0 Aug 13 07:08:59.995739 kernel: hyperv_fb: Synthvid Version major 3, minor 5 Aug 13 07:08:59.995806 kernel: hyperv_fb: Screen resolution: 1024x768, Color depth: 32, Frame buffer size: 8388608 Aug 13 07:08:59.995845 kernel: hv_balloon: Memory hot add disabled on ARM64 Aug 13 07:08:59.991198 systemd[1]: Starting modprobe@efi_pstore.service - Load Kernel Module efi_pstore... Aug 13 07:09:00.013501 kernel: Console: switching to colour dummy device 80x25 Aug 13 07:09:00.024052 kernel: Console: switching to colour frame buffer device 128x48 Aug 13 07:09:00.021244 systemd[1]: Starting modprobe@loop.service - Load Kernel Module loop... Aug 13 07:09:00.037148 systemd[1]: systemd-binfmt.service - Set Up Additional Binary Formats was skipped because no trigger condition checks were met. Aug 13 07:09:00.037354 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). Aug 13 07:09:00.045428 systemd[1]: Starting systemd-journal-catalog-update.service - Rebuild Journal Catalog... Aug 13 07:09:00.058403 systemd[1]: Starting systemd-networkd.service - Network Configuration... Aug 13 07:09:00.072154 systemd[1]: Starting systemd-resolved.service - Network Name Resolution... Aug 13 07:09:00.084630 systemd[1]: Starting systemd-update-utmp.service - Record System Boot/Shutdown in UTMP... Aug 13 07:09:00.096637 systemd[1]: modprobe@dm_mod.service: Deactivated successfully. Aug 13 07:09:00.097043 systemd[1]: Finished modprobe@dm_mod.service - Load Kernel Module dm_mod. Aug 13 07:09:00.105779 systemd[1]: modprobe@efi_pstore.service: Deactivated successfully. Aug 13 07:09:00.106100 systemd[1]: Finished modprobe@efi_pstore.service - Load Kernel Module efi_pstore. Aug 13 07:09:00.117865 systemd[1]: modprobe@loop.service: Deactivated successfully. Aug 13 07:09:00.120086 systemd[1]: Finished modprobe@loop.service - Load Kernel Module loop. Aug 13 07:09:00.150288 systemd[1]: Finished systemd-update-utmp.service - Record System Boot/Shutdown in UTMP. Aug 13 07:09:00.169185 systemd[1]: Finished systemd-journal-catalog-update.service - Rebuild Journal Catalog. Aug 13 07:09:00.172081 kernel: BTRFS warning: duplicate device /dev/sda3 devid 1 generation 42 scanned by (udev-worker) (1429) Aug 13 07:09:00.208068 systemd[1]: ignition-delete-config.service - Ignition (delete config) was skipped because no trigger condition checks were met. Aug 13 07:09:00.216182 systemd[1]: Starting modprobe@dm_mod.service - Load Kernel Module dm_mod... Aug 13 07:09:00.227649 augenrules[1523]: No rules Aug 13 07:09:00.228649 systemd[1]: Starting modprobe@drm.service - Load Kernel Module drm... Aug 13 07:09:00.248262 systemd[1]: Starting modprobe@efi_pstore.service - Load Kernel Module efi_pstore... Aug 13 07:09:00.264153 systemd[1]: Starting modprobe@loop.service - Load Kernel Module loop... Aug 13 07:09:00.276499 systemd[1]: systemd-binfmt.service - Set Up Additional Binary Formats was skipped because no trigger condition checks were met. Aug 13 07:09:00.276549 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). Aug 13 07:09:00.276606 systemd[1]: Reached target time-set.target - System Time Set. Aug 13 07:09:00.297176 systemd[1]: Starting systemd-userdbd.service - User Database Manager... Aug 13 07:09:00.314105 systemd[1]: Starting systemd-vconsole-setup.service - Virtual Console Setup... Aug 13 07:09:00.322995 systemd[1]: Finished ensure-sysext.service. Aug 13 07:09:00.330670 systemd[1]: audit-rules.service: Deactivated successfully. Aug 13 07:09:00.330874 systemd[1]: Finished audit-rules.service - Load Audit Rules. Aug 13 07:09:00.337049 systemd[1]: modprobe@dm_mod.service: Deactivated successfully. Aug 13 07:09:00.337223 systemd[1]: Finished modprobe@dm_mod.service - Load Kernel Module dm_mod. Aug 13 07:09:00.343687 systemd[1]: modprobe@drm.service: Deactivated successfully. Aug 13 07:09:00.345299 systemd[1]: Finished modprobe@drm.service - Load Kernel Module drm. Aug 13 07:09:00.354203 systemd[1]: modprobe@efi_pstore.service: Deactivated successfully. Aug 13 07:09:00.354379 systemd[1]: Finished modprobe@efi_pstore.service - Load Kernel Module efi_pstore. Aug 13 07:09:00.361924 systemd[1]: Started systemd-userdbd.service - User Database Manager. Aug 13 07:09:00.368795 systemd[1]: modprobe@loop.service: Deactivated successfully. Aug 13 07:09:00.369091 systemd[1]: Finished modprobe@loop.service - Load Kernel Module loop. Aug 13 07:09:00.411898 systemd[1]: Found device dev-disk-by\x2dlabel-OEM.device - Virtual_Disk OEM. Aug 13 07:09:00.440256 systemd[1]: Starting systemd-fsck@dev-disk-by\x2dlabel-OEM.service - File System Check on /dev/disk/by-label/OEM... Aug 13 07:09:00.451803 systemd[1]: systemd-pstore.service - Platform Persistent Storage Archival was skipped because of an unmet condition check (ConditionDirectoryNotEmpty=/sys/fs/pstore). Aug 13 07:09:00.451885 systemd[1]: systemd-repart.service - Repartition Root Disk was skipped because no trigger condition checks were met. Aug 13 07:09:00.452656 systemd[1]: Finished systemd-udev-settle.service - Wait for udev To Complete Device Initialization. Aug 13 07:09:00.461591 systemd[1]: systemd-vconsole-setup.service: Deactivated successfully. Aug 13 07:09:00.461817 systemd[1]: Stopped systemd-vconsole-setup.service - Virtual Console Setup. Aug 13 07:09:00.469766 systemd[1]: run-credentials-systemd\x2dvconsole\x2dsetup.service.mount: Deactivated successfully. Aug 13 07:09:00.480161 systemd[1]: Starting lvm2-activation-early.service - Activation of LVM2 logical volumes... Aug 13 07:09:00.489193 systemd[1]: Starting systemd-vconsole-setup.service - Virtual Console Setup... Aug 13 07:09:00.508728 systemd[1]: Finished systemd-fsck@dev-disk-by\x2dlabel-OEM.service - File System Check on /dev/disk/by-label/OEM. Aug 13 07:09:00.560514 systemd-networkd[1479]: lo: Link UP Aug 13 07:09:00.560523 systemd-networkd[1479]: lo: Gained carrier Aug 13 07:09:00.563308 systemd-networkd[1479]: Enumeration completed Aug 13 07:09:00.563466 systemd[1]: Started systemd-networkd.service - Network Configuration. Aug 13 07:09:00.563823 systemd-networkd[1479]: eth0: found matching network '/usr/lib/systemd/network/zz-default.network', based on potentially unpredictable interface name. Aug 13 07:09:00.563897 systemd-networkd[1479]: eth0: Configuring with /usr/lib/systemd/network/zz-default.network. Aug 13 07:09:00.566015 lvm[1583]: WARNING: Failed to connect to lvmetad. Falling back to device scanning. Aug 13 07:09:00.576855 systemd-resolved[1482]: Positive Trust Anchors: Aug 13 07:09:00.577268 systemd-resolved[1482]: . IN DS 20326 8 2 e06d44b80b8f1d39a95c0b0d7c65d08458e880409bbc683457104237c7f8ec8d Aug 13 07:09:00.577690 systemd-resolved[1482]: 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 Aug 13 07:09:00.581141 systemd[1]: Starting systemd-networkd-persistent-storage.service - Enable Persistent Storage in systemd-networkd... Aug 13 07:09:00.595207 systemd[1]: Starting systemd-networkd-wait-online.service - Wait for Network to be Configured... Aug 13 07:09:00.595608 systemd-resolved[1482]: Using system hostname 'ci-4230.2.2-a-8f178afe22'. Aug 13 07:09:00.609378 systemd[1]: Finished lvm2-activation-early.service - Activation of LVM2 logical volumes. Aug 13 07:09:00.618076 systemd[1]: Reached target cryptsetup.target - Local Encrypted Volumes. Aug 13 07:09:00.630805 systemd[1]: Starting lvm2-activation.service - Activation of LVM2 logical volumes... Aug 13 07:09:00.638262 lvm[1593]: WARNING: Failed to connect to lvmetad. Falling back to device scanning. Aug 13 07:09:00.639960 kernel: mlx5_core 54b6:00:02.0 enP21686s1: Link up Aug 13 07:09:00.669643 systemd[1]: Finished lvm2-activation.service - Activation of LVM2 logical volumes. Aug 13 07:09:00.684193 kernel: hv_netvsc 000d3afb-062a-000d-3afb-062a000d3afb eth0: Data path switched to VF: enP21686s1 Aug 13 07:09:00.687111 systemd-networkd[1479]: enP21686s1: Link UP Aug 13 07:09:00.687203 systemd-networkd[1479]: eth0: Link UP Aug 13 07:09:00.687206 systemd-networkd[1479]: eth0: Gained carrier Aug 13 07:09:00.687221 systemd-networkd[1479]: eth0: found matching network '/usr/lib/systemd/network/zz-default.network', based on potentially unpredictable interface name. Aug 13 07:09:00.688339 systemd[1]: Finished systemd-networkd-persistent-storage.service - Enable Persistent Storage in systemd-networkd. Aug 13 07:09:00.695553 systemd[1]: Started systemd-resolved.service - Network Name Resolution. Aug 13 07:09:00.702488 systemd[1]: Reached target network.target - Network. Aug 13 07:09:00.707585 systemd[1]: Reached target nss-lookup.target - Host and Network Name Lookups. Aug 13 07:09:00.714065 systemd-networkd[1479]: enP21686s1: Gained carrier Aug 13 07:09:00.717993 systemd-networkd[1479]: eth0: DHCPv4 address 10.200.20.45/24, gateway 10.200.20.1 acquired from 168.63.129.16 Aug 13 07:09:00.735265 systemd[1]: Finished systemd-vconsole-setup.service - Virtual Console Setup. Aug 13 07:09:00.972788 systemd[1]: Finished clean-ca-certificates.service - Clean up broken links in /etc/ssl/certs. Aug 13 07:09:00.982409 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). Aug 13 07:09:02.421093 systemd-networkd[1479]: eth0: Gained IPv6LL Aug 13 07:09:02.424016 systemd[1]: Finished systemd-networkd-wait-online.service - Wait for Network to be Configured. Aug 13 07:09:02.432509 systemd[1]: Reached target network-online.target - Network is Online. Aug 13 07:09:03.270620 ldconfig[1298]: /sbin/ldconfig: /usr/lib/ld.so.conf is not an ELF file - it has the wrong magic bytes at the start. Aug 13 07:09:03.289167 systemd[1]: Finished ldconfig.service - Rebuild Dynamic Linker Cache. Aug 13 07:09:03.299227 systemd[1]: Starting systemd-update-done.service - Update is Completed... Aug 13 07:09:03.314980 systemd[1]: Finished systemd-update-done.service - Update is Completed. Aug 13 07:09:03.321278 systemd[1]: Reached target sysinit.target - System Initialization. Aug 13 07:09:03.326867 systemd[1]: Started motdgen.path - Watch for update engine configuration changes. Aug 13 07:09:03.333493 systemd[1]: Started user-cloudinit@var-lib-flatcar\x2dinstall-user_data.path - Watch for a cloud-config at /var/lib/flatcar-install/user_data. Aug 13 07:09:03.340232 systemd[1]: Started logrotate.timer - Daily rotation of log files. Aug 13 07:09:03.345937 systemd[1]: Started mdadm.timer - Weekly check for MD array's redundancy information.. Aug 13 07:09:03.352582 systemd[1]: Started systemd-tmpfiles-clean.timer - Daily Cleanup of Temporary Directories. Aug 13 07:09:03.359046 systemd[1]: update-engine-stub.timer - Update Engine Stub Timer was skipped because of an unmet condition check (ConditionPathExists=/usr/.noupdate). Aug 13 07:09:03.359081 systemd[1]: Reached target paths.target - Path Units. Aug 13 07:09:03.363857 systemd[1]: Reached target timers.target - Timer Units. Aug 13 07:09:03.369546 systemd[1]: Listening on dbus.socket - D-Bus System Message Bus Socket. Aug 13 07:09:03.377045 systemd[1]: Starting docker.socket - Docker Socket for the API... Aug 13 07:09:03.384377 systemd[1]: Listening on sshd-unix-local.socket - OpenSSH Server Socket (systemd-ssh-generator, AF_UNIX Local). Aug 13 07:09:03.391319 systemd[1]: Listening on sshd-vsock.socket - OpenSSH Server Socket (systemd-ssh-generator, AF_VSOCK). Aug 13 07:09:03.398209 systemd[1]: Reached target ssh-access.target - SSH Access Available. Aug 13 07:09:03.411660 systemd[1]: Listening on sshd.socket - OpenSSH Server Socket. Aug 13 07:09:03.417973 systemd[1]: Listening on systemd-hostnamed.socket - Hostname Service Socket. Aug 13 07:09:03.424715 systemd[1]: Listening on docker.socket - Docker Socket for the API. Aug 13 07:09:03.430938 systemd[1]: Reached target sockets.target - Socket Units. Aug 13 07:09:03.436009 systemd[1]: Reached target basic.target - Basic System. Aug 13 07:09:03.440933 systemd[1]: addon-config@oem.service - Configure Addon /oem was skipped because no trigger condition checks were met. Aug 13 07:09:03.440968 systemd[1]: addon-run@oem.service - Run Addon /oem was skipped because no trigger condition checks were met. Aug 13 07:09:03.455062 systemd[1]: Starting chronyd.service - NTP client/server... Aug 13 07:09:03.464108 systemd[1]: Starting containerd.service - containerd container runtime... Aug 13 07:09:03.475120 systemd[1]: Starting coreos-metadata.service - Flatcar Metadata Agent... Aug 13 07:09:03.486870 systemd[1]: Starting dbus.service - D-Bus System Message Bus... Aug 13 07:09:03.495280 (chronyd)[1606]: chronyd.service: Referenced but unset environment variable evaluates to an empty string: OPTIONS Aug 13 07:09:03.503032 systemd[1]: Starting enable-oem-cloudinit.service - Enable cloudinit... Aug 13 07:09:03.509531 systemd[1]: Starting extend-filesystems.service - Extend Filesystems... Aug 13 07:09:03.513966 jq[1613]: false Aug 13 07:09:03.514900 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). Aug 13 07:09:03.514936 systemd[1]: hv_fcopy_daemon.service - Hyper-V FCOPY daemon was skipped because of an unmet condition check (ConditionPathExists=/dev/vmbus/hv_fcopy). Aug 13 07:09:03.517167 systemd[1]: Started hv_kvp_daemon.service - Hyper-V KVP daemon. Aug 13 07:09:03.524087 systemd[1]: hv_vss_daemon.service - Hyper-V VSS daemon was skipped because of an unmet condition check (ConditionPathExists=/dev/vmbus/hv_vss). Aug 13 07:09:03.525872 systemd[1]: Starting motdgen.service - Generate /run/flatcar/motd... Aug 13 07:09:03.535397 KVP[1615]: KVP starting; pid is:1615 Aug 13 07:09:03.540210 systemd[1]: Starting nvidia.service - NVIDIA Configure Service... Aug 13 07:09:03.549964 kernel: hv_utils: KVP IC version 4.0 Aug 13 07:09:03.550042 KVP[1615]: KVP LIC Version: 3.1 Aug 13 07:09:03.552779 systemd[1]: Starting ssh-key-proc-cmdline.service - Install an ssh key from /proc/cmdline... Aug 13 07:09:03.562821 chronyd[1624]: chronyd version 4.6.1 starting (+CMDMON +NTP +REFCLOCK +RTC +PRIVDROP +SCFILTER -SIGND +ASYNCDNS +NTS +SECHASH +IPV6 -DEBUG) Aug 13 07:09:03.565189 systemd[1]: Starting sshd-keygen.service - Generate sshd host keys... Aug 13 07:09:03.583209 systemd[1]: Starting systemd-logind.service - User Login Management... Aug 13 07:09:03.594703 systemd[1]: tcsd.service - TCG Core Services Daemon was skipped because of an unmet condition check (ConditionPathExists=/dev/tpm0). Aug 13 07:09:03.596363 systemd[1]: cgroup compatibility translation between legacy and unified hierarchy settings activated. See cgroup-compat debug messages for details. Aug 13 07:09:03.601665 systemd[1]: Starting update-engine.service - Update Engine... Aug 13 07:09:03.608545 extend-filesystems[1614]: Found loop3 Aug 13 07:09:03.608545 extend-filesystems[1614]: Found loop4 Aug 13 07:09:03.634285 extend-filesystems[1614]: Found loop5 Aug 13 07:09:03.634285 extend-filesystems[1614]: Found sda Aug 13 07:09:03.634285 extend-filesystems[1614]: Found sda1 Aug 13 07:09:03.634285 extend-filesystems[1614]: Found sda2 Aug 13 07:09:03.634285 extend-filesystems[1614]: Found sda3 Aug 13 07:09:03.634285 extend-filesystems[1614]: Found usr Aug 13 07:09:03.634285 extend-filesystems[1614]: Found sda4 Aug 13 07:09:03.634285 extend-filesystems[1614]: Found sda6 Aug 13 07:09:03.634285 extend-filesystems[1614]: Found sda7 Aug 13 07:09:03.634285 extend-filesystems[1614]: Found sda9 Aug 13 07:09:03.634285 extend-filesystems[1614]: Checking size of /dev/sda9 Aug 13 07:09:03.621731 chronyd[1624]: Timezone right/UTC failed leap second check, ignoring Aug 13 07:09:03.618214 systemd[1]: Starting update-ssh-keys-after-ignition.service - Run update-ssh-keys once after Ignition... Aug 13 07:09:03.802239 extend-filesystems[1614]: Old size kept for /dev/sda9 Aug 13 07:09:03.802239 extend-filesystems[1614]: Found sr0 Aug 13 07:09:03.621929 chronyd[1624]: Loaded seccomp filter (level 2) Aug 13 07:09:03.639982 systemd[1]: Started chronyd.service - NTP client/server. Aug 13 07:09:03.828570 update_engine[1633]: I20250813 07:09:03.676136 1633 main.cc:92] Flatcar Update Engine starting Aug 13 07:09:03.828570 update_engine[1633]: I20250813 07:09:03.731119 1633 update_check_scheduler.cc:74] Next update check in 7m27s Aug 13 07:09:03.829010 coreos-metadata[1608]: Aug 13 07:09:03.818 INFO Fetching http://168.63.129.16/?comp=versions: Attempt #1 Aug 13 07:09:03.829010 coreos-metadata[1608]: Aug 13 07:09:03.820 INFO Fetch successful Aug 13 07:09:03.829010 coreos-metadata[1608]: Aug 13 07:09:03.820 INFO Fetching http://168.63.129.16/machine/?comp=goalstate: Attempt #1 Aug 13 07:09:03.829010 coreos-metadata[1608]: Aug 13 07:09:03.828 INFO Fetch successful Aug 13 07:09:03.829010 coreos-metadata[1608]: Aug 13 07:09:03.828 INFO Fetching http://168.63.129.16/machine/982e9708-8b39-46af-88f6-5695255103fd/f5dc7c98%2Dc819%2D4916%2D98e9%2D570796f23db9.%5Fci%2D4230.2.2%2Da%2D8f178afe22?comp=config&type=sharedConfig&incarnation=1: Attempt #1 Aug 13 07:09:03.723105 dbus-daemon[1609]: [system] SELinux support is enabled Aug 13 07:09:03.662344 systemd[1]: enable-oem-cloudinit.service: Skipped due to 'exec-condition'. Aug 13 07:09:03.829523 jq[1636]: true Aug 13 07:09:03.774729 dbus-daemon[1609]: [system] Successfully activated service 'org.freedesktop.systemd1' Aug 13 07:09:03.662553 systemd[1]: Condition check resulted in enable-oem-cloudinit.service - Enable cloudinit being skipped. Aug 13 07:09:03.662827 systemd[1]: motdgen.service: Deactivated successfully. Aug 13 07:09:03.829851 jq[1658]: true Aug 13 07:09:03.663006 systemd[1]: Finished motdgen.service - Generate /run/flatcar/motd. Aug 13 07:09:03.836551 coreos-metadata[1608]: Aug 13 07:09:03.834 INFO Fetch successful Aug 13 07:09:03.836551 coreos-metadata[1608]: Aug 13 07:09:03.834 INFO Fetching http://169.254.169.254/metadata/instance/compute/vmSize?api-version=2017-08-01&format=text: Attempt #1 Aug 13 07:09:03.674523 systemd[1]: Finished nvidia.service - NVIDIA Configure Service. Aug 13 07:09:03.681308 systemd[1]: ssh-key-proc-cmdline.service: Deactivated successfully. Aug 13 07:09:03.681535 systemd[1]: Finished ssh-key-proc-cmdline.service - Install an ssh key from /proc/cmdline. Aug 13 07:09:03.692807 systemd[1]: extend-filesystems.service: Deactivated successfully. Aug 13 07:09:03.693047 systemd[1]: Finished extend-filesystems.service - Extend Filesystems. Aug 13 07:09:03.706234 systemd-logind[1626]: New seat seat0. Aug 13 07:09:03.707937 systemd-logind[1626]: Watching system buttons on /dev/input/event1 (AT Translated Set 2 keyboard) Aug 13 07:09:03.849668 coreos-metadata[1608]: Aug 13 07:09:03.848 INFO Fetch successful Aug 13 07:09:03.717481 systemd[1]: Started systemd-logind.service - User Login Management. Aug 13 07:09:03.737371 systemd[1]: Started dbus.service - D-Bus System Message Bus. Aug 13 07:09:03.772967 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). Aug 13 07:09:03.773025 systemd[1]: Reached target system-config.target - Load system-provided cloud configs. Aug 13 07:09:03.776910 (ntainerd)[1661]: containerd.service: Referenced but unset environment variable evaluates to an empty string: TORCX_IMAGEDIR, TORCX_UNPACKDIR Aug 13 07:09:03.792631 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). Aug 13 07:09:03.792655 systemd[1]: Reached target user-config.target - Load user-provided cloud configs. Aug 13 07:09:03.813403 systemd[1]: Started update-engine.service - Update Engine. Aug 13 07:09:03.842141 systemd[1]: Started locksmithd.service - Cluster reboot manager. Aug 13 07:09:03.870092 kernel: BTRFS warning: duplicate device /dev/sda3 devid 1 generation 42 scanned by (udev-worker) (1660) Aug 13 07:09:03.898826 systemd[1]: Finished coreos-metadata.service - Flatcar Metadata Agent. Aug 13 07:09:03.913895 systemd[1]: Starting etcd-member.service - etcd (System Application Container)... Aug 13 07:09:03.923892 systemd[1]: packet-phone-home.service - Report Success to Packet was skipped because no trigger condition checks were met. Aug 13 07:09:03.943124 (-wrapper)[1718]: etcd-member.service: Referenced but unset environment variable evaluates to an empty string: ETCD_OPTS Aug 13 07:09:03.967624 bash[1691]: Updated "/home/core/.ssh/authorized_keys" Aug 13 07:09:03.959846 systemd[1]: Finished update-ssh-keys-after-ignition.service - Run update-ssh-keys once after Ignition. Aug 13 07:09:03.970020 systemd[1]: sshkeys.service was skipped because no trigger condition checks were met. Aug 13 07:09:04.080715 locksmithd[1684]: locksmithd starting currentOperation="UPDATE_STATUS_IDLE" strategy="reboot" Aug 13 07:09:04.211960 containerd[1661]: time="2025-08-13T07:09:04.211858820Z" level=info msg="starting containerd" revision=9b2ad7760328148397346d10c7b2004271249db4 version=v1.7.23 Aug 13 07:09:04.247722 containerd[1661]: time="2025-08-13T07:09:04.247670940Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.aufs\"..." type=io.containerd.snapshotter.v1 Aug 13 07:09:04.249081 containerd[1661]: time="2025-08-13T07:09:04.249041580Z" level=info msg="skip loading plugin \"io.containerd.snapshotter.v1.aufs\"..." error="aufs is not supported (modprobe aufs failed: exit status 1 \"modprobe: FATAL: Module aufs not found in directory /lib/modules/6.6.100-flatcar\\n\"): skip plugin" type=io.containerd.snapshotter.v1 Aug 13 07:09:04.249081 containerd[1661]: time="2025-08-13T07:09:04.249078620Z" level=info msg="loading plugin \"io.containerd.event.v1.exchange\"..." type=io.containerd.event.v1 Aug 13 07:09:04.249149 containerd[1661]: time="2025-08-13T07:09:04.249097060Z" level=info msg="loading plugin \"io.containerd.internal.v1.opt\"..." type=io.containerd.internal.v1 Aug 13 07:09:04.249283 containerd[1661]: time="2025-08-13T07:09:04.249261540Z" level=info msg="loading plugin \"io.containerd.warning.v1.deprecations\"..." type=io.containerd.warning.v1 Aug 13 07:09:04.249310 containerd[1661]: time="2025-08-13T07:09:04.249284140Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.blockfile\"..." type=io.containerd.snapshotter.v1 Aug 13 07:09:04.249378 containerd[1661]: time="2025-08-13T07:09:04.249358100Z" level=info msg="skip loading plugin \"io.containerd.snapshotter.v1.blockfile\"..." error="no scratch file generator: skip plugin" type=io.containerd.snapshotter.v1 Aug 13 07:09:04.249405 containerd[1661]: time="2025-08-13T07:09:04.249375740Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.btrfs\"..." type=io.containerd.snapshotter.v1 Aug 13 07:09:04.249591 containerd[1661]: time="2025-08-13T07:09:04.249569580Z" level=info msg="skip loading plugin \"io.containerd.snapshotter.v1.btrfs\"..." 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" type=io.containerd.snapshotter.v1 Aug 13 07:09:04.249591 containerd[1661]: time="2025-08-13T07:09:04.249588380Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.devmapper\"..." type=io.containerd.snapshotter.v1 Aug 13 07:09:04.249638 containerd[1661]: time="2025-08-13T07:09:04.249602100Z" level=info msg="skip loading plugin \"io.containerd.snapshotter.v1.devmapper\"..." error="devmapper not configured: skip plugin" type=io.containerd.snapshotter.v1 Aug 13 07:09:04.249638 containerd[1661]: time="2025-08-13T07:09:04.249610740Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.native\"..." type=io.containerd.snapshotter.v1 Aug 13 07:09:04.249702 containerd[1661]: time="2025-08-13T07:09:04.249682660Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.overlayfs\"..." type=io.containerd.snapshotter.v1 Aug 13 07:09:04.249895 containerd[1661]: time="2025-08-13T07:09:04.249873140Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.zfs\"..." type=io.containerd.snapshotter.v1 Aug 13 07:09:04.250053 containerd[1661]: time="2025-08-13T07:09:04.250019860Z" level=info msg="skip loading plugin \"io.containerd.snapshotter.v1.zfs\"..." error="path /var/lib/containerd/io.containerd.snapshotter.v1.zfs must be a zfs filesystem to be used with the zfs snapshotter: skip plugin" type=io.containerd.snapshotter.v1 Aug 13 07:09:04.250053 containerd[1661]: time="2025-08-13T07:09:04.250038420Z" level=info msg="loading plugin \"io.containerd.content.v1.content\"..." type=io.containerd.content.v1 Aug 13 07:09:04.250148 containerd[1661]: time="2025-08-13T07:09:04.250126860Z" level=info msg="loading plugin \"io.containerd.metadata.v1.bolt\"..." type=io.containerd.metadata.v1 Aug 13 07:09:04.250190 containerd[1661]: time="2025-08-13T07:09:04.250175020Z" level=info msg="metadata content store policy set" policy=shared Aug 13 07:09:04.275128 containerd[1661]: time="2025-08-13T07:09:04.275074820Z" level=info msg="loading plugin \"io.containerd.gc.v1.scheduler\"..." type=io.containerd.gc.v1 Aug 13 07:09:04.275225 containerd[1661]: time="2025-08-13T07:09:04.275149020Z" level=info msg="loading plugin \"io.containerd.differ.v1.walking\"..." type=io.containerd.differ.v1 Aug 13 07:09:04.275225 containerd[1661]: time="2025-08-13T07:09:04.275165140Z" level=info msg="loading plugin \"io.containerd.lease.v1.manager\"..." type=io.containerd.lease.v1 Aug 13 07:09:04.275225 containerd[1661]: time="2025-08-13T07:09:04.275181500Z" level=info msg="loading plugin \"io.containerd.streaming.v1.manager\"..." type=io.containerd.streaming.v1 Aug 13 07:09:04.275225 containerd[1661]: time="2025-08-13T07:09:04.275196580Z" level=info msg="loading plugin \"io.containerd.runtime.v1.linux\"..." type=io.containerd.runtime.v1 Aug 13 07:09:04.275968 containerd[1661]: time="2025-08-13T07:09:04.275369660Z" level=info msg="loading plugin \"io.containerd.monitor.v1.cgroups\"..." type=io.containerd.monitor.v1 Aug 13 07:09:04.275968 containerd[1661]: time="2025-08-13T07:09:04.275603500Z" level=info msg="loading plugin \"io.containerd.runtime.v2.task\"..." type=io.containerd.runtime.v2 Aug 13 07:09:04.275968 containerd[1661]: time="2025-08-13T07:09:04.275697060Z" level=info msg="loading plugin \"io.containerd.runtime.v2.shim\"..." type=io.containerd.runtime.v2 Aug 13 07:09:04.275968 containerd[1661]: time="2025-08-13T07:09:04.275711620Z" level=info msg="loading plugin \"io.containerd.sandbox.store.v1.local\"..." type=io.containerd.sandbox.store.v1 Aug 13 07:09:04.275968 containerd[1661]: time="2025-08-13T07:09:04.275726340Z" level=info msg="loading plugin \"io.containerd.sandbox.controller.v1.local\"..." type=io.containerd.sandbox.controller.v1 Aug 13 07:09:04.275968 containerd[1661]: time="2025-08-13T07:09:04.275741220Z" level=info msg="loading plugin \"io.containerd.service.v1.containers-service\"..." type=io.containerd.service.v1 Aug 13 07:09:04.275968 containerd[1661]: time="2025-08-13T07:09:04.275753620Z" level=info msg="loading plugin \"io.containerd.service.v1.content-service\"..." type=io.containerd.service.v1 Aug 13 07:09:04.275968 containerd[1661]: time="2025-08-13T07:09:04.275769460Z" level=info msg="loading plugin \"io.containerd.service.v1.diff-service\"..." type=io.containerd.service.v1 Aug 13 07:09:04.275968 containerd[1661]: time="2025-08-13T07:09:04.275784180Z" level=info msg="loading plugin \"io.containerd.service.v1.images-service\"..." type=io.containerd.service.v1 Aug 13 07:09:04.275968 containerd[1661]: time="2025-08-13T07:09:04.275798020Z" level=info msg="loading plugin \"io.containerd.service.v1.introspection-service\"..." type=io.containerd.service.v1 Aug 13 07:09:04.275968 containerd[1661]: time="2025-08-13T07:09:04.275812460Z" level=info msg="loading plugin \"io.containerd.service.v1.namespaces-service\"..." type=io.containerd.service.v1 Aug 13 07:09:04.275968 containerd[1661]: time="2025-08-13T07:09:04.275824020Z" level=info msg="loading plugin \"io.containerd.service.v1.snapshots-service\"..." type=io.containerd.service.v1 Aug 13 07:09:04.275968 containerd[1661]: time="2025-08-13T07:09:04.275835420Z" level=info msg="loading plugin \"io.containerd.service.v1.tasks-service\"..." type=io.containerd.service.v1 Aug 13 07:09:04.275968 containerd[1661]: time="2025-08-13T07:09:04.275855660Z" level=info msg="loading plugin \"io.containerd.grpc.v1.containers\"..." type=io.containerd.grpc.v1 Aug 13 07:09:04.276204 containerd[1661]: time="2025-08-13T07:09:04.275868500Z" level=info msg="loading plugin \"io.containerd.grpc.v1.content\"..." type=io.containerd.grpc.v1 Aug 13 07:09:04.276204 containerd[1661]: time="2025-08-13T07:09:04.275880140Z" level=info msg="loading plugin \"io.containerd.grpc.v1.diff\"..." type=io.containerd.grpc.v1 Aug 13 07:09:04.276204 containerd[1661]: time="2025-08-13T07:09:04.275895180Z" level=info msg="loading plugin \"io.containerd.grpc.v1.events\"..." type=io.containerd.grpc.v1 Aug 13 07:09:04.276204 containerd[1661]: time="2025-08-13T07:09:04.275906700Z" level=info msg="loading plugin \"io.containerd.grpc.v1.images\"..." type=io.containerd.grpc.v1 Aug 13 07:09:04.276204 containerd[1661]: time="2025-08-13T07:09:04.275919380Z" level=info msg="loading plugin \"io.containerd.grpc.v1.introspection\"..." type=io.containerd.grpc.v1 Aug 13 07:09:04.276204 containerd[1661]: time="2025-08-13T07:09:04.275930060Z" level=info msg="loading plugin \"io.containerd.grpc.v1.leases\"..." type=io.containerd.grpc.v1 Aug 13 07:09:04.276204 containerd[1661]: time="2025-08-13T07:09:04.275964060Z" level=info msg="loading plugin \"io.containerd.grpc.v1.namespaces\"..." type=io.containerd.grpc.v1 Aug 13 07:09:04.276204 containerd[1661]: time="2025-08-13T07:09:04.275978900Z" level=info msg="loading plugin \"io.containerd.grpc.v1.sandbox-controllers\"..." type=io.containerd.grpc.v1 Aug 13 07:09:04.276204 containerd[1661]: time="2025-08-13T07:09:04.275992620Z" level=info msg="loading plugin \"io.containerd.grpc.v1.sandboxes\"..." type=io.containerd.grpc.v1 Aug 13 07:09:04.276204 containerd[1661]: time="2025-08-13T07:09:04.276008500Z" level=info msg="loading plugin \"io.containerd.grpc.v1.snapshots\"..." type=io.containerd.grpc.v1 Aug 13 07:09:04.276204 containerd[1661]: time="2025-08-13T07:09:04.276020900Z" level=info msg="loading plugin \"io.containerd.grpc.v1.streaming\"..." type=io.containerd.grpc.v1 Aug 13 07:09:04.276204 containerd[1661]: time="2025-08-13T07:09:04.276032980Z" level=info msg="loading plugin \"io.containerd.grpc.v1.tasks\"..." type=io.containerd.grpc.v1 Aug 13 07:09:04.276204 containerd[1661]: time="2025-08-13T07:09:04.276046980Z" level=info msg="loading plugin \"io.containerd.transfer.v1.local\"..." type=io.containerd.transfer.v1 Aug 13 07:09:04.276204 containerd[1661]: time="2025-08-13T07:09:04.276067420Z" level=info msg="loading plugin \"io.containerd.grpc.v1.transfer\"..." type=io.containerd.grpc.v1 Aug 13 07:09:04.276204 containerd[1661]: time="2025-08-13T07:09:04.276080220Z" level=info msg="loading plugin \"io.containerd.grpc.v1.version\"..." type=io.containerd.grpc.v1 Aug 13 07:09:04.276444 containerd[1661]: time="2025-08-13T07:09:04.276090740Z" level=info msg="loading plugin \"io.containerd.internal.v1.restart\"..." type=io.containerd.internal.v1 Aug 13 07:09:04.276444 containerd[1661]: time="2025-08-13T07:09:04.276138540Z" level=info msg="loading plugin \"io.containerd.tracing.processor.v1.otlp\"..." type=io.containerd.tracing.processor.v1 Aug 13 07:09:04.276444 containerd[1661]: time="2025-08-13T07:09:04.276156380Z" level=info msg="skip loading plugin \"io.containerd.tracing.processor.v1.otlp\"..." error="skip plugin: tracing endpoint not configured" type=io.containerd.tracing.processor.v1 Aug 13 07:09:04.276444 containerd[1661]: time="2025-08-13T07:09:04.276170660Z" level=info msg="loading plugin \"io.containerd.internal.v1.tracing\"..." type=io.containerd.internal.v1 Aug 13 07:09:04.276444 containerd[1661]: time="2025-08-13T07:09:04.276183620Z" level=info msg="skip loading plugin \"io.containerd.internal.v1.tracing\"..." error="skip plugin: tracing endpoint not configured" type=io.containerd.internal.v1 Aug 13 07:09:04.276444 containerd[1661]: time="2025-08-13T07:09:04.276192980Z" level=info msg="loading plugin \"io.containerd.grpc.v1.healthcheck\"..." type=io.containerd.grpc.v1 Aug 13 07:09:04.276444 containerd[1661]: time="2025-08-13T07:09:04.276207940Z" level=info msg="loading plugin \"io.containerd.nri.v1.nri\"..." type=io.containerd.nri.v1 Aug 13 07:09:04.276444 containerd[1661]: time="2025-08-13T07:09:04.276218340Z" level=info msg="NRI interface is disabled by configuration." Aug 13 07:09:04.276444 containerd[1661]: time="2025-08-13T07:09:04.276228100Z" level=info msg="loading plugin \"io.containerd.grpc.v1.cri\"..." type=io.containerd.grpc.v1 Aug 13 07:09:04.276597 containerd[1661]: time="2025-08-13T07:09:04.276502820Z" level=info msg="Start cri plugin with config {PluginConfig:{ContainerdConfig:{Snapshotter:overlayfs DefaultRuntimeName:runc DefaultRuntime:{Type: Path: Engine: PodAnnotations:[] ContainerAnnotations:[] Root: Options:map[] PrivilegedWithoutHostDevices:false PrivilegedWithoutHostDevicesAllDevicesAllowed:false BaseRuntimeSpec: NetworkPluginConfDir: NetworkPluginMaxConfNum:0 Snapshotter: SandboxMode:} UntrustedWorkloadRuntime:{Type: Path: Engine: PodAnnotations:[] ContainerAnnotations:[] Root: Options:map[] PrivilegedWithoutHostDevices:false PrivilegedWithoutHostDevicesAllDevicesAllowed:false BaseRuntimeSpec: NetworkPluginConfDir: NetworkPluginMaxConfNum:0 Snapshotter: SandboxMode:} Runtimes:map[runc:{Type:io.containerd.runc.v2 Path: Engine: PodAnnotations:[] ContainerAnnotations:[] Root: Options:map[SystemdCgroup:true] PrivilegedWithoutHostDevices:false PrivilegedWithoutHostDevicesAllDevicesAllowed:false BaseRuntimeSpec: NetworkPluginConfDir: NetworkPluginMaxConfNum:0 Snapshotter: SandboxMode:podsandbox}] NoPivot:false DisableSnapshotAnnotations:true DiscardUnpackedLayers:false IgnoreBlockIONotEnabledErrors:false IgnoreRdtNotEnabledErrors:false} CniConfig:{NetworkPluginBinDir:/opt/cni/bin NetworkPluginConfDir:/etc/cni/net.d NetworkPluginMaxConfNum:1 NetworkPluginSetupSerially:false NetworkPluginConfTemplate: IPPreference:} Registry:{ConfigPath: Mirrors:map[] Configs:map[] Auths:map[] Headers:map[]} ImageDecryption:{KeyModel:node} DisableTCPService:true StreamServerAddress:127.0.0.1 StreamServerPort:0 StreamIdleTimeout:4h0m0s EnableSelinux:true SelinuxCategoryRange:1024 SandboxImage:registry.k8s.io/pause:3.8 StatsCollectPeriod:10 SystemdCgroup:false EnableTLSStreaming:false X509KeyPairStreaming:{TLSCertFile: TLSKeyFile:} MaxContainerLogLineSize:16384 DisableCgroup:false DisableApparmor:false RestrictOOMScoreAdj:false MaxConcurrentDownloads:3 DisableProcMount:false UnsetSeccompProfile: TolerateMissingHugetlbController:true DisableHugetlbController:true DeviceOwnershipFromSecurityContext:false IgnoreImageDefinedVolumes:false NetNSMountsUnderStateDir:false EnableUnprivilegedPorts:false EnableUnprivilegedICMP:false EnableCDI:false CDISpecDirs:[/etc/cdi /var/run/cdi] ImagePullProgressTimeout:5m0s DrainExecSyncIOTimeout:0s ImagePullWithSyncFs:false IgnoreDeprecationWarnings:[]} 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}" Aug 13 07:09:04.276597 containerd[1661]: time="2025-08-13T07:09:04.276547660Z" level=info msg="Connect containerd service" Aug 13 07:09:04.276597 containerd[1661]: time="2025-08-13T07:09:04.276581060Z" level=info msg="using legacy CRI server" Aug 13 07:09:04.276597 containerd[1661]: time="2025-08-13T07:09:04.276588220Z" level=info msg="using experimental NRI integration - disable nri plugin to prevent this" Aug 13 07:09:04.276747 containerd[1661]: time="2025-08-13T07:09:04.276695620Z" level=info msg="Get image filesystem path \"/var/lib/containerd/io.containerd.snapshotter.v1.overlayfs\"" Aug 13 07:09:04.281961 containerd[1661]: time="2025-08-13T07:09:04.278649180Z" 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" Aug 13 07:09:04.281961 containerd[1661]: time="2025-08-13T07:09:04.279234340Z" level=info msg="Start subscribing containerd event" Aug 13 07:09:04.281961 containerd[1661]: time="2025-08-13T07:09:04.279298580Z" level=info msg="Start recovering state" Aug 13 07:09:04.281961 containerd[1661]: time="2025-08-13T07:09:04.279390900Z" level=info msg="Start event monitor" Aug 13 07:09:04.281961 containerd[1661]: time="2025-08-13T07:09:04.279404500Z" level=info msg="Start snapshots syncer" Aug 13 07:09:04.281961 containerd[1661]: time="2025-08-13T07:09:04.279263060Z" level=info msg=serving... address=/run/containerd/containerd.sock.ttrpc Aug 13 07:09:04.281961 containerd[1661]: time="2025-08-13T07:09:04.279416780Z" level=info msg="Start cni network conf syncer for default" Aug 13 07:09:04.281961 containerd[1661]: time="2025-08-13T07:09:04.279480620Z" level=info msg="Start streaming server" Aug 13 07:09:04.281961 containerd[1661]: time="2025-08-13T07:09:04.279474860Z" level=info msg=serving... address=/run/containerd/containerd.sock Aug 13 07:09:04.279683 systemd[1]: Started containerd.service - containerd container runtime. Aug 13 07:09:04.287862 containerd[1661]: time="2025-08-13T07:09:04.287823380Z" level=info msg="containerd successfully booted in 0.077696s" Aug 13 07:09:04.420189 systemd[1]: Starting docker.service - Docker Application Container Engine... Aug 13 07:09:04.420882 (dockerd)[1768]: 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 Aug 13 07:09:04.694765 sshd_keygen[1643]: ssh-keygen: generating new host keys: RSA ECDSA ED25519 Aug 13 07:09:04.713768 systemd[1]: Finished sshd-keygen.service - Generate sshd host keys. Aug 13 07:09:04.731215 systemd[1]: Starting issuegen.service - Generate /run/issue... Aug 13 07:09:04.740512 systemd[1]: Starting waagent.service - Microsoft Azure Linux Agent... Aug 13 07:09:04.746775 systemd[1]: issuegen.service: Deactivated successfully. Aug 13 07:09:04.749018 systemd[1]: Finished issuegen.service - Generate /run/issue. Aug 13 07:09:04.766294 systemd[1]: Starting systemd-user-sessions.service - Permit User Sessions... Aug 13 07:09:04.784117 systemd[1]: Started waagent.service - Microsoft Azure Linux Agent. Aug 13 07:09:04.792069 systemd[1]: Finished systemd-user-sessions.service - Permit User Sessions. Aug 13 07:09:04.807431 systemd[1]: Started getty@tty1.service - Getty on tty1. Aug 13 07:09:04.820422 systemd[1]: Started serial-getty@ttyAMA0.service - Serial Getty on ttyAMA0. Aug 13 07:09:04.826741 systemd[1]: Reached target getty.target - Login Prompts. Aug 13 07:09:05.165915 dockerd[1768]: time="2025-08-13T07:09:05.165832300Z" level=info msg="Starting up" Aug 13 07:09:05.475235 dockerd[1768]: time="2025-08-13T07:09:05.474929500Z" level=info msg="Loading containers: start." Aug 13 07:09:05.874985 kernel: Initializing XFRM netlink socket Aug 13 07:09:06.219728 systemd-networkd[1479]: docker0: Link UP Aug 13 07:09:06.258190 dockerd[1768]: time="2025-08-13T07:09:06.258150580Z" level=info msg="Loading containers: done." Aug 13 07:09:06.282840 dockerd[1768]: time="2025-08-13T07:09:06.282413820Z" 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 Aug 13 07:09:06.282840 dockerd[1768]: time="2025-08-13T07:09:06.282520580Z" level=info msg="Docker daemon" commit=41ca978a0a5400cc24b274137efa9f25517fcc0b containerd-snapshotter=false storage-driver=overlay2 version=27.3.1 Aug 13 07:09:06.282840 dockerd[1768]: time="2025-08-13T07:09:06.282642860Z" level=info msg="Daemon has completed initialization" Aug 13 07:09:06.357813 dockerd[1768]: time="2025-08-13T07:09:06.357383700Z" level=info msg="API listen on /run/docker.sock" Aug 13 07:09:06.358802 etcd-wrapper[1746]: Error response from daemon: No such container: etcd-member Aug 13 07:09:06.359290 systemd[1]: Started docker.service - Docker Application Container Engine. Aug 13 07:09:06.376538 waagent[1793]: 2025-08-13T07:09:06.376417Z INFO Daemon Daemon Azure Linux Agent Version: 2.9.1.1 Aug 13 07:09:06.383706 waagent[1793]: 2025-08-13T07:09:06.382647Z INFO Daemon Daemon OS: flatcar 4230.2.2 Aug 13 07:09:06.386391 etcd-wrapper[1967]: Error response from daemon: No such container: etcd-member Aug 13 07:09:06.388562 waagent[1793]: 2025-08-13T07:09:06.388473Z INFO Daemon Daemon Python: 3.11.11 Aug 13 07:09:06.394959 waagent[1793]: 2025-08-13T07:09:06.393200Z INFO Daemon Daemon Run daemon Aug 13 07:09:06.397760 waagent[1793]: 2025-08-13T07:09:06.397695Z INFO Daemon Daemon No RDMA handler exists for distro='Flatcar Container Linux by Kinvolk' version='4230.2.2' Aug 13 07:09:06.408295 waagent[1793]: 2025-08-13T07:09:06.407333Z INFO Daemon Daemon Using waagent for provisioning Aug 13 07:09:06.413738 waagent[1793]: 2025-08-13T07:09:06.413661Z INFO Daemon Daemon Activate resource disk Aug 13 07:09:06.418820 waagent[1793]: 2025-08-13T07:09:06.418744Z INFO Daemon Daemon Searching gen1 prefix 00000000-0001 or gen2 f8b3781a-1e82-4818-a1c3-63d806ec15bb Aug 13 07:09:06.432783 waagent[1793]: 2025-08-13T07:09:06.432691Z INFO Daemon Daemon Found device: None Aug 13 07:09:06.438235 waagent[1793]: 2025-08-13T07:09:06.438142Z ERROR Daemon Daemon Failed to mount resource disk [ResourceDiskError] unable to detect disk topology Aug 13 07:09:06.447002 waagent[1793]: 2025-08-13T07:09:06.446895Z ERROR Daemon Daemon Event: name=WALinuxAgent, op=ActivateResourceDisk, message=[ResourceDiskError] unable to detect disk topology, duration=0 Aug 13 07:09:06.460998 waagent[1793]: 2025-08-13T07:09:06.459449Z INFO Daemon Daemon Clean protocol and wireserver endpoint Aug 13 07:09:06.465656 waagent[1793]: 2025-08-13T07:09:06.465566Z INFO Daemon Daemon Running default provisioning handler Aug 13 07:09:06.476168 etcd-wrapper[1985]: Unable to find image 'quay.io/coreos/etcd:v3.5.16-arm64' locally Aug 13 07:09:06.482306 waagent[1793]: 2025-08-13T07:09:06.482214Z 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. Aug 13 07:09:06.497648 waagent[1793]: 2025-08-13T07:09:06.497573Z INFO Daemon Daemon Unable to get cloud-init enabled status from service: [Errno 2] No such file or directory: 'service' Aug 13 07:09:06.508416 waagent[1793]: 2025-08-13T07:09:06.508333Z INFO Daemon Daemon cloud-init is enabled: False Aug 13 07:09:06.514009 waagent[1793]: 2025-08-13T07:09:06.513905Z INFO Daemon Daemon Copying ovf-env.xml Aug 13 07:09:06.583584 waagent[1793]: 2025-08-13T07:09:06.583497Z INFO Daemon Daemon Successfully mounted dvd Aug 13 07:09:06.616528 systemd[1]: mnt-cdrom-secure.mount: Deactivated successfully. Aug 13 07:09:06.618144 waagent[1793]: 2025-08-13T07:09:06.618058Z INFO Daemon Daemon Detect protocol endpoint Aug 13 07:09:06.623522 waagent[1793]: 2025-08-13T07:09:06.623441Z INFO Daemon Daemon Clean protocol and wireserver endpoint Aug 13 07:09:06.629892 waagent[1793]: 2025-08-13T07:09:06.629818Z INFO Daemon Daemon WireServer endpoint is not found. Rerun dhcp handler Aug 13 07:09:06.636978 waagent[1793]: 2025-08-13T07:09:06.636883Z INFO Daemon Daemon Test for route to 168.63.129.16 Aug 13 07:09:06.642663 waagent[1793]: 2025-08-13T07:09:06.642594Z INFO Daemon Daemon Route to 168.63.129.16 exists Aug 13 07:09:06.647849 waagent[1793]: 2025-08-13T07:09:06.647783Z INFO Daemon Daemon Wire server endpoint:168.63.129.16 Aug 13 07:09:06.678794 waagent[1793]: 2025-08-13T07:09:06.678739Z INFO Daemon Daemon Fabric preferred wire protocol version:2015-04-05 Aug 13 07:09:06.687968 waagent[1793]: 2025-08-13T07:09:06.686202Z INFO Daemon Daemon Wire protocol version:2012-11-30 Aug 13 07:09:06.691633 waagent[1793]: 2025-08-13T07:09:06.691527Z INFO Daemon Daemon Server preferred version:2015-04-05 Aug 13 07:09:06.957359 waagent[1793]: 2025-08-13T07:09:06.957258Z INFO Daemon Daemon Initializing goal state during protocol detection Aug 13 07:09:06.965415 waagent[1793]: 2025-08-13T07:09:06.965335Z INFO Daemon Daemon Forcing an update of the goal state. Aug 13 07:09:06.975642 waagent[1793]: 2025-08-13T07:09:06.975577Z INFO Daemon Fetched a new incarnation for the WireServer goal state [incarnation 1] Aug 13 07:09:06.999280 waagent[1793]: 2025-08-13T07:09:06.999229Z INFO Daemon Daemon HostGAPlugin version: 1.0.8.175 Aug 13 07:09:07.005536 waagent[1793]: 2025-08-13T07:09:07.005482Z INFO Daemon Aug 13 07:09:07.008639 waagent[1793]: 2025-08-13T07:09:07.008576Z INFO Daemon Fetched new vmSettings [HostGAPlugin correlation ID: 1fb73c7f-4720-495b-9a0a-70f351eee2c7 eTag: 12098828505926204720 source: Fabric] Aug 13 07:09:07.021130 waagent[1793]: 2025-08-13T07:09:07.021067Z INFO Daemon The vmSettings originated via Fabric; will ignore them. Aug 13 07:09:07.028700 waagent[1793]: 2025-08-13T07:09:07.028642Z INFO Daemon Aug 13 07:09:07.032201 waagent[1793]: 2025-08-13T07:09:07.032142Z INFO Daemon Fetching full goal state from the WireServer [incarnation 1] Aug 13 07:09:07.043250 waagent[1793]: 2025-08-13T07:09:07.043205Z INFO Daemon Daemon Downloading artifacts profile blob Aug 13 07:09:07.134450 waagent[1793]: 2025-08-13T07:09:07.134352Z INFO Daemon Downloaded certificate {'thumbprint': 'B9DC13CBAB97AD3257FEC1487BC3191C4BCC8E65', 'hasPrivateKey': True} Aug 13 07:09:07.144460 waagent[1793]: 2025-08-13T07:09:07.144396Z INFO Daemon Downloaded certificate {'thumbprint': '6FC8320D616CB3A0AD71BF52BB1BF94E6937D28B', 'hasPrivateKey': False} Aug 13 07:09:07.154593 waagent[1793]: 2025-08-13T07:09:07.154531Z INFO Daemon Fetch goal state completed Aug 13 07:09:07.166012 waagent[1793]: 2025-08-13T07:09:07.165931Z INFO Daemon Daemon Starting provisioning Aug 13 07:09:07.172867 waagent[1793]: 2025-08-13T07:09:07.172790Z INFO Daemon Daemon Handle ovf-env.xml. Aug 13 07:09:07.177715 waagent[1793]: 2025-08-13T07:09:07.177654Z INFO Daemon Daemon Set hostname [ci-4230.2.2-a-8f178afe22] Aug 13 07:09:07.185627 waagent[1793]: 2025-08-13T07:09:07.185556Z INFO Daemon Daemon Publish hostname [ci-4230.2.2-a-8f178afe22] Aug 13 07:09:07.192561 waagent[1793]: 2025-08-13T07:09:07.192484Z INFO Daemon Daemon Examine /proc/net/route for primary interface Aug 13 07:09:07.199087 waagent[1793]: 2025-08-13T07:09:07.199023Z INFO Daemon Daemon Primary interface is [eth0] Aug 13 07:09:07.211483 systemd-networkd[1479]: eth0: found matching network '/usr/lib/systemd/network/zz-default.network', based on potentially unpredictable interface name. Aug 13 07:09:07.211492 systemd-networkd[1479]: eth0: Configuring with /usr/lib/systemd/network/zz-default.network. Aug 13 07:09:07.211535 systemd-networkd[1479]: eth0: DHCP lease lost Aug 13 07:09:07.212965 waagent[1793]: 2025-08-13T07:09:07.212498Z INFO Daemon Daemon Create user account if not exists Aug 13 07:09:07.218819 waagent[1793]: 2025-08-13T07:09:07.218741Z INFO Daemon Daemon User core already exists, skip useradd Aug 13 07:09:07.225439 waagent[1793]: 2025-08-13T07:09:07.225365Z INFO Daemon Daemon Configure sudoer Aug 13 07:09:07.230512 waagent[1793]: 2025-08-13T07:09:07.230429Z INFO Daemon Daemon Configure sshd Aug 13 07:09:07.235977 waagent[1793]: 2025-08-13T07:09:07.235343Z INFO Daemon Daemon Added a configuration snippet disabling SSH password-based authentication methods. It also configures SSH client probing to keep connections alive. Aug 13 07:09:07.249103 waagent[1793]: 2025-08-13T07:09:07.248898Z INFO Daemon Daemon Deploy ssh public key. Aug 13 07:09:07.261018 systemd-networkd[1479]: eth0: DHCPv4 address 10.200.20.45/24, gateway 10.200.20.1 acquired from 168.63.129.16 Aug 13 07:09:07.761141 etcd-wrapper[1985]: v3.5.16-arm64: Pulling from coreos/etcd Aug 13 07:09:07.761141 etcd-wrapper[1985]: d10f96ed9607: Pulling fs layer Aug 13 07:09:07.761141 etcd-wrapper[1985]: 2ae710cd8bfe: Pulling fs layer Aug 13 07:09:07.761141 etcd-wrapper[1985]: d462aa345367: Pulling fs layer Aug 13 07:09:07.761141 etcd-wrapper[1985]: 0f8b424aa0b9: Pulling fs layer Aug 13 07:09:07.761141 etcd-wrapper[1985]: d557676654e5: Pulling fs layer Aug 13 07:09:07.761141 etcd-wrapper[1985]: c8022d07192e: Pulling fs layer Aug 13 07:09:07.761141 etcd-wrapper[1985]: d858cbc252ad: Pulling fs layer Aug 13 07:09:07.761141 etcd-wrapper[1985]: 1069fc2daed1: Pulling fs layer Aug 13 07:09:07.761141 etcd-wrapper[1985]: b40161cd83fc: Pulling fs layer Aug 13 07:09:07.761141 etcd-wrapper[1985]: 5318d93a3a65: Pulling fs layer Aug 13 07:09:07.761141 etcd-wrapper[1985]: 307c1adadb60: Pulling fs layer Aug 13 07:09:07.761141 etcd-wrapper[1985]: f9b3c65df792: Pulling fs layer Aug 13 07:09:07.761141 etcd-wrapper[1985]: 5709b4a82c35: Pulling fs layer Aug 13 07:09:07.761141 etcd-wrapper[1985]: d5372e382b07: Pulling fs layer Aug 13 07:09:07.761141 etcd-wrapper[1985]: 9c3b5253dddc: Pulling fs layer Aug 13 07:09:07.762409 etcd-wrapper[1985]: 7a57323f7551: Pulling fs layer Aug 13 07:09:07.762409 etcd-wrapper[1985]: b40161cd83fc: Waiting Aug 13 07:09:07.762409 etcd-wrapper[1985]: 5318d93a3a65: Waiting Aug 13 07:09:07.762409 etcd-wrapper[1985]: 307c1adadb60: Waiting Aug 13 07:09:07.762409 etcd-wrapper[1985]: f9b3c65df792: Waiting Aug 13 07:09:07.762409 etcd-wrapper[1985]: 5709b4a82c35: Waiting Aug 13 07:09:07.762409 etcd-wrapper[1985]: d5372e382b07: Waiting Aug 13 07:09:07.762409 etcd-wrapper[1985]: 9c3b5253dddc: Waiting Aug 13 07:09:07.762409 etcd-wrapper[1985]: 0f8b424aa0b9: Waiting Aug 13 07:09:07.762409 etcd-wrapper[1985]: 7a57323f7551: Waiting Aug 13 07:09:07.762409 etcd-wrapper[1985]: d557676654e5: Waiting Aug 13 07:09:07.762409 etcd-wrapper[1985]: c8022d07192e: Waiting Aug 13 07:09:07.762409 etcd-wrapper[1985]: 1069fc2daed1: Waiting Aug 13 07:09:07.762409 etcd-wrapper[1985]: d858cbc252ad: Waiting Aug 13 07:09:08.065927 etcd-wrapper[1985]: 2ae710cd8bfe: Verifying Checksum Aug 13 07:09:08.065927 etcd-wrapper[1985]: 2ae710cd8bfe: Download complete Aug 13 07:09:08.082020 etcd-wrapper[1985]: d462aa345367: Verifying Checksum Aug 13 07:09:08.082197 etcd-wrapper[1985]: d462aa345367: Download complete Aug 13 07:09:08.082671 etcd-wrapper[1985]: d10f96ed9607: Verifying Checksum Aug 13 07:09:08.082845 etcd-wrapper[1985]: d10f96ed9607: Download complete Aug 13 07:09:08.166494 etcd-wrapper[1985]: d10f96ed9607: Pull complete Aug 13 07:09:08.215213 systemd[1]: var-lib-docker-overlay2-b8d45017add3158cb5ff1789e854114e62d52f293ae167c22739391fbc0188a7-merged.mount: Deactivated successfully. Aug 13 07:09:08.283029 etcd-wrapper[1985]: 2ae710cd8bfe: Pull complete Aug 13 07:09:08.344021 waagent[1793]: 2025-08-13T07:09:08.338796Z INFO Daemon Daemon Provisioning complete Aug 13 07:09:08.345431 etcd-wrapper[1985]: c8022d07192e: Verifying Checksum Aug 13 07:09:08.346356 etcd-wrapper[1985]: c8022d07192e: Download complete Aug 13 07:09:08.349882 etcd-wrapper[1985]: d557676654e5: Verifying Checksum Aug 13 07:09:08.350034 etcd-wrapper[1985]: d557676654e5: Download complete Aug 13 07:09:08.350116 etcd-wrapper[1985]: 0f8b424aa0b9: Verifying Checksum Aug 13 07:09:08.350348 etcd-wrapper[1985]: 0f8b424aa0b9: Download complete Aug 13 07:09:08.356418 waagent[1793]: 2025-08-13T07:09:08.356365Z INFO Daemon Daemon RDMA capabilities are not enabled, skipping Aug 13 07:09:08.363065 waagent[1793]: 2025-08-13T07:09:08.362984Z INFO Daemon Daemon End of log to /dev/console. The agent will now check for updates and then will process extensions. Aug 13 07:09:08.374426 waagent[1793]: 2025-08-13T07:09:08.374333Z INFO Daemon Daemon Installed Agent WALinuxAgent-2.9.1.1 is the most current agent Aug 13 07:09:08.521625 waagent[2033]: 2025-08-13T07:09:08.521546Z INFO ExtHandler ExtHandler Azure Linux Agent (Goal State Agent version 2.9.1.1) Aug 13 07:09:08.522172 waagent[2033]: 2025-08-13T07:09:08.522124Z INFO ExtHandler ExtHandler OS: flatcar 4230.2.2 Aug 13 07:09:08.522331 waagent[2033]: 2025-08-13T07:09:08.522295Z INFO ExtHandler ExtHandler Python: 3.11.11 Aug 13 07:09:08.530228 waagent[2033]: 2025-08-13T07:09:08.530148Z INFO ExtHandler ExtHandler Distro: flatcar-4230.2.2; OSUtil: FlatcarUtil; AgentService: waagent; Python: 3.11.11; systemd: True; LISDrivers: Absent; logrotate: logrotate 3.20.1; Aug 13 07:09:08.530677 waagent[2033]: 2025-08-13T07:09:08.530630Z INFO ExtHandler ExtHandler WireServer endpoint 168.63.129.16 read from file Aug 13 07:09:08.530841 waagent[2033]: 2025-08-13T07:09:08.530804Z INFO ExtHandler ExtHandler Wire server endpoint:168.63.129.16 Aug 13 07:09:08.539786 waagent[2033]: 2025-08-13T07:09:08.539707Z INFO ExtHandler Fetched a new incarnation for the WireServer goal state [incarnation 1] Aug 13 07:09:08.546369 waagent[2033]: 2025-08-13T07:09:08.546316Z INFO ExtHandler ExtHandler HostGAPlugin version: 1.0.8.175 Aug 13 07:09:08.547082 waagent[2033]: 2025-08-13T07:09:08.547036Z INFO ExtHandler Aug 13 07:09:08.547972 waagent[2033]: 2025-08-13T07:09:08.547313Z INFO ExtHandler Fetched new vmSettings [HostGAPlugin correlation ID: 70ed47a4-3bb7-4c56-b5d8-648a15068202 eTag: 12098828505926204720 source: Fabric] Aug 13 07:09:08.547972 waagent[2033]: 2025-08-13T07:09:08.547634Z INFO ExtHandler The vmSettings originated via Fabric; will ignore them. Aug 13 07:09:08.548523 waagent[2033]: 2025-08-13T07:09:08.548472Z INFO ExtHandler Aug 13 07:09:08.548676 waagent[2033]: 2025-08-13T07:09:08.548641Z INFO ExtHandler Fetching full goal state from the WireServer [incarnation 1] Aug 13 07:09:08.553113 waagent[2033]: 2025-08-13T07:09:08.553072Z INFO ExtHandler ExtHandler Downloading artifacts profile blob Aug 13 07:09:08.618224 etcd-wrapper[1985]: d858cbc252ad: Verifying Checksum Aug 13 07:09:08.618224 etcd-wrapper[1985]: d858cbc252ad: Download complete Aug 13 07:09:08.625232 etcd-wrapper[1985]: 1069fc2daed1: Verifying Checksum Aug 13 07:09:08.625449 etcd-wrapper[1985]: 1069fc2daed1: Download complete Aug 13 07:09:08.642407 etcd-wrapper[1985]: b40161cd83fc: Verifying Checksum Aug 13 07:09:08.642407 etcd-wrapper[1985]: b40161cd83fc: Download complete Aug 13 07:09:08.652986 waagent[2033]: 2025-08-13T07:09:08.652690Z INFO ExtHandler Downloaded certificate {'thumbprint': 'B9DC13CBAB97AD3257FEC1487BC3191C4BCC8E65', 'hasPrivateKey': True} Aug 13 07:09:08.653444 waagent[2033]: 2025-08-13T07:09:08.653394Z INFO ExtHandler Downloaded certificate {'thumbprint': '6FC8320D616CB3A0AD71BF52BB1BF94E6937D28B', 'hasPrivateKey': False} Aug 13 07:09:08.654912 waagent[2033]: 2025-08-13T07:09:08.653933Z INFO ExtHandler Fetch goal state completed Aug 13 07:09:08.658694 systemd[1]: var-lib-docker-overlay2-da538f581f004b7f02e31ac0a0cdc09963500724e484c6296351b3c2d1b9bc89-merged.mount: Deactivated successfully. Aug 13 07:09:08.669955 waagent[2033]: 2025-08-13T07:09:08.669472Z INFO ExtHandler ExtHandler WALinuxAgent-2.9.1.1 running as process 2033 Aug 13 07:09:08.669955 waagent[2033]: 2025-08-13T07:09:08.669702Z INFO ExtHandler ExtHandler ******** AutoUpdate.Enabled is set to False, not processing the operation ******** Aug 13 07:09:08.674977 waagent[2033]: 2025-08-13T07:09:08.674291Z INFO ExtHandler ExtHandler Cgroup monitoring is not supported on ['flatcar', '4230.2.2', '', 'Flatcar Container Linux by Kinvolk'] Aug 13 07:09:08.674977 waagent[2033]: 2025-08-13T07:09:08.674693Z INFO ExtHandler ExtHandler Starting setup for Persistent firewall rules Aug 13 07:09:08.676704 waagent[2033]: 2025-08-13T07:09:08.676672Z INFO ExtHandler ExtHandler Firewalld service not running/unavailable, trying to set up waagent-network-setup.service Aug 13 07:09:08.677002 waagent[2033]: 2025-08-13T07:09:08.676933Z INFO ExtHandler ExtHandler Successfully updated the Binary file /var/lib/waagent/waagent-network-setup.py for firewall setup Aug 13 07:09:08.683984 waagent[2033]: 2025-08-13T07:09:08.683510Z INFO ExtHandler ExtHandler Service: waagent-network-setup.service not enabled. Adding it now Aug 13 07:09:08.691854 systemd[1]: Reload requested from client PID 2048 ('systemctl') (unit waagent.service)... Aug 13 07:09:08.692058 systemd[1]: Reloading... Aug 13 07:09:08.723526 etcd-wrapper[1985]: d462aa345367: Pull complete Aug 13 07:09:08.799974 zram_generator::config[2092]: No configuration found. Aug 13 07:09:08.832041 etcd-wrapper[1985]: 0f8b424aa0b9: Pull complete Aug 13 07:09:08.882663 etcd-wrapper[1985]: 5318d93a3a65: Verifying Checksum Aug 13 07:09:08.882663 etcd-wrapper[1985]: 5318d93a3a65: Download complete Aug 13 07:09:08.917568 systemd[1]: /usr/lib/systemd/system/docker.socket:6: ListenStream= references a path below legacy directory /var/run/, updating /var/run/docker.sock → /run/docker.sock; please update the unit file accordingly. Aug 13 07:09:08.918055 etcd-wrapper[1985]: 307c1adadb60: Verifying Checksum Aug 13 07:09:08.918055 etcd-wrapper[1985]: 307c1adadb60: Download complete Aug 13 07:09:08.931110 etcd-wrapper[1985]: d557676654e5: Pull complete Aug 13 07:09:09.021969 etcd-wrapper[1985]: c8022d07192e: Pull complete Aug 13 07:09:09.031523 systemd[1]: Reloading finished in 339 ms. Aug 13 07:09:09.040125 etcd-wrapper[1985]: f9b3c65df792: Verifying Checksum Aug 13 07:09:09.040125 etcd-wrapper[1985]: f9b3c65df792: Download complete Aug 13 07:09:09.045099 waagent[2033]: 2025-08-13T07:09:09.044925Z INFO ExtHandler ExtHandler Executing systemctl daemon-reload for setting up waagent-network-setup.service Aug 13 07:09:09.057087 systemd[1]: Reload requested from client PID 2157 ('systemctl') (unit waagent.service)... Aug 13 07:09:09.057103 systemd[1]: Reloading... Aug 13 07:09:09.134126 etcd-wrapper[1985]: d858cbc252ad: Pull complete Aug 13 07:09:09.159990 zram_generator::config[2200]: No configuration found. Aug 13 07:09:09.230100 etcd-wrapper[1985]: 1069fc2daed1: Pull complete Aug 13 07:09:09.284864 systemd[1]: /usr/lib/systemd/system/docker.socket:6: ListenStream= references a path below legacy directory /var/run/, updating /var/run/docker.sock → /run/docker.sock; please update the unit file accordingly. Aug 13 07:09:09.293197 etcd-wrapper[1985]: 5709b4a82c35: Verifying Checksum Aug 13 07:09:09.293197 etcd-wrapper[1985]: 5709b4a82c35: Download complete Aug 13 07:09:09.327817 etcd-wrapper[1985]: b40161cd83fc: Pull complete Aug 13 07:09:09.369310 etcd-wrapper[1985]: d5372e382b07: Verifying Checksum Aug 13 07:09:09.369310 etcd-wrapper[1985]: d5372e382b07: Download complete Aug 13 07:09:09.381025 etcd-wrapper[1985]: 9c3b5253dddc: Verifying Checksum Aug 13 07:09:09.381723 etcd-wrapper[1985]: 9c3b5253dddc: Download complete Aug 13 07:09:09.389829 systemd[1]: Reloading finished in 332 ms. Aug 13 07:09:09.407021 waagent[2033]: 2025-08-13T07:09:09.406764Z INFO ExtHandler ExtHandler Successfully added and enabled the waagent-network-setup.service Aug 13 07:09:09.408983 waagent[2033]: 2025-08-13T07:09:09.407177Z INFO ExtHandler ExtHandler Persistent firewall rules setup successfully Aug 13 07:09:09.412477 waagent[2033]: 2025-08-13T07:09:09.412412Z INFO ExtHandler ExtHandler DROP rule is not available which implies no firewall rules are set yet. Environment thread will set it up. Aug 13 07:09:09.414229 waagent[2033]: 2025-08-13T07:09:09.414155Z INFO ExtHandler ExtHandler Checking if log collection is allowed at this time [False]. All three conditions must be met: configuration enabled [True], cgroups enabled [False], python supported: [True] Aug 13 07:09:09.415159 waagent[2033]: 2025-08-13T07:09:09.415102Z INFO ExtHandler ExtHandler Starting env monitor service. Aug 13 07:09:09.415299 waagent[2033]: 2025-08-13T07:09:09.415241Z INFO MonitorHandler ExtHandler WireServer endpoint 168.63.129.16 read from file Aug 13 07:09:09.416002 waagent[2033]: 2025-08-13T07:09:09.415736Z INFO ExtHandler ExtHandler Start SendTelemetryHandler service. Aug 13 07:09:09.416182 waagent[2033]: 2025-08-13T07:09:09.416058Z INFO MonitorHandler ExtHandler Wire server endpoint:168.63.129.16 Aug 13 07:09:09.416569 waagent[2033]: 2025-08-13T07:09:09.416514Z INFO SendTelemetryHandler ExtHandler Successfully started the SendTelemetryHandler thread Aug 13 07:09:09.416966 waagent[2033]: 2025-08-13T07:09:09.416900Z INFO MonitorHandler ExtHandler Monitor.NetworkConfigurationChanges is disabled. Aug 13 07:09:09.417106 waagent[2033]: 2025-08-13T07:09:09.417049Z INFO ExtHandler ExtHandler Start Extension Telemetry service. Aug 13 07:09:09.417266 waagent[2033]: 2025-08-13T07:09:09.417185Z INFO EnvHandler ExtHandler WireServer endpoint 168.63.129.16 read from file Aug 13 07:09:09.417753 waagent[2033]: 2025-08-13T07:09:09.417696Z INFO MonitorHandler ExtHandler Routing table from /proc/net/route: Aug 13 07:09:09.417753 waagent[2033]: Iface Destination Gateway Flags RefCnt Use Metric Mask MTU Window IRTT Aug 13 07:09:09.417753 waagent[2033]: eth0 00000000 0114C80A 0003 0 0 1024 00000000 0 0 0 Aug 13 07:09:09.417753 waagent[2033]: eth0 0014C80A 00000000 0001 0 0 1024 00FFFFFF 0 0 0 Aug 13 07:09:09.417753 waagent[2033]: eth0 0114C80A 00000000 0005 0 0 1024 FFFFFFFF 0 0 0 Aug 13 07:09:09.417753 waagent[2033]: eth0 10813FA8 0114C80A 0007 0 0 1024 FFFFFFFF 0 0 0 Aug 13 07:09:09.417753 waagent[2033]: eth0 FEA9FEA9 0114C80A 0007 0 0 1024 FFFFFFFF 0 0 0 Aug 13 07:09:09.417753 waagent[2033]: docker0 000011AC 00000000 0001 0 0 0 0000FFFF 0 0 0 Aug 13 07:09:09.418139 waagent[2033]: 2025-08-13T07:09:09.418085Z INFO EnvHandler ExtHandler Wire server endpoint:168.63.129.16 Aug 13 07:09:09.418399 waagent[2033]: 2025-08-13T07:09:09.418340Z INFO EnvHandler ExtHandler Configure routes Aug 13 07:09:09.418553 waagent[2033]: 2025-08-13T07:09:09.418469Z INFO TelemetryEventsCollector ExtHandler Extension Telemetry pipeline enabled: True Aug 13 07:09:09.418674 waagent[2033]: 2025-08-13T07:09:09.418627Z INFO ExtHandler ExtHandler Goal State Period: 6 sec. This indicates how often the agent checks for new goal states and reports status. Aug 13 07:09:09.418812 waagent[2033]: 2025-08-13T07:09:09.418763Z INFO TelemetryEventsCollector ExtHandler Successfully started the TelemetryEventsCollector thread Aug 13 07:09:09.419530 waagent[2033]: 2025-08-13T07:09:09.419473Z INFO EnvHandler ExtHandler Gateway:None Aug 13 07:09:09.419603 waagent[2033]: 2025-08-13T07:09:09.419565Z INFO EnvHandler ExtHandler Routes:None Aug 13 07:09:09.425747 waagent[2033]: 2025-08-13T07:09:09.425562Z INFO ExtHandler ExtHandler Aug 13 07:09:09.426550 waagent[2033]: 2025-08-13T07:09:09.426265Z INFO ExtHandler ExtHandler ProcessExtensionsGoalState started [incarnation_1 channel: WireServer source: Fabric activity: 6eccd479-52ac-4bb2-b64f-84e62cf7bccf correlation 91df9fb4-a4ff-4df3-a49b-215f4ee4e35f created: 2025-08-13T07:08:02.144257Z] Aug 13 07:09:09.427530 waagent[2033]: 2025-08-13T07:09:09.427458Z INFO ExtHandler ExtHandler No extension handlers found, not processing anything. Aug 13 07:09:09.428825 waagent[2033]: 2025-08-13T07:09:09.428762Z INFO ExtHandler ExtHandler ProcessExtensionsGoalState completed [incarnation_1 3 ms] Aug 13 07:09:09.436031 etcd-wrapper[1985]: 5318d93a3a65: Pull complete Aug 13 07:09:09.473976 waagent[2033]: 2025-08-13T07:09:09.473421Z INFO MonitorHandler ExtHandler Network interfaces: Aug 13 07:09:09.473976 waagent[2033]: Executing ['ip', '-a', '-o', 'link']: Aug 13 07:09:09.473976 waagent[2033]: 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 Aug 13 07:09:09.473976 waagent[2033]: 2: eth0: mtu 1500 qdisc mq state UP mode DEFAULT group default qlen 1000\ link/ether 00:0d:3a:fb:06:2a brd ff:ff:ff:ff:ff:ff Aug 13 07:09:09.473976 waagent[2033]: 3: enP21686s1: mtu 1500 qdisc mq master eth0 state UP mode DEFAULT group default qlen 1000\ link/ether 00:0d:3a:fb:06:2a brd ff:ff:ff:ff:ff:ff\ altname enP21686p0s2 Aug 13 07:09:09.473976 waagent[2033]: 4: docker0: mtu 1500 qdisc noqueue state DOWN mode DEFAULT group default \ link/ether 02:42:be:ab:95:f0 brd ff:ff:ff:ff:ff:ff Aug 13 07:09:09.473976 waagent[2033]: Executing ['ip', '-4', '-a', '-o', 'address']: Aug 13 07:09:09.473976 waagent[2033]: 1: lo inet 127.0.0.1/8 scope host lo\ valid_lft forever preferred_lft forever Aug 13 07:09:09.473976 waagent[2033]: 2: eth0 inet 10.200.20.45/24 metric 1024 brd 10.200.20.255 scope global eth0\ valid_lft forever preferred_lft forever Aug 13 07:09:09.473976 waagent[2033]: 4: docker0 inet 172.17.0.1/16 brd 172.17.255.255 scope global docker0\ valid_lft forever preferred_lft forever Aug 13 07:09:09.473976 waagent[2033]: Executing ['ip', '-6', '-a', '-o', 'address']: Aug 13 07:09:09.473976 waagent[2033]: 1: lo inet6 ::1/128 scope host noprefixroute \ valid_lft forever preferred_lft forever Aug 13 07:09:09.473976 waagent[2033]: 2: eth0 inet6 fe80::20d:3aff:fefb:62a/64 scope link proto kernel_ll \ valid_lft forever preferred_lft forever Aug 13 07:09:09.474896 systemd[1]: var-lib-docker-overlay2-d6312b51222287ab50a862293d8f112b7b55f31556d327a2a16e4b06b5e525a7-merged.mount: Deactivated successfully. Aug 13 07:09:09.495762 waagent[2033]: 2025-08-13T07:09:09.494653Z INFO ExtHandler ExtHandler [HEARTBEAT] Agent WALinuxAgent-2.9.1.1 is running as the goal state agent [DEBUG HeartbeatCounter: 0;HeartbeatId: 732852A4-D0FE-4763-A903-CD8CE64C06CB;DroppedPackets: 0;UpdateGSErrors: 0;AutoUpdate: 0] Aug 13 07:09:09.517277 waagent[2033]: 2025-08-13T07:09:09.517192Z INFO EnvHandler ExtHandler Successfully added Azure fabric firewall rules. Current Firewall rules: Aug 13 07:09:09.517277 waagent[2033]: Chain INPUT (policy ACCEPT 0 packets, 0 bytes) Aug 13 07:09:09.517277 waagent[2033]: pkts bytes target prot opt in out source destination Aug 13 07:09:09.517277 waagent[2033]: Chain FORWARD (policy ACCEPT 0 packets, 0 bytes) Aug 13 07:09:09.517277 waagent[2033]: pkts bytes target prot opt in out source destination Aug 13 07:09:09.517277 waagent[2033]: Chain OUTPUT (policy ACCEPT 0 packets, 0 bytes) Aug 13 07:09:09.517277 waagent[2033]: pkts bytes target prot opt in out source destination Aug 13 07:09:09.517277 waagent[2033]: 0 0 ACCEPT tcp -- * * 0.0.0.0/0 168.63.129.16 tcp dpt:53 Aug 13 07:09:09.517277 waagent[2033]: 9 993 ACCEPT tcp -- * * 0.0.0.0/0 168.63.129.16 owner UID match 0 Aug 13 07:09:09.517277 waagent[2033]: 0 0 DROP tcp -- * * 0.0.0.0/0 168.63.129.16 ctstate INVALID,NEW Aug 13 07:09:09.521643 waagent[2033]: 2025-08-13T07:09:09.521543Z INFO EnvHandler ExtHandler Current Firewall rules: Aug 13 07:09:09.521643 waagent[2033]: Chain INPUT (policy ACCEPT 0 packets, 0 bytes) Aug 13 07:09:09.521643 waagent[2033]: pkts bytes target prot opt in out source destination Aug 13 07:09:09.521643 waagent[2033]: Chain FORWARD (policy ACCEPT 0 packets, 0 bytes) Aug 13 07:09:09.521643 waagent[2033]: pkts bytes target prot opt in out source destination Aug 13 07:09:09.521643 waagent[2033]: Chain OUTPUT (policy ACCEPT 0 packets, 0 bytes) Aug 13 07:09:09.521643 waagent[2033]: pkts bytes target prot opt in out source destination Aug 13 07:09:09.521643 waagent[2033]: 0 0 ACCEPT tcp -- * * 0.0.0.0/0 168.63.129.16 tcp dpt:53 Aug 13 07:09:09.521643 waagent[2033]: 10 1045 ACCEPT tcp -- * * 0.0.0.0/0 168.63.129.16 owner UID match 0 Aug 13 07:09:09.521643 waagent[2033]: 0 0 DROP tcp -- * * 0.0.0.0/0 168.63.129.16 ctstate INVALID,NEW Aug 13 07:09:09.522214 waagent[2033]: 2025-08-13T07:09:09.522034Z INFO EnvHandler ExtHandler Set block dev timeout: sda with timeout: 300 Aug 13 07:09:09.537712 etcd-wrapper[1985]: 307c1adadb60: Pull complete Aug 13 07:09:09.652886 etcd-wrapper[1985]: 7a57323f7551: Verifying Checksum Aug 13 07:09:09.652886 etcd-wrapper[1985]: 7a57323f7551: Download complete Aug 13 07:09:09.710544 systemd[1]: var-lib-docker-overlay2-f84fe56f0e16a4a3116810509f339ab8f4446b0870690378f1b71830181e9de0-merged.mount: Deactivated successfully. Aug 13 07:09:09.843103 etcd-wrapper[1985]: f9b3c65df792: Pull complete Aug 13 07:09:10.075952 etcd-wrapper[1985]: 5709b4a82c35: Pull complete Aug 13 07:09:10.097109 login[1797]: pam_unix(login:session): session opened for user core(uid=500) by core(uid=0) Aug 13 07:09:10.098212 login[1796]: pam_unix(login:session): session opened for user core(uid=500) by core(uid=0) Aug 13 07:09:10.115843 systemd-logind[1626]: New session 1 of user core. Aug 13 07:09:10.116346 systemd[1]: Created slice user-500.slice - User Slice of UID 500. Aug 13 07:09:10.121219 systemd[1]: Starting user-runtime-dir@500.service - User Runtime Directory /run/user/500... Aug 13 07:09:10.125715 systemd-logind[1626]: New session 2 of user core. Aug 13 07:09:10.141998 systemd[1]: Finished user-runtime-dir@500.service - User Runtime Directory /run/user/500. Aug 13 07:09:10.151194 systemd[1]: Starting user@500.service - User Manager for UID 500... Aug 13 07:09:10.160609 (systemd)[2319]: pam_unix(systemd-user:session): session opened for user core(uid=500) by (uid=0) Aug 13 07:09:10.164525 systemd-logind[1626]: New session c1 of user core. Aug 13 07:09:10.323409 etcd-wrapper[1985]: d5372e382b07: Pull complete Aug 13 07:09:10.394488 etcd-wrapper[1985]: 9c3b5253dddc: Pull complete Aug 13 07:09:10.436725 systemd[2319]: Queued start job for default target default.target. Aug 13 07:09:10.443089 systemd[1]: var-lib-docker-overlay2-0e85cb544118cb16274d58899ba4a585753090dd5f2f27d47df95dcb2b8651da-merged.mount: Deactivated successfully. Aug 13 07:09:10.448152 systemd[2319]: Created slice app.slice - User Application Slice. Aug 13 07:09:10.448188 systemd[2319]: Reached target paths.target - Paths. Aug 13 07:09:10.448228 systemd[2319]: Reached target timers.target - Timers. Aug 13 07:09:10.449474 systemd[2319]: Starting dbus.socket - D-Bus User Message Bus Socket... Aug 13 07:09:10.461805 systemd[2319]: Listening on dbus.socket - D-Bus User Message Bus Socket. Aug 13 07:09:10.461939 systemd[2319]: Reached target sockets.target - Sockets. Aug 13 07:09:10.462078 systemd[2319]: Reached target basic.target - Basic System. Aug 13 07:09:10.462119 systemd[2319]: Reached target default.target - Main User Target. Aug 13 07:09:10.462147 systemd[2319]: Startup finished in 286ms. Aug 13 07:09:10.462224 systemd[1]: Started user@500.service - User Manager for UID 500. Aug 13 07:09:10.471168 systemd[1]: Started session-1.scope - Session 1 of User core. Aug 13 07:09:10.472059 systemd[1]: Started session-2.scope - Session 2 of User core. Aug 13 07:09:10.492784 etcd-wrapper[1985]: 7a57323f7551: Pull complete Aug 13 07:09:10.522175 etcd-wrapper[1985]: Digest: sha256:bdb64177a9250b4d594af525f4225c2d0657a251a6e38102a2ead39f67370db2 Aug 13 07:09:10.541399 etcd-wrapper[1985]: Status: Downloaded newer image for quay.io/coreos/etcd:v3.5.16-arm64 Aug 13 07:09:11.194212 containerd[1661]: time="2025-08-13T07:09:11.194081700Z" level=info msg="loading plugin \"io.containerd.event.v1.publisher\"..." runtime=io.containerd.runc.v2 type=io.containerd.event.v1 Aug 13 07:09:11.194212 containerd[1661]: time="2025-08-13T07:09:11.194167340Z" level=info msg="loading plugin \"io.containerd.internal.v1.shutdown\"..." runtime=io.containerd.runc.v2 type=io.containerd.internal.v1 Aug 13 07:09:11.194212 containerd[1661]: time="2025-08-13T07:09:11.194179660Z" level=info msg="loading plugin \"io.containerd.ttrpc.v1.task\"..." runtime=io.containerd.runc.v2 type=io.containerd.ttrpc.v1 Aug 13 07:09:11.194993 containerd[1661]: time="2025-08-13T07:09:11.194550420Z" level=info msg="loading plugin \"io.containerd.ttrpc.v1.pause\"..." runtime=io.containerd.runc.v2 type=io.containerd.ttrpc.v1 Aug 13 07:09:11.212193 systemd[1]: Started docker-b133d90ddc1989dbde162d3288d0bdca21f5a7b1cae9ed63dc181054507c5017.scope - libcontainer container b133d90ddc1989dbde162d3288d0bdca21f5a7b1cae9ed63dc181054507c5017. Aug 13 07:09:11.258186 etcd-wrapper[1985]: {"level":"info","ts":"2025-08-13T07:09:11.257017Z","caller":"flags/flag.go:113","msg":"recognized and used environment variable","variable-name":"ETCD_DATA_DIR","variable-value":"/var/lib/etcd"} Aug 13 07:09:11.258186 etcd-wrapper[1985]: {"level":"info","ts":"2025-08-13T07:09:11.257254Z","caller":"flags/flag.go:113","msg":"recognized and used environment variable","variable-name":"ETCD_NAME","variable-value":"19209727f5a047d2861c873cb16cb69f"} Aug 13 07:09:11.258186 etcd-wrapper[1985]: {"level":"warn","ts":"2025-08-13T07:09:11.257332Z","caller":"flags/flag.go:93","msg":"unrecognized environment variable","environment-variable":"ETCD_IMAGE_URL=quay.io/coreos/etcd"} Aug 13 07:09:11.258186 etcd-wrapper[1985]: {"level":"warn","ts":"2025-08-13T07:09:11.257347Z","caller":"flags/flag.go:93","msg":"unrecognized environment variable","environment-variable":"ETCD_IMAGE_TAG=v3.5.16-arm64"} Aug 13 07:09:11.258186 etcd-wrapper[1985]: {"level":"warn","ts":"2025-08-13T07:09:11.257353Z","caller":"flags/flag.go:93","msg":"unrecognized environment variable","environment-variable":"ETCD_USER=etcd"} Aug 13 07:09:11.258186 etcd-wrapper[1985]: {"level":"warn","ts":"2025-08-13T07:09:11.257371Z","caller":"flags/flag.go:93","msg":"unrecognized environment variable","environment-variable":"ETCD_SSL_DIR=/etc/ssl/certs"} Aug 13 07:09:11.258186 etcd-wrapper[1985]: {"level":"warn","ts":"2025-08-13T07:09:11.257426Z","caller":"embed/config.go:689","msg":"Running http and grpc server on single port. This is not recommended for production."} Aug 13 07:09:11.258186 etcd-wrapper[1985]: {"level":"info","ts":"2025-08-13T07:09:11.257464Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["/usr/local/bin/etcd","--listen-peer-urls=http://10.200.20.45:2380","--listen-client-urls=http://0.0.0.0:2379","--initial-advertise-peer-urls=http://10.200.20.45:2380","--advertise-client-urls=http://10.200.20.45:2379","--discovery=https://discovery.etcd.io/6cb21dd808a2fe1cffa1f7ef860d0d46"]} Aug 13 07:09:11.258871 etcd-wrapper[1985]: {"level":"warn","ts":"2025-08-13T07:09:11.258083Z","caller":"embed/config.go:689","msg":"Running http and grpc server on single port. This is not recommended for production."} Aug 13 07:09:11.258871 etcd-wrapper[1985]: {"level":"info","ts":"2025-08-13T07:09:11.258106Z","caller":"embed/etcd.go:128","msg":"configuring peer listeners","listen-peer-urls":["http://10.200.20.45:2380"]} Aug 13 07:09:11.259471 etcd-wrapper[1985]: {"level":"info","ts":"2025-08-13T07:09:11.259046Z","caller":"embed/etcd.go:136","msg":"configuring client listeners","listen-client-urls":["http://0.0.0.0:2379"]} Aug 13 07:09:11.259471 etcd-wrapper[1985]: {"level":"info","ts":"2025-08-13T07:09:11.259320Z","caller":"embed/etcd.go:311","msg":"starting an etcd server","etcd-version":"3.5.16","git-sha":"f20bbad","go-version":"go1.22.7","go-os":"linux","go-arch":"arm64","max-cpu-set":2,"max-cpu-available":2,"member-initialized":false,"name":"19209727f5a047d2861c873cb16cb69f","data-dir":"/var/lib/etcd","wal-dir":"","wal-dir-dedicated":"","member-dir":"/var/lib/etcd/member","force-new-cluster":false,"heartbeat-interval":"100ms","election-timeout":"1s","initial-election-tick-advance":true,"snapshot-count":100000,"max-wals":5,"max-snapshots":5,"snapshot-catchup-entries":5000,"initial-advertise-peer-urls":["http://10.200.20.45:2380"],"listen-peer-urls":["http://10.200.20.45:2380"],"advertise-client-urls":["http://10.200.20.45:2379"],"listen-client-urls":["http://0.0.0.0:2379"],"listen-metrics-urls":[],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"19209727f5a047d2861c873cb16cb69f=http://10.200.20.45:2380","initial-cluster-state":"new","initial-cluster-token":"https://discovery.etcd.io/6cb21dd808a2fe1cffa1f7ef860d0d46","quota-backend-bytes":2147483648,"max-request-bytes":1572864,"max-concurrent-streams":4294967295,"pre-vote":true,"initial-corrupt-check":false,"corrupt-check-time-interval":"0s","compact-check-time-enabled":false,"compact-check-time-interval":"1m0s","auto-compaction-mode":"periodic","auto-compaction-retention":"0s","auto-compaction-interval":"0s","discovery-url":"https://discovery.etcd.io/6cb21dd808a2fe1cffa1f7ef860d0d46","discovery-proxy":"","downgrade-check-interval":"5s"} Aug 13 07:09:11.265343 etcd-wrapper[1985]: {"level":"info","ts":"2025-08-13T07:09:11.265080Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"5.334ms"} Aug 13 07:09:11.949735 etcd-wrapper[1985]: {"level":"info","ts":"2025-08-13T07:09:11.949425Z","caller":"v2discovery/discovery.go:336","msg":"found self from discovery server","discovery-url":"https://discovery.etcd.io","self":"1b93a932f3d77f53"} Aug 13 07:09:11.949735 etcd-wrapper[1985]: {"level":"info","ts":"2025-08-13T07:09:11.949471Z","caller":"v2discovery/discovery.go:352","msg":"found peers from discovery server; waiting for more","discovery-url":"https://discovery.etcd.io","found-peers":1,"needed-peers":2} Aug 13 07:09:19.115165 systemd[1]: Created slice system-sshd.slice - Slice /system/sshd. Aug 13 07:09:19.123206 systemd[1]: Started sshd@0-10.200.20.45:22-10.200.16.10:53920.service - OpenSSH per-connection server daemon (10.200.16.10:53920). Aug 13 07:09:19.720140 sshd[2405]: Accepted publickey for core from 10.200.16.10 port 53920 ssh2: RSA SHA256:mUTVkvCTqAM/q6yF06VEIEfaT11Wyv/ewAABhIXzqTw Aug 13 07:09:19.721429 sshd-session[2405]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Aug 13 07:09:19.726033 systemd-logind[1626]: New session 3 of user core. Aug 13 07:09:19.736183 systemd[1]: Started session-3.scope - Session 3 of User core. Aug 13 07:09:20.155282 systemd[1]: Started sshd@1-10.200.20.45:22-10.200.16.10:53926.service - OpenSSH per-connection server daemon (10.200.16.10:53926). Aug 13 07:09:20.352234 etcd-wrapper[1985]: {"level":"info","ts":"2025-08-13T07:09:20.351657Z","caller":"v2discovery/discovery.go:371","msg":"found peer from discovery server","discovery-url":"https://discovery.etcd.io","peer":"7a92aff8d04a1626"} Aug 13 07:09:20.352234 etcd-wrapper[1985]: {"level":"info","ts":"2025-08-13T07:09:20.351702Z","caller":"v2discovery/discovery.go:352","msg":"found peers from discovery server; waiting for more","discovery-url":"https://discovery.etcd.io","found-peers":2,"needed-peers":1} Aug 13 07:09:20.648402 sshd[2410]: Accepted publickey for core from 10.200.16.10 port 53926 ssh2: RSA SHA256:mUTVkvCTqAM/q6yF06VEIEfaT11Wyv/ewAABhIXzqTw Aug 13 07:09:20.649693 sshd-session[2410]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Aug 13 07:09:20.655096 systemd-logind[1626]: New session 4 of user core. Aug 13 07:09:20.660141 systemd[1]: Started session-4.scope - Session 4 of User core. Aug 13 07:09:21.003106 sshd[2412]: Connection closed by 10.200.16.10 port 53926 Aug 13 07:09:21.002418 sshd-session[2410]: pam_unix(sshd:session): session closed for user core Aug 13 07:09:21.006476 systemd-logind[1626]: Session 4 logged out. Waiting for processes to exit. Aug 13 07:09:21.006738 systemd[1]: sshd@1-10.200.20.45:22-10.200.16.10:53926.service: Deactivated successfully. Aug 13 07:09:21.008428 systemd[1]: session-4.scope: Deactivated successfully. Aug 13 07:09:21.009251 systemd-logind[1626]: Removed session 4. Aug 13 07:09:21.098194 systemd[1]: Started sshd@2-10.200.20.45:22-10.200.16.10:39676.service - OpenSSH per-connection server daemon (10.200.16.10:39676). Aug 13 07:09:21.589766 sshd[2418]: Accepted publickey for core from 10.200.16.10 port 39676 ssh2: RSA SHA256:mUTVkvCTqAM/q6yF06VEIEfaT11Wyv/ewAABhIXzqTw Aug 13 07:09:21.592132 sshd-session[2418]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Aug 13 07:09:21.597821 systemd-logind[1626]: New session 5 of user core. Aug 13 07:09:21.604137 systemd[1]: Started session-5.scope - Session 5 of User core. Aug 13 07:09:21.944187 sshd[2420]: Connection closed by 10.200.16.10 port 39676 Aug 13 07:09:21.944504 sshd-session[2418]: pam_unix(sshd:session): session closed for user core Aug 13 07:09:21.947262 systemd-logind[1626]: Session 5 logged out. Waiting for processes to exit. Aug 13 07:09:21.947455 systemd[1]: sshd@2-10.200.20.45:22-10.200.16.10:39676.service: Deactivated successfully. Aug 13 07:09:21.949145 systemd[1]: session-5.scope: Deactivated successfully. Aug 13 07:09:21.951322 systemd-logind[1626]: Removed session 5. Aug 13 07:09:27.414544 chronyd[1624]: Selected source PHC0 Aug 13 07:09:32.048267 systemd[1]: Started sshd@3-10.200.20.45:22-10.200.16.10:42836.service - OpenSSH per-connection server daemon (10.200.16.10:42836). Aug 13 07:09:32.539853 sshd[2426]: Accepted publickey for core from 10.200.16.10 port 42836 ssh2: RSA SHA256:mUTVkvCTqAM/q6yF06VEIEfaT11Wyv/ewAABhIXzqTw Aug 13 07:09:32.541146 sshd-session[2426]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Aug 13 07:09:32.546724 systemd-logind[1626]: New session 6 of user core. Aug 13 07:09:32.553187 systemd[1]: Started session-6.scope - Session 6 of User core. Aug 13 07:09:32.889406 sshd[2428]: Connection closed by 10.200.16.10 port 42836 Aug 13 07:09:32.890024 sshd-session[2426]: pam_unix(sshd:session): session closed for user core Aug 13 07:09:32.893232 systemd[1]: sshd@3-10.200.20.45:22-10.200.16.10:42836.service: Deactivated successfully. Aug 13 07:09:32.894759 systemd[1]: session-6.scope: Deactivated successfully. Aug 13 07:09:32.895393 systemd-logind[1626]: Session 6 logged out. Waiting for processes to exit. Aug 13 07:09:32.896378 systemd-logind[1626]: Removed session 6. Aug 13 07:09:32.986181 systemd[1]: Started sshd@4-10.200.20.45:22-10.200.16.10:42844.service - OpenSSH per-connection server daemon (10.200.16.10:42844). Aug 13 07:09:33.473210 sshd[2434]: Accepted publickey for core from 10.200.16.10 port 42844 ssh2: RSA SHA256:mUTVkvCTqAM/q6yF06VEIEfaT11Wyv/ewAABhIXzqTw Aug 13 07:09:33.474463 sshd-session[2434]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Aug 13 07:09:33.478235 systemd-logind[1626]: New session 7 of user core. Aug 13 07:09:33.489067 systemd[1]: Started session-7.scope - Session 7 of User core. Aug 13 07:09:33.613376 etcd-wrapper[1985]: {"level":"info","ts":"2025-08-13T07:09:33.613094Z","caller":"v2discovery/discovery.go:371","msg":"found peer from discovery server","discovery-url":"https://discovery.etcd.io","peer":"e05267e23e35057a"} Aug 13 07:09:33.613376 etcd-wrapper[1985]: {"level":"info","ts":"2025-08-13T07:09:33.613142Z","caller":"v2discovery/discovery.go:378","msg":"found all needed peers from discovery server","discovery-url":"https://discovery.etcd.io","found-peers":3} Aug 13 07:09:33.625339 etcd-wrapper[1985]: {"level":"info","ts":"2025-08-13T07:09:33.624857Z","caller":"etcdserver/raft.go:505","msg":"starting local member","local-member-id":"1b93a932f3d77f53","cluster-id":"2c67fcb2fcb71b85"} Aug 13 07:09:33.625339 etcd-wrapper[1985]: {"level":"info","ts":"2025-08-13T07:09:33.624965Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1b93a932f3d77f53 switched to configuration voters=()"} Aug 13 07:09:33.625339 etcd-wrapper[1985]: {"level":"info","ts":"2025-08-13T07:09:33.625011Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1b93a932f3d77f53 became follower at term 0"} Aug 13 07:09:33.625339 etcd-wrapper[1985]: {"level":"info","ts":"2025-08-13T07:09:33.625027Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 1b93a932f3d77f53 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} Aug 13 07:09:33.625339 etcd-wrapper[1985]: {"level":"info","ts":"2025-08-13T07:09:33.625039Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1b93a932f3d77f53 became follower at term 1"} Aug 13 07:09:33.625339 etcd-wrapper[1985]: {"level":"info","ts":"2025-08-13T07:09:33.625081Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1b93a932f3d77f53 switched to configuration voters=(1987117896904965971)"} Aug 13 07:09:33.625339 etcd-wrapper[1985]: {"level":"info","ts":"2025-08-13T07:09:33.625096Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1b93a932f3d77f53 switched to configuration voters=(1987117896904965971 8832315302408230438)"} Aug 13 07:09:33.625339 etcd-wrapper[1985]: {"level":"info","ts":"2025-08-13T07:09:33.625109Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1b93a932f3d77f53 switched to configuration voters=(1987117896904965971 8832315302408230438 16164096233990063482)"} Aug 13 07:09:33.631858 etcd-wrapper[1985]: {"level":"warn","ts":"2025-08-13T07:09:33.631672Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} Aug 13 07:09:33.635856 etcd-wrapper[1985]: {"level":"info","ts":"2025-08-13T07:09:33.635590Z","caller":"mvcc/kvstore.go:423","msg":"kvstore restored","current-rev":1} Aug 13 07:09:33.639988 etcd-wrapper[1985]: {"level":"info","ts":"2025-08-13T07:09:33.639699Z","caller":"etcdserver/quota.go:94","msg":"enabled backend quota with default value","quota-name":"v3-applier","quota-size-bytes":2147483648,"quota-size":"2.1 GB"} Aug 13 07:09:33.649157 etcd-wrapper[1985]: {"level":"info","ts":"2025-08-13T07:09:33.647820Z","caller":"rafthttp/peer.go:133","msg":"starting remote peer","remote-peer-id":"7a92aff8d04a1626"} Aug 13 07:09:33.649157 etcd-wrapper[1985]: {"level":"info","ts":"2025-08-13T07:09:33.647882Z","caller":"rafthttp/pipeline.go:72","msg":"started HTTP pipelining with remote peer","local-member-id":"1b93a932f3d77f53","remote-peer-id":"7a92aff8d04a1626"} Aug 13 07:09:33.649157 etcd-wrapper[1985]: {"level":"info","ts":"2025-08-13T07:09:33.648232Z","caller":"rafthttp/stream.go:169","msg":"started stream writer with remote peer","local-member-id":"1b93a932f3d77f53","remote-peer-id":"7a92aff8d04a1626"} Aug 13 07:09:33.649157 etcd-wrapper[1985]: {"level":"info","ts":"2025-08-13T07:09:33.648361Z","caller":"rafthttp/stream.go:169","msg":"started stream writer with remote peer","local-member-id":"1b93a932f3d77f53","remote-peer-id":"7a92aff8d04a1626"} Aug 13 07:09:33.649157 etcd-wrapper[1985]: {"level":"info","ts":"2025-08-13T07:09:33.648678Z","caller":"rafthttp/peer.go:137","msg":"started remote peer","remote-peer-id":"7a92aff8d04a1626"} Aug 13 07:09:33.649157 etcd-wrapper[1985]: {"level":"info","ts":"2025-08-13T07:09:33.648713Z","caller":"rafthttp/transport.go:317","msg":"added remote peer","local-member-id":"1b93a932f3d77f53","remote-peer-id":"7a92aff8d04a1626","remote-peer-urls":["http://10.200.20.43:2380"]} Aug 13 07:09:33.649157 etcd-wrapper[1985]: {"level":"info","ts":"2025-08-13T07:09:33.648727Z","caller":"rafthttp/peer.go:133","msg":"starting remote peer","remote-peer-id":"e05267e23e35057a"} Aug 13 07:09:33.649157 etcd-wrapper[1985]: {"level":"info","ts":"2025-08-13T07:09:33.648745Z","caller":"rafthttp/pipeline.go:72","msg":"started HTTP pipelining with remote peer","local-member-id":"1b93a932f3d77f53","remote-peer-id":"e05267e23e35057a"} Aug 13 07:09:33.650233 etcd-wrapper[1985]: {"level":"info","ts":"2025-08-13T07:09:33.649526Z","caller":"rafthttp/stream.go:169","msg":"started stream writer with remote peer","local-member-id":"1b93a932f3d77f53","remote-peer-id":"e05267e23e35057a"} Aug 13 07:09:33.650233 etcd-wrapper[1985]: {"level":"info","ts":"2025-08-13T07:09:33.649618Z","caller":"rafthttp/peer.go:137","msg":"started remote peer","remote-peer-id":"e05267e23e35057a"} Aug 13 07:09:33.650233 etcd-wrapper[1985]: {"level":"info","ts":"2025-08-13T07:09:33.649635Z","caller":"rafthttp/transport.go:317","msg":"added remote peer","local-member-id":"1b93a932f3d77f53","remote-peer-id":"e05267e23e35057a","remote-peer-urls":["http://10.200.20.47:2380"]} Aug 13 07:09:33.650233 etcd-wrapper[1985]: {"level":"info","ts":"2025-08-13T07:09:33.649656Z","caller":"etcdserver/server.go:873","msg":"starting etcd server","local-member-id":"1b93a932f3d77f53","local-server-version":"3.5.16","cluster-version":"to_be_decided"} Aug 13 07:09:33.650233 etcd-wrapper[1985]: {"level":"info","ts":"2025-08-13T07:09:33.649536Z","caller":"rafthttp/stream.go:395","msg":"started stream reader with remote peer","stream-reader-type":"stream MsgApp v2","local-member-id":"1b93a932f3d77f53","remote-peer-id":"7a92aff8d04a1626"} Aug 13 07:09:33.650233 etcd-wrapper[1985]: {"level":"info","ts":"2025-08-13T07:09:33.649820Z","caller":"v3rpc/health.go:61","msg":"grpc service status changed","service":"","status":"SERVING"} Aug 13 07:09:33.650233 etcd-wrapper[1985]: {"level":"info","ts":"2025-08-13T07:09:33.649841Z","caller":"rafthttp/stream.go:395","msg":"started stream reader with remote peer","stream-reader-type":"stream Message","local-member-id":"1b93a932f3d77f53","remote-peer-id":"7a92aff8d04a1626"} Aug 13 07:09:33.651829 etcd-wrapper[1985]: {"level":"info","ts":"2025-08-13T07:09:33.651675Z","caller":"embed/etcd.go:280","msg":"now serving peer/client/metrics","local-member-id":"1b93a932f3d77f53","initial-advertise-peer-urls":["http://10.200.20.45:2380"],"listen-peer-urls":["http://10.200.20.45:2380"],"advertise-client-urls":["http://10.200.20.45:2379"],"listen-client-urls":["http://0.0.0.0:2379"],"listen-metrics-urls":[]} Aug 13 07:09:33.652932 etcd-wrapper[1985]: {"level":"info","ts":"2025-08-13T07:09:33.651737Z","caller":"etcdserver/server.go:773","msg":"starting initial election tick advance","election-ticks":10} Aug 13 07:09:33.652932 etcd-wrapper[1985]: {"level":"info","ts":"2025-08-13T07:09:33.651884Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/snap","suffix":"snap.db","max":5,"interval":"30s"} Aug 13 07:09:33.652932 etcd-wrapper[1985]: {"level":"info","ts":"2025-08-13T07:09:33.651906Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/snap","suffix":"snap","max":5,"interval":"30s"} Aug 13 07:09:33.652932 etcd-wrapper[1985]: {"level":"info","ts":"2025-08-13T07:09:33.651912Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/wal","suffix":"wal","max":5,"interval":"30s"} Aug 13 07:09:33.652932 etcd-wrapper[1985]: {"level":"info","ts":"2025-08-13T07:09:33.651959Z","caller":"rafthttp/stream.go:169","msg":"started stream writer with remote peer","local-member-id":"1b93a932f3d77f53","remote-peer-id":"e05267e23e35057a"} Aug 13 07:09:33.652932 etcd-wrapper[1985]: {"level":"info","ts":"2025-08-13T07:09:33.651984Z","caller":"rafthttp/stream.go:395","msg":"started stream reader with remote peer","stream-reader-type":"stream MsgApp v2","local-member-id":"1b93a932f3d77f53","remote-peer-id":"e05267e23e35057a"} Aug 13 07:09:33.652932 etcd-wrapper[1985]: {"level":"info","ts":"2025-08-13T07:09:33.652117Z","caller":"embed/etcd.go:600","msg":"serving peer traffic","address":"10.200.20.45:2380"} Aug 13 07:09:33.652932 etcd-wrapper[1985]: {"level":"info","ts":"2025-08-13T07:09:33.652128Z","caller":"embed/etcd.go:572","msg":"cmux::serve","address":"10.200.20.45:2380"} Aug 13 07:09:33.652932 etcd-wrapper[1985]: {"level":"info","ts":"2025-08-13T07:09:33.652128Z","caller":"rafthttp/stream.go:395","msg":"started stream reader with remote peer","stream-reader-type":"stream Message","local-member-id":"1b93a932f3d77f53","remote-peer-id":"e05267e23e35057a"} Aug 13 07:09:33.652932 etcd-wrapper[1985]: {"level":"info","ts":"2025-08-13T07:09:33.652312Z","caller":"rafthttp/stream.go:249","msg":"set message encoder","from":"1b93a932f3d77f53","to":"7a92aff8d04a1626","stream-type":"stream Message"} Aug 13 07:09:33.652932 etcd-wrapper[1985]: {"level":"info","ts":"2025-08-13T07:09:33.652327Z","caller":"rafthttp/peer_status.go:53","msg":"peer became active","peer-id":"7a92aff8d04a1626"} Aug 13 07:09:33.655238 etcd-wrapper[1985]: {"level":"info","ts":"2025-08-13T07:09:33.652338Z","caller":"rafthttp/stream.go:274","msg":"established TCP streaming connection with remote peer","stream-writer-type":"stream Message","local-member-id":"1b93a932f3d77f53","remote-peer-id":"7a92aff8d04a1626"} Aug 13 07:09:33.655238 etcd-wrapper[1985]: {"level":"info","ts":"2025-08-13T07:09:33.652382Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1b93a932f3d77f53 switched to configuration voters=(1987117896904965971 8832315302408230438 16164096233990063482)"} Aug 13 07:09:33.655238 etcd-wrapper[1985]: {"level":"info","ts":"2025-08-13T07:09:33.652447Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"2c67fcb2fcb71b85","local-member-id":"1b93a932f3d77f53","added-peer-id":"1b93a932f3d77f53","added-peer-peer-urls":["http://10.200.20.45:2380"]} Aug 13 07:09:33.655238 etcd-wrapper[1985]: {"level":"info","ts":"2025-08-13T07:09:33.652601Z","caller":"rafthttp/stream.go:249","msg":"set message encoder","from":"1b93a932f3d77f53","to":"7a92aff8d04a1626","stream-type":"stream MsgApp v2"} Aug 13 07:09:33.655238 etcd-wrapper[1985]: {"level":"info","ts":"2025-08-13T07:09:33.652602Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1b93a932f3d77f53 switched to configuration voters=(1987117896904965971 8832315302408230438 16164096233990063482)"} Aug 13 07:09:33.655238 etcd-wrapper[1985]: {"level":"info","ts":"2025-08-13T07:09:33.652615Z","caller":"rafthttp/stream.go:274","msg":"established TCP streaming connection with remote peer","stream-writer-type":"stream MsgApp v2","local-member-id":"1b93a932f3d77f53","remote-peer-id":"7a92aff8d04a1626"} Aug 13 07:09:33.655238 etcd-wrapper[1985]: {"level":"info","ts":"2025-08-13T07:09:33.652666Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"2c67fcb2fcb71b85","local-member-id":"1b93a932f3d77f53","added-peer-id":"7a92aff8d04a1626","added-peer-peer-urls":["http://10.200.20.43:2380"]} Aug 13 07:09:33.655238 etcd-wrapper[1985]: {"level":"info","ts":"2025-08-13T07:09:33.652708Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1b93a932f3d77f53 switched to configuration voters=(1987117896904965971 8832315302408230438 16164096233990063482)"} Aug 13 07:09:33.655423 etcd-wrapper[1985]: {"level":"info","ts":"2025-08-13T07:09:33.652766Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"2c67fcb2fcb71b85","local-member-id":"1b93a932f3d77f53","added-peer-id":"e05267e23e35057a","added-peer-peer-urls":["http://10.200.20.47:2380"]} Aug 13 07:09:33.655423 etcd-wrapper[1985]: {"level":"info","ts":"2025-08-13T07:09:33.652870Z","caller":"rafthttp/stream.go:412","msg":"established TCP streaming connection with remote peer","stream-reader-type":"stream MsgApp v2","local-member-id":"1b93a932f3d77f53","remote-peer-id":"7a92aff8d04a1626"} Aug 13 07:09:33.655423 etcd-wrapper[1985]: {"level":"info","ts":"2025-08-13T07:09:33.653249Z","caller":"rafthttp/stream.go:412","msg":"established TCP streaming connection with remote peer","stream-reader-type":"stream Message","local-member-id":"1b93a932f3d77f53","remote-peer-id":"7a92aff8d04a1626"} Aug 13 07:09:33.821827 sshd[2436]: Connection closed by 10.200.16.10 port 42844 Aug 13 07:09:33.822346 sshd-session[2434]: pam_unix(sshd:session): session closed for user core Aug 13 07:09:33.824814 systemd-logind[1626]: Session 7 logged out. Waiting for processes to exit. Aug 13 07:09:33.826139 systemd[1]: sshd@4-10.200.20.45:22-10.200.16.10:42844.service: Deactivated successfully. Aug 13 07:09:33.829057 systemd[1]: session-7.scope: Deactivated successfully. Aug 13 07:09:33.831567 systemd-logind[1626]: Removed session 7. Aug 13 07:09:33.859592 etcd-wrapper[1985]: {"level":"info","ts":"2025-08-13T07:09:33.859328Z","caller":"rafthttp/stream.go:249","msg":"set message encoder","from":"1b93a932f3d77f53","to":"e05267e23e35057a","stream-type":"stream MsgApp v2"} Aug 13 07:09:33.859781 etcd-wrapper[1985]: {"level":"info","ts":"2025-08-13T07:09:33.859539Z","caller":"rafthttp/peer_status.go:53","msg":"peer became active","peer-id":"e05267e23e35057a"} Aug 13 07:09:33.859781 etcd-wrapper[1985]: {"level":"info","ts":"2025-08-13T07:09:33.859664Z","caller":"rafthttp/stream.go:274","msg":"established TCP streaming connection with remote peer","stream-writer-type":"stream MsgApp v2","local-member-id":"1b93a932f3d77f53","remote-peer-id":"e05267e23e35057a"} Aug 13 07:09:33.860298 etcd-wrapper[1985]: {"level":"info","ts":"2025-08-13T07:09:33.860146Z","caller":"rafthttp/stream.go:249","msg":"set message encoder","from":"1b93a932f3d77f53","to":"e05267e23e35057a","stream-type":"stream Message"} Aug 13 07:09:33.860298 etcd-wrapper[1985]: {"level":"info","ts":"2025-08-13T07:09:33.860181Z","caller":"rafthttp/stream.go:274","msg":"established TCP streaming connection with remote peer","stream-writer-type":"stream Message","local-member-id":"1b93a932f3d77f53","remote-peer-id":"e05267e23e35057a"} Aug 13 07:09:33.862123 etcd-wrapper[1985]: {"level":"info","ts":"2025-08-13T07:09:33.861980Z","caller":"rafthttp/stream.go:412","msg":"established TCP streaming connection with remote peer","stream-reader-type":"stream MsgApp v2","local-member-id":"1b93a932f3d77f53","remote-peer-id":"e05267e23e35057a"} Aug 13 07:09:33.862832 etcd-wrapper[1985]: {"level":"info","ts":"2025-08-13T07:09:33.862667Z","caller":"rafthttp/stream.go:412","msg":"established TCP streaming connection with remote peer","stream-reader-type":"stream Message","local-member-id":"1b93a932f3d77f53","remote-peer-id":"e05267e23e35057a"} Aug 13 07:09:33.904032 etcd-wrapper[1985]: {"level":"info","ts":"2025-08-13T07:09:33.903836Z","caller":"etcdserver/server.go:796","msg":"initialized peer connections; fast-forwarding election ticks","local-member-id":"1b93a932f3d77f53","forward-ticks":8,"forward-duration":"800ms","election-ticks":10,"election-timeout":"1s","active-remote-members":2} Aug 13 07:09:34.128349 etcd-wrapper[1985]: {"level":"info","ts":"2025-08-13T07:09:34.127973Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1b93a932f3d77f53 [logterm: 1, index: 3, vote: 0] cast MsgPreVote for 7a92aff8d04a1626 [logterm: 1, index: 3] at term 1"} Aug 13 07:09:34.130437 etcd-wrapper[1985]: {"level":"info","ts":"2025-08-13T07:09:34.130233Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1b93a932f3d77f53 [term: 1] received a MsgVote message with higher term from 7a92aff8d04a1626 [term: 2]"} Aug 13 07:09:34.130658 etcd-wrapper[1985]: {"level":"info","ts":"2025-08-13T07:09:34.130295Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1b93a932f3d77f53 became follower at term 2"} Aug 13 07:09:34.130658 etcd-wrapper[1985]: {"level":"info","ts":"2025-08-13T07:09:34.130404Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1b93a932f3d77f53 [logterm: 1, index: 3, vote: 0] cast MsgVote for 7a92aff8d04a1626 [logterm: 1, index: 3] at term 2"} Aug 13 07:09:34.132636 etcd-wrapper[1985]: {"level":"info","ts":"2025-08-13T07:09:34.132410Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 1b93a932f3d77f53 elected leader 7a92aff8d04a1626 at term 2"} Aug 13 07:09:34.140368 etcd-wrapper[1985]: {"level":"info","ts":"2025-08-13T07:09:34.140047Z","caller":"etcdserver/server.go:2140","msg":"published local member to cluster through raft","local-member-id":"1b93a932f3d77f53","local-member-attributes":"{Name:19209727f5a047d2861c873cb16cb69f ClientURLs:[http://10.200.20.45:2379]}","request-path":"/0/members/1b93a932f3d77f53/attributes","cluster-id":"2c67fcb2fcb71b85","publish-timeout":"7s"} Aug 13 07:09:34.140709 etcd-wrapper[1985]: {"level":"info","ts":"2025-08-13T07:09:34.140155Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} Aug 13 07:09:34.141698 etcd-wrapper[1985]: {"level":"info","ts":"2025-08-13T07:09:34.140506Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} Aug 13 07:09:34.141698 etcd-wrapper[1985]: {"level":"info","ts":"2025-08-13T07:09:34.140967Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} Aug 13 07:09:34.141273 systemd[1]: Started etcd-member.service - etcd (System Application Container). Aug 13 07:09:34.141597 systemd[1]: Reached target multi-user.target - Multi-User System. Aug 13 07:09:34.142050 systemd[1]: Startup finished in 644ms (kernel) + 10.565s (initrd) + 39.870s (userspace) = 51.080s. Aug 13 07:09:34.143022 etcd-wrapper[1985]: {"level":"info","ts":"2025-08-13T07:09:34.142241Z","caller":"v3rpc/health.go:61","msg":"grpc service status changed","service":"","status":"SERVING"} Aug 13 07:09:34.143022 etcd-wrapper[1985]: {"level":"info","ts":"2025-08-13T07:09:34.142681Z","caller":"embed/serve.go:187","msg":"serving client traffic insecurely; this is strongly discouraged!","traffic":"grpc+http","address":"[::]:2379"} Aug 13 07:09:34.144250 etcd-wrapper[1985]: {"level":"info","ts":"2025-08-13T07:09:34.144104Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"2c67fcb2fcb71b85","local-member-id":"1b93a932f3d77f53","cluster-version":"3.5"} Aug 13 07:09:34.144459 etcd-wrapper[1985]: {"level":"info","ts":"2025-08-13T07:09:34.144335Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} Aug 13 07:09:43.906029 systemd[1]: Started sshd@5-10.200.20.45:22-10.200.16.10:36414.service - OpenSSH per-connection server daemon (10.200.16.10:36414). Aug 13 07:09:44.384108 sshd[2446]: Accepted publickey for core from 10.200.16.10 port 36414 ssh2: RSA SHA256:mUTVkvCTqAM/q6yF06VEIEfaT11Wyv/ewAABhIXzqTw Aug 13 07:09:44.385348 sshd-session[2446]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Aug 13 07:09:44.390588 systemd-logind[1626]: New session 8 of user core. Aug 13 07:09:44.397087 systemd[1]: Started session-8.scope - Session 8 of User core. Aug 13 07:09:44.724455 sshd[2448]: Connection closed by 10.200.16.10 port 36414 Aug 13 07:09:44.725194 sshd-session[2446]: pam_unix(sshd:session): session closed for user core Aug 13 07:09:44.728522 systemd-logind[1626]: Session 8 logged out. Waiting for processes to exit. Aug 13 07:09:44.729180 systemd[1]: sshd@5-10.200.20.45:22-10.200.16.10:36414.service: Deactivated successfully. Aug 13 07:09:44.730876 systemd[1]: session-8.scope: Deactivated successfully. Aug 13 07:09:44.732194 systemd-logind[1626]: Removed session 8. Aug 13 07:09:44.815053 systemd[1]: Started sshd@6-10.200.20.45:22-10.200.16.10:36428.service - OpenSSH per-connection server daemon (10.200.16.10:36428). Aug 13 07:09:45.309616 sshd[2454]: Accepted publickey for core from 10.200.16.10 port 36428 ssh2: RSA SHA256:mUTVkvCTqAM/q6yF06VEIEfaT11Wyv/ewAABhIXzqTw Aug 13 07:09:45.310860 sshd-session[2454]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Aug 13 07:09:45.316223 systemd-logind[1626]: New session 9 of user core. Aug 13 07:09:45.322094 systemd[1]: Started session-9.scope - Session 9 of User core. Aug 13 07:09:45.658851 sshd[2456]: Connection closed by 10.200.16.10 port 36428 Aug 13 07:09:45.662791 sshd-session[2454]: pam_unix(sshd:session): session closed for user core Aug 13 07:09:45.666063 systemd[1]: sshd@6-10.200.20.45:22-10.200.16.10:36428.service: Deactivated successfully. Aug 13 07:09:45.667609 systemd[1]: session-9.scope: Deactivated successfully. Aug 13 07:09:45.669517 systemd-logind[1626]: Session 9 logged out. Waiting for processes to exit. Aug 13 07:09:45.670309 systemd-logind[1626]: Removed session 9. Aug 13 07:09:45.747160 systemd[1]: Started sshd@7-10.200.20.45:22-10.200.16.10:36432.service - OpenSSH per-connection server daemon (10.200.16.10:36432). Aug 13 07:09:46.238854 sshd[2462]: Accepted publickey for core from 10.200.16.10 port 36432 ssh2: RSA SHA256:mUTVkvCTqAM/q6yF06VEIEfaT11Wyv/ewAABhIXzqTw Aug 13 07:09:46.240081 sshd-session[2462]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Aug 13 07:09:46.243833 systemd-logind[1626]: New session 10 of user core. Aug 13 07:09:46.254142 systemd[1]: Started session-10.scope - Session 10 of User core. Aug 13 07:09:46.588475 sshd[2464]: Connection closed by 10.200.16.10 port 36432 Aug 13 07:09:46.589093 sshd-session[2462]: pam_unix(sshd:session): session closed for user core Aug 13 07:09:46.592112 systemd[1]: sshd@7-10.200.20.45:22-10.200.16.10:36432.service: Deactivated successfully. Aug 13 07:09:46.593552 systemd[1]: session-10.scope: Deactivated successfully. Aug 13 07:09:46.594168 systemd-logind[1626]: Session 10 logged out. Waiting for processes to exit. Aug 13 07:09:46.595138 systemd-logind[1626]: Removed session 10. Aug 13 07:09:46.676089 systemd[1]: Started sshd@8-10.200.20.45:22-10.200.16.10:36434.service - OpenSSH per-connection server daemon (10.200.16.10:36434). Aug 13 07:09:47.165891 sshd[2470]: Accepted publickey for core from 10.200.16.10 port 36434 ssh2: RSA SHA256:mUTVkvCTqAM/q6yF06VEIEfaT11Wyv/ewAABhIXzqTw Aug 13 07:09:47.167126 sshd-session[2470]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Aug 13 07:09:47.172490 systemd-logind[1626]: New session 11 of user core. Aug 13 07:09:47.179162 systemd[1]: Started session-11.scope - Session 11 of User core. Aug 13 07:09:47.612443 sudo[2473]: core : PWD=/home/core ; USER=root ; COMMAND=/usr/sbin/setenforce 1 Aug 13 07:09:47.612710 sudo[2473]: pam_unix(sudo:session): session opened for user root(uid=0) by core(uid=500) Aug 13 07:09:47.628201 sudo[2473]: pam_unix(sudo:session): session closed for user root Aug 13 07:09:47.706646 sshd[2472]: Connection closed by 10.200.16.10 port 36434 Aug 13 07:09:47.705873 sshd-session[2470]: pam_unix(sshd:session): session closed for user core Aug 13 07:09:47.708986 systemd[1]: sshd@8-10.200.20.45:22-10.200.16.10:36434.service: Deactivated successfully. Aug 13 07:09:47.710754 systemd[1]: session-11.scope: Deactivated successfully. Aug 13 07:09:47.712268 systemd-logind[1626]: Session 11 logged out. Waiting for processes to exit. Aug 13 07:09:47.713995 systemd-logind[1626]: Removed session 11. Aug 13 07:09:47.789310 systemd[1]: Started sshd@9-10.200.20.45:22-10.200.16.10:36450.service - OpenSSH per-connection server daemon (10.200.16.10:36450). Aug 13 07:09:48.165565 kernel: hv_balloon: Max. dynamic memory size: 4096 MB Aug 13 07:09:48.245725 sshd[2479]: Accepted publickey for core from 10.200.16.10 port 36450 ssh2: RSA SHA256:mUTVkvCTqAM/q6yF06VEIEfaT11Wyv/ewAABhIXzqTw Aug 13 07:09:48.246999 sshd-session[2479]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Aug 13 07:09:48.252003 systemd-logind[1626]: New session 12 of user core. Aug 13 07:09:48.257144 systemd[1]: Started session-12.scope - Session 12 of User core. Aug 13 07:09:48.502021 sudo[2483]: 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 Aug 13 07:09:48.502282 sudo[2483]: pam_unix(sudo:session): session opened for user root(uid=0) by core(uid=500) Aug 13 07:09:48.505103 sudo[2483]: pam_unix(sudo:session): session closed for user root Aug 13 07:09:48.509100 sudo[2482]: core : PWD=/home/core ; USER=root ; COMMAND=/usr/sbin/systemctl restart audit-rules Aug 13 07:09:48.509341 sudo[2482]: pam_unix(sudo:session): session opened for user root(uid=0) by core(uid=500) Aug 13 07:09:48.525209 systemd[1]: Starting audit-rules.service - Load Audit Rules... Aug 13 07:09:48.545051 augenrules[2505]: No rules Aug 13 07:09:48.546411 systemd[1]: audit-rules.service: Deactivated successfully. Aug 13 07:09:48.548004 systemd[1]: Finished audit-rules.service - Load Audit Rules. Aug 13 07:09:48.549459 sudo[2482]: pam_unix(sudo:session): session closed for user root Aug 13 07:09:48.633455 sshd[2481]: Connection closed by 10.200.16.10 port 36450 Aug 13 07:09:48.633793 sshd-session[2479]: pam_unix(sshd:session): session closed for user core Aug 13 07:09:48.637126 systemd[1]: sshd@9-10.200.20.45:22-10.200.16.10:36450.service: Deactivated successfully. Aug 13 07:09:48.638745 systemd[1]: session-12.scope: Deactivated successfully. Aug 13 07:09:48.641416 systemd-logind[1626]: Session 12 logged out. Waiting for processes to exit. Aug 13 07:09:48.642441 systemd-logind[1626]: Removed session 12. Aug 13 07:09:49.063139 update_engine[1633]: I20250813 07:09:49.063074 1633 update_attempter.cc:509] Updating boot flags... Aug 13 07:09:49.128978 kernel: BTRFS warning: duplicate device /dev/sda3 devid 1 generation 42 scanned by (udev-worker) (2528) Aug 13 07:09:49.226332 kernel: BTRFS warning: duplicate device /dev/sda3 devid 1 generation 42 scanned by (udev-worker) (2527) Aug 13 07:09:50.762154 systemd[1]: Started sshd@10-10.200.20.45:22-10.200.16.10:42890.service - OpenSSH per-connection server daemon (10.200.16.10:42890). Aug 13 07:09:51.213829 sshd[2628]: Accepted publickey for core from 10.200.16.10 port 42890 ssh2: RSA SHA256:mUTVkvCTqAM/q6yF06VEIEfaT11Wyv/ewAABhIXzqTw Aug 13 07:09:51.215076 sshd-session[2628]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Aug 13 07:09:51.220486 systemd-logind[1626]: New session 13 of user core. Aug 13 07:09:51.225094 systemd[1]: Started session-13.scope - Session 13 of User core. Aug 13 07:09:51.879606 sshd[2630]: Connection closed by 10.200.16.10 port 42890 Aug 13 07:09:51.880170 sshd-session[2628]: pam_unix(sshd:session): session closed for user core Aug 13 07:09:51.883185 systemd[1]: sshd@10-10.200.20.45:22-10.200.16.10:42890.service: Deactivated successfully. Aug 13 07:09:51.884607 systemd[1]: session-13.scope: Deactivated successfully. Aug 13 07:09:51.886184 systemd-logind[1626]: Session 13 logged out. Waiting for processes to exit. Aug 13 07:09:51.887062 systemd-logind[1626]: Removed session 13.