Dec 13 13:25:57.912440 kernel: Booting Linux on physical CPU 0x0000000000 [0x413fd0c1] Dec 13 13:25:57.912460 kernel: Linux version 6.6.65-flatcar (build@pony-truck.infra.kinvolk.io) (aarch64-cros-linux-gnu-gcc (Gentoo Hardened 14.2.1_p20241116 p3) 14.2.1 20241116, GNU ld (Gentoo 2.42 p6) 2.42.0) #1 SMP PREEMPT Fri Dec 13 11:56:07 -00 2024 Dec 13 13:25:57.912469 kernel: KASLR enabled Dec 13 13:25:57.912475 kernel: efi: EFI v2.7 by EDK II Dec 13 13:25:57.912481 kernel: efi: SMBIOS 3.0=0xdced0000 MEMATTR=0xdbbae018 ACPI 2.0=0xd9b43018 RNG=0xd9b43a18 MEMRESERVE=0xd9b40218 Dec 13 13:25:57.912486 kernel: random: crng init done Dec 13 13:25:57.912493 kernel: secureboot: Secure boot disabled Dec 13 13:25:57.912499 kernel: ACPI: Early table checksum verification disabled Dec 13 13:25:57.912505 kernel: ACPI: RSDP 0x00000000D9B43018 000024 (v02 BOCHS ) Dec 13 13:25:57.912512 kernel: ACPI: XSDT 0x00000000D9B43F18 000064 (v01 BOCHS BXPC 00000001 01000013) Dec 13 13:25:57.912518 kernel: ACPI: FACP 0x00000000D9B43B18 000114 (v06 BOCHS BXPC 00000001 BXPC 00000001) Dec 13 13:25:57.912524 kernel: ACPI: DSDT 0x00000000D9B41018 0014A2 (v02 BOCHS BXPC 00000001 BXPC 00000001) Dec 13 13:25:57.912529 kernel: ACPI: APIC 0x00000000D9B43C98 0001A8 (v04 BOCHS BXPC 00000001 BXPC 00000001) Dec 13 13:25:57.912535 kernel: ACPI: PPTT 0x00000000D9B43098 00009C (v02 BOCHS BXPC 00000001 BXPC 00000001) Dec 13 13:25:57.912543 kernel: ACPI: GTDT 0x00000000D9B43818 000060 (v02 BOCHS BXPC 00000001 BXPC 00000001) Dec 13 13:25:57.912550 kernel: ACPI: MCFG 0x00000000D9B43A98 00003C (v01 BOCHS BXPC 00000001 BXPC 00000001) Dec 13 13:25:57.912557 kernel: ACPI: SPCR 0x00000000D9B43918 000050 (v02 BOCHS BXPC 00000001 BXPC 00000001) Dec 13 13:25:57.912563 kernel: ACPI: DBG2 0x00000000D9B43998 000057 (v00 BOCHS BXPC 00000001 BXPC 00000001) Dec 13 13:25:57.912569 kernel: ACPI: IORT 0x00000000D9B43198 000080 (v03 BOCHS BXPC 00000001 BXPC 00000001) Dec 13 13:25:57.912575 kernel: ACPI: SPCR: console: pl011,mmio,0x9000000,9600 Dec 13 13:25:57.912581 kernel: NUMA: Failed to initialise from firmware Dec 13 13:25:57.912587 kernel: NUMA: Faking a node at [mem 0x0000000040000000-0x00000000dcffffff] Dec 13 13:25:57.912594 kernel: NUMA: NODE_DATA [mem 0xdc958800-0xdc95dfff] Dec 13 13:25:57.912600 kernel: Zone ranges: Dec 13 13:25:57.912606 kernel: DMA [mem 0x0000000040000000-0x00000000dcffffff] Dec 13 13:25:57.912613 kernel: DMA32 empty Dec 13 13:25:57.912619 kernel: Normal empty Dec 13 13:25:57.912625 kernel: Movable zone start for each node Dec 13 13:25:57.912631 kernel: Early memory node ranges Dec 13 13:25:57.912637 kernel: node 0: [mem 0x0000000040000000-0x00000000d967ffff] Dec 13 13:25:57.912643 kernel: node 0: [mem 0x00000000d9680000-0x00000000d968ffff] Dec 13 13:25:57.912649 kernel: node 0: [mem 0x00000000d9690000-0x00000000d976ffff] Dec 13 13:25:57.912655 kernel: node 0: [mem 0x00000000d9770000-0x00000000d9b3ffff] Dec 13 13:25:57.912661 kernel: node 0: [mem 0x00000000d9b40000-0x00000000dce1ffff] Dec 13 13:25:57.912667 kernel: node 0: [mem 0x00000000dce20000-0x00000000dceaffff] Dec 13 13:25:57.912673 kernel: node 0: [mem 0x00000000dceb0000-0x00000000dcebffff] Dec 13 13:25:57.912679 kernel: node 0: [mem 0x00000000dcec0000-0x00000000dcfdffff] Dec 13 13:25:57.912686 kernel: node 0: [mem 0x00000000dcfe0000-0x00000000dcffffff] Dec 13 13:25:57.912693 kernel: Initmem setup node 0 [mem 0x0000000040000000-0x00000000dcffffff] Dec 13 13:25:57.912699 kernel: On node 0, zone DMA: 12288 pages in unavailable ranges Dec 13 13:25:57.912708 kernel: psci: probing for conduit method from ACPI. Dec 13 13:25:57.912715 kernel: psci: PSCIv1.1 detected in firmware. Dec 13 13:25:57.912721 kernel: psci: Using standard PSCI v0.2 function IDs Dec 13 13:25:57.912729 kernel: psci: Trusted OS migration not required Dec 13 13:25:57.912735 kernel: psci: SMC Calling Convention v1.1 Dec 13 13:25:57.912742 kernel: smccc: KVM: hypervisor services detected (0x00000000 0x00000000 0x00000000 0x00000003) Dec 13 13:25:57.912749 kernel: percpu: Embedded 31 pages/cpu s86696 r8192 d32088 u126976 Dec 13 13:25:57.912755 kernel: pcpu-alloc: s86696 r8192 d32088 u126976 alloc=31*4096 Dec 13 13:25:57.912762 kernel: pcpu-alloc: [0] 0 [0] 1 [0] 2 [0] 3 Dec 13 13:25:57.912768 kernel: Detected PIPT I-cache on CPU0 Dec 13 13:25:57.912775 kernel: CPU features: detected: GIC system register CPU interface Dec 13 13:25:57.912781 kernel: CPU features: detected: Hardware dirty bit management Dec 13 13:25:57.912798 kernel: CPU features: detected: Spectre-v4 Dec 13 13:25:57.912808 kernel: CPU features: detected: Spectre-BHB Dec 13 13:25:57.912814 kernel: CPU features: kernel page table isolation forced ON by KASLR Dec 13 13:25:57.912821 kernel: CPU features: detected: Kernel page table isolation (KPTI) Dec 13 13:25:57.912827 kernel: CPU features: detected: ARM erratum 1418040 Dec 13 13:25:57.912834 kernel: CPU features: detected: SSBS not fully self-synchronizing Dec 13 13:25:57.912840 kernel: alternatives: applying boot alternatives Dec 13 13:25:57.912847 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=c48af8adabdaf1d8e07ceb011d2665929c607ddf2c4d40203b31334d745cc472 Dec 13 13:25:57.912854 kernel: Unknown kernel command line parameters "BOOT_IMAGE=/flatcar/vmlinuz-a", will be passed to user space. Dec 13 13:25:57.912861 kernel: Dentry cache hash table entries: 524288 (order: 10, 4194304 bytes, linear) Dec 13 13:25:57.912868 kernel: Inode-cache hash table entries: 262144 (order: 9, 2097152 bytes, linear) Dec 13 13:25:57.912874 kernel: Fallback order for Node 0: 0 Dec 13 13:25:57.912882 kernel: Built 1 zonelists, mobility grouping on. Total pages: 633024 Dec 13 13:25:57.912889 kernel: Policy zone: DMA Dec 13 13:25:57.912895 kernel: mem auto-init: stack:off, heap alloc:off, heap free:off Dec 13 13:25:57.912902 kernel: software IO TLB: area num 4. Dec 13 13:25:57.912909 kernel: software IO TLB: mapped [mem 0x00000000d2e00000-0x00000000d6e00000] (64MB) Dec 13 13:25:57.912916 kernel: Memory: 2385940K/2572288K available (10304K kernel code, 2184K rwdata, 8088K rodata, 39936K init, 897K bss, 186348K reserved, 0K cma-reserved) Dec 13 13:25:57.912923 kernel: SLUB: HWalign=64, Order=0-3, MinObjects=0, CPUs=4, Nodes=1 Dec 13 13:25:57.912944 kernel: trace event string verifier disabled Dec 13 13:25:57.912950 kernel: rcu: Preemptible hierarchical RCU implementation. Dec 13 13:25:57.912957 kernel: rcu: RCU event tracing is enabled. Dec 13 13:25:57.912965 kernel: rcu: RCU restricting CPUs from NR_CPUS=512 to nr_cpu_ids=4. Dec 13 13:25:57.912972 kernel: Trampoline variant of Tasks RCU enabled. Dec 13 13:25:57.912980 kernel: Tracing variant of Tasks RCU enabled. Dec 13 13:25:57.912986 kernel: rcu: RCU calculated value of scheduler-enlistment delay is 100 jiffies. Dec 13 13:25:57.912993 kernel: rcu: Adjusting geometry for rcu_fanout_leaf=16, nr_cpu_ids=4 Dec 13 13:25:57.913000 kernel: NR_IRQS: 64, nr_irqs: 64, preallocated irqs: 0 Dec 13 13:25:57.913006 kernel: GICv3: 256 SPIs implemented Dec 13 13:25:57.913012 kernel: GICv3: 0 Extended SPIs implemented Dec 13 13:25:57.913019 kernel: Root IRQ handler: gic_handle_irq Dec 13 13:25:57.913026 kernel: GICv3: GICv3 features: 16 PPIs, DirectLPI Dec 13 13:25:57.913032 kernel: GICv3: CPU0: found redistributor 0 region 0:0x00000000080a0000 Dec 13 13:25:57.913039 kernel: ITS [mem 0x08080000-0x0809ffff] Dec 13 13:25:57.913046 kernel: ITS@0x0000000008080000: allocated 8192 Devices @400c0000 (indirect, esz 8, psz 64K, shr 1) Dec 13 13:25:57.913054 kernel: ITS@0x0000000008080000: allocated 8192 Interrupt Collections @400d0000 (flat, esz 8, psz 64K, shr 1) Dec 13 13:25:57.913061 kernel: GICv3: using LPI property table @0x00000000400f0000 Dec 13 13:25:57.913068 kernel: GICv3: CPU0: using allocated LPI pending table @0x0000000040100000 Dec 13 13:25:57.913074 kernel: rcu: srcu_init: Setting srcu_struct sizes based on contention. Dec 13 13:25:57.913081 kernel: arch_timer: Enabling local workaround for ARM erratum 1418040 Dec 13 13:25:57.913087 kernel: arch_timer: cp15 timer(s) running at 25.00MHz (virt). Dec 13 13:25:57.913094 kernel: clocksource: arch_sys_counter: mask: 0xffffffffffffff max_cycles: 0x5c40939b5, max_idle_ns: 440795202646 ns Dec 13 13:25:57.913101 kernel: sched_clock: 56 bits at 25MHz, resolution 40ns, wraps every 4398046511100ns Dec 13 13:25:57.913108 kernel: arm-pv: using stolen time PV Dec 13 13:25:57.913115 kernel: Console: colour dummy device 80x25 Dec 13 13:25:57.913121 kernel: ACPI: Core revision 20230628 Dec 13 13:25:57.913129 kernel: Calibrating delay loop (skipped), value calculated using timer frequency.. 50.00 BogoMIPS (lpj=25000) Dec 13 13:25:57.913136 kernel: pid_max: default: 32768 minimum: 301 Dec 13 13:25:57.913143 kernel: LSM: initializing lsm=lockdown,capability,landlock,selinux,integrity Dec 13 13:25:57.913150 kernel: landlock: Up and running. Dec 13 13:25:57.913156 kernel: SELinux: Initializing. Dec 13 13:25:57.913163 kernel: Mount-cache hash table entries: 8192 (order: 4, 65536 bytes, linear) Dec 13 13:25:57.913170 kernel: Mountpoint-cache hash table entries: 8192 (order: 4, 65536 bytes, linear) Dec 13 13:25:57.913177 kernel: RCU Tasks: Setting shift to 2 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=4. Dec 13 13:25:57.913183 kernel: RCU Tasks Trace: Setting shift to 2 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=4. Dec 13 13:25:57.913191 kernel: rcu: Hierarchical SRCU implementation. Dec 13 13:25:57.913198 kernel: rcu: Max phase no-delay instances is 400. Dec 13 13:25:57.913205 kernel: Platform MSI: ITS@0x8080000 domain created Dec 13 13:25:57.913211 kernel: PCI/MSI: ITS@0x8080000 domain created Dec 13 13:25:57.913218 kernel: Remapping and enabling EFI services. Dec 13 13:25:57.913224 kernel: smp: Bringing up secondary CPUs ... Dec 13 13:25:57.913231 kernel: Detected PIPT I-cache on CPU1 Dec 13 13:25:57.913238 kernel: GICv3: CPU1: found redistributor 1 region 0:0x00000000080c0000 Dec 13 13:25:57.913244 kernel: GICv3: CPU1: using allocated LPI pending table @0x0000000040110000 Dec 13 13:25:57.913252 kernel: arch_timer: Enabling local workaround for ARM erratum 1418040 Dec 13 13:25:57.913259 kernel: CPU1: Booted secondary processor 0x0000000001 [0x413fd0c1] Dec 13 13:25:57.913270 kernel: Detected PIPT I-cache on CPU2 Dec 13 13:25:57.913279 kernel: GICv3: CPU2: found redistributor 2 region 0:0x00000000080e0000 Dec 13 13:25:57.913292 kernel: GICv3: CPU2: using allocated LPI pending table @0x0000000040120000 Dec 13 13:25:57.913299 kernel: arch_timer: Enabling local workaround for ARM erratum 1418040 Dec 13 13:25:57.913306 kernel: CPU2: Booted secondary processor 0x0000000002 [0x413fd0c1] Dec 13 13:25:57.913313 kernel: Detected PIPT I-cache on CPU3 Dec 13 13:25:57.913320 kernel: GICv3: CPU3: found redistributor 3 region 0:0x0000000008100000 Dec 13 13:25:57.913328 kernel: GICv3: CPU3: using allocated LPI pending table @0x0000000040130000 Dec 13 13:25:57.913336 kernel: arch_timer: Enabling local workaround for ARM erratum 1418040 Dec 13 13:25:57.913342 kernel: CPU3: Booted secondary processor 0x0000000003 [0x413fd0c1] Dec 13 13:25:57.913349 kernel: smp: Brought up 1 node, 4 CPUs Dec 13 13:25:57.913356 kernel: SMP: Total of 4 processors activated. Dec 13 13:25:57.913363 kernel: CPU features: detected: 32-bit EL0 Support Dec 13 13:25:57.913370 kernel: CPU features: detected: Data cache clean to the PoU not required for I/D coherence Dec 13 13:25:57.913377 kernel: CPU features: detected: Common not Private translations Dec 13 13:25:57.913384 kernel: CPU features: detected: CRC32 instructions Dec 13 13:25:57.913392 kernel: CPU features: detected: Enhanced Virtualization Traps Dec 13 13:25:57.913400 kernel: CPU features: detected: RCpc load-acquire (LDAPR) Dec 13 13:25:57.913407 kernel: CPU features: detected: LSE atomic instructions Dec 13 13:25:57.913413 kernel: CPU features: detected: Privileged Access Never Dec 13 13:25:57.913420 kernel: CPU features: detected: RAS Extension Support Dec 13 13:25:57.913427 kernel: CPU features: detected: Speculative Store Bypassing Safe (SSBS) Dec 13 13:25:57.913434 kernel: CPU: All CPU(s) started at EL1 Dec 13 13:25:57.913442 kernel: alternatives: applying system-wide alternatives Dec 13 13:25:57.913449 kernel: devtmpfs: initialized Dec 13 13:25:57.913457 kernel: clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1911260446275000 ns Dec 13 13:25:57.913465 kernel: futex hash table entries: 1024 (order: 4, 65536 bytes, linear) Dec 13 13:25:57.913471 kernel: pinctrl core: initialized pinctrl subsystem Dec 13 13:25:57.913478 kernel: SMBIOS 3.0.0 present. Dec 13 13:25:57.913485 kernel: DMI: QEMU KVM Virtual Machine, BIOS unknown 02/02/2022 Dec 13 13:25:57.913492 kernel: NET: Registered PF_NETLINK/PF_ROUTE protocol family Dec 13 13:25:57.913500 kernel: DMA: preallocated 512 KiB GFP_KERNEL pool for atomic allocations Dec 13 13:25:57.913507 kernel: DMA: preallocated 512 KiB GFP_KERNEL|GFP_DMA pool for atomic allocations Dec 13 13:25:57.913514 kernel: DMA: preallocated 512 KiB GFP_KERNEL|GFP_DMA32 pool for atomic allocations Dec 13 13:25:57.913522 kernel: audit: initializing netlink subsys (disabled) Dec 13 13:25:57.913529 kernel: audit: type=2000 audit(0.018:1): state=initialized audit_enabled=0 res=1 Dec 13 13:25:57.913536 kernel: thermal_sys: Registered thermal governor 'step_wise' Dec 13 13:25:57.913543 kernel: cpuidle: using governor menu Dec 13 13:25:57.913550 kernel: hw-breakpoint: found 6 breakpoint and 4 watchpoint registers. Dec 13 13:25:57.913557 kernel: ASID allocator initialised with 32768 entries Dec 13 13:25:57.913565 kernel: acpiphp: ACPI Hot Plug PCI Controller Driver version: 0.5 Dec 13 13:25:57.913572 kernel: Serial: AMBA PL011 UART driver Dec 13 13:25:57.913579 kernel: Modules: 2G module region forced by RANDOMIZE_MODULE_REGION_FULL Dec 13 13:25:57.913587 kernel: Modules: 0 pages in range for non-PLT usage Dec 13 13:25:57.913594 kernel: Modules: 508880 pages in range for PLT usage Dec 13 13:25:57.913601 kernel: HugeTLB: registered 1.00 GiB page size, pre-allocated 0 pages Dec 13 13:25:57.913608 kernel: HugeTLB: 0 KiB vmemmap can be freed for a 1.00 GiB page Dec 13 13:25:57.913620 kernel: HugeTLB: registered 32.0 MiB page size, pre-allocated 0 pages Dec 13 13:25:57.913627 kernel: HugeTLB: 0 KiB vmemmap can be freed for a 32.0 MiB page Dec 13 13:25:57.913634 kernel: HugeTLB: registered 2.00 MiB page size, pre-allocated 0 pages Dec 13 13:25:57.913641 kernel: HugeTLB: 0 KiB vmemmap can be freed for a 2.00 MiB page Dec 13 13:25:57.913648 kernel: HugeTLB: registered 64.0 KiB page size, pre-allocated 0 pages Dec 13 13:25:57.913656 kernel: HugeTLB: 0 KiB vmemmap can be freed for a 64.0 KiB page Dec 13 13:25:57.913663 kernel: ACPI: Added _OSI(Module Device) Dec 13 13:25:57.913671 kernel: ACPI: Added _OSI(Processor Device) Dec 13 13:25:57.913677 kernel: ACPI: Added _OSI(3.0 _SCP Extensions) Dec 13 13:25:57.913684 kernel: ACPI: Added _OSI(Processor Aggregator Device) Dec 13 13:25:57.913691 kernel: ACPI: 1 ACPI AML tables successfully acquired and loaded Dec 13 13:25:57.913699 kernel: ACPI: Interpreter enabled Dec 13 13:25:57.913706 kernel: ACPI: Using GIC for interrupt routing Dec 13 13:25:57.913712 kernel: ACPI: MCFG table detected, 1 entries Dec 13 13:25:57.913721 kernel: ARMH0011:00: ttyAMA0 at MMIO 0x9000000 (irq = 12, base_baud = 0) is a SBSA Dec 13 13:25:57.913728 kernel: printk: console [ttyAMA0] enabled Dec 13 13:25:57.913735 kernel: ACPI: PCI Root Bridge [PCI0] (domain 0000 [bus 00-ff]) Dec 13 13:25:57.913859 kernel: acpi PNP0A08:00: _OSC: OS supports [ExtendedConfig ASPM ClockPM Segments MSI HPX-Type3] Dec 13 13:25:57.913931 kernel: acpi PNP0A08:00: _OSC: platform does not support [LTR] Dec 13 13:25:57.913996 kernel: acpi PNP0A08:00: _OSC: OS now controls [PCIeHotplug PME AER PCIeCapability] Dec 13 13:25:57.914060 kernel: acpi PNP0A08:00: ECAM area [mem 0x4010000000-0x401fffffff] reserved by PNP0C02:00 Dec 13 13:25:57.914124 kernel: acpi PNP0A08:00: ECAM at [mem 0x4010000000-0x401fffffff] for [bus 00-ff] Dec 13 13:25:57.914133 kernel: ACPI: Remapped I/O 0x000000003eff0000 to [io 0x0000-0xffff window] Dec 13 13:25:57.914140 kernel: PCI host bridge to bus 0000:00 Dec 13 13:25:57.914208 kernel: pci_bus 0000:00: root bus resource [mem 0x10000000-0x3efeffff window] Dec 13 13:25:57.914267 kernel: pci_bus 0000:00: root bus resource [io 0x0000-0xffff window] Dec 13 13:25:57.914335 kernel: pci_bus 0000:00: root bus resource [mem 0x8000000000-0xffffffffff window] Dec 13 13:25:57.914394 kernel: pci_bus 0000:00: root bus resource [bus 00-ff] Dec 13 13:25:57.914472 kernel: pci 0000:00:00.0: [1b36:0008] type 00 class 0x060000 Dec 13 13:25:57.914548 kernel: pci 0000:00:01.0: [1af4:1005] type 00 class 0x00ff00 Dec 13 13:25:57.914613 kernel: pci 0000:00:01.0: reg 0x10: [io 0x0000-0x001f] Dec 13 13:25:57.914678 kernel: pci 0000:00:01.0: reg 0x14: [mem 0x10000000-0x10000fff] Dec 13 13:25:57.914741 kernel: pci 0000:00:01.0: reg 0x20: [mem 0x8000000000-0x8000003fff 64bit pref] Dec 13 13:25:57.914827 kernel: pci 0000:00:01.0: BAR 4: assigned [mem 0x8000000000-0x8000003fff 64bit pref] Dec 13 13:25:57.914895 kernel: pci 0000:00:01.0: BAR 1: assigned [mem 0x10000000-0x10000fff] Dec 13 13:25:57.914964 kernel: pci 0000:00:01.0: BAR 0: assigned [io 0x1000-0x101f] Dec 13 13:25:57.915023 kernel: pci_bus 0000:00: resource 4 [mem 0x10000000-0x3efeffff window] Dec 13 13:25:57.915081 kernel: pci_bus 0000:00: resource 5 [io 0x0000-0xffff window] Dec 13 13:25:57.915139 kernel: pci_bus 0000:00: resource 6 [mem 0x8000000000-0xffffffffff window] Dec 13 13:25:57.915149 kernel: ACPI: PCI: Interrupt link GSI0 configured for IRQ 35 Dec 13 13:25:57.915156 kernel: ACPI: PCI: Interrupt link GSI1 configured for IRQ 36 Dec 13 13:25:57.915164 kernel: ACPI: PCI: Interrupt link GSI2 configured for IRQ 37 Dec 13 13:25:57.915171 kernel: ACPI: PCI: Interrupt link GSI3 configured for IRQ 38 Dec 13 13:25:57.915179 kernel: iommu: Default domain type: Translated Dec 13 13:25:57.915187 kernel: iommu: DMA domain TLB invalidation policy: strict mode Dec 13 13:25:57.915194 kernel: efivars: Registered efivars operations Dec 13 13:25:57.915200 kernel: vgaarb: loaded Dec 13 13:25:57.915208 kernel: clocksource: Switched to clocksource arch_sys_counter Dec 13 13:25:57.915214 kernel: VFS: Disk quotas dquot_6.6.0 Dec 13 13:25:57.915222 kernel: VFS: Dquot-cache hash table entries: 512 (order 0, 4096 bytes) Dec 13 13:25:57.915229 kernel: pnp: PnP ACPI init Dec 13 13:25:57.915308 kernel: system 00:00: [mem 0x4010000000-0x401fffffff window] could not be reserved Dec 13 13:25:57.915321 kernel: pnp: PnP ACPI: found 1 devices Dec 13 13:25:57.915328 kernel: NET: Registered PF_INET protocol family Dec 13 13:25:57.915335 kernel: IP idents hash table entries: 65536 (order: 7, 524288 bytes, linear) Dec 13 13:25:57.915343 kernel: tcp_listen_portaddr_hash hash table entries: 2048 (order: 3, 32768 bytes, linear) Dec 13 13:25:57.915350 kernel: Table-perturb hash table entries: 65536 (order: 6, 262144 bytes, linear) Dec 13 13:25:57.915357 kernel: TCP established hash table entries: 32768 (order: 6, 262144 bytes, linear) Dec 13 13:25:57.915364 kernel: TCP bind hash table entries: 32768 (order: 8, 1048576 bytes, linear) Dec 13 13:25:57.915371 kernel: TCP: Hash tables configured (established 32768 bind 32768) Dec 13 13:25:57.915380 kernel: UDP hash table entries: 2048 (order: 4, 65536 bytes, linear) Dec 13 13:25:57.915387 kernel: UDP-Lite hash table entries: 2048 (order: 4, 65536 bytes, linear) Dec 13 13:25:57.915394 kernel: NET: Registered PF_UNIX/PF_LOCAL protocol family Dec 13 13:25:57.915401 kernel: PCI: CLS 0 bytes, default 64 Dec 13 13:25:57.915408 kernel: kvm [1]: HYP mode not available Dec 13 13:25:57.915415 kernel: Initialise system trusted keyrings Dec 13 13:25:57.915422 kernel: workingset: timestamp_bits=39 max_order=20 bucket_order=0 Dec 13 13:25:57.915429 kernel: Key type asymmetric registered Dec 13 13:25:57.915436 kernel: Asymmetric key parser 'x509' registered Dec 13 13:25:57.915444 kernel: Block layer SCSI generic (bsg) driver version 0.4 loaded (major 250) Dec 13 13:25:57.915451 kernel: io scheduler mq-deadline registered Dec 13 13:25:57.915458 kernel: io scheduler kyber registered Dec 13 13:25:57.915465 kernel: io scheduler bfq registered Dec 13 13:25:57.915472 kernel: input: Power Button as /devices/LNXSYSTM:00/LNXSYBUS:00/PNP0C0C:00/input/input0 Dec 13 13:25:57.915479 kernel: ACPI: button: Power Button [PWRB] Dec 13 13:25:57.915487 kernel: ACPI: \_SB_.PCI0.GSI1: Enabled at IRQ 36 Dec 13 13:25:57.915551 kernel: virtio-pci 0000:00:01.0: enabling device (0005 -> 0007) Dec 13 13:25:57.915561 kernel: Serial: 8250/16550 driver, 4 ports, IRQ sharing enabled Dec 13 13:25:57.915570 kernel: thunder_xcv, ver 1.0 Dec 13 13:25:57.915577 kernel: thunder_bgx, ver 1.0 Dec 13 13:25:57.915584 kernel: nicpf, ver 1.0 Dec 13 13:25:57.915591 kernel: nicvf, ver 1.0 Dec 13 13:25:57.915660 kernel: rtc-efi rtc-efi.0: registered as rtc0 Dec 13 13:25:57.915721 kernel: rtc-efi rtc-efi.0: setting system clock to 2024-12-13T13:25:57 UTC (1734096357) Dec 13 13:25:57.915731 kernel: hid: raw HID events driver (C) Jiri Kosina Dec 13 13:25:57.915738 kernel: hw perfevents: enabled with armv8_pmuv3_0 PMU driver, 7 counters available Dec 13 13:25:57.915747 kernel: watchdog: Delayed init of the lockup detector failed: -19 Dec 13 13:25:57.915754 kernel: watchdog: Hard watchdog permanently disabled Dec 13 13:25:57.915761 kernel: NET: Registered PF_INET6 protocol family Dec 13 13:25:57.915768 kernel: Segment Routing with IPv6 Dec 13 13:25:57.915775 kernel: In-situ OAM (IOAM) with IPv6 Dec 13 13:25:57.915782 kernel: NET: Registered PF_PACKET protocol family Dec 13 13:25:57.915801 kernel: Key type dns_resolver registered Dec 13 13:25:57.915809 kernel: registered taskstats version 1 Dec 13 13:25:57.915816 kernel: Loading compiled-in X.509 certificates Dec 13 13:25:57.915825 kernel: Loaded X.509 cert 'Kinvolk GmbH: Module signing key for 6.6.65-flatcar: 752b3e36c6039904ea643ccad2b3f5f3cb4ebf78' Dec 13 13:25:57.915832 kernel: Key type .fscrypt registered Dec 13 13:25:57.915839 kernel: Key type fscrypt-provisioning registered Dec 13 13:25:57.915846 kernel: ima: No TPM chip found, activating TPM-bypass! Dec 13 13:25:57.915853 kernel: ima: Allocated hash algorithm: sha1 Dec 13 13:25:57.915860 kernel: ima: No architecture policies found Dec 13 13:25:57.915867 kernel: alg: No test for fips(ansi_cprng) (fips_ansi_cprng) Dec 13 13:25:57.915873 kernel: clk: Disabling unused clocks Dec 13 13:25:57.915880 kernel: Freeing unused kernel memory: 39936K Dec 13 13:25:57.915889 kernel: Run /init as init process Dec 13 13:25:57.915896 kernel: with arguments: Dec 13 13:25:57.915902 kernel: /init Dec 13 13:25:57.915909 kernel: with environment: Dec 13 13:25:57.915916 kernel: HOME=/ Dec 13 13:25:57.915923 kernel: TERM=linux Dec 13 13:25:57.915929 kernel: BOOT_IMAGE=/flatcar/vmlinuz-a Dec 13 13:25:57.915938 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) Dec 13 13:25:57.915948 systemd[1]: Detected virtualization kvm. Dec 13 13:25:57.915956 systemd[1]: Detected architecture arm64. Dec 13 13:25:57.915963 systemd[1]: Running in initrd. Dec 13 13:25:57.915970 systemd[1]: No hostname configured, using default hostname. Dec 13 13:25:57.915978 systemd[1]: Hostname set to . Dec 13 13:25:57.915986 systemd[1]: Initializing machine ID from VM UUID. Dec 13 13:25:57.915993 systemd[1]: Queued start job for default target initrd.target. Dec 13 13:25:57.916001 systemd[1]: Started clevis-luks-askpass.path - Forward Password Requests to Clevis Directory Watch. Dec 13 13:25:57.916010 systemd[1]: Started systemd-ask-password-console.path - Dispatch Password Requests to Console Directory Watch. Dec 13 13:25:57.916018 systemd[1]: Expecting device dev-disk-by\x2dlabel-EFI\x2dSYSTEM.device - /dev/disk/by-label/EFI-SYSTEM... Dec 13 13:25:57.916025 systemd[1]: Expecting device dev-disk-by\x2dlabel-OEM.device - /dev/disk/by-label/OEM... Dec 13 13:25:57.916033 systemd[1]: Expecting device dev-disk-by\x2dlabel-ROOT.device - /dev/disk/by-label/ROOT... Dec 13 13:25:57.916041 systemd[1]: Expecting device dev-disk-by\x2dpartlabel-USR\x2dA.device - /dev/disk/by-partlabel/USR-A... Dec 13 13:25:57.916050 systemd[1]: Expecting device dev-disk-by\x2dpartuuid-7130c94a\x2d213a\x2d4e5a\x2d8e26\x2d6cce9662f132.device - /dev/disk/by-partuuid/7130c94a-213a-4e5a-8e26-6cce9662f132... Dec 13 13:25:57.916057 systemd[1]: Expecting device dev-mapper-usr.device - /dev/mapper/usr... Dec 13 13:25:57.916066 systemd[1]: Reached target cryptsetup-pre.target - Local Encrypted Volumes (Pre). Dec 13 13:25:57.916074 systemd[1]: Reached target cryptsetup.target - Local Encrypted Volumes. Dec 13 13:25:57.916081 systemd[1]: Reached target paths.target - Path Units. Dec 13 13:25:57.916089 systemd[1]: Reached target slices.target - Slice Units. Dec 13 13:25:57.916096 systemd[1]: Reached target swap.target - Swaps. Dec 13 13:25:57.916104 systemd[1]: Reached target timers.target - Timer Units. Dec 13 13:25:57.916111 systemd[1]: Listening on iscsid.socket - Open-iSCSI iscsid Socket. Dec 13 13:25:57.916119 systemd[1]: Listening on iscsiuio.socket - Open-iSCSI iscsiuio Socket. Dec 13 13:25:57.916128 systemd[1]: Listening on systemd-journald-dev-log.socket - Journal Socket (/dev/log). Dec 13 13:25:57.916135 systemd[1]: Listening on systemd-journald.socket - Journal Socket. Dec 13 13:25:57.916143 systemd[1]: Listening on systemd-networkd.socket - Network Service Netlink Socket. Dec 13 13:25:57.916151 systemd[1]: Listening on systemd-udevd-control.socket - udev Control Socket. Dec 13 13:25:57.916158 systemd[1]: Listening on systemd-udevd-kernel.socket - udev Kernel Socket. Dec 13 13:25:57.916166 systemd[1]: Reached target sockets.target - Socket Units. Dec 13 13:25:57.916173 systemd[1]: Starting ignition-setup-pre.service - Ignition env setup... Dec 13 13:25:57.916181 systemd[1]: Starting kmod-static-nodes.service - Create List of Static Device Nodes... Dec 13 13:25:57.916189 systemd[1]: Finished network-cleanup.service - Network Cleanup. Dec 13 13:25:57.916197 systemd[1]: Starting systemd-fsck-usr.service... Dec 13 13:25:57.916205 systemd[1]: Starting systemd-journald.service - Journal Service... Dec 13 13:25:57.916212 systemd[1]: Starting systemd-modules-load.service - Load Kernel Modules... Dec 13 13:25:57.916220 systemd[1]: Starting systemd-vconsole-setup.service - Virtual Console Setup... Dec 13 13:25:57.916227 systemd[1]: Finished ignition-setup-pre.service - Ignition env setup. Dec 13 13:25:57.916235 systemd[1]: Finished kmod-static-nodes.service - Create List of Static Device Nodes. Dec 13 13:25:57.916242 systemd[1]: Finished systemd-fsck-usr.service. Dec 13 13:25:57.916252 systemd[1]: Starting systemd-tmpfiles-setup-dev-early.service - Create Static Device Nodes in /dev gracefully... Dec 13 13:25:57.916275 systemd-journald[238]: Collecting audit messages is disabled. Dec 13 13:25:57.916302 systemd[1]: Finished systemd-vconsole-setup.service - Virtual Console Setup. Dec 13 13:25:57.916310 systemd[1]: Finished systemd-tmpfiles-setup-dev-early.service - Create Static Device Nodes in /dev gracefully. Dec 13 13:25:57.916319 systemd-journald[238]: Journal started Dec 13 13:25:57.916341 systemd-journald[238]: Runtime Journal (/run/log/journal/01b648ea6e5444df9cbbe1471c33961e) is 5.9M, max 47.3M, 41.4M free. Dec 13 13:25:57.908981 systemd-modules-load[240]: Inserted module 'overlay' Dec 13 13:25:57.918855 systemd[1]: Started systemd-journald.service - Journal Service. Dec 13 13:25:57.922996 kernel: bridge: filtering via arp/ip/ip6tables is no longer available by default. Update your scripts to load br_netfilter if you need this. Dec 13 13:25:57.923963 systemd-modules-load[240]: Inserted module 'br_netfilter' Dec 13 13:25:57.924818 kernel: Bridge firewalling registered Dec 13 13:25:57.930913 systemd[1]: Starting dracut-cmdline-ask.service - dracut ask for additional cmdline parameters... Dec 13 13:25:57.932541 systemd[1]: Starting systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev... Dec 13 13:25:57.934644 systemd[1]: Starting systemd-tmpfiles-setup.service - Create System Files and Directories... Dec 13 13:25:57.936416 systemd[1]: Finished systemd-modules-load.service - Load Kernel Modules. Dec 13 13:25:57.939305 systemd[1]: Starting systemd-sysctl.service - Apply Kernel Variables... Dec 13 13:25:57.943839 systemd[1]: Finished systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev. Dec 13 13:25:57.946936 systemd[1]: Finished systemd-tmpfiles-setup.service - Create System Files and Directories. Dec 13 13:25:57.952482 systemd[1]: Finished systemd-sysctl.service - Apply Kernel Variables. Dec 13 13:25:57.954578 systemd[1]: Finished dracut-cmdline-ask.service - dracut ask for additional cmdline parameters. Dec 13 13:25:57.963920 systemd[1]: Starting dracut-cmdline.service - dracut cmdline hook... Dec 13 13:25:57.966134 systemd[1]: Starting systemd-resolved.service - Network Name Resolution... Dec 13 13:25:57.974750 dracut-cmdline[277]: dracut-dracut-053 Dec 13 13:25:57.977848 dracut-cmdline[277]: 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=c48af8adabdaf1d8e07ceb011d2665929c607ddf2c4d40203b31334d745cc472 Dec 13 13:25:57.990487 systemd-resolved[279]: Positive Trust Anchors: Dec 13 13:25:57.990504 systemd-resolved[279]: . IN DS 20326 8 2 e06d44b80b8f1d39a95c0b0d7c65d08458e880409bbc683457104237c7f8ec8d Dec 13 13:25:57.990534 systemd-resolved[279]: 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 Dec 13 13:25:57.994993 systemd-resolved[279]: Defaulting to hostname 'linux'. Dec 13 13:25:57.997716 systemd[1]: Started systemd-resolved.service - Network Name Resolution. Dec 13 13:25:57.998841 systemd[1]: Reached target nss-lookup.target - Host and Network Name Lookups. Dec 13 13:25:58.041814 kernel: SCSI subsystem initialized Dec 13 13:25:58.045822 kernel: Loading iSCSI transport class v2.0-870. Dec 13 13:25:58.053826 kernel: iscsi: registered transport (tcp) Dec 13 13:25:58.065810 kernel: iscsi: registered transport (qla4xxx) Dec 13 13:25:58.065833 kernel: QLogic iSCSI HBA Driver Dec 13 13:25:58.104137 systemd[1]: Finished dracut-cmdline.service - dracut cmdline hook. Dec 13 13:25:58.111930 systemd[1]: Starting dracut-pre-udev.service - dracut pre-udev hook... Dec 13 13:25:58.127812 kernel: device-mapper: core: CONFIG_IMA_DISABLE_HTABLE is disabled. Duplicate IMA measurements will not be recorded in the IMA log. Dec 13 13:25:58.127850 kernel: device-mapper: uevent: version 1.0.3 Dec 13 13:25:58.134806 kernel: device-mapper: ioctl: 4.48.0-ioctl (2023-03-01) initialised: dm-devel@redhat.com Dec 13 13:25:58.175831 kernel: raid6: neonx8 gen() 15769 MB/s Dec 13 13:25:58.192822 kernel: raid6: neonx4 gen() 15783 MB/s Dec 13 13:25:58.209824 kernel: raid6: neonx2 gen() 13290 MB/s Dec 13 13:25:58.226819 kernel: raid6: neonx1 gen() 10510 MB/s Dec 13 13:25:58.243821 kernel: raid6: int64x8 gen() 6773 MB/s Dec 13 13:25:58.260824 kernel: raid6: int64x4 gen() 7333 MB/s Dec 13 13:25:58.277824 kernel: raid6: int64x2 gen() 6096 MB/s Dec 13 13:25:58.294871 kernel: raid6: int64x1 gen() 5052 MB/s Dec 13 13:25:58.294885 kernel: raid6: using algorithm neonx4 gen() 15783 MB/s Dec 13 13:25:58.312860 kernel: raid6: .... xor() 12423 MB/s, rmw enabled Dec 13 13:25:58.312890 kernel: raid6: using neon recovery algorithm Dec 13 13:25:58.317970 kernel: xor: measuring software checksum speed Dec 13 13:25:58.317983 kernel: 8regs : 21090 MB/sec Dec 13 13:25:58.319216 kernel: 32regs : 21676 MB/sec Dec 13 13:25:58.319231 kernel: arm64_neon : 27804 MB/sec Dec 13 13:25:58.319240 kernel: xor: using function: arm64_neon (27804 MB/sec) Dec 13 13:25:58.371822 kernel: Btrfs loaded, zoned=no, fsverity=no Dec 13 13:25:58.382179 systemd[1]: Finished dracut-pre-udev.service - dracut pre-udev hook. Dec 13 13:25:58.393928 systemd[1]: Starting systemd-udevd.service - Rule-based Manager for Device Events and Files... Dec 13 13:25:58.405055 systemd-udevd[463]: Using default interface naming scheme 'v255'. Dec 13 13:25:58.408131 systemd[1]: Started systemd-udevd.service - Rule-based Manager for Device Events and Files. Dec 13 13:25:58.410687 systemd[1]: Starting dracut-pre-trigger.service - dracut pre-trigger hook... Dec 13 13:25:58.424633 dracut-pre-trigger[465]: rd.md=0: removing MD RAID activation Dec 13 13:25:58.449866 systemd[1]: Finished dracut-pre-trigger.service - dracut pre-trigger hook. Dec 13 13:25:58.462919 systemd[1]: Starting systemd-udev-trigger.service - Coldplug All udev Devices... Dec 13 13:25:58.503093 systemd[1]: Finished systemd-udev-trigger.service - Coldplug All udev Devices. Dec 13 13:25:58.511943 systemd[1]: Starting dracut-initqueue.service - dracut initqueue hook... Dec 13 13:25:58.523492 systemd[1]: Finished dracut-initqueue.service - dracut initqueue hook. Dec 13 13:25:58.524970 systemd[1]: Reached target remote-fs-pre.target - Preparation for Remote File Systems. Dec 13 13:25:58.527900 systemd[1]: Reached target remote-cryptsetup.target - Remote Encrypted Volumes. Dec 13 13:25:58.530373 systemd[1]: Reached target remote-fs.target - Remote File Systems. Dec 13 13:25:58.539116 systemd[1]: Starting dracut-pre-mount.service - dracut pre-mount hook... Dec 13 13:25:58.550075 systemd[1]: Finished dracut-pre-mount.service - dracut pre-mount hook. Dec 13 13:25:58.560403 kernel: virtio_blk virtio1: 1/0/0 default/read/poll queues Dec 13 13:25:58.563898 kernel: virtio_blk virtio1: [vda] 9289728 512-byte logical blocks (4.76 GB/4.43 GiB) Dec 13 13:25:58.563993 kernel: vda: vda1 vda2 vda3 vda4 vda6 vda7 vda9 Dec 13 13:25:58.565150 systemd[1]: dracut-cmdline-ask.service: Deactivated successfully. Dec 13 13:25:58.565255 systemd[1]: Stopped dracut-cmdline-ask.service - dracut ask for additional cmdline parameters. Dec 13 13:25:58.568190 systemd[1]: Stopping dracut-cmdline-ask.service - dracut ask for additional cmdline parameters... Dec 13 13:25:58.571043 systemd[1]: systemd-vconsole-setup.service: Deactivated successfully. Dec 13 13:25:58.571228 systemd[1]: Stopped systemd-vconsole-setup.service - Virtual Console Setup. Dec 13 13:25:58.573546 systemd[1]: Stopping systemd-vconsole-setup.service - Virtual Console Setup... Dec 13 13:25:58.582001 systemd[1]: Starting systemd-vconsole-setup.service - Virtual Console Setup... Dec 13 13:25:58.591134 kernel: BTRFS: device label OEM devid 1 transid 14 /dev/vda6 scanned by (udev-worker) (521) Dec 13 13:25:58.591174 kernel: BTRFS: device fsid 47b12626-f7d3-4179-9720-ca262eb4c614 devid 1 transid 38 /dev/vda3 scanned by (udev-worker) (509) Dec 13 13:25:58.596637 systemd[1]: Finished systemd-vconsole-setup.service - Virtual Console Setup. Dec 13 13:25:58.602429 systemd[1]: Found device dev-disk-by\x2dlabel-EFI\x2dSYSTEM.device - /dev/disk/by-label/EFI-SYSTEM. Dec 13 13:25:58.606804 systemd[1]: Found device dev-disk-by\x2dlabel-ROOT.device - /dev/disk/by-label/ROOT. Dec 13 13:25:58.613718 systemd[1]: Found device dev-disk-by\x2dlabel-OEM.device - /dev/disk/by-label/OEM. Dec 13 13:25:58.617384 systemd[1]: Found device dev-disk-by\x2dpartlabel-USR\x2dA.device - /dev/disk/by-partlabel/USR-A. Dec 13 13:25:58.618556 systemd[1]: Found device dev-disk-by\x2dpartuuid-7130c94a\x2d213a\x2d4e5a\x2d8e26\x2d6cce9662f132.device - /dev/disk/by-partuuid/7130c94a-213a-4e5a-8e26-6cce9662f132. Dec 13 13:25:58.631958 systemd[1]: Starting disk-uuid.service - Generate new UUID for disk GPT if necessary... Dec 13 13:25:58.633663 systemd[1]: Starting dracut-cmdline-ask.service - dracut ask for additional cmdline parameters... Dec 13 13:25:58.641741 kernel: vda: vda1 vda2 vda3 vda4 vda6 vda7 vda9 Dec 13 13:25:58.656763 systemd[1]: Finished dracut-cmdline-ask.service - dracut ask for additional cmdline parameters. Dec 13 13:25:59.656834 kernel: vda: vda1 vda2 vda3 vda4 vda6 vda7 vda9 Dec 13 13:25:59.657252 disk-uuid[553]: The operation has completed successfully. Dec 13 13:25:59.681311 systemd[1]: disk-uuid.service: Deactivated successfully. Dec 13 13:25:59.681425 systemd[1]: Finished disk-uuid.service - Generate new UUID for disk GPT if necessary. Dec 13 13:25:59.702945 systemd[1]: Starting verity-setup.service - Verity Setup for /dev/mapper/usr... Dec 13 13:25:59.706817 sh[572]: Success Dec 13 13:25:59.721821 kernel: device-mapper: verity: sha256 using implementation "sha256-ce" Dec 13 13:25:59.754136 systemd[1]: Found device dev-mapper-usr.device - /dev/mapper/usr. Dec 13 13:25:59.755837 systemd[1]: Finished verity-setup.service - Verity Setup for /dev/mapper/usr. Dec 13 13:25:59.757782 systemd[1]: Mounting sysusr-usr.mount - /sysusr/usr... Dec 13 13:25:59.769477 kernel: BTRFS info (device dm-0): first mount of filesystem 47b12626-f7d3-4179-9720-ca262eb4c614 Dec 13 13:25:59.769531 kernel: BTRFS info (device dm-0): using crc32c (crc32c-generic) checksum algorithm Dec 13 13:25:59.769551 kernel: BTRFS warning (device dm-0): 'nologreplay' is deprecated, use 'rescue=nologreplay' instead Dec 13 13:25:59.771343 kernel: BTRFS info (device dm-0): disabling log replay at mount time Dec 13 13:25:59.772038 kernel: BTRFS info (device dm-0): using free space tree Dec 13 13:25:59.775408 systemd[1]: Mounted sysusr-usr.mount - /sysusr/usr. Dec 13 13:25:59.776711 systemd[1]: afterburn-network-kargs.service - Afterburn Initrd Setup Network Kernel Arguments was skipped because no trigger condition checks were met. Dec 13 13:25:59.786934 systemd[1]: Starting ignition-setup.service - Ignition (setup)... Dec 13 13:25:59.788460 systemd[1]: Starting parse-ip-for-networkd.service - Write systemd-networkd units from cmdline... Dec 13 13:25:59.798495 kernel: BTRFS info (device vda6): first mount of filesystem d0a3d620-8ab2-45d8-a26c-bb488ffd59f2 Dec 13 13:25:59.798542 kernel: BTRFS info (device vda6): using crc32c (crc32c-generic) checksum algorithm Dec 13 13:25:59.799447 kernel: BTRFS info (device vda6): using free space tree Dec 13 13:25:59.801905 kernel: BTRFS info (device vda6): auto enabling async discard Dec 13 13:25:59.808927 systemd[1]: mnt-oem.mount: Deactivated successfully. Dec 13 13:25:59.810825 kernel: BTRFS info (device vda6): last unmount of filesystem d0a3d620-8ab2-45d8-a26c-bb488ffd59f2 Dec 13 13:25:59.815607 systemd[1]: Finished ignition-setup.service - Ignition (setup). Dec 13 13:25:59.820999 systemd[1]: Starting ignition-fetch-offline.service - Ignition (fetch-offline)... Dec 13 13:25:59.880842 systemd[1]: Finished parse-ip-for-networkd.service - Write systemd-networkd units from cmdline. Dec 13 13:25:59.889958 systemd[1]: Starting systemd-networkd.service - Network Configuration... Dec 13 13:25:59.909067 systemd-networkd[765]: lo: Link UP Dec 13 13:25:59.909079 systemd-networkd[765]: lo: Gained carrier Dec 13 13:25:59.909970 systemd-networkd[765]: Enumeration completed Dec 13 13:25:59.910051 systemd[1]: Started systemd-networkd.service - Network Configuration. Dec 13 13:25:59.910438 systemd-networkd[765]: eth0: found matching network '/usr/lib/systemd/network/zz-default.network', based on potentially unpredictable interface name. Dec 13 13:25:59.910441 systemd-networkd[765]: eth0: Configuring with /usr/lib/systemd/network/zz-default.network. Dec 13 13:25:59.911216 systemd-networkd[765]: eth0: Link UP Dec 13 13:25:59.911219 systemd-networkd[765]: eth0: Gained carrier Dec 13 13:25:59.911226 systemd-networkd[765]: eth0: found matching network '/usr/lib/systemd/network/zz-default.network', based on potentially unpredictable interface name. Dec 13 13:25:59.920368 ignition[669]: Ignition 2.20.0 Dec 13 13:25:59.912292 systemd[1]: Reached target network.target - Network. Dec 13 13:25:59.920374 ignition[669]: Stage: fetch-offline Dec 13 13:25:59.920414 ignition[669]: no configs at "/usr/lib/ignition/base.d" Dec 13 13:25:59.920423 ignition[669]: no config dir at "/usr/lib/ignition/base.platform.d/qemu" Dec 13 13:25:59.920596 ignition[669]: parsed url from cmdline: "" Dec 13 13:25:59.920600 ignition[669]: no config URL provided Dec 13 13:25:59.920604 ignition[669]: reading system config file "/usr/lib/ignition/user.ign" Dec 13 13:25:59.920611 ignition[669]: no config at "/usr/lib/ignition/user.ign" Dec 13 13:25:59.920636 ignition[669]: op(1): [started] loading QEMU firmware config module Dec 13 13:25:59.920640 ignition[669]: op(1): executing: "modprobe" "qemu_fw_cfg" Dec 13 13:25:59.930867 systemd-networkd[765]: eth0: DHCPv4 address 10.0.0.120/16, gateway 10.0.0.1 acquired from 10.0.0.1 Dec 13 13:25:59.927337 ignition[669]: op(1): [finished] loading QEMU firmware config module Dec 13 13:25:59.927355 ignition[669]: QEMU firmware config was not found. Ignoring... Dec 13 13:25:59.935194 ignition[669]: parsing config with SHA512: 5d11bbccc35c12f0eaed513113b349febe33f9a0b1d82ece5b5ffbd40be935411da3bd8fa5012c6e6a0f08cbee45b1929600210fb581ac9f6e6f753390c706d4 Dec 13 13:25:59.942403 unknown[669]: fetched base config from "system" Dec 13 13:25:59.942412 unknown[669]: fetched user config from "qemu" Dec 13 13:25:59.942600 ignition[669]: fetch-offline: fetch-offline passed Dec 13 13:25:59.944688 systemd[1]: Finished ignition-fetch-offline.service - Ignition (fetch-offline). Dec 13 13:25:59.942775 ignition[669]: Ignition finished successfully Dec 13 13:25:59.946068 systemd[1]: ignition-fetch.service - Ignition (fetch) was skipped because of an unmet condition check (ConditionPathExists=!/run/ignition.json). Dec 13 13:25:59.952950 systemd[1]: Starting ignition-kargs.service - Ignition (kargs)... Dec 13 13:25:59.962987 ignition[772]: Ignition 2.20.0 Dec 13 13:25:59.962997 ignition[772]: Stage: kargs Dec 13 13:25:59.963140 ignition[772]: no configs at "/usr/lib/ignition/base.d" Dec 13 13:25:59.963155 ignition[772]: no config dir at "/usr/lib/ignition/base.platform.d/qemu" Dec 13 13:25:59.965607 systemd[1]: Finished ignition-kargs.service - Ignition (kargs). Dec 13 13:25:59.963712 ignition[772]: kargs: kargs passed Dec 13 13:25:59.963753 ignition[772]: Ignition finished successfully Dec 13 13:25:59.967966 systemd[1]: Starting ignition-disks.service - Ignition (disks)... Dec 13 13:25:59.980185 ignition[781]: Ignition 2.20.0 Dec 13 13:25:59.980198 ignition[781]: Stage: disks Dec 13 13:25:59.980356 ignition[781]: no configs at "/usr/lib/ignition/base.d" Dec 13 13:25:59.983005 systemd[1]: Finished ignition-disks.service - Ignition (disks). Dec 13 13:25:59.980366 ignition[781]: no config dir at "/usr/lib/ignition/base.platform.d/qemu" Dec 13 13:25:59.984189 systemd[1]: Reached target initrd-root-device.target - Initrd Root Device. Dec 13 13:25:59.980932 ignition[781]: disks: disks passed Dec 13 13:25:59.985921 systemd[1]: Reached target local-fs-pre.target - Preparation for Local File Systems. Dec 13 13:25:59.980971 ignition[781]: Ignition finished successfully Dec 13 13:25:59.987937 systemd[1]: Reached target local-fs.target - Local File Systems. Dec 13 13:25:59.989699 systemd[1]: Reached target sysinit.target - System Initialization. Dec 13 13:25:59.991139 systemd[1]: Reached target basic.target - Basic System. Dec 13 13:25:59.999930 systemd[1]: Starting systemd-fsck-root.service - File System Check on /dev/disk/by-label/ROOT... Dec 13 13:26:00.010581 systemd-fsck[793]: ROOT: clean, 14/553520 files, 52654/553472 blocks Dec 13 13:26:00.014589 systemd[1]: Finished systemd-fsck-root.service - File System Check on /dev/disk/by-label/ROOT. Dec 13 13:26:00.017102 systemd[1]: Mounting sysroot.mount - /sysroot... Dec 13 13:26:00.062813 kernel: EXT4-fs (vda9): mounted filesystem 0aa4851d-a2ba-4d04-90b3-5d00bf608ecc r/w with ordered data mode. Quota mode: none. Dec 13 13:26:00.062840 systemd[1]: Mounted sysroot.mount - /sysroot. Dec 13 13:26:00.064066 systemd[1]: Reached target initrd-root-fs.target - Initrd Root File System. Dec 13 13:26:00.074869 systemd[1]: Mounting sysroot-oem.mount - /sysroot/oem... Dec 13 13:26:00.076448 systemd[1]: Mounting sysroot-usr.mount - /sysroot/usr... Dec 13 13:26:00.077861 systemd[1]: flatcar-metadata-hostname.service - Flatcar Metadata Hostname Agent was skipped because no trigger condition checks were met. Dec 13 13:26:00.077897 systemd[1]: ignition-remount-sysroot.service - Remount /sysroot read-write for Ignition was skipped because of an unmet condition check (ConditionPathIsReadWrite=!/sysroot). Dec 13 13:26:00.088042 kernel: BTRFS: device label OEM devid 1 transid 15 /dev/vda6 scanned by mount (801) Dec 13 13:26:00.088063 kernel: BTRFS info (device vda6): first mount of filesystem d0a3d620-8ab2-45d8-a26c-bb488ffd59f2 Dec 13 13:26:00.088073 kernel: BTRFS info (device vda6): using crc32c (crc32c-generic) checksum algorithm Dec 13 13:26:00.088083 kernel: BTRFS info (device vda6): using free space tree Dec 13 13:26:00.077919 systemd[1]: Reached target ignition-diskful.target - Ignition Boot Disk Setup. Dec 13 13:26:00.082320 systemd[1]: Mounted sysroot-usr.mount - /sysroot/usr. Dec 13 13:26:00.084328 systemd[1]: Starting initrd-setup-root.service - Root filesystem setup... Dec 13 13:26:00.093287 kernel: BTRFS info (device vda6): auto enabling async discard Dec 13 13:26:00.093593 systemd[1]: Mounted sysroot-oem.mount - /sysroot/oem. Dec 13 13:26:00.126895 initrd-setup-root[825]: cut: /sysroot/etc/passwd: No such file or directory Dec 13 13:26:00.130212 initrd-setup-root[832]: cut: /sysroot/etc/group: No such file or directory Dec 13 13:26:00.134437 initrd-setup-root[839]: cut: /sysroot/etc/shadow: No such file or directory Dec 13 13:26:00.138341 initrd-setup-root[846]: cut: /sysroot/etc/gshadow: No such file or directory Dec 13 13:26:00.207806 systemd[1]: Finished initrd-setup-root.service - Root filesystem setup. Dec 13 13:26:00.218902 systemd[1]: Starting ignition-mount.service - Ignition (mount)... Dec 13 13:26:00.221112 systemd[1]: Starting sysroot-boot.service - /sysroot/boot... Dec 13 13:26:00.225811 kernel: BTRFS info (device vda6): last unmount of filesystem d0a3d620-8ab2-45d8-a26c-bb488ffd59f2 Dec 13 13:26:00.241584 systemd[1]: Finished sysroot-boot.service - /sysroot/boot. Dec 13 13:26:00.243442 ignition[914]: INFO : Ignition 2.20.0 Dec 13 13:26:00.243442 ignition[914]: INFO : Stage: mount Dec 13 13:26:00.244999 ignition[914]: INFO : no configs at "/usr/lib/ignition/base.d" Dec 13 13:26:00.244999 ignition[914]: INFO : no config dir at "/usr/lib/ignition/base.platform.d/qemu" Dec 13 13:26:00.244999 ignition[914]: INFO : mount: mount passed Dec 13 13:26:00.244999 ignition[914]: INFO : Ignition finished successfully Dec 13 13:26:00.245462 systemd[1]: Finished ignition-mount.service - Ignition (mount). Dec 13 13:26:00.252899 systemd[1]: Starting ignition-files.service - Ignition (files)... Dec 13 13:26:00.768327 systemd[1]: sysroot-oem.mount: Deactivated successfully. Dec 13 13:26:00.778064 systemd[1]: Mounting sysroot-oem.mount - /sysroot/oem... Dec 13 13:26:00.784809 kernel: BTRFS: device label OEM devid 1 transid 16 /dev/vda6 scanned by mount (927) Dec 13 13:26:00.784843 kernel: BTRFS info (device vda6): first mount of filesystem d0a3d620-8ab2-45d8-a26c-bb488ffd59f2 Dec 13 13:26:00.784854 kernel: BTRFS info (device vda6): using crc32c (crc32c-generic) checksum algorithm Dec 13 13:26:00.786355 kernel: BTRFS info (device vda6): using free space tree Dec 13 13:26:00.788832 kernel: BTRFS info (device vda6): auto enabling async discard Dec 13 13:26:00.789563 systemd[1]: Mounted sysroot-oem.mount - /sysroot/oem. Dec 13 13:26:00.804866 ignition[944]: INFO : Ignition 2.20.0 Dec 13 13:26:00.804866 ignition[944]: INFO : Stage: files Dec 13 13:26:00.806573 ignition[944]: INFO : no configs at "/usr/lib/ignition/base.d" Dec 13 13:26:00.806573 ignition[944]: INFO : no config dir at "/usr/lib/ignition/base.platform.d/qemu" Dec 13 13:26:00.806573 ignition[944]: DEBUG : files: compiled without relabeling support, skipping Dec 13 13:26:00.806573 ignition[944]: INFO : files: ensureUsers: op(1): [started] creating or modifying user "core" Dec 13 13:26:00.806573 ignition[944]: DEBUG : files: ensureUsers: op(1): executing: "usermod" "--root" "/sysroot" "core" Dec 13 13:26:00.813139 ignition[944]: INFO : files: ensureUsers: op(1): [finished] creating or modifying user "core" Dec 13 13:26:00.813139 ignition[944]: INFO : files: ensureUsers: op(2): [started] adding ssh keys to user "core" Dec 13 13:26:00.813139 ignition[944]: INFO : files: ensureUsers: op(2): [finished] adding ssh keys to user "core" Dec 13 13:26:00.813139 ignition[944]: INFO : files: createFilesystemsFiles: createFiles: op(3): [started] writing file "/sysroot/etc/flatcar/update.conf" Dec 13 13:26:00.813139 ignition[944]: INFO : files: createFilesystemsFiles: createFiles: op(3): [finished] writing file "/sysroot/etc/flatcar/update.conf" Dec 13 13:26:00.813139 ignition[944]: INFO : files: op(4): [started] processing unit "etcd-member.service" Dec 13 13:26:00.813139 ignition[944]: INFO : files: op(4): op(5): [started] writing systemd drop-in "20-clct-etcd-member.conf" at "/sysroot/etc/systemd/system/etcd-member.service.d/20-clct-etcd-member.conf" Dec 13 13:26:00.813139 ignition[944]: INFO : files: op(4): op(5): [finished] writing systemd drop-in "20-clct-etcd-member.conf" at "/sysroot/etc/systemd/system/etcd-member.service.d/20-clct-etcd-member.conf" Dec 13 13:26:00.813139 ignition[944]: INFO : files: op(4): [finished] processing unit "etcd-member.service" Dec 13 13:26:00.813139 ignition[944]: INFO : files: op(6): [started] processing unit "coreos-metadata.service" Dec 13 13:26:00.813139 ignition[944]: INFO : files: op(6): op(7): [started] writing unit "coreos-metadata.service" at "/sysroot/etc/systemd/system/coreos-metadata.service" Dec 13 13:26:00.813139 ignition[944]: INFO : files: op(6): op(7): [finished] writing unit "coreos-metadata.service" at "/sysroot/etc/systemd/system/coreos-metadata.service" Dec 13 13:26:00.813139 ignition[944]: INFO : files: op(6): [finished] processing unit "coreos-metadata.service" Dec 13 13:26:00.813139 ignition[944]: INFO : files: op(8): [started] setting preset to disabled for "coreos-metadata.service" Dec 13 13:26:00.809452 unknown[944]: wrote ssh authorized keys file for user: core Dec 13 13:26:00.837825 ignition[944]: INFO : files: op(8): op(9): [started] removing enablement symlink(s) for "coreos-metadata.service" Dec 13 13:26:00.839484 ignition[944]: INFO : files: op(8): op(9): [finished] removing enablement symlink(s) for "coreos-metadata.service" Dec 13 13:26:00.840943 ignition[944]: INFO : files: op(8): [finished] setting preset to disabled for "coreos-metadata.service" Dec 13 13:26:00.840943 ignition[944]: INFO : files: op(a): [started] setting preset to enabled for "etcd-member.service" Dec 13 13:26:00.840943 ignition[944]: INFO : files: op(a): [finished] setting preset to enabled for "etcd-member.service" Dec 13 13:26:00.840943 ignition[944]: INFO : files: createResultFile: createFiles: op(b): [started] writing file "/sysroot/etc/.ignition-result.json" Dec 13 13:26:00.840943 ignition[944]: INFO : files: createResultFile: createFiles: op(b): [finished] writing file "/sysroot/etc/.ignition-result.json" Dec 13 13:26:00.840943 ignition[944]: INFO : files: files passed Dec 13 13:26:00.840943 ignition[944]: INFO : Ignition finished successfully Dec 13 13:26:00.842889 systemd[1]: Finished ignition-files.service - Ignition (files). Dec 13 13:26:00.852940 systemd[1]: Starting ignition-quench.service - Ignition (record completion)... Dec 13 13:26:00.854652 systemd[1]: Starting initrd-setup-root-after-ignition.service - Root filesystem completion... Dec 13 13:26:00.856743 systemd[1]: ignition-quench.service: Deactivated successfully. Dec 13 13:26:00.858030 systemd[1]: Finished ignition-quench.service - Ignition (record completion). Dec 13 13:26:00.862331 initrd-setup-root-after-ignition[973]: grep: /sysroot/oem/oem-release: No such file or directory Dec 13 13:26:00.865947 initrd-setup-root-after-ignition[975]: grep: /sysroot/etc/flatcar/enabled-sysext.conf: No such file or directory Dec 13 13:26:00.865947 initrd-setup-root-after-ignition[975]: grep: /sysroot/usr/share/flatcar/enabled-sysext.conf: No such file or directory Dec 13 13:26:00.869509 initrd-setup-root-after-ignition[979]: grep: /sysroot/etc/flatcar/enabled-sysext.conf: No such file or directory Dec 13 13:26:00.872067 systemd[1]: Finished initrd-setup-root-after-ignition.service - Root filesystem completion. Dec 13 13:26:00.873408 systemd[1]: Reached target ignition-complete.target - Ignition Complete. Dec 13 13:26:00.881997 systemd[1]: Starting initrd-parse-etc.service - Mountpoints Configured in the Real Root... Dec 13 13:26:00.899121 systemd[1]: initrd-parse-etc.service: Deactivated successfully. Dec 13 13:26:00.899216 systemd[1]: Finished initrd-parse-etc.service - Mountpoints Configured in the Real Root. Dec 13 13:26:00.901356 systemd[1]: Reached target initrd-fs.target - Initrd File Systems. Dec 13 13:26:00.903140 systemd[1]: Reached target initrd.target - Initrd Default Target. Dec 13 13:26:00.904844 systemd[1]: dracut-mount.service - dracut mount hook was skipped because no trigger condition checks were met. Dec 13 13:26:00.905542 systemd[1]: Starting dracut-pre-pivot.service - dracut pre-pivot and cleanup hook... Dec 13 13:26:00.920870 systemd[1]: Finished dracut-pre-pivot.service - dracut pre-pivot and cleanup hook. Dec 13 13:26:00.929914 systemd[1]: Starting initrd-cleanup.service - Cleaning Up and Shutting Down Daemons... Dec 13 13:26:00.937115 systemd[1]: Stopped target nss-lookup.target - Host and Network Name Lookups. Dec 13 13:26:00.938371 systemd[1]: Stopped target remote-cryptsetup.target - Remote Encrypted Volumes. Dec 13 13:26:00.940369 systemd[1]: Stopped target timers.target - Timer Units. Dec 13 13:26:00.942106 systemd[1]: dracut-pre-pivot.service: Deactivated successfully. Dec 13 13:26:00.942213 systemd[1]: Stopped dracut-pre-pivot.service - dracut pre-pivot and cleanup hook. Dec 13 13:26:00.944719 systemd[1]: Stopped target initrd.target - Initrd Default Target. Dec 13 13:26:00.946623 systemd[1]: Stopped target basic.target - Basic System. Dec 13 13:26:00.948139 systemd[1]: Stopped target ignition-complete.target - Ignition Complete. Dec 13 13:26:00.949734 systemd[1]: Stopped target ignition-diskful.target - Ignition Boot Disk Setup. Dec 13 13:26:00.951680 systemd[1]: Stopped target initrd-root-device.target - Initrd Root Device. Dec 13 13:26:00.953672 systemd[1]: Stopped target remote-fs.target - Remote File Systems. Dec 13 13:26:00.955302 systemd[1]: Stopped target remote-fs-pre.target - Preparation for Remote File Systems. Dec 13 13:26:00.957320 systemd[1]: Stopped target sysinit.target - System Initialization. Dec 13 13:26:00.959234 systemd[1]: Stopped target local-fs.target - Local File Systems. Dec 13 13:26:00.960850 systemd[1]: Stopped target swap.target - Swaps. Dec 13 13:26:00.962350 systemd[1]: dracut-pre-mount.service: Deactivated successfully. Dec 13 13:26:00.962460 systemd[1]: Stopped dracut-pre-mount.service - dracut pre-mount hook. Dec 13 13:26:00.964698 systemd[1]: Stopped target cryptsetup.target - Local Encrypted Volumes. Dec 13 13:26:00.966659 systemd[1]: Stopped target cryptsetup-pre.target - Local Encrypted Volumes (Pre). Dec 13 13:26:00.968574 systemd[1]: clevis-luks-askpass.path: Deactivated successfully. Dec 13 13:26:00.970512 systemd[1]: Stopped clevis-luks-askpass.path - Forward Password Requests to Clevis Directory Watch. Dec 13 13:26:00.971785 systemd[1]: dracut-initqueue.service: Deactivated successfully. Dec 13 13:26:00.971906 systemd[1]: Stopped dracut-initqueue.service - dracut initqueue hook. Dec 13 13:26:00.974633 systemd[1]: ignition-fetch-offline.service: Deactivated successfully. Dec 13 13:26:00.974742 systemd[1]: Stopped ignition-fetch-offline.service - Ignition (fetch-offline). Dec 13 13:26:00.976878 systemd[1]: Stopped target paths.target - Path Units. Dec 13 13:26:00.978502 systemd[1]: systemd-ask-password-console.path: Deactivated successfully. Dec 13 13:26:00.982837 systemd[1]: Stopped systemd-ask-password-console.path - Dispatch Password Requests to Console Directory Watch. Dec 13 13:26:00.984106 systemd[1]: Stopped target slices.target - Slice Units. Dec 13 13:26:00.986099 systemd[1]: Stopped target sockets.target - Socket Units. Dec 13 13:26:00.987619 systemd[1]: iscsid.socket: Deactivated successfully. Dec 13 13:26:00.987705 systemd[1]: Closed iscsid.socket - Open-iSCSI iscsid Socket. Dec 13 13:26:00.989226 systemd[1]: iscsiuio.socket: Deactivated successfully. Dec 13 13:26:00.989314 systemd[1]: Closed iscsiuio.socket - Open-iSCSI iscsiuio Socket. Dec 13 13:26:00.990835 systemd[1]: initrd-setup-root-after-ignition.service: Deactivated successfully. Dec 13 13:26:00.990941 systemd[1]: Stopped initrd-setup-root-after-ignition.service - Root filesystem completion. Dec 13 13:26:00.992721 systemd[1]: ignition-files.service: Deactivated successfully. Dec 13 13:26:00.992835 systemd[1]: Stopped ignition-files.service - Ignition (files). Dec 13 13:26:01.008009 systemd[1]: Stopping ignition-mount.service - Ignition (mount)... Dec 13 13:26:01.009742 systemd[1]: kmod-static-nodes.service: Deactivated successfully. Dec 13 13:26:01.009902 systemd[1]: Stopped kmod-static-nodes.service - Create List of Static Device Nodes. Dec 13 13:26:01.012601 systemd[1]: Stopping sysroot-boot.service - /sysroot/boot... Dec 13 13:26:01.013601 systemd[1]: systemd-udev-trigger.service: Deactivated successfully. Dec 13 13:26:01.013741 systemd[1]: Stopped systemd-udev-trigger.service - Coldplug All udev Devices. Dec 13 13:26:01.015618 systemd[1]: dracut-pre-trigger.service: Deactivated successfully. Dec 13 13:26:01.015710 systemd[1]: Stopped dracut-pre-trigger.service - dracut pre-trigger hook. Dec 13 13:26:01.020595 ignition[999]: INFO : Ignition 2.20.0 Dec 13 13:26:01.020595 ignition[999]: INFO : Stage: umount Dec 13 13:26:01.022183 ignition[999]: INFO : no configs at "/usr/lib/ignition/base.d" Dec 13 13:26:01.022183 ignition[999]: INFO : no config dir at "/usr/lib/ignition/base.platform.d/qemu" Dec 13 13:26:01.022183 ignition[999]: INFO : umount: umount passed Dec 13 13:26:01.022183 ignition[999]: INFO : Ignition finished successfully Dec 13 13:26:01.022468 systemd[1]: initrd-cleanup.service: Deactivated successfully. Dec 13 13:26:01.022553 systemd[1]: Finished initrd-cleanup.service - Cleaning Up and Shutting Down Daemons. Dec 13 13:26:01.024637 systemd[1]: ignition-mount.service: Deactivated successfully. Dec 13 13:26:01.024707 systemd[1]: Stopped ignition-mount.service - Ignition (mount). Dec 13 13:26:01.028991 systemd[1]: sysroot-boot.mount: Deactivated successfully. Dec 13 13:26:01.030940 systemd[1]: sysroot-boot.service: Deactivated successfully. Dec 13 13:26:01.031020 systemd[1]: Stopped sysroot-boot.service - /sysroot/boot. Dec 13 13:26:01.033252 systemd[1]: Stopped target network.target - Network. Dec 13 13:26:01.034316 systemd[1]: ignition-disks.service: Deactivated successfully. Dec 13 13:26:01.034390 systemd[1]: Stopped ignition-disks.service - Ignition (disks). Dec 13 13:26:01.035985 systemd[1]: ignition-kargs.service: Deactivated successfully. Dec 13 13:26:01.036029 systemd[1]: Stopped ignition-kargs.service - Ignition (kargs). Dec 13 13:26:01.037589 systemd[1]: ignition-setup.service: Deactivated successfully. Dec 13 13:26:01.037632 systemd[1]: Stopped ignition-setup.service - Ignition (setup). Dec 13 13:26:01.039129 systemd[1]: ignition-setup-pre.service: Deactivated successfully. Dec 13 13:26:01.039172 systemd[1]: Stopped ignition-setup-pre.service - Ignition env setup. Dec 13 13:26:01.040826 systemd[1]: initrd-setup-root.service: Deactivated successfully. Dec 13 13:26:01.040871 systemd[1]: Stopped initrd-setup-root.service - Root filesystem setup. Dec 13 13:26:01.042749 systemd[1]: Stopping systemd-networkd.service - Network Configuration... Dec 13 13:26:01.044433 systemd[1]: Stopping systemd-resolved.service - Network Name Resolution... Dec 13 13:26:01.050825 systemd-networkd[765]: eth0: DHCPv6 lease lost Dec 13 13:26:01.052088 systemd[1]: systemd-networkd.service: Deactivated successfully. Dec 13 13:26:01.052192 systemd[1]: Stopped systemd-networkd.service - Network Configuration. Dec 13 13:26:01.053897 systemd[1]: systemd-networkd.socket: Deactivated successfully. Dec 13 13:26:01.053928 systemd[1]: Closed systemd-networkd.socket - Network Service Netlink Socket. Dec 13 13:26:01.060920 systemd[1]: Stopping network-cleanup.service - Network Cleanup... Dec 13 13:26:01.062656 systemd[1]: parse-ip-for-networkd.service: Deactivated successfully. Dec 13 13:26:01.062718 systemd[1]: Stopped parse-ip-for-networkd.service - Write systemd-networkd units from cmdline. Dec 13 13:26:01.064968 systemd[1]: Stopping systemd-udevd.service - Rule-based Manager for Device Events and Files... Dec 13 13:26:01.066350 systemd[1]: systemd-resolved.service: Deactivated successfully. Dec 13 13:26:01.066439 systemd[1]: Stopped systemd-resolved.service - Network Name Resolution. Dec 13 13:26:01.070910 systemd[1]: systemd-sysctl.service: Deactivated successfully. Dec 13 13:26:01.070968 systemd[1]: Stopped systemd-sysctl.service - Apply Kernel Variables. Dec 13 13:26:01.072058 systemd[1]: systemd-modules-load.service: Deactivated successfully. Dec 13 13:26:01.072110 systemd[1]: Stopped systemd-modules-load.service - Load Kernel Modules. Dec 13 13:26:01.073888 systemd[1]: systemd-tmpfiles-setup.service: Deactivated successfully. Dec 13 13:26:01.073933 systemd[1]: Stopped systemd-tmpfiles-setup.service - Create System Files and Directories. Dec 13 13:26:01.077033 systemd[1]: network-cleanup.service: Deactivated successfully. Dec 13 13:26:01.077136 systemd[1]: Stopped network-cleanup.service - Network Cleanup. Dec 13 13:26:01.081011 systemd[1]: systemd-udevd.service: Deactivated successfully. Dec 13 13:26:01.081139 systemd[1]: Stopped systemd-udevd.service - Rule-based Manager for Device Events and Files. Dec 13 13:26:01.083502 systemd[1]: systemd-udevd-control.socket: Deactivated successfully. Dec 13 13:26:01.083560 systemd[1]: Closed systemd-udevd-control.socket - udev Control Socket. Dec 13 13:26:01.084800 systemd[1]: systemd-udevd-kernel.socket: Deactivated successfully. Dec 13 13:26:01.084835 systemd[1]: Closed systemd-udevd-kernel.socket - udev Kernel Socket. Dec 13 13:26:01.086586 systemd[1]: dracut-pre-udev.service: Deactivated successfully. Dec 13 13:26:01.086630 systemd[1]: Stopped dracut-pre-udev.service - dracut pre-udev hook. Dec 13 13:26:01.089456 systemd[1]: dracut-cmdline.service: Deactivated successfully. Dec 13 13:26:01.089498 systemd[1]: Stopped dracut-cmdline.service - dracut cmdline hook. Dec 13 13:26:01.092654 systemd[1]: dracut-cmdline-ask.service: Deactivated successfully. Dec 13 13:26:01.092699 systemd[1]: Stopped dracut-cmdline-ask.service - dracut ask for additional cmdline parameters. Dec 13 13:26:01.102972 systemd[1]: Starting initrd-udevadm-cleanup-db.service - Cleanup udev Database... Dec 13 13:26:01.103990 systemd[1]: systemd-tmpfiles-setup-dev.service: Deactivated successfully. Dec 13 13:26:01.104045 systemd[1]: Stopped systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev. Dec 13 13:26:01.106108 systemd[1]: systemd-vconsole-setup.service: Deactivated successfully. Dec 13 13:26:01.106152 systemd[1]: Stopped systemd-vconsole-setup.service - Virtual Console Setup. Dec 13 13:26:01.110110 systemd[1]: initrd-udevadm-cleanup-db.service: Deactivated successfully. Dec 13 13:26:01.110859 systemd[1]: Finished initrd-udevadm-cleanup-db.service - Cleanup udev Database. Dec 13 13:26:01.112592 systemd[1]: Reached target initrd-switch-root.target - Switch Root. Dec 13 13:26:01.114544 systemd[1]: Starting initrd-switch-root.service - Switch Root... Dec 13 13:26:01.123091 systemd[1]: Switching root. Dec 13 13:26:01.150860 systemd-journald[238]: Journal stopped Dec 13 13:26:01.744556 systemd-journald[238]: Received SIGTERM from PID 1 (systemd). Dec 13 13:26:01.744611 kernel: SELinux: policy capability network_peer_controls=1 Dec 13 13:26:01.744626 kernel: SELinux: policy capability open_perms=1 Dec 13 13:26:01.744636 kernel: SELinux: policy capability extended_socket_class=1 Dec 13 13:26:01.744645 kernel: SELinux: policy capability always_check_network=0 Dec 13 13:26:01.744657 kernel: SELinux: policy capability cgroup_seclabel=1 Dec 13 13:26:01.744666 kernel: SELinux: policy capability nnp_nosuid_transition=1 Dec 13 13:26:01.744679 kernel: SELinux: policy capability genfs_seclabel_symlinks=0 Dec 13 13:26:01.744688 kernel: SELinux: policy capability ioctl_skip_cloexec=0 Dec 13 13:26:01.744697 kernel: audit: type=1403 audit(1734096361.209:2): auid=4294967295 ses=4294967295 lsm=selinux res=1 Dec 13 13:26:01.744708 systemd[1]: Successfully loaded SELinux policy in 30.851ms. Dec 13 13:26:01.744728 systemd[1]: Relabeled /dev, /dev/shm, /run, /sys/fs/cgroup in 9.054ms. Dec 13 13:26:01.744739 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) Dec 13 13:26:01.744749 systemd[1]: Detected virtualization kvm. Dec 13 13:26:01.744760 systemd[1]: Detected architecture arm64. Dec 13 13:26:01.744770 systemd[1]: Detected first boot. Dec 13 13:26:01.744781 systemd[1]: Initializing machine ID from VM UUID. Dec 13 13:26:01.744888 zram_generator::config[1044]: No configuration found. Dec 13 13:26:01.744901 systemd[1]: Populated /etc with preset unit settings. Dec 13 13:26:01.744911 systemd[1]: initrd-switch-root.service: Deactivated successfully. Dec 13 13:26:01.744921 systemd[1]: Stopped initrd-switch-root.service - Switch Root. Dec 13 13:26:01.744932 systemd[1]: systemd-journald.service: Scheduled restart job, restart counter is at 1. Dec 13 13:26:01.744943 systemd[1]: Created slice system-addon\x2dconfig.slice - Slice /system/addon-config. Dec 13 13:26:01.744953 systemd[1]: Created slice system-addon\x2drun.slice - Slice /system/addon-run. Dec 13 13:26:01.744965 systemd[1]: Created slice system-getty.slice - Slice /system/getty. Dec 13 13:26:01.744976 systemd[1]: Created slice system-modprobe.slice - Slice /system/modprobe. Dec 13 13:26:01.744987 systemd[1]: Created slice system-serial\x2dgetty.slice - Slice /system/serial-getty. Dec 13 13:26:01.744998 systemd[1]: Created slice system-system\x2dcloudinit.slice - Slice /system/system-cloudinit. Dec 13 13:26:01.745008 systemd[1]: Created slice system-systemd\x2dfsck.slice - Slice /system/systemd-fsck. Dec 13 13:26:01.745019 systemd[1]: Created slice user.slice - User and Session Slice. Dec 13 13:26:01.745030 systemd[1]: Started clevis-luks-askpass.path - Forward Password Requests to Clevis Directory Watch. Dec 13 13:26:01.745040 systemd[1]: Started systemd-ask-password-console.path - Dispatch Password Requests to Console Directory Watch. Dec 13 13:26:01.745050 systemd[1]: Started systemd-ask-password-wall.path - Forward Password Requests to Wall Directory Watch. Dec 13 13:26:01.745061 systemd[1]: Set up automount boot.automount - Boot partition Automount Point. Dec 13 13:26:01.745071 systemd[1]: Set up automount proc-sys-fs-binfmt_misc.automount - Arbitrary Executable File Formats File System Automount Point. Dec 13 13:26:01.745081 systemd[1]: Expecting device dev-disk-by\x2dlabel-OEM.device - /dev/disk/by-label/OEM... Dec 13 13:26:01.745091 systemd[1]: Expecting device dev-ttyAMA0.device - /dev/ttyAMA0... Dec 13 13:26:01.745102 systemd[1]: Reached target cryptsetup-pre.target - Local Encrypted Volumes (Pre). Dec 13 13:26:01.745113 systemd[1]: Stopped target initrd-switch-root.target - Switch Root. Dec 13 13:26:01.745125 systemd[1]: Stopped target initrd-fs.target - Initrd File Systems. Dec 13 13:26:01.745135 systemd[1]: Stopped target initrd-root-fs.target - Initrd Root File System. Dec 13 13:26:01.745145 systemd[1]: Reached target integritysetup.target - Local Integrity Protected Volumes. Dec 13 13:26:01.745155 systemd[1]: Reached target remote-cryptsetup.target - Remote Encrypted Volumes. Dec 13 13:26:01.745166 systemd[1]: Reached target remote-fs.target - Remote File Systems. Dec 13 13:26:01.745176 systemd[1]: Reached target slices.target - Slice Units. Dec 13 13:26:01.745186 systemd[1]: Reached target swap.target - Swaps. Dec 13 13:26:01.745196 systemd[1]: Reached target veritysetup.target - Local Verity Protected Volumes. Dec 13 13:26:01.745208 systemd[1]: Listening on systemd-coredump.socket - Process Core Dump Socket. Dec 13 13:26:01.745218 systemd[1]: Listening on systemd-networkd.socket - Network Service Netlink Socket. Dec 13 13:26:01.745228 systemd[1]: Listening on systemd-udevd-control.socket - udev Control Socket. Dec 13 13:26:01.745239 systemd[1]: Listening on systemd-udevd-kernel.socket - udev Kernel Socket. Dec 13 13:26:01.745249 systemd[1]: Listening on systemd-userdbd.socket - User Database Manager Socket. Dec 13 13:26:01.745259 systemd[1]: Mounting dev-hugepages.mount - Huge Pages File System... Dec 13 13:26:01.745269 systemd[1]: Mounting dev-mqueue.mount - POSIX Message Queue File System... Dec 13 13:26:01.745287 systemd[1]: Mounting media.mount - External Media Directory... Dec 13 13:26:01.745308 systemd[1]: Mounting sys-kernel-debug.mount - Kernel Debug File System... Dec 13 13:26:01.745321 systemd[1]: Mounting sys-kernel-tracing.mount - Kernel Trace File System... Dec 13 13:26:01.745331 systemd[1]: Mounting tmp.mount - Temporary Directory /tmp... Dec 13 13:26:01.745341 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). Dec 13 13:26:01.745353 systemd[1]: Reached target machines.target - Containers. Dec 13 13:26:01.745363 systemd[1]: Starting flatcar-tmpfiles.service - Create missing system files... Dec 13 13:26:01.745373 systemd[1]: ignition-delete-config.service - Ignition (delete config) was skipped because no trigger condition checks were met. Dec 13 13:26:01.745383 systemd[1]: Starting kmod-static-nodes.service - Create List of Static Device Nodes... Dec 13 13:26:01.745394 systemd[1]: Starting modprobe@configfs.service - Load Kernel Module configfs... Dec 13 13:26:01.745405 systemd[1]: Starting modprobe@dm_mod.service - Load Kernel Module dm_mod... Dec 13 13:26:01.745415 systemd[1]: Starting modprobe@drm.service - Load Kernel Module drm... Dec 13 13:26:01.745425 systemd[1]: Starting modprobe@efi_pstore.service - Load Kernel Module efi_pstore... Dec 13 13:26:01.745435 systemd[1]: Starting modprobe@fuse.service - Load Kernel Module fuse... Dec 13 13:26:01.745445 systemd[1]: Starting modprobe@loop.service - Load Kernel Module loop... Dec 13 13:26:01.745455 systemd[1]: setup-nsswitch.service - Create /etc/nsswitch.conf was skipped because of an unmet condition check (ConditionPathExists=!/etc/nsswitch.conf). Dec 13 13:26:01.745465 systemd[1]: systemd-fsck-root.service: Deactivated successfully. Dec 13 13:26:01.745475 systemd[1]: Stopped systemd-fsck-root.service - File System Check on Root Device. Dec 13 13:26:01.745486 kernel: fuse: init (API version 7.39) Dec 13 13:26:01.745495 systemd[1]: systemd-fsck-usr.service: Deactivated successfully. Dec 13 13:26:01.745505 kernel: loop: module loaded Dec 13 13:26:01.745514 systemd[1]: Stopped systemd-fsck-usr.service. Dec 13 13:26:01.745524 systemd[1]: Starting systemd-journald.service - Journal Service... Dec 13 13:26:01.745533 kernel: ACPI: bus type drm_connector registered Dec 13 13:26:01.745542 systemd[1]: Starting systemd-modules-load.service - Load Kernel Modules... Dec 13 13:26:01.745552 systemd[1]: Starting systemd-network-generator.service - Generate network units from Kernel command line... Dec 13 13:26:01.745563 systemd[1]: Starting systemd-remount-fs.service - Remount Root and Kernel File Systems... Dec 13 13:26:01.745594 systemd-journald[1115]: Collecting audit messages is disabled. Dec 13 13:26:01.745619 systemd-journald[1115]: Journal started Dec 13 13:26:01.745644 systemd-journald[1115]: Runtime Journal (/run/log/journal/01b648ea6e5444df9cbbe1471c33961e) is 5.9M, max 47.3M, 41.4M free. Dec 13 13:26:01.552745 systemd[1]: Queued start job for default target multi-user.target. Dec 13 13:26:01.567315 systemd[1]: Unnecessary job was removed for dev-vda6.device - /dev/vda6. Dec 13 13:26:01.567684 systemd[1]: systemd-journald.service: Deactivated successfully. Dec 13 13:26:01.751025 systemd[1]: Starting systemd-udev-trigger.service - Coldplug All udev Devices... Dec 13 13:26:01.753327 systemd[1]: verity-setup.service: Deactivated successfully. Dec 13 13:26:01.753360 systemd[1]: Stopped verity-setup.service. Dec 13 13:26:01.756603 systemd[1]: Started systemd-journald.service - Journal Service. Dec 13 13:26:01.757265 systemd[1]: Mounted dev-hugepages.mount - Huge Pages File System. Dec 13 13:26:01.758418 systemd[1]: Mounted dev-mqueue.mount - POSIX Message Queue File System. Dec 13 13:26:01.759610 systemd[1]: Mounted media.mount - External Media Directory. Dec 13 13:26:01.760702 systemd[1]: Mounted sys-kernel-debug.mount - Kernel Debug File System. Dec 13 13:26:01.761933 systemd[1]: Mounted sys-kernel-tracing.mount - Kernel Trace File System. Dec 13 13:26:01.763165 systemd[1]: Mounted tmp.mount - Temporary Directory /tmp. Dec 13 13:26:01.765833 systemd[1]: Finished flatcar-tmpfiles.service - Create missing system files. Dec 13 13:26:01.767204 systemd[1]: Finished kmod-static-nodes.service - Create List of Static Device Nodes. Dec 13 13:26:01.770125 systemd[1]: modprobe@configfs.service: Deactivated successfully. Dec 13 13:26:01.770289 systemd[1]: Finished modprobe@configfs.service - Load Kernel Module configfs. Dec 13 13:26:01.771694 systemd[1]: modprobe@dm_mod.service: Deactivated successfully. Dec 13 13:26:01.771851 systemd[1]: Finished modprobe@dm_mod.service - Load Kernel Module dm_mod. Dec 13 13:26:01.773220 systemd[1]: modprobe@drm.service: Deactivated successfully. Dec 13 13:26:01.773389 systemd[1]: Finished modprobe@drm.service - Load Kernel Module drm. Dec 13 13:26:01.774648 systemd[1]: modprobe@efi_pstore.service: Deactivated successfully. Dec 13 13:26:01.774786 systemd[1]: Finished modprobe@efi_pstore.service - Load Kernel Module efi_pstore. Dec 13 13:26:01.776239 systemd[1]: modprobe@fuse.service: Deactivated successfully. Dec 13 13:26:01.776390 systemd[1]: Finished modprobe@fuse.service - Load Kernel Module fuse. Dec 13 13:26:01.779227 systemd[1]: modprobe@loop.service: Deactivated successfully. Dec 13 13:26:01.779461 systemd[1]: Finished modprobe@loop.service - Load Kernel Module loop. Dec 13 13:26:01.780834 systemd[1]: Finished systemd-modules-load.service - Load Kernel Modules. Dec 13 13:26:01.782174 systemd[1]: Finished systemd-network-generator.service - Generate network units from Kernel command line. Dec 13 13:26:01.783859 systemd[1]: Finished systemd-remount-fs.service - Remount Root and Kernel File Systems. Dec 13 13:26:01.795767 systemd[1]: Reached target network-pre.target - Preparation for Network. Dec 13 13:26:01.810899 systemd[1]: Mounting sys-fs-fuse-connections.mount - FUSE Control File System... Dec 13 13:26:01.812907 systemd[1]: Mounting sys-kernel-config.mount - Kernel Configuration File System... Dec 13 13:26:01.813956 systemd[1]: remount-root.service - Remount Root File System was skipped because of an unmet condition check (ConditionPathIsReadWrite=!/). Dec 13 13:26:01.813997 systemd[1]: Reached target local-fs.target - Local File Systems. Dec 13 13:26:01.815919 systemd[1]: Listening on systemd-sysext.socket - System Extension Image Management (Varlink). Dec 13 13:26:01.818063 systemd[1]: Starting dracut-shutdown.service - Restore /run/initramfs on shutdown... Dec 13 13:26:01.820087 systemd[1]: Starting ldconfig.service - Rebuild Dynamic Linker Cache... Dec 13 13:26:01.821157 systemd[1]: systemd-binfmt.service - Set Up Additional Binary Formats was skipped because no trigger condition checks were met. Dec 13 13:26:01.822536 systemd[1]: Starting systemd-hwdb-update.service - Rebuild Hardware Database... Dec 13 13:26:01.824484 systemd[1]: Starting systemd-journal-flush.service - Flush Journal to Persistent Storage... Dec 13 13:26:01.825675 systemd[1]: systemd-pstore.service - Platform Persistent Storage Archival was skipped because of an unmet condition check (ConditionDirectoryNotEmpty=/sys/fs/pstore). Dec 13 13:26:01.828954 systemd[1]: Starting systemd-random-seed.service - Load/Save OS Random Seed... Dec 13 13:26:01.830221 systemd[1]: systemd-repart.service - Repartition Root Disk was skipped because no trigger condition checks were met. Dec 13 13:26:01.832577 systemd-journald[1115]: Time spent on flushing to /var/log/journal/01b648ea6e5444df9cbbe1471c33961e is 19.589ms for 829 entries. Dec 13 13:26:01.832577 systemd-journald[1115]: System Journal (/var/log/journal/01b648ea6e5444df9cbbe1471c33961e) is 8.0M, max 195.6M, 187.6M free. Dec 13 13:26:01.870709 systemd-journald[1115]: Received client request to flush runtime journal. Dec 13 13:26:01.870758 kernel: loop0: detected capacity change from 0 to 116784 Dec 13 13:26:01.834033 systemd[1]: Starting systemd-sysctl.service - Apply Kernel Variables... Dec 13 13:26:01.839050 systemd[1]: Starting systemd-sysext.service - Merge System Extension Images into /usr/ and /opt/... Dec 13 13:26:01.843995 systemd[1]: Starting systemd-sysusers.service - Create System Users... Dec 13 13:26:01.846364 systemd[1]: Finished systemd-udev-trigger.service - Coldplug All udev Devices. Dec 13 13:26:01.850621 systemd[1]: Mounted sys-fs-fuse-connections.mount - FUSE Control File System. Dec 13 13:26:01.851915 systemd[1]: Mounted sys-kernel-config.mount - Kernel Configuration File System. Dec 13 13:26:01.854820 systemd[1]: Finished dracut-shutdown.service - Restore /run/initramfs on shutdown. Dec 13 13:26:01.856670 systemd[1]: Finished systemd-random-seed.service - Load/Save OS Random Seed. Dec 13 13:26:01.863064 systemd[1]: Reached target first-boot-complete.target - First Boot Complete. Dec 13 13:26:01.872310 systemd[1]: Starting systemd-machine-id-commit.service - Commit a transient machine-id on disk... Dec 13 13:26:01.873114 kernel: squashfs: version 4.0 (2009/01/31) Phillip Lougher Dec 13 13:26:01.879034 systemd[1]: Starting systemd-udev-settle.service - Wait for udev To Complete Device Initialization... Dec 13 13:26:01.880992 systemd[1]: Finished systemd-journal-flush.service - Flush Journal to Persistent Storage. Dec 13 13:26:01.883835 systemd[1]: Finished systemd-sysctl.service - Apply Kernel Variables. Dec 13 13:26:01.891324 udevadm[1168]: systemd-udev-settle.service is deprecated. Please fix lvm2-activation-early.service, lvm2-activation.service not to pull it in. Dec 13 13:26:01.893639 systemd[1]: etc-machine\x2did.mount: Deactivated successfully. Dec 13 13:26:01.894234 systemd[1]: Finished systemd-machine-id-commit.service - Commit a transient machine-id on disk. Dec 13 13:26:01.905671 systemd[1]: Finished systemd-sysusers.service - Create System Users. Dec 13 13:26:01.915978 systemd[1]: Starting systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev... Dec 13 13:26:01.923820 kernel: loop1: detected capacity change from 0 to 113552 Dec 13 13:26:01.935661 systemd-tmpfiles[1175]: ACLs are not supported, ignoring. Dec 13 13:26:01.935991 systemd-tmpfiles[1175]: ACLs are not supported, ignoring. Dec 13 13:26:01.942411 systemd[1]: Finished systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev. Dec 13 13:26:01.951841 kernel: loop2: detected capacity change from 0 to 116784 Dec 13 13:26:01.957818 kernel: loop3: detected capacity change from 0 to 113552 Dec 13 13:26:01.966566 (sd-merge)[1179]: Using extensions 'containerd-flatcar', 'docker-flatcar'. Dec 13 13:26:01.967146 (sd-merge)[1179]: Merged extensions into '/usr'. Dec 13 13:26:01.971569 systemd[1]: Finished systemd-sysext.service - Merge System Extension Images into /usr/ and /opt/. Dec 13 13:26:01.978979 systemd[1]: Starting ensure-sysext.service... Dec 13 13:26:01.981654 systemd[1]: Starting systemd-tmpfiles-setup.service - Create System Files and Directories... Dec 13 13:26:01.989961 systemd[1]: Reloading requested from client PID 1181 ('systemctl') (unit ensure-sysext.service)... Dec 13 13:26:01.989978 systemd[1]: Reloading... Dec 13 13:26:01.998644 systemd-tmpfiles[1182]: /usr/lib/tmpfiles.d/provision.conf:20: Duplicate line for path "/root", ignoring. Dec 13 13:26:01.998906 systemd-tmpfiles[1182]: /usr/lib/tmpfiles.d/systemd-flatcar.conf:6: Duplicate line for path "/var/log/journal", ignoring. Dec 13 13:26:01.999570 systemd-tmpfiles[1182]: /usr/lib/tmpfiles.d/systemd.conf:29: Duplicate line for path "/var/lib/systemd", ignoring. Dec 13 13:26:01.999842 systemd-tmpfiles[1182]: ACLs are not supported, ignoring. Dec 13 13:26:01.999889 systemd-tmpfiles[1182]: ACLs are not supported, ignoring. Dec 13 13:26:02.002665 systemd-tmpfiles[1182]: Detected autofs mount point /boot during canonicalization of boot. Dec 13 13:26:02.002680 systemd-tmpfiles[1182]: Skipping /boot Dec 13 13:26:02.012617 systemd-tmpfiles[1182]: Detected autofs mount point /boot during canonicalization of boot. Dec 13 13:26:02.012629 systemd-tmpfiles[1182]: Skipping /boot Dec 13 13:26:02.052825 zram_generator::config[1215]: No configuration found. Dec 13 13:26:02.113144 ldconfig[1150]: /sbin/ldconfig: /usr/lib/ld.so.conf is not an ELF file - it has the wrong magic bytes at the start. Dec 13 13:26:02.143114 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. Dec 13 13:26:02.178624 systemd[1]: Reloading finished in 188 ms. Dec 13 13:26:02.206824 systemd[1]: Finished ldconfig.service - Rebuild Dynamic Linker Cache. Dec 13 13:26:02.218189 systemd[1]: Finished systemd-tmpfiles-setup.service - Create System Files and Directories. Dec 13 13:26:02.224251 systemd[1]: Starting audit-rules.service - Load Audit Rules... Dec 13 13:26:02.226534 systemd[1]: Starting clean-ca-certificates.service - Clean up broken links in /etc/ssl/certs... Dec 13 13:26:02.230107 systemd[1]: Starting systemd-journal-catalog-update.service - Rebuild Journal Catalog... Dec 13 13:26:02.237583 systemd[1]: Starting systemd-resolved.service - Network Name Resolution... Dec 13 13:26:02.243122 systemd[1]: Starting systemd-update-utmp.service - Record System Boot/Shutdown in UTMP... Dec 13 13:26:02.248301 systemd[1]: ignition-delete-config.service - Ignition (delete config) was skipped because no trigger condition checks were met. Dec 13 13:26:02.249400 systemd[1]: Starting modprobe@dm_mod.service - Load Kernel Module dm_mod... Dec 13 13:26:02.252351 systemd[1]: Starting modprobe@efi_pstore.service - Load Kernel Module efi_pstore... Dec 13 13:26:02.257081 systemd[1]: Starting modprobe@loop.service - Load Kernel Module loop... Dec 13 13:26:02.258227 systemd[1]: systemd-binfmt.service - Set Up Additional Binary Formats was skipped because no trigger condition checks were met. Dec 13 13:26:02.260088 systemd[1]: Starting systemd-userdbd.service - User Database Manager... Dec 13 13:26:02.262144 systemd[1]: Finished systemd-journal-catalog-update.service - Rebuild Journal Catalog. Dec 13 13:26:02.264447 systemd[1]: modprobe@dm_mod.service: Deactivated successfully. Dec 13 13:26:02.264592 systemd[1]: Finished modprobe@dm_mod.service - Load Kernel Module dm_mod. Dec 13 13:26:02.276627 systemd[1]: ignition-delete-config.service - Ignition (delete config) was skipped because no trigger condition checks were met. Dec 13 13:26:02.279339 systemd[1]: Starting modprobe@dm_mod.service - Load Kernel Module dm_mod... Dec 13 13:26:02.280620 systemd[1]: systemd-binfmt.service - Set Up Additional Binary Formats was skipped because no trigger condition checks were met. Dec 13 13:26:02.283666 systemd[1]: modprobe@efi_pstore.service: Deactivated successfully. Dec 13 13:26:02.287852 systemd[1]: Finished modprobe@efi_pstore.service - Load Kernel Module efi_pstore. Dec 13 13:26:02.289632 systemd[1]: modprobe@loop.service: Deactivated successfully. Dec 13 13:26:02.289762 systemd[1]: Finished modprobe@loop.service - Load Kernel Module loop. Dec 13 13:26:02.291540 systemd[1]: Finished clean-ca-certificates.service - Clean up broken links in /etc/ssl/certs. Dec 13 13:26:02.293201 systemd[1]: modprobe@dm_mod.service: Deactivated successfully. Dec 13 13:26:02.293337 systemd[1]: Finished modprobe@dm_mod.service - Load Kernel Module dm_mod. Dec 13 13:26:02.299929 systemd[1]: Finished systemd-update-utmp.service - Record System Boot/Shutdown in UTMP. Dec 13 13:26:02.303512 systemd[1]: ignition-delete-config.service - Ignition (delete config) was skipped because no trigger condition checks were met. Dec 13 13:26:02.316227 systemd[1]: Starting modprobe@dm_mod.service - Load Kernel Module dm_mod... Dec 13 13:26:02.320956 systemd[1]: Starting modprobe@drm.service - Load Kernel Module drm... Dec 13 13:26:02.323998 augenrules[1294]: No rules Dec 13 13:26:02.324368 systemd[1]: Starting modprobe@efi_pstore.service - Load Kernel Module efi_pstore... Dec 13 13:26:02.327030 systemd[1]: Starting modprobe@loop.service - Load Kernel Module loop... Dec 13 13:26:02.329003 systemd[1]: systemd-binfmt.service - Set Up Additional Binary Formats was skipped because no trigger condition checks were met. Dec 13 13:26:02.329081 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). Dec 13 13:26:02.329390 systemd[1]: Started systemd-userdbd.service - User Database Manager. Dec 13 13:26:02.331944 systemd[1]: Finished ensure-sysext.service. Dec 13 13:26:02.333085 systemd[1]: audit-rules.service: Deactivated successfully. Dec 13 13:26:02.333874 systemd[1]: Finished audit-rules.service - Load Audit Rules. Dec 13 13:26:02.335120 systemd[1]: modprobe@dm_mod.service: Deactivated successfully. Dec 13 13:26:02.335241 systemd[1]: Finished modprobe@dm_mod.service - Load Kernel Module dm_mod. Dec 13 13:26:02.336678 systemd[1]: modprobe@drm.service: Deactivated successfully. Dec 13 13:26:02.336818 systemd[1]: Finished modprobe@drm.service - Load Kernel Module drm. Dec 13 13:26:02.338113 systemd[1]: modprobe@efi_pstore.service: Deactivated successfully. Dec 13 13:26:02.338246 systemd[1]: Finished modprobe@efi_pstore.service - Load Kernel Module efi_pstore. Dec 13 13:26:02.339763 systemd[1]: modprobe@loop.service: Deactivated successfully. Dec 13 13:26:02.339917 systemd[1]: Finished modprobe@loop.service - Load Kernel Module loop. Dec 13 13:26:02.345776 systemd[1]: systemd-pstore.service - Platform Persistent Storage Archival was skipped because of an unmet condition check (ConditionDirectoryNotEmpty=/sys/fs/pstore). Dec 13 13:26:02.345869 systemd[1]: systemd-repart.service - Repartition Root Disk was skipped because no trigger condition checks were met. Dec 13 13:26:02.350981 systemd[1]: Starting systemd-timesyncd.service - Network Time Synchronization... Dec 13 13:26:02.369998 systemd-resolved[1257]: Positive Trust Anchors: Dec 13 13:26:02.370017 systemd-resolved[1257]: . IN DS 20326 8 2 e06d44b80b8f1d39a95c0b0d7c65d08458e880409bbc683457104237c7f8ec8d Dec 13 13:26:02.370048 systemd-resolved[1257]: 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 Dec 13 13:26:02.379618 systemd-resolved[1257]: Defaulting to hostname 'linux'. Dec 13 13:26:02.381265 systemd[1]: Finished systemd-hwdb-update.service - Rebuild Hardware Database. Dec 13 13:26:02.382531 systemd[1]: Started systemd-resolved.service - Network Name Resolution. Dec 13 13:26:02.383912 systemd[1]: Reached target nss-lookup.target - Host and Network Name Lookups. Dec 13 13:26:02.393938 systemd[1]: Starting systemd-udevd.service - Rule-based Manager for Device Events and Files... Dec 13 13:26:02.396159 systemd[1]: Starting systemd-update-done.service - Update is Completed... Dec 13 13:26:02.402048 systemd[1]: Started systemd-timesyncd.service - Network Time Synchronization. Dec 13 13:26:02.403294 systemd[1]: Reached target time-set.target - System Time Set. Dec 13 13:26:02.407828 systemd[1]: Finished systemd-update-done.service - Update is Completed. Dec 13 13:26:02.413372 systemd-udevd[1308]: Using default interface naming scheme 'v255'. Dec 13 13:26:02.427254 systemd[1]: Started systemd-udevd.service - Rule-based Manager for Device Events and Files. Dec 13 13:26:02.435290 systemd[1]: Starting systemd-networkd.service - Network Configuration... Dec 13 13:26:02.452424 systemd[1]: Condition check resulted in dev-ttyAMA0.device - /dev/ttyAMA0 being skipped. Dec 13 13:26:02.468824 kernel: BTRFS info: devid 1 device path /dev/mapper/usr changed to /dev/dm-0 scanned by (udev-worker) (1321) Dec 13 13:26:02.486037 kernel: BTRFS info: devid 1 device path /dev/dm-0 changed to /dev/mapper/usr scanned by (udev-worker) (1321) Dec 13 13:26:02.486205 kernel: BTRFS warning: duplicate device /dev/vda3 devid 1 generation 38 scanned by (udev-worker) (1322) Dec 13 13:26:02.504017 systemd-networkd[1319]: lo: Link UP Dec 13 13:26:02.504025 systemd-networkd[1319]: lo: Gained carrier Dec 13 13:26:02.507580 systemd-networkd[1319]: Enumeration completed Dec 13 13:26:02.507684 systemd[1]: Started systemd-networkd.service - Network Configuration. Dec 13 13:26:02.508781 systemd[1]: Reached target network.target - Network. Dec 13 13:26:02.512014 systemd-networkd[1319]: eth0: found matching network '/usr/lib/systemd/network/zz-default.network', based on potentially unpredictable interface name. Dec 13 13:26:02.512026 systemd-networkd[1319]: eth0: Configuring with /usr/lib/systemd/network/zz-default.network. Dec 13 13:26:02.513153 systemd-networkd[1319]: eth0: Link UP Dec 13 13:26:02.513165 systemd-networkd[1319]: eth0: Gained carrier Dec 13 13:26:02.513180 systemd-networkd[1319]: eth0: found matching network '/usr/lib/systemd/network/zz-default.network', based on potentially unpredictable interface name. Dec 13 13:26:02.516936 systemd[1]: Starting systemd-networkd-wait-online.service - Wait for Network to be Configured... Dec 13 13:26:02.520135 systemd[1]: Found device dev-disk-by\x2dlabel-OEM.device - /dev/disk/by-label/OEM. Dec 13 13:26:02.523285 systemd[1]: Starting systemd-fsck@dev-disk-by\x2dlabel-OEM.service - File System Check on /dev/disk/by-label/OEM... Dec 13 13:26:02.523597 systemd-networkd[1319]: eth0: DHCPv4 address 10.0.0.120/16, gateway 10.0.0.1 acquired from 10.0.0.1 Dec 13 13:26:02.524165 systemd-timesyncd[1306]: Network configuration changed, trying to establish connection. Dec 13 13:26:02.527961 systemd-timesyncd[1306]: Contacted time server 10.0.0.1:123 (10.0.0.1). Dec 13 13:26:02.528021 systemd-timesyncd[1306]: Initial clock synchronization to Fri 2024-12-13 13:26:02.860561 UTC. Dec 13 13:26:02.541643 systemd[1]: Finished systemd-fsck@dev-disk-by\x2dlabel-OEM.service - File System Check on /dev/disk/by-label/OEM. Dec 13 13:26:02.559088 systemd[1]: Starting systemd-vconsole-setup.service - Virtual Console Setup... Dec 13 13:26:02.569024 systemd[1]: Finished systemd-udev-settle.service - Wait for udev To Complete Device Initialization. Dec 13 13:26:02.571680 systemd[1]: Starting lvm2-activation-early.service - Activation of LVM2 logical volumes... Dec 13 13:26:02.596958 lvm[1349]: WARNING: Failed to connect to lvmetad. Falling back to device scanning. Dec 13 13:26:02.611622 systemd[1]: Finished systemd-vconsole-setup.service - Virtual Console Setup. Dec 13 13:26:02.630392 systemd[1]: Finished lvm2-activation-early.service - Activation of LVM2 logical volumes. Dec 13 13:26:02.631940 systemd[1]: Reached target cryptsetup.target - Local Encrypted Volumes. Dec 13 13:26:02.633020 systemd[1]: Reached target sysinit.target - System Initialization. Dec 13 13:26:02.634142 systemd[1]: Started motdgen.path - Watch for update engine configuration changes. Dec 13 13:26:02.635364 systemd[1]: Started user-cloudinit@var-lib-flatcar\x2dinstall-user_data.path - Watch for a cloud-config at /var/lib/flatcar-install/user_data. Dec 13 13:26:02.636755 systemd[1]: Started logrotate.timer - Daily rotation of log files. Dec 13 13:26:02.637880 systemd[1]: Started mdadm.timer - Weekly check for MD array's redundancy information.. Dec 13 13:26:02.639195 systemd[1]: Started systemd-tmpfiles-clean.timer - Daily Cleanup of Temporary Directories. Dec 13 13:26:02.640395 systemd[1]: update-engine-stub.timer - Update Engine Stub Timer was skipped because of an unmet condition check (ConditionPathExists=/usr/.noupdate). Dec 13 13:26:02.640430 systemd[1]: Reached target paths.target - Path Units. Dec 13 13:26:02.641319 systemd[1]: Reached target timers.target - Timer Units. Dec 13 13:26:02.642998 systemd[1]: Listening on dbus.socket - D-Bus System Message Bus Socket. Dec 13 13:26:02.645375 systemd[1]: Starting docker.socket - Docker Socket for the API... Dec 13 13:26:02.669726 systemd[1]: Listening on sshd.socket - OpenSSH Server Socket. Dec 13 13:26:02.672031 systemd[1]: Starting lvm2-activation.service - Activation of LVM2 logical volumes... Dec 13 13:26:02.673551 systemd[1]: Listening on docker.socket - Docker Socket for the API. Dec 13 13:26:02.674745 systemd[1]: Reached target sockets.target - Socket Units. Dec 13 13:26:02.675739 systemd[1]: Reached target basic.target - Basic System. Dec 13 13:26:02.676697 systemd[1]: addon-config@oem.service - Configure Addon /oem was skipped because no trigger condition checks were met. Dec 13 13:26:02.676728 systemd[1]: addon-run@oem.service - Run Addon /oem was skipped because no trigger condition checks were met. Dec 13 13:26:02.677632 systemd[1]: Starting containerd.service - containerd container runtime... Dec 13 13:26:02.679300 lvm[1356]: WARNING: Failed to connect to lvmetad. Falling back to device scanning. Dec 13 13:26:02.681539 systemd[1]: Starting dbus.service - D-Bus System Message Bus... Dec 13 13:26:02.685828 systemd[1]: Starting enable-oem-cloudinit.service - Enable cloudinit... Dec 13 13:26:02.689601 systemd[1]: Starting extend-filesystems.service - Extend Filesystems... Dec 13 13:26:02.692851 jq[1359]: false Dec 13 13:26:02.690679 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). Dec 13 13:26:02.692121 systemd[1]: Starting motdgen.service - Generate /run/flatcar/motd... Dec 13 13:26:02.696034 systemd[1]: Starting ssh-key-proc-cmdline.service - Install an ssh key from /proc/cmdline... Dec 13 13:26:02.701074 systemd[1]: Starting sshd-keygen.service - Generate sshd host keys... Dec 13 13:26:02.708080 systemd[1]: Starting systemd-logind.service - User Login Management... Dec 13 13:26:02.708655 extend-filesystems[1360]: Found loop2 Dec 13 13:26:02.709649 systemd[1]: tcsd.service - TCG Core Services Daemon was skipped because of an unmet condition check (ConditionPathExists=/dev/tpm0). Dec 13 13:26:02.710127 extend-filesystems[1360]: Found loop3 Dec 13 13:26:02.710127 extend-filesystems[1360]: Found vda Dec 13 13:26:02.710127 extend-filesystems[1360]: Found vda1 Dec 13 13:26:02.710127 extend-filesystems[1360]: Found vda2 Dec 13 13:26:02.710081 systemd[1]: cgroup compatibility translation between legacy and unified hierarchy settings activated. See cgroup-compat debug messages for details. Dec 13 13:26:02.714699 extend-filesystems[1360]: Found vda3 Dec 13 13:26:02.714699 extend-filesystems[1360]: Found usr Dec 13 13:26:02.714699 extend-filesystems[1360]: Found vda4 Dec 13 13:26:02.714699 extend-filesystems[1360]: Found vda6 Dec 13 13:26:02.714699 extend-filesystems[1360]: Found vda7 Dec 13 13:26:02.714699 extend-filesystems[1360]: Found vda9 Dec 13 13:26:02.714699 extend-filesystems[1360]: Checking size of /dev/vda9 Dec 13 13:26:02.711019 systemd[1]: Starting update-engine.service - Update Engine... Dec 13 13:26:02.756939 extend-filesystems[1360]: Old size kept for /dev/vda9 Dec 13 13:26:02.720218 dbus-daemon[1358]: [system] SELinux support is enabled Dec 13 13:26:02.716395 systemd[1]: Starting update-ssh-keys-after-ignition.service - Run update-ssh-keys once after Ignition... Dec 13 13:26:02.719934 systemd[1]: Finished lvm2-activation.service - Activation of LVM2 logical volumes. Dec 13 13:26:02.721254 systemd[1]: Started dbus.service - D-Bus System Message Bus. Dec 13 13:26:02.758454 jq[1375]: true Dec 13 13:26:02.727882 systemd[1]: enable-oem-cloudinit.service: Skipped due to 'exec-condition'. Dec 13 13:26:02.729832 systemd[1]: Condition check resulted in enable-oem-cloudinit.service - Enable cloudinit being skipped. Dec 13 13:26:02.730142 systemd[1]: motdgen.service: Deactivated successfully. Dec 13 13:26:02.730296 systemd[1]: Finished motdgen.service - Generate /run/flatcar/motd. Dec 13 13:26:02.731601 systemd[1]: ssh-key-proc-cmdline.service: Deactivated successfully. Dec 13 13:26:02.731732 systemd[1]: Finished ssh-key-proc-cmdline.service - Install an ssh key from /proc/cmdline. Dec 13 13:26:02.735475 systemd[1]: extend-filesystems.service: Deactivated successfully. Dec 13 13:26:02.735619 systemd[1]: Finished extend-filesystems.service - Extend Filesystems. Dec 13 13:26:02.747880 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). Dec 13 13:26:02.747930 systemd[1]: Reached target system-config.target - Load system-provided cloud configs. Dec 13 13:26:02.749135 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). Dec 13 13:26:02.749150 systemd[1]: Reached target user-config.target - Load user-provided cloud configs. Dec 13 13:26:02.756864 (ntainerd)[1382]: containerd.service: Referenced but unset environment variable evaluates to an empty string: TORCX_IMAGEDIR, TORCX_UNPACKDIR Dec 13 13:26:02.760252 jq[1381]: true Dec 13 13:26:02.762904 kernel: BTRFS warning: duplicate device /dev/vda3 devid 1 generation 38 scanned by (udev-worker) (1314) Dec 13 13:26:02.764815 update_engine[1372]: I20241213 13:26:02.764317 1372 main.cc:92] Flatcar Update Engine starting Dec 13 13:26:02.768053 update_engine[1372]: I20241213 13:26:02.767871 1372 update_check_scheduler.cc:74] Next update check in 8m55s Dec 13 13:26:02.768022 systemd[1]: Started update-engine.service - Update Engine. Dec 13 13:26:02.773299 systemd[1]: Started locksmithd.service - Cluster reboot manager. Dec 13 13:26:02.816809 systemd-logind[1369]: Watching system buttons on /dev/input/event0 (Power Button) Dec 13 13:26:02.817071 systemd-logind[1369]: New seat seat0. Dec 13 13:26:02.821846 systemd[1]: Started systemd-logind.service - User Login Management. Dec 13 13:26:02.824207 bash[1408]: Updated "/home/core/.ssh/authorized_keys" Dec 13 13:26:02.825009 systemd[1]: Finished update-ssh-keys-after-ignition.service - Run update-ssh-keys once after Ignition. Dec 13 13:26:02.827473 systemd[1]: sshkeys.service was skipped because no trigger condition checks were met. Dec 13 13:26:02.840977 locksmithd[1393]: locksmithd starting currentOperation="UPDATE_STATUS_IDLE" strategy="reboot" Dec 13 13:26:02.944494 containerd[1382]: time="2024-12-13T13:26:02.944370360Z" level=info msg="starting containerd" revision=9b2ad7760328148397346d10c7b2004271249db4 version=v1.7.23 Dec 13 13:26:02.969843 containerd[1382]: time="2024-12-13T13:26:02.969770600Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.aufs\"..." type=io.containerd.snapshotter.v1 Dec 13 13:26:02.971227 containerd[1382]: time="2024-12-13T13:26:02.971189840Z" 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.65-flatcar\\n\"): skip plugin" type=io.containerd.snapshotter.v1 Dec 13 13:26:02.971227 containerd[1382]: time="2024-12-13T13:26:02.971222160Z" level=info msg="loading plugin \"io.containerd.event.v1.exchange\"..." type=io.containerd.event.v1 Dec 13 13:26:02.971277 containerd[1382]: time="2024-12-13T13:26:02.971237240Z" level=info msg="loading plugin \"io.containerd.internal.v1.opt\"..." type=io.containerd.internal.v1 Dec 13 13:26:02.971426 containerd[1382]: time="2024-12-13T13:26:02.971395280Z" level=info msg="loading plugin \"io.containerd.warning.v1.deprecations\"..." type=io.containerd.warning.v1 Dec 13 13:26:02.971426 containerd[1382]: time="2024-12-13T13:26:02.971422800Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.blockfile\"..." type=io.containerd.snapshotter.v1 Dec 13 13:26:02.971492 containerd[1382]: time="2024-12-13T13:26:02.971476360Z" level=info msg="skip loading plugin \"io.containerd.snapshotter.v1.blockfile\"..." error="no scratch file generator: skip plugin" type=io.containerd.snapshotter.v1 Dec 13 13:26:02.971514 containerd[1382]: time="2024-12-13T13:26:02.971492200Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.btrfs\"..." type=io.containerd.snapshotter.v1 Dec 13 13:26:02.971670 containerd[1382]: time="2024-12-13T13:26:02.971643440Z" 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 Dec 13 13:26:02.971670 containerd[1382]: time="2024-12-13T13:26:02.971664840Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.devmapper\"..." type=io.containerd.snapshotter.v1 Dec 13 13:26:02.971707 containerd[1382]: time="2024-12-13T13:26:02.971688120Z" level=info msg="skip loading plugin \"io.containerd.snapshotter.v1.devmapper\"..." error="devmapper not configured: skip plugin" type=io.containerd.snapshotter.v1 Dec 13 13:26:02.971707 containerd[1382]: time="2024-12-13T13:26:02.971701760Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.native\"..." type=io.containerd.snapshotter.v1 Dec 13 13:26:02.971793 containerd[1382]: time="2024-12-13T13:26:02.971775560Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.overlayfs\"..." type=io.containerd.snapshotter.v1 Dec 13 13:26:02.972010 containerd[1382]: time="2024-12-13T13:26:02.971982400Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.zfs\"..." type=io.containerd.snapshotter.v1 Dec 13 13:26:02.972110 containerd[1382]: time="2024-12-13T13:26:02.972092120Z" 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 Dec 13 13:26:02.972136 containerd[1382]: time="2024-12-13T13:26:02.972110920Z" level=info msg="loading plugin \"io.containerd.content.v1.content\"..." type=io.containerd.content.v1 Dec 13 13:26:02.972208 containerd[1382]: time="2024-12-13T13:26:02.972193840Z" level=info msg="loading plugin \"io.containerd.metadata.v1.bolt\"..." type=io.containerd.metadata.v1 Dec 13 13:26:02.972252 containerd[1382]: time="2024-12-13T13:26:02.972240560Z" level=info msg="metadata content store policy set" policy=shared Dec 13 13:26:02.975064 containerd[1382]: time="2024-12-13T13:26:02.975033160Z" level=info msg="loading plugin \"io.containerd.gc.v1.scheduler\"..." type=io.containerd.gc.v1 Dec 13 13:26:02.975108 containerd[1382]: time="2024-12-13T13:26:02.975080440Z" level=info msg="loading plugin \"io.containerd.differ.v1.walking\"..." type=io.containerd.differ.v1 Dec 13 13:26:02.975108 containerd[1382]: time="2024-12-13T13:26:02.975095920Z" level=info msg="loading plugin \"io.containerd.lease.v1.manager\"..." type=io.containerd.lease.v1 Dec 13 13:26:02.975160 containerd[1382]: time="2024-12-13T13:26:02.975111840Z" level=info msg="loading plugin \"io.containerd.streaming.v1.manager\"..." type=io.containerd.streaming.v1 Dec 13 13:26:02.975160 containerd[1382]: time="2024-12-13T13:26:02.975124520Z" level=info msg="loading plugin \"io.containerd.runtime.v1.linux\"..." type=io.containerd.runtime.v1 Dec 13 13:26:02.975279 containerd[1382]: time="2024-12-13T13:26:02.975252640Z" level=info msg="loading plugin \"io.containerd.monitor.v1.cgroups\"..." type=io.containerd.monitor.v1 Dec 13 13:26:02.975559 containerd[1382]: time="2024-12-13T13:26:02.975523600Z" level=info msg="loading plugin \"io.containerd.runtime.v2.task\"..." type=io.containerd.runtime.v2 Dec 13 13:26:02.975680 containerd[1382]: time="2024-12-13T13:26:02.975663080Z" level=info msg="loading plugin \"io.containerd.runtime.v2.shim\"..." type=io.containerd.runtime.v2 Dec 13 13:26:02.975706 containerd[1382]: time="2024-12-13T13:26:02.975684760Z" level=info msg="loading plugin \"io.containerd.sandbox.store.v1.local\"..." type=io.containerd.sandbox.store.v1 Dec 13 13:26:02.975725 containerd[1382]: time="2024-12-13T13:26:02.975704120Z" level=info msg="loading plugin \"io.containerd.sandbox.controller.v1.local\"..." type=io.containerd.sandbox.controller.v1 Dec 13 13:26:02.976361 containerd[1382]: time="2024-12-13T13:26:02.976328320Z" level=info msg="loading plugin \"io.containerd.service.v1.containers-service\"..." type=io.containerd.service.v1 Dec 13 13:26:02.976407 containerd[1382]: time="2024-12-13T13:26:02.976366520Z" level=info msg="loading plugin \"io.containerd.service.v1.content-service\"..." type=io.containerd.service.v1 Dec 13 13:26:02.976407 containerd[1382]: time="2024-12-13T13:26:02.976384480Z" level=info msg="loading plugin \"io.containerd.service.v1.diff-service\"..." type=io.containerd.service.v1 Dec 13 13:26:02.976407 containerd[1382]: time="2024-12-13T13:26:02.976401280Z" level=info msg="loading plugin \"io.containerd.service.v1.images-service\"..." type=io.containerd.service.v1 Dec 13 13:26:02.976455 containerd[1382]: time="2024-12-13T13:26:02.976418400Z" level=info msg="loading plugin \"io.containerd.service.v1.introspection-service\"..." type=io.containerd.service.v1 Dec 13 13:26:02.976455 containerd[1382]: time="2024-12-13T13:26:02.976432400Z" level=info msg="loading plugin \"io.containerd.service.v1.namespaces-service\"..." type=io.containerd.service.v1 Dec 13 13:26:02.976455 containerd[1382]: time="2024-12-13T13:26:02.976448840Z" level=info msg="loading plugin \"io.containerd.service.v1.snapshots-service\"..." type=io.containerd.service.v1 Dec 13 13:26:02.976516 containerd[1382]: time="2024-12-13T13:26:02.976463400Z" level=info msg="loading plugin \"io.containerd.service.v1.tasks-service\"..." type=io.containerd.service.v1 Dec 13 13:26:02.976516 containerd[1382]: time="2024-12-13T13:26:02.976489040Z" level=info msg="loading plugin \"io.containerd.grpc.v1.containers\"..." type=io.containerd.grpc.v1 Dec 13 13:26:02.976516 containerd[1382]: time="2024-12-13T13:26:02.976506360Z" level=info msg="loading plugin \"io.containerd.grpc.v1.content\"..." type=io.containerd.grpc.v1 Dec 13 13:26:02.976570 containerd[1382]: time="2024-12-13T13:26:02.976521440Z" level=info msg="loading plugin \"io.containerd.grpc.v1.diff\"..." type=io.containerd.grpc.v1 Dec 13 13:26:02.976570 containerd[1382]: time="2024-12-13T13:26:02.976537200Z" level=info msg="loading plugin \"io.containerd.grpc.v1.events\"..." type=io.containerd.grpc.v1 Dec 13 13:26:02.976570 containerd[1382]: time="2024-12-13T13:26:02.976552640Z" level=info msg="loading plugin \"io.containerd.grpc.v1.images\"..." type=io.containerd.grpc.v1 Dec 13 13:26:02.976570 containerd[1382]: time="2024-12-13T13:26:02.976568280Z" level=info msg="loading plugin \"io.containerd.grpc.v1.introspection\"..." type=io.containerd.grpc.v1 Dec 13 13:26:02.976635 containerd[1382]: time="2024-12-13T13:26:02.976585480Z" level=info msg="loading plugin \"io.containerd.grpc.v1.leases\"..." type=io.containerd.grpc.v1 Dec 13 13:26:02.976635 containerd[1382]: time="2024-12-13T13:26:02.976601840Z" level=info msg="loading plugin \"io.containerd.grpc.v1.namespaces\"..." type=io.containerd.grpc.v1 Dec 13 13:26:02.976635 containerd[1382]: time="2024-12-13T13:26:02.976618480Z" level=info msg="loading plugin \"io.containerd.grpc.v1.sandbox-controllers\"..." type=io.containerd.grpc.v1 Dec 13 13:26:02.976681 containerd[1382]: time="2024-12-13T13:26:02.976637240Z" level=info msg="loading plugin \"io.containerd.grpc.v1.sandboxes\"..." type=io.containerd.grpc.v1 Dec 13 13:26:02.976681 containerd[1382]: time="2024-12-13T13:26:02.976652760Z" level=info msg="loading plugin \"io.containerd.grpc.v1.snapshots\"..." type=io.containerd.grpc.v1 Dec 13 13:26:02.976681 containerd[1382]: time="2024-12-13T13:26:02.976664760Z" level=info msg="loading plugin \"io.containerd.grpc.v1.streaming\"..." type=io.containerd.grpc.v1 Dec 13 13:26:02.976731 containerd[1382]: time="2024-12-13T13:26:02.976679960Z" level=info msg="loading plugin \"io.containerd.grpc.v1.tasks\"..." type=io.containerd.grpc.v1 Dec 13 13:26:02.976731 containerd[1382]: time="2024-12-13T13:26:02.976722440Z" level=info msg="loading plugin \"io.containerd.transfer.v1.local\"..." type=io.containerd.transfer.v1 Dec 13 13:26:02.976763 containerd[1382]: time="2024-12-13T13:26:02.976749120Z" level=info msg="loading plugin \"io.containerd.grpc.v1.transfer\"..." type=io.containerd.grpc.v1 Dec 13 13:26:02.976780 containerd[1382]: time="2024-12-13T13:26:02.976766840Z" level=info msg="loading plugin \"io.containerd.grpc.v1.version\"..." type=io.containerd.grpc.v1 Dec 13 13:26:02.976823 containerd[1382]: time="2024-12-13T13:26:02.976782000Z" level=info msg="loading plugin \"io.containerd.internal.v1.restart\"..." type=io.containerd.internal.v1 Dec 13 13:26:02.977016 containerd[1382]: time="2024-12-13T13:26:02.976999800Z" level=info msg="loading plugin \"io.containerd.tracing.processor.v1.otlp\"..." type=io.containerd.tracing.processor.v1 Dec 13 13:26:02.977042 containerd[1382]: time="2024-12-13T13:26:02.977023920Z" 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 Dec 13 13:26:02.977042 containerd[1382]: time="2024-12-13T13:26:02.977038840Z" level=info msg="loading plugin \"io.containerd.internal.v1.tracing\"..." type=io.containerd.internal.v1 Dec 13 13:26:02.977085 containerd[1382]: time="2024-12-13T13:26:02.977054320Z" level=info msg="skip loading plugin \"io.containerd.internal.v1.tracing\"..." error="skip plugin: tracing endpoint not configured" type=io.containerd.internal.v1 Dec 13 13:26:02.977085 containerd[1382]: time="2024-12-13T13:26:02.977067160Z" level=info msg="loading plugin \"io.containerd.grpc.v1.healthcheck\"..." type=io.containerd.grpc.v1 Dec 13 13:26:02.977085 containerd[1382]: time="2024-12-13T13:26:02.977082320Z" level=info msg="loading plugin \"io.containerd.nri.v1.nri\"..." type=io.containerd.nri.v1 Dec 13 13:26:02.977140 containerd[1382]: time="2024-12-13T13:26:02.977093000Z" level=info msg="NRI interface is disabled by configuration." Dec 13 13:26:02.977140 containerd[1382]: time="2024-12-13T13:26:02.977106280Z" level=info msg="loading plugin \"io.containerd.grpc.v1.cri\"..." type=io.containerd.grpc.v1 Dec 13 13:26:02.977533 containerd[1382]: time="2024-12-13T13:26:02.977479560Z" 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}" Dec 13 13:26:02.977533 containerd[1382]: time="2024-12-13T13:26:02.977533720Z" level=info msg="Connect containerd service" Dec 13 13:26:02.977658 containerd[1382]: time="2024-12-13T13:26:02.977571160Z" level=info msg="using legacy CRI server" Dec 13 13:26:02.977658 containerd[1382]: time="2024-12-13T13:26:02.977578040Z" level=info msg="using experimental NRI integration - disable nri plugin to prevent this" Dec 13 13:26:02.977866 containerd[1382]: time="2024-12-13T13:26:02.977847160Z" level=info msg="Get image filesystem path \"/var/lib/containerd/io.containerd.snapshotter.v1.overlayfs\"" Dec 13 13:26:02.978595 containerd[1382]: time="2024-12-13T13:26:02.978564200Z" 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" Dec 13 13:26:02.978802 containerd[1382]: time="2024-12-13T13:26:02.978759760Z" level=info msg="Start subscribing containerd event" Dec 13 13:26:02.978832 containerd[1382]: time="2024-12-13T13:26:02.978819240Z" level=info msg="Start recovering state" Dec 13 13:26:02.978900 containerd[1382]: time="2024-12-13T13:26:02.978883280Z" level=info msg="Start event monitor" Dec 13 13:26:02.978926 containerd[1382]: time="2024-12-13T13:26:02.978907400Z" level=info msg="Start snapshots syncer" Dec 13 13:26:02.978926 containerd[1382]: time="2024-12-13T13:26:02.978917520Z" level=info msg="Start cni network conf syncer for default" Dec 13 13:26:02.978975 containerd[1382]: time="2024-12-13T13:26:02.978928720Z" level=info msg="Start streaming server" Dec 13 13:26:02.979655 containerd[1382]: time="2024-12-13T13:26:02.979636120Z" level=info msg=serving... address=/run/containerd/containerd.sock.ttrpc Dec 13 13:26:02.979693 containerd[1382]: time="2024-12-13T13:26:02.979687360Z" level=info msg=serving... address=/run/containerd/containerd.sock Dec 13 13:26:02.979881 systemd[1]: Started containerd.service - containerd container runtime. Dec 13 13:26:02.984096 containerd[1382]: time="2024-12-13T13:26:02.981320520Z" level=info msg="containerd successfully booted in 0.037801s" Dec 13 13:26:03.220802 sshd_keygen[1377]: ssh-keygen: generating new host keys: RSA ECDSA ED25519 Dec 13 13:26:03.240925 systemd[1]: Finished sshd-keygen.service - Generate sshd host keys. Dec 13 13:26:03.252266 systemd[1]: Starting issuegen.service - Generate /run/issue... Dec 13 13:26:03.256889 systemd[1]: issuegen.service: Deactivated successfully. Dec 13 13:26:03.257056 systemd[1]: Finished issuegen.service - Generate /run/issue. Dec 13 13:26:03.261134 systemd[1]: Starting systemd-user-sessions.service - Permit User Sessions... Dec 13 13:26:03.273760 systemd[1]: Finished systemd-user-sessions.service - Permit User Sessions. Dec 13 13:26:03.283316 systemd[1]: Started getty@tty1.service - Getty on tty1. Dec 13 13:26:03.285907 systemd[1]: Started serial-getty@ttyAMA0.service - Serial Getty on ttyAMA0. Dec 13 13:26:03.287195 systemd[1]: Reached target getty.target - Login Prompts. Dec 13 13:26:03.754887 systemd-networkd[1319]: eth0: Gained IPv6LL Dec 13 13:26:03.757689 systemd[1]: Finished systemd-networkd-wait-online.service - Wait for Network to be Configured. Dec 13 13:26:03.759384 systemd[1]: Reached target network-online.target - Network is Online. Dec 13 13:26:03.767149 systemd[1]: Starting coreos-metadata.service - QEMU metadata agent... Dec 13 13:26:03.768985 systemd[1]: Starting nvidia.service - NVIDIA Configure Service... Dec 13 13:26:03.783194 systemd[1]: coreos-metadata.service: Deactivated successfully. Dec 13 13:26:03.783380 systemd[1]: Finished coreos-metadata.service - QEMU metadata agent. Dec 13 13:26:03.787088 systemd[1]: Starting etcd-member.service - etcd (System Application Container)... Dec 13 13:26:03.788277 systemd[1]: packet-phone-home.service - Report Success to Packet was skipped because no trigger condition checks were met. Dec 13 13:26:03.789475 (-wrapper)[1451]: etcd-member.service: Referenced but unset environment variable evaluates to an empty string: ETCD_OPTS Dec 13 13:26:03.790078 systemd[1]: Finished nvidia.service - NVIDIA Configure Service. Dec 13 13:26:03.933064 systemd[1]: Starting docker.service - Docker Application Container Engine... Dec 13 13:26:03.933219 (dockerd)[1467]: docker.service: Referenced but unset environment variable evaluates to an empty string: DOCKER_CGROUPS, DOCKER_OPTS, DOCKER_OPT_BIP, DOCKER_OPT_IPMASQ, DOCKER_OPT_MTU Dec 13 13:26:04.179287 dockerd[1467]: time="2024-12-13T13:26:04.179171414Z" level=info msg="Starting up" Dec 13 13:26:04.267975 dockerd[1467]: time="2024-12-13T13:26:04.267879989Z" level=info msg="Loading containers: start." Dec 13 13:26:04.411855 kernel: Initializing XFRM netlink socket Dec 13 13:26:04.477558 systemd-networkd[1319]: docker0: Link UP Dec 13 13:26:04.501032 dockerd[1467]: time="2024-12-13T13:26:04.500973862Z" level=info msg="Loading containers: done." Dec 13 13:26:04.517168 dockerd[1467]: time="2024-12-13T13:26:04.517129685Z" level=warning msg="Not using native diff for overlay2, this may cause degraded performance for building images: kernel has CONFIG_OVERLAY_FS_REDIRECT_DIR enabled" storage-driver=overlay2 Dec 13 13:26:04.517288 dockerd[1467]: time="2024-12-13T13:26:04.517207041Z" level=info msg="Docker daemon" commit=41ca978a0a5400cc24b274137efa9f25517fcc0b containerd-snapshotter=false storage-driver=overlay2 version=27.3.1 Dec 13 13:26:04.517418 dockerd[1467]: time="2024-12-13T13:26:04.517395954Z" level=info msg="Daemon has completed initialization" Dec 13 13:26:04.543479 dockerd[1467]: time="2024-12-13T13:26:04.543348686Z" level=info msg="API listen on /run/docker.sock" Dec 13 13:26:04.543550 systemd[1]: Started docker.service - Docker Application Container Engine. Dec 13 13:26:04.544937 etcd-wrapper[1458]: Error response from daemon: No such container: etcd-member Dec 13 13:26:04.557209 etcd-wrapper[1645]: Error response from daemon: No such container: etcd-member Dec 13 13:26:04.588338 etcd-wrapper[1666]: Unable to find image 'quay.io/coreos/etcd:v3.5.16' locally Dec 13 13:26:05.624407 etcd-wrapper[1666]: v3.5.16: Pulling from coreos/etcd Dec 13 13:26:05.760003 etcd-wrapper[1666]: d10f96ed9607: Pulling fs layer Dec 13 13:26:05.760225 etcd-wrapper[1666]: 2ae710cd8bfe: Pulling fs layer Dec 13 13:26:05.760225 etcd-wrapper[1666]: d462aa345367: Pulling fs layer Dec 13 13:26:05.760294 etcd-wrapper[1666]: 0f8b424aa0b9: Pulling fs layer Dec 13 13:26:05.760294 etcd-wrapper[1666]: d557676654e5: Pulling fs layer Dec 13 13:26:05.760294 etcd-wrapper[1666]: c8022d07192e: Pulling fs layer Dec 13 13:26:05.760294 etcd-wrapper[1666]: d858cbc252ad: Pulling fs layer Dec 13 13:26:05.760294 etcd-wrapper[1666]: 1069fc2daed1: Pulling fs layer Dec 13 13:26:05.760294 etcd-wrapper[1666]: b40161cd83fc: Pulling fs layer Dec 13 13:26:05.760294 etcd-wrapper[1666]: 5318d93a3a65: Pulling fs layer Dec 13 13:26:05.760294 etcd-wrapper[1666]: 307c1adadb60: Pulling fs layer Dec 13 13:26:05.760294 etcd-wrapper[1666]: f9b3c65df792: Pulling fs layer Dec 13 13:26:05.760294 etcd-wrapper[1666]: 5709b4a82c35: Pulling fs layer Dec 13 13:26:05.760294 etcd-wrapper[1666]: d5372e382b07: Pulling fs layer Dec 13 13:26:05.760294 etcd-wrapper[1666]: 9c3b5253dddc: Pulling fs layer Dec 13 13:26:05.760294 etcd-wrapper[1666]: 7a57323f7551: Pulling fs layer Dec 13 13:26:05.760555 etcd-wrapper[1666]: c8022d07192e: Waiting Dec 13 13:26:05.760555 etcd-wrapper[1666]: d858cbc252ad: Waiting Dec 13 13:26:05.760555 etcd-wrapper[1666]: 1069fc2daed1: Waiting Dec 13 13:26:05.760555 etcd-wrapper[1666]: b40161cd83fc: Waiting Dec 13 13:26:05.760555 etcd-wrapper[1666]: 5318d93a3a65: Waiting Dec 13 13:26:05.760555 etcd-wrapper[1666]: 307c1adadb60: Waiting Dec 13 13:26:05.760555 etcd-wrapper[1666]: 9c3b5253dddc: Waiting Dec 13 13:26:05.760555 etcd-wrapper[1666]: 7a57323f7551: Waiting Dec 13 13:26:05.760555 etcd-wrapper[1666]: f9b3c65df792: Waiting Dec 13 13:26:05.760555 etcd-wrapper[1666]: d5372e382b07: Waiting Dec 13 13:26:05.760555 etcd-wrapper[1666]: 5709b4a82c35: Waiting Dec 13 13:26:05.760555 etcd-wrapper[1666]: 0f8b424aa0b9: Waiting Dec 13 13:26:05.760555 etcd-wrapper[1666]: d557676654e5: Waiting Dec 13 13:26:05.918213 etcd-wrapper[1666]: 2ae710cd8bfe: Download complete Dec 13 13:26:05.988440 etcd-wrapper[1666]: d10f96ed9607: Verifying Checksum Dec 13 13:26:05.988530 etcd-wrapper[1666]: d10f96ed9607: Download complete Dec 13 13:26:06.009495 etcd-wrapper[1666]: d10f96ed9607: Pull complete Dec 13 13:26:06.021231 systemd[1]: var-lib-docker-overlay2-f3fe1a0095c4109c689081e6eab1140766becdd9cc314ec63cd759473c2434aa-merged.mount: Deactivated successfully. Dec 13 13:26:06.032570 etcd-wrapper[1666]: 2ae710cd8bfe: Pull complete Dec 13 13:26:06.157197 etcd-wrapper[1666]: 0f8b424aa0b9: Verifying Checksum Dec 13 13:26:06.157197 etcd-wrapper[1666]: 0f8b424aa0b9: Download complete Dec 13 13:26:06.185525 etcd-wrapper[1666]: d557676654e5: Download complete Dec 13 13:26:06.579925 etcd-wrapper[1666]: c8022d07192e: Verifying Checksum Dec 13 13:26:06.579925 etcd-wrapper[1666]: c8022d07192e: Download complete Dec 13 13:26:06.902229 etcd-wrapper[1666]: d858cbc252ad: Verifying Checksum Dec 13 13:26:06.902229 etcd-wrapper[1666]: d858cbc252ad: Download complete Dec 13 13:26:07.057188 etcd-wrapper[1666]: b40161cd83fc: Verifying Checksum Dec 13 13:26:07.057188 etcd-wrapper[1666]: b40161cd83fc: Download complete Dec 13 13:26:07.171334 etcd-wrapper[1666]: d462aa345367: Download complete Dec 13 13:26:07.205134 etcd-wrapper[1666]: 5318d93a3a65: Verifying Checksum Dec 13 13:26:07.205134 etcd-wrapper[1666]: 5318d93a3a65: Download complete Dec 13 13:26:07.206333 etcd-wrapper[1666]: 1069fc2daed1: Verifying Checksum Dec 13 13:26:07.206333 etcd-wrapper[1666]: 1069fc2daed1: Download complete Dec 13 13:26:07.471757 systemd[1]: var-lib-docker-overlay2-47d7a0de0526eb38472a83bee6ac108a40638d84c086776230670fdfad84f2b6-merged.mount: Deactivated successfully. Dec 13 13:26:07.476919 etcd-wrapper[1666]: 5709b4a82c35: Verifying Checksum Dec 13 13:26:07.476919 etcd-wrapper[1666]: 5709b4a82c35: Download complete Dec 13 13:26:07.511479 etcd-wrapper[1666]: d462aa345367: Pull complete Dec 13 13:26:07.522308 systemd[1]: var-lib-docker-overlay2-0dd0e033b1076d207cc4cc3d1764ad6a4ac586291deed50927447b3aa9bf94a0-merged.mount: Deactivated successfully. Dec 13 13:26:07.537169 etcd-wrapper[1666]: 0f8b424aa0b9: Pull complete Dec 13 13:26:07.553301 etcd-wrapper[1666]: d557676654e5: Pull complete Dec 13 13:26:07.570741 etcd-wrapper[1666]: c8022d07192e: Pull complete Dec 13 13:26:07.584274 etcd-wrapper[1666]: d858cbc252ad: Pull complete Dec 13 13:26:07.598885 etcd-wrapper[1666]: 1069fc2daed1: Pull complete Dec 13 13:26:07.615273 etcd-wrapper[1666]: b40161cd83fc: Pull complete Dec 13 13:26:07.632637 etcd-wrapper[1666]: 5318d93a3a65: Pull complete Dec 13 13:26:07.747179 etcd-wrapper[1666]: f9b3c65df792: Verifying Checksum Dec 13 13:26:07.747179 etcd-wrapper[1666]: f9b3c65df792: Download complete Dec 13 13:26:08.007697 etcd-wrapper[1666]: 9c3b5253dddc: Verifying Checksum Dec 13 13:26:08.007697 etcd-wrapper[1666]: 9c3b5253dddc: Download complete Dec 13 13:26:08.046488 etcd-wrapper[1666]: 307c1adadb60: Verifying Checksum Dec 13 13:26:08.046488 etcd-wrapper[1666]: 307c1adadb60: Download complete Dec 13 13:26:08.073837 etcd-wrapper[1666]: 307c1adadb60: Pull complete Dec 13 13:26:08.177008 systemd[1]: var-lib-docker-overlay2-0a466aeed5b21af3edb61bfc647c5a83007d30e577a94b48078ffaf85b19c4ee-merged.mount: Deactivated successfully. Dec 13 13:26:08.205928 etcd-wrapper[1666]: f9b3c65df792: Pull complete Dec 13 13:26:08.287930 systemd[1]: var-lib-docker-overlay2-d0808d2e305166abf197b790a4dc749d29747c6aa38d53791982897e6eafbd8c-merged.mount: Deactivated successfully. Dec 13 13:26:08.313618 agetty[1438]: failed to open credentials directory Dec 13 13:26:08.313661 agetty[1439]: failed to open credentials directory Dec 13 13:26:08.320825 etcd-wrapper[1666]: 5709b4a82c35: Pull complete Dec 13 13:26:08.413558 etcd-wrapper[1666]: d5372e382b07: Verifying Checksum Dec 13 13:26:08.413558 etcd-wrapper[1666]: d5372e382b07: Download complete Dec 13 13:26:08.482182 systemd[1]: var-lib-docker-overlay2-b1ffe0be2878f22bee6d30fd82fcfb2e60b73cbdb6505653ac12cfc58ebd3bfd-merged.mount: Deactivated successfully. Dec 13 13:26:08.508209 etcd-wrapper[1666]: d5372e382b07: Pull complete Dec 13 13:26:08.524479 etcd-wrapper[1666]: 9c3b5253dddc: Pull complete Dec 13 13:26:08.538991 etcd-wrapper[1666]: 7a57323f7551: Verifying Checksum Dec 13 13:26:08.538991 etcd-wrapper[1666]: 7a57323f7551: Download complete Dec 13 13:26:08.551868 etcd-wrapper[1666]: 7a57323f7551: Pull complete Dec 13 13:26:08.557993 etcd-wrapper[1666]: Digest: sha256:d967d98a12dc220a1a290794711dba7eba04b8ce465e12b02383d1bfbb33e159 Dec 13 13:26:08.560237 etcd-wrapper[1666]: Status: Downloaded newer image for quay.io/coreos/etcd:v3.5.16 Dec 13 13:26:08.669558 containerd[1382]: time="2024-12-13T13:26:08.669428230Z" level=info msg="loading plugin \"io.containerd.event.v1.publisher\"..." runtime=io.containerd.runc.v2 type=io.containerd.event.v1 Dec 13 13:26:08.669558 containerd[1382]: time="2024-12-13T13:26:08.669513245Z" level=info msg="loading plugin \"io.containerd.internal.v1.shutdown\"..." runtime=io.containerd.runc.v2 type=io.containerd.internal.v1 Dec 13 13:26:08.669558 containerd[1382]: time="2024-12-13T13:26:08.669525052Z" level=info msg="loading plugin \"io.containerd.ttrpc.v1.task\"..." runtime=io.containerd.runc.v2 type=io.containerd.ttrpc.v1 Dec 13 13:26:08.669971 containerd[1382]: time="2024-12-13T13:26:08.669593726Z" level=info msg="loading plugin \"io.containerd.ttrpc.v1.pause\"..." runtime=io.containerd.runc.v2 type=io.containerd.ttrpc.v1 Dec 13 13:26:08.690959 systemd[1]: Started docker-7d6d064845ae1230365bc275d90eb03c16701e7b1536f0ab6acd7c155bab31b5.scope - libcontainer container 7d6d064845ae1230365bc275d90eb03c16701e7b1536f0ab6acd7c155bab31b5. Dec 13 13:26:08.700978 systemd-resolved[1257]: Failed to determine the local hostname and LLMNR/mDNS names, ignoring: No such device or address Dec 13 13:26:08.745253 etcd-wrapper[1666]: {"level":"info","ts":"2024-12-13T13:26:08.744893Z","caller":"flags/flag.go:113","msg":"recognized and used environment variable","variable-name":"ETCD_DATA_DIR","variable-value":"/var/lib/etcd"} Dec 13 13:26:08.745253 etcd-wrapper[1666]: {"level":"info","ts":"2024-12-13T13:26:08.745064Z","caller":"flags/flag.go:113","msg":"recognized and used environment variable","variable-name":"ETCD_NAME","variable-value":"01b648ea6e5444df9cbbe1471c33961e"} Dec 13 13:26:08.745253 etcd-wrapper[1666]: {"level":"warn","ts":"2024-12-13T13:26:08.745106Z","caller":"flags/flag.go:93","msg":"unrecognized environment variable","environment-variable":"ETCD_IMAGE_URL=quay.io/coreos/etcd"} Dec 13 13:26:08.745253 etcd-wrapper[1666]: {"level":"warn","ts":"2024-12-13T13:26:08.745139Z","caller":"flags/flag.go:93","msg":"unrecognized environment variable","environment-variable":"ETCD_IMAGE_TAG=v3.5.16"} Dec 13 13:26:08.745253 etcd-wrapper[1666]: {"level":"warn","ts":"2024-12-13T13:26:08.745158Z","caller":"flags/flag.go:93","msg":"unrecognized environment variable","environment-variable":"ETCD_USER=etcd"} Dec 13 13:26:08.745253 etcd-wrapper[1666]: {"level":"warn","ts":"2024-12-13T13:26:08.745174Z","caller":"flags/flag.go:93","msg":"unrecognized environment variable","environment-variable":"ETCD_SSL_DIR=/etc/ssl/certs"} Dec 13 13:26:08.745560 etcd-wrapper[1666]: {"level":"warn","ts":"2024-12-13T13:26:08.745356Z","caller":"embed/config.go:689","msg":"Running http and grpc server on single port. This is not recommended for production."} Dec 13 13:26:08.745560 etcd-wrapper[1666]: {"level":"info","ts":"2024-12-13T13:26:08.745427Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["/usr/local/bin/etcd","--listen-client-urls=http://0.0.0.0:2379","--advertise-client-urls=http://10.0.0.120:2379"]} Dec 13 13:26:08.745852 etcd-wrapper[1666]: {"level":"warn","ts":"2024-12-13T13:26:08.745516Z","caller":"embed/config.go:689","msg":"Running http and grpc server on single port. This is not recommended for production."} Dec 13 13:26:08.745852 etcd-wrapper[1666]: {"level":"info","ts":"2024-12-13T13:26:08.745561Z","caller":"embed/etcd.go:128","msg":"configuring peer listeners","listen-peer-urls":["http://localhost:2380"]} Dec 13 13:26:08.746377 etcd-wrapper[1666]: {"level":"info","ts":"2024-12-13T13:26:08.745998Z","caller":"embed/etcd.go:136","msg":"configuring client listeners","listen-client-urls":["http://0.0.0.0:2379"]} Dec 13 13:26:08.746614 etcd-wrapper[1666]: {"level":"info","ts":"2024-12-13T13:26:08.746408Z","caller":"embed/etcd.go:311","msg":"starting an etcd server","etcd-version":"3.5.16","git-sha":"f20bbad","go-version":"go1.22.7","go-os":"linux","go-arch":"arm64","max-cpu-set":4,"max-cpu-available":4,"member-initialized":false,"name":"01b648ea6e5444df9cbbe1471c33961e","data-dir":"/var/lib/etcd","wal-dir":"","wal-dir-dedicated":"","member-dir":"/var/lib/etcd/member","force-new-cluster":false,"heartbeat-interval":"100ms","election-timeout":"1s","initial-election-tick-advance":true,"snapshot-count":100000,"max-wals":5,"max-snapshots":5,"snapshot-catchup-entries":5000,"initial-advertise-peer-urls":["http://localhost:2380"],"listen-peer-urls":["http://localhost:2380"],"advertise-client-urls":["http://10.0.0.120:2379"],"listen-client-urls":["http://0.0.0.0:2379"],"listen-metrics-urls":[],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"01b648ea6e5444df9cbbe1471c33961e=http://localhost:2380","initial-cluster-state":"new","initial-cluster-token":"etcd-cluster","quota-backend-bytes":2147483648,"max-request-bytes":1572864,"max-concurrent-streams":4294967295,"pre-vote":true,"initial-corrupt-check":false,"corrupt-check-time-interval":"0s","compact-check-time-enabled":false,"compact-check-time-interval":"1m0s","auto-compaction-mode":"periodic","auto-compaction-retention":"0s","auto-compaction-interval":"0s","discovery-url":"","discovery-proxy":"","downgrade-check-interval":"5s"} Dec 13 13:26:08.748631 etcd-wrapper[1666]: {"level":"info","ts":"2024-12-13T13:26:08.748407Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"1.583022ms"} Dec 13 13:26:08.751248 etcd-wrapper[1666]: {"level":"info","ts":"2024-12-13T13:26:08.751068Z","caller":"etcdserver/raft.go:505","msg":"starting local member","local-member-id":"8e9e05c52164694d","cluster-id":"cdf818194e3a8c32"} Dec 13 13:26:08.751390 etcd-wrapper[1666]: {"level":"info","ts":"2024-12-13T13:26:08.751269Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"8e9e05c52164694d switched to configuration voters=()"} Dec 13 13:26:08.751390 etcd-wrapper[1666]: {"level":"info","ts":"2024-12-13T13:26:08.751299Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"8e9e05c52164694d became follower at term 0"} Dec 13 13:26:08.751390 etcd-wrapper[1666]: {"level":"info","ts":"2024-12-13T13:26:08.751309Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 8e9e05c52164694d [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} Dec 13 13:26:08.751533 etcd-wrapper[1666]: {"level":"info","ts":"2024-12-13T13:26:08.751319Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"8e9e05c52164694d became follower at term 1"} Dec 13 13:26:08.751533 etcd-wrapper[1666]: {"level":"info","ts":"2024-12-13T13:26:08.751364Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"8e9e05c52164694d switched to configuration voters=(10276657743932975437)"} Dec 13 13:26:08.753480 etcd-wrapper[1666]: {"level":"warn","ts":"2024-12-13T13:26:08.753306Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} Dec 13 13:26:08.754759 etcd-wrapper[1666]: {"level":"info","ts":"2024-12-13T13:26:08.754600Z","caller":"mvcc/kvstore.go:423","msg":"kvstore restored","current-rev":1} Dec 13 13:26:08.755251 etcd-wrapper[1666]: {"level":"info","ts":"2024-12-13T13:26:08.755130Z","caller":"etcdserver/quota.go:94","msg":"enabled backend quota with default value","quota-name":"v3-applier","quota-size-bytes":2147483648,"quota-size":"2.1 GB"} Dec 13 13:26:08.756079 etcd-wrapper[1666]: {"level":"info","ts":"2024-12-13T13:26:08.755626Z","caller":"etcdserver/server.go:873","msg":"starting etcd server","local-member-id":"8e9e05c52164694d","local-server-version":"3.5.16","cluster-version":"to_be_decided"} Dec 13 13:26:08.756079 etcd-wrapper[1666]: {"level":"info","ts":"2024-12-13T13:26:08.755821Z","caller":"v3rpc/health.go:61","msg":"grpc service status changed","service":"","status":"SERVING"} Dec 13 13:26:08.756079 etcd-wrapper[1666]: {"level":"info","ts":"2024-12-13T13:26:08.755826Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/snap","suffix":"snap.db","max":5,"interval":"30s"} Dec 13 13:26:08.756079 etcd-wrapper[1666]: {"level":"info","ts":"2024-12-13T13:26:08.755864Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/snap","suffix":"snap","max":5,"interval":"30s"} Dec 13 13:26:08.756079 etcd-wrapper[1666]: {"level":"info","ts":"2024-12-13T13:26:08.755871Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/wal","suffix":"wal","max":5,"interval":"30s"} Dec 13 13:26:08.756079 etcd-wrapper[1666]: {"level":"info","ts":"2024-12-13T13:26:08.755834Z","caller":"etcdserver/server.go:757","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"8e9e05c52164694d","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} Dec 13 13:26:08.756341 etcd-wrapper[1666]: {"level":"info","ts":"2024-12-13T13:26:08.756186Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"8e9e05c52164694d switched to configuration voters=(10276657743932975437)"} Dec 13 13:26:08.756520 etcd-wrapper[1666]: {"level":"info","ts":"2024-12-13T13:26:08.756360Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"cdf818194e3a8c32","local-member-id":"8e9e05c52164694d","added-peer-id":"8e9e05c52164694d","added-peer-peer-urls":["http://localhost:2380"]} Dec 13 13:26:08.757428 etcd-wrapper[1666]: {"level":"info","ts":"2024-12-13T13:26:08.757297Z","caller":"embed/etcd.go:600","msg":"serving peer traffic","address":"127.0.0.1:2380"} Dec 13 13:26:08.757428 etcd-wrapper[1666]: {"level":"info","ts":"2024-12-13T13:26:08.757319Z","caller":"embed/etcd.go:572","msg":"cmux::serve","address":"127.0.0.1:2380"} Dec 13 13:26:08.757506 etcd-wrapper[1666]: {"level":"info","ts":"2024-12-13T13:26:08.757349Z","caller":"embed/etcd.go:280","msg":"now serving peer/client/metrics","local-member-id":"8e9e05c52164694d","initial-advertise-peer-urls":["http://localhost:2380"],"listen-peer-urls":["http://localhost:2380"],"advertise-client-urls":["http://10.0.0.120:2379"],"listen-client-urls":["http://0.0.0.0:2379"],"listen-metrics-urls":[]} Dec 13 13:26:08.852039 etcd-wrapper[1666]: {"level":"info","ts":"2024-12-13T13:26:08.851742Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"8e9e05c52164694d is starting a new election at term 1"} Dec 13 13:26:08.852039 etcd-wrapper[1666]: {"level":"info","ts":"2024-12-13T13:26:08.851766Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"8e9e05c52164694d became pre-candidate at term 1"} Dec 13 13:26:08.852039 etcd-wrapper[1666]: {"level":"info","ts":"2024-12-13T13:26:08.851784Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"8e9e05c52164694d received MsgPreVoteResp from 8e9e05c52164694d at term 1"} Dec 13 13:26:08.852039 etcd-wrapper[1666]: {"level":"info","ts":"2024-12-13T13:26:08.851807Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"8e9e05c52164694d became candidate at term 2"} Dec 13 13:26:08.852039 etcd-wrapper[1666]: {"level":"info","ts":"2024-12-13T13:26:08.851814Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"8e9e05c52164694d received MsgVoteResp from 8e9e05c52164694d at term 2"} Dec 13 13:26:08.852039 etcd-wrapper[1666]: {"level":"info","ts":"2024-12-13T13:26:08.851822Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"8e9e05c52164694d became leader at term 2"} Dec 13 13:26:08.852039 etcd-wrapper[1666]: {"level":"info","ts":"2024-12-13T13:26:08.851844Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 8e9e05c52164694d elected leader 8e9e05c52164694d at term 2"} Dec 13 13:26:08.852620 etcd-wrapper[1666]: {"level":"info","ts":"2024-12-13T13:26:08.852483Z","caller":"etcdserver/server.go:2651","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} Dec 13 13:26:08.853041 etcd-wrapper[1666]: {"level":"info","ts":"2024-12-13T13:26:08.852887Z","caller":"etcdserver/server.go:2140","msg":"published local member to cluster through raft","local-member-id":"8e9e05c52164694d","local-member-attributes":"{Name:01b648ea6e5444df9cbbe1471c33961e ClientURLs:[http://10.0.0.120:2379]}","request-path":"/0/members/8e9e05c52164694d/attributes","cluster-id":"cdf818194e3a8c32","publish-timeout":"7s"} Dec 13 13:26:08.853041 etcd-wrapper[1666]: {"level":"info","ts":"2024-12-13T13:26:08.852940Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} Dec 13 13:26:08.854104 etcd-wrapper[1666]: {"level":"info","ts":"2024-12-13T13:26:08.853136Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} Dec 13 13:26:08.854104 etcd-wrapper[1666]: {"level":"info","ts":"2024-12-13T13:26:08.853275Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"cdf818194e3a8c32","local-member-id":"8e9e05c52164694d","cluster-version":"3.5"} Dec 13 13:26:08.854104 etcd-wrapper[1666]: {"level":"info","ts":"2024-12-13T13:26:08.853290Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} Dec 13 13:26:08.854104 etcd-wrapper[1666]: {"level":"info","ts":"2024-12-13T13:26:08.853337Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} Dec 13 13:26:08.854104 etcd-wrapper[1666]: {"level":"info","ts":"2024-12-13T13:26:08.853346Z","caller":"v3rpc/health.go:61","msg":"grpc service status changed","service":"","status":"SERVING"} Dec 13 13:26:08.854104 etcd-wrapper[1666]: {"level":"info","ts":"2024-12-13T13:26:08.853354Z","caller":"etcdserver/server.go:2675","msg":"cluster version is updated","cluster-version":"3.5"} Dec 13 13:26:08.853873 systemd[1]: Started etcd-member.service - etcd (System Application Container). Dec 13 13:26:08.854419 etcd-wrapper[1666]: {"level":"info","ts":"2024-12-13T13:26:08.853701Z","caller":"embed/serve.go:187","msg":"serving client traffic insecurely; this is strongly discouraged!","traffic":"grpc+http","address":"[::]:2379"} Dec 13 13:26:08.854156 systemd[1]: Reached target multi-user.target - Multi-User System. Dec 13 13:26:08.854282 systemd[1]: Startup finished in 540ms (kernel) + 3.511s (initrd) + 7.675s (userspace) = 11.726s. Dec 13 13:26:10.505546 systemd[1]: Created slice system-sshd.slice - Slice /system/sshd. Dec 13 13:26:10.506798 systemd[1]: Started sshd@0-10.0.0.120:22-10.0.0.1:54716.service - OpenSSH per-connection server daemon (10.0.0.1:54716). Dec 13 13:26:10.590402 sshd[1815]: Accepted publickey for core from 10.0.0.1 port 54716 ssh2: RSA SHA256:q9cWvSR3bBxu+L28Z4JmOHhvW5qF2BbU+1GVJNGhIf4 Dec 13 13:26:10.598235 sshd-session[1815]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Dec 13 13:26:10.606532 systemd-logind[1369]: New session 1 of user core. Dec 13 13:26:10.607566 systemd[1]: Created slice user-500.slice - User Slice of UID 500. Dec 13 13:26:10.615040 systemd[1]: Starting user-runtime-dir@500.service - User Runtime Directory /run/user/500... Dec 13 13:26:10.624792 systemd[1]: Finished user-runtime-dir@500.service - User Runtime Directory /run/user/500. Dec 13 13:26:10.627079 systemd[1]: Starting user@500.service - User Manager for UID 500... Dec 13 13:26:10.634213 (systemd)[1819]: pam_unix(systemd-user:session): session opened for user core(uid=500) by (uid=0) Dec 13 13:26:10.722447 systemd[1819]: Queued start job for default target default.target. Dec 13 13:26:10.732801 systemd[1819]: Created slice app.slice - User Application Slice. Dec 13 13:26:10.732851 systemd[1819]: Reached target paths.target - Paths. Dec 13 13:26:10.732863 systemd[1819]: Reached target timers.target - Timers. Dec 13 13:26:10.734130 systemd[1819]: Starting dbus.socket - D-Bus User Message Bus Socket... Dec 13 13:26:10.744253 systemd[1819]: Listening on dbus.socket - D-Bus User Message Bus Socket. Dec 13 13:26:10.744319 systemd[1819]: Reached target sockets.target - Sockets. Dec 13 13:26:10.744331 systemd[1819]: Reached target basic.target - Basic System. Dec 13 13:26:10.744371 systemd[1819]: Reached target default.target - Main User Target. Dec 13 13:26:10.744399 systemd[1819]: Startup finished in 104ms. Dec 13 13:26:10.744651 systemd[1]: Started user@500.service - User Manager for UID 500. Dec 13 13:26:10.745979 systemd[1]: Started session-1.scope - Session 1 of User core. Dec 13 13:26:10.826338 systemd[1]: Started sshd@1-10.0.0.120:22-10.0.0.1:54728.service - OpenSSH per-connection server daemon (10.0.0.1:54728). Dec 13 13:26:10.864076 sshd[1830]: Accepted publickey for core from 10.0.0.1 port 54728 ssh2: RSA SHA256:q9cWvSR3bBxu+L28Z4JmOHhvW5qF2BbU+1GVJNGhIf4 Dec 13 13:26:10.865278 sshd-session[1830]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Dec 13 13:26:10.868977 systemd-logind[1369]: New session 2 of user core. Dec 13 13:26:10.877948 systemd[1]: Started session-2.scope - Session 2 of User core. Dec 13 13:26:10.929335 sshd[1832]: Connection closed by 10.0.0.1 port 54728 Dec 13 13:26:10.929723 sshd-session[1830]: pam_unix(sshd:session): session closed for user core Dec 13 13:26:10.942127 systemd[1]: sshd@1-10.0.0.120:22-10.0.0.1:54728.service: Deactivated successfully. Dec 13 13:26:10.943599 systemd[1]: session-2.scope: Deactivated successfully. Dec 13 13:26:10.945177 systemd-logind[1369]: Session 2 logged out. Waiting for processes to exit. Dec 13 13:26:10.946344 systemd[1]: Started sshd@2-10.0.0.120:22-10.0.0.1:54740.service - OpenSSH per-connection server daemon (10.0.0.1:54740). Dec 13 13:26:10.947137 systemd-logind[1369]: Removed session 2. Dec 13 13:26:10.989731 sshd[1837]: Accepted publickey for core from 10.0.0.1 port 54740 ssh2: RSA SHA256:q9cWvSR3bBxu+L28Z4JmOHhvW5qF2BbU+1GVJNGhIf4 Dec 13 13:26:10.991121 sshd-session[1837]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Dec 13 13:26:10.995374 systemd-logind[1369]: New session 3 of user core. Dec 13 13:26:11.011001 systemd[1]: Started session-3.scope - Session 3 of User core. Dec 13 13:26:11.059155 sshd[1839]: Connection closed by 10.0.0.1 port 54740 Dec 13 13:26:11.059896 sshd-session[1837]: pam_unix(sshd:session): session closed for user core Dec 13 13:26:11.068675 systemd[1]: sshd@2-10.0.0.120:22-10.0.0.1:54740.service: Deactivated successfully. Dec 13 13:26:11.070601 systemd[1]: session-3.scope: Deactivated successfully. Dec 13 13:26:11.072560 systemd-logind[1369]: Session 3 logged out. Waiting for processes to exit. Dec 13 13:26:11.081099 systemd[1]: Started sshd@3-10.0.0.120:22-10.0.0.1:54752.service - OpenSSH per-connection server daemon (10.0.0.1:54752). Dec 13 13:26:11.082727 systemd-logind[1369]: Removed session 3. Dec 13 13:26:11.119540 sshd[1844]: Accepted publickey for core from 10.0.0.1 port 54752 ssh2: RSA SHA256:q9cWvSR3bBxu+L28Z4JmOHhvW5qF2BbU+1GVJNGhIf4 Dec 13 13:26:11.120770 sshd-session[1844]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Dec 13 13:26:11.124844 systemd-logind[1369]: New session 4 of user core. Dec 13 13:26:11.132958 systemd[1]: Started session-4.scope - Session 4 of User core. Dec 13 13:26:11.184587 sshd[1846]: Connection closed by 10.0.0.1 port 54752 Dec 13 13:26:11.185223 sshd-session[1844]: pam_unix(sshd:session): session closed for user core Dec 13 13:26:11.195341 systemd[1]: sshd@3-10.0.0.120:22-10.0.0.1:54752.service: Deactivated successfully. Dec 13 13:26:11.197155 systemd[1]: session-4.scope: Deactivated successfully. Dec 13 13:26:11.198427 systemd-logind[1369]: Session 4 logged out. Waiting for processes to exit. Dec 13 13:26:11.199733 systemd[1]: Started sshd@4-10.0.0.120:22-10.0.0.1:54754.service - OpenSSH per-connection server daemon (10.0.0.1:54754). Dec 13 13:26:11.200505 systemd-logind[1369]: Removed session 4. Dec 13 13:26:11.242329 sshd[1851]: Accepted publickey for core from 10.0.0.1 port 54754 ssh2: RSA SHA256:q9cWvSR3bBxu+L28Z4JmOHhvW5qF2BbU+1GVJNGhIf4 Dec 13 13:26:11.243506 sshd-session[1851]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Dec 13 13:26:11.246957 systemd-logind[1369]: New session 5 of user core. Dec 13 13:26:11.254969 systemd[1]: Started session-5.scope - Session 5 of User core. Dec 13 13:26:11.317842 sudo[1854]: core : PWD=/home/core ; USER=root ; COMMAND=/usr/sbin/setenforce 1 Dec 13 13:26:11.318115 sudo[1854]: pam_unix(sudo:session): session opened for user root(uid=0) by core(uid=500) Dec 13 13:26:11.333604 sudo[1854]: pam_unix(sudo:session): session closed for user root Dec 13 13:26:11.334899 sshd[1853]: Connection closed by 10.0.0.1 port 54754 Dec 13 13:26:11.335180 sshd-session[1851]: pam_unix(sshd:session): session closed for user core Dec 13 13:26:11.348926 systemd[1]: sshd@4-10.0.0.120:22-10.0.0.1:54754.service: Deactivated successfully. Dec 13 13:26:11.350236 systemd[1]: session-5.scope: Deactivated successfully. Dec 13 13:26:11.352663 systemd-logind[1369]: Session 5 logged out. Waiting for processes to exit. Dec 13 13:26:11.353934 systemd[1]: Started sshd@5-10.0.0.120:22-10.0.0.1:54756.service - OpenSSH per-connection server daemon (10.0.0.1:54756). Dec 13 13:26:11.354687 systemd-logind[1369]: Removed session 5. Dec 13 13:26:11.396013 sshd[1859]: Accepted publickey for core from 10.0.0.1 port 54756 ssh2: RSA SHA256:q9cWvSR3bBxu+L28Z4JmOHhvW5qF2BbU+1GVJNGhIf4 Dec 13 13:26:11.397169 sshd-session[1859]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Dec 13 13:26:11.400866 systemd-logind[1369]: New session 6 of user core. Dec 13 13:26:11.412952 systemd[1]: Started session-6.scope - Session 6 of User core. Dec 13 13:26:11.463544 sudo[1863]: 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 Dec 13 13:26:11.464115 sudo[1863]: pam_unix(sudo:session): session opened for user root(uid=0) by core(uid=500) Dec 13 13:26:11.467111 sudo[1863]: pam_unix(sudo:session): session closed for user root Dec 13 13:26:11.471440 sudo[1862]: core : PWD=/home/core ; USER=root ; COMMAND=/usr/sbin/systemctl restart audit-rules Dec 13 13:26:11.471696 sudo[1862]: pam_unix(sudo:session): session opened for user root(uid=0) by core(uid=500) Dec 13 13:26:11.486078 systemd[1]: Starting audit-rules.service - Load Audit Rules... Dec 13 13:26:11.507943 augenrules[1885]: No rules Dec 13 13:26:11.508990 systemd[1]: audit-rules.service: Deactivated successfully. Dec 13 13:26:11.509205 systemd[1]: Finished audit-rules.service - Load Audit Rules. Dec 13 13:26:11.510087 sudo[1862]: pam_unix(sudo:session): session closed for user root Dec 13 13:26:11.511878 sshd[1861]: Connection closed by 10.0.0.1 port 54756 Dec 13 13:26:11.511760 sshd-session[1859]: pam_unix(sshd:session): session closed for user core Dec 13 13:26:11.527168 systemd[1]: sshd@5-10.0.0.120:22-10.0.0.1:54756.service: Deactivated successfully. Dec 13 13:26:11.528411 systemd[1]: session-6.scope: Deactivated successfully. Dec 13 13:26:11.530909 systemd-logind[1369]: Session 6 logged out. Waiting for processes to exit. Dec 13 13:26:11.542135 systemd[1]: Started sshd@6-10.0.0.120:22-10.0.0.1:54772.service - OpenSSH per-connection server daemon (10.0.0.1:54772). Dec 13 13:26:11.545129 systemd-logind[1369]: Removed session 6. Dec 13 13:26:11.580242 sshd[1893]: Accepted publickey for core from 10.0.0.1 port 54772 ssh2: RSA SHA256:q9cWvSR3bBxu+L28Z4JmOHhvW5qF2BbU+1GVJNGhIf4 Dec 13 13:26:11.581313 sshd-session[1893]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Dec 13 13:26:11.584505 systemd-logind[1369]: New session 7 of user core. Dec 13 13:26:11.594997 systemd[1]: Started session-7.scope - Session 7 of User core. Dec 13 13:26:11.642779 sshd[1896]: Connection closed by 10.0.0.1 port 54772 Dec 13 13:26:11.643160 sshd-session[1893]: pam_unix(sshd:session): session closed for user core Dec 13 13:26:11.659876 systemd[1]: sshd@6-10.0.0.120:22-10.0.0.1:54772.service: Deactivated successfully. Dec 13 13:26:11.661208 systemd[1]: session-7.scope: Deactivated successfully. Dec 13 13:26:11.663868 systemd-logind[1369]: Session 7 logged out. Waiting for processes to exit. Dec 13 13:26:11.664856 systemd[1]: Started sshd@7-10.0.0.120:22-10.0.0.1:54784.service - OpenSSH per-connection server daemon (10.0.0.1:54784). Dec 13 13:26:11.665553 systemd-logind[1369]: Removed session 7. Dec 13 13:26:11.705282 sshd[1903]: Accepted publickey for core from 10.0.0.1 port 54784 ssh2: RSA SHA256:q9cWvSR3bBxu+L28Z4JmOHhvW5qF2BbU+1GVJNGhIf4 Dec 13 13:26:11.706274 sshd-session[1903]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Dec 13 13:26:11.709858 systemd-logind[1369]: New session 8 of user core. Dec 13 13:26:11.715934 systemd[1]: Started session-8.scope - Session 8 of User core. Dec 13 13:26:11.825553 sshd[1905]: Connection closed by 10.0.0.1 port 54784 Dec 13 13:26:11.825877 sshd-session[1903]: pam_unix(sshd:session): session closed for user core Dec 13 13:26:11.828751 systemd[1]: sshd@7-10.0.0.120:22-10.0.0.1:54784.service: Deactivated successfully. Dec 13 13:26:11.832146 systemd[1]: session-8.scope: Deactivated successfully. Dec 13 13:26:11.832683 systemd-logind[1369]: Session 8 logged out. Waiting for processes to exit. Dec 13 13:26:11.833432 systemd-logind[1369]: Removed session 8. Dec 13 13:26:48.165623 update_engine[1372]: I20241213 13:26:48.165035 1372 update_attempter.cc:509] Updating boot flags... Dec 13 13:26:48.195944 kernel: BTRFS warning: duplicate device /dev/vda3 devid 1 generation 38 scanned by (udev-worker) (1925) Dec 13 13:26:48.230816 kernel: BTRFS warning: duplicate device /dev/vda3 devid 1 generation 38 scanned by (udev-worker) (1923)