Oct 30 23:58:29.875549 kernel: Booting Linux on physical CPU 0x0000000000 [0x413fd0c1] Oct 30 23:58:29.875583 kernel: Linux version 6.6.113-flatcar (build@pony-truck.infra.kinvolk.io) (aarch64-cros-linux-gnu-gcc (Gentoo Hardened 14.2.1_p20241221 p7) 14.2.1 20241221, GNU ld (Gentoo 2.43 p3) 2.43.1) #1 SMP PREEMPT Thu Oct 30 22:19:25 -00 2025 Oct 30 23:58:29.875600 kernel: KASLR enabled Oct 30 23:58:29.875609 kernel: efi: EFI v2.7 by Ubuntu distribution of EDK II Oct 30 23:58:29.875618 kernel: efi: SMBIOS 3.0=0x139ed0000 MEMATTR=0x1390b8118 ACPI 2.0=0x136760018 RNG=0x13676e918 MEMRESERVE=0x136b41218 Oct 30 23:58:29.875627 kernel: random: crng init done Oct 30 23:58:29.875638 kernel: secureboot: Secure boot disabled Oct 30 23:58:29.875647 kernel: ACPI: Early table checksum verification disabled Oct 30 23:58:29.875657 kernel: ACPI: RSDP 0x0000000136760018 000024 (v02 BOCHS ) Oct 30 23:58:29.875668 kernel: ACPI: XSDT 0x000000013676FE98 00006C (v01 BOCHS BXPC 00000001 01000013) Oct 30 23:58:29.875679 kernel: ACPI: FACP 0x000000013676FA98 000114 (v06 BOCHS BXPC 00000001 BXPC 00000001) Oct 30 23:58:29.875688 kernel: ACPI: DSDT 0x0000000136767518 001468 (v02 BOCHS BXPC 00000001 BXPC 00000001) Oct 30 23:58:29.875698 kernel: ACPI: APIC 0x000000013676FC18 000108 (v04 BOCHS BXPC 00000001 BXPC 00000001) Oct 30 23:58:29.875707 kernel: ACPI: PPTT 0x000000013676FD98 000060 (v02 BOCHS BXPC 00000001 BXPC 00000001) Oct 30 23:58:29.875719 kernel: ACPI: GTDT 0x000000013676D898 000060 (v02 BOCHS BXPC 00000001 BXPC 00000001) Oct 30 23:58:29.875731 kernel: ACPI: MCFG 0x000000013676FF98 00003C (v01 BOCHS BXPC 00000001 BXPC 00000001) Oct 30 23:58:29.875741 kernel: ACPI: SPCR 0x000000013676E818 000050 (v02 BOCHS BXPC 00000001 BXPC 00000001) Oct 30 23:58:29.875751 kernel: ACPI: DBG2 0x000000013676E898 000057 (v00 BOCHS BXPC 00000001 BXPC 00000001) Oct 30 23:58:29.875761 kernel: ACPI: IORT 0x000000013676E418 000080 (v03 BOCHS BXPC 00000001 BXPC 00000001) Oct 30 23:58:29.875771 kernel: ACPI: BGRT 0x000000013676E798 000038 (v01 INTEL EDK2 00000002 01000013) Oct 30 23:58:29.875781 kernel: ACPI: SPCR: console: pl011,mmio32,0x9000000,9600 Oct 30 23:58:29.875791 kernel: NUMA: Failed to initialise from firmware Oct 30 23:58:29.875801 kernel: NUMA: Faking a node at [mem 0x0000000040000000-0x0000000139ffffff] Oct 30 23:58:29.875811 kernel: NUMA: NODE_DATA [mem 0x13966e800-0x139673fff] Oct 30 23:58:29.875821 kernel: Zone ranges: Oct 30 23:58:29.875832 kernel: DMA [mem 0x0000000040000000-0x00000000ffffffff] Oct 30 23:58:29.875842 kernel: DMA32 empty Oct 30 23:58:29.875852 kernel: Normal [mem 0x0000000100000000-0x0000000139ffffff] Oct 30 23:58:29.875862 kernel: Movable zone start for each node Oct 30 23:58:29.875872 kernel: Early memory node ranges Oct 30 23:58:29.875881 kernel: node 0: [mem 0x0000000040000000-0x000000013666ffff] Oct 30 23:58:29.875891 kernel: node 0: [mem 0x0000000136670000-0x000000013667ffff] Oct 30 23:58:29.875901 kernel: node 0: [mem 0x0000000136680000-0x000000013676ffff] Oct 30 23:58:29.875911 kernel: node 0: [mem 0x0000000136770000-0x0000000136b3ffff] Oct 30 23:58:29.875921 kernel: node 0: [mem 0x0000000136b40000-0x0000000139e1ffff] Oct 30 23:58:29.875931 kernel: node 0: [mem 0x0000000139e20000-0x0000000139eaffff] Oct 30 23:58:29.875941 kernel: node 0: [mem 0x0000000139eb0000-0x0000000139ebffff] Oct 30 23:58:29.875952 kernel: node 0: [mem 0x0000000139ec0000-0x0000000139fdffff] Oct 30 23:58:29.875962 kernel: node 0: [mem 0x0000000139fe0000-0x0000000139ffffff] Oct 30 23:58:29.875979 kernel: Initmem setup node 0 [mem 0x0000000040000000-0x0000000139ffffff] Oct 30 23:58:29.875994 kernel: On node 0, zone Normal: 24576 pages in unavailable ranges Oct 30 23:58:29.876005 kernel: psci: probing for conduit method from ACPI. Oct 30 23:58:29.876015 kernel: psci: PSCIv1.1 detected in firmware. Oct 30 23:58:29.876028 kernel: psci: Using standard PSCI v0.2 function IDs Oct 30 23:58:29.876038 kernel: psci: Trusted OS migration not required Oct 30 23:58:29.876049 kernel: psci: SMC Calling Convention v1.1 Oct 30 23:58:29.876060 kernel: smccc: KVM: hypervisor services detected (0x00000000 0x00000000 0x00000000 0x00000003) Oct 30 23:58:29.876070 kernel: percpu: Embedded 31 pages/cpu s86120 r8192 d32664 u126976 Oct 30 23:58:29.876080 kernel: pcpu-alloc: s86120 r8192 d32664 u126976 alloc=31*4096 Oct 30 23:58:29.876091 kernel: pcpu-alloc: [0] 0 [0] 1 Oct 30 23:58:29.876102 kernel: Detected PIPT I-cache on CPU0 Oct 30 23:58:29.876117 kernel: CPU features: detected: GIC system register CPU interface Oct 30 23:58:29.876128 kernel: CPU features: detected: Hardware dirty bit management Oct 30 23:58:29.876140 kernel: CPU features: detected: Spectre-v4 Oct 30 23:58:29.876151 kernel: CPU features: detected: Spectre-BHB Oct 30 23:58:29.876161 kernel: CPU features: kernel page table isolation forced ON by KASLR Oct 30 23:58:29.876172 kernel: CPU features: detected: Kernel page table isolation (KPTI) Oct 30 23:58:29.876182 kernel: CPU features: detected: ARM erratum 1418040 Oct 30 23:58:29.876193 kernel: CPU features: detected: SSBS not fully self-synchronizing Oct 30 23:58:29.876203 kernel: alternatives: applying boot alternatives Oct 30 23:58:29.876215 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=ttyAMA0,115200n8 flatcar.first_boot=detected acpi=force flatcar.oem.id=hetzner verity.usrhash=fa720f16dbb9986f34dd4402492c226087bd8d749299bbe02bbfafab6272d378 Oct 30 23:58:29.876226 kernel: Dentry cache hash table entries: 524288 (order: 10, 4194304 bytes, linear) Oct 30 23:58:29.876237 kernel: Inode-cache hash table entries: 262144 (order: 9, 2097152 bytes, linear) Oct 30 23:58:29.876247 kernel: Fallback order for Node 0: 0 Oct 30 23:58:29.876260 kernel: Built 1 zonelists, mobility grouping on. Total pages: 1008000 Oct 30 23:58:29.876270 kernel: Policy zone: Normal Oct 30 23:58:29.876301 kernel: mem auto-init: stack:off, heap alloc:off, heap free:off Oct 30 23:58:29.876315 kernel: software IO TLB: area num 2. Oct 30 23:58:29.876325 kernel: software IO TLB: mapped [mem 0x00000000fbfff000-0x00000000fffff000] (64MB) Oct 30 23:58:29.876336 kernel: Memory: 3883764K/4096000K available (10368K kernel code, 2180K rwdata, 8104K rodata, 38400K init, 897K bss, 212236K reserved, 0K cma-reserved) Oct 30 23:58:29.876347 kernel: SLUB: HWalign=64, Order=0-3, MinObjects=0, CPUs=2, Nodes=1 Oct 30 23:58:29.876357 kernel: rcu: Preemptible hierarchical RCU implementation. Oct 30 23:58:29.876369 kernel: rcu: RCU event tracing is enabled. Oct 30 23:58:29.876380 kernel: rcu: RCU restricting CPUs from NR_CPUS=512 to nr_cpu_ids=2. Oct 30 23:58:29.876390 kernel: Trampoline variant of Tasks RCU enabled. Oct 30 23:58:29.876401 kernel: Tracing variant of Tasks RCU enabled. Oct 30 23:58:29.876419 kernel: rcu: RCU calculated value of scheduler-enlistment delay is 100 jiffies. Oct 30 23:58:29.876431 kernel: rcu: Adjusting geometry for rcu_fanout_leaf=16, nr_cpu_ids=2 Oct 30 23:58:29.876442 kernel: NR_IRQS: 64, nr_irqs: 64, preallocated irqs: 0 Oct 30 23:58:29.876452 kernel: GICv3: 256 SPIs implemented Oct 30 23:58:29.876466 kernel: GICv3: 0 Extended SPIs implemented Oct 30 23:58:29.876477 kernel: Root IRQ handler: gic_handle_irq Oct 30 23:58:29.876487 kernel: GICv3: GICv3 features: 16 PPIs, DirectLPI Oct 30 23:58:29.876498 kernel: GICv3: CPU0: found redistributor 0 region 0:0x00000000080a0000 Oct 30 23:58:29.876508 kernel: ITS [mem 0x08080000-0x0809ffff] Oct 30 23:58:29.876519 kernel: ITS@0x0000000008080000: allocated 8192 Devices @1000c0000 (indirect, esz 8, psz 64K, shr 1) Oct 30 23:58:29.876530 kernel: ITS@0x0000000008080000: allocated 8192 Interrupt Collections @1000d0000 (flat, esz 8, psz 64K, shr 1) Oct 30 23:58:29.876542 kernel: GICv3: using LPI property table @0x00000001000e0000 Oct 30 23:58:29.876553 kernel: GICv3: CPU0: using allocated LPI pending table @0x00000001000f0000 Oct 30 23:58:29.876563 kernel: rcu: srcu_init: Setting srcu_struct sizes based on contention. Oct 30 23:58:29.876574 kernel: arch_timer: Enabling local workaround for ARM erratum 1418040 Oct 30 23:58:29.876584 kernel: arch_timer: cp15 timer(s) running at 25.00MHz (virt). Oct 30 23:58:29.876595 kernel: clocksource: arch_sys_counter: mask: 0xffffffffffffff max_cycles: 0x5c40939b5, max_idle_ns: 440795202646 ns Oct 30 23:58:29.876606 kernel: sched_clock: 56 bits at 25MHz, resolution 40ns, wraps every 4398046511100ns Oct 30 23:58:29.876616 kernel: Console: colour dummy device 80x25 Oct 30 23:58:29.876666 kernel: ACPI: Core revision 20230628 Oct 30 23:58:29.876682 kernel: Calibrating delay loop (skipped), value calculated using timer frequency.. 50.00 BogoMIPS (lpj=25000) Oct 30 23:58:29.876694 kernel: pid_max: default: 32768 minimum: 301 Oct 30 23:58:29.876709 kernel: LSM: initializing lsm=lockdown,capability,landlock,selinux,integrity Oct 30 23:58:29.876720 kernel: landlock: Up and running. Oct 30 23:58:29.876736 kernel: SELinux: Initializing. Oct 30 23:58:29.876747 kernel: Mount-cache hash table entries: 8192 (order: 4, 65536 bytes, linear) Oct 30 23:58:29.876758 kernel: Mountpoint-cache hash table entries: 8192 (order: 4, 65536 bytes, linear) Oct 30 23:58:29.876769 kernel: RCU Tasks: Setting shift to 1 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=2. Oct 30 23:58:29.876780 kernel: RCU Tasks Trace: Setting shift to 1 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=2. Oct 30 23:58:29.876791 kernel: rcu: Hierarchical SRCU implementation. Oct 30 23:58:29.876802 kernel: rcu: Max phase no-delay instances is 400. Oct 30 23:58:29.876816 kernel: Platform MSI: ITS@0x8080000 domain created Oct 30 23:58:29.876827 kernel: PCI/MSI: ITS@0x8080000 domain created Oct 30 23:58:29.876837 kernel: Remapping and enabling EFI services. Oct 30 23:58:29.876852 kernel: smp: Bringing up secondary CPUs ... Oct 30 23:58:29.876867 kernel: Detected PIPT I-cache on CPU1 Oct 30 23:58:29.876881 kernel: GICv3: CPU1: found redistributor 1 region 0:0x00000000080c0000 Oct 30 23:58:29.876893 kernel: GICv3: CPU1: using allocated LPI pending table @0x0000000100100000 Oct 30 23:58:29.876904 kernel: arch_timer: Enabling local workaround for ARM erratum 1418040 Oct 30 23:58:29.876918 kernel: CPU1: Booted secondary processor 0x0000000001 [0x413fd0c1] Oct 30 23:58:29.876931 kernel: smp: Brought up 1 node, 2 CPUs Oct 30 23:58:29.876943 kernel: SMP: Total of 2 processors activated. Oct 30 23:58:29.876960 kernel: CPU features: detected: 32-bit EL0 Support Oct 30 23:58:29.876973 kernel: CPU features: detected: Data cache clean to the PoU not required for I/D coherence Oct 30 23:58:29.876985 kernel: CPU features: detected: Common not Private translations Oct 30 23:58:29.876996 kernel: CPU features: detected: CRC32 instructions Oct 30 23:58:29.877008 kernel: CPU features: detected: Enhanced Virtualization Traps Oct 30 23:58:29.877019 kernel: CPU features: detected: RCpc load-acquire (LDAPR) Oct 30 23:58:29.877033 kernel: CPU features: detected: LSE atomic instructions Oct 30 23:58:29.877045 kernel: CPU features: detected: Privileged Access Never Oct 30 23:58:29.877056 kernel: CPU features: detected: RAS Extension Support Oct 30 23:58:29.877067 kernel: CPU features: detected: Speculative Store Bypassing Safe (SSBS) Oct 30 23:58:29.877079 kernel: CPU: All CPU(s) started at EL1 Oct 30 23:58:29.877090 kernel: alternatives: applying system-wide alternatives Oct 30 23:58:29.877108 kernel: devtmpfs: initialized Oct 30 23:58:29.877124 kernel: clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1911260446275000 ns Oct 30 23:58:29.877135 kernel: futex hash table entries: 512 (order: 3, 32768 bytes, linear) Oct 30 23:58:29.877149 kernel: pinctrl core: initialized pinctrl subsystem Oct 30 23:58:29.877160 kernel: SMBIOS 3.0.0 present. Oct 30 23:58:29.877172 kernel: DMI: Hetzner vServer/KVM Virtual Machine, BIOS 20171111 11/11/2017 Oct 30 23:58:29.877183 kernel: NET: Registered PF_NETLINK/PF_ROUTE protocol family Oct 30 23:58:29.877199 kernel: DMA: preallocated 512 KiB GFP_KERNEL pool for atomic allocations Oct 30 23:58:29.877210 kernel: DMA: preallocated 512 KiB GFP_KERNEL|GFP_DMA pool for atomic allocations Oct 30 23:58:29.877222 kernel: DMA: preallocated 512 KiB GFP_KERNEL|GFP_DMA32 pool for atomic allocations Oct 30 23:58:29.877234 kernel: audit: initializing netlink subsys (disabled) Oct 30 23:58:29.877245 kernel: audit: type=2000 audit(0.011:1): state=initialized audit_enabled=0 res=1 Oct 30 23:58:29.877259 kernel: thermal_sys: Registered thermal governor 'step_wise' Oct 30 23:58:29.877270 kernel: cpuidle: using governor menu Oct 30 23:58:29.877324 kernel: hw-breakpoint: found 6 breakpoint and 4 watchpoint registers. Oct 30 23:58:29.877337 kernel: ASID allocator initialised with 32768 entries Oct 30 23:58:29.877349 kernel: acpiphp: ACPI Hot Plug PCI Controller Driver version: 0.5 Oct 30 23:58:29.877360 kernel: Serial: AMBA PL011 UART driver Oct 30 23:58:29.877372 kernel: Modules: 2G module region forced by RANDOMIZE_MODULE_REGION_FULL Oct 30 23:58:29.877383 kernel: Modules: 0 pages in range for non-PLT usage Oct 30 23:58:29.877394 kernel: Modules: 509248 pages in range for PLT usage Oct 30 23:58:29.877410 kernel: HugeTLB: registered 1.00 GiB page size, pre-allocated 0 pages Oct 30 23:58:29.877422 kernel: HugeTLB: 0 KiB vmemmap can be freed for a 1.00 GiB page Oct 30 23:58:29.877433 kernel: HugeTLB: registered 32.0 MiB page size, pre-allocated 0 pages Oct 30 23:58:29.877445 kernel: HugeTLB: 0 KiB vmemmap can be freed for a 32.0 MiB page Oct 30 23:58:29.877456 kernel: HugeTLB: registered 2.00 MiB page size, pre-allocated 0 pages Oct 30 23:58:29.877468 kernel: HugeTLB: 0 KiB vmemmap can be freed for a 2.00 MiB page Oct 30 23:58:29.877480 kernel: HugeTLB: registered 64.0 KiB page size, pre-allocated 0 pages Oct 30 23:58:29.877491 kernel: HugeTLB: 0 KiB vmemmap can be freed for a 64.0 KiB page Oct 30 23:58:29.877503 kernel: ACPI: Added _OSI(Module Device) Oct 30 23:58:29.877518 kernel: ACPI: Added _OSI(Processor Device) Oct 30 23:58:29.877530 kernel: ACPI: Added _OSI(Processor Aggregator Device) Oct 30 23:58:29.877541 kernel: ACPI: 1 ACPI AML tables successfully acquired and loaded Oct 30 23:58:29.877557 kernel: ACPI: Interpreter enabled Oct 30 23:58:29.877569 kernel: ACPI: Using GIC for interrupt routing Oct 30 23:58:29.877580 kernel: ACPI: MCFG table detected, 1 entries Oct 30 23:58:29.877592 kernel: ARMH0011:00: ttyAMA0 at MMIO 0x9000000 (irq = 12, base_baud = 0) is a SBSA Oct 30 23:58:29.877609 kernel: printk: console [ttyAMA0] enabled Oct 30 23:58:29.877621 kernel: ACPI: PCI Root Bridge [PCI0] (domain 0000 [bus 00-ff]) Oct 30 23:58:29.877900 kernel: acpi PNP0A08:00: _OSC: OS supports [ExtendedConfig ASPM ClockPM Segments MSI HPX-Type3] Oct 30 23:58:29.878027 kernel: acpi PNP0A08:00: _OSC: platform does not support [LTR] Oct 30 23:58:29.878132 kernel: acpi PNP0A08:00: _OSC: OS now controls [PCIeHotplug PME AER PCIeCapability] Oct 30 23:58:29.878232 kernel: acpi PNP0A08:00: ECAM area [mem 0x4010000000-0x401fffffff] reserved by PNP0C02:00 Oct 30 23:58:29.878370 kernel: acpi PNP0A08:00: ECAM at [mem 0x4010000000-0x401fffffff] for [bus 00-ff] Oct 30 23:58:29.878389 kernel: ACPI: Remapped I/O 0x000000003eff0000 to [io 0x0000-0xffff window] Oct 30 23:58:29.878401 kernel: PCI host bridge to bus 0000:00 Oct 30 23:58:29.878519 kernel: pci_bus 0000:00: root bus resource [mem 0x10000000-0x3efeffff window] Oct 30 23:58:29.878613 kernel: pci_bus 0000:00: root bus resource [io 0x0000-0xffff window] Oct 30 23:58:29.878705 kernel: pci_bus 0000:00: root bus resource [mem 0x8000000000-0xffffffffff window] Oct 30 23:58:29.878795 kernel: pci_bus 0000:00: root bus resource [bus 00-ff] Oct 30 23:58:29.878915 kernel: pci 0000:00:00.0: [1b36:0008] type 00 class 0x060000 Oct 30 23:58:29.879109 kernel: pci 0000:00:01.0: [1af4:1050] type 00 class 0x038000 Oct 30 23:58:29.879226 kernel: pci 0000:00:01.0: reg 0x14: [mem 0x11289000-0x11289fff] Oct 30 23:58:29.879364 kernel: pci 0000:00:01.0: reg 0x20: [mem 0x8000600000-0x8000603fff 64bit pref] Oct 30 23:58:29.879499 kernel: pci 0000:00:02.0: [1b36:000c] type 01 class 0x060400 Oct 30 23:58:29.881484 kernel: pci 0000:00:02.0: reg 0x10: [mem 0x11288000-0x11288fff] Oct 30 23:58:29.881649 kernel: pci 0000:00:02.1: [1b36:000c] type 01 class 0x060400 Oct 30 23:58:29.881769 kernel: pci 0000:00:02.1: reg 0x10: [mem 0x11287000-0x11287fff] Oct 30 23:58:29.881904 kernel: pci 0000:00:02.2: [1b36:000c] type 01 class 0x060400 Oct 30 23:58:29.882017 kernel: pci 0000:00:02.2: reg 0x10: [mem 0x11286000-0x11286fff] Oct 30 23:58:29.882133 kernel: pci 0000:00:02.3: [1b36:000c] type 01 class 0x060400 Oct 30 23:58:29.882237 kernel: pci 0000:00:02.3: reg 0x10: [mem 0x11285000-0x11285fff] Oct 30 23:58:29.882389 kernel: pci 0000:00:02.4: [1b36:000c] type 01 class 0x060400 Oct 30 23:58:29.882500 kernel: pci 0000:00:02.4: reg 0x10: [mem 0x11284000-0x11284fff] Oct 30 23:58:29.882619 kernel: pci 0000:00:02.5: [1b36:000c] type 01 class 0x060400 Oct 30 23:58:29.882737 kernel: pci 0000:00:02.5: reg 0x10: [mem 0x11283000-0x11283fff] Oct 30 23:58:29.882857 kernel: pci 0000:00:02.6: [1b36:000c] type 01 class 0x060400 Oct 30 23:58:29.882963 kernel: pci 0000:00:02.6: reg 0x10: [mem 0x11282000-0x11282fff] Oct 30 23:58:29.883075 kernel: pci 0000:00:02.7: [1b36:000c] type 01 class 0x060400 Oct 30 23:58:29.883180 kernel: pci 0000:00:02.7: reg 0x10: [mem 0x11281000-0x11281fff] Oct 30 23:58:29.885468 kernel: pci 0000:00:03.0: [1b36:000c] type 01 class 0x060400 Oct 30 23:58:29.885651 kernel: pci 0000:00:03.0: reg 0x10: [mem 0x11280000-0x11280fff] Oct 30 23:58:29.885827 kernel: pci 0000:00:04.0: [1b36:0002] type 00 class 0x070002 Oct 30 23:58:29.885941 kernel: pci 0000:00:04.0: reg 0x10: [io 0x0000-0x0007] Oct 30 23:58:29.886071 kernel: pci 0000:01:00.0: [1af4:1041] type 00 class 0x020000 Oct 30 23:58:29.886202 kernel: pci 0000:01:00.0: reg 0x14: [mem 0x11000000-0x11000fff] Oct 30 23:58:29.887404 kernel: pci 0000:01:00.0: reg 0x20: [mem 0x8000000000-0x8000003fff 64bit pref] Oct 30 23:58:29.887557 kernel: pci 0000:01:00.0: reg 0x30: [mem 0xfff80000-0xffffffff pref] Oct 30 23:58:29.887680 kernel: pci 0000:02:00.0: [1b36:000d] type 00 class 0x0c0330 Oct 30 23:58:29.887787 kernel: pci 0000:02:00.0: reg 0x10: [mem 0x10e00000-0x10e03fff 64bit] Oct 30 23:58:29.887912 kernel: pci 0000:03:00.0: [1af4:1043] type 00 class 0x078000 Oct 30 23:58:29.888028 kernel: pci 0000:03:00.0: reg 0x14: [mem 0x10c00000-0x10c00fff] Oct 30 23:58:29.888136 kernel: pci 0000:03:00.0: reg 0x20: [mem 0x8000100000-0x8000103fff 64bit pref] Oct 30 23:58:29.888269 kernel: pci 0000:04:00.0: [1af4:1045] type 00 class 0x00ff00 Oct 30 23:58:29.890533 kernel: pci 0000:04:00.0: reg 0x20: [mem 0x8000200000-0x8000203fff 64bit pref] Oct 30 23:58:29.890661 kernel: pci 0000:05:00.0: [1af4:1044] type 00 class 0x00ff00 Oct 30 23:58:29.890770 kernel: pci 0000:05:00.0: reg 0x14: [mem 0x10800000-0x10800fff] Oct 30 23:58:29.890890 kernel: pci 0000:05:00.0: reg 0x20: [mem 0x8000300000-0x8000303fff 64bit pref] Oct 30 23:58:29.891026 kernel: pci 0000:06:00.0: [1af4:1048] type 00 class 0x010000 Oct 30 23:58:29.891134 kernel: pci 0000:06:00.0: reg 0x14: [mem 0x10600000-0x10600fff] Oct 30 23:58:29.891259 kernel: pci 0000:06:00.0: reg 0x20: [mem 0x8000400000-0x8000403fff 64bit pref] Oct 30 23:58:29.891491 kernel: pci 0000:07:00.0: [1af4:1041] type 00 class 0x020000 Oct 30 23:58:29.891638 kernel: pci 0000:07:00.0: reg 0x14: [mem 0x10400000-0x10400fff] Oct 30 23:58:29.891748 kernel: pci 0000:07:00.0: reg 0x20: [mem 0x8000500000-0x8000503fff 64bit pref] Oct 30 23:58:29.891853 kernel: pci 0000:07:00.0: reg 0x30: [mem 0xfff80000-0xffffffff pref] Oct 30 23:58:29.891971 kernel: pci 0000:00:02.0: bridge window [io 0x1000-0x0fff] to [bus 01] add_size 1000 Oct 30 23:58:29.892087 kernel: pci 0000:00:02.0: bridge window [mem 0x00100000-0x001fffff 64bit pref] to [bus 01] add_size 100000 add_align 100000 Oct 30 23:58:29.892190 kernel: pci 0000:00:02.0: bridge window [mem 0x00100000-0x001fffff] to [bus 01] add_size 100000 add_align 100000 Oct 30 23:58:29.893373 kernel: pci 0000:00:02.1: bridge window [io 0x1000-0x0fff] to [bus 02] add_size 1000 Oct 30 23:58:29.893507 kernel: pci 0000:00:02.1: bridge window [mem 0x00100000-0x000fffff 64bit pref] to [bus 02] add_size 200000 add_align 100000 Oct 30 23:58:29.893628 kernel: pci 0000:00:02.1: bridge window [mem 0x00100000-0x001fffff] to [bus 02] add_size 100000 add_align 100000 Oct 30 23:58:29.893740 kernel: pci 0000:00:02.2: bridge window [io 0x1000-0x0fff] to [bus 03] add_size 1000 Oct 30 23:58:29.893845 kernel: pci 0000:00:02.2: bridge window [mem 0x00100000-0x001fffff 64bit pref] to [bus 03] add_size 100000 add_align 100000 Oct 30 23:58:29.893946 kernel: pci 0000:00:02.2: bridge window [mem 0x00100000-0x001fffff] to [bus 03] add_size 100000 add_align 100000 Oct 30 23:58:29.894063 kernel: pci 0000:00:02.3: bridge window [io 0x1000-0x0fff] to [bus 04] add_size 1000 Oct 30 23:58:29.894182 kernel: pci 0000:00:02.3: bridge window [mem 0x00100000-0x001fffff 64bit pref] to [bus 04] add_size 100000 add_align 100000 Oct 30 23:58:29.894405 kernel: pci 0000:00:02.3: bridge window [mem 0x00100000-0x000fffff] to [bus 04] add_size 200000 add_align 100000 Oct 30 23:58:29.894746 kernel: pci 0000:00:02.4: bridge window [io 0x1000-0x0fff] to [bus 05] add_size 1000 Oct 30 23:58:29.894994 kernel: pci 0000:00:02.4: bridge window [mem 0x00100000-0x001fffff 64bit pref] to [bus 05] add_size 100000 add_align 100000 Oct 30 23:58:29.895189 kernel: pci 0000:00:02.4: bridge window [mem 0x00100000-0x001fffff] to [bus 05] add_size 100000 add_align 100000 Oct 30 23:58:29.897564 kernel: pci 0000:00:02.5: bridge window [io 0x1000-0x0fff] to [bus 06] add_size 1000 Oct 30 23:58:29.897786 kernel: pci 0000:00:02.5: bridge window [mem 0x00100000-0x001fffff 64bit pref] to [bus 06] add_size 100000 add_align 100000 Oct 30 23:58:29.897971 kernel: pci 0000:00:02.5: bridge window [mem 0x00100000-0x001fffff] to [bus 06] add_size 100000 add_align 100000 Oct 30 23:58:29.898400 kernel: pci 0000:00:02.6: bridge window [io 0x1000-0x0fff] to [bus 07] add_size 1000 Oct 30 23:58:29.898558 kernel: pci 0000:00:02.6: bridge window [mem 0x00100000-0x001fffff 64bit pref] to [bus 07] add_size 100000 add_align 100000 Oct 30 23:58:29.898639 kernel: pci 0000:00:02.6: bridge window [mem 0x00100000-0x001fffff] to [bus 07] add_size 100000 add_align 100000 Oct 30 23:58:29.898718 kernel: pci 0000:00:02.7: bridge window [io 0x1000-0x0fff] to [bus 08] add_size 1000 Oct 30 23:58:29.898790 kernel: pci 0000:00:02.7: bridge window [mem 0x00100000-0x000fffff 64bit pref] to [bus 08] add_size 200000 add_align 100000 Oct 30 23:58:29.898866 kernel: pci 0000:00:02.7: bridge window [mem 0x00100000-0x000fffff] to [bus 08] add_size 200000 add_align 100000 Oct 30 23:58:29.898940 kernel: pci 0000:00:03.0: bridge window [io 0x1000-0x0fff] to [bus 09] add_size 1000 Oct 30 23:58:29.899012 kernel: pci 0000:00:03.0: bridge window [mem 0x00100000-0x000fffff 64bit pref] to [bus 09] add_size 200000 add_align 100000 Oct 30 23:58:29.899083 kernel: pci 0000:00:03.0: bridge window [mem 0x00100000-0x000fffff] to [bus 09] add_size 200000 add_align 100000 Oct 30 23:58:29.899159 kernel: pci 0000:00:02.0: BAR 14: assigned [mem 0x10000000-0x101fffff] Oct 30 23:58:29.899231 kernel: pci 0000:00:02.0: BAR 15: assigned [mem 0x8000000000-0x80001fffff 64bit pref] Oct 30 23:58:29.899760 kernel: pci 0000:00:02.1: BAR 14: assigned [mem 0x10200000-0x103fffff] Oct 30 23:58:29.899859 kernel: pci 0000:00:02.1: BAR 15: assigned [mem 0x8000200000-0x80003fffff 64bit pref] Oct 30 23:58:29.899940 kernel: pci 0000:00:02.2: BAR 14: assigned [mem 0x10400000-0x105fffff] Oct 30 23:58:29.900010 kernel: pci 0000:00:02.2: BAR 15: assigned [mem 0x8000400000-0x80005fffff 64bit pref] Oct 30 23:58:29.900093 kernel: pci 0000:00:02.3: BAR 14: assigned [mem 0x10600000-0x107fffff] Oct 30 23:58:29.900172 kernel: pci 0000:00:02.3: BAR 15: assigned [mem 0x8000600000-0x80007fffff 64bit pref] Oct 30 23:58:29.900246 kernel: pci 0000:00:02.4: BAR 14: assigned [mem 0x10800000-0x109fffff] Oct 30 23:58:29.900349 kernel: pci 0000:00:02.4: BAR 15: assigned [mem 0x8000800000-0x80009fffff 64bit pref] Oct 30 23:58:29.900443 kernel: pci 0000:00:02.5: BAR 14: assigned [mem 0x10a00000-0x10bfffff] Oct 30 23:58:29.900516 kernel: pci 0000:00:02.5: BAR 15: assigned [mem 0x8000a00000-0x8000bfffff 64bit pref] Oct 30 23:58:29.900591 kernel: pci 0000:00:02.6: BAR 14: assigned [mem 0x10c00000-0x10dfffff] Oct 30 23:58:29.900660 kernel: pci 0000:00:02.6: BAR 15: assigned [mem 0x8000c00000-0x8000dfffff 64bit pref] Oct 30 23:58:29.900731 kernel: pci 0000:00:02.7: BAR 14: assigned [mem 0x10e00000-0x10ffffff] Oct 30 23:58:29.900800 kernel: pci 0000:00:02.7: BAR 15: assigned [mem 0x8000e00000-0x8000ffffff 64bit pref] Oct 30 23:58:29.900870 kernel: pci 0000:00:03.0: BAR 14: assigned [mem 0x11000000-0x111fffff] Oct 30 23:58:29.900943 kernel: pci 0000:00:03.0: BAR 15: assigned [mem 0x8001000000-0x80011fffff 64bit pref] Oct 30 23:58:29.901017 kernel: pci 0000:00:01.0: BAR 4: assigned [mem 0x8001200000-0x8001203fff 64bit pref] Oct 30 23:58:29.901100 kernel: pci 0000:00:01.0: BAR 1: assigned [mem 0x11200000-0x11200fff] Oct 30 23:58:29.901173 kernel: pci 0000:00:02.0: BAR 0: assigned [mem 0x11201000-0x11201fff] Oct 30 23:58:29.901241 kernel: pci 0000:00:02.0: BAR 13: assigned [io 0x1000-0x1fff] Oct 30 23:58:29.902101 kernel: pci 0000:00:02.1: BAR 0: assigned [mem 0x11202000-0x11202fff] Oct 30 23:58:29.902206 kernel: pci 0000:00:02.1: BAR 13: assigned [io 0x2000-0x2fff] Oct 30 23:58:29.902333 kernel: pci 0000:00:02.2: BAR 0: assigned [mem 0x11203000-0x11203fff] Oct 30 23:58:29.902432 kernel: pci 0000:00:02.2: BAR 13: assigned [io 0x3000-0x3fff] Oct 30 23:58:29.902505 kernel: pci 0000:00:02.3: BAR 0: assigned [mem 0x11204000-0x11204fff] Oct 30 23:58:29.902599 kernel: pci 0000:00:02.3: BAR 13: assigned [io 0x4000-0x4fff] Oct 30 23:58:29.902688 kernel: pci 0000:00:02.4: BAR 0: assigned [mem 0x11205000-0x11205fff] Oct 30 23:58:29.902765 kernel: pci 0000:00:02.4: BAR 13: assigned [io 0x5000-0x5fff] Oct 30 23:58:29.902838 kernel: pci 0000:00:02.5: BAR 0: assigned [mem 0x11206000-0x11206fff] Oct 30 23:58:29.902916 kernel: pci 0000:00:02.5: BAR 13: assigned [io 0x6000-0x6fff] Oct 30 23:58:29.902998 kernel: pci 0000:00:02.6: BAR 0: assigned [mem 0x11207000-0x11207fff] Oct 30 23:58:29.903079 kernel: pci 0000:00:02.6: BAR 13: assigned [io 0x7000-0x7fff] Oct 30 23:58:29.903151 kernel: pci 0000:00:02.7: BAR 0: assigned [mem 0x11208000-0x11208fff] Oct 30 23:58:29.903221 kernel: pci 0000:00:02.7: BAR 13: assigned [io 0x8000-0x8fff] Oct 30 23:58:29.903382 kernel: pci 0000:00:03.0: BAR 0: assigned [mem 0x11209000-0x11209fff] Oct 30 23:58:29.903456 kernel: pci 0000:00:03.0: BAR 13: assigned [io 0x9000-0x9fff] Oct 30 23:58:29.903537 kernel: pci 0000:00:04.0: BAR 0: assigned [io 0xa000-0xa007] Oct 30 23:58:29.903618 kernel: pci 0000:01:00.0: BAR 6: assigned [mem 0x10000000-0x1007ffff pref] Oct 30 23:58:29.903690 kernel: pci 0000:01:00.0: BAR 4: assigned [mem 0x8000000000-0x8000003fff 64bit pref] Oct 30 23:58:29.903776 kernel: pci 0000:01:00.0: BAR 1: assigned [mem 0x10080000-0x10080fff] Oct 30 23:58:29.903855 kernel: pci 0000:00:02.0: PCI bridge to [bus 01] Oct 30 23:58:29.903924 kernel: pci 0000:00:02.0: bridge window [io 0x1000-0x1fff] Oct 30 23:58:29.903991 kernel: pci 0000:00:02.0: bridge window [mem 0x10000000-0x101fffff] Oct 30 23:58:29.904059 kernel: pci 0000:00:02.0: bridge window [mem 0x8000000000-0x80001fffff 64bit pref] Oct 30 23:58:29.904134 kernel: pci 0000:02:00.0: BAR 0: assigned [mem 0x10200000-0x10203fff 64bit] Oct 30 23:58:29.904216 kernel: pci 0000:00:02.1: PCI bridge to [bus 02] Oct 30 23:58:29.904442 kernel: pci 0000:00:02.1: bridge window [io 0x2000-0x2fff] Oct 30 23:58:29.904542 kernel: pci 0000:00:02.1: bridge window [mem 0x10200000-0x103fffff] Oct 30 23:58:29.904620 kernel: pci 0000:00:02.1: bridge window [mem 0x8000200000-0x80003fffff 64bit pref] Oct 30 23:58:29.904702 kernel: pci 0000:03:00.0: BAR 4: assigned [mem 0x8000400000-0x8000403fff 64bit pref] Oct 30 23:58:29.904772 kernel: pci 0000:03:00.0: BAR 1: assigned [mem 0x10400000-0x10400fff] Oct 30 23:58:29.904848 kernel: pci 0000:00:02.2: PCI bridge to [bus 03] Oct 30 23:58:29.904929 kernel: pci 0000:00:02.2: bridge window [io 0x3000-0x3fff] Oct 30 23:58:29.905007 kernel: pci 0000:00:02.2: bridge window [mem 0x10400000-0x105fffff] Oct 30 23:58:29.905076 kernel: pci 0000:00:02.2: bridge window [mem 0x8000400000-0x80005fffff 64bit pref] Oct 30 23:58:29.905165 kernel: pci 0000:04:00.0: BAR 4: assigned [mem 0x8000600000-0x8000603fff 64bit pref] Oct 30 23:58:29.905245 kernel: pci 0000:00:02.3: PCI bridge to [bus 04] Oct 30 23:58:29.905374 kernel: pci 0000:00:02.3: bridge window [io 0x4000-0x4fff] Oct 30 23:58:29.905449 kernel: pci 0000:00:02.3: bridge window [mem 0x10600000-0x107fffff] Oct 30 23:58:29.905550 kernel: pci 0000:00:02.3: bridge window [mem 0x8000600000-0x80007fffff 64bit pref] Oct 30 23:58:29.905631 kernel: pci 0000:05:00.0: BAR 4: assigned [mem 0x8000800000-0x8000803fff 64bit pref] Oct 30 23:58:29.905711 kernel: pci 0000:05:00.0: BAR 1: assigned [mem 0x10800000-0x10800fff] Oct 30 23:58:29.905781 kernel: pci 0000:00:02.4: PCI bridge to [bus 05] Oct 30 23:58:29.905849 kernel: pci 0000:00:02.4: bridge window [io 0x5000-0x5fff] Oct 30 23:58:29.905929 kernel: pci 0000:00:02.4: bridge window [mem 0x10800000-0x109fffff] Oct 30 23:58:29.905997 kernel: pci 0000:00:02.4: bridge window [mem 0x8000800000-0x80009fffff 64bit pref] Oct 30 23:58:29.906073 kernel: pci 0000:06:00.0: BAR 4: assigned [mem 0x8000a00000-0x8000a03fff 64bit pref] Oct 30 23:58:29.906157 kernel: pci 0000:06:00.0: BAR 1: assigned [mem 0x10a00000-0x10a00fff] Oct 30 23:58:29.906233 kernel: pci 0000:00:02.5: PCI bridge to [bus 06] Oct 30 23:58:29.906381 kernel: pci 0000:00:02.5: bridge window [io 0x6000-0x6fff] Oct 30 23:58:29.906456 kernel: pci 0000:00:02.5: bridge window [mem 0x10a00000-0x10bfffff] Oct 30 23:58:29.906538 kernel: pci 0000:00:02.5: bridge window [mem 0x8000a00000-0x8000bfffff 64bit pref] Oct 30 23:58:29.906617 kernel: pci 0000:07:00.0: BAR 6: assigned [mem 0x10c00000-0x10c7ffff pref] Oct 30 23:58:29.906704 kernel: pci 0000:07:00.0: BAR 4: assigned [mem 0x8000c00000-0x8000c03fff 64bit pref] Oct 30 23:58:29.906790 kernel: pci 0000:07:00.0: BAR 1: assigned [mem 0x10c80000-0x10c80fff] Oct 30 23:58:29.906869 kernel: pci 0000:00:02.6: PCI bridge to [bus 07] Oct 30 23:58:29.906938 kernel: pci 0000:00:02.6: bridge window [io 0x7000-0x7fff] Oct 30 23:58:29.907050 kernel: pci 0000:00:02.6: bridge window [mem 0x10c00000-0x10dfffff] Oct 30 23:58:29.907126 kernel: pci 0000:00:02.6: bridge window [mem 0x8000c00000-0x8000dfffff 64bit pref] Oct 30 23:58:29.907197 kernel: pci 0000:00:02.7: PCI bridge to [bus 08] Oct 30 23:58:29.907263 kernel: pci 0000:00:02.7: bridge window [io 0x8000-0x8fff] Oct 30 23:58:29.907434 kernel: pci 0000:00:02.7: bridge window [mem 0x10e00000-0x10ffffff] Oct 30 23:58:29.907523 kernel: pci 0000:00:02.7: bridge window [mem 0x8000e00000-0x8000ffffff 64bit pref] Oct 30 23:58:29.907621 kernel: pci 0000:00:03.0: PCI bridge to [bus 09] Oct 30 23:58:29.907691 kernel: pci 0000:00:03.0: bridge window [io 0x9000-0x9fff] Oct 30 23:58:29.907758 kernel: pci 0000:00:03.0: bridge window [mem 0x11000000-0x111fffff] Oct 30 23:58:29.907837 kernel: pci 0000:00:03.0: bridge window [mem 0x8001000000-0x80011fffff 64bit pref] Oct 30 23:58:29.907915 kernel: pci_bus 0000:00: resource 4 [mem 0x10000000-0x3efeffff window] Oct 30 23:58:29.907983 kernel: pci_bus 0000:00: resource 5 [io 0x0000-0xffff window] Oct 30 23:58:29.908049 kernel: pci_bus 0000:00: resource 6 [mem 0x8000000000-0xffffffffff window] Oct 30 23:58:29.908135 kernel: pci_bus 0000:01: resource 0 [io 0x1000-0x1fff] Oct 30 23:58:29.908198 kernel: pci_bus 0000:01: resource 1 [mem 0x10000000-0x101fffff] Oct 30 23:58:29.908260 kernel: pci_bus 0000:01: resource 2 [mem 0x8000000000-0x80001fffff 64bit pref] Oct 30 23:58:29.908390 kernel: pci_bus 0000:02: resource 0 [io 0x2000-0x2fff] Oct 30 23:58:29.908457 kernel: pci_bus 0000:02: resource 1 [mem 0x10200000-0x103fffff] Oct 30 23:58:29.908531 kernel: pci_bus 0000:02: resource 2 [mem 0x8000200000-0x80003fffff 64bit pref] Oct 30 23:58:29.908611 kernel: pci_bus 0000:03: resource 0 [io 0x3000-0x3fff] Oct 30 23:58:29.908683 kernel: pci_bus 0000:03: resource 1 [mem 0x10400000-0x105fffff] Oct 30 23:58:29.908755 kernel: pci_bus 0000:03: resource 2 [mem 0x8000400000-0x80005fffff 64bit pref] Oct 30 23:58:29.908826 kernel: pci_bus 0000:04: resource 0 [io 0x4000-0x4fff] Oct 30 23:58:29.908895 kernel: pci_bus 0000:04: resource 1 [mem 0x10600000-0x107fffff] Oct 30 23:58:29.908958 kernel: pci_bus 0000:04: resource 2 [mem 0x8000600000-0x80007fffff 64bit pref] Oct 30 23:58:29.909027 kernel: pci_bus 0000:05: resource 0 [io 0x5000-0x5fff] Oct 30 23:58:29.909102 kernel: pci_bus 0000:05: resource 1 [mem 0x10800000-0x109fffff] Oct 30 23:58:29.909171 kernel: pci_bus 0000:05: resource 2 [mem 0x8000800000-0x80009fffff 64bit pref] Oct 30 23:58:29.909245 kernel: pci_bus 0000:06: resource 0 [io 0x6000-0x6fff] Oct 30 23:58:29.909343 kernel: pci_bus 0000:06: resource 1 [mem 0x10a00000-0x10bfffff] Oct 30 23:58:29.909415 kernel: pci_bus 0000:06: resource 2 [mem 0x8000a00000-0x8000bfffff 64bit pref] Oct 30 23:58:29.909500 kernel: pci_bus 0000:07: resource 0 [io 0x7000-0x7fff] Oct 30 23:58:29.909567 kernel: pci_bus 0000:07: resource 1 [mem 0x10c00000-0x10dfffff] Oct 30 23:58:29.909630 kernel: pci_bus 0000:07: resource 2 [mem 0x8000c00000-0x8000dfffff 64bit pref] Oct 30 23:58:29.909701 kernel: pci_bus 0000:08: resource 0 [io 0x8000-0x8fff] Oct 30 23:58:29.909777 kernel: pci_bus 0000:08: resource 1 [mem 0x10e00000-0x10ffffff] Oct 30 23:58:29.909840 kernel: pci_bus 0000:08: resource 2 [mem 0x8000e00000-0x8000ffffff 64bit pref] Oct 30 23:58:29.909915 kernel: pci_bus 0000:09: resource 0 [io 0x9000-0x9fff] Oct 30 23:58:29.909978 kernel: pci_bus 0000:09: resource 1 [mem 0x11000000-0x111fffff] Oct 30 23:58:29.910040 kernel: pci_bus 0000:09: resource 2 [mem 0x8001000000-0x80011fffff 64bit pref] Oct 30 23:58:29.910050 kernel: ACPI: PCI: Interrupt link GSI0 configured for IRQ 35 Oct 30 23:58:29.910058 kernel: ACPI: PCI: Interrupt link GSI1 configured for IRQ 36 Oct 30 23:58:29.910067 kernel: ACPI: PCI: Interrupt link GSI2 configured for IRQ 37 Oct 30 23:58:29.910075 kernel: ACPI: PCI: Interrupt link GSI3 configured for IRQ 38 Oct 30 23:58:29.910083 kernel: iommu: Default domain type: Translated Oct 30 23:58:29.910093 kernel: iommu: DMA domain TLB invalidation policy: strict mode Oct 30 23:58:29.910101 kernel: efivars: Registered efivars operations Oct 30 23:58:29.910109 kernel: vgaarb: loaded Oct 30 23:58:29.910117 kernel: clocksource: Switched to clocksource arch_sys_counter Oct 30 23:58:29.910125 kernel: VFS: Disk quotas dquot_6.6.0 Oct 30 23:58:29.910134 kernel: VFS: Dquot-cache hash table entries: 512 (order 0, 4096 bytes) Oct 30 23:58:29.910141 kernel: pnp: PnP ACPI init Oct 30 23:58:29.910230 kernel: system 00:00: [mem 0x4010000000-0x401fffffff window] could not be reserved Oct 30 23:58:29.910243 kernel: pnp: PnP ACPI: found 1 devices Oct 30 23:58:29.910254 kernel: NET: Registered PF_INET protocol family Oct 30 23:58:29.910263 kernel: IP idents hash table entries: 65536 (order: 7, 524288 bytes, linear) Oct 30 23:58:29.910271 kernel: tcp_listen_portaddr_hash hash table entries: 2048 (order: 3, 32768 bytes, linear) Oct 30 23:58:29.912335 kernel: Table-perturb hash table entries: 65536 (order: 6, 262144 bytes, linear) Oct 30 23:58:29.912365 kernel: TCP established hash table entries: 32768 (order: 6, 262144 bytes, linear) Oct 30 23:58:29.912374 kernel: TCP bind hash table entries: 32768 (order: 8, 1048576 bytes, linear) Oct 30 23:58:29.912383 kernel: TCP: Hash tables configured (established 32768 bind 32768) Oct 30 23:58:29.912391 kernel: UDP hash table entries: 2048 (order: 4, 65536 bytes, linear) Oct 30 23:58:29.912407 kernel: UDP-Lite hash table entries: 2048 (order: 4, 65536 bytes, linear) Oct 30 23:58:29.912416 kernel: NET: Registered PF_UNIX/PF_LOCAL protocol family Oct 30 23:58:29.912573 kernel: pci 0000:02:00.0: enabling device (0000 -> 0002) Oct 30 23:58:29.912587 kernel: PCI: CLS 0 bytes, default 64 Oct 30 23:58:29.912595 kernel: kvm [1]: HYP mode not available Oct 30 23:58:29.912603 kernel: Initialise system trusted keyrings Oct 30 23:58:29.912612 kernel: workingset: timestamp_bits=39 max_order=20 bucket_order=0 Oct 30 23:58:29.912620 kernel: Key type asymmetric registered Oct 30 23:58:29.912628 kernel: Asymmetric key parser 'x509' registered Oct 30 23:58:29.912640 kernel: Block layer SCSI generic (bsg) driver version 0.4 loaded (major 250) Oct 30 23:58:29.912648 kernel: io scheduler mq-deadline registered Oct 30 23:58:29.912656 kernel: io scheduler kyber registered Oct 30 23:58:29.912664 kernel: io scheduler bfq registered Oct 30 23:58:29.912673 kernel: ACPI: \_SB_.PCI0.GSI2: Enabled at IRQ 37 Oct 30 23:58:29.912749 kernel: pcieport 0000:00:02.0: PME: Signaling with IRQ 50 Oct 30 23:58:29.912819 kernel: pcieport 0000:00:02.0: AER: enabled with IRQ 50 Oct 30 23:58:29.912887 kernel: pcieport 0000:00:02.0: pciehp: Slot #0 AttnBtn+ PwrCtrl+ MRL- AttnInd+ PwrInd+ HotPlug+ Surprise+ Interlock+ NoCompl- IbPresDis- LLActRep+ Oct 30 23:58:29.912963 kernel: pcieport 0000:00:02.1: PME: Signaling with IRQ 51 Oct 30 23:58:29.913032 kernel: pcieport 0000:00:02.1: AER: enabled with IRQ 51 Oct 30 23:58:29.913137 kernel: pcieport 0000:00:02.1: pciehp: Slot #0 AttnBtn+ PwrCtrl+ MRL- AttnInd+ PwrInd+ HotPlug+ Surprise+ Interlock+ NoCompl- IbPresDis- LLActRep+ Oct 30 23:58:29.913213 kernel: pcieport 0000:00:02.2: PME: Signaling with IRQ 52 Oct 30 23:58:29.915721 kernel: pcieport 0000:00:02.2: AER: enabled with IRQ 52 Oct 30 23:58:29.915865 kernel: pcieport 0000:00:02.2: pciehp: Slot #0 AttnBtn+ PwrCtrl+ MRL- AttnInd+ PwrInd+ HotPlug+ Surprise+ Interlock+ NoCompl- IbPresDis- LLActRep+ Oct 30 23:58:29.916025 kernel: pcieport 0000:00:02.3: PME: Signaling with IRQ 53 Oct 30 23:58:29.916141 kernel: pcieport 0000:00:02.3: AER: enabled with IRQ 53 Oct 30 23:58:29.916220 kernel: pcieport 0000:00:02.3: pciehp: Slot #0 AttnBtn+ PwrCtrl+ MRL- AttnInd+ PwrInd+ HotPlug+ Surprise+ Interlock+ NoCompl- IbPresDis- LLActRep+ Oct 30 23:58:29.916340 kernel: pcieport 0000:00:02.4: PME: Signaling with IRQ 54 Oct 30 23:58:29.916418 kernel: pcieport 0000:00:02.4: AER: enabled with IRQ 54 Oct 30 23:58:29.916500 kernel: pcieport 0000:00:02.4: pciehp: Slot #0 AttnBtn+ PwrCtrl+ MRL- AttnInd+ PwrInd+ HotPlug+ Surprise+ Interlock+ NoCompl- IbPresDis- LLActRep+ Oct 30 23:58:29.916590 kernel: pcieport 0000:00:02.5: PME: Signaling with IRQ 55 Oct 30 23:58:29.916670 kernel: pcieport 0000:00:02.5: AER: enabled with IRQ 55 Oct 30 23:58:29.916740 kernel: pcieport 0000:00:02.5: pciehp: Slot #0 AttnBtn+ PwrCtrl+ MRL- AttnInd+ PwrInd+ HotPlug+ Surprise+ Interlock+ NoCompl- IbPresDis- LLActRep+ Oct 30 23:58:29.916813 kernel: pcieport 0000:00:02.6: PME: Signaling with IRQ 56 Oct 30 23:58:29.916882 kernel: pcieport 0000:00:02.6: AER: enabled with IRQ 56 Oct 30 23:58:29.916950 kernel: pcieport 0000:00:02.6: pciehp: Slot #0 AttnBtn+ PwrCtrl+ MRL- AttnInd+ PwrInd+ HotPlug+ Surprise+ Interlock+ NoCompl- IbPresDis- LLActRep+ Oct 30 23:58:29.917026 kernel: pcieport 0000:00:02.7: PME: Signaling with IRQ 57 Oct 30 23:58:29.917135 kernel: pcieport 0000:00:02.7: AER: enabled with IRQ 57 Oct 30 23:58:29.917210 kernel: pcieport 0000:00:02.7: pciehp: Slot #0 AttnBtn+ PwrCtrl+ MRL- AttnInd+ PwrInd+ HotPlug+ Surprise+ Interlock+ NoCompl- IbPresDis- LLActRep+ Oct 30 23:58:29.917221 kernel: ACPI: \_SB_.PCI0.GSI3: Enabled at IRQ 38 Oct 30 23:58:29.917343 kernel: pcieport 0000:00:03.0: PME: Signaling with IRQ 58 Oct 30 23:58:29.917435 kernel: pcieport 0000:00:03.0: AER: enabled with IRQ 58 Oct 30 23:58:29.917521 kernel: pcieport 0000:00:03.0: pciehp: Slot #0 AttnBtn+ PwrCtrl+ MRL- AttnInd+ PwrInd+ HotPlug+ Surprise+ Interlock+ NoCompl- IbPresDis- LLActRep+ Oct 30 23:58:29.917534 kernel: input: Power Button as /devices/LNXSYSTM:00/LNXSYBUS:00/PNP0C0C:00/input/input0 Oct 30 23:58:29.917542 kernel: ACPI: button: Power Button [PWRB] Oct 30 23:58:29.917551 kernel: ACPI: \_SB_.PCI0.GSI1: Enabled at IRQ 36 Oct 30 23:58:29.917636 kernel: virtio-pci 0000:04:00.0: enabling device (0000 -> 0002) Oct 30 23:58:29.917727 kernel: virtio-pci 0000:07:00.0: enabling device (0000 -> 0002) Oct 30 23:58:29.917739 kernel: Serial: 8250/16550 driver, 4 ports, IRQ sharing enabled Oct 30 23:58:29.917748 kernel: ACPI: \_SB_.PCI0.GSI0: Enabled at IRQ 35 Oct 30 23:58:29.917823 kernel: serial 0000:00:04.0: enabling device (0000 -> 0001) Oct 30 23:58:29.917837 kernel: 0000:00:04.0: ttyS0 at I/O 0xa000 (irq = 45, base_baud = 115200) is a 16550A Oct 30 23:58:29.917845 kernel: thunder_xcv, ver 1.0 Oct 30 23:58:29.917854 kernel: thunder_bgx, ver 1.0 Oct 30 23:58:29.917862 kernel: nicpf, ver 1.0 Oct 30 23:58:29.917870 kernel: nicvf, ver 1.0 Oct 30 23:58:29.917954 kernel: rtc-efi rtc-efi.0: registered as rtc0 Oct 30 23:58:29.918022 kernel: rtc-efi rtc-efi.0: setting system clock to 2025-10-30T23:58:29 UTC (1761868709) Oct 30 23:58:29.918033 kernel: hid: raw HID events driver (C) Jiri Kosina Oct 30 23:58:29.918044 kernel: hw perfevents: enabled with armv8_pmuv3_0 PMU driver, 7 counters available Oct 30 23:58:29.918052 kernel: watchdog: Delayed init of the lockup detector failed: -19 Oct 30 23:58:29.918063 kernel: watchdog: Hard watchdog permanently disabled Oct 30 23:58:29.918071 kernel: NET: Registered PF_INET6 protocol family Oct 30 23:58:29.918079 kernel: Segment Routing with IPv6 Oct 30 23:58:29.918087 kernel: In-situ OAM (IOAM) with IPv6 Oct 30 23:58:29.918095 kernel: NET: Registered PF_PACKET protocol family Oct 30 23:58:29.918103 kernel: Key type dns_resolver registered Oct 30 23:58:29.918111 kernel: registered taskstats version 1 Oct 30 23:58:29.918126 kernel: Loading compiled-in X.509 certificates Oct 30 23:58:29.918136 kernel: Loaded X.509 cert 'Kinvolk GmbH: Module signing key for 6.6.113-flatcar: aa1124814e36842ccda0ba5471ce49eeba345bb7' Oct 30 23:58:29.918143 kernel: Key type .fscrypt registered Oct 30 23:58:29.918155 kernel: Key type fscrypt-provisioning registered Oct 30 23:58:29.918163 kernel: ima: No TPM chip found, activating TPM-bypass! Oct 30 23:58:29.918171 kernel: ima: Allocated hash algorithm: sha1 Oct 30 23:58:29.918179 kernel: ima: No architecture policies found Oct 30 23:58:29.918187 kernel: alg: No test for fips(ansi_cprng) (fips_ansi_cprng) Oct 30 23:58:29.918195 kernel: clk: Disabling unused clocks Oct 30 23:58:29.918205 kernel: Freeing unused kernel memory: 38400K Oct 30 23:58:29.918213 kernel: Run /init as init process Oct 30 23:58:29.918225 kernel: with arguments: Oct 30 23:58:29.918233 kernel: /init Oct 30 23:58:29.918241 kernel: with environment: Oct 30 23:58:29.918249 kernel: HOME=/ Oct 30 23:58:29.918257 kernel: TERM=linux Oct 30 23:58:29.918266 systemd[1]: Successfully made /usr/ read-only. Oct 30 23:58:29.918342 systemd[1]: systemd 256.8 running in system mode (+PAM +AUDIT +SELINUX -APPARMOR +IMA +SMACK +SECCOMP +GCRYPT -GNUTLS +OPENSSL -ACL +BLKID +CURL +ELFUTILS -FIDO2 +IDN2 -IDN +IPTC +KMOD +LIBCRYPTSETUP +LIBCRYPTSETUP_PLUGINS +LIBFDISK +PCRE2 -PWQUALITY -P11KIT -QRENCODE +TPM2 +BZIP2 +LZ4 +XZ +ZLIB +ZSTD -BPF_FRAMEWORK -XKBCOMMON +UTMP -SYSVINIT +LIBARCHIVE) Oct 30 23:58:29.918356 systemd[1]: Detected virtualization kvm. Oct 30 23:58:29.918365 systemd[1]: Detected architecture arm64. Oct 30 23:58:29.918373 systemd[1]: Running in initrd. Oct 30 23:58:29.918382 systemd[1]: No hostname configured, using default hostname. Oct 30 23:58:29.918391 systemd[1]: Hostname set to . Oct 30 23:58:29.918399 systemd[1]: Initializing machine ID from VM UUID. Oct 30 23:58:29.918408 systemd[1]: Queued start job for default target initrd.target. Oct 30 23:58:29.918421 systemd[1]: Started clevis-luks-askpass.path - Forward Password Requests to Clevis Directory Watch. Oct 30 23:58:29.918430 systemd[1]: Started systemd-ask-password-console.path - Dispatch Password Requests to Console Directory Watch. Oct 30 23:58:29.918447 systemd[1]: Expecting device dev-disk-by\x2dlabel-EFI\x2dSYSTEM.device - /dev/disk/by-label/EFI-SYSTEM... Oct 30 23:58:29.918456 systemd[1]: Expecting device dev-disk-by\x2dlabel-OEM.device - /dev/disk/by-label/OEM... Oct 30 23:58:29.918465 systemd[1]: Expecting device dev-disk-by\x2dlabel-ROOT.device - /dev/disk/by-label/ROOT... Oct 30 23:58:29.918478 systemd[1]: Expecting device dev-disk-by\x2dpartlabel-USR\x2dA.device - /dev/disk/by-partlabel/USR-A... Oct 30 23:58:29.918488 systemd[1]: Expecting device dev-disk-by\x2dpartuuid-7130c94a\x2d213a\x2d4e5a\x2d8e26\x2d6cce9662f132.device - /dev/disk/by-partuuid/7130c94a-213a-4e5a-8e26-6cce9662f132... Oct 30 23:58:29.918499 systemd[1]: Expecting device dev-mapper-usr.device - /dev/mapper/usr... Oct 30 23:58:29.918508 systemd[1]: Reached target cryptsetup-pre.target - Local Encrypted Volumes (Pre). Oct 30 23:58:29.918516 systemd[1]: Reached target cryptsetup.target - Local Encrypted Volumes. Oct 30 23:58:29.918525 systemd[1]: Reached target paths.target - Path Units. Oct 30 23:58:29.918534 systemd[1]: Reached target slices.target - Slice Units. Oct 30 23:58:29.918542 systemd[1]: Reached target swap.target - Swaps. Oct 30 23:58:29.918551 systemd[1]: Reached target timers.target - Timer Units. Oct 30 23:58:29.918560 systemd[1]: Listening on iscsid.socket - Open-iSCSI iscsid Socket. Oct 30 23:58:29.918570 systemd[1]: Listening on iscsiuio.socket - Open-iSCSI iscsiuio Socket. Oct 30 23:58:29.918579 systemd[1]: Listening on systemd-journald-dev-log.socket - Journal Socket (/dev/log). Oct 30 23:58:29.918588 systemd[1]: Listening on systemd-journald.socket - Journal Sockets. Oct 30 23:58:29.918596 systemd[1]: Listening on systemd-networkd.socket - Network Service Netlink Socket. Oct 30 23:58:29.918605 systemd[1]: Listening on systemd-udevd-control.socket - udev Control Socket. Oct 30 23:58:29.918614 systemd[1]: Listening on systemd-udevd-kernel.socket - udev Kernel Socket. Oct 30 23:58:29.918622 systemd[1]: Reached target sockets.target - Socket Units. Oct 30 23:58:29.918631 systemd[1]: Starting ignition-setup-pre.service - Ignition env setup... Oct 30 23:58:29.918640 systemd[1]: Starting kmod-static-nodes.service - Create List of Static Device Nodes... Oct 30 23:58:29.918650 systemd[1]: Finished network-cleanup.service - Network Cleanup. Oct 30 23:58:29.918658 systemd[1]: Starting systemd-fsck-usr.service... Oct 30 23:58:29.918667 systemd[1]: Starting systemd-journald.service - Journal Service... Oct 30 23:58:29.918676 systemd[1]: Starting systemd-modules-load.service - Load Kernel Modules... Oct 30 23:58:29.918684 systemd[1]: Starting systemd-vconsole-setup.service - Virtual Console Setup... Oct 30 23:58:29.918693 systemd[1]: Finished ignition-setup-pre.service - Ignition env setup. Oct 30 23:58:29.918702 systemd[1]: Finished kmod-static-nodes.service - Create List of Static Device Nodes. Oct 30 23:58:29.918750 systemd-journald[236]: Collecting audit messages is disabled. Oct 30 23:58:29.918776 systemd[1]: Finished systemd-fsck-usr.service. Oct 30 23:58:29.918786 systemd[1]: Starting systemd-tmpfiles-setup-dev-early.service - Create Static Device Nodes in /dev gracefully... Oct 30 23:58:29.918794 systemd[1]: Finished systemd-vconsole-setup.service - Virtual Console Setup. Oct 30 23:58:29.918806 systemd[1]: Finished systemd-tmpfiles-setup-dev-early.service - Create Static Device Nodes in /dev gracefully. Oct 30 23:58:29.918815 kernel: bridge: filtering via arp/ip/ip6tables is no longer available by default. Update your scripts to load br_netfilter if you need this. Oct 30 23:58:29.918824 systemd[1]: Starting dracut-cmdline-ask.service - dracut ask for additional cmdline parameters... Oct 30 23:58:29.918833 kernel: Bridge firewalling registered Oct 30 23:58:29.918842 systemd-journald[236]: Journal started Oct 30 23:58:29.918864 systemd-journald[236]: Runtime Journal (/run/log/journal/4b8e0b355bbd4375a02a1eae4348f5a0) is 8M, max 76.6M, 68.6M free. Oct 30 23:58:29.894953 systemd-modules-load[237]: Inserted module 'overlay' Oct 30 23:58:29.926530 systemd[1]: Starting systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev... Oct 30 23:58:29.916496 systemd-modules-load[237]: Inserted module 'br_netfilter' Oct 30 23:58:29.931342 systemd[1]: Started systemd-journald.service - Journal Service. Oct 30 23:58:29.930691 systemd[1]: Finished systemd-modules-load.service - Load Kernel Modules. Oct 30 23:58:29.939614 systemd[1]: Starting systemd-sysctl.service - Apply Kernel Variables... Oct 30 23:58:29.942626 systemd[1]: Starting systemd-tmpfiles-setup.service - Create System Files and Directories... Oct 30 23:58:29.943807 systemd[1]: Finished systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev. Oct 30 23:58:29.955708 systemd[1]: Finished systemd-sysctl.service - Apply Kernel Variables. Oct 30 23:58:29.958179 systemd[1]: Finished dracut-cmdline-ask.service - dracut ask for additional cmdline parameters. Oct 30 23:58:29.966523 systemd[1]: Starting dracut-cmdline.service - dracut cmdline hook... Oct 30 23:58:29.967239 systemd[1]: Finished systemd-tmpfiles-setup.service - Create System Files and Directories. Oct 30 23:58:29.970454 systemd[1]: Starting systemd-resolved.service - Network Name Resolution... Oct 30 23:58:29.985154 dracut-cmdline[272]: dracut-dracut-053 Oct 30 23:58:29.990587 dracut-cmdline[272]: 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=ttyAMA0,115200n8 flatcar.first_boot=detected acpi=force flatcar.oem.id=hetzner verity.usrhash=fa720f16dbb9986f34dd4402492c226087bd8d749299bbe02bbfafab6272d378 Oct 30 23:58:30.010081 systemd-resolved[275]: Positive Trust Anchors: Oct 30 23:58:30.010096 systemd-resolved[275]: . IN DS 20326 8 2 e06d44b80b8f1d39a95c0b0d7c65d08458e880409bbc683457104237c7f8ec8d Oct 30 23:58:30.010127 systemd-resolved[275]: Negative trust anchors: home.arpa 10.in-addr.arpa 16.172.in-addr.arpa 17.172.in-addr.arpa 18.172.in-addr.arpa 19.172.in-addr.arpa 20.172.in-addr.arpa 21.172.in-addr.arpa 22.172.in-addr.arpa 23.172.in-addr.arpa 24.172.in-addr.arpa 25.172.in-addr.arpa 26.172.in-addr.arpa 27.172.in-addr.arpa 28.172.in-addr.arpa 29.172.in-addr.arpa 30.172.in-addr.arpa 31.172.in-addr.arpa 170.0.0.192.in-addr.arpa 171.0.0.192.in-addr.arpa 168.192.in-addr.arpa d.f.ip6.arpa ipv4only.arpa resolver.arpa corp home internal intranet lan local private test Oct 30 23:58:30.016044 systemd-resolved[275]: Defaulting to hostname 'linux'. Oct 30 23:58:30.017143 systemd[1]: Started systemd-resolved.service - Network Name Resolution. Oct 30 23:58:30.021629 systemd[1]: Reached target nss-lookup.target - Host and Network Name Lookups. Oct 30 23:58:30.091337 kernel: SCSI subsystem initialized Oct 30 23:58:30.096415 kernel: Loading iSCSI transport class v2.0-870. Oct 30 23:58:30.104433 kernel: iscsi: registered transport (tcp) Oct 30 23:58:30.118963 kernel: iscsi: registered transport (qla4xxx) Oct 30 23:58:30.119052 kernel: QLogic iSCSI HBA Driver Oct 30 23:58:30.166810 systemd[1]: Finished dracut-cmdline.service - dracut cmdline hook. Oct 30 23:58:30.174669 systemd[1]: Starting dracut-pre-udev.service - dracut pre-udev hook... Oct 30 23:58:30.194332 kernel: device-mapper: core: CONFIG_IMA_DISABLE_HTABLE is disabled. Duplicate IMA measurements will not be recorded in the IMA log. Oct 30 23:58:30.194427 kernel: device-mapper: uevent: version 1.0.3 Oct 30 23:58:30.194455 kernel: device-mapper: ioctl: 4.48.0-ioctl (2023-03-01) initialised: dm-devel@redhat.com Oct 30 23:58:30.245355 kernel: raid6: neonx8 gen() 15688 MB/s Oct 30 23:58:30.262347 kernel: raid6: neonx4 gen() 15744 MB/s Oct 30 23:58:30.279367 kernel: raid6: neonx2 gen() 13177 MB/s Oct 30 23:58:30.296365 kernel: raid6: neonx1 gen() 10422 MB/s Oct 30 23:58:30.313370 kernel: raid6: int64x8 gen() 6752 MB/s Oct 30 23:58:30.330361 kernel: raid6: int64x4 gen() 7316 MB/s Oct 30 23:58:30.347356 kernel: raid6: int64x2 gen() 6070 MB/s Oct 30 23:58:30.364341 kernel: raid6: int64x1 gen() 5030 MB/s Oct 30 23:58:30.364412 kernel: raid6: using algorithm neonx4 gen() 15744 MB/s Oct 30 23:58:30.381355 kernel: raid6: .... xor() 12331 MB/s, rmw enabled Oct 30 23:58:30.381427 kernel: raid6: using neon recovery algorithm Oct 30 23:58:30.386508 kernel: xor: measuring software checksum speed Oct 30 23:58:30.386592 kernel: 8regs : 21636 MB/sec Oct 30 23:58:30.386614 kernel: 32regs : 21716 MB/sec Oct 30 23:58:30.386634 kernel: arm64_neon : 27870 MB/sec Oct 30 23:58:30.387332 kernel: xor: using function: arm64_neon (27870 MB/sec) Oct 30 23:58:30.438357 kernel: Btrfs loaded, zoned=no, fsverity=no Oct 30 23:58:30.456162 systemd[1]: Finished dracut-pre-udev.service - dracut pre-udev hook. Oct 30 23:58:30.462576 systemd[1]: Starting systemd-udevd.service - Rule-based Manager for Device Events and Files... Oct 30 23:58:30.490941 systemd-udevd[457]: Using default interface naming scheme 'v255'. Oct 30 23:58:30.495094 systemd[1]: Started systemd-udevd.service - Rule-based Manager for Device Events and Files. Oct 30 23:58:30.506534 systemd[1]: Starting dracut-pre-trigger.service - dracut pre-trigger hook... Oct 30 23:58:30.522223 dracut-pre-trigger[467]: rd.md=0: removing MD RAID activation Oct 30 23:58:30.561395 systemd[1]: Finished dracut-pre-trigger.service - dracut pre-trigger hook. Oct 30 23:58:30.570538 systemd[1]: Starting systemd-udev-trigger.service - Coldplug All udev Devices... Oct 30 23:58:30.620943 systemd[1]: Finished systemd-udev-trigger.service - Coldplug All udev Devices. Oct 30 23:58:30.629527 systemd[1]: Starting dracut-initqueue.service - dracut initqueue hook... Oct 30 23:58:30.650226 systemd[1]: Finished dracut-initqueue.service - dracut initqueue hook. Oct 30 23:58:30.651651 systemd[1]: Reached target remote-fs-pre.target - Preparation for Remote File Systems. Oct 30 23:58:30.652506 systemd[1]: Reached target remote-cryptsetup.target - Remote Encrypted Volumes. Oct 30 23:58:30.655724 systemd[1]: Reached target remote-fs.target - Remote File Systems. Oct 30 23:58:30.664242 systemd[1]: Starting dracut-pre-mount.service - dracut pre-mount hook... Oct 30 23:58:30.684611 systemd[1]: Finished dracut-pre-mount.service - dracut pre-mount hook. Oct 30 23:58:30.743559 kernel: scsi host0: Virtio SCSI HBA Oct 30 23:58:30.754209 kernel: ACPI: bus type USB registered Oct 30 23:58:30.754305 kernel: usbcore: registered new interface driver usbfs Oct 30 23:58:30.754320 kernel: usbcore: registered new interface driver hub Oct 30 23:58:30.754331 kernel: usbcore: registered new device driver usb Oct 30 23:58:30.755789 kernel: scsi 0:0:0:0: CD-ROM QEMU QEMU CD-ROM 2.5+ PQ: 0 ANSI: 5 Oct 30 23:58:30.755861 kernel: scsi 0:0:0:1: Direct-Access QEMU QEMU HARDDISK 2.5+ PQ: 0 ANSI: 5 Oct 30 23:58:30.763718 systemd[1]: dracut-cmdline-ask.service: Deactivated successfully. Oct 30 23:58:30.763856 systemd[1]: Stopped dracut-cmdline-ask.service - dracut ask for additional cmdline parameters. Oct 30 23:58:30.765747 systemd[1]: Stopping dracut-cmdline-ask.service - dracut ask for additional cmdline parameters... Oct 30 23:58:30.766326 systemd[1]: systemd-vconsole-setup.service: Deactivated successfully. Oct 30 23:58:30.766549 systemd[1]: Stopped systemd-vconsole-setup.service - Virtual Console Setup. Oct 30 23:58:30.768462 systemd[1]: Stopping systemd-vconsole-setup.service - Virtual Console Setup... Oct 30 23:58:30.774840 systemd[1]: Starting systemd-vconsole-setup.service - Virtual Console Setup... Oct 30 23:58:30.797725 systemd[1]: Finished systemd-vconsole-setup.service - Virtual Console Setup. Oct 30 23:58:30.810907 systemd[1]: Starting dracut-cmdline-ask.service - dracut ask for additional cmdline parameters... Oct 30 23:58:30.816388 kernel: xhci_hcd 0000:02:00.0: xHCI Host Controller Oct 30 23:58:30.816593 kernel: xhci_hcd 0000:02:00.0: new USB bus registered, assigned bus number 1 Oct 30 23:58:30.818779 kernel: xhci_hcd 0000:02:00.0: hcc params 0x00087001 hci version 0x100 quirks 0x0000000000000010 Oct 30 23:58:30.818995 kernel: xhci_hcd 0000:02:00.0: xHCI Host Controller Oct 30 23:58:30.819087 kernel: xhci_hcd 0000:02:00.0: new USB bus registered, assigned bus number 2 Oct 30 23:58:30.822335 kernel: xhci_hcd 0000:02:00.0: Host supports USB 3.0 SuperSpeed Oct 30 23:58:30.822981 kernel: sd 0:0:0:1: Power-on or device reset occurred Oct 30 23:58:30.824732 kernel: sd 0:0:0:1: [sda] 80003072 512-byte logical blocks: (41.0 GB/38.1 GiB) Oct 30 23:58:30.824948 kernel: hub 1-0:1.0: USB hub found Oct 30 23:58:30.825065 kernel: hub 1-0:1.0: 4 ports detected Oct 30 23:58:30.826725 kernel: sd 0:0:0:1: [sda] Write Protect is off Oct 30 23:58:30.826948 kernel: sd 0:0:0:1: [sda] Mode Sense: 63 00 00 08 Oct 30 23:58:30.827040 kernel: usb usb2: We don't know the algorithms for LPM for this host, disabling LPM. Oct 30 23:58:30.828491 kernel: sd 0:0:0:1: [sda] Write cache: enabled, read cache: enabled, doesn't support DPO or FUA Oct 30 23:58:30.828682 kernel: hub 2-0:1.0: USB hub found Oct 30 23:58:30.829338 kernel: hub 2-0:1.0: 4 ports detected Oct 30 23:58:30.830818 kernel: sr 0:0:0:0: Power-on or device reset occurred Oct 30 23:58:30.831025 kernel: sr 0:0:0:0: [sr0] scsi3-mmc drive: 16x/50x cd/rw xa/form2 cdda tray Oct 30 23:58:30.835509 kernel: GPT:Primary header thinks Alt. header is not at the end of the disk. Oct 30 23:58:30.835567 kernel: cdrom: Uniform CD-ROM driver Revision: 3.20 Oct 30 23:58:30.835580 kernel: GPT:17805311 != 80003071 Oct 30 23:58:30.835590 kernel: GPT:Alternate GPT header not at the end of the disk. Oct 30 23:58:30.835609 kernel: sr 0:0:0:0: Attached scsi CD-ROM sr0 Oct 30 23:58:30.836475 kernel: GPT:17805311 != 80003071 Oct 30 23:58:30.837314 kernel: GPT: Use GNU Parted to correct GPT errors. Oct 30 23:58:30.837343 kernel: sda: sda1 sda2 sda3 sda4 sda6 sda7 sda9 Oct 30 23:58:30.838315 kernel: sd 0:0:0:1: [sda] Attached SCSI disk Oct 30 23:58:30.854614 systemd[1]: Finished dracut-cmdline-ask.service - dracut ask for additional cmdline parameters. Oct 30 23:58:30.890314 kernel: BTRFS: device label OEM devid 1 transid 11 /dev/sda6 scanned by (udev-worker) (504) Oct 30 23:58:30.893997 kernel: BTRFS: device fsid 19e89659-6f9c-4c3c-9ebb-614770f236c4 devid 1 transid 38 /dev/sda3 scanned by (udev-worker) (507) Oct 30 23:58:30.910341 systemd[1]: Found device dev-disk-by\x2dlabel-ROOT.device - QEMU_HARDDISK ROOT. Oct 30 23:58:30.922322 systemd[1]: Found device dev-disk-by\x2dlabel-EFI\x2dSYSTEM.device - QEMU_HARDDISK EFI-SYSTEM. Oct 30 23:58:30.944375 systemd[1]: Found device dev-disk-by\x2dpartlabel-USR\x2dA.device - QEMU_HARDDISK USR-A. Oct 30 23:58:30.945040 systemd[1]: Found device dev-disk-by\x2dpartuuid-7130c94a\x2d213a\x2d4e5a\x2d8e26\x2d6cce9662f132.device - QEMU_HARDDISK USR-A. Oct 30 23:58:30.956010 systemd[1]: Found device dev-disk-by\x2dlabel-OEM.device - QEMU_HARDDISK OEM. Oct 30 23:58:30.964470 systemd[1]: Starting disk-uuid.service - Generate new UUID for disk GPT if necessary... Oct 30 23:58:30.973111 disk-uuid[576]: Primary Header is updated. Oct 30 23:58:30.973111 disk-uuid[576]: Secondary Entries is updated. Oct 30 23:58:30.973111 disk-uuid[576]: Secondary Header is updated. Oct 30 23:58:30.980077 kernel: sda: sda1 sda2 sda3 sda4 sda6 sda7 sda9 Oct 30 23:58:31.072408 kernel: usb 1-1: new high-speed USB device number 2 using xhci_hcd Oct 30 23:58:31.209760 kernel: input: QEMU QEMU USB Tablet as /devices/pci0000:00/0000:00:02.1/0000:02:00.0/usb1/1-1/1-1:1.0/0003:0627:0001.0001/input/input1 Oct 30 23:58:31.209833 kernel: hid-generic 0003:0627:0001.0001: input,hidraw0: USB HID v0.01 Mouse [QEMU QEMU USB Tablet] on usb-0000:02:00.0-1/input0 Oct 30 23:58:31.210586 kernel: usbcore: registered new interface driver usbhid Oct 30 23:58:31.211299 kernel: usbhid: USB HID core driver Oct 30 23:58:31.316338 kernel: usb 1-2: new high-speed USB device number 3 using xhci_hcd Oct 30 23:58:31.446326 kernel: input: QEMU QEMU USB Keyboard as /devices/pci0000:00/0000:00:02.1/0000:02:00.0/usb1/1-2/1-2:1.0/0003:0627:0001.0002/input/input2 Oct 30 23:58:31.500368 kernel: hid-generic 0003:0627:0001.0002: input,hidraw1: USB HID v1.11 Keyboard [QEMU QEMU USB Keyboard] on usb-0000:02:00.0-2/input0 Oct 30 23:58:31.993343 kernel: sda: sda1 sda2 sda3 sda4 sda6 sda7 sda9 Oct 30 23:58:31.993718 disk-uuid[577]: The operation has completed successfully. Oct 30 23:58:32.059453 systemd[1]: disk-uuid.service: Deactivated successfully. Oct 30 23:58:32.059573 systemd[1]: Finished disk-uuid.service - Generate new UUID for disk GPT if necessary. Oct 30 23:58:32.089640 systemd[1]: Starting verity-setup.service - Verity Setup for /dev/mapper/usr... Oct 30 23:58:32.093995 sh[592]: Success Oct 30 23:58:32.107336 kernel: device-mapper: verity: sha256 using implementation "sha256-ce" Oct 30 23:58:32.164832 systemd[1]: Found device dev-mapper-usr.device - /dev/mapper/usr. Oct 30 23:58:32.178581 systemd[1]: Mounting sysusr-usr.mount - /sysusr/usr... Oct 30 23:58:32.181343 systemd[1]: Finished verity-setup.service - Verity Setup for /dev/mapper/usr. Oct 30 23:58:32.198817 kernel: BTRFS info (device dm-0): first mount of filesystem 19e89659-6f9c-4c3c-9ebb-614770f236c4 Oct 30 23:58:32.198899 kernel: BTRFS info (device dm-0): using crc32c (crc32c-generic) checksum algorithm Oct 30 23:58:32.198926 kernel: BTRFS warning (device dm-0): 'nologreplay' is deprecated, use 'rescue=nologreplay' instead Oct 30 23:58:32.200334 kernel: BTRFS info (device dm-0): disabling log replay at mount time Oct 30 23:58:32.200392 kernel: BTRFS info (device dm-0): using free space tree Oct 30 23:58:32.206330 kernel: BTRFS info (device dm-0): enabling ssd optimizations Oct 30 23:58:32.208431 systemd[1]: Mounted sysusr-usr.mount - /sysusr/usr. Oct 30 23:58:32.209705 systemd[1]: afterburn-network-kargs.service - Afterburn Initrd Setup Network Kernel Arguments was skipped because no trigger condition checks were met. Oct 30 23:58:32.220602 systemd[1]: Starting ignition-setup.service - Ignition (setup)... Oct 30 23:58:32.226555 systemd[1]: Starting parse-ip-for-networkd.service - Write systemd-networkd units from cmdline... Oct 30 23:58:32.246497 kernel: BTRFS info (device sda6): first mount of filesystem 69797441-c23d-4add-9f10-ca7ed5585018 Oct 30 23:58:32.246566 kernel: BTRFS info (device sda6): using crc32c (crc32c-generic) checksum algorithm Oct 30 23:58:32.246581 kernel: BTRFS info (device sda6): using free space tree Oct 30 23:58:32.255709 kernel: BTRFS info (device sda6): enabling ssd optimizations Oct 30 23:58:32.255782 kernel: BTRFS info (device sda6): auto enabling async discard Oct 30 23:58:32.262327 kernel: BTRFS info (device sda6): last unmount of filesystem 69797441-c23d-4add-9f10-ca7ed5585018 Oct 30 23:58:32.266045 systemd[1]: Finished ignition-setup.service - Ignition (setup). Oct 30 23:58:32.273589 systemd[1]: Starting ignition-fetch-offline.service - Ignition (fetch-offline)... Oct 30 23:58:32.366674 systemd[1]: Finished parse-ip-for-networkd.service - Write systemd-networkd units from cmdline. Oct 30 23:58:32.372579 systemd[1]: Starting systemd-networkd.service - Network Configuration... Oct 30 23:58:32.385476 ignition[685]: Ignition 2.20.0 Oct 30 23:58:32.385486 ignition[685]: Stage: fetch-offline Oct 30 23:58:32.385525 ignition[685]: no configs at "/usr/lib/ignition/base.d" Oct 30 23:58:32.385534 ignition[685]: no config dir at "/usr/lib/ignition/base.platform.d/hetzner" Oct 30 23:58:32.385696 ignition[685]: parsed url from cmdline: "" Oct 30 23:58:32.385699 ignition[685]: no config URL provided Oct 30 23:58:32.385704 ignition[685]: reading system config file "/usr/lib/ignition/user.ign" Oct 30 23:58:32.385710 ignition[685]: no config at "/usr/lib/ignition/user.ign" Oct 30 23:58:32.389642 systemd[1]: Finished ignition-fetch-offline.service - Ignition (fetch-offline). Oct 30 23:58:32.385716 ignition[685]: failed to fetch config: resource requires networking Oct 30 23:58:32.385901 ignition[685]: Ignition finished successfully Oct 30 23:58:32.417230 systemd-networkd[776]: lo: Link UP Oct 30 23:58:32.417271 systemd-networkd[776]: lo: Gained carrier Oct 30 23:58:32.419880 systemd-networkd[776]: Enumeration completed Oct 30 23:58:32.420015 systemd[1]: Started systemd-networkd.service - Network Configuration. Oct 30 23:58:32.420892 systemd[1]: Reached target network.target - Network. Oct 30 23:58:32.422084 systemd-networkd[776]: eth0: found matching network '/usr/lib/systemd/network/zz-default.network', based on potentially unpredictable interface name. Oct 30 23:58:32.422087 systemd-networkd[776]: eth0: Configuring with /usr/lib/systemd/network/zz-default.network. Oct 30 23:58:32.422859 systemd-networkd[776]: eth1: found matching network '/usr/lib/systemd/network/zz-default.network', based on potentially unpredictable interface name. Oct 30 23:58:32.422862 systemd-networkd[776]: eth1: Configuring with /usr/lib/systemd/network/zz-default.network. Oct 30 23:58:32.423618 systemd-networkd[776]: eth0: Link UP Oct 30 23:58:32.423622 systemd-networkd[776]: eth0: Gained carrier Oct 30 23:58:32.423630 systemd-networkd[776]: eth0: found matching network '/usr/lib/systemd/network/zz-default.network', based on potentially unpredictable interface name. Oct 30 23:58:32.428665 systemd[1]: Starting ignition-fetch.service - Ignition (fetch)... Oct 30 23:58:32.432711 systemd-networkd[776]: eth1: Link UP Oct 30 23:58:32.432715 systemd-networkd[776]: eth1: Gained carrier Oct 30 23:58:32.432727 systemd-networkd[776]: eth1: found matching network '/usr/lib/systemd/network/zz-default.network', based on potentially unpredictable interface name. Oct 30 23:58:32.446954 ignition[780]: Ignition 2.20.0 Oct 30 23:58:32.446976 ignition[780]: Stage: fetch Oct 30 23:58:32.447152 ignition[780]: no configs at "/usr/lib/ignition/base.d" Oct 30 23:58:32.447164 ignition[780]: no config dir at "/usr/lib/ignition/base.platform.d/hetzner" Oct 30 23:58:32.447268 ignition[780]: parsed url from cmdline: "" Oct 30 23:58:32.447272 ignition[780]: no config URL provided Oct 30 23:58:32.447278 ignition[780]: reading system config file "/usr/lib/ignition/user.ign" Oct 30 23:58:32.447300 ignition[780]: no config at "/usr/lib/ignition/user.ign" Oct 30 23:58:32.447387 ignition[780]: GET http://169.254.169.254/hetzner/v1/userdata: attempt #1 Oct 30 23:58:32.448403 ignition[780]: GET error: Get "http://169.254.169.254/hetzner/v1/userdata": dial tcp 169.254.169.254:80: connect: network is unreachable Oct 30 23:58:32.466398 systemd-networkd[776]: eth1: DHCPv4 address 10.0.0.3/32 acquired from 10.0.0.1 Oct 30 23:58:32.488404 systemd-networkd[776]: eth0: DHCPv4 address 116.202.99.226/32, gateway 172.31.1.1 acquired from 172.31.1.1 Oct 30 23:58:32.649512 ignition[780]: GET http://169.254.169.254/hetzner/v1/userdata: attempt #2 Oct 30 23:58:32.657561 ignition[780]: GET result: OK Oct 30 23:58:32.657676 ignition[780]: parsing config with SHA512: 936f1c01ba45e1e042bd74a7ff28faeeab92705553db91fd7f1374d011ac0c98148a007a617110374b81e7b2df94bde6ec722ab6e8524a4e0bc5ca997a1c88ff Oct 30 23:58:32.667685 unknown[780]: fetched base config from "system" Oct 30 23:58:32.668716 unknown[780]: fetched base config from "system" Oct 30 23:58:32.668794 unknown[780]: fetched user config from "hetzner" Oct 30 23:58:32.669684 ignition[780]: fetch: fetch complete Oct 30 23:58:32.669691 ignition[780]: fetch: fetch passed Oct 30 23:58:32.670265 ignition[780]: Ignition finished successfully Oct 30 23:58:32.672375 systemd[1]: Finished ignition-fetch.service - Ignition (fetch). Oct 30 23:58:32.680596 systemd[1]: Starting ignition-kargs.service - Ignition (kargs)... Oct 30 23:58:32.696965 ignition[788]: Ignition 2.20.0 Oct 30 23:58:32.696978 ignition[788]: Stage: kargs Oct 30 23:58:32.697164 ignition[788]: no configs at "/usr/lib/ignition/base.d" Oct 30 23:58:32.697174 ignition[788]: no config dir at "/usr/lib/ignition/base.platform.d/hetzner" Oct 30 23:58:32.697859 ignition[788]: kargs: kargs passed Oct 30 23:58:32.697907 ignition[788]: Ignition finished successfully Oct 30 23:58:32.702343 systemd[1]: Finished ignition-kargs.service - Ignition (kargs). Oct 30 23:58:32.710470 systemd[1]: Starting ignition-disks.service - Ignition (disks)... Oct 30 23:58:32.724360 ignition[795]: Ignition 2.20.0 Oct 30 23:58:32.724373 ignition[795]: Stage: disks Oct 30 23:58:32.724592 ignition[795]: no configs at "/usr/lib/ignition/base.d" Oct 30 23:58:32.728046 systemd[1]: Finished ignition-disks.service - Ignition (disks). Oct 30 23:58:32.724602 ignition[795]: no config dir at "/usr/lib/ignition/base.platform.d/hetzner" Oct 30 23:58:32.729471 systemd[1]: Reached target initrd-root-device.target - Initrd Root Device. Oct 30 23:58:32.726509 ignition[795]: disks: disks passed Oct 30 23:58:32.731105 systemd[1]: Reached target local-fs-pre.target - Preparation for Local File Systems. Oct 30 23:58:32.726596 ignition[795]: Ignition finished successfully Oct 30 23:58:32.732282 systemd[1]: Reached target local-fs.target - Local File Systems. Oct 30 23:58:32.733250 systemd[1]: Reached target sysinit.target - System Initialization. Oct 30 23:58:32.734030 systemd[1]: Reached target basic.target - Basic System. Oct 30 23:58:32.740565 systemd[1]: Starting systemd-fsck-root.service - File System Check on /dev/disk/by-label/ROOT... Oct 30 23:58:32.756952 systemd-fsck[803]: ROOT: clean, 14/1628000 files, 120691/1617920 blocks Oct 30 23:58:32.762803 systemd[1]: Finished systemd-fsck-root.service - File System Check on /dev/disk/by-label/ROOT. Oct 30 23:58:32.772445 systemd[1]: Mounting sysroot.mount - /sysroot... Oct 30 23:58:32.825330 kernel: EXT4-fs (sda9): mounted filesystem 1621dc2d-b1da-466c-b741-5cdb5d67d58e r/w with ordered data mode. Quota mode: none. Oct 30 23:58:32.825775 systemd[1]: Mounted sysroot.mount - /sysroot. Oct 30 23:58:32.828539 systemd[1]: Reached target initrd-root-fs.target - Initrd Root File System. Oct 30 23:58:32.838506 systemd[1]: Mounting sysroot-oem.mount - /sysroot/oem... Oct 30 23:58:32.842144 systemd[1]: Mounting sysroot-usr.mount - /sysroot/usr... Oct 30 23:58:32.845674 systemd[1]: Starting flatcar-metadata-hostname.service - Flatcar Metadata Hostname Agent... Oct 30 23:58:32.850401 systemd[1]: ignition-remount-sysroot.service - Remount /sysroot read-write for Ignition was skipped because of an unmet condition check (ConditionPathIsReadWrite=!/sysroot). Oct 30 23:58:32.850453 systemd[1]: Reached target ignition-diskful.target - Ignition Boot Disk Setup. Oct 30 23:58:32.855983 systemd[1]: Mounted sysroot-usr.mount - /sysroot/usr. Oct 30 23:58:32.859937 kernel: BTRFS: device label OEM devid 1 transid 12 /dev/sda6 scanned by mount (811) Oct 30 23:58:32.861709 kernel: BTRFS info (device sda6): first mount of filesystem 69797441-c23d-4add-9f10-ca7ed5585018 Oct 30 23:58:32.861749 kernel: BTRFS info (device sda6): using crc32c (crc32c-generic) checksum algorithm Oct 30 23:58:32.861770 kernel: BTRFS info (device sda6): using free space tree Oct 30 23:58:32.866617 systemd[1]: Starting initrd-setup-root.service - Root filesystem setup... Oct 30 23:58:32.870090 kernel: BTRFS info (device sda6): enabling ssd optimizations Oct 30 23:58:32.870163 kernel: BTRFS info (device sda6): auto enabling async discard Oct 30 23:58:32.876132 systemd[1]: Mounted sysroot-oem.mount - /sysroot/oem. Oct 30 23:58:32.933854 coreos-metadata[813]: Oct 30 23:58:32.933 INFO Fetching http://169.254.169.254/hetzner/v1/metadata/hostname: Attempt #1 Oct 30 23:58:32.937580 coreos-metadata[813]: Oct 30 23:58:32.937 INFO Fetch successful Oct 30 23:58:32.939886 coreos-metadata[813]: Oct 30 23:58:32.939 INFO wrote hostname ci-4230-2-4-n-a8cc557c56 to /sysroot/etc/hostname Oct 30 23:58:32.942348 systemd[1]: Finished flatcar-metadata-hostname.service - Flatcar Metadata Hostname Agent. Oct 30 23:58:32.944102 initrd-setup-root[840]: cut: /sysroot/etc/passwd: No such file or directory Oct 30 23:58:32.950361 initrd-setup-root[847]: cut: /sysroot/etc/group: No such file or directory Oct 30 23:58:32.956951 initrd-setup-root[854]: cut: /sysroot/etc/shadow: No such file or directory Oct 30 23:58:32.962221 initrd-setup-root[861]: cut: /sysroot/etc/gshadow: No such file or directory Oct 30 23:58:33.072538 systemd[1]: Finished initrd-setup-root.service - Root filesystem setup. Oct 30 23:58:33.080459 systemd[1]: Starting ignition-mount.service - Ignition (mount)... Oct 30 23:58:33.082381 systemd[1]: Starting sysroot-boot.service - /sysroot/boot... Oct 30 23:58:33.093335 kernel: BTRFS info (device sda6): last unmount of filesystem 69797441-c23d-4add-9f10-ca7ed5585018 Oct 30 23:58:33.115360 systemd[1]: Finished sysroot-boot.service - /sysroot/boot. Oct 30 23:58:33.121522 ignition[929]: INFO : Ignition 2.20.0 Oct 30 23:58:33.121522 ignition[929]: INFO : Stage: mount Oct 30 23:58:33.124038 ignition[929]: INFO : no configs at "/usr/lib/ignition/base.d" Oct 30 23:58:33.124038 ignition[929]: INFO : no config dir at "/usr/lib/ignition/base.platform.d/hetzner" Oct 30 23:58:33.124038 ignition[929]: INFO : mount: mount passed Oct 30 23:58:33.124038 ignition[929]: INFO : Ignition finished successfully Oct 30 23:58:33.124821 systemd[1]: Finished ignition-mount.service - Ignition (mount). Oct 30 23:58:33.134544 systemd[1]: Starting ignition-files.service - Ignition (files)... Oct 30 23:58:33.198979 systemd[1]: sysroot-oem.mount: Deactivated successfully. Oct 30 23:58:33.209633 systemd[1]: Mounting sysroot-oem.mount - /sysroot/oem... Oct 30 23:58:33.221336 kernel: BTRFS: device label OEM devid 1 transid 13 /dev/sda6 scanned by mount (942) Oct 30 23:58:33.223541 kernel: BTRFS info (device sda6): first mount of filesystem 69797441-c23d-4add-9f10-ca7ed5585018 Oct 30 23:58:33.223607 kernel: BTRFS info (device sda6): using crc32c (crc32c-generic) checksum algorithm Oct 30 23:58:33.223620 kernel: BTRFS info (device sda6): using free space tree Oct 30 23:58:33.227524 kernel: BTRFS info (device sda6): enabling ssd optimizations Oct 30 23:58:33.227592 kernel: BTRFS info (device sda6): auto enabling async discard Oct 30 23:58:33.230846 systemd[1]: Mounted sysroot-oem.mount - /sysroot/oem. Oct 30 23:58:33.256887 ignition[959]: INFO : Ignition 2.20.0 Oct 30 23:58:33.256887 ignition[959]: INFO : Stage: files Oct 30 23:58:33.258709 ignition[959]: INFO : no configs at "/usr/lib/ignition/base.d" Oct 30 23:58:33.258709 ignition[959]: INFO : no config dir at "/usr/lib/ignition/base.platform.d/hetzner" Oct 30 23:58:33.260457 ignition[959]: DEBUG : files: compiled without relabeling support, skipping Oct 30 23:58:33.261652 ignition[959]: INFO : files: ensureUsers: op(1): [started] creating or modifying user "core" Oct 30 23:58:33.261652 ignition[959]: DEBUG : files: ensureUsers: op(1): executing: "usermod" "--root" "/sysroot" "core" Oct 30 23:58:33.265434 ignition[959]: INFO : files: ensureUsers: op(1): [finished] creating or modifying user "core" Oct 30 23:58:33.266656 ignition[959]: INFO : files: ensureUsers: op(2): [started] adding ssh keys to user "core" Oct 30 23:58:33.268180 unknown[959]: wrote ssh authorized keys file for user: core Oct 30 23:58:33.268999 ignition[959]: INFO : files: ensureUsers: op(2): [finished] adding ssh keys to user "core" Oct 30 23:58:33.271880 ignition[959]: INFO : files: createFilesystemsFiles: createFiles: op(3): [started] writing file "/sysroot/etc/flatcar/update.conf" Oct 30 23:58:33.271880 ignition[959]: INFO : files: createFilesystemsFiles: createFiles: op(3): [finished] writing file "/sysroot/etc/flatcar/update.conf" Oct 30 23:58:33.271880 ignition[959]: INFO : files: op(4): [started] processing unit "etcd-member.service" Oct 30 23:58:33.277444 ignition[959]: 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" Oct 30 23:58:33.277444 ignition[959]: 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" Oct 30 23:58:33.277444 ignition[959]: INFO : files: op(4): [finished] processing unit "etcd-member.service" Oct 30 23:58:33.277444 ignition[959]: INFO : files: op(6): [started] processing unit "coreos-metadata.service" Oct 30 23:58:33.277444 ignition[959]: INFO : files: op(6): op(7): [started] writing systemd drop-in "00-custom-metadata.conf" at "/sysroot/etc/systemd/system/coreos-metadata.service.d/00-custom-metadata.conf" Oct 30 23:58:33.277444 ignition[959]: INFO : files: op(6): op(7): [finished] writing systemd drop-in "00-custom-metadata.conf" at "/sysroot/etc/systemd/system/coreos-metadata.service.d/00-custom-metadata.conf" Oct 30 23:58:33.277444 ignition[959]: INFO : files: op(6): [finished] processing unit "coreos-metadata.service" Oct 30 23:58:33.277444 ignition[959]: INFO : files: op(8): [started] setting preset to enabled for "etcd-member.service" Oct 30 23:58:33.277444 ignition[959]: INFO : files: op(8): [finished] setting preset to enabled for "etcd-member.service" Oct 30 23:58:33.277444 ignition[959]: INFO : files: createResultFile: createFiles: op(9): [started] writing file "/sysroot/etc/.ignition-result.json" Oct 30 23:58:33.277444 ignition[959]: INFO : files: createResultFile: createFiles: op(9): [finished] writing file "/sysroot/etc/.ignition-result.json" Oct 30 23:58:33.277444 ignition[959]: INFO : files: files passed Oct 30 23:58:33.277444 ignition[959]: INFO : Ignition finished successfully Oct 30 23:58:33.279025 systemd[1]: Finished ignition-files.service - Ignition (files). Oct 30 23:58:33.285561 systemd[1]: Starting ignition-quench.service - Ignition (record completion)... Oct 30 23:58:33.296895 systemd[1]: Starting initrd-setup-root-after-ignition.service - Root filesystem completion... Oct 30 23:58:33.304948 systemd[1]: ignition-quench.service: Deactivated successfully. Oct 30 23:58:33.305059 systemd[1]: Finished ignition-quench.service - Ignition (record completion). Oct 30 23:58:33.315411 initrd-setup-root-after-ignition[987]: grep: /sysroot/etc/flatcar/enabled-sysext.conf: No such file or directory Oct 30 23:58:33.315411 initrd-setup-root-after-ignition[987]: grep: /sysroot/usr/share/flatcar/enabled-sysext.conf: No such file or directory Oct 30 23:58:33.317933 initrd-setup-root-after-ignition[991]: grep: /sysroot/etc/flatcar/enabled-sysext.conf: No such file or directory Oct 30 23:58:33.320856 systemd[1]: Finished initrd-setup-root-after-ignition.service - Root filesystem completion. Oct 30 23:58:33.321833 systemd[1]: Reached target ignition-complete.target - Ignition Complete. Oct 30 23:58:33.326523 systemd[1]: Starting initrd-parse-etc.service - Mountpoints Configured in the Real Root... Oct 30 23:58:33.353622 systemd[1]: initrd-parse-etc.service: Deactivated successfully. Oct 30 23:58:33.353765 systemd[1]: Finished initrd-parse-etc.service - Mountpoints Configured in the Real Root. Oct 30 23:58:33.356556 systemd[1]: Reached target initrd-fs.target - Initrd File Systems. Oct 30 23:58:33.358432 systemd[1]: Reached target initrd.target - Initrd Default Target. Oct 30 23:58:33.360073 systemd[1]: dracut-mount.service - dracut mount hook was skipped because no trigger condition checks were met. Oct 30 23:58:33.365571 systemd[1]: Starting dracut-pre-pivot.service - dracut pre-pivot and cleanup hook... Oct 30 23:58:33.380967 systemd[1]: Finished dracut-pre-pivot.service - dracut pre-pivot and cleanup hook. Oct 30 23:58:33.385537 systemd[1]: Starting initrd-cleanup.service - Cleaning Up and Shutting Down Daemons... Oct 30 23:58:33.399653 systemd[1]: Stopped target nss-lookup.target - Host and Network Name Lookups. Oct 30 23:58:33.400383 systemd[1]: Stopped target remote-cryptsetup.target - Remote Encrypted Volumes. Oct 30 23:58:33.402474 systemd[1]: Stopped target timers.target - Timer Units. Oct 30 23:58:33.404204 systemd[1]: dracut-pre-pivot.service: Deactivated successfully. Oct 30 23:58:33.404368 systemd[1]: Stopped dracut-pre-pivot.service - dracut pre-pivot and cleanup hook. Oct 30 23:58:33.405961 systemd[1]: Stopped target initrd.target - Initrd Default Target. Oct 30 23:58:33.406901 systemd[1]: Stopped target basic.target - Basic System. Oct 30 23:58:33.407908 systemd[1]: Stopped target ignition-complete.target - Ignition Complete. Oct 30 23:58:33.408916 systemd[1]: Stopped target ignition-diskful.target - Ignition Boot Disk Setup. Oct 30 23:58:33.409937 systemd[1]: Stopped target initrd-root-device.target - Initrd Root Device. Oct 30 23:58:33.410989 systemd[1]: Stopped target remote-fs.target - Remote File Systems. Oct 30 23:58:33.412090 systemd[1]: Stopped target remote-fs-pre.target - Preparation for Remote File Systems. Oct 30 23:58:33.413279 systemd[1]: Stopped target sysinit.target - System Initialization. Oct 30 23:58:33.414307 systemd[1]: Stopped target local-fs.target - Local File Systems. Oct 30 23:58:33.415512 systemd[1]: Stopped target swap.target - Swaps. Oct 30 23:58:33.416407 systemd[1]: dracut-pre-mount.service: Deactivated successfully. Oct 30 23:58:33.416545 systemd[1]: Stopped dracut-pre-mount.service - dracut pre-mount hook. Oct 30 23:58:33.417788 systemd[1]: Stopped target cryptsetup.target - Local Encrypted Volumes. Oct 30 23:58:33.418445 systemd[1]: Stopped target cryptsetup-pre.target - Local Encrypted Volumes (Pre). Oct 30 23:58:33.419523 systemd[1]: clevis-luks-askpass.path: Deactivated successfully. Oct 30 23:58:33.421337 systemd[1]: Stopped clevis-luks-askpass.path - Forward Password Requests to Clevis Directory Watch. Oct 30 23:58:33.422469 systemd[1]: dracut-initqueue.service: Deactivated successfully. Oct 30 23:58:33.422603 systemd[1]: Stopped dracut-initqueue.service - dracut initqueue hook. Oct 30 23:58:33.424284 systemd[1]: initrd-setup-root-after-ignition.service: Deactivated successfully. Oct 30 23:58:33.424419 systemd[1]: Stopped initrd-setup-root-after-ignition.service - Root filesystem completion. Oct 30 23:58:33.425667 systemd[1]: ignition-files.service: Deactivated successfully. Oct 30 23:58:33.425763 systemd[1]: Stopped ignition-files.service - Ignition (files). Oct 30 23:58:33.426820 systemd[1]: flatcar-metadata-hostname.service: Deactivated successfully. Oct 30 23:58:33.426917 systemd[1]: Stopped flatcar-metadata-hostname.service - Flatcar Metadata Hostname Agent. Oct 30 23:58:33.433523 systemd[1]: Stopping ignition-mount.service - Ignition (mount)... Oct 30 23:58:33.438556 systemd[1]: Stopping sysroot-boot.service - /sysroot/boot... Oct 30 23:58:33.440415 systemd[1]: systemd-udev-trigger.service: Deactivated successfully. Oct 30 23:58:33.440607 systemd[1]: Stopped systemd-udev-trigger.service - Coldplug All udev Devices. Oct 30 23:58:33.441452 systemd[1]: dracut-pre-trigger.service: Deactivated successfully. Oct 30 23:58:33.441587 systemd[1]: Stopped dracut-pre-trigger.service - dracut pre-trigger hook. Oct 30 23:58:33.454206 systemd[1]: initrd-cleanup.service: Deactivated successfully. Oct 30 23:58:33.454341 systemd[1]: Finished initrd-cleanup.service - Cleaning Up and Shutting Down Daemons. Oct 30 23:58:33.458551 ignition[1011]: INFO : Ignition 2.20.0 Oct 30 23:58:33.458551 ignition[1011]: INFO : Stage: umount Oct 30 23:58:33.458551 ignition[1011]: INFO : no configs at "/usr/lib/ignition/base.d" Oct 30 23:58:33.458551 ignition[1011]: INFO : no config dir at "/usr/lib/ignition/base.platform.d/hetzner" Oct 30 23:58:33.458551 ignition[1011]: INFO : umount: umount passed Oct 30 23:58:33.458551 ignition[1011]: INFO : Ignition finished successfully Oct 30 23:58:33.460752 systemd[1]: ignition-mount.service: Deactivated successfully. Oct 30 23:58:33.460896 systemd[1]: Stopped ignition-mount.service - Ignition (mount). Oct 30 23:58:33.461698 systemd[1]: ignition-disks.service: Deactivated successfully. Oct 30 23:58:33.461746 systemd[1]: Stopped ignition-disks.service - Ignition (disks). Oct 30 23:58:33.463505 systemd[1]: ignition-kargs.service: Deactivated successfully. Oct 30 23:58:33.463554 systemd[1]: Stopped ignition-kargs.service - Ignition (kargs). Oct 30 23:58:33.464073 systemd[1]: ignition-fetch.service: Deactivated successfully. Oct 30 23:58:33.464110 systemd[1]: Stopped ignition-fetch.service - Ignition (fetch). Oct 30 23:58:33.464748 systemd[1]: Stopped target network.target - Network. Oct 30 23:58:33.465186 systemd[1]: ignition-fetch-offline.service: Deactivated successfully. Oct 30 23:58:33.465273 systemd[1]: Stopped ignition-fetch-offline.service - Ignition (fetch-offline). Oct 30 23:58:33.467033 systemd[1]: Stopped target paths.target - Path Units. Oct 30 23:58:33.467879 systemd[1]: systemd-ask-password-console.path: Deactivated successfully. Oct 30 23:58:33.469468 systemd[1]: Stopped systemd-ask-password-console.path - Dispatch Password Requests to Console Directory Watch. Oct 30 23:58:33.472357 systemd[1]: Stopped target slices.target - Slice Units. Oct 30 23:58:33.473260 systemd[1]: Stopped target sockets.target - Socket Units. Oct 30 23:58:33.475800 systemd[1]: iscsid.socket: Deactivated successfully. Oct 30 23:58:33.475850 systemd[1]: Closed iscsid.socket - Open-iSCSI iscsid Socket. Oct 30 23:58:33.478259 systemd[1]: iscsiuio.socket: Deactivated successfully. Oct 30 23:58:33.478333 systemd[1]: Closed iscsiuio.socket - Open-iSCSI iscsiuio Socket. Oct 30 23:58:33.479275 systemd[1]: ignition-setup.service: Deactivated successfully. Oct 30 23:58:33.479343 systemd[1]: Stopped ignition-setup.service - Ignition (setup). Oct 30 23:58:33.482739 systemd[1]: ignition-setup-pre.service: Deactivated successfully. Oct 30 23:58:33.482807 systemd[1]: Stopped ignition-setup-pre.service - Ignition env setup. Oct 30 23:58:33.484547 systemd[1]: Stopping systemd-networkd.service - Network Configuration... Oct 30 23:58:33.485627 systemd[1]: Stopping systemd-resolved.service - Network Name Resolution... Oct 30 23:58:33.488219 systemd[1]: sysroot-boot.mount: Deactivated successfully. Oct 30 23:58:33.488855 systemd[1]: sysroot-boot.service: Deactivated successfully. Oct 30 23:58:33.488955 systemd[1]: Stopped sysroot-boot.service - /sysroot/boot. Oct 30 23:58:33.491092 systemd[1]: initrd-setup-root.service: Deactivated successfully. Oct 30 23:58:33.491211 systemd[1]: Stopped initrd-setup-root.service - Root filesystem setup. Oct 30 23:58:33.495103 systemd[1]: systemd-resolved.service: Deactivated successfully. Oct 30 23:58:33.495237 systemd[1]: Stopped systemd-resolved.service - Network Name Resolution. Oct 30 23:58:33.500845 systemd[1]: run-credentials-systemd\x2dresolved.service.mount: Deactivated successfully. Oct 30 23:58:33.501118 systemd[1]: systemd-networkd.service: Deactivated successfully. Oct 30 23:58:33.501878 systemd[1]: Stopped systemd-networkd.service - Network Configuration. Oct 30 23:58:33.505675 systemd[1]: run-credentials-systemd\x2dnetworkd.service.mount: Deactivated successfully. Oct 30 23:58:33.507043 systemd[1]: systemd-networkd.socket: Deactivated successfully. Oct 30 23:58:33.507142 systemd[1]: Closed systemd-networkd.socket - Network Service Netlink Socket. Oct 30 23:58:33.516254 systemd[1]: Stopping network-cleanup.service - Network Cleanup... Oct 30 23:58:33.516773 systemd[1]: parse-ip-for-networkd.service: Deactivated successfully. Oct 30 23:58:33.516846 systemd[1]: Stopped parse-ip-for-networkd.service - Write systemd-networkd units from cmdline. Oct 30 23:58:33.518604 systemd[1]: systemd-sysctl.service: Deactivated successfully. Oct 30 23:58:33.518657 systemd[1]: Stopped systemd-sysctl.service - Apply Kernel Variables. Oct 30 23:58:33.521178 systemd[1]: systemd-modules-load.service: Deactivated successfully. Oct 30 23:58:33.521268 systemd[1]: Stopped systemd-modules-load.service - Load Kernel Modules. Oct 30 23:58:33.522640 systemd[1]: systemd-tmpfiles-setup.service: Deactivated successfully. Oct 30 23:58:33.522704 systemd[1]: Stopped systemd-tmpfiles-setup.service - Create System Files and Directories. Oct 30 23:58:33.525634 systemd[1]: Stopping systemd-udevd.service - Rule-based Manager for Device Events and Files... Oct 30 23:58:33.541241 systemd[1]: network-cleanup.service: Deactivated successfully. Oct 30 23:58:33.541415 systemd[1]: Stopped network-cleanup.service - Network Cleanup. Oct 30 23:58:33.543951 systemd[1]: systemd-udevd.service: Deactivated successfully. Oct 30 23:58:33.544596 systemd[1]: Stopped systemd-udevd.service - Rule-based Manager for Device Events and Files. Oct 30 23:58:33.545786 systemd[1]: systemd-udevd-control.socket: Deactivated successfully. Oct 30 23:58:33.545834 systemd[1]: Closed systemd-udevd-control.socket - udev Control Socket. Oct 30 23:58:33.546673 systemd[1]: systemd-udevd-kernel.socket: Deactivated successfully. Oct 30 23:58:33.546704 systemd[1]: Closed systemd-udevd-kernel.socket - udev Kernel Socket. Oct 30 23:58:33.547705 systemd[1]: dracut-pre-udev.service: Deactivated successfully. Oct 30 23:58:33.547757 systemd[1]: Stopped dracut-pre-udev.service - dracut pre-udev hook. Oct 30 23:58:33.549174 systemd[1]: dracut-cmdline.service: Deactivated successfully. Oct 30 23:58:33.549230 systemd[1]: Stopped dracut-cmdline.service - dracut cmdline hook. Oct 30 23:58:33.550739 systemd[1]: dracut-cmdline-ask.service: Deactivated successfully. Oct 30 23:58:33.550782 systemd[1]: Stopped dracut-cmdline-ask.service - dracut ask for additional cmdline parameters. Oct 30 23:58:33.557536 systemd[1]: Starting initrd-udevadm-cleanup-db.service - Cleanup udev Database... Oct 30 23:58:33.558094 systemd[1]: systemd-tmpfiles-setup-dev.service: Deactivated successfully. Oct 30 23:58:33.558160 systemd[1]: Stopped systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev. Oct 30 23:58:33.559877 systemd[1]: systemd-tmpfiles-setup-dev-early.service: Deactivated successfully. Oct 30 23:58:33.559926 systemd[1]: Stopped systemd-tmpfiles-setup-dev-early.service - Create Static Device Nodes in /dev gracefully. Oct 30 23:58:33.560739 systemd[1]: kmod-static-nodes.service: Deactivated successfully. Oct 30 23:58:33.560782 systemd[1]: Stopped kmod-static-nodes.service - Create List of Static Device Nodes. Oct 30 23:58:33.561510 systemd[1]: systemd-vconsole-setup.service: Deactivated successfully. Oct 30 23:58:33.561550 systemd[1]: Stopped systemd-vconsole-setup.service - Virtual Console Setup. Oct 30 23:58:33.567667 systemd[1]: initrd-udevadm-cleanup-db.service: Deactivated successfully. Oct 30 23:58:33.567791 systemd[1]: Finished initrd-udevadm-cleanup-db.service - Cleanup udev Database. Oct 30 23:58:33.569108 systemd[1]: Reached target initrd-switch-root.target - Switch Root. Oct 30 23:58:33.577563 systemd[1]: Starting initrd-switch-root.service - Switch Root... Oct 30 23:58:33.585419 systemd[1]: Switching root. Oct 30 23:58:33.615784 systemd-journald[236]: Journal stopped Oct 30 23:58:34.521593 systemd-journald[236]: Received SIGTERM from PID 1 (systemd). Oct 30 23:58:34.521668 kernel: SELinux: policy capability network_peer_controls=1 Oct 30 23:58:34.521684 kernel: SELinux: policy capability open_perms=1 Oct 30 23:58:34.521694 kernel: SELinux: policy capability extended_socket_class=1 Oct 30 23:58:34.521704 kernel: SELinux: policy capability always_check_network=0 Oct 30 23:58:34.521713 kernel: SELinux: policy capability cgroup_seclabel=1 Oct 30 23:58:34.521727 kernel: SELinux: policy capability nnp_nosuid_transition=1 Oct 30 23:58:34.521736 kernel: SELinux: policy capability genfs_seclabel_symlinks=0 Oct 30 23:58:34.521747 kernel: SELinux: policy capability ioctl_skip_cloexec=0 Oct 30 23:58:34.521756 kernel: audit: type=1403 audit(1761868713.702:2): auid=4294967295 ses=4294967295 lsm=selinux res=1 Oct 30 23:58:34.521766 systemd[1]: Successfully loaded SELinux policy in 35.875ms. Oct 30 23:58:34.521791 systemd[1]: Relabeled /dev/, /dev/shm/, /run/ in 11.037ms. Oct 30 23:58:34.521801 systemd[1]: systemd 256.8 running in system mode (+PAM +AUDIT +SELINUX -APPARMOR +IMA +SMACK +SECCOMP +GCRYPT -GNUTLS +OPENSSL -ACL +BLKID +CURL +ELFUTILS -FIDO2 +IDN2 -IDN +IPTC +KMOD +LIBCRYPTSETUP +LIBCRYPTSETUP_PLUGINS +LIBFDISK +PCRE2 -PWQUALITY -P11KIT -QRENCODE +TPM2 +BZIP2 +LZ4 +XZ +ZLIB +ZSTD -BPF_FRAMEWORK -XKBCOMMON +UTMP -SYSVINIT +LIBARCHIVE) Oct 30 23:58:34.521813 systemd[1]: Detected virtualization kvm. Oct 30 23:58:34.521823 systemd[1]: Detected architecture arm64. Oct 30 23:58:34.521833 systemd[1]: Detected first boot. Oct 30 23:58:34.521843 systemd[1]: Hostname set to . Oct 30 23:58:34.521854 systemd[1]: Initializing machine ID from VM UUID. Oct 30 23:58:34.521864 zram_generator::config[1056]: No configuration found. Oct 30 23:58:34.521875 kernel: NET: Registered PF_VSOCK protocol family Oct 30 23:58:34.521885 systemd[1]: Populated /etc with preset unit settings. Oct 30 23:58:34.521896 systemd[1]: run-credentials-systemd\x2djournald.service.mount: Deactivated successfully. Oct 30 23:58:34.521906 systemd[1]: initrd-switch-root.service: Deactivated successfully. Oct 30 23:58:34.521916 systemd[1]: Stopped initrd-switch-root.service - Switch Root. Oct 30 23:58:34.521925 systemd[1]: systemd-journald.service: Scheduled restart job, restart counter is at 1. Oct 30 23:58:34.521938 systemd[1]: Created slice system-addon\x2dconfig.slice - Slice /system/addon-config. Oct 30 23:58:34.521951 systemd[1]: Created slice system-addon\x2drun.slice - Slice /system/addon-run. Oct 30 23:58:34.521961 systemd[1]: Created slice system-getty.slice - Slice /system/getty. Oct 30 23:58:34.521971 systemd[1]: Created slice system-modprobe.slice - Slice /system/modprobe. Oct 30 23:58:34.521981 systemd[1]: Created slice system-serial\x2dgetty.slice - Slice /system/serial-getty. Oct 30 23:58:34.521991 systemd[1]: Created slice system-system\x2dcloudinit.slice - Slice /system/system-cloudinit. Oct 30 23:58:34.522001 systemd[1]: Created slice system-systemd\x2dfsck.slice - Slice /system/systemd-fsck. Oct 30 23:58:34.522011 systemd[1]: Created slice user.slice - User and Session Slice. Oct 30 23:58:34.522023 systemd[1]: Started clevis-luks-askpass.path - Forward Password Requests to Clevis Directory Watch. Oct 30 23:58:34.522033 systemd[1]: Started systemd-ask-password-console.path - Dispatch Password Requests to Console Directory Watch. Oct 30 23:58:34.522043 systemd[1]: Started systemd-ask-password-wall.path - Forward Password Requests to Wall Directory Watch. Oct 30 23:58:34.522053 systemd[1]: Set up automount boot.automount - Boot partition Automount Point. Oct 30 23:58:34.522063 systemd[1]: Set up automount proc-sys-fs-binfmt_misc.automount - Arbitrary Executable File Formats File System Automount Point. Oct 30 23:58:34.522074 systemd[1]: Expecting device dev-disk-by\x2dlabel-OEM.device - /dev/disk/by-label/OEM... Oct 30 23:58:34.522083 systemd[1]: Expecting device dev-ttyAMA0.device - /dev/ttyAMA0... Oct 30 23:58:34.522094 systemd[1]: Reached target cryptsetup-pre.target - Local Encrypted Volumes (Pre). Oct 30 23:58:34.522105 systemd[1]: Stopped target initrd-switch-root.target - Switch Root. Oct 30 23:58:34.522115 systemd[1]: Stopped target initrd-fs.target - Initrd File Systems. Oct 30 23:58:34.522125 systemd[1]: Stopped target initrd-root-fs.target - Initrd Root File System. Oct 30 23:58:34.522134 systemd[1]: Reached target integritysetup.target - Local Integrity Protected Volumes. Oct 30 23:58:34.522144 systemd[1]: Reached target remote-cryptsetup.target - Remote Encrypted Volumes. Oct 30 23:58:34.522154 systemd[1]: Reached target remote-fs.target - Remote File Systems. Oct 30 23:58:34.522164 systemd[1]: Reached target slices.target - Slice Units. Oct 30 23:58:34.522174 systemd[1]: Reached target swap.target - Swaps. Oct 30 23:58:34.522186 systemd[1]: Reached target veritysetup.target - Local Verity Protected Volumes. Oct 30 23:58:34.522196 systemd[1]: Listening on systemd-coredump.socket - Process Core Dump Socket. Oct 30 23:58:34.522218 systemd[1]: Listening on systemd-creds.socket - Credential Encryption/Decryption. Oct 30 23:58:34.522230 systemd[1]: Listening on systemd-networkd.socket - Network Service Netlink Socket. Oct 30 23:58:34.522240 systemd[1]: Listening on systemd-udevd-control.socket - udev Control Socket. Oct 30 23:58:34.522250 systemd[1]: Listening on systemd-udevd-kernel.socket - udev Kernel Socket. Oct 30 23:58:34.522260 systemd[1]: Listening on systemd-userdbd.socket - User Database Manager Socket. Oct 30 23:58:34.522270 systemd[1]: Mounting dev-hugepages.mount - Huge Pages File System... Oct 30 23:58:34.522281 systemd[1]: Mounting dev-mqueue.mount - POSIX Message Queue File System... Oct 30 23:58:34.522500 systemd[1]: Mounting media.mount - External Media Directory... Oct 30 23:58:34.522518 systemd[1]: Mounting sys-kernel-debug.mount - Kernel Debug File System... Oct 30 23:58:34.522529 systemd[1]: Mounting sys-kernel-tracing.mount - Kernel Trace File System... Oct 30 23:58:34.522539 systemd[1]: Mounting tmp.mount - Temporary Directory /tmp... Oct 30 23:58:34.522550 systemd[1]: var-lib-machines.mount - Virtual Machine and Container Storage (Compatibility) was skipped because of an unmet condition check (ConditionPathExists=/var/lib/machines.raw). Oct 30 23:58:34.522561 systemd[1]: Reached target machines.target - Containers. Oct 30 23:58:34.522571 systemd[1]: Starting flatcar-tmpfiles.service - Create missing system files... Oct 30 23:58:34.522581 systemd[1]: ignition-delete-config.service - Ignition (delete config) was skipped because no trigger condition checks were met. Oct 30 23:58:34.522594 systemd[1]: Starting kmod-static-nodes.service - Create List of Static Device Nodes... Oct 30 23:58:34.522605 systemd[1]: Starting modprobe@configfs.service - Load Kernel Module configfs... Oct 30 23:58:34.522615 systemd[1]: Starting modprobe@dm_mod.service - Load Kernel Module dm_mod... Oct 30 23:58:34.522625 systemd[1]: Starting modprobe@drm.service - Load Kernel Module drm... Oct 30 23:58:34.522635 systemd[1]: Starting modprobe@efi_pstore.service - Load Kernel Module efi_pstore... Oct 30 23:58:34.522645 systemd[1]: Starting modprobe@fuse.service - Load Kernel Module fuse... Oct 30 23:58:34.522655 systemd[1]: Starting modprobe@loop.service - Load Kernel Module loop... Oct 30 23:58:34.522666 systemd[1]: setup-nsswitch.service - Create /etc/nsswitch.conf was skipped because of an unmet condition check (ConditionPathExists=!/etc/nsswitch.conf). Oct 30 23:58:34.522676 systemd[1]: systemd-fsck-root.service: Deactivated successfully. Oct 30 23:58:34.522688 systemd[1]: Stopped systemd-fsck-root.service - File System Check on Root Device. Oct 30 23:58:34.522699 systemd[1]: systemd-fsck-usr.service: Deactivated successfully. Oct 30 23:58:34.522709 systemd[1]: Stopped systemd-fsck-usr.service. Oct 30 23:58:34.522720 systemd[1]: systemd-hibernate-clear.service - Clear Stale Hibernate Storage Info was skipped because of an unmet condition check (ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67). Oct 30 23:58:34.522730 systemd[1]: Starting systemd-journald.service - Journal Service... Oct 30 23:58:34.522740 systemd[1]: Starting systemd-modules-load.service - Load Kernel Modules... Oct 30 23:58:34.522753 systemd[1]: Starting systemd-network-generator.service - Generate network units from Kernel command line... Oct 30 23:58:34.522923 systemd[1]: Starting systemd-remount-fs.service - Remount Root and Kernel File Systems... Oct 30 23:58:34.522943 systemd[1]: Starting systemd-udev-load-credentials.service - Load udev Rules from Credentials... Oct 30 23:58:34.522954 systemd[1]: Starting systemd-udev-trigger.service - Coldplug All udev Devices... Oct 30 23:58:34.522971 systemd[1]: verity-setup.service: Deactivated successfully. Oct 30 23:58:34.522985 systemd[1]: Stopped verity-setup.service. Oct 30 23:58:34.522997 systemd[1]: Mounted dev-hugepages.mount - Huge Pages File System. Oct 30 23:58:34.523009 systemd[1]: Mounted dev-mqueue.mount - POSIX Message Queue File System. Oct 30 23:58:34.523020 systemd[1]: Mounted media.mount - External Media Directory. Oct 30 23:58:34.523033 systemd[1]: Mounted sys-kernel-debug.mount - Kernel Debug File System. Oct 30 23:58:34.523043 systemd[1]: Mounted sys-kernel-tracing.mount - Kernel Trace File System. Oct 30 23:58:34.523054 systemd[1]: Mounted tmp.mount - Temporary Directory /tmp. Oct 30 23:58:34.523064 systemd[1]: Finished kmod-static-nodes.service - Create List of Static Device Nodes. Oct 30 23:58:34.523080 systemd[1]: modprobe@configfs.service: Deactivated successfully. Oct 30 23:58:34.523130 systemd-journald[1127]: Collecting audit messages is disabled. Oct 30 23:58:34.523156 systemd[1]: Finished modprobe@configfs.service - Load Kernel Module configfs. Oct 30 23:58:34.523168 systemd[1]: modprobe@dm_mod.service: Deactivated successfully. Oct 30 23:58:34.523183 systemd[1]: Finished modprobe@dm_mod.service - Load Kernel Module dm_mod. Oct 30 23:58:34.523195 systemd[1]: modprobe@efi_pstore.service: Deactivated successfully. Oct 30 23:58:34.523258 systemd-journald[1127]: Journal started Oct 30 23:58:34.523299 systemd-journald[1127]: Runtime Journal (/run/log/journal/4b8e0b355bbd4375a02a1eae4348f5a0) is 8M, max 76.6M, 68.6M free. Oct 30 23:58:34.277717 systemd[1]: Queued start job for default target multi-user.target. Oct 30 23:58:34.290008 systemd[1]: Unnecessary job was removed for dev-sda6.device - /dev/sda6. Oct 30 23:58:34.290744 systemd[1]: systemd-journald.service: Deactivated successfully. Oct 30 23:58:34.526818 systemd[1]: Finished modprobe@efi_pstore.service - Load Kernel Module efi_pstore. Oct 30 23:58:34.529322 systemd[1]: Started systemd-journald.service - Journal Service. Oct 30 23:58:34.532347 systemd[1]: Finished systemd-modules-load.service - Load Kernel Modules. Oct 30 23:58:34.540326 kernel: ACPI: bus type drm_connector registered Oct 30 23:58:34.540878 systemd[1]: Finished systemd-udev-load-credentials.service - Load udev Rules from Credentials. Oct 30 23:58:34.544910 systemd[1]: modprobe@drm.service: Deactivated successfully. Oct 30 23:58:34.545090 systemd[1]: Finished modprobe@drm.service - Load Kernel Module drm. Oct 30 23:58:34.546140 systemd[1]: Finished systemd-remount-fs.service - Remount Root and Kernel File Systems. Oct 30 23:58:34.551414 kernel: fuse: init (API version 7.39) Oct 30 23:58:34.556067 systemd[1]: modprobe@fuse.service: Deactivated successfully. Oct 30 23:58:34.557022 systemd[1]: Finished modprobe@fuse.service - Load Kernel Module fuse. Oct 30 23:58:34.559305 kernel: loop: module loaded Oct 30 23:58:34.558496 systemd[1]: modprobe@loop.service: Deactivated successfully. Oct 30 23:58:34.559060 systemd[1]: Finished modprobe@loop.service - Load Kernel Module loop. Oct 30 23:58:34.570009 systemd[1]: Finished flatcar-tmpfiles.service - Create missing system files. Oct 30 23:58:34.572349 systemd[1]: Finished systemd-network-generator.service - Generate network units from Kernel command line. Oct 30 23:58:34.577074 systemd[1]: Reached target network-pre.target - Preparation for Network. Oct 30 23:58:34.586449 systemd[1]: Mounting sys-fs-fuse-connections.mount - FUSE Control File System... Oct 30 23:58:34.593429 systemd[1]: Mounting sys-kernel-config.mount - Kernel Configuration File System... Oct 30 23:58:34.596407 systemd[1]: remount-root.service - Remount Root File System was skipped because of an unmet condition check (ConditionPathIsReadWrite=!/). Oct 30 23:58:34.596455 systemd[1]: Reached target local-fs.target - Local File Systems. Oct 30 23:58:34.598166 systemd[1]: Listening on systemd-sysext.socket - System Extension Image Management. Oct 30 23:58:34.607516 systemd[1]: Starting dracut-shutdown.service - Restore /run/initramfs on shutdown... Oct 30 23:58:34.612630 systemd[1]: Starting ldconfig.service - Rebuild Dynamic Linker Cache... Oct 30 23:58:34.615124 systemd[1]: systemd-binfmt.service - Set Up Additional Binary Formats was skipped because no trigger condition checks were met. Oct 30 23:58:34.625636 systemd[1]: Starting systemd-hwdb-update.service - Rebuild Hardware Database... Oct 30 23:58:34.630568 systemd[1]: Starting systemd-journal-flush.service - Flush Journal to Persistent Storage... Oct 30 23:58:34.631322 systemd[1]: systemd-pstore.service - Platform Persistent Storage Archival was skipped because of an unmet condition check (ConditionDirectoryNotEmpty=/sys/fs/pstore). Oct 30 23:58:34.640623 systemd[1]: Starting systemd-random-seed.service - Load/Save OS Random Seed... Oct 30 23:58:34.641516 systemd[1]: systemd-repart.service - Repartition Root Disk was skipped because no trigger condition checks were met. Oct 30 23:58:34.644954 systemd[1]: Starting systemd-sysctl.service - Apply Kernel Variables... Oct 30 23:58:34.650518 systemd[1]: Starting systemd-sysext.service - Merge System Extension Images into /usr/ and /opt/... Oct 30 23:58:34.654556 systemd[1]: Starting systemd-tmpfiles-setup-dev-early.service - Create Static Device Nodes in /dev gracefully... Oct 30 23:58:34.657978 systemd[1]: Mounted sys-fs-fuse-connections.mount - FUSE Control File System. Oct 30 23:58:34.661633 systemd[1]: Mounted sys-kernel-config.mount - Kernel Configuration File System. Oct 30 23:58:34.662619 systemd[1]: Finished dracut-shutdown.service - Restore /run/initramfs on shutdown. Oct 30 23:58:34.667423 systemd[1]: Finished systemd-udev-trigger.service - Coldplug All udev Devices. Oct 30 23:58:34.678133 systemd[1]: Starting systemd-udev-settle.service - Wait for udev To Complete Device Initialization... Oct 30 23:58:34.687036 systemd[1]: Finished systemd-random-seed.service - Load/Save OS Random Seed. Oct 30 23:58:34.691754 systemd[1]: Reached target first-boot-complete.target - First Boot Complete. Oct 30 23:58:34.702566 systemd[1]: Starting systemd-machine-id-commit.service - Save Transient machine-id to Disk... Oct 30 23:58:34.718395 systemd-journald[1127]: Time spent on flushing to /var/log/journal/4b8e0b355bbd4375a02a1eae4348f5a0 is 17.151ms for 1118 entries. Oct 30 23:58:34.718395 systemd-journald[1127]: System Journal (/var/log/journal/4b8e0b355bbd4375a02a1eae4348f5a0) is 8M, max 584.8M, 576.8M free. Oct 30 23:58:34.749533 systemd-journald[1127]: Received client request to flush runtime journal. Oct 30 23:58:34.749579 kernel: loop0: detected capacity change from 0 to 8 Oct 30 23:58:34.749592 kernel: squashfs: version 4.0 (2009/01/31) Phillip Lougher Oct 30 23:58:34.741800 systemd[1]: Finished systemd-sysctl.service - Apply Kernel Variables. Oct 30 23:58:34.746913 systemd[1]: Finished systemd-machine-id-commit.service - Save Transient machine-id to Disk. Oct 30 23:58:34.753957 systemd[1]: Finished systemd-journal-flush.service - Flush Journal to Persistent Storage. Oct 30 23:58:34.761894 udevadm[1183]: systemd-udev-settle.service is deprecated. Please fix lvm2-activation-early.service, lvm2-activation.service not to pull it in. Oct 30 23:58:34.775325 kernel: loop1: detected capacity change from 0 to 113512 Oct 30 23:58:34.780687 systemd-tmpfiles[1177]: ACLs are not supported, ignoring. Oct 30 23:58:34.781126 systemd-tmpfiles[1177]: ACLs are not supported, ignoring. Oct 30 23:58:34.793455 systemd[1]: Finished systemd-tmpfiles-setup-dev-early.service - Create Static Device Nodes in /dev gracefully. Oct 30 23:58:34.802541 systemd[1]: Starting systemd-sysusers.service - Create System Users... Oct 30 23:58:34.818345 kernel: loop2: detected capacity change from 0 to 123192 Oct 30 23:58:34.854382 systemd[1]: Finished systemd-sysusers.service - Create System Users. Oct 30 23:58:34.858382 kernel: loop3: detected capacity change from 0 to 8 Oct 30 23:58:34.864573 systemd[1]: Starting systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev... Oct 30 23:58:34.870365 kernel: loop4: detected capacity change from 0 to 113512 Oct 30 23:58:34.889504 kernel: loop5: detected capacity change from 0 to 123192 Oct 30 23:58:34.909493 (sd-merge)[1200]: Using extensions 'containerd-flatcar', 'docker-flatcar', 'oem-hetzner'. Oct 30 23:58:34.909933 (sd-merge)[1200]: Merged extensions into '/usr'. Oct 30 23:58:34.915179 systemd-tmpfiles[1201]: ACLs are not supported, ignoring. Oct 30 23:58:34.915190 systemd-tmpfiles[1201]: ACLs are not supported, ignoring. Oct 30 23:58:34.916856 systemd[1]: Finished systemd-sysext.service - Merge System Extension Images into /usr/ and /opt/. Oct 30 23:58:34.923551 systemd[1]: Starting ensure-sysext.service... Oct 30 23:58:34.927535 systemd[1]: Starting systemd-tmpfiles-setup.service - Create System Files and Directories... Oct 30 23:58:34.928662 systemd[1]: Finished systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev. Oct 30 23:58:34.950792 systemd[1]: Reload requested from client PID 1204 ('systemctl') (unit ensure-sysext.service)... Oct 30 23:58:34.950914 systemd[1]: Reloading... Oct 30 23:58:34.969974 systemd-tmpfiles[1205]: /usr/lib/tmpfiles.d/provision.conf:20: Duplicate line for path "/root", ignoring. Oct 30 23:58:34.970155 systemd-tmpfiles[1205]: /usr/lib/tmpfiles.d/systemd-flatcar.conf:6: Duplicate line for path "/var/log/journal", ignoring. Oct 30 23:58:34.970782 systemd-tmpfiles[1205]: /usr/lib/tmpfiles.d/systemd.conf:29: Duplicate line for path "/var/lib/systemd", ignoring. Oct 30 23:58:34.970963 systemd-tmpfiles[1205]: ACLs are not supported, ignoring. Oct 30 23:58:34.971010 systemd-tmpfiles[1205]: ACLs are not supported, ignoring. Oct 30 23:58:34.979898 systemd-tmpfiles[1205]: Detected autofs mount point /boot during canonicalization of boot. Oct 30 23:58:34.979916 systemd-tmpfiles[1205]: Skipping /boot Oct 30 23:58:35.009098 systemd-tmpfiles[1205]: Detected autofs mount point /boot during canonicalization of boot. Oct 30 23:58:35.009110 systemd-tmpfiles[1205]: Skipping /boot Oct 30 23:58:35.092344 zram_generator::config[1237]: No configuration found. Oct 30 23:58:35.238160 systemd[1]: /usr/lib/systemd/system/docker.socket:6: ListenStream= references a path below legacy directory /var/run/, updating /var/run/docker.sock → /run/docker.sock; please update the unit file accordingly. Oct 30 23:58:35.274347 ldconfig[1171]: /sbin/ldconfig: /usr/lib/ld.so.conf is not an ELF file - it has the wrong magic bytes at the start. Oct 30 23:58:35.306439 systemd[1]: etc-machine\x2did.mount: Deactivated successfully. Oct 30 23:58:35.306777 systemd[1]: Reloading finished in 355 ms. Oct 30 23:58:35.337926 systemd[1]: Finished ldconfig.service - Rebuild Dynamic Linker Cache. Oct 30 23:58:35.341717 systemd[1]: Finished systemd-tmpfiles-setup.service - Create System Files and Directories. Oct 30 23:58:35.371607 systemd[1]: Starting audit-rules.service - Load Audit Rules... Oct 30 23:58:35.382502 systemd[1]: Starting clean-ca-certificates.service - Clean up broken links in /etc/ssl/certs... Oct 30 23:58:35.386537 systemd[1]: Starting systemd-journal-catalog-update.service - Rebuild Journal Catalog... Oct 30 23:58:35.394341 systemd[1]: Starting systemd-resolved.service - Network Name Resolution... Oct 30 23:58:35.401714 systemd[1]: Starting systemd-update-utmp.service - Record System Boot/Shutdown in UTMP... Oct 30 23:58:35.408420 systemd[1]: ignition-delete-config.service - Ignition (delete config) was skipped because no trigger condition checks were met. Oct 30 23:58:35.417460 systemd[1]: Starting modprobe@dm_mod.service - Load Kernel Module dm_mod... Oct 30 23:58:35.422048 systemd[1]: Starting modprobe@efi_pstore.service - Load Kernel Module efi_pstore... Oct 30 23:58:35.425708 systemd[1]: Starting modprobe@loop.service - Load Kernel Module loop... Oct 30 23:58:35.426858 systemd[1]: systemd-binfmt.service - Set Up Additional Binary Formats was skipped because no trigger condition checks were met. Oct 30 23:58:35.427245 systemd[1]: systemd-hibernate-clear.service - Clear Stale Hibernate Storage Info was skipped because of an unmet condition check (ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67). Oct 30 23:58:35.431449 systemd[1]: ignition-delete-config.service - Ignition (delete config) was skipped because no trigger condition checks were met. Oct 30 23:58:35.431622 systemd[1]: systemd-binfmt.service - Set Up Additional Binary Formats was skipped because no trigger condition checks were met. Oct 30 23:58:35.431699 systemd[1]: systemd-hibernate-clear.service - Clear Stale Hibernate Storage Info was skipped because of an unmet condition check (ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67). Oct 30 23:58:35.444607 systemd[1]: Starting systemd-userdbd.service - User Database Manager... Oct 30 23:58:35.453886 systemd[1]: ignition-delete-config.service - Ignition (delete config) was skipped because no trigger condition checks were met. Oct 30 23:58:35.464619 systemd[1]: Starting modprobe@drm.service - Load Kernel Module drm... Oct 30 23:58:35.465348 systemd[1]: systemd-binfmt.service - Set Up Additional Binary Formats was skipped because no trigger condition checks were met. Oct 30 23:58:35.465465 systemd[1]: systemd-hibernate-clear.service - Clear Stale Hibernate Storage Info was skipped because of an unmet condition check (ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67). Oct 30 23:58:35.466355 systemd[1]: Finished systemd-journal-catalog-update.service - Rebuild Journal Catalog. Oct 30 23:58:35.469015 systemd[1]: Finished systemd-update-utmp.service - Record System Boot/Shutdown in UTMP. Oct 30 23:58:35.476537 systemd[1]: modprobe@dm_mod.service: Deactivated successfully. Oct 30 23:58:35.477467 systemd[1]: Finished modprobe@dm_mod.service - Load Kernel Module dm_mod. Oct 30 23:58:35.479115 systemd[1]: modprobe@efi_pstore.service: Deactivated successfully. Oct 30 23:58:35.482425 systemd[1]: Finished modprobe@efi_pstore.service - Load Kernel Module efi_pstore. Oct 30 23:58:35.485013 systemd[1]: Finished ensure-sysext.service. Oct 30 23:58:35.486757 systemd[1]: modprobe@loop.service: Deactivated successfully. Oct 30 23:58:35.486929 systemd[1]: Finished modprobe@loop.service - Load Kernel Module loop. Oct 30 23:58:35.488028 systemd[1]: modprobe@drm.service: Deactivated successfully. Oct 30 23:58:35.488176 systemd[1]: Finished modprobe@drm.service - Load Kernel Module drm. Oct 30 23:58:35.501595 systemd[1]: systemd-pstore.service - Platform Persistent Storage Archival was skipped because of an unmet condition check (ConditionDirectoryNotEmpty=/sys/fs/pstore). Oct 30 23:58:35.501689 systemd[1]: systemd-repart.service - Repartition Root Disk was skipped because no trigger condition checks were met. Oct 30 23:58:35.513503 systemd[1]: Starting systemd-timesyncd.service - Network Time Synchronization... Oct 30 23:58:35.533831 augenrules[1312]: No rules Oct 30 23:58:35.535642 systemd[1]: audit-rules.service: Deactivated successfully. Oct 30 23:58:35.537409 systemd[1]: Finished audit-rules.service - Load Audit Rules. Oct 30 23:58:35.543672 systemd[1]: Started systemd-userdbd.service - User Database Manager. Oct 30 23:58:35.552902 systemd[1]: Finished clean-ca-certificates.service - Clean up broken links in /etc/ssl/certs. Oct 30 23:58:35.554371 systemd[1]: Finished systemd-hwdb-update.service - Rebuild Hardware Database. Oct 30 23:58:35.563588 systemd[1]: Starting systemd-udevd.service - Rule-based Manager for Device Events and Files... Oct 30 23:58:35.574609 systemd[1]: Starting systemd-update-done.service - Update is Completed... Oct 30 23:58:35.575233 systemd[1]: update-ca-certificates.service - Update CA bundle at /etc/ssl/certs/ca-certificates.crt was skipped because of an unmet condition check (ConditionPathIsSymbolicLink=!/etc/ssl/certs/ca-certificates.crt). Oct 30 23:58:35.596230 systemd[1]: Finished systemd-update-done.service - Update is Completed. Oct 30 23:58:35.624440 systemd[1]: Started systemd-timesyncd.service - Network Time Synchronization. Oct 30 23:58:35.625536 systemd[1]: Reached target time-set.target - System Time Set. Oct 30 23:58:35.630812 systemd-udevd[1325]: Using default interface naming scheme 'v255'. Oct 30 23:58:35.657306 systemd[1]: Started systemd-udevd.service - Rule-based Manager for Device Events and Files. Oct 30 23:58:35.660130 systemd-resolved[1278]: Positive Trust Anchors: Oct 30 23:58:35.660148 systemd-resolved[1278]: . IN DS 20326 8 2 e06d44b80b8f1d39a95c0b0d7c65d08458e880409bbc683457104237c7f8ec8d Oct 30 23:58:35.660178 systemd-resolved[1278]: Negative trust anchors: home.arpa 10.in-addr.arpa 16.172.in-addr.arpa 17.172.in-addr.arpa 18.172.in-addr.arpa 19.172.in-addr.arpa 20.172.in-addr.arpa 21.172.in-addr.arpa 22.172.in-addr.arpa 23.172.in-addr.arpa 24.172.in-addr.arpa 25.172.in-addr.arpa 26.172.in-addr.arpa 27.172.in-addr.arpa 28.172.in-addr.arpa 29.172.in-addr.arpa 30.172.in-addr.arpa 31.172.in-addr.arpa 170.0.0.192.in-addr.arpa 171.0.0.192.in-addr.arpa 168.192.in-addr.arpa d.f.ip6.arpa ipv4only.arpa resolver.arpa corp home internal intranet lan local private test Oct 30 23:58:35.668506 systemd[1]: Starting systemd-networkd.service - Network Configuration... Oct 30 23:58:35.680309 systemd-resolved[1278]: Using system hostname 'ci-4230-2-4-n-a8cc557c56'. Oct 30 23:58:35.684572 systemd[1]: Started systemd-resolved.service - Network Name Resolution. Oct 30 23:58:35.685451 systemd[1]: Reached target nss-lookup.target - Host and Network Name Lookups. Oct 30 23:58:35.737275 systemd[1]: Condition check resulted in dev-ttyAMA0.device - /dev/ttyAMA0 being skipped. Oct 30 23:58:35.771923 systemd-networkd[1336]: lo: Link UP Oct 30 23:58:35.772437 systemd-networkd[1336]: lo: Gained carrier Oct 30 23:58:35.780055 systemd-networkd[1336]: Enumeration completed Oct 30 23:58:35.780470 systemd[1]: Started systemd-networkd.service - Network Configuration. Oct 30 23:58:35.781484 systemd[1]: Reached target network.target - Network. Oct 30 23:58:35.789542 systemd[1]: Starting systemd-networkd-persistent-storage.service - Enable Persistent Storage in systemd-networkd... Oct 30 23:58:35.795226 systemd[1]: Starting systemd-networkd-wait-online.service - Wait for Network to be Configured... Oct 30 23:58:35.812066 systemd[1]: Finished systemd-networkd-persistent-storage.service - Enable Persistent Storage in systemd-networkd. Oct 30 23:58:35.835121 systemd-networkd[1336]: eth1: found matching network '/usr/lib/systemd/network/zz-default.network', based on potentially unpredictable interface name. Oct 30 23:58:35.835133 systemd-networkd[1336]: eth1: Configuring with /usr/lib/systemd/network/zz-default.network. Oct 30 23:58:35.837020 systemd-networkd[1336]: eth1: Link UP Oct 30 23:58:35.837035 systemd-networkd[1336]: eth1: Gained carrier Oct 30 23:58:35.837071 systemd-networkd[1336]: eth1: found matching network '/usr/lib/systemd/network/zz-default.network', based on potentially unpredictable interface name. Oct 30 23:58:35.845558 systemd-networkd[1336]: eth0: found matching network '/usr/lib/systemd/network/zz-default.network', based on potentially unpredictable interface name. Oct 30 23:58:35.845569 systemd-networkd[1336]: eth0: Configuring with /usr/lib/systemd/network/zz-default.network. Oct 30 23:58:35.846082 systemd-networkd[1336]: eth0: Link UP Oct 30 23:58:35.846085 systemd-networkd[1336]: eth0: Gained carrier Oct 30 23:58:35.846101 systemd-networkd[1336]: eth0: found matching network '/usr/lib/systemd/network/zz-default.network', based on potentially unpredictable interface name. Oct 30 23:58:35.867502 systemd-networkd[1336]: eth1: DHCPv4 address 10.0.0.3/32 acquired from 10.0.0.1 Oct 30 23:58:35.868554 systemd-timesyncd[1308]: Network configuration changed, trying to establish connection. Oct 30 23:58:35.887310 kernel: mousedev: PS/2 mouse device common for all mice Oct 30 23:58:35.896411 systemd-networkd[1336]: eth0: DHCPv4 address 116.202.99.226/32, gateway 172.31.1.1 acquired from 172.31.1.1 Oct 30 23:58:35.897354 systemd-timesyncd[1308]: Network configuration changed, trying to establish connection. Oct 30 23:58:35.911157 systemd[1]: Condition check resulted in dev-virtio\x2dports-org.qemu.guest_agent.0.device - /dev/virtio-ports/org.qemu.guest_agent.0 being skipped. Oct 30 23:58:35.911610 systemd[1]: ignition-delete-config.service - Ignition (delete config) was skipped because no trigger condition checks were met. Oct 30 23:58:35.918814 systemd[1]: Starting modprobe@dm_mod.service - Load Kernel Module dm_mod... Oct 30 23:58:35.923048 systemd[1]: Starting modprobe@efi_pstore.service - Load Kernel Module efi_pstore... Oct 30 23:58:35.932563 systemd[1]: Starting modprobe@loop.service - Load Kernel Module loop... Oct 30 23:58:35.933178 systemd[1]: systemd-binfmt.service - Set Up Additional Binary Formats was skipped because no trigger condition checks were met. Oct 30 23:58:35.933278 systemd[1]: systemd-hibernate-clear.service - Clear Stale Hibernate Storage Info was skipped because of an unmet condition check (ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67). Oct 30 23:58:35.933316 systemd[1]: update-ca-certificates.service - Update CA bundle at /etc/ssl/certs/ca-certificates.crt was skipped because of an unmet condition check (ConditionPathIsSymbolicLink=!/etc/ssl/certs/ca-certificates.crt). Oct 30 23:58:35.933707 systemd[1]: modprobe@dm_mod.service: Deactivated successfully. Oct 30 23:58:35.934371 systemd[1]: Finished modprobe@dm_mod.service - Load Kernel Module dm_mod. Oct 30 23:58:35.947307 kernel: BTRFS warning: duplicate device /dev/sda3 devid 1 generation 38 scanned by (udev-worker) (1332) Oct 30 23:58:35.950867 systemd[1]: modprobe@efi_pstore.service: Deactivated successfully. Oct 30 23:58:35.951374 systemd[1]: Finished modprobe@efi_pstore.service - Load Kernel Module efi_pstore. Oct 30 23:58:35.953051 systemd[1]: modprobe@loop.service: Deactivated successfully. Oct 30 23:58:35.953789 systemd[1]: Finished modprobe@loop.service - Load Kernel Module loop. Oct 30 23:58:35.956715 systemd[1]: systemd-pstore.service - Platform Persistent Storage Archival was skipped because of an unmet condition check (ConditionDirectoryNotEmpty=/sys/fs/pstore). Oct 30 23:58:35.956765 systemd[1]: systemd-repart.service - Repartition Root Disk was skipped because no trigger condition checks were met. Oct 30 23:58:36.028096 kernel: [drm] pci: virtio-gpu-pci detected at 0000:00:01.0 Oct 30 23:58:36.028316 kernel: [drm] features: -virgl +edid -resource_blob -host_visible Oct 30 23:58:36.028338 kernel: [drm] features: -context_init Oct 30 23:58:36.034323 kernel: [drm] number of scanouts: 1 Oct 30 23:58:36.034396 kernel: [drm] number of cap sets: 0 Oct 30 23:58:36.037313 kernel: [drm] Initialized virtio_gpu 0.1.0 0 for 0000:00:01.0 on minor 0 Oct 30 23:58:36.047621 kernel: Console: switching to colour frame buffer device 160x50 Oct 30 23:58:36.046727 systemd[1]: Starting systemd-vconsole-setup.service - Virtual Console Setup... Oct 30 23:58:36.051347 kernel: virtio-pci 0000:00:01.0: [drm] fb0: virtio_gpudrmfb frame buffer device Oct 30 23:58:36.072502 systemd[1]: Found device dev-disk-by\x2dlabel-OEM.device - QEMU_HARDDISK OEM. Oct 30 23:58:36.079511 systemd[1]: Starting systemd-fsck@dev-disk-by\x2dlabel-OEM.service - File System Check on /dev/disk/by-label/OEM... Oct 30 23:58:36.083079 systemd[1]: systemd-vconsole-setup.service: Deactivated successfully. Oct 30 23:58:36.085363 systemd[1]: Stopped systemd-vconsole-setup.service - Virtual Console Setup. Oct 30 23:58:36.089248 systemd[1]: run-credentials-systemd\x2dvconsole\x2dsetup.service.mount: Deactivated successfully. Oct 30 23:58:36.095568 systemd[1]: Starting systemd-vconsole-setup.service - Virtual Console Setup... Oct 30 23:58:36.096713 systemd[1]: Finished systemd-fsck@dev-disk-by\x2dlabel-OEM.service - File System Check on /dev/disk/by-label/OEM. Oct 30 23:58:36.157419 systemd[1]: Finished systemd-vconsole-setup.service - Virtual Console Setup. Oct 30 23:58:36.194505 systemd[1]: Finished systemd-udev-settle.service - Wait for udev To Complete Device Initialization. Oct 30 23:58:36.203235 systemd[1]: Starting lvm2-activation-early.service - Activation of LVM2 logical volumes... Oct 30 23:58:36.216953 lvm[1398]: WARNING: Failed to connect to lvmetad. Falling back to device scanning. Oct 30 23:58:36.247410 systemd[1]: Finished lvm2-activation-early.service - Activation of LVM2 logical volumes. Oct 30 23:58:36.248850 systemd[1]: Reached target cryptsetup.target - Local Encrypted Volumes. Oct 30 23:58:36.250569 systemd[1]: Reached target sysinit.target - System Initialization. Oct 30 23:58:36.252333 systemd[1]: Started motdgen.path - Watch for update engine configuration changes. Oct 30 23:58:36.253077 systemd[1]: Started user-cloudinit@var-lib-flatcar\x2dinstall-user_data.path - Watch for a cloud-config at /var/lib/flatcar-install/user_data. Oct 30 23:58:36.254089 systemd[1]: Started logrotate.timer - Daily rotation of log files. Oct 30 23:58:36.254958 systemd[1]: Started mdadm.timer - Weekly check for MD array's redundancy information.. Oct 30 23:58:36.256609 systemd[1]: Started systemd-tmpfiles-clean.timer - Daily Cleanup of Temporary Directories. Oct 30 23:58:36.257382 systemd[1]: update-engine-stub.timer - Update Engine Stub Timer was skipped because of an unmet condition check (ConditionPathExists=/usr/.noupdate). Oct 30 23:58:36.257422 systemd[1]: Reached target paths.target - Path Units. Oct 30 23:58:36.257967 systemd[1]: Reached target timers.target - Timer Units. Oct 30 23:58:36.259957 systemd[1]: Listening on dbus.socket - D-Bus System Message Bus Socket. Oct 30 23:58:36.262160 systemd[1]: Starting docker.socket - Docker Socket for the API... Oct 30 23:58:36.265792 systemd[1]: Listening on sshd-unix-local.socket - OpenSSH Server Socket (systemd-ssh-generator, AF_UNIX Local). Oct 30 23:58:36.266914 systemd[1]: Listening on sshd-vsock.socket - OpenSSH Server Socket (systemd-ssh-generator, AF_VSOCK). Oct 30 23:58:36.267776 systemd[1]: Reached target ssh-access.target - SSH Access Available. Oct 30 23:58:36.270935 systemd[1]: Listening on sshd.socket - OpenSSH Server Socket. Oct 30 23:58:36.272217 systemd[1]: Listening on systemd-hostnamed.socket - Hostname Service Socket. Oct 30 23:58:36.274519 systemd[1]: Starting lvm2-activation.service - Activation of LVM2 logical volumes... Oct 30 23:58:36.275846 systemd[1]: Listening on docker.socket - Docker Socket for the API. Oct 30 23:58:36.276767 systemd[1]: Reached target sockets.target - Socket Units. Oct 30 23:58:36.277373 systemd[1]: Reached target basic.target - Basic System. Oct 30 23:58:36.277947 systemd[1]: addon-config@oem.service - Configure Addon /oem was skipped because no trigger condition checks were met. Oct 30 23:58:36.277978 systemd[1]: addon-run@oem.service - Run Addon /oem was skipped because no trigger condition checks were met. Oct 30 23:58:36.285526 systemd[1]: Starting containerd.service - containerd container runtime... Oct 30 23:58:36.291767 systemd[1]: Starting coreos-metadata.service - Flatcar Metadata Agent... Oct 30 23:58:36.295054 lvm[1402]: WARNING: Failed to connect to lvmetad. Falling back to device scanning. Oct 30 23:58:36.297744 systemd[1]: Starting dbus.service - D-Bus System Message Bus... Oct 30 23:58:36.300794 systemd[1]: Starting enable-oem-cloudinit.service - Enable cloudinit... Oct 30 23:58:36.306749 systemd[1]: Starting extend-filesystems.service - Extend Filesystems... Oct 30 23:58:36.308381 systemd[1]: flatcar-setup-environment.service - Modifies /etc/environment for CoreOS was skipped because of an unmet condition check (ConditionPathExists=/oem/bin/flatcar-setup-environment). Oct 30 23:58:36.309676 systemd[1]: Starting motdgen.service - Generate /run/flatcar/motd... Oct 30 23:58:36.316536 systemd[1]: Started qemu-guest-agent.service - QEMU Guest Agent. Oct 30 23:58:36.319666 jq[1406]: false Oct 30 23:58:36.321461 systemd[1]: Starting ssh-key-proc-cmdline.service - Install an ssh key from /proc/cmdline... Oct 30 23:58:36.334247 systemd[1]: Starting sshd-keygen.service - Generate sshd host keys... Oct 30 23:58:36.343110 systemd[1]: Starting systemd-logind.service - User Login Management... Oct 30 23:58:36.347548 systemd[1]: tcsd.service - TCG Core Services Daemon was skipped because of an unmet condition check (ConditionPathExists=/dev/tpm0). Oct 30 23:58:36.349196 systemd[1]: cgroup compatibility translation between legacy and unified hierarchy settings activated. See cgroup-compat debug messages for details. Oct 30 23:58:36.353669 systemd[1]: Starting update-engine.service - Update Engine... Oct 30 23:58:36.356527 systemd[1]: Starting update-ssh-keys-after-ignition.service - Run update-ssh-keys once after Ignition... Oct 30 23:58:36.370072 systemd[1]: Finished lvm2-activation.service - Activation of LVM2 logical volumes. Oct 30 23:58:36.374765 systemd[1]: enable-oem-cloudinit.service: Skipped due to 'exec-condition'. Oct 30 23:58:36.375494 systemd[1]: Condition check resulted in enable-oem-cloudinit.service - Enable cloudinit being skipped. Oct 30 23:58:36.381212 jq[1421]: true Oct 30 23:58:36.396241 systemd[1]: ssh-key-proc-cmdline.service: Deactivated successfully. Oct 30 23:58:36.396508 systemd[1]: Finished ssh-key-proc-cmdline.service - Install an ssh key from /proc/cmdline. Oct 30 23:58:36.419797 dbus-daemon[1405]: [system] SELinux support is enabled Oct 30 23:58:36.419990 systemd[1]: Started dbus.service - D-Bus System Message Bus. Oct 30 23:58:36.423042 jq[1428]: true Oct 30 23:58:36.425575 systemd[1]: motdgen.service: Deactivated successfully. Oct 30 23:58:36.427080 systemd[1]: Finished motdgen.service - Generate /run/flatcar/motd. Oct 30 23:58:36.440917 systemd[1]: system-cloudinit@usr-share-oem-cloud\x2dconfig.yml.service - Load cloud-config from /usr/share/oem/cloud-config.yml was skipped because of an unmet condition check (ConditionFileNotEmpty=/usr/share/oem/cloud-config.yml). Oct 30 23:58:36.445066 extend-filesystems[1407]: Found loop3 Oct 30 23:58:36.440998 systemd[1]: Reached target system-config.target - Load system-provided cloud configs. Oct 30 23:58:36.454214 extend-filesystems[1407]: Found loop4 Oct 30 23:58:36.454214 extend-filesystems[1407]: Found loop5 Oct 30 23:58:36.454214 extend-filesystems[1407]: Found sda Oct 30 23:58:36.454214 extend-filesystems[1407]: Found sda1 Oct 30 23:58:36.454214 extend-filesystems[1407]: Found sda2 Oct 30 23:58:36.454214 extend-filesystems[1407]: Found sda3 Oct 30 23:58:36.454214 extend-filesystems[1407]: Found usr Oct 30 23:58:36.454214 extend-filesystems[1407]: Found sda4 Oct 30 23:58:36.454214 extend-filesystems[1407]: Found sda6 Oct 30 23:58:36.454214 extend-filesystems[1407]: Found sda7 Oct 30 23:58:36.454214 extend-filesystems[1407]: Found sda9 Oct 30 23:58:36.454214 extend-filesystems[1407]: Checking size of /dev/sda9 Oct 30 23:58:36.443133 systemd[1]: user-cloudinit-proc-cmdline.service - Load cloud-config from url defined in /proc/cmdline was skipped because of an unmet condition check (ConditionKernelCommandLine=cloud-config-url). Oct 30 23:58:36.479827 update_engine[1420]: I20251030 23:58:36.454969 1420 main.cc:92] Flatcar Update Engine starting Oct 30 23:58:36.479827 update_engine[1420]: I20251030 23:58:36.472415 1420 update_check_scheduler.cc:74] Next update check in 3m50s Oct 30 23:58:36.481201 coreos-metadata[1404]: Oct 30 23:58:36.458 INFO Fetching http://169.254.169.254/hetzner/v1/metadata: Attempt #1 Oct 30 23:58:36.481201 coreos-metadata[1404]: Oct 30 23:58:36.459 INFO Fetch successful Oct 30 23:58:36.481201 coreos-metadata[1404]: Oct 30 23:58:36.462 INFO Fetching http://169.254.169.254/hetzner/v1/metadata/private-networks: Attempt #1 Oct 30 23:58:36.481201 coreos-metadata[1404]: Oct 30 23:58:36.462 INFO Fetch successful Oct 30 23:58:36.443154 systemd[1]: Reached target user-config.target - Load user-provided cloud configs. Oct 30 23:58:36.450667 (ntainerd)[1436]: containerd.service: Referenced but unset environment variable evaluates to an empty string: TORCX_IMAGEDIR, TORCX_UNPACKDIR Oct 30 23:58:36.465821 systemd[1]: Started update-engine.service - Update Engine. Oct 30 23:58:36.480543 systemd[1]: Started locksmithd.service - Cluster reboot manager. Oct 30 23:58:36.506853 extend-filesystems[1407]: Resized partition /dev/sda9 Oct 30 23:58:36.513859 extend-filesystems[1458]: resize2fs 1.47.1 (20-May-2024) Oct 30 23:58:36.528894 kernel: EXT4-fs (sda9): resizing filesystem from 1617920 to 9393147 blocks Oct 30 23:58:36.568797 systemd-logind[1417]: New seat seat0. Oct 30 23:58:36.592576 systemd[1]: Finished coreos-metadata.service - Flatcar Metadata Agent. Oct 30 23:58:36.593634 systemd[1]: packet-phone-home.service - Report Success to Packet was skipped because no trigger condition checks were met. Oct 30 23:58:36.600741 systemd-logind[1417]: Watching system buttons on /dev/input/event0 (Power Button) Oct 30 23:58:36.600758 systemd-logind[1417]: Watching system buttons on /dev/input/event2 (QEMU QEMU USB Keyboard) Oct 30 23:58:36.601509 systemd[1]: Started systemd-logind.service - User Login Management. Oct 30 23:58:36.616997 kernel: BTRFS warning: duplicate device /dev/sda3 devid 1 generation 38 scanned by (udev-worker) (1333) Oct 30 23:58:36.650539 bash[1467]: Updated "/home/core/.ssh/authorized_keys" Oct 30 23:58:36.654332 systemd[1]: Finished update-ssh-keys-after-ignition.service - Run update-ssh-keys once after Ignition. Oct 30 23:58:36.683041 systemd[1]: Starting sshkeys.service... Oct 30 23:58:36.721540 kernel: EXT4-fs (sda9): resized filesystem to 9393147 Oct 30 23:58:36.730108 systemd[1]: Created slice system-coreos\x2dmetadata\x2dsshkeys.slice - Slice /system/coreos-metadata-sshkeys. Oct 30 23:58:36.739687 systemd[1]: Starting coreos-metadata-sshkeys@core.service - Flatcar Metadata Agent (SSH Keys)... Oct 30 23:58:36.755430 extend-filesystems[1458]: Filesystem at /dev/sda9 is mounted on /; on-line resizing required Oct 30 23:58:36.755430 extend-filesystems[1458]: old_desc_blocks = 1, new_desc_blocks = 5 Oct 30 23:58:36.755430 extend-filesystems[1458]: The filesystem on /dev/sda9 is now 9393147 (4k) blocks long. Oct 30 23:58:36.762017 extend-filesystems[1407]: Resized filesystem in /dev/sda9 Oct 30 23:58:36.762017 extend-filesystems[1407]: Found sr0 Oct 30 23:58:36.759506 systemd[1]: extend-filesystems.service: Deactivated successfully. Oct 30 23:58:36.762564 systemd[1]: Finished extend-filesystems.service - Extend Filesystems. Oct 30 23:58:36.786441 locksmithd[1444]: locksmithd starting currentOperation="UPDATE_STATUS_IDLE" strategy="reboot" Oct 30 23:58:36.789727 coreos-metadata[1484]: Oct 30 23:58:36.789 INFO Fetching http://169.254.169.254/hetzner/v1/metadata/public-keys: Attempt #1 Oct 30 23:58:36.795838 coreos-metadata[1484]: Oct 30 23:58:36.795 INFO Fetch successful Oct 30 23:58:36.799971 unknown[1484]: wrote ssh authorized keys file for user: core Oct 30 23:58:36.823076 update-ssh-keys[1489]: Updated "/home/core/.ssh/authorized_keys" Oct 30 23:58:36.823633 systemd[1]: Finished coreos-metadata-sshkeys@core.service - Flatcar Metadata Agent (SSH Keys). Oct 30 23:58:36.829965 systemd[1]: Finished sshkeys.service. Oct 30 23:58:36.834682 containerd[1436]: time="2025-10-30T23:58:36.834542200Z" level=info msg="starting containerd" revision=9b2ad7760328148397346d10c7b2004271249db4 version=v1.7.23 Oct 30 23:58:36.864620 containerd[1436]: time="2025-10-30T23:58:36.864556360Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.aufs\"..." type=io.containerd.snapshotter.v1 Oct 30 23:58:36.866293 containerd[1436]: time="2025-10-30T23:58:36.866017200Z" 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.113-flatcar\\n\"): skip plugin" type=io.containerd.snapshotter.v1 Oct 30 23:58:36.866293 containerd[1436]: time="2025-10-30T23:58:36.866060680Z" level=info msg="loading plugin \"io.containerd.event.v1.exchange\"..." type=io.containerd.event.v1 Oct 30 23:58:36.866293 containerd[1436]: time="2025-10-30T23:58:36.866080520Z" level=info msg="loading plugin \"io.containerd.internal.v1.opt\"..." type=io.containerd.internal.v1 Oct 30 23:58:36.866422 containerd[1436]: time="2025-10-30T23:58:36.866314960Z" level=info msg="loading plugin \"io.containerd.warning.v1.deprecations\"..." type=io.containerd.warning.v1 Oct 30 23:58:36.866422 containerd[1436]: time="2025-10-30T23:58:36.866336240Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.blockfile\"..." type=io.containerd.snapshotter.v1 Oct 30 23:58:36.866422 containerd[1436]: time="2025-10-30T23:58:36.866400160Z" level=info msg="skip loading plugin \"io.containerd.snapshotter.v1.blockfile\"..." error="no scratch file generator: skip plugin" type=io.containerd.snapshotter.v1 Oct 30 23:58:36.866422 containerd[1436]: time="2025-10-30T23:58:36.866413160Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.btrfs\"..." type=io.containerd.snapshotter.v1 Oct 30 23:58:36.866644 containerd[1436]: time="2025-10-30T23:58:36.866617360Z" 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 Oct 30 23:58:36.866675 containerd[1436]: time="2025-10-30T23:58:36.866643320Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.devmapper\"..." type=io.containerd.snapshotter.v1 Oct 30 23:58:36.866675 containerd[1436]: time="2025-10-30T23:58:36.866657680Z" level=info msg="skip loading plugin \"io.containerd.snapshotter.v1.devmapper\"..." error="devmapper not configured: skip plugin" type=io.containerd.snapshotter.v1 Oct 30 23:58:36.866675 containerd[1436]: time="2025-10-30T23:58:36.866667720Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.native\"..." type=io.containerd.snapshotter.v1 Oct 30 23:58:36.867315 containerd[1436]: time="2025-10-30T23:58:36.866736800Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.overlayfs\"..." type=io.containerd.snapshotter.v1 Oct 30 23:58:36.867315 containerd[1436]: time="2025-10-30T23:58:36.866931600Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.zfs\"..." type=io.containerd.snapshotter.v1 Oct 30 23:58:36.867315 containerd[1436]: time="2025-10-30T23:58:36.867055400Z" level=info msg="skip loading plugin \"io.containerd.snapshotter.v1.zfs\"..." error="path /var/lib/containerd/io.containerd.snapshotter.v1.zfs must be a zfs filesystem to be used with the zfs snapshotter: skip plugin" type=io.containerd.snapshotter.v1 Oct 30 23:58:36.867315 containerd[1436]: time="2025-10-30T23:58:36.867069240Z" level=info msg="loading plugin \"io.containerd.content.v1.content\"..." type=io.containerd.content.v1 Oct 30 23:58:36.867315 containerd[1436]: time="2025-10-30T23:58:36.867140520Z" level=info msg="loading plugin \"io.containerd.metadata.v1.bolt\"..." type=io.containerd.metadata.v1 Oct 30 23:58:36.867315 containerd[1436]: time="2025-10-30T23:58:36.867197120Z" level=info msg="metadata content store policy set" policy=shared Oct 30 23:58:36.874493 systemd-networkd[1336]: eth1: Gained IPv6LL Oct 30 23:58:36.875080 systemd-timesyncd[1308]: Network configuration changed, trying to establish connection. Oct 30 23:58:36.879504 systemd[1]: Finished systemd-networkd-wait-online.service - Wait for Network to be Configured. Oct 30 23:58:36.880562 containerd[1436]: time="2025-10-30T23:58:36.880522680Z" level=info msg="loading plugin \"io.containerd.gc.v1.scheduler\"..." type=io.containerd.gc.v1 Oct 30 23:58:36.880624 containerd[1436]: time="2025-10-30T23:58:36.880608800Z" level=info msg="loading plugin \"io.containerd.differ.v1.walking\"..." type=io.containerd.differ.v1 Oct 30 23:58:36.880652 containerd[1436]: time="2025-10-30T23:58:36.880629400Z" level=info msg="loading plugin \"io.containerd.lease.v1.manager\"..." type=io.containerd.lease.v1 Oct 30 23:58:36.880700 containerd[1436]: time="2025-10-30T23:58:36.880648280Z" level=info msg="loading plugin \"io.containerd.streaming.v1.manager\"..." type=io.containerd.streaming.v1 Oct 30 23:58:36.880718 containerd[1436]: time="2025-10-30T23:58:36.880701320Z" level=info msg="loading plugin \"io.containerd.runtime.v1.linux\"..." type=io.containerd.runtime.v1 Oct 30 23:58:36.880894 containerd[1436]: time="2025-10-30T23:58:36.880873080Z" level=info msg="loading plugin \"io.containerd.monitor.v1.cgroups\"..." type=io.containerd.monitor.v1 Oct 30 23:58:36.881207 containerd[1436]: time="2025-10-30T23:58:36.881185720Z" level=info msg="loading plugin \"io.containerd.runtime.v2.task\"..." type=io.containerd.runtime.v2 Oct 30 23:58:36.881635 containerd[1436]: time="2025-10-30T23:58:36.881609640Z" level=info msg="loading plugin \"io.containerd.runtime.v2.shim\"..." type=io.containerd.runtime.v2 Oct 30 23:58:36.881673 containerd[1436]: time="2025-10-30T23:58:36.881635440Z" level=info msg="loading plugin \"io.containerd.sandbox.store.v1.local\"..." type=io.containerd.sandbox.store.v1 Oct 30 23:58:36.881673 containerd[1436]: time="2025-10-30T23:58:36.881655120Z" level=info msg="loading plugin \"io.containerd.sandbox.controller.v1.local\"..." type=io.containerd.sandbox.controller.v1 Oct 30 23:58:36.881673 containerd[1436]: time="2025-10-30T23:58:36.881668600Z" level=info msg="loading plugin \"io.containerd.service.v1.containers-service\"..." type=io.containerd.service.v1 Oct 30 23:58:36.881719 containerd[1436]: time="2025-10-30T23:58:36.881681280Z" level=info msg="loading plugin \"io.containerd.service.v1.content-service\"..." type=io.containerd.service.v1 Oct 30 23:58:36.881719 containerd[1436]: time="2025-10-30T23:58:36.881693520Z" level=info msg="loading plugin \"io.containerd.service.v1.diff-service\"..." type=io.containerd.service.v1 Oct 30 23:58:36.881719 containerd[1436]: time="2025-10-30T23:58:36.881707280Z" level=info msg="loading plugin \"io.containerd.service.v1.images-service\"..." type=io.containerd.service.v1 Oct 30 23:58:36.881780 containerd[1436]: time="2025-10-30T23:58:36.881722240Z" level=info msg="loading plugin \"io.containerd.service.v1.introspection-service\"..." type=io.containerd.service.v1 Oct 30 23:58:36.881780 containerd[1436]: time="2025-10-30T23:58:36.881735960Z" level=info msg="loading plugin \"io.containerd.service.v1.namespaces-service\"..." type=io.containerd.service.v1 Oct 30 23:58:36.881780 containerd[1436]: time="2025-10-30T23:58:36.881748120Z" level=info msg="loading plugin \"io.containerd.service.v1.snapshots-service\"..." type=io.containerd.service.v1 Oct 30 23:58:36.881780 containerd[1436]: time="2025-10-30T23:58:36.881760720Z" level=info msg="loading plugin \"io.containerd.service.v1.tasks-service\"..." type=io.containerd.service.v1 Oct 30 23:58:36.881839 containerd[1436]: time="2025-10-30T23:58:36.881780960Z" level=info msg="loading plugin \"io.containerd.grpc.v1.containers\"..." type=io.containerd.grpc.v1 Oct 30 23:58:36.881839 containerd[1436]: time="2025-10-30T23:58:36.881796480Z" level=info msg="loading plugin \"io.containerd.grpc.v1.content\"..." type=io.containerd.grpc.v1 Oct 30 23:58:36.881839 containerd[1436]: time="2025-10-30T23:58:36.881809160Z" level=info msg="loading plugin \"io.containerd.grpc.v1.diff\"..." type=io.containerd.grpc.v1 Oct 30 23:58:36.881839 containerd[1436]: time="2025-10-30T23:58:36.881822920Z" level=info msg="loading plugin \"io.containerd.grpc.v1.events\"..." type=io.containerd.grpc.v1 Oct 30 23:58:36.881839 containerd[1436]: time="2025-10-30T23:58:36.881834600Z" level=info msg="loading plugin \"io.containerd.grpc.v1.images\"..." type=io.containerd.grpc.v1 Oct 30 23:58:36.881921 containerd[1436]: time="2025-10-30T23:58:36.881847800Z" level=info msg="loading plugin \"io.containerd.grpc.v1.introspection\"..." type=io.containerd.grpc.v1 Oct 30 23:58:36.881921 containerd[1436]: time="2025-10-30T23:58:36.881860960Z" level=info msg="loading plugin \"io.containerd.grpc.v1.leases\"..." type=io.containerd.grpc.v1 Oct 30 23:58:36.881921 containerd[1436]: time="2025-10-30T23:58:36.881876560Z" level=info msg="loading plugin \"io.containerd.grpc.v1.namespaces\"..." type=io.containerd.grpc.v1 Oct 30 23:58:36.881921 containerd[1436]: time="2025-10-30T23:58:36.881888960Z" level=info msg="loading plugin \"io.containerd.grpc.v1.sandbox-controllers\"..." type=io.containerd.grpc.v1 Oct 30 23:58:36.881921 containerd[1436]: time="2025-10-30T23:58:36.881902720Z" level=info msg="loading plugin \"io.containerd.grpc.v1.sandboxes\"..." type=io.containerd.grpc.v1 Oct 30 23:58:36.881921 containerd[1436]: time="2025-10-30T23:58:36.881914160Z" level=info msg="loading plugin \"io.containerd.grpc.v1.snapshots\"..." type=io.containerd.grpc.v1 Oct 30 23:58:36.882012 containerd[1436]: time="2025-10-30T23:58:36.881926480Z" level=info msg="loading plugin \"io.containerd.grpc.v1.streaming\"..." type=io.containerd.grpc.v1 Oct 30 23:58:36.882012 containerd[1436]: time="2025-10-30T23:58:36.881939360Z" level=info msg="loading plugin \"io.containerd.grpc.v1.tasks\"..." type=io.containerd.grpc.v1 Oct 30 23:58:36.882012 containerd[1436]: time="2025-10-30T23:58:36.881957600Z" level=info msg="loading plugin \"io.containerd.transfer.v1.local\"..." type=io.containerd.transfer.v1 Oct 30 23:58:36.882012 containerd[1436]: time="2025-10-30T23:58:36.881979280Z" level=info msg="loading plugin \"io.containerd.grpc.v1.transfer\"..." type=io.containerd.grpc.v1 Oct 30 23:58:36.882012 containerd[1436]: time="2025-10-30T23:58:36.881992960Z" level=info msg="loading plugin \"io.containerd.grpc.v1.version\"..." type=io.containerd.grpc.v1 Oct 30 23:58:36.882012 containerd[1436]: time="2025-10-30T23:58:36.882003240Z" level=info msg="loading plugin \"io.containerd.internal.v1.restart\"..." type=io.containerd.internal.v1 Oct 30 23:58:36.882645 systemd[1]: Reached target network-online.target - Network is Online. Oct 30 23:58:36.883439 containerd[1436]: time="2025-10-30T23:58:36.883400960Z" level=info msg="loading plugin \"io.containerd.tracing.processor.v1.otlp\"..." type=io.containerd.tracing.processor.v1 Oct 30 23:58:36.883488 containerd[1436]: time="2025-10-30T23:58:36.883453800Z" level=info msg="skip loading plugin \"io.containerd.tracing.processor.v1.otlp\"..." error="skip plugin: tracing endpoint not configured" type=io.containerd.tracing.processor.v1 Oct 30 23:58:36.883488 containerd[1436]: time="2025-10-30T23:58:36.883467680Z" level=info msg="loading plugin \"io.containerd.internal.v1.tracing\"..." type=io.containerd.internal.v1 Oct 30 23:58:36.883488 containerd[1436]: time="2025-10-30T23:58:36.883479800Z" level=info msg="skip loading plugin \"io.containerd.internal.v1.tracing\"..." error="skip plugin: tracing endpoint not configured" type=io.containerd.internal.v1 Oct 30 23:58:36.883542 containerd[1436]: time="2025-10-30T23:58:36.883489440Z" level=info msg="loading plugin \"io.containerd.grpc.v1.healthcheck\"..." type=io.containerd.grpc.v1 Oct 30 23:58:36.883542 containerd[1436]: time="2025-10-30T23:58:36.883504760Z" level=info msg="loading plugin \"io.containerd.nri.v1.nri\"..." type=io.containerd.nri.v1 Oct 30 23:58:36.883542 containerd[1436]: time="2025-10-30T23:58:36.883515680Z" level=info msg="NRI interface is disabled by configuration." Oct 30 23:58:36.883542 containerd[1436]: time="2025-10-30T23:58:36.883525800Z" level=info msg="loading plugin \"io.containerd.grpc.v1.cri\"..." type=io.containerd.grpc.v1 Oct 30 23:58:36.885322 containerd[1436]: time="2025-10-30T23:58:36.883881720Z" level=info msg="Start cri plugin with config {PluginConfig:{ContainerdConfig:{Snapshotter:overlayfs DefaultRuntimeName:runc DefaultRuntime:{Type: Path: Engine: PodAnnotations:[] ContainerAnnotations:[] Root: Options:map[] PrivilegedWithoutHostDevices:false PrivilegedWithoutHostDevicesAllDevicesAllowed:false BaseRuntimeSpec: NetworkPluginConfDir: NetworkPluginMaxConfNum:0 Snapshotter: SandboxMode:} UntrustedWorkloadRuntime:{Type: Path: Engine: PodAnnotations:[] ContainerAnnotations:[] Root: Options:map[] PrivilegedWithoutHostDevices:false PrivilegedWithoutHostDevicesAllDevicesAllowed:false BaseRuntimeSpec: NetworkPluginConfDir: NetworkPluginMaxConfNum:0 Snapshotter: SandboxMode:} Runtimes:map[runc:{Type:io.containerd.runc.v2 Path: Engine: PodAnnotations:[] ContainerAnnotations:[] Root: Options:map[SystemdCgroup:true] PrivilegedWithoutHostDevices:false PrivilegedWithoutHostDevicesAllDevicesAllowed:false BaseRuntimeSpec: NetworkPluginConfDir: NetworkPluginMaxConfNum:0 Snapshotter: SandboxMode:podsandbox}] NoPivot:false DisableSnapshotAnnotations:true DiscardUnpackedLayers:false IgnoreBlockIONotEnabledErrors:false IgnoreRdtNotEnabledErrors:false} CniConfig:{NetworkPluginBinDir:/opt/cni/bin NetworkPluginConfDir:/etc/cni/net.d NetworkPluginMaxConfNum:1 NetworkPluginSetupSerially:false NetworkPluginConfTemplate: IPPreference:} Registry:{ConfigPath: Mirrors:map[] Configs:map[] Auths:map[] Headers:map[]} ImageDecryption:{KeyModel:node} DisableTCPService:true StreamServerAddress:127.0.0.1 StreamServerPort:0 StreamIdleTimeout:4h0m0s EnableSelinux:true SelinuxCategoryRange:1024 SandboxImage:registry.k8s.io/pause:3.8 StatsCollectPeriod:10 SystemdCgroup:false EnableTLSStreaming:false X509KeyPairStreaming:{TLSCertFile: TLSKeyFile:} MaxContainerLogLineSize:16384 DisableCgroup:false DisableApparmor:false RestrictOOMScoreAdj:false MaxConcurrentDownloads:3 DisableProcMount:false UnsetSeccompProfile: TolerateMissingHugetlbController:true DisableHugetlbController:true DeviceOwnershipFromSecurityContext:false IgnoreImageDefinedVolumes:false NetNSMountsUnderStateDir:false EnableUnprivilegedPorts:false EnableUnprivilegedICMP:false EnableCDI:false CDISpecDirs:[/etc/cdi /var/run/cdi] ImagePullProgressTimeout:5m0s DrainExecSyncIOTimeout:0s ImagePullWithSyncFs:false IgnoreDeprecationWarnings:[]} ContainerdRootDir:/var/lib/containerd ContainerdEndpoint:/run/containerd/containerd.sock RootDir:/var/lib/containerd/io.containerd.grpc.v1.cri StateDir:/run/containerd/io.containerd.grpc.v1.cri}" Oct 30 23:58:36.885322 containerd[1436]: time="2025-10-30T23:58:36.883934080Z" level=info msg="Connect containerd service" Oct 30 23:58:36.885322 containerd[1436]: time="2025-10-30T23:58:36.883982720Z" level=info msg="using legacy CRI server" Oct 30 23:58:36.885322 containerd[1436]: time="2025-10-30T23:58:36.883990880Z" level=info msg="using experimental NRI integration - disable nri plugin to prevent this" Oct 30 23:58:36.885322 containerd[1436]: time="2025-10-30T23:58:36.884384840Z" level=info msg="Get image filesystem path \"/var/lib/containerd/io.containerd.snapshotter.v1.overlayfs\"" Oct 30 23:58:36.885322 containerd[1436]: time="2025-10-30T23:58:36.885125840Z" level=error msg="failed to load cni during init, please check CRI plugin status before setting up network for pods" error="cni config load failed: no network config found in /etc/cni/net.d: cni plugin not initialized: failed to load cni config" Oct 30 23:58:36.887135 containerd[1436]: time="2025-10-30T23:58:36.887083480Z" level=info msg="Start subscribing containerd event" Oct 30 23:58:36.887253 containerd[1436]: time="2025-10-30T23:58:36.887152760Z" level=info msg="Start recovering state" Oct 30 23:58:36.887282 containerd[1436]: time="2025-10-30T23:58:36.887254280Z" level=info msg="Start event monitor" Oct 30 23:58:36.887282 containerd[1436]: time="2025-10-30T23:58:36.887267040Z" level=info msg="Start snapshots syncer" Oct 30 23:58:36.888336 containerd[1436]: time="2025-10-30T23:58:36.887279640Z" level=info msg="Start cni network conf syncer for default" Oct 30 23:58:36.888336 containerd[1436]: time="2025-10-30T23:58:36.887408000Z" level=info msg="Start streaming server" Oct 30 23:58:36.888336 containerd[1436]: time="2025-10-30T23:58:36.888085960Z" level=info msg=serving... address=/run/containerd/containerd.sock.ttrpc Oct 30 23:58:36.888336 containerd[1436]: time="2025-10-30T23:58:36.888134640Z" level=info msg=serving... address=/run/containerd/containerd.sock Oct 30 23:58:36.889615 systemd[1]: Starting etcd-member.service - etcd (System Application Container)... Oct 30 23:58:36.896301 containerd[1436]: time="2025-10-30T23:58:36.894658480Z" level=info msg="containerd successfully booted in 0.064402s" Oct 30 23:58:36.901697 systemd[1]: Starting nvidia.service - NVIDIA Configure Service... Oct 30 23:58:36.902771 systemd[1]: Started containerd.service - containerd container runtime. Oct 30 23:58:36.903058 (-wrapper)[1497]: etcd-member.service: Referenced but unset environment variable evaluates to an empty string: ETCD_OPTS Oct 30 23:58:36.951066 systemd[1]: Finished nvidia.service - NVIDIA Configure Service. Oct 30 23:58:37.049689 (dockerd)[1518]: 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 Oct 30 23:58:37.049980 systemd[1]: Starting docker.service - Docker Application Container Engine... Oct 30 23:58:37.304357 dockerd[1518]: time="2025-10-30T23:58:37.302372360Z" level=info msg="Starting up" Oct 30 23:58:37.387067 systemd[1]: var-lib-docker-check\x2doverlayfs\x2dsupport2236959553-merged.mount: Deactivated successfully. Oct 30 23:58:37.412488 dockerd[1518]: time="2025-10-30T23:58:37.412435480Z" level=info msg="Loading containers: start." Oct 30 23:58:37.569317 kernel: Initializing XFRM netlink socket Oct 30 23:58:37.591847 systemd-timesyncd[1308]: Network configuration changed, trying to establish connection. Oct 30 23:58:37.592275 systemd-timesyncd[1308]: Network configuration changed, trying to establish connection. Oct 30 23:58:37.605242 systemd-timesyncd[1308]: Network configuration changed, trying to establish connection. Oct 30 23:58:37.652278 systemd-networkd[1336]: docker0: Link UP Oct 30 23:58:37.654067 systemd-timesyncd[1308]: Network configuration changed, trying to establish connection. Oct 30 23:58:37.682568 dockerd[1518]: time="2025-10-30T23:58:37.682513120Z" level=info msg="Loading containers: done." Oct 30 23:58:37.700250 dockerd[1518]: time="2025-10-30T23:58:37.700191040Z" 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 Oct 30 23:58:37.700444 dockerd[1518]: time="2025-10-30T23:58:37.700359360Z" level=info msg="Docker daemon" commit=41ca978a0a5400cc24b274137efa9f25517fcc0b containerd-snapshotter=false storage-driver=overlay2 version=27.3.1 Oct 30 23:58:37.700646 dockerd[1518]: time="2025-10-30T23:58:37.700615400Z" level=info msg="Daemon has completed initialization" Oct 30 23:58:37.706513 systemd-networkd[1336]: eth0: Gained IPv6LL Oct 30 23:58:37.707491 systemd-timesyncd[1308]: Network configuration changed, trying to establish connection. Oct 30 23:58:37.740302 dockerd[1518]: time="2025-10-30T23:58:37.740236800Z" level=info msg="API listen on /run/docker.sock" Oct 30 23:58:37.741008 systemd[1]: Started docker.service - Docker Application Container Engine. Oct 30 23:58:37.743554 etcd-wrapper[1506]: Error response from daemon: No such container: etcd-member Oct 30 23:58:37.758509 etcd-wrapper[1692]: Error response from daemon: No such container: etcd-member Oct 30 23:58:37.794116 etcd-wrapper[1710]: Unable to find image 'quay.io/coreos/etcd:v3.5.16-arm64' locally Oct 30 23:58:37.860481 sshd_keygen[1422]: ssh-keygen: generating new host keys: RSA ECDSA ED25519 Oct 30 23:58:37.884677 systemd[1]: Finished sshd-keygen.service - Generate sshd host keys. Oct 30 23:58:37.896689 systemd[1]: Starting issuegen.service - Generate /run/issue... Oct 30 23:58:37.907517 systemd[1]: issuegen.service: Deactivated successfully. Oct 30 23:58:37.908014 systemd[1]: Finished issuegen.service - Generate /run/issue. Oct 30 23:58:37.915621 systemd[1]: Starting systemd-user-sessions.service - Permit User Sessions... Oct 30 23:58:37.927370 systemd[1]: Finished systemd-user-sessions.service - Permit User Sessions. Oct 30 23:58:37.932637 systemd[1]: Started getty@tty1.service - Getty on tty1. Oct 30 23:58:37.939656 systemd[1]: Started serial-getty@ttyAMA0.service - Serial Getty on ttyAMA0. Oct 30 23:58:37.941141 systemd[1]: Reached target getty.target - Login Prompts. Oct 30 23:58:39.635927 etcd-wrapper[1710]: v3.5.16-arm64: Pulling from coreos/etcd Oct 30 23:58:39.637963 etcd-wrapper[1710]: d10f96ed9607: Pulling fs layer Oct 30 23:58:39.637963 etcd-wrapper[1710]: 2ae710cd8bfe: Pulling fs layer Oct 30 23:58:39.637963 etcd-wrapper[1710]: d462aa345367: Pulling fs layer Oct 30 23:58:39.637963 etcd-wrapper[1710]: 0f8b424aa0b9: Pulling fs layer Oct 30 23:58:39.637963 etcd-wrapper[1710]: d557676654e5: Pulling fs layer Oct 30 23:58:39.637963 etcd-wrapper[1710]: c8022d07192e: Pulling fs layer Oct 30 23:58:39.637963 etcd-wrapper[1710]: d858cbc252ad: Pulling fs layer Oct 30 23:58:39.637963 etcd-wrapper[1710]: 1069fc2daed1: Pulling fs layer Oct 30 23:58:39.637963 etcd-wrapper[1710]: b40161cd83fc: Pulling fs layer Oct 30 23:58:39.637963 etcd-wrapper[1710]: 5318d93a3a65: Pulling fs layer Oct 30 23:58:39.637963 etcd-wrapper[1710]: 307c1adadb60: Pulling fs layer Oct 30 23:58:39.637963 etcd-wrapper[1710]: f9b3c65df792: Pulling fs layer Oct 30 23:58:39.637963 etcd-wrapper[1710]: 5709b4a82c35: Pulling fs layer Oct 30 23:58:39.637963 etcd-wrapper[1710]: d5372e382b07: Pulling fs layer Oct 30 23:58:39.637963 etcd-wrapper[1710]: 9c3b5253dddc: Pulling fs layer Oct 30 23:58:39.637963 etcd-wrapper[1710]: 7a57323f7551: Pulling fs layer Oct 30 23:58:39.637963 etcd-wrapper[1710]: b40161cd83fc: Waiting Oct 30 23:58:39.637963 etcd-wrapper[1710]: 0f8b424aa0b9: Waiting Oct 30 23:58:39.637963 etcd-wrapper[1710]: d557676654e5: Waiting Oct 30 23:58:39.637963 etcd-wrapper[1710]: c8022d07192e: Waiting Oct 30 23:58:39.637963 etcd-wrapper[1710]: d858cbc252ad: Waiting Oct 30 23:58:39.637963 etcd-wrapper[1710]: 1069fc2daed1: Waiting Oct 30 23:58:39.637963 etcd-wrapper[1710]: 307c1adadb60: Waiting Oct 30 23:58:39.637963 etcd-wrapper[1710]: f9b3c65df792: Waiting Oct 30 23:58:39.637963 etcd-wrapper[1710]: 5709b4a82c35: Waiting Oct 30 23:58:39.637963 etcd-wrapper[1710]: d5372e382b07: Waiting Oct 30 23:58:39.637963 etcd-wrapper[1710]: 9c3b5253dddc: Waiting Oct 30 23:58:39.637963 etcd-wrapper[1710]: 7a57323f7551: Waiting Oct 30 23:58:39.639265 etcd-wrapper[1710]: 5318d93a3a65: Waiting Oct 30 23:58:40.000478 etcd-wrapper[1710]: 2ae710cd8bfe: Verifying Checksum Oct 30 23:58:40.000478 etcd-wrapper[1710]: 2ae710cd8bfe: Download complete Oct 30 23:58:40.023838 etcd-wrapper[1710]: d462aa345367: Verifying Checksum Oct 30 23:58:40.023838 etcd-wrapper[1710]: d462aa345367: Download complete Oct 30 23:58:40.141725 etcd-wrapper[1710]: d10f96ed9607: Verifying Checksum Oct 30 23:58:40.141725 etcd-wrapper[1710]: d10f96ed9607: Download complete Oct 30 23:58:40.180758 etcd-wrapper[1710]: d10f96ed9607: Pull complete Oct 30 23:58:40.202201 systemd[1]: var-lib-docker-overlay2-99b8a1e617b31493551db0561a5b4ee0e63e852f9f07d08a2f80b461b9cc757e-merged.mount: Deactivated successfully. Oct 30 23:58:40.226132 etcd-wrapper[1710]: 2ae710cd8bfe: Pull complete Oct 30 23:58:40.479658 etcd-wrapper[1710]: 0f8b424aa0b9: Verifying Checksum Oct 30 23:58:40.479854 etcd-wrapper[1710]: 0f8b424aa0b9: Download complete Oct 30 23:58:40.531208 etcd-wrapper[1710]: c8022d07192e: Verifying Checksum Oct 30 23:58:40.531462 etcd-wrapper[1710]: c8022d07192e: Download complete Oct 30 23:58:40.545822 etcd-wrapper[1710]: d557676654e5: Verifying Checksum Oct 30 23:58:40.545822 etcd-wrapper[1710]: d557676654e5: Download complete Oct 30 23:58:40.623056 systemd[1]: var-lib-docker-overlay2-0b68fef08813cddb8316b7852a347b0af9a708b6db5cdc87afd1e0c9e58f30c0-merged.mount: Deactivated successfully. Oct 30 23:58:40.669966 etcd-wrapper[1710]: d462aa345367: Pull complete Oct 30 23:58:40.698744 etcd-wrapper[1710]: 0f8b424aa0b9: Pull complete Oct 30 23:58:40.722433 etcd-wrapper[1710]: d557676654e5: Pull complete Oct 30 23:58:40.751402 etcd-wrapper[1710]: c8022d07192e: Pull complete Oct 30 23:58:40.879603 etcd-wrapper[1710]: 1069fc2daed1: Verifying Checksum Oct 30 23:58:40.879603 etcd-wrapper[1710]: 1069fc2daed1: Download complete Oct 30 23:58:40.916270 etcd-wrapper[1710]: b40161cd83fc: Verifying Checksum Oct 30 23:58:40.916270 etcd-wrapper[1710]: b40161cd83fc: Download complete Oct 30 23:58:40.991951 etcd-wrapper[1710]: d858cbc252ad: Verifying Checksum Oct 30 23:58:40.996179 etcd-wrapper[1710]: d858cbc252ad: Download complete Oct 30 23:58:41.018383 etcd-wrapper[1710]: d858cbc252ad: Pull complete Oct 30 23:58:41.046936 etcd-wrapper[1710]: 1069fc2daed1: Pull complete Oct 30 23:58:41.074654 etcd-wrapper[1710]: b40161cd83fc: Pull complete Oct 30 23:58:41.265603 etcd-wrapper[1710]: 5318d93a3a65: Verifying Checksum Oct 30 23:58:41.265603 etcd-wrapper[1710]: 5318d93a3a65: Download complete Oct 30 23:58:41.281424 systemd[1]: var-lib-docker-overlay2-d00d6ae53f4d5d5f61cca7b0f78beee255c8dd794abbc82f67cea015da87f063-merged.mount: Deactivated successfully. Oct 30 23:58:41.293731 etcd-wrapper[1710]: 5318d93a3a65: Pull complete Oct 30 23:58:41.294283 etcd-wrapper[1710]: 307c1adadb60: Verifying Checksum Oct 30 23:58:41.294283 etcd-wrapper[1710]: 307c1adadb60: Download complete Oct 30 23:58:41.319462 systemd[1]: var-lib-docker-overlay2-d68abd067921428901bcbf36984b58ba6e9ccbfdbfda8dede6cc756574f3948c-merged.mount: Deactivated successfully. Oct 30 23:58:41.330991 etcd-wrapper[1710]: 307c1adadb60: Pull complete Oct 30 23:58:41.504692 etcd-wrapper[1710]: f9b3c65df792: Verifying Checksum Oct 30 23:58:41.504692 etcd-wrapper[1710]: f9b3c65df792: Download complete Oct 30 23:58:41.693193 etcd-wrapper[1710]: f9b3c65df792: Pull complete Oct 30 23:58:41.848940 etcd-wrapper[1710]: 5709b4a82c35: Verifying Checksum Oct 30 23:58:41.849225 etcd-wrapper[1710]: 5709b4a82c35: Download complete Oct 30 23:58:41.862496 etcd-wrapper[1710]: d5372e382b07: Verifying Checksum Oct 30 23:58:41.862638 etcd-wrapper[1710]: d5372e382b07: Download complete Oct 30 23:58:41.907554 etcd-wrapper[1710]: 9c3b5253dddc: Verifying Checksum Oct 30 23:58:41.907554 etcd-wrapper[1710]: 9c3b5253dddc: Download complete Oct 30 23:58:41.994653 etcd-wrapper[1710]: 5709b4a82c35: Pull complete Oct 30 23:58:42.118634 etcd-wrapper[1710]: d5372e382b07: Pull complete Oct 30 23:58:42.140783 etcd-wrapper[1710]: 9c3b5253dddc: Pull complete Oct 30 23:58:42.280506 etcd-wrapper[1710]: 7a57323f7551: Verifying Checksum Oct 30 23:58:42.280506 etcd-wrapper[1710]: 7a57323f7551: Download complete Oct 30 23:58:42.293545 systemd[1]: var-lib-docker-overlay2-8c783a4d0f290ec22b19e8c41ac130c68a56c8f843a9dcc654c8f016be0afc6f-merged.mount: Deactivated successfully. Oct 30 23:58:42.303351 etcd-wrapper[1710]: 7a57323f7551: Pull complete Oct 30 23:58:42.314538 etcd-wrapper[1710]: Digest: sha256:bdb64177a9250b4d594af525f4225c2d0657a251a6e38102a2ead39f67370db2 Oct 30 23:58:42.318163 etcd-wrapper[1710]: Status: Downloaded newer image for quay.io/coreos/etcd:v3.5.16-arm64 Oct 30 23:58:42.330436 systemd[1]: var-lib-docker-overlay2-1df55d22acc02c570fd6e38dc76843bc8d3484ccfcec0c8fd5626f6aa291b261\x2dinit-merged.mount: Deactivated successfully. Oct 30 23:58:42.468032 containerd[1436]: time="2025-10-30T23:58:42.467844480Z" level=info msg="loading plugin \"io.containerd.event.v1.publisher\"..." runtime=io.containerd.runc.v2 type=io.containerd.event.v1 Oct 30 23:58:42.469676 containerd[1436]: time="2025-10-30T23:58:42.469074240Z" level=info msg="loading plugin \"io.containerd.internal.v1.shutdown\"..." runtime=io.containerd.runc.v2 type=io.containerd.internal.v1 Oct 30 23:58:42.470240 containerd[1436]: time="2025-10-30T23:58:42.469951760Z" level=info msg="loading plugin \"io.containerd.ttrpc.v1.task\"..." runtime=io.containerd.runc.v2 type=io.containerd.ttrpc.v1 Oct 30 23:58:42.470618 containerd[1436]: time="2025-10-30T23:58:42.470483240Z" level=info msg="loading plugin \"io.containerd.ttrpc.v1.pause\"..." runtime=io.containerd.runc.v2 type=io.containerd.ttrpc.v1 Oct 30 23:58:42.492655 systemd[1]: Started docker-e34056ecd00e9a41c45373a6b7a7c4a526e3143b7160b06be6e0195bbaf3429a.scope - libcontainer container e34056ecd00e9a41c45373a6b7a7c4a526e3143b7160b06be6e0195bbaf3429a. Oct 30 23:58:42.554756 etcd-wrapper[1710]: {"level":"info","ts":"2025-10-30T23:58:42.553544Z","caller":"flags/flag.go:113","msg":"recognized and used environment variable","variable-name":"ETCD_DATA_DIR","variable-value":"/var/lib/etcd"} Oct 30 23:58:42.554756 etcd-wrapper[1710]: {"level":"info","ts":"2025-10-30T23:58:42.553715Z","caller":"flags/flag.go:113","msg":"recognized and used environment variable","variable-name":"ETCD_NAME","variable-value":"4b8e0b355bbd4375a02a1eae4348f5a0"} Oct 30 23:58:42.554756 etcd-wrapper[1710]: {"level":"warn","ts":"2025-10-30T23:58:42.553752Z","caller":"flags/flag.go:93","msg":"unrecognized environment variable","environment-variable":"ETCD_IMAGE_URL=quay.io/coreos/etcd"} Oct 30 23:58:42.554756 etcd-wrapper[1710]: {"level":"warn","ts":"2025-10-30T23:58:42.553764Z","caller":"flags/flag.go:93","msg":"unrecognized environment variable","environment-variable":"ETCD_IMAGE_TAG=v3.5.16-arm64"} Oct 30 23:58:42.554756 etcd-wrapper[1710]: {"level":"warn","ts":"2025-10-30T23:58:42.553773Z","caller":"flags/flag.go:93","msg":"unrecognized environment variable","environment-variable":"ETCD_USER=etcd"} Oct 30 23:58:42.554756 etcd-wrapper[1710]: {"level":"warn","ts":"2025-10-30T23:58:42.553780Z","caller":"flags/flag.go:93","msg":"unrecognized environment variable","environment-variable":"ETCD_SSL_DIR=/etc/ssl/certs"} Oct 30 23:58:42.554756 etcd-wrapper[1710]: {"level":"warn","ts":"2025-10-30T23:58:42.553838Z","caller":"embed/config.go:689","msg":"Running http and grpc server on single port. This is not recommended for production."} Oct 30 23:58:42.554756 etcd-wrapper[1710]: {"level":"info","ts":"2025-10-30T23:58:42.553855Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["/usr/local/bin/etcd","--listen-peer-urls=http://10.0.0.3:2380","--listen-client-urls=http://0.0.0.0:2379","--initial-advertise-peer-urls=http://10.0.0.3:2380","--advertise-client-urls=http://10.0.0.3:2379","--discovery=https://discovery.etcd.io/e8aec29637b0ecf6570c12764f15388b"]} Oct 30 23:58:42.554756 etcd-wrapper[1710]: {"level":"warn","ts":"2025-10-30T23:58:42.553933Z","caller":"embed/config.go:689","msg":"Running http and grpc server on single port. This is not recommended for production."} Oct 30 23:58:42.554756 etcd-wrapper[1710]: {"level":"info","ts":"2025-10-30T23:58:42.553949Z","caller":"embed/etcd.go:128","msg":"configuring peer listeners","listen-peer-urls":["http://10.0.0.3:2380"]} Oct 30 23:58:42.555159 etcd-wrapper[1710]: {"level":"info","ts":"2025-10-30T23:58:42.554160Z","caller":"embed/etcd.go:136","msg":"configuring client listeners","listen-client-urls":["http://0.0.0.0:2379"]} Oct 30 23:58:42.555159 etcd-wrapper[1710]: {"level":"info","ts":"2025-10-30T23:58:42.554415Z","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":2,"max-cpu-available":2,"member-initialized":false,"name":"4b8e0b355bbd4375a02a1eae4348f5a0","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.3:2380"],"listen-peer-urls":["http://10.0.0.3:2380"],"advertise-client-urls":["http://10.0.0.3:2379"],"listen-client-urls":["http://0.0.0.0:2379"],"listen-metrics-urls":[],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"4b8e0b355bbd4375a02a1eae4348f5a0=http://10.0.0.3:2380","initial-cluster-state":"new","initial-cluster-token":"https://discovery.etcd.io/e8aec29637b0ecf6570c12764f15388b","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":"https://discovery.etcd.io/e8aec29637b0ecf6570c12764f15388b","discovery-proxy":"","downgrade-check-interval":"5s"} Oct 30 23:58:42.559264 etcd-wrapper[1710]: {"level":"info","ts":"2025-10-30T23:58:42.558332Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"2.81756ms"} Oct 30 23:58:43.570122 etcd-wrapper[1710]: {"level":"info","ts":"2025-10-30T23:58:43.569226Z","caller":"v2discovery/discovery.go:336","msg":"found self from discovery server","discovery-url":"https://discovery.etcd.io","self":"a260c84147cb8509"} Oct 30 23:58:43.570122 etcd-wrapper[1710]: {"level":"info","ts":"2025-10-30T23:58:43.569274Z","caller":"v2discovery/discovery.go:352","msg":"found peers from discovery server; waiting for more","discovery-url":"https://discovery.etcd.io","found-peers":1,"needed-peers":2} Oct 30 23:58:44.166327 etcd-wrapper[1710]: {"level":"info","ts":"2025-10-30T23:58:44.165675Z","caller":"v2discovery/discovery.go:371","msg":"found peer from discovery server","discovery-url":"https://discovery.etcd.io","peer":"bd028fe380a3d955"} Oct 30 23:58:44.166327 etcd-wrapper[1710]: {"level":"info","ts":"2025-10-30T23:58:44.165744Z","caller":"v2discovery/discovery.go:352","msg":"found peers from discovery server; waiting for more","discovery-url":"https://discovery.etcd.io","found-peers":2,"needed-peers":1} Oct 30 23:58:46.773366 etcd-wrapper[1710]: {"level":"info","ts":"2025-10-30T23:58:46.772789Z","caller":"v2discovery/discovery.go:371","msg":"found peer from discovery server","discovery-url":"https://discovery.etcd.io","peer":"2f64cb089325d5cb"} Oct 30 23:58:46.773366 etcd-wrapper[1710]: {"level":"info","ts":"2025-10-30T23:58:46.772833Z","caller":"v2discovery/discovery.go:378","msg":"found all needed peers from discovery server","discovery-url":"https://discovery.etcd.io","found-peers":3} Oct 30 23:58:46.779588 etcd-wrapper[1710]: {"level":"info","ts":"2025-10-30T23:58:46.779177Z","caller":"etcdserver/raft.go:505","msg":"starting local member","local-member-id":"a260c84147cb8509","cluster-id":"1d0393c66009448f"} Oct 30 23:58:46.779588 etcd-wrapper[1710]: {"level":"info","ts":"2025-10-30T23:58:46.779552Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a260c84147cb8509 switched to configuration voters=()"} Oct 30 23:58:46.779588 etcd-wrapper[1710]: {"level":"info","ts":"2025-10-30T23:58:46.779608Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a260c84147cb8509 became follower at term 0"} Oct 30 23:58:46.780712 etcd-wrapper[1710]: {"level":"info","ts":"2025-10-30T23:58:46.779688Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft a260c84147cb8509 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} Oct 30 23:58:46.780712 etcd-wrapper[1710]: {"level":"info","ts":"2025-10-30T23:58:46.779735Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a260c84147cb8509 became follower at term 1"} Oct 30 23:58:46.780712 etcd-wrapper[1710]: {"level":"info","ts":"2025-10-30T23:58:46.780045Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a260c84147cb8509 switched to configuration voters=(3415077655142585803)"} Oct 30 23:58:46.780712 etcd-wrapper[1710]: {"level":"info","ts":"2025-10-30T23:58:46.780103Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a260c84147cb8509 switched to configuration voters=(3415077655142585803 11700572014611498249)"} Oct 30 23:58:46.780712 etcd-wrapper[1710]: {"level":"info","ts":"2025-10-30T23:58:46.780330Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a260c84147cb8509 switched to configuration voters=(3415077655142585803 11700572014611498249 13619606430400371029)"} Oct 30 23:58:46.782686 etcd-wrapper[1710]: {"level":"warn","ts":"2025-10-30T23:58:46.782333Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} Oct 30 23:58:46.784929 etcd-wrapper[1710]: {"level":"info","ts":"2025-10-30T23:58:46.784521Z","caller":"mvcc/kvstore.go:423","msg":"kvstore restored","current-rev":1} Oct 30 23:58:46.785922 etcd-wrapper[1710]: {"level":"info","ts":"2025-10-30T23:58:46.785681Z","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"} Oct 30 23:58:46.786713 etcd-wrapper[1710]: {"level":"info","ts":"2025-10-30T23:58:46.786497Z","caller":"rafthttp/peer.go:133","msg":"starting remote peer","remote-peer-id":"2f64cb089325d5cb"} Oct 30 23:58:46.787073 etcd-wrapper[1710]: {"level":"info","ts":"2025-10-30T23:58:46.786869Z","caller":"rafthttp/pipeline.go:72","msg":"started HTTP pipelining with remote peer","local-member-id":"a260c84147cb8509","remote-peer-id":"2f64cb089325d5cb"} Oct 30 23:58:46.787554 etcd-wrapper[1710]: {"level":"info","ts":"2025-10-30T23:58:46.787407Z","caller":"rafthttp/stream.go:169","msg":"started stream writer with remote peer","local-member-id":"a260c84147cb8509","remote-peer-id":"2f64cb089325d5cb"} Oct 30 23:58:46.787839 etcd-wrapper[1710]: {"level":"info","ts":"2025-10-30T23:58:46.787623Z","caller":"rafthttp/stream.go:169","msg":"started stream writer with remote peer","local-member-id":"a260c84147cb8509","remote-peer-id":"2f64cb089325d5cb"} Oct 30 23:58:46.789994 etcd-wrapper[1710]: {"level":"info","ts":"2025-10-30T23:58:46.789573Z","caller":"rafthttp/peer.go:137","msg":"started remote peer","remote-peer-id":"2f64cb089325d5cb"} Oct 30 23:58:46.793978 etcd-wrapper[1710]: {"level":"info","ts":"2025-10-30T23:58:46.790249Z","caller":"rafthttp/stream.go:395","msg":"started stream reader with remote peer","stream-reader-type":"stream MsgApp v2","local-member-id":"a260c84147cb8509","remote-peer-id":"2f64cb089325d5cb"} Oct 30 23:58:46.793978 etcd-wrapper[1710]: {"level":"info","ts":"2025-10-30T23:58:46.790272Z","caller":"rafthttp/transport.go:317","msg":"added remote peer","local-member-id":"a260c84147cb8509","remote-peer-id":"2f64cb089325d5cb","remote-peer-urls":["http://10.0.0.4:2380"]} Oct 30 23:58:46.793978 etcd-wrapper[1710]: {"level":"info","ts":"2025-10-30T23:58:46.790348Z","caller":"rafthttp/peer.go:133","msg":"starting remote peer","remote-peer-id":"bd028fe380a3d955"} Oct 30 23:58:46.793978 etcd-wrapper[1710]: {"level":"info","ts":"2025-10-30T23:58:46.790367Z","caller":"rafthttp/pipeline.go:72","msg":"started HTTP pipelining with remote peer","local-member-id":"a260c84147cb8509","remote-peer-id":"bd028fe380a3d955"} Oct 30 23:58:46.793978 etcd-wrapper[1710]: {"level":"info","ts":"2025-10-30T23:58:46.789817Z","caller":"rafthttp/stream.go:395","msg":"started stream reader with remote peer","stream-reader-type":"stream Message","local-member-id":"a260c84147cb8509","remote-peer-id":"2f64cb089325d5cb"} Oct 30 23:58:46.793978 etcd-wrapper[1710]: {"level":"info","ts":"2025-10-30T23:58:46.790717Z","caller":"rafthttp/peer.go:137","msg":"started remote peer","remote-peer-id":"bd028fe380a3d955"} Oct 30 23:58:46.793978 etcd-wrapper[1710]: {"level":"info","ts":"2025-10-30T23:58:46.790734Z","caller":"rafthttp/transport.go:317","msg":"added remote peer","local-member-id":"a260c84147cb8509","remote-peer-id":"bd028fe380a3d955","remote-peer-urls":["http://10.0.0.2:2380"]} Oct 30 23:58:46.793978 etcd-wrapper[1710]: {"level":"info","ts":"2025-10-30T23:58:46.790730Z","caller":"rafthttp/stream.go:169","msg":"started stream writer with remote peer","local-member-id":"a260c84147cb8509","remote-peer-id":"bd028fe380a3d955"} Oct 30 23:58:46.793978 etcd-wrapper[1710]: {"level":"info","ts":"2025-10-30T23:58:46.790754Z","caller":"etcdserver/server.go:873","msg":"starting etcd server","local-member-id":"a260c84147cb8509","local-server-version":"3.5.16","cluster-version":"to_be_decided"} Oct 30 23:58:46.794421 etcd-wrapper[1710]: {"level":"info","ts":"2025-10-30T23:58:46.790768Z","caller":"rafthttp/stream.go:169","msg":"started stream writer with remote peer","local-member-id":"a260c84147cb8509","remote-peer-id":"bd028fe380a3d955"} Oct 30 23:58:46.794421 etcd-wrapper[1710]: {"level":"info","ts":"2025-10-30T23:58:46.790930Z","caller":"v3rpc/health.go:61","msg":"grpc service status changed","service":"","status":"SERVING"} Oct 30 23:58:46.794421 etcd-wrapper[1710]: {"level":"info","ts":"2025-10-30T23:58:46.792366Z","caller":"rafthttp/stream.go:395","msg":"started stream reader with remote peer","stream-reader-type":"stream MsgApp v2","local-member-id":"a260c84147cb8509","remote-peer-id":"bd028fe380a3d955"} Oct 30 23:58:46.794421 etcd-wrapper[1710]: {"level":"info","ts":"2025-10-30T23:58:46.792567Z","caller":"rafthttp/stream.go:395","msg":"started stream reader with remote peer","stream-reader-type":"stream Message","local-member-id":"a260c84147cb8509","remote-peer-id":"bd028fe380a3d955"} Oct 30 23:58:46.794421 etcd-wrapper[1710]: {"level":"info","ts":"2025-10-30T23:58:46.792857Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a260c84147cb8509 switched to configuration voters=(3415077655142585803 11700572014611498249 13619606430400371029)"} Oct 30 23:58:46.794421 etcd-wrapper[1710]: {"level":"info","ts":"2025-10-30T23:58:46.792954Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"1d0393c66009448f","local-member-id":"a260c84147cb8509","added-peer-id":"2f64cb089325d5cb","added-peer-peer-urls":["http://10.0.0.4:2380"]} Oct 30 23:58:46.794421 etcd-wrapper[1710]: {"level":"info","ts":"2025-10-30T23:58:46.793017Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a260c84147cb8509 switched to configuration voters=(3415077655142585803 11700572014611498249 13619606430400371029)"} Oct 30 23:58:46.794421 etcd-wrapper[1710]: {"level":"info","ts":"2025-10-30T23:58:46.793067Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"1d0393c66009448f","local-member-id":"a260c84147cb8509","added-peer-id":"a260c84147cb8509","added-peer-peer-urls":["http://10.0.0.3:2380"]} Oct 30 23:58:46.794421 etcd-wrapper[1710]: {"level":"info","ts":"2025-10-30T23:58:46.793114Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a260c84147cb8509 switched to configuration voters=(3415077655142585803 11700572014611498249 13619606430400371029)"} Oct 30 23:58:46.795109 etcd-wrapper[1710]: {"level":"info","ts":"2025-10-30T23:58:46.793142Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"1d0393c66009448f","local-member-id":"a260c84147cb8509","added-peer-id":"bd028fe380a3d955","added-peer-peer-urls":["http://10.0.0.2:2380"]} Oct 30 23:58:46.795109 etcd-wrapper[1710]: {"level":"info","ts":"2025-10-30T23:58:46.793318Z","caller":"embed/etcd.go:280","msg":"now serving peer/client/metrics","local-member-id":"a260c84147cb8509","initial-advertise-peer-urls":["http://10.0.0.3:2380"],"listen-peer-urls":["http://10.0.0.3:2380"],"advertise-client-urls":["http://10.0.0.3:2379"],"listen-client-urls":["http://0.0.0.0:2379"],"listen-metrics-urls":[]} Oct 30 23:58:46.795109 etcd-wrapper[1710]: {"level":"info","ts":"2025-10-30T23:58:46.793396Z","caller":"etcdserver/server.go:773","msg":"starting initial election tick advance","election-ticks":10} Oct 30 23:58:46.795109 etcd-wrapper[1710]: {"level":"info","ts":"2025-10-30T23:58:46.793475Z","caller":"embed/etcd.go:600","msg":"serving peer traffic","address":"10.0.0.3:2380"} Oct 30 23:58:46.795109 etcd-wrapper[1710]: {"level":"info","ts":"2025-10-30T23:58:46.793497Z","caller":"embed/etcd.go:572","msg":"cmux::serve","address":"10.0.0.3:2380"} Oct 30 23:58:46.795109 etcd-wrapper[1710]: {"level":"info","ts":"2025-10-30T23:58:46.793489Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/snap","suffix":"snap.db","max":5,"interval":"30s"} Oct 30 23:58:46.795109 etcd-wrapper[1710]: {"level":"info","ts":"2025-10-30T23:58:46.793625Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/snap","suffix":"snap","max":5,"interval":"30s"} Oct 30 23:58:46.795109 etcd-wrapper[1710]: {"level":"info","ts":"2025-10-30T23:58:46.793633Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/wal","suffix":"wal","max":5,"interval":"30s"} Oct 30 23:58:46.795109 etcd-wrapper[1710]: {"level":"info","ts":"2025-10-30T23:58:46.794394Z","caller":"rafthttp/stream.go:249","msg":"set message encoder","from":"a260c84147cb8509","to":"bd028fe380a3d955","stream-type":"stream MsgApp v2"} Oct 30 23:58:46.795109 etcd-wrapper[1710]: {"level":"info","ts":"2025-10-30T23:58:46.794430Z","caller":"rafthttp/peer_status.go:53","msg":"peer became active","peer-id":"bd028fe380a3d955"} Oct 30 23:58:46.795403 etcd-wrapper[1710]: {"level":"info","ts":"2025-10-30T23:58:46.794465Z","caller":"rafthttp/stream.go:274","msg":"established TCP streaming connection with remote peer","stream-writer-type":"stream MsgApp v2","local-member-id":"a260c84147cb8509","remote-peer-id":"bd028fe380a3d955"} Oct 30 23:58:46.795403 etcd-wrapper[1710]: {"level":"info","ts":"2025-10-30T23:58:46.794694Z","caller":"rafthttp/stream.go:412","msg":"established TCP streaming connection with remote peer","stream-reader-type":"stream MsgApp v2","local-member-id":"a260c84147cb8509","remote-peer-id":"bd028fe380a3d955"} Oct 30 23:58:46.795698 etcd-wrapper[1710]: {"level":"info","ts":"2025-10-30T23:58:46.795524Z","caller":"rafthttp/stream.go:412","msg":"established TCP streaming connection with remote peer","stream-reader-type":"stream Message","local-member-id":"a260c84147cb8509","remote-peer-id":"bd028fe380a3d955"} Oct 30 23:58:46.796377 etcd-wrapper[1710]: {"level":"info","ts":"2025-10-30T23:58:46.796123Z","caller":"rafthttp/stream.go:249","msg":"set message encoder","from":"a260c84147cb8509","to":"bd028fe380a3d955","stream-type":"stream Message"} Oct 30 23:58:46.796377 etcd-wrapper[1710]: {"level":"info","ts":"2025-10-30T23:58:46.796181Z","caller":"rafthttp/stream.go:274","msg":"established TCP streaming connection with remote peer","stream-writer-type":"stream Message","local-member-id":"a260c84147cb8509","remote-peer-id":"bd028fe380a3d955"} Oct 30 23:58:47.197429 etcd-wrapper[1710]: {"level":"info","ts":"2025-10-30T23:58:47.197072Z","caller":"rafthttp/stream.go:249","msg":"set message encoder","from":"a260c84147cb8509","to":"2f64cb089325d5cb","stream-type":"stream MsgApp v2"} Oct 30 23:58:47.197429 etcd-wrapper[1710]: {"level":"info","ts":"2025-10-30T23:58:47.197114Z","caller":"rafthttp/peer_status.go:53","msg":"peer became active","peer-id":"2f64cb089325d5cb"} Oct 30 23:58:47.197429 etcd-wrapper[1710]: {"level":"info","ts":"2025-10-30T23:58:47.197134Z","caller":"rafthttp/stream.go:274","msg":"established TCP streaming connection with remote peer","stream-writer-type":"stream MsgApp v2","local-member-id":"a260c84147cb8509","remote-peer-id":"2f64cb089325d5cb"} Oct 30 23:58:47.200051 etcd-wrapper[1710]: {"level":"info","ts":"2025-10-30T23:58:47.199720Z","caller":"rafthttp/stream.go:249","msg":"set message encoder","from":"a260c84147cb8509","to":"2f64cb089325d5cb","stream-type":"stream Message"} Oct 30 23:58:47.200051 etcd-wrapper[1710]: {"level":"info","ts":"2025-10-30T23:58:47.199761Z","caller":"rafthttp/stream.go:274","msg":"established TCP streaming connection with remote peer","stream-writer-type":"stream Message","local-member-id":"a260c84147cb8509","remote-peer-id":"2f64cb089325d5cb"} Oct 30 23:58:47.202606 etcd-wrapper[1710]: {"level":"info","ts":"2025-10-30T23:58:47.202315Z","caller":"rafthttp/stream.go:412","msg":"established TCP streaming connection with remote peer","stream-reader-type":"stream Message","local-member-id":"a260c84147cb8509","remote-peer-id":"2f64cb089325d5cb"} Oct 30 23:58:47.202865 etcd-wrapper[1710]: {"level":"info","ts":"2025-10-30T23:58:47.202697Z","caller":"rafthttp/stream.go:412","msg":"established TCP streaming connection with remote peer","stream-reader-type":"stream MsgApp v2","local-member-id":"a260c84147cb8509","remote-peer-id":"2f64cb089325d5cb"} Oct 30 23:58:47.247489 etcd-wrapper[1710]: {"level":"info","ts":"2025-10-30T23:58:47.247073Z","caller":"etcdserver/server.go:796","msg":"initialized peer connections; fast-forwarding election ticks","local-member-id":"a260c84147cb8509","forward-ticks":8,"forward-duration":"800ms","election-ticks":10,"election-timeout":"1s","active-remote-members":2} Oct 30 23:58:47.781373 etcd-wrapper[1710]: {"level":"info","ts":"2025-10-30T23:58:47.780874Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a260c84147cb8509 is starting a new election at term 1"} Oct 30 23:58:47.781373 etcd-wrapper[1710]: {"level":"info","ts":"2025-10-30T23:58:47.780936Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a260c84147cb8509 became pre-candidate at term 1"} Oct 30 23:58:47.781373 etcd-wrapper[1710]: {"level":"info","ts":"2025-10-30T23:58:47.780963Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a260c84147cb8509 received MsgPreVoteResp from a260c84147cb8509 at term 1"} Oct 30 23:58:47.783082 etcd-wrapper[1710]: {"level":"info","ts":"2025-10-30T23:58:47.781019Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a260c84147cb8509 [logterm: 1, index: 3] sent MsgPreVote request to 2f64cb089325d5cb at term 1"} Oct 30 23:58:47.783082 etcd-wrapper[1710]: {"level":"info","ts":"2025-10-30T23:58:47.781051Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a260c84147cb8509 [logterm: 1, index: 3] sent MsgPreVote request to bd028fe380a3d955 at term 1"} Oct 30 23:58:47.783082 etcd-wrapper[1710]: {"level":"info","ts":"2025-10-30T23:58:47.782559Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a260c84147cb8509 received MsgPreVoteResp from bd028fe380a3d955 at term 1"} Oct 30 23:58:47.783397 etcd-wrapper[1710]: {"level":"info","ts":"2025-10-30T23:58:47.782675Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a260c84147cb8509 has received 2 MsgPreVoteResp votes and 0 vote rejections"} Oct 30 23:58:47.783397 etcd-wrapper[1710]: {"level":"info","ts":"2025-10-30T23:58:47.782740Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a260c84147cb8509 became candidate at term 2"} Oct 30 23:58:47.783397 etcd-wrapper[1710]: {"level":"info","ts":"2025-10-30T23:58:47.782802Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a260c84147cb8509 received MsgVoteResp from a260c84147cb8509 at term 2"} Oct 30 23:58:47.783397 etcd-wrapper[1710]: {"level":"info","ts":"2025-10-30T23:58:47.782848Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a260c84147cb8509 [logterm: 1, index: 3] sent MsgVote request to 2f64cb089325d5cb at term 2"} Oct 30 23:58:47.783397 etcd-wrapper[1710]: {"level":"info","ts":"2025-10-30T23:58:47.782870Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a260c84147cb8509 [logterm: 1, index: 3] sent MsgVote request to bd028fe380a3d955 at term 2"} Oct 30 23:58:47.787674 etcd-wrapper[1710]: {"level":"info","ts":"2025-10-30T23:58:47.787333Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a260c84147cb8509 received MsgVoteResp from 2f64cb089325d5cb at term 2"} Oct 30 23:58:47.787674 etcd-wrapper[1710]: {"level":"info","ts":"2025-10-30T23:58:47.787372Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a260c84147cb8509 has received 2 MsgVoteResp votes and 0 vote rejections"} Oct 30 23:58:47.787674 etcd-wrapper[1710]: {"level":"info","ts":"2025-10-30T23:58:47.787387Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a260c84147cb8509 became leader at term 2"} Oct 30 23:58:47.787674 etcd-wrapper[1710]: {"level":"info","ts":"2025-10-30T23:58:47.787510Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: a260c84147cb8509 elected leader a260c84147cb8509 at term 2"} Oct 30 23:58:47.793657 etcd-wrapper[1710]: {"level":"info","ts":"2025-10-30T23:58:47.791890Z","caller":"etcdserver/server.go:2140","msg":"published local member to cluster through raft","local-member-id":"a260c84147cb8509","local-member-attributes":"{Name:4b8e0b355bbd4375a02a1eae4348f5a0 ClientURLs:[http://10.0.0.3:2379]}","request-path":"/0/members/a260c84147cb8509/attributes","cluster-id":"1d0393c66009448f","publish-timeout":"7s"} Oct 30 23:58:47.793857 etcd-wrapper[1710]: {"level":"info","ts":"2025-10-30T23:58:47.791949Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} Oct 30 23:58:47.793857 etcd-wrapper[1710]: {"level":"info","ts":"2025-10-30T23:58:47.792662Z","caller":"v3rpc/health.go:61","msg":"grpc service status changed","service":"","status":"SERVING"} Oct 30 23:58:47.793857 etcd-wrapper[1710]: {"level":"info","ts":"2025-10-30T23:58:47.793117Z","caller":"embed/serve.go:187","msg":"serving client traffic insecurely; this is strongly discouraged!","traffic":"grpc+http","address":"[::]:2379"} Oct 30 23:58:47.794089 etcd-wrapper[1710]: {"level":"info","ts":"2025-10-30T23:58:47.793865Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} Oct 30 23:58:47.794339 etcd-wrapper[1710]: {"level":"info","ts":"2025-10-30T23:58:47.794153Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} Oct 30 23:58:47.794549 systemd[1]: Started etcd-member.service - etcd (System Application Container). Oct 30 23:58:47.795528 systemd[1]: Reached target multi-user.target - Multi-User System. Oct 30 23:58:47.796028 systemd[1]: Startup finished in 803ms (kernel) + 4.021s (initrd) + 14.129s (userspace) = 18.953s. Oct 30 23:58:47.796244 etcd-wrapper[1710]: {"level":"info","ts":"2025-10-30T23:58:47.795268Z","caller":"etcdserver/server.go:2651","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} Oct 30 23:58:47.797368 etcd-wrapper[1710]: {"level":"info","ts":"2025-10-30T23:58:47.797089Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"1d0393c66009448f","local-member-id":"a260c84147cb8509","cluster-version":"3.5"} Oct 30 23:58:47.797611 etcd-wrapper[1710]: {"level":"info","ts":"2025-10-30T23:58:47.797460Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} Oct 30 23:58:47.797957 etcd-wrapper[1710]: {"level":"info","ts":"2025-10-30T23:58:47.797506Z","caller":"etcdserver/server.go:2675","msg":"cluster version is updated","cluster-version":"3.5"} Oct 30 23:59:00.783916 systemd[1]: Created slice system-sshd.slice - Slice /system/sshd. Oct 30 23:59:00.789732 systemd[1]: Started sshd@0-116.202.99.226:22-139.178.89.65:40480.service - OpenSSH per-connection server daemon (139.178.89.65:40480). Oct 30 23:59:01.753830 sshd[1870]: Accepted publickey for core from 139.178.89.65 port 40480 ssh2: RSA SHA256:Oiivr4FYZNoFRNArKDf1mcLLlGhqoYWE2cfJZWdI7tQ Oct 30 23:59:01.756587 sshd-session[1870]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Oct 30 23:59:01.765220 systemd[1]: Created slice user-500.slice - User Slice of UID 500. Oct 30 23:59:01.772704 systemd[1]: Starting user-runtime-dir@500.service - User Runtime Directory /run/user/500... Oct 30 23:59:01.782199 systemd-logind[1417]: New session 1 of user core. Oct 30 23:59:01.790357 systemd[1]: Finished user-runtime-dir@500.service - User Runtime Directory /run/user/500. Oct 30 23:59:01.800686 systemd[1]: Starting user@500.service - User Manager for UID 500... Oct 30 23:59:01.805528 (systemd)[1874]: pam_unix(systemd-user:session): session opened for user core(uid=500) by (uid=0) Oct 30 23:59:01.808562 systemd-logind[1417]: New session c1 of user core. Oct 30 23:59:01.958457 systemd[1874]: Queued start job for default target default.target. Oct 30 23:59:01.966708 systemd[1874]: Created slice app.slice - User Application Slice. Oct 30 23:59:01.966811 systemd[1874]: Reached target paths.target - Paths. Oct 30 23:59:01.966892 systemd[1874]: Reached target timers.target - Timers. Oct 30 23:59:01.969011 systemd[1874]: Starting dbus.socket - D-Bus User Message Bus Socket... Oct 30 23:59:01.982959 systemd[1874]: Listening on dbus.socket - D-Bus User Message Bus Socket. Oct 30 23:59:01.983097 systemd[1874]: Reached target sockets.target - Sockets. Oct 30 23:59:01.983145 systemd[1874]: Reached target basic.target - Basic System. Oct 30 23:59:01.983176 systemd[1874]: Reached target default.target - Main User Target. Oct 30 23:59:01.983202 systemd[1874]: Startup finished in 166ms. Oct 30 23:59:01.983361 systemd[1]: Started user@500.service - User Manager for UID 500. Oct 30 23:59:01.992957 systemd[1]: Started session-1.scope - Session 1 of User core. Oct 30 23:59:02.668720 systemd[1]: Started sshd@1-116.202.99.226:22-139.178.89.65:40496.service - OpenSSH per-connection server daemon (139.178.89.65:40496). Oct 30 23:59:03.637134 sshd[1885]: Accepted publickey for core from 139.178.89.65 port 40496 ssh2: RSA SHA256:Oiivr4FYZNoFRNArKDf1mcLLlGhqoYWE2cfJZWdI7tQ Oct 30 23:59:03.638800 sshd-session[1885]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Oct 30 23:59:03.643870 systemd-logind[1417]: New session 2 of user core. Oct 30 23:59:03.651637 systemd[1]: Started session-2.scope - Session 2 of User core. Oct 30 23:59:04.306423 sshd[1887]: Connection closed by 139.178.89.65 port 40496 Oct 30 23:59:04.306205 sshd-session[1885]: pam_unix(sshd:session): session closed for user core Oct 30 23:59:04.311442 systemd-logind[1417]: Session 2 logged out. Waiting for processes to exit. Oct 30 23:59:04.312775 systemd[1]: sshd@1-116.202.99.226:22-139.178.89.65:40496.service: Deactivated successfully. Oct 30 23:59:04.315072 systemd[1]: session-2.scope: Deactivated successfully. Oct 30 23:59:04.317430 systemd-logind[1417]: Removed session 2. Oct 30 23:59:04.477800 systemd[1]: Started sshd@2-116.202.99.226:22-139.178.89.65:40500.service - OpenSSH per-connection server daemon (139.178.89.65:40500). Oct 30 23:59:05.432530 sshd[1893]: Accepted publickey for core from 139.178.89.65 port 40500 ssh2: RSA SHA256:Oiivr4FYZNoFRNArKDf1mcLLlGhqoYWE2cfJZWdI7tQ Oct 30 23:59:05.435436 sshd-session[1893]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Oct 30 23:59:05.442568 systemd-logind[1417]: New session 3 of user core. Oct 30 23:59:05.449666 systemd[1]: Started session-3.scope - Session 3 of User core. Oct 30 23:59:06.091101 sshd[1895]: Connection closed by 139.178.89.65 port 40500 Oct 30 23:59:06.092284 sshd-session[1893]: pam_unix(sshd:session): session closed for user core Oct 30 23:59:06.099051 systemd-logind[1417]: Session 3 logged out. Waiting for processes to exit. Oct 30 23:59:06.099276 systemd[1]: sshd@2-116.202.99.226:22-139.178.89.65:40500.service: Deactivated successfully. Oct 30 23:59:06.101260 systemd[1]: session-3.scope: Deactivated successfully. Oct 30 23:59:06.102430 systemd-logind[1417]: Removed session 3. Oct 30 23:59:06.261744 systemd[1]: Started sshd@3-116.202.99.226:22-139.178.89.65:55122.service - OpenSSH per-connection server daemon (139.178.89.65:55122). Oct 30 23:59:07.216616 sshd[1901]: Accepted publickey for core from 139.178.89.65 port 55122 ssh2: RSA SHA256:Oiivr4FYZNoFRNArKDf1mcLLlGhqoYWE2cfJZWdI7tQ Oct 30 23:59:07.219109 sshd-session[1901]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Oct 30 23:59:07.224818 systemd-logind[1417]: New session 4 of user core. Oct 30 23:59:07.234579 systemd[1]: Started session-4.scope - Session 4 of User core. Oct 30 23:59:07.879097 sshd[1903]: Connection closed by 139.178.89.65 port 55122 Oct 30 23:59:07.878444 sshd-session[1901]: pam_unix(sshd:session): session closed for user core Oct 30 23:59:07.884742 systemd[1]: sshd@3-116.202.99.226:22-139.178.89.65:55122.service: Deactivated successfully. Oct 30 23:59:07.888155 systemd[1]: session-4.scope: Deactivated successfully. Oct 30 23:59:07.891540 systemd-logind[1417]: Session 4 logged out. Waiting for processes to exit. Oct 30 23:59:07.893122 systemd-logind[1417]: Removed session 4. Oct 30 23:59:08.040056 systemd[1]: Started sshd@4-116.202.99.226:22-139.178.89.65:55128.service - OpenSSH per-connection server daemon (139.178.89.65:55128). Oct 30 23:59:08.629552 systemd-resolved[1278]: Clock change detected. Flushing caches. Oct 30 23:59:08.629844 systemd-timesyncd[1308]: Contacted time server 81.169.217.236:123 (2.flatcar.pool.ntp.org). Oct 30 23:59:08.629936 systemd-timesyncd[1308]: Initial clock synchronization to Thu 2025-10-30 23:59:08.629289 UTC. Oct 30 23:59:09.461788 sshd[1909]: Accepted publickey for core from 139.178.89.65 port 55128 ssh2: RSA SHA256:Oiivr4FYZNoFRNArKDf1mcLLlGhqoYWE2cfJZWdI7tQ Oct 30 23:59:09.463981 sshd-session[1909]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Oct 30 23:59:09.470805 systemd-logind[1417]: New session 5 of user core. Oct 30 23:59:09.476628 systemd[1]: Started session-5.scope - Session 5 of User core. Oct 30 23:59:09.969171 sudo[1912]: core : PWD=/home/core ; USER=root ; COMMAND=/usr/sbin/setenforce 1 Oct 30 23:59:09.969479 sudo[1912]: pam_unix(sudo:session): session opened for user root(uid=0) by core(uid=500) Oct 30 23:59:09.984323 sudo[1912]: pam_unix(sudo:session): session closed for user root Oct 30 23:59:10.137093 sshd[1911]: Connection closed by 139.178.89.65 port 55128 Oct 30 23:59:10.136930 sshd-session[1909]: pam_unix(sshd:session): session closed for user core Oct 30 23:59:10.141940 systemd[1]: sshd@4-116.202.99.226:22-139.178.89.65:55128.service: Deactivated successfully. Oct 30 23:59:10.141999 systemd-logind[1417]: Session 5 logged out. Waiting for processes to exit. Oct 30 23:59:10.143914 systemd[1]: session-5.scope: Deactivated successfully. Oct 30 23:59:10.146878 systemd-logind[1417]: Removed session 5. Oct 30 23:59:10.319636 systemd[1]: Started sshd@5-116.202.99.226:22-139.178.89.65:55138.service - OpenSSH per-connection server daemon (139.178.89.65:55138). Oct 30 23:59:11.266435 sshd[1918]: Accepted publickey for core from 139.178.89.65 port 55138 ssh2: RSA SHA256:Oiivr4FYZNoFRNArKDf1mcLLlGhqoYWE2cfJZWdI7tQ Oct 30 23:59:11.267991 sshd-session[1918]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Oct 30 23:59:11.274505 systemd-logind[1417]: New session 6 of user core. Oct 30 23:59:11.284499 systemd[1]: Started session-6.scope - Session 6 of User core. Oct 30 23:59:11.772036 sudo[1922]: 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 Oct 30 23:59:11.772802 sudo[1922]: pam_unix(sudo:session): session opened for user root(uid=0) by core(uid=500) Oct 30 23:59:11.777704 sudo[1922]: pam_unix(sudo:session): session closed for user root Oct 30 23:59:11.784954 sudo[1921]: core : PWD=/home/core ; USER=root ; COMMAND=/usr/sbin/systemctl restart audit-rules Oct 30 23:59:11.785416 sudo[1921]: pam_unix(sudo:session): session opened for user root(uid=0) by core(uid=500) Oct 30 23:59:11.802848 systemd[1]: Starting audit-rules.service - Load Audit Rules... Oct 30 23:59:11.839468 augenrules[1944]: No rules Oct 30 23:59:11.841323 systemd[1]: audit-rules.service: Deactivated successfully. Oct 30 23:59:11.842321 systemd[1]: Finished audit-rules.service - Load Audit Rules. Oct 30 23:59:11.844039 sudo[1921]: pam_unix(sudo:session): session closed for user root Oct 30 23:59:11.999199 sshd[1920]: Connection closed by 139.178.89.65 port 55138 Oct 30 23:59:11.998002 sshd-session[1918]: pam_unix(sshd:session): session closed for user core Oct 30 23:59:12.002517 systemd[1]: sshd@5-116.202.99.226:22-139.178.89.65:55138.service: Deactivated successfully. Oct 30 23:59:12.004842 systemd[1]: session-6.scope: Deactivated successfully. Oct 30 23:59:12.006885 systemd-logind[1417]: Session 6 logged out. Waiting for processes to exit. Oct 30 23:59:12.008047 systemd-logind[1417]: Removed session 6. Oct 30 23:59:12.173540 systemd[1]: Started sshd@6-116.202.99.226:22-139.178.89.65:55150.service - OpenSSH per-connection server daemon (139.178.89.65:55150). Oct 30 23:59:13.113041 sshd[1953]: Accepted publickey for core from 139.178.89.65 port 55150 ssh2: RSA SHA256:Oiivr4FYZNoFRNArKDf1mcLLlGhqoYWE2cfJZWdI7tQ Oct 30 23:59:13.115115 sshd-session[1953]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Oct 30 23:59:13.121091 systemd-logind[1417]: New session 7 of user core. Oct 30 23:59:13.125419 systemd[1]: Started session-7.scope - Session 7 of User core. Oct 30 23:59:13.833902 sshd[1956]: Connection closed by 139.178.89.65 port 55150 Oct 30 23:59:13.834824 sshd-session[1953]: pam_unix(sshd:session): session closed for user core Oct 30 23:59:13.840300 systemd[1]: sshd@6-116.202.99.226:22-139.178.89.65:55150.service: Deactivated successfully. Oct 30 23:59:13.840595 systemd-logind[1417]: Session 7 logged out. Waiting for processes to exit. Oct 30 23:59:13.845681 systemd[1]: session-7.scope: Deactivated successfully. Oct 30 23:59:13.846855 systemd-logind[1417]: Removed session 7. Oct 30 23:59:22.267039 etcd-wrapper[1710]: {"level":"warn","ts":"2025-10-30T23:59:22.266558Z","caller":"rafthttp/probing_status.go:68","msg":"prober detected unhealthy status","round-tripper-name":"ROUND_TRIPPER_RAFT_MESSAGE","remote-peer-id":"bd028fe380a3d955","rtt":"764.989µs","error":"dial tcp 10.0.0.2:2380: i/o timeout"} Oct 30 23:59:22.324326 update_engine[1420]: I20251030 23:59:22.324204 1420 update_attempter.cc:509] Updating boot flags... Oct 30 23:59:22.376279 kernel: BTRFS warning: duplicate device /dev/sda3 devid 1 generation 38 scanned by (udev-worker) (1975) Oct 30 23:59:22.456416 kernel: BTRFS warning: duplicate device /dev/sda3 devid 1 generation 38 scanned by (udev-worker) (1978) Oct 30 23:59:27.267665 etcd-wrapper[1710]: {"level":"warn","ts":"2025-10-30T23:59:27.267243Z","caller":"rafthttp/probing_status.go:68","msg":"prober detected unhealthy status","round-tripper-name":"ROUND_TRIPPER_RAFT_MESSAGE","remote-peer-id":"bd028fe380a3d955","rtt":"764.989µs","error":"dial tcp 10.0.0.2:2380: i/o timeout"} Oct 30 23:59:32.268329 etcd-wrapper[1710]: {"level":"warn","ts":"2025-10-30T23:59:32.267726Z","caller":"rafthttp/probing_status.go:68","msg":"prober detected unhealthy status","round-tripper-name":"ROUND_TRIPPER_RAFT_MESSAGE","remote-peer-id":"bd028fe380a3d955","rtt":"764.989µs","error":"dial tcp 10.0.0.2:2380: i/o timeout"} Oct 30 23:59:36.255313 etcd-wrapper[1710]: {"level":"warn","ts":"2025-10-30T23:59:36.254780Z","logger":"raft","caller":"etcdserver/zap_raft.go:85","msg":"a260c84147cb8509 stepped down to follower since quorum is not active"} Oct 30 23:59:36.255313 etcd-wrapper[1710]: {"level":"info","ts":"2025-10-30T23:59:36.254855Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a260c84147cb8509 became follower at term 2"} Oct 30 23:59:36.255313 etcd-wrapper[1710]: {"level":"info","ts":"2025-10-30T23:59:36.254880Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: a260c84147cb8509 lost leader a260c84147cb8509 at term 2"} Oct 30 23:59:37.269027 etcd-wrapper[1710]: {"level":"warn","ts":"2025-10-30T23:59:37.268674Z","caller":"rafthttp/probing_status.go:68","msg":"prober detected unhealthy status","round-tripper-name":"ROUND_TRIPPER_RAFT_MESSAGE","remote-peer-id":"bd028fe380a3d955","rtt":"764.989µs","error":"dial tcp 10.0.0.2:2380: i/o timeout"} Oct 30 23:59:37.855241 etcd-wrapper[1710]: {"level":"info","ts":"2025-10-30T23:59:37.854734Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a260c84147cb8509 is starting a new election at term 2"} Oct 30 23:59:37.855241 etcd-wrapper[1710]: {"level":"info","ts":"2025-10-30T23:59:37.854783Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a260c84147cb8509 became pre-candidate at term 2"} Oct 30 23:59:37.855241 etcd-wrapper[1710]: {"level":"info","ts":"2025-10-30T23:59:37.854795Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a260c84147cb8509 received MsgPreVoteResp from a260c84147cb8509 at term 2"} Oct 30 23:59:37.855241 etcd-wrapper[1710]: {"level":"info","ts":"2025-10-30T23:59:37.854809Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a260c84147cb8509 [logterm: 2, index: 11] sent MsgPreVote request to 2f64cb089325d5cb at term 2"} Oct 30 23:59:37.855241 etcd-wrapper[1710]: {"level":"info","ts":"2025-10-30T23:59:37.854817Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a260c84147cb8509 [logterm: 2, index: 11] sent MsgPreVote request to bd028fe380a3d955 at term 2"} Oct 30 23:59:39.455057 etcd-wrapper[1710]: {"level":"info","ts":"2025-10-30T23:59:39.454458Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a260c84147cb8509 is starting a new election at term 2"} Oct 30 23:59:39.455057 etcd-wrapper[1710]: {"level":"info","ts":"2025-10-30T23:59:39.454524Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a260c84147cb8509 became pre-candidate at term 2"} Oct 30 23:59:39.455057 etcd-wrapper[1710]: {"level":"info","ts":"2025-10-30T23:59:39.454545Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a260c84147cb8509 received MsgPreVoteResp from a260c84147cb8509 at term 2"} Oct 30 23:59:39.455057 etcd-wrapper[1710]: {"level":"info","ts":"2025-10-30T23:59:39.454570Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a260c84147cb8509 [logterm: 2, index: 11] sent MsgPreVote request to 2f64cb089325d5cb at term 2"} Oct 30 23:59:39.455057 etcd-wrapper[1710]: {"level":"info","ts":"2025-10-30T23:59:39.454585Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a260c84147cb8509 [logterm: 2, index: 11] sent MsgPreVote request to bd028fe380a3d955 at term 2"} Oct 30 23:59:41.054666 etcd-wrapper[1710]: {"level":"info","ts":"2025-10-30T23:59:41.054043Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a260c84147cb8509 is starting a new election at term 2"} Oct 30 23:59:41.054666 etcd-wrapper[1710]: {"level":"info","ts":"2025-10-30T23:59:41.054114Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a260c84147cb8509 became pre-candidate at term 2"} Oct 30 23:59:41.054666 etcd-wrapper[1710]: {"level":"info","ts":"2025-10-30T23:59:41.054134Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a260c84147cb8509 received MsgPreVoteResp from a260c84147cb8509 at term 2"} Oct 30 23:59:41.054666 etcd-wrapper[1710]: {"level":"info","ts":"2025-10-30T23:59:41.054159Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a260c84147cb8509 [logterm: 2, index: 11] sent MsgPreVote request to 2f64cb089325d5cb at term 2"} Oct 30 23:59:41.054666 etcd-wrapper[1710]: {"level":"info","ts":"2025-10-30T23:59:41.054173Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a260c84147cb8509 [logterm: 2, index: 11] sent MsgPreVote request to bd028fe380a3d955 at term 2"} Oct 30 23:59:42.269361 etcd-wrapper[1710]: {"level":"warn","ts":"2025-10-30T23:59:42.268845Z","caller":"rafthttp/probing_status.go:68","msg":"prober detected unhealthy status","round-tripper-name":"ROUND_TRIPPER_RAFT_MESSAGE","remote-peer-id":"bd028fe380a3d955","rtt":"764.989µs","error":"dial tcp 10.0.0.2:2380: i/o timeout"} Oct 30 23:59:42.654254 etcd-wrapper[1710]: {"level":"info","ts":"2025-10-30T23:59:42.653710Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a260c84147cb8509 is starting a new election at term 2"} Oct 30 23:59:42.654254 etcd-wrapper[1710]: {"level":"info","ts":"2025-10-30T23:59:42.653779Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a260c84147cb8509 became pre-candidate at term 2"} Oct 30 23:59:42.654254 etcd-wrapper[1710]: {"level":"info","ts":"2025-10-30T23:59:42.653801Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a260c84147cb8509 received MsgPreVoteResp from a260c84147cb8509 at term 2"} Oct 30 23:59:42.654254 etcd-wrapper[1710]: {"level":"info","ts":"2025-10-30T23:59:42.653824Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a260c84147cb8509 [logterm: 2, index: 11] sent MsgPreVote request to 2f64cb089325d5cb at term 2"} Oct 30 23:59:42.654254 etcd-wrapper[1710]: {"level":"info","ts":"2025-10-30T23:59:42.653848Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a260c84147cb8509 [logterm: 2, index: 11] sent MsgPreVote request to bd028fe380a3d955 at term 2"} Oct 30 23:59:44.254504 etcd-wrapper[1710]: {"level":"info","ts":"2025-10-30T23:59:44.254007Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a260c84147cb8509 is starting a new election at term 2"} Oct 30 23:59:44.254504 etcd-wrapper[1710]: {"level":"info","ts":"2025-10-30T23:59:44.254064Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a260c84147cb8509 became pre-candidate at term 2"} Oct 30 23:59:44.254504 etcd-wrapper[1710]: {"level":"info","ts":"2025-10-30T23:59:44.254085Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a260c84147cb8509 received MsgPreVoteResp from a260c84147cb8509 at term 2"} Oct 30 23:59:44.254504 etcd-wrapper[1710]: {"level":"info","ts":"2025-10-30T23:59:44.254110Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a260c84147cb8509 [logterm: 2, index: 11] sent MsgPreVote request to 2f64cb089325d5cb at term 2"} Oct 30 23:59:44.254504 etcd-wrapper[1710]: {"level":"info","ts":"2025-10-30T23:59:44.254175Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a260c84147cb8509 [logterm: 2, index: 11] sent MsgPreVote request to bd028fe380a3d955 at term 2"} Oct 30 23:59:45.854737 etcd-wrapper[1710]: {"level":"info","ts":"2025-10-30T23:59:45.854118Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a260c84147cb8509 is starting a new election at term 2"} Oct 30 23:59:45.854737 etcd-wrapper[1710]: {"level":"info","ts":"2025-10-30T23:59:45.854175Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a260c84147cb8509 became pre-candidate at term 2"} Oct 30 23:59:45.854737 etcd-wrapper[1710]: {"level":"info","ts":"2025-10-30T23:59:45.854188Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a260c84147cb8509 received MsgPreVoteResp from a260c84147cb8509 at term 2"} Oct 30 23:59:45.854737 etcd-wrapper[1710]: {"level":"info","ts":"2025-10-30T23:59:45.854202Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a260c84147cb8509 [logterm: 2, index: 11] sent MsgPreVote request to 2f64cb089325d5cb at term 2"} Oct 30 23:59:45.854737 etcd-wrapper[1710]: {"level":"info","ts":"2025-10-30T23:59:45.854235Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a260c84147cb8509 [logterm: 2, index: 11] sent MsgPreVote request to bd028fe380a3d955 at term 2"} Oct 30 23:59:47.270064 etcd-wrapper[1710]: {"level":"warn","ts":"2025-10-30T23:59:47.269771Z","caller":"rafthttp/probing_status.go:68","msg":"prober detected unhealthy status","round-tripper-name":"ROUND_TRIPPER_RAFT_MESSAGE","remote-peer-id":"bd028fe380a3d955","rtt":"764.989µs","error":"dial tcp 10.0.0.2:2380: i/o timeout"} Oct 30 23:59:47.454058 etcd-wrapper[1710]: {"level":"info","ts":"2025-10-30T23:59:47.453713Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a260c84147cb8509 is starting a new election at term 2"} Oct 30 23:59:47.454058 etcd-wrapper[1710]: {"level":"info","ts":"2025-10-30T23:59:47.453770Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a260c84147cb8509 became pre-candidate at term 2"} Oct 30 23:59:47.454707 etcd-wrapper[1710]: {"level":"info","ts":"2025-10-30T23:59:47.453789Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a260c84147cb8509 received MsgPreVoteResp from a260c84147cb8509 at term 2"} Oct 30 23:59:47.454707 etcd-wrapper[1710]: {"level":"info","ts":"2025-10-30T23:59:47.453822Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a260c84147cb8509 [logterm: 2, index: 11] sent MsgPreVote request to 2f64cb089325d5cb at term 2"} Oct 30 23:59:47.454707 etcd-wrapper[1710]: {"level":"info","ts":"2025-10-30T23:59:47.453838Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a260c84147cb8509 [logterm: 2, index: 11] sent MsgPreVote request to bd028fe380a3d955 at term 2"} Oct 30 23:59:49.054483 etcd-wrapper[1710]: {"level":"info","ts":"2025-10-30T23:59:49.054002Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a260c84147cb8509 is starting a new election at term 2"} Oct 30 23:59:49.054483 etcd-wrapper[1710]: {"level":"info","ts":"2025-10-30T23:59:49.054062Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a260c84147cb8509 became pre-candidate at term 2"} Oct 30 23:59:49.054483 etcd-wrapper[1710]: {"level":"info","ts":"2025-10-30T23:59:49.054085Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a260c84147cb8509 received MsgPreVoteResp from a260c84147cb8509 at term 2"} Oct 30 23:59:49.054483 etcd-wrapper[1710]: {"level":"info","ts":"2025-10-30T23:59:49.054128Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a260c84147cb8509 [logterm: 2, index: 11] sent MsgPreVote request to 2f64cb089325d5cb at term 2"} Oct 30 23:59:49.054483 etcd-wrapper[1710]: {"level":"info","ts":"2025-10-30T23:59:49.054156Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a260c84147cb8509 [logterm: 2, index: 11] sent MsgPreVote request to bd028fe380a3d955 at term 2"} Oct 30 23:59:50.654149 etcd-wrapper[1710]: {"level":"info","ts":"2025-10-30T23:59:50.653702Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a260c84147cb8509 is starting a new election at term 2"} Oct 30 23:59:50.654149 etcd-wrapper[1710]: {"level":"info","ts":"2025-10-30T23:59:50.653768Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a260c84147cb8509 became pre-candidate at term 2"} Oct 30 23:59:50.654149 etcd-wrapper[1710]: {"level":"info","ts":"2025-10-30T23:59:50.653794Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a260c84147cb8509 received MsgPreVoteResp from a260c84147cb8509 at term 2"} Oct 30 23:59:50.654149 etcd-wrapper[1710]: {"level":"info","ts":"2025-10-30T23:59:50.653820Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a260c84147cb8509 [logterm: 2, index: 11] sent MsgPreVote request to 2f64cb089325d5cb at term 2"} Oct 30 23:59:50.654149 etcd-wrapper[1710]: {"level":"info","ts":"2025-10-30T23:59:50.653845Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a260c84147cb8509 [logterm: 2, index: 11] sent MsgPreVote request to bd028fe380a3d955 at term 2"}