Jan 28 01:24:45.214716 kernel: Booting Linux on physical CPU 0x0000000000 [0x413fd0c1] Jan 28 01:24:45.214738 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 Tue Jan 27 23:05:14 -00 2026 Jan 28 01:24:45.214746 kernel: KASLR enabled Jan 28 01:24:45.214752 kernel: earlycon: pl11 at MMIO 0x00000000effec000 (options '') Jan 28 01:24:45.214759 kernel: printk: bootconsole [pl11] enabled Jan 28 01:24:45.214765 kernel: efi: EFI v2.7 by EDK II Jan 28 01:24:45.214772 kernel: efi: ACPI 2.0=0x3fd5f018 SMBIOS=0x3e580000 SMBIOS 3.0=0x3e560000 MEMATTR=0x3f215018 RNG=0x3fd5f998 MEMRESERVE=0x3e44ee18 Jan 28 01:24:45.214778 kernel: random: crng init done Jan 28 01:24:45.214784 kernel: ACPI: Early table checksum verification disabled Jan 28 01:24:45.214790 kernel: ACPI: RSDP 0x000000003FD5F018 000024 (v02 VRTUAL) Jan 28 01:24:45.214797 kernel: ACPI: XSDT 0x000000003FD5FF18 00006C (v01 VRTUAL MICROSFT 00000001 MSFT 00000001) Jan 28 01:24:45.214803 kernel: ACPI: FACP 0x000000003FD5FC18 000114 (v06 VRTUAL MICROSFT 00000001 MSFT 00000001) Jan 28 01:24:45.214810 kernel: ACPI: DSDT 0x000000003FD41018 01DFCD (v02 MSFTVM DSDT01 00000001 INTL 20230628) Jan 28 01:24:45.214816 kernel: ACPI: DBG2 0x000000003FD5FB18 000072 (v00 VRTUAL MICROSFT 00000001 MSFT 00000001) Jan 28 01:24:45.214824 kernel: ACPI: GTDT 0x000000003FD5FD98 000060 (v02 VRTUAL MICROSFT 00000001 MSFT 00000001) Jan 28 01:24:45.214830 kernel: ACPI: OEM0 0x000000003FD5F098 000064 (v01 VRTUAL MICROSFT 00000001 MSFT 00000001) Jan 28 01:24:45.214837 kernel: ACPI: SPCR 0x000000003FD5FA98 000050 (v02 VRTUAL MICROSFT 00000001 MSFT 00000001) Jan 28 01:24:45.214845 kernel: ACPI: APIC 0x000000003FD5F818 0000FC (v04 VRTUAL MICROSFT 00000001 MSFT 00000001) Jan 28 01:24:45.214851 kernel: ACPI: SRAT 0x000000003FD5F198 000234 (v03 VRTUAL MICROSFT 00000001 MSFT 00000001) Jan 28 01:24:45.214858 kernel: ACPI: PPTT 0x000000003FD5F418 000120 (v01 VRTUAL MICROSFT 00000000 MSFT 00000000) Jan 28 01:24:45.214864 kernel: ACPI: BGRT 0x000000003FD5FE98 000038 (v01 VRTUAL MICROSFT 00000001 MSFT 00000001) Jan 28 01:24:45.214871 kernel: ACPI: SPCR: console: pl011,mmio32,0xeffec000,115200 Jan 28 01:24:45.214877 kernel: ACPI: SRAT: Node 0 PXM 0 [mem 0x00000000-0x3fffffff] Jan 28 01:24:45.214883 kernel: ACPI: SRAT: Node 0 PXM 0 [mem 0x100000000-0x1bfffffff] Jan 28 01:24:45.214890 kernel: ACPI: SRAT: Node 0 PXM 0 [mem 0x1c0000000-0xfbfffffff] Jan 28 01:24:45.214896 kernel: ACPI: SRAT: Node 0 PXM 0 [mem 0x1000000000-0xffffffffff] Jan 28 01:24:45.214902 kernel: ACPI: SRAT: Node 0 PXM 0 [mem 0x10000000000-0x1ffffffffff] Jan 28 01:24:45.214909 kernel: ACPI: SRAT: Node 0 PXM 0 [mem 0x20000000000-0x3ffffffffff] Jan 28 01:24:45.214917 kernel: ACPI: SRAT: Node 0 PXM 0 [mem 0x40000000000-0x7ffffffffff] Jan 28 01:24:45.214923 kernel: ACPI: SRAT: Node 0 PXM 0 [mem 0x80000000000-0xfffffffffff] Jan 28 01:24:45.214930 kernel: ACPI: SRAT: Node 0 PXM 0 [mem 0x100000000000-0x1fffffffffff] Jan 28 01:24:45.214936 kernel: ACPI: SRAT: Node 0 PXM 0 [mem 0x200000000000-0x3fffffffffff] Jan 28 01:24:45.214942 kernel: ACPI: SRAT: Node 0 PXM 0 [mem 0x400000000000-0x7fffffffffff] Jan 28 01:24:45.214949 kernel: ACPI: SRAT: Node 0 PXM 0 [mem 0x800000000000-0xffffffffffff] Jan 28 01:24:45.214955 kernel: NUMA: NODE_DATA [mem 0x1bf7ee800-0x1bf7f3fff] Jan 28 01:24:45.214961 kernel: Zone ranges: Jan 28 01:24:45.214968 kernel: DMA [mem 0x0000000000000000-0x00000000ffffffff] Jan 28 01:24:45.214974 kernel: DMA32 empty Jan 28 01:24:45.214980 kernel: Normal [mem 0x0000000100000000-0x00000001bfffffff] Jan 28 01:24:45.214987 kernel: Movable zone start for each node Jan 28 01:24:45.214997 kernel: Early memory node ranges Jan 28 01:24:45.215004 kernel: node 0: [mem 0x0000000000000000-0x00000000007fffff] Jan 28 01:24:45.215011 kernel: node 0: [mem 0x0000000000824000-0x000000003e54ffff] Jan 28 01:24:45.215017 kernel: node 0: [mem 0x000000003e550000-0x000000003e87ffff] Jan 28 01:24:45.215024 kernel: node 0: [mem 0x000000003e880000-0x000000003fc7ffff] Jan 28 01:24:45.215033 kernel: node 0: [mem 0x000000003fc80000-0x000000003fcfffff] Jan 28 01:24:45.215040 kernel: node 0: [mem 0x000000003fd00000-0x000000003fffffff] Jan 28 01:24:45.215046 kernel: node 0: [mem 0x0000000100000000-0x00000001bfffffff] Jan 28 01:24:45.215053 kernel: Initmem setup node 0 [mem 0x0000000000000000-0x00000001bfffffff] Jan 28 01:24:45.215060 kernel: On node 0, zone DMA: 36 pages in unavailable ranges Jan 28 01:24:45.215067 kernel: psci: probing for conduit method from ACPI. Jan 28 01:24:45.215074 kernel: psci: PSCIv1.1 detected in firmware. Jan 28 01:24:45.215081 kernel: psci: Using standard PSCI v0.2 function IDs Jan 28 01:24:45.215088 kernel: psci: MIGRATE_INFO_TYPE not supported. Jan 28 01:24:45.215095 kernel: psci: SMC Calling Convention v1.4 Jan 28 01:24:45.215101 kernel: ACPI: NUMA: SRAT: PXM 0 -> MPIDR 0x0 -> Node 0 Jan 28 01:24:45.217153 kernel: ACPI: NUMA: SRAT: PXM 0 -> MPIDR 0x1 -> Node 0 Jan 28 01:24:45.217175 kernel: percpu: Embedded 30 pages/cpu s85672 r8192 d29016 u122880 Jan 28 01:24:45.217183 kernel: pcpu-alloc: s85672 r8192 d29016 u122880 alloc=30*4096 Jan 28 01:24:45.217190 kernel: pcpu-alloc: [0] 0 [0] 1 Jan 28 01:24:45.217197 kernel: Detected PIPT I-cache on CPU0 Jan 28 01:24:45.217204 kernel: CPU features: detected: GIC system register CPU interface Jan 28 01:24:45.217211 kernel: CPU features: detected: Hardware dirty bit management Jan 28 01:24:45.217218 kernel: CPU features: detected: Spectre-BHB Jan 28 01:24:45.217225 kernel: CPU features: kernel page table isolation forced ON by KASLR Jan 28 01:24:45.217232 kernel: CPU features: detected: Kernel page table isolation (KPTI) Jan 28 01:24:45.217238 kernel: CPU features: detected: ARM erratum 1418040 Jan 28 01:24:45.217245 kernel: CPU features: detected: ARM erratum 1542419 (kernel portion) Jan 28 01:24:45.217254 kernel: CPU features: detected: SSBS not fully self-synchronizing Jan 28 01:24:45.217260 kernel: alternatives: applying boot alternatives Jan 28 01:24:45.217269 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=e7a8cac0a248eeeb18f7bcbd95b9dbb1e3415729dc1af128dd9f394f73832ecf Jan 28 01:24:45.217277 kernel: Dentry cache hash table entries: 524288 (order: 10, 4194304 bytes, linear) Jan 28 01:24:45.217284 kernel: Inode-cache hash table entries: 262144 (order: 9, 2097152 bytes, linear) Jan 28 01:24:45.217291 kernel: Fallback order for Node 0: 0 Jan 28 01:24:45.217297 kernel: Built 1 zonelists, mobility grouping on. Total pages: 1032156 Jan 28 01:24:45.217304 kernel: Policy zone: Normal Jan 28 01:24:45.217311 kernel: mem auto-init: stack:off, heap alloc:off, heap free:off Jan 28 01:24:45.217318 kernel: software IO TLB: area num 2. Jan 28 01:24:45.217324 kernel: software IO TLB: mapped [mem 0x000000003a44e000-0x000000003e44e000] (64MB) Jan 28 01:24:45.217333 kernel: Memory: 3982632K/4194160K available (10304K kernel code, 2180K rwdata, 8112K rodata, 39424K init, 897K bss, 211528K reserved, 0K cma-reserved) Jan 28 01:24:45.217340 kernel: SLUB: HWalign=64, Order=0-3, MinObjects=0, CPUs=2, Nodes=1 Jan 28 01:24:45.217347 kernel: rcu: Preemptible hierarchical RCU implementation. Jan 28 01:24:45.217354 kernel: rcu: RCU event tracing is enabled. Jan 28 01:24:45.217361 kernel: rcu: RCU restricting CPUs from NR_CPUS=512 to nr_cpu_ids=2. Jan 28 01:24:45.217368 kernel: Trampoline variant of Tasks RCU enabled. Jan 28 01:24:45.217375 kernel: Tracing variant of Tasks RCU enabled. Jan 28 01:24:45.217382 kernel: rcu: RCU calculated value of scheduler-enlistment delay is 100 jiffies. Jan 28 01:24:45.217389 kernel: rcu: Adjusting geometry for rcu_fanout_leaf=16, nr_cpu_ids=2 Jan 28 01:24:45.217396 kernel: NR_IRQS: 64, nr_irqs: 64, preallocated irqs: 0 Jan 28 01:24:45.217403 kernel: GICv3: 960 SPIs implemented Jan 28 01:24:45.217411 kernel: GICv3: 0 Extended SPIs implemented Jan 28 01:24:45.217418 kernel: Root IRQ handler: gic_handle_irq Jan 28 01:24:45.217425 kernel: GICv3: GICv3 features: 16 PPIs, RSS Jan 28 01:24:45.217431 kernel: GICv3: CPU0: found redistributor 0 region 0:0x00000000effee000 Jan 28 01:24:45.217438 kernel: ITS: No ITS available, not enabling LPIs Jan 28 01:24:45.217445 kernel: rcu: srcu_init: Setting srcu_struct sizes based on contention. Jan 28 01:24:45.217452 kernel: arch_timer: Enabling local workaround for ARM erratum 1418040 Jan 28 01:24:45.217459 kernel: arch_timer: cp15 timer(s) running at 25.00MHz (virt). Jan 28 01:24:45.217466 kernel: clocksource: arch_sys_counter: mask: 0xffffffffffffff max_cycles: 0x5c40939b5, max_idle_ns: 440795202646 ns Jan 28 01:24:45.217473 kernel: sched_clock: 56 bits at 25MHz, resolution 40ns, wraps every 4398046511100ns Jan 28 01:24:45.217480 kernel: Console: colour dummy device 80x25 Jan 28 01:24:45.217488 kernel: printk: console [tty1] enabled Jan 28 01:24:45.217496 kernel: ACPI: Core revision 20230628 Jan 28 01:24:45.217503 kernel: Calibrating delay loop (skipped), value calculated using timer frequency.. 50.00 BogoMIPS (lpj=25000) Jan 28 01:24:45.217510 kernel: pid_max: default: 32768 minimum: 301 Jan 28 01:24:45.217517 kernel: LSM: initializing lsm=lockdown,capability,landlock,selinux,integrity Jan 28 01:24:45.217524 kernel: landlock: Up and running. Jan 28 01:24:45.217531 kernel: SELinux: Initializing. Jan 28 01:24:45.217538 kernel: Mount-cache hash table entries: 8192 (order: 4, 65536 bytes, linear) Jan 28 01:24:45.217545 kernel: Mountpoint-cache hash table entries: 8192 (order: 4, 65536 bytes, linear) Jan 28 01:24:45.217554 kernel: RCU Tasks: Setting shift to 1 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=2. Jan 28 01:24:45.217561 kernel: RCU Tasks Trace: Setting shift to 1 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=2. Jan 28 01:24:45.217568 kernel: Hyper-V: privilege flags low 0x2e7f, high 0x3a8030, hints 0x100000e, misc 0x31e1 Jan 28 01:24:45.217575 kernel: Hyper-V: Host Build 10.0.26100.1448-1-0 Jan 28 01:24:45.217582 kernel: Hyper-V: enabling crash_kexec_post_notifiers Jan 28 01:24:45.217589 kernel: rcu: Hierarchical SRCU implementation. Jan 28 01:24:45.217596 kernel: rcu: Max phase no-delay instances is 400. Jan 28 01:24:45.217603 kernel: Remapping and enabling EFI services. Jan 28 01:24:45.217616 kernel: smp: Bringing up secondary CPUs ... Jan 28 01:24:45.217623 kernel: Detected PIPT I-cache on CPU1 Jan 28 01:24:45.217631 kernel: GICv3: CPU1: found redistributor 1 region 1:0x00000000f000e000 Jan 28 01:24:45.217638 kernel: arch_timer: Enabling local workaround for ARM erratum 1418040 Jan 28 01:24:45.217647 kernel: CPU1: Booted secondary processor 0x0000000001 [0x413fd0c1] Jan 28 01:24:45.217654 kernel: smp: Brought up 1 node, 2 CPUs Jan 28 01:24:45.217661 kernel: SMP: Total of 2 processors activated. Jan 28 01:24:45.217669 kernel: CPU features: detected: 32-bit EL0 Support Jan 28 01:24:45.217676 kernel: CPU features: detected: Instruction cache invalidation not required for I/D coherence Jan 28 01:24:45.217685 kernel: CPU features: detected: Data cache clean to the PoU not required for I/D coherence Jan 28 01:24:45.217693 kernel: CPU features: detected: CRC32 instructions Jan 28 01:24:45.217701 kernel: CPU features: detected: RCpc load-acquire (LDAPR) Jan 28 01:24:45.217708 kernel: CPU features: detected: LSE atomic instructions Jan 28 01:24:45.217715 kernel: CPU features: detected: Privileged Access Never Jan 28 01:24:45.217722 kernel: CPU: All CPU(s) started at EL1 Jan 28 01:24:45.217730 kernel: alternatives: applying system-wide alternatives Jan 28 01:24:45.217737 kernel: devtmpfs: initialized Jan 28 01:24:45.217745 kernel: clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1911260446275000 ns Jan 28 01:24:45.217754 kernel: futex hash table entries: 512 (order: 3, 32768 bytes, linear) Jan 28 01:24:45.217761 kernel: pinctrl core: initialized pinctrl subsystem Jan 28 01:24:45.217768 kernel: SMBIOS 3.1.0 present. Jan 28 01:24:45.217776 kernel: DMI: Microsoft Corporation Virtual Machine/Virtual Machine, BIOS Hyper-V UEFI Release v4.1 09/28/2024 Jan 28 01:24:45.217783 kernel: NET: Registered PF_NETLINK/PF_ROUTE protocol family Jan 28 01:24:45.217791 kernel: DMA: preallocated 512 KiB GFP_KERNEL pool for atomic allocations Jan 28 01:24:45.217798 kernel: DMA: preallocated 512 KiB GFP_KERNEL|GFP_DMA pool for atomic allocations Jan 28 01:24:45.217806 kernel: DMA: preallocated 512 KiB GFP_KERNEL|GFP_DMA32 pool for atomic allocations Jan 28 01:24:45.217813 kernel: audit: initializing netlink subsys (disabled) Jan 28 01:24:45.217822 kernel: audit: type=2000 audit(0.047:1): state=initialized audit_enabled=0 res=1 Jan 28 01:24:45.217830 kernel: thermal_sys: Registered thermal governor 'step_wise' Jan 28 01:24:45.217837 kernel: cpuidle: using governor menu Jan 28 01:24:45.217844 kernel: hw-breakpoint: found 6 breakpoint and 4 watchpoint registers. Jan 28 01:24:45.217852 kernel: ASID allocator initialised with 32768 entries Jan 28 01:24:45.217859 kernel: acpiphp: ACPI Hot Plug PCI Controller Driver version: 0.5 Jan 28 01:24:45.217867 kernel: Serial: AMBA PL011 UART driver Jan 28 01:24:45.217874 kernel: Modules: 2G module region forced by RANDOMIZE_MODULE_REGION_FULL Jan 28 01:24:45.217881 kernel: Modules: 0 pages in range for non-PLT usage Jan 28 01:24:45.217890 kernel: Modules: 509008 pages in range for PLT usage Jan 28 01:24:45.217897 kernel: HugeTLB: registered 1.00 GiB page size, pre-allocated 0 pages Jan 28 01:24:45.217905 kernel: HugeTLB: 0 KiB vmemmap can be freed for a 1.00 GiB page Jan 28 01:24:45.217912 kernel: HugeTLB: registered 32.0 MiB page size, pre-allocated 0 pages Jan 28 01:24:45.217919 kernel: HugeTLB: 0 KiB vmemmap can be freed for a 32.0 MiB page Jan 28 01:24:45.217927 kernel: HugeTLB: registered 2.00 MiB page size, pre-allocated 0 pages Jan 28 01:24:45.217934 kernel: HugeTLB: 0 KiB vmemmap can be freed for a 2.00 MiB page Jan 28 01:24:45.217942 kernel: HugeTLB: registered 64.0 KiB page size, pre-allocated 0 pages Jan 28 01:24:45.217949 kernel: HugeTLB: 0 KiB vmemmap can be freed for a 64.0 KiB page Jan 28 01:24:45.217958 kernel: ACPI: Added _OSI(Module Device) Jan 28 01:24:45.217966 kernel: ACPI: Added _OSI(Processor Device) Jan 28 01:24:45.217973 kernel: ACPI: Added _OSI(Processor Aggregator Device) Jan 28 01:24:45.217980 kernel: ACPI: 1 ACPI AML tables successfully acquired and loaded Jan 28 01:24:45.217988 kernel: ACPI: Interpreter enabled Jan 28 01:24:45.217995 kernel: ACPI: Using GIC for interrupt routing Jan 28 01:24:45.218002 kernel: ARMH0011:00: ttyAMA0 at MMIO 0xeffec000 (irq = 12, base_baud = 0) is a SBSA Jan 28 01:24:45.218010 kernel: printk: console [ttyAMA0] enabled Jan 28 01:24:45.218017 kernel: printk: bootconsole [pl11] disabled Jan 28 01:24:45.218026 kernel: ARMH0011:01: ttyAMA1 at MMIO 0xeffeb000 (irq = 13, base_baud = 0) is a SBSA Jan 28 01:24:45.218034 kernel: iommu: Default domain type: Translated Jan 28 01:24:45.218042 kernel: iommu: DMA domain TLB invalidation policy: strict mode Jan 28 01:24:45.218049 kernel: efivars: Registered efivars operations Jan 28 01:24:45.218056 kernel: vgaarb: loaded Jan 28 01:24:45.218063 kernel: clocksource: Switched to clocksource arch_sys_counter Jan 28 01:24:45.218071 kernel: VFS: Disk quotas dquot_6.6.0 Jan 28 01:24:45.218078 kernel: VFS: Dquot-cache hash table entries: 512 (order 0, 4096 bytes) Jan 28 01:24:45.218085 kernel: pnp: PnP ACPI init Jan 28 01:24:45.218094 kernel: pnp: PnP ACPI: found 0 devices Jan 28 01:24:45.218102 kernel: NET: Registered PF_INET protocol family Jan 28 01:24:45.218117 kernel: IP idents hash table entries: 65536 (order: 7, 524288 bytes, linear) Jan 28 01:24:45.218125 kernel: tcp_listen_portaddr_hash hash table entries: 2048 (order: 3, 32768 bytes, linear) Jan 28 01:24:45.218133 kernel: Table-perturb hash table entries: 65536 (order: 6, 262144 bytes, linear) Jan 28 01:24:45.218140 kernel: TCP established hash table entries: 32768 (order: 6, 262144 bytes, linear) Jan 28 01:24:45.218148 kernel: TCP bind hash table entries: 32768 (order: 8, 1048576 bytes, linear) Jan 28 01:24:45.218155 kernel: TCP: Hash tables configured (established 32768 bind 32768) Jan 28 01:24:45.218162 kernel: UDP hash table entries: 2048 (order: 4, 65536 bytes, linear) Jan 28 01:24:45.218172 kernel: UDP-Lite hash table entries: 2048 (order: 4, 65536 bytes, linear) Jan 28 01:24:45.218180 kernel: NET: Registered PF_UNIX/PF_LOCAL protocol family Jan 28 01:24:45.218187 kernel: PCI: CLS 0 bytes, default 64 Jan 28 01:24:45.218194 kernel: kvm [1]: HYP mode not available Jan 28 01:24:45.218202 kernel: Initialise system trusted keyrings Jan 28 01:24:45.218209 kernel: workingset: timestamp_bits=39 max_order=20 bucket_order=0 Jan 28 01:24:45.218217 kernel: Key type asymmetric registered Jan 28 01:24:45.218224 kernel: Asymmetric key parser 'x509' registered Jan 28 01:24:45.218231 kernel: Block layer SCSI generic (bsg) driver version 0.4 loaded (major 250) Jan 28 01:24:45.218241 kernel: io scheduler mq-deadline registered Jan 28 01:24:45.218248 kernel: io scheduler kyber registered Jan 28 01:24:45.218255 kernel: io scheduler bfq registered Jan 28 01:24:45.218262 kernel: Serial: 8250/16550 driver, 4 ports, IRQ sharing enabled Jan 28 01:24:45.218270 kernel: thunder_xcv, ver 1.0 Jan 28 01:24:45.218277 kernel: thunder_bgx, ver 1.0 Jan 28 01:24:45.218284 kernel: nicpf, ver 1.0 Jan 28 01:24:45.218292 kernel: nicvf, ver 1.0 Jan 28 01:24:45.218436 kernel: rtc-efi rtc-efi.0: registered as rtc0 Jan 28 01:24:45.218509 kernel: rtc-efi rtc-efi.0: setting system clock to 2026-01-28T01:24:44 UTC (1769563484) Jan 28 01:24:45.218520 kernel: efifb: probing for efifb Jan 28 01:24:45.218528 kernel: efifb: framebuffer at 0x40000000, using 3072k, total 3072k Jan 28 01:24:45.218535 kernel: efifb: mode is 1024x768x32, linelength=4096, pages=1 Jan 28 01:24:45.218543 kernel: efifb: scrolling: redraw Jan 28 01:24:45.218550 kernel: efifb: Truecolor: size=8:8:8:8, shift=24:16:8:0 Jan 28 01:24:45.218557 kernel: Console: switching to colour frame buffer device 128x48 Jan 28 01:24:45.218565 kernel: fb0: EFI VGA frame buffer device Jan 28 01:24:45.218574 kernel: SMCCC: SOC_ID: ARCH_SOC_ID not implemented, skipping .... Jan 28 01:24:45.218581 kernel: hid: raw HID events driver (C) Jiri Kosina Jan 28 01:24:45.218589 kernel: hw perfevents: enabled with armv8_pmuv3_0 PMU driver, 6 counters available Jan 28 01:24:45.218596 kernel: watchdog: Delayed init of the lockup detector failed: -19 Jan 28 01:24:45.218604 kernel: watchdog: Hard watchdog permanently disabled Jan 28 01:24:45.218611 kernel: NET: Registered PF_INET6 protocol family Jan 28 01:24:45.218619 kernel: Segment Routing with IPv6 Jan 28 01:24:45.218626 kernel: In-situ OAM (IOAM) with IPv6 Jan 28 01:24:45.218634 kernel: NET: Registered PF_PACKET protocol family Jan 28 01:24:45.218642 kernel: Key type dns_resolver registered Jan 28 01:24:45.218650 kernel: registered taskstats version 1 Jan 28 01:24:45.218657 kernel: Loading compiled-in X.509 certificates Jan 28 01:24:45.218665 kernel: Loaded X.509 cert 'Kinvolk GmbH: Module signing key for 6.6.119-flatcar: 00ce1dc8bc64b61f07099b23b76dee034878817c' Jan 28 01:24:45.218672 kernel: Key type .fscrypt registered Jan 28 01:24:45.218679 kernel: Key type fscrypt-provisioning registered Jan 28 01:24:45.218687 kernel: ima: No TPM chip found, activating TPM-bypass! Jan 28 01:24:45.218694 kernel: ima: Allocated hash algorithm: sha1 Jan 28 01:24:45.218702 kernel: ima: No architecture policies found Jan 28 01:24:45.218711 kernel: alg: No test for fips(ansi_cprng) (fips_ansi_cprng) Jan 28 01:24:45.218718 kernel: clk: Disabling unused clocks Jan 28 01:24:45.218726 kernel: Freeing unused kernel memory: 39424K Jan 28 01:24:45.218733 kernel: Run /init as init process Jan 28 01:24:45.218740 kernel: with arguments: Jan 28 01:24:45.218747 kernel: /init Jan 28 01:24:45.218754 kernel: with environment: Jan 28 01:24:45.218761 kernel: HOME=/ Jan 28 01:24:45.218768 kernel: TERM=linux Jan 28 01:24:45.218778 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 28 01:24:45.218791 systemd[1]: Detected virtualization microsoft. Jan 28 01:24:45.218801 systemd[1]: Detected architecture arm64. Jan 28 01:24:45.218810 systemd[1]: Running in initrd. Jan 28 01:24:45.218819 systemd[1]: No hostname configured, using default hostname. Jan 28 01:24:45.218827 systemd[1]: Hostname set to . Jan 28 01:24:45.218837 systemd[1]: Initializing machine ID from random generator. Jan 28 01:24:45.218848 systemd[1]: Queued start job for default target initrd.target. Jan 28 01:24:45.218858 systemd[1]: Started clevis-luks-askpass.path - Forward Password Requests to Clevis Directory Watch. Jan 28 01:24:45.218867 systemd[1]: Started systemd-ask-password-console.path - Dispatch Password Requests to Console Directory Watch. Jan 28 01:24:45.218877 systemd[1]: Expecting device dev-disk-by\x2dlabel-EFI\x2dSYSTEM.device - /dev/disk/by-label/EFI-SYSTEM... Jan 28 01:24:45.218887 systemd[1]: Expecting device dev-disk-by\x2dlabel-OEM.device - /dev/disk/by-label/OEM... Jan 28 01:24:45.218896 systemd[1]: Expecting device dev-disk-by\x2dlabel-ROOT.device - /dev/disk/by-label/ROOT... Jan 28 01:24:45.218905 systemd[1]: Expecting device dev-disk-by\x2dpartlabel-USR\x2dA.device - /dev/disk/by-partlabel/USR-A... Jan 28 01:24:45.218916 systemd[1]: Expecting device dev-disk-by\x2dpartuuid-7130c94a\x2d213a\x2d4e5a\x2d8e26\x2d6cce9662f132.device - /dev/disk/by-partuuid/7130c94a-213a-4e5a-8e26-6cce9662f132... Jan 28 01:24:45.218928 systemd[1]: Expecting device dev-mapper-usr.device - /dev/mapper/usr... Jan 28 01:24:45.218937 systemd[1]: Reached target cryptsetup-pre.target - Local Encrypted Volumes (Pre). Jan 28 01:24:45.218945 systemd[1]: Reached target cryptsetup.target - Local Encrypted Volumes. Jan 28 01:24:45.218953 systemd[1]: Reached target paths.target - Path Units. Jan 28 01:24:45.218961 systemd[1]: Reached target slices.target - Slice Units. Jan 28 01:24:45.218969 systemd[1]: Reached target swap.target - Swaps. Jan 28 01:24:45.218977 systemd[1]: Reached target timers.target - Timer Units. Jan 28 01:24:45.218987 systemd[1]: Listening on iscsid.socket - Open-iSCSI iscsid Socket. Jan 28 01:24:45.218998 systemd[1]: Listening on iscsiuio.socket - Open-iSCSI iscsiuio Socket. Jan 28 01:24:45.219008 systemd[1]: Listening on systemd-journald-dev-log.socket - Journal Socket (/dev/log). Jan 28 01:24:45.219017 systemd[1]: Listening on systemd-journald.socket - Journal Socket. Jan 28 01:24:45.219026 systemd[1]: Listening on systemd-networkd.socket - Network Service Netlink Socket. Jan 28 01:24:45.219036 systemd[1]: Listening on systemd-udevd-control.socket - udev Control Socket. Jan 28 01:24:45.219045 systemd[1]: Listening on systemd-udevd-kernel.socket - udev Kernel Socket. Jan 28 01:24:45.219054 systemd[1]: Reached target sockets.target - Socket Units. Jan 28 01:24:45.219064 systemd[1]: Starting ignition-setup-pre.service - Ignition env setup... Jan 28 01:24:45.219074 systemd[1]: Starting kmod-static-nodes.service - Create List of Static Device Nodes... Jan 28 01:24:45.219083 systemd[1]: Finished network-cleanup.service - Network Cleanup. Jan 28 01:24:45.219090 systemd[1]: Starting systemd-fsck-usr.service... Jan 28 01:24:45.219099 systemd[1]: Starting systemd-journald.service - Journal Service... Jan 28 01:24:45.221142 systemd[1]: Starting systemd-modules-load.service - Load Kernel Modules... Jan 28 01:24:45.221187 systemd-journald[218]: Collecting audit messages is disabled. Jan 28 01:24:45.221214 systemd[1]: Starting systemd-vconsole-setup.service - Virtual Console Setup... Jan 28 01:24:45.221224 systemd-journald[218]: Journal started Jan 28 01:24:45.221242 systemd-journald[218]: Runtime Journal (/run/log/journal/d70ccb4e685b4e0aa3aaff3821801c67) is 8.0M, max 78.5M, 70.5M free. Jan 28 01:24:45.229785 systemd-modules-load[219]: Inserted module 'overlay' Jan 28 01:24:45.242959 systemd[1]: Started systemd-journald.service - Journal Service. Jan 28 01:24:45.245137 systemd[1]: Finished ignition-setup-pre.service - Ignition env setup. Jan 28 01:24:45.257377 systemd[1]: Finished kmod-static-nodes.service - Create List of Static Device Nodes. Jan 28 01:24:45.288912 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 28 01:24:45.288934 kernel: Bridge firewalling registered Jan 28 01:24:45.279953 systemd-modules-load[219]: Inserted module 'br_netfilter' Jan 28 01:24:45.286152 systemd[1]: Finished systemd-fsck-usr.service. Jan 28 01:24:45.292899 systemd[1]: Finished systemd-modules-load.service - Load Kernel Modules. Jan 28 01:24:45.301941 systemd[1]: Finished systemd-vconsole-setup.service - Virtual Console Setup. Jan 28 01:24:45.322239 systemd[1]: Starting dracut-cmdline-ask.service - dracut ask for additional cmdline parameters... Jan 28 01:24:45.328457 systemd[1]: Starting systemd-sysctl.service - Apply Kernel Variables... Jan 28 01:24:45.349179 systemd[1]: Starting systemd-tmpfiles-setup-dev-early.service - Create Static Device Nodes in /dev gracefully... Jan 28 01:24:45.365288 systemd[1]: Starting systemd-tmpfiles-setup.service - Create System Files and Directories... Jan 28 01:24:45.378139 systemd[1]: Finished dracut-cmdline-ask.service - dracut ask for additional cmdline parameters. Jan 28 01:24:45.384693 systemd[1]: Finished systemd-sysctl.service - Apply Kernel Variables. Jan 28 01:24:45.404691 systemd[1]: Finished systemd-tmpfiles-setup-dev-early.service - Create Static Device Nodes in /dev gracefully. Jan 28 01:24:45.421335 systemd[1]: Starting dracut-cmdline.service - dracut cmdline hook... Jan 28 01:24:45.432295 systemd[1]: Starting systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev... Jan 28 01:24:45.445613 systemd[1]: Finished systemd-tmpfiles-setup.service - Create System Files and Directories. Jan 28 01:24:45.463567 dracut-cmdline[251]: dracut-dracut-053 Jan 28 01:24:45.463567 dracut-cmdline[251]: 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=e7a8cac0a248eeeb18f7bcbd95b9dbb1e3415729dc1af128dd9f394f73832ecf Jan 28 01:24:45.469351 systemd[1]: Starting systemd-resolved.service - Network Name Resolution... Jan 28 01:24:45.475206 systemd[1]: Finished systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev. Jan 28 01:24:45.533771 systemd-resolved[265]: Positive Trust Anchors: Jan 28 01:24:45.533786 systemd-resolved[265]: . IN DS 20326 8 2 e06d44b80b8f1d39a95c0b0d7c65d08458e880409bbc683457104237c7f8ec8d Jan 28 01:24:45.533817 systemd-resolved[265]: 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 28 01:24:45.540138 systemd-resolved[265]: Defaulting to hostname 'linux'. Jan 28 01:24:45.541041 systemd[1]: Started systemd-resolved.service - Network Name Resolution. Jan 28 01:24:45.604404 kernel: SCSI subsystem initialized Jan 28 01:24:45.553730 systemd[1]: Reached target nss-lookup.target - Host and Network Name Lookups. Jan 28 01:24:45.623120 kernel: Loading iSCSI transport class v2.0-870. Jan 28 01:24:45.633142 kernel: iscsi: registered transport (tcp) Jan 28 01:24:45.651040 kernel: iscsi: registered transport (qla4xxx) Jan 28 01:24:45.651061 kernel: QLogic iSCSI HBA Driver Jan 28 01:24:45.690943 systemd[1]: Finished dracut-cmdline.service - dracut cmdline hook. Jan 28 01:24:45.703563 systemd[1]: Starting dracut-pre-udev.service - dracut pre-udev hook... Jan 28 01:24:45.733131 kernel: device-mapper: core: CONFIG_IMA_DISABLE_HTABLE is disabled. Duplicate IMA measurements will not be recorded in the IMA log. Jan 28 01:24:45.733193 kernel: device-mapper: uevent: version 1.0.3 Jan 28 01:24:45.738791 kernel: device-mapper: ioctl: 4.48.0-ioctl (2023-03-01) initialised: dm-devel@redhat.com Jan 28 01:24:45.785123 kernel: raid6: neonx8 gen() 15826 MB/s Jan 28 01:24:45.806117 kernel: raid6: neonx4 gen() 15685 MB/s Jan 28 01:24:45.825112 kernel: raid6: neonx2 gen() 13318 MB/s Jan 28 01:24:45.844112 kernel: raid6: neonx1 gen() 10494 MB/s Jan 28 01:24:45.864113 kernel: raid6: int64x8 gen() 6974 MB/s Jan 28 01:24:45.883112 kernel: raid6: int64x4 gen() 7372 MB/s Jan 28 01:24:45.902111 kernel: raid6: int64x2 gen() 6149 MB/s Jan 28 01:24:45.925417 kernel: raid6: int64x1 gen() 5069 MB/s Jan 28 01:24:45.925428 kernel: raid6: using algorithm neonx8 gen() 15826 MB/s Jan 28 01:24:45.948641 kernel: raid6: .... xor() 12044 MB/s, rmw enabled Jan 28 01:24:45.948651 kernel: raid6: using neon recovery algorithm Jan 28 01:24:45.956115 kernel: xor: measuring software checksum speed Jan 28 01:24:45.962070 kernel: 8regs : 19017 MB/sec Jan 28 01:24:45.962084 kernel: 32regs : 19627 MB/sec Jan 28 01:24:45.964863 kernel: arm64_neon : 27061 MB/sec Jan 28 01:24:45.968691 kernel: xor: using function: arm64_neon (27061 MB/sec) Jan 28 01:24:46.018122 kernel: Btrfs loaded, zoned=no, fsverity=no Jan 28 01:24:46.028175 systemd[1]: Finished dracut-pre-udev.service - dracut pre-udev hook. Jan 28 01:24:46.042245 systemd[1]: Starting systemd-udevd.service - Rule-based Manager for Device Events and Files... Jan 28 01:24:46.064529 systemd-udevd[438]: Using default interface naming scheme 'v255'. Jan 28 01:24:46.069456 systemd[1]: Started systemd-udevd.service - Rule-based Manager for Device Events and Files. Jan 28 01:24:46.087217 systemd[1]: Starting dracut-pre-trigger.service - dracut pre-trigger hook... Jan 28 01:24:46.109232 dracut-pre-trigger[448]: rd.md=0: removing MD RAID activation Jan 28 01:24:46.137474 systemd[1]: Finished dracut-pre-trigger.service - dracut pre-trigger hook. Jan 28 01:24:46.150386 systemd[1]: Starting systemd-udev-trigger.service - Coldplug All udev Devices... Jan 28 01:24:46.187556 systemd[1]: Finished systemd-udev-trigger.service - Coldplug All udev Devices. Jan 28 01:24:46.206130 systemd[1]: Starting dracut-initqueue.service - dracut initqueue hook... Jan 28 01:24:46.248399 systemd[1]: Finished dracut-initqueue.service - dracut initqueue hook. Jan 28 01:24:46.261402 systemd[1]: Reached target remote-fs-pre.target - Preparation for Remote File Systems. Jan 28 01:24:46.274487 systemd[1]: Reached target remote-cryptsetup.target - Remote Encrypted Volumes. Jan 28 01:24:46.289205 systemd[1]: Reached target remote-fs.target - Remote File Systems. Jan 28 01:24:46.300760 kernel: hv_vmbus: Vmbus version:5.3 Jan 28 01:24:46.313405 kernel: hv_vmbus: registering driver hid_hyperv Jan 28 01:24:46.313459 kernel: pps_core: LinuxPPS API ver. 1 registered Jan 28 01:24:46.313470 kernel: hv_vmbus: registering driver hv_netvsc Jan 28 01:24:46.313377 systemd[1]: Starting dracut-pre-mount.service - dracut pre-mount hook... Jan 28 01:24:46.348819 kernel: input: Microsoft Vmbus HID-compliant Mouse as /devices/0006:045E:0621.0001/input/input0 Jan 28 01:24:46.348848 kernel: hid-hyperv 0006:045E:0621.0001: input: VIRTUAL HID v0.01 Mouse [Microsoft Vmbus HID-compliant Mouse] on Jan 28 01:24:46.349009 kernel: pps_core: Software ver. 5.3.6 - Copyright 2005-2007 Rodolfo Giometti Jan 28 01:24:46.343660 systemd[1]: Finished dracut-pre-mount.service - dracut pre-mount hook. Jan 28 01:24:46.359102 systemd[1]: dracut-cmdline-ask.service: Deactivated successfully. Jan 28 01:24:46.380272 kernel: hv_vmbus: registering driver hyperv_keyboard Jan 28 01:24:46.359272 systemd[1]: Stopped dracut-cmdline-ask.service - dracut ask for additional cmdline parameters. Jan 28 01:24:46.411901 kernel: input: AT Translated Set 2 keyboard as /devices/LNXSYSTM:00/LNXSYBUS:00/ACPI0004:00/MSFT1000:00/d34b2567-b9b6-42b9-8778-0a4ec0b955bf/serio0/input/input1 Jan 28 01:24:46.411922 kernel: hv_vmbus: registering driver hv_storvsc Jan 28 01:24:46.375032 systemd[1]: Stopping dracut-cmdline-ask.service - dracut ask for additional cmdline parameters... Jan 28 01:24:46.421609 kernel: PTP clock support registered Jan 28 01:24:46.391381 systemd[1]: systemd-vconsole-setup.service: Deactivated successfully. Jan 28 01:24:46.433446 kernel: scsi host1: storvsc_host_t Jan 28 01:24:46.433882 kernel: scsi host0: storvsc_host_t Jan 28 01:24:46.391602 systemd[1]: Stopped systemd-vconsole-setup.service - Virtual Console Setup. Jan 28 01:24:46.445189 kernel: scsi 0:0:0:0: Direct-Access Msft Virtual Disk 1.0 PQ: 0 ANSI: 5 Jan 28 01:24:46.406501 systemd[1]: Stopping systemd-vconsole-setup.service - Virtual Console Setup... Jan 28 01:24:46.456158 systemd[1]: Starting systemd-vconsole-setup.service - Virtual Console Setup... Jan 28 01:24:46.466609 kernel: scsi 0:0:0:2: CD-ROM Msft Virtual DVD-ROM 1.0 PQ: 0 ANSI: 5 Jan 28 01:24:46.466663 kernel: hv_netvsc 00224878-3498-0022-4878-349800224878 eth0: VF slot 1 added Jan 28 01:24:46.485399 kernel: hv_vmbus: registering driver hv_pci Jan 28 01:24:46.485453 kernel: hv_pci a5a4ec51-593d-411d-a67c-dc4194180d2e: PCI VMBus probing: Using version 0x10004 Jan 28 01:24:46.494061 systemd[1]: systemd-vconsole-setup.service: Deactivated successfully. Jan 28 01:24:46.508030 kernel: hv_pci a5a4ec51-593d-411d-a67c-dc4194180d2e: PCI host bridge to bus 593d:00 Jan 28 01:24:46.508200 kernel: pci_bus 593d:00: root bus resource [mem 0xfc0000000-0xfc00fffff window] Jan 28 01:24:46.498685 systemd[1]: Stopped systemd-vconsole-setup.service - Virtual Console Setup. Jan 28 01:24:46.549464 kernel: pci_bus 593d:00: No busn resource found for root bus, will use [bus 00-ff] Jan 28 01:24:46.549627 kernel: pci 593d:00:02.0: [15b3:1018] type 00 class 0x020000 Jan 28 01:24:46.549652 kernel: pci 593d:00:02.0: reg 0x10: [mem 0xfc0000000-0xfc00fffff 64bit pref] Jan 28 01:24:46.549676 kernel: hv_utils: Registering HyperV Utility Driver Jan 28 01:24:46.549686 kernel: pci 593d:00:02.0: enabling Extended Tags Jan 28 01:24:46.518355 systemd[1]: Stopping systemd-vconsole-setup.service - Virtual Console Setup... Jan 28 01:24:46.571505 kernel: pci 593d:00:02.0: 0.000 Gb/s available PCIe bandwidth, limited by Unknown x0 link at 593d:00:02.0 (capable of 126.016 Gb/s with 8.0 GT/s PCIe x16 link) Jan 28 01:24:46.571681 kernel: pci_bus 593d:00: busn_res: [bus 00-ff] end is updated to 00 Jan 28 01:24:46.571768 kernel: hv_vmbus: registering driver hv_utils Jan 28 01:24:46.576785 kernel: pci 593d:00:02.0: BAR 0: assigned [mem 0xfc0000000-0xfc00fffff 64bit pref] Jan 28 01:24:46.578384 systemd[1]: Starting systemd-vconsole-setup.service - Virtual Console Setup... Jan 28 01:24:46.228808 kernel: hv_utils: Heartbeat IC version 3.0 Jan 28 01:24:46.245452 kernel: hv_utils: Shutdown IC version 3.2 Jan 28 01:24:46.245468 kernel: hv_utils: TimeSync IC version 4.0 Jan 28 01:24:46.245489 kernel: sr 0:0:0:2: [sr0] scsi-1 drive Jan 28 01:24:46.245650 systemd-journald[218]: Time jumped backwards, rotating. Jan 28 01:24:46.245686 kernel: cdrom: Uniform CD-ROM driver Revision: 3.20 Jan 28 01:24:46.221995 systemd-resolved[265]: Clock change detected. Flushing caches. Jan 28 01:24:46.257303 kernel: sr 0:0:0:2: Attached scsi CD-ROM sr0 Jan 28 01:24:46.226559 systemd[1]: Finished systemd-vconsole-setup.service - Virtual Console Setup. Jan 28 01:24:46.263399 systemd[1]: Starting dracut-cmdline-ask.service - dracut ask for additional cmdline parameters... Jan 28 01:24:46.287172 kernel: sd 0:0:0:0: [sda] 63737856 512-byte logical blocks: (32.6 GB/30.4 GiB) Jan 28 01:24:46.287371 kernel: sd 0:0:0:0: [sda] 4096-byte physical blocks Jan 28 01:24:46.298763 kernel: sd 0:0:0:0: [sda] Write Protect is off Jan 28 01:24:46.298970 kernel: sd 0:0:0:0: [sda] Mode Sense: 0f 00 10 00 Jan 28 01:24:46.299090 kernel: sd 0:0:0:0: [sda] Write cache: disabled, read cache: enabled, supports DPO and FUA Jan 28 01:24:46.309510 kernel: hv_storvsc f8b3781a-1e82-4818-a1c3-63d806ec15bb: tag#122 cmd 0x85 status: scsi 0x2 srb 0x6 hv 0xc0000001 Jan 28 01:24:46.317681 kernel: mlx5_core 593d:00:02.0: enabling device (0000 -> 0002) Jan 28 01:24:46.326656 kernel: mlx5_core 593d:00:02.0: firmware version: 16.30.5026 Jan 28 01:24:46.326878 kernel: sda: sda1 sda2 sda3 sda4 sda6 sda7 sda9 Jan 28 01:24:46.334503 kernel: sd 0:0:0:0: [sda] Attached SCSI disk Jan 28 01:24:46.344904 systemd[1]: Finished dracut-cmdline-ask.service - dracut ask for additional cmdline parameters. Jan 28 01:24:46.373499 kernel: hv_storvsc f8b3781a-1e82-4818-a1c3-63d806ec15bb: tag#114 cmd 0x85 status: scsi 0x2 srb 0x6 hv 0xc0000001 Jan 28 01:24:46.520913 kernel: hv_netvsc 00224878-3498-0022-4878-349800224878 eth0: VF registering: eth1 Jan 28 01:24:46.521114 kernel: mlx5_core 593d:00:02.0 eth1: joined to eth0 Jan 28 01:24:46.527513 kernel: mlx5_core 593d:00:02.0: MLX5E: StrdRq(1) RqSz(8) StrdSz(2048) RxCqeCmprss(0 basic) Jan 28 01:24:46.536500 kernel: mlx5_core 593d:00:02.0 enP22845s1: renamed from eth1 Jan 28 01:24:46.839755 systemd[1]: Found device dev-disk-by\x2dlabel-EFI\x2dSYSTEM.device - Virtual_Disk EFI-SYSTEM. Jan 28 01:24:46.883517 kernel: BTRFS: device label OEM devid 1 transid 10 /dev/sda6 scanned by (udev-worker) (498) Jan 28 01:24:46.897472 systemd[1]: Found device dev-disk-by\x2dlabel-OEM.device - Virtual_Disk OEM. Jan 28 01:24:46.919874 kernel: BTRFS: device fsid 0fc26676-8036-4cd5-8c30-2943afb25b0b devid 1 transid 36 /dev/sda3 scanned by (udev-worker) (483) Jan 28 01:24:46.929151 systemd[1]: Found device dev-disk-by\x2dlabel-ROOT.device - Virtual_Disk ROOT. Jan 28 01:24:46.940381 systemd[1]: Found device dev-disk-by\x2dpartlabel-USR\x2dA.device - Virtual_Disk USR-A. Jan 28 01:24:46.945944 systemd[1]: Found device dev-disk-by\x2dpartuuid-7130c94a\x2d213a\x2d4e5a\x2d8e26\x2d6cce9662f132.device - Virtual_Disk USR-A. Jan 28 01:24:46.974700 systemd[1]: Starting disk-uuid.service - Generate new UUID for disk GPT if necessary... Jan 28 01:24:47.001501 kernel: sda: sda1 sda2 sda3 sda4 sda6 sda7 sda9 Jan 28 01:24:47.009515 kernel: sda: sda1 sda2 sda3 sda4 sda6 sda7 sda9 Jan 28 01:24:48.021513 kernel: sda: sda1 sda2 sda3 sda4 sda6 sda7 sda9 Jan 28 01:24:48.021738 disk-uuid[605]: The operation has completed successfully. Jan 28 01:24:48.089927 systemd[1]: disk-uuid.service: Deactivated successfully. Jan 28 01:24:48.093731 systemd[1]: Finished disk-uuid.service - Generate new UUID for disk GPT if necessary. Jan 28 01:24:48.119598 systemd[1]: Starting verity-setup.service - Verity Setup for /dev/mapper/usr... Jan 28 01:24:48.129493 sh[718]: Success Jan 28 01:24:48.161495 kernel: device-mapper: verity: sha256 using implementation "sha256-ce" Jan 28 01:24:48.456462 systemd[1]: Found device dev-mapper-usr.device - /dev/mapper/usr. Jan 28 01:24:48.474599 systemd[1]: Mounting sysusr-usr.mount - /sysusr/usr... Jan 28 01:24:48.482413 systemd[1]: Finished verity-setup.service - Verity Setup for /dev/mapper/usr. Jan 28 01:24:48.512989 kernel: BTRFS info (device dm-0): first mount of filesystem 0fc26676-8036-4cd5-8c30-2943afb25b0b Jan 28 01:24:48.513040 kernel: BTRFS info (device dm-0): using crc32c (crc32c-generic) checksum algorithm Jan 28 01:24:48.518515 kernel: BTRFS warning (device dm-0): 'nologreplay' is deprecated, use 'rescue=nologreplay' instead Jan 28 01:24:48.522690 kernel: BTRFS info (device dm-0): disabling log replay at mount time Jan 28 01:24:48.526106 kernel: BTRFS info (device dm-0): using free space tree Jan 28 01:24:48.840179 systemd[1]: Mounted sysusr-usr.mount - /sysusr/usr. Jan 28 01:24:48.844737 systemd[1]: afterburn-network-kargs.service - Afterburn Initrd Setup Network Kernel Arguments was skipped because no trigger condition checks were met. Jan 28 01:24:48.860666 systemd[1]: Starting ignition-setup.service - Ignition (setup)... Jan 28 01:24:48.869888 systemd[1]: Starting parse-ip-for-networkd.service - Write systemd-networkd units from cmdline... Jan 28 01:24:48.892062 kernel: BTRFS info (device sda6): first mount of filesystem 11ff68ea-4313-40eb-9d5c-ba27cd060334 Jan 28 01:24:48.892094 kernel: BTRFS info (device sda6): using crc32c (crc32c-generic) checksum algorithm Jan 28 01:24:48.895302 kernel: BTRFS info (device sda6): using free space tree Jan 28 01:24:48.930721 kernel: BTRFS info (device sda6): auto enabling async discard Jan 28 01:24:48.939989 systemd[1]: mnt-oem.mount: Deactivated successfully. Jan 28 01:24:48.951555 kernel: BTRFS info (device sda6): last unmount of filesystem 11ff68ea-4313-40eb-9d5c-ba27cd060334 Jan 28 01:24:48.963507 systemd[1]: Finished ignition-setup.service - Ignition (setup). Jan 28 01:24:48.976915 systemd[1]: Starting ignition-fetch-offline.service - Ignition (fetch-offline)... Jan 28 01:24:49.010516 systemd[1]: Finished parse-ip-for-networkd.service - Write systemd-networkd units from cmdline. Jan 28 01:24:49.025613 systemd[1]: Starting systemd-networkd.service - Network Configuration... Jan 28 01:24:49.051785 systemd-networkd[902]: lo: Link UP Jan 28 01:24:49.051793 systemd-networkd[902]: lo: Gained carrier Jan 28 01:24:49.053748 systemd-networkd[902]: Enumeration completed Jan 28 01:24:49.054625 systemd[1]: Started systemd-networkd.service - Network Configuration. Jan 28 01:24:49.054980 systemd-networkd[902]: eth0: found matching network '/usr/lib/systemd/network/zz-default.network', based on potentially unpredictable interface name. Jan 28 01:24:49.054983 systemd-networkd[902]: eth0: Configuring with /usr/lib/systemd/network/zz-default.network. Jan 28 01:24:49.062691 systemd[1]: Reached target network.target - Network. Jan 28 01:24:49.135501 kernel: mlx5_core 593d:00:02.0 enP22845s1: Link up Jan 28 01:24:49.177501 kernel: hv_netvsc 00224878-3498-0022-4878-349800224878 eth0: Data path switched to VF: enP22845s1 Jan 28 01:24:49.177859 systemd-networkd[902]: enP22845s1: Link UP Jan 28 01:24:49.178089 systemd-networkd[902]: eth0: Link UP Jan 28 01:24:49.178499 systemd-networkd[902]: eth0: Gained carrier Jan 28 01:24:49.178508 systemd-networkd[902]: eth0: found matching network '/usr/lib/systemd/network/zz-default.network', based on potentially unpredictable interface name. Jan 28 01:24:49.188988 systemd-networkd[902]: enP22845s1: Gained carrier Jan 28 01:24:49.204534 systemd-networkd[902]: eth0: DHCPv4 address 10.200.20.29/24, gateway 10.200.20.1 acquired from 168.63.129.16 Jan 28 01:24:49.958858 ignition[862]: Ignition 2.19.0 Jan 28 01:24:49.958867 ignition[862]: Stage: fetch-offline Jan 28 01:24:49.962697 systemd[1]: Finished ignition-fetch-offline.service - Ignition (fetch-offline). Jan 28 01:24:49.958909 ignition[862]: no configs at "/usr/lib/ignition/base.d" Jan 28 01:24:49.958917 ignition[862]: no config dir at "/usr/lib/ignition/base.platform.d/azure" Jan 28 01:24:49.959013 ignition[862]: parsed url from cmdline: "" Jan 28 01:24:49.959017 ignition[862]: no config URL provided Jan 28 01:24:49.959027 ignition[862]: reading system config file "/usr/lib/ignition/user.ign" Jan 28 01:24:49.985700 systemd[1]: Starting ignition-fetch.service - Ignition (fetch)... Jan 28 01:24:49.959034 ignition[862]: no config at "/usr/lib/ignition/user.ign" Jan 28 01:24:49.959039 ignition[862]: failed to fetch config: resource requires networking Jan 28 01:24:49.959464 ignition[862]: Ignition finished successfully Jan 28 01:24:50.003902 ignition[912]: Ignition 2.19.0 Jan 28 01:24:50.003908 ignition[912]: Stage: fetch Jan 28 01:24:50.004105 ignition[912]: no configs at "/usr/lib/ignition/base.d" Jan 28 01:24:50.004117 ignition[912]: no config dir at "/usr/lib/ignition/base.platform.d/azure" Jan 28 01:24:50.004220 ignition[912]: parsed url from cmdline: "" Jan 28 01:24:50.004223 ignition[912]: no config URL provided Jan 28 01:24:50.004228 ignition[912]: reading system config file "/usr/lib/ignition/user.ign" Jan 28 01:24:50.004234 ignition[912]: no config at "/usr/lib/ignition/user.ign" Jan 28 01:24:50.004258 ignition[912]: GET http://169.254.169.254/metadata/instance/compute/userData?api-version=2021-01-01&format=text: attempt #1 Jan 28 01:24:50.106632 ignition[912]: GET result: OK Jan 28 01:24:50.106672 ignition[912]: config has been read from IMDS userdata Jan 28 01:24:50.106683 ignition[912]: parsing config with SHA512: eeb8c19711d5009d49d9e22cc3ede4842b4a5b97816ffef3992b9bd007279fb01df67a7f2ee3abceccd03bc3f3af645b3a1fe5c2a1fb214cbcb6c8e5268c20cf Jan 28 01:24:50.110152 unknown[912]: fetched base config from "system" Jan 28 01:24:50.110331 ignition[912]: fetch: fetch complete Jan 28 01:24:50.110159 unknown[912]: fetched base config from "system" Jan 28 01:24:50.110335 ignition[912]: fetch: fetch passed Jan 28 01:24:50.110165 unknown[912]: fetched user config from "azure" Jan 28 01:24:50.110379 ignition[912]: Ignition finished successfully Jan 28 01:24:50.117279 systemd[1]: Finished ignition-fetch.service - Ignition (fetch). Jan 28 01:24:50.134735 systemd[1]: Starting ignition-kargs.service - Ignition (kargs)... Jan 28 01:24:50.152158 ignition[919]: Ignition 2.19.0 Jan 28 01:24:50.152164 ignition[919]: Stage: kargs Jan 28 01:24:50.152328 ignition[919]: no configs at "/usr/lib/ignition/base.d" Jan 28 01:24:50.157796 systemd[1]: Finished ignition-kargs.service - Ignition (kargs). Jan 28 01:24:50.152340 ignition[919]: no config dir at "/usr/lib/ignition/base.platform.d/azure" Jan 28 01:24:50.153073 ignition[919]: kargs: kargs passed Jan 28 01:24:50.153116 ignition[919]: Ignition finished successfully Jan 28 01:24:50.183836 systemd[1]: Starting ignition-disks.service - Ignition (disks)... Jan 28 01:24:50.195824 ignition[926]: Ignition 2.19.0 Jan 28 01:24:50.195834 ignition[926]: Stage: disks Jan 28 01:24:50.198978 systemd[1]: Finished ignition-disks.service - Ignition (disks). Jan 28 01:24:50.196018 ignition[926]: no configs at "/usr/lib/ignition/base.d" Jan 28 01:24:50.204359 systemd[1]: Reached target initrd-root-device.target - Initrd Root Device. Jan 28 01:24:50.196027 ignition[926]: no config dir at "/usr/lib/ignition/base.platform.d/azure" Jan 28 01:24:50.211595 systemd[1]: Reached target local-fs-pre.target - Preparation for Local File Systems. Jan 28 01:24:50.196682 ignition[926]: disks: disks passed Jan 28 01:24:50.220955 systemd[1]: Reached target local-fs.target - Local File Systems. Jan 28 01:24:50.196724 ignition[926]: Ignition finished successfully Jan 28 01:24:50.228905 systemd[1]: Reached target sysinit.target - System Initialization. Jan 28 01:24:50.237333 systemd[1]: Reached target basic.target - Basic System. Jan 28 01:24:50.258704 systemd[1]: Starting systemd-fsck-root.service - File System Check on /dev/disk/by-label/ROOT... Jan 28 01:24:50.330649 systemd-fsck[934]: ROOT: clean, 14/7326000 files, 477710/7359488 blocks Jan 28 01:24:50.336941 systemd[1]: Finished systemd-fsck-root.service - File System Check on /dev/disk/by-label/ROOT. Jan 28 01:24:50.354655 systemd[1]: Mounting sysroot.mount - /sysroot... Jan 28 01:24:50.416489 kernel: EXT4-fs (sda9): mounted filesystem 2c7419f5-3bc3-4c5f-b132-f03585db88cd r/w with ordered data mode. Quota mode: none. Jan 28 01:24:50.416972 systemd[1]: Mounted sysroot.mount - /sysroot. Jan 28 01:24:50.420831 systemd[1]: Reached target initrd-root-fs.target - Initrd Root File System. Jan 28 01:24:50.462569 systemd[1]: Mounting sysroot-oem.mount - /sysroot/oem... Jan 28 01:24:50.480492 kernel: BTRFS: device label OEM devid 1 transid 11 /dev/sda6 scanned by mount (945) Jan 28 01:24:50.490399 kernel: BTRFS info (device sda6): first mount of filesystem 11ff68ea-4313-40eb-9d5c-ba27cd060334 Jan 28 01:24:50.490428 kernel: BTRFS info (device sda6): using crc32c (crc32c-generic) checksum algorithm Jan 28 01:24:50.494101 kernel: BTRFS info (device sda6): using free space tree Jan 28 01:24:50.497649 systemd[1]: Mounting sysroot-usr.mount - /sysroot/usr... Jan 28 01:24:50.508021 kernel: BTRFS info (device sda6): auto enabling async discard Jan 28 01:24:50.509325 systemd[1]: Starting flatcar-metadata-hostname.service - Flatcar Metadata Hostname Agent... Jan 28 01:24:50.519455 systemd[1]: ignition-remount-sysroot.service - Remount /sysroot read-write for Ignition was skipped because of an unmet condition check (ConditionPathIsReadWrite=!/sysroot). Jan 28 01:24:50.525569 systemd[1]: Reached target ignition-diskful.target - Ignition Boot Disk Setup. Jan 28 01:24:50.535092 systemd[1]: Mounted sysroot-oem.mount - /sysroot/oem. Jan 28 01:24:50.542963 systemd[1]: Mounted sysroot-usr.mount - /sysroot/usr. Jan 28 01:24:50.559740 systemd[1]: Starting initrd-setup-root.service - Root filesystem setup... Jan 28 01:24:51.045678 systemd-networkd[902]: eth0: Gained IPv6LL Jan 28 01:24:51.162607 coreos-metadata[962]: Jan 28 01:24:51.162 INFO Fetching http://168.63.129.16/?comp=versions: Attempt #1 Jan 28 01:24:51.170574 coreos-metadata[962]: Jan 28 01:24:51.170 INFO Fetch successful Jan 28 01:24:51.174966 coreos-metadata[962]: Jan 28 01:24:51.174 INFO Fetching http://169.254.169.254/metadata/instance/compute/name?api-version=2017-08-01&format=text: Attempt #1 Jan 28 01:24:51.191649 coreos-metadata[962]: Jan 28 01:24:51.191 INFO Fetch successful Jan 28 01:24:51.222485 coreos-metadata[962]: Jan 28 01:24:51.222 INFO wrote hostname ci-4081.3.6-n-eb37c95875 to /sysroot/etc/hostname Jan 28 01:24:51.230503 systemd[1]: Finished flatcar-metadata-hostname.service - Flatcar Metadata Hostname Agent. Jan 28 01:24:51.362013 initrd-setup-root[975]: cut: /sysroot/etc/passwd: No such file or directory Jan 28 01:24:51.402852 initrd-setup-root[982]: cut: /sysroot/etc/group: No such file or directory Jan 28 01:24:51.438233 initrd-setup-root[989]: cut: /sysroot/etc/shadow: No such file or directory Jan 28 01:24:51.461944 initrd-setup-root[996]: cut: /sysroot/etc/gshadow: No such file or directory Jan 28 01:24:52.567209 systemd[1]: Finished initrd-setup-root.service - Root filesystem setup. Jan 28 01:24:52.583683 systemd[1]: Starting ignition-mount.service - Ignition (mount)... Jan 28 01:24:52.596669 systemd[1]: Starting sysroot-boot.service - /sysroot/boot... Jan 28 01:24:52.612297 kernel: BTRFS info (device sda6): last unmount of filesystem 11ff68ea-4313-40eb-9d5c-ba27cd060334 Jan 28 01:24:52.606958 systemd[1]: sysroot-oem.mount: Deactivated successfully. Jan 28 01:24:52.630115 ignition[1064]: INFO : Ignition 2.19.0 Jan 28 01:24:52.630115 ignition[1064]: INFO : Stage: mount Jan 28 01:24:52.637693 ignition[1064]: INFO : no configs at "/usr/lib/ignition/base.d" Jan 28 01:24:52.637693 ignition[1064]: INFO : no config dir at "/usr/lib/ignition/base.platform.d/azure" Jan 28 01:24:52.637693 ignition[1064]: INFO : mount: mount passed Jan 28 01:24:52.637693 ignition[1064]: INFO : Ignition finished successfully Jan 28 01:24:52.637531 systemd[1]: Finished ignition-mount.service - Ignition (mount). Jan 28 01:24:52.658655 systemd[1]: Starting ignition-files.service - Ignition (files)... Jan 28 01:24:52.669044 systemd[1]: Finished sysroot-boot.service - /sysroot/boot. Jan 28 01:24:52.679715 systemd[1]: Mounting sysroot-oem.mount - /sysroot/oem... Jan 28 01:24:52.705559 kernel: BTRFS: device label OEM devid 1 transid 12 /dev/sda6 scanned by mount (1075) Jan 28 01:24:52.716044 kernel: BTRFS info (device sda6): first mount of filesystem 11ff68ea-4313-40eb-9d5c-ba27cd060334 Jan 28 01:24:52.716075 kernel: BTRFS info (device sda6): using crc32c (crc32c-generic) checksum algorithm Jan 28 01:24:52.719344 kernel: BTRFS info (device sda6): using free space tree Jan 28 01:24:52.727501 kernel: BTRFS info (device sda6): auto enabling async discard Jan 28 01:24:52.727750 systemd[1]: Mounted sysroot-oem.mount - /sysroot/oem. Jan 28 01:24:52.755028 ignition[1092]: INFO : Ignition 2.19.0 Jan 28 01:24:52.755028 ignition[1092]: INFO : Stage: files Jan 28 01:24:52.761226 ignition[1092]: INFO : no configs at "/usr/lib/ignition/base.d" Jan 28 01:24:52.761226 ignition[1092]: INFO : no config dir at "/usr/lib/ignition/base.platform.d/azure" Jan 28 01:24:52.761226 ignition[1092]: DEBUG : files: compiled without relabeling support, skipping Jan 28 01:24:52.761226 ignition[1092]: INFO : files: ensureUsers: op(1): [started] creating or modifying user "core" Jan 28 01:24:52.761226 ignition[1092]: DEBUG : files: ensureUsers: op(1): executing: "usermod" "--root" "/sysroot" "core" Jan 28 01:24:52.832653 ignition[1092]: INFO : files: ensureUsers: op(1): [finished] creating or modifying user "core" Jan 28 01:24:52.838584 ignition[1092]: INFO : files: ensureUsers: op(2): [started] adding ssh keys to user "core" Jan 28 01:24:52.838584 ignition[1092]: INFO : files: ensureUsers: op(2): [finished] adding ssh keys to user "core" Jan 28 01:24:52.833045 unknown[1092]: wrote ssh authorized keys file for user: core Jan 28 01:24:52.862653 ignition[1092]: INFO : files: createFilesystemsFiles: createFiles: op(3): [started] writing file "/sysroot/etc/flatcar/update.conf" Jan 28 01:24:52.871259 ignition[1092]: INFO : files: createFilesystemsFiles: createFiles: op(3): [finished] writing file "/sysroot/etc/flatcar/update.conf" Jan 28 01:24:52.871259 ignition[1092]: INFO : files: createResultFile: createFiles: op(4): [started] writing file "/sysroot/etc/.ignition-result.json" Jan 28 01:24:52.871259 ignition[1092]: INFO : files: createResultFile: createFiles: op(4): [finished] writing file "/sysroot/etc/.ignition-result.json" Jan 28 01:24:52.871259 ignition[1092]: INFO : files: files passed Jan 28 01:24:52.871259 ignition[1092]: INFO : Ignition finished successfully Jan 28 01:24:52.875824 systemd[1]: Finished ignition-files.service - Ignition (files). Jan 28 01:24:52.904758 systemd[1]: Starting ignition-quench.service - Ignition (record completion)... Jan 28 01:24:52.916672 systemd[1]: Starting initrd-setup-root-after-ignition.service - Root filesystem completion... Jan 28 01:24:52.925390 systemd[1]: ignition-quench.service: Deactivated successfully. Jan 28 01:24:52.925521 systemd[1]: Finished ignition-quench.service - Ignition (record completion). Jan 28 01:24:52.959642 initrd-setup-root-after-ignition[1120]: grep: /sysroot/etc/flatcar/enabled-sysext.conf: No such file or directory Jan 28 01:24:52.959642 initrd-setup-root-after-ignition[1120]: grep: /sysroot/usr/share/flatcar/enabled-sysext.conf: No such file or directory Jan 28 01:24:52.974161 initrd-setup-root-after-ignition[1124]: grep: /sysroot/etc/flatcar/enabled-sysext.conf: No such file or directory Jan 28 01:24:52.968390 systemd[1]: Finished initrd-setup-root-after-ignition.service - Root filesystem completion. Jan 28 01:24:52.979640 systemd[1]: Reached target ignition-complete.target - Ignition Complete. Jan 28 01:24:53.002646 systemd[1]: Starting initrd-parse-etc.service - Mountpoints Configured in the Real Root... Jan 28 01:24:53.030373 systemd[1]: initrd-parse-etc.service: Deactivated successfully. Jan 28 01:24:53.032534 systemd[1]: Finished initrd-parse-etc.service - Mountpoints Configured in the Real Root. Jan 28 01:24:53.040359 systemd[1]: Reached target initrd-fs.target - Initrd File Systems. Jan 28 01:24:53.050657 systemd[1]: Reached target initrd.target - Initrd Default Target. Jan 28 01:24:53.059397 systemd[1]: dracut-mount.service - dracut mount hook was skipped because no trigger condition checks were met. Jan 28 01:24:53.073713 systemd[1]: Starting dracut-pre-pivot.service - dracut pre-pivot and cleanup hook... Jan 28 01:24:53.085804 systemd[1]: Finished dracut-pre-pivot.service - dracut pre-pivot and cleanup hook. Jan 28 01:24:53.107632 systemd[1]: Starting initrd-cleanup.service - Cleaning Up and Shutting Down Daemons... Jan 28 01:24:53.124840 systemd[1]: Stopped target nss-lookup.target - Host and Network Name Lookups. Jan 28 01:24:53.135721 systemd[1]: Stopped target remote-cryptsetup.target - Remote Encrypted Volumes. Jan 28 01:24:53.141300 systemd[1]: Stopped target timers.target - Timer Units. Jan 28 01:24:53.150140 systemd[1]: dracut-pre-pivot.service: Deactivated successfully. Jan 28 01:24:53.150313 systemd[1]: Stopped dracut-pre-pivot.service - dracut pre-pivot and cleanup hook. Jan 28 01:24:53.163423 systemd[1]: Stopped target initrd.target - Initrd Default Target. Jan 28 01:24:53.172781 systemd[1]: Stopped target basic.target - Basic System. Jan 28 01:24:53.181189 systemd[1]: Stopped target ignition-complete.target - Ignition Complete. Jan 28 01:24:53.189715 systemd[1]: Stopped target ignition-diskful.target - Ignition Boot Disk Setup. Jan 28 01:24:53.198880 systemd[1]: Stopped target initrd-root-device.target - Initrd Root Device. Jan 28 01:24:53.208402 systemd[1]: Stopped target remote-fs.target - Remote File Systems. Jan 28 01:24:53.217228 systemd[1]: Stopped target remote-fs-pre.target - Preparation for Remote File Systems. Jan 28 01:24:53.227412 systemd[1]: Stopped target sysinit.target - System Initialization. Jan 28 01:24:53.237124 systemd[1]: Stopped target local-fs.target - Local File Systems. Jan 28 01:24:53.245129 systemd[1]: Stopped target swap.target - Swaps. Jan 28 01:24:53.252666 systemd[1]: dracut-pre-mount.service: Deactivated successfully. Jan 28 01:24:53.252836 systemd[1]: Stopped dracut-pre-mount.service - dracut pre-mount hook. Jan 28 01:24:53.264896 systemd[1]: Stopped target cryptsetup.target - Local Encrypted Volumes. Jan 28 01:24:53.274401 systemd[1]: Stopped target cryptsetup-pre.target - Local Encrypted Volumes (Pre). Jan 28 01:24:53.283893 systemd[1]: clevis-luks-askpass.path: Deactivated successfully. Jan 28 01:24:53.284001 systemd[1]: Stopped clevis-luks-askpass.path - Forward Password Requests to Clevis Directory Watch. Jan 28 01:24:53.293730 systemd[1]: dracut-initqueue.service: Deactivated successfully. Jan 28 01:24:53.293901 systemd[1]: Stopped dracut-initqueue.service - dracut initqueue hook. Jan 28 01:24:53.308144 systemd[1]: initrd-setup-root-after-ignition.service: Deactivated successfully. Jan 28 01:24:53.308308 systemd[1]: Stopped initrd-setup-root-after-ignition.service - Root filesystem completion. Jan 28 01:24:53.317822 systemd[1]: ignition-files.service: Deactivated successfully. Jan 28 01:24:53.317963 systemd[1]: Stopped ignition-files.service - Ignition (files). Jan 28 01:24:53.327074 systemd[1]: flatcar-metadata-hostname.service: Deactivated successfully. Jan 28 01:24:53.327224 systemd[1]: Stopped flatcar-metadata-hostname.service - Flatcar Metadata Hostname Agent. Jan 28 01:24:53.354606 systemd[1]: Stopping ignition-mount.service - Ignition (mount)... Jan 28 01:24:53.368937 systemd[1]: Stopping sysroot-boot.service - /sysroot/boot... Jan 28 01:24:53.390952 ignition[1144]: INFO : Ignition 2.19.0 Jan 28 01:24:53.390952 ignition[1144]: INFO : Stage: umount Jan 28 01:24:53.390952 ignition[1144]: INFO : no configs at "/usr/lib/ignition/base.d" Jan 28 01:24:53.390952 ignition[1144]: INFO : no config dir at "/usr/lib/ignition/base.platform.d/azure" Jan 28 01:24:53.390952 ignition[1144]: INFO : umount: umount passed Jan 28 01:24:53.390952 ignition[1144]: INFO : Ignition finished successfully Jan 28 01:24:53.378883 systemd[1]: systemd-udev-trigger.service: Deactivated successfully. Jan 28 01:24:53.379051 systemd[1]: Stopped systemd-udev-trigger.service - Coldplug All udev Devices. Jan 28 01:24:53.389801 systemd[1]: dracut-pre-trigger.service: Deactivated successfully. Jan 28 01:24:53.389969 systemd[1]: Stopped dracut-pre-trigger.service - dracut pre-trigger hook. Jan 28 01:24:53.402509 systemd[1]: sysroot-boot.mount: Deactivated successfully. Jan 28 01:24:53.403340 systemd[1]: ignition-mount.service: Deactivated successfully. Jan 28 01:24:53.403441 systemd[1]: Stopped ignition-mount.service - Ignition (mount). Jan 28 01:24:53.414631 systemd[1]: initrd-cleanup.service: Deactivated successfully. Jan 28 01:24:53.414735 systemd[1]: Finished initrd-cleanup.service - Cleaning Up and Shutting Down Daemons. Jan 28 01:24:53.422941 systemd[1]: ignition-disks.service: Deactivated successfully. Jan 28 01:24:53.423013 systemd[1]: Stopped ignition-disks.service - Ignition (disks). Jan 28 01:24:53.434020 systemd[1]: ignition-kargs.service: Deactivated successfully. Jan 28 01:24:53.434079 systemd[1]: Stopped ignition-kargs.service - Ignition (kargs). Jan 28 01:24:53.438452 systemd[1]: ignition-fetch.service: Deactivated successfully. Jan 28 01:24:53.438495 systemd[1]: Stopped ignition-fetch.service - Ignition (fetch). Jan 28 01:24:53.447018 systemd[1]: Stopped target network.target - Network. Jan 28 01:24:53.455504 systemd[1]: ignition-fetch-offline.service: Deactivated successfully. Jan 28 01:24:53.455562 systemd[1]: Stopped ignition-fetch-offline.service - Ignition (fetch-offline). Jan 28 01:24:53.464558 systemd[1]: Stopped target paths.target - Path Units. Jan 28 01:24:53.472829 systemd[1]: systemd-ask-password-console.path: Deactivated successfully. Jan 28 01:24:53.476503 systemd[1]: Stopped systemd-ask-password-console.path - Dispatch Password Requests to Console Directory Watch. Jan 28 01:24:53.485654 systemd[1]: Stopped target slices.target - Slice Units. Jan 28 01:24:53.493337 systemd[1]: Stopped target sockets.target - Socket Units. Jan 28 01:24:53.501173 systemd[1]: iscsid.socket: Deactivated successfully. Jan 28 01:24:53.501219 systemd[1]: Closed iscsid.socket - Open-iSCSI iscsid Socket. Jan 28 01:24:53.510263 systemd[1]: iscsiuio.socket: Deactivated successfully. Jan 28 01:24:53.510296 systemd[1]: Closed iscsiuio.socket - Open-iSCSI iscsiuio Socket. Jan 28 01:24:53.518753 systemd[1]: ignition-setup.service: Deactivated successfully. Jan 28 01:24:53.518796 systemd[1]: Stopped ignition-setup.service - Ignition (setup). Jan 28 01:24:53.527189 systemd[1]: ignition-setup-pre.service: Deactivated successfully. Jan 28 01:24:53.527222 systemd[1]: Stopped ignition-setup-pre.service - Ignition env setup. Jan 28 01:24:53.535726 systemd[1]: Stopping systemd-networkd.service - Network Configuration... Jan 28 01:24:53.543971 systemd[1]: Stopping systemd-resolved.service - Network Name Resolution... Jan 28 01:24:53.551996 systemd-networkd[902]: eth0: DHCPv6 lease lost Jan 28 01:24:53.553620 systemd[1]: systemd-networkd.service: Deactivated successfully. Jan 28 01:24:53.553718 systemd[1]: Stopped systemd-networkd.service - Network Configuration. Jan 28 01:24:53.563621 systemd[1]: systemd-resolved.service: Deactivated successfully. Jan 28 01:24:53.563717 systemd[1]: Stopped systemd-resolved.service - Network Name Resolution. Jan 28 01:24:53.743892 kernel: hv_netvsc 00224878-3498-0022-4878-349800224878 eth0: Data path switched from VF: enP22845s1 Jan 28 01:24:53.572769 systemd[1]: sysroot-boot.service: Deactivated successfully. Jan 28 01:24:53.572902 systemd[1]: Stopped sysroot-boot.service - /sysroot/boot. Jan 28 01:24:53.581358 systemd[1]: systemd-networkd.socket: Deactivated successfully. Jan 28 01:24:53.581436 systemd[1]: Closed systemd-networkd.socket - Network Service Netlink Socket. Jan 28 01:24:53.590170 systemd[1]: initrd-setup-root.service: Deactivated successfully. Jan 28 01:24:53.590229 systemd[1]: Stopped initrd-setup-root.service - Root filesystem setup. Jan 28 01:24:53.613692 systemd[1]: Stopping network-cleanup.service - Network Cleanup... Jan 28 01:24:53.621469 systemd[1]: parse-ip-for-networkd.service: Deactivated successfully. Jan 28 01:24:53.621545 systemd[1]: Stopped parse-ip-for-networkd.service - Write systemd-networkd units from cmdline. Jan 28 01:24:53.630445 systemd[1]: systemd-sysctl.service: Deactivated successfully. Jan 28 01:24:53.630542 systemd[1]: Stopped systemd-sysctl.service - Apply Kernel Variables. Jan 28 01:24:53.638783 systemd[1]: systemd-modules-load.service: Deactivated successfully. Jan 28 01:24:53.638825 systemd[1]: Stopped systemd-modules-load.service - Load Kernel Modules. Jan 28 01:24:53.647641 systemd[1]: systemd-tmpfiles-setup.service: Deactivated successfully. Jan 28 01:24:53.647685 systemd[1]: Stopped systemd-tmpfiles-setup.service - Create System Files and Directories. Jan 28 01:24:53.657607 systemd[1]: Stopping systemd-udevd.service - Rule-based Manager for Device Events and Files... Jan 28 01:24:53.695239 systemd[1]: systemd-udevd.service: Deactivated successfully. Jan 28 01:24:53.695415 systemd[1]: Stopped systemd-udevd.service - Rule-based Manager for Device Events and Files. Jan 28 01:24:53.704238 systemd[1]: systemd-udevd-control.socket: Deactivated successfully. Jan 28 01:24:53.704281 systemd[1]: Closed systemd-udevd-control.socket - udev Control Socket. Jan 28 01:24:53.713017 systemd[1]: systemd-udevd-kernel.socket: Deactivated successfully. Jan 28 01:24:53.713046 systemd[1]: Closed systemd-udevd-kernel.socket - udev Kernel Socket. Jan 28 01:24:53.723073 systemd[1]: dracut-pre-udev.service: Deactivated successfully. Jan 28 01:24:53.723118 systemd[1]: Stopped dracut-pre-udev.service - dracut pre-udev hook. Jan 28 01:24:53.743983 systemd[1]: dracut-cmdline.service: Deactivated successfully. Jan 28 01:24:53.744044 systemd[1]: Stopped dracut-cmdline.service - dracut cmdline hook. Jan 28 01:24:53.753592 systemd[1]: dracut-cmdline-ask.service: Deactivated successfully. Jan 28 01:24:53.753646 systemd[1]: Stopped dracut-cmdline-ask.service - dracut ask for additional cmdline parameters. Jan 28 01:24:53.778670 systemd[1]: Starting initrd-udevadm-cleanup-db.service - Cleanup udev Database... Jan 28 01:24:53.791551 systemd[1]: systemd-tmpfiles-setup-dev.service: Deactivated successfully. Jan 28 01:24:53.791623 systemd[1]: Stopped systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev. Jan 28 01:24:53.806957 systemd[1]: systemd-tmpfiles-setup-dev-early.service: Deactivated successfully. Jan 28 01:24:53.807018 systemd[1]: Stopped systemd-tmpfiles-setup-dev-early.service - Create Static Device Nodes in /dev gracefully. Jan 28 01:24:53.818516 systemd[1]: kmod-static-nodes.service: Deactivated successfully. Jan 28 01:24:53.818565 systemd[1]: Stopped kmod-static-nodes.service - Create List of Static Device Nodes. Jan 28 01:24:53.827667 systemd[1]: systemd-vconsole-setup.service: Deactivated successfully. Jan 28 01:24:53.827706 systemd[1]: Stopped systemd-vconsole-setup.service - Virtual Console Setup. Jan 28 01:24:53.837532 systemd[1]: network-cleanup.service: Deactivated successfully. Jan 28 01:24:53.996219 systemd-journald[218]: Received SIGTERM from PID 1 (systemd). Jan 28 01:24:53.837641 systemd[1]: Stopped network-cleanup.service - Network Cleanup. Jan 28 01:24:53.846043 systemd[1]: initrd-udevadm-cleanup-db.service: Deactivated successfully. Jan 28 01:24:53.846131 systemd[1]: Finished initrd-udevadm-cleanup-db.service - Cleanup udev Database. Jan 28 01:24:53.856236 systemd[1]: Reached target initrd-switch-root.target - Switch Root. Jan 28 01:24:53.881706 systemd[1]: Starting initrd-switch-root.service - Switch Root... Jan 28 01:24:53.916366 systemd[1]: Switching root. Jan 28 01:24:54.022173 systemd-journald[218]: Journal stopped Jan 28 01:24:45.214716 kernel: Booting Linux on physical CPU 0x0000000000 [0x413fd0c1] Jan 28 01:24:45.214738 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 Tue Jan 27 23:05:14 -00 2026 Jan 28 01:24:45.214746 kernel: KASLR enabled Jan 28 01:24:45.214752 kernel: earlycon: pl11 at MMIO 0x00000000effec000 (options '') Jan 28 01:24:45.214759 kernel: printk: bootconsole [pl11] enabled Jan 28 01:24:45.214765 kernel: efi: EFI v2.7 by EDK II Jan 28 01:24:45.214772 kernel: efi: ACPI 2.0=0x3fd5f018 SMBIOS=0x3e580000 SMBIOS 3.0=0x3e560000 MEMATTR=0x3f215018 RNG=0x3fd5f998 MEMRESERVE=0x3e44ee18 Jan 28 01:24:45.214778 kernel: random: crng init done Jan 28 01:24:45.214784 kernel: ACPI: Early table checksum verification disabled Jan 28 01:24:45.214790 kernel: ACPI: RSDP 0x000000003FD5F018 000024 (v02 VRTUAL) Jan 28 01:24:45.214797 kernel: ACPI: XSDT 0x000000003FD5FF18 00006C (v01 VRTUAL MICROSFT 00000001 MSFT 00000001) Jan 28 01:24:45.214803 kernel: ACPI: FACP 0x000000003FD5FC18 000114 (v06 VRTUAL MICROSFT 00000001 MSFT 00000001) Jan 28 01:24:45.214810 kernel: ACPI: DSDT 0x000000003FD41018 01DFCD (v02 MSFTVM DSDT01 00000001 INTL 20230628) Jan 28 01:24:45.214816 kernel: ACPI: DBG2 0x000000003FD5FB18 000072 (v00 VRTUAL MICROSFT 00000001 MSFT 00000001) Jan 28 01:24:45.214824 kernel: ACPI: GTDT 0x000000003FD5FD98 000060 (v02 VRTUAL MICROSFT 00000001 MSFT 00000001) Jan 28 01:24:45.214830 kernel: ACPI: OEM0 0x000000003FD5F098 000064 (v01 VRTUAL MICROSFT 00000001 MSFT 00000001) Jan 28 01:24:45.214837 kernel: ACPI: SPCR 0x000000003FD5FA98 000050 (v02 VRTUAL MICROSFT 00000001 MSFT 00000001) Jan 28 01:24:45.214845 kernel: ACPI: APIC 0x000000003FD5F818 0000FC (v04 VRTUAL MICROSFT 00000001 MSFT 00000001) Jan 28 01:24:45.214851 kernel: ACPI: SRAT 0x000000003FD5F198 000234 (v03 VRTUAL MICROSFT 00000001 MSFT 00000001) Jan 28 01:24:45.214858 kernel: ACPI: PPTT 0x000000003FD5F418 000120 (v01 VRTUAL MICROSFT 00000000 MSFT 00000000) Jan 28 01:24:45.214864 kernel: ACPI: BGRT 0x000000003FD5FE98 000038 (v01 VRTUAL MICROSFT 00000001 MSFT 00000001) Jan 28 01:24:45.214871 kernel: ACPI: SPCR: console: pl011,mmio32,0xeffec000,115200 Jan 28 01:24:45.214877 kernel: ACPI: SRAT: Node 0 PXM 0 [mem 0x00000000-0x3fffffff] Jan 28 01:24:45.214883 kernel: ACPI: SRAT: Node 0 PXM 0 [mem 0x100000000-0x1bfffffff] Jan 28 01:24:45.214890 kernel: ACPI: SRAT: Node 0 PXM 0 [mem 0x1c0000000-0xfbfffffff] Jan 28 01:24:45.214896 kernel: ACPI: SRAT: Node 0 PXM 0 [mem 0x1000000000-0xffffffffff] Jan 28 01:24:45.214902 kernel: ACPI: SRAT: Node 0 PXM 0 [mem 0x10000000000-0x1ffffffffff] Jan 28 01:24:45.214909 kernel: ACPI: SRAT: Node 0 PXM 0 [mem 0x20000000000-0x3ffffffffff] Jan 28 01:24:45.214917 kernel: ACPI: SRAT: Node 0 PXM 0 [mem 0x40000000000-0x7ffffffffff] Jan 28 01:24:45.214923 kernel: ACPI: SRAT: Node 0 PXM 0 [mem 0x80000000000-0xfffffffffff] Jan 28 01:24:45.214930 kernel: ACPI: SRAT: Node 0 PXM 0 [mem 0x100000000000-0x1fffffffffff] Jan 28 01:24:45.214936 kernel: ACPI: SRAT: Node 0 PXM 0 [mem 0x200000000000-0x3fffffffffff] Jan 28 01:24:45.214942 kernel: ACPI: SRAT: Node 0 PXM 0 [mem 0x400000000000-0x7fffffffffff] Jan 28 01:24:45.214949 kernel: ACPI: SRAT: Node 0 PXM 0 [mem 0x800000000000-0xffffffffffff] Jan 28 01:24:45.214955 kernel: NUMA: NODE_DATA [mem 0x1bf7ee800-0x1bf7f3fff] Jan 28 01:24:45.214961 kernel: Zone ranges: Jan 28 01:24:45.214968 kernel: DMA [mem 0x0000000000000000-0x00000000ffffffff] Jan 28 01:24:45.214974 kernel: DMA32 empty Jan 28 01:24:45.214980 kernel: Normal [mem 0x0000000100000000-0x00000001bfffffff] Jan 28 01:24:45.214987 kernel: Movable zone start for each node Jan 28 01:24:45.214997 kernel: Early memory node ranges Jan 28 01:24:45.215004 kernel: node 0: [mem 0x0000000000000000-0x00000000007fffff] Jan 28 01:24:45.215011 kernel: node 0: [mem 0x0000000000824000-0x000000003e54ffff] Jan 28 01:24:45.215017 kernel: node 0: [mem 0x000000003e550000-0x000000003e87ffff] Jan 28 01:24:45.215024 kernel: node 0: [mem 0x000000003e880000-0x000000003fc7ffff] Jan 28 01:24:45.215033 kernel: node 0: [mem 0x000000003fc80000-0x000000003fcfffff] Jan 28 01:24:45.215040 kernel: node 0: [mem 0x000000003fd00000-0x000000003fffffff] Jan 28 01:24:45.215046 kernel: node 0: [mem 0x0000000100000000-0x00000001bfffffff] Jan 28 01:24:45.215053 kernel: Initmem setup node 0 [mem 0x0000000000000000-0x00000001bfffffff] Jan 28 01:24:45.215060 kernel: On node 0, zone DMA: 36 pages in unavailable ranges Jan 28 01:24:45.215067 kernel: psci: probing for conduit method from ACPI. Jan 28 01:24:45.215074 kernel: psci: PSCIv1.1 detected in firmware. Jan 28 01:24:45.215081 kernel: psci: Using standard PSCI v0.2 function IDs Jan 28 01:24:45.215088 kernel: psci: MIGRATE_INFO_TYPE not supported. Jan 28 01:24:45.215095 kernel: psci: SMC Calling Convention v1.4 Jan 28 01:24:45.215101 kernel: ACPI: NUMA: SRAT: PXM 0 -> MPIDR 0x0 -> Node 0 Jan 28 01:24:45.217153 kernel: ACPI: NUMA: SRAT: PXM 0 -> MPIDR 0x1 -> Node 0 Jan 28 01:24:45.217175 kernel: percpu: Embedded 30 pages/cpu s85672 r8192 d29016 u122880 Jan 28 01:24:45.217183 kernel: pcpu-alloc: s85672 r8192 d29016 u122880 alloc=30*4096 Jan 28 01:24:45.217190 kernel: pcpu-alloc: [0] 0 [0] 1 Jan 28 01:24:45.217197 kernel: Detected PIPT I-cache on CPU0 Jan 28 01:24:45.217204 kernel: CPU features: detected: GIC system register CPU interface Jan 28 01:24:45.217211 kernel: CPU features: detected: Hardware dirty bit management Jan 28 01:24:45.217218 kernel: CPU features: detected: Spectre-BHB Jan 28 01:24:45.217225 kernel: CPU features: kernel page table isolation forced ON by KASLR Jan 28 01:24:45.217232 kernel: CPU features: detected: Kernel page table isolation (KPTI) Jan 28 01:24:45.217238 kernel: CPU features: detected: ARM erratum 1418040 Jan 28 01:24:45.217245 kernel: CPU features: detected: ARM erratum 1542419 (kernel portion) Jan 28 01:24:45.217254 kernel: CPU features: detected: SSBS not fully self-synchronizing Jan 28 01:24:45.217260 kernel: alternatives: applying boot alternatives Jan 28 01:24:45.217269 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=e7a8cac0a248eeeb18f7bcbd95b9dbb1e3415729dc1af128dd9f394f73832ecf Jan 28 01:24:45.217277 kernel: Dentry cache hash table entries: 524288 (order: 10, 4194304 bytes, linear) Jan 28 01:24:45.217284 kernel: Inode-cache hash table entries: 262144 (order: 9, 2097152 bytes, linear) Jan 28 01:24:45.217291 kernel: Fallback order for Node 0: 0 Jan 28 01:24:45.217297 kernel: Built 1 zonelists, mobility grouping on. Total pages: 1032156 Jan 28 01:24:45.217304 kernel: Policy zone: Normal Jan 28 01:24:45.217311 kernel: mem auto-init: stack:off, heap alloc:off, heap free:off Jan 28 01:24:45.217318 kernel: software IO TLB: area num 2. Jan 28 01:24:45.217324 kernel: software IO TLB: mapped [mem 0x000000003a44e000-0x000000003e44e000] (64MB) Jan 28 01:24:45.217333 kernel: Memory: 3982632K/4194160K available (10304K kernel code, 2180K rwdata, 8112K rodata, 39424K init, 897K bss, 211528K reserved, 0K cma-reserved) Jan 28 01:24:45.217340 kernel: SLUB: HWalign=64, Order=0-3, MinObjects=0, CPUs=2, Nodes=1 Jan 28 01:24:45.217347 kernel: rcu: Preemptible hierarchical RCU implementation. Jan 28 01:24:45.217354 kernel: rcu: RCU event tracing is enabled. Jan 28 01:24:45.217361 kernel: rcu: RCU restricting CPUs from NR_CPUS=512 to nr_cpu_ids=2. Jan 28 01:24:45.217368 kernel: Trampoline variant of Tasks RCU enabled. Jan 28 01:24:45.217375 kernel: Tracing variant of Tasks RCU enabled. Jan 28 01:24:45.217382 kernel: rcu: RCU calculated value of scheduler-enlistment delay is 100 jiffies. Jan 28 01:24:45.217389 kernel: rcu: Adjusting geometry for rcu_fanout_leaf=16, nr_cpu_ids=2 Jan 28 01:24:45.217396 kernel: NR_IRQS: 64, nr_irqs: 64, preallocated irqs: 0 Jan 28 01:24:45.217403 kernel: GICv3: 960 SPIs implemented Jan 28 01:24:45.217411 kernel: GICv3: 0 Extended SPIs implemented Jan 28 01:24:45.217418 kernel: Root IRQ handler: gic_handle_irq Jan 28 01:24:45.217425 kernel: GICv3: GICv3 features: 16 PPIs, RSS Jan 28 01:24:45.217431 kernel: GICv3: CPU0: found redistributor 0 region 0:0x00000000effee000 Jan 28 01:24:45.217438 kernel: ITS: No ITS available, not enabling LPIs Jan 28 01:24:45.217445 kernel: rcu: srcu_init: Setting srcu_struct sizes based on contention. Jan 28 01:24:45.217452 kernel: arch_timer: Enabling local workaround for ARM erratum 1418040 Jan 28 01:24:45.217459 kernel: arch_timer: cp15 timer(s) running at 25.00MHz (virt). Jan 28 01:24:45.217466 kernel: clocksource: arch_sys_counter: mask: 0xffffffffffffff max_cycles: 0x5c40939b5, max_idle_ns: 440795202646 ns Jan 28 01:24:45.217473 kernel: sched_clock: 56 bits at 25MHz, resolution 40ns, wraps every 4398046511100ns Jan 28 01:24:45.217480 kernel: Console: colour dummy device 80x25 Jan 28 01:24:45.217488 kernel: printk: console [tty1] enabled Jan 28 01:24:45.217496 kernel: ACPI: Core revision 20230628 Jan 28 01:24:45.217503 kernel: Calibrating delay loop (skipped), value calculated using timer frequency.. 50.00 BogoMIPS (lpj=25000) Jan 28 01:24:45.217510 kernel: pid_max: default: 32768 minimum: 301 Jan 28 01:24:45.217517 kernel: LSM: initializing lsm=lockdown,capability,landlock,selinux,integrity Jan 28 01:24:45.217524 kernel: landlock: Up and running. Jan 28 01:24:45.217531 kernel: SELinux: Initializing. Jan 28 01:24:45.217538 kernel: Mount-cache hash table entries: 8192 (order: 4, 65536 bytes, linear) Jan 28 01:24:45.217545 kernel: Mountpoint-cache hash table entries: 8192 (order: 4, 65536 bytes, linear) Jan 28 01:24:45.217554 kernel: RCU Tasks: Setting shift to 1 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=2. Jan 28 01:24:45.217561 kernel: RCU Tasks Trace: Setting shift to 1 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=2. Jan 28 01:24:45.217568 kernel: Hyper-V: privilege flags low 0x2e7f, high 0x3a8030, hints 0x100000e, misc 0x31e1 Jan 28 01:24:45.217575 kernel: Hyper-V: Host Build 10.0.26100.1448-1-0 Jan 28 01:24:45.217582 kernel: Hyper-V: enabling crash_kexec_post_notifiers Jan 28 01:24:45.217589 kernel: rcu: Hierarchical SRCU implementation. Jan 28 01:24:45.217596 kernel: rcu: Max phase no-delay instances is 400. Jan 28 01:24:45.217603 kernel: Remapping and enabling EFI services. Jan 28 01:24:45.217616 kernel: smp: Bringing up secondary CPUs ... Jan 28 01:24:45.217623 kernel: Detected PIPT I-cache on CPU1 Jan 28 01:24:45.217631 kernel: GICv3: CPU1: found redistributor 1 region 1:0x00000000f000e000 Jan 28 01:24:45.217638 kernel: arch_timer: Enabling local workaround for ARM erratum 1418040 Jan 28 01:24:45.217647 kernel: CPU1: Booted secondary processor 0x0000000001 [0x413fd0c1] Jan 28 01:24:45.217654 kernel: smp: Brought up 1 node, 2 CPUs Jan 28 01:24:45.217661 kernel: SMP: Total of 2 processors activated. Jan 28 01:24:45.217669 kernel: CPU features: detected: 32-bit EL0 Support Jan 28 01:24:45.217676 kernel: CPU features: detected: Instruction cache invalidation not required for I/D coherence Jan 28 01:24:45.217685 kernel: CPU features: detected: Data cache clean to the PoU not required for I/D coherence Jan 28 01:24:45.217693 kernel: CPU features: detected: CRC32 instructions Jan 28 01:24:45.217701 kernel: CPU features: detected: RCpc load-acquire (LDAPR) Jan 28 01:24:45.217708 kernel: CPU features: detected: LSE atomic instructions Jan 28 01:24:45.217715 kernel: CPU features: detected: Privileged Access Never Jan 28 01:24:45.217722 kernel: CPU: All CPU(s) started at EL1 Jan 28 01:24:45.217730 kernel: alternatives: applying system-wide alternatives Jan 28 01:24:45.217737 kernel: devtmpfs: initialized Jan 28 01:24:45.217745 kernel: clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1911260446275000 ns Jan 28 01:24:45.217754 kernel: futex hash table entries: 512 (order: 3, 32768 bytes, linear) Jan 28 01:24:45.217761 kernel: pinctrl core: initialized pinctrl subsystem Jan 28 01:24:45.217768 kernel: SMBIOS 3.1.0 present. Jan 28 01:24:45.217776 kernel: DMI: Microsoft Corporation Virtual Machine/Virtual Machine, BIOS Hyper-V UEFI Release v4.1 09/28/2024 Jan 28 01:24:45.217783 kernel: NET: Registered PF_NETLINK/PF_ROUTE protocol family Jan 28 01:24:45.217791 kernel: DMA: preallocated 512 KiB GFP_KERNEL pool for atomic allocations Jan 28 01:24:45.217798 kernel: DMA: preallocated 512 KiB GFP_KERNEL|GFP_DMA pool for atomic allocations Jan 28 01:24:45.217806 kernel: DMA: preallocated 512 KiB GFP_KERNEL|GFP_DMA32 pool for atomic allocations Jan 28 01:24:45.217813 kernel: audit: initializing netlink subsys (disabled) Jan 28 01:24:45.217822 kernel: audit: type=2000 audit(0.047:1): state=initialized audit_enabled=0 res=1 Jan 28 01:24:45.217830 kernel: thermal_sys: Registered thermal governor 'step_wise' Jan 28 01:24:45.217837 kernel: cpuidle: using governor menu Jan 28 01:24:45.217844 kernel: hw-breakpoint: found 6 breakpoint and 4 watchpoint registers. Jan 28 01:24:45.217852 kernel: ASID allocator initialised with 32768 entries Jan 28 01:24:45.217859 kernel: acpiphp: ACPI Hot Plug PCI Controller Driver version: 0.5 Jan 28 01:24:45.217867 kernel: Serial: AMBA PL011 UART driver Jan 28 01:24:45.217874 kernel: Modules: 2G module region forced by RANDOMIZE_MODULE_REGION_FULL Jan 28 01:24:45.217881 kernel: Modules: 0 pages in range for non-PLT usage Jan 28 01:24:45.217890 kernel: Modules: 509008 pages in range for PLT usage Jan 28 01:24:45.217897 kernel: HugeTLB: registered 1.00 GiB page size, pre-allocated 0 pages Jan 28 01:24:45.217905 kernel: HugeTLB: 0 KiB vmemmap can be freed for a 1.00 GiB page Jan 28 01:24:45.217912 kernel: HugeTLB: registered 32.0 MiB page size, pre-allocated 0 pages Jan 28 01:24:45.217919 kernel: HugeTLB: 0 KiB vmemmap can be freed for a 32.0 MiB page Jan 28 01:24:45.217927 kernel: HugeTLB: registered 2.00 MiB page size, pre-allocated 0 pages Jan 28 01:24:45.217934 kernel: HugeTLB: 0 KiB vmemmap can be freed for a 2.00 MiB page Jan 28 01:24:45.217942 kernel: HugeTLB: registered 64.0 KiB page size, pre-allocated 0 pages Jan 28 01:24:45.217949 kernel: HugeTLB: 0 KiB vmemmap can be freed for a 64.0 KiB page Jan 28 01:24:45.217958 kernel: ACPI: Added _OSI(Module Device) Jan 28 01:24:45.217966 kernel: ACPI: Added _OSI(Processor Device) Jan 28 01:24:45.217973 kernel: ACPI: Added _OSI(Processor Aggregator Device) Jan 28 01:24:45.217980 kernel: ACPI: 1 ACPI AML tables successfully acquired and loaded Jan 28 01:24:45.217988 kernel: ACPI: Interpreter enabled Jan 28 01:24:45.217995 kernel: ACPI: Using GIC for interrupt routing Jan 28 01:24:45.218002 kernel: ARMH0011:00: ttyAMA0 at MMIO 0xeffec000 (irq = 12, base_baud = 0) is a SBSA Jan 28 01:24:45.218010 kernel: printk: console [ttyAMA0] enabled Jan 28 01:24:45.218017 kernel: printk: bootconsole [pl11] disabled Jan 28 01:24:45.218026 kernel: ARMH0011:01: ttyAMA1 at MMIO 0xeffeb000 (irq = 13, base_baud = 0) is a SBSA Jan 28 01:24:45.218034 kernel: iommu: Default domain type: Translated Jan 28 01:24:45.218042 kernel: iommu: DMA domain TLB invalidation policy: strict mode Jan 28 01:24:45.218049 kernel: efivars: Registered efivars operations Jan 28 01:24:45.218056 kernel: vgaarb: loaded Jan 28 01:24:45.218063 kernel: clocksource: Switched to clocksource arch_sys_counter Jan 28 01:24:45.218071 kernel: VFS: Disk quotas dquot_6.6.0 Jan 28 01:24:45.218078 kernel: VFS: Dquot-cache hash table entries: 512 (order 0, 4096 bytes) Jan 28 01:24:45.218085 kernel: pnp: PnP ACPI init Jan 28 01:24:45.218094 kernel: pnp: PnP ACPI: found 0 devices Jan 28 01:24:45.218102 kernel: NET: Registered PF_INET protocol family Jan 28 01:24:45.218117 kernel: IP idents hash table entries: 65536 (order: 7, 524288 bytes, linear) Jan 28 01:24:45.218125 kernel: tcp_listen_portaddr_hash hash table entries: 2048 (order: 3, 32768 bytes, linear) Jan 28 01:24:45.218133 kernel: Table-perturb hash table entries: 65536 (order: 6, 262144 bytes, linear) Jan 28 01:24:45.218140 kernel: TCP established hash table entries: 32768 (order: 6, 262144 bytes, linear) Jan 28 01:24:45.218148 kernel: TCP bind hash table entries: 32768 (order: 8, 1048576 bytes, linear) Jan 28 01:24:45.218155 kernel: TCP: Hash tables configured (established 32768 bind 32768) Jan 28 01:24:45.218162 kernel: UDP hash table entries: 2048 (order: 4, 65536 bytes, linear) Jan 28 01:24:45.218172 kernel: UDP-Lite hash table entries: 2048 (order: 4, 65536 bytes, linear) Jan 28 01:24:45.218180 kernel: NET: Registered PF_UNIX/PF_LOCAL protocol family Jan 28 01:24:45.218187 kernel: PCI: CLS 0 bytes, default 64 Jan 28 01:24:45.218194 kernel: kvm [1]: HYP mode not available Jan 28 01:24:45.218202 kernel: Initialise system trusted keyrings Jan 28 01:24:45.218209 kernel: workingset: timestamp_bits=39 max_order=20 bucket_order=0 Jan 28 01:24:45.218217 kernel: Key type asymmetric registered Jan 28 01:24:45.218224 kernel: Asymmetric key parser 'x509' registered Jan 28 01:24:45.218231 kernel: Block layer SCSI generic (bsg) driver version 0.4 loaded (major 250) Jan 28 01:24:45.218241 kernel: io scheduler mq-deadline registered Jan 28 01:24:45.218248 kernel: io scheduler kyber registered Jan 28 01:24:45.218255 kernel: io scheduler bfq registered Jan 28 01:24:45.218262 kernel: Serial: 8250/16550 driver, 4 ports, IRQ sharing enabled Jan 28 01:24:45.218270 kernel: thunder_xcv, ver 1.0 Jan 28 01:24:45.218277 kernel: thunder_bgx, ver 1.0 Jan 28 01:24:45.218284 kernel: nicpf, ver 1.0 Jan 28 01:24:45.218292 kernel: nicvf, ver 1.0 Jan 28 01:24:45.218436 kernel: rtc-efi rtc-efi.0: registered as rtc0 Jan 28 01:24:45.218509 kernel: rtc-efi rtc-efi.0: setting system clock to 2026-01-28T01:24:44 UTC (1769563484) Jan 28 01:24:45.218520 kernel: efifb: probing for efifb Jan 28 01:24:45.218528 kernel: efifb: framebuffer at 0x40000000, using 3072k, total 3072k Jan 28 01:24:45.218535 kernel: efifb: mode is 1024x768x32, linelength=4096, pages=1 Jan 28 01:24:45.218543 kernel: efifb: scrolling: redraw Jan 28 01:24:45.218550 kernel: efifb: Truecolor: size=8:8:8:8, shift=24:16:8:0 Jan 28 01:24:45.218557 kernel: Console: switching to colour frame buffer device 128x48 Jan 28 01:24:45.218565 kernel: fb0: EFI VGA frame buffer device Jan 28 01:24:45.218574 kernel: SMCCC: SOC_ID: ARCH_SOC_ID not implemented, skipping .... Jan 28 01:24:45.218581 kernel: hid: raw HID events driver (C) Jiri Kosina Jan 28 01:24:45.218589 kernel: hw perfevents: enabled with armv8_pmuv3_0 PMU driver, 6 counters available Jan 28 01:24:45.218596 kernel: watchdog: Delayed init of the lockup detector failed: -19 Jan 28 01:24:45.218604 kernel: watchdog: Hard watchdog permanently disabled Jan 28 01:24:45.218611 kernel: NET: Registered PF_INET6 protocol family Jan 28 01:24:45.218619 kernel: Segment Routing with IPv6 Jan 28 01:24:45.218626 kernel: In-situ OAM (IOAM) with IPv6 Jan 28 01:24:45.218634 kernel: NET: Registered PF_PACKET protocol family Jan 28 01:24:45.218642 kernel: Key type dns_resolver registered Jan 28 01:24:45.218650 kernel: registered taskstats version 1 Jan 28 01:24:45.218657 kernel: Loading compiled-in X.509 certificates Jan 28 01:24:45.218665 kernel: Loaded X.509 cert 'Kinvolk GmbH: Module signing key for 6.6.119-flatcar: 00ce1dc8bc64b61f07099b23b76dee034878817c' Jan 28 01:24:45.218672 kernel: Key type .fscrypt registered Jan 28 01:24:45.218679 kernel: Key type fscrypt-provisioning registered Jan 28 01:24:45.218687 kernel: ima: No TPM chip found, activating TPM-bypass! Jan 28 01:24:45.218694 kernel: ima: Allocated hash algorithm: sha1 Jan 28 01:24:45.218702 kernel: ima: No architecture policies found Jan 28 01:24:45.218711 kernel: alg: No test for fips(ansi_cprng) (fips_ansi_cprng) Jan 28 01:24:45.218718 kernel: clk: Disabling unused clocks Jan 28 01:24:45.218726 kernel: Freeing unused kernel memory: 39424K Jan 28 01:24:45.218733 kernel: Run /init as init process Jan 28 01:24:45.218740 kernel: with arguments: Jan 28 01:24:45.218747 kernel: /init Jan 28 01:24:45.218754 kernel: with environment: Jan 28 01:24:45.218761 kernel: HOME=/ Jan 28 01:24:45.218768 kernel: TERM=linux Jan 28 01:24:45.218778 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 28 01:24:45.218791 systemd[1]: Detected virtualization microsoft. Jan 28 01:24:45.218801 systemd[1]: Detected architecture arm64. Jan 28 01:24:45.218810 systemd[1]: Running in initrd. Jan 28 01:24:45.218819 systemd[1]: No hostname configured, using default hostname. Jan 28 01:24:45.218827 systemd[1]: Hostname set to . Jan 28 01:24:45.218837 systemd[1]: Initializing machine ID from random generator. Jan 28 01:24:45.218848 systemd[1]: Queued start job for default target initrd.target. Jan 28 01:24:45.218858 systemd[1]: Started clevis-luks-askpass.path - Forward Password Requests to Clevis Directory Watch. Jan 28 01:24:45.218867 systemd[1]: Started systemd-ask-password-console.path - Dispatch Password Requests to Console Directory Watch. Jan 28 01:24:45.218877 systemd[1]: Expecting device dev-disk-by\x2dlabel-EFI\x2dSYSTEM.device - /dev/disk/by-label/EFI-SYSTEM... Jan 28 01:24:45.218887 systemd[1]: Expecting device dev-disk-by\x2dlabel-OEM.device - /dev/disk/by-label/OEM... Jan 28 01:24:45.218896 systemd[1]: Expecting device dev-disk-by\x2dlabel-ROOT.device - /dev/disk/by-label/ROOT... Jan 28 01:24:45.218905 systemd[1]: Expecting device dev-disk-by\x2dpartlabel-USR\x2dA.device - /dev/disk/by-partlabel/USR-A... Jan 28 01:24:45.218916 systemd[1]: Expecting device dev-disk-by\x2dpartuuid-7130c94a\x2d213a\x2d4e5a\x2d8e26\x2d6cce9662f132.device - /dev/disk/by-partuuid/7130c94a-213a-4e5a-8e26-6cce9662f132... Jan 28 01:24:45.218928 systemd[1]: Expecting device dev-mapper-usr.device - /dev/mapper/usr... Jan 28 01:24:45.218937 systemd[1]: Reached target cryptsetup-pre.target - Local Encrypted Volumes (Pre). Jan 28 01:24:45.218945 systemd[1]: Reached target cryptsetup.target - Local Encrypted Volumes. Jan 28 01:24:45.218953 systemd[1]: Reached target paths.target - Path Units. Jan 28 01:24:45.218961 systemd[1]: Reached target slices.target - Slice Units. Jan 28 01:24:45.218969 systemd[1]: Reached target swap.target - Swaps. Jan 28 01:24:45.218977 systemd[1]: Reached target timers.target - Timer Units. Jan 28 01:24:45.218987 systemd[1]: Listening on iscsid.socket - Open-iSCSI iscsid Socket. Jan 28 01:24:45.218998 systemd[1]: Listening on iscsiuio.socket - Open-iSCSI iscsiuio Socket. Jan 28 01:24:45.219008 systemd[1]: Listening on systemd-journald-dev-log.socket - Journal Socket (/dev/log). Jan 28 01:24:45.219017 systemd[1]: Listening on systemd-journald.socket - Journal Socket. Jan 28 01:24:45.219026 systemd[1]: Listening on systemd-networkd.socket - Network Service Netlink Socket. Jan 28 01:24:45.219036 systemd[1]: Listening on systemd-udevd-control.socket - udev Control Socket. Jan 28 01:24:45.219045 systemd[1]: Listening on systemd-udevd-kernel.socket - udev Kernel Socket. Jan 28 01:24:45.219054 systemd[1]: Reached target sockets.target - Socket Units. Jan 28 01:24:45.219064 systemd[1]: Starting ignition-setup-pre.service - Ignition env setup... Jan 28 01:24:45.219074 systemd[1]: Starting kmod-static-nodes.service - Create List of Static Device Nodes... Jan 28 01:24:45.219083 systemd[1]: Finished network-cleanup.service - Network Cleanup. Jan 28 01:24:45.219090 systemd[1]: Starting systemd-fsck-usr.service... Jan 28 01:24:45.219099 systemd[1]: Starting systemd-journald.service - Journal Service... Jan 28 01:24:45.221142 systemd[1]: Starting systemd-modules-load.service - Load Kernel Modules... Jan 28 01:24:45.221187 systemd-journald[218]: Collecting audit messages is disabled. Jan 28 01:24:45.221214 systemd[1]: Starting systemd-vconsole-setup.service - Virtual Console Setup... Jan 28 01:24:45.221224 systemd-journald[218]: Journal started Jan 28 01:24:45.221242 systemd-journald[218]: Runtime Journal (/run/log/journal/d70ccb4e685b4e0aa3aaff3821801c67) is 8.0M, max 78.5M, 70.5M free. Jan 28 01:24:45.229785 systemd-modules-load[219]: Inserted module 'overlay' Jan 28 01:24:45.242959 systemd[1]: Started systemd-journald.service - Journal Service. Jan 28 01:24:45.245137 systemd[1]: Finished ignition-setup-pre.service - Ignition env setup. Jan 28 01:24:45.257377 systemd[1]: Finished kmod-static-nodes.service - Create List of Static Device Nodes. Jan 28 01:24:45.288912 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 28 01:24:45.288934 kernel: Bridge firewalling registered Jan 28 01:24:45.279953 systemd-modules-load[219]: Inserted module 'br_netfilter' Jan 28 01:24:45.286152 systemd[1]: Finished systemd-fsck-usr.service. Jan 28 01:24:45.292899 systemd[1]: Finished systemd-modules-load.service - Load Kernel Modules. Jan 28 01:24:45.301941 systemd[1]: Finished systemd-vconsole-setup.service - Virtual Console Setup. Jan 28 01:24:45.322239 systemd[1]: Starting dracut-cmdline-ask.service - dracut ask for additional cmdline parameters... Jan 28 01:24:45.328457 systemd[1]: Starting systemd-sysctl.service - Apply Kernel Variables... Jan 28 01:24:45.349179 systemd[1]: Starting systemd-tmpfiles-setup-dev-early.service - Create Static Device Nodes in /dev gracefully... Jan 28 01:24:45.365288 systemd[1]: Starting systemd-tmpfiles-setup.service - Create System Files and Directories... Jan 28 01:24:45.378139 systemd[1]: Finished dracut-cmdline-ask.service - dracut ask for additional cmdline parameters. Jan 28 01:24:45.384693 systemd[1]: Finished systemd-sysctl.service - Apply Kernel Variables. Jan 28 01:24:45.404691 systemd[1]: Finished systemd-tmpfiles-setup-dev-early.service - Create Static Device Nodes in /dev gracefully. Jan 28 01:24:45.421335 systemd[1]: Starting dracut-cmdline.service - dracut cmdline hook... Jan 28 01:24:45.432295 systemd[1]: Starting systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev... Jan 28 01:24:45.445613 systemd[1]: Finished systemd-tmpfiles-setup.service - Create System Files and Directories. Jan 28 01:24:45.463567 dracut-cmdline[251]: dracut-dracut-053 Jan 28 01:24:45.463567 dracut-cmdline[251]: 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=e7a8cac0a248eeeb18f7bcbd95b9dbb1e3415729dc1af128dd9f394f73832ecf Jan 28 01:24:45.469351 systemd[1]: Starting systemd-resolved.service - Network Name Resolution... Jan 28 01:24:45.475206 systemd[1]: Finished systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev. Jan 28 01:24:45.533771 systemd-resolved[265]: Positive Trust Anchors: Jan 28 01:24:45.533786 systemd-resolved[265]: . IN DS 20326 8 2 e06d44b80b8f1d39a95c0b0d7c65d08458e880409bbc683457104237c7f8ec8d Jan 28 01:24:45.533817 systemd-resolved[265]: 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 28 01:24:45.540138 systemd-resolved[265]: Defaulting to hostname 'linux'. Jan 28 01:24:45.541041 systemd[1]: Started systemd-resolved.service - Network Name Resolution. Jan 28 01:24:45.604404 kernel: SCSI subsystem initialized Jan 28 01:24:45.553730 systemd[1]: Reached target nss-lookup.target - Host and Network Name Lookups. Jan 28 01:24:45.623120 kernel: Loading iSCSI transport class v2.0-870. Jan 28 01:24:45.633142 kernel: iscsi: registered transport (tcp) Jan 28 01:24:45.651040 kernel: iscsi: registered transport (qla4xxx) Jan 28 01:24:45.651061 kernel: QLogic iSCSI HBA Driver Jan 28 01:24:45.690943 systemd[1]: Finished dracut-cmdline.service - dracut cmdline hook. Jan 28 01:24:45.703563 systemd[1]: Starting dracut-pre-udev.service - dracut pre-udev hook... Jan 28 01:24:45.733131 kernel: device-mapper: core: CONFIG_IMA_DISABLE_HTABLE is disabled. Duplicate IMA measurements will not be recorded in the IMA log. Jan 28 01:24:45.733193 kernel: device-mapper: uevent: version 1.0.3 Jan 28 01:24:45.738791 kernel: device-mapper: ioctl: 4.48.0-ioctl (2023-03-01) initialised: dm-devel@redhat.com Jan 28 01:24:45.785123 kernel: raid6: neonx8 gen() 15826 MB/s Jan 28 01:24:45.806117 kernel: raid6: neonx4 gen() 15685 MB/s Jan 28 01:24:45.825112 kernel: raid6: neonx2 gen() 13318 MB/s Jan 28 01:24:45.844112 kernel: raid6: neonx1 gen() 10494 MB/s Jan 28 01:24:45.864113 kernel: raid6: int64x8 gen() 6974 MB/s Jan 28 01:24:45.883112 kernel: raid6: int64x4 gen() 7372 MB/s Jan 28 01:24:45.902111 kernel: raid6: int64x2 gen() 6149 MB/s Jan 28 01:24:45.925417 kernel: raid6: int64x1 gen() 5069 MB/s Jan 28 01:24:45.925428 kernel: raid6: using algorithm neonx8 gen() 15826 MB/s Jan 28 01:24:45.948641 kernel: raid6: .... xor() 12044 MB/s, rmw enabled Jan 28 01:24:45.948651 kernel: raid6: using neon recovery algorithm Jan 28 01:24:45.956115 kernel: xor: measuring software checksum speed Jan 28 01:24:45.962070 kernel: 8regs : 19017 MB/sec Jan 28 01:24:45.962084 kernel: 32regs : 19627 MB/sec Jan 28 01:24:45.964863 kernel: arm64_neon : 27061 MB/sec Jan 28 01:24:45.968691 kernel: xor: using function: arm64_neon (27061 MB/sec) Jan 28 01:24:46.018122 kernel: Btrfs loaded, zoned=no, fsverity=no Jan 28 01:24:46.028175 systemd[1]: Finished dracut-pre-udev.service - dracut pre-udev hook. Jan 28 01:24:46.042245 systemd[1]: Starting systemd-udevd.service - Rule-based Manager for Device Events and Files... Jan 28 01:24:46.064529 systemd-udevd[438]: Using default interface naming scheme 'v255'. Jan 28 01:24:46.069456 systemd[1]: Started systemd-udevd.service - Rule-based Manager for Device Events and Files. Jan 28 01:24:46.087217 systemd[1]: Starting dracut-pre-trigger.service - dracut pre-trigger hook... Jan 28 01:24:46.109232 dracut-pre-trigger[448]: rd.md=0: removing MD RAID activation Jan 28 01:24:46.137474 systemd[1]: Finished dracut-pre-trigger.service - dracut pre-trigger hook. Jan 28 01:24:46.150386 systemd[1]: Starting systemd-udev-trigger.service - Coldplug All udev Devices... Jan 28 01:24:46.187556 systemd[1]: Finished systemd-udev-trigger.service - Coldplug All udev Devices. Jan 28 01:24:46.206130 systemd[1]: Starting dracut-initqueue.service - dracut initqueue hook... Jan 28 01:24:46.248399 systemd[1]: Finished dracut-initqueue.service - dracut initqueue hook. Jan 28 01:24:46.261402 systemd[1]: Reached target remote-fs-pre.target - Preparation for Remote File Systems. Jan 28 01:24:46.274487 systemd[1]: Reached target remote-cryptsetup.target - Remote Encrypted Volumes. Jan 28 01:24:46.289205 systemd[1]: Reached target remote-fs.target - Remote File Systems. Jan 28 01:24:46.300760 kernel: hv_vmbus: Vmbus version:5.3 Jan 28 01:24:46.313405 kernel: hv_vmbus: registering driver hid_hyperv Jan 28 01:24:46.313459 kernel: pps_core: LinuxPPS API ver. 1 registered Jan 28 01:24:46.313470 kernel: hv_vmbus: registering driver hv_netvsc Jan 28 01:24:46.313377 systemd[1]: Starting dracut-pre-mount.service - dracut pre-mount hook... Jan 28 01:24:46.348819 kernel: input: Microsoft Vmbus HID-compliant Mouse as /devices/0006:045E:0621.0001/input/input0 Jan 28 01:24:46.348848 kernel: hid-hyperv 0006:045E:0621.0001: input: VIRTUAL HID v0.01 Mouse [Microsoft Vmbus HID-compliant Mouse] on Jan 28 01:24:46.349009 kernel: pps_core: Software ver. 5.3.6 - Copyright 2005-2007 Rodolfo Giometti Jan 28 01:24:46.343660 systemd[1]: Finished dracut-pre-mount.service - dracut pre-mount hook. Jan 28 01:24:46.359102 systemd[1]: dracut-cmdline-ask.service: Deactivated successfully. Jan 28 01:24:46.380272 kernel: hv_vmbus: registering driver hyperv_keyboard Jan 28 01:24:46.359272 systemd[1]: Stopped dracut-cmdline-ask.service - dracut ask for additional cmdline parameters. Jan 28 01:24:46.411901 kernel: input: AT Translated Set 2 keyboard as /devices/LNXSYSTM:00/LNXSYBUS:00/ACPI0004:00/MSFT1000:00/d34b2567-b9b6-42b9-8778-0a4ec0b955bf/serio0/input/input1 Jan 28 01:24:46.411922 kernel: hv_vmbus: registering driver hv_storvsc Jan 28 01:24:46.375032 systemd[1]: Stopping dracut-cmdline-ask.service - dracut ask for additional cmdline parameters... Jan 28 01:24:46.421609 kernel: PTP clock support registered Jan 28 01:24:46.391381 systemd[1]: systemd-vconsole-setup.service: Deactivated successfully. Jan 28 01:24:46.433446 kernel: scsi host1: storvsc_host_t Jan 28 01:24:46.433882 kernel: scsi host0: storvsc_host_t Jan 28 01:24:46.391602 systemd[1]: Stopped systemd-vconsole-setup.service - Virtual Console Setup. Jan 28 01:24:46.445189 kernel: scsi 0:0:0:0: Direct-Access Msft Virtual Disk 1.0 PQ: 0 ANSI: 5 Jan 28 01:24:46.406501 systemd[1]: Stopping systemd-vconsole-setup.service - Virtual Console Setup... Jan 28 01:24:46.456158 systemd[1]: Starting systemd-vconsole-setup.service - Virtual Console Setup... Jan 28 01:24:46.466609 kernel: scsi 0:0:0:2: CD-ROM Msft Virtual DVD-ROM 1.0 PQ: 0 ANSI: 5 Jan 28 01:24:46.466663 kernel: hv_netvsc 00224878-3498-0022-4878-349800224878 eth0: VF slot 1 added Jan 28 01:24:46.485399 kernel: hv_vmbus: registering driver hv_pci Jan 28 01:24:46.485453 kernel: hv_pci a5a4ec51-593d-411d-a67c-dc4194180d2e: PCI VMBus probing: Using version 0x10004 Jan 28 01:24:46.494061 systemd[1]: systemd-vconsole-setup.service: Deactivated successfully. Jan 28 01:24:46.508030 kernel: hv_pci a5a4ec51-593d-411d-a67c-dc4194180d2e: PCI host bridge to bus 593d:00 Jan 28 01:24:46.508200 kernel: pci_bus 593d:00: root bus resource [mem 0xfc0000000-0xfc00fffff window] Jan 28 01:24:46.498685 systemd[1]: Stopped systemd-vconsole-setup.service - Virtual Console Setup. Jan 28 01:24:46.549464 kernel: pci_bus 593d:00: No busn resource found for root bus, will use [bus 00-ff] Jan 28 01:24:46.549627 kernel: pci 593d:00:02.0: [15b3:1018] type 00 class 0x020000 Jan 28 01:24:46.549652 kernel: pci 593d:00:02.0: reg 0x10: [mem 0xfc0000000-0xfc00fffff 64bit pref] Jan 28 01:24:46.549676 kernel: hv_utils: Registering HyperV Utility Driver Jan 28 01:24:46.549686 kernel: pci 593d:00:02.0: enabling Extended Tags Jan 28 01:24:46.518355 systemd[1]: Stopping systemd-vconsole-setup.service - Virtual Console Setup... Jan 28 01:24:46.571505 kernel: pci 593d:00:02.0: 0.000 Gb/s available PCIe bandwidth, limited by Unknown x0 link at 593d:00:02.0 (capable of 126.016 Gb/s with 8.0 GT/s PCIe x16 link) Jan 28 01:24:46.571681 kernel: pci_bus 593d:00: busn_res: [bus 00-ff] end is updated to 00 Jan 28 01:24:46.571768 kernel: hv_vmbus: registering driver hv_utils Jan 28 01:24:46.576785 kernel: pci 593d:00:02.0: BAR 0: assigned [mem 0xfc0000000-0xfc00fffff 64bit pref] Jan 28 01:24:46.578384 systemd[1]: Starting systemd-vconsole-setup.service - Virtual Console Setup... Jan 28 01:24:46.228808 kernel: hv_utils: Heartbeat IC version 3.0 Jan 28 01:24:46.245452 kernel: hv_utils: Shutdown IC version 3.2 Jan 28 01:24:46.245468 kernel: hv_utils: TimeSync IC version 4.0 Jan 28 01:24:46.245489 kernel: sr 0:0:0:2: [sr0] scsi-1 drive Jan 28 01:24:46.245650 systemd-journald[218]: Time jumped backwards, rotating. Jan 28 01:24:46.245686 kernel: cdrom: Uniform CD-ROM driver Revision: 3.20 Jan 28 01:24:46.221995 systemd-resolved[265]: Clock change detected. Flushing caches. Jan 28 01:24:46.257303 kernel: sr 0:0:0:2: Attached scsi CD-ROM sr0 Jan 28 01:24:46.226559 systemd[1]: Finished systemd-vconsole-setup.service - Virtual Console Setup. Jan 28 01:24:46.263399 systemd[1]: Starting dracut-cmdline-ask.service - dracut ask for additional cmdline parameters... Jan 28 01:24:46.287172 kernel: sd 0:0:0:0: [sda] 63737856 512-byte logical blocks: (32.6 GB/30.4 GiB) Jan 28 01:24:46.287371 kernel: sd 0:0:0:0: [sda] 4096-byte physical blocks Jan 28 01:24:46.298763 kernel: sd 0:0:0:0: [sda] Write Protect is off Jan 28 01:24:46.298970 kernel: sd 0:0:0:0: [sda] Mode Sense: 0f 00 10 00 Jan 28 01:24:46.299090 kernel: sd 0:0:0:0: [sda] Write cache: disabled, read cache: enabled, supports DPO and FUA Jan 28 01:24:46.309510 kernel: hv_storvsc f8b3781a-1e82-4818-a1c3-63d806ec15bb: tag#122 cmd 0x85 status: scsi 0x2 srb 0x6 hv 0xc0000001 Jan 28 01:24:46.317681 kernel: mlx5_core 593d:00:02.0: enabling device (0000 -> 0002) Jan 28 01:24:46.326656 kernel: mlx5_core 593d:00:02.0: firmware version: 16.30.5026 Jan 28 01:24:46.326878 kernel: sda: sda1 sda2 sda3 sda4 sda6 sda7 sda9 Jan 28 01:24:46.334503 kernel: sd 0:0:0:0: [sda] Attached SCSI disk Jan 28 01:24:46.344904 systemd[1]: Finished dracut-cmdline-ask.service - dracut ask for additional cmdline parameters. Jan 28 01:24:46.373499 kernel: hv_storvsc f8b3781a-1e82-4818-a1c3-63d806ec15bb: tag#114 cmd 0x85 status: scsi 0x2 srb 0x6 hv 0xc0000001 Jan 28 01:24:46.520913 kernel: hv_netvsc 00224878-3498-0022-4878-349800224878 eth0: VF registering: eth1 Jan 28 01:24:46.521114 kernel: mlx5_core 593d:00:02.0 eth1: joined to eth0 Jan 28 01:24:46.527513 kernel: mlx5_core 593d:00:02.0: MLX5E: StrdRq(1) RqSz(8) StrdSz(2048) RxCqeCmprss(0 basic) Jan 28 01:24:46.536500 kernel: mlx5_core 593d:00:02.0 enP22845s1: renamed from eth1 Jan 28 01:24:46.839755 systemd[1]: Found device dev-disk-by\x2dlabel-EFI\x2dSYSTEM.device - Virtual_Disk EFI-SYSTEM. Jan 28 01:24:46.883517 kernel: BTRFS: device label OEM devid 1 transid 10 /dev/sda6 scanned by (udev-worker) (498) Jan 28 01:24:46.897472 systemd[1]: Found device dev-disk-by\x2dlabel-OEM.device - Virtual_Disk OEM. Jan 28 01:24:46.919874 kernel: BTRFS: device fsid 0fc26676-8036-4cd5-8c30-2943afb25b0b devid 1 transid 36 /dev/sda3 scanned by (udev-worker) (483) Jan 28 01:24:46.929151 systemd[1]: Found device dev-disk-by\x2dlabel-ROOT.device - Virtual_Disk ROOT. Jan 28 01:24:46.940381 systemd[1]: Found device dev-disk-by\x2dpartlabel-USR\x2dA.device - Virtual_Disk USR-A. Jan 28 01:24:46.945944 systemd[1]: Found device dev-disk-by\x2dpartuuid-7130c94a\x2d213a\x2d4e5a\x2d8e26\x2d6cce9662f132.device - Virtual_Disk USR-A. Jan 28 01:24:46.974700 systemd[1]: Starting disk-uuid.service - Generate new UUID for disk GPT if necessary... Jan 28 01:24:47.001501 kernel: sda: sda1 sda2 sda3 sda4 sda6 sda7 sda9 Jan 28 01:24:47.009515 kernel: sda: sda1 sda2 sda3 sda4 sda6 sda7 sda9 Jan 28 01:24:48.021513 kernel: sda: sda1 sda2 sda3 sda4 sda6 sda7 sda9 Jan 28 01:24:48.021738 disk-uuid[605]: The operation has completed successfully. Jan 28 01:24:48.089927 systemd[1]: disk-uuid.service: Deactivated successfully. Jan 28 01:24:48.093731 systemd[1]: Finished disk-uuid.service - Generate new UUID for disk GPT if necessary. Jan 28 01:24:48.119598 systemd[1]: Starting verity-setup.service - Verity Setup for /dev/mapper/usr... Jan 28 01:24:48.129493 sh[718]: Success Jan 28 01:24:48.161495 kernel: device-mapper: verity: sha256 using implementation "sha256-ce" Jan 28 01:24:48.456462 systemd[1]: Found device dev-mapper-usr.device - /dev/mapper/usr. Jan 28 01:24:48.474599 systemd[1]: Mounting sysusr-usr.mount - /sysusr/usr... Jan 28 01:24:48.482413 systemd[1]: Finished verity-setup.service - Verity Setup for /dev/mapper/usr. Jan 28 01:24:48.512989 kernel: BTRFS info (device dm-0): first mount of filesystem 0fc26676-8036-4cd5-8c30-2943afb25b0b Jan 28 01:24:48.513040 kernel: BTRFS info (device dm-0): using crc32c (crc32c-generic) checksum algorithm Jan 28 01:24:48.518515 kernel: BTRFS warning (device dm-0): 'nologreplay' is deprecated, use 'rescue=nologreplay' instead Jan 28 01:24:48.522690 kernel: BTRFS info (device dm-0): disabling log replay at mount time Jan 28 01:24:48.526106 kernel: BTRFS info (device dm-0): using free space tree Jan 28 01:24:48.840179 systemd[1]: Mounted sysusr-usr.mount - /sysusr/usr. Jan 28 01:24:48.844737 systemd[1]: afterburn-network-kargs.service - Afterburn Initrd Setup Network Kernel Arguments was skipped because no trigger condition checks were met. Jan 28 01:24:48.860666 systemd[1]: Starting ignition-setup.service - Ignition (setup)... Jan 28 01:24:48.869888 systemd[1]: Starting parse-ip-for-networkd.service - Write systemd-networkd units from cmdline... Jan 28 01:24:48.892062 kernel: BTRFS info (device sda6): first mount of filesystem 11ff68ea-4313-40eb-9d5c-ba27cd060334 Jan 28 01:24:48.892094 kernel: BTRFS info (device sda6): using crc32c (crc32c-generic) checksum algorithm Jan 28 01:24:48.895302 kernel: BTRFS info (device sda6): using free space tree Jan 28 01:24:48.930721 kernel: BTRFS info (device sda6): auto enabling async discard Jan 28 01:24:48.939989 systemd[1]: mnt-oem.mount: Deactivated successfully. Jan 28 01:24:48.951555 kernel: BTRFS info (device sda6): last unmount of filesystem 11ff68ea-4313-40eb-9d5c-ba27cd060334 Jan 28 01:24:48.963507 systemd[1]: Finished ignition-setup.service - Ignition (setup). Jan 28 01:24:48.976915 systemd[1]: Starting ignition-fetch-offline.service - Ignition (fetch-offline)... Jan 28 01:24:49.010516 systemd[1]: Finished parse-ip-for-networkd.service - Write systemd-networkd units from cmdline. Jan 28 01:24:49.025613 systemd[1]: Starting systemd-networkd.service - Network Configuration... Jan 28 01:24:49.051785 systemd-networkd[902]: lo: Link UP Jan 28 01:24:49.051793 systemd-networkd[902]: lo: Gained carrier Jan 28 01:24:49.053748 systemd-networkd[902]: Enumeration completed Jan 28 01:24:49.054625 systemd[1]: Started systemd-networkd.service - Network Configuration. Jan 28 01:24:49.054980 systemd-networkd[902]: eth0: found matching network '/usr/lib/systemd/network/zz-default.network', based on potentially unpredictable interface name. Jan 28 01:24:49.054983 systemd-networkd[902]: eth0: Configuring with /usr/lib/systemd/network/zz-default.network. Jan 28 01:24:49.062691 systemd[1]: Reached target network.target - Network. Jan 28 01:24:49.135501 kernel: mlx5_core 593d:00:02.0 enP22845s1: Link up Jan 28 01:24:49.177501 kernel: hv_netvsc 00224878-3498-0022-4878-349800224878 eth0: Data path switched to VF: enP22845s1 Jan 28 01:24:49.177859 systemd-networkd[902]: enP22845s1: Link UP Jan 28 01:24:49.178089 systemd-networkd[902]: eth0: Link UP Jan 28 01:24:49.178499 systemd-networkd[902]: eth0: Gained carrier Jan 28 01:24:49.178508 systemd-networkd[902]: eth0: found matching network '/usr/lib/systemd/network/zz-default.network', based on potentially unpredictable interface name. Jan 28 01:24:49.188988 systemd-networkd[902]: enP22845s1: Gained carrier Jan 28 01:24:49.204534 systemd-networkd[902]: eth0: DHCPv4 address 10.200.20.29/24, gateway 10.200.20.1 acquired from 168.63.129.16 Jan 28 01:24:49.958858 ignition[862]: Ignition 2.19.0 Jan 28 01:24:49.958867 ignition[862]: Stage: fetch-offline Jan 28 01:24:49.962697 systemd[1]: Finished ignition-fetch-offline.service - Ignition (fetch-offline). Jan 28 01:24:49.958909 ignition[862]: no configs at "/usr/lib/ignition/base.d" Jan 28 01:24:49.958917 ignition[862]: no config dir at "/usr/lib/ignition/base.platform.d/azure" Jan 28 01:24:49.959013 ignition[862]: parsed url from cmdline: "" Jan 28 01:24:49.959017 ignition[862]: no config URL provided Jan 28 01:24:49.959027 ignition[862]: reading system config file "/usr/lib/ignition/user.ign" Jan 28 01:24:49.985700 systemd[1]: Starting ignition-fetch.service - Ignition (fetch)... Jan 28 01:24:49.959034 ignition[862]: no config at "/usr/lib/ignition/user.ign" Jan 28 01:24:49.959039 ignition[862]: failed to fetch config: resource requires networking Jan 28 01:24:49.959464 ignition[862]: Ignition finished successfully Jan 28 01:24:50.003902 ignition[912]: Ignition 2.19.0 Jan 28 01:24:50.003908 ignition[912]: Stage: fetch Jan 28 01:24:50.004105 ignition[912]: no configs at "/usr/lib/ignition/base.d" Jan 28 01:24:50.004117 ignition[912]: no config dir at "/usr/lib/ignition/base.platform.d/azure" Jan 28 01:24:50.004220 ignition[912]: parsed url from cmdline: "" Jan 28 01:24:50.004223 ignition[912]: no config URL provided Jan 28 01:24:50.004228 ignition[912]: reading system config file "/usr/lib/ignition/user.ign" Jan 28 01:24:50.004234 ignition[912]: no config at "/usr/lib/ignition/user.ign" Jan 28 01:24:50.004258 ignition[912]: GET http://169.254.169.254/metadata/instance/compute/userData?api-version=2021-01-01&format=text: attempt #1 Jan 28 01:24:50.106632 ignition[912]: GET result: OK Jan 28 01:24:50.106672 ignition[912]: config has been read from IMDS userdata Jan 28 01:24:50.106683 ignition[912]: parsing config with SHA512: eeb8c19711d5009d49d9e22cc3ede4842b4a5b97816ffef3992b9bd007279fb01df67a7f2ee3abceccd03bc3f3af645b3a1fe5c2a1fb214cbcb6c8e5268c20cf Jan 28 01:24:50.110152 unknown[912]: fetched base config from "system" Jan 28 01:24:50.110331 ignition[912]: fetch: fetch complete Jan 28 01:24:50.110159 unknown[912]: fetched base config from "system" Jan 28 01:24:50.110335 ignition[912]: fetch: fetch passed Jan 28 01:24:50.110165 unknown[912]: fetched user config from "azure" Jan 28 01:24:50.110379 ignition[912]: Ignition finished successfully Jan 28 01:24:50.117279 systemd[1]: Finished ignition-fetch.service - Ignition (fetch). Jan 28 01:24:50.134735 systemd[1]: Starting ignition-kargs.service - Ignition (kargs)... Jan 28 01:24:50.152158 ignition[919]: Ignition 2.19.0 Jan 28 01:24:50.152164 ignition[919]: Stage: kargs Jan 28 01:24:50.152328 ignition[919]: no configs at "/usr/lib/ignition/base.d" Jan 28 01:24:50.157796 systemd[1]: Finished ignition-kargs.service - Ignition (kargs). Jan 28 01:24:50.152340 ignition[919]: no config dir at "/usr/lib/ignition/base.platform.d/azure" Jan 28 01:24:50.153073 ignition[919]: kargs: kargs passed Jan 28 01:24:50.153116 ignition[919]: Ignition finished successfully Jan 28 01:24:50.183836 systemd[1]: Starting ignition-disks.service - Ignition (disks)... Jan 28 01:24:50.195824 ignition[926]: Ignition 2.19.0 Jan 28 01:24:50.195834 ignition[926]: Stage: disks Jan 28 01:24:50.198978 systemd[1]: Finished ignition-disks.service - Ignition (disks). Jan 28 01:24:50.196018 ignition[926]: no configs at "/usr/lib/ignition/base.d" Jan 28 01:24:50.204359 systemd[1]: Reached target initrd-root-device.target - Initrd Root Device. Jan 28 01:24:50.196027 ignition[926]: no config dir at "/usr/lib/ignition/base.platform.d/azure" Jan 28 01:24:50.211595 systemd[1]: Reached target local-fs-pre.target - Preparation for Local File Systems. Jan 28 01:24:50.196682 ignition[926]: disks: disks passed Jan 28 01:24:50.220955 systemd[1]: Reached target local-fs.target - Local File Systems. Jan 28 01:24:50.196724 ignition[926]: Ignition finished successfully Jan 28 01:24:50.228905 systemd[1]: Reached target sysinit.target - System Initialization. Jan 28 01:24:50.237333 systemd[1]: Reached target basic.target - Basic System. Jan 28 01:24:50.258704 systemd[1]: Starting systemd-fsck-root.service - File System Check on /dev/disk/by-label/ROOT... Jan 28 01:24:50.330649 systemd-fsck[934]: ROOT: clean, 14/7326000 files, 477710/7359488 blocks Jan 28 01:24:50.336941 systemd[1]: Finished systemd-fsck-root.service - File System Check on /dev/disk/by-label/ROOT. Jan 28 01:24:50.354655 systemd[1]: Mounting sysroot.mount - /sysroot... Jan 28 01:24:50.416489 kernel: EXT4-fs (sda9): mounted filesystem 2c7419f5-3bc3-4c5f-b132-f03585db88cd r/w with ordered data mode. Quota mode: none. Jan 28 01:24:50.416972 systemd[1]: Mounted sysroot.mount - /sysroot. Jan 28 01:24:50.420831 systemd[1]: Reached target initrd-root-fs.target - Initrd Root File System. Jan 28 01:24:50.462569 systemd[1]: Mounting sysroot-oem.mount - /sysroot/oem... Jan 28 01:24:50.480492 kernel: BTRFS: device label OEM devid 1 transid 11 /dev/sda6 scanned by mount (945) Jan 28 01:24:50.490399 kernel: BTRFS info (device sda6): first mount of filesystem 11ff68ea-4313-40eb-9d5c-ba27cd060334 Jan 28 01:24:50.490428 kernel: BTRFS info (device sda6): using crc32c (crc32c-generic) checksum algorithm Jan 28 01:24:50.494101 kernel: BTRFS info (device sda6): using free space tree Jan 28 01:24:50.497649 systemd[1]: Mounting sysroot-usr.mount - /sysroot/usr... Jan 28 01:24:50.508021 kernel: BTRFS info (device sda6): auto enabling async discard Jan 28 01:24:50.509325 systemd[1]: Starting flatcar-metadata-hostname.service - Flatcar Metadata Hostname Agent... Jan 28 01:24:50.519455 systemd[1]: ignition-remount-sysroot.service - Remount /sysroot read-write for Ignition was skipped because of an unmet condition check (ConditionPathIsReadWrite=!/sysroot). Jan 28 01:24:50.525569 systemd[1]: Reached target ignition-diskful.target - Ignition Boot Disk Setup. Jan 28 01:24:50.535092 systemd[1]: Mounted sysroot-oem.mount - /sysroot/oem. Jan 28 01:24:50.542963 systemd[1]: Mounted sysroot-usr.mount - /sysroot/usr. Jan 28 01:24:50.559740 systemd[1]: Starting initrd-setup-root.service - Root filesystem setup... Jan 28 01:24:51.045678 systemd-networkd[902]: eth0: Gained IPv6LL Jan 28 01:24:51.162607 coreos-metadata[962]: Jan 28 01:24:51.162 INFO Fetching http://168.63.129.16/?comp=versions: Attempt #1 Jan 28 01:24:51.170574 coreos-metadata[962]: Jan 28 01:24:51.170 INFO Fetch successful Jan 28 01:24:51.174966 coreos-metadata[962]: Jan 28 01:24:51.174 INFO Fetching http://169.254.169.254/metadata/instance/compute/name?api-version=2017-08-01&format=text: Attempt #1 Jan 28 01:24:51.191649 coreos-metadata[962]: Jan 28 01:24:51.191 INFO Fetch successful Jan 28 01:24:51.222485 coreos-metadata[962]: Jan 28 01:24:51.222 INFO wrote hostname ci-4081.3.6-n-eb37c95875 to /sysroot/etc/hostname Jan 28 01:24:51.230503 systemd[1]: Finished flatcar-metadata-hostname.service - Flatcar Metadata Hostname Agent. Jan 28 01:24:51.362013 initrd-setup-root[975]: cut: /sysroot/etc/passwd: No such file or directory Jan 28 01:24:51.402852 initrd-setup-root[982]: cut: /sysroot/etc/group: No such file or directory Jan 28 01:24:51.438233 initrd-setup-root[989]: cut: /sysroot/etc/shadow: No such file or directory Jan 28 01:24:51.461944 initrd-setup-root[996]: cut: /sysroot/etc/gshadow: No such file or directory Jan 28 01:24:52.567209 systemd[1]: Finished initrd-setup-root.service - Root filesystem setup. Jan 28 01:24:52.583683 systemd[1]: Starting ignition-mount.service - Ignition (mount)... Jan 28 01:24:52.596669 systemd[1]: Starting sysroot-boot.service - /sysroot/boot... Jan 28 01:24:52.612297 kernel: BTRFS info (device sda6): last unmount of filesystem 11ff68ea-4313-40eb-9d5c-ba27cd060334 Jan 28 01:24:52.606958 systemd[1]: sysroot-oem.mount: Deactivated successfully. Jan 28 01:24:52.630115 ignition[1064]: INFO : Ignition 2.19.0 Jan 28 01:24:52.630115 ignition[1064]: INFO : Stage: mount Jan 28 01:24:52.637693 ignition[1064]: INFO : no configs at "/usr/lib/ignition/base.d" Jan 28 01:24:52.637693 ignition[1064]: INFO : no config dir at "/usr/lib/ignition/base.platform.d/azure" Jan 28 01:24:52.637693 ignition[1064]: INFO : mount: mount passed Jan 28 01:24:52.637693 ignition[1064]: INFO : Ignition finished successfully Jan 28 01:24:52.637531 systemd[1]: Finished ignition-mount.service - Ignition (mount). Jan 28 01:24:52.658655 systemd[1]: Starting ignition-files.service - Ignition (files)... Jan 28 01:24:52.669044 systemd[1]: Finished sysroot-boot.service - /sysroot/boot. Jan 28 01:24:52.679715 systemd[1]: Mounting sysroot-oem.mount - /sysroot/oem... Jan 28 01:24:52.705559 kernel: BTRFS: device label OEM devid 1 transid 12 /dev/sda6 scanned by mount (1075) Jan 28 01:24:52.716044 kernel: BTRFS info (device sda6): first mount of filesystem 11ff68ea-4313-40eb-9d5c-ba27cd060334 Jan 28 01:24:52.716075 kernel: BTRFS info (device sda6): using crc32c (crc32c-generic) checksum algorithm Jan 28 01:24:52.719344 kernel: BTRFS info (device sda6): using free space tree Jan 28 01:24:52.727501 kernel: BTRFS info (device sda6): auto enabling async discard Jan 28 01:24:52.727750 systemd[1]: Mounted sysroot-oem.mount - /sysroot/oem. Jan 28 01:24:52.755028 ignition[1092]: INFO : Ignition 2.19.0 Jan 28 01:24:52.755028 ignition[1092]: INFO : Stage: files Jan 28 01:24:52.761226 ignition[1092]: INFO : no configs at "/usr/lib/ignition/base.d" Jan 28 01:24:52.761226 ignition[1092]: INFO : no config dir at "/usr/lib/ignition/base.platform.d/azure" Jan 28 01:24:52.761226 ignition[1092]: DEBUG : files: compiled without relabeling support, skipping Jan 28 01:24:52.761226 ignition[1092]: INFO : files: ensureUsers: op(1): [started] creating or modifying user "core" Jan 28 01:24:52.761226 ignition[1092]: DEBUG : files: ensureUsers: op(1): executing: "usermod" "--root" "/sysroot" "core" Jan 28 01:24:52.832653 ignition[1092]: INFO : files: ensureUsers: op(1): [finished] creating or modifying user "core" Jan 28 01:24:52.838584 ignition[1092]: INFO : files: ensureUsers: op(2): [started] adding ssh keys to user "core" Jan 28 01:24:52.838584 ignition[1092]: INFO : files: ensureUsers: op(2): [finished] adding ssh keys to user "core" Jan 28 01:24:52.833045 unknown[1092]: wrote ssh authorized keys file for user: core Jan 28 01:24:52.862653 ignition[1092]: INFO : files: createFilesystemsFiles: createFiles: op(3): [started] writing file "/sysroot/etc/flatcar/update.conf" Jan 28 01:24:52.871259 ignition[1092]: INFO : files: createFilesystemsFiles: createFiles: op(3): [finished] writing file "/sysroot/etc/flatcar/update.conf" Jan 28 01:24:52.871259 ignition[1092]: INFO : files: createResultFile: createFiles: op(4): [started] writing file "/sysroot/etc/.ignition-result.json" Jan 28 01:24:52.871259 ignition[1092]: INFO : files: createResultFile: createFiles: op(4): [finished] writing file "/sysroot/etc/.ignition-result.json" Jan 28 01:24:52.871259 ignition[1092]: INFO : files: files passed Jan 28 01:24:52.871259 ignition[1092]: INFO : Ignition finished successfully Jan 28 01:24:52.875824 systemd[1]: Finished ignition-files.service - Ignition (files). Jan 28 01:24:52.904758 systemd[1]: Starting ignition-quench.service - Ignition (record completion)... Jan 28 01:24:52.916672 systemd[1]: Starting initrd-setup-root-after-ignition.service - Root filesystem completion... Jan 28 01:24:52.925390 systemd[1]: ignition-quench.service: Deactivated successfully. Jan 28 01:24:52.925521 systemd[1]: Finished ignition-quench.service - Ignition (record completion). Jan 28 01:24:52.959642 initrd-setup-root-after-ignition[1120]: grep: /sysroot/etc/flatcar/enabled-sysext.conf: No such file or directory Jan 28 01:24:52.959642 initrd-setup-root-after-ignition[1120]: grep: /sysroot/usr/share/flatcar/enabled-sysext.conf: No such file or directory Jan 28 01:24:52.974161 initrd-setup-root-after-ignition[1124]: grep: /sysroot/etc/flatcar/enabled-sysext.conf: No such file or directory Jan 28 01:24:52.968390 systemd[1]: Finished initrd-setup-root-after-ignition.service - Root filesystem completion. Jan 28 01:24:52.979640 systemd[1]: Reached target ignition-complete.target - Ignition Complete. Jan 28 01:24:53.002646 systemd[1]: Starting initrd-parse-etc.service - Mountpoints Configured in the Real Root... Jan 28 01:24:53.030373 systemd[1]: initrd-parse-etc.service: Deactivated successfully. Jan 28 01:24:53.032534 systemd[1]: Finished initrd-parse-etc.service - Mountpoints Configured in the Real Root. Jan 28 01:24:53.040359 systemd[1]: Reached target initrd-fs.target - Initrd File Systems. Jan 28 01:24:53.050657 systemd[1]: Reached target initrd.target - Initrd Default Target. Jan 28 01:24:53.059397 systemd[1]: dracut-mount.service - dracut mount hook was skipped because no trigger condition checks were met. Jan 28 01:24:53.073713 systemd[1]: Starting dracut-pre-pivot.service - dracut pre-pivot and cleanup hook... Jan 28 01:24:53.085804 systemd[1]: Finished dracut-pre-pivot.service - dracut pre-pivot and cleanup hook. Jan 28 01:24:53.107632 systemd[1]: Starting initrd-cleanup.service - Cleaning Up and Shutting Down Daemons... Jan 28 01:24:53.124840 systemd[1]: Stopped target nss-lookup.target - Host and Network Name Lookups. Jan 28 01:24:53.135721 systemd[1]: Stopped target remote-cryptsetup.target - Remote Encrypted Volumes. Jan 28 01:24:53.141300 systemd[1]: Stopped target timers.target - Timer Units. Jan 28 01:24:53.150140 systemd[1]: dracut-pre-pivot.service: Deactivated successfully. Jan 28 01:24:53.150313 systemd[1]: Stopped dracut-pre-pivot.service - dracut pre-pivot and cleanup hook. Jan 28 01:24:53.163423 systemd[1]: Stopped target initrd.target - Initrd Default Target. Jan 28 01:24:53.172781 systemd[1]: Stopped target basic.target - Basic System. Jan 28 01:24:53.181189 systemd[1]: Stopped target ignition-complete.target - Ignition Complete. Jan 28 01:24:53.189715 systemd[1]: Stopped target ignition-diskful.target - Ignition Boot Disk Setup. Jan 28 01:24:53.198880 systemd[1]: Stopped target initrd-root-device.target - Initrd Root Device. Jan 28 01:24:53.208402 systemd[1]: Stopped target remote-fs.target - Remote File Systems. Jan 28 01:24:53.217228 systemd[1]: Stopped target remote-fs-pre.target - Preparation for Remote File Systems. Jan 28 01:24:53.227412 systemd[1]: Stopped target sysinit.target - System Initialization. Jan 28 01:24:53.237124 systemd[1]: Stopped target local-fs.target - Local File Systems. Jan 28 01:24:53.245129 systemd[1]: Stopped target swap.target - Swaps. Jan 28 01:24:53.252666 systemd[1]: dracut-pre-mount.service: Deactivated successfully. Jan 28 01:24:53.252836 systemd[1]: Stopped dracut-pre-mount.service - dracut pre-mount hook. Jan 28 01:24:53.264896 systemd[1]: Stopped target cryptsetup.target - Local Encrypted Volumes. Jan 28 01:24:53.274401 systemd[1]: Stopped target cryptsetup-pre.target - Local Encrypted Volumes (Pre). Jan 28 01:24:53.283893 systemd[1]: clevis-luks-askpass.path: Deactivated successfully. Jan 28 01:24:53.284001 systemd[1]: Stopped clevis-luks-askpass.path - Forward Password Requests to Clevis Directory Watch. Jan 28 01:24:53.293730 systemd[1]: dracut-initqueue.service: Deactivated successfully. Jan 28 01:24:53.293901 systemd[1]: Stopped dracut-initqueue.service - dracut initqueue hook. Jan 28 01:24:53.308144 systemd[1]: initrd-setup-root-after-ignition.service: Deactivated successfully. Jan 28 01:24:53.308308 systemd[1]: Stopped initrd-setup-root-after-ignition.service - Root filesystem completion. Jan 28 01:24:53.317822 systemd[1]: ignition-files.service: Deactivated successfully. Jan 28 01:24:53.317963 systemd[1]: Stopped ignition-files.service - Ignition (files). Jan 28 01:24:53.327074 systemd[1]: flatcar-metadata-hostname.service: Deactivated successfully. Jan 28 01:24:53.327224 systemd[1]: Stopped flatcar-metadata-hostname.service - Flatcar Metadata Hostname Agent. Jan 28 01:24:53.354606 systemd[1]: Stopping ignition-mount.service - Ignition (mount)... Jan 28 01:24:53.368937 systemd[1]: Stopping sysroot-boot.service - /sysroot/boot... Jan 28 01:24:53.390952 ignition[1144]: INFO : Ignition 2.19.0 Jan 28 01:24:53.390952 ignition[1144]: INFO : Stage: umount Jan 28 01:24:53.390952 ignition[1144]: INFO : no configs at "/usr/lib/ignition/base.d" Jan 28 01:24:53.390952 ignition[1144]: INFO : no config dir at "/usr/lib/ignition/base.platform.d/azure" Jan 28 01:24:53.390952 ignition[1144]: INFO : umount: umount passed Jan 28 01:24:53.390952 ignition[1144]: INFO : Ignition finished successfully Jan 28 01:24:53.378883 systemd[1]: systemd-udev-trigger.service: Deactivated successfully. Jan 28 01:24:53.379051 systemd[1]: Stopped systemd-udev-trigger.service - Coldplug All udev Devices. Jan 28 01:24:53.389801 systemd[1]: dracut-pre-trigger.service: Deactivated successfully. Jan 28 01:24:53.389969 systemd[1]: Stopped dracut-pre-trigger.service - dracut pre-trigger hook. Jan 28 01:24:53.402509 systemd[1]: sysroot-boot.mount: Deactivated successfully. Jan 28 01:24:53.403340 systemd[1]: ignition-mount.service: Deactivated successfully. Jan 28 01:24:53.403441 systemd[1]: Stopped ignition-mount.service - Ignition (mount). Jan 28 01:24:53.414631 systemd[1]: initrd-cleanup.service: Deactivated successfully. Jan 28 01:24:53.414735 systemd[1]: Finished initrd-cleanup.service - Cleaning Up and Shutting Down Daemons. Jan 28 01:24:53.422941 systemd[1]: ignition-disks.service: Deactivated successfully. Jan 28 01:24:53.423013 systemd[1]: Stopped ignition-disks.service - Ignition (disks). Jan 28 01:24:53.434020 systemd[1]: ignition-kargs.service: Deactivated successfully. Jan 28 01:24:53.434079 systemd[1]: Stopped ignition-kargs.service - Ignition (kargs). Jan 28 01:24:53.438452 systemd[1]: ignition-fetch.service: Deactivated successfully. Jan 28 01:24:53.438495 systemd[1]: Stopped ignition-fetch.service - Ignition (fetch). Jan 28 01:24:53.447018 systemd[1]: Stopped target network.target - Network. Jan 28 01:24:53.455504 systemd[1]: ignition-fetch-offline.service: Deactivated successfully. Jan 28 01:24:53.455562 systemd[1]: Stopped ignition-fetch-offline.service - Ignition (fetch-offline). Jan 28 01:24:53.464558 systemd[1]: Stopped target paths.target - Path Units. Jan 28 01:24:53.472829 systemd[1]: systemd-ask-password-console.path: Deactivated successfully. Jan 28 01:24:53.476503 systemd[1]: Stopped systemd-ask-password-console.path - Dispatch Password Requests to Console Directory Watch. Jan 28 01:24:53.485654 systemd[1]: Stopped target slices.target - Slice Units. Jan 28 01:24:53.493337 systemd[1]: Stopped target sockets.target - Socket Units. Jan 28 01:24:53.501173 systemd[1]: iscsid.socket: Deactivated successfully. Jan 28 01:24:53.501219 systemd[1]: Closed iscsid.socket - Open-iSCSI iscsid Socket. Jan 28 01:24:53.510263 systemd[1]: iscsiuio.socket: Deactivated successfully. Jan 28 01:24:53.510296 systemd[1]: Closed iscsiuio.socket - Open-iSCSI iscsiuio Socket. Jan 28 01:24:53.518753 systemd[1]: ignition-setup.service: Deactivated successfully. Jan 28 01:24:53.518796 systemd[1]: Stopped ignition-setup.service - Ignition (setup). Jan 28 01:24:53.527189 systemd[1]: ignition-setup-pre.service: Deactivated successfully. Jan 28 01:24:53.527222 systemd[1]: Stopped ignition-setup-pre.service - Ignition env setup. Jan 28 01:24:53.535726 systemd[1]: Stopping systemd-networkd.service - Network Configuration... Jan 28 01:24:53.543971 systemd[1]: Stopping systemd-resolved.service - Network Name Resolution... Jan 28 01:24:53.551996 systemd-networkd[902]: eth0: DHCPv6 lease lost Jan 28 01:24:53.553620 systemd[1]: systemd-networkd.service: Deactivated successfully. Jan 28 01:24:53.553718 systemd[1]: Stopped systemd-networkd.service - Network Configuration. Jan 28 01:24:53.563621 systemd[1]: systemd-resolved.service: Deactivated successfully. Jan 28 01:24:53.563717 systemd[1]: Stopped systemd-resolved.service - Network Name Resolution. Jan 28 01:24:53.743892 kernel: hv_netvsc 00224878-3498-0022-4878-349800224878 eth0: Data path switched from VF: enP22845s1 Jan 28 01:24:53.572769 systemd[1]: sysroot-boot.service: Deactivated successfully. Jan 28 01:24:53.572902 systemd[1]: Stopped sysroot-boot.service - /sysroot/boot. Jan 28 01:24:53.581358 systemd[1]: systemd-networkd.socket: Deactivated successfully. Jan 28 01:24:53.581436 systemd[1]: Closed systemd-networkd.socket - Network Service Netlink Socket. Jan 28 01:24:53.590170 systemd[1]: initrd-setup-root.service: Deactivated successfully. Jan 28 01:24:53.590229 systemd[1]: Stopped initrd-setup-root.service - Root filesystem setup. Jan 28 01:24:53.613692 systemd[1]: Stopping network-cleanup.service - Network Cleanup... Jan 28 01:24:53.621469 systemd[1]: parse-ip-for-networkd.service: Deactivated successfully. Jan 28 01:24:53.621545 systemd[1]: Stopped parse-ip-for-networkd.service - Write systemd-networkd units from cmdline. Jan 28 01:24:53.630445 systemd[1]: systemd-sysctl.service: Deactivated successfully. Jan 28 01:24:53.630542 systemd[1]: Stopped systemd-sysctl.service - Apply Kernel Variables. Jan 28 01:24:53.638783 systemd[1]: systemd-modules-load.service: Deactivated successfully. Jan 28 01:24:53.638825 systemd[1]: Stopped systemd-modules-load.service - Load Kernel Modules. Jan 28 01:24:53.647641 systemd[1]: systemd-tmpfiles-setup.service: Deactivated successfully. Jan 28 01:24:53.647685 systemd[1]: Stopped systemd-tmpfiles-setup.service - Create System Files and Directories. Jan 28 01:24:53.657607 systemd[1]: Stopping systemd-udevd.service - Rule-based Manager for Device Events and Files... Jan 28 01:24:53.695239 systemd[1]: systemd-udevd.service: Deactivated successfully. Jan 28 01:24:53.695415 systemd[1]: Stopped systemd-udevd.service - Rule-based Manager for Device Events and Files. Jan 28 01:24:53.704238 systemd[1]: systemd-udevd-control.socket: Deactivated successfully. Jan 28 01:24:53.704281 systemd[1]: Closed systemd-udevd-control.socket - udev Control Socket. Jan 28 01:24:53.713017 systemd[1]: systemd-udevd-kernel.socket: Deactivated successfully. Jan 28 01:24:53.713046 systemd[1]: Closed systemd-udevd-kernel.socket - udev Kernel Socket. Jan 28 01:24:53.723073 systemd[1]: dracut-pre-udev.service: Deactivated successfully. Jan 28 01:24:53.723118 systemd[1]: Stopped dracut-pre-udev.service - dracut pre-udev hook. Jan 28 01:24:53.743983 systemd[1]: dracut-cmdline.service: Deactivated successfully. Jan 28 01:24:53.744044 systemd[1]: Stopped dracut-cmdline.service - dracut cmdline hook. Jan 28 01:24:53.753592 systemd[1]: dracut-cmdline-ask.service: Deactivated successfully. Jan 28 01:24:53.753646 systemd[1]: Stopped dracut-cmdline-ask.service - dracut ask for additional cmdline parameters. Jan 28 01:24:53.778670 systemd[1]: Starting initrd-udevadm-cleanup-db.service - Cleanup udev Database... Jan 28 01:24:53.791551 systemd[1]: systemd-tmpfiles-setup-dev.service: Deactivated successfully. Jan 28 01:24:53.791623 systemd[1]: Stopped systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev. Jan 28 01:24:53.806957 systemd[1]: systemd-tmpfiles-setup-dev-early.service: Deactivated successfully. Jan 28 01:24:53.807018 systemd[1]: Stopped systemd-tmpfiles-setup-dev-early.service - Create Static Device Nodes in /dev gracefully. Jan 28 01:24:53.818516 systemd[1]: kmod-static-nodes.service: Deactivated successfully. Jan 28 01:24:53.818565 systemd[1]: Stopped kmod-static-nodes.service - Create List of Static Device Nodes. Jan 28 01:24:53.827667 systemd[1]: systemd-vconsole-setup.service: Deactivated successfully. Jan 28 01:24:53.827706 systemd[1]: Stopped systemd-vconsole-setup.service - Virtual Console Setup. Jan 28 01:24:53.837532 systemd[1]: network-cleanup.service: Deactivated successfully. Jan 28 01:24:53.996219 systemd-journald[218]: Received SIGTERM from PID 1 (systemd). Jan 28 01:24:53.837641 systemd[1]: Stopped network-cleanup.service - Network Cleanup. Jan 28 01:24:53.846043 systemd[1]: initrd-udevadm-cleanup-db.service: Deactivated successfully. Jan 28 01:24:53.846131 systemd[1]: Finished initrd-udevadm-cleanup-db.service - Cleanup udev Database. Jan 28 01:24:53.856236 systemd[1]: Reached target initrd-switch-root.target - Switch Root. Jan 28 01:24:53.881706 systemd[1]: Starting initrd-switch-root.service - Switch Root... Jan 28 01:24:53.916366 systemd[1]: Switching root. Jan 28 01:24:54.022173 systemd-journald[218]: Journal stopped Jan 28 01:24:59.038094 kernel: SELinux: policy capability network_peer_controls=1 Jan 28 01:24:59.038117 kernel: SELinux: policy capability open_perms=1 Jan 28 01:24:59.038127 kernel: SELinux: policy capability extended_socket_class=1 Jan 28 01:24:59.038135 kernel: SELinux: policy capability always_check_network=0 Jan 28 01:24:59.038145 kernel: SELinux: policy capability cgroup_seclabel=1 Jan 28 01:24:59.038153 kernel: SELinux: policy capability nnp_nosuid_transition=1 Jan 28 01:24:59.038163 kernel: SELinux: policy capability genfs_seclabel_symlinks=0 Jan 28 01:24:59.038171 kernel: SELinux: policy capability ioctl_skip_cloexec=0 Jan 28 01:24:59.038180 kernel: audit: type=1403 audit(1769563495.260:2): auid=4294967295 ses=4294967295 lsm=selinux res=1 Jan 28 01:24:59.038192 systemd[1]: Successfully loaded SELinux policy in 191.406ms. Jan 28 01:24:59.038204 systemd[1]: Relabeled /dev, /dev/shm, /run, /sys/fs/cgroup in 10.242ms. Jan 28 01:24:59.038215 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 28 01:24:59.038224 systemd[1]: Detected virtualization microsoft. Jan 28 01:24:59.038232 systemd[1]: Detected architecture arm64. Jan 28 01:24:59.038242 systemd[1]: Detected first boot. Jan 28 01:24:59.038253 systemd[1]: Hostname set to . Jan 28 01:24:59.038262 systemd[1]: Initializing machine ID from random generator. Jan 28 01:24:59.038272 zram_generator::config[1185]: No configuration found. Jan 28 01:24:59.038281 systemd[1]: Populated /etc with preset unit settings. Jan 28 01:24:59.038290 systemd[1]: initrd-switch-root.service: Deactivated successfully. Jan 28 01:24:59.038300 systemd[1]: Stopped initrd-switch-root.service - Switch Root. Jan 28 01:24:59.038309 systemd[1]: systemd-journald.service: Scheduled restart job, restart counter is at 1. Jan 28 01:24:59.038320 systemd[1]: Created slice system-addon\x2dconfig.slice - Slice /system/addon-config. Jan 28 01:24:59.038330 systemd[1]: Created slice system-addon\x2drun.slice - Slice /system/addon-run. Jan 28 01:24:59.038340 systemd[1]: Created slice system-getty.slice - Slice /system/getty. Jan 28 01:24:59.038349 systemd[1]: Created slice system-modprobe.slice - Slice /system/modprobe. Jan 28 01:24:59.038359 systemd[1]: Created slice system-serial\x2dgetty.slice - Slice /system/serial-getty. Jan 28 01:24:59.038369 systemd[1]: Created slice system-system\x2dcloudinit.slice - Slice /system/system-cloudinit. Jan 28 01:24:59.038378 systemd[1]: Created slice system-systemd\x2dfsck.slice - Slice /system/systemd-fsck. Jan 28 01:24:59.038390 systemd[1]: Created slice user.slice - User and Session Slice. Jan 28 01:24:59.038400 systemd[1]: Started clevis-luks-askpass.path - Forward Password Requests to Clevis Directory Watch. Jan 28 01:24:59.038410 systemd[1]: Started systemd-ask-password-console.path - Dispatch Password Requests to Console Directory Watch. Jan 28 01:24:59.038419 systemd[1]: Started systemd-ask-password-wall.path - Forward Password Requests to Wall Directory Watch. Jan 28 01:24:59.038429 systemd[1]: Set up automount boot.automount - Boot partition Automount Point. Jan 28 01:24:59.038439 systemd[1]: Set up automount proc-sys-fs-binfmt_misc.automount - Arbitrary Executable File Formats File System Automount Point. Jan 28 01:24:59.038448 systemd[1]: Expecting device dev-disk-by\x2dlabel-OEM.device - /dev/disk/by-label/OEM... Jan 28 01:24:59.038458 systemd[1]: Expecting device dev-ttyAMA0.device - /dev/ttyAMA0... Jan 28 01:24:59.038469 systemd[1]: Reached target cryptsetup-pre.target - Local Encrypted Volumes (Pre). Jan 28 01:24:59.042088 systemd[1]: Stopped target initrd-switch-root.target - Switch Root. Jan 28 01:24:59.042113 systemd[1]: Stopped target initrd-fs.target - Initrd File Systems. Jan 28 01:24:59.042130 systemd[1]: Stopped target initrd-root-fs.target - Initrd Root File System. Jan 28 01:24:59.042140 systemd[1]: Reached target integritysetup.target - Local Integrity Protected Volumes. Jan 28 01:24:59.042153 systemd[1]: Reached target remote-cryptsetup.target - Remote Encrypted Volumes. Jan 28 01:24:59.042163 systemd[1]: Reached target remote-fs.target - Remote File Systems. Jan 28 01:24:59.042172 systemd[1]: Reached target slices.target - Slice Units. Jan 28 01:24:59.042184 systemd[1]: Reached target swap.target - Swaps. Jan 28 01:24:59.042193 systemd[1]: Reached target veritysetup.target - Local Verity Protected Volumes. Jan 28 01:24:59.042203 systemd[1]: Listening on systemd-coredump.socket - Process Core Dump Socket. Jan 28 01:24:59.042213 systemd[1]: Listening on systemd-networkd.socket - Network Service Netlink Socket. Jan 28 01:24:59.042223 systemd[1]: Listening on systemd-udevd-control.socket - udev Control Socket. Jan 28 01:24:59.042233 systemd[1]: Listening on systemd-udevd-kernel.socket - udev Kernel Socket. Jan 28 01:24:59.042245 systemd[1]: Listening on systemd-userdbd.socket - User Database Manager Socket. Jan 28 01:24:59.042254 systemd[1]: Mounting dev-hugepages.mount - Huge Pages File System... Jan 28 01:24:59.042264 systemd[1]: Mounting dev-mqueue.mount - POSIX Message Queue File System... Jan 28 01:24:59.042274 systemd[1]: Mounting media.mount - External Media Directory... Jan 28 01:24:59.042284 systemd[1]: Mounting sys-kernel-debug.mount - Kernel Debug File System... Jan 28 01:24:59.042294 systemd[1]: Mounting sys-kernel-tracing.mount - Kernel Trace File System... Jan 28 01:24:59.042304 systemd[1]: Mounting tmp.mount - Temporary Directory /tmp... Jan 28 01:24:59.042316 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 28 01:24:59.042326 systemd[1]: Reached target machines.target - Containers. Jan 28 01:24:59.042336 systemd[1]: Starting flatcar-tmpfiles.service - Create missing system files... Jan 28 01:24:59.042346 systemd[1]: ignition-delete-config.service - Ignition (delete config) was skipped because no trigger condition checks were met. Jan 28 01:24:59.042356 systemd[1]: Starting kmod-static-nodes.service - Create List of Static Device Nodes... Jan 28 01:24:59.042367 systemd[1]: Starting modprobe@configfs.service - Load Kernel Module configfs... Jan 28 01:24:59.042377 systemd[1]: Starting modprobe@dm_mod.service - Load Kernel Module dm_mod... Jan 28 01:24:59.042387 systemd[1]: Starting modprobe@drm.service - Load Kernel Module drm... Jan 28 01:24:59.042399 systemd[1]: Starting modprobe@efi_pstore.service - Load Kernel Module efi_pstore... Jan 28 01:24:59.042409 systemd[1]: Starting modprobe@fuse.service - Load Kernel Module fuse... Jan 28 01:24:59.042418 systemd[1]: Starting modprobe@loop.service - Load Kernel Module loop... Jan 28 01:24:59.042428 systemd[1]: setup-nsswitch.service - Create /etc/nsswitch.conf was skipped because of an unmet condition check (ConditionPathExists=!/etc/nsswitch.conf). Jan 28 01:24:59.042438 systemd[1]: systemd-fsck-root.service: Deactivated successfully. Jan 28 01:24:59.042448 systemd[1]: Stopped systemd-fsck-root.service - File System Check on Root Device. Jan 28 01:24:59.042458 kernel: fuse: init (API version 7.39) Jan 28 01:24:59.042467 systemd[1]: systemd-fsck-usr.service: Deactivated successfully. Jan 28 01:24:59.042486 systemd[1]: Stopped systemd-fsck-usr.service. Jan 28 01:24:59.042497 systemd[1]: Starting systemd-journald.service - Journal Service... Jan 28 01:24:59.042507 kernel: ACPI: bus type drm_connector registered Jan 28 01:24:59.042516 systemd[1]: Starting systemd-modules-load.service - Load Kernel Modules... Jan 28 01:24:59.042526 kernel: loop: module loaded Jan 28 01:24:59.042535 systemd[1]: Starting systemd-network-generator.service - Generate network units from Kernel command line... Jan 28 01:24:59.042545 systemd[1]: Starting systemd-remount-fs.service - Remount Root and Kernel File Systems... Jan 28 01:24:59.042555 systemd[1]: Starting systemd-udev-trigger.service - Coldplug All udev Devices... Jan 28 01:24:59.042592 systemd-journald[1288]: Collecting audit messages is disabled. Jan 28 01:24:59.042615 systemd[1]: verity-setup.service: Deactivated successfully. Jan 28 01:24:59.042627 systemd[1]: Stopped verity-setup.service. Jan 28 01:24:59.042637 systemd-journald[1288]: Journal started Jan 28 01:24:59.042659 systemd-journald[1288]: Runtime Journal (/run/log/journal/d4efbeca32dc4b14828da9b05428c8c8) is 8.0M, max 78.5M, 70.5M free. Jan 28 01:24:58.153270 systemd[1]: Queued start job for default target multi-user.target. Jan 28 01:24:58.290290 systemd[1]: Unnecessary job was removed for dev-sda6.device - /dev/sda6. Jan 28 01:24:58.290661 systemd[1]: systemd-journald.service: Deactivated successfully. Jan 28 01:24:58.290976 systemd[1]: systemd-journald.service: Consumed 2.328s CPU time. Jan 28 01:24:59.060446 systemd[1]: Started systemd-journald.service - Journal Service. Jan 28 01:24:59.064084 systemd[1]: Mounted dev-hugepages.mount - Huge Pages File System. Jan 28 01:24:59.069325 systemd[1]: Mounted dev-mqueue.mount - POSIX Message Queue File System. Jan 28 01:24:59.074449 systemd[1]: Mounted media.mount - External Media Directory. Jan 28 01:24:59.078921 systemd[1]: Mounted sys-kernel-debug.mount - Kernel Debug File System. Jan 28 01:24:59.084014 systemd[1]: Mounted sys-kernel-tracing.mount - Kernel Trace File System. Jan 28 01:24:59.089915 systemd[1]: Mounted tmp.mount - Temporary Directory /tmp. Jan 28 01:24:59.094984 systemd[1]: Finished flatcar-tmpfiles.service - Create missing system files. Jan 28 01:24:59.100788 systemd[1]: Finished kmod-static-nodes.service - Create List of Static Device Nodes. Jan 28 01:24:59.106424 systemd[1]: modprobe@configfs.service: Deactivated successfully. Jan 28 01:24:59.106672 systemd[1]: Finished modprobe@configfs.service - Load Kernel Module configfs. Jan 28 01:24:59.112377 systemd[1]: modprobe@dm_mod.service: Deactivated successfully. Jan 28 01:24:59.112504 systemd[1]: Finished modprobe@dm_mod.service - Load Kernel Module dm_mod. Jan 28 01:24:59.118122 systemd[1]: modprobe@drm.service: Deactivated successfully. Jan 28 01:24:59.118268 systemd[1]: Finished modprobe@drm.service - Load Kernel Module drm. Jan 28 01:24:59.123454 systemd[1]: modprobe@efi_pstore.service: Deactivated successfully. Jan 28 01:24:59.123586 systemd[1]: Finished modprobe@efi_pstore.service - Load Kernel Module efi_pstore. Jan 28 01:24:59.129468 systemd[1]: modprobe@fuse.service: Deactivated successfully. Jan 28 01:24:59.129747 systemd[1]: Finished modprobe@fuse.service - Load Kernel Module fuse. Jan 28 01:24:59.134650 systemd[1]: modprobe@loop.service: Deactivated successfully. Jan 28 01:24:59.135840 systemd[1]: Finished modprobe@loop.service - Load Kernel Module loop. Jan 28 01:24:59.142503 systemd[1]: Finished systemd-modules-load.service - Load Kernel Modules. Jan 28 01:24:59.147701 systemd[1]: Finished systemd-network-generator.service - Generate network units from Kernel command line. Jan 28 01:24:59.153233 systemd[1]: Finished systemd-remount-fs.service - Remount Root and Kernel File Systems. Jan 28 01:24:59.159377 systemd[1]: Finished systemd-udev-trigger.service - Coldplug All udev Devices. Jan 28 01:24:59.173149 systemd[1]: Reached target network-pre.target - Preparation for Network. Jan 28 01:24:59.181562 systemd[1]: Mounting sys-fs-fuse-connections.mount - FUSE Control File System... Jan 28 01:24:59.189652 systemd[1]: Mounting sys-kernel-config.mount - Kernel Configuration File System... Jan 28 01:24:59.194852 systemd[1]: remount-root.service - Remount Root File System was skipped because of an unmet condition check (ConditionPathIsReadWrite=!/). Jan 28 01:24:59.194959 systemd[1]: Reached target local-fs.target - Local File Systems. Jan 28 01:24:59.200658 systemd[1]: Listening on systemd-sysext.socket - System Extension Image Management (Varlink). Jan 28 01:24:59.207589 systemd[1]: Starting dracut-shutdown.service - Restore /run/initramfs on shutdown... Jan 28 01:24:59.213986 systemd[1]: Starting ldconfig.service - Rebuild Dynamic Linker Cache... Jan 28 01:24:59.218543 systemd[1]: systemd-binfmt.service - Set Up Additional Binary Formats was skipped because no trigger condition checks were met. Jan 28 01:24:59.220230 systemd[1]: Starting systemd-hwdb-update.service - Rebuild Hardware Database... Jan 28 01:24:59.226250 systemd[1]: Starting systemd-journal-flush.service - Flush Journal to Persistent Storage... Jan 28 01:24:59.231922 systemd[1]: systemd-pstore.service - Platform Persistent Storage Archival was skipped because of an unmet condition check (ConditionDirectoryNotEmpty=/sys/fs/pstore). Jan 28 01:24:59.233156 systemd[1]: Starting systemd-random-seed.service - Load/Save OS Random Seed... Jan 28 01:24:59.238447 systemd[1]: systemd-repart.service - Repartition Root Disk was skipped because no trigger condition checks were met. Jan 28 01:24:59.239697 systemd[1]: Starting systemd-sysctl.service - Apply Kernel Variables... Jan 28 01:24:59.246704 systemd[1]: Starting systemd-sysext.service - Merge System Extension Images into /usr/ and /opt/... Jan 28 01:24:59.260725 systemd[1]: Starting systemd-tmpfiles-setup-dev-early.service - Create Static Device Nodes in /dev gracefully... Jan 28 01:24:59.268669 systemd[1]: Starting systemd-udev-settle.service - Wait for udev To Complete Device Initialization... Jan 28 01:24:59.279080 systemd[1]: Mounted sys-fs-fuse-connections.mount - FUSE Control File System. Jan 28 01:24:59.286769 systemd[1]: Mounted sys-kernel-config.mount - Kernel Configuration File System. Jan 28 01:24:59.293524 systemd[1]: Finished systemd-random-seed.service - Load/Save OS Random Seed. Jan 28 01:24:59.305009 udevadm[1323]: systemd-udev-settle.service is deprecated. Please fix lvm2-activation.service, lvm2-activation-early.service not to pull it in. Jan 28 01:24:59.305722 systemd[1]: Reached target first-boot-complete.target - First Boot Complete. Jan 28 01:24:59.306726 systemd-journald[1288]: Time spent on flushing to /var/log/journal/d4efbeca32dc4b14828da9b05428c8c8 is 54.810ms for 877 entries. Jan 28 01:24:59.306726 systemd-journald[1288]: System Journal (/var/log/journal/d4efbeca32dc4b14828da9b05428c8c8) is 11.8M, max 2.6G, 2.6G free. Jan 28 01:24:59.402921 systemd-journald[1288]: Received client request to flush runtime journal. Jan 28 01:24:59.402963 kernel: loop0: detected capacity change from 0 to 114328 Jan 28 01:24:59.402979 systemd-journald[1288]: /var/log/journal/d4efbeca32dc4b14828da9b05428c8c8/system.journal: Realtime clock jumped backwards relative to last journal entry, rotating. Jan 28 01:24:59.403007 systemd-journald[1288]: Rotating system journal. Jan 28 01:24:59.327680 systemd[1]: Starting systemd-machine-id-commit.service - Commit a transient machine-id on disk... Jan 28 01:24:59.366958 systemd[1]: Finished systemd-sysctl.service - Apply Kernel Variables. Jan 28 01:24:59.393685 systemd[1]: Finished dracut-shutdown.service - Restore /run/initramfs on shutdown. Jan 28 01:24:59.405532 systemd[1]: Finished systemd-journal-flush.service - Flush Journal to Persistent Storage. Jan 28 01:24:59.444391 systemd-tmpfiles[1321]: ACLs are not supported, ignoring. Jan 28 01:24:59.444407 systemd-tmpfiles[1321]: ACLs are not supported, ignoring. Jan 28 01:24:59.450583 systemd[1]: Finished systemd-tmpfiles-setup-dev-early.service - Create Static Device Nodes in /dev gracefully. Jan 28 01:24:59.467942 systemd[1]: Starting systemd-sysusers.service - Create System Users... Jan 28 01:24:59.513339 systemd[1]: etc-machine\x2did.mount: Deactivated successfully. Jan 28 01:24:59.514902 systemd[1]: Finished systemd-machine-id-commit.service - Commit a transient machine-id on disk. Jan 28 01:24:59.560008 systemd[1]: Finished systemd-sysusers.service - Create System Users. Jan 28 01:24:59.575629 systemd[1]: Starting systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev... Jan 28 01:24:59.594532 systemd-tmpfiles[1340]: ACLs are not supported, ignoring. Jan 28 01:24:59.594853 systemd-tmpfiles[1340]: ACLs are not supported, ignoring. Jan 28 01:24:59.600650 systemd[1]: Finished systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev. Jan 28 01:24:59.789825 kernel: squashfs: version 4.0 (2009/01/31) Phillip Lougher Jan 28 01:24:59.824497 kernel: loop1: detected capacity change from 0 to 31320 Jan 28 01:25:00.008925 systemd[1]: Finished systemd-hwdb-update.service - Rebuild Hardware Database. Jan 28 01:25:00.019705 systemd[1]: Starting systemd-udevd.service - Rule-based Manager for Device Events and Files... Jan 28 01:25:00.052913 systemd-udevd[1347]: Using default interface naming scheme 'v255'. Jan 28 01:25:00.252499 kernel: loop2: detected capacity change from 0 to 114432 Jan 28 01:25:00.272243 systemd[1]: Started systemd-udevd.service - Rule-based Manager for Device Events and Files. Jan 28 01:25:00.295425 systemd[1]: Starting systemd-networkd.service - Network Configuration... Jan 28 01:25:00.351703 systemd[1]: Starting systemd-userdbd.service - User Database Manager... Jan 28 01:25:00.362840 systemd[1]: Condition check resulted in dev-ttyAMA0.device - /dev/ttyAMA0 being skipped. Jan 28 01:25:00.419573 kernel: hv_storvsc f8b3781a-1e82-4818-a1c3-63d806ec15bb: tag#47 cmd 0x85 status: scsi 0x2 srb 0x6 hv 0xc0000001 Jan 28 01:25:00.426069 systemd[1]: Started systemd-userdbd.service - User Database Manager. Jan 28 01:25:00.488739 kernel: mousedev: PS/2 mouse device common for all mice Jan 28 01:25:00.488945 kernel: hv_vmbus: registering driver hv_balloon Jan 28 01:25:00.488968 kernel: hv_balloon: Using Dynamic Memory protocol version 2.0 Jan 28 01:25:00.488985 kernel: hv_balloon: Memory hot add disabled on ARM64 Jan 28 01:25:00.516862 systemd[1]: Starting systemd-vconsole-setup.service - Virtual Console Setup... Jan 28 01:25:00.537344 kernel: hv_vmbus: registering driver hyperv_fb Jan 28 01:25:00.537436 kernel: hyperv_fb: Synthvid Version major 3, minor 5 Jan 28 01:25:00.542668 kernel: hyperv_fb: Screen resolution: 1024x768, Color depth: 32, Frame buffer size: 8388608 Jan 28 01:25:00.543908 kernel: Console: switching to colour dummy device 80x25 Jan 28 01:25:00.553157 kernel: Console: switching to colour frame buffer device 128x48 Jan 28 01:25:00.560001 systemd[1]: systemd-vconsole-setup.service: Deactivated successfully. Jan 28 01:25:00.560193 systemd[1]: Stopped systemd-vconsole-setup.service - Virtual Console Setup. Jan 28 01:25:00.570992 systemd[1]: Starting systemd-vconsole-setup.service - Virtual Console Setup... Jan 28 01:25:00.598595 kernel: BTRFS warning: duplicate device /dev/sda3 devid 1 generation 36 scanned by (udev-worker) (1368) Jan 28 01:25:00.606528 systemd-networkd[1361]: lo: Link UP Jan 28 01:25:00.606535 systemd-networkd[1361]: lo: Gained carrier Jan 28 01:25:00.609908 systemd-networkd[1361]: Enumeration completed Jan 28 01:25:00.610039 systemd[1]: Started systemd-networkd.service - Network Configuration. Jan 28 01:25:00.617594 systemd-networkd[1361]: eth0: found matching network '/usr/lib/systemd/network/zz-default.network', based on potentially unpredictable interface name. Jan 28 01:25:00.617605 systemd-networkd[1361]: eth0: Configuring with /usr/lib/systemd/network/zz-default.network. Jan 28 01:25:00.625787 systemd[1]: Starting systemd-networkd-wait-online.service - Wait for Network to be Configured... Jan 28 01:25:00.641835 systemd[1]: Found device dev-disk-by\x2dlabel-OEM.device - Virtual_Disk OEM. Jan 28 01:25:00.667813 systemd[1]: Starting systemd-fsck@dev-disk-by\x2dlabel-OEM.service - File System Check on /dev/disk/by-label/OEM... Jan 28 01:25:00.683532 kernel: loop3: detected capacity change from 0 to 114328 Jan 28 01:25:00.695590 kernel: loop4: detected capacity change from 0 to 31320 Jan 28 01:25:00.700508 kernel: mlx5_core 593d:00:02.0 enP22845s1: Link up Jan 28 01:25:00.715496 kernel: loop5: detected capacity change from 0 to 114432 Jan 28 01:25:00.726510 kernel: hv_netvsc 00224878-3498-0022-4878-349800224878 eth0: Data path switched to VF: enP22845s1 Jan 28 01:25:00.727562 systemd-networkd[1361]: enP22845s1: Link UP Jan 28 01:25:00.727738 systemd-networkd[1361]: eth0: Link UP Jan 28 01:25:00.727746 systemd-networkd[1361]: eth0: Gained carrier Jan 28 01:25:00.727762 systemd-networkd[1361]: eth0: found matching network '/usr/lib/systemd/network/zz-default.network', based on potentially unpredictable interface name. Jan 28 01:25:00.729987 (sd-merge)[1439]: Using extensions 'containerd-flatcar', 'docker-flatcar', 'oem-azure'. Jan 28 01:25:00.731599 (sd-merge)[1439]: Merged extensions into '/usr'. Jan 28 01:25:00.733106 systemd-networkd[1361]: enP22845s1: Gained carrier Jan 28 01:25:00.738095 systemd[1]: Finished systemd-sysext.service - Merge System Extension Images into /usr/ and /opt/. Jan 28 01:25:00.744593 systemd-networkd[1361]: eth0: DHCPv4 address 10.200.20.29/24, gateway 10.200.20.1 acquired from 168.63.129.16 Jan 28 01:25:00.744689 systemd[1]: Finished systemd-fsck@dev-disk-by\x2dlabel-OEM.service - File System Check on /dev/disk/by-label/OEM. Jan 28 01:25:00.755655 systemd[1]: Starting ensure-sysext.service... Jan 28 01:25:00.761534 systemd[1]: Starting systemd-tmpfiles-setup.service - Create System Files and Directories... Jan 28 01:25:00.769814 systemd[1]: Reloading requested from client PID 1443 ('systemctl') (unit ensure-sysext.service)... Jan 28 01:25:00.769940 systemd[1]: Reloading... Jan 28 01:25:00.818127 systemd-tmpfiles[1444]: /usr/lib/tmpfiles.d/provision.conf:20: Duplicate line for path "/root", ignoring. Jan 28 01:25:00.818420 systemd-tmpfiles[1444]: /usr/lib/tmpfiles.d/systemd-flatcar.conf:6: Duplicate line for path "/var/log/journal", ignoring. Jan 28 01:25:00.819084 systemd-tmpfiles[1444]: /usr/lib/tmpfiles.d/systemd.conf:29: Duplicate line for path "/var/lib/systemd", ignoring. Jan 28 01:25:00.819309 systemd-tmpfiles[1444]: ACLs are not supported, ignoring. Jan 28 01:25:00.819358 systemd-tmpfiles[1444]: ACLs are not supported, ignoring. Jan 28 01:25:00.842191 systemd-tmpfiles[1444]: Detected autofs mount point /boot during canonicalization of boot. Jan 28 01:25:00.842204 systemd-tmpfiles[1444]: Skipping /boot Jan 28 01:25:00.847498 zram_generator::config[1477]: No configuration found. Jan 28 01:25:00.854899 systemd-tmpfiles[1444]: Detected autofs mount point /boot during canonicalization of boot. Jan 28 01:25:00.854913 systemd-tmpfiles[1444]: Skipping /boot Jan 28 01:25:00.978358 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 28 01:25:01.049356 systemd[1]: Reloading finished in 279 ms. Jan 28 01:25:01.079135 systemd[1]: Finished systemd-tmpfiles-setup.service - Create System Files and Directories. Jan 28 01:25:01.097871 systemd[1]: Starting audit-rules.service - Load Security Auditing Rules... Jan 28 01:25:01.104250 systemd[1]: Starting clean-ca-certificates.service - Clean up broken links in /etc/ssl/certs... Jan 28 01:25:01.116641 systemd[1]: Starting systemd-journal-catalog-update.service - Rebuild Journal Catalog... Jan 28 01:25:01.123555 systemd[1]: Starting systemd-resolved.service - Network Name Resolution... Jan 28 01:25:01.134743 systemd[1]: Starting systemd-update-utmp.service - Record System Boot/Shutdown in UTMP... Jan 28 01:25:01.141502 systemd[1]: Finished systemd-vconsole-setup.service - Virtual Console Setup. Jan 28 01:25:01.164059 systemd[1]: ignition-delete-config.service - Ignition (delete config) was skipped because no trigger condition checks were met. Jan 28 01:25:01.170832 systemd[1]: Starting modprobe@dm_mod.service - Load Kernel Module dm_mod... Jan 28 01:25:01.178733 systemd[1]: Starting modprobe@efi_pstore.service - Load Kernel Module efi_pstore... Jan 28 01:25:01.194728 systemd[1]: Starting modprobe@loop.service - Load Kernel Module loop... Jan 28 01:25:01.200894 systemd[1]: systemd-binfmt.service - Set Up Additional Binary Formats was skipped because no trigger condition checks were met. Jan 28 01:25:01.201866 systemd[1]: Finished systemd-udev-settle.service - Wait for udev To Complete Device Initialization. Jan 28 01:25:01.209904 systemd[1]: Finished systemd-update-utmp.service - Record System Boot/Shutdown in UTMP. Jan 28 01:25:01.216418 systemd[1]: modprobe@dm_mod.service: Deactivated successfully. Jan 28 01:25:01.216638 systemd[1]: Finished modprobe@dm_mod.service - Load Kernel Module dm_mod. Jan 28 01:25:01.222720 systemd[1]: modprobe@efi_pstore.service: Deactivated successfully. Jan 28 01:25:01.222860 systemd[1]: Finished modprobe@efi_pstore.service - Load Kernel Module efi_pstore. Jan 28 01:25:01.232953 systemd[1]: modprobe@loop.service: Deactivated successfully. Jan 28 01:25:01.233119 systemd[1]: Finished modprobe@loop.service - Load Kernel Module loop. Jan 28 01:25:01.239361 systemd[1]: Finished systemd-journal-catalog-update.service - Rebuild Journal Catalog. Jan 28 01:25:01.252179 systemd-resolved[1541]: Positive Trust Anchors: Jan 28 01:25:01.252440 systemd-resolved[1541]: . IN DS 20326 8 2 e06d44b80b8f1d39a95c0b0d7c65d08458e880409bbc683457104237c7f8ec8d Jan 28 01:25:01.252552 systemd-resolved[1541]: 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 28 01:25:01.254003 systemd[1]: ignition-delete-config.service - Ignition (delete config) was skipped because no trigger condition checks were met. Jan 28 01:25:01.258723 systemd[1]: Starting lvm2-activation-early.service - Activation of LVM2 logical volumes... Jan 28 01:25:01.267071 systemd[1]: Starting modprobe@dm_mod.service - Load Kernel Module dm_mod... Jan 28 01:25:01.273745 systemd[1]: Starting modprobe@efi_pstore.service - Load Kernel Module efi_pstore... Jan 28 01:25:01.280804 systemd[1]: Starting modprobe@loop.service - Load Kernel Module loop... Jan 28 01:25:01.285740 systemd[1]: systemd-binfmt.service - Set Up Additional Binary Formats was skipped because no trigger condition checks were met. Jan 28 01:25:01.286723 systemd[1]: modprobe@dm_mod.service: Deactivated successfully. Jan 28 01:25:01.286884 systemd[1]: Finished modprobe@dm_mod.service - Load Kernel Module dm_mod. Jan 28 01:25:01.298704 systemd[1]: modprobe@efi_pstore.service: Deactivated successfully. Jan 28 01:25:01.298900 systemd[1]: Finished modprobe@efi_pstore.service - Load Kernel Module efi_pstore. Jan 28 01:25:01.305103 systemd[1]: modprobe@loop.service: Deactivated successfully. Jan 28 01:25:01.305245 systemd[1]: Finished modprobe@loop.service - Load Kernel Module loop. Jan 28 01:25:01.311911 systemd-resolved[1541]: Using system hostname 'ci-4081.3.6-n-eb37c95875'. Jan 28 01:25:01.316144 systemd[1]: Started systemd-resolved.service - Network Name Resolution. Jan 28 01:25:01.321850 systemd[1]: Reached target network.target - Network. Jan 28 01:25:01.325994 systemd[1]: Reached target nss-lookup.target - Host and Network Name Lookups. Jan 28 01:25:01.331772 systemd[1]: ignition-delete-config.service - Ignition (delete config) was skipped because no trigger condition checks were met. Jan 28 01:25:01.335690 systemd[1]: Starting modprobe@dm_mod.service - Load Kernel Module dm_mod... Jan 28 01:25:01.342744 systemd[1]: Starting modprobe@drm.service - Load Kernel Module drm... Jan 28 01:25:01.355774 systemd[1]: Starting modprobe@efi_pstore.service - Load Kernel Module efi_pstore... Jan 28 01:25:01.358492 lvm[1564]: WARNING: Failed to connect to lvmetad. Falling back to device scanning. Jan 28 01:25:01.365364 systemd[1]: Starting modprobe@loop.service - Load Kernel Module loop... Jan 28 01:25:01.370138 systemd[1]: systemd-binfmt.service - Set Up Additional Binary Formats was skipped because no trigger condition checks were met. Jan 28 01:25:01.370319 systemd[1]: Reached target time-set.target - System Time Set. Jan 28 01:25:01.384433 systemd[1]: modprobe@dm_mod.service: Deactivated successfully. Jan 28 01:25:01.385988 systemd[1]: Finished modprobe@dm_mod.service - Load Kernel Module dm_mod. Jan 28 01:25:01.393643 systemd[1]: Finished lvm2-activation-early.service - Activation of LVM2 logical volumes. Jan 28 01:25:01.400502 systemd[1]: modprobe@drm.service: Deactivated successfully. Jan 28 01:25:01.400635 systemd[1]: Finished modprobe@drm.service - Load Kernel Module drm. Jan 28 01:25:01.406252 systemd[1]: modprobe@efi_pstore.service: Deactivated successfully. Jan 28 01:25:01.406400 systemd[1]: Finished modprobe@efi_pstore.service - Load Kernel Module efi_pstore. Jan 28 01:25:01.412890 systemd[1]: modprobe@loop.service: Deactivated successfully. Jan 28 01:25:01.413114 augenrules[1574]: No rules Jan 28 01:25:01.413308 systemd[1]: Finished modprobe@loop.service - Load Kernel Module loop. Jan 28 01:25:01.419721 systemd[1]: Finished audit-rules.service - Load Security Auditing Rules. Jan 28 01:25:01.430156 systemd[1]: Finished ensure-sysext.service. Jan 28 01:25:01.439093 systemd[1]: Reached target cryptsetup.target - Local Encrypted Volumes. Jan 28 01:25:01.454691 systemd[1]: Starting lvm2-activation.service - Activation of LVM2 logical volumes... Jan 28 01:25:01.459858 lvm[1590]: WARNING: Failed to connect to lvmetad. Falling back to device scanning. Jan 28 01:25:01.460419 systemd[1]: systemd-pstore.service - Platform Persistent Storage Archival was skipped because of an unmet condition check (ConditionDirectoryNotEmpty=/sys/fs/pstore). Jan 28 01:25:01.460600 systemd[1]: systemd-repart.service - Repartition Root Disk was skipped because no trigger condition checks were met. Jan 28 01:25:01.488629 systemd[1]: Finished lvm2-activation.service - Activation of LVM2 logical volumes. Jan 28 01:25:01.862786 systemd[1]: Finished clean-ca-certificates.service - Clean up broken links in /etc/ssl/certs. Jan 28 01:25:01.868893 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 28 01:25:02.629597 systemd-networkd[1361]: eth0: Gained IPv6LL Jan 28 01:25:02.632574 systemd[1]: Finished systemd-networkd-wait-online.service - Wait for Network to be Configured. Jan 28 01:25:02.638755 systemd[1]: Reached target network-online.target - Network is Online. Jan 28 01:25:05.274095 ldconfig[1314]: /sbin/ldconfig: /lib/ld.so.conf is not an ELF file - it has the wrong magic bytes at the start. Jan 28 01:25:05.291831 systemd[1]: Finished ldconfig.service - Rebuild Dynamic Linker Cache. Jan 28 01:25:05.302728 systemd[1]: Starting systemd-update-done.service - Update is Completed... Jan 28 01:25:05.317018 systemd[1]: Finished systemd-update-done.service - Update is Completed. Jan 28 01:25:05.322739 systemd[1]: Reached target sysinit.target - System Initialization. Jan 28 01:25:05.328142 systemd[1]: Started motdgen.path - Watch for update engine configuration changes. Jan 28 01:25:05.334277 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 28 01:25:05.340809 systemd[1]: Started logrotate.timer - Daily rotation of log files. Jan 28 01:25:05.346094 systemd[1]: Started mdadm.timer - Weekly check for MD array's redundancy information.. Jan 28 01:25:05.352425 systemd[1]: Started systemd-tmpfiles-clean.timer - Daily Cleanup of Temporary Directories. Jan 28 01:25:05.358741 systemd[1]: update-engine-stub.timer - Update Engine Stub Timer was skipped because of an unmet condition check (ConditionPathExists=/usr/.noupdate). Jan 28 01:25:05.358774 systemd[1]: Reached target paths.target - Path Units. Jan 28 01:25:05.363509 systemd[1]: Reached target timers.target - Timer Units. Jan 28 01:25:05.369092 systemd[1]: Listening on dbus.socket - D-Bus System Message Bus Socket. Jan 28 01:25:05.375868 systemd[1]: Starting docker.socket - Docker Socket for the API... Jan 28 01:25:05.385100 systemd[1]: Listening on sshd.socket - OpenSSH Server Socket. Jan 28 01:25:05.390542 systemd[1]: Listening on docker.socket - Docker Socket for the API. Jan 28 01:25:05.395554 systemd[1]: Reached target sockets.target - Socket Units. Jan 28 01:25:05.400261 systemd[1]: Reached target basic.target - Basic System. Jan 28 01:25:05.404558 systemd[1]: addon-config@oem.service - Configure Addon /oem was skipped because no trigger condition checks were met. Jan 28 01:25:05.404583 systemd[1]: addon-run@oem.service - Run Addon /oem was skipped because no trigger condition checks were met. Jan 28 01:25:05.413576 systemd[1]: Starting chronyd.service - NTP client/server... Jan 28 01:25:05.420627 systemd[1]: Starting containerd.service - containerd container runtime... Jan 28 01:25:05.431656 systemd[1]: Starting coreos-metadata.service - Flatcar Metadata Agent... Jan 28 01:25:05.437199 (chronyd)[1599]: chronyd.service: Referenced but unset environment variable evaluates to an empty string: OPTIONS Jan 28 01:25:05.442342 systemd[1]: Starting dbus.service - D-Bus System Message Bus... Jan 28 01:25:05.447668 systemd[1]: Starting enable-oem-cloudinit.service - Enable cloudinit... Jan 28 01:25:05.455743 systemd[1]: Starting extend-filesystems.service - Extend Filesystems... Jan 28 01:25:05.461599 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 28 01:25:05.461637 systemd[1]: hv_fcopy_daemon.service - Hyper-V FCOPY daemon was skipped because of an unmet condition check (ConditionPathExists=/dev/vmbus/hv_fcopy). Jan 28 01:25:05.462995 chronyd[1608]: chronyd version 4.5 starting (+CMDMON +NTP +REFCLOCK +RTC +PRIVDROP +SCFILTER -SIGND +ASYNCDNS +NTS +SECHASH +IPV6 -DEBUG) Jan 28 01:25:05.464678 systemd[1]: Started hv_kvp_daemon.service - Hyper-V KVP daemon. Jan 28 01:25:05.471457 KVP[1609]: KVP starting; pid is:1609 Jan 28 01:25:05.472373 systemd[1]: hv_vss_daemon.service - Hyper-V VSS daemon was skipped because of an unmet condition check (ConditionPathExists=/dev/vmbus/hv_vss). Jan 28 01:25:05.475431 jq[1605]: false Jan 28 01:25:05.481308 systemd[1]: Starting motdgen.service - Generate /run/flatcar/motd... Jan 28 01:25:05.486948 chronyd[1608]: Timezone right/UTC failed leap second check, ignoring Jan 28 01:25:05.487164 chronyd[1608]: Loaded seccomp filter (level 2) Jan 28 01:25:05.494766 systemd[1]: Starting nvidia.service - NVIDIA Configure Service... Jan 28 01:25:05.500353 systemd[1]: Starting ssh-key-proc-cmdline.service - Install an ssh key from /proc/cmdline... Jan 28 01:25:05.515507 kernel: hv_utils: KVP IC version 4.0 Jan 28 01:25:05.516551 KVP[1609]: KVP LIC Version: 3.1 Jan 28 01:25:05.517531 extend-filesystems[1606]: Found loop3 Jan 28 01:25:05.517531 extend-filesystems[1606]: Found loop4 Jan 28 01:25:05.517531 extend-filesystems[1606]: Found loop5 Jan 28 01:25:05.517531 extend-filesystems[1606]: Found sda Jan 28 01:25:05.517531 extend-filesystems[1606]: Found sda1 Jan 28 01:25:05.517531 extend-filesystems[1606]: Found sda2 Jan 28 01:25:05.517531 extend-filesystems[1606]: Found sda3 Jan 28 01:25:05.517531 extend-filesystems[1606]: Found usr Jan 28 01:25:05.517531 extend-filesystems[1606]: Found sda4 Jan 28 01:25:05.517531 extend-filesystems[1606]: Found sda6 Jan 28 01:25:05.517531 extend-filesystems[1606]: Found sda7 Jan 28 01:25:05.517531 extend-filesystems[1606]: Found sda9 Jan 28 01:25:05.517531 extend-filesystems[1606]: Checking size of /dev/sda9 Jan 28 01:25:05.686264 coreos-metadata[1601]: Jan 28 01:25:05.634 INFO Fetching http://168.63.129.16/?comp=versions: Attempt #1 Jan 28 01:25:05.686264 coreos-metadata[1601]: Jan 28 01:25:05.639 INFO Fetch successful Jan 28 01:25:05.686264 coreos-metadata[1601]: Jan 28 01:25:05.639 INFO Fetching http://168.63.129.16/machine/?comp=goalstate: Attempt #1 Jan 28 01:25:05.686264 coreos-metadata[1601]: Jan 28 01:25:05.645 INFO Fetch successful Jan 28 01:25:05.686264 coreos-metadata[1601]: Jan 28 01:25:05.645 INFO Fetching http://168.63.129.16/machine/dfa96117-a266-4beb-9ac6-e480584fb6a3/7c449def%2Df7e4%2D4793%2Da822%2Db122ab3b6efd.%5Fci%2D4081.3.6%2Dn%2Deb37c95875?comp=config&type=sharedConfig&incarnation=1: Attempt #1 Jan 28 01:25:05.686264 coreos-metadata[1601]: Jan 28 01:25:05.648 INFO Fetch successful Jan 28 01:25:05.686264 coreos-metadata[1601]: Jan 28 01:25:05.648 INFO Fetching http://169.254.169.254/metadata/instance/compute/vmSize?api-version=2017-08-01&format=text: Attempt #1 Jan 28 01:25:05.686264 coreos-metadata[1601]: Jan 28 01:25:05.660 INFO Fetch successful Jan 28 01:25:05.542551 dbus-daemon[1602]: [system] SELinux support is enabled Jan 28 01:25:05.701681 extend-filesystems[1606]: Old size kept for /dev/sda9 Jan 28 01:25:05.701681 extend-filesystems[1606]: Found sr0 Jan 28 01:25:05.518083 systemd[1]: Starting sshd-keygen.service - Generate sshd host keys... Jan 28 01:25:05.530446 systemd[1]: Starting systemd-logind.service - User Login Management... Jan 28 01:25:05.537090 systemd[1]: tcsd.service - TCG Core Services Daemon was skipped because of an unmet condition check (ConditionPathExists=/dev/tpm0). Jan 28 01:25:05.537582 systemd[1]: cgroup compatibility translation between legacy and unified hierarchy settings activated. See cgroup-compat debug messages for details. Jan 28 01:25:05.722752 update_engine[1624]: I20260128 01:25:05.644449 1624 main.cc:92] Flatcar Update Engine starting Jan 28 01:25:05.722752 update_engine[1624]: I20260128 01:25:05.651520 1624 update_check_scheduler.cc:74] Next update check in 3m26s Jan 28 01:25:05.545650 systemd[1]: Starting update-engine.service - Update Engine... Jan 28 01:25:05.723039 jq[1628]: true Jan 28 01:25:05.552519 systemd[1]: Starting update-ssh-keys-after-ignition.service - Run update-ssh-keys once after Ignition... Jan 28 01:25:05.569124 systemd[1]: Started dbus.service - D-Bus System Message Bus. Jan 28 01:25:05.590284 systemd[1]: Started chronyd.service - NTP client/server. Jan 28 01:25:05.723465 jq[1654]: true Jan 28 01:25:05.616035 systemd[1]: enable-oem-cloudinit.service: Skipped due to 'exec-condition'. Jan 28 01:25:05.724266 dbus-daemon[1602]: [system] Successfully activated service 'org.freedesktop.systemd1' Jan 28 01:25:05.616202 systemd[1]: Condition check resulted in enable-oem-cloudinit.service - Enable cloudinit being skipped. Jan 28 01:25:05.616460 systemd[1]: extend-filesystems.service: Deactivated successfully. Jan 28 01:25:05.616621 systemd[1]: Finished extend-filesystems.service - Extend Filesystems. Jan 28 01:25:05.644707 systemd[1]: motdgen.service: Deactivated successfully. Jan 28 01:25:05.644901 systemd[1]: Finished motdgen.service - Generate /run/flatcar/motd. Jan 28 01:25:05.666601 systemd[1]: Finished nvidia.service - NVIDIA Configure Service. Jan 28 01:25:05.671788 systemd-logind[1622]: Watching system buttons on /dev/input/event1 (AT Translated Set 2 keyboard) Jan 28 01:25:05.677023 systemd-logind[1622]: New seat seat0. Jan 28 01:25:05.680743 systemd[1]: Started systemd-logind.service - User Login Management. Jan 28 01:25:05.685928 systemd[1]: ssh-key-proc-cmdline.service: Deactivated successfully. Jan 28 01:25:05.686575 systemd[1]: Finished ssh-key-proc-cmdline.service - Install an ssh key from /proc/cmdline. Jan 28 01:25:05.723343 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 28 01:25:05.723386 systemd[1]: Reached target system-config.target - Load system-provided cloud configs. Jan 28 01:25:05.729856 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 28 01:25:05.729876 systemd[1]: Reached target user-config.target - Load user-provided cloud configs. Jan 28 01:25:05.741797 (ntainerd)[1655]: containerd.service: Referenced but unset environment variable evaluates to an empty string: TORCX_IMAGEDIR, TORCX_UNPACKDIR Jan 28 01:25:05.763702 systemd[1]: Finished coreos-metadata.service - Flatcar Metadata Agent. Jan 28 01:25:05.777658 systemd[1]: Started update-engine.service - Update Engine. Jan 28 01:25:05.786068 systemd[1]: packet-phone-home.service - Report Success to Packet was skipped because no trigger condition checks were met. Jan 28 01:25:05.790512 kernel: BTRFS warning: duplicate device /dev/sda3 devid 1 generation 36 scanned by (udev-worker) (1643) Jan 28 01:25:05.795826 systemd[1]: Started locksmithd.service - Cluster reboot manager. Jan 28 01:25:05.906658 bash[1696]: Updated "/home/core/.ssh/authorized_keys" Jan 28 01:25:05.908086 systemd[1]: Finished update-ssh-keys-after-ignition.service - Run update-ssh-keys once after Ignition. Jan 28 01:25:05.914470 systemd[1]: sshkeys.service was skipped because no trigger condition checks were met. Jan 28 01:25:05.984927 locksmithd[1674]: locksmithd starting currentOperation="UPDATE_STATUS_IDLE" strategy="reboot" Jan 28 01:25:06.390492 containerd[1655]: time="2026-01-28T01:25:06.390349740Z" level=info msg="starting containerd" revision=174e0d1785eeda18dc2beba45e1d5a188771636b version=v1.7.21 Jan 28 01:25:06.420392 containerd[1655]: time="2026-01-28T01:25:06.420345740Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.aufs\"..." type=io.containerd.snapshotter.v1 Jan 28 01:25:06.422000 containerd[1655]: time="2026-01-28T01:25:06.421963340Z" 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 28 01:25:06.422059 containerd[1655]: time="2026-01-28T01:25:06.422000580Z" level=info msg="loading plugin \"io.containerd.event.v1.exchange\"..." type=io.containerd.event.v1 Jan 28 01:25:06.422059 containerd[1655]: time="2026-01-28T01:25:06.422017260Z" level=info msg="loading plugin \"io.containerd.internal.v1.opt\"..." type=io.containerd.internal.v1 Jan 28 01:25:06.422197 containerd[1655]: time="2026-01-28T01:25:06.422180100Z" level=info msg="loading plugin \"io.containerd.warning.v1.deprecations\"..." type=io.containerd.warning.v1 Jan 28 01:25:06.422221 containerd[1655]: time="2026-01-28T01:25:06.422201220Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.blockfile\"..." type=io.containerd.snapshotter.v1 Jan 28 01:25:06.422276 containerd[1655]: time="2026-01-28T01:25:06.422260500Z" level=info msg="skip loading plugin \"io.containerd.snapshotter.v1.blockfile\"..." error="no scratch file generator: skip plugin" type=io.containerd.snapshotter.v1 Jan 28 01:25:06.422302 containerd[1655]: time="2026-01-28T01:25:06.422275060Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.btrfs\"..." type=io.containerd.snapshotter.v1 Jan 28 01:25:06.422464 containerd[1655]: time="2026-01-28T01:25:06.422444060Z" level=info msg="skip loading plugin \"io.containerd.snapshotter.v1.btrfs\"..." error="path /var/lib/containerd/io.containerd.snapshotter.v1.btrfs (ext4) must be a btrfs filesystem to be used with the btrfs snapshotter: skip plugin" type=io.containerd.snapshotter.v1 Jan 28 01:25:06.422506 containerd[1655]: time="2026-01-28T01:25:06.422462820Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.devmapper\"..." type=io.containerd.snapshotter.v1 Jan 28 01:25:06.422506 containerd[1655]: time="2026-01-28T01:25:06.422484180Z" level=info msg="skip loading plugin \"io.containerd.snapshotter.v1.devmapper\"..." error="devmapper not configured: skip plugin" type=io.containerd.snapshotter.v1 Jan 28 01:25:06.422506 containerd[1655]: time="2026-01-28T01:25:06.422494780Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.native\"..." type=io.containerd.snapshotter.v1 Jan 28 01:25:06.422585 containerd[1655]: time="2026-01-28T01:25:06.422569860Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.overlayfs\"..." type=io.containerd.snapshotter.v1 Jan 28 01:25:06.422774 containerd[1655]: time="2026-01-28T01:25:06.422756780Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.zfs\"..." type=io.containerd.snapshotter.v1 Jan 28 01:25:06.422892 containerd[1655]: time="2026-01-28T01:25:06.422874340Z" 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 28 01:25:06.422918 containerd[1655]: time="2026-01-28T01:25:06.422891860Z" level=info msg="loading plugin \"io.containerd.content.v1.content\"..." type=io.containerd.content.v1 Jan 28 01:25:06.422981 containerd[1655]: time="2026-01-28T01:25:06.422967460Z" level=info msg="loading plugin \"io.containerd.metadata.v1.bolt\"..." type=io.containerd.metadata.v1 Jan 28 01:25:06.423024 containerd[1655]: time="2026-01-28T01:25:06.423011020Z" level=info msg="metadata content store policy set" policy=shared Jan 28 01:25:06.439482 containerd[1655]: time="2026-01-28T01:25:06.437063780Z" level=info msg="loading plugin \"io.containerd.gc.v1.scheduler\"..." type=io.containerd.gc.v1 Jan 28 01:25:06.439482 containerd[1655]: time="2026-01-28T01:25:06.437123700Z" level=info msg="loading plugin \"io.containerd.differ.v1.walking\"..." type=io.containerd.differ.v1 Jan 28 01:25:06.439482 containerd[1655]: time="2026-01-28T01:25:06.437141980Z" level=info msg="loading plugin \"io.containerd.lease.v1.manager\"..." type=io.containerd.lease.v1 Jan 28 01:25:06.439482 containerd[1655]: time="2026-01-28T01:25:06.437157980Z" level=info msg="loading plugin \"io.containerd.streaming.v1.manager\"..." type=io.containerd.streaming.v1 Jan 28 01:25:06.439482 containerd[1655]: time="2026-01-28T01:25:06.437171740Z" level=info msg="loading plugin \"io.containerd.runtime.v1.linux\"..." type=io.containerd.runtime.v1 Jan 28 01:25:06.439482 containerd[1655]: time="2026-01-28T01:25:06.437339300Z" level=info msg="loading plugin \"io.containerd.monitor.v1.cgroups\"..." type=io.containerd.monitor.v1 Jan 28 01:25:06.439482 containerd[1655]: time="2026-01-28T01:25:06.437625700Z" level=info msg="loading plugin \"io.containerd.runtime.v2.task\"..." type=io.containerd.runtime.v2 Jan 28 01:25:06.439482 containerd[1655]: time="2026-01-28T01:25:06.437737220Z" level=info msg="loading plugin \"io.containerd.runtime.v2.shim\"..." type=io.containerd.runtime.v2 Jan 28 01:25:06.439482 containerd[1655]: time="2026-01-28T01:25:06.437758180Z" level=info msg="loading plugin \"io.containerd.sandbox.store.v1.local\"..." type=io.containerd.sandbox.store.v1 Jan 28 01:25:06.439482 containerd[1655]: time="2026-01-28T01:25:06.437771860Z" level=info msg="loading plugin \"io.containerd.sandbox.controller.v1.local\"..." type=io.containerd.sandbox.controller.v1 Jan 28 01:25:06.439482 containerd[1655]: time="2026-01-28T01:25:06.437790380Z" level=info msg="loading plugin \"io.containerd.service.v1.containers-service\"..." type=io.containerd.service.v1 Jan 28 01:25:06.439482 containerd[1655]: time="2026-01-28T01:25:06.437803740Z" level=info msg="loading plugin \"io.containerd.service.v1.content-service\"..." type=io.containerd.service.v1 Jan 28 01:25:06.439482 containerd[1655]: time="2026-01-28T01:25:06.437816100Z" level=info msg="loading plugin \"io.containerd.service.v1.diff-service\"..." type=io.containerd.service.v1 Jan 28 01:25:06.439482 containerd[1655]: time="2026-01-28T01:25:06.437829700Z" level=info msg="loading plugin \"io.containerd.service.v1.images-service\"..." type=io.containerd.service.v1 Jan 28 01:25:06.439771 containerd[1655]: time="2026-01-28T01:25:06.437844100Z" level=info msg="loading plugin \"io.containerd.service.v1.introspection-service\"..." type=io.containerd.service.v1 Jan 28 01:25:06.439771 containerd[1655]: time="2026-01-28T01:25:06.437856820Z" level=info msg="loading plugin \"io.containerd.service.v1.namespaces-service\"..." type=io.containerd.service.v1 Jan 28 01:25:06.439771 containerd[1655]: time="2026-01-28T01:25:06.437870980Z" level=info msg="loading plugin \"io.containerd.service.v1.snapshots-service\"..." type=io.containerd.service.v1 Jan 28 01:25:06.439771 containerd[1655]: time="2026-01-28T01:25:06.437883500Z" level=info msg="loading plugin \"io.containerd.service.v1.tasks-service\"..." type=io.containerd.service.v1 Jan 28 01:25:06.439771 containerd[1655]: time="2026-01-28T01:25:06.437903220Z" level=info msg="loading plugin \"io.containerd.grpc.v1.containers\"..." type=io.containerd.grpc.v1 Jan 28 01:25:06.439771 containerd[1655]: time="2026-01-28T01:25:06.437918220Z" level=info msg="loading plugin \"io.containerd.grpc.v1.content\"..." type=io.containerd.grpc.v1 Jan 28 01:25:06.439771 containerd[1655]: time="2026-01-28T01:25:06.437930900Z" level=info msg="loading plugin \"io.containerd.grpc.v1.diff\"..." type=io.containerd.grpc.v1 Jan 28 01:25:06.439771 containerd[1655]: time="2026-01-28T01:25:06.437944620Z" level=info msg="loading plugin \"io.containerd.grpc.v1.events\"..." type=io.containerd.grpc.v1 Jan 28 01:25:06.439771 containerd[1655]: time="2026-01-28T01:25:06.437957780Z" level=info msg="loading plugin \"io.containerd.grpc.v1.images\"..." type=io.containerd.grpc.v1 Jan 28 01:25:06.439771 containerd[1655]: time="2026-01-28T01:25:06.437970860Z" level=info msg="loading plugin \"io.containerd.grpc.v1.introspection\"..." type=io.containerd.grpc.v1 Jan 28 01:25:06.439771 containerd[1655]: time="2026-01-28T01:25:06.437982820Z" level=info msg="loading plugin \"io.containerd.grpc.v1.leases\"..." type=io.containerd.grpc.v1 Jan 28 01:25:06.439771 containerd[1655]: time="2026-01-28T01:25:06.437995420Z" level=info msg="loading plugin \"io.containerd.grpc.v1.namespaces\"..." type=io.containerd.grpc.v1 Jan 28 01:25:06.439771 containerd[1655]: time="2026-01-28T01:25:06.438009420Z" level=info msg="loading plugin \"io.containerd.grpc.v1.sandbox-controllers\"..." type=io.containerd.grpc.v1 Jan 28 01:25:06.439771 containerd[1655]: time="2026-01-28T01:25:06.438023860Z" level=info msg="loading plugin \"io.containerd.grpc.v1.sandboxes\"..." type=io.containerd.grpc.v1 Jan 28 01:25:06.440010 containerd[1655]: time="2026-01-28T01:25:06.438035500Z" level=info msg="loading plugin \"io.containerd.grpc.v1.snapshots\"..." type=io.containerd.grpc.v1 Jan 28 01:25:06.440010 containerd[1655]: time="2026-01-28T01:25:06.438048180Z" level=info msg="loading plugin \"io.containerd.grpc.v1.streaming\"..." type=io.containerd.grpc.v1 Jan 28 01:25:06.440010 containerd[1655]: time="2026-01-28T01:25:06.438063460Z" level=info msg="loading plugin \"io.containerd.grpc.v1.tasks\"..." type=io.containerd.grpc.v1 Jan 28 01:25:06.440010 containerd[1655]: time="2026-01-28T01:25:06.438079860Z" level=info msg="loading plugin \"io.containerd.transfer.v1.local\"..." type=io.containerd.transfer.v1 Jan 28 01:25:06.440010 containerd[1655]: time="2026-01-28T01:25:06.438101020Z" level=info msg="loading plugin \"io.containerd.grpc.v1.transfer\"..." type=io.containerd.grpc.v1 Jan 28 01:25:06.440010 containerd[1655]: time="2026-01-28T01:25:06.438116780Z" level=info msg="loading plugin \"io.containerd.grpc.v1.version\"..." type=io.containerd.grpc.v1 Jan 28 01:25:06.440010 containerd[1655]: time="2026-01-28T01:25:06.438149580Z" level=info msg="loading plugin \"io.containerd.internal.v1.restart\"..." type=io.containerd.internal.v1 Jan 28 01:25:06.440010 containerd[1655]: time="2026-01-28T01:25:06.438204100Z" level=info msg="loading plugin \"io.containerd.tracing.processor.v1.otlp\"..." type=io.containerd.tracing.processor.v1 Jan 28 01:25:06.440010 containerd[1655]: time="2026-01-28T01:25:06.438222180Z" 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 28 01:25:06.440010 containerd[1655]: time="2026-01-28T01:25:06.438233820Z" level=info msg="loading plugin \"io.containerd.internal.v1.tracing\"..." type=io.containerd.internal.v1 Jan 28 01:25:06.440010 containerd[1655]: time="2026-01-28T01:25:06.438247420Z" level=info msg="skip loading plugin \"io.containerd.internal.v1.tracing\"..." error="skip plugin: tracing endpoint not configured" type=io.containerd.internal.v1 Jan 28 01:25:06.440010 containerd[1655]: time="2026-01-28T01:25:06.438318020Z" level=info msg="loading plugin \"io.containerd.grpc.v1.healthcheck\"..." type=io.containerd.grpc.v1 Jan 28 01:25:06.440010 containerd[1655]: time="2026-01-28T01:25:06.438334100Z" level=info msg="loading plugin \"io.containerd.nri.v1.nri\"..." type=io.containerd.nri.v1 Jan 28 01:25:06.440010 containerd[1655]: time="2026-01-28T01:25:06.438343540Z" level=info msg="NRI interface is disabled by configuration." Jan 28 01:25:06.440249 containerd[1655]: time="2026-01-28T01:25:06.438353700Z" level=info msg="loading plugin \"io.containerd.grpc.v1.cri\"..." type=io.containerd.grpc.v1 Jan 28 01:25:06.440271 containerd[1655]: time="2026-01-28T01:25:06.438628100Z" 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 28 01:25:06.440271 containerd[1655]: time="2026-01-28T01:25:06.438722820Z" level=info msg="Connect containerd service" Jan 28 01:25:06.440271 containerd[1655]: time="2026-01-28T01:25:06.438747540Z" level=info msg="using legacy CRI server" Jan 28 01:25:06.440271 containerd[1655]: time="2026-01-28T01:25:06.438754180Z" level=info msg="using experimental NRI integration - disable nri plugin to prevent this" Jan 28 01:25:06.440271 containerd[1655]: time="2026-01-28T01:25:06.438837380Z" level=info msg="Get image filesystem path \"/var/lib/containerd/io.containerd.snapshotter.v1.overlayfs\"" Jan 28 01:25:06.440271 containerd[1655]: time="2026-01-28T01:25:06.439462460Z" 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 28 01:25:06.440271 containerd[1655]: time="2026-01-28T01:25:06.439596460Z" level=info msg="Start subscribing containerd event" Jan 28 01:25:06.440271 containerd[1655]: time="2026-01-28T01:25:06.439642580Z" level=info msg="Start recovering state" Jan 28 01:25:06.440271 containerd[1655]: time="2026-01-28T01:25:06.439699820Z" level=info msg="Start event monitor" Jan 28 01:25:06.440271 containerd[1655]: time="2026-01-28T01:25:06.439710340Z" level=info msg="Start snapshots syncer" Jan 28 01:25:06.440271 containerd[1655]: time="2026-01-28T01:25:06.439720420Z" level=info msg="Start cni network conf syncer for default" Jan 28 01:25:06.440271 containerd[1655]: time="2026-01-28T01:25:06.439728500Z" level=info msg="Start streaming server" Jan 28 01:25:06.440271 containerd[1655]: time="2026-01-28T01:25:06.440126860Z" level=info msg=serving... address=/run/containerd/containerd.sock.ttrpc Jan 28 01:25:06.440271 containerd[1655]: time="2026-01-28T01:25:06.440163220Z" level=info msg=serving... address=/run/containerd/containerd.sock Jan 28 01:25:06.440291 systemd[1]: Started containerd.service - containerd container runtime. Jan 28 01:25:06.447726 containerd[1655]: time="2026-01-28T01:25:06.447605860Z" level=info msg="containerd successfully booted in 0.058171s" Jan 28 01:25:07.262672 sshd_keygen[1632]: ssh-keygen: generating new host keys: RSA ECDSA ED25519 Jan 28 01:25:07.281125 systemd[1]: Finished sshd-keygen.service - Generate sshd host keys. Jan 28 01:25:07.291765 systemd[1]: Starting issuegen.service - Generate /run/issue... Jan 28 01:25:07.297965 systemd[1]: Starting waagent.service - Microsoft Azure Linux Agent... Jan 28 01:25:07.303736 systemd[1]: issuegen.service: Deactivated successfully. Jan 28 01:25:07.305518 systemd[1]: Finished issuegen.service - Generate /run/issue. Jan 28 01:25:07.320958 systemd[1]: Starting systemd-user-sessions.service - Permit User Sessions... Jan 28 01:25:07.327654 systemd[1]: Started waagent.service - Microsoft Azure Linux Agent. Jan 28 01:25:07.336707 systemd[1]: Finished systemd-user-sessions.service - Permit User Sessions. Jan 28 01:25:07.350761 systemd[1]: Started getty@tty1.service - Getty on tty1. Jan 28 01:25:07.356029 systemd[1]: Started serial-getty@ttyAMA0.service - Serial Getty on ttyAMA0. Jan 28 01:25:07.361352 systemd[1]: Reached target getty.target - Login Prompts. Jan 28 01:25:07.366199 systemd[1]: Reached target multi-user.target - Multi-User System. Jan 28 01:25:07.371371 systemd[1]: Startup finished in 629ms (kernel) + 10.722s (initrd) + 12.300s (userspace) = 23.652s. Jan 28 01:25:07.753560 login[1747]: pam_lastlog(login:session): file /var/log/lastlog is locked/write, retrying Jan 28 01:25:07.754814 login[1746]: pam_unix(login:session): session opened for user core(uid=500) by core(uid=0) Jan 28 01:25:07.765969 systemd-logind[1622]: New session 2 of user core. Jan 28 01:25:07.767751 systemd[1]: Created slice user-500.slice - User Slice of UID 500. Jan 28 01:25:07.778726 systemd[1]: Starting user-runtime-dir@500.service - User Runtime Directory /run/user/500... Jan 28 01:25:07.802161 systemd[1]: Finished user-runtime-dir@500.service - User Runtime Directory /run/user/500. Jan 28 01:25:07.811757 systemd[1]: Starting user@500.service - User Manager for UID 500... Jan 28 01:25:07.814394 (systemd)[1754]: pam_unix(systemd-user:session): session opened for user core(uid=500) by (uid=0) Jan 28 01:25:07.947955 systemd[1754]: Queued start job for default target default.target. Jan 28 01:25:07.955795 systemd[1754]: Created slice app.slice - User Application Slice. Jan 28 01:25:07.955825 systemd[1754]: Reached target paths.target - Paths. Jan 28 01:25:07.955837 systemd[1754]: Reached target timers.target - Timers. Jan 28 01:25:07.957041 systemd[1754]: Starting dbus.socket - D-Bus User Message Bus Socket... Jan 28 01:25:07.968284 systemd[1754]: Listening on dbus.socket - D-Bus User Message Bus Socket. Jan 28 01:25:07.968395 systemd[1754]: Reached target sockets.target - Sockets. Jan 28 01:25:07.968408 systemd[1754]: Reached target basic.target - Basic System. Jan 28 01:25:07.968446 systemd[1754]: Reached target default.target - Main User Target. Jan 28 01:25:07.968471 systemd[1754]: Startup finished in 148ms. Jan 28 01:25:07.968696 systemd[1]: Started user@500.service - User Manager for UID 500. Jan 28 01:25:07.977663 systemd[1]: Started session-2.scope - Session 2 of User core. Jan 28 01:25:08.755346 login[1747]: pam_unix(login:session): session opened for user core(uid=500) by core(uid=0) Jan 28 01:25:08.760326 systemd-logind[1622]: New session 1 of user core. Jan 28 01:25:08.766617 systemd[1]: Started session-1.scope - Session 1 of User core. Jan 28 01:25:08.970092 waagent[1743]: 2026-01-28T01:25:08.969997Z INFO Daemon Daemon Azure Linux Agent Version: 2.9.1.1 Jan 28 01:25:08.974796 waagent[1743]: 2026-01-28T01:25:08.974729Z INFO Daemon Daemon OS: flatcar 4081.3.6 Jan 28 01:25:08.978283 waagent[1743]: 2026-01-28T01:25:08.978238Z INFO Daemon Daemon Python: 3.11.9 Jan 28 01:25:08.981875 waagent[1743]: 2026-01-28T01:25:08.981826Z INFO Daemon Daemon Run daemon Jan 28 01:25:08.985148 waagent[1743]: 2026-01-28T01:25:08.985107Z INFO Daemon Daemon No RDMA handler exists for distro='Flatcar Container Linux by Kinvolk' version='4081.3.6' Jan 28 01:25:08.992224 waagent[1743]: 2026-01-28T01:25:08.992160Z INFO Daemon Daemon Using waagent for provisioning Jan 28 01:25:08.996484 waagent[1743]: 2026-01-28T01:25:08.996433Z INFO Daemon Daemon Activate resource disk Jan 28 01:25:09.000151 waagent[1743]: 2026-01-28T01:25:09.000103Z INFO Daemon Daemon Searching gen1 prefix 00000000-0001 or gen2 f8b3781a-1e82-4818-a1c3-63d806ec15bb Jan 28 01:25:09.009555 waagent[1743]: 2026-01-28T01:25:09.009459Z INFO Daemon Daemon Found device: None Jan 28 01:25:09.013003 waagent[1743]: 2026-01-28T01:25:09.012963Z ERROR Daemon Daemon Failed to mount resource disk [ResourceDiskError] unable to detect disk topology Jan 28 01:25:09.019496 waagent[1743]: 2026-01-28T01:25:09.019449Z ERROR Daemon Daemon Event: name=WALinuxAgent, op=ActivateResourceDisk, message=[ResourceDiskError] unable to detect disk topology, duration=0 Jan 28 01:25:09.029866 waagent[1743]: 2026-01-28T01:25:09.029813Z INFO Daemon Daemon Clean protocol and wireserver endpoint Jan 28 01:25:09.034297 waagent[1743]: 2026-01-28T01:25:09.034256Z INFO Daemon Daemon Running default provisioning handler Jan 28 01:25:09.045263 waagent[1743]: 2026-01-28T01:25:09.045200Z 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 28 01:25:09.056630 waagent[1743]: 2026-01-28T01:25:09.056575Z INFO Daemon Daemon Unable to get cloud-init enabled status from service: [Errno 2] No such file or directory: 'service' Jan 28 01:25:09.064024 waagent[1743]: 2026-01-28T01:25:09.063979Z INFO Daemon Daemon cloud-init is enabled: False Jan 28 01:25:09.067931 waagent[1743]: 2026-01-28T01:25:09.067892Z INFO Daemon Daemon Copying ovf-env.xml Jan 28 01:25:09.179585 waagent[1743]: 2026-01-28T01:25:09.178069Z INFO Daemon Daemon Successfully mounted dvd Jan 28 01:25:09.205976 systemd[1]: mnt-cdrom-secure.mount: Deactivated successfully. Jan 28 01:25:09.207806 waagent[1743]: 2026-01-28T01:25:09.207729Z INFO Daemon Daemon Detect protocol endpoint Jan 28 01:25:09.212503 waagent[1743]: 2026-01-28T01:25:09.212437Z INFO Daemon Daemon Clean protocol and wireserver endpoint Jan 28 01:25:09.217488 waagent[1743]: 2026-01-28T01:25:09.217433Z INFO Daemon Daemon WireServer endpoint is not found. Rerun dhcp handler Jan 28 01:25:09.222893 waagent[1743]: 2026-01-28T01:25:09.222853Z INFO Daemon Daemon Test for route to 168.63.129.16 Jan 28 01:25:09.227745 waagent[1743]: 2026-01-28T01:25:09.227699Z INFO Daemon Daemon Route to 168.63.129.16 exists Jan 28 01:25:09.232160 waagent[1743]: 2026-01-28T01:25:09.232115Z INFO Daemon Daemon Wire server endpoint:168.63.129.16 Jan 28 01:25:09.283156 waagent[1743]: 2026-01-28T01:25:09.283067Z INFO Daemon Daemon Fabric preferred wire protocol version:2015-04-05 Jan 28 01:25:09.288769 waagent[1743]: 2026-01-28T01:25:09.288743Z INFO Daemon Daemon Wire protocol version:2012-11-30 Jan 28 01:25:09.293080 waagent[1743]: 2026-01-28T01:25:09.293039Z INFO Daemon Daemon Server preferred version:2015-04-05 Jan 28 01:25:09.458964 waagent[1743]: 2026-01-28T01:25:09.458863Z INFO Daemon Daemon Initializing goal state during protocol detection Jan 28 01:25:09.464360 waagent[1743]: 2026-01-28T01:25:09.464304Z INFO Daemon Daemon Forcing an update of the goal state. Jan 28 01:25:09.472431 waagent[1743]: 2026-01-28T01:25:09.472386Z INFO Daemon Fetched a new incarnation for the WireServer goal state [incarnation 1] Jan 28 01:25:09.493872 waagent[1743]: 2026-01-28T01:25:09.493828Z INFO Daemon Daemon HostGAPlugin version: 1.0.8.177 Jan 28 01:25:09.498844 waagent[1743]: 2026-01-28T01:25:09.498799Z INFO Daemon Jan 28 01:25:09.501060 waagent[1743]: 2026-01-28T01:25:09.501022Z INFO Daemon Fetched new vmSettings [HostGAPlugin correlation ID: fd8027d1-8de7-4418-ab3c-6dc889daa5ef eTag: 2822612000643562565 source: Fabric] Jan 28 01:25:09.510417 waagent[1743]: 2026-01-28T01:25:09.510376Z INFO Daemon The vmSettings originated via Fabric; will ignore them. Jan 28 01:25:09.516328 waagent[1743]: 2026-01-28T01:25:09.516286Z INFO Daemon Jan 28 01:25:09.518783 waagent[1743]: 2026-01-28T01:25:09.518747Z INFO Daemon Fetching full goal state from the WireServer [incarnation 1] Jan 28 01:25:09.528523 waagent[1743]: 2026-01-28T01:25:09.528488Z INFO Daemon Daemon Downloading artifacts profile blob Jan 28 01:25:09.608332 waagent[1743]: 2026-01-28T01:25:09.608197Z INFO Daemon Downloaded certificate {'thumbprint': 'EB43529A41BC1946C51CF5DEC0A3F9893F327322', 'hasPrivateKey': True} Jan 28 01:25:09.616439 waagent[1743]: 2026-01-28T01:25:09.616392Z INFO Daemon Fetch goal state completed Jan 28 01:25:09.627036 waagent[1743]: 2026-01-28T01:25:09.626981Z INFO Daemon Daemon Starting provisioning Jan 28 01:25:09.631227 waagent[1743]: 2026-01-28T01:25:09.631179Z INFO Daemon Daemon Handle ovf-env.xml. Jan 28 01:25:09.635340 waagent[1743]: 2026-01-28T01:25:09.635300Z INFO Daemon Daemon Set hostname [ci-4081.3.6-n-eb37c95875] Jan 28 01:25:09.645502 waagent[1743]: 2026-01-28T01:25:09.642197Z INFO Daemon Daemon Publish hostname [ci-4081.3.6-n-eb37c95875] Jan 28 01:25:09.647786 waagent[1743]: 2026-01-28T01:25:09.647723Z INFO Daemon Daemon Examine /proc/net/route for primary interface Jan 28 01:25:09.653085 waagent[1743]: 2026-01-28T01:25:09.653035Z INFO Daemon Daemon Primary interface is [eth0] Jan 28 01:25:09.682919 systemd-networkd[1361]: eth0: found matching network '/usr/lib/systemd/network/zz-default.network', based on potentially unpredictable interface name. Jan 28 01:25:09.682930 systemd-networkd[1361]: eth0: Configuring with /usr/lib/systemd/network/zz-default.network. Jan 28 01:25:09.682976 systemd-networkd[1361]: eth0: DHCP lease lost Jan 28 01:25:09.684171 waagent[1743]: 2026-01-28T01:25:09.684094Z INFO Daemon Daemon Create user account if not exists Jan 28 01:25:09.688780 waagent[1743]: 2026-01-28T01:25:09.688726Z INFO Daemon Daemon User core already exists, skip useradd Jan 28 01:25:09.693450 waagent[1743]: 2026-01-28T01:25:09.693406Z INFO Daemon Daemon Configure sudoer Jan 28 01:25:09.693666 systemd-networkd[1361]: eth0: DHCPv6 lease lost Jan 28 01:25:09.697150 waagent[1743]: 2026-01-28T01:25:09.697091Z INFO Daemon Daemon Configure sshd Jan 28 01:25:09.700743 waagent[1743]: 2026-01-28T01:25:09.700693Z INFO Daemon Daemon Added a configuration snippet disabling SSH password-based authentication methods. It also configures SSH client probing to keep connections alive. Jan 28 01:25:09.710029 waagent[1743]: 2026-01-28T01:25:09.709980Z INFO Daemon Daemon Deploy ssh public key. Jan 28 01:25:09.723522 systemd-networkd[1361]: eth0: DHCPv4 address 10.200.20.29/24, gateway 10.200.20.1 acquired from 168.63.129.16 Jan 28 01:25:10.804780 waagent[1743]: 2026-01-28T01:25:10.804731Z INFO Daemon Daemon Provisioning complete Jan 28 01:25:10.819111 waagent[1743]: 2026-01-28T01:25:10.819067Z INFO Daemon Daemon RDMA capabilities are not enabled, skipping Jan 28 01:25:10.824586 waagent[1743]: 2026-01-28T01:25:10.824529Z INFO Daemon Daemon End of log to /dev/console. The agent will now check for updates and then will process extensions. Jan 28 01:25:10.831600 waagent[1743]: 2026-01-28T01:25:10.831559Z INFO Daemon Daemon Installed Agent WALinuxAgent-2.9.1.1 is the most current agent Jan 28 01:25:10.963231 waagent[1804]: 2026-01-28T01:25:10.962598Z INFO ExtHandler ExtHandler Azure Linux Agent (Goal State Agent version 2.9.1.1) Jan 28 01:25:10.963231 waagent[1804]: 2026-01-28T01:25:10.962747Z INFO ExtHandler ExtHandler OS: flatcar 4081.3.6 Jan 28 01:25:10.963231 waagent[1804]: 2026-01-28T01:25:10.962800Z INFO ExtHandler ExtHandler Python: 3.11.9 Jan 28 01:25:10.998311 waagent[1804]: 2026-01-28T01:25:10.998232Z 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 28 01:25:10.998667 waagent[1804]: 2026-01-28T01:25:10.998628Z INFO ExtHandler ExtHandler WireServer endpoint 168.63.129.16 read from file Jan 28 01:25:10.998821 waagent[1804]: 2026-01-28T01:25:10.998786Z INFO ExtHandler ExtHandler Wire server endpoint:168.63.129.16 Jan 28 01:25:11.007379 waagent[1804]: 2026-01-28T01:25:11.007309Z INFO ExtHandler Fetched a new incarnation for the WireServer goal state [incarnation 1] Jan 28 01:25:11.013681 waagent[1804]: 2026-01-28T01:25:11.013634Z INFO ExtHandler ExtHandler HostGAPlugin version: 1.0.8.177 Jan 28 01:25:11.014328 waagent[1804]: 2026-01-28T01:25:11.014287Z INFO ExtHandler Jan 28 01:25:11.014489 waagent[1804]: 2026-01-28T01:25:11.014444Z INFO ExtHandler Fetched new vmSettings [HostGAPlugin correlation ID: 271fe0fa-06ee-42cd-b1f1-399b40afa6b0 eTag: 2822612000643562565 source: Fabric] Jan 28 01:25:11.014878 waagent[1804]: 2026-01-28T01:25:11.014838Z INFO ExtHandler The vmSettings originated via Fabric; will ignore them. Jan 28 01:25:11.016241 waagent[1804]: 2026-01-28T01:25:11.015523Z INFO ExtHandler Jan 28 01:25:11.016241 waagent[1804]: 2026-01-28T01:25:11.015612Z INFO ExtHandler Fetching full goal state from the WireServer [incarnation 1] Jan 28 01:25:11.020510 waagent[1804]: 2026-01-28T01:25:11.019856Z INFO ExtHandler ExtHandler Downloading artifacts profile blob Jan 28 01:25:11.090934 waagent[1804]: 2026-01-28T01:25:11.090805Z INFO ExtHandler Downloaded certificate {'thumbprint': 'EB43529A41BC1946C51CF5DEC0A3F9893F327322', 'hasPrivateKey': True} Jan 28 01:25:11.091631 waagent[1804]: 2026-01-28T01:25:11.091586Z INFO ExtHandler Fetch goal state completed Jan 28 01:25:11.104164 waagent[1804]: 2026-01-28T01:25:11.104105Z INFO ExtHandler ExtHandler WALinuxAgent-2.9.1.1 running as process 1804 Jan 28 01:25:11.104453 waagent[1804]: 2026-01-28T01:25:11.104417Z INFO ExtHandler ExtHandler ******** AutoUpdate.Enabled is set to False, not processing the operation ******** Jan 28 01:25:11.106224 waagent[1804]: 2026-01-28T01:25:11.106179Z INFO ExtHandler ExtHandler Cgroup monitoring is not supported on ['flatcar', '4081.3.6', '', 'Flatcar Container Linux by Kinvolk'] Jan 28 01:25:11.106733 waagent[1804]: 2026-01-28T01:25:11.106692Z INFO ExtHandler ExtHandler Starting setup for Persistent firewall rules Jan 28 01:25:11.139893 waagent[1804]: 2026-01-28T01:25:11.139854Z INFO ExtHandler ExtHandler Firewalld service not running/unavailable, trying to set up waagent-network-setup.service Jan 28 01:25:11.140401 waagent[1804]: 2026-01-28T01:25:11.140169Z INFO ExtHandler ExtHandler Successfully updated the Binary file /var/lib/waagent/waagent-network-setup.py for firewall setup Jan 28 01:25:11.145982 waagent[1804]: 2026-01-28T01:25:11.145940Z INFO ExtHandler ExtHandler Service: waagent-network-setup.service not enabled. Adding it now Jan 28 01:25:11.152723 systemd[1]: Reloading requested from client PID 1817 ('systemctl') (unit waagent.service)... Jan 28 01:25:11.152964 systemd[1]: Reloading... Jan 28 01:25:11.222953 zram_generator::config[1854]: No configuration found. Jan 28 01:25:11.331172 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 28 01:25:11.410347 systemd[1]: Reloading finished in 257 ms. Jan 28 01:25:11.438627 waagent[1804]: 2026-01-28T01:25:11.430660Z INFO ExtHandler ExtHandler Executing systemctl daemon-reload for setting up waagent-network-setup.service Jan 28 01:25:11.437149 systemd[1]: Reloading requested from client PID 1907 ('systemctl') (unit waagent.service)... Jan 28 01:25:11.437158 systemd[1]: Reloading... Jan 28 01:25:11.521507 zram_generator::config[1941]: No configuration found. Jan 28 01:25:11.621422 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 28 01:25:11.695235 systemd[1]: Reloading finished in 257 ms. Jan 28 01:25:11.719816 waagent[1804]: 2026-01-28T01:25:11.719732Z INFO ExtHandler ExtHandler Successfully added and enabled the waagent-network-setup.service Jan 28 01:25:11.719926 waagent[1804]: 2026-01-28T01:25:11.719899Z INFO ExtHandler ExtHandler Persistent firewall rules setup successfully Jan 28 01:25:12.113558 waagent[1804]: 2026-01-28T01:25:12.112858Z INFO ExtHandler ExtHandler DROP rule is not available which implies no firewall rules are set yet. Environment thread will set it up. Jan 28 01:25:12.113558 waagent[1804]: 2026-01-28T01:25:12.113459Z 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 28 01:25:12.114325 waagent[1804]: 2026-01-28T01:25:12.114223Z INFO ExtHandler ExtHandler Starting env monitor service. Jan 28 01:25:12.114690 waagent[1804]: 2026-01-28T01:25:12.114618Z INFO ExtHandler ExtHandler Start SendTelemetryHandler service. Jan 28 01:25:12.114921 waagent[1804]: 2026-01-28T01:25:12.114873Z INFO MonitorHandler ExtHandler WireServer endpoint 168.63.129.16 read from file Jan 28 01:25:12.115138 waagent[1804]: 2026-01-28T01:25:12.115084Z INFO SendTelemetryHandler ExtHandler Successfully started the SendTelemetryHandler thread Jan 28 01:25:12.115288 waagent[1804]: 2026-01-28T01:25:12.115218Z INFO ExtHandler ExtHandler Start Extension Telemetry service. Jan 28 01:25:12.115712 waagent[1804]: 2026-01-28T01:25:12.115584Z INFO TelemetryEventsCollector ExtHandler Extension Telemetry pipeline enabled: True Jan 28 01:25:12.115816 waagent[1804]: 2026-01-28T01:25:12.115717Z INFO ExtHandler ExtHandler Goal State Period: 6 sec. This indicates how often the agent checks for new goal states and reports status. Jan 28 01:25:12.116563 waagent[1804]: 2026-01-28T01:25:12.116425Z INFO MonitorHandler ExtHandler Wire server endpoint:168.63.129.16 Jan 28 01:25:12.116767 waagent[1804]: 2026-01-28T01:25:12.116656Z INFO TelemetryEventsCollector ExtHandler Successfully started the TelemetryEventsCollector thread Jan 28 01:25:12.116902 waagent[1804]: 2026-01-28T01:25:12.116831Z INFO EnvHandler ExtHandler WireServer endpoint 168.63.129.16 read from file Jan 28 01:25:12.117266 waagent[1804]: 2026-01-28T01:25:12.117160Z INFO MonitorHandler ExtHandler Monitor.NetworkConfigurationChanges is disabled. Jan 28 01:25:12.117684 waagent[1804]: 2026-01-28T01:25:12.117566Z INFO EnvHandler ExtHandler Wire server endpoint:168.63.129.16 Jan 28 01:25:12.117887 waagent[1804]: 2026-01-28T01:25:12.117786Z INFO EnvHandler ExtHandler Configure routes Jan 28 01:25:12.118338 waagent[1804]: 2026-01-28T01:25:12.118228Z INFO EnvHandler ExtHandler Gateway:None Jan 28 01:25:12.118386 waagent[1804]: 2026-01-28T01:25:12.118359Z INFO EnvHandler ExtHandler Routes:None Jan 28 01:25:12.118858 waagent[1804]: 2026-01-28T01:25:12.118807Z INFO MonitorHandler ExtHandler Routing table from /proc/net/route: Jan 28 01:25:12.118858 waagent[1804]: Iface Destination Gateway Flags RefCnt Use Metric Mask MTU Window IRTT Jan 28 01:25:12.118858 waagent[1804]: eth0 00000000 0114C80A 0003 0 0 1024 00000000 0 0 0 Jan 28 01:25:12.118858 waagent[1804]: eth0 0014C80A 00000000 0001 0 0 1024 00FFFFFF 0 0 0 Jan 28 01:25:12.118858 waagent[1804]: eth0 0114C80A 00000000 0005 0 0 1024 FFFFFFFF 0 0 0 Jan 28 01:25:12.118858 waagent[1804]: eth0 10813FA8 0114C80A 0007 0 0 1024 FFFFFFFF 0 0 0 Jan 28 01:25:12.118858 waagent[1804]: eth0 FEA9FEA9 0114C80A 0007 0 0 1024 FFFFFFFF 0 0 0 Jan 28 01:25:12.123239 waagent[1804]: 2026-01-28T01:25:12.123131Z INFO ExtHandler ExtHandler Jan 28 01:25:12.123730 waagent[1804]: 2026-01-28T01:25:12.123659Z INFO ExtHandler ExtHandler ProcessExtensionsGoalState started [incarnation_1 channel: WireServer source: Fabric activity: 5f938705-e81b-40b2-96f9-c234b12fc846 correlation d383f27d-788d-4d4f-9c40-2c00a76a5806 created: 2026-01-28T01:24:12.253105Z] Jan 28 01:25:12.126412 waagent[1804]: 2026-01-28T01:25:12.124398Z INFO ExtHandler ExtHandler No extension handlers found, not processing anything. Jan 28 01:25:12.128968 waagent[1804]: 2026-01-28T01:25:12.128103Z INFO ExtHandler ExtHandler ProcessExtensionsGoalState completed [incarnation_1 4 ms] Jan 28 01:25:12.164547 waagent[1804]: 2026-01-28T01:25:12.164461Z INFO ExtHandler ExtHandler [HEARTBEAT] Agent WALinuxAgent-2.9.1.1 is running as the goal state agent [DEBUG HeartbeatCounter: 0;HeartbeatId: 41F8F031-3F3F-496C-947C-E289BB4D51CB;DroppedPackets: 0;UpdateGSErrors: 0;AutoUpdate: 0] Jan 28 01:25:12.172638 waagent[1804]: 2026-01-28T01:25:12.172567Z INFO MonitorHandler ExtHandler Network interfaces: Jan 28 01:25:12.172638 waagent[1804]: Executing ['ip', '-a', '-o', 'link']: Jan 28 01:25:12.172638 waagent[1804]: 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 28 01:25:12.172638 waagent[1804]: 2: eth0: mtu 1500 qdisc mq state UP mode DEFAULT group default qlen 1000\ link/ether 00:22:48:78:34:98 brd ff:ff:ff:ff:ff:ff Jan 28 01:25:12.172638 waagent[1804]: 3: enP22845s1: mtu 1500 qdisc mq master eth0 state UP mode DEFAULT group default qlen 1000\ link/ether 00:22:48:78:34:98 brd ff:ff:ff:ff:ff:ff\ altname enP22845p0s2 Jan 28 01:25:12.172638 waagent[1804]: Executing ['ip', '-4', '-a', '-o', 'address']: Jan 28 01:25:12.172638 waagent[1804]: 1: lo inet 127.0.0.1/8 scope host lo\ valid_lft forever preferred_lft forever Jan 28 01:25:12.172638 waagent[1804]: 2: eth0 inet 10.200.20.29/24 metric 1024 brd 10.200.20.255 scope global eth0\ valid_lft forever preferred_lft forever Jan 28 01:25:12.172638 waagent[1804]: Executing ['ip', '-6', '-a', '-o', 'address']: Jan 28 01:25:12.172638 waagent[1804]: 1: lo inet6 ::1/128 scope host noprefixroute \ valid_lft forever preferred_lft forever Jan 28 01:25:12.172638 waagent[1804]: 2: eth0 inet6 fe80::222:48ff:fe78:3498/64 scope link proto kernel_ll \ valid_lft forever preferred_lft forever Jan 28 01:25:12.227734 waagent[1804]: 2026-01-28T01:25:12.227663Z INFO EnvHandler ExtHandler Successfully added Azure fabric firewall rules. Current Firewall rules: Jan 28 01:25:12.227734 waagent[1804]: Chain INPUT (policy ACCEPT 0 packets, 0 bytes) Jan 28 01:25:12.227734 waagent[1804]: pkts bytes target prot opt in out source destination Jan 28 01:25:12.227734 waagent[1804]: Chain FORWARD (policy ACCEPT 0 packets, 0 bytes) Jan 28 01:25:12.227734 waagent[1804]: pkts bytes target prot opt in out source destination Jan 28 01:25:12.227734 waagent[1804]: Chain OUTPUT (policy ACCEPT 0 packets, 0 bytes) Jan 28 01:25:12.227734 waagent[1804]: pkts bytes target prot opt in out source destination Jan 28 01:25:12.227734 waagent[1804]: 0 0 ACCEPT tcp -- * * 0.0.0.0/0 168.63.129.16 tcp dpt:53 Jan 28 01:25:12.227734 waagent[1804]: 4 594 ACCEPT tcp -- * * 0.0.0.0/0 168.63.129.16 owner UID match 0 Jan 28 01:25:12.227734 waagent[1804]: 0 0 DROP tcp -- * * 0.0.0.0/0 168.63.129.16 ctstate INVALID,NEW Jan 28 01:25:12.231229 waagent[1804]: 2026-01-28T01:25:12.231155Z INFO EnvHandler ExtHandler Current Firewall rules: Jan 28 01:25:12.231229 waagent[1804]: Chain INPUT (policy ACCEPT 0 packets, 0 bytes) Jan 28 01:25:12.231229 waagent[1804]: pkts bytes target prot opt in out source destination Jan 28 01:25:12.231229 waagent[1804]: Chain FORWARD (policy ACCEPT 0 packets, 0 bytes) Jan 28 01:25:12.231229 waagent[1804]: pkts bytes target prot opt in out source destination Jan 28 01:25:12.231229 waagent[1804]: Chain OUTPUT (policy ACCEPT 0 packets, 0 bytes) Jan 28 01:25:12.231229 waagent[1804]: pkts bytes target prot opt in out source destination Jan 28 01:25:12.231229 waagent[1804]: 0 0 ACCEPT tcp -- * * 0.0.0.0/0 168.63.129.16 tcp dpt:53 Jan 28 01:25:12.231229 waagent[1804]: 5 646 ACCEPT tcp -- * * 0.0.0.0/0 168.63.129.16 owner UID match 0 Jan 28 01:25:12.231229 waagent[1804]: 0 0 DROP tcp -- * * 0.0.0.0/0 168.63.129.16 ctstate INVALID,NEW Jan 28 01:25:12.231544 waagent[1804]: 2026-01-28T01:25:12.231455Z INFO EnvHandler ExtHandler Set block dev timeout: sda with timeout: 300 Jan 28 01:25:28.580505 systemd[1]: Created slice system-sshd.slice - Slice /system/sshd. Jan 28 01:25:28.581638 systemd[1]: Started sshd@0-10.200.20.29:22-10.200.16.10:34270.service - OpenSSH per-connection server daemon (10.200.16.10:34270). Jan 28 01:25:29.160035 sshd[2027]: Accepted publickey for core from 10.200.16.10 port 34270 ssh2: RSA SHA256:mt/Wq3KIKwIer9YIq1LQuVz4zsibJKOQxGgoJKvjdGI Jan 28 01:25:29.161341 sshd[2027]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Jan 28 01:25:29.165185 systemd-logind[1622]: New session 3 of user core. Jan 28 01:25:29.173619 systemd[1]: Started session-3.scope - Session 3 of User core. Jan 28 01:25:29.268236 chronyd[1608]: Selected source PHC0 Jan 28 01:25:29.588632 systemd[1]: Started sshd@1-10.200.20.29:22-10.200.16.10:45202.service - OpenSSH per-connection server daemon (10.200.16.10:45202). Jan 28 01:25:30.036128 sshd[2032]: Accepted publickey for core from 10.200.16.10 port 45202 ssh2: RSA SHA256:mt/Wq3KIKwIer9YIq1LQuVz4zsibJKOQxGgoJKvjdGI Jan 28 01:25:30.037451 sshd[2032]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Jan 28 01:25:30.042467 systemd-logind[1622]: New session 4 of user core. Jan 28 01:25:30.048642 systemd[1]: Started session-4.scope - Session 4 of User core. Jan 28 01:25:30.370942 sshd[2032]: pam_unix(sshd:session): session closed for user core Jan 28 01:25:30.374845 systemd[1]: sshd@1-10.200.20.29:22-10.200.16.10:45202.service: Deactivated successfully. Jan 28 01:25:30.376281 systemd[1]: session-4.scope: Deactivated successfully. Jan 28 01:25:30.376864 systemd-logind[1622]: Session 4 logged out. Waiting for processes to exit. Jan 28 01:25:30.377654 systemd-logind[1622]: Removed session 4. Jan 28 01:25:30.451859 systemd[1]: Started sshd@2-10.200.20.29:22-10.200.16.10:45210.service - OpenSSH per-connection server daemon (10.200.16.10:45210). Jan 28 01:25:30.899439 sshd[2039]: Accepted publickey for core from 10.200.16.10 port 45210 ssh2: RSA SHA256:mt/Wq3KIKwIer9YIq1LQuVz4zsibJKOQxGgoJKvjdGI Jan 28 01:25:30.900776 sshd[2039]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Jan 28 01:25:30.905416 systemd-logind[1622]: New session 5 of user core. Jan 28 01:25:30.910653 systemd[1]: Started session-5.scope - Session 5 of User core. Jan 28 01:25:31.229843 sshd[2039]: pam_unix(sshd:session): session closed for user core Jan 28 01:25:31.233963 systemd[1]: sshd@2-10.200.20.29:22-10.200.16.10:45210.service: Deactivated successfully. Jan 28 01:25:31.235419 systemd[1]: session-5.scope: Deactivated successfully. Jan 28 01:25:31.236232 systemd-logind[1622]: Session 5 logged out. Waiting for processes to exit. Jan 28 01:25:31.237152 systemd-logind[1622]: Removed session 5. Jan 28 01:25:31.321718 systemd[1]: Started sshd@3-10.200.20.29:22-10.200.16.10:45222.service - OpenSSH per-connection server daemon (10.200.16.10:45222). Jan 28 01:25:31.801776 sshd[2046]: Accepted publickey for core from 10.200.16.10 port 45222 ssh2: RSA SHA256:mt/Wq3KIKwIer9YIq1LQuVz4zsibJKOQxGgoJKvjdGI Jan 28 01:25:31.803074 sshd[2046]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Jan 28 01:25:31.806662 systemd-logind[1622]: New session 6 of user core. Jan 28 01:25:31.815648 systemd[1]: Started session-6.scope - Session 6 of User core. Jan 28 01:25:32.154248 sshd[2046]: pam_unix(sshd:session): session closed for user core Jan 28 01:25:32.157610 systemd[1]: sshd@3-10.200.20.29:22-10.200.16.10:45222.service: Deactivated successfully. Jan 28 01:25:32.159235 systemd[1]: session-6.scope: Deactivated successfully. Jan 28 01:25:32.161726 systemd-logind[1622]: Session 6 logged out. Waiting for processes to exit. Jan 28 01:25:32.162639 systemd-logind[1622]: Removed session 6. Jan 28 01:25:32.246705 systemd[1]: Started sshd@4-10.200.20.29:22-10.200.16.10:45238.service - OpenSSH per-connection server daemon (10.200.16.10:45238). Jan 28 01:25:32.726081 sshd[2053]: Accepted publickey for core from 10.200.16.10 port 45238 ssh2: RSA SHA256:mt/Wq3KIKwIer9YIq1LQuVz4zsibJKOQxGgoJKvjdGI Jan 28 01:25:32.727379 sshd[2053]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Jan 28 01:25:32.731135 systemd-logind[1622]: New session 7 of user core. Jan 28 01:25:32.738632 systemd[1]: Started session-7.scope - Session 7 of User core. Jan 28 01:25:33.165995 sudo[2056]: core : PWD=/home/core ; USER=root ; COMMAND=/usr/sbin/setenforce 1 Jan 28 01:25:33.166275 sudo[2056]: pam_unix(sudo:session): session opened for user root(uid=0) by core(uid=500) Jan 28 01:25:33.194262 sudo[2056]: pam_unix(sudo:session): session closed for user root Jan 28 01:25:33.271957 sshd[2053]: pam_unix(sshd:session): session closed for user core Jan 28 01:25:33.275679 systemd[1]: sshd@4-10.200.20.29:22-10.200.16.10:45238.service: Deactivated successfully. Jan 28 01:25:33.277280 systemd[1]: session-7.scope: Deactivated successfully. Jan 28 01:25:33.278000 systemd-logind[1622]: Session 7 logged out. Waiting for processes to exit. Jan 28 01:25:33.278986 systemd-logind[1622]: Removed session 7. Jan 28 01:25:33.362517 systemd[1]: Started sshd@5-10.200.20.29:22-10.200.16.10:45240.service - OpenSSH per-connection server daemon (10.200.16.10:45240). Jan 28 01:25:33.845808 sshd[2061]: Accepted publickey for core from 10.200.16.10 port 45240 ssh2: RSA SHA256:mt/Wq3KIKwIer9YIq1LQuVz4zsibJKOQxGgoJKvjdGI Jan 28 01:25:33.847161 sshd[2061]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Jan 28 01:25:33.850797 systemd-logind[1622]: New session 8 of user core. Jan 28 01:25:33.861652 systemd[1]: Started session-8.scope - Session 8 of User core. Jan 28 01:25:34.120035 sudo[2065]: 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 28 01:25:34.120370 sudo[2065]: pam_unix(sudo:session): session opened for user root(uid=0) by core(uid=500) Jan 28 01:25:34.123848 sudo[2065]: pam_unix(sudo:session): session closed for user root Jan 28 01:25:34.128471 sudo[2064]: core : PWD=/home/core ; USER=root ; COMMAND=/usr/bin/systemctl restart audit-rules Jan 28 01:25:34.128802 sudo[2064]: pam_unix(sudo:session): session opened for user root(uid=0) by core(uid=500) Jan 28 01:25:34.142938 systemd[1]: Stopping audit-rules.service - Load Security Auditing Rules... Jan 28 01:25:34.143853 auditctl[2068]: No rules Jan 28 01:25:34.144146 systemd[1]: audit-rules.service: Deactivated successfully. Jan 28 01:25:34.144310 systemd[1]: Stopped audit-rules.service - Load Security Auditing Rules. Jan 28 01:25:34.152874 systemd[1]: Starting audit-rules.service - Load Security Auditing Rules... Jan 28 01:25:34.172837 augenrules[2086]: No rules Jan 28 01:25:34.174421 systemd[1]: Finished audit-rules.service - Load Security Auditing Rules. Jan 28 01:25:34.176050 sudo[2064]: pam_unix(sudo:session): session closed for user root Jan 28 01:25:34.253550 sshd[2061]: pam_unix(sshd:session): session closed for user core Jan 28 01:25:34.257363 systemd-logind[1622]: Session 8 logged out. Waiting for processes to exit. Jan 28 01:25:34.258307 systemd[1]: sshd@5-10.200.20.29:22-10.200.16.10:45240.service: Deactivated successfully. Jan 28 01:25:34.260058 systemd[1]: session-8.scope: Deactivated successfully. Jan 28 01:25:34.261134 systemd-logind[1622]: Removed session 8. Jan 28 01:25:34.342685 systemd[1]: Started sshd@6-10.200.20.29:22-10.200.16.10:45250.service - OpenSSH per-connection server daemon (10.200.16.10:45250). Jan 28 01:25:34.827545 sshd[2094]: Accepted publickey for core from 10.200.16.10 port 45250 ssh2: RSA SHA256:mt/Wq3KIKwIer9YIq1LQuVz4zsibJKOQxGgoJKvjdGI Jan 28 01:25:34.828910 sshd[2094]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Jan 28 01:25:34.832654 systemd-logind[1622]: New session 9 of user core. Jan 28 01:25:34.839605 systemd[1]: Started session-9.scope - Session 9 of User core. Jan 28 01:25:35.102863 sudo[2097]: core : PWD=/home/core ; USER=root ; COMMAND=/usr/bin/mkdir -p . Jan 28 01:25:35.103122 sudo[2097]: pam_unix(sudo:session): session opened for user root(uid=0) by core(uid=500) Jan 28 01:25:35.106212 sudo[2097]: pam_unix(sudo:session): session closed for user root Jan 28 01:25:35.183679 sshd[2094]: pam_unix(sshd:session): session closed for user core Jan 28 01:25:35.186831 systemd[1]: sshd@6-10.200.20.29:22-10.200.16.10:45250.service: Deactivated successfully. Jan 28 01:25:35.188265 systemd[1]: session-9.scope: Deactivated successfully. Jan 28 01:25:35.188884 systemd-logind[1622]: Session 9 logged out. Waiting for processes to exit. Jan 28 01:25:35.189874 systemd-logind[1622]: Removed session 9. Jan 28 01:25:35.270767 systemd[1]: Started sshd@7-10.200.20.29:22-10.200.16.10:45254.service - OpenSSH per-connection server daemon (10.200.16.10:45254). Jan 28 01:25:35.755082 sshd[2102]: Accepted publickey for core from 10.200.16.10 port 45254 ssh2: RSA SHA256:mt/Wq3KIKwIer9YIq1LQuVz4zsibJKOQxGgoJKvjdGI Jan 28 01:25:35.756686 sshd[2102]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Jan 28 01:25:35.760071 systemd-logind[1622]: New session 10 of user core. Jan 28 01:25:35.770611 systemd[1]: Started session-10.scope - Session 10 of User core. Jan 28 01:25:36.030867 sudo[2105]: core : PWD=/home/core ; USER=root ; COMMAND=/usr/bin/install -m 0755 /dev/stdin kolet Jan 28 01:25:36.031126 sudo[2105]: pam_unix(sudo:session): session opened for user root(uid=0) by core(uid=500) Jan 28 01:25:38.534045 sudo[2105]: pam_unix(sudo:session): session closed for user root Jan 28 01:25:38.610752 sshd[2102]: pam_unix(sshd:session): session closed for user core Jan 28 01:25:38.613986 systemd-logind[1622]: Session 10 logged out. Waiting for processes to exit. Jan 28 01:25:38.614788 systemd[1]: sshd@7-10.200.20.29:22-10.200.16.10:45254.service: Deactivated successfully. Jan 28 01:25:38.616602 systemd[1]: session-10.scope: Deactivated successfully. Jan 28 01:25:38.619342 systemd-logind[1622]: Removed session 10. Jan 28 01:25:38.699680 systemd[1]: Started sshd@8-10.200.20.29:22-10.200.16.10:45258.service - OpenSSH per-connection server daemon (10.200.16.10:45258). Jan 28 01:25:39.185494 sshd[2110]: Accepted publickey for core from 10.200.16.10 port 45258 ssh2: RSA SHA256:mt/Wq3KIKwIer9YIq1LQuVz4zsibJKOQxGgoJKvjdGI Jan 28 01:25:39.188345 sshd[2110]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Jan 28 01:25:39.191852 systemd-logind[1622]: New session 11 of user core. Jan 28 01:25:39.201685 systemd[1]: Started session-11.scope - Session 11 of User core. Jan 28 01:25:39.480609 sudo[2119]: core : PWD=/home/core ; USER=root ; COMMAND=/usr/bin/coreos-cloudinit --workspace /tmp/coretest-cloudinit-1373527673 --from-file /tmp/coretest-935092682 --ssh-key-name coretest Jan 28 01:25:39.480877 sudo[2119]: pam_unix(sudo:session): session opened for user root(uid=0) by core(uid=500) Jan 28 01:25:39.721105 systemd[1]: Reloading requested from client PID 2120 ('coreos-cloudini') (unit session-11.scope)... Jan 28 01:25:39.721387 systemd[1]: Reloading... Jan 28 01:25:39.798288 zram_generator::config[2163]: No configuration found. Jan 28 01:25:39.897777 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 28 01:25:39.972990 systemd[1]: Reloading finished in 251 ms. Jan 28 01:25:39.996174 sudo[2119]: pam_unix(sudo:session): session closed for user root Jan 28 01:25:40.024391 sudo[2218]: core : PWD=/home/core ; USER=root ; COMMAND=/usr/bin/rm -rf /tmp/coretest-cloudinit-1373527673 Jan 28 01:25:40.025001 sudo[2218]: pam_unix(sudo:session): session opened for user root(uid=0) by core(uid=500) Jan 28 01:25:40.027752 sudo[2218]: pam_unix(sudo:session): session closed for user root Jan 28 01:25:40.106995 sshd[2110]: pam_unix(sshd:session): session closed for user core Jan 28 01:25:40.110190 systemd[1]: sshd@8-10.200.20.29:22-10.200.16.10:45258.service: Deactivated successfully. Jan 28 01:25:40.111666 systemd[1]: session-11.scope: Deactivated successfully. Jan 28 01:25:40.112243 systemd-logind[1622]: Session 11 logged out. Waiting for processes to exit. Jan 28 01:25:40.113211 systemd-logind[1622]: Removed session 11. Jan 28 01:25:40.209732 systemd[1]: Started sshd@9-10.200.20.29:22-10.200.16.10:57034.service - OpenSSH per-connection server daemon (10.200.16.10:57034). Jan 28 01:25:40.654680 sshd[2223]: Accepted publickey for core from 10.200.16.10 port 57034 ssh2: RSA SHA256:mt/Wq3KIKwIer9YIq1LQuVz4zsibJKOQxGgoJKvjdGI Jan 28 01:25:40.655940 sshd[2223]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Jan 28 01:25:40.660563 systemd-logind[1622]: New session 12 of user core. Jan 28 01:25:40.665647 systemd[1]: Started session-12.scope - Session 12 of User core. Jan 28 01:25:40.934972 systemd[1]: Started sshd@10-127.0.0.1:22-127.0.0.1:44378.service - OpenSSH per-connection server daemon (127.0.0.1:44378). Jan 28 01:25:40.947568 sshd[2232]: Connection closed by 127.0.0.1 port 44378 Jan 28 01:25:40.948771 systemd[1]: sshd@10-127.0.0.1:22-127.0.0.1:44378.service: Deactivated successfully. Jan 28 01:25:41.002511 sshd[2223]: pam_unix(sshd:session): session closed for user core Jan 28 01:25:41.005030 systemd[1]: sshd@9-10.200.20.29:22-10.200.16.10:57034.service: Deactivated successfully. Jan 28 01:25:41.006960 systemd[1]: session-12.scope: Deactivated successfully. Jan 28 01:25:41.008361 systemd-logind[1622]: Session 12 logged out. Waiting for processes to exit. Jan 28 01:25:41.009767 systemd-logind[1622]: Removed session 12. Jan 28 01:25:41.090802 systemd[1]: Started sshd@11-10.200.20.29:22-10.200.16.10:57050.service - OpenSSH per-connection server daemon (10.200.16.10:57050). Jan 28 01:25:41.531533 sshd[2238]: Accepted publickey for core from 10.200.16.10 port 57050 ssh2: RSA SHA256:mt/Wq3KIKwIer9YIq1LQuVz4zsibJKOQxGgoJKvjdGI Jan 28 01:25:41.532831 sshd[2238]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Jan 28 01:25:41.537453 systemd-logind[1622]: New session 13 of user core. Jan 28 01:25:41.543657 systemd[1]: Started session-13.scope - Session 13 of User core. Jan 28 01:25:41.908940 sshd[2238]: pam_unix(sshd:session): session closed for user core Jan 28 01:25:41.911959 systemd-logind[1622]: Session 13 logged out. Waiting for processes to exit. Jan 28 01:25:41.913372 systemd[1]: sshd@11-10.200.20.29:22-10.200.16.10:57050.service: Deactivated successfully. Jan 28 01:25:41.915082 systemd[1]: session-13.scope: Deactivated successfully. Jan 28 01:25:41.917195 systemd-logind[1622]: Removed session 13. Jan 28 01:25:41.990549 systemd[1]: Started sshd@12-10.200.20.29:22-10.200.16.10:57060.service - OpenSSH per-connection server daemon (10.200.16.10:57060). Jan 28 01:25:42.431834 sshd[2248]: Accepted publickey for core from 10.200.16.10 port 57060 ssh2: RSA SHA256:mt/Wq3KIKwIer9YIq1LQuVz4zsibJKOQxGgoJKvjdGI Jan 28 01:25:42.433132 sshd[2248]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Jan 28 01:25:42.437679 systemd-logind[1622]: New session 14 of user core. Jan 28 01:25:42.441688 systemd[1]: Started session-14.scope - Session 14 of User core. Jan 28 01:25:42.811848 sshd[2248]: pam_unix(sshd:session): session closed for user core Jan 28 01:25:42.814473 systemd[1]: sshd@12-10.200.20.29:22-10.200.16.10:57060.service: Deactivated successfully. Jan 28 01:25:42.816203 systemd[1]: session-14.scope: Deactivated successfully. Jan 28 01:25:42.817599 systemd-logind[1622]: Session 14 logged out. Waiting for processes to exit. Jan 28 01:25:42.818703 systemd-logind[1622]: Removed session 14. Jan 28 01:25:42.899389 systemd[1]: Started sshd@13-10.200.20.29:22-10.200.16.10:57076.service - OpenSSH per-connection server daemon (10.200.16.10:57076). Jan 28 01:25:43.380539 sshd[2258]: Accepted publickey for core from 10.200.16.10 port 57076 ssh2: RSA SHA256:mt/Wq3KIKwIer9YIq1LQuVz4zsibJKOQxGgoJKvjdGI Jan 28 01:25:43.381836 sshd[2258]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Jan 28 01:25:43.385430 systemd-logind[1622]: New session 15 of user core. Jan 28 01:25:43.391686 systemd[1]: Started session-15.scope - Session 15 of User core. Jan 28 01:25:43.766617 sshd[2258]: pam_unix(sshd:session): session closed for user core Jan 28 01:25:43.769649 systemd-logind[1622]: Session 15 logged out. Waiting for processes to exit. Jan 28 01:25:43.770605 systemd[1]: sshd@13-10.200.20.29:22-10.200.16.10:57076.service: Deactivated successfully. Jan 28 01:25:43.772203 systemd[1]: session-15.scope: Deactivated successfully. Jan 28 01:25:43.773266 systemd-logind[1622]: Removed session 15. Jan 28 01:25:43.864596 systemd[1]: Started sshd@14-10.200.20.29:22-10.200.16.10:57080.service - OpenSSH per-connection server daemon (10.200.16.10:57080). Jan 28 01:25:44.348445 sshd[2275]: Accepted publickey for core from 10.200.16.10 port 57080 ssh2: RSA SHA256:mt/Wq3KIKwIer9YIq1LQuVz4zsibJKOQxGgoJKvjdGI Jan 28 01:25:44.349798 sshd[2275]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Jan 28 01:25:44.354373 systemd-logind[1622]: New session 16 of user core. Jan 28 01:25:44.364655 systemd[1]: Started session-16.scope - Session 16 of User core. Jan 28 01:25:44.715782 sshd[2275]: pam_unix(sshd:session): session closed for user core Jan 28 01:25:44.718996 systemd[1]: sshd@14-10.200.20.29:22-10.200.16.10:57080.service: Deactivated successfully. Jan 28 01:25:44.720757 systemd[1]: session-16.scope: Deactivated successfully. Jan 28 01:25:44.721582 systemd-logind[1622]: Session 16 logged out. Waiting for processes to exit. Jan 28 01:25:44.722331 systemd-logind[1622]: Removed session 16. Jan 28 01:25:44.803369 systemd[1]: Started sshd@15-10.200.20.29:22-10.200.16.10:57094.service - OpenSSH per-connection server daemon (10.200.16.10:57094). Jan 28 01:25:45.284012 sshd[2286]: Accepted publickey for core from 10.200.16.10 port 57094 ssh2: RSA SHA256:mt/Wq3KIKwIer9YIq1LQuVz4zsibJKOQxGgoJKvjdGI Jan 28 01:25:45.285332 sshd[2286]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Jan 28 01:25:45.289300 systemd-logind[1622]: New session 17 of user core. Jan 28 01:25:45.295629 systemd[1]: Started session-17.scope - Session 17 of User core. Jan 28 01:25:45.651361 sshd[2286]: pam_unix(sshd:session): session closed for user core Jan 28 01:25:45.654989 systemd[1]: sshd@15-10.200.20.29:22-10.200.16.10:57094.service: Deactivated successfully. Jan 28 01:25:45.658748 systemd[1]: session-17.scope: Deactivated successfully. Jan 28 01:25:45.659448 systemd-logind[1622]: Session 17 logged out. Waiting for processes to exit. Jan 28 01:25:45.660850 systemd-logind[1622]: Removed session 17. Jan 28 01:25:45.739269 systemd[1]: Started sshd@16-10.200.20.29:22-10.200.16.10:57110.service - OpenSSH per-connection server daemon (10.200.16.10:57110). Jan 28 01:25:46.224986 sshd[2299]: Accepted publickey for core from 10.200.16.10 port 57110 ssh2: RSA SHA256:mt/Wq3KIKwIer9YIq1LQuVz4zsibJKOQxGgoJKvjdGI Jan 28 01:25:46.226293 sshd[2299]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Jan 28 01:25:46.229889 systemd-logind[1622]: New session 18 of user core. Jan 28 01:25:46.241942 systemd[1]: Started session-18.scope - Session 18 of User core. Jan 28 01:25:46.520608 sudo[2309]: core : PWD=/home/core ; USER=root ; COMMAND=/usr/bin/coreos-cloudinit --workspace /tmp/coretest-cloudinit-1036759815 --from-file /tmp/coretest-735381941 Jan 28 01:25:46.520872 sudo[2309]: pam_unix(sudo:session): session opened for user root(uid=0) by core(uid=500) Jan 28 01:25:46.533695 systemd[1]: Started coreos-cloudinit-2485145928.service - Unit generated and executed by coreos-cloudinit on behalf of user. Jan 28 01:25:46.537688 sudo[2309]: pam_unix(sudo:session): session closed for user root Jan 28 01:25:46.550017 dbus-daemon[1602]: [system] Activating via systemd: service name='org.freedesktop.PolicyKit1' unit='polkit.service' requested by ':1.5' (uid=0 pid=1 comm="/usr/lib/systemd/systemd --switched-root --system" label="system_u:system_r:kernel_t:s0") Jan 28 01:25:46.561702 systemd[1]: Starting polkit.service - Authorization Manager... Jan 28 01:25:46.585196 polkitd[2319]: Started polkitd version 121 Jan 28 01:25:46.588978 polkitd[2319]: Loading rules from directory /etc/polkit-1/rules.d Jan 28 01:25:46.589147 polkitd[2319]: Loading rules from directory /usr/share/polkit-1/rules.d Jan 28 01:25:46.589592 polkitd[2319]: Finished loading, compiling and executing 2 rules Jan 28 01:25:46.590043 dbus-daemon[1602]: [system] Successfully activated service 'org.freedesktop.PolicyKit1' Jan 28 01:25:46.590276 systemd[1]: Started polkit.service - Authorization Manager. Jan 28 01:25:46.590770 polkitd[2319]: Acquired the name org.freedesktop.PolicyKit1 on the system bus Jan 28 01:25:46.606163 sudo[2329]: core : PWD=/home/core ; USER=root ; COMMAND=/usr/bin/rm -rf /tmp/coretest-cloudinit-1036759815 Jan 28 01:25:46.606425 sudo[2329]: pam_unix(sudo:session): session opened for user root(uid=0) by core(uid=500) Jan 28 01:25:46.609845 sudo[2329]: pam_unix(sudo:session): session closed for user root Jan 28 01:25:46.688740 sshd[2299]: pam_unix(sshd:session): session closed for user core Jan 28 01:25:46.692101 systemd[1]: sshd@16-10.200.20.29:22-10.200.16.10:57110.service: Deactivated successfully. Jan 28 01:25:46.693545 systemd[1]: session-18.scope: Deactivated successfully. Jan 28 01:25:46.694629 systemd-logind[1622]: Session 18 logged out. Waiting for processes to exit. Jan 28 01:25:46.696034 systemd-logind[1622]: Removed session 18. Jan 28 01:25:46.770566 systemd[1]: Started sshd@17-10.200.20.29:22-10.200.16.10:57116.service - OpenSSH per-connection server daemon (10.200.16.10:57116). Jan 28 01:25:47.218064 sshd[2334]: Accepted publickey for core from 10.200.16.10 port 57116 ssh2: RSA SHA256:mt/Wq3KIKwIer9YIq1LQuVz4zsibJKOQxGgoJKvjdGI Jan 28 01:25:47.219501 sshd[2334]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Jan 28 01:25:47.222962 systemd-logind[1622]: New session 19 of user core. Jan 28 01:25:47.232636 systemd[1]: Started session-19.scope - Session 19 of User core. Jan 28 01:25:47.495670 sudo[2343]: core : PWD=/home/core ; USER=core ; COMMAND=/usr/bin/gdbus call --system --dest org.freedesktop.systemd1 --object-path /org/freedesktop/systemd1 --method org.freedesktop.systemd1.Manager.RestartUnit ntpd.service replace Jan 28 01:25:47.496291 sudo[2343]: pam_unix(sudo:session): session opened for user core(uid=500) by core(uid=500) Jan 28 01:25:47.527270 sudo[2343]: pam_unix(sudo:session): session closed for user core Jan 28 01:25:47.532839 sudo[2350]: core : PWD=/home/core ; USER=core ; COMMAND=/usr/bin/gdbus call --system --dest org.freedesktop.systemd1 --object-path /org/freedesktop/systemd1/unit/ntpd_2eservice --method org.freedesktop.DBus.Properties.GetAll org.freedesktop.systemd1.Unit Jan 28 01:25:47.533422 sudo[2350]: pam_unix(sudo:session): session opened for user core(uid=500) by core(uid=500) Jan 28 01:25:47.546892 sudo[2350]: pam_unix(sudo:session): session closed for user core Jan 28 01:25:47.626631 sshd[2334]: pam_unix(sshd:session): session closed for user core Jan 28 01:25:47.629328 systemd-logind[1622]: Session 19 logged out. Waiting for processes to exit. Jan 28 01:25:47.630093 systemd[1]: sshd@17-10.200.20.29:22-10.200.16.10:57116.service: Deactivated successfully. Jan 28 01:25:47.631767 systemd[1]: session-19.scope: Deactivated successfully. Jan 28 01:25:47.634882 systemd-logind[1622]: Removed session 19. Jan 28 01:25:47.714966 systemd[1]: Started sshd@18-10.200.20.29:22-10.200.16.10:57132.service - OpenSSH per-connection server daemon (10.200.16.10:57132). Jan 28 01:25:48.202913 sshd[2358]: Accepted publickey for core from 10.200.16.10 port 57132 ssh2: RSA SHA256:mt/Wq3KIKwIer9YIq1LQuVz4zsibJKOQxGgoJKvjdGI Jan 28 01:25:48.204277 sshd[2358]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Jan 28 01:25:48.208044 systemd-logind[1622]: New session 20 of user core. Jan 28 01:25:48.217784 systemd[1]: Started session-20.scope - Session 20 of User core. Jan 28 01:25:48.573357 sshd[2358]: pam_unix(sshd:session): session closed for user core Jan 28 01:25:48.577337 systemd[1]: sshd@18-10.200.20.29:22-10.200.16.10:57132.service: Deactivated successfully. Jan 28 01:25:48.578803 systemd[1]: session-20.scope: Deactivated successfully. Jan 28 01:25:48.579374 systemd-logind[1622]: Session 20 logged out. Waiting for processes to exit. Jan 28 01:25:48.580396 systemd-logind[1622]: Removed session 20. Jan 28 01:25:48.622172 kernel: hv_balloon: Max. dynamic memory size: 4096 MB Jan 28 01:25:48.653839 systemd[1]: Started sshd@19-10.200.20.29:22-10.200.16.10:57144.service - OpenSSH per-connection server daemon (10.200.16.10:57144). Jan 28 01:25:49.100209 sshd[2370]: Accepted publickey for core from 10.200.16.10 port 57144 ssh2: RSA SHA256:mt/Wq3KIKwIer9YIq1LQuVz4zsibJKOQxGgoJKvjdGI Jan 28 01:25:49.101544 sshd[2370]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Jan 28 01:25:49.106409 systemd-logind[1622]: New session 21 of user core. Jan 28 01:25:49.112646 systemd[1]: Started session-21.scope - Session 21 of User core. Jan 28 01:25:49.398102 sudo[2379]: core : PWD=/home/core ; USER=root ; COMMAND=/usr/sbin/blkid -o value -s PTUUID /dev/sda Jan 28 01:25:49.398377 sudo[2379]: pam_unix(sudo:session): session opened for user root(uid=0) by core(uid=500) Jan 28 01:25:49.436164 sudo[2379]: pam_unix(sudo:session): session closed for user root Jan 28 01:25:49.514751 sshd[2370]: pam_unix(sshd:session): session closed for user core Jan 28 01:25:49.518215 systemd[1]: sshd@19-10.200.20.29:22-10.200.16.10:57144.service: Deactivated successfully. Jan 28 01:25:49.520038 systemd[1]: session-21.scope: Deactivated successfully. Jan 28 01:25:49.520828 systemd-logind[1622]: Session 21 logged out. Waiting for processes to exit. Jan 28 01:25:49.521811 systemd-logind[1622]: Removed session 21. Jan 28 01:25:49.595297 systemd[1]: Started sshd@20-10.200.20.29:22-10.200.16.10:60730.service - OpenSSH per-connection server daemon (10.200.16.10:60730). Jan 28 01:25:50.042323 sshd[2386]: Accepted publickey for core from 10.200.16.10 port 60730 ssh2: RSA SHA256:mt/Wq3KIKwIer9YIq1LQuVz4zsibJKOQxGgoJKvjdGI Jan 28 01:25:50.043674 sshd[2386]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Jan 28 01:25:50.047457 systemd-logind[1622]: New session 22 of user core. Jan 28 01:25:50.055634 systemd[1]: Started session-22.scope - Session 22 of User core. Jan 28 01:25:50.316513 sudo[2396]: core : PWD=/home/core ; USER=root ; COMMAND=/usr/sbin/useradd -p * -U -m user1 -G sudo Jan 28 01:25:50.316779 sudo[2396]: pam_unix(sudo:session): session opened for user root(uid=0) by core(uid=500) Jan 28 01:25:50.404227 useradd[2397]: new group: name=user1, GID=1000 Jan 28 01:25:50.404247 useradd[2397]: new user: name=user1, UID=1000, GID=1000, home=/home/user1, shell=/bin/bash, from=none Jan 28 01:25:50.405375 useradd[2397]: add 'user1' to group 'sudo' Jan 28 01:25:50.405382 useradd[2397]: add 'user1' to shadow group 'sudo' Jan 28 01:25:50.719724 update_engine[1624]: I20260128 01:25:50.719115 1624 update_attempter.cc:509] Updating boot flags... Jan 28 01:25:50.775563 kernel: BTRFS warning: duplicate device /dev/sda3 devid 1 generation 36 scanned by (udev-worker) (2413) Jan 28 01:25:50.780607 sudo[2396]: pam_unix(sudo:session): session closed for user root Jan 28 01:25:50.859719 kernel: BTRFS warning: duplicate device /dev/sda3 devid 1 generation 36 scanned by (udev-worker) (2414) Jan 28 01:25:50.897006 sshd[2386]: pam_unix(sshd:session): session closed for user core Jan 28 01:25:50.901834 systemd-logind[1622]: Session 22 logged out. Waiting for processes to exit. Jan 28 01:25:50.903730 systemd[1]: sshd@20-10.200.20.29:22-10.200.16.10:60730.service: Deactivated successfully. Jan 28 01:25:50.906325 systemd[1]: session-22.scope: Deactivated successfully. Jan 28 01:25:50.911504 systemd-logind[1622]: Removed session 22. Jan 28 01:25:50.978790 systemd[1]: Started sshd@21-10.200.20.29:22-10.200.16.10:60744.service - OpenSSH per-connection server daemon (10.200.16.10:60744). Jan 28 01:25:51.424041 sshd[2474]: Accepted publickey for core from 10.200.16.10 port 60744 ssh2: RSA SHA256:mt/Wq3KIKwIer9YIq1LQuVz4zsibJKOQxGgoJKvjdGI Jan 28 01:25:51.425378 sshd[2474]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Jan 28 01:25:51.430177 systemd-logind[1622]: New session 23 of user core. Jan 28 01:25:51.436655 systemd[1]: Started session-23.scope - Session 23 of User core. Jan 28 01:25:51.770512 sshd[2474]: pam_unix(sshd:session): session closed for user core Jan 28 01:25:51.773891 systemd[1]: sshd@21-10.200.20.29:22-10.200.16.10:60744.service: Deactivated successfully. Jan 28 01:25:51.775839 systemd[1]: session-23.scope: Deactivated successfully. Jan 28 01:25:51.776600 systemd-logind[1622]: Session 23 logged out. Waiting for processes to exit. Jan 28 01:25:51.777353 systemd-logind[1622]: Removed session 23.