Sep 9 00:36:03.711753 kernel: Booting Linux on physical CPU 0x0000000000 [0x413fd0c1] Sep 9 00:36:03.711773 kernel: Linux version 5.15.191-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 Sep 8 23:23:23 -00 2025 Sep 9 00:36:03.711781 kernel: efi: EFI v2.70 by EDK II Sep 9 00:36:03.711787 kernel: efi: SMBIOS 3.0=0xd9260000 ACPI 2.0=0xd9240000 MEMATTR=0xda32b018 RNG=0xd9220018 MEMRESERVE=0xd9521c18 Sep 9 00:36:03.711792 kernel: random: crng init done Sep 9 00:36:03.711798 kernel: ACPI: Early table checksum verification disabled Sep 9 00:36:03.711804 kernel: ACPI: RSDP 0x00000000D9240000 000024 (v02 BOCHS ) Sep 9 00:36:03.711811 kernel: ACPI: XSDT 0x00000000D9230000 000064 (v01 BOCHS BXPC 00000001 01000013) Sep 9 00:36:03.711817 kernel: ACPI: FACP 0x00000000D91E0000 000114 (v06 BOCHS BXPC 00000001 BXPC 00000001) Sep 9 00:36:03.711823 kernel: ACPI: DSDT 0x00000000D91F0000 0014A2 (v02 BOCHS BXPC 00000001 BXPC 00000001) Sep 9 00:36:03.711829 kernel: ACPI: APIC 0x00000000D91D0000 0001A8 (v04 BOCHS BXPC 00000001 BXPC 00000001) Sep 9 00:36:03.711834 kernel: ACPI: PPTT 0x00000000D91C0000 00009C (v02 BOCHS BXPC 00000001 BXPC 00000001) Sep 9 00:36:03.711840 kernel: ACPI: GTDT 0x00000000D91B0000 000060 (v02 BOCHS BXPC 00000001 BXPC 00000001) Sep 9 00:36:03.711846 kernel: ACPI: MCFG 0x00000000D91A0000 00003C (v01 BOCHS BXPC 00000001 BXPC 00000001) Sep 9 00:36:03.711854 kernel: ACPI: SPCR 0x00000000D9190000 000050 (v02 BOCHS BXPC 00000001 BXPC 00000001) Sep 9 00:36:03.711860 kernel: ACPI: DBG2 0x00000000D9180000 000057 (v00 BOCHS BXPC 00000001 BXPC 00000001) Sep 9 00:36:03.711867 kernel: ACPI: IORT 0x00000000D9170000 000080 (v03 BOCHS BXPC 00000001 BXPC 00000001) Sep 9 00:36:03.711873 kernel: ACPI: SPCR: console: pl011,mmio,0x9000000,9600 Sep 9 00:36:03.711879 kernel: NUMA: Failed to initialise from firmware Sep 9 00:36:03.711885 kernel: NUMA: Faking a node at [mem 0x0000000040000000-0x00000000dcffffff] Sep 9 00:36:03.711891 kernel: NUMA: NODE_DATA [mem 0xdcb0a900-0xdcb0ffff] Sep 9 00:36:03.711897 kernel: Zone ranges: Sep 9 00:36:03.711903 kernel: DMA [mem 0x0000000040000000-0x00000000dcffffff] Sep 9 00:36:03.711910 kernel: DMA32 empty Sep 9 00:36:03.711916 kernel: Normal empty Sep 9 00:36:03.711922 kernel: Movable zone start for each node Sep 9 00:36:03.711928 kernel: Early memory node ranges Sep 9 00:36:03.711934 kernel: node 0: [mem 0x0000000040000000-0x00000000d924ffff] Sep 9 00:36:03.711940 kernel: node 0: [mem 0x00000000d9250000-0x00000000d951ffff] Sep 9 00:36:03.711946 kernel: node 0: [mem 0x00000000d9520000-0x00000000dc7fffff] Sep 9 00:36:03.711952 kernel: node 0: [mem 0x00000000dc800000-0x00000000dc88ffff] Sep 9 00:36:03.711958 kernel: node 0: [mem 0x00000000dc890000-0x00000000dc89ffff] Sep 9 00:36:03.711975 kernel: node 0: [mem 0x00000000dc8a0000-0x00000000dc9bffff] Sep 9 00:36:03.711981 kernel: node 0: [mem 0x00000000dc9c0000-0x00000000dcffffff] Sep 9 00:36:03.711988 kernel: Initmem setup node 0 [mem 0x0000000040000000-0x00000000dcffffff] Sep 9 00:36:03.711995 kernel: On node 0, zone DMA: 12288 pages in unavailable ranges Sep 9 00:36:03.712001 kernel: psci: probing for conduit method from ACPI. Sep 9 00:36:03.712007 kernel: psci: PSCIv1.1 detected in firmware. Sep 9 00:36:03.712013 kernel: psci: Using standard PSCI v0.2 function IDs Sep 9 00:36:03.712019 kernel: psci: Trusted OS migration not required Sep 9 00:36:03.712027 kernel: psci: SMC Calling Convention v1.1 Sep 9 00:36:03.712034 kernel: smccc: KVM: hypervisor services detected (0x00000000 0x00000000 0x00000000 0x00000003) Sep 9 00:36:03.712042 kernel: ACPI: SRAT not present Sep 9 00:36:03.712048 kernel: percpu: Embedded 30 pages/cpu s82968 r8192 d31720 u122880 Sep 9 00:36:03.712055 kernel: pcpu-alloc: s82968 r8192 d31720 u122880 alloc=30*4096 Sep 9 00:36:03.712061 kernel: pcpu-alloc: [0] 0 [0] 1 [0] 2 [0] 3 Sep 9 00:36:03.712068 kernel: Detected PIPT I-cache on CPU0 Sep 9 00:36:03.712074 kernel: CPU features: detected: GIC system register CPU interface Sep 9 00:36:03.712080 kernel: CPU features: detected: Hardware dirty bit management Sep 9 00:36:03.712087 kernel: CPU features: detected: Spectre-v4 Sep 9 00:36:03.712093 kernel: CPU features: detected: Spectre-BHB Sep 9 00:36:03.712100 kernel: CPU features: kernel page table isolation forced ON by KASLR Sep 9 00:36:03.712107 kernel: CPU features: detected: Kernel page table isolation (KPTI) Sep 9 00:36:03.712113 kernel: CPU features: detected: ARM erratum 1418040 Sep 9 00:36:03.712125 kernel: CPU features: detected: SSBS not fully self-synchronizing Sep 9 00:36:03.712133 kernel: Built 1 zonelists, mobility grouping on. Total pages: 633024 Sep 9 00:36:03.712140 kernel: Policy zone: DMA Sep 9 00:36:03.712147 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=32b3b664430ec28e33efa673a32f74eb733fc8145822fbe5ce810188f7f71923 Sep 9 00:36:03.712154 kernel: Unknown kernel command line parameters "BOOT_IMAGE=/flatcar/vmlinuz-a", will be passed to user space. Sep 9 00:36:03.712160 kernel: Dentry cache hash table entries: 524288 (order: 10, 4194304 bytes, linear) Sep 9 00:36:03.712167 kernel: Inode-cache hash table entries: 262144 (order: 9, 2097152 bytes, linear) Sep 9 00:36:03.712173 kernel: mem auto-init: stack:off, heap alloc:off, heap free:off Sep 9 00:36:03.712182 kernel: Memory: 2457336K/2572288K available (9792K kernel code, 2094K rwdata, 7592K rodata, 36416K init, 777K bss, 114952K reserved, 0K cma-reserved) Sep 9 00:36:03.712189 kernel: SLUB: HWalign=64, Order=0-3, MinObjects=0, CPUs=4, Nodes=1 Sep 9 00:36:03.712195 kernel: trace event string verifier disabled Sep 9 00:36:03.712202 kernel: rcu: Preemptible hierarchical RCU implementation. Sep 9 00:36:03.712208 kernel: rcu: RCU event tracing is enabled. Sep 9 00:36:03.712215 kernel: rcu: RCU restricting CPUs from NR_CPUS=512 to nr_cpu_ids=4. Sep 9 00:36:03.712221 kernel: Trampoline variant of Tasks RCU enabled. Sep 9 00:36:03.712228 kernel: Tracing variant of Tasks RCU enabled. Sep 9 00:36:03.712234 kernel: rcu: RCU calculated value of scheduler-enlistment delay is 100 jiffies. Sep 9 00:36:03.712241 kernel: rcu: Adjusting geometry for rcu_fanout_leaf=16, nr_cpu_ids=4 Sep 9 00:36:03.712247 kernel: NR_IRQS: 64, nr_irqs: 64, preallocated irqs: 0 Sep 9 00:36:03.712254 kernel: GICv3: 256 SPIs implemented Sep 9 00:36:03.712261 kernel: GICv3: 0 Extended SPIs implemented Sep 9 00:36:03.712267 kernel: GICv3: Distributor has no Range Selector support Sep 9 00:36:03.712273 kernel: Root IRQ handler: gic_handle_irq Sep 9 00:36:03.712280 kernel: GICv3: 16 PPIs implemented Sep 9 00:36:03.712286 kernel: GICv3: CPU0: found redistributor 0 region 0:0x00000000080a0000 Sep 9 00:36:03.712292 kernel: ACPI: SRAT not present Sep 9 00:36:03.712298 kernel: ITS [mem 0x08080000-0x0809ffff] Sep 9 00:36:03.712305 kernel: ITS@0x0000000008080000: allocated 8192 Devices @400b0000 (indirect, esz 8, psz 64K, shr 1) Sep 9 00:36:03.712311 kernel: ITS@0x0000000008080000: allocated 8192 Interrupt Collections @400c0000 (flat, esz 8, psz 64K, shr 1) Sep 9 00:36:03.712318 kernel: GICv3: using LPI property table @0x00000000400d0000 Sep 9 00:36:03.712324 kernel: GICv3: CPU0: using allocated LPI pending table @0x00000000400e0000 Sep 9 00:36:03.712332 kernel: arch_timer: Enabling local workaround for ARM erratum 1418040 Sep 9 00:36:03.712338 kernel: arch_timer: cp15 timer(s) running at 25.00MHz (virt). Sep 9 00:36:03.712345 kernel: clocksource: arch_sys_counter: mask: 0xffffffffffffff max_cycles: 0x5c40939b5, max_idle_ns: 440795202646 ns Sep 9 00:36:03.712351 kernel: sched_clock: 56 bits at 25MHz, resolution 40ns, wraps every 4398046511100ns Sep 9 00:36:03.712358 kernel: arm-pv: using stolen time PV Sep 9 00:36:03.712364 kernel: Console: colour dummy device 80x25 Sep 9 00:36:03.712371 kernel: ACPI: Core revision 20210730 Sep 9 00:36:03.712378 kernel: Calibrating delay loop (skipped), value calculated using timer frequency.. 50.00 BogoMIPS (lpj=25000) Sep 9 00:36:03.712385 kernel: pid_max: default: 32768 minimum: 301 Sep 9 00:36:03.712391 kernel: LSM: Security Framework initializing Sep 9 00:36:03.712399 kernel: SELinux: Initializing. Sep 9 00:36:03.712406 kernel: Mount-cache hash table entries: 8192 (order: 4, 65536 bytes, linear) Sep 9 00:36:03.712412 kernel: Mountpoint-cache hash table entries: 8192 (order: 4, 65536 bytes, linear) Sep 9 00:36:03.712419 kernel: rcu: Hierarchical SRCU implementation. Sep 9 00:36:03.712425 kernel: Platform MSI: ITS@0x8080000 domain created Sep 9 00:36:03.712432 kernel: PCI/MSI: ITS@0x8080000 domain created Sep 9 00:36:03.712438 kernel: Remapping and enabling EFI services. Sep 9 00:36:03.712445 kernel: smp: Bringing up secondary CPUs ... Sep 9 00:36:03.712452 kernel: Detected PIPT I-cache on CPU1 Sep 9 00:36:03.712460 kernel: GICv3: CPU1: found redistributor 1 region 0:0x00000000080c0000 Sep 9 00:36:03.712466 kernel: GICv3: CPU1: using allocated LPI pending table @0x00000000400f0000 Sep 9 00:36:03.712473 kernel: arch_timer: Enabling local workaround for ARM erratum 1418040 Sep 9 00:36:03.712479 kernel: CPU1: Booted secondary processor 0x0000000001 [0x413fd0c1] Sep 9 00:36:03.712486 kernel: Detected PIPT I-cache on CPU2 Sep 9 00:36:03.712493 kernel: GICv3: CPU2: found redistributor 2 region 0:0x00000000080e0000 Sep 9 00:36:03.712499 kernel: GICv3: CPU2: using allocated LPI pending table @0x0000000040100000 Sep 9 00:36:03.712506 kernel: arch_timer: Enabling local workaround for ARM erratum 1418040 Sep 9 00:36:03.712513 kernel: CPU2: Booted secondary processor 0x0000000002 [0x413fd0c1] Sep 9 00:36:03.712519 kernel: Detected PIPT I-cache on CPU3 Sep 9 00:36:03.712527 kernel: GICv3: CPU3: found redistributor 3 region 0:0x0000000008100000 Sep 9 00:36:03.712534 kernel: GICv3: CPU3: using allocated LPI pending table @0x0000000040110000 Sep 9 00:36:03.712540 kernel: arch_timer: Enabling local workaround for ARM erratum 1418040 Sep 9 00:36:03.712547 kernel: CPU3: Booted secondary processor 0x0000000003 [0x413fd0c1] Sep 9 00:36:03.712557 kernel: smp: Brought up 1 node, 4 CPUs Sep 9 00:36:03.712565 kernel: SMP: Total of 4 processors activated. Sep 9 00:36:03.712572 kernel: CPU features: detected: 32-bit EL0 Support Sep 9 00:36:03.712579 kernel: CPU features: detected: Data cache clean to the PoU not required for I/D coherence Sep 9 00:36:03.712586 kernel: CPU features: detected: Common not Private translations Sep 9 00:36:03.712593 kernel: CPU features: detected: CRC32 instructions Sep 9 00:36:03.712600 kernel: CPU features: detected: RCpc load-acquire (LDAPR) Sep 9 00:36:03.712607 kernel: CPU features: detected: LSE atomic instructions Sep 9 00:36:03.712615 kernel: CPU features: detected: Privileged Access Never Sep 9 00:36:03.712622 kernel: CPU features: detected: RAS Extension Support Sep 9 00:36:03.712629 kernel: CPU features: detected: Speculative Store Bypassing Safe (SSBS) Sep 9 00:36:03.712635 kernel: CPU: All CPU(s) started at EL1 Sep 9 00:36:03.712642 kernel: alternatives: patching kernel code Sep 9 00:36:03.712650 kernel: devtmpfs: initialized Sep 9 00:36:03.712657 kernel: KASLR enabled Sep 9 00:36:03.712664 kernel: clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1911260446275000 ns Sep 9 00:36:03.712671 kernel: futex hash table entries: 1024 (order: 4, 65536 bytes, linear) Sep 9 00:36:03.712678 kernel: pinctrl core: initialized pinctrl subsystem Sep 9 00:36:03.712685 kernel: SMBIOS 3.0.0 present. Sep 9 00:36:03.712692 kernel: DMI: QEMU KVM Virtual Machine, BIOS 0.0.0 02/06/2015 Sep 9 00:36:03.712699 kernel: NET: Registered PF_NETLINK/PF_ROUTE protocol family Sep 9 00:36:03.712706 kernel: DMA: preallocated 512 KiB GFP_KERNEL pool for atomic allocations Sep 9 00:36:03.712714 kernel: DMA: preallocated 512 KiB GFP_KERNEL|GFP_DMA pool for atomic allocations Sep 9 00:36:03.712721 kernel: DMA: preallocated 512 KiB GFP_KERNEL|GFP_DMA32 pool for atomic allocations Sep 9 00:36:03.712728 kernel: audit: initializing netlink subsys (disabled) Sep 9 00:36:03.712735 kernel: audit: type=2000 audit(0.034:1): state=initialized audit_enabled=0 res=1 Sep 9 00:36:03.712742 kernel: thermal_sys: Registered thermal governor 'step_wise' Sep 9 00:36:03.712748 kernel: cpuidle: using governor menu Sep 9 00:36:03.712755 kernel: hw-breakpoint: found 6 breakpoint and 4 watchpoint registers. Sep 9 00:36:03.712762 kernel: ASID allocator initialised with 32768 entries Sep 9 00:36:03.712769 kernel: ACPI: bus type PCI registered Sep 9 00:36:03.712777 kernel: acpiphp: ACPI Hot Plug PCI Controller Driver version: 0.5 Sep 9 00:36:03.712784 kernel: Serial: AMBA PL011 UART driver Sep 9 00:36:03.712791 kernel: HugeTLB registered 1.00 GiB page size, pre-allocated 0 pages Sep 9 00:36:03.712798 kernel: HugeTLB registered 32.0 MiB page size, pre-allocated 0 pages Sep 9 00:36:03.712805 kernel: HugeTLB registered 2.00 MiB page size, pre-allocated 0 pages Sep 9 00:36:03.712812 kernel: HugeTLB registered 64.0 KiB page size, pre-allocated 0 pages Sep 9 00:36:03.712818 kernel: cryptd: max_cpu_qlen set to 1000 Sep 9 00:36:03.712825 kernel: alg: No test for fips(ansi_cprng) (fips_ansi_cprng) Sep 9 00:36:03.712832 kernel: ACPI: Added _OSI(Module Device) Sep 9 00:36:03.712841 kernel: ACPI: Added _OSI(Processor Device) Sep 9 00:36:03.712848 kernel: ACPI: Added _OSI(Processor Aggregator Device) Sep 9 00:36:03.712855 kernel: ACPI: Added _OSI(Linux-Dell-Video) Sep 9 00:36:03.712861 kernel: ACPI: Added _OSI(Linux-Lenovo-NV-HDMI-Audio) Sep 9 00:36:03.712868 kernel: ACPI: Added _OSI(Linux-HPI-Hybrid-Graphics) Sep 9 00:36:03.712875 kernel: ACPI: 1 ACPI AML tables successfully acquired and loaded Sep 9 00:36:03.712882 kernel: ACPI: Interpreter enabled Sep 9 00:36:03.712889 kernel: ACPI: Using GIC for interrupt routing Sep 9 00:36:03.712896 kernel: ACPI: MCFG table detected, 1 entries Sep 9 00:36:03.712904 kernel: ARMH0011:00: ttyAMA0 at MMIO 0x9000000 (irq = 12, base_baud = 0) is a SBSA Sep 9 00:36:03.712911 kernel: printk: console [ttyAMA0] enabled Sep 9 00:36:03.712917 kernel: ACPI: PCI Root Bridge [PCI0] (domain 0000 [bus 00-ff]) Sep 9 00:36:03.713044 kernel: acpi PNP0A08:00: _OSC: OS supports [ExtendedConfig ASPM ClockPM Segments MSI HPX-Type3] Sep 9 00:36:03.713112 kernel: acpi PNP0A08:00: _OSC: platform does not support [LTR] Sep 9 00:36:03.713184 kernel: acpi PNP0A08:00: _OSC: OS now controls [PCIeHotplug PME AER PCIeCapability] Sep 9 00:36:03.713247 kernel: acpi PNP0A08:00: ECAM area [mem 0x4010000000-0x401fffffff] reserved by PNP0C02:00 Sep 9 00:36:03.713310 kernel: acpi PNP0A08:00: ECAM at [mem 0x4010000000-0x401fffffff] for [bus 00-ff] Sep 9 00:36:03.713320 kernel: ACPI: Remapped I/O 0x000000003eff0000 to [io 0x0000-0xffff window] Sep 9 00:36:03.713327 kernel: PCI host bridge to bus 0000:00 Sep 9 00:36:03.713396 kernel: pci_bus 0000:00: root bus resource [mem 0x10000000-0x3efeffff window] Sep 9 00:36:03.713455 kernel: pci_bus 0000:00: root bus resource [io 0x0000-0xffff window] Sep 9 00:36:03.713511 kernel: pci_bus 0000:00: root bus resource [mem 0x8000000000-0xffffffffff window] Sep 9 00:36:03.713566 kernel: pci_bus 0000:00: root bus resource [bus 00-ff] Sep 9 00:36:03.713643 kernel: pci 0000:00:00.0: [1b36:0008] type 00 class 0x060000 Sep 9 00:36:03.713716 kernel: pci 0000:00:01.0: [1af4:1005] type 00 class 0x00ff00 Sep 9 00:36:03.713782 kernel: pci 0000:00:01.0: reg 0x10: [io 0x0000-0x001f] Sep 9 00:36:03.713846 kernel: pci 0000:00:01.0: reg 0x14: [mem 0x10000000-0x10000fff] Sep 9 00:36:03.713909 kernel: pci 0000:00:01.0: reg 0x20: [mem 0x8000000000-0x8000003fff 64bit pref] Sep 9 00:36:03.713983 kernel: pci 0000:00:01.0: BAR 4: assigned [mem 0x8000000000-0x8000003fff 64bit pref] Sep 9 00:36:03.714049 kernel: pci 0000:00:01.0: BAR 1: assigned [mem 0x10000000-0x10000fff] Sep 9 00:36:03.714116 kernel: pci 0000:00:01.0: BAR 0: assigned [io 0x1000-0x101f] Sep 9 00:36:03.714181 kernel: pci_bus 0000:00: resource 4 [mem 0x10000000-0x3efeffff window] Sep 9 00:36:03.714238 kernel: pci_bus 0000:00: resource 5 [io 0x0000-0xffff window] Sep 9 00:36:03.714296 kernel: pci_bus 0000:00: resource 6 [mem 0x8000000000-0xffffffffff window] Sep 9 00:36:03.714305 kernel: ACPI: PCI: Interrupt link GSI0 configured for IRQ 35 Sep 9 00:36:03.714312 kernel: ACPI: PCI: Interrupt link GSI1 configured for IRQ 36 Sep 9 00:36:03.714319 kernel: ACPI: PCI: Interrupt link GSI2 configured for IRQ 37 Sep 9 00:36:03.714326 kernel: ACPI: PCI: Interrupt link GSI3 configured for IRQ 38 Sep 9 00:36:03.714335 kernel: iommu: Default domain type: Translated Sep 9 00:36:03.714342 kernel: iommu: DMA domain TLB invalidation policy: strict mode Sep 9 00:36:03.714349 kernel: vgaarb: loaded Sep 9 00:36:03.714356 kernel: pps_core: LinuxPPS API ver. 1 registered Sep 9 00:36:03.714363 kernel: pps_core: Software ver. 5.3.6 - Copyright 2005-2007 Rodolfo Giometti Sep 9 00:36:03.714370 kernel: PTP clock support registered Sep 9 00:36:03.714377 kernel: Registered efivars operations Sep 9 00:36:03.714384 kernel: clocksource: Switched to clocksource arch_sys_counter Sep 9 00:36:03.714391 kernel: VFS: Disk quotas dquot_6.6.0 Sep 9 00:36:03.714399 kernel: VFS: Dquot-cache hash table entries: 512 (order 0, 4096 bytes) Sep 9 00:36:03.714406 kernel: pnp: PnP ACPI init Sep 9 00:36:03.714474 kernel: system 00:00: [mem 0x4010000000-0x401fffffff window] could not be reserved Sep 9 00:36:03.714484 kernel: pnp: PnP ACPI: found 1 devices Sep 9 00:36:03.714491 kernel: NET: Registered PF_INET protocol family Sep 9 00:36:03.714499 kernel: IP idents hash table entries: 65536 (order: 7, 524288 bytes, linear) Sep 9 00:36:03.714506 kernel: tcp_listen_portaddr_hash hash table entries: 2048 (order: 3, 32768 bytes, linear) Sep 9 00:36:03.714513 kernel: Table-perturb hash table entries: 65536 (order: 6, 262144 bytes, linear) Sep 9 00:36:03.714521 kernel: TCP established hash table entries: 32768 (order: 6, 262144 bytes, linear) Sep 9 00:36:03.714528 kernel: TCP bind hash table entries: 32768 (order: 7, 524288 bytes, linear) Sep 9 00:36:03.714535 kernel: TCP: Hash tables configured (established 32768 bind 32768) Sep 9 00:36:03.714542 kernel: UDP hash table entries: 2048 (order: 4, 65536 bytes, linear) Sep 9 00:36:03.714549 kernel: UDP-Lite hash table entries: 2048 (order: 4, 65536 bytes, linear) Sep 9 00:36:03.714556 kernel: NET: Registered PF_UNIX/PF_LOCAL protocol family Sep 9 00:36:03.714563 kernel: PCI: CLS 0 bytes, default 64 Sep 9 00:36:03.714570 kernel: hw perfevents: enabled with armv8_pmuv3_0 PMU driver, 7 counters available Sep 9 00:36:03.714577 kernel: kvm [1]: HYP mode not available Sep 9 00:36:03.714585 kernel: Initialise system trusted keyrings Sep 9 00:36:03.714592 kernel: workingset: timestamp_bits=39 max_order=20 bucket_order=0 Sep 9 00:36:03.714599 kernel: Key type asymmetric registered Sep 9 00:36:03.714606 kernel: Asymmetric key parser 'x509' registered Sep 9 00:36:03.714613 kernel: Block layer SCSI generic (bsg) driver version 0.4 loaded (major 249) Sep 9 00:36:03.714620 kernel: io scheduler mq-deadline registered Sep 9 00:36:03.714626 kernel: io scheduler kyber registered Sep 9 00:36:03.714633 kernel: io scheduler bfq registered Sep 9 00:36:03.714640 kernel: input: Power Button as /devices/LNXSYSTM:00/LNXSYBUS:00/PNP0C0C:00/input/input0 Sep 9 00:36:03.714648 kernel: ACPI: button: Power Button [PWRB] Sep 9 00:36:03.714656 kernel: ACPI: \_SB_.PCI0.GSI1: Enabled at IRQ 36 Sep 9 00:36:03.714719 kernel: virtio-pci 0000:00:01.0: enabling device (0005 -> 0007) Sep 9 00:36:03.714729 kernel: Serial: 8250/16550 driver, 4 ports, IRQ sharing enabled Sep 9 00:36:03.714736 kernel: thunder_xcv, ver 1.0 Sep 9 00:36:03.714742 kernel: thunder_bgx, ver 1.0 Sep 9 00:36:03.714749 kernel: nicpf, ver 1.0 Sep 9 00:36:03.714756 kernel: nicvf, ver 1.0 Sep 9 00:36:03.714827 kernel: rtc-efi rtc-efi.0: registered as rtc0 Sep 9 00:36:03.714889 kernel: rtc-efi rtc-efi.0: setting system clock to 2025-09-09T00:36:03 UTC (1757378163) Sep 9 00:36:03.714899 kernel: hid: raw HID events driver (C) Jiri Kosina Sep 9 00:36:03.714906 kernel: NET: Registered PF_INET6 protocol family Sep 9 00:36:03.714913 kernel: Segment Routing with IPv6 Sep 9 00:36:03.714919 kernel: In-situ OAM (IOAM) with IPv6 Sep 9 00:36:03.714927 kernel: NET: Registered PF_PACKET protocol family Sep 9 00:36:03.714933 kernel: Key type dns_resolver registered Sep 9 00:36:03.714940 kernel: registered taskstats version 1 Sep 9 00:36:03.714949 kernel: Loading compiled-in X.509 certificates Sep 9 00:36:03.714956 kernel: Loaded X.509 cert 'Kinvolk GmbH: Module signing key for 5.15.191-flatcar: 14b3f28443a1a4b809c7c0337ab8c3dc8fdb5252' Sep 9 00:36:03.715349 kernel: Key type .fscrypt registered Sep 9 00:36:03.715363 kernel: Key type fscrypt-provisioning registered Sep 9 00:36:03.715371 kernel: ima: No TPM chip found, activating TPM-bypass! Sep 9 00:36:03.715378 kernel: ima: Allocated hash algorithm: sha1 Sep 9 00:36:03.715385 kernel: ima: No architecture policies found Sep 9 00:36:03.715392 kernel: clk: Disabling unused clocks Sep 9 00:36:03.715399 kernel: Freeing unused kernel memory: 36416K Sep 9 00:36:03.715410 kernel: Run /init as init process Sep 9 00:36:03.715417 kernel: with arguments: Sep 9 00:36:03.715424 kernel: /init Sep 9 00:36:03.715431 kernel: with environment: Sep 9 00:36:03.715437 kernel: HOME=/ Sep 9 00:36:03.715444 kernel: TERM=linux Sep 9 00:36:03.715451 kernel: BOOT_IMAGE=/flatcar/vmlinuz-a Sep 9 00:36:03.715460 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) Sep 9 00:36:03.715470 systemd[1]: Detected virtualization kvm. Sep 9 00:36:03.715478 systemd[1]: Detected architecture arm64. Sep 9 00:36:03.715485 systemd[1]: Running in initrd. Sep 9 00:36:03.715493 systemd[1]: No hostname configured, using default hostname. Sep 9 00:36:03.715500 systemd[1]: Hostname set to . Sep 9 00:36:03.715507 systemd[1]: Initializing machine ID from VM UUID. Sep 9 00:36:03.715515 systemd[1]: Queued start job for default target initrd.target. Sep 9 00:36:03.715522 systemd[1]: Started systemd-ask-password-console.path. Sep 9 00:36:03.715531 systemd[1]: Reached target cryptsetup.target. Sep 9 00:36:03.715539 systemd[1]: Reached target paths.target. Sep 9 00:36:03.715546 systemd[1]: Reached target slices.target. Sep 9 00:36:03.715553 systemd[1]: Reached target swap.target. Sep 9 00:36:03.715561 systemd[1]: Reached target timers.target. Sep 9 00:36:03.715569 systemd[1]: Listening on iscsid.socket. Sep 9 00:36:03.715576 systemd[1]: Listening on iscsiuio.socket. Sep 9 00:36:03.715584 systemd[1]: Listening on systemd-journald-audit.socket. Sep 9 00:36:03.715592 systemd[1]: Listening on systemd-journald-dev-log.socket. Sep 9 00:36:03.715600 systemd[1]: Listening on systemd-journald.socket. Sep 9 00:36:03.715613 systemd[1]: Listening on systemd-networkd.socket. Sep 9 00:36:03.715621 systemd[1]: Listening on systemd-udevd-control.socket. Sep 9 00:36:03.715628 systemd[1]: Listening on systemd-udevd-kernel.socket. Sep 9 00:36:03.715636 systemd[1]: Reached target sockets.target. Sep 9 00:36:03.715643 systemd[1]: Starting kmod-static-nodes.service... Sep 9 00:36:03.715653 systemd[1]: Finished network-cleanup.service. Sep 9 00:36:03.715662 systemd[1]: Starting systemd-fsck-usr.service... Sep 9 00:36:03.715669 systemd[1]: Starting systemd-journald.service... Sep 9 00:36:03.715677 systemd[1]: Starting systemd-modules-load.service... Sep 9 00:36:03.715684 systemd[1]: Starting systemd-resolved.service... Sep 9 00:36:03.715694 systemd[1]: Starting systemd-vconsole-setup.service... Sep 9 00:36:03.715702 systemd[1]: Finished kmod-static-nodes.service. Sep 9 00:36:03.715710 systemd[1]: Finished systemd-fsck-usr.service. Sep 9 00:36:03.715717 systemd[1]: Starting systemd-tmpfiles-setup-dev.service... Sep 9 00:36:03.715727 systemd[1]: Finished systemd-vconsole-setup.service. Sep 9 00:36:03.715736 systemd[1]: Starting dracut-cmdline-ask.service... Sep 9 00:36:03.715744 systemd[1]: Finished systemd-tmpfiles-setup-dev.service. Sep 9 00:36:03.715754 systemd-journald[290]: Journal started Sep 9 00:36:03.715804 systemd-journald[290]: Runtime Journal (/run/log/journal/33e67a1b46624fa58932b540518f23ff) is 6.0M, max 48.7M, 42.6M free. Sep 9 00:36:03.698380 systemd-modules-load[291]: Inserted module 'overlay' Sep 9 00:36:03.719778 systemd[1]: Started systemd-journald.service. Sep 9 00:36:03.719796 kernel: audit: type=1130 audit(1757378163.717: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' Sep 9 00:36:03.717000 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' Sep 9 00:36:03.726033 kernel: bridge: filtering via arp/ip/ip6tables is no longer available by default. Update your scripts to load br_netfilter if you need this. Sep 9 00:36:03.726479 systemd[1]: Finished dracut-cmdline-ask.service. Sep 9 00:36:03.730285 kernel: audit: type=1130 audit(1757378163.727:3): 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' Sep 9 00:36:03.727000 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' Sep 9 00:36:03.729719 systemd-resolved[292]: Positive Trust Anchors: Sep 9 00:36:03.729725 systemd-resolved[292]: . IN DS 20326 8 2 e06d44b80b8f1d39a95c0b0d7c65d08458e880409bbc683457104237c7f8ec8d Sep 9 00:36:03.729752 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 Sep 9 00:36:03.738745 kernel: Bridge firewalling registered Sep 9 00:36:03.729871 systemd[1]: Starting dracut-cmdline.service... Sep 9 00:36:03.742987 kernel: audit: type=1130 audit(1757378163.740:4): 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' Sep 9 00:36:03.740000 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' Sep 9 00:36:03.733292 systemd-modules-load[291]: Inserted module 'br_netfilter' Sep 9 00:36:03.733935 systemd-resolved[292]: Defaulting to hostname 'linux'. Sep 9 00:36:03.735304 systemd[1]: Started systemd-resolved.service. Sep 9 00:36:03.740368 systemd[1]: Reached target nss-lookup.target. Sep 9 00:36:03.748147 dracut-cmdline[310]: dracut-dracut-053 Sep 9 00:36:03.750221 dracut-cmdline[310]: 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=32b3b664430ec28e33efa673a32f74eb733fc8145822fbe5ce810188f7f71923 Sep 9 00:36:03.754986 kernel: SCSI subsystem initialized Sep 9 00:36:03.761989 kernel: device-mapper: core: CONFIG_IMA_DISABLE_HTABLE is disabled. Duplicate IMA measurements will not be recorded in the IMA log. Sep 9 00:36:03.762022 kernel: device-mapper: uevent: version 1.0.3 Sep 9 00:36:03.762032 kernel: device-mapper: ioctl: 4.45.0-ioctl (2021-03-22) initialised: dm-devel@redhat.com Sep 9 00:36:03.765644 systemd-modules-load[291]: Inserted module 'dm_multipath' Sep 9 00:36:03.766398 systemd[1]: Finished systemd-modules-load.service. Sep 9 00:36:03.767000 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' Sep 9 00:36:03.771337 kernel: audit: type=1130 audit(1757378163.767:5): 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' Sep 9 00:36:03.770688 systemd[1]: Starting systemd-sysctl.service... Sep 9 00:36:03.777479 systemd[1]: Finished systemd-sysctl.service. Sep 9 00:36:03.777000 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' Sep 9 00:36:03.781212 kernel: audit: type=1130 audit(1757378163.777:6): 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' Sep 9 00:36:03.811992 kernel: Loading iSCSI transport class v2.0-870. Sep 9 00:36:03.823992 kernel: iscsi: registered transport (tcp) Sep 9 00:36:03.841077 kernel: iscsi: registered transport (qla4xxx) Sep 9 00:36:03.841131 kernel: QLogic iSCSI HBA Driver Sep 9 00:36:03.876315 systemd[1]: Finished dracut-cmdline.service. Sep 9 00:36:03.878000 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' Sep 9 00:36:03.879054 systemd[1]: Starting dracut-pre-udev.service... Sep 9 00:36:03.881872 kernel: audit: type=1130 audit(1757378163.878:7): 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' Sep 9 00:36:03.923016 kernel: raid6: neonx8 gen() 13706 MB/s Sep 9 00:36:03.939994 kernel: raid6: neonx8 xor() 10821 MB/s Sep 9 00:36:03.957003 kernel: raid6: neonx4 gen() 13457 MB/s Sep 9 00:36:03.974001 kernel: raid6: neonx4 xor() 11095 MB/s Sep 9 00:36:03.991002 kernel: raid6: neonx2 gen() 12941 MB/s Sep 9 00:36:04.008000 kernel: raid6: neonx2 xor() 10239 MB/s Sep 9 00:36:04.025003 kernel: raid6: neonx1 gen() 10557 MB/s Sep 9 00:36:04.042003 kernel: raid6: neonx1 xor() 8705 MB/s Sep 9 00:36:04.059007 kernel: raid6: int64x8 gen() 6266 MB/s Sep 9 00:36:04.076014 kernel: raid6: int64x8 xor() 3498 MB/s Sep 9 00:36:04.092986 kernel: raid6: int64x4 gen() 7212 MB/s Sep 9 00:36:04.110005 kernel: raid6: int64x4 xor() 3849 MB/s Sep 9 00:36:04.126997 kernel: raid6: int64x2 gen() 6150 MB/s Sep 9 00:36:04.143995 kernel: raid6: int64x2 xor() 3306 MB/s Sep 9 00:36:04.161001 kernel: raid6: int64x1 gen() 5041 MB/s Sep 9 00:36:04.178299 kernel: raid6: int64x1 xor() 2636 MB/s Sep 9 00:36:04.178345 kernel: raid6: using algorithm neonx8 gen() 13706 MB/s Sep 9 00:36:04.178365 kernel: raid6: .... xor() 10821 MB/s, rmw enabled Sep 9 00:36:04.178382 kernel: raid6: using neon recovery algorithm Sep 9 00:36:04.191227 kernel: xor: measuring software checksum speed Sep 9 00:36:04.191257 kernel: 8regs : 17224 MB/sec Sep 9 00:36:04.192292 kernel: 32regs : 20723 MB/sec Sep 9 00:36:04.192324 kernel: arm64_neon : 27908 MB/sec Sep 9 00:36:04.192342 kernel: xor: using function: arm64_neon (27908 MB/sec) Sep 9 00:36:04.244997 kernel: Btrfs loaded, crc32c=crc32c-generic, zoned=no, fsverity=no Sep 9 00:36:04.255000 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' Sep 9 00:36:04.255758 systemd[1]: Finished dracut-pre-udev.service. Sep 9 00:36:04.259003 kernel: audit: type=1130 audit(1757378164.255:8): 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' Sep 9 00:36:04.258000 audit: BPF prog-id=7 op=LOAD Sep 9 00:36:04.258000 audit: BPF prog-id=8 op=LOAD Sep 9 00:36:04.260286 systemd[1]: Starting systemd-udevd.service... Sep 9 00:36:04.263217 kernel: audit: type=1334 audit(1757378164.258:9): prog-id=7 op=LOAD Sep 9 00:36:04.263234 kernel: audit: type=1334 audit(1757378164.258:10): prog-id=8 op=LOAD Sep 9 00:36:04.275398 systemd-udevd[493]: Using default interface naming scheme 'v252'. Sep 9 00:36:04.278881 systemd[1]: Started systemd-udevd.service. Sep 9 00:36:04.279000 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' Sep 9 00:36:04.286220 systemd[1]: Starting dracut-pre-trigger.service... Sep 9 00:36:04.300234 dracut-pre-trigger[509]: rd.md=0: removing MD RAID activation Sep 9 00:36:04.332419 systemd[1]: Finished dracut-pre-trigger.service. Sep 9 00:36:04.333000 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' Sep 9 00:36:04.333788 systemd[1]: Starting systemd-udev-trigger.service... Sep 9 00:36:04.366000 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' Sep 9 00:36:04.366513 systemd[1]: Finished systemd-udev-trigger.service. Sep 9 00:36:04.410201 kernel: virtio_blk virtio1: [vda] 9289728 512-byte logical blocks (4.76 GB/4.43 GiB) Sep 9 00:36:04.414013 kernel: vda: vda1 vda2 vda3 vda4 vda6 vda7 vda9 Sep 9 00:36:04.434983 kernel: BTRFS: device label OEM devid 1 transid 9 /dev/vda6 scanned by (udev-worker) (544) Sep 9 00:36:04.436119 systemd[1]: Found device dev-disk-by\x2dlabel-EFI\x2dSYSTEM.device. Sep 9 00:36:04.447807 systemd[1]: Found device dev-disk-by\x2dlabel-ROOT.device. Sep 9 00:36:04.450458 systemd[1]: Found device dev-disk-by\x2dpartuuid-7130c94a\x2d213a\x2d4e5a\x2d8e26\x2d6cce9662f132.device. Sep 9 00:36:04.451370 systemd[1]: Found device dev-disk-by\x2dpartlabel-USR\x2dA.device. Sep 9 00:36:04.456267 systemd[1]: Found device dev-disk-by\x2dlabel-OEM.device. Sep 9 00:36:04.457696 systemd[1]: Starting disk-uuid.service... Sep 9 00:36:04.468982 kernel: vda: vda1 vda2 vda3 vda4 vda6 vda7 vda9 Sep 9 00:36:04.472980 kernel: vda: vda1 vda2 vda3 vda4 vda6 vda7 vda9 Sep 9 00:36:04.475983 kernel: vda: vda1 vda2 vda3 vda4 vda6 vda7 vda9 Sep 9 00:36:05.479019 kernel: vda: vda1 vda2 vda3 vda4 vda6 vda7 vda9 Sep 9 00:36:05.480363 disk-uuid[565]: The operation has completed successfully. Sep 9 00:36:05.514518 systemd[1]: disk-uuid.service: Deactivated successfully. Sep 9 00:36:05.514000 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' Sep 9 00:36:05.514000 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' Sep 9 00:36:05.514617 systemd[1]: Finished disk-uuid.service. Sep 9 00:36:05.516901 systemd[1]: Starting verity-setup.service... Sep 9 00:36:05.538063 kernel: device-mapper: verity: sha256 using implementation "sha256-ce" Sep 9 00:36:05.574647 systemd[1]: Found device dev-mapper-usr.device. Sep 9 00:36:05.576261 systemd[1]: Mounting sysusr-usr.mount... Sep 9 00:36:05.578916 systemd[1]: Finished verity-setup.service. Sep 9 00:36:05.577000 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' Sep 9 00:36:05.628197 kernel: EXT4-fs (dm-0): mounted filesystem without journal. Opts: norecovery. Quota mode: none. Sep 9 00:36:05.628499 systemd[1]: Mounted sysusr-usr.mount. Sep 9 00:36:05.629351 systemd[1]: afterburn-network-kargs.service was skipped because no trigger condition checks were met. Sep 9 00:36:05.630669 systemd[1]: Starting ignition-setup.service... Sep 9 00:36:05.631927 systemd[1]: Starting parse-ip-for-networkd.service... Sep 9 00:36:05.644224 kernel: BTRFS info (device vda6): using crc32c (crc32c-generic) checksum algorithm Sep 9 00:36:05.644260 kernel: BTRFS info (device vda6): using free space tree Sep 9 00:36:05.644270 kernel: BTRFS info (device vda6): has skinny extents Sep 9 00:36:05.655781 systemd[1]: mnt-oem.mount: Deactivated successfully. Sep 9 00:36:05.664033 systemd[1]: Finished ignition-setup.service. Sep 9 00:36:05.665444 systemd[1]: Starting ignition-fetch-offline.service... Sep 9 00:36:05.663000 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' Sep 9 00:36:05.729213 systemd[1]: Finished parse-ip-for-networkd.service. Sep 9 00:36:05.731501 systemd[1]: Starting systemd-networkd.service... Sep 9 00:36:05.728000 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' Sep 9 00:36:05.729000 audit: BPF prog-id=9 op=LOAD Sep 9 00:36:05.756082 ignition[664]: Ignition 2.14.0 Sep 9 00:36:05.756810 ignition[664]: Stage: fetch-offline Sep 9 00:36:05.757417 ignition[664]: no configs at "/usr/lib/ignition/base.d" Sep 9 00:36:05.758106 ignition[664]: no config dir at "/usr/lib/ignition/base.platform.d/qemu" Sep 9 00:36:05.759101 ignition[664]: parsed url from cmdline: "" Sep 9 00:36:05.759163 ignition[664]: no config URL provided Sep 9 00:36:05.759703 ignition[664]: reading system config file "/usr/lib/ignition/user.ign" Sep 9 00:36:05.760420 ignition[664]: no config at "/usr/lib/ignition/user.ign" Sep 9 00:36:05.760441 ignition[664]: op(1): [started] loading QEMU firmware config module Sep 9 00:36:05.760446 ignition[664]: op(1): executing: "modprobe" "qemu_fw_cfg" Sep 9 00:36:05.763287 systemd-networkd[740]: lo: Link UP Sep 9 00:36:05.763295 systemd-networkd[740]: lo: Gained carrier Sep 9 00:36:05.764000 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' Sep 9 00:36:05.763685 systemd-networkd[740]: Enumeration completed Sep 9 00:36:05.763865 systemd-networkd[740]: eth0: Configuring with /usr/lib/systemd/network/zz-default.network. Sep 9 00:36:05.764107 systemd[1]: Started systemd-networkd.service. Sep 9 00:36:05.769233 ignition[664]: op(1): [finished] loading QEMU firmware config module Sep 9 00:36:05.765298 systemd-networkd[740]: eth0: Link UP Sep 9 00:36:05.765301 systemd-networkd[740]: eth0: Gained carrier Sep 9 00:36:05.765539 systemd[1]: Reached target network.target. Sep 9 00:36:05.768309 systemd[1]: Starting iscsiuio.service... Sep 9 00:36:05.775535 ignition[664]: parsing config with SHA512: 0ba776a11b8fc1d1e5ccbdb518de9dfc7c9ba599c6ff97f00ba1be09a3b49057859cf0da547a39fe2ece4017c4e63b700fc010a0465ae78f17dc075b60b8d85d Sep 9 00:36:05.775881 systemd[1]: Started iscsiuio.service. Sep 9 00:36:05.777460 systemd[1]: Starting iscsid.service... Sep 9 00:36:05.775000 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' Sep 9 00:36:05.779038 systemd-networkd[740]: eth0: DHCPv4 address 10.0.0.89/16, gateway 10.0.0.1 acquired from 10.0.0.1 Sep 9 00:36:05.780854 iscsid[747]: iscsid: can't open InitiatorName configuration file /etc/iscsi/initiatorname.iscsi Sep 9 00:36:05.780854 iscsid[747]: 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]. Sep 9 00:36:05.780854 iscsid[747]: Example: InitiatorName=iqn.2001-04.com.redhat:fc6. Sep 9 00:36:05.780854 iscsid[747]: If using hardware iscsi like qla4xxx this message can be ignored. Sep 9 00:36:05.780854 iscsid[747]: iscsid: can't open InitiatorAlias configuration file /etc/iscsi/initiatorname.iscsi Sep 9 00:36:05.780854 iscsid[747]: iscsid: can't open iscsid.safe_logout configuration file /etc/iscsi/iscsid.conf Sep 9 00:36:05.786000 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' Sep 9 00:36:05.783918 systemd[1]: Started iscsid.service. Sep 9 00:36:05.788236 systemd[1]: Starting dracut-initqueue.service... Sep 9 00:36:05.798938 systemd[1]: Finished dracut-initqueue.service. Sep 9 00:36:05.799773 systemd[1]: Reached target remote-fs-pre.target. Sep 9 00:36:05.800863 systemd[1]: Reached target remote-cryptsetup.target. Sep 9 00:36:05.798000 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' Sep 9 00:36:05.802173 systemd[1]: Reached target remote-fs.target. Sep 9 00:36:05.804247 systemd[1]: Starting dracut-pre-mount.service... Sep 9 00:36:05.806795 ignition[664]: fetch-offline: fetch-offline passed Sep 9 00:36:05.806607 unknown[664]: fetched base config from "system" Sep 9 00:36:05.806855 ignition[664]: Ignition finished successfully Sep 9 00:36:05.806614 unknown[664]: fetched user config from "qemu" Sep 9 00:36:05.810000 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' Sep 9 00:36:05.809592 systemd[1]: Finished ignition-fetch-offline.service. Sep 9 00:36:05.810577 systemd[1]: ignition-fetch.service was skipped because of an unmet condition check (ConditionPathExists=!/run/ignition.json). Sep 9 00:36:05.811283 systemd[1]: Starting ignition-kargs.service... Sep 9 00:36:05.814000 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' Sep 9 00:36:05.813393 systemd[1]: Finished dracut-pre-mount.service. Sep 9 00:36:05.821591 ignition[761]: Ignition 2.14.0 Sep 9 00:36:05.821600 ignition[761]: Stage: kargs Sep 9 00:36:05.821693 ignition[761]: no configs at "/usr/lib/ignition/base.d" Sep 9 00:36:05.823609 systemd[1]: Finished ignition-kargs.service. Sep 9 00:36:05.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' Sep 9 00:36:05.821702 ignition[761]: no config dir at "/usr/lib/ignition/base.platform.d/qemu" Sep 9 00:36:05.822332 ignition[761]: kargs: kargs passed Sep 9 00:36:05.825622 systemd[1]: Starting ignition-disks.service... Sep 9 00:36:05.822371 ignition[761]: Ignition finished successfully Sep 9 00:36:05.831767 ignition[767]: Ignition 2.14.0 Sep 9 00:36:05.831776 ignition[767]: Stage: disks Sep 9 00:36:05.831866 ignition[767]: no configs at "/usr/lib/ignition/base.d" Sep 9 00:36:05.831876 ignition[767]: no config dir at "/usr/lib/ignition/base.platform.d/qemu" Sep 9 00:36:05.834000 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' Sep 9 00:36:05.833312 systemd[1]: Finished ignition-disks.service. Sep 9 00:36:05.832487 ignition[767]: disks: disks passed Sep 9 00:36:05.834378 systemd[1]: Reached target initrd-root-device.target. Sep 9 00:36:05.832522 ignition[767]: Ignition finished successfully Sep 9 00:36:05.835739 systemd[1]: Reached target local-fs-pre.target. Sep 9 00:36:05.836879 systemd[1]: Reached target local-fs.target. Sep 9 00:36:05.837932 systemd[1]: Reached target sysinit.target. Sep 9 00:36:05.839436 systemd[1]: Reached target basic.target. Sep 9 00:36:05.841390 systemd[1]: Starting systemd-fsck-root.service... Sep 9 00:36:05.853405 systemd-fsck[775]: ROOT: clean, 629/553520 files, 56027/553472 blocks Sep 9 00:36:05.858410 systemd[1]: Finished systemd-fsck-root.service. Sep 9 00:36:05.859000 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' Sep 9 00:36:05.860268 systemd[1]: Mounting sysroot.mount... Sep 9 00:36:05.866787 systemd[1]: Mounted sysroot.mount. Sep 9 00:36:05.867893 kernel: EXT4-fs (vda9): mounted filesystem with ordered data mode. Opts: (null). Quota mode: none. Sep 9 00:36:05.867559 systemd[1]: Reached target initrd-root-fs.target. Sep 9 00:36:05.869743 systemd[1]: Mounting sysroot-usr.mount... Sep 9 00:36:05.870541 systemd[1]: flatcar-metadata-hostname.service was skipped because no trigger condition checks were met. Sep 9 00:36:05.870579 systemd[1]: ignition-remount-sysroot.service was skipped because of an unmet condition check (ConditionPathIsReadWrite=!/sysroot). Sep 9 00:36:05.870601 systemd[1]: Reached target ignition-diskful.target. Sep 9 00:36:05.872228 systemd[1]: Mounted sysroot-usr.mount. Sep 9 00:36:05.873830 systemd[1]: Starting initrd-setup-root.service... Sep 9 00:36:05.877908 initrd-setup-root[785]: cut: /sysroot/etc/passwd: No such file or directory Sep 9 00:36:05.882484 initrd-setup-root[793]: cut: /sysroot/etc/group: No such file or directory Sep 9 00:36:05.886265 initrd-setup-root[801]: cut: /sysroot/etc/shadow: No such file or directory Sep 9 00:36:05.890028 initrd-setup-root[809]: cut: /sysroot/etc/gshadow: No such file or directory Sep 9 00:36:05.925262 systemd[1]: Finished initrd-setup-root.service. Sep 9 00:36:05.925000 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' Sep 9 00:36:05.926885 systemd[1]: Starting ignition-mount.service... Sep 9 00:36:05.928473 systemd[1]: Starting sysroot-boot.service... Sep 9 00:36:05.932167 bash[826]: umount: /sysroot/usr/share/oem: not mounted. Sep 9 00:36:05.940422 ignition[827]: INFO : Ignition 2.14.0 Sep 9 00:36:05.940422 ignition[827]: INFO : Stage: mount Sep 9 00:36:05.941636 ignition[827]: INFO : no configs at "/usr/lib/ignition/base.d" Sep 9 00:36:05.941636 ignition[827]: INFO : no config dir at "/usr/lib/ignition/base.platform.d/qemu" Sep 9 00:36:05.941636 ignition[827]: INFO : mount: mount passed Sep 9 00:36:05.941636 ignition[827]: INFO : Ignition finished successfully Sep 9 00:36:05.942000 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' Sep 9 00:36:05.941796 systemd[1]: Finished ignition-mount.service. Sep 9 00:36:05.948667 systemd[1]: Finished sysroot-boot.service. Sep 9 00:36:05.948000 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' Sep 9 00:36:06.591541 systemd[1]: Mounting sysroot-usr-share-oem.mount... Sep 9 00:36:06.600328 kernel: BTRFS: device label OEM devid 1 transid 10 /dev/vda6 scanned by mount (838) Sep 9 00:36:06.600376 kernel: BTRFS info (device vda6): using crc32c (crc32c-generic) checksum algorithm Sep 9 00:36:06.600392 kernel: BTRFS info (device vda6): using free space tree Sep 9 00:36:06.601022 kernel: BTRFS info (device vda6): has skinny extents Sep 9 00:36:06.605211 systemd[1]: Mounted sysroot-usr-share-oem.mount. Sep 9 00:36:06.606682 systemd[1]: Starting ignition-files.service... Sep 9 00:36:06.620600 ignition[858]: INFO : Ignition 2.14.0 Sep 9 00:36:06.620600 ignition[858]: INFO : Stage: files Sep 9 00:36:06.622584 ignition[858]: INFO : no configs at "/usr/lib/ignition/base.d" Sep 9 00:36:06.622584 ignition[858]: INFO : no config dir at "/usr/lib/ignition/base.platform.d/qemu" Sep 9 00:36:06.622584 ignition[858]: DEBUG : files: compiled without relabeling support, skipping Sep 9 00:36:06.622584 ignition[858]: INFO : files: ensureUsers: op(1): [started] creating or modifying user "core" Sep 9 00:36:06.622584 ignition[858]: DEBUG : files: ensureUsers: op(1): executing: "usermod" "--root" "/sysroot" "core" Sep 9 00:36:06.628437 ignition[858]: INFO : files: ensureUsers: op(1): [finished] creating or modifying user "core" Sep 9 00:36:06.628437 ignition[858]: INFO : files: ensureUsers: op(2): [started] adding ssh keys to user "core" Sep 9 00:36:06.628437 ignition[858]: INFO : files: ensureUsers: op(2): [finished] adding ssh keys to user "core" Sep 9 00:36:06.625119 unknown[858]: wrote ssh authorized keys file for user: core Sep 9 00:36:06.634088 ignition[858]: INFO : files: createFilesystemsFiles: createFiles: op(3): [started] writing file "/sysroot/etc/flatcar/update.conf" Sep 9 00:36:06.634088 ignition[858]: INFO : files: createFilesystemsFiles: createFiles: op(3): [finished] writing file "/sysroot/etc/flatcar/update.conf" Sep 9 00:36:06.634088 ignition[858]: INFO : files: op(4): [started] processing unit "etcd-member.service" Sep 9 00:36:06.634088 ignition[858]: INFO : files: op(4): op(5): [started] writing systemd drop-in "20-clct-etcd-member.conf" at "/sysroot/etc/systemd/system/etcd-member.service.d/20-clct-etcd-member.conf" Sep 9 00:36:06.634088 ignition[858]: INFO : files: op(4): op(5): [finished] writing systemd drop-in "20-clct-etcd-member.conf" at "/sysroot/etc/systemd/system/etcd-member.service.d/20-clct-etcd-member.conf" Sep 9 00:36:06.634088 ignition[858]: INFO : files: op(4): [finished] processing unit "etcd-member.service" Sep 9 00:36:06.634088 ignition[858]: INFO : files: op(6): [started] processing unit "coreos-metadata.service" Sep 9 00:36:06.634088 ignition[858]: INFO : files: op(6): op(7): [started] writing unit "coreos-metadata.service" at "/sysroot/etc/systemd/system/coreos-metadata.service" Sep 9 00:36:06.634088 ignition[858]: INFO : files: op(6): op(7): [finished] writing unit "coreos-metadata.service" at "/sysroot/etc/systemd/system/coreos-metadata.service" Sep 9 00:36:06.634088 ignition[858]: INFO : files: op(6): [finished] processing unit "coreos-metadata.service" Sep 9 00:36:06.634088 ignition[858]: INFO : files: op(8): [started] setting preset to enabled for "etcd-member.service" Sep 9 00:36:06.634088 ignition[858]: INFO : files: op(8): [finished] setting preset to enabled for "etcd-member.service" Sep 9 00:36:06.634088 ignition[858]: INFO : files: op(9): [started] setting preset to disabled for "coreos-metadata.service" Sep 9 00:36:06.634088 ignition[858]: INFO : files: op(9): op(a): [started] removing enablement symlink(s) for "coreos-metadata.service" Sep 9 00:36:06.674407 ignition[858]: INFO : files: op(9): op(a): [finished] removing enablement symlink(s) for "coreos-metadata.service" Sep 9 00:36:06.676000 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' Sep 9 00:36:06.679990 ignition[858]: INFO : files: op(9): [finished] setting preset to disabled for "coreos-metadata.service" Sep 9 00:36:06.679990 ignition[858]: INFO : files: createResultFile: createFiles: op(b): [started] writing file "/sysroot/etc/.ignition-result.json" Sep 9 00:36:06.679990 ignition[858]: INFO : files: createResultFile: createFiles: op(b): [finished] writing file "/sysroot/etc/.ignition-result.json" Sep 9 00:36:06.679990 ignition[858]: INFO : files: files passed Sep 9 00:36:06.679990 ignition[858]: INFO : Ignition finished successfully Sep 9 00:36:06.682000 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' Sep 9 00:36:06.682000 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' Sep 9 00:36:06.676424 systemd[1]: Finished ignition-files.service. Sep 9 00:36:06.677802 systemd[1]: Starting initrd-setup-root-after-ignition.service... Sep 9 00:36:06.687000 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' Sep 9 00:36:06.690434 initrd-setup-root-after-ignition[882]: grep: /sysroot/usr/share/oem/oem-release: No such file or directory Sep 9 00:36:06.678550 systemd[1]: torcx-profile-populate.service was skipped because of an unmet condition check (ConditionPathExists=/sysroot/etc/torcx/next-profile). Sep 9 00:36:06.693303 initrd-setup-root-after-ignition[884]: grep: /sysroot/etc/flatcar/enabled-sysext.conf: No such file or directory Sep 9 00:36:06.679269 systemd[1]: Starting ignition-quench.service... Sep 9 00:36:06.682478 systemd[1]: ignition-quench.service: Deactivated successfully. Sep 9 00:36:06.682551 systemd[1]: Finished ignition-quench.service. Sep 9 00:36:06.687613 systemd[1]: Finished initrd-setup-root-after-ignition.service. Sep 9 00:36:06.688453 systemd[1]: Reached target ignition-complete.target. Sep 9 00:36:06.689692 systemd[1]: Starting initrd-parse-etc.service... Sep 9 00:36:06.703821 systemd[1]: initrd-parse-etc.service: Deactivated successfully. Sep 9 00:36:06.703911 systemd[1]: Finished initrd-parse-etc.service. Sep 9 00:36:06.705000 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' Sep 9 00:36:06.705000 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' Sep 9 00:36:06.705453 systemd[1]: Reached target initrd-fs.target. Sep 9 00:36:06.706539 systemd[1]: Reached target initrd.target. Sep 9 00:36:06.707677 systemd[1]: dracut-mount.service was skipped because no trigger condition checks were met. Sep 9 00:36:06.708390 systemd[1]: Starting dracut-pre-pivot.service... Sep 9 00:36:06.718545 systemd[1]: Finished dracut-pre-pivot.service. Sep 9 00:36:06.719000 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' Sep 9 00:36:06.719852 systemd[1]: Starting initrd-cleanup.service... Sep 9 00:36:06.727944 systemd[1]: Stopped target nss-lookup.target. Sep 9 00:36:06.728904 systemd[1]: Stopped target remote-cryptsetup.target. Sep 9 00:36:06.730367 systemd[1]: Stopped target timers.target. Sep 9 00:36:06.731430 systemd[1]: dracut-pre-pivot.service: Deactivated successfully. Sep 9 00:36:06.731000 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' Sep 9 00:36:06.731533 systemd[1]: Stopped dracut-pre-pivot.service. Sep 9 00:36:06.732737 systemd[1]: Stopped target initrd.target. Sep 9 00:36:06.734044 systemd[1]: Stopped target basic.target. Sep 9 00:36:06.735167 systemd[1]: Stopped target ignition-complete.target. Sep 9 00:36:06.736338 systemd[1]: Stopped target ignition-diskful.target. Sep 9 00:36:06.737501 systemd[1]: Stopped target initrd-root-device.target. Sep 9 00:36:06.738874 systemd[1]: Stopped target remote-fs.target. Sep 9 00:36:06.740534 systemd[1]: Stopped target remote-fs-pre.target. Sep 9 00:36:06.741728 systemd[1]: Stopped target sysinit.target. Sep 9 00:36:06.742824 systemd[1]: Stopped target local-fs.target. Sep 9 00:36:06.743955 systemd[1]: Stopped target local-fs-pre.target. Sep 9 00:36:06.745142 systemd[1]: Stopped target swap.target. Sep 9 00:36:06.746000 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' Sep 9 00:36:06.746456 systemd[1]: dracut-pre-mount.service: Deactivated successfully. Sep 9 00:36:06.746564 systemd[1]: Stopped dracut-pre-mount.service. Sep 9 00:36:06.750000 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' Sep 9 00:36:06.747876 systemd[1]: Stopped target cryptsetup.target. Sep 9 00:36:06.751000 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' Sep 9 00:36:06.748757 systemd[1]: dracut-initqueue.service: Deactivated successfully. Sep 9 00:36:06.748855 systemd[1]: Stopped dracut-initqueue.service. Sep 9 00:36:06.750241 systemd[1]: ignition-fetch-offline.service: Deactivated successfully. Sep 9 00:36:06.750331 systemd[1]: Stopped ignition-fetch-offline.service. Sep 9 00:36:06.751749 systemd[1]: Stopped target paths.target. Sep 9 00:36:06.752932 systemd[1]: systemd-ask-password-console.path: Deactivated successfully. Sep 9 00:36:06.757026 systemd[1]: Stopped systemd-ask-password-console.path. Sep 9 00:36:06.758598 systemd[1]: Stopped target slices.target. Sep 9 00:36:06.759755 systemd[1]: Stopped target sockets.target. Sep 9 00:36:06.760974 systemd[1]: initrd-setup-root-after-ignition.service: Deactivated successfully. Sep 9 00:36:06.762000 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' Sep 9 00:36:06.761089 systemd[1]: Stopped initrd-setup-root-after-ignition.service. Sep 9 00:36:06.763000 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' Sep 9 00:36:06.762225 systemd[1]: ignition-files.service: Deactivated successfully. Sep 9 00:36:06.762312 systemd[1]: Stopped ignition-files.service. Sep 9 00:36:06.766503 systemd[1]: Stopping ignition-mount.service... Sep 9 00:36:06.767194 systemd[1]: Stopping iscsid.service... Sep 9 00:36:06.768626 iscsid[747]: iscsid shutting down. Sep 9 00:36:06.768051 systemd[1]: kmod-static-nodes.service: Deactivated successfully. Sep 9 00:36:06.770195 systemd[1]: Stopped kmod-static-nodes.service. Sep 9 00:36:06.770000 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' Sep 9 00:36:06.771607 systemd[1]: Stopping sysroot-boot.service... Sep 9 00:36:06.773461 systemd[1]: systemd-udev-trigger.service: Deactivated successfully. Sep 9 00:36:06.774000 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' Sep 9 00:36:06.775635 ignition[897]: INFO : Ignition 2.14.0 Sep 9 00:36:06.775635 ignition[897]: INFO : Stage: umount Sep 9 00:36:06.775635 ignition[897]: INFO : no configs at "/usr/lib/ignition/base.d" Sep 9 00:36:06.775635 ignition[897]: INFO : no config dir at "/usr/lib/ignition/base.platform.d/qemu" Sep 9 00:36:06.775635 ignition[897]: INFO : umount: umount passed Sep 9 00:36:06.775635 ignition[897]: INFO : Ignition finished successfully Sep 9 00:36:06.776000 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' Sep 9 00:36:06.779000 audit[1]: SERVICE_STOP 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' Sep 9 00:36:06.781000 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' Sep 9 00:36:06.773589 systemd[1]: Stopped systemd-udev-trigger.service. Sep 9 00:36:06.783000 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' Sep 9 00:36:06.774775 systemd[1]: dracut-pre-trigger.service: Deactivated successfully. Sep 9 00:36:06.784000 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' Sep 9 00:36:06.774862 systemd[1]: Stopped dracut-pre-trigger.service. Sep 9 00:36:06.786000 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' Sep 9 00:36:06.777893 systemd[1]: iscsid.service: Deactivated successfully. Sep 9 00:36:06.778013 systemd[1]: Stopped iscsid.service. Sep 9 00:36:06.779812 systemd[1]: ignition-mount.service: Deactivated successfully. Sep 9 00:36:06.779906 systemd[1]: Stopped ignition-mount.service. Sep 9 00:36:06.790000 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' Sep 9 00:36:06.790000 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' Sep 9 00:36:06.781511 systemd[1]: iscsid.socket: Deactivated successfully. Sep 9 00:36:06.792000 audit[1]: SERVICE_STOP 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' Sep 9 00:36:06.781577 systemd[1]: Closed iscsid.socket. Sep 9 00:36:06.793000 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' Sep 9 00:36:06.782720 systemd[1]: ignition-disks.service: Deactivated successfully. Sep 9 00:36:06.782761 systemd[1]: Stopped ignition-disks.service. Sep 9 00:36:06.784037 systemd[1]: ignition-kargs.service: Deactivated successfully. Sep 9 00:36:06.784073 systemd[1]: Stopped ignition-kargs.service. Sep 9 00:36:06.798000 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' Sep 9 00:36:06.785545 systemd[1]: ignition-setup.service: Deactivated successfully. Sep 9 00:36:06.785580 systemd[1]: Stopped ignition-setup.service. Sep 9 00:36:06.787247 systemd[1]: Stopping iscsiuio.service... Sep 9 00:36:06.789086 systemd[1]: sysroot-boot.mount: Deactivated successfully. Sep 9 00:36:06.789779 systemd[1]: initrd-cleanup.service: Deactivated successfully. Sep 9 00:36:06.789858 systemd[1]: Finished initrd-cleanup.service. Sep 9 00:36:06.804000 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' Sep 9 00:36:06.791229 systemd[1]: iscsiuio.service: Deactivated successfully. Sep 9 00:36:06.791309 systemd[1]: Stopped iscsiuio.service. Sep 9 00:36:06.792399 systemd[1]: sysroot-boot.service: Deactivated successfully. Sep 9 00:36:06.809000 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' Sep 9 00:36:06.792477 systemd[1]: Stopped sysroot-boot.service. Sep 9 00:36:06.809000 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' Sep 9 00:36:06.794469 systemd[1]: Stopped target network.target. Sep 9 00:36:06.811000 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' Sep 9 00:36:06.795585 systemd[1]: iscsiuio.socket: Deactivated successfully. Sep 9 00:36:06.795620 systemd[1]: Closed iscsiuio.socket. Sep 9 00:36:06.796660 systemd[1]: initrd-setup-root.service: Deactivated successfully. Sep 9 00:36:06.796696 systemd[1]: Stopped initrd-setup-root.service. Sep 9 00:36:06.817000 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' Sep 9 00:36:06.798211 systemd[1]: Stopping systemd-networkd.service... Sep 9 00:36:06.799362 systemd[1]: Stopping systemd-resolved.service... Sep 9 00:36:06.802003 systemd-networkd[740]: eth0: DHCPv6 lease lost Sep 9 00:36:06.819000 audit: BPF prog-id=9 op=UNLOAD Sep 9 00:36:06.803028 systemd[1]: systemd-networkd.service: Deactivated successfully. Sep 9 00:36:06.821000 audit: BPF prog-id=6 op=UNLOAD Sep 9 00:36:06.821000 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' Sep 9 00:36:06.803119 systemd[1]: Stopped systemd-networkd.service. Sep 9 00:36:06.822000 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' Sep 9 00:36:06.804705 systemd[1]: systemd-networkd.socket: Deactivated successfully. Sep 9 00:36:06.804732 systemd[1]: Closed systemd-networkd.socket. Sep 9 00:36:06.806212 systemd[1]: Stopping network-cleanup.service... Sep 9 00:36:06.826000 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' Sep 9 00:36:06.808154 systemd[1]: parse-ip-for-networkd.service: Deactivated successfully. Sep 9 00:36:06.827000 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' Sep 9 00:36:06.808204 systemd[1]: Stopped parse-ip-for-networkd.service. Sep 9 00:36:06.829000 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' Sep 9 00:36:06.809302 systemd[1]: systemd-sysctl.service: Deactivated successfully. Sep 9 00:36:06.809336 systemd[1]: Stopped systemd-sysctl.service. Sep 9 00:36:06.832000 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' Sep 9 00:36:06.811309 systemd[1]: systemd-modules-load.service: Deactivated successfully. Sep 9 00:36:06.811345 systemd[1]: Stopped systemd-modules-load.service. Sep 9 00:36:06.812038 systemd[1]: Stopping systemd-udevd.service... Sep 9 00:36:06.815558 systemd[1]: run-credentials-systemd\x2dsysctl.service.mount: Deactivated successfully. Sep 9 00:36:06.835000 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' Sep 9 00:36:06.835000 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' Sep 9 00:36:06.816066 systemd[1]: systemd-resolved.service: Deactivated successfully. Sep 9 00:36:06.816161 systemd[1]: Stopped systemd-resolved.service. Sep 9 00:36:06.820235 systemd[1]: network-cleanup.service: Deactivated successfully. Sep 9 00:36:06.820320 systemd[1]: Stopped network-cleanup.service. Sep 9 00:36:06.821641 systemd[1]: systemd-udevd.service: Deactivated successfully. Sep 9 00:36:06.821747 systemd[1]: Stopped systemd-udevd.service. Sep 9 00:36:06.823069 systemd[1]: systemd-udevd-control.socket: Deactivated successfully. Sep 9 00:36:06.823101 systemd[1]: Closed systemd-udevd-control.socket. Sep 9 00:36:06.824153 systemd[1]: systemd-udevd-kernel.socket: Deactivated successfully. Sep 9 00:36:06.824182 systemd[1]: Closed systemd-udevd-kernel.socket. Sep 9 00:36:06.825513 systemd[1]: dracut-pre-udev.service: Deactivated successfully. Sep 9 00:36:06.825552 systemd[1]: Stopped dracut-pre-udev.service. Sep 9 00:36:06.826689 systemd[1]: dracut-cmdline.service: Deactivated successfully. Sep 9 00:36:06.826719 systemd[1]: Stopped dracut-cmdline.service. Sep 9 00:36:06.827850 systemd[1]: dracut-cmdline-ask.service: Deactivated successfully. Sep 9 00:36:06.827884 systemd[1]: Stopped dracut-cmdline-ask.service. Sep 9 00:36:06.830095 systemd[1]: Starting initrd-udevadm-cleanup-db.service... Sep 9 00:36:06.830692 systemd[1]: systemd-vconsole-setup.service: Deactivated successfully. Sep 9 00:36:06.830737 systemd[1]: Stopped systemd-vconsole-setup.service. Sep 9 00:36:06.835068 systemd[1]: initrd-udevadm-cleanup-db.service: Deactivated successfully. Sep 9 00:36:06.835150 systemd[1]: Finished initrd-udevadm-cleanup-db.service. Sep 9 00:36:06.836048 systemd[1]: Reached target initrd-switch-root.target. Sep 9 00:36:06.838670 systemd[1]: Starting initrd-switch-root.service... Sep 9 00:36:06.844805 systemd[1]: Switching root. Sep 9 00:36:06.861099 systemd-journald[290]: Journal stopped Sep 9 00:36:08.759671 systemd-journald[290]: Received SIGTERM from PID 1 (systemd). Sep 9 00:36:08.759718 kernel: SELinux: Class mctp_socket not defined in policy. Sep 9 00:36:08.759733 kernel: SELinux: Class anon_inode not defined in policy. Sep 9 00:36:08.759743 kernel: SELinux: the above unknown classes and permissions will be allowed Sep 9 00:36:08.759752 kernel: SELinux: policy capability network_peer_controls=1 Sep 9 00:36:08.759762 kernel: SELinux: policy capability open_perms=1 Sep 9 00:36:08.759771 kernel: SELinux: policy capability extended_socket_class=1 Sep 9 00:36:08.759781 kernel: SELinux: policy capability always_check_network=0 Sep 9 00:36:08.759790 kernel: SELinux: policy capability cgroup_seclabel=1 Sep 9 00:36:08.759803 kernel: SELinux: policy capability nnp_nosuid_transition=1 Sep 9 00:36:08.759813 kernel: SELinux: policy capability genfs_seclabel_symlinks=0 Sep 9 00:36:08.759824 kernel: SELinux: policy capability ioctl_skip_cloexec=0 Sep 9 00:36:08.759834 systemd[1]: Successfully loaded SELinux policy in 34.014ms. Sep 9 00:36:08.759852 systemd[1]: Relabelled /dev, /dev/shm, /run, /sys/fs/cgroup in 7.214ms. Sep 9 00:36:08.759863 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) Sep 9 00:36:08.759874 systemd[1]: Detected virtualization kvm. Sep 9 00:36:08.759884 systemd[1]: Detected architecture arm64. Sep 9 00:36:08.759895 systemd[1]: Detected first boot. Sep 9 00:36:08.759907 systemd[1]: Initializing machine ID from VM UUID. Sep 9 00:36:08.759918 kernel: SELinux: Context system_u:object_r:container_file_t:s0:c1022,c1023 is not valid (left unmapped). Sep 9 00:36:08.759929 systemd[1]: Populated /etc with preset unit settings. Sep 9 00:36:08.759939 systemd[1]: /usr/lib/systemd/system/locksmithd.service:8: Unit uses CPUShares=; please use CPUWeight= instead. Support for CPUShares= will be removed soon. Sep 9 00:36:08.759950 systemd[1]: /usr/lib/systemd/system/locksmithd.service:9: Unit uses MemoryLimit=; please use MemoryMax= instead. Support for MemoryLimit= will be removed soon. Sep 9 00:36:08.759977 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. Sep 9 00:36:08.759989 kernel: kauditd_printk_skb: 78 callbacks suppressed Sep 9 00:36:08.759999 kernel: audit: type=1334 audit(1757378168.650:82): prog-id=12 op=LOAD Sep 9 00:36:08.760009 kernel: audit: type=1334 audit(1757378168.651:83): prog-id=3 op=UNLOAD Sep 9 00:36:08.760019 kernel: audit: type=1334 audit(1757378168.651:84): prog-id=13 op=LOAD Sep 9 00:36:08.760029 kernel: audit: type=1334 audit(1757378168.652:85): prog-id=14 op=LOAD Sep 9 00:36:08.760038 kernel: audit: type=1334 audit(1757378168.652:86): prog-id=4 op=UNLOAD Sep 9 00:36:08.760051 kernel: audit: type=1334 audit(1757378168.652:87): prog-id=5 op=UNLOAD Sep 9 00:36:08.760061 kernel: audit: type=1334 audit(1757378168.653:88): prog-id=15 op=LOAD Sep 9 00:36:08.760071 kernel: audit: type=1334 audit(1757378168.653:89): prog-id=12 op=UNLOAD Sep 9 00:36:08.760080 systemd[1]: initrd-switch-root.service: Deactivated successfully. Sep 9 00:36:08.760091 kernel: audit: type=1334 audit(1757378168.653:90): prog-id=16 op=LOAD Sep 9 00:36:08.760110 kernel: audit: type=1334 audit(1757378168.654:91): prog-id=17 op=LOAD Sep 9 00:36:08.760121 systemd[1]: Stopped initrd-switch-root.service. Sep 9 00:36:08.760132 systemd[1]: systemd-journald.service: Scheduled restart job, restart counter is at 1. Sep 9 00:36:08.760143 systemd[1]: Created slice system-addon\x2dconfig.slice. Sep 9 00:36:08.760154 systemd[1]: Created slice system-addon\x2drun.slice. Sep 9 00:36:08.760164 systemd[1]: Created slice system-getty.slice. Sep 9 00:36:08.760176 systemd[1]: Created slice system-modprobe.slice. Sep 9 00:36:08.760186 systemd[1]: Created slice system-serial\x2dgetty.slice. Sep 9 00:36:08.760196 systemd[1]: Created slice system-system\x2dcloudinit.slice. Sep 9 00:36:08.760207 systemd[1]: Created slice system-systemd\x2dfsck.slice. Sep 9 00:36:08.760217 systemd[1]: Created slice user.slice. Sep 9 00:36:08.760227 systemd[1]: Started systemd-ask-password-console.path. Sep 9 00:36:08.760238 systemd[1]: Started systemd-ask-password-wall.path. Sep 9 00:36:08.760251 systemd[1]: Set up automount boot.automount. Sep 9 00:36:08.760262 systemd[1]: Set up automount proc-sys-fs-binfmt_misc.automount. Sep 9 00:36:08.760274 systemd[1]: Stopped target initrd-switch-root.target. Sep 9 00:36:08.760285 systemd[1]: Stopped target initrd-fs.target. Sep 9 00:36:08.760295 systemd[1]: Stopped target initrd-root-fs.target. Sep 9 00:36:08.760306 systemd[1]: Reached target integritysetup.target. Sep 9 00:36:08.760317 systemd[1]: Reached target remote-cryptsetup.target. Sep 9 00:36:08.760328 systemd[1]: Reached target remote-fs.target. Sep 9 00:36:08.760338 systemd[1]: Reached target slices.target. Sep 9 00:36:08.760351 systemd[1]: Reached target swap.target. Sep 9 00:36:08.760361 systemd[1]: Reached target torcx.target. Sep 9 00:36:08.760372 systemd[1]: Reached target veritysetup.target. Sep 9 00:36:08.760383 systemd[1]: Listening on systemd-coredump.socket. Sep 9 00:36:08.760393 systemd[1]: Listening on systemd-initctl.socket. Sep 9 00:36:08.760404 systemd[1]: Listening on systemd-networkd.socket. Sep 9 00:36:08.760414 systemd[1]: Listening on systemd-udevd-control.socket. Sep 9 00:36:08.760425 systemd[1]: Listening on systemd-udevd-kernel.socket. Sep 9 00:36:08.760436 systemd[1]: Listening on systemd-userdbd.socket. Sep 9 00:36:08.760448 systemd[1]: Mounting dev-hugepages.mount... Sep 9 00:36:08.760458 systemd[1]: Mounting dev-mqueue.mount... Sep 9 00:36:08.760469 systemd[1]: Mounting media.mount... Sep 9 00:36:08.760479 systemd[1]: Mounting sys-kernel-debug.mount... Sep 9 00:36:08.760491 systemd[1]: Mounting sys-kernel-tracing.mount... Sep 9 00:36:08.760501 systemd[1]: Mounting tmp.mount... Sep 9 00:36:08.760511 systemd[1]: Starting flatcar-tmpfiles.service... Sep 9 00:36:08.760522 systemd[1]: ignition-delete-config.service was skipped because no trigger condition checks were met. Sep 9 00:36:08.760532 systemd[1]: Starting kmod-static-nodes.service... Sep 9 00:36:08.760544 systemd[1]: Starting modprobe@configfs.service... Sep 9 00:36:08.760555 systemd[1]: Starting modprobe@dm_mod.service... Sep 9 00:36:08.760565 systemd[1]: Starting modprobe@drm.service... Sep 9 00:36:08.760576 systemd[1]: Starting modprobe@efi_pstore.service... Sep 9 00:36:08.760586 systemd[1]: Starting modprobe@fuse.service... Sep 9 00:36:08.760597 systemd[1]: Starting modprobe@loop.service... Sep 9 00:36:08.760608 systemd[1]: setup-nsswitch.service was skipped because of an unmet condition check (ConditionPathExists=!/etc/nsswitch.conf). Sep 9 00:36:08.760618 systemd[1]: systemd-fsck-root.service: Deactivated successfully. Sep 9 00:36:08.760629 systemd[1]: Stopped systemd-fsck-root.service. Sep 9 00:36:08.760641 systemd[1]: systemd-fsck-usr.service: Deactivated successfully. Sep 9 00:36:08.760652 systemd[1]: Stopped systemd-fsck-usr.service. Sep 9 00:36:08.760662 systemd[1]: Stopped systemd-journald.service. Sep 9 00:36:08.760672 kernel: loop: module loaded Sep 9 00:36:08.760682 kernel: fuse: init (API version 7.34) Sep 9 00:36:08.760692 systemd[1]: Starting systemd-journald.service... Sep 9 00:36:08.760702 systemd[1]: Starting systemd-modules-load.service... Sep 9 00:36:08.760713 systemd[1]: Starting systemd-network-generator.service... Sep 9 00:36:08.760723 systemd[1]: Starting systemd-remount-fs.service... Sep 9 00:36:08.760735 systemd[1]: Starting systemd-udev-trigger.service... Sep 9 00:36:08.760745 systemd[1]: verity-setup.service: Deactivated successfully. Sep 9 00:36:08.760756 systemd[1]: Stopped verity-setup.service. Sep 9 00:36:08.760766 systemd[1]: Mounted dev-hugepages.mount. Sep 9 00:36:08.760777 systemd[1]: Mounted dev-mqueue.mount. Sep 9 00:36:08.760787 systemd[1]: Mounted media.mount. Sep 9 00:36:08.760798 systemd[1]: Mounted sys-kernel-debug.mount. Sep 9 00:36:08.760808 systemd[1]: Mounted sys-kernel-tracing.mount. Sep 9 00:36:08.760819 systemd[1]: Mounted tmp.mount. Sep 9 00:36:08.760833 systemd-journald[1004]: Journal started Sep 9 00:36:08.760874 systemd-journald[1004]: Runtime Journal (/run/log/journal/33e67a1b46624fa58932b540518f23ff) is 6.0M, max 48.7M, 42.6M free. Sep 9 00:36:06.915000 audit: MAC_POLICY_LOAD auid=4294967295 ses=4294967295 lsm=selinux res=1 Sep 9 00:36:06.953000 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 Sep 9 00:36:06.953000 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 Sep 9 00:36:06.953000 audit: BPF prog-id=10 op=LOAD Sep 9 00:36:06.954000 audit: BPF prog-id=10 op=UNLOAD Sep 9 00:36:06.954000 audit: BPF prog-id=11 op=LOAD Sep 9 00:36:06.954000 audit: BPF prog-id=11 op=UNLOAD Sep 9 00:36:06.991000 audit[930]: AVC avc: denied { associate } for pid=930 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" Sep 9 00:36:06.991000 audit[930]: SYSCALL arch=c00000b7 syscall=5 success=yes exit=0 a0=40001c589c a1=40000c8de0 a2=40000cf0c0 a3=32 items=0 ppid=913 pid=930 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) Sep 9 00:36:06.991000 audit: PROCTITLE proctitle=2F7573722F6C69622F73797374656D642F73797374656D2D67656E657261746F72732F746F7263782D67656E657261746F72002F72756E2F73797374656D642F67656E657261746F72002F72756E2F73797374656D642F67656E657261746F722E6561726C79002F72756E2F73797374656D642F67656E657261746F722E6C61 Sep 9 00:36:06.992000 audit[930]: AVC avc: denied { associate } for pid=930 comm="torcx-generator" name="lib" scontext=system_u:object_r:unlabeled_t:s0 tcontext=system_u:object_r:tmpfs_t:s0 tclass=filesystem permissive=1 Sep 9 00:36:06.992000 audit[930]: SYSCALL arch=c00000b7 syscall=34 success=yes exit=0 a0=ffffffffffffff9c a1=40001c5975 a2=1ed a3=0 items=2 ppid=913 pid=930 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) Sep 9 00:36:06.992000 audit: CWD cwd="/" Sep 9 00:36:06.992000 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 Sep 9 00:36:06.992000 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 Sep 9 00:36:06.992000 audit: PROCTITLE proctitle=2F7573722F6C69622F73797374656D642F73797374656D2D67656E657261746F72732F746F7263782D67656E657261746F72002F72756E2F73797374656D642F67656E657261746F72002F72756E2F73797374656D642F67656E657261746F722E6561726C79002F72756E2F73797374656D642F67656E657261746F722E6C61 Sep 9 00:36:08.650000 audit: BPF prog-id=12 op=LOAD Sep 9 00:36:08.651000 audit: BPF prog-id=3 op=UNLOAD Sep 9 00:36:08.651000 audit: BPF prog-id=13 op=LOAD Sep 9 00:36:08.652000 audit: BPF prog-id=14 op=LOAD Sep 9 00:36:08.652000 audit: BPF prog-id=4 op=UNLOAD Sep 9 00:36:08.652000 audit: BPF prog-id=5 op=UNLOAD Sep 9 00:36:08.653000 audit: BPF prog-id=15 op=LOAD Sep 9 00:36:08.653000 audit: BPF prog-id=12 op=UNLOAD Sep 9 00:36:08.653000 audit: BPF prog-id=16 op=LOAD Sep 9 00:36:08.654000 audit: BPF prog-id=17 op=LOAD Sep 9 00:36:08.654000 audit: BPF prog-id=13 op=UNLOAD Sep 9 00:36:08.654000 audit: BPF prog-id=14 op=UNLOAD Sep 9 00:36:08.655000 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' Sep 9 00:36:08.659000 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' Sep 9 00:36:08.659000 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' Sep 9 00:36:08.667000 audit: BPF prog-id=15 op=UNLOAD Sep 9 00:36:08.734000 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' Sep 9 00:36:08.736000 audit[1]: SERVICE_STOP pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=systemd-fsck-usr comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Sep 9 00:36:08.738000 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' Sep 9 00:36:08.738000 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' Sep 9 00:36:08.738000 audit: BPF prog-id=18 op=LOAD Sep 9 00:36:08.738000 audit: BPF prog-id=19 op=LOAD Sep 9 00:36:08.738000 audit: BPF prog-id=20 op=LOAD Sep 9 00:36:08.738000 audit: BPF prog-id=16 op=UNLOAD Sep 9 00:36:08.738000 audit: BPF prog-id=17 op=UNLOAD Sep 9 00:36:08.753000 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' Sep 9 00:36:08.758000 audit: CONFIG_CHANGE op=set audit_enabled=1 old=1 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 res=1 Sep 9 00:36:08.758000 audit[1004]: SYSCALL arch=c00000b7 syscall=211 success=yes exit=60 a0=6 a1=fffff01f41e0 a2=4000 a3=1 items=0 ppid=1 pid=1004 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) Sep 9 00:36:08.758000 audit: PROCTITLE proctitle="/usr/lib/systemd/systemd-journald" Sep 9 00:36:08.650642 systemd[1]: Queued start job for default target multi-user.target. Sep 9 00:36:06.990852 /usr/lib/systemd/system-generators/torcx-generator[930]: time="2025-09-09T00:36:06Z" 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.8 /usr/share/oem/torcx/store /var/lib/torcx/store/3510.3.8 /var/lib/torcx/store]" Sep 9 00:36:08.650654 systemd[1]: Unnecessary job was removed for dev-vda6.device. Sep 9 00:36:06.991168 /usr/lib/systemd/system-generators/torcx-generator[930]: time="2025-09-09T00:36:06Z" level=debug msg="profile found" name=docker-1.12-no path=/usr/share/torcx/profiles/docker-1.12-no.json Sep 9 00:36:08.762279 systemd[1]: Started systemd-journald.service. Sep 9 00:36:08.656145 systemd[1]: systemd-journald.service: Deactivated successfully. Sep 9 00:36:06.991188 /usr/lib/systemd/system-generators/torcx-generator[930]: time="2025-09-09T00:36:06Z" level=debug msg="profile found" name=vendor path=/usr/share/torcx/profiles/vendor.json Sep 9 00:36:06.991218 /usr/lib/systemd/system-generators/torcx-generator[930]: time="2025-09-09T00:36:06Z" level=info msg="no vendor profile selected by /etc/flatcar/docker-1.12" Sep 9 00:36:06.991228 /usr/lib/systemd/system-generators/torcx-generator[930]: time="2025-09-09T00:36:06Z" level=debug msg="skipped missing lower profile" missing profile=oem Sep 9 00:36:06.991258 /usr/lib/systemd/system-generators/torcx-generator[930]: time="2025-09-09T00:36:06Z" level=warning msg="no next profile: unable to read profile file: open /etc/torcx/next-profile: no such file or directory" Sep 9 00:36:06.991270 /usr/lib/systemd/system-generators/torcx-generator[930]: time="2025-09-09T00:36:06Z" level=debug msg="apply configuration parsed" lower profiles (vendor/oem)="[vendor]" upper profile (user)= Sep 9 00:36:06.991474 /usr/lib/systemd/system-generators/torcx-generator[930]: time="2025-09-09T00:36:06Z" level=debug msg="mounted tmpfs" target=/run/torcx/unpack Sep 9 00:36:06.991510 /usr/lib/systemd/system-generators/torcx-generator[930]: time="2025-09-09T00:36:06Z" level=debug msg="profile found" name=docker-1.12-no path=/usr/share/torcx/profiles/docker-1.12-no.json Sep 9 00:36:06.991523 /usr/lib/systemd/system-generators/torcx-generator[930]: time="2025-09-09T00:36:06Z" level=debug msg="profile found" name=vendor path=/usr/share/torcx/profiles/vendor.json Sep 9 00:36:08.762000 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' Sep 9 00:36:06.992226 /usr/lib/systemd/system-generators/torcx-generator[930]: time="2025-09-09T00:36:06Z" 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 Sep 9 00:36:06.992263 /usr/lib/systemd/system-generators/torcx-generator[930]: time="2025-09-09T00:36:06Z" 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 Sep 9 00:36:06.992281 /usr/lib/systemd/system-generators/torcx-generator[930]: time="2025-09-09T00:36:06Z" level=info msg="store skipped" err="open /usr/share/oem/torcx/store/3510.3.8: no such file or directory" path=/usr/share/oem/torcx/store/3510.3.8 Sep 9 00:36:06.992295 /usr/lib/systemd/system-generators/torcx-generator[930]: time="2025-09-09T00:36:06Z" level=info msg="store skipped" err="open /usr/share/oem/torcx/store: no such file or directory" path=/usr/share/oem/torcx/store Sep 9 00:36:06.992313 /usr/lib/systemd/system-generators/torcx-generator[930]: time="2025-09-09T00:36:06Z" level=info msg="store skipped" err="open /var/lib/torcx/store/3510.3.8: no such file or directory" path=/var/lib/torcx/store/3510.3.8 Sep 9 00:36:06.992326 /usr/lib/systemd/system-generators/torcx-generator[930]: time="2025-09-09T00:36:06Z" level=info msg="store skipped" err="open /var/lib/torcx/store: no such file or directory" path=/var/lib/torcx/store Sep 9 00:36:08.409788 /usr/lib/systemd/system-generators/torcx-generator[930]: time="2025-09-09T00:36:08Z" level=debug msg="image unpacked" image=docker path=/run/torcx/unpack/docker reference=com.coreos.cl Sep 9 00:36:08.763415 systemd[1]: Finished kmod-static-nodes.service. Sep 9 00:36:08.410069 /usr/lib/systemd/system-generators/torcx-generator[930]: time="2025-09-09T00:36:08Z" 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 Sep 9 00:36:08.410178 /usr/lib/systemd/system-generators/torcx-generator[930]: time="2025-09-09T00:36:08Z" 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 Sep 9 00:36:08.410342 /usr/lib/systemd/system-generators/torcx-generator[930]: time="2025-09-09T00:36:08Z" 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 Sep 9 00:36:08.410390 /usr/lib/systemd/system-generators/torcx-generator[930]: time="2025-09-09T00:36:08Z" level=debug msg="profile applied" sealed profile=/run/torcx/profile.json upper profile= Sep 9 00:36:08.410446 /usr/lib/systemd/system-generators/torcx-generator[930]: time="2025-09-09T00:36:08Z" 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 Sep 9 00:36:08.763000 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' Sep 9 00:36:08.764428 systemd[1]: modprobe@configfs.service: Deactivated successfully. Sep 9 00:36:08.764596 systemd[1]: Finished modprobe@configfs.service. Sep 9 00:36:08.765000 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' Sep 9 00:36:08.765000 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' Sep 9 00:36:08.765524 systemd[1]: modprobe@dm_mod.service: Deactivated successfully. Sep 9 00:36:08.765669 systemd[1]: Finished modprobe@dm_mod.service. Sep 9 00:36:08.766000 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' Sep 9 00:36:08.766000 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' Sep 9 00:36:08.766603 systemd[1]: modprobe@drm.service: Deactivated successfully. Sep 9 00:36:08.766755 systemd[1]: Finished modprobe@drm.service. Sep 9 00:36:08.767000 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' Sep 9 00:36:08.767000 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' Sep 9 00:36:08.767730 systemd[1]: Finished flatcar-tmpfiles.service. Sep 9 00:36:08.768000 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' Sep 9 00:36:08.768634 systemd[1]: modprobe@efi_pstore.service: Deactivated successfully. Sep 9 00:36:08.768778 systemd[1]: Finished modprobe@efi_pstore.service. Sep 9 00:36:08.769000 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' Sep 9 00:36:08.769000 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' Sep 9 00:36:08.769842 systemd[1]: modprobe@fuse.service: Deactivated successfully. Sep 9 00:36:08.770003 systemd[1]: Finished modprobe@fuse.service. Sep 9 00:36:08.769000 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' Sep 9 00:36:08.769000 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' Sep 9 00:36:08.770830 systemd[1]: modprobe@loop.service: Deactivated successfully. Sep 9 00:36:08.770975 systemd[1]: Finished modprobe@loop.service. Sep 9 00:36:08.770000 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' Sep 9 00:36:08.770000 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' Sep 9 00:36:08.771834 systemd[1]: Finished systemd-modules-load.service. Sep 9 00:36:08.772000 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' Sep 9 00:36:08.772933 systemd[1]: Finished systemd-network-generator.service. Sep 9 00:36:08.773000 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' Sep 9 00:36:08.774121 systemd[1]: Finished systemd-remount-fs.service. Sep 9 00:36:08.773000 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' Sep 9 00:36:08.775188 systemd[1]: Reached target network-pre.target. Sep 9 00:36:08.776997 systemd[1]: Mounting sys-fs-fuse-connections.mount... Sep 9 00:36:08.778622 systemd[1]: Mounting sys-kernel-config.mount... Sep 9 00:36:08.779320 systemd[1]: remount-root.service was skipped because of an unmet condition check (ConditionPathIsReadWrite=!/). Sep 9 00:36:08.780804 systemd[1]: Starting systemd-hwdb-update.service... Sep 9 00:36:08.782771 systemd[1]: Starting systemd-journal-flush.service... Sep 9 00:36:08.783619 systemd[1]: systemd-pstore.service was skipped because of an unmet condition check (ConditionDirectoryNotEmpty=/sys/fs/pstore). Sep 9 00:36:08.784552 systemd[1]: Starting systemd-random-seed.service... Sep 9 00:36:08.785382 systemd[1]: systemd-repart.service was skipped because no trigger condition checks were met. Sep 9 00:36:08.786374 systemd[1]: Starting systemd-sysctl.service... Sep 9 00:36:08.788248 systemd[1]: Starting systemd-sysusers.service... Sep 9 00:36:08.790463 systemd-journald[1004]: Time spent on flushing to /var/log/journal/33e67a1b46624fa58932b540518f23ff is 12.907ms for 965 entries. Sep 9 00:36:08.790463 systemd-journald[1004]: System Journal (/var/log/journal/33e67a1b46624fa58932b540518f23ff) is 8.0M, max 195.6M, 187.6M free. Sep 9 00:36:08.813868 systemd-journald[1004]: Received client request to flush runtime journal. Sep 9 00:36:08.796000 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' Sep 9 00:36:08.797000 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' Sep 9 00:36:08.807000 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' Sep 9 00:36:08.791328 systemd[1]: Mounted sys-fs-fuse-connections.mount. Sep 9 00:36:08.814302 udevadm[1030]: systemd-udev-settle.service is deprecated. Please fix lvm2-activation-early.service, lvm2-activation.service not to pull it in. Sep 9 00:36:08.792430 systemd[1]: Mounted sys-kernel-config.mount. Sep 9 00:36:08.795190 systemd[1]: Finished systemd-udev-trigger.service. Sep 9 00:36:08.796434 systemd[1]: Finished systemd-random-seed.service. Sep 9 00:36:08.797257 systemd[1]: Reached target first-boot-complete.target. Sep 9 00:36:08.798853 systemd[1]: Starting systemd-udev-settle.service... Sep 9 00:36:08.807210 systemd[1]: Finished systemd-sysctl.service. Sep 9 00:36:08.814810 systemd[1]: Finished systemd-journal-flush.service. Sep 9 00:36:08.815000 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' Sep 9 00:36:08.818841 systemd[1]: Finished systemd-sysusers.service. Sep 9 00:36:08.819000 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' Sep 9 00:36:09.180560 systemd[1]: Finished systemd-hwdb-update.service. Sep 9 00:36:09.180000 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' Sep 9 00:36:09.180000 audit: BPF prog-id=21 op=LOAD Sep 9 00:36:09.180000 audit: BPF prog-id=22 op=LOAD Sep 9 00:36:09.181000 audit: BPF prog-id=7 op=UNLOAD Sep 9 00:36:09.181000 audit: BPF prog-id=8 op=UNLOAD Sep 9 00:36:09.182636 systemd[1]: Starting systemd-udevd.service... Sep 9 00:36:09.198300 systemd-udevd[1033]: Using default interface naming scheme 'v252'. Sep 9 00:36:09.214244 systemd[1]: Started systemd-udevd.service. Sep 9 00:36:09.213000 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' Sep 9 00:36:09.214000 audit: BPF prog-id=23 op=LOAD Sep 9 00:36:09.216519 systemd[1]: Starting systemd-networkd.service... Sep 9 00:36:09.226000 audit: BPF prog-id=24 op=LOAD Sep 9 00:36:09.226000 audit: BPF prog-id=25 op=LOAD Sep 9 00:36:09.226000 audit: BPF prog-id=26 op=LOAD Sep 9 00:36:09.227959 systemd[1]: Starting systemd-userdbd.service... Sep 9 00:36:09.254291 systemd[1]: Condition check resulted in dev-ttyAMA0.device being skipped. Sep 9 00:36:09.256401 systemd[1]: Started systemd-userdbd.service. Sep 9 00:36:09.256000 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' Sep 9 00:36:09.274808 systemd[1]: Found device dev-disk-by\x2dlabel-OEM.device. Sep 9 00:36:09.297673 systemd-networkd[1040]: lo: Link UP Sep 9 00:36:09.297685 systemd-networkd[1040]: lo: Gained carrier Sep 9 00:36:09.298218 systemd-networkd[1040]: Enumeration completed Sep 9 00:36:09.298315 systemd[1]: Started systemd-networkd.service. Sep 9 00:36:09.298324 systemd-networkd[1040]: eth0: Configuring with /usr/lib/systemd/network/zz-default.network. Sep 9 00:36:09.298000 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' Sep 9 00:36:09.299501 systemd-networkd[1040]: eth0: Link UP Sep 9 00:36:09.299511 systemd-networkd[1040]: eth0: Gained carrier Sep 9 00:36:09.300238 systemd[1]: Starting systemd-networkd-wait-online.service... Sep 9 00:36:09.326158 systemd-networkd[1040]: eth0: DHCPv4 address 10.0.0.89/16, gateway 10.0.0.1 acquired from 10.0.0.1 Sep 9 00:36:09.336359 systemd[1]: Finished systemd-udev-settle.service. Sep 9 00:36:09.336000 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' Sep 9 00:36:09.338291 systemd[1]: Starting lvm2-activation-early.service... Sep 9 00:36:09.346403 lvm[1067]: WARNING: Failed to connect to lvmetad. Falling back to device scanning. Sep 9 00:36:09.373897 systemd[1]: Finished lvm2-activation-early.service. Sep 9 00:36:09.373000 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' Sep 9 00:36:09.374823 systemd[1]: Reached target cryptsetup.target. Sep 9 00:36:09.376717 systemd[1]: Starting lvm2-activation.service... Sep 9 00:36:09.380399 lvm[1068]: WARNING: Failed to connect to lvmetad. Falling back to device scanning. Sep 9 00:36:09.410923 systemd[1]: Finished lvm2-activation.service. Sep 9 00:36:09.410000 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' Sep 9 00:36:09.411785 systemd[1]: Reached target local-fs-pre.target. Sep 9 00:36:09.412498 systemd[1]: var-lib-machines.mount was skipped because of an unmet condition check (ConditionPathExists=/var/lib/machines.raw). Sep 9 00:36:09.412529 systemd[1]: Reached target local-fs.target. Sep 9 00:36:09.413133 systemd[1]: Reached target machines.target. Sep 9 00:36:09.414893 systemd[1]: Starting ldconfig.service... Sep 9 00:36:09.415868 systemd[1]: systemd-binfmt.service was skipped because no trigger condition checks were met. Sep 9 00:36:09.415940 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). Sep 9 00:36:09.416953 systemd[1]: Starting systemd-boot-update.service... Sep 9 00:36:09.418723 systemd[1]: Starting systemd-fsck@dev-disk-by\x2dlabel-OEM.service... Sep 9 00:36:09.420730 systemd[1]: Starting systemd-machine-id-commit.service... Sep 9 00:36:09.422267 systemd[1]: systemd-sysext.service was skipped because no trigger condition checks were met. Sep 9 00:36:09.422308 systemd[1]: ensure-sysext.service was skipped because no trigger condition checks were met. Sep 9 00:36:09.423350 systemd[1]: Starting systemd-tmpfiles-setup.service... Sep 9 00:36:09.424297 systemd[1]: boot.automount: Got automount request for /boot, triggered by 1070 (bootctl) Sep 9 00:36:09.425616 systemd[1]: Starting systemd-fsck@dev-disk-by\x2dlabel-EFI\x2dSYSTEM.service... Sep 9 00:36:09.430623 systemd[1]: Finished systemd-fsck@dev-disk-by\x2dlabel-OEM.service. Sep 9 00:36:09.430000 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' Sep 9 00:36:09.437349 systemd[1]: etc-machine\x2did.mount: Deactivated successfully. Sep 9 00:36:09.437917 systemd[1]: Finished systemd-machine-id-commit.service. Sep 9 00:36:09.438000 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' Sep 9 00:36:09.448510 systemd-tmpfiles[1073]: /usr/lib/tmpfiles.d/legacy.conf:13: Duplicate line for path "/run/lock", ignoring. Sep 9 00:36:09.451556 systemd-tmpfiles[1073]: /usr/lib/tmpfiles.d/provision.conf:20: Duplicate line for path "/root", ignoring. Sep 9 00:36:09.456418 systemd-tmpfiles[1073]: /usr/lib/tmpfiles.d/systemd.conf:29: Duplicate line for path "/var/lib/systemd", ignoring. Sep 9 00:36:09.464277 systemd-fsck[1078]: fsck.fat 4.2 (2021-01-31) Sep 9 00:36:09.464277 systemd-fsck[1078]: /dev/vda1: 236 files, 117310/258078 clusters Sep 9 00:36:09.466745 systemd[1]: Finished systemd-fsck@dev-disk-by\x2dlabel-EFI\x2dSYSTEM.service. Sep 9 00:36:09.467000 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' Sep 9 00:36:09.469376 systemd[1]: Mounting boot.mount... Sep 9 00:36:09.476046 systemd[1]: Mounted boot.mount. Sep 9 00:36:09.484283 systemd[1]: Finished systemd-boot-update.service. Sep 9 00:36:09.484000 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' Sep 9 00:36:09.552477 ldconfig[1069]: /sbin/ldconfig: /lib/ld.so.conf is not an ELF file - it has the wrong magic bytes at the start. Sep 9 00:36:09.556147 systemd[1]: Finished ldconfig.service. Sep 9 00:36:09.555000 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' Sep 9 00:36:09.574601 systemd[1]: Finished systemd-tmpfiles-setup.service. Sep 9 00:36:09.574000 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' Sep 9 00:36:09.576820 systemd[1]: Starting audit-rules.service... Sep 9 00:36:09.578599 systemd[1]: Starting clean-ca-certificates.service... Sep 9 00:36:09.580672 systemd[1]: Starting systemd-journal-catalog-update.service... Sep 9 00:36:09.581000 audit: BPF prog-id=27 op=LOAD Sep 9 00:36:09.583315 systemd[1]: Starting systemd-resolved.service... Sep 9 00:36:09.584000 audit: BPF prog-id=28 op=LOAD Sep 9 00:36:09.586672 systemd[1]: Starting systemd-timesyncd.service... Sep 9 00:36:09.588669 systemd[1]: Starting systemd-update-utmp.service... Sep 9 00:36:09.590364 systemd[1]: Finished clean-ca-certificates.service. Sep 9 00:36:09.590000 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' Sep 9 00:36:09.591717 systemd[1]: update-ca-certificates.service was skipped because of an unmet condition check (ConditionPathIsSymbolicLink=!/etc/ssl/certs/ca-certificates.crt). Sep 9 00:36:09.593000 audit[1095]: SYSTEM_BOOT pid=1095 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' Sep 9 00:36:09.599026 systemd[1]: Finished systemd-update-utmp.service. Sep 9 00:36:09.598000 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' Sep 9 00:36:09.603690 systemd[1]: Finished systemd-journal-catalog-update.service. Sep 9 00:36:09.603000 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' Sep 9 00:36:09.605784 systemd[1]: Starting systemd-update-done.service... Sep 9 00:36:09.612332 systemd[1]: Finished systemd-update-done.service. Sep 9 00:36:09.612000 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' Sep 9 00:36:09.617000 audit: CONFIG_CHANGE auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 op=add_rule key=(null) list=5 res=1 Sep 9 00:36:09.617000 audit[1105]: SYSCALL arch=c00000b7 syscall=206 success=yes exit=1056 a0=3 a1=ffffe4f226f0 a2=420 a3=0 items=0 ppid=1084 pid=1105 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) Sep 9 00:36:09.617000 audit: PROCTITLE proctitle=2F7362696E2F617564697463746C002D52002F6574632F61756469742F61756469742E72756C6573 Sep 9 00:36:09.619123 augenrules[1105]: No rules Sep 9 00:36:09.619991 systemd[1]: Finished audit-rules.service. Sep 9 00:36:09.629573 systemd[1]: Started systemd-timesyncd.service. Sep 9 00:36:10.066864 systemd-timesyncd[1094]: Contacted time server 10.0.0.1:123 (10.0.0.1). Sep 9 00:36:10.066939 systemd-timesyncd[1094]: Initial clock synchronization to Tue 2025-09-09 00:36:10.066766 UTC. Sep 9 00:36:10.067161 systemd[1]: Reached target time-set.target. Sep 9 00:36:10.072819 systemd-resolved[1088]: Positive Trust Anchors: Sep 9 00:36:10.072829 systemd-resolved[1088]: . IN DS 20326 8 2 e06d44b80b8f1d39a95c0b0d7c65d08458e880409bbc683457104237c7f8ec8d Sep 9 00:36:10.072857 systemd-resolved[1088]: 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 Sep 9 00:36:10.080678 systemd-resolved[1088]: Defaulting to hostname 'linux'. Sep 9 00:36:10.082135 systemd[1]: Started systemd-resolved.service. Sep 9 00:36:10.082914 systemd[1]: Reached target network.target. Sep 9 00:36:10.083531 systemd[1]: Reached target nss-lookup.target. Sep 9 00:36:10.084112 systemd[1]: Reached target sysinit.target. Sep 9 00:36:10.084800 systemd[1]: Started motdgen.path. Sep 9 00:36:10.085346 systemd[1]: Started user-cloudinit@var-lib-flatcar\x2dinstall-user_data.path. Sep 9 00:36:10.086281 systemd[1]: Started logrotate.timer. Sep 9 00:36:10.087009 systemd[1]: Started mdadm.timer. Sep 9 00:36:10.087601 systemd[1]: Started systemd-tmpfiles-clean.timer. Sep 9 00:36:10.088209 systemd[1]: update-engine-stub.timer was skipped because of an unmet condition check (ConditionPathExists=/usr/.noupdate). Sep 9 00:36:10.088235 systemd[1]: Reached target paths.target. Sep 9 00:36:10.088854 systemd[1]: Reached target timers.target. Sep 9 00:36:10.089726 systemd[1]: Listening on dbus.socket. Sep 9 00:36:10.091335 systemd[1]: Starting docker.socket... Sep 9 00:36:10.094864 systemd[1]: Listening on sshd.socket. Sep 9 00:36:10.095725 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). Sep 9 00:36:10.096157 systemd[1]: Listening on docker.socket. Sep 9 00:36:10.096887 systemd[1]: Reached target sockets.target. Sep 9 00:36:10.097519 systemd[1]: Reached target basic.target. Sep 9 00:36:10.098089 systemd[1]: addon-config@usr-share-oem.service was skipped because no trigger condition checks were met. Sep 9 00:36:10.098113 systemd[1]: addon-run@usr-share-oem.service was skipped because no trigger condition checks were met. Sep 9 00:36:10.099091 systemd[1]: Starting containerd.service... Sep 9 00:36:10.100683 systemd[1]: Starting dbus.service... Sep 9 00:36:10.102291 systemd[1]: Starting enable-oem-cloudinit.service... Sep 9 00:36:10.103991 systemd[1]: Starting extend-filesystems.service... Sep 9 00:36:10.107299 jq[1115]: false Sep 9 00:36:10.104822 systemd[1]: flatcar-setup-environment.service was skipped because of an unmet condition check (ConditionPathExists=/usr/share/oem/bin/flatcar-setup-environment). Sep 9 00:36:10.105973 systemd[1]: Starting motdgen.service... Sep 9 00:36:10.108624 systemd[1]: Starting ssh-key-proc-cmdline.service... Sep 9 00:36:10.110292 systemd[1]: Starting sshd-keygen.service... Sep 9 00:36:10.113055 systemd[1]: Starting systemd-logind.service... Sep 9 00:36:10.113712 systemd[1]: systemd-pcrphase.service was skipped because of an unmet condition check (ConditionPathExists=/sys/firmware/efi/efivars/StubPcrKernelImage-4a67b082-0a4c-41cf-b6c7-440b29bb8c4f). Sep 9 00:36:10.113784 systemd[1]: tcsd.service was skipped because of an unmet condition check (ConditionPathExists=/dev/tpm0). Sep 9 00:36:10.114182 systemd[1]: cgroup compatibility translation between legacy and unified hierarchy settings activated. See cgroup-compat debug messages for details. Sep 9 00:36:10.114868 systemd[1]: Starting update-engine.service... Sep 9 00:36:10.117407 systemd[1]: Starting update-ssh-keys-after-ignition.service... Sep 9 00:36:10.121735 systemd[1]: enable-oem-cloudinit.service: Skipped due to 'exec-condition'. Sep 9 00:36:10.122015 systemd[1]: Condition check resulted in enable-oem-cloudinit.service being skipped. Sep 9 00:36:10.122368 systemd[1]: ssh-key-proc-cmdline.service: Deactivated successfully. Sep 9 00:36:10.122528 systemd[1]: Finished ssh-key-proc-cmdline.service. Sep 9 00:36:10.125122 jq[1130]: true Sep 9 00:36:10.127928 dbus-daemon[1114]: [system] SELinux support is enabled Sep 9 00:36:10.128108 systemd[1]: Started dbus.service. Sep 9 00:36:10.130638 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). Sep 9 00:36:10.130678 systemd[1]: Reached target system-config.target. Sep 9 00:36:10.131546 systemd[1]: user-cloudinit-proc-cmdline.service was skipped because of an unmet condition check (ConditionKernelCommandLine=cloud-config-url). Sep 9 00:36:10.131567 systemd[1]: Reached target user-config.target. Sep 9 00:36:10.135773 extend-filesystems[1116]: Found vda Sep 9 00:36:10.136981 systemd[1]: motdgen.service: Deactivated successfully. Sep 9 00:36:10.137148 systemd[1]: Finished motdgen.service. Sep 9 00:36:10.137230 extend-filesystems[1116]: Found vda1 Sep 9 00:36:10.139814 extend-filesystems[1116]: Found vda2 Sep 9 00:36:10.140510 extend-filesystems[1116]: Found vda3 Sep 9 00:36:10.141076 extend-filesystems[1116]: Found usr Sep 9 00:36:10.141701 extend-filesystems[1116]: Found vda4 Sep 9 00:36:10.142270 extend-filesystems[1116]: Found vda6 Sep 9 00:36:10.142921 extend-filesystems[1116]: Found vda7 Sep 9 00:36:10.143728 extend-filesystems[1116]: Found vda9 Sep 9 00:36:10.143728 extend-filesystems[1116]: Checking size of /dev/vda9 Sep 9 00:36:10.145078 jq[1136]: true Sep 9 00:36:10.153741 extend-filesystems[1116]: Old size kept for /dev/vda9 Sep 9 00:36:10.161557 systemd[1]: extend-filesystems.service: Deactivated successfully. Sep 9 00:36:10.161722 systemd[1]: Finished extend-filesystems.service. Sep 9 00:36:10.168312 systemd-logind[1124]: Watching system buttons on /dev/input/event0 (Power Button) Sep 9 00:36:10.168542 systemd-logind[1124]: New seat seat0. Sep 9 00:36:10.170056 systemd[1]: Started systemd-logind.service. Sep 9 00:36:10.175078 update_engine[1127]: I0909 00:36:10.174847 1127 main.cc:92] Flatcar Update Engine starting Sep 9 00:36:10.177512 systemd[1]: Started update-engine.service. Sep 9 00:36:10.177718 update_engine[1127]: I0909 00:36:10.177534 1127 update_check_scheduler.cc:74] Next update check in 4m54s Sep 9 00:36:10.180273 systemd[1]: Started locksmithd.service. Sep 9 00:36:10.182933 bash[1162]: Updated "/home/core/.ssh/authorized_keys" Sep 9 00:36:10.183935 systemd[1]: Finished update-ssh-keys-after-ignition.service. Sep 9 00:36:10.212337 env[1135]: time="2025-09-09T00:36:10.210152558Z" level=info msg="starting containerd" revision=92b3a9d6f1b3bcc6dc74875cfdea653fe39f09c2 version=1.6.16 Sep 9 00:36:10.215686 locksmithd[1163]: locksmithd starting currentOperation="UPDATE_STATUS_IDLE" strategy="reboot" Sep 9 00:36:10.226950 env[1135]: time="2025-09-09T00:36:10.226902278Z" level=info msg="loading plugin \"io.containerd.content.v1.content\"..." type=io.containerd.content.v1 Sep 9 00:36:10.227076 env[1135]: time="2025-09-09T00:36:10.227048878Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.aufs\"..." type=io.containerd.snapshotter.v1 Sep 9 00:36:10.228347 env[1135]: time="2025-09-09T00:36:10.228306318Z" 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.191-flatcar\\n\"): skip plugin" type=io.containerd.snapshotter.v1 Sep 9 00:36:10.228385 env[1135]: time="2025-09-09T00:36:10.228347958Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.btrfs\"..." type=io.containerd.snapshotter.v1 Sep 9 00:36:10.228577 env[1135]: time="2025-09-09T00:36:10.228546118Z" 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 Sep 9 00:36:10.228577 env[1135]: time="2025-09-09T00:36:10.228570678Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.devmapper\"..." type=io.containerd.snapshotter.v1 Sep 9 00:36:10.228632 env[1135]: time="2025-09-09T00:36:10.228585638Z" level=warning msg="failed to load plugin io.containerd.snapshotter.v1.devmapper" error="devmapper not configured" Sep 9 00:36:10.228632 env[1135]: time="2025-09-09T00:36:10.228595838Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.native\"..." type=io.containerd.snapshotter.v1 Sep 9 00:36:10.228680 env[1135]: time="2025-09-09T00:36:10.228664998Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.overlayfs\"..." type=io.containerd.snapshotter.v1 Sep 9 00:36:10.228966 env[1135]: time="2025-09-09T00:36:10.228937238Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.zfs\"..." type=io.containerd.snapshotter.v1 Sep 9 00:36:10.229072 env[1135]: time="2025-09-09T00:36:10.229053918Z" 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 Sep 9 00:36:10.229096 env[1135]: time="2025-09-09T00:36:10.229073998Z" level=info msg="loading plugin \"io.containerd.metadata.v1.bolt\"..." type=io.containerd.metadata.v1 Sep 9 00:36:10.229139 env[1135]: time="2025-09-09T00:36:10.229124478Z" level=warning msg="could not use snapshotter devmapper in metadata plugin" error="devmapper not configured" Sep 9 00:36:10.229165 env[1135]: time="2025-09-09T00:36:10.229140318Z" level=info msg="metadata content store policy set" policy=shared Sep 9 00:36:10.232816 env[1135]: time="2025-09-09T00:36:10.232783118Z" level=info msg="loading plugin \"io.containerd.differ.v1.walking\"..." type=io.containerd.differ.v1 Sep 9 00:36:10.232862 env[1135]: time="2025-09-09T00:36:10.232816158Z" level=info msg="loading plugin \"io.containerd.event.v1.exchange\"..." type=io.containerd.event.v1 Sep 9 00:36:10.232862 env[1135]: time="2025-09-09T00:36:10.232829318Z" level=info msg="loading plugin \"io.containerd.gc.v1.scheduler\"..." type=io.containerd.gc.v1 Sep 9 00:36:10.232862 env[1135]: time="2025-09-09T00:36:10.232858638Z" level=info msg="loading plugin \"io.containerd.service.v1.introspection-service\"..." type=io.containerd.service.v1 Sep 9 00:36:10.232929 env[1135]: time="2025-09-09T00:36:10.232872718Z" level=info msg="loading plugin \"io.containerd.service.v1.containers-service\"..." type=io.containerd.service.v1 Sep 9 00:36:10.232929 env[1135]: time="2025-09-09T00:36:10.232885838Z" level=info msg="loading plugin \"io.containerd.service.v1.content-service\"..." type=io.containerd.service.v1 Sep 9 00:36:10.232929 env[1135]: time="2025-09-09T00:36:10.232897478Z" level=info msg="loading plugin \"io.containerd.service.v1.diff-service\"..." type=io.containerd.service.v1 Sep 9 00:36:10.233272 env[1135]: time="2025-09-09T00:36:10.233240238Z" level=info msg="loading plugin \"io.containerd.service.v1.images-service\"..." type=io.containerd.service.v1 Sep 9 00:36:10.233272 env[1135]: time="2025-09-09T00:36:10.233264598Z" level=info msg="loading plugin \"io.containerd.service.v1.leases-service\"..." type=io.containerd.service.v1 Sep 9 00:36:10.233353 env[1135]: time="2025-09-09T00:36:10.233278038Z" level=info msg="loading plugin \"io.containerd.service.v1.namespaces-service\"..." type=io.containerd.service.v1 Sep 9 00:36:10.233353 env[1135]: time="2025-09-09T00:36:10.233296238Z" level=info msg="loading plugin \"io.containerd.service.v1.snapshots-service\"..." type=io.containerd.service.v1 Sep 9 00:36:10.233353 env[1135]: time="2025-09-09T00:36:10.233308158Z" level=info msg="loading plugin \"io.containerd.runtime.v1.linux\"..." type=io.containerd.runtime.v1 Sep 9 00:36:10.233466 env[1135]: time="2025-09-09T00:36:10.233435878Z" level=info msg="loading plugin \"io.containerd.runtime.v2.task\"..." type=io.containerd.runtime.v2 Sep 9 00:36:10.233550 env[1135]: time="2025-09-09T00:36:10.233534558Z" level=info msg="loading plugin \"io.containerd.monitor.v1.cgroups\"..." type=io.containerd.monitor.v1 Sep 9 00:36:10.233829 env[1135]: time="2025-09-09T00:36:10.233801598Z" level=info msg="loading plugin \"io.containerd.service.v1.tasks-service\"..." type=io.containerd.service.v1 Sep 9 00:36:10.233919 env[1135]: time="2025-09-09T00:36:10.233904718Z" level=info msg="loading plugin \"io.containerd.grpc.v1.introspection\"..." type=io.containerd.grpc.v1 Sep 9 00:36:10.233975 env[1135]: time="2025-09-09T00:36:10.233962918Z" level=info msg="loading plugin \"io.containerd.internal.v1.restart\"..." type=io.containerd.internal.v1 Sep 9 00:36:10.234136 env[1135]: time="2025-09-09T00:36:10.234121958Z" level=info msg="loading plugin \"io.containerd.grpc.v1.containers\"..." type=io.containerd.grpc.v1 Sep 9 00:36:10.234196 env[1135]: time="2025-09-09T00:36:10.234182798Z" level=info msg="loading plugin \"io.containerd.grpc.v1.content\"..." type=io.containerd.grpc.v1 Sep 9 00:36:10.234256 env[1135]: time="2025-09-09T00:36:10.234243438Z" level=info msg="loading plugin \"io.containerd.grpc.v1.diff\"..." type=io.containerd.grpc.v1 Sep 9 00:36:10.234310 env[1135]: time="2025-09-09T00:36:10.234297118Z" level=info msg="loading plugin \"io.containerd.grpc.v1.events\"..." type=io.containerd.grpc.v1 Sep 9 00:36:10.234386 env[1135]: time="2025-09-09T00:36:10.234371678Z" level=info msg="loading plugin \"io.containerd.grpc.v1.healthcheck\"..." type=io.containerd.grpc.v1 Sep 9 00:36:10.234461 env[1135]: time="2025-09-09T00:36:10.234437078Z" level=info msg="loading plugin \"io.containerd.grpc.v1.images\"..." type=io.containerd.grpc.v1 Sep 9 00:36:10.234520 env[1135]: time="2025-09-09T00:36:10.234507238Z" level=info msg="loading plugin \"io.containerd.grpc.v1.leases\"..." type=io.containerd.grpc.v1 Sep 9 00:36:10.234584 env[1135]: time="2025-09-09T00:36:10.234571478Z" level=info msg="loading plugin \"io.containerd.grpc.v1.namespaces\"..." type=io.containerd.grpc.v1 Sep 9 00:36:10.234700 env[1135]: time="2025-09-09T00:36:10.234684158Z" level=info msg="loading plugin \"io.containerd.internal.v1.opt\"..." type=io.containerd.internal.v1 Sep 9 00:36:10.234891 env[1135]: time="2025-09-09T00:36:10.234870078Z" level=info msg="loading plugin \"io.containerd.grpc.v1.snapshots\"..." type=io.containerd.grpc.v1 Sep 9 00:36:10.234965 env[1135]: time="2025-09-09T00:36:10.234951598Z" level=info msg="loading plugin \"io.containerd.grpc.v1.tasks\"..." type=io.containerd.grpc.v1 Sep 9 00:36:10.235026 env[1135]: time="2025-09-09T00:36:10.235013838Z" level=info msg="loading plugin \"io.containerd.grpc.v1.version\"..." type=io.containerd.grpc.v1 Sep 9 00:36:10.235079 env[1135]: time="2025-09-09T00:36:10.235067558Z" level=info msg="loading plugin \"io.containerd.tracing.processor.v1.otlp\"..." type=io.containerd.tracing.processor.v1 Sep 9 00:36:10.235139 env[1135]: time="2025-09-09T00:36:10.235121878Z" level=info msg="skip loading plugin \"io.containerd.tracing.processor.v1.otlp\"..." error="no OpenTelemetry endpoint: skip plugin" type=io.containerd.tracing.processor.v1 Sep 9 00:36:10.235190 env[1135]: time="2025-09-09T00:36:10.235178438Z" level=info msg="loading plugin \"io.containerd.internal.v1.tracing\"..." type=io.containerd.internal.v1 Sep 9 00:36:10.235249 env[1135]: time="2025-09-09T00:36:10.235236078Z" level=error msg="failed to initialize a tracing processor \"otlp\"" error="no OpenTelemetry endpoint: skip plugin" Sep 9 00:36:10.235344 env[1135]: time="2025-09-09T00:36:10.235311078Z" level=info msg="loading plugin \"io.containerd.grpc.v1.cri\"..." type=io.containerd.grpc.v1 Sep 9 00:36:10.235628 env[1135]: time="2025-09-09T00:36:10.235574118Z" 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}" Sep 9 00:36:10.236258 env[1135]: time="2025-09-09T00:36:10.235953398Z" level=info msg="Connect containerd service" Sep 9 00:36:10.236258 env[1135]: time="2025-09-09T00:36:10.235994118Z" level=info msg="Get image filesystem path \"/var/lib/containerd/io.containerd.snapshotter.v1.overlayfs\"" Sep 9 00:36:10.236827 env[1135]: time="2025-09-09T00:36:10.236797678Z" 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" Sep 9 00:36:10.237160 env[1135]: time="2025-09-09T00:36:10.237119278Z" level=info msg="Start subscribing containerd event" Sep 9 00:36:10.237204 env[1135]: time="2025-09-09T00:36:10.237171278Z" level=info msg="Start recovering state" Sep 9 00:36:10.237273 env[1135]: time="2025-09-09T00:36:10.237255478Z" level=info msg="Start event monitor" Sep 9 00:36:10.237304 env[1135]: time="2025-09-09T00:36:10.237284478Z" level=info msg="Start snapshots syncer" Sep 9 00:36:10.237304 env[1135]: time="2025-09-09T00:36:10.237295558Z" level=info msg="Start cni network conf syncer for default" Sep 9 00:36:10.237354 env[1135]: time="2025-09-09T00:36:10.237308958Z" level=info msg="Start streaming server" Sep 9 00:36:10.237494 env[1135]: time="2025-09-09T00:36:10.237471238Z" level=info msg=serving... address=/run/containerd/containerd.sock.ttrpc Sep 9 00:36:10.237607 env[1135]: time="2025-09-09T00:36:10.237592998Z" level=info msg=serving... address=/run/containerd/containerd.sock Sep 9 00:36:10.237713 env[1135]: time="2025-09-09T00:36:10.237699958Z" level=info msg="containerd successfully booted in 0.035411s" Sep 9 00:36:10.237782 systemd[1]: Started containerd.service. Sep 9 00:36:11.712461 systemd-networkd[1040]: eth0: Gained IPv6LL Sep 9 00:36:11.714081 systemd[1]: Finished systemd-networkd-wait-online.service. Sep 9 00:36:11.715162 systemd[1]: Reached target network-online.target. Sep 9 00:36:11.717524 systemd[1]: Starting coreos-metadata.service... Sep 9 00:36:11.724148 systemd[1]: coreos-metadata.service: Deactivated successfully. Sep 9 00:36:11.724315 systemd[1]: Finished coreos-metadata.service. Sep 9 00:36:11.726303 systemd[1]: Starting etcd-member.service... Sep 9 00:36:11.791943 systemd[1]: Starting docker.service... Sep 9 00:36:11.862156 env[1187]: time="2025-09-09T00:36:11.862091398Z" level=info msg="Starting up" Sep 9 00:36:11.863616 env[1187]: time="2025-09-09T00:36:11.863586958Z" level=info msg="parsed scheme: \"unix\"" module=grpc Sep 9 00:36:11.863616 env[1187]: time="2025-09-09T00:36:11.863615758Z" level=info msg="scheme \"unix\" not registered, fallback to default scheme" module=grpc Sep 9 00:36:11.863703 env[1187]: time="2025-09-09T00:36:11.863636878Z" level=info msg="ccResolverWrapper: sending update to cc: {[{unix:///var/run/docker/libcontainerd/docker-containerd.sock 0 }] }" module=grpc Sep 9 00:36:11.863703 env[1187]: time="2025-09-09T00:36:11.863651278Z" level=info msg="ClientConn switching balancer to \"pick_first\"" module=grpc Sep 9 00:36:11.866019 env[1187]: time="2025-09-09T00:36:11.865995798Z" level=info msg="parsed scheme: \"unix\"" module=grpc Sep 9 00:36:11.866120 env[1187]: time="2025-09-09T00:36:11.866105118Z" level=info msg="scheme \"unix\" not registered, fallback to default scheme" module=grpc Sep 9 00:36:11.866182 env[1187]: time="2025-09-09T00:36:11.866165758Z" level=info msg="ccResolverWrapper: sending update to cc: {[{unix:///var/run/docker/libcontainerd/docker-containerd.sock 0 }] }" module=grpc Sep 9 00:36:11.866239 env[1187]: time="2025-09-09T00:36:11.866226678Z" level=info msg="ClientConn switching balancer to \"pick_first\"" module=grpc Sep 9 00:36:11.870192 systemd[1]: var-lib-docker-check\x2doverlayfs\x2dsupport2995867668-merged.mount: Deactivated successfully. Sep 9 00:36:11.898333 env[1187]: time="2025-09-09T00:36:11.898290718Z" level=info msg="Loading containers: start." Sep 9 00:36:12.006451 kernel: Initializing XFRM netlink socket Sep 9 00:36:12.018773 sshd_keygen[1132]: ssh-keygen: generating new host keys: RSA ECDSA ED25519 Sep 9 00:36:12.031376 env[1187]: time="2025-09-09T00:36:12.031340238Z" 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" Sep 9 00:36:12.039978 systemd[1]: Finished sshd-keygen.service. Sep 9 00:36:12.042204 systemd[1]: Starting issuegen.service... Sep 9 00:36:12.047012 systemd[1]: issuegen.service: Deactivated successfully. Sep 9 00:36:12.047164 systemd[1]: Finished issuegen.service. Sep 9 00:36:12.049231 systemd[1]: Starting systemd-user-sessions.service... Sep 9 00:36:12.055063 systemd[1]: Finished systemd-user-sessions.service. Sep 9 00:36:12.057183 systemd[1]: Started getty@tty1.service. Sep 9 00:36:12.059357 systemd[1]: Started serial-getty@ttyAMA0.service. Sep 9 00:36:12.060288 systemd[1]: Reached target getty.target. Sep 9 00:36:12.084983 systemd-networkd[1040]: docker0: Link UP Sep 9 00:36:12.106617 env[1187]: time="2025-09-09T00:36:12.106568238Z" level=info msg="Loading containers: done." Sep 9 00:36:12.121628 systemd[1]: var-lib-docker-overlay2-opaque\x2dbug\x2dcheck2414448736-merged.mount: Deactivated successfully. Sep 9 00:36:12.127855 env[1187]: time="2025-09-09T00:36:12.127805438Z" 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 Sep 9 00:36:12.128021 env[1187]: time="2025-09-09T00:36:12.127991638Z" level=info msg="Docker daemon" commit=112bdf3343 graphdriver(s)=overlay2 version=20.10.23 Sep 9 00:36:12.128117 env[1187]: time="2025-09-09T00:36:12.128095398Z" level=info msg="Daemon has completed initialization" Sep 9 00:36:12.140488 systemd[1]: Started docker.service. Sep 9 00:36:12.147945 env[1187]: time="2025-09-09T00:36:12.147887838Z" level=info msg="API listen on /run/docker.sock" Sep 9 00:36:12.149144 etcd-wrapper[1179]: Error response from daemon: No such container: etcd-member Sep 9 00:36:12.167911 etcd-wrapper[1311]: Error: No such container: etcd-member Sep 9 00:36:12.197028 etcd-wrapper[1332]: Unable to find image 'quay.io/coreos/etcd:v3.5.16' locally Sep 9 00:36:12.929121 etcd-wrapper[1332]: v3.5.16: Pulling from coreos/etcd Sep 9 00:36:13.100389 etcd-wrapper[1332]: d10f96ed9607: Pulling fs layer Sep 9 00:36:13.100512 etcd-wrapper[1332]: 2ae710cd8bfe: Pulling fs layer Sep 9 00:36:13.100512 etcd-wrapper[1332]: d462aa345367: Pulling fs layer Sep 9 00:36:13.100512 etcd-wrapper[1332]: 0f8b424aa0b9: Pulling fs layer Sep 9 00:36:13.100590 etcd-wrapper[1332]: d557676654e5: Pulling fs layer Sep 9 00:36:13.100590 etcd-wrapper[1332]: c8022d07192e: Pulling fs layer Sep 9 00:36:13.100590 etcd-wrapper[1332]: d858cbc252ad: Pulling fs layer Sep 9 00:36:13.100650 etcd-wrapper[1332]: 1069fc2daed1: Pulling fs layer Sep 9 00:36:13.100671 etcd-wrapper[1332]: b40161cd83fc: Pulling fs layer Sep 9 00:36:13.100695 etcd-wrapper[1332]: 5318d93a3a65: Pulling fs layer Sep 9 00:36:13.100802 etcd-wrapper[1332]: 307c1adadb60: Pulling fs layer Sep 9 00:36:13.100802 etcd-wrapper[1332]: f9b3c65df792: Pulling fs layer Sep 9 00:36:13.100802 etcd-wrapper[1332]: 5709b4a82c35: Pulling fs layer Sep 9 00:36:13.100904 etcd-wrapper[1332]: d5372e382b07: Pulling fs layer Sep 9 00:36:13.101333 etcd-wrapper[1332]: 9c3b5253dddc: Pulling fs layer Sep 9 00:36:13.101399 etcd-wrapper[1332]: 7a57323f7551: Pulling fs layer Sep 9 00:36:13.101425 etcd-wrapper[1332]: d557676654e5: Waiting Sep 9 00:36:13.101850 etcd-wrapper[1332]: c8022d07192e: Waiting Sep 9 00:36:13.101884 etcd-wrapper[1332]: d858cbc252ad: Waiting Sep 9 00:36:13.101919 etcd-wrapper[1332]: 1069fc2daed1: Waiting Sep 9 00:36:13.101954 etcd-wrapper[1332]: b40161cd83fc: Waiting Sep 9 00:36:13.101990 etcd-wrapper[1332]: 5318d93a3a65: Waiting Sep 9 00:36:13.102026 etcd-wrapper[1332]: 307c1adadb60: Waiting Sep 9 00:36:13.102067 etcd-wrapper[1332]: f9b3c65df792: Waiting Sep 9 00:36:13.102103 etcd-wrapper[1332]: 5709b4a82c35: Waiting Sep 9 00:36:13.102140 etcd-wrapper[1332]: d5372e382b07: Waiting Sep 9 00:36:13.102178 etcd-wrapper[1332]: 9c3b5253dddc: Waiting Sep 9 00:36:13.102214 etcd-wrapper[1332]: 7a57323f7551: Waiting Sep 9 00:36:13.102249 etcd-wrapper[1332]: 0f8b424aa0b9: Waiting Sep 9 00:36:13.231412 etcd-wrapper[1332]: 2ae710cd8bfe: Download complete Sep 9 00:36:13.274001 etcd-wrapper[1332]: d10f96ed9607: Verifying Checksum Sep 9 00:36:13.274001 etcd-wrapper[1332]: d10f96ed9607: Download complete Sep 9 00:36:13.319455 etcd-wrapper[1332]: d10f96ed9607: Pull complete Sep 9 00:36:13.357103 etcd-wrapper[1332]: 0f8b424aa0b9: Verifying Checksum Sep 9 00:36:13.357103 etcd-wrapper[1332]: 0f8b424aa0b9: Download complete Sep 9 00:36:13.357865 systemd[1]: var-lib-docker-overlay2-4a4647c2afbd17e1f9929d5fc290db36f40d189d9270cc6c879d09bbe2d5c647-merged.mount: Deactivated successfully. Sep 9 00:36:13.375925 etcd-wrapper[1332]: 2ae710cd8bfe: Pull complete Sep 9 00:36:13.497786 etcd-wrapper[1332]: d557676654e5: Verifying Checksum Sep 9 00:36:13.497786 etcd-wrapper[1332]: d557676654e5: Download complete Sep 9 00:36:13.505545 etcd-wrapper[1332]: c8022d07192e: Verifying Checksum Sep 9 00:36:13.505545 etcd-wrapper[1332]: c8022d07192e: Download complete Sep 9 00:36:13.628639 etcd-wrapper[1332]: d858cbc252ad: Verifying Checksum Sep 9 00:36:13.628639 etcd-wrapper[1332]: d858cbc252ad: Download complete Sep 9 00:36:13.661742 etcd-wrapper[1332]: 1069fc2daed1: Verifying Checksum Sep 9 00:36:13.661864 etcd-wrapper[1332]: 1069fc2daed1: Download complete Sep 9 00:36:13.690063 etcd-wrapper[1332]: d462aa345367: Verifying Checksum Sep 9 00:36:13.690190 etcd-wrapper[1332]: d462aa345367: Download complete Sep 9 00:36:13.753685 etcd-wrapper[1332]: b40161cd83fc: Verifying Checksum Sep 9 00:36:13.753685 etcd-wrapper[1332]: b40161cd83fc: Download complete Sep 9 00:36:13.813826 etcd-wrapper[1332]: 5318d93a3a65: Verifying Checksum Sep 9 00:36:13.813956 etcd-wrapper[1332]: 5318d93a3a65: Download complete Sep 9 00:36:13.841880 systemd[1]: var-lib-docker-overlay2-88143ebef4c2d76097887469ec3575798e5fe75b86272592dac1983857f5ae87-merged.mount: Deactivated successfully. Sep 9 00:36:13.874499 etcd-wrapper[1332]: d462aa345367: Pull complete Sep 9 00:36:13.901615 etcd-wrapper[1332]: 307c1adadb60: Verifying Checksum Sep 9 00:36:13.901744 etcd-wrapper[1332]: 307c1adadb60: Download complete Sep 9 00:36:13.916388 etcd-wrapper[1332]: 0f8b424aa0b9: Pull complete Sep 9 00:36:13.971123 etcd-wrapper[1332]: f9b3c65df792: Verifying Checksum Sep 9 00:36:13.971123 etcd-wrapper[1332]: f9b3c65df792: Download complete Sep 9 00:36:13.980415 etcd-wrapper[1332]: d557676654e5: Pull complete Sep 9 00:36:14.023752 etcd-wrapper[1332]: c8022d07192e: Pull complete Sep 9 00:36:14.076642 etcd-wrapper[1332]: d858cbc252ad: Pull complete Sep 9 00:36:14.088487 etcd-wrapper[1332]: 5709b4a82c35: Verifying Checksum Sep 9 00:36:14.124261 etcd-wrapper[1332]: d5372e382b07: Verifying Checksum Sep 9 00:36:14.124261 etcd-wrapper[1332]: d5372e382b07: Download complete Sep 9 00:36:14.138997 etcd-wrapper[1332]: 1069fc2daed1: Pull complete Sep 9 00:36:14.180622 etcd-wrapper[1332]: 9c3b5253dddc: Verifying Checksum Sep 9 00:36:14.180622 etcd-wrapper[1332]: 9c3b5253dddc: Download complete Sep 9 00:36:14.181495 etcd-wrapper[1332]: b40161cd83fc: Pull complete Sep 9 00:36:14.225659 etcd-wrapper[1332]: 5318d93a3a65: Pull complete Sep 9 00:36:14.269509 etcd-wrapper[1332]: 307c1adadb60: Pull complete Sep 9 00:36:14.315977 etcd-wrapper[1332]: 7a57323f7551: Verifying Checksum Sep 9 00:36:14.316084 etcd-wrapper[1332]: 7a57323f7551: Download complete Sep 9 00:36:14.323397 systemd[1]: var-lib-docker-overlay2-f459cf829f469f033b7265444533a12e51eba65212acfcb1e3c8838ca14f9b83-merged.mount: Deactivated successfully. Sep 9 00:36:14.538589 systemd[1]: var-lib-docker-overlay2-88172f1bea9d8d18986baf592c1fa18392b5819e1d55c91cf830eb53aeb97fff-merged.mount: Deactivated successfully. Sep 9 00:36:14.572530 etcd-wrapper[1332]: f9b3c65df792: Pull complete Sep 9 00:36:14.782746 systemd[1]: var-lib-docker-overlay2-d741dff014142627d6e51e31b05466752dcf69850eabc039d3aad2e4f5cf6ace-merged.mount: Deactivated successfully. Sep 9 00:36:14.809622 etcd-wrapper[1332]: 5709b4a82c35: Pull complete Sep 9 00:36:15.017520 etcd-wrapper[1332]: d5372e382b07: Pull complete Sep 9 00:36:15.082475 etcd-wrapper[1332]: 9c3b5253dddc: Pull complete Sep 9 00:36:15.137599 etcd-wrapper[1332]: 7a57323f7551: Pull complete Sep 9 00:36:15.144613 etcd-wrapper[1332]: Digest: sha256:d967d98a12dc220a1a290794711dba7eba04b8ce465e12b02383d1bfbb33e159 Sep 9 00:36:15.147276 etcd-wrapper[1332]: Status: Downloaded newer image for quay.io/coreos/etcd:v3.5.16 Sep 9 00:36:15.235147 env[1135]: time="2025-09-09T00:36:15.234911918Z" level=info msg="loading plugin \"io.containerd.event.v1.publisher\"..." runtime=io.containerd.runc.v2 type=io.containerd.event.v1 Sep 9 00:36:15.235147 env[1135]: time="2025-09-09T00:36:15.234949798Z" level=info msg="loading plugin \"io.containerd.internal.v1.shutdown\"..." runtime=io.containerd.runc.v2 type=io.containerd.internal.v1 Sep 9 00:36:15.235147 env[1135]: time="2025-09-09T00:36:15.234960238Z" level=info msg="loading plugin \"io.containerd.ttrpc.v1.task\"..." runtime=io.containerd.runc.v2 type=io.containerd.ttrpc.v1 Sep 9 00:36:15.235578 env[1135]: time="2025-09-09T00:36:15.235199278Z" level=info msg="starting signal loop" namespace=moby path=/run/containerd/io.containerd.runtime.v2.task/moby/0f2d4f1d044cfa0367cddcbfe6c5d49feeb0f91bf2c71968e95c10d51b2d1263 pid=1522 runtime=io.containerd.runc.v2 Sep 9 00:36:15.245077 systemd[1]: Started docker-0f2d4f1d044cfa0367cddcbfe6c5d49feeb0f91bf2c71968e95c10d51b2d1263.scope. Sep 9 00:36:15.264001 systemd-resolved[1088]: Failed to determine the local hostname and LLMNR/mDNS names, ignoring: No such device or address Sep 9 00:36:15.298525 etcd-wrapper[1332]: {"level":"info","ts":"2025-09-09T00:36:15.298110Z","caller":"flags/flag.go:113","msg":"recognized and used environment variable","variable-name":"ETCD_DATA_DIR","variable-value":"/var/lib/etcd"} Sep 9 00:36:15.298525 etcd-wrapper[1332]: {"level":"info","ts":"2025-09-09T00:36:15.298245Z","caller":"flags/flag.go:113","msg":"recognized and used environment variable","variable-name":"ETCD_NAME","variable-value":"33e67a1b46624fa58932b540518f23ff"} Sep 9 00:36:15.298525 etcd-wrapper[1332]: {"level":"warn","ts":"2025-09-09T00:36:15.298269Z","caller":"flags/flag.go:93","msg":"unrecognized environment variable","environment-variable":"ETCD_IMAGE_URL=quay.io/coreos/etcd"} Sep 9 00:36:15.298525 etcd-wrapper[1332]: {"level":"warn","ts":"2025-09-09T00:36:15.298284Z","caller":"flags/flag.go:93","msg":"unrecognized environment variable","environment-variable":"ETCD_IMAGE_TAG=v3.5.16"} Sep 9 00:36:15.298525 etcd-wrapper[1332]: {"level":"warn","ts":"2025-09-09T00:36:15.298290Z","caller":"flags/flag.go:93","msg":"unrecognized environment variable","environment-variable":"ETCD_USER=etcd"} Sep 9 00:36:15.298525 etcd-wrapper[1332]: {"level":"warn","ts":"2025-09-09T00:36:15.298293Z","caller":"flags/flag.go:93","msg":"unrecognized environment variable","environment-variable":"ETCD_SSL_DIR=/etc/ssl/certs"} Sep 9 00:36:15.298525 etcd-wrapper[1332]: {"level":"warn","ts":"2025-09-09T00:36:15.298351Z","caller":"embed/config.go:689","msg":"Running http and grpc server on single port. This is not recommended for production."} Sep 9 00:36:15.299078 etcd-wrapper[1332]: {"level":"info","ts":"2025-09-09T00:36:15.298367Z","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.89:2379"]} Sep 9 00:36:15.299078 etcd-wrapper[1332]: {"level":"warn","ts":"2025-09-09T00:36:15.298439Z","caller":"embed/config.go:689","msg":"Running http and grpc server on single port. This is not recommended for production."} Sep 9 00:36:15.299078 etcd-wrapper[1332]: {"level":"info","ts":"2025-09-09T00:36:15.298449Z","caller":"embed/etcd.go:128","msg":"configuring peer listeners","listen-peer-urls":["http://localhost:2380"]} Sep 9 00:36:15.299078 etcd-wrapper[1332]: {"level":"info","ts":"2025-09-09T00:36:15.298842Z","caller":"embed/etcd.go:136","msg":"configuring client listeners","listen-client-urls":["http://0.0.0.0:2379"]} Sep 9 00:36:15.299196 etcd-wrapper[1332]: {"level":"info","ts":"2025-09-09T00:36:15.298952Z","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":"33e67a1b46624fa58932b540518f23ff","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.89:2379"],"listen-client-urls":["http://0.0.0.0:2379"],"listen-metrics-urls":[],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"33e67a1b46624fa58932b540518f23ff=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"} Sep 9 00:36:15.300575 etcd-wrapper[1332]: {"level":"info","ts":"2025-09-09T00:36:15.300430Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"1.26508ms"} Sep 9 00:36:15.302631 etcd-wrapper[1332]: {"level":"info","ts":"2025-09-09T00:36:15.302466Z","caller":"etcdserver/raft.go:505","msg":"starting local member","local-member-id":"8e9e05c52164694d","cluster-id":"cdf818194e3a8c32"} Sep 9 00:36:15.302813 etcd-wrapper[1332]: {"level":"info","ts":"2025-09-09T00:36:15.302650Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"8e9e05c52164694d switched to configuration voters=()"} Sep 9 00:36:15.302813 etcd-wrapper[1332]: {"level":"info","ts":"2025-09-09T00:36:15.302676Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"8e9e05c52164694d became follower at term 0"} Sep 9 00:36:15.302813 etcd-wrapper[1332]: {"level":"info","ts":"2025-09-09T00:36:15.302684Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 8e9e05c52164694d [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} Sep 9 00:36:15.302813 etcd-wrapper[1332]: {"level":"info","ts":"2025-09-09T00:36:15.302694Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"8e9e05c52164694d became follower at term 1"} Sep 9 00:36:15.302813 etcd-wrapper[1332]: {"level":"info","ts":"2025-09-09T00:36:15.302721Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"8e9e05c52164694d switched to configuration voters=(10276657743932975437)"} Sep 9 00:36:15.304851 etcd-wrapper[1332]: {"level":"warn","ts":"2025-09-09T00:36:15.304691Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} Sep 9 00:36:15.305352 etcd-wrapper[1332]: {"level":"info","ts":"2025-09-09T00:36:15.305213Z","caller":"mvcc/kvstore.go:423","msg":"kvstore restored","current-rev":1} Sep 9 00:36:15.305808 etcd-wrapper[1332]: {"level":"info","ts":"2025-09-09T00:36:15.305668Z","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"} Sep 9 00:36:15.306176 etcd-wrapper[1332]: {"level":"info","ts":"2025-09-09T00:36:15.306070Z","caller":"etcdserver/server.go:873","msg":"starting etcd server","local-member-id":"8e9e05c52164694d","local-server-version":"3.5.16","cluster-version":"to_be_decided"} Sep 9 00:36:15.306794 etcd-wrapper[1332]: {"level":"info","ts":"2025-09-09T00:36:15.306244Z","caller":"v3rpc/health.go:61","msg":"grpc service status changed","service":"","status":"SERVING"} Sep 9 00:36:15.306794 etcd-wrapper[1332]: {"level":"info","ts":"2025-09-09T00:36:15.306362Z","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"} Sep 9 00:36:15.306794 etcd-wrapper[1332]: {"level":"info","ts":"2025-09-09T00:36:15.306499Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/snap","suffix":"snap.db","max":5,"interval":"30s"} Sep 9 00:36:15.306794 etcd-wrapper[1332]: {"level":"info","ts":"2025-09-09T00:36:15.306528Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/snap","suffix":"snap","max":5,"interval":"30s"} Sep 9 00:36:15.306794 etcd-wrapper[1332]: {"level":"info","ts":"2025-09-09T00:36:15.306534Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/wal","suffix":"wal","max":5,"interval":"30s"} Sep 9 00:36:15.306794 etcd-wrapper[1332]: {"level":"info","ts":"2025-09-09T00:36:15.306566Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"8e9e05c52164694d switched to configuration voters=(10276657743932975437)"} Sep 9 00:36:15.306794 etcd-wrapper[1332]: {"level":"info","ts":"2025-09-09T00:36:15.306632Z","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"]} Sep 9 00:36:15.308811 etcd-wrapper[1332]: {"level":"info","ts":"2025-09-09T00:36:15.308635Z","caller":"embed/etcd.go:600","msg":"serving peer traffic","address":"127.0.0.1:2380"} Sep 9 00:36:15.308811 etcd-wrapper[1332]: {"level":"info","ts":"2025-09-09T00:36:15.308663Z","caller":"embed/etcd.go:572","msg":"cmux::serve","address":"127.0.0.1:2380"} Sep 9 00:36:15.308811 etcd-wrapper[1332]: {"level":"info","ts":"2025-09-09T00:36:15.308661Z","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.89:2379"],"listen-client-urls":["http://0.0.0.0:2379"],"listen-metrics-urls":[]} Sep 9 00:36:15.323867 systemd[1]: var-lib-docker-overlay2-83c707edf2afdfcf2fde8e80ca2deb329f47f0f8b333b67b33666f495053ea87-merged.mount: Deactivated successfully. Sep 9 00:36:15.403436 etcd-wrapper[1332]: {"level":"info","ts":"2025-09-09T00:36:15.402857Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"8e9e05c52164694d is starting a new election at term 1"} Sep 9 00:36:15.403436 etcd-wrapper[1332]: {"level":"info","ts":"2025-09-09T00:36:15.402916Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"8e9e05c52164694d became pre-candidate at term 1"} Sep 9 00:36:15.403436 etcd-wrapper[1332]: {"level":"info","ts":"2025-09-09T00:36:15.402948Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"8e9e05c52164694d received MsgPreVoteResp from 8e9e05c52164694d at term 1"} Sep 9 00:36:15.403436 etcd-wrapper[1332]: {"level":"info","ts":"2025-09-09T00:36:15.402966Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"8e9e05c52164694d became candidate at term 2"} Sep 9 00:36:15.403436 etcd-wrapper[1332]: {"level":"info","ts":"2025-09-09T00:36:15.402977Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"8e9e05c52164694d received MsgVoteResp from 8e9e05c52164694d at term 2"} Sep 9 00:36:15.403436 etcd-wrapper[1332]: {"level":"info","ts":"2025-09-09T00:36:15.402992Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"8e9e05c52164694d became leader at term 2"} Sep 9 00:36:15.403436 etcd-wrapper[1332]: {"level":"info","ts":"2025-09-09T00:36:15.403003Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 8e9e05c52164694d elected leader 8e9e05c52164694d at term 2"} Sep 9 00:36:15.414634 etcd-wrapper[1332]: {"level":"info","ts":"2025-09-09T00:36:15.414440Z","caller":"etcdserver/server.go:2651","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} Sep 9 00:36:15.421368 etcd-wrapper[1332]: {"level":"info","ts":"2025-09-09T00:36:15.421192Z","caller":"etcdserver/server.go:2140","msg":"published local member to cluster through raft","local-member-id":"8e9e05c52164694d","local-member-attributes":"{Name:33e67a1b46624fa58932b540518f23ff ClientURLs:[http://10.0.0.89:2379]}","request-path":"/0/members/8e9e05c52164694d/attributes","cluster-id":"cdf818194e3a8c32","publish-timeout":"7s"} Sep 9 00:36:15.421368 etcd-wrapper[1332]: {"level":"info","ts":"2025-09-09T00:36:15.421226Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} Sep 9 00:36:15.421588 etcd-wrapper[1332]: {"level":"info","ts":"2025-09-09T00:36:15.421438Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} Sep 9 00:36:15.421830 systemd[1]: Started etcd-member.service. Sep 9 00:36:15.422729 systemd[1]: Reached target multi-user.target. Sep 9 00:36:15.423516 etcd-wrapper[1332]: {"level":"info","ts":"2025-09-09T00:36:15.421641Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} Sep 9 00:36:15.423516 etcd-wrapper[1332]: {"level":"info","ts":"2025-09-09T00:36:15.422500Z","caller":"v3rpc/health.go:61","msg":"grpc service status changed","service":"","status":"SERVING"} Sep 9 00:36:15.424184 etcd-wrapper[1332]: {"level":"info","ts":"2025-09-09T00:36:15.423726Z","caller":"embed/serve.go:187","msg":"serving client traffic insecurely; this is strongly discouraged!","traffic":"grpc+http","address":"[::]:2379"} Sep 9 00:36:15.424784 systemd[1]: Starting systemd-update-utmp-runlevel.service... Sep 9 00:36:15.428394 etcd-wrapper[1332]: {"level":"info","ts":"2025-09-09T00:36:15.428213Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"cdf818194e3a8c32","local-member-id":"8e9e05c52164694d","cluster-version":"3.5"} Sep 9 00:36:15.428394 etcd-wrapper[1332]: {"level":"info","ts":"2025-09-09T00:36:15.428284Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} Sep 9 00:36:15.428593 etcd-wrapper[1332]: {"level":"info","ts":"2025-09-09T00:36:15.428402Z","caller":"etcdserver/server.go:2675","msg":"cluster version is updated","cluster-version":"3.5"} Sep 9 00:36:15.431600 systemd[1]: systemd-update-utmp-runlevel.service: Deactivated successfully. Sep 9 00:36:15.431785 systemd[1]: Finished systemd-update-utmp-runlevel.service. Sep 9 00:36:15.432643 systemd[1]: Startup finished in 628ms (kernel) + 3.328s (initrd) + 8.114s (userspace) = 12.071s. Sep 9 00:36:16.748967 systemd[1]: Created slice system-sshd.slice. Sep 9 00:36:16.751714 systemd[1]: Started sshd@0-10.0.0.89:22-10.0.0.1:38372.service. Sep 9 00:36:16.793481 sshd[1567]: Accepted publickey for core from 10.0.0.1 port 38372 ssh2: RSA SHA256:SJL83fEN2Ip3G6nq+SFahxwHER39rSdiWTx9teXxMXo Sep 9 00:36:16.796036 sshd[1567]: pam_unix(sshd:session): session opened for user core(uid=500) by (uid=0) Sep 9 00:36:16.805594 systemd-logind[1124]: New session 1 of user core. Sep 9 00:36:16.806596 systemd[1]: Created slice user-500.slice. Sep 9 00:36:16.807776 systemd[1]: Starting user-runtime-dir@500.service... Sep 9 00:36:16.815956 systemd[1]: Finished user-runtime-dir@500.service. Sep 9 00:36:16.817390 systemd[1]: Starting user@500.service... Sep 9 00:36:16.820493 (systemd)[1570]: pam_unix(systemd-user:session): session opened for user core(uid=500) by (uid=0) Sep 9 00:36:16.909568 systemd[1570]: Queued start job for default target default.target. Sep 9 00:36:16.910374 systemd[1570]: Reached target paths.target. Sep 9 00:36:16.910400 systemd[1570]: Reached target sockets.target. Sep 9 00:36:16.910419 systemd[1570]: Reached target timers.target. Sep 9 00:36:16.910432 systemd[1570]: Reached target basic.target. Sep 9 00:36:16.910480 systemd[1570]: Reached target default.target. Sep 9 00:36:16.910506 systemd[1570]: Startup finished in 82ms. Sep 9 00:36:16.910570 systemd[1]: Started user@500.service. Sep 9 00:36:16.911943 systemd[1]: Started session-1.scope. Sep 9 00:36:16.963818 systemd[1]: Started sshd@1-10.0.0.89:22-10.0.0.1:38382.service. Sep 9 00:36:17.011579 sshd[1579]: Accepted publickey for core from 10.0.0.1 port 38382 ssh2: RSA SHA256:SJL83fEN2Ip3G6nq+SFahxwHER39rSdiWTx9teXxMXo Sep 9 00:36:17.012820 sshd[1579]: pam_unix(sshd:session): session opened for user core(uid=500) by (uid=0) Sep 9 00:36:17.016391 systemd-logind[1124]: New session 2 of user core. Sep 9 00:36:17.017245 systemd[1]: Started session-2.scope. Sep 9 00:36:17.073033 sshd[1579]: pam_unix(sshd:session): session closed for user core Sep 9 00:36:17.076460 systemd[1]: Started sshd@2-10.0.0.89:22-10.0.0.1:38398.service. Sep 9 00:36:17.076897 systemd[1]: sshd@1-10.0.0.89:22-10.0.0.1:38382.service: Deactivated successfully. Sep 9 00:36:17.077597 systemd[1]: session-2.scope: Deactivated successfully. Sep 9 00:36:17.078403 systemd-logind[1124]: Session 2 logged out. Waiting for processes to exit. Sep 9 00:36:17.079357 systemd-logind[1124]: Removed session 2. Sep 9 00:36:17.107820 sshd[1584]: Accepted publickey for core from 10.0.0.1 port 38398 ssh2: RSA SHA256:SJL83fEN2Ip3G6nq+SFahxwHER39rSdiWTx9teXxMXo Sep 9 00:36:17.109055 sshd[1584]: pam_unix(sshd:session): session opened for user core(uid=500) by (uid=0) Sep 9 00:36:17.112542 systemd-logind[1124]: New session 3 of user core. Sep 9 00:36:17.113310 systemd[1]: Started session-3.scope. Sep 9 00:36:17.164272 sshd[1584]: pam_unix(sshd:session): session closed for user core Sep 9 00:36:17.168267 systemd[1]: sshd@2-10.0.0.89:22-10.0.0.1:38398.service: Deactivated successfully. Sep 9 00:36:17.168880 systemd[1]: session-3.scope: Deactivated successfully. Sep 9 00:36:17.169382 systemd-logind[1124]: Session 3 logged out. Waiting for processes to exit. Sep 9 00:36:17.170483 systemd[1]: Started sshd@3-10.0.0.89:22-10.0.0.1:38414.service. Sep 9 00:36:17.171064 systemd-logind[1124]: Removed session 3. Sep 9 00:36:17.202311 sshd[1591]: Accepted publickey for core from 10.0.0.1 port 38414 ssh2: RSA SHA256:SJL83fEN2Ip3G6nq+SFahxwHER39rSdiWTx9teXxMXo Sep 9 00:36:17.203662 sshd[1591]: pam_unix(sshd:session): session opened for user core(uid=500) by (uid=0) Sep 9 00:36:17.207487 systemd-logind[1124]: New session 4 of user core. Sep 9 00:36:17.208216 systemd[1]: Started session-4.scope. Sep 9 00:36:17.263822 sshd[1591]: pam_unix(sshd:session): session closed for user core Sep 9 00:36:17.267769 systemd[1]: Started sshd@4-10.0.0.89:22-10.0.0.1:38422.service. Sep 9 00:36:17.268262 systemd[1]: sshd@3-10.0.0.89:22-10.0.0.1:38414.service: Deactivated successfully. Sep 9 00:36:17.268955 systemd[1]: session-4.scope: Deactivated successfully. Sep 9 00:36:17.269448 systemd-logind[1124]: Session 4 logged out. Waiting for processes to exit. Sep 9 00:36:17.270139 systemd-logind[1124]: Removed session 4. Sep 9 00:36:17.300908 sshd[1596]: Accepted publickey for core from 10.0.0.1 port 38422 ssh2: RSA SHA256:SJL83fEN2Ip3G6nq+SFahxwHER39rSdiWTx9teXxMXo Sep 9 00:36:17.302118 sshd[1596]: pam_unix(sshd:session): session opened for user core(uid=500) by (uid=0) Sep 9 00:36:17.306185 systemd-logind[1124]: New session 5 of user core. Sep 9 00:36:17.306629 systemd[1]: Started session-5.scope. Sep 9 00:36:17.362648 sudo[1600]: core : PWD=/home/core ; USER=root ; COMMAND=/usr/sbin/setenforce 1 Sep 9 00:36:17.362861 sudo[1600]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=500) Sep 9 00:36:17.377587 dbus-daemon[1114]: avc: received setenforce notice (enforcing=1) Sep 9 00:36:17.379721 sudo[1600]: pam_unix(sudo:session): session closed for user root Sep 9 00:36:17.382933 sshd[1596]: pam_unix(sshd:session): session closed for user core Sep 9 00:36:17.387363 systemd[1]: Started sshd@5-10.0.0.89:22-10.0.0.1:38438.service. Sep 9 00:36:17.388017 systemd[1]: sshd@4-10.0.0.89:22-10.0.0.1:38422.service: Deactivated successfully. Sep 9 00:36:17.388707 systemd[1]: session-5.scope: Deactivated successfully. Sep 9 00:36:17.389303 systemd-logind[1124]: Session 5 logged out. Waiting for processes to exit. Sep 9 00:36:17.390380 systemd-logind[1124]: Removed session 5. Sep 9 00:36:17.419241 sshd[1603]: Accepted publickey for core from 10.0.0.1 port 38438 ssh2: RSA SHA256:SJL83fEN2Ip3G6nq+SFahxwHER39rSdiWTx9teXxMXo Sep 9 00:36:17.421067 sshd[1603]: pam_unix(sshd:session): session opened for user core(uid=500) by (uid=0) Sep 9 00:36:17.424977 systemd-logind[1124]: New session 6 of user core. Sep 9 00:36:17.425450 systemd[1]: Started session-6.scope. Sep 9 00:36:17.477991 sudo[1609]: core : PWD=/home/core ; USER=root ; COMMAND=/usr/bin/rm -rf /etc/audit/rules.d/80-selinux.rules /etc/audit/rules.d/99-default.rules Sep 9 00:36:17.478502 sudo[1609]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=500) Sep 9 00:36:17.481257 sudo[1609]: pam_unix(sudo:session): session closed for user root Sep 9 00:36:17.485831 sudo[1608]: core : PWD=/home/core ; USER=root ; COMMAND=/usr/bin/systemctl restart audit-rules Sep 9 00:36:17.486036 sudo[1608]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=500) Sep 9 00:36:17.494895 systemd[1]: Stopping audit-rules.service... Sep 9 00:36:17.494000 audit: CONFIG_CHANGE auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 op=remove_rule key=(null) list=5 res=1 Sep 9 00:36:17.496692 kernel: kauditd_printk_skb: 73 callbacks suppressed Sep 9 00:36:17.496745 kernel: audit: type=1305 audit(1757378177.494:161): auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 op=remove_rule key=(null) list=5 res=1 Sep 9 00:36:17.497624 auditctl[1612]: No rules Sep 9 00:36:17.497882 systemd[1]: audit-rules.service: Deactivated successfully. Sep 9 00:36:17.494000 audit[1612]: SYSCALL arch=c00000b7 syscall=206 success=yes exit=1056 a0=3 a1=ffffe747f190 a2=420 a3=0 items=0 ppid=1 pid=1612 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) Sep 9 00:36:17.498077 systemd[1]: Stopped audit-rules.service. Sep 9 00:36:17.499659 systemd[1]: Starting audit-rules.service... Sep 9 00:36:17.500972 kernel: audit: type=1300 audit(1757378177.494:161): arch=c00000b7 syscall=206 success=yes exit=1056 a0=3 a1=ffffe747f190 a2=420 a3=0 items=0 ppid=1 pid=1612 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) Sep 9 00:36:17.501024 kernel: audit: type=1327 audit(1757378177.494:161): proctitle=2F7362696E2F617564697463746C002D44 Sep 9 00:36:17.494000 audit: PROCTITLE proctitle=2F7362696E2F617564697463746C002D44 Sep 9 00:36:17.501870 kernel: audit: type=1131 audit(1757378177.496:162): pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=audit-rules comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Sep 9 00:36:17.496000 audit[1]: SERVICE_STOP pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=audit-rules comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Sep 9 00:36:17.517635 augenrules[1629]: No rules Sep 9 00:36:17.518988 systemd[1]: Finished audit-rules.service. Sep 9 00:36:17.517000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=audit-rules comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Sep 9 00:36:17.519000 audit[1608]: USER_END pid=1608 uid=500 auid=500 ses=6 subj=system_u:system_r:kernel_t:s0 msg='op=PAM:session_close grantors=pam_limits,pam_env,pam_unix,pam_permit,pam_systemd acct="root" exe="/usr/bin/sudo" hostname=? addr=? terminal=? res=success' Sep 9 00:36:17.520915 sudo[1608]: pam_unix(sudo:session): session closed for user root Sep 9 00:36:17.524072 kernel: audit: type=1130 audit(1757378177.517:163): pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=audit-rules comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Sep 9 00:36:17.524147 kernel: audit: type=1106 audit(1757378177.519:164): pid=1608 uid=500 auid=500 ses=6 subj=system_u:system_r:kernel_t:s0 msg='op=PAM:session_close grantors=pam_limits,pam_env,pam_unix,pam_permit,pam_systemd acct="root" exe="/usr/bin/sudo" hostname=? addr=? terminal=? res=success' Sep 9 00:36:17.524241 sshd[1603]: pam_unix(sshd:session): session closed for user core Sep 9 00:36:17.519000 audit[1608]: CRED_DISP pid=1608 uid=500 auid=500 ses=6 subj=system_u:system_r:kernel_t:s0 msg='op=PAM:setcred grantors=pam_env,pam_faillock,pam_unix acct="root" exe="/usr/bin/sudo" hostname=? addr=? terminal=? res=success' Sep 9 00:36:17.526677 kernel: audit: type=1104 audit(1757378177.519:165): pid=1608 uid=500 auid=500 ses=6 subj=system_u:system_r:kernel_t:s0 msg='op=PAM:setcred grantors=pam_env,pam_faillock,pam_unix acct="root" exe="/usr/bin/sudo" hostname=? addr=? terminal=? res=success' Sep 9 00:36:17.525000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=sshd@6-10.0.0.89:22-10.0.0.1:38452 comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Sep 9 00:36:17.526916 systemd[1]: Started sshd@6-10.0.0.89:22-10.0.0.1:38452.service. Sep 9 00:36:17.529460 kernel: audit: type=1130 audit(1757378177.525:166): pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=sshd@6-10.0.0.89:22-10.0.0.1:38452 comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Sep 9 00:36:17.528000 audit[1603]: USER_END pid=1603 uid=0 auid=500 ses=6 subj=system_u:system_r:kernel_t:s0 msg='op=PAM:session_close grantors=pam_loginuid,pam_env,pam_lastlog,pam_limits,pam_env,pam_unix,pam_permit,pam_systemd,pam_mail acct="core" exe="/usr/sbin/sshd" hostname=10.0.0.1 addr=10.0.0.1 terminal=ssh res=success' Sep 9 00:36:17.533231 kernel: audit: type=1106 audit(1757378177.528:167): pid=1603 uid=0 auid=500 ses=6 subj=system_u:system_r:kernel_t:s0 msg='op=PAM:session_close grantors=pam_loginuid,pam_env,pam_lastlog,pam_limits,pam_env,pam_unix,pam_permit,pam_systemd,pam_mail acct="core" exe="/usr/sbin/sshd" hostname=10.0.0.1 addr=10.0.0.1 terminal=ssh res=success' Sep 9 00:36:17.533500 systemd[1]: sshd@5-10.0.0.89:22-10.0.0.1:38438.service: Deactivated successfully. Sep 9 00:36:17.528000 audit[1603]: CRED_DISP pid=1603 uid=0 auid=500 ses=6 subj=system_u:system_r:kernel_t:s0 msg='op=PAM:setcred grantors=pam_env,pam_faillock,pam_unix acct="core" exe="/usr/sbin/sshd" hostname=10.0.0.1 addr=10.0.0.1 terminal=ssh res=success' Sep 9 00:36:17.534163 systemd[1]: session-6.scope: Deactivated successfully. Sep 9 00:36:17.537389 kernel: audit: type=1104 audit(1757378177.528:168): pid=1603 uid=0 auid=500 ses=6 subj=system_u:system_r:kernel_t:s0 msg='op=PAM:setcred grantors=pam_env,pam_faillock,pam_unix acct="core" exe="/usr/sbin/sshd" hostname=10.0.0.1 addr=10.0.0.1 terminal=ssh res=success' Sep 9 00:36:17.532000 audit[1]: SERVICE_STOP pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=sshd@5-10.0.0.89:22-10.0.0.1:38438 comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Sep 9 00:36:17.537786 systemd-logind[1124]: Session 6 logged out. Waiting for processes to exit. Sep 9 00:36:17.539636 systemd-logind[1124]: Removed session 6. Sep 9 00:36:17.557000 audit[1634]: USER_ACCT pid=1634 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='op=PAM:accounting grantors=pam_access,pam_unix,pam_faillock,pam_permit acct="core" exe="/usr/sbin/sshd" hostname=10.0.0.1 addr=10.0.0.1 terminal=ssh res=success' Sep 9 00:36:17.559286 sshd[1634]: Accepted publickey for core from 10.0.0.1 port 38452 ssh2: RSA SHA256:SJL83fEN2Ip3G6nq+SFahxwHER39rSdiWTx9teXxMXo Sep 9 00:36:17.558000 audit[1634]: CRED_ACQ pid=1634 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='op=PAM:setcred grantors=pam_env,pam_faillock,pam_unix acct="core" exe="/usr/sbin/sshd" hostname=10.0.0.1 addr=10.0.0.1 terminal=ssh res=success' Sep 9 00:36:17.558000 audit[1634]: SYSCALL arch=c00000b7 syscall=64 success=yes exit=3 a0=5 a1=ffffe739f520 a2=3 a3=1 items=0 ppid=1 pid=1634 auid=500 uid=0 gid=0 euid=0 suid=0 fsuid=0 egid=0 sgid=0 fsgid=0 tty=(none) ses=7 comm="sshd" exe="/usr/sbin/sshd" subj=system_u:system_r:kernel_t:s0 key=(null) Sep 9 00:36:17.558000 audit: PROCTITLE proctitle=737368643A20636F7265205B707269765D Sep 9 00:36:17.560478 sshd[1634]: pam_unix(sshd:session): session opened for user core(uid=500) by (uid=0) Sep 9 00:36:17.564391 systemd[1]: Started session-7.scope. Sep 9 00:36:17.565364 systemd-logind[1124]: New session 7 of user core. Sep 9 00:36:17.567000 audit[1634]: USER_START pid=1634 uid=0 auid=500 ses=7 subj=system_u:system_r:kernel_t:s0 msg='op=PAM:session_open grantors=pam_loginuid,pam_env,pam_lastlog,pam_limits,pam_env,pam_unix,pam_permit,pam_systemd,pam_mail acct="core" exe="/usr/sbin/sshd" hostname=10.0.0.1 addr=10.0.0.1 terminal=ssh res=success' Sep 9 00:36:17.568000 audit[1637]: CRED_ACQ pid=1637 uid=0 auid=500 ses=7 subj=system_u:system_r:kernel_t:s0 msg='op=PAM:setcred grantors=pam_env,pam_faillock,pam_unix acct="core" exe="/usr/sbin/sshd" hostname=10.0.0.1 addr=10.0.0.1 terminal=ssh res=success' Sep 9 00:36:17.617049 sshd[1634]: pam_unix(sshd:session): session closed for user core Sep 9 00:36:17.616000 audit[1634]: USER_END pid=1634 uid=0 auid=500 ses=7 subj=system_u:system_r:kernel_t:s0 msg='op=PAM:session_close grantors=pam_loginuid,pam_env,pam_lastlog,pam_limits,pam_env,pam_unix,pam_permit,pam_systemd,pam_mail acct="core" exe="/usr/sbin/sshd" hostname=10.0.0.1 addr=10.0.0.1 terminal=ssh res=success' Sep 9 00:36:17.616000 audit[1634]: CRED_DISP pid=1634 uid=0 auid=500 ses=7 subj=system_u:system_r:kernel_t:s0 msg='op=PAM:setcred grantors=pam_env,pam_faillock,pam_unix acct="core" exe="/usr/sbin/sshd" hostname=10.0.0.1 addr=10.0.0.1 terminal=ssh res=success' Sep 9 00:36:17.620291 systemd[1]: Started sshd@7-10.0.0.89:22-10.0.0.1:38454.service. Sep 9 00:36:17.619000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=sshd@7-10.0.0.89:22-10.0.0.1:38454 comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Sep 9 00:36:17.620850 systemd[1]: sshd@6-10.0.0.89:22-10.0.0.1:38452.service: Deactivated successfully. Sep 9 00:36:17.619000 audit[1]: SERVICE_STOP pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=sshd@6-10.0.0.89:22-10.0.0.1:38452 comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Sep 9 00:36:17.621569 systemd[1]: session-7.scope: Deactivated successfully. Sep 9 00:36:17.622283 systemd-logind[1124]: Session 7 logged out. Waiting for processes to exit. Sep 9 00:36:17.623550 systemd-logind[1124]: Removed session 7. Sep 9 00:36:17.650000 audit[1642]: USER_ACCT pid=1642 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='op=PAM:accounting grantors=pam_access,pam_unix,pam_faillock,pam_permit acct="core" exe="/usr/sbin/sshd" hostname=10.0.0.1 addr=10.0.0.1 terminal=ssh res=success' Sep 9 00:36:17.651945 sshd[1642]: Accepted publickey for core from 10.0.0.1 port 38454 ssh2: RSA SHA256:SJL83fEN2Ip3G6nq+SFahxwHER39rSdiWTx9teXxMXo Sep 9 00:36:17.651000 audit[1642]: CRED_ACQ pid=1642 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='op=PAM:setcred grantors=pam_env,pam_faillock,pam_unix acct="core" exe="/usr/sbin/sshd" hostname=10.0.0.1 addr=10.0.0.1 terminal=ssh res=success' Sep 9 00:36:17.651000 audit[1642]: SYSCALL arch=c00000b7 syscall=64 success=yes exit=3 a0=5 a1=fffff11030e0 a2=3 a3=1 items=0 ppid=1 pid=1642 auid=500 uid=0 gid=0 euid=0 suid=0 fsuid=0 egid=0 sgid=0 fsgid=0 tty=(none) ses=8 comm="sshd" exe="/usr/sbin/sshd" subj=system_u:system_r:kernel_t:s0 key=(null) Sep 9 00:36:17.651000 audit: PROCTITLE proctitle=737368643A20636F7265205B707269765D Sep 9 00:36:17.653108 sshd[1642]: pam_unix(sshd:session): session opened for user core(uid=500) by (uid=0) Sep 9 00:36:17.656462 systemd-logind[1124]: New session 8 of user core. Sep 9 00:36:17.657236 systemd[1]: Started session-8.scope. Sep 9 00:36:17.660000 audit[1642]: USER_START pid=1642 uid=0 auid=500 ses=8 subj=system_u:system_r:kernel_t:s0 msg='op=PAM:session_open grantors=pam_loginuid,pam_env,pam_lastlog,pam_limits,pam_env,pam_unix,pam_permit,pam_systemd,pam_mail acct="core" exe="/usr/sbin/sshd" hostname=10.0.0.1 addr=10.0.0.1 terminal=ssh res=success' Sep 9 00:36:17.661000 audit[1646]: CRED_ACQ pid=1646 uid=0 auid=500 ses=8 subj=system_u:system_r:kernel_t:s0 msg='op=PAM:setcred grantors=pam_env,pam_faillock,pam_unix acct="core" exe="/usr/sbin/sshd" hostname=10.0.0.1 addr=10.0.0.1 terminal=ssh res=success' Sep 9 00:36:17.767995 sshd[1642]: pam_unix(sshd:session): session closed for user core Sep 9 00:36:17.767000 audit[1642]: USER_END pid=1642 uid=0 auid=500 ses=8 subj=system_u:system_r:kernel_t:s0 msg='op=PAM:session_close grantors=pam_loginuid,pam_env,pam_lastlog,pam_limits,pam_env,pam_unix,pam_permit,pam_systemd,pam_mail acct="core" exe="/usr/sbin/sshd" hostname=10.0.0.1 addr=10.0.0.1 terminal=ssh res=success' Sep 9 00:36:17.767000 audit[1642]: CRED_DISP pid=1642 uid=0 auid=500 ses=8 subj=system_u:system_r:kernel_t:s0 msg='op=PAM:setcred grantors=pam_env,pam_faillock,pam_unix acct="core" exe="/usr/sbin/sshd" hostname=10.0.0.1 addr=10.0.0.1 terminal=ssh res=success' Sep 9 00:36:17.770820 systemd[1]: session-8.scope: Deactivated successfully. Sep 9 00:36:17.771560 systemd-logind[1124]: Session 8 logged out. Waiting for processes to exit. Sep 9 00:36:17.771708 systemd[1]: sshd@7-10.0.0.89:22-10.0.0.1:38454.service: Deactivated successfully. Sep 9 00:36:17.770000 audit[1]: SERVICE_STOP pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=sshd@7-10.0.0.89:22-10.0.0.1:38454 comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Sep 9 00:36:17.774503 systemd-logind[1124]: Removed session 8. Sep 9 00:36:55.367794 update_engine[1127]: I0909 00:36:55.367413 1127 update_attempter.cc:509] Updating boot flags...