Aug 5 22:15:00.908373 kernel: Booting Linux on physical CPU 0x0000000000 [0x413fd0c1] Aug 5 22:15:00.908395 kernel: Linux version 6.6.43-flatcar (build@pony-truck.infra.kinvolk.io) (aarch64-cros-linux-gnu-gcc (Gentoo Hardened 13.2.1_p20240210 p14) 13.2.1 20240210, GNU ld (Gentoo 2.41 p5) 2.41.0) #1 SMP PREEMPT Mon Aug 5 20:37:57 -00 2024 Aug 5 22:15:00.908405 kernel: KASLR enabled Aug 5 22:15:00.908410 kernel: efi: EFI v2.7 by EDK II Aug 5 22:15:00.908416 kernel: efi: SMBIOS 3.0=0xdced0000 MEMATTR=0xdb8fd018 ACPI 2.0=0xd9710018 RNG=0xd971e498 MEMRESERVE=0xd9b43d18 Aug 5 22:15:00.908422 kernel: random: crng init done Aug 5 22:15:00.908429 kernel: ACPI: Early table checksum verification disabled Aug 5 22:15:00.908434 kernel: ACPI: RSDP 0x00000000D9710018 000024 (v02 BOCHS ) Aug 5 22:15:00.908441 kernel: ACPI: XSDT 0x00000000D971FE98 000064 (v01 BOCHS BXPC 00000001 01000013) Aug 5 22:15:00.908448 kernel: ACPI: FACP 0x00000000D971FA98 000114 (v06 BOCHS BXPC 00000001 BXPC 00000001) Aug 5 22:15:00.908454 kernel: ACPI: DSDT 0x00000000D9717518 0014A2 (v02 BOCHS BXPC 00000001 BXPC 00000001) Aug 5 22:15:00.908459 kernel: ACPI: APIC 0x00000000D971FC18 0001A8 (v04 BOCHS BXPC 00000001 BXPC 00000001) Aug 5 22:15:00.908465 kernel: ACPI: PPTT 0x00000000D971D898 00009C (v02 BOCHS BXPC 00000001 BXPC 00000001) Aug 5 22:15:00.908471 kernel: ACPI: GTDT 0x00000000D971E818 000060 (v02 BOCHS BXPC 00000001 BXPC 00000001) Aug 5 22:15:00.908478 kernel: ACPI: MCFG 0x00000000D971E918 00003C (v01 BOCHS BXPC 00000001 BXPC 00000001) Aug 5 22:15:00.908486 kernel: ACPI: SPCR 0x00000000D971FF98 000050 (v02 BOCHS BXPC 00000001 BXPC 00000001) Aug 5 22:15:00.908492 kernel: ACPI: DBG2 0x00000000D971E418 000057 (v00 BOCHS BXPC 00000001 BXPC 00000001) Aug 5 22:15:00.908498 kernel: ACPI: IORT 0x00000000D971E718 000080 (v03 BOCHS BXPC 00000001 BXPC 00000001) Aug 5 22:15:00.908505 kernel: ACPI: SPCR: console: pl011,mmio,0x9000000,9600 Aug 5 22:15:00.908511 kernel: NUMA: Failed to initialise from firmware Aug 5 22:15:00.908517 kernel: NUMA: Faking a node at [mem 0x0000000040000000-0x00000000dcffffff] Aug 5 22:15:00.908523 kernel: NUMA: NODE_DATA [mem 0xdc958800-0xdc95dfff] Aug 5 22:15:00.908529 kernel: Zone ranges: Aug 5 22:15:00.908536 kernel: DMA [mem 0x0000000040000000-0x00000000dcffffff] Aug 5 22:15:00.908542 kernel: DMA32 empty Aug 5 22:15:00.908549 kernel: Normal empty Aug 5 22:15:00.908555 kernel: Movable zone start for each node Aug 5 22:15:00.908561 kernel: Early memory node ranges Aug 5 22:15:00.908568 kernel: node 0: [mem 0x0000000040000000-0x00000000d976ffff] Aug 5 22:15:00.908574 kernel: node 0: [mem 0x00000000d9770000-0x00000000d9b3ffff] Aug 5 22:15:00.908580 kernel: node 0: [mem 0x00000000d9b40000-0x00000000dce1ffff] Aug 5 22:15:00.908587 kernel: node 0: [mem 0x00000000dce20000-0x00000000dceaffff] Aug 5 22:15:00.908593 kernel: node 0: [mem 0x00000000dceb0000-0x00000000dcebffff] Aug 5 22:15:00.908599 kernel: node 0: [mem 0x00000000dcec0000-0x00000000dcfdffff] Aug 5 22:15:00.908605 kernel: node 0: [mem 0x00000000dcfe0000-0x00000000dcffffff] Aug 5 22:15:00.908612 kernel: Initmem setup node 0 [mem 0x0000000040000000-0x00000000dcffffff] Aug 5 22:15:00.908618 kernel: On node 0, zone DMA: 12288 pages in unavailable ranges Aug 5 22:15:00.908625 kernel: psci: probing for conduit method from ACPI. Aug 5 22:15:00.908632 kernel: psci: PSCIv1.1 detected in firmware. Aug 5 22:15:00.908638 kernel: psci: Using standard PSCI v0.2 function IDs Aug 5 22:15:00.908647 kernel: psci: Trusted OS migration not required Aug 5 22:15:00.908653 kernel: psci: SMC Calling Convention v1.1 Aug 5 22:15:00.908660 kernel: smccc: KVM: hypervisor services detected (0x00000000 0x00000000 0x00000000 0x00000003) Aug 5 22:15:00.908668 kernel: percpu: Embedded 31 pages/cpu s86632 r8192 d32152 u126976 Aug 5 22:15:00.908675 kernel: pcpu-alloc: s86632 r8192 d32152 u126976 alloc=31*4096 Aug 5 22:15:00.908682 kernel: pcpu-alloc: [0] 0 [0] 1 [0] 2 [0] 3 Aug 5 22:15:00.908688 kernel: Detected PIPT I-cache on CPU0 Aug 5 22:15:00.908695 kernel: CPU features: detected: GIC system register CPU interface Aug 5 22:15:00.908701 kernel: CPU features: detected: Hardware dirty bit management Aug 5 22:15:00.908708 kernel: CPU features: detected: Spectre-v4 Aug 5 22:15:00.908714 kernel: CPU features: detected: Spectre-BHB Aug 5 22:15:00.908721 kernel: CPU features: kernel page table isolation forced ON by KASLR Aug 5 22:15:00.908728 kernel: CPU features: detected: Kernel page table isolation (KPTI) Aug 5 22:15:00.908736 kernel: CPU features: detected: ARM erratum 1418040 Aug 5 22:15:00.908742 kernel: alternatives: applying boot alternatives Aug 5 22:15:00.908750 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=4052403b8e39e55d48e6afcca927358798017aa0d33c868bc3038260a8d9be90 Aug 5 22:15:00.908757 kernel: Unknown kernel command line parameters "BOOT_IMAGE=/flatcar/vmlinuz-a", will be passed to user space. Aug 5 22:15:00.908764 kernel: Dentry cache hash table entries: 524288 (order: 10, 4194304 bytes, linear) Aug 5 22:15:00.908778 kernel: Inode-cache hash table entries: 262144 (order: 9, 2097152 bytes, linear) Aug 5 22:15:00.908786 kernel: Fallback order for Node 0: 0 Aug 5 22:15:00.908793 kernel: Built 1 zonelists, mobility grouping on. Total pages: 633024 Aug 5 22:15:00.908800 kernel: Policy zone: DMA Aug 5 22:15:00.908806 kernel: mem auto-init: stack:off, heap alloc:off, heap free:off Aug 5 22:15:00.908813 kernel: software IO TLB: area num 4. Aug 5 22:15:00.908821 kernel: software IO TLB: mapped [mem 0x00000000d2e00000-0x00000000d6e00000] (64MB) Aug 5 22:15:00.908828 kernel: Memory: 2386852K/2572288K available (10240K kernel code, 2182K rwdata, 8072K rodata, 39040K init, 897K bss, 185436K reserved, 0K cma-reserved) Aug 5 22:15:00.908846 kernel: SLUB: HWalign=64, Order=0-3, MinObjects=0, CPUs=4, Nodes=1 Aug 5 22:15:00.908854 kernel: trace event string verifier disabled Aug 5 22:15:00.908860 kernel: rcu: Preemptible hierarchical RCU implementation. Aug 5 22:15:00.908868 kernel: rcu: RCU event tracing is enabled. Aug 5 22:15:00.908874 kernel: rcu: RCU restricting CPUs from NR_CPUS=512 to nr_cpu_ids=4. Aug 5 22:15:00.908881 kernel: Trampoline variant of Tasks RCU enabled. Aug 5 22:15:00.908888 kernel: Tracing variant of Tasks RCU enabled. Aug 5 22:15:00.908895 kernel: rcu: RCU calculated value of scheduler-enlistment delay is 100 jiffies. Aug 5 22:15:00.908902 kernel: rcu: Adjusting geometry for rcu_fanout_leaf=16, nr_cpu_ids=4 Aug 5 22:15:00.908909 kernel: NR_IRQS: 64, nr_irqs: 64, preallocated irqs: 0 Aug 5 22:15:00.908917 kernel: GICv3: 256 SPIs implemented Aug 5 22:15:00.908924 kernel: GICv3: 0 Extended SPIs implemented Aug 5 22:15:00.908930 kernel: Root IRQ handler: gic_handle_irq Aug 5 22:15:00.908937 kernel: GICv3: GICv3 features: 16 PPIs, DirectLPI Aug 5 22:15:00.908944 kernel: GICv3: CPU0: found redistributor 0 region 0:0x00000000080a0000 Aug 5 22:15:00.908950 kernel: ITS [mem 0x08080000-0x0809ffff] Aug 5 22:15:00.908957 kernel: ITS@0x0000000008080000: allocated 8192 Devices @400d0000 (indirect, esz 8, psz 64K, shr 1) Aug 5 22:15:00.908964 kernel: ITS@0x0000000008080000: allocated 8192 Interrupt Collections @400e0000 (flat, esz 8, psz 64K, shr 1) Aug 5 22:15:00.908971 kernel: GICv3: using LPI property table @0x00000000400f0000 Aug 5 22:15:00.908978 kernel: GICv3: CPU0: using allocated LPI pending table @0x0000000040100000 Aug 5 22:15:00.908984 kernel: rcu: srcu_init: Setting srcu_struct sizes based on contention. Aug 5 22:15:00.908992 kernel: arch_timer: Enabling local workaround for ARM erratum 1418040 Aug 5 22:15:00.908999 kernel: arch_timer: cp15 timer(s) running at 25.00MHz (virt). Aug 5 22:15:00.909006 kernel: clocksource: arch_sys_counter: mask: 0xffffffffffffff max_cycles: 0x5c40939b5, max_idle_ns: 440795202646 ns Aug 5 22:15:00.909013 kernel: sched_clock: 56 bits at 25MHz, resolution 40ns, wraps every 4398046511100ns Aug 5 22:15:00.909020 kernel: arm-pv: using stolen time PV Aug 5 22:15:00.909026 kernel: Console: colour dummy device 80x25 Aug 5 22:15:00.909033 kernel: ACPI: Core revision 20230628 Aug 5 22:15:00.909040 kernel: Calibrating delay loop (skipped), value calculated using timer frequency.. 50.00 BogoMIPS (lpj=25000) Aug 5 22:15:00.909047 kernel: pid_max: default: 32768 minimum: 301 Aug 5 22:15:00.909054 kernel: LSM: initializing lsm=lockdown,capability,selinux,integrity Aug 5 22:15:00.909062 kernel: SELinux: Initializing. Aug 5 22:15:00.909069 kernel: Mount-cache hash table entries: 8192 (order: 4, 65536 bytes, linear) Aug 5 22:15:00.909076 kernel: Mountpoint-cache hash table entries: 8192 (order: 4, 65536 bytes, linear) Aug 5 22:15:00.909083 kernel: RCU Tasks: Setting shift to 2 and lim to 1 rcu_task_cb_adjust=1. Aug 5 22:15:00.909090 kernel: RCU Tasks Trace: Setting shift to 2 and lim to 1 rcu_task_cb_adjust=1. Aug 5 22:15:00.909097 kernel: rcu: Hierarchical SRCU implementation. Aug 5 22:15:00.909104 kernel: rcu: Max phase no-delay instances is 400. Aug 5 22:15:00.909110 kernel: Platform MSI: ITS@0x8080000 domain created Aug 5 22:15:00.909117 kernel: PCI/MSI: ITS@0x8080000 domain created Aug 5 22:15:00.909125 kernel: Remapping and enabling EFI services. Aug 5 22:15:00.909133 kernel: smp: Bringing up secondary CPUs ... Aug 5 22:15:00.909139 kernel: Detected PIPT I-cache on CPU1 Aug 5 22:15:00.909146 kernel: GICv3: CPU1: found redistributor 1 region 0:0x00000000080c0000 Aug 5 22:15:00.909153 kernel: GICv3: CPU1: using allocated LPI pending table @0x0000000040110000 Aug 5 22:15:00.909160 kernel: arch_timer: Enabling local workaround for ARM erratum 1418040 Aug 5 22:15:00.909167 kernel: CPU1: Booted secondary processor 0x0000000001 [0x413fd0c1] Aug 5 22:15:00.909174 kernel: Detected PIPT I-cache on CPU2 Aug 5 22:15:00.909181 kernel: GICv3: CPU2: found redistributor 2 region 0:0x00000000080e0000 Aug 5 22:15:00.909188 kernel: GICv3: CPU2: using allocated LPI pending table @0x0000000040120000 Aug 5 22:15:00.909196 kernel: arch_timer: Enabling local workaround for ARM erratum 1418040 Aug 5 22:15:00.909203 kernel: CPU2: Booted secondary processor 0x0000000002 [0x413fd0c1] Aug 5 22:15:00.909215 kernel: Detected PIPT I-cache on CPU3 Aug 5 22:15:00.909223 kernel: GICv3: CPU3: found redistributor 3 region 0:0x0000000008100000 Aug 5 22:15:00.909231 kernel: GICv3: CPU3: using allocated LPI pending table @0x0000000040130000 Aug 5 22:15:00.909238 kernel: arch_timer: Enabling local workaround for ARM erratum 1418040 Aug 5 22:15:00.909245 kernel: CPU3: Booted secondary processor 0x0000000003 [0x413fd0c1] Aug 5 22:15:00.909252 kernel: smp: Brought up 1 node, 4 CPUs Aug 5 22:15:00.909260 kernel: SMP: Total of 4 processors activated. Aug 5 22:15:00.909268 kernel: CPU features: detected: 32-bit EL0 Support Aug 5 22:15:00.909276 kernel: CPU features: detected: Data cache clean to the PoU not required for I/D coherence Aug 5 22:15:00.909283 kernel: CPU features: detected: Common not Private translations Aug 5 22:15:00.909291 kernel: CPU features: detected: CRC32 instructions Aug 5 22:15:00.909298 kernel: CPU features: detected: Enhanced Virtualization Traps Aug 5 22:15:00.909306 kernel: CPU features: detected: RCpc load-acquire (LDAPR) Aug 5 22:15:00.909315 kernel: CPU features: detected: LSE atomic instructions Aug 5 22:15:00.909325 kernel: CPU features: detected: Privileged Access Never Aug 5 22:15:00.909337 kernel: CPU features: detected: RAS Extension Support Aug 5 22:15:00.909346 kernel: CPU features: detected: Speculative Store Bypassing Safe (SSBS) Aug 5 22:15:00.909356 kernel: CPU: All CPU(s) started at EL1 Aug 5 22:15:00.909364 kernel: alternatives: applying system-wide alternatives Aug 5 22:15:00.909374 kernel: devtmpfs: initialized Aug 5 22:15:00.909384 kernel: clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1911260446275000 ns Aug 5 22:15:00.909392 kernel: futex hash table entries: 1024 (order: 4, 65536 bytes, linear) Aug 5 22:15:00.909402 kernel: pinctrl core: initialized pinctrl subsystem Aug 5 22:15:00.909410 kernel: SMBIOS 3.0.0 present. Aug 5 22:15:00.909419 kernel: DMI: QEMU KVM Virtual Machine, BIOS edk2-20230524-3.fc38 05/24/2023 Aug 5 22:15:00.909426 kernel: NET: Registered PF_NETLINK/PF_ROUTE protocol family Aug 5 22:15:00.909433 kernel: DMA: preallocated 512 KiB GFP_KERNEL pool for atomic allocations Aug 5 22:15:00.909441 kernel: DMA: preallocated 512 KiB GFP_KERNEL|GFP_DMA pool for atomic allocations Aug 5 22:15:00.909448 kernel: DMA: preallocated 512 KiB GFP_KERNEL|GFP_DMA32 pool for atomic allocations Aug 5 22:15:00.909455 kernel: audit: initializing netlink subsys (disabled) Aug 5 22:15:00.909462 kernel: audit: type=2000 audit(0.024:1): state=initialized audit_enabled=0 res=1 Aug 5 22:15:00.909470 kernel: thermal_sys: Registered thermal governor 'step_wise' Aug 5 22:15:00.909477 kernel: cpuidle: using governor menu Aug 5 22:15:00.909485 kernel: hw-breakpoint: found 6 breakpoint and 4 watchpoint registers. Aug 5 22:15:00.909493 kernel: ASID allocator initialised with 32768 entries Aug 5 22:15:00.909500 kernel: acpiphp: ACPI Hot Plug PCI Controller Driver version: 0.5 Aug 5 22:15:00.909507 kernel: Serial: AMBA PL011 UART driver Aug 5 22:15:00.909515 kernel: Modules: 2G module region forced by RANDOMIZE_MODULE_REGION_FULL Aug 5 22:15:00.909522 kernel: Modules: 0 pages in range for non-PLT usage Aug 5 22:15:00.909529 kernel: Modules: 509120 pages in range for PLT usage Aug 5 22:15:00.909536 kernel: HugeTLB: registered 1.00 GiB page size, pre-allocated 0 pages Aug 5 22:15:00.909543 kernel: HugeTLB: 0 KiB vmemmap can be freed for a 1.00 GiB page Aug 5 22:15:00.909552 kernel: HugeTLB: registered 32.0 MiB page size, pre-allocated 0 pages Aug 5 22:15:00.909559 kernel: HugeTLB: 0 KiB vmemmap can be freed for a 32.0 MiB page Aug 5 22:15:00.909566 kernel: HugeTLB: registered 2.00 MiB page size, pre-allocated 0 pages Aug 5 22:15:00.909574 kernel: HugeTLB: 0 KiB vmemmap can be freed for a 2.00 MiB page Aug 5 22:15:00.909581 kernel: HugeTLB: registered 64.0 KiB page size, pre-allocated 0 pages Aug 5 22:15:00.909588 kernel: HugeTLB: 0 KiB vmemmap can be freed for a 64.0 KiB page Aug 5 22:15:00.909595 kernel: ACPI: Added _OSI(Module Device) Aug 5 22:15:00.909602 kernel: ACPI: Added _OSI(Processor Device) Aug 5 22:15:00.909610 kernel: ACPI: Added _OSI(3.0 _SCP Extensions) Aug 5 22:15:00.909618 kernel: ACPI: Added _OSI(Processor Aggregator Device) Aug 5 22:15:00.909625 kernel: ACPI: 1 ACPI AML tables successfully acquired and loaded Aug 5 22:15:00.909632 kernel: ACPI: Interpreter enabled Aug 5 22:15:00.909640 kernel: ACPI: Using GIC for interrupt routing Aug 5 22:15:00.909647 kernel: ACPI: MCFG table detected, 1 entries Aug 5 22:15:00.909654 kernel: ARMH0011:00: ttyAMA0 at MMIO 0x9000000 (irq = 12, base_baud = 0) is a SBSA Aug 5 22:15:00.909661 kernel: printk: console [ttyAMA0] enabled Aug 5 22:15:00.909669 kernel: ACPI: PCI Root Bridge [PCI0] (domain 0000 [bus 00-ff]) Aug 5 22:15:00.909809 kernel: acpi PNP0A08:00: _OSC: OS supports [ExtendedConfig ASPM ClockPM Segments MSI HPX-Type3] Aug 5 22:15:00.909900 kernel: acpi PNP0A08:00: _OSC: platform does not support [LTR] Aug 5 22:15:00.909966 kernel: acpi PNP0A08:00: _OSC: OS now controls [PCIeHotplug PME AER PCIeCapability] Aug 5 22:15:00.910028 kernel: acpi PNP0A08:00: ECAM area [mem 0x4010000000-0x401fffffff] reserved by PNP0C02:00 Aug 5 22:15:00.910090 kernel: acpi PNP0A08:00: ECAM at [mem 0x4010000000-0x401fffffff] for [bus 00-ff] Aug 5 22:15:00.910100 kernel: ACPI: Remapped I/O 0x000000003eff0000 to [io 0x0000-0xffff window] Aug 5 22:15:00.910107 kernel: PCI host bridge to bus 0000:00 Aug 5 22:15:00.910176 kernel: pci_bus 0000:00: root bus resource [mem 0x10000000-0x3efeffff window] Aug 5 22:15:00.910237 kernel: pci_bus 0000:00: root bus resource [io 0x0000-0xffff window] Aug 5 22:15:00.910295 kernel: pci_bus 0000:00: root bus resource [mem 0x8000000000-0xffffffffff window] Aug 5 22:15:00.910352 kernel: pci_bus 0000:00: root bus resource [bus 00-ff] Aug 5 22:15:00.910428 kernel: pci 0000:00:00.0: [1b36:0008] type 00 class 0x060000 Aug 5 22:15:00.910501 kernel: pci 0000:00:01.0: [1af4:1005] type 00 class 0x00ff00 Aug 5 22:15:00.910566 kernel: pci 0000:00:01.0: reg 0x10: [io 0x0000-0x001f] Aug 5 22:15:00.910632 kernel: pci 0000:00:01.0: reg 0x14: [mem 0x10000000-0x10000fff] Aug 5 22:15:00.910696 kernel: pci 0000:00:01.0: reg 0x20: [mem 0x8000000000-0x8000003fff 64bit pref] Aug 5 22:15:00.910768 kernel: pci 0000:00:01.0: BAR 4: assigned [mem 0x8000000000-0x8000003fff 64bit pref] Aug 5 22:15:00.910855 kernel: pci 0000:00:01.0: BAR 1: assigned [mem 0x10000000-0x10000fff] Aug 5 22:15:00.910923 kernel: pci 0000:00:01.0: BAR 0: assigned [io 0x1000-0x101f] Aug 5 22:15:00.910981 kernel: pci_bus 0000:00: resource 4 [mem 0x10000000-0x3efeffff window] Aug 5 22:15:00.911037 kernel: pci_bus 0000:00: resource 5 [io 0x0000-0xffff window] Aug 5 22:15:00.911097 kernel: pci_bus 0000:00: resource 6 [mem 0x8000000000-0xffffffffff window] Aug 5 22:15:00.911107 kernel: ACPI: PCI: Interrupt link GSI0 configured for IRQ 35 Aug 5 22:15:00.911114 kernel: ACPI: PCI: Interrupt link GSI1 configured for IRQ 36 Aug 5 22:15:00.911122 kernel: ACPI: PCI: Interrupt link GSI2 configured for IRQ 37 Aug 5 22:15:00.911129 kernel: ACPI: PCI: Interrupt link GSI3 configured for IRQ 38 Aug 5 22:15:00.911136 kernel: iommu: Default domain type: Translated Aug 5 22:15:00.911143 kernel: iommu: DMA domain TLB invalidation policy: strict mode Aug 5 22:15:00.911151 kernel: efivars: Registered efivars operations Aug 5 22:15:00.911158 kernel: vgaarb: loaded Aug 5 22:15:00.911168 kernel: clocksource: Switched to clocksource arch_sys_counter Aug 5 22:15:00.911175 kernel: VFS: Disk quotas dquot_6.6.0 Aug 5 22:15:00.911183 kernel: VFS: Dquot-cache hash table entries: 512 (order 0, 4096 bytes) Aug 5 22:15:00.911190 kernel: pnp: PnP ACPI init Aug 5 22:15:00.911266 kernel: system 00:00: [mem 0x4010000000-0x401fffffff window] could not be reserved Aug 5 22:15:00.911277 kernel: pnp: PnP ACPI: found 1 devices Aug 5 22:15:00.911284 kernel: NET: Registered PF_INET protocol family Aug 5 22:15:00.911292 kernel: IP idents hash table entries: 65536 (order: 7, 524288 bytes, linear) Aug 5 22:15:00.911301 kernel: tcp_listen_portaddr_hash hash table entries: 2048 (order: 3, 32768 bytes, linear) Aug 5 22:15:00.911309 kernel: Table-perturb hash table entries: 65536 (order: 6, 262144 bytes, linear) Aug 5 22:15:00.911316 kernel: TCP established hash table entries: 32768 (order: 6, 262144 bytes, linear) Aug 5 22:15:00.911323 kernel: TCP bind hash table entries: 32768 (order: 8, 1048576 bytes, linear) Aug 5 22:15:00.911331 kernel: TCP: Hash tables configured (established 32768 bind 32768) Aug 5 22:15:00.911338 kernel: UDP hash table entries: 2048 (order: 4, 65536 bytes, linear) Aug 5 22:15:00.911346 kernel: UDP-Lite hash table entries: 2048 (order: 4, 65536 bytes, linear) Aug 5 22:15:00.911359 kernel: NET: Registered PF_UNIX/PF_LOCAL protocol family Aug 5 22:15:00.911370 kernel: PCI: CLS 0 bytes, default 64 Aug 5 22:15:00.911382 kernel: kvm [1]: HYP mode not available Aug 5 22:15:00.911391 kernel: Initialise system trusted keyrings Aug 5 22:15:00.911399 kernel: workingset: timestamp_bits=39 max_order=20 bucket_order=0 Aug 5 22:15:00.911406 kernel: Key type asymmetric registered Aug 5 22:15:00.911414 kernel: Asymmetric key parser 'x509' registered Aug 5 22:15:00.911421 kernel: Block layer SCSI generic (bsg) driver version 0.4 loaded (major 250) Aug 5 22:15:00.911428 kernel: io scheduler mq-deadline registered Aug 5 22:15:00.911435 kernel: io scheduler kyber registered Aug 5 22:15:00.911443 kernel: io scheduler bfq registered Aug 5 22:15:00.911451 kernel: input: Power Button as /devices/LNXSYSTM:00/LNXSYBUS:00/PNP0C0C:00/input/input0 Aug 5 22:15:00.911459 kernel: ACPI: button: Power Button [PWRB] Aug 5 22:15:00.911467 kernel: ACPI: \_SB_.PCI0.GSI1: Enabled at IRQ 36 Aug 5 22:15:00.911539 kernel: virtio-pci 0000:00:01.0: enabling device (0005 -> 0007) Aug 5 22:15:00.911549 kernel: Serial: 8250/16550 driver, 4 ports, IRQ sharing enabled Aug 5 22:15:00.911556 kernel: thunder_xcv, ver 1.0 Aug 5 22:15:00.911563 kernel: thunder_bgx, ver 1.0 Aug 5 22:15:00.911570 kernel: nicpf, ver 1.0 Aug 5 22:15:00.911577 kernel: nicvf, ver 1.0 Aug 5 22:15:00.911650 kernel: rtc-efi rtc-efi.0: registered as rtc0 Aug 5 22:15:00.911712 kernel: rtc-efi rtc-efi.0: setting system clock to 2024-08-05T22:15:00 UTC (1722896100) Aug 5 22:15:00.911721 kernel: hid: raw HID events driver (C) Jiri Kosina Aug 5 22:15:00.911729 kernel: hw perfevents: enabled with armv8_pmuv3_0 PMU driver, 7 counters available Aug 5 22:15:00.911736 kernel: watchdog: Delayed init of the lockup detector failed: -19 Aug 5 22:15:00.911744 kernel: watchdog: Hard watchdog permanently disabled Aug 5 22:15:00.911751 kernel: NET: Registered PF_INET6 protocol family Aug 5 22:15:00.911758 kernel: Segment Routing with IPv6 Aug 5 22:15:00.911767 kernel: In-situ OAM (IOAM) with IPv6 Aug 5 22:15:00.911780 kernel: NET: Registered PF_PACKET protocol family Aug 5 22:15:00.911788 kernel: Key type dns_resolver registered Aug 5 22:15:00.911795 kernel: registered taskstats version 1 Aug 5 22:15:00.911802 kernel: Loading compiled-in X.509 certificates Aug 5 22:15:00.911809 kernel: Loaded X.509 cert 'Kinvolk GmbH: Module signing key for 6.6.43-flatcar: 99cab5c9e2f0f3a5ca972c2df7b3d6ed64d627d4' Aug 5 22:15:00.911817 kernel: Key type .fscrypt registered Aug 5 22:15:00.911824 kernel: Key type fscrypt-provisioning registered Aug 5 22:15:00.911832 kernel: ima: No TPM chip found, activating TPM-bypass! Aug 5 22:15:00.911867 kernel: ima: Allocated hash algorithm: sha1 Aug 5 22:15:00.911875 kernel: ima: No architecture policies found Aug 5 22:15:00.911883 kernel: alg: No test for fips(ansi_cprng) (fips_ansi_cprng) Aug 5 22:15:00.911890 kernel: clk: Disabling unused clocks Aug 5 22:15:00.911897 kernel: Freeing unused kernel memory: 39040K Aug 5 22:15:00.911905 kernel: Run /init as init process Aug 5 22:15:00.911914 kernel: with arguments: Aug 5 22:15:00.911923 kernel: /init Aug 5 22:15:00.911930 kernel: with environment: Aug 5 22:15:00.911940 kernel: HOME=/ Aug 5 22:15:00.911947 kernel: TERM=linux Aug 5 22:15:00.911954 kernel: BOOT_IMAGE=/flatcar/vmlinuz-a Aug 5 22:15:00.911963 systemd[1]: systemd 255 running in system mode (+PAM +AUDIT +SELINUX -APPARMOR +IMA +SMACK +SECCOMP +GCRYPT -GNUTLS +OPENSSL -ACL +BLKID +CURL +ELFUTILS -FIDO2 +IDN2 -IDN +IPTC +KMOD +LIBCRYPTSETUP +LIBFDISK +PCRE2 -PWQUALITY -P11KIT -QRENCODE +TPM2 +BZIP2 +LZ4 +XZ +ZLIB +ZSTD -BPF_FRAMEWORK -XKBCOMMON +UTMP -SYSVINIT default-hierarchy=unified) Aug 5 22:15:00.911973 systemd[1]: Detected virtualization kvm. Aug 5 22:15:00.911980 systemd[1]: Detected architecture arm64. Aug 5 22:15:00.911988 systemd[1]: Running in initrd. Aug 5 22:15:00.911996 systemd[1]: No hostname configured, using default hostname. Aug 5 22:15:00.912005 systemd[1]: Hostname set to . Aug 5 22:15:00.912013 systemd[1]: Initializing machine ID from VM UUID. Aug 5 22:15:00.912021 systemd[1]: Queued start job for default target initrd.target. Aug 5 22:15:00.912029 systemd[1]: Started clevis-luks-askpass.path - Forward Password Requests to Clevis Directory Watch. Aug 5 22:15:00.912036 systemd[1]: Started systemd-ask-password-console.path - Dispatch Password Requests to Console Directory Watch. Aug 5 22:15:00.912045 systemd[1]: Expecting device dev-disk-by\x2dlabel-EFI\x2dSYSTEM.device - /dev/disk/by-label/EFI-SYSTEM... Aug 5 22:15:00.912053 systemd[1]: Expecting device dev-disk-by\x2dlabel-OEM.device - /dev/disk/by-label/OEM... Aug 5 22:15:00.912062 systemd[1]: Expecting device dev-disk-by\x2dlabel-ROOT.device - /dev/disk/by-label/ROOT... Aug 5 22:15:00.912070 systemd[1]: Expecting device dev-disk-by\x2dpartlabel-USR\x2dA.device - /dev/disk/by-partlabel/USR-A... Aug 5 22:15:00.912079 systemd[1]: Expecting device dev-disk-by\x2dpartuuid-7130c94a\x2d213a\x2d4e5a\x2d8e26\x2d6cce9662f132.device - /dev/disk/by-partuuid/7130c94a-213a-4e5a-8e26-6cce9662f132... Aug 5 22:15:00.912087 systemd[1]: Expecting device dev-mapper-usr.device - /dev/mapper/usr... Aug 5 22:15:00.912095 systemd[1]: Reached target cryptsetup-pre.target - Local Encrypted Volumes (Pre). Aug 5 22:15:00.912103 systemd[1]: Reached target cryptsetup.target - Local Encrypted Volumes. Aug 5 22:15:00.912111 systemd[1]: Reached target paths.target - Path Units. Aug 5 22:15:00.912120 systemd[1]: Reached target slices.target - Slice Units. Aug 5 22:15:00.912128 systemd[1]: Reached target swap.target - Swaps. Aug 5 22:15:00.912135 systemd[1]: Reached target timers.target - Timer Units. Aug 5 22:15:00.912143 systemd[1]: Listening on iscsid.socket - Open-iSCSI iscsid Socket. Aug 5 22:15:00.912151 systemd[1]: Listening on iscsiuio.socket - Open-iSCSI iscsiuio Socket. Aug 5 22:15:00.912159 systemd[1]: Listening on systemd-journald-dev-log.socket - Journal Socket (/dev/log). Aug 5 22:15:00.912166 systemd[1]: Listening on systemd-journald.socket - Journal Socket. Aug 5 22:15:00.912174 systemd[1]: Listening on systemd-networkd.socket - Network Service Netlink Socket. Aug 5 22:15:00.912182 systemd[1]: Listening on systemd-udevd-control.socket - udev Control Socket. Aug 5 22:15:00.912191 systemd[1]: Listening on systemd-udevd-kernel.socket - udev Kernel Socket. Aug 5 22:15:00.912199 systemd[1]: Reached target sockets.target - Socket Units. Aug 5 22:15:00.912207 systemd[1]: Starting ignition-setup-pre.service - Ignition env setup... Aug 5 22:15:00.912215 systemd[1]: Starting kmod-static-nodes.service - Create List of Static Device Nodes... Aug 5 22:15:00.912222 systemd[1]: Finished network-cleanup.service - Network Cleanup. Aug 5 22:15:00.912230 systemd[1]: Starting systemd-fsck-usr.service... Aug 5 22:15:00.912238 systemd[1]: Starting systemd-journald.service - Journal Service... Aug 5 22:15:00.912246 systemd[1]: Starting systemd-modules-load.service - Load Kernel Modules... Aug 5 22:15:00.912254 systemd[1]: Starting systemd-vconsole-setup.service - Virtual Console Setup... Aug 5 22:15:00.912263 systemd[1]: Finished ignition-setup-pre.service - Ignition env setup. Aug 5 22:15:00.912271 systemd[1]: Finished kmod-static-nodes.service - Create List of Static Device Nodes. Aug 5 22:15:00.912278 systemd[1]: Finished systemd-fsck-usr.service. Aug 5 22:15:00.912304 systemd-journald[238]: Collecting audit messages is disabled. Aug 5 22:15:00.912325 systemd[1]: Starting systemd-tmpfiles-setup-dev-early.service - Create Static Device Nodes in /dev gracefully... Aug 5 22:15:00.912333 systemd[1]: Finished systemd-vconsole-setup.service - Virtual Console Setup. Aug 5 22:15:00.912341 kernel: bridge: filtering via arp/ip/ip6tables is no longer available by default. Update your scripts to load br_netfilter if you need this. Aug 5 22:15:00.912349 systemd[1]: Finished systemd-tmpfiles-setup-dev-early.service - Create Static Device Nodes in /dev gracefully. Aug 5 22:15:00.912358 kernel: Bridge firewalling registered Aug 5 22:15:00.912367 systemd-journald[238]: Journal started Aug 5 22:15:00.912385 systemd-journald[238]: Runtime Journal (/run/log/journal/b3a66ac8397e47cd9ac903b453653775) is 5.9M, max 47.3M, 41.4M free. Aug 5 22:15:00.893627 systemd-modules-load[239]: Inserted module 'overlay' Aug 5 22:15:00.911875 systemd-modules-load[239]: Inserted module 'br_netfilter' Aug 5 22:15:00.916955 systemd[1]: Starting dracut-cmdline-ask.service - dracut ask for additional cmdline parameters... Aug 5 22:15:00.916975 systemd[1]: Starting systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev... Aug 5 22:15:00.919359 systemd[1]: Started systemd-journald.service - Journal Service. Aug 5 22:15:00.919720 systemd[1]: Finished systemd-modules-load.service - Load Kernel Modules. Aug 5 22:15:00.923108 systemd[1]: Starting systemd-sysctl.service - Apply Kernel Variables... Aug 5 22:15:00.924982 systemd[1]: Starting systemd-tmpfiles-setup.service - Create Volatile Files and Directories... Aug 5 22:15:00.928437 systemd[1]: Finished systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev. Aug 5 22:15:00.936385 systemd[1]: Finished systemd-sysctl.service - Apply Kernel Variables. Aug 5 22:15:00.937464 systemd[1]: Finished systemd-tmpfiles-setup.service - Create Volatile Files and Directories. Aug 5 22:15:00.939115 systemd[1]: Finished dracut-cmdline-ask.service - dracut ask for additional cmdline parameters. Aug 5 22:15:00.960125 systemd[1]: Starting dracut-cmdline.service - dracut cmdline hook... Aug 5 22:15:00.962198 systemd[1]: Starting systemd-resolved.service - Network Name Resolution... Aug 5 22:15:00.969467 dracut-cmdline[275]: dracut-dracut-053 Aug 5 22:15:00.972638 dracut-cmdline[275]: 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=4052403b8e39e55d48e6afcca927358798017aa0d33c868bc3038260a8d9be90 Aug 5 22:15:00.989195 systemd-resolved[277]: Positive Trust Anchors: Aug 5 22:15:00.989211 systemd-resolved[277]: . IN DS 20326 8 2 e06d44b80b8f1d39a95c0b0d7c65d08458e880409bbc683457104237c7f8ec8d Aug 5 22:15:00.989246 systemd-resolved[277]: Negative trust anchors: home.arpa 10.in-addr.arpa 16.172.in-addr.arpa 17.172.in-addr.arpa 18.172.in-addr.arpa 19.172.in-addr.arpa 20.172.in-addr.arpa 21.172.in-addr.arpa 22.172.in-addr.arpa 23.172.in-addr.arpa 24.172.in-addr.arpa 25.172.in-addr.arpa 26.172.in-addr.arpa 27.172.in-addr.arpa 28.172.in-addr.arpa 29.172.in-addr.arpa 30.172.in-addr.arpa 31.172.in-addr.arpa 170.0.0.192.in-addr.arpa 171.0.0.192.in-addr.arpa 168.192.in-addr.arpa d.f.ip6.arpa ipv4only.arpa corp home internal intranet lan local private test Aug 5 22:15:00.993756 systemd-resolved[277]: Defaulting to hostname 'linux'. Aug 5 22:15:00.994691 systemd[1]: Started systemd-resolved.service - Network Name Resolution. Aug 5 22:15:00.998057 systemd[1]: Reached target nss-lookup.target - Host and Network Name Lookups. Aug 5 22:15:01.041866 kernel: SCSI subsystem initialized Aug 5 22:15:01.046855 kernel: Loading iSCSI transport class v2.0-870. Aug 5 22:15:01.053856 kernel: iscsi: registered transport (tcp) Aug 5 22:15:01.066935 kernel: iscsi: registered transport (qla4xxx) Aug 5 22:15:01.066958 kernel: QLogic iSCSI HBA Driver Aug 5 22:15:01.109213 systemd[1]: Finished dracut-cmdline.service - dracut cmdline hook. Aug 5 22:15:01.121088 systemd[1]: Starting dracut-pre-udev.service - dracut pre-udev hook... Aug 5 22:15:01.138487 kernel: device-mapper: core: CONFIG_IMA_DISABLE_HTABLE is disabled. Duplicate IMA measurements will not be recorded in the IMA log. Aug 5 22:15:01.138573 kernel: device-mapper: uevent: version 1.0.3 Aug 5 22:15:01.138603 kernel: device-mapper: ioctl: 4.48.0-ioctl (2023-03-01) initialised: dm-devel@redhat.com Aug 5 22:15:01.183862 kernel: raid6: neonx8 gen() 15631 MB/s Aug 5 22:15:01.200854 kernel: raid6: neonx4 gen() 15465 MB/s Aug 5 22:15:01.217854 kernel: raid6: neonx2 gen() 13152 MB/s Aug 5 22:15:01.234863 kernel: raid6: neonx1 gen() 10388 MB/s Aug 5 22:15:01.251852 kernel: raid6: int64x8 gen() 6895 MB/s Aug 5 22:15:01.268859 kernel: raid6: int64x4 gen() 7179 MB/s Aug 5 22:15:01.285858 kernel: raid6: int64x2 gen() 6083 MB/s Aug 5 22:15:01.302861 kernel: raid6: int64x1 gen() 5021 MB/s Aug 5 22:15:01.302885 kernel: raid6: using algorithm neonx8 gen() 15631 MB/s Aug 5 22:15:01.319857 kernel: raid6: .... xor() 11715 MB/s, rmw enabled Aug 5 22:15:01.319870 kernel: raid6: using neon recovery algorithm Aug 5 22:15:01.325163 kernel: xor: measuring software checksum speed Aug 5 22:15:01.325181 kernel: 8regs : 19893 MB/sec Aug 5 22:15:01.326060 kernel: 32regs : 19682 MB/sec Aug 5 22:15:01.326887 kernel: arm64_neon : 27179 MB/sec Aug 5 22:15:01.326899 kernel: xor: using function: arm64_neon (27179 MB/sec) Aug 5 22:15:01.377861 kernel: Btrfs loaded, zoned=no, fsverity=no Aug 5 22:15:01.388325 systemd[1]: Finished dracut-pre-udev.service - dracut pre-udev hook. Aug 5 22:15:01.401039 systemd[1]: Starting systemd-udevd.service - Rule-based Manager for Device Events and Files... Aug 5 22:15:01.414180 systemd-udevd[460]: Using default interface naming scheme 'v255'. Aug 5 22:15:01.417196 systemd[1]: Started systemd-udevd.service - Rule-based Manager for Device Events and Files. Aug 5 22:15:01.428294 systemd[1]: Starting dracut-pre-trigger.service - dracut pre-trigger hook... Aug 5 22:15:01.439091 dracut-pre-trigger[468]: rd.md=0: removing MD RAID activation Aug 5 22:15:01.464604 systemd[1]: Finished dracut-pre-trigger.service - dracut pre-trigger hook. Aug 5 22:15:01.476017 systemd[1]: Starting systemd-udev-trigger.service - Coldplug All udev Devices... Aug 5 22:15:01.513002 systemd[1]: Finished systemd-udev-trigger.service - Coldplug All udev Devices. Aug 5 22:15:01.521204 systemd[1]: Starting dracut-initqueue.service - dracut initqueue hook... Aug 5 22:15:01.532588 systemd[1]: Finished dracut-initqueue.service - dracut initqueue hook. Aug 5 22:15:01.536372 systemd[1]: Reached target remote-fs-pre.target - Preparation for Remote File Systems. Aug 5 22:15:01.538776 systemd[1]: Reached target remote-cryptsetup.target - Remote Encrypted Volumes. Aug 5 22:15:01.539886 systemd[1]: Reached target remote-fs.target - Remote File Systems. Aug 5 22:15:01.549128 systemd[1]: Starting dracut-pre-mount.service - dracut pre-mount hook... Aug 5 22:15:01.557502 systemd[1]: Finished dracut-pre-mount.service - dracut pre-mount hook. Aug 5 22:15:01.559860 kernel: virtio_blk virtio1: 1/0/0 default/read/poll queues Aug 5 22:15:01.574969 kernel: virtio_blk virtio1: [vda] 9289728 512-byte logical blocks (4.76 GB/4.43 GiB) Aug 5 22:15:01.575072 kernel: vda: vda1 vda2 vda3 vda4 vda6 vda7 vda9 Aug 5 22:15:01.579820 systemd[1]: dracut-cmdline-ask.service: Deactivated successfully. Aug 5 22:15:01.579946 systemd[1]: Stopped dracut-cmdline-ask.service - dracut ask for additional cmdline parameters. Aug 5 22:15:01.583168 systemd[1]: Stopping dracut-cmdline-ask.service - dracut ask for additional cmdline parameters... Aug 5 22:15:01.584418 systemd[1]: systemd-vconsole-setup.service: Deactivated successfully. Aug 5 22:15:01.584671 systemd[1]: Stopped systemd-vconsole-setup.service - Virtual Console Setup. Aug 5 22:15:01.586689 systemd[1]: Stopping systemd-vconsole-setup.service - Virtual Console Setup... Aug 5 22:15:01.593860 kernel: BTRFS: device label OEM devid 1 transid 12 /dev/vda6 scanned by (udev-worker) (519) Aug 5 22:15:01.596862 kernel: BTRFS: device fsid 278882ec-4175-45f0-a12b-7fddc0d6d9a3 devid 1 transid 41 /dev/vda3 scanned by (udev-worker) (521) Aug 5 22:15:01.608051 systemd[1]: Starting systemd-vconsole-setup.service - Virtual Console Setup... Aug 5 22:15:01.618883 systemd[1]: Finished systemd-vconsole-setup.service - Virtual Console Setup. Aug 5 22:15:01.624246 systemd[1]: Found device dev-disk-by\x2dlabel-EFI\x2dSYSTEM.device - /dev/disk/by-label/EFI-SYSTEM. Aug 5 22:15:01.632028 systemd[1]: Found device dev-disk-by\x2dlabel-ROOT.device - /dev/disk/by-label/ROOT. Aug 5 22:15:01.637111 systemd[1]: Found device dev-disk-by\x2dlabel-OEM.device - /dev/disk/by-label/OEM. Aug 5 22:15:01.641290 systemd[1]: Found device dev-disk-by\x2dpartlabel-USR\x2dA.device - /dev/disk/by-partlabel/USR-A. Aug 5 22:15:01.642148 systemd[1]: Found device dev-disk-by\x2dpartuuid-7130c94a\x2d213a\x2d4e5a\x2d8e26\x2d6cce9662f132.device - /dev/disk/by-partuuid/7130c94a-213a-4e5a-8e26-6cce9662f132. Aug 5 22:15:01.654962 systemd[1]: Starting disk-uuid.service - Generate new UUID for disk GPT if necessary... Aug 5 22:15:01.656596 systemd[1]: Starting dracut-cmdline-ask.service - dracut ask for additional cmdline parameters... Aug 5 22:15:01.663910 kernel: vda: vda1 vda2 vda3 vda4 vda6 vda7 vda9 Aug 5 22:15:01.675196 systemd[1]: Finished dracut-cmdline-ask.service - dracut ask for additional cmdline parameters. Aug 5 22:15:01.678619 kernel: vda: vda1 vda2 vda3 vda4 vda6 vda7 vda9 Aug 5 22:15:02.677866 kernel: vda: vda1 vda2 vda3 vda4 vda6 vda7 vda9 Aug 5 22:15:02.678706 disk-uuid[552]: The operation has completed successfully. Aug 5 22:15:02.703020 systemd[1]: disk-uuid.service: Deactivated successfully. Aug 5 22:15:02.703111 systemd[1]: Finished disk-uuid.service - Generate new UUID for disk GPT if necessary. Aug 5 22:15:02.721986 systemd[1]: Starting verity-setup.service - Verity Setup for /dev/mapper/usr... Aug 5 22:15:02.725578 sh[573]: Success Aug 5 22:15:02.737892 kernel: device-mapper: verity: sha256 using implementation "sha256-ce" Aug 5 22:15:02.764874 systemd[1]: Found device dev-mapper-usr.device - /dev/mapper/usr. Aug 5 22:15:02.774152 systemd[1]: Mounting sysusr-usr.mount - /sysusr/usr... Aug 5 22:15:02.776103 systemd[1]: Finished verity-setup.service - Verity Setup for /dev/mapper/usr. Aug 5 22:15:02.785980 kernel: BTRFS info (device dm-0): first mount of filesystem 278882ec-4175-45f0-a12b-7fddc0d6d9a3 Aug 5 22:15:02.786016 kernel: BTRFS info (device dm-0): using crc32c (crc32c-generic) checksum algorithm Aug 5 22:15:02.786026 kernel: BTRFS warning (device dm-0): 'nologreplay' is deprecated, use 'rescue=nologreplay' instead Aug 5 22:15:02.787263 kernel: BTRFS info (device dm-0): disabling log replay at mount time Aug 5 22:15:02.787286 kernel: BTRFS info (device dm-0): using free space tree Aug 5 22:15:02.791098 systemd[1]: Mounted sysusr-usr.mount - /sysusr/usr. Aug 5 22:15:02.792321 systemd[1]: afterburn-network-kargs.service - Afterburn Initrd Setup Network Kernel Arguments was skipped because no trigger condition checks were met. Aug 5 22:15:02.793038 systemd[1]: Starting ignition-setup.service - Ignition (setup)... Aug 5 22:15:02.795368 systemd[1]: Starting parse-ip-for-networkd.service - Write systemd-networkd units from cmdline... Aug 5 22:15:02.804657 kernel: BTRFS info (device vda6): first mount of filesystem 47327e03-a391-4166-b35e-18ba93a1f298 Aug 5 22:15:02.804695 kernel: BTRFS info (device vda6): using crc32c (crc32c-generic) checksum algorithm Aug 5 22:15:02.804705 kernel: BTRFS info (device vda6): using free space tree Aug 5 22:15:02.806857 kernel: BTRFS info (device vda6): auto enabling async discard Aug 5 22:15:02.813666 systemd[1]: mnt-oem.mount: Deactivated successfully. Aug 5 22:15:02.815276 kernel: BTRFS info (device vda6): last unmount of filesystem 47327e03-a391-4166-b35e-18ba93a1f298 Aug 5 22:15:02.820693 systemd[1]: Finished ignition-setup.service - Ignition (setup). Aug 5 22:15:02.828991 systemd[1]: Starting ignition-fetch-offline.service - Ignition (fetch-offline)... Aug 5 22:15:02.887336 systemd[1]: Finished parse-ip-for-networkd.service - Write systemd-networkd units from cmdline. Aug 5 22:15:02.894989 systemd[1]: Starting systemd-networkd.service - Network Configuration... Aug 5 22:15:02.921451 systemd-networkd[764]: lo: Link UP Aug 5 22:15:02.921458 systemd-networkd[764]: lo: Gained carrier Aug 5 22:15:02.921981 ignition[668]: Ignition 2.18.0 Aug 5 22:15:02.922123 systemd-networkd[764]: Enumeration completed Aug 5 22:15:02.921988 ignition[668]: Stage: fetch-offline Aug 5 22:15:02.922228 systemd[1]: Started systemd-networkd.service - Network Configuration. Aug 5 22:15:02.922017 ignition[668]: no configs at "/usr/lib/ignition/base.d" Aug 5 22:15:02.922557 systemd-networkd[764]: eth0: found matching network '/usr/lib/systemd/network/zz-default.network', based on potentially unpredictable interface name. Aug 5 22:15:02.922024 ignition[668]: no config dir at "/usr/lib/ignition/base.platform.d/qemu" Aug 5 22:15:02.922560 systemd-networkd[764]: eth0: Configuring with /usr/lib/systemd/network/zz-default.network. Aug 5 22:15:02.922104 ignition[668]: parsed url from cmdline: "" Aug 5 22:15:02.923456 systemd-networkd[764]: eth0: Link UP Aug 5 22:15:02.922107 ignition[668]: no config URL provided Aug 5 22:15:02.923458 systemd-networkd[764]: eth0: Gained carrier Aug 5 22:15:02.922111 ignition[668]: reading system config file "/usr/lib/ignition/user.ign" Aug 5 22:15:02.923466 systemd-networkd[764]: eth0: found matching network '/usr/lib/systemd/network/zz-default.network', based on potentially unpredictable interface name. Aug 5 22:15:02.922118 ignition[668]: no config at "/usr/lib/ignition/user.ign" Aug 5 22:15:02.923693 systemd[1]: Reached target network.target - Network. Aug 5 22:15:02.922142 ignition[668]: op(1): [started] loading QEMU firmware config module Aug 5 22:15:02.922146 ignition[668]: op(1): executing: "modprobe" "qemu_fw_cfg" Aug 5 22:15:02.936831 ignition[668]: op(1): [finished] loading QEMU firmware config module Aug 5 22:15:02.942564 ignition[668]: parsing config with SHA512: 13ed2c3363523124a49b3b2569f835f5efcba09ce8b28ab6fed86c4eb8c3e48cb6093f99f5cb4c6cc10aaa288a3bc3c5566894abf9d2cf220be66da1de161fa6 Aug 5 22:15:02.942874 systemd-networkd[764]: eth0: DHCPv4 address 10.0.0.115/16, gateway 10.0.0.1 acquired from 10.0.0.1 Aug 5 22:15:02.950858 unknown[668]: fetched base config from "system" Aug 5 22:15:02.951466 unknown[668]: fetched user config from "qemu" Aug 5 22:15:02.951742 ignition[668]: fetch-offline: fetch-offline passed Aug 5 22:15:02.951870 ignition[668]: Ignition finished successfully Aug 5 22:15:02.953455 systemd[1]: Finished ignition-fetch-offline.service - Ignition (fetch-offline). Aug 5 22:15:02.955270 systemd[1]: ignition-fetch.service - Ignition (fetch) was skipped because of an unmet condition check (ConditionPathExists=!/run/ignition.json). Aug 5 22:15:02.967038 systemd[1]: Starting ignition-kargs.service - Ignition (kargs)... Aug 5 22:15:02.977045 ignition[772]: Ignition 2.18.0 Aug 5 22:15:02.977054 ignition[772]: Stage: kargs Aug 5 22:15:02.977203 ignition[772]: no configs at "/usr/lib/ignition/base.d" Aug 5 22:15:02.977212 ignition[772]: no config dir at "/usr/lib/ignition/base.platform.d/qemu" Aug 5 22:15:02.980231 systemd[1]: Finished ignition-kargs.service - Ignition (kargs). Aug 5 22:15:02.977853 ignition[772]: kargs: kargs passed Aug 5 22:15:02.977896 ignition[772]: Ignition finished successfully Aug 5 22:15:02.989016 systemd[1]: Starting ignition-disks.service - Ignition (disks)... Aug 5 22:15:02.999381 ignition[780]: Ignition 2.18.0 Aug 5 22:15:02.999391 ignition[780]: Stage: disks Aug 5 22:15:02.999545 ignition[780]: no configs at "/usr/lib/ignition/base.d" Aug 5 22:15:02.999553 ignition[780]: no config dir at "/usr/lib/ignition/base.platform.d/qemu" Aug 5 22:15:03.001976 systemd[1]: Finished ignition-disks.service - Ignition (disks). Aug 5 22:15:03.000214 ignition[780]: disks: disks passed Aug 5 22:15:03.000256 ignition[780]: Ignition finished successfully Aug 5 22:15:03.004705 systemd[1]: Reached target initrd-root-device.target - Initrd Root Device. Aug 5 22:15:03.005841 systemd[1]: Reached target local-fs-pre.target - Preparation for Local File Systems. Aug 5 22:15:03.007784 systemd[1]: Reached target local-fs.target - Local File Systems. Aug 5 22:15:03.009675 systemd[1]: Reached target sysinit.target - System Initialization. Aug 5 22:15:03.011383 systemd[1]: Reached target basic.target - Basic System. Aug 5 22:15:03.025992 systemd[1]: Starting systemd-fsck-root.service - File System Check on /dev/disk/by-label/ROOT... Aug 5 22:15:03.036291 systemd-fsck[791]: ROOT: clean, 14/553520 files, 52654/553472 blocks Aug 5 22:15:03.040394 systemd[1]: Finished systemd-fsck-root.service - File System Check on /dev/disk/by-label/ROOT. Aug 5 22:15:03.042423 systemd[1]: Mounting sysroot.mount - /sysroot... Aug 5 22:15:03.088861 kernel: EXT4-fs (vda9): mounted filesystem 44c9fced-dca5-4347-a15f-96911c2e5e61 r/w with ordered data mode. Quota mode: none. Aug 5 22:15:03.089293 systemd[1]: Mounted sysroot.mount - /sysroot. Aug 5 22:15:03.090405 systemd[1]: Reached target initrd-root-fs.target - Initrd Root File System. Aug 5 22:15:03.103919 systemd[1]: Mounting sysroot-oem.mount - /sysroot/oem... Aug 5 22:15:03.105938 systemd[1]: Mounting sysroot-usr.mount - /sysroot/usr... Aug 5 22:15:03.106917 systemd[1]: flatcar-metadata-hostname.service - Flatcar Metadata Hostname Agent was skipped because no trigger condition checks were met. Aug 5 22:15:03.106957 systemd[1]: ignition-remount-sysroot.service - Remount /sysroot read-write for Ignition was skipped because of an unmet condition check (ConditionPathIsReadWrite=!/sysroot). Aug 5 22:15:03.106977 systemd[1]: Reached target ignition-diskful.target - Ignition Boot Disk Setup. Aug 5 22:15:03.112973 systemd[1]: Mounted sysroot-usr.mount - /sysroot/usr. Aug 5 22:15:03.114827 systemd[1]: Starting initrd-setup-root.service - Root filesystem setup... Aug 5 22:15:03.118585 kernel: BTRFS: device label OEM devid 1 transid 13 /dev/vda6 scanned by mount (799) Aug 5 22:15:03.118612 kernel: BTRFS info (device vda6): first mount of filesystem 47327e03-a391-4166-b35e-18ba93a1f298 Aug 5 22:15:03.118622 kernel: BTRFS info (device vda6): using crc32c (crc32c-generic) checksum algorithm Aug 5 22:15:03.118632 kernel: BTRFS info (device vda6): using free space tree Aug 5 22:15:03.120854 kernel: BTRFS info (device vda6): auto enabling async discard Aug 5 22:15:03.122003 systemd[1]: Mounted sysroot-oem.mount - /sysroot/oem. Aug 5 22:15:03.159187 initrd-setup-root[823]: cut: /sysroot/etc/passwd: No such file or directory Aug 5 22:15:03.163684 initrd-setup-root[830]: cut: /sysroot/etc/group: No such file or directory Aug 5 22:15:03.167619 initrd-setup-root[837]: cut: /sysroot/etc/shadow: No such file or directory Aug 5 22:15:03.171599 initrd-setup-root[844]: cut: /sysroot/etc/gshadow: No such file or directory Aug 5 22:15:03.253788 systemd[1]: Finished initrd-setup-root.service - Root filesystem setup. Aug 5 22:15:03.261945 systemd[1]: Starting ignition-mount.service - Ignition (mount)... Aug 5 22:15:03.264373 systemd[1]: Starting sysroot-boot.service - /sysroot/boot... Aug 5 22:15:03.268862 kernel: BTRFS info (device vda6): last unmount of filesystem 47327e03-a391-4166-b35e-18ba93a1f298 Aug 5 22:15:03.285888 ignition[912]: INFO : Ignition 2.18.0 Aug 5 22:15:03.285888 ignition[912]: INFO : Stage: mount Aug 5 22:15:03.287423 ignition[912]: INFO : no configs at "/usr/lib/ignition/base.d" Aug 5 22:15:03.287423 ignition[912]: INFO : no config dir at "/usr/lib/ignition/base.platform.d/qemu" Aug 5 22:15:03.287423 ignition[912]: INFO : mount: mount passed Aug 5 22:15:03.287423 ignition[912]: INFO : Ignition finished successfully Aug 5 22:15:03.287583 systemd[1]: Finished sysroot-boot.service - /sysroot/boot. Aug 5 22:15:03.289090 systemd[1]: Finished ignition-mount.service - Ignition (mount). Aug 5 22:15:03.298975 systemd[1]: Starting ignition-files.service - Ignition (files)... Aug 5 22:15:03.785601 systemd[1]: sysroot-oem.mount: Deactivated successfully. Aug 5 22:15:03.803022 systemd[1]: Mounting sysroot-oem.mount - /sysroot/oem... Aug 5 22:15:03.807850 kernel: BTRFS: device label OEM devid 1 transid 14 /dev/vda6 scanned by mount (927) Aug 5 22:15:03.809413 kernel: BTRFS info (device vda6): first mount of filesystem 47327e03-a391-4166-b35e-18ba93a1f298 Aug 5 22:15:03.809446 kernel: BTRFS info (device vda6): using crc32c (crc32c-generic) checksum algorithm Aug 5 22:15:03.809465 kernel: BTRFS info (device vda6): using free space tree Aug 5 22:15:03.811847 kernel: BTRFS info (device vda6): auto enabling async discard Aug 5 22:15:03.812920 systemd[1]: Mounted sysroot-oem.mount - /sysroot/oem. Aug 5 22:15:03.829632 ignition[944]: INFO : Ignition 2.18.0 Aug 5 22:15:03.829632 ignition[944]: INFO : Stage: files Aug 5 22:15:03.831022 ignition[944]: INFO : no configs at "/usr/lib/ignition/base.d" Aug 5 22:15:03.831022 ignition[944]: INFO : no config dir at "/usr/lib/ignition/base.platform.d/qemu" Aug 5 22:15:03.831022 ignition[944]: DEBUG : files: compiled without relabeling support, skipping Aug 5 22:15:03.834125 ignition[944]: INFO : files: ensureUsers: op(1): [started] creating or modifying user "core" Aug 5 22:15:03.834125 ignition[944]: DEBUG : files: ensureUsers: op(1): executing: "usermod" "--root" "/sysroot" "core" Aug 5 22:15:03.836820 ignition[944]: INFO : files: ensureUsers: op(1): [finished] creating or modifying user "core" Aug 5 22:15:03.836820 ignition[944]: INFO : files: ensureUsers: op(2): [started] adding ssh keys to user "core" Aug 5 22:15:03.836820 ignition[944]: INFO : files: ensureUsers: op(2): [finished] adding ssh keys to user "core" Aug 5 22:15:03.836078 unknown[944]: wrote ssh authorized keys file for user: core Aug 5 22:15:03.841587 ignition[944]: INFO : files: createFilesystemsFiles: createFiles: op(3): [started] writing file "/sysroot/etc/hostname" Aug 5 22:15:03.841587 ignition[944]: INFO : files: createFilesystemsFiles: createFiles: op(3): [finished] writing file "/sysroot/etc/hostname" Aug 5 22:15:03.841587 ignition[944]: INFO : files: createFilesystemsFiles: createFiles: op(4): [started] writing file "/sysroot/etc/exports" Aug 5 22:15:03.841587 ignition[944]: INFO : files: createFilesystemsFiles: createFiles: op(4): [finished] writing file "/sysroot/etc/exports" Aug 5 22:15:03.841587 ignition[944]: INFO : files: createFilesystemsFiles: createFiles: op(5): [started] writing file "/sysroot/etc/flatcar/update.conf" Aug 5 22:15:03.841587 ignition[944]: INFO : files: createFilesystemsFiles: createFiles: op(5): [finished] writing file "/sysroot/etc/flatcar/update.conf" Aug 5 22:15:03.841587 ignition[944]: INFO : files: createFilesystemsFiles: createFiles: op(6): [started] writing file "/sysroot/var/lib/nfs/etab" Aug 5 22:15:03.841587 ignition[944]: INFO : files: createFilesystemsFiles: createFiles: op(6): [finished] writing file "/sysroot/var/lib/nfs/etab" Aug 5 22:15:03.841587 ignition[944]: INFO : files: op(7): [started] processing unit "nfs-server.service" Aug 5 22:15:03.841587 ignition[944]: INFO : files: op(7): [finished] processing unit "nfs-server.service" Aug 5 22:15:03.841587 ignition[944]: INFO : files: op(8): [started] processing unit "coreos-metadata.service" Aug 5 22:15:03.841587 ignition[944]: INFO : files: op(8): op(9): [started] writing unit "coreos-metadata.service" at "/sysroot/etc/systemd/system/coreos-metadata.service" Aug 5 22:15:03.841587 ignition[944]: INFO : files: op(8): op(9): [finished] writing unit "coreos-metadata.service" at "/sysroot/etc/systemd/system/coreos-metadata.service" Aug 5 22:15:03.841587 ignition[944]: INFO : files: op(8): [finished] processing unit "coreos-metadata.service" Aug 5 22:15:03.841587 ignition[944]: INFO : files: op(a): [started] setting preset to disabled for "coreos-metadata.service" Aug 5 22:15:03.875530 ignition[944]: INFO : files: op(a): op(b): [started] removing enablement symlink(s) for "coreos-metadata.service" Aug 5 22:15:03.879045 ignition[944]: INFO : files: op(a): op(b): [finished] removing enablement symlink(s) for "coreos-metadata.service" Aug 5 22:15:03.880433 ignition[944]: INFO : files: op(a): [finished] setting preset to disabled for "coreos-metadata.service" Aug 5 22:15:03.880433 ignition[944]: INFO : files: op(c): [started] setting preset to enabled for "nfs-server.service" Aug 5 22:15:03.880433 ignition[944]: INFO : files: op(c): [finished] setting preset to enabled for "nfs-server.service" Aug 5 22:15:03.880433 ignition[944]: INFO : files: createResultFile: createFiles: op(d): [started] writing file "/sysroot/etc/.ignition-result.json" Aug 5 22:15:03.880433 ignition[944]: INFO : files: createResultFile: createFiles: op(d): [finished] writing file "/sysroot/etc/.ignition-result.json" Aug 5 22:15:03.880433 ignition[944]: INFO : files: files passed Aug 5 22:15:03.880433 ignition[944]: INFO : Ignition finished successfully Aug 5 22:15:03.880769 systemd[1]: Finished ignition-files.service - Ignition (files). Aug 5 22:15:03.890959 systemd[1]: Starting ignition-quench.service - Ignition (record completion)... Aug 5 22:15:03.892585 systemd[1]: Starting initrd-setup-root-after-ignition.service - Root filesystem completion... Aug 5 22:15:03.895744 systemd[1]: ignition-quench.service: Deactivated successfully. Aug 5 22:15:03.895900 systemd[1]: Finished ignition-quench.service - Ignition (record completion). Aug 5 22:15:03.900602 initrd-setup-root-after-ignition[972]: grep: /sysroot/oem/oem-release: No such file or directory Aug 5 22:15:03.903573 initrd-setup-root-after-ignition[974]: grep: /sysroot/etc/flatcar/enabled-sysext.conf: No such file or directory Aug 5 22:15:03.903573 initrd-setup-root-after-ignition[974]: grep: /sysroot/usr/share/flatcar/enabled-sysext.conf: No such file or directory Aug 5 22:15:03.905890 initrd-setup-root-after-ignition[978]: grep: /sysroot/etc/flatcar/enabled-sysext.conf: No such file or directory Aug 5 22:15:03.905986 systemd[1]: Finished initrd-setup-root-after-ignition.service - Root filesystem completion. Aug 5 22:15:03.908328 systemd[1]: Reached target ignition-complete.target - Ignition Complete. Aug 5 22:15:03.919991 systemd[1]: Starting initrd-parse-etc.service - Mountpoints Configured in the Real Root... Aug 5 22:15:03.938891 systemd[1]: initrd-parse-etc.service: Deactivated successfully. Aug 5 22:15:03.939002 systemd[1]: Finished initrd-parse-etc.service - Mountpoints Configured in the Real Root. Aug 5 22:15:03.940878 systemd[1]: Reached target initrd-fs.target - Initrd File Systems. Aug 5 22:15:03.942430 systemd[1]: Reached target initrd.target - Initrd Default Target. Aug 5 22:15:03.944173 systemd[1]: dracut-mount.service - dracut mount hook was skipped because no trigger condition checks were met. Aug 5 22:15:03.944868 systemd[1]: Starting dracut-pre-pivot.service - dracut pre-pivot and cleanup hook... Aug 5 22:15:03.959024 systemd[1]: Finished dracut-pre-pivot.service - dracut pre-pivot and cleanup hook. Aug 5 22:15:03.970044 systemd[1]: Starting initrd-cleanup.service - Cleaning Up and Shutting Down Daemons... Aug 5 22:15:03.977934 systemd[1]: Stopped target network.target - Network. Aug 5 22:15:03.978873 systemd[1]: Stopped target nss-lookup.target - Host and Network Name Lookups. Aug 5 22:15:03.980564 systemd[1]: Stopped target remote-cryptsetup.target - Remote Encrypted Volumes. Aug 5 22:15:03.982345 systemd[1]: Stopped target timers.target - Timer Units. Aug 5 22:15:03.984091 systemd[1]: dracut-pre-pivot.service: Deactivated successfully. Aug 5 22:15:03.984217 systemd[1]: Stopped dracut-pre-pivot.service - dracut pre-pivot and cleanup hook. Aug 5 22:15:03.986346 systemd[1]: Stopped target initrd.target - Initrd Default Target. Aug 5 22:15:03.988266 systemd[1]: Stopped target basic.target - Basic System. Aug 5 22:15:03.989852 systemd[1]: Stopped target ignition-complete.target - Ignition Complete. Aug 5 22:15:03.991446 systemd[1]: Stopped target ignition-diskful.target - Ignition Boot Disk Setup. Aug 5 22:15:03.993347 systemd[1]: Stopped target initrd-root-device.target - Initrd Root Device. Aug 5 22:15:03.995268 systemd[1]: Stopped target remote-fs.target - Remote File Systems. Aug 5 22:15:03.997064 systemd[1]: Stopped target remote-fs-pre.target - Preparation for Remote File Systems. Aug 5 22:15:03.998969 systemd[1]: Stopped target sysinit.target - System Initialization. Aug 5 22:15:04.000905 systemd[1]: Stopped target local-fs.target - Local File Systems. Aug 5 22:15:04.002598 systemd[1]: Stopped target swap.target - Swaps. Aug 5 22:15:04.003936 systemd[1]: dracut-pre-mount.service: Deactivated successfully. Aug 5 22:15:04.004065 systemd[1]: Stopped dracut-pre-mount.service - dracut pre-mount hook. Aug 5 22:15:04.006219 systemd[1]: Stopped target cryptsetup.target - Local Encrypted Volumes. Aug 5 22:15:04.008125 systemd[1]: Stopped target cryptsetup-pre.target - Local Encrypted Volumes (Pre). Aug 5 22:15:04.009969 systemd[1]: clevis-luks-askpass.path: Deactivated successfully. Aug 5 22:15:04.011352 systemd[1]: Stopped clevis-luks-askpass.path - Forward Password Requests to Clevis Directory Watch. Aug 5 22:15:04.012514 systemd[1]: dracut-initqueue.service: Deactivated successfully. Aug 5 22:15:04.012635 systemd[1]: Stopped dracut-initqueue.service - dracut initqueue hook. Aug 5 22:15:04.015346 systemd[1]: ignition-fetch-offline.service: Deactivated successfully. Aug 5 22:15:04.015474 systemd[1]: Stopped ignition-fetch-offline.service - Ignition (fetch-offline). Aug 5 22:15:04.017379 systemd[1]: Stopped target paths.target - Path Units. Aug 5 22:15:04.018900 systemd[1]: systemd-ask-password-console.path: Deactivated successfully. Aug 5 22:15:04.023886 systemd[1]: Stopped systemd-ask-password-console.path - Dispatch Password Requests to Console Directory Watch. Aug 5 22:15:04.025147 systemd[1]: Stopped target slices.target - Slice Units. Aug 5 22:15:04.027146 systemd[1]: Stopped target sockets.target - Socket Units. Aug 5 22:15:04.028607 systemd[1]: iscsid.socket: Deactivated successfully. Aug 5 22:15:04.028698 systemd[1]: Closed iscsid.socket - Open-iSCSI iscsid Socket. Aug 5 22:15:04.029993 systemd[1]: iscsiuio.socket: Deactivated successfully. Aug 5 22:15:04.030079 systemd[1]: Closed iscsiuio.socket - Open-iSCSI iscsiuio Socket. Aug 5 22:15:04.031403 systemd[1]: initrd-setup-root-after-ignition.service: Deactivated successfully. Aug 5 22:15:04.031517 systemd[1]: Stopped initrd-setup-root-after-ignition.service - Root filesystem completion. Aug 5 22:15:04.033077 systemd[1]: ignition-files.service: Deactivated successfully. Aug 5 22:15:04.033185 systemd[1]: Stopped ignition-files.service - Ignition (files). Aug 5 22:15:04.041007 systemd[1]: Stopping ignition-mount.service - Ignition (mount)... Aug 5 22:15:04.042522 systemd[1]: Stopping sysroot-boot.service - /sysroot/boot... Aug 5 22:15:04.043641 systemd[1]: Stopping systemd-networkd.service - Network Configuration... Aug 5 22:15:04.045211 systemd[1]: Stopping systemd-resolved.service - Network Name Resolution... Aug 5 22:15:04.046168 systemd[1]: systemd-udev-trigger.service: Deactivated successfully. Aug 5 22:15:04.046300 systemd[1]: Stopped systemd-udev-trigger.service - Coldplug All udev Devices. Aug 5 22:15:04.047478 systemd[1]: dracut-pre-trigger.service: Deactivated successfully. Aug 5 22:15:04.047581 systemd[1]: Stopped dracut-pre-trigger.service - dracut pre-trigger hook. Aug 5 22:15:04.052525 systemd[1]: initrd-cleanup.service: Deactivated successfully. Aug 5 22:15:04.053865 systemd[1]: Finished initrd-cleanup.service - Cleaning Up and Shutting Down Daemons. Aug 5 22:15:04.056364 systemd-networkd[764]: eth0: DHCPv6 lease lost Aug 5 22:15:04.059251 ignition[998]: INFO : Ignition 2.18.0 Aug 5 22:15:04.059251 ignition[998]: INFO : Stage: umount Aug 5 22:15:04.059251 ignition[998]: INFO : no configs at "/usr/lib/ignition/base.d" Aug 5 22:15:04.059251 ignition[998]: INFO : no config dir at "/usr/lib/ignition/base.platform.d/qemu" Aug 5 22:15:04.059251 ignition[998]: INFO : umount: umount passed Aug 5 22:15:04.059251 ignition[998]: INFO : Ignition finished successfully Aug 5 22:15:04.056901 systemd[1]: ignition-mount.service: Deactivated successfully. Aug 5 22:15:04.056991 systemd[1]: Stopped ignition-mount.service - Ignition (mount). Aug 5 22:15:04.061016 systemd[1]: sysroot-boot.mount: Deactivated successfully. Aug 5 22:15:04.061443 systemd[1]: systemd-resolved.service: Deactivated successfully. Aug 5 22:15:04.061525 systemd[1]: Stopped systemd-resolved.service - Network Name Resolution. Aug 5 22:15:04.063959 systemd[1]: systemd-networkd.service: Deactivated successfully. Aug 5 22:15:04.064063 systemd[1]: Stopped systemd-networkd.service - Network Configuration. Aug 5 22:15:04.065412 systemd[1]: sysroot-boot.service: Deactivated successfully. Aug 5 22:15:04.065489 systemd[1]: Stopped sysroot-boot.service - /sysroot/boot. Aug 5 22:15:04.067832 systemd[1]: systemd-networkd.socket: Deactivated successfully. Aug 5 22:15:04.067898 systemd[1]: Closed systemd-networkd.socket - Network Service Netlink Socket. Aug 5 22:15:04.069167 systemd[1]: ignition-disks.service: Deactivated successfully. Aug 5 22:15:04.069215 systemd[1]: Stopped ignition-disks.service - Ignition (disks). Aug 5 22:15:04.070773 systemd[1]: ignition-kargs.service: Deactivated successfully. Aug 5 22:15:04.070823 systemd[1]: Stopped ignition-kargs.service - Ignition (kargs). Aug 5 22:15:04.072044 systemd[1]: ignition-setup.service: Deactivated successfully. Aug 5 22:15:04.072082 systemd[1]: Stopped ignition-setup.service - Ignition (setup). Aug 5 22:15:04.073457 systemd[1]: ignition-setup-pre.service: Deactivated successfully. Aug 5 22:15:04.073497 systemd[1]: Stopped ignition-setup-pre.service - Ignition env setup. Aug 5 22:15:04.075242 systemd[1]: initrd-setup-root.service: Deactivated successfully. Aug 5 22:15:04.075285 systemd[1]: Stopped initrd-setup-root.service - Root filesystem setup. Aug 5 22:15:04.090972 systemd[1]: Stopping network-cleanup.service - Network Cleanup... Aug 5 22:15:04.091702 systemd[1]: parse-ip-for-networkd.service: Deactivated successfully. Aug 5 22:15:04.091751 systemd[1]: Stopped parse-ip-for-networkd.service - Write systemd-networkd units from cmdline. Aug 5 22:15:04.093570 systemd[1]: systemd-sysctl.service: Deactivated successfully. Aug 5 22:15:04.093610 systemd[1]: Stopped systemd-sysctl.service - Apply Kernel Variables. Aug 5 22:15:04.095414 systemd[1]: systemd-modules-load.service: Deactivated successfully. Aug 5 22:15:04.095456 systemd[1]: Stopped systemd-modules-load.service - Load Kernel Modules. Aug 5 22:15:04.097340 systemd[1]: systemd-tmpfiles-setup.service: Deactivated successfully. Aug 5 22:15:04.097380 systemd[1]: Stopped systemd-tmpfiles-setup.service - Create Volatile Files and Directories. Aug 5 22:15:04.099153 systemd[1]: Stopping systemd-udevd.service - Rule-based Manager for Device Events and Files... Aug 5 22:15:04.107868 systemd[1]: network-cleanup.service: Deactivated successfully. Aug 5 22:15:04.107968 systemd[1]: Stopped network-cleanup.service - Network Cleanup. Aug 5 22:15:04.117513 systemd[1]: systemd-udevd.service: Deactivated successfully. Aug 5 22:15:04.117645 systemd[1]: Stopped systemd-udevd.service - Rule-based Manager for Device Events and Files. Aug 5 22:15:04.119637 systemd[1]: systemd-udevd-control.socket: Deactivated successfully. Aug 5 22:15:04.119676 systemd[1]: Closed systemd-udevd-control.socket - udev Control Socket. Aug 5 22:15:04.121408 systemd[1]: systemd-udevd-kernel.socket: Deactivated successfully. Aug 5 22:15:04.121443 systemd[1]: Closed systemd-udevd-kernel.socket - udev Kernel Socket. Aug 5 22:15:04.123089 systemd[1]: dracut-pre-udev.service: Deactivated successfully. Aug 5 22:15:04.123132 systemd[1]: Stopped dracut-pre-udev.service - dracut pre-udev hook. Aug 5 22:15:04.125588 systemd[1]: dracut-cmdline.service: Deactivated successfully. Aug 5 22:15:04.125634 systemd[1]: Stopped dracut-cmdline.service - dracut cmdline hook. Aug 5 22:15:04.128022 systemd[1]: dracut-cmdline-ask.service: Deactivated successfully. Aug 5 22:15:04.128068 systemd[1]: Stopped dracut-cmdline-ask.service - dracut ask for additional cmdline parameters. Aug 5 22:15:04.142974 systemd[1]: Starting initrd-udevadm-cleanup-db.service - Cleanup udev Database... Aug 5 22:15:04.143963 systemd[1]: systemd-tmpfiles-setup-dev.service: Deactivated successfully. Aug 5 22:15:04.144022 systemd[1]: Stopped systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev. Aug 5 22:15:04.145946 systemd[1]: systemd-tmpfiles-setup-dev-early.service: Deactivated successfully. Aug 5 22:15:04.145990 systemd[1]: Stopped systemd-tmpfiles-setup-dev-early.service - Create Static Device Nodes in /dev gracefully. Aug 5 22:15:04.147955 systemd[1]: kmod-static-nodes.service: Deactivated successfully. Aug 5 22:15:04.148004 systemd[1]: Stopped kmod-static-nodes.service - Create List of Static Device Nodes. Aug 5 22:15:04.149848 systemd[1]: systemd-vconsole-setup.service: Deactivated successfully. Aug 5 22:15:04.149891 systemd[1]: Stopped systemd-vconsole-setup.service - Virtual Console Setup. Aug 5 22:15:04.152122 systemd[1]: initrd-udevadm-cleanup-db.service: Deactivated successfully. Aug 5 22:15:04.152214 systemd[1]: Finished initrd-udevadm-cleanup-db.service - Cleanup udev Database. Aug 5 22:15:04.154373 systemd[1]: Reached target initrd-switch-root.target - Switch Root. Aug 5 22:15:04.156528 systemd[1]: Starting initrd-switch-root.service - Switch Root... Aug 5 22:15:04.166670 systemd[1]: Switching root. Aug 5 22:15:04.189706 systemd-journald[238]: Journal stopped Aug 5 22:15:04.842852 systemd-journald[238]: Received SIGTERM from PID 1 (systemd). Aug 5 22:15:04.842908 kernel: SELinux: policy capability network_peer_controls=1 Aug 5 22:15:04.842921 kernel: SELinux: policy capability open_perms=1 Aug 5 22:15:04.842931 kernel: SELinux: policy capability extended_socket_class=1 Aug 5 22:15:04.842941 kernel: SELinux: policy capability always_check_network=0 Aug 5 22:15:04.842954 kernel: SELinux: policy capability cgroup_seclabel=1 Aug 5 22:15:04.842963 kernel: SELinux: policy capability nnp_nosuid_transition=1 Aug 5 22:15:04.842973 kernel: SELinux: policy capability genfs_seclabel_symlinks=0 Aug 5 22:15:04.842982 kernel: SELinux: policy capability ioctl_skip_cloexec=0 Aug 5 22:15:04.842995 kernel: audit: type=1403 audit(1722896104.247:2): auid=4294967295 ses=4294967295 lsm=selinux res=1 Aug 5 22:15:04.843006 systemd[1]: Successfully loaded SELinux policy in 28.613ms. Aug 5 22:15:04.843021 systemd[1]: Relabeled /dev, /dev/shm, /run, /sys/fs/cgroup in 8.899ms. Aug 5 22:15:04.843032 systemd[1]: systemd 255 running in system mode (+PAM +AUDIT +SELINUX -APPARMOR +IMA +SMACK +SECCOMP +GCRYPT -GNUTLS +OPENSSL -ACL +BLKID +CURL +ELFUTILS -FIDO2 +IDN2 -IDN +IPTC +KMOD +LIBCRYPTSETUP +LIBFDISK +PCRE2 -PWQUALITY -P11KIT -QRENCODE +TPM2 +BZIP2 +LZ4 +XZ +ZLIB +ZSTD -BPF_FRAMEWORK -XKBCOMMON +UTMP -SYSVINIT default-hierarchy=unified) Aug 5 22:15:04.843043 systemd[1]: Detected virtualization kvm. Aug 5 22:15:04.843055 systemd[1]: Detected architecture arm64. Aug 5 22:15:04.843065 systemd[1]: Detected first boot. Aug 5 22:15:04.843075 systemd[1]: Hostname set to . Aug 5 22:15:04.843085 systemd[1]: Initializing machine ID from VM UUID. Aug 5 22:15:04.843095 zram_generator::config[1044]: No configuration found. Aug 5 22:15:04.843109 (sd-exec-[1029]: /usr/lib/systemd/system-generators/nfs-server-generator failed with exit status 1. Aug 5 22:15:04.843120 systemd[1]: Populated /etc with preset unit settings. Aug 5 22:15:04.843132 systemd[1]: initrd-switch-root.service: Deactivated successfully. Aug 5 22:15:04.843142 systemd[1]: Stopped initrd-switch-root.service - Switch Root. Aug 5 22:15:04.843152 systemd[1]: systemd-journald.service: Scheduled restart job, restart counter is at 1. Aug 5 22:15:04.843163 systemd[1]: Created slice system-addon\x2dconfig.slice - Slice /system/addon-config. Aug 5 22:15:04.843174 systemd[1]: Created slice system-addon\x2drun.slice - Slice /system/addon-run. Aug 5 22:15:04.843185 systemd[1]: Created slice system-getty.slice - Slice /system/getty. Aug 5 22:15:04.843196 systemd[1]: Created slice system-modprobe.slice - Slice /system/modprobe. Aug 5 22:15:04.843206 systemd[1]: Created slice system-serial\x2dgetty.slice - Slice /system/serial-getty. Aug 5 22:15:04.843216 systemd[1]: Created slice system-system\x2dcloudinit.slice - Slice /system/system-cloudinit. Aug 5 22:15:04.843229 systemd[1]: Created slice system-systemd\x2dfsck.slice - Slice /system/systemd-fsck. Aug 5 22:15:04.843241 systemd[1]: Created slice user.slice - User and Session Slice. Aug 5 22:15:04.843252 systemd[1]: Started clevis-luks-askpass.path - Forward Password Requests to Clevis Directory Watch. Aug 5 22:15:04.843262 systemd[1]: Started systemd-ask-password-console.path - Dispatch Password Requests to Console Directory Watch. Aug 5 22:15:04.843272 systemd[1]: Started systemd-ask-password-wall.path - Forward Password Requests to Wall Directory Watch. Aug 5 22:15:04.843284 systemd[1]: Set up automount boot.automount - Boot partition Automount Point. Aug 5 22:15:04.843295 systemd[1]: Set up automount proc-sys-fs-binfmt_misc.automount - Arbitrary Executable File Formats File System Automount Point. Aug 5 22:15:04.843306 systemd[1]: Expecting device dev-disk-by\x2dlabel-OEM.device - /dev/disk/by-label/OEM... Aug 5 22:15:04.843319 systemd[1]: Expecting device dev-ttyAMA0.device - /dev/ttyAMA0... Aug 5 22:15:04.843329 systemd[1]: Reached target cryptsetup-pre.target - Local Encrypted Volumes (Pre). Aug 5 22:15:04.843340 systemd[1]: Stopped target initrd-switch-root.target - Switch Root. Aug 5 22:15:04.843351 systemd[1]: Stopped target initrd-fs.target - Initrd File Systems. Aug 5 22:15:04.843363 systemd[1]: Stopped target initrd-root-fs.target - Initrd Root File System. Aug 5 22:15:04.843375 systemd[1]: Reached target integritysetup.target - Local Integrity Protected Volumes. Aug 5 22:15:04.843385 systemd[1]: Reached target remote-cryptsetup.target - Remote Encrypted Volumes. Aug 5 22:15:04.843396 systemd[1]: Reached target remote-fs.target - Remote File Systems. Aug 5 22:15:04.843406 systemd[1]: Reached target slices.target - Slice Units. Aug 5 22:15:04.843417 systemd[1]: Reached target swap.target - Swaps. Aug 5 22:15:04.843427 systemd[1]: Reached target veritysetup.target - Local Verity Protected Volumes. Aug 5 22:15:04.843438 systemd[1]: Listening on rpcbind.socket - RPCbind Server Activation Socket. Aug 5 22:15:04.843450 systemd[1]: Reached target rpcbind.target - RPC Port Mapper. Aug 5 22:15:04.843460 systemd[1]: Listening on systemd-coredump.socket - Process Core Dump Socket. Aug 5 22:15:04.843471 systemd[1]: Listening on systemd-networkd.socket - Network Service Netlink Socket. Aug 5 22:15:04.843482 systemd[1]: Listening on systemd-udevd-control.socket - udev Control Socket. Aug 5 22:15:04.843493 systemd[1]: Listening on systemd-udevd-kernel.socket - udev Kernel Socket. Aug 5 22:15:04.843503 systemd[1]: Listening on systemd-userdbd.socket - User Database Manager Socket. Aug 5 22:15:04.843513 systemd[1]: Mounting dev-hugepages.mount - Huge Pages File System... Aug 5 22:15:04.843524 systemd[1]: Mounting dev-mqueue.mount - POSIX Message Queue File System... Aug 5 22:15:04.843534 systemd[1]: Mounting media.mount - External Media Directory... Aug 5 22:15:04.843546 systemd[1]: Mounting proc-fs-nfsd.mount - NFSD configuration filesystem... Aug 5 22:15:04.843557 systemd[1]: Mounting sys-kernel-debug.mount - Kernel Debug File System... Aug 5 22:15:04.843567 systemd[1]: Mounting sys-kernel-tracing.mount - Kernel Trace File System... Aug 5 22:15:04.843577 systemd[1]: Mounting tmp.mount - Temporary Directory /tmp... Aug 5 22:15:04.843588 systemd[1]: var-lib-machines.mount - Virtual Machine and Container Storage (Compatibility) was skipped because of an unmet condition check (ConditionPathExists=/var/lib/machines.raw). Aug 5 22:15:04.843598 systemd[1]: Reached target machines.target - Containers. Aug 5 22:15:04.843609 systemd[1]: auth-rpcgss-module.service - Kernel Module supporting RPCSEC_GSS was skipped because of an unmet condition check (ConditionPathExists=/etc/krb5.keytab). Aug 5 22:15:04.843619 systemd[1]: Starting flatcar-tmpfiles.service - Create missing system files... Aug 5 22:15:04.843631 systemd[1]: ignition-delete-config.service - Ignition (delete config) was skipped because no trigger condition checks were met. Aug 5 22:15:04.843641 systemd[1]: Starting kmod-static-nodes.service - Create List of Static Device Nodes... Aug 5 22:15:04.843651 systemd[1]: Starting modprobe@configfs.service - Load Kernel Module configfs... Aug 5 22:15:04.843662 systemd[1]: Starting modprobe@dm_mod.service - Load Kernel Module dm_mod... Aug 5 22:15:04.843672 kernel: RPC: Registered named UNIX socket transport module. Aug 5 22:15:04.843681 systemd[1]: Starting modprobe@drm.service - Load Kernel Module drm... Aug 5 22:15:04.843691 kernel: RPC: Registered udp transport module. Aug 5 22:15:04.843701 kernel: RPC: Registered tcp transport module. Aug 5 22:15:04.843710 kernel: RPC: Registered tcp-with-tls transport module. Aug 5 22:15:04.843720 kernel: RPC: Registered tcp NFSv4.1 backchannel transport module. Aug 5 22:15:04.843730 systemd[1]: Starting modprobe@efi_pstore.service - Load Kernel Module efi_pstore... Aug 5 22:15:04.843741 systemd[1]: Starting modprobe@fuse.service - Load Kernel Module fuse... Aug 5 22:15:04.843751 systemd[1]: Starting modprobe@loop.service - Load Kernel Module loop... Aug 5 22:15:04.843770 systemd[1]: Starting rpcbind.service - RPC Bind... Aug 5 22:15:04.843782 systemd[1]: setup-nsswitch.service - Create /etc/nsswitch.conf was skipped because of an unmet condition check (ConditionPathExists=!/etc/nsswitch.conf). Aug 5 22:15:04.843793 systemd[1]: systemd-fsck-root.service: Deactivated successfully. Aug 5 22:15:04.843803 systemd[1]: Stopped systemd-fsck-root.service - File System Check on Root Device. Aug 5 22:15:04.843813 kernel: fuse: init (API version 7.39) Aug 5 22:15:04.843825 systemd[1]: systemd-fsck-usr.service: Deactivated successfully. Aug 5 22:15:04.843842 kernel: ACPI: bus type drm_connector registered Aug 5 22:15:04.843856 systemd[1]: Stopped systemd-fsck-usr.service. Aug 5 22:15:04.843866 kernel: loop: module loaded Aug 5 22:15:04.843876 (rpcbind)[1115]: rpcbind.service: Referenced but unset environment variable evaluates to an empty string: RPCBIND_OPTIONS Aug 5 22:15:04.843887 systemd[1]: Starting systemd-journald.service - Journal Service... Aug 5 22:15:04.843897 systemd[1]: Starting systemd-modules-load.service - Load Kernel Modules... Aug 5 22:15:04.843907 systemd[1]: Starting systemd-network-generator.service - Generate network units from Kernel command line... Aug 5 22:15:04.843918 systemd[1]: Starting systemd-remount-fs.service - Remount Root and Kernel File Systems... Aug 5 22:15:04.843931 systemd[1]: Starting systemd-udev-trigger.service - Coldplug All udev Devices... Aug 5 22:15:04.843964 systemd-journald[1123]: Collecting audit messages is disabled. Aug 5 22:15:04.843984 systemd[1]: verity-setup.service: Deactivated successfully. Aug 5 22:15:04.843996 systemd[1]: Stopped verity-setup.service. Aug 5 22:15:04.844007 systemd-journald[1123]: Journal started Aug 5 22:15:04.844027 systemd-journald[1123]: Runtime Journal (/run/log/journal/b3a66ac8397e47cd9ac903b453653775) is 5.9M, max 47.3M, 41.4M free. Aug 5 22:15:04.603578 systemd[1]: Queued start job for default target multi-user.target. Aug 5 22:15:04.630719 systemd[1]: Unnecessary job was removed for dev-vda6.device - /dev/vda6. Aug 5 22:15:04.631139 systemd[1]: systemd-journald.service: Deactivated successfully. Aug 5 22:15:04.846858 systemd[1]: Started systemd-journald.service - Journal Service. Aug 5 22:15:04.846964 systemd[1]: Started rpcbind.service - RPC Bind. Aug 5 22:15:04.848291 systemd[1]: Mounted dev-hugepages.mount - Huge Pages File System. Aug 5 22:15:04.849395 systemd[1]: Mounted dev-mqueue.mount - POSIX Message Queue File System. Aug 5 22:15:04.854987 systemd[1]: Mounted media.mount - External Media Directory. Aug 5 22:15:04.856021 systemd[1]: Mounted proc-fs-nfsd.mount - NFSD configuration filesystem. Aug 5 22:15:04.857369 systemd[1]: Mounted sys-kernel-debug.mount - Kernel Debug File System. Aug 5 22:15:04.858637 systemd[1]: Mounted sys-kernel-tracing.mount - Kernel Trace File System. Aug 5 22:15:04.859996 systemd[1]: Mounted tmp.mount - Temporary Directory /tmp. Aug 5 22:15:04.861257 systemd[1]: Finished flatcar-tmpfiles.service - Create missing system files. Aug 5 22:15:04.862632 systemd[1]: Finished kmod-static-nodes.service - Create List of Static Device Nodes. Aug 5 22:15:04.863917 systemd[1]: modprobe@configfs.service: Deactivated successfully. Aug 5 22:15:04.864058 systemd[1]: Finished modprobe@configfs.service - Load Kernel Module configfs. Aug 5 22:15:04.865440 systemd[1]: modprobe@dm_mod.service: Deactivated successfully. Aug 5 22:15:04.865579 systemd[1]: Finished modprobe@dm_mod.service - Load Kernel Module dm_mod. Aug 5 22:15:04.866812 systemd[1]: modprobe@drm.service: Deactivated successfully. Aug 5 22:15:04.866976 systemd[1]: Finished modprobe@drm.service - Load Kernel Module drm. Aug 5 22:15:04.868077 systemd[1]: modprobe@efi_pstore.service: Deactivated successfully. Aug 5 22:15:04.868203 systemd[1]: Finished modprobe@efi_pstore.service - Load Kernel Module efi_pstore. Aug 5 22:15:04.869685 systemd[1]: modprobe@fuse.service: Deactivated successfully. Aug 5 22:15:04.869852 systemd[1]: Finished modprobe@fuse.service - Load Kernel Module fuse. Aug 5 22:15:04.871005 systemd[1]: modprobe@loop.service: Deactivated successfully. Aug 5 22:15:04.871149 systemd[1]: Finished modprobe@loop.service - Load Kernel Module loop. Aug 5 22:15:04.872431 systemd[1]: Finished systemd-modules-load.service - Load Kernel Modules. Aug 5 22:15:04.873863 systemd[1]: Finished systemd-network-generator.service - Generate network units from Kernel command line. Aug 5 22:15:04.875176 systemd[1]: Finished systemd-remount-fs.service - Remount Root and Kernel File Systems. Aug 5 22:15:04.888412 systemd[1]: Reached target network-pre.target - Preparation for Network. Aug 5 22:15:04.895953 systemd[1]: Mounting sys-fs-fuse-connections.mount - FUSE Control File System... Aug 5 22:15:04.901010 systemd[1]: Mounting sys-kernel-config.mount - Kernel Configuration File System... Aug 5 22:15:04.902120 systemd[1]: remount-root.service - Remount Root File System was skipped because of an unmet condition check (ConditionPathIsReadWrite=!/). Aug 5 22:15:04.902159 systemd[1]: Reached target local-fs.target - Local File Systems. Aug 5 22:15:04.904110 systemd[1]: Listening on systemd-sysext.socket - System Extension Image Management (Varlink). Aug 5 22:15:04.906421 systemd[1]: Starting dracut-shutdown.service - Restore /run/initramfs on shutdown... Aug 5 22:15:04.908418 systemd[1]: Starting ldconfig.service - Rebuild Dynamic Linker Cache... Aug 5 22:15:04.909260 systemd[1]: rpc-svcgssd.service - RPC security service for NFS server was skipped because of an unmet condition check (ConditionPathExists=/etc/krb5.keytab). Aug 5 22:15:04.909421 systemd[1]: systemd-binfmt.service - Set Up Additional Binary Formats was skipped because no trigger condition checks were met. Aug 5 22:15:04.910849 systemd[1]: Starting systemd-hwdb-update.service - Rebuild Hardware Database... Aug 5 22:15:04.915048 systemd[1]: Starting systemd-journal-flush.service - Flush Journal to Persistent Storage... Aug 5 22:15:04.916056 systemd[1]: systemd-pstore.service - Platform Persistent Storage Archival was skipped because of an unmet condition check (ConditionDirectoryNotEmpty=/sys/fs/pstore). Aug 5 22:15:04.920906 systemd[1]: Starting systemd-random-seed.service - Load/Save OS Random Seed... Aug 5 22:15:04.922144 systemd[1]: systemd-repart.service - Repartition Root Disk was skipped because no trigger condition checks were met. Aug 5 22:15:04.923130 systemd-journald[1123]: Time spent on flushing to /var/log/journal/b3a66ac8397e47cd9ac903b453653775 is 24.503ms for 846 entries. Aug 5 22:15:04.923130 systemd-journald[1123]: System Journal (/var/log/journal/b3a66ac8397e47cd9ac903b453653775) is 8.0M, max 195.6M, 187.6M free. Aug 5 22:15:04.976140 systemd-journald[1123]: Received client request to flush runtime journal. Aug 5 22:15:04.976684 kernel: loop0: detected capacity change from 0 to 113672 Aug 5 22:15:04.976716 kernel: block loop0: the capability attribute has been deprecated. Aug 5 22:15:04.976820 kernel: squashfs: version 4.0 (2009/01/31) Phillip Lougher Aug 5 22:15:04.923495 systemd[1]: Starting systemd-sysctl.service - Apply Kernel Variables... Aug 5 22:15:04.926142 systemd[1]: Starting systemd-sysext.service - Merge System Extension Images into /usr/ and /opt/... Aug 5 22:15:04.931019 systemd[1]: Starting systemd-tmpfiles-setup-dev-early.service - Create Static Device Nodes in /dev gracefully... Aug 5 22:15:04.935555 systemd[1]: Finished systemd-udev-trigger.service - Coldplug All udev Devices. Aug 5 22:15:04.940357 systemd[1]: Mounted sys-fs-fuse-connections.mount - FUSE Control File System. Aug 5 22:15:04.942179 systemd[1]: Mounted sys-kernel-config.mount - Kernel Configuration File System. Aug 5 22:15:04.946499 systemd[1]: Finished dracut-shutdown.service - Restore /run/initramfs on shutdown. Aug 5 22:15:04.948220 systemd[1]: Finished systemd-random-seed.service - Load/Save OS Random Seed. Aug 5 22:15:04.952548 systemd[1]: Reached target first-boot-complete.target - First Boot Complete. Aug 5 22:15:04.966209 systemd[1]: Starting systemd-machine-id-commit.service - Commit a transient machine-id on disk... Aug 5 22:15:04.968621 systemd[1]: Starting systemd-udev-settle.service - Wait for udev To Complete Device Initialization... Aug 5 22:15:04.977863 systemd[1]: Finished systemd-sysctl.service - Apply Kernel Variables. Aug 5 22:15:04.978186 systemd-tmpfiles[1165]: ACLs are not supported, ignoring. Aug 5 22:15:04.978196 systemd-tmpfiles[1165]: ACLs are not supported, ignoring. Aug 5 22:15:04.981701 systemd[1]: Finished systemd-journal-flush.service - Flush Journal to Persistent Storage. Aug 5 22:15:04.984467 systemd[1]: Finished systemd-tmpfiles-setup-dev-early.service - Create Static Device Nodes in /dev gracefully. Aug 5 22:15:04.987371 kernel: loop1: detected capacity change from 0 to 59688 Aug 5 22:15:04.996054 systemd[1]: Starting systemd-sysusers.service - Create System Users... Aug 5 22:15:04.998130 systemd[1]: etc-machine\x2did.mount: Deactivated successfully. Aug 5 22:15:04.998887 systemd[1]: Finished systemd-machine-id-commit.service - Commit a transient machine-id on disk. Aug 5 22:15:05.006210 udevadm[1177]: systemd-udev-settle.service is deprecated. Please fix lvm2-activation-early.service, lvm2-activation.service not to pull it in. Aug 5 22:15:05.021240 systemd[1]: Finished systemd-sysusers.service - Create System Users. Aug 5 22:15:05.022857 kernel: loop2: detected capacity change from 0 to 113672 Aug 5 22:15:05.027993 systemd[1]: Starting systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev... Aug 5 22:15:05.034095 kernel: loop3: detected capacity change from 0 to 59688 Aug 5 22:15:05.039320 systemd-tmpfiles[1188]: ACLs are not supported, ignoring. Aug 5 22:15:05.039336 systemd-tmpfiles[1188]: ACLs are not supported, ignoring. Aug 5 22:15:05.040101 (sd-merge)[1186]: Using extensions 'containerd-flatcar', 'docker-flatcar'. Aug 5 22:15:05.040433 (sd-merge)[1186]: Merged extensions into '/usr'. Aug 5 22:15:05.043766 systemd[1]: Finished systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev. Aug 5 22:15:05.045331 systemd[1]: Finished systemd-sysext.service - Merge System Extension Images into /usr/ and /opt/. Aug 5 22:15:05.052034 systemd[1]: Starting ensure-sysext.service... Aug 5 22:15:05.053680 systemd[1]: Starting systemd-tmpfiles-setup.service - Create Volatile Files and Directories... Aug 5 22:15:05.068797 systemd[1]: Reloading requested from client PID 1193 ('systemctl') (unit ensure-sysext.service)... Aug 5 22:15:05.068817 systemd[1]: Reloading... Aug 5 22:15:05.072964 systemd-tmpfiles[1195]: /usr/lib/tmpfiles.d/provision.conf:20: Duplicate line for path "/root", ignoring. Aug 5 22:15:05.073216 systemd-tmpfiles[1195]: /usr/lib/tmpfiles.d/systemd-flatcar.conf:6: Duplicate line for path "/var/log/journal", ignoring. Aug 5 22:15:05.073862 systemd-tmpfiles[1195]: /usr/lib/tmpfiles.d/systemd.conf:29: Duplicate line for path "/var/lib/systemd", ignoring. Aug 5 22:15:05.074080 systemd-tmpfiles[1195]: ACLs are not supported, ignoring. Aug 5 22:15:05.074130 systemd-tmpfiles[1195]: ACLs are not supported, ignoring. Aug 5 22:15:05.076301 systemd-tmpfiles[1195]: Detected autofs mount point /boot during canonicalization of boot. Aug 5 22:15:05.076314 systemd-tmpfiles[1195]: Skipping /boot Aug 5 22:15:05.083833 systemd-tmpfiles[1195]: Detected autofs mount point /boot during canonicalization of boot. Aug 5 22:15:05.083969 systemd-tmpfiles[1195]: Skipping /boot Aug 5 22:15:05.113888 zram_generator::config[1219]: No configuration found. Aug 5 22:15:05.129662 (sd-exec-[1204]: /usr/lib/systemd/system-generators/nfs-server-generator failed with exit status 1. Aug 5 22:15:05.204580 ldconfig[1159]: /sbin/ldconfig: /lib/ld.so.conf is not an ELF file - it has the wrong magic bytes at the start. Aug 5 22:15:05.208870 systemd[1]: /usr/lib/systemd/system/docker.socket:6: ListenStream= references a path below legacy directory /var/run/, updating /var/run/docker.sock → /run/docker.sock; please update the unit file accordingly. Aug 5 22:15:05.247226 systemd[1]: Reloading finished in 178 ms. Aug 5 22:15:05.272989 systemd[1]: Finished ldconfig.service - Rebuild Dynamic Linker Cache. Aug 5 22:15:05.274772 systemd[1]: Finished systemd-tmpfiles-setup.service - Create Volatile Files and Directories. Aug 5 22:15:05.281113 systemd[1]: Mounting var-lib-nfs-rpc_pipefs.mount - RPC Pipe File System... Aug 5 22:15:05.283399 systemd[1]: Starting audit-rules.service - Load Security Auditing Rules... Aug 5 22:15:05.286022 systemd[1]: Starting clean-ca-certificates.service - Clean up broken links in /etc/ssl/certs... Aug 5 22:15:05.290066 systemd[1]: Starting systemd-journal-catalog-update.service - Rebuild Journal Catalog... Aug 5 22:15:05.296035 systemd[1]: Starting systemd-resolved.service - Network Name Resolution... Aug 5 22:15:05.312034 systemd[1]: Starting systemd-update-utmp.service - Record System Boot/Shutdown in UTMP... Aug 5 22:15:05.314915 systemd[1]: Mounted var-lib-nfs-rpc_pipefs.mount - RPC Pipe File System. Aug 5 22:15:05.318903 systemd[1]: Finished systemd-journal-catalog-update.service - Rebuild Journal Catalog. Aug 5 22:15:05.325405 systemd[1]: Reached target rpc_pipefs.target. Aug 5 22:15:05.331092 systemd[1]: Starting nfs-idmapd.service - NFSv4 ID-name mapping service... Aug 5 22:15:05.333037 systemd[1]: Starting nfsdcld.service - NFSv4 Client Tracking Daemon... Aug 5 22:15:05.333875 systemd[1]: rpc-gssd.service - RPC security service for NFS client and server was skipped because of an unmet condition check (ConditionPathExists=/etc/krb5.keytab). Aug 5 22:15:05.335987 systemd[1]: Starting systemd-userdbd.service - User Database Manager... Aug 5 22:15:05.340125 systemd[1]: ignition-delete-config.service - Ignition (delete config) was skipped because no trigger condition checks were met. Aug 5 22:15:05.343131 systemd[1]: Starting modprobe@dm_mod.service - Load Kernel Module dm_mod... Aug 5 22:15:05.348208 systemd[1]: Starting modprobe@efi_pstore.service - Load Kernel Module efi_pstore... Aug 5 22:15:05.353291 systemd[1]: Starting modprobe@loop.service - Load Kernel Module loop... Aug 5 22:15:05.354144 systemd[1]: systemd-binfmt.service - Set Up Additional Binary Formats was skipped because no trigger condition checks were met. Aug 5 22:15:05.355988 systemd[1]: Finished clean-ca-certificates.service - Clean up broken links in /etc/ssl/certs. Aug 5 22:15:05.357568 systemd[1]: Finished systemd-update-utmp.service - Record System Boot/Shutdown in UTMP. Aug 5 22:15:05.360983 systemd[1]: modprobe@dm_mod.service: Deactivated successfully. Aug 5 22:15:05.361114 systemd[1]: Finished modprobe@dm_mod.service - Load Kernel Module dm_mod. Aug 5 22:15:05.362553 systemd[1]: modprobe@efi_pstore.service: Deactivated successfully. Aug 5 22:15:05.362657 systemd[1]: Finished modprobe@efi_pstore.service - Load Kernel Module efi_pstore. Aug 5 22:15:05.364372 systemd[1]: Started nfsdcld.service - NFSv4 Client Tracking Daemon. Aug 5 22:15:05.365824 systemd[1]: modprobe@loop.service: Deactivated successfully. Aug 5 22:15:05.365969 systemd[1]: Finished modprobe@loop.service - Load Kernel Module loop. Aug 5 22:15:05.373185 systemd[1]: ignition-delete-config.service - Ignition (delete config) was skipped because no trigger condition checks were met. Aug 5 22:15:05.373464 rpc.idmapd[1292]: Setting log level to 0 Aug 5 22:15:05.390228 systemd[1]: Starting modprobe@dm_mod.service - Load Kernel Module dm_mod... Aug 5 22:15:05.392203 systemd[1]: Starting modprobe@efi_pstore.service - Load Kernel Module efi_pstore... Aug 5 22:15:05.395422 systemd[1]: Starting modprobe@loop.service - Load Kernel Module loop... Aug 5 22:15:05.398900 systemd[1]: systemd-binfmt.service - Set Up Additional Binary Formats was skipped because no trigger condition checks were met. Aug 5 22:15:05.399055 systemd[1]: update-ca-certificates.service - Update CA bundle at /etc/ssl/certs/ca-certificates.crt was skipped because of an unmet condition check (ConditionPathIsSymbolicLink=!/etc/ssl/certs/ca-certificates.crt). Aug 5 22:15:05.399495 augenrules[1302]: No rules Aug 5 22:15:05.399590 systemd[1]: Started systemd-userdbd.service - User Database Manager. Aug 5 22:15:05.401114 systemd[1]: Started nfs-idmapd.service - NFSv4 ID-name mapping service. Aug 5 22:15:05.402585 systemd[1]: Finished audit-rules.service - Load Security Auditing Rules. Aug 5 22:15:05.403902 systemd[1]: modprobe@dm_mod.service: Deactivated successfully. Aug 5 22:15:05.404033 systemd[1]: Finished modprobe@dm_mod.service - Load Kernel Module dm_mod. Aug 5 22:15:05.405537 systemd[1]: modprobe@efi_pstore.service: Deactivated successfully. Aug 5 22:15:05.405666 systemd[1]: Finished modprobe@efi_pstore.service - Load Kernel Module efi_pstore. Aug 5 22:15:05.412012 systemd[1]: auth-rpcgss-module.service - Kernel Module supporting RPCSEC_GSS was skipped because of an unmet condition check (ConditionPathExists=/etc/krb5.keytab). Aug 5 22:15:05.412188 systemd[1]: ignition-delete-config.service - Ignition (delete config) was skipped because no trigger condition checks were met. Aug 5 22:15:05.413418 systemd[1]: Starting modprobe@dm_mod.service - Load Kernel Module dm_mod... Aug 5 22:15:05.416339 systemd[1]: Starting modprobe@drm.service - Load Kernel Module drm... Aug 5 22:15:05.420146 systemd[1]: Starting modprobe@efi_pstore.service - Load Kernel Module efi_pstore... Aug 5 22:15:05.421451 systemd[1]: rpc-gssd.service - RPC security service for NFS client and server was skipped because of an unmet condition check (ConditionPathExists=/etc/krb5.keytab). Aug 5 22:15:05.421555 systemd[1]: rpc-svcgssd.service - RPC security service for NFS server was skipped because of an unmet condition check (ConditionPathExists=/etc/krb5.keytab). Aug 5 22:15:05.421711 systemd[1]: systemd-binfmt.service - Set Up Additional Binary Formats was skipped because no trigger condition checks were met. Aug 5 22:15:05.421847 systemd[1]: update-ca-certificates.service - Update CA bundle at /etc/ssl/certs/ca-certificates.crt was skipped because of an unmet condition check (ConditionPathIsSymbolicLink=!/etc/ssl/certs/ca-certificates.crt). Aug 5 22:15:05.422689 systemd[1]: modprobe@loop.service: Deactivated successfully. Aug 5 22:15:05.424865 systemd[1]: Finished modprobe@loop.service - Load Kernel Module loop. Aug 5 22:15:05.426471 systemd[1]: Finished systemd-hwdb-update.service - Rebuild Hardware Database. Aug 5 22:15:05.428068 systemd[1]: modprobe@dm_mod.service: Deactivated successfully. Aug 5 22:15:05.428225 systemd[1]: Finished modprobe@dm_mod.service - Load Kernel Module dm_mod. Aug 5 22:15:05.429823 systemd[1]: modprobe@drm.service: Deactivated successfully. Aug 5 22:15:05.429974 systemd[1]: Finished modprobe@drm.service - Load Kernel Module drm. Aug 5 22:15:05.431522 systemd[1]: modprobe@efi_pstore.service: Deactivated successfully. Aug 5 22:15:05.431640 systemd[1]: Finished modprobe@efi_pstore.service - Load Kernel Module efi_pstore. Aug 5 22:15:05.434774 systemd[1]: Finished ensure-sysext.service. Aug 5 22:15:05.439725 systemd[1]: systemd-pstore.service - Platform Persistent Storage Archival was skipped because of an unmet condition check (ConditionDirectoryNotEmpty=/sys/fs/pstore). Aug 5 22:15:05.439794 systemd[1]: systemd-repart.service - Repartition Root Disk was skipped because no trigger condition checks were met. Aug 5 22:15:05.445993 systemd[1]: Starting systemd-timesyncd.service - Network Time Synchronization... Aug 5 22:15:05.448010 systemd[1]: Starting systemd-udevd.service - Rule-based Manager for Device Events and Files... Aug 5 22:15:05.450148 systemd[1]: Starting systemd-update-done.service - Update is Completed... Aug 5 22:15:05.453616 systemd-resolved[1264]: Positive Trust Anchors: Aug 5 22:15:05.453627 systemd-resolved[1264]: . IN DS 20326 8 2 e06d44b80b8f1d39a95c0b0d7c65d08458e880409bbc683457104237c7f8ec8d Aug 5 22:15:05.453658 systemd-resolved[1264]: Negative trust anchors: home.arpa 10.in-addr.arpa 16.172.in-addr.arpa 17.172.in-addr.arpa 18.172.in-addr.arpa 19.172.in-addr.arpa 20.172.in-addr.arpa 21.172.in-addr.arpa 22.172.in-addr.arpa 23.172.in-addr.arpa 24.172.in-addr.arpa 25.172.in-addr.arpa 26.172.in-addr.arpa 27.172.in-addr.arpa 28.172.in-addr.arpa 29.172.in-addr.arpa 30.172.in-addr.arpa 31.172.in-addr.arpa 170.0.0.192.in-addr.arpa 171.0.0.192.in-addr.arpa 168.192.in-addr.arpa d.f.ip6.arpa ipv4only.arpa corp home internal intranet lan local private test Aug 5 22:15:05.462282 systemd-resolved[1264]: Using system hostname 'nfs1'. Aug 5 22:15:05.466966 systemd[1]: Started systemd-resolved.service - Network Name Resolution. Aug 5 22:15:05.467863 systemd[1]: Reached target nss-lookup.target - Host and Network Name Lookups. Aug 5 22:15:05.472018 systemd-udevd[1322]: Using default interface naming scheme 'v255'. Aug 5 22:15:05.474453 systemd[1]: Finished systemd-update-done.service - Update is Completed. Aug 5 22:15:05.484976 systemd[1]: Started systemd-udevd.service - Rule-based Manager for Device Events and Files. Aug 5 22:15:05.496042 systemd[1]: Starting systemd-networkd.service - Network Configuration... Aug 5 22:15:05.502199 systemd[1]: Started systemd-timesyncd.service - Network Time Synchronization. Aug 5 22:15:05.505021 systemd[1]: Reached target time-set.target - System Time Set. Aug 5 22:15:05.513901 kernel: BTRFS info: devid 1 device path /dev/mapper/usr changed to /dev/dm-0 scanned by (udev-worker) (1326) Aug 5 22:15:05.520893 systemd[1]: Condition check resulted in dev-ttyAMA0.device - /dev/ttyAMA0 being skipped. Aug 5 22:15:05.542903 kernel: BTRFS warning: duplicate device /dev/vda3 devid 1 generation 41 scanned by (udev-worker) (1341) Aug 5 22:15:05.573027 systemd[1]: Found device dev-disk-by\x2dlabel-OEM.device - /dev/disk/by-label/OEM. Aug 5 22:15:05.575360 systemd-networkd[1333]: lo: Link UP Aug 5 22:15:05.575365 systemd-networkd[1333]: lo: Gained carrier Aug 5 22:15:05.576092 systemd-networkd[1333]: Enumeration completed Aug 5 22:15:05.578972 systemd-networkd[1333]: eth0: found matching network '/usr/lib/systemd/network/zz-default.network', based on potentially unpredictable interface name. Aug 5 22:15:05.578985 systemd-networkd[1333]: eth0: Configuring with /usr/lib/systemd/network/zz-default.network. Aug 5 22:15:05.582109 systemd[1]: Starting systemd-fsck@dev-disk-by\x2dlabel-OEM.service - File System Check on /dev/disk/by-label/OEM... Aug 5 22:15:05.585151 systemd[1]: Started systemd-networkd.service - Network Configuration. Aug 5 22:15:05.586626 systemd[1]: Reached target network.target - Network. Aug 5 22:15:05.588696 systemd[1]: Starting systemd-networkd-wait-online.service - Wait for Network to be Configured... Aug 5 22:15:05.591480 systemd-networkd[1333]: eth0: Link UP Aug 5 22:15:05.591548 systemd-networkd[1333]: eth0: Gained carrier Aug 5 22:15:05.591612 systemd-networkd[1333]: eth0: found matching network '/usr/lib/systemd/network/zz-default.network', based on potentially unpredictable interface name. Aug 5 22:15:05.593721 systemd[1]: Starting systemd-vconsole-setup.service - Virtual Console Setup... Aug 5 22:15:05.602716 systemd[1]: Finished systemd-udev-settle.service - Wait for udev To Complete Device Initialization. Aug 5 22:15:05.604219 systemd[1]: Finished systemd-fsck@dev-disk-by\x2dlabel-OEM.service - File System Check on /dev/disk/by-label/OEM. Aug 5 22:15:05.612908 systemd-networkd[1333]: eth0: DHCPv4 address 10.0.0.115/16, gateway 10.0.0.1 acquired from 10.0.0.1 Aug 5 22:15:05.613544 systemd-timesyncd[1321]: Network configuration changed, trying to establish connection. Aug 5 22:15:05.614163 systemd-timesyncd[1321]: Contacted time server 10.0.0.1:123 (10.0.0.1). Aug 5 22:15:05.614203 systemd-timesyncd[1321]: Initial clock synchronization to Mon 2024-08-05 22:15:05.739892 UTC. Aug 5 22:15:05.617007 systemd[1]: Starting lvm2-activation-early.service - Activation of LVM2 logical volumes... Aug 5 22:15:05.631315 lvm[1362]: WARNING: Failed to connect to lvmetad. Falling back to device scanning. Aug 5 22:15:05.638096 systemd[1]: Finished systemd-vconsole-setup.service - Virtual Console Setup. Aug 5 22:15:05.672648 systemd[1]: Finished lvm2-activation-early.service - Activation of LVM2 logical volumes. Aug 5 22:15:05.674468 systemd[1]: Reached target cryptsetup.target - Local Encrypted Volumes. Aug 5 22:15:05.675464 systemd[1]: Reached target sysinit.target - System Initialization. Aug 5 22:15:05.676532 systemd[1]: Started motdgen.path - Watch for update engine configuration changes. Aug 5 22:15:05.677750 systemd[1]: Started user-cloudinit@var-lib-flatcar\x2dinstall-user_data.path - Watch for a cloud-config at /var/lib/flatcar-install/user_data. Aug 5 22:15:05.679071 systemd[1]: Started logrotate.timer - Daily rotation of log files. Aug 5 22:15:05.680200 systemd[1]: Started mdadm.timer - Weekly check for MD array's redundancy information.. Aug 5 22:15:05.681340 systemd[1]: Started systemd-tmpfiles-clean.timer - Daily Cleanup of Temporary Directories. Aug 5 22:15:05.682437 systemd[1]: update-engine-stub.timer - Update Engine Stub Timer was skipped because of an unmet condition check (ConditionPathExists=/usr/.noupdate). Aug 5 22:15:05.682472 systemd[1]: Reached target paths.target - Path Units. Aug 5 22:15:05.683147 systemd[1]: Reached target timers.target - Timer Units. Aug 5 22:15:05.684728 systemd[1]: Listening on dbus.socket - D-Bus System Message Bus Socket. Aug 5 22:15:05.687049 systemd[1]: Starting docker.socket - Docker Socket for the API... Aug 5 22:15:05.694738 systemd[1]: Listening on sshd.socket - OpenSSH Server Socket. Aug 5 22:15:05.696689 systemd[1]: Starting lvm2-activation.service - Activation of LVM2 logical volumes... Aug 5 22:15:05.698092 systemd[1]: Listening on docker.socket - Docker Socket for the API. Aug 5 22:15:05.699256 systemd[1]: Reached target sockets.target - Socket Units. Aug 5 22:15:05.700187 systemd[1]: Reached target basic.target - Basic System. Aug 5 22:15:05.700920 systemd[1]: addon-config@oem.service - Configure Addon /oem was skipped because no trigger condition checks were met. Aug 5 22:15:05.700947 systemd[1]: addon-run@oem.service - Run Addon /oem was skipped because no trigger condition checks were met. Aug 5 22:15:05.701795 systemd[1]: Starting containerd.service - containerd container runtime... Aug 5 22:15:05.703573 systemd[1]: Starting dbus.service - D-Bus System Message Bus... Aug 5 22:15:05.705263 lvm[1370]: WARNING: Failed to connect to lvmetad. Falling back to device scanning. Aug 5 22:15:05.706571 systemd[1]: Starting enable-oem-cloudinit.service - Enable cloudinit... Aug 5 22:15:05.712068 systemd[1]: Starting extend-filesystems.service - Extend Filesystems... Aug 5 22:15:05.713238 systemd[1]: flatcar-setup-environment.service - Modifies /etc/environment for CoreOS was skipped because of an unmet condition check (ConditionPathExists=/oem/bin/flatcar-setup-environment). Aug 5 22:15:05.713511 jq[1373]: false Aug 5 22:15:05.717431 systemd[1]: Starting motdgen.service - Generate /run/flatcar/motd... Aug 5 22:15:05.721020 systemd[1]: Starting ssh-key-proc-cmdline.service - Install an ssh key from /proc/cmdline... Aug 5 22:15:05.725027 systemd[1]: Starting sshd-keygen.service - Generate sshd host keys... Aug 5 22:15:05.727809 extend-filesystems[1374]: Found loop2 Aug 5 22:15:05.730912 extend-filesystems[1374]: Found loop3 Aug 5 22:15:05.730912 extend-filesystems[1374]: Found vda Aug 5 22:15:05.730912 extend-filesystems[1374]: Found vda1 Aug 5 22:15:05.730912 extend-filesystems[1374]: Found vda2 Aug 5 22:15:05.730912 extend-filesystems[1374]: Found vda3 Aug 5 22:15:05.730912 extend-filesystems[1374]: Found usr Aug 5 22:15:05.730912 extend-filesystems[1374]: Found vda4 Aug 5 22:15:05.730912 extend-filesystems[1374]: Found vda6 Aug 5 22:15:05.730912 extend-filesystems[1374]: Found vda7 Aug 5 22:15:05.730912 extend-filesystems[1374]: Found vda9 Aug 5 22:15:05.730912 extend-filesystems[1374]: Checking size of /dev/vda9 Aug 5 22:15:05.728131 systemd[1]: Starting systemd-logind.service - User Login Management... Aug 5 22:15:05.735461 dbus-daemon[1372]: [system] SELinux support is enabled Aug 5 22:15:05.729864 systemd[1]: tcsd.service - TCG Core Services Daemon was skipped because of an unmet condition check (ConditionPathExists=/dev/tpm0). Aug 5 22:15:05.739035 dbus-daemon[1372]: [system] Activating systemd to hand-off: service name='org.freedesktop.hostname1' unit='dbus-org.freedesktop.hostname1.service' requested by ':1.2' (uid=244 pid=1333 comm="/usr/lib/systemd/systemd-networkd" label="system_u:system_r:kernel_t:s0") Aug 5 22:15:05.732072 systemd[1]: cgroup compatibility translation between legacy and unified hierarchy settings activated. See cgroup-compat debug messages for details. Aug 5 22:15:05.733018 systemd[1]: Starting update-engine.service - Update Engine... Aug 5 22:15:05.760177 jq[1388]: true Aug 5 22:15:05.735910 systemd[1]: Starting update-ssh-keys-after-ignition.service - Run update-ssh-keys once after Ignition... Aug 5 22:15:05.737382 systemd[1]: Started dbus.service - D-Bus System Message Bus. Aug 5 22:15:05.743117 systemd[1]: Finished lvm2-activation.service - Activation of LVM2 logical volumes. Aug 5 22:15:05.755369 systemd[1]: enable-oem-cloudinit.service: Skipped due to 'exec-condition'. Aug 5 22:15:05.755533 systemd[1]: Condition check resulted in enable-oem-cloudinit.service - Enable cloudinit being skipped. Aug 5 22:15:05.755815 systemd[1]: motdgen.service: Deactivated successfully. Aug 5 22:15:05.755982 systemd[1]: Finished motdgen.service - Generate /run/flatcar/motd. Aug 5 22:15:05.757548 systemd[1]: ssh-key-proc-cmdline.service: Deactivated successfully. Aug 5 22:15:05.757690 systemd[1]: Finished ssh-key-proc-cmdline.service - Install an ssh key from /proc/cmdline. Aug 5 22:15:05.773108 extend-filesystems[1374]: Old size kept for /dev/vda9 Aug 5 22:15:05.773614 systemd[1]: extend-filesystems.service: Deactivated successfully. Aug 5 22:15:05.773785 systemd[1]: Finished extend-filesystems.service - Extend Filesystems. Aug 5 22:15:05.776335 dbus-daemon[1372]: [system] Successfully activated service 'org.freedesktop.systemd1' Aug 5 22:15:05.779578 jq[1394]: true Aug 5 22:15:05.782526 kernel: BTRFS warning: duplicate device /dev/vda3 devid 1 generation 41 scanned by (udev-worker) (1334) Aug 5 22:15:05.787216 (ntainerd)[1396]: containerd.service: Referenced but unset environment variable evaluates to an empty string: TORCX_IMAGEDIR, TORCX_UNPACKDIR Aug 5 22:15:05.788788 systemd-logind[1384]: Watching system buttons on /dev/input/event0 (Power Button) Aug 5 22:15:05.789168 systemd-logind[1384]: New seat seat0. Aug 5 22:15:05.789629 update_engine[1386]: I0805 22:15:05.789451 1386 main.cc:92] Flatcar Update Engine starting Aug 5 22:15:05.791729 systemd[1]: Started systemd-logind.service - User Login Management. Aug 5 22:15:05.796770 systemd[1]: system-cloudinit@usr-share-oem-cloud\x2dconfig.yml.service - Load cloud-config from /usr/share/oem/cloud-config.yml was skipped because of an unmet condition check (ConditionFileNotEmpty=/usr/share/oem/cloud-config.yml). Aug 5 22:15:05.796921 systemd[1]: Reached target system-config.target - Load system-provided cloud configs. Aug 5 22:15:05.798360 update_engine[1386]: I0805 22:15:05.797116 1386 update_check_scheduler.cc:74] Next update check in 5m14s Aug 5 22:15:05.800090 systemd[1]: Starting systemd-hostnamed.service - Hostname Service... Aug 5 22:15:05.801021 systemd[1]: user-cloudinit-proc-cmdline.service - Load cloud-config from url defined in /proc/cmdline was skipped because of an unmet condition check (ConditionKernelCommandLine=cloud-config-url). Aug 5 22:15:05.801149 systemd[1]: Reached target user-config.target - Load user-provided cloud configs. Aug 5 22:15:05.804130 systemd[1]: Started update-engine.service - Update Engine. Aug 5 22:15:05.815079 systemd[1]: Started locksmithd.service - Cluster reboot manager. Aug 5 22:15:05.868890 bash[1423]: Updated "/home/core/.ssh/authorized_keys" Aug 5 22:15:05.868150 locksmithd[1413]: locksmithd starting currentOperation="UPDATE_STATUS_IDLE" strategy="reboot" Aug 5 22:15:05.871515 systemd[1]: Finished update-ssh-keys-after-ignition.service - Run update-ssh-keys once after Ignition. Aug 5 22:15:05.874179 dbus-daemon[1372]: [system] Successfully activated service 'org.freedesktop.hostname1' Aug 5 22:15:05.874431 systemd[1]: sshkeys.service was skipped because no trigger condition checks were met. Aug 5 22:15:05.874924 systemd[1]: Started systemd-hostnamed.service - Hostname Service. Aug 5 22:15:05.875910 dbus-daemon[1372]: [system] Activating via systemd: service name='org.freedesktop.PolicyKit1' unit='polkit.service' requested by ':1.8' (uid=0 pid=1409 comm="/usr/lib/systemd/systemd-hostnamed" label="system_u:system_r:kernel_t:s0") Aug 5 22:15:05.883054 systemd[1]: Starting polkit.service - Authorization Manager... Aug 5 22:15:05.893404 polkitd[1436]: Started polkitd version 121 Aug 5 22:15:05.898393 polkitd[1436]: Loading rules from directory /etc/polkit-1/rules.d Aug 5 22:15:05.898456 polkitd[1436]: Loading rules from directory /usr/share/polkit-1/rules.d Aug 5 22:15:05.898967 polkitd[1436]: Finished loading, compiling and executing 2 rules Aug 5 22:15:05.899454 dbus-daemon[1372]: [system] Successfully activated service 'org.freedesktop.PolicyKit1' Aug 5 22:15:05.899673 polkitd[1436]: Acquired the name org.freedesktop.PolicyKit1 on the system bus Aug 5 22:15:05.899685 systemd[1]: Started polkit.service - Authorization Manager. Aug 5 22:15:05.907891 systemd-hostnamed[1409]: Hostname set to (static) Aug 5 22:15:05.999904 containerd[1396]: time="2024-08-05T22:15:05.999078080Z" level=info msg="starting containerd" revision=1fbfc07f8d28210e62bdbcbf7b950bac8028afbf version=v1.7.17 Aug 5 22:15:06.024038 containerd[1396]: time="2024-08-05T22:15:06.023786244Z" level=info msg="loading plugin \"io.containerd.warning.v1.deprecations\"..." type=io.containerd.warning.v1 Aug 5 22:15:06.024038 containerd[1396]: time="2024-08-05T22:15:06.023831316Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.aufs\"..." type=io.containerd.snapshotter.v1 Aug 5 22:15:06.025938 containerd[1396]: time="2024-08-05T22:15:06.025225311Z" level=info msg="skip loading plugin \"io.containerd.snapshotter.v1.aufs\"..." error="aufs is not supported (modprobe aufs failed: exit status 1 \"modprobe: FATAL: Module aufs not found in directory /lib/modules/6.6.43-flatcar\\n\"): skip plugin" type=io.containerd.snapshotter.v1 Aug 5 22:15:06.025938 containerd[1396]: time="2024-08-05T22:15:06.025259054Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.btrfs\"..." type=io.containerd.snapshotter.v1 Aug 5 22:15:06.025938 containerd[1396]: time="2024-08-05T22:15:06.025457603Z" 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 Aug 5 22:15:06.025938 containerd[1396]: time="2024-08-05T22:15:06.025478325Z" level=info msg="loading plugin \"io.containerd.content.v1.content\"..." type=io.containerd.content.v1 Aug 5 22:15:06.025938 containerd[1396]: time="2024-08-05T22:15:06.025549278Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.blockfile\"..." type=io.containerd.snapshotter.v1 Aug 5 22:15:06.025938 containerd[1396]: time="2024-08-05T22:15:06.025592415Z" level=info msg="skip loading plugin \"io.containerd.snapshotter.v1.blockfile\"..." error="no scratch file generator: skip plugin" type=io.containerd.snapshotter.v1 Aug 5 22:15:06.025938 containerd[1396]: time="2024-08-05T22:15:06.025603703Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.native\"..." type=io.containerd.snapshotter.v1 Aug 5 22:15:06.025938 containerd[1396]: time="2024-08-05T22:15:06.025662844Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.overlayfs\"..." type=io.containerd.snapshotter.v1 Aug 5 22:15:06.025938 containerd[1396]: time="2024-08-05T22:15:06.025871028Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.devmapper\"..." type=io.containerd.snapshotter.v1 Aug 5 22:15:06.025938 containerd[1396]: time="2024-08-05T22:15:06.025889976Z" level=warning msg="failed to load plugin io.containerd.snapshotter.v1.devmapper" error="devmapper not configured" Aug 5 22:15:06.025938 containerd[1396]: time="2024-08-05T22:15:06.025900498Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.zfs\"..." type=io.containerd.snapshotter.v1 Aug 5 22:15:06.026321 containerd[1396]: time="2024-08-05T22:15:06.026296064Z" 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 Aug 5 22:15:06.026391 containerd[1396]: time="2024-08-05T22:15:06.026376693Z" level=info msg="loading plugin \"io.containerd.metadata.v1.bolt\"..." type=io.containerd.metadata.v1 Aug 5 22:15:06.026503 containerd[1396]: time="2024-08-05T22:15:06.026484534Z" level=warning msg="could not use snapshotter devmapper in metadata plugin" error="devmapper not configured" Aug 5 22:15:06.026564 containerd[1396]: time="2024-08-05T22:15:06.026549038Z" level=info msg="metadata content store policy set" policy=shared Aug 5 22:15:06.030004 containerd[1396]: time="2024-08-05T22:15:06.029971215Z" level=info msg="loading plugin \"io.containerd.differ.v1.walking\"..." type=io.containerd.differ.v1 Aug 5 22:15:06.030100 containerd[1396]: time="2024-08-05T22:15:06.030084983Z" level=info msg="loading plugin \"io.containerd.event.v1.exchange\"..." type=io.containerd.event.v1 Aug 5 22:15:06.030153 containerd[1396]: time="2024-08-05T22:15:06.030140738Z" level=info msg="loading plugin \"io.containerd.gc.v1.scheduler\"..." type=io.containerd.gc.v1 Aug 5 22:15:06.030253 containerd[1396]: time="2024-08-05T22:15:06.030237372Z" level=info msg="loading plugin \"io.containerd.lease.v1.manager\"..." type=io.containerd.lease.v1 Aug 5 22:15:06.030387 containerd[1396]: time="2024-08-05T22:15:06.030370813Z" level=info msg="loading plugin \"io.containerd.nri.v1.nri\"..." type=io.containerd.nri.v1 Aug 5 22:15:06.030452 containerd[1396]: time="2024-08-05T22:15:06.030439751Z" level=info msg="NRI interface is disabled by configuration." Aug 5 22:15:06.030503 containerd[1396]: time="2024-08-05T22:15:06.030491152Z" level=info msg="loading plugin \"io.containerd.runtime.v2.task\"..." type=io.containerd.runtime.v2 Aug 5 22:15:06.030670 containerd[1396]: time="2024-08-05T22:15:06.030649588Z" level=info msg="loading plugin \"io.containerd.runtime.v2.shim\"..." type=io.containerd.runtime.v2 Aug 5 22:15:06.030739 containerd[1396]: time="2024-08-05T22:15:06.030724895Z" level=info msg="loading plugin \"io.containerd.sandbox.store.v1.local\"..." type=io.containerd.sandbox.store.v1 Aug 5 22:15:06.030807 containerd[1396]: time="2024-08-05T22:15:06.030790205Z" level=info msg="loading plugin \"io.containerd.sandbox.controller.v1.local\"..." type=io.containerd.sandbox.controller.v1 Aug 5 22:15:06.030885 containerd[1396]: time="2024-08-05T22:15:06.030869826Z" level=info msg="loading plugin \"io.containerd.streaming.v1.manager\"..." type=io.containerd.streaming.v1 Aug 5 22:15:06.030950 containerd[1396]: time="2024-08-05T22:15:06.030934531Z" level=info msg="loading plugin \"io.containerd.service.v1.introspection-service\"..." type=io.containerd.service.v1 Aug 5 22:15:06.031022 containerd[1396]: time="2024-08-05T22:15:06.031007782Z" level=info msg="loading plugin \"io.containerd.service.v1.containers-service\"..." type=io.containerd.service.v1 Aug 5 22:15:06.031078 containerd[1396]: time="2024-08-05T22:15:06.031065432Z" level=info msg="loading plugin \"io.containerd.service.v1.content-service\"..." type=io.containerd.service.v1 Aug 5 22:15:06.031129 containerd[1396]: time="2024-08-05T22:15:06.031117236Z" level=info msg="loading plugin \"io.containerd.service.v1.diff-service\"..." type=io.containerd.service.v1 Aug 5 22:15:06.031200 containerd[1396]: time="2024-08-05T22:15:06.031185448Z" level=info msg="loading plugin \"io.containerd.service.v1.images-service\"..." type=io.containerd.service.v1 Aug 5 22:15:06.031257 containerd[1396]: time="2024-08-05T22:15:06.031244751Z" level=info msg="loading plugin \"io.containerd.service.v1.namespaces-service\"..." type=io.containerd.service.v1 Aug 5 22:15:06.031309 containerd[1396]: time="2024-08-05T22:15:06.031297281Z" level=info msg="loading plugin \"io.containerd.service.v1.snapshots-service\"..." type=io.containerd.service.v1 Aug 5 22:15:06.031360 containerd[1396]: time="2024-08-05T22:15:06.031347633Z" level=info msg="loading plugin \"io.containerd.runtime.v1.linux\"..." type=io.containerd.runtime.v1 Aug 5 22:15:06.031546 containerd[1396]: time="2024-08-05T22:15:06.031523566Z" level=info msg="loading plugin \"io.containerd.monitor.v1.cgroups\"..." type=io.containerd.monitor.v1 Aug 5 22:15:06.031872 containerd[1396]: time="2024-08-05T22:15:06.031848582Z" level=info msg="loading plugin \"io.containerd.service.v1.tasks-service\"..." type=io.containerd.service.v1 Aug 5 22:15:06.031957 containerd[1396]: time="2024-08-05T22:15:06.031942756Z" level=info msg="loading plugin \"io.containerd.grpc.v1.introspection\"..." type=io.containerd.grpc.v1 Aug 5 22:15:06.032046 containerd[1396]: time="2024-08-05T22:15:06.032030803Z" level=info msg="loading plugin \"io.containerd.transfer.v1.local\"..." type=io.containerd.transfer.v1 Aug 5 22:15:06.032327 containerd[1396]: time="2024-08-05T22:15:06.032106917Z" level=info msg="loading plugin \"io.containerd.internal.v1.restart\"..." type=io.containerd.internal.v1 Aug 5 22:15:06.032882 containerd[1396]: time="2024-08-05T22:15:06.032826773Z" level=info msg="loading plugin \"io.containerd.grpc.v1.containers\"..." type=io.containerd.grpc.v1 Aug 5 22:15:06.032991 containerd[1396]: time="2024-08-05T22:15:06.032975856Z" level=info msg="loading plugin \"io.containerd.grpc.v1.content\"..." type=io.containerd.grpc.v1 Aug 5 22:15:06.033057 containerd[1396]: time="2024-08-05T22:15:06.033043826Z" level=info msg="loading plugin \"io.containerd.grpc.v1.diff\"..." type=io.containerd.grpc.v1 Aug 5 22:15:06.033109 containerd[1396]: time="2024-08-05T22:15:06.033097485Z" level=info msg="loading plugin \"io.containerd.grpc.v1.events\"..." type=io.containerd.grpc.v1 Aug 5 22:15:06.033161 containerd[1396]: time="2024-08-05T22:15:06.033149128Z" level=info msg="loading plugin \"io.containerd.grpc.v1.healthcheck\"..." type=io.containerd.grpc.v1 Aug 5 22:15:06.033234 containerd[1396]: time="2024-08-05T22:15:06.033220484Z" level=info msg="loading plugin \"io.containerd.grpc.v1.images\"..." type=io.containerd.grpc.v1 Aug 5 22:15:06.033287 containerd[1396]: time="2024-08-05T22:15:06.033274707Z" level=info msg="loading plugin \"io.containerd.grpc.v1.leases\"..." type=io.containerd.grpc.v1 Aug 5 22:15:06.033894 containerd[1396]: time="2024-08-05T22:15:06.033325302Z" level=info msg="loading plugin \"io.containerd.grpc.v1.namespaces\"..." type=io.containerd.grpc.v1 Aug 5 22:15:06.033894 containerd[1396]: time="2024-08-05T22:15:06.033347677Z" level=info msg="loading plugin \"io.containerd.internal.v1.opt\"..." type=io.containerd.internal.v1 Aug 5 22:15:06.033894 containerd[1396]: time="2024-08-05T22:15:06.033488173Z" level=info msg="loading plugin \"io.containerd.grpc.v1.sandbox-controllers\"..." type=io.containerd.grpc.v1 Aug 5 22:15:06.033894 containerd[1396]: time="2024-08-05T22:15:06.033509177Z" level=info msg="loading plugin \"io.containerd.grpc.v1.sandboxes\"..." type=io.containerd.grpc.v1 Aug 5 22:15:06.033894 containerd[1396]: time="2024-08-05T22:15:06.033521634Z" level=info msg="loading plugin \"io.containerd.grpc.v1.snapshots\"..." type=io.containerd.grpc.v1 Aug 5 22:15:06.033894 containerd[1396]: time="2024-08-05T22:15:06.033534938Z" level=info msg="loading plugin \"io.containerd.grpc.v1.streaming\"..." type=io.containerd.grpc.v1 Aug 5 22:15:06.033894 containerd[1396]: time="2024-08-05T22:15:06.033547072Z" level=info msg="loading plugin \"io.containerd.grpc.v1.tasks\"..." type=io.containerd.grpc.v1 Aug 5 22:15:06.033894 containerd[1396]: time="2024-08-05T22:15:06.033561464Z" level=info msg="loading plugin \"io.containerd.grpc.v1.transfer\"..." type=io.containerd.grpc.v1 Aug 5 22:15:06.033894 containerd[1396]: time="2024-08-05T22:15:06.033572954Z" level=info msg="loading plugin \"io.containerd.grpc.v1.version\"..." type=io.containerd.grpc.v1 Aug 5 22:15:06.033894 containerd[1396]: time="2024-08-05T22:15:06.033584363Z" level=info msg="loading plugin \"io.containerd.grpc.v1.cri\"..." type=io.containerd.grpc.v1 Aug 5 22:15:06.034234 containerd[1396]: time="2024-08-05T22:15:06.034166827Z" level=info msg="Start cri plugin with config {PluginConfig:{ContainerdConfig:{Snapshotter:overlayfs DefaultRuntimeName:runc DefaultRuntime:{Type: Path: Engine: PodAnnotations:[] ContainerAnnotations:[] Root: Options:map[] PrivilegedWithoutHostDevices:false PrivilegedWithoutHostDevicesAllDevicesAllowed:false BaseRuntimeSpec: NetworkPluginConfDir: NetworkPluginMaxConfNum:0 Snapshotter: SandboxMode:} UntrustedWorkloadRuntime:{Type: Path: Engine: PodAnnotations:[] ContainerAnnotations:[] Root: Options:map[] PrivilegedWithoutHostDevices:false PrivilegedWithoutHostDevicesAllDevicesAllowed:false BaseRuntimeSpec: NetworkPluginConfDir: NetworkPluginMaxConfNum:0 Snapshotter: SandboxMode:} Runtimes:map[runc:{Type:io.containerd.runc.v2 Path: Engine: PodAnnotations:[] ContainerAnnotations:[] Root: Options:map[SystemdCgroup:true] PrivilegedWithoutHostDevices:false PrivilegedWithoutHostDevicesAllDevicesAllowed:false BaseRuntimeSpec: NetworkPluginConfDir: NetworkPluginMaxConfNum:0 Snapshotter: SandboxMode:podsandbox}] NoPivot:false DisableSnapshotAnnotations:true DiscardUnpackedLayers:false IgnoreBlockIONotEnabledErrors:false IgnoreRdtNotEnabledErrors:false} CniConfig:{NetworkPluginBinDir:/opt/cni/bin NetworkPluginConfDir:/etc/cni/net.d NetworkPluginMaxConfNum:1 NetworkPluginSetupSerially:false NetworkPluginConfTemplate: IPPreference:} Registry:{ConfigPath: Mirrors:map[] Configs:map[] Auths:map[] Headers:map[]} ImageDecryption:{KeyModel:node} DisableTCPService:true StreamServerAddress:127.0.0.1 StreamServerPort:0 StreamIdleTimeout:4h0m0s EnableSelinux:true SelinuxCategoryRange:1024 SandboxImage:registry.k8s.io/pause:3.8 StatsCollectPeriod:10 SystemdCgroup:false EnableTLSStreaming:false X509KeyPairStreaming:{TLSCertFile: TLSKeyFile:} MaxContainerLogLineSize:16384 DisableCgroup:false DisableApparmor:false RestrictOOMScoreAdj:false MaxConcurrentDownloads:3 DisableProcMount:false UnsetSeccompProfile: TolerateMissingHugetlbController:true DisableHugetlbController:true DeviceOwnershipFromSecurityContext:false IgnoreImageDefinedVolumes:false NetNSMountsUnderStateDir:false EnableUnprivilegedPorts:false EnableUnprivilegedICMP:false EnableCDI:false CDISpecDirs:[/etc/cdi /var/run/cdi] ImagePullProgressTimeout:5m0s DrainExecSyncIOTimeout:0s ImagePullWithSyncFs:false IgnoreDeprecationWarnings:[]} ContainerdRootDir:/var/lib/containerd ContainerdEndpoint:/run/containerd/containerd.sock RootDir:/var/lib/containerd/io.containerd.grpc.v1.cri StateDir:/run/containerd/io.containerd.grpc.v1.cri}" Aug 5 22:15:06.034399 containerd[1396]: time="2024-08-05T22:15:06.034381583Z" level=info msg="Connect containerd service" Aug 5 22:15:06.034476 containerd[1396]: time="2024-08-05T22:15:06.034462091Z" level=info msg="using legacy CRI server" Aug 5 22:15:06.034523 containerd[1396]: time="2024-08-05T22:15:06.034511476Z" level=info msg="using experimental NRI integration - disable nri plugin to prevent this" Aug 5 22:15:06.034718 containerd[1396]: time="2024-08-05T22:15:06.034699946Z" level=info msg="Get image filesystem path \"/var/lib/containerd/io.containerd.snapshotter.v1.overlayfs\"" Aug 5 22:15:06.035565 containerd[1396]: time="2024-08-05T22:15:06.035533046Z" 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" Aug 5 22:15:06.035680 containerd[1396]: time="2024-08-05T22:15:06.035663987Z" level=info msg="loading plugin \"io.containerd.tracing.processor.v1.otlp\"..." type=io.containerd.tracing.processor.v1 Aug 5 22:15:06.035947 containerd[1396]: time="2024-08-05T22:15:06.035928652Z" level=info msg="skip loading plugin \"io.containerd.tracing.processor.v1.otlp\"..." error="skip plugin: tracing endpoint not configured" type=io.containerd.tracing.processor.v1 Aug 5 22:15:06.036041 containerd[1396]: time="2024-08-05T22:15:06.036017384Z" level=info msg="loading plugin \"io.containerd.internal.v1.tracing\"..." type=io.containerd.internal.v1 Aug 5 22:15:06.036127 containerd[1396]: time="2024-08-05T22:15:06.035898940Z" level=info msg="Start subscribing containerd event" Aug 5 22:15:06.036175 containerd[1396]: time="2024-08-05T22:15:06.036141553Z" level=info msg="Start recovering state" Aug 5 22:15:06.036365 containerd[1396]: time="2024-08-05T22:15:06.036207104Z" level=info msg="Start event monitor" Aug 5 22:15:06.036365 containerd[1396]: time="2024-08-05T22:15:06.036221819Z" level=info msg="Start snapshots syncer" Aug 5 22:15:06.036365 containerd[1396]: time="2024-08-05T22:15:06.036231374Z" level=info msg="Start cni network conf syncer for default" Aug 5 22:15:06.036365 containerd[1396]: time="2024-08-05T22:15:06.036238025Z" level=info msg="Start streaming server" Aug 5 22:15:06.036497 containerd[1396]: time="2024-08-05T22:15:06.036099787Z" level=info msg="skip loading plugin \"io.containerd.internal.v1.tracing\"..." error="skip plugin: tracing endpoint not configured" type=io.containerd.internal.v1 Aug 5 22:15:06.036734 containerd[1396]: time="2024-08-05T22:15:06.036714382Z" level=info msg=serving... address=/run/containerd/containerd.sock.ttrpc Aug 5 22:15:06.037896 containerd[1396]: time="2024-08-05T22:15:06.036913777Z" level=info msg=serving... address=/run/containerd/containerd.sock Aug 5 22:15:06.037095 systemd[1]: Started containerd.service - containerd container runtime. Aug 5 22:15:06.038071 containerd[1396]: time="2024-08-05T22:15:06.038030167Z" level=info msg="containerd successfully booted in 0.039271s" Aug 5 22:15:06.956140 sshd_keygen[1392]: ssh-keygen: generating new host keys: RSA ECDSA ED25519 Aug 5 22:15:06.975243 systemd[1]: Finished sshd-keygen.service - Generate sshd host keys. Aug 5 22:15:06.996123 systemd[1]: Starting issuegen.service - Generate /run/issue... Aug 5 22:15:07.001585 systemd[1]: issuegen.service: Deactivated successfully. Aug 5 22:15:07.001828 systemd[1]: Finished issuegen.service - Generate /run/issue. Aug 5 22:15:07.006579 systemd[1]: Starting systemd-user-sessions.service - Permit User Sessions... Aug 5 22:15:07.021053 systemd[1]: Finished systemd-user-sessions.service - Permit User Sessions. Aug 5 22:15:07.025072 systemd[1]: Started getty@tty1.service - Getty on tty1. Aug 5 22:15:07.026946 systemd[1]: Started serial-getty@ttyAMA0.service - Serial Getty on ttyAMA0. Aug 5 22:15:07.028211 systemd[1]: Reached target getty.target - Login Prompts. Aug 5 22:15:07.604152 systemd-networkd[1333]: eth0: Gained IPv6LL Aug 5 22:15:07.606688 systemd[1]: Finished systemd-networkd-wait-online.service - Wait for Network to be Configured. Aug 5 22:15:07.608250 systemd[1]: Reached target network-online.target - Network is Online. Aug 5 22:15:07.617136 systemd[1]: Starting coreos-metadata.service - QEMU metadata agent... Aug 5 22:15:07.619282 systemd[1]: Starting nfs-mountd.service - NFS Mount Daemon... Aug 5 22:15:07.621064 systemd[1]: Starting nvidia.service - NVIDIA Configure Service... Aug 5 22:15:07.623070 systemd[1]: Starting rpc-statd.service - NFS status monitor for NFSv2/3 locking.... Aug 5 22:15:07.632465 rpc.statd[1475]: Version 2.5.4 starting Aug 5 22:15:07.632469 rpc.statd[1475]: Flags: TI-RPC Aug 5 22:15:07.633003 rpc.statd[1475]: Failed to read /var/lib/nfs/state: Success Aug 5 22:15:07.633006 rpc.statd[1475]: Initializing NSM state Aug 5 22:15:07.639919 systemd[1]: Started rpc-statd.service - NFS status monitor for NFSv2/3 locking.. Aug 5 22:15:07.643168 systemd[1]: coreos-metadata.service: Deactivated successfully. Aug 5 22:15:07.643359 systemd[1]: Finished coreos-metadata.service - QEMU metadata agent. Aug 5 22:15:07.644489 rpc.mountd[1483]: Version 2.5.4 starting Aug 5 22:15:07.645598 systemd[1]: Started nfs-mountd.service - NFS Mount Daemon. Aug 5 22:15:07.647484 systemd[1]: Finished nvidia.service - NVIDIA Configure Service. Aug 5 22:15:07.659142 systemd[1]: Starting nfs-server.service - NFS server and services... Aug 5 22:15:07.659937 systemd[1]: packet-phone-home.service - Report Success to Packet was skipped because no trigger condition checks were met. Aug 5 22:15:07.660079 systemd[1]: Reached target multi-user.target - Multi-User System. Aug 5 22:15:07.788079 kernel: NFSD: Using nfsdcld client tracking operations. Aug 5 22:15:07.788149 kernel: NFSD: no clients to reclaim, skipping NFSv4 grace period (net f0000000) Aug 5 22:15:07.792427 systemd[1]: Finished nfs-server.service - NFS server and services. Aug 5 22:15:07.812093 systemd[1]: Starting rpc-statd-notify.service - Notify NFS peers of a restart... Aug 5 22:15:07.815270 sm-notify[1500]: Version 2.5.4 starting Aug 5 22:15:07.816589 systemd[1]: Started rpc-statd-notify.service - Notify NFS peers of a restart. Aug 5 22:15:07.819922 systemd[1]: Startup finished in 520ms (kernel) + 3.551s (initrd) + 3.602s (userspace) = 7.675s. Aug 5 22:15:13.206454 systemd[1]: Created slice system-sshd.slice - Slice /system/sshd. Aug 5 22:15:13.207559 systemd[1]: Started sshd@0-10.0.0.115:22-10.0.0.1:52562.service - OpenSSH per-connection server daemon (10.0.0.1:52562). Aug 5 22:15:13.259902 sshd[1507]: Accepted publickey for core from 10.0.0.1 port 52562 ssh2: RSA SHA256:m+vSf9MZ8jyHy+Dz2uz+ngzM5NRoRVVH/LZDa5ltoPE Aug 5 22:15:13.261656 sshd[1507]: pam_unix(sshd:session): session opened for user core(uid=500) by (uid=0) Aug 5 22:15:13.278788 systemd[1]: Created slice user-500.slice - User Slice of UID 500. Aug 5 22:15:13.290148 systemd[1]: Starting user-runtime-dir@500.service - User Runtime Directory /run/user/500... Aug 5 22:15:13.292562 systemd-logind[1384]: New session 1 of user core. Aug 5 22:15:13.299136 systemd[1]: Finished user-runtime-dir@500.service - User Runtime Directory /run/user/500. Aug 5 22:15:13.301288 systemd[1]: Starting user@500.service - User Manager for UID 500... Aug 5 22:15:13.308717 (systemd)[1511]: pam_unix(systemd-user:session): session opened for user core(uid=500) by (uid=0) Aug 5 22:15:13.388327 systemd[1511]: Queued start job for default target default.target. Aug 5 22:15:13.397889 systemd[1511]: Created slice app.slice - User Application Slice. Aug 5 22:15:13.397928 systemd[1511]: Reached target paths.target - Paths. Aug 5 22:15:13.397941 systemd[1511]: Reached target timers.target - Timers. Aug 5 22:15:13.399188 systemd[1511]: Starting dbus.socket - D-Bus User Message Bus Socket... Aug 5 22:15:13.409226 systemd[1511]: Listening on dbus.socket - D-Bus User Message Bus Socket. Aug 5 22:15:13.409283 systemd[1511]: Reached target sockets.target - Sockets. Aug 5 22:15:13.409295 systemd[1511]: Reached target basic.target - Basic System. Aug 5 22:15:13.409327 systemd[1511]: Reached target default.target - Main User Target. Aug 5 22:15:13.409352 systemd[1511]: Startup finished in 95ms. Aug 5 22:15:13.409552 systemd[1]: Started user@500.service - User Manager for UID 500. Aug 5 22:15:13.411097 systemd[1]: Started session-1.scope - Session 1 of User core. Aug 5 22:15:13.470466 systemd[1]: Started sshd@1-10.0.0.115:22-10.0.0.1:52568.service - OpenSSH per-connection server daemon (10.0.0.1:52568). Aug 5 22:15:13.505188 sshd[1522]: Accepted publickey for core from 10.0.0.1 port 52568 ssh2: RSA SHA256:m+vSf9MZ8jyHy+Dz2uz+ngzM5NRoRVVH/LZDa5ltoPE Aug 5 22:15:13.506446 sshd[1522]: pam_unix(sshd:session): session opened for user core(uid=500) by (uid=0) Aug 5 22:15:13.510775 systemd-logind[1384]: New session 2 of user core. Aug 5 22:15:13.522051 systemd[1]: Started session-2.scope - Session 2 of User core. Aug 5 22:15:13.575143 sshd[1522]: pam_unix(sshd:session): session closed for user core Aug 5 22:15:13.587245 systemd[1]: sshd@1-10.0.0.115:22-10.0.0.1:52568.service: Deactivated successfully. Aug 5 22:15:13.588603 systemd[1]: session-2.scope: Deactivated successfully. Aug 5 22:15:13.590926 systemd-logind[1384]: Session 2 logged out. Waiting for processes to exit. Aug 5 22:15:13.592501 systemd[1]: Started sshd@2-10.0.0.115:22-10.0.0.1:52572.service - OpenSSH per-connection server daemon (10.0.0.1:52572). Aug 5 22:15:13.593311 systemd-logind[1384]: Removed session 2. Aug 5 22:15:13.626667 sshd[1529]: Accepted publickey for core from 10.0.0.1 port 52572 ssh2: RSA SHA256:m+vSf9MZ8jyHy+Dz2uz+ngzM5NRoRVVH/LZDa5ltoPE Aug 5 22:15:13.627968 sshd[1529]: pam_unix(sshd:session): session opened for user core(uid=500) by (uid=0) Aug 5 22:15:13.632707 systemd-logind[1384]: New session 3 of user core. Aug 5 22:15:13.647019 systemd[1]: Started session-3.scope - Session 3 of User core. Aug 5 22:15:13.696119 sshd[1529]: pam_unix(sshd:session): session closed for user core Aug 5 22:15:13.710272 systemd[1]: sshd@2-10.0.0.115:22-10.0.0.1:52572.service: Deactivated successfully. Aug 5 22:15:13.712701 systemd[1]: session-3.scope: Deactivated successfully. Aug 5 22:15:13.713965 systemd-logind[1384]: Session 3 logged out. Waiting for processes to exit. Aug 5 22:15:13.725144 systemd[1]: Started sshd@3-10.0.0.115:22-10.0.0.1:52580.service - OpenSSH per-connection server daemon (10.0.0.1:52580). Aug 5 22:15:13.726656 systemd-logind[1384]: Removed session 3. Aug 5 22:15:13.756959 sshd[1536]: Accepted publickey for core from 10.0.0.1 port 52580 ssh2: RSA SHA256:m+vSf9MZ8jyHy+Dz2uz+ngzM5NRoRVVH/LZDa5ltoPE Aug 5 22:15:13.757745 sshd[1536]: pam_unix(sshd:session): session opened for user core(uid=500) by (uid=0) Aug 5 22:15:13.764090 systemd-logind[1384]: New session 4 of user core. Aug 5 22:15:13.773526 systemd[1]: Started session-4.scope - Session 4 of User core. Aug 5 22:15:13.826712 sshd[1536]: pam_unix(sshd:session): session closed for user core Aug 5 22:15:13.839162 systemd[1]: sshd@3-10.0.0.115:22-10.0.0.1:52580.service: Deactivated successfully. Aug 5 22:15:13.840738 systemd[1]: session-4.scope: Deactivated successfully. Aug 5 22:15:13.843934 systemd-logind[1384]: Session 4 logged out. Waiting for processes to exit. Aug 5 22:15:13.850121 systemd[1]: Started sshd@4-10.0.0.115:22-10.0.0.1:52586.service - OpenSSH per-connection server daemon (10.0.0.1:52586). Aug 5 22:15:13.850997 systemd-logind[1384]: Removed session 4. Aug 5 22:15:13.880027 sshd[1543]: Accepted publickey for core from 10.0.0.1 port 52586 ssh2: RSA SHA256:m+vSf9MZ8jyHy+Dz2uz+ngzM5NRoRVVH/LZDa5ltoPE Aug 5 22:15:13.881651 sshd[1543]: pam_unix(sshd:session): session opened for user core(uid=500) by (uid=0) Aug 5 22:15:13.886004 systemd-logind[1384]: New session 5 of user core. Aug 5 22:15:13.902070 systemd[1]: Started session-5.scope - Session 5 of User core. Aug 5 22:15:13.969828 sudo[1546]: core : PWD=/home/core ; USER=root ; COMMAND=/usr/sbin/setenforce 1 Aug 5 22:15:13.970131 sudo[1546]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=500) Aug 5 22:15:13.987942 sudo[1546]: pam_unix(sudo:session): session closed for user root Aug 5 22:15:13.990093 sshd[1543]: pam_unix(sshd:session): session closed for user core Aug 5 22:15:14.000069 systemd[1]: sshd@4-10.0.0.115:22-10.0.0.1:52586.service: Deactivated successfully. Aug 5 22:15:14.001399 systemd[1]: session-5.scope: Deactivated successfully. Aug 5 22:15:14.003457 systemd-logind[1384]: Session 5 logged out. Waiting for processes to exit. Aug 5 22:15:14.004686 systemd[1]: Started sshd@5-10.0.0.115:22-10.0.0.1:52590.service - OpenSSH per-connection server daemon (10.0.0.1:52590). Aug 5 22:15:14.005453 systemd-logind[1384]: Removed session 5. Aug 5 22:15:14.039971 sshd[1551]: Accepted publickey for core from 10.0.0.1 port 52590 ssh2: RSA SHA256:m+vSf9MZ8jyHy+Dz2uz+ngzM5NRoRVVH/LZDa5ltoPE Aug 5 22:15:14.041251 sshd[1551]: pam_unix(sshd:session): session opened for user core(uid=500) by (uid=0) Aug 5 22:15:14.045422 systemd-logind[1384]: New session 6 of user core. Aug 5 22:15:14.053001 systemd[1]: Started session-6.scope - Session 6 of User core. Aug 5 22:15:14.104266 sudo[1555]: 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 Aug 5 22:15:14.104506 sudo[1555]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=500) Aug 5 22:15:14.107598 sudo[1555]: pam_unix(sudo:session): session closed for user root Aug 5 22:15:14.111801 sudo[1554]: core : PWD=/home/core ; USER=root ; COMMAND=/usr/bin/systemctl restart audit-rules Aug 5 22:15:14.112039 sudo[1554]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=500) Aug 5 22:15:14.126340 systemd[1]: Stopping audit-rules.service - Load Security Auditing Rules... Aug 5 22:15:14.127387 auditctl[1558]: No rules Aug 5 22:15:14.128185 systemd[1]: audit-rules.service: Deactivated successfully. Aug 5 22:15:14.128372 systemd[1]: Stopped audit-rules.service - Load Security Auditing Rules. Aug 5 22:15:14.130026 systemd[1]: Starting audit-rules.service - Load Security Auditing Rules... Aug 5 22:15:14.153172 augenrules[1576]: No rules Aug 5 22:15:14.153731 systemd[1]: Finished audit-rules.service - Load Security Auditing Rules. Aug 5 22:15:14.154798 sudo[1554]: pam_unix(sudo:session): session closed for user root Aug 5 22:15:14.156279 sshd[1551]: pam_unix(sshd:session): session closed for user core Aug 5 22:15:14.164017 systemd[1]: sshd@5-10.0.0.115:22-10.0.0.1:52590.service: Deactivated successfully. Aug 5 22:15:14.165297 systemd[1]: session-6.scope: Deactivated successfully. Aug 5 22:15:14.166471 systemd-logind[1384]: Session 6 logged out. Waiting for processes to exit. Aug 5 22:15:14.167565 systemd[1]: Started sshd@6-10.0.0.115:22-10.0.0.1:52600.service - OpenSSH per-connection server daemon (10.0.0.1:52600). Aug 5 22:15:14.168571 systemd-logind[1384]: Removed session 6. Aug 5 22:15:14.203422 sshd[1584]: Accepted publickey for core from 10.0.0.1 port 52600 ssh2: RSA SHA256:m+vSf9MZ8jyHy+Dz2uz+ngzM5NRoRVVH/LZDa5ltoPE Aug 5 22:15:14.204533 sshd[1584]: pam_unix(sshd:session): session opened for user core(uid=500) by (uid=0) Aug 5 22:15:14.207896 systemd-logind[1384]: New session 7 of user core. Aug 5 22:15:14.219976 systemd[1]: Started session-7.scope - Session 7 of User core. Aug 5 22:15:14.267799 sshd[1584]: pam_unix(sshd:session): session closed for user core Aug 5 22:15:14.272026 systemd[1]: sshd@6-10.0.0.115:22-10.0.0.1:52600.service: Deactivated successfully. Aug 5 22:15:14.274229 systemd[1]: session-7.scope: Deactivated successfully. Aug 5 22:15:14.275739 systemd-logind[1384]: Session 7 logged out. Waiting for processes to exit. Aug 5 22:15:14.277104 systemd-logind[1384]: Removed session 7. Aug 5 22:15:35.942175 systemd[1]: systemd-hostnamed.service: Deactivated successfully.