Oct 16 23:36:02.227241 kernel: Booting Linux on physical CPU 0x0000000000 [0x413fd0c1] Oct 16 23:36:02.227263 kernel: Linux version 6.6.157-flatcar (build@pony-truck.infra.kinvolk.io) (aarch64-cros-linux-gnu-gcc (Gentoo Hardened 13.3.1_p20240614 p17) 13.3.1 20240614, GNU ld (Gentoo 2.42 p3) 2.42.0) #1 SMP PREEMPT Fri Oct 16 22:26:59 -00 2026 Oct 16 23:36:02.227270 kernel: KASLR enabled Oct 16 23:36:02.227276 kernel: earlycon: pl11 at MMIO 0x00000000effec000 (options '') Oct 16 23:36:02.227284 kernel: printk: bootconsole [pl11] enabled Oct 16 23:36:02.227289 kernel: efi: EFI v2.7 by EDK II Oct 16 23:36:02.227296 kernel: efi: ACPI 2.0=0x3fd5f018 SMBIOS=0x3e580000 SMBIOS 3.0=0x3e560000 MEMATTR=0x3f213018 RNG=0x3fd5f998 MEMRESERVE=0x3e44ee18 Oct 16 23:36:02.227303 kernel: random: crng init done Oct 16 23:36:02.227309 kernel: ACPI: Early table checksum verification disabled Oct 16 23:36:02.227314 kernel: ACPI: RSDP 0x000000003FD5F018 000024 (v02 VRTUAL) Oct 16 23:36:02.227321 kernel: ACPI: XSDT 0x000000003FD5FF18 00006C (v01 VRTUAL MICROSFT 00000001 MSFT 00000001) Oct 16 23:36:02.227327 kernel: ACPI: FACP 0x000000003FD5FC18 000114 (v06 VRTUAL MICROSFT 00000001 MSFT 00000001) Oct 16 23:36:02.227334 kernel: ACPI: DSDT 0x000000003FD41018 01DF7E (v02 MSFTVM DSDT01 00000001 INTL 20230628) Oct 16 23:36:02.227341 kernel: ACPI: DBG2 0x000000003FD5FB18 000072 (v00 VRTUAL MICROSFT 00000001 MSFT 00000001) Oct 16 23:36:02.227348 kernel: ACPI: GTDT 0x000000003FD5FD98 000060 (v02 VRTUAL MICROSFT 00000001 MSFT 00000001) Oct 16 23:36:02.227354 kernel: ACPI: OEM0 0x000000003FD5F098 000064 (v01 VRTUAL MICROSFT 00000001 MSFT 00000001) Oct 16 23:36:02.227361 kernel: ACPI: SPCR 0x000000003FD5FA98 000050 (v02 VRTUAL MICROSFT 00000001 MSFT 00000001) Oct 16 23:36:02.227369 kernel: ACPI: APIC 0x000000003FD5F818 0000FC (v04 VRTUAL MICROSFT 00000001 MSFT 00000001) Oct 16 23:36:02.227375 kernel: ACPI: SRAT 0x000000003FD5F198 000234 (v03 VRTUAL MICROSFT 00000001 MSFT 00000001) Oct 16 23:36:02.227381 kernel: ACPI: PPTT 0x000000003FD5F418 000120 (v01 VRTUAL MICROSFT 00000000 MSFT 00000000) Oct 16 23:36:02.227388 kernel: ACPI: BGRT 0x000000003FD5FE98 000038 (v01 VRTUAL MICROSFT 00000001 MSFT 00000001) Oct 16 23:36:02.227394 kernel: ACPI: SPCR: console: pl011,mmio32,0xeffec000,115200 Oct 16 23:36:02.227401 kernel: ACPI: SRAT: Node 0 PXM 0 [mem 0x00000000-0x3fffffff] Oct 16 23:36:02.227407 kernel: ACPI: SRAT: Node 0 PXM 0 [mem 0x100000000-0x1bfffffff] Oct 16 23:36:02.227413 kernel: ACPI: SRAT: Node 0 PXM 0 [mem 0x1c0000000-0xfbfffffff] Oct 16 23:36:02.227420 kernel: ACPI: SRAT: Node 0 PXM 0 [mem 0x1000000000-0xffffffffff] Oct 16 23:36:02.227426 kernel: ACPI: SRAT: Node 0 PXM 0 [mem 0x10000000000-0x1ffffffffff] Oct 16 23:36:02.227433 kernel: ACPI: SRAT: Node 0 PXM 0 [mem 0x20000000000-0x3ffffffffff] Oct 16 23:36:02.227441 kernel: ACPI: SRAT: Node 0 PXM 0 [mem 0x40000000000-0x7ffffffffff] Oct 16 23:36:02.227447 kernel: ACPI: SRAT: Node 0 PXM 0 [mem 0x80000000000-0xfffffffffff] Oct 16 23:36:02.227453 kernel: ACPI: SRAT: Node 0 PXM 0 [mem 0x100000000000-0x1fffffffffff] Oct 16 23:36:02.227460 kernel: ACPI: SRAT: Node 0 PXM 0 [mem 0x200000000000-0x3fffffffffff] Oct 16 23:36:02.227466 kernel: ACPI: SRAT: Node 0 PXM 0 [mem 0x400000000000-0x7fffffffffff] Oct 16 23:36:02.227473 kernel: ACPI: SRAT: Node 0 PXM 0 [mem 0x800000000000-0xffffffffffff] Oct 16 23:36:02.227479 kernel: NUMA: NODE_DATA [mem 0x1bf7ee800-0x1bf7f3fff] Oct 16 23:36:02.227485 kernel: Zone ranges: Oct 16 23:36:02.227492 kernel: DMA [mem 0x0000000000000000-0x00000000ffffffff] Oct 16 23:36:02.227498 kernel: DMA32 empty Oct 16 23:36:02.227504 kernel: Normal [mem 0x0000000100000000-0x00000001bfffffff] Oct 16 23:36:02.227511 kernel: Movable zone start for each node Oct 16 23:36:02.227521 kernel: Early memory node ranges Oct 16 23:36:02.227528 kernel: node 0: [mem 0x0000000000000000-0x00000000007fffff] Oct 16 23:36:02.227535 kernel: node 0: [mem 0x0000000000824000-0x000000003e54ffff] Oct 16 23:36:02.227541 kernel: node 0: [mem 0x000000003e550000-0x000000003e87ffff] Oct 16 23:36:02.227548 kernel: node 0: [mem 0x000000003e880000-0x000000003fc7ffff] Oct 16 23:36:02.227557 kernel: node 0: [mem 0x000000003fc80000-0x000000003fcfffff] Oct 16 23:36:02.227563 kernel: node 0: [mem 0x000000003fd00000-0x000000003fffffff] Oct 16 23:36:02.227570 kernel: node 0: [mem 0x0000000100000000-0x00000001bfffffff] Oct 16 23:36:02.227577 kernel: Initmem setup node 0 [mem 0x0000000000000000-0x00000001bfffffff] Oct 16 23:36:02.227584 kernel: On node 0, zone DMA: 36 pages in unavailable ranges Oct 16 23:36:02.227590 kernel: psci: probing for conduit method from ACPI. Oct 16 23:36:02.227597 kernel: psci: PSCIv1.1 detected in firmware. Oct 16 23:36:02.227604 kernel: psci: Using standard PSCI v0.2 function IDs Oct 16 23:36:02.227610 kernel: psci: MIGRATE_INFO_TYPE not supported. Oct 16 23:36:02.227617 kernel: psci: SMC Calling Convention v1.4 Oct 16 23:36:02.227623 kernel: ACPI: NUMA: SRAT: PXM 0 -> MPIDR 0x0 -> Node 0 Oct 16 23:36:02.227630 kernel: ACPI: NUMA: SRAT: PXM 0 -> MPIDR 0x1 -> Node 0 Oct 16 23:36:02.227638 kernel: percpu: Embedded 30 pages/cpu s85800 r8192 d28888 u122880 Oct 16 23:36:02.227645 kernel: pcpu-alloc: s85800 r8192 d28888 u122880 alloc=30*4096 Oct 16 23:36:02.227652 kernel: pcpu-alloc: [0] 0 [0] 1 Oct 16 23:36:02.227659 kernel: Detected PIPT I-cache on CPU0 Oct 16 23:36:02.227666 kernel: CPU features: detected: GIC system register CPU interface Oct 16 23:36:02.227672 kernel: CPU features: detected: Hardware dirty bit management Oct 16 23:36:02.227679 kernel: CPU features: detected: Spectre-BHB Oct 16 23:36:02.227686 kernel: CPU features: kernel page table isolation forced ON by KASLR Oct 16 23:36:02.227692 kernel: CPU features: detected: Kernel page table isolation (KPTI) Oct 16 23:36:02.227699 kernel: CPU features: detected: ARM erratum 1418040 Oct 16 23:36:02.227706 kernel: CPU features: detected: ARM erratum 1542419 (kernel portion) Oct 16 23:36:02.227714 kernel: CPU features: detected: Broken broadcast TLBI completion Oct 16 23:36:02.227721 kernel: CPU features: detected: SSBS not fully self-synchronizing Oct 16 23:36:02.227728 kernel: alternatives: applying boot alternatives Oct 16 23:36:02.227736 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=b6d8446922cf13eecaec0980e282bbdb3b0ddc033d7963ab534d359a174601ee Oct 16 23:36:02.227743 kernel: Dentry cache hash table entries: 524288 (order: 10, 4194304 bytes, linear) Oct 16 23:36:02.227750 kernel: Inode-cache hash table entries: 262144 (order: 9, 2097152 bytes, linear) Oct 16 23:36:02.227757 kernel: Fallback order for Node 0: 0 Oct 16 23:36:02.227763 kernel: Built 1 zonelists, mobility grouping on. Total pages: 1032156 Oct 16 23:36:02.227770 kernel: Policy zone: Normal Oct 16 23:36:02.227777 kernel: mem auto-init: stack:off, heap alloc:off, heap free:off Oct 16 23:36:02.227783 kernel: software IO TLB: area num 2. Oct 16 23:36:02.227791 kernel: software IO TLB: mapped [mem 0x000000003a44e000-0x000000003e44e000] (64MB) Oct 16 23:36:02.227799 kernel: Memory: 3982504K/4194160K available (10304K kernel code, 2180K rwdata, 8136K rodata, 39488K init, 901K bss, 211656K reserved, 0K cma-reserved) Oct 16 23:36:02.227806 kernel: SLUB: HWalign=64, Order=0-3, MinObjects=0, CPUs=2, Nodes=1 Oct 16 23:36:02.227813 kernel: rcu: Preemptible hierarchical RCU implementation. Oct 16 23:36:02.227820 kernel: rcu: RCU event tracing is enabled. Oct 16 23:36:02.227827 kernel: rcu: RCU restricting CPUs from NR_CPUS=512 to nr_cpu_ids=2. Oct 16 23:36:02.227834 kernel: Trampoline variant of Tasks RCU enabled. Oct 16 23:36:02.227841 kernel: Tracing variant of Tasks RCU enabled. Oct 16 23:36:02.227847 kernel: rcu: RCU calculated value of scheduler-enlistment delay is 100 jiffies. Oct 16 23:36:02.227854 kernel: rcu: Adjusting geometry for rcu_fanout_leaf=16, nr_cpu_ids=2 Oct 16 23:36:02.227861 kernel: NR_IRQS: 64, nr_irqs: 64, preallocated irqs: 0 Oct 16 23:36:02.227869 kernel: GICv3: 960 SPIs implemented Oct 16 23:36:02.227876 kernel: GICv3: 0 Extended SPIs implemented Oct 16 23:36:02.227882 kernel: Root IRQ handler: gic_handle_irq Oct 16 23:36:02.227889 kernel: GICv3: GICv3 features: 16 PPIs, RSS Oct 16 23:36:02.227896 kernel: GICv3: CPU0: found redistributor 0 region 0:0x00000000effee000 Oct 16 23:36:02.227903 kernel: ITS: No ITS available, not enabling LPIs Oct 16 23:36:02.227909 kernel: rcu: srcu_init: Setting srcu_struct sizes based on contention. Oct 16 23:36:02.227917 kernel: arch_timer: Enabling local workaround for ARM erratum 1418040 Oct 16 23:36:02.227923 kernel: arch_timer: cp15 timer(s) running at 25.00MHz (virt). Oct 16 23:36:02.227930 kernel: clocksource: arch_sys_counter: mask: 0xffffffffffffff max_cycles: 0x5c40939b5, max_idle_ns: 440795202646 ns Oct 16 23:36:02.227937 kernel: sched_clock: 56 bits at 25MHz, resolution 40ns, wraps every 4398046511100ns Oct 16 23:36:02.227944 kernel: Console: colour dummy device 80x25 Oct 16 23:36:02.227953 kernel: printk: console [tty1] enabled Oct 16 23:36:02.227960 kernel: ACPI: Core revision 20230628 Oct 16 23:36:02.227967 kernel: Calibrating delay loop (skipped), value calculated using timer frequency.. 50.00 BogoMIPS (lpj=25000) Oct 16 23:36:02.227974 kernel: pid_max: default: 32768 minimum: 301 Oct 16 23:36:02.227981 kernel: LSM: initializing lsm=lockdown,capability,landlock,selinux,integrity Oct 16 23:36:02.227988 kernel: landlock: Up and running. Oct 16 23:36:02.227994 kernel: SELinux: Initializing. Oct 16 23:36:02.228001 kernel: Mount-cache hash table entries: 8192 (order: 4, 65536 bytes, linear) Oct 16 23:36:02.228008 kernel: Mountpoint-cache hash table entries: 8192 (order: 4, 65536 bytes, linear) Oct 16 23:36:02.228017 kernel: RCU Tasks: Setting shift to 1 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=2. Oct 16 23:36:02.228024 kernel: RCU Tasks Trace: Setting shift to 1 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=2. Oct 16 23:36:02.228031 kernel: Hyper-V: privilege flags low 0x2e7f, high 0x3a8030, hints 0x100000e, misc 0x31e1 Oct 16 23:36:02.228038 kernel: Hyper-V: Host Build 10.0.26100.1601-1-0 Oct 16 23:36:02.228045 kernel: Hyper-V: enabling crash_kexec_post_notifiers Oct 16 23:36:02.228051 kernel: rcu: Hierarchical SRCU implementation. Oct 16 23:36:02.228058 kernel: rcu: Max phase no-delay instances is 400. Oct 16 23:36:02.228078 kernel: Remapping and enabling EFI services. Oct 16 23:36:02.228086 kernel: smp: Bringing up secondary CPUs ... Oct 16 23:36:02.228093 kernel: Detected PIPT I-cache on CPU1 Oct 16 23:36:02.228101 kernel: GICv3: CPU1: found redistributor 1 region 1:0x00000000f000e000 Oct 16 23:36:02.228109 kernel: arch_timer: Enabling local workaround for ARM erratum 1418040 Oct 16 23:36:02.228116 kernel: CPU1: Booted secondary processor 0x0000000001 [0x413fd0c1] Oct 16 23:36:02.228124 kernel: smp: Brought up 1 node, 2 CPUs Oct 16 23:36:02.228131 kernel: SMP: Total of 2 processors activated. Oct 16 23:36:02.228138 kernel: CPU features: detected: 32-bit EL0 Support Oct 16 23:36:02.228147 kernel: CPU features: detected: Instruction cache invalidation not required for I/D coherence Oct 16 23:36:02.228154 kernel: CPU features: detected: Data cache clean to the PoU not required for I/D coherence Oct 16 23:36:02.228162 kernel: CPU features: detected: CRC32 instructions Oct 16 23:36:02.228169 kernel: CPU features: detected: RCpc load-acquire (LDAPR) Oct 16 23:36:02.228176 kernel: CPU features: detected: LSE atomic instructions Oct 16 23:36:02.228184 kernel: CPU features: detected: Privileged Access Never Oct 16 23:36:02.228191 kernel: CPU: All CPU(s) started at EL1 Oct 16 23:36:02.228198 kernel: alternatives: applying system-wide alternatives Oct 16 23:36:02.228205 kernel: devtmpfs: initialized Oct 16 23:36:02.228214 kernel: clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1911260446275000 ns Oct 16 23:36:02.228222 kernel: futex hash table entries: 512 (order: 3, 32768 bytes, linear) Oct 16 23:36:02.228230 kernel: pinctrl core: initialized pinctrl subsystem Oct 16 23:36:02.228238 kernel: SMBIOS 3.1.0 present. Oct 16 23:36:02.228246 kernel: DMI: Microsoft Corporation Virtual Machine/Virtual Machine, BIOS Hyper-V UEFI Release v4.1 01/09/2026 Oct 16 23:36:02.228254 kernel: NET: Registered PF_NETLINK/PF_ROUTE protocol family Oct 16 23:36:02.228261 kernel: DMA: preallocated 512 KiB GFP_KERNEL pool for atomic allocations Oct 16 23:36:02.228270 kernel: DMA: preallocated 512 KiB GFP_KERNEL|GFP_DMA pool for atomic allocations Oct 16 23:36:02.228278 kernel: DMA: preallocated 512 KiB GFP_KERNEL|GFP_DMA32 pool for atomic allocations Oct 16 23:36:02.228287 kernel: audit: initializing netlink subsys (disabled) Oct 16 23:36:02.228295 kernel: audit: type=2000 audit(0.047:1): state=initialized audit_enabled=0 res=1 Oct 16 23:36:02.228303 kernel: thermal_sys: Registered thermal governor 'step_wise' Oct 16 23:36:02.228311 kernel: cpuidle: using governor menu Oct 16 23:36:02.228318 kernel: hw-breakpoint: found 6 breakpoint and 4 watchpoint registers. Oct 16 23:36:02.228326 kernel: ASID allocator initialised with 32768 entries Oct 16 23:36:02.228335 kernel: acpiphp: ACPI Hot Plug PCI Controller Driver version: 0.5 Oct 16 23:36:02.228343 kernel: Serial: AMBA PL011 UART driver Oct 16 23:36:02.228350 kernel: Modules: 2G module region forced by RANDOMIZE_MODULE_REGION_FULL Oct 16 23:36:02.228360 kernel: Modules: 0 pages in range for non-PLT usage Oct 16 23:36:02.228368 kernel: Modules: 508976 pages in range for PLT usage Oct 16 23:36:02.228376 kernel: HugeTLB: registered 1.00 GiB page size, pre-allocated 0 pages Oct 16 23:36:02.228384 kernel: HugeTLB: 0 KiB vmemmap can be freed for a 1.00 GiB page Oct 16 23:36:02.228392 kernel: HugeTLB: registered 32.0 MiB page size, pre-allocated 0 pages Oct 16 23:36:02.228400 kernel: HugeTLB: 0 KiB vmemmap can be freed for a 32.0 MiB page Oct 16 23:36:02.228408 kernel: HugeTLB: registered 2.00 MiB page size, pre-allocated 0 pages Oct 16 23:36:02.228416 kernel: HugeTLB: 0 KiB vmemmap can be freed for a 2.00 MiB page Oct 16 23:36:02.228424 kernel: HugeTLB: registered 64.0 KiB page size, pre-allocated 0 pages Oct 16 23:36:02.228434 kernel: HugeTLB: 0 KiB vmemmap can be freed for a 64.0 KiB page Oct 16 23:36:02.228442 kernel: ACPI: Added _OSI(Module Device) Oct 16 23:36:02.228450 kernel: ACPI: Added _OSI(Processor Device) Oct 16 23:36:02.228458 kernel: ACPI: Added _OSI(Processor Aggregator Device) Oct 16 23:36:02.228465 kernel: ACPI: 1 ACPI AML tables successfully acquired and loaded Oct 16 23:36:02.228473 kernel: ACPI: Interpreter enabled Oct 16 23:36:02.228481 kernel: ACPI: Using GIC for interrupt routing Oct 16 23:36:02.228489 kernel: ARMH0011:00: ttyAMA0 at MMIO 0xeffec000 (irq = 12, base_baud = 0) is a SBSA Oct 16 23:36:02.228497 kernel: printk: console [ttyAMA0] enabled Oct 16 23:36:02.228507 kernel: printk: bootconsole [pl11] disabled Oct 16 23:36:02.228515 kernel: ARMH0011:01: ttyAMA1 at MMIO 0xeffeb000 (irq = 13, base_baud = 0) is a SBSA Oct 16 23:36:02.228523 kernel: iommu: Default domain type: Translated Oct 16 23:36:02.228531 kernel: iommu: DMA domain TLB invalidation policy: strict mode Oct 16 23:36:02.228540 kernel: efivars: Registered efivars operations Oct 16 23:36:02.228547 kernel: vgaarb: loaded Oct 16 23:36:02.228555 kernel: clocksource: Switched to clocksource arch_sys_counter Oct 16 23:36:02.228563 kernel: VFS: Disk quotas dquot_6.6.0 Oct 16 23:36:02.228571 kernel: VFS: Dquot-cache hash table entries: 512 (order 0, 4096 bytes) Oct 16 23:36:02.228580 kernel: pnp: PnP ACPI init Oct 16 23:36:02.228589 kernel: pnp: PnP ACPI: found 0 devices Oct 16 23:36:02.228596 kernel: NET: Registered PF_INET protocol family Oct 16 23:36:02.228604 kernel: IP idents hash table entries: 65536 (order: 7, 524288 bytes, linear) Oct 16 23:36:02.228612 kernel: tcp_listen_portaddr_hash hash table entries: 2048 (order: 3, 32768 bytes, linear) Oct 16 23:36:02.228620 kernel: Table-perturb hash table entries: 65536 (order: 6, 262144 bytes, linear) Oct 16 23:36:02.228628 kernel: TCP established hash table entries: 32768 (order: 6, 262144 bytes, linear) Oct 16 23:36:02.228636 kernel: TCP bind hash table entries: 32768 (order: 8, 1048576 bytes, linear) Oct 16 23:36:02.228644 kernel: TCP: Hash tables configured (established 32768 bind 32768) Oct 16 23:36:02.228653 kernel: UDP hash table entries: 2048 (order: 4, 65536 bytes, linear) Oct 16 23:36:02.228661 kernel: UDP-Lite hash table entries: 2048 (order: 4, 65536 bytes, linear) Oct 16 23:36:02.228669 kernel: NET: Registered PF_UNIX/PF_LOCAL protocol family Oct 16 23:36:02.228677 kernel: PCI: CLS 0 bytes, default 64 Oct 16 23:36:02.228685 kernel: kvm [1]: HYP mode not available Oct 16 23:36:02.228693 kernel: Initialise system trusted keyrings Oct 16 23:36:02.228701 kernel: workingset: timestamp_bits=39 max_order=20 bucket_order=0 Oct 16 23:36:02.228709 kernel: Key type asymmetric registered Oct 16 23:36:02.228716 kernel: Asymmetric key parser 'x509' registered Oct 16 23:36:02.228725 kernel: Block layer SCSI generic (bsg) driver version 0.4 loaded (major 250) Oct 16 23:36:02.228734 kernel: io scheduler mq-deadline registered Oct 16 23:36:02.228742 kernel: io scheduler kyber registered Oct 16 23:36:02.228749 kernel: io scheduler bfq registered Oct 16 23:36:02.228757 kernel: Serial: 8250/16550 driver, 4 ports, IRQ sharing enabled Oct 16 23:36:02.228765 kernel: thunder_xcv, ver 1.0 Oct 16 23:36:02.228773 kernel: thunder_bgx, ver 1.0 Oct 16 23:36:02.228780 kernel: nicpf, ver 1.0 Oct 16 23:36:02.228789 kernel: nicvf, ver 1.0 Oct 16 23:36:02.228930 kernel: rtc-efi rtc-efi.0: registered as rtc0 Oct 16 23:36:02.229015 kernel: rtc-efi rtc-efi.0: setting system clock to 2026-10-16T23:36:01 UTC (1792193761) Oct 16 23:36:02.229026 kernel: efifb: probing for efifb Oct 16 23:36:02.229034 kernel: efifb: framebuffer at 0x40000000, using 3072k, total 3072k Oct 16 23:36:02.229043 kernel: efifb: mode is 1024x768x32, linelength=4096, pages=1 Oct 16 23:36:02.229050 kernel: efifb: scrolling: redraw Oct 16 23:36:02.229058 kernel: efifb: Truecolor: size=8:8:8:8, shift=24:16:8:0 Oct 16 23:36:02.229072 kernel: Console: switching to colour frame buffer device 128x48 Oct 16 23:36:02.229083 kernel: fb0: EFI VGA frame buffer device Oct 16 23:36:02.229092 kernel: SMCCC: SOC_ID: ARCH_SOC_ID not implemented, skipping .... Oct 16 23:36:02.229099 kernel: hid: raw HID events driver (C) Jiri Kosina Oct 16 23:36:02.229107 kernel: hw perfevents: enabled with armv8_pmuv3_0 PMU driver, 6 counters available Oct 16 23:36:02.229116 kernel: watchdog: Delayed init of the lockup detector failed: -19 Oct 16 23:36:02.229124 kernel: watchdog: Hard watchdog permanently disabled Oct 16 23:36:02.229131 kernel: NET: Registered PF_INET6 protocol family Oct 16 23:36:02.229139 kernel: Segment Routing with IPv6 Oct 16 23:36:02.229147 kernel: In-situ OAM (IOAM) with IPv6 Oct 16 23:36:02.229156 kernel: NET: Registered PF_PACKET protocol family Oct 16 23:36:02.229164 kernel: Key type dns_resolver registered Oct 16 23:36:02.229172 kernel: registered taskstats version 1 Oct 16 23:36:02.229180 kernel: Loading compiled-in X.509 certificates Oct 16 23:36:02.229188 kernel: Loaded X.509 cert 'Kinvolk GmbH: Module signing key for 6.6.157-flatcar: 826cf14d1fa97ed54b7271b7b56accf57910e9fc' Oct 16 23:36:02.229196 kernel: Key type .fscrypt registered Oct 16 23:36:02.229204 kernel: Key type fscrypt-provisioning registered Oct 16 23:36:02.229212 kernel: ima: No TPM chip found, activating TPM-bypass! Oct 16 23:36:02.229219 kernel: ima: Allocated hash algorithm: sha1 Oct 16 23:36:02.229226 kernel: ima: No architecture policies found Oct 16 23:36:02.229235 kernel: alg: No test for fips(ansi_cprng) (fips_ansi_cprng) Oct 16 23:36:02.229242 kernel: clk: Disabling unused clocks Oct 16 23:36:02.229250 kernel: Freeing unused kernel memory: 39488K Oct 16 23:36:02.229257 kernel: Run /init as init process Oct 16 23:36:02.229264 kernel: with arguments: Oct 16 23:36:02.229271 kernel: /init Oct 16 23:36:02.229278 kernel: with environment: Oct 16 23:36:02.229285 kernel: HOME=/ Oct 16 23:36:02.229292 kernel: TERM=linux Oct 16 23:36:02.229303 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) Oct 16 23:36:02.229312 systemd[1]: Detected virtualization microsoft. Oct 16 23:36:02.229320 systemd[1]: Detected architecture arm64. Oct 16 23:36:02.229327 systemd[1]: Running in initrd. Oct 16 23:36:02.229335 systemd[1]: No hostname configured, using default hostname. Oct 16 23:36:02.229343 systemd[1]: Hostname set to . Oct 16 23:36:02.229351 systemd[1]: Initializing machine ID from random generator. Oct 16 23:36:02.229360 systemd[1]: Queued start job for default target initrd.target. Oct 16 23:36:02.229368 systemd[1]: Started clevis-luks-askpass.path - Forward Password Requests to Clevis Directory Watch. Oct 16 23:36:02.229376 systemd[1]: Started systemd-ask-password-console.path - Dispatch Password Requests to Console Directory Watch. Oct 16 23:36:02.229385 systemd[1]: Expecting device dev-disk-by\x2dlabel-EFI\x2dSYSTEM.device - /dev/disk/by-label/EFI-SYSTEM... Oct 16 23:36:02.229393 systemd[1]: Expecting device dev-disk-by\x2dlabel-OEM.device - /dev/disk/by-label/OEM... Oct 16 23:36:02.229401 systemd[1]: Expecting device dev-disk-by\x2dlabel-ROOT.device - /dev/disk/by-label/ROOT... Oct 16 23:36:02.229409 systemd[1]: Expecting device dev-disk-by\x2dpartlabel-USR\x2dA.device - /dev/disk/by-partlabel/USR-A... Oct 16 23:36:02.229420 systemd[1]: Expecting device dev-disk-by\x2dpartuuid-7130c94a\x2d213a\x2d4e5a\x2d8e26\x2d6cce9662f132.device - /dev/disk/by-partuuid/7130c94a-213a-4e5a-8e26-6cce9662f132... Oct 16 23:36:02.229428 systemd[1]: Expecting device dev-mapper-usr.device - /dev/mapper/usr... Oct 16 23:36:02.229436 systemd[1]: Reached target cryptsetup-pre.target - Local Encrypted Volumes (Pre). Oct 16 23:36:02.229444 systemd[1]: Reached target cryptsetup.target - Local Encrypted Volumes. Oct 16 23:36:02.229452 systemd[1]: Reached target paths.target - Path Units. Oct 16 23:36:02.229460 systemd[1]: Reached target slices.target - Slice Units. Oct 16 23:36:02.229468 systemd[1]: Reached target swap.target - Swaps. Oct 16 23:36:02.229476 systemd[1]: Reached target timers.target - Timer Units. Oct 16 23:36:02.229485 systemd[1]: Listening on iscsid.socket - Open-iSCSI iscsid Socket. Oct 16 23:36:02.229493 systemd[1]: Listening on iscsiuio.socket - Open-iSCSI iscsiuio Socket. Oct 16 23:36:02.229501 systemd[1]: Listening on systemd-journald-dev-log.socket - Journal Socket (/dev/log). Oct 16 23:36:02.229508 systemd[1]: Listening on systemd-journald.socket - Journal Socket. Oct 16 23:36:02.229516 systemd[1]: Listening on systemd-networkd.socket - Network Service Netlink Socket. Oct 16 23:36:02.229524 systemd[1]: Listening on systemd-udevd-control.socket - udev Control Socket. Oct 16 23:36:02.229532 systemd[1]: Listening on systemd-udevd-kernel.socket - udev Kernel Socket. Oct 16 23:36:02.229540 systemd[1]: Reached target sockets.target - Socket Units. Oct 16 23:36:02.229549 systemd[1]: Starting ignition-setup-pre.service - Ignition env setup... Oct 16 23:36:02.229557 systemd[1]: Starting kmod-static-nodes.service - Create List of Static Device Nodes... Oct 16 23:36:02.229565 systemd[1]: Finished network-cleanup.service - Network Cleanup. Oct 16 23:36:02.229573 systemd[1]: Starting systemd-fsck-usr.service... Oct 16 23:36:02.229580 systemd[1]: Starting systemd-journald.service - Journal Service... Oct 16 23:36:02.229588 systemd[1]: Starting systemd-modules-load.service - Load Kernel Modules... Oct 16 23:36:02.229611 systemd-journald[218]: Collecting audit messages is disabled. Oct 16 23:36:02.229631 systemd-journald[218]: Journal started Oct 16 23:36:02.229650 systemd-journald[218]: Runtime Journal (/run/log/journal/10946151bf9a4d20ae4dcc80d47bc0ba) is 8.0M, max 78.5M, 70.5M free. Oct 16 23:36:02.234683 systemd-modules-load[219]: Inserted module 'overlay' Oct 16 23:36:02.250090 systemd[1]: Starting systemd-vconsole-setup.service - Virtual Console Setup... Oct 16 23:36:02.250141 kernel: bridge: filtering via arp/ip/ip6tables is no longer available by default. Update your scripts to load br_netfilter if you need this. Oct 16 23:36:02.263184 kernel: Bridge firewalling registered Oct 16 23:36:02.270014 systemd[1]: Started systemd-journald.service - Journal Service. Oct 16 23:36:02.268875 systemd-modules-load[219]: Inserted module 'br_netfilter' Oct 16 23:36:02.278348 systemd[1]: Finished ignition-setup-pre.service - Ignition env setup. Oct 16 23:36:02.283016 systemd[1]: Finished kmod-static-nodes.service - Create List of Static Device Nodes. Oct 16 23:36:02.293599 systemd[1]: Finished systemd-fsck-usr.service. Oct 16 23:36:02.301724 systemd[1]: Finished systemd-modules-load.service - Load Kernel Modules. Oct 16 23:36:02.313585 systemd[1]: Finished systemd-vconsole-setup.service - Virtual Console Setup. Oct 16 23:36:02.329214 systemd[1]: Starting dracut-cmdline-ask.service - dracut ask for additional cmdline parameters... Oct 16 23:36:02.336214 systemd[1]: Starting systemd-sysctl.service - Apply Kernel Variables... Oct 16 23:36:02.355599 systemd[1]: Starting systemd-tmpfiles-setup-dev-early.service - Create Static Device Nodes in /dev gracefully... Oct 16 23:36:02.374867 systemd[1]: Starting systemd-tmpfiles-setup.service - Create System Files and Directories... Oct 16 23:36:02.381211 systemd[1]: Finished systemd-sysctl.service - Apply Kernel Variables. Oct 16 23:36:02.398262 systemd[1]: Finished dracut-cmdline-ask.service - dracut ask for additional cmdline parameters. Oct 16 23:36:02.403970 systemd[1]: Finished systemd-tmpfiles-setup-dev-early.service - Create Static Device Nodes in /dev gracefully. Oct 16 23:36:02.415526 systemd[1]: Finished systemd-tmpfiles-setup.service - Create System Files and Directories. Oct 16 23:36:02.436334 systemd[1]: Starting dracut-cmdline.service - dracut cmdline hook... Oct 16 23:36:02.449256 systemd[1]: Starting systemd-resolved.service - Network Name Resolution... Oct 16 23:36:02.461746 systemd[1]: Starting systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev... Oct 16 23:36:02.482521 systemd[1]: Finished systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev. Oct 16 23:36:02.500913 dracut-cmdline[253]: dracut-dracut-053 Oct 16 23:36:02.500913 dracut-cmdline[253]: Using kernel command line parameters: rd.driver.pre=btrfs BOOT_IMAGE=/flatcar/vmlinuz-a mount.usr=/dev/mapper/usr verity.usr=PARTUUID=7130c94a-213a-4e5a-8e26-6cce9662f132 rootflags=rw mount.usrflags=ro consoleblank=0 root=LABEL=ROOT console=tty1 console=ttyAMA0,115200n8 earlycon=pl011,0xeffec000 flatcar.first_boot=detected acpi=force flatcar.oem.id=azure flatcar.autologin verity.usrhash=b6d8446922cf13eecaec0980e282bbdb3b0ddc033d7963ab534d359a174601ee Oct 16 23:36:02.506235 systemd-resolved[256]: Positive Trust Anchors: Oct 16 23:36:02.506244 systemd-resolved[256]: . IN DS 20326 8 2 e06d44b80b8f1d39a95c0b0d7c65d08458e880409bbc683457104237c7f8ec8d Oct 16 23:36:02.506275 systemd-resolved[256]: 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 Oct 16 23:36:02.508635 systemd-resolved[256]: Defaulting to hostname 'linux'. Oct 16 23:36:02.509508 systemd[1]: Started systemd-resolved.service - Network Name Resolution. Oct 16 23:36:02.535419 systemd[1]: Reached target nss-lookup.target - Host and Network Name Lookups. Oct 16 23:36:02.670079 kernel: SCSI subsystem initialized Oct 16 23:36:02.676084 kernel: Loading iSCSI transport class v2.0-870. Oct 16 23:36:02.686092 kernel: iscsi: registered transport (tcp) Oct 16 23:36:02.702783 kernel: iscsi: registered transport (qla4xxx) Oct 16 23:36:02.702804 kernel: QLogic iSCSI HBA Driver Oct 16 23:36:02.741205 systemd[1]: Finished dracut-cmdline.service - dracut cmdline hook. Oct 16 23:36:02.753420 systemd[1]: Starting dracut-pre-udev.service - dracut pre-udev hook... Oct 16 23:36:02.783086 kernel: device-mapper: core: CONFIG_IMA_DISABLE_HTABLE is disabled. Duplicate IMA measurements will not be recorded in the IMA log. Oct 16 23:36:02.783151 kernel: device-mapper: uevent: version 1.0.3 Oct 16 23:36:02.787974 kernel: device-mapper: ioctl: 4.48.0-ioctl (2023-03-01) initialised: dm-devel@redhat.com Oct 16 23:36:02.837094 kernel: raid6: neonx8 gen() 15801 MB/s Oct 16 23:36:02.856078 kernel: raid6: neonx4 gen() 15704 MB/s Oct 16 23:36:02.875074 kernel: raid6: neonx2 gen() 13185 MB/s Oct 16 23:36:02.895142 kernel: raid6: neonx1 gen() 10526 MB/s Oct 16 23:36:02.916079 kernel: raid6: int64x8 gen() 7138 MB/s Oct 16 23:36:02.935074 kernel: raid6: int64x4 gen() 7357 MB/s Oct 16 23:36:02.955074 kernel: raid6: int64x2 gen() 6145 MB/s Oct 16 23:36:02.977207 kernel: raid6: int64x1 gen() 5069 MB/s Oct 16 23:36:02.977226 kernel: raid6: using algorithm neonx8 gen() 15801 MB/s Oct 16 23:36:03.000246 kernel: raid6: .... xor() 12040 MB/s, rmw enabled Oct 16 23:36:03.000264 kernel: raid6: using neon recovery algorithm Oct 16 23:36:03.011614 kernel: xor: measuring software checksum speed Oct 16 23:36:03.011630 kernel: 8regs : 19788 MB/sec Oct 16 23:36:03.014635 kernel: 32regs : 19636 MB/sec Oct 16 23:36:03.017534 kernel: arm64_neon : 27105 MB/sec Oct 16 23:36:03.021019 kernel: xor: using function: arm64_neon (27105 MB/sec) Oct 16 23:36:03.073098 kernel: Btrfs loaded, zoned=no, fsverity=no Oct 16 23:36:03.084599 systemd[1]: Finished dracut-pre-udev.service - dracut pre-udev hook. Oct 16 23:36:03.098198 systemd[1]: Starting systemd-udevd.service - Rule-based Manager for Device Events and Files... Oct 16 23:36:03.115570 systemd-udevd[441]: Using default interface naming scheme 'v255'. Oct 16 23:36:03.119817 systemd[1]: Started systemd-udevd.service - Rule-based Manager for Device Events and Files. Oct 16 23:36:03.136288 systemd[1]: Starting dracut-pre-trigger.service - dracut pre-trigger hook... Oct 16 23:36:03.156545 dracut-pre-trigger[451]: rd.md=0: removing MD RAID activation Oct 16 23:36:03.185943 systemd[1]: Finished dracut-pre-trigger.service - dracut pre-trigger hook. Oct 16 23:36:03.197321 systemd[1]: Starting systemd-udev-trigger.service - Coldplug All udev Devices... Oct 16 23:36:03.237380 systemd[1]: Finished systemd-udev-trigger.service - Coldplug All udev Devices. Oct 16 23:36:03.254414 systemd[1]: Starting dracut-initqueue.service - dracut initqueue hook... Oct 16 23:36:03.285871 systemd[1]: Finished dracut-initqueue.service - dracut initqueue hook. Oct 16 23:36:03.295501 systemd[1]: Reached target remote-fs-pre.target - Preparation for Remote File Systems. Oct 16 23:36:03.303394 systemd[1]: Reached target remote-cryptsetup.target - Remote Encrypted Volumes. Oct 16 23:36:03.310985 systemd[1]: Reached target remote-fs.target - Remote File Systems. Oct 16 23:36:03.334411 systemd[1]: Starting dracut-pre-mount.service - dracut pre-mount hook... Oct 16 23:36:03.360984 systemd[1]: Finished dracut-pre-mount.service - dracut pre-mount hook. Oct 16 23:36:03.379583 kernel: hv_vmbus: hv_mmio=[mem 0x40000000-0xfed3ffff],[mem 0xfc0000000-0xfffffffff] fb=[mem 0x40000000-0x47ffffff] Oct 16 23:36:03.383082 kernel: hv_vmbus: Vmbus version:5.3 Oct 16 23:36:03.388658 systemd[1]: dracut-cmdline-ask.service: Deactivated successfully. Oct 16 23:36:03.388807 systemd[1]: Stopped dracut-cmdline-ask.service - dracut ask for additional cmdline parameters. Oct 16 23:36:03.428912 kernel: hv_vmbus: registering driver hid_hyperv Oct 16 23:36:03.428935 kernel: input: Microsoft Vmbus HID-compliant Mouse as /devices/0006:045E:0621.0001/input/input0 Oct 16 23:36:03.428946 kernel: hid-hyperv 0006:045E:0621.0001: input: VIRTUAL HID v0.01 Mouse [Microsoft Vmbus HID-compliant Mouse] on Oct 16 23:36:03.429129 kernel: hv_vmbus: registering driver hyperv_keyboard Oct 16 23:36:03.403773 systemd[1]: Stopping dracut-cmdline-ask.service - dracut ask for additional cmdline parameters... Oct 16 23:36:03.457963 kernel: hv_vmbus: registering driver hv_netvsc Oct 16 23:36:03.457987 kernel: hv_vmbus: registering driver hv_storvsc Oct 16 23:36:03.457997 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 Oct 16 23:36:03.441354 systemd[1]: systemd-vconsole-setup.service: Deactivated successfully. Oct 16 23:36:03.490989 kernel: pps_core: LinuxPPS API ver. 1 registered Oct 16 23:36:03.491012 kernel: scsi host0: storvsc_host_t Oct 16 23:36:03.491231 kernel: pps_core: Software ver. 5.3.6 - Copyright 2005-2007 Rodolfo Giometti Oct 16 23:36:03.491243 kernel: scsi host1: storvsc_host_t Oct 16 23:36:03.491335 kernel: scsi 0:0:0:0: Direct-Access Msft Virtual Disk 1.0 PQ: 0 ANSI: 5 Oct 16 23:36:03.441600 systemd[1]: Stopped systemd-vconsole-setup.service - Virtual Console Setup. Oct 16 23:36:03.508307 kernel: scsi 0:0:0:2: CD-ROM Msft Virtual DVD-ROM 1.0 PQ: 0 ANSI: 5 Oct 16 23:36:03.477704 systemd[1]: Stopping systemd-vconsole-setup.service - Virtual Console Setup... Oct 16 23:36:03.520383 systemd[1]: Starting systemd-vconsole-setup.service - Virtual Console Setup... Oct 16 23:36:03.536456 kernel: PTP clock support registered Oct 16 23:36:03.552113 systemd[1]: Finished systemd-vconsole-setup.service - Virtual Console Setup. Oct 16 23:36:03.573391 kernel: hv_utils: Registering HyperV Utility Driver Oct 16 23:36:03.573414 kernel: hv_vmbus: registering driver hv_utils Oct 16 23:36:03.573426 kernel: sr 0:0:0:2: [sr0] scsi-1 drive Oct 16 23:36:03.574201 systemd[1]: Starting dracut-cmdline-ask.service - dracut ask for additional cmdline parameters... Oct 16 23:36:03.605283 kernel: hv_utils: Heartbeat IC version 3.0 Oct 16 23:36:03.605310 kernel: cdrom: Uniform CD-ROM driver Revision: 3.20 Oct 16 23:36:03.605320 kernel: hv_utils: Shutdown IC version 3.2 Oct 16 23:36:03.605329 kernel: hv_netvsc 7ced8dd4-cc46-7ced-8dd4-cc467ced8dd4 eth0: VF slot 1 added Oct 16 23:36:03.608466 kernel: sd 0:0:0:0: [sda] 63737856 512-byte logical blocks: (32.6 GB/30.4 GiB) Oct 16 23:36:03.608625 kernel: hv_utils: TimeSync IC version 4.0 Oct 16 23:36:03.608637 kernel: sr 0:0:0:2: Attached scsi CD-ROM sr0 Oct 16 23:36:03.709514 systemd-resolved[256]: Clock change detected. Flushing caches. Oct 16 23:36:03.721971 kernel: sd 0:0:0:0: [sda] 4096-byte physical blocks Oct 16 23:36:03.722143 kernel: sd 0:0:0:0: [sda] Write Protect is off Oct 16 23:36:03.728630 kernel: sd 0:0:0:0: [sda] Mode Sense: 0f 00 10 00 Oct 16 23:36:03.728852 kernel: sd 0:0:0:0: [sda] Write cache: disabled, read cache: enabled, supports DPO and FUA Oct 16 23:36:03.731743 systemd[1]: Finished dracut-cmdline-ask.service - dracut ask for additional cmdline parameters. Oct 16 23:36:03.753433 kernel: sda: sda1 sda2 sda3 sda4 sda6 sda7 sda9 Oct 16 23:36:03.753480 kernel: sd 0:0:0:0: [sda] Attached SCSI disk Oct 16 23:36:03.763951 kernel: hv_vmbus: registering driver hv_pci Oct 16 23:36:03.764011 kernel: hv_pci dd9db976-e036-4991-966d-87a0f679e5bd: PCI VMBus probing: Using version 0x10004 Oct 16 23:36:03.777052 kernel: hv_storvsc f8b3781a-1e82-4818-a1c3-63d806ec15bb: tag#53 cmd 0x85 status: scsi 0x2 srb 0x6 hv 0xc0000001 Oct 16 23:36:03.777279 kernel: hv_pci dd9db976-e036-4991-966d-87a0f679e5bd: PCI host bridge to bus e036:00 Oct 16 23:36:03.786618 kernel: pci_bus e036:00: root bus resource [mem 0xfc0000000-0xfc00fffff window] Oct 16 23:36:03.787485 kernel: pci_bus e036:00: No busn resource found for root bus, will use [bus 00-ff] Oct 16 23:36:03.797779 kernel: pci e036:00:02.0: [15b3:1018] type 00 class 0x020000 Oct 16 23:36:03.804709 kernel: pci e036:00:02.0: BAR 0 [mem 0xfc0000000-0xfc00fffff 64bit pref] Oct 16 23:36:03.810947 kernel: pci e036:00:02.0: enabling Extended Tags Oct 16 23:36:03.821931 kernel: hv_storvsc f8b3781a-1e82-4818-a1c3-63d806ec15bb: tag#24 cmd 0x85 status: scsi 0x2 srb 0x6 hv 0xc0000001 Oct 16 23:36:03.822132 kernel: pci e036:00:02.0: 0.000 Gb/s available PCIe bandwidth, limited by Unknown x0 link at e036:00:02.0 (capable of 126.016 Gb/s with 8.0 GT/s PCIe x16 link) Oct 16 23:36:03.842020 kernel: pci_bus e036:00: busn_res: [bus 00-ff] end is updated to 00 Oct 16 23:36:03.842216 kernel: pci e036:00:02.0: BAR 0 [mem 0xfc0000000-0xfc00fffff 64bit pref]: assigned Oct 16 23:36:03.883896 kernel: mlx5_core e036:00:02.0: enabling device (0000 -> 0002) Oct 16 23:36:03.889696 kernel: mlx5_core e036:00:02.0: firmware version: 16.30.5026 Oct 16 23:36:04.100702 kernel: hv_netvsc 7ced8dd4-cc46-7ced-8dd4-cc467ced8dd4 eth0: VF registering: eth1 Oct 16 23:36:04.100908 kernel: mlx5_core e036:00:02.0 eth1: joined to eth0 Oct 16 23:36:04.107013 kernel: mlx5_core e036:00:02.0: MLX5E: StrdRq(1) RqSz(8) StrdSz(2048) RxCqeCmprss(0 basic) Oct 16 23:36:04.118975 kernel: mlx5_core e036:00:02.0 enP57398s1: renamed from eth1 Oct 16 23:36:04.127469 systemd[1]: Found device dev-disk-by\x2dlabel-EFI\x2dSYSTEM.device - Virtual_Disk EFI-SYSTEM. Oct 16 23:36:04.146709 kernel: BTRFS: device label OEM devid 1 transid 10 /dev/sda6 scanned by (udev-worker) (493) Oct 16 23:36:04.163593 systemd[1]: Found device dev-disk-by\x2dlabel-OEM.device - Virtual_Disk OEM. Oct 16 23:36:04.183726 kernel: BTRFS: device fsid 01ae2c3f-1cbb-4765-84ed-a78ac8536acd devid 1 transid 33 /dev/sda3 scanned by (udev-worker) (484) Oct 16 23:36:04.198456 systemd[1]: Found device dev-disk-by\x2dpartuuid-7130c94a\x2d213a\x2d4e5a\x2d8e26\x2d6cce9662f132.device - Virtual_Disk USR-A. Oct 16 23:36:04.204908 systemd[1]: Found device dev-disk-by\x2dpartlabel-USR\x2dA.device - Virtual_Disk USR-A. Oct 16 23:36:04.229991 systemd[1]: Starting disk-uuid.service - Generate new UUID for disk GPT if necessary... Oct 16 23:36:04.258816 systemd[1]: Found device dev-disk-by\x2dlabel-ROOT.device - Virtual_Disk ROOT. Oct 16 23:36:04.271842 kernel: GPT:disk_guids don't match. Oct 16 23:36:04.271884 kernel: GPT: Use GNU Parted to correct GPT errors. Oct 16 23:36:04.271901 kernel: sda: sda1 sda2 sda3 sda4 sda6 sda7 sda9 Oct 16 23:36:04.284744 kernel: sda: sda1 sda2 sda3 sda4 sda6 sda7 sda9 Oct 16 23:36:05.282706 kernel: sda: sda1 sda2 sda3 sda4 sda6 sda7 sda9 Oct 16 23:36:05.283819 disk-uuid[603]: The operation has completed successfully. Oct 16 23:36:05.360441 systemd[1]: disk-uuid.service: Deactivated successfully. Oct 16 23:36:05.361711 systemd[1]: Finished disk-uuid.service - Generate new UUID for disk GPT if necessary. Oct 16 23:36:05.385950 systemd[1]: Starting verity-setup.service - Verity Setup for /dev/mapper/usr... Oct 16 23:36:05.398253 sh[716]: Success Oct 16 23:36:05.425909 kernel: device-mapper: verity: sha256 using implementation "sha256-ce" Oct 16 23:36:05.589265 systemd[1]: Found device dev-mapper-usr.device - /dev/mapper/usr. Oct 16 23:36:05.597793 systemd[1]: Mounting sysusr-usr.mount - /sysusr/usr... Oct 16 23:36:05.611884 systemd[1]: Finished verity-setup.service - Verity Setup for /dev/mapper/usr. Oct 16 23:36:05.639109 kernel: BTRFS info (device dm-0): first mount of filesystem 01ae2c3f-1cbb-4765-84ed-a78ac8536acd Oct 16 23:36:05.639159 kernel: BTRFS info (device dm-0): using crc32c (crc32c-generic) checksum algorithm Oct 16 23:36:05.645273 kernel: BTRFS warning (device dm-0): 'nologreplay' is deprecated, use 'rescue=nologreplay' instead Oct 16 23:36:05.650128 kernel: BTRFS info (device dm-0): disabling log replay at mount time Oct 16 23:36:05.654963 kernel: BTRFS info (device dm-0): using free space tree Oct 16 23:36:05.866888 systemd[1]: Mounted sysusr-usr.mount - /sysusr/usr. Oct 16 23:36:05.872220 systemd[1]: afterburn-network-kargs.service - Afterburn Initrd Setup Network Kernel Arguments was skipped because no trigger condition checks were met. Oct 16 23:36:05.886936 systemd[1]: Starting ignition-setup.service - Ignition (setup)... Oct 16 23:36:05.896854 systemd[1]: Starting parse-ip-for-networkd.service - Write systemd-networkd units from cmdline... Oct 16 23:36:05.925545 kernel: BTRFS info (device sda6): first mount of filesystem 215947b1-b867-4a28-935e-b2ab65af567d Oct 16 23:36:05.925598 kernel: BTRFS info (device sda6): using crc32c (crc32c-generic) checksum algorithm Oct 16 23:36:05.929379 kernel: BTRFS info (device sda6): using free space tree Oct 16 23:36:05.952742 kernel: BTRFS info (device sda6): auto enabling async discard Oct 16 23:36:05.961503 systemd[1]: mnt-oem.mount: Deactivated successfully. Oct 16 23:36:05.972536 kernel: BTRFS info (device sda6): last unmount of filesystem 215947b1-b867-4a28-935e-b2ab65af567d Oct 16 23:36:05.980626 systemd[1]: Finished ignition-setup.service - Ignition (setup). Oct 16 23:36:05.995015 systemd[1]: Starting ignition-fetch-offline.service - Ignition (fetch-offline)... Oct 16 23:36:06.040593 systemd[1]: Finished parse-ip-for-networkd.service - Write systemd-networkd units from cmdline. Oct 16 23:36:06.057836 systemd[1]: Starting systemd-networkd.service - Network Configuration... Oct 16 23:36:06.085623 systemd-networkd[900]: lo: Link UP Oct 16 23:36:06.085634 systemd-networkd[900]: lo: Gained carrier Oct 16 23:36:06.087357 systemd-networkd[900]: Enumeration completed Oct 16 23:36:06.090116 systemd[1]: Started systemd-networkd.service - Network Configuration. Oct 16 23:36:06.093461 systemd-networkd[900]: eth0: found matching network '/usr/lib/systemd/network/zz-default.network', based on potentially unpredictable interface name. Oct 16 23:36:06.093464 systemd-networkd[900]: eth0: Configuring with /usr/lib/systemd/network/zz-default.network. Oct 16 23:36:06.098927 systemd[1]: Reached target network.target - Network. Oct 16 23:36:06.176720 kernel: mlx5_core e036:00:02.0 enP57398s1: Link up Oct 16 23:36:06.218696 kernel: hv_netvsc 7ced8dd4-cc46-7ced-8dd4-cc467ced8dd4 eth0: Data path switched to VF: enP57398s1 Oct 16 23:36:06.219048 systemd-networkd[900]: enP57398s1: Link UP Oct 16 23:36:06.219143 systemd-networkd[900]: eth0: Link UP Oct 16 23:36:06.219268 systemd-networkd[900]: eth0: Gained carrier Oct 16 23:36:06.219278 systemd-networkd[900]: eth0: found matching network '/usr/lib/systemd/network/zz-default.network', based on potentially unpredictable interface name. Oct 16 23:36:06.240844 systemd-networkd[900]: enP57398s1: Gained carrier Oct 16 23:36:06.252734 systemd-networkd[900]: eth0: DHCPv4 address 10.0.0.5/24, gateway 10.0.0.1 acquired from 168.63.129.16 Oct 16 23:36:06.754249 ignition[845]: Ignition 2.19.0 Oct 16 23:36:06.754261 ignition[845]: Stage: fetch-offline Oct 16 23:36:06.754298 ignition[845]: no configs at "/usr/lib/ignition/base.d" Oct 16 23:36:06.754306 ignition[845]: no config dir at "/usr/lib/ignition/base.platform.d/azure" Oct 16 23:36:06.761965 systemd[1]: Finished ignition-fetch-offline.service - Ignition (fetch-offline). Oct 16 23:36:06.754408 ignition[845]: parsed url from cmdline: "" Oct 16 23:36:06.780038 systemd[1]: Starting ignition-fetch.service - Ignition (fetch)... Oct 16 23:36:06.754412 ignition[845]: no config URL provided Oct 16 23:36:06.754416 ignition[845]: reading system config file "/usr/lib/ignition/user.ign" Oct 16 23:36:06.754422 ignition[845]: no config at "/usr/lib/ignition/user.ign" Oct 16 23:36:06.754427 ignition[845]: failed to fetch config: resource requires networking Oct 16 23:36:06.755030 ignition[845]: Ignition finished successfully Oct 16 23:36:06.800217 ignition[912]: Ignition 2.19.0 Oct 16 23:36:06.800224 ignition[912]: Stage: fetch Oct 16 23:36:06.800432 ignition[912]: no configs at "/usr/lib/ignition/base.d" Oct 16 23:36:06.800441 ignition[912]: no config dir at "/usr/lib/ignition/base.platform.d/azure" Oct 16 23:36:06.800545 ignition[912]: parsed url from cmdline: "" Oct 16 23:36:06.800549 ignition[912]: no config URL provided Oct 16 23:36:06.800553 ignition[912]: reading system config file "/usr/lib/ignition/user.ign" Oct 16 23:36:06.800563 ignition[912]: no config at "/usr/lib/ignition/user.ign" Oct 16 23:36:06.800586 ignition[912]: GET http://169.254.169.254/metadata/instance/compute/userData?api-version=2021-01-01&format=text: attempt #1 Oct 16 23:36:06.888404 ignition[912]: GET result: OK Oct 16 23:36:06.888458 ignition[912]: config has been read from IMDS userdata Oct 16 23:36:06.888475 ignition[912]: parsing config with SHA512: ea896ad2b7468ee42b8f152ed972d664e07a6cdef31b45b23a7c4028393ee3c5b4fbb0804e3afa914cb1c88666ee930d12a810420e16ca2f4d3c4cdea73a19e7 Oct 16 23:36:06.892266 unknown[912]: fetched base config from "system" Oct 16 23:36:06.892476 ignition[912]: fetch: fetch complete Oct 16 23:36:06.892280 unknown[912]: fetched base config from "system" Oct 16 23:36:06.892480 ignition[912]: fetch: fetch passed Oct 16 23:36:06.892285 unknown[912]: fetched user config from "azure" Oct 16 23:36:06.892524 ignition[912]: Ignition finished successfully Oct 16 23:36:06.895096 systemd[1]: Finished ignition-fetch.service - Ignition (fetch). Oct 16 23:36:06.919221 systemd[1]: Starting ignition-kargs.service - Ignition (kargs)... Oct 16 23:36:06.935312 ignition[918]: Ignition 2.19.0 Oct 16 23:36:06.935328 ignition[918]: Stage: kargs Oct 16 23:36:06.935496 ignition[918]: no configs at "/usr/lib/ignition/base.d" Oct 16 23:36:06.940980 systemd[1]: Finished ignition-kargs.service - Ignition (kargs). Oct 16 23:36:06.935514 ignition[918]: no config dir at "/usr/lib/ignition/base.platform.d/azure" Oct 16 23:36:06.936119 ignition[918]: kargs: kargs passed Oct 16 23:36:06.936208 ignition[918]: Ignition finished successfully Oct 16 23:36:06.964970 systemd[1]: Starting ignition-disks.service - Ignition (disks)... Oct 16 23:36:06.981306 ignition[924]: Ignition 2.19.0 Oct 16 23:36:06.981315 ignition[924]: Stage: disks Oct 16 23:36:06.981504 ignition[924]: no configs at "/usr/lib/ignition/base.d" Oct 16 23:36:06.981513 ignition[924]: no config dir at "/usr/lib/ignition/base.platform.d/azure" Oct 16 23:36:06.982140 ignition[924]: disks: createFilesystems: op(1): [started] waiting for devices [/dev/disk/by-partlabel/ROOT] Oct 16 23:36:06.989924 ignition[924]: disks: createFilesystems: op(1): [finished] waiting for devices [/dev/disk/by-partlabel/ROOT] Oct 16 23:36:06.990004 ignition[924]: disks: createFilesystems: created device alias for "/dev/disk/by-partlabel/ROOT": "/run/ignition/dev_aliases/dev/disk/by-partlabel/ROOT" -> "/dev/sda9" Oct 16 23:36:06.990051 ignition[924]: disks: createFilesystems: op(2): [started] determining filesystem type of "/dev/disk/by-partlabel/ROOT" Oct 16 23:36:07.037700 ignition[924]: disks: createFilesystems: op(2): [finished] determining filesystem type of "/dev/disk/by-partlabel/ROOT" Oct 16 23:36:07.037711 ignition[924]: disks: createFilesystems: found ext4 filesystem at "/dev/disk/by-partlabel/ROOT" with uuid "27a6772a-7728-4cc3-9f31-549603a5b63c" and label "ROOT" Oct 16 23:36:07.037747 ignition[924]: disks: createFilesystems: op(3): [started] wiping filesystem signatures from "/run/ignition/dev_aliases/dev/disk/by-partlabel/ROOT" Oct 16 23:36:07.037754 ignition[924]: disks: createFilesystems: op(3): executing: "wipefs" "-a" "/run/ignition/dev_aliases/dev/disk/by-partlabel/ROOT" Oct 16 23:36:07.118066 ignition[924]: disks: createFilesystems: op(3): [finished] wiping filesystem signatures from "/run/ignition/dev_aliases/dev/disk/by-partlabel/ROOT" Oct 16 23:36:07.118104 ignition[924]: disks: createFilesystems: op(4): [started] creating "xfs" filesystem on "/run/ignition/dev_aliases/dev/disk/by-partlabel/ROOT" Oct 16 23:36:07.118120 ignition[924]: disks: createFilesystems: op(4): executing: "mkfs.xfs" "-L" "ROOT" "-m" "uuid=9aa5237a-ab6b-458b-a7e8-f25e2baef1a3" "-f" "/run/ignition/dev_aliases/dev/disk/by-partlabel/ROOT" Oct 16 23:36:07.753644 ignition[924]: disks: createFilesystems: op(4): [finished] creating "xfs" filesystem on "/run/ignition/dev_aliases/dev/disk/by-partlabel/ROOT" Oct 16 23:36:07.753727 ignition[924]: disks: createFilesystems: op(5): [started] waiting for triggered uevent Oct 16 23:36:07.753733 ignition[924]: disks: createFilesystems: op(5): executing: "udevadm" "trigger" "--settle" "/dev/sda9" Oct 16 23:36:07.937784 systemd-networkd[900]: eth0: Gained IPv6LL Oct 16 23:36:08.903196 ignition[924]: disks: createFilesystems: op(5): [finished] waiting for triggered uevent Oct 16 23:36:08.903213 ignition[924]: disks: disks passed Oct 16 23:36:08.907466 systemd[1]: Finished ignition-disks.service - Ignition (disks). Oct 16 23:36:08.903277 ignition[924]: Ignition finished successfully Oct 16 23:36:08.916211 systemd[1]: Reached target initrd-root-device.target - Initrd Root Device. Oct 16 23:36:08.923749 systemd[1]: Reached target local-fs-pre.target - Preparation for Local File Systems. Oct 16 23:36:08.931630 systemd[1]: Reached target local-fs.target - Local File Systems. Oct 16 23:36:08.940887 systemd[1]: Reached target sysinit.target - System Initialization. Oct 16 23:36:08.949875 systemd[1]: Reached target basic.target - Basic System. Oct 16 23:36:08.969960 systemd[1]: Starting systemd-fsck-root.service - File System Check on /dev/disk/by-label/ROOT... Oct 16 23:36:08.992168 systemd-fsck[946]: /usr/sbin/fsck.xfs: XFS file system. Oct 16 23:36:08.997047 systemd[1]: Finished systemd-fsck-root.service - File System Check on /dev/disk/by-label/ROOT. Oct 16 23:36:09.013920 systemd[1]: Mounting sysroot.mount - /sysroot... Oct 16 23:36:09.092838 kernel: SGI XFS with ACLs, security attributes, quota, no debug enabled Oct 16 23:36:09.098695 kernel: XFS (sda9): Mounting V5 Filesystem 9aa5237a-ab6b-458b-a7e8-f25e2baef1a3 Oct 16 23:36:09.115699 kernel: XFS (sda9): Ending clean mount Oct 16 23:36:09.119403 systemd[1]: Mounted sysroot.mount - /sysroot. Oct 16 23:36:09.122889 systemd[1]: Reached target initrd-root-fs.target - Initrd Root File System. Oct 16 23:36:09.140761 systemd[1]: Mounting sysroot-oem.mount - /sysroot/oem... Oct 16 23:36:09.150302 systemd[1]: Mounting sysroot-usr.mount - /sysroot/usr... Oct 16 23:36:09.156877 systemd[1]: Starting flatcar-metadata-hostname.service - Flatcar Metadata Hostname Agent... Oct 16 23:36:09.174191 systemd[1]: ignition-remount-sysroot.service - Remount /sysroot read-write for Ignition was skipped because of an unmet condition check (ConditionPathIsReadWrite=!/sysroot). Oct 16 23:36:09.186995 kernel: BTRFS: device label OEM devid 1 transid 11 /dev/sda6 scanned by mount (961) Oct 16 23:36:09.174272 systemd[1]: Reached target ignition-diskful.target - Ignition Boot Disk Setup. Oct 16 23:36:09.193360 systemd[1]: Mounted sysroot-usr.mount - /sysroot/usr. Oct 16 23:36:09.217853 kernel: BTRFS info (device sda6): first mount of filesystem 215947b1-b867-4a28-935e-b2ab65af567d Oct 16 23:36:09.217877 kernel: BTRFS info (device sda6): using crc32c (crc32c-generic) checksum algorithm Oct 16 23:36:09.217887 kernel: BTRFS info (device sda6): using free space tree Oct 16 23:36:09.230370 kernel: BTRFS info (device sda6): auto enabling async discard Oct 16 23:36:09.226203 systemd[1]: Starting initrd-setup-root.service - Root filesystem setup... Oct 16 23:36:09.233090 systemd[1]: Mounted sysroot-oem.mount - /sysroot/oem. Oct 16 23:36:09.308952 initrd-setup-root[986]: cut: /sysroot/etc/passwd: No such file or directory Oct 16 23:36:09.334576 initrd-setup-root[993]: cut: /sysroot/etc/group: No such file or directory Oct 16 23:36:09.350773 initrd-setup-root[1000]: cut: /sysroot/etc/shadow: No such file or directory Oct 16 23:36:09.359305 initrd-setup-root[1007]: cut: /sysroot/etc/gshadow: No such file or directory Oct 16 23:36:09.598835 coreos-metadata[963]: Oct 16 23:36:09.598 INFO Fetching http://168.63.129.16/?comp=versions: Attempt #1 Oct 16 23:36:09.606176 coreos-metadata[963]: Oct 16 23:36:09.606 INFO Fetch successful Oct 16 23:36:09.610452 coreos-metadata[963]: Oct 16 23:36:09.610 INFO Fetching http://169.254.169.254/metadata/instance/compute/name?api-version=2017-08-01&format=text: Attempt #1 Oct 16 23:36:09.625076 coreos-metadata[963]: Oct 16 23:36:09.625 INFO Fetch successful Oct 16 23:36:09.630115 coreos-metadata[963]: Oct 16 23:36:09.627 INFO wrote hostname ci-4081.3.10--e3223b72ee to /sysroot/etc/hostname Oct 16 23:36:09.631600 systemd[1]: Finished flatcar-metadata-hostname.service - Flatcar Metadata Hostname Agent. Oct 16 23:36:09.703225 systemd[1]: Finished initrd-setup-root.service - Root filesystem setup. Oct 16 23:36:09.715893 systemd[1]: Starting ignition-mount.service - Ignition (mount)... Oct 16 23:36:09.727963 systemd[1]: Starting sysroot-boot.service - /sysroot/boot... Oct 16 23:36:09.740956 kernel: BTRFS info (device sda6): last unmount of filesystem 215947b1-b867-4a28-935e-b2ab65af567d Oct 16 23:36:09.737983 systemd[1]: sysroot-oem.mount: Deactivated successfully. Oct 16 23:36:09.765113 ignition[1079]: INFO : Ignition 2.19.0 Oct 16 23:36:09.768924 ignition[1079]: INFO : Stage: mount Oct 16 23:36:09.768924 ignition[1079]: INFO : no configs at "/usr/lib/ignition/base.d" Oct 16 23:36:09.768924 ignition[1079]: INFO : no config dir at "/usr/lib/ignition/base.platform.d/azure" Oct 16 23:36:09.765523 systemd[1]: Finished sysroot-boot.service - /sysroot/boot. Oct 16 23:36:09.794853 ignition[1079]: INFO : mount: mount passed Oct 16 23:36:09.794853 ignition[1079]: INFO : Ignition finished successfully Oct 16 23:36:09.776644 systemd[1]: Finished ignition-mount.service - Ignition (mount). Oct 16 23:36:09.801912 systemd[1]: Starting ignition-files.service - Ignition (files)... Oct 16 23:36:10.127842 systemd[1]: Mounting sysroot-oem.mount - /sysroot/oem... Oct 16 23:36:10.149346 kernel: BTRFS: device label OEM devid 1 transid 12 /dev/sda6 scanned by mount (1090) Oct 16 23:36:10.160178 kernel: BTRFS info (device sda6): first mount of filesystem 215947b1-b867-4a28-935e-b2ab65af567d Oct 16 23:36:10.160239 kernel: BTRFS info (device sda6): using crc32c (crc32c-generic) checksum algorithm Oct 16 23:36:10.163549 kernel: BTRFS info (device sda6): using free space tree Oct 16 23:36:10.170704 kernel: BTRFS info (device sda6): auto enabling async discard Oct 16 23:36:10.171792 systemd[1]: Mounted sysroot-oem.mount - /sysroot/oem. Oct 16 23:36:10.196339 ignition[1108]: INFO : Ignition 2.19.0 Oct 16 23:36:10.201074 ignition[1108]: INFO : Stage: files Oct 16 23:36:10.201074 ignition[1108]: INFO : no configs at "/usr/lib/ignition/base.d" Oct 16 23:36:10.201074 ignition[1108]: INFO : no config dir at "/usr/lib/ignition/base.platform.d/azure" Oct 16 23:36:10.201074 ignition[1108]: DEBUG : files: compiled without relabeling support, skipping Oct 16 23:36:10.218093 ignition[1108]: INFO : files: ensureUsers: op(1): [started] creating or modifying user "core" Oct 16 23:36:10.218093 ignition[1108]: DEBUG : files: ensureUsers: op(1): executing: "usermod" "--root" "/sysroot" "core" Oct 16 23:36:10.258395 ignition[1108]: INFO : files: ensureUsers: op(1): [finished] creating or modifying user "core" Oct 16 23:36:10.264479 ignition[1108]: INFO : files: ensureUsers: op(2): [started] adding ssh keys to user "core" Oct 16 23:36:10.264479 ignition[1108]: INFO : files: ensureUsers: op(2): [finished] adding ssh keys to user "core" Oct 16 23:36:10.259361 unknown[1108]: wrote ssh authorized keys file for user: core Oct 16 23:36:10.283790 ignition[1108]: INFO : files: createFilesystemsFiles: createFiles: op(3): [started] writing file "/sysroot/etc/flatcar/update.conf" Oct 16 23:36:10.283790 ignition[1108]: INFO : files: createFilesystemsFiles: createFiles: op(3): [finished] writing file "/sysroot/etc/flatcar/update.conf" Oct 16 23:36:10.283790 ignition[1108]: INFO : files: createResultFile: createFiles: op(4): [started] writing file "/sysroot/etc/.ignition-result.json" Oct 16 23:36:10.283790 ignition[1108]: INFO : files: createResultFile: createFiles: op(4): [finished] writing file "/sysroot/etc/.ignition-result.json" Oct 16 23:36:10.283790 ignition[1108]: INFO : files: files passed Oct 16 23:36:10.283790 ignition[1108]: INFO : Ignition finished successfully Oct 16 23:36:10.275830 systemd[1]: Finished ignition-files.service - Ignition (files). Oct 16 23:36:10.306985 systemd[1]: Starting ignition-quench.service - Ignition (record completion)... Oct 16 23:36:10.320884 systemd[1]: Starting initrd-setup-root-after-ignition.service - Root filesystem completion... Oct 16 23:36:10.330284 systemd[1]: ignition-quench.service: Deactivated successfully. Oct 16 23:36:10.330390 systemd[1]: Finished ignition-quench.service - Ignition (record completion). Oct 16 23:36:10.362671 initrd-setup-root-after-ignition[1135]: grep: /sysroot/etc/flatcar/enabled-sysext.conf: No such file or directory Oct 16 23:36:10.362671 initrd-setup-root-after-ignition[1135]: grep: /sysroot/usr/share/flatcar/enabled-sysext.conf: No such file or directory Oct 16 23:36:10.376622 initrd-setup-root-after-ignition[1139]: grep: /sysroot/etc/flatcar/enabled-sysext.conf: No such file or directory Oct 16 23:36:10.377583 systemd[1]: Finished initrd-setup-root-after-ignition.service - Root filesystem completion. Oct 16 23:36:10.388572 systemd[1]: Reached target ignition-complete.target - Ignition Complete. Oct 16 23:36:10.407912 systemd[1]: Starting initrd-parse-etc.service - Mountpoints Configured in the Real Root... Oct 16 23:36:10.433289 systemd[1]: initrd-parse-etc.service: Deactivated successfully. Oct 16 23:36:10.435466 systemd[1]: Finished initrd-parse-etc.service - Mountpoints Configured in the Real Root. Oct 16 23:36:10.443111 systemd[1]: Reached target initrd-fs.target - Initrd File Systems. Oct 16 23:36:10.452188 systemd[1]: Reached target initrd.target - Initrd Default Target. Oct 16 23:36:10.460444 systemd[1]: dracut-mount.service - dracut mount hook was skipped because no trigger condition checks were met. Oct 16 23:36:10.471960 systemd[1]: Starting dracut-pre-pivot.service - dracut pre-pivot and cleanup hook... Oct 16 23:36:10.488116 systemd[1]: Finished dracut-pre-pivot.service - dracut pre-pivot and cleanup hook. Oct 16 23:36:10.499943 systemd[1]: Starting initrd-cleanup.service - Cleaning Up and Shutting Down Daemons... Oct 16 23:36:10.518276 systemd[1]: Stopped target nss-lookup.target - Host and Network Name Lookups. Oct 16 23:36:10.523335 systemd[1]: Stopped target remote-cryptsetup.target - Remote Encrypted Volumes. Oct 16 23:36:10.532883 systemd[1]: Stopped target timers.target - Timer Units. Oct 16 23:36:10.541185 systemd[1]: dracut-pre-pivot.service: Deactivated successfully. Oct 16 23:36:10.541302 systemd[1]: Stopped dracut-pre-pivot.service - dracut pre-pivot and cleanup hook. Oct 16 23:36:10.554227 systemd[1]: Stopped target initrd.target - Initrd Default Target. Oct 16 23:36:10.558837 systemd[1]: Stopped target basic.target - Basic System. Oct 16 23:36:10.567474 systemd[1]: Stopped target ignition-complete.target - Ignition Complete. Oct 16 23:36:10.575901 systemd[1]: Stopped target ignition-diskful.target - Ignition Boot Disk Setup. Oct 16 23:36:10.584252 systemd[1]: Stopped target initrd-root-device.target - Initrd Root Device. Oct 16 23:36:10.593307 systemd[1]: Stopped target remote-fs.target - Remote File Systems. Oct 16 23:36:10.602266 systemd[1]: Stopped target remote-fs-pre.target - Preparation for Remote File Systems. Oct 16 23:36:10.611894 systemd[1]: Stopped target sysinit.target - System Initialization. Oct 16 23:36:10.620080 systemd[1]: Stopped target local-fs.target - Local File Systems. Oct 16 23:36:10.629514 systemd[1]: Stopped target swap.target - Swaps. Oct 16 23:36:10.637033 systemd[1]: dracut-pre-mount.service: Deactivated successfully. Oct 16 23:36:10.637156 systemd[1]: Stopped dracut-pre-mount.service - dracut pre-mount hook. Oct 16 23:36:10.649258 systemd[1]: Stopped target cryptsetup.target - Local Encrypted Volumes. Oct 16 23:36:10.654237 systemd[1]: Stopped target cryptsetup-pre.target - Local Encrypted Volumes (Pre). Oct 16 23:36:10.663095 systemd[1]: clevis-luks-askpass.path: Deactivated successfully. Oct 16 23:36:10.667036 systemd[1]: Stopped clevis-luks-askpass.path - Forward Password Requests to Clevis Directory Watch. Oct 16 23:36:10.672438 systemd[1]: dracut-initqueue.service: Deactivated successfully. Oct 16 23:36:10.672556 systemd[1]: Stopped dracut-initqueue.service - dracut initqueue hook. Oct 16 23:36:10.685900 systemd[1]: initrd-setup-root-after-ignition.service: Deactivated successfully. Oct 16 23:36:10.686005 systemd[1]: Stopped initrd-setup-root-after-ignition.service - Root filesystem completion. Oct 16 23:36:10.691233 systemd[1]: ignition-files.service: Deactivated successfully. Oct 16 23:36:10.691318 systemd[1]: Stopped ignition-files.service - Ignition (files). Oct 16 23:36:10.699135 systemd[1]: flatcar-metadata-hostname.service: Deactivated successfully. Oct 16 23:36:10.699217 systemd[1]: Stopped flatcar-metadata-hostname.service - Flatcar Metadata Hostname Agent. Oct 16 23:36:10.727995 systemd[1]: Stopping ignition-mount.service - Ignition (mount)... Oct 16 23:36:10.757245 ignition[1159]: INFO : Ignition 2.19.0 Oct 16 23:36:10.757245 ignition[1159]: INFO : Stage: umount Oct 16 23:36:10.757245 ignition[1159]: INFO : no configs at "/usr/lib/ignition/base.d" Oct 16 23:36:10.757245 ignition[1159]: INFO : no config dir at "/usr/lib/ignition/base.platform.d/azure" Oct 16 23:36:10.757245 ignition[1159]: INFO : umount: umount passed Oct 16 23:36:10.757245 ignition[1159]: INFO : Ignition finished successfully Oct 16 23:36:10.756959 systemd[1]: Stopping sysroot-boot.service - /sysroot/boot... Oct 16 23:36:10.767040 systemd[1]: systemd-udev-trigger.service: Deactivated successfully. Oct 16 23:36:10.767197 systemd[1]: Stopped systemd-udev-trigger.service - Coldplug All udev Devices. Oct 16 23:36:10.772904 systemd[1]: dracut-pre-trigger.service: Deactivated successfully. Oct 16 23:36:10.773012 systemd[1]: Stopped dracut-pre-trigger.service - dracut pre-trigger hook. Oct 16 23:36:10.789325 systemd[1]: sysroot-boot.mount: Deactivated successfully. Oct 16 23:36:10.789986 systemd[1]: ignition-mount.service: Deactivated successfully. Oct 16 23:36:10.790088 systemd[1]: Stopped ignition-mount.service - Ignition (mount). Oct 16 23:36:10.799042 systemd[1]: sysroot-boot.service: Deactivated successfully. Oct 16 23:36:10.800706 systemd[1]: Stopped sysroot-boot.service - /sysroot/boot. Oct 16 23:36:10.808183 systemd[1]: ignition-disks.service: Deactivated successfully. Oct 16 23:36:10.808469 systemd[1]: Stopped ignition-disks.service - Ignition (disks). Oct 16 23:36:10.816285 systemd[1]: ignition-kargs.service: Deactivated successfully. Oct 16 23:36:10.816335 systemd[1]: Stopped ignition-kargs.service - Ignition (kargs). Oct 16 23:36:10.825185 systemd[1]: ignition-fetch.service: Deactivated successfully. Oct 16 23:36:10.825277 systemd[1]: Stopped ignition-fetch.service - Ignition (fetch). Oct 16 23:36:10.836260 systemd[1]: Stopped target network.target - Network. Oct 16 23:36:10.844417 systemd[1]: ignition-fetch-offline.service: Deactivated successfully. Oct 16 23:36:10.844493 systemd[1]: Stopped ignition-fetch-offline.service - Ignition (fetch-offline). Oct 16 23:36:10.853184 systemd[1]: Stopped target paths.target - Path Units. Oct 16 23:36:10.860568 systemd[1]: systemd-ask-password-console.path: Deactivated successfully. Oct 16 23:36:10.864208 systemd[1]: Stopped systemd-ask-password-console.path - Dispatch Password Requests to Console Directory Watch. Oct 16 23:36:10.869696 systemd[1]: Stopped target slices.target - Slice Units. Oct 16 23:36:10.877458 systemd[1]: Stopped target sockets.target - Socket Units. Oct 16 23:36:10.885214 systemd[1]: iscsid.socket: Deactivated successfully. Oct 16 23:36:10.885265 systemd[1]: Closed iscsid.socket - Open-iSCSI iscsid Socket. Oct 16 23:36:10.893111 systemd[1]: iscsiuio.socket: Deactivated successfully. Oct 16 23:36:10.893147 systemd[1]: Closed iscsiuio.socket - Open-iSCSI iscsiuio Socket. Oct 16 23:36:10.901146 systemd[1]: ignition-setup.service: Deactivated successfully. Oct 16 23:36:10.901191 systemd[1]: Stopped ignition-setup.service - Ignition (setup). Oct 16 23:36:10.909343 systemd[1]: ignition-setup-pre.service: Deactivated successfully. Oct 16 23:36:10.909379 systemd[1]: Stopped ignition-setup-pre.service - Ignition env setup. Oct 16 23:36:10.917724 systemd[1]: initrd-setup-root.service: Deactivated successfully. Oct 16 23:36:10.917762 systemd[1]: Stopped initrd-setup-root.service - Root filesystem setup. Oct 16 23:36:10.928406 systemd[1]: Stopping systemd-networkd.service - Network Configuration... Oct 16 23:36:10.937643 systemd[1]: Stopping systemd-resolved.service - Network Name Resolution... Oct 16 23:36:10.945589 systemd-networkd[900]: eth0: DHCPv6 lease lost Oct 16 23:36:10.947205 systemd[1]: systemd-networkd.service: Deactivated successfully. Oct 16 23:36:11.112612 kernel: hv_netvsc 7ced8dd4-cc46-7ced-8dd4-cc467ced8dd4 eth0: Data path switched from VF: enP57398s1 Oct 16 23:36:10.947341 systemd[1]: Stopped systemd-networkd.service - Network Configuration. Oct 16 23:36:10.957315 systemd[1]: initrd-cleanup.service: Deactivated successfully. Oct 16 23:36:10.957411 systemd[1]: Finished initrd-cleanup.service - Cleaning Up and Shutting Down Daemons. Oct 16 23:36:10.968405 systemd[1]: systemd-networkd.socket: Deactivated successfully. Oct 16 23:36:10.968461 systemd[1]: Closed systemd-networkd.socket - Network Service Netlink Socket. Oct 16 23:36:10.991854 systemd[1]: Stopping network-cleanup.service - Network Cleanup... Oct 16 23:36:10.998612 systemd[1]: parse-ip-for-networkd.service: Deactivated successfully. Oct 16 23:36:10.998677 systemd[1]: Stopped parse-ip-for-networkd.service - Write systemd-networkd units from cmdline. Oct 16 23:36:11.007718 systemd[1]: Stopping systemd-udevd.service - Rule-based Manager for Device Events and Files... Oct 16 23:36:11.020154 systemd[1]: systemd-resolved.service: Deactivated successfully. Oct 16 23:36:11.020263 systemd[1]: Stopped systemd-resolved.service - Network Name Resolution. Oct 16 23:36:11.043808 systemd[1]: systemd-sysctl.service: Deactivated successfully. Oct 16 23:36:11.043938 systemd[1]: Stopped systemd-sysctl.service - Apply Kernel Variables. Oct 16 23:36:11.052534 systemd[1]: systemd-modules-load.service: Deactivated successfully. Oct 16 23:36:11.052589 systemd[1]: Stopped systemd-modules-load.service - Load Kernel Modules. Oct 16 23:36:11.061167 systemd[1]: systemd-tmpfiles-setup.service: Deactivated successfully. Oct 16 23:36:11.061214 systemd[1]: Stopped systemd-tmpfiles-setup.service - Create System Files and Directories. Oct 16 23:36:11.072092 systemd[1]: systemd-udevd.service: Deactivated successfully. Oct 16 23:36:11.072224 systemd[1]: Stopped systemd-udevd.service - Rule-based Manager for Device Events and Files. Oct 16 23:36:11.082313 systemd[1]: systemd-udevd-control.socket: Deactivated successfully. Oct 16 23:36:11.082378 systemd[1]: Closed systemd-udevd-control.socket - udev Control Socket. Oct 16 23:36:11.091331 systemd[1]: systemd-udevd-kernel.socket: Deactivated successfully. Oct 16 23:36:11.091373 systemd[1]: Closed systemd-udevd-kernel.socket - udev Kernel Socket. Oct 16 23:36:11.104259 systemd[1]: dracut-pre-udev.service: Deactivated successfully. Oct 16 23:36:11.104323 systemd[1]: Stopped dracut-pre-udev.service - dracut pre-udev hook. Oct 16 23:36:11.117138 systemd[1]: dracut-cmdline.service: Deactivated successfully. Oct 16 23:36:11.117222 systemd[1]: Stopped dracut-cmdline.service - dracut cmdline hook. Oct 16 23:36:11.125450 systemd[1]: dracut-cmdline-ask.service: Deactivated successfully. Oct 16 23:36:11.125503 systemd[1]: Stopped dracut-cmdline-ask.service - dracut ask for additional cmdline parameters. Oct 16 23:36:11.152906 systemd[1]: Starting initrd-udevadm-cleanup-db.service - Cleanup udev Database... Oct 16 23:36:11.167727 systemd[1]: systemd-tmpfiles-setup-dev.service: Deactivated successfully. Oct 16 23:36:11.167802 systemd[1]: Stopped systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev. Oct 16 23:36:11.173481 systemd[1]: systemd-tmpfiles-setup-dev-early.service: Deactivated successfully. Oct 16 23:36:11.322955 systemd-journald[218]: Received SIGTERM from PID 1 (systemd). Oct 16 23:36:11.173523 systemd[1]: Stopped systemd-tmpfiles-setup-dev-early.service - Create Static Device Nodes in /dev gracefully. Oct 16 23:36:11.184053 systemd[1]: kmod-static-nodes.service: Deactivated successfully. Oct 16 23:36:11.184086 systemd[1]: Stopped kmod-static-nodes.service - Create List of Static Device Nodes. Oct 16 23:36:11.193029 systemd[1]: systemd-vconsole-setup.service: Deactivated successfully. Oct 16 23:36:11.193062 systemd[1]: Stopped systemd-vconsole-setup.service - Virtual Console Setup. Oct 16 23:36:11.202312 systemd[1]: network-cleanup.service: Deactivated successfully. Oct 16 23:36:11.202418 systemd[1]: Stopped network-cleanup.service - Network Cleanup. Oct 16 23:36:11.209985 systemd[1]: initrd-udevadm-cleanup-db.service: Deactivated successfully. Oct 16 23:36:11.210063 systemd[1]: Finished initrd-udevadm-cleanup-db.service - Cleanup udev Database. Oct 16 23:36:11.219547 systemd[1]: Reached target initrd-switch-root.target - Switch Root. Oct 16 23:36:11.240771 systemd[1]: Starting initrd-switch-root.service - Switch Root... Oct 16 23:36:11.249888 systemd[1]: Switching root. Oct 16 23:36:11.351369 systemd-journald[218]: Journal stopped Oct 16 23:36:02.227241 kernel: Booting Linux on physical CPU 0x0000000000 [0x413fd0c1] Oct 16 23:36:02.227263 kernel: Linux version 6.6.157-flatcar (build@pony-truck.infra.kinvolk.io) (aarch64-cros-linux-gnu-gcc (Gentoo Hardened 13.3.1_p20240614 p17) 13.3.1 20240614, GNU ld (Gentoo 2.42 p3) 2.42.0) #1 SMP PREEMPT Fri Oct 16 22:26:59 -00 2026 Oct 16 23:36:02.227270 kernel: KASLR enabled Oct 16 23:36:02.227276 kernel: earlycon: pl11 at MMIO 0x00000000effec000 (options '') Oct 16 23:36:02.227284 kernel: printk: bootconsole [pl11] enabled Oct 16 23:36:02.227289 kernel: efi: EFI v2.7 by EDK II Oct 16 23:36:02.227296 kernel: efi: ACPI 2.0=0x3fd5f018 SMBIOS=0x3e580000 SMBIOS 3.0=0x3e560000 MEMATTR=0x3f213018 RNG=0x3fd5f998 MEMRESERVE=0x3e44ee18 Oct 16 23:36:02.227303 kernel: random: crng init done Oct 16 23:36:02.227309 kernel: ACPI: Early table checksum verification disabled Oct 16 23:36:02.227314 kernel: ACPI: RSDP 0x000000003FD5F018 000024 (v02 VRTUAL) Oct 16 23:36:02.227321 kernel: ACPI: XSDT 0x000000003FD5FF18 00006C (v01 VRTUAL MICROSFT 00000001 MSFT 00000001) Oct 16 23:36:02.227327 kernel: ACPI: FACP 0x000000003FD5FC18 000114 (v06 VRTUAL MICROSFT 00000001 MSFT 00000001) Oct 16 23:36:02.227334 kernel: ACPI: DSDT 0x000000003FD41018 01DF7E (v02 MSFTVM DSDT01 00000001 INTL 20230628) Oct 16 23:36:02.227341 kernel: ACPI: DBG2 0x000000003FD5FB18 000072 (v00 VRTUAL MICROSFT 00000001 MSFT 00000001) Oct 16 23:36:02.227348 kernel: ACPI: GTDT 0x000000003FD5FD98 000060 (v02 VRTUAL MICROSFT 00000001 MSFT 00000001) Oct 16 23:36:02.227354 kernel: ACPI: OEM0 0x000000003FD5F098 000064 (v01 VRTUAL MICROSFT 00000001 MSFT 00000001) Oct 16 23:36:02.227361 kernel: ACPI: SPCR 0x000000003FD5FA98 000050 (v02 VRTUAL MICROSFT 00000001 MSFT 00000001) Oct 16 23:36:02.227369 kernel: ACPI: APIC 0x000000003FD5F818 0000FC (v04 VRTUAL MICROSFT 00000001 MSFT 00000001) Oct 16 23:36:02.227375 kernel: ACPI: SRAT 0x000000003FD5F198 000234 (v03 VRTUAL MICROSFT 00000001 MSFT 00000001) Oct 16 23:36:02.227381 kernel: ACPI: PPTT 0x000000003FD5F418 000120 (v01 VRTUAL MICROSFT 00000000 MSFT 00000000) Oct 16 23:36:02.227388 kernel: ACPI: BGRT 0x000000003FD5FE98 000038 (v01 VRTUAL MICROSFT 00000001 MSFT 00000001) Oct 16 23:36:02.227394 kernel: ACPI: SPCR: console: pl011,mmio32,0xeffec000,115200 Oct 16 23:36:02.227401 kernel: ACPI: SRAT: Node 0 PXM 0 [mem 0x00000000-0x3fffffff] Oct 16 23:36:02.227407 kernel: ACPI: SRAT: Node 0 PXM 0 [mem 0x100000000-0x1bfffffff] Oct 16 23:36:02.227413 kernel: ACPI: SRAT: Node 0 PXM 0 [mem 0x1c0000000-0xfbfffffff] Oct 16 23:36:02.227420 kernel: ACPI: SRAT: Node 0 PXM 0 [mem 0x1000000000-0xffffffffff] Oct 16 23:36:02.227426 kernel: ACPI: SRAT: Node 0 PXM 0 [mem 0x10000000000-0x1ffffffffff] Oct 16 23:36:02.227433 kernel: ACPI: SRAT: Node 0 PXM 0 [mem 0x20000000000-0x3ffffffffff] Oct 16 23:36:02.227441 kernel: ACPI: SRAT: Node 0 PXM 0 [mem 0x40000000000-0x7ffffffffff] Oct 16 23:36:02.227447 kernel: ACPI: SRAT: Node 0 PXM 0 [mem 0x80000000000-0xfffffffffff] Oct 16 23:36:02.227453 kernel: ACPI: SRAT: Node 0 PXM 0 [mem 0x100000000000-0x1fffffffffff] Oct 16 23:36:02.227460 kernel: ACPI: SRAT: Node 0 PXM 0 [mem 0x200000000000-0x3fffffffffff] Oct 16 23:36:02.227466 kernel: ACPI: SRAT: Node 0 PXM 0 [mem 0x400000000000-0x7fffffffffff] Oct 16 23:36:02.227473 kernel: ACPI: SRAT: Node 0 PXM 0 [mem 0x800000000000-0xffffffffffff] Oct 16 23:36:02.227479 kernel: NUMA: NODE_DATA [mem 0x1bf7ee800-0x1bf7f3fff] Oct 16 23:36:02.227485 kernel: Zone ranges: Oct 16 23:36:02.227492 kernel: DMA [mem 0x0000000000000000-0x00000000ffffffff] Oct 16 23:36:02.227498 kernel: DMA32 empty Oct 16 23:36:02.227504 kernel: Normal [mem 0x0000000100000000-0x00000001bfffffff] Oct 16 23:36:02.227511 kernel: Movable zone start for each node Oct 16 23:36:02.227521 kernel: Early memory node ranges Oct 16 23:36:02.227528 kernel: node 0: [mem 0x0000000000000000-0x00000000007fffff] Oct 16 23:36:02.227535 kernel: node 0: [mem 0x0000000000824000-0x000000003e54ffff] Oct 16 23:36:02.227541 kernel: node 0: [mem 0x000000003e550000-0x000000003e87ffff] Oct 16 23:36:02.227548 kernel: node 0: [mem 0x000000003e880000-0x000000003fc7ffff] Oct 16 23:36:02.227557 kernel: node 0: [mem 0x000000003fc80000-0x000000003fcfffff] Oct 16 23:36:02.227563 kernel: node 0: [mem 0x000000003fd00000-0x000000003fffffff] Oct 16 23:36:02.227570 kernel: node 0: [mem 0x0000000100000000-0x00000001bfffffff] Oct 16 23:36:02.227577 kernel: Initmem setup node 0 [mem 0x0000000000000000-0x00000001bfffffff] Oct 16 23:36:02.227584 kernel: On node 0, zone DMA: 36 pages in unavailable ranges Oct 16 23:36:02.227590 kernel: psci: probing for conduit method from ACPI. Oct 16 23:36:02.227597 kernel: psci: PSCIv1.1 detected in firmware. Oct 16 23:36:02.227604 kernel: psci: Using standard PSCI v0.2 function IDs Oct 16 23:36:02.227610 kernel: psci: MIGRATE_INFO_TYPE not supported. Oct 16 23:36:02.227617 kernel: psci: SMC Calling Convention v1.4 Oct 16 23:36:02.227623 kernel: ACPI: NUMA: SRAT: PXM 0 -> MPIDR 0x0 -> Node 0 Oct 16 23:36:02.227630 kernel: ACPI: NUMA: SRAT: PXM 0 -> MPIDR 0x1 -> Node 0 Oct 16 23:36:02.227638 kernel: percpu: Embedded 30 pages/cpu s85800 r8192 d28888 u122880 Oct 16 23:36:02.227645 kernel: pcpu-alloc: s85800 r8192 d28888 u122880 alloc=30*4096 Oct 16 23:36:02.227652 kernel: pcpu-alloc: [0] 0 [0] 1 Oct 16 23:36:02.227659 kernel: Detected PIPT I-cache on CPU0 Oct 16 23:36:02.227666 kernel: CPU features: detected: GIC system register CPU interface Oct 16 23:36:02.227672 kernel: CPU features: detected: Hardware dirty bit management Oct 16 23:36:02.227679 kernel: CPU features: detected: Spectre-BHB Oct 16 23:36:02.227686 kernel: CPU features: kernel page table isolation forced ON by KASLR Oct 16 23:36:02.227692 kernel: CPU features: detected: Kernel page table isolation (KPTI) Oct 16 23:36:02.227699 kernel: CPU features: detected: ARM erratum 1418040 Oct 16 23:36:02.227706 kernel: CPU features: detected: ARM erratum 1542419 (kernel portion) Oct 16 23:36:02.227714 kernel: CPU features: detected: Broken broadcast TLBI completion Oct 16 23:36:02.227721 kernel: CPU features: detected: SSBS not fully self-synchronizing Oct 16 23:36:02.227728 kernel: alternatives: applying boot alternatives Oct 16 23:36:02.227736 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=b6d8446922cf13eecaec0980e282bbdb3b0ddc033d7963ab534d359a174601ee Oct 16 23:36:02.227743 kernel: Dentry cache hash table entries: 524288 (order: 10, 4194304 bytes, linear) Oct 16 23:36:02.227750 kernel: Inode-cache hash table entries: 262144 (order: 9, 2097152 bytes, linear) Oct 16 23:36:02.227757 kernel: Fallback order for Node 0: 0 Oct 16 23:36:02.227763 kernel: Built 1 zonelists, mobility grouping on. Total pages: 1032156 Oct 16 23:36:02.227770 kernel: Policy zone: Normal Oct 16 23:36:02.227777 kernel: mem auto-init: stack:off, heap alloc:off, heap free:off Oct 16 23:36:02.227783 kernel: software IO TLB: area num 2. Oct 16 23:36:02.227791 kernel: software IO TLB: mapped [mem 0x000000003a44e000-0x000000003e44e000] (64MB) Oct 16 23:36:02.227799 kernel: Memory: 3982504K/4194160K available (10304K kernel code, 2180K rwdata, 8136K rodata, 39488K init, 901K bss, 211656K reserved, 0K cma-reserved) Oct 16 23:36:02.227806 kernel: SLUB: HWalign=64, Order=0-3, MinObjects=0, CPUs=2, Nodes=1 Oct 16 23:36:02.227813 kernel: rcu: Preemptible hierarchical RCU implementation. Oct 16 23:36:02.227820 kernel: rcu: RCU event tracing is enabled. Oct 16 23:36:02.227827 kernel: rcu: RCU restricting CPUs from NR_CPUS=512 to nr_cpu_ids=2. Oct 16 23:36:02.227834 kernel: Trampoline variant of Tasks RCU enabled. Oct 16 23:36:02.227841 kernel: Tracing variant of Tasks RCU enabled. Oct 16 23:36:02.227847 kernel: rcu: RCU calculated value of scheduler-enlistment delay is 100 jiffies. Oct 16 23:36:02.227854 kernel: rcu: Adjusting geometry for rcu_fanout_leaf=16, nr_cpu_ids=2 Oct 16 23:36:02.227861 kernel: NR_IRQS: 64, nr_irqs: 64, preallocated irqs: 0 Oct 16 23:36:02.227869 kernel: GICv3: 960 SPIs implemented Oct 16 23:36:02.227876 kernel: GICv3: 0 Extended SPIs implemented Oct 16 23:36:02.227882 kernel: Root IRQ handler: gic_handle_irq Oct 16 23:36:02.227889 kernel: GICv3: GICv3 features: 16 PPIs, RSS Oct 16 23:36:02.227896 kernel: GICv3: CPU0: found redistributor 0 region 0:0x00000000effee000 Oct 16 23:36:02.227903 kernel: ITS: No ITS available, not enabling LPIs Oct 16 23:36:02.227909 kernel: rcu: srcu_init: Setting srcu_struct sizes based on contention. Oct 16 23:36:02.227917 kernel: arch_timer: Enabling local workaround for ARM erratum 1418040 Oct 16 23:36:02.227923 kernel: arch_timer: cp15 timer(s) running at 25.00MHz (virt). Oct 16 23:36:02.227930 kernel: clocksource: arch_sys_counter: mask: 0xffffffffffffff max_cycles: 0x5c40939b5, max_idle_ns: 440795202646 ns Oct 16 23:36:02.227937 kernel: sched_clock: 56 bits at 25MHz, resolution 40ns, wraps every 4398046511100ns Oct 16 23:36:02.227944 kernel: Console: colour dummy device 80x25 Oct 16 23:36:02.227953 kernel: printk: console [tty1] enabled Oct 16 23:36:02.227960 kernel: ACPI: Core revision 20230628 Oct 16 23:36:02.227967 kernel: Calibrating delay loop (skipped), value calculated using timer frequency.. 50.00 BogoMIPS (lpj=25000) Oct 16 23:36:02.227974 kernel: pid_max: default: 32768 minimum: 301 Oct 16 23:36:02.227981 kernel: LSM: initializing lsm=lockdown,capability,landlock,selinux,integrity Oct 16 23:36:02.227988 kernel: landlock: Up and running. Oct 16 23:36:02.227994 kernel: SELinux: Initializing. Oct 16 23:36:02.228001 kernel: Mount-cache hash table entries: 8192 (order: 4, 65536 bytes, linear) Oct 16 23:36:02.228008 kernel: Mountpoint-cache hash table entries: 8192 (order: 4, 65536 bytes, linear) Oct 16 23:36:02.228017 kernel: RCU Tasks: Setting shift to 1 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=2. Oct 16 23:36:02.228024 kernel: RCU Tasks Trace: Setting shift to 1 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=2. Oct 16 23:36:02.228031 kernel: Hyper-V: privilege flags low 0x2e7f, high 0x3a8030, hints 0x100000e, misc 0x31e1 Oct 16 23:36:02.228038 kernel: Hyper-V: Host Build 10.0.26100.1601-1-0 Oct 16 23:36:02.228045 kernel: Hyper-V: enabling crash_kexec_post_notifiers Oct 16 23:36:02.228051 kernel: rcu: Hierarchical SRCU implementation. Oct 16 23:36:02.228058 kernel: rcu: Max phase no-delay instances is 400. Oct 16 23:36:02.228078 kernel: Remapping and enabling EFI services. Oct 16 23:36:02.228086 kernel: smp: Bringing up secondary CPUs ... Oct 16 23:36:02.228093 kernel: Detected PIPT I-cache on CPU1 Oct 16 23:36:02.228101 kernel: GICv3: CPU1: found redistributor 1 region 1:0x00000000f000e000 Oct 16 23:36:02.228109 kernel: arch_timer: Enabling local workaround for ARM erratum 1418040 Oct 16 23:36:02.228116 kernel: CPU1: Booted secondary processor 0x0000000001 [0x413fd0c1] Oct 16 23:36:02.228124 kernel: smp: Brought up 1 node, 2 CPUs Oct 16 23:36:02.228131 kernel: SMP: Total of 2 processors activated. Oct 16 23:36:02.228138 kernel: CPU features: detected: 32-bit EL0 Support Oct 16 23:36:02.228147 kernel: CPU features: detected: Instruction cache invalidation not required for I/D coherence Oct 16 23:36:02.228154 kernel: CPU features: detected: Data cache clean to the PoU not required for I/D coherence Oct 16 23:36:02.228162 kernel: CPU features: detected: CRC32 instructions Oct 16 23:36:02.228169 kernel: CPU features: detected: RCpc load-acquire (LDAPR) Oct 16 23:36:02.228176 kernel: CPU features: detected: LSE atomic instructions Oct 16 23:36:02.228184 kernel: CPU features: detected: Privileged Access Never Oct 16 23:36:02.228191 kernel: CPU: All CPU(s) started at EL1 Oct 16 23:36:02.228198 kernel: alternatives: applying system-wide alternatives Oct 16 23:36:02.228205 kernel: devtmpfs: initialized Oct 16 23:36:02.228214 kernel: clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1911260446275000 ns Oct 16 23:36:02.228222 kernel: futex hash table entries: 512 (order: 3, 32768 bytes, linear) Oct 16 23:36:02.228230 kernel: pinctrl core: initialized pinctrl subsystem Oct 16 23:36:02.228238 kernel: SMBIOS 3.1.0 present. Oct 16 23:36:02.228246 kernel: DMI: Microsoft Corporation Virtual Machine/Virtual Machine, BIOS Hyper-V UEFI Release v4.1 01/09/2026 Oct 16 23:36:02.228254 kernel: NET: Registered PF_NETLINK/PF_ROUTE protocol family Oct 16 23:36:02.228261 kernel: DMA: preallocated 512 KiB GFP_KERNEL pool for atomic allocations Oct 16 23:36:02.228270 kernel: DMA: preallocated 512 KiB GFP_KERNEL|GFP_DMA pool for atomic allocations Oct 16 23:36:02.228278 kernel: DMA: preallocated 512 KiB GFP_KERNEL|GFP_DMA32 pool for atomic allocations Oct 16 23:36:02.228287 kernel: audit: initializing netlink subsys (disabled) Oct 16 23:36:02.228295 kernel: audit: type=2000 audit(0.047:1): state=initialized audit_enabled=0 res=1 Oct 16 23:36:02.228303 kernel: thermal_sys: Registered thermal governor 'step_wise' Oct 16 23:36:02.228311 kernel: cpuidle: using governor menu Oct 16 23:36:02.228318 kernel: hw-breakpoint: found 6 breakpoint and 4 watchpoint registers. Oct 16 23:36:02.228326 kernel: ASID allocator initialised with 32768 entries Oct 16 23:36:02.228335 kernel: acpiphp: ACPI Hot Plug PCI Controller Driver version: 0.5 Oct 16 23:36:02.228343 kernel: Serial: AMBA PL011 UART driver Oct 16 23:36:02.228350 kernel: Modules: 2G module region forced by RANDOMIZE_MODULE_REGION_FULL Oct 16 23:36:02.228360 kernel: Modules: 0 pages in range for non-PLT usage Oct 16 23:36:02.228368 kernel: Modules: 508976 pages in range for PLT usage Oct 16 23:36:02.228376 kernel: HugeTLB: registered 1.00 GiB page size, pre-allocated 0 pages Oct 16 23:36:02.228384 kernel: HugeTLB: 0 KiB vmemmap can be freed for a 1.00 GiB page Oct 16 23:36:02.228392 kernel: HugeTLB: registered 32.0 MiB page size, pre-allocated 0 pages Oct 16 23:36:02.228400 kernel: HugeTLB: 0 KiB vmemmap can be freed for a 32.0 MiB page Oct 16 23:36:02.228408 kernel: HugeTLB: registered 2.00 MiB page size, pre-allocated 0 pages Oct 16 23:36:02.228416 kernel: HugeTLB: 0 KiB vmemmap can be freed for a 2.00 MiB page Oct 16 23:36:02.228424 kernel: HugeTLB: registered 64.0 KiB page size, pre-allocated 0 pages Oct 16 23:36:02.228434 kernel: HugeTLB: 0 KiB vmemmap can be freed for a 64.0 KiB page Oct 16 23:36:02.228442 kernel: ACPI: Added _OSI(Module Device) Oct 16 23:36:02.228450 kernel: ACPI: Added _OSI(Processor Device) Oct 16 23:36:02.228458 kernel: ACPI: Added _OSI(Processor Aggregator Device) Oct 16 23:36:02.228465 kernel: ACPI: 1 ACPI AML tables successfully acquired and loaded Oct 16 23:36:02.228473 kernel: ACPI: Interpreter enabled Oct 16 23:36:02.228481 kernel: ACPI: Using GIC for interrupt routing Oct 16 23:36:02.228489 kernel: ARMH0011:00: ttyAMA0 at MMIO 0xeffec000 (irq = 12, base_baud = 0) is a SBSA Oct 16 23:36:02.228497 kernel: printk: console [ttyAMA0] enabled Oct 16 23:36:02.228507 kernel: printk: bootconsole [pl11] disabled Oct 16 23:36:02.228515 kernel: ARMH0011:01: ttyAMA1 at MMIO 0xeffeb000 (irq = 13, base_baud = 0) is a SBSA Oct 16 23:36:02.228523 kernel: iommu: Default domain type: Translated Oct 16 23:36:02.228531 kernel: iommu: DMA domain TLB invalidation policy: strict mode Oct 16 23:36:02.228540 kernel: efivars: Registered efivars operations Oct 16 23:36:02.228547 kernel: vgaarb: loaded Oct 16 23:36:02.228555 kernel: clocksource: Switched to clocksource arch_sys_counter Oct 16 23:36:02.228563 kernel: VFS: Disk quotas dquot_6.6.0 Oct 16 23:36:02.228571 kernel: VFS: Dquot-cache hash table entries: 512 (order 0, 4096 bytes) Oct 16 23:36:02.228580 kernel: pnp: PnP ACPI init Oct 16 23:36:02.228589 kernel: pnp: PnP ACPI: found 0 devices Oct 16 23:36:02.228596 kernel: NET: Registered PF_INET protocol family Oct 16 23:36:02.228604 kernel: IP idents hash table entries: 65536 (order: 7, 524288 bytes, linear) Oct 16 23:36:02.228612 kernel: tcp_listen_portaddr_hash hash table entries: 2048 (order: 3, 32768 bytes, linear) Oct 16 23:36:02.228620 kernel: Table-perturb hash table entries: 65536 (order: 6, 262144 bytes, linear) Oct 16 23:36:02.228628 kernel: TCP established hash table entries: 32768 (order: 6, 262144 bytes, linear) Oct 16 23:36:02.228636 kernel: TCP bind hash table entries: 32768 (order: 8, 1048576 bytes, linear) Oct 16 23:36:02.228644 kernel: TCP: Hash tables configured (established 32768 bind 32768) Oct 16 23:36:02.228653 kernel: UDP hash table entries: 2048 (order: 4, 65536 bytes, linear) Oct 16 23:36:02.228661 kernel: UDP-Lite hash table entries: 2048 (order: 4, 65536 bytes, linear) Oct 16 23:36:02.228669 kernel: NET: Registered PF_UNIX/PF_LOCAL protocol family Oct 16 23:36:02.228677 kernel: PCI: CLS 0 bytes, default 64 Oct 16 23:36:02.228685 kernel: kvm [1]: HYP mode not available Oct 16 23:36:02.228693 kernel: Initialise system trusted keyrings Oct 16 23:36:02.228701 kernel: workingset: timestamp_bits=39 max_order=20 bucket_order=0 Oct 16 23:36:02.228709 kernel: Key type asymmetric registered Oct 16 23:36:02.228716 kernel: Asymmetric key parser 'x509' registered Oct 16 23:36:02.228725 kernel: Block layer SCSI generic (bsg) driver version 0.4 loaded (major 250) Oct 16 23:36:02.228734 kernel: io scheduler mq-deadline registered Oct 16 23:36:02.228742 kernel: io scheduler kyber registered Oct 16 23:36:02.228749 kernel: io scheduler bfq registered Oct 16 23:36:02.228757 kernel: Serial: 8250/16550 driver, 4 ports, IRQ sharing enabled Oct 16 23:36:02.228765 kernel: thunder_xcv, ver 1.0 Oct 16 23:36:02.228773 kernel: thunder_bgx, ver 1.0 Oct 16 23:36:02.228780 kernel: nicpf, ver 1.0 Oct 16 23:36:02.228789 kernel: nicvf, ver 1.0 Oct 16 23:36:02.228930 kernel: rtc-efi rtc-efi.0: registered as rtc0 Oct 16 23:36:02.229015 kernel: rtc-efi rtc-efi.0: setting system clock to 2026-10-16T23:36:01 UTC (1792193761) Oct 16 23:36:02.229026 kernel: efifb: probing for efifb Oct 16 23:36:02.229034 kernel: efifb: framebuffer at 0x40000000, using 3072k, total 3072k Oct 16 23:36:02.229043 kernel: efifb: mode is 1024x768x32, linelength=4096, pages=1 Oct 16 23:36:02.229050 kernel: efifb: scrolling: redraw Oct 16 23:36:02.229058 kernel: efifb: Truecolor: size=8:8:8:8, shift=24:16:8:0 Oct 16 23:36:02.229072 kernel: Console: switching to colour frame buffer device 128x48 Oct 16 23:36:02.229083 kernel: fb0: EFI VGA frame buffer device Oct 16 23:36:02.229092 kernel: SMCCC: SOC_ID: ARCH_SOC_ID not implemented, skipping .... Oct 16 23:36:02.229099 kernel: hid: raw HID events driver (C) Jiri Kosina Oct 16 23:36:02.229107 kernel: hw perfevents: enabled with armv8_pmuv3_0 PMU driver, 6 counters available Oct 16 23:36:02.229116 kernel: watchdog: Delayed init of the lockup detector failed: -19 Oct 16 23:36:02.229124 kernel: watchdog: Hard watchdog permanently disabled Oct 16 23:36:02.229131 kernel: NET: Registered PF_INET6 protocol family Oct 16 23:36:02.229139 kernel: Segment Routing with IPv6 Oct 16 23:36:02.229147 kernel: In-situ OAM (IOAM) with IPv6 Oct 16 23:36:02.229156 kernel: NET: Registered PF_PACKET protocol family Oct 16 23:36:02.229164 kernel: Key type dns_resolver registered Oct 16 23:36:02.229172 kernel: registered taskstats version 1 Oct 16 23:36:02.229180 kernel: Loading compiled-in X.509 certificates Oct 16 23:36:02.229188 kernel: Loaded X.509 cert 'Kinvolk GmbH: Module signing key for 6.6.157-flatcar: 826cf14d1fa97ed54b7271b7b56accf57910e9fc' Oct 16 23:36:02.229196 kernel: Key type .fscrypt registered Oct 16 23:36:02.229204 kernel: Key type fscrypt-provisioning registered Oct 16 23:36:02.229212 kernel: ima: No TPM chip found, activating TPM-bypass! Oct 16 23:36:02.229219 kernel: ima: Allocated hash algorithm: sha1 Oct 16 23:36:02.229226 kernel: ima: No architecture policies found Oct 16 23:36:02.229235 kernel: alg: No test for fips(ansi_cprng) (fips_ansi_cprng) Oct 16 23:36:02.229242 kernel: clk: Disabling unused clocks Oct 16 23:36:02.229250 kernel: Freeing unused kernel memory: 39488K Oct 16 23:36:02.229257 kernel: Run /init as init process Oct 16 23:36:02.229264 kernel: with arguments: Oct 16 23:36:02.229271 kernel: /init Oct 16 23:36:02.229278 kernel: with environment: Oct 16 23:36:02.229285 kernel: HOME=/ Oct 16 23:36:02.229292 kernel: TERM=linux Oct 16 23:36:02.229303 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) Oct 16 23:36:02.229312 systemd[1]: Detected virtualization microsoft. Oct 16 23:36:02.229320 systemd[1]: Detected architecture arm64. Oct 16 23:36:02.229327 systemd[1]: Running in initrd. Oct 16 23:36:02.229335 systemd[1]: No hostname configured, using default hostname. Oct 16 23:36:02.229343 systemd[1]: Hostname set to . Oct 16 23:36:02.229351 systemd[1]: Initializing machine ID from random generator. Oct 16 23:36:02.229360 systemd[1]: Queued start job for default target initrd.target. Oct 16 23:36:02.229368 systemd[1]: Started clevis-luks-askpass.path - Forward Password Requests to Clevis Directory Watch. Oct 16 23:36:02.229376 systemd[1]: Started systemd-ask-password-console.path - Dispatch Password Requests to Console Directory Watch. Oct 16 23:36:02.229385 systemd[1]: Expecting device dev-disk-by\x2dlabel-EFI\x2dSYSTEM.device - /dev/disk/by-label/EFI-SYSTEM... Oct 16 23:36:02.229393 systemd[1]: Expecting device dev-disk-by\x2dlabel-OEM.device - /dev/disk/by-label/OEM... Oct 16 23:36:02.229401 systemd[1]: Expecting device dev-disk-by\x2dlabel-ROOT.device - /dev/disk/by-label/ROOT... Oct 16 23:36:02.229409 systemd[1]: Expecting device dev-disk-by\x2dpartlabel-USR\x2dA.device - /dev/disk/by-partlabel/USR-A... Oct 16 23:36:02.229420 systemd[1]: Expecting device dev-disk-by\x2dpartuuid-7130c94a\x2d213a\x2d4e5a\x2d8e26\x2d6cce9662f132.device - /dev/disk/by-partuuid/7130c94a-213a-4e5a-8e26-6cce9662f132... Oct 16 23:36:02.229428 systemd[1]: Expecting device dev-mapper-usr.device - /dev/mapper/usr... Oct 16 23:36:02.229436 systemd[1]: Reached target cryptsetup-pre.target - Local Encrypted Volumes (Pre). Oct 16 23:36:02.229444 systemd[1]: Reached target cryptsetup.target - Local Encrypted Volumes. Oct 16 23:36:02.229452 systemd[1]: Reached target paths.target - Path Units. Oct 16 23:36:02.229460 systemd[1]: Reached target slices.target - Slice Units. Oct 16 23:36:02.229468 systemd[1]: Reached target swap.target - Swaps. Oct 16 23:36:02.229476 systemd[1]: Reached target timers.target - Timer Units. Oct 16 23:36:02.229485 systemd[1]: Listening on iscsid.socket - Open-iSCSI iscsid Socket. Oct 16 23:36:02.229493 systemd[1]: Listening on iscsiuio.socket - Open-iSCSI iscsiuio Socket. Oct 16 23:36:02.229501 systemd[1]: Listening on systemd-journald-dev-log.socket - Journal Socket (/dev/log). Oct 16 23:36:02.229508 systemd[1]: Listening on systemd-journald.socket - Journal Socket. Oct 16 23:36:02.229516 systemd[1]: Listening on systemd-networkd.socket - Network Service Netlink Socket. Oct 16 23:36:02.229524 systemd[1]: Listening on systemd-udevd-control.socket - udev Control Socket. Oct 16 23:36:02.229532 systemd[1]: Listening on systemd-udevd-kernel.socket - udev Kernel Socket. Oct 16 23:36:02.229540 systemd[1]: Reached target sockets.target - Socket Units. Oct 16 23:36:02.229549 systemd[1]: Starting ignition-setup-pre.service - Ignition env setup... Oct 16 23:36:02.229557 systemd[1]: Starting kmod-static-nodes.service - Create List of Static Device Nodes... Oct 16 23:36:02.229565 systemd[1]: Finished network-cleanup.service - Network Cleanup. Oct 16 23:36:02.229573 systemd[1]: Starting systemd-fsck-usr.service... Oct 16 23:36:02.229580 systemd[1]: Starting systemd-journald.service - Journal Service... Oct 16 23:36:02.229588 systemd[1]: Starting systemd-modules-load.service - Load Kernel Modules... Oct 16 23:36:02.229611 systemd-journald[218]: Collecting audit messages is disabled. Oct 16 23:36:02.229631 systemd-journald[218]: Journal started Oct 16 23:36:02.229650 systemd-journald[218]: Runtime Journal (/run/log/journal/10946151bf9a4d20ae4dcc80d47bc0ba) is 8.0M, max 78.5M, 70.5M free. Oct 16 23:36:02.234683 systemd-modules-load[219]: Inserted module 'overlay' Oct 16 23:36:02.250090 systemd[1]: Starting systemd-vconsole-setup.service - Virtual Console Setup... Oct 16 23:36:02.250141 kernel: bridge: filtering via arp/ip/ip6tables is no longer available by default. Update your scripts to load br_netfilter if you need this. Oct 16 23:36:02.263184 kernel: Bridge firewalling registered Oct 16 23:36:02.270014 systemd[1]: Started systemd-journald.service - Journal Service. Oct 16 23:36:02.268875 systemd-modules-load[219]: Inserted module 'br_netfilter' Oct 16 23:36:02.278348 systemd[1]: Finished ignition-setup-pre.service - Ignition env setup. Oct 16 23:36:02.283016 systemd[1]: Finished kmod-static-nodes.service - Create List of Static Device Nodes. Oct 16 23:36:02.293599 systemd[1]: Finished systemd-fsck-usr.service. Oct 16 23:36:02.301724 systemd[1]: Finished systemd-modules-load.service - Load Kernel Modules. Oct 16 23:36:02.313585 systemd[1]: Finished systemd-vconsole-setup.service - Virtual Console Setup. Oct 16 23:36:02.329214 systemd[1]: Starting dracut-cmdline-ask.service - dracut ask for additional cmdline parameters... Oct 16 23:36:02.336214 systemd[1]: Starting systemd-sysctl.service - Apply Kernel Variables... Oct 16 23:36:02.355599 systemd[1]: Starting systemd-tmpfiles-setup-dev-early.service - Create Static Device Nodes in /dev gracefully... Oct 16 23:36:02.374867 systemd[1]: Starting systemd-tmpfiles-setup.service - Create System Files and Directories... Oct 16 23:36:02.381211 systemd[1]: Finished systemd-sysctl.service - Apply Kernel Variables. Oct 16 23:36:02.398262 systemd[1]: Finished dracut-cmdline-ask.service - dracut ask for additional cmdline parameters. Oct 16 23:36:02.403970 systemd[1]: Finished systemd-tmpfiles-setup-dev-early.service - Create Static Device Nodes in /dev gracefully. Oct 16 23:36:02.415526 systemd[1]: Finished systemd-tmpfiles-setup.service - Create System Files and Directories. Oct 16 23:36:02.436334 systemd[1]: Starting dracut-cmdline.service - dracut cmdline hook... Oct 16 23:36:02.449256 systemd[1]: Starting systemd-resolved.service - Network Name Resolution... Oct 16 23:36:02.461746 systemd[1]: Starting systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev... Oct 16 23:36:02.482521 systemd[1]: Finished systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev. Oct 16 23:36:02.500913 dracut-cmdline[253]: dracut-dracut-053 Oct 16 23:36:02.500913 dracut-cmdline[253]: Using kernel command line parameters: rd.driver.pre=btrfs BOOT_IMAGE=/flatcar/vmlinuz-a mount.usr=/dev/mapper/usr verity.usr=PARTUUID=7130c94a-213a-4e5a-8e26-6cce9662f132 rootflags=rw mount.usrflags=ro consoleblank=0 root=LABEL=ROOT console=tty1 console=ttyAMA0,115200n8 earlycon=pl011,0xeffec000 flatcar.first_boot=detected acpi=force flatcar.oem.id=azure flatcar.autologin verity.usrhash=b6d8446922cf13eecaec0980e282bbdb3b0ddc033d7963ab534d359a174601ee Oct 16 23:36:02.506235 systemd-resolved[256]: Positive Trust Anchors: Oct 16 23:36:02.506244 systemd-resolved[256]: . IN DS 20326 8 2 e06d44b80b8f1d39a95c0b0d7c65d08458e880409bbc683457104237c7f8ec8d Oct 16 23:36:02.506275 systemd-resolved[256]: 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 Oct 16 23:36:02.508635 systemd-resolved[256]: Defaulting to hostname 'linux'. Oct 16 23:36:02.509508 systemd[1]: Started systemd-resolved.service - Network Name Resolution. Oct 16 23:36:02.535419 systemd[1]: Reached target nss-lookup.target - Host and Network Name Lookups. Oct 16 23:36:02.670079 kernel: SCSI subsystem initialized Oct 16 23:36:02.676084 kernel: Loading iSCSI transport class v2.0-870. Oct 16 23:36:02.686092 kernel: iscsi: registered transport (tcp) Oct 16 23:36:02.702783 kernel: iscsi: registered transport (qla4xxx) Oct 16 23:36:02.702804 kernel: QLogic iSCSI HBA Driver Oct 16 23:36:02.741205 systemd[1]: Finished dracut-cmdline.service - dracut cmdline hook. Oct 16 23:36:02.753420 systemd[1]: Starting dracut-pre-udev.service - dracut pre-udev hook... Oct 16 23:36:02.783086 kernel: device-mapper: core: CONFIG_IMA_DISABLE_HTABLE is disabled. Duplicate IMA measurements will not be recorded in the IMA log. Oct 16 23:36:02.783151 kernel: device-mapper: uevent: version 1.0.3 Oct 16 23:36:02.787974 kernel: device-mapper: ioctl: 4.48.0-ioctl (2023-03-01) initialised: dm-devel@redhat.com Oct 16 23:36:02.837094 kernel: raid6: neonx8 gen() 15801 MB/s Oct 16 23:36:02.856078 kernel: raid6: neonx4 gen() 15704 MB/s Oct 16 23:36:02.875074 kernel: raid6: neonx2 gen() 13185 MB/s Oct 16 23:36:02.895142 kernel: raid6: neonx1 gen() 10526 MB/s Oct 16 23:36:02.916079 kernel: raid6: int64x8 gen() 7138 MB/s Oct 16 23:36:02.935074 kernel: raid6: int64x4 gen() 7357 MB/s Oct 16 23:36:02.955074 kernel: raid6: int64x2 gen() 6145 MB/s Oct 16 23:36:02.977207 kernel: raid6: int64x1 gen() 5069 MB/s Oct 16 23:36:02.977226 kernel: raid6: using algorithm neonx8 gen() 15801 MB/s Oct 16 23:36:03.000246 kernel: raid6: .... xor() 12040 MB/s, rmw enabled Oct 16 23:36:03.000264 kernel: raid6: using neon recovery algorithm Oct 16 23:36:03.011614 kernel: xor: measuring software checksum speed Oct 16 23:36:03.011630 kernel: 8regs : 19788 MB/sec Oct 16 23:36:03.014635 kernel: 32regs : 19636 MB/sec Oct 16 23:36:03.017534 kernel: arm64_neon : 27105 MB/sec Oct 16 23:36:03.021019 kernel: xor: using function: arm64_neon (27105 MB/sec) Oct 16 23:36:03.073098 kernel: Btrfs loaded, zoned=no, fsverity=no Oct 16 23:36:03.084599 systemd[1]: Finished dracut-pre-udev.service - dracut pre-udev hook. Oct 16 23:36:03.098198 systemd[1]: Starting systemd-udevd.service - Rule-based Manager for Device Events and Files... Oct 16 23:36:03.115570 systemd-udevd[441]: Using default interface naming scheme 'v255'. Oct 16 23:36:03.119817 systemd[1]: Started systemd-udevd.service - Rule-based Manager for Device Events and Files. Oct 16 23:36:03.136288 systemd[1]: Starting dracut-pre-trigger.service - dracut pre-trigger hook... Oct 16 23:36:03.156545 dracut-pre-trigger[451]: rd.md=0: removing MD RAID activation Oct 16 23:36:03.185943 systemd[1]: Finished dracut-pre-trigger.service - dracut pre-trigger hook. Oct 16 23:36:03.197321 systemd[1]: Starting systemd-udev-trigger.service - Coldplug All udev Devices... Oct 16 23:36:03.237380 systemd[1]: Finished systemd-udev-trigger.service - Coldplug All udev Devices. Oct 16 23:36:03.254414 systemd[1]: Starting dracut-initqueue.service - dracut initqueue hook... Oct 16 23:36:03.285871 systemd[1]: Finished dracut-initqueue.service - dracut initqueue hook. Oct 16 23:36:03.295501 systemd[1]: Reached target remote-fs-pre.target - Preparation for Remote File Systems. Oct 16 23:36:03.303394 systemd[1]: Reached target remote-cryptsetup.target - Remote Encrypted Volumes. Oct 16 23:36:03.310985 systemd[1]: Reached target remote-fs.target - Remote File Systems. Oct 16 23:36:03.334411 systemd[1]: Starting dracut-pre-mount.service - dracut pre-mount hook... Oct 16 23:36:03.360984 systemd[1]: Finished dracut-pre-mount.service - dracut pre-mount hook. Oct 16 23:36:03.379583 kernel: hv_vmbus: hv_mmio=[mem 0x40000000-0xfed3ffff],[mem 0xfc0000000-0xfffffffff] fb=[mem 0x40000000-0x47ffffff] Oct 16 23:36:03.383082 kernel: hv_vmbus: Vmbus version:5.3 Oct 16 23:36:03.388658 systemd[1]: dracut-cmdline-ask.service: Deactivated successfully. Oct 16 23:36:03.388807 systemd[1]: Stopped dracut-cmdline-ask.service - dracut ask for additional cmdline parameters. Oct 16 23:36:03.428912 kernel: hv_vmbus: registering driver hid_hyperv Oct 16 23:36:03.428935 kernel: input: Microsoft Vmbus HID-compliant Mouse as /devices/0006:045E:0621.0001/input/input0 Oct 16 23:36:03.428946 kernel: hid-hyperv 0006:045E:0621.0001: input: VIRTUAL HID v0.01 Mouse [Microsoft Vmbus HID-compliant Mouse] on Oct 16 23:36:03.429129 kernel: hv_vmbus: registering driver hyperv_keyboard Oct 16 23:36:03.403773 systemd[1]: Stopping dracut-cmdline-ask.service - dracut ask for additional cmdline parameters... Oct 16 23:36:03.457963 kernel: hv_vmbus: registering driver hv_netvsc Oct 16 23:36:03.457987 kernel: hv_vmbus: registering driver hv_storvsc Oct 16 23:36:03.457997 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 Oct 16 23:36:03.441354 systemd[1]: systemd-vconsole-setup.service: Deactivated successfully. Oct 16 23:36:03.490989 kernel: pps_core: LinuxPPS API ver. 1 registered Oct 16 23:36:03.491012 kernel: scsi host0: storvsc_host_t Oct 16 23:36:03.491231 kernel: pps_core: Software ver. 5.3.6 - Copyright 2005-2007 Rodolfo Giometti Oct 16 23:36:03.491243 kernel: scsi host1: storvsc_host_t Oct 16 23:36:03.491335 kernel: scsi 0:0:0:0: Direct-Access Msft Virtual Disk 1.0 PQ: 0 ANSI: 5 Oct 16 23:36:03.441600 systemd[1]: Stopped systemd-vconsole-setup.service - Virtual Console Setup. Oct 16 23:36:03.508307 kernel: scsi 0:0:0:2: CD-ROM Msft Virtual DVD-ROM 1.0 PQ: 0 ANSI: 5 Oct 16 23:36:03.477704 systemd[1]: Stopping systemd-vconsole-setup.service - Virtual Console Setup... Oct 16 23:36:03.520383 systemd[1]: Starting systemd-vconsole-setup.service - Virtual Console Setup... Oct 16 23:36:03.536456 kernel: PTP clock support registered Oct 16 23:36:03.552113 systemd[1]: Finished systemd-vconsole-setup.service - Virtual Console Setup. Oct 16 23:36:03.573391 kernel: hv_utils: Registering HyperV Utility Driver Oct 16 23:36:03.573414 kernel: hv_vmbus: registering driver hv_utils Oct 16 23:36:03.573426 kernel: sr 0:0:0:2: [sr0] scsi-1 drive Oct 16 23:36:03.574201 systemd[1]: Starting dracut-cmdline-ask.service - dracut ask for additional cmdline parameters... Oct 16 23:36:03.605283 kernel: hv_utils: Heartbeat IC version 3.0 Oct 16 23:36:03.605310 kernel: cdrom: Uniform CD-ROM driver Revision: 3.20 Oct 16 23:36:03.605320 kernel: hv_utils: Shutdown IC version 3.2 Oct 16 23:36:03.605329 kernel: hv_netvsc 7ced8dd4-cc46-7ced-8dd4-cc467ced8dd4 eth0: VF slot 1 added Oct 16 23:36:03.608466 kernel: sd 0:0:0:0: [sda] 63737856 512-byte logical blocks: (32.6 GB/30.4 GiB) Oct 16 23:36:03.608625 kernel: hv_utils: TimeSync IC version 4.0 Oct 16 23:36:03.608637 kernel: sr 0:0:0:2: Attached scsi CD-ROM sr0 Oct 16 23:36:03.709514 systemd-resolved[256]: Clock change detected. Flushing caches. Oct 16 23:36:03.721971 kernel: sd 0:0:0:0: [sda] 4096-byte physical blocks Oct 16 23:36:03.722143 kernel: sd 0:0:0:0: [sda] Write Protect is off Oct 16 23:36:03.728630 kernel: sd 0:0:0:0: [sda] Mode Sense: 0f 00 10 00 Oct 16 23:36:03.728852 kernel: sd 0:0:0:0: [sda] Write cache: disabled, read cache: enabled, supports DPO and FUA Oct 16 23:36:03.731743 systemd[1]: Finished dracut-cmdline-ask.service - dracut ask for additional cmdline parameters. Oct 16 23:36:03.753433 kernel: sda: sda1 sda2 sda3 sda4 sda6 sda7 sda9 Oct 16 23:36:03.753480 kernel: sd 0:0:0:0: [sda] Attached SCSI disk Oct 16 23:36:03.763951 kernel: hv_vmbus: registering driver hv_pci Oct 16 23:36:03.764011 kernel: hv_pci dd9db976-e036-4991-966d-87a0f679e5bd: PCI VMBus probing: Using version 0x10004 Oct 16 23:36:03.777052 kernel: hv_storvsc f8b3781a-1e82-4818-a1c3-63d806ec15bb: tag#53 cmd 0x85 status: scsi 0x2 srb 0x6 hv 0xc0000001 Oct 16 23:36:03.777279 kernel: hv_pci dd9db976-e036-4991-966d-87a0f679e5bd: PCI host bridge to bus e036:00 Oct 16 23:36:03.786618 kernel: pci_bus e036:00: root bus resource [mem 0xfc0000000-0xfc00fffff window] Oct 16 23:36:03.787485 kernel: pci_bus e036:00: No busn resource found for root bus, will use [bus 00-ff] Oct 16 23:36:03.797779 kernel: pci e036:00:02.0: [15b3:1018] type 00 class 0x020000 Oct 16 23:36:03.804709 kernel: pci e036:00:02.0: BAR 0 [mem 0xfc0000000-0xfc00fffff 64bit pref] Oct 16 23:36:03.810947 kernel: pci e036:00:02.0: enabling Extended Tags Oct 16 23:36:03.821931 kernel: hv_storvsc f8b3781a-1e82-4818-a1c3-63d806ec15bb: tag#24 cmd 0x85 status: scsi 0x2 srb 0x6 hv 0xc0000001 Oct 16 23:36:03.822132 kernel: pci e036:00:02.0: 0.000 Gb/s available PCIe bandwidth, limited by Unknown x0 link at e036:00:02.0 (capable of 126.016 Gb/s with 8.0 GT/s PCIe x16 link) Oct 16 23:36:03.842020 kernel: pci_bus e036:00: busn_res: [bus 00-ff] end is updated to 00 Oct 16 23:36:03.842216 kernel: pci e036:00:02.0: BAR 0 [mem 0xfc0000000-0xfc00fffff 64bit pref]: assigned Oct 16 23:36:03.883896 kernel: mlx5_core e036:00:02.0: enabling device (0000 -> 0002) Oct 16 23:36:03.889696 kernel: mlx5_core e036:00:02.0: firmware version: 16.30.5026 Oct 16 23:36:04.100702 kernel: hv_netvsc 7ced8dd4-cc46-7ced-8dd4-cc467ced8dd4 eth0: VF registering: eth1 Oct 16 23:36:04.100908 kernel: mlx5_core e036:00:02.0 eth1: joined to eth0 Oct 16 23:36:04.107013 kernel: mlx5_core e036:00:02.0: MLX5E: StrdRq(1) RqSz(8) StrdSz(2048) RxCqeCmprss(0 basic) Oct 16 23:36:04.118975 kernel: mlx5_core e036:00:02.0 enP57398s1: renamed from eth1 Oct 16 23:36:04.127469 systemd[1]: Found device dev-disk-by\x2dlabel-EFI\x2dSYSTEM.device - Virtual_Disk EFI-SYSTEM. Oct 16 23:36:04.146709 kernel: BTRFS: device label OEM devid 1 transid 10 /dev/sda6 scanned by (udev-worker) (493) Oct 16 23:36:04.163593 systemd[1]: Found device dev-disk-by\x2dlabel-OEM.device - Virtual_Disk OEM. Oct 16 23:36:04.183726 kernel: BTRFS: device fsid 01ae2c3f-1cbb-4765-84ed-a78ac8536acd devid 1 transid 33 /dev/sda3 scanned by (udev-worker) (484) Oct 16 23:36:04.198456 systemd[1]: Found device dev-disk-by\x2dpartuuid-7130c94a\x2d213a\x2d4e5a\x2d8e26\x2d6cce9662f132.device - Virtual_Disk USR-A. Oct 16 23:36:04.204908 systemd[1]: Found device dev-disk-by\x2dpartlabel-USR\x2dA.device - Virtual_Disk USR-A. Oct 16 23:36:04.229991 systemd[1]: Starting disk-uuid.service - Generate new UUID for disk GPT if necessary... Oct 16 23:36:04.258816 systemd[1]: Found device dev-disk-by\x2dlabel-ROOT.device - Virtual_Disk ROOT. Oct 16 23:36:04.271842 kernel: GPT:disk_guids don't match. Oct 16 23:36:04.271884 kernel: GPT: Use GNU Parted to correct GPT errors. Oct 16 23:36:04.271901 kernel: sda: sda1 sda2 sda3 sda4 sda6 sda7 sda9 Oct 16 23:36:04.284744 kernel: sda: sda1 sda2 sda3 sda4 sda6 sda7 sda9 Oct 16 23:36:05.282706 kernel: sda: sda1 sda2 sda3 sda4 sda6 sda7 sda9 Oct 16 23:36:05.283819 disk-uuid[603]: The operation has completed successfully. Oct 16 23:36:05.360441 systemd[1]: disk-uuid.service: Deactivated successfully. Oct 16 23:36:05.361711 systemd[1]: Finished disk-uuid.service - Generate new UUID for disk GPT if necessary. Oct 16 23:36:05.385950 systemd[1]: Starting verity-setup.service - Verity Setup for /dev/mapper/usr... Oct 16 23:36:05.398253 sh[716]: Success Oct 16 23:36:05.425909 kernel: device-mapper: verity: sha256 using implementation "sha256-ce" Oct 16 23:36:05.589265 systemd[1]: Found device dev-mapper-usr.device - /dev/mapper/usr. Oct 16 23:36:05.597793 systemd[1]: Mounting sysusr-usr.mount - /sysusr/usr... Oct 16 23:36:05.611884 systemd[1]: Finished verity-setup.service - Verity Setup for /dev/mapper/usr. Oct 16 23:36:05.639109 kernel: BTRFS info (device dm-0): first mount of filesystem 01ae2c3f-1cbb-4765-84ed-a78ac8536acd Oct 16 23:36:05.639159 kernel: BTRFS info (device dm-0): using crc32c (crc32c-generic) checksum algorithm Oct 16 23:36:05.645273 kernel: BTRFS warning (device dm-0): 'nologreplay' is deprecated, use 'rescue=nologreplay' instead Oct 16 23:36:05.650128 kernel: BTRFS info (device dm-0): disabling log replay at mount time Oct 16 23:36:05.654963 kernel: BTRFS info (device dm-0): using free space tree Oct 16 23:36:05.866888 systemd[1]: Mounted sysusr-usr.mount - /sysusr/usr. Oct 16 23:36:05.872220 systemd[1]: afterburn-network-kargs.service - Afterburn Initrd Setup Network Kernel Arguments was skipped because no trigger condition checks were met. Oct 16 23:36:05.886936 systemd[1]: Starting ignition-setup.service - Ignition (setup)... Oct 16 23:36:05.896854 systemd[1]: Starting parse-ip-for-networkd.service - Write systemd-networkd units from cmdline... Oct 16 23:36:05.925545 kernel: BTRFS info (device sda6): first mount of filesystem 215947b1-b867-4a28-935e-b2ab65af567d Oct 16 23:36:05.925598 kernel: BTRFS info (device sda6): using crc32c (crc32c-generic) checksum algorithm Oct 16 23:36:05.929379 kernel: BTRFS info (device sda6): using free space tree Oct 16 23:36:05.952742 kernel: BTRFS info (device sda6): auto enabling async discard Oct 16 23:36:05.961503 systemd[1]: mnt-oem.mount: Deactivated successfully. Oct 16 23:36:05.972536 kernel: BTRFS info (device sda6): last unmount of filesystem 215947b1-b867-4a28-935e-b2ab65af567d Oct 16 23:36:05.980626 systemd[1]: Finished ignition-setup.service - Ignition (setup). Oct 16 23:36:05.995015 systemd[1]: Starting ignition-fetch-offline.service - Ignition (fetch-offline)... Oct 16 23:36:06.040593 systemd[1]: Finished parse-ip-for-networkd.service - Write systemd-networkd units from cmdline. Oct 16 23:36:06.057836 systemd[1]: Starting systemd-networkd.service - Network Configuration... Oct 16 23:36:06.085623 systemd-networkd[900]: lo: Link UP Oct 16 23:36:06.085634 systemd-networkd[900]: lo: Gained carrier Oct 16 23:36:06.087357 systemd-networkd[900]: Enumeration completed Oct 16 23:36:06.090116 systemd[1]: Started systemd-networkd.service - Network Configuration. Oct 16 23:36:06.093461 systemd-networkd[900]: eth0: found matching network '/usr/lib/systemd/network/zz-default.network', based on potentially unpredictable interface name. Oct 16 23:36:06.093464 systemd-networkd[900]: eth0: Configuring with /usr/lib/systemd/network/zz-default.network. Oct 16 23:36:06.098927 systemd[1]: Reached target network.target - Network. Oct 16 23:36:06.176720 kernel: mlx5_core e036:00:02.0 enP57398s1: Link up Oct 16 23:36:06.218696 kernel: hv_netvsc 7ced8dd4-cc46-7ced-8dd4-cc467ced8dd4 eth0: Data path switched to VF: enP57398s1 Oct 16 23:36:06.219048 systemd-networkd[900]: enP57398s1: Link UP Oct 16 23:36:06.219143 systemd-networkd[900]: eth0: Link UP Oct 16 23:36:06.219268 systemd-networkd[900]: eth0: Gained carrier Oct 16 23:36:06.219278 systemd-networkd[900]: eth0: found matching network '/usr/lib/systemd/network/zz-default.network', based on potentially unpredictable interface name. Oct 16 23:36:06.240844 systemd-networkd[900]: enP57398s1: Gained carrier Oct 16 23:36:06.252734 systemd-networkd[900]: eth0: DHCPv4 address 10.0.0.5/24, gateway 10.0.0.1 acquired from 168.63.129.16 Oct 16 23:36:06.754249 ignition[845]: Ignition 2.19.0 Oct 16 23:36:06.754261 ignition[845]: Stage: fetch-offline Oct 16 23:36:06.754298 ignition[845]: no configs at "/usr/lib/ignition/base.d" Oct 16 23:36:06.754306 ignition[845]: no config dir at "/usr/lib/ignition/base.platform.d/azure" Oct 16 23:36:06.761965 systemd[1]: Finished ignition-fetch-offline.service - Ignition (fetch-offline). Oct 16 23:36:06.754408 ignition[845]: parsed url from cmdline: "" Oct 16 23:36:06.780038 systemd[1]: Starting ignition-fetch.service - Ignition (fetch)... Oct 16 23:36:06.754412 ignition[845]: no config URL provided Oct 16 23:36:06.754416 ignition[845]: reading system config file "/usr/lib/ignition/user.ign" Oct 16 23:36:06.754422 ignition[845]: no config at "/usr/lib/ignition/user.ign" Oct 16 23:36:06.754427 ignition[845]: failed to fetch config: resource requires networking Oct 16 23:36:06.755030 ignition[845]: Ignition finished successfully Oct 16 23:36:06.800217 ignition[912]: Ignition 2.19.0 Oct 16 23:36:06.800224 ignition[912]: Stage: fetch Oct 16 23:36:06.800432 ignition[912]: no configs at "/usr/lib/ignition/base.d" Oct 16 23:36:06.800441 ignition[912]: no config dir at "/usr/lib/ignition/base.platform.d/azure" Oct 16 23:36:06.800545 ignition[912]: parsed url from cmdline: "" Oct 16 23:36:06.800549 ignition[912]: no config URL provided Oct 16 23:36:06.800553 ignition[912]: reading system config file "/usr/lib/ignition/user.ign" Oct 16 23:36:06.800563 ignition[912]: no config at "/usr/lib/ignition/user.ign" Oct 16 23:36:06.800586 ignition[912]: GET http://169.254.169.254/metadata/instance/compute/userData?api-version=2021-01-01&format=text: attempt #1 Oct 16 23:36:06.888404 ignition[912]: GET result: OK Oct 16 23:36:06.888458 ignition[912]: config has been read from IMDS userdata Oct 16 23:36:06.888475 ignition[912]: parsing config with SHA512: ea896ad2b7468ee42b8f152ed972d664e07a6cdef31b45b23a7c4028393ee3c5b4fbb0804e3afa914cb1c88666ee930d12a810420e16ca2f4d3c4cdea73a19e7 Oct 16 23:36:06.892266 unknown[912]: fetched base config from "system" Oct 16 23:36:06.892476 ignition[912]: fetch: fetch complete Oct 16 23:36:06.892280 unknown[912]: fetched base config from "system" Oct 16 23:36:06.892480 ignition[912]: fetch: fetch passed Oct 16 23:36:06.892285 unknown[912]: fetched user config from "azure" Oct 16 23:36:06.892524 ignition[912]: Ignition finished successfully Oct 16 23:36:06.895096 systemd[1]: Finished ignition-fetch.service - Ignition (fetch). Oct 16 23:36:06.919221 systemd[1]: Starting ignition-kargs.service - Ignition (kargs)... Oct 16 23:36:06.935312 ignition[918]: Ignition 2.19.0 Oct 16 23:36:06.935328 ignition[918]: Stage: kargs Oct 16 23:36:06.935496 ignition[918]: no configs at "/usr/lib/ignition/base.d" Oct 16 23:36:06.940980 systemd[1]: Finished ignition-kargs.service - Ignition (kargs). Oct 16 23:36:06.935514 ignition[918]: no config dir at "/usr/lib/ignition/base.platform.d/azure" Oct 16 23:36:06.936119 ignition[918]: kargs: kargs passed Oct 16 23:36:06.936208 ignition[918]: Ignition finished successfully Oct 16 23:36:06.964970 systemd[1]: Starting ignition-disks.service - Ignition (disks)... Oct 16 23:36:06.981306 ignition[924]: Ignition 2.19.0 Oct 16 23:36:06.981315 ignition[924]: Stage: disks Oct 16 23:36:06.981504 ignition[924]: no configs at "/usr/lib/ignition/base.d" Oct 16 23:36:06.981513 ignition[924]: no config dir at "/usr/lib/ignition/base.platform.d/azure" Oct 16 23:36:06.982140 ignition[924]: disks: createFilesystems: op(1): [started] waiting for devices [/dev/disk/by-partlabel/ROOT] Oct 16 23:36:06.989924 ignition[924]: disks: createFilesystems: op(1): [finished] waiting for devices [/dev/disk/by-partlabel/ROOT] Oct 16 23:36:06.990004 ignition[924]: disks: createFilesystems: created device alias for "/dev/disk/by-partlabel/ROOT": "/run/ignition/dev_aliases/dev/disk/by-partlabel/ROOT" -> "/dev/sda9" Oct 16 23:36:06.990051 ignition[924]: disks: createFilesystems: op(2): [started] determining filesystem type of "/dev/disk/by-partlabel/ROOT" Oct 16 23:36:07.037700 ignition[924]: disks: createFilesystems: op(2): [finished] determining filesystem type of "/dev/disk/by-partlabel/ROOT" Oct 16 23:36:07.037711 ignition[924]: disks: createFilesystems: found ext4 filesystem at "/dev/disk/by-partlabel/ROOT" with uuid "27a6772a-7728-4cc3-9f31-549603a5b63c" and label "ROOT" Oct 16 23:36:07.037747 ignition[924]: disks: createFilesystems: op(3): [started] wiping filesystem signatures from "/run/ignition/dev_aliases/dev/disk/by-partlabel/ROOT" Oct 16 23:36:07.037754 ignition[924]: disks: createFilesystems: op(3): executing: "wipefs" "-a" "/run/ignition/dev_aliases/dev/disk/by-partlabel/ROOT" Oct 16 23:36:07.118066 ignition[924]: disks: createFilesystems: op(3): [finished] wiping filesystem signatures from "/run/ignition/dev_aliases/dev/disk/by-partlabel/ROOT" Oct 16 23:36:07.118104 ignition[924]: disks: createFilesystems: op(4): [started] creating "xfs" filesystem on "/run/ignition/dev_aliases/dev/disk/by-partlabel/ROOT" Oct 16 23:36:07.118120 ignition[924]: disks: createFilesystems: op(4): executing: "mkfs.xfs" "-L" "ROOT" "-m" "uuid=9aa5237a-ab6b-458b-a7e8-f25e2baef1a3" "-f" "/run/ignition/dev_aliases/dev/disk/by-partlabel/ROOT" Oct 16 23:36:07.753644 ignition[924]: disks: createFilesystems: op(4): [finished] creating "xfs" filesystem on "/run/ignition/dev_aliases/dev/disk/by-partlabel/ROOT" Oct 16 23:36:07.753727 ignition[924]: disks: createFilesystems: op(5): [started] waiting for triggered uevent Oct 16 23:36:07.753733 ignition[924]: disks: createFilesystems: op(5): executing: "udevadm" "trigger" "--settle" "/dev/sda9" Oct 16 23:36:07.937784 systemd-networkd[900]: eth0: Gained IPv6LL Oct 16 23:36:08.903196 ignition[924]: disks: createFilesystems: op(5): [finished] waiting for triggered uevent Oct 16 23:36:08.903213 ignition[924]: disks: disks passed Oct 16 23:36:08.907466 systemd[1]: Finished ignition-disks.service - Ignition (disks). Oct 16 23:36:08.903277 ignition[924]: Ignition finished successfully Oct 16 23:36:08.916211 systemd[1]: Reached target initrd-root-device.target - Initrd Root Device. Oct 16 23:36:08.923749 systemd[1]: Reached target local-fs-pre.target - Preparation for Local File Systems. Oct 16 23:36:08.931630 systemd[1]: Reached target local-fs.target - Local File Systems. Oct 16 23:36:08.940887 systemd[1]: Reached target sysinit.target - System Initialization. Oct 16 23:36:08.949875 systemd[1]: Reached target basic.target - Basic System. Oct 16 23:36:08.969960 systemd[1]: Starting systemd-fsck-root.service - File System Check on /dev/disk/by-label/ROOT... Oct 16 23:36:08.992168 systemd-fsck[946]: /usr/sbin/fsck.xfs: XFS file system. Oct 16 23:36:08.997047 systemd[1]: Finished systemd-fsck-root.service - File System Check on /dev/disk/by-label/ROOT. Oct 16 23:36:09.013920 systemd[1]: Mounting sysroot.mount - /sysroot... Oct 16 23:36:09.092838 kernel: SGI XFS with ACLs, security attributes, quota, no debug enabled Oct 16 23:36:09.098695 kernel: XFS (sda9): Mounting V5 Filesystem 9aa5237a-ab6b-458b-a7e8-f25e2baef1a3 Oct 16 23:36:09.115699 kernel: XFS (sda9): Ending clean mount Oct 16 23:36:09.119403 systemd[1]: Mounted sysroot.mount - /sysroot. Oct 16 23:36:09.122889 systemd[1]: Reached target initrd-root-fs.target - Initrd Root File System. Oct 16 23:36:09.140761 systemd[1]: Mounting sysroot-oem.mount - /sysroot/oem... Oct 16 23:36:09.150302 systemd[1]: Mounting sysroot-usr.mount - /sysroot/usr... Oct 16 23:36:09.156877 systemd[1]: Starting flatcar-metadata-hostname.service - Flatcar Metadata Hostname Agent... Oct 16 23:36:09.174191 systemd[1]: ignition-remount-sysroot.service - Remount /sysroot read-write for Ignition was skipped because of an unmet condition check (ConditionPathIsReadWrite=!/sysroot). Oct 16 23:36:09.186995 kernel: BTRFS: device label OEM devid 1 transid 11 /dev/sda6 scanned by mount (961) Oct 16 23:36:09.174272 systemd[1]: Reached target ignition-diskful.target - Ignition Boot Disk Setup. Oct 16 23:36:09.193360 systemd[1]: Mounted sysroot-usr.mount - /sysroot/usr. Oct 16 23:36:09.217853 kernel: BTRFS info (device sda6): first mount of filesystem 215947b1-b867-4a28-935e-b2ab65af567d Oct 16 23:36:09.217877 kernel: BTRFS info (device sda6): using crc32c (crc32c-generic) checksum algorithm Oct 16 23:36:09.217887 kernel: BTRFS info (device sda6): using free space tree Oct 16 23:36:09.230370 kernel: BTRFS info (device sda6): auto enabling async discard Oct 16 23:36:09.226203 systemd[1]: Starting initrd-setup-root.service - Root filesystem setup... Oct 16 23:36:09.233090 systemd[1]: Mounted sysroot-oem.mount - /sysroot/oem. Oct 16 23:36:09.308952 initrd-setup-root[986]: cut: /sysroot/etc/passwd: No such file or directory Oct 16 23:36:09.334576 initrd-setup-root[993]: cut: /sysroot/etc/group: No such file or directory Oct 16 23:36:09.350773 initrd-setup-root[1000]: cut: /sysroot/etc/shadow: No such file or directory Oct 16 23:36:09.359305 initrd-setup-root[1007]: cut: /sysroot/etc/gshadow: No such file or directory Oct 16 23:36:09.598835 coreos-metadata[963]: Oct 16 23:36:09.598 INFO Fetching http://168.63.129.16/?comp=versions: Attempt #1 Oct 16 23:36:09.606176 coreos-metadata[963]: Oct 16 23:36:09.606 INFO Fetch successful Oct 16 23:36:09.610452 coreos-metadata[963]: Oct 16 23:36:09.610 INFO Fetching http://169.254.169.254/metadata/instance/compute/name?api-version=2017-08-01&format=text: Attempt #1 Oct 16 23:36:09.625076 coreos-metadata[963]: Oct 16 23:36:09.625 INFO Fetch successful Oct 16 23:36:09.630115 coreos-metadata[963]: Oct 16 23:36:09.627 INFO wrote hostname ci-4081.3.10--e3223b72ee to /sysroot/etc/hostname Oct 16 23:36:09.631600 systemd[1]: Finished flatcar-metadata-hostname.service - Flatcar Metadata Hostname Agent. Oct 16 23:36:09.703225 systemd[1]: Finished initrd-setup-root.service - Root filesystem setup. Oct 16 23:36:09.715893 systemd[1]: Starting ignition-mount.service - Ignition (mount)... Oct 16 23:36:09.727963 systemd[1]: Starting sysroot-boot.service - /sysroot/boot... Oct 16 23:36:09.740956 kernel: BTRFS info (device sda6): last unmount of filesystem 215947b1-b867-4a28-935e-b2ab65af567d Oct 16 23:36:09.737983 systemd[1]: sysroot-oem.mount: Deactivated successfully. Oct 16 23:36:09.765113 ignition[1079]: INFO : Ignition 2.19.0 Oct 16 23:36:09.768924 ignition[1079]: INFO : Stage: mount Oct 16 23:36:09.768924 ignition[1079]: INFO : no configs at "/usr/lib/ignition/base.d" Oct 16 23:36:09.768924 ignition[1079]: INFO : no config dir at "/usr/lib/ignition/base.platform.d/azure" Oct 16 23:36:09.765523 systemd[1]: Finished sysroot-boot.service - /sysroot/boot. Oct 16 23:36:09.794853 ignition[1079]: INFO : mount: mount passed Oct 16 23:36:09.794853 ignition[1079]: INFO : Ignition finished successfully Oct 16 23:36:09.776644 systemd[1]: Finished ignition-mount.service - Ignition (mount). Oct 16 23:36:09.801912 systemd[1]: Starting ignition-files.service - Ignition (files)... Oct 16 23:36:10.127842 systemd[1]: Mounting sysroot-oem.mount - /sysroot/oem... Oct 16 23:36:10.149346 kernel: BTRFS: device label OEM devid 1 transid 12 /dev/sda6 scanned by mount (1090) Oct 16 23:36:10.160178 kernel: BTRFS info (device sda6): first mount of filesystem 215947b1-b867-4a28-935e-b2ab65af567d Oct 16 23:36:10.160239 kernel: BTRFS info (device sda6): using crc32c (crc32c-generic) checksum algorithm Oct 16 23:36:10.163549 kernel: BTRFS info (device sda6): using free space tree Oct 16 23:36:10.170704 kernel: BTRFS info (device sda6): auto enabling async discard Oct 16 23:36:10.171792 systemd[1]: Mounted sysroot-oem.mount - /sysroot/oem. Oct 16 23:36:10.196339 ignition[1108]: INFO : Ignition 2.19.0 Oct 16 23:36:10.201074 ignition[1108]: INFO : Stage: files Oct 16 23:36:10.201074 ignition[1108]: INFO : no configs at "/usr/lib/ignition/base.d" Oct 16 23:36:10.201074 ignition[1108]: INFO : no config dir at "/usr/lib/ignition/base.platform.d/azure" Oct 16 23:36:10.201074 ignition[1108]: DEBUG : files: compiled without relabeling support, skipping Oct 16 23:36:10.218093 ignition[1108]: INFO : files: ensureUsers: op(1): [started] creating or modifying user "core" Oct 16 23:36:10.218093 ignition[1108]: DEBUG : files: ensureUsers: op(1): executing: "usermod" "--root" "/sysroot" "core" Oct 16 23:36:10.258395 ignition[1108]: INFO : files: ensureUsers: op(1): [finished] creating or modifying user "core" Oct 16 23:36:10.264479 ignition[1108]: INFO : files: ensureUsers: op(2): [started] adding ssh keys to user "core" Oct 16 23:36:10.264479 ignition[1108]: INFO : files: ensureUsers: op(2): [finished] adding ssh keys to user "core" Oct 16 23:36:10.259361 unknown[1108]: wrote ssh authorized keys file for user: core Oct 16 23:36:10.283790 ignition[1108]: INFO : files: createFilesystemsFiles: createFiles: op(3): [started] writing file "/sysroot/etc/flatcar/update.conf" Oct 16 23:36:10.283790 ignition[1108]: INFO : files: createFilesystemsFiles: createFiles: op(3): [finished] writing file "/sysroot/etc/flatcar/update.conf" Oct 16 23:36:10.283790 ignition[1108]: INFO : files: createResultFile: createFiles: op(4): [started] writing file "/sysroot/etc/.ignition-result.json" Oct 16 23:36:10.283790 ignition[1108]: INFO : files: createResultFile: createFiles: op(4): [finished] writing file "/sysroot/etc/.ignition-result.json" Oct 16 23:36:10.283790 ignition[1108]: INFO : files: files passed Oct 16 23:36:10.283790 ignition[1108]: INFO : Ignition finished successfully Oct 16 23:36:10.275830 systemd[1]: Finished ignition-files.service - Ignition (files). Oct 16 23:36:10.306985 systemd[1]: Starting ignition-quench.service - Ignition (record completion)... Oct 16 23:36:10.320884 systemd[1]: Starting initrd-setup-root-after-ignition.service - Root filesystem completion... Oct 16 23:36:10.330284 systemd[1]: ignition-quench.service: Deactivated successfully. Oct 16 23:36:10.330390 systemd[1]: Finished ignition-quench.service - Ignition (record completion). Oct 16 23:36:10.362671 initrd-setup-root-after-ignition[1135]: grep: /sysroot/etc/flatcar/enabled-sysext.conf: No such file or directory Oct 16 23:36:10.362671 initrd-setup-root-after-ignition[1135]: grep: /sysroot/usr/share/flatcar/enabled-sysext.conf: No such file or directory Oct 16 23:36:10.376622 initrd-setup-root-after-ignition[1139]: grep: /sysroot/etc/flatcar/enabled-sysext.conf: No such file or directory Oct 16 23:36:10.377583 systemd[1]: Finished initrd-setup-root-after-ignition.service - Root filesystem completion. Oct 16 23:36:10.388572 systemd[1]: Reached target ignition-complete.target - Ignition Complete. Oct 16 23:36:10.407912 systemd[1]: Starting initrd-parse-etc.service - Mountpoints Configured in the Real Root... Oct 16 23:36:10.433289 systemd[1]: initrd-parse-etc.service: Deactivated successfully. Oct 16 23:36:10.435466 systemd[1]: Finished initrd-parse-etc.service - Mountpoints Configured in the Real Root. Oct 16 23:36:10.443111 systemd[1]: Reached target initrd-fs.target - Initrd File Systems. Oct 16 23:36:10.452188 systemd[1]: Reached target initrd.target - Initrd Default Target. Oct 16 23:36:10.460444 systemd[1]: dracut-mount.service - dracut mount hook was skipped because no trigger condition checks were met. Oct 16 23:36:10.471960 systemd[1]: Starting dracut-pre-pivot.service - dracut pre-pivot and cleanup hook... Oct 16 23:36:10.488116 systemd[1]: Finished dracut-pre-pivot.service - dracut pre-pivot and cleanup hook. Oct 16 23:36:10.499943 systemd[1]: Starting initrd-cleanup.service - Cleaning Up and Shutting Down Daemons... Oct 16 23:36:10.518276 systemd[1]: Stopped target nss-lookup.target - Host and Network Name Lookups. Oct 16 23:36:10.523335 systemd[1]: Stopped target remote-cryptsetup.target - Remote Encrypted Volumes. Oct 16 23:36:10.532883 systemd[1]: Stopped target timers.target - Timer Units. Oct 16 23:36:10.541185 systemd[1]: dracut-pre-pivot.service: Deactivated successfully. Oct 16 23:36:10.541302 systemd[1]: Stopped dracut-pre-pivot.service - dracut pre-pivot and cleanup hook. Oct 16 23:36:10.554227 systemd[1]: Stopped target initrd.target - Initrd Default Target. Oct 16 23:36:10.558837 systemd[1]: Stopped target basic.target - Basic System. Oct 16 23:36:10.567474 systemd[1]: Stopped target ignition-complete.target - Ignition Complete. Oct 16 23:36:10.575901 systemd[1]: Stopped target ignition-diskful.target - Ignition Boot Disk Setup. Oct 16 23:36:10.584252 systemd[1]: Stopped target initrd-root-device.target - Initrd Root Device. Oct 16 23:36:10.593307 systemd[1]: Stopped target remote-fs.target - Remote File Systems. Oct 16 23:36:10.602266 systemd[1]: Stopped target remote-fs-pre.target - Preparation for Remote File Systems. Oct 16 23:36:10.611894 systemd[1]: Stopped target sysinit.target - System Initialization. Oct 16 23:36:10.620080 systemd[1]: Stopped target local-fs.target - Local File Systems. Oct 16 23:36:10.629514 systemd[1]: Stopped target swap.target - Swaps. Oct 16 23:36:10.637033 systemd[1]: dracut-pre-mount.service: Deactivated successfully. Oct 16 23:36:10.637156 systemd[1]: Stopped dracut-pre-mount.service - dracut pre-mount hook. Oct 16 23:36:10.649258 systemd[1]: Stopped target cryptsetup.target - Local Encrypted Volumes. Oct 16 23:36:10.654237 systemd[1]: Stopped target cryptsetup-pre.target - Local Encrypted Volumes (Pre). Oct 16 23:36:10.663095 systemd[1]: clevis-luks-askpass.path: Deactivated successfully. Oct 16 23:36:10.667036 systemd[1]: Stopped clevis-luks-askpass.path - Forward Password Requests to Clevis Directory Watch. Oct 16 23:36:10.672438 systemd[1]: dracut-initqueue.service: Deactivated successfully. Oct 16 23:36:10.672556 systemd[1]: Stopped dracut-initqueue.service - dracut initqueue hook. Oct 16 23:36:10.685900 systemd[1]: initrd-setup-root-after-ignition.service: Deactivated successfully. Oct 16 23:36:10.686005 systemd[1]: Stopped initrd-setup-root-after-ignition.service - Root filesystem completion. Oct 16 23:36:10.691233 systemd[1]: ignition-files.service: Deactivated successfully. Oct 16 23:36:10.691318 systemd[1]: Stopped ignition-files.service - Ignition (files). Oct 16 23:36:10.699135 systemd[1]: flatcar-metadata-hostname.service: Deactivated successfully. Oct 16 23:36:10.699217 systemd[1]: Stopped flatcar-metadata-hostname.service - Flatcar Metadata Hostname Agent. Oct 16 23:36:10.727995 systemd[1]: Stopping ignition-mount.service - Ignition (mount)... Oct 16 23:36:10.757245 ignition[1159]: INFO : Ignition 2.19.0 Oct 16 23:36:10.757245 ignition[1159]: INFO : Stage: umount Oct 16 23:36:10.757245 ignition[1159]: INFO : no configs at "/usr/lib/ignition/base.d" Oct 16 23:36:10.757245 ignition[1159]: INFO : no config dir at "/usr/lib/ignition/base.platform.d/azure" Oct 16 23:36:10.757245 ignition[1159]: INFO : umount: umount passed Oct 16 23:36:10.757245 ignition[1159]: INFO : Ignition finished successfully Oct 16 23:36:10.756959 systemd[1]: Stopping sysroot-boot.service - /sysroot/boot... Oct 16 23:36:10.767040 systemd[1]: systemd-udev-trigger.service: Deactivated successfully. Oct 16 23:36:10.767197 systemd[1]: Stopped systemd-udev-trigger.service - Coldplug All udev Devices. Oct 16 23:36:10.772904 systemd[1]: dracut-pre-trigger.service: Deactivated successfully. Oct 16 23:36:10.773012 systemd[1]: Stopped dracut-pre-trigger.service - dracut pre-trigger hook. Oct 16 23:36:10.789325 systemd[1]: sysroot-boot.mount: Deactivated successfully. Oct 16 23:36:10.789986 systemd[1]: ignition-mount.service: Deactivated successfully. Oct 16 23:36:10.790088 systemd[1]: Stopped ignition-mount.service - Ignition (mount). Oct 16 23:36:10.799042 systemd[1]: sysroot-boot.service: Deactivated successfully. Oct 16 23:36:10.800706 systemd[1]: Stopped sysroot-boot.service - /sysroot/boot. Oct 16 23:36:10.808183 systemd[1]: ignition-disks.service: Deactivated successfully. Oct 16 23:36:10.808469 systemd[1]: Stopped ignition-disks.service - Ignition (disks). Oct 16 23:36:10.816285 systemd[1]: ignition-kargs.service: Deactivated successfully. Oct 16 23:36:10.816335 systemd[1]: Stopped ignition-kargs.service - Ignition (kargs). Oct 16 23:36:10.825185 systemd[1]: ignition-fetch.service: Deactivated successfully. Oct 16 23:36:10.825277 systemd[1]: Stopped ignition-fetch.service - Ignition (fetch). Oct 16 23:36:10.836260 systemd[1]: Stopped target network.target - Network. Oct 16 23:36:10.844417 systemd[1]: ignition-fetch-offline.service: Deactivated successfully. Oct 16 23:36:10.844493 systemd[1]: Stopped ignition-fetch-offline.service - Ignition (fetch-offline). Oct 16 23:36:10.853184 systemd[1]: Stopped target paths.target - Path Units. Oct 16 23:36:10.860568 systemd[1]: systemd-ask-password-console.path: Deactivated successfully. Oct 16 23:36:10.864208 systemd[1]: Stopped systemd-ask-password-console.path - Dispatch Password Requests to Console Directory Watch. Oct 16 23:36:10.869696 systemd[1]: Stopped target slices.target - Slice Units. Oct 16 23:36:10.877458 systemd[1]: Stopped target sockets.target - Socket Units. Oct 16 23:36:10.885214 systemd[1]: iscsid.socket: Deactivated successfully. Oct 16 23:36:10.885265 systemd[1]: Closed iscsid.socket - Open-iSCSI iscsid Socket. Oct 16 23:36:10.893111 systemd[1]: iscsiuio.socket: Deactivated successfully. Oct 16 23:36:10.893147 systemd[1]: Closed iscsiuio.socket - Open-iSCSI iscsiuio Socket. Oct 16 23:36:10.901146 systemd[1]: ignition-setup.service: Deactivated successfully. Oct 16 23:36:10.901191 systemd[1]: Stopped ignition-setup.service - Ignition (setup). Oct 16 23:36:10.909343 systemd[1]: ignition-setup-pre.service: Deactivated successfully. Oct 16 23:36:10.909379 systemd[1]: Stopped ignition-setup-pre.service - Ignition env setup. Oct 16 23:36:10.917724 systemd[1]: initrd-setup-root.service: Deactivated successfully. Oct 16 23:36:10.917762 systemd[1]: Stopped initrd-setup-root.service - Root filesystem setup. Oct 16 23:36:10.928406 systemd[1]: Stopping systemd-networkd.service - Network Configuration... Oct 16 23:36:10.937643 systemd[1]: Stopping systemd-resolved.service - Network Name Resolution... Oct 16 23:36:10.945589 systemd-networkd[900]: eth0: DHCPv6 lease lost Oct 16 23:36:10.947205 systemd[1]: systemd-networkd.service: Deactivated successfully. Oct 16 23:36:11.112612 kernel: hv_netvsc 7ced8dd4-cc46-7ced-8dd4-cc467ced8dd4 eth0: Data path switched from VF: enP57398s1 Oct 16 23:36:10.947341 systemd[1]: Stopped systemd-networkd.service - Network Configuration. Oct 16 23:36:10.957315 systemd[1]: initrd-cleanup.service: Deactivated successfully. Oct 16 23:36:10.957411 systemd[1]: Finished initrd-cleanup.service - Cleaning Up and Shutting Down Daemons. Oct 16 23:36:10.968405 systemd[1]: systemd-networkd.socket: Deactivated successfully. Oct 16 23:36:10.968461 systemd[1]: Closed systemd-networkd.socket - Network Service Netlink Socket. Oct 16 23:36:10.991854 systemd[1]: Stopping network-cleanup.service - Network Cleanup... Oct 16 23:36:10.998612 systemd[1]: parse-ip-for-networkd.service: Deactivated successfully. Oct 16 23:36:10.998677 systemd[1]: Stopped parse-ip-for-networkd.service - Write systemd-networkd units from cmdline. Oct 16 23:36:11.007718 systemd[1]: Stopping systemd-udevd.service - Rule-based Manager for Device Events and Files... Oct 16 23:36:11.020154 systemd[1]: systemd-resolved.service: Deactivated successfully. Oct 16 23:36:11.020263 systemd[1]: Stopped systemd-resolved.service - Network Name Resolution. Oct 16 23:36:11.043808 systemd[1]: systemd-sysctl.service: Deactivated successfully. Oct 16 23:36:11.043938 systemd[1]: Stopped systemd-sysctl.service - Apply Kernel Variables. Oct 16 23:36:11.052534 systemd[1]: systemd-modules-load.service: Deactivated successfully. Oct 16 23:36:11.052589 systemd[1]: Stopped systemd-modules-load.service - Load Kernel Modules. Oct 16 23:36:11.061167 systemd[1]: systemd-tmpfiles-setup.service: Deactivated successfully. Oct 16 23:36:11.061214 systemd[1]: Stopped systemd-tmpfiles-setup.service - Create System Files and Directories. Oct 16 23:36:11.072092 systemd[1]: systemd-udevd.service: Deactivated successfully. Oct 16 23:36:11.072224 systemd[1]: Stopped systemd-udevd.service - Rule-based Manager for Device Events and Files. Oct 16 23:36:11.082313 systemd[1]: systemd-udevd-control.socket: Deactivated successfully. Oct 16 23:36:11.082378 systemd[1]: Closed systemd-udevd-control.socket - udev Control Socket. Oct 16 23:36:11.091331 systemd[1]: systemd-udevd-kernel.socket: Deactivated successfully. Oct 16 23:36:11.091373 systemd[1]: Closed systemd-udevd-kernel.socket - udev Kernel Socket. Oct 16 23:36:11.104259 systemd[1]: dracut-pre-udev.service: Deactivated successfully. Oct 16 23:36:11.104323 systemd[1]: Stopped dracut-pre-udev.service - dracut pre-udev hook. Oct 16 23:36:11.117138 systemd[1]: dracut-cmdline.service: Deactivated successfully. Oct 16 23:36:11.117222 systemd[1]: Stopped dracut-cmdline.service - dracut cmdline hook. Oct 16 23:36:11.125450 systemd[1]: dracut-cmdline-ask.service: Deactivated successfully. Oct 16 23:36:11.125503 systemd[1]: Stopped dracut-cmdline-ask.service - dracut ask for additional cmdline parameters. Oct 16 23:36:11.152906 systemd[1]: Starting initrd-udevadm-cleanup-db.service - Cleanup udev Database... Oct 16 23:36:11.167727 systemd[1]: systemd-tmpfiles-setup-dev.service: Deactivated successfully. Oct 16 23:36:11.167802 systemd[1]: Stopped systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev. Oct 16 23:36:11.173481 systemd[1]: systemd-tmpfiles-setup-dev-early.service: Deactivated successfully. Oct 16 23:36:11.322955 systemd-journald[218]: Received SIGTERM from PID 1 (systemd). Oct 16 23:36:11.173523 systemd[1]: Stopped systemd-tmpfiles-setup-dev-early.service - Create Static Device Nodes in /dev gracefully. Oct 16 23:36:11.184053 systemd[1]: kmod-static-nodes.service: Deactivated successfully. Oct 16 23:36:11.184086 systemd[1]: Stopped kmod-static-nodes.service - Create List of Static Device Nodes. Oct 16 23:36:11.193029 systemd[1]: systemd-vconsole-setup.service: Deactivated successfully. Oct 16 23:36:11.193062 systemd[1]: Stopped systemd-vconsole-setup.service - Virtual Console Setup. Oct 16 23:36:11.202312 systemd[1]: network-cleanup.service: Deactivated successfully. Oct 16 23:36:11.202418 systemd[1]: Stopped network-cleanup.service - Network Cleanup. Oct 16 23:36:11.209985 systemd[1]: initrd-udevadm-cleanup-db.service: Deactivated successfully. Oct 16 23:36:11.210063 systemd[1]: Finished initrd-udevadm-cleanup-db.service - Cleanup udev Database. Oct 16 23:36:11.219547 systemd[1]: Reached target initrd-switch-root.target - Switch Root. Oct 16 23:36:11.240771 systemd[1]: Starting initrd-switch-root.service - Switch Root... Oct 16 23:36:11.249888 systemd[1]: Switching root. Oct 16 23:36:11.351369 systemd-journald[218]: Journal stopped Oct 16 23:36:14.583046 kernel: SELinux: policy capability network_peer_controls=1 Oct 16 23:36:14.583072 kernel: SELinux: policy capability open_perms=1 Oct 16 23:36:14.583083 kernel: SELinux: policy capability extended_socket_class=1 Oct 16 23:36:14.583090 kernel: SELinux: policy capability always_check_network=0 Oct 16 23:36:14.583100 kernel: SELinux: policy capability cgroup_seclabel=1 Oct 16 23:36:14.583108 kernel: SELinux: policy capability nnp_nosuid_transition=1 Oct 16 23:36:14.583117 kernel: SELinux: policy capability genfs_seclabel_symlinks=0 Oct 16 23:36:14.583125 kernel: SELinux: policy capability ioctl_skip_cloexec=0 Oct 16 23:36:14.583134 systemd[1]: Successfully loaded SELinux policy in 156.255ms. Oct 16 23:36:14.583144 kernel: audit: type=1403 audit(1792193771.653:2): auid=4294967295 ses=4294967295 lsm=selinux res=1 Oct 16 23:36:14.583154 systemd[1]: Relabeled /dev, /dev/shm, /run, /sys/fs/cgroup in 10.693ms. Oct 16 23:36:14.583165 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) Oct 16 23:36:14.583174 systemd[1]: Detected virtualization microsoft. Oct 16 23:36:14.583182 systemd[1]: Detected architecture arm64. Oct 16 23:36:14.583191 systemd[1]: Detected first boot. Oct 16 23:36:14.583202 systemd[1]: Hostname set to . Oct 16 23:36:14.583212 systemd[1]: Initializing machine ID from random generator. Oct 16 23:36:14.583220 zram_generator::config[1201]: No configuration found. Oct 16 23:36:14.583230 systemd[1]: Populated /etc with preset unit settings. Oct 16 23:36:14.583241 systemd[1]: initrd-switch-root.service: Deactivated successfully. Oct 16 23:36:14.583250 systemd[1]: Stopped initrd-switch-root.service - Switch Root. Oct 16 23:36:14.583259 systemd[1]: systemd-journald.service: Scheduled restart job, restart counter is at 1. Oct 16 23:36:14.583270 systemd[1]: Created slice system-addon\x2dconfig.slice - Slice /system/addon-config. Oct 16 23:36:14.583279 systemd[1]: Created slice system-addon\x2drun.slice - Slice /system/addon-run. Oct 16 23:36:14.583289 systemd[1]: Created slice system-getty.slice - Slice /system/getty. Oct 16 23:36:14.583298 systemd[1]: Created slice system-modprobe.slice - Slice /system/modprobe. Oct 16 23:36:14.583307 systemd[1]: Created slice system-serial\x2dgetty.slice - Slice /system/serial-getty. Oct 16 23:36:14.583316 systemd[1]: Created slice system-system\x2dcloudinit.slice - Slice /system/system-cloudinit. Oct 16 23:36:14.583326 systemd[1]: Created slice system-systemd\x2dfsck.slice - Slice /system/systemd-fsck. Oct 16 23:36:14.583336 systemd[1]: Created slice user.slice - User and Session Slice. Oct 16 23:36:14.583346 systemd[1]: Started clevis-luks-askpass.path - Forward Password Requests to Clevis Directory Watch. Oct 16 23:36:14.583355 systemd[1]: Started systemd-ask-password-console.path - Dispatch Password Requests to Console Directory Watch. Oct 16 23:36:14.583365 systemd[1]: Started systemd-ask-password-wall.path - Forward Password Requests to Wall Directory Watch. Oct 16 23:36:14.583374 systemd[1]: Set up automount boot.automount - Boot partition Automount Point. Oct 16 23:36:14.583383 systemd[1]: Set up automount proc-sys-fs-binfmt_misc.automount - Arbitrary Executable File Formats File System Automount Point. Oct 16 23:36:14.583393 systemd[1]: Expecting device dev-disk-by\x2dlabel-OEM.device - /dev/disk/by-label/OEM... Oct 16 23:36:14.583402 systemd[1]: Expecting device dev-ttyAMA0.device - /dev/ttyAMA0... Oct 16 23:36:14.583412 systemd[1]: Reached target cryptsetup-pre.target - Local Encrypted Volumes (Pre). Oct 16 23:36:14.583421 systemd[1]: Stopped target initrd-switch-root.target - Switch Root. Oct 16 23:36:14.583431 systemd[1]: Stopped target initrd-fs.target - Initrd File Systems. Oct 16 23:36:14.583444 systemd[1]: Stopped target initrd-root-fs.target - Initrd Root File System. Oct 16 23:36:14.583453 systemd[1]: Reached target integritysetup.target - Local Integrity Protected Volumes. Oct 16 23:36:14.583463 systemd[1]: Reached target remote-cryptsetup.target - Remote Encrypted Volumes. Oct 16 23:36:14.583472 systemd[1]: Reached target remote-fs.target - Remote File Systems. Oct 16 23:36:14.583481 systemd[1]: Reached target slices.target - Slice Units. Oct 16 23:36:14.583492 systemd[1]: Reached target swap.target - Swaps. Oct 16 23:36:14.583502 systemd[1]: Reached target veritysetup.target - Local Verity Protected Volumes. Oct 16 23:36:14.583511 systemd[1]: Listening on systemd-coredump.socket - Process Core Dump Socket. Oct 16 23:36:14.583521 systemd[1]: Listening on systemd-networkd.socket - Network Service Netlink Socket. Oct 16 23:36:14.583530 systemd[1]: Listening on systemd-udevd-control.socket - udev Control Socket. Oct 16 23:36:14.583540 systemd[1]: Listening on systemd-udevd-kernel.socket - udev Kernel Socket. Oct 16 23:36:14.583551 systemd[1]: Listening on systemd-userdbd.socket - User Database Manager Socket. Oct 16 23:36:14.583561 systemd[1]: Mounting dev-hugepages.mount - Huge Pages File System... Oct 16 23:36:14.583570 systemd[1]: Mounting dev-mqueue.mount - POSIX Message Queue File System... Oct 16 23:36:14.583580 systemd[1]: Mounting media.mount - External Media Directory... Oct 16 23:36:14.583589 systemd[1]: Mounting sys-kernel-debug.mount - Kernel Debug File System... Oct 16 23:36:14.583599 systemd[1]: Mounting sys-kernel-tracing.mount - Kernel Trace File System... Oct 16 23:36:14.583608 systemd[1]: Mounting tmp.mount - Temporary Directory /tmp... Oct 16 23:36:14.583620 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). Oct 16 23:36:14.583629 systemd[1]: Reached target machines.target - Containers. Oct 16 23:36:14.583639 systemd[1]: Starting flatcar-tmpfiles.service - Create missing system files... Oct 16 23:36:14.583650 systemd[1]: ignition-delete-config.service - Ignition (delete config) was skipped because no trigger condition checks were met. Oct 16 23:36:14.583660 systemd[1]: Starting kmod-static-nodes.service - Create List of Static Device Nodes... Oct 16 23:36:14.583669 systemd[1]: Starting modprobe@configfs.service - Load Kernel Module configfs... Oct 16 23:36:14.583679 systemd[1]: Starting modprobe@dm_mod.service - Load Kernel Module dm_mod... Oct 16 23:36:14.583694 systemd[1]: Starting modprobe@drm.service - Load Kernel Module drm... Oct 16 23:36:14.583707 systemd[1]: Starting modprobe@efi_pstore.service - Load Kernel Module efi_pstore... Oct 16 23:36:14.583717 systemd[1]: Starting modprobe@fuse.service - Load Kernel Module fuse... Oct 16 23:36:14.583726 systemd[1]: Starting modprobe@loop.service - Load Kernel Module loop... Oct 16 23:36:14.583736 systemd[1]: setup-nsswitch.service - Create /etc/nsswitch.conf was skipped because of an unmet condition check (ConditionPathExists=!/etc/nsswitch.conf). Oct 16 23:36:14.583746 systemd[1]: systemd-fsck-root.service: Deactivated successfully. Oct 16 23:36:14.583755 systemd[1]: Stopped systemd-fsck-root.service - File System Check on Root Device. Oct 16 23:36:14.583764 kernel: fuse: init (API version 7.39) Oct 16 23:36:14.583773 systemd[1]: systemd-fsck-usr.service: Deactivated successfully. Oct 16 23:36:14.583785 systemd[1]: Stopped systemd-fsck-usr.service. Oct 16 23:36:14.583794 kernel: ACPI: bus type drm_connector registered Oct 16 23:36:14.583803 systemd[1]: Starting systemd-journald.service - Journal Service... Oct 16 23:36:14.583812 kernel: loop: module loaded Oct 16 23:36:14.583821 systemd[1]: Starting systemd-modules-load.service - Load Kernel Modules... Oct 16 23:36:14.583831 systemd[1]: Starting systemd-network-generator.service - Generate network units from Kernel command line... Oct 16 23:36:14.583855 systemd-journald[1297]: Collecting audit messages is disabled. Oct 16 23:36:14.583878 systemd[1]: Starting systemd-remount-fs.service - Remount Root and Kernel File Systems... Oct 16 23:36:14.583890 systemd-journald[1297]: Journal started Oct 16 23:36:14.583910 systemd-journald[1297]: Runtime Journal (/run/log/journal/154788fcee0e4ae6b1616962802cc032) is 8.0M, max 78.5M, 70.5M free. Oct 16 23:36:13.776022 systemd[1]: Queued start job for default target multi-user.target. Oct 16 23:36:13.906586 systemd[1]: Unnecessary job was removed for dev-sda6.device - /dev/sda6. Oct 16 23:36:13.907062 systemd[1]: systemd-journald.service: Deactivated successfully. Oct 16 23:36:13.907386 systemd[1]: systemd-journald.service: Consumed 2.348s CPU time. Oct 16 23:36:14.609795 systemd[1]: Starting systemd-udev-trigger.service - Coldplug All udev Devices... Oct 16 23:36:14.617415 systemd[1]: verity-setup.service: Deactivated successfully. Oct 16 23:36:14.617450 systemd[1]: Stopped verity-setup.service. Oct 16 23:36:14.634400 systemd[1]: Started systemd-journald.service - Journal Service. Oct 16 23:36:14.637539 systemd[1]: Mounted dev-hugepages.mount - Huge Pages File System. Oct 16 23:36:14.642066 systemd[1]: Mounted dev-mqueue.mount - POSIX Message Queue File System. Oct 16 23:36:14.646977 systemd[1]: Mounted media.mount - External Media Directory. Oct 16 23:36:14.651099 systemd[1]: Mounted sys-kernel-debug.mount - Kernel Debug File System. Oct 16 23:36:14.655872 systemd[1]: Mounted sys-kernel-tracing.mount - Kernel Trace File System. Oct 16 23:36:14.660625 systemd[1]: Mounted tmp.mount - Temporary Directory /tmp. Oct 16 23:36:14.664965 systemd[1]: Finished flatcar-tmpfiles.service - Create missing system files. Oct 16 23:36:14.671240 systemd[1]: Finished kmod-static-nodes.service - Create List of Static Device Nodes. Oct 16 23:36:14.676819 systemd[1]: modprobe@configfs.service: Deactivated successfully. Oct 16 23:36:14.676964 systemd[1]: Finished modprobe@configfs.service - Load Kernel Module configfs. Oct 16 23:36:14.682264 systemd[1]: modprobe@dm_mod.service: Deactivated successfully. Oct 16 23:36:14.682397 systemd[1]: Finished modprobe@dm_mod.service - Load Kernel Module dm_mod. Oct 16 23:36:14.687504 systemd[1]: modprobe@drm.service: Deactivated successfully. Oct 16 23:36:14.687646 systemd[1]: Finished modprobe@drm.service - Load Kernel Module drm. Oct 16 23:36:14.694198 systemd[1]: modprobe@efi_pstore.service: Deactivated successfully. Oct 16 23:36:14.694330 systemd[1]: Finished modprobe@efi_pstore.service - Load Kernel Module efi_pstore. Oct 16 23:36:14.699779 systemd[1]: modprobe@fuse.service: Deactivated successfully. Oct 16 23:36:14.699924 systemd[1]: Finished modprobe@fuse.service - Load Kernel Module fuse. Oct 16 23:36:14.704793 systemd[1]: modprobe@loop.service: Deactivated successfully. Oct 16 23:36:14.704927 systemd[1]: Finished modprobe@loop.service - Load Kernel Module loop. Oct 16 23:36:14.709930 systemd[1]: Finished systemd-modules-load.service - Load Kernel Modules. Oct 16 23:36:14.715135 systemd[1]: Finished systemd-network-generator.service - Generate network units from Kernel command line. Oct 16 23:36:14.720839 systemd[1]: Finished systemd-remount-fs.service - Remount Root and Kernel File Systems. Oct 16 23:36:14.726494 systemd[1]: Finished systemd-udev-trigger.service - Coldplug All udev Devices. Oct 16 23:36:14.742765 systemd[1]: Reached target network-pre.target - Preparation for Network. Oct 16 23:36:14.757782 systemd[1]: Mounting sys-fs-fuse-connections.mount - FUSE Control File System... Oct 16 23:36:14.763384 systemd[1]: Mounting sys-kernel-config.mount - Kernel Configuration File System... Oct 16 23:36:14.768185 systemd[1]: remount-root.service - Remount Root File System was skipped because of an unmet condition check (ConditionPathIsReadWrite=!/). Oct 16 23:36:14.768223 systemd[1]: Reached target local-fs.target - Local File Systems. Oct 16 23:36:14.773746 systemd[1]: Listening on systemd-sysext.socket - System Extension Image Management (Varlink). Oct 16 23:36:14.783806 systemd[1]: Starting dracut-shutdown.service - Restore /run/initramfs on shutdown... Oct 16 23:36:14.789636 systemd[1]: Starting ldconfig.service - Rebuild Dynamic Linker Cache... Oct 16 23:36:14.793845 systemd[1]: systemd-binfmt.service - Set Up Additional Binary Formats was skipped because no trigger condition checks were met. Oct 16 23:36:14.795720 systemd[1]: Starting systemd-hwdb-update.service - Rebuild Hardware Database... Oct 16 23:36:14.802219 systemd[1]: Starting systemd-journal-flush.service - Flush Journal to Persistent Storage... Oct 16 23:36:14.808122 systemd[1]: systemd-pstore.service - Platform Persistent Storage Archival was skipped because of an unmet condition check (ConditionDirectoryNotEmpty=/sys/fs/pstore). Oct 16 23:36:14.809325 systemd[1]: Starting systemd-random-seed.service - Load/Save OS Random Seed... Oct 16 23:36:14.814068 systemd[1]: systemd-repart.service - Repartition Root Disk was skipped because no trigger condition checks were met. Oct 16 23:36:14.815874 systemd[1]: Starting systemd-sysctl.service - Apply Kernel Variables... Oct 16 23:36:14.825553 systemd[1]: Starting systemd-sysext.service - Merge System Extension Images into /usr/ and /opt/... Oct 16 23:36:14.835771 systemd[1]: Starting systemd-tmpfiles-setup-dev-early.service - Create Static Device Nodes in /dev gracefully... Oct 16 23:36:14.842593 systemd[1]: Starting systemd-udev-settle.service - Wait for udev To Complete Device Initialization... Oct 16 23:36:14.852533 systemd[1]: Mounted sys-fs-fuse-connections.mount - FUSE Control File System. Oct 16 23:36:14.863350 systemd[1]: Mounted sys-kernel-config.mount - Kernel Configuration File System. Oct 16 23:36:14.864498 systemd-journald[1297]: Time spent on flushing to /var/log/journal/154788fcee0e4ae6b1616962802cc032 is 16.686ms for 890 entries. Oct 16 23:36:14.864498 systemd-journald[1297]: System Journal (/var/log/journal/154788fcee0e4ae6b1616962802cc032) is 8.0M, max 2.8G, 2.7G free. Oct 16 23:36:14.902621 systemd-journald[1297]: Received client request to flush runtime journal. Oct 16 23:36:14.902655 kernel: loop0: detected capacity change from 0 to 114432 Oct 16 23:36:14.879208 systemd[1]: Finished dracut-shutdown.service - Restore /run/initramfs on shutdown. Oct 16 23:36:14.888480 systemd[1]: Finished systemd-random-seed.service - Load/Save OS Random Seed. Oct 16 23:36:14.897851 systemd[1]: Reached target first-boot-complete.target - First Boot Complete. Oct 16 23:36:14.909946 systemd[1]: Starting systemd-machine-id-commit.service - Commit a transient machine-id on disk... Oct 16 23:36:14.917172 systemd[1]: Finished systemd-journal-flush.service - Flush Journal to Persistent Storage. Oct 16 23:36:14.925228 udevadm[1338]: systemd-udev-settle.service is deprecated. Please fix lvm2-activation-early.service, lvm2-activation.service not to pull it in. Oct 16 23:36:14.931374 systemd[1]: Finished systemd-sysctl.service - Apply Kernel Variables. Oct 16 23:36:14.952582 systemd[1]: etc-machine\x2did.mount: Deactivated successfully. Oct 16 23:36:14.954017 systemd[1]: Finished systemd-machine-id-commit.service - Commit a transient machine-id on disk. Oct 16 23:36:15.003135 systemd-tmpfiles[1337]: ACLs are not supported, ignoring. Oct 16 23:36:15.003153 systemd-tmpfiles[1337]: ACLs are not supported, ignoring. Oct 16 23:36:15.007787 systemd[1]: Finished systemd-tmpfiles-setup-dev-early.service - Create Static Device Nodes in /dev gracefully. Oct 16 23:36:15.020856 systemd[1]: Starting systemd-sysusers.service - Create System Users... Oct 16 23:36:15.077721 systemd[1]: Finished systemd-sysusers.service - Create System Users. Oct 16 23:36:15.092872 systemd[1]: Starting systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev... Oct 16 23:36:15.106954 systemd-tmpfiles[1356]: ACLs are not supported, ignoring. Oct 16 23:36:15.107264 systemd-tmpfiles[1356]: ACLs are not supported, ignoring. Oct 16 23:36:15.112064 systemd[1]: Finished systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev. Oct 16 23:36:15.171714 kernel: squashfs: version 4.0 (2009/01/31) Phillip Lougher Oct 16 23:36:15.213698 kernel: loop1: detected capacity change from 0 to 114328 Oct 16 23:36:15.409708 kernel: loop2: detected capacity change from 0 to 31320 Oct 16 23:36:15.473530 systemd[1]: Finished systemd-hwdb-update.service - Rebuild Hardware Database. Oct 16 23:36:15.485822 systemd[1]: Starting systemd-udevd.service - Rule-based Manager for Device Events and Files... Oct 16 23:36:15.505570 systemd-udevd[1364]: Using default interface naming scheme 'v255'. Oct 16 23:36:15.583651 systemd[1]: Started systemd-udevd.service - Rule-based Manager for Device Events and Files. Oct 16 23:36:15.600886 systemd[1]: Starting systemd-networkd.service - Network Configuration... Oct 16 23:36:15.663153 systemd[1]: Starting systemd-userdbd.service - User Database Manager... Oct 16 23:36:15.671279 systemd[1]: Condition check resulted in dev-ttyAMA0.device - /dev/ttyAMA0 being skipped. Oct 16 23:36:15.709726 kernel: loop3: detected capacity change from 0 to 114432 Oct 16 23:36:15.721714 kernel: mousedev: PS/2 mouse device common for all mice Oct 16 23:36:15.721813 kernel: loop4: detected capacity change from 0 to 114328 Oct 16 23:36:15.736056 systemd[1]: Started systemd-userdbd.service - User Database Manager. Oct 16 23:36:15.751713 kernel: loop5: detected capacity change from 0 to 31320 Oct 16 23:36:15.766717 kernel: hv_storvsc f8b3781a-1e82-4818-a1c3-63d806ec15bb: tag#270 cmd 0x85 status: scsi 0x2 srb 0x6 hv 0xc0000001 Oct 16 23:36:15.769421 (sd-merge)[1401]: Using extensions 'containerd-flatcar', 'docker-flatcar', 'oem-azure'. Oct 16 23:36:15.769827 (sd-merge)[1401]: Merged extensions into '/usr'. Oct 16 23:36:15.782126 systemd[1]: Finished systemd-sysext.service - Merge System Extension Images into /usr/ and /opt/. Oct 16 23:36:15.794984 systemd[1]: Starting ensure-sysext.service... Oct 16 23:36:15.802860 systemd[1]: Starting systemd-tmpfiles-setup.service - Create System Files and Directories... Oct 16 23:36:15.840378 systemd[1]: Reloading requested from client PID 1409 ('systemctl') (unit ensure-sysext.service)... Oct 16 23:36:15.840394 systemd[1]: Reloading... Oct 16 23:36:15.856181 systemd-networkd[1375]: lo: Link UP Oct 16 23:36:15.856192 systemd-networkd[1375]: lo: Gained carrier Oct 16 23:36:15.864236 systemd-networkd[1375]: Enumeration completed Oct 16 23:36:15.870632 systemd-networkd[1375]: eth0: found matching network '/usr/lib/systemd/network/zz-default.network', based on potentially unpredictable interface name. Oct 16 23:36:15.870641 systemd-networkd[1375]: eth0: Configuring with /usr/lib/systemd/network/zz-default.network. Oct 16 23:36:15.877731 kernel: hv_vmbus: registering driver hv_balloon Oct 16 23:36:15.877823 kernel: hv_vmbus: registering driver hyperv_fb Oct 16 23:36:15.887375 kernel: hv_balloon: Using Dynamic Memory protocol version 2.0 Oct 16 23:36:15.887475 kernel: hyperv_fb: Synthvid Version major 3, minor 5 Oct 16 23:36:15.887500 kernel: hv_balloon: Memory hot add disabled on ARM64 Oct 16 23:36:15.887521 kernel: hyperv_fb: Screen resolution: 1024x768, Color depth: 32, Frame buffer size: 8388608 Oct 16 23:36:15.898389 kernel: Console: switching to colour dummy device 80x25 Oct 16 23:36:15.906035 systemd-tmpfiles[1410]: /usr/lib/tmpfiles.d/provision.conf:20: Duplicate line for path "/root", ignoring. Oct 16 23:36:15.909733 kernel: Console: switching to colour frame buffer device 128x48 Oct 16 23:36:15.907867 systemd-tmpfiles[1410]: /usr/lib/tmpfiles.d/systemd-flatcar.conf:6: Duplicate line for path "/var/log/journal", ignoring. Oct 16 23:36:15.908552 systemd-tmpfiles[1410]: /usr/lib/tmpfiles.d/systemd.conf:29: Duplicate line for path "/var/lib/systemd", ignoring. Oct 16 23:36:15.912565 systemd-tmpfiles[1410]: ACLs are not supported, ignoring. Oct 16 23:36:15.912799 systemd-tmpfiles[1410]: ACLs are not supported, ignoring. Oct 16 23:36:15.934284 systemd-tmpfiles[1410]: Detected autofs mount point /boot during canonicalization of boot. Oct 16 23:36:15.935765 systemd-tmpfiles[1410]: Skipping /boot Oct 16 23:36:15.964281 systemd-tmpfiles[1410]: Detected autofs mount point /boot during canonicalization of boot. Oct 16 23:36:15.967709 kernel: mlx5_core e036:00:02.0 enP57398s1: Link up Oct 16 23:36:15.968021 systemd-tmpfiles[1410]: Skipping /boot Oct 16 23:36:15.998698 zram_generator::config[1453]: No configuration found. Oct 16 23:36:15.998798 kernel: hv_netvsc 7ced8dd4-cc46-7ced-8dd4-cc467ced8dd4 eth0: Data path switched to VF: enP57398s1 Oct 16 23:36:16.009874 systemd-networkd[1375]: enP57398s1: Link UP Oct 16 23:36:16.009969 systemd-networkd[1375]: eth0: Link UP Oct 16 23:36:16.009972 systemd-networkd[1375]: eth0: Gained carrier Oct 16 23:36:16.009990 systemd-networkd[1375]: eth0: found matching network '/usr/lib/systemd/network/zz-default.network', based on potentially unpredictable interface name. Oct 16 23:36:16.019146 systemd-networkd[1375]: enP57398s1: Gained carrier Oct 16 23:36:16.035880 kernel: BTRFS warning: duplicate device /dev/sda3 devid 1 generation 33 scanned by (udev-worker) (1381) Oct 16 23:36:16.041347 systemd-networkd[1375]: eth0: DHCPv4 address 10.0.0.5/24, gateway 10.0.0.1 acquired from 168.63.129.16 Oct 16 23:36:16.143510 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. Oct 16 23:36:16.218258 systemd[1]: Found device dev-disk-by\x2dlabel-OEM.device - Virtual_Disk OEM. Oct 16 23:36:16.223800 systemd[1]: Reloading finished in 383 ms. Oct 16 23:36:16.259748 systemd[1]: Started systemd-networkd.service - Network Configuration. Oct 16 23:36:16.271110 systemd[1]: Finished systemd-tmpfiles-setup.service - Create System Files and Directories. Oct 16 23:36:16.299331 systemd[1]: Finished ensure-sysext.service. Oct 16 23:36:16.331979 systemd[1]: Starting audit-rules.service - Load Security Auditing Rules... Oct 16 23:36:16.339897 systemd[1]: Starting clean-ca-certificates.service - Clean up broken links in /etc/ssl/certs... Oct 16 23:36:16.348795 systemd[1]: ignition-delete-config.service - Ignition (delete config) was skipped because no trigger condition checks were met. Oct 16 23:36:16.351895 systemd[1]: Starting modprobe@dm_mod.service - Load Kernel Module dm_mod... Oct 16 23:36:16.359558 systemd[1]: Starting modprobe@drm.service - Load Kernel Module drm... Oct 16 23:36:16.369879 systemd[1]: Starting modprobe@efi_pstore.service - Load Kernel Module efi_pstore... Oct 16 23:36:16.385011 systemd[1]: Starting modprobe@loop.service - Load Kernel Module loop... Oct 16 23:36:16.389841 systemd[1]: systemd-binfmt.service - Set Up Additional Binary Formats was skipped because no trigger condition checks were met. Oct 16 23:36:16.392147 systemd[1]: Starting systemd-fsck@dev-disk-by\x2dlabel-OEM.service - File System Check on /dev/disk/by-label/OEM... Oct 16 23:36:16.397778 systemd[1]: Starting systemd-journal-catalog-update.service - Rebuild Journal Catalog... Oct 16 23:36:16.405858 systemd[1]: Starting systemd-networkd-wait-online.service - Wait for Network to be Configured... Oct 16 23:36:16.424037 systemd[1]: Starting systemd-resolved.service - Network Name Resolution... Oct 16 23:36:16.429680 systemd[1]: Reached target time-set.target - System Time Set. Oct 16 23:36:16.440085 systemd[1]: Starting systemd-update-utmp.service - Record System Boot/Shutdown in UTMP... Oct 16 23:36:16.447188 systemd[1]: Starting systemd-vconsole-setup.service - Virtual Console Setup... Oct 16 23:36:16.461760 systemd[1]: Finished systemd-udev-settle.service - Wait for udev To Complete Device Initialization. Oct 16 23:36:16.469792 systemd[1]: modprobe@dm_mod.service: Deactivated successfully. Oct 16 23:36:16.469952 systemd[1]: Finished modprobe@dm_mod.service - Load Kernel Module dm_mod. Oct 16 23:36:16.476663 systemd[1]: modprobe@drm.service: Deactivated successfully. Oct 16 23:36:16.476822 systemd[1]: Finished modprobe@drm.service - Load Kernel Module drm. Oct 16 23:36:16.482072 systemd[1]: modprobe@efi_pstore.service: Deactivated successfully. Oct 16 23:36:16.482215 systemd[1]: Finished modprobe@efi_pstore.service - Load Kernel Module efi_pstore. Oct 16 23:36:16.488046 systemd[1]: modprobe@loop.service: Deactivated successfully. Oct 16 23:36:16.488176 systemd[1]: Finished modprobe@loop.service - Load Kernel Module loop. Oct 16 23:36:16.493451 systemd[1]: Finished systemd-fsck@dev-disk-by\x2dlabel-OEM.service - File System Check on /dev/disk/by-label/OEM. Oct 16 23:36:16.501811 augenrules[1568]: No rules Oct 16 23:36:16.501150 systemd[1]: Finished systemd-journal-catalog-update.service - Rebuild Journal Catalog. Oct 16 23:36:16.509255 systemd[1]: Finished audit-rules.service - Load Security Auditing Rules. Oct 16 23:36:16.532134 systemd[1]: Finished systemd-update-utmp.service - Record System Boot/Shutdown in UTMP. Oct 16 23:36:16.544959 systemd[1]: Starting lvm2-activation-early.service - Activation of LVM2 logical volumes... Oct 16 23:36:16.552416 systemd[1]: systemd-pstore.service - Platform Persistent Storage Archival was skipped because of an unmet condition check (ConditionDirectoryNotEmpty=/sys/fs/pstore). Oct 16 23:36:16.552495 systemd[1]: systemd-repart.service - Repartition Root Disk was skipped because no trigger condition checks were met. Oct 16 23:36:16.605697 systemd-resolved[1556]: Positive Trust Anchors: Oct 16 23:36:16.606018 systemd-resolved[1556]: . IN DS 20326 8 2 e06d44b80b8f1d39a95c0b0d7c65d08458e880409bbc683457104237c7f8ec8d Oct 16 23:36:16.606054 systemd-resolved[1556]: 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 Oct 16 23:36:16.669802 systemd-resolved[1556]: Using system hostname 'ci-4081.3.10--e3223b72ee'. Oct 16 23:36:16.671397 systemd[1]: Started systemd-resolved.service - Network Name Resolution. Oct 16 23:36:16.676343 lvm[1584]: WARNING: Failed to connect to lvmetad. Falling back to device scanning. Oct 16 23:36:16.677112 systemd[1]: Reached target network.target - Network. Oct 16 23:36:16.681541 systemd[1]: Reached target nss-lookup.target - Host and Network Name Lookups. Oct 16 23:36:16.695635 systemd[1]: Finished lvm2-activation-early.service - Activation of LVM2 logical volumes. Oct 16 23:36:16.701639 systemd[1]: Reached target cryptsetup.target - Local Encrypted Volumes. Oct 16 23:36:16.710829 systemd[1]: Starting lvm2-activation.service - Activation of LVM2 logical volumes... Oct 16 23:36:16.719425 lvm[1586]: WARNING: Failed to connect to lvmetad. Falling back to device scanning. Oct 16 23:36:16.742417 systemd[1]: Finished lvm2-activation.service - Activation of LVM2 logical volumes. Oct 16 23:36:16.973730 systemd[1]: Finished clean-ca-certificates.service - Clean up broken links in /etc/ssl/certs. Oct 16 23:36:16.979646 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). Oct 16 23:36:17.036378 systemd[1]: Finished systemd-vconsole-setup.service - Virtual Console Setup. Oct 16 23:36:17.281963 systemd-networkd[1375]: eth0: Gained IPv6LL Oct 16 23:36:17.284405 systemd[1]: Finished systemd-networkd-wait-online.service - Wait for Network to be Configured. Oct 16 23:36:17.290586 systemd[1]: Reached target network-online.target - Network is Online. Oct 16 23:36:18.969913 ldconfig[1330]: /sbin/ldconfig: /lib/ld.so.conf is not an ELF file - it has the wrong magic bytes at the start. Oct 16 23:36:18.978795 systemd[1]: Finished ldconfig.service - Rebuild Dynamic Linker Cache. Oct 16 23:36:18.995894 systemd[1]: Starting systemd-update-done.service - Update is Completed... Oct 16 23:36:19.007506 systemd[1]: Finished systemd-update-done.service - Update is Completed. Oct 16 23:36:19.013223 systemd[1]: Reached target sysinit.target - System Initialization. Oct 16 23:36:19.017889 systemd[1]: Started motdgen.path - Watch for update engine configuration changes. Oct 16 23:36:19.022960 systemd[1]: Started user-cloudinit@var-lib-flatcar\x2dinstall-user_data.path - Watch for a cloud-config at /var/lib/flatcar-install/user_data. Oct 16 23:36:19.028495 systemd[1]: Started logrotate.timer - Daily rotation of log files. Oct 16 23:36:19.033277 systemd[1]: Started mdadm.timer - Weekly check for MD array's redundancy information.. Oct 16 23:36:19.038581 systemd[1]: Started systemd-tmpfiles-clean.timer - Daily Cleanup of Temporary Directories. Oct 16 23:36:19.043999 systemd[1]: update-engine-stub.timer - Update Engine Stub Timer was skipped because of an unmet condition check (ConditionPathExists=/usr/.noupdate). Oct 16 23:36:19.044115 systemd[1]: Reached target paths.target - Path Units. Oct 16 23:36:19.047834 systemd[1]: Reached target timers.target - Timer Units. Oct 16 23:36:19.052337 systemd[1]: Listening on dbus.socket - D-Bus System Message Bus Socket. Oct 16 23:36:19.058340 systemd[1]: Starting docker.socket - Docker Socket for the API... Oct 16 23:36:19.068404 systemd[1]: Listening on sshd.socket - OpenSSH Server Socket. Oct 16 23:36:19.073251 systemd[1]: Listening on docker.socket - Docker Socket for the API. Oct 16 23:36:19.077911 systemd[1]: Reached target sockets.target - Socket Units. Oct 16 23:36:19.081732 systemd[1]: Reached target basic.target - Basic System. Oct 16 23:36:19.085506 systemd[1]: addon-config@oem.service - Configure Addon /oem was skipped because no trigger condition checks were met. Oct 16 23:36:19.085533 systemd[1]: addon-run@oem.service - Run Addon /oem was skipped because no trigger condition checks were met. Oct 16 23:36:19.108777 systemd[1]: Starting chronyd.service - NTP client/server... Oct 16 23:36:19.113808 systemd[1]: Starting containerd.service - containerd container runtime... Oct 16 23:36:19.127837 systemd[1]: Starting coreos-metadata.service - Flatcar Metadata Agent... Oct 16 23:36:19.133495 (chronyd)[1598]: chronyd.service: Referenced but unset environment variable evaluates to an empty string: OPTIONS Oct 16 23:36:19.133844 systemd[1]: Starting dbus.service - D-Bus System Message Bus... Oct 16 23:36:19.139826 systemd[1]: Starting enable-oem-cloudinit.service - Enable cloudinit... Oct 16 23:36:19.148858 systemd[1]: Starting extend-filesystems.service - Extend Filesystems... Oct 16 23:36:19.150439 chronyd[1607]: chronyd version 4.5 starting (+CMDMON +NTP +REFCLOCK +RTC +PRIVDROP +SCFILTER -SIGND +ASYNCDNS +NTS +SECHASH +IPV6 -DEBUG) Oct 16 23:36:19.153354 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). Oct 16 23:36:19.153400 systemd[1]: hv_fcopy_daemon.service - Hyper-V FCOPY daemon was skipped because of an unmet condition check (ConditionPathExists=/dev/vmbus/hv_fcopy). Oct 16 23:36:19.157842 systemd[1]: Started hv_kvp_daemon.service - Hyper-V KVP daemon. Oct 16 23:36:19.160203 KVP[1608]: KVP starting; pid is:1608 Oct 16 23:36:19.163700 systemd[1]: hv_vss_daemon.service - Hyper-V VSS daemon was skipped because of an unmet condition check (ConditionPathExists=/dev/vmbus/hv_vss). Oct 16 23:36:19.166908 systemd[1]: Starting motdgen.service - Generate /run/flatcar/motd... Oct 16 23:36:19.176918 jq[1604]: false Oct 16 23:36:19.174648 chronyd[1607]: Timezone right/UTC failed leap second check, ignoring Oct 16 23:36:19.174909 systemd[1]: Starting nvidia.service - NVIDIA Configure Service... Oct 16 23:36:19.174868 chronyd[1607]: Loaded seccomp filter (level 2) Oct 16 23:36:19.184094 systemd[1]: Starting ssh-key-proc-cmdline.service - Install an ssh key from /proc/cmdline... Oct 16 23:36:19.200885 systemd[1]: Starting sshd-keygen.service - Generate sshd host keys... Oct 16 23:36:19.207706 kernel: hv_utils: KVP IC version 4.0 Oct 16 23:36:19.209519 KVP[1608]: KVP LIC Version: 3.1 Oct 16 23:36:19.215349 extend-filesystems[1605]: Found loop3 Oct 16 23:36:19.215349 extend-filesystems[1605]: Found loop4 Oct 16 23:36:19.215349 extend-filesystems[1605]: Found loop5 Oct 16 23:36:19.215349 extend-filesystems[1605]: Found sda Oct 16 23:36:19.215349 extend-filesystems[1605]: Found sda1 Oct 16 23:36:19.215349 extend-filesystems[1605]: Found sda2 Oct 16 23:36:19.215349 extend-filesystems[1605]: Found sda3 Oct 16 23:36:19.215349 extend-filesystems[1605]: Found usr Oct 16 23:36:19.215349 extend-filesystems[1605]: Found sda4 Oct 16 23:36:19.215349 extend-filesystems[1605]: Found sda6 Oct 16 23:36:19.215349 extend-filesystems[1605]: Found sda7 Oct 16 23:36:19.215349 extend-filesystems[1605]: Found sda9 Oct 16 23:36:19.215349 extend-filesystems[1605]: Checking size of /dev/sda9 Oct 16 23:36:19.350960 coreos-metadata[1600]: Oct 16 23:36:19.343 INFO Fetching http://168.63.129.16/?comp=versions: Attempt #1 Oct 16 23:36:19.218083 systemd[1]: Starting systemd-logind.service - User Login Management... Oct 16 23:36:19.353977 extend-filesystems[1605]: Old size kept for /dev/sda9 Oct 16 23:36:19.353977 extend-filesystems[1605]: Found sr0 Oct 16 23:36:19.244300 dbus-daemon[1601]: [system] SELinux support is enabled Oct 16 23:36:19.369484 coreos-metadata[1600]: Oct 16 23:36:19.352 INFO Fetch successful Oct 16 23:36:19.369484 coreos-metadata[1600]: Oct 16 23:36:19.352 INFO Fetching http://168.63.129.16/machine/?comp=goalstate: Attempt #1 Oct 16 23:36:19.369484 coreos-metadata[1600]: Oct 16 23:36:19.368 INFO Fetch successful Oct 16 23:36:19.369484 coreos-metadata[1600]: Oct 16 23:36:19.369 INFO Fetching http://168.63.129.16/machine/b2bb3f18-68ab-4c25-a60c-fc902a84d015/38436d82%2Ddc4e%2D411a%2Db3b6%2D467cfa7ed74f.%5Fci%2D4081.3.10%2D%2De3223b72ee?comp=config&type=sharedConfig&incarnation=1: Attempt #1 Oct 16 23:36:19.230346 systemd[1]: tcsd.service - TCG Core Services Daemon was skipped because of an unmet condition check (ConditionPathExists=/dev/tpm0). Oct 16 23:36:19.233953 systemd[1]: cgroup compatibility translation between legacy and unified hierarchy settings activated. See cgroup-compat debug messages for details. Oct 16 23:36:19.369890 jq[1633]: true Oct 16 23:36:19.237162 systemd[1]: Starting update-engine.service - Update Engine... Oct 16 23:36:19.259635 systemd[1]: Starting update-ssh-keys-after-ignition.service - Run update-ssh-keys once after Ignition... Oct 16 23:36:19.267953 systemd[1]: Started dbus.service - D-Bus System Message Bus. Oct 16 23:36:19.279145 systemd[1]: Started chronyd.service - NTP client/server. Oct 16 23:36:19.293065 systemd[1]: enable-oem-cloudinit.service: Skipped due to 'exec-condition'. Oct 16 23:36:19.293601 systemd[1]: Condition check resulted in enable-oem-cloudinit.service - Enable cloudinit being skipped. Oct 16 23:36:19.294419 systemd[1]: motdgen.service: Deactivated successfully. Oct 16 23:36:19.294581 systemd[1]: Finished motdgen.service - Generate /run/flatcar/motd. Oct 16 23:36:19.306723 systemd[1]: extend-filesystems.service: Deactivated successfully. Oct 16 23:36:19.371894 jq[1642]: true Oct 16 23:36:19.372109 coreos-metadata[1600]: Oct 16 23:36:19.370 INFO Fetch successful Oct 16 23:36:19.372109 coreos-metadata[1600]: Oct 16 23:36:19.371 INFO Fetching http://169.254.169.254/metadata/instance/compute/vmSize?api-version=2017-08-01&format=text: Attempt #1 Oct 16 23:36:19.306923 systemd[1]: Finished extend-filesystems.service - Extend Filesystems. Oct 16 23:36:19.315618 systemd[1]: Finished nvidia.service - NVIDIA Configure Service. Oct 16 23:36:19.327410 systemd[1]: ssh-key-proc-cmdline.service: Deactivated successfully. Oct 16 23:36:19.327572 systemd[1]: Finished ssh-key-proc-cmdline.service - Install an ssh key from /proc/cmdline. Oct 16 23:36:19.380134 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). Oct 16 23:36:19.380177 systemd[1]: Reached target system-config.target - Load system-provided cloud configs. Oct 16 23:36:19.383894 coreos-metadata[1600]: Oct 16 23:36:19.382 INFO Fetch successful Oct 16 23:36:19.391094 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). Oct 16 23:36:19.391121 systemd[1]: Reached target user-config.target - Load user-provided cloud configs. Oct 16 23:36:19.396863 (ntainerd)[1645]: containerd.service: Referenced but unset environment variable evaluates to an empty string: TORCX_IMAGEDIR, TORCX_UNPACKDIR Oct 16 23:36:19.402857 systemd-logind[1622]: Watching system buttons on /dev/input/event1 (AT Translated Set 2 keyboard) Oct 16 23:36:19.408288 systemd-logind[1622]: New seat seat0. Oct 16 23:36:19.410018 systemd[1]: Started systemd-logind.service - User Login Management. Oct 16 23:36:19.430894 update_engine[1627]: I20261016 23:36:19.430403 1627 main.cc:92] Flatcar Update Engine starting Oct 16 23:36:19.454868 kernel: BTRFS warning: duplicate device /dev/sda3 devid 1 generation 33 scanned by (udev-worker) (1654) Oct 16 23:36:19.454926 update_engine[1627]: I20261016 23:36:19.434507 1627 update_check_scheduler.cc:74] Next update check in 8m28s Oct 16 23:36:19.434497 systemd[1]: Started update-engine.service - Update Engine. Oct 16 23:36:19.456317 systemd[1]: Started locksmithd.service - Cluster reboot manager. Oct 16 23:36:19.493723 systemd[1]: Finished coreos-metadata.service - Flatcar Metadata Agent. Oct 16 23:36:19.501769 systemd[1]: packet-phone-home.service - Report Success to Packet was skipped because no trigger condition checks were met. Oct 16 23:36:19.577027 bash[1706]: Updated "/home/core/.ssh/authorized_keys" Oct 16 23:36:19.579082 systemd[1]: Finished update-ssh-keys-after-ignition.service - Run update-ssh-keys once after Ignition. Oct 16 23:36:19.585111 systemd[1]: sshkeys.service was skipped because no trigger condition checks were met. Oct 16 23:36:19.680124 locksmithd[1681]: locksmithd starting currentOperation="UPDATE_STATUS_IDLE" strategy="reboot" Oct 16 23:36:20.069747 containerd[1645]: time="2026-10-16T23:36:20.069353960Z" level=info msg="starting containerd" revision=174e0d1785eeda18dc2beba45e1d5a188771636b version=v1.7.21 Oct 16 23:36:20.099705 containerd[1645]: time="2026-10-16T23:36:20.099084560Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.aufs\"..." type=io.containerd.snapshotter.v1 Oct 16 23:36:20.100463 containerd[1645]: time="2026-10-16T23:36:20.100428920Z" 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.157-flatcar\\n\"): skip plugin" type=io.containerd.snapshotter.v1 Oct 16 23:36:20.100508 containerd[1645]: time="2026-10-16T23:36:20.100463640Z" level=info msg="loading plugin \"io.containerd.event.v1.exchange\"..." type=io.containerd.event.v1 Oct 16 23:36:20.100508 containerd[1645]: time="2026-10-16T23:36:20.100481120Z" level=info msg="loading plugin \"io.containerd.internal.v1.opt\"..." type=io.containerd.internal.v1 Oct 16 23:36:20.100632 containerd[1645]: time="2026-10-16T23:36:20.100615560Z" level=info msg="loading plugin \"io.containerd.warning.v1.deprecations\"..." type=io.containerd.warning.v1 Oct 16 23:36:20.100659 containerd[1645]: time="2026-10-16T23:36:20.100635200Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.blockfile\"..." type=io.containerd.snapshotter.v1 Oct 16 23:36:20.100713 containerd[1645]: time="2026-10-16T23:36:20.100697000Z" level=info msg="skip loading plugin \"io.containerd.snapshotter.v1.blockfile\"..." error="no scratch file generator: skip plugin" type=io.containerd.snapshotter.v1 Oct 16 23:36:20.100739 containerd[1645]: time="2026-10-16T23:36:20.100711840Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.btrfs\"..." type=io.containerd.snapshotter.v1 Oct 16 23:36:20.100876 containerd[1645]: time="2026-10-16T23:36:20.100858480Z" level=info msg="skip loading plugin \"io.containerd.snapshotter.v1.btrfs\"..." error="path /var/lib/containerd/io.containerd.snapshotter.v1.btrfs (xfs) must be a btrfs filesystem to be used with the btrfs snapshotter: skip plugin" type=io.containerd.snapshotter.v1 Oct 16 23:36:20.100903 containerd[1645]: time="2026-10-16T23:36:20.100876040Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.devmapper\"..." type=io.containerd.snapshotter.v1 Oct 16 23:36:20.100903 containerd[1645]: time="2026-10-16T23:36:20.100889080Z" level=info msg="skip loading plugin \"io.containerd.snapshotter.v1.devmapper\"..." error="devmapper not configured: skip plugin" type=io.containerd.snapshotter.v1 Oct 16 23:36:20.100903 containerd[1645]: time="2026-10-16T23:36:20.100899200Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.native\"..." type=io.containerd.snapshotter.v1 Oct 16 23:36:20.100988 containerd[1645]: time="2026-10-16T23:36:20.100964760Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.overlayfs\"..." type=io.containerd.snapshotter.v1 Oct 16 23:36:20.101712 containerd[1645]: time="2026-10-16T23:36:20.101183240Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.zfs\"..." type=io.containerd.snapshotter.v1 Oct 16 23:36:20.101712 containerd[1645]: time="2026-10-16T23:36:20.101275600Z" 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 Oct 16 23:36:20.101712 containerd[1645]: time="2026-10-16T23:36:20.101290520Z" level=info msg="loading plugin \"io.containerd.content.v1.content\"..." type=io.containerd.content.v1 Oct 16 23:36:20.101712 containerd[1645]: time="2026-10-16T23:36:20.101355160Z" level=info msg="loading plugin \"io.containerd.metadata.v1.bolt\"..." type=io.containerd.metadata.v1 Oct 16 23:36:20.101712 containerd[1645]: time="2026-10-16T23:36:20.101388960Z" level=info msg="metadata content store policy set" policy=shared Oct 16 23:36:20.111532 containerd[1645]: time="2026-10-16T23:36:20.111477200Z" level=info msg="loading plugin \"io.containerd.gc.v1.scheduler\"..." type=io.containerd.gc.v1 Oct 16 23:36:20.111674 containerd[1645]: time="2026-10-16T23:36:20.111611360Z" level=info msg="loading plugin \"io.containerd.differ.v1.walking\"..." type=io.containerd.differ.v1 Oct 16 23:36:20.111674 containerd[1645]: time="2026-10-16T23:36:20.111634840Z" level=info msg="loading plugin \"io.containerd.lease.v1.manager\"..." type=io.containerd.lease.v1 Oct 16 23:36:20.112014 containerd[1645]: time="2026-10-16T23:36:20.111650360Z" level=info msg="loading plugin \"io.containerd.streaming.v1.manager\"..." type=io.containerd.streaming.v1 Oct 16 23:36:20.112014 containerd[1645]: time="2026-10-16T23:36:20.111777440Z" level=info msg="loading plugin \"io.containerd.runtime.v1.linux\"..." type=io.containerd.runtime.v1 Oct 16 23:36:20.112014 containerd[1645]: time="2026-10-16T23:36:20.111923440Z" level=info msg="loading plugin \"io.containerd.monitor.v1.cgroups\"..." type=io.containerd.monitor.v1 Oct 16 23:36:20.112340 containerd[1645]: time="2026-10-16T23:36:20.112322080Z" level=info msg="loading plugin \"io.containerd.runtime.v2.task\"..." type=io.containerd.runtime.v2 Oct 16 23:36:20.112497 containerd[1645]: time="2026-10-16T23:36:20.112482840Z" level=info msg="loading plugin \"io.containerd.runtime.v2.shim\"..." type=io.containerd.runtime.v2 Oct 16 23:36:20.112558 containerd[1645]: time="2026-10-16T23:36:20.112545280Z" level=info msg="loading plugin \"io.containerd.sandbox.store.v1.local\"..." type=io.containerd.sandbox.store.v1 Oct 16 23:36:20.113138 containerd[1645]: time="2026-10-16T23:36:20.112596640Z" level=info msg="loading plugin \"io.containerd.sandbox.controller.v1.local\"..." type=io.containerd.sandbox.controller.v1 Oct 16 23:36:20.113138 containerd[1645]: time="2026-10-16T23:36:20.112617200Z" level=info msg="loading plugin \"io.containerd.service.v1.containers-service\"..." type=io.containerd.service.v1 Oct 16 23:36:20.113138 containerd[1645]: time="2026-10-16T23:36:20.112631560Z" level=info msg="loading plugin \"io.containerd.service.v1.content-service\"..." type=io.containerd.service.v1 Oct 16 23:36:20.113138 containerd[1645]: time="2026-10-16T23:36:20.112645680Z" level=info msg="loading plugin \"io.containerd.service.v1.diff-service\"..." type=io.containerd.service.v1 Oct 16 23:36:20.113138 containerd[1645]: time="2026-10-16T23:36:20.112659920Z" level=info msg="loading plugin \"io.containerd.service.v1.images-service\"..." type=io.containerd.service.v1 Oct 16 23:36:20.113138 containerd[1645]: time="2026-10-16T23:36:20.112674520Z" level=info msg="loading plugin \"io.containerd.service.v1.introspection-service\"..." type=io.containerd.service.v1 Oct 16 23:36:20.113138 containerd[1645]: time="2026-10-16T23:36:20.112699600Z" level=info msg="loading plugin \"io.containerd.service.v1.namespaces-service\"..." type=io.containerd.service.v1 Oct 16 23:36:20.113138 containerd[1645]: time="2026-10-16T23:36:20.112714720Z" level=info msg="loading plugin \"io.containerd.service.v1.snapshots-service\"..." type=io.containerd.service.v1 Oct 16 23:36:20.113138 containerd[1645]: time="2026-10-16T23:36:20.112728200Z" level=info msg="loading plugin \"io.containerd.service.v1.tasks-service\"..." type=io.containerd.service.v1 Oct 16 23:36:20.113138 containerd[1645]: time="2026-10-16T23:36:20.112749480Z" level=info msg="loading plugin \"io.containerd.grpc.v1.containers\"..." type=io.containerd.grpc.v1 Oct 16 23:36:20.113138 containerd[1645]: time="2026-10-16T23:36:20.112762720Z" level=info msg="loading plugin \"io.containerd.grpc.v1.content\"..." type=io.containerd.grpc.v1 Oct 16 23:36:20.113138 containerd[1645]: time="2026-10-16T23:36:20.112775200Z" level=info msg="loading plugin \"io.containerd.grpc.v1.diff\"..." type=io.containerd.grpc.v1 Oct 16 23:36:20.113138 containerd[1645]: time="2026-10-16T23:36:20.112793880Z" level=info msg="loading plugin \"io.containerd.grpc.v1.events\"..." type=io.containerd.grpc.v1 Oct 16 23:36:20.113138 containerd[1645]: time="2026-10-16T23:36:20.112806320Z" level=info msg="loading plugin \"io.containerd.grpc.v1.images\"..." type=io.containerd.grpc.v1 Oct 16 23:36:20.113409 containerd[1645]: time="2026-10-16T23:36:20.112832200Z" level=info msg="loading plugin \"io.containerd.grpc.v1.introspection\"..." type=io.containerd.grpc.v1 Oct 16 23:36:20.113409 containerd[1645]: time="2026-10-16T23:36:20.112845400Z" level=info msg="loading plugin \"io.containerd.grpc.v1.leases\"..." type=io.containerd.grpc.v1 Oct 16 23:36:20.113409 containerd[1645]: time="2026-10-16T23:36:20.112858960Z" level=info msg="loading plugin \"io.containerd.grpc.v1.namespaces\"..." type=io.containerd.grpc.v1 Oct 16 23:36:20.113409 containerd[1645]: time="2026-10-16T23:36:20.112871640Z" level=info msg="loading plugin \"io.containerd.grpc.v1.sandbox-controllers\"..." type=io.containerd.grpc.v1 Oct 16 23:36:20.113409 containerd[1645]: time="2026-10-16T23:36:20.112885360Z" level=info msg="loading plugin \"io.containerd.grpc.v1.sandboxes\"..." type=io.containerd.grpc.v1 Oct 16 23:36:20.113409 containerd[1645]: time="2026-10-16T23:36:20.112900280Z" level=info msg="loading plugin \"io.containerd.grpc.v1.snapshots\"..." type=io.containerd.grpc.v1 Oct 16 23:36:20.113409 containerd[1645]: time="2026-10-16T23:36:20.112911760Z" level=info msg="loading plugin \"io.containerd.grpc.v1.streaming\"..." type=io.containerd.grpc.v1 Oct 16 23:36:20.113409 containerd[1645]: time="2026-10-16T23:36:20.112925960Z" level=info msg="loading plugin \"io.containerd.grpc.v1.tasks\"..." type=io.containerd.grpc.v1 Oct 16 23:36:20.113409 containerd[1645]: time="2026-10-16T23:36:20.112941240Z" level=info msg="loading plugin \"io.containerd.transfer.v1.local\"..." type=io.containerd.transfer.v1 Oct 16 23:36:20.113409 containerd[1645]: time="2026-10-16T23:36:20.112963400Z" level=info msg="loading plugin \"io.containerd.grpc.v1.transfer\"..." type=io.containerd.grpc.v1 Oct 16 23:36:20.113409 containerd[1645]: time="2026-10-16T23:36:20.112977120Z" level=info msg="loading plugin \"io.containerd.grpc.v1.version\"..." type=io.containerd.grpc.v1 Oct 16 23:36:20.113409 containerd[1645]: time="2026-10-16T23:36:20.112987440Z" level=info msg="loading plugin \"io.containerd.internal.v1.restart\"..." type=io.containerd.internal.v1 Oct 16 23:36:20.114086 containerd[1645]: time="2026-10-16T23:36:20.114062160Z" level=info msg="loading plugin \"io.containerd.tracing.processor.v1.otlp\"..." type=io.containerd.tracing.processor.v1 Oct 16 23:36:20.114267 containerd[1645]: time="2026-10-16T23:36:20.114249480Z" 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 Oct 16 23:36:20.115199 containerd[1645]: time="2026-10-16T23:36:20.114320880Z" level=info msg="loading plugin \"io.containerd.internal.v1.tracing\"..." type=io.containerd.internal.v1 Oct 16 23:36:20.115199 containerd[1645]: time="2026-10-16T23:36:20.114341160Z" level=info msg="skip loading plugin \"io.containerd.internal.v1.tracing\"..." error="skip plugin: tracing endpoint not configured" type=io.containerd.internal.v1 Oct 16 23:36:20.115199 containerd[1645]: time="2026-10-16T23:36:20.114351760Z" level=info msg="loading plugin \"io.containerd.grpc.v1.healthcheck\"..." type=io.containerd.grpc.v1 Oct 16 23:36:20.115199 containerd[1645]: time="2026-10-16T23:36:20.114366000Z" level=info msg="loading plugin \"io.containerd.nri.v1.nri\"..." type=io.containerd.nri.v1 Oct 16 23:36:20.115199 containerd[1645]: time="2026-10-16T23:36:20.114378880Z" level=info msg="NRI interface is disabled by configuration." Oct 16 23:36:20.115199 containerd[1645]: time="2026-10-16T23:36:20.114390200Z" level=info msg="loading plugin \"io.containerd.grpc.v1.cri\"..." type=io.containerd.grpc.v1 Oct 16 23:36:20.115362 containerd[1645]: time="2026-10-16T23:36:20.114675720Z" 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}" Oct 16 23:36:20.115362 containerd[1645]: time="2026-10-16T23:36:20.114747480Z" level=info msg="Connect containerd service" Oct 16 23:36:20.115362 containerd[1645]: time="2026-10-16T23:36:20.114789720Z" level=info msg="using legacy CRI server" Oct 16 23:36:20.115362 containerd[1645]: time="2026-10-16T23:36:20.114796440Z" level=info msg="using experimental NRI integration - disable nri plugin to prevent this" Oct 16 23:36:20.115362 containerd[1645]: time="2026-10-16T23:36:20.114881840Z" level=info msg="Get image filesystem path \"/var/lib/containerd/io.containerd.snapshotter.v1.overlayfs\"" Oct 16 23:36:20.115954 containerd[1645]: time="2026-10-16T23:36:20.115930800Z" 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" Oct 16 23:36:20.116163 containerd[1645]: time="2026-10-16T23:36:20.116129720Z" level=info msg="Start subscribing containerd event" Oct 16 23:36:20.116241 containerd[1645]: time="2026-10-16T23:36:20.116228320Z" level=info msg="Start recovering state" Oct 16 23:36:20.116358 containerd[1645]: time="2026-10-16T23:36:20.116345520Z" level=info msg="Start event monitor" Oct 16 23:36:20.116408 containerd[1645]: time="2026-10-16T23:36:20.116397480Z" level=info msg="Start snapshots syncer" Oct 16 23:36:20.116454 containerd[1645]: time="2026-10-16T23:36:20.116443320Z" level=info msg="Start cni network conf syncer for default" Oct 16 23:36:20.116499 containerd[1645]: time="2026-10-16T23:36:20.116488640Z" level=info msg="Start streaming server" Oct 16 23:36:20.117000 containerd[1645]: time="2026-10-16T23:36:20.116981520Z" level=info msg=serving... address=/run/containerd/containerd.sock.ttrpc Oct 16 23:36:20.117103 containerd[1645]: time="2026-10-16T23:36:20.117091720Z" level=info msg=serving... address=/run/containerd/containerd.sock Oct 16 23:36:20.117351 systemd[1]: Started containerd.service - containerd container runtime. Oct 16 23:36:20.123231 containerd[1645]: time="2026-10-16T23:36:20.117246560Z" level=info msg="containerd successfully booted in 0.048755s" Oct 16 23:36:20.508535 sshd_keygen[1626]: ssh-keygen: generating new host keys: RSA ECDSA ED25519 Oct 16 23:36:20.526141 systemd[1]: Finished sshd-keygen.service - Generate sshd host keys. Oct 16 23:36:20.538917 systemd[1]: Starting issuegen.service - Generate /run/issue... Oct 16 23:36:20.543882 systemd[1]: Starting waagent.service - Microsoft Azure Linux Agent... Oct 16 23:36:20.548389 systemd[1]: issuegen.service: Deactivated successfully. Oct 16 23:36:20.549718 systemd[1]: Finished issuegen.service - Generate /run/issue. Oct 16 23:36:20.556955 systemd[1]: Starting systemd-user-sessions.service - Permit User Sessions... Oct 16 23:36:20.572866 systemd[1]: Started waagent.service - Microsoft Azure Linux Agent. Oct 16 23:36:20.579153 systemd[1]: Finished systemd-user-sessions.service - Permit User Sessions. Oct 16 23:36:20.587999 systemd[1]: Started getty@tty1.service - Getty on tty1. Oct 16 23:36:20.595855 systemd[1]: Started serial-getty@ttyAMA0.service - Serial Getty on ttyAMA0. Oct 16 23:36:20.601032 systemd[1]: Reached target getty.target - Login Prompts. Oct 16 23:36:20.605243 systemd[1]: Reached target multi-user.target - Multi-User System. Oct 16 23:36:20.609751 systemd[1]: Startup finished in 635ms (kernel) + 9.676s (initrd) + 9.110s (userspace) = 19.423s. Oct 16 23:36:20.894954 login[1746]: pam_lastlog(login:session): file /var/log/lastlog is locked/write, retrying Oct 16 23:36:20.896923 login[1747]: pam_unix(login:session): session opened for user core(uid=500) by core(uid=0) Oct 16 23:36:20.904797 systemd[1]: Created slice user-500.slice - User Slice of UID 500. Oct 16 23:36:20.910893 systemd[1]: Starting user-runtime-dir@500.service - User Runtime Directory /run/user/500... Oct 16 23:36:20.914292 systemd-logind[1622]: New session 2 of user core. Oct 16 23:36:20.930921 systemd[1]: Finished user-runtime-dir@500.service - User Runtime Directory /run/user/500. Oct 16 23:36:20.938941 systemd[1]: Starting user@500.service - User Manager for UID 500... Oct 16 23:36:20.950581 (systemd)[1754]: pam_unix(systemd-user:session): session opened for user core(uid=500) by (uid=0) Oct 16 23:36:21.090262 systemd[1754]: Queued start job for default target default.target. Oct 16 23:36:21.097575 systemd[1754]: Created slice app.slice - User Application Slice. Oct 16 23:36:21.098086 systemd[1754]: Reached target paths.target - Paths. Oct 16 23:36:21.098168 systemd[1754]: Reached target timers.target - Timers. Oct 16 23:36:21.100840 systemd[1754]: Starting dbus.socket - D-Bus User Message Bus Socket... Oct 16 23:36:21.110749 systemd[1754]: Listening on dbus.socket - D-Bus User Message Bus Socket. Oct 16 23:36:21.110815 systemd[1754]: Reached target sockets.target - Sockets. Oct 16 23:36:21.110827 systemd[1754]: Reached target basic.target - Basic System. Oct 16 23:36:21.110861 systemd[1754]: Reached target default.target - Main User Target. Oct 16 23:36:21.110886 systemd[1754]: Startup finished in 154ms. Oct 16 23:36:21.111157 systemd[1]: Started user@500.service - User Manager for UID 500. Oct 16 23:36:21.117859 systemd[1]: Started session-2.scope - Session 2 of User core. Oct 16 23:36:21.895419 login[1746]: pam_unix(login:session): session opened for user core(uid=500) by core(uid=0) Oct 16 23:36:21.901835 systemd-logind[1622]: New session 1 of user core. Oct 16 23:36:21.903811 systemd[1]: Started session-1.scope - Session 1 of User core. Oct 16 23:36:21.959972 waagent[1743]: 2026-10-16T23:36:21.959864Z INFO Daemon Daemon Azure Linux Agent Version: 2.9.1.1 Oct 16 23:36:21.964453 waagent[1743]: 2026-10-16T23:36:21.964382Z INFO Daemon Daemon OS: flatcar 4081.3.10 Oct 16 23:36:21.968114 waagent[1743]: 2026-10-16T23:36:21.968060Z INFO Daemon Daemon Python: 3.11.9 Oct 16 23:36:21.972175 waagent[1743]: 2026-10-16T23:36:21.971966Z INFO Daemon Daemon Run daemon Oct 16 23:36:21.975522 waagent[1743]: 2026-10-16T23:36:21.975471Z INFO Daemon Daemon No RDMA handler exists for distro='Flatcar Container Linux by Kinvolk' version='4081.3.10' Oct 16 23:36:21.983393 waagent[1743]: 2026-10-16T23:36:21.983336Z INFO Daemon Daemon Using waagent for provisioning Oct 16 23:36:21.988010 waagent[1743]: 2026-10-16T23:36:21.987967Z INFO Daemon Daemon Activate resource disk Oct 16 23:36:21.991930 waagent[1743]: 2026-10-16T23:36:21.991881Z INFO Daemon Daemon Searching gen1 prefix 00000000-0001 or gen2 f8b3781a-1e82-4818-a1c3-63d806ec15bb Oct 16 23:36:22.001140 waagent[1743]: 2026-10-16T23:36:22.001080Z INFO Daemon Daemon Found device: None Oct 16 23:36:22.004714 waagent[1743]: 2026-10-16T23:36:22.004661Z ERROR Daemon Daemon Failed to mount resource disk [ResourceDiskError] unable to detect disk topology Oct 16 23:36:22.011439 waagent[1743]: 2026-10-16T23:36:22.011379Z ERROR Daemon Daemon Event: name=WALinuxAgent, op=ActivateResourceDisk, message=[ResourceDiskError] unable to detect disk topology, duration=0 Oct 16 23:36:22.021603 waagent[1743]: 2026-10-16T23:36:22.021547Z INFO Daemon Daemon Clean protocol and wireserver endpoint Oct 16 23:36:22.026053 waagent[1743]: 2026-10-16T23:36:22.026005Z INFO Daemon Daemon Running default provisioning handler Oct 16 23:36:22.036184 waagent[1743]: 2026-10-16T23:36:22.036111Z 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. Oct 16 23:36:22.046586 waagent[1743]: 2026-10-16T23:36:22.046526Z INFO Daemon Daemon Unable to get cloud-init enabled status from service: [Errno 2] No such file or directory: 'service' Oct 16 23:36:22.054055 waagent[1743]: 2026-10-16T23:36:22.054005Z INFO Daemon Daemon cloud-init is enabled: False Oct 16 23:36:22.057770 waagent[1743]: 2026-10-16T23:36:22.057728Z INFO Daemon Daemon Copying ovf-env.xml Oct 16 23:36:22.129721 waagent[1743]: 2026-10-16T23:36:22.128779Z INFO Daemon Daemon Successfully mounted dvd Oct 16 23:36:22.142132 systemd[1]: mnt-cdrom-secure.mount: Deactivated successfully. Oct 16 23:36:22.143836 waagent[1743]: 2026-10-16T23:36:22.143771Z INFO Daemon Daemon Detect protocol endpoint Oct 16 23:36:22.147805 waagent[1743]: 2026-10-16T23:36:22.147705Z INFO Daemon Daemon Clean protocol and wireserver endpoint Oct 16 23:36:22.152369 waagent[1743]: 2026-10-16T23:36:22.152307Z INFO Daemon Daemon WireServer endpoint is not found. Rerun dhcp handler Oct 16 23:36:22.157841 waagent[1743]: 2026-10-16T23:36:22.157776Z INFO Daemon Daemon Test for route to 168.63.129.16 Oct 16 23:36:22.162051 waagent[1743]: 2026-10-16T23:36:22.161991Z INFO Daemon Daemon Route to 168.63.129.16 exists Oct 16 23:36:22.166701 waagent[1743]: 2026-10-16T23:36:22.166059Z INFO Daemon Daemon Wire server endpoint:168.63.129.16 Oct 16 23:36:22.239507 waagent[1743]: 2026-10-16T23:36:22.239461Z INFO Daemon Daemon Fabric preferred wire protocol version:2015-04-05 Oct 16 23:36:22.244691 waagent[1743]: 2026-10-16T23:36:22.244663Z INFO Daemon Daemon Wire protocol version:2012-11-30 Oct 16 23:36:22.249125 waagent[1743]: 2026-10-16T23:36:22.249083Z INFO Daemon Daemon Server preferred version:2015-04-05 Oct 16 23:36:22.415756 waagent[1743]: 2026-10-16T23:36:22.411747Z INFO Daemon Daemon Initializing goal state during protocol detection Oct 16 23:36:22.416848 waagent[1743]: 2026-10-16T23:36:22.416787Z INFO Daemon Daemon Forcing an update of the goal state. Oct 16 23:36:22.424023 waagent[1743]: 2026-10-16T23:36:22.423979Z INFO Daemon Fetched a new incarnation for the WireServer goal state [incarnation 1] Oct 16 23:36:22.439452 waagent[1743]: 2026-10-16T23:36:22.439406Z INFO Daemon Daemon HostGAPlugin version: 1.0.8.189 Oct 16 23:36:22.444583 waagent[1743]: 2026-10-16T23:36:22.444538Z INFO Daemon Oct 16 23:36:22.446896 waagent[1743]: 2026-10-16T23:36:22.446858Z INFO Daemon Fetched new vmSettings [HostGAPlugin correlation ID: 2a7735cd-fbd3-4476-8707-a2a0620cad9a eTag: 17440654630840153197 source: Fabric] Oct 16 23:36:22.456072 waagent[1743]: 2026-10-16T23:36:22.456030Z INFO Daemon The vmSettings originated via Fabric; will ignore them. Oct 16 23:36:22.461930 waagent[1743]: 2026-10-16T23:36:22.461887Z INFO Daemon Oct 16 23:36:22.464187 waagent[1743]: 2026-10-16T23:36:22.464147Z INFO Daemon Fetching full goal state from the WireServer [incarnation 1] Oct 16 23:36:22.472321 waagent[1743]: 2026-10-16T23:36:22.472290Z INFO Daemon Daemon Downloading artifacts profile blob Oct 16 23:36:22.554033 waagent[1743]: 2026-10-16T23:36:22.553946Z INFO Daemon Downloaded certificate {'thumbprint': 'A4AEE7E6F0825A2E4397C04A6050B608D94D583E', 'hasPrivateKey': True} Oct 16 23:36:22.561739 waagent[1743]: 2026-10-16T23:36:22.561678Z INFO Daemon Fetch goal state completed Oct 16 23:36:22.570960 waagent[1743]: 2026-10-16T23:36:22.570902Z INFO Daemon Daemon Starting provisioning Oct 16 23:36:22.574721 waagent[1743]: 2026-10-16T23:36:22.574660Z INFO Daemon Daemon Handle ovf-env.xml. Oct 16 23:36:22.578266 waagent[1743]: 2026-10-16T23:36:22.578216Z INFO Daemon Daemon Set hostname [ci-4081.3.10--e3223b72ee] Oct 16 23:36:22.584519 waagent[1743]: 2026-10-16T23:36:22.584462Z INFO Daemon Daemon Publish hostname [ci-4081.3.10--e3223b72ee] Oct 16 23:36:22.589826 waagent[1743]: 2026-10-16T23:36:22.589768Z INFO Daemon Daemon Examine /proc/net/route for primary interface Oct 16 23:36:22.594592 waagent[1743]: 2026-10-16T23:36:22.594545Z INFO Daemon Daemon Primary interface is [eth0] Oct 16 23:36:22.616294 systemd-networkd[1375]: eth0: found matching network '/usr/lib/systemd/network/zz-default.network', based on potentially unpredictable interface name. Oct 16 23:36:22.616304 systemd-networkd[1375]: eth0: Configuring with /usr/lib/systemd/network/zz-default.network. Oct 16 23:36:22.616333 systemd-networkd[1375]: eth0: DHCP lease lost Oct 16 23:36:22.617634 waagent[1743]: 2026-10-16T23:36:22.617555Z INFO Daemon Daemon Create user account if not exists Oct 16 23:36:22.621822 systemd-networkd[1375]: eth0: DHCPv6 lease lost Oct 16 23:36:22.622314 waagent[1743]: 2026-10-16T23:36:22.622256Z INFO Daemon Daemon User core already exists, skip useradd Oct 16 23:36:22.626895 waagent[1743]: 2026-10-16T23:36:22.626841Z INFO Daemon Daemon Configure sudoer Oct 16 23:36:22.633088 waagent[1743]: 2026-10-16T23:36:22.633032Z INFO Daemon Daemon Configure sshd Oct 16 23:36:22.642704 waagent[1743]: 2026-10-16T23:36:22.637181Z INFO Daemon Daemon Added a configuration snippet disabling SSH password-based authentication methods. It also configures SSH client probing to keep connections alive. Oct 16 23:36:22.646920 waagent[1743]: 2026-10-16T23:36:22.646859Z INFO Daemon Daemon Deploy ssh public key. Oct 16 23:36:22.656752 systemd-networkd[1375]: eth0: DHCPv4 address 10.0.0.5/24, gateway 10.0.0.1 acquired from 168.63.129.16 Oct 16 23:36:23.715963 waagent[1743]: 2026-10-16T23:36:23.715907Z INFO Daemon Daemon Provisioning complete Oct 16 23:36:23.727163 waagent[1743]: 2026-10-16T23:36:23.727118Z INFO Daemon Daemon RDMA capabilities are not enabled, skipping Oct 16 23:36:23.732052 waagent[1743]: 2026-10-16T23:36:23.731997Z INFO Daemon Daemon End of log to /dev/console. The agent will now check for updates and then will process extensions. Oct 16 23:36:23.739140 waagent[1743]: 2026-10-16T23:36:23.739098Z INFO Daemon Daemon Installed Agent WALinuxAgent-2.9.1.1 is the most current agent Oct 16 23:36:23.868717 waagent[1803]: 2026-10-16T23:36:23.868043Z INFO ExtHandler ExtHandler Azure Linux Agent (Goal State Agent version 2.9.1.1) Oct 16 23:36:23.868717 waagent[1803]: 2026-10-16T23:36:23.868215Z INFO ExtHandler ExtHandler OS: flatcar 4081.3.10 Oct 16 23:36:23.868717 waagent[1803]: 2026-10-16T23:36:23.868293Z INFO ExtHandler ExtHandler Python: 3.11.9 Oct 16 23:36:23.895631 waagent[1803]: 2026-10-16T23:36:23.895541Z INFO ExtHandler ExtHandler Distro: flatcar-4081.3.10; OSUtil: FlatcarUtil; AgentService: waagent; Python: 3.11.9; systemd: True; LISDrivers: Absent; logrotate: logrotate 3.20.1; Oct 16 23:36:23.895840 waagent[1803]: 2026-10-16T23:36:23.895803Z INFO ExtHandler ExtHandler WireServer endpoint 168.63.129.16 read from file Oct 16 23:36:23.895907 waagent[1803]: 2026-10-16T23:36:23.895879Z INFO ExtHandler ExtHandler Wire server endpoint:168.63.129.16 Oct 16 23:36:23.903118 waagent[1803]: 2026-10-16T23:36:23.903059Z INFO ExtHandler Fetched a new incarnation for the WireServer goal state [incarnation 1] Oct 16 23:36:23.907764 waagent[1803]: 2026-10-16T23:36:23.907727Z INFO ExtHandler ExtHandler HostGAPlugin version: 1.0.8.189 Oct 16 23:36:23.908245 waagent[1803]: 2026-10-16T23:36:23.908205Z INFO ExtHandler Oct 16 23:36:23.908314 waagent[1803]: 2026-10-16T23:36:23.908288Z INFO ExtHandler Fetched new vmSettings [HostGAPlugin correlation ID: 838ad751-8e87-4e2e-9bfc-b9a589684b19 eTag: 17440654630840153197 source: Fabric] Oct 16 23:36:23.908617 waagent[1803]: 2026-10-16T23:36:23.908578Z INFO ExtHandler The vmSettings originated via Fabric; will ignore them. Oct 16 23:36:23.911202 waagent[1803]: 2026-10-16T23:36:23.911156Z INFO ExtHandler Oct 16 23:36:23.911273 waagent[1803]: 2026-10-16T23:36:23.911246Z INFO ExtHandler Fetching full goal state from the WireServer [incarnation 1] Oct 16 23:36:23.913926 waagent[1803]: 2026-10-16T23:36:23.913898Z INFO ExtHandler ExtHandler Downloading artifacts profile blob Oct 16 23:36:23.985711 waagent[1803]: 2026-10-16T23:36:23.985559Z INFO ExtHandler Downloaded certificate {'thumbprint': 'A4AEE7E6F0825A2E4397C04A6050B608D94D583E', 'hasPrivateKey': True} Oct 16 23:36:23.986214 waagent[1803]: 2026-10-16T23:36:23.986169Z INFO ExtHandler Fetch goal state completed Oct 16 23:36:23.995979 waagent[1803]: 2026-10-16T23:36:23.995928Z INFO ExtHandler ExtHandler WALinuxAgent-2.9.1.1 running as process 1803 Oct 16 23:36:23.996138 waagent[1803]: 2026-10-16T23:36:23.996104Z INFO ExtHandler ExtHandler ******** AutoUpdate.Enabled is set to False, not processing the operation ******** Oct 16 23:36:23.997852 waagent[1803]: 2026-10-16T23:36:23.997814Z INFO ExtHandler ExtHandler Cgroup monitoring is not supported on ['flatcar', '4081.3.10', '', 'Flatcar Container Linux by Kinvolk'] Oct 16 23:36:23.998212 waagent[1803]: 2026-10-16T23:36:23.998178Z INFO ExtHandler ExtHandler Starting setup for Persistent firewall rules Oct 16 23:36:24.009795 waagent[1803]: 2026-10-16T23:36:24.009749Z INFO ExtHandler ExtHandler Firewalld service not running/unavailable, trying to set up waagent-network-setup.service Oct 16 23:36:24.010010 waagent[1803]: 2026-10-16T23:36:24.009972Z INFO ExtHandler ExtHandler Successfully updated the Binary file /var/lib/waagent/waagent-network-setup.py for firewall setup Oct 16 23:36:24.015767 waagent[1803]: 2026-10-16T23:36:24.015723Z INFO ExtHandler ExtHandler Service: waagent-network-setup.service not enabled. Adding it now Oct 16 23:36:24.022158 systemd[1]: Reloading requested from client PID 1816 ('systemctl') (unit waagent.service)... Oct 16 23:36:24.022173 systemd[1]: Reloading... Oct 16 23:36:24.113714 zram_generator::config[1857]: No configuration found. Oct 16 23:36:24.204914 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. Oct 16 23:36:24.284548 systemd[1]: Reloading finished in 262 ms. Oct 16 23:36:24.307650 waagent[1803]: 2026-10-16T23:36:24.306208Z INFO ExtHandler ExtHandler Executing systemctl daemon-reload for setting up waagent-network-setup.service Oct 16 23:36:24.312547 systemd[1]: Reloading requested from client PID 1904 ('systemctl') (unit waagent.service)... Oct 16 23:36:24.312681 systemd[1]: Reloading... Oct 16 23:36:24.397713 zram_generator::config[1941]: No configuration found. Oct 16 23:36:24.501608 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. Oct 16 23:36:24.575703 systemd[1]: Reloading finished in 262 ms. Oct 16 23:36:24.598733 waagent[1803]: 2026-10-16T23:36:24.595870Z INFO ExtHandler ExtHandler Successfully added and enabled the waagent-network-setup.service Oct 16 23:36:24.598733 waagent[1803]: 2026-10-16T23:36:24.596040Z INFO ExtHandler ExtHandler Persistent firewall rules setup successfully Oct 16 23:36:24.844435 waagent[1803]: 2026-10-16T23:36:24.844294Z INFO ExtHandler ExtHandler DROP rule is not available which implies no firewall rules are set yet. Environment thread will set it up. Oct 16 23:36:24.844952 waagent[1803]: 2026-10-16T23:36:24.844908Z 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] Oct 16 23:36:24.845724 waagent[1803]: 2026-10-16T23:36:24.845654Z INFO ExtHandler ExtHandler Starting env monitor service. Oct 16 23:36:24.846037 waagent[1803]: 2026-10-16T23:36:24.845807Z INFO MonitorHandler ExtHandler WireServer endpoint 168.63.129.16 read from file Oct 16 23:36:24.846221 waagent[1803]: 2026-10-16T23:36:24.846168Z INFO ExtHandler ExtHandler Start SendTelemetryHandler service. Oct 16 23:36:24.846300 waagent[1803]: 2026-10-16T23:36:24.846268Z INFO MonitorHandler ExtHandler Wire server endpoint:168.63.129.16 Oct 16 23:36:24.846629 waagent[1803]: 2026-10-16T23:36:24.846575Z INFO MonitorHandler ExtHandler Monitor.NetworkConfigurationChanges is disabled. Oct 16 23:36:24.846981 waagent[1803]: 2026-10-16T23:36:24.846931Z INFO SendTelemetryHandler ExtHandler Successfully started the SendTelemetryHandler thread Oct 16 23:36:24.847271 waagent[1803]: 2026-10-16T23:36:24.847224Z INFO MonitorHandler ExtHandler Routing table from /proc/net/route: Oct 16 23:36:24.847271 waagent[1803]: Iface Destination Gateway Flags RefCnt Use Metric Mask MTU Window IRTT Oct 16 23:36:24.847271 waagent[1803]: eth0 00000000 0100000A 0003 0 0 1024 00000000 0 0 0 Oct 16 23:36:24.847271 waagent[1803]: eth0 0000000A 00000000 0001 0 0 1024 00FFFFFF 0 0 0 Oct 16 23:36:24.847271 waagent[1803]: eth0 0100000A 00000000 0005 0 0 1024 FFFFFFFF 0 0 0 Oct 16 23:36:24.847271 waagent[1803]: eth0 10813FA8 0100000A 0007 0 0 1024 FFFFFFFF 0 0 0 Oct 16 23:36:24.847271 waagent[1803]: eth0 FEA9FEA9 0100000A 0007 0 0 1024 FFFFFFFF 0 0 0 Oct 16 23:36:24.847867 waagent[1803]: 2026-10-16T23:36:24.847828Z INFO EnvHandler ExtHandler WireServer endpoint 168.63.129.16 read from file Oct 16 23:36:24.847942 waagent[1803]: 2026-10-16T23:36:24.847911Z INFO EnvHandler ExtHandler Wire server endpoint:168.63.129.16 Oct 16 23:36:24.848150 waagent[1803]: 2026-10-16T23:36:24.848052Z INFO EnvHandler ExtHandler Configure routes Oct 16 23:36:24.848150 waagent[1803]: 2026-10-16T23:36:24.848125Z INFO EnvHandler ExtHandler Gateway:None Oct 16 23:36:24.848206 waagent[1803]: 2026-10-16T23:36:24.848174Z INFO EnvHandler ExtHandler Routes:None Oct 16 23:36:24.848479 waagent[1803]: 2026-10-16T23:36:24.847719Z INFO ExtHandler ExtHandler Start Extension Telemetry service. Oct 16 23:36:24.848780 waagent[1803]: 2026-10-16T23:36:24.848720Z INFO TelemetryEventsCollector ExtHandler Extension Telemetry pipeline enabled: True Oct 16 23:36:24.848830 waagent[1803]: 2026-10-16T23:36:24.848777Z INFO ExtHandler ExtHandler Goal State Period: 6 sec. This indicates how often the agent checks for new goal states and reports status. Oct 16 23:36:24.848997 waagent[1803]: 2026-10-16T23:36:24.848943Z INFO TelemetryEventsCollector ExtHandler Successfully started the TelemetryEventsCollector thread Oct 16 23:36:24.853532 waagent[1803]: 2026-10-16T23:36:24.853461Z INFO ExtHandler ExtHandler Oct 16 23:36:24.853704 waagent[1803]: 2026-10-16T23:36:24.853580Z INFO ExtHandler ExtHandler ProcessExtensionsGoalState started [incarnation_1 channel: WireServer source: Fabric activity: 52a0e12c-d10a-4bd5-9eb9-4562346abb3e correlation 82d197ee-2d33-4b92-a7f4-bb34bf6c35e1 created: 2026-10-16T23:35:37.780266Z] Oct 16 23:36:24.854981 waagent[1803]: 2026-10-16T23:36:24.854930Z INFO ExtHandler ExtHandler No extension handlers found, not processing anything. Oct 16 23:36:24.856302 waagent[1803]: 2026-10-16T23:36:24.856257Z INFO ExtHandler ExtHandler ProcessExtensionsGoalState completed [incarnation_1 2 ms] Oct 16 23:36:24.895489 waagent[1803]: 2026-10-16T23:36:24.895425Z INFO ExtHandler ExtHandler [HEARTBEAT] Agent WALinuxAgent-2.9.1.1 is running as the goal state agent [DEBUG HeartbeatCounter: 0;HeartbeatId: 2F6713D1-6C72-43F7-9BB4-83E92265E92F;DroppedPackets: 0;UpdateGSErrors: 0;AutoUpdate: 0] Oct 16 23:36:24.902153 waagent[1803]: 2026-10-16T23:36:24.902079Z INFO MonitorHandler ExtHandler Network interfaces: Oct 16 23:36:24.902153 waagent[1803]: Executing ['ip', '-a', '-o', 'link']: Oct 16 23:36:24.902153 waagent[1803]: 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 Oct 16 23:36:24.902153 waagent[1803]: 2: eth0: mtu 1500 qdisc mq state UP mode DEFAULT group default qlen 1000\ link/ether 7c:ed:8d:d4:cc:46 brd ff:ff:ff:ff:ff:ff Oct 16 23:36:24.902153 waagent[1803]: 3: enP57398s1: mtu 1500 qdisc mq master eth0 state UP mode DEFAULT group default qlen 1000\ link/ether 7c:ed:8d:d4:cc:46 brd ff:ff:ff:ff:ff:ff\ altname enP57398p0s2 Oct 16 23:36:24.902153 waagent[1803]: Executing ['ip', '-4', '-a', '-o', 'address']: Oct 16 23:36:24.902153 waagent[1803]: 1: lo inet 127.0.0.1/8 scope host lo\ valid_lft forever preferred_lft forever Oct 16 23:36:24.902153 waagent[1803]: 2: eth0 inet 10.0.0.5/24 metric 1024 brd 10.0.0.255 scope global eth0\ valid_lft forever preferred_lft forever Oct 16 23:36:24.902153 waagent[1803]: Executing ['ip', '-6', '-a', '-o', 'address']: Oct 16 23:36:24.902153 waagent[1803]: 1: lo inet6 ::1/128 scope host noprefixroute \ valid_lft forever preferred_lft forever Oct 16 23:36:24.902153 waagent[1803]: 2: eth0 inet6 fe80::7eed:8dff:fed4:cc46/64 scope link proto kernel_ll \ valid_lft forever preferred_lft forever Oct 16 23:36:24.931046 waagent[1803]: 2026-10-16T23:36:24.930986Z INFO EnvHandler ExtHandler Successfully added Azure fabric firewall rules. Current Firewall rules: Oct 16 23:36:24.931046 waagent[1803]: Chain INPUT (policy ACCEPT 0 packets, 0 bytes) Oct 16 23:36:24.931046 waagent[1803]: pkts bytes target prot opt in out source destination Oct 16 23:36:24.931046 waagent[1803]: Chain FORWARD (policy ACCEPT 0 packets, 0 bytes) Oct 16 23:36:24.931046 waagent[1803]: pkts bytes target prot opt in out source destination Oct 16 23:36:24.931046 waagent[1803]: Chain OUTPUT (policy ACCEPT 0 packets, 0 bytes) Oct 16 23:36:24.931046 waagent[1803]: pkts bytes target prot opt in out source destination Oct 16 23:36:24.931046 waagent[1803]: 0 0 ACCEPT tcp -- * * 0.0.0.0/0 168.63.129.16 tcp dpt:53 Oct 16 23:36:24.931046 waagent[1803]: 1 52 ACCEPT tcp -- * * 0.0.0.0/0 168.63.129.16 owner UID match 0 Oct 16 23:36:24.931046 waagent[1803]: 0 0 DROP tcp -- * * 0.0.0.0/0 168.63.129.16 ctstate INVALID,NEW Oct 16 23:36:24.933866 waagent[1803]: 2026-10-16T23:36:24.933809Z INFO EnvHandler ExtHandler Current Firewall rules: Oct 16 23:36:24.933866 waagent[1803]: Chain INPUT (policy ACCEPT 0 packets, 0 bytes) Oct 16 23:36:24.933866 waagent[1803]: pkts bytes target prot opt in out source destination Oct 16 23:36:24.933866 waagent[1803]: Chain FORWARD (policy ACCEPT 0 packets, 0 bytes) Oct 16 23:36:24.933866 waagent[1803]: pkts bytes target prot opt in out source destination Oct 16 23:36:24.933866 waagent[1803]: Chain OUTPUT (policy ACCEPT 0 packets, 0 bytes) Oct 16 23:36:24.933866 waagent[1803]: pkts bytes target prot opt in out source destination Oct 16 23:36:24.933866 waagent[1803]: 0 0 ACCEPT tcp -- * * 0.0.0.0/0 168.63.129.16 tcp dpt:53 Oct 16 23:36:24.933866 waagent[1803]: 1 52 ACCEPT tcp -- * * 0.0.0.0/0 168.63.129.16 owner UID match 0 Oct 16 23:36:24.933866 waagent[1803]: 0 0 DROP tcp -- * * 0.0.0.0/0 168.63.129.16 ctstate INVALID,NEW Oct 16 23:36:24.934133 waagent[1803]: 2026-10-16T23:36:24.934100Z INFO EnvHandler ExtHandler Set block dev timeout: sda with timeout: 300 Oct 16 23:36:42.956356 chronyd[1607]: Selected source PHC0 Oct 16 23:36:44.187662 systemd[1]: Created slice system-sshd.slice - Slice /system/sshd. Oct 16 23:36:44.188809 systemd[1]: Started sshd@0-10.0.0.5:22-181.45.133.60:2451.service - OpenSSH per-connection server daemon (181.45.133.60:2451). Oct 16 23:36:44.262129 sshd[2024]: Connection closed by 181.45.133.60 port 2451 Oct 16 23:36:44.262707 systemd[1]: sshd@0-10.0.0.5:22-181.45.133.60:2451.service: Deactivated successfully. Oct 16 23:36:55.423593 systemd[1]: Started sshd@1-10.0.0.5:22-98.64.94.113:50514.service - OpenSSH per-connection server daemon (98.64.94.113:50514). Oct 16 23:36:56.263707 sshd[2028]: Accepted publickey for core from 98.64.94.113 port 50514 ssh2: RSA SHA256:9ZVNdNqfR1p2jlahct7rtguJdifXDBsYNAu9iiomQp8 Oct 16 23:36:56.265068 sshd[2028]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Oct 16 23:36:56.268741 systemd-logind[1622]: New session 3 of user core. Oct 16 23:36:56.272871 systemd[1]: Started session-3.scope - Session 3 of User core. Oct 16 23:36:57.005742 systemd[1]: Started sshd@2-10.0.0.5:22-98.64.94.113:50526.service - OpenSSH per-connection server daemon (98.64.94.113:50526). Oct 16 23:36:57.843205 sshd[2033]: Accepted publickey for core from 98.64.94.113 port 50526 ssh2: RSA SHA256:9ZVNdNqfR1p2jlahct7rtguJdifXDBsYNAu9iiomQp8 Oct 16 23:36:57.844518 sshd[2033]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Oct 16 23:36:57.848493 systemd-logind[1622]: New session 4 of user core. Oct 16 23:36:57.854866 systemd[1]: Started session-4.scope - Session 4 of User core. Oct 16 23:36:58.439941 sshd[2033]: pam_unix(sshd:session): session closed for user core Oct 16 23:36:58.442493 systemd[1]: sshd@2-10.0.0.5:22-98.64.94.113:50526.service: Deactivated successfully. Oct 16 23:36:58.444366 systemd[1]: session-4.scope: Deactivated successfully. Oct 16 23:36:58.446119 systemd-logind[1622]: Session 4 logged out. Waiting for processes to exit. Oct 16 23:36:58.446874 systemd-logind[1622]: Removed session 4. Oct 16 23:36:58.588019 systemd[1]: Started sshd@3-10.0.0.5:22-98.64.94.113:50536.service - OpenSSH per-connection server daemon (98.64.94.113:50536). Oct 16 23:36:59.427710 sshd[2040]: Accepted publickey for core from 98.64.94.113 port 50536 ssh2: RSA SHA256:9ZVNdNqfR1p2jlahct7rtguJdifXDBsYNAu9iiomQp8 Oct 16 23:36:59.429046 sshd[2040]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Oct 16 23:36:59.432825 systemd-logind[1622]: New session 5 of user core. Oct 16 23:36:59.443903 systemd[1]: Started session-5.scope - Session 5 of User core. Oct 16 23:37:00.025629 sshd[2040]: pam_unix(sshd:session): session closed for user core Oct 16 23:37:00.030117 systemd[1]: sshd@3-10.0.0.5:22-98.64.94.113:50536.service: Deactivated successfully. Oct 16 23:37:00.032465 systemd[1]: session-5.scope: Deactivated successfully. Oct 16 23:37:00.033502 systemd-logind[1622]: Session 5 logged out. Waiting for processes to exit. Oct 16 23:37:00.034618 systemd-logind[1622]: Removed session 5. Oct 16 23:37:00.172510 systemd[1]: Started sshd@4-10.0.0.5:22-98.64.94.113:52342.service - OpenSSH per-connection server daemon (98.64.94.113:52342). Oct 16 23:37:01.014713 sshd[2047]: Accepted publickey for core from 98.64.94.113 port 52342 ssh2: RSA SHA256:9ZVNdNqfR1p2jlahct7rtguJdifXDBsYNAu9iiomQp8 Oct 16 23:37:01.015642 sshd[2047]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Oct 16 23:37:01.019443 systemd-logind[1622]: New session 6 of user core. Oct 16 23:37:01.029836 systemd[1]: Started session-6.scope - Session 6 of User core. Oct 16 23:37:01.608579 sshd[2047]: pam_unix(sshd:session): session closed for user core Oct 16 23:37:01.611487 systemd[1]: sshd@4-10.0.0.5:22-98.64.94.113:52342.service: Deactivated successfully. Oct 16 23:37:01.613251 systemd[1]: session-6.scope: Deactivated successfully. Oct 16 23:37:01.614879 systemd-logind[1622]: Session 6 logged out. Waiting for processes to exit. Oct 16 23:37:01.615975 systemd-logind[1622]: Removed session 6. Oct 16 23:37:01.758461 systemd[1]: Started sshd@5-10.0.0.5:22-98.64.94.113:52358.service - OpenSSH per-connection server daemon (98.64.94.113:52358). Oct 16 23:37:02.629707 sshd[2054]: Accepted publickey for core from 98.64.94.113 port 52358 ssh2: RSA SHA256:9ZVNdNqfR1p2jlahct7rtguJdifXDBsYNAu9iiomQp8 Oct 16 23:37:02.631080 sshd[2054]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Oct 16 23:37:02.634754 systemd-logind[1622]: New session 7 of user core. Oct 16 23:37:02.641841 systemd[1]: Started session-7.scope - Session 7 of User core. Oct 16 23:37:03.202728 sudo[2057]: core : PWD=/home/core ; USER=root ; COMMAND=/usr/sbin/setenforce 1 Oct 16 23:37:03.203017 sudo[2057]: pam_unix(sudo:session): session opened for user root(uid=0) by core(uid=500) Oct 16 23:37:03.214400 sudo[2057]: pam_unix(sudo:session): session closed for user root Oct 16 23:37:03.355155 sshd[2054]: pam_unix(sshd:session): session closed for user core Oct 16 23:37:03.359379 systemd[1]: sshd@5-10.0.0.5:22-98.64.94.113:52358.service: Deactivated successfully. Oct 16 23:37:03.361105 systemd[1]: session-7.scope: Deactivated successfully. Oct 16 23:37:03.363196 systemd-logind[1622]: Session 7 logged out. Waiting for processes to exit. Oct 16 23:37:03.364089 systemd-logind[1622]: Removed session 7. Oct 16 23:37:03.501328 systemd[1]: Started sshd@6-10.0.0.5:22-98.64.94.113:52366.service - OpenSSH per-connection server daemon (98.64.94.113:52366). Oct 16 23:37:03.989770 kernel: hv_balloon: Max. dynamic memory size: 4096 MB Oct 16 23:37:04.188293 update_engine[1627]: I20261016 23:37:04.188223 1627 update_attempter.cc:509] Updating boot flags... Oct 16 23:37:04.276753 kernel: BTRFS warning: duplicate device /dev/sda3 devid 1 generation 33 scanned by (udev-worker) (2076) Oct 16 23:37:04.353612 sshd[2062]: Accepted publickey for core from 98.64.94.113 port 52366 ssh2: RSA SHA256:9ZVNdNqfR1p2jlahct7rtguJdifXDBsYNAu9iiomQp8 Oct 16 23:37:04.356001 sshd[2062]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Oct 16 23:37:04.369181 kernel: BTRFS warning: duplicate device /dev/sda3 devid 1 generation 33 scanned by (udev-worker) (2076) Oct 16 23:37:04.377203 systemd-logind[1622]: New session 8 of user core. Oct 16 23:37:04.383552 systemd[1]: Started session-8.scope - Session 8 of User core. Oct 16 23:37:04.807453 sudo[2132]: 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 Oct 16 23:37:04.808000 sudo[2132]: pam_unix(sudo:session): session opened for user root(uid=0) by core(uid=500) Oct 16 23:37:04.811467 sudo[2132]: pam_unix(sudo:session): session closed for user root Oct 16 23:37:04.816525 sudo[2131]: core : PWD=/home/core ; USER=root ; COMMAND=/usr/bin/systemctl restart audit-rules Oct 16 23:37:04.817187 sudo[2131]: pam_unix(sudo:session): session opened for user root(uid=0) by core(uid=500) Oct 16 23:37:04.829958 systemd[1]: Stopping audit-rules.service - Load Security Auditing Rules... Oct 16 23:37:04.849775 auditctl[2135]: No rules Oct 16 23:37:04.850320 systemd[1]: audit-rules.service: Deactivated successfully. Oct 16 23:37:04.850480 systemd[1]: Stopped audit-rules.service - Load Security Auditing Rules. Oct 16 23:37:04.856099 systemd[1]: Starting audit-rules.service - Load Security Auditing Rules... Oct 16 23:37:04.880006 augenrules[2153]: No rules Oct 16 23:37:04.881516 systemd[1]: Finished audit-rules.service - Load Security Auditing Rules. Oct 16 23:37:04.883292 sudo[2131]: pam_unix(sudo:session): session closed for user root Oct 16 23:37:05.029484 sshd[2062]: pam_unix(sshd:session): session closed for user core Oct 16 23:37:05.032443 systemd-logind[1622]: Session 8 logged out. Waiting for processes to exit. Oct 16 23:37:05.032623 systemd[1]: sshd@6-10.0.0.5:22-98.64.94.113:52366.service: Deactivated successfully. Oct 16 23:37:05.034287 systemd[1]: session-8.scope: Deactivated successfully. Oct 16 23:37:05.036060 systemd-logind[1622]: Removed session 8. Oct 16 23:37:05.178380 systemd[1]: Started sshd@7-10.0.0.5:22-98.64.94.113:52376.service - OpenSSH per-connection server daemon (98.64.94.113:52376). Oct 16 23:37:06.021247 sshd[2161]: Accepted publickey for core from 98.64.94.113 port 52376 ssh2: RSA SHA256:9ZVNdNqfR1p2jlahct7rtguJdifXDBsYNAu9iiomQp8 Oct 16 23:37:06.022576 sshd[2161]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Oct 16 23:37:06.027221 systemd-logind[1622]: New session 9 of user core. Oct 16 23:37:06.035925 systemd[1]: Started session-9.scope - Session 9 of User core. Oct 16 23:37:06.475319 sudo[2164]: core : PWD=/home/core ; USER=root ; COMMAND=/usr/sbin/blkid -s UUID -o value /dev/disk/by-label/ROOT Oct 16 23:37:06.475590 sudo[2164]: pam_unix(sudo:session): session opened for user root(uid=0) by core(uid=500) Oct 16 23:37:06.508882 sudo[2164]: pam_unix(sudo:session): session closed for user root Oct 16 23:37:06.659839 sshd[2161]: pam_unix(sshd:session): session closed for user core Oct 16 23:37:06.663567 systemd[1]: sshd@7-10.0.0.5:22-98.64.94.113:52376.service: Deactivated successfully. Oct 16 23:37:06.665129 systemd[1]: session-9.scope: Deactivated successfully. Oct 16 23:37:06.665734 systemd-logind[1622]: Session 9 logged out. Waiting for processes to exit. Oct 16 23:37:06.666601 systemd-logind[1622]: Removed session 9. Oct 16 23:37:06.808441 systemd[1]: Started sshd@8-10.0.0.5:22-98.64.94.113:52380.service - OpenSSH per-connection server daemon (98.64.94.113:52380). Oct 16 23:37:07.674341 sshd[2169]: Accepted publickey for core from 98.64.94.113 port 52380 ssh2: RSA SHA256:9ZVNdNqfR1p2jlahct7rtguJdifXDBsYNAu9iiomQp8 Oct 16 23:37:07.675709 sshd[2169]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Oct 16 23:37:07.679590 systemd-logind[1622]: New session 10 of user core. Oct 16 23:37:07.688815 systemd[1]: Started session-10.scope - Session 10 of User core. Oct 16 23:37:08.137322 sudo[2172]: core : PWD=/home/core ; USER=root ; COMMAND=/usr/sbin/blkid -s TYPE -o value /dev/disk/by-label/ROOT Oct 16 23:37:08.137586 sudo[2172]: pam_unix(sudo:session): session opened for user root(uid=0) by core(uid=500) Oct 16 23:37:08.141624 sudo[2172]: pam_unix(sudo:session): session closed for user root Oct 16 23:37:08.281721 sshd[2169]: pam_unix(sshd:session): session closed for user core Oct 16 23:37:08.284877 systemd[1]: sshd@8-10.0.0.5:22-98.64.94.113:52380.service: Deactivated successfully. Oct 16 23:37:08.286646 systemd[1]: session-10.scope: Deactivated successfully. Oct 16 23:37:08.287432 systemd-logind[1622]: Session 10 logged out. Waiting for processes to exit. Oct 16 23:37:08.288205 systemd-logind[1622]: Removed session 10. Oct 16 23:37:08.439922 systemd[1]: Started sshd@9-10.0.0.5:22-98.64.94.113:52396.service - OpenSSH per-connection server daemon (98.64.94.113:52396). Oct 16 23:37:09.300712 sshd[2177]: Accepted publickey for core from 98.64.94.113 port 52396 ssh2: RSA SHA256:9ZVNdNqfR1p2jlahct7rtguJdifXDBsYNAu9iiomQp8 Oct 16 23:37:09.301524 sshd[2177]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Oct 16 23:37:09.305735 systemd-logind[1622]: New session 11 of user core. Oct 16 23:37:09.315846 systemd[1]: Started session-11.scope - Session 11 of User core. Oct 16 23:37:09.912935 sshd[2177]: pam_unix(sshd:session): session closed for user core Oct 16 23:37:09.916184 systemd[1]: sshd@9-10.0.0.5:22-98.64.94.113:52396.service: Deactivated successfully. Oct 16 23:37:09.918038 systemd[1]: session-11.scope: Deactivated successfully. Oct 16 23:37:09.918919 systemd-logind[1622]: Session 11 logged out. Waiting for processes to exit. Oct 16 23:37:09.919634 systemd-logind[1622]: Removed session 11.