Jan 16 23:57:19.217148 kernel: Booting Linux on physical CPU 0x0000000000 [0x413fd0c1] Jan 16 23:57:19.217171 kernel: Linux version 6.6.119-flatcar (build@pony-truck.infra.kinvolk.io) (aarch64-cros-linux-gnu-gcc (Gentoo Hardened 13.3.1_p20240614 p17) 13.3.1 20240614, GNU ld (Gentoo 2.42 p3) 2.42.0) #1 SMP PREEMPT Fri Jan 16 22:28:08 -00 2026 Jan 16 23:57:19.217180 kernel: KASLR enabled Jan 16 23:57:19.217186 kernel: earlycon: pl11 at MMIO 0x00000000effec000 (options '') Jan 16 23:57:19.217194 kernel: printk: bootconsole [pl11] enabled Jan 16 23:57:19.217200 kernel: efi: EFI v2.7 by EDK II Jan 16 23:57:19.217208 kernel: efi: ACPI 2.0=0x3fd5f018 SMBIOS=0x3e580000 SMBIOS 3.0=0x3e560000 MEMATTR=0x3f215018 RNG=0x3fd5f998 MEMRESERVE=0x3e44ee18 Jan 16 23:57:19.217215 kernel: random: crng init done Jan 16 23:57:19.217222 kernel: ACPI: Early table checksum verification disabled Jan 16 23:57:19.217227 kernel: ACPI: RSDP 0x000000003FD5F018 000024 (v02 VRTUAL) Jan 16 23:57:19.217234 kernel: ACPI: XSDT 0x000000003FD5FF18 00006C (v01 VRTUAL MICROSFT 00000001 MSFT 00000001) Jan 16 23:57:19.217240 kernel: ACPI: FACP 0x000000003FD5FC18 000114 (v06 VRTUAL MICROSFT 00000001 MSFT 00000001) Jan 16 23:57:19.217248 kernel: ACPI: DSDT 0x000000003FD41018 01DFCD (v02 MSFTVM DSDT01 00000001 INTL 20230628) Jan 16 23:57:19.217254 kernel: ACPI: DBG2 0x000000003FD5FB18 000072 (v00 VRTUAL MICROSFT 00000001 MSFT 00000001) Jan 16 23:57:19.217262 kernel: ACPI: GTDT 0x000000003FD5FD98 000060 (v02 VRTUAL MICROSFT 00000001 MSFT 00000001) Jan 16 23:57:19.217268 kernel: ACPI: OEM0 0x000000003FD5F098 000064 (v01 VRTUAL MICROSFT 00000001 MSFT 00000001) Jan 16 23:57:19.217275 kernel: ACPI: SPCR 0x000000003FD5FA98 000050 (v02 VRTUAL MICROSFT 00000001 MSFT 00000001) Jan 16 23:57:19.217283 kernel: ACPI: APIC 0x000000003FD5F818 0000FC (v04 VRTUAL MICROSFT 00000001 MSFT 00000001) Jan 16 23:57:19.217290 kernel: ACPI: SRAT 0x000000003FD5F198 000234 (v03 VRTUAL MICROSFT 00000001 MSFT 00000001) Jan 16 23:57:19.217296 kernel: ACPI: PPTT 0x000000003FD5F418 000120 (v01 VRTUAL MICROSFT 00000000 MSFT 00000000) Jan 16 23:57:19.217304 kernel: ACPI: BGRT 0x000000003FD5FE98 000038 (v01 VRTUAL MICROSFT 00000001 MSFT 00000001) Jan 16 23:57:19.217311 kernel: ACPI: SPCR: console: pl011,mmio32,0xeffec000,115200 Jan 16 23:57:19.217317 kernel: ACPI: SRAT: Node 0 PXM 0 [mem 0x00000000-0x3fffffff] Jan 16 23:57:19.217324 kernel: ACPI: SRAT: Node 0 PXM 0 [mem 0x100000000-0x1bfffffff] Jan 16 23:57:19.217331 kernel: ACPI: SRAT: Node 0 PXM 0 [mem 0x1c0000000-0xfbfffffff] Jan 16 23:57:19.217337 kernel: ACPI: SRAT: Node 0 PXM 0 [mem 0x1000000000-0xffffffffff] Jan 16 23:57:19.217344 kernel: ACPI: SRAT: Node 0 PXM 0 [mem 0x10000000000-0x1ffffffffff] Jan 16 23:57:19.217351 kernel: ACPI: SRAT: Node 0 PXM 0 [mem 0x20000000000-0x3ffffffffff] Jan 16 23:57:19.217360 kernel: ACPI: SRAT: Node 0 PXM 0 [mem 0x40000000000-0x7ffffffffff] Jan 16 23:57:19.217366 kernel: ACPI: SRAT: Node 0 PXM 0 [mem 0x80000000000-0xfffffffffff] Jan 16 23:57:19.217373 kernel: ACPI: SRAT: Node 0 PXM 0 [mem 0x100000000000-0x1fffffffffff] Jan 16 23:57:19.217379 kernel: ACPI: SRAT: Node 0 PXM 0 [mem 0x200000000000-0x3fffffffffff] Jan 16 23:57:19.217386 kernel: ACPI: SRAT: Node 0 PXM 0 [mem 0x400000000000-0x7fffffffffff] Jan 16 23:57:19.217392 kernel: ACPI: SRAT: Node 0 PXM 0 [mem 0x800000000000-0xffffffffffff] Jan 16 23:57:19.217398 kernel: NUMA: NODE_DATA [mem 0x1bf7ef800-0x1bf7f4fff] Jan 16 23:57:19.217404 kernel: Zone ranges: Jan 16 23:57:19.217411 kernel: DMA [mem 0x0000000000000000-0x00000000ffffffff] Jan 16 23:57:19.218077 kernel: DMA32 empty Jan 16 23:57:19.218087 kernel: Normal [mem 0x0000000100000000-0x00000001bfffffff] Jan 16 23:57:19.218094 kernel: Movable zone start for each node Jan 16 23:57:19.218106 kernel: Early memory node ranges Jan 16 23:57:19.218114 kernel: node 0: [mem 0x0000000000000000-0x00000000007fffff] Jan 16 23:57:19.218121 kernel: node 0: [mem 0x0000000000824000-0x000000003e54ffff] Jan 16 23:57:19.218128 kernel: node 0: [mem 0x000000003e550000-0x000000003e87ffff] Jan 16 23:57:19.218135 kernel: node 0: [mem 0x000000003e880000-0x000000003fc7ffff] Jan 16 23:57:19.218143 kernel: node 0: [mem 0x000000003fc80000-0x000000003fcfffff] Jan 16 23:57:19.218150 kernel: node 0: [mem 0x000000003fd00000-0x000000003fffffff] Jan 16 23:57:19.218157 kernel: node 0: [mem 0x0000000100000000-0x00000001bfffffff] Jan 16 23:57:19.218164 kernel: Initmem setup node 0 [mem 0x0000000000000000-0x00000001bfffffff] Jan 16 23:57:19.218172 kernel: On node 0, zone DMA: 36 pages in unavailable ranges Jan 16 23:57:19.218179 kernel: psci: probing for conduit method from ACPI. Jan 16 23:57:19.218185 kernel: psci: PSCIv1.1 detected in firmware. Jan 16 23:57:19.218192 kernel: psci: Using standard PSCI v0.2 function IDs Jan 16 23:57:19.218199 kernel: psci: MIGRATE_INFO_TYPE not supported. Jan 16 23:57:19.218206 kernel: psci: SMC Calling Convention v1.4 Jan 16 23:57:19.218214 kernel: ACPI: NUMA: SRAT: PXM 0 -> MPIDR 0x0 -> Node 0 Jan 16 23:57:19.218221 kernel: ACPI: NUMA: SRAT: PXM 0 -> MPIDR 0x1 -> Node 0 Jan 16 23:57:19.218229 kernel: percpu: Embedded 30 pages/cpu s85672 r8192 d29016 u122880 Jan 16 23:57:19.218236 kernel: pcpu-alloc: s85672 r8192 d29016 u122880 alloc=30*4096 Jan 16 23:57:19.218243 kernel: pcpu-alloc: [0] 0 [0] 1 Jan 16 23:57:19.218250 kernel: Detected PIPT I-cache on CPU0 Jan 16 23:57:19.218257 kernel: CPU features: detected: GIC system register CPU interface Jan 16 23:57:19.218264 kernel: CPU features: detected: Hardware dirty bit management Jan 16 23:57:19.218271 kernel: CPU features: detected: Spectre-BHB Jan 16 23:57:19.218278 kernel: CPU features: kernel page table isolation forced ON by KASLR Jan 16 23:57:19.218285 kernel: CPU features: detected: Kernel page table isolation (KPTI) Jan 16 23:57:19.218292 kernel: CPU features: detected: ARM erratum 1418040 Jan 16 23:57:19.218299 kernel: CPU features: detected: ARM erratum 1542419 (kernel portion) Jan 16 23:57:19.218308 kernel: CPU features: detected: SSBS not fully self-synchronizing Jan 16 23:57:19.218315 kernel: alternatives: applying boot alternatives Jan 16 23:57:19.218323 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=d499dc3f7d5d4118d4e4300ad00f17ad72271d2a2f6bb9119457036ac5212c83 Jan 16 23:57:19.218330 kernel: Dentry cache hash table entries: 524288 (order: 10, 4194304 bytes, linear) Jan 16 23:57:19.218337 kernel: Inode-cache hash table entries: 262144 (order: 9, 2097152 bytes, linear) Jan 16 23:57:19.218344 kernel: Fallback order for Node 0: 0 Jan 16 23:57:19.218351 kernel: Built 1 zonelists, mobility grouping on. Total pages: 1032156 Jan 16 23:57:19.218358 kernel: Policy zone: Normal Jan 16 23:57:19.218364 kernel: mem auto-init: stack:off, heap alloc:off, heap free:off Jan 16 23:57:19.218371 kernel: software IO TLB: area num 2. Jan 16 23:57:19.218378 kernel: software IO TLB: mapped [mem 0x000000003a44e000-0x000000003e44e000] (64MB) Jan 16 23:57:19.218387 kernel: Memory: 3982636K/4194160K available (10304K kernel code, 2180K rwdata, 8112K rodata, 39424K init, 897K bss, 211524K reserved, 0K cma-reserved) Jan 16 23:57:19.218394 kernel: SLUB: HWalign=64, Order=0-3, MinObjects=0, CPUs=2, Nodes=1 Jan 16 23:57:19.218401 kernel: rcu: Preemptible hierarchical RCU implementation. Jan 16 23:57:19.218408 kernel: rcu: RCU event tracing is enabled. Jan 16 23:57:19.219456 kernel: rcu: RCU restricting CPUs from NR_CPUS=512 to nr_cpu_ids=2. Jan 16 23:57:19.219477 kernel: Trampoline variant of Tasks RCU enabled. Jan 16 23:57:19.219485 kernel: Tracing variant of Tasks RCU enabled. Jan 16 23:57:19.219492 kernel: rcu: RCU calculated value of scheduler-enlistment delay is 100 jiffies. Jan 16 23:57:19.219499 kernel: rcu: Adjusting geometry for rcu_fanout_leaf=16, nr_cpu_ids=2 Jan 16 23:57:19.219515 kernel: NR_IRQS: 64, nr_irqs: 64, preallocated irqs: 0 Jan 16 23:57:19.219523 kernel: GICv3: 960 SPIs implemented Jan 16 23:57:19.219533 kernel: GICv3: 0 Extended SPIs implemented Jan 16 23:57:19.219540 kernel: Root IRQ handler: gic_handle_irq Jan 16 23:57:19.219547 kernel: GICv3: GICv3 features: 16 PPIs, RSS Jan 16 23:57:19.219554 kernel: GICv3: CPU0: found redistributor 0 region 0:0x00000000effee000 Jan 16 23:57:19.219560 kernel: ITS: No ITS available, not enabling LPIs Jan 16 23:57:19.219567 kernel: rcu: srcu_init: Setting srcu_struct sizes based on contention. Jan 16 23:57:19.219574 kernel: arch_timer: Enabling local workaround for ARM erratum 1418040 Jan 16 23:57:19.219581 kernel: arch_timer: cp15 timer(s) running at 25.00MHz (virt). Jan 16 23:57:19.219588 kernel: clocksource: arch_sys_counter: mask: 0xffffffffffffff max_cycles: 0x5c40939b5, max_idle_ns: 440795202646 ns Jan 16 23:57:19.219595 kernel: sched_clock: 56 bits at 25MHz, resolution 40ns, wraps every 4398046511100ns Jan 16 23:57:19.219602 kernel: Console: colour dummy device 80x25 Jan 16 23:57:19.219611 kernel: printk: console [tty1] enabled Jan 16 23:57:19.219618 kernel: ACPI: Core revision 20230628 Jan 16 23:57:19.219625 kernel: Calibrating delay loop (skipped), value calculated using timer frequency.. 50.00 BogoMIPS (lpj=25000) Jan 16 23:57:19.219632 kernel: pid_max: default: 32768 minimum: 301 Jan 16 23:57:19.219639 kernel: LSM: initializing lsm=lockdown,capability,landlock,selinux,integrity Jan 16 23:57:19.219646 kernel: landlock: Up and running. Jan 16 23:57:19.219653 kernel: SELinux: Initializing. Jan 16 23:57:19.219660 kernel: Mount-cache hash table entries: 8192 (order: 4, 65536 bytes, linear) Jan 16 23:57:19.219667 kernel: Mountpoint-cache hash table entries: 8192 (order: 4, 65536 bytes, linear) Jan 16 23:57:19.219676 kernel: RCU Tasks: Setting shift to 1 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=2. Jan 16 23:57:19.219683 kernel: RCU Tasks Trace: Setting shift to 1 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=2. Jan 16 23:57:19.219690 kernel: Hyper-V: privilege flags low 0x2e7f, high 0x3a8030, hints 0x100000e, misc 0x31e1 Jan 16 23:57:19.219697 kernel: Hyper-V: Host Build 10.0.26100.1448-1-0 Jan 16 23:57:19.219704 kernel: Hyper-V: enabling crash_kexec_post_notifiers Jan 16 23:57:19.219711 kernel: rcu: Hierarchical SRCU implementation. Jan 16 23:57:19.219718 kernel: rcu: Max phase no-delay instances is 400. Jan 16 23:57:19.219725 kernel: Remapping and enabling EFI services. Jan 16 23:57:19.219740 kernel: smp: Bringing up secondary CPUs ... Jan 16 23:57:19.219747 kernel: Detected PIPT I-cache on CPU1 Jan 16 23:57:19.219754 kernel: GICv3: CPU1: found redistributor 1 region 1:0x00000000f000e000 Jan 16 23:57:19.219762 kernel: arch_timer: Enabling local workaround for ARM erratum 1418040 Jan 16 23:57:19.219771 kernel: CPU1: Booted secondary processor 0x0000000001 [0x413fd0c1] Jan 16 23:57:19.219778 kernel: smp: Brought up 1 node, 2 CPUs Jan 16 23:57:19.219786 kernel: SMP: Total of 2 processors activated. Jan 16 23:57:19.219794 kernel: CPU features: detected: 32-bit EL0 Support Jan 16 23:57:19.219802 kernel: CPU features: detected: Instruction cache invalidation not required for I/D coherence Jan 16 23:57:19.219811 kernel: CPU features: detected: Data cache clean to the PoU not required for I/D coherence Jan 16 23:57:19.219818 kernel: CPU features: detected: CRC32 instructions Jan 16 23:57:19.219826 kernel: CPU features: detected: RCpc load-acquire (LDAPR) Jan 16 23:57:19.219833 kernel: CPU features: detected: LSE atomic instructions Jan 16 23:57:19.219841 kernel: CPU features: detected: Privileged Access Never Jan 16 23:57:19.219848 kernel: CPU: All CPU(s) started at EL1 Jan 16 23:57:19.219856 kernel: alternatives: applying system-wide alternatives Jan 16 23:57:19.219863 kernel: devtmpfs: initialized Jan 16 23:57:19.219871 kernel: clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1911260446275000 ns Jan 16 23:57:19.219879 kernel: futex hash table entries: 512 (order: 3, 32768 bytes, linear) Jan 16 23:57:19.219887 kernel: pinctrl core: initialized pinctrl subsystem Jan 16 23:57:19.219895 kernel: SMBIOS 3.1.0 present. Jan 16 23:57:19.219902 kernel: DMI: Microsoft Corporation Virtual Machine/Virtual Machine, BIOS Hyper-V UEFI Release v4.1 09/28/2024 Jan 16 23:57:19.219910 kernel: NET: Registered PF_NETLINK/PF_ROUTE protocol family Jan 16 23:57:19.219917 kernel: DMA: preallocated 512 KiB GFP_KERNEL pool for atomic allocations Jan 16 23:57:19.219925 kernel: DMA: preallocated 512 KiB GFP_KERNEL|GFP_DMA pool for atomic allocations Jan 16 23:57:19.219932 kernel: DMA: preallocated 512 KiB GFP_KERNEL|GFP_DMA32 pool for atomic allocations Jan 16 23:57:19.219939 kernel: audit: initializing netlink subsys (disabled) Jan 16 23:57:19.219949 kernel: audit: type=2000 audit(0.047:1): state=initialized audit_enabled=0 res=1 Jan 16 23:57:19.219956 kernel: thermal_sys: Registered thermal governor 'step_wise' Jan 16 23:57:19.219963 kernel: cpuidle: using governor menu Jan 16 23:57:19.219971 kernel: hw-breakpoint: found 6 breakpoint and 4 watchpoint registers. Jan 16 23:57:19.219978 kernel: ASID allocator initialised with 32768 entries Jan 16 23:57:19.219985 kernel: acpiphp: ACPI Hot Plug PCI Controller Driver version: 0.5 Jan 16 23:57:19.219993 kernel: Serial: AMBA PL011 UART driver Jan 16 23:57:19.220000 kernel: Modules: 2G module region forced by RANDOMIZE_MODULE_REGION_FULL Jan 16 23:57:19.220007 kernel: Modules: 0 pages in range for non-PLT usage Jan 16 23:57:19.220016 kernel: Modules: 509008 pages in range for PLT usage Jan 16 23:57:19.220023 kernel: HugeTLB: registered 1.00 GiB page size, pre-allocated 0 pages Jan 16 23:57:19.220031 kernel: HugeTLB: 0 KiB vmemmap can be freed for a 1.00 GiB page Jan 16 23:57:19.220038 kernel: HugeTLB: registered 32.0 MiB page size, pre-allocated 0 pages Jan 16 23:57:19.220046 kernel: HugeTLB: 0 KiB vmemmap can be freed for a 32.0 MiB page Jan 16 23:57:19.220053 kernel: HugeTLB: registered 2.00 MiB page size, pre-allocated 0 pages Jan 16 23:57:19.220061 kernel: HugeTLB: 0 KiB vmemmap can be freed for a 2.00 MiB page Jan 16 23:57:19.220068 kernel: HugeTLB: registered 64.0 KiB page size, pre-allocated 0 pages Jan 16 23:57:19.220075 kernel: HugeTLB: 0 KiB vmemmap can be freed for a 64.0 KiB page Jan 16 23:57:19.220084 kernel: ACPI: Added _OSI(Module Device) Jan 16 23:57:19.220092 kernel: ACPI: Added _OSI(Processor Device) Jan 16 23:57:19.220099 kernel: ACPI: Added _OSI(Processor Aggregator Device) Jan 16 23:57:19.220107 kernel: ACPI: 1 ACPI AML tables successfully acquired and loaded Jan 16 23:57:19.220114 kernel: ACPI: Interpreter enabled Jan 16 23:57:19.220122 kernel: ACPI: Using GIC for interrupt routing Jan 16 23:57:19.220130 kernel: ARMH0011:00: ttyAMA0 at MMIO 0xeffec000 (irq = 12, base_baud = 0) is a SBSA Jan 16 23:57:19.220138 kernel: printk: console [ttyAMA0] enabled Jan 16 23:57:19.220146 kernel: printk: bootconsole [pl11] disabled Jan 16 23:57:19.220155 kernel: ARMH0011:01: ttyAMA1 at MMIO 0xeffeb000 (irq = 13, base_baud = 0) is a SBSA Jan 16 23:57:19.220162 kernel: iommu: Default domain type: Translated Jan 16 23:57:19.220170 kernel: iommu: DMA domain TLB invalidation policy: strict mode Jan 16 23:57:19.220178 kernel: efivars: Registered efivars operations Jan 16 23:57:19.220185 kernel: vgaarb: loaded Jan 16 23:57:19.220192 kernel: clocksource: Switched to clocksource arch_sys_counter Jan 16 23:57:19.220200 kernel: VFS: Disk quotas dquot_6.6.0 Jan 16 23:57:19.220207 kernel: VFS: Dquot-cache hash table entries: 512 (order 0, 4096 bytes) Jan 16 23:57:19.220214 kernel: pnp: PnP ACPI init Jan 16 23:57:19.220223 kernel: pnp: PnP ACPI: found 0 devices Jan 16 23:57:19.220230 kernel: NET: Registered PF_INET protocol family Jan 16 23:57:19.220238 kernel: IP idents hash table entries: 65536 (order: 7, 524288 bytes, linear) Jan 16 23:57:19.220246 kernel: tcp_listen_portaddr_hash hash table entries: 2048 (order: 3, 32768 bytes, linear) Jan 16 23:57:19.220253 kernel: Table-perturb hash table entries: 65536 (order: 6, 262144 bytes, linear) Jan 16 23:57:19.220261 kernel: TCP established hash table entries: 32768 (order: 6, 262144 bytes, linear) Jan 16 23:57:19.220268 kernel: TCP bind hash table entries: 32768 (order: 8, 1048576 bytes, linear) Jan 16 23:57:19.220276 kernel: TCP: Hash tables configured (established 32768 bind 32768) Jan 16 23:57:19.220283 kernel: UDP hash table entries: 2048 (order: 4, 65536 bytes, linear) Jan 16 23:57:19.220293 kernel: UDP-Lite hash table entries: 2048 (order: 4, 65536 bytes, linear) Jan 16 23:57:19.220300 kernel: NET: Registered PF_UNIX/PF_LOCAL protocol family Jan 16 23:57:19.220308 kernel: PCI: CLS 0 bytes, default 64 Jan 16 23:57:19.220315 kernel: kvm [1]: HYP mode not available Jan 16 23:57:19.220322 kernel: Initialise system trusted keyrings Jan 16 23:57:19.220330 kernel: workingset: timestamp_bits=39 max_order=20 bucket_order=0 Jan 16 23:57:19.220337 kernel: Key type asymmetric registered Jan 16 23:57:19.220344 kernel: Asymmetric key parser 'x509' registered Jan 16 23:57:19.220352 kernel: Block layer SCSI generic (bsg) driver version 0.4 loaded (major 250) Jan 16 23:57:19.220361 kernel: io scheduler mq-deadline registered Jan 16 23:57:19.220369 kernel: io scheduler kyber registered Jan 16 23:57:19.220376 kernel: io scheduler bfq registered Jan 16 23:57:19.220384 kernel: Serial: 8250/16550 driver, 4 ports, IRQ sharing enabled Jan 16 23:57:19.220391 kernel: thunder_xcv, ver 1.0 Jan 16 23:57:19.220398 kernel: thunder_bgx, ver 1.0 Jan 16 23:57:19.220406 kernel: nicpf, ver 1.0 Jan 16 23:57:19.220413 kernel: nicvf, ver 1.0 Jan 16 23:57:19.220570 kernel: rtc-efi rtc-efi.0: registered as rtc0 Jan 16 23:57:19.220647 kernel: rtc-efi rtc-efi.0: setting system clock to 2026-01-16T23:57:18 UTC (1768607838) Jan 16 23:57:19.220658 kernel: efifb: probing for efifb Jan 16 23:57:19.220666 kernel: efifb: framebuffer at 0x40000000, using 3072k, total 3072k Jan 16 23:57:19.220674 kernel: efifb: mode is 1024x768x32, linelength=4096, pages=1 Jan 16 23:57:19.220681 kernel: efifb: scrolling: redraw Jan 16 23:57:19.220689 kernel: efifb: Truecolor: size=8:8:8:8, shift=24:16:8:0 Jan 16 23:57:19.220696 kernel: Console: switching to colour frame buffer device 128x48 Jan 16 23:57:19.220704 kernel: fb0: EFI VGA frame buffer device Jan 16 23:57:19.220713 kernel: SMCCC: SOC_ID: ARCH_SOC_ID not implemented, skipping .... Jan 16 23:57:19.220721 kernel: hid: raw HID events driver (C) Jiri Kosina Jan 16 23:57:19.220729 kernel: hw perfevents: enabled with armv8_pmuv3_0 PMU driver, 6 counters available Jan 16 23:57:19.220736 kernel: watchdog: Delayed init of the lockup detector failed: -19 Jan 16 23:57:19.220744 kernel: watchdog: Hard watchdog permanently disabled Jan 16 23:57:19.220751 kernel: NET: Registered PF_INET6 protocol family Jan 16 23:57:19.220759 kernel: Segment Routing with IPv6 Jan 16 23:57:19.220766 kernel: In-situ OAM (IOAM) with IPv6 Jan 16 23:57:19.220774 kernel: NET: Registered PF_PACKET protocol family Jan 16 23:57:19.220783 kernel: Key type dns_resolver registered Jan 16 23:57:19.220790 kernel: registered taskstats version 1 Jan 16 23:57:19.220798 kernel: Loading compiled-in X.509 certificates Jan 16 23:57:19.220806 kernel: Loaded X.509 cert 'Kinvolk GmbH: Module signing key for 6.6.119-flatcar: 0aabad27df82424bfffc9b1a502a9ae84b35bad4' Jan 16 23:57:19.220813 kernel: Key type .fscrypt registered Jan 16 23:57:19.220820 kernel: Key type fscrypt-provisioning registered Jan 16 23:57:19.220828 kernel: ima: No TPM chip found, activating TPM-bypass! Jan 16 23:57:19.220836 kernel: ima: Allocated hash algorithm: sha1 Jan 16 23:57:19.220843 kernel: ima: No architecture policies found Jan 16 23:57:19.220853 kernel: alg: No test for fips(ansi_cprng) (fips_ansi_cprng) Jan 16 23:57:19.220860 kernel: clk: Disabling unused clocks Jan 16 23:57:19.220868 kernel: Freeing unused kernel memory: 39424K Jan 16 23:57:19.220875 kernel: Run /init as init process Jan 16 23:57:19.220882 kernel: with arguments: Jan 16 23:57:19.220889 kernel: /init Jan 16 23:57:19.220897 kernel: with environment: Jan 16 23:57:19.220904 kernel: HOME=/ Jan 16 23:57:19.220911 kernel: TERM=linux Jan 16 23:57:19.220920 systemd[1]: systemd 255 running in system mode (+PAM +AUDIT +SELINUX -APPARMOR +IMA +SMACK +SECCOMP +GCRYPT -GNUTLS +OPENSSL -ACL +BLKID +CURL +ELFUTILS -FIDO2 +IDN2 -IDN +IPTC +KMOD +LIBCRYPTSETUP +LIBFDISK +PCRE2 -PWQUALITY -P11KIT -QRENCODE +TPM2 +BZIP2 +LZ4 +XZ +ZLIB +ZSTD -BPF_FRAMEWORK -XKBCOMMON +UTMP -SYSVINIT default-hierarchy=unified) Jan 16 23:57:19.220932 systemd[1]: Detected virtualization microsoft. Jan 16 23:57:19.220940 systemd[1]: Detected architecture arm64. Jan 16 23:57:19.220948 systemd[1]: Running in initrd. Jan 16 23:57:19.220955 systemd[1]: No hostname configured, using default hostname. Jan 16 23:57:19.220963 systemd[1]: Hostname set to . Jan 16 23:57:19.220971 systemd[1]: Initializing machine ID from random generator. Jan 16 23:57:19.220981 systemd[1]: Queued start job for default target initrd.target. Jan 16 23:57:19.220989 systemd[1]: Started clevis-luks-askpass.path - Forward Password Requests to Clevis Directory Watch. Jan 16 23:57:19.220997 systemd[1]: Started systemd-ask-password-console.path - Dispatch Password Requests to Console Directory Watch. Jan 16 23:57:19.221006 systemd[1]: Expecting device dev-disk-by\x2dlabel-EFI\x2dSYSTEM.device - /dev/disk/by-label/EFI-SYSTEM... Jan 16 23:57:19.221014 systemd[1]: Expecting device dev-disk-by\x2dlabel-OEM.device - /dev/disk/by-label/OEM... Jan 16 23:57:19.221022 systemd[1]: Expecting device dev-disk-by\x2dlabel-ROOT.device - /dev/disk/by-label/ROOT... Jan 16 23:57:19.221031 systemd[1]: Expecting device dev-disk-by\x2dpartlabel-USR\x2dA.device - /dev/disk/by-partlabel/USR-A... Jan 16 23:57:19.221041 systemd[1]: Expecting device dev-disk-by\x2dpartuuid-7130c94a\x2d213a\x2d4e5a\x2d8e26\x2d6cce9662f132.device - /dev/disk/by-partuuid/7130c94a-213a-4e5a-8e26-6cce9662f132... Jan 16 23:57:19.221052 systemd[1]: Expecting device dev-mapper-usr.device - /dev/mapper/usr... Jan 16 23:57:19.221061 systemd[1]: Reached target cryptsetup-pre.target - Local Encrypted Volumes (Pre). Jan 16 23:57:19.221070 systemd[1]: Reached target cryptsetup.target - Local Encrypted Volumes. Jan 16 23:57:19.221078 systemd[1]: Reached target paths.target - Path Units. Jan 16 23:57:19.221086 systemd[1]: Reached target slices.target - Slice Units. Jan 16 23:57:19.221094 systemd[1]: Reached target swap.target - Swaps. Jan 16 23:57:19.221102 systemd[1]: Reached target timers.target - Timer Units. Jan 16 23:57:19.221111 systemd[1]: Listening on iscsid.socket - Open-iSCSI iscsid Socket. Jan 16 23:57:19.221122 systemd[1]: Listening on iscsiuio.socket - Open-iSCSI iscsiuio Socket. Jan 16 23:57:19.221131 systemd[1]: Listening on systemd-journald-dev-log.socket - Journal Socket (/dev/log). Jan 16 23:57:19.221139 systemd[1]: Listening on systemd-journald.socket - Journal Socket. Jan 16 23:57:19.221148 systemd[1]: Listening on systemd-networkd.socket - Network Service Netlink Socket. Jan 16 23:57:19.221156 systemd[1]: Listening on systemd-udevd-control.socket - udev Control Socket. Jan 16 23:57:19.221164 systemd[1]: Listening on systemd-udevd-kernel.socket - udev Kernel Socket. Jan 16 23:57:19.221173 systemd[1]: Reached target sockets.target - Socket Units. Jan 16 23:57:19.221181 systemd[1]: Starting ignition-setup-pre.service - Ignition env setup... Jan 16 23:57:19.221190 systemd[1]: Starting kmod-static-nodes.service - Create List of Static Device Nodes... Jan 16 23:57:19.221199 systemd[1]: Finished network-cleanup.service - Network Cleanup. Jan 16 23:57:19.221207 systemd[1]: Starting systemd-fsck-usr.service... Jan 16 23:57:19.221215 systemd[1]: Starting systemd-journald.service - Journal Service... Jan 16 23:57:19.221224 systemd[1]: Starting systemd-modules-load.service - Load Kernel Modules... Jan 16 23:57:19.221250 systemd-journald[217]: Collecting audit messages is disabled. Jan 16 23:57:19.221272 systemd[1]: Starting systemd-vconsole-setup.service - Virtual Console Setup... Jan 16 23:57:19.221281 systemd-journald[217]: Journal started Jan 16 23:57:19.221300 systemd-journald[217]: Runtime Journal (/run/log/journal/77ae9142220b4e22a04e16a4719b9612) is 8.0M, max 78.5M, 70.5M free. Jan 16 23:57:19.224882 systemd-modules-load[218]: Inserted module 'overlay' Jan 16 23:57:19.241477 systemd[1]: Started systemd-journald.service - Journal Service. Jan 16 23:57:19.243924 systemd[1]: Finished ignition-setup-pre.service - Ignition env setup. Jan 16 23:57:19.264597 kernel: bridge: filtering via arp/ip/ip6tables is no longer available by default. Update your scripts to load br_netfilter if you need this. Jan 16 23:57:19.264626 kernel: Bridge firewalling registered Jan 16 23:57:19.256732 systemd[1]: Finished kmod-static-nodes.service - Create List of Static Device Nodes. Jan 16 23:57:19.269851 systemd-modules-load[218]: Inserted module 'br_netfilter' Jan 16 23:57:19.278312 systemd[1]: Finished systemd-fsck-usr.service. Jan 16 23:57:19.282325 systemd[1]: Finished systemd-modules-load.service - Load Kernel Modules. Jan 16 23:57:19.291311 systemd[1]: Finished systemd-vconsole-setup.service - Virtual Console Setup. Jan 16 23:57:19.312594 systemd[1]: Starting dracut-cmdline-ask.service - dracut ask for additional cmdline parameters... Jan 16 23:57:19.324354 systemd[1]: Starting systemd-sysctl.service - Apply Kernel Variables... Jan 16 23:57:19.331582 systemd[1]: Starting systemd-tmpfiles-setup-dev-early.service - Create Static Device Nodes in /dev gracefully... Jan 16 23:57:19.357608 systemd[1]: Starting systemd-tmpfiles-setup.service - Create System Files and Directories... Jan 16 23:57:19.363328 systemd[1]: Finished dracut-cmdline-ask.service - dracut ask for additional cmdline parameters. Jan 16 23:57:19.374791 systemd[1]: Finished systemd-sysctl.service - Apply Kernel Variables. Jan 16 23:57:19.380011 systemd[1]: Finished systemd-tmpfiles-setup-dev-early.service - Create Static Device Nodes in /dev gracefully. Jan 16 23:57:19.393561 systemd[1]: Finished systemd-tmpfiles-setup.service - Create System Files and Directories. Jan 16 23:57:19.417749 systemd[1]: Starting dracut-cmdline.service - dracut cmdline hook... Jan 16 23:57:19.431221 systemd[1]: Starting systemd-resolved.service - Network Name Resolution... Jan 16 23:57:19.443828 dracut-cmdline[252]: dracut-dracut-053 Jan 16 23:57:19.443828 dracut-cmdline[252]: 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=d499dc3f7d5d4118d4e4300ad00f17ad72271d2a2f6bb9119457036ac5212c83 Jan 16 23:57:19.442757 systemd[1]: Starting systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev... Jan 16 23:57:19.495209 systemd-resolved[259]: Positive Trust Anchors: Jan 16 23:57:19.498913 systemd[1]: Finished systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev. Jan 16 23:57:19.498976 systemd-resolved[259]: . IN DS 20326 8 2 e06d44b80b8f1d39a95c0b0d7c65d08458e880409bbc683457104237c7f8ec8d Jan 16 23:57:19.499011 systemd-resolved[259]: Negative trust anchors: home.arpa 10.in-addr.arpa 16.172.in-addr.arpa 17.172.in-addr.arpa 18.172.in-addr.arpa 19.172.in-addr.arpa 20.172.in-addr.arpa 21.172.in-addr.arpa 22.172.in-addr.arpa 23.172.in-addr.arpa 24.172.in-addr.arpa 25.172.in-addr.arpa 26.172.in-addr.arpa 27.172.in-addr.arpa 28.172.in-addr.arpa 29.172.in-addr.arpa 30.172.in-addr.arpa 31.172.in-addr.arpa 170.0.0.192.in-addr.arpa 171.0.0.192.in-addr.arpa 168.192.in-addr.arpa d.f.ip6.arpa ipv4only.arpa resolver.arpa corp home internal intranet lan local private test Jan 16 23:57:19.501404 systemd-resolved[259]: Defaulting to hostname 'linux'. Jan 16 23:57:19.514523 systemd[1]: Started systemd-resolved.service - Network Name Resolution. Jan 16 23:57:19.527206 systemd[1]: Reached target nss-lookup.target - Host and Network Name Lookups. Jan 16 23:57:19.580428 kernel: SCSI subsystem initialized Jan 16 23:57:19.587425 kernel: Loading iSCSI transport class v2.0-870. Jan 16 23:57:19.597427 kernel: iscsi: registered transport (tcp) Jan 16 23:57:19.614030 kernel: iscsi: registered transport (qla4xxx) Jan 16 23:57:19.614095 kernel: QLogic iSCSI HBA Driver Jan 16 23:57:19.649242 systemd[1]: Finished dracut-cmdline.service - dracut cmdline hook. Jan 16 23:57:19.661901 systemd[1]: Starting dracut-pre-udev.service - dracut pre-udev hook... Jan 16 23:57:19.689438 kernel: device-mapper: core: CONFIG_IMA_DISABLE_HTABLE is disabled. Duplicate IMA measurements will not be recorded in the IMA log. Jan 16 23:57:19.689479 kernel: device-mapper: uevent: version 1.0.3 Jan 16 23:57:19.694590 kernel: device-mapper: ioctl: 4.48.0-ioctl (2023-03-01) initialised: dm-devel@redhat.com Jan 16 23:57:19.743435 kernel: raid6: neonx8 gen() 15817 MB/s Jan 16 23:57:19.761428 kernel: raid6: neonx4 gen() 15695 MB/s Jan 16 23:57:19.780427 kernel: raid6: neonx2 gen() 13218 MB/s Jan 16 23:57:19.799423 kernel: raid6: neonx1 gen() 10489 MB/s Jan 16 23:57:19.819423 kernel: raid6: int64x8 gen() 6975 MB/s Jan 16 23:57:19.838423 kernel: raid6: int64x4 gen() 7353 MB/s Jan 16 23:57:19.857426 kernel: raid6: int64x2 gen() 6147 MB/s Jan 16 23:57:19.880412 kernel: raid6: int64x1 gen() 5066 MB/s Jan 16 23:57:19.880444 kernel: raid6: using algorithm neonx8 gen() 15817 MB/s Jan 16 23:57:19.903430 kernel: raid6: .... xor() 12015 MB/s, rmw enabled Jan 16 23:57:19.903440 kernel: raid6: using neon recovery algorithm Jan 16 23:57:19.913527 kernel: xor: measuring software checksum speed Jan 16 23:57:19.913540 kernel: 8regs : 19826 MB/sec Jan 16 23:57:19.916499 kernel: 32regs : 19660 MB/sec Jan 16 23:57:19.919380 kernel: arm64_neon : 27052 MB/sec Jan 16 23:57:19.922785 kernel: xor: using function: arm64_neon (27052 MB/sec) Jan 16 23:57:19.972449 kernel: Btrfs loaded, zoned=no, fsverity=no Jan 16 23:57:19.982452 systemd[1]: Finished dracut-pre-udev.service - dracut pre-udev hook. Jan 16 23:57:20.000594 systemd[1]: Starting systemd-udevd.service - Rule-based Manager for Device Events and Files... Jan 16 23:57:20.020495 systemd-udevd[438]: Using default interface naming scheme 'v255'. Jan 16 23:57:20.025030 systemd[1]: Started systemd-udevd.service - Rule-based Manager for Device Events and Files. Jan 16 23:57:20.045586 systemd[1]: Starting dracut-pre-trigger.service - dracut pre-trigger hook... Jan 16 23:57:20.061550 dracut-pre-trigger[448]: rd.md=0: removing MD RAID activation Jan 16 23:57:20.090195 systemd[1]: Finished dracut-pre-trigger.service - dracut pre-trigger hook. Jan 16 23:57:20.110705 systemd[1]: Starting systemd-udev-trigger.service - Coldplug All udev Devices... Jan 16 23:57:20.152590 systemd[1]: Finished systemd-udev-trigger.service - Coldplug All udev Devices. Jan 16 23:57:20.171583 systemd[1]: Starting dracut-initqueue.service - dracut initqueue hook... Jan 16 23:57:20.192613 systemd[1]: Finished dracut-initqueue.service - dracut initqueue hook. Jan 16 23:57:20.201519 systemd[1]: Reached target remote-fs-pre.target - Preparation for Remote File Systems. Jan 16 23:57:20.220600 systemd[1]: Reached target remote-cryptsetup.target - Remote Encrypted Volumes. Jan 16 23:57:20.232797 systemd[1]: Reached target remote-fs.target - Remote File Systems. Jan 16 23:57:20.255167 systemd[1]: Starting dracut-pre-mount.service - dracut pre-mount hook... Jan 16 23:57:20.269725 kernel: hv_vmbus: Vmbus version:5.3 Jan 16 23:57:20.272819 systemd[1]: dracut-cmdline-ask.service: Deactivated successfully. Jan 16 23:57:20.272974 systemd[1]: Stopped dracut-cmdline-ask.service - dracut ask for additional cmdline parameters. Jan 16 23:57:20.328369 kernel: pps_core: LinuxPPS API ver. 1 registered Jan 16 23:57:20.328397 kernel: hv_vmbus: registering driver hid_hyperv Jan 16 23:57:20.328409 kernel: hv_vmbus: registering driver hyperv_keyboard Jan 16 23:57:20.328425 kernel: pps_core: Software ver. 5.3.6 - Copyright 2005-2007 Rodolfo Giometti Jan 16 23:57:20.328438 kernel: input: AT Translated Set 2 keyboard as /devices/LNXSYSTM:00/LNXSYBUS:00/ACPI0004:00/MSFT1000:00/d34b2567-b9b6-42b9-8778-0a4ec0b955bf/serio0/input/input0 Jan 16 23:57:20.294536 systemd[1]: Stopping dracut-cmdline-ask.service - dracut ask for additional cmdline parameters... Jan 16 23:57:20.373570 kernel: input: Microsoft Vmbus HID-compliant Mouse as /devices/0006:045E:0621.0001/input/input1 Jan 16 23:57:20.373595 kernel: hv_vmbus: registering driver hv_storvsc Jan 16 23:57:20.373605 kernel: hid-hyperv 0006:045E:0621.0001: input: VIRTUAL HID v0.01 Mouse [Microsoft Vmbus HID-compliant Mouse] on Jan 16 23:57:20.373752 kernel: scsi host0: storvsc_host_t Jan 16 23:57:20.378898 kernel: scsi 0:0:0:0: Direct-Access Msft Virtual Disk 1.0 PQ: 0 ANSI: 5 Jan 16 23:57:20.379000 kernel: scsi 0:0:0:2: CD-ROM Msft Virtual DVD-ROM 1.0 PQ: 0 ANSI: 5 Jan 16 23:57:20.379103 kernel: hv_vmbus: registering driver hv_netvsc Jan 16 23:57:20.379114 kernel: PTP clock support registered Jan 16 23:57:20.310678 systemd[1]: systemd-vconsole-setup.service: Deactivated successfully. Jan 16 23:57:20.388495 kernel: scsi host1: storvsc_host_t Jan 16 23:57:20.310913 systemd[1]: Stopped systemd-vconsole-setup.service - Virtual Console Setup. Jan 16 23:57:20.342160 systemd[1]: Stopping systemd-vconsole-setup.service - Virtual Console Setup... Jan 16 23:57:20.394840 systemd[1]: Starting systemd-vconsole-setup.service - Virtual Console Setup... Jan 16 23:57:20.553356 kernel: hv_utils: Registering HyperV Utility Driver Jan 16 23:57:20.553379 kernel: hv_vmbus: registering driver hv_utils Jan 16 23:57:20.553389 kernel: hv_utils: Heartbeat IC version 3.0 Jan 16 23:57:20.553407 kernel: hv_utils: Shutdown IC version 3.2 Jan 16 23:57:20.553418 kernel: hv_utils: TimeSync IC version 4.0 Jan 16 23:57:20.553427 kernel: sr 0:0:0:2: [sr0] scsi-1 drive Jan 16 23:57:20.406185 systemd[1]: Finished dracut-pre-mount.service - dracut pre-mount hook. Jan 16 23:57:20.436976 systemd[1]: Finished systemd-vconsole-setup.service - Virtual Console Setup. Jan 16 23:57:20.579659 kernel: hv_netvsc 7ced8d89-6cc4-7ced-8d89-6cc47ced8d89 eth0: VF slot 1 added Jan 16 23:57:20.579841 kernel: cdrom: Uniform CD-ROM driver Revision: 3.20 Jan 16 23:57:20.548830 systemd-resolved[259]: Clock change detected. Flushing caches. Jan 16 23:57:20.621987 kernel: hv_vmbus: registering driver hv_pci Jan 16 23:57:20.622022 kernel: sd 0:0:0:0: [sda] 63737856 512-byte logical blocks: (32.6 GB/30.4 GiB) Jan 16 23:57:20.622188 kernel: sd 0:0:0:0: [sda] 4096-byte physical blocks Jan 16 23:57:20.622278 kernel: sd 0:0:0:0: [sda] Write Protect is off Jan 16 23:57:20.622364 kernel: hv_pci 043aaf96-1664-4089-b7f5-7e7d9c66608f: PCI VMBus probing: Using version 0x10004 Jan 16 23:57:20.622466 kernel: sd 0:0:0:0: [sda] Mode Sense: 0f 00 10 00 Jan 16 23:57:20.622555 kernel: sd 0:0:0:0: [sda] Write cache: disabled, read cache: enabled, supports DPO and FUA Jan 16 23:57:20.575027 systemd[1]: systemd-vconsole-setup.service: Deactivated successfully. Jan 16 23:57:20.575329 systemd[1]: Stopped systemd-vconsole-setup.service - Virtual Console Setup. Jan 16 23:57:20.637632 kernel: sr 0:0:0:2: Attached scsi CD-ROM sr0 Jan 16 23:57:20.637815 kernel: sda: sda1 sda2 sda3 sda4 sda6 sda7 sda9 Jan 16 23:57:20.637828 kernel: hv_pci 043aaf96-1664-4089-b7f5-7e7d9c66608f: PCI host bridge to bus 1664:00 Jan 16 23:57:20.595934 systemd[1]: Stopping systemd-vconsole-setup.service - Virtual Console Setup... Jan 16 23:57:20.664071 kernel: sd 0:0:0:0: [sda] Attached SCSI disk Jan 16 23:57:20.664254 kernel: pci_bus 1664:00: root bus resource [mem 0xfc0000000-0xfc00fffff window] Jan 16 23:57:20.664367 kernel: pci_bus 1664:00: No busn resource found for root bus, will use [bus 00-ff] Jan 16 23:57:20.633890 systemd[1]: Starting systemd-vconsole-setup.service - Virtual Console Setup... Jan 16 23:57:20.678107 kernel: pci 1664:00:02.0: [15b3:1018] type 00 class 0x020000 Jan 16 23:57:20.681198 systemd[1]: Finished systemd-vconsole-setup.service - Virtual Console Setup. Jan 16 23:57:20.696920 kernel: pci 1664:00:02.0: reg 0x10: [mem 0xfc0000000-0xfc00fffff 64bit pref] Jan 16 23:57:20.696978 kernel: pci 1664:00:02.0: enabling Extended Tags Jan 16 23:57:20.713953 kernel: hv_storvsc f8b3781a-1e82-4818-a1c3-63d806ec15bb: tag#161 cmd 0x85 status: scsi 0x2 srb 0x6 hv 0xc0000001 Jan 16 23:57:20.714144 kernel: pci 1664:00:02.0: 0.000 Gb/s available PCIe bandwidth, limited by Unknown x0 link at 1664:00:02.0 (capable of 126.016 Gb/s with 8.0 GT/s PCIe x16 link) Jan 16 23:57:20.716123 systemd[1]: Starting dracut-cmdline-ask.service - dracut ask for additional cmdline parameters... Jan 16 23:57:20.741359 kernel: pci_bus 1664:00: busn_res: [bus 00-ff] end is updated to 00 Jan 16 23:57:20.742146 kernel: pci 1664:00:02.0: BAR 0: assigned [mem 0xfc0000000-0xfc00fffff 64bit pref] Jan 16 23:57:20.755807 systemd[1]: Finished dracut-cmdline-ask.service - dracut ask for additional cmdline parameters. Jan 16 23:57:20.778912 kernel: hv_storvsc f8b3781a-1e82-4818-a1c3-63d806ec15bb: tag#131 cmd 0x85 status: scsi 0x2 srb 0x6 hv 0xc0000001 Jan 16 23:57:20.804860 kernel: mlx5_core 1664:00:02.0: enabling device (0000 -> 0002) Jan 16 23:57:20.809808 kernel: mlx5_core 1664:00:02.0: firmware version: 16.30.5026 Jan 16 23:57:21.006140 kernel: hv_netvsc 7ced8d89-6cc4-7ced-8d89-6cc47ced8d89 eth0: VF registering: eth1 Jan 16 23:57:21.006344 kernel: mlx5_core 1664:00:02.0 eth1: joined to eth0 Jan 16 23:57:21.018814 kernel: mlx5_core 1664:00:02.0: MLX5E: StrdRq(1) RqSz(8) StrdSz(2048) RxCqeCmprss(0 basic) Jan 16 23:57:21.029810 kernel: mlx5_core 1664:00:02.0 enP5732s1: renamed from eth1 Jan 16 23:57:21.401348 systemd[1]: Found device dev-disk-by\x2dlabel-EFI\x2dSYSTEM.device - Virtual_Disk EFI-SYSTEM. Jan 16 23:57:21.430225 kernel: BTRFS: device label OEM devid 1 transid 10 /dev/sda6 scanned by (udev-worker) (486) Jan 16 23:57:21.438355 systemd[1]: Found device dev-disk-by\x2dlabel-ROOT.device - Virtual_Disk ROOT. Jan 16 23:57:21.454780 systemd[1]: Found device dev-disk-by\x2dlabel-OEM.device - Virtual_Disk OEM. Jan 16 23:57:21.474818 kernel: BTRFS: device fsid 257557f7-4bf9-4b29-86df-93ad67770d31 devid 1 transid 37 /dev/sda3 scanned by (udev-worker) (484) Jan 16 23:57:21.488758 systemd[1]: Found device dev-disk-by\x2dpartlabel-USR\x2dA.device - Virtual_Disk USR-A. Jan 16 23:57:21.500126 systemd[1]: Found device dev-disk-by\x2dpartuuid-7130c94a\x2d213a\x2d4e5a\x2d8e26\x2d6cce9662f132.device - Virtual_Disk USR-A. Jan 16 23:57:21.520050 systemd[1]: Starting disk-uuid.service - Generate new UUID for disk GPT if necessary... Jan 16 23:57:21.542810 kernel: sda: sda1 sda2 sda3 sda4 sda6 sda7 sda9 Jan 16 23:57:21.551855 kernel: sda: sda1 sda2 sda3 sda4 sda6 sda7 sda9 Jan 16 23:57:21.559812 kernel: sda: sda1 sda2 sda3 sda4 sda6 sda7 sda9 Jan 16 23:57:22.568371 disk-uuid[604]: The operation has completed successfully. Jan 16 23:57:22.573619 kernel: sda: sda1 sda2 sda3 sda4 sda6 sda7 sda9 Jan 16 23:57:22.635817 systemd[1]: disk-uuid.service: Deactivated successfully. Jan 16 23:57:22.637955 systemd[1]: Finished disk-uuid.service - Generate new UUID for disk GPT if necessary. Jan 16 23:57:22.665946 systemd[1]: Starting verity-setup.service - Verity Setup for /dev/mapper/usr... Jan 16 23:57:22.676189 sh[717]: Success Jan 16 23:57:22.701974 kernel: device-mapper: verity: sha256 using implementation "sha256-ce" Jan 16 23:57:22.957255 systemd[1]: Found device dev-mapper-usr.device - /dev/mapper/usr. Jan 16 23:57:22.965926 systemd[1]: Mounting sysusr-usr.mount - /sysusr/usr... Jan 16 23:57:22.971817 systemd[1]: Finished verity-setup.service - Verity Setup for /dev/mapper/usr. Jan 16 23:57:23.003527 kernel: BTRFS info (device dm-0): first mount of filesystem 257557f7-4bf9-4b29-86df-93ad67770d31 Jan 16 23:57:23.003582 kernel: BTRFS info (device dm-0): using crc32c (crc32c-generic) checksum algorithm Jan 16 23:57:23.009164 kernel: BTRFS warning (device dm-0): 'nologreplay' is deprecated, use 'rescue=nologreplay' instead Jan 16 23:57:23.013465 kernel: BTRFS info (device dm-0): disabling log replay at mount time Jan 16 23:57:23.016938 kernel: BTRFS info (device dm-0): using free space tree Jan 16 23:57:23.272835 systemd[1]: Mounted sysusr-usr.mount - /sysusr/usr. Jan 16 23:57:23.277417 systemd[1]: afterburn-network-kargs.service - Afterburn Initrd Setup Network Kernel Arguments was skipped because no trigger condition checks were met. Jan 16 23:57:23.290038 systemd[1]: Starting ignition-setup.service - Ignition (setup)... Jan 16 23:57:23.299871 systemd[1]: Starting parse-ip-for-networkd.service - Write systemd-networkd units from cmdline... Jan 16 23:57:23.325156 kernel: BTRFS info (device sda6): first mount of filesystem 629d412e-8b84-495a-b9b7-c361e81b0700 Jan 16 23:57:23.325222 kernel: BTRFS info (device sda6): using crc32c (crc32c-generic) checksum algorithm Jan 16 23:57:23.329219 kernel: BTRFS info (device sda6): using free space tree Jan 16 23:57:23.367744 kernel: BTRFS info (device sda6): auto enabling async discard Jan 16 23:57:23.375525 systemd[1]: mnt-oem.mount: Deactivated successfully. Jan 16 23:57:23.386661 kernel: BTRFS info (device sda6): last unmount of filesystem 629d412e-8b84-495a-b9b7-c361e81b0700 Jan 16 23:57:23.393150 systemd[1]: Finished ignition-setup.service - Ignition (setup). Jan 16 23:57:23.406994 systemd[1]: Starting ignition-fetch-offline.service - Ignition (fetch-offline)... Jan 16 23:57:23.437853 systemd[1]: Finished parse-ip-for-networkd.service - Write systemd-networkd units from cmdline. Jan 16 23:57:23.453956 systemd[1]: Starting systemd-networkd.service - Network Configuration... Jan 16 23:57:23.486513 systemd-networkd[901]: lo: Link UP Jan 16 23:57:23.486520 systemd-networkd[901]: lo: Gained carrier Jan 16 23:57:23.488118 systemd-networkd[901]: Enumeration completed Jan 16 23:57:23.488291 systemd[1]: Started systemd-networkd.service - Network Configuration. Jan 16 23:57:23.495513 systemd-networkd[901]: eth0: found matching network '/usr/lib/systemd/network/zz-default.network', based on potentially unpredictable interface name. Jan 16 23:57:23.495517 systemd-networkd[901]: eth0: Configuring with /usr/lib/systemd/network/zz-default.network. Jan 16 23:57:23.495898 systemd[1]: Reached target network.target - Network. Jan 16 23:57:23.576811 kernel: mlx5_core 1664:00:02.0 enP5732s1: Link up Jan 16 23:57:23.614807 kernel: hv_netvsc 7ced8d89-6cc4-7ced-8d89-6cc47ced8d89 eth0: Data path switched to VF: enP5732s1 Jan 16 23:57:23.615897 systemd-networkd[901]: enP5732s1: Link UP Jan 16 23:57:23.615985 systemd-networkd[901]: eth0: Link UP Jan 16 23:57:23.616080 systemd-networkd[901]: eth0: Gained carrier Jan 16 23:57:23.616089 systemd-networkd[901]: eth0: found matching network '/usr/lib/systemd/network/zz-default.network', based on potentially unpredictable interface name. Jan 16 23:57:23.635321 systemd-networkd[901]: enP5732s1: Gained carrier Jan 16 23:57:23.646836 systemd-networkd[901]: eth0: DHCPv4 address 10.200.20.16/24, gateway 10.200.20.1 acquired from 168.63.129.16 Jan 16 23:57:24.308159 ignition[873]: Ignition 2.19.0 Jan 16 23:57:24.308169 ignition[873]: Stage: fetch-offline Jan 16 23:57:24.311601 systemd[1]: Finished ignition-fetch-offline.service - Ignition (fetch-offline). Jan 16 23:57:24.308206 ignition[873]: no configs at "/usr/lib/ignition/base.d" Jan 16 23:57:24.327074 systemd[1]: Starting ignition-fetch.service - Ignition (fetch)... Jan 16 23:57:24.308214 ignition[873]: no config dir at "/usr/lib/ignition/base.platform.d/azure" Jan 16 23:57:24.308309 ignition[873]: parsed url from cmdline: "" Jan 16 23:57:24.308311 ignition[873]: no config URL provided Jan 16 23:57:24.308316 ignition[873]: reading system config file "/usr/lib/ignition/user.ign" Jan 16 23:57:24.308322 ignition[873]: no config at "/usr/lib/ignition/user.ign" Jan 16 23:57:24.308326 ignition[873]: failed to fetch config: resource requires networking Jan 16 23:57:24.308501 ignition[873]: Ignition finished successfully Jan 16 23:57:24.351631 ignition[925]: Ignition 2.19.0 Jan 16 23:57:24.351638 ignition[925]: Stage: fetch Jan 16 23:57:24.351838 ignition[925]: no configs at "/usr/lib/ignition/base.d" Jan 16 23:57:24.351848 ignition[925]: no config dir at "/usr/lib/ignition/base.platform.d/azure" Jan 16 23:57:24.351939 ignition[925]: parsed url from cmdline: "" Jan 16 23:57:24.351942 ignition[925]: no config URL provided Jan 16 23:57:24.351947 ignition[925]: reading system config file "/usr/lib/ignition/user.ign" Jan 16 23:57:24.351954 ignition[925]: no config at "/usr/lib/ignition/user.ign" Jan 16 23:57:24.351976 ignition[925]: GET http://169.254.169.254/metadata/instance/compute/userData?api-version=2021-01-01&format=text: attempt #1 Jan 16 23:57:24.485851 ignition[925]: GET result: OK Jan 16 23:57:24.485934 ignition[925]: config has been read from IMDS userdata Jan 16 23:57:24.491868 unknown[925]: fetched base config from "system" Jan 16 23:57:24.485946 ignition[925]: parsing config with SHA512: 8526f797200ab66f7032057f3825f750a03fb41af503dfdfec86db969eb24d53dae7002cb08c011c1f0ac1f58d18e91cd9b9b05201827c7ae5f740237a9e9ad2 Jan 16 23:57:24.491877 unknown[925]: fetched base config from "system" Jan 16 23:57:24.492082 ignition[925]: fetch: fetch complete Jan 16 23:57:24.491883 unknown[925]: fetched user config from "azure" Jan 16 23:57:24.492087 ignition[925]: fetch: fetch passed Jan 16 23:57:24.495995 systemd[1]: Finished ignition-fetch.service - Ignition (fetch). Jan 16 23:57:24.492132 ignition[925]: Ignition finished successfully Jan 16 23:57:24.517962 systemd[1]: Starting ignition-kargs.service - Ignition (kargs)... Jan 16 23:57:24.537929 ignition[932]: Ignition 2.19.0 Jan 16 23:57:24.537937 ignition[932]: Stage: kargs Jan 16 23:57:24.541812 systemd[1]: Finished ignition-kargs.service - Ignition (kargs). Jan 16 23:57:24.538106 ignition[932]: no configs at "/usr/lib/ignition/base.d" Jan 16 23:57:24.538115 ignition[932]: no config dir at "/usr/lib/ignition/base.platform.d/azure" Jan 16 23:57:24.538758 ignition[932]: kargs: kargs passed Jan 16 23:57:24.538837 ignition[932]: Ignition finished successfully Jan 16 23:57:24.564929 systemd[1]: Starting ignition-disks.service - Ignition (disks)... Jan 16 23:57:24.580214 ignition[938]: Ignition 2.19.0 Jan 16 23:57:24.580223 ignition[938]: Stage: disks Jan 16 23:57:24.580384 ignition[938]: no configs at "/usr/lib/ignition/base.d" Jan 16 23:57:24.580392 ignition[938]: no config dir at "/usr/lib/ignition/base.platform.d/azure" Jan 16 23:57:24.581040 ignition[938]: disks: createFilesystems: op(1): [started] waiting for devices [/dev/disk/by-partlabel/ROOT] Jan 16 23:57:24.590149 ignition[938]: disks: createFilesystems: op(1): [finished] waiting for devices [/dev/disk/by-partlabel/ROOT] Jan 16 23:57:24.590233 ignition[938]: disks: createFilesystems: created device alias for "/dev/disk/by-partlabel/ROOT": "/run/ignition/dev_aliases/dev/disk/by-partlabel/ROOT" -> "/dev/sda9" Jan 16 23:57:24.590286 ignition[938]: disks: createFilesystems: op(2): [started] determining filesystem type of "/dev/disk/by-partlabel/ROOT" Jan 16 23:57:24.639835 ignition[938]: disks: createFilesystems: op(2): [finished] determining filesystem type of "/dev/disk/by-partlabel/ROOT" Jan 16 23:57:24.639849 ignition[938]: disks: createFilesystems: found ext4 filesystem at "/dev/disk/by-partlabel/ROOT" with uuid "b70ce012-b356-4603-a688-ee0b3b7de551" and label "ROOT" Jan 16 23:57:24.639886 ignition[938]: disks: createFilesystems: op(3): [started] wiping filesystem signatures from "/run/ignition/dev_aliases/dev/disk/by-partlabel/ROOT" Jan 16 23:57:24.639893 ignition[938]: disks: createFilesystems: op(3): executing: "wipefs" "-a" "/run/ignition/dev_aliases/dev/disk/by-partlabel/ROOT" Jan 16 23:57:24.733125 ignition[938]: disks: createFilesystems: op(3): [finished] wiping filesystem signatures from "/run/ignition/dev_aliases/dev/disk/by-partlabel/ROOT" Jan 16 23:57:24.733160 ignition[938]: disks: createFilesystems: op(4): [started] creating "btrfs" filesystem on "/run/ignition/dev_aliases/dev/disk/by-partlabel/ROOT" Jan 16 23:57:24.733170 ignition[938]: disks: createFilesystems: op(4): executing: "mkfs.btrfs" "--label=ROOT" "--uuid=9aa5237a-ab6b-458b-a7e8-f25e2baef1a3" "--force" "/run/ignition/dev_aliases/dev/disk/by-partlabel/ROOT" Jan 16 23:57:25.046210 ignition[938]: disks: createFilesystems: op(4): [finished] creating "btrfs" filesystem on "/run/ignition/dev_aliases/dev/disk/by-partlabel/ROOT" Jan 16 23:57:25.055613 kernel: BTRFS: device label ROOT devid 1 transid 6 /run/ignition/dev_aliases/dev/disk/by-partlabel/ROOT scanned by mkfs.btrfs (945) Jan 16 23:57:25.046279 ignition[938]: disks: createFilesystems: op(5): [started] waiting for triggered uevent Jan 16 23:57:25.046286 ignition[938]: disks: createFilesystems: op(5): executing: "udevadm" "trigger" "--settle" "/dev/sda9" Jan 16 23:57:25.532965 systemd-networkd[901]: eth0: Gained IPv6LL Jan 16 23:57:26.517679 ignition[938]: disks: createFilesystems: op(5): [finished] waiting for triggered uevent Jan 16 23:57:26.517699 ignition[938]: disks: disks passed Jan 16 23:57:26.519890 systemd[1]: Finished ignition-disks.service - Ignition (disks). Jan 16 23:57:26.517768 ignition[938]: Ignition finished successfully Jan 16 23:57:26.530872 systemd[1]: Reached target initrd-root-device.target - Initrd Root Device. Jan 16 23:57:26.537837 systemd[1]: Reached target local-fs-pre.target - Preparation for Local File Systems. Jan 16 23:57:26.547699 systemd[1]: Reached target local-fs.target - Local File Systems. Jan 16 23:57:26.555387 systemd[1]: Reached target sysinit.target - System Initialization. Jan 16 23:57:26.564596 systemd[1]: Reached target basic.target - Basic System. Jan 16 23:57:26.591069 systemd[1]: Starting systemd-fsck-root.service - File System Check on /dev/disk/by-label/ROOT... Jan 16 23:57:26.610730 systemd[1]: Finished systemd-fsck-root.service - File System Check on /dev/disk/by-label/ROOT. Jan 16 23:57:26.624963 systemd[1]: Mounting sysroot.mount - /sysroot... Jan 16 23:57:26.649202 kernel: BTRFS info (device sda9): first mount of filesystem 9aa5237a-ab6b-458b-a7e8-f25e2baef1a3 Jan 16 23:57:26.649252 kernel: BTRFS info (device sda9): using crc32c (crc32c-generic) checksum algorithm Jan 16 23:57:26.652722 kernel: BTRFS info (device sda9): using free space tree Jan 16 23:57:26.662624 kernel: BTRFS info (device sda9): auto enabling async discard Jan 16 23:57:26.662668 kernel: BTRFS info (device sda9): checking UUID tree Jan 16 23:57:26.664553 systemd[1]: Mounted sysroot.mount - /sysroot. Jan 16 23:57:26.668269 systemd[1]: Reached target initrd-root-fs.target - Initrd Root File System. Jan 16 23:57:26.687873 systemd[1]: Mounting sysroot-oem.mount - /sysroot/oem... Jan 16 23:57:26.693950 systemd[1]: Mounting sysroot-usr.mount - /sysroot/usr... Jan 16 23:57:26.705549 systemd[1]: Starting flatcar-metadata-hostname.service - Flatcar Metadata Hostname Agent... Jan 16 23:57:26.714023 systemd[1]: ignition-remount-sysroot.service - Remount /sysroot read-write for Ignition was skipped because of an unmet condition check (ConditionPathIsReadWrite=!/sysroot). Jan 16 23:57:26.714064 systemd[1]: Reached target ignition-diskful.target - Ignition Boot Disk Setup. Jan 16 23:57:26.760965 kernel: BTRFS: device label OEM devid 1 transid 11 /dev/sda6 scanned by mount (982) Jan 16 23:57:26.760998 kernel: BTRFS info (device sda6): first mount of filesystem 629d412e-8b84-495a-b9b7-c361e81b0700 Jan 16 23:57:26.761009 kernel: BTRFS info (device sda6): using crc32c (crc32c-generic) checksum algorithm Jan 16 23:57:26.761019 kernel: BTRFS info (device sda6): using free space tree Jan 16 23:57:26.761029 kernel: BTRFS info (device sda6): auto enabling async discard Jan 16 23:57:26.752425 systemd[1]: Mounted sysroot-usr.mount - /sysroot/usr. Jan 16 23:57:26.773852 systemd[1]: Mounted sysroot-oem.mount - /sysroot/oem. Jan 16 23:57:26.787924 systemd[1]: Starting initrd-setup-root.service - Root filesystem setup... Jan 16 23:57:26.914428 initrd-setup-root[1007]: cut: /sysroot/etc/passwd: No such file or directory Jan 16 23:57:26.953656 initrd-setup-root[1014]: cut: /sysroot/etc/group: No such file or directory Jan 16 23:57:26.979707 initrd-setup-root[1021]: cut: /sysroot/etc/shadow: No such file or directory Jan 16 23:57:26.988050 initrd-setup-root[1028]: cut: /sysroot/etc/gshadow: No such file or directory Jan 16 23:57:27.136152 coreos-metadata[984]: Jan 16 23:57:27.136 INFO Fetching http://168.63.129.16/?comp=versions: Attempt #1 Jan 16 23:57:27.143083 coreos-metadata[984]: Jan 16 23:57:27.142 INFO Fetch successful Jan 16 23:57:27.143083 coreos-metadata[984]: Jan 16 23:57:27.143 INFO Fetching http://169.254.169.254/metadata/instance/compute/name?api-version=2017-08-01&format=text: Attempt #1 Jan 16 23:57:27.156882 coreos-metadata[984]: Jan 16 23:57:27.156 INFO Fetch successful Jan 16 23:57:27.161662 coreos-metadata[984]: Jan 16 23:57:27.156 INFO wrote hostname ci-4081.3.6-n-189a678227 to /sysroot/etc/hostname Jan 16 23:57:27.162514 systemd[1]: Finished flatcar-metadata-hostname.service - Flatcar Metadata Hostname Agent. Jan 16 23:57:27.529648 systemd[1]: Finished initrd-setup-root.service - Root filesystem setup. Jan 16 23:57:27.547049 systemd[1]: Starting ignition-mount.service - Ignition (mount)... Jan 16 23:57:27.553442 systemd[1]: Starting sysroot-boot.service - /sysroot/boot... Jan 16 23:57:27.569517 systemd[1]: sysroot-oem.mount: Deactivated successfully. Jan 16 23:57:27.579817 kernel: BTRFS info (device sda6): last unmount of filesystem 629d412e-8b84-495a-b9b7-c361e81b0700 Jan 16 23:57:27.605285 ignition[1100]: INFO : Ignition 2.19.0 Jan 16 23:57:27.608923 ignition[1100]: INFO : Stage: mount Jan 16 23:57:27.608923 ignition[1100]: INFO : no configs at "/usr/lib/ignition/base.d" Jan 16 23:57:27.608923 ignition[1100]: INFO : no config dir at "/usr/lib/ignition/base.platform.d/azure" Jan 16 23:57:27.634080 ignition[1100]: INFO : mount: op(1): [started] mounting "/dev/disk/by-partlabel/ROOT" at "/sysroot/tmp/_translate-filesystem-0-ign1" with type "btrfs" and options "" Jan 16 23:57:27.634080 ignition[1100]: DEBUG : mount: op(1): executing: "mount" "-o" "" "-t" "btrfs" "/dev/disk/by-partlabel/ROOT" "/sysroot/tmp/_translate-filesystem-0-ign1" Jan 16 23:57:27.634080 ignition[1100]: INFO : mount: op(1): [finished] mounting "/dev/disk/by-partlabel/ROOT" at "/sysroot/tmp/_translate-filesystem-0-ign1" with type "btrfs" and options "" Jan 16 23:57:27.634080 ignition[1100]: INFO : mount: mount passed Jan 16 23:57:27.634080 ignition[1100]: INFO : Ignition finished successfully Jan 16 23:57:27.610146 systemd[1]: Finished sysroot-boot.service - /sysroot/boot. Jan 16 23:57:27.619390 systemd[1]: Finished ignition-mount.service - Ignition (mount). Jan 16 23:57:27.654024 systemd[1]: Starting ignition-files.service - Ignition (files)... Jan 16 23:57:27.675993 systemd[1]: Mounting sysroot-oem.mount - /sysroot/oem... Jan 16 23:57:27.709806 kernel: BTRFS: device label OEM devid 1 transid 12 /dev/sda6 scanned by mount (1112) Jan 16 23:57:27.720623 kernel: BTRFS info (device sda6): first mount of filesystem 629d412e-8b84-495a-b9b7-c361e81b0700 Jan 16 23:57:27.720681 kernel: BTRFS info (device sda6): using crc32c (crc32c-generic) checksum algorithm Jan 16 23:57:27.724072 kernel: BTRFS info (device sda6): using free space tree Jan 16 23:57:27.730803 kernel: BTRFS info (device sda6): auto enabling async discard Jan 16 23:57:27.732754 systemd[1]: Mounted sysroot-oem.mount - /sysroot/oem. Jan 16 23:57:27.760702 ignition[1129]: INFO : Ignition 2.19.0 Jan 16 23:57:27.760702 ignition[1129]: INFO : Stage: files Jan 16 23:57:27.767257 ignition[1129]: INFO : no configs at "/usr/lib/ignition/base.d" Jan 16 23:57:27.767257 ignition[1129]: INFO : no config dir at "/usr/lib/ignition/base.platform.d/azure" Jan 16 23:57:27.767257 ignition[1129]: DEBUG : files: compiled without relabeling support, skipping Jan 16 23:57:27.767257 ignition[1129]: INFO : files: ensureUsers: op(1): [started] creating or modifying user "core" Jan 16 23:57:27.767257 ignition[1129]: DEBUG : files: ensureUsers: op(1): executing: "usermod" "--root" "/sysroot" "core" Jan 16 23:57:27.811278 ignition[1129]: INFO : files: ensureUsers: op(1): [finished] creating or modifying user "core" Jan 16 23:57:27.817612 ignition[1129]: INFO : files: ensureUsers: op(2): [started] adding ssh keys to user "core" Jan 16 23:57:27.823660 ignition[1129]: INFO : files: ensureUsers: op(2): [finished] adding ssh keys to user "core" Jan 16 23:57:27.823607 unknown[1129]: wrote ssh authorized keys file for user: core Jan 16 23:57:27.842254 ignition[1129]: INFO : files: createFilesystemsFiles: createFiles: op(3): [started] writing file "/sysroot/tmp/_translate-filesystem-0-ign1/etc/flatcar/update.conf" Jan 16 23:57:27.852114 ignition[1129]: INFO : files: createFilesystemsFiles: createFiles: op(3): [finished] writing file "/sysroot/tmp/_translate-filesystem-0-ign1/etc/flatcar/update.conf" Jan 16 23:57:27.852114 ignition[1129]: INFO : files: createResultFile: createFiles: op(4): [started] writing file "/sysroot/etc/.ignition-result.json" Jan 16 23:57:27.852114 ignition[1129]: INFO : files: createResultFile: createFiles: op(4): [finished] writing file "/sysroot/etc/.ignition-result.json" Jan 16 23:57:27.852114 ignition[1129]: INFO : files: files passed Jan 16 23:57:27.852114 ignition[1129]: INFO : Ignition finished successfully Jan 16 23:57:27.844613 systemd[1]: Finished ignition-files.service - Ignition (files). Jan 16 23:57:27.875524 systemd[1]: Starting ignition-quench.service - Ignition (record completion)... Jan 16 23:57:27.888987 systemd[1]: Starting initrd-setup-root-after-ignition.service - Root filesystem completion... Jan 16 23:57:27.898301 systemd[1]: ignition-quench.service: Deactivated successfully. Jan 16 23:57:27.899852 systemd[1]: Finished ignition-quench.service - Ignition (record completion). Jan 16 23:57:27.942172 kernel: BTRFS info (device sda9): setting incompat feature flag for COMPRESS_ZSTD (0x10) Jan 16 23:57:27.942713 initrd-setup-root-after-ignition[1158]: grep: /sysroot/etc/flatcar/enabled-sysext.conf: No such file or directory Jan 16 23:57:27.942713 initrd-setup-root-after-ignition[1158]: grep: /sysroot/usr/share/flatcar/enabled-sysext.conf: No such file or directory Jan 16 23:57:27.957159 initrd-setup-root-after-ignition[1162]: grep: /sysroot/etc/flatcar/enabled-sysext.conf: No such file or directory Jan 16 23:57:27.951079 systemd[1]: Finished initrd-setup-root-after-ignition.service - Root filesystem completion. Jan 16 23:57:27.963093 systemd[1]: Reached target ignition-complete.target - Ignition Complete. Jan 16 23:57:27.988040 systemd[1]: Starting initrd-parse-etc.service - Mountpoints Configured in the Real Root... Jan 16 23:57:28.015774 systemd[1]: initrd-parse-etc.service: Deactivated successfully. Jan 16 23:57:28.015917 systemd[1]: Finished initrd-parse-etc.service - Mountpoints Configured in the Real Root. Jan 16 23:57:28.026128 systemd[1]: Reached target initrd-fs.target - Initrd File Systems. Jan 16 23:57:28.036015 systemd[1]: Reached target initrd.target - Initrd Default Target. Jan 16 23:57:28.044725 systemd[1]: dracut-mount.service - dracut mount hook was skipped because no trigger condition checks were met. Jan 16 23:57:28.063050 systemd[1]: Starting dracut-pre-pivot.service - dracut pre-pivot and cleanup hook... Jan 16 23:57:28.080392 systemd[1]: Finished dracut-pre-pivot.service - dracut pre-pivot and cleanup hook. Jan 16 23:57:28.097948 systemd[1]: Starting initrd-cleanup.service - Cleaning Up and Shutting Down Daemons... Jan 16 23:57:28.114774 systemd[1]: Stopped target nss-lookup.target - Host and Network Name Lookups. Jan 16 23:57:28.125277 systemd[1]: Stopped target remote-cryptsetup.target - Remote Encrypted Volumes. Jan 16 23:57:28.130842 systemd[1]: Stopped target timers.target - Timer Units. Jan 16 23:57:28.139810 systemd[1]: dracut-pre-pivot.service: Deactivated successfully. Jan 16 23:57:28.139936 systemd[1]: Stopped dracut-pre-pivot.service - dracut pre-pivot and cleanup hook. Jan 16 23:57:28.152832 systemd[1]: Stopped target initrd.target - Initrd Default Target. Jan 16 23:57:28.157518 systemd[1]: Stopped target basic.target - Basic System. Jan 16 23:57:28.166815 systemd[1]: Stopped target ignition-complete.target - Ignition Complete. Jan 16 23:57:28.176234 systemd[1]: Stopped target ignition-diskful.target - Ignition Boot Disk Setup. Jan 16 23:57:28.185146 systemd[1]: Stopped target initrd-root-device.target - Initrd Root Device. Jan 16 23:57:28.194861 systemd[1]: Stopped target remote-fs.target - Remote File Systems. Jan 16 23:57:28.204443 systemd[1]: Stopped target remote-fs-pre.target - Preparation for Remote File Systems. Jan 16 23:57:28.214757 systemd[1]: Stopped target sysinit.target - System Initialization. Jan 16 23:57:28.223904 systemd[1]: Stopped target local-fs.target - Local File Systems. Jan 16 23:57:28.233774 systemd[1]: Stopped target swap.target - Swaps. Jan 16 23:57:28.242026 systemd[1]: dracut-pre-mount.service: Deactivated successfully. Jan 16 23:57:28.242146 systemd[1]: Stopped dracut-pre-mount.service - dracut pre-mount hook. Jan 16 23:57:28.254643 systemd[1]: Stopped target cryptsetup.target - Local Encrypted Volumes. Jan 16 23:57:28.259806 systemd[1]: Stopped target cryptsetup-pre.target - Local Encrypted Volumes (Pre). Jan 16 23:57:28.269291 systemd[1]: clevis-luks-askpass.path: Deactivated successfully. Jan 16 23:57:28.278701 systemd[1]: Stopped clevis-luks-askpass.path - Forward Password Requests to Clevis Directory Watch. Jan 16 23:57:28.284455 systemd[1]: dracut-initqueue.service: Deactivated successfully. Jan 16 23:57:28.284569 systemd[1]: Stopped dracut-initqueue.service - dracut initqueue hook. Jan 16 23:57:28.298767 systemd[1]: initrd-setup-root-after-ignition.service: Deactivated successfully. Jan 16 23:57:28.298889 systemd[1]: Stopped initrd-setup-root-after-ignition.service - Root filesystem completion. Jan 16 23:57:28.304931 systemd[1]: ignition-files.service: Deactivated successfully. Jan 16 23:57:28.305022 systemd[1]: Stopped ignition-files.service - Ignition (files). Jan 16 23:57:28.315373 systemd[1]: flatcar-metadata-hostname.service: Deactivated successfully. Jan 16 23:57:28.315463 systemd[1]: Stopped flatcar-metadata-hostname.service - Flatcar Metadata Hostname Agent. Jan 16 23:57:28.346059 systemd[1]: Stopping ignition-mount.service - Ignition (mount)... Jan 16 23:57:28.360048 systemd[1]: Stopping sysroot-boot.service - /sysroot/boot... Jan 16 23:57:28.392433 ignition[1182]: INFO : Ignition 2.19.0 Jan 16 23:57:28.392433 ignition[1182]: INFO : Stage: umount Jan 16 23:57:28.392433 ignition[1182]: INFO : no configs at "/usr/lib/ignition/base.d" Jan 16 23:57:28.392433 ignition[1182]: INFO : no config dir at "/usr/lib/ignition/base.platform.d/azure" Jan 16 23:57:28.392433 ignition[1182]: INFO : umount: op(1): [started] umounting "/sysroot/tmp/_translate-filesystem-0-ign1" Jan 16 23:57:28.392433 ignition[1182]: INFO : umount: op(1): [finished] umounting "/sysroot/tmp/_translate-filesystem-0-ign1" Jan 16 23:57:28.392433 ignition[1182]: INFO : umount: umount passed Jan 16 23:57:28.392433 ignition[1182]: INFO : Ignition finished successfully Jan 16 23:57:28.374297 systemd[1]: systemd-udev-trigger.service: Deactivated successfully. Jan 16 23:57:28.374543 systemd[1]: Stopped systemd-udev-trigger.service - Coldplug All udev Devices. Jan 16 23:57:28.380333 systemd[1]: dracut-pre-trigger.service: Deactivated successfully. Jan 16 23:57:28.380492 systemd[1]: Stopped dracut-pre-trigger.service - dracut pre-trigger hook. Jan 16 23:57:28.389808 systemd[1]: sysroot-tmp-_translate\x2dfilesystem\x2d0\x2dign1.mount: Deactivated successfully. Jan 16 23:57:28.390603 systemd[1]: ignition-mount.service: Deactivated successfully. Jan 16 23:57:28.390705 systemd[1]: Stopped ignition-mount.service - Ignition (mount). Jan 16 23:57:28.399637 systemd[1]: ignition-disks.service: Deactivated successfully. Jan 16 23:57:28.399902 systemd[1]: Stopped ignition-disks.service - Ignition (disks). Jan 16 23:57:28.409724 systemd[1]: ignition-kargs.service: Deactivated successfully. Jan 16 23:57:28.409807 systemd[1]: Stopped ignition-kargs.service - Ignition (kargs). Jan 16 23:57:28.414706 systemd[1]: ignition-fetch.service: Deactivated successfully. Jan 16 23:57:28.414750 systemd[1]: Stopped ignition-fetch.service - Ignition (fetch). Jan 16 23:57:28.423557 systemd[1]: Stopped target network.target - Network. Jan 16 23:57:28.432722 systemd[1]: ignition-fetch-offline.service: Deactivated successfully. Jan 16 23:57:28.432782 systemd[1]: Stopped ignition-fetch-offline.service - Ignition (fetch-offline). Jan 16 23:57:28.445171 systemd[1]: Stopped target paths.target - Path Units. Jan 16 23:57:28.449448 systemd[1]: systemd-ask-password-console.path: Deactivated successfully. Jan 16 23:57:28.452813 systemd[1]: Stopped systemd-ask-password-console.path - Dispatch Password Requests to Console Directory Watch. Jan 16 23:57:28.461202 systemd[1]: Stopped target slices.target - Slice Units. Jan 16 23:57:28.468515 systemd[1]: Stopped target sockets.target - Socket Units. Jan 16 23:57:28.476616 systemd[1]: iscsid.socket: Deactivated successfully. Jan 16 23:57:28.476665 systemd[1]: Closed iscsid.socket - Open-iSCSI iscsid Socket. Jan 16 23:57:28.485176 systemd[1]: iscsiuio.socket: Deactivated successfully. Jan 16 23:57:28.485219 systemd[1]: Closed iscsiuio.socket - Open-iSCSI iscsiuio Socket. Jan 16 23:57:28.494519 systemd[1]: ignition-setup.service: Deactivated successfully. Jan 16 23:57:28.494569 systemd[1]: Stopped ignition-setup.service - Ignition (setup). Jan 16 23:57:28.503300 systemd[1]: ignition-setup-pre.service: Deactivated successfully. Jan 16 23:57:28.503338 systemd[1]: Stopped ignition-setup-pre.service - Ignition env setup. Jan 16 23:57:28.512993 systemd[1]: Stopping systemd-networkd.service - Network Configuration... Jan 16 23:57:28.522933 systemd[1]: Stopping systemd-resolved.service - Network Name Resolution... Jan 16 23:57:28.532466 systemd[1]: sysroot-boot.mount: Deactivated successfully. Jan 16 23:57:28.534404 systemd[1]: initrd-cleanup.service: Deactivated successfully. Jan 16 23:57:28.746717 kernel: hv_netvsc 7ced8d89-6cc4-7ced-8d89-6cc47ced8d89 eth0: Data path switched from VF: enP5732s1 Jan 16 23:57:28.534505 systemd[1]: Finished initrd-cleanup.service - Cleaning Up and Shutting Down Daemons. Jan 16 23:57:28.535595 systemd-networkd[901]: eth0: DHCPv6 lease lost Jan 16 23:57:28.543404 systemd[1]: systemd-resolved.service: Deactivated successfully. Jan 16 23:57:28.543540 systemd[1]: Stopped systemd-resolved.service - Network Name Resolution. Jan 16 23:57:28.554370 systemd[1]: systemd-networkd.service: Deactivated successfully. Jan 16 23:57:28.554544 systemd[1]: Stopped systemd-networkd.service - Network Configuration. Jan 16 23:57:28.563365 systemd[1]: sysroot-boot.service: Deactivated successfully. Jan 16 23:57:28.563466 systemd[1]: Stopped sysroot-boot.service - /sysroot/boot. Jan 16 23:57:28.573659 systemd[1]: systemd-networkd.socket: Deactivated successfully. Jan 16 23:57:28.573721 systemd[1]: Closed systemd-networkd.socket - Network Service Netlink Socket. Jan 16 23:57:28.581032 systemd[1]: initrd-setup-root.service: Deactivated successfully. Jan 16 23:57:28.581089 systemd[1]: Stopped initrd-setup-root.service - Root filesystem setup. Jan 16 23:57:28.604347 systemd[1]: Stopping network-cleanup.service - Network Cleanup... Jan 16 23:57:28.611776 systemd[1]: parse-ip-for-networkd.service: Deactivated successfully. Jan 16 23:57:28.611871 systemd[1]: Stopped parse-ip-for-networkd.service - Write systemd-networkd units from cmdline. Jan 16 23:57:28.621463 systemd[1]: systemd-sysctl.service: Deactivated successfully. Jan 16 23:57:28.621512 systemd[1]: Stopped systemd-sysctl.service - Apply Kernel Variables. Jan 16 23:57:28.630864 systemd[1]: systemd-modules-load.service: Deactivated successfully. Jan 16 23:57:28.630916 systemd[1]: Stopped systemd-modules-load.service - Load Kernel Modules. Jan 16 23:57:28.642286 systemd[1]: systemd-tmpfiles-setup.service: Deactivated successfully. Jan 16 23:57:28.642326 systemd[1]: Stopped systemd-tmpfiles-setup.service - Create System Files and Directories. Jan 16 23:57:28.651722 systemd[1]: Stopping systemd-udevd.service - Rule-based Manager for Device Events and Files... Jan 16 23:57:28.692126 systemd[1]: systemd-udevd.service: Deactivated successfully. Jan 16 23:57:28.692294 systemd[1]: Stopped systemd-udevd.service - Rule-based Manager for Device Events and Files. Jan 16 23:57:28.702984 systemd[1]: systemd-udevd-control.socket: Deactivated successfully. Jan 16 23:57:28.703055 systemd[1]: Closed systemd-udevd-control.socket - udev Control Socket. Jan 16 23:57:28.712328 systemd[1]: systemd-udevd-kernel.socket: Deactivated successfully. Jan 16 23:57:28.712369 systemd[1]: Closed systemd-udevd-kernel.socket - udev Kernel Socket. Jan 16 23:57:28.721981 systemd[1]: dracut-pre-udev.service: Deactivated successfully. Jan 16 23:57:28.722036 systemd[1]: Stopped dracut-pre-udev.service - dracut pre-udev hook. Jan 16 23:57:28.742726 systemd[1]: dracut-cmdline.service: Deactivated successfully. Jan 16 23:57:28.742811 systemd[1]: Stopped dracut-cmdline.service - dracut cmdline hook. Jan 16 23:57:28.968245 systemd-journald[217]: Received SIGTERM from PID 1 (systemd). Jan 16 23:57:28.756570 systemd[1]: dracut-cmdline-ask.service: Deactivated successfully. Jan 16 23:57:28.756708 systemd[1]: Stopped dracut-cmdline-ask.service - dracut ask for additional cmdline parameters. Jan 16 23:57:28.784059 systemd[1]: Starting initrd-udevadm-cleanup-db.service - Cleanup udev Database... Jan 16 23:57:28.794863 systemd[1]: systemd-tmpfiles-setup-dev.service: Deactivated successfully. Jan 16 23:57:28.794942 systemd[1]: Stopped systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev. Jan 16 23:57:28.806922 systemd[1]: systemd-tmpfiles-setup-dev-early.service: Deactivated successfully. Jan 16 23:57:28.806969 systemd[1]: Stopped systemd-tmpfiles-setup-dev-early.service - Create Static Device Nodes in /dev gracefully. Jan 16 23:57:28.816736 systemd[1]: kmod-static-nodes.service: Deactivated successfully. Jan 16 23:57:28.816773 systemd[1]: Stopped kmod-static-nodes.service - Create List of Static Device Nodes. Jan 16 23:57:28.827414 systemd[1]: systemd-vconsole-setup.service: Deactivated successfully. Jan 16 23:57:28.827451 systemd[1]: Stopped systemd-vconsole-setup.service - Virtual Console Setup. Jan 16 23:57:28.837158 systemd[1]: network-cleanup.service: Deactivated successfully. Jan 16 23:57:28.837258 systemd[1]: Stopped network-cleanup.service - Network Cleanup. Jan 16 23:57:28.846361 systemd[1]: initrd-udevadm-cleanup-db.service: Deactivated successfully. Jan 16 23:57:28.846447 systemd[1]: Finished initrd-udevadm-cleanup-db.service - Cleanup udev Database. Jan 16 23:57:28.856860 systemd[1]: Reached target initrd-switch-root.target - Switch Root. Jan 16 23:57:28.877054 systemd[1]: Starting initrd-switch-root.service - Switch Root... Jan 16 23:57:28.898227 systemd[1]: Switching root. Jan 16 23:57:29.007739 systemd-journald[217]: Journal stopped Jan 16 23:57:19.217148 kernel: Booting Linux on physical CPU 0x0000000000 [0x413fd0c1] Jan 16 23:57:19.217171 kernel: Linux version 6.6.119-flatcar (build@pony-truck.infra.kinvolk.io) (aarch64-cros-linux-gnu-gcc (Gentoo Hardened 13.3.1_p20240614 p17) 13.3.1 20240614, GNU ld (Gentoo 2.42 p3) 2.42.0) #1 SMP PREEMPT Fri Jan 16 22:28:08 -00 2026 Jan 16 23:57:19.217180 kernel: KASLR enabled Jan 16 23:57:19.217186 kernel: earlycon: pl11 at MMIO 0x00000000effec000 (options '') Jan 16 23:57:19.217194 kernel: printk: bootconsole [pl11] enabled Jan 16 23:57:19.217200 kernel: efi: EFI v2.7 by EDK II Jan 16 23:57:19.217208 kernel: efi: ACPI 2.0=0x3fd5f018 SMBIOS=0x3e580000 SMBIOS 3.0=0x3e560000 MEMATTR=0x3f215018 RNG=0x3fd5f998 MEMRESERVE=0x3e44ee18 Jan 16 23:57:19.217215 kernel: random: crng init done Jan 16 23:57:19.217222 kernel: ACPI: Early table checksum verification disabled Jan 16 23:57:19.217227 kernel: ACPI: RSDP 0x000000003FD5F018 000024 (v02 VRTUAL) Jan 16 23:57:19.217234 kernel: ACPI: XSDT 0x000000003FD5FF18 00006C (v01 VRTUAL MICROSFT 00000001 MSFT 00000001) Jan 16 23:57:19.217240 kernel: ACPI: FACP 0x000000003FD5FC18 000114 (v06 VRTUAL MICROSFT 00000001 MSFT 00000001) Jan 16 23:57:19.217248 kernel: ACPI: DSDT 0x000000003FD41018 01DFCD (v02 MSFTVM DSDT01 00000001 INTL 20230628) Jan 16 23:57:19.217254 kernel: ACPI: DBG2 0x000000003FD5FB18 000072 (v00 VRTUAL MICROSFT 00000001 MSFT 00000001) Jan 16 23:57:19.217262 kernel: ACPI: GTDT 0x000000003FD5FD98 000060 (v02 VRTUAL MICROSFT 00000001 MSFT 00000001) Jan 16 23:57:19.217268 kernel: ACPI: OEM0 0x000000003FD5F098 000064 (v01 VRTUAL MICROSFT 00000001 MSFT 00000001) Jan 16 23:57:19.217275 kernel: ACPI: SPCR 0x000000003FD5FA98 000050 (v02 VRTUAL MICROSFT 00000001 MSFT 00000001) Jan 16 23:57:19.217283 kernel: ACPI: APIC 0x000000003FD5F818 0000FC (v04 VRTUAL MICROSFT 00000001 MSFT 00000001) Jan 16 23:57:19.217290 kernel: ACPI: SRAT 0x000000003FD5F198 000234 (v03 VRTUAL MICROSFT 00000001 MSFT 00000001) Jan 16 23:57:19.217296 kernel: ACPI: PPTT 0x000000003FD5F418 000120 (v01 VRTUAL MICROSFT 00000000 MSFT 00000000) Jan 16 23:57:19.217304 kernel: ACPI: BGRT 0x000000003FD5FE98 000038 (v01 VRTUAL MICROSFT 00000001 MSFT 00000001) Jan 16 23:57:19.217311 kernel: ACPI: SPCR: console: pl011,mmio32,0xeffec000,115200 Jan 16 23:57:19.217317 kernel: ACPI: SRAT: Node 0 PXM 0 [mem 0x00000000-0x3fffffff] Jan 16 23:57:19.217324 kernel: ACPI: SRAT: Node 0 PXM 0 [mem 0x100000000-0x1bfffffff] Jan 16 23:57:19.217331 kernel: ACPI: SRAT: Node 0 PXM 0 [mem 0x1c0000000-0xfbfffffff] Jan 16 23:57:19.217337 kernel: ACPI: SRAT: Node 0 PXM 0 [mem 0x1000000000-0xffffffffff] Jan 16 23:57:19.217344 kernel: ACPI: SRAT: Node 0 PXM 0 [mem 0x10000000000-0x1ffffffffff] Jan 16 23:57:19.217351 kernel: ACPI: SRAT: Node 0 PXM 0 [mem 0x20000000000-0x3ffffffffff] Jan 16 23:57:19.217360 kernel: ACPI: SRAT: Node 0 PXM 0 [mem 0x40000000000-0x7ffffffffff] Jan 16 23:57:19.217366 kernel: ACPI: SRAT: Node 0 PXM 0 [mem 0x80000000000-0xfffffffffff] Jan 16 23:57:19.217373 kernel: ACPI: SRAT: Node 0 PXM 0 [mem 0x100000000000-0x1fffffffffff] Jan 16 23:57:19.217379 kernel: ACPI: SRAT: Node 0 PXM 0 [mem 0x200000000000-0x3fffffffffff] Jan 16 23:57:19.217386 kernel: ACPI: SRAT: Node 0 PXM 0 [mem 0x400000000000-0x7fffffffffff] Jan 16 23:57:19.217392 kernel: ACPI: SRAT: Node 0 PXM 0 [mem 0x800000000000-0xffffffffffff] Jan 16 23:57:19.217398 kernel: NUMA: NODE_DATA [mem 0x1bf7ef800-0x1bf7f4fff] Jan 16 23:57:19.217404 kernel: Zone ranges: Jan 16 23:57:19.217411 kernel: DMA [mem 0x0000000000000000-0x00000000ffffffff] Jan 16 23:57:19.218077 kernel: DMA32 empty Jan 16 23:57:19.218087 kernel: Normal [mem 0x0000000100000000-0x00000001bfffffff] Jan 16 23:57:19.218094 kernel: Movable zone start for each node Jan 16 23:57:19.218106 kernel: Early memory node ranges Jan 16 23:57:19.218114 kernel: node 0: [mem 0x0000000000000000-0x00000000007fffff] Jan 16 23:57:19.218121 kernel: node 0: [mem 0x0000000000824000-0x000000003e54ffff] Jan 16 23:57:19.218128 kernel: node 0: [mem 0x000000003e550000-0x000000003e87ffff] Jan 16 23:57:19.218135 kernel: node 0: [mem 0x000000003e880000-0x000000003fc7ffff] Jan 16 23:57:19.218143 kernel: node 0: [mem 0x000000003fc80000-0x000000003fcfffff] Jan 16 23:57:19.218150 kernel: node 0: [mem 0x000000003fd00000-0x000000003fffffff] Jan 16 23:57:19.218157 kernel: node 0: [mem 0x0000000100000000-0x00000001bfffffff] Jan 16 23:57:19.218164 kernel: Initmem setup node 0 [mem 0x0000000000000000-0x00000001bfffffff] Jan 16 23:57:19.218172 kernel: On node 0, zone DMA: 36 pages in unavailable ranges Jan 16 23:57:19.218179 kernel: psci: probing for conduit method from ACPI. Jan 16 23:57:19.218185 kernel: psci: PSCIv1.1 detected in firmware. Jan 16 23:57:19.218192 kernel: psci: Using standard PSCI v0.2 function IDs Jan 16 23:57:19.218199 kernel: psci: MIGRATE_INFO_TYPE not supported. Jan 16 23:57:19.218206 kernel: psci: SMC Calling Convention v1.4 Jan 16 23:57:19.218214 kernel: ACPI: NUMA: SRAT: PXM 0 -> MPIDR 0x0 -> Node 0 Jan 16 23:57:19.218221 kernel: ACPI: NUMA: SRAT: PXM 0 -> MPIDR 0x1 -> Node 0 Jan 16 23:57:19.218229 kernel: percpu: Embedded 30 pages/cpu s85672 r8192 d29016 u122880 Jan 16 23:57:19.218236 kernel: pcpu-alloc: s85672 r8192 d29016 u122880 alloc=30*4096 Jan 16 23:57:19.218243 kernel: pcpu-alloc: [0] 0 [0] 1 Jan 16 23:57:19.218250 kernel: Detected PIPT I-cache on CPU0 Jan 16 23:57:19.218257 kernel: CPU features: detected: GIC system register CPU interface Jan 16 23:57:19.218264 kernel: CPU features: detected: Hardware dirty bit management Jan 16 23:57:19.218271 kernel: CPU features: detected: Spectre-BHB Jan 16 23:57:19.218278 kernel: CPU features: kernel page table isolation forced ON by KASLR Jan 16 23:57:19.218285 kernel: CPU features: detected: Kernel page table isolation (KPTI) Jan 16 23:57:19.218292 kernel: CPU features: detected: ARM erratum 1418040 Jan 16 23:57:19.218299 kernel: CPU features: detected: ARM erratum 1542419 (kernel portion) Jan 16 23:57:19.218308 kernel: CPU features: detected: SSBS not fully self-synchronizing Jan 16 23:57:19.218315 kernel: alternatives: applying boot alternatives Jan 16 23:57:19.218323 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=d499dc3f7d5d4118d4e4300ad00f17ad72271d2a2f6bb9119457036ac5212c83 Jan 16 23:57:19.218330 kernel: Dentry cache hash table entries: 524288 (order: 10, 4194304 bytes, linear) Jan 16 23:57:19.218337 kernel: Inode-cache hash table entries: 262144 (order: 9, 2097152 bytes, linear) Jan 16 23:57:19.218344 kernel: Fallback order for Node 0: 0 Jan 16 23:57:19.218351 kernel: Built 1 zonelists, mobility grouping on. Total pages: 1032156 Jan 16 23:57:19.218358 kernel: Policy zone: Normal Jan 16 23:57:19.218364 kernel: mem auto-init: stack:off, heap alloc:off, heap free:off Jan 16 23:57:19.218371 kernel: software IO TLB: area num 2. Jan 16 23:57:19.218378 kernel: software IO TLB: mapped [mem 0x000000003a44e000-0x000000003e44e000] (64MB) Jan 16 23:57:19.218387 kernel: Memory: 3982636K/4194160K available (10304K kernel code, 2180K rwdata, 8112K rodata, 39424K init, 897K bss, 211524K reserved, 0K cma-reserved) Jan 16 23:57:19.218394 kernel: SLUB: HWalign=64, Order=0-3, MinObjects=0, CPUs=2, Nodes=1 Jan 16 23:57:19.218401 kernel: rcu: Preemptible hierarchical RCU implementation. Jan 16 23:57:19.218408 kernel: rcu: RCU event tracing is enabled. Jan 16 23:57:19.219456 kernel: rcu: RCU restricting CPUs from NR_CPUS=512 to nr_cpu_ids=2. Jan 16 23:57:19.219477 kernel: Trampoline variant of Tasks RCU enabled. Jan 16 23:57:19.219485 kernel: Tracing variant of Tasks RCU enabled. Jan 16 23:57:19.219492 kernel: rcu: RCU calculated value of scheduler-enlistment delay is 100 jiffies. Jan 16 23:57:19.219499 kernel: rcu: Adjusting geometry for rcu_fanout_leaf=16, nr_cpu_ids=2 Jan 16 23:57:19.219515 kernel: NR_IRQS: 64, nr_irqs: 64, preallocated irqs: 0 Jan 16 23:57:19.219523 kernel: GICv3: 960 SPIs implemented Jan 16 23:57:19.219533 kernel: GICv3: 0 Extended SPIs implemented Jan 16 23:57:19.219540 kernel: Root IRQ handler: gic_handle_irq Jan 16 23:57:19.219547 kernel: GICv3: GICv3 features: 16 PPIs, RSS Jan 16 23:57:19.219554 kernel: GICv3: CPU0: found redistributor 0 region 0:0x00000000effee000 Jan 16 23:57:19.219560 kernel: ITS: No ITS available, not enabling LPIs Jan 16 23:57:19.219567 kernel: rcu: srcu_init: Setting srcu_struct sizes based on contention. Jan 16 23:57:19.219574 kernel: arch_timer: Enabling local workaround for ARM erratum 1418040 Jan 16 23:57:19.219581 kernel: arch_timer: cp15 timer(s) running at 25.00MHz (virt). Jan 16 23:57:19.219588 kernel: clocksource: arch_sys_counter: mask: 0xffffffffffffff max_cycles: 0x5c40939b5, max_idle_ns: 440795202646 ns Jan 16 23:57:19.219595 kernel: sched_clock: 56 bits at 25MHz, resolution 40ns, wraps every 4398046511100ns Jan 16 23:57:19.219602 kernel: Console: colour dummy device 80x25 Jan 16 23:57:19.219611 kernel: printk: console [tty1] enabled Jan 16 23:57:19.219618 kernel: ACPI: Core revision 20230628 Jan 16 23:57:19.219625 kernel: Calibrating delay loop (skipped), value calculated using timer frequency.. 50.00 BogoMIPS (lpj=25000) Jan 16 23:57:19.219632 kernel: pid_max: default: 32768 minimum: 301 Jan 16 23:57:19.219639 kernel: LSM: initializing lsm=lockdown,capability,landlock,selinux,integrity Jan 16 23:57:19.219646 kernel: landlock: Up and running. Jan 16 23:57:19.219653 kernel: SELinux: Initializing. Jan 16 23:57:19.219660 kernel: Mount-cache hash table entries: 8192 (order: 4, 65536 bytes, linear) Jan 16 23:57:19.219667 kernel: Mountpoint-cache hash table entries: 8192 (order: 4, 65536 bytes, linear) Jan 16 23:57:19.219676 kernel: RCU Tasks: Setting shift to 1 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=2. Jan 16 23:57:19.219683 kernel: RCU Tasks Trace: Setting shift to 1 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=2. Jan 16 23:57:19.219690 kernel: Hyper-V: privilege flags low 0x2e7f, high 0x3a8030, hints 0x100000e, misc 0x31e1 Jan 16 23:57:19.219697 kernel: Hyper-V: Host Build 10.0.26100.1448-1-0 Jan 16 23:57:19.219704 kernel: Hyper-V: enabling crash_kexec_post_notifiers Jan 16 23:57:19.219711 kernel: rcu: Hierarchical SRCU implementation. Jan 16 23:57:19.219718 kernel: rcu: Max phase no-delay instances is 400. Jan 16 23:57:19.219725 kernel: Remapping and enabling EFI services. Jan 16 23:57:19.219740 kernel: smp: Bringing up secondary CPUs ... Jan 16 23:57:19.219747 kernel: Detected PIPT I-cache on CPU1 Jan 16 23:57:19.219754 kernel: GICv3: CPU1: found redistributor 1 region 1:0x00000000f000e000 Jan 16 23:57:19.219762 kernel: arch_timer: Enabling local workaround for ARM erratum 1418040 Jan 16 23:57:19.219771 kernel: CPU1: Booted secondary processor 0x0000000001 [0x413fd0c1] Jan 16 23:57:19.219778 kernel: smp: Brought up 1 node, 2 CPUs Jan 16 23:57:19.219786 kernel: SMP: Total of 2 processors activated. Jan 16 23:57:19.219794 kernel: CPU features: detected: 32-bit EL0 Support Jan 16 23:57:19.219802 kernel: CPU features: detected: Instruction cache invalidation not required for I/D coherence Jan 16 23:57:19.219811 kernel: CPU features: detected: Data cache clean to the PoU not required for I/D coherence Jan 16 23:57:19.219818 kernel: CPU features: detected: CRC32 instructions Jan 16 23:57:19.219826 kernel: CPU features: detected: RCpc load-acquire (LDAPR) Jan 16 23:57:19.219833 kernel: CPU features: detected: LSE atomic instructions Jan 16 23:57:19.219841 kernel: CPU features: detected: Privileged Access Never Jan 16 23:57:19.219848 kernel: CPU: All CPU(s) started at EL1 Jan 16 23:57:19.219856 kernel: alternatives: applying system-wide alternatives Jan 16 23:57:19.219863 kernel: devtmpfs: initialized Jan 16 23:57:19.219871 kernel: clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1911260446275000 ns Jan 16 23:57:19.219879 kernel: futex hash table entries: 512 (order: 3, 32768 bytes, linear) Jan 16 23:57:19.219887 kernel: pinctrl core: initialized pinctrl subsystem Jan 16 23:57:19.219895 kernel: SMBIOS 3.1.0 present. Jan 16 23:57:19.219902 kernel: DMI: Microsoft Corporation Virtual Machine/Virtual Machine, BIOS Hyper-V UEFI Release v4.1 09/28/2024 Jan 16 23:57:19.219910 kernel: NET: Registered PF_NETLINK/PF_ROUTE protocol family Jan 16 23:57:19.219917 kernel: DMA: preallocated 512 KiB GFP_KERNEL pool for atomic allocations Jan 16 23:57:19.219925 kernel: DMA: preallocated 512 KiB GFP_KERNEL|GFP_DMA pool for atomic allocations Jan 16 23:57:19.219932 kernel: DMA: preallocated 512 KiB GFP_KERNEL|GFP_DMA32 pool for atomic allocations Jan 16 23:57:19.219939 kernel: audit: initializing netlink subsys (disabled) Jan 16 23:57:19.219949 kernel: audit: type=2000 audit(0.047:1): state=initialized audit_enabled=0 res=1 Jan 16 23:57:19.219956 kernel: thermal_sys: Registered thermal governor 'step_wise' Jan 16 23:57:19.219963 kernel: cpuidle: using governor menu Jan 16 23:57:19.219971 kernel: hw-breakpoint: found 6 breakpoint and 4 watchpoint registers. Jan 16 23:57:19.219978 kernel: ASID allocator initialised with 32768 entries Jan 16 23:57:19.219985 kernel: acpiphp: ACPI Hot Plug PCI Controller Driver version: 0.5 Jan 16 23:57:19.219993 kernel: Serial: AMBA PL011 UART driver Jan 16 23:57:19.220000 kernel: Modules: 2G module region forced by RANDOMIZE_MODULE_REGION_FULL Jan 16 23:57:19.220007 kernel: Modules: 0 pages in range for non-PLT usage Jan 16 23:57:19.220016 kernel: Modules: 509008 pages in range for PLT usage Jan 16 23:57:19.220023 kernel: HugeTLB: registered 1.00 GiB page size, pre-allocated 0 pages Jan 16 23:57:19.220031 kernel: HugeTLB: 0 KiB vmemmap can be freed for a 1.00 GiB page Jan 16 23:57:19.220038 kernel: HugeTLB: registered 32.0 MiB page size, pre-allocated 0 pages Jan 16 23:57:19.220046 kernel: HugeTLB: 0 KiB vmemmap can be freed for a 32.0 MiB page Jan 16 23:57:19.220053 kernel: HugeTLB: registered 2.00 MiB page size, pre-allocated 0 pages Jan 16 23:57:19.220061 kernel: HugeTLB: 0 KiB vmemmap can be freed for a 2.00 MiB page Jan 16 23:57:19.220068 kernel: HugeTLB: registered 64.0 KiB page size, pre-allocated 0 pages Jan 16 23:57:19.220075 kernel: HugeTLB: 0 KiB vmemmap can be freed for a 64.0 KiB page Jan 16 23:57:19.220084 kernel: ACPI: Added _OSI(Module Device) Jan 16 23:57:19.220092 kernel: ACPI: Added _OSI(Processor Device) Jan 16 23:57:19.220099 kernel: ACPI: Added _OSI(Processor Aggregator Device) Jan 16 23:57:19.220107 kernel: ACPI: 1 ACPI AML tables successfully acquired and loaded Jan 16 23:57:19.220114 kernel: ACPI: Interpreter enabled Jan 16 23:57:19.220122 kernel: ACPI: Using GIC for interrupt routing Jan 16 23:57:19.220130 kernel: ARMH0011:00: ttyAMA0 at MMIO 0xeffec000 (irq = 12, base_baud = 0) is a SBSA Jan 16 23:57:19.220138 kernel: printk: console [ttyAMA0] enabled Jan 16 23:57:19.220146 kernel: printk: bootconsole [pl11] disabled Jan 16 23:57:19.220155 kernel: ARMH0011:01: ttyAMA1 at MMIO 0xeffeb000 (irq = 13, base_baud = 0) is a SBSA Jan 16 23:57:19.220162 kernel: iommu: Default domain type: Translated Jan 16 23:57:19.220170 kernel: iommu: DMA domain TLB invalidation policy: strict mode Jan 16 23:57:19.220178 kernel: efivars: Registered efivars operations Jan 16 23:57:19.220185 kernel: vgaarb: loaded Jan 16 23:57:19.220192 kernel: clocksource: Switched to clocksource arch_sys_counter Jan 16 23:57:19.220200 kernel: VFS: Disk quotas dquot_6.6.0 Jan 16 23:57:19.220207 kernel: VFS: Dquot-cache hash table entries: 512 (order 0, 4096 bytes) Jan 16 23:57:19.220214 kernel: pnp: PnP ACPI init Jan 16 23:57:19.220223 kernel: pnp: PnP ACPI: found 0 devices Jan 16 23:57:19.220230 kernel: NET: Registered PF_INET protocol family Jan 16 23:57:19.220238 kernel: IP idents hash table entries: 65536 (order: 7, 524288 bytes, linear) Jan 16 23:57:19.220246 kernel: tcp_listen_portaddr_hash hash table entries: 2048 (order: 3, 32768 bytes, linear) Jan 16 23:57:19.220253 kernel: Table-perturb hash table entries: 65536 (order: 6, 262144 bytes, linear) Jan 16 23:57:19.220261 kernel: TCP established hash table entries: 32768 (order: 6, 262144 bytes, linear) Jan 16 23:57:19.220268 kernel: TCP bind hash table entries: 32768 (order: 8, 1048576 bytes, linear) Jan 16 23:57:19.220276 kernel: TCP: Hash tables configured (established 32768 bind 32768) Jan 16 23:57:19.220283 kernel: UDP hash table entries: 2048 (order: 4, 65536 bytes, linear) Jan 16 23:57:19.220293 kernel: UDP-Lite hash table entries: 2048 (order: 4, 65536 bytes, linear) Jan 16 23:57:19.220300 kernel: NET: Registered PF_UNIX/PF_LOCAL protocol family Jan 16 23:57:19.220308 kernel: PCI: CLS 0 bytes, default 64 Jan 16 23:57:19.220315 kernel: kvm [1]: HYP mode not available Jan 16 23:57:19.220322 kernel: Initialise system trusted keyrings Jan 16 23:57:19.220330 kernel: workingset: timestamp_bits=39 max_order=20 bucket_order=0 Jan 16 23:57:19.220337 kernel: Key type asymmetric registered Jan 16 23:57:19.220344 kernel: Asymmetric key parser 'x509' registered Jan 16 23:57:19.220352 kernel: Block layer SCSI generic (bsg) driver version 0.4 loaded (major 250) Jan 16 23:57:19.220361 kernel: io scheduler mq-deadline registered Jan 16 23:57:19.220369 kernel: io scheduler kyber registered Jan 16 23:57:19.220376 kernel: io scheduler bfq registered Jan 16 23:57:19.220384 kernel: Serial: 8250/16550 driver, 4 ports, IRQ sharing enabled Jan 16 23:57:19.220391 kernel: thunder_xcv, ver 1.0 Jan 16 23:57:19.220398 kernel: thunder_bgx, ver 1.0 Jan 16 23:57:19.220406 kernel: nicpf, ver 1.0 Jan 16 23:57:19.220413 kernel: nicvf, ver 1.0 Jan 16 23:57:19.220570 kernel: rtc-efi rtc-efi.0: registered as rtc0 Jan 16 23:57:19.220647 kernel: rtc-efi rtc-efi.0: setting system clock to 2026-01-16T23:57:18 UTC (1768607838) Jan 16 23:57:19.220658 kernel: efifb: probing for efifb Jan 16 23:57:19.220666 kernel: efifb: framebuffer at 0x40000000, using 3072k, total 3072k Jan 16 23:57:19.220674 kernel: efifb: mode is 1024x768x32, linelength=4096, pages=1 Jan 16 23:57:19.220681 kernel: efifb: scrolling: redraw Jan 16 23:57:19.220689 kernel: efifb: Truecolor: size=8:8:8:8, shift=24:16:8:0 Jan 16 23:57:19.220696 kernel: Console: switching to colour frame buffer device 128x48 Jan 16 23:57:19.220704 kernel: fb0: EFI VGA frame buffer device Jan 16 23:57:19.220713 kernel: SMCCC: SOC_ID: ARCH_SOC_ID not implemented, skipping .... Jan 16 23:57:19.220721 kernel: hid: raw HID events driver (C) Jiri Kosina Jan 16 23:57:19.220729 kernel: hw perfevents: enabled with armv8_pmuv3_0 PMU driver, 6 counters available Jan 16 23:57:19.220736 kernel: watchdog: Delayed init of the lockup detector failed: -19 Jan 16 23:57:19.220744 kernel: watchdog: Hard watchdog permanently disabled Jan 16 23:57:19.220751 kernel: NET: Registered PF_INET6 protocol family Jan 16 23:57:19.220759 kernel: Segment Routing with IPv6 Jan 16 23:57:19.220766 kernel: In-situ OAM (IOAM) with IPv6 Jan 16 23:57:19.220774 kernel: NET: Registered PF_PACKET protocol family Jan 16 23:57:19.220783 kernel: Key type dns_resolver registered Jan 16 23:57:19.220790 kernel: registered taskstats version 1 Jan 16 23:57:19.220798 kernel: Loading compiled-in X.509 certificates Jan 16 23:57:19.220806 kernel: Loaded X.509 cert 'Kinvolk GmbH: Module signing key for 6.6.119-flatcar: 0aabad27df82424bfffc9b1a502a9ae84b35bad4' Jan 16 23:57:19.220813 kernel: Key type .fscrypt registered Jan 16 23:57:19.220820 kernel: Key type fscrypt-provisioning registered Jan 16 23:57:19.220828 kernel: ima: No TPM chip found, activating TPM-bypass! Jan 16 23:57:19.220836 kernel: ima: Allocated hash algorithm: sha1 Jan 16 23:57:19.220843 kernel: ima: No architecture policies found Jan 16 23:57:19.220853 kernel: alg: No test for fips(ansi_cprng) (fips_ansi_cprng) Jan 16 23:57:19.220860 kernel: clk: Disabling unused clocks Jan 16 23:57:19.220868 kernel: Freeing unused kernel memory: 39424K Jan 16 23:57:19.220875 kernel: Run /init as init process Jan 16 23:57:19.220882 kernel: with arguments: Jan 16 23:57:19.220889 kernel: /init Jan 16 23:57:19.220897 kernel: with environment: Jan 16 23:57:19.220904 kernel: HOME=/ Jan 16 23:57:19.220911 kernel: TERM=linux Jan 16 23:57:19.220920 systemd[1]: systemd 255 running in system mode (+PAM +AUDIT +SELINUX -APPARMOR +IMA +SMACK +SECCOMP +GCRYPT -GNUTLS +OPENSSL -ACL +BLKID +CURL +ELFUTILS -FIDO2 +IDN2 -IDN +IPTC +KMOD +LIBCRYPTSETUP +LIBFDISK +PCRE2 -PWQUALITY -P11KIT -QRENCODE +TPM2 +BZIP2 +LZ4 +XZ +ZLIB +ZSTD -BPF_FRAMEWORK -XKBCOMMON +UTMP -SYSVINIT default-hierarchy=unified) Jan 16 23:57:19.220932 systemd[1]: Detected virtualization microsoft. Jan 16 23:57:19.220940 systemd[1]: Detected architecture arm64. Jan 16 23:57:19.220948 systemd[1]: Running in initrd. Jan 16 23:57:19.220955 systemd[1]: No hostname configured, using default hostname. Jan 16 23:57:19.220963 systemd[1]: Hostname set to . Jan 16 23:57:19.220971 systemd[1]: Initializing machine ID from random generator. Jan 16 23:57:19.220981 systemd[1]: Queued start job for default target initrd.target. Jan 16 23:57:19.220989 systemd[1]: Started clevis-luks-askpass.path - Forward Password Requests to Clevis Directory Watch. Jan 16 23:57:19.220997 systemd[1]: Started systemd-ask-password-console.path - Dispatch Password Requests to Console Directory Watch. Jan 16 23:57:19.221006 systemd[1]: Expecting device dev-disk-by\x2dlabel-EFI\x2dSYSTEM.device - /dev/disk/by-label/EFI-SYSTEM... Jan 16 23:57:19.221014 systemd[1]: Expecting device dev-disk-by\x2dlabel-OEM.device - /dev/disk/by-label/OEM... Jan 16 23:57:19.221022 systemd[1]: Expecting device dev-disk-by\x2dlabel-ROOT.device - /dev/disk/by-label/ROOT... Jan 16 23:57:19.221031 systemd[1]: Expecting device dev-disk-by\x2dpartlabel-USR\x2dA.device - /dev/disk/by-partlabel/USR-A... Jan 16 23:57:19.221041 systemd[1]: Expecting device dev-disk-by\x2dpartuuid-7130c94a\x2d213a\x2d4e5a\x2d8e26\x2d6cce9662f132.device - /dev/disk/by-partuuid/7130c94a-213a-4e5a-8e26-6cce9662f132... Jan 16 23:57:19.221052 systemd[1]: Expecting device dev-mapper-usr.device - /dev/mapper/usr... Jan 16 23:57:19.221061 systemd[1]: Reached target cryptsetup-pre.target - Local Encrypted Volumes (Pre). Jan 16 23:57:19.221070 systemd[1]: Reached target cryptsetup.target - Local Encrypted Volumes. Jan 16 23:57:19.221078 systemd[1]: Reached target paths.target - Path Units. Jan 16 23:57:19.221086 systemd[1]: Reached target slices.target - Slice Units. Jan 16 23:57:19.221094 systemd[1]: Reached target swap.target - Swaps. Jan 16 23:57:19.221102 systemd[1]: Reached target timers.target - Timer Units. Jan 16 23:57:19.221111 systemd[1]: Listening on iscsid.socket - Open-iSCSI iscsid Socket. Jan 16 23:57:19.221122 systemd[1]: Listening on iscsiuio.socket - Open-iSCSI iscsiuio Socket. Jan 16 23:57:19.221131 systemd[1]: Listening on systemd-journald-dev-log.socket - Journal Socket (/dev/log). Jan 16 23:57:19.221139 systemd[1]: Listening on systemd-journald.socket - Journal Socket. Jan 16 23:57:19.221148 systemd[1]: Listening on systemd-networkd.socket - Network Service Netlink Socket. Jan 16 23:57:19.221156 systemd[1]: Listening on systemd-udevd-control.socket - udev Control Socket. Jan 16 23:57:19.221164 systemd[1]: Listening on systemd-udevd-kernel.socket - udev Kernel Socket. Jan 16 23:57:19.221173 systemd[1]: Reached target sockets.target - Socket Units. Jan 16 23:57:19.221181 systemd[1]: Starting ignition-setup-pre.service - Ignition env setup... Jan 16 23:57:19.221190 systemd[1]: Starting kmod-static-nodes.service - Create List of Static Device Nodes... Jan 16 23:57:19.221199 systemd[1]: Finished network-cleanup.service - Network Cleanup. Jan 16 23:57:19.221207 systemd[1]: Starting systemd-fsck-usr.service... Jan 16 23:57:19.221215 systemd[1]: Starting systemd-journald.service - Journal Service... Jan 16 23:57:19.221224 systemd[1]: Starting systemd-modules-load.service - Load Kernel Modules... Jan 16 23:57:19.221250 systemd-journald[217]: Collecting audit messages is disabled. Jan 16 23:57:19.221272 systemd[1]: Starting systemd-vconsole-setup.service - Virtual Console Setup... Jan 16 23:57:19.221281 systemd-journald[217]: Journal started Jan 16 23:57:19.221300 systemd-journald[217]: Runtime Journal (/run/log/journal/77ae9142220b4e22a04e16a4719b9612) is 8.0M, max 78.5M, 70.5M free. Jan 16 23:57:19.224882 systemd-modules-load[218]: Inserted module 'overlay' Jan 16 23:57:19.241477 systemd[1]: Started systemd-journald.service - Journal Service. Jan 16 23:57:19.243924 systemd[1]: Finished ignition-setup-pre.service - Ignition env setup. Jan 16 23:57:19.264597 kernel: bridge: filtering via arp/ip/ip6tables is no longer available by default. Update your scripts to load br_netfilter if you need this. Jan 16 23:57:19.264626 kernel: Bridge firewalling registered Jan 16 23:57:19.256732 systemd[1]: Finished kmod-static-nodes.service - Create List of Static Device Nodes. Jan 16 23:57:19.269851 systemd-modules-load[218]: Inserted module 'br_netfilter' Jan 16 23:57:19.278312 systemd[1]: Finished systemd-fsck-usr.service. Jan 16 23:57:19.282325 systemd[1]: Finished systemd-modules-load.service - Load Kernel Modules. Jan 16 23:57:19.291311 systemd[1]: Finished systemd-vconsole-setup.service - Virtual Console Setup. Jan 16 23:57:19.312594 systemd[1]: Starting dracut-cmdline-ask.service - dracut ask for additional cmdline parameters... Jan 16 23:57:19.324354 systemd[1]: Starting systemd-sysctl.service - Apply Kernel Variables... Jan 16 23:57:19.331582 systemd[1]: Starting systemd-tmpfiles-setup-dev-early.service - Create Static Device Nodes in /dev gracefully... Jan 16 23:57:19.357608 systemd[1]: Starting systemd-tmpfiles-setup.service - Create System Files and Directories... Jan 16 23:57:19.363328 systemd[1]: Finished dracut-cmdline-ask.service - dracut ask for additional cmdline parameters. Jan 16 23:57:19.374791 systemd[1]: Finished systemd-sysctl.service - Apply Kernel Variables. Jan 16 23:57:19.380011 systemd[1]: Finished systemd-tmpfiles-setup-dev-early.service - Create Static Device Nodes in /dev gracefully. Jan 16 23:57:19.393561 systemd[1]: Finished systemd-tmpfiles-setup.service - Create System Files and Directories. Jan 16 23:57:19.417749 systemd[1]: Starting dracut-cmdline.service - dracut cmdline hook... Jan 16 23:57:19.431221 systemd[1]: Starting systemd-resolved.service - Network Name Resolution... Jan 16 23:57:19.443828 dracut-cmdline[252]: dracut-dracut-053 Jan 16 23:57:19.443828 dracut-cmdline[252]: 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=d499dc3f7d5d4118d4e4300ad00f17ad72271d2a2f6bb9119457036ac5212c83 Jan 16 23:57:19.442757 systemd[1]: Starting systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev... Jan 16 23:57:19.495209 systemd-resolved[259]: Positive Trust Anchors: Jan 16 23:57:19.498913 systemd[1]: Finished systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev. Jan 16 23:57:19.498976 systemd-resolved[259]: . IN DS 20326 8 2 e06d44b80b8f1d39a95c0b0d7c65d08458e880409bbc683457104237c7f8ec8d Jan 16 23:57:19.499011 systemd-resolved[259]: Negative trust anchors: home.arpa 10.in-addr.arpa 16.172.in-addr.arpa 17.172.in-addr.arpa 18.172.in-addr.arpa 19.172.in-addr.arpa 20.172.in-addr.arpa 21.172.in-addr.arpa 22.172.in-addr.arpa 23.172.in-addr.arpa 24.172.in-addr.arpa 25.172.in-addr.arpa 26.172.in-addr.arpa 27.172.in-addr.arpa 28.172.in-addr.arpa 29.172.in-addr.arpa 30.172.in-addr.arpa 31.172.in-addr.arpa 170.0.0.192.in-addr.arpa 171.0.0.192.in-addr.arpa 168.192.in-addr.arpa d.f.ip6.arpa ipv4only.arpa resolver.arpa corp home internal intranet lan local private test Jan 16 23:57:19.501404 systemd-resolved[259]: Defaulting to hostname 'linux'. Jan 16 23:57:19.514523 systemd[1]: Started systemd-resolved.service - Network Name Resolution. Jan 16 23:57:19.527206 systemd[1]: Reached target nss-lookup.target - Host and Network Name Lookups. Jan 16 23:57:19.580428 kernel: SCSI subsystem initialized Jan 16 23:57:19.587425 kernel: Loading iSCSI transport class v2.0-870. Jan 16 23:57:19.597427 kernel: iscsi: registered transport (tcp) Jan 16 23:57:19.614030 kernel: iscsi: registered transport (qla4xxx) Jan 16 23:57:19.614095 kernel: QLogic iSCSI HBA Driver Jan 16 23:57:19.649242 systemd[1]: Finished dracut-cmdline.service - dracut cmdline hook. Jan 16 23:57:19.661901 systemd[1]: Starting dracut-pre-udev.service - dracut pre-udev hook... Jan 16 23:57:19.689438 kernel: device-mapper: core: CONFIG_IMA_DISABLE_HTABLE is disabled. Duplicate IMA measurements will not be recorded in the IMA log. Jan 16 23:57:19.689479 kernel: device-mapper: uevent: version 1.0.3 Jan 16 23:57:19.694590 kernel: device-mapper: ioctl: 4.48.0-ioctl (2023-03-01) initialised: dm-devel@redhat.com Jan 16 23:57:19.743435 kernel: raid6: neonx8 gen() 15817 MB/s Jan 16 23:57:19.761428 kernel: raid6: neonx4 gen() 15695 MB/s Jan 16 23:57:19.780427 kernel: raid6: neonx2 gen() 13218 MB/s Jan 16 23:57:19.799423 kernel: raid6: neonx1 gen() 10489 MB/s Jan 16 23:57:19.819423 kernel: raid6: int64x8 gen() 6975 MB/s Jan 16 23:57:19.838423 kernel: raid6: int64x4 gen() 7353 MB/s Jan 16 23:57:19.857426 kernel: raid6: int64x2 gen() 6147 MB/s Jan 16 23:57:19.880412 kernel: raid6: int64x1 gen() 5066 MB/s Jan 16 23:57:19.880444 kernel: raid6: using algorithm neonx8 gen() 15817 MB/s Jan 16 23:57:19.903430 kernel: raid6: .... xor() 12015 MB/s, rmw enabled Jan 16 23:57:19.903440 kernel: raid6: using neon recovery algorithm Jan 16 23:57:19.913527 kernel: xor: measuring software checksum speed Jan 16 23:57:19.913540 kernel: 8regs : 19826 MB/sec Jan 16 23:57:19.916499 kernel: 32regs : 19660 MB/sec Jan 16 23:57:19.919380 kernel: arm64_neon : 27052 MB/sec Jan 16 23:57:19.922785 kernel: xor: using function: arm64_neon (27052 MB/sec) Jan 16 23:57:19.972449 kernel: Btrfs loaded, zoned=no, fsverity=no Jan 16 23:57:19.982452 systemd[1]: Finished dracut-pre-udev.service - dracut pre-udev hook. Jan 16 23:57:20.000594 systemd[1]: Starting systemd-udevd.service - Rule-based Manager for Device Events and Files... Jan 16 23:57:20.020495 systemd-udevd[438]: Using default interface naming scheme 'v255'. Jan 16 23:57:20.025030 systemd[1]: Started systemd-udevd.service - Rule-based Manager for Device Events and Files. Jan 16 23:57:20.045586 systemd[1]: Starting dracut-pre-trigger.service - dracut pre-trigger hook... Jan 16 23:57:20.061550 dracut-pre-trigger[448]: rd.md=0: removing MD RAID activation Jan 16 23:57:20.090195 systemd[1]: Finished dracut-pre-trigger.service - dracut pre-trigger hook. Jan 16 23:57:20.110705 systemd[1]: Starting systemd-udev-trigger.service - Coldplug All udev Devices... Jan 16 23:57:20.152590 systemd[1]: Finished systemd-udev-trigger.service - Coldplug All udev Devices. Jan 16 23:57:20.171583 systemd[1]: Starting dracut-initqueue.service - dracut initqueue hook... Jan 16 23:57:20.192613 systemd[1]: Finished dracut-initqueue.service - dracut initqueue hook. Jan 16 23:57:20.201519 systemd[1]: Reached target remote-fs-pre.target - Preparation for Remote File Systems. Jan 16 23:57:20.220600 systemd[1]: Reached target remote-cryptsetup.target - Remote Encrypted Volumes. Jan 16 23:57:20.232797 systemd[1]: Reached target remote-fs.target - Remote File Systems. Jan 16 23:57:20.255167 systemd[1]: Starting dracut-pre-mount.service - dracut pre-mount hook... Jan 16 23:57:20.269725 kernel: hv_vmbus: Vmbus version:5.3 Jan 16 23:57:20.272819 systemd[1]: dracut-cmdline-ask.service: Deactivated successfully. Jan 16 23:57:20.272974 systemd[1]: Stopped dracut-cmdline-ask.service - dracut ask for additional cmdline parameters. Jan 16 23:57:20.328369 kernel: pps_core: LinuxPPS API ver. 1 registered Jan 16 23:57:20.328397 kernel: hv_vmbus: registering driver hid_hyperv Jan 16 23:57:20.328409 kernel: hv_vmbus: registering driver hyperv_keyboard Jan 16 23:57:20.328425 kernel: pps_core: Software ver. 5.3.6 - Copyright 2005-2007 Rodolfo Giometti Jan 16 23:57:20.328438 kernel: input: AT Translated Set 2 keyboard as /devices/LNXSYSTM:00/LNXSYBUS:00/ACPI0004:00/MSFT1000:00/d34b2567-b9b6-42b9-8778-0a4ec0b955bf/serio0/input/input0 Jan 16 23:57:20.294536 systemd[1]: Stopping dracut-cmdline-ask.service - dracut ask for additional cmdline parameters... Jan 16 23:57:20.373570 kernel: input: Microsoft Vmbus HID-compliant Mouse as /devices/0006:045E:0621.0001/input/input1 Jan 16 23:57:20.373595 kernel: hv_vmbus: registering driver hv_storvsc Jan 16 23:57:20.373605 kernel: hid-hyperv 0006:045E:0621.0001: input: VIRTUAL HID v0.01 Mouse [Microsoft Vmbus HID-compliant Mouse] on Jan 16 23:57:20.373752 kernel: scsi host0: storvsc_host_t Jan 16 23:57:20.378898 kernel: scsi 0:0:0:0: Direct-Access Msft Virtual Disk 1.0 PQ: 0 ANSI: 5 Jan 16 23:57:20.379000 kernel: scsi 0:0:0:2: CD-ROM Msft Virtual DVD-ROM 1.0 PQ: 0 ANSI: 5 Jan 16 23:57:20.379103 kernel: hv_vmbus: registering driver hv_netvsc Jan 16 23:57:20.379114 kernel: PTP clock support registered Jan 16 23:57:20.310678 systemd[1]: systemd-vconsole-setup.service: Deactivated successfully. Jan 16 23:57:20.388495 kernel: scsi host1: storvsc_host_t Jan 16 23:57:20.310913 systemd[1]: Stopped systemd-vconsole-setup.service - Virtual Console Setup. Jan 16 23:57:20.342160 systemd[1]: Stopping systemd-vconsole-setup.service - Virtual Console Setup... Jan 16 23:57:20.394840 systemd[1]: Starting systemd-vconsole-setup.service - Virtual Console Setup... Jan 16 23:57:20.553356 kernel: hv_utils: Registering HyperV Utility Driver Jan 16 23:57:20.553379 kernel: hv_vmbus: registering driver hv_utils Jan 16 23:57:20.553389 kernel: hv_utils: Heartbeat IC version 3.0 Jan 16 23:57:20.553407 kernel: hv_utils: Shutdown IC version 3.2 Jan 16 23:57:20.553418 kernel: hv_utils: TimeSync IC version 4.0 Jan 16 23:57:20.553427 kernel: sr 0:0:0:2: [sr0] scsi-1 drive Jan 16 23:57:20.406185 systemd[1]: Finished dracut-pre-mount.service - dracut pre-mount hook. Jan 16 23:57:20.436976 systemd[1]: Finished systemd-vconsole-setup.service - Virtual Console Setup. Jan 16 23:57:20.579659 kernel: hv_netvsc 7ced8d89-6cc4-7ced-8d89-6cc47ced8d89 eth0: VF slot 1 added Jan 16 23:57:20.579841 kernel: cdrom: Uniform CD-ROM driver Revision: 3.20 Jan 16 23:57:20.548830 systemd-resolved[259]: Clock change detected. Flushing caches. Jan 16 23:57:20.621987 kernel: hv_vmbus: registering driver hv_pci Jan 16 23:57:20.622022 kernel: sd 0:0:0:0: [sda] 63737856 512-byte logical blocks: (32.6 GB/30.4 GiB) Jan 16 23:57:20.622188 kernel: sd 0:0:0:0: [sda] 4096-byte physical blocks Jan 16 23:57:20.622278 kernel: sd 0:0:0:0: [sda] Write Protect is off Jan 16 23:57:20.622364 kernel: hv_pci 043aaf96-1664-4089-b7f5-7e7d9c66608f: PCI VMBus probing: Using version 0x10004 Jan 16 23:57:20.622466 kernel: sd 0:0:0:0: [sda] Mode Sense: 0f 00 10 00 Jan 16 23:57:20.622555 kernel: sd 0:0:0:0: [sda] Write cache: disabled, read cache: enabled, supports DPO and FUA Jan 16 23:57:20.575027 systemd[1]: systemd-vconsole-setup.service: Deactivated successfully. Jan 16 23:57:20.575329 systemd[1]: Stopped systemd-vconsole-setup.service - Virtual Console Setup. Jan 16 23:57:20.637632 kernel: sr 0:0:0:2: Attached scsi CD-ROM sr0 Jan 16 23:57:20.637815 kernel: sda: sda1 sda2 sda3 sda4 sda6 sda7 sda9 Jan 16 23:57:20.637828 kernel: hv_pci 043aaf96-1664-4089-b7f5-7e7d9c66608f: PCI host bridge to bus 1664:00 Jan 16 23:57:20.595934 systemd[1]: Stopping systemd-vconsole-setup.service - Virtual Console Setup... Jan 16 23:57:20.664071 kernel: sd 0:0:0:0: [sda] Attached SCSI disk Jan 16 23:57:20.664254 kernel: pci_bus 1664:00: root bus resource [mem 0xfc0000000-0xfc00fffff window] Jan 16 23:57:20.664367 kernel: pci_bus 1664:00: No busn resource found for root bus, will use [bus 00-ff] Jan 16 23:57:20.633890 systemd[1]: Starting systemd-vconsole-setup.service - Virtual Console Setup... Jan 16 23:57:20.678107 kernel: pci 1664:00:02.0: [15b3:1018] type 00 class 0x020000 Jan 16 23:57:20.681198 systemd[1]: Finished systemd-vconsole-setup.service - Virtual Console Setup. Jan 16 23:57:20.696920 kernel: pci 1664:00:02.0: reg 0x10: [mem 0xfc0000000-0xfc00fffff 64bit pref] Jan 16 23:57:20.696978 kernel: pci 1664:00:02.0: enabling Extended Tags Jan 16 23:57:20.713953 kernel: hv_storvsc f8b3781a-1e82-4818-a1c3-63d806ec15bb: tag#161 cmd 0x85 status: scsi 0x2 srb 0x6 hv 0xc0000001 Jan 16 23:57:20.714144 kernel: pci 1664:00:02.0: 0.000 Gb/s available PCIe bandwidth, limited by Unknown x0 link at 1664:00:02.0 (capable of 126.016 Gb/s with 8.0 GT/s PCIe x16 link) Jan 16 23:57:20.716123 systemd[1]: Starting dracut-cmdline-ask.service - dracut ask for additional cmdline parameters... Jan 16 23:57:20.741359 kernel: pci_bus 1664:00: busn_res: [bus 00-ff] end is updated to 00 Jan 16 23:57:20.742146 kernel: pci 1664:00:02.0: BAR 0: assigned [mem 0xfc0000000-0xfc00fffff 64bit pref] Jan 16 23:57:20.755807 systemd[1]: Finished dracut-cmdline-ask.service - dracut ask for additional cmdline parameters. Jan 16 23:57:20.778912 kernel: hv_storvsc f8b3781a-1e82-4818-a1c3-63d806ec15bb: tag#131 cmd 0x85 status: scsi 0x2 srb 0x6 hv 0xc0000001 Jan 16 23:57:20.804860 kernel: mlx5_core 1664:00:02.0: enabling device (0000 -> 0002) Jan 16 23:57:20.809808 kernel: mlx5_core 1664:00:02.0: firmware version: 16.30.5026 Jan 16 23:57:21.006140 kernel: hv_netvsc 7ced8d89-6cc4-7ced-8d89-6cc47ced8d89 eth0: VF registering: eth1 Jan 16 23:57:21.006344 kernel: mlx5_core 1664:00:02.0 eth1: joined to eth0 Jan 16 23:57:21.018814 kernel: mlx5_core 1664:00:02.0: MLX5E: StrdRq(1) RqSz(8) StrdSz(2048) RxCqeCmprss(0 basic) Jan 16 23:57:21.029810 kernel: mlx5_core 1664:00:02.0 enP5732s1: renamed from eth1 Jan 16 23:57:21.401348 systemd[1]: Found device dev-disk-by\x2dlabel-EFI\x2dSYSTEM.device - Virtual_Disk EFI-SYSTEM. Jan 16 23:57:21.430225 kernel: BTRFS: device label OEM devid 1 transid 10 /dev/sda6 scanned by (udev-worker) (486) Jan 16 23:57:21.438355 systemd[1]: Found device dev-disk-by\x2dlabel-ROOT.device - Virtual_Disk ROOT. Jan 16 23:57:21.454780 systemd[1]: Found device dev-disk-by\x2dlabel-OEM.device - Virtual_Disk OEM. Jan 16 23:57:21.474818 kernel: BTRFS: device fsid 257557f7-4bf9-4b29-86df-93ad67770d31 devid 1 transid 37 /dev/sda3 scanned by (udev-worker) (484) Jan 16 23:57:21.488758 systemd[1]: Found device dev-disk-by\x2dpartlabel-USR\x2dA.device - Virtual_Disk USR-A. Jan 16 23:57:21.500126 systemd[1]: Found device dev-disk-by\x2dpartuuid-7130c94a\x2d213a\x2d4e5a\x2d8e26\x2d6cce9662f132.device - Virtual_Disk USR-A. Jan 16 23:57:21.520050 systemd[1]: Starting disk-uuid.service - Generate new UUID for disk GPT if necessary... Jan 16 23:57:21.542810 kernel: sda: sda1 sda2 sda3 sda4 sda6 sda7 sda9 Jan 16 23:57:21.551855 kernel: sda: sda1 sda2 sda3 sda4 sda6 sda7 sda9 Jan 16 23:57:21.559812 kernel: sda: sda1 sda2 sda3 sda4 sda6 sda7 sda9 Jan 16 23:57:22.568371 disk-uuid[604]: The operation has completed successfully. Jan 16 23:57:22.573619 kernel: sda: sda1 sda2 sda3 sda4 sda6 sda7 sda9 Jan 16 23:57:22.635817 systemd[1]: disk-uuid.service: Deactivated successfully. Jan 16 23:57:22.637955 systemd[1]: Finished disk-uuid.service - Generate new UUID for disk GPT if necessary. Jan 16 23:57:22.665946 systemd[1]: Starting verity-setup.service - Verity Setup for /dev/mapper/usr... Jan 16 23:57:22.676189 sh[717]: Success Jan 16 23:57:22.701974 kernel: device-mapper: verity: sha256 using implementation "sha256-ce" Jan 16 23:57:22.957255 systemd[1]: Found device dev-mapper-usr.device - /dev/mapper/usr. Jan 16 23:57:22.965926 systemd[1]: Mounting sysusr-usr.mount - /sysusr/usr... Jan 16 23:57:22.971817 systemd[1]: Finished verity-setup.service - Verity Setup for /dev/mapper/usr. Jan 16 23:57:23.003527 kernel: BTRFS info (device dm-0): first mount of filesystem 257557f7-4bf9-4b29-86df-93ad67770d31 Jan 16 23:57:23.003582 kernel: BTRFS info (device dm-0): using crc32c (crc32c-generic) checksum algorithm Jan 16 23:57:23.009164 kernel: BTRFS warning (device dm-0): 'nologreplay' is deprecated, use 'rescue=nologreplay' instead Jan 16 23:57:23.013465 kernel: BTRFS info (device dm-0): disabling log replay at mount time Jan 16 23:57:23.016938 kernel: BTRFS info (device dm-0): using free space tree Jan 16 23:57:23.272835 systemd[1]: Mounted sysusr-usr.mount - /sysusr/usr. Jan 16 23:57:23.277417 systemd[1]: afterburn-network-kargs.service - Afterburn Initrd Setup Network Kernel Arguments was skipped because no trigger condition checks were met. Jan 16 23:57:23.290038 systemd[1]: Starting ignition-setup.service - Ignition (setup)... Jan 16 23:57:23.299871 systemd[1]: Starting parse-ip-for-networkd.service - Write systemd-networkd units from cmdline... Jan 16 23:57:23.325156 kernel: BTRFS info (device sda6): first mount of filesystem 629d412e-8b84-495a-b9b7-c361e81b0700 Jan 16 23:57:23.325222 kernel: BTRFS info (device sda6): using crc32c (crc32c-generic) checksum algorithm Jan 16 23:57:23.329219 kernel: BTRFS info (device sda6): using free space tree Jan 16 23:57:23.367744 kernel: BTRFS info (device sda6): auto enabling async discard Jan 16 23:57:23.375525 systemd[1]: mnt-oem.mount: Deactivated successfully. Jan 16 23:57:23.386661 kernel: BTRFS info (device sda6): last unmount of filesystem 629d412e-8b84-495a-b9b7-c361e81b0700 Jan 16 23:57:23.393150 systemd[1]: Finished ignition-setup.service - Ignition (setup). Jan 16 23:57:23.406994 systemd[1]: Starting ignition-fetch-offline.service - Ignition (fetch-offline)... Jan 16 23:57:23.437853 systemd[1]: Finished parse-ip-for-networkd.service - Write systemd-networkd units from cmdline. Jan 16 23:57:23.453956 systemd[1]: Starting systemd-networkd.service - Network Configuration... Jan 16 23:57:23.486513 systemd-networkd[901]: lo: Link UP Jan 16 23:57:23.486520 systemd-networkd[901]: lo: Gained carrier Jan 16 23:57:23.488118 systemd-networkd[901]: Enumeration completed Jan 16 23:57:23.488291 systemd[1]: Started systemd-networkd.service - Network Configuration. Jan 16 23:57:23.495513 systemd-networkd[901]: eth0: found matching network '/usr/lib/systemd/network/zz-default.network', based on potentially unpredictable interface name. Jan 16 23:57:23.495517 systemd-networkd[901]: eth0: Configuring with /usr/lib/systemd/network/zz-default.network. Jan 16 23:57:23.495898 systemd[1]: Reached target network.target - Network. Jan 16 23:57:23.576811 kernel: mlx5_core 1664:00:02.0 enP5732s1: Link up Jan 16 23:57:23.614807 kernel: hv_netvsc 7ced8d89-6cc4-7ced-8d89-6cc47ced8d89 eth0: Data path switched to VF: enP5732s1 Jan 16 23:57:23.615897 systemd-networkd[901]: enP5732s1: Link UP Jan 16 23:57:23.615985 systemd-networkd[901]: eth0: Link UP Jan 16 23:57:23.616080 systemd-networkd[901]: eth0: Gained carrier Jan 16 23:57:23.616089 systemd-networkd[901]: eth0: found matching network '/usr/lib/systemd/network/zz-default.network', based on potentially unpredictable interface name. Jan 16 23:57:23.635321 systemd-networkd[901]: enP5732s1: Gained carrier Jan 16 23:57:23.646836 systemd-networkd[901]: eth0: DHCPv4 address 10.200.20.16/24, gateway 10.200.20.1 acquired from 168.63.129.16 Jan 16 23:57:24.308159 ignition[873]: Ignition 2.19.0 Jan 16 23:57:24.308169 ignition[873]: Stage: fetch-offline Jan 16 23:57:24.311601 systemd[1]: Finished ignition-fetch-offline.service - Ignition (fetch-offline). Jan 16 23:57:24.308206 ignition[873]: no configs at "/usr/lib/ignition/base.d" Jan 16 23:57:24.327074 systemd[1]: Starting ignition-fetch.service - Ignition (fetch)... Jan 16 23:57:24.308214 ignition[873]: no config dir at "/usr/lib/ignition/base.platform.d/azure" Jan 16 23:57:24.308309 ignition[873]: parsed url from cmdline: "" Jan 16 23:57:24.308311 ignition[873]: no config URL provided Jan 16 23:57:24.308316 ignition[873]: reading system config file "/usr/lib/ignition/user.ign" Jan 16 23:57:24.308322 ignition[873]: no config at "/usr/lib/ignition/user.ign" Jan 16 23:57:24.308326 ignition[873]: failed to fetch config: resource requires networking Jan 16 23:57:24.308501 ignition[873]: Ignition finished successfully Jan 16 23:57:24.351631 ignition[925]: Ignition 2.19.0 Jan 16 23:57:24.351638 ignition[925]: Stage: fetch Jan 16 23:57:24.351838 ignition[925]: no configs at "/usr/lib/ignition/base.d" Jan 16 23:57:24.351848 ignition[925]: no config dir at "/usr/lib/ignition/base.platform.d/azure" Jan 16 23:57:24.351939 ignition[925]: parsed url from cmdline: "" Jan 16 23:57:24.351942 ignition[925]: no config URL provided Jan 16 23:57:24.351947 ignition[925]: reading system config file "/usr/lib/ignition/user.ign" Jan 16 23:57:24.351954 ignition[925]: no config at "/usr/lib/ignition/user.ign" Jan 16 23:57:24.351976 ignition[925]: GET http://169.254.169.254/metadata/instance/compute/userData?api-version=2021-01-01&format=text: attempt #1 Jan 16 23:57:24.485851 ignition[925]: GET result: OK Jan 16 23:57:24.485934 ignition[925]: config has been read from IMDS userdata Jan 16 23:57:24.491868 unknown[925]: fetched base config from "system" Jan 16 23:57:24.485946 ignition[925]: parsing config with SHA512: 8526f797200ab66f7032057f3825f750a03fb41af503dfdfec86db969eb24d53dae7002cb08c011c1f0ac1f58d18e91cd9b9b05201827c7ae5f740237a9e9ad2 Jan 16 23:57:24.491877 unknown[925]: fetched base config from "system" Jan 16 23:57:24.492082 ignition[925]: fetch: fetch complete Jan 16 23:57:24.491883 unknown[925]: fetched user config from "azure" Jan 16 23:57:24.492087 ignition[925]: fetch: fetch passed Jan 16 23:57:24.495995 systemd[1]: Finished ignition-fetch.service - Ignition (fetch). Jan 16 23:57:24.492132 ignition[925]: Ignition finished successfully Jan 16 23:57:24.517962 systemd[1]: Starting ignition-kargs.service - Ignition (kargs)... Jan 16 23:57:24.537929 ignition[932]: Ignition 2.19.0 Jan 16 23:57:24.537937 ignition[932]: Stage: kargs Jan 16 23:57:24.541812 systemd[1]: Finished ignition-kargs.service - Ignition (kargs). Jan 16 23:57:24.538106 ignition[932]: no configs at "/usr/lib/ignition/base.d" Jan 16 23:57:24.538115 ignition[932]: no config dir at "/usr/lib/ignition/base.platform.d/azure" Jan 16 23:57:24.538758 ignition[932]: kargs: kargs passed Jan 16 23:57:24.538837 ignition[932]: Ignition finished successfully Jan 16 23:57:24.564929 systemd[1]: Starting ignition-disks.service - Ignition (disks)... Jan 16 23:57:24.580214 ignition[938]: Ignition 2.19.0 Jan 16 23:57:24.580223 ignition[938]: Stage: disks Jan 16 23:57:24.580384 ignition[938]: no configs at "/usr/lib/ignition/base.d" Jan 16 23:57:24.580392 ignition[938]: no config dir at "/usr/lib/ignition/base.platform.d/azure" Jan 16 23:57:24.581040 ignition[938]: disks: createFilesystems: op(1): [started] waiting for devices [/dev/disk/by-partlabel/ROOT] Jan 16 23:57:24.590149 ignition[938]: disks: createFilesystems: op(1): [finished] waiting for devices [/dev/disk/by-partlabel/ROOT] Jan 16 23:57:24.590233 ignition[938]: disks: createFilesystems: created device alias for "/dev/disk/by-partlabel/ROOT": "/run/ignition/dev_aliases/dev/disk/by-partlabel/ROOT" -> "/dev/sda9" Jan 16 23:57:24.590286 ignition[938]: disks: createFilesystems: op(2): [started] determining filesystem type of "/dev/disk/by-partlabel/ROOT" Jan 16 23:57:24.639835 ignition[938]: disks: createFilesystems: op(2): [finished] determining filesystem type of "/dev/disk/by-partlabel/ROOT" Jan 16 23:57:24.639849 ignition[938]: disks: createFilesystems: found ext4 filesystem at "/dev/disk/by-partlabel/ROOT" with uuid "b70ce012-b356-4603-a688-ee0b3b7de551" and label "ROOT" Jan 16 23:57:24.639886 ignition[938]: disks: createFilesystems: op(3): [started] wiping filesystem signatures from "/run/ignition/dev_aliases/dev/disk/by-partlabel/ROOT" Jan 16 23:57:24.639893 ignition[938]: disks: createFilesystems: op(3): executing: "wipefs" "-a" "/run/ignition/dev_aliases/dev/disk/by-partlabel/ROOT" Jan 16 23:57:24.733125 ignition[938]: disks: createFilesystems: op(3): [finished] wiping filesystem signatures from "/run/ignition/dev_aliases/dev/disk/by-partlabel/ROOT" Jan 16 23:57:24.733160 ignition[938]: disks: createFilesystems: op(4): [started] creating "btrfs" filesystem on "/run/ignition/dev_aliases/dev/disk/by-partlabel/ROOT" Jan 16 23:57:24.733170 ignition[938]: disks: createFilesystems: op(4): executing: "mkfs.btrfs" "--label=ROOT" "--uuid=9aa5237a-ab6b-458b-a7e8-f25e2baef1a3" "--force" "/run/ignition/dev_aliases/dev/disk/by-partlabel/ROOT" Jan 16 23:57:25.046210 ignition[938]: disks: createFilesystems: op(4): [finished] creating "btrfs" filesystem on "/run/ignition/dev_aliases/dev/disk/by-partlabel/ROOT" Jan 16 23:57:25.055613 kernel: BTRFS: device label ROOT devid 1 transid 6 /run/ignition/dev_aliases/dev/disk/by-partlabel/ROOT scanned by mkfs.btrfs (945) Jan 16 23:57:25.046279 ignition[938]: disks: createFilesystems: op(5): [started] waiting for triggered uevent Jan 16 23:57:25.046286 ignition[938]: disks: createFilesystems: op(5): executing: "udevadm" "trigger" "--settle" "/dev/sda9" Jan 16 23:57:25.532965 systemd-networkd[901]: eth0: Gained IPv6LL Jan 16 23:57:26.517679 ignition[938]: disks: createFilesystems: op(5): [finished] waiting for triggered uevent Jan 16 23:57:26.517699 ignition[938]: disks: disks passed Jan 16 23:57:26.519890 systemd[1]: Finished ignition-disks.service - Ignition (disks). Jan 16 23:57:26.517768 ignition[938]: Ignition finished successfully Jan 16 23:57:26.530872 systemd[1]: Reached target initrd-root-device.target - Initrd Root Device. Jan 16 23:57:26.537837 systemd[1]: Reached target local-fs-pre.target - Preparation for Local File Systems. Jan 16 23:57:26.547699 systemd[1]: Reached target local-fs.target - Local File Systems. Jan 16 23:57:26.555387 systemd[1]: Reached target sysinit.target - System Initialization. Jan 16 23:57:26.564596 systemd[1]: Reached target basic.target - Basic System. Jan 16 23:57:26.591069 systemd[1]: Starting systemd-fsck-root.service - File System Check on /dev/disk/by-label/ROOT... Jan 16 23:57:26.610730 systemd[1]: Finished systemd-fsck-root.service - File System Check on /dev/disk/by-label/ROOT. Jan 16 23:57:26.624963 systemd[1]: Mounting sysroot.mount - /sysroot... Jan 16 23:57:26.649202 kernel: BTRFS info (device sda9): first mount of filesystem 9aa5237a-ab6b-458b-a7e8-f25e2baef1a3 Jan 16 23:57:26.649252 kernel: BTRFS info (device sda9): using crc32c (crc32c-generic) checksum algorithm Jan 16 23:57:26.652722 kernel: BTRFS info (device sda9): using free space tree Jan 16 23:57:26.662624 kernel: BTRFS info (device sda9): auto enabling async discard Jan 16 23:57:26.662668 kernel: BTRFS info (device sda9): checking UUID tree Jan 16 23:57:26.664553 systemd[1]: Mounted sysroot.mount - /sysroot. Jan 16 23:57:26.668269 systemd[1]: Reached target initrd-root-fs.target - Initrd Root File System. Jan 16 23:57:26.687873 systemd[1]: Mounting sysroot-oem.mount - /sysroot/oem... Jan 16 23:57:26.693950 systemd[1]: Mounting sysroot-usr.mount - /sysroot/usr... Jan 16 23:57:26.705549 systemd[1]: Starting flatcar-metadata-hostname.service - Flatcar Metadata Hostname Agent... Jan 16 23:57:26.714023 systemd[1]: ignition-remount-sysroot.service - Remount /sysroot read-write for Ignition was skipped because of an unmet condition check (ConditionPathIsReadWrite=!/sysroot). Jan 16 23:57:26.714064 systemd[1]: Reached target ignition-diskful.target - Ignition Boot Disk Setup. Jan 16 23:57:26.760965 kernel: BTRFS: device label OEM devid 1 transid 11 /dev/sda6 scanned by mount (982) Jan 16 23:57:26.760998 kernel: BTRFS info (device sda6): first mount of filesystem 629d412e-8b84-495a-b9b7-c361e81b0700 Jan 16 23:57:26.761009 kernel: BTRFS info (device sda6): using crc32c (crc32c-generic) checksum algorithm Jan 16 23:57:26.761019 kernel: BTRFS info (device sda6): using free space tree Jan 16 23:57:26.761029 kernel: BTRFS info (device sda6): auto enabling async discard Jan 16 23:57:26.752425 systemd[1]: Mounted sysroot-usr.mount - /sysroot/usr. Jan 16 23:57:26.773852 systemd[1]: Mounted sysroot-oem.mount - /sysroot/oem. Jan 16 23:57:26.787924 systemd[1]: Starting initrd-setup-root.service - Root filesystem setup... Jan 16 23:57:26.914428 initrd-setup-root[1007]: cut: /sysroot/etc/passwd: No such file or directory Jan 16 23:57:26.953656 initrd-setup-root[1014]: cut: /sysroot/etc/group: No such file or directory Jan 16 23:57:26.979707 initrd-setup-root[1021]: cut: /sysroot/etc/shadow: No such file or directory Jan 16 23:57:26.988050 initrd-setup-root[1028]: cut: /sysroot/etc/gshadow: No such file or directory Jan 16 23:57:27.136152 coreos-metadata[984]: Jan 16 23:57:27.136 INFO Fetching http://168.63.129.16/?comp=versions: Attempt #1 Jan 16 23:57:27.143083 coreos-metadata[984]: Jan 16 23:57:27.142 INFO Fetch successful Jan 16 23:57:27.143083 coreos-metadata[984]: Jan 16 23:57:27.143 INFO Fetching http://169.254.169.254/metadata/instance/compute/name?api-version=2017-08-01&format=text: Attempt #1 Jan 16 23:57:27.156882 coreos-metadata[984]: Jan 16 23:57:27.156 INFO Fetch successful Jan 16 23:57:27.161662 coreos-metadata[984]: Jan 16 23:57:27.156 INFO wrote hostname ci-4081.3.6-n-189a678227 to /sysroot/etc/hostname Jan 16 23:57:27.162514 systemd[1]: Finished flatcar-metadata-hostname.service - Flatcar Metadata Hostname Agent. Jan 16 23:57:27.529648 systemd[1]: Finished initrd-setup-root.service - Root filesystem setup. Jan 16 23:57:27.547049 systemd[1]: Starting ignition-mount.service - Ignition (mount)... Jan 16 23:57:27.553442 systemd[1]: Starting sysroot-boot.service - /sysroot/boot... Jan 16 23:57:27.569517 systemd[1]: sysroot-oem.mount: Deactivated successfully. Jan 16 23:57:27.579817 kernel: BTRFS info (device sda6): last unmount of filesystem 629d412e-8b84-495a-b9b7-c361e81b0700 Jan 16 23:57:27.605285 ignition[1100]: INFO : Ignition 2.19.0 Jan 16 23:57:27.608923 ignition[1100]: INFO : Stage: mount Jan 16 23:57:27.608923 ignition[1100]: INFO : no configs at "/usr/lib/ignition/base.d" Jan 16 23:57:27.608923 ignition[1100]: INFO : no config dir at "/usr/lib/ignition/base.platform.d/azure" Jan 16 23:57:27.634080 ignition[1100]: INFO : mount: op(1): [started] mounting "/dev/disk/by-partlabel/ROOT" at "/sysroot/tmp/_translate-filesystem-0-ign1" with type "btrfs" and options "" Jan 16 23:57:27.634080 ignition[1100]: DEBUG : mount: op(1): executing: "mount" "-o" "" "-t" "btrfs" "/dev/disk/by-partlabel/ROOT" "/sysroot/tmp/_translate-filesystem-0-ign1" Jan 16 23:57:27.634080 ignition[1100]: INFO : mount: op(1): [finished] mounting "/dev/disk/by-partlabel/ROOT" at "/sysroot/tmp/_translate-filesystem-0-ign1" with type "btrfs" and options "" Jan 16 23:57:27.634080 ignition[1100]: INFO : mount: mount passed Jan 16 23:57:27.634080 ignition[1100]: INFO : Ignition finished successfully Jan 16 23:57:27.610146 systemd[1]: Finished sysroot-boot.service - /sysroot/boot. Jan 16 23:57:27.619390 systemd[1]: Finished ignition-mount.service - Ignition (mount). Jan 16 23:57:27.654024 systemd[1]: Starting ignition-files.service - Ignition (files)... Jan 16 23:57:27.675993 systemd[1]: Mounting sysroot-oem.mount - /sysroot/oem... Jan 16 23:57:27.709806 kernel: BTRFS: device label OEM devid 1 transid 12 /dev/sda6 scanned by mount (1112) Jan 16 23:57:27.720623 kernel: BTRFS info (device sda6): first mount of filesystem 629d412e-8b84-495a-b9b7-c361e81b0700 Jan 16 23:57:27.720681 kernel: BTRFS info (device sda6): using crc32c (crc32c-generic) checksum algorithm Jan 16 23:57:27.724072 kernel: BTRFS info (device sda6): using free space tree Jan 16 23:57:27.730803 kernel: BTRFS info (device sda6): auto enabling async discard Jan 16 23:57:27.732754 systemd[1]: Mounted sysroot-oem.mount - /sysroot/oem. Jan 16 23:57:27.760702 ignition[1129]: INFO : Ignition 2.19.0 Jan 16 23:57:27.760702 ignition[1129]: INFO : Stage: files Jan 16 23:57:27.767257 ignition[1129]: INFO : no configs at "/usr/lib/ignition/base.d" Jan 16 23:57:27.767257 ignition[1129]: INFO : no config dir at "/usr/lib/ignition/base.platform.d/azure" Jan 16 23:57:27.767257 ignition[1129]: DEBUG : files: compiled without relabeling support, skipping Jan 16 23:57:27.767257 ignition[1129]: INFO : files: ensureUsers: op(1): [started] creating or modifying user "core" Jan 16 23:57:27.767257 ignition[1129]: DEBUG : files: ensureUsers: op(1): executing: "usermod" "--root" "/sysroot" "core" Jan 16 23:57:27.811278 ignition[1129]: INFO : files: ensureUsers: op(1): [finished] creating or modifying user "core" Jan 16 23:57:27.817612 ignition[1129]: INFO : files: ensureUsers: op(2): [started] adding ssh keys to user "core" Jan 16 23:57:27.823660 ignition[1129]: INFO : files: ensureUsers: op(2): [finished] adding ssh keys to user "core" Jan 16 23:57:27.823607 unknown[1129]: wrote ssh authorized keys file for user: core Jan 16 23:57:27.842254 ignition[1129]: INFO : files: createFilesystemsFiles: createFiles: op(3): [started] writing file "/sysroot/tmp/_translate-filesystem-0-ign1/etc/flatcar/update.conf" Jan 16 23:57:27.852114 ignition[1129]: INFO : files: createFilesystemsFiles: createFiles: op(3): [finished] writing file "/sysroot/tmp/_translate-filesystem-0-ign1/etc/flatcar/update.conf" Jan 16 23:57:27.852114 ignition[1129]: INFO : files: createResultFile: createFiles: op(4): [started] writing file "/sysroot/etc/.ignition-result.json" Jan 16 23:57:27.852114 ignition[1129]: INFO : files: createResultFile: createFiles: op(4): [finished] writing file "/sysroot/etc/.ignition-result.json" Jan 16 23:57:27.852114 ignition[1129]: INFO : files: files passed Jan 16 23:57:27.852114 ignition[1129]: INFO : Ignition finished successfully Jan 16 23:57:27.844613 systemd[1]: Finished ignition-files.service - Ignition (files). Jan 16 23:57:27.875524 systemd[1]: Starting ignition-quench.service - Ignition (record completion)... Jan 16 23:57:27.888987 systemd[1]: Starting initrd-setup-root-after-ignition.service - Root filesystem completion... Jan 16 23:57:27.898301 systemd[1]: ignition-quench.service: Deactivated successfully. Jan 16 23:57:27.899852 systemd[1]: Finished ignition-quench.service - Ignition (record completion). Jan 16 23:57:27.942172 kernel: BTRFS info (device sda9): setting incompat feature flag for COMPRESS_ZSTD (0x10) Jan 16 23:57:27.942713 initrd-setup-root-after-ignition[1158]: grep: /sysroot/etc/flatcar/enabled-sysext.conf: No such file or directory Jan 16 23:57:27.942713 initrd-setup-root-after-ignition[1158]: grep: /sysroot/usr/share/flatcar/enabled-sysext.conf: No such file or directory Jan 16 23:57:27.957159 initrd-setup-root-after-ignition[1162]: grep: /sysroot/etc/flatcar/enabled-sysext.conf: No such file or directory Jan 16 23:57:27.951079 systemd[1]: Finished initrd-setup-root-after-ignition.service - Root filesystem completion. Jan 16 23:57:27.963093 systemd[1]: Reached target ignition-complete.target - Ignition Complete. Jan 16 23:57:27.988040 systemd[1]: Starting initrd-parse-etc.service - Mountpoints Configured in the Real Root... Jan 16 23:57:28.015774 systemd[1]: initrd-parse-etc.service: Deactivated successfully. Jan 16 23:57:28.015917 systemd[1]: Finished initrd-parse-etc.service - Mountpoints Configured in the Real Root. Jan 16 23:57:28.026128 systemd[1]: Reached target initrd-fs.target - Initrd File Systems. Jan 16 23:57:28.036015 systemd[1]: Reached target initrd.target - Initrd Default Target. Jan 16 23:57:28.044725 systemd[1]: dracut-mount.service - dracut mount hook was skipped because no trigger condition checks were met. Jan 16 23:57:28.063050 systemd[1]: Starting dracut-pre-pivot.service - dracut pre-pivot and cleanup hook... Jan 16 23:57:28.080392 systemd[1]: Finished dracut-pre-pivot.service - dracut pre-pivot and cleanup hook. Jan 16 23:57:28.097948 systemd[1]: Starting initrd-cleanup.service - Cleaning Up and Shutting Down Daemons... Jan 16 23:57:28.114774 systemd[1]: Stopped target nss-lookup.target - Host and Network Name Lookups. Jan 16 23:57:28.125277 systemd[1]: Stopped target remote-cryptsetup.target - Remote Encrypted Volumes. Jan 16 23:57:28.130842 systemd[1]: Stopped target timers.target - Timer Units. Jan 16 23:57:28.139810 systemd[1]: dracut-pre-pivot.service: Deactivated successfully. Jan 16 23:57:28.139936 systemd[1]: Stopped dracut-pre-pivot.service - dracut pre-pivot and cleanup hook. Jan 16 23:57:28.152832 systemd[1]: Stopped target initrd.target - Initrd Default Target. Jan 16 23:57:28.157518 systemd[1]: Stopped target basic.target - Basic System. Jan 16 23:57:28.166815 systemd[1]: Stopped target ignition-complete.target - Ignition Complete. Jan 16 23:57:28.176234 systemd[1]: Stopped target ignition-diskful.target - Ignition Boot Disk Setup. Jan 16 23:57:28.185146 systemd[1]: Stopped target initrd-root-device.target - Initrd Root Device. Jan 16 23:57:28.194861 systemd[1]: Stopped target remote-fs.target - Remote File Systems. Jan 16 23:57:28.204443 systemd[1]: Stopped target remote-fs-pre.target - Preparation for Remote File Systems. Jan 16 23:57:28.214757 systemd[1]: Stopped target sysinit.target - System Initialization. Jan 16 23:57:28.223904 systemd[1]: Stopped target local-fs.target - Local File Systems. Jan 16 23:57:28.233774 systemd[1]: Stopped target swap.target - Swaps. Jan 16 23:57:28.242026 systemd[1]: dracut-pre-mount.service: Deactivated successfully. Jan 16 23:57:28.242146 systemd[1]: Stopped dracut-pre-mount.service - dracut pre-mount hook. Jan 16 23:57:28.254643 systemd[1]: Stopped target cryptsetup.target - Local Encrypted Volumes. Jan 16 23:57:28.259806 systemd[1]: Stopped target cryptsetup-pre.target - Local Encrypted Volumes (Pre). Jan 16 23:57:28.269291 systemd[1]: clevis-luks-askpass.path: Deactivated successfully. Jan 16 23:57:28.278701 systemd[1]: Stopped clevis-luks-askpass.path - Forward Password Requests to Clevis Directory Watch. Jan 16 23:57:28.284455 systemd[1]: dracut-initqueue.service: Deactivated successfully. Jan 16 23:57:28.284569 systemd[1]: Stopped dracut-initqueue.service - dracut initqueue hook. Jan 16 23:57:28.298767 systemd[1]: initrd-setup-root-after-ignition.service: Deactivated successfully. Jan 16 23:57:28.298889 systemd[1]: Stopped initrd-setup-root-after-ignition.service - Root filesystem completion. Jan 16 23:57:28.304931 systemd[1]: ignition-files.service: Deactivated successfully. Jan 16 23:57:28.305022 systemd[1]: Stopped ignition-files.service - Ignition (files). Jan 16 23:57:28.315373 systemd[1]: flatcar-metadata-hostname.service: Deactivated successfully. Jan 16 23:57:28.315463 systemd[1]: Stopped flatcar-metadata-hostname.service - Flatcar Metadata Hostname Agent. Jan 16 23:57:28.346059 systemd[1]: Stopping ignition-mount.service - Ignition (mount)... Jan 16 23:57:28.360048 systemd[1]: Stopping sysroot-boot.service - /sysroot/boot... Jan 16 23:57:28.392433 ignition[1182]: INFO : Ignition 2.19.0 Jan 16 23:57:28.392433 ignition[1182]: INFO : Stage: umount Jan 16 23:57:28.392433 ignition[1182]: INFO : no configs at "/usr/lib/ignition/base.d" Jan 16 23:57:28.392433 ignition[1182]: INFO : no config dir at "/usr/lib/ignition/base.platform.d/azure" Jan 16 23:57:28.392433 ignition[1182]: INFO : umount: op(1): [started] umounting "/sysroot/tmp/_translate-filesystem-0-ign1" Jan 16 23:57:28.392433 ignition[1182]: INFO : umount: op(1): [finished] umounting "/sysroot/tmp/_translate-filesystem-0-ign1" Jan 16 23:57:28.392433 ignition[1182]: INFO : umount: umount passed Jan 16 23:57:28.392433 ignition[1182]: INFO : Ignition finished successfully Jan 16 23:57:28.374297 systemd[1]: systemd-udev-trigger.service: Deactivated successfully. Jan 16 23:57:28.374543 systemd[1]: Stopped systemd-udev-trigger.service - Coldplug All udev Devices. Jan 16 23:57:28.380333 systemd[1]: dracut-pre-trigger.service: Deactivated successfully. Jan 16 23:57:28.380492 systemd[1]: Stopped dracut-pre-trigger.service - dracut pre-trigger hook. Jan 16 23:57:28.389808 systemd[1]: sysroot-tmp-_translate\x2dfilesystem\x2d0\x2dign1.mount: Deactivated successfully. Jan 16 23:57:28.390603 systemd[1]: ignition-mount.service: Deactivated successfully. Jan 16 23:57:28.390705 systemd[1]: Stopped ignition-mount.service - Ignition (mount). Jan 16 23:57:28.399637 systemd[1]: ignition-disks.service: Deactivated successfully. Jan 16 23:57:28.399902 systemd[1]: Stopped ignition-disks.service - Ignition (disks). Jan 16 23:57:28.409724 systemd[1]: ignition-kargs.service: Deactivated successfully. Jan 16 23:57:28.409807 systemd[1]: Stopped ignition-kargs.service - Ignition (kargs). Jan 16 23:57:28.414706 systemd[1]: ignition-fetch.service: Deactivated successfully. Jan 16 23:57:28.414750 systemd[1]: Stopped ignition-fetch.service - Ignition (fetch). Jan 16 23:57:28.423557 systemd[1]: Stopped target network.target - Network. Jan 16 23:57:28.432722 systemd[1]: ignition-fetch-offline.service: Deactivated successfully. Jan 16 23:57:28.432782 systemd[1]: Stopped ignition-fetch-offline.service - Ignition (fetch-offline). Jan 16 23:57:28.445171 systemd[1]: Stopped target paths.target - Path Units. Jan 16 23:57:28.449448 systemd[1]: systemd-ask-password-console.path: Deactivated successfully. Jan 16 23:57:28.452813 systemd[1]: Stopped systemd-ask-password-console.path - Dispatch Password Requests to Console Directory Watch. Jan 16 23:57:28.461202 systemd[1]: Stopped target slices.target - Slice Units. Jan 16 23:57:28.468515 systemd[1]: Stopped target sockets.target - Socket Units. Jan 16 23:57:28.476616 systemd[1]: iscsid.socket: Deactivated successfully. Jan 16 23:57:28.476665 systemd[1]: Closed iscsid.socket - Open-iSCSI iscsid Socket. Jan 16 23:57:28.485176 systemd[1]: iscsiuio.socket: Deactivated successfully. Jan 16 23:57:28.485219 systemd[1]: Closed iscsiuio.socket - Open-iSCSI iscsiuio Socket. Jan 16 23:57:28.494519 systemd[1]: ignition-setup.service: Deactivated successfully. Jan 16 23:57:28.494569 systemd[1]: Stopped ignition-setup.service - Ignition (setup). Jan 16 23:57:28.503300 systemd[1]: ignition-setup-pre.service: Deactivated successfully. Jan 16 23:57:28.503338 systemd[1]: Stopped ignition-setup-pre.service - Ignition env setup. Jan 16 23:57:28.512993 systemd[1]: Stopping systemd-networkd.service - Network Configuration... Jan 16 23:57:28.522933 systemd[1]: Stopping systemd-resolved.service - Network Name Resolution... Jan 16 23:57:28.532466 systemd[1]: sysroot-boot.mount: Deactivated successfully. Jan 16 23:57:28.534404 systemd[1]: initrd-cleanup.service: Deactivated successfully. Jan 16 23:57:28.746717 kernel: hv_netvsc 7ced8d89-6cc4-7ced-8d89-6cc47ced8d89 eth0: Data path switched from VF: enP5732s1 Jan 16 23:57:28.534505 systemd[1]: Finished initrd-cleanup.service - Cleaning Up and Shutting Down Daemons. Jan 16 23:57:28.535595 systemd-networkd[901]: eth0: DHCPv6 lease lost Jan 16 23:57:28.543404 systemd[1]: systemd-resolved.service: Deactivated successfully. Jan 16 23:57:28.543540 systemd[1]: Stopped systemd-resolved.service - Network Name Resolution. Jan 16 23:57:28.554370 systemd[1]: systemd-networkd.service: Deactivated successfully. Jan 16 23:57:28.554544 systemd[1]: Stopped systemd-networkd.service - Network Configuration. Jan 16 23:57:28.563365 systemd[1]: sysroot-boot.service: Deactivated successfully. Jan 16 23:57:28.563466 systemd[1]: Stopped sysroot-boot.service - /sysroot/boot. Jan 16 23:57:28.573659 systemd[1]: systemd-networkd.socket: Deactivated successfully. Jan 16 23:57:28.573721 systemd[1]: Closed systemd-networkd.socket - Network Service Netlink Socket. Jan 16 23:57:28.581032 systemd[1]: initrd-setup-root.service: Deactivated successfully. Jan 16 23:57:28.581089 systemd[1]: Stopped initrd-setup-root.service - Root filesystem setup. Jan 16 23:57:28.604347 systemd[1]: Stopping network-cleanup.service - Network Cleanup... Jan 16 23:57:28.611776 systemd[1]: parse-ip-for-networkd.service: Deactivated successfully. Jan 16 23:57:28.611871 systemd[1]: Stopped parse-ip-for-networkd.service - Write systemd-networkd units from cmdline. Jan 16 23:57:28.621463 systemd[1]: systemd-sysctl.service: Deactivated successfully. Jan 16 23:57:28.621512 systemd[1]: Stopped systemd-sysctl.service - Apply Kernel Variables. Jan 16 23:57:28.630864 systemd[1]: systemd-modules-load.service: Deactivated successfully. Jan 16 23:57:28.630916 systemd[1]: Stopped systemd-modules-load.service - Load Kernel Modules. Jan 16 23:57:28.642286 systemd[1]: systemd-tmpfiles-setup.service: Deactivated successfully. Jan 16 23:57:28.642326 systemd[1]: Stopped systemd-tmpfiles-setup.service - Create System Files and Directories. Jan 16 23:57:28.651722 systemd[1]: Stopping systemd-udevd.service - Rule-based Manager for Device Events and Files... Jan 16 23:57:28.692126 systemd[1]: systemd-udevd.service: Deactivated successfully. Jan 16 23:57:28.692294 systemd[1]: Stopped systemd-udevd.service - Rule-based Manager for Device Events and Files. Jan 16 23:57:28.702984 systemd[1]: systemd-udevd-control.socket: Deactivated successfully. Jan 16 23:57:28.703055 systemd[1]: Closed systemd-udevd-control.socket - udev Control Socket. Jan 16 23:57:28.712328 systemd[1]: systemd-udevd-kernel.socket: Deactivated successfully. Jan 16 23:57:28.712369 systemd[1]: Closed systemd-udevd-kernel.socket - udev Kernel Socket. Jan 16 23:57:28.721981 systemd[1]: dracut-pre-udev.service: Deactivated successfully. Jan 16 23:57:28.722036 systemd[1]: Stopped dracut-pre-udev.service - dracut pre-udev hook. Jan 16 23:57:28.742726 systemd[1]: dracut-cmdline.service: Deactivated successfully. Jan 16 23:57:28.742811 systemd[1]: Stopped dracut-cmdline.service - dracut cmdline hook. Jan 16 23:57:28.968245 systemd-journald[217]: Received SIGTERM from PID 1 (systemd). Jan 16 23:57:28.756570 systemd[1]: dracut-cmdline-ask.service: Deactivated successfully. Jan 16 23:57:28.756708 systemd[1]: Stopped dracut-cmdline-ask.service - dracut ask for additional cmdline parameters. Jan 16 23:57:28.784059 systemd[1]: Starting initrd-udevadm-cleanup-db.service - Cleanup udev Database... Jan 16 23:57:28.794863 systemd[1]: systemd-tmpfiles-setup-dev.service: Deactivated successfully. Jan 16 23:57:28.794942 systemd[1]: Stopped systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev. Jan 16 23:57:28.806922 systemd[1]: systemd-tmpfiles-setup-dev-early.service: Deactivated successfully. Jan 16 23:57:28.806969 systemd[1]: Stopped systemd-tmpfiles-setup-dev-early.service - Create Static Device Nodes in /dev gracefully. Jan 16 23:57:28.816736 systemd[1]: kmod-static-nodes.service: Deactivated successfully. Jan 16 23:57:28.816773 systemd[1]: Stopped kmod-static-nodes.service - Create List of Static Device Nodes. Jan 16 23:57:28.827414 systemd[1]: systemd-vconsole-setup.service: Deactivated successfully. Jan 16 23:57:28.827451 systemd[1]: Stopped systemd-vconsole-setup.service - Virtual Console Setup. Jan 16 23:57:28.837158 systemd[1]: network-cleanup.service: Deactivated successfully. Jan 16 23:57:28.837258 systemd[1]: Stopped network-cleanup.service - Network Cleanup. Jan 16 23:57:28.846361 systemd[1]: initrd-udevadm-cleanup-db.service: Deactivated successfully. Jan 16 23:57:28.846447 systemd[1]: Finished initrd-udevadm-cleanup-db.service - Cleanup udev Database. Jan 16 23:57:28.856860 systemd[1]: Reached target initrd-switch-root.target - Switch Root. Jan 16 23:57:28.877054 systemd[1]: Starting initrd-switch-root.service - Switch Root... Jan 16 23:57:28.898227 systemd[1]: Switching root. Jan 16 23:57:29.007739 systemd-journald[217]: Journal stopped Jan 16 23:57:33.088060 kernel: SELinux: policy capability network_peer_controls=1 Jan 16 23:57:33.088093 kernel: SELinux: policy capability open_perms=1 Jan 16 23:57:33.088103 kernel: SELinux: policy capability extended_socket_class=1 Jan 16 23:57:33.088112 kernel: SELinux: policy capability always_check_network=0 Jan 16 23:57:33.088124 kernel: SELinux: policy capability cgroup_seclabel=1 Jan 16 23:57:33.088132 kernel: SELinux: policy capability nnp_nosuid_transition=1 Jan 16 23:57:33.088141 kernel: SELinux: policy capability genfs_seclabel_symlinks=0 Jan 16 23:57:33.088149 kernel: SELinux: policy capability ioctl_skip_cloexec=0 Jan 16 23:57:33.088157 kernel: audit: type=1403 audit(1768607849.466:2): auid=4294967295 ses=4294967295 lsm=selinux res=1 Jan 16 23:57:33.088167 systemd[1]: Successfully loaded SELinux policy in 167.443ms. Jan 16 23:57:33.088179 systemd[1]: Relabeled /dev, /dev/shm, /run, /sys/fs/cgroup in 10.691ms. Jan 16 23:57:33.088189 systemd[1]: systemd 255 running in system mode (+PAM +AUDIT +SELINUX -APPARMOR +IMA +SMACK +SECCOMP +GCRYPT -GNUTLS +OPENSSL -ACL +BLKID +CURL +ELFUTILS -FIDO2 +IDN2 -IDN +IPTC +KMOD +LIBCRYPTSETUP +LIBFDISK +PCRE2 -PWQUALITY -P11KIT -QRENCODE +TPM2 +BZIP2 +LZ4 +XZ +ZLIB +ZSTD -BPF_FRAMEWORK -XKBCOMMON +UTMP -SYSVINIT default-hierarchy=unified) Jan 16 23:57:33.088198 systemd[1]: Detected virtualization microsoft. Jan 16 23:57:33.088207 systemd[1]: Detected architecture arm64. Jan 16 23:57:33.088218 systemd[1]: Detected first boot. Jan 16 23:57:33.088230 systemd[1]: Hostname set to . Jan 16 23:57:33.088239 systemd[1]: Initializing machine ID from random generator. Jan 16 23:57:33.088248 zram_generator::config[1224]: No configuration found. Jan 16 23:57:33.088258 systemd[1]: Populated /etc with preset unit settings. Jan 16 23:57:33.088268 systemd[1]: initrd-switch-root.service: Deactivated successfully. Jan 16 23:57:33.088277 systemd[1]: Stopped initrd-switch-root.service - Switch Root. Jan 16 23:57:33.088286 systemd[1]: systemd-journald.service: Scheduled restart job, restart counter is at 1. Jan 16 23:57:33.088298 systemd[1]: Created slice system-addon\x2dconfig.slice - Slice /system/addon-config. Jan 16 23:57:33.088307 systemd[1]: Created slice system-addon\x2drun.slice - Slice /system/addon-run. Jan 16 23:57:33.088317 systemd[1]: Created slice system-getty.slice - Slice /system/getty. Jan 16 23:57:33.088326 systemd[1]: Created slice system-modprobe.slice - Slice /system/modprobe. Jan 16 23:57:33.088335 systemd[1]: Created slice system-serial\x2dgetty.slice - Slice /system/serial-getty. Jan 16 23:57:33.088344 systemd[1]: Created slice system-system\x2dcloudinit.slice - Slice /system/system-cloudinit. Jan 16 23:57:33.088354 systemd[1]: Created slice system-systemd\x2dfsck.slice - Slice /system/systemd-fsck. Jan 16 23:57:33.088365 systemd[1]: Created slice user.slice - User and Session Slice. Jan 16 23:57:33.088375 systemd[1]: Started clevis-luks-askpass.path - Forward Password Requests to Clevis Directory Watch. Jan 16 23:57:33.088384 systemd[1]: Started systemd-ask-password-console.path - Dispatch Password Requests to Console Directory Watch. Jan 16 23:57:33.088394 systemd[1]: Started systemd-ask-password-wall.path - Forward Password Requests to Wall Directory Watch. Jan 16 23:57:33.088403 systemd[1]: Set up automount boot.automount - Boot partition Automount Point. Jan 16 23:57:33.088412 systemd[1]: Set up automount proc-sys-fs-binfmt_misc.automount - Arbitrary Executable File Formats File System Automount Point. Jan 16 23:57:33.088423 systemd[1]: Expecting device dev-disk-by\x2dlabel-OEM.device - /dev/disk/by-label/OEM... Jan 16 23:57:33.088432 systemd[1]: Expecting device dev-ttyAMA0.device - /dev/ttyAMA0... Jan 16 23:57:33.088443 systemd[1]: Reached target cryptsetup-pre.target - Local Encrypted Volumes (Pre). Jan 16 23:57:33.088452 systemd[1]: Stopped target initrd-switch-root.target - Switch Root. Jan 16 23:57:33.088462 systemd[1]: Stopped target initrd-fs.target - Initrd File Systems. Jan 16 23:57:33.088473 systemd[1]: Stopped target initrd-root-fs.target - Initrd Root File System. Jan 16 23:57:33.088483 systemd[1]: Reached target integritysetup.target - Local Integrity Protected Volumes. Jan 16 23:57:33.088493 systemd[1]: Reached target remote-cryptsetup.target - Remote Encrypted Volumes. Jan 16 23:57:33.088502 systemd[1]: Reached target remote-fs.target - Remote File Systems. Jan 16 23:57:33.088512 systemd[1]: Reached target slices.target - Slice Units. Jan 16 23:57:33.088523 systemd[1]: Reached target swap.target - Swaps. Jan 16 23:57:33.088532 systemd[1]: Reached target veritysetup.target - Local Verity Protected Volumes. Jan 16 23:57:33.088542 systemd[1]: Listening on systemd-coredump.socket - Process Core Dump Socket. Jan 16 23:57:33.088552 systemd[1]: Listening on systemd-networkd.socket - Network Service Netlink Socket. Jan 16 23:57:33.088561 systemd[1]: Listening on systemd-udevd-control.socket - udev Control Socket. Jan 16 23:57:33.088571 systemd[1]: Listening on systemd-udevd-kernel.socket - udev Kernel Socket. Jan 16 23:57:33.088582 systemd[1]: Listening on systemd-userdbd.socket - User Database Manager Socket. Jan 16 23:57:33.088592 systemd[1]: Mounting dev-hugepages.mount - Huge Pages File System... Jan 16 23:57:33.088602 systemd[1]: Mounting dev-mqueue.mount - POSIX Message Queue File System... Jan 16 23:57:33.088612 systemd[1]: Mounting media.mount - External Media Directory... Jan 16 23:57:33.088621 systemd[1]: Mounting sys-kernel-debug.mount - Kernel Debug File System... Jan 16 23:57:33.088632 systemd[1]: Mounting sys-kernel-tracing.mount - Kernel Trace File System... Jan 16 23:57:33.088641 systemd[1]: tmp.mount: Directory /tmp to mount over is not empty, mounting anyway. Jan 16 23:57:33.088653 systemd[1]: Mounting tmp.mount - Temporary Directory /tmp... Jan 16 23:57:33.088663 systemd[1]: var-lib-machines.mount - Virtual Machine and Container Storage (Compatibility) was skipped because of an unmet condition check (ConditionPathExists=/var/lib/machines.raw). Jan 16 23:57:33.088673 systemd[1]: Reached target machines.target - Containers. Jan 16 23:57:33.088683 systemd[1]: Starting flatcar-tmpfiles.service - Create missing system files... Jan 16 23:57:33.088693 systemd[1]: ignition-delete-config.service - Ignition (delete config) was skipped because no trigger condition checks were met. Jan 16 23:57:33.088703 systemd[1]: Starting kmod-static-nodes.service - Create List of Static Device Nodes... Jan 16 23:57:33.088713 systemd[1]: Starting modprobe@configfs.service - Load Kernel Module configfs... Jan 16 23:57:33.088722 systemd[1]: Starting modprobe@dm_mod.service - Load Kernel Module dm_mod... Jan 16 23:57:33.088734 systemd[1]: Starting modprobe@drm.service - Load Kernel Module drm... Jan 16 23:57:33.088743 systemd[1]: Starting modprobe@efi_pstore.service - Load Kernel Module efi_pstore... Jan 16 23:57:33.088753 systemd[1]: Starting modprobe@fuse.service - Load Kernel Module fuse... Jan 16 23:57:33.088763 systemd[1]: Starting modprobe@loop.service - Load Kernel Module loop... Jan 16 23:57:33.088773 systemd[1]: setup-nsswitch.service - Create /etc/nsswitch.conf was skipped because of an unmet condition check (ConditionPathExists=!/etc/nsswitch.conf). Jan 16 23:57:33.088782 systemd[1]: systemd-fsck-root.service: Deactivated successfully. Jan 16 23:57:33.088802 systemd[1]: Stopped systemd-fsck-root.service - File System Check on Root Device. Jan 16 23:57:33.088815 systemd[1]: systemd-fsck-usr.service: Deactivated successfully. Jan 16 23:57:33.088828 systemd[1]: Stopped systemd-fsck-usr.service. Jan 16 23:57:33.088837 systemd[1]: Starting systemd-journald.service - Journal Service... Jan 16 23:57:33.088847 kernel: loop: module loaded Jan 16 23:57:33.088857 kernel: fuse: init (API version 7.39) Jan 16 23:57:33.088866 kernel: ACPI: bus type drm_connector registered Jan 16 23:57:33.088874 systemd[1]: Starting systemd-modules-load.service - Load Kernel Modules... Jan 16 23:57:33.088884 systemd[1]: Starting systemd-network-generator.service - Generate network units from Kernel command line... Jan 16 23:57:33.088894 systemd[1]: Starting systemd-remount-fs.service - Remount Root and Kernel File Systems... Jan 16 23:57:33.088927 systemd-journald[1324]: Collecting audit messages is disabled. Jan 16 23:57:33.088949 systemd-journald[1324]: Journal started Jan 16 23:57:33.088971 systemd-journald[1324]: Runtime Journal (/run/log/journal/317acc5ec85f4bc18a058e2bfe7cc71e) is 8.0M, max 78.5M, 70.5M free. Jan 16 23:57:33.089013 systemd[1]: Starting systemd-udev-trigger.service - Coldplug All udev Devices... Jan 16 23:57:32.107431 systemd[1]: Queued start job for default target multi-user.target. Jan 16 23:57:32.351074 systemd[1]: Unnecessary job was removed for dev-sda6.device - /dev/sda6. Jan 16 23:57:32.351529 systemd[1]: systemd-journald.service: Deactivated successfully. Jan 16 23:57:32.351891 systemd[1]: systemd-journald.service: Consumed 2.484s CPU time. Jan 16 23:57:33.106620 systemd[1]: verity-setup.service: Deactivated successfully. Jan 16 23:57:33.106680 systemd[1]: Stopped verity-setup.service. Jan 16 23:57:33.124609 systemd[1]: Started systemd-journald.service - Journal Service. Jan 16 23:57:33.125356 systemd[1]: Mounted dev-hugepages.mount - Huge Pages File System. Jan 16 23:57:33.130028 systemd[1]: Mounted dev-mqueue.mount - POSIX Message Queue File System. Jan 16 23:57:33.134999 systemd[1]: Mounted media.mount - External Media Directory. Jan 16 23:57:33.139508 systemd[1]: Mounted sys-kernel-debug.mount - Kernel Debug File System. Jan 16 23:57:33.144427 systemd[1]: Mounted sys-kernel-tracing.mount - Kernel Trace File System. Jan 16 23:57:33.149486 systemd[1]: Mounted tmp.mount - Temporary Directory /tmp. Jan 16 23:57:33.154249 systemd[1]: Finished flatcar-tmpfiles.service - Create missing system files. Jan 16 23:57:33.160077 systemd[1]: Finished kmod-static-nodes.service - Create List of Static Device Nodes. Jan 16 23:57:33.166313 systemd[1]: modprobe@configfs.service: Deactivated successfully. Jan 16 23:57:33.166456 systemd[1]: Finished modprobe@configfs.service - Load Kernel Module configfs. Jan 16 23:57:33.172338 systemd[1]: modprobe@dm_mod.service: Deactivated successfully. Jan 16 23:57:33.172473 systemd[1]: Finished modprobe@dm_mod.service - Load Kernel Module dm_mod. Jan 16 23:57:33.177831 systemd[1]: modprobe@drm.service: Deactivated successfully. Jan 16 23:57:33.177965 systemd[1]: Finished modprobe@drm.service - Load Kernel Module drm. Jan 16 23:57:33.183417 systemd[1]: modprobe@efi_pstore.service: Deactivated successfully. Jan 16 23:57:33.183556 systemd[1]: Finished modprobe@efi_pstore.service - Load Kernel Module efi_pstore. Jan 16 23:57:33.189517 systemd[1]: modprobe@fuse.service: Deactivated successfully. Jan 16 23:57:33.189635 systemd[1]: Finished modprobe@fuse.service - Load Kernel Module fuse. Jan 16 23:57:33.195435 systemd[1]: modprobe@loop.service: Deactivated successfully. Jan 16 23:57:33.195566 systemd[1]: Finished modprobe@loop.service - Load Kernel Module loop. Jan 16 23:57:33.201489 systemd[1]: Finished systemd-modules-load.service - Load Kernel Modules. Jan 16 23:57:33.207335 systemd[1]: Finished systemd-network-generator.service - Generate network units from Kernel command line. Jan 16 23:57:33.213565 systemd[1]: Finished systemd-remount-fs.service - Remount Root and Kernel File Systems. Jan 16 23:57:33.220280 systemd[1]: Finished systemd-udev-trigger.service - Coldplug All udev Devices. Jan 16 23:57:33.235298 systemd[1]: Reached target network-pre.target - Preparation for Network. Jan 16 23:57:33.245889 systemd[1]: Mounting sys-fs-fuse-connections.mount - FUSE Control File System... Jan 16 23:57:33.251933 systemd[1]: Mounting sys-kernel-config.mount - Kernel Configuration File System... Jan 16 23:57:33.257155 systemd[1]: remount-root.service - Remount Root File System was skipped because of an unmet condition check (ConditionPathIsReadWrite=!/). Jan 16 23:57:33.257191 systemd[1]: Reached target local-fs.target - Local File Systems. Jan 16 23:57:33.262969 systemd[1]: Listening on systemd-sysext.socket - System Extension Image Management (Varlink). Jan 16 23:57:33.269621 systemd[1]: Starting dracut-shutdown.service - Restore /run/initramfs on shutdown... Jan 16 23:57:33.275950 systemd[1]: Starting ldconfig.service - Rebuild Dynamic Linker Cache... Jan 16 23:57:33.280745 systemd[1]: systemd-binfmt.service - Set Up Additional Binary Formats was skipped because no trigger condition checks were met. Jan 16 23:57:33.282507 systemd[1]: Starting systemd-hwdb-update.service - Rebuild Hardware Database... Jan 16 23:57:33.288874 systemd[1]: Starting systemd-journal-flush.service - Flush Journal to Persistent Storage... Jan 16 23:57:33.294496 systemd[1]: systemd-pstore.service - Platform Persistent Storage Archival was skipped because of an unmet condition check (ConditionDirectoryNotEmpty=/sys/fs/pstore). Jan 16 23:57:33.295624 systemd[1]: Starting systemd-random-seed.service - Load/Save OS Random Seed... Jan 16 23:57:33.300743 systemd[1]: systemd-repart.service - Repartition Root Disk was skipped because no trigger condition checks were met. Jan 16 23:57:33.304039 systemd[1]: Starting systemd-sysctl.service - Apply Kernel Variables... Jan 16 23:57:33.312024 systemd[1]: Starting systemd-sysext.service - Merge System Extension Images into /usr/ and /opt/... Jan 16 23:57:33.319075 systemd[1]: Starting systemd-tmpfiles-setup-dev-early.service - Create Static Device Nodes in /dev gracefully... Jan 16 23:57:33.330517 systemd[1]: Starting systemd-udev-settle.service - Wait for udev To Complete Device Initialization... Jan 16 23:57:33.337615 systemd[1]: Mounted sys-fs-fuse-connections.mount - FUSE Control File System. Jan 16 23:57:33.343804 systemd[1]: Mounted sys-kernel-config.mount - Kernel Configuration File System. Jan 16 23:57:33.346920 systemd-journald[1324]: Time spent on flushing to /var/log/journal/317acc5ec85f4bc18a058e2bfe7cc71e is 23.965ms for 902 entries. Jan 16 23:57:33.346920 systemd-journald[1324]: System Journal (/var/log/journal/317acc5ec85f4bc18a058e2bfe7cc71e) is 8.0M, max 2.8G, 2.7G free. Jan 16 23:57:33.423157 systemd-journald[1324]: Received client request to flush runtime journal. Jan 16 23:57:33.423202 systemd-journald[1324]: Creating journal file /var/log/journal/317acc5ec85f4bc18a058e2bfe7cc71e/system.journal on a btrfs file system, and copy-on-write is enabled. This is likely to slow down journal access substantially, please consider turning off the copy-on-write file attribute on the journal directory, using chattr +C. Jan 16 23:57:33.423355 kernel: loop0: detected capacity change from 0 to 114432 Jan 16 23:57:33.354190 systemd[1]: Finished dracut-shutdown.service - Restore /run/initramfs on shutdown. Jan 16 23:57:33.364931 systemd[1]: Finished systemd-random-seed.service - Load/Save OS Random Seed. Jan 16 23:57:33.394020 systemd[1]: Reached target first-boot-complete.target - First Boot Complete. Jan 16 23:57:33.407134 systemd[1]: Starting systemd-machine-id-commit.service - Commit a transient machine-id on disk... Jan 16 23:57:33.415758 udevadm[1361]: systemd-udev-settle.service is deprecated. Please fix lvm2-activation-early.service, lvm2-activation.service not to pull it in. Jan 16 23:57:33.428305 systemd[1]: Finished systemd-journal-flush.service - Flush Journal to Persistent Storage. Jan 16 23:57:33.444910 systemd[1]: Finished systemd-sysctl.service - Apply Kernel Variables. Jan 16 23:57:33.462125 systemd[1]: etc-machine\x2did.mount: Deactivated successfully. Jan 16 23:57:33.463318 systemd[1]: Finished systemd-machine-id-commit.service - Commit a transient machine-id on disk. Jan 16 23:57:33.466747 systemd-tmpfiles[1360]: ACLs are not supported, ignoring. Jan 16 23:57:33.466768 systemd-tmpfiles[1360]: ACLs are not supported, ignoring. Jan 16 23:57:33.474127 systemd[1]: Finished systemd-tmpfiles-setup-dev-early.service - Create Static Device Nodes in /dev gracefully. Jan 16 23:57:33.487012 systemd[1]: Starting systemd-sysusers.service - Create System Users... Jan 16 23:57:33.549105 systemd[1]: Finished systemd-sysusers.service - Create System Users. Jan 16 23:57:33.558087 systemd[1]: Starting systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev... Jan 16 23:57:33.576844 systemd-tmpfiles[1379]: ACLs are not supported, ignoring. Jan 16 23:57:33.576860 systemd-tmpfiles[1379]: ACLs are not supported, ignoring. Jan 16 23:57:33.580853 systemd[1]: Finished systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev. Jan 16 23:57:33.796859 kernel: squashfs: version 4.0 (2009/01/31) Phillip Lougher Jan 16 23:57:33.853854 kernel: loop1: detected capacity change from 0 to 114328 Jan 16 23:57:34.021736 systemd[1]: Finished systemd-hwdb-update.service - Rebuild Hardware Database. Jan 16 23:57:34.032940 systemd[1]: Starting systemd-udevd.service - Rule-based Manager for Device Events and Files... Jan 16 23:57:34.059305 systemd-udevd[1387]: Using default interface naming scheme 'v255'. Jan 16 23:57:34.174749 systemd[1]: Started systemd-udevd.service - Rule-based Manager for Device Events and Files. Jan 16 23:57:34.190391 systemd[1]: Starting systemd-networkd.service - Network Configuration... Jan 16 23:57:34.243109 systemd[1]: Starting systemd-userdbd.service - User Database Manager... Jan 16 23:57:34.262831 kernel: loop2: detected capacity change from 0 to 31320 Jan 16 23:57:34.284254 systemd[1]: Condition check resulted in dev-ttyAMA0.device - /dev/ttyAMA0 being skipped. Jan 16 23:57:34.298471 systemd[1]: Started systemd-userdbd.service - User Database Manager. Jan 16 23:57:34.350969 kernel: mousedev: PS/2 mouse device common for all mice Jan 16 23:57:34.402610 kernel: hv_storvsc f8b3781a-1e82-4818-a1c3-63d806ec15bb: tag#147 cmd 0x85 status: scsi 0x2 srb 0x6 hv 0xc0000001 Jan 16 23:57:34.413679 kernel: hv_vmbus: registering driver hv_balloon Jan 16 23:57:34.413788 kernel: hv_balloon: Using Dynamic Memory protocol version 2.0 Jan 16 23:57:34.417291 kernel: hv_balloon: Memory hot add disabled on ARM64 Jan 16 23:57:34.436326 kernel: hv_vmbus: registering driver hyperv_fb Jan 16 23:57:34.444413 kernel: hyperv_fb: Synthvid Version major 3, minor 5 Jan 16 23:57:34.436255 systemd[1]: Starting systemd-vconsole-setup.service - Virtual Console Setup... Jan 16 23:57:34.448422 kernel: hyperv_fb: Screen resolution: 1024x768, Color depth: 32, Frame buffer size: 8388608 Jan 16 23:57:34.450637 systemd-networkd[1395]: lo: Link UP Jan 16 23:57:34.450643 systemd-networkd[1395]: lo: Gained carrier Jan 16 23:57:34.456159 systemd-networkd[1395]: Enumeration completed Jan 16 23:57:34.456255 systemd[1]: Started systemd-networkd.service - Network Configuration. Jan 16 23:57:34.457507 kernel: Console: switching to colour dummy device 80x25 Jan 16 23:57:34.462501 kernel: Console: switching to colour frame buffer device 128x48 Jan 16 23:57:34.463463 systemd-networkd[1395]: eth0: found matching network '/usr/lib/systemd/network/zz-default.network', based on potentially unpredictable interface name. Jan 16 23:57:34.463574 systemd-networkd[1395]: eth0: Configuring with /usr/lib/systemd/network/zz-default.network. Jan 16 23:57:34.466853 systemd[1]: systemd-vconsole-setup.service: Deactivated successfully. Jan 16 23:57:34.467180 systemd[1]: Stopped systemd-vconsole-setup.service - Virtual Console Setup. Jan 16 23:57:34.488179 systemd[1]: Starting systemd-networkd-wait-online.service - Wait for Network to be Configured... Jan 16 23:57:34.500003 systemd[1]: Starting systemd-vconsole-setup.service - Virtual Console Setup... Jan 16 23:57:34.511436 systemd[1]: systemd-vconsole-setup.service: Deactivated successfully. Jan 16 23:57:34.512439 systemd[1]: Stopped systemd-vconsole-setup.service - Virtual Console Setup. Jan 16 23:57:34.528126 systemd[1]: Starting systemd-vconsole-setup.service - Virtual Console Setup... Jan 16 23:57:34.540492 kernel: BTRFS warning: duplicate device /dev/sda3 devid 1 generation 37 scanned by (udev-worker) (1393) Jan 16 23:57:34.545913 kernel: mlx5_core 1664:00:02.0 enP5732s1: Link up Jan 16 23:57:34.572850 kernel: hv_netvsc 7ced8d89-6cc4-7ced-8d89-6cc47ced8d89 eth0: Data path switched to VF: enP5732s1 Jan 16 23:57:34.575178 systemd-networkd[1395]: enP5732s1: Link UP Jan 16 23:57:34.575444 systemd-networkd[1395]: eth0: Link UP Jan 16 23:57:34.575449 systemd-networkd[1395]: eth0: Gained carrier Jan 16 23:57:34.575463 systemd-networkd[1395]: eth0: found matching network '/usr/lib/systemd/network/zz-default.network', based on potentially unpredictable interface name. Jan 16 23:57:34.582325 systemd-networkd[1395]: enP5732s1: Gained carrier Jan 16 23:57:34.589977 systemd-networkd[1395]: eth0: DHCPv4 address 10.200.20.16/24, gateway 10.200.20.1 acquired from 168.63.129.16 Jan 16 23:57:34.600743 systemd[1]: Found device dev-disk-by\x2dlabel-OEM.device - Virtual_Disk OEM. Jan 16 23:57:34.615004 systemd[1]: Starting systemd-fsck@dev-disk-by\x2dlabel-OEM.service - File System Check on /dev/disk/by-label/OEM... Jan 16 23:57:34.649812 kernel: loop3: detected capacity change from 0 to 114432 Jan 16 23:57:34.662269 systemd[1]: Finished systemd-fsck@dev-disk-by\x2dlabel-OEM.service - File System Check on /dev/disk/by-label/OEM. Jan 16 23:57:34.672823 kernel: loop4: detected capacity change from 0 to 114328 Jan 16 23:57:34.685825 kernel: loop5: detected capacity change from 0 to 31320 Jan 16 23:57:34.694843 (sd-merge)[1479]: Using extensions 'containerd-flatcar', 'docker-flatcar', 'oem-azure'. Jan 16 23:57:34.695247 (sd-merge)[1479]: Merged extensions into '/usr'. Jan 16 23:57:34.708834 systemd[1]: Finished systemd-sysext.service - Merge System Extension Images into /usr/ and /opt/. Jan 16 23:57:34.724000 systemd[1]: Starting ensure-sysext.service... Jan 16 23:57:34.729964 systemd[1]: Starting systemd-tmpfiles-setup.service - Create System Files and Directories... Jan 16 23:57:34.740972 systemd[1]: Reloading requested from client PID 1486 ('systemctl') (unit ensure-sysext.service)... Jan 16 23:57:34.740987 systemd[1]: Reloading... Jan 16 23:57:34.801155 systemd-tmpfiles[1487]: /usr/lib/tmpfiles.d/provision.conf:20: Duplicate line for path "/root", ignoring. Jan 16 23:57:34.801859 systemd-tmpfiles[1487]: /usr/lib/tmpfiles.d/systemd-flatcar.conf:6: Duplicate line for path "/var/log/journal", ignoring. Jan 16 23:57:34.802688 systemd-tmpfiles[1487]: /usr/lib/tmpfiles.d/systemd.conf:29: Duplicate line for path "/var/lib/systemd", ignoring. Jan 16 23:57:34.803283 systemd-tmpfiles[1487]: ACLs are not supported, ignoring. Jan 16 23:57:34.803328 systemd-tmpfiles[1487]: ACLs are not supported, ignoring. Jan 16 23:57:34.806449 systemd-tmpfiles[1487]: Detected autofs mount point /boot during canonicalization of boot. Jan 16 23:57:34.807600 systemd-tmpfiles[1487]: Skipping /boot Jan 16 23:57:34.818069 systemd-tmpfiles[1487]: Detected autofs mount point /boot during canonicalization of boot. Jan 16 23:57:34.818214 systemd-tmpfiles[1487]: Skipping /boot Jan 16 23:57:34.837815 zram_generator::config[1530]: No configuration found. Jan 16 23:57:34.945206 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. Jan 16 23:57:35.023136 systemd[1]: Reloading finished in 281 ms. Jan 16 23:57:35.053921 systemd[1]: Finished systemd-udev-settle.service - Wait for udev To Complete Device Initialization. Jan 16 23:57:35.060345 systemd[1]: Finished systemd-vconsole-setup.service - Virtual Console Setup. Jan 16 23:57:35.070206 systemd[1]: Finished systemd-tmpfiles-setup.service - Create System Files and Directories. Jan 16 23:57:35.088976 systemd[1]: Starting audit-rules.service - Load Security Auditing Rules... Jan 16 23:57:35.098344 systemd[1]: Starting clean-ca-certificates.service - Clean up broken links in /etc/ssl/certs... Jan 16 23:57:35.105587 systemd[1]: Starting lvm2-activation-early.service - Activation of LVM2 logical volumes... Jan 16 23:57:35.123108 systemd[1]: Starting systemd-journal-catalog-update.service - Rebuild Journal Catalog... Jan 16 23:57:35.130964 systemd[1]: Starting systemd-resolved.service - Network Name Resolution... Jan 16 23:57:35.136949 systemd[1]: Starting systemd-update-utmp.service - Record System Boot/Shutdown in UTMP... Jan 16 23:57:35.146952 systemd[1]: ignition-delete-config.service - Ignition (delete config) was skipped because no trigger condition checks were met. Jan 16 23:57:35.149695 systemd[1]: Starting modprobe@dm_mod.service - Load Kernel Module dm_mod... Jan 16 23:57:35.159175 systemd[1]: Starting modprobe@efi_pstore.service - Load Kernel Module efi_pstore... Jan 16 23:57:35.172948 systemd[1]: Starting modprobe@loop.service - Load Kernel Module loop... Jan 16 23:57:35.180417 systemd[1]: systemd-binfmt.service - Set Up Additional Binary Formats was skipped because no trigger condition checks were met. Jan 16 23:57:35.181222 systemd[1]: modprobe@dm_mod.service: Deactivated successfully. Jan 16 23:57:35.182886 systemd[1]: Finished modprobe@dm_mod.service - Load Kernel Module dm_mod. Jan 16 23:57:35.188776 systemd[1]: modprobe@efi_pstore.service: Deactivated successfully. Jan 16 23:57:35.188914 systemd[1]: Finished modprobe@efi_pstore.service - Load Kernel Module efi_pstore. Jan 16 23:57:35.195424 systemd[1]: modprobe@loop.service: Deactivated successfully. Jan 16 23:57:35.195545 systemd[1]: Finished modprobe@loop.service - Load Kernel Module loop. Jan 16 23:57:35.207681 systemd[1]: ignition-delete-config.service - Ignition (delete config) was skipped because no trigger condition checks were met. Jan 16 23:57:35.215187 systemd[1]: Starting modprobe@dm_mod.service - Load Kernel Module dm_mod... Jan 16 23:57:35.227472 lvm[1585]: WARNING: Failed to connect to lvmetad. Falling back to device scanning. Jan 16 23:57:35.232456 systemd[1]: Starting modprobe@efi_pstore.service - Load Kernel Module efi_pstore... Jan 16 23:57:35.248126 systemd[1]: Starting modprobe@loop.service - Load Kernel Module loop... Jan 16 23:57:35.253497 systemd[1]: systemd-binfmt.service - Set Up Additional Binary Formats was skipped because no trigger condition checks were met. Jan 16 23:57:35.255113 systemd-resolved[1592]: Positive Trust Anchors: Jan 16 23:57:35.255124 systemd-resolved[1592]: . IN DS 20326 8 2 e06d44b80b8f1d39a95c0b0d7c65d08458e880409bbc683457104237c7f8ec8d Jan 16 23:57:35.255156 systemd-resolved[1592]: Negative trust anchors: home.arpa 10.in-addr.arpa 16.172.in-addr.arpa 17.172.in-addr.arpa 18.172.in-addr.arpa 19.172.in-addr.arpa 20.172.in-addr.arpa 21.172.in-addr.arpa 22.172.in-addr.arpa 23.172.in-addr.arpa 24.172.in-addr.arpa 25.172.in-addr.arpa 26.172.in-addr.arpa 27.172.in-addr.arpa 28.172.in-addr.arpa 29.172.in-addr.arpa 30.172.in-addr.arpa 31.172.in-addr.arpa 170.0.0.192.in-addr.arpa 171.0.0.192.in-addr.arpa 168.192.in-addr.arpa d.f.ip6.arpa ipv4only.arpa resolver.arpa corp home internal intranet lan local private test Jan 16 23:57:35.255668 systemd[1]: Finished lvm2-activation-early.service - Activation of LVM2 logical volumes. Jan 16 23:57:35.266872 systemd[1]: Finished systemd-update-utmp.service - Record System Boot/Shutdown in UTMP. Jan 16 23:57:35.273407 systemd[1]: modprobe@dm_mod.service: Deactivated successfully. Jan 16 23:57:35.273547 systemd[1]: Finished modprobe@dm_mod.service - Load Kernel Module dm_mod. Jan 16 23:57:35.279292 systemd[1]: modprobe@efi_pstore.service: Deactivated successfully. Jan 16 23:57:35.279421 systemd[1]: Finished modprobe@efi_pstore.service - Load Kernel Module efi_pstore. Jan 16 23:57:35.285537 systemd[1]: modprobe@loop.service: Deactivated successfully. Jan 16 23:57:35.286895 systemd[1]: Finished modprobe@loop.service - Load Kernel Module loop. Jan 16 23:57:35.289365 systemd-resolved[1592]: Using system hostname 'ci-4081.3.6-n-189a678227'. Jan 16 23:57:35.292506 systemd[1]: Started systemd-resolved.service - Network Name Resolution. Jan 16 23:57:35.292983 augenrules[1612]: No rules Jan 16 23:57:35.297984 systemd[1]: Finished audit-rules.service - Load Security Auditing Rules. Jan 16 23:57:35.303747 systemd[1]: Finished systemd-journal-catalog-update.service - Rebuild Journal Catalog. Jan 16 23:57:35.317221 systemd[1]: Reached target cryptsetup.target - Local Encrypted Volumes. Jan 16 23:57:35.322367 systemd[1]: Reached target network.target - Network. Jan 16 23:57:35.326336 systemd[1]: Reached target nss-lookup.target - Host and Network Name Lookups. Jan 16 23:57:35.331761 systemd[1]: ignition-delete-config.service - Ignition (delete config) was skipped because no trigger condition checks were met. Jan 16 23:57:35.343057 systemd[1]: Starting lvm2-activation.service - Activation of LVM2 logical volumes... Jan 16 23:57:35.348033 lvm[1624]: WARNING: Failed to connect to lvmetad. Falling back to device scanning. Jan 16 23:57:35.352123 systemd[1]: Starting modprobe@dm_mod.service - Load Kernel Module dm_mod... Jan 16 23:57:35.362207 systemd[1]: Starting modprobe@drm.service - Load Kernel Module drm... Jan 16 23:57:35.370930 systemd[1]: Starting modprobe@efi_pstore.service - Load Kernel Module efi_pstore... Jan 16 23:57:35.380504 systemd[1]: Starting modprobe@loop.service - Load Kernel Module loop... Jan 16 23:57:35.385706 systemd[1]: systemd-binfmt.service - Set Up Additional Binary Formats was skipped because no trigger condition checks were met. Jan 16 23:57:35.386245 systemd[1]: Reached target time-set.target - System Time Set. Jan 16 23:57:35.393097 systemd[1]: Finished lvm2-activation.service - Activation of LVM2 logical volumes. Jan 16 23:57:35.399660 systemd[1]: modprobe@dm_mod.service: Deactivated successfully. Jan 16 23:57:35.399977 systemd[1]: Finished modprobe@dm_mod.service - Load Kernel Module dm_mod. Jan 16 23:57:35.405912 systemd[1]: modprobe@drm.service: Deactivated successfully. Jan 16 23:57:35.406154 systemd[1]: Finished modprobe@drm.service - Load Kernel Module drm. Jan 16 23:57:35.411859 systemd[1]: modprobe@efi_pstore.service: Deactivated successfully. Jan 16 23:57:35.412118 systemd[1]: Finished modprobe@efi_pstore.service - Load Kernel Module efi_pstore. Jan 16 23:57:35.418358 systemd[1]: modprobe@loop.service: Deactivated successfully. Jan 16 23:57:35.419819 systemd[1]: Finished modprobe@loop.service - Load Kernel Module loop. Jan 16 23:57:35.428228 systemd[1]: Finished ensure-sysext.service. Jan 16 23:57:35.435357 systemd[1]: systemd-pstore.service - Platform Persistent Storage Archival was skipped because of an unmet condition check (ConditionDirectoryNotEmpty=/sys/fs/pstore). Jan 16 23:57:35.435426 systemd[1]: systemd-repart.service - Repartition Root Disk was skipped because no trigger condition checks were met. Jan 16 23:57:35.733578 systemd[1]: Finished clean-ca-certificates.service - Clean up broken links in /etc/ssl/certs. Jan 16 23:57:35.739573 systemd[1]: update-ca-certificates.service - Update CA bundle at /etc/ssl/certs/ca-certificates.crt was skipped because of an unmet condition check (ConditionPathIsSymbolicLink=!/etc/ssl/certs/ca-certificates.crt). Jan 16 23:57:36.220977 systemd-networkd[1395]: eth0: Gained IPv6LL Jan 16 23:57:36.224345 systemd[1]: Finished systemd-networkd-wait-online.service - Wait for Network to be Configured. Jan 16 23:57:36.231270 systemd[1]: Reached target network-online.target - Network is Online. Jan 16 23:57:38.732177 ldconfig[1353]: /sbin/ldconfig: /lib/ld.so.conf is not an ELF file - it has the wrong magic bytes at the start. Jan 16 23:57:38.747153 systemd[1]: Finished ldconfig.service - Rebuild Dynamic Linker Cache. Jan 16 23:57:38.756987 systemd[1]: Starting systemd-update-done.service - Update is Completed... Jan 16 23:57:38.770857 systemd[1]: Finished systemd-update-done.service - Update is Completed. Jan 16 23:57:38.776140 systemd[1]: Reached target sysinit.target - System Initialization. Jan 16 23:57:38.781099 systemd[1]: Started motdgen.path - Watch for update engine configuration changes. Jan 16 23:57:38.786658 systemd[1]: Started user-cloudinit@var-lib-flatcar\x2dinstall-user_data.path - Watch for a cloud-config at /var/lib/flatcar-install/user_data. Jan 16 23:57:38.792466 systemd[1]: Started logrotate.timer - Daily rotation of log files. Jan 16 23:57:38.797329 systemd[1]: Started mdadm.timer - Weekly check for MD array's redundancy information.. Jan 16 23:57:38.803332 systemd[1]: Started systemd-tmpfiles-clean.timer - Daily Cleanup of Temporary Directories. Jan 16 23:57:38.808985 systemd[1]: update-engine-stub.timer - Update Engine Stub Timer was skipped because of an unmet condition check (ConditionPathExists=/usr/.noupdate). Jan 16 23:57:38.809018 systemd[1]: Reached target paths.target - Path Units. Jan 16 23:57:38.813057 systemd[1]: Reached target timers.target - Timer Units. Jan 16 23:57:38.817973 systemd[1]: Listening on dbus.socket - D-Bus System Message Bus Socket. Jan 16 23:57:38.824355 systemd[1]: Starting docker.socket - Docker Socket for the API... Jan 16 23:57:38.832527 systemd[1]: Listening on sshd.socket - OpenSSH Server Socket. Jan 16 23:57:38.837783 systemd[1]: Listening on docker.socket - Docker Socket for the API. Jan 16 23:57:38.842623 systemd[1]: Reached target sockets.target - Socket Units. Jan 16 23:57:38.846939 systemd[1]: Reached target basic.target - Basic System. Jan 16 23:57:38.851263 systemd[1]: addon-config@oem.service - Configure Addon /oem was skipped because no trigger condition checks were met. Jan 16 23:57:38.851290 systemd[1]: addon-run@oem.service - Run Addon /oem was skipped because no trigger condition checks were met. Jan 16 23:57:38.867895 systemd[1]: Starting chronyd.service - NTP client/server... Jan 16 23:57:38.874940 systemd[1]: Starting containerd.service - containerd container runtime... Jan 16 23:57:38.885996 systemd[1]: Starting coreos-metadata.service - Flatcar Metadata Agent... Jan 16 23:57:38.891652 (chronyd)[1642]: chronyd.service: Referenced but unset environment variable evaluates to an empty string: OPTIONS Jan 16 23:57:38.895995 systemd[1]: Starting dbus.service - D-Bus System Message Bus... Jan 16 23:57:38.901964 systemd[1]: Starting enable-oem-cloudinit.service - Enable cloudinit... Jan 16 23:57:38.908009 systemd[1]: Starting extend-filesystems.service - Extend Filesystems... Jan 16 23:57:38.912929 systemd[1]: flatcar-setup-environment.service - Modifies /etc/environment for CoreOS was skipped because of an unmet condition check (ConditionPathExists=/oem/bin/flatcar-setup-environment). Jan 16 23:57:38.912970 systemd[1]: hv_fcopy_daemon.service - Hyper-V FCOPY daemon was skipped because of an unmet condition check (ConditionPathExists=/dev/vmbus/hv_fcopy). Jan 16 23:57:38.914996 systemd[1]: Started hv_kvp_daemon.service - Hyper-V KVP daemon. Jan 16 23:57:38.924833 chronyd[1652]: chronyd version 4.5 starting (+CMDMON +NTP +REFCLOCK +RTC +PRIVDROP +SCFILTER -SIGND +ASYNCDNS +NTS +SECHASH +IPV6 -DEBUG) Jan 16 23:57:38.927676 systemd[1]: hv_vss_daemon.service - Hyper-V VSS daemon was skipped because of an unmet condition check (ConditionPathExists=/dev/vmbus/hv_vss). Jan 16 23:57:38.930004 jq[1648]: false Jan 16 23:57:38.933508 systemd[1]: Starting motdgen.service - Generate /run/flatcar/motd... Jan 16 23:57:38.940973 systemd[1]: Starting nvidia.service - NVIDIA Configure Service... Jan 16 23:57:38.941404 KVP[1650]: KVP starting; pid is:1650 Jan 16 23:57:38.961021 systemd[1]: Starting ssh-key-proc-cmdline.service - Install an ssh key from /proc/cmdline... Jan 16 23:57:38.962768 chronyd[1652]: Timezone right/UTC failed leap second check, ignoring Jan 16 23:57:38.968166 chronyd[1652]: Loaded seccomp filter (level 2) Jan 16 23:57:38.979036 systemd[1]: Starting sshd-keygen.service - Generate sshd host keys... Jan 16 23:57:38.990889 extend-filesystems[1649]: Found loop3 Jan 16 23:57:38.990889 extend-filesystems[1649]: Found loop4 Jan 16 23:57:38.990889 extend-filesystems[1649]: Found loop5 Jan 16 23:57:38.990889 extend-filesystems[1649]: Found sda Jan 16 23:57:38.990889 extend-filesystems[1649]: Found sda1 Jan 16 23:57:38.990889 extend-filesystems[1649]: Found sda2 Jan 16 23:57:38.990889 extend-filesystems[1649]: Found sda3 Jan 16 23:57:38.990889 extend-filesystems[1649]: Found usr Jan 16 23:57:38.990889 extend-filesystems[1649]: Found sda4 Jan 16 23:57:38.990889 extend-filesystems[1649]: Found sda6 Jan 16 23:57:38.990889 extend-filesystems[1649]: Found sda7 Jan 16 23:57:38.990889 extend-filesystems[1649]: Found sda9 Jan 16 23:57:38.990889 extend-filesystems[1649]: Checking size of /dev/sda9 Jan 16 23:57:39.181238 kernel: hv_utils: KVP IC version 4.0 Jan 16 23:57:39.181300 coreos-metadata[1644]: Jan 16 23:57:39.121 INFO Fetching http://168.63.129.16/?comp=versions: Attempt #1 Jan 16 23:57:39.181300 coreos-metadata[1644]: Jan 16 23:57:39.125 INFO Fetch successful Jan 16 23:57:39.181300 coreos-metadata[1644]: Jan 16 23:57:39.125 INFO Fetching http://168.63.129.16/machine/?comp=goalstate: Attempt #1 Jan 16 23:57:39.181300 coreos-metadata[1644]: Jan 16 23:57:39.136 INFO Fetch successful Jan 16 23:57:39.181300 coreos-metadata[1644]: Jan 16 23:57:39.137 INFO Fetching http://168.63.129.16/machine/e06d0569-7329-4886-9f2d-3527e1585a33/baf14abc%2Dc290%2D45d9%2D9bed%2D59ac29c04e1a.%5Fci%2D4081.3.6%2Dn%2D189a678227?comp=config&type=sharedConfig&incarnation=1: Attempt #1 Jan 16 23:57:39.181300 coreos-metadata[1644]: Jan 16 23:57:39.139 INFO Fetch successful Jan 16 23:57:39.181300 coreos-metadata[1644]: Jan 16 23:57:39.141 INFO Fetching http://169.254.169.254/metadata/instance/compute/vmSize?api-version=2017-08-01&format=text: Attempt #1 Jan 16 23:57:39.181300 coreos-metadata[1644]: Jan 16 23:57:39.153 INFO Fetch successful Jan 16 23:57:39.182865 extend-filesystems[1649]: Old size kept for /dev/sda9 Jan 16 23:57:39.182865 extend-filesystems[1649]: Found sr0 Jan 16 23:57:39.034027 dbus-daemon[1645]: [system] SELinux support is enabled Jan 16 23:57:38.997186 systemd[1]: Starting systemd-logind.service - User Login Management... Jan 16 23:57:39.050819 KVP[1650]: KVP LIC Version: 3.1 Jan 16 23:57:39.003559 systemd[1]: tcsd.service - TCG Core Services Daemon was skipped because of an unmet condition check (ConditionPathExists=/dev/tpm0). Jan 16 23:57:39.216448 update_engine[1671]: I20260116 23:57:39.167752 1671 main.cc:92] Flatcar Update Engine starting Jan 16 23:57:39.216448 update_engine[1671]: I20260116 23:57:39.172926 1671 update_check_scheduler.cc:74] Next update check in 5m1s Jan 16 23:57:39.206217 dbus-daemon[1645]: [system] Successfully activated service 'org.freedesktop.systemd1' Jan 16 23:57:39.004131 systemd[1]: cgroup compatibility translation between legacy and unified hierarchy settings activated. See cgroup-compat debug messages for details. Jan 16 23:57:39.217894 jq[1673]: true Jan 16 23:57:39.006232 systemd[1]: Starting update-engine.service - Update Engine... Jan 16 23:57:39.022919 systemd[1]: Starting update-ssh-keys-after-ignition.service - Run update-ssh-keys once after Ignition... Jan 16 23:57:39.218415 jq[1692]: true Jan 16 23:57:39.034408 systemd[1]: Started dbus.service - D-Bus System Message Bus. Jan 16 23:57:39.044962 systemd[1]: Started chronyd.service - NTP client/server. Jan 16 23:57:39.070198 systemd[1]: enable-oem-cloudinit.service: Skipped due to 'exec-condition'. Jan 16 23:57:39.070401 systemd[1]: Condition check resulted in enable-oem-cloudinit.service - Enable cloudinit being skipped. Jan 16 23:57:39.070689 systemd[1]: motdgen.service: Deactivated successfully. Jan 16 23:57:39.070882 systemd[1]: Finished motdgen.service - Generate /run/flatcar/motd. Jan 16 23:57:39.088205 systemd[1]: Finished nvidia.service - NVIDIA Configure Service. Jan 16 23:57:39.096505 systemd[1]: extend-filesystems.service: Deactivated successfully. Jan 16 23:57:39.097851 systemd[1]: Finished extend-filesystems.service - Extend Filesystems. Jan 16 23:57:39.122766 systemd-logind[1667]: Watching system buttons on /dev/input/event1 (AT Translated Set 2 keyboard) Jan 16 23:57:39.128690 systemd-logind[1667]: New seat seat0. Jan 16 23:57:39.129079 systemd[1]: ssh-key-proc-cmdline.service: Deactivated successfully. Jan 16 23:57:39.129286 systemd[1]: Finished ssh-key-proc-cmdline.service - Install an ssh key from /proc/cmdline. Jan 16 23:57:39.142053 systemd[1]: Started systemd-logind.service - User Login Management. Jan 16 23:57:39.205372 systemd[1]: system-cloudinit@usr-share-oem-cloud\x2dconfig.yml.service - Load cloud-config from /usr/share/oem/cloud-config.yml was skipped because of an unmet condition check (ConditionFileNotEmpty=/usr/share/oem/cloud-config.yml). Jan 16 23:57:39.205425 systemd[1]: Reached target system-config.target - Load system-provided cloud configs. Jan 16 23:57:39.216166 (ntainerd)[1697]: containerd.service: Referenced but unset environment variable evaluates to an empty string: TORCX_IMAGEDIR, TORCX_UNPACKDIR Jan 16 23:57:39.221178 systemd[1]: user-cloudinit-proc-cmdline.service - Load cloud-config from url defined in /proc/cmdline was skipped because of an unmet condition check (ConditionKernelCommandLine=cloud-config-url). Jan 16 23:57:39.221202 systemd[1]: Reached target user-config.target - Load user-provided cloud configs. Jan 16 23:57:39.247399 kernel: BTRFS warning: duplicate device /dev/sda3 devid 1 generation 37 scanned by (udev-worker) (1695) Jan 16 23:57:39.247372 systemd[1]: Started update-engine.service - Update Engine. Jan 16 23:57:39.270051 systemd[1]: Started locksmithd.service - Cluster reboot manager. Jan 16 23:57:39.281852 systemd[1]: Finished coreos-metadata.service - Flatcar Metadata Agent. Jan 16 23:57:39.312848 systemd[1]: packet-phone-home.service - Report Success to Packet was skipped because no trigger condition checks were met. Jan 16 23:57:39.434910 bash[1753]: Updated "/home/core/.ssh/authorized_keys" Jan 16 23:57:39.436696 systemd[1]: Finished update-ssh-keys-after-ignition.service - Run update-ssh-keys once after Ignition. Jan 16 23:57:39.444725 systemd[1]: sshkeys.service was skipped because no trigger condition checks were met. Jan 16 23:57:39.447393 locksmithd[1733]: locksmithd starting currentOperation="UPDATE_STATUS_IDLE" strategy="reboot" Jan 16 23:57:39.736332 sshd_keygen[1670]: ssh-keygen: generating new host keys: RSA ECDSA ED25519 Jan 16 23:57:39.755438 systemd[1]: Finished sshd-keygen.service - Generate sshd host keys. Jan 16 23:57:39.766036 systemd[1]: Starting issuegen.service - Generate /run/issue... Jan 16 23:57:39.772006 systemd[1]: Starting waagent.service - Microsoft Azure Linux Agent... Jan 16 23:57:39.778006 systemd[1]: issuegen.service: Deactivated successfully. Jan 16 23:57:39.778392 systemd[1]: Finished issuegen.service - Generate /run/issue. Jan 16 23:57:39.792128 systemd[1]: Starting systemd-user-sessions.service - Permit User Sessions... Jan 16 23:57:39.808025 systemd[1]: Started waagent.service - Microsoft Azure Linux Agent. Jan 16 23:57:39.816082 systemd[1]: Finished systemd-user-sessions.service - Permit User Sessions. Jan 16 23:57:39.830013 systemd[1]: Started getty@tty1.service - Getty on tty1. Jan 16 23:57:39.836788 systemd[1]: Started serial-getty@ttyAMA0.service - Serial Getty on ttyAMA0. Jan 16 23:57:39.842652 systemd[1]: Reached target getty.target - Login Prompts. Jan 16 23:57:40.074162 containerd[1697]: time="2026-01-16T23:57:40.074035540Z" level=info msg="starting containerd" revision=174e0d1785eeda18dc2beba45e1d5a188771636b version=v1.7.21 Jan 16 23:57:40.098766 containerd[1697]: time="2026-01-16T23:57:40.098702060Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.aufs\"..." type=io.containerd.snapshotter.v1 Jan 16 23:57:40.100222 containerd[1697]: time="2026-01-16T23:57:40.100173740Z" 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.119-flatcar\\n\"): skip plugin" type=io.containerd.snapshotter.v1 Jan 16 23:57:40.100222 containerd[1697]: time="2026-01-16T23:57:40.100227180Z" level=info msg="loading plugin \"io.containerd.event.v1.exchange\"..." type=io.containerd.event.v1 Jan 16 23:57:40.100222 containerd[1697]: time="2026-01-16T23:57:40.100244860Z" level=info msg="loading plugin \"io.containerd.internal.v1.opt\"..." type=io.containerd.internal.v1 Jan 16 23:57:40.100470 containerd[1697]: time="2026-01-16T23:57:40.100376460Z" level=info msg="loading plugin \"io.containerd.warning.v1.deprecations\"..." type=io.containerd.warning.v1 Jan 16 23:57:40.100470 containerd[1697]: time="2026-01-16T23:57:40.100397100Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.blockfile\"..." type=io.containerd.snapshotter.v1 Jan 16 23:57:40.100470 containerd[1697]: time="2026-01-16T23:57:40.100440660Z" level=info msg="skip loading plugin \"io.containerd.snapshotter.v1.blockfile\"..." error="no scratch file generator: skip plugin" type=io.containerd.snapshotter.v1 Jan 16 23:57:40.100470 containerd[1697]: time="2026-01-16T23:57:40.100451820Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.btrfs\"..." type=io.containerd.snapshotter.v1 Jan 16 23:57:40.100662 containerd[1697]: time="2026-01-16T23:57:40.100640420Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.devmapper\"..." type=io.containerd.snapshotter.v1 Jan 16 23:57:40.100695 containerd[1697]: time="2026-01-16T23:57:40.100662060Z" level=info msg="skip loading plugin \"io.containerd.snapshotter.v1.devmapper\"..." error="devmapper not configured: skip plugin" type=io.containerd.snapshotter.v1 Jan 16 23:57:40.100695 containerd[1697]: time="2026-01-16T23:57:40.100674820Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.native\"..." type=io.containerd.snapshotter.v1 Jan 16 23:57:40.100738 containerd[1697]: time="2026-01-16T23:57:40.100724500Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.overlayfs\"..." type=io.containerd.snapshotter.v1 Jan 16 23:57:40.100969 containerd[1697]: time="2026-01-16T23:57:40.100937220Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.zfs\"..." type=io.containerd.snapshotter.v1 Jan 16 23:57:40.101404 containerd[1697]: time="2026-01-16T23:57:40.101048020Z" 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 Jan 16 23:57:40.101404 containerd[1697]: time="2026-01-16T23:57:40.101065380Z" level=info msg="loading plugin \"io.containerd.content.v1.content\"..." type=io.containerd.content.v1 Jan 16 23:57:40.101404 containerd[1697]: time="2026-01-16T23:57:40.101126700Z" level=info msg="loading plugin \"io.containerd.metadata.v1.bolt\"..." type=io.containerd.metadata.v1 Jan 16 23:57:40.101404 containerd[1697]: time="2026-01-16T23:57:40.101158340Z" level=info msg="metadata content store policy set" policy=shared Jan 16 23:57:40.117393 containerd[1697]: time="2026-01-16T23:57:40.117347620Z" level=info msg="loading plugin \"io.containerd.gc.v1.scheduler\"..." type=io.containerd.gc.v1 Jan 16 23:57:40.117498 containerd[1697]: time="2026-01-16T23:57:40.117418980Z" level=info msg="loading plugin \"io.containerd.differ.v1.walking\"..." type=io.containerd.differ.v1 Jan 16 23:57:40.117498 containerd[1697]: time="2026-01-16T23:57:40.117436260Z" level=info msg="loading plugin \"io.containerd.lease.v1.manager\"..." type=io.containerd.lease.v1 Jan 16 23:57:40.117498 containerd[1697]: time="2026-01-16T23:57:40.117451980Z" level=info msg="loading plugin \"io.containerd.streaming.v1.manager\"..." type=io.containerd.streaming.v1 Jan 16 23:57:40.117498 containerd[1697]: time="2026-01-16T23:57:40.117468900Z" level=info msg="loading plugin \"io.containerd.runtime.v1.linux\"..." type=io.containerd.runtime.v1 Jan 16 23:57:40.117641 containerd[1697]: time="2026-01-16T23:57:40.117618580Z" level=info msg="loading plugin \"io.containerd.monitor.v1.cgroups\"..." type=io.containerd.monitor.v1 Jan 16 23:57:40.117932 containerd[1697]: time="2026-01-16T23:57:40.117911940Z" level=info msg="loading plugin \"io.containerd.runtime.v2.task\"..." type=io.containerd.runtime.v2 Jan 16 23:57:40.118030 containerd[1697]: time="2026-01-16T23:57:40.118009980Z" level=info msg="loading plugin \"io.containerd.runtime.v2.shim\"..." type=io.containerd.runtime.v2 Jan 16 23:57:40.118056 containerd[1697]: time="2026-01-16T23:57:40.118033340Z" level=info msg="loading plugin \"io.containerd.sandbox.store.v1.local\"..." type=io.containerd.sandbox.store.v1 Jan 16 23:57:40.118056 containerd[1697]: time="2026-01-16T23:57:40.118048140Z" level=info msg="loading plugin \"io.containerd.sandbox.controller.v1.local\"..." type=io.containerd.sandbox.controller.v1 Jan 16 23:57:40.118105 containerd[1697]: time="2026-01-16T23:57:40.118061620Z" level=info msg="loading plugin \"io.containerd.service.v1.containers-service\"..." type=io.containerd.service.v1 Jan 16 23:57:40.118105 containerd[1697]: time="2026-01-16T23:57:40.118083140Z" level=info msg="loading plugin \"io.containerd.service.v1.content-service\"..." type=io.containerd.service.v1 Jan 16 23:57:40.118105 containerd[1697]: time="2026-01-16T23:57:40.118097620Z" level=info msg="loading plugin \"io.containerd.service.v1.diff-service\"..." type=io.containerd.service.v1 Jan 16 23:57:40.118168 containerd[1697]: time="2026-01-16T23:57:40.118113100Z" level=info msg="loading plugin \"io.containerd.service.v1.images-service\"..." type=io.containerd.service.v1 Jan 16 23:57:40.118168 containerd[1697]: time="2026-01-16T23:57:40.118128900Z" level=info msg="loading plugin \"io.containerd.service.v1.introspection-service\"..." type=io.containerd.service.v1 Jan 16 23:57:40.118168 containerd[1697]: time="2026-01-16T23:57:40.118141860Z" level=info msg="loading plugin \"io.containerd.service.v1.namespaces-service\"..." type=io.containerd.service.v1 Jan 16 23:57:40.118168 containerd[1697]: time="2026-01-16T23:57:40.118154580Z" level=info msg="loading plugin \"io.containerd.service.v1.snapshots-service\"..." type=io.containerd.service.v1 Jan 16 23:57:40.118168 containerd[1697]: time="2026-01-16T23:57:40.118166500Z" level=info msg="loading plugin \"io.containerd.service.v1.tasks-service\"..." type=io.containerd.service.v1 Jan 16 23:57:40.118255 containerd[1697]: time="2026-01-16T23:57:40.118187020Z" level=info msg="loading plugin \"io.containerd.grpc.v1.containers\"..." type=io.containerd.grpc.v1 Jan 16 23:57:40.118255 containerd[1697]: time="2026-01-16T23:57:40.118200780Z" level=info msg="loading plugin \"io.containerd.grpc.v1.content\"..." type=io.containerd.grpc.v1 Jan 16 23:57:40.118255 containerd[1697]: time="2026-01-16T23:57:40.118212940Z" level=info msg="loading plugin \"io.containerd.grpc.v1.diff\"..." type=io.containerd.grpc.v1 Jan 16 23:57:40.118255 containerd[1697]: time="2026-01-16T23:57:40.118227420Z" level=info msg="loading plugin \"io.containerd.grpc.v1.events\"..." type=io.containerd.grpc.v1 Jan 16 23:57:40.118255 containerd[1697]: time="2026-01-16T23:57:40.118240180Z" level=info msg="loading plugin \"io.containerd.grpc.v1.images\"..." type=io.containerd.grpc.v1 Jan 16 23:57:40.118255 containerd[1697]: time="2026-01-16T23:57:40.118252900Z" level=info msg="loading plugin \"io.containerd.grpc.v1.introspection\"..." type=io.containerd.grpc.v1 Jan 16 23:57:40.118369 containerd[1697]: time="2026-01-16T23:57:40.118265100Z" level=info msg="loading plugin \"io.containerd.grpc.v1.leases\"..." type=io.containerd.grpc.v1 Jan 16 23:57:40.118369 containerd[1697]: time="2026-01-16T23:57:40.118278780Z" level=info msg="loading plugin \"io.containerd.grpc.v1.namespaces\"..." type=io.containerd.grpc.v1 Jan 16 23:57:40.118369 containerd[1697]: time="2026-01-16T23:57:40.118291380Z" level=info msg="loading plugin \"io.containerd.grpc.v1.sandbox-controllers\"..." type=io.containerd.grpc.v1 Jan 16 23:57:40.118369 containerd[1697]: time="2026-01-16T23:57:40.118306700Z" level=info msg="loading plugin \"io.containerd.grpc.v1.sandboxes\"..." type=io.containerd.grpc.v1 Jan 16 23:57:40.118369 containerd[1697]: time="2026-01-16T23:57:40.118318220Z" level=info msg="loading plugin \"io.containerd.grpc.v1.snapshots\"..." type=io.containerd.grpc.v1 Jan 16 23:57:40.118369 containerd[1697]: time="2026-01-16T23:57:40.118329740Z" level=info msg="loading plugin \"io.containerd.grpc.v1.streaming\"..." type=io.containerd.grpc.v1 Jan 16 23:57:40.118369 containerd[1697]: time="2026-01-16T23:57:40.118342060Z" level=info msg="loading plugin \"io.containerd.grpc.v1.tasks\"..." type=io.containerd.grpc.v1 Jan 16 23:57:40.118369 containerd[1697]: time="2026-01-16T23:57:40.118358140Z" level=info msg="loading plugin \"io.containerd.transfer.v1.local\"..." type=io.containerd.transfer.v1 Jan 16 23:57:40.118522 containerd[1697]: time="2026-01-16T23:57:40.118391180Z" level=info msg="loading plugin \"io.containerd.grpc.v1.transfer\"..." type=io.containerd.grpc.v1 Jan 16 23:57:40.118522 containerd[1697]: time="2026-01-16T23:57:40.118405900Z" level=info msg="loading plugin \"io.containerd.grpc.v1.version\"..." type=io.containerd.grpc.v1 Jan 16 23:57:40.118522 containerd[1697]: time="2026-01-16T23:57:40.118417140Z" level=info msg="loading plugin \"io.containerd.internal.v1.restart\"..." type=io.containerd.internal.v1 Jan 16 23:57:40.118522 containerd[1697]: time="2026-01-16T23:57:40.118468900Z" level=info msg="loading plugin \"io.containerd.tracing.processor.v1.otlp\"..." type=io.containerd.tracing.processor.v1 Jan 16 23:57:40.118522 containerd[1697]: time="2026-01-16T23:57:40.118486900Z" 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 Jan 16 23:57:40.118522 containerd[1697]: time="2026-01-16T23:57:40.118497820Z" level=info msg="loading plugin \"io.containerd.internal.v1.tracing\"..." type=io.containerd.internal.v1 Jan 16 23:57:40.118522 containerd[1697]: time="2026-01-16T23:57:40.118509220Z" level=info msg="skip loading plugin \"io.containerd.internal.v1.tracing\"..." error="skip plugin: tracing endpoint not configured" type=io.containerd.internal.v1 Jan 16 23:57:40.118522 containerd[1697]: time="2026-01-16T23:57:40.118518500Z" level=info msg="loading plugin \"io.containerd.grpc.v1.healthcheck\"..." type=io.containerd.grpc.v1 Jan 16 23:57:40.118665 containerd[1697]: time="2026-01-16T23:57:40.118530460Z" level=info msg="loading plugin \"io.containerd.nri.v1.nri\"..." type=io.containerd.nri.v1 Jan 16 23:57:40.118665 containerd[1697]: time="2026-01-16T23:57:40.118540180Z" level=info msg="NRI interface is disabled by configuration." Jan 16 23:57:40.118665 containerd[1697]: time="2026-01-16T23:57:40.118551700Z" level=info msg="loading plugin \"io.containerd.grpc.v1.cri\"..." type=io.containerd.grpc.v1 Jan 16 23:57:40.118940 containerd[1697]: time="2026-01-16T23:57:40.118876820Z" 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}" Jan 16 23:57:40.118940 containerd[1697]: time="2026-01-16T23:57:40.118941980Z" level=info msg="Connect containerd service" Jan 16 23:57:40.119072 containerd[1697]: time="2026-01-16T23:57:40.118973500Z" level=info msg="using legacy CRI server" Jan 16 23:57:40.119072 containerd[1697]: time="2026-01-16T23:57:40.118980820Z" level=info msg="using experimental NRI integration - disable nri plugin to prevent this" Jan 16 23:57:40.119125 containerd[1697]: time="2026-01-16T23:57:40.119081500Z" level=info msg="Get image filesystem path \"/var/lib/containerd/io.containerd.snapshotter.v1.overlayfs\"" Jan 16 23:57:40.119731 containerd[1697]: time="2026-01-16T23:57:40.119703140Z" level=error msg="failed to load cni during init, please check CRI plugin status before setting up network for pods" error="cni config load failed: no network config found in /etc/cni/net.d: cni plugin not initialized: failed to load cni config" Jan 16 23:57:40.121090 containerd[1697]: time="2026-01-16T23:57:40.120227220Z" level=info msg=serving... address=/run/containerd/containerd.sock.ttrpc Jan 16 23:57:40.121090 containerd[1697]: time="2026-01-16T23:57:40.120282340Z" level=info msg=serving... address=/run/containerd/containerd.sock Jan 16 23:57:40.121090 containerd[1697]: time="2026-01-16T23:57:40.120469580Z" level=info msg="Start subscribing containerd event" Jan 16 23:57:40.121090 containerd[1697]: time="2026-01-16T23:57:40.120511100Z" level=info msg="Start recovering state" Jan 16 23:57:40.121090 containerd[1697]: time="2026-01-16T23:57:40.120584900Z" level=info msg="Start event monitor" Jan 16 23:57:40.121090 containerd[1697]: time="2026-01-16T23:57:40.120595780Z" level=info msg="Start snapshots syncer" Jan 16 23:57:40.121090 containerd[1697]: time="2026-01-16T23:57:40.120605060Z" level=info msg="Start cni network conf syncer for default" Jan 16 23:57:40.121090 containerd[1697]: time="2026-01-16T23:57:40.120616060Z" level=info msg="Start streaming server" Jan 16 23:57:40.121090 containerd[1697]: time="2026-01-16T23:57:40.120772740Z" level=info msg="containerd successfully booted in 0.047659s" Jan 16 23:57:40.121917 systemd[1]: Started containerd.service - containerd container runtime. Jan 16 23:57:40.128068 systemd[1]: Reached target multi-user.target - Multi-User System. Jan 16 23:57:40.136852 systemd[1]: Startup finished in 629ms (kernel) + 10.464s (initrd) + 10.836s (userspace) = 21.931s. Jan 16 23:57:40.487311 login[1786]: pam_lastlog(login:session): file /var/log/lastlog is locked/write, retrying Jan 16 23:57:40.488315 login[1785]: pam_unix(login:session): session opened for user core(uid=500) by core(uid=0) Jan 16 23:57:40.498259 systemd-logind[1667]: New session 1 of user core. Jan 16 23:57:40.499559 systemd[1]: Created slice user-500.slice - User Slice of UID 500. Jan 16 23:57:40.509072 systemd[1]: Starting user-runtime-dir@500.service - User Runtime Directory /run/user/500... Jan 16 23:57:40.534663 systemd[1]: Finished user-runtime-dir@500.service - User Runtime Directory /run/user/500. Jan 16 23:57:40.542378 systemd[1]: Starting user@500.service - User Manager for UID 500... Jan 16 23:57:40.545951 (systemd)[1796]: pam_unix(systemd-user:session): session opened for user core(uid=500) by (uid=0) Jan 16 23:57:40.687250 systemd[1796]: Queued start job for default target default.target. Jan 16 23:57:40.693006 systemd[1796]: Created slice app.slice - User Application Slice. Jan 16 23:57:40.693138 systemd[1796]: Reached target paths.target - Paths. Jan 16 23:57:40.693221 systemd[1796]: Reached target timers.target - Timers. Jan 16 23:57:40.694523 systemd[1796]: Starting dbus.socket - D-Bus User Message Bus Socket... Jan 16 23:57:40.704836 systemd[1796]: Listening on dbus.socket - D-Bus User Message Bus Socket. Jan 16 23:57:40.704894 systemd[1796]: Reached target sockets.target - Sockets. Jan 16 23:57:40.704906 systemd[1796]: Reached target basic.target - Basic System. Jan 16 23:57:40.704945 systemd[1796]: Reached target default.target - Main User Target. Jan 16 23:57:40.704970 systemd[1796]: Startup finished in 153ms. Jan 16 23:57:40.705323 systemd[1]: Started user@500.service - User Manager for UID 500. Jan 16 23:57:40.709956 systemd[1]: Started session-1.scope - Session 1 of User core. Jan 16 23:57:41.488771 login[1786]: pam_unix(login:session): session opened for user core(uid=500) by core(uid=0) Jan 16 23:57:41.492926 systemd-logind[1667]: New session 2 of user core. Jan 16 23:57:41.498930 systemd[1]: Started session-2.scope - Session 2 of User core. Jan 16 23:57:41.516221 waagent[1782]: 2026-01-16T23:57:41.516131Z INFO Daemon Daemon Azure Linux Agent Version: 2.9.1.1 Jan 16 23:57:41.520986 waagent[1782]: 2026-01-16T23:57:41.520918Z INFO Daemon Daemon OS: flatcar 4081.3.6 Jan 16 23:57:41.524857 waagent[1782]: 2026-01-16T23:57:41.524800Z INFO Daemon Daemon Python: 3.11.9 Jan 16 23:57:41.529894 waagent[1782]: 2026-01-16T23:57:41.528480Z INFO Daemon Daemon Run daemon Jan 16 23:57:41.531852 waagent[1782]: 2026-01-16T23:57:41.531790Z INFO Daemon Daemon No RDMA handler exists for distro='Flatcar Container Linux by Kinvolk' version='4081.3.6' Jan 16 23:57:41.540702 waagent[1782]: 2026-01-16T23:57:41.540131Z INFO Daemon Daemon Using waagent for provisioning Jan 16 23:57:41.545188 waagent[1782]: 2026-01-16T23:57:41.545121Z INFO Daemon Daemon Activate resource disk Jan 16 23:57:41.549894 waagent[1782]: 2026-01-16T23:57:41.549397Z INFO Daemon Daemon Searching gen1 prefix 00000000-0001 or gen2 f8b3781a-1e82-4818-a1c3-63d806ec15bb Jan 16 23:57:41.560511 waagent[1782]: 2026-01-16T23:57:41.560441Z INFO Daemon Daemon Found device: None Jan 16 23:57:41.564128 waagent[1782]: 2026-01-16T23:57:41.564077Z ERROR Daemon Daemon Failed to mount resource disk [ResourceDiskError] unable to detect disk topology Jan 16 23:57:41.570940 waagent[1782]: 2026-01-16T23:57:41.570892Z ERROR Daemon Daemon Event: name=WALinuxAgent, op=ActivateResourceDisk, message=[ResourceDiskError] unable to detect disk topology, duration=0 Jan 16 23:57:41.581684 waagent[1782]: 2026-01-16T23:57:41.581621Z INFO Daemon Daemon Clean protocol and wireserver endpoint Jan 16 23:57:41.586446 waagent[1782]: 2026-01-16T23:57:41.586399Z INFO Daemon Daemon Running default provisioning handler Jan 16 23:57:41.597533 waagent[1782]: 2026-01-16T23:57:41.597460Z INFO Daemon Daemon Unable to get cloud-init enabled status from systemctl: Command '['systemctl', 'is-enabled', 'cloud-init-local.service']' returned non-zero exit status 4. Jan 16 23:57:41.608738 waagent[1782]: 2026-01-16T23:57:41.608677Z INFO Daemon Daemon Unable to get cloud-init enabled status from service: [Errno 2] No such file or directory: 'service' Jan 16 23:57:41.616731 waagent[1782]: 2026-01-16T23:57:41.616670Z INFO Daemon Daemon cloud-init is enabled: False Jan 16 23:57:41.621077 waagent[1782]: 2026-01-16T23:57:41.621023Z INFO Daemon Daemon Copying ovf-env.xml Jan 16 23:57:41.710253 waagent[1782]: 2026-01-16T23:57:41.709902Z INFO Daemon Daemon Successfully mounted dvd Jan 16 23:57:41.749208 systemd[1]: mnt-cdrom-secure.mount: Deactivated successfully. Jan 16 23:57:41.750852 waagent[1782]: 2026-01-16T23:57:41.750757Z INFO Daemon Daemon Detect protocol endpoint Jan 16 23:57:41.755037 waagent[1782]: 2026-01-16T23:57:41.754968Z INFO Daemon Daemon Clean protocol and wireserver endpoint Jan 16 23:57:41.759879 waagent[1782]: 2026-01-16T23:57:41.759821Z INFO Daemon Daemon WireServer endpoint is not found. Rerun dhcp handler Jan 16 23:57:41.765258 waagent[1782]: 2026-01-16T23:57:41.765199Z INFO Daemon Daemon Test for route to 168.63.129.16 Jan 16 23:57:41.769731 waagent[1782]: 2026-01-16T23:57:41.769673Z INFO Daemon Daemon Route to 168.63.129.16 exists Jan 16 23:57:41.778318 waagent[1782]: 2026-01-16T23:57:41.774096Z INFO Daemon Daemon Wire server endpoint:168.63.129.16 Jan 16 23:57:41.805948 waagent[1782]: 2026-01-16T23:57:41.805904Z INFO Daemon Daemon Fabric preferred wire protocol version:2015-04-05 Jan 16 23:57:41.811407 waagent[1782]: 2026-01-16T23:57:41.811381Z INFO Daemon Daemon Wire protocol version:2012-11-30 Jan 16 23:57:41.815648 waagent[1782]: 2026-01-16T23:57:41.815609Z INFO Daemon Daemon Server preferred version:2015-04-05 Jan 16 23:57:41.944937 waagent[1782]: 2026-01-16T23:57:41.944831Z INFO Daemon Daemon Initializing goal state during protocol detection Jan 16 23:57:41.950336 waagent[1782]: 2026-01-16T23:57:41.950281Z INFO Daemon Daemon Forcing an update of the goal state. Jan 16 23:57:41.958561 waagent[1782]: 2026-01-16T23:57:41.958510Z INFO Daemon Fetched a new incarnation for the WireServer goal state [incarnation 1] Jan 16 23:57:41.977404 waagent[1782]: 2026-01-16T23:57:41.977357Z INFO Daemon Daemon HostGAPlugin version: 1.0.8.177 Jan 16 23:57:41.982261 waagent[1782]: 2026-01-16T23:57:41.982212Z INFO Daemon Jan 16 23:57:41.984617 waagent[1782]: 2026-01-16T23:57:41.984576Z INFO Daemon Fetched new vmSettings [HostGAPlugin correlation ID: c19c7b69-ab16-4f6f-80bf-df62cca83659 eTag: 14947913547471674943 source: Fabric] Jan 16 23:57:41.993948 waagent[1782]: 2026-01-16T23:57:41.993899Z INFO Daemon The vmSettings originated via Fabric; will ignore them. Jan 16 23:57:41.999568 waagent[1782]: 2026-01-16T23:57:41.999525Z INFO Daemon Jan 16 23:57:42.001870 waagent[1782]: 2026-01-16T23:57:42.001802Z INFO Daemon Fetching full goal state from the WireServer [incarnation 1] Jan 16 23:57:42.011262 waagent[1782]: 2026-01-16T23:57:42.011230Z INFO Daemon Daemon Downloading artifacts profile blob Jan 16 23:57:42.152682 waagent[1782]: 2026-01-16T23:57:42.152590Z INFO Daemon Downloaded certificate {'thumbprint': '322A603A1924A56D516DC9AD52A47C8D47A58CE7', 'hasPrivateKey': True} Jan 16 23:57:42.160836 waagent[1782]: 2026-01-16T23:57:42.160763Z INFO Daemon Fetch goal state completed Jan 16 23:57:42.202490 waagent[1782]: 2026-01-16T23:57:42.202433Z INFO Daemon Daemon Starting provisioning Jan 16 23:57:42.206512 waagent[1782]: 2026-01-16T23:57:42.206461Z INFO Daemon Daemon Handle ovf-env.xml. Jan 16 23:57:42.210284 waagent[1782]: 2026-01-16T23:57:42.210241Z INFO Daemon Daemon Set hostname [ci-4081.3.6-n-189a678227] Jan 16 23:57:42.232138 waagent[1782]: 2026-01-16T23:57:42.232064Z INFO Daemon Daemon Publish hostname [ci-4081.3.6-n-189a678227] Jan 16 23:57:42.237342 waagent[1782]: 2026-01-16T23:57:42.237278Z INFO Daemon Daemon Examine /proc/net/route for primary interface Jan 16 23:57:42.242508 waagent[1782]: 2026-01-16T23:57:42.242453Z INFO Daemon Daemon Primary interface is [eth0] Jan 16 23:57:42.270447 systemd-networkd[1395]: eth0: found matching network '/usr/lib/systemd/network/zz-default.network', based on potentially unpredictable interface name. Jan 16 23:57:42.270454 systemd-networkd[1395]: eth0: Configuring with /usr/lib/systemd/network/zz-default.network. Jan 16 23:57:42.270498 systemd-networkd[1395]: eth0: DHCP lease lost Jan 16 23:57:42.271689 waagent[1782]: 2026-01-16T23:57:42.271617Z INFO Daemon Daemon Create user account if not exists Jan 16 23:57:42.276540 waagent[1782]: 2026-01-16T23:57:42.276481Z INFO Daemon Daemon User core already exists, skip useradd Jan 16 23:57:42.281515 waagent[1782]: 2026-01-16T23:57:42.281467Z INFO Daemon Daemon Configure sudoer Jan 16 23:57:42.281882 systemd-networkd[1395]: eth0: DHCPv6 lease lost Jan 16 23:57:42.285594 waagent[1782]: 2026-01-16T23:57:42.285536Z INFO Daemon Daemon Configure sshd Jan 16 23:57:42.289380 waagent[1782]: 2026-01-16T23:57:42.289331Z INFO Daemon Daemon Added a configuration snippet disabling SSH password-based authentication methods. It also configures SSH client probing to keep connections alive. Jan 16 23:57:42.300225 waagent[1782]: 2026-01-16T23:57:42.300163Z INFO Daemon Daemon Deploy ssh public key. Jan 16 23:57:42.314891 systemd-networkd[1395]: eth0: DHCPv4 address 10.200.20.16/24, gateway 10.200.20.1 acquired from 168.63.129.16 Jan 16 23:57:43.442071 waagent[1782]: 2026-01-16T23:57:43.442024Z INFO Daemon Daemon Provisioning complete Jan 16 23:57:43.456195 waagent[1782]: 2026-01-16T23:57:43.456148Z INFO Daemon Daemon RDMA capabilities are not enabled, skipping Jan 16 23:57:43.461241 waagent[1782]: 2026-01-16T23:57:43.461192Z INFO Daemon Daemon End of log to /dev/console. The agent will now check for updates and then will process extensions. Jan 16 23:57:43.468981 waagent[1782]: 2026-01-16T23:57:43.468940Z INFO Daemon Daemon Installed Agent WALinuxAgent-2.9.1.1 is the most current agent Jan 16 23:57:43.603828 waagent[1845]: 2026-01-16T23:57:43.603670Z INFO ExtHandler ExtHandler Azure Linux Agent (Goal State Agent version 2.9.1.1) Jan 16 23:57:43.604121 waagent[1845]: 2026-01-16T23:57:43.603842Z INFO ExtHandler ExtHandler OS: flatcar 4081.3.6 Jan 16 23:57:43.604121 waagent[1845]: 2026-01-16T23:57:43.603912Z INFO ExtHandler ExtHandler Python: 3.11.9 Jan 16 23:57:43.664783 waagent[1845]: 2026-01-16T23:57:43.664689Z INFO ExtHandler ExtHandler Distro: flatcar-4081.3.6; OSUtil: FlatcarUtil; AgentService: waagent; Python: 3.11.9; systemd: True; LISDrivers: Absent; logrotate: logrotate 3.20.1; Jan 16 23:57:43.665010 waagent[1845]: 2026-01-16T23:57:43.664968Z INFO ExtHandler ExtHandler WireServer endpoint 168.63.129.16 read from file Jan 16 23:57:43.665079 waagent[1845]: 2026-01-16T23:57:43.665049Z INFO ExtHandler ExtHandler Wire server endpoint:168.63.129.16 Jan 16 23:57:43.673773 waagent[1845]: 2026-01-16T23:57:43.673684Z INFO ExtHandler Fetched a new incarnation for the WireServer goal state [incarnation 1] Jan 16 23:57:43.680259 waagent[1845]: 2026-01-16T23:57:43.680212Z INFO ExtHandler ExtHandler HostGAPlugin version: 1.0.8.177 Jan 16 23:57:43.680932 waagent[1845]: 2026-01-16T23:57:43.680861Z INFO ExtHandler Jan 16 23:57:43.681001 waagent[1845]: 2026-01-16T23:57:43.680966Z INFO ExtHandler Fetched new vmSettings [HostGAPlugin correlation ID: b9877181-9424-43d2-8206-9e9997f5d82b eTag: 14947913547471674943 source: Fabric] Jan 16 23:57:43.681358 waagent[1845]: 2026-01-16T23:57:43.681318Z INFO ExtHandler The vmSettings originated via Fabric; will ignore them. Jan 16 23:57:43.681963 waagent[1845]: 2026-01-16T23:57:43.681917Z INFO ExtHandler Jan 16 23:57:43.682033 waagent[1845]: 2026-01-16T23:57:43.682006Z INFO ExtHandler Fetching full goal state from the WireServer [incarnation 1] Jan 16 23:57:43.686160 waagent[1845]: 2026-01-16T23:57:43.686121Z INFO ExtHandler ExtHandler Downloading artifacts profile blob Jan 16 23:57:43.755709 waagent[1845]: 2026-01-16T23:57:43.755567Z INFO ExtHandler Downloaded certificate {'thumbprint': '322A603A1924A56D516DC9AD52A47C8D47A58CE7', 'hasPrivateKey': True} Jan 16 23:57:43.756236 waagent[1845]: 2026-01-16T23:57:43.756188Z INFO ExtHandler Fetch goal state completed Jan 16 23:57:43.768412 waagent[1845]: 2026-01-16T23:57:43.768362Z INFO ExtHandler ExtHandler WALinuxAgent-2.9.1.1 running as process 1845 Jan 16 23:57:43.768563 waagent[1845]: 2026-01-16T23:57:43.768530Z INFO ExtHandler ExtHandler ******** AutoUpdate.Enabled is set to False, not processing the operation ******** Jan 16 23:57:43.770193 waagent[1845]: 2026-01-16T23:57:43.770151Z INFO ExtHandler ExtHandler Cgroup monitoring is not supported on ['flatcar', '4081.3.6', '', 'Flatcar Container Linux by Kinvolk'] Jan 16 23:57:43.770566 waagent[1845]: 2026-01-16T23:57:43.770529Z INFO ExtHandler ExtHandler Starting setup for Persistent firewall rules Jan 16 23:57:43.798551 waagent[1845]: 2026-01-16T23:57:43.798506Z INFO ExtHandler ExtHandler Firewalld service not running/unavailable, trying to set up waagent-network-setup.service Jan 16 23:57:43.798760 waagent[1845]: 2026-01-16T23:57:43.798717Z INFO ExtHandler ExtHandler Successfully updated the Binary file /var/lib/waagent/waagent-network-setup.py for firewall setup Jan 16 23:57:43.804678 waagent[1845]: 2026-01-16T23:57:43.804641Z INFO ExtHandler ExtHandler Service: waagent-network-setup.service not enabled. Adding it now Jan 16 23:57:43.811709 systemd[1]: Reloading requested from client PID 1858 ('systemctl') (unit waagent.service)... Jan 16 23:57:43.811726 systemd[1]: Reloading... Jan 16 23:57:43.891876 zram_generator::config[1895]: No configuration found. Jan 16 23:57:43.979150 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. Jan 16 23:57:44.056640 systemd[1]: Reloading finished in 244 ms. Jan 16 23:57:44.076823 waagent[1845]: 2026-01-16T23:57:44.073991Z INFO ExtHandler ExtHandler Executing systemctl daemon-reload for setting up waagent-network-setup.service Jan 16 23:57:44.081032 systemd[1]: Reloading requested from client PID 1946 ('systemctl') (unit waagent.service)... Jan 16 23:57:44.081044 systemd[1]: Reloading... Jan 16 23:57:44.133828 zram_generator::config[1976]: No configuration found. Jan 16 23:57:44.257788 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. Jan 16 23:57:44.332651 systemd[1]: Reloading finished in 251 ms. Jan 16 23:57:44.357530 waagent[1845]: 2026-01-16T23:57:44.356693Z INFO ExtHandler ExtHandler Successfully added and enabled the waagent-network-setup.service Jan 16 23:57:44.357530 waagent[1845]: 2026-01-16T23:57:44.356872Z INFO ExtHandler ExtHandler Persistent firewall rules setup successfully Jan 16 23:57:44.699819 waagent[1845]: 2026-01-16T23:57:44.699731Z INFO ExtHandler ExtHandler DROP rule is not available which implies no firewall rules are set yet. Environment thread will set it up. Jan 16 23:57:44.700429 waagent[1845]: 2026-01-16T23:57:44.700370Z 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] Jan 16 23:57:44.701268 waagent[1845]: 2026-01-16T23:57:44.701189Z INFO ExtHandler ExtHandler Starting env monitor service. Jan 16 23:57:44.701790 waagent[1845]: 2026-01-16T23:57:44.701580Z INFO ExtHandler ExtHandler Start SendTelemetryHandler service. Jan 16 23:57:44.701790 waagent[1845]: 2026-01-16T23:57:44.701733Z INFO EnvHandler ExtHandler WireServer endpoint 168.63.129.16 read from file Jan 16 23:57:44.702080 waagent[1845]: 2026-01-16T23:57:44.702031Z INFO MonitorHandler ExtHandler WireServer endpoint 168.63.129.16 read from file Jan 16 23:57:44.702846 waagent[1845]: 2026-01-16T23:57:44.702210Z INFO EnvHandler ExtHandler Wire server endpoint:168.63.129.16 Jan 16 23:57:44.702846 waagent[1845]: 2026-01-16T23:57:44.702380Z INFO EnvHandler ExtHandler Configure routes Jan 16 23:57:44.702846 waagent[1845]: 2026-01-16T23:57:44.702446Z INFO EnvHandler ExtHandler Gateway:None Jan 16 23:57:44.702846 waagent[1845]: 2026-01-16T23:57:44.702493Z INFO EnvHandler ExtHandler Routes:None Jan 16 23:57:44.703202 waagent[1845]: 2026-01-16T23:57:44.703042Z INFO SendTelemetryHandler ExtHandler Successfully started the SendTelemetryHandler thread Jan 16 23:57:44.703533 waagent[1845]: 2026-01-16T23:57:44.703272Z INFO ExtHandler ExtHandler Start Extension Telemetry service. Jan 16 23:57:44.703883 waagent[1845]: 2026-01-16T23:57:44.703829Z INFO MonitorHandler ExtHandler Wire server endpoint:168.63.129.16 Jan 16 23:57:44.704042 waagent[1845]: 2026-01-16T23:57:44.704005Z INFO TelemetryEventsCollector ExtHandler Extension Telemetry pipeline enabled: True Jan 16 23:57:44.704377 waagent[1845]: 2026-01-16T23:57:44.704330Z INFO MonitorHandler ExtHandler Monitor.NetworkConfigurationChanges is disabled. Jan 16 23:57:44.704552 waagent[1845]: 2026-01-16T23:57:44.704513Z INFO TelemetryEventsCollector ExtHandler Successfully started the TelemetryEventsCollector thread Jan 16 23:57:44.705976 waagent[1845]: 2026-01-16T23:57:44.705937Z INFO ExtHandler ExtHandler Goal State Period: 6 sec. This indicates how often the agent checks for new goal states and reports status. Jan 16 23:57:44.706765 waagent[1845]: 2026-01-16T23:57:44.706719Z INFO MonitorHandler ExtHandler Routing table from /proc/net/route: Jan 16 23:57:44.706765 waagent[1845]: Iface Destination Gateway Flags RefCnt Use Metric Mask MTU Window IRTT Jan 16 23:57:44.706765 waagent[1845]: eth0 00000000 0114C80A 0003 0 0 1024 00000000 0 0 0 Jan 16 23:57:44.706765 waagent[1845]: eth0 0014C80A 00000000 0001 0 0 1024 00FFFFFF 0 0 0 Jan 16 23:57:44.706765 waagent[1845]: eth0 0114C80A 00000000 0005 0 0 1024 FFFFFFFF 0 0 0 Jan 16 23:57:44.706765 waagent[1845]: eth0 10813FA8 0114C80A 0007 0 0 1024 FFFFFFFF 0 0 0 Jan 16 23:57:44.706765 waagent[1845]: eth0 FEA9FEA9 0114C80A 0007 0 0 1024 FFFFFFFF 0 0 0 Jan 16 23:57:44.715826 waagent[1845]: 2026-01-16T23:57:44.714009Z INFO ExtHandler ExtHandler Jan 16 23:57:44.715826 waagent[1845]: 2026-01-16T23:57:44.714149Z INFO ExtHandler ExtHandler ProcessExtensionsGoalState started [incarnation_1 channel: WireServer source: Fabric activity: 73c2c8e5-a481-49d7-9073-c16fe8711c56 correlation a18bac20-fd71-4f5d-bdfe-9ae589769211 created: 2026-01-16T23:56:49.563751Z] Jan 16 23:57:44.715826 waagent[1845]: 2026-01-16T23:57:44.714545Z INFO ExtHandler ExtHandler No extension handlers found, not processing anything. Jan 16 23:57:44.715826 waagent[1845]: 2026-01-16T23:57:44.715162Z INFO ExtHandler ExtHandler ProcessExtensionsGoalState completed [incarnation_1 1 ms] Jan 16 23:57:44.749522 waagent[1845]: 2026-01-16T23:57:44.749449Z INFO MonitorHandler ExtHandler Network interfaces: Jan 16 23:57:44.749522 waagent[1845]: Executing ['ip', '-a', '-o', 'link']: Jan 16 23:57:44.749522 waagent[1845]: 1: lo: mtu 65536 qdisc noqueue state UNKNOWN mode DEFAULT group default qlen 1000\ link/loopback 00:00:00:00:00:00 brd 00:00:00:00:00:00 Jan 16 23:57:44.749522 waagent[1845]: 2: eth0: mtu 1500 qdisc mq state UP mode DEFAULT group default qlen 1000\ link/ether 7c:ed:8d:89:6c:c4 brd ff:ff:ff:ff:ff:ff Jan 16 23:57:44.749522 waagent[1845]: 3: enP5732s1: mtu 1500 qdisc mq master eth0 state UP mode DEFAULT group default qlen 1000\ link/ether 7c:ed:8d:89:6c:c4 brd ff:ff:ff:ff:ff:ff\ altname enP5732p0s2 Jan 16 23:57:44.749522 waagent[1845]: Executing ['ip', '-4', '-a', '-o', 'address']: Jan 16 23:57:44.749522 waagent[1845]: 1: lo inet 127.0.0.1/8 scope host lo\ valid_lft forever preferred_lft forever Jan 16 23:57:44.749522 waagent[1845]: 2: eth0 inet 10.200.20.16/24 metric 1024 brd 10.200.20.255 scope global eth0\ valid_lft forever preferred_lft forever Jan 16 23:57:44.749522 waagent[1845]: Executing ['ip', '-6', '-a', '-o', 'address']: Jan 16 23:57:44.749522 waagent[1845]: 1: lo inet6 ::1/128 scope host noprefixroute \ valid_lft forever preferred_lft forever Jan 16 23:57:44.749522 waagent[1845]: 2: eth0 inet6 fe80::7eed:8dff:fe89:6cc4/64 scope link proto kernel_ll \ valid_lft forever preferred_lft forever Jan 16 23:57:44.751093 waagent[1845]: 2026-01-16T23:57:44.751041Z INFO ExtHandler ExtHandler [HEARTBEAT] Agent WALinuxAgent-2.9.1.1 is running as the goal state agent [DEBUG HeartbeatCounter: 0;HeartbeatId: 49E63BB8-E004-4285-B193-C4AFA2D4E128;DroppedPackets: 0;UpdateGSErrors: 0;AutoUpdate: 0] Jan 16 23:57:44.836097 waagent[1845]: 2026-01-16T23:57:44.836022Z INFO EnvHandler ExtHandler Successfully added Azure fabric firewall rules. Current Firewall rules: Jan 16 23:57:44.836097 waagent[1845]: Chain INPUT (policy ACCEPT 0 packets, 0 bytes) Jan 16 23:57:44.836097 waagent[1845]: pkts bytes target prot opt in out source destination Jan 16 23:57:44.836097 waagent[1845]: Chain FORWARD (policy ACCEPT 0 packets, 0 bytes) Jan 16 23:57:44.836097 waagent[1845]: pkts bytes target prot opt in out source destination Jan 16 23:57:44.836097 waagent[1845]: Chain OUTPUT (policy ACCEPT 0 packets, 0 bytes) Jan 16 23:57:44.836097 waagent[1845]: pkts bytes target prot opt in out source destination Jan 16 23:57:44.836097 waagent[1845]: 0 0 ACCEPT tcp -- * * 0.0.0.0/0 168.63.129.16 tcp dpt:53 Jan 16 23:57:44.836097 waagent[1845]: 0 0 ACCEPT tcp -- * * 0.0.0.0/0 168.63.129.16 owner UID match 0 Jan 16 23:57:44.836097 waagent[1845]: 0 0 DROP tcp -- * * 0.0.0.0/0 168.63.129.16 ctstate INVALID,NEW Jan 16 23:57:44.839773 waagent[1845]: 2026-01-16T23:57:44.839715Z INFO EnvHandler ExtHandler Current Firewall rules: Jan 16 23:57:44.839773 waagent[1845]: Chain INPUT (policy ACCEPT 0 packets, 0 bytes) Jan 16 23:57:44.839773 waagent[1845]: pkts bytes target prot opt in out source destination Jan 16 23:57:44.839773 waagent[1845]: Chain FORWARD (policy ACCEPT 0 packets, 0 bytes) Jan 16 23:57:44.839773 waagent[1845]: pkts bytes target prot opt in out source destination Jan 16 23:57:44.839773 waagent[1845]: Chain OUTPUT (policy ACCEPT 0 packets, 0 bytes) Jan 16 23:57:44.839773 waagent[1845]: pkts bytes target prot opt in out source destination Jan 16 23:57:44.839773 waagent[1845]: 0 0 ACCEPT tcp -- * * 0.0.0.0/0 168.63.129.16 tcp dpt:53 Jan 16 23:57:44.839773 waagent[1845]: 0 0 ACCEPT tcp -- * * 0.0.0.0/0 168.63.129.16 owner UID match 0 Jan 16 23:57:44.839773 waagent[1845]: 0 0 DROP tcp -- * * 0.0.0.0/0 168.63.129.16 ctstate INVALID,NEW Jan 16 23:57:44.840363 waagent[1845]: 2026-01-16T23:57:44.840331Z INFO EnvHandler ExtHandler Set block dev timeout: sda with timeout: 300 Jan 16 23:58:02.769955 chronyd[1652]: Selected source PHC0 Jan 16 23:58:05.618907 systemd[1]: Created slice system-sshd.slice - Slice /system/sshd. Jan 16 23:58:05.620067 systemd[1]: Started sshd@0-10.200.20.16:22-10.200.16.10:38186.service - OpenSSH per-connection server daemon (10.200.16.10:38186). Jan 16 23:58:06.133385 sshd[2066]: Accepted publickey for core from 10.200.16.10 port 38186 ssh2: RSA SHA256:h9EzKM+OQiROMon03wb6yima4rGeMK2wJ6P2Si2QWb8 Jan 16 23:58:06.134717 sshd[2066]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Jan 16 23:58:06.138445 systemd-logind[1667]: New session 3 of user core. Jan 16 23:58:06.146987 systemd[1]: Started session-3.scope - Session 3 of User core. Jan 16 23:58:06.541101 systemd[1]: Started sshd@1-10.200.20.16:22-10.200.16.10:38196.service - OpenSSH per-connection server daemon (10.200.16.10:38196). Jan 16 23:58:06.998957 sshd[2071]: Accepted publickey for core from 10.200.16.10 port 38196 ssh2: RSA SHA256:h9EzKM+OQiROMon03wb6yima4rGeMK2wJ6P2Si2QWb8 Jan 16 23:58:07.000292 sshd[2071]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Jan 16 23:58:07.004201 systemd-logind[1667]: New session 4 of user core. Jan 16 23:58:07.009936 systemd[1]: Started session-4.scope - Session 4 of User core. Jan 16 23:58:07.331204 sshd[2071]: pam_unix(sshd:session): session closed for user core Jan 16 23:58:07.335068 systemd[1]: sshd@1-10.200.20.16:22-10.200.16.10:38196.service: Deactivated successfully. Jan 16 23:58:07.336609 systemd[1]: session-4.scope: Deactivated successfully. Jan 16 23:58:07.337227 systemd-logind[1667]: Session 4 logged out. Waiting for processes to exit. Jan 16 23:58:07.338441 systemd-logind[1667]: Removed session 4. Jan 16 23:58:07.418263 systemd[1]: Started sshd@2-10.200.20.16:22-10.200.16.10:38200.service - OpenSSH per-connection server daemon (10.200.16.10:38200). Jan 16 23:58:07.904824 sshd[2078]: Accepted publickey for core from 10.200.16.10 port 38200 ssh2: RSA SHA256:h9EzKM+OQiROMon03wb6yima4rGeMK2wJ6P2Si2QWb8 Jan 16 23:58:07.906182 sshd[2078]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Jan 16 23:58:07.909775 systemd-logind[1667]: New session 5 of user core. Jan 16 23:58:07.916931 systemd[1]: Started session-5.scope - Session 5 of User core. Jan 16 23:58:08.249572 sshd[2078]: pam_unix(sshd:session): session closed for user core Jan 16 23:58:08.252950 systemd[1]: sshd@2-10.200.20.16:22-10.200.16.10:38200.service: Deactivated successfully. Jan 16 23:58:08.254767 systemd[1]: session-5.scope: Deactivated successfully. Jan 16 23:58:08.256556 systemd-logind[1667]: Session 5 logged out. Waiting for processes to exit. Jan 16 23:58:08.257329 systemd-logind[1667]: Removed session 5. Jan 16 23:58:08.337921 systemd[1]: Started sshd@3-10.200.20.16:22-10.200.16.10:38216.service - OpenSSH per-connection server daemon (10.200.16.10:38216). Jan 16 23:58:08.825742 sshd[2085]: Accepted publickey for core from 10.200.16.10 port 38216 ssh2: RSA SHA256:h9EzKM+OQiROMon03wb6yima4rGeMK2wJ6P2Si2QWb8 Jan 16 23:58:08.827152 sshd[2085]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Jan 16 23:58:08.831978 systemd-logind[1667]: New session 6 of user core. Jan 16 23:58:08.840971 systemd[1]: Started session-6.scope - Session 6 of User core. Jan 16 23:58:09.179300 sshd[2085]: pam_unix(sshd:session): session closed for user core Jan 16 23:58:09.182530 systemd[1]: sshd@3-10.200.20.16:22-10.200.16.10:38216.service: Deactivated successfully. Jan 16 23:58:09.186049 systemd[1]: session-6.scope: Deactivated successfully. Jan 16 23:58:09.186689 systemd-logind[1667]: Session 6 logged out. Waiting for processes to exit. Jan 16 23:58:09.187612 systemd-logind[1667]: Removed session 6. Jan 16 23:58:09.266330 systemd[1]: Started sshd@4-10.200.20.16:22-10.200.16.10:38232.service - OpenSSH per-connection server daemon (10.200.16.10:38232). Jan 16 23:58:09.753974 sshd[2092]: Accepted publickey for core from 10.200.16.10 port 38232 ssh2: RSA SHA256:h9EzKM+OQiROMon03wb6yima4rGeMK2wJ6P2Si2QWb8 Jan 16 23:58:09.755348 sshd[2092]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Jan 16 23:58:09.760330 systemd-logind[1667]: New session 7 of user core. Jan 16 23:58:09.766955 systemd[1]: Started session-7.scope - Session 7 of User core. Jan 16 23:58:10.184635 sudo[2095]: core : PWD=/home/core ; USER=root ; COMMAND=/usr/sbin/setenforce 1 Jan 16 23:58:10.184913 sudo[2095]: pam_unix(sudo:session): session opened for user root(uid=0) by core(uid=500) Jan 16 23:58:10.197737 sudo[2095]: pam_unix(sudo:session): session closed for user root Jan 16 23:58:10.275710 sshd[2092]: pam_unix(sshd:session): session closed for user core Jan 16 23:58:10.279567 systemd[1]: sshd@4-10.200.20.16:22-10.200.16.10:38232.service: Deactivated successfully. Jan 16 23:58:10.281466 systemd[1]: session-7.scope: Deactivated successfully. Jan 16 23:58:10.282259 systemd-logind[1667]: Session 7 logged out. Waiting for processes to exit. Jan 16 23:58:10.283244 systemd-logind[1667]: Removed session 7. Jan 16 23:58:10.363424 systemd[1]: Started sshd@5-10.200.20.16:22-10.200.16.10:43132.service - OpenSSH per-connection server daemon (10.200.16.10:43132). Jan 16 23:58:10.853976 sshd[2100]: Accepted publickey for core from 10.200.16.10 port 43132 ssh2: RSA SHA256:h9EzKM+OQiROMon03wb6yima4rGeMK2wJ6P2Si2QWb8 Jan 16 23:58:10.855441 sshd[2100]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Jan 16 23:58:10.860327 systemd-logind[1667]: New session 8 of user core. Jan 16 23:58:10.866024 systemd[1]: Started session-8.scope - Session 8 of User core. Jan 16 23:58:11.130781 sudo[2104]: core : PWD=/home/core ; USER=root ; COMMAND=/usr/bin/rm -rf /etc/audit/rules.d/80-selinux.rules /etc/audit/rules.d/99-default.rules Jan 16 23:58:11.131059 sudo[2104]: pam_unix(sudo:session): session opened for user root(uid=0) by core(uid=500) Jan 16 23:58:11.134251 sudo[2104]: pam_unix(sudo:session): session closed for user root Jan 16 23:58:11.139394 sudo[2103]: core : PWD=/home/core ; USER=root ; COMMAND=/usr/bin/systemctl restart audit-rules Jan 16 23:58:11.139665 sudo[2103]: pam_unix(sudo:session): session opened for user root(uid=0) by core(uid=500) Jan 16 23:58:11.153034 systemd[1]: Stopping audit-rules.service - Load Security Auditing Rules... Jan 16 23:58:11.155020 auditctl[2107]: No rules Jan 16 23:58:11.155341 systemd[1]: audit-rules.service: Deactivated successfully. Jan 16 23:58:11.155517 systemd[1]: Stopped audit-rules.service - Load Security Auditing Rules. Jan 16 23:58:11.158477 systemd[1]: Starting audit-rules.service - Load Security Auditing Rules... Jan 16 23:58:11.188678 augenrules[2125]: No rules Jan 16 23:58:11.190256 systemd[1]: Finished audit-rules.service - Load Security Auditing Rules. Jan 16 23:58:11.192158 sudo[2103]: pam_unix(sudo:session): session closed for user root Jan 16 23:58:11.270350 sshd[2100]: pam_unix(sshd:session): session closed for user core Jan 16 23:58:11.272845 systemd[1]: sshd@5-10.200.20.16:22-10.200.16.10:43132.service: Deactivated successfully. Jan 16 23:58:11.274283 systemd[1]: session-8.scope: Deactivated successfully. Jan 16 23:58:11.276128 systemd-logind[1667]: Session 8 logged out. Waiting for processes to exit. Jan 16 23:58:11.277181 systemd-logind[1667]: Removed session 8. Jan 16 23:58:11.360112 systemd[1]: Started sshd@6-10.200.20.16:22-10.200.16.10:43146.service - OpenSSH per-connection server daemon (10.200.16.10:43146). Jan 16 23:58:11.847232 sshd[2133]: Accepted publickey for core from 10.200.16.10 port 43146 ssh2: RSA SHA256:h9EzKM+OQiROMon03wb6yima4rGeMK2wJ6P2Si2QWb8 Jan 16 23:58:11.848596 sshd[2133]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Jan 16 23:58:11.852744 systemd-logind[1667]: New session 9 of user core. Jan 16 23:58:11.863940 systemd[1]: Started session-9.scope - Session 9 of User core. Jan 16 23:58:12.121928 sudo[2136]: core : PWD=/home/core ; USER=root ; COMMAND=/usr/sbin/blkid -s UUID -o value /dev/disk/by-label/ROOT Jan 16 23:58:12.122202 sudo[2136]: pam_unix(sudo:session): session opened for user root(uid=0) by core(uid=500) Jan 16 23:58:12.147620 sudo[2136]: pam_unix(sudo:session): session closed for user root Jan 16 23:58:12.219065 sshd[2133]: pam_unix(sshd:session): session closed for user core Jan 16 23:58:12.222450 systemd[1]: sshd@6-10.200.20.16:22-10.200.16.10:43146.service: Deactivated successfully. Jan 16 23:58:12.224251 systemd[1]: session-9.scope: Deactivated successfully. Jan 16 23:58:12.225031 systemd-logind[1667]: Session 9 logged out. Waiting for processes to exit. Jan 16 23:58:12.225766 systemd-logind[1667]: Removed session 9. Jan 16 23:58:12.306676 systemd[1]: Started sshd@7-10.200.20.16:22-10.200.16.10:43148.service - OpenSSH per-connection server daemon (10.200.16.10:43148). Jan 16 23:58:12.792849 sshd[2141]: Accepted publickey for core from 10.200.16.10 port 43148 ssh2: RSA SHA256:h9EzKM+OQiROMon03wb6yima4rGeMK2wJ6P2Si2QWb8 Jan 16 23:58:12.794291 sshd[2141]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Jan 16 23:58:12.799185 systemd-logind[1667]: New session 10 of user core. Jan 16 23:58:12.805976 systemd[1]: Started session-10.scope - Session 10 of User core. Jan 16 23:58:13.067174 sudo[2144]: core : PWD=/home/core ; USER=root ; COMMAND=/usr/sbin/blkid -s TYPE -o value /dev/disk/by-label/ROOT Jan 16 23:58:13.067446 sudo[2144]: pam_unix(sudo:session): session opened for user root(uid=0) by core(uid=500) Jan 16 23:58:13.070737 sudo[2144]: pam_unix(sudo:session): session closed for user root Jan 16 23:58:13.147565 sshd[2141]: pam_unix(sshd:session): session closed for user core Jan 16 23:58:13.151713 systemd[1]: sshd@7-10.200.20.16:22-10.200.16.10:43148.service: Deactivated successfully. Jan 16 23:58:13.153263 systemd[1]: session-10.scope: Deactivated successfully. Jan 16 23:58:13.155311 systemd-logind[1667]: Session 10 logged out. Waiting for processes to exit. Jan 16 23:58:13.156432 systemd-logind[1667]: Removed session 10. Jan 16 23:58:13.234189 systemd[1]: Started sshd@8-10.200.20.16:22-10.200.16.10:43152.service - OpenSSH per-connection server daemon (10.200.16.10:43152). Jan 16 23:58:13.721597 sshd[2149]: Accepted publickey for core from 10.200.16.10 port 43152 ssh2: RSA SHA256:h9EzKM+OQiROMon03wb6yima4rGeMK2wJ6P2Si2QWb8 Jan 16 23:58:13.722939 sshd[2149]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Jan 16 23:58:13.727547 systemd-logind[1667]: New session 11 of user core. Jan 16 23:58:13.733952 systemd[1]: Started session-11.scope - Session 11 of User core. Jan 16 23:58:14.089761 sshd[2149]: pam_unix(sshd:session): session closed for user core Jan 16 23:58:14.094175 systemd[1]: sshd@8-10.200.20.16:22-10.200.16.10:43152.service: Deactivated successfully. Jan 16 23:58:14.095926 systemd[1]: session-11.scope: Deactivated successfully. Jan 16 23:58:14.096585 systemd-logind[1667]: Session 11 logged out. Waiting for processes to exit. Jan 16 23:58:14.097365 systemd-logind[1667]: Removed session 11.