Jan 30 12:44:08.091593 kernel: Booting Linux on physical CPU 0x0000000000 [0x413fd0c1] Jan 30 12:44:08.091614 kernel: Linux version 6.6.74-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 Wed Jan 29 09:30:22 -00 2025 Jan 30 12:44:08.091634 kernel: KASLR enabled Jan 30 12:44:08.091641 kernel: efi: EFI v2.7 by EDK II Jan 30 12:44:08.091647 kernel: efi: SMBIOS 3.0=0xdced0000 MEMATTR=0xdbbae018 ACPI 2.0=0xd9b43018 RNG=0xd9b43a18 MEMRESERVE=0xd9b40218 Jan 30 12:44:08.091653 kernel: random: crng init done Jan 30 12:44:08.091660 kernel: secureboot: Secure boot disabled Jan 30 12:44:08.091666 kernel: ACPI: Early table checksum verification disabled Jan 30 12:44:08.091672 kernel: ACPI: RSDP 0x00000000D9B43018 000024 (v02 BOCHS ) Jan 30 12:44:08.091681 kernel: ACPI: XSDT 0x00000000D9B43F18 000064 (v01 BOCHS BXPC 00000001 01000013) Jan 30 12:44:08.091687 kernel: ACPI: FACP 0x00000000D9B43B18 000114 (v06 BOCHS BXPC 00000001 BXPC 00000001) Jan 30 12:44:08.091693 kernel: ACPI: DSDT 0x00000000D9B41018 0014A2 (v02 BOCHS BXPC 00000001 BXPC 00000001) Jan 30 12:44:08.091699 kernel: ACPI: APIC 0x00000000D9B43C98 0001A8 (v04 BOCHS BXPC 00000001 BXPC 00000001) Jan 30 12:44:08.091705 kernel: ACPI: PPTT 0x00000000D9B43098 00009C (v02 BOCHS BXPC 00000001 BXPC 00000001) Jan 30 12:44:08.091713 kernel: ACPI: GTDT 0x00000000D9B43818 000060 (v02 BOCHS BXPC 00000001 BXPC 00000001) Jan 30 12:44:08.091720 kernel: ACPI: MCFG 0x00000000D9B43A98 00003C (v01 BOCHS BXPC 00000001 BXPC 00000001) Jan 30 12:44:08.091727 kernel: ACPI: SPCR 0x00000000D9B43918 000050 (v02 BOCHS BXPC 00000001 BXPC 00000001) Jan 30 12:44:08.091733 kernel: ACPI: DBG2 0x00000000D9B43998 000057 (v00 BOCHS BXPC 00000001 BXPC 00000001) Jan 30 12:44:08.091740 kernel: ACPI: IORT 0x00000000D9B43198 000080 (v03 BOCHS BXPC 00000001 BXPC 00000001) Jan 30 12:44:08.091746 kernel: ACPI: SPCR: console: pl011,mmio,0x9000000,9600 Jan 30 12:44:08.091752 kernel: NUMA: Failed to initialise from firmware Jan 30 12:44:08.091758 kernel: NUMA: Faking a node at [mem 0x0000000040000000-0x00000000dcffffff] Jan 30 12:44:08.091765 kernel: NUMA: NODE_DATA [mem 0xdc959800-0xdc95efff] Jan 30 12:44:08.091771 kernel: Zone ranges: Jan 30 12:44:08.091777 kernel: DMA [mem 0x0000000040000000-0x00000000dcffffff] Jan 30 12:44:08.091785 kernel: DMA32 empty Jan 30 12:44:08.091791 kernel: Normal empty Jan 30 12:44:08.091805 kernel: Movable zone start for each node Jan 30 12:44:08.091812 kernel: Early memory node ranges Jan 30 12:44:08.091818 kernel: node 0: [mem 0x0000000040000000-0x00000000d967ffff] Jan 30 12:44:08.091825 kernel: node 0: [mem 0x00000000d9680000-0x00000000d968ffff] Jan 30 12:44:08.091831 kernel: node 0: [mem 0x00000000d9690000-0x00000000d976ffff] Jan 30 12:44:08.091837 kernel: node 0: [mem 0x00000000d9770000-0x00000000d9b3ffff] Jan 30 12:44:08.091843 kernel: node 0: [mem 0x00000000d9b40000-0x00000000dce1ffff] Jan 30 12:44:08.091850 kernel: node 0: [mem 0x00000000dce20000-0x00000000dceaffff] Jan 30 12:44:08.091856 kernel: node 0: [mem 0x00000000dceb0000-0x00000000dcebffff] Jan 30 12:44:08.091862 kernel: node 0: [mem 0x00000000dcec0000-0x00000000dcfdffff] Jan 30 12:44:08.091871 kernel: node 0: [mem 0x00000000dcfe0000-0x00000000dcffffff] Jan 30 12:44:08.091877 kernel: Initmem setup node 0 [mem 0x0000000040000000-0x00000000dcffffff] Jan 30 12:44:08.091884 kernel: On node 0, zone DMA: 12288 pages in unavailable ranges Jan 30 12:44:08.091893 kernel: psci: probing for conduit method from ACPI. Jan 30 12:44:08.091900 kernel: psci: PSCIv1.1 detected in firmware. Jan 30 12:44:08.091906 kernel: psci: Using standard PSCI v0.2 function IDs Jan 30 12:44:08.091915 kernel: psci: Trusted OS migration not required Jan 30 12:44:08.091921 kernel: psci: SMC Calling Convention v1.1 Jan 30 12:44:08.091928 kernel: smccc: KVM: hypervisor services detected (0x00000000 0x00000000 0x00000000 0x00000003) Jan 30 12:44:08.091935 kernel: percpu: Embedded 31 pages/cpu s86696 r8192 d32088 u126976 Jan 30 12:44:08.091941 kernel: pcpu-alloc: s86696 r8192 d32088 u126976 alloc=31*4096 Jan 30 12:44:08.091948 kernel: pcpu-alloc: [0] 0 [0] 1 [0] 2 [0] 3 Jan 30 12:44:08.091955 kernel: Detected PIPT I-cache on CPU0 Jan 30 12:44:08.091962 kernel: CPU features: detected: GIC system register CPU interface Jan 30 12:44:08.091968 kernel: CPU features: detected: Hardware dirty bit management Jan 30 12:44:08.091975 kernel: CPU features: detected: Spectre-v4 Jan 30 12:44:08.091983 kernel: CPU features: detected: Spectre-BHB Jan 30 12:44:08.091990 kernel: CPU features: kernel page table isolation forced ON by KASLR Jan 30 12:44:08.091997 kernel: CPU features: detected: Kernel page table isolation (KPTI) Jan 30 12:44:08.092003 kernel: CPU features: detected: ARM erratum 1418040 Jan 30 12:44:08.092010 kernel: CPU features: detected: SSBS not fully self-synchronizing Jan 30 12:44:08.092016 kernel: alternatives: applying boot alternatives Jan 30 12:44:08.092024 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=e6957044c3256d96283265c263579aa4275d1d707b02496fcb081f5fc6356346 Jan 30 12:44:08.092031 kernel: Unknown kernel command line parameters "BOOT_IMAGE=/flatcar/vmlinuz-a", will be passed to user space. Jan 30 12:44:08.092038 kernel: Dentry cache hash table entries: 524288 (order: 10, 4194304 bytes, linear) Jan 30 12:44:08.092045 kernel: Inode-cache hash table entries: 262144 (order: 9, 2097152 bytes, linear) Jan 30 12:44:08.092053 kernel: Fallback order for Node 0: 0 Jan 30 12:44:08.092061 kernel: Built 1 zonelists, mobility grouping on. Total pages: 633024 Jan 30 12:44:08.092068 kernel: Policy zone: DMA Jan 30 12:44:08.092074 kernel: mem auto-init: stack:off, heap alloc:off, heap free:off Jan 30 12:44:08.092081 kernel: software IO TLB: area num 4. Jan 30 12:44:08.092087 kernel: software IO TLB: mapped [mem 0x00000000d2e00000-0x00000000d6e00000] (64MB) Jan 30 12:44:08.092094 kernel: Memory: 2385944K/2572288K available (10304K kernel code, 2186K rwdata, 8092K rodata, 39936K init, 897K bss, 186344K reserved, 0K cma-reserved) Jan 30 12:44:08.092101 kernel: SLUB: HWalign=64, Order=0-3, MinObjects=0, CPUs=4, Nodes=1 Jan 30 12:44:08.092108 kernel: rcu: Preemptible hierarchical RCU implementation. Jan 30 12:44:08.092117 kernel: rcu: RCU event tracing is enabled. Jan 30 12:44:08.092124 kernel: rcu: RCU restricting CPUs from NR_CPUS=512 to nr_cpu_ids=4. Jan 30 12:44:08.092132 kernel: Trampoline variant of Tasks RCU enabled. Jan 30 12:44:08.092139 kernel: Tracing variant of Tasks RCU enabled. Jan 30 12:44:08.092148 kernel: rcu: RCU calculated value of scheduler-enlistment delay is 100 jiffies. Jan 30 12:44:08.092155 kernel: rcu: Adjusting geometry for rcu_fanout_leaf=16, nr_cpu_ids=4 Jan 30 12:44:08.092163 kernel: NR_IRQS: 64, nr_irqs: 64, preallocated irqs: 0 Jan 30 12:44:08.092170 kernel: GICv3: 256 SPIs implemented Jan 30 12:44:08.092176 kernel: GICv3: 0 Extended SPIs implemented Jan 30 12:44:08.092183 kernel: Root IRQ handler: gic_handle_irq Jan 30 12:44:08.092189 kernel: GICv3: GICv3 features: 16 PPIs, DirectLPI Jan 30 12:44:08.092196 kernel: GICv3: CPU0: found redistributor 0 region 0:0x00000000080a0000 Jan 30 12:44:08.092202 kernel: ITS [mem 0x08080000-0x0809ffff] Jan 30 12:44:08.092290 kernel: ITS@0x0000000008080000: allocated 8192 Devices @400c0000 (indirect, esz 8, psz 64K, shr 1) Jan 30 12:44:08.092297 kernel: ITS@0x0000000008080000: allocated 8192 Interrupt Collections @400d0000 (flat, esz 8, psz 64K, shr 1) Jan 30 12:44:08.092310 kernel: GICv3: using LPI property table @0x00000000400f0000 Jan 30 12:44:08.092317 kernel: GICv3: CPU0: using allocated LPI pending table @0x0000000040100000 Jan 30 12:44:08.092325 kernel: rcu: srcu_init: Setting srcu_struct sizes based on contention. Jan 30 12:44:08.092332 kernel: arch_timer: Enabling local workaround for ARM erratum 1418040 Jan 30 12:44:08.092338 kernel: arch_timer: cp15 timer(s) running at 25.00MHz (virt). Jan 30 12:44:08.092345 kernel: clocksource: arch_sys_counter: mask: 0xffffffffffffff max_cycles: 0x5c40939b5, max_idle_ns: 440795202646 ns Jan 30 12:44:08.092352 kernel: sched_clock: 56 bits at 25MHz, resolution 40ns, wraps every 4398046511100ns Jan 30 12:44:08.092358 kernel: arm-pv: using stolen time PV Jan 30 12:44:08.092366 kernel: Console: colour dummy device 80x25 Jan 30 12:44:08.092372 kernel: ACPI: Core revision 20230628 Jan 30 12:44:08.092380 kernel: Calibrating delay loop (skipped), value calculated using timer frequency.. 50.00 BogoMIPS (lpj=25000) Jan 30 12:44:08.092389 kernel: pid_max: default: 32768 minimum: 301 Jan 30 12:44:08.092396 kernel: LSM: initializing lsm=lockdown,capability,landlock,selinux,integrity Jan 30 12:44:08.092403 kernel: landlock: Up and running. Jan 30 12:44:08.092409 kernel: SELinux: Initializing. Jan 30 12:44:08.092416 kernel: Mount-cache hash table entries: 8192 (order: 4, 65536 bytes, linear) Jan 30 12:44:08.092423 kernel: Mountpoint-cache hash table entries: 8192 (order: 4, 65536 bytes, linear) Jan 30 12:44:08.092430 kernel: RCU Tasks: Setting shift to 2 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=4. Jan 30 12:44:08.092437 kernel: RCU Tasks Trace: Setting shift to 2 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=4. Jan 30 12:44:08.092444 kernel: rcu: Hierarchical SRCU implementation. Jan 30 12:44:08.092453 kernel: rcu: Max phase no-delay instances is 400. Jan 30 12:44:08.092460 kernel: Platform MSI: ITS@0x8080000 domain created Jan 30 12:44:08.092467 kernel: PCI/MSI: ITS@0x8080000 domain created Jan 30 12:44:08.092473 kernel: Remapping and enabling EFI services. Jan 30 12:44:08.092480 kernel: smp: Bringing up secondary CPUs ... Jan 30 12:44:08.092487 kernel: Detected PIPT I-cache on CPU1 Jan 30 12:44:08.092494 kernel: GICv3: CPU1: found redistributor 1 region 0:0x00000000080c0000 Jan 30 12:44:08.092501 kernel: GICv3: CPU1: using allocated LPI pending table @0x0000000040110000 Jan 30 12:44:08.092507 kernel: arch_timer: Enabling local workaround for ARM erratum 1418040 Jan 30 12:44:08.092516 kernel: CPU1: Booted secondary processor 0x0000000001 [0x413fd0c1] Jan 30 12:44:08.092523 kernel: Detected PIPT I-cache on CPU2 Jan 30 12:44:08.092536 kernel: GICv3: CPU2: found redistributor 2 region 0:0x00000000080e0000 Jan 30 12:44:08.092545 kernel: GICv3: CPU2: using allocated LPI pending table @0x0000000040120000 Jan 30 12:44:08.092552 kernel: arch_timer: Enabling local workaround for ARM erratum 1418040 Jan 30 12:44:08.092559 kernel: CPU2: Booted secondary processor 0x0000000002 [0x413fd0c1] Jan 30 12:44:08.092566 kernel: Detected PIPT I-cache on CPU3 Jan 30 12:44:08.092574 kernel: GICv3: CPU3: found redistributor 3 region 0:0x0000000008100000 Jan 30 12:44:08.092581 kernel: GICv3: CPU3: using allocated LPI pending table @0x0000000040130000 Jan 30 12:44:08.092590 kernel: arch_timer: Enabling local workaround for ARM erratum 1418040 Jan 30 12:44:08.092597 kernel: CPU3: Booted secondary processor 0x0000000003 [0x413fd0c1] Jan 30 12:44:08.092604 kernel: smp: Brought up 1 node, 4 CPUs Jan 30 12:44:08.092612 kernel: SMP: Total of 4 processors activated. Jan 30 12:44:08.092619 kernel: CPU features: detected: 32-bit EL0 Support Jan 30 12:44:08.092631 kernel: CPU features: detected: Data cache clean to the PoU not required for I/D coherence Jan 30 12:44:08.092639 kernel: CPU features: detected: Common not Private translations Jan 30 12:44:08.092647 kernel: CPU features: detected: CRC32 instructions Jan 30 12:44:08.092656 kernel: CPU features: detected: Enhanced Virtualization Traps Jan 30 12:44:08.092663 kernel: CPU features: detected: RCpc load-acquire (LDAPR) Jan 30 12:44:08.092670 kernel: CPU features: detected: LSE atomic instructions Jan 30 12:44:08.092678 kernel: CPU features: detected: Privileged Access Never Jan 30 12:44:08.092685 kernel: CPU features: detected: RAS Extension Support Jan 30 12:44:08.092693 kernel: CPU features: detected: Speculative Store Bypassing Safe (SSBS) Jan 30 12:44:08.092700 kernel: CPU: All CPU(s) started at EL1 Jan 30 12:44:08.092707 kernel: alternatives: applying system-wide alternatives Jan 30 12:44:08.092714 kernel: devtmpfs: initialized Jan 30 12:44:08.092722 kernel: clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1911260446275000 ns Jan 30 12:44:08.092731 kernel: futex hash table entries: 1024 (order: 4, 65536 bytes, linear) Jan 30 12:44:08.092738 kernel: pinctrl core: initialized pinctrl subsystem Jan 30 12:44:08.092746 kernel: SMBIOS 3.0.0 present. Jan 30 12:44:08.092753 kernel: DMI: QEMU KVM Virtual Machine, BIOS unknown 02/02/2022 Jan 30 12:44:08.092760 kernel: NET: Registered PF_NETLINK/PF_ROUTE protocol family Jan 30 12:44:08.092768 kernel: DMA: preallocated 512 KiB GFP_KERNEL pool for atomic allocations Jan 30 12:44:08.092775 kernel: DMA: preallocated 512 KiB GFP_KERNEL|GFP_DMA pool for atomic allocations Jan 30 12:44:08.092782 kernel: DMA: preallocated 512 KiB GFP_KERNEL|GFP_DMA32 pool for atomic allocations Jan 30 12:44:08.092791 kernel: audit: initializing netlink subsys (disabled) Jan 30 12:44:08.092798 kernel: audit: type=2000 audit(0.022:1): state=initialized audit_enabled=0 res=1 Jan 30 12:44:08.092806 kernel: thermal_sys: Registered thermal governor 'step_wise' Jan 30 12:44:08.092813 kernel: cpuidle: using governor menu Jan 30 12:44:08.092820 kernel: hw-breakpoint: found 6 breakpoint and 4 watchpoint registers. Jan 30 12:44:08.092828 kernel: ASID allocator initialised with 32768 entries Jan 30 12:44:08.092835 kernel: acpiphp: ACPI Hot Plug PCI Controller Driver version: 0.5 Jan 30 12:44:08.092842 kernel: Serial: AMBA PL011 UART driver Jan 30 12:44:08.092849 kernel: Modules: 2G module region forced by RANDOMIZE_MODULE_REGION_FULL Jan 30 12:44:08.092858 kernel: Modules: 0 pages in range for non-PLT usage Jan 30 12:44:08.092865 kernel: Modules: 508880 pages in range for PLT usage Jan 30 12:44:08.092874 kernel: HugeTLB: registered 1.00 GiB page size, pre-allocated 0 pages Jan 30 12:44:08.092881 kernel: HugeTLB: 0 KiB vmemmap can be freed for a 1.00 GiB page Jan 30 12:44:08.092889 kernel: HugeTLB: registered 32.0 MiB page size, pre-allocated 0 pages Jan 30 12:44:08.092896 kernel: HugeTLB: 0 KiB vmemmap can be freed for a 32.0 MiB page Jan 30 12:44:08.092903 kernel: HugeTLB: registered 2.00 MiB page size, pre-allocated 0 pages Jan 30 12:44:08.092911 kernel: HugeTLB: 0 KiB vmemmap can be freed for a 2.00 MiB page Jan 30 12:44:08.092918 kernel: HugeTLB: registered 64.0 KiB page size, pre-allocated 0 pages Jan 30 12:44:08.092927 kernel: HugeTLB: 0 KiB vmemmap can be freed for a 64.0 KiB page Jan 30 12:44:08.092934 kernel: ACPI: Added _OSI(Module Device) Jan 30 12:44:08.092941 kernel: ACPI: Added _OSI(Processor Device) Jan 30 12:44:08.092948 kernel: ACPI: Added _OSI(3.0 _SCP Extensions) Jan 30 12:44:08.092955 kernel: ACPI: Added _OSI(Processor Aggregator Device) Jan 30 12:44:08.092962 kernel: ACPI: 1 ACPI AML tables successfully acquired and loaded Jan 30 12:44:08.092970 kernel: ACPI: Interpreter enabled Jan 30 12:44:08.092977 kernel: ACPI: Using GIC for interrupt routing Jan 30 12:44:08.092984 kernel: ACPI: MCFG table detected, 1 entries Jan 30 12:44:08.092991 kernel: ARMH0011:00: ttyAMA0 at MMIO 0x9000000 (irq = 12, base_baud = 0) is a SBSA Jan 30 12:44:08.093000 kernel: printk: console [ttyAMA0] enabled Jan 30 12:44:08.093008 kernel: ACPI: PCI Root Bridge [PCI0] (domain 0000 [bus 00-ff]) Jan 30 12:44:08.093159 kernel: acpi PNP0A08:00: _OSC: OS supports [ExtendedConfig ASPM ClockPM Segments MSI HPX-Type3] Jan 30 12:44:08.093254 kernel: acpi PNP0A08:00: _OSC: platform does not support [LTR] Jan 30 12:44:08.093324 kernel: acpi PNP0A08:00: _OSC: OS now controls [PCIeHotplug PME AER PCIeCapability] Jan 30 12:44:08.093389 kernel: acpi PNP0A08:00: ECAM area [mem 0x4010000000-0x401fffffff] reserved by PNP0C02:00 Jan 30 12:44:08.093456 kernel: acpi PNP0A08:00: ECAM at [mem 0x4010000000-0x401fffffff] for [bus 00-ff] Jan 30 12:44:08.093469 kernel: ACPI: Remapped I/O 0x000000003eff0000 to [io 0x0000-0xffff window] Jan 30 12:44:08.093477 kernel: PCI host bridge to bus 0000:00 Jan 30 12:44:08.093550 kernel: pci_bus 0000:00: root bus resource [mem 0x10000000-0x3efeffff window] Jan 30 12:44:08.093614 kernel: pci_bus 0000:00: root bus resource [io 0x0000-0xffff window] Jan 30 12:44:08.093691 kernel: pci_bus 0000:00: root bus resource [mem 0x8000000000-0xffffffffff window] Jan 30 12:44:08.093755 kernel: pci_bus 0000:00: root bus resource [bus 00-ff] Jan 30 12:44:08.093840 kernel: pci 0000:00:00.0: [1b36:0008] type 00 class 0x060000 Jan 30 12:44:08.093925 kernel: pci 0000:00:01.0: [1af4:1005] type 00 class 0x00ff00 Jan 30 12:44:08.093997 kernel: pci 0000:00:01.0: reg 0x10: [io 0x0000-0x001f] Jan 30 12:44:08.094064 kernel: pci 0000:00:01.0: reg 0x14: [mem 0x10000000-0x10000fff] Jan 30 12:44:08.094130 kernel: pci 0000:00:01.0: reg 0x20: [mem 0x8000000000-0x8000003fff 64bit pref] Jan 30 12:44:08.094221 kernel: pci 0000:00:01.0: BAR 4: assigned [mem 0x8000000000-0x8000003fff 64bit pref] Jan 30 12:44:08.094304 kernel: pci 0000:00:01.0: BAR 1: assigned [mem 0x10000000-0x10000fff] Jan 30 12:44:08.094380 kernel: pci 0000:00:01.0: BAR 0: assigned [io 0x1000-0x101f] Jan 30 12:44:08.094444 kernel: pci_bus 0000:00: resource 4 [mem 0x10000000-0x3efeffff window] Jan 30 12:44:08.094508 kernel: pci_bus 0000:00: resource 5 [io 0x0000-0xffff window] Jan 30 12:44:08.094571 kernel: pci_bus 0000:00: resource 6 [mem 0x8000000000-0xffffffffff window] Jan 30 12:44:08.094580 kernel: ACPI: PCI: Interrupt link GSI0 configured for IRQ 35 Jan 30 12:44:08.094591 kernel: ACPI: PCI: Interrupt link GSI1 configured for IRQ 36 Jan 30 12:44:08.094598 kernel: ACPI: PCI: Interrupt link GSI2 configured for IRQ 37 Jan 30 12:44:08.094607 kernel: ACPI: PCI: Interrupt link GSI3 configured for IRQ 38 Jan 30 12:44:08.094617 kernel: iommu: Default domain type: Translated Jan 30 12:44:08.094632 kernel: iommu: DMA domain TLB invalidation policy: strict mode Jan 30 12:44:08.094640 kernel: efivars: Registered efivars operations Jan 30 12:44:08.094648 kernel: vgaarb: loaded Jan 30 12:44:08.094656 kernel: clocksource: Switched to clocksource arch_sys_counter Jan 30 12:44:08.094664 kernel: VFS: Disk quotas dquot_6.6.0 Jan 30 12:44:08.094671 kernel: VFS: Dquot-cache hash table entries: 512 (order 0, 4096 bytes) Jan 30 12:44:08.094678 kernel: pnp: PnP ACPI init Jan 30 12:44:08.094758 kernel: system 00:00: [mem 0x4010000000-0x401fffffff window] could not be reserved Jan 30 12:44:08.094774 kernel: pnp: PnP ACPI: found 1 devices Jan 30 12:44:08.094783 kernel: NET: Registered PF_INET protocol family Jan 30 12:44:08.094790 kernel: IP idents hash table entries: 65536 (order: 7, 524288 bytes, linear) Jan 30 12:44:08.094797 kernel: tcp_listen_portaddr_hash hash table entries: 2048 (order: 3, 32768 bytes, linear) Jan 30 12:44:08.094805 kernel: Table-perturb hash table entries: 65536 (order: 6, 262144 bytes, linear) Jan 30 12:44:08.094812 kernel: TCP established hash table entries: 32768 (order: 6, 262144 bytes, linear) Jan 30 12:44:08.094819 kernel: TCP bind hash table entries: 32768 (order: 8, 1048576 bytes, linear) Jan 30 12:44:08.094827 kernel: TCP: Hash tables configured (established 32768 bind 32768) Jan 30 12:44:08.094837 kernel: UDP hash table entries: 2048 (order: 4, 65536 bytes, linear) Jan 30 12:44:08.094845 kernel: UDP-Lite hash table entries: 2048 (order: 4, 65536 bytes, linear) Jan 30 12:44:08.094852 kernel: NET: Registered PF_UNIX/PF_LOCAL protocol family Jan 30 12:44:08.094859 kernel: PCI: CLS 0 bytes, default 64 Jan 30 12:44:08.094867 kernel: kvm [1]: HYP mode not available Jan 30 12:44:08.094874 kernel: Initialise system trusted keyrings Jan 30 12:44:08.094881 kernel: workingset: timestamp_bits=39 max_order=20 bucket_order=0 Jan 30 12:44:08.094888 kernel: Key type asymmetric registered Jan 30 12:44:08.094895 kernel: Asymmetric key parser 'x509' registered Jan 30 12:44:08.094905 kernel: Block layer SCSI generic (bsg) driver version 0.4 loaded (major 250) Jan 30 12:44:08.094912 kernel: io scheduler mq-deadline registered Jan 30 12:44:08.094919 kernel: io scheduler kyber registered Jan 30 12:44:08.094929 kernel: io scheduler bfq registered Jan 30 12:44:08.094936 kernel: input: Power Button as /devices/LNXSYSTM:00/LNXSYBUS:00/PNP0C0C:00/input/input0 Jan 30 12:44:08.094943 kernel: ACPI: button: Power Button [PWRB] Jan 30 12:44:08.094951 kernel: ACPI: \_SB_.PCI0.GSI1: Enabled at IRQ 36 Jan 30 12:44:08.095023 kernel: virtio-pci 0000:00:01.0: enabling device (0005 -> 0007) Jan 30 12:44:08.095033 kernel: Serial: 8250/16550 driver, 4 ports, IRQ sharing enabled Jan 30 12:44:08.095042 kernel: thunder_xcv, ver 1.0 Jan 30 12:44:08.095049 kernel: thunder_bgx, ver 1.0 Jan 30 12:44:08.095056 kernel: nicpf, ver 1.0 Jan 30 12:44:08.095063 kernel: nicvf, ver 1.0 Jan 30 12:44:08.095144 kernel: rtc-efi rtc-efi.0: registered as rtc0 Jan 30 12:44:08.095271 kernel: rtc-efi rtc-efi.0: setting system clock to 2025-01-30T12:44:07 UTC (1738241047) Jan 30 12:44:08.095284 kernel: hid: raw HID events driver (C) Jiri Kosina Jan 30 12:44:08.095291 kernel: hw perfevents: enabled with armv8_pmuv3_0 PMU driver, 7 counters available Jan 30 12:44:08.095299 kernel: watchdog: Delayed init of the lockup detector failed: -19 Jan 30 12:44:08.095310 kernel: watchdog: Hard watchdog permanently disabled Jan 30 12:44:08.095317 kernel: NET: Registered PF_INET6 protocol family Jan 30 12:44:08.095324 kernel: Segment Routing with IPv6 Jan 30 12:44:08.095331 kernel: In-situ OAM (IOAM) with IPv6 Jan 30 12:44:08.095338 kernel: NET: Registered PF_PACKET protocol family Jan 30 12:44:08.095346 kernel: Key type dns_resolver registered Jan 30 12:44:08.095353 kernel: registered taskstats version 1 Jan 30 12:44:08.095361 kernel: Loading compiled-in X.509 certificates Jan 30 12:44:08.095368 kernel: Loaded X.509 cert 'Kinvolk GmbH: Module signing key for 6.6.74-flatcar: c31663d2c680b3b306c17f44b5295280d3a2e28a' Jan 30 12:44:08.095377 kernel: Key type .fscrypt registered Jan 30 12:44:08.095384 kernel: Key type fscrypt-provisioning registered Jan 30 12:44:08.095391 kernel: ima: No TPM chip found, activating TPM-bypass! Jan 30 12:44:08.095403 kernel: ima: Allocated hash algorithm: sha1 Jan 30 12:44:08.095410 kernel: ima: No architecture policies found Jan 30 12:44:08.095417 kernel: alg: No test for fips(ansi_cprng) (fips_ansi_cprng) Jan 30 12:44:08.095424 kernel: clk: Disabling unused clocks Jan 30 12:44:08.095431 kernel: Freeing unused kernel memory: 39936K Jan 30 12:44:08.095440 kernel: Run /init as init process Jan 30 12:44:08.095447 kernel: with arguments: Jan 30 12:44:08.095455 kernel: /init Jan 30 12:44:08.095461 kernel: with environment: Jan 30 12:44:08.095468 kernel: HOME=/ Jan 30 12:44:08.095476 kernel: TERM=linux Jan 30 12:44:08.095483 kernel: BOOT_IMAGE=/flatcar/vmlinuz-a Jan 30 12:44:08.095492 systemd[1]: systemd 255 running in system mode (+PAM +AUDIT +SELINUX -APPARMOR +IMA +SMACK +SECCOMP +GCRYPT -GNUTLS +OPENSSL -ACL +BLKID +CURL +ELFUTILS -FIDO2 +IDN2 -IDN +IPTC +KMOD +LIBCRYPTSETUP +LIBFDISK +PCRE2 -PWQUALITY -P11KIT -QRENCODE +TPM2 +BZIP2 +LZ4 +XZ +ZLIB +ZSTD -BPF_FRAMEWORK -XKBCOMMON +UTMP -SYSVINIT default-hierarchy=unified) Jan 30 12:44:08.095503 systemd[1]: Detected virtualization kvm. Jan 30 12:44:08.095511 systemd[1]: Detected architecture arm64. Jan 30 12:44:08.095519 systemd[1]: Running in initrd. Jan 30 12:44:08.095526 systemd[1]: No hostname configured, using default hostname. Jan 30 12:44:08.095533 systemd[1]: Hostname set to . Jan 30 12:44:08.095542 systemd[1]: Initializing machine ID from VM UUID. Jan 30 12:44:08.095549 systemd[1]: Queued start job for default target initrd.target. Jan 30 12:44:08.095557 systemd[1]: Started clevis-luks-askpass.path - Forward Password Requests to Clevis Directory Watch. Jan 30 12:44:08.095567 systemd[1]: Started systemd-ask-password-console.path - Dispatch Password Requests to Console Directory Watch. Jan 30 12:44:08.095575 systemd[1]: Expecting device dev-disk-by\x2dlabel-EFI\x2dSYSTEM.device - /dev/disk/by-label/EFI-SYSTEM... Jan 30 12:44:08.095583 systemd[1]: Expecting device dev-disk-by\x2dlabel-OEM.device - /dev/disk/by-label/OEM... Jan 30 12:44:08.095591 systemd[1]: Expecting device dev-disk-by\x2dlabel-ROOT.device - /dev/disk/by-label/ROOT... Jan 30 12:44:08.095599 systemd[1]: Expecting device dev-disk-by\x2dpartlabel-USR\x2dA.device - /dev/disk/by-partlabel/USR-A... Jan 30 12:44:08.095608 systemd[1]: Expecting device dev-disk-by\x2dpartuuid-7130c94a\x2d213a\x2d4e5a\x2d8e26\x2d6cce9662f132.device - /dev/disk/by-partuuid/7130c94a-213a-4e5a-8e26-6cce9662f132... Jan 30 12:44:08.095616 systemd[1]: Expecting device dev-mapper-usr.device - /dev/mapper/usr... Jan 30 12:44:08.095634 systemd[1]: Reached target cryptsetup-pre.target - Local Encrypted Volumes (Pre). Jan 30 12:44:08.095642 systemd[1]: Reached target cryptsetup.target - Local Encrypted Volumes. Jan 30 12:44:08.095651 systemd[1]: Reached target paths.target - Path Units. Jan 30 12:44:08.095658 systemd[1]: Reached target slices.target - Slice Units. Jan 30 12:44:08.095666 systemd[1]: Reached target swap.target - Swaps. Jan 30 12:44:08.095674 systemd[1]: Reached target timers.target - Timer Units. Jan 30 12:44:08.095682 systemd[1]: Listening on iscsid.socket - Open-iSCSI iscsid Socket. Jan 30 12:44:08.095690 systemd[1]: Listening on iscsiuio.socket - Open-iSCSI iscsiuio Socket. Jan 30 12:44:08.095698 systemd[1]: Listening on systemd-journald-dev-log.socket - Journal Socket (/dev/log). Jan 30 12:44:08.095707 systemd[1]: Listening on systemd-journald.socket - Journal Socket. Jan 30 12:44:08.095715 systemd[1]: Listening on systemd-networkd.socket - Network Service Netlink Socket. Jan 30 12:44:08.095723 systemd[1]: Listening on systemd-udevd-control.socket - udev Control Socket. Jan 30 12:44:08.095731 systemd[1]: Listening on systemd-udevd-kernel.socket - udev Kernel Socket. Jan 30 12:44:08.095739 systemd[1]: Reached target sockets.target - Socket Units. Jan 30 12:44:08.095747 systemd[1]: Starting ignition-setup-pre.service - Ignition env setup... Jan 30 12:44:08.095755 systemd[1]: Starting kmod-static-nodes.service - Create List of Static Device Nodes... Jan 30 12:44:08.095763 systemd[1]: Finished network-cleanup.service - Network Cleanup. Jan 30 12:44:08.095772 systemd[1]: Starting systemd-fsck-usr.service... Jan 30 12:44:08.095780 systemd[1]: Starting systemd-journald.service - Journal Service... Jan 30 12:44:08.095788 systemd[1]: Starting systemd-modules-load.service - Load Kernel Modules... Jan 30 12:44:08.095795 systemd[1]: Starting systemd-vconsole-setup.service - Virtual Console Setup... Jan 30 12:44:08.095803 systemd[1]: Finished ignition-setup-pre.service - Ignition env setup. Jan 30 12:44:08.095811 systemd[1]: Finished kmod-static-nodes.service - Create List of Static Device Nodes. Jan 30 12:44:08.095819 systemd[1]: Finished systemd-fsck-usr.service. Jan 30 12:44:08.095829 systemd[1]: Starting systemd-tmpfiles-setup-dev-early.service - Create Static Device Nodes in /dev gracefully... Jan 30 12:44:08.095837 systemd[1]: Finished systemd-tmpfiles-setup-dev-early.service - Create Static Device Nodes in /dev gracefully. Jan 30 12:44:08.095846 systemd[1]: Starting systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev... Jan 30 12:44:08.095876 systemd-journald[236]: Collecting audit messages is disabled. Jan 30 12:44:08.095898 systemd[1]: Finished systemd-vconsole-setup.service - Virtual Console Setup. Jan 30 12:44:08.095907 systemd-journald[236]: Journal started Jan 30 12:44:08.095930 systemd-journald[236]: Runtime Journal (/run/log/journal/9f71c6933da04ad79f9683bcd3c39978) is 5.9M, max 47.3M, 41.4M free. Jan 30 12:44:08.067163 systemd-modules-load[238]: Inserted module 'overlay' Jan 30 12:44:08.099260 systemd[1]: Starting dracut-cmdline-ask.service - dracut ask for additional cmdline parameters... Jan 30 12:44:08.099447 kernel: bridge: filtering via arp/ip/ip6tables is no longer available by default. Update your scripts to load br_netfilter if you need this. Jan 30 12:44:08.102604 systemd[1]: Started systemd-journald.service - Journal Service. Jan 30 12:44:08.104135 systemd-modules-load[238]: Inserted module 'br_netfilter' Jan 30 12:44:08.105857 kernel: Bridge firewalling registered Jan 30 12:44:08.104230 systemd[1]: Finished systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev. Jan 30 12:44:08.106131 systemd[1]: Finished systemd-modules-load.service - Load Kernel Modules. Jan 30 12:44:08.113331 systemd[1]: Starting systemd-sysctl.service - Apply Kernel Variables... Jan 30 12:44:08.117434 systemd[1]: Starting systemd-tmpfiles-setup.service - Create System Files and Directories... Jan 30 12:44:08.129115 systemd[1]: Finished systemd-sysctl.service - Apply Kernel Variables. Jan 30 12:44:08.131075 systemd[1]: Finished systemd-tmpfiles-setup.service - Create System Files and Directories. Jan 30 12:44:08.133523 systemd[1]: Finished dracut-cmdline-ask.service - dracut ask for additional cmdline parameters. Jan 30 12:44:08.146457 systemd[1]: Starting dracut-cmdline.service - dracut cmdline hook... Jan 30 12:44:08.148736 systemd[1]: Starting systemd-resolved.service - Network Name Resolution... Jan 30 12:44:08.159453 dracut-cmdline[278]: dracut-dracut-053 Jan 30 12:44:08.163216 dracut-cmdline[278]: 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=e6957044c3256d96283265c263579aa4275d1d707b02496fcb081f5fc6356346 Jan 30 12:44:08.193405 systemd-resolved[281]: Positive Trust Anchors: Jan 30 12:44:08.193426 systemd-resolved[281]: . IN DS 20326 8 2 e06d44b80b8f1d39a95c0b0d7c65d08458e880409bbc683457104237c7f8ec8d Jan 30 12:44:08.193457 systemd-resolved[281]: Negative trust anchors: home.arpa 10.in-addr.arpa 16.172.in-addr.arpa 17.172.in-addr.arpa 18.172.in-addr.arpa 19.172.in-addr.arpa 20.172.in-addr.arpa 21.172.in-addr.arpa 22.172.in-addr.arpa 23.172.in-addr.arpa 24.172.in-addr.arpa 25.172.in-addr.arpa 26.172.in-addr.arpa 27.172.in-addr.arpa 28.172.in-addr.arpa 29.172.in-addr.arpa 30.172.in-addr.arpa 31.172.in-addr.arpa 170.0.0.192.in-addr.arpa 171.0.0.192.in-addr.arpa 168.192.in-addr.arpa d.f.ip6.arpa ipv4only.arpa resolver.arpa corp home internal intranet lan local private test Jan 30 12:44:08.198374 systemd-resolved[281]: Defaulting to hostname 'linux'. Jan 30 12:44:08.199546 systemd[1]: Started systemd-resolved.service - Network Name Resolution. Jan 30 12:44:08.202381 systemd[1]: Reached target nss-lookup.target - Host and Network Name Lookups. Jan 30 12:44:08.249281 kernel: SCSI subsystem initialized Jan 30 12:44:08.257244 kernel: Loading iSCSI transport class v2.0-870. Jan 30 12:44:08.269386 kernel: iscsi: registered transport (tcp) Jan 30 12:44:08.285238 kernel: iscsi: registered transport (qla4xxx) Jan 30 12:44:08.285301 kernel: QLogic iSCSI HBA Driver Jan 30 12:44:08.339145 systemd[1]: Finished dracut-cmdline.service - dracut cmdline hook. Jan 30 12:44:08.351399 systemd[1]: Starting dracut-pre-udev.service - dracut pre-udev hook... Jan 30 12:44:08.370251 kernel: device-mapper: core: CONFIG_IMA_DISABLE_HTABLE is disabled. Duplicate IMA measurements will not be recorded in the IMA log. Jan 30 12:44:08.370331 kernel: device-mapper: uevent: version 1.0.3 Jan 30 12:44:08.371852 kernel: device-mapper: ioctl: 4.48.0-ioctl (2023-03-01) initialised: dm-devel@redhat.com Jan 30 12:44:08.431239 kernel: raid6: neonx8 gen() 14509 MB/s Jan 30 12:44:08.448249 kernel: raid6: neonx4 gen() 11852 MB/s Jan 30 12:44:08.465224 kernel: raid6: neonx2 gen() 11652 MB/s Jan 30 12:44:08.482226 kernel: raid6: neonx1 gen() 10262 MB/s Jan 30 12:44:08.499230 kernel: raid6: int64x8 gen() 6597 MB/s Jan 30 12:44:08.516236 kernel: raid6: int64x4 gen() 7341 MB/s Jan 30 12:44:08.533239 kernel: raid6: int64x2 gen() 6102 MB/s Jan 30 12:44:08.550255 kernel: raid6: int64x1 gen() 5046 MB/s Jan 30 12:44:08.550319 kernel: raid6: using algorithm neonx8 gen() 14509 MB/s Jan 30 12:44:08.567235 kernel: raid6: .... xor() 11876 MB/s, rmw enabled Jan 30 12:44:08.567291 kernel: raid6: using neon recovery algorithm Jan 30 12:44:08.572457 kernel: xor: measuring software checksum speed Jan 30 12:44:08.572499 kernel: 8regs : 21636 MB/sec Jan 30 12:44:08.573641 kernel: 32regs : 21670 MB/sec Jan 30 12:44:08.573661 kernel: arm64_neon : 27889 MB/sec Jan 30 12:44:08.573670 kernel: xor: using function: arm64_neon (27889 MB/sec) Jan 30 12:44:08.625260 kernel: Btrfs loaded, zoned=no, fsverity=no Jan 30 12:44:08.637221 systemd[1]: Finished dracut-pre-udev.service - dracut pre-udev hook. Jan 30 12:44:08.643495 systemd[1]: Starting systemd-udevd.service - Rule-based Manager for Device Events and Files... Jan 30 12:44:08.691993 systemd-udevd[464]: Using default interface naming scheme 'v255'. Jan 30 12:44:08.696282 systemd[1]: Started systemd-udevd.service - Rule-based Manager for Device Events and Files. Jan 30 12:44:08.707438 systemd[1]: Starting dracut-pre-trigger.service - dracut pre-trigger hook... Jan 30 12:44:08.722584 dracut-pre-trigger[470]: rd.md=0: removing MD RAID activation Jan 30 12:44:08.756000 systemd[1]: Finished dracut-pre-trigger.service - dracut pre-trigger hook. Jan 30 12:44:08.766439 systemd[1]: Starting systemd-udev-trigger.service - Coldplug All udev Devices... Jan 30 12:44:08.810236 systemd[1]: Finished systemd-udev-trigger.service - Coldplug All udev Devices. Jan 30 12:44:08.818414 systemd[1]: Starting dracut-initqueue.service - dracut initqueue hook... Jan 30 12:44:08.831916 systemd[1]: Finished dracut-initqueue.service - dracut initqueue hook. Jan 30 12:44:08.834018 systemd[1]: Reached target remote-fs-pre.target - Preparation for Remote File Systems. Jan 30 12:44:08.836882 systemd[1]: Reached target remote-cryptsetup.target - Remote Encrypted Volumes. Jan 30 12:44:08.838319 systemd[1]: Reached target remote-fs.target - Remote File Systems. Jan 30 12:44:08.850055 systemd[1]: Starting dracut-pre-mount.service - dracut pre-mount hook... Jan 30 12:44:08.855975 kernel: virtio_blk virtio1: 1/0/0 default/read/poll queues Jan 30 12:44:08.869479 kernel: virtio_blk virtio1: [vda] 9289728 512-byte logical blocks (4.76 GB/4.43 GiB) Jan 30 12:44:08.869603 kernel: vda: vda1 vda2 vda3 vda4 vda6 vda7 vda9 Jan 30 12:44:08.865238 systemd[1]: Finished dracut-pre-mount.service - dracut pre-mount hook. Jan 30 12:44:08.869439 systemd[1]: dracut-cmdline-ask.service: Deactivated successfully. Jan 30 12:44:08.869552 systemd[1]: Stopped dracut-cmdline-ask.service - dracut ask for additional cmdline parameters. Jan 30 12:44:08.871745 systemd[1]: Stopping dracut-cmdline-ask.service - dracut ask for additional cmdline parameters... Jan 30 12:44:08.872899 systemd[1]: systemd-vconsole-setup.service: Deactivated successfully. Jan 30 12:44:08.873065 systemd[1]: Stopped systemd-vconsole-setup.service - Virtual Console Setup. Jan 30 12:44:08.874548 systemd[1]: Stopping systemd-vconsole-setup.service - Virtual Console Setup... Jan 30 12:44:08.882440 systemd[1]: Starting systemd-vconsole-setup.service - Virtual Console Setup... Jan 30 12:44:08.893288 systemd[1]: Finished systemd-vconsole-setup.service - Virtual Console Setup. Jan 30 12:44:08.899165 kernel: BTRFS: device fsid 1e2e5fa7-c757-4d5d-af66-73afe98fbaae devid 1 transid 39 /dev/vda3 scanned by (udev-worker) (523) Jan 30 12:44:08.899227 kernel: BTRFS: device label OEM devid 1 transid 14 /dev/vda6 scanned by (udev-worker) (514) Jan 30 12:44:08.902493 systemd[1]: Starting dracut-cmdline-ask.service - dracut ask for additional cmdline parameters... Jan 30 12:44:08.912808 systemd[1]: Found device dev-disk-by\x2dlabel-ROOT.device - /dev/disk/by-label/ROOT. Jan 30 12:44:08.919808 systemd[1]: Found device dev-disk-by\x2dlabel-EFI\x2dSYSTEM.device - /dev/disk/by-label/EFI-SYSTEM. Jan 30 12:44:08.924181 systemd[1]: Found device dev-disk-by\x2dlabel-OEM.device - /dev/disk/by-label/OEM. Jan 30 12:44:08.926265 systemd[1]: Finished dracut-cmdline-ask.service - dracut ask for additional cmdline parameters. Jan 30 12:44:08.930161 systemd[1]: Found device dev-disk-by\x2dpartuuid-7130c94a\x2d213a\x2d4e5a\x2d8e26\x2d6cce9662f132.device - /dev/disk/by-partuuid/7130c94a-213a-4e5a-8e26-6cce9662f132. Jan 30 12:44:08.931149 systemd[1]: Found device dev-disk-by\x2dpartlabel-USR\x2dA.device - /dev/disk/by-partlabel/USR-A. Jan 30 12:44:08.949385 systemd[1]: Starting disk-uuid.service - Generate new UUID for disk GPT if necessary... Jan 30 12:44:08.960238 kernel: vda: vda1 vda2 vda3 vda4 vda6 vda7 vda9 Jan 30 12:44:09.987233 kernel: vda: vda1 vda2 vda3 vda4 vda6 vda7 vda9 Jan 30 12:44:09.988679 disk-uuid[567]: The operation has completed successfully. Jan 30 12:44:10.014767 systemd[1]: disk-uuid.service: Deactivated successfully. Jan 30 12:44:10.014899 systemd[1]: Finished disk-uuid.service - Generate new UUID for disk GPT if necessary. Jan 30 12:44:10.038393 systemd[1]: Starting verity-setup.service - Verity Setup for /dev/mapper/usr... Jan 30 12:44:10.042591 sh[579]: Success Jan 30 12:44:10.064414 kernel: device-mapper: verity: sha256 using implementation "sha256-ce" Jan 30 12:44:10.096524 systemd[1]: Found device dev-mapper-usr.device - /dev/mapper/usr. Jan 30 12:44:10.104597 systemd[1]: Mounting sysusr-usr.mount - /sysusr/usr... Jan 30 12:44:10.106014 systemd[1]: Finished verity-setup.service - Verity Setup for /dev/mapper/usr. Jan 30 12:44:10.122425 kernel: BTRFS info (device dm-0): first mount of filesystem 1e2e5fa7-c757-4d5d-af66-73afe98fbaae Jan 30 12:44:10.122475 kernel: BTRFS info (device dm-0): using crc32c (crc32c-generic) checksum algorithm Jan 30 12:44:10.122487 kernel: BTRFS warning (device dm-0): 'nologreplay' is deprecated, use 'rescue=nologreplay' instead Jan 30 12:44:10.124466 kernel: BTRFS info (device dm-0): disabling log replay at mount time Jan 30 12:44:10.124486 kernel: BTRFS info (device dm-0): using free space tree Jan 30 12:44:10.133005 systemd[1]: Mounted sysusr-usr.mount - /sysusr/usr. Jan 30 12:44:10.134251 systemd[1]: afterburn-network-kargs.service - Afterburn Initrd Setup Network Kernel Arguments was skipped because no trigger condition checks were met. Jan 30 12:44:10.141378 systemd[1]: Starting ignition-setup.service - Ignition (setup)... Jan 30 12:44:10.142850 systemd[1]: Starting parse-ip-for-networkd.service - Write systemd-networkd units from cmdline... Jan 30 12:44:10.153870 kernel: BTRFS info (device vda6): first mount of filesystem 5265f28b-8d78-4be2-8b05-2145d9ab7cfa Jan 30 12:44:10.153933 kernel: BTRFS info (device vda6): using crc32c (crc32c-generic) checksum algorithm Jan 30 12:44:10.153944 kernel: BTRFS info (device vda6): using free space tree Jan 30 12:44:10.156250 kernel: BTRFS info (device vda6): auto enabling async discard Jan 30 12:44:10.165366 systemd[1]: mnt-oem.mount: Deactivated successfully. Jan 30 12:44:10.167011 kernel: BTRFS info (device vda6): last unmount of filesystem 5265f28b-8d78-4be2-8b05-2145d9ab7cfa Jan 30 12:44:10.176716 systemd[1]: Finished ignition-setup.service - Ignition (setup). Jan 30 12:44:10.185462 systemd[1]: Starting ignition-fetch-offline.service - Ignition (fetch-offline)... Jan 30 12:44:10.261881 systemd[1]: Finished parse-ip-for-networkd.service - Write systemd-networkd units from cmdline. Jan 30 12:44:10.270402 systemd[1]: Starting systemd-networkd.service - Network Configuration... Jan 30 12:44:10.303920 systemd-networkd[764]: lo: Link UP Jan 30 12:44:10.303932 systemd-networkd[764]: lo: Gained carrier Jan 30 12:44:10.304862 systemd-networkd[764]: Enumeration completed Jan 30 12:44:10.305328 systemd[1]: Started systemd-networkd.service - Network Configuration. Jan 30 12:44:10.305373 systemd-networkd[764]: eth0: found matching network '/usr/lib/systemd/network/zz-default.network', based on potentially unpredictable interface name. Jan 30 12:44:10.305376 systemd-networkd[764]: eth0: Configuring with /usr/lib/systemd/network/zz-default.network. Jan 30 12:44:10.306341 systemd-networkd[764]: eth0: Link UP Jan 30 12:44:10.306343 systemd-networkd[764]: eth0: Gained carrier Jan 30 12:44:10.306351 systemd-networkd[764]: eth0: found matching network '/usr/lib/systemd/network/zz-default.network', based on potentially unpredictable interface name. Jan 30 12:44:10.306861 systemd[1]: Reached target network.target - Network. Jan 30 12:44:10.328291 systemd-networkd[764]: eth0: DHCPv4 address 10.0.0.16/16, gateway 10.0.0.1 acquired from 10.0.0.1 Jan 30 12:44:10.328650 ignition[674]: Ignition 2.20.0 Jan 30 12:44:10.328656 ignition[674]: Stage: fetch-offline Jan 30 12:44:10.328694 ignition[674]: no configs at "/usr/lib/ignition/base.d" Jan 30 12:44:10.328702 ignition[674]: no config dir at "/usr/lib/ignition/base.platform.d/qemu" Jan 30 12:44:10.328857 ignition[674]: parsed url from cmdline: "" Jan 30 12:44:10.328861 ignition[674]: no config URL provided Jan 30 12:44:10.328866 ignition[674]: reading system config file "/usr/lib/ignition/user.ign" Jan 30 12:44:10.328873 ignition[674]: no config at "/usr/lib/ignition/user.ign" Jan 30 12:44:10.328905 ignition[674]: op(1): [started] loading QEMU firmware config module Jan 30 12:44:10.328910 ignition[674]: op(1): executing: "modprobe" "qemu_fw_cfg" Jan 30 12:44:10.338558 ignition[674]: op(1): [finished] loading QEMU firmware config module Jan 30 12:44:10.338591 ignition[674]: QEMU firmware config was not found. Ignoring... Jan 30 12:44:10.343409 ignition[674]: parsing config with SHA512: 5f615cedfae068ee63fc3c7228d9a597a79c28f5f87d43ecc99f18408cf9961b21b2223b45e7f41494a9164f4a5d286aa53a4375bf35a41898ec24fb35edd7ec Jan 30 12:44:10.350670 unknown[674]: fetched base config from "system" Jan 30 12:44:10.350685 unknown[674]: fetched user config from "qemu" Jan 30 12:44:10.350889 ignition[674]: fetch-offline: fetch-offline passed Jan 30 12:44:10.350978 ignition[674]: Ignition finished successfully Jan 30 12:44:10.354240 systemd[1]: Finished ignition-fetch-offline.service - Ignition (fetch-offline). Jan 30 12:44:10.355717 systemd[1]: ignition-fetch.service - Ignition (fetch) was skipped because of an unmet condition check (ConditionPathExists=!/run/ignition.json). Jan 30 12:44:10.371438 systemd[1]: Starting ignition-kargs.service - Ignition (kargs)... Jan 30 12:44:10.384004 ignition[777]: Ignition 2.20.0 Jan 30 12:44:10.384015 ignition[777]: Stage: kargs Jan 30 12:44:10.384225 ignition[777]: no configs at "/usr/lib/ignition/base.d" Jan 30 12:44:10.384236 ignition[777]: no config dir at "/usr/lib/ignition/base.platform.d/qemu" Jan 30 12:44:10.384883 ignition[777]: kargs: kargs passed Jan 30 12:44:10.384930 ignition[777]: Ignition finished successfully Jan 30 12:44:10.387392 systemd[1]: Finished ignition-kargs.service - Ignition (kargs). Jan 30 12:44:10.397457 systemd[1]: Starting ignition-disks.service - Ignition (disks)... Jan 30 12:44:10.407849 ignition[786]: Ignition 2.20.0 Jan 30 12:44:10.407860 ignition[786]: Stage: disks Jan 30 12:44:10.408051 ignition[786]: no configs at "/usr/lib/ignition/base.d" Jan 30 12:44:10.408062 ignition[786]: no config dir at "/usr/lib/ignition/base.platform.d/qemu" Jan 30 12:44:10.408764 ignition[786]: disks: disks passed Jan 30 12:44:10.410691 systemd[1]: Finished ignition-disks.service - Ignition (disks). Jan 30 12:44:10.408810 ignition[786]: Ignition finished successfully Jan 30 12:44:10.412302 systemd[1]: Reached target initrd-root-device.target - Initrd Root Device. Jan 30 12:44:10.413198 systemd[1]: Reached target local-fs-pre.target - Preparation for Local File Systems. Jan 30 12:44:10.414718 systemd[1]: Reached target local-fs.target - Local File Systems. Jan 30 12:44:10.415909 systemd[1]: Reached target sysinit.target - System Initialization. Jan 30 12:44:10.417381 systemd[1]: Reached target basic.target - Basic System. Jan 30 12:44:10.431389 systemd[1]: Starting systemd-fsck-root.service - File System Check on /dev/disk/by-label/ROOT... Jan 30 12:44:10.446785 systemd-fsck[797]: ROOT: clean, 14/553520 files, 52654/553472 blocks Jan 30 12:44:10.453562 systemd[1]: Finished systemd-fsck-root.service - File System Check on /dev/disk/by-label/ROOT. Jan 30 12:44:10.459323 systemd[1]: Mounting sysroot.mount - /sysroot... Jan 30 12:44:10.509235 kernel: EXT4-fs (vda9): mounted filesystem 88903c49-366d-43ff-90b1-141790b6e85c r/w with ordered data mode. Quota mode: none. Jan 30 12:44:10.509252 systemd[1]: Mounted sysroot.mount - /sysroot. Jan 30 12:44:10.510346 systemd[1]: Reached target initrd-root-fs.target - Initrd Root File System. Jan 30 12:44:10.523316 systemd[1]: Mounting sysroot-oem.mount - /sysroot/oem... Jan 30 12:44:10.524955 systemd[1]: Mounting sysroot-usr.mount - /sysroot/usr... Jan 30 12:44:10.526042 systemd[1]: flatcar-metadata-hostname.service - Flatcar Metadata Hostname Agent was skipped because no trigger condition checks were met. Jan 30 12:44:10.526086 systemd[1]: ignition-remount-sysroot.service - Remount /sysroot read-write for Ignition was skipped because of an unmet condition check (ConditionPathIsReadWrite=!/sysroot). Jan 30 12:44:10.533220 kernel: BTRFS: device label OEM devid 1 transid 15 /dev/vda6 scanned by mount (805) Jan 30 12:44:10.533243 kernel: BTRFS info (device vda6): first mount of filesystem 5265f28b-8d78-4be2-8b05-2145d9ab7cfa Jan 30 12:44:10.533254 kernel: BTRFS info (device vda6): using crc32c (crc32c-generic) checksum algorithm Jan 30 12:44:10.526109 systemd[1]: Reached target ignition-diskful.target - Ignition Boot Disk Setup. Jan 30 12:44:10.537458 kernel: BTRFS info (device vda6): using free space tree Jan 30 12:44:10.537478 kernel: BTRFS info (device vda6): auto enabling async discard Jan 30 12:44:10.532625 systemd[1]: Mounted sysroot-usr.mount - /sysroot/usr. Jan 30 12:44:10.536696 systemd[1]: Starting initrd-setup-root.service - Root filesystem setup... Jan 30 12:44:10.539811 systemd[1]: Mounted sysroot-oem.mount - /sysroot/oem. Jan 30 12:44:10.603115 initrd-setup-root[829]: cut: /sysroot/etc/passwd: No such file or directory Jan 30 12:44:10.608044 initrd-setup-root[836]: cut: /sysroot/etc/group: No such file or directory Jan 30 12:44:10.612024 initrd-setup-root[843]: cut: /sysroot/etc/shadow: No such file or directory Jan 30 12:44:10.616394 initrd-setup-root[850]: cut: /sysroot/etc/gshadow: No such file or directory Jan 30 12:44:10.702077 systemd[1]: Finished initrd-setup-root.service - Root filesystem setup. Jan 30 12:44:10.723345 systemd[1]: Starting ignition-mount.service - Ignition (mount)... Jan 30 12:44:10.724860 systemd[1]: Starting sysroot-boot.service - /sysroot/boot... Jan 30 12:44:10.731233 kernel: BTRFS info (device vda6): last unmount of filesystem 5265f28b-8d78-4be2-8b05-2145d9ab7cfa Jan 30 12:44:10.754226 systemd[1]: Finished sysroot-boot.service - /sysroot/boot. Jan 30 12:44:10.794758 ignition[922]: INFO : Ignition 2.20.0 Jan 30 12:44:10.794758 ignition[922]: INFO : Stage: mount Jan 30 12:44:10.796983 ignition[922]: INFO : no configs at "/usr/lib/ignition/base.d" Jan 30 12:44:10.796983 ignition[922]: INFO : no config dir at "/usr/lib/ignition/base.platform.d/qemu" Jan 30 12:44:10.796983 ignition[922]: INFO : mount: mount passed Jan 30 12:44:10.796983 ignition[922]: INFO : Ignition finished successfully Jan 30 12:44:10.797085 systemd[1]: Finished ignition-mount.service - Ignition (mount). Jan 30 12:44:10.811371 systemd[1]: Starting ignition-files.service - Ignition (files)... Jan 30 12:44:10.935920 systemd-resolved[281]: Detected conflict on linux IN A 10.0.0.16 Jan 30 12:44:10.935935 systemd-resolved[281]: Hostname conflict, changing published hostname from 'linux' to 'linux3'. Jan 30 12:44:11.121152 systemd[1]: sysroot-oem.mount: Deactivated successfully. Jan 30 12:44:11.137446 systemd[1]: Mounting sysroot-oem.mount - /sysroot/oem... Jan 30 12:44:11.145643 kernel: BTRFS: device label OEM devid 1 transid 16 /dev/vda6 scanned by mount (931) Jan 30 12:44:11.145694 kernel: BTRFS info (device vda6): first mount of filesystem 5265f28b-8d78-4be2-8b05-2145d9ab7cfa Jan 30 12:44:11.145705 kernel: BTRFS info (device vda6): using crc32c (crc32c-generic) checksum algorithm Jan 30 12:44:11.147215 kernel: BTRFS info (device vda6): using free space tree Jan 30 12:44:11.152244 kernel: BTRFS info (device vda6): auto enabling async discard Jan 30 12:44:11.153658 systemd[1]: Mounted sysroot-oem.mount - /sysroot/oem. Jan 30 12:44:11.175033 ignition[948]: INFO : Ignition 2.20.0 Jan 30 12:44:11.175033 ignition[948]: INFO : Stage: files Jan 30 12:44:11.176471 ignition[948]: INFO : no configs at "/usr/lib/ignition/base.d" Jan 30 12:44:11.176471 ignition[948]: INFO : no config dir at "/usr/lib/ignition/base.platform.d/qemu" Jan 30 12:44:11.176471 ignition[948]: DEBUG : files: compiled without relabeling support, skipping Jan 30 12:44:11.179070 ignition[948]: INFO : files: ensureUsers: op(1): [started] creating or modifying user "core" Jan 30 12:44:11.179070 ignition[948]: DEBUG : files: ensureUsers: op(1): executing: "usermod" "--root" "/sysroot" "core" Jan 30 12:44:11.182161 ignition[948]: INFO : files: ensureUsers: op(1): [finished] creating or modifying user "core" Jan 30 12:44:11.183266 ignition[948]: INFO : files: ensureUsers: op(2): [started] adding ssh keys to user "core" Jan 30 12:44:11.183266 ignition[948]: INFO : files: ensureUsers: op(2): [finished] adding ssh keys to user "core" Jan 30 12:44:11.182757 unknown[948]: wrote ssh authorized keys file for user: core Jan 30 12:44:11.186485 ignition[948]: INFO : files: createFilesystemsFiles: createFiles: op(3): [started] writing file "/sysroot/etc/flatcar/update.conf" Jan 30 12:44:11.186485 ignition[948]: INFO : files: createFilesystemsFiles: createFiles: op(3): [finished] writing file "/sysroot/etc/flatcar/update.conf" Jan 30 12:44:11.186485 ignition[948]: INFO : files: op(4): [started] processing unit "etcd-member.service" Jan 30 12:44:11.190334 ignition[948]: 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" Jan 30 12:44:11.190334 ignition[948]: 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" Jan 30 12:44:11.190334 ignition[948]: INFO : files: op(4): [finished] processing unit "etcd-member.service" Jan 30 12:44:11.190334 ignition[948]: INFO : files: op(6): [started] processing unit "coreos-metadata.service" Jan 30 12:44:11.190334 ignition[948]: INFO : files: op(6): op(7): [started] writing unit "coreos-metadata.service" at "/sysroot/etc/systemd/system/coreos-metadata.service" Jan 30 12:44:11.190334 ignition[948]: INFO : files: op(6): op(7): [finished] writing unit "coreos-metadata.service" at "/sysroot/etc/systemd/system/coreos-metadata.service" Jan 30 12:44:11.190334 ignition[948]: INFO : files: op(6): [finished] processing unit "coreos-metadata.service" Jan 30 12:44:11.190334 ignition[948]: INFO : files: op(8): [started] setting preset to disabled for "coreos-metadata.service" Jan 30 12:44:11.194245 systemd-resolved[281]: Detected conflict on linux3 IN A 10.0.0.16 Jan 30 12:44:11.194257 systemd-resolved[281]: Hostname conflict, changing published hostname from 'linux3' to 'linux6'. Jan 30 12:44:11.224649 ignition[948]: INFO : files: op(8): op(9): [started] removing enablement symlink(s) for "coreos-metadata.service" Jan 30 12:44:11.228216 ignition[948]: INFO : files: op(8): op(9): [finished] removing enablement symlink(s) for "coreos-metadata.service" Jan 30 12:44:11.229402 ignition[948]: INFO : files: op(8): [finished] setting preset to disabled for "coreos-metadata.service" Jan 30 12:44:11.229402 ignition[948]: INFO : files: op(a): [started] setting preset to enabled for "etcd-member.service" Jan 30 12:44:11.229402 ignition[948]: INFO : files: op(a): [finished] setting preset to enabled for "etcd-member.service" Jan 30 12:44:11.229402 ignition[948]: INFO : files: createResultFile: createFiles: op(b): [started] writing file "/sysroot/etc/.ignition-result.json" Jan 30 12:44:11.229402 ignition[948]: INFO : files: createResultFile: createFiles: op(b): [finished] writing file "/sysroot/etc/.ignition-result.json" Jan 30 12:44:11.229402 ignition[948]: INFO : files: files passed Jan 30 12:44:11.229402 ignition[948]: INFO : Ignition finished successfully Jan 30 12:44:11.231239 systemd[1]: Finished ignition-files.service - Ignition (files). Jan 30 12:44:11.242404 systemd[1]: Starting ignition-quench.service - Ignition (record completion)... Jan 30 12:44:11.243926 systemd[1]: Starting initrd-setup-root-after-ignition.service - Root filesystem completion... Jan 30 12:44:11.246818 systemd[1]: ignition-quench.service: Deactivated successfully. Jan 30 12:44:11.246918 systemd[1]: Finished ignition-quench.service - Ignition (record completion). Jan 30 12:44:11.252851 initrd-setup-root-after-ignition[976]: grep: /sysroot/oem/oem-release: No such file or directory Jan 30 12:44:11.255253 initrd-setup-root-after-ignition[978]: grep: /sysroot/etc/flatcar/enabled-sysext.conf: No such file or directory Jan 30 12:44:11.255253 initrd-setup-root-after-ignition[978]: grep: /sysroot/usr/share/flatcar/enabled-sysext.conf: No such file or directory Jan 30 12:44:11.257818 initrd-setup-root-after-ignition[982]: grep: /sysroot/etc/flatcar/enabled-sysext.conf: No such file or directory Jan 30 12:44:11.257416 systemd[1]: Finished initrd-setup-root-after-ignition.service - Root filesystem completion. Jan 30 12:44:11.259255 systemd[1]: Reached target ignition-complete.target - Ignition Complete. Jan 30 12:44:11.278400 systemd[1]: Starting initrd-parse-etc.service - Mountpoints Configured in the Real Root... Jan 30 12:44:11.299617 systemd[1]: initrd-parse-etc.service: Deactivated successfully. Jan 30 12:44:11.299739 systemd[1]: Finished initrd-parse-etc.service - Mountpoints Configured in the Real Root. Jan 30 12:44:11.301620 systemd[1]: Reached target initrd-fs.target - Initrd File Systems. Jan 30 12:44:11.302986 systemd[1]: Reached target initrd.target - Initrd Default Target. Jan 30 12:44:11.304503 systemd[1]: dracut-mount.service - dracut mount hook was skipped because no trigger condition checks were met. Jan 30 12:44:11.305385 systemd[1]: Starting dracut-pre-pivot.service - dracut pre-pivot and cleanup hook... Jan 30 12:44:11.321321 systemd[1]: Finished dracut-pre-pivot.service - dracut pre-pivot and cleanup hook. Jan 30 12:44:11.331732 systemd[1]: Starting initrd-cleanup.service - Cleaning Up and Shutting Down Daemons... Jan 30 12:44:11.341270 systemd[1]: Stopped target nss-lookup.target - Host and Network Name Lookups. Jan 30 12:44:11.342332 systemd[1]: Stopped target remote-cryptsetup.target - Remote Encrypted Volumes. Jan 30 12:44:11.344110 systemd[1]: Stopped target timers.target - Timer Units. Jan 30 12:44:11.345641 systemd[1]: dracut-pre-pivot.service: Deactivated successfully. Jan 30 12:44:11.345767 systemd[1]: Stopped dracut-pre-pivot.service - dracut pre-pivot and cleanup hook. Jan 30 12:44:11.347973 systemd[1]: Stopped target initrd.target - Initrd Default Target. Jan 30 12:44:11.349750 systemd[1]: Stopped target basic.target - Basic System. Jan 30 12:44:11.351308 systemd[1]: Stopped target ignition-complete.target - Ignition Complete. Jan 30 12:44:11.352828 systemd[1]: Stopped target ignition-diskful.target - Ignition Boot Disk Setup. Jan 30 12:44:11.354521 systemd[1]: Stopped target initrd-root-device.target - Initrd Root Device. Jan 30 12:44:11.356256 systemd[1]: Stopped target remote-fs.target - Remote File Systems. Jan 30 12:44:11.357923 systemd[1]: Stopped target remote-fs-pre.target - Preparation for Remote File Systems. Jan 30 12:44:11.359525 systemd[1]: Stopped target sysinit.target - System Initialization. Jan 30 12:44:11.361298 systemd[1]: Stopped target local-fs.target - Local File Systems. Jan 30 12:44:11.362779 systemd[1]: Stopped target swap.target - Swaps. Jan 30 12:44:11.364008 systemd[1]: dracut-pre-mount.service: Deactivated successfully. Jan 30 12:44:11.364139 systemd[1]: Stopped dracut-pre-mount.service - dracut pre-mount hook. Jan 30 12:44:11.366102 systemd[1]: Stopped target cryptsetup.target - Local Encrypted Volumes. Jan 30 12:44:11.367863 systemd[1]: Stopped target cryptsetup-pre.target - Local Encrypted Volumes (Pre). Jan 30 12:44:11.369443 systemd[1]: clevis-luks-askpass.path: Deactivated successfully. Jan 30 12:44:11.371106 systemd[1]: Stopped clevis-luks-askpass.path - Forward Password Requests to Clevis Directory Watch. Jan 30 12:44:11.372562 systemd[1]: dracut-initqueue.service: Deactivated successfully. Jan 30 12:44:11.372703 systemd[1]: Stopped dracut-initqueue.service - dracut initqueue hook. Jan 30 12:44:11.375344 systemd[1]: ignition-fetch-offline.service: Deactivated successfully. Jan 30 12:44:11.375468 systemd[1]: Stopped ignition-fetch-offline.service - Ignition (fetch-offline). Jan 30 12:44:11.377191 systemd[1]: Stopped target paths.target - Path Units. Jan 30 12:44:11.378661 systemd[1]: systemd-ask-password-console.path: Deactivated successfully. Jan 30 12:44:11.381132 systemd[1]: Stopped systemd-ask-password-console.path - Dispatch Password Requests to Console Directory Watch. Jan 30 12:44:11.383428 systemd[1]: Stopped target slices.target - Slice Units. Jan 30 12:44:11.384286 systemd[1]: Stopped target sockets.target - Socket Units. Jan 30 12:44:11.385711 systemd[1]: iscsid.socket: Deactivated successfully. Jan 30 12:44:11.385804 systemd[1]: Closed iscsid.socket - Open-iSCSI iscsid Socket. Jan 30 12:44:11.387194 systemd[1]: iscsiuio.socket: Deactivated successfully. Jan 30 12:44:11.387289 systemd[1]: Closed iscsiuio.socket - Open-iSCSI iscsiuio Socket. Jan 30 12:44:11.388734 systemd[1]: initrd-setup-root-after-ignition.service: Deactivated successfully. Jan 30 12:44:11.388840 systemd[1]: Stopped initrd-setup-root-after-ignition.service - Root filesystem completion. Jan 30 12:44:11.390389 systemd[1]: ignition-files.service: Deactivated successfully. Jan 30 12:44:11.390485 systemd[1]: Stopped ignition-files.service - Ignition (files). Jan 30 12:44:11.404448 systemd[1]: Stopping ignition-mount.service - Ignition (mount)... Jan 30 12:44:11.405938 systemd[1]: Stopping sysroot-boot.service - /sysroot/boot... Jan 30 12:44:11.406652 systemd[1]: systemd-udev-trigger.service: Deactivated successfully. Jan 30 12:44:11.406765 systemd[1]: Stopped systemd-udev-trigger.service - Coldplug All udev Devices. Jan 30 12:44:11.408315 systemd[1]: dracut-pre-trigger.service: Deactivated successfully. Jan 30 12:44:11.408440 systemd[1]: Stopped dracut-pre-trigger.service - dracut pre-trigger hook. Jan 30 12:44:11.414847 systemd[1]: initrd-cleanup.service: Deactivated successfully. Jan 30 12:44:11.415793 systemd[1]: Finished initrd-cleanup.service - Cleaning Up and Shutting Down Daemons. Jan 30 12:44:11.419265 ignition[1002]: INFO : Ignition 2.20.0 Jan 30 12:44:11.419265 ignition[1002]: INFO : Stage: umount Jan 30 12:44:11.419265 ignition[1002]: INFO : no configs at "/usr/lib/ignition/base.d" Jan 30 12:44:11.419265 ignition[1002]: INFO : no config dir at "/usr/lib/ignition/base.platform.d/qemu" Jan 30 12:44:11.419265 ignition[1002]: INFO : umount: umount passed Jan 30 12:44:11.419265 ignition[1002]: INFO : Ignition finished successfully Jan 30 12:44:11.419538 systemd[1]: ignition-mount.service: Deactivated successfully. Jan 30 12:44:11.419661 systemd[1]: Stopped ignition-mount.service - Ignition (mount). Jan 30 12:44:11.421106 systemd[1]: Stopped target network.target - Network. Jan 30 12:44:11.423115 systemd[1]: ignition-disks.service: Deactivated successfully. Jan 30 12:44:11.423185 systemd[1]: Stopped ignition-disks.service - Ignition (disks). Jan 30 12:44:11.424281 systemd[1]: ignition-kargs.service: Deactivated successfully. Jan 30 12:44:11.424326 systemd[1]: Stopped ignition-kargs.service - Ignition (kargs). Jan 30 12:44:11.426322 systemd[1]: ignition-setup.service: Deactivated successfully. Jan 30 12:44:11.426375 systemd[1]: Stopped ignition-setup.service - Ignition (setup). Jan 30 12:44:11.427957 systemd[1]: ignition-setup-pre.service: Deactivated successfully. Jan 30 12:44:11.427995 systemd[1]: Stopped ignition-setup-pre.service - Ignition env setup. Jan 30 12:44:11.431146 systemd[1]: Stopping systemd-networkd.service - Network Configuration... Jan 30 12:44:11.432361 systemd[1]: Stopping systemd-resolved.service - Network Name Resolution... Jan 30 12:44:11.433032 systemd-networkd[764]: eth0: DHCPv6 lease lost Jan 30 12:44:11.434676 systemd[1]: sysroot-boot.mount: Deactivated successfully. Jan 30 12:44:11.435256 systemd[1]: systemd-networkd.service: Deactivated successfully. Jan 30 12:44:11.435350 systemd[1]: Stopped systemd-networkd.service - Network Configuration. Jan 30 12:44:11.437163 systemd[1]: sysroot-boot.service: Deactivated successfully. Jan 30 12:44:11.437258 systemd[1]: Stopped sysroot-boot.service - /sysroot/boot. Jan 30 12:44:11.438950 systemd[1]: systemd-networkd.socket: Deactivated successfully. Jan 30 12:44:11.439051 systemd[1]: Closed systemd-networkd.socket - Network Service Netlink Socket. Jan 30 12:44:11.440365 systemd[1]: initrd-setup-root.service: Deactivated successfully. Jan 30 12:44:11.440409 systemd[1]: Stopped initrd-setup-root.service - Root filesystem setup. Jan 30 12:44:11.448339 systemd[1]: Stopping network-cleanup.service - Network Cleanup... Jan 30 12:44:11.449237 systemd[1]: parse-ip-for-networkd.service: Deactivated successfully. Jan 30 12:44:11.449296 systemd[1]: Stopped parse-ip-for-networkd.service - Write systemd-networkd units from cmdline. Jan 30 12:44:11.450997 systemd[1]: Stopping systemd-udevd.service - Rule-based Manager for Device Events and Files... Jan 30 12:44:11.456267 systemd[1]: systemd-resolved.service: Deactivated successfully. Jan 30 12:44:11.456371 systemd[1]: Stopped systemd-resolved.service - Network Name Resolution. Jan 30 12:44:11.461044 systemd[1]: systemd-sysctl.service: Deactivated successfully. Jan 30 12:44:11.461106 systemd[1]: Stopped systemd-sysctl.service - Apply Kernel Variables. Jan 30 12:44:11.462038 systemd[1]: systemd-modules-load.service: Deactivated successfully. Jan 30 12:44:11.462084 systemd[1]: Stopped systemd-modules-load.service - Load Kernel Modules. Jan 30 12:44:11.463488 systemd[1]: systemd-tmpfiles-setup.service: Deactivated successfully. Jan 30 12:44:11.463532 systemd[1]: Stopped systemd-tmpfiles-setup.service - Create System Files and Directories. Jan 30 12:44:11.465502 systemd[1]: systemd-udevd.service: Deactivated successfully. Jan 30 12:44:11.465636 systemd[1]: Stopped systemd-udevd.service - Rule-based Manager for Device Events and Files. Jan 30 12:44:11.467770 systemd[1]: network-cleanup.service: Deactivated successfully. Jan 30 12:44:11.467874 systemd[1]: Stopped network-cleanup.service - Network Cleanup. Jan 30 12:44:11.469769 systemd[1]: systemd-udevd-control.socket: Deactivated successfully. Jan 30 12:44:11.469821 systemd[1]: Closed systemd-udevd-control.socket - udev Control Socket. Jan 30 12:44:11.471607 systemd[1]: systemd-udevd-kernel.socket: Deactivated successfully. Jan 30 12:44:11.471645 systemd[1]: Closed systemd-udevd-kernel.socket - udev Kernel Socket. Jan 30 12:44:11.473110 systemd[1]: dracut-pre-udev.service: Deactivated successfully. Jan 30 12:44:11.473157 systemd[1]: Stopped dracut-pre-udev.service - dracut pre-udev hook. Jan 30 12:44:11.475301 systemd[1]: dracut-cmdline.service: Deactivated successfully. Jan 30 12:44:11.475347 systemd[1]: Stopped dracut-cmdline.service - dracut cmdline hook. Jan 30 12:44:11.477770 systemd[1]: dracut-cmdline-ask.service: Deactivated successfully. Jan 30 12:44:11.477819 systemd[1]: Stopped dracut-cmdline-ask.service - dracut ask for additional cmdline parameters. Jan 30 12:44:11.492420 systemd[1]: Starting initrd-udevadm-cleanup-db.service - Cleanup udev Database... Jan 30 12:44:11.493288 systemd[1]: systemd-tmpfiles-setup-dev.service: Deactivated successfully. Jan 30 12:44:11.493352 systemd[1]: Stopped systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev. Jan 30 12:44:11.495052 systemd[1]: systemd-tmpfiles-setup-dev-early.service: Deactivated successfully. Jan 30 12:44:11.495096 systemd[1]: Stopped systemd-tmpfiles-setup-dev-early.service - Create Static Device Nodes in /dev gracefully. Jan 30 12:44:11.496723 systemd[1]: kmod-static-nodes.service: Deactivated successfully. Jan 30 12:44:11.496764 systemd[1]: Stopped kmod-static-nodes.service - Create List of Static Device Nodes. Jan 30 12:44:11.498532 systemd[1]: systemd-vconsole-setup.service: Deactivated successfully. Jan 30 12:44:11.498573 systemd[1]: Stopped systemd-vconsole-setup.service - Virtual Console Setup. Jan 30 12:44:11.500648 systemd[1]: initrd-udevadm-cleanup-db.service: Deactivated successfully. Jan 30 12:44:11.500735 systemd[1]: Finished initrd-udevadm-cleanup-db.service - Cleanup udev Database. Jan 30 12:44:11.502632 systemd[1]: Reached target initrd-switch-root.target - Switch Root. Jan 30 12:44:11.505352 systemd[1]: Starting initrd-switch-root.service - Switch Root... Jan 30 12:44:11.514301 systemd[1]: Switching root. Jan 30 12:44:11.547980 systemd-journald[236]: Journal stopped Jan 30 12:44:12.250354 systemd-journald[236]: Received SIGTERM from PID 1 (systemd). Jan 30 12:44:12.250411 kernel: SELinux: policy capability network_peer_controls=1 Jan 30 12:44:12.250424 kernel: SELinux: policy capability open_perms=1 Jan 30 12:44:12.250439 kernel: SELinux: policy capability extended_socket_class=1 Jan 30 12:44:12.250448 kernel: SELinux: policy capability always_check_network=0 Jan 30 12:44:12.250458 kernel: SELinux: policy capability cgroup_seclabel=1 Jan 30 12:44:12.250468 kernel: SELinux: policy capability nnp_nosuid_transition=1 Jan 30 12:44:12.250477 kernel: SELinux: policy capability genfs_seclabel_symlinks=0 Jan 30 12:44:12.250487 kernel: SELinux: policy capability ioctl_skip_cloexec=0 Jan 30 12:44:12.250496 kernel: audit: type=1403 audit(1738241051.623:2): auid=4294967295 ses=4294967295 lsm=selinux res=1 Jan 30 12:44:12.250507 systemd[1]: Successfully loaded SELinux policy in 38.001ms. Jan 30 12:44:12.250523 systemd[1]: Relabeled /dev, /dev/shm, /run, /sys/fs/cgroup in 9.691ms. Jan 30 12:44:12.250535 systemd[1]: systemd 255 running in system mode (+PAM +AUDIT +SELINUX -APPARMOR +IMA +SMACK +SECCOMP +GCRYPT -GNUTLS +OPENSSL -ACL +BLKID +CURL +ELFUTILS -FIDO2 +IDN2 -IDN +IPTC +KMOD +LIBCRYPTSETUP +LIBFDISK +PCRE2 -PWQUALITY -P11KIT -QRENCODE +TPM2 +BZIP2 +LZ4 +XZ +ZLIB +ZSTD -BPF_FRAMEWORK -XKBCOMMON +UTMP -SYSVINIT default-hierarchy=unified) Jan 30 12:44:12.250546 systemd[1]: Detected virtualization kvm. Jan 30 12:44:12.250556 systemd[1]: Detected architecture arm64. Jan 30 12:44:12.250566 systemd[1]: Detected first boot. Jan 30 12:44:12.250583 systemd[1]: Initializing machine ID from VM UUID. Jan 30 12:44:12.250597 zram_generator::config[1046]: No configuration found. Jan 30 12:44:12.250609 systemd[1]: Populated /etc with preset unit settings. Jan 30 12:44:12.250619 systemd[1]: initrd-switch-root.service: Deactivated successfully. Jan 30 12:44:12.250631 systemd[1]: Stopped initrd-switch-root.service - Switch Root. Jan 30 12:44:12.250644 systemd[1]: systemd-journald.service: Scheduled restart job, restart counter is at 1. Jan 30 12:44:12.250656 systemd[1]: Created slice system-addon\x2dconfig.slice - Slice /system/addon-config. Jan 30 12:44:12.250666 systemd[1]: Created slice system-addon\x2drun.slice - Slice /system/addon-run. Jan 30 12:44:12.250678 systemd[1]: Created slice system-getty.slice - Slice /system/getty. Jan 30 12:44:12.250690 systemd[1]: Created slice system-modprobe.slice - Slice /system/modprobe. Jan 30 12:44:12.250704 systemd[1]: Created slice system-serial\x2dgetty.slice - Slice /system/serial-getty. Jan 30 12:44:12.250715 systemd[1]: Created slice system-system\x2dcloudinit.slice - Slice /system/system-cloudinit. Jan 30 12:44:12.250726 systemd[1]: Created slice system-systemd\x2dfsck.slice - Slice /system/systemd-fsck. Jan 30 12:44:12.250737 systemd[1]: Created slice user.slice - User and Session Slice. Jan 30 12:44:12.250748 systemd[1]: Started clevis-luks-askpass.path - Forward Password Requests to Clevis Directory Watch. Jan 30 12:44:12.250758 systemd[1]: Started systemd-ask-password-console.path - Dispatch Password Requests to Console Directory Watch. Jan 30 12:44:12.250769 systemd[1]: Started systemd-ask-password-wall.path - Forward Password Requests to Wall Directory Watch. Jan 30 12:44:12.250779 systemd[1]: Set up automount boot.automount - Boot partition Automount Point. Jan 30 12:44:12.250791 systemd[1]: Set up automount proc-sys-fs-binfmt_misc.automount - Arbitrary Executable File Formats File System Automount Point. Jan 30 12:44:12.250802 systemd[1]: Expecting device dev-disk-by\x2dlabel-OEM.device - /dev/disk/by-label/OEM... Jan 30 12:44:12.250813 systemd[1]: Expecting device dev-ttyAMA0.device - /dev/ttyAMA0... Jan 30 12:44:12.250823 systemd[1]: Reached target cryptsetup-pre.target - Local Encrypted Volumes (Pre). Jan 30 12:44:12.250834 systemd[1]: Stopped target initrd-switch-root.target - Switch Root. Jan 30 12:44:12.250844 systemd[1]: Stopped target initrd-fs.target - Initrd File Systems. Jan 30 12:44:12.250854 systemd[1]: Stopped target initrd-root-fs.target - Initrd Root File System. Jan 30 12:44:12.250866 systemd[1]: Reached target integritysetup.target - Local Integrity Protected Volumes. Jan 30 12:44:12.250876 systemd[1]: Reached target remote-cryptsetup.target - Remote Encrypted Volumes. Jan 30 12:44:12.250887 systemd[1]: Reached target remote-fs.target - Remote File Systems. Jan 30 12:44:12.250897 systemd[1]: Reached target slices.target - Slice Units. Jan 30 12:44:12.250909 systemd[1]: Reached target swap.target - Swaps. Jan 30 12:44:12.250919 systemd[1]: Reached target veritysetup.target - Local Verity Protected Volumes. Jan 30 12:44:12.250930 systemd[1]: Listening on systemd-coredump.socket - Process Core Dump Socket. Jan 30 12:44:12.250940 systemd[1]: Listening on systemd-networkd.socket - Network Service Netlink Socket. Jan 30 12:44:12.250951 systemd[1]: Listening on systemd-udevd-control.socket - udev Control Socket. Jan 30 12:44:12.250961 systemd[1]: Listening on systemd-udevd-kernel.socket - udev Kernel Socket. Jan 30 12:44:12.250973 systemd[1]: Listening on systemd-userdbd.socket - User Database Manager Socket. Jan 30 12:44:12.250983 systemd[1]: Mounting dev-hugepages.mount - Huge Pages File System... Jan 30 12:44:12.250994 systemd[1]: Mounting dev-mqueue.mount - POSIX Message Queue File System... Jan 30 12:44:12.251004 systemd[1]: Mounting media.mount - External Media Directory... Jan 30 12:44:12.251015 systemd[1]: Mounting sys-kernel-debug.mount - Kernel Debug File System... Jan 30 12:44:12.251025 systemd[1]: Mounting sys-kernel-tracing.mount - Kernel Trace File System... Jan 30 12:44:12.251036 systemd[1]: Mounting tmp.mount - Temporary Directory /tmp... Jan 30 12:44:12.251046 systemd[1]: var-lib-machines.mount - Virtual Machine and Container Storage (Compatibility) was skipped because of an unmet condition check (ConditionPathExists=/var/lib/machines.raw). Jan 30 12:44:12.251058 systemd[1]: Reached target machines.target - Containers. Jan 30 12:44:12.251069 systemd[1]: Starting flatcar-tmpfiles.service - Create missing system files... Jan 30 12:44:12.251079 systemd[1]: ignition-delete-config.service - Ignition (delete config) was skipped because no trigger condition checks were met. Jan 30 12:44:12.251090 systemd[1]: Starting kmod-static-nodes.service - Create List of Static Device Nodes... Jan 30 12:44:12.251100 systemd[1]: Starting modprobe@configfs.service - Load Kernel Module configfs... Jan 30 12:44:12.251110 systemd[1]: Starting modprobe@dm_mod.service - Load Kernel Module dm_mod... Jan 30 12:44:12.251121 systemd[1]: Starting modprobe@drm.service - Load Kernel Module drm... Jan 30 12:44:12.251132 systemd[1]: Starting modprobe@efi_pstore.service - Load Kernel Module efi_pstore... Jan 30 12:44:12.251142 systemd[1]: Starting modprobe@fuse.service - Load Kernel Module fuse... Jan 30 12:44:12.251155 systemd[1]: Starting modprobe@loop.service - Load Kernel Module loop... Jan 30 12:44:12.251166 systemd[1]: setup-nsswitch.service - Create /etc/nsswitch.conf was skipped because of an unmet condition check (ConditionPathExists=!/etc/nsswitch.conf). Jan 30 12:44:12.251177 systemd[1]: systemd-fsck-root.service: Deactivated successfully. Jan 30 12:44:12.251187 systemd[1]: Stopped systemd-fsck-root.service - File System Check on Root Device. Jan 30 12:44:12.251198 systemd[1]: systemd-fsck-usr.service: Deactivated successfully. Jan 30 12:44:12.251217 systemd[1]: Stopped systemd-fsck-usr.service. Jan 30 12:44:12.251229 kernel: fuse: init (API version 7.39) Jan 30 12:44:12.251239 systemd[1]: Starting systemd-journald.service - Journal Service... Jan 30 12:44:12.251249 systemd[1]: Starting systemd-modules-load.service - Load Kernel Modules... Jan 30 12:44:12.251262 kernel: loop: module loaded Jan 30 12:44:12.251272 systemd[1]: Starting systemd-network-generator.service - Generate network units from Kernel command line... Jan 30 12:44:12.251282 systemd[1]: Starting systemd-remount-fs.service - Remount Root and Kernel File Systems... Jan 30 12:44:12.251292 systemd[1]: Starting systemd-udev-trigger.service - Coldplug All udev Devices... Jan 30 12:44:12.251303 systemd[1]: verity-setup.service: Deactivated successfully. Jan 30 12:44:12.251313 systemd[1]: Stopped verity-setup.service. Jan 30 12:44:12.251323 systemd[1]: Mounted dev-hugepages.mount - Huge Pages File System. Jan 30 12:44:12.251334 systemd[1]: Mounted dev-mqueue.mount - POSIX Message Queue File System. Jan 30 12:44:12.251346 kernel: ACPI: bus type drm_connector registered Jan 30 12:44:12.251356 systemd[1]: Mounted media.mount - External Media Directory. Jan 30 12:44:12.251391 systemd-journald[1113]: Collecting audit messages is disabled. Jan 30 12:44:12.251411 systemd[1]: Mounted sys-kernel-debug.mount - Kernel Debug File System. Jan 30 12:44:12.251424 systemd[1]: Mounted sys-kernel-tracing.mount - Kernel Trace File System. Jan 30 12:44:12.251434 systemd-journald[1113]: Journal started Jan 30 12:44:12.251460 systemd-journald[1113]: Runtime Journal (/run/log/journal/9f71c6933da04ad79f9683bcd3c39978) is 5.9M, max 47.3M, 41.4M free. Jan 30 12:44:12.052702 systemd[1]: Queued start job for default target multi-user.target. Jan 30 12:44:12.073593 systemd[1]: Unnecessary job was removed for dev-vda6.device - /dev/vda6. Jan 30 12:44:12.073975 systemd[1]: systemd-journald.service: Deactivated successfully. Jan 30 12:44:12.254870 systemd[1]: Started systemd-journald.service - Journal Service. Jan 30 12:44:12.255547 systemd[1]: Mounted tmp.mount - Temporary Directory /tmp. Jan 30 12:44:12.256693 systemd[1]: Finished kmod-static-nodes.service - Create List of Static Device Nodes. Jan 30 12:44:12.258043 systemd[1]: modprobe@configfs.service: Deactivated successfully. Jan 30 12:44:12.259230 systemd[1]: Finished modprobe@configfs.service - Load Kernel Module configfs. Jan 30 12:44:12.260444 systemd[1]: modprobe@dm_mod.service: Deactivated successfully. Jan 30 12:44:12.260588 systemd[1]: Finished modprobe@dm_mod.service - Load Kernel Module dm_mod. Jan 30 12:44:12.261928 systemd[1]: modprobe@drm.service: Deactivated successfully. Jan 30 12:44:12.263279 systemd[1]: Finished modprobe@drm.service - Load Kernel Module drm. Jan 30 12:44:12.264441 systemd[1]: modprobe@efi_pstore.service: Deactivated successfully. Jan 30 12:44:12.264572 systemd[1]: Finished modprobe@efi_pstore.service - Load Kernel Module efi_pstore. Jan 30 12:44:12.266250 systemd[1]: modprobe@fuse.service: Deactivated successfully. Jan 30 12:44:12.266373 systemd[1]: Finished modprobe@fuse.service - Load Kernel Module fuse. Jan 30 12:44:12.267752 systemd[1]: modprobe@loop.service: Deactivated successfully. Jan 30 12:44:12.267872 systemd[1]: Finished modprobe@loop.service - Load Kernel Module loop. Jan 30 12:44:12.269063 systemd[1]: Finished systemd-modules-load.service - Load Kernel Modules. Jan 30 12:44:12.270413 systemd[1]: Finished systemd-network-generator.service - Generate network units from Kernel command line. Jan 30 12:44:12.271879 systemd[1]: Finished flatcar-tmpfiles.service - Create missing system files. Jan 30 12:44:12.273126 systemd[1]: Finished systemd-remount-fs.service - Remount Root and Kernel File Systems. Jan 30 12:44:12.284909 systemd[1]: Reached target network-pre.target - Preparation for Network. Jan 30 12:44:12.306347 systemd[1]: Mounting sys-fs-fuse-connections.mount - FUSE Control File System... Jan 30 12:44:12.308300 systemd[1]: Mounting sys-kernel-config.mount - Kernel Configuration File System... Jan 30 12:44:12.309253 systemd[1]: remount-root.service - Remount Root File System was skipped because of an unmet condition check (ConditionPathIsReadWrite=!/). Jan 30 12:44:12.309293 systemd[1]: Reached target local-fs.target - Local File Systems. Jan 30 12:44:12.310989 systemd[1]: Listening on systemd-sysext.socket - System Extension Image Management (Varlink). Jan 30 12:44:12.312972 systemd[1]: Starting dracut-shutdown.service - Restore /run/initramfs on shutdown... Jan 30 12:44:12.314943 systemd[1]: Starting ldconfig.service - Rebuild Dynamic Linker Cache... Jan 30 12:44:12.315860 systemd[1]: systemd-binfmt.service - Set Up Additional Binary Formats was skipped because no trigger condition checks were met. Jan 30 12:44:12.317271 systemd[1]: Starting systemd-hwdb-update.service - Rebuild Hardware Database... Jan 30 12:44:12.319023 systemd[1]: Starting systemd-journal-flush.service - Flush Journal to Persistent Storage... Jan 30 12:44:12.320110 systemd[1]: systemd-pstore.service - Platform Persistent Storage Archival was skipped because of an unmet condition check (ConditionDirectoryNotEmpty=/sys/fs/pstore). Jan 30 12:44:12.323374 systemd[1]: Starting systemd-random-seed.service - Load/Save OS Random Seed... Jan 30 12:44:12.324424 systemd[1]: systemd-repart.service - Repartition Root Disk was skipped because no trigger condition checks were met. Jan 30 12:44:12.328395 systemd[1]: Starting systemd-sysctl.service - Apply Kernel Variables... Jan 30 12:44:12.328968 systemd-journald[1113]: Time spent on flushing to /var/log/journal/9f71c6933da04ad79f9683bcd3c39978 is 18.136ms for 835 entries. Jan 30 12:44:12.328968 systemd-journald[1113]: System Journal (/var/log/journal/9f71c6933da04ad79f9683bcd3c39978) is 8.0M, max 195.6M, 187.6M free. Jan 30 12:44:12.378906 systemd-journald[1113]: Received client request to flush runtime journal. Jan 30 12:44:12.378980 kernel: loop0: detected capacity change from 0 to 113552 Jan 30 12:44:12.331649 systemd[1]: Starting systemd-sysext.service - Merge System Extension Images into /usr/ and /opt/... Jan 30 12:44:12.337493 systemd[1]: Starting systemd-tmpfiles-setup-dev-early.service - Create Static Device Nodes in /dev gracefully... Jan 30 12:44:12.341280 systemd[1]: Finished systemd-udev-trigger.service - Coldplug All udev Devices. Jan 30 12:44:12.343371 systemd[1]: Mounted sys-fs-fuse-connections.mount - FUSE Control File System. Jan 30 12:44:12.344711 systemd[1]: Mounted sys-kernel-config.mount - Kernel Configuration File System. Jan 30 12:44:12.346493 systemd[1]: Finished dracut-shutdown.service - Restore /run/initramfs on shutdown. Jan 30 12:44:12.352321 systemd[1]: Finished systemd-random-seed.service - Load/Save OS Random Seed. Jan 30 12:44:12.354312 systemd[1]: Reached target first-boot-complete.target - First Boot Complete. Jan 30 12:44:12.366447 systemd[1]: Starting systemd-machine-id-commit.service - Commit a transient machine-id on disk... Jan 30 12:44:12.371521 systemd[1]: Starting systemd-udev-settle.service - Wait for udev To Complete Device Initialization... Jan 30 12:44:12.374533 systemd[1]: Finished systemd-sysctl.service - Apply Kernel Variables. Jan 30 12:44:12.388093 systemd[1]: Finished systemd-journal-flush.service - Flush Journal to Persistent Storage. Jan 30 12:44:12.388668 systemd-tmpfiles[1159]: ACLs are not supported, ignoring. Jan 30 12:44:12.388683 systemd-tmpfiles[1159]: ACLs are not supported, ignoring. Jan 30 12:44:12.395979 systemd[1]: Finished systemd-tmpfiles-setup-dev-early.service - Create Static Device Nodes in /dev gracefully. Jan 30 12:44:12.410586 systemd[1]: Starting systemd-sysusers.service - Create System Users... Jan 30 12:44:12.413266 kernel: squashfs: version 4.0 (2009/01/31) Phillip Lougher Jan 30 12:44:12.415641 udevadm[1169]: systemd-udev-settle.service is deprecated. Please fix lvm2-activation.service, lvm2-activation-early.service not to pull it in. Jan 30 12:44:12.429502 systemd[1]: etc-machine\x2did.mount: Deactivated successfully. Jan 30 12:44:12.430219 systemd[1]: Finished systemd-machine-id-commit.service - Commit a transient machine-id on disk. Jan 30 12:44:12.441231 kernel: loop1: detected capacity change from 0 to 116784 Jan 30 12:44:12.445219 systemd[1]: Finished systemd-sysusers.service - Create System Users. Jan 30 12:44:12.453583 systemd[1]: Starting systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev... Jan 30 12:44:12.467274 systemd-tmpfiles[1181]: ACLs are not supported, ignoring. Jan 30 12:44:12.467294 systemd-tmpfiles[1181]: ACLs are not supported, ignoring. Jan 30 12:44:12.471791 systemd[1]: Finished systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev. Jan 30 12:44:12.480243 kernel: loop2: detected capacity change from 0 to 113552 Jan 30 12:44:12.486233 kernel: loop3: detected capacity change from 0 to 116784 Jan 30 12:44:12.493610 (sd-merge)[1185]: Using extensions 'containerd-flatcar', 'docker-flatcar'. Jan 30 12:44:12.493961 (sd-merge)[1185]: Merged extensions into '/usr'. Jan 30 12:44:12.498237 systemd[1]: Finished systemd-sysext.service - Merge System Extension Images into /usr/ and /opt/. Jan 30 12:44:12.509464 systemd[1]: Starting ensure-sysext.service... Jan 30 12:44:12.511510 systemd[1]: Starting systemd-tmpfiles-setup.service - Create System Files and Directories... Jan 30 12:44:12.528540 systemd[1]: Reloading requested from client PID 1187 ('systemctl') (unit ensure-sysext.service)... Jan 30 12:44:12.528559 systemd[1]: Reloading... Jan 30 12:44:12.539619 systemd-tmpfiles[1188]: /usr/lib/tmpfiles.d/provision.conf:20: Duplicate line for path "/root", ignoring. Jan 30 12:44:12.539846 systemd-tmpfiles[1188]: /usr/lib/tmpfiles.d/systemd-flatcar.conf:6: Duplicate line for path "/var/log/journal", ignoring. Jan 30 12:44:12.540621 systemd-tmpfiles[1188]: /usr/lib/tmpfiles.d/systemd.conf:29: Duplicate line for path "/var/lib/systemd", ignoring. Jan 30 12:44:12.540848 systemd-tmpfiles[1188]: ACLs are not supported, ignoring. Jan 30 12:44:12.540903 systemd-tmpfiles[1188]: ACLs are not supported, ignoring. Jan 30 12:44:12.544510 systemd-tmpfiles[1188]: Detected autofs mount point /boot during canonicalization of boot. Jan 30 12:44:12.544523 systemd-tmpfiles[1188]: Skipping /boot Jan 30 12:44:12.553426 systemd-tmpfiles[1188]: Detected autofs mount point /boot during canonicalization of boot. Jan 30 12:44:12.553443 systemd-tmpfiles[1188]: Skipping /boot Jan 30 12:44:12.591579 zram_generator::config[1216]: No configuration found. Jan 30 12:44:12.696075 systemd[1]: /usr/lib/systemd/system/docker.socket:6: ListenStream= references a path below legacy directory /var/run/, updating /var/run/docker.sock → /run/docker.sock; please update the unit file accordingly. Jan 30 12:44:12.733678 systemd[1]: Reloading finished in 204 ms. Jan 30 12:44:12.739340 ldconfig[1152]: /sbin/ldconfig: /usr/lib/ld.so.conf is not an ELF file - it has the wrong magic bytes at the start. Jan 30 12:44:12.781307 systemd[1]: Finished ldconfig.service - Rebuild Dynamic Linker Cache. Jan 30 12:44:12.785287 systemd[1]: Finished systemd-tmpfiles-setup.service - Create System Files and Directories. Jan 30 12:44:12.792687 systemd[1]: Starting audit-rules.service - Load Audit Rules... Jan 30 12:44:12.795341 systemd[1]: Starting clean-ca-certificates.service - Clean up broken links in /etc/ssl/certs... Jan 30 12:44:12.799766 systemd[1]: Starting systemd-journal-catalog-update.service - Rebuild Journal Catalog... Jan 30 12:44:12.812711 systemd[1]: Starting systemd-resolved.service - Network Name Resolution... Jan 30 12:44:12.818921 systemd[1]: Starting systemd-update-utmp.service - Record System Boot/Shutdown in UTMP... Jan 30 12:44:12.824382 systemd[1]: ignition-delete-config.service - Ignition (delete config) was skipped because no trigger condition checks were met. Jan 30 12:44:12.825985 systemd[1]: Starting modprobe@dm_mod.service - Load Kernel Module dm_mod... Jan 30 12:44:12.833090 systemd[1]: Starting modprobe@efi_pstore.service - Load Kernel Module efi_pstore... Jan 30 12:44:12.836611 systemd[1]: Starting modprobe@loop.service - Load Kernel Module loop... Jan 30 12:44:12.837746 systemd[1]: systemd-binfmt.service - Set Up Additional Binary Formats was skipped because no trigger condition checks were met. Jan 30 12:44:12.840125 systemd[1]: Finished systemd-journal-catalog-update.service - Rebuild Journal Catalog. Jan 30 12:44:12.843171 systemd[1]: modprobe@efi_pstore.service: Deactivated successfully. Jan 30 12:44:12.843552 systemd[1]: Finished modprobe@efi_pstore.service - Load Kernel Module efi_pstore. Jan 30 12:44:12.845933 systemd[1]: modprobe@dm_mod.service: Deactivated successfully. Jan 30 12:44:12.846080 systemd[1]: Finished modprobe@dm_mod.service - Load Kernel Module dm_mod. Jan 30 12:44:12.848073 systemd[1]: modprobe@loop.service: Deactivated successfully. Jan 30 12:44:12.849281 systemd[1]: Finished modprobe@loop.service - Load Kernel Module loop. Jan 30 12:44:12.862513 systemd[1]: systemd-pstore.service - Platform Persistent Storage Archival was skipped because of an unmet condition check (ConditionDirectoryNotEmpty=/sys/fs/pstore). Jan 30 12:44:12.862862 systemd[1]: systemd-repart.service - Repartition Root Disk was skipped because no trigger condition checks were met. Jan 30 12:44:12.877610 systemd[1]: Starting systemd-userdbd.service - User Database Manager... Jan 30 12:44:12.881665 systemd[1]: Finished systemd-update-utmp.service - Record System Boot/Shutdown in UTMP. Jan 30 12:44:12.887390 systemd[1]: ignition-delete-config.service - Ignition (delete config) was skipped because no trigger condition checks were met. Jan 30 12:44:12.900534 systemd[1]: Starting modprobe@dm_mod.service - Load Kernel Module dm_mod... Jan 30 12:44:12.904448 systemd[1]: Starting modprobe@efi_pstore.service - Load Kernel Module efi_pstore... Jan 30 12:44:12.907048 systemd[1]: Starting modprobe@loop.service - Load Kernel Module loop... Jan 30 12:44:12.907976 systemd[1]: systemd-binfmt.service - Set Up Additional Binary Formats was skipped because no trigger condition checks were met. Jan 30 12:44:12.909278 systemd[1]: Finished clean-ca-certificates.service - Clean up broken links in /etc/ssl/certs. Jan 30 12:44:12.911024 systemd[1]: modprobe@dm_mod.service: Deactivated successfully. Jan 30 12:44:12.911593 systemd[1]: Finished modprobe@dm_mod.service - Load Kernel Module dm_mod. Jan 30 12:44:12.917775 systemd[1]: modprobe@efi_pstore.service: Deactivated successfully. Jan 30 12:44:12.918362 systemd[1]: Finished modprobe@efi_pstore.service - Load Kernel Module efi_pstore. Jan 30 12:44:12.919412 augenrules[1287]: No rules Jan 30 12:44:12.920092 systemd[1]: modprobe@loop.service: Deactivated successfully. Jan 30 12:44:12.920395 systemd[1]: Finished modprobe@loop.service - Load Kernel Module loop. Jan 30 12:44:12.921693 systemd[1]: audit-rules.service: Deactivated successfully. Jan 30 12:44:12.921880 systemd[1]: Finished audit-rules.service - Load Audit Rules. Jan 30 12:44:12.928953 systemd[1]: Started systemd-userdbd.service - User Database Manager. Jan 30 12:44:12.930940 systemd[1]: Finished systemd-hwdb-update.service - Rebuild Hardware Database. Jan 30 12:44:12.957669 systemd[1]: Starting audit-rules.service - Load Audit Rules... Jan 30 12:44:12.958687 systemd[1]: ignition-delete-config.service - Ignition (delete config) was skipped because no trigger condition checks were met. Jan 30 12:44:12.960313 systemd[1]: Starting modprobe@dm_mod.service - Load Kernel Module dm_mod... Jan 30 12:44:12.964482 systemd[1]: Starting modprobe@drm.service - Load Kernel Module drm... Jan 30 12:44:12.967690 systemd[1]: Starting modprobe@efi_pstore.service - Load Kernel Module efi_pstore... Jan 30 12:44:12.971638 systemd[1]: Starting modprobe@loop.service - Load Kernel Module loop... Jan 30 12:44:12.975176 systemd[1]: systemd-binfmt.service - Set Up Additional Binary Formats was skipped because no trigger condition checks were met. Jan 30 12:44:12.977559 systemd[1]: Starting systemd-udevd.service - Rule-based Manager for Device Events and Files... Jan 30 12:44:12.979274 augenrules[1303]: /sbin/augenrules: No change Jan 30 12:44:12.980393 systemd[1]: Starting systemd-update-done.service - Update is Completed... Jan 30 12:44:12.981722 systemd[1]: update-ca-certificates.service - Update CA bundle at /etc/ssl/certs/ca-certificates.crt was skipped because of an unmet condition check (ConditionPathIsSymbolicLink=!/etc/ssl/certs/ca-certificates.crt). Jan 30 12:44:12.983260 systemd[1]: modprobe@dm_mod.service: Deactivated successfully. Jan 30 12:44:12.984362 systemd[1]: Finished modprobe@dm_mod.service - Load Kernel Module dm_mod. Jan 30 12:44:12.988789 systemd[1]: modprobe@drm.service: Deactivated successfully. Jan 30 12:44:12.988941 systemd[1]: Finished modprobe@drm.service - Load Kernel Module drm. Jan 30 12:44:12.990371 systemd[1]: modprobe@efi_pstore.service: Deactivated successfully. Jan 30 12:44:12.990529 systemd[1]: Finished modprobe@efi_pstore.service - Load Kernel Module efi_pstore. Jan 30 12:44:12.997254 augenrules[1327]: No rules Jan 30 12:44:12.997219 systemd[1]: modprobe@loop.service: Deactivated successfully. Jan 30 12:44:12.997361 systemd[1]: Finished modprobe@loop.service - Load Kernel Module loop. Jan 30 12:44:13.002285 systemd[1]: Finished ensure-sysext.service. Jan 30 12:44:13.003819 systemd[1]: audit-rules.service: Deactivated successfully. Jan 30 12:44:13.005386 systemd[1]: Finished audit-rules.service - Load Audit Rules. Jan 30 12:44:13.006579 systemd[1]: Finished systemd-update-done.service - Update is Completed. Jan 30 12:44:13.011708 systemd[1]: systemd-pstore.service - Platform Persistent Storage Archival was skipped because of an unmet condition check (ConditionDirectoryNotEmpty=/sys/fs/pstore). Jan 30 12:44:13.011818 systemd[1]: systemd-repart.service - Repartition Root Disk was skipped because no trigger condition checks were met. Jan 30 12:44:13.016310 systemd-udevd[1318]: Using default interface naming scheme 'v255'. Jan 30 12:44:13.025407 systemd[1]: Starting systemd-timesyncd.service - Network Time Synchronization... Jan 30 12:44:13.044996 systemd-resolved[1260]: Positive Trust Anchors: Jan 30 12:44:13.045019 systemd-resolved[1260]: . IN DS 20326 8 2 e06d44b80b8f1d39a95c0b0d7c65d08458e880409bbc683457104237c7f8ec8d Jan 30 12:44:13.045051 systemd-resolved[1260]: Negative trust anchors: home.arpa 10.in-addr.arpa 16.172.in-addr.arpa 17.172.in-addr.arpa 18.172.in-addr.arpa 19.172.in-addr.arpa 20.172.in-addr.arpa 21.172.in-addr.arpa 22.172.in-addr.arpa 23.172.in-addr.arpa 24.172.in-addr.arpa 25.172.in-addr.arpa 26.172.in-addr.arpa 27.172.in-addr.arpa 28.172.in-addr.arpa 29.172.in-addr.arpa 30.172.in-addr.arpa 31.172.in-addr.arpa 170.0.0.192.in-addr.arpa 171.0.0.192.in-addr.arpa 168.192.in-addr.arpa d.f.ip6.arpa ipv4only.arpa resolver.arpa corp home internal intranet lan local private test Jan 30 12:44:13.045818 systemd[1]: Started systemd-udevd.service - Rule-based Manager for Device Events and Files. Jan 30 12:44:13.050348 systemd[1]: Starting systemd-networkd.service - Network Configuration... Jan 30 12:44:13.057951 systemd-resolved[1260]: Defaulting to hostname 'linux'. Jan 30 12:44:13.068707 systemd[1]: Started systemd-resolved.service - Network Name Resolution. Jan 30 12:44:13.070230 systemd[1]: Reached target nss-lookup.target - Host and Network Name Lookups. Jan 30 12:44:13.091425 systemd[1]: Condition check resulted in dev-ttyAMA0.device - /dev/ttyAMA0 being skipped. Jan 30 12:44:13.113303 systemd[1]: Started systemd-timesyncd.service - Network Time Synchronization. Jan 30 12:44:13.116024 systemd[1]: Reached target time-set.target - System Time Set. Jan 30 12:44:13.134304 kernel: BTRFS warning: duplicate device /dev/vda3 devid 1 generation 39 scanned by (udev-worker) (1350) Jan 30 12:44:13.167955 systemd-networkd[1345]: lo: Link UP Jan 30 12:44:13.167963 systemd-networkd[1345]: lo: Gained carrier Jan 30 12:44:13.174329 systemd[1]: Found device dev-disk-by\x2dlabel-OEM.device - /dev/disk/by-label/OEM. Jan 30 12:44:13.174469 systemd-networkd[1345]: Enumeration completed Jan 30 12:44:13.175465 systemd[1]: Started systemd-networkd.service - Network Configuration. Jan 30 12:44:13.176424 systemd[1]: Reached target network.target - Network. Jan 30 12:44:13.182500 systemd-networkd[1345]: eth0: found matching network '/usr/lib/systemd/network/zz-default.network', based on potentially unpredictable interface name. Jan 30 12:44:13.182513 systemd-networkd[1345]: eth0: Configuring with /usr/lib/systemd/network/zz-default.network. Jan 30 12:44:13.183932 systemd-networkd[1345]: eth0: Link UP Jan 30 12:44:13.183943 systemd-networkd[1345]: eth0: Gained carrier Jan 30 12:44:13.183960 systemd-networkd[1345]: eth0: found matching network '/usr/lib/systemd/network/zz-default.network', based on potentially unpredictable interface name. Jan 30 12:44:13.188484 systemd[1]: Starting systemd-fsck@dev-disk-by\x2dlabel-OEM.service - File System Check on /dev/disk/by-label/OEM... Jan 30 12:44:13.193640 systemd[1]: Starting systemd-networkd-wait-online.service - Wait for Network to be Configured... Jan 30 12:44:13.225526 systemd[1]: Starting systemd-vconsole-setup.service - Virtual Console Setup... Jan 30 12:44:13.225785 systemd-networkd[1345]: eth0: DHCPv4 address 10.0.0.16/16, gateway 10.0.0.1 acquired from 10.0.0.1 Jan 30 12:44:13.226963 systemd[1]: Finished systemd-fsck@dev-disk-by\x2dlabel-OEM.service - File System Check on /dev/disk/by-label/OEM. Jan 30 12:44:13.227728 systemd-timesyncd[1339]: Network configuration changed, trying to establish connection. Jan 30 12:44:13.228378 systemd-timesyncd[1339]: Contacted time server 10.0.0.1:123 (10.0.0.1). Jan 30 12:44:13.228431 systemd-timesyncd[1339]: Initial clock synchronization to Thu 2025-01-30 12:44:13.608268 UTC. Jan 30 12:44:13.237729 systemd[1]: Finished systemd-udev-settle.service - Wait for udev To Complete Device Initialization. Jan 30 12:44:13.250481 systemd[1]: Starting lvm2-activation-early.service - Activation of LVM2 logical volumes... Jan 30 12:44:13.283370 lvm[1379]: WARNING: Failed to connect to lvmetad. Falling back to device scanning. Jan 30 12:44:13.290134 systemd[1]: Finished systemd-vconsole-setup.service - Virtual Console Setup. Jan 30 12:44:13.334056 systemd[1]: Finished lvm2-activation-early.service - Activation of LVM2 logical volumes. Jan 30 12:44:13.335604 systemd[1]: Reached target cryptsetup.target - Local Encrypted Volumes. Jan 30 12:44:13.336623 systemd[1]: Reached target sysinit.target - System Initialization. Jan 30 12:44:13.337604 systemd[1]: Started motdgen.path - Watch for update engine configuration changes. Jan 30 12:44:13.338628 systemd[1]: Started user-cloudinit@var-lib-flatcar\x2dinstall-user_data.path - Watch for a cloud-config at /var/lib/flatcar-install/user_data. Jan 30 12:44:13.339861 systemd[1]: Started logrotate.timer - Daily rotation of log files. Jan 30 12:44:13.340898 systemd[1]: Started mdadm.timer - Weekly check for MD array's redundancy information.. Jan 30 12:44:13.342035 systemd[1]: Started systemd-tmpfiles-clean.timer - Daily Cleanup of Temporary Directories. Jan 30 12:44:13.343120 systemd[1]: update-engine-stub.timer - Update Engine Stub Timer was skipped because of an unmet condition check (ConditionPathExists=/usr/.noupdate). Jan 30 12:44:13.343157 systemd[1]: Reached target paths.target - Path Units. Jan 30 12:44:13.343938 systemd[1]: Reached target timers.target - Timer Units. Jan 30 12:44:13.346412 systemd[1]: Listening on dbus.socket - D-Bus System Message Bus Socket. Jan 30 12:44:13.348751 systemd[1]: Starting docker.socket - Docker Socket for the API... Jan 30 12:44:13.359338 systemd[1]: Listening on sshd.socket - OpenSSH Server Socket. Jan 30 12:44:13.362003 systemd[1]: Starting lvm2-activation.service - Activation of LVM2 logical volumes... Jan 30 12:44:13.363418 systemd[1]: Listening on docker.socket - Docker Socket for the API. Jan 30 12:44:13.364428 systemd[1]: Reached target sockets.target - Socket Units. Jan 30 12:44:13.365168 systemd[1]: Reached target basic.target - Basic System. Jan 30 12:44:13.366015 systemd[1]: addon-config@oem.service - Configure Addon /oem was skipped because no trigger condition checks were met. Jan 30 12:44:13.366049 systemd[1]: addon-run@oem.service - Run Addon /oem was skipped because no trigger condition checks were met. Jan 30 12:44:13.367200 systemd[1]: Starting containerd.service - containerd container runtime... Jan 30 12:44:13.369298 systemd[1]: Starting dbus.service - D-Bus System Message Bus... Jan 30 12:44:13.370925 lvm[1386]: WARNING: Failed to connect to lvmetad. Falling back to device scanning. Jan 30 12:44:13.373229 systemd[1]: Starting enable-oem-cloudinit.service - Enable cloudinit... Jan 30 12:44:13.376449 systemd[1]: Starting extend-filesystems.service - Extend Filesystems... Jan 30 12:44:13.378387 systemd[1]: flatcar-setup-environment.service - Modifies /etc/environment for CoreOS was skipped because of an unmet condition check (ConditionPathExists=/oem/bin/flatcar-setup-environment). Jan 30 12:44:13.380413 systemd[1]: Starting motdgen.service - Generate /run/flatcar/motd... Jan 30 12:44:13.383076 jq[1389]: false Jan 30 12:44:13.384542 systemd[1]: Starting ssh-key-proc-cmdline.service - Install an ssh key from /proc/cmdline... Jan 30 12:44:13.387680 systemd[1]: Starting sshd-keygen.service - Generate sshd host keys... Jan 30 12:44:13.392581 systemd[1]: Starting systemd-logind.service - User Login Management... Jan 30 12:44:13.394313 systemd[1]: tcsd.service - TCG Core Services Daemon was skipped because of an unmet condition check (ConditionPathExists=/dev/tpm0). Jan 30 12:44:13.394823 systemd[1]: cgroup compatibility translation between legacy and unified hierarchy settings activated. See cgroup-compat debug messages for details. Jan 30 12:44:13.395521 systemd[1]: Starting update-engine.service - Update Engine... Jan 30 12:44:13.398439 systemd[1]: Starting update-ssh-keys-after-ignition.service - Run update-ssh-keys once after Ignition... Jan 30 12:44:13.402265 systemd[1]: Finished lvm2-activation.service - Activation of LVM2 logical volumes. Jan 30 12:44:13.406695 systemd[1]: enable-oem-cloudinit.service: Skipped due to 'exec-condition'. Jan 30 12:44:13.406874 systemd[1]: Condition check resulted in enable-oem-cloudinit.service - Enable cloudinit being skipped. Jan 30 12:44:13.407154 systemd[1]: ssh-key-proc-cmdline.service: Deactivated successfully. Jan 30 12:44:13.407393 systemd[1]: Finished ssh-key-proc-cmdline.service - Install an ssh key from /proc/cmdline. Jan 30 12:44:13.421842 dbus-daemon[1388]: [system] SELinux support is enabled Jan 30 12:44:13.422102 systemd[1]: Started dbus.service - D-Bus System Message Bus. Jan 30 12:44:13.438465 systemd[1]: motdgen.service: Deactivated successfully. Jan 30 12:44:13.438727 systemd[1]: Finished motdgen.service - Generate /run/flatcar/motd. Jan 30 12:44:13.441621 systemd[1]: system-cloudinit@usr-share-oem-cloud\x2dconfig.yml.service - Load cloud-config from /usr/share/oem/cloud-config.yml was skipped because of an unmet condition check (ConditionFileNotEmpty=/usr/share/oem/cloud-config.yml). Jan 30 12:44:13.441703 systemd[1]: Reached target system-config.target - Load system-provided cloud configs. Jan 30 12:44:13.443558 systemd[1]: user-cloudinit-proc-cmdline.service - Load cloud-config from url defined in /proc/cmdline was skipped because of an unmet condition check (ConditionKernelCommandLine=cloud-config-url). Jan 30 12:44:13.443594 systemd[1]: Reached target user-config.target - Load user-provided cloud configs. Jan 30 12:44:13.443687 jq[1399]: true Jan 30 12:44:13.447561 extend-filesystems[1390]: Found loop2 Jan 30 12:44:13.449743 extend-filesystems[1390]: Found loop3 Jan 30 12:44:13.449743 extend-filesystems[1390]: Found vda Jan 30 12:44:13.449743 extend-filesystems[1390]: Found vda1 Jan 30 12:44:13.449743 extend-filesystems[1390]: Found vda2 Jan 30 12:44:13.449743 extend-filesystems[1390]: Found vda3 Jan 30 12:44:13.449743 extend-filesystems[1390]: Found usr Jan 30 12:44:13.449743 extend-filesystems[1390]: Found vda4 Jan 30 12:44:13.449743 extend-filesystems[1390]: Found vda6 Jan 30 12:44:13.449743 extend-filesystems[1390]: Found vda7 Jan 30 12:44:13.449743 extend-filesystems[1390]: Found vda9 Jan 30 12:44:13.449743 extend-filesystems[1390]: Checking size of /dev/vda9 Jan 30 12:44:13.459003 jq[1413]: true Jan 30 12:44:13.460912 (ntainerd)[1414]: containerd.service: Referenced but unset environment variable evaluates to an empty string: TORCX_IMAGEDIR, TORCX_UNPACKDIR Jan 30 12:44:13.479200 update_engine[1396]: I20250130 12:44:13.478889 1396 main.cc:92] Flatcar Update Engine starting Jan 30 12:44:13.479661 extend-filesystems[1390]: Old size kept for /dev/vda9 Jan 30 12:44:13.483350 systemd[1]: extend-filesystems.service: Deactivated successfully. Jan 30 12:44:13.483591 systemd[1]: Finished extend-filesystems.service - Extend Filesystems. Jan 30 12:44:13.487008 systemd-logind[1394]: Watching system buttons on /dev/input/event0 (Power Button) Jan 30 12:44:13.488506 systemd[1]: Started update-engine.service - Update Engine. Jan 30 12:44:13.488789 systemd-logind[1394]: New seat seat0. Jan 30 12:44:13.489822 update_engine[1396]: I20250130 12:44:13.489660 1396 update_check_scheduler.cc:74] Next update check in 8m10s Jan 30 12:44:13.510684 systemd[1]: Started locksmithd.service - Cluster reboot manager. Jan 30 12:44:13.512138 systemd[1]: Started systemd-logind.service - User Login Management. Jan 30 12:44:13.526254 kernel: BTRFS warning: duplicate device /dev/vda3 devid 1 generation 39 scanned by (udev-worker) (1343) Jan 30 12:44:13.569828 bash[1436]: Updated "/home/core/.ssh/authorized_keys" Jan 30 12:44:13.573029 systemd[1]: Finished update-ssh-keys-after-ignition.service - Run update-ssh-keys once after Ignition. Jan 30 12:44:13.576399 systemd[1]: sshkeys.service was skipped because no trigger condition checks were met. Jan 30 12:44:13.658134 locksmithd[1437]: locksmithd starting currentOperation="UPDATE_STATUS_IDLE" strategy="reboot" Jan 30 12:44:13.843745 sshd_keygen[1410]: ssh-keygen: generating new host keys: RSA ECDSA ED25519 Jan 30 12:44:13.867240 systemd[1]: Finished sshd-keygen.service - Generate sshd host keys. Jan 30 12:44:13.880549 systemd[1]: Starting issuegen.service - Generate /run/issue... Jan 30 12:44:13.882257 containerd[1414]: time="2025-01-30T12:44:13.882159640Z" level=info msg="starting containerd" revision=9b2ad7760328148397346d10c7b2004271249db4 version=v1.7.23 Jan 30 12:44:13.888717 systemd[1]: issuegen.service: Deactivated successfully. Jan 30 12:44:13.888928 systemd[1]: Finished issuegen.service - Generate /run/issue. Jan 30 12:44:13.904580 systemd[1]: Starting systemd-user-sessions.service - Permit User Sessions... Jan 30 12:44:13.908530 containerd[1414]: time="2025-01-30T12:44:13.908477680Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.aufs\"..." type=io.containerd.snapshotter.v1 Jan 30 12:44:13.909911 containerd[1414]: time="2025-01-30T12:44:13.909869520Z" level=info msg="skip loading plugin \"io.containerd.snapshotter.v1.aufs\"..." error="aufs is not supported (modprobe aufs failed: exit status 1 \"modprobe: FATAL: Module aufs not found in directory /lib/modules/6.6.74-flatcar\\n\"): skip plugin" type=io.containerd.snapshotter.v1 Jan 30 12:44:13.909911 containerd[1414]: time="2025-01-30T12:44:13.909904960Z" level=info msg="loading plugin \"io.containerd.event.v1.exchange\"..." type=io.containerd.event.v1 Jan 30 12:44:13.909976 containerd[1414]: time="2025-01-30T12:44:13.909923120Z" level=info msg="loading plugin \"io.containerd.internal.v1.opt\"..." type=io.containerd.internal.v1 Jan 30 12:44:13.910112 containerd[1414]: time="2025-01-30T12:44:13.910082400Z" level=info msg="loading plugin \"io.containerd.warning.v1.deprecations\"..." type=io.containerd.warning.v1 Jan 30 12:44:13.910112 containerd[1414]: time="2025-01-30T12:44:13.910107520Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.blockfile\"..." type=io.containerd.snapshotter.v1 Jan 30 12:44:13.910181 containerd[1414]: time="2025-01-30T12:44:13.910165920Z" level=info msg="skip loading plugin \"io.containerd.snapshotter.v1.blockfile\"..." error="no scratch file generator: skip plugin" type=io.containerd.snapshotter.v1 Jan 30 12:44:13.910201 containerd[1414]: time="2025-01-30T12:44:13.910181280Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.btrfs\"..." type=io.containerd.snapshotter.v1 Jan 30 12:44:13.910387 containerd[1414]: time="2025-01-30T12:44:13.910359800Z" level=info msg="skip loading plugin \"io.containerd.snapshotter.v1.btrfs\"..." error="path /var/lib/containerd/io.containerd.snapshotter.v1.btrfs (ext4) must be a btrfs filesystem to be used with the btrfs snapshotter: skip plugin" type=io.containerd.snapshotter.v1 Jan 30 12:44:13.910387 containerd[1414]: time="2025-01-30T12:44:13.910381680Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.devmapper\"..." type=io.containerd.snapshotter.v1 Jan 30 12:44:13.910433 containerd[1414]: time="2025-01-30T12:44:13.910396400Z" level=info msg="skip loading plugin \"io.containerd.snapshotter.v1.devmapper\"..." error="devmapper not configured: skip plugin" type=io.containerd.snapshotter.v1 Jan 30 12:44:13.910433 containerd[1414]: time="2025-01-30T12:44:13.910406200Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.native\"..." type=io.containerd.snapshotter.v1 Jan 30 12:44:13.910492 containerd[1414]: time="2025-01-30T12:44:13.910478440Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.overlayfs\"..." type=io.containerd.snapshotter.v1 Jan 30 12:44:13.910711 containerd[1414]: time="2025-01-30T12:44:13.910687520Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.zfs\"..." type=io.containerd.snapshotter.v1 Jan 30 12:44:13.910806 containerd[1414]: time="2025-01-30T12:44:13.910790640Z" level=info msg="skip loading plugin \"io.containerd.snapshotter.v1.zfs\"..." error="path /var/lib/containerd/io.containerd.snapshotter.v1.zfs must be a zfs filesystem to be used with the zfs snapshotter: skip plugin" type=io.containerd.snapshotter.v1 Jan 30 12:44:13.910826 containerd[1414]: time="2025-01-30T12:44:13.910809320Z" level=info msg="loading plugin \"io.containerd.content.v1.content\"..." type=io.containerd.content.v1 Jan 30 12:44:13.910897 containerd[1414]: time="2025-01-30T12:44:13.910883440Z" level=info msg="loading plugin \"io.containerd.metadata.v1.bolt\"..." type=io.containerd.metadata.v1 Jan 30 12:44:13.910940 containerd[1414]: time="2025-01-30T12:44:13.910928480Z" level=info msg="metadata content store policy set" policy=shared Jan 30 12:44:13.914578 containerd[1414]: time="2025-01-30T12:44:13.914545960Z" level=info msg="loading plugin \"io.containerd.gc.v1.scheduler\"..." type=io.containerd.gc.v1 Jan 30 12:44:13.914647 containerd[1414]: time="2025-01-30T12:44:13.914602000Z" level=info msg="loading plugin \"io.containerd.differ.v1.walking\"..." type=io.containerd.differ.v1 Jan 30 12:44:13.914647 containerd[1414]: time="2025-01-30T12:44:13.914618960Z" level=info msg="loading plugin \"io.containerd.lease.v1.manager\"..." type=io.containerd.lease.v1 Jan 30 12:44:13.914647 containerd[1414]: time="2025-01-30T12:44:13.914641760Z" level=info msg="loading plugin \"io.containerd.streaming.v1.manager\"..." type=io.containerd.streaming.v1 Jan 30 12:44:13.914712 containerd[1414]: time="2025-01-30T12:44:13.914659320Z" level=info msg="loading plugin \"io.containerd.runtime.v1.linux\"..." type=io.containerd.runtime.v1 Jan 30 12:44:13.914819 containerd[1414]: time="2025-01-30T12:44:13.914796800Z" level=info msg="loading plugin \"io.containerd.monitor.v1.cgroups\"..." type=io.containerd.monitor.v1 Jan 30 12:44:13.915016 systemd[1]: Finished systemd-user-sessions.service - Permit User Sessions. Jan 30 12:44:13.915101 containerd[1414]: time="2025-01-30T12:44:13.915033320Z" level=info msg="loading plugin \"io.containerd.runtime.v2.task\"..." type=io.containerd.runtime.v2 Jan 30 12:44:13.915149 containerd[1414]: time="2025-01-30T12:44:13.915131160Z" level=info msg="loading plugin \"io.containerd.runtime.v2.shim\"..." type=io.containerd.runtime.v2 Jan 30 12:44:13.915174 containerd[1414]: time="2025-01-30T12:44:13.915153920Z" level=info msg="loading plugin \"io.containerd.sandbox.store.v1.local\"..." type=io.containerd.sandbox.store.v1 Jan 30 12:44:13.915174 containerd[1414]: time="2025-01-30T12:44:13.915168760Z" level=info msg="loading plugin \"io.containerd.sandbox.controller.v1.local\"..." type=io.containerd.sandbox.controller.v1 Jan 30 12:44:13.915217 containerd[1414]: time="2025-01-30T12:44:13.915183400Z" level=info msg="loading plugin \"io.containerd.service.v1.containers-service\"..." type=io.containerd.service.v1 Jan 30 12:44:13.915217 containerd[1414]: time="2025-01-30T12:44:13.915196480Z" level=info msg="loading plugin \"io.containerd.service.v1.content-service\"..." type=io.containerd.service.v1 Jan 30 12:44:13.915271 containerd[1414]: time="2025-01-30T12:44:13.915230720Z" level=info msg="loading plugin \"io.containerd.service.v1.diff-service\"..." type=io.containerd.service.v1 Jan 30 12:44:13.915271 containerd[1414]: time="2025-01-30T12:44:13.915246640Z" level=info msg="loading plugin \"io.containerd.service.v1.images-service\"..." type=io.containerd.service.v1 Jan 30 12:44:13.915271 containerd[1414]: time="2025-01-30T12:44:13.915261680Z" level=info msg="loading plugin \"io.containerd.service.v1.introspection-service\"..." type=io.containerd.service.v1 Jan 30 12:44:13.915319 containerd[1414]: time="2025-01-30T12:44:13.915275000Z" level=info msg="loading plugin \"io.containerd.service.v1.namespaces-service\"..." type=io.containerd.service.v1 Jan 30 12:44:13.915319 containerd[1414]: time="2025-01-30T12:44:13.915287800Z" level=info msg="loading plugin \"io.containerd.service.v1.snapshots-service\"..." type=io.containerd.service.v1 Jan 30 12:44:13.915319 containerd[1414]: time="2025-01-30T12:44:13.915298960Z" level=info msg="loading plugin \"io.containerd.service.v1.tasks-service\"..." type=io.containerd.service.v1 Jan 30 12:44:13.915369 containerd[1414]: time="2025-01-30T12:44:13.915320320Z" level=info msg="loading plugin \"io.containerd.grpc.v1.containers\"..." type=io.containerd.grpc.v1 Jan 30 12:44:13.915369 containerd[1414]: time="2025-01-30T12:44:13.915334240Z" level=info msg="loading plugin \"io.containerd.grpc.v1.content\"..." type=io.containerd.grpc.v1 Jan 30 12:44:13.915369 containerd[1414]: time="2025-01-30T12:44:13.915345720Z" level=info msg="loading plugin \"io.containerd.grpc.v1.diff\"..." type=io.containerd.grpc.v1 Jan 30 12:44:13.915369 containerd[1414]: time="2025-01-30T12:44:13.915358560Z" level=info msg="loading plugin \"io.containerd.grpc.v1.events\"..." type=io.containerd.grpc.v1 Jan 30 12:44:13.915447 containerd[1414]: time="2025-01-30T12:44:13.915370640Z" level=info msg="loading plugin \"io.containerd.grpc.v1.images\"..." type=io.containerd.grpc.v1 Jan 30 12:44:13.915447 containerd[1414]: time="2025-01-30T12:44:13.915383560Z" level=info msg="loading plugin \"io.containerd.grpc.v1.introspection\"..." type=io.containerd.grpc.v1 Jan 30 12:44:13.915447 containerd[1414]: time="2025-01-30T12:44:13.915395160Z" level=info msg="loading plugin \"io.containerd.grpc.v1.leases\"..." type=io.containerd.grpc.v1 Jan 30 12:44:13.915447 containerd[1414]: time="2025-01-30T12:44:13.915407960Z" level=info msg="loading plugin \"io.containerd.grpc.v1.namespaces\"..." type=io.containerd.grpc.v1 Jan 30 12:44:13.915447 containerd[1414]: time="2025-01-30T12:44:13.915420160Z" level=info msg="loading plugin \"io.containerd.grpc.v1.sandbox-controllers\"..." type=io.containerd.grpc.v1 Jan 30 12:44:13.915447 containerd[1414]: time="2025-01-30T12:44:13.915442600Z" level=info msg="loading plugin \"io.containerd.grpc.v1.sandboxes\"..." type=io.containerd.grpc.v1 Jan 30 12:44:13.915545 containerd[1414]: time="2025-01-30T12:44:13.915455960Z" level=info msg="loading plugin \"io.containerd.grpc.v1.snapshots\"..." type=io.containerd.grpc.v1 Jan 30 12:44:13.915545 containerd[1414]: time="2025-01-30T12:44:13.915468080Z" level=info msg="loading plugin \"io.containerd.grpc.v1.streaming\"..." type=io.containerd.grpc.v1 Jan 30 12:44:13.915545 containerd[1414]: time="2025-01-30T12:44:13.915479880Z" level=info msg="loading plugin \"io.containerd.grpc.v1.tasks\"..." type=io.containerd.grpc.v1 Jan 30 12:44:13.915545 containerd[1414]: time="2025-01-30T12:44:13.915494640Z" level=info msg="loading plugin \"io.containerd.transfer.v1.local\"..." type=io.containerd.transfer.v1 Jan 30 12:44:13.915545 containerd[1414]: time="2025-01-30T12:44:13.915516520Z" level=info msg="loading plugin \"io.containerd.grpc.v1.transfer\"..." type=io.containerd.grpc.v1 Jan 30 12:44:13.915545 containerd[1414]: time="2025-01-30T12:44:13.915529800Z" level=info msg="loading plugin \"io.containerd.grpc.v1.version\"..." type=io.containerd.grpc.v1 Jan 30 12:44:13.915545 containerd[1414]: time="2025-01-30T12:44:13.915540720Z" level=info msg="loading plugin \"io.containerd.internal.v1.restart\"..." type=io.containerd.internal.v1 Jan 30 12:44:13.915917 containerd[1414]: time="2025-01-30T12:44:13.915902280Z" level=info msg="loading plugin \"io.containerd.tracing.processor.v1.otlp\"..." type=io.containerd.tracing.processor.v1 Jan 30 12:44:13.915944 containerd[1414]: time="2025-01-30T12:44:13.915925520Z" level=info msg="skip loading plugin \"io.containerd.tracing.processor.v1.otlp\"..." error="skip plugin: tracing endpoint not configured" type=io.containerd.tracing.processor.v1 Jan 30 12:44:13.915944 containerd[1414]: time="2025-01-30T12:44:13.915938320Z" level=info msg="loading plugin \"io.containerd.internal.v1.tracing\"..." type=io.containerd.internal.v1 Jan 30 12:44:13.915999 containerd[1414]: time="2025-01-30T12:44:13.915951440Z" level=info msg="skip loading plugin \"io.containerd.internal.v1.tracing\"..." error="skip plugin: tracing endpoint not configured" type=io.containerd.internal.v1 Jan 30 12:44:13.915999 containerd[1414]: time="2025-01-30T12:44:13.915960840Z" level=info msg="loading plugin \"io.containerd.grpc.v1.healthcheck\"..." type=io.containerd.grpc.v1 Jan 30 12:44:13.915999 containerd[1414]: time="2025-01-30T12:44:13.915974160Z" level=info msg="loading plugin \"io.containerd.nri.v1.nri\"..." type=io.containerd.nri.v1 Jan 30 12:44:13.915999 containerd[1414]: time="2025-01-30T12:44:13.915984840Z" level=info msg="NRI interface is disabled by configuration." Jan 30 12:44:13.915999 containerd[1414]: time="2025-01-30T12:44:13.915995200Z" level=info msg="loading plugin \"io.containerd.grpc.v1.cri\"..." type=io.containerd.grpc.v1 Jan 30 12:44:13.916727 containerd[1414]: time="2025-01-30T12:44:13.916461520Z" level=info msg="Start cri plugin with config {PluginConfig:{ContainerdConfig:{Snapshotter:overlayfs DefaultRuntimeName:runc DefaultRuntime:{Type: Path: Engine: PodAnnotations:[] ContainerAnnotations:[] Root: Options:map[] PrivilegedWithoutHostDevices:false PrivilegedWithoutHostDevicesAllDevicesAllowed:false BaseRuntimeSpec: NetworkPluginConfDir: NetworkPluginMaxConfNum:0 Snapshotter: SandboxMode:} UntrustedWorkloadRuntime:{Type: Path: Engine: PodAnnotations:[] ContainerAnnotations:[] Root: Options:map[] PrivilegedWithoutHostDevices:false PrivilegedWithoutHostDevicesAllDevicesAllowed:false BaseRuntimeSpec: NetworkPluginConfDir: NetworkPluginMaxConfNum:0 Snapshotter: SandboxMode:} Runtimes:map[runc:{Type:io.containerd.runc.v2 Path: Engine: PodAnnotations:[] ContainerAnnotations:[] Root: Options:map[SystemdCgroup:true] PrivilegedWithoutHostDevices:false PrivilegedWithoutHostDevicesAllDevicesAllowed:false BaseRuntimeSpec: NetworkPluginConfDir: NetworkPluginMaxConfNum:0 Snapshotter: SandboxMode:podsandbox}] NoPivot:false DisableSnapshotAnnotations:true DiscardUnpackedLayers:false IgnoreBlockIONotEnabledErrors:false IgnoreRdtNotEnabledErrors:false} CniConfig:{NetworkPluginBinDir:/opt/cni/bin NetworkPluginConfDir:/etc/cni/net.d NetworkPluginMaxConfNum:1 NetworkPluginSetupSerially:false NetworkPluginConfTemplate: IPPreference:} Registry:{ConfigPath: Mirrors:map[] Configs:map[] Auths:map[] Headers:map[]} ImageDecryption:{KeyModel:node} DisableTCPService:true StreamServerAddress:127.0.0.1 StreamServerPort:0 StreamIdleTimeout:4h0m0s EnableSelinux:true SelinuxCategoryRange:1024 SandboxImage:registry.k8s.io/pause:3.8 StatsCollectPeriod:10 SystemdCgroup:false EnableTLSStreaming:false X509KeyPairStreaming:{TLSCertFile: TLSKeyFile:} MaxContainerLogLineSize:16384 DisableCgroup:false DisableApparmor:false RestrictOOMScoreAdj:false MaxConcurrentDownloads:3 DisableProcMount:false UnsetSeccompProfile: TolerateMissingHugetlbController:true DisableHugetlbController:true DeviceOwnershipFromSecurityContext:false IgnoreImageDefinedVolumes:false NetNSMountsUnderStateDir:false EnableUnprivilegedPorts:false EnableUnprivilegedICMP:false EnableCDI:false CDISpecDirs:[/etc/cdi /var/run/cdi] ImagePullProgressTimeout:5m0s DrainExecSyncIOTimeout:0s ImagePullWithSyncFs:false IgnoreDeprecationWarnings:[]} ContainerdRootDir:/var/lib/containerd ContainerdEndpoint:/run/containerd/containerd.sock RootDir:/var/lib/containerd/io.containerd.grpc.v1.cri StateDir:/run/containerd/io.containerd.grpc.v1.cri}" Jan 30 12:44:13.916727 containerd[1414]: time="2025-01-30T12:44:13.916514000Z" level=info msg="Connect containerd service" Jan 30 12:44:13.916727 containerd[1414]: time="2025-01-30T12:44:13.916555800Z" level=info msg="using legacy CRI server" Jan 30 12:44:13.916727 containerd[1414]: time="2025-01-30T12:44:13.916570920Z" level=info msg="using experimental NRI integration - disable nri plugin to prevent this" Jan 30 12:44:13.917012 containerd[1414]: time="2025-01-30T12:44:13.916930480Z" level=info msg="Get image filesystem path \"/var/lib/containerd/io.containerd.snapshotter.v1.overlayfs\"" Jan 30 12:44:13.917628 containerd[1414]: time="2025-01-30T12:44:13.917600320Z" level=error msg="failed to load cni during init, please check CRI plugin status before setting up network for pods" error="cni config load failed: no network config found in /etc/cni/net.d: cni plugin not initialized: failed to load cni config" Jan 30 12:44:13.918492 systemd[1]: Started getty@tty1.service - Getty on tty1. Jan 30 12:44:13.920148 containerd[1414]: time="2025-01-30T12:44:13.918387800Z" level=info msg="Start subscribing containerd event" Jan 30 12:44:13.920229 containerd[1414]: time="2025-01-30T12:44:13.920166840Z" level=info msg="Start recovering state" Jan 30 12:44:13.921898 containerd[1414]: time="2025-01-30T12:44:13.920262320Z" level=info msg="Start event monitor" Jan 30 12:44:13.921898 containerd[1414]: time="2025-01-30T12:44:13.920287960Z" level=info msg="Start snapshots syncer" Jan 30 12:44:13.921898 containerd[1414]: time="2025-01-30T12:44:13.920299160Z" level=info msg="Start cni network conf syncer for default" Jan 30 12:44:13.921898 containerd[1414]: time="2025-01-30T12:44:13.920305720Z" level=info msg="Start streaming server" Jan 30 12:44:13.921898 containerd[1414]: time="2025-01-30T12:44:13.919157000Z" level=info msg=serving... address=/run/containerd/containerd.sock.ttrpc Jan 30 12:44:13.921898 containerd[1414]: time="2025-01-30T12:44:13.920520920Z" level=info msg=serving... address=/run/containerd/containerd.sock Jan 30 12:44:13.921898 containerd[1414]: time="2025-01-30T12:44:13.921860840Z" level=info msg="containerd successfully booted in 0.041082s" Jan 30 12:44:13.921700 systemd[1]: Started serial-getty@ttyAMA0.service - Serial Getty on ttyAMA0. Jan 30 12:44:13.925690 systemd[1]: Reached target getty.target - Login Prompts. Jan 30 12:44:13.926857 systemd[1]: Started containerd.service - containerd container runtime. Jan 30 12:44:14.426762 systemd-networkd[1345]: eth0: Gained IPv6LL Jan 30 12:44:14.429199 systemd[1]: Finished systemd-networkd-wait-online.service - Wait for Network to be Configured. Jan 30 12:44:14.430804 systemd[1]: Reached target network-online.target - Network is Online. Jan 30 12:44:14.441564 systemd[1]: Starting coreos-metadata.service - QEMU metadata agent... Jan 30 12:44:14.443663 systemd[1]: Starting nvidia.service - NVIDIA Configure Service... Jan 30 12:44:14.459934 systemd[1]: coreos-metadata.service: Deactivated successfully. Jan 30 12:44:14.460170 systemd[1]: Finished coreos-metadata.service - QEMU metadata agent. Jan 30 12:44:14.463452 systemd[1]: Starting etcd-member.service - etcd (System Application Container)... Jan 30 12:44:14.464435 systemd[1]: packet-phone-home.service - Report Success to Packet was skipped because no trigger condition checks were met. Jan 30 12:44:14.464975 systemd[1]: Finished nvidia.service - NVIDIA Configure Service. Jan 30 12:44:14.469067 (-wrapper)[1483]: etcd-member.service: Referenced but unset environment variable evaluates to an empty string: ETCD_OPTS Jan 30 12:44:14.634571 systemd[1]: Starting docker.service - Docker Application Container Engine... Jan 30 12:44:14.634670 (dockerd)[1497]: 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 Jan 30 12:44:14.974845 dockerd[1497]: time="2025-01-30T12:44:14.974780216Z" level=info msg="Starting up" Jan 30 12:44:15.204972 dockerd[1497]: time="2025-01-30T12:44:15.204918279Z" level=info msg="Loading containers: start." Jan 30 12:44:15.378423 kernel: Initializing XFRM netlink socket Jan 30 12:44:15.465071 systemd-networkd[1345]: docker0: Link UP Jan 30 12:44:15.504622 dockerd[1497]: time="2025-01-30T12:44:15.504556183Z" level=info msg="Loading containers: done." Jan 30 12:44:15.533358 dockerd[1497]: time="2025-01-30T12:44:15.533304486Z" 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 Jan 30 12:44:15.533534 dockerd[1497]: time="2025-01-30T12:44:15.533428931Z" level=info msg="Docker daemon" commit=41ca978a0a5400cc24b274137efa9f25517fcc0b containerd-snapshotter=false storage-driver=overlay2 version=27.3.1 Jan 30 12:44:15.533686 dockerd[1497]: time="2025-01-30T12:44:15.533647326Z" level=info msg="Daemon has completed initialization" Jan 30 12:44:15.582600 dockerd[1497]: time="2025-01-30T12:44:15.582540271Z" level=info msg="API listen on /run/docker.sock" Jan 30 12:44:15.582928 systemd[1]: Started docker.service - Docker Application Container Engine. Jan 30 12:44:15.586654 etcd-wrapper[1488]: Error response from daemon: No such container: etcd-member Jan 30 12:44:15.601833 etcd-wrapper[1674]: Error response from daemon: No such container: etcd-member Jan 30 12:44:15.655874 etcd-wrapper[1693]: Unable to find image 'quay.io/coreos/etcd:v3.5.16-arm64' locally Jan 30 12:44:16.348387 etcd-wrapper[1693]: v3.5.16-arm64: Pulling from coreos/etcd Jan 30 12:44:16.349118 etcd-wrapper[1693]: d10f96ed9607: Pulling fs layer Jan 30 12:44:16.349170 etcd-wrapper[1693]: 2ae710cd8bfe: Pulling fs layer Jan 30 12:44:16.349170 etcd-wrapper[1693]: d462aa345367: Pulling fs layer Jan 30 12:44:16.349170 etcd-wrapper[1693]: 0f8b424aa0b9: Pulling fs layer Jan 30 12:44:16.349170 etcd-wrapper[1693]: d557676654e5: Pulling fs layer Jan 30 12:44:16.349538 etcd-wrapper[1693]: c8022d07192e: Pulling fs layer Jan 30 12:44:16.349538 etcd-wrapper[1693]: d858cbc252ad: Pulling fs layer Jan 30 12:44:16.349601 etcd-wrapper[1693]: 1069fc2daed1: Pulling fs layer Jan 30 12:44:16.349601 etcd-wrapper[1693]: b40161cd83fc: Pulling fs layer Jan 30 12:44:16.349601 etcd-wrapper[1693]: 5318d93a3a65: Pulling fs layer Jan 30 12:44:16.349601 etcd-wrapper[1693]: 0f8b424aa0b9: Waiting Jan 30 12:44:16.349601 etcd-wrapper[1693]: d557676654e5: Waiting Jan 30 12:44:16.349601 etcd-wrapper[1693]: c8022d07192e: Waiting Jan 30 12:44:16.349601 etcd-wrapper[1693]: d858cbc252ad: Waiting Jan 30 12:44:16.349601 etcd-wrapper[1693]: 1069fc2daed1: Waiting Jan 30 12:44:16.349601 etcd-wrapper[1693]: b40161cd83fc: Waiting Jan 30 12:44:16.349807 etcd-wrapper[1693]: 307c1adadb60: Pulling fs layer Jan 30 12:44:16.349807 etcd-wrapper[1693]: f9b3c65df792: Pulling fs layer Jan 30 12:44:16.349807 etcd-wrapper[1693]: 5709b4a82c35: Pulling fs layer Jan 30 12:44:16.349807 etcd-wrapper[1693]: d5372e382b07: Pulling fs layer Jan 30 12:44:16.349807 etcd-wrapper[1693]: 9c3b5253dddc: Pulling fs layer Jan 30 12:44:16.349807 etcd-wrapper[1693]: 7a57323f7551: Pulling fs layer Jan 30 12:44:16.349807 etcd-wrapper[1693]: 5318d93a3a65: Waiting Jan 30 12:44:16.349807 etcd-wrapper[1693]: 307c1adadb60: Waiting Jan 30 12:44:16.349807 etcd-wrapper[1693]: f9b3c65df792: Waiting Jan 30 12:44:16.349807 etcd-wrapper[1693]: d5372e382b07: Waiting Jan 30 12:44:16.350325 etcd-wrapper[1693]: 5709b4a82c35: Waiting Jan 30 12:44:16.350325 etcd-wrapper[1693]: 9c3b5253dddc: Waiting Jan 30 12:44:16.350325 etcd-wrapper[1693]: 7a57323f7551: Waiting Jan 30 12:44:16.484177 etcd-wrapper[1693]: d462aa345367: Verifying Checksum Jan 30 12:44:16.484177 etcd-wrapper[1693]: d462aa345367: Download complete Jan 30 12:44:16.488462 etcd-wrapper[1693]: 2ae710cd8bfe: Verifying Checksum Jan 30 12:44:16.488462 etcd-wrapper[1693]: 2ae710cd8bfe: Download complete Jan 30 12:44:16.503553 etcd-wrapper[1693]: d10f96ed9607: Verifying Checksum Jan 30 12:44:16.503553 etcd-wrapper[1693]: d10f96ed9607: Download complete Jan 30 12:44:16.541973 etcd-wrapper[1693]: d10f96ed9607: Pull complete Jan 30 12:44:16.611772 systemd[1]: var-lib-docker-overlay2-c19d6d9d9cf43067bffcd6987a25705b4631b255368e57fc8655d9df4e481486-merged.mount: Deactivated successfully. Jan 30 12:44:16.628010 etcd-wrapper[1693]: d557676654e5: Verifying Checksum Jan 30 12:44:16.628010 etcd-wrapper[1693]: d557676654e5: Download complete Jan 30 12:44:16.637709 etcd-wrapper[1693]: 2ae710cd8bfe: Pull complete Jan 30 12:44:16.644021 etcd-wrapper[1693]: c8022d07192e: Verifying Checksum Jan 30 12:44:16.644021 etcd-wrapper[1693]: c8022d07192e: Download complete Jan 30 12:44:16.662622 etcd-wrapper[1693]: 0f8b424aa0b9: Verifying Checksum Jan 30 12:44:16.662622 etcd-wrapper[1693]: 0f8b424aa0b9: Download complete Jan 30 12:44:16.770061 etcd-wrapper[1693]: d858cbc252ad: Verifying Checksum Jan 30 12:44:16.770061 etcd-wrapper[1693]: d858cbc252ad: Download complete Jan 30 12:44:16.781365 etcd-wrapper[1693]: 1069fc2daed1: Verifying Checksum Jan 30 12:44:16.781614 etcd-wrapper[1693]: 1069fc2daed1: Download complete Jan 30 12:44:16.789488 etcd-wrapper[1693]: b40161cd83fc: Verifying Checksum Jan 30 12:44:16.789488 etcd-wrapper[1693]: b40161cd83fc: Download complete Jan 30 12:44:16.912959 etcd-wrapper[1693]: 307c1adadb60: Verifying Checksum Jan 30 12:44:16.912959 etcd-wrapper[1693]: 307c1adadb60: Download complete Jan 30 12:44:16.933473 etcd-wrapper[1693]: 5318d93a3a65: Verifying Checksum Jan 30 12:44:16.933692 etcd-wrapper[1693]: 5318d93a3a65: Download complete Jan 30 12:44:16.968165 etcd-wrapper[1693]: f9b3c65df792: Verifying Checksum Jan 30 12:44:16.968165 etcd-wrapper[1693]: f9b3c65df792: Download complete Jan 30 12:44:17.027810 systemd[1]: var-lib-docker-overlay2-1846df4adf4503509ad8154e4298169052539a60232dcf0580997d57e8774074-merged.mount: Deactivated successfully. Jan 30 12:44:17.081540 etcd-wrapper[1693]: 5709b4a82c35: Verifying Checksum Jan 30 12:44:17.081540 etcd-wrapper[1693]: 5709b4a82c35: Download complete Jan 30 12:44:17.089547 etcd-wrapper[1693]: d462aa345367: Pull complete Jan 30 12:44:17.090599 etcd-wrapper[1693]: 9c3b5253dddc: Verifying Checksum Jan 30 12:44:17.090599 etcd-wrapper[1693]: 9c3b5253dddc: Download complete Jan 30 12:44:17.139388 etcd-wrapper[1693]: 0f8b424aa0b9: Pull complete Jan 30 12:44:17.202248 etcd-wrapper[1693]: d5372e382b07: Verifying Checksum Jan 30 12:44:17.202248 etcd-wrapper[1693]: d5372e382b07: Download complete Jan 30 12:44:17.215733 etcd-wrapper[1693]: 7a57323f7551: Verifying Checksum Jan 30 12:44:17.215733 etcd-wrapper[1693]: 7a57323f7551: Download complete Jan 30 12:44:17.284001 etcd-wrapper[1693]: d557676654e5: Pull complete Jan 30 12:44:17.323846 etcd-wrapper[1693]: c8022d07192e: Pull complete Jan 30 12:44:17.352115 etcd-wrapper[1693]: d858cbc252ad: Pull complete Jan 30 12:44:17.370464 etcd-wrapper[1693]: 1069fc2daed1: Pull complete Jan 30 12:44:17.395398 etcd-wrapper[1693]: b40161cd83fc: Pull complete Jan 30 12:44:17.425099 etcd-wrapper[1693]: 5318d93a3a65: Pull complete Jan 30 12:44:17.448824 etcd-wrapper[1693]: 307c1adadb60: Pull complete Jan 30 12:44:17.592565 etcd-wrapper[1693]: f9b3c65df792: Pull complete Jan 30 12:44:17.604278 systemd[1]: var-lib-docker-overlay2-bfb77939d179d01ebdb74f07f4d1b81c411090424423455fd212facf92b1cbf8-merged.mount: Deactivated successfully. Jan 30 12:44:17.675438 systemd[1]: var-lib-docker-overlay2-b857ef31e31ccfc5b16511cea5e7dcc166280e37c9f3df1a3a855b4760083a61-merged.mount: Deactivated successfully. Jan 30 12:44:17.760197 etcd-wrapper[1693]: 5709b4a82c35: Pull complete Jan 30 12:44:17.831546 systemd[1]: var-lib-docker-overlay2-b7b5fb2927eb5c0b1f8e8759dd6423782a751bb939cd014c62be7b1c91cd627f-merged.mount: Deactivated successfully. Jan 30 12:44:17.865722 etcd-wrapper[1693]: d5372e382b07: Pull complete Jan 30 12:44:17.902194 etcd-wrapper[1693]: 9c3b5253dddc: Pull complete Jan 30 12:44:17.936339 etcd-wrapper[1693]: 7a57323f7551: Pull complete Jan 30 12:44:18.614578 systemd[1]: var-lib-docker-overlay2-30a8f58d1ee5abdbcacadeb0b50178a73026a3cc54f1b3010e4654fe802ed04f-merged.mount: Deactivated successfully. Jan 30 12:44:18.945593 agetty[1467]: failed to open credentials directory Jan 30 12:44:18.945623 agetty[1469]: failed to open credentials directory Jan 30 12:44:19.867038 etcd-wrapper[1693]: Digest: sha256:bdb64177a9250b4d594af525f4225c2d0657a251a6e38102a2ead39f67370db2 Jan 30 12:44:19.892890 etcd-wrapper[1693]: Status: Downloaded newer image for quay.io/coreos/etcd:v3.5.16-arm64 Jan 30 12:44:19.949294 systemd[1]: var-lib-docker-overlay2-6808dc13e7e34006a3a5bc0c5f4f651581c0d774571a8141405337912ae51618\x2dinit-merged.mount: Deactivated successfully. Jan 30 12:44:20.244580 containerd[1414]: time="2025-01-30T12:44:20.244392207Z" level=info msg="loading plugin \"io.containerd.event.v1.publisher\"..." runtime=io.containerd.runc.v2 type=io.containerd.event.v1 Jan 30 12:44:20.244580 containerd[1414]: time="2025-01-30T12:44:20.244469378Z" level=info msg="loading plugin \"io.containerd.internal.v1.shutdown\"..." runtime=io.containerd.runc.v2 type=io.containerd.internal.v1 Jan 30 12:44:20.244580 containerd[1414]: time="2025-01-30T12:44:20.244481225Z" level=info msg="loading plugin \"io.containerd.ttrpc.v1.task\"..." runtime=io.containerd.runc.v2 type=io.containerd.ttrpc.v1 Jan 30 12:44:20.245054 containerd[1414]: time="2025-01-30T12:44:20.244575513Z" level=info msg="loading plugin \"io.containerd.ttrpc.v1.pause\"..." runtime=io.containerd.runc.v2 type=io.containerd.ttrpc.v1 Jan 30 12:44:20.268493 systemd[1]: Started docker-602c797a88cc7c5da2c2b98b1b0f5542219891e96d45d365caa2aad10287f758.scope - libcontainer container 602c797a88cc7c5da2c2b98b1b0f5542219891e96d45d365caa2aad10287f758. Jan 30 12:44:20.281737 systemd-resolved[1260]: Failed to determine the local hostname and LLMNR/mDNS names, ignoring: No such device or address Jan 30 12:44:20.362901 etcd-wrapper[1693]: {"level":"info","ts":"2025-01-30T12:44:20.362442Z","caller":"flags/flag.go:113","msg":"recognized and used environment variable","variable-name":"ETCD_DATA_DIR","variable-value":"/var/lib/etcd"} Jan 30 12:44:20.362901 etcd-wrapper[1693]: {"level":"info","ts":"2025-01-30T12:44:20.362590Z","caller":"flags/flag.go:113","msg":"recognized and used environment variable","variable-name":"ETCD_NAME","variable-value":"9f71c6933da04ad79f9683bcd3c39978"} Jan 30 12:44:20.362901 etcd-wrapper[1693]: {"level":"warn","ts":"2025-01-30T12:44:20.362618Z","caller":"flags/flag.go:93","msg":"unrecognized environment variable","environment-variable":"ETCD_IMAGE_URL=quay.io/coreos/etcd"} Jan 30 12:44:20.362901 etcd-wrapper[1693]: {"level":"warn","ts":"2025-01-30T12:44:20.362628Z","caller":"flags/flag.go:93","msg":"unrecognized environment variable","environment-variable":"ETCD_IMAGE_TAG=v3.5.16-arm64"} Jan 30 12:44:20.362901 etcd-wrapper[1693]: {"level":"warn","ts":"2025-01-30T12:44:20.362634Z","caller":"flags/flag.go:93","msg":"unrecognized environment variable","environment-variable":"ETCD_USER=etcd"} Jan 30 12:44:20.362901 etcd-wrapper[1693]: {"level":"warn","ts":"2025-01-30T12:44:20.362638Z","caller":"flags/flag.go:93","msg":"unrecognized environment variable","environment-variable":"ETCD_SSL_DIR=/etc/ssl/certs"} Jan 30 12:44:20.362901 etcd-wrapper[1693]: {"level":"warn","ts":"2025-01-30T12:44:20.362683Z","caller":"embed/config.go:689","msg":"Running http and grpc server on single port. This is not recommended for production."} Jan 30 12:44:20.362901 etcd-wrapper[1693]: {"level":"info","ts":"2025-01-30T12:44:20.362707Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["/usr/local/bin/etcd","--listen-peer-urls=http://10.0.0.16:2380","--listen-client-urls=http://0.0.0.0:2379","--initial-advertise-peer-urls=http://10.0.0.16:2380","--advertise-client-urls=http://10.0.0.16:2379","--discovery=http://10.0.0.1:37375/v2/keys/discovery/3103614527720839059"]} Jan 30 12:44:20.362901 etcd-wrapper[1693]: {"level":"warn","ts":"2025-01-30T12:44:20.362776Z","caller":"embed/config.go:689","msg":"Running http and grpc server on single port. This is not recommended for production."} Jan 30 12:44:20.362901 etcd-wrapper[1693]: {"level":"info","ts":"2025-01-30T12:44:20.362789Z","caller":"embed/etcd.go:128","msg":"configuring peer listeners","listen-peer-urls":["http://10.0.0.16:2380"]} Jan 30 12:44:20.363837 etcd-wrapper[1693]: {"level":"info","ts":"2025-01-30T12:44:20.362963Z","caller":"embed/etcd.go:136","msg":"configuring client listeners","listen-client-urls":["http://0.0.0.0:2379"]} Jan 30 12:44:20.363837 etcd-wrapper[1693]: {"level":"info","ts":"2025-01-30T12:44:20.363077Z","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":"9f71c6933da04ad79f9683bcd3c39978","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://10.0.0.16:2380"],"listen-peer-urls":["http://10.0.0.16:2380"],"advertise-client-urls":["http://10.0.0.16:2379"],"listen-client-urls":["http://0.0.0.0:2379"],"listen-metrics-urls":[],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"9f71c6933da04ad79f9683bcd3c39978=http://10.0.0.16:2380","initial-cluster-state":"new","initial-cluster-token":"http://10.0.0.1:37375/v2/keys/discovery/3103614527720839059","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":"http://10.0.0.1:37375/v2/keys/discovery/3103614527720839059","discovery-proxy":"","downgrade-check-interval":"5s"} Jan 30 12:44:20.368592 etcd-wrapper[1693]: {"level":"info","ts":"2025-01-30T12:44:20.367547Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"4.158841ms"} Jan 30 12:44:20.412504 etcd-wrapper[1693]: {"level":"info","ts":"2025-01-30T12:44:20.412142Z","caller":"v2discovery/discovery.go:336","msg":"found self from discovery server","discovery-url":"http://10.0.0.1:37375","self":"bf238d424856ebd3"} Jan 30 12:44:20.412504 etcd-wrapper[1693]: {"level":"info","ts":"2025-01-30T12:44:20.412184Z","caller":"v2discovery/discovery.go:352","msg":"found peers from discovery server; waiting for more","discovery-url":"http://10.0.0.1:37375","found-peers":1,"needed-peers":2} Jan 30 12:44:20.628731 etcd-wrapper[1693]: {"level":"info","ts":"2025-01-30T12:44:20.628280Z","caller":"v2discovery/discovery.go:371","msg":"found peer from discovery server","discovery-url":"http://10.0.0.1:37375","peer":"b675a341598b56fd"} Jan 30 12:44:20.628731 etcd-wrapper[1693]: {"level":"info","ts":"2025-01-30T12:44:20.628322Z","caller":"v2discovery/discovery.go:352","msg":"found peers from discovery server; waiting for more","discovery-url":"http://10.0.0.1:37375","found-peers":2,"needed-peers":1} Jan 30 12:44:21.185511 systemd[1]: Created slice system-sshd.slice - Slice /system/sshd. Jan 30 12:44:21.186714 systemd[1]: Started sshd@0-10.0.0.16:22-10.0.0.1:41612.service - OpenSSH per-connection server daemon (10.0.0.1:41612). Jan 30 12:44:21.255571 etcd-wrapper[1693]: {"level":"info","ts":"2025-01-30T12:44:21.255191Z","caller":"v2discovery/discovery.go:371","msg":"found peer from discovery server","discovery-url":"http://10.0.0.1:37375","peer":"189ebc097fccf56a"} Jan 30 12:44:21.255571 etcd-wrapper[1693]: {"level":"info","ts":"2025-01-30T12:44:21.255251Z","caller":"v2discovery/discovery.go:378","msg":"found all needed peers from discovery server","discovery-url":"http://10.0.0.1:37375","found-peers":3} Jan 30 12:44:21.260284 sshd[1841]: Accepted publickey for core from 10.0.0.1 port 41612 ssh2: RSA SHA256:DFbjE3cliO0t0vQoroiQEd9uw5v6TFYRV953GUOdMNo Jan 30 12:44:21.260868 etcd-wrapper[1693]: {"level":"info","ts":"2025-01-30T12:44:21.260506Z","caller":"etcdserver/raft.go:505","msg":"starting local member","local-member-id":"bf238d424856ebd3","cluster-id":"189d30633c4802d2"} Jan 30 12:44:21.261088 etcd-wrapper[1693]: {"level":"info","ts":"2025-01-30T12:44:21.260903Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"bf238d424856ebd3 switched to configuration voters=()"} Jan 30 12:44:21.261088 etcd-wrapper[1693]: {"level":"info","ts":"2025-01-30T12:44:21.260928Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"bf238d424856ebd3 became follower at term 0"} Jan 30 12:44:21.261088 etcd-wrapper[1693]: {"level":"info","ts":"2025-01-30T12:44:21.260938Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft bf238d424856ebd3 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} Jan 30 12:44:21.261442 etcd-wrapper[1693]: {"level":"info","ts":"2025-01-30T12:44:21.260945Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"bf238d424856ebd3 became follower at term 1"} Jan 30 12:44:21.261442 etcd-wrapper[1693]: {"level":"info","ts":"2025-01-30T12:44:21.260975Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"bf238d424856ebd3 switched to configuration voters=(1774062052215420266)"} Jan 30 12:44:21.261442 etcd-wrapper[1693]: {"level":"info","ts":"2025-01-30T12:44:21.260988Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"bf238d424856ebd3 switched to configuration voters=(1774062052215420266 13147594188248536829)"} Jan 30 12:44:21.261442 etcd-wrapper[1693]: {"level":"info","ts":"2025-01-30T12:44:21.261003Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"bf238d424856ebd3 switched to configuration voters=(1774062052215420266 13147594188248536829 13773007401250122707)"} Jan 30 12:44:21.262191 etcd-wrapper[1693]: {"level":"warn","ts":"2025-01-30T12:44:21.261966Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} Jan 30 12:44:21.262694 sshd-session[1841]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Jan 30 12:44:21.265312 etcd-wrapper[1693]: {"level":"info","ts":"2025-01-30T12:44:21.264842Z","caller":"mvcc/kvstore.go:423","msg":"kvstore restored","current-rev":1} Jan 30 12:44:21.268048 etcd-wrapper[1693]: {"level":"info","ts":"2025-01-30T12:44:21.267687Z","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"} Jan 30 12:44:21.269658 etcd-wrapper[1693]: {"level":"info","ts":"2025-01-30T12:44:21.269355Z","caller":"rafthttp/peer.go:133","msg":"starting remote peer","remote-peer-id":"189ebc097fccf56a"} Jan 30 12:44:21.269658 etcd-wrapper[1693]: {"level":"info","ts":"2025-01-30T12:44:21.269405Z","caller":"rafthttp/pipeline.go:72","msg":"started HTTP pipelining with remote peer","local-member-id":"bf238d424856ebd3","remote-peer-id":"189ebc097fccf56a"} Jan 30 12:44:21.270744 etcd-wrapper[1693]: {"level":"info","ts":"2025-01-30T12:44:21.269885Z","caller":"rafthttp/stream.go:169","msg":"started stream writer with remote peer","local-member-id":"bf238d424856ebd3","remote-peer-id":"189ebc097fccf56a"} Jan 30 12:44:21.270744 etcd-wrapper[1693]: {"level":"info","ts":"2025-01-30T12:44:21.269930Z","caller":"rafthttp/stream.go:169","msg":"started stream writer with remote peer","local-member-id":"bf238d424856ebd3","remote-peer-id":"189ebc097fccf56a"} Jan 30 12:44:21.273807 systemd[1]: Created slice user-500.slice - User Slice of UID 500. Jan 30 12:44:21.275346 etcd-wrapper[1693]: {"level":"info","ts":"2025-01-30T12:44:21.274707Z","caller":"rafthttp/peer.go:137","msg":"started remote peer","remote-peer-id":"189ebc097fccf56a"} Jan 30 12:44:21.275346 etcd-wrapper[1693]: {"level":"info","ts":"2025-01-30T12:44:21.274765Z","caller":"rafthttp/transport.go:317","msg":"added remote peer","local-member-id":"bf238d424856ebd3","remote-peer-id":"189ebc097fccf56a","remote-peer-urls":["http://10.0.0.15:2380"]} Jan 30 12:44:21.275346 etcd-wrapper[1693]: {"level":"info","ts":"2025-01-30T12:44:21.274792Z","caller":"rafthttp/peer.go:133","msg":"starting remote peer","remote-peer-id":"b675a341598b56fd"} Jan 30 12:44:21.275346 etcd-wrapper[1693]: {"level":"info","ts":"2025-01-30T12:44:21.274809Z","caller":"rafthttp/pipeline.go:72","msg":"started HTTP pipelining with remote peer","local-member-id":"bf238d424856ebd3","remote-peer-id":"b675a341598b56fd"} Jan 30 12:44:21.276583 etcd-wrapper[1693]: {"level":"info","ts":"2025-01-30T12:44:21.275381Z","caller":"rafthttp/stream.go:395","msg":"started stream reader with remote peer","stream-reader-type":"stream MsgApp v2","local-member-id":"bf238d424856ebd3","remote-peer-id":"189ebc097fccf56a"} Jan 30 12:44:21.276583 etcd-wrapper[1693]: {"level":"info","ts":"2025-01-30T12:44:21.275396Z","caller":"rafthttp/stream.go:395","msg":"started stream reader with remote peer","stream-reader-type":"stream Message","local-member-id":"bf238d424856ebd3","remote-peer-id":"189ebc097fccf56a"} Jan 30 12:44:21.276583 etcd-wrapper[1693]: {"level":"info","ts":"2025-01-30T12:44:21.275527Z","caller":"rafthttp/stream.go:169","msg":"started stream writer with remote peer","local-member-id":"bf238d424856ebd3","remote-peer-id":"b675a341598b56fd"} Jan 30 12:44:21.276583 etcd-wrapper[1693]: {"level":"info","ts":"2025-01-30T12:44:21.275571Z","caller":"rafthttp/stream.go:169","msg":"started stream writer with remote peer","local-member-id":"bf238d424856ebd3","remote-peer-id":"b675a341598b56fd"} Jan 30 12:44:21.280228 etcd-wrapper[1693]: {"level":"info","ts":"2025-01-30T12:44:21.279741Z","caller":"rafthttp/peer.go:137","msg":"started remote peer","remote-peer-id":"b675a341598b56fd"} Jan 30 12:44:21.280228 etcd-wrapper[1693]: {"level":"info","ts":"2025-01-30T12:44:21.279908Z","caller":"rafthttp/transport.go:317","msg":"added remote peer","local-member-id":"bf238d424856ebd3","remote-peer-id":"b675a341598b56fd","remote-peer-urls":["http://10.0.0.14:2380"]} Jan 30 12:44:21.281292 etcd-wrapper[1693]: {"level":"info","ts":"2025-01-30T12:44:21.279828Z","caller":"rafthttp/stream.go:395","msg":"started stream reader with remote peer","stream-reader-type":"stream MsgApp v2","local-member-id":"bf238d424856ebd3","remote-peer-id":"b675a341598b56fd"} Jan 30 12:44:21.281292 etcd-wrapper[1693]: {"level":"info","ts":"2025-01-30T12:44:21.280095Z","caller":"etcdserver/server.go:873","msg":"starting etcd server","local-member-id":"bf238d424856ebd3","local-server-version":"3.5.16","cluster-version":"to_be_decided"} Jan 30 12:44:21.281292 etcd-wrapper[1693]: {"level":"info","ts":"2025-01-30T12:44:21.279840Z","caller":"rafthttp/stream.go:395","msg":"started stream reader with remote peer","stream-reader-type":"stream Message","local-member-id":"bf238d424856ebd3","remote-peer-id":"b675a341598b56fd"} Jan 30 12:44:21.281292 etcd-wrapper[1693]: {"level":"info","ts":"2025-01-30T12:44:21.280378Z","caller":"v3rpc/health.go:61","msg":"grpc service status changed","service":"","status":"SERVING"} Jan 30 12:44:21.281292 etcd-wrapper[1693]: {"level":"info","ts":"2025-01-30T12:44:21.280585Z","caller":"etcdserver/server.go:773","msg":"starting initial election tick advance","election-ticks":10} Jan 30 12:44:21.281585 etcd-wrapper[1693]: {"level":"info","ts":"2025-01-30T12:44:21.280809Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/snap","suffix":"snap.db","max":5,"interval":"30s"} Jan 30 12:44:21.281585 etcd-wrapper[1693]: {"level":"info","ts":"2025-01-30T12:44:21.280874Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/snap","suffix":"snap","max":5,"interval":"30s"} Jan 30 12:44:21.281585 etcd-wrapper[1693]: {"level":"info","ts":"2025-01-30T12:44:21.280882Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/wal","suffix":"wal","max":5,"interval":"30s"} Jan 30 12:44:21.281558 systemd[1]: Starting user-runtime-dir@500.service - User Runtime Directory /run/user/500... Jan 30 12:44:21.283895 etcd-wrapper[1693]: {"level":"info","ts":"2025-01-30T12:44:21.281946Z","caller":"embed/etcd.go:600","msg":"serving peer traffic","address":"10.0.0.16:2380"} Jan 30 12:44:21.283895 etcd-wrapper[1693]: {"level":"info","ts":"2025-01-30T12:44:21.281971Z","caller":"embed/etcd.go:572","msg":"cmux::serve","address":"10.0.0.16:2380"} Jan 30 12:44:21.283895 etcd-wrapper[1693]: {"level":"info","ts":"2025-01-30T12:44:21.282310Z","caller":"rafthttp/stream.go:249","msg":"set message encoder","from":"bf238d424856ebd3","to":"b675a341598b56fd","stream-type":"stream MsgApp v2"} Jan 30 12:44:21.283895 etcd-wrapper[1693]: {"level":"info","ts":"2025-01-30T12:44:21.282331Z","caller":"rafthttp/peer_status.go:53","msg":"peer became active","peer-id":"b675a341598b56fd"} Jan 30 12:44:21.283895 etcd-wrapper[1693]: {"level":"info","ts":"2025-01-30T12:44:21.282354Z","caller":"rafthttp/stream.go:274","msg":"established TCP streaming connection with remote peer","stream-writer-type":"stream MsgApp v2","local-member-id":"bf238d424856ebd3","remote-peer-id":"b675a341598b56fd"} Jan 30 12:44:21.283895 etcd-wrapper[1693]: {"level":"info","ts":"2025-01-30T12:44:21.281938Z","caller":"embed/etcd.go:280","msg":"now serving peer/client/metrics","local-member-id":"bf238d424856ebd3","initial-advertise-peer-urls":["http://10.0.0.16:2380"],"listen-peer-urls":["http://10.0.0.16:2380"],"advertise-client-urls":["http://10.0.0.16:2379"],"listen-client-urls":["http://0.0.0.0:2379"],"listen-metrics-urls":[]} Jan 30 12:44:21.283895 etcd-wrapper[1693]: {"level":"info","ts":"2025-01-30T12:44:21.282403Z","caller":"rafthttp/peer_status.go:53","msg":"peer became active","peer-id":"189ebc097fccf56a"} Jan 30 12:44:21.283895 etcd-wrapper[1693]: {"level":"info","ts":"2025-01-30T12:44:21.282411Z","caller":"rafthttp/stream.go:412","msg":"established TCP streaming connection with remote peer","stream-reader-type":"stream Message","local-member-id":"bf238d424856ebd3","remote-peer-id":"189ebc097fccf56a"} Jan 30 12:44:21.283895 etcd-wrapper[1693]: {"level":"info","ts":"2025-01-30T12:44:21.282443Z","caller":"rafthttp/stream.go:412","msg":"established TCP streaming connection with remote peer","stream-reader-type":"stream MsgApp v2","local-member-id":"bf238d424856ebd3","remote-peer-id":"189ebc097fccf56a"} Jan 30 12:44:21.284211 etcd-wrapper[1693]: {"level":"info","ts":"2025-01-30T12:44:21.282516Z","caller":"rafthttp/stream.go:249","msg":"set message encoder","from":"bf238d424856ebd3","to":"b675a341598b56fd","stream-type":"stream Message"} Jan 30 12:44:21.284211 etcd-wrapper[1693]: {"level":"info","ts":"2025-01-30T12:44:21.282527Z","caller":"rafthttp/stream.go:274","msg":"established TCP streaming connection with remote peer","stream-writer-type":"stream Message","local-member-id":"bf238d424856ebd3","remote-peer-id":"b675a341598b56fd"} Jan 30 12:44:21.284211 etcd-wrapper[1693]: {"level":"info","ts":"2025-01-30T12:44:21.282523Z","caller":"rafthttp/stream.go:249","msg":"set message encoder","from":"bf238d424856ebd3","to":"189ebc097fccf56a","stream-type":"stream Message"} Jan 30 12:44:21.284211 etcd-wrapper[1693]: {"level":"info","ts":"2025-01-30T12:44:21.282544Z","caller":"rafthttp/stream.go:274","msg":"established TCP streaming connection with remote peer","stream-writer-type":"stream Message","local-member-id":"bf238d424856ebd3","remote-peer-id":"189ebc097fccf56a"} Jan 30 12:44:21.284211 etcd-wrapper[1693]: {"level":"info","ts":"2025-01-30T12:44:21.282616Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"bf238d424856ebd3 switched to configuration voters=(1774062052215420266 13147594188248536829 13773007401250122707)"} Jan 30 12:44:21.284211 etcd-wrapper[1693]: {"level":"info","ts":"2025-01-30T12:44:21.282773Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"189d30633c4802d2","local-member-id":"bf238d424856ebd3","added-peer-id":"189ebc097fccf56a","added-peer-peer-urls":["http://10.0.0.15:2380"]} Jan 30 12:44:21.284211 etcd-wrapper[1693]: {"level":"info","ts":"2025-01-30T12:44:21.282849Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"bf238d424856ebd3 switched to configuration voters=(1774062052215420266 13147594188248536829 13773007401250122707)"} Jan 30 12:44:21.284211 etcd-wrapper[1693]: {"level":"info","ts":"2025-01-30T12:44:21.282847Z","caller":"rafthttp/stream.go:249","msg":"set message encoder","from":"bf238d424856ebd3","to":"189ebc097fccf56a","stream-type":"stream MsgApp v2"} Jan 30 12:44:21.284517 etcd-wrapper[1693]: {"level":"info","ts":"2025-01-30T12:44:21.282871Z","caller":"rafthttp/stream.go:274","msg":"established TCP streaming connection with remote peer","stream-writer-type":"stream MsgApp v2","local-member-id":"bf238d424856ebd3","remote-peer-id":"189ebc097fccf56a"} Jan 30 12:44:21.284517 etcd-wrapper[1693]: {"level":"info","ts":"2025-01-30T12:44:21.282912Z","caller":"rafthttp/stream.go:412","msg":"established TCP streaming connection with remote peer","stream-reader-type":"stream MsgApp v2","local-member-id":"bf238d424856ebd3","remote-peer-id":"b675a341598b56fd"} Jan 30 12:44:21.284517 etcd-wrapper[1693]: {"level":"info","ts":"2025-01-30T12:44:21.282948Z","caller":"rafthttp/stream.go:412","msg":"established TCP streaming connection with remote peer","stream-reader-type":"stream Message","local-member-id":"bf238d424856ebd3","remote-peer-id":"b675a341598b56fd"} Jan 30 12:44:21.284517 etcd-wrapper[1693]: {"level":"info","ts":"2025-01-30T12:44:21.282914Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"189d30633c4802d2","local-member-id":"bf238d424856ebd3","added-peer-id":"b675a341598b56fd","added-peer-peer-urls":["http://10.0.0.14:2380"]} Jan 30 12:44:21.284517 etcd-wrapper[1693]: {"level":"info","ts":"2025-01-30T12:44:21.283321Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"bf238d424856ebd3 switched to configuration voters=(1774062052215420266 13147594188248536829 13773007401250122707)"} Jan 30 12:44:21.284517 etcd-wrapper[1693]: {"level":"info","ts":"2025-01-30T12:44:21.283494Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"189d30633c4802d2","local-member-id":"bf238d424856ebd3","added-peer-id":"bf238d424856ebd3","added-peer-peer-urls":["http://10.0.0.16:2380"]} Jan 30 12:44:21.290228 systemd-logind[1394]: New session 1 of user core. Jan 30 12:44:21.296673 systemd[1]: Finished user-runtime-dir@500.service - User Runtime Directory /run/user/500. Jan 30 12:44:21.299451 systemd[1]: Starting user@500.service - User Manager for UID 500... Jan 30 12:44:21.310149 (systemd)[1845]: pam_unix(systemd-user:session): session opened for user core(uid=500) by (uid=0) Jan 30 12:44:21.332094 etcd-wrapper[1693]: {"level":"info","ts":"2025-01-30T12:44:21.331815Z","caller":"etcdserver/server.go:796","msg":"initialized peer connections; fast-forwarding election ticks","local-member-id":"bf238d424856ebd3","forward-ticks":8,"forward-duration":"800ms","election-ticks":10,"election-timeout":"1s","active-remote-members":2} Jan 30 12:44:21.430265 systemd[1845]: Queued start job for default target default.target. Jan 30 12:44:21.439507 systemd[1845]: Created slice app.slice - User Application Slice. Jan 30 12:44:21.439541 systemd[1845]: Reached target paths.target - Paths. Jan 30 12:44:21.439554 systemd[1845]: Reached target timers.target - Timers. Jan 30 12:44:21.440926 systemd[1845]: Starting dbus.socket - D-Bus User Message Bus Socket... Jan 30 12:44:21.454980 systemd[1845]: Listening on dbus.socket - D-Bus User Message Bus Socket. Jan 30 12:44:21.455108 systemd[1845]: Reached target sockets.target - Sockets. Jan 30 12:44:21.455121 systemd[1845]: Reached target basic.target - Basic System. Jan 30 12:44:21.455163 systemd[1845]: Reached target default.target - Main User Target. Jan 30 12:44:21.455191 systemd[1845]: Startup finished in 132ms. Jan 30 12:44:21.455383 systemd[1]: Started user@500.service - User Manager for UID 500. Jan 30 12:44:21.457950 systemd[1]: Started session-1.scope - Session 1 of User core. Jan 30 12:44:21.524120 systemd[1]: Started sshd@1-10.0.0.16:22-10.0.0.1:41616.service - OpenSSH per-connection server daemon (10.0.0.1:41616). Jan 30 12:44:21.596952 sshd[1856]: Accepted publickey for core from 10.0.0.1 port 41616 ssh2: RSA SHA256:DFbjE3cliO0t0vQoroiQEd9uw5v6TFYRV953GUOdMNo Jan 30 12:44:21.598499 sshd-session[1856]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Jan 30 12:44:21.602936 systemd-logind[1394]: New session 2 of user core. Jan 30 12:44:21.620474 systemd[1]: Started session-2.scope - Session 2 of User core. Jan 30 12:44:21.673852 sshd[1858]: Connection closed by 10.0.0.1 port 41616 Jan 30 12:44:21.674559 sshd-session[1856]: pam_unix(sshd:session): session closed for user core Jan 30 12:44:21.684873 systemd[1]: sshd@1-10.0.0.16:22-10.0.0.1:41616.service: Deactivated successfully. Jan 30 12:44:21.687750 systemd[1]: session-2.scope: Deactivated successfully. Jan 30 12:44:21.689418 systemd-logind[1394]: Session 2 logged out. Waiting for processes to exit. Jan 30 12:44:21.690861 systemd-logind[1394]: Removed session 2. Jan 30 12:44:21.701626 systemd[1]: Started sshd@2-10.0.0.16:22-10.0.0.1:41628.service - OpenSSH per-connection server daemon (10.0.0.1:41628). Jan 30 12:44:21.739584 sshd[1863]: Accepted publickey for core from 10.0.0.1 port 41628 ssh2: RSA SHA256:DFbjE3cliO0t0vQoroiQEd9uw5v6TFYRV953GUOdMNo Jan 30 12:44:21.740972 sshd-session[1863]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Jan 30 12:44:21.745621 systemd-logind[1394]: New session 3 of user core. Jan 30 12:44:21.755468 systemd[1]: Started session-3.scope - Session 3 of User core. Jan 30 12:44:21.812583 sshd[1865]: Connection closed by 10.0.0.1 port 41628 Jan 30 12:44:21.812954 sshd-session[1863]: pam_unix(sshd:session): session closed for user core Jan 30 12:44:21.816127 systemd[1]: sshd@2-10.0.0.16:22-10.0.0.1:41628.service: Deactivated successfully. Jan 30 12:44:21.817810 systemd[1]: session-3.scope: Deactivated successfully. Jan 30 12:44:21.819824 systemd-logind[1394]: Session 3 logged out. Waiting for processes to exit. Jan 30 12:44:21.820762 systemd-logind[1394]: Removed session 3. Jan 30 12:44:22.180907 etcd-wrapper[1693]: {"level":"info","ts":"2025-01-30T12:44:22.180465Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"bf238d424856ebd3 [logterm: 1, index: 3, vote: 0] cast MsgPreVote for b675a341598b56fd [logterm: 1, index: 3] at term 1"} Jan 30 12:44:22.236332 etcd-wrapper[1693]: {"level":"info","ts":"2025-01-30T12:44:22.236036Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"bf238d424856ebd3 [term: 1] received a MsgVote message with higher term from b675a341598b56fd [term: 2]"} Jan 30 12:44:22.236332 etcd-wrapper[1693]: {"level":"info","ts":"2025-01-30T12:44:22.236082Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"bf238d424856ebd3 became follower at term 2"} Jan 30 12:44:22.236332 etcd-wrapper[1693]: {"level":"info","ts":"2025-01-30T12:44:22.236094Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"bf238d424856ebd3 [logterm: 1, index: 3, vote: 0] cast MsgVote for b675a341598b56fd [logterm: 1, index: 3] at term 2"} Jan 30 12:44:22.239385 etcd-wrapper[1693]: {"level":"info","ts":"2025-01-30T12:44:22.239107Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: bf238d424856ebd3 elected leader b675a341598b56fd at term 2"} Jan 30 12:44:22.252300 etcd-wrapper[1693]: {"level":"info","ts":"2025-01-30T12:44:22.251902Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"189d30633c4802d2","local-member-id":"bf238d424856ebd3","cluster-version":"3.5"} Jan 30 12:44:22.252300 etcd-wrapper[1693]: {"level":"info","ts":"2025-01-30T12:44:22.251983Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} Jan 30 12:44:22.252300 etcd-wrapper[1693]: {"level":"info","ts":"2025-01-30T12:44:22.252010Z","caller":"etcdserver/server.go:2140","msg":"published local member to cluster through raft","local-member-id":"bf238d424856ebd3","local-member-attributes":"{Name:9f71c6933da04ad79f9683bcd3c39978 ClientURLs:[http://10.0.0.16:2379]}","request-path":"/0/members/bf238d424856ebd3/attributes","cluster-id":"189d30633c4802d2","publish-timeout":"7s"} Jan 30 12:44:22.252300 etcd-wrapper[1693]: {"level":"info","ts":"2025-01-30T12:44:22.252032Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} Jan 30 12:44:22.253190 etcd-wrapper[1693]: {"level":"info","ts":"2025-01-30T12:44:22.252272Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} Jan 30 12:44:22.253354 etcd-wrapper[1693]: {"level":"info","ts":"2025-01-30T12:44:22.252469Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} Jan 30 12:44:22.253354 etcd-wrapper[1693]: {"level":"info","ts":"2025-01-30T12:44:22.253042Z","caller":"v3rpc/health.go:61","msg":"grpc service status changed","service":"","status":"SERVING"} Jan 30 12:44:22.253364 systemd[1]: Started etcd-member.service - etcd (System Application Container). Jan 30 12:44:22.253890 systemd[1]: Reached target multi-user.target - Multi-User System. Jan 30 12:44:22.254304 etcd-wrapper[1693]: {"level":"info","ts":"2025-01-30T12:44:22.253645Z","caller":"embed/serve.go:187","msg":"serving client traffic insecurely; this is strongly discouraged!","traffic":"grpc+http","address":"[::]:2379"} Jan 30 12:44:22.254264 systemd[1]: Startup finished in 670ms (kernel) + 3.885s (initrd) + 10.671s (userspace) = 15.227s. Jan 30 12:44:31.921541 systemd[1]: Started sshd@3-10.0.0.16:22-10.0.0.1:48826.service - OpenSSH per-connection server daemon (10.0.0.1:48826). Jan 30 12:44:31.967668 sshd[1872]: Accepted publickey for core from 10.0.0.1 port 48826 ssh2: RSA SHA256:DFbjE3cliO0t0vQoroiQEd9uw5v6TFYRV953GUOdMNo Jan 30 12:44:31.969028 sshd-session[1872]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Jan 30 12:44:31.975269 systemd-logind[1394]: New session 4 of user core. Jan 30 12:44:31.985472 systemd[1]: Started session-4.scope - Session 4 of User core. Jan 30 12:44:32.039553 sshd[1874]: Connection closed by 10.0.0.1 port 48826 Jan 30 12:44:32.040087 sshd-session[1872]: pam_unix(sshd:session): session closed for user core Jan 30 12:44:32.057753 systemd[1]: sshd@3-10.0.0.16:22-10.0.0.1:48826.service: Deactivated successfully. Jan 30 12:44:32.059222 systemd[1]: session-4.scope: Deactivated successfully. Jan 30 12:44:32.060863 systemd-logind[1394]: Session 4 logged out. Waiting for processes to exit. Jan 30 12:44:32.062063 systemd[1]: Started sshd@4-10.0.0.16:22-10.0.0.1:48834.service - OpenSSH per-connection server daemon (10.0.0.1:48834). Jan 30 12:44:32.063107 systemd-logind[1394]: Removed session 4. Jan 30 12:44:32.115003 sshd[1879]: Accepted publickey for core from 10.0.0.1 port 48834 ssh2: RSA SHA256:DFbjE3cliO0t0vQoroiQEd9uw5v6TFYRV953GUOdMNo Jan 30 12:44:32.116784 sshd-session[1879]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Jan 30 12:44:32.121746 systemd-logind[1394]: New session 5 of user core. Jan 30 12:44:32.129446 systemd[1]: Started session-5.scope - Session 5 of User core. Jan 30 12:44:32.178021 sshd[1881]: Connection closed by 10.0.0.1 port 48834 Jan 30 12:44:32.178490 sshd-session[1879]: pam_unix(sshd:session): session closed for user core Jan 30 12:44:32.191763 systemd[1]: sshd@4-10.0.0.16:22-10.0.0.1:48834.service: Deactivated successfully. Jan 30 12:44:32.193358 systemd[1]: session-5.scope: Deactivated successfully. Jan 30 12:44:32.195470 systemd-logind[1394]: Session 5 logged out. Waiting for processes to exit. Jan 30 12:44:32.196719 systemd[1]: Started sshd@5-10.0.0.16:22-10.0.0.1:48850.service - OpenSSH per-connection server daemon (10.0.0.1:48850). Jan 30 12:44:32.197456 systemd-logind[1394]: Removed session 5. Jan 30 12:44:32.244416 sshd[1886]: Accepted publickey for core from 10.0.0.1 port 48850 ssh2: RSA SHA256:DFbjE3cliO0t0vQoroiQEd9uw5v6TFYRV953GUOdMNo Jan 30 12:44:32.246251 sshd-session[1886]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Jan 30 12:44:32.251421 systemd-logind[1394]: New session 6 of user core. Jan 30 12:44:32.257621 systemd[1]: Started session-6.scope - Session 6 of User core. Jan 30 12:44:32.313591 sshd[1888]: Connection closed by 10.0.0.1 port 48850 Jan 30 12:44:32.315108 sshd-session[1886]: pam_unix(sshd:session): session closed for user core Jan 30 12:44:32.326882 systemd[1]: sshd@5-10.0.0.16:22-10.0.0.1:48850.service: Deactivated successfully. Jan 30 12:44:32.331010 systemd[1]: session-6.scope: Deactivated successfully. Jan 30 12:44:32.333069 systemd-logind[1394]: Session 6 logged out. Waiting for processes to exit. Jan 30 12:44:32.350669 systemd[1]: Started sshd@6-10.0.0.16:22-10.0.0.1:48858.service - OpenSSH per-connection server daemon (10.0.0.1:48858). Jan 30 12:44:32.352855 systemd-logind[1394]: Removed session 6. Jan 30 12:44:32.391790 sshd[1893]: Accepted publickey for core from 10.0.0.1 port 48858 ssh2: RSA SHA256:DFbjE3cliO0t0vQoroiQEd9uw5v6TFYRV953GUOdMNo Jan 30 12:44:32.393545 sshd-session[1893]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Jan 30 12:44:32.405810 systemd-logind[1394]: New session 7 of user core. Jan 30 12:44:32.414448 systemd[1]: Started session-7.scope - Session 7 of User core. Jan 30 12:44:32.484457 sudo[1896]: core : PWD=/home/core ; USER=root ; COMMAND=/usr/sbin/setenforce 1 Jan 30 12:44:32.484748 sudo[1896]: pam_unix(sudo:session): session opened for user root(uid=0) by core(uid=500) Jan 30 12:44:32.500349 sudo[1896]: pam_unix(sudo:session): session closed for user root Jan 30 12:44:32.502381 sshd[1895]: Connection closed by 10.0.0.1 port 48858 Jan 30 12:44:32.502801 sshd-session[1893]: pam_unix(sshd:session): session closed for user core Jan 30 12:44:32.515882 systemd[1]: sshd@6-10.0.0.16:22-10.0.0.1:48858.service: Deactivated successfully. Jan 30 12:44:32.517516 systemd[1]: session-7.scope: Deactivated successfully. Jan 30 12:44:32.520487 systemd-logind[1394]: Session 7 logged out. Waiting for processes to exit. Jan 30 12:44:32.529572 systemd[1]: Started sshd@7-10.0.0.16:22-10.0.0.1:58738.service - OpenSSH per-connection server daemon (10.0.0.1:58738). Jan 30 12:44:32.530871 systemd-logind[1394]: Removed session 7. Jan 30 12:44:32.574418 sshd[1901]: Accepted publickey for core from 10.0.0.1 port 58738 ssh2: RSA SHA256:DFbjE3cliO0t0vQoroiQEd9uw5v6TFYRV953GUOdMNo Jan 30 12:44:32.575872 sshd-session[1901]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Jan 30 12:44:32.580342 systemd-logind[1394]: New session 8 of user core. Jan 30 12:44:32.587454 systemd[1]: Started session-8.scope - Session 8 of User core. Jan 30 12:44:32.640390 sudo[1905]: core : PWD=/home/core ; USER=root ; COMMAND=/usr/sbin/rm -rf /etc/audit/rules.d/80-selinux.rules /etc/audit/rules.d/99-default.rules Jan 30 12:44:32.640670 sudo[1905]: pam_unix(sudo:session): session opened for user root(uid=0) by core(uid=500) Jan 30 12:44:32.643737 sudo[1905]: pam_unix(sudo:session): session closed for user root Jan 30 12:44:32.649274 sudo[1904]: core : PWD=/home/core ; USER=root ; COMMAND=/usr/sbin/systemctl restart audit-rules Jan 30 12:44:32.649567 sudo[1904]: pam_unix(sudo:session): session opened for user root(uid=0) by core(uid=500) Jan 30 12:44:32.667654 systemd[1]: Starting audit-rules.service - Load Audit Rules... Jan 30 12:44:32.705234 augenrules[1927]: No rules Jan 30 12:44:32.705913 systemd[1]: audit-rules.service: Deactivated successfully. Jan 30 12:44:32.706143 systemd[1]: Finished audit-rules.service - Load Audit Rules. Jan 30 12:44:32.707450 sudo[1904]: pam_unix(sudo:session): session closed for user root Jan 30 12:44:32.709821 sshd[1903]: Connection closed by 10.0.0.1 port 58738 Jan 30 12:44:32.710336 sshd-session[1901]: pam_unix(sshd:session): session closed for user core Jan 30 12:44:32.716334 systemd[1]: sshd@7-10.0.0.16:22-10.0.0.1:58738.service: Deactivated successfully. Jan 30 12:44:32.717940 systemd[1]: session-8.scope: Deactivated successfully. Jan 30 12:44:32.719866 systemd-logind[1394]: Session 8 logged out. Waiting for processes to exit. Jan 30 12:44:32.720835 systemd-logind[1394]: Removed session 8. Jan 30 12:44:32.945019 systemd[1]: Started sshd@8-10.0.0.16:22-10.0.0.1:58744.service - OpenSSH per-connection server daemon (10.0.0.1:58744). Jan 30 12:44:32.986327 sshd[1935]: Accepted publickey for core from 10.0.0.1 port 58744 ssh2: RSA SHA256:DFbjE3cliO0t0vQoroiQEd9uw5v6TFYRV953GUOdMNo Jan 30 12:44:32.987854 sshd-session[1935]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Jan 30 12:44:32.991966 systemd-logind[1394]: New session 9 of user core. Jan 30 12:44:33.000479 systemd[1]: Started session-9.scope - Session 9 of User core. Jan 30 12:44:33.173407 sshd[1937]: Connection closed by 10.0.0.1 port 58744 Jan 30 12:44:33.174350 sshd-session[1935]: pam_unix(sshd:session): session closed for user core Jan 30 12:44:33.180816 systemd[1]: sshd@8-10.0.0.16:22-10.0.0.1:58744.service: Deactivated successfully. Jan 30 12:44:33.183642 systemd[1]: session-9.scope: Deactivated successfully. Jan 30 12:44:33.186367 systemd-logind[1394]: Session 9 logged out. Waiting for processes to exit. Jan 30 12:44:33.187609 systemd-logind[1394]: Removed session 9.