Jul 14 21:45:38.731814 kernel: Booting Linux on physical CPU 0x0000000000 [0x413fd0c1] Jul 14 21:45:38.731834 kernel: Linux version 5.15.187-flatcar (build@pony-truck.infra.kinvolk.io) (aarch64-cros-linux-gnu-gcc (Gentoo Hardened 11.3.1_p20221209 p3) 11.3.1 20221209, GNU ld (Gentoo 2.39 p5) 2.39.0) #1 SMP PREEMPT Mon Jul 14 20:49:56 -00 2025 Jul 14 21:45:38.731850 kernel: efi: EFI v2.70 by EDK II Jul 14 21:45:38.731857 kernel: efi: SMBIOS 3.0=0xd9260000 ACPI 2.0=0xd9240000 MEMATTR=0xda32b018 RNG=0xd9220018 MEMRESERVE=0xd9521c18 Jul 14 21:45:38.731862 kernel: random: crng init done Jul 14 21:45:38.731868 kernel: ACPI: Early table checksum verification disabled Jul 14 21:45:38.731875 kernel: ACPI: RSDP 0x00000000D9240000 000024 (v02 BOCHS ) Jul 14 21:45:38.731882 kernel: ACPI: XSDT 0x00000000D9230000 000064 (v01 BOCHS BXPC 00000001 01000013) Jul 14 21:45:38.731887 kernel: ACPI: FACP 0x00000000D91E0000 000114 (v06 BOCHS BXPC 00000001 BXPC 00000001) Jul 14 21:45:38.731893 kernel: ACPI: DSDT 0x00000000D91F0000 0014A2 (v02 BOCHS BXPC 00000001 BXPC 00000001) Jul 14 21:45:38.731899 kernel: ACPI: APIC 0x00000000D91D0000 0001A8 (v04 BOCHS BXPC 00000001 BXPC 00000001) Jul 14 21:45:38.731904 kernel: ACPI: PPTT 0x00000000D91C0000 00009C (v02 BOCHS BXPC 00000001 BXPC 00000001) Jul 14 21:45:38.731910 kernel: ACPI: GTDT 0x00000000D91B0000 000060 (v02 BOCHS BXPC 00000001 BXPC 00000001) Jul 14 21:45:38.731958 kernel: ACPI: MCFG 0x00000000D91A0000 00003C (v01 BOCHS BXPC 00000001 BXPC 00000001) Jul 14 21:45:38.731967 kernel: ACPI: SPCR 0x00000000D9190000 000050 (v02 BOCHS BXPC 00000001 BXPC 00000001) Jul 14 21:45:38.731973 kernel: ACPI: DBG2 0x00000000D9180000 000057 (v00 BOCHS BXPC 00000001 BXPC 00000001) Jul 14 21:45:38.731979 kernel: ACPI: IORT 0x00000000D9170000 000080 (v03 BOCHS BXPC 00000001 BXPC 00000001) Jul 14 21:45:38.731985 kernel: ACPI: SPCR: console: pl011,mmio,0x9000000,9600 Jul 14 21:45:38.731991 kernel: NUMA: Failed to initialise from firmware Jul 14 21:45:38.731997 kernel: NUMA: Faking a node at [mem 0x0000000040000000-0x00000000dcffffff] Jul 14 21:45:38.732003 kernel: NUMA: NODE_DATA [mem 0xdcb0b900-0xdcb10fff] Jul 14 21:45:38.732009 kernel: Zone ranges: Jul 14 21:45:38.732015 kernel: DMA [mem 0x0000000040000000-0x00000000dcffffff] Jul 14 21:45:38.732022 kernel: DMA32 empty Jul 14 21:45:38.732028 kernel: Normal empty Jul 14 21:45:38.732033 kernel: Movable zone start for each node Jul 14 21:45:38.732039 kernel: Early memory node ranges Jul 14 21:45:38.732045 kernel: node 0: [mem 0x0000000040000000-0x00000000d924ffff] Jul 14 21:45:38.732051 kernel: node 0: [mem 0x00000000d9250000-0x00000000d951ffff] Jul 14 21:45:38.732056 kernel: node 0: [mem 0x00000000d9520000-0x00000000dc7fffff] Jul 14 21:45:38.732062 kernel: node 0: [mem 0x00000000dc800000-0x00000000dc88ffff] Jul 14 21:45:38.732068 kernel: node 0: [mem 0x00000000dc890000-0x00000000dc89ffff] Jul 14 21:45:38.732074 kernel: node 0: [mem 0x00000000dc8a0000-0x00000000dc9bffff] Jul 14 21:45:38.732079 kernel: node 0: [mem 0x00000000dc9c0000-0x00000000dcffffff] Jul 14 21:45:38.732086 kernel: Initmem setup node 0 [mem 0x0000000040000000-0x00000000dcffffff] Jul 14 21:45:38.732093 kernel: On node 0, zone DMA: 12288 pages in unavailable ranges Jul 14 21:45:38.732098 kernel: psci: probing for conduit method from ACPI. Jul 14 21:45:38.732104 kernel: psci: PSCIv1.1 detected in firmware. Jul 14 21:45:38.732110 kernel: psci: Using standard PSCI v0.2 function IDs Jul 14 21:45:38.732116 kernel: psci: Trusted OS migration not required Jul 14 21:45:38.732124 kernel: psci: SMC Calling Convention v1.1 Jul 14 21:45:38.732131 kernel: smccc: KVM: hypervisor services detected (0x00000000 0x00000000 0x00000000 0x00000003) Jul 14 21:45:38.732138 kernel: ACPI: SRAT not present Jul 14 21:45:38.732145 kernel: percpu: Embedded 30 pages/cpu s82968 r8192 d31720 u122880 Jul 14 21:45:38.732151 kernel: pcpu-alloc: s82968 r8192 d31720 u122880 alloc=30*4096 Jul 14 21:45:38.732157 kernel: pcpu-alloc: [0] 0 [0] 1 [0] 2 [0] 3 Jul 14 21:45:38.732164 kernel: Detected PIPT I-cache on CPU0 Jul 14 21:45:38.732170 kernel: CPU features: detected: GIC system register CPU interface Jul 14 21:45:38.732176 kernel: CPU features: detected: Hardware dirty bit management Jul 14 21:45:38.732182 kernel: CPU features: detected: Spectre-v4 Jul 14 21:45:38.732188 kernel: CPU features: detected: Spectre-BHB Jul 14 21:45:38.732196 kernel: CPU features: kernel page table isolation forced ON by KASLR Jul 14 21:45:38.732202 kernel: CPU features: detected: Kernel page table isolation (KPTI) Jul 14 21:45:38.732208 kernel: CPU features: detected: ARM erratum 1418040 Jul 14 21:45:38.732215 kernel: CPU features: detected: SSBS not fully self-synchronizing Jul 14 21:45:38.732221 kernel: Built 1 zonelists, mobility grouping on. Total pages: 633024 Jul 14 21:45:38.732227 kernel: Policy zone: DMA Jul 14 21:45:38.732234 kernel: Kernel command line: BOOT_IMAGE=/flatcar/vmlinuz-a mount.usr=/dev/mapper/usr verity.usr=PARTUUID=7130c94a-213a-4e5a-8e26-6cce9662f132 rootflags=rw mount.usrflags=ro consoleblank=0 root=LABEL=ROOT console=ttyS0,115200 flatcar.first_boot=detected acpi=force verity.usrhash=0fbac260ee8dcd4db6590eed44229ca41387b27ea0fa758fd2be410620d68236 Jul 14 21:45:38.732241 kernel: Unknown kernel command line parameters "BOOT_IMAGE=/flatcar/vmlinuz-a", will be passed to user space. Jul 14 21:45:38.732247 kernel: Dentry cache hash table entries: 524288 (order: 10, 4194304 bytes, linear) Jul 14 21:45:38.732254 kernel: Inode-cache hash table entries: 262144 (order: 9, 2097152 bytes, linear) Jul 14 21:45:38.732260 kernel: mem auto-init: stack:off, heap alloc:off, heap free:off Jul 14 21:45:38.732268 kernel: Memory: 2457340K/2572288K available (9792K kernel code, 2094K rwdata, 7588K rodata, 36416K init, 777K bss, 114948K reserved, 0K cma-reserved) Jul 14 21:45:38.732274 kernel: SLUB: HWalign=64, Order=0-3, MinObjects=0, CPUs=4, Nodes=1 Jul 14 21:45:38.732280 kernel: trace event string verifier disabled Jul 14 21:45:38.732286 kernel: rcu: Preemptible hierarchical RCU implementation. Jul 14 21:45:38.732293 kernel: rcu: RCU event tracing is enabled. Jul 14 21:45:38.732300 kernel: rcu: RCU restricting CPUs from NR_CPUS=512 to nr_cpu_ids=4. Jul 14 21:45:38.732306 kernel: Trampoline variant of Tasks RCU enabled. Jul 14 21:45:38.732313 kernel: Tracing variant of Tasks RCU enabled. Jul 14 21:45:38.732319 kernel: rcu: RCU calculated value of scheduler-enlistment delay is 100 jiffies. Jul 14 21:45:38.732326 kernel: rcu: Adjusting geometry for rcu_fanout_leaf=16, nr_cpu_ids=4 Jul 14 21:45:38.732332 kernel: NR_IRQS: 64, nr_irqs: 64, preallocated irqs: 0 Jul 14 21:45:38.732339 kernel: GICv3: 256 SPIs implemented Jul 14 21:45:38.732345 kernel: GICv3: 0 Extended SPIs implemented Jul 14 21:45:38.732352 kernel: GICv3: Distributor has no Range Selector support Jul 14 21:45:38.732358 kernel: Root IRQ handler: gic_handle_irq Jul 14 21:45:38.732364 kernel: GICv3: 16 PPIs implemented Jul 14 21:45:38.732370 kernel: GICv3: CPU0: found redistributor 0 region 0:0x00000000080a0000 Jul 14 21:45:38.732377 kernel: ACPI: SRAT not present Jul 14 21:45:38.732383 kernel: ITS [mem 0x08080000-0x0809ffff] Jul 14 21:45:38.732389 kernel: ITS@0x0000000008080000: allocated 8192 Devices @400b0000 (indirect, esz 8, psz 64K, shr 1) Jul 14 21:45:38.732396 kernel: ITS@0x0000000008080000: allocated 8192 Interrupt Collections @400c0000 (flat, esz 8, psz 64K, shr 1) Jul 14 21:45:38.732402 kernel: GICv3: using LPI property table @0x00000000400d0000 Jul 14 21:45:38.732408 kernel: GICv3: CPU0: using allocated LPI pending table @0x00000000400e0000 Jul 14 21:45:38.732416 kernel: arch_timer: Enabling local workaround for ARM erratum 1418040 Jul 14 21:45:38.732422 kernel: arch_timer: cp15 timer(s) running at 25.00MHz (virt). Jul 14 21:45:38.732429 kernel: clocksource: arch_sys_counter: mask: 0xffffffffffffff max_cycles: 0x5c40939b5, max_idle_ns: 440795202646 ns Jul 14 21:45:38.732435 kernel: sched_clock: 56 bits at 25MHz, resolution 40ns, wraps every 4398046511100ns Jul 14 21:45:38.732441 kernel: arm-pv: using stolen time PV Jul 14 21:45:38.732448 kernel: Console: colour dummy device 80x25 Jul 14 21:45:38.732454 kernel: ACPI: Core revision 20210730 Jul 14 21:45:38.732461 kernel: Calibrating delay loop (skipped), value calculated using timer frequency.. 50.00 BogoMIPS (lpj=25000) Jul 14 21:45:38.732467 kernel: pid_max: default: 32768 minimum: 301 Jul 14 21:45:38.732474 kernel: LSM: Security Framework initializing Jul 14 21:45:38.732481 kernel: SELinux: Initializing. Jul 14 21:45:38.732488 kernel: Mount-cache hash table entries: 8192 (order: 4, 65536 bytes, linear) Jul 14 21:45:38.732494 kernel: Mountpoint-cache hash table entries: 8192 (order: 4, 65536 bytes, linear) Jul 14 21:45:38.732501 kernel: rcu: Hierarchical SRCU implementation. Jul 14 21:45:38.732507 kernel: Platform MSI: ITS@0x8080000 domain created Jul 14 21:45:38.732513 kernel: PCI/MSI: ITS@0x8080000 domain created Jul 14 21:45:38.732520 kernel: Remapping and enabling EFI services. Jul 14 21:45:38.732526 kernel: smp: Bringing up secondary CPUs ... Jul 14 21:45:38.732532 kernel: Detected PIPT I-cache on CPU1 Jul 14 21:45:38.732540 kernel: GICv3: CPU1: found redistributor 1 region 0:0x00000000080c0000 Jul 14 21:45:38.732547 kernel: GICv3: CPU1: using allocated LPI pending table @0x00000000400f0000 Jul 14 21:45:38.732553 kernel: arch_timer: Enabling local workaround for ARM erratum 1418040 Jul 14 21:45:38.732560 kernel: CPU1: Booted secondary processor 0x0000000001 [0x413fd0c1] Jul 14 21:45:38.732566 kernel: Detected PIPT I-cache on CPU2 Jul 14 21:45:38.732573 kernel: GICv3: CPU2: found redistributor 2 region 0:0x00000000080e0000 Jul 14 21:45:38.732579 kernel: GICv3: CPU2: using allocated LPI pending table @0x0000000040100000 Jul 14 21:45:38.732586 kernel: arch_timer: Enabling local workaround for ARM erratum 1418040 Jul 14 21:45:38.732592 kernel: CPU2: Booted secondary processor 0x0000000002 [0x413fd0c1] Jul 14 21:45:38.732599 kernel: Detected PIPT I-cache on CPU3 Jul 14 21:45:38.732606 kernel: GICv3: CPU3: found redistributor 3 region 0:0x0000000008100000 Jul 14 21:45:38.732613 kernel: GICv3: CPU3: using allocated LPI pending table @0x0000000040110000 Jul 14 21:45:38.732619 kernel: arch_timer: Enabling local workaround for ARM erratum 1418040 Jul 14 21:45:38.732626 kernel: CPU3: Booted secondary processor 0x0000000003 [0x413fd0c1] Jul 14 21:45:38.732652 kernel: smp: Brought up 1 node, 4 CPUs Jul 14 21:45:38.732661 kernel: SMP: Total of 4 processors activated. Jul 14 21:45:38.732667 kernel: CPU features: detected: 32-bit EL0 Support Jul 14 21:45:38.732674 kernel: CPU features: detected: Data cache clean to the PoU not required for I/D coherence Jul 14 21:45:38.732681 kernel: CPU features: detected: Common not Private translations Jul 14 21:45:38.732688 kernel: CPU features: detected: CRC32 instructions Jul 14 21:45:38.732695 kernel: CPU features: detected: RCpc load-acquire (LDAPR) Jul 14 21:45:38.732701 kernel: CPU features: detected: LSE atomic instructions Jul 14 21:45:38.732710 kernel: CPU features: detected: Privileged Access Never Jul 14 21:45:38.732717 kernel: CPU features: detected: RAS Extension Support Jul 14 21:45:38.732723 kernel: CPU features: detected: Speculative Store Bypassing Safe (SSBS) Jul 14 21:45:38.732730 kernel: CPU: All CPU(s) started at EL1 Jul 14 21:45:38.732737 kernel: alternatives: patching kernel code Jul 14 21:45:38.732745 kernel: devtmpfs: initialized Jul 14 21:45:38.732751 kernel: KASLR enabled Jul 14 21:45:38.732758 kernel: clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1911260446275000 ns Jul 14 21:45:38.732765 kernel: futex hash table entries: 1024 (order: 4, 65536 bytes, linear) Jul 14 21:45:38.732772 kernel: pinctrl core: initialized pinctrl subsystem Jul 14 21:45:38.732779 kernel: SMBIOS 3.0.0 present. Jul 14 21:45:38.732786 kernel: DMI: QEMU KVM Virtual Machine, BIOS 0.0.0 02/06/2015 Jul 14 21:45:38.732792 kernel: NET: Registered PF_NETLINK/PF_ROUTE protocol family Jul 14 21:45:38.732799 kernel: DMA: preallocated 512 KiB GFP_KERNEL pool for atomic allocations Jul 14 21:45:38.732807 kernel: DMA: preallocated 512 KiB GFP_KERNEL|GFP_DMA pool for atomic allocations Jul 14 21:45:38.732814 kernel: DMA: preallocated 512 KiB GFP_KERNEL|GFP_DMA32 pool for atomic allocations Jul 14 21:45:38.732821 kernel: audit: initializing netlink subsys (disabled) Jul 14 21:45:38.732828 kernel: audit: type=2000 audit(0.032:1): state=initialized audit_enabled=0 res=1 Jul 14 21:45:38.732835 kernel: thermal_sys: Registered thermal governor 'step_wise' Jul 14 21:45:38.732847 kernel: cpuidle: using governor menu Jul 14 21:45:38.732855 kernel: hw-breakpoint: found 6 breakpoint and 4 watchpoint registers. Jul 14 21:45:38.732862 kernel: ASID allocator initialised with 32768 entries Jul 14 21:45:38.732869 kernel: ACPI: bus type PCI registered Jul 14 21:45:38.732877 kernel: acpiphp: ACPI Hot Plug PCI Controller Driver version: 0.5 Jul 14 21:45:38.732884 kernel: Serial: AMBA PL011 UART driver Jul 14 21:45:38.732891 kernel: HugeTLB registered 1.00 GiB page size, pre-allocated 0 pages Jul 14 21:45:38.732897 kernel: HugeTLB registered 32.0 MiB page size, pre-allocated 0 pages Jul 14 21:45:38.732904 kernel: HugeTLB registered 2.00 MiB page size, pre-allocated 0 pages Jul 14 21:45:38.732911 kernel: HugeTLB registered 64.0 KiB page size, pre-allocated 0 pages Jul 14 21:45:38.732918 kernel: cryptd: max_cpu_qlen set to 1000 Jul 14 21:45:38.732925 kernel: alg: No test for fips(ansi_cprng) (fips_ansi_cprng) Jul 14 21:45:38.732931 kernel: ACPI: Added _OSI(Module Device) Jul 14 21:45:38.732940 kernel: ACPI: Added _OSI(Processor Device) Jul 14 21:45:38.732947 kernel: ACPI: Added _OSI(Processor Aggregator Device) Jul 14 21:45:38.732953 kernel: ACPI: Added _OSI(Linux-Dell-Video) Jul 14 21:45:38.732960 kernel: ACPI: Added _OSI(Linux-Lenovo-NV-HDMI-Audio) Jul 14 21:45:38.732967 kernel: ACPI: Added _OSI(Linux-HPI-Hybrid-Graphics) Jul 14 21:45:38.732974 kernel: ACPI: 1 ACPI AML tables successfully acquired and loaded Jul 14 21:45:38.732980 kernel: ACPI: Interpreter enabled Jul 14 21:45:38.732987 kernel: ACPI: Using GIC for interrupt routing Jul 14 21:45:38.732994 kernel: ACPI: MCFG table detected, 1 entries Jul 14 21:45:38.733002 kernel: ARMH0011:00: ttyAMA0 at MMIO 0x9000000 (irq = 12, base_baud = 0) is a SBSA Jul 14 21:45:38.733009 kernel: printk: console [ttyAMA0] enabled Jul 14 21:45:38.733015 kernel: ACPI: PCI Root Bridge [PCI0] (domain 0000 [bus 00-ff]) Jul 14 21:45:38.733171 kernel: acpi PNP0A08:00: _OSC: OS supports [ExtendedConfig ASPM ClockPM Segments MSI HPX-Type3] Jul 14 21:45:38.733241 kernel: acpi PNP0A08:00: _OSC: platform does not support [LTR] Jul 14 21:45:38.733303 kernel: acpi PNP0A08:00: _OSC: OS now controls [PCIeHotplug PME AER PCIeCapability] Jul 14 21:45:38.733368 kernel: acpi PNP0A08:00: ECAM area [mem 0x4010000000-0x401fffffff] reserved by PNP0C02:00 Jul 14 21:45:38.733435 kernel: acpi PNP0A08:00: ECAM at [mem 0x4010000000-0x401fffffff] for [bus 00-ff] Jul 14 21:45:38.733445 kernel: ACPI: Remapped I/O 0x000000003eff0000 to [io 0x0000-0xffff window] Jul 14 21:45:38.733452 kernel: PCI host bridge to bus 0000:00 Jul 14 21:45:38.733516 kernel: pci_bus 0000:00: root bus resource [mem 0x10000000-0x3efeffff window] Jul 14 21:45:38.733570 kernel: pci_bus 0000:00: root bus resource [io 0x0000-0xffff window] Jul 14 21:45:38.733623 kernel: pci_bus 0000:00: root bus resource [mem 0x8000000000-0xffffffffff window] Jul 14 21:45:38.733696 kernel: pci_bus 0000:00: root bus resource [bus 00-ff] Jul 14 21:45:38.733771 kernel: pci 0000:00:00.0: [1b36:0008] type 00 class 0x060000 Jul 14 21:45:38.733839 kernel: pci 0000:00:01.0: [1af4:1005] type 00 class 0x00ff00 Jul 14 21:45:38.733914 kernel: pci 0000:00:01.0: reg 0x10: [io 0x0000-0x001f] Jul 14 21:45:38.733977 kernel: pci 0000:00:01.0: reg 0x14: [mem 0x10000000-0x10000fff] Jul 14 21:45:38.734039 kernel: pci 0000:00:01.0: reg 0x20: [mem 0x8000000000-0x8000003fff 64bit pref] Jul 14 21:45:38.734099 kernel: pci 0000:00:01.0: BAR 4: assigned [mem 0x8000000000-0x8000003fff 64bit pref] Jul 14 21:45:38.734159 kernel: pci 0000:00:01.0: BAR 1: assigned [mem 0x10000000-0x10000fff] Jul 14 21:45:38.734222 kernel: pci 0000:00:01.0: BAR 0: assigned [io 0x1000-0x101f] Jul 14 21:45:38.734276 kernel: pci_bus 0000:00: resource 4 [mem 0x10000000-0x3efeffff window] Jul 14 21:45:38.734329 kernel: pci_bus 0000:00: resource 5 [io 0x0000-0xffff window] Jul 14 21:45:38.734382 kernel: pci_bus 0000:00: resource 6 [mem 0x8000000000-0xffffffffff window] Jul 14 21:45:38.734391 kernel: ACPI: PCI: Interrupt link GSI0 configured for IRQ 35 Jul 14 21:45:38.734398 kernel: ACPI: PCI: Interrupt link GSI1 configured for IRQ 36 Jul 14 21:45:38.734405 kernel: ACPI: PCI: Interrupt link GSI2 configured for IRQ 37 Jul 14 21:45:38.734412 kernel: ACPI: PCI: Interrupt link GSI3 configured for IRQ 38 Jul 14 21:45:38.734420 kernel: iommu: Default domain type: Translated Jul 14 21:45:38.734427 kernel: iommu: DMA domain TLB invalidation policy: strict mode Jul 14 21:45:38.734434 kernel: vgaarb: loaded Jul 14 21:45:38.734441 kernel: pps_core: LinuxPPS API ver. 1 registered Jul 14 21:45:38.734448 kernel: pps_core: Software ver. 5.3.6 - Copyright 2005-2007 Rodolfo Giometti Jul 14 21:45:38.734455 kernel: PTP clock support registered Jul 14 21:45:38.734462 kernel: Registered efivars operations Jul 14 21:45:38.734469 kernel: clocksource: Switched to clocksource arch_sys_counter Jul 14 21:45:38.734475 kernel: VFS: Disk quotas dquot_6.6.0 Jul 14 21:45:38.734484 kernel: VFS: Dquot-cache hash table entries: 512 (order 0, 4096 bytes) Jul 14 21:45:38.734491 kernel: pnp: PnP ACPI init Jul 14 21:45:38.734557 kernel: system 00:00: [mem 0x4010000000-0x401fffffff window] could not be reserved Jul 14 21:45:38.734567 kernel: pnp: PnP ACPI: found 1 devices Jul 14 21:45:38.734574 kernel: NET: Registered PF_INET protocol family Jul 14 21:45:38.734581 kernel: IP idents hash table entries: 65536 (order: 7, 524288 bytes, linear) Jul 14 21:45:38.734588 kernel: tcp_listen_portaddr_hash hash table entries: 2048 (order: 3, 32768 bytes, linear) Jul 14 21:45:38.734595 kernel: Table-perturb hash table entries: 65536 (order: 6, 262144 bytes, linear) Jul 14 21:45:38.734603 kernel: TCP established hash table entries: 32768 (order: 6, 262144 bytes, linear) Jul 14 21:45:38.734610 kernel: TCP bind hash table entries: 32768 (order: 7, 524288 bytes, linear) Jul 14 21:45:38.734617 kernel: TCP: Hash tables configured (established 32768 bind 32768) Jul 14 21:45:38.734624 kernel: UDP hash table entries: 2048 (order: 4, 65536 bytes, linear) Jul 14 21:45:38.734643 kernel: UDP-Lite hash table entries: 2048 (order: 4, 65536 bytes, linear) Jul 14 21:45:38.734650 kernel: NET: Registered PF_UNIX/PF_LOCAL protocol family Jul 14 21:45:38.734657 kernel: PCI: CLS 0 bytes, default 64 Jul 14 21:45:38.734664 kernel: hw perfevents: enabled with armv8_pmuv3_0 PMU driver, 7 counters available Jul 14 21:45:38.734671 kernel: kvm [1]: HYP mode not available Jul 14 21:45:38.734679 kernel: Initialise system trusted keyrings Jul 14 21:45:38.734686 kernel: workingset: timestamp_bits=39 max_order=20 bucket_order=0 Jul 14 21:45:38.734693 kernel: Key type asymmetric registered Jul 14 21:45:38.734700 kernel: Asymmetric key parser 'x509' registered Jul 14 21:45:38.734707 kernel: Block layer SCSI generic (bsg) driver version 0.4 loaded (major 249) Jul 14 21:45:38.734713 kernel: io scheduler mq-deadline registered Jul 14 21:45:38.734720 kernel: io scheduler kyber registered Jul 14 21:45:38.734727 kernel: io scheduler bfq registered Jul 14 21:45:38.734734 kernel: input: Power Button as /devices/LNXSYSTM:00/LNXSYBUS:00/PNP0C0C:00/input/input0 Jul 14 21:45:38.734742 kernel: ACPI: button: Power Button [PWRB] Jul 14 21:45:38.734749 kernel: ACPI: \_SB_.PCI0.GSI1: Enabled at IRQ 36 Jul 14 21:45:38.734815 kernel: virtio-pci 0000:00:01.0: enabling device (0005 -> 0007) Jul 14 21:45:38.734825 kernel: Serial: 8250/16550 driver, 4 ports, IRQ sharing enabled Jul 14 21:45:38.734832 kernel: thunder_xcv, ver 1.0 Jul 14 21:45:38.734839 kernel: thunder_bgx, ver 1.0 Jul 14 21:45:38.734853 kernel: nicpf, ver 1.0 Jul 14 21:45:38.734860 kernel: nicvf, ver 1.0 Jul 14 21:45:38.734931 kernel: rtc-efi rtc-efi.0: registered as rtc0 Jul 14 21:45:38.734991 kernel: rtc-efi rtc-efi.0: setting system clock to 2025-07-14T21:45:38 UTC (1752529538) Jul 14 21:45:38.735000 kernel: hid: raw HID events driver (C) Jiri Kosina Jul 14 21:45:38.735007 kernel: NET: Registered PF_INET6 protocol family Jul 14 21:45:38.735014 kernel: Segment Routing with IPv6 Jul 14 21:45:38.735020 kernel: In-situ OAM (IOAM) with IPv6 Jul 14 21:45:38.735027 kernel: NET: Registered PF_PACKET protocol family Jul 14 21:45:38.735034 kernel: Key type dns_resolver registered Jul 14 21:45:38.735041 kernel: registered taskstats version 1 Jul 14 21:45:38.735049 kernel: Loading compiled-in X.509 certificates Jul 14 21:45:38.735056 kernel: Loaded X.509 cert 'Kinvolk GmbH: Module signing key for 5.15.187-flatcar: 118351bb2b1409a8fe1c98db16ecff1bb5342a27' Jul 14 21:45:38.735063 kernel: Key type .fscrypt registered Jul 14 21:45:38.735070 kernel: Key type fscrypt-provisioning registered Jul 14 21:45:38.735077 kernel: ima: No TPM chip found, activating TPM-bypass! Jul 14 21:45:38.735084 kernel: ima: Allocated hash algorithm: sha1 Jul 14 21:45:38.735091 kernel: ima: No architecture policies found Jul 14 21:45:38.735098 kernel: clk: Disabling unused clocks Jul 14 21:45:38.735104 kernel: Freeing unused kernel memory: 36416K Jul 14 21:45:38.735112 kernel: Run /init as init process Jul 14 21:45:38.735119 kernel: with arguments: Jul 14 21:45:38.735126 kernel: /init Jul 14 21:45:38.735132 kernel: with environment: Jul 14 21:45:38.735139 kernel: HOME=/ Jul 14 21:45:38.735146 kernel: TERM=linux Jul 14 21:45:38.735152 kernel: BOOT_IMAGE=/flatcar/vmlinuz-a Jul 14 21:45:38.735161 systemd[1]: systemd 252 running in system mode (+PAM +AUDIT +SELINUX -APPARMOR +IMA +SMACK +SECCOMP +GCRYPT -GNUTLS +OPENSSL -ACL +BLKID +CURL -ELFUTILS -FIDO2 +IDN2 -IDN +IPTC +KMOD +LIBCRYPTSETUP +LIBFDISK +PCRE2 -PWQUALITY -P11KIT -QRENCODE -TPM2 +BZIP2 +LZ4 +XZ +ZLIB +ZSTD -BPF_FRAMEWORK -XKBCOMMON +UTMP +SYSVINIT default-hierarchy=unified) Jul 14 21:45:38.735171 systemd[1]: Detected virtualization kvm. Jul 14 21:45:38.735179 systemd[1]: Detected architecture arm64. Jul 14 21:45:38.735186 systemd[1]: Running in initrd. Jul 14 21:45:38.735193 systemd[1]: No hostname configured, using default hostname. Jul 14 21:45:38.735201 systemd[1]: Hostname set to . Jul 14 21:45:38.735208 systemd[1]: Initializing machine ID from VM UUID. Jul 14 21:45:38.735216 systemd[1]: Queued start job for default target initrd.target. Jul 14 21:45:38.735223 systemd[1]: Started systemd-ask-password-console.path. Jul 14 21:45:38.735232 systemd[1]: Reached target cryptsetup.target. Jul 14 21:45:38.735239 systemd[1]: Reached target paths.target. Jul 14 21:45:38.735247 systemd[1]: Reached target slices.target. Jul 14 21:45:38.735254 systemd[1]: Reached target swap.target. Jul 14 21:45:38.735261 systemd[1]: Reached target timers.target. Jul 14 21:45:38.735269 systemd[1]: Listening on iscsid.socket. Jul 14 21:45:38.735276 systemd[1]: Listening on iscsiuio.socket. Jul 14 21:45:38.735284 systemd[1]: Listening on systemd-journald-audit.socket. Jul 14 21:45:38.735292 systemd[1]: Listening on systemd-journald-dev-log.socket. Jul 14 21:45:38.735299 systemd[1]: Listening on systemd-journald.socket. Jul 14 21:45:38.735307 systemd[1]: Listening on systemd-networkd.socket. Jul 14 21:45:38.735314 systemd[1]: Listening on systemd-udevd-control.socket. Jul 14 21:45:38.735322 systemd[1]: Listening on systemd-udevd-kernel.socket. Jul 14 21:45:38.735329 systemd[1]: Reached target sockets.target. Jul 14 21:45:38.735336 systemd[1]: Starting kmod-static-nodes.service... Jul 14 21:45:38.735343 systemd[1]: Finished network-cleanup.service. Jul 14 21:45:38.735352 systemd[1]: Starting systemd-fsck-usr.service... Jul 14 21:45:38.735359 systemd[1]: Starting systemd-journald.service... Jul 14 21:45:38.735367 systemd[1]: Starting systemd-modules-load.service... Jul 14 21:45:38.735374 systemd[1]: Starting systemd-resolved.service... Jul 14 21:45:38.735381 systemd[1]: Starting systemd-vconsole-setup.service... Jul 14 21:45:38.735389 systemd[1]: Finished kmod-static-nodes.service. Jul 14 21:45:38.735396 systemd[1]: Finished systemd-fsck-usr.service. Jul 14 21:45:38.735403 systemd[1]: Starting systemd-tmpfiles-setup-dev.service... Jul 14 21:45:38.735411 systemd[1]: Finished systemd-vconsole-setup.service. Jul 14 21:45:38.735419 systemd[1]: Starting dracut-cmdline-ask.service... Jul 14 21:45:38.735427 systemd[1]: Finished systemd-tmpfiles-setup-dev.service. Jul 14 21:45:38.735435 kernel: audit: type=1130 audit(1752529538.733:2): pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=systemd-tmpfiles-setup-dev comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Jul 14 21:45:38.735445 systemd-journald[290]: Journal started Jul 14 21:45:38.735484 systemd-journald[290]: Runtime Journal (/run/log/journal/6089e8fe23d74dc9a859aa94a86b28e6) is 6.0M, max 48.7M, 42.6M free. Jul 14 21:45:38.733000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=systemd-tmpfiles-setup-dev comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Jul 14 21:45:38.726417 systemd-modules-load[291]: Inserted module 'overlay' Jul 14 21:45:38.736689 systemd[1]: Started systemd-journald.service. Jul 14 21:45:38.736000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=systemd-journald comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Jul 14 21:45:38.741143 kernel: audit: type=1130 audit(1752529538.736:3): pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=systemd-journald comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Jul 14 21:45:38.745645 kernel: bridge: filtering via arp/ip/ip6tables is no longer available by default. Update your scripts to load br_netfilter if you need this. Jul 14 21:45:38.749135 systemd-modules-load[291]: Inserted module 'br_netfilter' Jul 14 21:45:38.749795 kernel: Bridge firewalling registered Jul 14 21:45:38.749330 systemd[1]: Finished dracut-cmdline-ask.service. Jul 14 21:45:38.753066 kernel: audit: type=1130 audit(1752529538.749:4): pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=dracut-cmdline-ask comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Jul 14 21:45:38.749000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=dracut-cmdline-ask comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Jul 14 21:45:38.752659 systemd[1]: Starting dracut-cmdline.service... Jul 14 21:45:38.754131 systemd-resolved[292]: Positive Trust Anchors: Jul 14 21:45:38.754146 systemd-resolved[292]: . IN DS 20326 8 2 e06d44b80b8f1d39a95c0b0d7c65d08458e880409bbc683457104237c7f8ec8d Jul 14 21:45:38.754174 systemd-resolved[292]: 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 168.192.in-addr.arpa d.f.ip6.arpa corp home internal intranet lan local private test Jul 14 21:45:38.758355 systemd-resolved[292]: Defaulting to hostname 'linux'. Jul 14 21:45:38.764745 kernel: SCSI subsystem initialized Jul 14 21:45:38.764764 kernel: audit: type=1130 audit(1752529538.761:5): pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=systemd-resolved comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Jul 14 21:45:38.761000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=systemd-resolved comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Jul 14 21:45:38.759172 systemd[1]: Started systemd-resolved.service. Jul 14 21:45:38.762136 systemd[1]: Reached target nss-lookup.target. Jul 14 21:45:38.769207 dracut-cmdline[309]: dracut-dracut-053 Jul 14 21:45:38.770715 kernel: device-mapper: core: CONFIG_IMA_DISABLE_HTABLE is disabled. Duplicate IMA measurements will not be recorded in the IMA log. Jul 14 21:45:38.770732 kernel: device-mapper: uevent: version 1.0.3 Jul 14 21:45:38.770742 kernel: device-mapper: ioctl: 4.45.0-ioctl (2021-03-22) initialised: dm-devel@redhat.com Jul 14 21:45:38.771870 dracut-cmdline[309]: Using kernel command line parameters: rd.driver.pre=btrfs BOOT_IMAGE=/flatcar/vmlinuz-a mount.usr=/dev/mapper/usr verity.usr=PARTUUID=7130c94a-213a-4e5a-8e26-6cce9662f132 rootflags=rw mount.usrflags=ro consoleblank=0 root=LABEL=ROOT console=ttyS0,115200 flatcar.first_boot=detected acpi=force verity.usrhash=0fbac260ee8dcd4db6590eed44229ca41387b27ea0fa758fd2be410620d68236 Jul 14 21:45:38.775290 systemd-modules-load[291]: Inserted module 'dm_multipath' Jul 14 21:45:38.776095 systemd[1]: Finished systemd-modules-load.service. Jul 14 21:45:38.776000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=systemd-modules-load comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Jul 14 21:45:38.777435 systemd[1]: Starting systemd-sysctl.service... Jul 14 21:45:38.779915 kernel: audit: type=1130 audit(1752529538.776:6): pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=systemd-modules-load comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Jul 14 21:45:38.785208 systemd[1]: Finished systemd-sysctl.service. Jul 14 21:45:38.785000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=systemd-sysctl comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Jul 14 21:45:38.788660 kernel: audit: type=1130 audit(1752529538.785:7): pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=systemd-sysctl comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Jul 14 21:45:38.833659 kernel: Loading iSCSI transport class v2.0-870. Jul 14 21:45:38.845657 kernel: iscsi: registered transport (tcp) Jul 14 21:45:38.859815 kernel: iscsi: registered transport (qla4xxx) Jul 14 21:45:38.859856 kernel: QLogic iSCSI HBA Driver Jul 14 21:45:38.893093 systemd[1]: Finished dracut-cmdline.service. Jul 14 21:45:38.893000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=dracut-cmdline comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Jul 14 21:45:38.894592 systemd[1]: Starting dracut-pre-udev.service... Jul 14 21:45:38.896876 kernel: audit: type=1130 audit(1752529538.893:8): pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=dracut-cmdline comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Jul 14 21:45:38.938650 kernel: raid6: neonx8 gen() 12164 MB/s Jul 14 21:45:38.955650 kernel: raid6: neonx8 xor() 10735 MB/s Jul 14 21:45:38.972642 kernel: raid6: neonx4 gen() 13415 MB/s Jul 14 21:45:38.989644 kernel: raid6: neonx4 xor() 11052 MB/s Jul 14 21:45:39.006641 kernel: raid6: neonx2 gen() 12902 MB/s Jul 14 21:45:39.023637 kernel: raid6: neonx2 xor() 10311 MB/s Jul 14 21:45:39.040643 kernel: raid6: neonx1 gen() 10567 MB/s Jul 14 21:45:39.057647 kernel: raid6: neonx1 xor() 8780 MB/s Jul 14 21:45:39.074644 kernel: raid6: int64x8 gen() 6221 MB/s Jul 14 21:45:39.091640 kernel: raid6: int64x8 xor() 3522 MB/s Jul 14 21:45:39.108644 kernel: raid6: int64x4 gen() 7158 MB/s Jul 14 21:45:39.125652 kernel: raid6: int64x4 xor() 3804 MB/s Jul 14 21:45:39.142646 kernel: raid6: int64x2 gen() 6084 MB/s Jul 14 21:45:39.159647 kernel: raid6: int64x2 xor() 3290 MB/s Jul 14 21:45:39.176658 kernel: raid6: int64x1 gen() 5005 MB/s Jul 14 21:45:39.193836 kernel: raid6: int64x1 xor() 2632 MB/s Jul 14 21:45:39.193864 kernel: raid6: using algorithm neonx4 gen() 13415 MB/s Jul 14 21:45:39.193873 kernel: raid6: .... xor() 11052 MB/s, rmw enabled Jul 14 21:45:39.193883 kernel: raid6: using neon recovery algorithm Jul 14 21:45:39.207742 kernel: xor: measuring software checksum speed Jul 14 21:45:39.207785 kernel: 8regs : 17209 MB/sec Jul 14 21:45:39.208754 kernel: 32regs : 19942 MB/sec Jul 14 21:45:39.208769 kernel: arm64_neon : 27533 MB/sec Jul 14 21:45:39.208778 kernel: xor: using function: arm64_neon (27533 MB/sec) Jul 14 21:45:39.265678 kernel: Btrfs loaded, crc32c=crc32c-generic, zoned=no, fsverity=no Jul 14 21:45:39.276121 systemd[1]: Finished dracut-pre-udev.service. Jul 14 21:45:39.276000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=dracut-pre-udev comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Jul 14 21:45:39.279654 kernel: audit: type=1130 audit(1752529539.276:9): pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=dracut-pre-udev comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Jul 14 21:45:39.279686 kernel: audit: type=1334 audit(1752529539.278:10): prog-id=7 op=LOAD Jul 14 21:45:39.278000 audit: BPF prog-id=7 op=LOAD Jul 14 21:45:39.278000 audit: BPF prog-id=8 op=LOAD Jul 14 21:45:39.279891 systemd[1]: Starting systemd-udevd.service... Jul 14 21:45:39.292271 systemd-udevd[491]: Using default interface naming scheme 'v252'. Jul 14 21:45:39.295726 systemd[1]: Started systemd-udevd.service. Jul 14 21:45:39.295000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=systemd-udevd comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Jul 14 21:45:39.297167 systemd[1]: Starting dracut-pre-trigger.service... Jul 14 21:45:39.309475 dracut-pre-trigger[497]: rd.md=0: removing MD RAID activation Jul 14 21:45:39.341407 systemd[1]: Finished dracut-pre-trigger.service. Jul 14 21:45:39.341000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=dracut-pre-trigger comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Jul 14 21:45:39.342823 systemd[1]: Starting systemd-udev-trigger.service... Jul 14 21:45:39.377253 systemd[1]: Finished systemd-udev-trigger.service. Jul 14 21:45:39.377000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=systemd-udev-trigger comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Jul 14 21:45:39.409100 kernel: virtio_blk virtio1: [vda] 9289728 512-byte logical blocks (4.76 GB/4.43 GiB) Jul 14 21:45:39.410898 kernel: vda: vda1 vda2 vda3 vda4 vda6 vda7 vda9 Jul 14 21:45:39.422660 kernel: BTRFS: device label OEM devid 1 transid 10 /dev/vda6 scanned by (udev-worker) (557) Jul 14 21:45:39.423050 systemd[1]: Found device dev-disk-by\x2dpartuuid-7130c94a\x2d213a\x2d4e5a\x2d8e26\x2d6cce9662f132.device. Jul 14 21:45:39.423973 systemd[1]: Found device dev-disk-by\x2dpartlabel-USR\x2dA.device. Jul 14 21:45:39.430169 systemd[1]: Found device dev-disk-by\x2dlabel-ROOT.device. Jul 14 21:45:39.433442 systemd[1]: Found device dev-disk-by\x2dlabel-EFI\x2dSYSTEM.device. Jul 14 21:45:39.438667 systemd[1]: Found device dev-disk-by\x2dlabel-OEM.device. Jul 14 21:45:39.442820 systemd[1]: Starting disk-uuid.service... Jul 14 21:45:39.450660 kernel: vda: vda1 vda2 vda3 vda4 vda6 vda7 vda9 Jul 14 21:45:40.464215 disk-uuid[565]: The operation has completed successfully. Jul 14 21:45:40.465065 kernel: vda: vda1 vda2 vda3 vda4 vda6 vda7 vda9 Jul 14 21:45:40.488227 systemd[1]: disk-uuid.service: Deactivated successfully. Jul 14 21:45:40.488000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=disk-uuid comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Jul 14 21:45:40.488000 audit[1]: SERVICE_STOP pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=disk-uuid comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Jul 14 21:45:40.488331 systemd[1]: Finished disk-uuid.service. Jul 14 21:45:40.489721 systemd[1]: Starting verity-setup.service... Jul 14 21:45:40.507952 kernel: device-mapper: verity: sha256 using implementation "sha256-ce" Jul 14 21:45:40.527964 systemd[1]: Found device dev-mapper-usr.device. Jul 14 21:45:40.529933 systemd[1]: Mounting sysusr-usr.mount... Jul 14 21:45:40.531834 systemd[1]: Finished verity-setup.service. Jul 14 21:45:40.531000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=verity-setup comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Jul 14 21:45:40.578539 systemd[1]: Mounted sysusr-usr.mount. Jul 14 21:45:40.579566 kernel: EXT4-fs (dm-0): mounted filesystem without journal. Opts: norecovery. Quota mode: none. Jul 14 21:45:40.579221 systemd[1]: afterburn-network-kargs.service was skipped because no trigger condition checks were met. Jul 14 21:45:40.579978 systemd[1]: Starting ignition-setup.service... Jul 14 21:45:40.581585 systemd[1]: Starting parse-ip-for-networkd.service... Jul 14 21:45:40.588692 kernel: BTRFS info (device vda6): using crc32c (crc32c-generic) checksum algorithm Jul 14 21:45:40.588738 kernel: BTRFS info (device vda6): using free space tree Jul 14 21:45:40.588749 kernel: BTRFS info (device vda6): has skinny extents Jul 14 21:45:40.597817 systemd[1]: mnt-oem.mount: Deactivated successfully. Jul 14 21:45:40.603201 systemd[1]: Finished ignition-setup.service. Jul 14 21:45:40.603000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=ignition-setup comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Jul 14 21:45:40.605335 systemd[1]: Starting ignition-fetch-offline.service... Jul 14 21:45:40.672303 systemd[1]: Finished parse-ip-for-networkd.service. Jul 14 21:45:40.672000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=parse-ip-for-networkd comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Jul 14 21:45:40.673000 audit: BPF prog-id=9 op=LOAD Jul 14 21:45:40.674455 systemd[1]: Starting systemd-networkd.service... Jul 14 21:45:40.679185 ignition[648]: Ignition 2.14.0 Jul 14 21:45:40.679197 ignition[648]: Stage: fetch-offline Jul 14 21:45:40.679246 ignition[648]: no configs at "/usr/lib/ignition/base.d" Jul 14 21:45:40.679255 ignition[648]: no config dir at "/usr/lib/ignition/base.platform.d/qemu" Jul 14 21:45:40.679423 ignition[648]: parsed url from cmdline: "" Jul 14 21:45:40.679426 ignition[648]: no config URL provided Jul 14 21:45:40.679431 ignition[648]: reading system config file "/usr/lib/ignition/user.ign" Jul 14 21:45:40.679439 ignition[648]: no config at "/usr/lib/ignition/user.ign" Jul 14 21:45:40.679457 ignition[648]: op(1): [started] loading QEMU firmware config module Jul 14 21:45:40.679462 ignition[648]: op(1): executing: "modprobe" "qemu_fw_cfg" Jul 14 21:45:40.684401 ignition[648]: op(1): [finished] loading QEMU firmware config module Jul 14 21:45:40.688387 ignition[648]: parsing config with SHA512: a38f406a35803402a7114a19eec27b65da74cd7ead42ac6e70a522b05d9e423b0dd851e788d60b4c5cdaa46a68c0cbada28d1a6cb83648d8889b1510df9614ac Jul 14 21:45:40.703085 systemd-networkd[740]: lo: Link UP Jul 14 21:45:40.703095 systemd-networkd[740]: lo: Gained carrier Jul 14 21:45:40.703000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=systemd-networkd comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Jul 14 21:45:40.703467 systemd-networkd[740]: Enumeration completed Jul 14 21:45:40.703551 systemd[1]: Started systemd-networkd.service. Jul 14 21:45:40.703924 systemd-networkd[740]: eth0: Configuring with /usr/lib/systemd/network/zz-default.network. Jul 14 21:45:40.704705 systemd[1]: Reached target network.target. Jul 14 21:45:40.706361 systemd[1]: Starting iscsiuio.service... Jul 14 21:45:40.708080 systemd-networkd[740]: eth0: Link UP Jul 14 21:45:40.708083 systemd-networkd[740]: eth0: Gained carrier Jul 14 21:45:40.710964 ignition[648]: fetch-offline: fetch-offline passed Jul 14 21:45:40.710734 unknown[648]: fetched base config from "system" Jul 14 21:45:40.711757 ignition[648]: Ignition finished successfully Jul 14 21:45:40.710741 unknown[648]: fetched user config from "qemu" Jul 14 21:45:40.715149 systemd[1]: Finished ignition-fetch-offline.service. Jul 14 21:45:40.715000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=ignition-fetch-offline comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Jul 14 21:45:40.715914 systemd[1]: Started iscsiuio.service. Jul 14 21:45:40.716000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=iscsiuio comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Jul 14 21:45:40.716929 systemd[1]: ignition-fetch.service was skipped because of an unmet condition check (ConditionPathExists=!/run/ignition.json). Jul 14 21:45:40.717912 systemd[1]: Starting ignition-kargs.service... Jul 14 21:45:40.720029 systemd[1]: Starting iscsid.service... Jul 14 21:45:40.723688 iscsid[748]: iscsid: can't open InitiatorName configuration file /etc/iscsi/initiatorname.iscsi Jul 14 21:45:40.723688 iscsid[748]: iscsid: Warning: InitiatorName file /etc/iscsi/initiatorname.iscsi does not exist or does not contain a properly formatted InitiatorName. If using software iscsi (iscsi_tcp or ib_iser) or partial offload (bnx2i or cxgbi iscsi), you may not be able to log into or discover targets. Please create a file /etc/iscsi/initiatorname.iscsi that contains a sting with the format: InitiatorName=iqn.yyyy-mm.[:identifier]. Jul 14 21:45:40.723688 iscsid[748]: Example: InitiatorName=iqn.2001-04.com.redhat:fc6. Jul 14 21:45:40.723688 iscsid[748]: If using hardware iscsi like qla4xxx this message can be ignored. Jul 14 21:45:40.723688 iscsid[748]: iscsid: can't open InitiatorAlias configuration file /etc/iscsi/initiatorname.iscsi Jul 14 21:45:40.723688 iscsid[748]: iscsid: can't open iscsid.safe_logout configuration file /etc/iscsi/iscsid.conf Jul 14 21:45:40.728000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=iscsid comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Jul 14 21:45:40.731000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=ignition-kargs comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Jul 14 21:45:40.727026 ignition[747]: Ignition 2.14.0 Jul 14 21:45:40.724745 systemd-networkd[740]: eth0: DHCPv4 address 10.0.0.17/16, gateway 10.0.0.1 acquired from 10.0.0.1 Jul 14 21:45:40.727033 ignition[747]: Stage: kargs Jul 14 21:45:40.727422 systemd[1]: Started iscsid.service. Jul 14 21:45:40.727138 ignition[747]: no configs at "/usr/lib/ignition/base.d" Jul 14 21:45:40.730177 systemd[1]: Starting dracut-initqueue.service... Jul 14 21:45:40.727148 ignition[747]: no config dir at "/usr/lib/ignition/base.platform.d/qemu" Jul 14 21:45:40.731343 systemd[1]: Finished ignition-kargs.service. Jul 14 21:45:40.727734 ignition[747]: kargs: kargs passed Jul 14 21:45:40.733438 systemd[1]: Starting ignition-disks.service... Jul 14 21:45:40.727776 ignition[747]: Ignition finished successfully Jul 14 21:45:40.740162 ignition[755]: Ignition 2.14.0 Jul 14 21:45:40.741000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=dracut-initqueue comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Jul 14 21:45:40.740695 systemd[1]: Finished dracut-initqueue.service. Jul 14 21:45:40.740168 ignition[755]: Stage: disks Jul 14 21:45:40.741975 systemd[1]: Reached target remote-fs-pre.target. Jul 14 21:45:40.740262 ignition[755]: no configs at "/usr/lib/ignition/base.d" Jul 14 21:45:40.742795 systemd[1]: Reached target remote-cryptsetup.target. Jul 14 21:45:40.740272 ignition[755]: no config dir at "/usr/lib/ignition/base.platform.d/qemu" Jul 14 21:45:40.746000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=ignition-disks comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Jul 14 21:45:40.743785 systemd[1]: Reached target remote-fs.target. Jul 14 21:45:40.740945 ignition[755]: disks: disks passed Jul 14 21:45:40.745411 systemd[1]: Starting dracut-pre-mount.service... Jul 14 21:45:40.740986 ignition[755]: Ignition finished successfully Jul 14 21:45:40.746374 systemd[1]: Finished ignition-disks.service. Jul 14 21:45:40.747322 systemd[1]: Reached target initrd-root-device.target. Jul 14 21:45:40.748450 systemd[1]: Reached target local-fs-pre.target. Jul 14 21:45:40.753000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=dracut-pre-mount comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Jul 14 21:45:40.749430 systemd[1]: Reached target local-fs.target. Jul 14 21:45:40.750315 systemd[1]: Reached target sysinit.target. Jul 14 21:45:40.751280 systemd[1]: Reached target basic.target. Jul 14 21:45:40.753230 systemd[1]: Finished dracut-pre-mount.service. Jul 14 21:45:40.754669 systemd[1]: Starting systemd-fsck-root.service... Jul 14 21:45:40.766143 systemd-fsck[776]: ROOT: clean, 619/553520 files, 56022/553472 blocks Jul 14 21:45:40.770274 systemd[1]: Finished systemd-fsck-root.service. Jul 14 21:45:40.770000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=systemd-fsck-root comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Jul 14 21:45:40.771932 systemd[1]: Mounting sysroot.mount... Jul 14 21:45:40.778662 kernel: EXT4-fs (vda9): mounted filesystem with ordered data mode. Opts: (null). Quota mode: none. Jul 14 21:45:40.778750 systemd[1]: Mounted sysroot.mount. Jul 14 21:45:40.779356 systemd[1]: Reached target initrd-root-fs.target. Jul 14 21:45:40.781323 systemd[1]: Mounting sysroot-usr.mount... Jul 14 21:45:40.782071 systemd[1]: flatcar-metadata-hostname.service was skipped because no trigger condition checks were met. Jul 14 21:45:40.782108 systemd[1]: ignition-remount-sysroot.service was skipped because of an unmet condition check (ConditionPathIsReadWrite=!/sysroot). Jul 14 21:45:40.782130 systemd[1]: Reached target ignition-diskful.target. Jul 14 21:45:40.784305 systemd[1]: Mounted sysroot-usr.mount. Jul 14 21:45:40.786158 systemd[1]: Starting initrd-setup-root.service... Jul 14 21:45:40.790526 initrd-setup-root[786]: cut: /sysroot/etc/passwd: No such file or directory Jul 14 21:45:40.795255 initrd-setup-root[794]: cut: /sysroot/etc/group: No such file or directory Jul 14 21:45:40.799303 initrd-setup-root[802]: cut: /sysroot/etc/shadow: No such file or directory Jul 14 21:45:40.803506 initrd-setup-root[810]: cut: /sysroot/etc/gshadow: No such file or directory Jul 14 21:45:40.832321 systemd[1]: Finished initrd-setup-root.service. Jul 14 21:45:40.832000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=initrd-setup-root comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Jul 14 21:45:40.833731 systemd[1]: Starting ignition-mount.service... Jul 14 21:45:40.834910 systemd[1]: Starting sysroot-boot.service... Jul 14 21:45:40.840184 bash[827]: umount: /sysroot/usr/share/oem: not mounted. Jul 14 21:45:40.849069 ignition[829]: INFO : Ignition 2.14.0 Jul 14 21:45:40.849069 ignition[829]: INFO : Stage: mount Jul 14 21:45:40.850806 ignition[829]: INFO : no configs at "/usr/lib/ignition/base.d" Jul 14 21:45:40.850806 ignition[829]: INFO : no config dir at "/usr/lib/ignition/base.platform.d/qemu" Jul 14 21:45:40.850806 ignition[829]: INFO : mount: mount passed Jul 14 21:45:40.850806 ignition[829]: INFO : Ignition finished successfully Jul 14 21:45:40.854170 systemd[1]: Finished ignition-mount.service. Jul 14 21:45:40.854000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=ignition-mount comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Jul 14 21:45:40.856002 systemd[1]: Finished sysroot-boot.service. Jul 14 21:45:40.855000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=sysroot-boot comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Jul 14 21:45:41.538374 systemd[1]: Mounting sysroot-usr-share-oem.mount... Jul 14 21:45:41.543657 kernel: BTRFS: device label OEM devid 1 transid 11 /dev/vda6 scanned by mount (838) Jul 14 21:45:41.545005 kernel: BTRFS info (device vda6): using crc32c (crc32c-generic) checksum algorithm Jul 14 21:45:41.545066 kernel: BTRFS info (device vda6): using free space tree Jul 14 21:45:41.545081 kernel: BTRFS info (device vda6): has skinny extents Jul 14 21:45:41.548452 systemd[1]: Mounted sysroot-usr-share-oem.mount. Jul 14 21:45:41.549877 systemd[1]: Starting ignition-files.service... Jul 14 21:45:41.564388 ignition[858]: INFO : Ignition 2.14.0 Jul 14 21:45:41.564388 ignition[858]: INFO : Stage: files Jul 14 21:45:41.566066 ignition[858]: INFO : no configs at "/usr/lib/ignition/base.d" Jul 14 21:45:41.566066 ignition[858]: INFO : no config dir at "/usr/lib/ignition/base.platform.d/qemu" Jul 14 21:45:41.566066 ignition[858]: DEBUG : files: compiled without relabeling support, skipping Jul 14 21:45:41.569367 ignition[858]: INFO : files: ensureUsers: op(1): [started] creating or modifying user "core" Jul 14 21:45:41.569367 ignition[858]: DEBUG : files: ensureUsers: op(1): executing: "usermod" "--root" "/sysroot" "core" Jul 14 21:45:41.572646 ignition[858]: INFO : files: ensureUsers: op(1): [finished] creating or modifying user "core" Jul 14 21:45:41.572646 ignition[858]: INFO : files: ensureUsers: op(2): [started] adding ssh keys to user "core" Jul 14 21:45:41.572646 ignition[858]: INFO : files: ensureUsers: op(2): [finished] adding ssh keys to user "core" Jul 14 21:45:41.572158 unknown[858]: wrote ssh authorized keys file for user: core Jul 14 21:45:41.577053 ignition[858]: INFO : files: createFilesystemsFiles: createFiles: op(3): [started] writing file "/sysroot/etc/flatcar/update.conf" Jul 14 21:45:41.577053 ignition[858]: INFO : files: createFilesystemsFiles: createFiles: op(3): [finished] writing file "/sysroot/etc/flatcar/update.conf" Jul 14 21:45:41.577053 ignition[858]: INFO : files: op(4): [started] processing unit "etcd-member.service" Jul 14 21:45:41.577053 ignition[858]: 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" Jul 14 21:45:41.577053 ignition[858]: 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" Jul 14 21:45:41.577053 ignition[858]: INFO : files: op(4): [finished] processing unit "etcd-member.service" Jul 14 21:45:41.577053 ignition[858]: INFO : files: op(6): [started] processing unit "coreos-metadata.service" Jul 14 21:45:41.577053 ignition[858]: INFO : files: op(6): op(7): [started] writing unit "coreos-metadata.service" at "/sysroot/etc/systemd/system/coreos-metadata.service" Jul 14 21:45:41.577053 ignition[858]: INFO : files: op(6): op(7): [finished] writing unit "coreos-metadata.service" at "/sysroot/etc/systemd/system/coreos-metadata.service" Jul 14 21:45:41.577053 ignition[858]: INFO : files: op(6): [finished] processing unit "coreos-metadata.service" Jul 14 21:45:41.577053 ignition[858]: INFO : files: op(8): [started] setting preset to enabled for "etcd-member.service" Jul 14 21:45:41.577053 ignition[858]: INFO : files: op(8): [finished] setting preset to enabled for "etcd-member.service" Jul 14 21:45:41.577053 ignition[858]: INFO : files: op(9): [started] setting preset to disabled for "coreos-metadata.service" Jul 14 21:45:41.577053 ignition[858]: INFO : files: op(9): op(a): [started] removing enablement symlink(s) for "coreos-metadata.service" Jul 14 21:45:41.609120 ignition[858]: INFO : files: op(9): op(a): [finished] removing enablement symlink(s) for "coreos-metadata.service" Jul 14 21:45:41.610000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=ignition-files comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Jul 14 21:45:41.611749 ignition[858]: INFO : files: op(9): [finished] setting preset to disabled for "coreos-metadata.service" Jul 14 21:45:41.611749 ignition[858]: INFO : files: createResultFile: createFiles: op(b): [started] writing file "/sysroot/etc/.ignition-result.json" Jul 14 21:45:41.611749 ignition[858]: INFO : files: createResultFile: createFiles: op(b): [finished] writing file "/sysroot/etc/.ignition-result.json" Jul 14 21:45:41.611749 ignition[858]: INFO : files: files passed Jul 14 21:45:41.611749 ignition[858]: INFO : Ignition finished successfully Jul 14 21:45:41.619000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=ignition-quench comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Jul 14 21:45:41.619000 audit[1]: SERVICE_STOP pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=ignition-quench comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Jul 14 21:45:41.620000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=initrd-setup-root-after-ignition comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Jul 14 21:45:41.611013 systemd[1]: Finished ignition-files.service. Jul 14 21:45:41.612409 systemd[1]: Starting initrd-setup-root-after-ignition.service... Jul 14 21:45:41.613304 systemd[1]: torcx-profile-populate.service was skipped because of an unmet condition check (ConditionPathExists=/sysroot/etc/torcx/next-profile). Jul 14 21:45:41.626282 initrd-setup-root-after-ignition[882]: grep: /sysroot/usr/share/oem/oem-release: No such file or directory Jul 14 21:45:41.613963 systemd[1]: Starting ignition-quench.service... Jul 14 21:45:41.630984 initrd-setup-root-after-ignition[885]: grep: /sysroot/etc/flatcar/enabled-sysext.conf: No such file or directory Jul 14 21:45:41.618163 systemd[1]: ignition-quench.service: Deactivated successfully. Jul 14 21:45:41.618253 systemd[1]: Finished ignition-quench.service. Jul 14 21:45:41.619976 systemd[1]: Finished initrd-setup-root-after-ignition.service. Jul 14 21:45:41.621089 systemd[1]: Reached target ignition-complete.target. Jul 14 21:45:41.623025 systemd[1]: Starting initrd-parse-etc.service... Jul 14 21:45:41.635890 systemd[1]: initrd-parse-etc.service: Deactivated successfully. Jul 14 21:45:41.636000 systemd[1]: Finished initrd-parse-etc.service. Jul 14 21:45:41.636000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=initrd-parse-etc comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Jul 14 21:45:41.636000 audit[1]: SERVICE_STOP pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=initrd-parse-etc comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Jul 14 21:45:41.637242 systemd[1]: Reached target initrd-fs.target. Jul 14 21:45:41.638192 systemd[1]: Reached target initrd.target. Jul 14 21:45:41.639169 systemd[1]: dracut-mount.service was skipped because no trigger condition checks were met. Jul 14 21:45:41.639950 systemd[1]: Starting dracut-pre-pivot.service... Jul 14 21:45:41.651686 systemd[1]: Finished dracut-pre-pivot.service. Jul 14 21:45:41.651000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=dracut-pre-pivot comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Jul 14 21:45:41.653201 systemd[1]: Starting initrd-cleanup.service... Jul 14 21:45:41.662425 systemd[1]: Stopped target nss-lookup.target. Jul 14 21:45:41.663139 systemd[1]: Stopped target remote-cryptsetup.target. Jul 14 21:45:41.664195 systemd[1]: Stopped target timers.target. Jul 14 21:45:41.665196 systemd[1]: dracut-pre-pivot.service: Deactivated successfully. Jul 14 21:45:41.665000 audit[1]: SERVICE_STOP pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=dracut-pre-pivot comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Jul 14 21:45:41.665313 systemd[1]: Stopped dracut-pre-pivot.service. Jul 14 21:45:41.666324 systemd[1]: Stopped target initrd.target. Jul 14 21:45:41.667337 systemd[1]: Stopped target basic.target. Jul 14 21:45:41.668220 systemd[1]: Stopped target ignition-complete.target. Jul 14 21:45:41.669250 systemd[1]: Stopped target ignition-diskful.target. Jul 14 21:45:41.670238 systemd[1]: Stopped target initrd-root-device.target. Jul 14 21:45:41.671305 systemd[1]: Stopped target remote-fs.target. Jul 14 21:45:41.672380 systemd[1]: Stopped target remote-fs-pre.target. Jul 14 21:45:41.673737 systemd[1]: Stopped target sysinit.target. Jul 14 21:45:41.674672 systemd[1]: Stopped target local-fs.target. Jul 14 21:45:41.675640 systemd[1]: Stopped target local-fs-pre.target. Jul 14 21:45:41.676572 systemd[1]: Stopped target swap.target. Jul 14 21:45:41.677000 audit[1]: SERVICE_STOP pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=dracut-pre-mount comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Jul 14 21:45:41.677437 systemd[1]: dracut-pre-mount.service: Deactivated successfully. Jul 14 21:45:41.677550 systemd[1]: Stopped dracut-pre-mount.service. Jul 14 21:45:41.679000 audit[1]: SERVICE_STOP pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=dracut-initqueue comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Jul 14 21:45:41.678492 systemd[1]: Stopped target cryptsetup.target. Jul 14 21:45:41.680000 audit[1]: SERVICE_STOP pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=ignition-fetch-offline comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Jul 14 21:45:41.679369 systemd[1]: dracut-initqueue.service: Deactivated successfully. Jul 14 21:45:41.679469 systemd[1]: Stopped dracut-initqueue.service. Jul 14 21:45:41.680509 systemd[1]: ignition-fetch-offline.service: Deactivated successfully. Jul 14 21:45:41.680602 systemd[1]: Stopped ignition-fetch-offline.service. Jul 14 21:45:41.681552 systemd[1]: Stopped target paths.target. Jul 14 21:45:41.682396 systemd[1]: systemd-ask-password-console.path: Deactivated successfully. Jul 14 21:45:41.685673 systemd[1]: Stopped systemd-ask-password-console.path. Jul 14 21:45:41.686625 systemd[1]: Stopped target slices.target. Jul 14 21:45:41.687596 systemd[1]: Stopped target sockets.target. Jul 14 21:45:41.688549 systemd[1]: iscsid.socket: Deactivated successfully. Jul 14 21:45:41.688621 systemd[1]: Closed iscsid.socket. Jul 14 21:45:41.689428 systemd[1]: iscsiuio.socket: Deactivated successfully. Jul 14 21:45:41.692000 audit[1]: SERVICE_STOP pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=initrd-setup-root-after-ignition comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Jul 14 21:45:41.689491 systemd[1]: Closed iscsiuio.socket. Jul 14 21:45:41.693000 audit[1]: SERVICE_STOP pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=ignition-files comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Jul 14 21:45:41.691701 systemd[1]: initrd-setup-root-after-ignition.service: Deactivated successfully. Jul 14 21:45:41.691802 systemd[1]: Stopped initrd-setup-root-after-ignition.service. Jul 14 21:45:41.692709 systemd[1]: ignition-files.service: Deactivated successfully. Jul 14 21:45:41.695000 audit[1]: SERVICE_STOP pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=kmod-static-nodes comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Jul 14 21:45:41.692797 systemd[1]: Stopped ignition-files.service. Jul 14 21:45:41.694610 systemd[1]: Stopping ignition-mount.service... Jul 14 21:45:41.695336 systemd[1]: kmod-static-nodes.service: Deactivated successfully. Jul 14 21:45:41.699000 audit[1]: SERVICE_STOP pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=systemd-udev-trigger comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Jul 14 21:45:41.695451 systemd[1]: Stopped kmod-static-nodes.service. Jul 14 21:45:41.700000 audit[1]: SERVICE_STOP pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=dracut-pre-trigger comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Jul 14 21:45:41.697220 systemd[1]: Stopping sysroot-boot.service... Jul 14 21:45:41.698162 systemd[1]: systemd-udev-trigger.service: Deactivated successfully. Jul 14 21:45:41.698278 systemd[1]: Stopped systemd-udev-trigger.service. Jul 14 21:45:41.699347 systemd[1]: dracut-pre-trigger.service: Deactivated successfully. Jul 14 21:45:41.699431 systemd[1]: Stopped dracut-pre-trigger.service. Jul 14 21:45:41.704219 ignition[898]: INFO : Ignition 2.14.0 Jul 14 21:45:41.704219 ignition[898]: INFO : Stage: umount Jul 14 21:45:41.704219 ignition[898]: INFO : no configs at "/usr/lib/ignition/base.d" Jul 14 21:45:41.704219 ignition[898]: INFO : no config dir at "/usr/lib/ignition/base.platform.d/qemu" Jul 14 21:45:41.704219 ignition[898]: INFO : umount: umount passed Jul 14 21:45:41.704219 ignition[898]: INFO : Ignition finished successfully Jul 14 21:45:41.704000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=initrd-cleanup comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Jul 14 21:45:41.704000 audit[1]: SERVICE_STOP pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=initrd-cleanup comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Jul 14 21:45:41.705000 audit[1]: SERVICE_STOP pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=ignition-mount comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Jul 14 21:45:41.708000 audit[1]: SERVICE_STOP pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=ignition-disks comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Jul 14 21:45:41.709000 audit[1]: SERVICE_STOP pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=ignition-kargs comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Jul 14 21:45:41.704340 systemd[1]: initrd-cleanup.service: Deactivated successfully. Jul 14 21:45:41.711000 audit[1]: SERVICE_STOP pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=ignition-setup comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Jul 14 21:45:41.704431 systemd[1]: Finished initrd-cleanup.service. Jul 14 21:45:41.705613 systemd[1]: ignition-mount.service: Deactivated successfully. Jul 14 21:45:41.705717 systemd[1]: Stopped ignition-mount.service. Jul 14 21:45:41.706506 systemd[1]: Stopped target network.target. Jul 14 21:45:41.707486 systemd[1]: ignition-disks.service: Deactivated successfully. Jul 14 21:45:41.707531 systemd[1]: Stopped ignition-disks.service. Jul 14 21:45:41.708893 systemd[1]: ignition-kargs.service: Deactivated successfully. Jul 14 21:45:41.708928 systemd[1]: Stopped ignition-kargs.service. Jul 14 21:45:41.718000 audit[1]: SERVICE_STOP pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=sysroot-boot comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Jul 14 21:45:41.709916 systemd[1]: ignition-setup.service: Deactivated successfully. Jul 14 21:45:41.719000 audit[1]: SERVICE_STOP pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=initrd-setup-root comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Jul 14 21:45:41.709950 systemd[1]: Stopped ignition-setup.service. Jul 14 21:45:41.711317 systemd[1]: Stopping systemd-networkd.service... Jul 14 21:45:41.714736 systemd[1]: Stopping systemd-resolved.service... Jul 14 21:45:41.716387 systemd[1]: sysroot-boot.mount: Deactivated successfully. Jul 14 21:45:41.718320 systemd[1]: sysroot-boot.service: Deactivated successfully. Jul 14 21:45:41.723000 audit[1]: SERVICE_STOP pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=systemd-resolved comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Jul 14 21:45:41.718400 systemd[1]: Stopped sysroot-boot.service. Jul 14 21:45:41.724000 audit[1]: SERVICE_STOP pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=systemd-networkd comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Jul 14 21:45:41.719549 systemd[1]: initrd-setup-root.service: Deactivated successfully. Jul 14 21:45:41.719586 systemd[1]: Stopped initrd-setup-root.service. Jul 14 21:45:41.722688 systemd-networkd[740]: eth0: DHCPv6 lease lost Jul 14 21:45:41.722823 systemd[1]: systemd-resolved.service: Deactivated successfully. Jul 14 21:45:41.728000 audit[1]: SERVICE_STOP pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=parse-ip-for-networkd comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Jul 14 21:45:41.722926 systemd[1]: Stopped systemd-resolved.service. Jul 14 21:45:41.729000 audit[1]: SERVICE_STOP pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=systemd-sysctl comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Jul 14 21:45:41.724326 systemd[1]: systemd-networkd.service: Deactivated successfully. Jul 14 21:45:41.730000 audit[1]: SERVICE_STOP pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=systemd-modules-load comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Jul 14 21:45:41.732000 audit: BPF prog-id=6 op=UNLOAD Jul 14 21:45:41.732000 audit: BPF prog-id=9 op=UNLOAD Jul 14 21:45:41.724414 systemd[1]: Stopped systemd-networkd.service. Jul 14 21:45:41.725325 systemd[1]: systemd-networkd.socket: Deactivated successfully. Jul 14 21:45:41.725352 systemd[1]: Closed systemd-networkd.socket. Jul 14 21:45:41.726696 systemd[1]: Stopping network-cleanup.service... Jul 14 21:45:41.727565 systemd[1]: parse-ip-for-networkd.service: Deactivated successfully. Jul 14 21:45:41.727614 systemd[1]: Stopped parse-ip-for-networkd.service. Jul 14 21:45:41.728648 systemd[1]: systemd-sysctl.service: Deactivated successfully. Jul 14 21:45:41.737000 audit[1]: SERVICE_STOP pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=network-cleanup comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Jul 14 21:45:41.728686 systemd[1]: Stopped systemd-sysctl.service. Jul 14 21:45:41.730246 systemd[1]: systemd-modules-load.service: Deactivated successfully. Jul 14 21:45:41.739000 audit[1]: SERVICE_STOP pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=systemd-udevd comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Jul 14 21:45:41.730283 systemd[1]: Stopped systemd-modules-load.service. Jul 14 21:45:41.731016 systemd[1]: Stopping systemd-udevd.service... Jul 14 21:45:41.735079 systemd[1]: run-credentials-systemd\x2dsysctl.service.mount: Deactivated successfully. Jul 14 21:45:41.742000 audit[1]: SERVICE_STOP pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=dracut-pre-udev comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Jul 14 21:45:41.737484 systemd[1]: network-cleanup.service: Deactivated successfully. Jul 14 21:45:41.743000 audit[1]: SERVICE_STOP pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=dracut-cmdline comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Jul 14 21:45:41.737577 systemd[1]: Stopped network-cleanup.service. Jul 14 21:45:41.744000 audit[1]: SERVICE_STOP pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=dracut-cmdline-ask comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Jul 14 21:45:41.739106 systemd[1]: systemd-udevd.service: Deactivated successfully. Jul 14 21:45:41.739219 systemd[1]: Stopped systemd-udevd.service. Jul 14 21:45:41.740173 systemd[1]: systemd-udevd-control.socket: Deactivated successfully. Jul 14 21:45:41.748000 audit[1]: SERVICE_STOP pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=systemd-vconsole-setup comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Jul 14 21:45:41.740208 systemd[1]: Closed systemd-udevd-control.socket. Jul 14 21:45:41.741193 systemd[1]: systemd-udevd-kernel.socket: Deactivated successfully. Jul 14 21:45:41.741221 systemd[1]: Closed systemd-udevd-kernel.socket. Jul 14 21:45:41.742254 systemd[1]: dracut-pre-udev.service: Deactivated successfully. Jul 14 21:45:41.742292 systemd[1]: Stopped dracut-pre-udev.service. Jul 14 21:45:41.743204 systemd[1]: dracut-cmdline.service: Deactivated successfully. Jul 14 21:45:41.751000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=initrd-udevadm-cleanup-db comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Jul 14 21:45:41.751000 audit[1]: SERVICE_STOP pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=initrd-udevadm-cleanup-db comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Jul 14 21:45:41.743236 systemd[1]: Stopped dracut-cmdline.service. Jul 14 21:45:41.744402 systemd[1]: dracut-cmdline-ask.service: Deactivated successfully. Jul 14 21:45:41.744435 systemd[1]: Stopped dracut-cmdline-ask.service. Jul 14 21:45:41.746159 systemd[1]: Starting initrd-udevadm-cleanup-db.service... Jul 14 21:45:41.747112 systemd[1]: systemd-vconsole-setup.service: Deactivated successfully. Jul 14 21:45:41.747159 systemd[1]: Stopped systemd-vconsole-setup.service. Jul 14 21:45:41.751472 systemd[1]: initrd-udevadm-cleanup-db.service: Deactivated successfully. Jul 14 21:45:41.751553 systemd[1]: Finished initrd-udevadm-cleanup-db.service. Jul 14 21:45:41.752494 systemd[1]: Reached target initrd-switch-root.target. Jul 14 21:45:41.754213 systemd[1]: Starting initrd-switch-root.service... Jul 14 21:45:41.760540 systemd[1]: Switching root. Jul 14 21:45:41.779970 iscsid[748]: iscsid shutting down. Jul 14 21:45:41.780479 systemd-journald[290]: Journal stopped Jul 14 21:45:43.769096 systemd-journald[290]: Received SIGTERM from PID 1 (systemd). Jul 14 21:45:43.769164 kernel: SELinux: Class mctp_socket not defined in policy. Jul 14 21:45:43.769177 kernel: SELinux: Class anon_inode not defined in policy. Jul 14 21:45:43.769191 kernel: SELinux: the above unknown classes and permissions will be allowed Jul 14 21:45:43.769205 kernel: SELinux: policy capability network_peer_controls=1 Jul 14 21:45:43.769214 kernel: SELinux: policy capability open_perms=1 Jul 14 21:45:43.769227 kernel: SELinux: policy capability extended_socket_class=1 Jul 14 21:45:43.769236 kernel: SELinux: policy capability always_check_network=0 Jul 14 21:45:43.769246 kernel: SELinux: policy capability cgroup_seclabel=1 Jul 14 21:45:43.769255 kernel: SELinux: policy capability nnp_nosuid_transition=1 Jul 14 21:45:43.769265 kernel: SELinux: policy capability genfs_seclabel_symlinks=0 Jul 14 21:45:43.769274 kernel: SELinux: policy capability ioctl_skip_cloexec=0 Jul 14 21:45:43.769286 systemd[1]: Successfully loaded SELinux policy in 39.970ms. Jul 14 21:45:43.769299 systemd[1]: Relabelled /dev, /dev/shm, /run, /sys/fs/cgroup in 9.337ms. Jul 14 21:45:43.769311 systemd[1]: systemd 252 running in system mode (+PAM +AUDIT +SELINUX -APPARMOR +IMA +SMACK +SECCOMP +GCRYPT -GNUTLS +OPENSSL -ACL +BLKID +CURL -ELFUTILS -FIDO2 +IDN2 -IDN +IPTC +KMOD +LIBCRYPTSETUP +LIBFDISK +PCRE2 -PWQUALITY -P11KIT -QRENCODE -TPM2 +BZIP2 +LZ4 +XZ +ZLIB +ZSTD -BPF_FRAMEWORK -XKBCOMMON +UTMP +SYSVINIT default-hierarchy=unified) Jul 14 21:45:43.769322 systemd[1]: Detected virtualization kvm. Jul 14 21:45:43.769332 systemd[1]: Detected architecture arm64. Jul 14 21:45:43.769344 systemd[1]: Detected first boot. Jul 14 21:45:43.769354 systemd[1]: Initializing machine ID from VM UUID. Jul 14 21:45:43.769365 kernel: SELinux: Context system_u:object_r:container_file_t:s0:c1022,c1023 is not valid (left unmapped). Jul 14 21:45:43.769376 systemd[1]: Populated /etc with preset unit settings. Jul 14 21:45:43.769387 systemd[1]: /usr/lib/systemd/system/locksmithd.service:8: Unit uses CPUShares=; please use CPUWeight= instead. Support for CPUShares= will be removed soon. Jul 14 21:45:43.769398 systemd[1]: /usr/lib/systemd/system/locksmithd.service:9: Unit uses MemoryLimit=; please use MemoryMax= instead. Support for MemoryLimit= will be removed soon. Jul 14 21:45:43.769410 systemd[1]: /run/systemd/system/docker.socket:8: ListenStream= references a path below legacy directory /var/run/, updating /var/run/docker.sock → /run/docker.sock; please update the unit file accordingly. Jul 14 21:45:43.769421 kernel: kauditd_printk_skb: 77 callbacks suppressed Jul 14 21:45:43.769430 kernel: audit: type=1334 audit(1752529543.634:81): prog-id=12 op=LOAD Jul 14 21:45:43.769440 kernel: audit: type=1334 audit(1752529543.634:82): prog-id=3 op=UNLOAD Jul 14 21:45:43.769451 kernel: audit: type=1334 audit(1752529543.634:83): prog-id=13 op=LOAD Jul 14 21:45:43.769461 kernel: audit: type=1334 audit(1752529543.635:84): prog-id=14 op=LOAD Jul 14 21:45:43.769470 kernel: audit: type=1334 audit(1752529543.635:85): prog-id=4 op=UNLOAD Jul 14 21:45:43.769481 kernel: audit: type=1334 audit(1752529543.635:86): prog-id=5 op=UNLOAD Jul 14 21:45:43.769491 kernel: audit: type=1334 audit(1752529543.636:87): prog-id=15 op=LOAD Jul 14 21:45:43.769500 kernel: audit: type=1334 audit(1752529543.636:88): prog-id=12 op=UNLOAD Jul 14 21:45:43.769510 kernel: audit: type=1334 audit(1752529543.637:89): prog-id=16 op=LOAD Jul 14 21:45:43.769519 kernel: audit: type=1334 audit(1752529543.637:90): prog-id=17 op=LOAD Jul 14 21:45:43.769529 systemd[1]: iscsiuio.service: Deactivated successfully. Jul 14 21:45:43.769541 systemd[1]: Stopped iscsiuio.service. Jul 14 21:45:43.769552 systemd[1]: iscsid.service: Deactivated successfully. Jul 14 21:45:43.769562 systemd[1]: Stopped iscsid.service. Jul 14 21:45:43.769573 systemd[1]: initrd-switch-root.service: Deactivated successfully. Jul 14 21:45:43.769583 systemd[1]: Stopped initrd-switch-root.service. Jul 14 21:45:43.769593 systemd[1]: systemd-journald.service: Scheduled restart job, restart counter is at 1. Jul 14 21:45:43.769606 systemd[1]: Created slice system-addon\x2dconfig.slice. Jul 14 21:45:43.769619 systemd[1]: Created slice system-addon\x2drun.slice. Jul 14 21:45:43.769643 systemd[1]: Created slice system-getty.slice. Jul 14 21:45:43.769655 systemd[1]: Created slice system-modprobe.slice. Jul 14 21:45:43.769665 systemd[1]: Created slice system-serial\x2dgetty.slice. Jul 14 21:45:43.769676 systemd[1]: Created slice system-system\x2dcloudinit.slice. Jul 14 21:45:43.769686 systemd[1]: Created slice system-systemd\x2dfsck.slice. Jul 14 21:45:43.769697 systemd[1]: Created slice user.slice. Jul 14 21:45:43.769708 systemd[1]: Started systemd-ask-password-console.path. Jul 14 21:45:43.769720 systemd[1]: Started systemd-ask-password-wall.path. Jul 14 21:45:43.769731 systemd[1]: Set up automount boot.automount. Jul 14 21:45:43.769742 systemd[1]: Set up automount proc-sys-fs-binfmt_misc.automount. Jul 14 21:45:43.769752 systemd[1]: Stopped target initrd-switch-root.target. Jul 14 21:45:43.769762 systemd[1]: Stopped target initrd-fs.target. Jul 14 21:45:43.769772 systemd[1]: Stopped target initrd-root-fs.target. Jul 14 21:45:43.769784 systemd[1]: Reached target integritysetup.target. Jul 14 21:45:43.769795 systemd[1]: Reached target remote-cryptsetup.target. Jul 14 21:45:43.769806 systemd[1]: Reached target remote-fs.target. Jul 14 21:45:43.769817 systemd[1]: Reached target slices.target. Jul 14 21:45:43.769835 systemd[1]: Reached target swap.target. Jul 14 21:45:43.769846 systemd[1]: Reached target torcx.target. Jul 14 21:45:43.769856 systemd[1]: Reached target veritysetup.target. Jul 14 21:45:43.769868 systemd[1]: Listening on systemd-coredump.socket. Jul 14 21:45:43.769878 systemd[1]: Listening on systemd-initctl.socket. Jul 14 21:45:43.769890 systemd[1]: Listening on systemd-networkd.socket. Jul 14 21:45:43.769900 systemd[1]: Listening on systemd-udevd-control.socket. Jul 14 21:45:43.769910 systemd[1]: Listening on systemd-udevd-kernel.socket. Jul 14 21:45:43.769921 systemd[1]: Listening on systemd-userdbd.socket. Jul 14 21:45:43.769932 systemd[1]: Mounting dev-hugepages.mount... Jul 14 21:45:43.769942 systemd[1]: Mounting dev-mqueue.mount... Jul 14 21:45:43.769952 systemd[1]: Mounting media.mount... Jul 14 21:45:43.769963 systemd[1]: Mounting sys-kernel-debug.mount... Jul 14 21:45:43.769973 systemd[1]: Mounting sys-kernel-tracing.mount... Jul 14 21:45:43.769985 systemd[1]: Mounting tmp.mount... Jul 14 21:45:43.769995 systemd[1]: Starting flatcar-tmpfiles.service... Jul 14 21:45:43.770005 systemd[1]: ignition-delete-config.service was skipped because no trigger condition checks were met. Jul 14 21:45:43.770016 systemd[1]: Starting kmod-static-nodes.service... Jul 14 21:45:43.770027 systemd[1]: Starting modprobe@configfs.service... Jul 14 21:45:43.770037 systemd[1]: Starting modprobe@dm_mod.service... Jul 14 21:45:43.770047 systemd[1]: Starting modprobe@drm.service... Jul 14 21:45:43.770058 systemd[1]: Starting modprobe@efi_pstore.service... Jul 14 21:45:43.770068 systemd[1]: Starting modprobe@fuse.service... Jul 14 21:45:43.770079 systemd[1]: Starting modprobe@loop.service... Jul 14 21:45:43.770091 systemd[1]: setup-nsswitch.service was skipped because of an unmet condition check (ConditionPathExists=!/etc/nsswitch.conf). Jul 14 21:45:43.770102 systemd[1]: systemd-fsck-root.service: Deactivated successfully. Jul 14 21:45:43.770112 systemd[1]: Stopped systemd-fsck-root.service. Jul 14 21:45:43.770122 systemd[1]: systemd-fsck-usr.service: Deactivated successfully. Jul 14 21:45:43.770133 systemd[1]: Stopped systemd-fsck-usr.service. Jul 14 21:45:43.770143 systemd[1]: Stopped systemd-journald.service. Jul 14 21:45:43.770153 kernel: fuse: init (API version 7.34) Jul 14 21:45:43.770163 systemd[1]: Starting systemd-journald.service... Jul 14 21:45:43.770176 systemd[1]: Starting systemd-modules-load.service... Jul 14 21:45:43.770186 systemd[1]: Starting systemd-network-generator.service... Jul 14 21:45:43.770196 kernel: loop: module loaded Jul 14 21:45:43.770206 systemd[1]: Starting systemd-remount-fs.service... Jul 14 21:45:43.770217 systemd[1]: Starting systemd-udev-trigger.service... Jul 14 21:45:43.770227 systemd[1]: verity-setup.service: Deactivated successfully. Jul 14 21:45:43.770238 systemd[1]: Stopped verity-setup.service. Jul 14 21:45:43.770249 systemd[1]: Mounted dev-hugepages.mount. Jul 14 21:45:43.770259 systemd[1]: Mounted dev-mqueue.mount. Jul 14 21:45:43.770269 systemd[1]: Mounted media.mount. Jul 14 21:45:43.770281 systemd[1]: Mounted sys-kernel-debug.mount. Jul 14 21:45:43.770291 systemd[1]: Mounted sys-kernel-tracing.mount. Jul 14 21:45:43.770302 systemd[1]: Mounted tmp.mount. Jul 14 21:45:43.770312 systemd[1]: Finished kmod-static-nodes.service. Jul 14 21:45:43.770322 systemd[1]: modprobe@configfs.service: Deactivated successfully. Jul 14 21:45:43.770334 systemd[1]: Finished modprobe@configfs.service. Jul 14 21:45:43.770345 systemd[1]: modprobe@dm_mod.service: Deactivated successfully. Jul 14 21:45:43.770355 systemd[1]: Finished modprobe@dm_mod.service. Jul 14 21:45:43.770372 systemd-journald[992]: Journal started Jul 14 21:45:43.770415 systemd-journald[992]: Runtime Journal (/run/log/journal/6089e8fe23d74dc9a859aa94a86b28e6) is 6.0M, max 48.7M, 42.6M free. Jul 14 21:45:41.863000 audit: MAC_POLICY_LOAD auid=4294967295 ses=4294967295 lsm=selinux res=1 Jul 14 21:45:41.909000 audit[1]: AVC avc: denied { bpf } for pid=1 comm="systemd" capability=39 scontext=system_u:system_r:kernel_t:s0 tcontext=system_u:system_r:kernel_t:s0 tclass=capability2 permissive=1 Jul 14 21:45:41.909000 audit[1]: AVC avc: denied { perfmon } for pid=1 comm="systemd" capability=38 scontext=system_u:system_r:kernel_t:s0 tcontext=system_u:system_r:kernel_t:s0 tclass=capability2 permissive=1 Jul 14 21:45:41.909000 audit: BPF prog-id=10 op=LOAD Jul 14 21:45:41.909000 audit: BPF prog-id=10 op=UNLOAD Jul 14 21:45:41.909000 audit: BPF prog-id=11 op=LOAD Jul 14 21:45:41.909000 audit: BPF prog-id=11 op=UNLOAD Jul 14 21:45:41.951000 audit[931]: AVC avc: denied { associate } for pid=931 comm="torcx-generator" name="docker" dev="tmpfs" ino=2 scontext=system_u:object_r:unlabeled_t:s0 tcontext=system_u:object_r:tmpfs_t:s0 tclass=filesystem permissive=1 srawcon="system_u:object_r:container_file_t:s0:c1022,c1023" Jul 14 21:45:41.951000 audit[931]: SYSCALL arch=c00000b7 syscall=5 success=yes exit=0 a0=40001c58b4 a1=40000c8de0 a2=40000cf040 a3=32 items=0 ppid=914 pid=931 auid=4294967295 uid=0 gid=0 euid=0 suid=0 fsuid=0 egid=0 sgid=0 fsgid=0 tty=(none) ses=4294967295 comm="torcx-generator" exe="/usr/lib/systemd/system-generators/torcx-generator" subj=system_u:system_r:kernel_t:s0 key=(null) Jul 14 21:45:41.951000 audit: PROCTITLE proctitle=2F7573722F6C69622F73797374656D642F73797374656D2D67656E657261746F72732F746F7263782D67656E657261746F72002F72756E2F73797374656D642F67656E657261746F72002F72756E2F73797374656D642F67656E657261746F722E6561726C79002F72756E2F73797374656D642F67656E657261746F722E6C61 Jul 14 21:45:41.952000 audit[931]: AVC avc: denied { associate } for pid=931 comm="torcx-generator" name="usr" scontext=system_u:object_r:unlabeled_t:s0 tcontext=system_u:object_r:tmpfs_t:s0 tclass=filesystem permissive=1 Jul 14 21:45:41.952000 audit[931]: SYSCALL arch=c00000b7 syscall=34 success=yes exit=0 a0=ffffffffffffff9c a1=40001c5989 a2=1ed a3=0 items=2 ppid=914 pid=931 auid=4294967295 uid=0 gid=0 euid=0 suid=0 fsuid=0 egid=0 sgid=0 fsgid=0 tty=(none) ses=4294967295 comm="torcx-generator" exe="/usr/lib/systemd/system-generators/torcx-generator" subj=system_u:system_r:kernel_t:s0 key=(null) Jul 14 21:45:41.952000 audit: CWD cwd="/" Jul 14 21:45:41.952000 audit: PATH item=0 name=(null) inode=2 dev=00:1c mode=040755 ouid=0 ogid=0 rdev=00:00 obj=system_u:object_r:unlabeled_t:s0 nametype=PARENT cap_fp=0 cap_fi=0 cap_fe=0 cap_fver=0 cap_frootid=0 Jul 14 21:45:41.952000 audit: PATH item=1 name=(null) inode=3 dev=00:1c mode=040755 ouid=0 ogid=0 rdev=00:00 obj=system_u:object_r:unlabeled_t:s0 nametype=CREATE cap_fp=0 cap_fi=0 cap_fe=0 cap_fver=0 cap_frootid=0 Jul 14 21:45:41.952000 audit: PROCTITLE proctitle=2F7573722F6C69622F73797374656D642F73797374656D2D67656E657261746F72732F746F7263782D67656E657261746F72002F72756E2F73797374656D642F67656E657261746F72002F72756E2F73797374656D642F67656E657261746F722E6561726C79002F72756E2F73797374656D642F67656E657261746F722E6C61 Jul 14 21:45:43.634000 audit: BPF prog-id=12 op=LOAD Jul 14 21:45:43.634000 audit: BPF prog-id=3 op=UNLOAD Jul 14 21:45:43.634000 audit: BPF prog-id=13 op=LOAD Jul 14 21:45:43.635000 audit: BPF prog-id=14 op=LOAD Jul 14 21:45:43.635000 audit: BPF prog-id=4 op=UNLOAD Jul 14 21:45:43.635000 audit: BPF prog-id=5 op=UNLOAD Jul 14 21:45:43.636000 audit: BPF prog-id=15 op=LOAD Jul 14 21:45:43.636000 audit: BPF prog-id=12 op=UNLOAD Jul 14 21:45:43.637000 audit: BPF prog-id=16 op=LOAD Jul 14 21:45:43.637000 audit: BPF prog-id=17 op=LOAD Jul 14 21:45:43.637000 audit: BPF prog-id=13 op=UNLOAD Jul 14 21:45:43.637000 audit: BPF prog-id=14 op=UNLOAD Jul 14 21:45:43.638000 audit: BPF prog-id=18 op=LOAD Jul 14 21:45:43.638000 audit: BPF prog-id=15 op=UNLOAD Jul 14 21:45:43.639000 audit: BPF prog-id=19 op=LOAD Jul 14 21:45:43.639000 audit: BPF prog-id=20 op=LOAD Jul 14 21:45:43.639000 audit: BPF prog-id=16 op=UNLOAD Jul 14 21:45:43.639000 audit: BPF prog-id=17 op=UNLOAD Jul 14 21:45:43.640000 audit[1]: SERVICE_STOP pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=systemd-journald comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Jul 14 21:45:43.642000 audit[1]: SERVICE_STOP pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=iscsiuio comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Jul 14 21:45:43.644000 audit[1]: SERVICE_STOP pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=iscsid comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Jul 14 21:45:43.647000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=initrd-switch-root comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Jul 14 21:45:43.647000 audit[1]: SERVICE_STOP pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=initrd-switch-root comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Jul 14 21:45:43.658000 audit: BPF prog-id=18 op=UNLOAD Jul 14 21:45:43.736000 audit[1]: SERVICE_STOP pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=systemd-fsck-root comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Jul 14 21:45:43.738000 audit[1]: SERVICE_STOP pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=systemd-fsck-usr comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Jul 14 21:45:43.739000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=systemd-journald comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Jul 14 21:45:43.739000 audit[1]: SERVICE_STOP pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=systemd-journald comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Jul 14 21:45:43.740000 audit: BPF prog-id=21 op=LOAD Jul 14 21:45:43.740000 audit: BPF prog-id=22 op=LOAD Jul 14 21:45:43.740000 audit: BPF prog-id=23 op=LOAD Jul 14 21:45:43.740000 audit: BPF prog-id=19 op=UNLOAD Jul 14 21:45:43.740000 audit: BPF prog-id=20 op=UNLOAD Jul 14 21:45:43.754000 audit[1]: SERVICE_STOP pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=verity-setup comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Jul 14 21:45:43.765000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=kmod-static-nodes comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Jul 14 21:45:43.765000 audit: CONFIG_CHANGE op=set audit_enabled=1 old=1 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 res=1 Jul 14 21:45:43.765000 audit[992]: SYSCALL arch=c00000b7 syscall=211 success=yes exit=60 a0=5 a1=ffffc7541a10 a2=4000 a3=1 items=0 ppid=1 pid=992 auid=4294967295 uid=0 gid=0 euid=0 suid=0 fsuid=0 egid=0 sgid=0 fsgid=0 tty=(none) ses=4294967295 comm="systemd-journal" exe="/usr/lib/systemd/systemd-journald" subj=system_u:system_r:kernel_t:s0 key=(null) Jul 14 21:45:43.765000 audit: PROCTITLE proctitle="/usr/lib/systemd/systemd-journald" Jul 14 21:45:43.767000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=modprobe@configfs comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Jul 14 21:45:43.767000 audit[1]: SERVICE_STOP pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=modprobe@configfs comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Jul 14 21:45:43.769000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=modprobe@dm_mod comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Jul 14 21:45:43.769000 audit[1]: SERVICE_STOP pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=modprobe@dm_mod comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Jul 14 21:45:41.950101 /usr/lib/systemd/system-generators/torcx-generator[931]: time="2025-07-14T21:45:41Z" level=debug msg="common configuration parsed" base_dir=/var/lib/torcx/ conf_dir=/etc/torcx/ run_dir=/run/torcx/ store_paths="[/usr/share/torcx/store /usr/share/oem/torcx/store/3510.3.101 /usr/share/oem/torcx/store /var/lib/torcx/store/3510.3.101 /var/lib/torcx/store]" Jul 14 21:45:43.632992 systemd[1]: Queued start job for default target multi-user.target. Jul 14 21:45:43.771820 systemd[1]: Started systemd-journald.service. Jul 14 21:45:41.950451 /usr/lib/systemd/system-generators/torcx-generator[931]: time="2025-07-14T21:45:41Z" level=debug msg="profile found" name=docker-1.12-no path=/usr/share/torcx/profiles/docker-1.12-no.json Jul 14 21:45:43.633003 systemd[1]: Unnecessary job was removed for dev-vda6.device. Jul 14 21:45:41.950471 /usr/lib/systemd/system-generators/torcx-generator[931]: time="2025-07-14T21:45:41Z" level=debug msg="profile found" name=vendor path=/usr/share/torcx/profiles/vendor.json Jul 14 21:45:43.771000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=systemd-journald comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Jul 14 21:45:43.640690 systemd[1]: systemd-journald.service: Deactivated successfully. Jul 14 21:45:41.950503 /usr/lib/systemd/system-generators/torcx-generator[931]: time="2025-07-14T21:45:41Z" level=info msg="no vendor profile selected by /etc/flatcar/docker-1.12" Jul 14 21:45:41.950513 /usr/lib/systemd/system-generators/torcx-generator[931]: time="2025-07-14T21:45:41Z" level=debug msg="skipped missing lower profile" missing profile=oem Jul 14 21:45:41.950541 /usr/lib/systemd/system-generators/torcx-generator[931]: time="2025-07-14T21:45:41Z" level=warning msg="no next profile: unable to read profile file: open /etc/torcx/next-profile: no such file or directory" Jul 14 21:45:43.772242 systemd[1]: modprobe@drm.service: Deactivated successfully. Jul 14 21:45:41.950553 /usr/lib/systemd/system-generators/torcx-generator[931]: time="2025-07-14T21:45:41Z" level=debug msg="apply configuration parsed" lower profiles (vendor/oem)="[vendor]" upper profile (user)= Jul 14 21:45:41.950780 /usr/lib/systemd/system-generators/torcx-generator[931]: time="2025-07-14T21:45:41Z" level=debug msg="mounted tmpfs" target=/run/torcx/unpack Jul 14 21:45:43.772411 systemd[1]: Finished modprobe@drm.service. Jul 14 21:45:41.950815 /usr/lib/systemd/system-generators/torcx-generator[931]: time="2025-07-14T21:45:41Z" level=debug msg="profile found" name=docker-1.12-no path=/usr/share/torcx/profiles/docker-1.12-no.json Jul 14 21:45:41.950827 /usr/lib/systemd/system-generators/torcx-generator[931]: time="2025-07-14T21:45:41Z" level=debug msg="profile found" name=vendor path=/usr/share/torcx/profiles/vendor.json Jul 14 21:45:41.951664 /usr/lib/systemd/system-generators/torcx-generator[931]: time="2025-07-14T21:45:41Z" level=debug msg="new archive/reference added to cache" format=tgz name=docker path="/usr/share/torcx/store/docker:20.10.torcx.tgz" reference=20.10 Jul 14 21:45:41.951702 /usr/lib/systemd/system-generators/torcx-generator[931]: time="2025-07-14T21:45:41Z" level=debug msg="new archive/reference added to cache" format=tgz name=docker path="/usr/share/torcx/store/docker:com.coreos.cl.torcx.tgz" reference=com.coreos.cl Jul 14 21:45:41.951721 /usr/lib/systemd/system-generators/torcx-generator[931]: time="2025-07-14T21:45:41Z" level=info msg="store skipped" err="open /usr/share/oem/torcx/store/3510.3.101: no such file or directory" path=/usr/share/oem/torcx/store/3510.3.101 Jul 14 21:45:41.951734 /usr/lib/systemd/system-generators/torcx-generator[931]: time="2025-07-14T21:45:41Z" level=info msg="store skipped" err="open /usr/share/oem/torcx/store: no such file or directory" path=/usr/share/oem/torcx/store Jul 14 21:45:41.951752 /usr/lib/systemd/system-generators/torcx-generator[931]: time="2025-07-14T21:45:41Z" level=info msg="store skipped" err="open /var/lib/torcx/store/3510.3.101: no such file or directory" path=/var/lib/torcx/store/3510.3.101 Jul 14 21:45:43.772000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=modprobe@drm comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Jul 14 21:45:43.772000 audit[1]: SERVICE_STOP pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=modprobe@drm comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Jul 14 21:45:41.951765 /usr/lib/systemd/system-generators/torcx-generator[931]: time="2025-07-14T21:45:41Z" level=info msg="store skipped" err="open /var/lib/torcx/store: no such file or directory" path=/var/lib/torcx/store Jul 14 21:45:43.391812 /usr/lib/systemd/system-generators/torcx-generator[931]: time="2025-07-14T21:45:43Z" level=debug msg="image unpacked" image=docker path=/run/torcx/unpack/docker reference=com.coreos.cl Jul 14 21:45:43.392081 /usr/lib/systemd/system-generators/torcx-generator[931]: time="2025-07-14T21:45:43Z" level=debug msg="binaries propagated" assets="[/bin/containerd /bin/containerd-shim /bin/ctr /bin/docker /bin/docker-containerd /bin/docker-containerd-shim /bin/docker-init /bin/docker-proxy /bin/docker-runc /bin/dockerd /bin/runc /bin/tini]" image=docker path=/run/torcx/unpack/docker reference=com.coreos.cl Jul 14 21:45:43.392177 /usr/lib/systemd/system-generators/torcx-generator[931]: time="2025-07-14T21:45:43Z" level=debug msg="networkd units propagated" assets="[/lib/systemd/network/50-docker.network /lib/systemd/network/90-docker-veth.network]" image=docker path=/run/torcx/unpack/docker reference=com.coreos.cl Jul 14 21:45:43.392340 /usr/lib/systemd/system-generators/torcx-generator[931]: time="2025-07-14T21:45:43Z" level=debug msg="systemd units propagated" assets="[/lib/systemd/system/containerd.service /lib/systemd/system/docker.service /lib/systemd/system/docker.socket /lib/systemd/system/sockets.target.wants /lib/systemd/system/multi-user.target.wants]" image=docker path=/run/torcx/unpack/docker reference=com.coreos.cl Jul 14 21:45:43.392389 /usr/lib/systemd/system-generators/torcx-generator[931]: time="2025-07-14T21:45:43Z" level=debug msg="profile applied" sealed profile=/run/torcx/profile.json upper profile= Jul 14 21:45:43.392446 /usr/lib/systemd/system-generators/torcx-generator[931]: time="2025-07-14T21:45:43Z" level=debug msg="system state sealed" content="[TORCX_LOWER_PROFILES=\"vendor\" TORCX_UPPER_PROFILE=\"\" TORCX_PROFILE_PATH=\"/run/torcx/profile.json\" TORCX_BINDIR=\"/run/torcx/bin\" TORCX_UNPACKDIR=\"/run/torcx/unpack\"]" path=/run/metadata/torcx Jul 14 21:45:43.773602 systemd[1]: modprobe@efi_pstore.service: Deactivated successfully. Jul 14 21:45:43.775235 systemd[1]: Finished modprobe@efi_pstore.service. Jul 14 21:45:43.775000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=modprobe@efi_pstore comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Jul 14 21:45:43.775000 audit[1]: SERVICE_STOP pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=modprobe@efi_pstore comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Jul 14 21:45:43.776172 systemd[1]: modprobe@fuse.service: Deactivated successfully. Jul 14 21:45:43.776333 systemd[1]: Finished modprobe@fuse.service. Jul 14 21:45:43.776000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=modprobe@fuse comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Jul 14 21:45:43.776000 audit[1]: SERVICE_STOP pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=modprobe@fuse comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Jul 14 21:45:43.777247 systemd[1]: modprobe@loop.service: Deactivated successfully. Jul 14 21:45:43.778106 systemd[1]: Finished modprobe@loop.service. Jul 14 21:45:43.778000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=modprobe@loop comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Jul 14 21:45:43.778000 audit[1]: SERVICE_STOP pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=modprobe@loop comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Jul 14 21:45:43.779027 systemd[1]: Finished systemd-modules-load.service. Jul 14 21:45:43.779000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=systemd-modules-load comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Jul 14 21:45:43.780084 systemd[1]: Finished systemd-network-generator.service. Jul 14 21:45:43.780000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=systemd-network-generator comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Jul 14 21:45:43.781167 systemd[1]: Finished systemd-remount-fs.service. Jul 14 21:45:43.781000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=systemd-remount-fs comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Jul 14 21:45:43.782285 systemd[1]: Reached target network-pre.target. Jul 14 21:45:43.785142 systemd[1]: Mounting sys-fs-fuse-connections.mount... Jul 14 21:45:43.786901 systemd[1]: Mounting sys-kernel-config.mount... Jul 14 21:45:43.787461 systemd[1]: remount-root.service was skipped because of an unmet condition check (ConditionPathIsReadWrite=!/). Jul 14 21:45:43.789623 systemd[1]: Starting systemd-hwdb-update.service... Jul 14 21:45:43.791787 systemd[1]: Starting systemd-journal-flush.service... Jul 14 21:45:43.792492 systemd[1]: systemd-pstore.service was skipped because of an unmet condition check (ConditionDirectoryNotEmpty=/sys/fs/pstore). Jul 14 21:45:43.793814 systemd[1]: Starting systemd-random-seed.service... Jul 14 21:45:43.794547 systemd[1]: systemd-repart.service was skipped because no trigger condition checks were met. Jul 14 21:45:43.798371 systemd[1]: Starting systemd-sysctl.service... Jul 14 21:45:43.799809 systemd-journald[992]: Time spent on flushing to /var/log/journal/6089e8fe23d74dc9a859aa94a86b28e6 is 11.507ms for 965 entries. Jul 14 21:45:43.799809 systemd-journald[992]: System Journal (/var/log/journal/6089e8fe23d74dc9a859aa94a86b28e6) is 8.0M, max 195.6M, 187.6M free. Jul 14 21:45:43.846055 systemd-journald[992]: Received client request to flush runtime journal. Jul 14 21:45:43.803000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=flatcar-tmpfiles comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Jul 14 21:45:43.809000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=systemd-udev-trigger comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Jul 14 21:45:43.824000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=systemd-random-seed comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Jul 14 21:45:43.825000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=systemd-sysctl comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Jul 14 21:45:43.827000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=systemd-sysusers comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Jul 14 21:45:43.801711 systemd[1]: Mounted sys-fs-fuse-connections.mount. Jul 14 21:45:43.802439 systemd[1]: Mounted sys-kernel-config.mount. Jul 14 21:45:43.846735 udevadm[1031]: systemd-udev-settle.service is deprecated. Please fix lvm2-activation-early.service, lvm2-activation.service not to pull it in. Jul 14 21:45:43.803386 systemd[1]: Finished flatcar-tmpfiles.service. Jul 14 21:45:43.805696 systemd[1]: Starting systemd-sysusers.service... Jul 14 21:45:43.809046 systemd[1]: Finished systemd-udev-trigger.service. Jul 14 21:45:43.811078 systemd[1]: Starting systemd-udev-settle.service... Jul 14 21:45:43.824770 systemd[1]: Finished systemd-random-seed.service. Jul 14 21:45:43.825821 systemd[1]: Finished systemd-sysctl.service. Jul 14 21:45:43.826570 systemd[1]: Reached target first-boot-complete.target. Jul 14 21:45:43.827672 systemd[1]: Finished systemd-sysusers.service. Jul 14 21:45:43.847034 systemd[1]: Finished systemd-journal-flush.service. Jul 14 21:45:43.847000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=systemd-journal-flush comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Jul 14 21:45:44.201124 systemd[1]: Finished systemd-hwdb-update.service. Jul 14 21:45:44.201000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=systemd-hwdb-update comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Jul 14 21:45:44.201000 audit: BPF prog-id=24 op=LOAD Jul 14 21:45:44.201000 audit: BPF prog-id=25 op=LOAD Jul 14 21:45:44.201000 audit: BPF prog-id=7 op=UNLOAD Jul 14 21:45:44.201000 audit: BPF prog-id=8 op=UNLOAD Jul 14 21:45:44.203273 systemd[1]: Starting systemd-udevd.service... Jul 14 21:45:44.220454 systemd-udevd[1035]: Using default interface naming scheme 'v252'. Jul 14 21:45:44.238451 systemd[1]: Started systemd-udevd.service. Jul 14 21:45:44.238000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=systemd-udevd comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Jul 14 21:45:44.239000 audit: BPF prog-id=26 op=LOAD Jul 14 21:45:44.241944 systemd[1]: Starting systemd-networkd.service... Jul 14 21:45:44.247000 audit: BPF prog-id=27 op=LOAD Jul 14 21:45:44.247000 audit: BPF prog-id=28 op=LOAD Jul 14 21:45:44.247000 audit: BPF prog-id=29 op=LOAD Jul 14 21:45:44.249229 systemd[1]: Starting systemd-userdbd.service... Jul 14 21:45:44.258126 systemd[1]: Condition check resulted in dev-ttyAMA0.device being skipped. Jul 14 21:45:44.281386 systemd[1]: Started systemd-userdbd.service. Jul 14 21:45:44.281000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=systemd-userdbd comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Jul 14 21:45:44.304541 systemd[1]: Found device dev-disk-by\x2dlabel-OEM.device. Jul 14 21:45:44.349037 systemd[1]: Finished systemd-udev-settle.service. Jul 14 21:45:44.349000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=systemd-udev-settle comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Jul 14 21:45:44.351280 systemd[1]: Starting lvm2-activation-early.service... Jul 14 21:45:44.360139 systemd-networkd[1043]: lo: Link UP Jul 14 21:45:44.360476 systemd-networkd[1043]: lo: Gained carrier Jul 14 21:45:44.360983 systemd-networkd[1043]: Enumeration completed Jul 14 21:45:44.361278 systemd-networkd[1043]: eth0: Configuring with /usr/lib/systemd/network/zz-default.network. Jul 14 21:45:44.361286 systemd[1]: Started systemd-networkd.service. Jul 14 21:45:44.361000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=systemd-networkd comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Jul 14 21:45:44.363955 systemd[1]: Starting systemd-networkd-wait-online.service... Jul 14 21:45:44.371253 systemd-networkd[1043]: eth0: Link UP Jul 14 21:45:44.371369 systemd-networkd[1043]: eth0: Gained carrier Jul 14 21:45:44.382416 lvm[1068]: WARNING: Failed to connect to lvmetad. Falling back to device scanning. Jul 14 21:45:44.400776 systemd-networkd[1043]: eth0: DHCPv4 address 10.0.0.17/16, gateway 10.0.0.1 acquired from 10.0.0.1 Jul 14 21:45:44.417524 systemd[1]: Finished lvm2-activation-early.service. Jul 14 21:45:44.417000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=lvm2-activation-early comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Jul 14 21:45:44.418371 systemd[1]: Reached target cryptsetup.target. Jul 14 21:45:44.420162 systemd[1]: Starting lvm2-activation.service... Jul 14 21:45:44.423766 lvm[1070]: WARNING: Failed to connect to lvmetad. Falling back to device scanning. Jul 14 21:45:44.455569 systemd[1]: Finished lvm2-activation.service. Jul 14 21:45:44.455000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=lvm2-activation comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Jul 14 21:45:44.456374 systemd[1]: Reached target local-fs-pre.target. Jul 14 21:45:44.457040 systemd[1]: var-lib-machines.mount was skipped because of an unmet condition check (ConditionPathExists=/var/lib/machines.raw). Jul 14 21:45:44.457074 systemd[1]: Reached target local-fs.target. Jul 14 21:45:44.457667 systemd[1]: Reached target machines.target. Jul 14 21:45:44.459518 systemd[1]: Starting ldconfig.service... Jul 14 21:45:44.460497 systemd[1]: systemd-binfmt.service was skipped because no trigger condition checks were met. Jul 14 21:45:44.460581 systemd[1]: systemd-boot-system-token.service was skipped because of an unmet condition check (ConditionPathExists=/sys/firmware/efi/efivars/LoaderFeatures-4a67b082-0a4c-41cf-b6c7-440b29bb8c4f). Jul 14 21:45:44.461914 systemd[1]: Starting systemd-boot-update.service... Jul 14 21:45:44.463922 systemd[1]: Starting systemd-fsck@dev-disk-by\x2dlabel-OEM.service... Jul 14 21:45:44.466073 systemd[1]: Starting systemd-machine-id-commit.service... Jul 14 21:45:44.466912 systemd[1]: systemd-sysext.service was skipped because no trigger condition checks were met. Jul 14 21:45:44.466980 systemd[1]: ensure-sysext.service was skipped because no trigger condition checks were met. Jul 14 21:45:44.468214 systemd[1]: Starting systemd-tmpfiles-setup.service... Jul 14 21:45:44.474910 systemd[1]: boot.automount: Got automount request for /boot, triggered by 1072 (bootctl) Jul 14 21:45:44.476048 systemd[1]: Starting systemd-fsck@dev-disk-by\x2dlabel-EFI\x2dSYSTEM.service... Jul 14 21:45:44.481427 systemd[1]: Finished systemd-fsck@dev-disk-by\x2dlabel-OEM.service. Jul 14 21:45:44.481000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=systemd-fsck@dev-disk-by\x2dlabel-OEM comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Jul 14 21:45:44.507876 systemd-tmpfiles[1075]: /usr/lib/tmpfiles.d/legacy.conf:13: Duplicate line for path "/run/lock", ignoring. Jul 14 21:45:44.510221 systemd-tmpfiles[1075]: /usr/lib/tmpfiles.d/provision.conf:20: Duplicate line for path "/root", ignoring. Jul 14 21:45:44.513078 systemd-tmpfiles[1075]: /usr/lib/tmpfiles.d/systemd.conf:29: Duplicate line for path "/var/lib/systemd", ignoring. Jul 14 21:45:44.530017 systemd-fsck[1080]: fsck.fat 4.2 (2021-01-31) Jul 14 21:45:44.530017 systemd-fsck[1080]: /dev/vda1: 236 files, 117310/258078 clusters Jul 14 21:45:44.531671 systemd[1]: Finished systemd-fsck@dev-disk-by\x2dlabel-EFI\x2dSYSTEM.service. Jul 14 21:45:44.531000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=systemd-fsck@dev-disk-by\x2dlabel-EFI\x2dSYSTEM comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Jul 14 21:45:44.534364 systemd[1]: Mounting boot.mount... Jul 14 21:45:44.560974 systemd[1]: Mounted boot.mount. Jul 14 21:45:44.587533 systemd[1]: Finished systemd-boot-update.service. Jul 14 21:45:44.588000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=systemd-boot-update comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Jul 14 21:45:44.600531 systemd[1]: Finished systemd-machine-id-commit.service. Jul 14 21:45:44.601000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=systemd-machine-id-commit comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Jul 14 21:45:44.640469 ldconfig[1071]: /sbin/ldconfig: /lib/ld.so.conf is not an ELF file - it has the wrong magic bytes at the start. Jul 14 21:45:44.646351 systemd[1]: Finished ldconfig.service. Jul 14 21:45:44.646000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=ldconfig comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Jul 14 21:45:44.654342 systemd[1]: Finished systemd-tmpfiles-setup.service. Jul 14 21:45:44.656000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=systemd-tmpfiles-setup comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Jul 14 21:45:44.658168 systemd[1]: Starting audit-rules.service... Jul 14 21:45:44.659762 systemd[1]: Starting clean-ca-certificates.service... Jul 14 21:45:44.661471 systemd[1]: Starting systemd-journal-catalog-update.service... Jul 14 21:45:44.662000 audit: BPF prog-id=30 op=LOAD Jul 14 21:45:44.663739 systemd[1]: Starting systemd-resolved.service... Jul 14 21:45:44.667000 audit: BPF prog-id=31 op=LOAD Jul 14 21:45:44.669470 systemd[1]: Starting systemd-timesyncd.service... Jul 14 21:45:44.673519 systemd[1]: Starting systemd-update-utmp.service... Jul 14 21:45:44.674707 systemd[1]: Finished clean-ca-certificates.service. Jul 14 21:45:44.674000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=clean-ca-certificates comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Jul 14 21:45:44.675620 systemd[1]: update-ca-certificates.service was skipped because of an unmet condition check (ConditionPathIsSymbolicLink=!/etc/ssl/certs/ca-certificates.crt). Jul 14 21:45:44.677000 audit[1094]: SYSTEM_BOOT pid=1094 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg=' comm="systemd-update-utmp" exe="/usr/lib/systemd/systemd-update-utmp" hostname=? addr=? terminal=? res=success' Jul 14 21:45:44.685011 systemd[1]: Finished systemd-update-utmp.service. Jul 14 21:45:44.685000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=systemd-update-utmp comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Jul 14 21:45:44.687071 systemd[1]: Finished systemd-journal-catalog-update.service. Jul 14 21:45:44.687000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=systemd-journal-catalog-update comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Jul 14 21:45:44.689174 systemd[1]: Starting systemd-update-done.service... Jul 14 21:45:44.696542 systemd[1]: Finished systemd-update-done.service. Jul 14 21:45:44.697000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=systemd-update-done comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Jul 14 21:45:44.703460 augenrules[1104]: No rules Jul 14 21:45:44.702000 audit: CONFIG_CHANGE auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 op=add_rule key=(null) list=5 res=1 Jul 14 21:45:44.702000 audit[1104]: SYSCALL arch=c00000b7 syscall=206 success=yes exit=1056 a0=3 a1=ffffcf6520d0 a2=420 a3=0 items=0 ppid=1083 pid=1104 auid=4294967295 uid=0 gid=0 euid=0 suid=0 fsuid=0 egid=0 sgid=0 fsgid=0 tty=(none) ses=4294967295 comm="auditctl" exe="/usr/sbin/auditctl" subj=system_u:system_r:kernel_t:s0 key=(null) Jul 14 21:45:44.702000 audit: PROCTITLE proctitle=2F7362696E2F617564697463746C002D52002F6574632F61756469742F61756469742E72756C6573 Jul 14 21:45:44.704699 systemd[1]: Finished audit-rules.service. Jul 14 21:45:44.718841 systemd[1]: Started systemd-timesyncd.service. Jul 14 21:45:44.719516 systemd-timesyncd[1089]: Contacted time server 10.0.0.1:123 (10.0.0.1). Jul 14 21:45:44.719580 systemd-timesyncd[1089]: Initial clock synchronization to Mon 2025-07-14 21:45:44.645124 UTC. Jul 14 21:45:44.719782 systemd[1]: Reached target time-set.target. Jul 14 21:45:44.722451 systemd-resolved[1087]: Positive Trust Anchors: Jul 14 21:45:44.722463 systemd-resolved[1087]: . IN DS 20326 8 2 e06d44b80b8f1d39a95c0b0d7c65d08458e880409bbc683457104237c7f8ec8d Jul 14 21:45:44.722489 systemd-resolved[1087]: 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 168.192.in-addr.arpa d.f.ip6.arpa corp home internal intranet lan local private test Jul 14 21:45:44.735420 systemd-resolved[1087]: Defaulting to hostname 'linux'. Jul 14 21:45:44.736869 systemd[1]: Started systemd-resolved.service. Jul 14 21:45:44.737520 systemd[1]: Reached target network.target. Jul 14 21:45:44.738125 systemd[1]: Reached target nss-lookup.target. Jul 14 21:45:44.738696 systemd[1]: Reached target sysinit.target. Jul 14 21:45:44.739316 systemd[1]: Started motdgen.path. Jul 14 21:45:44.739861 systemd[1]: Started user-cloudinit@var-lib-flatcar\x2dinstall-user_data.path. Jul 14 21:45:44.740768 systemd[1]: Started logrotate.timer. Jul 14 21:45:44.741434 systemd[1]: Started mdadm.timer. Jul 14 21:45:44.741971 systemd[1]: Started systemd-tmpfiles-clean.timer. Jul 14 21:45:44.742553 systemd[1]: update-engine-stub.timer was skipped because of an unmet condition check (ConditionPathExists=/usr/.noupdate). Jul 14 21:45:44.742579 systemd[1]: Reached target paths.target. Jul 14 21:45:44.743131 systemd[1]: Reached target timers.target. Jul 14 21:45:44.743983 systemd[1]: Listening on dbus.socket. Jul 14 21:45:44.745576 systemd[1]: Starting docker.socket... Jul 14 21:45:44.748519 systemd[1]: Listening on sshd.socket. Jul 14 21:45:44.749220 systemd[1]: systemd-pcrphase-sysinit.service was skipped because of an unmet condition check (ConditionPathExists=/sys/firmware/efi/efivars/StubPcrKernelImage-4a67b082-0a4c-41cf-b6c7-440b29bb8c4f). Jul 14 21:45:44.749707 systemd[1]: Listening on docker.socket. Jul 14 21:45:44.750322 systemd[1]: Reached target sockets.target. Jul 14 21:45:44.750895 systemd[1]: Reached target basic.target. Jul 14 21:45:44.751438 systemd[1]: addon-config@usr-share-oem.service was skipped because no trigger condition checks were met. Jul 14 21:45:44.751467 systemd[1]: addon-run@usr-share-oem.service was skipped because no trigger condition checks were met. Jul 14 21:45:44.752428 systemd[1]: Starting containerd.service... Jul 14 21:45:44.753987 systemd[1]: Starting dbus.service... Jul 14 21:45:44.755381 systemd[1]: Starting enable-oem-cloudinit.service... Jul 14 21:45:44.757113 systemd[1]: Starting extend-filesystems.service... Jul 14 21:45:44.757837 systemd[1]: flatcar-setup-environment.service was skipped because of an unmet condition check (ConditionPathExists=/usr/share/oem/bin/flatcar-setup-environment). Jul 14 21:45:44.759001 systemd[1]: Starting motdgen.service... Jul 14 21:45:44.763322 systemd[1]: Starting ssh-key-proc-cmdline.service... Jul 14 21:45:44.765347 systemd[1]: Starting sshd-keygen.service... Jul 14 21:45:44.768143 systemd[1]: Starting systemd-logind.service... Jul 14 21:45:44.768787 systemd[1]: systemd-pcrphase.service was skipped because of an unmet condition check (ConditionPathExists=/sys/firmware/efi/efivars/StubPcrKernelImage-4a67b082-0a4c-41cf-b6c7-440b29bb8c4f). Jul 14 21:45:44.768888 systemd[1]: tcsd.service was skipped because of an unmet condition check (ConditionPathExists=/dev/tpm0). Jul 14 21:45:44.771045 jq[1114]: false Jul 14 21:45:44.769329 systemd[1]: cgroup compatibility translation between legacy and unified hierarchy settings activated. See cgroup-compat debug messages for details. Jul 14 21:45:44.770189 systemd[1]: Starting update-engine.service... Jul 14 21:45:44.772582 systemd[1]: Starting update-ssh-keys-after-ignition.service... Jul 14 21:45:44.774334 systemd[1]: etc-machine\x2did.mount: Deactivated successfully. Jul 14 21:45:44.776031 jq[1126]: true Jul 14 21:45:44.775903 systemd[1]: enable-oem-cloudinit.service: Skipped due to 'exec-condition'. Jul 14 21:45:44.776069 systemd[1]: Condition check resulted in enable-oem-cloudinit.service being skipped. Jul 14 21:45:44.776352 systemd[1]: ssh-key-proc-cmdline.service: Deactivated successfully. Jul 14 21:45:44.776489 systemd[1]: Finished ssh-key-proc-cmdline.service. Jul 14 21:45:44.787474 jq[1130]: true Jul 14 21:45:44.790426 extend-filesystems[1115]: Found vda Jul 14 21:45:44.791226 extend-filesystems[1115]: Found vda1 Jul 14 21:45:44.791226 extend-filesystems[1115]: Found vda2 Jul 14 21:45:44.791226 extend-filesystems[1115]: Found vda3 Jul 14 21:45:44.791226 extend-filesystems[1115]: Found usr Jul 14 21:45:44.791226 extend-filesystems[1115]: Found vda4 Jul 14 21:45:44.791226 extend-filesystems[1115]: Found vda6 Jul 14 21:45:44.791226 extend-filesystems[1115]: Found vda7 Jul 14 21:45:44.791226 extend-filesystems[1115]: Found vda9 Jul 14 21:45:44.791226 extend-filesystems[1115]: Checking size of /dev/vda9 Jul 14 21:45:44.795677 systemd[1]: motdgen.service: Deactivated successfully. Jul 14 21:45:44.795856 systemd[1]: Finished motdgen.service. Jul 14 21:45:44.810515 dbus-daemon[1113]: [system] SELinux support is enabled Jul 14 21:45:44.810696 systemd[1]: Started dbus.service. Jul 14 21:45:44.813070 systemd[1]: system-cloudinit@usr-share-oem-cloud\x2dconfig.yml.service was skipped because of an unmet condition check (ConditionFileNotEmpty=/usr/share/oem/cloud-config.yml). Jul 14 21:45:44.813090 systemd[1]: Reached target system-config.target. Jul 14 21:45:44.813938 systemd[1]: user-cloudinit-proc-cmdline.service was skipped because of an unmet condition check (ConditionKernelCommandLine=cloud-config-url). Jul 14 21:45:44.813956 systemd[1]: Reached target user-config.target. Jul 14 21:45:44.833104 bash[1156]: Updated "/home/core/.ssh/authorized_keys" Jul 14 21:45:44.835190 extend-filesystems[1115]: Old size kept for /dev/vda9 Jul 14 21:45:44.843940 systemd[1]: Finished update-ssh-keys-after-ignition.service. Jul 14 21:45:44.845811 systemd[1]: extend-filesystems.service: Deactivated successfully. Jul 14 21:45:44.845982 systemd[1]: Finished extend-filesystems.service. Jul 14 21:45:44.853724 systemd-logind[1122]: Watching system buttons on /dev/input/event0 (Power Button) Jul 14 21:45:44.854075 systemd-logind[1122]: New seat seat0. Jul 14 21:45:44.856422 systemd[1]: Started systemd-logind.service. Jul 14 21:45:44.869071 update_engine[1124]: I0714 21:45:44.868805 1124 main.cc:92] Flatcar Update Engine starting Jul 14 21:45:44.871305 systemd[1]: Started update-engine.service. Jul 14 21:45:44.872335 update_engine[1124]: I0714 21:45:44.872304 1124 update_check_scheduler.cc:74] Next update check in 7m49s Jul 14 21:45:44.873746 systemd[1]: Started locksmithd.service. Jul 14 21:45:44.884289 env[1132]: time="2025-07-14T21:45:44.884222320Z" level=info msg="starting containerd" revision=92b3a9d6f1b3bcc6dc74875cfdea653fe39f09c2 version=1.6.16 Jul 14 21:45:44.907206 env[1132]: time="2025-07-14T21:45:44.907147920Z" level=info msg="loading plugin \"io.containerd.content.v1.content\"..." type=io.containerd.content.v1 Jul 14 21:45:44.907337 env[1132]: time="2025-07-14T21:45:44.907312520Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.aufs\"..." type=io.containerd.snapshotter.v1 Jul 14 21:45:44.908433 env[1132]: time="2025-07-14T21:45:44.908380960Z" 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/5.15.187-flatcar\\n\"): skip plugin" type=io.containerd.snapshotter.v1 Jul 14 21:45:44.908433 env[1132]: time="2025-07-14T21:45:44.908412640Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.btrfs\"..." type=io.containerd.snapshotter.v1 Jul 14 21:45:44.908675 env[1132]: time="2025-07-14T21:45:44.908646240Z" 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 Jul 14 21:45:44.908675 env[1132]: time="2025-07-14T21:45:44.908671080Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.devmapper\"..." type=io.containerd.snapshotter.v1 Jul 14 21:45:44.908744 env[1132]: time="2025-07-14T21:45:44.908684360Z" level=warning msg="failed to load plugin io.containerd.snapshotter.v1.devmapper" error="devmapper not configured" Jul 14 21:45:44.908744 env[1132]: time="2025-07-14T21:45:44.908694800Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.native\"..." type=io.containerd.snapshotter.v1 Jul 14 21:45:44.908784 env[1132]: time="2025-07-14T21:45:44.908767960Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.overlayfs\"..." type=io.containerd.snapshotter.v1 Jul 14 21:45:44.909118 env[1132]: time="2025-07-14T21:45:44.909097080Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.zfs\"..." type=io.containerd.snapshotter.v1 Jul 14 21:45:44.909272 env[1132]: time="2025-07-14T21:45:44.909235960Z" 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 Jul 14 21:45:44.909272 env[1132]: time="2025-07-14T21:45:44.909252320Z" level=info msg="loading plugin \"io.containerd.metadata.v1.bolt\"..." type=io.containerd.metadata.v1 Jul 14 21:45:44.909332 env[1132]: time="2025-07-14T21:45:44.909305880Z" level=warning msg="could not use snapshotter devmapper in metadata plugin" error="devmapper not configured" Jul 14 21:45:44.909332 env[1132]: time="2025-07-14T21:45:44.909318280Z" level=info msg="metadata content store policy set" policy=shared Jul 14 21:45:44.912421 env[1132]: time="2025-07-14T21:45:44.912383360Z" level=info msg="loading plugin \"io.containerd.differ.v1.walking\"..." type=io.containerd.differ.v1 Jul 14 21:45:44.912421 env[1132]: time="2025-07-14T21:45:44.912416600Z" level=info msg="loading plugin \"io.containerd.event.v1.exchange\"..." type=io.containerd.event.v1 Jul 14 21:45:44.912523 env[1132]: time="2025-07-14T21:45:44.912430920Z" level=info msg="loading plugin \"io.containerd.gc.v1.scheduler\"..." type=io.containerd.gc.v1 Jul 14 21:45:44.912523 env[1132]: time="2025-07-14T21:45:44.912462320Z" level=info msg="loading plugin \"io.containerd.service.v1.introspection-service\"..." type=io.containerd.service.v1 Jul 14 21:45:44.912523 env[1132]: time="2025-07-14T21:45:44.912476360Z" level=info msg="loading plugin \"io.containerd.service.v1.containers-service\"..." type=io.containerd.service.v1 Jul 14 21:45:44.912523 env[1132]: time="2025-07-14T21:45:44.912490000Z" level=info msg="loading plugin \"io.containerd.service.v1.content-service\"..." type=io.containerd.service.v1 Jul 14 21:45:44.912523 env[1132]: time="2025-07-14T21:45:44.912501680Z" level=info msg="loading plugin \"io.containerd.service.v1.diff-service\"..." type=io.containerd.service.v1 Jul 14 21:45:44.912893 env[1132]: time="2025-07-14T21:45:44.912871760Z" level=info msg="loading plugin \"io.containerd.service.v1.images-service\"..." type=io.containerd.service.v1 Jul 14 21:45:44.912931 env[1132]: time="2025-07-14T21:45:44.912897680Z" level=info msg="loading plugin \"io.containerd.service.v1.leases-service\"..." type=io.containerd.service.v1 Jul 14 21:45:44.912931 env[1132]: time="2025-07-14T21:45:44.912923720Z" level=info msg="loading plugin \"io.containerd.service.v1.namespaces-service\"..." type=io.containerd.service.v1 Jul 14 21:45:44.912970 env[1132]: time="2025-07-14T21:45:44.912936440Z" level=info msg="loading plugin \"io.containerd.service.v1.snapshots-service\"..." type=io.containerd.service.v1 Jul 14 21:45:44.912970 env[1132]: time="2025-07-14T21:45:44.912949320Z" level=info msg="loading plugin \"io.containerd.runtime.v1.linux\"..." type=io.containerd.runtime.v1 Jul 14 21:45:44.913075 env[1132]: time="2025-07-14T21:45:44.913059520Z" level=info msg="loading plugin \"io.containerd.runtime.v2.task\"..." type=io.containerd.runtime.v2 Jul 14 21:45:44.913151 env[1132]: time="2025-07-14T21:45:44.913137720Z" level=info msg="loading plugin \"io.containerd.monitor.v1.cgroups\"..." type=io.containerd.monitor.v1 Jul 14 21:45:44.913458 env[1132]: time="2025-07-14T21:45:44.913428680Z" level=info msg="loading plugin \"io.containerd.service.v1.tasks-service\"..." type=io.containerd.service.v1 Jul 14 21:45:44.913540 env[1132]: time="2025-07-14T21:45:44.913524880Z" level=info msg="loading plugin \"io.containerd.grpc.v1.introspection\"..." type=io.containerd.grpc.v1 Jul 14 21:45:44.913598 env[1132]: time="2025-07-14T21:45:44.913584560Z" level=info msg="loading plugin \"io.containerd.internal.v1.restart\"..." type=io.containerd.internal.v1 Jul 14 21:45:44.913787 env[1132]: time="2025-07-14T21:45:44.913770360Z" level=info msg="loading plugin \"io.containerd.grpc.v1.containers\"..." type=io.containerd.grpc.v1 Jul 14 21:45:44.913873 env[1132]: time="2025-07-14T21:45:44.913858200Z" level=info msg="loading plugin \"io.containerd.grpc.v1.content\"..." type=io.containerd.grpc.v1 Jul 14 21:45:44.913949 env[1132]: time="2025-07-14T21:45:44.913934040Z" level=info msg="loading plugin \"io.containerd.grpc.v1.diff\"..." type=io.containerd.grpc.v1 Jul 14 21:45:44.914007 env[1132]: time="2025-07-14T21:45:44.913995680Z" level=info msg="loading plugin \"io.containerd.grpc.v1.events\"..." type=io.containerd.grpc.v1 Jul 14 21:45:44.914062 env[1132]: time="2025-07-14T21:45:44.914049280Z" level=info msg="loading plugin \"io.containerd.grpc.v1.healthcheck\"..." type=io.containerd.grpc.v1 Jul 14 21:45:44.914116 env[1132]: time="2025-07-14T21:45:44.914104480Z" level=info msg="loading plugin \"io.containerd.grpc.v1.images\"..." type=io.containerd.grpc.v1 Jul 14 21:45:44.914175 env[1132]: time="2025-07-14T21:45:44.914162760Z" level=info msg="loading plugin \"io.containerd.grpc.v1.leases\"..." type=io.containerd.grpc.v1 Jul 14 21:45:44.914228 env[1132]: time="2025-07-14T21:45:44.914216640Z" level=info msg="loading plugin \"io.containerd.grpc.v1.namespaces\"..." type=io.containerd.grpc.v1 Jul 14 21:45:44.914292 env[1132]: time="2025-07-14T21:45:44.914279000Z" level=info msg="loading plugin \"io.containerd.internal.v1.opt\"..." type=io.containerd.internal.v1 Jul 14 21:45:44.914497 env[1132]: time="2025-07-14T21:45:44.914476360Z" level=info msg="loading plugin \"io.containerd.grpc.v1.snapshots\"..." type=io.containerd.grpc.v1 Jul 14 21:45:44.914621 env[1132]: time="2025-07-14T21:45:44.914604360Z" level=info msg="loading plugin \"io.containerd.grpc.v1.tasks\"..." type=io.containerd.grpc.v1 Jul 14 21:45:44.914718 env[1132]: time="2025-07-14T21:45:44.914704200Z" level=info msg="loading plugin \"io.containerd.grpc.v1.version\"..." type=io.containerd.grpc.v1 Jul 14 21:45:44.914784 env[1132]: time="2025-07-14T21:45:44.914770000Z" level=info msg="loading plugin \"io.containerd.tracing.processor.v1.otlp\"..." type=io.containerd.tracing.processor.v1 Jul 14 21:45:44.914880 env[1132]: time="2025-07-14T21:45:44.914853160Z" level=info msg="skip loading plugin \"io.containerd.tracing.processor.v1.otlp\"..." error="no OpenTelemetry endpoint: skip plugin" type=io.containerd.tracing.processor.v1 Jul 14 21:45:44.914937 env[1132]: time="2025-07-14T21:45:44.914923360Z" level=info msg="loading plugin \"io.containerd.internal.v1.tracing\"..." type=io.containerd.internal.v1 Jul 14 21:45:44.915005 env[1132]: time="2025-07-14T21:45:44.914991480Z" level=error msg="failed to initialize a tracing processor \"otlp\"" error="no OpenTelemetry endpoint: skip plugin" Jul 14 21:45:44.915097 env[1132]: time="2025-07-14T21:45:44.915082600Z" level=info msg="loading plugin \"io.containerd.grpc.v1.cri\"..." type=io.containerd.grpc.v1 Jul 14 21:45:44.916426 env[1132]: time="2025-07-14T21:45:44.916359200Z" 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 BaseRuntimeSpec: NetworkPluginConfDir: NetworkPluginMaxConfNum:0} UntrustedWorkloadRuntime:{Type: Path: Engine: PodAnnotations:[] ContainerAnnotations:[] Root: Options:map[] PrivilegedWithoutHostDevices:false BaseRuntimeSpec: NetworkPluginConfDir: NetworkPluginMaxConfNum:0} Runtimes:map[runc:{Type:io.containerd.runc.v2 Path: Engine: PodAnnotations:[] ContainerAnnotations:[] Root: Options:map[SystemdCgroup:true] PrivilegedWithoutHostDevices:false BaseRuntimeSpec: NetworkPluginConfDir: NetworkPluginMaxConfNum:0}] NoPivot:false DisableSnapshotAnnotations:true DiscardUnpackedLayers:false IgnoreRdtNotEnabledErrors:false} CniConfig:{NetworkPluginBinDir:/opt/cni/bin NetworkPluginConfDir:/etc/cni/net.d NetworkPluginMaxConfNum:1 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.6 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} 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}" Jul 14 21:45:44.917084 env[1132]: time="2025-07-14T21:45:44.916797120Z" level=info msg="Connect containerd service" Jul 14 21:45:44.917084 env[1132]: time="2025-07-14T21:45:44.916913680Z" level=info msg="Get image filesystem path \"/var/lib/containerd/io.containerd.snapshotter.v1.overlayfs\"" Jul 14 21:45:44.917784 env[1132]: time="2025-07-14T21:45:44.917756000Z" 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" Jul 14 21:45:44.918135 env[1132]: time="2025-07-14T21:45:44.918088880Z" level=info msg="Start subscribing containerd event" Jul 14 21:45:44.918178 env[1132]: time="2025-07-14T21:45:44.918142640Z" level=info msg="Start recovering state" Jul 14 21:45:44.918220 env[1132]: time="2025-07-14T21:45:44.918203560Z" level=info msg="Start event monitor" Jul 14 21:45:44.918248 env[1132]: time="2025-07-14T21:45:44.918227120Z" level=info msg="Start snapshots syncer" Jul 14 21:45:44.918248 env[1132]: time="2025-07-14T21:45:44.918236920Z" level=info msg="Start cni network conf syncer for default" Jul 14 21:45:44.918248 env[1132]: time="2025-07-14T21:45:44.918244040Z" level=info msg="Start streaming server" Jul 14 21:45:44.918411 env[1132]: time="2025-07-14T21:45:44.918391280Z" level=info msg=serving... address=/run/containerd/containerd.sock.ttrpc Jul 14 21:45:44.918527 env[1132]: time="2025-07-14T21:45:44.918512040Z" level=info msg=serving... address=/run/containerd/containerd.sock Jul 14 21:45:44.918674 env[1132]: time="2025-07-14T21:45:44.918625720Z" level=info msg="containerd successfully booted in 0.035210s" Jul 14 21:45:44.918710 systemd[1]: Started containerd.service. Jul 14 21:45:44.922877 locksmithd[1162]: locksmithd starting currentOperation="UPDATE_STATUS_IDLE" strategy="reboot" Jul 14 21:45:45.948749 systemd-networkd[1043]: eth0: Gained IPv6LL Jul 14 21:45:45.950361 systemd[1]: Finished systemd-networkd-wait-online.service. Jul 14 21:45:45.951326 systemd[1]: Reached target network-online.target. Jul 14 21:45:45.953172 systemd[1]: Starting coreos-metadata.service... Jul 14 21:45:45.959374 systemd[1]: coreos-metadata.service: Deactivated successfully. Jul 14 21:45:45.959517 systemd[1]: Finished coreos-metadata.service. Jul 14 21:45:45.961378 systemd[1]: Starting etcd-member.service... Jul 14 21:45:46.024891 systemd[1]: Starting docker.service... Jul 14 21:45:46.051998 sshd_keygen[1133]: ssh-keygen: generating new host keys: RSA ECDSA ED25519 Jul 14 21:45:46.073973 systemd[1]: Finished sshd-keygen.service. Jul 14 21:45:46.076067 systemd[1]: Starting issuegen.service... Jul 14 21:45:46.080781 systemd[1]: issuegen.service: Deactivated successfully. Jul 14 21:45:46.080951 systemd[1]: Finished issuegen.service. Jul 14 21:45:46.082877 systemd[1]: Starting systemd-user-sessions.service... Jul 14 21:45:46.088968 systemd[1]: Finished systemd-user-sessions.service. Jul 14 21:45:46.091026 systemd[1]: Started getty@tty1.service. Jul 14 21:45:46.092867 systemd[1]: Started serial-getty@ttyAMA0.service. Jul 14 21:45:46.093699 systemd[1]: Reached target getty.target. Jul 14 21:45:46.110686 env[1186]: time="2025-07-14T21:45:46.110620613Z" level=info msg="Starting up" Jul 14 21:45:46.112195 env[1186]: time="2025-07-14T21:45:46.112164045Z" level=info msg="parsed scheme: \"unix\"" module=grpc Jul 14 21:45:46.112283 env[1186]: time="2025-07-14T21:45:46.112269223Z" level=info msg="scheme \"unix\" not registered, fallback to default scheme" module=grpc Jul 14 21:45:46.112354 env[1186]: time="2025-07-14T21:45:46.112338337Z" level=info msg="ccResolverWrapper: sending update to cc: {[{unix:///var/run/docker/libcontainerd/docker-containerd.sock 0 }] }" module=grpc Jul 14 21:45:46.112405 env[1186]: time="2025-07-14T21:45:46.112391501Z" level=info msg="ClientConn switching balancer to \"pick_first\"" module=grpc Jul 14 21:45:46.114451 env[1186]: time="2025-07-14T21:45:46.114427457Z" level=info msg="parsed scheme: \"unix\"" module=grpc Jul 14 21:45:46.114451 env[1186]: time="2025-07-14T21:45:46.114446144Z" level=info msg="scheme \"unix\" not registered, fallback to default scheme" module=grpc Jul 14 21:45:46.114548 env[1186]: time="2025-07-14T21:45:46.114459554Z" level=info msg="ccResolverWrapper: sending update to cc: {[{unix:///var/run/docker/libcontainerd/docker-containerd.sock 0 }] }" module=grpc Jul 14 21:45:46.114548 env[1186]: time="2025-07-14T21:45:46.114468164Z" level=info msg="ClientConn switching balancer to \"pick_first\"" module=grpc Jul 14 21:45:46.135391 env[1186]: time="2025-07-14T21:45:46.135355596Z" level=info msg="Loading containers: start." Jul 14 21:45:46.450668 kernel: Initializing XFRM netlink socket Jul 14 21:45:46.474517 env[1186]: time="2025-07-14T21:45:46.474479038Z" level=info msg="Default bridge (docker0) is assigned with an IP address 172.17.0.0/16. Daemon option --bip can be used to set a preferred IP address" Jul 14 21:45:46.536295 systemd-networkd[1043]: docker0: Link UP Jul 14 21:45:46.551050 env[1186]: time="2025-07-14T21:45:46.551005680Z" level=info msg="Loading containers: done." Jul 14 21:45:46.569254 systemd[1]: var-lib-docker-overlay2-opaque\x2dbug\x2dcheck58676160-merged.mount: Deactivated successfully. Jul 14 21:45:46.571755 env[1186]: time="2025-07-14T21:45:46.571716679Z" 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 Jul 14 21:45:46.572069 env[1186]: time="2025-07-14T21:45:46.572047210Z" level=info msg="Docker daemon" commit=112bdf3343 graphdriver(s)=overlay2 version=20.10.23 Jul 14 21:45:46.572238 env[1186]: time="2025-07-14T21:45:46.572222057Z" level=info msg="Daemon has completed initialization" Jul 14 21:45:46.589701 systemd[1]: Started docker.service. Jul 14 21:45:46.594834 env[1186]: time="2025-07-14T21:45:46.594711839Z" level=info msg="API listen on /run/docker.sock" Jul 14 21:45:46.597315 etcd-wrapper[1178]: Error response from daemon: No such container: etcd-member Jul 14 21:45:46.615617 etcd-wrapper[1310]: Error: No such container: etcd-member Jul 14 21:45:46.647625 etcd-wrapper[1330]: Unable to find image 'quay.io/coreos/etcd:v3.5.16' locally Jul 14 21:45:47.304355 etcd-wrapper[1330]: v3.5.16: Pulling from coreos/etcd Jul 14 21:45:47.522893 etcd-wrapper[1330]: d10f96ed9607: Pulling fs layer Jul 14 21:45:47.522893 etcd-wrapper[1330]: 2ae710cd8bfe: Pulling fs layer Jul 14 21:45:47.522893 etcd-wrapper[1330]: d462aa345367: Pulling fs layer Jul 14 21:45:47.522893 etcd-wrapper[1330]: 0f8b424aa0b9: Pulling fs layer Jul 14 21:45:47.522893 etcd-wrapper[1330]: d557676654e5: Pulling fs layer Jul 14 21:45:47.522893 etcd-wrapper[1330]: c8022d07192e: Pulling fs layer Jul 14 21:45:47.522893 etcd-wrapper[1330]: 0f8b424aa0b9: Waiting Jul 14 21:45:47.522893 etcd-wrapper[1330]: d557676654e5: Waiting Jul 14 21:45:47.523432 etcd-wrapper[1330]: d858cbc252ad: Pulling fs layer Jul 14 21:45:47.523833 etcd-wrapper[1330]: 1069fc2daed1: Pulling fs layer Jul 14 21:45:47.523833 etcd-wrapper[1330]: b40161cd83fc: Pulling fs layer Jul 14 21:45:47.523833 etcd-wrapper[1330]: 5318d93a3a65: Pulling fs layer Jul 14 21:45:47.523833 etcd-wrapper[1330]: 307c1adadb60: Pulling fs layer Jul 14 21:45:47.523833 etcd-wrapper[1330]: f9b3c65df792: Pulling fs layer Jul 14 21:45:47.523833 etcd-wrapper[1330]: 5709b4a82c35: Pulling fs layer Jul 14 21:45:47.523833 etcd-wrapper[1330]: b40161cd83fc: Waiting Jul 14 21:45:47.523833 etcd-wrapper[1330]: 1069fc2daed1: Waiting Jul 14 21:45:47.523833 etcd-wrapper[1330]: 5318d93a3a65: Waiting Jul 14 21:45:47.523833 etcd-wrapper[1330]: 307c1adadb60: Waiting Jul 14 21:45:47.523833 etcd-wrapper[1330]: c8022d07192e: Waiting Jul 14 21:45:47.523833 etcd-wrapper[1330]: f9b3c65df792: Waiting Jul 14 21:45:47.523833 etcd-wrapper[1330]: d858cbc252ad: Waiting Jul 14 21:45:47.523833 etcd-wrapper[1330]: 5709b4a82c35: Waiting Jul 14 21:45:47.523833 etcd-wrapper[1330]: d5372e382b07: Pulling fs layer Jul 14 21:45:47.524602 etcd-wrapper[1330]: 9c3b5253dddc: Pulling fs layer Jul 14 21:45:47.524602 etcd-wrapper[1330]: 7a57323f7551: Pulling fs layer Jul 14 21:45:47.524602 etcd-wrapper[1330]: 9c3b5253dddc: Waiting Jul 14 21:45:47.525094 etcd-wrapper[1330]: 7a57323f7551: Waiting Jul 14 21:45:47.660229 etcd-wrapper[1330]: d462aa345367: Verifying Checksum Jul 14 21:45:47.660229 etcd-wrapper[1330]: d462aa345367: Download complete Jul 14 21:45:47.663837 etcd-wrapper[1330]: 2ae710cd8bfe: Verifying Checksum Jul 14 21:45:47.664278 etcd-wrapper[1330]: 2ae710cd8bfe: Download complete Jul 14 21:45:47.756966 etcd-wrapper[1330]: d10f96ed9607: Verifying Checksum Jul 14 21:45:47.756966 etcd-wrapper[1330]: d10f96ed9607: Download complete Jul 14 21:45:47.787825 etcd-wrapper[1330]: 0f8b424aa0b9: Verifying Checksum Jul 14 21:45:47.787825 etcd-wrapper[1330]: 0f8b424aa0b9: Download complete Jul 14 21:45:47.806574 etcd-wrapper[1330]: d10f96ed9607: Pull complete Jul 14 21:45:47.826280 etcd-wrapper[1330]: d557676654e5: Verifying Checksum Jul 14 21:45:47.826280 etcd-wrapper[1330]: d557676654e5: Download complete Jul 14 21:45:47.848524 systemd[1]: var-lib-docker-overlay2-f2853dfbd38603194004cce3690aae928fc1e24ff303872dc9f4d0762c4fc1fd-merged.mount: Deactivated successfully. Jul 14 21:45:47.862729 etcd-wrapper[1330]: 2ae710cd8bfe: Pull complete Jul 14 21:45:47.912878 etcd-wrapper[1330]: c8022d07192e: Verifying Checksum Jul 14 21:45:47.912878 etcd-wrapper[1330]: c8022d07192e: Download complete Jul 14 21:45:47.951333 etcd-wrapper[1330]: 1069fc2daed1: Verifying Checksum Jul 14 21:45:47.951333 etcd-wrapper[1330]: 1069fc2daed1: Download complete Jul 14 21:45:47.994881 etcd-wrapper[1330]: d858cbc252ad: Download complete Jul 14 21:45:48.046148 systemd[1]: var-lib-docker-overlay2-cf9dc03678e0cf3af9ca655bff60f0973966bc86bb71808e8b5e15777b225554-merged.mount: Deactivated successfully. Jul 14 21:45:48.051955 etcd-wrapper[1330]: b40161cd83fc: Download complete Jul 14 21:45:48.081599 etcd-wrapper[1330]: d462aa345367: Pull complete Jul 14 21:45:48.084749 etcd-wrapper[1330]: 5318d93a3a65: Verifying Checksum Jul 14 21:45:48.084749 etcd-wrapper[1330]: 5318d93a3a65: Download complete Jul 14 21:45:48.128553 etcd-wrapper[1330]: 0f8b424aa0b9: Pull complete Jul 14 21:45:48.179848 etcd-wrapper[1330]: d557676654e5: Pull complete Jul 14 21:45:48.215223 etcd-wrapper[1330]: f9b3c65df792: Verifying Checksum Jul 14 21:45:48.215223 etcd-wrapper[1330]: f9b3c65df792: Download complete Jul 14 21:45:48.217807 etcd-wrapper[1330]: 307c1adadb60: Verifying Checksum Jul 14 21:45:48.217807 etcd-wrapper[1330]: 307c1adadb60: Download complete Jul 14 21:45:48.244125 etcd-wrapper[1330]: c8022d07192e: Pull complete Jul 14 21:45:48.291958 etcd-wrapper[1330]: d858cbc252ad: Pull complete Jul 14 21:45:48.319959 etcd-wrapper[1330]: 5709b4a82c35: Verifying Checksum Jul 14 21:45:48.319959 etcd-wrapper[1330]: 5709b4a82c35: Download complete Jul 14 21:45:48.356833 etcd-wrapper[1330]: 1069fc2daed1: Pull complete Jul 14 21:45:48.369969 etcd-wrapper[1330]: d5372e382b07: Verifying Checksum Jul 14 21:45:48.369969 etcd-wrapper[1330]: d5372e382b07: Download complete Jul 14 21:45:48.378193 etcd-wrapper[1330]: 9c3b5253dddc: Verifying Checksum Jul 14 21:45:48.378193 etcd-wrapper[1330]: 9c3b5253dddc: Download complete Jul 14 21:45:48.414833 etcd-wrapper[1330]: b40161cd83fc: Pull complete Jul 14 21:45:48.452545 etcd-wrapper[1330]: 7a57323f7551: Verifying Checksum Jul 14 21:45:48.452545 etcd-wrapper[1330]: 7a57323f7551: Download complete Jul 14 21:45:48.457527 etcd-wrapper[1330]: 5318d93a3a65: Pull complete Jul 14 21:45:48.505790 etcd-wrapper[1330]: 307c1adadb60: Pull complete Jul 14 21:45:48.795981 etcd-wrapper[1330]: f9b3c65df792: Pull complete Jul 14 21:45:48.811951 systemd[1]: var-lib-docker-overlay2-ee95a9c76a2ae332ff5054f2d534ef1c7e1332e75b68b341092b787e96f4e924-merged.mount: Deactivated successfully. Jul 14 21:45:49.002332 systemd[1]: var-lib-docker-overlay2-11615241f21fa93012d8691117cf603afa4b4873416b45e8a769c0e2b8bab530-merged.mount: Deactivated successfully. Jul 14 21:45:49.026996 etcd-wrapper[1330]: 5709b4a82c35: Pull complete Jul 14 21:45:49.206330 systemd[1]: var-lib-docker-overlay2-873ed93b2f75cc889f703c7148c77fe7793981cec84546f11cf3d4ff86818fe7-merged.mount: Deactivated successfully. Jul 14 21:45:49.229305 etcd-wrapper[1330]: d5372e382b07: Pull complete Jul 14 21:45:49.273798 etcd-wrapper[1330]: 9c3b5253dddc: Pull complete Jul 14 21:45:49.315436 etcd-wrapper[1330]: 7a57323f7551: Pull complete Jul 14 21:45:49.321497 etcd-wrapper[1330]: Digest: sha256:d967d98a12dc220a1a290794711dba7eba04b8ce465e12b02383d1bfbb33e159 Jul 14 21:45:49.323805 etcd-wrapper[1330]: Status: Downloaded newer image for quay.io/coreos/etcd:v3.5.16 Jul 14 21:45:49.409172 env[1132]: time="2025-07-14T21:45:49.409102732Z" level=info msg="loading plugin \"io.containerd.event.v1.publisher\"..." runtime=io.containerd.runc.v2 type=io.containerd.event.v1 Jul 14 21:45:49.409172 env[1132]: time="2025-07-14T21:45:49.409144384Z" level=info msg="loading plugin \"io.containerd.internal.v1.shutdown\"..." runtime=io.containerd.runc.v2 type=io.containerd.internal.v1 Jul 14 21:45:49.409562 env[1132]: time="2025-07-14T21:45:49.409154528Z" level=info msg="loading plugin \"io.containerd.ttrpc.v1.task\"..." runtime=io.containerd.runc.v2 type=io.containerd.ttrpc.v1 Jul 14 21:45:49.409898 env[1132]: time="2025-07-14T21:45:49.409864402Z" level=info msg="starting signal loop" namespace=moby path=/run/containerd/io.containerd.runtime.v2.task/moby/3ec3b557314d4dc6dcd9e4795c8a5715e5874b6008a182f0694605dd4ae2123c pid=1515 runtime=io.containerd.runc.v2 Jul 14 21:45:49.419417 systemd[1]: Started docker-3ec3b557314d4dc6dcd9e4795c8a5715e5874b6008a182f0694605dd4ae2123c.scope. Jul 14 21:45:49.498445 systemd-resolved[1087]: Failed to determine the local hostname and LLMNR/mDNS names, ignoring: No such device or address Jul 14 21:45:49.558055 etcd-wrapper[1330]: {"level":"info","ts":"2025-07-14T21:45:49.557613Z","caller":"flags/flag.go:113","msg":"recognized and used environment variable","variable-name":"ETCD_DATA_DIR","variable-value":"/var/lib/etcd"} Jul 14 21:45:49.558055 etcd-wrapper[1330]: {"level":"info","ts":"2025-07-14T21:45:49.557757Z","caller":"flags/flag.go:113","msg":"recognized and used environment variable","variable-name":"ETCD_NAME","variable-value":"6089e8fe23d74dc9a859aa94a86b28e6"} Jul 14 21:45:49.558055 etcd-wrapper[1330]: {"level":"warn","ts":"2025-07-14T21:45:49.557791Z","caller":"flags/flag.go:93","msg":"unrecognized environment variable","environment-variable":"ETCD_IMAGE_URL=quay.io/coreos/etcd"} Jul 14 21:45:49.558055 etcd-wrapper[1330]: {"level":"warn","ts":"2025-07-14T21:45:49.557802Z","caller":"flags/flag.go:93","msg":"unrecognized environment variable","environment-variable":"ETCD_IMAGE_TAG=v3.5.16"} Jul 14 21:45:49.558055 etcd-wrapper[1330]: {"level":"warn","ts":"2025-07-14T21:45:49.557807Z","caller":"flags/flag.go:93","msg":"unrecognized environment variable","environment-variable":"ETCD_USER=etcd"} Jul 14 21:45:49.558055 etcd-wrapper[1330]: {"level":"warn","ts":"2025-07-14T21:45:49.557812Z","caller":"flags/flag.go:93","msg":"unrecognized environment variable","environment-variable":"ETCD_SSL_DIR=/etc/ssl/certs"} Jul 14 21:45:49.558055 etcd-wrapper[1330]: {"level":"warn","ts":"2025-07-14T21:45:49.557832Z","caller":"embed/config.go:689","msg":"Running http and grpc server on single port. This is not recommended for production."} Jul 14 21:45:49.558055 etcd-wrapper[1330]: {"level":"info","ts":"2025-07-14T21:45:49.557861Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["/usr/local/bin/etcd","--listen-client-urls=http://0.0.0.0:2379","--advertise-client-urls=http://10.0.0.17:2379"]} Jul 14 21:45:49.558055 etcd-wrapper[1330]: {"level":"warn","ts":"2025-07-14T21:45:49.557921Z","caller":"embed/config.go:689","msg":"Running http and grpc server on single port. This is not recommended for production."} Jul 14 21:45:49.558055 etcd-wrapper[1330]: {"level":"info","ts":"2025-07-14T21:45:49.557933Z","caller":"embed/etcd.go:128","msg":"configuring peer listeners","listen-peer-urls":["http://localhost:2380"]} Jul 14 21:45:49.558456 etcd-wrapper[1330]: {"level":"info","ts":"2025-07-14T21:45:49.558334Z","caller":"embed/etcd.go:136","msg":"configuring client listeners","listen-client-urls":["http://0.0.0.0:2379"]} Jul 14 21:45:49.558568 etcd-wrapper[1330]: {"level":"info","ts":"2025-07-14T21:45:49.558460Z","caller":"embed/etcd.go:311","msg":"starting an etcd server","etcd-version":"3.5.16","git-sha":"f20bbad","go-version":"go1.22.7","go-os":"linux","go-arch":"arm64","max-cpu-set":4,"max-cpu-available":4,"member-initialized":false,"name":"6089e8fe23d74dc9a859aa94a86b28e6","data-dir":"/var/lib/etcd","wal-dir":"","wal-dir-dedicated":"","member-dir":"/var/lib/etcd/member","force-new-cluster":false,"heartbeat-interval":"100ms","election-timeout":"1s","initial-election-tick-advance":true,"snapshot-count":100000,"max-wals":5,"max-snapshots":5,"snapshot-catchup-entries":5000,"initial-advertise-peer-urls":["http://localhost:2380"],"listen-peer-urls":["http://localhost:2380"],"advertise-client-urls":["http://10.0.0.17:2379"],"listen-client-urls":["http://0.0.0.0:2379"],"listen-metrics-urls":[],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"6089e8fe23d74dc9a859aa94a86b28e6=http://localhost:2380","initial-cluster-state":"new","initial-cluster-token":"etcd-cluster","quota-backend-bytes":2147483648,"max-request-bytes":1572864,"max-concurrent-streams":4294967295,"pre-vote":true,"initial-corrupt-check":false,"corrupt-check-time-interval":"0s","compact-check-time-enabled":false,"compact-check-time-interval":"1m0s","auto-compaction-mode":"periodic","auto-compaction-retention":"0s","auto-compaction-interval":"0s","discovery-url":"","discovery-proxy":"","downgrade-check-interval":"5s"} Jul 14 21:45:49.562405 etcd-wrapper[1330]: {"level":"info","ts":"2025-07-14T21:45:49.562225Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"3.521082ms"} Jul 14 21:45:49.565913 etcd-wrapper[1330]: {"level":"info","ts":"2025-07-14T21:45:49.565728Z","caller":"etcdserver/raft.go:505","msg":"starting local member","local-member-id":"8e9e05c52164694d","cluster-id":"cdf818194e3a8c32"} Jul 14 21:45:49.566071 etcd-wrapper[1330]: {"level":"info","ts":"2025-07-14T21:45:49.565912Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"8e9e05c52164694d switched to configuration voters=()"} Jul 14 21:45:49.566071 etcd-wrapper[1330]: {"level":"info","ts":"2025-07-14T21:45:49.565940Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"8e9e05c52164694d became follower at term 0"} Jul 14 21:45:49.566071 etcd-wrapper[1330]: {"level":"info","ts":"2025-07-14T21:45:49.565949Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 8e9e05c52164694d [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} Jul 14 21:45:49.566071 etcd-wrapper[1330]: {"level":"info","ts":"2025-07-14T21:45:49.565957Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"8e9e05c52164694d became follower at term 1"} Jul 14 21:45:49.566071 etcd-wrapper[1330]: {"level":"info","ts":"2025-07-14T21:45:49.565985Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"8e9e05c52164694d switched to configuration voters=(10276657743932975437)"} Jul 14 21:45:49.569332 etcd-wrapper[1330]: {"level":"warn","ts":"2025-07-14T21:45:49.569203Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} Jul 14 21:45:49.569918 etcd-wrapper[1330]: {"level":"info","ts":"2025-07-14T21:45:49.569814Z","caller":"mvcc/kvstore.go:423","msg":"kvstore restored","current-rev":1} Jul 14 21:45:49.570405 etcd-wrapper[1330]: {"level":"info","ts":"2025-07-14T21:45:49.570296Z","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"} Jul 14 21:45:49.570852 etcd-wrapper[1330]: {"level":"info","ts":"2025-07-14T21:45:49.570742Z","caller":"etcdserver/server.go:873","msg":"starting etcd server","local-member-id":"8e9e05c52164694d","local-server-version":"3.5.16","cluster-version":"to_be_decided"} Jul 14 21:45:49.571078 etcd-wrapper[1330]: {"level":"info","ts":"2025-07-14T21:45:49.570918Z","caller":"v3rpc/health.go:61","msg":"grpc service status changed","service":"","status":"SERVING"} Jul 14 21:45:49.571078 etcd-wrapper[1330]: {"level":"info","ts":"2025-07-14T21:45:49.570919Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/snap","suffix":"snap.db","max":5,"interval":"30s"} Jul 14 21:45:49.571078 etcd-wrapper[1330]: {"level":"info","ts":"2025-07-14T21:45:49.570960Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/snap","suffix":"snap","max":5,"interval":"30s"} Jul 14 21:45:49.571078 etcd-wrapper[1330]: {"level":"info","ts":"2025-07-14T21:45:49.570969Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/wal","suffix":"wal","max":5,"interval":"30s"} Jul 14 21:45:49.571289 etcd-wrapper[1330]: {"level":"info","ts":"2025-07-14T21:45:49.570793Z","caller":"etcdserver/server.go:757","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"8e9e05c52164694d","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} Jul 14 21:45:49.572673 etcd-wrapper[1330]: {"level":"info","ts":"2025-07-14T21:45:49.572509Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"8e9e05c52164694d switched to configuration voters=(10276657743932975437)"} Jul 14 21:45:49.573383 etcd-wrapper[1330]: {"level":"info","ts":"2025-07-14T21:45:49.573243Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"cdf818194e3a8c32","local-member-id":"8e9e05c52164694d","added-peer-id":"8e9e05c52164694d","added-peer-peer-urls":["http://localhost:2380"]} Jul 14 21:45:49.573838 etcd-wrapper[1330]: {"level":"info","ts":"2025-07-14T21:45:49.573692Z","caller":"embed/etcd.go:280","msg":"now serving peer/client/metrics","local-member-id":"8e9e05c52164694d","initial-advertise-peer-urls":["http://localhost:2380"],"listen-peer-urls":["http://localhost:2380"],"advertise-client-urls":["http://10.0.0.17:2379"],"listen-client-urls":["http://0.0.0.0:2379"],"listen-metrics-urls":[]} Jul 14 21:45:49.573838 etcd-wrapper[1330]: {"level":"info","ts":"2025-07-14T21:45:49.573705Z","caller":"embed/etcd.go:600","msg":"serving peer traffic","address":"127.0.0.1:2380"} Jul 14 21:45:49.574065 etcd-wrapper[1330]: {"level":"info","ts":"2025-07-14T21:45:49.573728Z","caller":"embed/etcd.go:572","msg":"cmux::serve","address":"127.0.0.1:2380"} Jul 14 21:45:49.666946 etcd-wrapper[1330]: {"level":"info","ts":"2025-07-14T21:45:49.666664Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"8e9e05c52164694d is starting a new election at term 1"} Jul 14 21:45:49.666946 etcd-wrapper[1330]: {"level":"info","ts":"2025-07-14T21:45:49.666699Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"8e9e05c52164694d became pre-candidate at term 1"} Jul 14 21:45:49.666946 etcd-wrapper[1330]: {"level":"info","ts":"2025-07-14T21:45:49.666722Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"8e9e05c52164694d received MsgPreVoteResp from 8e9e05c52164694d at term 1"} Jul 14 21:45:49.666946 etcd-wrapper[1330]: {"level":"info","ts":"2025-07-14T21:45:49.666735Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"8e9e05c52164694d became candidate at term 2"} Jul 14 21:45:49.666946 etcd-wrapper[1330]: {"level":"info","ts":"2025-07-14T21:45:49.666740Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"8e9e05c52164694d received MsgVoteResp from 8e9e05c52164694d at term 2"} Jul 14 21:45:49.666946 etcd-wrapper[1330]: {"level":"info","ts":"2025-07-14T21:45:49.666750Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"8e9e05c52164694d became leader at term 2"} Jul 14 21:45:49.666946 etcd-wrapper[1330]: {"level":"info","ts":"2025-07-14T21:45:49.666757Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 8e9e05c52164694d elected leader 8e9e05c52164694d at term 2"} Jul 14 21:45:49.667438 etcd-wrapper[1330]: {"level":"info","ts":"2025-07-14T21:45:49.667289Z","caller":"etcdserver/server.go:2140","msg":"published local member to cluster through raft","local-member-id":"8e9e05c52164694d","local-member-attributes":"{Name:6089e8fe23d74dc9a859aa94a86b28e6 ClientURLs:[http://10.0.0.17:2379]}","request-path":"/0/members/8e9e05c52164694d/attributes","cluster-id":"cdf818194e3a8c32","publish-timeout":"7s"} Jul 14 21:45:49.667602 etcd-wrapper[1330]: {"level":"info","ts":"2025-07-14T21:45:49.667398Z","caller":"etcdserver/server.go:2651","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} Jul 14 21:45:49.667602 etcd-wrapper[1330]: {"level":"info","ts":"2025-07-14T21:45:49.667477Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} Jul 14 21:45:49.667602 etcd-wrapper[1330]: {"level":"info","ts":"2025-07-14T21:45:49.667521Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} Jul 14 21:45:49.667810 systemd[1]: Started etcd-member.service. Jul 14 21:45:49.667919 etcd-wrapper[1330]: {"level":"info","ts":"2025-07-14T21:45:49.667647Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} Jul 14 21:45:49.668198 etcd-wrapper[1330]: {"level":"info","ts":"2025-07-14T21:45:49.668027Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"cdf818194e3a8c32","local-member-id":"8e9e05c52164694d","cluster-version":"3.5"} Jul 14 21:45:49.668198 etcd-wrapper[1330]: {"level":"info","ts":"2025-07-14T21:45:49.668109Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} Jul 14 21:45:49.668291 etcd-wrapper[1330]: {"level":"info","ts":"2025-07-14T21:45:49.668147Z","caller":"etcdserver/server.go:2675","msg":"cluster version is updated","cluster-version":"3.5"} Jul 14 21:45:49.668507 etcd-wrapper[1330]: {"level":"info","ts":"2025-07-14T21:45:49.668353Z","caller":"v3rpc/health.go:61","msg":"grpc service status changed","service":"","status":"SERVING"} Jul 14 21:45:49.668800 systemd[1]: Reached target multi-user.target. Jul 14 21:45:49.669146 etcd-wrapper[1330]: {"level":"info","ts":"2025-07-14T21:45:49.668959Z","caller":"embed/serve.go:187","msg":"serving client traffic insecurely; this is strongly discouraged!","traffic":"grpc+http","address":"[::]:2379"} Jul 14 21:45:49.670999 systemd[1]: Starting systemd-update-utmp-runlevel.service... Jul 14 21:45:49.678011 systemd[1]: systemd-update-utmp-runlevel.service: Deactivated successfully. Jul 14 21:45:49.678208 systemd[1]: Finished systemd-update-utmp-runlevel.service. Jul 14 21:45:49.679157 systemd[1]: Startup finished in 591ms (kernel) + 3.246s (initrd) + 7.860s (userspace) = 11.697s. Jul 14 21:45:49.812302 systemd[1]: var-lib-docker-overlay2-48256c60195c4a725f7249731dcb49de7fab3bc60102991bbbe897f7f9b3e6e7-merged.mount: Deactivated successfully. Jul 14 21:45:51.477188 systemd[1]: Created slice system-sshd.slice. Jul 14 21:45:51.478281 systemd[1]: Started sshd@0-10.0.0.17:22-10.0.0.1:43466.service. Jul 14 21:45:51.522982 sshd[1558]: Accepted publickey for core from 10.0.0.1 port 43466 ssh2: RSA SHA256:BOxEaGpHMktIkRdcKvKv9Es2//92qEL6t3QfRP9zfwU Jul 14 21:45:51.525187 sshd[1558]: pam_unix(sshd:session): session opened for user core(uid=500) by (uid=0) Jul 14 21:45:51.537807 systemd[1]: Created slice user-500.slice. Jul 14 21:45:51.539021 systemd[1]: Starting user-runtime-dir@500.service... Jul 14 21:45:51.540673 systemd-logind[1122]: New session 1 of user core. Jul 14 21:45:51.547177 systemd[1]: Finished user-runtime-dir@500.service. Jul 14 21:45:51.548722 systemd[1]: Starting user@500.service... Jul 14 21:45:51.551890 (systemd)[1561]: pam_unix(systemd-user:session): session opened for user core(uid=500) by (uid=0) Jul 14 21:45:51.620458 systemd[1561]: Queued start job for default target default.target. Jul 14 21:45:51.621048 systemd[1561]: Reached target paths.target. Jul 14 21:45:51.621067 systemd[1561]: Reached target sockets.target. Jul 14 21:45:51.621078 systemd[1561]: Reached target timers.target. Jul 14 21:45:51.621092 systemd[1561]: Reached target basic.target. Jul 14 21:45:51.621136 systemd[1561]: Reached target default.target. Jul 14 21:45:51.621162 systemd[1561]: Startup finished in 63ms. Jul 14 21:45:51.621239 systemd[1]: Started user@500.service. Jul 14 21:45:51.622916 systemd[1]: Started session-1.scope. Jul 14 21:45:51.679007 systemd[1]: Started sshd@1-10.0.0.17:22-10.0.0.1:43478.service. Jul 14 21:45:51.723616 sshd[1570]: Accepted publickey for core from 10.0.0.1 port 43478 ssh2: RSA SHA256:BOxEaGpHMktIkRdcKvKv9Es2//92qEL6t3QfRP9zfwU Jul 14 21:45:51.725052 sshd[1570]: pam_unix(sshd:session): session opened for user core(uid=500) by (uid=0) Jul 14 21:45:51.728900 systemd-logind[1122]: New session 2 of user core. Jul 14 21:45:51.730515 systemd[1]: Started session-2.scope. Jul 14 21:45:51.791542 sshd[1570]: pam_unix(sshd:session): session closed for user core Jul 14 21:45:51.794655 systemd[1]: Started sshd@2-10.0.0.17:22-10.0.0.1:43486.service. Jul 14 21:45:51.795274 systemd[1]: sshd@1-10.0.0.17:22-10.0.0.1:43478.service: Deactivated successfully. Jul 14 21:45:51.796083 systemd[1]: session-2.scope: Deactivated successfully. Jul 14 21:45:51.796691 systemd-logind[1122]: Session 2 logged out. Waiting for processes to exit. Jul 14 21:45:51.797558 systemd-logind[1122]: Removed session 2. Jul 14 21:45:51.832520 sshd[1575]: Accepted publickey for core from 10.0.0.1 port 43486 ssh2: RSA SHA256:BOxEaGpHMktIkRdcKvKv9Es2//92qEL6t3QfRP9zfwU Jul 14 21:45:51.833713 sshd[1575]: pam_unix(sshd:session): session opened for user core(uid=500) by (uid=0) Jul 14 21:45:51.836960 systemd-logind[1122]: New session 3 of user core. Jul 14 21:45:51.837737 systemd[1]: Started session-3.scope. Jul 14 21:45:51.887566 sshd[1575]: pam_unix(sshd:session): session closed for user core Jul 14 21:45:51.890068 systemd[1]: sshd@2-10.0.0.17:22-10.0.0.1:43486.service: Deactivated successfully. Jul 14 21:45:51.890687 systemd[1]: session-3.scope: Deactivated successfully. Jul 14 21:45:51.891293 systemd-logind[1122]: Session 3 logged out. Waiting for processes to exit. Jul 14 21:45:51.892797 systemd[1]: Started sshd@3-10.0.0.17:22-10.0.0.1:43490.service. Jul 14 21:45:51.893381 systemd-logind[1122]: Removed session 3. Jul 14 21:45:51.928777 sshd[1582]: Accepted publickey for core from 10.0.0.1 port 43490 ssh2: RSA SHA256:BOxEaGpHMktIkRdcKvKv9Es2//92qEL6t3QfRP9zfwU Jul 14 21:45:51.930203 sshd[1582]: pam_unix(sshd:session): session opened for user core(uid=500) by (uid=0) Jul 14 21:45:51.934048 systemd-logind[1122]: New session 4 of user core. Jul 14 21:45:51.934278 systemd[1]: Started session-4.scope. Jul 14 21:45:51.988494 sshd[1582]: pam_unix(sshd:session): session closed for user core Jul 14 21:45:51.991793 systemd[1]: Started sshd@4-10.0.0.17:22-10.0.0.1:43504.service. Jul 14 21:45:51.994216 systemd[1]: sshd@3-10.0.0.17:22-10.0.0.1:43490.service: Deactivated successfully. Jul 14 21:45:51.994828 systemd[1]: session-4.scope: Deactivated successfully. Jul 14 21:45:51.995362 systemd-logind[1122]: Session 4 logged out. Waiting for processes to exit. Jul 14 21:45:51.996192 systemd-logind[1122]: Removed session 4. Jul 14 21:45:52.029881 sshd[1587]: Accepted publickey for core from 10.0.0.1 port 43504 ssh2: RSA SHA256:BOxEaGpHMktIkRdcKvKv9Es2//92qEL6t3QfRP9zfwU Jul 14 21:45:52.031131 sshd[1587]: pam_unix(sshd:session): session opened for user core(uid=500) by (uid=0) Jul 14 21:45:52.034682 systemd-logind[1122]: New session 5 of user core. Jul 14 21:45:52.035069 systemd[1]: Started session-5.scope. Jul 14 21:45:52.086288 sshd[1587]: pam_unix(sshd:session): session closed for user core Jul 14 21:45:52.088692 systemd[1]: sshd@4-10.0.0.17:22-10.0.0.1:43504.service: Deactivated successfully. Jul 14 21:45:52.089258 systemd[1]: session-5.scope: Deactivated successfully. Jul 14 21:45:52.089723 systemd-logind[1122]: Session 5 logged out. Waiting for processes to exit. Jul 14 21:45:52.090706 systemd[1]: Started sshd@5-10.0.0.17:22-10.0.0.1:43514.service. Jul 14 21:45:52.096372 systemd-logind[1122]: Removed session 5. Jul 14 21:45:52.128150 sshd[1597]: Accepted publickey for core from 10.0.0.1 port 43514 ssh2: RSA SHA256:BOxEaGpHMktIkRdcKvKv9Es2//92qEL6t3QfRP9zfwU Jul 14 21:45:52.129406 sshd[1597]: pam_unix(sshd:session): session opened for user core(uid=500) by (uid=0) Jul 14 21:45:52.132708 systemd-logind[1122]: New session 6 of user core. Jul 14 21:45:52.133499 systemd[1]: Started session-6.scope. Jul 14 21:45:52.243716 sshd[1597]: pam_unix(sshd:session): session closed for user core Jul 14 21:45:52.246666 systemd[1]: sshd@5-10.0.0.17:22-10.0.0.1:43514.service: Deactivated successfully. Jul 14 21:45:52.247372 systemd[1]: session-6.scope: Deactivated successfully. Jul 14 21:45:52.247945 systemd-logind[1122]: Session 6 logged out. Waiting for processes to exit. Jul 14 21:45:52.248698 systemd-logind[1122]: Removed session 6. Jul 14 21:46:30.011457 update_engine[1124]: I0714 21:46:30.011075 1124 update_attempter.cc:509] Updating boot flags...