Jan 29 11:14:41.923363 kernel: Booting Linux on physical CPU 0x0000000000 [0x413fd0c1] Jan 29 11:14:41.923384 kernel: Linux version 6.6.74-flatcar (build@pony-truck.infra.kinvolk.io) (aarch64-cros-linux-gnu-gcc (Gentoo Hardened 13.3.1_p20240614 p1) 13.3.1 20240614, GNU ld (Gentoo 2.42 p6) 2.42.0) #1 SMP PREEMPT Wed Jan 29 09:37:00 -00 2025 Jan 29 11:14:41.923394 kernel: KASLR enabled Jan 29 11:14:41.923400 kernel: efi: EFI v2.7 by EDK II Jan 29 11:14:41.923405 kernel: efi: SMBIOS 3.0=0xdced0000 TPMFinalLog=0xd9760000 MEMATTR=0xdbb9b198 ACPI 2.0=0xd9b43018 TPMEventLog=0xd975a018 RNG=0xd9b43698 MEMRESERVE=0xd9b40c18 Jan 29 11:14:41.923411 kernel: random: crng init done Jan 29 11:14:41.923418 kernel: secureboot: Secure boot disabled Jan 29 11:14:41.923423 kernel: ACPI: Early table checksum verification disabled Jan 29 11:14:41.923429 kernel: ACPI: RSDP 0x00000000D9B43018 000024 (v02 BOCHS ) Jan 29 11:14:41.923437 kernel: ACPI: XSDT 0x00000000D9B43F18 00006C (v01 BOCHS BXPC 00000001 01000013) Jan 29 11:14:41.923443 kernel: ACPI: FACP 0x00000000D9B43B18 000114 (v06 BOCHS BXPC 00000001 BXPC 00000001) Jan 29 11:14:41.923448 kernel: ACPI: DSDT 0x00000000D9B41018 0014EB (v02 BOCHS BXPC 00000001 BXPC 00000001) Jan 29 11:14:41.923454 kernel: ACPI: APIC 0x00000000D9B43C98 0001A8 (v04 BOCHS BXPC 00000001 BXPC 00000001) Jan 29 11:14:41.923460 kernel: ACPI: PPTT 0x00000000D9B43098 00009C (v02 BOCHS BXPC 00000001 BXPC 00000001) Jan 29 11:14:41.923467 kernel: ACPI: GTDT 0x00000000D9B43818 000060 (v02 BOCHS BXPC 00000001 BXPC 00000001) Jan 29 11:14:41.923475 kernel: ACPI: MCFG 0x00000000D9B43A98 00003C (v01 BOCHS BXPC 00000001 BXPC 00000001) Jan 29 11:14:41.923481 kernel: ACPI: SPCR 0x00000000D9B43918 000050 (v02 BOCHS BXPC 00000001 BXPC 00000001) Jan 29 11:14:41.923487 kernel: ACPI: DBG2 0x00000000D9B43998 000057 (v00 BOCHS BXPC 00000001 BXPC 00000001) Jan 29 11:14:41.923493 kernel: ACPI: IORT 0x00000000D9B43198 000080 (v03 BOCHS BXPC 00000001 BXPC 00000001) Jan 29 11:14:41.923500 kernel: ACPI: TPM2 0x00000000D9B43A18 00004C (v04 BOCHS BXPC 00000001 BXPC 00000001) Jan 29 11:14:41.923506 kernel: ACPI: SPCR: console: pl011,mmio,0x9000000,9600 Jan 29 11:14:41.923512 kernel: NUMA: Failed to initialise from firmware Jan 29 11:14:41.923518 kernel: NUMA: Faking a node at [mem 0x0000000040000000-0x00000000dcffffff] Jan 29 11:14:41.923524 kernel: NUMA: NODE_DATA [mem 0xdc958800-0xdc95dfff] Jan 29 11:14:41.923530 kernel: Zone ranges: Jan 29 11:14:41.923538 kernel: DMA [mem 0x0000000040000000-0x00000000dcffffff] Jan 29 11:14:41.923544 kernel: DMA32 empty Jan 29 11:14:41.923550 kernel: Normal empty Jan 29 11:14:41.923556 kernel: Movable zone start for each node Jan 29 11:14:41.923562 kernel: Early memory node ranges Jan 29 11:14:41.923568 kernel: node 0: [mem 0x0000000040000000-0x00000000d973ffff] Jan 29 11:14:41.923574 kernel: node 0: [mem 0x00000000d9740000-0x00000000d974ffff] Jan 29 11:14:41.923580 kernel: node 0: [mem 0x00000000d9750000-0x00000000d975ffff] Jan 29 11:14:41.923586 kernel: node 0: [mem 0x00000000d9760000-0x00000000d9b3ffff] Jan 29 11:14:41.923592 kernel: node 0: [mem 0x00000000d9b40000-0x00000000dce1ffff] Jan 29 11:14:41.923598 kernel: node 0: [mem 0x00000000dce20000-0x00000000dceaffff] Jan 29 11:14:41.923604 kernel: node 0: [mem 0x00000000dceb0000-0x00000000dcebffff] Jan 29 11:14:41.923611 kernel: node 0: [mem 0x00000000dcec0000-0x00000000dcfdffff] Jan 29 11:14:41.923617 kernel: node 0: [mem 0x00000000dcfe0000-0x00000000dcffffff] Jan 29 11:14:41.923624 kernel: Initmem setup node 0 [mem 0x0000000040000000-0x00000000dcffffff] Jan 29 11:14:41.923633 kernel: On node 0, zone DMA: 12288 pages in unavailable ranges Jan 29 11:14:41.923639 kernel: psci: probing for conduit method from ACPI. Jan 29 11:14:41.923646 kernel: psci: PSCIv1.1 detected in firmware. Jan 29 11:14:41.923653 kernel: psci: Using standard PSCI v0.2 function IDs Jan 29 11:14:41.923660 kernel: psci: Trusted OS migration not required Jan 29 11:14:41.923666 kernel: psci: SMC Calling Convention v1.1 Jan 29 11:14:41.923673 kernel: smccc: KVM: hypervisor services detected (0x00000000 0x00000000 0x00000000 0x00000003) Jan 29 11:14:41.923679 kernel: percpu: Embedded 31 pages/cpu s86696 r8192 d32088 u126976 Jan 29 11:14:41.923686 kernel: pcpu-alloc: s86696 r8192 d32088 u126976 alloc=31*4096 Jan 29 11:14:41.923693 kernel: pcpu-alloc: [0] 0 [0] 1 [0] 2 [0] 3 Jan 29 11:14:41.923699 kernel: Detected PIPT I-cache on CPU0 Jan 29 11:14:41.923706 kernel: CPU features: detected: GIC system register CPU interface Jan 29 11:14:41.923712 kernel: CPU features: detected: Hardware dirty bit management Jan 29 11:14:41.923720 kernel: CPU features: detected: Spectre-v4 Jan 29 11:14:41.923727 kernel: CPU features: detected: Spectre-BHB Jan 29 11:14:41.923733 kernel: CPU features: kernel page table isolation forced ON by KASLR Jan 29 11:14:41.923739 kernel: CPU features: detected: Kernel page table isolation (KPTI) Jan 29 11:14:41.923746 kernel: CPU features: detected: ARM erratum 1418040 Jan 29 11:14:41.923752 kernel: CPU features: detected: SSBS not fully self-synchronizing Jan 29 11:14:41.923759 kernel: alternatives: applying boot alternatives Jan 29 11:14:41.923766 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=ttyS0,115200 flatcar.first_boot=detected acpi=force verity.usrhash=c8edc06d36325e34bb125a9ad39c4f788eb9f01102631b71efea3f9afa94c89e Jan 29 11:14:41.923773 kernel: Unknown kernel command line parameters "BOOT_IMAGE=/flatcar/vmlinuz-a", will be passed to user space. Jan 29 11:14:41.923780 kernel: Dentry cache hash table entries: 524288 (order: 10, 4194304 bytes, linear) Jan 29 11:14:41.923798 kernel: Inode-cache hash table entries: 262144 (order: 9, 2097152 bytes, linear) Jan 29 11:14:41.923807 kernel: Fallback order for Node 0: 0 Jan 29 11:14:41.923814 kernel: Built 1 zonelists, mobility grouping on. Total pages: 633024 Jan 29 11:14:41.923820 kernel: Policy zone: DMA Jan 29 11:14:41.923827 kernel: mem auto-init: stack:off, heap alloc:off, heap free:off Jan 29 11:14:41.923833 kernel: software IO TLB: area num 4. Jan 29 11:14:41.923840 kernel: software IO TLB: mapped [mem 0x00000000d2e00000-0x00000000d6e00000] (64MB) Jan 29 11:14:41.923847 kernel: Memory: 2386176K/2572288K available (10240K kernel code, 2186K rwdata, 8096K rodata, 39680K init, 897K bss, 186112K reserved, 0K cma-reserved) Jan 29 11:14:41.923853 kernel: SLUB: HWalign=64, Order=0-3, MinObjects=0, CPUs=4, Nodes=1 Jan 29 11:14:41.923860 kernel: rcu: Preemptible hierarchical RCU implementation. Jan 29 11:14:41.923867 kernel: rcu: RCU event tracing is enabled. Jan 29 11:14:41.923874 kernel: rcu: RCU restricting CPUs from NR_CPUS=512 to nr_cpu_ids=4. Jan 29 11:14:41.923882 kernel: Trampoline variant of Tasks RCU enabled. Jan 29 11:14:41.923889 kernel: Tracing variant of Tasks RCU enabled. Jan 29 11:14:41.923900 kernel: rcu: RCU calculated value of scheduler-enlistment delay is 100 jiffies. Jan 29 11:14:41.923906 kernel: rcu: Adjusting geometry for rcu_fanout_leaf=16, nr_cpu_ids=4 Jan 29 11:14:41.923913 kernel: NR_IRQS: 64, nr_irqs: 64, preallocated irqs: 0 Jan 29 11:14:41.923919 kernel: GICv3: 256 SPIs implemented Jan 29 11:14:41.923925 kernel: GICv3: 0 Extended SPIs implemented Jan 29 11:14:41.923932 kernel: Root IRQ handler: gic_handle_irq Jan 29 11:14:41.923938 kernel: GICv3: GICv3 features: 16 PPIs, DirectLPI Jan 29 11:14:41.923945 kernel: GICv3: CPU0: found redistributor 0 region 0:0x00000000080a0000 Jan 29 11:14:41.923951 kernel: ITS [mem 0x08080000-0x0809ffff] Jan 29 11:14:41.923958 kernel: ITS@0x0000000008080000: allocated 8192 Devices @400c0000 (indirect, esz 8, psz 64K, shr 1) Jan 29 11:14:41.923966 kernel: ITS@0x0000000008080000: allocated 8192 Interrupt Collections @400d0000 (flat, esz 8, psz 64K, shr 1) Jan 29 11:14:41.923973 kernel: GICv3: using LPI property table @0x00000000400f0000 Jan 29 11:14:41.923979 kernel: GICv3: CPU0: using allocated LPI pending table @0x0000000040100000 Jan 29 11:14:41.923986 kernel: rcu: srcu_init: Setting srcu_struct sizes based on contention. Jan 29 11:14:41.923993 kernel: arch_timer: Enabling local workaround for ARM erratum 1418040 Jan 29 11:14:41.923999 kernel: arch_timer: cp15 timer(s) running at 25.00MHz (virt). Jan 29 11:14:41.924006 kernel: clocksource: arch_sys_counter: mask: 0xffffffffffffff max_cycles: 0x5c40939b5, max_idle_ns: 440795202646 ns Jan 29 11:14:41.924013 kernel: sched_clock: 56 bits at 25MHz, resolution 40ns, wraps every 4398046511100ns Jan 29 11:14:41.924020 kernel: arm-pv: using stolen time PV Jan 29 11:14:41.924027 kernel: Console: colour dummy device 80x25 Jan 29 11:14:41.924033 kernel: ACPI: Core revision 20230628 Jan 29 11:14:41.924042 kernel: Calibrating delay loop (skipped), value calculated using timer frequency.. 50.00 BogoMIPS (lpj=25000) Jan 29 11:14:41.924049 kernel: pid_max: default: 32768 minimum: 301 Jan 29 11:14:41.924056 kernel: LSM: initializing lsm=lockdown,capability,landlock,selinux,integrity Jan 29 11:14:41.924062 kernel: landlock: Up and running. Jan 29 11:14:41.924089 kernel: SELinux: Initializing. Jan 29 11:14:41.924096 kernel: Mount-cache hash table entries: 8192 (order: 4, 65536 bytes, linear) Jan 29 11:14:41.924103 kernel: Mountpoint-cache hash table entries: 8192 (order: 4, 65536 bytes, linear) Jan 29 11:14:41.924110 kernel: RCU Tasks: Setting shift to 2 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=4. Jan 29 11:14:41.924117 kernel: RCU Tasks Trace: Setting shift to 2 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=4. Jan 29 11:14:41.924126 kernel: rcu: Hierarchical SRCU implementation. Jan 29 11:14:41.924133 kernel: rcu: Max phase no-delay instances is 400. Jan 29 11:14:41.924140 kernel: Platform MSI: ITS@0x8080000 domain created Jan 29 11:14:41.924147 kernel: PCI/MSI: ITS@0x8080000 domain created Jan 29 11:14:41.924154 kernel: Remapping and enabling EFI services. Jan 29 11:14:41.924161 kernel: smp: Bringing up secondary CPUs ... Jan 29 11:14:41.924168 kernel: Detected PIPT I-cache on CPU1 Jan 29 11:14:41.924175 kernel: GICv3: CPU1: found redistributor 1 region 0:0x00000000080c0000 Jan 29 11:14:41.924181 kernel: GICv3: CPU1: using allocated LPI pending table @0x0000000040110000 Jan 29 11:14:41.924190 kernel: arch_timer: Enabling local workaround for ARM erratum 1418040 Jan 29 11:14:41.924196 kernel: CPU1: Booted secondary processor 0x0000000001 [0x413fd0c1] Jan 29 11:14:41.924208 kernel: Detected PIPT I-cache on CPU2 Jan 29 11:14:41.924218 kernel: GICv3: CPU2: found redistributor 2 region 0:0x00000000080e0000 Jan 29 11:14:41.924225 kernel: GICv3: CPU2: using allocated LPI pending table @0x0000000040120000 Jan 29 11:14:41.924232 kernel: arch_timer: Enabling local workaround for ARM erratum 1418040 Jan 29 11:14:41.924239 kernel: CPU2: Booted secondary processor 0x0000000002 [0x413fd0c1] Jan 29 11:14:41.924246 kernel: Detected PIPT I-cache on CPU3 Jan 29 11:14:41.924253 kernel: GICv3: CPU3: found redistributor 3 region 0:0x0000000008100000 Jan 29 11:14:41.924262 kernel: GICv3: CPU3: using allocated LPI pending table @0x0000000040130000 Jan 29 11:14:41.924269 kernel: arch_timer: Enabling local workaround for ARM erratum 1418040 Jan 29 11:14:41.924276 kernel: CPU3: Booted secondary processor 0x0000000003 [0x413fd0c1] Jan 29 11:14:41.924283 kernel: smp: Brought up 1 node, 4 CPUs Jan 29 11:14:41.924290 kernel: SMP: Total of 4 processors activated. Jan 29 11:14:41.924297 kernel: CPU features: detected: 32-bit EL0 Support Jan 29 11:14:41.924305 kernel: CPU features: detected: Data cache clean to the PoU not required for I/D coherence Jan 29 11:14:41.924312 kernel: CPU features: detected: Common not Private translations Jan 29 11:14:41.924320 kernel: CPU features: detected: CRC32 instructions Jan 29 11:14:41.924327 kernel: CPU features: detected: Enhanced Virtualization Traps Jan 29 11:14:41.924335 kernel: CPU features: detected: RCpc load-acquire (LDAPR) Jan 29 11:14:41.924342 kernel: CPU features: detected: LSE atomic instructions Jan 29 11:14:41.924350 kernel: CPU features: detected: Privileged Access Never Jan 29 11:14:41.924357 kernel: CPU features: detected: RAS Extension Support Jan 29 11:14:41.924364 kernel: CPU features: detected: Speculative Store Bypassing Safe (SSBS) Jan 29 11:14:41.924371 kernel: CPU: All CPU(s) started at EL1 Jan 29 11:14:41.924378 kernel: alternatives: applying system-wide alternatives Jan 29 11:14:41.924385 kernel: devtmpfs: initialized Jan 29 11:14:41.924394 kernel: clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1911260446275000 ns Jan 29 11:14:41.924401 kernel: futex hash table entries: 1024 (order: 4, 65536 bytes, linear) Jan 29 11:14:41.924408 kernel: pinctrl core: initialized pinctrl subsystem Jan 29 11:14:41.924414 kernel: SMBIOS 3.0.0 present. Jan 29 11:14:41.924422 kernel: DMI: QEMU KVM Virtual Machine, BIOS unknown 02/02/2022 Jan 29 11:14:41.924429 kernel: NET: Registered PF_NETLINK/PF_ROUTE protocol family Jan 29 11:14:41.924436 kernel: DMA: preallocated 512 KiB GFP_KERNEL pool for atomic allocations Jan 29 11:14:41.924443 kernel: DMA: preallocated 512 KiB GFP_KERNEL|GFP_DMA pool for atomic allocations Jan 29 11:14:41.924451 kernel: DMA: preallocated 512 KiB GFP_KERNEL|GFP_DMA32 pool for atomic allocations Jan 29 11:14:41.924459 kernel: audit: initializing netlink subsys (disabled) Jan 29 11:14:41.924466 kernel: audit: type=2000 audit(0.021:1): state=initialized audit_enabled=0 res=1 Jan 29 11:14:41.924473 kernel: thermal_sys: Registered thermal governor 'step_wise' Jan 29 11:14:41.924479 kernel: cpuidle: using governor menu Jan 29 11:14:41.924487 kernel: hw-breakpoint: found 6 breakpoint and 4 watchpoint registers. Jan 29 11:14:41.924493 kernel: ASID allocator initialised with 32768 entries Jan 29 11:14:41.924500 kernel: acpiphp: ACPI Hot Plug PCI Controller Driver version: 0.5 Jan 29 11:14:41.924522 kernel: Serial: AMBA PL011 UART driver Jan 29 11:14:41.924530 kernel: Modules: 2G module region forced by RANDOMIZE_MODULE_REGION_FULL Jan 29 11:14:41.924537 kernel: Modules: 0 pages in range for non-PLT usage Jan 29 11:14:41.924544 kernel: Modules: 508960 pages in range for PLT usage Jan 29 11:14:41.924551 kernel: HugeTLB: registered 1.00 GiB page size, pre-allocated 0 pages Jan 29 11:14:41.924558 kernel: HugeTLB: 0 KiB vmemmap can be freed for a 1.00 GiB page Jan 29 11:14:41.924566 kernel: HugeTLB: registered 32.0 MiB page size, pre-allocated 0 pages Jan 29 11:14:41.924574 kernel: HugeTLB: 0 KiB vmemmap can be freed for a 32.0 MiB page Jan 29 11:14:41.924584 kernel: HugeTLB: registered 2.00 MiB page size, pre-allocated 0 pages Jan 29 11:14:41.924592 kernel: HugeTLB: 0 KiB vmemmap can be freed for a 2.00 MiB page Jan 29 11:14:41.924600 kernel: HugeTLB: registered 64.0 KiB page size, pre-allocated 0 pages Jan 29 11:14:41.924607 kernel: HugeTLB: 0 KiB vmemmap can be freed for a 64.0 KiB page Jan 29 11:14:41.924614 kernel: ACPI: Added _OSI(Module Device) Jan 29 11:14:41.924622 kernel: ACPI: Added _OSI(Processor Device) Jan 29 11:14:41.924629 kernel: ACPI: Added _OSI(3.0 _SCP Extensions) Jan 29 11:14:41.924636 kernel: ACPI: Added _OSI(Processor Aggregator Device) Jan 29 11:14:41.924643 kernel: ACPI: 1 ACPI AML tables successfully acquired and loaded Jan 29 11:14:41.924650 kernel: ACPI: Interpreter enabled Jan 29 11:14:41.924659 kernel: ACPI: Using GIC for interrupt routing Jan 29 11:14:41.924666 kernel: ACPI: MCFG table detected, 1 entries Jan 29 11:14:41.924675 kernel: ARMH0011:00: ttyAMA0 at MMIO 0x9000000 (irq = 12, base_baud = 0) is a SBSA Jan 29 11:14:41.924682 kernel: printk: console [ttyAMA0] enabled Jan 29 11:14:41.924689 kernel: ACPI: PCI Root Bridge [PCI0] (domain 0000 [bus 00-ff]) Jan 29 11:14:41.924831 kernel: acpi PNP0A08:00: _OSC: OS supports [ExtendedConfig ASPM ClockPM Segments MSI HPX-Type3] Jan 29 11:14:41.924921 kernel: acpi PNP0A08:00: _OSC: platform does not support [LTR] Jan 29 11:14:41.924994 kernel: acpi PNP0A08:00: _OSC: OS now controls [PCIeHotplug PME AER PCIeCapability] Jan 29 11:14:41.925060 kernel: acpi PNP0A08:00: ECAM area [mem 0x4010000000-0x401fffffff] reserved by PNP0C02:00 Jan 29 11:14:41.925145 kernel: acpi PNP0A08:00: ECAM at [mem 0x4010000000-0x401fffffff] for [bus 00-ff] Jan 29 11:14:41.925155 kernel: ACPI: Remapped I/O 0x000000003eff0000 to [io 0x0000-0xffff window] Jan 29 11:14:41.925162 kernel: PCI host bridge to bus 0000:00 Jan 29 11:14:41.925245 kernel: pci_bus 0000:00: root bus resource [mem 0x10000000-0x3efeffff window] Jan 29 11:14:41.925305 kernel: pci_bus 0000:00: root bus resource [io 0x0000-0xffff window] Jan 29 11:14:41.925380 kernel: pci_bus 0000:00: root bus resource [mem 0x8000000000-0xffffffffff window] Jan 29 11:14:41.925474 kernel: pci_bus 0000:00: root bus resource [bus 00-ff] Jan 29 11:14:41.925571 kernel: pci 0000:00:00.0: [1b36:0008] type 00 class 0x060000 Jan 29 11:14:41.925652 kernel: pci 0000:00:01.0: [1af4:1005] type 00 class 0x00ff00 Jan 29 11:14:41.925719 kernel: pci 0000:00:01.0: reg 0x10: [io 0x0000-0x001f] Jan 29 11:14:41.925794 kernel: pci 0000:00:01.0: reg 0x14: [mem 0x10000000-0x10000fff] Jan 29 11:14:41.925867 kernel: pci 0000:00:01.0: reg 0x20: [mem 0x8000000000-0x8000003fff 64bit pref] Jan 29 11:14:41.925953 kernel: pci 0000:00:01.0: BAR 4: assigned [mem 0x8000000000-0x8000003fff 64bit pref] Jan 29 11:14:41.926033 kernel: pci 0000:00:01.0: BAR 1: assigned [mem 0x10000000-0x10000fff] Jan 29 11:14:41.926135 kernel: pci 0000:00:01.0: BAR 0: assigned [io 0x1000-0x101f] Jan 29 11:14:41.926210 kernel: pci_bus 0000:00: resource 4 [mem 0x10000000-0x3efeffff window] Jan 29 11:14:41.926284 kernel: pci_bus 0000:00: resource 5 [io 0x0000-0xffff window] Jan 29 11:14:41.926355 kernel: pci_bus 0000:00: resource 6 [mem 0x8000000000-0xffffffffff window] Jan 29 11:14:41.926365 kernel: ACPI: PCI: Interrupt link GSI0 configured for IRQ 35 Jan 29 11:14:41.926373 kernel: ACPI: PCI: Interrupt link GSI1 configured for IRQ 36 Jan 29 11:14:41.926381 kernel: ACPI: PCI: Interrupt link GSI2 configured for IRQ 37 Jan 29 11:14:41.926391 kernel: ACPI: PCI: Interrupt link GSI3 configured for IRQ 38 Jan 29 11:14:41.926399 kernel: iommu: Default domain type: Translated Jan 29 11:14:41.926406 kernel: iommu: DMA domain TLB invalidation policy: strict mode Jan 29 11:14:41.926414 kernel: efivars: Registered efivars operations Jan 29 11:14:41.926422 kernel: vgaarb: loaded Jan 29 11:14:41.926429 kernel: clocksource: Switched to clocksource arch_sys_counter Jan 29 11:14:41.926437 kernel: VFS: Disk quotas dquot_6.6.0 Jan 29 11:14:41.926444 kernel: VFS: Dquot-cache hash table entries: 512 (order 0, 4096 bytes) Jan 29 11:14:41.926452 kernel: pnp: PnP ACPI init Jan 29 11:14:41.926534 kernel: system 00:00: [mem 0x4010000000-0x401fffffff window] could not be reserved Jan 29 11:14:41.926545 kernel: pnp: PnP ACPI: found 1 devices Jan 29 11:14:41.926553 kernel: NET: Registered PF_INET protocol family Jan 29 11:14:41.926560 kernel: IP idents hash table entries: 65536 (order: 7, 524288 bytes, linear) Jan 29 11:14:41.926568 kernel: tcp_listen_portaddr_hash hash table entries: 2048 (order: 3, 32768 bytes, linear) Jan 29 11:14:41.926576 kernel: Table-perturb hash table entries: 65536 (order: 6, 262144 bytes, linear) Jan 29 11:14:41.926583 kernel: TCP established hash table entries: 32768 (order: 6, 262144 bytes, linear) Jan 29 11:14:41.926591 kernel: TCP bind hash table entries: 32768 (order: 8, 1048576 bytes, linear) Jan 29 11:14:41.926600 kernel: TCP: Hash tables configured (established 32768 bind 32768) Jan 29 11:14:41.926608 kernel: UDP hash table entries: 2048 (order: 4, 65536 bytes, linear) Jan 29 11:14:41.926615 kernel: UDP-Lite hash table entries: 2048 (order: 4, 65536 bytes, linear) Jan 29 11:14:41.926623 kernel: NET: Registered PF_UNIX/PF_LOCAL protocol family Jan 29 11:14:41.926630 kernel: PCI: CLS 0 bytes, default 64 Jan 29 11:14:41.926638 kernel: kvm [1]: HYP mode not available Jan 29 11:14:41.926645 kernel: Initialise system trusted keyrings Jan 29 11:14:41.926653 kernel: workingset: timestamp_bits=39 max_order=20 bucket_order=0 Jan 29 11:14:41.926660 kernel: Key type asymmetric registered Jan 29 11:14:41.926669 kernel: Asymmetric key parser 'x509' registered Jan 29 11:14:41.926677 kernel: Block layer SCSI generic (bsg) driver version 0.4 loaded (major 250) Jan 29 11:14:41.926684 kernel: io scheduler mq-deadline registered Jan 29 11:14:41.926691 kernel: io scheduler kyber registered Jan 29 11:14:41.926698 kernel: io scheduler bfq registered Jan 29 11:14:41.926705 kernel: input: Power Button as /devices/LNXSYSTM:00/LNXSYBUS:00/PNP0C0C:00/input/input0 Jan 29 11:14:41.926713 kernel: ACPI: button: Power Button [PWRB] Jan 29 11:14:41.926721 kernel: ACPI: \_SB_.PCI0.GSI1: Enabled at IRQ 36 Jan 29 11:14:41.926797 kernel: virtio-pci 0000:00:01.0: enabling device (0005 -> 0007) Jan 29 11:14:41.926807 kernel: Serial: 8250/16550 driver, 4 ports, IRQ sharing enabled Jan 29 11:14:41.926817 kernel: thunder_xcv, ver 1.0 Jan 29 11:14:41.926825 kernel: thunder_bgx, ver 1.0 Jan 29 11:14:41.926832 kernel: nicpf, ver 1.0 Jan 29 11:14:41.926843 kernel: nicvf, ver 1.0 Jan 29 11:14:41.926924 kernel: rtc-efi rtc-efi.0: registered as rtc0 Jan 29 11:14:41.926995 kernel: rtc-efi rtc-efi.0: setting system clock to 2025-01-29T11:14:41 UTC (1738149281) Jan 29 11:14:41.927006 kernel: hid: raw HID events driver (C) Jiri Kosina Jan 29 11:14:41.927016 kernel: hw perfevents: enabled with armv8_pmuv3_0 PMU driver, 7 counters available Jan 29 11:14:41.927028 kernel: watchdog: Delayed init of the lockup detector failed: -19 Jan 29 11:14:41.927035 kernel: watchdog: Hard watchdog permanently disabled Jan 29 11:14:41.927043 kernel: NET: Registered PF_INET6 protocol family Jan 29 11:14:41.927050 kernel: Segment Routing with IPv6 Jan 29 11:14:41.927057 kernel: In-situ OAM (IOAM) with IPv6 Jan 29 11:14:41.927064 kernel: NET: Registered PF_PACKET protocol family Jan 29 11:14:41.927086 kernel: Key type dns_resolver registered Jan 29 11:14:41.927094 kernel: registered taskstats version 1 Jan 29 11:14:41.927101 kernel: Loading compiled-in X.509 certificates Jan 29 11:14:41.927111 kernel: Loaded X.509 cert 'Kinvolk GmbH: Module signing key for 6.6.74-flatcar: f3333311a24aa8c58222f4e98a07eaa1f186ad1a' Jan 29 11:14:41.927118 kernel: Key type .fscrypt registered Jan 29 11:14:41.927127 kernel: Key type fscrypt-provisioning registered Jan 29 11:14:41.927135 kernel: ima: No TPM chip found, activating TPM-bypass! Jan 29 11:14:41.927142 kernel: ima: Allocated hash algorithm: sha1 Jan 29 11:14:41.927150 kernel: ima: No architecture policies found Jan 29 11:14:41.927157 kernel: alg: No test for fips(ansi_cprng) (fips_ansi_cprng) Jan 29 11:14:41.927165 kernel: clk: Disabling unused clocks Jan 29 11:14:41.927174 kernel: Freeing unused kernel memory: 39680K Jan 29 11:14:41.927183 kernel: Run /init as init process Jan 29 11:14:41.927194 kernel: with arguments: Jan 29 11:14:41.927208 kernel: /init Jan 29 11:14:41.927215 kernel: with environment: Jan 29 11:14:41.927222 kernel: HOME=/ Jan 29 11:14:41.927230 kernel: TERM=linux Jan 29 11:14:41.927237 kernel: BOOT_IMAGE=/flatcar/vmlinuz-a Jan 29 11:14:41.927246 systemd[1]: systemd 255 running in system mode (+PAM +AUDIT +SELINUX -APPARMOR +IMA +SMACK +SECCOMP +GCRYPT -GNUTLS +OPENSSL -ACL +BLKID +CURL +ELFUTILS -FIDO2 +IDN2 -IDN +IPTC +KMOD +LIBCRYPTSETUP +LIBFDISK +PCRE2 -PWQUALITY -P11KIT -QRENCODE +TPM2 +BZIP2 +LZ4 +XZ +ZLIB +ZSTD -BPF_FRAMEWORK -XKBCOMMON +UTMP -SYSVINIT default-hierarchy=unified) Jan 29 11:14:41.927257 systemd[1]: Detected virtualization kvm. Jan 29 11:14:41.927265 systemd[1]: Detected architecture arm64. Jan 29 11:14:41.927272 systemd[1]: Running in initrd. Jan 29 11:14:41.927280 systemd[1]: No hostname configured, using default hostname. Jan 29 11:14:41.927287 systemd[1]: Hostname set to <localhost>. Jan 29 11:14:41.927296 systemd[1]: Initializing machine ID from VM UUID. Jan 29 11:14:41.927303 systemd[1]: Queued start job for default target initrd.target. Jan 29 11:14:41.927311 systemd[1]: Started clevis-luks-askpass.path - Forward Password Requests to Clevis Directory Watch. Jan 29 11:14:41.927321 systemd[1]: Started systemd-ask-password-console.path - Dispatch Password Requests to Console Directory Watch. Jan 29 11:14:41.927329 systemd[1]: Expecting device dev-disk-by\x2dlabel-EFI\x2dSYSTEM.device - /dev/disk/by-label/EFI-SYSTEM... Jan 29 11:14:41.927337 systemd[1]: Expecting device dev-disk-by\x2dlabel-OEM.device - /dev/disk/by-label/OEM... Jan 29 11:14:41.927345 systemd[1]: Expecting device dev-disk-by\x2dlabel-ROOT.device - /dev/disk/by-label/ROOT... Jan 29 11:14:41.927353 systemd[1]: Expecting device dev-disk-by\x2dpartlabel-USR\x2dA.device - /dev/disk/by-partlabel/USR-A... Jan 29 11:14:41.927363 systemd[1]: Expecting device dev-disk-by\x2dpartuuid-7130c94a\x2d213a\x2d4e5a\x2d8e26\x2d6cce9662f132.device - /dev/disk/by-partuuid/7130c94a-213a-4e5a-8e26-6cce9662f132... Jan 29 11:14:41.927372 systemd[1]: Expecting device dev-mapper-usr.device - /dev/mapper/usr... Jan 29 11:14:41.927380 systemd[1]: Reached target cryptsetup-pre.target - Local Encrypted Volumes (Pre). Jan 29 11:14:41.927388 systemd[1]: Reached target cryptsetup.target - Local Encrypted Volumes. Jan 29 11:14:41.927396 systemd[1]: Reached target paths.target - Path Units. Jan 29 11:14:41.927404 systemd[1]: Reached target slices.target - Slice Units. Jan 29 11:14:41.927412 systemd[1]: Reached target swap.target - Swaps. Jan 29 11:14:41.927420 systemd[1]: Reached target timers.target - Timer Units. Jan 29 11:14:41.927428 systemd[1]: Listening on iscsid.socket - Open-iSCSI iscsid Socket. Jan 29 11:14:41.927436 systemd[1]: Listening on iscsiuio.socket - Open-iSCSI iscsiuio Socket. Jan 29 11:14:41.927445 systemd[1]: Listening on systemd-journald-dev-log.socket - Journal Socket (/dev/log). Jan 29 11:14:41.927453 systemd[1]: Listening on systemd-journald.socket - Journal Socket. Jan 29 11:14:41.927461 systemd[1]: Listening on systemd-networkd.socket - Network Service Netlink Socket. Jan 29 11:14:41.927469 systemd[1]: Listening on systemd-udevd-control.socket - udev Control Socket. Jan 29 11:14:41.927477 systemd[1]: Listening on systemd-udevd-kernel.socket - udev Kernel Socket. Jan 29 11:14:41.927485 systemd[1]: Reached target sockets.target - Socket Units. Jan 29 11:14:41.927493 systemd[1]: Starting ignition-setup-pre.service - Ignition env setup... Jan 29 11:14:41.927501 systemd[1]: Starting kmod-static-nodes.service - Create List of Static Device Nodes... Jan 29 11:14:41.927510 systemd[1]: Finished network-cleanup.service - Network Cleanup. Jan 29 11:14:41.927518 systemd[1]: Starting systemd-fsck-usr.service... Jan 29 11:14:41.927526 systemd[1]: Starting systemd-journald.service - Journal Service... Jan 29 11:14:41.927534 systemd[1]: Starting systemd-modules-load.service - Load Kernel Modules... Jan 29 11:14:41.927542 systemd[1]: Starting systemd-vconsole-setup.service - Virtual Console Setup... Jan 29 11:14:41.927550 systemd[1]: Finished ignition-setup-pre.service - Ignition env setup. Jan 29 11:14:41.927558 systemd[1]: Finished kmod-static-nodes.service - Create List of Static Device Nodes. Jan 29 11:14:41.927566 systemd[1]: Finished systemd-fsck-usr.service. Jan 29 11:14:41.927576 systemd[1]: Starting systemd-tmpfiles-setup-dev-early.service - Create Static Device Nodes in /dev gracefully... Jan 29 11:14:41.927584 systemd[1]: Finished systemd-vconsole-setup.service - Virtual Console Setup. Jan 29 11:14:41.927611 systemd-journald[239]: Collecting audit messages is disabled. Jan 29 11:14:41.927632 kernel: bridge: filtering via arp/ip/ip6tables is no longer available by default. Update your scripts to load br_netfilter if you need this. Jan 29 11:14:41.927641 systemd-journald[239]: Journal started Jan 29 11:14:41.927659 systemd-journald[239]: Runtime Journal (/run/log/journal/26241df84bea4e8d8f434986b14b8294) is 5.9M, max 47.3M, 41.4M free. Jan 29 11:14:41.932174 kernel: Bridge firewalling registered Jan 29 11:14:41.914833 systemd-modules-load[240]: Inserted module 'overlay' Jan 29 11:14:41.930611 systemd-modules-load[240]: Inserted module 'br_netfilter' Jan 29 11:14:41.935607 systemd[1]: Starting dracut-cmdline-ask.service - dracut ask for additional cmdline parameters... Jan 29 11:14:41.935626 systemd[1]: Started systemd-journald.service - Journal Service. Jan 29 11:14:41.936567 systemd[1]: Finished systemd-modules-load.service - Load Kernel Modules. Jan 29 11:14:41.937614 systemd[1]: Finished systemd-tmpfiles-setup-dev-early.service - Create Static Device Nodes in /dev gracefully. Jan 29 11:14:41.942772 systemd[1]: Starting systemd-sysctl.service - Apply Kernel Variables... Jan 29 11:14:41.945872 systemd[1]: Starting systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev... Jan 29 11:14:41.948286 systemd[1]: Starting systemd-tmpfiles-setup.service - Create System Files and Directories... Jan 29 11:14:41.952331 systemd[1]: Finished dracut-cmdline-ask.service - dracut ask for additional cmdline parameters. Jan 29 11:14:41.955389 systemd[1]: Starting dracut-cmdline.service - dracut cmdline hook... Jan 29 11:14:41.956974 systemd[1]: Finished systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev. Jan 29 11:14:41.961494 systemd[1]: Finished systemd-sysctl.service - Apply Kernel Variables. Jan 29 11:14:41.962484 systemd[1]: Finished systemd-tmpfiles-setup.service - Create System Files and Directories. Jan 29 11:14:41.965444 systemd[1]: Starting systemd-resolved.service - Network Name Resolution... Jan 29 11:14:41.968900 dracut-cmdline[273]: dracut-dracut-053 Jan 29 11:14:41.972737 dracut-cmdline[273]: 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=ttyS0,115200 flatcar.first_boot=detected acpi=force verity.usrhash=c8edc06d36325e34bb125a9ad39c4f788eb9f01102631b71efea3f9afa94c89e Jan 29 11:14:41.993966 systemd-resolved[283]: Positive Trust Anchors: Jan 29 11:14:41.994040 systemd-resolved[283]: . IN DS 20326 8 2 e06d44b80b8f1d39a95c0b0d7c65d08458e880409bbc683457104237c7f8ec8d Jan 29 11:14:41.994082 systemd-resolved[283]: Negative trust anchors: home.arpa 10.in-addr.arpa 16.172.in-addr.arpa 17.172.in-addr.arpa 18.172.in-addr.arpa 19.172.in-addr.arpa 20.172.in-addr.arpa 21.172.in-addr.arpa 22.172.in-addr.arpa 23.172.in-addr.arpa 24.172.in-addr.arpa 25.172.in-addr.arpa 26.172.in-addr.arpa 27.172.in-addr.arpa 28.172.in-addr.arpa 29.172.in-addr.arpa 30.172.in-addr.arpa 31.172.in-addr.arpa 170.0.0.192.in-addr.arpa 171.0.0.192.in-addr.arpa 168.192.in-addr.arpa d.f.ip6.arpa ipv4only.arpa resolver.arpa corp home internal intranet lan local private test Jan 29 11:14:41.998729 systemd-resolved[283]: Defaulting to hostname 'linux'. Jan 29 11:14:41.999738 systemd[1]: Started systemd-resolved.service - Network Name Resolution. Jan 29 11:14:42.001390 systemd[1]: Reached target nss-lookup.target - Host and Network Name Lookups. Jan 29 11:14:42.042113 kernel: SCSI subsystem initialized Jan 29 11:14:42.047090 kernel: Loading iSCSI transport class v2.0-870. Jan 29 11:14:42.055138 kernel: iscsi: registered transport (tcp) Jan 29 11:14:42.068095 kernel: iscsi: registered transport (qla4xxx) Jan 29 11:14:42.068132 kernel: QLogic iSCSI HBA Driver Jan 29 11:14:42.115822 systemd[1]: Finished dracut-cmdline.service - dracut cmdline hook. Jan 29 11:14:42.131244 systemd[1]: Starting dracut-pre-udev.service - dracut pre-udev hook... Jan 29 11:14:42.148862 kernel: device-mapper: core: CONFIG_IMA_DISABLE_HTABLE is disabled. Duplicate IMA measurements will not be recorded in the IMA log. Jan 29 11:14:42.148919 kernel: device-mapper: uevent: version 1.0.3 Jan 29 11:14:42.148930 kernel: device-mapper: ioctl: 4.48.0-ioctl (2023-03-01) initialised: dm-devel@redhat.com Jan 29 11:14:42.209092 kernel: raid6: neonx8 gen() 15771 MB/s Jan 29 11:14:42.226085 kernel: raid6: neonx4 gen() 15650 MB/s Jan 29 11:14:42.243089 kernel: raid6: neonx2 gen() 13240 MB/s Jan 29 11:14:42.260084 kernel: raid6: neonx1 gen() 10492 MB/s Jan 29 11:14:42.277083 kernel: raid6: int64x8 gen() 6974 MB/s Jan 29 11:14:42.294085 kernel: raid6: int64x4 gen() 7349 MB/s Jan 29 11:14:42.311093 kernel: raid6: int64x2 gen() 6130 MB/s Jan 29 11:14:42.328101 kernel: raid6: int64x1 gen() 5044 MB/s Jan 29 11:14:42.328132 kernel: raid6: using algorithm neonx8 gen() 15771 MB/s Jan 29 11:14:42.345107 kernel: raid6: .... xor() 11903 MB/s, rmw enabled Jan 29 11:14:42.345137 kernel: raid6: using neon recovery algorithm Jan 29 11:14:42.350267 kernel: xor: measuring software checksum speed Jan 29 11:14:42.350291 kernel: 8regs : 19276 MB/sec Jan 29 11:14:42.351273 kernel: 32regs : 19641 MB/sec Jan 29 11:14:42.351296 kernel: arm64_neon : 26272 MB/sec Jan 29 11:14:42.351305 kernel: xor: using function: arm64_neon (26272 MB/sec) Jan 29 11:14:42.404097 kernel: Btrfs loaded, zoned=no, fsverity=no Jan 29 11:14:42.415171 systemd[1]: Finished dracut-pre-udev.service - dracut pre-udev hook. Jan 29 11:14:42.425199 systemd[1]: Starting systemd-udevd.service - Rule-based Manager for Device Events and Files... Jan 29 11:14:42.440076 systemd-udevd[463]: Using default interface naming scheme 'v255'. Jan 29 11:14:42.446701 systemd[1]: Started systemd-udevd.service - Rule-based Manager for Device Events and Files. Jan 29 11:14:42.466317 systemd[1]: Starting dracut-pre-trigger.service - dracut pre-trigger hook... Jan 29 11:14:42.478605 dracut-pre-trigger[469]: rd.md=0: removing MD RAID activation Jan 29 11:14:42.507736 systemd[1]: Finished dracut-pre-trigger.service - dracut pre-trigger hook. Jan 29 11:14:42.527266 systemd[1]: Starting systemd-udev-trigger.service - Coldplug All udev Devices... Jan 29 11:14:42.568809 systemd[1]: Finished systemd-udev-trigger.service - Coldplug All udev Devices. Jan 29 11:14:42.577302 systemd[1]: Starting dracut-initqueue.service - dracut initqueue hook... Jan 29 11:14:42.597462 systemd[1]: Finished dracut-initqueue.service - dracut initqueue hook. Jan 29 11:14:42.598730 systemd[1]: Reached target remote-fs-pre.target - Preparation for Remote File Systems. Jan 29 11:14:42.601226 systemd[1]: Reached target remote-cryptsetup.target - Remote Encrypted Volumes. Jan 29 11:14:42.602028 systemd[1]: Reached target remote-fs.target - Remote File Systems. Jan 29 11:14:42.612193 systemd[1]: Starting dracut-pre-mount.service - dracut pre-mount hook... Jan 29 11:14:42.620544 systemd[1]: Finished dracut-pre-mount.service - dracut pre-mount hook. Jan 29 11:14:42.623089 kernel: virtio_blk virtio1: 1/0/0 default/read/poll queues Jan 29 11:14:42.639823 kernel: virtio_blk virtio1: [vda] 1064960 512-byte logical blocks (545 MB/520 MiB) Jan 29 11:14:42.639938 kernel: tpm_tis MSFT0101:00: 2.0 TPM (device-id 0x1, rev-id 1) Jan 29 11:14:42.640034 kernel: virtio_blk virtio2: 1/0/0 default/read/poll queues Jan 29 11:14:42.650158 kernel: virtio_blk virtio2: [vdb] 9289728 512-byte logical blocks (4.76 GB/4.43 GiB) Jan 29 11:14:42.650529 kernel: vdb: vdb1 vdb2 vdb3 vdb4 vdb6 vdb7 vdb9 Jan 29 11:14:42.648589 systemd[1]: dracut-cmdline-ask.service: Deactivated successfully. Jan 29 11:14:42.648712 systemd[1]: Stopped dracut-cmdline-ask.service - dracut ask for additional cmdline parameters. Jan 29 11:14:42.650098 systemd[1]: Stopping dracut-cmdline-ask.service - dracut ask for additional cmdline parameters... Jan 29 11:14:42.650984 systemd[1]: systemd-vconsole-setup.service: Deactivated successfully. Jan 29 11:14:42.651199 systemd[1]: Stopped systemd-vconsole-setup.service - Virtual Console Setup. Jan 29 11:14:42.652765 systemd[1]: Stopping systemd-vconsole-setup.service - Virtual Console Setup... Jan 29 11:14:42.664368 systemd[1]: Starting systemd-vconsole-setup.service - Virtual Console Setup... Jan 29 11:14:42.675111 kernel: BTRFS: device label OEM devid 1 transid 14 /dev/vdb6 scanned by (udev-worker) (527) Jan 29 11:14:42.675148 kernel: BTRFS: device fsid b5bc7ecc-f31a-46c7-9582-5efca7819025 devid 1 transid 39 /dev/vdb3 scanned by (udev-worker) (513) Jan 29 11:14:42.676952 systemd[1]: Finished systemd-vconsole-setup.service - Virtual Console Setup. Jan 29 11:14:42.687819 systemd[1]: Found device dev-disk-by\x2dlabel-ROOT.device - /dev/disk/by-label/ROOT. Jan 29 11:14:42.692002 systemd[1]: Found device dev-disk-by\x2dlabel-EFI\x2dSYSTEM.device - /dev/disk/by-label/EFI-SYSTEM. Jan 29 11:14:42.696596 systemd[1]: Found device dev-disk-by\x2dlabel-OEM.device - /dev/disk/by-label/OEM. Jan 29 11:14:42.700517 systemd[1]: Found device dev-disk-by\x2dpartlabel-USR\x2dA.device - /dev/disk/by-partlabel/USR-A. Jan 29 11:14:42.701425 systemd[1]: Found device dev-disk-by\x2dpartuuid-7130c94a\x2d213a\x2d4e5a\x2d8e26\x2d6cce9662f132.device - /dev/disk/by-partuuid/7130c94a-213a-4e5a-8e26-6cce9662f132. Jan 29 11:14:42.712223 systemd[1]: Starting disk-uuid.service - Generate new UUID for disk GPT if necessary... Jan 29 11:14:42.714996 systemd[1]: Starting dracut-cmdline-ask.service - dracut ask for additional cmdline parameters... Jan 29 11:14:42.721097 kernel: vdb: vdb1 vdb2 vdb3 vdb4 vdb6 vdb7 vdb9 Jan 29 11:14:42.737119 systemd[1]: Finished dracut-cmdline-ask.service - dracut ask for additional cmdline parameters. Jan 29 11:14:43.737106 kernel: vdb: vdb1 vdb2 vdb3 vdb4 vdb6 vdb7 vdb9 Jan 29 11:14:43.739428 disk-uuid[556]: The operation has completed successfully. Jan 29 11:14:43.775588 systemd[1]: disk-uuid.service: Deactivated successfully. Jan 29 11:14:43.775692 systemd[1]: Finished disk-uuid.service - Generate new UUID for disk GPT if necessary. Jan 29 11:14:43.799260 systemd[1]: Starting verity-setup.service - Verity Setup for /dev/mapper/usr... Jan 29 11:14:43.802355 sh[576]: Success Jan 29 11:14:43.821125 kernel: device-mapper: verity: sha256 using implementation "sha256-ce" Jan 29 11:14:43.858540 systemd[1]: Found device dev-mapper-usr.device - /dev/mapper/usr. Jan 29 11:14:43.860148 systemd[1]: Mounting sysusr-usr.mount - /sysusr/usr... Jan 29 11:14:43.860868 systemd[1]: Finished verity-setup.service - Verity Setup for /dev/mapper/usr. Jan 29 11:14:43.871595 kernel: BTRFS info (device dm-0): first mount of filesystem b5bc7ecc-f31a-46c7-9582-5efca7819025 Jan 29 11:14:43.871643 kernel: BTRFS info (device dm-0): using crc32c (crc32c-generic) checksum algorithm Jan 29 11:14:43.871653 kernel: BTRFS warning (device dm-0): 'nologreplay' is deprecated, use 'rescue=nologreplay' instead Jan 29 11:14:43.872437 kernel: BTRFS info (device dm-0): disabling log replay at mount time Jan 29 11:14:43.873477 kernel: BTRFS info (device dm-0): using free space tree Jan 29 11:14:43.876891 systemd[1]: Mounted sysusr-usr.mount - /sysusr/usr. Jan 29 11:14:43.878258 systemd[1]: afterburn-network-kargs.service - Afterburn Initrd Setup Network Kernel Arguments was skipped because no trigger condition checks were met. Jan 29 11:14:43.878994 systemd[1]: Starting ignition-setup.service - Ignition (setup)... Jan 29 11:14:43.881226 systemd[1]: Starting parse-ip-for-networkd.service - Write systemd-networkd units from cmdline... Jan 29 11:14:43.894360 kernel: BTRFS info (device vdb6): first mount of filesystem 9c6de53f-d522-4994-b092-a63f342c3ab0 Jan 29 11:14:43.894398 kernel: BTRFS info (device vdb6): using crc32c (crc32c-generic) checksum algorithm Jan 29 11:14:43.894409 kernel: BTRFS info (device vdb6): using free space tree Jan 29 11:14:43.898178 kernel: BTRFS info (device vdb6): auto enabling async discard Jan 29 11:14:43.904268 systemd[1]: mnt-oem.mount: Deactivated successfully. Jan 29 11:14:43.905554 kernel: BTRFS info (device vdb6): last unmount of filesystem 9c6de53f-d522-4994-b092-a63f342c3ab0 Jan 29 11:14:43.911259 systemd[1]: Finished ignition-setup.service - Ignition (setup). Jan 29 11:14:43.918290 systemd[1]: Starting ignition-fetch-offline.service - Ignition (fetch-offline)... Jan 29 11:14:43.980777 systemd[1]: Finished parse-ip-for-networkd.service - Write systemd-networkd units from cmdline. Jan 29 11:14:43.990285 systemd[1]: Starting systemd-networkd.service - Network Configuration... Jan 29 11:14:44.024702 systemd-networkd[760]: lo: Link UP Jan 29 11:14:44.024712 systemd-networkd[760]: lo: Gained carrier Jan 29 11:14:44.025796 systemd-networkd[760]: Enumeration completed Jan 29 11:14:44.026114 systemd[1]: Started systemd-networkd.service - Network Configuration. Jan 29 11:14:44.026301 systemd-networkd[760]: eth0: found matching network '/usr/lib/systemd/network/zz-default.network', based on potentially unpredictable interface name. Jan 29 11:14:44.026304 systemd-networkd[760]: eth0: Configuring with /usr/lib/systemd/network/zz-default.network. Jan 29 11:14:44.031384 ignition[671]: Ignition 2.20.0 Jan 29 11:14:44.027248 systemd-networkd[760]: eth0: Link UP Jan 29 11:14:44.031392 ignition[671]: Stage: fetch-offline Jan 29 11:14:44.027251 systemd-networkd[760]: eth0: Gained carrier Jan 29 11:14:44.031428 ignition[671]: no configs at "/usr/lib/ignition/base.d" Jan 29 11:14:44.027258 systemd-networkd[760]: eth0: found matching network '/usr/lib/systemd/network/zz-default.network', based on potentially unpredictable interface name. Jan 29 11:14:44.031437 ignition[671]: no config dir at "/usr/lib/ignition/base.platform.d/qemu" Jan 29 11:14:44.027775 systemd[1]: Reached target network.target - Network. Jan 29 11:14:44.031588 ignition[671]: parsed url from cmdline: "" Jan 29 11:14:44.031592 ignition[671]: no config URL provided Jan 29 11:14:44.031596 ignition[671]: reading system config file "/usr/lib/ignition/user.ign" Jan 29 11:14:44.031603 ignition[671]: no config at "/usr/lib/ignition/user.ign" Jan 29 11:14:44.031632 ignition[671]: op(1): [started] loading QEMU firmware config module Jan 29 11:14:44.031637 ignition[671]: op(1): executing: "modprobe" "qemu_fw_cfg" Jan 29 11:14:44.039433 ignition[671]: op(1): [finished] loading QEMU firmware config module Jan 29 11:14:44.046131 ignition[671]: parsing config with SHA512: 001f51fb845bc483f0b2d1e8015d04020537db46847eea243877dc3923e0932ffeee403b02ba15ceab7b8a666e84fd396acb0ed6032d07a15c427459a054536e Jan 29 11:14:44.048119 systemd-networkd[760]: eth0: DHCPv4 address 10.0.0.128/16, gateway 10.0.0.1 acquired from 10.0.0.1 Jan 29 11:14:44.049451 unknown[671]: fetched base config from "system" Jan 29 11:14:44.049461 unknown[671]: fetched user config from "qemu" Jan 29 11:14:44.049677 ignition[671]: fetch-offline: fetch-offline passed Jan 29 11:14:44.051402 systemd[1]: Finished ignition-fetch-offline.service - Ignition (fetch-offline). Jan 29 11:14:44.049763 ignition[671]: Ignition finished successfully Jan 29 11:14:44.052924 systemd[1]: ignition-fetch.service - Ignition (fetch) was skipped because of an unmet condition check (ConditionPathExists=!/run/ignition.json). Jan 29 11:14:44.063310 systemd[1]: Starting ignition-kargs.service - Ignition (kargs)... Jan 29 11:14:44.073749 ignition[771]: Ignition 2.20.0 Jan 29 11:14:44.073759 ignition[771]: Stage: kargs Jan 29 11:14:44.073923 ignition[771]: no configs at "/usr/lib/ignition/base.d" Jan 29 11:14:44.073932 ignition[771]: no config dir at "/usr/lib/ignition/base.platform.d/qemu" Jan 29 11:14:44.074633 ignition[771]: kargs: kargs passed Jan 29 11:14:44.074677 ignition[771]: Ignition finished successfully Jan 29 11:14:44.076683 systemd[1]: Finished ignition-kargs.service - Ignition (kargs). Jan 29 11:14:44.080281 systemd[1]: Starting ignition-disks.service - Ignition (disks)... Jan 29 11:14:44.092915 ignition[780]: Ignition 2.20.0 Jan 29 11:14:44.092925 ignition[780]: Stage: disks Jan 29 11:14:44.093091 ignition[780]: no configs at "/usr/lib/ignition/base.d" Jan 29 11:14:44.093100 ignition[780]: no config dir at "/usr/lib/ignition/base.platform.d/qemu" Jan 29 11:14:44.093757 ignition[780]: disks: createLuks: op(1): [started] waiting for devices [/dev/disk/by-partlabel/ROOT] Jan 29 11:14:44.097930 ignition[780]: disks: createLuks: op(1): [finished] waiting for devices [/dev/disk/by-partlabel/ROOT] Jan 29 11:14:44.098997 ignition[780]: disks: createLuks: created device alias for "/dev/disk/by-partlabel/ROOT": "/run/ignition/dev_aliases/dev/disk/by-partlabel/ROOT" -> "/dev/vdb9" Jan 29 11:14:44.099150 ignition[780]: disks: createLuks: op(2): [started] wiping filesystem signatures from "/run/ignition/dev_aliases/dev/disk/by-partlabel/ROOT" Jan 29 11:14:44.099157 ignition[780]: disks: createLuks: op(2): executing: "wipefs" "-a" "/run/ignition/dev_aliases/dev/disk/by-partlabel/ROOT" Jan 29 11:14:44.105436 ignition[780]: disks: createLuks: op(2): [finished] wiping filesystem signatures from "/run/ignition/dev_aliases/dev/disk/by-partlabel/ROOT" Jan 29 11:14:44.105474 ignition[780]: disks: createLuks: op(3): [started] creating "rootencrypted" Jan 29 11:14:44.105485 ignition[780]: disks: createLuks: op(3): executing: "cryptsetup" "luksFormat" "--type" "luks2" "--key-file" "/tmp/ignition-luks-2462465519" "/run/ignition/dev_aliases/dev/disk/by-partlabel/ROOT" Jan 29 11:14:45.314260 systemd-networkd[760]: eth0: Gained IPv6LL Jan 29 11:14:51.052450 ignition[780]: disks: createLuks: op(3): [finished] creating "rootencrypted" Jan 29 11:14:51.052487 ignition[780]: disks: createLuks: op(4): [started] opening luks device rootencrypted Jan 29 11:14:51.052498 ignition[780]: disks: createLuks: op(4): executing: "cryptsetup" "luksOpen" "/run/ignition/dev_aliases/dev/disk/by-partlabel/ROOT" "rootencrypted" "--key-file" "/tmp/ignition-luks-2462465519" "--persistent" Jan 29 11:14:53.060095 kernel: Key type trusted registered Jan 29 11:14:53.062079 kernel: Key type encrypted registered Jan 29 11:14:53.088213 ignition[780]: disks: createLuks: op(4): [finished] opening luks device rootencrypted Jan 29 11:14:53.088272 ignition[780]: disks: createLuks: op(5): [started] waiting for triggered uevent Jan 29 11:14:53.088281 ignition[780]: disks: createLuks: op(5): executing: "udevadm" "trigger" "--settle" "/dev/vdb9" Jan 29 11:14:53.116978 ignition[780]: disks: createLuks: op(5): [finished] waiting for triggered uevent Jan 29 11:14:53.117016 ignition[780]: disks: createFilesystems: op(6): [started] waiting for devices [/dev/mapper/rootencrypted] Jan 29 11:14:53.123424 ignition[780]: disks: createFilesystems: op(6): [finished] waiting for devices [/dev/mapper/rootencrypted] Jan 29 11:14:53.123496 ignition[780]: disks: createFilesystems: created device alias for "/dev/mapper/rootencrypted": "/run/ignition/dev_aliases/dev/mapper/rootencrypted" -> "/dev/dm-1" Jan 29 11:14:53.124013 ignition[780]: disks: createFilesystems: op(7): [started] determining filesystem type of "/dev/mapper/rootencrypted" Jan 29 11:14:53.136443 ignition[780]: disks: createFilesystems: op(7): [finished] determining filesystem type of "/dev/mapper/rootencrypted" Jan 29 11:14:53.136458 ignition[780]: disks: createFilesystems: found filesystem at "/dev/mapper/rootencrypted" with uuid "" and label "" Jan 29 11:14:53.136499 ignition[780]: disks: createFilesystems: op(8): [started] wiping filesystem signatures from "/run/ignition/dev_aliases/dev/mapper/rootencrypted" Jan 29 11:14:53.136506 ignition[780]: disks: createFilesystems: op(8): executing: "wipefs" "-a" "/run/ignition/dev_aliases/dev/mapper/rootencrypted" Jan 29 11:14:53.141706 ignition[780]: disks: createFilesystems: op(8): [finished] wiping filesystem signatures from "/run/ignition/dev_aliases/dev/mapper/rootencrypted" Jan 29 11:14:53.141743 ignition[780]: disks: createFilesystems: op(9): [started] creating "ext4" filesystem on "/run/ignition/dev_aliases/dev/mapper/rootencrypted" Jan 29 11:14:53.141751 ignition[780]: disks: createFilesystems: op(9): executing: "mkfs.ext4" "-F" "-L" "ROOT" "/run/ignition/dev_aliases/dev/mapper/rootencrypted" Jan 29 11:14:53.228896 ignition[780]: disks: createFilesystems: op(9): [finished] creating "ext4" filesystem on "/run/ignition/dev_aliases/dev/mapper/rootencrypted" Jan 29 11:14:53.228963 ignition[780]: disks: createFilesystems: op(a): [started] waiting for triggered uevent Jan 29 11:14:53.228970 ignition[780]: disks: createFilesystems: op(a): executing: "udevadm" "trigger" "--settle" "/dev/dm-1" Jan 29 11:14:53.244062 ignition[780]: disks: createFilesystems: op(a): [finished] waiting for triggered uevent Jan 29 11:14:53.244088 ignition[780]: disks: disks passed Jan 29 11:14:53.244186 ignition[780]: Ignition finished successfully Jan 29 11:14:53.246814 systemd[1]: Finished ignition-disks.service - Ignition (disks). Jan 29 11:14:53.249992 systemd[1]: Reached target initrd-root-device.target - Initrd Root Device. Jan 29 11:14:53.250986 systemd[1]: Reached target local-fs-pre.target - Preparation for Local File Systems. Jan 29 11:14:53.252691 systemd[1]: Reached target local-fs.target - Local File Systems. Jan 29 11:14:53.254334 systemd[1]: Reached target sysinit.target - System Initialization. Jan 29 11:14:53.255651 systemd[1]: Reached target basic.target - Basic System. Jan 29 11:14:53.269224 systemd[1]: Starting systemd-fsck-root.service - File System Check on /dev/disk/by-label/ROOT... Jan 29 11:14:53.280701 systemd-fsck[1648]: ROOT: clean, 11/137360 files, 26629/549376 blocks Jan 29 11:14:53.283012 systemd[1]: Finished systemd-fsck-root.service - File System Check on /dev/disk/by-label/ROOT. Jan 29 11:14:53.285417 systemd[1]: Mounting sysroot.mount - /sysroot... Jan 29 11:14:53.333945 systemd[1]: Mounted sysroot.mount - /sysroot. Jan 29 11:14:53.335213 kernel: EXT4-fs (dm-1): mounted filesystem 3d702c2f-2e35-4867-ae49-d597b9ede2d5 r/w with ordered data mode. Quota mode: none. Jan 29 11:14:53.335045 systemd[1]: Reached target initrd-root-fs.target - Initrd Root File System. Jan 29 11:14:53.345149 systemd[1]: Mounting sysroot-oem.mount - /sysroot/oem... Jan 29 11:14:53.346625 systemd[1]: Mounting sysroot-usr.mount - /sysroot/usr... Jan 29 11:14:53.347920 systemd[1]: flatcar-metadata-hostname.service - Flatcar Metadata Hostname Agent was skipped because no trigger condition checks were met. Jan 29 11:14:53.352124 kernel: BTRFS: device label OEM devid 1 transid 15 /dev/vdb6 scanned by mount (1658) Jan 29 11:14:53.347959 systemd[1]: ignition-remount-sysroot.service - Remount /sysroot read-write for Ignition was skipped because of an unmet condition check (ConditionPathIsReadWrite=!/sysroot). Jan 29 11:14:53.347980 systemd[1]: Reached target ignition-diskful.target - Ignition Boot Disk Setup. Jan 29 11:14:53.356620 kernel: BTRFS info (device vdb6): first mount of filesystem 9c6de53f-d522-4994-b092-a63f342c3ab0 Jan 29 11:14:53.356637 kernel: BTRFS info (device vdb6): using crc32c (crc32c-generic) checksum algorithm Jan 29 11:14:53.356647 kernel: BTRFS info (device vdb6): using free space tree Jan 29 11:14:53.354854 systemd[1]: Mounted sysroot-usr.mount - /sysroot/usr. Jan 29 11:14:53.358525 systemd[1]: Starting initrd-setup-root.service - Root filesystem setup... Jan 29 11:14:53.362086 kernel: BTRFS info (device vdb6): auto enabling async discard Jan 29 11:14:53.363109 systemd[1]: Mounted sysroot-oem.mount - /sysroot/oem. Jan 29 11:14:53.374956 initrd-setup-root[1682]: cut: /sysroot/etc/passwd: No such file or directory Jan 29 11:14:53.378846 initrd-setup-root[1689]: cut: /sysroot/etc/group: No such file or directory Jan 29 11:14:53.381730 initrd-setup-root[1696]: cut: /sysroot/etc/shadow: No such file or directory Jan 29 11:14:53.385466 initrd-setup-root[1703]: cut: /sysroot/etc/gshadow: No such file or directory Jan 29 11:14:53.452223 systemd[1]: Finished initrd-setup-root.service - Root filesystem setup. Jan 29 11:14:53.463227 systemd[1]: Starting ignition-mount.service - Ignition (mount)... Jan 29 11:14:53.464601 systemd[1]: Starting sysroot-boot.service - /sysroot/boot... Jan 29 11:14:53.469110 kernel: BTRFS info (device vdb6): last unmount of filesystem 9c6de53f-d522-4994-b092-a63f342c3ab0 Jan 29 11:14:53.468687 systemd[1]: sysroot-oem.mount: Deactivated successfully. Jan 29 11:14:53.483644 systemd[1]: Finished sysroot-boot.service - /sysroot/boot. Jan 29 11:14:53.486649 ignition[1771]: INFO : Ignition 2.20.0 Jan 29 11:14:53.487607 ignition[1771]: INFO : Stage: mount Jan 29 11:14:53.489131 ignition[1771]: INFO : no configs at "/usr/lib/ignition/base.d" Jan 29 11:14:53.489131 ignition[1771]: INFO : no config dir at "/usr/lib/ignition/base.platform.d/qemu" Jan 29 11:14:53.489131 ignition[1771]: INFO : mount: mount passed Jan 29 11:14:53.491256 ignition[1771]: INFO : Ignition finished successfully Jan 29 11:14:53.493096 systemd[1]: Finished ignition-mount.service - Ignition (mount). Jan 29 11:14:53.502171 systemd[1]: Starting ignition-files.service - Ignition (files)... Jan 29 11:14:54.348258 systemd[1]: Mounting sysroot-oem.mount - /sysroot/oem... Jan 29 11:14:54.354934 kernel: BTRFS: device label OEM devid 1 transid 16 /dev/vdb6 scanned by mount (1785) Jan 29 11:14:54.356705 kernel: BTRFS info (device vdb6): first mount of filesystem 9c6de53f-d522-4994-b092-a63f342c3ab0 Jan 29 11:14:54.356731 kernel: BTRFS info (device vdb6): using crc32c (crc32c-generic) checksum algorithm Jan 29 11:14:54.356748 kernel: BTRFS info (device vdb6): using free space tree Jan 29 11:14:54.359083 kernel: BTRFS info (device vdb6): auto enabling async discard Jan 29 11:14:54.360249 systemd[1]: Mounted sysroot-oem.mount - /sysroot/oem. Jan 29 11:14:54.376640 ignition[1802]: INFO : Ignition 2.20.0 Jan 29 11:14:54.376640 ignition[1802]: INFO : Stage: files Jan 29 11:14:54.378061 ignition[1802]: INFO : no configs at "/usr/lib/ignition/base.d" Jan 29 11:14:54.378061 ignition[1802]: INFO : no config dir at "/usr/lib/ignition/base.platform.d/qemu" Jan 29 11:14:54.378061 ignition[1802]: DEBUG : files: compiled without relabeling support, skipping Jan 29 11:14:54.381105 ignition[1802]: INFO : files: ensureUsers: op(1): [started] creating or modifying user "core" Jan 29 11:14:54.381105 ignition[1802]: DEBUG : files: ensureUsers: op(1): executing: "usermod" "--root" "/sysroot" "core" Jan 29 11:14:54.381105 ignition[1802]: INFO : files: ensureUsers: op(1): [finished] creating or modifying user "core" Jan 29 11:14:54.381105 ignition[1802]: INFO : files: ensureUsers: op(2): [started] adding ssh keys to user "core" Jan 29 11:14:54.381105 ignition[1802]: INFO : files: ensureUsers: op(2): [finished] adding ssh keys to user "core" Jan 29 11:14:54.380579 unknown[1802]: wrote ssh authorized keys file for user: core Jan 29 11:14:54.387236 ignition[1802]: INFO : files: createFilesystemsFiles: createFiles: op(3): [started] writing file "/sysroot/etc/flatcar/update.conf" Jan 29 11:14:54.387236 ignition[1802]: INFO : files: createFilesystemsFiles: createFiles: op(3): [finished] writing file "/sysroot/etc/flatcar/update.conf" Jan 29 11:14:54.387236 ignition[1802]: INFO : files: op(4): [started] processing unit "cryptenroll-helper-first.service" Jan 29 11:14:54.387236 ignition[1802]: INFO : files: op(4): op(5): [started] writing unit "cryptenroll-helper-first.service" at "/sysroot/etc/systemd/system/cryptenroll-helper-first.service" Jan 29 11:14:54.387236 ignition[1802]: INFO : files: op(4): op(5): [finished] writing unit "cryptenroll-helper-first.service" at "/sysroot/etc/systemd/system/cryptenroll-helper-first.service" Jan 29 11:14:54.387236 ignition[1802]: INFO : files: op(4): [finished] processing unit "cryptenroll-helper-first.service" Jan 29 11:14:54.387236 ignition[1802]: INFO : files: op(6): [started] processing unit "cryptenroll-helper-bind.service" Jan 29 11:14:54.387236 ignition[1802]: INFO : files: op(6): op(7): [started] writing unit "cryptenroll-helper-bind.service" at "/sysroot/etc/systemd/system/cryptenroll-helper-bind.service" Jan 29 11:14:54.387236 ignition[1802]: INFO : files: op(6): op(7): [finished] writing unit "cryptenroll-helper-bind.service" at "/sysroot/etc/systemd/system/cryptenroll-helper-bind.service" Jan 29 11:14:54.387236 ignition[1802]: INFO : files: op(6): [finished] processing unit "cryptenroll-helper-bind.service" Jan 29 11:14:54.387236 ignition[1802]: INFO : files: op(8): [started] processing unit "coreos-metadata.service" Jan 29 11:14:54.387236 ignition[1802]: INFO : files: op(8): op(9): [started] writing unit "coreos-metadata.service" at "/sysroot/etc/systemd/system/coreos-metadata.service" Jan 29 11:14:54.387236 ignition[1802]: INFO : files: op(8): op(9): [finished] writing unit "coreos-metadata.service" at "/sysroot/etc/systemd/system/coreos-metadata.service" Jan 29 11:14:54.387236 ignition[1802]: INFO : files: op(8): [finished] processing unit "coreos-metadata.service" Jan 29 11:14:54.387236 ignition[1802]: INFO : files: op(a): [started] setting preset to disabled for "coreos-metadata.service" Jan 29 11:14:54.409641 ignition[1802]: INFO : files: op(a): op(b): [started] removing enablement symlink(s) for "coreos-metadata.service" Jan 29 11:14:54.409641 ignition[1802]: INFO : files: op(a): op(b): [finished] removing enablement symlink(s) for "coreos-metadata.service" Jan 29 11:14:54.409641 ignition[1802]: INFO : files: op(a): [finished] setting preset to disabled for "coreos-metadata.service" Jan 29 11:14:54.409641 ignition[1802]: INFO : files: op(c): [started] setting preset to enabled for "cryptenroll-helper-bind.service" Jan 29 11:14:54.409641 ignition[1802]: INFO : files: op(c): [finished] setting preset to enabled for "cryptenroll-helper-bind.service" Jan 29 11:14:54.409641 ignition[1802]: INFO : files: op(d): [started] setting preset to enabled for "cryptenroll-helper-first.service" Jan 29 11:14:54.409641 ignition[1802]: INFO : files: op(d): [finished] setting preset to enabled for "cryptenroll-helper-first.service" Jan 29 11:14:54.409641 ignition[1802]: INFO : files: createCrypttabEntries: createFiles: op(e): [started] writing file "/sysroot/etc/luks/rootencrypted" Jan 29 11:14:54.409641 ignition[1802]: INFO : files: createCrypttabEntries: createFiles: op(e): [finished] writing file "/sysroot/etc/luks/rootencrypted" Jan 29 11:14:54.409641 ignition[1802]: INFO : files: createCrypttabEntries: createFiles: op(f): [started] writing file "/sysroot/etc/crypttab" Jan 29 11:14:54.409641 ignition[1802]: INFO : files: createCrypttabEntries: createFiles: op(f): [finished] writing file "/sysroot/etc/crypttab" Jan 29 11:14:54.409641 ignition[1802]: INFO : files: createCrypttabEntries: createFiles: op(10): [started] appending to file "/sysroot/etc/crypttab" Jan 29 11:14:54.409641 ignition[1802]: INFO : files: createCrypttabEntries: createFiles: op(10): [finished] appending to file "/sysroot/etc/crypttab" Jan 29 11:14:54.409641 ignition[1802]: INFO : files: createResultFile: createFiles: op(11): [started] writing file "/sysroot/etc/.ignition-result.json" Jan 29 11:14:54.409641 ignition[1802]: INFO : files: createResultFile: createFiles: op(11): [finished] writing file "/sysroot/etc/.ignition-result.json" Jan 29 11:14:54.409641 ignition[1802]: INFO : files: files passed Jan 29 11:14:54.409641 ignition[1802]: INFO : Ignition finished successfully Jan 29 11:14:54.404637 systemd[1]: Finished ignition-files.service - Ignition (files). Jan 29 11:14:54.415212 systemd[1]: Starting ignition-quench.service - Ignition (record completion)... Jan 29 11:14:54.417604 systemd[1]: Starting initrd-setup-root-after-ignition.service - Root filesystem completion... Jan 29 11:14:54.419005 systemd[1]: ignition-quench.service: Deactivated successfully. Jan 29 11:14:54.435774 initrd-setup-root-after-ignition[1831]: grep: /sysroot/oem/oem-release: No such file or directory Jan 29 11:14:54.419103 systemd[1]: Finished ignition-quench.service - Ignition (record completion). Jan 29 11:14:54.437644 initrd-setup-root-after-ignition[1833]: grep: /sysroot/etc/flatcar/enabled-sysext.conf: No such file or directory Jan 29 11:14:54.437644 initrd-setup-root-after-ignition[1833]: grep: /sysroot/usr/share/flatcar/enabled-sysext.conf: No such file or directory Jan 29 11:14:54.431192 systemd[1]: Finished initrd-setup-root-after-ignition.service - Root filesystem completion. Jan 29 11:14:54.440860 initrd-setup-root-after-ignition[1837]: grep: /sysroot/etc/flatcar/enabled-sysext.conf: No such file or directory Jan 29 11:14:54.432776 systemd[1]: Reached target ignition-complete.target - Ignition Complete. Jan 29 11:14:54.442199 systemd[1]: Starting initrd-parse-etc.service - Mountpoints Configured in the Real Root... Jan 29 11:14:54.463593 systemd[1]: initrd-parse-etc.service: Deactivated successfully. Jan 29 11:14:54.463700 systemd[1]: Finished initrd-parse-etc.service - Mountpoints Configured in the Real Root. Jan 29 11:14:54.465417 systemd[1]: Reached target initrd-fs.target - Initrd File Systems. Jan 29 11:14:54.466741 systemd[1]: Reached target initrd.target - Initrd Default Target. Jan 29 11:14:54.468045 systemd[1]: dracut-mount.service - dracut mount hook was skipped because no trigger condition checks were met. Jan 29 11:14:54.468828 systemd[1]: Starting dracut-pre-pivot.service - dracut pre-pivot and cleanup hook... Jan 29 11:14:54.484087 systemd[1]: Finished dracut-pre-pivot.service - dracut pre-pivot and cleanup hook. Jan 29 11:14:54.486207 systemd[1]: Starting initrd-cleanup.service - Cleaning Up and Shutting Down Daemons... Jan 29 11:14:54.497463 systemd[1]: Stopped target nss-lookup.target - Host and Network Name Lookups. Jan 29 11:14:54.498422 systemd[1]: Stopped target remote-cryptsetup.target - Remote Encrypted Volumes. Jan 29 11:14:54.499927 systemd[1]: Stopped target timers.target - Timer Units. Jan 29 11:14:54.501245 systemd[1]: dracut-pre-pivot.service: Deactivated successfully. Jan 29 11:14:54.501361 systemd[1]: Stopped dracut-pre-pivot.service - dracut pre-pivot and cleanup hook. Jan 29 11:14:54.503191 systemd[1]: Stopped target initrd.target - Initrd Default Target. Jan 29 11:14:54.504643 systemd[1]: Stopped target basic.target - Basic System. Jan 29 11:14:54.505837 systemd[1]: Stopped target ignition-complete.target - Ignition Complete. Jan 29 11:14:54.507083 systemd[1]: Stopped target ignition-diskful.target - Ignition Boot Disk Setup. Jan 29 11:14:54.508583 systemd[1]: Stopped target initrd-root-device.target - Initrd Root Device. Jan 29 11:14:54.510041 systemd[1]: Stopped target remote-fs.target - Remote File Systems. Jan 29 11:14:54.511408 systemd[1]: Stopped target remote-fs-pre.target - Preparation for Remote File Systems. Jan 29 11:14:54.512906 systemd[1]: Stopped target sysinit.target - System Initialization. Jan 29 11:14:54.514382 systemd[1]: Stopped target local-fs.target - Local File Systems. Jan 29 11:14:54.515663 systemd[1]: Stopped target swap.target - Swaps. Jan 29 11:14:54.516826 systemd[1]: dracut-pre-mount.service: Deactivated successfully. Jan 29 11:14:54.516946 systemd[1]: Stopped dracut-pre-mount.service - dracut pre-mount hook. Jan 29 11:14:54.518673 systemd[1]: Stopped target cryptsetup.target - Local Encrypted Volumes. Jan 29 11:14:54.520144 systemd[1]: Stopped target cryptsetup-pre.target - Local Encrypted Volumes (Pre). Jan 29 11:14:54.521586 systemd[1]: clevis-luks-askpass.path: Deactivated successfully. Jan 29 11:14:54.521679 systemd[1]: Stopped clevis-luks-askpass.path - Forward Password Requests to Clevis Directory Watch. Jan 29 11:14:54.523215 systemd[1]: dracut-initqueue.service: Deactivated successfully. Jan 29 11:14:54.523326 systemd[1]: Stopped dracut-initqueue.service - dracut initqueue hook. Jan 29 11:14:54.525398 systemd[1]: ignition-fetch-offline.service: Deactivated successfully. Jan 29 11:14:54.525510 systemd[1]: Stopped ignition-fetch-offline.service - Ignition (fetch-offline). Jan 29 11:14:54.526929 systemd[1]: Stopped target paths.target - Path Units. Jan 29 11:14:54.528097 systemd[1]: systemd-ask-password-console.path: Deactivated successfully. Jan 29 11:14:54.533112 systemd[1]: Stopped systemd-ask-password-console.path - Dispatch Password Requests to Console Directory Watch. Jan 29 11:14:54.534113 systemd[1]: Stopped target slices.target - Slice Units. Jan 29 11:14:54.535787 systemd[1]: Stopped target sockets.target - Socket Units. Jan 29 11:14:54.536971 systemd[1]: iscsid.socket: Deactivated successfully. Jan 29 11:14:54.537060 systemd[1]: Closed iscsid.socket - Open-iSCSI iscsid Socket. Jan 29 11:14:54.538233 systemd[1]: iscsiuio.socket: Deactivated successfully. Jan 29 11:14:54.538311 systemd[1]: Closed iscsiuio.socket - Open-iSCSI iscsiuio Socket. Jan 29 11:14:54.539470 systemd[1]: initrd-setup-root-after-ignition.service: Deactivated successfully. Jan 29 11:14:54.539571 systemd[1]: Stopped initrd-setup-root-after-ignition.service - Root filesystem completion. Jan 29 11:14:54.540890 systemd[1]: ignition-files.service: Deactivated successfully. Jan 29 11:14:54.540983 systemd[1]: Stopped ignition-files.service - Ignition (files). Jan 29 11:14:54.553253 systemd[1]: Stopping ignition-mount.service - Ignition (mount)... Jan 29 11:14:54.553962 systemd[1]: kmod-static-nodes.service: Deactivated successfully. Jan 29 11:14:54.554105 systemd[1]: Stopped kmod-static-nodes.service - Create List of Static Device Nodes. Jan 29 11:14:54.559306 systemd[1]: Stopping sysroot-boot.service - /sysroot/boot... Jan 29 11:14:54.559971 systemd[1]: systemd-udev-trigger.service: Deactivated successfully. Jan 29 11:14:54.560238 systemd[1]: Stopped systemd-udev-trigger.service - Coldplug All udev Devices. Jan 29 11:14:54.561596 systemd[1]: dracut-pre-trigger.service: Deactivated successfully. Jan 29 11:14:54.561735 systemd[1]: Stopped dracut-pre-trigger.service - dracut pre-trigger hook. Jan 29 11:14:54.566555 ignition[1858]: INFO : Ignition 2.20.0 Jan 29 11:14:54.566555 ignition[1858]: INFO : Stage: umount Jan 29 11:14:54.566555 ignition[1858]: INFO : no configs at "/usr/lib/ignition/base.d" Jan 29 11:14:54.566555 ignition[1858]: INFO : no config dir at "/usr/lib/ignition/base.platform.d/qemu" Jan 29 11:14:54.566555 ignition[1858]: INFO : umount: umount passed Jan 29 11:14:54.566555 ignition[1858]: INFO : Ignition finished successfully Jan 29 11:14:54.566692 systemd[1]: initrd-cleanup.service: Deactivated successfully. Jan 29 11:14:54.566777 systemd[1]: Finished initrd-cleanup.service - Cleaning Up and Shutting Down Daemons. Jan 29 11:14:54.571588 systemd[1]: ignition-mount.service: Deactivated successfully. Jan 29 11:14:54.572659 systemd[1]: Stopped ignition-mount.service - Ignition (mount). Jan 29 11:14:54.574400 systemd[1]: Stopped target network.target - Network. Jan 29 11:14:54.575594 systemd[1]: ignition-disks.service: Deactivated successfully. Jan 29 11:14:54.575656 systemd[1]: Stopped ignition-disks.service - Ignition (disks). Jan 29 11:14:54.577227 systemd[1]: ignition-kargs.service: Deactivated successfully. Jan 29 11:14:54.577271 systemd[1]: Stopped ignition-kargs.service - Ignition (kargs). Jan 29 11:14:54.578564 systemd[1]: ignition-setup.service: Deactivated successfully. Jan 29 11:14:54.578604 systemd[1]: Stopped ignition-setup.service - Ignition (setup). Jan 29 11:14:54.579825 systemd[1]: ignition-setup-pre.service: Deactivated successfully. Jan 29 11:14:54.579863 systemd[1]: Stopped ignition-setup-pre.service - Ignition env setup. Jan 29 11:14:54.581230 systemd[1]: Stopping systemd-networkd.service - Network Configuration... Jan 29 11:14:54.582421 systemd[1]: Stopping systemd-resolved.service - Network Name Resolution... Jan 29 11:14:54.584393 systemd[1]: sysroot-boot.mount: Deactivated successfully. Jan 29 11:14:54.584856 systemd[1]: sysroot-boot.service: Deactivated successfully. Jan 29 11:14:54.584939 systemd[1]: Stopped sysroot-boot.service - /sysroot/boot. Jan 29 11:14:54.586733 systemd[1]: initrd-setup-root.service: Deactivated successfully. Jan 29 11:14:54.586826 systemd[1]: Stopped initrd-setup-root.service - Root filesystem setup. Jan 29 11:14:54.590101 systemd-networkd[760]: eth0: DHCPv6 lease lost Jan 29 11:14:54.591812 systemd[1]: systemd-networkd.service: Deactivated successfully. Jan 29 11:14:54.591908 systemd[1]: Stopped systemd-networkd.service - Network Configuration. Jan 29 11:14:54.593668 systemd[1]: systemd-resolved.service: Deactivated successfully. Jan 29 11:14:54.593776 systemd[1]: Stopped systemd-resolved.service - Network Name Resolution. Jan 29 11:14:54.596216 systemd[1]: systemd-networkd.socket: Deactivated successfully. Jan 29 11:14:54.596265 systemd[1]: Closed systemd-networkd.socket - Network Service Netlink Socket. Jan 29 11:14:54.609203 systemd[1]: Stopping network-cleanup.service - Network Cleanup... Jan 29 11:14:54.609945 systemd[1]: parse-ip-for-networkd.service: Deactivated successfully. Jan 29 11:14:54.610002 systemd[1]: Stopped parse-ip-for-networkd.service - Write systemd-networkd units from cmdline. Jan 29 11:14:54.611439 systemd[1]: systemd-sysctl.service: Deactivated successfully. Jan 29 11:14:54.611477 systemd[1]: Stopped systemd-sysctl.service - Apply Kernel Variables. Jan 29 11:14:54.612785 systemd[1]: systemd-modules-load.service: Deactivated successfully. Jan 29 11:14:54.612835 systemd[1]: Stopped systemd-modules-load.service - Load Kernel Modules. Jan 29 11:14:54.614446 systemd[1]: systemd-tmpfiles-setup.service: Deactivated successfully. Jan 29 11:14:54.614484 systemd[1]: Stopped systemd-tmpfiles-setup.service - Create System Files and Directories. Jan 29 11:14:54.615913 systemd[1]: Stopping systemd-udevd.service - Rule-based Manager for Device Events and Files... Jan 29 11:14:54.624261 systemd[1]: network-cleanup.service: Deactivated successfully. Jan 29 11:14:54.624370 systemd[1]: Stopped network-cleanup.service - Network Cleanup. Jan 29 11:14:54.634743 systemd[1]: systemd-udevd.service: Deactivated successfully. Jan 29 11:14:54.634891 systemd[1]: Stopped systemd-udevd.service - Rule-based Manager for Device Events and Files. Jan 29 11:14:54.636612 systemd[1]: systemd-udevd-control.socket: Deactivated successfully. Jan 29 11:14:54.636650 systemd[1]: Closed systemd-udevd-control.socket - udev Control Socket. Jan 29 11:14:54.637847 systemd[1]: systemd-udevd-kernel.socket: Deactivated successfully. Jan 29 11:14:54.637876 systemd[1]: Closed systemd-udevd-kernel.socket - udev Kernel Socket. Jan 29 11:14:54.639251 systemd[1]: dracut-pre-udev.service: Deactivated successfully. Jan 29 11:14:54.639295 systemd[1]: Stopped dracut-pre-udev.service - dracut pre-udev hook. Jan 29 11:14:54.641334 systemd[1]: dracut-cmdline.service: Deactivated successfully. Jan 29 11:14:54.641375 systemd[1]: Stopped dracut-cmdline.service - dracut cmdline hook. Jan 29 11:14:54.643299 systemd[1]: dracut-cmdline-ask.service: Deactivated successfully. Jan 29 11:14:54.643342 systemd[1]: Stopped dracut-cmdline-ask.service - dracut ask for additional cmdline parameters. Jan 29 11:14:54.663219 systemd[1]: Starting initrd-udevadm-cleanup-db.service - Cleanup udev Database... Jan 29 11:14:54.663997 systemd[1]: systemd-tmpfiles-setup-dev.service: Deactivated successfully. Jan 29 11:14:54.664051 systemd[1]: Stopped systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev. Jan 29 11:14:54.665642 systemd[1]: systemd-vconsole-setup.service: Deactivated successfully. Jan 29 11:14:54.665684 systemd[1]: Stopped systemd-vconsole-setup.service - Virtual Console Setup. Jan 29 11:14:54.670726 systemd[1]: initrd-udevadm-cleanup-db.service: Deactivated successfully. Jan 29 11:14:54.670835 systemd[1]: Finished initrd-udevadm-cleanup-db.service - Cleanup udev Database. Jan 29 11:14:54.672505 systemd[1]: Reached target initrd-switch-root.target - Switch Root. Jan 29 11:14:54.675482 systemd[1]: Starting initrd-switch-root.service - Switch Root... Jan 29 11:14:54.683038 systemd[1]: Switching root. Jan 29 11:14:54.711225 systemd-journald[239]: Journal stopped Jan 29 11:14:55.318169 systemd-journald[239]: Received SIGTERM from PID 1 (systemd). Jan 29 11:14:55.318227 kernel: SELinux: policy capability network_peer_controls=1 Jan 29 11:14:55.318238 kernel: SELinux: policy capability open_perms=1 Jan 29 11:14:55.318248 kernel: SELinux: policy capability extended_socket_class=1 Jan 29 11:14:55.318258 kernel: SELinux: policy capability always_check_network=0 Jan 29 11:14:55.318267 kernel: SELinux: policy capability cgroup_seclabel=1 Jan 29 11:14:55.318277 kernel: SELinux: policy capability nnp_nosuid_transition=1 Jan 29 11:14:55.318287 kernel: SELinux: policy capability genfs_seclabel_symlinks=0 Jan 29 11:14:55.318299 kernel: SELinux: policy capability ioctl_skip_cloexec=0 Jan 29 11:14:55.318308 kernel: audit: type=1403 audit(1738149294.778:2): auid=4294967295 ses=4294967295 lsm=selinux res=1 Jan 29 11:14:55.318319 systemd[1]: Successfully loaded SELinux policy in 34.921ms. Jan 29 11:14:55.318339 systemd[1]: Relabeled /dev, /dev/shm, /run, /sys/fs/cgroup in 10.083ms. Jan 29 11:14:55.318351 systemd[1]: systemd 255 running in system mode (+PAM +AUDIT +SELINUX -APPARMOR +IMA +SMACK +SECCOMP +GCRYPT -GNUTLS +OPENSSL -ACL +BLKID +CURL +ELFUTILS -FIDO2 +IDN2 -IDN +IPTC +KMOD +LIBCRYPTSETUP +LIBFDISK +PCRE2 -PWQUALITY -P11KIT -QRENCODE +TPM2 +BZIP2 +LZ4 +XZ +ZLIB +ZSTD -BPF_FRAMEWORK -XKBCOMMON +UTMP -SYSVINIT default-hierarchy=unified) Jan 29 11:14:55.318363 systemd[1]: Detected virtualization kvm. Jan 29 11:14:55.318375 systemd[1]: Detected architecture arm64. Jan 29 11:14:55.318385 systemd[1]: Detected first boot. Jan 29 11:14:55.318398 systemd[1]: Initializing machine ID from VM UUID. Jan 29 11:14:55.318408 zram_generator::config[1904]: No configuration found. Jan 29 11:14:55.318419 systemd[1]: Populated /etc with preset unit settings. Jan 29 11:14:55.318433 systemd[1]: initrd-switch-root.service: Deactivated successfully. Jan 29 11:14:55.318443 systemd[1]: Stopped initrd-switch-root.service - Switch Root. Jan 29 11:14:55.318454 systemd[1]: systemd-journald.service: Scheduled restart job, restart counter is at 1. Jan 29 11:14:55.318470 systemd[1]: Created slice system-addon\x2dconfig.slice - Slice /system/addon-config. Jan 29 11:14:55.318480 systemd[1]: Created slice system-addon\x2drun.slice - Slice /system/addon-run. Jan 29 11:14:55.318491 systemd[1]: Created slice system-getty.slice - Slice /system/getty. Jan 29 11:14:55.318501 systemd[1]: Created slice system-modprobe.slice - Slice /system/modprobe. Jan 29 11:14:55.318512 systemd[1]: Created slice system-serial\x2dgetty.slice - Slice /system/serial-getty. Jan 29 11:14:55.318522 systemd[1]: Created slice system-system\x2dcloudinit.slice - Slice /system/system-cloudinit. Jan 29 11:14:55.318532 systemd[1]: Created slice system-systemd\x2dcryptsetup.slice - Encrypted Volume Units Service Slice. Jan 29 11:14:55.318543 systemd[1]: Created slice system-systemd\x2dfsck.slice - Slice /system/systemd-fsck. Jan 29 11:14:55.318554 systemd[1]: Created slice user.slice - User and Session Slice. Jan 29 11:14:55.318564 systemd[1]: Started clevis-luks-askpass.path - Forward Password Requests to Clevis Directory Watch. Jan 29 11:14:55.318575 systemd[1]: Started systemd-ask-password-console.path - Dispatch Password Requests to Console Directory Watch. Jan 29 11:14:55.318585 systemd[1]: Started systemd-ask-password-wall.path - Forward Password Requests to Wall Directory Watch. Jan 29 11:14:55.318596 systemd[1]: Set up automount boot.automount - Boot partition Automount Point. Jan 29 11:14:55.318606 systemd[1]: Set up automount proc-sys-fs-binfmt_misc.automount - Arbitrary Executable File Formats File System Automount Point. Jan 29 11:14:55.318616 systemd[1]: Expecting device dev-disk-by\x2dlabel-OEM.device - /dev/disk/by-label/OEM... Jan 29 11:14:55.318628 systemd[1]: Expecting device dev-disk-by\x2duuid-46e18de8\x2df34f\x2d418c\x2d86f8\x2d742425a13ab8.device - /dev/disk/by-uuid/46e18de8-f34f-418c-86f8-742425a13ab8... Jan 29 11:14:55.318638 systemd[1]: Expecting device dev-ttyAMA0.device - /dev/ttyAMA0... Jan 29 11:14:55.318650 systemd[1]: Reached target cryptsetup-pre.target - Local Encrypted Volumes (Pre). Jan 29 11:14:55.318660 systemd[1]: Stopped target initrd-switch-root.target - Switch Root. Jan 29 11:14:55.318671 systemd[1]: Stopped target initrd-fs.target - Initrd File Systems. Jan 29 11:14:55.318681 systemd[1]: Stopped target initrd-root-fs.target - Initrd Root File System. Jan 29 11:14:55.318691 systemd[1]: Reached target integritysetup.target - Local Integrity Protected Volumes. Jan 29 11:14:55.318701 systemd[1]: Reached target remote-cryptsetup.target - Remote Encrypted Volumes. Jan 29 11:14:55.318711 systemd[1]: Reached target remote-fs.target - Remote File Systems. Jan 29 11:14:55.318721 systemd[1]: Reached target slices.target - Slice Units. Jan 29 11:14:55.318733 systemd[1]: Reached target swap.target - Swaps. Jan 29 11:14:55.318744 systemd[1]: Reached target veritysetup.target - Local Verity Protected Volumes. Jan 29 11:14:55.318754 systemd[1]: Listening on systemd-coredump.socket - Process Core Dump Socket. Jan 29 11:14:55.318764 systemd[1]: Listening on systemd-networkd.socket - Network Service Netlink Socket. Jan 29 11:14:55.318775 systemd[1]: Listening on systemd-udevd-control.socket - udev Control Socket. Jan 29 11:14:55.318785 systemd[1]: Listening on systemd-udevd-kernel.socket - udev Kernel Socket. Jan 29 11:14:55.318801 systemd[1]: Listening on systemd-userdbd.socket - User Database Manager Socket. Jan 29 11:14:55.318813 systemd[1]: Mounting dev-hugepages.mount - Huge Pages File System... Jan 29 11:14:55.318823 systemd[1]: Mounting dev-mqueue.mount - POSIX Message Queue File System... Jan 29 11:14:55.318835 systemd[1]: Mounting media.mount - External Media Directory... Jan 29 11:14:55.318846 systemd[1]: Mounting sys-kernel-debug.mount - Kernel Debug File System... Jan 29 11:14:55.318857 systemd[1]: Mounting sys-kernel-tracing.mount - Kernel Trace File System... Jan 29 11:14:55.318867 systemd[1]: Mounting tmp.mount - Temporary Directory /tmp... Jan 29 11:14:55.318877 systemd[1]: var-lib-machines.mount - Virtual Machine and Container Storage (Compatibility) was skipped because of an unmet condition check (ConditionPathExists=/var/lib/machines.raw). Jan 29 11:14:55.318887 systemd[1]: Reached target machines.target - Containers. Jan 29 11:14:55.318897 systemd[1]: Starting flatcar-tmpfiles.service - Create missing system files... Jan 29 11:14:55.318908 systemd[1]: ignition-delete-config.service - Ignition (delete config) was skipped because no trigger condition checks were met. Jan 29 11:14:55.318920 systemd[1]: Starting kmod-static-nodes.service - Create List of Static Device Nodes... Jan 29 11:14:55.318931 systemd[1]: Starting modprobe@configfs.service - Load Kernel Module configfs... Jan 29 11:14:55.318944 systemd[1]: Starting modprobe@dm_mod.service - Load Kernel Module dm_mod... Jan 29 11:14:55.318954 systemd[1]: Starting modprobe@drm.service - Load Kernel Module drm... Jan 29 11:14:55.318964 systemd[1]: Starting modprobe@efi_pstore.service - Load Kernel Module efi_pstore... Jan 29 11:14:55.318975 systemd[1]: Starting modprobe@fuse.service - Load Kernel Module fuse... Jan 29 11:14:55.318985 systemd[1]: Starting modprobe@loop.service - Load Kernel Module loop... Jan 29 11:14:55.318995 systemd[1]: setup-nsswitch.service - Create /etc/nsswitch.conf was skipped because of an unmet condition check (ConditionPathExists=!/etc/nsswitch.conf). Jan 29 11:14:55.319006 systemd[1]: systemd-fsck-root.service: Deactivated successfully. Jan 29 11:14:55.319017 systemd[1]: Stopped systemd-fsck-root.service - File System Check on Root Device. Jan 29 11:14:55.319028 systemd[1]: systemd-fsck-usr.service: Deactivated successfully. Jan 29 11:14:55.319038 systemd[1]: Stopped systemd-fsck-usr.service. Jan 29 11:14:55.319048 systemd[1]: Starting systemd-journald.service - Journal Service... Jan 29 11:14:55.319058 kernel: ACPI: bus type drm_connector registered Jan 29 11:14:55.319087 kernel: fuse: init (API version 7.39) Jan 29 11:14:55.319100 systemd[1]: Starting systemd-modules-load.service - Load Kernel Modules... Jan 29 11:14:55.319110 kernel: loop: module loaded Jan 29 11:14:55.319120 systemd[1]: Starting systemd-network-generator.service - Generate network units from Kernel command line... Jan 29 11:14:55.319133 systemd[1]: Starting systemd-remount-fs.service - Remount Root and Kernel File Systems... Jan 29 11:14:55.319145 systemd[1]: Starting systemd-udev-trigger.service - Coldplug All udev Devices... Jan 29 11:14:55.319156 systemd[1]: verity-setup.service: Deactivated successfully. Jan 29 11:14:55.319165 systemd[1]: Stopped verity-setup.service. Jan 29 11:14:55.319175 systemd[1]: Mounted dev-hugepages.mount - Huge Pages File System. Jan 29 11:14:55.319186 systemd[1]: Mounted dev-mqueue.mount - POSIX Message Queue File System. Jan 29 11:14:55.319200 systemd[1]: Mounted media.mount - External Media Directory. Jan 29 11:14:55.319228 systemd-journald[1975]: Collecting audit messages is disabled. Jan 29 11:14:55.319252 systemd[1]: Mounted sys-kernel-debug.mount - Kernel Debug File System. Jan 29 11:14:55.319265 systemd-journald[1975]: Journal started Jan 29 11:14:55.319286 systemd-journald[1975]: Runtime Journal (/run/log/journal/26241df84bea4e8d8f434986b14b8294) is 5.9M, max 47.3M, 41.4M free. Jan 29 11:14:55.140239 systemd[1]: Queued start job for default target multi-user.target. Jan 29 11:14:55.154918 systemd[1]: Unnecessary job was removed for dev-vdb6.device - /dev/vdb6. Jan 29 11:14:55.155295 systemd[1]: systemd-journald.service: Deactivated successfully. Jan 29 11:14:55.321098 systemd[1]: Started systemd-journald.service - Journal Service. Jan 29 11:14:55.321436 systemd[1]: Mounted sys-kernel-tracing.mount - Kernel Trace File System. Jan 29 11:14:55.322678 systemd[1]: Mounted tmp.mount - Temporary Directory /tmp. Jan 29 11:14:55.323799 systemd[1]: Finished flatcar-tmpfiles.service - Create missing system files. Jan 29 11:14:55.324982 systemd[1]: Finished kmod-static-nodes.service - Create List of Static Device Nodes. Jan 29 11:14:55.326254 systemd[1]: modprobe@configfs.service: Deactivated successfully. Jan 29 11:14:55.326385 systemd[1]: Finished modprobe@configfs.service - Load Kernel Module configfs. Jan 29 11:14:55.327602 systemd[1]: modprobe@dm_mod.service: Deactivated successfully. Jan 29 11:14:55.327753 systemd[1]: Finished modprobe@dm_mod.service - Load Kernel Module dm_mod. Jan 29 11:14:55.328846 systemd[1]: modprobe@drm.service: Deactivated successfully. Jan 29 11:14:55.328985 systemd[1]: Finished modprobe@drm.service - Load Kernel Module drm. Jan 29 11:14:55.330097 systemd[1]: modprobe@efi_pstore.service: Deactivated successfully. Jan 29 11:14:55.330228 systemd[1]: Finished modprobe@efi_pstore.service - Load Kernel Module efi_pstore. Jan 29 11:14:55.331867 systemd[1]: modprobe@fuse.service: Deactivated successfully. Jan 29 11:14:55.332002 systemd[1]: Finished modprobe@fuse.service - Load Kernel Module fuse. Jan 29 11:14:55.333141 systemd[1]: modprobe@loop.service: Deactivated successfully. Jan 29 11:14:55.333269 systemd[1]: Finished modprobe@loop.service - Load Kernel Module loop. Jan 29 11:14:55.334300 systemd[1]: Finished systemd-modules-load.service - Load Kernel Modules. Jan 29 11:14:55.335357 systemd[1]: Finished systemd-network-generator.service - Generate network units from Kernel command line. Jan 29 11:14:55.336598 systemd[1]: Finished systemd-remount-fs.service - Remount Root and Kernel File Systems. Jan 29 11:14:55.348344 systemd[1]: Reached target network-pre.target - Preparation for Network. Jan 29 11:14:55.355185 systemd[1]: Mounting sys-fs-fuse-connections.mount - FUSE Control File System... Jan 29 11:14:55.357046 systemd[1]: Mounting sys-kernel-config.mount - Kernel Configuration File System... Jan 29 11:14:55.358224 systemd[1]: remount-root.service - Remount Root File System was skipped because of an unmet condition check (ConditionPathIsReadWrite=!/). Jan 29 11:14:55.358266 systemd[1]: Reached target local-fs.target - Local File Systems. Jan 29 11:14:55.359963 systemd[1]: Listening on systemd-sysext.socket - System Extension Image Management (Varlink). Jan 29 11:14:55.362275 systemd[1]: Starting dracut-shutdown.service - Restore /run/initramfs on shutdown... Jan 29 11:14:55.364208 systemd[1]: Starting ldconfig.service - Rebuild Dynamic Linker Cache... Jan 29 11:14:55.365122 systemd[1]: systemd-binfmt.service - Set Up Additional Binary Formats was skipped because no trigger condition checks were met. Jan 29 11:14:55.366489 systemd[1]: Starting systemd-hwdb-update.service - Rebuild Hardware Database... Jan 29 11:14:55.369454 systemd[1]: Starting systemd-journal-flush.service - Flush Journal to Persistent Storage... Jan 29 11:14:55.370439 systemd[1]: systemd-pstore.service - Platform Persistent Storage Archival was skipped because of an unmet condition check (ConditionDirectoryNotEmpty=/sys/fs/pstore). Jan 29 11:14:55.375111 systemd[1]: Starting systemd-random-seed.service - Load/Save OS Random Seed... Jan 29 11:14:55.376115 systemd[1]: systemd-repart.service - Repartition Root Disk was skipped because no trigger condition checks were met. Jan 29 11:14:55.378184 systemd-journald[1975]: Time spent on flushing to /var/log/journal/26241df84bea4e8d8f434986b14b8294 is 11.916ms for 878 entries. Jan 29 11:14:55.378184 systemd-journald[1975]: System Journal (/var/log/journal/26241df84bea4e8d8f434986b14b8294) is 8.0M, max 204.2M, 196.1M free. Jan 29 11:14:55.396857 systemd-journald[1975]: Received client request to flush runtime journal. Jan 29 11:14:55.396893 kernel: loop0: detected capacity change from 0 to 116808 Jan 29 11:14:55.380312 systemd[1]: Starting systemd-sysctl.service - Apply Kernel Variables... Jan 29 11:14:55.382367 systemd[1]: Starting systemd-sysext.service - Merge System Extension Images into /usr/ and /opt/... Jan 29 11:14:55.387321 systemd[1]: Starting systemd-sysusers.service - Create System Users... Jan 29 11:14:55.392502 systemd[1]: Finished systemd-udev-trigger.service - Coldplug All udev Devices. Jan 29 11:14:55.397311 systemd[1]: Mounted sys-fs-fuse-connections.mount - FUSE Control File System. Jan 29 11:14:55.398554 systemd[1]: Mounted sys-kernel-config.mount - Kernel Configuration File System. Jan 29 11:14:55.406108 kernel: squashfs: version 4.0 (2009/01/31) Phillip Lougher Jan 29 11:14:55.411869 systemd[1]: Finished dracut-shutdown.service - Restore /run/initramfs on shutdown. Jan 29 11:14:55.413904 systemd[1]: Finished systemd-journal-flush.service - Flush Journal to Persistent Storage. Jan 29 11:14:55.417246 systemd[1]: Finished systemd-random-seed.service - Load/Save OS Random Seed. Jan 29 11:14:55.424996 systemd[1]: Reached target first-boot-complete.target - First Boot Complete. Jan 29 11:14:55.428537 kernel: loop1: detected capacity change from 0 to 113536 Jan 29 11:14:55.436276 systemd[1]: Starting systemd-machine-id-commit.service - Commit a transient machine-id on disk... Jan 29 11:14:55.441260 systemd[1]: Starting systemd-udev-settle.service - Wait for udev To Complete Device Initialization... Jan 29 11:14:55.442618 systemd[1]: Finished systemd-sysctl.service - Apply Kernel Variables. Jan 29 11:14:55.443767 systemd[1]: Finished systemd-sysusers.service - Create System Users. Jan 29 11:14:55.453385 systemd[1]: Starting systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev... Jan 29 11:14:55.461165 udevadm[2032]: systemd-udev-settle.service is deprecated. Please fix lvm2-activation-early.service, lvm2-activation.service not to pull it in. Jan 29 11:14:55.463535 systemd[1]: etc-machine\x2did.mount: Deactivated successfully. Jan 29 11:14:55.464216 systemd[1]: Finished systemd-machine-id-commit.service - Commit a transient machine-id on disk. Jan 29 11:14:55.466146 kernel: loop2: detected capacity change from 0 to 116808 Jan 29 11:14:55.471086 kernel: loop3: detected capacity change from 0 to 113536 Jan 29 11:14:55.476739 (sd-merge)[2037]: Using extensions 'containerd-flatcar', 'docker-flatcar'. Jan 29 11:14:55.478970 (sd-merge)[2037]: Merged extensions into '/usr'. Jan 29 11:14:55.484189 systemd[1]: Finished systemd-sysext.service - Merge System Extension Images into /usr/ and /opt/. Jan 29 11:14:55.495924 systemd-tmpfiles[2036]: ACLs are not supported, ignoring. Jan 29 11:14:55.495939 systemd-tmpfiles[2036]: ACLs are not supported, ignoring. Jan 29 11:14:55.499314 systemd[1]: Starting ensure-sysext.service... Jan 29 11:14:55.501252 systemd[1]: Starting systemd-tmpfiles-setup.service - Create System Files and Directories... Jan 29 11:14:55.502685 systemd[1]: Finished systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev. Jan 29 11:14:55.514456 systemd[1]: Reloading requested from client PID 2041 ('systemctl') (unit ensure-sysext.service)... Jan 29 11:14:55.514473 systemd[1]: Reloading... Jan 29 11:14:55.531248 systemd-tmpfiles[2043]: /usr/lib/tmpfiles.d/provision.conf:20: Duplicate line for path "/root", ignoring. Jan 29 11:14:55.531462 systemd-tmpfiles[2043]: /usr/lib/tmpfiles.d/systemd-flatcar.conf:6: Duplicate line for path "/var/log/journal", ignoring. Jan 29 11:14:55.532041 systemd-tmpfiles[2043]: /usr/lib/tmpfiles.d/systemd.conf:29: Duplicate line for path "/var/lib/systemd", ignoring. Jan 29 11:14:55.532250 systemd-tmpfiles[2043]: ACLs are not supported, ignoring. Jan 29 11:14:55.532294 systemd-tmpfiles[2043]: ACLs are not supported, ignoring. Jan 29 11:14:55.537252 systemd-tmpfiles[2043]: Detected autofs mount point /boot during canonicalization of boot. Jan 29 11:14:55.537264 systemd-tmpfiles[2043]: Skipping /boot Jan 29 11:14:55.550833 systemd-tmpfiles[2043]: Detected autofs mount point /boot during canonicalization of boot. Jan 29 11:14:55.550846 systemd-tmpfiles[2043]: Skipping /boot Jan 29 11:14:55.568088 zram_generator::config[2072]: No configuration found. Jan 29 11:14:55.654160 ldconfig[2011]: /sbin/ldconfig: /usr/lib/ld.so.conf is not an ELF file - it has the wrong magic bytes at the start. Jan 29 11:14:55.682514 systemd[1]: /usr/lib/systemd/system/docker.socket:6: ListenStream= references a path below legacy directory /var/run/, updating /var/run/docker.sock → /run/docker.sock; please update the unit file accordingly. Jan 29 11:14:55.721821 systemd[1]: Reloading finished in 207 ms. Jan 29 11:14:55.753137 systemd[1]: Finished ldconfig.service - Rebuild Dynamic Linker Cache. Jan 29 11:14:55.762581 systemd[1]: Finished systemd-tmpfiles-setup.service - Create System Files and Directories. Jan 29 11:14:55.768538 systemd[1]: Starting audit-rules.service - Load Audit Rules... Jan 29 11:14:55.770917 systemd[1]: Starting clean-ca-certificates.service - Clean up broken links in /etc/ssl/certs... Jan 29 11:14:55.775836 systemd[1]: Starting systemd-journal-catalog-update.service - Rebuild Journal Catalog... Jan 29 11:14:55.779505 systemd[1]: Starting systemd-resolved.service - Network Name Resolution... Jan 29 11:14:55.781656 systemd[1]: Starting systemd-update-utmp.service - Record System Boot/Shutdown in UTMP... Jan 29 11:14:55.790591 systemd[1]: ignition-delete-config.service - Ignition (delete config) was skipped because no trigger condition checks were met. Jan 29 11:14:55.793512 systemd[1]: Starting modprobe@dm_mod.service - Load Kernel Module dm_mod... Jan 29 11:14:55.804504 systemd[1]: Starting modprobe@efi_pstore.service - Load Kernel Module efi_pstore... Jan 29 11:14:55.808495 systemd[1]: Starting modprobe@loop.service - Load Kernel Module loop... Jan 29 11:14:55.809321 systemd[1]: systemd-binfmt.service - Set Up Additional Binary Formats was skipped because no trigger condition checks were met. Jan 29 11:14:55.810019 systemd[1]: modprobe@dm_mod.service: Deactivated successfully. Jan 29 11:14:55.810173 systemd[1]: Finished modprobe@dm_mod.service - Load Kernel Module dm_mod. Jan 29 11:14:55.817111 systemd[1]: Finished systemd-journal-catalog-update.service - Rebuild Journal Catalog. Jan 29 11:14:55.819103 systemd[1]: modprobe@loop.service: Deactivated successfully. Jan 29 11:14:55.819227 systemd[1]: Finished modprobe@loop.service - Load Kernel Module loop. Jan 29 11:14:55.820657 systemd[1]: modprobe@efi_pstore.service: Deactivated successfully. Jan 29 11:14:55.820774 systemd[1]: Finished modprobe@efi_pstore.service - Load Kernel Module efi_pstore. Jan 29 11:14:55.828645 systemd[1]: Finished systemd-update-utmp.service - Record System Boot/Shutdown in UTMP. Jan 29 11:14:55.830568 systemd[1]: ignition-delete-config.service - Ignition (delete config) was skipped because no trigger condition checks were met. Jan 29 11:14:55.844392 systemd[1]: Starting modprobe@dm_mod.service - Load Kernel Module dm_mod... Jan 29 11:14:55.846171 systemd[1]: Starting modprobe@efi_pstore.service - Load Kernel Module efi_pstore... Jan 29 11:14:55.851497 systemd[1]: Starting modprobe@loop.service - Load Kernel Module loop... Jan 29 11:14:55.852487 systemd[1]: systemd-binfmt.service - Set Up Additional Binary Formats was skipped because no trigger condition checks were met. Jan 29 11:14:55.854307 systemd[1]: Starting systemd-userdbd.service - User Database Manager... Jan 29 11:14:55.855836 systemd[1]: Finished clean-ca-certificates.service - Clean up broken links in /etc/ssl/certs. Jan 29 11:14:55.857373 systemd[1]: modprobe@dm_mod.service: Deactivated successfully. Jan 29 11:14:55.859097 systemd[1]: Finished modprobe@dm_mod.service - Load Kernel Module dm_mod. Jan 29 11:14:55.860343 systemd[1]: modprobe@efi_pstore.service: Deactivated successfully. Jan 29 11:14:55.860457 systemd[1]: Finished modprobe@efi_pstore.service - Load Kernel Module efi_pstore. Jan 29 11:14:55.861921 systemd[1]: modprobe@loop.service: Deactivated successfully. Jan 29 11:14:55.862086 systemd[1]: Finished modprobe@loop.service - Load Kernel Module loop. Jan 29 11:14:55.862176 augenrules[2145]: No rules Jan 29 11:14:55.865667 systemd[1]: audit-rules.service: Deactivated successfully. Jan 29 11:14:55.865838 systemd[1]: Finished audit-rules.service - Load Audit Rules. Jan 29 11:14:55.872904 systemd[1]: ignition-delete-config.service - Ignition (delete config) was skipped because no trigger condition checks were met. Jan 29 11:14:55.877219 systemd[1]: Starting modprobe@dm_mod.service - Load Kernel Module dm_mod... Jan 29 11:14:55.879907 systemd[1]: Starting modprobe@drm.service - Load Kernel Module drm... Jan 29 11:14:55.884265 systemd[1]: Starting modprobe@efi_pstore.service - Load Kernel Module efi_pstore... Jan 29 11:14:55.886306 systemd[1]: Starting modprobe@loop.service - Load Kernel Module loop... Jan 29 11:14:55.888284 systemd[1]: systemd-binfmt.service - Set Up Additional Binary Formats was skipped because no trigger condition checks were met. Jan 29 11:14:55.888364 systemd[1]: update-ca-certificates.service - Update CA bundle at /etc/ssl/certs/ca-certificates.crt was skipped because of an unmet condition check (ConditionPathIsSymbolicLink=!/etc/ssl/certs/ca-certificates.crt). Jan 29 11:14:55.888615 systemd[1]: Started systemd-userdbd.service - User Database Manager. Jan 29 11:14:55.889709 systemd[1]: Finished ensure-sysext.service. Jan 29 11:14:55.890554 systemd[1]: modprobe@dm_mod.service: Deactivated successfully. Jan 29 11:14:55.890677 systemd[1]: Finished modprobe@dm_mod.service - Load Kernel Module dm_mod. Jan 29 11:14:55.891825 systemd[1]: modprobe@drm.service: Deactivated successfully. Jan 29 11:14:55.891955 systemd[1]: Finished modprobe@drm.service - Load Kernel Module drm. Jan 29 11:14:55.893004 systemd[1]: modprobe@efi_pstore.service: Deactivated successfully. Jan 29 11:14:55.893237 systemd[1]: Finished modprobe@efi_pstore.service - Load Kernel Module efi_pstore. Jan 29 11:14:55.896267 systemd[1]: systemd-pstore.service - Platform Persistent Storage Archival was skipped because of an unmet condition check (ConditionDirectoryNotEmpty=/sys/fs/pstore). Jan 29 11:14:55.905286 systemd[1]: Starting systemd-timesyncd.service - Network Time Synchronization... Jan 29 11:14:55.906499 systemd[1]: Finished systemd-hwdb-update.service - Rebuild Hardware Database. Jan 29 11:14:55.907654 systemd[1]: modprobe@loop.service: Deactivated successfully. Jan 29 11:14:55.907811 systemd[1]: Finished modprobe@loop.service - Load Kernel Module loop. Jan 29 11:14:55.910161 systemd[1]: systemd-repart.service - Repartition Root Disk was skipped because no trigger condition checks were met. Jan 29 11:14:55.911823 systemd[1]: Starting systemd-udevd.service - Rule-based Manager for Device Events and Files... Jan 29 11:14:55.915228 systemd[1]: Starting systemd-update-done.service - Update is Completed... Jan 29 11:14:55.926633 systemd[1]: Finished systemd-update-done.service - Update is Completed. Jan 29 11:14:55.939968 systemd-udevd[2171]: Using default interface naming scheme 'v255'. Jan 29 11:14:55.947470 systemd[1]: Started systemd-timesyncd.service - Network Time Synchronization. Jan 29 11:14:55.948468 systemd[1]: Reached target time-set.target - System Time Set. Jan 29 11:14:55.951839 systemd-resolved[2113]: Positive Trust Anchors: Jan 29 11:14:55.951911 systemd-resolved[2113]: . IN DS 20326 8 2 e06d44b80b8f1d39a95c0b0d7c65d08458e880409bbc683457104237c7f8ec8d Jan 29 11:14:55.951943 systemd-resolved[2113]: Negative trust anchors: home.arpa 10.in-addr.arpa 16.172.in-addr.arpa 17.172.in-addr.arpa 18.172.in-addr.arpa 19.172.in-addr.arpa 20.172.in-addr.arpa 21.172.in-addr.arpa 22.172.in-addr.arpa 23.172.in-addr.arpa 24.172.in-addr.arpa 25.172.in-addr.arpa 26.172.in-addr.arpa 27.172.in-addr.arpa 28.172.in-addr.arpa 29.172.in-addr.arpa 30.172.in-addr.arpa 31.172.in-addr.arpa 170.0.0.192.in-addr.arpa 171.0.0.192.in-addr.arpa 168.192.in-addr.arpa d.f.ip6.arpa ipv4only.arpa resolver.arpa corp home internal intranet lan local private test Jan 29 11:14:55.953686 systemd[1]: Started systemd-udevd.service - Rule-based Manager for Device Events and Files. Jan 29 11:14:55.957203 systemd-resolved[2113]: Defaulting to hostname 'linux'. Jan 29 11:14:55.963332 systemd[1]: Starting systemd-networkd.service - Network Configuration... Jan 29 11:14:55.964508 systemd[1]: Started systemd-resolved.service - Network Name Resolution. Jan 29 11:14:55.970363 systemd[1]: Reached target nss-lookup.target - Host and Network Name Lookups. Jan 29 11:14:55.985640 systemd[1]: Condition check resulted in dev-ttyAMA0.device - /dev/ttyAMA0 being skipped. Jan 29 11:14:56.006140 kernel: BTRFS warning: duplicate device /dev/vdb3 devid 1 generation 39 scanned by (udev-worker) (2193) Jan 29 11:14:56.014027 systemd[1]: Condition check resulted in dev-disk-by\x2duuid-46e18de8\x2df34f\x2d418c\x2d86f8\x2d742425a13ab8.device - /dev/disk/by-uuid/46e18de8-f34f-418c-86f8-742425a13ab8 being skipped. Jan 29 11:14:56.018554 systemd-networkd[2183]: lo: Link UP Jan 29 11:14:56.018565 systemd-networkd[2183]: lo: Gained carrier Jan 29 11:14:56.019383 systemd-networkd[2183]: Enumeration completed Jan 29 11:14:56.023253 systemd[1]: Starting systemd-cryptsetup@rootencrypted.service - Cryptography Setup for rootencrypted... Jan 29 11:14:56.024155 systemd[1]: Started systemd-networkd.service - Network Configuration. Jan 29 11:14:56.025763 systemd-networkd[2183]: eth0: found matching network '/usr/lib/systemd/network/zz-default.network', based on potentially unpredictable interface name. Jan 29 11:14:56.025772 systemd-networkd[2183]: eth0: Configuring with /usr/lib/systemd/network/zz-default.network. Jan 29 11:14:56.026395 systemd-networkd[2183]: eth0: found matching network '/usr/lib/systemd/network/zz-default.network', based on potentially unpredictable interface name. Jan 29 11:14:56.026422 systemd-networkd[2183]: eth0: Link UP Jan 29 11:14:56.026431 systemd-networkd[2183]: eth0: Gained carrier Jan 29 11:14:56.026439 systemd-networkd[2183]: eth0: found matching network '/usr/lib/systemd/network/zz-default.network', based on potentially unpredictable interface name. Jan 29 11:14:56.027264 systemd[1]: Found device dev-disk-by\x2dlabel-OEM.device - /dev/disk/by-label/OEM. Jan 29 11:14:56.030358 systemd[1]: Reached target network.target - Network. Jan 29 11:14:56.035192 systemd[1]: Starting systemd-fsck@dev-disk-by\x2dlabel-OEM.service - File System Check on /dev/disk/by-label/OEM... Jan 29 11:14:56.040861 systemd[1]: Starting systemd-networkd-wait-online.service - Wait for Network to be Configured... Jan 29 11:14:56.049846 systemd-cryptsetup[2202]: Volume rootencrypted already active. Jan 29 11:14:56.053119 systemd-networkd[2183]: eth0: DHCPv4 address 10.0.0.128/16, gateway 10.0.0.1 acquired from 10.0.0.1 Jan 29 11:14:56.053611 systemd-timesyncd[2167]: Network configuration changed, trying to establish connection. Jan 29 11:14:56.054393 systemd-timesyncd[2167]: Contacted time server 10.0.0.1:123 (10.0.0.1). Jan 29 11:14:56.054505 systemd-timesyncd[2167]: Initial clock synchronization to Wed 2025-01-29 11:14:55.720015 UTC. Jan 29 11:14:56.056553 systemd[1]: Finished systemd-cryptsetup@rootencrypted.service - Cryptography Setup for rootencrypted. Jan 29 11:14:56.058009 systemd[1]: Reached target blockdev@dev-mapper-rootencrypted.target - Block Device Preparation for /dev/mapper/rootencrypted. Jan 29 11:14:56.061598 systemd[1]: Finished systemd-fsck@dev-disk-by\x2dlabel-OEM.service - File System Check on /dev/disk/by-label/OEM. Jan 29 11:14:56.093299 systemd[1]: Starting systemd-vconsole-setup.service - Virtual Console Setup... Jan 29 11:14:56.104500 systemd[1]: Finished systemd-udev-settle.service - Wait for udev To Complete Device Initialization. Jan 29 11:14:56.115297 systemd[1]: Starting lvm2-activation-early.service - Activation of LVM2 logical volumes... Jan 29 11:14:56.127639 lvm[2214]: WARNING: Failed to connect to lvmetad. Falling back to device scanning. Jan 29 11:14:56.131033 systemd[1]: Finished systemd-vconsole-setup.service - Virtual Console Setup. Jan 29 11:14:56.162152 systemd[1]: Finished lvm2-activation-early.service - Activation of LVM2 logical volumes. Jan 29 11:14:56.163292 systemd[1]: Reached target cryptsetup.target - Local Encrypted Volumes. Jan 29 11:14:56.164100 systemd[1]: Reached target sysinit.target - System Initialization. Jan 29 11:14:56.164909 systemd[1]: Started motdgen.path - Watch for update engine configuration changes. Jan 29 11:14:56.165884 systemd[1]: Started user-cloudinit@var-lib-flatcar\x2dinstall-user_data.path - Watch for a cloud-config at /var/lib/flatcar-install/user_data. Jan 29 11:14:56.166973 systemd[1]: Started logrotate.timer - Daily rotation of log files. Jan 29 11:14:56.167913 systemd[1]: Started mdadm.timer - Weekly check for MD array's redundancy information.. Jan 29 11:14:56.168863 systemd[1]: Started systemd-tmpfiles-clean.timer - Daily Cleanup of Temporary Directories. Jan 29 11:14:56.169772 systemd[1]: update-engine-stub.timer - Update Engine Stub Timer was skipped because of an unmet condition check (ConditionPathExists=/usr/.noupdate). Jan 29 11:14:56.169811 systemd[1]: Reached target paths.target - Path Units. Jan 29 11:14:56.170489 systemd[1]: Reached target timers.target - Timer Units. Jan 29 11:14:56.171967 systemd[1]: Listening on dbus.socket - D-Bus System Message Bus Socket. Jan 29 11:14:56.173932 systemd[1]: Starting docker.socket - Docker Socket for the API... Jan 29 11:14:56.185994 systemd[1]: Listening on sshd.socket - OpenSSH Server Socket. Jan 29 11:14:56.188048 systemd[1]: Starting lvm2-activation.service - Activation of LVM2 logical volumes... Jan 29 11:14:56.189343 systemd[1]: Listening on docker.socket - Docker Socket for the API. Jan 29 11:14:56.190217 systemd[1]: Reached target sockets.target - Socket Units. Jan 29 11:14:56.190908 systemd[1]: Reached target basic.target - Basic System. Jan 29 11:14:56.191668 systemd[1]: addon-config@oem.service - Configure Addon /oem was skipped because no trigger condition checks were met. Jan 29 11:14:56.191699 systemd[1]: addon-run@oem.service - Run Addon /oem was skipped because no trigger condition checks were met. Jan 29 11:14:56.192642 systemd[1]: Starting containerd.service - containerd container runtime... Jan 29 11:14:56.193454 systemd[1]: cryptenroll-helper-bind.service was skipped because of an unmet condition check (ConditionPathExists=/etc/luks/rootencrypted-bind). Jan 29 11:14:56.194499 systemd[1]: Starting dbus.service - D-Bus System Message Bus... Jan 29 11:14:56.197218 lvm[2221]: WARNING: Failed to connect to lvmetad. Falling back to device scanning. Jan 29 11:14:56.196186 systemd[1]: Starting enable-oem-cloudinit.service - Enable cloudinit... Jan 29 11:14:56.199251 systemd[1]: Starting extend-filesystems.service - Extend Filesystems... Jan 29 11:14:56.200113 systemd[1]: flatcar-setup-environment.service - Modifies /etc/environment for CoreOS was skipped because of an unmet condition check (ConditionPathExists=/oem/bin/flatcar-setup-environment). Jan 29 11:14:56.201255 systemd[1]: Starting motdgen.service - Generate /run/flatcar/motd... Jan 29 11:14:56.206798 jq[2224]: false Jan 29 11:14:56.203225 systemd[1]: Starting ssh-key-proc-cmdline.service - Install an ssh key from /proc/cmdline... Jan 29 11:14:56.208284 systemd[1]: Starting sshd-keygen.service - Generate sshd host keys... Jan 29 11:14:56.215718 systemd[1]: Starting systemd-logind.service - User Login Management... Jan 29 11:14:56.217886 systemd[1]: tcsd.service - TCG Core Services Daemon was skipped because of an unmet condition check (ConditionSecurity=!tpm2). Jan 29 11:14:56.218369 systemd[1]: cgroup compatibility translation between legacy and unified hierarchy settings activated. See cgroup-compat debug messages for details. Jan 29 11:14:56.220578 systemd[1]: Starting update-engine.service - Update Engine... Jan 29 11:14:56.225508 systemd[1]: Starting update-ssh-keys-after-ignition.service - Run update-ssh-keys once after Ignition... Jan 29 11:14:56.228170 systemd[1]: Finished lvm2-activation.service - Activation of LVM2 logical volumes. Jan 29 11:14:56.230077 jq[2235]: true Jan 29 11:14:56.231898 systemd[1]: enable-oem-cloudinit.service: Skipped due to 'exec-condition'. Jan 29 11:14:56.232056 systemd[1]: Condition check resulted in enable-oem-cloudinit.service - Enable cloudinit being skipped. Jan 29 11:14:56.233401 systemd[1]: ssh-key-proc-cmdline.service: Deactivated successfully. Jan 29 11:14:56.234267 systemd[1]: Finished ssh-key-proc-cmdline.service - Install an ssh key from /proc/cmdline. Jan 29 11:14:56.235816 extend-filesystems[2225]: Found loop2 Jan 29 11:14:56.236579 extend-filesystems[2225]: Found loop3 Jan 29 11:14:56.236579 extend-filesystems[2225]: Found vda Jan 29 11:14:56.236579 extend-filesystems[2225]: Found vdb Jan 29 11:14:56.236579 extend-filesystems[2225]: Found vdb1 Jan 29 11:14:56.236579 extend-filesystems[2225]: Found vdb2 Jan 29 11:14:56.236579 extend-filesystems[2225]: Found vdb3 Jan 29 11:14:56.236579 extend-filesystems[2225]: Found usr Jan 29 11:14:56.236579 extend-filesystems[2225]: Found vdb4 Jan 29 11:14:56.236579 extend-filesystems[2225]: Found vdb6 Jan 29 11:14:56.236579 extend-filesystems[2225]: Found vdb7 Jan 29 11:14:56.236579 extend-filesystems[2225]: Found vdb9 Jan 29 11:14:56.236579 extend-filesystems[2225]: Found rootencrypted Jan 29 11:14:56.238589 systemd[1]: extend-filesystems.service: Deactivated successfully. Jan 29 11:14:56.239366 systemd[1]: Finished extend-filesystems.service - Extend Filesystems. Jan 29 11:14:56.249338 systemd[1]: motdgen.service: Deactivated successfully. Jan 29 11:14:56.252626 jq[2243]: true Jan 29 11:14:56.249496 systemd[1]: Finished motdgen.service - Generate /run/flatcar/motd. Jan 29 11:14:56.265361 dbus-daemon[2223]: [system] SELinux support is enabled Jan 29 11:14:56.265509 systemd[1]: Started dbus.service - D-Bus System Message Bus. Jan 29 11:14:56.266627 (ntainerd)[2253]: containerd.service: Referenced but unset environment variable evaluates to an empty string: TORCX_IMAGEDIR, TORCX_UNPACKDIR Jan 29 11:14:56.269975 systemd[1]: system-cloudinit@usr-share-oem-cloud\x2dconfig.yml.service - Load cloud-config from /usr/share/oem/cloud-config.yml was skipped because of an unmet condition check (ConditionFileNotEmpty=/usr/share/oem/cloud-config.yml). Jan 29 11:14:56.270006 systemd[1]: Reached target system-config.target - Load system-provided cloud configs. Jan 29 11:14:56.271108 systemd[1]: user-cloudinit-proc-cmdline.service - Load cloud-config from url defined in /proc/cmdline was skipped because of an unmet condition check (ConditionKernelCommandLine=cloud-config-url). Jan 29 11:14:56.271141 systemd[1]: Reached target user-config.target - Load user-provided cloud configs. Jan 29 11:14:56.276646 update_engine[2233]: I20250129 11:14:56.275835 2233 main.cc:92] Flatcar Update Engine starting Jan 29 11:14:56.280957 systemd[1]: Started update-engine.service - Update Engine. Jan 29 11:14:56.281431 update_engine[2233]: I20250129 11:14:56.281033 2233 update_check_scheduler.cc:74] Next update check in 7m59s Jan 29 11:14:56.284357 systemd-logind[2231]: Watching system buttons on /dev/input/event0 (Power Button) Jan 29 11:14:56.284721 systemd-logind[2231]: New seat seat0. Jan 29 11:14:56.290508 systemd[1]: Started locksmithd.service - Cluster reboot manager. Jan 29 11:14:56.292429 systemd[1]: Started systemd-logind.service - User Login Management. Jan 29 11:14:56.301816 bash[2268]: Updated "/home/core/.ssh/authorized_keys" Jan 29 11:14:56.309923 systemd[1]: Finished update-ssh-keys-after-ignition.service - Run update-ssh-keys once after Ignition. Jan 29 11:14:56.312088 systemd[1]: sshkeys.service was skipped because no trigger condition checks were met. Jan 29 11:14:56.327652 locksmithd[2269]: locksmithd starting currentOperation="UPDATE_STATUS_IDLE" strategy="reboot" Jan 29 11:14:56.437376 containerd[2253]: time="2025-01-29T11:14:56.437239440Z" level=info msg="starting containerd" revision=9b2ad7760328148397346d10c7b2004271249db4 version=v1.7.23 Jan 29 11:14:56.461286 containerd[2253]: time="2025-01-29T11:14:56.461240560Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.aufs\"..." type=io.containerd.snapshotter.v1 Jan 29 11:14:56.462621 containerd[2253]: time="2025-01-29T11:14:56.462585200Z" 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.74-flatcar\\n\"): skip plugin" type=io.containerd.snapshotter.v1 Jan 29 11:14:56.462660 containerd[2253]: time="2025-01-29T11:14:56.462622080Z" level=info msg="loading plugin \"io.containerd.event.v1.exchange\"..." type=io.containerd.event.v1 Jan 29 11:14:56.462660 containerd[2253]: time="2025-01-29T11:14:56.462639000Z" level=info msg="loading plugin \"io.containerd.internal.v1.opt\"..." type=io.containerd.internal.v1 Jan 29 11:14:56.462814 containerd[2253]: time="2025-01-29T11:14:56.462785400Z" level=info msg="loading plugin \"io.containerd.warning.v1.deprecations\"..." type=io.containerd.warning.v1 Jan 29 11:14:56.462841 containerd[2253]: time="2025-01-29T11:14:56.462817040Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.blockfile\"..." type=io.containerd.snapshotter.v1 Jan 29 11:14:56.462886 containerd[2253]: time="2025-01-29T11:14:56.462871720Z" level=info msg="skip loading plugin \"io.containerd.snapshotter.v1.blockfile\"..." error="no scratch file generator: skip plugin" type=io.containerd.snapshotter.v1 Jan 29 11:14:56.462906 containerd[2253]: time="2025-01-29T11:14:56.462887120Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.btrfs\"..." type=io.containerd.snapshotter.v1 Jan 29 11:14:56.463029 sshd_keygen[2242]: ssh-keygen: generating new host keys: RSA ECDSA ED25519 Jan 29 11:14:56.463236 containerd[2253]: time="2025-01-29T11:14:56.463041400Z" level=info msg="skip loading plugin \"io.containerd.snapshotter.v1.btrfs\"..." error="path /var/lib/containerd/io.containerd.snapshotter.v1.btrfs (ext4) must be a btrfs filesystem to be used with the btrfs snapshotter: skip plugin" type=io.containerd.snapshotter.v1 Jan 29 11:14:56.463236 containerd[2253]: time="2025-01-29T11:14:56.463055840Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.devmapper\"..." type=io.containerd.snapshotter.v1 Jan 29 11:14:56.463236 containerd[2253]: time="2025-01-29T11:14:56.463080800Z" level=info msg="skip loading plugin \"io.containerd.snapshotter.v1.devmapper\"..." error="devmapper not configured: skip plugin" type=io.containerd.snapshotter.v1 Jan 29 11:14:56.463236 containerd[2253]: time="2025-01-29T11:14:56.463091120Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.native\"..." type=io.containerd.snapshotter.v1 Jan 29 11:14:56.463236 containerd[2253]: time="2025-01-29T11:14:56.463169680Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.overlayfs\"..." type=io.containerd.snapshotter.v1 Jan 29 11:14:56.463364 containerd[2253]: time="2025-01-29T11:14:56.463343600Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.zfs\"..." type=io.containerd.snapshotter.v1 Jan 29 11:14:56.463455 containerd[2253]: time="2025-01-29T11:14:56.463440240Z" level=info msg="skip loading plugin \"io.containerd.snapshotter.v1.zfs\"..." error="path /var/lib/containerd/io.containerd.snapshotter.v1.zfs must be a zfs filesystem to be used with the zfs snapshotter: skip plugin" type=io.containerd.snapshotter.v1 Jan 29 11:14:56.463476 containerd[2253]: time="2025-01-29T11:14:56.463456320Z" level=info msg="loading plugin \"io.containerd.content.v1.content\"..." type=io.containerd.content.v1 Jan 29 11:14:56.463546 containerd[2253]: time="2025-01-29T11:14:56.463533240Z" level=info msg="loading plugin \"io.containerd.metadata.v1.bolt\"..." type=io.containerd.metadata.v1 Jan 29 11:14:56.463591 containerd[2253]: time="2025-01-29T11:14:56.463579240Z" level=info msg="metadata content store policy set" policy=shared Jan 29 11:14:56.469302 containerd[2253]: time="2025-01-29T11:14:56.469268880Z" level=info msg="loading plugin \"io.containerd.gc.v1.scheduler\"..." type=io.containerd.gc.v1 Jan 29 11:14:56.469339 containerd[2253]: time="2025-01-29T11:14:56.469313000Z" level=info msg="loading plugin \"io.containerd.differ.v1.walking\"..." type=io.containerd.differ.v1 Jan 29 11:14:56.469339 containerd[2253]: time="2025-01-29T11:14:56.469328280Z" level=info msg="loading plugin \"io.containerd.lease.v1.manager\"..." type=io.containerd.lease.v1 Jan 29 11:14:56.469372 containerd[2253]: time="2025-01-29T11:14:56.469343520Z" level=info msg="loading plugin \"io.containerd.streaming.v1.manager\"..." type=io.containerd.streaming.v1 Jan 29 11:14:56.469372 containerd[2253]: time="2025-01-29T11:14:56.469359160Z" level=info msg="loading plugin \"io.containerd.runtime.v1.linux\"..." type=io.containerd.runtime.v1 Jan 29 11:14:56.469529 containerd[2253]: time="2025-01-29T11:14:56.469499640Z" level=info msg="loading plugin \"io.containerd.monitor.v1.cgroups\"..." type=io.containerd.monitor.v1 Jan 29 11:14:56.470101 containerd[2253]: time="2025-01-29T11:14:56.469760640Z" level=info msg="loading plugin \"io.containerd.runtime.v2.task\"..." type=io.containerd.runtime.v2 Jan 29 11:14:56.470101 containerd[2253]: time="2025-01-29T11:14:56.469910680Z" level=info msg="loading plugin \"io.containerd.runtime.v2.shim\"..." type=io.containerd.runtime.v2 Jan 29 11:14:56.470101 containerd[2253]: time="2025-01-29T11:14:56.469927400Z" level=info msg="loading plugin \"io.containerd.sandbox.store.v1.local\"..." type=io.containerd.sandbox.store.v1 Jan 29 11:14:56.470101 containerd[2253]: time="2025-01-29T11:14:56.469942360Z" level=info msg="loading plugin \"io.containerd.sandbox.controller.v1.local\"..." type=io.containerd.sandbox.controller.v1 Jan 29 11:14:56.470101 containerd[2253]: time="2025-01-29T11:14:56.469957600Z" level=info msg="loading plugin \"io.containerd.service.v1.containers-service\"..." type=io.containerd.service.v1 Jan 29 11:14:56.470101 containerd[2253]: time="2025-01-29T11:14:56.469971320Z" level=info msg="loading plugin \"io.containerd.service.v1.content-service\"..." type=io.containerd.service.v1 Jan 29 11:14:56.470101 containerd[2253]: time="2025-01-29T11:14:56.469984000Z" level=info msg="loading plugin \"io.containerd.service.v1.diff-service\"..." type=io.containerd.service.v1 Jan 29 11:14:56.470101 containerd[2253]: time="2025-01-29T11:14:56.469997000Z" level=info msg="loading plugin \"io.containerd.service.v1.images-service\"..." type=io.containerd.service.v1 Jan 29 11:14:56.470101 containerd[2253]: time="2025-01-29T11:14:56.470011200Z" level=info msg="loading plugin \"io.containerd.service.v1.introspection-service\"..." type=io.containerd.service.v1 Jan 29 11:14:56.470101 containerd[2253]: time="2025-01-29T11:14:56.470024480Z" level=info msg="loading plugin \"io.containerd.service.v1.namespaces-service\"..." type=io.containerd.service.v1 Jan 29 11:14:56.470101 containerd[2253]: time="2025-01-29T11:14:56.470036320Z" level=info msg="loading plugin \"io.containerd.service.v1.snapshots-service\"..." type=io.containerd.service.v1 Jan 29 11:14:56.470101 containerd[2253]: time="2025-01-29T11:14:56.470048040Z" level=info msg="loading plugin \"io.containerd.service.v1.tasks-service\"..." type=io.containerd.service.v1 Jan 29 11:14:56.470101 containerd[2253]: time="2025-01-29T11:14:56.470086320Z" level=info msg="loading plugin \"io.containerd.grpc.v1.containers\"..." type=io.containerd.grpc.v1 Jan 29 11:14:56.470101 containerd[2253]: time="2025-01-29T11:14:56.470100720Z" level=info msg="loading plugin \"io.containerd.grpc.v1.content\"..." type=io.containerd.grpc.v1 Jan 29 11:14:56.470400 containerd[2253]: time="2025-01-29T11:14:56.470113520Z" level=info msg="loading plugin \"io.containerd.grpc.v1.diff\"..." type=io.containerd.grpc.v1 Jan 29 11:14:56.470400 containerd[2253]: time="2025-01-29T11:14:56.470127800Z" level=info msg="loading plugin \"io.containerd.grpc.v1.events\"..." type=io.containerd.grpc.v1 Jan 29 11:14:56.470400 containerd[2253]: time="2025-01-29T11:14:56.470140920Z" level=info msg="loading plugin \"io.containerd.grpc.v1.images\"..." type=io.containerd.grpc.v1 Jan 29 11:14:56.470400 containerd[2253]: time="2025-01-29T11:14:56.470153520Z" level=info msg="loading plugin \"io.containerd.grpc.v1.introspection\"..." type=io.containerd.grpc.v1 Jan 29 11:14:56.470400 containerd[2253]: time="2025-01-29T11:14:56.470164600Z" level=info msg="loading plugin \"io.containerd.grpc.v1.leases\"..." type=io.containerd.grpc.v1 Jan 29 11:14:56.470400 containerd[2253]: time="2025-01-29T11:14:56.470177600Z" level=info msg="loading plugin \"io.containerd.grpc.v1.namespaces\"..." type=io.containerd.grpc.v1 Jan 29 11:14:56.470400 containerd[2253]: time="2025-01-29T11:14:56.470189480Z" level=info msg="loading plugin \"io.containerd.grpc.v1.sandbox-controllers\"..." type=io.containerd.grpc.v1 Jan 29 11:14:56.470400 containerd[2253]: time="2025-01-29T11:14:56.470202800Z" level=info msg="loading plugin \"io.containerd.grpc.v1.sandboxes\"..." type=io.containerd.grpc.v1 Jan 29 11:14:56.470400 containerd[2253]: time="2025-01-29T11:14:56.470214680Z" level=info msg="loading plugin \"io.containerd.grpc.v1.snapshots\"..." type=io.containerd.grpc.v1 Jan 29 11:14:56.470400 containerd[2253]: time="2025-01-29T11:14:56.470226320Z" level=info msg="loading plugin \"io.containerd.grpc.v1.streaming\"..." type=io.containerd.grpc.v1 Jan 29 11:14:56.470400 containerd[2253]: time="2025-01-29T11:14:56.470238320Z" level=info msg="loading plugin \"io.containerd.grpc.v1.tasks\"..." type=io.containerd.grpc.v1 Jan 29 11:14:56.470400 containerd[2253]: time="2025-01-29T11:14:56.470251920Z" level=info msg="loading plugin \"io.containerd.transfer.v1.local\"..." type=io.containerd.transfer.v1 Jan 29 11:14:56.470400 containerd[2253]: time="2025-01-29T11:14:56.470271680Z" level=info msg="loading plugin \"io.containerd.grpc.v1.transfer\"..." type=io.containerd.grpc.v1 Jan 29 11:14:56.470400 containerd[2253]: time="2025-01-29T11:14:56.470286200Z" level=info msg="loading plugin \"io.containerd.grpc.v1.version\"..." type=io.containerd.grpc.v1 Jan 29 11:14:56.470400 containerd[2253]: time="2025-01-29T11:14:56.470297520Z" level=info msg="loading plugin \"io.containerd.internal.v1.restart\"..." type=io.containerd.internal.v1 Jan 29 11:14:56.470642 containerd[2253]: time="2025-01-29T11:14:56.470461640Z" level=info msg="loading plugin \"io.containerd.tracing.processor.v1.otlp\"..." type=io.containerd.tracing.processor.v1 Jan 29 11:14:56.470642 containerd[2253]: time="2025-01-29T11:14:56.470478160Z" level=info msg="skip loading plugin \"io.containerd.tracing.processor.v1.otlp\"..." error="skip plugin: tracing endpoint not configured" type=io.containerd.tracing.processor.v1 Jan 29 11:14:56.470642 containerd[2253]: time="2025-01-29T11:14:56.470506200Z" level=info msg="loading plugin \"io.containerd.internal.v1.tracing\"..." type=io.containerd.internal.v1 Jan 29 11:14:56.470642 containerd[2253]: time="2025-01-29T11:14:56.470518760Z" level=info msg="skip loading plugin \"io.containerd.internal.v1.tracing\"..." error="skip plugin: tracing endpoint not configured" type=io.containerd.internal.v1 Jan 29 11:14:56.470642 containerd[2253]: time="2025-01-29T11:14:56.470527880Z" level=info msg="loading plugin \"io.containerd.grpc.v1.healthcheck\"..." type=io.containerd.grpc.v1 Jan 29 11:14:56.470642 containerd[2253]: time="2025-01-29T11:14:56.470540880Z" level=info msg="loading plugin \"io.containerd.nri.v1.nri\"..." type=io.containerd.nri.v1 Jan 29 11:14:56.470642 containerd[2253]: time="2025-01-29T11:14:56.470551080Z" level=info msg="NRI interface is disabled by configuration." Jan 29 11:14:56.470642 containerd[2253]: time="2025-01-29T11:14:56.470561640Z" level=info msg="loading plugin \"io.containerd.grpc.v1.cri\"..." type=io.containerd.grpc.v1 Jan 29 11:14:56.470939 containerd[2253]: time="2025-01-29T11:14:56.470890960Z" level=info msg="Start cri plugin with config {PluginConfig:{ContainerdConfig:{Snapshotter:overlayfs DefaultRuntimeName:runc DefaultRuntime:{Type: Path: Engine: PodAnnotations:[] ContainerAnnotations:[] Root: Options:map[] PrivilegedWithoutHostDevices:false PrivilegedWithoutHostDevicesAllDevicesAllowed:false BaseRuntimeSpec: NetworkPluginConfDir: NetworkPluginMaxConfNum:0 Snapshotter: SandboxMode:} UntrustedWorkloadRuntime:{Type: Path: Engine: PodAnnotations:[] ContainerAnnotations:[] Root: Options:map[] PrivilegedWithoutHostDevices:false PrivilegedWithoutHostDevicesAllDevicesAllowed:false BaseRuntimeSpec: NetworkPluginConfDir: NetworkPluginMaxConfNum:0 Snapshotter: SandboxMode:} Runtimes:map[runc:{Type:io.containerd.runc.v2 Path: Engine: PodAnnotations:[] ContainerAnnotations:[] Root: Options:map[SystemdCgroup:true] PrivilegedWithoutHostDevices:false PrivilegedWithoutHostDevicesAllDevicesAllowed:false BaseRuntimeSpec: NetworkPluginConfDir: NetworkPluginMaxConfNum:0 Snapshotter: SandboxMode:podsandbox}] NoPivot:false DisableSnapshotAnnotations:true DiscardUnpackedLayers:false IgnoreBlockIONotEnabledErrors:false IgnoreRdtNotEnabledErrors:false} CniConfig:{NetworkPluginBinDir:/opt/cni/bin NetworkPluginConfDir:/etc/cni/net.d NetworkPluginMaxConfNum:1 NetworkPluginSetupSerially:false NetworkPluginConfTemplate: IPPreference:} Registry:{ConfigPath: Mirrors:map[] Configs:map[] Auths:map[] Headers:map[]} ImageDecryption:{KeyModel:node} DisableTCPService:true StreamServerAddress:127.0.0.1 StreamServerPort:0 StreamIdleTimeout:4h0m0s EnableSelinux:true SelinuxCategoryRange:1024 SandboxImage:registry.k8s.io/pause:3.8 StatsCollectPeriod:10 SystemdCgroup:false EnableTLSStreaming:false X509KeyPairStreaming:{TLSCertFile: TLSKeyFile:} MaxContainerLogLineSize:16384 DisableCgroup:false DisableApparmor:false RestrictOOMScoreAdj:false MaxConcurrentDownloads:3 DisableProcMount:false UnsetSeccompProfile: TolerateMissingHugetlbController:true DisableHugetlbController:true DeviceOwnershipFromSecurityContext:false IgnoreImageDefinedVolumes:false NetNSMountsUnderStateDir:false EnableUnprivilegedPorts:false EnableUnprivilegedICMP:false EnableCDI:false CDISpecDirs:[/etc/cdi /var/run/cdi] ImagePullProgressTimeout:5m0s DrainExecSyncIOTimeout:0s ImagePullWithSyncFs:false IgnoreDeprecationWarnings:[]} ContainerdRootDir:/var/lib/containerd ContainerdEndpoint:/run/containerd/containerd.sock RootDir:/var/lib/containerd/io.containerd.grpc.v1.cri StateDir:/run/containerd/io.containerd.grpc.v1.cri}" Jan 29 11:14:56.471044 containerd[2253]: time="2025-01-29T11:14:56.470944640Z" level=info msg="Connect containerd service" Jan 29 11:14:56.471044 containerd[2253]: time="2025-01-29T11:14:56.470975760Z" level=info msg="using legacy CRI server" Jan 29 11:14:56.471044 containerd[2253]: time="2025-01-29T11:14:56.470981920Z" level=info msg="using experimental NRI integration - disable nri plugin to prevent this" Jan 29 11:14:56.471233 containerd[2253]: time="2025-01-29T11:14:56.471216720Z" level=info msg="Get image filesystem path \"/var/lib/containerd/io.containerd.snapshotter.v1.overlayfs\"" Jan 29 11:14:56.474559 containerd[2253]: time="2025-01-29T11:14:56.474521360Z" level=error msg="failed to load cni during init, please check CRI plugin status before setting up network for pods" error="cni config load failed: no network config found in /etc/cni/net.d: cni plugin not initialized: failed to load cni config" Jan 29 11:14:56.475109 containerd[2253]: time="2025-01-29T11:14:56.474837680Z" level=info msg="Start subscribing containerd event" Jan 29 11:14:56.475109 containerd[2253]: time="2025-01-29T11:14:56.474893280Z" level=info msg="Start recovering state" Jan 29 11:14:56.475109 containerd[2253]: time="2025-01-29T11:14:56.474963120Z" level=info msg="Start event monitor" Jan 29 11:14:56.475109 containerd[2253]: time="2025-01-29T11:14:56.474977800Z" level=info msg="Start snapshots syncer" Jan 29 11:14:56.475109 containerd[2253]: time="2025-01-29T11:14:56.474987200Z" level=info msg="Start cni network conf syncer for default" Jan 29 11:14:56.475109 containerd[2253]: time="2025-01-29T11:14:56.475000080Z" level=info msg="Start streaming server" Jan 29 11:14:56.475369 containerd[2253]: time="2025-01-29T11:14:56.475340080Z" level=info msg=serving... address=/run/containerd/containerd.sock.ttrpc Jan 29 11:14:56.475416 containerd[2253]: time="2025-01-29T11:14:56.475405480Z" level=info msg=serving... address=/run/containerd/containerd.sock Jan 29 11:14:56.475475 containerd[2253]: time="2025-01-29T11:14:56.475460600Z" level=info msg="containerd successfully booted in 0.039134s" Jan 29 11:14:56.475583 systemd[1]: Started containerd.service - containerd container runtime. Jan 29 11:14:56.482444 systemd[1]: Finished sshd-keygen.service - Generate sshd host keys. Jan 29 11:14:56.494476 systemd[1]: Starting issuegen.service - Generate /run/issue... Jan 29 11:14:56.498895 systemd[1]: issuegen.service: Deactivated successfully. Jan 29 11:14:56.500108 systemd[1]: Finished issuegen.service - Generate /run/issue. Jan 29 11:14:56.502821 systemd[1]: Starting systemd-user-sessions.service - Permit User Sessions... Jan 29 11:14:56.515547 systemd[1]: Finished systemd-user-sessions.service - Permit User Sessions. Jan 29 11:14:56.527420 systemd[1]: Started getty@tty1.service - Getty on tty1. Jan 29 11:14:56.529402 systemd[1]: Started serial-getty@ttyAMA0.service - Serial Getty on ttyAMA0. Jan 29 11:14:56.530400 systemd[1]: Reached target getty.target - Login Prompts. Jan 29 11:14:57.282173 systemd-networkd[2183]: eth0: Gained IPv6LL Jan 29 11:14:57.285155 systemd[1]: Finished systemd-networkd-wait-online.service - Wait for Network to be Configured. Jan 29 11:14:57.286496 systemd[1]: Reached target network-online.target - Network is Online. Jan 29 11:14:57.303373 systemd[1]: Starting coreos-metadata.service - QEMU metadata agent... Jan 29 11:14:57.305143 systemd[1]: Starting nvidia.service - NVIDIA Configure Service... Jan 29 11:14:57.318904 systemd[1]: coreos-metadata.service: Deactivated successfully. Jan 29 11:14:57.319129 systemd[1]: Finished coreos-metadata.service - QEMU metadata agent. Jan 29 11:14:57.320936 systemd[1]: packet-phone-home.service - Report Success to Packet was skipped because no trigger condition checks were met. Jan 29 11:14:57.326795 systemd[1]: Finished nvidia.service - NVIDIA Configure Service. Jan 29 11:14:57.328160 systemd[1]: Reached target multi-user.target - Multi-User System. Jan 29 11:14:57.348525 systemd[1]: Starting cryptenroll-helper-first.service... Jan 29 11:14:57.355824 systemd-cryptenroll[2315]: Warning: keyslot operation could fail as it requires more than available memory. Jan 29 11:14:59.559396 systemd-cryptenroll[2315]: New TPM2 token enrolled as key slot 1. Jan 29 11:15:04.041987 systemd[1]: Created slice system-sshd.slice - Slice /system/sshd. Jan 29 11:15:04.043225 systemd[1]: Started sshd@0-10.0.0.128:22-10.0.0.1:51110.service - OpenSSH per-connection server daemon (10.0.0.1:51110). Jan 29 11:15:04.116030 sshd[2454]: Accepted publickey for core from 10.0.0.1 port 51110 ssh2: RSA SHA256:Bq1DMYRFt3vwSJT5tcC1MQpWKmkwK1uKH+vc+Uts7DI Jan 29 11:15:04.117614 sshd-session[2454]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Jan 29 11:15:04.130309 systemd[1]: Created slice user-500.slice - User Slice of UID 500. Jan 29 11:15:04.138408 systemd[1]: Starting user-runtime-dir@500.service - User Runtime Directory /run/user/500... Jan 29 11:15:04.139998 systemd-logind[2231]: New session 1 of user core. Jan 29 11:15:04.146336 systemd[1]: Finished user-runtime-dir@500.service - User Runtime Directory /run/user/500. Jan 29 11:15:04.149290 systemd[1]: Starting user@500.service - User Manager for UID 500... Jan 29 11:15:04.154278 (systemd)[2458]: pam_unix(systemd-user:session): session opened for user core(uid=500) by (uid=0) Jan 29 11:15:04.230597 systemd[2458]: Queued start job for default target default.target. Jan 29 11:15:04.241961 systemd[2458]: Created slice app.slice - User Application Slice. Jan 29 11:15:04.241989 systemd[2458]: Reached target paths.target - Paths. Jan 29 11:15:04.242000 systemd[2458]: Reached target timers.target - Timers. Jan 29 11:15:04.243250 systemd[2458]: Starting dbus.socket - D-Bus User Message Bus Socket... Jan 29 11:15:04.252484 systemd[2458]: Listening on dbus.socket - D-Bus User Message Bus Socket. Jan 29 11:15:04.252540 systemd[2458]: Reached target sockets.target - Sockets. Jan 29 11:15:04.252552 systemd[2458]: Reached target basic.target - Basic System. Jan 29 11:15:04.252585 systemd[2458]: Reached target default.target - Main User Target. Jan 29 11:15:04.252609 systemd[2458]: Startup finished in 93ms. Jan 29 11:15:04.252867 systemd[1]: Started user@500.service - User Manager for UID 500. Jan 29 11:15:04.254201 systemd[1]: Started session-1.scope - Session 1 of User core. Jan 29 11:15:04.312900 systemd[1]: Started sshd@1-10.0.0.128:22-10.0.0.1:51116.service - OpenSSH per-connection server daemon (10.0.0.1:51116). Jan 29 11:15:04.365292 sshd[2469]: Accepted publickey for core from 10.0.0.1 port 51116 ssh2: RSA SHA256:Bq1DMYRFt3vwSJT5tcC1MQpWKmkwK1uKH+vc+Uts7DI Jan 29 11:15:04.366448 sshd-session[2469]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Jan 29 11:15:04.370927 systemd-logind[2231]: New session 2 of user core. Jan 29 11:15:04.381219 systemd[1]: Started session-2.scope - Session 2 of User core. Jan 29 11:15:04.432330 sshd[2471]: Connection closed by 10.0.0.1 port 51116 Jan 29 11:15:04.432227 sshd-session[2469]: pam_unix(sshd:session): session closed for user core Jan 29 11:15:04.443156 systemd[1]: sshd@1-10.0.0.128:22-10.0.0.1:51116.service: Deactivated successfully. Jan 29 11:15:04.444380 systemd[1]: session-2.scope: Deactivated successfully. Jan 29 11:15:04.446367 systemd-logind[2231]: Session 2 logged out. Waiting for processes to exit. Jan 29 11:15:04.446739 systemd[1]: Started sshd@2-10.0.0.128:22-10.0.0.1:51126.service - OpenSSH per-connection server daemon (10.0.0.1:51126). Jan 29 11:15:04.447868 systemd-logind[2231]: Removed session 2. Jan 29 11:15:04.485586 sshd[2476]: Accepted publickey for core from 10.0.0.1 port 51126 ssh2: RSA SHA256:Bq1DMYRFt3vwSJT5tcC1MQpWKmkwK1uKH+vc+Uts7DI Jan 29 11:15:04.486623 sshd-session[2476]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Jan 29 11:15:04.490011 systemd-logind[2231]: New session 3 of user core. Jan 29 11:15:04.497194 systemd[1]: Started session-3.scope - Session 3 of User core. Jan 29 11:15:04.546878 sshd[2478]: Connection closed by 10.0.0.1 port 51126 Jan 29 11:15:04.547174 sshd-session[2476]: pam_unix(sshd:session): session closed for user core Jan 29 11:15:04.549790 systemd[1]: sshd@2-10.0.0.128:22-10.0.0.1:51126.service: Deactivated successfully. Jan 29 11:15:04.551221 systemd[1]: session-3.scope: Deactivated successfully. Jan 29 11:15:04.552191 systemd-logind[2231]: Session 3 logged out. Waiting for processes to exit. Jan 29 11:15:04.553036 systemd-logind[2231]: Removed session 3. -- Reboot -- Jan 29 11:16:42.882054 kernel: Booting Linux on physical CPU 0x0000000000 [0x413fd0c1] Jan 29 11:16:42.882074 kernel: Linux version 6.6.74-flatcar (build@pony-truck.infra.kinvolk.io) (aarch64-cros-linux-gnu-gcc (Gentoo Hardened 13.3.1_p20240614 p1) 13.3.1 20240614, GNU ld (Gentoo 2.42 p6) 2.42.0) #1 SMP PREEMPT Wed Jan 29 09:37:00 -00 2025 Jan 29 11:16:42.882084 kernel: KASLR enabled Jan 29 11:16:42.882089 kernel: efi: EFI v2.7 by EDK II Jan 29 11:16:42.882095 kernel: efi: SMBIOS 3.0=0xdced0000 TPMFinalLog=0xd9740000 MEMATTR=0xdbbba018 ACPI 2.0=0xd9b43018 TPMEventLog=0xd973a018 RNG=0xd9b43698 MEMRESERVE=0xd9b40c18 Jan 29 11:16:42.882101 kernel: random: crng init done Jan 29 11:16:42.882107 kernel: secureboot: Secure boot disabled Jan 29 11:16:42.882113 kernel: ACPI: Early table checksum verification disabled Jan 29 11:16:42.882119 kernel: ACPI: RSDP 0x00000000D9B43018 000024 (v02 BOCHS ) Jan 29 11:16:42.882127 kernel: ACPI: XSDT 0x00000000D9B43F18 00006C (v01 BOCHS BXPC 00000001 01000013) Jan 29 11:16:42.882133 kernel: ACPI: FACP 0x00000000D9B43B18 000114 (v06 BOCHS BXPC 00000001 BXPC 00000001) Jan 29 11:16:42.882139 kernel: ACPI: DSDT 0x00000000D9B41018 0014EB (v02 BOCHS BXPC 00000001 BXPC 00000001) Jan 29 11:16:42.882145 kernel: ACPI: APIC 0x00000000D9B43C98 0001A8 (v04 BOCHS BXPC 00000001 BXPC 00000001) Jan 29 11:16:42.882151 kernel: ACPI: PPTT 0x00000000D9B43098 00009C (v02 BOCHS BXPC 00000001 BXPC 00000001) Jan 29 11:16:42.882158 kernel: ACPI: GTDT 0x00000000D9B43818 000060 (v02 BOCHS BXPC 00000001 BXPC 00000001) Jan 29 11:16:42.882165 kernel: ACPI: MCFG 0x00000000D9B43A98 00003C (v01 BOCHS BXPC 00000001 BXPC 00000001) Jan 29 11:16:42.882172 kernel: ACPI: SPCR 0x00000000D9B43918 000050 (v02 BOCHS BXPC 00000001 BXPC 00000001) Jan 29 11:16:42.882178 kernel: ACPI: DBG2 0x00000000D9B43998 000057 (v00 BOCHS BXPC 00000001 BXPC 00000001) Jan 29 11:16:42.882184 kernel: ACPI: IORT 0x00000000D9B43198 000080 (v03 BOCHS BXPC 00000001 BXPC 00000001) Jan 29 11:16:42.882190 kernel: ACPI: TPM2 0x00000000D9B43A18 00004C (v04 BOCHS BXPC 00000001 BXPC 00000001) Jan 29 11:16:42.882196 kernel: ACPI: SPCR: console: pl011,mmio,0x9000000,9600 Jan 29 11:16:42.882202 kernel: NUMA: Failed to initialise from firmware Jan 29 11:16:42.882208 kernel: NUMA: Faking a node at [mem 0x0000000040000000-0x00000000dcffffff] Jan 29 11:16:42.882214 kernel: NUMA: NODE_DATA [mem 0xdc957800-0xdc95cfff] Jan 29 11:16:42.882220 kernel: Zone ranges: Jan 29 11:16:42.882227 kernel: DMA [mem 0x0000000040000000-0x00000000dcffffff] Jan 29 11:16:42.882233 kernel: DMA32 empty Jan 29 11:16:42.882239 kernel: Normal empty Jan 29 11:16:42.882245 kernel: Movable zone start for each node Jan 29 11:16:42.882251 kernel: Early memory node ranges Jan 29 11:16:42.882257 kernel: node 0: [mem 0x0000000040000000-0x00000000d971ffff] Jan 29 11:16:42.882263 kernel: node 0: [mem 0x00000000d9720000-0x00000000d972ffff] Jan 29 11:16:42.882269 kernel: node 0: [mem 0x00000000d9730000-0x00000000d973ffff] Jan 29 11:16:42.882275 kernel: node 0: [mem 0x00000000d9740000-0x00000000d9b3ffff] Jan 29 11:16:42.882281 kernel: node 0: [mem 0x00000000d9b40000-0x00000000dce1ffff] Jan 29 11:16:42.882288 kernel: node 0: [mem 0x00000000dce20000-0x00000000dceaffff] Jan 29 11:16:42.882294 kernel: node 0: [mem 0x00000000dceb0000-0x00000000dcebffff] Jan 29 11:16:42.882301 kernel: node 0: [mem 0x00000000dcec0000-0x00000000dcfdffff] Jan 29 11:16:42.882307 kernel: node 0: [mem 0x00000000dcfe0000-0x00000000dcffffff] Jan 29 11:16:42.882313 kernel: Initmem setup node 0 [mem 0x0000000040000000-0x00000000dcffffff] Jan 29 11:16:42.882322 kernel: On node 0, zone DMA: 12288 pages in unavailable ranges Jan 29 11:16:42.882328 kernel: psci: probing for conduit method from ACPI. Jan 29 11:16:42.882335 kernel: psci: PSCIv1.1 detected in firmware. Jan 29 11:16:42.882342 kernel: psci: Using standard PSCI v0.2 function IDs Jan 29 11:16:42.882349 kernel: psci: Trusted OS migration not required Jan 29 11:16:42.882355 kernel: psci: SMC Calling Convention v1.1 Jan 29 11:16:42.882374 kernel: smccc: KVM: hypervisor services detected (0x00000000 0x00000000 0x00000000 0x00000003) Jan 29 11:16:42.882381 kernel: percpu: Embedded 31 pages/cpu s86696 r8192 d32088 u126976 Jan 29 11:16:42.882387 kernel: pcpu-alloc: s86696 r8192 d32088 u126976 alloc=31*4096 Jan 29 11:16:42.882394 kernel: pcpu-alloc: [0] 0 [0] 1 [0] 2 [0] 3 Jan 29 11:16:42.882401 kernel: Detected PIPT I-cache on CPU0 Jan 29 11:16:42.882408 kernel: CPU features: detected: GIC system register CPU interface Jan 29 11:16:42.882414 kernel: CPU features: detected: Hardware dirty bit management Jan 29 11:16:42.882422 kernel: CPU features: detected: Spectre-v4 Jan 29 11:16:42.882429 kernel: CPU features: detected: Spectre-BHB Jan 29 11:16:42.882435 kernel: CPU features: kernel page table isolation forced ON by KASLR Jan 29 11:16:42.882442 kernel: CPU features: detected: Kernel page table isolation (KPTI) Jan 29 11:16:42.882448 kernel: CPU features: detected: ARM erratum 1418040 Jan 29 11:16:42.882455 kernel: CPU features: detected: SSBS not fully self-synchronizing Jan 29 11:16:42.882461 kernel: alternatives: applying boot alternatives Jan 29 11:16:42.882469 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=ttyS0,115200 acpi=force verity.usrhash=c8edc06d36325e34bb125a9ad39c4f788eb9f01102631b71efea3f9afa94c89e Jan 29 11:16:42.882475 kernel: Unknown kernel command line parameters "BOOT_IMAGE=/flatcar/vmlinuz-a", will be passed to user space. Jan 29 11:16:42.882482 kernel: Dentry cache hash table entries: 524288 (order: 10, 4194304 bytes, linear) Jan 29 11:16:42.882488 kernel: Inode-cache hash table entries: 262144 (order: 9, 2097152 bytes, linear) Jan 29 11:16:42.882496 kernel: Fallback order for Node 0: 0 Jan 29 11:16:42.882503 kernel: Built 1 zonelists, mobility grouping on. Total pages: 633024 Jan 29 11:16:42.882509 kernel: Policy zone: DMA Jan 29 11:16:42.882516 kernel: mem auto-init: stack:off, heap alloc:off, heap free:off Jan 29 11:16:42.882522 kernel: software IO TLB: area num 4. Jan 29 11:16:42.882529 kernel: software IO TLB: mapped [mem 0x00000000d2e00000-0x00000000d6e00000] (64MB) Jan 29 11:16:42.882535 kernel: Memory: 2386044K/2572288K available (10240K kernel code, 2186K rwdata, 8096K rodata, 39680K init, 897K bss, 186244K reserved, 0K cma-reserved) Jan 29 11:16:42.882542 kernel: SLUB: HWalign=64, Order=0-3, MinObjects=0, CPUs=4, Nodes=1 Jan 29 11:16:42.882548 kernel: rcu: Preemptible hierarchical RCU implementation. Jan 29 11:16:42.882555 kernel: rcu: RCU event tracing is enabled. Jan 29 11:16:42.882562 kernel: rcu: RCU restricting CPUs from NR_CPUS=512 to nr_cpu_ids=4. Jan 29 11:16:42.882570 kernel: Trampoline variant of Tasks RCU enabled. Jan 29 11:16:42.882576 kernel: Tracing variant of Tasks RCU enabled. Jan 29 11:16:42.882583 kernel: rcu: RCU calculated value of scheduler-enlistment delay is 100 jiffies. Jan 29 11:16:42.882590 kernel: rcu: Adjusting geometry for rcu_fanout_leaf=16, nr_cpu_ids=4 Jan 29 11:16:42.882596 kernel: NR_IRQS: 64, nr_irqs: 64, preallocated irqs: 0 Jan 29 11:16:42.882602 kernel: GICv3: 256 SPIs implemented Jan 29 11:16:42.882609 kernel: GICv3: 0 Extended SPIs implemented Jan 29 11:16:42.882615 kernel: Root IRQ handler: gic_handle_irq Jan 29 11:16:42.882622 kernel: GICv3: GICv3 features: 16 PPIs, DirectLPI Jan 29 11:16:42.882628 kernel: GICv3: CPU0: found redistributor 0 region 0:0x00000000080a0000 Jan 29 11:16:42.882635 kernel: ITS [mem 0x08080000-0x0809ffff] Jan 29 11:16:42.882641 kernel: ITS@0x0000000008080000: allocated 8192 Devices @400c0000 (indirect, esz 8, psz 64K, shr 1) Jan 29 11:16:42.882649 kernel: ITS@0x0000000008080000: allocated 8192 Interrupt Collections @400d0000 (flat, esz 8, psz 64K, shr 1) Jan 29 11:16:42.882656 kernel: GICv3: using LPI property table @0x00000000400f0000 Jan 29 11:16:42.882663 kernel: GICv3: CPU0: using allocated LPI pending table @0x0000000040100000 Jan 29 11:16:42.882669 kernel: rcu: srcu_init: Setting srcu_struct sizes based on contention. Jan 29 11:16:42.882682 kernel: arch_timer: Enabling local workaround for ARM erratum 1418040 Jan 29 11:16:42.882689 kernel: arch_timer: cp15 timer(s) running at 25.00MHz (virt). Jan 29 11:16:42.882696 kernel: clocksource: arch_sys_counter: mask: 0xffffffffffffff max_cycles: 0x5c40939b5, max_idle_ns: 440795202646 ns Jan 29 11:16:42.882702 kernel: sched_clock: 56 bits at 25MHz, resolution 40ns, wraps every 4398046511100ns Jan 29 11:16:42.882709 kernel: arm-pv: using stolen time PV Jan 29 11:16:42.882716 kernel: Console: colour dummy device 80x25 Jan 29 11:16:42.882723 kernel: ACPI: Core revision 20230628 Jan 29 11:16:42.882731 kernel: Calibrating delay loop (skipped), value calculated using timer frequency.. 50.00 BogoMIPS (lpj=25000) Jan 29 11:16:42.882738 kernel: pid_max: default: 32768 minimum: 301 Jan 29 11:16:42.882745 kernel: LSM: initializing lsm=lockdown,capability,landlock,selinux,integrity Jan 29 11:16:42.882751 kernel: landlock: Up and running. Jan 29 11:16:42.882758 kernel: SELinux: Initializing. Jan 29 11:16:42.882764 kernel: Mount-cache hash table entries: 8192 (order: 4, 65536 bytes, linear) Jan 29 11:16:42.882771 kernel: Mountpoint-cache hash table entries: 8192 (order: 4, 65536 bytes, linear) Jan 29 11:16:42.882778 kernel: RCU Tasks: Setting shift to 2 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=4. Jan 29 11:16:42.882785 kernel: RCU Tasks Trace: Setting shift to 2 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=4. Jan 29 11:16:42.882792 kernel: rcu: Hierarchical SRCU implementation. Jan 29 11:16:42.882799 kernel: rcu: Max phase no-delay instances is 400. Jan 29 11:16:42.882806 kernel: Platform MSI: ITS@0x8080000 domain created Jan 29 11:16:42.882812 kernel: PCI/MSI: ITS@0x8080000 domain created Jan 29 11:16:42.882819 kernel: Remapping and enabling EFI services. Jan 29 11:16:42.882826 kernel: smp: Bringing up secondary CPUs ... Jan 29 11:16:42.882833 kernel: Detected PIPT I-cache on CPU1 Jan 29 11:16:42.882839 kernel: GICv3: CPU1: found redistributor 1 region 0:0x00000000080c0000 Jan 29 11:16:42.882846 kernel: GICv3: CPU1: using allocated LPI pending table @0x0000000040110000 Jan 29 11:16:42.882854 kernel: arch_timer: Enabling local workaround for ARM erratum 1418040 Jan 29 11:16:42.882861 kernel: CPU1: Booted secondary processor 0x0000000001 [0x413fd0c1] Jan 29 11:16:42.882872 kernel: Detected PIPT I-cache on CPU2 Jan 29 11:16:42.882880 kernel: GICv3: CPU2: found redistributor 2 region 0:0x00000000080e0000 Jan 29 11:16:42.882887 kernel: GICv3: CPU2: using allocated LPI pending table @0x0000000040120000 Jan 29 11:16:42.882894 kernel: arch_timer: Enabling local workaround for ARM erratum 1418040 Jan 29 11:16:42.882901 kernel: CPU2: Booted secondary processor 0x0000000002 [0x413fd0c1] Jan 29 11:16:42.882908 kernel: Detected PIPT I-cache on CPU3 Jan 29 11:16:42.882915 kernel: GICv3: CPU3: found redistributor 3 region 0:0x0000000008100000 Jan 29 11:16:42.882924 kernel: GICv3: CPU3: using allocated LPI pending table @0x0000000040130000 Jan 29 11:16:42.882931 kernel: arch_timer: Enabling local workaround for ARM erratum 1418040 Jan 29 11:16:42.882938 kernel: CPU3: Booted secondary processor 0x0000000003 [0x413fd0c1] Jan 29 11:16:42.882945 kernel: smp: Brought up 1 node, 4 CPUs Jan 29 11:16:42.882952 kernel: SMP: Total of 4 processors activated. Jan 29 11:16:42.882959 kernel: CPU features: detected: 32-bit EL0 Support Jan 29 11:16:42.882966 kernel: CPU features: detected: Data cache clean to the PoU not required for I/D coherence Jan 29 11:16:42.882973 kernel: CPU features: detected: Common not Private translations Jan 29 11:16:42.882981 kernel: CPU features: detected: CRC32 instructions Jan 29 11:16:42.882989 kernel: CPU features: detected: Enhanced Virtualization Traps Jan 29 11:16:42.882996 kernel: CPU features: detected: RCpc load-acquire (LDAPR) Jan 29 11:16:42.883003 kernel: CPU features: detected: LSE atomic instructions Jan 29 11:16:42.883011 kernel: CPU features: detected: Privileged Access Never Jan 29 11:16:42.883018 kernel: CPU features: detected: RAS Extension Support Jan 29 11:16:42.883025 kernel: CPU features: detected: Speculative Store Bypassing Safe (SSBS) Jan 29 11:16:42.883032 kernel: CPU: All CPU(s) started at EL1 Jan 29 11:16:42.883039 kernel: alternatives: applying system-wide alternatives Jan 29 11:16:42.883046 kernel: devtmpfs: initialized Jan 29 11:16:42.883055 kernel: clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1911260446275000 ns Jan 29 11:16:42.883062 kernel: futex hash table entries: 1024 (order: 4, 65536 bytes, linear) Jan 29 11:16:42.883069 kernel: pinctrl core: initialized pinctrl subsystem Jan 29 11:16:42.883076 kernel: SMBIOS 3.0.0 present. Jan 29 11:16:42.883083 kernel: DMI: QEMU KVM Virtual Machine, BIOS unknown 02/02/2022 Jan 29 11:16:42.883090 kernel: NET: Registered PF_NETLINK/PF_ROUTE protocol family Jan 29 11:16:42.883097 kernel: DMA: preallocated 512 KiB GFP_KERNEL pool for atomic allocations Jan 29 11:16:42.883104 kernel: DMA: preallocated 512 KiB GFP_KERNEL|GFP_DMA pool for atomic allocations Jan 29 11:16:42.883112 kernel: DMA: preallocated 512 KiB GFP_KERNEL|GFP_DMA32 pool for atomic allocations Jan 29 11:16:42.883120 kernel: audit: initializing netlink subsys (disabled) Jan 29 11:16:42.883127 kernel: audit: type=2000 audit(0.021:1): state=initialized audit_enabled=0 res=1 Jan 29 11:16:42.883134 kernel: thermal_sys: Registered thermal governor 'step_wise' Jan 29 11:16:42.883141 kernel: cpuidle: using governor menu Jan 29 11:16:42.883148 kernel: hw-breakpoint: found 6 breakpoint and 4 watchpoint registers. Jan 29 11:16:42.883155 kernel: ASID allocator initialised with 32768 entries Jan 29 11:16:42.883162 kernel: acpiphp: ACPI Hot Plug PCI Controller Driver version: 0.5 Jan 29 11:16:42.883169 kernel: Serial: AMBA PL011 UART driver Jan 29 11:16:42.883176 kernel: Modules: 2G module region forced by RANDOMIZE_MODULE_REGION_FULL Jan 29 11:16:42.883185 kernel: Modules: 0 pages in range for non-PLT usage Jan 29 11:16:42.883192 kernel: Modules: 508960 pages in range for PLT usage Jan 29 11:16:42.883199 kernel: HugeTLB: registered 1.00 GiB page size, pre-allocated 0 pages Jan 29 11:16:42.883206 kernel: HugeTLB: 0 KiB vmemmap can be freed for a 1.00 GiB page Jan 29 11:16:42.883213 kernel: HugeTLB: registered 32.0 MiB page size, pre-allocated 0 pages Jan 29 11:16:42.883220 kernel: HugeTLB: 0 KiB vmemmap can be freed for a 32.0 MiB page Jan 29 11:16:42.883227 kernel: HugeTLB: registered 2.00 MiB page size, pre-allocated 0 pages Jan 29 11:16:42.883235 kernel: HugeTLB: 0 KiB vmemmap can be freed for a 2.00 MiB page Jan 29 11:16:42.883242 kernel: HugeTLB: registered 64.0 KiB page size, pre-allocated 0 pages Jan 29 11:16:42.883251 kernel: HugeTLB: 0 KiB vmemmap can be freed for a 64.0 KiB page Jan 29 11:16:42.883258 kernel: ACPI: Added _OSI(Module Device) Jan 29 11:16:42.883265 kernel: ACPI: Added _OSI(Processor Device) Jan 29 11:16:42.883272 kernel: ACPI: Added _OSI(3.0 _SCP Extensions) Jan 29 11:16:42.883292 kernel: ACPI: Added _OSI(Processor Aggregator Device) Jan 29 11:16:42.883299 kernel: ACPI: 1 ACPI AML tables successfully acquired and loaded Jan 29 11:16:42.883306 kernel: ACPI: Interpreter enabled Jan 29 11:16:42.883313 kernel: ACPI: Using GIC for interrupt routing Jan 29 11:16:42.883322 kernel: ACPI: MCFG table detected, 1 entries Jan 29 11:16:42.883330 kernel: ARMH0011:00: ttyAMA0 at MMIO 0x9000000 (irq = 12, base_baud = 0) is a SBSA Jan 29 11:16:42.883337 kernel: printk: console [ttyAMA0] enabled Jan 29 11:16:42.883344 kernel: ACPI: PCI Root Bridge [PCI0] (domain 0000 [bus 00-ff]) Jan 29 11:16:42.883477 kernel: acpi PNP0A08:00: _OSC: OS supports [ExtendedConfig ASPM ClockPM Segments MSI HPX-Type3] Jan 29 11:16:42.883552 kernel: acpi PNP0A08:00: _OSC: platform does not support [LTR] Jan 29 11:16:42.883615 kernel: acpi PNP0A08:00: _OSC: OS now controls [PCIeHotplug PME AER PCIeCapability] Jan 29 11:16:42.883686 kernel: acpi PNP0A08:00: ECAM area [mem 0x4010000000-0x401fffffff] reserved by PNP0C02:00 Jan 29 11:16:42.883756 kernel: acpi PNP0A08:00: ECAM at [mem 0x4010000000-0x401fffffff] for [bus 00-ff] Jan 29 11:16:42.883766 kernel: ACPI: Remapped I/O 0x000000003eff0000 to [io 0x0000-0xffff window] Jan 29 11:16:42.883773 kernel: PCI host bridge to bus 0000:00 Jan 29 11:16:42.883840 kernel: pci_bus 0000:00: root bus resource [mem 0x10000000-0x3efeffff window] Jan 29 11:16:42.883898 kernel: pci_bus 0000:00: root bus resource [io 0x0000-0xffff window] Jan 29 11:16:42.883954 kernel: pci_bus 0000:00: root bus resource [mem 0x8000000000-0xffffffffff window] Jan 29 11:16:42.884010 kernel: pci_bus 0000:00: root bus resource [bus 00-ff] Jan 29 11:16:42.884089 kernel: pci 0000:00:00.0: [1b36:0008] type 00 class 0x060000 Jan 29 11:16:42.884162 kernel: pci 0000:00:01.0: [1af4:1005] type 00 class 0x00ff00 Jan 29 11:16:42.884229 kernel: pci 0000:00:01.0: reg 0x10: [io 0x0000-0x001f] Jan 29 11:16:42.884298 kernel: pci 0000:00:01.0: reg 0x14: [mem 0x10000000-0x10000fff] Jan 29 11:16:42.884377 kernel: pci 0000:00:01.0: reg 0x20: [mem 0x8000000000-0x8000003fff 64bit pref] Jan 29 11:16:42.884451 kernel: pci 0000:00:01.0: BAR 4: assigned [mem 0x8000000000-0x8000003fff 64bit pref] Jan 29 11:16:42.884517 kernel: pci 0000:00:01.0: BAR 1: assigned [mem 0x10000000-0x10000fff] Jan 29 11:16:42.884589 kernel: pci 0000:00:01.0: BAR 0: assigned [io 0x1000-0x101f] Jan 29 11:16:42.884651 kernel: pci_bus 0000:00: resource 4 [mem 0x10000000-0x3efeffff window] Jan 29 11:16:42.884719 kernel: pci_bus 0000:00: resource 5 [io 0x0000-0xffff window] Jan 29 11:16:42.884778 kernel: pci_bus 0000:00: resource 6 [mem 0x8000000000-0xffffffffff window] Jan 29 11:16:42.884787 kernel: ACPI: PCI: Interrupt link GSI0 configured for IRQ 35 Jan 29 11:16:42.884795 kernel: ACPI: PCI: Interrupt link GSI1 configured for IRQ 36 Jan 29 11:16:42.884802 kernel: ACPI: PCI: Interrupt link GSI2 configured for IRQ 37 Jan 29 11:16:42.884812 kernel: ACPI: PCI: Interrupt link GSI3 configured for IRQ 38 Jan 29 11:16:42.884819 kernel: iommu: Default domain type: Translated Jan 29 11:16:42.884826 kernel: iommu: DMA domain TLB invalidation policy: strict mode Jan 29 11:16:42.884833 kernel: efivars: Registered efivars operations Jan 29 11:16:42.884840 kernel: vgaarb: loaded Jan 29 11:16:42.884858 kernel: clocksource: Switched to clocksource arch_sys_counter Jan 29 11:16:42.884865 kernel: VFS: Disk quotas dquot_6.6.0 Jan 29 11:16:42.884872 kernel: VFS: Dquot-cache hash table entries: 512 (order 0, 4096 bytes) Jan 29 11:16:42.884879 kernel: pnp: PnP ACPI init Jan 29 11:16:42.884954 kernel: system 00:00: [mem 0x4010000000-0x401fffffff window] could not be reserved Jan 29 11:16:42.884968 kernel: pnp: PnP ACPI: found 1 devices Jan 29 11:16:42.884975 kernel: NET: Registered PF_INET protocol family Jan 29 11:16:42.884982 kernel: IP idents hash table entries: 65536 (order: 7, 524288 bytes, linear) Jan 29 11:16:42.884990 kernel: tcp_listen_portaddr_hash hash table entries: 2048 (order: 3, 32768 bytes, linear) Jan 29 11:16:42.884997 kernel: Table-perturb hash table entries: 65536 (order: 6, 262144 bytes, linear) Jan 29 11:16:42.885004 kernel: TCP established hash table entries: 32768 (order: 6, 262144 bytes, linear) Jan 29 11:16:42.885011 kernel: TCP bind hash table entries: 32768 (order: 8, 1048576 bytes, linear) Jan 29 11:16:42.885018 kernel: TCP: Hash tables configured (established 32768 bind 32768) Jan 29 11:16:42.885027 kernel: UDP hash table entries: 2048 (order: 4, 65536 bytes, linear) Jan 29 11:16:42.885034 kernel: UDP-Lite hash table entries: 2048 (order: 4, 65536 bytes, linear) Jan 29 11:16:42.885041 kernel: NET: Registered PF_UNIX/PF_LOCAL protocol family Jan 29 11:16:42.885048 kernel: PCI: CLS 0 bytes, default 64 Jan 29 11:16:42.885055 kernel: kvm [1]: HYP mode not available Jan 29 11:16:42.885062 kernel: Initialise system trusted keyrings Jan 29 11:16:42.885070 kernel: workingset: timestamp_bits=39 max_order=20 bucket_order=0 Jan 29 11:16:42.885077 kernel: Key type asymmetric registered Jan 29 11:16:42.885084 kernel: Asymmetric key parser 'x509' registered Jan 29 11:16:42.885092 kernel: Block layer SCSI generic (bsg) driver version 0.4 loaded (major 250) Jan 29 11:16:42.885099 kernel: io scheduler mq-deadline registered Jan 29 11:16:42.885106 kernel: io scheduler kyber registered Jan 29 11:16:42.885113 kernel: io scheduler bfq registered Jan 29 11:16:42.885121 kernel: input: Power Button as /devices/LNXSYSTM:00/LNXSYBUS:00/PNP0C0C:00/input/input0 Jan 29 11:16:42.885127 kernel: ACPI: button: Power Button [PWRB] Jan 29 11:16:42.885135 kernel: ACPI: \_SB_.PCI0.GSI1: Enabled at IRQ 36 Jan 29 11:16:42.885200 kernel: virtio-pci 0000:00:01.0: enabling device (0005 -> 0007) Jan 29 11:16:42.885210 kernel: Serial: 8250/16550 driver, 4 ports, IRQ sharing enabled Jan 29 11:16:42.885219 kernel: thunder_xcv, ver 1.0 Jan 29 11:16:42.885226 kernel: thunder_bgx, ver 1.0 Jan 29 11:16:42.885233 kernel: nicpf, ver 1.0 Jan 29 11:16:42.885240 kernel: nicvf, ver 1.0 Jan 29 11:16:42.885310 kernel: rtc-efi rtc-efi.0: registered as rtc0 Jan 29 11:16:42.885459 kernel: rtc-efi rtc-efi.0: setting system clock to 2025-01-29T11:16:42 UTC (1738149402) Jan 29 11:16:42.885473 kernel: hid: raw HID events driver (C) Jiri Kosina Jan 29 11:16:42.885480 kernel: hw perfevents: enabled with armv8_pmuv3_0 PMU driver, 7 counters available Jan 29 11:16:42.885492 kernel: watchdog: Delayed init of the lockup detector failed: -19 Jan 29 11:16:42.885499 kernel: watchdog: Hard watchdog permanently disabled Jan 29 11:16:42.885506 kernel: NET: Registered PF_INET6 protocol family Jan 29 11:16:42.885513 kernel: Segment Routing with IPv6 Jan 29 11:16:42.885520 kernel: In-situ OAM (IOAM) with IPv6 Jan 29 11:16:42.885527 kernel: NET: Registered PF_PACKET protocol family Jan 29 11:16:42.885535 kernel: Key type dns_resolver registered Jan 29 11:16:42.885542 kernel: registered taskstats version 1 Jan 29 11:16:42.885549 kernel: Loading compiled-in X.509 certificates Jan 29 11:16:42.885558 kernel: Loaded X.509 cert 'Kinvolk GmbH: Module signing key for 6.6.74-flatcar: f3333311a24aa8c58222f4e98a07eaa1f186ad1a' Jan 29 11:16:42.885565 kernel: Key type .fscrypt registered Jan 29 11:16:42.885572 kernel: Key type fscrypt-provisioning registered Jan 29 11:16:42.885579 kernel: ima: No TPM chip found, activating TPM-bypass! Jan 29 11:16:42.885586 kernel: ima: Allocated hash algorithm: sha1 Jan 29 11:16:42.885593 kernel: ima: No architecture policies found Jan 29 11:16:42.885601 kernel: alg: No test for fips(ansi_cprng) (fips_ansi_cprng) Jan 29 11:16:42.885608 kernel: clk: Disabling unused clocks Jan 29 11:16:42.885615 kernel: Freeing unused kernel memory: 39680K Jan 29 11:16:42.885624 kernel: Run /init as init process Jan 29 11:16:42.885630 kernel: with arguments: Jan 29 11:16:42.885637 kernel: /init Jan 29 11:16:42.885644 kernel: with environment: Jan 29 11:16:42.885651 kernel: HOME=/ Jan 29 11:16:42.885658 kernel: TERM=linux Jan 29 11:16:42.885665 kernel: BOOT_IMAGE=/flatcar/vmlinuz-a Jan 29 11:16:42.885681 systemd[1]: systemd 255 running in system mode (+PAM +AUDIT +SELINUX -APPARMOR +IMA +SMACK +SECCOMP +GCRYPT -GNUTLS +OPENSSL -ACL +BLKID +CURL +ELFUTILS -FIDO2 +IDN2 -IDN +IPTC +KMOD +LIBCRYPTSETUP +LIBFDISK +PCRE2 -PWQUALITY -P11KIT -QRENCODE +TPM2 +BZIP2 +LZ4 +XZ +ZLIB +ZSTD -BPF_FRAMEWORK -XKBCOMMON +UTMP -SYSVINIT default-hierarchy=unified) Jan 29 11:16:42.885694 systemd[1]: Detected virtualization kvm. Jan 29 11:16:42.885702 systemd[1]: Detected architecture arm64. Jan 29 11:16:42.885709 systemd[1]: Running in initrd. Jan 29 11:16:42.885716 systemd[1]: No hostname configured, using default hostname. Jan 29 11:16:42.885723 systemd[1]: Hostname set to <localhost>. Jan 29 11:16:42.885731 systemd[1]: Initializing machine ID from VM UUID. Jan 29 11:16:42.885738 systemd[1]: Queued start job for default target initrd.target. Jan 29 11:16:42.885746 systemd[1]: Started clevis-luks-askpass.path - Forward Password Requests to Clevis Directory Watch. Jan 29 11:16:42.885755 systemd[1]: Started systemd-ask-password-console.path - Dispatch Password Requests to Console Directory Watch. Jan 29 11:16:42.885763 systemd[1]: Expecting device dev-disk-by\x2dlabel-OEM.device - /dev/disk/by-label/OEM... Jan 29 11:16:42.885771 systemd[1]: Expecting device dev-disk-by\x2dlabel-ROOT.device - /dev/disk/by-label/ROOT... Jan 29 11:16:42.885779 systemd[1]: Expecting device dev-disk-by\x2dpartlabel-USR\x2dA.device - /dev/disk/by-partlabel/USR-A... Jan 29 11:16:42.885788 systemd[1]: Expecting device dev-disk-by\x2dpartuuid-7130c94a\x2d213a\x2d4e5a\x2d8e26\x2d6cce9662f132.device - /dev/disk/by-partuuid/7130c94a-213a-4e5a-8e26-6cce9662f132... Jan 29 11:16:42.885796 systemd[1]: Expecting device dev-mapper-usr.device - /dev/mapper/usr... Jan 29 11:16:42.885805 systemd[1]: Reached target cryptsetup-pre.target - Local Encrypted Volumes (Pre). Jan 29 11:16:42.885813 systemd[1]: Reached target cryptsetup.target - Local Encrypted Volumes. Jan 29 11:16:42.885835 systemd[1]: Reached target ignition-diskful-subsequent.target - Ignition Subsequent Boot Disk Setup. Jan 29 11:16:42.885842 systemd[1]: Reached target paths.target - Path Units. Jan 29 11:16:42.885850 systemd[1]: Reached target slices.target - Slice Units. Jan 29 11:16:42.885858 systemd[1]: Reached target swap.target - Swaps. Jan 29 11:16:42.885866 systemd[1]: Reached target timers.target - Timer Units. Jan 29 11:16:42.885873 systemd[1]: Listening on iscsid.socket - Open-iSCSI iscsid Socket. Jan 29 11:16:42.885881 systemd[1]: Listening on iscsiuio.socket - Open-iSCSI iscsiuio Socket. Jan 29 11:16:42.885890 systemd[1]: Listening on systemd-journald-dev-log.socket - Journal Socket (/dev/log). Jan 29 11:16:42.885897 systemd[1]: Listening on systemd-journald.socket - Journal Socket. Jan 29 11:16:42.885905 systemd[1]: Listening on systemd-udevd-control.socket - udev Control Socket. Jan 29 11:16:42.885913 systemd[1]: Listening on systemd-udevd-kernel.socket - udev Kernel Socket. Jan 29 11:16:42.885921 systemd[1]: Reached target sockets.target - Socket Units. Jan 29 11:16:42.885929 systemd[1]: Starting ignition-setup-pre.service - Ignition env setup... Jan 29 11:16:42.885937 systemd[1]: Starting kmod-static-nodes.service - Create List of Static Device Nodes... Jan 29 11:16:42.885945 systemd[1]: Starting systemd-fsck-usr.service... Jan 29 11:16:42.885952 systemd[1]: Starting systemd-journald.service - Journal Service... Jan 29 11:16:42.885961 systemd[1]: Starting systemd-modules-load.service - Load Kernel Modules... Jan 29 11:16:42.885969 systemd[1]: Starting systemd-vconsole-setup.service - Virtual Console Setup... Jan 29 11:16:42.885976 systemd[1]: Finished ignition-setup-pre.service - Ignition env setup. Jan 29 11:16:42.885984 systemd[1]: Finished kmod-static-nodes.service - Create List of Static Device Nodes. Jan 29 11:16:42.885992 systemd[1]: Finished systemd-fsck-usr.service. Jan 29 11:16:42.886019 systemd-journald[231]: Collecting audit messages is disabled. Jan 29 11:16:42.886040 systemd[1]: Starting systemd-tmpfiles-setup-dev-early.service - Create Static Device Nodes in /dev gracefully... Jan 29 11:16:42.886048 systemd[1]: Finished systemd-vconsole-setup.service - Virtual Console Setup. Jan 29 11:16:42.886057 systemd-journald[231]: Journal started Jan 29 11:16:42.886077 systemd-journald[231]: Runtime Journal (/run/log/journal/26241df84bea4e8d8f434986b14b8294) is 5.9M, max 47.3M, 41.4M free. Jan 29 11:16:42.876807 systemd-modules-load[234]: Inserted module 'overlay' Jan 29 11:16:42.888564 systemd[1]: Starting dracut-cmdline-ask.service - dracut ask for additional cmdline parameters... Jan 29 11:16:42.889405 systemd[1]: Started systemd-journald.service - Journal Service. Jan 29 11:16:42.889421 kernel: bridge: filtering via arp/ip/ip6tables is no longer available by default. Update your scripts to load br_netfilter if you need this. Jan 29 11:16:42.891522 systemd[1]: Finished systemd-tmpfiles-setup-dev-early.service - Create Static Device Nodes in /dev gracefully. Jan 29 11:16:42.893884 kernel: Bridge firewalling registered Jan 29 11:16:42.892896 systemd-modules-load[234]: Inserted module 'br_netfilter' Jan 29 11:16:42.894301 systemd[1]: Finished systemd-modules-load.service - Load Kernel Modules. Jan 29 11:16:42.896299 systemd[1]: Starting systemd-sysctl.service - Apply Kernel Variables... Jan 29 11:16:42.899567 systemd[1]: Starting systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev... Jan 29 11:16:42.903495 systemd[1]: Starting systemd-tmpfiles-setup.service - Create System Files and Directories... Jan 29 11:16:42.909433 systemd[1]: Finished dracut-cmdline-ask.service - dracut ask for additional cmdline parameters. Jan 29 11:16:42.910591 systemd[1]: Finished systemd-sysctl.service - Apply Kernel Variables. Jan 29 11:16:42.912161 systemd[1]: Finished systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev. Jan 29 11:16:42.913648 systemd[1]: Finished systemd-tmpfiles-setup.service - Create System Files and Directories. Jan 29 11:16:42.916564 systemd[1]: Starting dracut-cmdline.service - dracut cmdline hook... Jan 29 11:16:42.928703 dracut-cmdline[270]: dracut-dracut-053 Jan 29 11:16:42.931386 dracut-cmdline[270]: 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=ttyS0,115200 acpi=force verity.usrhash=c8edc06d36325e34bb125a9ad39c4f788eb9f01102631b71efea3f9afa94c89e Jan 29 11:16:42.995391 kernel: SCSI subsystem initialized Jan 29 11:16:42.999376 kernel: Loading iSCSI transport class v2.0-870. Jan 29 11:16:43.009380 kernel: iscsi: registered transport (tcp) Jan 29 11:16:43.019385 kernel: iscsi: registered transport (qla4xxx) Jan 29 11:16:43.019403 kernel: QLogic iSCSI HBA Driver Jan 29 11:16:43.062423 systemd[1]: Finished dracut-cmdline.service - dracut cmdline hook. Jan 29 11:16:43.080499 systemd[1]: Starting dracut-pre-udev.service - dracut pre-udev hook... Jan 29 11:16:43.097792 kernel: device-mapper: core: CONFIG_IMA_DISABLE_HTABLE is disabled. Duplicate IMA measurements will not be recorded in the IMA log. Jan 29 11:16:43.097847 kernel: device-mapper: uevent: version 1.0.3 Jan 29 11:16:43.097865 kernel: device-mapper: ioctl: 4.48.0-ioctl (2023-03-01) initialised: dm-devel@redhat.com Jan 29 11:16:43.145380 kernel: raid6: neonx8 gen() 15673 MB/s Jan 29 11:16:43.162371 kernel: raid6: neonx4 gen() 15521 MB/s Jan 29 11:16:43.179377 kernel: raid6: neonx2 gen() 13151 MB/s Jan 29 11:16:43.196370 kernel: raid6: neonx1 gen() 10395 MB/s Jan 29 11:16:43.213371 kernel: raid6: int64x8 gen() 6886 MB/s Jan 29 11:16:43.230369 kernel: raid6: int64x4 gen() 7291 MB/s Jan 29 11:16:43.247371 kernel: raid6: int64x2 gen() 6074 MB/s Jan 29 11:16:43.264374 kernel: raid6: int64x1 gen() 5024 MB/s Jan 29 11:16:43.264397 kernel: raid6: using algorithm neonx8 gen() 15673 MB/s Jan 29 11:16:43.281383 kernel: raid6: .... xor() 11864 MB/s, rmw enabled Jan 29 11:16:43.281408 kernel: raid6: using neon recovery algorithm Jan 29 11:16:43.286475 kernel: xor: measuring software checksum speed Jan 29 11:16:43.286489 kernel: 8regs : 19290 MB/sec Jan 29 11:16:43.287571 kernel: 32regs : 19693 MB/sec Jan 29 11:16:43.287588 kernel: arm64_neon : 27007 MB/sec Jan 29 11:16:43.287598 kernel: xor: using function: arm64_neon (27007 MB/sec) Jan 29 11:16:43.337386 kernel: Btrfs loaded, zoned=no, fsverity=no Jan 29 11:16:43.348114 systemd[1]: Finished dracut-pre-udev.service - dracut pre-udev hook. Jan 29 11:16:43.360504 systemd[1]: Starting systemd-udevd.service - Rule-based Manager for Device Events and Files... Jan 29 11:16:43.371434 systemd-udevd[453]: Using default interface naming scheme 'v255'. Jan 29 11:16:43.375077 systemd[1]: Started systemd-udevd.service - Rule-based Manager for Device Events and Files. Jan 29 11:16:43.382647 systemd[1]: Starting dracut-pre-trigger.service - dracut pre-trigger hook... Jan 29 11:16:43.398115 dracut-pre-trigger[461]: rd.md=0: removing MD RAID activation Jan 29 11:16:43.424117 systemd[1]: Finished dracut-pre-trigger.service - dracut pre-trigger hook. Jan 29 11:16:43.440514 systemd[1]: Starting systemd-udev-trigger.service - Coldplug All udev Devices... Jan 29 11:16:43.481542 systemd[1]: Finished systemd-udev-trigger.service - Coldplug All udev Devices. Jan 29 11:16:43.489538 systemd[1]: Starting dracut-initqueue.service - dracut initqueue hook... Jan 29 11:16:43.501080 systemd[1]: Finished dracut-initqueue.service - dracut initqueue hook. Jan 29 11:16:43.503412 systemd[1]: Reached target remote-fs-pre.target - Preparation for Remote File Systems. Jan 29 11:16:43.505295 systemd[1]: Reached target remote-cryptsetup.target - Remote Encrypted Volumes. Jan 29 11:16:43.507134 systemd[1]: Reached target remote-fs.target - Remote File Systems. Jan 29 11:16:43.516611 systemd[1]: Starting dracut-pre-mount.service - dracut pre-mount hook... Jan 29 11:16:43.526379 kernel: tpm_tis MSFT0101:00: 2.0 TPM (device-id 0x1, rev-id 1) Jan 29 11:16:43.543515 kernel: virtio_blk virtio1: 1/0/0 default/read/poll queues Jan 29 11:16:43.543620 kernel: virtio_blk virtio1: [vda] 1064960 512-byte logical blocks (545 MB/520 MiB) Jan 29 11:16:43.543706 kernel: virtio_blk virtio2: 1/0/0 default/read/poll queues Jan 29 11:16:43.543784 kernel: virtio_blk virtio2: [vdb] 9289728 512-byte logical blocks (4.76 GB/4.43 GiB) Jan 29 11:16:43.543850 kernel: vdb: vdb1 vdb2 vdb3 vdb4 vdb6 vdb7 vdb9 Jan 29 11:16:43.528413 systemd[1]: Finished dracut-pre-mount.service - dracut pre-mount hook. Jan 29 11:16:43.535915 systemd[1]: dracut-cmdline-ask.service: Deactivated successfully. Jan 29 11:16:43.536031 systemd[1]: Stopped dracut-cmdline-ask.service - dracut ask for additional cmdline parameters. Jan 29 11:16:43.537155 systemd[1]: Stopping dracut-cmdline-ask.service - dracut ask for additional cmdline parameters... Jan 29 11:16:43.538812 systemd[1]: systemd-vconsole-setup.service: Deactivated successfully. Jan 29 11:16:43.538955 systemd[1]: Stopped systemd-vconsole-setup.service - Virtual Console Setup. Jan 29 11:16:43.541704 systemd[1]: Stopping systemd-vconsole-setup.service - Virtual Console Setup... Jan 29 11:16:43.549589 systemd[1]: Starting systemd-vconsole-setup.service - Virtual Console Setup... Jan 29 11:16:43.560747 systemd[1]: Finished systemd-vconsole-setup.service - Virtual Console Setup. Jan 29 11:16:43.568716 kernel: BTRFS: device label OEM devid 1 transid 20 /dev/vdb6 scanned by (udev-worker) (520) Jan 29 11:16:43.570386 kernel: BTRFS: device fsid b5bc7ecc-f31a-46c7-9582-5efca7819025 devid 1 transid 39 /dev/vdb3 scanned by (udev-worker) (516) Jan 29 11:16:43.572593 systemd[1]: Starting dracut-cmdline-ask.service - dracut ask for additional cmdline parameters... Jan 29 11:16:43.579621 systemd[1]: Condition check resulted in dev-disk-by\x2dpartuuid-312d1d97\x2d24d0\x2d4ba4\x2db8cb\x2d142a38cc13b7.device - /dev/disk/by-partuuid/312d1d97-24d0-4ba4-b8cb-142a38cc13b7 being skipped. Jan 29 11:16:43.579639 systemd[1]: Condition check resulted in dev-disk-by\x2ddiskseq-2\x2dpart9.device - /dev/disk/by-diskseq/2-part9 being skipped. Jan 29 11:16:43.579646 systemd[1]: Condition check resulted in dev-disk-by\x2dpath-platform\x2dLNRO0005:1f\x2dpart9.device - /dev/disk/by-path/platform-LNRO0005:1f-part9 being skipped. Jan 29 11:16:43.579652 systemd[1]: Condition check resulted in dev-disk-by\x2dpartlabel-ROOT.device - /dev/disk/by-partlabel/ROOT being skipped. Jan 29 11:16:43.579659 systemd[1]: Condition check resulted in dev-disk-by\x2duuid-46e18de8\x2df34f\x2d418c\x2d86f8\x2d742425a13ab8.device - /dev/disk/by-uuid/46e18de8-f34f-418c-86f8-742425a13ab8 being skipped. Jan 29 11:16:43.579665 systemd[1]: Condition check resulted in dev-vdb9.device - /dev/vdb9 being skipped. Jan 29 11:16:43.585828 systemd[1]: Finished dracut-cmdline-ask.service - dracut ask for additional cmdline parameters. Jan 29 11:16:43.593285 systemd[1]: Found device dev-disk-by\x2dlabel-OEM.device - /dev/disk/by-label/OEM. Jan 29 11:16:43.597064 systemd[1]: Found device dev-disk-by\x2dpartuuid-7130c94a\x2d213a\x2d4e5a\x2d8e26\x2d6cce9662f132.device - /dev/disk/by-partuuid/7130c94a-213a-4e5a-8e26-6cce9662f132. Jan 29 11:16:43.598003 systemd[1]: Found device dev-disk-by\x2dpartlabel-USR\x2dA.device - /dev/disk/by-partlabel/USR-A. Jan 29 11:16:43.610543 systemd[1]: Starting decrypt-root.service - Generate and execute a systemd-cryptsetup service to decrypt the ROOT partition... Jan 29 11:16:43.612003 systemd[1]: Starting disk-uuid.service - Generate new UUID for disk GPT if necessary... Jan 29 11:16:43.618008 systemd[1]: disk-uuid.service: Deactivated successfully. Jan 29 11:16:43.618113 systemd[1]: Finished disk-uuid.service - Generate new UUID for disk GPT if necessary. Jan 29 11:16:43.619720 systemd[1]: Reached target local-fs-pre.target - Preparation for Local File Systems. Jan 29 11:16:43.621122 systemd[1]: Reached target local-fs.target - Local File Systems. Jan 29 11:16:43.622556 systemd[1]: Reached target sysinit.target - System Initialization. Jan 29 11:16:43.623841 systemd[1]: Reached target basic.target - Basic System. Jan 29 11:16:43.625739 systemd[1]: Starting verity-setup.service - Verity Setup for /dev/mapper/usr... Jan 29 11:16:43.628284 systemd[1]: Reloading requested from client PID 560 ('systemctl') (unit decrypt-root.service)... Jan 29 11:16:43.628297 systemd[1]: Reloading... Jan 29 11:16:43.633181 sh[565]: Success Jan 29 11:16:43.650346 kernel: device-mapper: verity: sha256 using implementation "sha256-ce" Jan 29 11:16:43.739775 systemd[1]: Found device dev-mapper-usr.device - /dev/mapper/usr. Jan 29 11:16:43.740648 systemd[1]: Reloading finished in 112 ms. Jan 29 11:16:43.769415 systemd[1]: Finished verity-setup.service - Verity Setup for /dev/mapper/usr. Jan 29 11:16:43.775790 systemd[1]: Mounting sysusr-usr.mount - /sysusr/usr... Jan 29 11:16:43.777525 systemd[1]: Created slice system-systemd\x2dcryptsetup.slice - Slice /system/systemd-cryptsetup. Jan 29 11:16:43.779187 systemd[1]: Starting systemd-cryptsetup@rootencrypted.service - Cryptography Setup for rootencrypted... Jan 29 11:16:43.789152 kernel: BTRFS info (device dm-0): first mount of filesystem b5bc7ecc-f31a-46c7-9582-5efca7819025 Jan 29 11:16:43.789188 kernel: BTRFS info (device dm-0): using crc32c (crc32c-generic) checksum algorithm Jan 29 11:16:43.789205 kernel: BTRFS warning (device dm-0): 'nologreplay' is deprecated, use 'rescue=nologreplay' instead Jan 29 11:16:43.789215 kernel: BTRFS info (device dm-0): disabling log replay at mount time Jan 29 11:16:43.789739 kernel: BTRFS info (device dm-0): using free space tree Jan 29 11:16:43.793942 systemd[1]: Mounted sysusr-usr.mount - /sysusr/usr. Jan 29 11:16:44.071592 kernel: Key type trusted registered Jan 29 11:16:44.073547 kernel: Key type encrypted registered Jan 29 11:16:44.095128 systemd[1]: Finished systemd-cryptsetup@rootencrypted.service - Cryptography Setup for rootencrypted. Jan 29 11:16:44.098700 systemd[1]: Found device dev-disk-by\x2dlabel-ROOT.device - /dev/disk/by-label/ROOT. Jan 29 11:16:44.099835 systemd[1]: Finished decrypt-root.service - Generate and execute a systemd-cryptsetup service to decrypt the ROOT partition. Jan 29 11:16:44.102517 systemd[1]: Reached target initrd-root-device.target - Initrd Root Device. Jan 29 11:16:44.113496 systemd[1]: Starting systemd-fsck-root.service - File System Check on /dev/disk/by-label/ROOT... Jan 29 11:16:44.123484 systemd-fsck[716]: ROOT: clean, 202/137360 files, 32562/549376 blocks Jan 29 11:16:44.126793 systemd[1]: Finished systemd-fsck-root.service - File System Check on /dev/disk/by-label/ROOT. Jan 29 11:16:44.128589 systemd[1]: Mounting sysroot.mount - /sysroot... Jan 29 11:16:44.177413 kernel: EXT4-fs (dm-1): mounted filesystem 3d702c2f-2e35-4867-ae49-d597b9ede2d5 r/w with ordered data mode. Quota mode: none. Jan 29 11:16:44.177447 systemd[1]: Mounted sysroot.mount - /sysroot. Jan 29 11:16:44.178555 systemd[1]: Reached target initrd-root-fs.target - Initrd Root File System. Jan 29 11:16:44.199450 systemd[1]: Mounting sysroot-oem.mount - /sysroot/oem... Jan 29 11:16:44.201107 systemd[1]: Mounting sysroot-usr.mount - /sysroot/usr... Jan 29 11:16:44.206843 systemd[1]: Mounted sysroot-usr.mount - /sysroot/usr. Jan 29 11:16:44.208885 systemd[1]: Starting initrd-setup-root.service - Root filesystem setup... Jan 29 11:16:44.212562 kernel: BTRFS info (device vdb6): first mount of filesystem 9c6de53f-d522-4994-b092-a63f342c3ab0 Jan 29 11:16:44.212629 kernel: BTRFS info (device vdb6): using crc32c (crc32c-generic) checksum algorithm Jan 29 11:16:44.212642 kernel: BTRFS info (device vdb6): using free space tree Jan 29 11:16:44.214383 kernel: BTRFS info (device vdb6): auto enabling async discard Jan 29 11:16:44.214954 systemd[1]: Mounted sysroot-oem.mount - /sysroot/oem. Jan 29 11:16:44.503064 systemd[1]: Finished initrd-setup-root.service - Root filesystem setup. Jan 29 11:16:44.517499 systemd[1]: Starting initrd-setup-root-after-ignition.service - Root filesystem completion... Jan 29 11:16:44.520962 initrd-setup-root-after-ignition[1022]: grep: /sysroot/oem/oem-release: No such file or directory Jan 29 11:16:44.523995 initrd-setup-root-after-ignition[1024]: grep: /sysroot/etc/flatcar/enabled-sysext.conf: No such file or directory Jan 29 11:16:44.523995 initrd-setup-root-after-ignition[1024]: grep: /sysroot/usr/share/flatcar/enabled-sysext.conf: No such file or directory Jan 29 11:16:44.526349 initrd-setup-root-after-ignition[1028]: grep: /sysroot/etc/flatcar/enabled-sysext.conf: No such file or directory Jan 29 11:16:44.526221 systemd[1]: Finished initrd-setup-root-after-ignition.service - Root filesystem completion. Jan 29 11:16:44.527589 systemd[1]: Reached target ignition-subsequent.target - Subsequent (Not Ignition) boot complete. Jan 29 11:16:44.529052 systemd[1]: Starting initrd-parse-etc.service - Mountpoints Configured in the Real Root... Jan 29 11:16:44.548929 systemd[1]: initrd-parse-etc.service: Deactivated successfully. Jan 29 11:16:44.549020 systemd[1]: Finished initrd-parse-etc.service - Mountpoints Configured in the Real Root. Jan 29 11:16:44.550626 systemd[1]: Reached target initrd-fs.target - Initrd File Systems. Jan 29 11:16:44.552076 systemd[1]: Reached target initrd.target - Initrd Default Target. Jan 29 11:16:44.553405 systemd[1]: dracut-mount.service - dracut mount hook was skipped because no trigger condition checks were met. Jan 29 11:16:44.554049 systemd[1]: Starting dracut-pre-pivot.service - dracut pre-pivot and cleanup hook... Jan 29 11:16:44.568158 systemd[1]: Finished dracut-pre-pivot.service - dracut pre-pivot and cleanup hook. Jan 29 11:16:44.577505 systemd[1]: Starting initrd-cleanup.service - Cleaning Up and Shutting Down Daemons... Jan 29 11:16:44.585109 systemd[1]: Stopped target remote-cryptsetup.target - Remote Encrypted Volumes. Jan 29 11:16:44.586139 systemd[1]: Stopped target timers.target - Timer Units. Jan 29 11:16:44.587467 systemd[1]: decrypt-root.service: Deactivated successfully. Jan 29 11:16:44.587575 systemd[1]: Stopped decrypt-root.service - Generate and execute a systemd-cryptsetup service to decrypt the ROOT partition. Jan 29 11:16:44.588907 systemd[1]: dracut-pre-pivot.service: Deactivated successfully. Jan 29 11:16:44.589005 systemd[1]: Stopped dracut-pre-pivot.service - dracut pre-pivot and cleanup hook. Jan 29 11:16:44.591435 systemd[1]: Stopped target initrd.target - Initrd Default Target. Jan 29 11:16:44.592840 systemd[1]: Stopped target basic.target - Basic System. Jan 29 11:16:44.594182 systemd[1]: Stopped target ignition-subsequent.target - Subsequent (Not Ignition) boot complete. Jan 29 11:16:44.595719 systemd[1]: Stopped target ignition-diskful-subsequent.target - Ignition Subsequent Boot Disk Setup. Jan 29 11:16:44.597062 systemd[1]: Stopped target initrd-root-device.target - Initrd Root Device. Jan 29 11:16:44.598670 systemd[1]: Stopped target paths.target - Path Units. Jan 29 11:16:44.600290 systemd[1]: Stopped target remote-fs.target - Remote File Systems. Jan 29 11:16:44.601683 systemd[1]: Stopped target remote-fs-pre.target - Preparation for Remote File Systems. Jan 29 11:16:44.603028 systemd[1]: Stopped target slices.target - Slice Units. Jan 29 11:16:44.604347 systemd[1]: Stopped target sockets.target - Socket Units. Jan 29 11:16:44.605801 systemd[1]: Stopped target sysinit.target - System Initialization. Jan 29 11:16:44.607033 systemd[1]: Stopped target local-fs.target - Local File Systems. Jan 29 11:16:44.608352 systemd[1]: Stopped target swap.target - Swaps. Jan 29 11:16:44.609582 systemd[1]: iscsid.socket: Deactivated successfully. Jan 29 11:16:44.609669 systemd[1]: Closed iscsid.socket - Open-iSCSI iscsid Socket. Jan 29 11:16:44.610871 systemd[1]: iscsiuio.socket: Deactivated successfully. Jan 29 11:16:44.610951 systemd[1]: Closed iscsiuio.socket - Open-iSCSI iscsiuio Socket. Jan 29 11:16:44.612120 systemd[1]: dracut-pre-mount.service: Deactivated successfully. Jan 29 11:16:44.612222 systemd[1]: Stopped dracut-pre-mount.service - dracut pre-mount hook. Jan 29 11:16:44.614033 systemd[1]: Stopped target cryptsetup.target - Local Encrypted Volumes. Jan 29 11:16:44.615416 systemd[1]: systemd-ask-password-console.path: Deactivated successfully. Jan 29 11:16:44.620412 systemd[1]: Stopped systemd-ask-password-console.path - Dispatch Password Requests to Console Directory Watch. Jan 29 11:16:44.621424 systemd[1]: Stopped target cryptsetup-pre.target - Local Encrypted Volumes (Pre). Jan 29 11:16:44.623214 systemd[1]: clevis-luks-askpass.path: Deactivated successfully. Jan 29 11:16:44.627415 systemd[1]: Stopped clevis-luks-askpass.path - Forward Password Requests to Clevis Directory Watch. Jan 29 11:16:44.628370 systemd[1]: dracut-initqueue.service: Deactivated successfully. Jan 29 11:16:44.628494 systemd[1]: Stopped dracut-initqueue.service - dracut initqueue hook. Jan 29 11:16:44.630643 systemd[1]: ignition-setup-pre.service: Deactivated successfully. Jan 29 11:16:44.630756 systemd[1]: Stopped ignition-setup-pre.service - Ignition env setup. Jan 29 11:16:44.632186 systemd[1]: initrd-setup-root-after-ignition.service: Deactivated successfully. Jan 29 11:16:44.632288 systemd[1]: Stopped initrd-setup-root-after-ignition.service - Root filesystem completion. Jan 29 11:16:44.633692 systemd[1]: initrd-setup-root.service: Deactivated successfully. Jan 29 11:16:44.633786 systemd[1]: Stopped initrd-setup-root.service - Root filesystem setup. Jan 29 11:16:44.635165 systemd[1]: systemd-sysctl.service: Deactivated successfully. Jan 29 11:16:44.635255 systemd[1]: Stopped systemd-sysctl.service - Apply Kernel Variables. Jan 29 11:16:44.636565 systemd[1]: systemd-modules-load.service: Deactivated successfully. Jan 29 11:16:44.636657 systemd[1]: Stopped systemd-modules-load.service - Load Kernel Modules. Jan 29 11:16:44.638174 systemd[1]: systemd-tmpfiles-setup.service: Deactivated successfully. Jan 29 11:16:44.638268 systemd[1]: Stopped systemd-tmpfiles-setup.service - Create System Files and Directories. Jan 29 11:16:44.639594 systemd[1]: systemd-udev-trigger.service: Deactivated successfully. Jan 29 11:16:44.639692 systemd[1]: Stopped systemd-udev-trigger.service - Coldplug All udev Devices. Jan 29 11:16:44.641034 systemd[1]: dracut-pre-trigger.service: Deactivated successfully. Jan 29 11:16:44.641132 systemd[1]: Stopped dracut-pre-trigger.service - dracut pre-trigger hook. Jan 29 11:16:44.643092 systemd[1]: Stopping systemd-udevd.service - Rule-based Manager for Device Events and Files... Jan 29 11:16:44.647706 systemd[1]: initrd-cleanup.service: Deactivated successfully. Jan 29 11:16:44.647788 systemd[1]: Finished initrd-cleanup.service - Cleaning Up and Shutting Down Daemons. Jan 29 11:16:44.660027 systemd[1]: systemd-udevd.service: Deactivated successfully. Jan 29 11:16:44.661059 systemd[1]: Stopped systemd-udevd.service - Rule-based Manager for Device Events and Files. Jan 29 11:16:44.662221 systemd[1]: systemd-udevd-control.socket: Deactivated successfully. Jan 29 11:16:44.662255 systemd[1]: Closed systemd-udevd-control.socket - udev Control Socket. Jan 29 11:16:44.663167 systemd[1]: systemd-udevd-kernel.socket: Deactivated successfully. Jan 29 11:16:44.663194 systemd[1]: Closed systemd-udevd-kernel.socket - udev Kernel Socket. Jan 29 11:16:44.664147 systemd[1]: dracut-pre-udev.service: Deactivated successfully. Jan 29 11:16:44.664195 systemd[1]: Stopped dracut-pre-udev.service - dracut pre-udev hook. Jan 29 11:16:44.666406 systemd[1]: dracut-cmdline.service: Deactivated successfully. Jan 29 11:16:44.666449 systemd[1]: Stopped dracut-cmdline.service - dracut cmdline hook. Jan 29 11:16:44.668420 systemd[1]: dracut-cmdline-ask.service: Deactivated successfully. Jan 29 11:16:44.668483 systemd[1]: Stopped dracut-cmdline-ask.service - dracut ask for additional cmdline parameters. Jan 29 11:16:44.681507 systemd[1]: Starting initrd-udevadm-cleanup-db.service - Cleanup udev Database... Jan 29 11:16:44.682263 systemd[1]: systemd-tmpfiles-setup-dev.service: Deactivated successfully. Jan 29 11:16:44.682309 systemd[1]: Stopped systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev. Jan 29 11:16:44.683993 systemd[1]: systemd-tmpfiles-setup-dev-early.service: Deactivated successfully. Jan 29 11:16:44.684030 systemd[1]: Stopped systemd-tmpfiles-setup-dev-early.service - Create Static Device Nodes in /dev gracefully. Jan 29 11:16:44.685466 systemd[1]: kmod-static-nodes.service: Deactivated successfully. Jan 29 11:16:44.685501 systemd[1]: Stopped kmod-static-nodes.service - Create List of Static Device Nodes. Jan 29 11:16:44.687252 systemd[1]: systemd-vconsole-setup.service: Deactivated successfully. Jan 29 11:16:44.687288 systemd[1]: Stopped systemd-vconsole-setup.service - Virtual Console Setup. Jan 29 11:16:44.689053 systemd[1]: initrd-udevadm-cleanup-db.service: Deactivated successfully. Jan 29 11:16:44.690429 systemd[1]: Finished initrd-udevadm-cleanup-db.service - Cleanup udev Database. Jan 29 11:16:44.691619 systemd[1]: Reached target initrd-switch-root.target - Switch Root. Jan 29 11:16:44.693691 systemd[1]: Starting initrd-switch-root.service - Switch Root... Jan 29 11:16:44.703516 systemd[1]: Switching root. Jan 29 11:16:44.728313 systemd-journald[231]: Journal stopped Jan 29 11:16:45.225368 systemd-journald[231]: Received SIGTERM from PID 1 (systemd). Jan 29 11:16:45.225425 kernel: SELinux: policy capability network_peer_controls=1 Jan 29 11:16:45.225442 kernel: SELinux: policy capability open_perms=1 Jan 29 11:16:45.225451 kernel: SELinux: policy capability extended_socket_class=1 Jan 29 11:16:45.225461 kernel: SELinux: policy capability always_check_network=0 Jan 29 11:16:45.225471 kernel: SELinux: policy capability cgroup_seclabel=1 Jan 29 11:16:45.225484 kernel: SELinux: policy capability nnp_nosuid_transition=1 Jan 29 11:16:45.225493 kernel: SELinux: policy capability genfs_seclabel_symlinks=0 Jan 29 11:16:45.225502 kernel: SELinux: policy capability ioctl_skip_cloexec=0 Jan 29 11:16:45.225512 kernel: audit: type=1403 audit(1738149404.796:2): auid=4294967295 ses=4294967295 lsm=selinux res=1 Jan 29 11:16:45.225525 systemd[1]: Successfully loaded SELinux policy in 29.933ms. Jan 29 11:16:45.225538 systemd[1]: Relabeled /dev, /dev/shm, /run, /sys/fs/cgroup in 9.651ms. Jan 29 11:16:45.225549 systemd[1]: systemd 255 running in system mode (+PAM +AUDIT +SELINUX -APPARMOR +IMA +SMACK +SECCOMP +GCRYPT -GNUTLS +OPENSSL -ACL +BLKID +CURL +ELFUTILS -FIDO2 +IDN2 -IDN +IPTC +KMOD +LIBCRYPTSETUP +LIBFDISK +PCRE2 -PWQUALITY -P11KIT -QRENCODE +TPM2 +BZIP2 +LZ4 +XZ +ZLIB +ZSTD -BPF_FRAMEWORK -XKBCOMMON +UTMP -SYSVINIT default-hierarchy=unified) Jan 29 11:16:45.225560 systemd[1]: Detected virtualization kvm. Jan 29 11:16:45.225570 systemd[1]: Detected architecture arm64. Jan 29 11:16:45.225580 zram_generator::config[1072]: No configuration found. Jan 29 11:16:45.225591 systemd[1]: initrd-switch-root.service: Deactivated successfully. Jan 29 11:16:45.225602 systemd[1]: Stopped initrd-switch-root.service - Switch Root. Jan 29 11:16:45.225615 systemd[1]: systemd-journald.service: Scheduled restart job, restart counter is at 1. Jan 29 11:16:45.225625 systemd[1]: Created slice system-addon\x2dconfig.slice - Slice /system/addon-config. Jan 29 11:16:45.225636 systemd[1]: Created slice system-addon\x2drun.slice - Slice /system/addon-run. Jan 29 11:16:45.225646 systemd[1]: Created slice system-getty.slice - Slice /system/getty. Jan 29 11:16:45.225658 systemd[1]: Created slice system-modprobe.slice - Slice /system/modprobe. Jan 29 11:16:45.225669 systemd[1]: Created slice system-serial\x2dgetty.slice - Slice /system/serial-getty. Jan 29 11:16:45.225685 systemd[1]: Created slice system-system\x2dcloudinit.slice - Slice /system/system-cloudinit. Jan 29 11:16:45.225697 systemd[1]: Created slice system-systemd\x2dfsck.slice - Slice /system/systemd-fsck. Jan 29 11:16:45.225707 systemd[1]: Created slice user.slice - User and Session Slice. Jan 29 11:16:45.225719 systemd[1]: Started clevis-luks-askpass.path - Forward Password Requests to Clevis Directory Watch. Jan 29 11:16:45.225729 systemd[1]: Started systemd-ask-password-console.path - Dispatch Password Requests to Console Directory Watch. Jan 29 11:16:45.225740 systemd[1]: Started systemd-ask-password-wall.path - Forward Password Requests to Wall Directory Watch. Jan 29 11:16:45.225750 systemd[1]: Set up automount boot.automount - Boot partition Automount Point. Jan 29 11:16:45.225760 systemd[1]: Set up automount proc-sys-fs-binfmt_misc.automount - Arbitrary Executable File Formats File System Automount Point. Jan 29 11:16:45.225770 systemd[1]: Expecting device dev-disk-by\x2dlabel-OEM.device - /dev/disk/by-label/OEM... Jan 29 11:16:45.225781 systemd[1]: Expecting device dev-ttyAMA0.device - /dev/ttyAMA0... Jan 29 11:16:45.225791 systemd[1]: Reached target blockdev@dev-mapper-rootencrypted.target - Block Device Preparation for /dev/mapper/rootencrypted. Jan 29 11:16:45.225802 systemd[1]: Reached target cryptsetup-pre.target - Local Encrypted Volumes (Pre). Jan 29 11:16:45.225812 systemd[1]: Stopped target initrd-switch-root.target - Switch Root. Jan 29 11:16:45.225823 systemd[1]: Stopped target initrd-fs.target - Initrd File Systems. Jan 29 11:16:45.225833 systemd[1]: Stopped target initrd-root-fs.target - Initrd Root File System. Jan 29 11:16:45.225843 systemd[1]: Reached target integritysetup.target - Local Integrity Protected Volumes. Jan 29 11:16:45.225854 systemd[1]: Reached target remote-cryptsetup.target - Remote Encrypted Volumes. Jan 29 11:16:45.225864 systemd[1]: Reached target remote-fs.target - Remote File Systems. Jan 29 11:16:45.225874 systemd[1]: Reached target slices.target - Slice Units. Jan 29 11:16:45.225887 systemd[1]: Reached target swap.target - Swaps. Jan 29 11:16:45.225898 systemd[1]: Reached target veritysetup.target - Local Verity Protected Volumes. Jan 29 11:16:45.225908 systemd[1]: Listening on systemd-coredump.socket - Process Core Dump Socket. Jan 29 11:16:45.225918 systemd[1]: Listening on systemd-networkd.socket - Network Service Netlink Socket. Jan 29 11:16:45.225928 systemd[1]: Listening on systemd-udevd-control.socket - udev Control Socket. Jan 29 11:16:45.225939 systemd[1]: Listening on systemd-udevd-kernel.socket - udev Kernel Socket. Jan 29 11:16:45.225949 systemd[1]: Listening on systemd-userdbd.socket - User Database Manager Socket. Jan 29 11:16:45.225959 systemd[1]: Mounting dev-hugepages.mount - Huge Pages File System... Jan 29 11:16:45.225969 systemd[1]: Mounting dev-mqueue.mount - POSIX Message Queue File System... Jan 29 11:16:45.225981 systemd[1]: Mounting media.mount - External Media Directory... Jan 29 11:16:45.225991 systemd[1]: Mounting sys-kernel-debug.mount - Kernel Debug File System... Jan 29 11:16:45.226001 systemd[1]: Mounting sys-kernel-tracing.mount - Kernel Trace File System... Jan 29 11:16:45.226011 systemd[1]: Mounting tmp.mount - Temporary Directory /tmp... Jan 29 11:16:45.226021 systemd[1]: var-lib-machines.mount - Virtual Machine and Container Storage (Compatibility) was skipped because of an unmet condition check (ConditionPathExists=/var/lib/machines.raw). Jan 29 11:16:45.226032 systemd[1]: Reached target machines.target - Containers. Jan 29 11:16:45.226041 systemd[1]: Starting flatcar-tmpfiles.service - Create missing system files... Jan 29 11:16:45.226052 systemd[1]: ignition-delete-config.service - Ignition (delete config) was skipped because of an unmet condition check (ConditionFirstBoot=true). Jan 29 11:16:45.226064 systemd[1]: Starting kmod-static-nodes.service - Create List of Static Device Nodes... Jan 29 11:16:45.226075 systemd[1]: Starting modprobe@configfs.service - Load Kernel Module configfs... Jan 29 11:16:45.226085 systemd[1]: Starting modprobe@dm_mod.service - Load Kernel Module dm_mod... Jan 29 11:16:45.226096 systemd[1]: Starting modprobe@drm.service - Load Kernel Module drm... Jan 29 11:16:45.226107 systemd[1]: Starting modprobe@efi_pstore.service - Load Kernel Module efi_pstore... Jan 29 11:16:45.226118 systemd[1]: Starting modprobe@fuse.service - Load Kernel Module fuse... Jan 29 11:16:45.226128 systemd[1]: Starting modprobe@loop.service - Load Kernel Module loop... Jan 29 11:16:45.226145 systemd[1]: setup-nsswitch.service - Create /etc/nsswitch.conf was skipped because of an unmet condition check (ConditionPathExists=!/etc/nsswitch.conf). Jan 29 11:16:45.226158 systemd[1]: systemd-fsck-root.service: Deactivated successfully. Jan 29 11:16:45.226170 systemd[1]: Stopped systemd-fsck-root.service - File System Check on Root Device. Jan 29 11:16:45.226181 systemd[1]: systemd-fsck-usr.service: Deactivated successfully. Jan 29 11:16:45.226191 systemd[1]: Stopped systemd-fsck-usr.service. Jan 29 11:16:45.226201 kernel: fuse: init (API version 7.39) Jan 29 11:16:45.226212 systemd[1]: Starting systemd-journald.service - Journal Service... Jan 29 11:16:45.226222 systemd[1]: Starting systemd-modules-load.service - Load Kernel Modules... Jan 29 11:16:45.226232 kernel: loop: module loaded Jan 29 11:16:45.226242 systemd[1]: Starting systemd-network-generator.service - Generate network units from Kernel command line... Jan 29 11:16:45.226252 kernel: ACPI: bus type drm_connector registered Jan 29 11:16:45.226263 systemd[1]: Starting systemd-remount-fs.service - Remount Root and Kernel File Systems... Jan 29 11:16:45.226274 systemd[1]: Starting systemd-udev-trigger.service - Coldplug All udev Devices... Jan 29 11:16:45.226303 systemd-journald[1136]: Collecting audit messages is disabled. Jan 29 11:16:45.226325 systemd[1]: verity-setup.service: Deactivated successfully. Jan 29 11:16:45.226335 systemd[1]: Stopped verity-setup.service. Jan 29 11:16:45.226346 systemd[1]: Mounted dev-hugepages.mount - Huge Pages File System. Jan 29 11:16:45.226374 systemd-journald[1136]: Journal started Jan 29 11:16:45.226399 systemd-journald[1136]: Runtime Journal (/run/log/journal/26241df84bea4e8d8f434986b14b8294) is 5.9M, max 47.3M, 41.4M free. Jan 29 11:16:45.042233 systemd[1]: Queued start job for default target multi-user.target. Jan 29 11:16:45.064165 systemd[1]: Unnecessary job was removed for dev-disk-by\x2duuid-46e18de8\x2df34f\x2d418c\x2d86f8\x2d742425a13ab8.device - /dev/disk/by-uuid/46e18de8-f34f-418c-86f8-742425a13ab8. Jan 29 11:16:45.064176 systemd[1]: Unnecessary job was removed for dev-vdb6.device - /dev/vdb6. Jan 29 11:16:45.064613 systemd[1]: systemd-journald.service: Deactivated successfully. Jan 29 11:16:45.228453 systemd[1]: Started systemd-journald.service - Journal Service. Jan 29 11:16:45.228991 systemd[1]: Mounted dev-mqueue.mount - POSIX Message Queue File System. Jan 29 11:16:45.229890 systemd[1]: Mounted media.mount - External Media Directory. Jan 29 11:16:45.230735 systemd[1]: Mounted sys-kernel-debug.mount - Kernel Debug File System. Jan 29 11:16:45.231604 systemd[1]: Mounted sys-kernel-tracing.mount - Kernel Trace File System. Jan 29 11:16:45.232518 systemd[1]: Mounted tmp.mount - Temporary Directory /tmp. Jan 29 11:16:45.235392 systemd[1]: Finished flatcar-tmpfiles.service - Create missing system files. Jan 29 11:16:45.236456 systemd[1]: Finished kmod-static-nodes.service - Create List of Static Device Nodes. Jan 29 11:16:45.237583 systemd[1]: modprobe@configfs.service: Deactivated successfully. Jan 29 11:16:45.237722 systemd[1]: Finished modprobe@configfs.service - Load Kernel Module configfs. Jan 29 11:16:45.238948 systemd[1]: modprobe@dm_mod.service: Deactivated successfully. Jan 29 11:16:45.239085 systemd[1]: Finished modprobe@dm_mod.service - Load Kernel Module dm_mod. Jan 29 11:16:45.240253 systemd[1]: modprobe@drm.service: Deactivated successfully. Jan 29 11:16:45.240397 systemd[1]: Finished modprobe@drm.service - Load Kernel Module drm. Jan 29 11:16:45.241376 systemd[1]: modprobe@efi_pstore.service: Deactivated successfully. Jan 29 11:16:45.241504 systemd[1]: Finished modprobe@efi_pstore.service - Load Kernel Module efi_pstore. Jan 29 11:16:45.242632 systemd[1]: modprobe@fuse.service: Deactivated successfully. Jan 29 11:16:45.242762 systemd[1]: Finished modprobe@fuse.service - Load Kernel Module fuse. Jan 29 11:16:45.243870 systemd[1]: modprobe@loop.service: Deactivated successfully. Jan 29 11:16:45.244004 systemd[1]: Finished modprobe@loop.service - Load Kernel Module loop. Jan 29 11:16:45.245045 systemd[1]: Finished systemd-modules-load.service - Load Kernel Modules. Jan 29 11:16:45.246094 systemd[1]: Finished systemd-network-generator.service - Generate network units from Kernel command line. Jan 29 11:16:45.247242 systemd[1]: Finished systemd-remount-fs.service - Remount Root and Kernel File Systems. Jan 29 11:16:45.256790 systemd[1]: Reached target network-pre.target - Preparation for Network. Jan 29 11:16:45.268455 systemd[1]: Mounting sys-fs-fuse-connections.mount - FUSE Control File System... Jan 29 11:16:45.270198 systemd[1]: Mounting sys-kernel-config.mount - Kernel Configuration File System... Jan 29 11:16:45.271046 systemd[1]: remount-root.service - Remount Root File System was skipped because of an unmet condition check (ConditionPathIsReadWrite=!/). Jan 29 11:16:45.271080 systemd[1]: Reached target local-fs.target - Local File Systems. Jan 29 11:16:45.272873 systemd[1]: Listening on systemd-sysext.socket - System Extension Image Management (Varlink). Jan 29 11:16:45.274724 systemd[1]: Starting dracut-shutdown.service - Restore /run/initramfs on shutdown... Jan 29 11:16:45.276453 systemd[1]: Starting ldconfig.service - Rebuild Dynamic Linker Cache... Jan 29 11:16:45.277502 systemd[1]: systemd-binfmt.service - Set Up Additional Binary Formats was skipped because no trigger condition checks were met. Jan 29 11:16:45.278830 systemd[1]: Starting systemd-hwdb-update.service - Rebuild Hardware Database... Jan 29 11:16:45.280454 systemd[1]: Starting systemd-journal-flush.service - Flush Journal to Persistent Storage... Jan 29 11:16:45.281344 systemd[1]: systemd-pstore.service - Platform Persistent Storage Archival was skipped because of an unmet condition check (ConditionDirectoryNotEmpty=/sys/fs/pstore). Jan 29 11:16:45.283522 systemd[1]: Starting systemd-random-seed.service - Load/Save OS Random Seed... Jan 29 11:16:45.284403 systemd[1]: systemd-repart.service - Repartition Root Disk was skipped because no trigger condition checks were met. Jan 29 11:16:45.285547 systemd[1]: Starting systemd-sysctl.service - Apply Kernel Variables... Jan 29 11:16:45.289552 systemd[1]: Starting systemd-sysext.service - Merge System Extension Images into /usr/ and /opt/... Jan 29 11:16:45.293129 systemd[1]: Starting systemd-tmpfiles-setup-dev-early.service - Create Static Device Nodes in /dev gracefully... Jan 29 11:16:45.297622 systemd[1]: Finished systemd-udev-trigger.service - Coldplug All udev Devices. Jan 29 11:16:45.298878 systemd[1]: Mounted sys-fs-fuse-connections.mount - FUSE Control File System. Jan 29 11:16:45.301429 systemd-journald[1136]: Time spent on flushing to /var/log/journal/26241df84bea4e8d8f434986b14b8294 is 31.415ms for 682 entries. Jan 29 11:16:45.301429 systemd-journald[1136]: System Journal (/var/log/journal/26241df84bea4e8d8f434986b14b8294) is 12.3M, max 204.2M, 191.8M free. Jan 29 11:16:45.360036 systemd-journald[1136]: Received client request to flush runtime journal. Jan 29 11:16:45.360083 systemd-journald[1136]: /var/log/journal/26241df84bea4e8d8f434986b14b8294/system.journal: Journal file uses a different sequence number ID, rotating. Jan 29 11:16:45.360106 kernel: loop0: detected capacity change from 0 to 116808 Jan 29 11:16:45.360124 systemd-journald[1136]: Rotating system journal. Jan 29 11:16:45.360146 kernel: squashfs: version 4.0 (2009/01/31) Phillip Lougher Jan 29 11:16:45.360160 kernel: loop1: detected capacity change from 0 to 113536 Jan 29 11:16:45.301521 systemd[1]: Mounted sys-kernel-config.mount - Kernel Configuration File System. Jan 29 11:16:45.303863 systemd[1]: Finished dracut-shutdown.service - Restore /run/initramfs on shutdown. Jan 29 11:16:45.305402 systemd[1]: Finished systemd-random-seed.service - Load/Save OS Random Seed. Jan 29 11:16:45.308970 systemd[1]: first-boot-complete.target - First Boot Complete was skipped because of an unmet condition check (ConditionFirstBoot=yes). Jan 29 11:16:45.309056 systemd[1]: systemd-machine-id-commit.service - Commit a transient machine-id on disk was skipped because of an unmet condition check (ConditionPathIsMountPoint=/etc/machine-id). Jan 29 11:16:45.311523 systemd[1]: Starting systemd-udev-settle.service - Wait for udev To Complete Device Initialization... Jan 29 11:16:45.324124 systemd-tmpfiles[1182]: ACLs are not supported, ignoring. Jan 29 11:16:45.324134 systemd-tmpfiles[1182]: ACLs are not supported, ignoring. Jan 29 11:16:45.326580 systemd[1]: Finished systemd-sysctl.service - Apply Kernel Variables. Jan 29 11:16:45.332644 udevadm[1189]: systemd-udev-settle.service is deprecated. Please fix lvm2-activation-early.service, lvm2-activation.service not to pull it in. Jan 29 11:16:45.335605 systemd[1]: Finished systemd-tmpfiles-setup-dev-early.service - Create Static Device Nodes in /dev gracefully. Jan 29 11:16:45.347538 systemd[1]: Starting systemd-sysusers.service - Create System Users... Jan 29 11:16:45.361986 systemd[1]: Finished systemd-journal-flush.service - Flush Journal to Persistent Storage. Jan 29 11:16:45.368253 systemd[1]: Finished systemd-sysusers.service - Create System Users. Jan 29 11:16:45.375583 systemd[1]: Starting systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev... Jan 29 11:16:45.388446 kernel: loop2: detected capacity change from 0 to 116808 Jan 29 11:16:45.387732 systemd-tmpfiles[1204]: ACLs are not supported, ignoring. Jan 29 11:16:45.387748 systemd-tmpfiles[1204]: ACLs are not supported, ignoring. Jan 29 11:16:45.392208 systemd[1]: Finished systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev. Jan 29 11:16:45.394375 kernel: loop3: detected capacity change from 0 to 113536 Jan 29 11:16:45.397216 (sd-merge)[1207]: Using extensions 'containerd-flatcar', 'docker-flatcar'. Jan 29 11:16:45.397588 (sd-merge)[1207]: Merged extensions into '/usr'. Jan 29 11:16:45.401030 systemd[1]: Finished systemd-sysext.service - Merge System Extension Images into /usr/ and /opt/. Jan 29 11:16:45.413583 ldconfig[1175]: /sbin/ldconfig: /usr/lib/ld.so.conf is not an ELF file - it has the wrong magic bytes at the start. Jan 29 11:16:45.415479 systemd[1]: Starting ensure-sysext.service... Jan 29 11:16:45.417015 systemd[1]: Starting systemd-tmpfiles-setup.service - Create System Files and Directories... Jan 29 11:16:45.419776 systemd[1]: Finished ldconfig.service - Rebuild Dynamic Linker Cache. Jan 29 11:16:45.427556 systemd[1]: Reloading requested from client PID 1211 ('systemctl') (unit ensure-sysext.service)... Jan 29 11:16:45.427578 systemd[1]: Reloading... Jan 29 11:16:45.433564 systemd-tmpfiles[1212]: /usr/lib/tmpfiles.d/provision.conf:20: Duplicate line for path "/root", ignoring. Jan 29 11:16:45.434078 systemd-tmpfiles[1212]: /usr/lib/tmpfiles.d/systemd-flatcar.conf:6: Duplicate line for path "/var/log/journal", ignoring. Jan 29 11:16:45.434807 systemd-tmpfiles[1212]: /usr/lib/tmpfiles.d/systemd.conf:29: Duplicate line for path "/var/lib/systemd", ignoring. Jan 29 11:16:45.435085 systemd-tmpfiles[1212]: ACLs are not supported, ignoring. Jan 29 11:16:45.435186 systemd-tmpfiles[1212]: ACLs are not supported, ignoring. Jan 29 11:16:45.438251 systemd-tmpfiles[1212]: Detected autofs mount point /boot during canonicalization of boot. Jan 29 11:16:45.438345 systemd-tmpfiles[1212]: Skipping /boot Jan 29 11:16:45.446341 systemd-tmpfiles[1212]: Detected autofs mount point /boot during canonicalization of boot. Jan 29 11:16:45.446436 systemd-tmpfiles[1212]: Skipping /boot Jan 29 11:16:45.474413 zram_generator::config[1241]: No configuration found. Jan 29 11:16:45.558737 systemd[1]: /usr/lib/systemd/system/docker.socket:6: ListenStream= references a path below legacy directory /var/run/, updating /var/run/docker.sock → /run/docker.sock; please update the unit file accordingly. Jan 29 11:16:45.601707 systemd[1]: Reloading finished in 173 ms. Jan 29 11:16:45.637717 systemd[1]: Finished systemd-tmpfiles-setup.service - Create System Files and Directories. Jan 29 11:16:45.644339 systemd[1]: Starting audit-rules.service - Load Audit Rules... Jan 29 11:16:45.646297 systemd[1]: Starting clean-ca-certificates.service - Clean up broken links in /etc/ssl/certs... Jan 29 11:16:45.650624 systemd[1]: Starting systemd-journal-catalog-update.service - Rebuild Journal Catalog... Jan 29 11:16:45.657697 systemd[1]: Starting systemd-resolved.service - Network Name Resolution... Jan 29 11:16:45.662586 systemd[1]: Starting systemd-update-utmp.service - Record System Boot/Shutdown in UTMP... Jan 29 11:16:45.665517 systemd[1]: ignition-delete-config.service - Ignition (delete config) was skipped because of an unmet condition check (ConditionFirstBoot=true). Jan 29 11:16:45.668868 systemd[1]: Starting modprobe@dm_mod.service - Load Kernel Module dm_mod... Jan 29 11:16:45.673699 systemd[1]: Starting modprobe@efi_pstore.service - Load Kernel Module efi_pstore... Jan 29 11:16:45.675656 systemd[1]: Starting modprobe@loop.service - Load Kernel Module loop... Jan 29 11:16:45.676665 systemd[1]: systemd-binfmt.service - Set Up Additional Binary Formats was skipped because no trigger condition checks were met. Jan 29 11:16:45.676792 systemd[1]: systemd-machine-id-commit.service - Commit a transient machine-id on disk was skipped because of an unmet condition check (ConditionPathIsMountPoint=/etc/machine-id). Jan 29 11:16:45.681113 systemd[1]: ignition-delete-config.service - Ignition (delete config) was skipped because of an unmet condition check (ConditionFirstBoot=true). Jan 29 11:16:45.681297 systemd[1]: systemd-binfmt.service - Set Up Additional Binary Formats was skipped because no trigger condition checks were met. Jan 29 11:16:45.681425 systemd[1]: systemd-machine-id-commit.service - Commit a transient machine-id on disk was skipped because of an unmet condition check (ConditionPathIsMountPoint=/etc/machine-id). Jan 29 11:16:45.684389 systemd[1]: Finished systemd-update-utmp.service - Record System Boot/Shutdown in UTMP. Jan 29 11:16:45.685757 systemd[1]: modprobe@loop.service: Deactivated successfully. Jan 29 11:16:45.686224 systemd[1]: Finished modprobe@loop.service - Load Kernel Module loop. Jan 29 11:16:45.691989 systemd[1]: Finished systemd-journal-catalog-update.service - Rebuild Journal Catalog. Jan 29 11:16:45.694871 systemd[1]: modprobe@dm_mod.service: Deactivated successfully. Jan 29 11:16:45.694996 systemd[1]: Finished modprobe@dm_mod.service - Load Kernel Module dm_mod. Jan 29 11:16:45.696321 systemd[1]: modprobe@efi_pstore.service: Deactivated successfully. Jan 29 11:16:45.696483 systemd[1]: Finished modprobe@efi_pstore.service - Load Kernel Module efi_pstore. Jan 29 11:16:45.697321 augenrules[1272]: /sbin/augenrules: No change Jan 29 11:16:45.700605 systemd[1]: ignition-delete-config.service - Ignition (delete config) was skipped because of an unmet condition check (ConditionFirstBoot=true). Jan 29 11:16:45.709606 systemd[1]: Starting modprobe@drm.service - Load Kernel Module drm... Jan 29 11:16:45.709881 augenrules[1300]: No rules Jan 29 11:16:45.711399 systemd[1]: Starting modprobe@loop.service - Load Kernel Module loop... Jan 29 11:16:45.712199 systemd[1]: systemd-binfmt.service - Set Up Additional Binary Formats was skipped because no trigger condition checks were met. Jan 29 11:16:45.712246 systemd[1]: systemd-machine-id-commit.service - Commit a transient machine-id on disk was skipped because of an unmet condition check (ConditionPathIsMountPoint=/etc/machine-id). Jan 29 11:16:45.712273 systemd[1]: systemd-pstore.service - Platform Persistent Storage Archival was skipped because of an unmet condition check (ConditionDirectoryNotEmpty=/sys/fs/pstore). Jan 29 11:16:45.713808 systemd[1]: Starting systemd-userdbd.service - User Database Manager... Jan 29 11:16:45.714994 systemd[1]: Finished ensure-sysext.service. Jan 29 11:16:45.715872 systemd[1]: audit-rules.service: Deactivated successfully. Jan 29 11:16:45.716017 systemd[1]: Finished audit-rules.service - Load Audit Rules. Jan 29 11:16:45.717089 systemd[1]: Finished clean-ca-certificates.service - Clean up broken links in /etc/ssl/certs. Jan 29 11:16:45.718248 systemd[1]: modprobe@drm.service: Deactivated successfully. Jan 29 11:16:45.718386 systemd[1]: Finished modprobe@drm.service - Load Kernel Module drm. Jan 29 11:16:45.719479 systemd[1]: modprobe@loop.service: Deactivated successfully. Jan 29 11:16:45.719593 systemd[1]: Finished modprobe@loop.service - Load Kernel Module loop. Jan 29 11:16:45.724672 systemd[1]: systemd-repart.service - Repartition Root Disk was skipped because no trigger condition checks were met. Jan 29 11:16:45.734552 systemd[1]: Starting systemd-timesyncd.service - Network Time Synchronization... Jan 29 11:16:45.735354 systemd[1]: update-ca-certificates.service - Update CA bundle at /etc/ssl/certs/ca-certificates.crt was skipped because of an unmet condition check (ConditionPathIsSymbolicLink=!/etc/ssl/certs/ca-certificates.crt). Jan 29 11:16:45.747624 systemd[1]: Started systemd-userdbd.service - User Database Manager. Jan 29 11:16:45.759404 systemd[1]: Finished systemd-hwdb-update.service - Rebuild Hardware Database. Jan 29 11:16:45.761956 systemd[1]: Starting systemd-udevd.service - Rule-based Manager for Device Events and Files... Jan 29 11:16:45.765523 systemd[1]: Starting systemd-update-done.service - Update is Completed... Jan 29 11:16:45.778936 systemd[1]: Finished systemd-update-done.service - Update is Completed. Jan 29 11:16:45.787299 systemd-udevd[1319]: Using default interface naming scheme 'v255'. Jan 29 11:16:45.794690 systemd[1]: Started systemd-timesyncd.service - Network Time Synchronization. Jan 29 11:16:45.795845 systemd[1]: Reached target time-set.target - System Time Set. Jan 29 11:16:45.799162 systemd-resolved[1276]: Positive Trust Anchors: Jan 29 11:16:45.799279 systemd-resolved[1276]: . IN DS 20326 8 2 e06d44b80b8f1d39a95c0b0d7c65d08458e880409bbc683457104237c7f8ec8d Jan 29 11:16:45.799318 systemd-resolved[1276]: Negative trust anchors: home.arpa 10.in-addr.arpa 16.172.in-addr.arpa 17.172.in-addr.arpa 18.172.in-addr.arpa 19.172.in-addr.arpa 20.172.in-addr.arpa 21.172.in-addr.arpa 22.172.in-addr.arpa 23.172.in-addr.arpa 24.172.in-addr.arpa 25.172.in-addr.arpa 26.172.in-addr.arpa 27.172.in-addr.arpa 28.172.in-addr.arpa 29.172.in-addr.arpa 30.172.in-addr.arpa 31.172.in-addr.arpa 170.0.0.192.in-addr.arpa 171.0.0.192.in-addr.arpa 168.192.in-addr.arpa d.f.ip6.arpa ipv4only.arpa resolver.arpa corp home internal intranet lan local private test Jan 29 11:16:45.803661 systemd[1]: Started systemd-udevd.service - Rule-based Manager for Device Events and Files. Jan 29 11:16:45.807076 systemd-resolved[1276]: Defaulting to hostname 'linux'. Jan 29 11:16:45.814534 systemd[1]: Starting systemd-networkd.service - Network Configuration... Jan 29 11:16:45.815368 systemd[1]: Started systemd-resolved.service - Network Name Resolution. Jan 29 11:16:45.819293 systemd[1]: Reached target nss-lookup.target - Host and Network Name Lookups. Jan 29 11:16:45.848475 systemd[1]: Condition check resulted in dev-ttyAMA0.device - /dev/ttyAMA0 being skipped. Jan 29 11:16:45.857436 kernel: BTRFS warning: duplicate device /dev/vdb3 devid 1 generation 39 scanned by (udev-worker) (1329) Jan 29 11:16:45.881475 systemd-networkd[1332]: lo: Link UP Jan 29 11:16:45.881483 systemd-networkd[1332]: lo: Gained carrier Jan 29 11:16:45.884006 systemd-networkd[1332]: Enumeration completed Jan 29 11:16:45.884086 systemd[1]: Started systemd-networkd.service - Network Configuration. Jan 29 11:16:45.885465 systemd[1]: Reached target network.target - Network. Jan 29 11:16:45.886906 systemd-networkd[1332]: eth0: found matching network '/usr/lib/systemd/network/zz-default.network', based on potentially unpredictable interface name. Jan 29 11:16:45.886919 systemd-networkd[1332]: eth0: Configuring with /usr/lib/systemd/network/zz-default.network. Jan 29 11:16:45.890585 systemd-networkd[1332]: eth0: found matching network '/usr/lib/systemd/network/zz-default.network', based on potentially unpredictable interface name. Jan 29 11:16:45.890615 systemd-networkd[1332]: eth0: Link UP Jan 29 11:16:45.890618 systemd-networkd[1332]: eth0: Gained carrier Jan 29 11:16:45.890626 systemd-networkd[1332]: eth0: found matching network '/usr/lib/systemd/network/zz-default.network', based on potentially unpredictable interface name. Jan 29 11:16:45.893552 systemd[1]: Starting systemd-networkd-wait-online.service - Wait for Network to be Configured... Jan 29 11:16:45.895563 systemd[1]: Found device dev-disk-by\x2dlabel-OEM.device - /dev/disk/by-label/OEM. Jan 29 11:16:45.899221 systemd[1]: Starting systemd-fsck@dev-disk-by\x2dlabel-OEM.service - File System Check on /dev/disk/by-label/OEM... Jan 29 11:16:45.906444 systemd-networkd[1332]: eth0: DHCPv4 address 10.0.0.128/16, gateway 10.0.0.1 acquired from 10.0.0.1 Jan 29 11:16:45.907505 systemd-timesyncd[1311]: Network configuration changed, trying to establish connection. Jan 29 11:16:45.921569 systemd[1]: Starting systemd-vconsole-setup.service - Virtual Console Setup... Jan 29 11:16:45.922685 systemd[1]: Finished systemd-fsck@dev-disk-by\x2dlabel-OEM.service - File System Check on /dev/disk/by-label/OEM. Jan 29 11:16:45.932425 systemd[1]: Finished systemd-udev-settle.service - Wait for udev To Complete Device Initialization. Jan 29 11:16:45.935170 systemd[1]: Starting lvm2-activation-early.service - Activation of LVM2 logical volumes... Jan 29 11:16:45.962214 lvm[1360]: WARNING: Failed to connect to lvmetad. Falling back to device scanning. Jan 29 11:16:45.976712 systemd[1]: Finished systemd-vconsole-setup.service - Virtual Console Setup. Jan 29 11:16:45.999430 systemd[1]: Finished lvm2-activation-early.service - Activation of LVM2 logical volumes. Jan 29 11:16:46.000602 systemd[1]: Reached target cryptsetup.target - Local Encrypted Volumes. Jan 29 11:16:46.001480 systemd[1]: Reached target sysinit.target - System Initialization. Jan 29 11:16:46.002401 systemd[1]: Started motdgen.path - Watch for update engine configuration changes. Jan 29 11:16:46.003351 systemd[1]: Started user-cloudinit@var-lib-flatcar\x2dinstall-user_data.path - Watch for a cloud-config at /var/lib/flatcar-install/user_data. Jan 29 11:16:46.004518 systemd[1]: Started logrotate.timer - Daily rotation of log files. Jan 29 11:16:46.005438 systemd[1]: Started mdadm.timer - Weekly check for MD array's redundancy information.. Jan 29 11:16:46.006376 systemd[1]: Started systemd-tmpfiles-clean.timer - Daily Cleanup of Temporary Directories. Jan 29 11:16:46.007286 systemd[1]: update-engine-stub.timer - Update Engine Stub Timer was skipped because of an unmet condition check (ConditionPathExists=/usr/.noupdate). Jan 29 11:16:46.007407 systemd[1]: Reached target paths.target - Path Units. Jan 29 11:16:46.008126 systemd[1]: Reached target timers.target - Timer Units. Jan 29 11:16:46.011414 systemd[1]: Listening on dbus.socket - D-Bus System Message Bus Socket. Jan 29 11:16:46.013410 systemd[1]: Starting docker.socket - Docker Socket for the API... Jan 29 11:16:46.027211 systemd[1]: Listening on sshd.socket - OpenSSH Server Socket. Jan 29 11:16:46.029291 systemd[1]: Starting lvm2-activation.service - Activation of LVM2 logical volumes... Jan 29 11:16:46.030606 systemd[1]: Listening on docker.socket - Docker Socket for the API. Jan 29 11:16:46.031488 systemd[1]: Reached target sockets.target - Socket Units. Jan 29 11:16:46.032190 systemd[1]: Reached target basic.target - Basic System. Jan 29 11:16:46.032938 systemd[1]: addon-config@oem.service - Configure Addon /oem was skipped because no trigger condition checks were met. Jan 29 11:16:46.032969 systemd[1]: addon-run@oem.service - Run Addon /oem was skipped because no trigger condition checks were met. Jan 29 11:16:46.033814 systemd[1]: Starting containerd.service - containerd container runtime... Jan 29 11:16:46.034603 systemd[1]: cryptenroll-helper-bind.service was skipped because of an unmet condition check (ConditionPathExists=/etc/luks/rootencrypted-bind). Jan 29 11:16:46.035543 systemd[1]: Starting dbus.service - D-Bus System Message Bus... Jan 29 11:16:46.036700 lvm[1367]: WARNING: Failed to connect to lvmetad. Falling back to device scanning. Jan 29 11:16:46.038184 systemd[1]: Starting enable-oem-cloudinit.service - Enable cloudinit... Jan 29 11:16:46.040555 systemd[1]: Starting extend-filesystems.service - Extend Filesystems... Jan 29 11:16:46.044453 systemd[1]: flatcar-setup-environment.service - Modifies /etc/environment for CoreOS was skipped because of an unmet condition check (ConditionPathExists=/oem/bin/flatcar-setup-environment). Jan 29 11:16:46.046115 jq[1370]: false Jan 29 11:16:46.046469 systemd[1]: Starting motdgen.service - Generate /run/flatcar/motd... Jan 29 11:16:46.048949 systemd[1]: Starting ssh-key-proc-cmdline.service - Install an ssh key from /proc/cmdline... Jan 29 11:16:46.053563 systemd[1]: Starting sshd-keygen.service - Generate sshd host keys... Jan 29 11:16:46.058054 extend-filesystems[1371]: Found loop2 Jan 29 11:16:46.058054 extend-filesystems[1371]: Found loop3 Jan 29 11:16:46.058054 extend-filesystems[1371]: Found vda Jan 29 11:16:46.058054 extend-filesystems[1371]: Found vdb Jan 29 11:16:46.058054 extend-filesystems[1371]: Found vdb1 Jan 29 11:16:46.058054 extend-filesystems[1371]: Found vdb2 Jan 29 11:16:46.058054 extend-filesystems[1371]: Found vdb3 Jan 29 11:16:46.058054 extend-filesystems[1371]: Found usr Jan 29 11:16:46.058054 extend-filesystems[1371]: Found vdb4 Jan 29 11:16:46.058054 extend-filesystems[1371]: Found vdb6 Jan 29 11:16:46.056391 systemd[1]: Starting systemd-logind.service - User Login Management... Jan 29 11:16:46.068794 extend-filesystems[1371]: Found vdb7 Jan 29 11:16:46.068794 extend-filesystems[1371]: Found vdb9 Jan 29 11:16:46.068794 extend-filesystems[1371]: Found rootencrypted Jan 29 11:16:46.061305 systemd[1]: tcsd.service - TCG Core Services Daemon was skipped because of an unmet condition check (ConditionSecurity=!tpm2). Jan 29 11:16:46.073907 dbus-daemon[1369]: [system] SELinux support is enabled Jan 29 11:16:46.061720 systemd[1]: cgroup compatibility translation between legacy and unified hierarchy settings activated. See cgroup-compat debug messages for details. Jan 29 11:16:46.064216 systemd[1]: Starting update-engine.service - Update Engine... Jan 29 11:16:46.069531 systemd[1]: Starting update-ssh-keys-after-ignition.service - Run update-ssh-keys once after Ignition... Jan 29 11:16:46.084135 jq[1385]: true Jan 29 11:16:46.071855 systemd[1]: Finished lvm2-activation.service - Activation of LVM2 logical volumes. Jan 29 11:16:46.075604 systemd[1]: Started dbus.service - D-Bus System Message Bus. Jan 29 11:16:46.078777 systemd[1]: enable-oem-cloudinit.service: Skipped due to 'exec-condition'. Jan 29 11:16:46.079390 systemd[1]: Condition check resulted in enable-oem-cloudinit.service - Enable cloudinit being skipped. Jan 29 11:16:46.079653 systemd[1]: extend-filesystems.service: Deactivated successfully. Jan 29 11:16:46.081589 systemd[1]: Finished extend-filesystems.service - Extend Filesystems. Jan 29 11:16:46.082899 systemd[1]: motdgen.service: Deactivated successfully. Jan 29 11:16:46.083040 systemd[1]: Finished motdgen.service - Generate /run/flatcar/motd. Jan 29 11:16:46.084184 systemd[1]: ssh-key-proc-cmdline.service: Deactivated successfully. Jan 29 11:16:46.084663 systemd[1]: Finished ssh-key-proc-cmdline.service - Install an ssh key from /proc/cmdline. Jan 29 11:16:46.100380 (ntainerd)[1394]: containerd.service: Referenced but unset environment variable evaluates to an empty string: TORCX_IMAGEDIR, TORCX_UNPACKDIR Jan 29 11:16:46.101437 systemd[1]: Created slice system-sshd.slice - Slice /system/sshd. Jan 29 11:16:46.102099 jq[1393]: false Jan 29 11:16:46.104435 systemd-logind[1378]: Watching system buttons on /dev/input/event0 (Power Button) Jan 29 11:16:46.104463 systemd[1]: system-cloudinit@usr-share-oem-cloud\x2dconfig.yml.service - Load cloud-config from /usr/share/oem/cloud-config.yml was skipped because of an unmet condition check (ConditionFileNotEmpty=/usr/share/oem/cloud-config.yml). Jan 29 11:16:46.104489 systemd[1]: Reached target system-config.target - Load system-provided cloud configs. Jan 29 11:16:46.104801 systemd-logind[1378]: New seat seat0. Jan 29 11:16:46.106480 systemd[1]: user-cloudinit-proc-cmdline.service - Load cloud-config from url defined in /proc/cmdline was skipped because of an unmet condition check (ConditionKernelCommandLine=cloud-config-url). Jan 29 11:16:46.106503 systemd[1]: Reached target user-config.target - Load user-provided cloud configs. Jan 29 11:16:46.110486 systemd[1]: update-ssh-keys-after-ignition.service: Skipped due to 'exec-condition'. Jan 29 11:16:46.110663 systemd[1]: Condition check resulted in update-ssh-keys-after-ignition.service - Run update-ssh-keys once after Ignition being skipped. Jan 29 11:16:46.111787 systemd[1]: sshkeys.service was skipped because no trigger condition checks were met. Jan 29 11:16:46.111876 systemd[1]: Started systemd-logind.service - User Login Management. Jan 29 11:16:46.120017 systemd[1]: Finished sshd-keygen.service - Generate sshd host keys. Jan 29 11:16:46.129671 systemd[1]: Starting issuegen.service - Generate /run/issue... Jan 29 11:16:46.131530 systemd[1]: Started sshd@0-10.0.0.128:22-10.0.0.1:48952.service - OpenSSH per-connection server daemon (10.0.0.1:48952). Jan 29 11:16:46.135801 systemd[1]: issuegen.service: Deactivated successfully. Jan 29 11:16:46.137384 update_engine[1382]: I20250129 11:16:46.136555 1382 main.cc:92] Flatcar Update Engine starting Jan 29 11:16:46.137636 systemd[1]: Finished issuegen.service - Generate /run/issue. Jan 29 11:16:46.138992 systemd[1]: Started update-engine.service - Update Engine. Jan 29 11:16:46.142961 update_engine[1382]: I20250129 11:16:46.142769 1382 update_check_scheduler.cc:74] Next update check in 5m55s Jan 29 11:16:46.142641 systemd[1]: Starting systemd-user-sessions.service - Permit User Sessions... Jan 29 11:16:46.146661 systemd[1]: Started locksmithd.service - Cluster reboot manager. Jan 29 11:16:46.160569 systemd[1]: Finished systemd-user-sessions.service - Permit User Sessions. Jan 29 11:16:46.163651 systemd[1]: Started getty@tty1.service - Getty on tty1. Jan 29 11:16:46.178297 systemd[1]: Started serial-getty@ttyAMA0.service - Serial Getty on ttyAMA0. Jan 29 11:16:46.179485 systemd[1]: Reached target getty.target - Login Prompts. Jan 29 11:16:46.214655 locksmithd[1414]: locksmithd starting currentOperation="UPDATE_STATUS_IDLE" strategy="reboot" Jan 29 11:16:46.236221 sshd[1409]: Accepted publickey for core from 10.0.0.1 port 48952 ssh2: RSA SHA256:Bq1DMYRFt3vwSJT5tcC1MQpWKmkwK1uKH+vc+Uts7DI Jan 29 11:16:46.238142 sshd-session[1409]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Jan 29 11:16:46.247120 systemd[1]: Created slice user-500.slice - User Slice of UID 500. Jan 29 11:16:46.255794 systemd[1]: Starting user-runtime-dir@500.service - User Runtime Directory /run/user/500... Jan 29 11:16:46.259132 systemd-logind[1378]: New session 1 of user core. Jan 29 11:16:46.270035 systemd[1]: Finished user-runtime-dir@500.service - User Runtime Directory /run/user/500. Jan 29 11:16:46.279644 systemd[1]: Starting user@500.service - User Manager for UID 500... Jan 29 11:16:46.285102 (systemd)[1430]: pam_unix(systemd-user:session): session opened for user core(uid=500) by (uid=0) Jan 29 11:16:46.286426 containerd[1394]: time="2025-01-29T11:16:46.286334560Z" level=info msg="starting containerd" revision=9b2ad7760328148397346d10c7b2004271249db4 version=v1.7.23 Jan 29 11:16:46.310892 containerd[1394]: time="2025-01-29T11:16:46.310836080Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.aufs\"..." type=io.containerd.snapshotter.v1 Jan 29 11:16:46.313000 containerd[1394]: time="2025-01-29T11:16:46.312877280Z" 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.74-flatcar\\n\"): skip plugin" type=io.containerd.snapshotter.v1 Jan 29 11:16:46.313000 containerd[1394]: time="2025-01-29T11:16:46.312909640Z" level=info msg="loading plugin \"io.containerd.event.v1.exchange\"..." type=io.containerd.event.v1 Jan 29 11:16:46.313000 containerd[1394]: time="2025-01-29T11:16:46.312925440Z" level=info msg="loading plugin \"io.containerd.internal.v1.opt\"..." type=io.containerd.internal.v1 Jan 29 11:16:46.313527 containerd[1394]: time="2025-01-29T11:16:46.313506200Z" level=info msg="loading plugin \"io.containerd.warning.v1.deprecations\"..." type=io.containerd.warning.v1 Jan 29 11:16:46.313595 containerd[1394]: time="2025-01-29T11:16:46.313583000Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.blockfile\"..." type=io.containerd.snapshotter.v1 Jan 29 11:16:46.313795 containerd[1394]: time="2025-01-29T11:16:46.313776000Z" level=info msg="skip loading plugin \"io.containerd.snapshotter.v1.blockfile\"..." error="no scratch file generator: skip plugin" type=io.containerd.snapshotter.v1 Jan 29 11:16:46.313852 containerd[1394]: time="2025-01-29T11:16:46.313840640Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.btrfs\"..." type=io.containerd.snapshotter.v1 Jan 29 11:16:46.314137 containerd[1394]: time="2025-01-29T11:16:46.314037560Z" level=info msg="skip loading plugin \"io.containerd.snapshotter.v1.btrfs\"..." error="path /var/lib/containerd/io.containerd.snapshotter.v1.btrfs (ext4) must be a btrfs filesystem to be used with the btrfs snapshotter: skip plugin" type=io.containerd.snapshotter.v1 Jan 29 11:16:46.314137 containerd[1394]: time="2025-01-29T11:16:46.314056960Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.devmapper\"..." type=io.containerd.snapshotter.v1 Jan 29 11:16:46.314137 containerd[1394]: time="2025-01-29T11:16:46.314070160Z" level=info msg="skip loading plugin \"io.containerd.snapshotter.v1.devmapper\"..." error="devmapper not configured: skip plugin" type=io.containerd.snapshotter.v1 Jan 29 11:16:46.314137 containerd[1394]: time="2025-01-29T11:16:46.314078760Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.native\"..." type=io.containerd.snapshotter.v1 Jan 29 11:16:46.314308 containerd[1394]: time="2025-01-29T11:16:46.314290880Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.overlayfs\"..." type=io.containerd.snapshotter.v1 Jan 29 11:16:46.314658 containerd[1394]: time="2025-01-29T11:16:46.314638160Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.zfs\"..." type=io.containerd.snapshotter.v1 Jan 29 11:16:46.314882 containerd[1394]: time="2025-01-29T11:16:46.314812080Z" level=info msg="skip loading plugin \"io.containerd.snapshotter.v1.zfs\"..." error="path /var/lib/containerd/io.containerd.snapshotter.v1.zfs must be a zfs filesystem to be used with the zfs snapshotter: skip plugin" type=io.containerd.snapshotter.v1 Jan 29 11:16:46.314882 containerd[1394]: time="2025-01-29T11:16:46.314830680Z" level=info msg="loading plugin \"io.containerd.content.v1.content\"..." type=io.containerd.content.v1 Jan 29 11:16:46.314992 containerd[1394]: time="2025-01-29T11:16:46.314976800Z" level=info msg="loading plugin \"io.containerd.metadata.v1.bolt\"..." type=io.containerd.metadata.v1 Jan 29 11:16:46.315129 containerd[1394]: time="2025-01-29T11:16:46.315058440Z" level=info msg="metadata content store policy set" policy=shared Jan 29 11:16:46.315608 containerd[1394]: time="2025-01-29T11:16:46.315588800Z" level=info msg="loading plugin \"io.containerd.gc.v1.scheduler\"..." type=io.containerd.gc.v1 Jan 29 11:16:46.316591 containerd[1394]: time="2025-01-29T11:16:46.316569040Z" level=info msg="loading plugin \"io.containerd.differ.v1.walking\"..." type=io.containerd.differ.v1 Jan 29 11:16:46.317193 containerd[1394]: time="2025-01-29T11:16:46.316655600Z" level=info msg="loading plugin \"io.containerd.lease.v1.manager\"..." type=io.containerd.lease.v1 Jan 29 11:16:46.317193 containerd[1394]: time="2025-01-29T11:16:46.316685200Z" level=info msg="loading plugin \"io.containerd.streaming.v1.manager\"..." type=io.containerd.streaming.v1 Jan 29 11:16:46.317193 containerd[1394]: time="2025-01-29T11:16:46.316703360Z" level=info msg="loading plugin \"io.containerd.runtime.v1.linux\"..." type=io.containerd.runtime.v1 Jan 29 11:16:46.317193 containerd[1394]: time="2025-01-29T11:16:46.316784040Z" level=info msg="loading plugin \"io.containerd.monitor.v1.cgroups\"..." type=io.containerd.monitor.v1 Jan 29 11:16:46.317193 containerd[1394]: time="2025-01-29T11:16:46.316994200Z" level=info msg="loading plugin \"io.containerd.runtime.v2.task\"..." type=io.containerd.runtime.v2 Jan 29 11:16:46.317193 containerd[1394]: time="2025-01-29T11:16:46.317056080Z" level=info msg="loading plugin \"io.containerd.runtime.v2.shim\"..." type=io.containerd.runtime.v2 Jan 29 11:16:46.317193 containerd[1394]: time="2025-01-29T11:16:46.317069480Z" level=info msg="loading plugin \"io.containerd.sandbox.store.v1.local\"..." type=io.containerd.sandbox.store.v1 Jan 29 11:16:46.317193 containerd[1394]: time="2025-01-29T11:16:46.317085640Z" level=info msg="loading plugin \"io.containerd.sandbox.controller.v1.local\"..." type=io.containerd.sandbox.controller.v1 Jan 29 11:16:46.317193 containerd[1394]: time="2025-01-29T11:16:46.317098400Z" level=info msg="loading plugin \"io.containerd.service.v1.containers-service\"..." type=io.containerd.service.v1 Jan 29 11:16:46.317193 containerd[1394]: time="2025-01-29T11:16:46.317111200Z" level=info msg="loading plugin \"io.containerd.service.v1.content-service\"..." type=io.containerd.service.v1 Jan 29 11:16:46.317193 containerd[1394]: time="2025-01-29T11:16:46.317123640Z" level=info msg="loading plugin \"io.containerd.service.v1.diff-service\"..." type=io.containerd.service.v1 Jan 29 11:16:46.317193 containerd[1394]: time="2025-01-29T11:16:46.317136160Z" level=info msg="loading plugin \"io.containerd.service.v1.images-service\"..." type=io.containerd.service.v1 Jan 29 11:16:46.317193 containerd[1394]: time="2025-01-29T11:16:46.317149200Z" level=info msg="loading plugin \"io.containerd.service.v1.introspection-service\"..." type=io.containerd.service.v1 Jan 29 11:16:46.317193 containerd[1394]: time="2025-01-29T11:16:46.317162240Z" level=info msg="loading plugin \"io.containerd.service.v1.namespaces-service\"..." type=io.containerd.service.v1 Jan 29 11:16:46.317908 containerd[1394]: time="2025-01-29T11:16:46.317174200Z" level=info msg="loading plugin \"io.containerd.service.v1.snapshots-service\"..." type=io.containerd.service.v1 Jan 29 11:16:46.317908 containerd[1394]: time="2025-01-29T11:16:46.317184840Z" level=info msg="loading plugin \"io.containerd.service.v1.tasks-service\"..." type=io.containerd.service.v1 Jan 29 11:16:46.317908 containerd[1394]: time="2025-01-29T11:16:46.317202920Z" level=info msg="loading plugin \"io.containerd.grpc.v1.containers\"..." type=io.containerd.grpc.v1 Jan 29 11:16:46.317908 containerd[1394]: time="2025-01-29T11:16:46.317215960Z" level=info msg="loading plugin \"io.containerd.grpc.v1.content\"..." type=io.containerd.grpc.v1 Jan 29 11:16:46.317908 containerd[1394]: time="2025-01-29T11:16:46.317230800Z" level=info msg="loading plugin \"io.containerd.grpc.v1.diff\"..." type=io.containerd.grpc.v1 Jan 29 11:16:46.317908 containerd[1394]: time="2025-01-29T11:16:46.317242360Z" level=info msg="loading plugin \"io.containerd.grpc.v1.events\"..." type=io.containerd.grpc.v1 Jan 29 11:16:46.317908 containerd[1394]: time="2025-01-29T11:16:46.317254640Z" level=info msg="loading plugin \"io.containerd.grpc.v1.images\"..." type=io.containerd.grpc.v1 Jan 29 11:16:46.317908 containerd[1394]: time="2025-01-29T11:16:46.317266360Z" level=info msg="loading plugin \"io.containerd.grpc.v1.introspection\"..." type=io.containerd.grpc.v1 Jan 29 11:16:46.317908 containerd[1394]: time="2025-01-29T11:16:46.317277640Z" level=info msg="loading plugin \"io.containerd.grpc.v1.leases\"..." type=io.containerd.grpc.v1 Jan 29 11:16:46.317908 containerd[1394]: time="2025-01-29T11:16:46.317288880Z" level=info msg="loading plugin \"io.containerd.grpc.v1.namespaces\"..." type=io.containerd.grpc.v1 Jan 29 11:16:46.317908 containerd[1394]: time="2025-01-29T11:16:46.317300320Z" level=info msg="loading plugin \"io.containerd.grpc.v1.sandbox-controllers\"..." type=io.containerd.grpc.v1 Jan 29 11:16:46.317908 containerd[1394]: time="2025-01-29T11:16:46.317312600Z" level=info msg="loading plugin \"io.containerd.grpc.v1.sandboxes\"..." type=io.containerd.grpc.v1 Jan 29 11:16:46.317908 containerd[1394]: time="2025-01-29T11:16:46.317323560Z" level=info msg="loading plugin \"io.containerd.grpc.v1.snapshots\"..." type=io.containerd.grpc.v1 Jan 29 11:16:46.317908 containerd[1394]: time="2025-01-29T11:16:46.317336000Z" level=info msg="loading plugin \"io.containerd.grpc.v1.streaming\"..." type=io.containerd.grpc.v1 Jan 29 11:16:46.318162 containerd[1394]: time="2025-01-29T11:16:46.317347280Z" level=info msg="loading plugin \"io.containerd.grpc.v1.tasks\"..." type=io.containerd.grpc.v1 Jan 29 11:16:46.318162 containerd[1394]: time="2025-01-29T11:16:46.317391040Z" level=info msg="loading plugin \"io.containerd.transfer.v1.local\"..." type=io.containerd.transfer.v1 Jan 29 11:16:46.318162 containerd[1394]: time="2025-01-29T11:16:46.317414120Z" level=info msg="loading plugin \"io.containerd.grpc.v1.transfer\"..." type=io.containerd.grpc.v1 Jan 29 11:16:46.318162 containerd[1394]: time="2025-01-29T11:16:46.317428080Z" level=info msg="loading plugin \"io.containerd.grpc.v1.version\"..." type=io.containerd.grpc.v1 Jan 29 11:16:46.318162 containerd[1394]: time="2025-01-29T11:16:46.317438680Z" level=info msg="loading plugin \"io.containerd.internal.v1.restart\"..." type=io.containerd.internal.v1 Jan 29 11:16:46.318162 containerd[1394]: time="2025-01-29T11:16:46.317605920Z" level=info msg="loading plugin \"io.containerd.tracing.processor.v1.otlp\"..." type=io.containerd.tracing.processor.v1 Jan 29 11:16:46.318162 containerd[1394]: time="2025-01-29T11:16:46.317622440Z" level=info msg="skip loading plugin \"io.containerd.tracing.processor.v1.otlp\"..." error="skip plugin: tracing endpoint not configured" type=io.containerd.tracing.processor.v1 Jan 29 11:16:46.318162 containerd[1394]: time="2025-01-29T11:16:46.317633080Z" level=info msg="loading plugin \"io.containerd.internal.v1.tracing\"..." type=io.containerd.internal.v1 Jan 29 11:16:46.318162 containerd[1394]: time="2025-01-29T11:16:46.317734160Z" level=info msg="skip loading plugin \"io.containerd.internal.v1.tracing\"..." error="skip plugin: tracing endpoint not configured" type=io.containerd.internal.v1 Jan 29 11:16:46.318162 containerd[1394]: time="2025-01-29T11:16:46.317744920Z" level=info msg="loading plugin \"io.containerd.grpc.v1.healthcheck\"..." type=io.containerd.grpc.v1 Jan 29 11:16:46.318162 containerd[1394]: time="2025-01-29T11:16:46.317757680Z" level=info msg="loading plugin \"io.containerd.nri.v1.nri\"..." type=io.containerd.nri.v1 Jan 29 11:16:46.318162 containerd[1394]: time="2025-01-29T11:16:46.317767120Z" level=info msg="NRI interface is disabled by configuration." Jan 29 11:16:46.318162 containerd[1394]: time="2025-01-29T11:16:46.317778640Z" level=info msg="loading plugin \"io.containerd.grpc.v1.cri\"..." type=io.containerd.grpc.v1 Jan 29 11:16:46.319023 containerd[1394]: time="2025-01-29T11:16:46.318085280Z" level=info msg="Start cri plugin with config {PluginConfig:{ContainerdConfig:{Snapshotter:overlayfs DefaultRuntimeName:runc DefaultRuntime:{Type: Path: Engine: PodAnnotations:[] ContainerAnnotations:[] Root: Options:map[] PrivilegedWithoutHostDevices:false PrivilegedWithoutHostDevicesAllDevicesAllowed:false BaseRuntimeSpec: NetworkPluginConfDir: NetworkPluginMaxConfNum:0 Snapshotter: SandboxMode:} UntrustedWorkloadRuntime:{Type: Path: Engine: PodAnnotations:[] ContainerAnnotations:[] Root: Options:map[] PrivilegedWithoutHostDevices:false PrivilegedWithoutHostDevicesAllDevicesAllowed:false BaseRuntimeSpec: NetworkPluginConfDir: NetworkPluginMaxConfNum:0 Snapshotter: SandboxMode:} Runtimes:map[runc:{Type:io.containerd.runc.v2 Path: Engine: PodAnnotations:[] ContainerAnnotations:[] Root: Options:map[SystemdCgroup:true] PrivilegedWithoutHostDevices:false PrivilegedWithoutHostDevicesAllDevicesAllowed:false BaseRuntimeSpec: NetworkPluginConfDir: NetworkPluginMaxConfNum:0 Snapshotter: SandboxMode:podsandbox}] NoPivot:false DisableSnapshotAnnotations:true DiscardUnpackedLayers:false IgnoreBlockIONotEnabledErrors:false IgnoreRdtNotEnabledErrors:false} CniConfig:{NetworkPluginBinDir:/opt/cni/bin NetworkPluginConfDir:/etc/cni/net.d NetworkPluginMaxConfNum:1 NetworkPluginSetupSerially:false NetworkPluginConfTemplate: IPPreference:} Registry:{ConfigPath: Mirrors:map[] Configs:map[] Auths:map[] Headers:map[]} ImageDecryption:{KeyModel:node} DisableTCPService:true StreamServerAddress:127.0.0.1 StreamServerPort:0 StreamIdleTimeout:4h0m0s EnableSelinux:true SelinuxCategoryRange:1024 SandboxImage:registry.k8s.io/pause:3.8 StatsCollectPeriod:10 SystemdCgroup:false EnableTLSStreaming:false X509KeyPairStreaming:{TLSCertFile: TLSKeyFile:} MaxContainerLogLineSize:16384 DisableCgroup:false DisableApparmor:false RestrictOOMScoreAdj:false MaxConcurrentDownloads:3 DisableProcMount:false UnsetSeccompProfile: TolerateMissingHugetlbController:true DisableHugetlbController:true DeviceOwnershipFromSecurityContext:false IgnoreImageDefinedVolumes:false NetNSMountsUnderStateDir:false EnableUnprivilegedPorts:false EnableUnprivilegedICMP:false EnableCDI:false CDISpecDirs:[/etc/cdi /var/run/cdi] ImagePullProgressTimeout:5m0s DrainExecSyncIOTimeout:0s ImagePullWithSyncFs:false IgnoreDeprecationWarnings:[]} ContainerdRootDir:/var/lib/containerd ContainerdEndpoint:/run/containerd/containerd.sock RootDir:/var/lib/containerd/io.containerd.grpc.v1.cri StateDir:/run/containerd/io.containerd.grpc.v1.cri}" Jan 29 11:16:46.319023 containerd[1394]: time="2025-01-29T11:16:46.318128160Z" level=info msg="Connect containerd service" Jan 29 11:16:46.319023 containerd[1394]: time="2025-01-29T11:16:46.318155640Z" level=info msg="using legacy CRI server" Jan 29 11:16:46.319023 containerd[1394]: time="2025-01-29T11:16:46.318162320Z" level=info msg="using experimental NRI integration - disable nri plugin to prevent this" Jan 29 11:16:46.319023 containerd[1394]: time="2025-01-29T11:16:46.318413520Z" level=info msg="Get image filesystem path \"/var/lib/containerd/io.containerd.snapshotter.v1.overlayfs\"" Jan 29 11:16:46.319023 containerd[1394]: time="2025-01-29T11:16:46.318883840Z" level=error msg="failed to load cni during init, please check CRI plugin status before setting up network for pods" error="cni config load failed: no network config found in /etc/cni/net.d: cni plugin not initialized: failed to load cni config" Jan 29 11:16:46.319788 containerd[1394]: time="2025-01-29T11:16:46.319334200Z" level=info msg="Start subscribing containerd event" Jan 29 11:16:46.319788 containerd[1394]: time="2025-01-29T11:16:46.319394880Z" level=info msg="Start recovering state" Jan 29 11:16:46.319788 containerd[1394]: time="2025-01-29T11:16:46.319355840Z" level=info msg=serving... address=/run/containerd/containerd.sock.ttrpc Jan 29 11:16:46.319788 containerd[1394]: time="2025-01-29T11:16:46.319450880Z" level=info msg="Start event monitor" Jan 29 11:16:46.319788 containerd[1394]: time="2025-01-29T11:16:46.319480080Z" level=info msg="Start snapshots syncer" Jan 29 11:16:46.319788 containerd[1394]: time="2025-01-29T11:16:46.319488160Z" level=info msg=serving... address=/run/containerd/containerd.sock Jan 29 11:16:46.319788 containerd[1394]: time="2025-01-29T11:16:46.319489960Z" level=info msg="Start cni network conf syncer for default" Jan 29 11:16:46.319788 containerd[1394]: time="2025-01-29T11:16:46.319557480Z" level=info msg="Start streaming server" Jan 29 11:16:46.319788 containerd[1394]: time="2025-01-29T11:16:46.319696640Z" level=info msg="containerd successfully booted in 0.034591s" Jan 29 11:16:46.320464 systemd[1]: Started containerd.service - containerd container runtime. Jan 29 11:16:46.378162 systemd[1430]: Queued start job for default target default.target. Jan 29 11:16:46.389195 systemd[1430]: Created slice app.slice - User Application Slice. Jan 29 11:16:46.389214 systemd[1430]: Reached target paths.target - Paths. Jan 29 11:16:46.389225 systemd[1430]: Reached target timers.target - Timers. Jan 29 11:16:46.390421 systemd[1430]: Starting dbus.socket - D-Bus User Message Bus Socket... Jan 29 11:16:46.399774 systemd[1430]: Listening on dbus.socket - D-Bus User Message Bus Socket. Jan 29 11:16:46.399829 systemd[1430]: Reached target sockets.target - Sockets. Jan 29 11:16:46.399840 systemd[1430]: Reached target basic.target - Basic System. Jan 29 11:16:46.399872 systemd[1430]: Reached target default.target - Main User Target. Jan 29 11:16:46.399896 systemd[1430]: Startup finished in 109ms. Jan 29 11:16:46.400147 systemd[1]: Started user@500.service - User Manager for UID 500. Jan 29 11:16:46.402117 systemd[1]: Started session-1.scope - Session 1 of User core. Jan 29 11:16:46.462785 systemd[1]: Started sshd@1-10.0.0.128:22-10.0.0.1:48954.service - OpenSSH per-connection server daemon (10.0.0.1:48954). Jan 29 11:16:46.501191 sshd[1445]: Accepted publickey for core from 10.0.0.1 port 48954 ssh2: RSA SHA256:Bq1DMYRFt3vwSJT5tcC1MQpWKmkwK1uKH+vc+Uts7DI Jan 29 11:16:46.502255 sshd-session[1445]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Jan 29 11:16:46.506513 systemd-logind[1378]: New session 2 of user core. Jan 29 11:16:46.515511 systemd[1]: Started session-2.scope - Session 2 of User core. Jan 29 11:16:46.566075 sshd[1447]: Connection closed by 10.0.0.1 port 48954 Jan 29 11:16:46.566392 sshd-session[1445]: pam_unix(sshd:session): session closed for user core Jan 29 11:16:46.576456 systemd[1]: sshd@1-10.0.0.128:22-10.0.0.1:48954.service: Deactivated successfully. Jan 29 11:16:46.577914 systemd[1]: session-2.scope: Deactivated successfully. Jan 29 11:16:46.578962 systemd-logind[1378]: Session 2 logged out. Waiting for processes to exit. Jan 29 11:16:46.580030 systemd[1]: Started sshd@2-10.0.0.128:22-10.0.0.1:48958.service - OpenSSH per-connection server daemon (10.0.0.1:48958). Jan 29 11:16:46.581720 systemd-logind[1378]: Removed session 2. Jan 29 11:16:46.618784 sshd[1452]: Accepted publickey for core from 10.0.0.1 port 48958 ssh2: RSA SHA256:Bq1DMYRFt3vwSJT5tcC1MQpWKmkwK1uKH+vc+Uts7DI Jan 29 11:16:46.619838 sshd-session[1452]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Jan 29 11:16:46.623426 systemd-logind[1378]: New session 3 of user core. Jan 29 11:16:46.632540 systemd[1]: Started session-3.scope - Session 3 of User core. Jan 29 11:16:46.683060 sshd[1454]: Connection closed by 10.0.0.1 port 48958 Jan 29 11:16:46.683445 sshd-session[1452]: pam_unix(sshd:session): session closed for user core Jan 29 11:16:46.686136 systemd[1]: sshd@2-10.0.0.128:22-10.0.0.1:48958.service: Deactivated successfully. Jan 29 11:16:46.687562 systemd[1]: session-3.scope: Deactivated successfully. Jan 29 11:16:46.688060 systemd-logind[1378]: Session 3 logged out. Waiting for processes to exit. Jan 29 11:16:46.688785 systemd-logind[1378]: Removed session 3. Jan 29 11:16:47.533522 systemd-networkd[1332]: eth0: Gained IPv6LL Jan 29 11:16:47.534148 systemd-timesyncd[1311]: Network configuration changed, trying to establish connection. Jan 29 11:16:47.536020 systemd[1]: Finished systemd-networkd-wait-online.service - Wait for Network to be Configured. Jan 29 11:16:47.537657 systemd[1]: Reached target network-online.target - Network is Online. Jan 29 11:16:47.552651 systemd[1]: Starting coreos-metadata.service - QEMU metadata agent... Jan 29 11:16:47.554504 systemd[1]: Starting nvidia.service - NVIDIA Configure Service... Jan 29 11:16:47.570926 systemd[1]: coreos-metadata.service: Deactivated successfully. Jan 29 11:16:47.571121 systemd[1]: Finished coreos-metadata.service - QEMU metadata agent. Jan 29 11:16:47.572276 systemd[1]: packet-phone-home.service - Report Success to Packet was skipped because of an unmet condition check (ConditionFirstBoot=true). Jan 29 11:16:47.575396 systemd[1]: Finished nvidia.service - NVIDIA Configure Service. Jan 29 11:16:47.576580 systemd[1]: Reached target multi-user.target - Multi-User System. Jan 29 11:16:47.577450 systemd[1]: cryptenroll-helper-first.service was skipped because of an unmet condition check (ConditionFirstBoot=true). Jan 29 11:16:47.579402 systemd[1]: Startup finished in 538ms (kernel) + 2.100s (initrd) + 2.813s (userspace) = 5.453s. Jan 29 11:16:49.034529 systemd-timesyncd[1311]: Network configuration changed, trying to establish connection. Jan 29 11:16:50.157919 systemd-timesyncd[1311]: Network configuration changed, trying to establish connection. Jan 29 11:16:56.693672 systemd[1]: Started sshd@3-10.0.0.128:22-10.0.0.1:49528.service - OpenSSH per-connection server daemon (10.0.0.1:49528). Jan 29 11:16:56.734886 sshd[1478]: Accepted publickey for core from 10.0.0.1 port 49528 ssh2: RSA SHA256:Bq1DMYRFt3vwSJT5tcC1MQpWKmkwK1uKH+vc+Uts7DI Jan 29 11:16:56.736001 sshd-session[1478]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Jan 29 11:16:56.739344 systemd-logind[1378]: New session 4 of user core. Jan 29 11:16:56.760506 systemd[1]: Started session-4.scope - Session 4 of User core. Jan 29 11:16:56.811619 sshd[1480]: Connection closed by 10.0.0.1 port 49528 Jan 29 11:16:56.811981 sshd-session[1478]: pam_unix(sshd:session): session closed for user core Jan 29 11:16:56.821675 systemd[1]: sshd@3-10.0.0.128:22-10.0.0.1:49528.service: Deactivated successfully. Jan 29 11:16:56.823054 systemd[1]: session-4.scope: Deactivated successfully. Jan 29 11:16:56.824479 systemd-logind[1378]: Session 4 logged out. Waiting for processes to exit. Jan 29 11:16:56.825543 systemd[1]: Started sshd@4-10.0.0.128:22-10.0.0.1:49540.service - OpenSSH per-connection server daemon (10.0.0.1:49540). Jan 29 11:16:56.826275 systemd-logind[1378]: Removed session 4. Jan 29 11:16:56.866096 sshd[1485]: Accepted publickey for core from 10.0.0.1 port 49540 ssh2: RSA SHA256:Bq1DMYRFt3vwSJT5tcC1MQpWKmkwK1uKH+vc+Uts7DI Jan 29 11:16:56.867240 sshd-session[1485]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Jan 29 11:16:56.871266 systemd-logind[1378]: New session 5 of user core. Jan 29 11:16:56.879515 systemd[1]: Started session-5.scope - Session 5 of User core. Jan 29 11:16:56.927063 sshd[1487]: Connection closed by 10.0.0.1 port 49540 Jan 29 11:16:56.927456 sshd-session[1485]: pam_unix(sshd:session): session closed for user core Jan 29 11:16:56.939617 systemd[1]: sshd@4-10.0.0.128:22-10.0.0.1:49540.service: Deactivated successfully. Jan 29 11:16:56.942555 systemd[1]: session-5.scope: Deactivated successfully. Jan 29 11:16:56.943629 systemd-logind[1378]: Session 5 logged out. Waiting for processes to exit. Jan 29 11:16:56.944700 systemd[1]: Started sshd@5-10.0.0.128:22-10.0.0.1:49552.service - OpenSSH per-connection server daemon (10.0.0.1:49552). Jan 29 11:16:56.945561 systemd-logind[1378]: Removed session 5. Jan 29 11:16:56.988997 sshd[1492]: Accepted publickey for core from 10.0.0.1 port 49552 ssh2: RSA SHA256:Bq1DMYRFt3vwSJT5tcC1MQpWKmkwK1uKH+vc+Uts7DI Jan 29 11:16:56.990160 sshd-session[1492]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Jan 29 11:16:56.994262 systemd-logind[1378]: New session 6 of user core. Jan 29 11:16:57.005507 systemd[1]: Started session-6.scope - Session 6 of User core. Jan 29 11:16:57.057013 sshd[1494]: Connection closed by 10.0.0.1 port 49552 Jan 29 11:16:57.057289 sshd-session[1492]: pam_unix(sshd:session): session closed for user core Jan 29 11:16:57.066790 systemd[1]: sshd@5-10.0.0.128:22-10.0.0.1:49552.service: Deactivated successfully. Jan 29 11:16:57.068134 systemd[1]: session-6.scope: Deactivated successfully. Jan 29 11:16:57.070132 systemd-logind[1378]: Session 6 logged out. Waiting for processes to exit. Jan 29 11:16:57.070979 systemd[1]: Started sshd@6-10.0.0.128:22-10.0.0.1:49566.service - OpenSSH per-connection server daemon (10.0.0.1:49566). Jan 29 11:16:57.072081 systemd-logind[1378]: Removed session 6. Jan 29 11:16:57.110174 sshd[1499]: Accepted publickey for core from 10.0.0.1 port 49566 ssh2: RSA SHA256:Bq1DMYRFt3vwSJT5tcC1MQpWKmkwK1uKH+vc+Uts7DI Jan 29 11:16:57.111251 sshd-session[1499]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Jan 29 11:16:57.115561 systemd-logind[1378]: New session 7 of user core. Jan 29 11:16:57.124531 systemd[1]: Started session-7.scope - Session 7 of User core. Jan 29 11:16:57.187695 sudo[1502]: core : PWD=/home/core ; USER=root ; COMMAND=/usr/sbin/setenforce 1 Jan 29 11:16:57.187965 sudo[1502]: pam_unix(sudo:session): session opened for user root(uid=0) by core(uid=500) Jan 29 11:16:57.193395 kernel: audit: type=1404 audit(1738149417.190:3): enforcing=1 old_enforcing=0 auid=500 ses=7 enabled=1 old-enabled=1 lsm=selinux res=1 Jan 29 11:16:57.202174 sudo[1502]: pam_unix(sudo:session): session closed for user root Jan 29 11:16:57.203427 sshd[1501]: Connection closed by 10.0.0.1 port 49566 Jan 29 11:16:57.203772 sshd-session[1499]: pam_unix(sshd:session): session closed for user core Jan 29 11:16:57.212611 systemd[1]: sshd@6-10.0.0.128:22-10.0.0.1:49566.service: Deactivated successfully. Jan 29 11:16:57.213884 systemd[1]: session-7.scope: Deactivated successfully. Jan 29 11:16:57.215124 systemd-logind[1378]: Session 7 logged out. Waiting for processes to exit. Jan 29 11:16:57.216411 systemd[1]: Started sshd@7-10.0.0.128:22-10.0.0.1:49576.service - OpenSSH per-connection server daemon (10.0.0.1:49576). Jan 29 11:16:57.217191 systemd-logind[1378]: Removed session 7. Jan 29 11:16:57.256953 sshd[1507]: Accepted publickey for core from 10.0.0.1 port 49576 ssh2: RSA SHA256:Bq1DMYRFt3vwSJT5tcC1MQpWKmkwK1uKH+vc+Uts7DI Jan 29 11:16:57.258253 sshd-session[1507]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Jan 29 11:16:57.262342 systemd-logind[1378]: New session 8 of user core. Jan 29 11:16:57.273528 systemd[1]: Started session-8.scope - Session 8 of User core. Jan 29 11:16:57.324353 sudo[1511]: core : PWD=/home/core ; USER=root ; COMMAND=/usr/sbin/rm -rf /etc/audit/rules.d/80-selinux.rules /etc/audit/rules.d/99-default.rules Jan 29 11:16:57.324646 sudo[1511]: pam_unix(sudo:session): session opened for user root(uid=0) by core(uid=500) Jan 29 11:16:57.327267 sudo[1511]: pam_unix(sudo:session): session closed for user root Jan 29 11:16:57.331736 sudo[1510]: core : PWD=/home/core ; USER=root ; COMMAND=/usr/sbin/systemctl restart audit-rules Jan 29 11:16:57.332003 sudo[1510]: pam_unix(sudo:session): session opened for user root(uid=0) by core(uid=500) Jan 29 11:16:57.349688 systemd[1]: Starting audit-rules.service - Load Audit Rules... Jan 29 11:16:57.359599 augenrules[1514]: /sbin/augenrules: No change Jan 29 11:16:57.364876 augenrules[1529]: No rules Jan 29 11:16:57.366065 systemd[1]: audit-rules.service: Deactivated successfully. Jan 29 11:16:57.366287 systemd[1]: Finished audit-rules.service - Load Audit Rules. Jan 29 11:16:57.367328 sudo[1510]: pam_unix(sudo:session): session closed for user root Jan 29 11:16:57.369240 sshd[1509]: Connection closed by 10.0.0.1 port 49576 Jan 29 11:16:57.369166 sshd-session[1507]: pam_unix(sshd:session): session closed for user core Jan 29 11:16:57.376747 systemd[1]: sshd@7-10.0.0.128:22-10.0.0.1:49576.service: Deactivated successfully. Jan 29 11:16:57.378534 systemd[1]: session-8.scope: Deactivated successfully. Jan 29 11:16:57.380450 systemd-logind[1378]: Session 8 logged out. Waiting for processes to exit. Jan 29 11:16:57.386603 systemd[1]: Started sshd@8-10.0.0.128:22-10.0.0.1:49584.service - OpenSSH per-connection server daemon (10.0.0.1:49584). Jan 29 11:16:57.387465 systemd-logind[1378]: Removed session 8. Jan 29 11:16:57.422843 sshd[1537]: Accepted publickey for core from 10.0.0.1 port 49584 ssh2: RSA SHA256:Bq1DMYRFt3vwSJT5tcC1MQpWKmkwK1uKH+vc+Uts7DI Jan 29 11:16:57.424068 sshd-session[1537]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Jan 29 11:16:57.427618 systemd-logind[1378]: New session 9 of user core. Jan 29 11:16:57.433500 systemd[1]: Started session-9.scope - Session 9 of User core. Jan 29 11:16:57.484988 sshd[1539]: Connection closed by 10.0.0.1 port 49584 Jan 29 11:16:57.485438 sshd-session[1537]: pam_unix(sshd:session): session closed for user core Jan 29 11:16:57.503915 systemd[1]: sshd@8-10.0.0.128:22-10.0.0.1:49584.service: Deactivated successfully. Jan 29 11:16:57.505313 systemd[1]: session-9.scope: Deactivated successfully. Jan 29 11:16:57.507415 systemd-logind[1378]: Session 9 logged out. Waiting for processes to exit. Jan 29 11:16:57.508584 systemd[1]: Started sshd@9-10.0.0.128:22-10.0.0.1:49586.service - OpenSSH per-connection server daemon (10.0.0.1:49586). Jan 29 11:16:57.509249 systemd-logind[1378]: Removed session 9. Jan 29 11:16:57.570450 sshd[1544]: Accepted publickey for core from 10.0.0.1 port 49586 ssh2: RSA SHA256:Bq1DMYRFt3vwSJT5tcC1MQpWKmkwK1uKH+vc+Uts7DI Jan 29 11:16:57.571864 sshd-session[1544]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Jan 29 11:16:57.575734 systemd-logind[1378]: New session 10 of user core. Jan 29 11:16:57.592520 systemd[1]: Started session-10.scope - Session 10 of User core. Jan 29 11:16:57.642839 sshd[1546]: Connection closed by 10.0.0.1 port 49586 Jan 29 11:16:57.643171 sshd-session[1544]: pam_unix(sshd:session): session closed for user core Jan 29 11:16:57.647201 systemd[1]: sshd@9-10.0.0.128:22-10.0.0.1:49586.service: Deactivated successfully. Jan 29 11:16:57.648699 systemd[1]: session-10.scope: Deactivated successfully. Jan 29 11:16:57.649865 systemd-logind[1378]: Session 10 logged out. Waiting for processes to exit. Jan 29 11:16:57.650712 systemd-logind[1378]: Removed session 10.