Jul 14 21:49:00.756527 kernel: Booting Linux on physical CPU 0x0000000000 [0x413fd0c1] Jul 14 21:49:00.756548 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:49:00.756557 kernel: efi: EFI v2.70 by EDK II Jul 14 21:49:00.756562 kernel: efi: SMBIOS 3.0=0xd9260000 ACPI 2.0=0xd9240000 MEMATTR=0xda32b018 RNG=0xd9220018 MEMRESERVE=0xd9521c18 Jul 14 21:49:00.756568 kernel: random: crng init done Jul 14 21:49:00.756573 kernel: ACPI: Early table checksum verification disabled Jul 14 21:49:00.756579 kernel: ACPI: RSDP 0x00000000D9240000 000024 (v02 BOCHS ) Jul 14 21:49:00.756586 kernel: ACPI: XSDT 0x00000000D9230000 000064 (v01 BOCHS BXPC 00000001 01000013) Jul 14 21:49:00.756592 kernel: ACPI: FACP 0x00000000D91E0000 000114 (v06 BOCHS BXPC 00000001 BXPC 00000001) Jul 14 21:49:00.756597 kernel: ACPI: DSDT 0x00000000D91F0000 0014A2 (v02 BOCHS BXPC 00000001 BXPC 00000001) Jul 14 21:49:00.756603 kernel: ACPI: APIC 0x00000000D91D0000 0001A8 (v04 BOCHS BXPC 00000001 BXPC 00000001) Jul 14 21:49:00.756609 kernel: ACPI: PPTT 0x00000000D91C0000 00009C (v02 BOCHS BXPC 00000001 BXPC 00000001) Jul 14 21:49:00.756614 kernel: ACPI: GTDT 0x00000000D91B0000 000060 (v02 BOCHS BXPC 00000001 BXPC 00000001) Jul 14 21:49:00.756620 kernel: ACPI: MCFG 0x00000000D91A0000 00003C (v01 BOCHS BXPC 00000001 BXPC 00000001) Jul 14 21:49:00.756628 kernel: ACPI: SPCR 0x00000000D9190000 000050 (v02 BOCHS BXPC 00000001 BXPC 00000001) Jul 14 21:49:00.756634 kernel: ACPI: DBG2 0x00000000D9180000 000057 (v00 BOCHS BXPC 00000001 BXPC 00000001) Jul 14 21:49:00.756640 kernel: ACPI: IORT 0x00000000D9170000 000080 (v03 BOCHS BXPC 00000001 BXPC 00000001) Jul 14 21:49:00.756646 kernel: ACPI: SPCR: console: pl011,mmio,0x9000000,9600 Jul 14 21:49:00.756652 kernel: NUMA: Failed to initialise from firmware Jul 14 21:49:00.756658 kernel: NUMA: Faking a node at [mem 0x0000000040000000-0x00000000dcffffff] Jul 14 21:49:00.756664 kernel: NUMA: NODE_DATA [mem 0xdcb0a900-0xdcb0ffff] Jul 14 21:49:00.756670 kernel: Zone ranges: Jul 14 21:49:00.756676 kernel: DMA [mem 0x0000000040000000-0x00000000dcffffff] Jul 14 21:49:00.756683 kernel: DMA32 empty Jul 14 21:49:00.756689 kernel: Normal empty Jul 14 21:49:00.756695 kernel: Movable zone start for each node Jul 14 21:49:00.756701 kernel: Early memory node ranges Jul 14 21:49:00.756707 kernel: node 0: [mem 0x0000000040000000-0x00000000d924ffff] Jul 14 21:49:00.756713 kernel: node 0: [mem 0x00000000d9250000-0x00000000d951ffff] Jul 14 21:49:00.756719 kernel: node 0: [mem 0x00000000d9520000-0x00000000dc7fffff] Jul 14 21:49:00.756725 kernel: node 0: [mem 0x00000000dc800000-0x00000000dc88ffff] Jul 14 21:49:00.756731 kernel: node 0: [mem 0x00000000dc890000-0x00000000dc89ffff] Jul 14 21:49:00.756736 kernel: node 0: [mem 0x00000000dc8a0000-0x00000000dc9bffff] Jul 14 21:49:00.756742 kernel: node 0: [mem 0x00000000dc9c0000-0x00000000dcffffff] Jul 14 21:49:00.756748 kernel: Initmem setup node 0 [mem 0x0000000040000000-0x00000000dcffffff] Jul 14 21:49:00.756756 kernel: On node 0, zone DMA: 12288 pages in unavailable ranges Jul 14 21:49:00.756761 kernel: psci: probing for conduit method from ACPI. Jul 14 21:49:00.756767 kernel: psci: PSCIv1.1 detected in firmware. Jul 14 21:49:00.756773 kernel: psci: Using standard PSCI v0.2 function IDs Jul 14 21:49:00.756780 kernel: psci: Trusted OS migration not required Jul 14 21:49:00.756791 kernel: psci: SMC Calling Convention v1.1 Jul 14 21:49:00.756799 kernel: smccc: KVM: hypervisor services detected (0x00000000 0x00000000 0x00000000 0x00000003) Jul 14 21:49:00.756809 kernel: ACPI: SRAT not present Jul 14 21:49:00.756815 kernel: percpu: Embedded 30 pages/cpu s82968 r8192 d31720 u122880 Jul 14 21:49:00.756821 kernel: pcpu-alloc: s82968 r8192 d31720 u122880 alloc=30*4096 Jul 14 21:49:00.756828 kernel: pcpu-alloc: [0] 0 [0] 1 [0] 2 [0] 3 Jul 14 21:49:00.756834 kernel: Detected PIPT I-cache on CPU0 Jul 14 21:49:00.756840 kernel: CPU features: detected: GIC system register CPU interface Jul 14 21:49:00.756847 kernel: CPU features: detected: Hardware dirty bit management Jul 14 21:49:00.756852 kernel: CPU features: detected: Spectre-v4 Jul 14 21:49:00.756859 kernel: CPU features: detected: Spectre-BHB Jul 14 21:49:00.756866 kernel: CPU features: kernel page table isolation forced ON by KASLR Jul 14 21:49:00.756873 kernel: CPU features: detected: Kernel page table isolation (KPTI) Jul 14 21:49:00.756879 kernel: CPU features: detected: ARM erratum 1418040 Jul 14 21:49:00.756885 kernel: CPU features: detected: SSBS not fully self-synchronizing Jul 14 21:49:00.756891 kernel: Built 1 zonelists, mobility grouping on. Total pages: 633024 Jul 14 21:49:00.756897 kernel: Policy zone: DMA Jul 14 21:49:00.756904 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:49:00.756911 kernel: Unknown kernel command line parameters "BOOT_IMAGE=/flatcar/vmlinuz-a", will be passed to user space. Jul 14 21:49:00.756917 kernel: Dentry cache hash table entries: 524288 (order: 10, 4194304 bytes, linear) Jul 14 21:49:00.756923 kernel: Inode-cache hash table entries: 262144 (order: 9, 2097152 bytes, linear) Jul 14 21:49:00.756930 kernel: mem auto-init: stack:off, heap alloc:off, heap free:off Jul 14 21:49:00.756938 kernel: Memory: 2457336K/2572288K available (9792K kernel code, 2094K rwdata, 7588K rodata, 36416K init, 777K bss, 114952K reserved, 0K cma-reserved) Jul 14 21:49:00.756944 kernel: SLUB: HWalign=64, Order=0-3, MinObjects=0, CPUs=4, Nodes=1 Jul 14 21:49:00.756950 kernel: trace event string verifier disabled Jul 14 21:49:00.756956 kernel: rcu: Preemptible hierarchical RCU implementation. Jul 14 21:49:00.756963 kernel: rcu: RCU event tracing is enabled. Jul 14 21:49:00.756969 kernel: rcu: RCU restricting CPUs from NR_CPUS=512 to nr_cpu_ids=4. Jul 14 21:49:00.756976 kernel: Trampoline variant of Tasks RCU enabled. Jul 14 21:49:00.756982 kernel: Tracing variant of Tasks RCU enabled. Jul 14 21:49:00.756988 kernel: rcu: RCU calculated value of scheduler-enlistment delay is 100 jiffies. Jul 14 21:49:00.756995 kernel: rcu: Adjusting geometry for rcu_fanout_leaf=16, nr_cpu_ids=4 Jul 14 21:49:00.757001 kernel: NR_IRQS: 64, nr_irqs: 64, preallocated irqs: 0 Jul 14 21:49:00.757024 kernel: GICv3: 256 SPIs implemented Jul 14 21:49:00.757031 kernel: GICv3: 0 Extended SPIs implemented Jul 14 21:49:00.757037 kernel: GICv3: Distributor has no Range Selector support Jul 14 21:49:00.757043 kernel: Root IRQ handler: gic_handle_irq Jul 14 21:49:00.757049 kernel: GICv3: 16 PPIs implemented Jul 14 21:49:00.757055 kernel: GICv3: CPU0: found redistributor 0 region 0:0x00000000080a0000 Jul 14 21:49:00.757062 kernel: ACPI: SRAT not present Jul 14 21:49:00.757068 kernel: ITS [mem 0x08080000-0x0809ffff] Jul 14 21:49:00.757074 kernel: ITS@0x0000000008080000: allocated 8192 Devices @400b0000 (indirect, esz 8, psz 64K, shr 1) Jul 14 21:49:00.757081 kernel: ITS@0x0000000008080000: allocated 8192 Interrupt Collections @400c0000 (flat, esz 8, psz 64K, shr 1) Jul 14 21:49:00.757088 kernel: GICv3: using LPI property table @0x00000000400d0000 Jul 14 21:49:00.757094 kernel: GICv3: CPU0: using allocated LPI pending table @0x00000000400e0000 Jul 14 21:49:00.757102 kernel: arch_timer: Enabling local workaround for ARM erratum 1418040 Jul 14 21:49:00.757109 kernel: arch_timer: cp15 timer(s) running at 25.00MHz (virt). Jul 14 21:49:00.757115 kernel: clocksource: arch_sys_counter: mask: 0xffffffffffffff max_cycles: 0x5c40939b5, max_idle_ns: 440795202646 ns Jul 14 21:49:00.757122 kernel: sched_clock: 56 bits at 25MHz, resolution 40ns, wraps every 4398046511100ns Jul 14 21:49:00.757128 kernel: arm-pv: using stolen time PV Jul 14 21:49:00.757135 kernel: Console: colour dummy device 80x25 Jul 14 21:49:00.757145 kernel: ACPI: Core revision 20210730 Jul 14 21:49:00.757151 kernel: Calibrating delay loop (skipped), value calculated using timer frequency.. 50.00 BogoMIPS (lpj=25000) Jul 14 21:49:00.757158 kernel: pid_max: default: 32768 minimum: 301 Jul 14 21:49:00.757164 kernel: LSM: Security Framework initializing Jul 14 21:49:00.757172 kernel: SELinux: Initializing. Jul 14 21:49:00.757179 kernel: Mount-cache hash table entries: 8192 (order: 4, 65536 bytes, linear) Jul 14 21:49:00.757185 kernel: Mountpoint-cache hash table entries: 8192 (order: 4, 65536 bytes, linear) Jul 14 21:49:00.757191 kernel: rcu: Hierarchical SRCU implementation. Jul 14 21:49:00.757198 kernel: Platform MSI: ITS@0x8080000 domain created Jul 14 21:49:00.757204 kernel: PCI/MSI: ITS@0x8080000 domain created Jul 14 21:49:00.757212 kernel: Remapping and enabling EFI services. Jul 14 21:49:00.757220 kernel: smp: Bringing up secondary CPUs ... Jul 14 21:49:00.757227 kernel: Detected PIPT I-cache on CPU1 Jul 14 21:49:00.757237 kernel: GICv3: CPU1: found redistributor 1 region 0:0x00000000080c0000 Jul 14 21:49:00.757243 kernel: GICv3: CPU1: using allocated LPI pending table @0x00000000400f0000 Jul 14 21:49:00.757250 kernel: arch_timer: Enabling local workaround for ARM erratum 1418040 Jul 14 21:49:00.757256 kernel: CPU1: Booted secondary processor 0x0000000001 [0x413fd0c1] Jul 14 21:49:00.757263 kernel: Detected PIPT I-cache on CPU2 Jul 14 21:49:00.757270 kernel: GICv3: CPU2: found redistributor 2 region 0:0x00000000080e0000 Jul 14 21:49:00.757276 kernel: GICv3: CPU2: using allocated LPI pending table @0x0000000040100000 Jul 14 21:49:00.757284 kernel: arch_timer: Enabling local workaround for ARM erratum 1418040 Jul 14 21:49:00.757290 kernel: CPU2: Booted secondary processor 0x0000000002 [0x413fd0c1] Jul 14 21:49:00.757297 kernel: Detected PIPT I-cache on CPU3 Jul 14 21:49:00.757304 kernel: GICv3: CPU3: found redistributor 3 region 0:0x0000000008100000 Jul 14 21:49:00.757311 kernel: GICv3: CPU3: using allocated LPI pending table @0x0000000040110000 Jul 14 21:49:00.757317 kernel: arch_timer: Enabling local workaround for ARM erratum 1418040 Jul 14 21:49:00.757324 kernel: CPU3: Booted secondary processor 0x0000000003 [0x413fd0c1] Jul 14 21:49:00.757335 kernel: smp: Brought up 1 node, 4 CPUs Jul 14 21:49:00.757343 kernel: SMP: Total of 4 processors activated. Jul 14 21:49:00.757350 kernel: CPU features: detected: 32-bit EL0 Support Jul 14 21:49:00.757357 kernel: CPU features: detected: Data cache clean to the PoU not required for I/D coherence Jul 14 21:49:00.757363 kernel: CPU features: detected: Common not Private translations Jul 14 21:49:00.757370 kernel: CPU features: detected: CRC32 instructions Jul 14 21:49:00.757377 kernel: CPU features: detected: RCpc load-acquire (LDAPR) Jul 14 21:49:00.757384 kernel: CPU features: detected: LSE atomic instructions Jul 14 21:49:00.757392 kernel: CPU features: detected: Privileged Access Never Jul 14 21:49:00.757399 kernel: CPU features: detected: RAS Extension Support Jul 14 21:49:00.757406 kernel: CPU features: detected: Speculative Store Bypassing Safe (SSBS) Jul 14 21:49:00.757413 kernel: CPU: All CPU(s) started at EL1 Jul 14 21:49:00.757420 kernel: alternatives: patching kernel code Jul 14 21:49:00.757429 kernel: devtmpfs: initialized Jul 14 21:49:00.757436 kernel: KASLR enabled Jul 14 21:49:00.757445 kernel: clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1911260446275000 ns Jul 14 21:49:00.757454 kernel: futex hash table entries: 1024 (order: 4, 65536 bytes, linear) Jul 14 21:49:00.757461 kernel: pinctrl core: initialized pinctrl subsystem Jul 14 21:49:00.757468 kernel: SMBIOS 3.0.0 present. Jul 14 21:49:00.757474 kernel: DMI: QEMU KVM Virtual Machine, BIOS 0.0.0 02/06/2015 Jul 14 21:49:00.757481 kernel: NET: Registered PF_NETLINK/PF_ROUTE protocol family Jul 14 21:49:00.757488 kernel: DMA: preallocated 512 KiB GFP_KERNEL pool for atomic allocations Jul 14 21:49:00.757496 kernel: DMA: preallocated 512 KiB GFP_KERNEL|GFP_DMA pool for atomic allocations Jul 14 21:49:00.757503 kernel: DMA: preallocated 512 KiB GFP_KERNEL|GFP_DMA32 pool for atomic allocations Jul 14 21:49:00.757510 kernel: audit: initializing netlink subsys (disabled) Jul 14 21:49:00.757517 kernel: audit: type=2000 audit(0.045:1): state=initialized audit_enabled=0 res=1 Jul 14 21:49:00.757523 kernel: thermal_sys: Registered thermal governor 'step_wise' Jul 14 21:49:00.757530 kernel: cpuidle: using governor menu Jul 14 21:49:00.757537 kernel: hw-breakpoint: found 6 breakpoint and 4 watchpoint registers. Jul 14 21:49:00.757544 kernel: ASID allocator initialised with 32768 entries Jul 14 21:49:00.757551 kernel: ACPI: bus type PCI registered Jul 14 21:49:00.757559 kernel: acpiphp: ACPI Hot Plug PCI Controller Driver version: 0.5 Jul 14 21:49:00.757566 kernel: Serial: AMBA PL011 UART driver Jul 14 21:49:00.757573 kernel: HugeTLB registered 1.00 GiB page size, pre-allocated 0 pages Jul 14 21:49:00.757580 kernel: HugeTLB registered 32.0 MiB page size, pre-allocated 0 pages Jul 14 21:49:00.757587 kernel: HugeTLB registered 2.00 MiB page size, pre-allocated 0 pages Jul 14 21:49:00.757594 kernel: HugeTLB registered 64.0 KiB page size, pre-allocated 0 pages Jul 14 21:49:00.757600 kernel: cryptd: max_cpu_qlen set to 1000 Jul 14 21:49:00.757607 kernel: alg: No test for fips(ansi_cprng) (fips_ansi_cprng) Jul 14 21:49:00.757614 kernel: ACPI: Added _OSI(Module Device) Jul 14 21:49:00.757622 kernel: ACPI: Added _OSI(Processor Device) Jul 14 21:49:00.757630 kernel: ACPI: Added _OSI(Processor Aggregator Device) Jul 14 21:49:00.757636 kernel: ACPI: Added _OSI(Linux-Dell-Video) Jul 14 21:49:00.757643 kernel: ACPI: Added _OSI(Linux-Lenovo-NV-HDMI-Audio) Jul 14 21:49:00.757650 kernel: ACPI: Added _OSI(Linux-HPI-Hybrid-Graphics) Jul 14 21:49:00.757656 kernel: ACPI: 1 ACPI AML tables successfully acquired and loaded Jul 14 21:49:00.757663 kernel: ACPI: Interpreter enabled Jul 14 21:49:00.757670 kernel: ACPI: Using GIC for interrupt routing Jul 14 21:49:00.757677 kernel: ACPI: MCFG table detected, 1 entries Jul 14 21:49:00.757685 kernel: ARMH0011:00: ttyAMA0 at MMIO 0x9000000 (irq = 12, base_baud = 0) is a SBSA Jul 14 21:49:00.757691 kernel: printk: console [ttyAMA0] enabled Jul 14 21:49:00.757698 kernel: ACPI: PCI Root Bridge [PCI0] (domain 0000 [bus 00-ff]) Jul 14 21:49:00.757835 kernel: acpi PNP0A08:00: _OSC: OS supports [ExtendedConfig ASPM ClockPM Segments MSI HPX-Type3] Jul 14 21:49:00.757906 kernel: acpi PNP0A08:00: _OSC: platform does not support [LTR] Jul 14 21:49:00.757969 kernel: acpi PNP0A08:00: _OSC: OS now controls [PCIeHotplug PME AER PCIeCapability] Jul 14 21:49:00.758064 kernel: acpi PNP0A08:00: ECAM area [mem 0x4010000000-0x401fffffff] reserved by PNP0C02:00 Jul 14 21:49:00.758135 kernel: acpi PNP0A08:00: ECAM at [mem 0x4010000000-0x401fffffff] for [bus 00-ff] Jul 14 21:49:00.758144 kernel: ACPI: Remapped I/O 0x000000003eff0000 to [io 0x0000-0xffff window] Jul 14 21:49:00.758151 kernel: PCI host bridge to bus 0000:00 Jul 14 21:49:00.758220 kernel: pci_bus 0000:00: root bus resource [mem 0x10000000-0x3efeffff window] Jul 14 21:49:00.758278 kernel: pci_bus 0000:00: root bus resource [io 0x0000-0xffff window] Jul 14 21:49:00.758333 kernel: pci_bus 0000:00: root bus resource [mem 0x8000000000-0xffffffffff window] Jul 14 21:49:00.758388 kernel: pci_bus 0000:00: root bus resource [bus 00-ff] Jul 14 21:49:00.758469 kernel: pci 0000:00:00.0: [1b36:0008] type 00 class 0x060000 Jul 14 21:49:00.758545 kernel: pci 0000:00:01.0: [1af4:1005] type 00 class 0x00ff00 Jul 14 21:49:00.758611 kernel: pci 0000:00:01.0: reg 0x10: [io 0x0000-0x001f] Jul 14 21:49:00.758673 kernel: pci 0000:00:01.0: reg 0x14: [mem 0x10000000-0x10000fff] Jul 14 21:49:00.758738 kernel: pci 0000:00:01.0: reg 0x20: [mem 0x8000000000-0x8000003fff 64bit pref] Jul 14 21:49:00.758801 kernel: pci 0000:00:01.0: BAR 4: assigned [mem 0x8000000000-0x8000003fff 64bit pref] Jul 14 21:49:00.758864 kernel: pci 0000:00:01.0: BAR 1: assigned [mem 0x10000000-0x10000fff] Jul 14 21:49:00.758928 kernel: pci 0000:00:01.0: BAR 0: assigned [io 0x1000-0x101f] Jul 14 21:49:00.758984 kernel: pci_bus 0000:00: resource 4 [mem 0x10000000-0x3efeffff window] Jul 14 21:49:00.759059 kernel: pci_bus 0000:00: resource 5 [io 0x0000-0xffff window] Jul 14 21:49:00.759121 kernel: pci_bus 0000:00: resource 6 [mem 0x8000000000-0xffffffffff window] Jul 14 21:49:00.759130 kernel: ACPI: PCI: Interrupt link GSI0 configured for IRQ 35 Jul 14 21:49:00.759137 kernel: ACPI: PCI: Interrupt link GSI1 configured for IRQ 36 Jul 14 21:49:00.759144 kernel: ACPI: PCI: Interrupt link GSI2 configured for IRQ 37 Jul 14 21:49:00.759153 kernel: ACPI: PCI: Interrupt link GSI3 configured for IRQ 38 Jul 14 21:49:00.759160 kernel: iommu: Default domain type: Translated Jul 14 21:49:00.759167 kernel: iommu: DMA domain TLB invalidation policy: strict mode Jul 14 21:49:00.759186 kernel: vgaarb: loaded Jul 14 21:49:00.759202 kernel: pps_core: LinuxPPS API ver. 1 registered Jul 14 21:49:00.759209 kernel: pps_core: Software ver. 5.3.6 - Copyright 2005-2007 Rodolfo Giometti Jul 14 21:49:00.759216 kernel: PTP clock support registered Jul 14 21:49:00.759222 kernel: Registered efivars operations Jul 14 21:49:00.759229 kernel: clocksource: Switched to clocksource arch_sys_counter Jul 14 21:49:00.759236 kernel: VFS: Disk quotas dquot_6.6.0 Jul 14 21:49:00.759245 kernel: VFS: Dquot-cache hash table entries: 512 (order 0, 4096 bytes) Jul 14 21:49:00.759252 kernel: pnp: PnP ACPI init Jul 14 21:49:00.759329 kernel: system 00:00: [mem 0x4010000000-0x401fffffff window] could not be reserved Jul 14 21:49:00.759338 kernel: pnp: PnP ACPI: found 1 devices Jul 14 21:49:00.759346 kernel: NET: Registered PF_INET protocol family Jul 14 21:49:00.759353 kernel: IP idents hash table entries: 65536 (order: 7, 524288 bytes, linear) Jul 14 21:49:00.759360 kernel: tcp_listen_portaddr_hash hash table entries: 2048 (order: 3, 32768 bytes, linear) Jul 14 21:49:00.759367 kernel: Table-perturb hash table entries: 65536 (order: 6, 262144 bytes, linear) Jul 14 21:49:00.759375 kernel: TCP established hash table entries: 32768 (order: 6, 262144 bytes, linear) Jul 14 21:49:00.759382 kernel: TCP bind hash table entries: 32768 (order: 7, 524288 bytes, linear) Jul 14 21:49:00.759389 kernel: TCP: Hash tables configured (established 32768 bind 32768) Jul 14 21:49:00.759396 kernel: UDP hash table entries: 2048 (order: 4, 65536 bytes, linear) Jul 14 21:49:00.759404 kernel: UDP-Lite hash table entries: 2048 (order: 4, 65536 bytes, linear) Jul 14 21:49:00.759412 kernel: NET: Registered PF_UNIX/PF_LOCAL protocol family Jul 14 21:49:00.759419 kernel: PCI: CLS 0 bytes, default 64 Jul 14 21:49:00.759428 kernel: hw perfevents: enabled with armv8_pmuv3_0 PMU driver, 7 counters available Jul 14 21:49:00.759436 kernel: kvm [1]: HYP mode not available Jul 14 21:49:00.759445 kernel: Initialise system trusted keyrings Jul 14 21:49:00.759454 kernel: workingset: timestamp_bits=39 max_order=20 bucket_order=0 Jul 14 21:49:00.759462 kernel: Key type asymmetric registered Jul 14 21:49:00.759470 kernel: Asymmetric key parser 'x509' registered Jul 14 21:49:00.759479 kernel: Block layer SCSI generic (bsg) driver version 0.4 loaded (major 249) Jul 14 21:49:00.759485 kernel: io scheduler mq-deadline registered Jul 14 21:49:00.759492 kernel: io scheduler kyber registered Jul 14 21:49:00.759499 kernel: io scheduler bfq registered Jul 14 21:49:00.759506 kernel: input: Power Button as /devices/LNXSYSTM:00/LNXSYBUS:00/PNP0C0C:00/input/input0 Jul 14 21:49:00.759514 kernel: ACPI: button: Power Button [PWRB] Jul 14 21:49:00.759522 kernel: ACPI: \_SB_.PCI0.GSI1: Enabled at IRQ 36 Jul 14 21:49:00.759587 kernel: virtio-pci 0000:00:01.0: enabling device (0005 -> 0007) Jul 14 21:49:00.759597 kernel: Serial: 8250/16550 driver, 4 ports, IRQ sharing enabled Jul 14 21:49:00.759604 kernel: thunder_xcv, ver 1.0 Jul 14 21:49:00.759610 kernel: thunder_bgx, ver 1.0 Jul 14 21:49:00.759617 kernel: nicpf, ver 1.0 Jul 14 21:49:00.759624 kernel: nicvf, ver 1.0 Jul 14 21:49:00.759700 kernel: rtc-efi rtc-efi.0: registered as rtc0 Jul 14 21:49:00.759762 kernel: rtc-efi rtc-efi.0: setting system clock to 2025-07-14T21:49:00 UTC (1752529740) Jul 14 21:49:00.759772 kernel: hid: raw HID events driver (C) Jiri Kosina Jul 14 21:49:00.759779 kernel: NET: Registered PF_INET6 protocol family Jul 14 21:49:00.759785 kernel: Segment Routing with IPv6 Jul 14 21:49:00.759792 kernel: In-situ OAM (IOAM) with IPv6 Jul 14 21:49:00.759798 kernel: NET: Registered PF_PACKET protocol family Jul 14 21:49:00.759805 kernel: Key type dns_resolver registered Jul 14 21:49:00.759812 kernel: registered taskstats version 1 Jul 14 21:49:00.759821 kernel: Loading compiled-in X.509 certificates Jul 14 21:49:00.759828 kernel: Loaded X.509 cert 'Kinvolk GmbH: Module signing key for 5.15.187-flatcar: 118351bb2b1409a8fe1c98db16ecff1bb5342a27' Jul 14 21:49:00.759835 kernel: Key type .fscrypt registered Jul 14 21:49:00.759841 kernel: Key type fscrypt-provisioning registered Jul 14 21:49:00.759848 kernel: ima: No TPM chip found, activating TPM-bypass! Jul 14 21:49:00.759855 kernel: ima: Allocated hash algorithm: sha1 Jul 14 21:49:00.759862 kernel: ima: No architecture policies found Jul 14 21:49:00.759869 kernel: clk: Disabling unused clocks Jul 14 21:49:00.759875 kernel: Freeing unused kernel memory: 36416K Jul 14 21:49:00.759883 kernel: Run /init as init process Jul 14 21:49:00.759890 kernel: with arguments: Jul 14 21:49:00.759897 kernel: /init Jul 14 21:49:00.759903 kernel: with environment: Jul 14 21:49:00.759910 kernel: HOME=/ Jul 14 21:49:00.759916 kernel: TERM=linux Jul 14 21:49:00.759923 kernel: BOOT_IMAGE=/flatcar/vmlinuz-a Jul 14 21:49:00.759932 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:49:00.759942 systemd[1]: Detected virtualization kvm. Jul 14 21:49:00.759949 systemd[1]: Detected architecture arm64. Jul 14 21:49:00.759956 systemd[1]: Running in initrd. Jul 14 21:49:00.759963 systemd[1]: No hostname configured, using default hostname. Jul 14 21:49:00.759970 systemd[1]: Hostname set to . Jul 14 21:49:00.759978 systemd[1]: Initializing machine ID from VM UUID. Jul 14 21:49:00.759985 systemd[1]: Queued start job for default target initrd.target. Jul 14 21:49:00.759992 systemd[1]: Started systemd-ask-password-console.path. Jul 14 21:49:00.760000 systemd[1]: Reached target cryptsetup.target. Jul 14 21:49:00.760042 systemd[1]: Reached target paths.target. Jul 14 21:49:00.760051 systemd[1]: Reached target slices.target. Jul 14 21:49:00.760058 systemd[1]: Reached target swap.target. Jul 14 21:49:00.760066 systemd[1]: Reached target timers.target. Jul 14 21:49:00.760073 systemd[1]: Listening on iscsid.socket. Jul 14 21:49:00.760080 systemd[1]: Listening on iscsiuio.socket. Jul 14 21:49:00.760089 systemd[1]: Listening on systemd-journald-audit.socket. Jul 14 21:49:00.760097 systemd[1]: Listening on systemd-journald-dev-log.socket. Jul 14 21:49:00.760105 systemd[1]: Listening on systemd-journald.socket. Jul 14 21:49:00.760112 systemd[1]: Listening on systemd-networkd.socket. Jul 14 21:49:00.760119 systemd[1]: Listening on systemd-udevd-control.socket. Jul 14 21:49:00.760127 systemd[1]: Listening on systemd-udevd-kernel.socket. Jul 14 21:49:00.760134 systemd[1]: Reached target sockets.target. Jul 14 21:49:00.760142 systemd[1]: Starting kmod-static-nodes.service... Jul 14 21:49:00.760149 systemd[1]: Finished network-cleanup.service. Jul 14 21:49:00.760158 systemd[1]: Starting systemd-fsck-usr.service... Jul 14 21:49:00.760165 systemd[1]: Starting systemd-journald.service... Jul 14 21:49:00.760173 systemd[1]: Starting systemd-modules-load.service... Jul 14 21:49:00.760180 systemd[1]: Starting systemd-resolved.service... Jul 14 21:49:00.760188 systemd[1]: Starting systemd-vconsole-setup.service... Jul 14 21:49:00.760195 systemd[1]: Finished kmod-static-nodes.service. Jul 14 21:49:00.760203 systemd[1]: Finished systemd-fsck-usr.service. Jul 14 21:49:00.760210 systemd[1]: Starting systemd-tmpfiles-setup-dev.service... Jul 14 21:49:00.760218 systemd[1]: Finished systemd-vconsole-setup.service. Jul 14 21:49:00.760226 systemd[1]: Starting dracut-cmdline-ask.service... Jul 14 21:49:00.760238 systemd-journald[290]: Journal started Jul 14 21:49:00.760282 systemd-journald[290]: Runtime Journal (/run/log/journal/fac0a200b6c3499d8fe3ad8058bf8bda) is 6.0M, max 48.7M, 42.6M free. Jul 14 21:49:00.764890 systemd[1]: Started systemd-journald.service. Jul 14 21:49:00.764933 kernel: audit: type=1130 audit(1752529740.764:2): 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:49:00.764000 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:49:00.763649 systemd-modules-load[291]: Inserted module 'overlay' Jul 14 21:49:00.768403 systemd[1]: Finished systemd-tmpfiles-setup-dev.service. Jul 14 21:49:00.770000 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:49:00.774042 kernel: audit: type=1130 audit(1752529740.770:3): 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:49:00.781535 systemd[1]: Finished dracut-cmdline-ask.service. Jul 14 21:49:00.782000 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:49:00.783471 systemd[1]: Starting dracut-cmdline.service... Jul 14 21:49:00.787481 kernel: audit: type=1130 audit(1752529740.782: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:49:00.794862 systemd-resolved[292]: Positive Trust Anchors: Jul 14 21:49:00.794878 systemd-resolved[292]: . IN DS 20326 8 2 e06d44b80b8f1d39a95c0b0d7c65d08458e880409bbc683457104237c7f8ec8d Jul 14 21:49:00.794907 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:49:00.804085 systemd-resolved[292]: Defaulting to hostname 'linux'. Jul 14 21:49:00.805299 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:49:00.804994 systemd[1]: Started systemd-resolved.service. Jul 14 21:49:00.805000 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:49:00.806194 systemd[1]: Reached target nss-lookup.target. Jul 14 21:49:00.810618 kernel: audit: type=1130 audit(1752529740.805: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:49:00.810640 kernel: Bridge firewalling registered Jul 14 21:49:00.810649 dracut-cmdline[309]: dracut-dracut-053 Jul 14 21:49:00.810478 systemd-modules-load[291]: Inserted module 'br_netfilter' Jul 14 21:49:00.813923 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:49:00.822049 kernel: SCSI subsystem initialized Jul 14 21:49:00.829509 kernel: device-mapper: core: CONFIG_IMA_DISABLE_HTABLE is disabled. Duplicate IMA measurements will not be recorded in the IMA log. Jul 14 21:49:00.829584 kernel: device-mapper: uevent: version 1.0.3 Jul 14 21:49:00.830877 kernel: device-mapper: ioctl: 4.45.0-ioctl (2021-03-22) initialised: dm-devel@redhat.com Jul 14 21:49:00.833003 systemd-modules-load[291]: Inserted module 'dm_multipath' Jul 14 21:49:00.833793 systemd[1]: Finished systemd-modules-load.service. Jul 14 21:49:00.835879 systemd[1]: Starting systemd-sysctl.service... Jul 14 21:49:00.834000 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:49:00.840037 kernel: audit: type=1130 audit(1752529740.834: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:49:00.845707 systemd[1]: Finished systemd-sysctl.service. Jul 14 21:49:00.846000 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:49:00.850046 kernel: audit: type=1130 audit(1752529740.846: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:49:00.882039 kernel: Loading iSCSI transport class v2.0-870. Jul 14 21:49:00.895046 kernel: iscsi: registered transport (tcp) Jul 14 21:49:00.911041 kernel: iscsi: registered transport (qla4xxx) Jul 14 21:49:00.911062 kernel: QLogic iSCSI HBA Driver Jul 14 21:49:00.950919 systemd[1]: Finished dracut-cmdline.service. Jul 14 21:49:00.951000 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:49:00.952738 systemd[1]: Starting dracut-pre-udev.service... Jul 14 21:49:00.956085 kernel: audit: type=1130 audit(1752529740.951: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:49:00.998051 kernel: raid6: neonx8 gen() 13353 MB/s Jul 14 21:49:01.015048 kernel: raid6: neonx8 xor() 10355 MB/s Jul 14 21:49:01.032046 kernel: raid6: neonx4 gen() 13051 MB/s Jul 14 21:49:01.049045 kernel: raid6: neonx4 xor() 10844 MB/s Jul 14 21:49:01.066047 kernel: raid6: neonx2 gen() 12574 MB/s Jul 14 21:49:01.083044 kernel: raid6: neonx2 xor() 10062 MB/s Jul 14 21:49:01.100042 kernel: raid6: neonx1 gen() 10368 MB/s Jul 14 21:49:01.117043 kernel: raid6: neonx1 xor() 8772 MB/s Jul 14 21:49:01.134041 kernel: raid6: int64x8 gen() 6251 MB/s Jul 14 21:49:01.151046 kernel: raid6: int64x8 xor() 3541 MB/s Jul 14 21:49:01.168039 kernel: raid6: int64x4 gen() 7218 MB/s Jul 14 21:49:01.185038 kernel: raid6: int64x4 xor() 3848 MB/s Jul 14 21:49:01.202048 kernel: raid6: int64x2 gen() 6146 MB/s Jul 14 21:49:01.219041 kernel: raid6: int64x2 xor() 3279 MB/s Jul 14 21:49:01.236043 kernel: raid6: int64x1 gen() 5003 MB/s Jul 14 21:49:01.253232 kernel: raid6: int64x1 xor() 2610 MB/s Jul 14 21:49:01.253242 kernel: raid6: using algorithm neonx8 gen() 13353 MB/s Jul 14 21:49:01.253251 kernel: raid6: .... xor() 10355 MB/s, rmw enabled Jul 14 21:49:01.254369 kernel: raid6: using neon recovery algorithm Jul 14 21:49:01.265471 kernel: xor: measuring software checksum speed Jul 14 21:49:01.265484 kernel: 8regs : 17217 MB/sec Jul 14 21:49:01.266149 kernel: 32regs : 20676 MB/sec Jul 14 21:49:01.267440 kernel: arm64_neon : 27368 MB/sec Jul 14 21:49:01.267450 kernel: xor: using function: arm64_neon (27368 MB/sec) Jul 14 21:49:01.322041 kernel: Btrfs loaded, crc32c=crc32c-generic, zoned=no, fsverity=no Jul 14 21:49:01.334075 systemd[1]: Finished dracut-pre-udev.service. Jul 14 21:49:01.338748 kernel: audit: type=1130 audit(1752529741.334: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:49:01.338778 kernel: audit: type=1334 audit(1752529741.337:10): prog-id=7 op=LOAD Jul 14 21:49:01.334000 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:49:01.337000 audit: BPF prog-id=7 op=LOAD Jul 14 21:49:01.338000 audit: BPF prog-id=8 op=LOAD Jul 14 21:49:01.339151 systemd[1]: Starting systemd-udevd.service... Jul 14 21:49:01.351809 systemd-udevd[491]: Using default interface naming scheme 'v252'. Jul 14 21:49:01.355153 systemd[1]: Started systemd-udevd.service. Jul 14 21:49:01.355000 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:49:01.357605 systemd[1]: Starting dracut-pre-trigger.service... Jul 14 21:49:01.368870 dracut-pre-trigger[499]: rd.md=0: removing MD RAID activation Jul 14 21:49:01.397800 systemd[1]: Finished dracut-pre-trigger.service. Jul 14 21:49:01.398000 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:49:01.399606 systemd[1]: Starting systemd-udev-trigger.service... Jul 14 21:49:01.434650 systemd[1]: Finished systemd-udev-trigger.service. Jul 14 21:49:01.435000 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:49:01.469087 kernel: virtio_blk virtio1: [vda] 9289728 512-byte logical blocks (4.76 GB/4.43 GiB) Jul 14 21:49:01.471297 kernel: vda: vda1 vda2 vda3 vda4 vda6 vda7 vda9 Jul 14 21:49:01.484102 systemd[1]: Found device dev-disk-by\x2dlabel-ROOT.device. Jul 14 21:49:01.487144 systemd[1]: Found device dev-disk-by\x2dpartuuid-7130c94a\x2d213a\x2d4e5a\x2d8e26\x2d6cce9662f132.device. Jul 14 21:49:01.489666 kernel: BTRFS: device label OEM devid 1 transid 10 /dev/vda6 scanned by (udev-worker) (548) Jul 14 21:49:01.488298 systemd[1]: Found device dev-disk-by\x2dpartlabel-USR\x2dA.device. Jul 14 21:49:01.497023 systemd[1]: Found device dev-disk-by\x2dlabel-EFI\x2dSYSTEM.device. Jul 14 21:49:01.502422 systemd[1]: Found device dev-disk-by\x2dlabel-OEM.device. Jul 14 21:49:01.504537 systemd[1]: Starting disk-uuid.service... Jul 14 21:49:01.514043 kernel: vda: vda1 vda2 vda3 vda4 vda6 vda7 vda9 Jul 14 21:49:02.532036 kernel: vda: vda1 vda2 vda3 vda4 vda6 vda7 vda9 Jul 14 21:49:02.532084 disk-uuid[562]: The operation has completed successfully. Jul 14 21:49:02.555410 systemd[1]: disk-uuid.service: Deactivated successfully. Jul 14 21:49:02.556000 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:49:02.556000 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:49:02.555507 systemd[1]: Finished disk-uuid.service. Jul 14 21:49:02.557197 systemd[1]: Starting verity-setup.service... Jul 14 21:49:02.575046 kernel: device-mapper: verity: sha256 using implementation "sha256-ce" Jul 14 21:49:02.597621 systemd[1]: Found device dev-mapper-usr.device. Jul 14 21:49:02.600084 systemd[1]: Mounting sysusr-usr.mount... Jul 14 21:49:02.601882 systemd[1]: Finished verity-setup.service. Jul 14 21:49:02.602000 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:49:02.651869 systemd[1]: Mounted sysusr-usr.mount. Jul 14 21:49:02.653301 kernel: EXT4-fs (dm-0): mounted filesystem without journal. Opts: norecovery. Quota mode: none. Jul 14 21:49:02.652787 systemd[1]: afterburn-network-kargs.service was skipped because no trigger condition checks were met. Jul 14 21:49:02.653580 systemd[1]: Starting ignition-setup.service... Jul 14 21:49:02.656345 systemd[1]: Starting parse-ip-for-networkd.service... Jul 14 21:49:02.663493 kernel: BTRFS info (device vda6): using crc32c (crc32c-generic) checksum algorithm Jul 14 21:49:02.663550 kernel: BTRFS info (device vda6): using free space tree Jul 14 21:49:02.663565 kernel: BTRFS info (device vda6): has skinny extents Jul 14 21:49:02.673989 systemd[1]: mnt-oem.mount: Deactivated successfully. Jul 14 21:49:02.682000 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:49:02.681835 systemd[1]: Finished ignition-setup.service. Jul 14 21:49:02.683646 systemd[1]: Starting ignition-fetch-offline.service... Jul 14 21:49:02.753000 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:49:02.753000 audit: BPF prog-id=9 op=LOAD Jul 14 21:49:02.751876 systemd[1]: Finished parse-ip-for-networkd.service. Jul 14 21:49:02.754417 systemd[1]: Starting systemd-networkd.service... Jul 14 21:49:02.771391 ignition[648]: Ignition 2.14.0 Jul 14 21:49:02.771404 ignition[648]: Stage: fetch-offline Jul 14 21:49:02.771450 ignition[648]: no configs at "/usr/lib/ignition/base.d" Jul 14 21:49:02.771459 ignition[648]: no config dir at "/usr/lib/ignition/base.platform.d/qemu" Jul 14 21:49:02.771622 ignition[648]: parsed url from cmdline: "" Jul 14 21:49:02.771626 ignition[648]: no config URL provided Jul 14 21:49:02.771631 ignition[648]: reading system config file "/usr/lib/ignition/user.ign" Jul 14 21:49:02.771638 ignition[648]: no config at "/usr/lib/ignition/user.ign" Jul 14 21:49:02.771657 ignition[648]: op(1): [started] loading QEMU firmware config module Jul 14 21:49:02.771664 ignition[648]: op(1): executing: "modprobe" "qemu_fw_cfg" Jul 14 21:49:02.778579 ignition[648]: op(1): [finished] loading QEMU firmware config module Jul 14 21:49:02.783309 ignition[648]: parsing config with SHA512: 6f5765129264b1145295f9c2a03759d08ffd58fd213d6bd82f9b96a75d35ea68f8fbdfa2a2bbc039a69e009f0fa4cfd24f200808345ebf7d2818d28ca2115909 Jul 14 21:49:02.784357 systemd-networkd[738]: lo: Link UP Jul 14 21:49:02.786000 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:49:02.784371 systemd-networkd[738]: lo: Gained carrier Jul 14 21:49:02.784779 systemd-networkd[738]: Enumeration completed Jul 14 21:49:02.784980 systemd-networkd[738]: eth0: Configuring with /usr/lib/systemd/network/zz-default.network. Jul 14 21:49:02.785327 systemd[1]: Started systemd-networkd.service. Jul 14 21:49:02.786049 systemd-networkd[738]: eth0: Link UP Jul 14 21:49:02.786053 systemd-networkd[738]: eth0: Gained carrier Jul 14 21:49:02.786593 systemd[1]: Reached target network.target. Jul 14 21:49:02.788232 systemd[1]: Starting iscsiuio.service... Jul 14 21:49:02.798501 systemd[1]: Started iscsiuio.service. Jul 14 21:49:02.799000 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:49:02.800344 systemd[1]: Starting iscsid.service... Jul 14 21:49:02.803744 unknown[648]: fetched base config from "system" Jul 14 21:49:02.803757 unknown[648]: fetched user config from "qemu" Jul 14 21:49:02.803943 ignition[648]: fetch-offline: fetch-offline passed Jul 14 21:49:02.807000 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:49:02.808757 iscsid[745]: iscsid: can't open InitiatorName configuration file /etc/iscsi/initiatorname.iscsi Jul 14 21:49:02.808757 iscsid[745]: 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:49:02.808757 iscsid[745]: Example: InitiatorName=iqn.2001-04.com.redhat:fc6. Jul 14 21:49:02.808757 iscsid[745]: If using hardware iscsi like qla4xxx this message can be ignored. Jul 14 21:49:02.808757 iscsid[745]: iscsid: can't open InitiatorAlias configuration file /etc/iscsi/initiatorname.iscsi Jul 14 21:49:02.808757 iscsid[745]: iscsid: can't open iscsid.safe_logout configuration file /etc/iscsi/iscsid.conf Jul 14 21:49:02.817000 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:49:02.805353 systemd-networkd[738]: eth0: DHCPv4 address 10.0.0.38/16, gateway 10.0.0.1 acquired from 10.0.0.1 Jul 14 21:49:02.824000 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:49:02.804063 ignition[648]: Ignition finished successfully Jul 14 21:49:02.806291 systemd[1]: Finished ignition-fetch-offline.service. Jul 14 21:49:02.819451 ignition[746]: Ignition 2.14.0 Jul 14 21:49:02.808109 systemd[1]: ignition-fetch.service was skipped because of an unmet condition check (ConditionPathExists=!/run/ignition.json). Jul 14 21:49:02.819457 ignition[746]: Stage: kargs Jul 14 21:49:02.832000 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:49:02.809106 systemd[1]: Starting ignition-kargs.service... Jul 14 21:49:02.819562 ignition[746]: no configs at "/usr/lib/ignition/base.d" Jul 14 21:49:02.811399 systemd[1]: Started iscsid.service. Jul 14 21:49:02.819571 ignition[746]: no config dir at "/usr/lib/ignition/base.platform.d/qemu" Jul 14 21:49:02.818135 systemd[1]: Starting dracut-initqueue.service... Jul 14 21:49:02.820256 ignition[746]: kargs: kargs passed Jul 14 21:49:02.841000 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:49:02.822458 systemd[1]: Finished ignition-kargs.service. Jul 14 21:49:02.820303 ignition[746]: Ignition finished successfully Jul 14 21:49:02.825332 systemd[1]: Starting ignition-disks.service... Jul 14 21:49:02.832293 ignition[755]: Ignition 2.14.0 Jul 14 21:49:02.831277 systemd[1]: Finished dracut-initqueue.service. Jul 14 21:49:02.832299 ignition[755]: Stage: disks Jul 14 21:49:02.850000 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:49:02.832843 systemd[1]: Reached target remote-fs-pre.target. Jul 14 21:49:02.832403 ignition[755]: no configs at "/usr/lib/ignition/base.d" Jul 14 21:49:02.834555 systemd[1]: Reached target remote-cryptsetup.target. Jul 14 21:49:02.832412 ignition[755]: no config dir at "/usr/lib/ignition/base.platform.d/qemu" Jul 14 21:49:02.836104 systemd[1]: Reached target remote-fs.target. Jul 14 21:49:02.833059 ignition[755]: disks: disks passed Jul 14 21:49:02.838574 systemd[1]: Starting dracut-pre-mount.service... Jul 14 21:49:02.833103 ignition[755]: Ignition finished successfully Jul 14 21:49:02.840594 systemd[1]: Finished ignition-disks.service. Jul 14 21:49:02.842009 systemd[1]: Reached target initrd-root-device.target. Jul 14 21:49:02.843393 systemd[1]: Reached target local-fs-pre.target. Jul 14 21:49:02.844917 systemd[1]: Reached target local-fs.target. Jul 14 21:49:02.846536 systemd[1]: Reached target sysinit.target. Jul 14 21:49:02.848092 systemd[1]: Reached target basic.target. Jul 14 21:49:02.865034 systemd-fsck[773]: ROOT: clean, 619/553520 files, 56022/553472 blocks Jul 14 21:49:02.849752 systemd[1]: Finished dracut-pre-mount.service. Jul 14 21:49:02.851757 systemd[1]: Starting systemd-fsck-root.service... Jul 14 21:49:02.868578 systemd[1]: Finished systemd-fsck-root.service. Jul 14 21:49:02.869000 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:49:02.870751 systemd[1]: Mounting sysroot.mount... Jul 14 21:49:02.878044 kernel: EXT4-fs (vda9): mounted filesystem with ordered data mode. Opts: (null). Quota mode: none. Jul 14 21:49:02.878281 systemd[1]: Mounted sysroot.mount. Jul 14 21:49:02.879114 systemd[1]: Reached target initrd-root-fs.target. Jul 14 21:49:02.881456 systemd[1]: Mounting sysroot-usr.mount... Jul 14 21:49:02.882447 systemd[1]: flatcar-metadata-hostname.service was skipped because no trigger condition checks were met. Jul 14 21:49:02.882500 systemd[1]: ignition-remount-sysroot.service was skipped because of an unmet condition check (ConditionPathIsReadWrite=!/sysroot). Jul 14 21:49:02.882524 systemd[1]: Reached target ignition-diskful.target. Jul 14 21:49:02.884686 systemd[1]: Mounted sysroot-usr.mount. Jul 14 21:49:02.886814 systemd[1]: Starting initrd-setup-root.service... Jul 14 21:49:02.891470 initrd-setup-root[783]: cut: /sysroot/etc/passwd: No such file or directory Jul 14 21:49:02.895405 initrd-setup-root[791]: cut: /sysroot/etc/group: No such file or directory Jul 14 21:49:02.899944 initrd-setup-root[799]: cut: /sysroot/etc/shadow: No such file or directory Jul 14 21:49:02.903173 initrd-setup-root[807]: cut: /sysroot/etc/gshadow: No such file or directory Jul 14 21:49:02.933134 systemd[1]: Finished initrd-setup-root.service. Jul 14 21:49:02.934000 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:49:02.934871 systemd[1]: Starting ignition-mount.service... Jul 14 21:49:02.936374 systemd[1]: Starting sysroot-boot.service... Jul 14 21:49:02.941133 bash[824]: umount: /sysroot/usr/share/oem: not mounted. Jul 14 21:49:02.951178 ignition[826]: INFO : Ignition 2.14.0 Jul 14 21:49:02.951178 ignition[826]: INFO : Stage: mount Jul 14 21:49:02.952841 ignition[826]: INFO : no configs at "/usr/lib/ignition/base.d" Jul 14 21:49:02.952841 ignition[826]: INFO : no config dir at "/usr/lib/ignition/base.platform.d/qemu" Jul 14 21:49:02.952841 ignition[826]: INFO : mount: mount passed Jul 14 21:49:02.952841 ignition[826]: INFO : Ignition finished successfully Jul 14 21:49:02.953000 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:49:02.952773 systemd[1]: Finished ignition-mount.service. Jul 14 21:49:02.959470 systemd[1]: Finished sysroot-boot.service. Jul 14 21:49:02.960000 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:49:03.611400 systemd[1]: Mounting sysroot-usr-share-oem.mount... Jul 14 21:49:03.618819 kernel: BTRFS: device label OEM devid 1 transid 11 /dev/vda6 scanned by mount (835) Jul 14 21:49:03.618853 kernel: BTRFS info (device vda6): using crc32c (crc32c-generic) checksum algorithm Jul 14 21:49:03.618863 kernel: BTRFS info (device vda6): using free space tree Jul 14 21:49:03.620233 kernel: BTRFS info (device vda6): has skinny extents Jul 14 21:49:03.623220 systemd[1]: Mounted sysroot-usr-share-oem.mount. Jul 14 21:49:03.625094 systemd[1]: Starting ignition-files.service... Jul 14 21:49:03.640696 ignition[855]: INFO : Ignition 2.14.0 Jul 14 21:49:03.640696 ignition[855]: INFO : Stage: files Jul 14 21:49:03.642474 ignition[855]: INFO : no configs at "/usr/lib/ignition/base.d" Jul 14 21:49:03.642474 ignition[855]: INFO : no config dir at "/usr/lib/ignition/base.platform.d/qemu" Jul 14 21:49:03.642474 ignition[855]: DEBUG : files: compiled without relabeling support, skipping Jul 14 21:49:03.645913 ignition[855]: INFO : files: ensureUsers: op(1): [started] creating or modifying user "core" Jul 14 21:49:03.645913 ignition[855]: DEBUG : files: ensureUsers: op(1): executing: "usermod" "--root" "/sysroot" "core" Jul 14 21:49:03.649680 ignition[855]: INFO : files: ensureUsers: op(1): [finished] creating or modifying user "core" Jul 14 21:49:03.651112 ignition[855]: INFO : files: ensureUsers: op(2): [started] adding ssh keys to user "core" Jul 14 21:49:03.651112 ignition[855]: INFO : files: ensureUsers: op(2): [finished] adding ssh keys to user "core" Jul 14 21:49:03.651112 ignition[855]: INFO : files: createFilesystemsFiles: createFiles: op(3): [started] writing file "/sysroot/etc/flatcar/update.conf" Jul 14 21:49:03.650418 unknown[855]: wrote ssh authorized keys file for user: core Jul 14 21:49:03.657559 ignition[855]: INFO : files: createFilesystemsFiles: createFiles: op(3): [finished] writing file "/sysroot/etc/flatcar/update.conf" Jul 14 21:49:03.657559 ignition[855]: INFO : files: op(4): [started] processing unit "etcd-member.service" Jul 14 21:49:03.657559 ignition[855]: 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:49:03.657559 ignition[855]: 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:49:03.657559 ignition[855]: INFO : files: op(4): [finished] processing unit "etcd-member.service" Jul 14 21:49:03.657559 ignition[855]: INFO : files: op(6): [started] processing unit "coreos-metadata.service" Jul 14 21:49:03.657559 ignition[855]: INFO : files: op(6): op(7): [started] writing unit "coreos-metadata.service" at "/sysroot/etc/systemd/system/coreos-metadata.service" Jul 14 21:49:03.657559 ignition[855]: INFO : files: op(6): op(7): [finished] writing unit "coreos-metadata.service" at "/sysroot/etc/systemd/system/coreos-metadata.service" Jul 14 21:49:03.657559 ignition[855]: INFO : files: op(6): [finished] processing unit "coreos-metadata.service" Jul 14 21:49:03.657559 ignition[855]: INFO : files: op(8): [started] setting preset to disabled for "coreos-metadata.service" Jul 14 21:49:03.657559 ignition[855]: INFO : files: op(8): op(9): [started] removing enablement symlink(s) for "coreos-metadata.service" Jul 14 21:49:03.678978 ignition[855]: INFO : files: op(8): op(9): [finished] removing enablement symlink(s) for "coreos-metadata.service" Jul 14 21:49:03.680995 ignition[855]: INFO : files: op(8): [finished] setting preset to disabled for "coreos-metadata.service" Jul 14 21:49:03.680995 ignition[855]: INFO : files: op(a): [started] setting preset to enabled for "etcd-member.service" Jul 14 21:49:03.680995 ignition[855]: INFO : files: op(a): [finished] setting preset to enabled for "etcd-member.service" Jul 14 21:49:03.680995 ignition[855]: INFO : files: createResultFile: createFiles: op(b): [started] writing file "/sysroot/etc/.ignition-result.json" Jul 14 21:49:03.680995 ignition[855]: INFO : files: createResultFile: createFiles: op(b): [finished] writing file "/sysroot/etc/.ignition-result.json" Jul 14 21:49:03.680995 ignition[855]: INFO : files: files passed Jul 14 21:49:03.680995 ignition[855]: INFO : Ignition finished successfully Jul 14 21:49:03.682000 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:49:03.691000 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:49:03.691000 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:49:03.681204 systemd[1]: Finished ignition-files.service. Jul 14 21:49:03.683983 systemd[1]: Starting initrd-setup-root-after-ignition.service... Jul 14 21:49:03.685115 systemd[1]: torcx-profile-populate.service was skipped because of an unmet condition check (ConditionPathExists=/sysroot/etc/torcx/next-profile). Jul 14 21:49:03.695000 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:49:03.697376 initrd-setup-root-after-ignition[879]: grep: /sysroot/usr/share/oem/oem-release: No such file or directory Jul 14 21:49:03.685912 systemd[1]: Starting ignition-quench.service... Jul 14 21:49:03.701037 initrd-setup-root-after-ignition[881]: grep: /sysroot/etc/flatcar/enabled-sysext.conf: No such file or directory Jul 14 21:49:03.690251 systemd[1]: ignition-quench.service: Deactivated successfully. Jul 14 21:49:03.690347 systemd[1]: Finished ignition-quench.service. Jul 14 21:49:03.694405 systemd[1]: Finished initrd-setup-root-after-ignition.service. Jul 14 21:49:03.695610 systemd[1]: Reached target ignition-complete.target. Jul 14 21:49:03.698836 systemd[1]: Starting initrd-parse-etc.service... Jul 14 21:49:03.713269 systemd[1]: initrd-parse-etc.service: Deactivated successfully. Jul 14 21:49:03.713384 systemd[1]: Finished initrd-parse-etc.service. Jul 14 21:49:03.714000 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:49:03.714000 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:49:03.715299 systemd[1]: Reached target initrd-fs.target. Jul 14 21:49:03.716563 systemd[1]: Reached target initrd.target. Jul 14 21:49:03.717968 systemd[1]: dracut-mount.service was skipped because no trigger condition checks were met. Jul 14 21:49:03.718982 systemd[1]: Starting dracut-pre-pivot.service... Jul 14 21:49:03.730265 systemd[1]: Finished dracut-pre-pivot.service. Jul 14 21:49:03.731000 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:49:03.732143 systemd[1]: Starting initrd-cleanup.service... Jul 14 21:49:03.740992 systemd[1]: Stopped target nss-lookup.target. Jul 14 21:49:03.742745 systemd[1]: Stopped target remote-cryptsetup.target. Jul 14 21:49:03.743796 systemd[1]: Stopped target timers.target. Jul 14 21:49:03.745363 systemd[1]: dracut-pre-pivot.service: Deactivated successfully. Jul 14 21:49:03.746000 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:49:03.745490 systemd[1]: Stopped dracut-pre-pivot.service. Jul 14 21:49:03.746921 systemd[1]: Stopped target initrd.target. Jul 14 21:49:03.748550 systemd[1]: Stopped target basic.target. Jul 14 21:49:03.749979 systemd[1]: Stopped target ignition-complete.target. Jul 14 21:49:03.751543 systemd[1]: Stopped target ignition-diskful.target. Jul 14 21:49:03.753087 systemd[1]: Stopped target initrd-root-device.target. Jul 14 21:49:03.754747 systemd[1]: Stopped target remote-fs.target. Jul 14 21:49:03.756250 systemd[1]: Stopped target remote-fs-pre.target. Jul 14 21:49:03.757882 systemd[1]: Stopped target sysinit.target. Jul 14 21:49:03.759233 systemd[1]: Stopped target local-fs.target. Jul 14 21:49:03.760648 systemd[1]: Stopped target local-fs-pre.target. Jul 14 21:49:03.762066 systemd[1]: Stopped target swap.target. Jul 14 21:49:03.764000 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:49:03.763336 systemd[1]: dracut-pre-mount.service: Deactivated successfully. Jul 14 21:49:03.763457 systemd[1]: Stopped dracut-pre-mount.service. Jul 14 21:49:03.767000 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:49:03.764904 systemd[1]: Stopped target cryptsetup.target. Jul 14 21:49:03.769000 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:49:03.766259 systemd[1]: dracut-initqueue.service: Deactivated successfully. Jul 14 21:49:03.766376 systemd[1]: Stopped dracut-initqueue.service. Jul 14 21:49:03.767963 systemd[1]: ignition-fetch-offline.service: Deactivated successfully. Jul 14 21:49:03.768095 systemd[1]: Stopped ignition-fetch-offline.service. Jul 14 21:49:03.769541 systemd[1]: Stopped target paths.target. Jul 14 21:49:03.770887 systemd[1]: systemd-ask-password-console.path: Deactivated successfully. Jul 14 21:49:03.775054 systemd[1]: Stopped systemd-ask-password-console.path. Jul 14 21:49:03.776221 systemd[1]: Stopped target slices.target. Jul 14 21:49:03.777841 systemd[1]: Stopped target sockets.target. Jul 14 21:49:03.779316 systemd[1]: iscsid.socket: Deactivated successfully. Jul 14 21:49:03.779399 systemd[1]: Closed iscsid.socket. Jul 14 21:49:03.783000 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:49:03.780630 systemd[1]: iscsiuio.socket: Deactivated successfully. Jul 14 21:49:03.784000 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:49:03.780695 systemd[1]: Closed iscsiuio.socket. Jul 14 21:49:03.781957 systemd[1]: initrd-setup-root-after-ignition.service: Deactivated successfully. Jul 14 21:49:03.782097 systemd[1]: Stopped initrd-setup-root-after-ignition.service. Jul 14 21:49:03.788000 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:49:03.783655 systemd[1]: ignition-files.service: Deactivated successfully. Jul 14 21:49:03.793000 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:49:03.794000 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:49:03.795357 ignition[894]: INFO : Ignition 2.14.0 Jul 14 21:49:03.795357 ignition[894]: INFO : Stage: umount Jul 14 21:49:03.795357 ignition[894]: INFO : no configs at "/usr/lib/ignition/base.d" Jul 14 21:49:03.795357 ignition[894]: INFO : no config dir at "/usr/lib/ignition/base.platform.d/qemu" Jul 14 21:49:03.795357 ignition[894]: INFO : umount: umount passed Jul 14 21:49:03.795357 ignition[894]: INFO : Ignition finished successfully Jul 14 21:49:03.797000 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:49:03.802000 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:49:03.803000 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:49:03.783750 systemd[1]: Stopped ignition-files.service. Jul 14 21:49:03.805000 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:49:03.785821 systemd[1]: Stopping ignition-mount.service... Jul 14 21:49:03.786958 systemd[1]: kmod-static-nodes.service: Deactivated successfully. Jul 14 21:49:03.787119 systemd[1]: Stopped kmod-static-nodes.service. Jul 14 21:49:03.789847 systemd[1]: Stopping sysroot-boot.service... Jul 14 21:49:03.811000 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:49:03.811000 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:49:03.792103 systemd[1]: systemd-udev-trigger.service: Deactivated successfully. Jul 14 21:49:03.813000 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:49:03.792251 systemd[1]: Stopped systemd-udev-trigger.service. Jul 14 21:49:03.793312 systemd[1]: dracut-pre-trigger.service: Deactivated successfully. Jul 14 21:49:03.816000 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:49:03.793417 systemd[1]: Stopped dracut-pre-trigger.service. Jul 14 21:49:03.818000 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:49:03.796289 systemd[1]: ignition-mount.service: Deactivated successfully. Jul 14 21:49:03.796393 systemd[1]: Stopped ignition-mount.service. Jul 14 21:49:03.821000 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:49:03.798352 systemd[1]: Stopped target network.target. Jul 14 21:49:03.800013 systemd[1]: ignition-disks.service: Deactivated successfully. Jul 14 21:49:03.824000 audit: BPF prog-id=6 op=UNLOAD Jul 14 21:49:03.800104 systemd[1]: Stopped ignition-disks.service. Jul 14 21:49:03.825000 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:49:03.802201 systemd[1]: ignition-kargs.service: Deactivated successfully. Jul 14 21:49:03.826000 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:49:03.802249 systemd[1]: Stopped ignition-kargs.service. Jul 14 21:49:03.828000 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:49:03.803929 systemd[1]: ignition-setup.service: Deactivated successfully. Jul 14 21:49:03.803974 systemd[1]: Stopped ignition-setup.service. Jul 14 21:49:03.806182 systemd[1]: Stopping systemd-networkd.service... Jul 14 21:49:03.807418 systemd[1]: Stopping systemd-resolved.service... Jul 14 21:49:03.809626 systemd[1]: sysroot-boot.mount: Deactivated successfully. Jul 14 21:49:03.810251 systemd[1]: initrd-cleanup.service: Deactivated successfully. Jul 14 21:49:03.837000 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:49:03.810354 systemd[1]: Finished initrd-cleanup.service. Jul 14 21:49:03.811607 systemd[1]: sysroot-boot.service: Deactivated successfully. Jul 14 21:49:03.840000 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:49:03.811690 systemd[1]: Stopped sysroot-boot.service. Jul 14 21:49:03.812869 systemd-networkd[738]: eth0: DHCPv6 lease lost Jul 14 21:49:03.842000 audit: BPF prog-id=9 op=UNLOAD Jul 14 21:49:03.814796 systemd[1]: systemd-networkd.service: Deactivated successfully. Jul 14 21:49:03.845000 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:49:03.814878 systemd[1]: Stopped systemd-networkd.service. Jul 14 21:49:03.846000 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:49:03.816785 systemd[1]: systemd-resolved.service: Deactivated successfully. Jul 14 21:49:03.848000 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:49:03.816897 systemd[1]: Stopped systemd-resolved.service. Jul 14 21:49:03.818544 systemd[1]: systemd-networkd.socket: Deactivated successfully. Jul 14 21:49:03.851000 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:49:03.818573 systemd[1]: Closed systemd-networkd.socket. Jul 14 21:49:03.819797 systemd[1]: initrd-setup-root.service: Deactivated successfully. Jul 14 21:49:03.819842 systemd[1]: Stopped initrd-setup-root.service. Jul 14 21:49:03.822243 systemd[1]: Stopping network-cleanup.service... Jul 14 21:49:03.856000 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:49:03.856000 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:49:03.823679 systemd[1]: parse-ip-for-networkd.service: Deactivated successfully. Jul 14 21:49:03.823742 systemd[1]: Stopped parse-ip-for-networkd.service. Jul 14 21:49:03.825601 systemd[1]: systemd-sysctl.service: Deactivated successfully. Jul 14 21:49:03.825644 systemd[1]: Stopped systemd-sysctl.service. Jul 14 21:49:03.827927 systemd[1]: systemd-modules-load.service: Deactivated successfully. Jul 14 21:49:03.827990 systemd[1]: Stopped systemd-modules-load.service. Jul 14 21:49:03.829013 systemd[1]: Stopping systemd-udevd.service... Jul 14 21:49:03.833793 systemd[1]: run-credentials-systemd\x2dsysctl.service.mount: Deactivated successfully. Jul 14 21:49:03.836544 systemd[1]: network-cleanup.service: Deactivated successfully. Jul 14 21:49:03.836648 systemd[1]: Stopped network-cleanup.service. Jul 14 21:49:03.838993 systemd[1]: systemd-udevd.service: Deactivated successfully. Jul 14 21:49:03.839166 systemd[1]: Stopped systemd-udevd.service. Jul 14 21:49:03.840723 systemd[1]: systemd-udevd-control.socket: Deactivated successfully. Jul 14 21:49:03.840758 systemd[1]: Closed systemd-udevd-control.socket. Jul 14 21:49:03.842272 systemd[1]: systemd-udevd-kernel.socket: Deactivated successfully. Jul 14 21:49:03.842310 systemd[1]: Closed systemd-udevd-kernel.socket. Jul 14 21:49:03.843717 systemd[1]: dracut-pre-udev.service: Deactivated successfully. Jul 14 21:49:03.843769 systemd[1]: Stopped dracut-pre-udev.service. Jul 14 21:49:03.845206 systemd[1]: dracut-cmdline.service: Deactivated successfully. Jul 14 21:49:03.845249 systemd[1]: Stopped dracut-cmdline.service. Jul 14 21:49:03.846938 systemd[1]: dracut-cmdline-ask.service: Deactivated successfully. Jul 14 21:49:03.846988 systemd[1]: Stopped dracut-cmdline-ask.service. Jul 14 21:49:03.849470 systemd[1]: Starting initrd-udevadm-cleanup-db.service... Jul 14 21:49:03.850434 systemd[1]: systemd-vconsole-setup.service: Deactivated successfully. Jul 14 21:49:03.850498 systemd[1]: Stopped systemd-vconsole-setup.service. Jul 14 21:49:03.855474 systemd[1]: initrd-udevadm-cleanup-db.service: Deactivated successfully. Jul 14 21:49:03.855573 systemd[1]: Finished initrd-udevadm-cleanup-db.service. Jul 14 21:49:03.856660 systemd[1]: Reached target initrd-switch-root.target. Jul 14 21:49:03.888470 systemd-journald[290]: Received SIGTERM from PID 1 (n/a). Jul 14 21:49:03.888532 iscsid[745]: iscsid shutting down. Jul 14 21:49:03.858955 systemd[1]: Starting initrd-switch-root.service... Jul 14 21:49:03.866480 systemd[1]: Switching root. Jul 14 21:49:03.890733 systemd-journald[290]: Journal stopped Jul 14 21:49:05.900042 kernel: SELinux: Class mctp_socket not defined in policy. Jul 14 21:49:05.900102 kernel: SELinux: Class anon_inode not defined in policy. Jul 14 21:49:05.900115 kernel: SELinux: the above unknown classes and permissions will be allowed Jul 14 21:49:05.900128 kernel: SELinux: policy capability network_peer_controls=1 Jul 14 21:49:05.900145 kernel: SELinux: policy capability open_perms=1 Jul 14 21:49:05.900155 kernel: SELinux: policy capability extended_socket_class=1 Jul 14 21:49:05.900169 kernel: SELinux: policy capability always_check_network=0 Jul 14 21:49:05.900180 kernel: SELinux: policy capability cgroup_seclabel=1 Jul 14 21:49:05.900190 kernel: SELinux: policy capability nnp_nosuid_transition=1 Jul 14 21:49:05.900200 kernel: SELinux: policy capability genfs_seclabel_symlinks=0 Jul 14 21:49:05.900209 kernel: SELinux: policy capability ioctl_skip_cloexec=0 Jul 14 21:49:05.900222 systemd[1]: Successfully loaded SELinux policy in 35.602ms. Jul 14 21:49:05.900239 systemd[1]: Relabelled /dev, /dev/shm, /run, /sys/fs/cgroup in 7.521ms. Jul 14 21:49:05.900251 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:49:05.900263 systemd[1]: Detected virtualization kvm. Jul 14 21:49:05.900274 systemd[1]: Detected architecture arm64. Jul 14 21:49:05.900284 systemd[1]: Detected first boot. Jul 14 21:49:05.900295 systemd[1]: Initializing machine ID from VM UUID. Jul 14 21:49:05.900305 kernel: SELinux: Context system_u:object_r:container_file_t:s0:c1022,c1023 is not valid (left unmapped). Jul 14 21:49:05.900316 systemd[1]: Populated /etc with preset unit settings. Jul 14 21:49:05.900328 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:49:05.900339 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:49:05.900351 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:49:05.900362 kernel: kauditd_printk_skb: 77 callbacks suppressed Jul 14 21:49:05.900372 kernel: audit: type=1334 audit(1752529745.753:81): prog-id=12 op=LOAD Jul 14 21:49:05.900381 kernel: audit: type=1334 audit(1752529745.753:82): prog-id=3 op=UNLOAD Jul 14 21:49:05.900392 kernel: audit: type=1334 audit(1752529745.754:83): prog-id=13 op=LOAD Jul 14 21:49:05.900403 kernel: audit: type=1334 audit(1752529745.755:84): prog-id=14 op=LOAD Jul 14 21:49:05.900413 kernel: audit: type=1334 audit(1752529745.755:85): prog-id=4 op=UNLOAD Jul 14 21:49:05.900423 kernel: audit: type=1334 audit(1752529745.755:86): prog-id=5 op=UNLOAD Jul 14 21:49:05.900433 kernel: audit: type=1334 audit(1752529745.756:87): prog-id=15 op=LOAD Jul 14 21:49:05.900443 kernel: audit: type=1334 audit(1752529745.756:88): prog-id=12 op=UNLOAD Jul 14 21:49:05.900453 systemd[1]: iscsiuio.service: Deactivated successfully. Jul 14 21:49:05.900463 kernel: audit: type=1334 audit(1752529745.757:89): prog-id=16 op=LOAD Jul 14 21:49:05.900473 systemd[1]: Stopped iscsiuio.service. Jul 14 21:49:05.900483 kernel: audit: type=1334 audit(1752529745.758:90): prog-id=17 op=LOAD Jul 14 21:49:05.900495 systemd[1]: iscsid.service: Deactivated successfully. Jul 14 21:49:05.900506 systemd[1]: Stopped iscsid.service. Jul 14 21:49:05.900517 systemd[1]: initrd-switch-root.service: Deactivated successfully. Jul 14 21:49:05.900527 systemd[1]: Stopped initrd-switch-root.service. Jul 14 21:49:05.900538 systemd[1]: systemd-journald.service: Scheduled restart job, restart counter is at 1. Jul 14 21:49:05.900549 systemd[1]: Created slice system-addon\x2dconfig.slice. Jul 14 21:49:05.900561 systemd[1]: Created slice system-addon\x2drun.slice. Jul 14 21:49:05.900572 systemd[1]: Created slice system-getty.slice. Jul 14 21:49:05.900583 systemd[1]: Created slice system-modprobe.slice. Jul 14 21:49:05.900593 systemd[1]: Created slice system-serial\x2dgetty.slice. Jul 14 21:49:05.900605 systemd[1]: Created slice system-system\x2dcloudinit.slice. Jul 14 21:49:05.900616 systemd[1]: Created slice system-systemd\x2dfsck.slice. Jul 14 21:49:05.900626 systemd[1]: Created slice user.slice. Jul 14 21:49:05.900637 systemd[1]: Started systemd-ask-password-console.path. Jul 14 21:49:05.900647 systemd[1]: Started systemd-ask-password-wall.path. Jul 14 21:49:05.900659 systemd[1]: Set up automount boot.automount. Jul 14 21:49:05.900670 systemd[1]: Set up automount proc-sys-fs-binfmt_misc.automount. Jul 14 21:49:05.900681 systemd[1]: Stopped target initrd-switch-root.target. Jul 14 21:49:05.900691 systemd[1]: Stopped target initrd-fs.target. Jul 14 21:49:05.900702 systemd[1]: Stopped target initrd-root-fs.target. Jul 14 21:49:05.900712 systemd[1]: Reached target integritysetup.target. Jul 14 21:49:05.900724 systemd[1]: Reached target remote-cryptsetup.target. Jul 14 21:49:05.900735 systemd[1]: Reached target remote-fs.target. Jul 14 21:49:05.900768 systemd[1]: Reached target slices.target. Jul 14 21:49:05.900779 systemd[1]: Reached target swap.target. Jul 14 21:49:05.900791 systemd[1]: Reached target torcx.target. Jul 14 21:49:05.900801 systemd[1]: Reached target veritysetup.target. Jul 14 21:49:05.900813 systemd[1]: Listening on systemd-coredump.socket. Jul 14 21:49:05.900831 systemd[1]: Listening on systemd-initctl.socket. Jul 14 21:49:05.900844 systemd[1]: Listening on systemd-networkd.socket. Jul 14 21:49:05.900856 systemd[1]: Listening on systemd-udevd-control.socket. Jul 14 21:49:05.900867 systemd[1]: Listening on systemd-udevd-kernel.socket. Jul 14 21:49:05.900878 systemd[1]: Listening on systemd-userdbd.socket. Jul 14 21:49:05.900889 systemd[1]: Mounting dev-hugepages.mount... Jul 14 21:49:05.900899 systemd[1]: Mounting dev-mqueue.mount... Jul 14 21:49:05.900910 systemd[1]: Mounting media.mount... Jul 14 21:49:05.900921 systemd[1]: Mounting sys-kernel-debug.mount... Jul 14 21:49:05.900931 systemd[1]: Mounting sys-kernel-tracing.mount... Jul 14 21:49:05.900941 systemd[1]: Mounting tmp.mount... Jul 14 21:49:05.900952 systemd[1]: Starting flatcar-tmpfiles.service... Jul 14 21:49:05.900964 systemd[1]: ignition-delete-config.service was skipped because no trigger condition checks were met. Jul 14 21:49:05.900975 systemd[1]: Starting kmod-static-nodes.service... Jul 14 21:49:05.900985 systemd[1]: Starting modprobe@configfs.service... Jul 14 21:49:05.901003 systemd[1]: Starting modprobe@dm_mod.service... Jul 14 21:49:05.901025 systemd[1]: Starting modprobe@drm.service... Jul 14 21:49:05.901036 systemd[1]: Starting modprobe@efi_pstore.service... Jul 14 21:49:05.901046 systemd[1]: Starting modprobe@fuse.service... Jul 14 21:49:05.901057 systemd[1]: Starting modprobe@loop.service... Jul 14 21:49:05.901069 systemd[1]: setup-nsswitch.service was skipped because of an unmet condition check (ConditionPathExists=!/etc/nsswitch.conf). Jul 14 21:49:05.901081 systemd[1]: systemd-fsck-root.service: Deactivated successfully. Jul 14 21:49:05.901092 systemd[1]: Stopped systemd-fsck-root.service. Jul 14 21:49:05.901103 systemd[1]: systemd-fsck-usr.service: Deactivated successfully. Jul 14 21:49:05.901114 systemd[1]: Stopped systemd-fsck-usr.service. Jul 14 21:49:05.901125 systemd[1]: Stopped systemd-journald.service. Jul 14 21:49:05.901135 kernel: fuse: init (API version 7.34) Jul 14 21:49:05.901145 systemd[1]: Starting systemd-journald.service... Jul 14 21:49:05.901156 kernel: loop: module loaded Jul 14 21:49:05.901165 systemd[1]: Starting systemd-modules-load.service... Jul 14 21:49:05.901177 systemd[1]: Starting systemd-network-generator.service... Jul 14 21:49:05.901188 systemd[1]: Starting systemd-remount-fs.service... Jul 14 21:49:05.901199 systemd[1]: Starting systemd-udev-trigger.service... Jul 14 21:49:05.901209 systemd[1]: verity-setup.service: Deactivated successfully. Jul 14 21:49:05.901221 systemd[1]: Stopped verity-setup.service. Jul 14 21:49:05.901234 systemd-journald[997]: Journal started Jul 14 21:49:05.901276 systemd-journald[997]: Runtime Journal (/run/log/journal/fac0a200b6c3499d8fe3ad8058bf8bda) is 6.0M, max 48.7M, 42.6M free. Jul 14 21:49:03.949000 audit: MAC_POLICY_LOAD auid=4294967295 ses=4294967295 lsm=selinux res=1 Jul 14 21:49:04.002000 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:49:04.002000 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:49:04.006000 audit: BPF prog-id=10 op=LOAD Jul 14 21:49:04.006000 audit: BPF prog-id=10 op=UNLOAD Jul 14 21:49:04.006000 audit: BPF prog-id=11 op=LOAD Jul 14 21:49:04.006000 audit: BPF prog-id=11 op=UNLOAD Jul 14 21:49:04.051000 audit[927]: AVC avc: denied { associate } for pid=927 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:49:04.051000 audit[927]: SYSCALL arch=c00000b7 syscall=5 success=yes exit=0 a0=40001c58b4 a1=40000c8de0 a2=40000cf040 a3=32 items=0 ppid=910 pid=927 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:49:04.051000 audit: PROCTITLE proctitle=2F7573722F6C69622F73797374656D642F73797374656D2D67656E657261746F72732F746F7263782D67656E657261746F72002F72756E2F73797374656D642F67656E657261746F72002F72756E2F73797374656D642F67656E657261746F722E6561726C79002F72756E2F73797374656D642F67656E657261746F722E6C61 Jul 14 21:49:04.053000 audit[927]: AVC avc: denied { associate } for pid=927 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:49:04.053000 audit[927]: SYSCALL arch=c00000b7 syscall=34 success=yes exit=0 a0=ffffffffffffff9c a1=40001c5989 a2=1ed a3=0 items=2 ppid=910 pid=927 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:49:04.053000 audit: CWD cwd="/" Jul 14 21:49:04.053000 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:49:04.053000 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:49:04.053000 audit: PROCTITLE proctitle=2F7573722F6C69622F73797374656D642F73797374656D2D67656E657261746F72732F746F7263782D67656E657261746F72002F72756E2F73797374656D642F67656E657261746F72002F72756E2F73797374656D642F67656E657261746F722E6561726C79002F72756E2F73797374656D642F67656E657261746F722E6C61 Jul 14 21:49:05.753000 audit: BPF prog-id=12 op=LOAD Jul 14 21:49:05.753000 audit: BPF prog-id=3 op=UNLOAD Jul 14 21:49:05.754000 audit: BPF prog-id=13 op=LOAD Jul 14 21:49:05.755000 audit: BPF prog-id=14 op=LOAD Jul 14 21:49:05.755000 audit: BPF prog-id=4 op=UNLOAD Jul 14 21:49:05.755000 audit: BPF prog-id=5 op=UNLOAD Jul 14 21:49:05.756000 audit: BPF prog-id=15 op=LOAD Jul 14 21:49:05.756000 audit: BPF prog-id=12 op=UNLOAD Jul 14 21:49:05.757000 audit: BPF prog-id=16 op=LOAD Jul 14 21:49:05.758000 audit: BPF prog-id=17 op=LOAD Jul 14 21:49:05.758000 audit: BPF prog-id=13 op=UNLOAD Jul 14 21:49:05.758000 audit: BPF prog-id=14 op=UNLOAD Jul 14 21:49:05.759000 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:49:05.764000 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:49:05.767000 audit: BPF prog-id=15 op=UNLOAD Jul 14 21:49:05.767000 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:49:05.770000 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:49:05.770000 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:49:05.865000 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:49:05.868000 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:49:05.870000 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:49:05.870000 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:49:05.871000 audit: BPF prog-id=18 op=LOAD Jul 14 21:49:05.871000 audit: BPF prog-id=19 op=LOAD Jul 14 21:49:05.871000 audit: BPF prog-id=20 op=LOAD Jul 14 21:49:05.871000 audit: BPF prog-id=16 op=UNLOAD Jul 14 21:49:05.871000 audit: BPF prog-id=17 op=UNLOAD Jul 14 21:49:05.899000 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:49:05.899000 audit[997]: SYSCALL arch=c00000b7 syscall=211 success=yes exit=60 a0=3 a1=ffffdafa8740 a2=4000 a3=1 items=0 ppid=1 pid=997 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:49:05.899000 audit: PROCTITLE proctitle="/usr/lib/systemd/systemd-journald" Jul 14 21:49:04.049491 /usr/lib/systemd/system-generators/torcx-generator[927]: time="2025-07-14T21:49:04Z" 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:49:05.902000 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:49:05.752456 systemd[1]: Queued start job for default target multi-user.target. Jul 14 21:49:04.049793 /usr/lib/systemd/system-generators/torcx-generator[927]: time="2025-07-14T21:49:04Z" level=debug msg="profile found" name=docker-1.12-no path=/usr/share/torcx/profiles/docker-1.12-no.json Jul 14 21:49:05.752468 systemd[1]: Unnecessary job was removed for dev-vda6.device. Jul 14 21:49:04.049813 /usr/lib/systemd/system-generators/torcx-generator[927]: time="2025-07-14T21:49:04Z" level=debug msg="profile found" name=vendor path=/usr/share/torcx/profiles/vendor.json Jul 14 21:49:05.759483 systemd[1]: systemd-journald.service: Deactivated successfully. Jul 14 21:49:04.049853 /usr/lib/systemd/system-generators/torcx-generator[927]: time="2025-07-14T21:49:04Z" level=info msg="no vendor profile selected by /etc/flatcar/docker-1.12" Jul 14 21:49:04.049864 /usr/lib/systemd/system-generators/torcx-generator[927]: time="2025-07-14T21:49:04Z" level=debug msg="skipped missing lower profile" missing profile=oem Jul 14 21:49:04.049896 /usr/lib/systemd/system-generators/torcx-generator[927]: time="2025-07-14T21:49:04Z" level=warning msg="no next profile: unable to read profile file: open /etc/torcx/next-profile: no such file or directory" Jul 14 21:49:04.049908 /usr/lib/systemd/system-generators/torcx-generator[927]: time="2025-07-14T21:49:04Z" level=debug msg="apply configuration parsed" lower profiles (vendor/oem)="[vendor]" upper profile (user)= Jul 14 21:49:04.050166 /usr/lib/systemd/system-generators/torcx-generator[927]: time="2025-07-14T21:49:04Z" level=debug msg="mounted tmpfs" target=/run/torcx/unpack Jul 14 21:49:04.050207 /usr/lib/systemd/system-generators/torcx-generator[927]: time="2025-07-14T21:49:04Z" level=debug msg="profile found" name=docker-1.12-no path=/usr/share/torcx/profiles/docker-1.12-no.json Jul 14 21:49:04.050220 /usr/lib/systemd/system-generators/torcx-generator[927]: time="2025-07-14T21:49:04Z" level=debug msg="profile found" name=vendor path=/usr/share/torcx/profiles/vendor.json Jul 14 21:49:04.051138 /usr/lib/systemd/system-generators/torcx-generator[927]: time="2025-07-14T21:49:04Z" 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:49:04.051180 /usr/lib/systemd/system-generators/torcx-generator[927]: time="2025-07-14T21:49:04Z" 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:49:04.051201 /usr/lib/systemd/system-generators/torcx-generator[927]: time="2025-07-14T21:49:04Z" 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:49:04.051216 /usr/lib/systemd/system-generators/torcx-generator[927]: time="2025-07-14T21:49:04Z" 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:49:04.051251 /usr/lib/systemd/system-generators/torcx-generator[927]: time="2025-07-14T21:49:04Z" 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:49:04.051265 /usr/lib/systemd/system-generators/torcx-generator[927]: time="2025-07-14T21:49:04Z" level=info msg="store skipped" err="open /var/lib/torcx/store: no such file or directory" path=/var/lib/torcx/store Jul 14 21:49:05.499649 /usr/lib/systemd/system-generators/torcx-generator[927]: time="2025-07-14T21:49:05Z" level=debug msg="image unpacked" image=docker path=/run/torcx/unpack/docker reference=com.coreos.cl Jul 14 21:49:05.499965 /usr/lib/systemd/system-generators/torcx-generator[927]: time="2025-07-14T21:49:05Z" 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:49:05.500132 /usr/lib/systemd/system-generators/torcx-generator[927]: time="2025-07-14T21:49:05Z" 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:49:05.500307 /usr/lib/systemd/system-generators/torcx-generator[927]: time="2025-07-14T21:49:05Z" 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:49:05.500365 /usr/lib/systemd/system-generators/torcx-generator[927]: time="2025-07-14T21:49:05Z" level=debug msg="profile applied" sealed profile=/run/torcx/profile.json upper profile= Jul 14 21:49:05.500438 /usr/lib/systemd/system-generators/torcx-generator[927]: time="2025-07-14T21:49:05Z" 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:49:05.906096 systemd[1]: Started systemd-journald.service. Jul 14 21:49:05.906000 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:49:05.906548 systemd[1]: Mounted dev-hugepages.mount. Jul 14 21:49:05.907481 systemd[1]: Mounted dev-mqueue.mount. Jul 14 21:49:05.908341 systemd[1]: Mounted media.mount. Jul 14 21:49:05.909218 systemd[1]: Mounted sys-kernel-debug.mount. Jul 14 21:49:05.910226 systemd[1]: Mounted sys-kernel-tracing.mount. Jul 14 21:49:05.911224 systemd[1]: Mounted tmp.mount. Jul 14 21:49:05.912231 systemd[1]: Finished flatcar-tmpfiles.service. Jul 14 21:49:05.913000 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:49:05.913474 systemd[1]: Finished kmod-static-nodes.service. Jul 14 21:49:05.914000 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:49:05.914646 systemd[1]: modprobe@configfs.service: Deactivated successfully. Jul 14 21:49:05.914819 systemd[1]: Finished modprobe@configfs.service. Jul 14 21:49:05.915000 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:49:05.915000 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:49:05.916060 systemd[1]: modprobe@dm_mod.service: Deactivated successfully. Jul 14 21:49:05.916235 systemd[1]: Finished modprobe@dm_mod.service. Jul 14 21:49:05.917000 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:49:05.917000 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:49:05.917477 systemd[1]: modprobe@drm.service: Deactivated successfully. Jul 14 21:49:05.917645 systemd[1]: Finished modprobe@drm.service. Jul 14 21:49:05.918000 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:49:05.918000 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:49:05.918822 systemd[1]: modprobe@efi_pstore.service: Deactivated successfully. Jul 14 21:49:05.918981 systemd[1]: Finished modprobe@efi_pstore.service. Jul 14 21:49:05.919000 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:49:05.919000 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:49:05.920262 systemd[1]: modprobe@fuse.service: Deactivated successfully. Jul 14 21:49:05.920416 systemd[1]: Finished modprobe@fuse.service. Jul 14 21:49:05.921000 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:49:05.921000 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:49:05.921553 systemd[1]: modprobe@loop.service: Deactivated successfully. Jul 14 21:49:05.921700 systemd[1]: Finished modprobe@loop.service. Jul 14 21:49:05.922000 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:49:05.922000 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:49:05.922864 systemd[1]: Finished systemd-modules-load.service. Jul 14 21:49:05.923000 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:49:05.924231 systemd[1]: Finished systemd-network-generator.service. Jul 14 21:49:05.925000 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:49:05.925463 systemd[1]: Finished systemd-remount-fs.service. Jul 14 21:49:05.926000 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:49:05.927006 systemd[1]: Reached target network-pre.target. Jul 14 21:49:05.929208 systemd[1]: Mounting sys-fs-fuse-connections.mount... Jul 14 21:49:05.931608 systemd[1]: Mounting sys-kernel-config.mount... Jul 14 21:49:05.932592 systemd[1]: remount-root.service was skipped because of an unmet condition check (ConditionPathIsReadWrite=!/). Jul 14 21:49:05.934565 systemd[1]: Starting systemd-hwdb-update.service... Jul 14 21:49:05.936700 systemd[1]: Starting systemd-journal-flush.service... Jul 14 21:49:05.937699 systemd[1]: systemd-pstore.service was skipped because of an unmet condition check (ConditionDirectoryNotEmpty=/sys/fs/pstore). Jul 14 21:49:05.938921 systemd[1]: Starting systemd-random-seed.service... Jul 14 21:49:05.939956 systemd[1]: systemd-repart.service was skipped because no trigger condition checks were met. Jul 14 21:49:05.941112 systemd[1]: Starting systemd-sysctl.service... Jul 14 21:49:05.944033 systemd[1]: Starting systemd-sysusers.service... Jul 14 21:49:05.952776 systemd-journald[997]: Time spent on flushing to /var/log/journal/fac0a200b6c3499d8fe3ad8058bf8bda is 19.080ms for 962 entries. Jul 14 21:49:05.952776 systemd-journald[997]: System Journal (/var/log/journal/fac0a200b6c3499d8fe3ad8058bf8bda) is 8.0M, max 195.6M, 187.6M free. Jul 14 21:49:05.987646 systemd-journald[997]: Received client request to flush runtime journal. Jul 14 21:49:05.955000 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:49:05.956000 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:49:05.973000 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:49:05.974000 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:49:05.948368 systemd[1]: Mounted sys-fs-fuse-connections.mount. Jul 14 21:49:05.949808 systemd[1]: Mounted sys-kernel-config.mount. Jul 14 21:49:05.988234 udevadm[1027]: systemd-udev-settle.service is deprecated. Please fix lvm2-activation.service, lvm2-activation-early.service not to pull it in. Jul 14 21:49:05.954352 systemd[1]: Finished systemd-udev-trigger.service. Jul 14 21:49:05.955734 systemd[1]: Finished systemd-random-seed.service. Jul 14 21:49:05.957182 systemd[1]: Reached target first-boot-complete.target. Jul 14 21:49:05.959670 systemd[1]: Starting systemd-udev-settle.service... Jul 14 21:49:05.969281 systemd[1]: Finished systemd-sysusers.service. Jul 14 21:49:05.974182 systemd[1]: Finished systemd-sysctl.service. Jul 14 21:49:05.988609 systemd[1]: Finished systemd-journal-flush.service. Jul 14 21:49:05.989000 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:49:06.355000 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:49:06.356000 audit: BPF prog-id=21 op=LOAD Jul 14 21:49:06.356000 audit: BPF prog-id=22 op=LOAD Jul 14 21:49:06.356000 audit: BPF prog-id=7 op=UNLOAD Jul 14 21:49:06.356000 audit: BPF prog-id=8 op=UNLOAD Jul 14 21:49:06.354933 systemd[1]: Finished systemd-hwdb-update.service. Jul 14 21:49:06.357497 systemd[1]: Starting systemd-udevd.service... Jul 14 21:49:06.383169 systemd-udevd[1031]: Using default interface naming scheme 'v252'. Jul 14 21:49:06.397332 systemd[1]: Started systemd-udevd.service. Jul 14 21:49:06.398000 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:49:06.401000 audit: BPF prog-id=23 op=LOAD Jul 14 21:49:06.403129 systemd[1]: Starting systemd-networkd.service... Jul 14 21:49:06.409000 audit: BPF prog-id=24 op=LOAD Jul 14 21:49:06.409000 audit: BPF prog-id=25 op=LOAD Jul 14 21:49:06.409000 audit: BPF prog-id=26 op=LOAD Jul 14 21:49:06.410671 systemd[1]: Starting systemd-userdbd.service... Jul 14 21:49:06.422495 systemd[1]: Condition check resulted in dev-ttyAMA0.device being skipped. Jul 14 21:49:06.455000 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:49:06.454528 systemd[1]: Started systemd-userdbd.service. Jul 14 21:49:06.495684 systemd[1]: Found device dev-disk-by\x2dlabel-OEM.device. Jul 14 21:49:06.510179 systemd-networkd[1044]: lo: Link UP Jul 14 21:49:06.510190 systemd-networkd[1044]: lo: Gained carrier Jul 14 21:49:06.510565 systemd-networkd[1044]: Enumeration completed Jul 14 21:49:06.510683 systemd[1]: Started systemd-networkd.service. Jul 14 21:49:06.510683 systemd-networkd[1044]: eth0: Configuring with /usr/lib/systemd/network/zz-default.network. Jul 14 21:49:06.510000 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:49:06.513164 systemd[1]: Starting systemd-networkd-wait-online.service... Jul 14 21:49:06.515837 systemd-networkd[1044]: eth0: Link UP Jul 14 21:49:06.515849 systemd-networkd[1044]: eth0: Gained carrier Jul 14 21:49:06.518483 systemd[1]: Finished systemd-udev-settle.service. Jul 14 21:49:06.519000 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:49:06.520749 systemd[1]: Starting lvm2-activation-early.service... Jul 14 21:49:06.537938 lvm[1065]: WARNING: Failed to connect to lvmetad. Falling back to device scanning. Jul 14 21:49:06.539184 systemd-networkd[1044]: eth0: DHCPv4 address 10.0.0.38/16, gateway 10.0.0.1 acquired from 10.0.0.1 Jul 14 21:49:06.562917 systemd[1]: Finished lvm2-activation-early.service. Jul 14 21:49:06.563000 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:49:06.564056 systemd[1]: Reached target cryptsetup.target. Jul 14 21:49:06.566142 systemd[1]: Starting lvm2-activation.service... Jul 14 21:49:06.570185 lvm[1066]: WARNING: Failed to connect to lvmetad. Falling back to device scanning. Jul 14 21:49:06.592918 systemd[1]: Finished lvm2-activation.service. Jul 14 21:49:06.593000 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:49:06.593958 systemd[1]: Reached target local-fs-pre.target. Jul 14 21:49:06.594858 systemd[1]: var-lib-machines.mount was skipped because of an unmet condition check (ConditionPathExists=/var/lib/machines.raw). Jul 14 21:49:06.594895 systemd[1]: Reached target local-fs.target. Jul 14 21:49:06.595735 systemd[1]: Reached target machines.target. Jul 14 21:49:06.597864 systemd[1]: Starting ldconfig.service... Jul 14 21:49:06.599072 systemd[1]: systemd-binfmt.service was skipped because no trigger condition checks were met. Jul 14 21:49:06.599133 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:49:06.600390 systemd[1]: Starting systemd-boot-update.service... Jul 14 21:49:06.602385 systemd[1]: Starting systemd-fsck@dev-disk-by\x2dlabel-OEM.service... Jul 14 21:49:06.604906 systemd[1]: Starting systemd-machine-id-commit.service... Jul 14 21:49:06.606080 systemd[1]: systemd-sysext.service was skipped because no trigger condition checks were met. Jul 14 21:49:06.606119 systemd[1]: ensure-sysext.service was skipped because no trigger condition checks were met. Jul 14 21:49:06.607239 systemd[1]: Starting systemd-tmpfiles-setup.service... Jul 14 21:49:06.610742 systemd[1]: boot.automount: Got automount request for /boot, triggered by 1068 (bootctl) Jul 14 21:49:06.611917 systemd[1]: Starting systemd-fsck@dev-disk-by\x2dlabel-EFI\x2dSYSTEM.service... Jul 14 21:49:06.623298 systemd[1]: Finished systemd-fsck@dev-disk-by\x2dlabel-OEM.service. Jul 14 21:49:06.624000 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:49:06.637328 systemd-tmpfiles[1071]: /usr/lib/tmpfiles.d/legacy.conf:13: Duplicate line for path "/run/lock", ignoring. Jul 14 21:49:06.639618 systemd[1]: etc-machine\x2did.mount: Deactivated successfully. Jul 14 21:49:06.640288 systemd[1]: Finished systemd-machine-id-commit.service. Jul 14 21:49:06.641000 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:49:06.645218 systemd-tmpfiles[1071]: /usr/lib/tmpfiles.d/provision.conf:20: Duplicate line for path "/root", ignoring. Jul 14 21:49:06.649889 systemd-tmpfiles[1071]: /usr/lib/tmpfiles.d/systemd.conf:29: Duplicate line for path "/var/lib/systemd", ignoring. Jul 14 21:49:06.663720 systemd-fsck[1076]: fsck.fat 4.2 (2021-01-31) Jul 14 21:49:06.663720 systemd-fsck[1076]: /dev/vda1: 236 files, 117310/258078 clusters Jul 14 21:49:06.666409 systemd[1]: Finished systemd-fsck@dev-disk-by\x2dlabel-EFI\x2dSYSTEM.service. Jul 14 21:49:06.667000 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:49:06.670435 systemd[1]: Mounting boot.mount... Jul 14 21:49:06.679484 systemd[1]: Mounted boot.mount. Jul 14 21:49:06.696111 systemd[1]: Finished systemd-boot-update.service. Jul 14 21:49:06.697000 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:49:06.746517 systemd[1]: Finished systemd-tmpfiles-setup.service. Jul 14 21:49:06.747000 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:49:06.749074 systemd[1]: Starting audit-rules.service... Jul 14 21:49:06.750013 ldconfig[1067]: /sbin/ldconfig: /lib/ld.so.conf is not an ELF file - it has the wrong magic bytes at the start. Jul 14 21:49:06.751264 systemd[1]: Starting clean-ca-certificates.service... Jul 14 21:49:06.753502 systemd[1]: Starting systemd-journal-catalog-update.service... Jul 14 21:49:06.755000 audit: BPF prog-id=27 op=LOAD Jul 14 21:49:06.756803 systemd[1]: Starting systemd-resolved.service... Jul 14 21:49:06.759000 audit: BPF prog-id=28 op=LOAD Jul 14 21:49:06.761189 systemd[1]: Starting systemd-timesyncd.service... Jul 14 21:49:06.763154 systemd[1]: Starting systemd-update-utmp.service... Jul 14 21:49:06.764536 systemd[1]: Finished clean-ca-certificates.service. Jul 14 21:49:06.765000 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:49:06.765816 systemd[1]: update-ca-certificates.service was skipped because of an unmet condition check (ConditionPathIsSymbolicLink=!/etc/ssl/certs/ca-certificates.crt). Jul 14 21:49:06.778000 audit[1090]: SYSTEM_BOOT pid=1090 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:49:06.778979 systemd[1]: Finished ldconfig.service. Jul 14 21:49:06.779000 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:49:06.783871 systemd[1]: Finished systemd-update-utmp.service. Jul 14 21:49:06.784000 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:49:06.787942 systemd[1]: Finished systemd-journal-catalog-update.service. Jul 14 21:49:06.789000 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:49:06.790607 systemd[1]: Starting systemd-update-done.service... Jul 14 21:49:06.798566 systemd[1]: Finished systemd-update-done.service. Jul 14 21:49:06.799000 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:49:06.810677 augenrules[1100]: No rules Jul 14 21:49:06.811853 systemd[1]: Finished audit-rules.service. Jul 14 21:49:06.810000 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:49:06.810000 audit[1100]: SYSCALL arch=c00000b7 syscall=206 success=yes exit=1056 a0=3 a1=ffffcd3fe9b0 a2=420 a3=0 items=0 ppid=1079 pid=1100 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:49:06.810000 audit: PROCTITLE proctitle=2F7362696E2F617564697463746C002D52002F6574632F61756469742F61756469742E72756C6573 Jul 14 21:49:06.819880 systemd[1]: Started systemd-timesyncd.service. Jul 14 21:49:06.820601 systemd-timesyncd[1089]: Contacted time server 10.0.0.1:123 (10.0.0.1). Jul 14 21:49:06.820662 systemd-timesyncd[1089]: Initial clock synchronization to Mon 2025-07-14 21:49:06.910043 UTC. Jul 14 21:49:06.821129 systemd[1]: Reached target time-set.target. Jul 14 21:49:06.826868 systemd-resolved[1083]: Positive Trust Anchors: Jul 14 21:49:06.826884 systemd-resolved[1083]: . IN DS 20326 8 2 e06d44b80b8f1d39a95c0b0d7c65d08458e880409bbc683457104237c7f8ec8d Jul 14 21:49:06.826910 systemd-resolved[1083]: 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:49:06.839274 systemd-resolved[1083]: Defaulting to hostname 'linux'. Jul 14 21:49:06.840735 systemd[1]: Started systemd-resolved.service. Jul 14 21:49:06.841680 systemd[1]: Reached target network.target. Jul 14 21:49:06.842516 systemd[1]: Reached target nss-lookup.target. Jul 14 21:49:06.843393 systemd[1]: Reached target sysinit.target. Jul 14 21:49:06.844322 systemd[1]: Started motdgen.path. Jul 14 21:49:06.845103 systemd[1]: Started user-cloudinit@var-lib-flatcar\x2dinstall-user_data.path. Jul 14 21:49:06.846431 systemd[1]: Started logrotate.timer. Jul 14 21:49:06.847315 systemd[1]: Started mdadm.timer. Jul 14 21:49:06.848127 systemd[1]: Started systemd-tmpfiles-clean.timer. Jul 14 21:49:06.849000 systemd[1]: update-engine-stub.timer was skipped because of an unmet condition check (ConditionPathExists=/usr/.noupdate). Jul 14 21:49:06.849052 systemd[1]: Reached target paths.target. Jul 14 21:49:06.849790 systemd[1]: Reached target timers.target. Jul 14 21:49:06.850945 systemd[1]: Listening on dbus.socket. Jul 14 21:49:06.852923 systemd[1]: Starting docker.socket... Jul 14 21:49:06.856464 systemd[1]: Listening on sshd.socket. Jul 14 21:49:06.857465 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:49:06.858164 systemd[1]: Listening on docker.socket. Jul 14 21:49:06.859066 systemd[1]: Reached target sockets.target. Jul 14 21:49:06.859847 systemd[1]: Reached target basic.target. Jul 14 21:49:06.860688 systemd[1]: addon-config@usr-share-oem.service was skipped because no trigger condition checks were met. Jul 14 21:49:06.860722 systemd[1]: addon-run@usr-share-oem.service was skipped because no trigger condition checks were met. Jul 14 21:49:06.861901 systemd[1]: Starting containerd.service... Jul 14 21:49:06.863791 systemd[1]: Starting dbus.service... Jul 14 21:49:06.865594 systemd[1]: Starting enable-oem-cloudinit.service... Jul 14 21:49:06.867708 systemd[1]: Starting extend-filesystems.service... Jul 14 21:49:06.868620 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:49:06.870012 systemd[1]: Starting motdgen.service... Jul 14 21:49:06.875078 systemd[1]: Starting ssh-key-proc-cmdline.service... Jul 14 21:49:06.877397 systemd[1]: Starting sshd-keygen.service... Jul 14 21:49:06.879343 jq[1110]: false Jul 14 21:49:06.880450 systemd[1]: Starting systemd-logind.service... Jul 14 21:49:06.882032 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:49:06.882120 systemd[1]: tcsd.service was skipped because of an unmet condition check (ConditionPathExists=/dev/tpm0). Jul 14 21:49:06.882613 systemd[1]: cgroup compatibility translation between legacy and unified hierarchy settings activated. See cgroup-compat debug messages for details. Jul 14 21:49:06.887504 systemd[1]: Starting update-engine.service... Jul 14 21:49:06.889772 systemd[1]: Starting update-ssh-keys-after-ignition.service... Jul 14 21:49:06.892575 systemd[1]: enable-oem-cloudinit.service: Skipped due to 'exec-condition'. Jul 14 21:49:06.892811 jq[1127]: true Jul 14 21:49:06.892849 systemd[1]: Condition check resulted in enable-oem-cloudinit.service being skipped. Jul 14 21:49:06.893238 systemd[1]: ssh-key-proc-cmdline.service: Deactivated successfully. Jul 14 21:49:06.893402 systemd[1]: Finished ssh-key-proc-cmdline.service. Jul 14 21:49:06.893506 extend-filesystems[1111]: Found vda Jul 14 21:49:06.894969 extend-filesystems[1111]: Found vda1 Jul 14 21:49:06.894969 extend-filesystems[1111]: Found vda2 Jul 14 21:49:06.894969 extend-filesystems[1111]: Found vda3 Jul 14 21:49:06.894969 extend-filesystems[1111]: Found usr Jul 14 21:49:06.894969 extend-filesystems[1111]: Found vda4 Jul 14 21:49:06.894969 extend-filesystems[1111]: Found vda6 Jul 14 21:49:06.894969 extend-filesystems[1111]: Found vda7 Jul 14 21:49:06.894969 extend-filesystems[1111]: Found vda9 Jul 14 21:49:06.894969 extend-filesystems[1111]: Checking size of /dev/vda9 Jul 14 21:49:06.907052 dbus-daemon[1109]: [system] SELinux support is enabled Jul 14 21:49:06.896481 systemd[1]: motdgen.service: Deactivated successfully. Jul 14 21:49:06.921837 jq[1130]: true Jul 14 21:49:06.896654 systemd[1]: Finished motdgen.service. Jul 14 21:49:06.907398 systemd[1]: Started dbus.service. Jul 14 21:49:06.912428 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:49:06.912478 systemd[1]: Reached target system-config.target. Jul 14 21:49:06.913477 systemd[1]: user-cloudinit-proc-cmdline.service was skipped because of an unmet condition check (ConditionKernelCommandLine=cloud-config-url). Jul 14 21:49:06.913493 systemd[1]: Reached target user-config.target. Jul 14 21:49:06.926206 extend-filesystems[1111]: Old size kept for /dev/vda9 Jul 14 21:49:06.926726 systemd[1]: extend-filesystems.service: Deactivated successfully. Jul 14 21:49:06.926894 systemd[1]: Finished extend-filesystems.service. Jul 14 21:49:06.948835 systemd-logind[1119]: Watching system buttons on /dev/input/event0 (Power Button) Jul 14 21:49:06.949507 systemd-logind[1119]: New seat seat0. Jul 14 21:49:06.951158 systemd[1]: Started systemd-logind.service. Jul 14 21:49:06.974884 bash[1151]: Updated "/home/core/.ssh/authorized_keys" Jul 14 21:49:06.979856 systemd[1]: Finished update-ssh-keys-after-ignition.service. Jul 14 21:49:06.984233 update_engine[1125]: I0714 21:49:06.983925 1125 main.cc:92] Flatcar Update Engine starting Jul 14 21:49:06.989565 systemd[1]: Started update-engine.service. Jul 14 21:49:06.989775 update_engine[1125]: I0714 21:49:06.989750 1125 update_check_scheduler.cc:74] Next update check in 8m13s Jul 14 21:49:06.992504 systemd[1]: Started locksmithd.service. Jul 14 21:49:07.025471 env[1133]: time="2025-07-14T21:49:07.025418701Z" level=info msg="starting containerd" revision=92b3a9d6f1b3bcc6dc74875cfdea653fe39f09c2 version=1.6.16 Jul 14 21:49:07.039501 locksmithd[1157]: locksmithd starting currentOperation="UPDATE_STATUS_IDLE" strategy="reboot" Jul 14 21:49:07.044120 env[1133]: time="2025-07-14T21:49:07.044068013Z" level=info msg="loading plugin \"io.containerd.content.v1.content\"..." type=io.containerd.content.v1 Jul 14 21:49:07.044269 env[1133]: time="2025-07-14T21:49:07.044242585Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.aufs\"..." type=io.containerd.snapshotter.v1 Jul 14 21:49:07.045480 env[1133]: time="2025-07-14T21:49:07.045439593Z" 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:49:07.045480 env[1133]: time="2025-07-14T21:49:07.045474216Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.btrfs\"..." type=io.containerd.snapshotter.v1 Jul 14 21:49:07.045734 env[1133]: time="2025-07-14T21:49:07.045701693Z" 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:49:07.045734 env[1133]: time="2025-07-14T21:49:07.045725072Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.devmapper\"..." type=io.containerd.snapshotter.v1 Jul 14 21:49:07.045799 env[1133]: time="2025-07-14T21:49:07.045738986Z" level=warning msg="failed to load plugin io.containerd.snapshotter.v1.devmapper" error="devmapper not configured" Jul 14 21:49:07.045799 env[1133]: time="2025-07-14T21:49:07.045748896Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.native\"..." type=io.containerd.snapshotter.v1 Jul 14 21:49:07.045841 env[1133]: time="2025-07-14T21:49:07.045822713Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.overlayfs\"..." type=io.containerd.snapshotter.v1 Jul 14 21:49:07.046131 env[1133]: time="2025-07-14T21:49:07.046112237Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.zfs\"..." type=io.containerd.snapshotter.v1 Jul 14 21:49:07.046252 env[1133]: time="2025-07-14T21:49:07.046234834Z" 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:49:07.046281 env[1133]: time="2025-07-14T21:49:07.046253965Z" level=info msg="loading plugin \"io.containerd.metadata.v1.bolt\"..." type=io.containerd.metadata.v1 Jul 14 21:49:07.046324 env[1133]: time="2025-07-14T21:49:07.046306588Z" level=warning msg="could not use snapshotter devmapper in metadata plugin" error="devmapper not configured" Jul 14 21:49:07.046353 env[1133]: time="2025-07-14T21:49:07.046325355Z" level=info msg="metadata content store policy set" policy=shared Jul 14 21:49:07.050428 env[1133]: time="2025-07-14T21:49:07.050387390Z" level=info msg="loading plugin \"io.containerd.differ.v1.walking\"..." type=io.containerd.differ.v1 Jul 14 21:49:07.050502 env[1133]: time="2025-07-14T21:49:07.050465090Z" level=info msg="loading plugin \"io.containerd.event.v1.exchange\"..." type=io.containerd.event.v1 Jul 14 21:49:07.050502 env[1133]: time="2025-07-14T21:49:07.050481309Z" level=info msg="loading plugin \"io.containerd.gc.v1.scheduler\"..." type=io.containerd.gc.v1 Jul 14 21:49:07.050544 env[1133]: time="2025-07-14T21:49:07.050513708Z" level=info msg="loading plugin \"io.containerd.service.v1.introspection-service\"..." type=io.containerd.service.v1 Jul 14 21:49:07.050544 env[1133]: time="2025-07-14T21:49:07.050539109Z" level=info msg="loading plugin \"io.containerd.service.v1.containers-service\"..." type=io.containerd.service.v1 Jul 14 21:49:07.050600 env[1133]: time="2025-07-14T21:49:07.050560789Z" level=info msg="loading plugin \"io.containerd.service.v1.content-service\"..." type=io.containerd.service.v1 Jul 14 21:49:07.050600 env[1133]: time="2025-07-14T21:49:07.050576685Z" level=info msg="loading plugin \"io.containerd.service.v1.diff-service\"..." type=io.containerd.service.v1 Jul 14 21:49:07.051016 env[1133]: time="2025-07-14T21:49:07.050983143Z" level=info msg="loading plugin \"io.containerd.service.v1.images-service\"..." type=io.containerd.service.v1 Jul 14 21:49:07.051059 env[1133]: time="2025-07-14T21:49:07.051012630Z" level=info msg="loading plugin \"io.containerd.service.v1.leases-service\"..." type=io.containerd.service.v1 Jul 14 21:49:07.051059 env[1133]: time="2025-07-14T21:49:07.051042399Z" level=info msg="loading plugin \"io.containerd.service.v1.namespaces-service\"..." type=io.containerd.service.v1 Jul 14 21:49:07.051059 env[1133]: time="2025-07-14T21:49:07.051055342Z" level=info msg="loading plugin \"io.containerd.service.v1.snapshots-service\"..." type=io.containerd.service.v1 Jul 14 21:49:07.051119 env[1133]: time="2025-07-14T21:49:07.051071076Z" level=info msg="loading plugin \"io.containerd.runtime.v1.linux\"..." type=io.containerd.runtime.v1 Jul 14 21:49:07.051253 env[1133]: time="2025-07-14T21:49:07.051225344Z" level=info msg="loading plugin \"io.containerd.runtime.v2.task\"..." type=io.containerd.runtime.v2 Jul 14 21:49:07.051343 env[1133]: time="2025-07-14T21:49:07.051321407Z" level=info msg="loading plugin \"io.containerd.monitor.v1.cgroups\"..." type=io.containerd.monitor.v1 Jul 14 21:49:07.051701 env[1133]: time="2025-07-14T21:49:07.051660398Z" level=info msg="loading plugin \"io.containerd.service.v1.tasks-service\"..." type=io.containerd.service.v1 Jul 14 21:49:07.051731 env[1133]: time="2025-07-14T21:49:07.051709664Z" level=info msg="loading plugin \"io.containerd.grpc.v1.introspection\"..." type=io.containerd.grpc.v1 Jul 14 21:49:07.051731 env[1133]: time="2025-07-14T21:49:07.051725357Z" level=info msg="loading plugin \"io.containerd.internal.v1.restart\"..." type=io.containerd.internal.v1 Jul 14 21:49:07.051857 env[1133]: time="2025-07-14T21:49:07.051843950Z" level=info msg="loading plugin \"io.containerd.grpc.v1.containers\"..." type=io.containerd.grpc.v1 Jul 14 21:49:07.051881 env[1133]: time="2025-07-14T21:49:07.051860897Z" level=info msg="loading plugin \"io.containerd.grpc.v1.content\"..." type=io.containerd.grpc.v1 Jul 14 21:49:07.051881 env[1133]: time="2025-07-14T21:49:07.051875539Z" level=info msg="loading plugin \"io.containerd.grpc.v1.diff\"..." type=io.containerd.grpc.v1 Jul 14 21:49:07.053572 env[1133]: time="2025-07-14T21:49:07.051887835Z" level=info msg="loading plugin \"io.containerd.grpc.v1.events\"..." type=io.containerd.grpc.v1 Jul 14 21:49:07.053757 env[1133]: time="2025-07-14T21:49:07.053729012Z" level=info msg="loading plugin \"io.containerd.grpc.v1.healthcheck\"..." type=io.containerd.grpc.v1 Jul 14 21:49:07.053757 env[1133]: time="2025-07-14T21:49:07.053754372Z" level=info msg="loading plugin \"io.containerd.grpc.v1.images\"..." type=io.containerd.grpc.v1 Jul 14 21:49:07.053812 env[1133]: time="2025-07-14T21:49:07.053767599Z" level=info msg="loading plugin \"io.containerd.grpc.v1.leases\"..." type=io.containerd.grpc.v1 Jul 14 21:49:07.053812 env[1133]: time="2025-07-14T21:49:07.053779531Z" level=info msg="loading plugin \"io.containerd.grpc.v1.namespaces\"..." type=io.containerd.grpc.v1 Jul 14 21:49:07.053812 env[1133]: time="2025-07-14T21:49:07.053794011Z" level=info msg="loading plugin \"io.containerd.internal.v1.opt\"..." type=io.containerd.internal.v1 Jul 14 21:49:07.053988 env[1133]: time="2025-07-14T21:49:07.053955640Z" level=info msg="loading plugin \"io.containerd.grpc.v1.snapshots\"..." type=io.containerd.grpc.v1 Jul 14 21:49:07.053988 env[1133]: time="2025-07-14T21:49:07.053979504Z" level=info msg="loading plugin \"io.containerd.grpc.v1.tasks\"..." type=io.containerd.grpc.v1 Jul 14 21:49:07.054065 env[1133]: time="2025-07-14T21:49:07.053992730Z" level=info msg="loading plugin \"io.containerd.grpc.v1.version\"..." type=io.containerd.grpc.v1 Jul 14 21:49:07.054065 env[1133]: time="2025-07-14T21:49:07.054005997Z" level=info msg="loading plugin \"io.containerd.tracing.processor.v1.otlp\"..." type=io.containerd.tracing.processor.v1 Jul 14 21:49:07.054065 env[1133]: time="2025-07-14T21:49:07.054040661Z" 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:49:07.054065 env[1133]: time="2025-07-14T21:49:07.054057325Z" level=info msg="loading plugin \"io.containerd.internal.v1.tracing\"..." type=io.containerd.internal.v1 Jul 14 21:49:07.054143 env[1133]: time="2025-07-14T21:49:07.054075284Z" level=error msg="failed to initialize a tracing processor \"otlp\"" error="no OpenTelemetry endpoint: skip plugin" Jul 14 21:49:07.054143 env[1133]: time="2025-07-14T21:49:07.054118482Z" level=info msg="loading plugin \"io.containerd.grpc.v1.cri\"..." type=io.containerd.grpc.v1 Jul 14 21:49:07.054383 env[1133]: time="2025-07-14T21:49:07.054315098Z" 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:49:07.054383 env[1133]: time="2025-07-14T21:49:07.054378156Z" level=info msg="Connect containerd service" Jul 14 21:49:07.058255 env[1133]: time="2025-07-14T21:49:07.054413264Z" level=info msg="Get image filesystem path \"/var/lib/containerd/io.containerd.snapshotter.v1.overlayfs\"" Jul 14 21:49:07.058255 env[1133]: time="2025-07-14T21:49:07.055222217Z" 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:49:07.058255 env[1133]: time="2025-07-14T21:49:07.055746499Z" level=info msg="Start subscribing containerd event" Jul 14 21:49:07.058255 env[1133]: time="2025-07-14T21:49:07.055795684Z" level=info msg="Start recovering state" Jul 14 21:49:07.058255 env[1133]: time="2025-07-14T21:49:07.055859753Z" level=info msg="Start event monitor" Jul 14 21:49:07.058255 env[1133]: time="2025-07-14T21:49:07.055878804Z" level=info msg="Start snapshots syncer" Jul 14 21:49:07.058255 env[1133]: time="2025-07-14T21:49:07.055888187Z" level=info msg="Start cni network conf syncer for default" Jul 14 21:49:07.058255 env[1133]: time="2025-07-14T21:49:07.055895953Z" level=info msg="Start streaming server" Jul 14 21:49:07.058255 env[1133]: time="2025-07-14T21:49:07.056102236Z" level=info msg=serving... address=/run/containerd/containerd.sock.ttrpc Jul 14 21:49:07.058255 env[1133]: time="2025-07-14T21:49:07.056144342Z" level=info msg=serving... address=/run/containerd/containerd.sock Jul 14 21:49:07.058255 env[1133]: time="2025-07-14T21:49:07.056255209Z" level=info msg="containerd successfully booted in 0.031744s" Jul 14 21:49:07.057048 systemd[1]: Started containerd.service. Jul 14 21:49:07.828182 systemd-networkd[1044]: eth0: Gained IPv6LL Jul 14 21:49:07.830497 systemd[1]: Finished systemd-networkd-wait-online.service. Jul 14 21:49:07.831845 systemd[1]: Reached target network-online.target. Jul 14 21:49:07.834259 systemd[1]: Starting coreos-metadata.service... Jul 14 21:49:07.841222 systemd[1]: coreos-metadata.service: Deactivated successfully. Jul 14 21:49:07.841414 systemd[1]: Finished coreos-metadata.service. Jul 14 21:49:07.843834 systemd[1]: Starting etcd-member.service... Jul 14 21:49:07.913498 systemd[1]: Starting docker.service... Jul 14 21:49:08.007385 env[1182]: time="2025-07-14T21:49:08.007327626Z" level=info msg="Starting up" Jul 14 21:49:08.008903 env[1182]: time="2025-07-14T21:49:08.008877293Z" level=info msg="parsed scheme: \"unix\"" module=grpc Jul 14 21:49:08.008903 env[1182]: time="2025-07-14T21:49:08.008898903Z" level=info msg="scheme \"unix\" not registered, fallback to default scheme" module=grpc Jul 14 21:49:08.009014 env[1182]: time="2025-07-14T21:49:08.008923098Z" level=info msg="ccResolverWrapper: sending update to cc: {[{unix:///var/run/docker/libcontainerd/docker-containerd.sock 0 }] }" module=grpc Jul 14 21:49:08.009014 env[1182]: time="2025-07-14T21:49:08.008935175Z" level=info msg="ClientConn switching balancer to \"pick_first\"" module=grpc Jul 14 21:49:08.011342 env[1182]: time="2025-07-14T21:49:08.011317032Z" level=info msg="parsed scheme: \"unix\"" module=grpc Jul 14 21:49:08.011427 env[1182]: time="2025-07-14T21:49:08.011413366Z" level=info msg="scheme \"unix\" not registered, fallback to default scheme" module=grpc Jul 14 21:49:08.011503 env[1182]: time="2025-07-14T21:49:08.011487081Z" level=info msg="ccResolverWrapper: sending update to cc: {[{unix:///var/run/docker/libcontainerd/docker-containerd.sock 0 }] }" module=grpc Jul 14 21:49:08.011555 env[1182]: time="2025-07-14T21:49:08.011543185Z" level=info msg="ClientConn switching balancer to \"pick_first\"" module=grpc Jul 14 21:49:08.015134 systemd[1]: var-lib-docker-check\x2doverlayfs\x2dsupport3211423786-merged.mount: Deactivated successfully. Jul 14 21:49:08.040655 env[1182]: time="2025-07-14T21:49:08.040621923Z" level=info msg="Loading containers: start." Jul 14 21:49:08.162052 kernel: Initializing XFRM netlink socket Jul 14 21:49:08.187682 env[1182]: time="2025-07-14T21:49:08.187646346Z" 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:49:08.243155 systemd-networkd[1044]: docker0: Link UP Jul 14 21:49:08.260193 env[1182]: time="2025-07-14T21:49:08.260158298Z" level=info msg="Loading containers: done." Jul 14 21:49:08.276066 systemd[1]: var-lib-docker-overlay2-opaque\x2dbug\x2dcheck4085876248-merged.mount: Deactivated successfully. Jul 14 21:49:08.278226 env[1182]: time="2025-07-14T21:49:08.278140997Z" 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:49:08.278406 env[1182]: time="2025-07-14T21:49:08.278377248Z" level=info msg="Docker daemon" commit=112bdf3343 graphdriver(s)=overlay2 version=20.10.23 Jul 14 21:49:08.278508 env[1182]: time="2025-07-14T21:49:08.278482468Z" level=info msg="Daemon has completed initialization" Jul 14 21:49:08.291988 systemd[1]: Started docker.service. Jul 14 21:49:08.299278 env[1182]: time="2025-07-14T21:49:08.299228241Z" level=info msg="API listen on /run/docker.sock" Jul 14 21:49:08.300502 etcd-wrapper[1174]: Error response from daemon: No such container: etcd-member Jul 14 21:49:08.318990 etcd-wrapper[1292]: Error: No such container: etcd-member Jul 14 21:49:08.355027 etcd-wrapper[1312]: Unable to find image 'quay.io/coreos/etcd:v3.5.16' locally Jul 14 21:49:08.701928 sshd_keygen[1129]: ssh-keygen: generating new host keys: RSA ECDSA ED25519 Jul 14 21:49:08.721721 systemd[1]: Finished sshd-keygen.service. Jul 14 21:49:08.724261 systemd[1]: Starting issuegen.service... Jul 14 21:49:08.728924 systemd[1]: issuegen.service: Deactivated successfully. Jul 14 21:49:08.729145 systemd[1]: Finished issuegen.service. Jul 14 21:49:08.731699 systemd[1]: Starting systemd-user-sessions.service... Jul 14 21:49:08.737971 systemd[1]: Finished systemd-user-sessions.service. Jul 14 21:49:08.740603 systemd[1]: Started getty@tty1.service. Jul 14 21:49:08.743023 systemd[1]: Started serial-getty@ttyAMA0.service. Jul 14 21:49:08.744213 systemd[1]: Reached target getty.target. Jul 14 21:49:09.097068 etcd-wrapper[1312]: v3.5.16: Pulling from coreos/etcd Jul 14 21:49:09.240281 etcd-wrapper[1312]: d10f96ed9607: Pulling fs layer Jul 14 21:49:09.240281 etcd-wrapper[1312]: 2ae710cd8bfe: Pulling fs layer Jul 14 21:49:09.240281 etcd-wrapper[1312]: d462aa345367: Pulling fs layer Jul 14 21:49:09.240447 etcd-wrapper[1312]: 0f8b424aa0b9: Pulling fs layer Jul 14 21:49:09.240447 etcd-wrapper[1312]: d557676654e5: Pulling fs layer Jul 14 21:49:09.240447 etcd-wrapper[1312]: c8022d07192e: Pulling fs layer Jul 14 21:49:09.240447 etcd-wrapper[1312]: d858cbc252ad: Pulling fs layer Jul 14 21:49:09.240447 etcd-wrapper[1312]: 1069fc2daed1: Pulling fs layer Jul 14 21:49:09.240558 etcd-wrapper[1312]: b40161cd83fc: Pulling fs layer Jul 14 21:49:09.240558 etcd-wrapper[1312]: 5318d93a3a65: Pulling fs layer Jul 14 21:49:09.240558 etcd-wrapper[1312]: 307c1adadb60: Pulling fs layer Jul 14 21:49:09.240628 etcd-wrapper[1312]: f9b3c65df792: Pulling fs layer Jul 14 21:49:09.240628 etcd-wrapper[1312]: 5709b4a82c35: Pulling fs layer Jul 14 21:49:09.240628 etcd-wrapper[1312]: d5372e382b07: Pulling fs layer Jul 14 21:49:09.240687 etcd-wrapper[1312]: 9c3b5253dddc: Pulling fs layer Jul 14 21:49:09.240710 etcd-wrapper[1312]: 7a57323f7551: Pulling fs layer Jul 14 21:49:09.240734 etcd-wrapper[1312]: 0f8b424aa0b9: Waiting Jul 14 21:49:09.240776 etcd-wrapper[1312]: d557676654e5: Waiting Jul 14 21:49:09.240822 etcd-wrapper[1312]: c8022d07192e: Waiting Jul 14 21:49:09.240847 etcd-wrapper[1312]: d858cbc252ad: Waiting Jul 14 21:49:09.240886 etcd-wrapper[1312]: 1069fc2daed1: Waiting Jul 14 21:49:09.240917 etcd-wrapper[1312]: b40161cd83fc: Waiting Jul 14 21:49:09.241104 etcd-wrapper[1312]: 5318d93a3a65: Waiting Jul 14 21:49:09.241104 etcd-wrapper[1312]: 307c1adadb60: Waiting Jul 14 21:49:09.241104 etcd-wrapper[1312]: f9b3c65df792: Waiting Jul 14 21:49:09.241104 etcd-wrapper[1312]: 5709b4a82c35: Waiting Jul 14 21:49:09.241104 etcd-wrapper[1312]: d5372e382b07: Waiting Jul 14 21:49:09.241251 etcd-wrapper[1312]: 9c3b5253dddc: Waiting Jul 14 21:49:09.241251 etcd-wrapper[1312]: 7a57323f7551: Waiting Jul 14 21:49:09.400245 etcd-wrapper[1312]: 2ae710cd8bfe: Verifying Checksum Jul 14 21:49:09.400245 etcd-wrapper[1312]: 2ae710cd8bfe: Download complete Jul 14 21:49:09.400245 etcd-wrapper[1312]: d10f96ed9607: Verifying Checksum Jul 14 21:49:09.400245 etcd-wrapper[1312]: d10f96ed9607: Download complete Jul 14 21:49:09.403336 etcd-wrapper[1312]: d462aa345367: Verifying Checksum Jul 14 21:49:09.403454 etcd-wrapper[1312]: d462aa345367: Download complete Jul 14 21:49:09.453403 etcd-wrapper[1312]: d10f96ed9607: Pull complete Jul 14 21:49:09.498877 systemd[1]: var-lib-docker-overlay2-63c6a03361f1e7fb8cf6f9261dcf5d68814d0dd90fe3cb7d2b0a3447cfe60f16-merged.mount: Deactivated successfully. Jul 14 21:49:09.513240 etcd-wrapper[1312]: 2ae710cd8bfe: Pull complete Jul 14 21:49:09.535070 etcd-wrapper[1312]: 0f8b424aa0b9: Download complete Jul 14 21:49:09.552470 etcd-wrapper[1312]: d557676654e5: Verifying Checksum Jul 14 21:49:09.552470 etcd-wrapper[1312]: d557676654e5: Download complete Jul 14 21:49:09.578477 etcd-wrapper[1312]: c8022d07192e: Verifying Checksum Jul 14 21:49:09.578477 etcd-wrapper[1312]: c8022d07192e: Download complete Jul 14 21:49:09.662269 etcd-wrapper[1312]: d858cbc252ad: Verifying Checksum Jul 14 21:49:09.662269 etcd-wrapper[1312]: d858cbc252ad: Download complete Jul 14 21:49:09.684863 etcd-wrapper[1312]: 1069fc2daed1: Verifying Checksum Jul 14 21:49:09.684863 etcd-wrapper[1312]: 1069fc2daed1: Download complete Jul 14 21:49:09.707878 etcd-wrapper[1312]: b40161cd83fc: Verifying Checksum Jul 14 21:49:09.707878 etcd-wrapper[1312]: b40161cd83fc: Download complete Jul 14 21:49:09.734768 systemd[1]: var-lib-docker-overlay2-e656b4ad93369331a6a519a16bbb3baa39e8e0a483ac76edff98d19159d11c83-merged.mount: Deactivated successfully. Jul 14 21:49:09.803506 etcd-wrapper[1312]: 5318d93a3a65: Verifying Checksum Jul 14 21:49:09.803506 etcd-wrapper[1312]: 5318d93a3a65: Download complete Jul 14 21:49:09.812468 etcd-wrapper[1312]: 307c1adadb60: Verifying Checksum Jul 14 21:49:09.812468 etcd-wrapper[1312]: 307c1adadb60: Download complete Jul 14 21:49:09.831538 etcd-wrapper[1312]: d462aa345367: Pull complete Jul 14 21:49:09.903891 etcd-wrapper[1312]: f9b3c65df792: Verifying Checksum Jul 14 21:49:09.903891 etcd-wrapper[1312]: f9b3c65df792: Download complete Jul 14 21:49:09.954218 etcd-wrapper[1312]: 0f8b424aa0b9: Pull complete Jul 14 21:49:09.963688 etcd-wrapper[1312]: d5372e382b07: Verifying Checksum Jul 14 21:49:09.963688 etcd-wrapper[1312]: d5372e382b07: Download complete Jul 14 21:49:09.971061 etcd-wrapper[1312]: 5709b4a82c35: Verifying Checksum Jul 14 21:49:09.971195 etcd-wrapper[1312]: 5709b4a82c35: Download complete Jul 14 21:49:10.035918 etcd-wrapper[1312]: 9c3b5253dddc: Verifying Checksum Jul 14 21:49:10.035918 etcd-wrapper[1312]: 9c3b5253dddc: Download complete Jul 14 21:49:10.044849 etcd-wrapper[1312]: d557676654e5: Pull complete Jul 14 21:49:10.089067 etcd-wrapper[1312]: c8022d07192e: Pull complete Jul 14 21:49:10.138898 etcd-wrapper[1312]: d858cbc252ad: Pull complete Jul 14 21:49:10.184526 etcd-wrapper[1312]: 1069fc2daed1: Pull complete Jul 14 21:49:10.227463 etcd-wrapper[1312]: b40161cd83fc: Pull complete Jul 14 21:49:10.240188 etcd-wrapper[1312]: 7a57323f7551: Verifying Checksum Jul 14 21:49:10.240188 etcd-wrapper[1312]: 7a57323f7551: Download complete Jul 14 21:49:10.275066 etcd-wrapper[1312]: 5318d93a3a65: Pull complete Jul 14 21:49:10.327499 etcd-wrapper[1312]: 307c1adadb60: Pull complete Jul 14 21:49:10.458234 systemd[1]: var-lib-docker-overlay2-39c422d47fac3d1abe53ef936f6b64b35de32210763c66af279bc19a39da8aef-merged.mount: Deactivated successfully. Jul 14 21:49:10.601200 systemd[1]: var-lib-docker-overlay2-84c6ffd181bb4b50f6d6972bdd353196381ebd094ea0ea8b1d47d258256ee6c9-merged.mount: Deactivated successfully. Jul 14 21:49:10.631922 etcd-wrapper[1312]: f9b3c65df792: Pull complete Jul 14 21:49:10.846577 systemd[1]: var-lib-docker-overlay2-74336d912be788d73503fd85b070a80e888911ba009d56d0fb691d7998957e39-merged.mount: Deactivated successfully. Jul 14 21:49:10.872200 etcd-wrapper[1312]: 5709b4a82c35: Pull complete Jul 14 21:49:11.071565 etcd-wrapper[1312]: d5372e382b07: Pull complete Jul 14 21:49:11.116806 etcd-wrapper[1312]: 9c3b5253dddc: Pull complete Jul 14 21:49:11.163852 etcd-wrapper[1312]: 7a57323f7551: Pull complete Jul 14 21:49:11.169819 etcd-wrapper[1312]: Digest: sha256:d967d98a12dc220a1a290794711dba7eba04b8ce465e12b02383d1bfbb33e159 Jul 14 21:49:11.172731 etcd-wrapper[1312]: Status: Downloaded newer image for quay.io/coreos/etcd:v3.5.16 Jul 14 21:49:11.264575 env[1133]: time="2025-07-14T21:49:11.264500399Z" level=info msg="loading plugin \"io.containerd.event.v1.publisher\"..." runtime=io.containerd.runc.v2 type=io.containerd.event.v1 Jul 14 21:49:11.264575 env[1133]: time="2025-07-14T21:49:11.264541507Z" level=info msg="loading plugin \"io.containerd.internal.v1.shutdown\"..." runtime=io.containerd.runc.v2 type=io.containerd.internal.v1 Jul 14 21:49:11.265019 env[1133]: time="2025-07-14T21:49:11.264553102Z" level=info msg="loading plugin \"io.containerd.ttrpc.v1.task\"..." runtime=io.containerd.runc.v2 type=io.containerd.ttrpc.v1 Jul 14 21:49:11.265415 env[1133]: time="2025-07-14T21:49:11.265346835Z" level=info msg="starting signal loop" namespace=moby path=/run/containerd/io.containerd.runtime.v2.task/moby/5378640d84ae3a067b0a57841311f65d2401b6f4afa67adffc10f1f529691c23 pid=1505 runtime=io.containerd.runc.v2 Jul 14 21:49:11.276506 systemd[1]: Started docker-5378640d84ae3a067b0a57841311f65d2401b6f4afa67adffc10f1f529691c23.scope. Jul 14 21:49:11.387865 systemd-resolved[1083]: Failed to determine the local hostname and LLMNR/mDNS names, ignoring: No such device or address Jul 14 21:49:11.438613 etcd-wrapper[1312]: {"level":"info","ts":"2025-07-14T21:49:11.438217Z","caller":"flags/flag.go:113","msg":"recognized and used environment variable","variable-name":"ETCD_DATA_DIR","variable-value":"/var/lib/etcd"} Jul 14 21:49:11.438613 etcd-wrapper[1312]: {"level":"info","ts":"2025-07-14T21:49:11.438350Z","caller":"flags/flag.go:113","msg":"recognized and used environment variable","variable-name":"ETCD_NAME","variable-value":"fac0a200b6c3499d8fe3ad8058bf8bda"} Jul 14 21:49:11.438613 etcd-wrapper[1312]: {"level":"warn","ts":"2025-07-14T21:49:11.438374Z","caller":"flags/flag.go:93","msg":"unrecognized environment variable","environment-variable":"ETCD_IMAGE_URL=quay.io/coreos/etcd"} Jul 14 21:49:11.438613 etcd-wrapper[1312]: {"level":"warn","ts":"2025-07-14T21:49:11.438385Z","caller":"flags/flag.go:93","msg":"unrecognized environment variable","environment-variable":"ETCD_IMAGE_TAG=v3.5.16"} Jul 14 21:49:11.438613 etcd-wrapper[1312]: {"level":"warn","ts":"2025-07-14T21:49:11.438391Z","caller":"flags/flag.go:93","msg":"unrecognized environment variable","environment-variable":"ETCD_USER=etcd"} Jul 14 21:49:11.438613 etcd-wrapper[1312]: {"level":"warn","ts":"2025-07-14T21:49:11.438394Z","caller":"flags/flag.go:93","msg":"unrecognized environment variable","environment-variable":"ETCD_SSL_DIR=/etc/ssl/certs"} Jul 14 21:49:11.438613 etcd-wrapper[1312]: {"level":"warn","ts":"2025-07-14T21:49:11.438431Z","caller":"embed/config.go:689","msg":"Running http and grpc server on single port. This is not recommended for production."} Jul 14 21:49:11.438613 etcd-wrapper[1312]: {"level":"info","ts":"2025-07-14T21:49:11.438447Z","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.38:2379"]} Jul 14 21:49:11.438905 etcd-wrapper[1312]: {"level":"warn","ts":"2025-07-14T21:49:11.438598Z","caller":"embed/config.go:689","msg":"Running http and grpc server on single port. This is not recommended for production."} Jul 14 21:49:11.438905 etcd-wrapper[1312]: {"level":"info","ts":"2025-07-14T21:49:11.438615Z","caller":"embed/etcd.go:128","msg":"configuring peer listeners","listen-peer-urls":["http://localhost:2380"]} Jul 14 21:49:11.439472 etcd-wrapper[1312]: {"level":"info","ts":"2025-07-14T21:49:11.439300Z","caller":"embed/etcd.go:136","msg":"configuring client listeners","listen-client-urls":["http://0.0.0.0:2379"]} Jul 14 21:49:11.440041 etcd-wrapper[1312]: {"level":"info","ts":"2025-07-14T21:49:11.439839Z","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":"fac0a200b6c3499d8fe3ad8058bf8bda","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.38:2379"],"listen-client-urls":["http://0.0.0.0:2379"],"listen-metrics-urls":[],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"fac0a200b6c3499d8fe3ad8058bf8bda=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:49:11.442063 etcd-wrapper[1312]: {"level":"info","ts":"2025-07-14T21:49:11.441856Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"1.58509ms"} Jul 14 21:49:11.444626 etcd-wrapper[1312]: {"level":"info","ts":"2025-07-14T21:49:11.444450Z","caller":"etcdserver/raft.go:505","msg":"starting local member","local-member-id":"8e9e05c52164694d","cluster-id":"cdf818194e3a8c32"} Jul 14 21:49:11.444965 etcd-wrapper[1312]: {"level":"info","ts":"2025-07-14T21:49:11.444855Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"8e9e05c52164694d switched to configuration voters=()"} Jul 14 21:49:11.445145 etcd-wrapper[1312]: {"level":"info","ts":"2025-07-14T21:49:11.444948Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"8e9e05c52164694d became follower at term 0"} Jul 14 21:49:11.445145 etcd-wrapper[1312]: {"level":"info","ts":"2025-07-14T21:49:11.444980Z","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:49:11.445145 etcd-wrapper[1312]: {"level":"info","ts":"2025-07-14T21:49:11.445027Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"8e9e05c52164694d became follower at term 1"} Jul 14 21:49:11.445145 etcd-wrapper[1312]: {"level":"info","ts":"2025-07-14T21:49:11.445085Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"8e9e05c52164694d switched to configuration voters=(10276657743932975437)"} Jul 14 21:49:11.447496 etcd-wrapper[1312]: {"level":"warn","ts":"2025-07-14T21:49:11.447340Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} Jul 14 21:49:11.448784 etcd-wrapper[1312]: {"level":"info","ts":"2025-07-14T21:49:11.448639Z","caller":"mvcc/kvstore.go:423","msg":"kvstore restored","current-rev":1} Jul 14 21:49:11.449449 etcd-wrapper[1312]: {"level":"info","ts":"2025-07-14T21:49:11.449329Z","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:49:11.450050 etcd-wrapper[1312]: {"level":"info","ts":"2025-07-14T21:49:11.449915Z","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:49:11.450241 etcd-wrapper[1312]: {"level":"info","ts":"2025-07-14T21:49:11.450087Z","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:49:11.450444 etcd-wrapper[1312]: {"level":"info","ts":"2025-07-14T21:49:11.450236Z","caller":"v3rpc/health.go:61","msg":"grpc service status changed","service":"","status":"SERVING"} Jul 14 21:49:11.450444 etcd-wrapper[1312]: {"level":"info","ts":"2025-07-14T21:49:11.450290Z","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:49:11.450444 etcd-wrapper[1312]: {"level":"info","ts":"2025-07-14T21:49:11.450332Z","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:49:11.450444 etcd-wrapper[1312]: {"level":"info","ts":"2025-07-14T21:49:11.450347Z","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:49:11.450841 etcd-wrapper[1312]: {"level":"info","ts":"2025-07-14T21:49:11.450693Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"8e9e05c52164694d switched to configuration voters=(10276657743932975437)"} Jul 14 21:49:11.450841 etcd-wrapper[1312]: {"level":"info","ts":"2025-07-14T21:49:11.450771Z","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:49:11.452099 etcd-wrapper[1312]: {"level":"info","ts":"2025-07-14T21:49:11.451938Z","caller":"embed/etcd.go:600","msg":"serving peer traffic","address":"127.0.0.1:2380"} Jul 14 21:49:11.452099 etcd-wrapper[1312]: {"level":"info","ts":"2025-07-14T21:49:11.451955Z","caller":"embed/etcd.go:572","msg":"cmux::serve","address":"127.0.0.1:2380"} Jul 14 21:49:11.452263 etcd-wrapper[1312]: {"level":"info","ts":"2025-07-14T21:49:11.452066Z","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.38:2379"],"listen-client-urls":["http://0.0.0.0:2379"],"listen-metrics-urls":[]} Jul 14 21:49:11.458552 systemd[1]: var-lib-docker-overlay2-21f3850802c6413ea8b2ff08b61db847d13fae74cb1adee7c0b2853c837fc59a-merged.mount: Deactivated successfully. Jul 14 21:49:11.746227 etcd-wrapper[1312]: {"level":"info","ts":"2025-07-14T21:49:11.745904Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"8e9e05c52164694d is starting a new election at term 1"} Jul 14 21:49:11.746227 etcd-wrapper[1312]: {"level":"info","ts":"2025-07-14T21:49:11.745945Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"8e9e05c52164694d became pre-candidate at term 1"} Jul 14 21:49:11.746227 etcd-wrapper[1312]: {"level":"info","ts":"2025-07-14T21:49:11.745984Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"8e9e05c52164694d received MsgPreVoteResp from 8e9e05c52164694d at term 1"} Jul 14 21:49:11.746691 etcd-wrapper[1312]: {"level":"info","ts":"2025-07-14T21:49:11.746140Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"8e9e05c52164694d became candidate at term 2"} Jul 14 21:49:11.746871 etcd-wrapper[1312]: {"level":"info","ts":"2025-07-14T21:49:11.746754Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"8e9e05c52164694d received MsgVoteResp from 8e9e05c52164694d at term 2"} Jul 14 21:49:11.747041 etcd-wrapper[1312]: {"level":"info","ts":"2025-07-14T21:49:11.746786Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"8e9e05c52164694d became leader at term 2"} Jul 14 21:49:11.747205 etcd-wrapper[1312]: {"level":"info","ts":"2025-07-14T21:49:11.746943Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 8e9e05c52164694d elected leader 8e9e05c52164694d at term 2"} Jul 14 21:49:11.747884 etcd-wrapper[1312]: {"level":"info","ts":"2025-07-14T21:49:11.747743Z","caller":"etcdserver/server.go:2651","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} Jul 14 21:49:11.748282 etcd-wrapper[1312]: {"level":"info","ts":"2025-07-14T21:49:11.748135Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} Jul 14 21:49:11.748282 etcd-wrapper[1312]: {"level":"info","ts":"2025-07-14T21:49:11.748146Z","caller":"etcdserver/server.go:2140","msg":"published local member to cluster through raft","local-member-id":"8e9e05c52164694d","local-member-attributes":"{Name:fac0a200b6c3499d8fe3ad8058bf8bda ClientURLs:[http://10.0.0.38:2379]}","request-path":"/0/members/8e9e05c52164694d/attributes","cluster-id":"cdf818194e3a8c32","publish-timeout":"7s"} Jul 14 21:49:11.748697 systemd[1]: Started etcd-member.service. Jul 14 21:49:11.749602 etcd-wrapper[1312]: {"level":"info","ts":"2025-07-14T21:49:11.748365Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} Jul 14 21:49:11.749602 etcd-wrapper[1312]: {"level":"info","ts":"2025-07-14T21:49:11.748419Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"cdf818194e3a8c32","local-member-id":"8e9e05c52164694d","cluster-version":"3.5"} Jul 14 21:49:11.749602 etcd-wrapper[1312]: {"level":"info","ts":"2025-07-14T21:49:11.748477Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} Jul 14 21:49:11.749602 etcd-wrapper[1312]: {"level":"info","ts":"2025-07-14T21:49:11.748478Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} Jul 14 21:49:11.749602 etcd-wrapper[1312]: {"level":"info","ts":"2025-07-14T21:49:11.748494Z","caller":"etcdserver/server.go:2675","msg":"cluster version is updated","cluster-version":"3.5"} Jul 14 21:49:11.749602 etcd-wrapper[1312]: {"level":"info","ts":"2025-07-14T21:49:11.748875Z","caller":"v3rpc/health.go:61","msg":"grpc service status changed","service":"","status":"SERVING"} Jul 14 21:49:11.749602 etcd-wrapper[1312]: {"level":"info","ts":"2025-07-14T21:49:11.749261Z","caller":"embed/serve.go:187","msg":"serving client traffic insecurely; this is strongly discouraged!","traffic":"grpc+http","address":"[::]:2379"} Jul 14 21:49:11.749774 systemd[1]: Reached target multi-user.target. Jul 14 21:49:11.752089 systemd[1]: Starting systemd-update-utmp-runlevel.service... Jul 14 21:49:11.758956 systemd[1]: systemd-update-utmp-runlevel.service: Deactivated successfully. Jul 14 21:49:11.759180 systemd[1]: Finished systemd-update-utmp-runlevel.service. Jul 14 21:49:11.760348 systemd[1]: Startup finished in 648ms (kernel) + 3.338s (initrd) + 7.848s (userspace) = 11.836s. Jul 14 21:49:13.003758 systemd[1]: Created slice system-sshd.slice. Jul 14 21:49:13.004816 systemd[1]: Started sshd@0-10.0.0.38:22-10.0.0.1:52824.service. Jul 14 21:49:13.054862 sshd[1549]: Accepted publickey for core from 10.0.0.1 port 52824 ssh2: RSA SHA256:BOxEaGpHMktIkRdcKvKv9Es2//92qEL6t3QfRP9zfwU Jul 14 21:49:13.058539 sshd[1549]: pam_unix(sshd:session): session opened for user core(uid=500) by (uid=0) Jul 14 21:49:13.071324 systemd[1]: Created slice user-500.slice. Jul 14 21:49:13.072507 systemd[1]: Starting user-runtime-dir@500.service... Jul 14 21:49:13.074125 systemd-logind[1119]: New session 1 of user core. Jul 14 21:49:13.080602 systemd[1]: Finished user-runtime-dir@500.service. Jul 14 21:49:13.081986 systemd[1]: Starting user@500.service... Jul 14 21:49:13.084607 (systemd)[1552]: pam_unix(systemd-user:session): session opened for user core(uid=500) by (uid=0) Jul 14 21:49:13.143370 systemd[1552]: Queued start job for default target default.target. Jul 14 21:49:13.143886 systemd[1552]: Reached target paths.target. Jul 14 21:49:13.143906 systemd[1552]: Reached target sockets.target. Jul 14 21:49:13.143917 systemd[1552]: Reached target timers.target. Jul 14 21:49:13.143927 systemd[1552]: Reached target basic.target. Jul 14 21:49:13.143967 systemd[1552]: Reached target default.target. Jul 14 21:49:13.143991 systemd[1552]: Startup finished in 53ms. Jul 14 21:49:13.144065 systemd[1]: Started user@500.service. Jul 14 21:49:13.145433 systemd[1]: Started session-1.scope. Jul 14 21:49:13.197339 systemd[1]: Started sshd@1-10.0.0.38:22-10.0.0.1:52830.service. Jul 14 21:49:13.255717 sshd[1561]: Accepted publickey for core from 10.0.0.1 port 52830 ssh2: RSA SHA256:BOxEaGpHMktIkRdcKvKv9Es2//92qEL6t3QfRP9zfwU Jul 14 21:49:13.256751 sshd[1561]: pam_unix(sshd:session): session opened for user core(uid=500) by (uid=0) Jul 14 21:49:13.261128 systemd-logind[1119]: New session 2 of user core. Jul 14 21:49:13.261805 systemd[1]: Started session-2.scope. Jul 14 21:49:13.317070 sshd[1561]: pam_unix(sshd:session): session closed for user core Jul 14 21:49:13.319703 systemd[1]: sshd@1-10.0.0.38:22-10.0.0.1:52830.service: Deactivated successfully. Jul 14 21:49:13.320366 systemd[1]: session-2.scope: Deactivated successfully. Jul 14 21:49:13.320842 systemd-logind[1119]: Session 2 logged out. Waiting for processes to exit. Jul 14 21:49:13.321852 systemd[1]: Started sshd@2-10.0.0.38:22-10.0.0.1:52838.service. Jul 14 21:49:13.322392 systemd-logind[1119]: Removed session 2. Jul 14 21:49:13.365314 sshd[1567]: Accepted publickey for core from 10.0.0.1 port 52838 ssh2: RSA SHA256:BOxEaGpHMktIkRdcKvKv9Es2//92qEL6t3QfRP9zfwU Jul 14 21:49:13.366633 sshd[1567]: pam_unix(sshd:session): session opened for user core(uid=500) by (uid=0) Jul 14 21:49:13.369852 systemd-logind[1119]: New session 3 of user core. Jul 14 21:49:13.370634 systemd[1]: Started session-3.scope. Jul 14 21:49:13.419601 sshd[1567]: pam_unix(sshd:session): session closed for user core Jul 14 21:49:13.423648 systemd[1]: sshd@2-10.0.0.38:22-10.0.0.1:52838.service: Deactivated successfully. Jul 14 21:49:13.424339 systemd[1]: session-3.scope: Deactivated successfully. Jul 14 21:49:13.424817 systemd-logind[1119]: Session 3 logged out. Waiting for processes to exit. Jul 14 21:49:13.425879 systemd[1]: Started sshd@3-10.0.0.38:22-10.0.0.1:52852.service. Jul 14 21:49:13.426513 systemd-logind[1119]: Removed session 3. Jul 14 21:49:13.469866 sshd[1573]: Accepted publickey for core from 10.0.0.1 port 52852 ssh2: RSA SHA256:BOxEaGpHMktIkRdcKvKv9Es2//92qEL6t3QfRP9zfwU Jul 14 21:49:13.471415 sshd[1573]: pam_unix(sshd:session): session opened for user core(uid=500) by (uid=0) Jul 14 21:49:13.475610 systemd-logind[1119]: New session 4 of user core. Jul 14 21:49:13.476437 systemd[1]: Started session-4.scope. Jul 14 21:49:13.531415 sshd[1573]: pam_unix(sshd:session): session closed for user core Jul 14 21:49:13.536283 systemd[1]: sshd@3-10.0.0.38:22-10.0.0.1:52852.service: Deactivated successfully. Jul 14 21:49:13.537273 systemd[1]: session-4.scope: Deactivated successfully. Jul 14 21:49:13.538082 systemd-logind[1119]: Session 4 logged out. Waiting for processes to exit. Jul 14 21:49:13.539679 systemd[1]: Started sshd@4-10.0.0.38:22-10.0.0.1:52862.service. Jul 14 21:49:13.540774 systemd-logind[1119]: Removed session 4. Jul 14 21:49:13.583281 sshd[1579]: Accepted publickey for core from 10.0.0.1 port 52862 ssh2: RSA SHA256:BOxEaGpHMktIkRdcKvKv9Es2//92qEL6t3QfRP9zfwU Jul 14 21:49:13.584527 sshd[1579]: pam_unix(sshd:session): session opened for user core(uid=500) by (uid=0) Jul 14 21:49:13.588136 systemd-logind[1119]: New session 5 of user core. Jul 14 21:49:13.590094 systemd[1]: Started session-5.scope. Jul 14 21:49:13.640359 sshd[1579]: pam_unix(sshd:session): session closed for user core Jul 14 21:49:13.644437 systemd[1]: sshd@4-10.0.0.38:22-10.0.0.1:52862.service: Deactivated successfully. Jul 14 21:49:13.645105 systemd[1]: session-5.scope: Deactivated successfully. Jul 14 21:49:13.645582 systemd-logind[1119]: Session 5 logged out. Waiting for processes to exit. Jul 14 21:49:13.646722 systemd[1]: Started sshd@5-10.0.0.38:22-10.0.0.1:52876.service. Jul 14 21:49:13.647379 systemd-logind[1119]: Removed session 5. Jul 14 21:49:13.690183 sshd[1587]: Accepted publickey for core from 10.0.0.1 port 52876 ssh2: RSA SHA256:BOxEaGpHMktIkRdcKvKv9Es2//92qEL6t3QfRP9zfwU Jul 14 21:49:13.691964 sshd[1587]: pam_unix(sshd:session): session opened for user core(uid=500) by (uid=0) Jul 14 21:49:13.695677 systemd-logind[1119]: New session 6 of user core. Jul 14 21:49:13.696531 systemd[1]: Started session-6.scope. Jul 14 21:49:13.805878 sshd[1587]: pam_unix(sshd:session): session closed for user core Jul 14 21:49:13.808533 systemd[1]: sshd@5-10.0.0.38:22-10.0.0.1:52876.service: Deactivated successfully. Jul 14 21:49:13.809436 systemd[1]: session-6.scope: Deactivated successfully. Jul 14 21:49:13.809959 systemd-logind[1119]: Session 6 logged out. Waiting for processes to exit. Jul 14 21:49:13.810542 systemd-logind[1119]: Removed session 6. Jul 14 21:49:51.962337 update_engine[1125]: I0714 21:49:51.962275 1125 update_attempter.cc:509] Updating boot flags...