Aug 5 22:14:26.931879 kernel: Booting Linux on physical CPU 0x0000000000 [0x413fd0c1] Aug 5 22:14:26.931901 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:14:26.931912 kernel: KASLR enabled Aug 5 22:14:26.931918 kernel: efi: EFI v2.7 by EDK II Aug 5 22:14:26.931924 kernel: efi: SMBIOS 3.0=0xdced0000 TPMFinalLog=0xd9760000 MEMATTR=0xdb8c7698 ACPI 2.0=0xd9700018 TPMEventLog=0xd9673018 RNG=0xd970e698 MEMRESERVE=0xd9b43e18 Aug 5 22:14:26.931930 kernel: random: crng init done Aug 5 22:14:26.931937 kernel: ACPI: Early table checksum verification disabled Aug 5 22:14:26.931943 kernel: ACPI: RSDP 0x00000000D9700018 000024 (v02 BOCHS ) Aug 5 22:14:26.931950 kernel: ACPI: XSDT 0x00000000D970FE98 00006C (v01 BOCHS BXPC 00000001 01000013) Aug 5 22:14:26.931957 kernel: ACPI: FACP 0x00000000D970FA98 000114 (v06 BOCHS BXPC 00000001 BXPC 00000001) Aug 5 22:14:26.931963 kernel: ACPI: DSDT 0x00000000D9707518 0014EB (v02 BOCHS BXPC 00000001 BXPC 00000001) Aug 5 22:14:26.931970 kernel: ACPI: APIC 0x00000000D970FC18 0001A8 (v04 BOCHS BXPC 00000001 BXPC 00000001) Aug 5 22:14:26.931976 kernel: ACPI: PPTT 0x00000000D970D898 00009C (v02 BOCHS BXPC 00000001 BXPC 00000001) Aug 5 22:14:26.931982 kernel: ACPI: GTDT 0x00000000D970E818 000060 (v02 BOCHS BXPC 00000001 BXPC 00000001) Aug 5 22:14:26.931989 kernel: ACPI: MCFG 0x00000000D970E918 00003C (v01 BOCHS BXPC 00000001 BXPC 00000001) Aug 5 22:14:26.931997 kernel: ACPI: SPCR 0x00000000D970FF98 000050 (v02 BOCHS BXPC 00000001 BXPC 00000001) Aug 5 22:14:26.932004 kernel: ACPI: DBG2 0x00000000D970E418 000057 (v00 BOCHS BXPC 00000001 BXPC 00000001) Aug 5 22:14:26.932011 kernel: ACPI: IORT 0x00000000D970E718 000080 (v03 BOCHS BXPC 00000001 BXPC 00000001) Aug 5 22:14:26.932017 kernel: ACPI: TPM2 0x00000000D970E498 00004C (v04 BOCHS BXPC 00000001 BXPC 00000001) Aug 5 22:14:26.932024 kernel: ACPI: SPCR: console: pl011,mmio,0x9000000,9600 Aug 5 22:14:26.932031 kernel: NUMA: Failed to initialise from firmware Aug 5 22:14:26.932037 kernel: NUMA: Faking a node at [mem 0x0000000040000000-0x00000000dcffffff] Aug 5 22:14:26.932044 kernel: NUMA: NODE_DATA [mem 0xdc958800-0xdc95dfff] Aug 5 22:14:26.932050 kernel: Zone ranges: Aug 5 22:14:26.932057 kernel: DMA [mem 0x0000000040000000-0x00000000dcffffff] Aug 5 22:14:26.932065 kernel: DMA32 empty Aug 5 22:14:26.932072 kernel: Normal empty Aug 5 22:14:26.932078 kernel: Movable zone start for each node Aug 5 22:14:26.932085 kernel: Early memory node ranges Aug 5 22:14:26.932091 kernel: node 0: [mem 0x0000000040000000-0x00000000d964ffff] Aug 5 22:14:26.932100 kernel: node 0: [mem 0x00000000d9650000-0x00000000d965ffff] Aug 5 22:14:26.932110 kernel: node 0: [mem 0x00000000d9660000-0x00000000d975ffff] Aug 5 22:14:26.932118 kernel: node 0: [mem 0x00000000d9760000-0x00000000d9b3ffff] Aug 5 22:14:26.932125 kernel: node 0: [mem 0x00000000d9b40000-0x00000000dce1ffff] Aug 5 22:14:26.932131 kernel: node 0: [mem 0x00000000dce20000-0x00000000dceaffff] Aug 5 22:14:26.932138 kernel: node 0: [mem 0x00000000dceb0000-0x00000000dcebffff] Aug 5 22:14:26.932144 kernel: node 0: [mem 0x00000000dcec0000-0x00000000dcfdffff] Aug 5 22:14:26.932152 kernel: node 0: [mem 0x00000000dcfe0000-0x00000000dcffffff] Aug 5 22:14:26.932159 kernel: Initmem setup node 0 [mem 0x0000000040000000-0x00000000dcffffff] Aug 5 22:14:26.932165 kernel: On node 0, zone DMA: 12288 pages in unavailable ranges Aug 5 22:14:26.932175 kernel: psci: probing for conduit method from ACPI. Aug 5 22:14:26.932182 kernel: psci: PSCIv1.1 detected in firmware. Aug 5 22:14:26.932189 kernel: psci: Using standard PSCI v0.2 function IDs Aug 5 22:14:26.932198 kernel: psci: Trusted OS migration not required Aug 5 22:14:26.932205 kernel: psci: SMC Calling Convention v1.1 Aug 5 22:14:26.932212 kernel: smccc: KVM: hypervisor services detected (0x00000000 0x00000000 0x00000000 0x00000003) Aug 5 22:14:26.932219 kernel: percpu: Embedded 31 pages/cpu s86632 r8192 d32152 u126976 Aug 5 22:14:26.932226 kernel: pcpu-alloc: s86632 r8192 d32152 u126976 alloc=31*4096 Aug 5 22:14:26.932233 kernel: pcpu-alloc: [0] 0 [0] 1 [0] 2 [0] 3 Aug 5 22:14:26.932240 kernel: Detected PIPT I-cache on CPU0 Aug 5 22:14:26.932247 kernel: CPU features: detected: GIC system register CPU interface Aug 5 22:14:26.932254 kernel: CPU features: detected: Hardware dirty bit management Aug 5 22:14:26.932262 kernel: CPU features: detected: Spectre-v4 Aug 5 22:14:26.932270 kernel: CPU features: detected: Spectre-BHB Aug 5 22:14:26.932277 kernel: CPU features: kernel page table isolation forced ON by KASLR Aug 5 22:14:26.932284 kernel: CPU features: detected: Kernel page table isolation (KPTI) Aug 5 22:14:26.932291 kernel: CPU features: detected: ARM erratum 1418040 Aug 5 22:14:26.932298 kernel: alternatives: applying boot alternatives Aug 5 22:14:26.932306 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:14:26.932313 kernel: Unknown kernel command line parameters "BOOT_IMAGE=/flatcar/vmlinuz-a", will be passed to user space. Aug 5 22:14:26.932332 kernel: Dentry cache hash table entries: 524288 (order: 10, 4194304 bytes, linear) Aug 5 22:14:26.932339 kernel: Inode-cache hash table entries: 262144 (order: 9, 2097152 bytes, linear) Aug 5 22:14:26.932346 kernel: Fallback order for Node 0: 0 Aug 5 22:14:26.932354 kernel: Built 1 zonelists, mobility grouping on. Total pages: 633024 Aug 5 22:14:26.932362 kernel: Policy zone: DMA Aug 5 22:14:26.932369 kernel: mem auto-init: stack:off, heap alloc:off, heap free:off Aug 5 22:14:26.932376 kernel: software IO TLB: area num 4. Aug 5 22:14:26.932383 kernel: software IO TLB: mapped [mem 0x00000000d2e00000-0x00000000d6e00000] (64MB) Aug 5 22:14:26.932391 kernel: Memory: 2386704K/2572288K available (10240K kernel code, 2182K rwdata, 8072K rodata, 39040K init, 897K bss, 185584K reserved, 0K cma-reserved) Aug 5 22:14:26.932398 kernel: SLUB: HWalign=64, Order=0-3, MinObjects=0, CPUs=4, Nodes=1 Aug 5 22:14:26.932405 kernel: trace event string verifier disabled Aug 5 22:14:26.932411 kernel: rcu: Preemptible hierarchical RCU implementation. Aug 5 22:14:26.932419 kernel: rcu: RCU event tracing is enabled. Aug 5 22:14:26.932426 kernel: rcu: RCU restricting CPUs from NR_CPUS=512 to nr_cpu_ids=4. Aug 5 22:14:26.932433 kernel: Trampoline variant of Tasks RCU enabled. Aug 5 22:14:26.932442 kernel: Tracing variant of Tasks RCU enabled. Aug 5 22:14:26.932449 kernel: rcu: RCU calculated value of scheduler-enlistment delay is 100 jiffies. Aug 5 22:14:26.932456 kernel: rcu: Adjusting geometry for rcu_fanout_leaf=16, nr_cpu_ids=4 Aug 5 22:14:26.932463 kernel: NR_IRQS: 64, nr_irqs: 64, preallocated irqs: 0 Aug 5 22:14:26.932470 kernel: GICv3: 256 SPIs implemented Aug 5 22:14:26.932477 kernel: GICv3: 0 Extended SPIs implemented Aug 5 22:14:26.932483 kernel: Root IRQ handler: gic_handle_irq Aug 5 22:14:26.932491 kernel: GICv3: GICv3 features: 16 PPIs, DirectLPI Aug 5 22:14:26.932498 kernel: GICv3: CPU0: found redistributor 0 region 0:0x00000000080a0000 Aug 5 22:14:26.932505 kernel: ITS [mem 0x08080000-0x0809ffff] Aug 5 22:14:26.932512 kernel: ITS@0x0000000008080000: allocated 8192 Devices @400d0000 (indirect, esz 8, psz 64K, shr 1) Aug 5 22:14:26.932519 kernel: ITS@0x0000000008080000: allocated 8192 Interrupt Collections @400e0000 (flat, esz 8, psz 64K, shr 1) Aug 5 22:14:26.932527 kernel: GICv3: using LPI property table @0x00000000400f0000 Aug 5 22:14:26.932535 kernel: GICv3: CPU0: using allocated LPI pending table @0x0000000040100000 Aug 5 22:14:26.932542 kernel: rcu: srcu_init: Setting srcu_struct sizes based on contention. Aug 5 22:14:26.932548 kernel: arch_timer: Enabling local workaround for ARM erratum 1418040 Aug 5 22:14:26.932555 kernel: arch_timer: cp15 timer(s) running at 25.00MHz (virt). Aug 5 22:14:26.932562 kernel: clocksource: arch_sys_counter: mask: 0xffffffffffffff max_cycles: 0x5c40939b5, max_idle_ns: 440795202646 ns Aug 5 22:14:26.932570 kernel: sched_clock: 56 bits at 25MHz, resolution 40ns, wraps every 4398046511100ns Aug 5 22:14:26.932576 kernel: arm-pv: using stolen time PV Aug 5 22:14:26.932584 kernel: Console: colour dummy device 80x25 Aug 5 22:14:26.932591 kernel: ACPI: Core revision 20230628 Aug 5 22:14:26.932599 kernel: Calibrating delay loop (skipped), value calculated using timer frequency.. 50.00 BogoMIPS (lpj=25000) Aug 5 22:14:26.932607 kernel: pid_max: default: 32768 minimum: 301 Aug 5 22:14:26.932614 kernel: LSM: initializing lsm=lockdown,capability,selinux,integrity Aug 5 22:14:26.932621 kernel: SELinux: Initializing. Aug 5 22:14:26.932629 kernel: Mount-cache hash table entries: 8192 (order: 4, 65536 bytes, linear) Aug 5 22:14:26.932636 kernel: Mountpoint-cache hash table entries: 8192 (order: 4, 65536 bytes, linear) Aug 5 22:14:26.932643 kernel: RCU Tasks: Setting shift to 2 and lim to 1 rcu_task_cb_adjust=1. Aug 5 22:14:26.932651 kernel: RCU Tasks Trace: Setting shift to 2 and lim to 1 rcu_task_cb_adjust=1. Aug 5 22:14:26.932658 kernel: rcu: Hierarchical SRCU implementation. Aug 5 22:14:26.932665 kernel: rcu: Max phase no-delay instances is 400. Aug 5 22:14:26.932674 kernel: Platform MSI: ITS@0x8080000 domain created Aug 5 22:14:26.932681 kernel: PCI/MSI: ITS@0x8080000 domain created Aug 5 22:14:26.932688 kernel: Remapping and enabling EFI services. Aug 5 22:14:26.932695 kernel: smp: Bringing up secondary CPUs ... Aug 5 22:14:26.932702 kernel: Detected PIPT I-cache on CPU1 Aug 5 22:14:26.932709 kernel: GICv3: CPU1: found redistributor 1 region 0:0x00000000080c0000 Aug 5 22:14:26.932716 kernel: GICv3: CPU1: using allocated LPI pending table @0x0000000040110000 Aug 5 22:14:26.932723 kernel: arch_timer: Enabling local workaround for ARM erratum 1418040 Aug 5 22:14:26.932730 kernel: CPU1: Booted secondary processor 0x0000000001 [0x413fd0c1] Aug 5 22:14:26.932739 kernel: Detected PIPT I-cache on CPU2 Aug 5 22:14:26.932746 kernel: GICv3: CPU2: found redistributor 2 region 0:0x00000000080e0000 Aug 5 22:14:26.932766 kernel: GICv3: CPU2: using allocated LPI pending table @0x0000000040120000 Aug 5 22:14:26.932775 kernel: arch_timer: Enabling local workaround for ARM erratum 1418040 Aug 5 22:14:26.932782 kernel: CPU2: Booted secondary processor 0x0000000002 [0x413fd0c1] Aug 5 22:14:26.932789 kernel: Detected PIPT I-cache on CPU3 Aug 5 22:14:26.932797 kernel: GICv3: CPU3: found redistributor 3 region 0:0x0000000008100000 Aug 5 22:14:26.932805 kernel: GICv3: CPU3: using allocated LPI pending table @0x0000000040130000 Aug 5 22:14:26.932812 kernel: arch_timer: Enabling local workaround for ARM erratum 1418040 Aug 5 22:14:26.932821 kernel: CPU3: Booted secondary processor 0x0000000003 [0x413fd0c1] Aug 5 22:14:26.932828 kernel: smp: Brought up 1 node, 4 CPUs Aug 5 22:14:26.932836 kernel: SMP: Total of 4 processors activated. Aug 5 22:14:26.932843 kernel: CPU features: detected: 32-bit EL0 Support Aug 5 22:14:26.932851 kernel: CPU features: detected: Data cache clean to the PoU not required for I/D coherence Aug 5 22:14:26.932859 kernel: CPU features: detected: Common not Private translations Aug 5 22:14:26.932866 kernel: CPU features: detected: CRC32 instructions Aug 5 22:14:26.932874 kernel: CPU features: detected: Enhanced Virtualization Traps Aug 5 22:14:26.932883 kernel: CPU features: detected: RCpc load-acquire (LDAPR) Aug 5 22:14:26.932890 kernel: CPU features: detected: LSE atomic instructions Aug 5 22:14:26.932898 kernel: CPU features: detected: Privileged Access Never Aug 5 22:14:26.932905 kernel: CPU features: detected: RAS Extension Support Aug 5 22:14:26.932913 kernel: CPU features: detected: Speculative Store Bypassing Safe (SSBS) Aug 5 22:14:26.932920 kernel: CPU: All CPU(s) started at EL1 Aug 5 22:14:26.932928 kernel: alternatives: applying system-wide alternatives Aug 5 22:14:26.932935 kernel: devtmpfs: initialized Aug 5 22:14:26.932943 kernel: clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1911260446275000 ns Aug 5 22:14:26.932952 kernel: futex hash table entries: 1024 (order: 4, 65536 bytes, linear) Aug 5 22:14:26.932959 kernel: pinctrl core: initialized pinctrl subsystem Aug 5 22:14:26.932967 kernel: SMBIOS 3.0.0 present. Aug 5 22:14:26.932975 kernel: DMI: QEMU KVM Virtual Machine, BIOS edk2-20230524-3.fc38 05/24/2023 Aug 5 22:14:26.932982 kernel: NET: Registered PF_NETLINK/PF_ROUTE protocol family Aug 5 22:14:26.932990 kernel: DMA: preallocated 512 KiB GFP_KERNEL pool for atomic allocations Aug 5 22:14:26.932998 kernel: DMA: preallocated 512 KiB GFP_KERNEL|GFP_DMA pool for atomic allocations Aug 5 22:14:26.933005 kernel: DMA: preallocated 512 KiB GFP_KERNEL|GFP_DMA32 pool for atomic allocations Aug 5 22:14:26.933013 kernel: audit: initializing netlink subsys (disabled) Aug 5 22:14:26.933022 kernel: audit: type=2000 audit(0.024:1): state=initialized audit_enabled=0 res=1 Aug 5 22:14:26.933029 kernel: thermal_sys: Registered thermal governor 'step_wise' Aug 5 22:14:26.933037 kernel: cpuidle: using governor menu Aug 5 22:14:26.933044 kernel: hw-breakpoint: found 6 breakpoint and 4 watchpoint registers. Aug 5 22:14:26.933052 kernel: ASID allocator initialised with 32768 entries Aug 5 22:14:26.933059 kernel: acpiphp: ACPI Hot Plug PCI Controller Driver version: 0.5 Aug 5 22:14:26.933067 kernel: Serial: AMBA PL011 UART driver Aug 5 22:14:26.933074 kernel: Modules: 2G module region forced by RANDOMIZE_MODULE_REGION_FULL Aug 5 22:14:26.933082 kernel: Modules: 0 pages in range for non-PLT usage Aug 5 22:14:26.933090 kernel: Modules: 509120 pages in range for PLT usage Aug 5 22:14:26.933098 kernel: HugeTLB: registered 1.00 GiB page size, pre-allocated 0 pages Aug 5 22:14:26.933105 kernel: HugeTLB: 0 KiB vmemmap can be freed for a 1.00 GiB page Aug 5 22:14:26.933113 kernel: HugeTLB: registered 32.0 MiB page size, pre-allocated 0 pages Aug 5 22:14:26.933120 kernel: HugeTLB: 0 KiB vmemmap can be freed for a 32.0 MiB page Aug 5 22:14:26.933127 kernel: HugeTLB: registered 2.00 MiB page size, pre-allocated 0 pages Aug 5 22:14:26.933135 kernel: HugeTLB: 0 KiB vmemmap can be freed for a 2.00 MiB page Aug 5 22:14:26.933142 kernel: HugeTLB: registered 64.0 KiB page size, pre-allocated 0 pages Aug 5 22:14:26.933150 kernel: HugeTLB: 0 KiB vmemmap can be freed for a 64.0 KiB page Aug 5 22:14:26.933162 kernel: ACPI: Added _OSI(Module Device) Aug 5 22:14:26.933170 kernel: ACPI: Added _OSI(Processor Device) Aug 5 22:14:26.933177 kernel: ACPI: Added _OSI(3.0 _SCP Extensions) Aug 5 22:14:26.933185 kernel: ACPI: Added _OSI(Processor Aggregator Device) Aug 5 22:14:26.933192 kernel: ACPI: 1 ACPI AML tables successfully acquired and loaded Aug 5 22:14:26.933199 kernel: ACPI: Interpreter enabled Aug 5 22:14:26.933207 kernel: ACPI: Using GIC for interrupt routing Aug 5 22:14:26.933214 kernel: ACPI: MCFG table detected, 1 entries Aug 5 22:14:26.933222 kernel: ARMH0011:00: ttyAMA0 at MMIO 0x9000000 (irq = 12, base_baud = 0) is a SBSA Aug 5 22:14:26.933231 kernel: printk: console [ttyAMA0] enabled Aug 5 22:14:26.933238 kernel: ACPI: PCI Root Bridge [PCI0] (domain 0000 [bus 00-ff]) Aug 5 22:14:26.933388 kernel: acpi PNP0A08:00: _OSC: OS supports [ExtendedConfig ASPM ClockPM Segments MSI HPX-Type3] Aug 5 22:14:26.933467 kernel: acpi PNP0A08:00: _OSC: platform does not support [LTR] Aug 5 22:14:26.933536 kernel: acpi PNP0A08:00: _OSC: OS now controls [PCIeHotplug PME AER PCIeCapability] Aug 5 22:14:26.933601 kernel: acpi PNP0A08:00: ECAM area [mem 0x4010000000-0x401fffffff] reserved by PNP0C02:00 Aug 5 22:14:26.933665 kernel: acpi PNP0A08:00: ECAM at [mem 0x4010000000-0x401fffffff] for [bus 00-ff] Aug 5 22:14:26.933678 kernel: ACPI: Remapped I/O 0x000000003eff0000 to [io 0x0000-0xffff window] Aug 5 22:14:26.933686 kernel: PCI host bridge to bus 0000:00 Aug 5 22:14:26.933764 kernel: pci_bus 0000:00: root bus resource [mem 0x10000000-0x3efeffff window] Aug 5 22:14:26.933828 kernel: pci_bus 0000:00: root bus resource [io 0x0000-0xffff window] Aug 5 22:14:26.933889 kernel: pci_bus 0000:00: root bus resource [mem 0x8000000000-0xffffffffff window] Aug 5 22:14:26.933948 kernel: pci_bus 0000:00: root bus resource [bus 00-ff] Aug 5 22:14:26.934032 kernel: pci 0000:00:00.0: [1b36:0008] type 00 class 0x060000 Aug 5 22:14:26.934111 kernel: pci 0000:00:01.0: [1af4:1005] type 00 class 0x00ff00 Aug 5 22:14:26.934180 kernel: pci 0000:00:01.0: reg 0x10: [io 0x0000-0x001f] Aug 5 22:14:26.934250 kernel: pci 0000:00:01.0: reg 0x14: [mem 0x10000000-0x10000fff] Aug 5 22:14:26.934317 kernel: pci 0000:00:01.0: reg 0x20: [mem 0x8000000000-0x8000003fff 64bit pref] Aug 5 22:14:26.934399 kernel: pci 0000:00:01.0: BAR 4: assigned [mem 0x8000000000-0x8000003fff 64bit pref] Aug 5 22:14:26.934467 kernel: pci 0000:00:01.0: BAR 1: assigned [mem 0x10000000-0x10000fff] Aug 5 22:14:26.934546 kernel: pci 0000:00:01.0: BAR 0: assigned [io 0x1000-0x101f] Aug 5 22:14:26.934611 kernel: pci_bus 0000:00: resource 4 [mem 0x10000000-0x3efeffff window] Aug 5 22:14:26.934671 kernel: pci_bus 0000:00: resource 5 [io 0x0000-0xffff window] Aug 5 22:14:26.934731 kernel: pci_bus 0000:00: resource 6 [mem 0x8000000000-0xffffffffff window] Aug 5 22:14:26.934741 kernel: ACPI: PCI: Interrupt link GSI0 configured for IRQ 35 Aug 5 22:14:26.934748 kernel: ACPI: PCI: Interrupt link GSI1 configured for IRQ 36 Aug 5 22:14:26.934763 kernel: ACPI: PCI: Interrupt link GSI2 configured for IRQ 37 Aug 5 22:14:26.934771 kernel: ACPI: PCI: Interrupt link GSI3 configured for IRQ 38 Aug 5 22:14:26.934779 kernel: iommu: Default domain type: Translated Aug 5 22:14:26.934789 kernel: iommu: DMA domain TLB invalidation policy: strict mode Aug 5 22:14:26.934797 kernel: efivars: Registered efivars operations Aug 5 22:14:26.934804 kernel: vgaarb: loaded Aug 5 22:14:26.934811 kernel: clocksource: Switched to clocksource arch_sys_counter Aug 5 22:14:26.934819 kernel: VFS: Disk quotas dquot_6.6.0 Aug 5 22:14:26.934826 kernel: VFS: Dquot-cache hash table entries: 512 (order 0, 4096 bytes) Aug 5 22:14:26.934834 kernel: pnp: PnP ACPI init Aug 5 22:14:26.934915 kernel: system 00:00: [mem 0x4010000000-0x401fffffff window] could not be reserved Aug 5 22:14:26.934928 kernel: pnp: PnP ACPI: found 1 devices Aug 5 22:14:26.934936 kernel: NET: Registered PF_INET protocol family Aug 5 22:14:26.934943 kernel: IP idents hash table entries: 65536 (order: 7, 524288 bytes, linear) Aug 5 22:14:26.934951 kernel: tcp_listen_portaddr_hash hash table entries: 2048 (order: 3, 32768 bytes, linear) Aug 5 22:14:26.934959 kernel: Table-perturb hash table entries: 65536 (order: 6, 262144 bytes, linear) Aug 5 22:14:26.934966 kernel: TCP established hash table entries: 32768 (order: 6, 262144 bytes, linear) Aug 5 22:14:26.934974 kernel: TCP bind hash table entries: 32768 (order: 8, 1048576 bytes, linear) Aug 5 22:14:26.934982 kernel: TCP: Hash tables configured (established 32768 bind 32768) Aug 5 22:14:26.934989 kernel: UDP hash table entries: 2048 (order: 4, 65536 bytes, linear) Aug 5 22:14:26.934998 kernel: UDP-Lite hash table entries: 2048 (order: 4, 65536 bytes, linear) Aug 5 22:14:26.935005 kernel: NET: Registered PF_UNIX/PF_LOCAL protocol family Aug 5 22:14:26.935013 kernel: PCI: CLS 0 bytes, default 64 Aug 5 22:14:26.935020 kernel: kvm [1]: HYP mode not available Aug 5 22:14:26.935027 kernel: Initialise system trusted keyrings Aug 5 22:14:26.935035 kernel: workingset: timestamp_bits=39 max_order=20 bucket_order=0 Aug 5 22:14:26.935042 kernel: Key type asymmetric registered Aug 5 22:14:26.935050 kernel: Asymmetric key parser 'x509' registered Aug 5 22:14:26.935057 kernel: Block layer SCSI generic (bsg) driver version 0.4 loaded (major 250) Aug 5 22:14:26.935066 kernel: io scheduler mq-deadline registered Aug 5 22:14:26.935073 kernel: io scheduler kyber registered Aug 5 22:14:26.935081 kernel: io scheduler bfq registered Aug 5 22:14:26.935088 kernel: input: Power Button as /devices/LNXSYSTM:00/LNXSYBUS:00/PNP0C0C:00/input/input0 Aug 5 22:14:26.935096 kernel: ACPI: button: Power Button [PWRB] Aug 5 22:14:26.935104 kernel: ACPI: \_SB_.PCI0.GSI1: Enabled at IRQ 36 Aug 5 22:14:26.935174 kernel: virtio-pci 0000:00:01.0: enabling device (0005 -> 0007) Aug 5 22:14:26.935184 kernel: Serial: 8250/16550 driver, 4 ports, IRQ sharing enabled Aug 5 22:14:26.935191 kernel: thunder_xcv, ver 1.0 Aug 5 22:14:26.935200 kernel: thunder_bgx, ver 1.0 Aug 5 22:14:26.935208 kernel: nicpf, ver 1.0 Aug 5 22:14:26.935215 kernel: nicvf, ver 1.0 Aug 5 22:14:26.935289 kernel: rtc-efi rtc-efi.0: registered as rtc0 Aug 5 22:14:26.935367 kernel: rtc-efi rtc-efi.0: setting system clock to 2024-08-05T22:14:26 UTC (1722896066) Aug 5 22:14:26.935378 kernel: hid: raw HID events driver (C) Jiri Kosina Aug 5 22:14:26.935385 kernel: hw perfevents: enabled with armv8_pmuv3_0 PMU driver, 7 counters available Aug 5 22:14:26.935393 kernel: watchdog: Delayed init of the lockup detector failed: -19 Aug 5 22:14:26.935403 kernel: watchdog: Hard watchdog permanently disabled Aug 5 22:14:26.935410 kernel: NET: Registered PF_INET6 protocol family Aug 5 22:14:26.935418 kernel: Segment Routing with IPv6 Aug 5 22:14:26.935425 kernel: In-situ OAM (IOAM) with IPv6 Aug 5 22:14:26.935433 kernel: NET: Registered PF_PACKET protocol family Aug 5 22:14:26.935440 kernel: Key type dns_resolver registered Aug 5 22:14:26.935447 kernel: registered taskstats version 1 Aug 5 22:14:26.935455 kernel: Loading compiled-in X.509 certificates Aug 5 22:14:26.935462 kernel: Loaded X.509 cert 'Kinvolk GmbH: Module signing key for 6.6.43-flatcar: 99cab5c9e2f0f3a5ca972c2df7b3d6ed64d627d4' Aug 5 22:14:26.935471 kernel: Key type .fscrypt registered Aug 5 22:14:26.935478 kernel: Key type fscrypt-provisioning registered Aug 5 22:14:26.935486 kernel: ima: No TPM chip found, activating TPM-bypass! Aug 5 22:14:26.935494 kernel: ima: Allocated hash algorithm: sha1 Aug 5 22:14:26.935501 kernel: ima: No architecture policies found Aug 5 22:14:26.935509 kernel: alg: No test for fips(ansi_cprng) (fips_ansi_cprng) Aug 5 22:14:26.935516 kernel: clk: Disabling unused clocks Aug 5 22:14:26.935524 kernel: Freeing unused kernel memory: 39040K Aug 5 22:14:26.935531 kernel: Run /init as init process Aug 5 22:14:26.935540 kernel: with arguments: Aug 5 22:14:26.935547 kernel: /init Aug 5 22:14:26.935554 kernel: with environment: Aug 5 22:14:26.935562 kernel: HOME=/ Aug 5 22:14:26.935569 kernel: TERM=linux Aug 5 22:14:26.935576 kernel: BOOT_IMAGE=/flatcar/vmlinuz-a Aug 5 22:14:26.935586 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:14:26.935595 systemd[1]: Detected virtualization kvm. Aug 5 22:14:26.935604 systemd[1]: Detected architecture arm64. Aug 5 22:14:26.935612 systemd[1]: Running in initrd. Aug 5 22:14:26.935620 systemd[1]: No hostname configured, using default hostname. Aug 5 22:14:26.935627 systemd[1]: Hostname set to . Aug 5 22:14:26.935636 systemd[1]: Initializing machine ID from VM UUID. Aug 5 22:14:26.935644 systemd[1]: Queued start job for default target initrd.target. Aug 5 22:14:26.935652 systemd[1]: Started clevis-luks-askpass.path - Forward Password Requests to Clevis Directory Watch. Aug 5 22:14:26.935660 systemd[1]: Started systemd-ask-password-console.path - Dispatch Password Requests to Console Directory Watch. Aug 5 22:14:26.935670 systemd[1]: Expecting device dev-disk-by\x2dlabel-EFI\x2dSYSTEM.device - /dev/disk/by-label/EFI-SYSTEM... Aug 5 22:14:26.935678 systemd[1]: Expecting device dev-disk-by\x2dlabel-OEM.device - /dev/disk/by-label/OEM... Aug 5 22:14:26.935686 systemd[1]: Expecting device dev-disk-by\x2dlabel-ROOT.device - /dev/disk/by-label/ROOT... Aug 5 22:14:26.935695 systemd[1]: Expecting device dev-disk-by\x2dpartlabel-USR\x2dA.device - /dev/disk/by-partlabel/USR-A... Aug 5 22:14:26.935704 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:14:26.935713 systemd[1]: Expecting device dev-mapper-usr.device - /dev/mapper/usr... Aug 5 22:14:26.935721 systemd[1]: Reached target cryptsetup-pre.target - Local Encrypted Volumes (Pre). Aug 5 22:14:26.935730 systemd[1]: Reached target cryptsetup.target - Local Encrypted Volumes. Aug 5 22:14:26.935738 systemd[1]: Reached target paths.target - Path Units. Aug 5 22:14:26.935746 systemd[1]: Reached target slices.target - Slice Units. Aug 5 22:14:26.935760 systemd[1]: Reached target swap.target - Swaps. Aug 5 22:14:26.935769 systemd[1]: Reached target timers.target - Timer Units. Aug 5 22:14:26.935777 systemd[1]: Listening on iscsid.socket - Open-iSCSI iscsid Socket. Aug 5 22:14:26.935785 systemd[1]: Listening on iscsiuio.socket - Open-iSCSI iscsiuio Socket. Aug 5 22:14:26.935793 systemd[1]: Listening on systemd-journald-dev-log.socket - Journal Socket (/dev/log). Aug 5 22:14:26.935803 systemd[1]: Listening on systemd-journald.socket - Journal Socket. Aug 5 22:14:26.935811 systemd[1]: Listening on systemd-networkd.socket - Network Service Netlink Socket. Aug 5 22:14:26.935819 systemd[1]: Listening on systemd-udevd-control.socket - udev Control Socket. Aug 5 22:14:26.935827 systemd[1]: Listening on systemd-udevd-kernel.socket - udev Kernel Socket. Aug 5 22:14:26.935835 systemd[1]: Reached target sockets.target - Socket Units. Aug 5 22:14:26.935843 systemd[1]: Starting ignition-setup-pre.service - Ignition env setup... Aug 5 22:14:26.935851 systemd[1]: Starting kmod-static-nodes.service - Create List of Static Device Nodes... Aug 5 22:14:26.935859 systemd[1]: Finished network-cleanup.service - Network Cleanup. Aug 5 22:14:26.935867 systemd[1]: Starting systemd-fsck-usr.service... Aug 5 22:14:26.935876 systemd[1]: Starting systemd-journald.service - Journal Service... Aug 5 22:14:26.935884 systemd[1]: Starting systemd-modules-load.service - Load Kernel Modules... Aug 5 22:14:26.935892 systemd[1]: Starting systemd-vconsole-setup.service - Virtual Console Setup... Aug 5 22:14:26.935900 systemd[1]: Finished ignition-setup-pre.service - Ignition env setup. Aug 5 22:14:26.935909 systemd[1]: Finished kmod-static-nodes.service - Create List of Static Device Nodes. Aug 5 22:14:26.935916 systemd[1]: Finished systemd-fsck-usr.service. Aug 5 22:14:26.935926 systemd[1]: Starting systemd-tmpfiles-setup-dev-early.service - Create Static Device Nodes in /dev gracefully... Aug 5 22:14:26.935935 systemd[1]: Finished systemd-vconsole-setup.service - Virtual Console Setup. Aug 5 22:14:26.935943 systemd[1]: Starting dracut-cmdline-ask.service - dracut ask for additional cmdline parameters... Aug 5 22:14:26.935951 systemd[1]: Finished systemd-tmpfiles-setup-dev-early.service - Create Static Device Nodes in /dev gracefully. Aug 5 22:14:26.935975 systemd-journald[236]: Collecting audit messages is disabled. Aug 5 22:14:26.935996 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:14:26.936004 kernel: Bridge firewalling registered Aug 5 22:14:26.936011 systemd[1]: Starting systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev... Aug 5 22:14:26.936020 systemd[1]: Finished systemd-modules-load.service - Load Kernel Modules. Aug 5 22:14:26.936033 systemd-journald[236]: Journal started Aug 5 22:14:26.936053 systemd-journald[236]: Runtime Journal (/run/log/journal/34d35adb6cb64892a3f942ca92e347c0) is 5.9M, max 47.3M, 41.4M free. Aug 5 22:14:26.910489 systemd-modules-load[237]: Inserted module 'overlay' Aug 5 22:14:26.938088 systemd[1]: Started systemd-journald.service - Journal Service. Aug 5 22:14:26.928798 systemd-modules-load[237]: Inserted module 'br_netfilter' Aug 5 22:14:26.940236 systemd[1]: Starting systemd-sysctl.service - Apply Kernel Variables... Aug 5 22:14:26.942472 systemd[1]: Starting systemd-tmpfiles-setup.service - Create Volatile Files and Directories... Aug 5 22:14:26.945206 systemd[1]: Finished systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev. Aug 5 22:14:26.949910 systemd[1]: Finished dracut-cmdline-ask.service - dracut ask for additional cmdline parameters. Aug 5 22:14:26.953145 systemd[1]: Finished systemd-sysctl.service - Apply Kernel Variables. Aug 5 22:14:26.955128 systemd[1]: Finished systemd-tmpfiles-setup.service - Create Volatile Files and Directories. Aug 5 22:14:26.968459 systemd[1]: Starting dracut-cmdline.service - dracut cmdline hook... Aug 5 22:14:26.970530 systemd[1]: Starting systemd-resolved.service - Network Name Resolution... Aug 5 22:14:26.981256 dracut-cmdline[274]: dracut-dracut-053 Aug 5 22:14:26.984844 dracut-cmdline[274]: 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:14:26.997648 systemd-resolved[277]: Positive Trust Anchors: Aug 5 22:14:26.997668 systemd-resolved[277]: . IN DS 20326 8 2 e06d44b80b8f1d39a95c0b0d7c65d08458e880409bbc683457104237c7f8ec8d Aug 5 22:14:26.997699 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:14:27.002314 systemd-resolved[277]: Defaulting to hostname 'linux'. Aug 5 22:14:27.003274 systemd[1]: Started systemd-resolved.service - Network Name Resolution. Aug 5 22:14:27.005156 systemd[1]: Reached target nss-lookup.target - Host and Network Name Lookups. Aug 5 22:14:27.052352 kernel: SCSI subsystem initialized Aug 5 22:14:27.057335 kernel: Loading iSCSI transport class v2.0-870. Aug 5 22:14:27.064341 kernel: iscsi: registered transport (tcp) Aug 5 22:14:27.077368 kernel: iscsi: registered transport (qla4xxx) Aug 5 22:14:27.077385 kernel: QLogic iSCSI HBA Driver Aug 5 22:14:27.124180 systemd[1]: Finished dracut-cmdline.service - dracut cmdline hook. Aug 5 22:14:27.135458 systemd[1]: Starting dracut-pre-udev.service - dracut pre-udev hook... Aug 5 22:14:27.154366 kernel: device-mapper: core: CONFIG_IMA_DISABLE_HTABLE is disabled. Duplicate IMA measurements will not be recorded in the IMA log. Aug 5 22:14:27.154417 kernel: device-mapper: uevent: version 1.0.3 Aug 5 22:14:27.159339 kernel: device-mapper: ioctl: 4.48.0-ioctl (2023-03-01) initialised: dm-devel@redhat.com Aug 5 22:14:27.210354 kernel: raid6: neonx8 gen() 15769 MB/s Aug 5 22:14:27.227344 kernel: raid6: neonx4 gen() 15669 MB/s Aug 5 22:14:27.244345 kernel: raid6: neonx2 gen() 13226 MB/s Aug 5 22:14:27.261344 kernel: raid6: neonx1 gen() 10448 MB/s Aug 5 22:14:27.278335 kernel: raid6: int64x8 gen() 6962 MB/s Aug 5 22:14:27.295337 kernel: raid6: int64x4 gen() 7434 MB/s Aug 5 22:14:27.312338 kernel: raid6: int64x2 gen() 6140 MB/s Aug 5 22:14:27.329343 kernel: raid6: int64x1 gen() 5041 MB/s Aug 5 22:14:27.329371 kernel: raid6: using algorithm neonx8 gen() 15769 MB/s Aug 5 22:14:27.346348 kernel: raid6: .... xor() 11901 MB/s, rmw enabled Aug 5 22:14:27.346376 kernel: raid6: using neon recovery algorithm Aug 5 22:14:27.351663 kernel: xor: measuring software checksum speed Aug 5 22:14:27.351698 kernel: 8regs : 19864 MB/sec Aug 5 22:14:27.352571 kernel: 32regs : 19720 MB/sec Aug 5 22:14:27.353749 kernel: arm64_neon : 27197 MB/sec Aug 5 22:14:27.353764 kernel: xor: using function: arm64_neon (27197 MB/sec) Aug 5 22:14:27.405342 kernel: Btrfs loaded, zoned=no, fsverity=no Aug 5 22:14:27.416217 systemd[1]: Finished dracut-pre-udev.service - dracut pre-udev hook. Aug 5 22:14:27.429082 systemd[1]: Starting systemd-udevd.service - Rule-based Manager for Device Events and Files... Aug 5 22:14:27.441635 systemd-udevd[460]: Using default interface naming scheme 'v255'. Aug 5 22:14:27.445063 systemd[1]: Started systemd-udevd.service - Rule-based Manager for Device Events and Files. Aug 5 22:14:27.451490 systemd[1]: Starting dracut-pre-trigger.service - dracut pre-trigger hook... Aug 5 22:14:27.463715 dracut-pre-trigger[463]: rd.md=0: removing MD RAID activation Aug 5 22:14:27.490038 systemd[1]: Finished dracut-pre-trigger.service - dracut pre-trigger hook. Aug 5 22:14:27.502469 systemd[1]: Starting systemd-udev-trigger.service - Coldplug All udev Devices... Aug 5 22:14:27.541978 systemd[1]: Finished systemd-udev-trigger.service - Coldplug All udev Devices. Aug 5 22:14:27.549492 systemd[1]: Starting dracut-initqueue.service - dracut initqueue hook... Aug 5 22:14:27.561578 systemd[1]: Finished dracut-initqueue.service - dracut initqueue hook. Aug 5 22:14:27.562959 systemd[1]: Reached target remote-fs-pre.target - Preparation for Remote File Systems. Aug 5 22:14:27.564986 systemd[1]: Reached target remote-cryptsetup.target - Remote Encrypted Volumes. Aug 5 22:14:27.567181 systemd[1]: Reached target remote-fs.target - Remote File Systems. Aug 5 22:14:27.578499 systemd[1]: Starting dracut-pre-mount.service - dracut pre-mount hook... Aug 5 22:14:27.588360 systemd[1]: Finished dracut-pre-mount.service - dracut pre-mount hook. Aug 5 22:14:27.593339 kernel: virtio_blk virtio1: 1/0/0 default/read/poll queues Aug 5 22:14:27.598506 kernel: virtio_blk virtio1: [vda] 1064960 512-byte logical blocks (545 MB/520 MiB) Aug 5 22:14:27.599185 kernel: tpm_tis MSFT0101:00: 2.0 TPM (device-id 0x1, rev-id 1) Aug 5 22:14:27.610433 kernel: virtio_blk virtio2: 1/0/0 default/read/poll queues Aug 5 22:14:27.610538 kernel: virtio_blk virtio2: [vdb] 9289728 512-byte logical blocks (4.76 GB/4.43 GiB) Aug 5 22:14:27.610609 kernel: vdb: vdb1 vdb2 vdb3 vdb4 vdb6 vdb7 vdb9 Aug 5 22:14:27.606082 systemd[1]: dracut-cmdline-ask.service: Deactivated successfully. Aug 5 22:14:27.606193 systemd[1]: Stopped dracut-cmdline-ask.service - dracut ask for additional cmdline parameters. Aug 5 22:14:27.607831 systemd[1]: Stopping dracut-cmdline-ask.service - dracut ask for additional cmdline parameters... Aug 5 22:14:27.609138 systemd[1]: systemd-vconsole-setup.service: Deactivated successfully. Aug 5 22:14:27.609267 systemd[1]: Stopped systemd-vconsole-setup.service - Virtual Console Setup. Aug 5 22:14:27.610603 systemd[1]: Stopping systemd-vconsole-setup.service - Virtual Console Setup... Aug 5 22:14:27.619809 systemd[1]: Starting systemd-vconsole-setup.service - Virtual Console Setup... Aug 5 22:14:27.634086 kernel: BTRFS: device fsid 278882ec-4175-45f0-a12b-7fddc0d6d9a3 devid 1 transid 41 /dev/vdb3 scanned by (udev-worker) (504) Aug 5 22:14:27.634125 kernel: BTRFS: device label OEM devid 1 transid 12 /dev/vdb6 scanned by (udev-worker) (514) Aug 5 22:14:27.636364 systemd[1]: Finished systemd-vconsole-setup.service - Virtual Console Setup. Aug 5 22:14:27.641239 systemd[1]: Found device dev-disk-by\x2dlabel-ROOT.device - /dev/disk/by-label/ROOT. Aug 5 22:14:27.645697 systemd[1]: Found device dev-disk-by\x2dlabel-EFI\x2dSYSTEM.device - /dev/disk/by-label/EFI-SYSTEM. Aug 5 22:14:27.654607 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:14:27.655760 systemd[1]: Found device dev-disk-by\x2dpartlabel-USR\x2dA.device - /dev/disk/by-partlabel/USR-A. Aug 5 22:14:27.661545 systemd[1]: Found device dev-disk-by\x2dlabel-OEM.device - /dev/disk/by-label/OEM. Aug 5 22:14:27.675510 systemd[1]: Starting disk-uuid.service - Generate new UUID for disk GPT if necessary... Aug 5 22:14:27.677265 systemd[1]: Starting dracut-cmdline-ask.service - dracut ask for additional cmdline parameters... Aug 5 22:14:27.688373 kernel: vdb: vdb1 vdb2 vdb3 vdb4 vdb6 vdb7 vdb9 Aug 5 22:14:27.696336 systemd[1]: Finished dracut-cmdline-ask.service - dracut ask for additional cmdline parameters. Aug 5 22:14:28.705354 kernel: vdb: vdb1 vdb2 vdb3 vdb4 vdb6 vdb7 vdb9 Aug 5 22:14:28.706420 disk-uuid[551]: The operation has completed successfully. Aug 5 22:14:28.743135 systemd[1]: disk-uuid.service: Deactivated successfully. Aug 5 22:14:28.743252 systemd[1]: Finished disk-uuid.service - Generate new UUID for disk GPT if necessary. Aug 5 22:14:28.763518 systemd[1]: Starting verity-setup.service - Verity Setup for /dev/mapper/usr... Aug 5 22:14:28.768365 sh[573]: Success Aug 5 22:14:28.783318 kernel: device-mapper: verity: sha256 using implementation "sha256-ce" Aug 5 22:14:28.834783 systemd[1]: Found device dev-mapper-usr.device - /dev/mapper/usr. Aug 5 22:14:28.837109 systemd[1]: Mounting sysusr-usr.mount - /sysusr/usr... Aug 5 22:14:28.838540 systemd[1]: Finished verity-setup.service - Verity Setup for /dev/mapper/usr. Aug 5 22:14:28.853199 kernel: BTRFS info (device dm-0): first mount of filesystem 278882ec-4175-45f0-a12b-7fddc0d6d9a3 Aug 5 22:14:28.853239 kernel: BTRFS info (device dm-0): using crc32c (crc32c-generic) checksum algorithm Aug 5 22:14:28.853251 kernel: BTRFS warning (device dm-0): 'nologreplay' is deprecated, use 'rescue=nologreplay' instead Aug 5 22:14:28.853261 kernel: BTRFS info (device dm-0): disabling log replay at mount time Aug 5 22:14:28.853270 kernel: BTRFS info (device dm-0): using free space tree Aug 5 22:14:28.858652 systemd[1]: Mounted sysusr-usr.mount - /sysusr/usr. Aug 5 22:14:28.859925 systemd[1]: afterburn-network-kargs.service - Afterburn Initrd Setup Network Kernel Arguments was skipped because no trigger condition checks were met. Aug 5 22:14:28.872466 systemd[1]: Starting ignition-setup.service - Ignition (setup)... Aug 5 22:14:28.874153 systemd[1]: Starting parse-ip-for-networkd.service - Write systemd-networkd units from cmdline... Aug 5 22:14:28.883646 kernel: BTRFS info (device vdb6): first mount of filesystem 47327e03-a391-4166-b35e-18ba93a1f298 Aug 5 22:14:28.883693 kernel: BTRFS info (device vdb6): using crc32c (crc32c-generic) checksum algorithm Aug 5 22:14:28.883710 kernel: BTRFS info (device vdb6): using free space tree Aug 5 22:14:28.888380 kernel: BTRFS info (device vdb6): auto enabling async discard Aug 5 22:14:28.896413 systemd[1]: mnt-oem.mount: Deactivated successfully. Aug 5 22:14:28.898023 kernel: BTRFS info (device vdb6): last unmount of filesystem 47327e03-a391-4166-b35e-18ba93a1f298 Aug 5 22:14:28.903605 systemd[1]: Finished ignition-setup.service - Ignition (setup). Aug 5 22:14:28.911591 systemd[1]: Starting ignition-fetch-offline.service - Ignition (fetch-offline)... Aug 5 22:14:28.977830 systemd[1]: Finished parse-ip-for-networkd.service - Write systemd-networkd units from cmdline. Aug 5 22:14:28.989510 systemd[1]: Starting systemd-networkd.service - Network Configuration... Aug 5 22:14:28.998547 ignition[665]: Ignition 2.18.0 Aug 5 22:14:28.998556 ignition[665]: Stage: fetch-offline Aug 5 22:14:28.998595 ignition[665]: no configs at "/usr/lib/ignition/base.d" Aug 5 22:14:28.998603 ignition[665]: no config dir at "/usr/lib/ignition/base.platform.d/qemu" Aug 5 22:14:28.998688 ignition[665]: parsed url from cmdline: "" Aug 5 22:14:28.998691 ignition[665]: no config URL provided Aug 5 22:14:28.998695 ignition[665]: reading system config file "/usr/lib/ignition/user.ign" Aug 5 22:14:28.998702 ignition[665]: no config at "/usr/lib/ignition/user.ign" Aug 5 22:14:28.998726 ignition[665]: op(1): [started] loading QEMU firmware config module Aug 5 22:14:28.998731 ignition[665]: op(1): executing: "modprobe" "qemu_fw_cfg" Aug 5 22:14:29.011378 ignition[665]: op(1): [finished] loading QEMU firmware config module Aug 5 22:14:29.014773 systemd-networkd[766]: lo: Link UP Aug 5 22:14:29.014781 systemd-networkd[766]: lo: Gained carrier Aug 5 22:14:29.015403 systemd-networkd[766]: Enumeration completed Aug 5 22:14:29.015664 systemd[1]: Started systemd-networkd.service - Network Configuration. Aug 5 22:14:29.015983 systemd-networkd[766]: eth0: found matching network '/usr/lib/systemd/network/zz-default.network', based on potentially unpredictable interface name. Aug 5 22:14:29.015987 systemd-networkd[766]: eth0: Configuring with /usr/lib/systemd/network/zz-default.network. Aug 5 22:14:29.021373 ignition[665]: parsing config with SHA512: cd5c6c53dd423f76468b76a54a5d14c6091be6e9f643a05b98d0e4297382587e97e914b5058b6b5105168dd327708c8e3937c66ad9b2f4f5b63213f283ff2883 Aug 5 22:14:29.017041 systemd[1]: Reached target network.target - Network. Aug 5 22:14:29.017698 systemd-networkd[766]: eth0: Link UP Aug 5 22:14:29.017701 systemd-networkd[766]: eth0: Gained carrier Aug 5 22:14:29.024524 ignition[665]: fetch-offline: fetch-offline passed Aug 5 22:14:29.017708 systemd-networkd[766]: eth0: found matching network '/usr/lib/systemd/network/zz-default.network', based on potentially unpredictable interface name. Aug 5 22:14:29.024597 ignition[665]: Ignition finished successfully Aug 5 22:14:29.024263 unknown[665]: fetched base config from "system" Aug 5 22:14:29.024270 unknown[665]: fetched user config from "qemu" Aug 5 22:14:29.026014 systemd[1]: Finished ignition-fetch-offline.service - Ignition (fetch-offline). Aug 5 22:14:29.027908 systemd[1]: ignition-fetch.service - Ignition (fetch) was skipped because of an unmet condition check (ConditionPathExists=!/run/ignition.json). Aug 5 22:14:29.032489 systemd[1]: Starting ignition-kargs.service - Ignition (kargs)... Aug 5 22:14:29.032662 systemd-networkd[766]: eth0: DHCPv4 address 10.0.0.113/16, gateway 10.0.0.1 acquired from 10.0.0.1 Aug 5 22:14:29.043902 ignition[773]: Ignition 2.18.0 Aug 5 22:14:29.043911 ignition[773]: Stage: kargs Aug 5 22:14:29.044047 ignition[773]: no configs at "/usr/lib/ignition/base.d" Aug 5 22:14:29.044056 ignition[773]: no config dir at "/usr/lib/ignition/base.platform.d/qemu" Aug 5 22:14:29.044677 ignition[773]: kargs: kargs passed Aug 5 22:14:29.047986 systemd[1]: Finished ignition-kargs.service - Ignition (kargs). Aug 5 22:14:29.044716 ignition[773]: Ignition finished successfully Aug 5 22:14:29.058483 systemd[1]: Starting ignition-disks.service - Ignition (disks)... Aug 5 22:14:29.069039 ignition[782]: Ignition 2.18.0 Aug 5 22:14:29.069048 ignition[782]: Stage: disks Aug 5 22:14:29.069193 ignition[782]: no configs at "/usr/lib/ignition/base.d" Aug 5 22:14:29.069202 ignition[782]: no config dir at "/usr/lib/ignition/base.platform.d/qemu" Aug 5 22:14:29.069834 ignition[782]: disks: createLuks: op(1): [started] waiting for devices [/dev/disk/by-partlabel/ROOT] Aug 5 22:14:29.077525 ignition[782]: disks: createLuks: op(1): [finished] waiting for devices [/dev/disk/by-partlabel/ROOT] Aug 5 22:14:29.077599 ignition[782]: disks: createLuks: created device alias for "/dev/disk/by-partlabel/ROOT": "/run/ignition/dev_aliases/dev/disk/by-partlabel/ROOT" -> "/dev/vdb9" Aug 5 22:14:29.077913 ignition[782]: disks: createLuks: op(2): [started] wiping filesystem signatures from "/run/ignition/dev_aliases/dev/disk/by-partlabel/ROOT" Aug 5 22:14:29.077921 ignition[782]: disks: createLuks: op(2): executing: "wipefs" "-a" "/run/ignition/dev_aliases/dev/disk/by-partlabel/ROOT" Aug 5 22:14:29.089059 ignition[782]: disks: createLuks: op(2): [finished] wiping filesystem signatures from "/run/ignition/dev_aliases/dev/disk/by-partlabel/ROOT" Aug 5 22:14:29.089090 ignition[782]: disks: createLuks: op(3): [started] creating "rootencrypted" Aug 5 22:14:29.089100 ignition[782]: disks: createLuks: op(3): executing: "cryptsetup" "luksFormat" "--type" "luks2" "--key-file" "/tmp/ignition-luks-1459623791" "/run/ignition/dev_aliases/dev/disk/by-partlabel/ROOT" Aug 5 22:14:30.682553 systemd-networkd[766]: eth0: Gained IPv6LL Aug 5 22:14:35.611116 ignition[782]: disks: createLuks: op(3): [finished] creating "rootencrypted" Aug 5 22:14:35.611155 ignition[782]: disks: createLuks: op(4): [started] opening luks device rootencrypted Aug 5 22:14:35.611169 ignition[782]: disks: createLuks: op(4): executing: "cryptsetup" "luksOpen" "/run/ignition/dev_aliases/dev/disk/by-partlabel/ROOT" "rootencrypted" "--key-file" "/tmp/ignition-luks-1459623791" "--persistent" Aug 5 22:14:37.579349 kernel: Key type trusted registered Aug 5 22:14:37.581351 kernel: Key type encrypted registered Aug 5 22:14:37.606678 ignition[782]: disks: createLuks: op(4): [finished] opening luks device rootencrypted Aug 5 22:14:37.606746 ignition[782]: disks: createLuks: op(5): [started] waiting for triggered uevent Aug 5 22:14:37.606755 ignition[782]: disks: createLuks: op(5): executing: "udevadm" "trigger" "--settle" "/dev/vdb9" Aug 5 22:14:37.645258 ignition[782]: disks: createLuks: op(5): [finished] waiting for triggered uevent Aug 5 22:14:37.645291 ignition[782]: disks: createFilesystems: op(6): [started] waiting for devices [/dev/mapper/rootencrypted] Aug 5 22:14:37.649729 ignition[782]: disks: createFilesystems: op(6): [finished] waiting for devices [/dev/mapper/rootencrypted] Aug 5 22:14:37.649794 ignition[782]: disks: createFilesystems: created device alias for "/dev/mapper/rootencrypted": "/run/ignition/dev_aliases/dev/mapper/rootencrypted" -> "/dev/dm-1" Aug 5 22:14:37.650821 ignition[782]: disks: createFilesystems: op(7): [started] determining filesystem type of "/dev/mapper/rootencrypted" Aug 5 22:14:37.664893 ignition[782]: disks: createFilesystems: op(7): [finished] determining filesystem type of "/dev/mapper/rootencrypted" Aug 5 22:14:37.664908 ignition[782]: disks: createFilesystems: found filesystem at "/dev/mapper/rootencrypted" with uuid "" and label "" Aug 5 22:14:37.664940 ignition[782]: disks: createFilesystems: op(8): [started] wiping filesystem signatures from "/run/ignition/dev_aliases/dev/mapper/rootencrypted" Aug 5 22:14:37.664948 ignition[782]: disks: createFilesystems: op(8): executing: "wipefs" "-a" "/run/ignition/dev_aliases/dev/mapper/rootencrypted" Aug 5 22:14:37.671886 ignition[782]: disks: createFilesystems: op(8): [finished] wiping filesystem signatures from "/run/ignition/dev_aliases/dev/mapper/rootencrypted" Aug 5 22:14:37.671931 ignition[782]: disks: createFilesystems: op(9): [started] creating "ext4" filesystem on "/run/ignition/dev_aliases/dev/mapper/rootencrypted" Aug 5 22:14:37.671940 ignition[782]: disks: createFilesystems: op(9): executing: "mkfs.ext4" "-F" "-L" "ROOT" "/run/ignition/dev_aliases/dev/mapper/rootencrypted" Aug 5 22:14:37.770776 ignition[782]: disks: createFilesystems: op(9): [finished] creating "ext4" filesystem on "/run/ignition/dev_aliases/dev/mapper/rootencrypted" Aug 5 22:14:37.770840 ignition[782]: disks: createFilesystems: op(a): [started] waiting for triggered uevent Aug 5 22:14:37.770846 ignition[782]: disks: createFilesystems: op(a): executing: "udevadm" "trigger" "--settle" "/dev/dm-1" Aug 5 22:14:37.791380 ignition[782]: disks: createFilesystems: op(a): [finished] waiting for triggered uevent Aug 5 22:14:37.791398 ignition[782]: disks: disks passed Aug 5 22:14:37.791485 ignition[782]: Ignition finished successfully Aug 5 22:14:37.794679 systemd[1]: Finished ignition-disks.service - Ignition (disks). Aug 5 22:14:37.798812 systemd[1]: Reached target initrd-root-device.target - Initrd Root Device. Aug 5 22:14:37.799664 systemd[1]: Reached target local-fs-pre.target - Preparation for Local File Systems. Aug 5 22:14:37.801265 systemd[1]: Reached target local-fs.target - Local File Systems. Aug 5 22:14:37.802921 systemd[1]: Reached target sysinit.target - System Initialization. Aug 5 22:14:37.804563 systemd[1]: Reached target basic.target - Basic System. Aug 5 22:14:37.813502 systemd[1]: Starting systemd-fsck-root.service - File System Check on /dev/disk/by-label/ROOT... Aug 5 22:14:37.827046 systemd-fsck[1588]: ROOT: clean, 11/137360 files, 26629/549376 blocks Aug 5 22:14:37.830647 systemd[1]: Finished systemd-fsck-root.service - File System Check on /dev/disk/by-label/ROOT. Aug 5 22:14:37.832437 systemd[1]: Mounting sysroot.mount - /sysroot... Aug 5 22:14:37.877370 kernel: EXT4-fs (dm-1): mounted filesystem 306d9b36-dfb2-4196-ac47-05782b256d27 r/w with ordered data mode. Quota mode: none. Aug 5 22:14:37.878035 systemd[1]: Mounted sysroot.mount - /sysroot. Aug 5 22:14:37.879266 systemd[1]: Reached target initrd-root-fs.target - Initrd Root File System. Aug 5 22:14:37.899420 systemd[1]: Mounting sysroot-oem.mount - /sysroot/oem... Aug 5 22:14:37.900957 systemd[1]: Mounting sysroot-usr.mount - /sysroot/usr... Aug 5 22:14:37.901893 systemd[1]: flatcar-metadata-hostname.service - Flatcar Metadata Hostname Agent was skipped because no trigger condition checks were met. Aug 5 22:14:37.901935 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:14:37.901956 systemd[1]: Reached target ignition-diskful.target - Ignition Boot Disk Setup. Aug 5 22:14:37.907694 systemd[1]: Mounted sysroot-usr.mount - /sysroot/usr. Aug 5 22:14:37.909349 systemd[1]: Starting initrd-setup-root.service - Root filesystem setup... Aug 5 22:14:37.916345 kernel: BTRFS: device label OEM devid 1 transid 13 /dev/vdb6 scanned by mount (1597) Aug 5 22:14:37.916381 kernel: BTRFS info (device vdb6): first mount of filesystem 47327e03-a391-4166-b35e-18ba93a1f298 Aug 5 22:14:37.916392 kernel: BTRFS info (device vdb6): using crc32c (crc32c-generic) checksum algorithm Aug 5 22:14:37.916402 kernel: BTRFS info (device vdb6): using free space tree Aug 5 22:14:37.918338 kernel: BTRFS info (device vdb6): auto enabling async discard Aug 5 22:14:37.919315 systemd[1]: Mounted sysroot-oem.mount - /sysroot/oem. Aug 5 22:14:37.925839 initrd-setup-root[1621]: cut: /sysroot/etc/passwd: No such file or directory Aug 5 22:14:37.928969 initrd-setup-root[1628]: cut: /sysroot/etc/group: No such file or directory Aug 5 22:14:37.933050 initrd-setup-root[1635]: cut: /sysroot/etc/shadow: No such file or directory Aug 5 22:14:37.935959 initrd-setup-root[1642]: cut: /sysroot/etc/gshadow: No such file or directory Aug 5 22:14:38.002874 systemd[1]: Finished initrd-setup-root.service - Root filesystem setup. Aug 5 22:14:38.015423 systemd[1]: Starting ignition-mount.service - Ignition (mount)... Aug 5 22:14:38.016801 systemd[1]: Starting sysroot-boot.service - /sysroot/boot... Aug 5 22:14:38.026264 systemd[1]: sysroot-oem.mount: Deactivated successfully. Aug 5 22:14:38.028177 kernel: BTRFS info (device vdb6): last unmount of filesystem 47327e03-a391-4166-b35e-18ba93a1f298 Aug 5 22:14:38.040814 systemd[1]: Finished sysroot-boot.service - /sysroot/boot. Aug 5 22:14:38.044863 ignition[1711]: INFO : Ignition 2.18.0 Aug 5 22:14:38.044863 ignition[1711]: INFO : Stage: mount Aug 5 22:14:38.047043 ignition[1711]: INFO : no configs at "/usr/lib/ignition/base.d" Aug 5 22:14:38.047043 ignition[1711]: INFO : no config dir at "/usr/lib/ignition/base.platform.d/qemu" Aug 5 22:14:38.047043 ignition[1711]: INFO : mount: mount passed Aug 5 22:14:38.047043 ignition[1711]: INFO : Ignition finished successfully Aug 5 22:14:38.047402 systemd[1]: Finished ignition-mount.service - Ignition (mount). Aug 5 22:14:38.054431 systemd[1]: Starting ignition-files.service - Ignition (files)... Aug 5 22:14:38.888477 systemd[1]: Mounting sysroot-oem.mount - /sysroot/oem... Aug 5 22:14:38.894890 kernel: BTRFS: device label OEM devid 1 transid 14 /dev/vdb6 scanned by mount (1724) Aug 5 22:14:38.894926 kernel: BTRFS info (device vdb6): first mount of filesystem 47327e03-a391-4166-b35e-18ba93a1f298 Aug 5 22:14:38.894938 kernel: BTRFS info (device vdb6): using crc32c (crc32c-generic) checksum algorithm Aug 5 22:14:38.895677 kernel: BTRFS info (device vdb6): using free space tree Aug 5 22:14:38.898342 kernel: BTRFS info (device vdb6): auto enabling async discard Aug 5 22:14:38.899119 systemd[1]: Mounted sysroot-oem.mount - /sysroot/oem. Aug 5 22:14:38.919963 ignition[1741]: INFO : Ignition 2.18.0 Aug 5 22:14:38.920946 ignition[1741]: INFO : Stage: files Aug 5 22:14:38.920946 ignition[1741]: INFO : no configs at "/usr/lib/ignition/base.d" Aug 5 22:14:38.920946 ignition[1741]: INFO : no config dir at "/usr/lib/ignition/base.platform.d/qemu" Aug 5 22:14:38.923757 ignition[1741]: DEBUG : files: compiled without relabeling support, skipping Aug 5 22:14:38.923757 ignition[1741]: INFO : files: ensureUsers: op(1): [started] creating or modifying user "core" Aug 5 22:14:38.923757 ignition[1741]: DEBUG : files: ensureUsers: op(1): executing: "usermod" "--root" "/sysroot" "core" Aug 5 22:14:38.923757 ignition[1741]: INFO : files: ensureUsers: op(1): [finished] creating or modifying user "core" Aug 5 22:14:38.928657 ignition[1741]: INFO : files: ensureUsers: op(2): [started] adding ssh keys to user "core" Aug 5 22:14:38.928657 ignition[1741]: INFO : files: ensureUsers: op(2): [finished] adding ssh keys to user "core" Aug 5 22:14:38.928657 ignition[1741]: INFO : files: createFilesystemsFiles: createFiles: op(3): [started] writing file "/sysroot/etc/flatcar/update.conf" Aug 5 22:14:38.928657 ignition[1741]: INFO : files: createFilesystemsFiles: createFiles: op(3): [finished] writing file "/sysroot/etc/flatcar/update.conf" Aug 5 22:14:38.928657 ignition[1741]: INFO : files: op(4): [started] processing unit "cryptenroll-helper-first.service" Aug 5 22:14:38.928657 ignition[1741]: INFO : files: op(4): op(5): [started] writing unit "cryptenroll-helper-first.service" at "/sysroot/etc/systemd/system/cryptenroll-helper-first.service" Aug 5 22:14:38.928657 ignition[1741]: INFO : files: op(4): op(5): [finished] writing unit "cryptenroll-helper-first.service" at "/sysroot/etc/systemd/system/cryptenroll-helper-first.service" Aug 5 22:14:38.928657 ignition[1741]: INFO : files: op(4): [finished] processing unit "cryptenroll-helper-first.service" Aug 5 22:14:38.928657 ignition[1741]: INFO : files: op(6): [started] processing unit "cryptenroll-helper-bind.service" Aug 5 22:14:38.928657 ignition[1741]: INFO : files: op(6): op(7): [started] writing unit "cryptenroll-helper-bind.service" at "/sysroot/etc/systemd/system/cryptenroll-helper-bind.service" Aug 5 22:14:38.928657 ignition[1741]: INFO : files: op(6): op(7): [finished] writing unit "cryptenroll-helper-bind.service" at "/sysroot/etc/systemd/system/cryptenroll-helper-bind.service" Aug 5 22:14:38.928657 ignition[1741]: INFO : files: op(6): [finished] processing unit "cryptenroll-helper-bind.service" Aug 5 22:14:38.928657 ignition[1741]: INFO : files: op(8): [started] processing unit "coreos-metadata.service" Aug 5 22:14:38.928657 ignition[1741]: INFO : files: op(8): op(9): [started] writing unit "coreos-metadata.service" at "/sysroot/etc/systemd/system/coreos-metadata.service" Aug 5 22:14:38.928657 ignition[1741]: INFO : files: op(8): op(9): [finished] writing unit "coreos-metadata.service" at "/sysroot/etc/systemd/system/coreos-metadata.service" Aug 5 22:14:38.928657 ignition[1741]: INFO : files: op(8): [finished] processing unit "coreos-metadata.service" Aug 5 22:14:38.928657 ignition[1741]: INFO : files: op(a): [started] setting preset to disabled for "coreos-metadata.service" Aug 5 22:14:38.924150 unknown[1741]: wrote ssh authorized keys file for user: core Aug 5 22:14:38.954798 ignition[1741]: INFO : files: op(a): op(b): [started] removing enablement symlink(s) for "coreos-metadata.service" Aug 5 22:14:38.954798 ignition[1741]: INFO : files: op(a): op(b): [finished] removing enablement symlink(s) for "coreos-metadata.service" Aug 5 22:14:38.954798 ignition[1741]: INFO : files: op(a): [finished] setting preset to disabled for "coreos-metadata.service" Aug 5 22:14:38.954798 ignition[1741]: INFO : files: op(c): [started] setting preset to enabled for "cryptenroll-helper-bind.service" Aug 5 22:14:38.954798 ignition[1741]: INFO : files: op(c): [finished] setting preset to enabled for "cryptenroll-helper-bind.service" Aug 5 22:14:38.954798 ignition[1741]: INFO : files: op(d): [started] setting preset to enabled for "cryptenroll-helper-first.service" Aug 5 22:14:38.954798 ignition[1741]: INFO : files: op(d): [finished] setting preset to enabled for "cryptenroll-helper-first.service" Aug 5 22:14:38.954798 ignition[1741]: INFO : files: createCrypttabEntries: createFiles: op(e): [started] writing file "/sysroot/etc/luks/rootencrypted" Aug 5 22:14:38.954798 ignition[1741]: INFO : files: createCrypttabEntries: createFiles: op(e): [finished] writing file "/sysroot/etc/luks/rootencrypted" Aug 5 22:14:38.954798 ignition[1741]: INFO : files: createCrypttabEntries: createFiles: op(f): [started] writing file "/sysroot/etc/crypttab" Aug 5 22:14:38.954798 ignition[1741]: INFO : files: createCrypttabEntries: createFiles: op(f): [finished] writing file "/sysroot/etc/crypttab" Aug 5 22:14:38.954798 ignition[1741]: INFO : files: createCrypttabEntries: createFiles: op(10): [started] appending to file "/sysroot/etc/crypttab" Aug 5 22:14:38.954798 ignition[1741]: INFO : files: createCrypttabEntries: createFiles: op(10): [finished] appending to file "/sysroot/etc/crypttab" Aug 5 22:14:38.954798 ignition[1741]: INFO : files: createResultFile: createFiles: op(11): [started] writing file "/sysroot/etc/.ignition-result.json" Aug 5 22:14:38.954798 ignition[1741]: INFO : files: createResultFile: createFiles: op(11): [finished] writing file "/sysroot/etc/.ignition-result.json" Aug 5 22:14:38.954798 ignition[1741]: INFO : files: files passed Aug 5 22:14:38.954798 ignition[1741]: INFO : Ignition finished successfully Aug 5 22:14:38.945511 systemd[1]: Finished ignition-files.service - Ignition (files). Aug 5 22:14:38.957469 systemd[1]: Starting ignition-quench.service - Ignition (record completion)... Aug 5 22:14:38.959169 systemd[1]: Starting initrd-setup-root-after-ignition.service - Root filesystem completion... Aug 5 22:14:38.960857 systemd[1]: ignition-quench.service: Deactivated successfully. Aug 5 22:14:38.986453 initrd-setup-root-after-ignition[1770]: grep: /sysroot/oem/oem-release: No such file or directory Aug 5 22:14:38.960934 systemd[1]: Finished ignition-quench.service - Ignition (record completion). Aug 5 22:14:38.988494 initrd-setup-root-after-ignition[1772]: grep: /sysroot/etc/flatcar/enabled-sysext.conf: No such file or directory Aug 5 22:14:38.988494 initrd-setup-root-after-ignition[1772]: grep: /sysroot/usr/share/flatcar/enabled-sysext.conf: No such file or directory Aug 5 22:14:38.971135 systemd[1]: Finished initrd-setup-root-after-ignition.service - Root filesystem completion. Aug 5 22:14:38.992309 initrd-setup-root-after-ignition[1776]: grep: /sysroot/etc/flatcar/enabled-sysext.conf: No such file or directory Aug 5 22:14:38.973523 systemd[1]: Reached target ignition-complete.target - Ignition Complete. Aug 5 22:14:38.976186 systemd[1]: Starting initrd-parse-etc.service - Mountpoints Configured in the Real Root... Aug 5 22:14:39.000264 systemd[1]: initrd-parse-etc.service: Deactivated successfully. Aug 5 22:14:39.000424 systemd[1]: Finished initrd-parse-etc.service - Mountpoints Configured in the Real Root. Aug 5 22:14:39.002438 systemd[1]: Reached target initrd-fs.target - Initrd File Systems. Aug 5 22:14:39.004016 systemd[1]: Reached target initrd.target - Initrd Default Target. Aug 5 22:14:39.005456 systemd[1]: dracut-mount.service - dracut mount hook was skipped because no trigger condition checks were met. Aug 5 22:14:39.006183 systemd[1]: Starting dracut-pre-pivot.service - dracut pre-pivot and cleanup hook... Aug 5 22:14:39.020449 systemd[1]: Finished dracut-pre-pivot.service - dracut pre-pivot and cleanup hook. Aug 5 22:14:39.035498 systemd[1]: Starting initrd-cleanup.service - Cleaning Up and Shutting Down Daemons... Aug 5 22:14:39.042832 systemd[1]: Stopped target network.target - Network. Aug 5 22:14:39.043727 systemd[1]: Stopped target nss-lookup.target - Host and Network Name Lookups. Aug 5 22:14:39.045243 systemd[1]: Stopped target remote-cryptsetup.target - Remote Encrypted Volumes. Aug 5 22:14:39.046992 systemd[1]: Stopped target timers.target - Timer Units. Aug 5 22:14:39.048581 systemd[1]: dracut-pre-pivot.service: Deactivated successfully. Aug 5 22:14:39.048697 systemd[1]: Stopped dracut-pre-pivot.service - dracut pre-pivot and cleanup hook. Aug 5 22:14:39.051166 systemd[1]: Stopped target initrd.target - Initrd Default Target. Aug 5 22:14:39.053080 systemd[1]: Stopped target basic.target - Basic System. Aug 5 22:14:39.054695 systemd[1]: Stopped target ignition-complete.target - Ignition Complete. Aug 5 22:14:39.056166 systemd[1]: Stopped target ignition-diskful.target - Ignition Boot Disk Setup. Aug 5 22:14:39.057885 systemd[1]: Stopped target initrd-root-device.target - Initrd Root Device. Aug 5 22:14:39.059825 systemd[1]: Stopped target remote-fs.target - Remote File Systems. Aug 5 22:14:39.061467 systemd[1]: Stopped target remote-fs-pre.target - Preparation for Remote File Systems. Aug 5 22:14:39.063248 systemd[1]: Stopped target sysinit.target - System Initialization. Aug 5 22:14:39.064949 systemd[1]: Stopped target local-fs.target - Local File Systems. Aug 5 22:14:39.066618 systemd[1]: Stopped target swap.target - Swaps. Aug 5 22:14:39.068112 systemd[1]: dracut-pre-mount.service: Deactivated successfully. Aug 5 22:14:39.068235 systemd[1]: Stopped dracut-pre-mount.service - dracut pre-mount hook. Aug 5 22:14:39.070388 systemd[1]: Stopped target cryptsetup.target - Local Encrypted Volumes. Aug 5 22:14:39.072377 systemd[1]: Stopped target cryptsetup-pre.target - Local Encrypted Volumes (Pre). Aug 5 22:14:39.074275 systemd[1]: clevis-luks-askpass.path: Deactivated successfully. Aug 5 22:14:39.075403 systemd[1]: Stopped clevis-luks-askpass.path - Forward Password Requests to Clevis Directory Watch. Aug 5 22:14:39.077140 systemd[1]: dracut-initqueue.service: Deactivated successfully. Aug 5 22:14:39.077249 systemd[1]: Stopped dracut-initqueue.service - dracut initqueue hook. Aug 5 22:14:39.080004 systemd[1]: ignition-fetch-offline.service: Deactivated successfully. Aug 5 22:14:39.080122 systemd[1]: Stopped ignition-fetch-offline.service - Ignition (fetch-offline). Aug 5 22:14:39.081803 systemd[1]: Stopped target paths.target - Path Units. Aug 5 22:14:39.083397 systemd[1]: systemd-ask-password-console.path: Deactivated successfully. Aug 5 22:14:39.083498 systemd[1]: Stopped systemd-ask-password-console.path - Dispatch Password Requests to Console Directory Watch. Aug 5 22:14:39.085225 systemd[1]: Stopped target slices.target - Slice Units. Aug 5 22:14:39.086684 systemd[1]: Stopped target sockets.target - Socket Units. Aug 5 22:14:39.088306 systemd[1]: iscsid.socket: Deactivated successfully. Aug 5 22:14:39.088412 systemd[1]: Closed iscsid.socket - Open-iSCSI iscsid Socket. Aug 5 22:14:39.090231 systemd[1]: iscsiuio.socket: Deactivated successfully. Aug 5 22:14:39.090313 systemd[1]: Closed iscsiuio.socket - Open-iSCSI iscsiuio Socket. Aug 5 22:14:39.091837 systemd[1]: initrd-setup-root-after-ignition.service: Deactivated successfully. Aug 5 22:14:39.091940 systemd[1]: Stopped initrd-setup-root-after-ignition.service - Root filesystem completion. Aug 5 22:14:39.093537 systemd[1]: ignition-files.service: Deactivated successfully. Aug 5 22:14:39.093640 systemd[1]: Stopped ignition-files.service - Ignition (files). Aug 5 22:14:39.105524 systemd[1]: Stopping ignition-mount.service - Ignition (mount)... Aug 5 22:14:39.106266 systemd[1]: kmod-static-nodes.service: Deactivated successfully. Aug 5 22:14:39.106410 systemd[1]: Stopped kmod-static-nodes.service - Create List of Static Device Nodes. Aug 5 22:14:39.111630 systemd[1]: Stopping sysroot-boot.service - /sysroot/boot... Aug 5 22:14:39.112507 systemd[1]: Stopping systemd-networkd.service - Network Configuration... Aug 5 22:14:39.113953 systemd[1]: Stopping systemd-resolved.service - Network Name Resolution... Aug 5 22:14:39.117390 ignition[1797]: INFO : Ignition 2.18.0 Aug 5 22:14:39.117390 ignition[1797]: INFO : Stage: umount Aug 5 22:14:39.117390 ignition[1797]: INFO : no configs at "/usr/lib/ignition/base.d" Aug 5 22:14:39.117390 ignition[1797]: INFO : no config dir at "/usr/lib/ignition/base.platform.d/qemu" Aug 5 22:14:39.117390 ignition[1797]: INFO : umount: umount passed Aug 5 22:14:39.117390 ignition[1797]: INFO : Ignition finished successfully Aug 5 22:14:39.116923 systemd[1]: systemd-udev-trigger.service: Deactivated successfully. Aug 5 22:14:39.117050 systemd[1]: Stopped systemd-udev-trigger.service - Coldplug All udev Devices. Aug 5 22:14:39.118881 systemd[1]: dracut-pre-trigger.service: Deactivated successfully. Aug 5 22:14:39.118971 systemd[1]: Stopped dracut-pre-trigger.service - dracut pre-trigger hook. Aug 5 22:14:39.120820 systemd-networkd[766]: eth0: DHCPv6 lease lost Aug 5 22:14:39.124569 systemd[1]: sysroot-boot.mount: Deactivated successfully. Aug 5 22:14:39.125098 systemd[1]: systemd-resolved.service: Deactivated successfully. Aug 5 22:14:39.125185 systemd[1]: Stopped systemd-resolved.service - Network Name Resolution. Aug 5 22:14:39.128554 systemd[1]: systemd-networkd.service: Deactivated successfully. Aug 5 22:14:39.128654 systemd[1]: Stopped systemd-networkd.service - Network Configuration. Aug 5 22:14:39.130690 systemd[1]: ignition-mount.service: Deactivated successfully. Aug 5 22:14:39.131380 systemd[1]: Stopped ignition-mount.service - Ignition (mount). Aug 5 22:14:39.133186 systemd[1]: sysroot-boot.service: Deactivated successfully. Aug 5 22:14:39.133267 systemd[1]: Stopped sysroot-boot.service - /sysroot/boot. Aug 5 22:14:39.135713 systemd[1]: initrd-cleanup.service: Deactivated successfully. Aug 5 22:14:39.135802 systemd[1]: Finished initrd-cleanup.service - Cleaning Up and Shutting Down Daemons. Aug 5 22:14:39.138863 systemd[1]: systemd-networkd.socket: Deactivated successfully. Aug 5 22:14:39.138904 systemd[1]: Closed systemd-networkd.socket - Network Service Netlink Socket. Aug 5 22:14:39.140720 systemd[1]: ignition-disks.service: Deactivated successfully. Aug 5 22:14:39.140766 systemd[1]: Stopped ignition-disks.service - Ignition (disks). Aug 5 22:14:39.142398 systemd[1]: ignition-kargs.service: Deactivated successfully. Aug 5 22:14:39.142444 systemd[1]: Stopped ignition-kargs.service - Ignition (kargs). Aug 5 22:14:39.143967 systemd[1]: ignition-setup.service: Deactivated successfully. Aug 5 22:14:39.144006 systemd[1]: Stopped ignition-setup.service - Ignition (setup). Aug 5 22:14:39.145468 systemd[1]: ignition-setup-pre.service: Deactivated successfully. Aug 5 22:14:39.145509 systemd[1]: Stopped ignition-setup-pre.service - Ignition env setup. Aug 5 22:14:39.147063 systemd[1]: initrd-setup-root.service: Deactivated successfully. Aug 5 22:14:39.147105 systemd[1]: Stopped initrd-setup-root.service - Root filesystem setup. Aug 5 22:14:39.166428 systemd[1]: Stopping network-cleanup.service - Network Cleanup... Aug 5 22:14:39.167237 systemd[1]: parse-ip-for-networkd.service: Deactivated successfully. Aug 5 22:14:39.167294 systemd[1]: Stopped parse-ip-for-networkd.service - Write systemd-networkd units from cmdline. Aug 5 22:14:39.169310 systemd[1]: systemd-sysctl.service: Deactivated successfully. Aug 5 22:14:39.169374 systemd[1]: Stopped systemd-sysctl.service - Apply Kernel Variables. Aug 5 22:14:39.171179 systemd[1]: systemd-modules-load.service: Deactivated successfully. Aug 5 22:14:39.171223 systemd[1]: Stopped systemd-modules-load.service - Load Kernel Modules. Aug 5 22:14:39.173222 systemd[1]: systemd-tmpfiles-setup.service: Deactivated successfully. Aug 5 22:14:39.173266 systemd[1]: Stopped systemd-tmpfiles-setup.service - Create Volatile Files and Directories. Aug 5 22:14:39.175171 systemd[1]: Stopping systemd-udevd.service - Rule-based Manager for Device Events and Files... Aug 5 22:14:39.183996 systemd[1]: network-cleanup.service: Deactivated successfully. Aug 5 22:14:39.184110 systemd[1]: Stopped network-cleanup.service - Network Cleanup. Aug 5 22:14:39.186175 systemd[1]: systemd-udevd.service: Deactivated successfully. Aug 5 22:14:39.186306 systemd[1]: Stopped systemd-udevd.service - Rule-based Manager for Device Events and Files. Aug 5 22:14:39.188431 systemd[1]: systemd-udevd-control.socket: Deactivated successfully. Aug 5 22:14:39.188500 systemd[1]: Closed systemd-udevd-control.socket - udev Control Socket. Aug 5 22:14:39.189619 systemd[1]: systemd-udevd-kernel.socket: Deactivated successfully. Aug 5 22:14:39.189656 systemd[1]: Closed systemd-udevd-kernel.socket - udev Kernel Socket. Aug 5 22:14:39.191620 systemd[1]: dracut-pre-udev.service: Deactivated successfully. Aug 5 22:14:39.191667 systemd[1]: Stopped dracut-pre-udev.service - dracut pre-udev hook. Aug 5 22:14:39.194231 systemd[1]: dracut-cmdline.service: Deactivated successfully. Aug 5 22:14:39.194274 systemd[1]: Stopped dracut-cmdline.service - dracut cmdline hook. Aug 5 22:14:39.196975 systemd[1]: dracut-cmdline-ask.service: Deactivated successfully. Aug 5 22:14:39.197023 systemd[1]: Stopped dracut-cmdline-ask.service - dracut ask for additional cmdline parameters. Aug 5 22:14:39.200440 systemd[1]: Starting initrd-udevadm-cleanup-db.service - Cleanup udev Database... Aug 5 22:14:39.201451 systemd[1]: systemd-tmpfiles-setup-dev.service: Deactivated successfully. Aug 5 22:14:39.201505 systemd[1]: Stopped systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev. Aug 5 22:14:39.203409 systemd[1]: systemd-vconsole-setup.service: Deactivated successfully. Aug 5 22:14:39.203461 systemd[1]: Stopped systemd-vconsole-setup.service - Virtual Console Setup. Aug 5 22:14:39.209594 systemd[1]: initrd-udevadm-cleanup-db.service: Deactivated successfully. Aug 5 22:14:39.211611 systemd[1]: Finished initrd-udevadm-cleanup-db.service - Cleanup udev Database. Aug 5 22:14:39.212927 systemd[1]: Reached target initrd-switch-root.target - Switch Root. Aug 5 22:14:39.227483 systemd[1]: Starting initrd-switch-root.service - Switch Root... Aug 5 22:14:39.234308 systemd[1]: Switching root. Aug 5 22:14:39.258567 systemd-journald[236]: Journal stopped Aug 5 22:14:39.848986 systemd-journald[236]: Received SIGTERM from PID 1 (systemd). Aug 5 22:14:39.849036 kernel: SELinux: policy capability network_peer_controls=1 Aug 5 22:14:39.849052 kernel: SELinux: policy capability open_perms=1 Aug 5 22:14:39.849062 kernel: SELinux: policy capability extended_socket_class=1 Aug 5 22:14:39.849072 kernel: SELinux: policy capability always_check_network=0 Aug 5 22:14:39.849081 kernel: SELinux: policy capability cgroup_seclabel=1 Aug 5 22:14:39.849091 kernel: SELinux: policy capability nnp_nosuid_transition=1 Aug 5 22:14:39.849101 kernel: SELinux: policy capability genfs_seclabel_symlinks=0 Aug 5 22:14:39.849114 kernel: SELinux: policy capability ioctl_skip_cloexec=0 Aug 5 22:14:39.849126 kernel: audit: type=1403 audit(1722896079.323:2): auid=4294967295 ses=4294967295 lsm=selinux res=1 Aug 5 22:14:39.849137 systemd[1]: Successfully loaded SELinux policy in 31.029ms. Aug 5 22:14:39.849158 systemd[1]: Relabeled /dev, /dev/shm, /run, /sys/fs/cgroup in 9.669ms. Aug 5 22:14:39.849170 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:14:39.849183 systemd[1]: Detected virtualization kvm. Aug 5 22:14:39.849194 systemd[1]: Detected architecture arm64. Aug 5 22:14:39.849204 systemd[1]: Detected first boot. Aug 5 22:14:39.849214 systemd[1]: Initializing machine ID from VM UUID. Aug 5 22:14:39.849225 zram_generator::config[1841]: No configuration found. Aug 5 22:14:39.849236 systemd[1]: Populated /etc with preset unit settings. Aug 5 22:14:39.849246 systemd[1]: initrd-switch-root.service: Deactivated successfully. Aug 5 22:14:39.849257 systemd[1]: Stopped initrd-switch-root.service - Switch Root. Aug 5 22:14:39.849267 systemd[1]: systemd-journald.service: Scheduled restart job, restart counter is at 1. Aug 5 22:14:39.849280 systemd[1]: Created slice system-addon\x2dconfig.slice - Slice /system/addon-config. Aug 5 22:14:39.849291 systemd[1]: Created slice system-addon\x2drun.slice - Slice /system/addon-run. Aug 5 22:14:39.849302 systemd[1]: Created slice system-getty.slice - Slice /system/getty. Aug 5 22:14:39.849312 systemd[1]: Created slice system-modprobe.slice - Slice /system/modprobe. Aug 5 22:14:39.849382 systemd[1]: Created slice system-serial\x2dgetty.slice - Slice /system/serial-getty. Aug 5 22:14:39.849396 systemd[1]: Created slice system-system\x2dcloudinit.slice - Slice /system/system-cloudinit. Aug 5 22:14:39.849406 systemd[1]: Created slice system-systemd\x2dcryptsetup.slice - Encrypted Volume Units Service Slice. Aug 5 22:14:39.849422 systemd[1]: Created slice system-systemd\x2dfsck.slice - Slice /system/systemd-fsck. Aug 5 22:14:39.849435 systemd[1]: Created slice user.slice - User and Session Slice. Aug 5 22:14:39.849446 systemd[1]: Started clevis-luks-askpass.path - Forward Password Requests to Clevis Directory Watch. Aug 5 22:14:39.849456 systemd[1]: Started systemd-ask-password-console.path - Dispatch Password Requests to Console Directory Watch. Aug 5 22:14:39.849467 systemd[1]: Started systemd-ask-password-wall.path - Forward Password Requests to Wall Directory Watch. Aug 5 22:14:39.849477 systemd[1]: Set up automount boot.automount - Boot partition Automount Point. Aug 5 22:14:39.849488 systemd[1]: Set up automount proc-sys-fs-binfmt_misc.automount - Arbitrary Executable File Formats File System Automount Point. Aug 5 22:14:39.849500 systemd[1]: Expecting device dev-disk-by\x2dlabel-OEM.device - /dev/disk/by-label/OEM... Aug 5 22:14:39.849512 systemd[1]: Expecting device dev-disk-by\x2duuid-dfb25628\x2de29b\x2d470b\x2d9f0e\x2d77bf2c42124a.device - /dev/disk/by-uuid/dfb25628-e29b-470b-9f0e-77bf2c42124a... Aug 5 22:14:39.849523 systemd[1]: Expecting device dev-ttyAMA0.device - /dev/ttyAMA0... Aug 5 22:14:39.849535 systemd[1]: Reached target cryptsetup-pre.target - Local Encrypted Volumes (Pre). Aug 5 22:14:39.849546 systemd[1]: Stopped target initrd-switch-root.target - Switch Root. Aug 5 22:14:39.849556 systemd[1]: Stopped target initrd-fs.target - Initrd File Systems. Aug 5 22:14:39.849567 systemd[1]: Stopped target initrd-root-fs.target - Initrd Root File System. Aug 5 22:14:39.849578 systemd[1]: Reached target integritysetup.target - Local Integrity Protected Volumes. Aug 5 22:14:39.849589 systemd[1]: Reached target remote-cryptsetup.target - Remote Encrypted Volumes. Aug 5 22:14:39.849599 systemd[1]: Reached target remote-fs.target - Remote File Systems. Aug 5 22:14:39.849612 systemd[1]: Reached target slices.target - Slice Units. Aug 5 22:14:39.849623 systemd[1]: Reached target swap.target - Swaps. Aug 5 22:14:39.849634 systemd[1]: Reached target veritysetup.target - Local Verity Protected Volumes. Aug 5 22:14:39.849645 systemd[1]: Listening on systemd-coredump.socket - Process Core Dump Socket. Aug 5 22:14:39.849655 systemd[1]: Listening on systemd-networkd.socket - Network Service Netlink Socket. Aug 5 22:14:39.849666 systemd[1]: Listening on systemd-udevd-control.socket - udev Control Socket. Aug 5 22:14:39.849677 systemd[1]: Listening on systemd-udevd-kernel.socket - udev Kernel Socket. Aug 5 22:14:39.849687 systemd[1]: Listening on systemd-userdbd.socket - User Database Manager Socket. Aug 5 22:14:39.849698 systemd[1]: Mounting dev-hugepages.mount - Huge Pages File System... Aug 5 22:14:39.849709 systemd[1]: Mounting dev-mqueue.mount - POSIX Message Queue File System... Aug 5 22:14:39.849727 systemd[1]: Mounting media.mount - External Media Directory... Aug 5 22:14:39.849739 systemd[1]: Mounting sys-kernel-debug.mount - Kernel Debug File System... Aug 5 22:14:39.849750 systemd[1]: Mounting sys-kernel-tracing.mount - Kernel Trace File System... Aug 5 22:14:39.849761 systemd[1]: Mounting tmp.mount - Temporary Directory /tmp... Aug 5 22:14:39.849772 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:14:39.849783 systemd[1]: Reached target machines.target - Containers. Aug 5 22:14:39.849794 systemd[1]: Starting flatcar-tmpfiles.service - Create missing system files... Aug 5 22:14:39.849804 systemd[1]: ignition-delete-config.service - Ignition (delete config) was skipped because no trigger condition checks were met. Aug 5 22:14:39.849817 systemd[1]: Starting kmod-static-nodes.service - Create List of Static Device Nodes... Aug 5 22:14:39.849827 systemd[1]: Starting modprobe@configfs.service - Load Kernel Module configfs... Aug 5 22:14:39.849838 systemd[1]: Starting modprobe@dm_mod.service - Load Kernel Module dm_mod... Aug 5 22:14:39.849849 systemd[1]: Starting modprobe@drm.service - Load Kernel Module drm... Aug 5 22:14:39.849859 systemd[1]: Starting modprobe@efi_pstore.service - Load Kernel Module efi_pstore... Aug 5 22:14:39.849870 systemd[1]: Starting modprobe@fuse.service - Load Kernel Module fuse... Aug 5 22:14:39.849881 systemd[1]: Starting modprobe@loop.service - Load Kernel Module loop... Aug 5 22:14:39.849891 systemd[1]: setup-nsswitch.service - Create /etc/nsswitch.conf was skipped because of an unmet condition check (ConditionPathExists=!/etc/nsswitch.conf). Aug 5 22:14:39.849909 systemd[1]: systemd-fsck-root.service: Deactivated successfully. Aug 5 22:14:39.849921 systemd[1]: Stopped systemd-fsck-root.service - File System Check on Root Device. Aug 5 22:14:39.849931 systemd[1]: systemd-fsck-usr.service: Deactivated successfully. Aug 5 22:14:39.849942 systemd[1]: Stopped systemd-fsck-usr.service. Aug 5 22:14:39.849967 systemd[1]: Starting systemd-journald.service - Journal Service... Aug 5 22:14:39.849978 kernel: fuse: init (API version 7.39) Aug 5 22:14:39.849989 kernel: loop: module loaded Aug 5 22:14:39.849999 systemd[1]: Starting systemd-modules-load.service - Load Kernel Modules... Aug 5 22:14:39.850010 systemd[1]: Starting systemd-network-generator.service - Generate network units from Kernel command line... Aug 5 22:14:39.850023 systemd[1]: Starting systemd-remount-fs.service - Remount Root and Kernel File Systems... Aug 5 22:14:39.850035 systemd[1]: Starting systemd-udev-trigger.service - Coldplug All udev Devices... Aug 5 22:14:39.850046 systemd[1]: verity-setup.service: Deactivated successfully. Aug 5 22:14:39.850056 systemd[1]: Stopped verity-setup.service. Aug 5 22:14:39.850067 systemd[1]: Mounted dev-hugepages.mount - Huge Pages File System. Aug 5 22:14:39.850079 kernel: ACPI: bus type drm_connector registered Aug 5 22:14:39.850090 systemd[1]: Mounted dev-mqueue.mount - POSIX Message Queue File System. Aug 5 22:14:39.850101 systemd[1]: Mounted media.mount - External Media Directory. Aug 5 22:14:39.850112 systemd[1]: Mounted sys-kernel-debug.mount - Kernel Debug File System. Aug 5 22:14:39.850143 systemd-journald[1900]: Collecting audit messages is disabled. Aug 5 22:14:39.850165 systemd-journald[1900]: Journal started Aug 5 22:14:39.850189 systemd-journald[1900]: Runtime Journal (/run/log/journal/34d35adb6cb64892a3f942ca92e347c0) is 5.9M, max 47.3M, 41.4M free. Aug 5 22:14:39.670624 systemd[1]: Queued start job for default target multi-user.target. Aug 5 22:14:39.684179 systemd[1]: Unnecessary job was removed for dev-vdb6.device - /dev/vdb6. Aug 5 22:14:39.684583 systemd[1]: systemd-journald.service: Deactivated successfully. Aug 5 22:14:39.853001 systemd[1]: Started systemd-journald.service - Journal Service. Aug 5 22:14:39.853630 systemd[1]: Mounted sys-kernel-tracing.mount - Kernel Trace File System. Aug 5 22:14:39.855181 systemd[1]: Mounted tmp.mount - Temporary Directory /tmp. Aug 5 22:14:39.856199 systemd[1]: Finished kmod-static-nodes.service - Create List of Static Device Nodes. Aug 5 22:14:39.859641 systemd[1]: modprobe@configfs.service: Deactivated successfully. Aug 5 22:14:39.859810 systemd[1]: Finished modprobe@configfs.service - Load Kernel Module configfs. Aug 5 22:14:39.861265 systemd[1]: modprobe@dm_mod.service: Deactivated successfully. Aug 5 22:14:39.861456 systemd[1]: Finished modprobe@dm_mod.service - Load Kernel Module dm_mod. Aug 5 22:14:39.862498 systemd[1]: modprobe@drm.service: Deactivated successfully. Aug 5 22:14:39.862617 systemd[1]: Finished modprobe@drm.service - Load Kernel Module drm. Aug 5 22:14:39.863829 systemd[1]: modprobe@efi_pstore.service: Deactivated successfully. Aug 5 22:14:39.863952 systemd[1]: Finished modprobe@efi_pstore.service - Load Kernel Module efi_pstore. Aug 5 22:14:39.865107 systemd[1]: modprobe@fuse.service: Deactivated successfully. Aug 5 22:14:39.865236 systemd[1]: Finished modprobe@fuse.service - Load Kernel Module fuse. Aug 5 22:14:39.866403 systemd[1]: modprobe@loop.service: Deactivated successfully. Aug 5 22:14:39.866542 systemd[1]: Finished modprobe@loop.service - Load Kernel Module loop. Aug 5 22:14:39.867918 systemd[1]: Finished flatcar-tmpfiles.service - Create missing system files. Aug 5 22:14:39.869271 systemd[1]: Finished systemd-modules-load.service - Load Kernel Modules. Aug 5 22:14:39.870637 systemd[1]: Finished systemd-network-generator.service - Generate network units from Kernel command line. Aug 5 22:14:39.872084 systemd[1]: Finished systemd-remount-fs.service - Remount Root and Kernel File Systems. Aug 5 22:14:39.884188 systemd[1]: Reached target network-pre.target - Preparation for Network. Aug 5 22:14:39.891459 systemd[1]: Mounting sys-fs-fuse-connections.mount - FUSE Control File System... Aug 5 22:14:39.893349 systemd[1]: Mounting sys-kernel-config.mount - Kernel Configuration File System... Aug 5 22:14:39.894375 systemd[1]: remount-root.service - Remount Root File System was skipped because of an unmet condition check (ConditionPathIsReadWrite=!/). Aug 5 22:14:39.894416 systemd[1]: Reached target local-fs.target - Local File Systems. Aug 5 22:14:39.896036 systemd[1]: Listening on systemd-sysext.socket - System Extension Image Management (Varlink). Aug 5 22:14:39.897950 systemd[1]: Starting dracut-shutdown.service - Restore /run/initramfs on shutdown... Aug 5 22:14:39.899857 systemd[1]: Starting ldconfig.service - Rebuild Dynamic Linker Cache... Aug 5 22:14:39.900888 systemd[1]: systemd-binfmt.service - Set Up Additional Binary Formats was skipped because no trigger condition checks were met. Aug 5 22:14:39.902363 systemd[1]: Starting systemd-hwdb-update.service - Rebuild Hardware Database... Aug 5 22:14:39.904382 systemd[1]: Starting systemd-journal-flush.service - Flush Journal to Persistent Storage... Aug 5 22:14:39.905562 systemd[1]: systemd-pstore.service - Platform Persistent Storage Archival was skipped because of an unmet condition check (ConditionDirectoryNotEmpty=/sys/fs/pstore). Aug 5 22:14:39.906512 systemd[1]: Starting systemd-random-seed.service - Load/Save OS Random Seed... Aug 5 22:14:39.907664 systemd[1]: systemd-repart.service - Repartition Root Disk was skipped because no trigger condition checks were met. Aug 5 22:14:39.911532 systemd[1]: Starting systemd-sysctl.service - Apply Kernel Variables... Aug 5 22:14:39.915647 systemd[1]: Starting systemd-sysext.service - Merge System Extension Images into /usr/ and /opt/... Aug 5 22:14:39.918394 systemd-journald[1900]: Time spent on flushing to /var/log/journal/34d35adb6cb64892a3f942ca92e347c0 is 18.763ms for 878 entries. Aug 5 22:14:39.918394 systemd-journald[1900]: System Journal (/var/log/journal/34d35adb6cb64892a3f942ca92e347c0) is 8.0M, max 204.2M, 196.1M free. Aug 5 22:14:39.942021 systemd-journald[1900]: Received client request to flush runtime journal. Aug 5 22:14:39.918637 systemd[1]: Starting systemd-sysusers.service - Create System Users... Aug 5 22:14:39.923360 systemd[1]: Finished systemd-udev-trigger.service - Coldplug All udev Devices. Aug 5 22:14:39.925115 systemd[1]: Mounted sys-fs-fuse-connections.mount - FUSE Control File System. Aug 5 22:14:39.926442 systemd[1]: Mounted sys-kernel-config.mount - Kernel Configuration File System. Aug 5 22:14:39.928183 systemd[1]: Finished dracut-shutdown.service - Restore /run/initramfs on shutdown. Aug 5 22:14:39.934501 systemd[1]: Starting systemd-udev-settle.service - Wait for udev To Complete Device Initialization... Aug 5 22:14:39.938357 systemd[1]: Finished systemd-random-seed.service - Load/Save OS Random Seed. Aug 5 22:14:39.940150 systemd[1]: Reached target first-boot-complete.target - First Boot Complete. Aug 5 22:14:39.950008 kernel: loop0: detected capacity change from 0 to 59688 Aug 5 22:14:39.950196 kernel: block loop0: the capability attribute has been deprecated. Aug 5 22:14:39.952589 systemd[1]: Starting systemd-machine-id-commit.service - Commit a transient machine-id on disk... Aug 5 22:14:39.954168 systemd[1]: Finished systemd-journal-flush.service - Flush Journal to Persistent Storage. Aug 5 22:14:39.970192 systemd[1]: Finished systemd-sysctl.service - Apply Kernel Variables. Aug 5 22:14:39.974208 udevadm[1959]: systemd-udev-settle.service is deprecated. Please fix lvm2-activation-early.service, lvm2-activation.service not to pull it in. Aug 5 22:14:39.975955 systemd[1]: etc-machine\x2did.mount: Deactivated successfully. Aug 5 22:14:39.976593 systemd[1]: Finished systemd-machine-id-commit.service - Commit a transient machine-id on disk. Aug 5 22:14:39.986389 kernel: squashfs: version 4.0 (2009/01/31) Phillip Lougher Aug 5 22:14:39.992496 systemd[1]: Finished systemd-sysusers.service - Create System Users. Aug 5 22:14:40.003488 systemd[1]: Starting systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev... Aug 5 22:14:40.010343 kernel: loop1: detected capacity change from 0 to 113672 Aug 5 22:14:40.027532 systemd-tmpfiles[1973]: ACLs are not supported, ignoring. Aug 5 22:14:40.027551 systemd-tmpfiles[1973]: ACLs are not supported, ignoring. Aug 5 22:14:40.031750 systemd[1]: Finished systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev. Aug 5 22:14:40.045254 kernel: loop2: detected capacity change from 0 to 59688 Aug 5 22:14:40.058349 kernel: loop3: detected capacity change from 0 to 113672 Aug 5 22:14:40.083608 (sd-merge)[1977]: Using extensions 'containerd-flatcar', 'docker-flatcar'. Aug 5 22:14:40.083971 (sd-merge)[1977]: Merged extensions into '/usr'. Aug 5 22:14:40.089366 systemd[1]: Finished systemd-sysext.service - Merge System Extension Images into /usr/ and /opt/. Aug 5 22:14:40.096485 systemd[1]: Starting ensure-sysext.service... Aug 5 22:14:40.098348 systemd[1]: Starting systemd-tmpfiles-setup.service - Create Volatile Files and Directories... Aug 5 22:14:40.110363 systemd[1]: Reloading requested from client PID 1979 ('systemctl') (unit ensure-sysext.service)... Aug 5 22:14:40.110405 systemd[1]: Reloading... Aug 5 22:14:40.129759 systemd-tmpfiles[1980]: /usr/lib/tmpfiles.d/provision.conf:20: Duplicate line for path "/root", ignoring. Aug 5 22:14:40.130063 systemd-tmpfiles[1980]: /usr/lib/tmpfiles.d/systemd-flatcar.conf:6: Duplicate line for path "/var/log/journal", ignoring. Aug 5 22:14:40.130709 systemd-tmpfiles[1980]: /usr/lib/tmpfiles.d/systemd.conf:29: Duplicate line for path "/var/lib/systemd", ignoring. Aug 5 22:14:40.130938 systemd-tmpfiles[1980]: ACLs are not supported, ignoring. Aug 5 22:14:40.130988 systemd-tmpfiles[1980]: ACLs are not supported, ignoring. Aug 5 22:14:40.133253 systemd-tmpfiles[1980]: Detected autofs mount point /boot during canonicalization of boot. Aug 5 22:14:40.133267 systemd-tmpfiles[1980]: Skipping /boot Aug 5 22:14:40.140073 systemd-tmpfiles[1980]: Detected autofs mount point /boot during canonicalization of boot. Aug 5 22:14:40.140088 systemd-tmpfiles[1980]: Skipping /boot Aug 5 22:14:40.175473 zram_generator::config[2004]: No configuration found. Aug 5 22:14:40.271214 ldconfig[1946]: /sbin/ldconfig: /lib/ld.so.conf is not an ELF file - it has the wrong magic bytes at the start. Aug 5 22:14:40.293668 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:14:40.337230 systemd[1]: Reloading finished in 226 ms. Aug 5 22:14:40.369289 systemd[1]: Finished ldconfig.service - Rebuild Dynamic Linker Cache. Aug 5 22:14:40.378687 systemd[1]: Finished systemd-tmpfiles-setup.service - Create Volatile Files and Directories. Aug 5 22:14:40.386517 systemd[1]: Starting audit-rules.service - Load Security Auditing Rules... Aug 5 22:14:40.388859 systemd[1]: Starting clean-ca-certificates.service - Clean up broken links in /etc/ssl/certs... Aug 5 22:14:40.393526 systemd[1]: Starting systemd-journal-catalog-update.service - Rebuild Journal Catalog... Aug 5 22:14:40.397181 systemd[1]: Starting systemd-resolved.service - Network Name Resolution... Aug 5 22:14:40.404980 systemd[1]: Starting systemd-update-utmp.service - Record System Boot/Shutdown in UTMP... Aug 5 22:14:40.409519 systemd[1]: ignition-delete-config.service - Ignition (delete config) was skipped because no trigger condition checks were met. Aug 5 22:14:40.411009 systemd[1]: Starting modprobe@dm_mod.service - Load Kernel Module dm_mod... Aug 5 22:14:40.413092 systemd[1]: Starting modprobe@efi_pstore.service - Load Kernel Module efi_pstore... Aug 5 22:14:40.419575 systemd[1]: Starting modprobe@loop.service - Load Kernel Module loop... Aug 5 22:14:40.420609 systemd[1]: systemd-binfmt.service - Set Up Additional Binary Formats was skipped because no trigger condition checks were met. Aug 5 22:14:40.421334 systemd[1]: Finished systemd-hwdb-update.service - Rebuild Hardware Database. Aug 5 22:14:40.422746 systemd[1]: modprobe@dm_mod.service: Deactivated successfully. Aug 5 22:14:40.422873 systemd[1]: Finished modprobe@dm_mod.service - Load Kernel Module dm_mod. Aug 5 22:14:40.424220 systemd[1]: modprobe@loop.service: Deactivated successfully. Aug 5 22:14:40.426430 systemd[1]: Finished modprobe@loop.service - Load Kernel Module loop. Aug 5 22:14:40.432220 systemd[1]: modprobe@efi_pstore.service: Deactivated successfully. Aug 5 22:14:40.434552 systemd[1]: Finished modprobe@efi_pstore.service - Load Kernel Module efi_pstore. Aug 5 22:14:40.436885 systemd[1]: Finished systemd-journal-catalog-update.service - Rebuild Journal Catalog. Aug 5 22:14:40.442961 systemd[1]: Finished systemd-update-utmp.service - Record System Boot/Shutdown in UTMP. Aug 5 22:14:40.445961 systemd[1]: ignition-delete-config.service - Ignition (delete config) was skipped because no trigger condition checks were met. Aug 5 22:14:40.458570 systemd[1]: Starting modprobe@dm_mod.service - Load Kernel Module dm_mod... Aug 5 22:14:40.460386 systemd[1]: Starting modprobe@efi_pstore.service - Load Kernel Module efi_pstore... Aug 5 22:14:40.462386 systemd[1]: Starting modprobe@loop.service - Load Kernel Module loop... Aug 5 22:14:40.463437 systemd[1]: systemd-binfmt.service - Set Up Additional Binary Formats was skipped because no trigger condition checks were met. Aug 5 22:14:40.465271 systemd[1]: Starting systemd-udevd.service - Rule-based Manager for Device Events and Files... Aug 5 22:14:40.468641 systemd[1]: Starting systemd-update-done.service - Update is Completed... Aug 5 22:14:40.471077 systemd[1]: Starting systemd-userdbd.service - User Database Manager... Aug 5 22:14:40.473004 systemd[1]: Finished clean-ca-certificates.service - Clean up broken links in /etc/ssl/certs. Aug 5 22:14:40.474704 systemd[1]: modprobe@dm_mod.service: Deactivated successfully. Aug 5 22:14:40.476381 systemd[1]: Finished modprobe@dm_mod.service - Load Kernel Module dm_mod. Aug 5 22:14:40.477628 systemd[1]: modprobe@efi_pstore.service: Deactivated successfully. Aug 5 22:14:40.477761 systemd[1]: Finished modprobe@efi_pstore.service - Load Kernel Module efi_pstore. Aug 5 22:14:40.479148 systemd[1]: modprobe@loop.service: Deactivated successfully. Aug 5 22:14:40.479273 systemd[1]: Finished modprobe@loop.service - Load Kernel Module loop. Aug 5 22:14:40.485641 augenrules[2078]: No rules Aug 5 22:14:40.491157 systemd[1]: Finished audit-rules.service - Load Security Auditing Rules. Aug 5 22:14:40.492463 systemd[1]: Finished systemd-update-done.service - Update is Completed. Aug 5 22:14:40.494529 systemd-udevd[2074]: Using default interface naming scheme 'v255'. Aug 5 22:14:40.498180 systemd[1]: Finished ensure-sysext.service. Aug 5 22:14:40.499931 systemd[1]: ignition-delete-config.service - Ignition (delete config) was skipped because no trigger condition checks were met. Aug 5 22:14:40.509459 systemd[1]: Starting modprobe@dm_mod.service - Load Kernel Module dm_mod... Aug 5 22:14:40.514478 systemd[1]: Starting modprobe@drm.service - Load Kernel Module drm... Aug 5 22:14:40.516274 systemd[1]: Starting modprobe@efi_pstore.service - Load Kernel Module efi_pstore... Aug 5 22:14:40.518101 systemd[1]: Starting modprobe@loop.service - Load Kernel Module loop... Aug 5 22:14:40.519438 systemd[1]: systemd-binfmt.service - Set Up Additional Binary Formats was skipped because no trigger condition checks were met. Aug 5 22:14:40.521057 systemd[1]: Starting systemd-timesyncd.service - Network Time Synchronization... Aug 5 22:14:40.524423 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:14:40.524657 systemd[1]: Started systemd-udevd.service - Rule-based Manager for Device Events and Files. Aug 5 22:14:40.526008 systemd[1]: Started systemd-userdbd.service - User Database Manager. Aug 5 22:14:40.527604 systemd[1]: modprobe@dm_mod.service: Deactivated successfully. Aug 5 22:14:40.527751 systemd[1]: Finished modprobe@dm_mod.service - Load Kernel Module dm_mod. Aug 5 22:14:40.539015 systemd[1]: Starting systemd-networkd.service - Network Configuration... Aug 5 22:14:40.544537 systemd[1]: modprobe@efi_pstore.service: Deactivated successfully. Aug 5 22:14:40.544674 systemd[1]: Finished modprobe@efi_pstore.service - Load Kernel Module efi_pstore. Aug 5 22:14:40.546987 systemd[1]: systemd-pstore.service - Platform Persistent Storage Archival was skipped because of an unmet condition check (ConditionDirectoryNotEmpty=/sys/fs/pstore). Aug 5 22:14:40.553948 systemd[1]: modprobe@loop.service: Deactivated successfully. Aug 5 22:14:40.554091 systemd[1]: Finished modprobe@loop.service - Load Kernel Module loop. Aug 5 22:14:40.556957 systemd[1]: systemd-repart.service - Repartition Root Disk was skipped because no trigger condition checks were met. Aug 5 22:14:40.562626 systemd[1]: Condition check resulted in dev-disk-by\x2duuid-dfb25628\x2de29b\x2d470b\x2d9f0e\x2d77bf2c42124a.device - /dev/disk/by-uuid/dfb25628-e29b-470b-9f0e-77bf2c42124a being skipped. Aug 5 22:14:40.564382 kernel: BTRFS warning: duplicate device /dev/vdb3 devid 1 generation 41 scanned by (udev-worker) (2119) Aug 5 22:14:40.573608 systemd[1]: Starting systemd-cryptsetup@rootencrypted.service - Cryptography Setup for rootencrypted... Aug 5 22:14:40.575784 systemd[1]: modprobe@drm.service: Deactivated successfully. Aug 5 22:14:40.577399 systemd[1]: Finished modprobe@drm.service - Load Kernel Module drm. Aug 5 22:14:40.581776 systemd[1]: Condition check resulted in dev-ttyAMA0.device - /dev/ttyAMA0 being skipped. Aug 5 22:14:40.589453 systemd[1]: Found device dev-disk-by\x2dlabel-OEM.device - /dev/disk/by-label/OEM. Aug 5 22:14:40.597374 kernel: BTRFS info: devid 1 device path /dev/mapper/usr changed to /dev/dm-0 scanned by (udev-worker) (2103) Aug 5 22:14:40.602210 systemd-cryptsetup[2124]: Volume rootencrypted already active. Aug 5 22:14:40.603555 systemd[1]: Starting systemd-fsck@dev-disk-by\x2dlabel-OEM.service - File System Check on /dev/disk/by-label/OEM... Aug 5 22:14:40.606464 systemd[1]: Finished systemd-cryptsetup@rootencrypted.service - Cryptography Setup for rootencrypted. Aug 5 22:14:40.608519 systemd[1]: Reached target blockdev@dev-mapper-rootencrypted.target - Block Device Preparation for /dev/mapper/rootencrypted. Aug 5 22:14:40.626756 systemd-resolved[2048]: Positive Trust Anchors: Aug 5 22:14:40.627138 systemd-resolved[2048]: . IN DS 20326 8 2 e06d44b80b8f1d39a95c0b0d7c65d08458e880409bbc683457104237c7f8ec8d Aug 5 22:14:40.627222 systemd-resolved[2048]: 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:14:40.627657 systemd[1]: Started systemd-timesyncd.service - Network Time Synchronization. Aug 5 22:14:40.629336 systemd[1]: Reached target time-set.target - System Time Set. Aug 5 22:14:40.631533 systemd-resolved[2048]: Defaulting to hostname 'linux'. Aug 5 22:14:40.643938 systemd[1]: Started systemd-resolved.service - Network Name Resolution. Aug 5 22:14:40.646282 systemd[1]: Finished systemd-fsck@dev-disk-by\x2dlabel-OEM.service - File System Check on /dev/disk/by-label/OEM. Aug 5 22:14:40.649884 systemd[1]: Reached target nss-lookup.target - Host and Network Name Lookups. Aug 5 22:14:40.665652 systemd-networkd[2118]: lo: Link UP Aug 5 22:14:40.665667 systemd-networkd[2118]: lo: Gained carrier Aug 5 22:14:40.666458 systemd-networkd[2118]: Enumeration completed Aug 5 22:14:40.666563 systemd[1]: Started systemd-networkd.service - Network Configuration. Aug 5 22:14:40.666939 systemd-networkd[2118]: eth0: found matching network '/usr/lib/systemd/network/zz-default.network', based on potentially unpredictable interface name. Aug 5 22:14:40.666950 systemd-networkd[2118]: eth0: Configuring with /usr/lib/systemd/network/zz-default.network. Aug 5 22:14:40.667819 systemd[1]: Reached target network.target - Network. Aug 5 22:14:40.667905 systemd-networkd[2118]: eth0: Link UP Aug 5 22:14:40.667909 systemd-networkd[2118]: eth0: Gained carrier Aug 5 22:14:40.667923 systemd-networkd[2118]: eth0: found matching network '/usr/lib/systemd/network/zz-default.network', based on potentially unpredictable interface name. Aug 5 22:14:40.677570 systemd[1]: Starting systemd-networkd-wait-online.service - Wait for Network to be Configured... Aug 5 22:14:40.682447 systemd-networkd[2118]: eth0: DHCPv4 address 10.0.0.113/16, gateway 10.0.0.1 acquired from 10.0.0.1 Aug 5 22:14:40.684202 systemd-timesyncd[2109]: Network configuration changed, trying to establish connection. Aug 5 22:14:40.684971 systemd[1]: Starting systemd-vconsole-setup.service - Virtual Console Setup... Aug 5 22:14:40.685019 systemd-timesyncd[2109]: Contacted time server 10.0.0.1:123 (10.0.0.1). Aug 5 22:14:40.685062 systemd-timesyncd[2109]: Initial clock synchronization to Mon 2024-08-05 22:14:40.298801 UTC. Aug 5 22:14:40.689550 systemd[1]: Finished systemd-udev-settle.service - Wait for udev To Complete Device Initialization. Aug 5 22:14:40.693574 systemd[1]: Starting lvm2-activation-early.service - Activation of LVM2 logical volumes... Aug 5 22:14:40.712342 lvm[2142]: WARNING: Failed to connect to lvmetad. Falling back to device scanning. Aug 5 22:14:40.726366 systemd[1]: Finished systemd-vconsole-setup.service - Virtual Console Setup. Aug 5 22:14:40.742592 systemd[1]: Finished lvm2-activation-early.service - Activation of LVM2 logical volumes. Aug 5 22:14:40.743755 systemd[1]: Reached target cryptsetup.target - Local Encrypted Volumes. Aug 5 22:14:40.745432 systemd[1]: Reached target sysinit.target - System Initialization. Aug 5 22:14:40.746630 systemd[1]: Started motdgen.path - Watch for update engine configuration changes. Aug 5 22:14:40.747854 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:14:40.749201 systemd[1]: Started logrotate.timer - Daily rotation of log files. Aug 5 22:14:40.750403 systemd[1]: Started mdadm.timer - Weekly check for MD array's redundancy information.. Aug 5 22:14:40.751551 systemd[1]: Started systemd-tmpfiles-clean.timer - Daily Cleanup of Temporary Directories. Aug 5 22:14:40.752744 systemd[1]: update-engine-stub.timer - Update Engine Stub Timer was skipped because of an unmet condition check (ConditionPathExists=/usr/.noupdate). Aug 5 22:14:40.752782 systemd[1]: Reached target paths.target - Path Units. Aug 5 22:14:40.753646 systemd[1]: Reached target timers.target - Timer Units. Aug 5 22:14:40.755495 systemd[1]: Listening on dbus.socket - D-Bus System Message Bus Socket. Aug 5 22:14:40.757906 systemd[1]: Starting docker.socket - Docker Socket for the API... Aug 5 22:14:40.769058 systemd[1]: Listening on sshd.socket - OpenSSH Server Socket. Aug 5 22:14:40.771196 systemd[1]: Starting lvm2-activation.service - Activation of LVM2 logical volumes... Aug 5 22:14:40.772727 systemd[1]: Listening on docker.socket - Docker Socket for the API. Aug 5 22:14:40.773887 systemd[1]: Reached target sockets.target - Socket Units. Aug 5 22:14:40.774699 systemd[1]: Reached target basic.target - Basic System. Aug 5 22:14:40.775585 systemd[1]: addon-config@oem.service - Configure Addon /oem was skipped because no trigger condition checks were met. Aug 5 22:14:40.775619 systemd[1]: addon-run@oem.service - Run Addon /oem was skipped because no trigger condition checks were met. Aug 5 22:14:40.776474 systemd[1]: Starting containerd.service - containerd container runtime... Aug 5 22:14:40.777446 systemd[1]: cryptenroll-helper-bind.service was skipped because of an unmet condition check (ConditionPathExists=/etc/luks/rootencrypted-bind). Aug 5 22:14:40.778437 systemd[1]: Starting dbus.service - D-Bus System Message Bus... Aug 5 22:14:40.781433 lvm[2151]: WARNING: Failed to connect to lvmetad. Falling back to device scanning. Aug 5 22:14:40.782442 systemd[1]: Starting enable-oem-cloudinit.service - Enable cloudinit... Aug 5 22:14:40.785337 systemd[1]: Starting extend-filesystems.service - Extend Filesystems... Aug 5 22:14:40.786549 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:14:40.788260 systemd[1]: Starting motdgen.service - Generate /run/flatcar/motd... Aug 5 22:14:40.794130 systemd[1]: Starting ssh-key-proc-cmdline.service - Install an ssh key from /proc/cmdline... Aug 5 22:14:40.796506 systemd[1]: Starting sshd-keygen.service - Generate sshd host keys... Aug 5 22:14:40.798263 jq[2154]: false Aug 5 22:14:40.803626 systemd[1]: Starting systemd-logind.service - User Login Management... Aug 5 22:14:40.806052 extend-filesystems[2155]: Found loop2 Aug 5 22:14:40.806052 extend-filesystems[2155]: Found loop3 Aug 5 22:14:40.806052 extend-filesystems[2155]: Found vda Aug 5 22:14:40.806052 extend-filesystems[2155]: Found vdb Aug 5 22:14:40.806052 extend-filesystems[2155]: Found vdb1 Aug 5 22:14:40.806052 extend-filesystems[2155]: Found vdb2 Aug 5 22:14:40.806052 extend-filesystems[2155]: Found vdb3 Aug 5 22:14:40.806052 extend-filesystems[2155]: Found usr Aug 5 22:14:40.806052 extend-filesystems[2155]: Found vdb4 Aug 5 22:14:40.806052 extend-filesystems[2155]: Found vdb6 Aug 5 22:14:40.806052 extend-filesystems[2155]: Found vdb7 Aug 5 22:14:40.806052 extend-filesystems[2155]: Found vdb9 Aug 5 22:14:40.806052 extend-filesystems[2155]: Found rootencrypted Aug 5 22:14:40.806193 systemd[1]: tcsd.service - TCG Core Services Daemon was skipped because of an unmet condition check (ConditionSecurity=!tpm2). Aug 5 22:14:40.806599 systemd[1]: cgroup compatibility translation between legacy and unified hierarchy settings activated. See cgroup-compat debug messages for details. Aug 5 22:14:40.825958 jq[2169]: true Aug 5 22:14:40.807196 systemd[1]: Starting update-engine.service - Update Engine... Aug 5 22:14:40.811034 systemd[1]: Starting update-ssh-keys-after-ignition.service - Run update-ssh-keys once after Ignition... Aug 5 22:14:40.816548 systemd[1]: Finished lvm2-activation.service - Activation of LVM2 logical volumes. Aug 5 22:14:40.820081 systemd[1]: enable-oem-cloudinit.service: Skipped due to 'exec-condition'. Aug 5 22:14:40.820253 systemd[1]: Condition check resulted in enable-oem-cloudinit.service - Enable cloudinit being skipped. Aug 5 22:14:40.820521 systemd[1]: extend-filesystems.service: Deactivated successfully. Aug 5 22:14:40.822506 systemd[1]: Finished extend-filesystems.service - Extend Filesystems. Aug 5 22:14:40.824311 systemd[1]: motdgen.service: Deactivated successfully. Aug 5 22:14:40.824474 systemd[1]: Finished motdgen.service - Generate /run/flatcar/motd. Aug 5 22:14:40.825482 systemd[1]: ssh-key-proc-cmdline.service: Deactivated successfully. Aug 5 22:14:40.825615 systemd[1]: Finished ssh-key-proc-cmdline.service - Install an ssh key from /proc/cmdline. Aug 5 22:14:40.827062 dbus-daemon[2153]: [system] SELinux support is enabled Aug 5 22:14:40.827238 systemd[1]: Started dbus.service - D-Bus System Message Bus. Aug 5 22:14:40.838875 jq[2172]: true Aug 5 22:14:40.840687 (ntainerd)[2173]: containerd.service: Referenced but unset environment variable evaluates to an empty string: TORCX_IMAGEDIR, TORCX_UNPACKDIR Aug 5 22:14:40.845540 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:14:40.845590 systemd[1]: Reached target system-config.target - Load system-provided cloud configs. Aug 5 22:14:40.849503 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:14:40.849535 systemd[1]: Reached target user-config.target - Load user-provided cloud configs. Aug 5 22:14:40.860598 systemd-logind[2161]: Watching system buttons on /dev/input/event0 (Power Button) Aug 5 22:14:40.860998 systemd-logind[2161]: New seat seat0. Aug 5 22:14:40.861180 update_engine[2167]: I0805 22:14:40.860731 2167 main.cc:92] Flatcar Update Engine starting Aug 5 22:14:40.862472 systemd[1]: Started systemd-logind.service - User Login Management. Aug 5 22:14:40.869360 systemd[1]: Started update-engine.service - Update Engine. Aug 5 22:14:40.869496 update_engine[2167]: I0805 22:14:40.869454 2167 update_check_scheduler.cc:74] Next update check in 10m35s Aug 5 22:14:40.877573 systemd[1]: Started locksmithd.service - Cluster reboot manager. Aug 5 22:14:40.901400 bash[2198]: Updated "/home/core/.ssh/authorized_keys" Aug 5 22:14:40.903048 systemd[1]: Finished update-ssh-keys-after-ignition.service - Run update-ssh-keys once after Ignition. Aug 5 22:14:40.904721 systemd[1]: sshkeys.service was skipped because no trigger condition checks were met. Aug 5 22:14:40.922502 locksmithd[2197]: locksmithd starting currentOperation="UPDATE_STATUS_IDLE" strategy="reboot" Aug 5 22:14:40.949358 systemd[1]: Created slice system-sshd.slice - Slice /system/sshd. Aug 5 22:14:41.023883 containerd[2173]: time="2024-08-05T22:14:41.023744611Z" level=info msg="starting containerd" revision=1fbfc07f8d28210e62bdbcbf7b950bac8028afbf version=v1.7.17 Aug 5 22:14:41.046713 containerd[2173]: time="2024-08-05T22:14:41.046661731Z" level=info msg="loading plugin \"io.containerd.warning.v1.deprecations\"..." type=io.containerd.warning.v1 Aug 5 22:14:41.046713 containerd[2173]: time="2024-08-05T22:14:41.046709355Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.aufs\"..." type=io.containerd.snapshotter.v1 Aug 5 22:14:41.047993 containerd[2173]: time="2024-08-05T22:14:41.047962181Z" 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:14:41.047993 containerd[2173]: time="2024-08-05T22:14:41.047991799Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.btrfs\"..." type=io.containerd.snapshotter.v1 Aug 5 22:14:41.048214 containerd[2173]: time="2024-08-05T22:14:41.048196193Z" 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:14:41.048296 containerd[2173]: time="2024-08-05T22:14:41.048215609Z" level=info msg="loading plugin \"io.containerd.content.v1.content\"..." type=io.containerd.content.v1 Aug 5 22:14:41.048338 containerd[2173]: time="2024-08-05T22:14:41.048314741Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.blockfile\"..." type=io.containerd.snapshotter.v1 Aug 5 22:14:41.048391 containerd[2173]: time="2024-08-05T22:14:41.048374700Z" 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:14:41.048411 containerd[2173]: time="2024-08-05T22:14:41.048391146Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.native\"..." type=io.containerd.snapshotter.v1 Aug 5 22:14:41.048459 containerd[2173]: time="2024-08-05T22:14:41.048447337Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.overlayfs\"..." type=io.containerd.snapshotter.v1 Aug 5 22:14:41.048630 containerd[2173]: time="2024-08-05T22:14:41.048615908Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.devmapper\"..." type=io.containerd.snapshotter.v1 Aug 5 22:14:41.048648 containerd[2173]: time="2024-08-05T22:14:41.048637075Z" level=warning msg="failed to load plugin io.containerd.snapshotter.v1.devmapper" error="devmapper not configured" Aug 5 22:14:41.048678 containerd[2173]: time="2024-08-05T22:14:41.048647087Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.zfs\"..." type=io.containerd.snapshotter.v1 Aug 5 22:14:41.048747 containerd[2173]: time="2024-08-05T22:14:41.048732210Z" 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:14:41.048775 containerd[2173]: time="2024-08-05T22:14:41.048748009Z" level=info msg="loading plugin \"io.containerd.metadata.v1.bolt\"..." type=io.containerd.metadata.v1 Aug 5 22:14:41.048807 containerd[2173]: time="2024-08-05T22:14:41.048793388Z" level=warning msg="could not use snapshotter devmapper in metadata plugin" error="devmapper not configured" Aug 5 22:14:41.048829 containerd[2173]: time="2024-08-05T22:14:41.048808615Z" level=info msg="metadata content store policy set" policy=shared Aug 5 22:14:41.055914 containerd[2173]: time="2024-08-05T22:14:41.055881487Z" level=info msg="loading plugin \"io.containerd.differ.v1.walking\"..." type=io.containerd.differ.v1 Aug 5 22:14:41.055972 containerd[2173]: time="2024-08-05T22:14:41.055918415Z" level=info msg="loading plugin \"io.containerd.event.v1.exchange\"..." type=io.containerd.event.v1 Aug 5 22:14:41.055972 containerd[2173]: time="2024-08-05T22:14:41.055938668Z" level=info msg="loading plugin \"io.containerd.gc.v1.scheduler\"..." type=io.containerd.gc.v1 Aug 5 22:14:41.055972 containerd[2173]: time="2024-08-05T22:14:41.055968019Z" level=info msg="loading plugin \"io.containerd.lease.v1.manager\"..." type=io.containerd.lease.v1 Aug 5 22:14:41.056037 containerd[2173]: time="2024-08-05T22:14:41.055984732Z" level=info msg="loading plugin \"io.containerd.nri.v1.nri\"..." type=io.containerd.nri.v1 Aug 5 22:14:41.056037 containerd[2173]: time="2024-08-05T22:14:41.055995543Z" level=info msg="NRI interface is disabled by configuration." Aug 5 22:14:41.056037 containerd[2173]: time="2024-08-05T22:14:41.056007573Z" level=info msg="loading plugin \"io.containerd.runtime.v2.task\"..." type=io.containerd.runtime.v2 Aug 5 22:14:41.056143 containerd[2173]: time="2024-08-05T22:14:41.056122162Z" level=info msg="loading plugin \"io.containerd.runtime.v2.shim\"..." type=io.containerd.runtime.v2 Aug 5 22:14:41.056171 containerd[2173]: time="2024-08-05T22:14:41.056144318Z" level=info msg="loading plugin \"io.containerd.sandbox.store.v1.local\"..." type=io.containerd.sandbox.store.v1 Aug 5 22:14:41.056171 containerd[2173]: time="2024-08-05T22:14:41.056161716Z" level=info msg="loading plugin \"io.containerd.sandbox.controller.v1.local\"..." type=io.containerd.sandbox.controller.v1 Aug 5 22:14:41.056209 containerd[2173]: time="2024-08-05T22:14:41.056174545Z" level=info msg="loading plugin \"io.containerd.streaming.v1.manager\"..." type=io.containerd.streaming.v1 Aug 5 22:14:41.056209 containerd[2173]: time="2024-08-05T22:14:41.056187756Z" level=info msg="loading plugin \"io.containerd.service.v1.introspection-service\"..." type=io.containerd.service.v1 Aug 5 22:14:41.056209 containerd[2173]: time="2024-08-05T22:14:41.056202831Z" level=info msg="loading plugin \"io.containerd.service.v1.containers-service\"..." type=io.containerd.service.v1 Aug 5 22:14:41.056256 containerd[2173]: time="2024-08-05T22:14:41.056214785Z" level=info msg="loading plugin \"io.containerd.service.v1.content-service\"..." type=io.containerd.service.v1 Aug 5 22:14:41.056256 containerd[2173]: time="2024-08-05T22:14:41.056226777Z" level=info msg="loading plugin \"io.containerd.service.v1.diff-service\"..." type=io.containerd.service.v1 Aug 5 22:14:41.056256 containerd[2173]: time="2024-08-05T22:14:41.056239568Z" level=info msg="loading plugin \"io.containerd.service.v1.images-service\"..." type=io.containerd.service.v1 Aug 5 22:14:41.056256 containerd[2173]: time="2024-08-05T22:14:41.056251370Z" level=info msg="loading plugin \"io.containerd.service.v1.namespaces-service\"..." type=io.containerd.service.v1 Aug 5 22:14:41.056331 containerd[2173]: time="2024-08-05T22:14:41.056262866Z" level=info msg="loading plugin \"io.containerd.service.v1.snapshots-service\"..." type=io.containerd.service.v1 Aug 5 22:14:41.056331 containerd[2173]: time="2024-08-05T22:14:41.056280835Z" level=info msg="loading plugin \"io.containerd.runtime.v1.linux\"..." type=io.containerd.runtime.v1 Aug 5 22:14:41.056402 containerd[2173]: time="2024-08-05T22:14:41.056386135Z" level=info msg="loading plugin \"io.containerd.monitor.v1.cgroups\"..." type=io.containerd.monitor.v1 Aug 5 22:14:41.056610 containerd[2173]: time="2024-08-05T22:14:41.056595745Z" level=info msg="loading plugin \"io.containerd.service.v1.tasks-service\"..." type=io.containerd.service.v1 Aug 5 22:14:41.056640 containerd[2173]: time="2024-08-05T22:14:41.056623612Z" level=info msg="loading plugin \"io.containerd.grpc.v1.introspection\"..." type=io.containerd.grpc.v1 Aug 5 22:14:41.056640 containerd[2173]: time="2024-08-05T22:14:41.056636670Z" level=info msg="loading plugin \"io.containerd.transfer.v1.local\"..." type=io.containerd.transfer.v1 Aug 5 22:14:41.056680 containerd[2173]: time="2024-08-05T22:14:41.056656923Z" level=info msg="loading plugin \"io.containerd.internal.v1.restart\"..." type=io.containerd.internal.v1 Aug 5 22:14:41.056778 containerd[2173]: time="2024-08-05T22:14:41.056765344Z" level=info msg="loading plugin \"io.containerd.grpc.v1.containers\"..." type=io.containerd.grpc.v1 Aug 5 22:14:41.056802 containerd[2173]: time="2024-08-05T22:14:41.056781029Z" level=info msg="loading plugin \"io.containerd.grpc.v1.content\"..." type=io.containerd.grpc.v1 Aug 5 22:14:41.056802 containerd[2173]: time="2024-08-05T22:14:41.056793021Z" level=info msg="loading plugin \"io.containerd.grpc.v1.diff\"..." type=io.containerd.grpc.v1 Aug 5 22:14:41.056853 containerd[2173]: time="2024-08-05T22:14:41.056803528Z" level=info msg="loading plugin \"io.containerd.grpc.v1.events\"..." type=io.containerd.grpc.v1 Aug 5 22:14:41.056853 containerd[2173]: time="2024-08-05T22:14:41.056815596Z" level=info msg="loading plugin \"io.containerd.grpc.v1.healthcheck\"..." type=io.containerd.grpc.v1 Aug 5 22:14:41.056853 containerd[2173]: time="2024-08-05T22:14:41.056827093Z" level=info msg="loading plugin \"io.containerd.grpc.v1.images\"..." type=io.containerd.grpc.v1 Aug 5 22:14:41.056853 containerd[2173]: time="2024-08-05T22:14:41.056838209Z" level=info msg="loading plugin \"io.containerd.grpc.v1.leases\"..." type=io.containerd.grpc.v1 Aug 5 22:14:41.056922 containerd[2173]: time="2024-08-05T22:14:41.056857777Z" level=info msg="loading plugin \"io.containerd.grpc.v1.namespaces\"..." type=io.containerd.grpc.v1 Aug 5 22:14:41.056922 containerd[2173]: time="2024-08-05T22:14:41.056871367Z" level=info msg="loading plugin \"io.containerd.internal.v1.opt\"..." type=io.containerd.internal.v1 Aug 5 22:14:41.057012 containerd[2173]: time="2024-08-05T22:14:41.056984586Z" level=info msg="loading plugin \"io.containerd.grpc.v1.sandbox-controllers\"..." type=io.containerd.grpc.v1 Aug 5 22:14:41.057012 containerd[2173]: time="2024-08-05T22:14:41.057005143Z" level=info msg="loading plugin \"io.containerd.grpc.v1.sandboxes\"..." type=io.containerd.grpc.v1 Aug 5 22:14:41.057054 containerd[2173]: time="2024-08-05T22:14:41.057020980Z" level=info msg="loading plugin \"io.containerd.grpc.v1.snapshots\"..." type=io.containerd.grpc.v1 Aug 5 22:14:41.057054 containerd[2173]: time="2024-08-05T22:14:41.057032934Z" level=info msg="loading plugin \"io.containerd.grpc.v1.streaming\"..." type=io.containerd.grpc.v1 Aug 5 22:14:41.057054 containerd[2173]: time="2024-08-05T22:14:41.057044279Z" level=info msg="loading plugin \"io.containerd.grpc.v1.tasks\"..." type=io.containerd.grpc.v1 Aug 5 22:14:41.057107 containerd[2173]: time="2024-08-05T22:14:41.057056575Z" level=info msg="loading plugin \"io.containerd.grpc.v1.transfer\"..." type=io.containerd.grpc.v1 Aug 5 22:14:41.057107 containerd[2173]: time="2024-08-05T22:14:41.057067729Z" level=info msg="loading plugin \"io.containerd.grpc.v1.version\"..." type=io.containerd.grpc.v1 Aug 5 22:14:41.057107 containerd[2173]: time="2024-08-05T22:14:41.057077399Z" level=info msg="loading plugin \"io.containerd.grpc.v1.cri\"..." type=io.containerd.grpc.v1 Aug 5 22:14:41.057489 containerd[2173]: time="2024-08-05T22:14:41.057437992Z" 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:14:41.057597 containerd[2173]: time="2024-08-05T22:14:41.057494449Z" level=info msg="Connect containerd service" Aug 5 22:14:41.057597 containerd[2173]: time="2024-08-05T22:14:41.057518395Z" level=info msg="using legacy CRI server" Aug 5 22:14:41.057597 containerd[2173]: time="2024-08-05T22:14:41.057524486Z" level=info msg="using experimental NRI integration - disable nri plugin to prevent this" Aug 5 22:14:41.057666 containerd[2173]: time="2024-08-05T22:14:41.057650686Z" level=info msg="Get image filesystem path \"/var/lib/containerd/io.containerd.snapshotter.v1.overlayfs\"" Aug 5 22:14:41.058253 containerd[2173]: time="2024-08-05T22:14:41.058229683Z" 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:14:41.058289 containerd[2173]: time="2024-08-05T22:14:41.058279287Z" level=info msg="loading plugin \"io.containerd.tracing.processor.v1.otlp\"..." type=io.containerd.tracing.processor.v1 Aug 5 22:14:41.058308 containerd[2173]: time="2024-08-05T22:14:41.058295962Z" 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:14:41.058350 containerd[2173]: time="2024-08-05T22:14:41.058305631Z" level=info msg="loading plugin \"io.containerd.internal.v1.tracing\"..." type=io.containerd.internal.v1 Aug 5 22:14:41.058350 containerd[2173]: time="2024-08-05T22:14:41.058328397Z" 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:14:41.058807 containerd[2173]: time="2024-08-05T22:14:41.058576381Z" level=info msg="Start subscribing containerd event" Aug 5 22:14:41.058807 containerd[2173]: time="2024-08-05T22:14:41.058731818Z" level=info msg="Start recovering state" Aug 5 22:14:41.058865 containerd[2173]: time="2024-08-05T22:14:41.058850062Z" level=info msg=serving... address=/run/containerd/containerd.sock.ttrpc Aug 5 22:14:41.059089 containerd[2173]: time="2024-08-05T22:14:41.058970894Z" level=info msg="Start event monitor" Aug 5 22:14:41.059089 containerd[2173]: time="2024-08-05T22:14:41.058985474Z" level=info msg=serving... address=/run/containerd/containerd.sock Aug 5 22:14:41.059089 containerd[2173]: time="2024-08-05T22:14:41.058993507Z" level=info msg="Start snapshots syncer" Aug 5 22:14:41.059089 containerd[2173]: time="2024-08-05T22:14:41.059004014Z" level=info msg="Start cni network conf syncer for default" Aug 5 22:14:41.059089 containerd[2173]: time="2024-08-05T22:14:41.059012313Z" level=info msg="Start streaming server" Aug 5 22:14:41.060132 containerd[2173]: time="2024-08-05T22:14:41.059512126Z" level=info msg="containerd successfully booted in 0.036674s" Aug 5 22:14:41.059790 systemd[1]: Started containerd.service - containerd container runtime. Aug 5 22:14:41.141408 sshd_keygen[2170]: ssh-keygen: generating new host keys: RSA ECDSA ED25519 Aug 5 22:14:41.159297 systemd[1]: Finished sshd-keygen.service - Generate sshd host keys. Aug 5 22:14:41.170633 systemd[1]: Starting issuegen.service - Generate /run/issue... Aug 5 22:14:41.172364 systemd[1]: Started sshd@0-10.0.0.113:22-10.0.0.1:34538.service - OpenSSH per-connection server daemon (10.0.0.1:34538). Aug 5 22:14:41.175019 systemd[1]: issuegen.service: Deactivated successfully. Aug 5 22:14:41.175831 systemd[1]: Finished issuegen.service - Generate /run/issue. Aug 5 22:14:41.179082 systemd[1]: Starting systemd-user-sessions.service - Permit User Sessions... Aug 5 22:14:41.190496 systemd[1]: Finished systemd-user-sessions.service - Permit User Sessions. Aug 5 22:14:41.205637 systemd[1]: Started getty@tty1.service - Getty on tty1. Aug 5 22:14:41.208019 systemd[1]: Started serial-getty@ttyAMA0.service - Serial Getty on ttyAMA0. Aug 5 22:14:41.209028 systemd[1]: Reached target getty.target - Login Prompts. Aug 5 22:14:41.228645 sshd[2223]: Accepted publickey for core from 10.0.0.1 port 34538 ssh2: RSA SHA256:m+vSf9MZ8jyHy+Dz2uz+ngzM5NRoRVVH/LZDa5ltoPE Aug 5 22:14:41.230385 sshd[2223]: pam_unix(sshd:session): session opened for user core(uid=500) by (uid=0) Aug 5 22:14:41.238517 systemd-logind[2161]: New session 1 of user core. Aug 5 22:14:41.239495 systemd[1]: Created slice user-500.slice - User Slice of UID 500. Aug 5 22:14:41.252531 systemd[1]: Starting user-runtime-dir@500.service - User Runtime Directory /run/user/500... Aug 5 22:14:41.262604 systemd[1]: Finished user-runtime-dir@500.service - User Runtime Directory /run/user/500. Aug 5 22:14:41.266284 systemd[1]: Starting user@500.service - User Manager for UID 500... Aug 5 22:14:41.275269 (systemd)[2234]: pam_unix(systemd-user:session): session opened for user core(uid=500) by (uid=0) Aug 5 22:14:41.351783 systemd[2234]: Queued start job for default target default.target. Aug 5 22:14:41.366349 systemd[2234]: Created slice app.slice - User Application Slice. Aug 5 22:14:41.366381 systemd[2234]: Reached target paths.target - Paths. Aug 5 22:14:41.366394 systemd[2234]: Reached target timers.target - Timers. Aug 5 22:14:41.367567 systemd[2234]: Starting dbus.socket - D-Bus User Message Bus Socket... Aug 5 22:14:41.377383 systemd[2234]: Listening on dbus.socket - D-Bus User Message Bus Socket. Aug 5 22:14:41.377447 systemd[2234]: Reached target sockets.target - Sockets. Aug 5 22:14:41.377460 systemd[2234]: Reached target basic.target - Basic System. Aug 5 22:14:41.377495 systemd[2234]: Reached target default.target - Main User Target. Aug 5 22:14:41.377521 systemd[2234]: Startup finished in 96ms. Aug 5 22:14:41.377849 systemd[1]: Started user@500.service - User Manager for UID 500. Aug 5 22:14:41.380219 systemd[1]: Started session-1.scope - Session 1 of User core. Aug 5 22:14:41.445901 systemd[1]: Started sshd@1-10.0.0.113:22-10.0.0.1:34546.service - OpenSSH per-connection server daemon (10.0.0.1:34546). Aug 5 22:14:41.482976 sshd[2245]: Accepted publickey for core from 10.0.0.1 port 34546 ssh2: RSA SHA256:m+vSf9MZ8jyHy+Dz2uz+ngzM5NRoRVVH/LZDa5ltoPE Aug 5 22:14:41.484121 sshd[2245]: pam_unix(sshd:session): session opened for user core(uid=500) by (uid=0) Aug 5 22:14:41.487953 systemd-logind[2161]: New session 2 of user core. Aug 5 22:14:41.500493 systemd[1]: Started session-2.scope - Session 2 of User core. Aug 5 22:14:41.551454 sshd[2245]: pam_unix(sshd:session): session closed for user core Aug 5 22:14:41.564437 systemd[1]: sshd@1-10.0.0.113:22-10.0.0.1:34546.service: Deactivated successfully. Aug 5 22:14:41.566629 systemd[1]: session-2.scope: Deactivated successfully. Aug 5 22:14:41.568481 systemd-logind[2161]: Session 2 logged out. Waiting for processes to exit. Aug 5 22:14:41.582580 systemd[1]: Started sshd@2-10.0.0.113:22-10.0.0.1:34562.service - OpenSSH per-connection server daemon (10.0.0.1:34562). Aug 5 22:14:41.584199 systemd-logind[2161]: Removed session 2. Aug 5 22:14:41.614985 sshd[2252]: Accepted publickey for core from 10.0.0.1 port 34562 ssh2: RSA SHA256:m+vSf9MZ8jyHy+Dz2uz+ngzM5NRoRVVH/LZDa5ltoPE Aug 5 22:14:41.616040 sshd[2252]: pam_unix(sshd:session): session opened for user core(uid=500) by (uid=0) Aug 5 22:14:41.619954 systemd-logind[2161]: New session 3 of user core. Aug 5 22:14:41.629505 systemd[1]: Started session-3.scope - Session 3 of User core. Aug 5 22:14:41.679711 sshd[2252]: pam_unix(sshd:session): session closed for user core Aug 5 22:14:41.682215 systemd[1]: sshd@2-10.0.0.113:22-10.0.0.1:34562.service: Deactivated successfully. Aug 5 22:14:41.684613 systemd[1]: session-3.scope: Deactivated successfully. Aug 5 22:14:41.685802 systemd-logind[2161]: Session 3 logged out. Waiting for processes to exit. Aug 5 22:14:41.686651 systemd-logind[2161]: Removed session 3. Aug 5 22:14:42.586458 systemd-networkd[2118]: eth0: Gained IPv6LL Aug 5 22:14:42.588854 systemd[1]: Finished systemd-networkd-wait-online.service - Wait for Network to be Configured. Aug 5 22:14:42.590590 systemd[1]: Reached target network-online.target - Network is Online. Aug 5 22:14:42.599556 systemd[1]: Starting coreos-metadata.service - QEMU metadata agent... Aug 5 22:14:42.601340 systemd[1]: Starting nvidia.service - NVIDIA Configure Service... Aug 5 22:14:42.614192 systemd[1]: coreos-metadata.service: Deactivated successfully. Aug 5 22:14:42.614368 systemd[1]: Finished coreos-metadata.service - QEMU metadata agent. Aug 5 22:14:42.615559 systemd[1]: packet-phone-home.service - Report Success to Packet was skipped because no trigger condition checks were met. Aug 5 22:14:42.618334 systemd[1]: Finished nvidia.service - NVIDIA Configure Service. Aug 5 22:14:42.619629 systemd[1]: Reached target multi-user.target - Multi-User System. Aug 5 22:14:42.621545 systemd[1]: Starting cryptenroll-helper-first.service... Aug 5 22:14:44.793400 systemd-cryptenroll[2272]: New TPM2 token enrolled as key slot 1. Aug 5 22:14:51.424365 systemd[1]: Started sshd@3-10.0.0.113:22-10.0.0.1:52484.service - OpenSSH per-connection server daemon (10.0.0.1:52484). Aug 5 22:14:51.461460 sshd[2411]: Accepted publickey for core from 10.0.0.1 port 52484 ssh2: RSA SHA256:m+vSf9MZ8jyHy+Dz2uz+ngzM5NRoRVVH/LZDa5ltoPE Aug 5 22:14:51.462697 sshd[2411]: pam_unix(sshd:session): session opened for user core(uid=500) by (uid=0) Aug 5 22:14:51.466509 systemd-logind[2161]: New session 4 of user core. Aug 5 22:14:51.480489 systemd[1]: Started session-4.scope - Session 4 of User core. Aug 5 22:14:51.532958 sshd[2411]: pam_unix(sshd:session): session closed for user core Aug 5 22:14:51.542402 systemd[1]: sshd@3-10.0.0.113:22-10.0.0.1:52484.service: Deactivated successfully. Aug 5 22:14:51.543652 systemd[1]: session-4.scope: Deactivated successfully. Aug 5 22:14:51.545318 systemd-logind[2161]: Session 4 logged out. Waiting for processes to exit. Aug 5 22:14:51.546464 systemd[1]: Started sshd@4-10.0.0.113:22-10.0.0.1:52490.service - OpenSSH per-connection server daemon (10.0.0.1:52490). Aug 5 22:14:51.547697 systemd-logind[2161]: Removed session 4. Aug 5 22:14:51.585206 sshd[2418]: Accepted publickey for core from 10.0.0.1 port 52490 ssh2: RSA SHA256:m+vSf9MZ8jyHy+Dz2uz+ngzM5NRoRVVH/LZDa5ltoPE Aug 5 22:14:51.586029 sshd[2418]: pam_unix(sshd:session): session opened for user core(uid=500) by (uid=0) Aug 5 22:14:51.590263 systemd-logind[2161]: New session 5 of user core. Aug 5 22:14:51.600491 systemd[1]: Started session-5.scope - Session 5 of User core. Aug 5 22:14:51.651919 sshd[2418]: pam_unix(sshd:session): session closed for user core Aug 5 22:14:51.654822 systemd[1]: sshd@4-10.0.0.113:22-10.0.0.1:52490.service: Deactivated successfully. Aug 5 22:14:51.656088 systemd[1]: session-5.scope: Deactivated successfully. Aug 5 22:14:51.659283 systemd-logind[2161]: Session 5 logged out. Waiting for processes to exit. Aug 5 22:14:51.660090 systemd-logind[2161]: Removed session 5. -- Reboot -- Aug 5 22:16:29.888475 kernel: Booting Linux on physical CPU 0x0000000000 [0x413fd0c1] Aug 5 22:16:29.888497 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:16:29.888507 kernel: KASLR enabled Aug 5 22:16:29.888513 kernel: efi: EFI v2.7 by EDK II Aug 5 22:16:29.888519 kernel: efi: SMBIOS 3.0=0xdced0000 TPMFinalLog=0xd9740000 MEMATTR=0xdc06a018 ACPI 2.0=0xd96e0018 TPMEventLog=0xd9653018 RNG=0xd96ee698 MEMRESERVE=0xd9b43e18 Aug 5 22:16:29.888525 kernel: random: crng init done Aug 5 22:16:29.888532 kernel: ACPI: Early table checksum verification disabled Aug 5 22:16:29.888538 kernel: ACPI: RSDP 0x00000000D96E0018 000024 (v02 BOCHS ) Aug 5 22:16:29.888544 kernel: ACPI: XSDT 0x00000000D96EFE98 00006C (v01 BOCHS BXPC 00000001 01000013) Aug 5 22:16:29.888551 kernel: ACPI: FACP 0x00000000D96EFA98 000114 (v06 BOCHS BXPC 00000001 BXPC 00000001) Aug 5 22:16:29.888558 kernel: ACPI: DSDT 0x00000000D96E7518 0014EB (v02 BOCHS BXPC 00000001 BXPC 00000001) Aug 5 22:16:29.888564 kernel: ACPI: APIC 0x00000000D96EFC18 0001A8 (v04 BOCHS BXPC 00000001 BXPC 00000001) Aug 5 22:16:29.888570 kernel: ACPI: PPTT 0x00000000D96ED898 00009C (v02 BOCHS BXPC 00000001 BXPC 00000001) Aug 5 22:16:29.888576 kernel: ACPI: GTDT 0x00000000D96EE818 000060 (v02 BOCHS BXPC 00000001 BXPC 00000001) Aug 5 22:16:29.888583 kernel: ACPI: MCFG 0x00000000D96EE918 00003C (v01 BOCHS BXPC 00000001 BXPC 00000001) Aug 5 22:16:29.888590 kernel: ACPI: SPCR 0x00000000D96EFF98 000050 (v02 BOCHS BXPC 00000001 BXPC 00000001) Aug 5 22:16:29.888597 kernel: ACPI: DBG2 0x00000000D96EE418 000057 (v00 BOCHS BXPC 00000001 BXPC 00000001) Aug 5 22:16:29.888603 kernel: ACPI: IORT 0x00000000D96EE718 000080 (v03 BOCHS BXPC 00000001 BXPC 00000001) Aug 5 22:16:29.888610 kernel: ACPI: TPM2 0x00000000D96EE498 00004C (v04 BOCHS BXPC 00000001 BXPC 00000001) Aug 5 22:16:29.888616 kernel: ACPI: SPCR: console: pl011,mmio,0x9000000,9600 Aug 5 22:16:29.888622 kernel: NUMA: Failed to initialise from firmware Aug 5 22:16:29.888629 kernel: NUMA: Faking a node at [mem 0x0000000040000000-0x00000000dcffffff] Aug 5 22:16:29.888635 kernel: NUMA: NODE_DATA [mem 0xdc957800-0xdc95cfff] Aug 5 22:16:29.888641 kernel: Zone ranges: Aug 5 22:16:29.888648 kernel: DMA [mem 0x0000000040000000-0x00000000dcffffff] Aug 5 22:16:29.888655 kernel: DMA32 empty Aug 5 22:16:29.888662 kernel: Normal empty Aug 5 22:16:29.888668 kernel: Movable zone start for each node Aug 5 22:16:29.888674 kernel: Early memory node ranges Aug 5 22:16:29.888681 kernel: node 0: [mem 0x0000000040000000-0x00000000d962ffff] Aug 5 22:16:29.888687 kernel: node 0: [mem 0x00000000d9630000-0x00000000d963ffff] Aug 5 22:16:29.888693 kernel: node 0: [mem 0x00000000d9640000-0x00000000d973ffff] Aug 5 22:16:29.888700 kernel: node 0: [mem 0x00000000d9740000-0x00000000d9b3ffff] Aug 5 22:16:29.888706 kernel: node 0: [mem 0x00000000d9b40000-0x00000000dce1ffff] Aug 5 22:16:29.888713 kernel: node 0: [mem 0x00000000dce20000-0x00000000dceaffff] Aug 5 22:16:29.888719 kernel: node 0: [mem 0x00000000dceb0000-0x00000000dcebffff] Aug 5 22:16:29.888731 kernel: node 0: [mem 0x00000000dcec0000-0x00000000dcfdffff] Aug 5 22:16:29.888740 kernel: node 0: [mem 0x00000000dcfe0000-0x00000000dcffffff] Aug 5 22:16:29.888746 kernel: Initmem setup node 0 [mem 0x0000000040000000-0x00000000dcffffff] Aug 5 22:16:29.888753 kernel: On node 0, zone DMA: 12288 pages in unavailable ranges Aug 5 22:16:29.888762 kernel: psci: probing for conduit method from ACPI. Aug 5 22:16:29.888769 kernel: psci: PSCIv1.1 detected in firmware. Aug 5 22:16:29.888776 kernel: psci: Using standard PSCI v0.2 function IDs Aug 5 22:16:29.888784 kernel: psci: Trusted OS migration not required Aug 5 22:16:29.888790 kernel: psci: SMC Calling Convention v1.1 Aug 5 22:16:29.888797 kernel: smccc: KVM: hypervisor services detected (0x00000000 0x00000000 0x00000000 0x00000003) Aug 5 22:16:29.888804 kernel: percpu: Embedded 31 pages/cpu s86632 r8192 d32152 u126976 Aug 5 22:16:29.888811 kernel: pcpu-alloc: s86632 r8192 d32152 u126976 alloc=31*4096 Aug 5 22:16:29.888818 kernel: pcpu-alloc: [0] 0 [0] 1 [0] 2 [0] 3 Aug 5 22:16:29.888825 kernel: Detected PIPT I-cache on CPU0 Aug 5 22:16:29.888831 kernel: CPU features: detected: GIC system register CPU interface Aug 5 22:16:29.888838 kernel: CPU features: detected: Hardware dirty bit management Aug 5 22:16:29.888845 kernel: CPU features: detected: Spectre-v4 Aug 5 22:16:29.888853 kernel: CPU features: detected: Spectre-BHB Aug 5 22:16:29.888860 kernel: CPU features: kernel page table isolation forced ON by KASLR Aug 5 22:16:29.888866 kernel: CPU features: detected: Kernel page table isolation (KPTI) Aug 5 22:16:29.888873 kernel: CPU features: detected: ARM erratum 1418040 Aug 5 22:16:29.888880 kernel: alternatives: applying boot alternatives Aug 5 22:16:29.888887 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 acpi=force verity.usrhash=4052403b8e39e55d48e6afcca927358798017aa0d33c868bc3038260a8d9be90 Aug 5 22:16:29.888895 kernel: Unknown kernel command line parameters "BOOT_IMAGE=/flatcar/vmlinuz-a", will be passed to user space. Aug 5 22:16:29.888901 kernel: Dentry cache hash table entries: 524288 (order: 10, 4194304 bytes, linear) Aug 5 22:16:29.888908 kernel: Inode-cache hash table entries: 262144 (order: 9, 2097152 bytes, linear) Aug 5 22:16:29.888915 kernel: Fallback order for Node 0: 0 Aug 5 22:16:29.888922 kernel: Built 1 zonelists, mobility grouping on. Total pages: 633024 Aug 5 22:16:29.888931 kernel: Policy zone: DMA Aug 5 22:16:29.888937 kernel: mem auto-init: stack:off, heap alloc:off, heap free:off Aug 5 22:16:29.888944 kernel: software IO TLB: area num 4. Aug 5 22:16:29.888951 kernel: software IO TLB: mapped [mem 0x00000000d2e00000-0x00000000d6e00000] (64MB) Aug 5 22:16:29.888958 kernel: Memory: 2386572K/2572288K available (10240K kernel code, 2182K rwdata, 8072K rodata, 39040K init, 897K bss, 185716K reserved, 0K cma-reserved) Aug 5 22:16:29.888965 kernel: SLUB: HWalign=64, Order=0-3, MinObjects=0, CPUs=4, Nodes=1 Aug 5 22:16:29.888972 kernel: trace event string verifier disabled Aug 5 22:16:29.888979 kernel: rcu: Preemptible hierarchical RCU implementation. Aug 5 22:16:29.888987 kernel: rcu: RCU event tracing is enabled. Aug 5 22:16:29.888994 kernel: rcu: RCU restricting CPUs from NR_CPUS=512 to nr_cpu_ids=4. Aug 5 22:16:29.889000 kernel: Trampoline variant of Tasks RCU enabled. Aug 5 22:16:29.889009 kernel: Tracing variant of Tasks RCU enabled. Aug 5 22:16:29.889026 kernel: rcu: RCU calculated value of scheduler-enlistment delay is 100 jiffies. Aug 5 22:16:29.889034 kernel: rcu: Adjusting geometry for rcu_fanout_leaf=16, nr_cpu_ids=4 Aug 5 22:16:29.889041 kernel: NR_IRQS: 64, nr_irqs: 64, preallocated irqs: 0 Aug 5 22:16:29.889047 kernel: GICv3: 256 SPIs implemented Aug 5 22:16:29.889054 kernel: GICv3: 0 Extended SPIs implemented Aug 5 22:16:29.889061 kernel: Root IRQ handler: gic_handle_irq Aug 5 22:16:29.889068 kernel: GICv3: GICv3 features: 16 PPIs, DirectLPI Aug 5 22:16:29.889074 kernel: GICv3: CPU0: found redistributor 0 region 0:0x00000000080a0000 Aug 5 22:16:29.889081 kernel: ITS [mem 0x08080000-0x0809ffff] Aug 5 22:16:29.889088 kernel: ITS@0x0000000008080000: allocated 8192 Devices @400d0000 (indirect, esz 8, psz 64K, shr 1) Aug 5 22:16:29.889095 kernel: ITS@0x0000000008080000: allocated 8192 Interrupt Collections @400e0000 (flat, esz 8, psz 64K, shr 1) Aug 5 22:16:29.889103 kernel: GICv3: using LPI property table @0x00000000400f0000 Aug 5 22:16:29.889110 kernel: GICv3: CPU0: using allocated LPI pending table @0x0000000040100000 Aug 5 22:16:29.889117 kernel: rcu: srcu_init: Setting srcu_struct sizes based on contention. Aug 5 22:16:29.889124 kernel: arch_timer: Enabling local workaround for ARM erratum 1418040 Aug 5 22:16:29.889131 kernel: arch_timer: cp15 timer(s) running at 25.00MHz (virt). Aug 5 22:16:29.889138 kernel: clocksource: arch_sys_counter: mask: 0xffffffffffffff max_cycles: 0x5c40939b5, max_idle_ns: 440795202646 ns Aug 5 22:16:29.889146 kernel: sched_clock: 56 bits at 25MHz, resolution 40ns, wraps every 4398046511100ns Aug 5 22:16:29.889153 kernel: arm-pv: using stolen time PV Aug 5 22:16:29.889160 kernel: Console: colour dummy device 80x25 Aug 5 22:16:29.889167 kernel: ACPI: Core revision 20230628 Aug 5 22:16:29.889174 kernel: Calibrating delay loop (skipped), value calculated using timer frequency.. 50.00 BogoMIPS (lpj=25000) Aug 5 22:16:29.889183 kernel: pid_max: default: 32768 minimum: 301 Aug 5 22:16:29.889190 kernel: LSM: initializing lsm=lockdown,capability,selinux,integrity Aug 5 22:16:29.889197 kernel: SELinux: Initializing. Aug 5 22:16:29.889204 kernel: Mount-cache hash table entries: 8192 (order: 4, 65536 bytes, linear) Aug 5 22:16:29.889211 kernel: Mountpoint-cache hash table entries: 8192 (order: 4, 65536 bytes, linear) Aug 5 22:16:29.889218 kernel: RCU Tasks: Setting shift to 2 and lim to 1 rcu_task_cb_adjust=1. Aug 5 22:16:29.889226 kernel: RCU Tasks Trace: Setting shift to 2 and lim to 1 rcu_task_cb_adjust=1. Aug 5 22:16:29.889233 kernel: rcu: Hierarchical SRCU implementation. Aug 5 22:16:29.889240 kernel: rcu: Max phase no-delay instances is 400. Aug 5 22:16:29.889249 kernel: Platform MSI: ITS@0x8080000 domain created Aug 5 22:16:29.889256 kernel: PCI/MSI: ITS@0x8080000 domain created Aug 5 22:16:29.889263 kernel: Remapping and enabling EFI services. Aug 5 22:16:29.889270 kernel: smp: Bringing up secondary CPUs ... Aug 5 22:16:29.889277 kernel: Detected PIPT I-cache on CPU1 Aug 5 22:16:29.889285 kernel: GICv3: CPU1: found redistributor 1 region 0:0x00000000080c0000 Aug 5 22:16:29.889292 kernel: GICv3: CPU1: using allocated LPI pending table @0x0000000040110000 Aug 5 22:16:29.889299 kernel: arch_timer: Enabling local workaround for ARM erratum 1418040 Aug 5 22:16:29.889306 kernel: CPU1: Booted secondary processor 0x0000000001 [0x413fd0c1] Aug 5 22:16:29.889314 kernel: Detected PIPT I-cache on CPU2 Aug 5 22:16:29.889322 kernel: GICv3: CPU2: found redistributor 2 region 0:0x00000000080e0000 Aug 5 22:16:29.889334 kernel: GICv3: CPU2: using allocated LPI pending table @0x0000000040120000 Aug 5 22:16:29.889344 kernel: arch_timer: Enabling local workaround for ARM erratum 1418040 Aug 5 22:16:29.889351 kernel: CPU2: Booted secondary processor 0x0000000002 [0x413fd0c1] Aug 5 22:16:29.889358 kernel: Detected PIPT I-cache on CPU3 Aug 5 22:16:29.889366 kernel: GICv3: CPU3: found redistributor 3 region 0:0x0000000008100000 Aug 5 22:16:29.889380 kernel: GICv3: CPU3: using allocated LPI pending table @0x0000000040130000 Aug 5 22:16:29.889388 kernel: arch_timer: Enabling local workaround for ARM erratum 1418040 Aug 5 22:16:29.889398 kernel: CPU3: Booted secondary processor 0x0000000003 [0x413fd0c1] Aug 5 22:16:29.889405 kernel: smp: Brought up 1 node, 4 CPUs Aug 5 22:16:29.889413 kernel: SMP: Total of 4 processors activated. Aug 5 22:16:29.889421 kernel: CPU features: detected: 32-bit EL0 Support Aug 5 22:16:29.889428 kernel: CPU features: detected: Data cache clean to the PoU not required for I/D coherence Aug 5 22:16:29.889436 kernel: CPU features: detected: Common not Private translations Aug 5 22:16:29.889443 kernel: CPU features: detected: CRC32 instructions Aug 5 22:16:29.889451 kernel: CPU features: detected: Enhanced Virtualization Traps Aug 5 22:16:29.889460 kernel: CPU features: detected: RCpc load-acquire (LDAPR) Aug 5 22:16:29.889468 kernel: CPU features: detected: LSE atomic instructions Aug 5 22:16:29.889475 kernel: CPU features: detected: Privileged Access Never Aug 5 22:16:29.889483 kernel: CPU features: detected: RAS Extension Support Aug 5 22:16:29.889490 kernel: CPU features: detected: Speculative Store Bypassing Safe (SSBS) Aug 5 22:16:29.889498 kernel: CPU: All CPU(s) started at EL1 Aug 5 22:16:29.889507 kernel: alternatives: applying system-wide alternatives Aug 5 22:16:29.889514 kernel: devtmpfs: initialized Aug 5 22:16:29.889522 kernel: clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1911260446275000 ns Aug 5 22:16:29.889531 kernel: futex hash table entries: 1024 (order: 4, 65536 bytes, linear) Aug 5 22:16:29.889539 kernel: pinctrl core: initialized pinctrl subsystem Aug 5 22:16:29.889546 kernel: SMBIOS 3.0.0 present. Aug 5 22:16:29.889553 kernel: DMI: QEMU KVM Virtual Machine, BIOS edk2-20230524-3.fc38 05/24/2023 Aug 5 22:16:29.889561 kernel: NET: Registered PF_NETLINK/PF_ROUTE protocol family Aug 5 22:16:29.889568 kernel: DMA: preallocated 512 KiB GFP_KERNEL pool for atomic allocations Aug 5 22:16:29.889575 kernel: DMA: preallocated 512 KiB GFP_KERNEL|GFP_DMA pool for atomic allocations Aug 5 22:16:29.889583 kernel: DMA: preallocated 512 KiB GFP_KERNEL|GFP_DMA32 pool for atomic allocations Aug 5 22:16:29.889590 kernel: audit: initializing netlink subsys (disabled) Aug 5 22:16:29.889599 kernel: audit: type=2000 audit(0.020:1): state=initialized audit_enabled=0 res=1 Aug 5 22:16:29.889607 kernel: thermal_sys: Registered thermal governor 'step_wise' Aug 5 22:16:29.889614 kernel: cpuidle: using governor menu Aug 5 22:16:29.889621 kernel: hw-breakpoint: found 6 breakpoint and 4 watchpoint registers. Aug 5 22:16:29.889629 kernel: ASID allocator initialised with 32768 entries Aug 5 22:16:29.889636 kernel: acpiphp: ACPI Hot Plug PCI Controller Driver version: 0.5 Aug 5 22:16:29.889644 kernel: Serial: AMBA PL011 UART driver Aug 5 22:16:29.889651 kernel: Modules: 2G module region forced by RANDOMIZE_MODULE_REGION_FULL Aug 5 22:16:29.889658 kernel: Modules: 0 pages in range for non-PLT usage Aug 5 22:16:29.889667 kernel: Modules: 509120 pages in range for PLT usage Aug 5 22:16:29.889674 kernel: HugeTLB: registered 1.00 GiB page size, pre-allocated 0 pages Aug 5 22:16:29.889681 kernel: HugeTLB: 0 KiB vmemmap can be freed for a 1.00 GiB page Aug 5 22:16:29.889689 kernel: HugeTLB: registered 32.0 MiB page size, pre-allocated 0 pages Aug 5 22:16:29.889696 kernel: HugeTLB: 0 KiB vmemmap can be freed for a 32.0 MiB page Aug 5 22:16:29.889703 kernel: HugeTLB: registered 2.00 MiB page size, pre-allocated 0 pages Aug 5 22:16:29.889711 kernel: HugeTLB: 0 KiB vmemmap can be freed for a 2.00 MiB page Aug 5 22:16:29.889718 kernel: HugeTLB: registered 64.0 KiB page size, pre-allocated 0 pages Aug 5 22:16:29.889730 kernel: HugeTLB: 0 KiB vmemmap can be freed for a 64.0 KiB page Aug 5 22:16:29.889739 kernel: ACPI: Added _OSI(Module Device) Aug 5 22:16:29.889747 kernel: ACPI: Added _OSI(Processor Device) Aug 5 22:16:29.889754 kernel: ACPI: Added _OSI(3.0 _SCP Extensions) Aug 5 22:16:29.889761 kernel: ACPI: Added _OSI(Processor Aggregator Device) Aug 5 22:16:29.889769 kernel: ACPI: 1 ACPI AML tables successfully acquired and loaded Aug 5 22:16:29.889776 kernel: ACPI: Interpreter enabled Aug 5 22:16:29.889783 kernel: ACPI: Using GIC for interrupt routing Aug 5 22:16:29.889791 kernel: ACPI: MCFG table detected, 1 entries Aug 5 22:16:29.889798 kernel: ARMH0011:00: ttyAMA0 at MMIO 0x9000000 (irq = 12, base_baud = 0) is a SBSA Aug 5 22:16:29.889805 kernel: printk: console [ttyAMA0] enabled Aug 5 22:16:29.889814 kernel: ACPI: PCI Root Bridge [PCI0] (domain 0000 [bus 00-ff]) Aug 5 22:16:29.889943 kernel: acpi PNP0A08:00: _OSC: OS supports [ExtendedConfig ASPM ClockPM Segments MSI HPX-Type3] Aug 5 22:16:29.890017 kernel: acpi PNP0A08:00: _OSC: platform does not support [LTR] Aug 5 22:16:29.890083 kernel: acpi PNP0A08:00: _OSC: OS now controls [PCIeHotplug PME AER PCIeCapability] Aug 5 22:16:29.890147 kernel: acpi PNP0A08:00: ECAM area [mem 0x4010000000-0x401fffffff] reserved by PNP0C02:00 Aug 5 22:16:29.890215 kernel: acpi PNP0A08:00: ECAM at [mem 0x4010000000-0x401fffffff] for [bus 00-ff] Aug 5 22:16:29.890227 kernel: ACPI: Remapped I/O 0x000000003eff0000 to [io 0x0000-0xffff window] Aug 5 22:16:29.890235 kernel: PCI host bridge to bus 0000:00 Aug 5 22:16:29.890305 kernel: pci_bus 0000:00: root bus resource [mem 0x10000000-0x3efeffff window] Aug 5 22:16:29.890365 kernel: pci_bus 0000:00: root bus resource [io 0x0000-0xffff window] Aug 5 22:16:29.890440 kernel: pci_bus 0000:00: root bus resource [mem 0x8000000000-0xffffffffff window] Aug 5 22:16:29.890500 kernel: pci_bus 0000:00: root bus resource [bus 00-ff] Aug 5 22:16:29.890582 kernel: pci 0000:00:00.0: [1b36:0008] type 00 class 0x060000 Aug 5 22:16:29.890661 kernel: pci 0000:00:01.0: [1af4:1005] type 00 class 0x00ff00 Aug 5 22:16:29.890754 kernel: pci 0000:00:01.0: reg 0x10: [io 0x0000-0x001f] Aug 5 22:16:29.890824 kernel: pci 0000:00:01.0: reg 0x14: [mem 0x10000000-0x10000fff] Aug 5 22:16:29.890891 kernel: pci 0000:00:01.0: reg 0x20: [mem 0x8000000000-0x8000003fff 64bit pref] Aug 5 22:16:29.890957 kernel: pci 0000:00:01.0: BAR 4: assigned [mem 0x8000000000-0x8000003fff 64bit pref] Aug 5 22:16:29.891023 kernel: pci 0000:00:01.0: BAR 1: assigned [mem 0x10000000-0x10000fff] Aug 5 22:16:29.891089 kernel: pci 0000:00:01.0: BAR 0: assigned [io 0x1000-0x101f] Aug 5 22:16:29.891154 kernel: pci_bus 0000:00: resource 4 [mem 0x10000000-0x3efeffff window] Aug 5 22:16:29.891212 kernel: pci_bus 0000:00: resource 5 [io 0x0000-0xffff window] Aug 5 22:16:29.891273 kernel: pci_bus 0000:00: resource 6 [mem 0x8000000000-0xffffffffff window] Aug 5 22:16:29.891283 kernel: ACPI: PCI: Interrupt link GSI0 configured for IRQ 35 Aug 5 22:16:29.891291 kernel: ACPI: PCI: Interrupt link GSI1 configured for IRQ 36 Aug 5 22:16:29.891299 kernel: ACPI: PCI: Interrupt link GSI2 configured for IRQ 37 Aug 5 22:16:29.891306 kernel: ACPI: PCI: Interrupt link GSI3 configured for IRQ 38 Aug 5 22:16:29.891314 kernel: iommu: Default domain type: Translated Aug 5 22:16:29.891323 kernel: iommu: DMA domain TLB invalidation policy: strict mode Aug 5 22:16:29.891330 kernel: efivars: Registered efivars operations Aug 5 22:16:29.891337 kernel: vgaarb: loaded Aug 5 22:16:29.891345 kernel: clocksource: Switched to clocksource arch_sys_counter Aug 5 22:16:29.891352 kernel: VFS: Disk quotas dquot_6.6.0 Aug 5 22:16:29.891360 kernel: VFS: Dquot-cache hash table entries: 512 (order 0, 4096 bytes) Aug 5 22:16:29.891367 kernel: pnp: PnP ACPI init Aug 5 22:16:29.891525 kernel: system 00:00: [mem 0x4010000000-0x401fffffff window] could not be reserved Aug 5 22:16:29.891540 kernel: pnp: PnP ACPI: found 1 devices Aug 5 22:16:29.891547 kernel: NET: Registered PF_INET protocol family Aug 5 22:16:29.891555 kernel: IP idents hash table entries: 65536 (order: 7, 524288 bytes, linear) Aug 5 22:16:29.891563 kernel: tcp_listen_portaddr_hash hash table entries: 2048 (order: 3, 32768 bytes, linear) Aug 5 22:16:29.891570 kernel: Table-perturb hash table entries: 65536 (order: 6, 262144 bytes, linear) Aug 5 22:16:29.891578 kernel: TCP established hash table entries: 32768 (order: 6, 262144 bytes, linear) Aug 5 22:16:29.891585 kernel: TCP bind hash table entries: 32768 (order: 8, 1048576 bytes, linear) Aug 5 22:16:29.891593 kernel: TCP: Hash tables configured (established 32768 bind 32768) Aug 5 22:16:29.891601 kernel: UDP hash table entries: 2048 (order: 4, 65536 bytes, linear) Aug 5 22:16:29.891610 kernel: UDP-Lite hash table entries: 2048 (order: 4, 65536 bytes, linear) Aug 5 22:16:29.891617 kernel: NET: Registered PF_UNIX/PF_LOCAL protocol family Aug 5 22:16:29.891625 kernel: PCI: CLS 0 bytes, default 64 Aug 5 22:16:29.891632 kernel: kvm [1]: HYP mode not available Aug 5 22:16:29.891639 kernel: Initialise system trusted keyrings Aug 5 22:16:29.891647 kernel: workingset: timestamp_bits=39 max_order=20 bucket_order=0 Aug 5 22:16:29.891654 kernel: Key type asymmetric registered Aug 5 22:16:29.891662 kernel: Asymmetric key parser 'x509' registered Aug 5 22:16:29.891669 kernel: Block layer SCSI generic (bsg) driver version 0.4 loaded (major 250) Aug 5 22:16:29.891678 kernel: io scheduler mq-deadline registered Aug 5 22:16:29.891685 kernel: io scheduler kyber registered Aug 5 22:16:29.891693 kernel: io scheduler bfq registered Aug 5 22:16:29.891700 kernel: input: Power Button as /devices/LNXSYSTM:00/LNXSYBUS:00/PNP0C0C:00/input/input0 Aug 5 22:16:29.891708 kernel: ACPI: button: Power Button [PWRB] Aug 5 22:16:29.891715 kernel: ACPI: \_SB_.PCI0.GSI1: Enabled at IRQ 36 Aug 5 22:16:29.891796 kernel: virtio-pci 0000:00:01.0: enabling device (0005 -> 0007) Aug 5 22:16:29.891807 kernel: Serial: 8250/16550 driver, 4 ports, IRQ sharing enabled Aug 5 22:16:29.891815 kernel: thunder_xcv, ver 1.0 Aug 5 22:16:29.891824 kernel: thunder_bgx, ver 1.0 Aug 5 22:16:29.891831 kernel: nicpf, ver 1.0 Aug 5 22:16:29.891839 kernel: nicvf, ver 1.0 Aug 5 22:16:29.891915 kernel: rtc-efi rtc-efi.0: registered as rtc0 Aug 5 22:16:29.891978 kernel: rtc-efi rtc-efi.0: setting system clock to 2024-08-05T22:16:29 UTC (1722896189) Aug 5 22:16:29.891988 kernel: hid: raw HID events driver (C) Jiri Kosina Aug 5 22:16:29.891996 kernel: hw perfevents: enabled with armv8_pmuv3_0 PMU driver, 7 counters available Aug 5 22:16:29.892003 kernel: watchdog: Delayed init of the lockup detector failed: -19 Aug 5 22:16:29.892013 kernel: watchdog: Hard watchdog permanently disabled Aug 5 22:16:29.892020 kernel: NET: Registered PF_INET6 protocol family Aug 5 22:16:29.892028 kernel: Segment Routing with IPv6 Aug 5 22:16:29.892035 kernel: In-situ OAM (IOAM) with IPv6 Aug 5 22:16:29.892043 kernel: NET: Registered PF_PACKET protocol family Aug 5 22:16:29.892050 kernel: Key type dns_resolver registered Aug 5 22:16:29.892058 kernel: registered taskstats version 1 Aug 5 22:16:29.892065 kernel: Loading compiled-in X.509 certificates Aug 5 22:16:29.892073 kernel: Loaded X.509 cert 'Kinvolk GmbH: Module signing key for 6.6.43-flatcar: 99cab5c9e2f0f3a5ca972c2df7b3d6ed64d627d4' Aug 5 22:16:29.892091 kernel: Key type .fscrypt registered Aug 5 22:16:29.892100 kernel: Key type fscrypt-provisioning registered Aug 5 22:16:29.892107 kernel: ima: No TPM chip found, activating TPM-bypass! Aug 5 22:16:29.892115 kernel: ima: Allocated hash algorithm: sha1 Aug 5 22:16:29.892122 kernel: ima: No architecture policies found Aug 5 22:16:29.892130 kernel: alg: No test for fips(ansi_cprng) (fips_ansi_cprng) Aug 5 22:16:29.892137 kernel: clk: Disabling unused clocks Aug 5 22:16:29.892145 kernel: Freeing unused kernel memory: 39040K Aug 5 22:16:29.892153 kernel: Run /init as init process Aug 5 22:16:29.892161 kernel: with arguments: Aug 5 22:16:29.892169 kernel: /init Aug 5 22:16:29.892176 kernel: with environment: Aug 5 22:16:29.892183 kernel: HOME=/ Aug 5 22:16:29.892192 kernel: TERM=linux Aug 5 22:16:29.892199 kernel: BOOT_IMAGE=/flatcar/vmlinuz-a Aug 5 22:16:29.892208 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:16:29.892217 systemd[1]: Detected virtualization kvm. Aug 5 22:16:29.892227 systemd[1]: Detected architecture arm64. Aug 5 22:16:29.892234 systemd[1]: Running in initrd. Aug 5 22:16:29.892242 systemd[1]: No hostname configured, using default hostname. Aug 5 22:16:29.892251 systemd[1]: Hostname set to . Aug 5 22:16:29.892259 systemd[1]: Initializing machine ID from VM UUID. Aug 5 22:16:29.892267 systemd[1]: Queued start job for default target initrd.target. Aug 5 22:16:29.892275 systemd[1]: Started clevis-luks-askpass.path - Forward Password Requests to Clevis Directory Watch. Aug 5 22:16:29.892283 systemd[1]: Started systemd-ask-password-console.path - Dispatch Password Requests to Console Directory Watch. Aug 5 22:16:29.892292 systemd[1]: Expecting device dev-disk-by\x2dlabel-OEM.device - /dev/disk/by-label/OEM... Aug 5 22:16:29.892301 systemd[1]: Expecting device dev-disk-by\x2dlabel-ROOT.device - /dev/disk/by-label/ROOT... Aug 5 22:16:29.892309 systemd[1]: Expecting device dev-disk-by\x2dpartlabel-ROOT.device - /dev/disk/by-partlabel/ROOT... Aug 5 22:16:29.892317 systemd[1]: Expecting device dev-disk-by\x2dpartlabel-USR\x2dA.device - /dev/disk/by-partlabel/USR-A... Aug 5 22:16:29.892326 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:16:29.892334 systemd[1]: Expecting device dev-mapper-usr.device - /dev/mapper/usr... Aug 5 22:16:29.892342 systemd[1]: Reached target cryptsetup-pre.target - Local Encrypted Volumes (Pre). Aug 5 22:16:29.892351 systemd[1]: Reached target cryptsetup.target - Local Encrypted Volumes. Aug 5 22:16:29.892360 systemd[1]: Reached target ignition-diskful-subsequent.target - Ignition Subsequent Boot Disk Setup. Aug 5 22:16:29.892367 systemd[1]: Reached target paths.target - Path Units. Aug 5 22:16:29.892385 systemd[1]: Reached target slices.target - Slice Units. Aug 5 22:16:29.892393 systemd[1]: Reached target swap.target - Swaps. Aug 5 22:16:29.892401 systemd[1]: Reached target timers.target - Timer Units. Aug 5 22:16:29.892409 systemd[1]: Listening on iscsid.socket - Open-iSCSI iscsid Socket. Aug 5 22:16:29.892417 systemd[1]: Listening on iscsiuio.socket - Open-iSCSI iscsiuio Socket. Aug 5 22:16:29.892425 systemd[1]: Listening on systemd-journald-dev-log.socket - Journal Socket (/dev/log). Aug 5 22:16:29.892434 systemd[1]: Listening on systemd-journald.socket - Journal Socket. Aug 5 22:16:29.892442 systemd[1]: Listening on systemd-udevd-control.socket - udev Control Socket. Aug 5 22:16:29.892450 systemd[1]: Listening on systemd-udevd-kernel.socket - udev Kernel Socket. Aug 5 22:16:29.892458 systemd[1]: Reached target sockets.target - Socket Units. Aug 5 22:16:29.892466 systemd[1]: Starting ignition-setup-pre.service - Ignition env setup... Aug 5 22:16:29.892474 systemd[1]: Starting kmod-static-nodes.service - Create List of Static Device Nodes... Aug 5 22:16:29.892481 systemd[1]: Starting systemd-fsck-usr.service... Aug 5 22:16:29.892489 systemd[1]: Starting systemd-journald.service - Journal Service... Aug 5 22:16:29.892499 systemd[1]: Starting systemd-modules-load.service - Load Kernel Modules... Aug 5 22:16:29.892507 systemd[1]: Starting systemd-vconsole-setup.service - Virtual Console Setup... Aug 5 22:16:29.892515 systemd[1]: Finished ignition-setup-pre.service - Ignition env setup. Aug 5 22:16:29.892523 systemd[1]: Finished kmod-static-nodes.service - Create List of Static Device Nodes. Aug 5 22:16:29.892530 systemd[1]: Finished systemd-fsck-usr.service. Aug 5 22:16:29.892538 systemd[1]: Starting systemd-tmpfiles-setup-dev-early.service - Create Static Device Nodes in /dev gracefully... Aug 5 22:16:29.892548 systemd[1]: Finished systemd-tmpfiles-setup-dev-early.service - Create Static Device Nodes in /dev gracefully. Aug 5 22:16:29.892574 systemd-journald[231]: Collecting audit messages is disabled. Aug 5 22:16:29.892595 systemd[1]: Starting systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev... Aug 5 22:16:29.892604 systemd-journald[231]: Journal started Aug 5 22:16:29.892622 systemd-journald[231]: Runtime Journal (/run/log/journal/34d35adb6cb64892a3f942ca92e347c0) is 5.9M, max 47.3M, 41.4M free. Aug 5 22:16:29.883389 systemd-modules-load[233]: Inserted module 'overlay' Aug 5 22:16:29.894630 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:16:29.896411 systemd[1]: Started systemd-journald.service - Journal Service. Aug 5 22:16:29.898062 systemd-modules-load[233]: Inserted module 'br_netfilter' Aug 5 22:16:29.898960 kernel: Bridge firewalling registered Aug 5 22:16:29.899131 systemd[1]: Finished systemd-vconsole-setup.service - Virtual Console Setup. Aug 5 22:16:29.900331 systemd[1]: Finished systemd-modules-load.service - Load Kernel Modules. Aug 5 22:16:29.903822 systemd[1]: Starting dracut-cmdline-ask.service - dracut ask for additional cmdline parameters... Aug 5 22:16:29.905547 systemd[1]: Starting systemd-sysctl.service - Apply Kernel Variables... Aug 5 22:16:29.909248 systemd[1]: Starting systemd-tmpfiles-setup.service - Create Volatile Files and Directories... Aug 5 22:16:29.913693 systemd[1]: Finished systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev. Aug 5 22:16:29.920062 systemd[1]: Finished systemd-sysctl.service - Apply Kernel Variables. Aug 5 22:16:29.923277 systemd[1]: Finished systemd-tmpfiles-setup.service - Create Volatile Files and Directories. Aug 5 22:16:29.930134 systemd[1]: Finished dracut-cmdline-ask.service - dracut ask for additional cmdline parameters. Aug 5 22:16:29.935551 systemd[1]: Starting dracut-cmdline.service - dracut cmdline hook... Aug 5 22:16:29.945646 dracut-cmdline[269]: dracut-dracut-053 Aug 5 22:16:29.948037 dracut-cmdline[269]: 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 acpi=force verity.usrhash=4052403b8e39e55d48e6afcca927358798017aa0d33c868bc3038260a8d9be90 Aug 5 22:16:30.018404 kernel: SCSI subsystem initialized Aug 5 22:16:30.023398 kernel: Loading iSCSI transport class v2.0-870. Aug 5 22:16:30.034416 kernel: iscsi: registered transport (tcp) Aug 5 22:16:30.048404 kernel: iscsi: registered transport (qla4xxx) Aug 5 22:16:30.048440 kernel: QLogic iSCSI HBA Driver Aug 5 22:16:30.094122 systemd[1]: Finished dracut-cmdline.service - dracut cmdline hook. Aug 5 22:16:30.105552 systemd[1]: Starting dracut-pre-udev.service - dracut pre-udev hook... Aug 5 22:16:30.122112 kernel: device-mapper: core: CONFIG_IMA_DISABLE_HTABLE is disabled. Duplicate IMA measurements will not be recorded in the IMA log. Aug 5 22:16:30.122158 kernel: device-mapper: uevent: version 1.0.3 Aug 5 22:16:30.123044 kernel: device-mapper: ioctl: 4.48.0-ioctl (2023-03-01) initialised: dm-devel@redhat.com Aug 5 22:16:30.169398 kernel: raid6: neonx8 gen() 16781 MB/s Aug 5 22:16:30.186389 kernel: raid6: neonx4 gen() 15653 MB/s Aug 5 22:16:30.206385 kernel: raid6: neonx2 gen() 13246 MB/s Aug 5 22:16:30.223385 kernel: raid6: neonx1 gen() 10473 MB/s Aug 5 22:16:30.240397 kernel: raid6: int64x8 gen() 6960 MB/s Aug 5 22:16:30.257389 kernel: raid6: int64x4 gen() 7349 MB/s Aug 5 22:16:30.274383 kernel: raid6: int64x2 gen() 6117 MB/s Aug 5 22:16:30.291392 kernel: raid6: int64x1 gen() 5053 MB/s Aug 5 22:16:30.291406 kernel: raid6: using algorithm neonx8 gen() 16781 MB/s Aug 5 22:16:30.308384 kernel: raid6: .... xor() 11901 MB/s, rmw enabled Aug 5 22:16:30.308397 kernel: raid6: using neon recovery algorithm Aug 5 22:16:30.313392 kernel: xor: measuring software checksum speed Aug 5 22:16:30.313410 kernel: 8regs : 19840 MB/sec Aug 5 22:16:30.314612 kernel: 32regs : 19659 MB/sec Aug 5 22:16:30.315430 kernel: arm64_neon : 27170 MB/sec Aug 5 22:16:30.315455 kernel: xor: using function: arm64_neon (27170 MB/sec) Aug 5 22:16:30.367424 kernel: Btrfs loaded, zoned=no, fsverity=no Aug 5 22:16:30.378217 systemd[1]: Finished dracut-pre-udev.service - dracut pre-udev hook. Aug 5 22:16:30.384503 systemd[1]: Starting systemd-udevd.service - Rule-based Manager for Device Events and Files... Aug 5 22:16:30.396493 systemd-udevd[452]: Using default interface naming scheme 'v255'. Aug 5 22:16:30.399701 systemd[1]: Started systemd-udevd.service - Rule-based Manager for Device Events and Files. Aug 5 22:16:30.402668 systemd[1]: Starting dracut-pre-trigger.service - dracut pre-trigger hook... Aug 5 22:16:30.416552 dracut-pre-trigger[460]: rd.md=0: removing MD RAID activation Aug 5 22:16:30.446508 systemd[1]: Finished dracut-pre-trigger.service - dracut pre-trigger hook. Aug 5 22:16:30.458625 systemd[1]: Starting systemd-udev-trigger.service - Coldplug All udev Devices... Aug 5 22:16:30.499612 systemd[1]: Finished systemd-udev-trigger.service - Coldplug All udev Devices. Aug 5 22:16:30.536436 kernel: virtio_blk virtio1: 1/0/0 default/read/poll queues Aug 5 22:16:30.548228 kernel: tpm_tis MSFT0101:00: 2.0 TPM (device-id 0x1, rev-id 1) Aug 5 22:16:30.570105 kernel: virtio_blk virtio1: [vda] 1064960 512-byte logical blocks (545 MB/520 MiB) Aug 5 22:16:30.570226 kernel: virtio_blk virtio2: 1/0/0 default/read/poll queues Aug 5 22:16:30.570308 kernel: virtio_blk virtio2: [vdb] 9289728 512-byte logical blocks (4.76 GB/4.43 GiB) Aug 5 22:16:30.570526 kernel: vdb: vdb1 vdb2 vdb3 vdb4 vdb6 vdb7 vdb9 Aug 5 22:16:30.546427 systemd[1]: dracut-cmdline-ask.service: Deactivated successfully. Aug 5 22:16:30.546489 systemd[1]: Stopped dracut-cmdline-ask.service - dracut ask for additional cmdline parameters. Aug 5 22:16:30.548918 systemd[1]: Stopping dracut-cmdline-ask.service - dracut ask for additional cmdline parameters... Aug 5 22:16:30.556024 systemd[1]: systemd-vconsole-setup.service: Deactivated successfully. Aug 5 22:16:30.556091 systemd[1]: Stopped systemd-vconsole-setup.service - Virtual Console Setup. Aug 5 22:16:30.557469 systemd[1]: Stopping systemd-vconsole-setup.service - Virtual Console Setup... Aug 5 22:16:30.568507 systemd[1]: Starting systemd-vconsole-setup.service - Virtual Console Setup... Aug 5 22:16:30.579291 systemd[1]: Finished systemd-vconsole-setup.service - Virtual Console Setup. Aug 5 22:16:30.591609 systemd[1]: Starting dracut-cmdline-ask.service - dracut ask for additional cmdline parameters... Aug 5 22:16:30.600441 systemd[1]: Found device dev-disk-by\x2dpartlabel-ROOT.device - /dev/disk/by-partlabel/ROOT. Aug 5 22:16:30.606596 kernel: BTRFS: device fsid 278882ec-4175-45f0-a12b-7fddc0d6d9a3 devid 1 transid 41 /dev/vdb3 scanned by (udev-worker) (497) Aug 5 22:16:30.609465 kernel: BTRFS: device label OEM devid 1 transid 18 /dev/vdb6 scanned by (udev-worker) (512) Aug 5 22:16:30.613206 systemd[1]: Finished dracut-cmdline-ask.service - dracut ask for additional cmdline parameters. Aug 5 22:16:30.621087 systemd[1]: Found device dev-disk-by\x2dlabel-OEM.device - /dev/disk/by-label/OEM. Aug 5 22:16:30.624833 systemd[1]: Found device dev-disk-by\x2dpartlabel-USR\x2dA.device - /dev/disk/by-partlabel/USR-A. Aug 5 22:16:30.625930 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:16:30.639556 systemd[1]: Starting decrypt-root.service - Generate and execute a systemd-cryptsetup service to decrypt the ROOT partition... Aug 5 22:16:30.641547 systemd[1]: Starting disk-uuid.service - Generate new UUID for disk GPT if necessary... Aug 5 22:16:30.647839 systemd[1]: disk-uuid.service: Deactivated successfully. Aug 5 22:16:30.650434 systemd[1]: Finished disk-uuid.service - Generate new UUID for disk GPT if necessary. Aug 5 22:16:30.651830 systemd[1]: Reached target local-fs-pre.target - Preparation for Local File Systems. Aug 5 22:16:30.653549 systemd[1]: Reached target local-fs.target - Local File Systems. Aug 5 22:16:30.655188 systemd[1]: Reached target sysinit.target - System Initialization. Aug 5 22:16:30.656705 systemd[1]: Reached target basic.target - Basic System. Aug 5 22:16:30.658921 systemd[1]: Starting verity-setup.service - Verity Setup for /dev/mapper/usr... Aug 5 22:16:30.664116 systemd[1]: Created slice system-systemd\x2dcryptsetup.slice - Slice /system/systemd-cryptsetup. Aug 5 22:16:30.665971 systemd[1]: Starting systemd-cryptsetup@rootencrypted.service - Cryptography Setup for rootencrypted... Aug 5 22:16:30.668504 sh[545]: Success Aug 5 22:16:30.689398 kernel: device-mapper: verity: sha256 using implementation "sha256-ce" Aug 5 22:16:30.737017 systemd[1]: Found device dev-mapper-usr.device - /dev/mapper/usr. Aug 5 22:16:30.738979 systemd[1]: Mounting sysusr-usr.mount - /sysusr/usr... Aug 5 22:16:30.739984 systemd[1]: Finished verity-setup.service - Verity Setup for /dev/mapper/usr. Aug 5 22:16:30.751924 kernel: BTRFS info (device dm-0): first mount of filesystem 278882ec-4175-45f0-a12b-7fddc0d6d9a3 Aug 5 22:16:30.751954 kernel: BTRFS info (device dm-0): using crc32c (crc32c-generic) checksum algorithm Aug 5 22:16:30.751965 kernel: BTRFS warning (device dm-0): 'nologreplay' is deprecated, use 'rescue=nologreplay' instead Aug 5 22:16:30.752918 kernel: BTRFS info (device dm-0): disabling log replay at mount time Aug 5 22:16:30.753659 kernel: BTRFS info (device dm-0): using free space tree Aug 5 22:16:30.760716 systemd[1]: Mounted sysusr-usr.mount - /sysusr/usr. Aug 5 22:16:30.923391 kernel: Key type trusted registered Aug 5 22:16:30.931822 kernel: Key type encrypted registered Aug 5 22:16:30.951910 systemd[1]: Found device dev-disk-by\x2dlabel-ROOT.device - /dev/disk/by-label/ROOT. Aug 5 22:16:30.953593 systemd[1]: Finished systemd-cryptsetup@rootencrypted.service - Cryptography Setup for rootencrypted. Aug 5 22:16:30.957026 systemd[1]: Finished decrypt-root.service - Generate and execute a systemd-cryptsetup service to decrypt the ROOT partition. Aug 5 22:16:30.958689 systemd[1]: Reached target initrd-root-device.target - Initrd Root Device. Aug 5 22:16:30.972502 systemd[1]: Starting dracut-initqueue.service - dracut initqueue hook... Aug 5 22:16:30.981686 systemd[1]: Finished dracut-initqueue.service - dracut initqueue hook. Aug 5 22:16:30.983147 systemd[1]: Reached target remote-fs-pre.target - Preparation for Remote File Systems. Aug 5 22:16:30.984607 systemd[1]: Reached target remote-cryptsetup.target - Remote Encrypted Volumes. Aug 5 22:16:30.986500 systemd[1]: Reached target remote-fs.target - Remote File Systems. Aug 5 22:16:30.996528 systemd[1]: Starting dracut-pre-mount.service - dracut pre-mount hook... Aug 5 22:16:31.005010 systemd[1]: Finished dracut-pre-mount.service - dracut pre-mount hook. Aug 5 22:16:31.007237 systemd[1]: Starting systemd-fsck-root.service - File System Check on /dev/disk/by-label/ROOT... Aug 5 22:16:31.029523 systemd-fsck[613]: ROOT: clean, 200/137360 files, 32507/549376 blocks Aug 5 22:16:31.032957 systemd[1]: Finished systemd-fsck-root.service - File System Check on /dev/disk/by-label/ROOT. Aug 5 22:16:31.045482 systemd[1]: Mounting sysroot.mount - /sysroot... Aug 5 22:16:31.094393 kernel: EXT4-fs (dm-1): mounted filesystem 306d9b36-dfb2-4196-ac47-05782b256d27 r/w with ordered data mode. Quota mode: none. Aug 5 22:16:31.095044 systemd[1]: Mounted sysroot.mount - /sysroot. Aug 5 22:16:31.096172 systemd[1]: Reached target initrd-root-fs.target - Initrd Root File System. Aug 5 22:16:31.108110 systemd[1]: Mounting sysroot-oem.mount - /sysroot/oem... Aug 5 22:16:31.109759 systemd[1]: Mounting sysroot-usr.mount - /sysroot/usr... Aug 5 22:16:31.115752 systemd[1]: Mounted sysroot-usr.mount - /sysroot/usr. Aug 5 22:16:31.117709 systemd[1]: Starting initrd-setup-root.service - Root filesystem setup... Aug 5 22:16:31.121030 kernel: BTRFS info (device vdb6): first mount of filesystem 47327e03-a391-4166-b35e-18ba93a1f298 Aug 5 22:16:31.121052 kernel: BTRFS info (device vdb6): using crc32c (crc32c-generic) checksum algorithm Aug 5 22:16:31.121062 kernel: BTRFS info (device vdb6): using free space tree Aug 5 22:16:31.123387 kernel: BTRFS info (device vdb6): auto enabling async discard Aug 5 22:16:31.124153 systemd[1]: Mounted sysroot-oem.mount - /sysroot/oem. Aug 5 22:16:31.451282 systemd[1]: Finished initrd-setup-root.service - Root filesystem setup. Aug 5 22:16:31.462604 systemd[1]: Starting initrd-setup-root-after-ignition.service - Root filesystem completion... Aug 5 22:16:31.469865 initrd-setup-root-after-ignition[919]: grep: /sysroot/oem/oem-release: No such file or directory Aug 5 22:16:31.473269 initrd-setup-root-after-ignition[921]: grep: /sysroot/etc/flatcar/enabled-sysext.conf: No such file or directory Aug 5 22:16:31.473269 initrd-setup-root-after-ignition[921]: grep: /sysroot/usr/share/flatcar/enabled-sysext.conf: No such file or directory Aug 5 22:16:31.476897 initrd-setup-root-after-ignition[925]: grep: /sysroot/etc/flatcar/enabled-sysext.conf: No such file or directory Aug 5 22:16:31.479419 systemd[1]: Finished initrd-setup-root-after-ignition.service - Root filesystem completion. Aug 5 22:16:31.480967 systemd[1]: Reached target ignition-subsequent.target - Subsequent (Not Ignition) boot complete. Aug 5 22:16:31.502562 systemd[1]: Starting initrd-parse-etc.service - Mountpoints Configured in the Real Root... Aug 5 22:16:31.525129 systemd[1]: initrd-parse-etc.service: Deactivated successfully. Aug 5 22:16:31.525238 systemd[1]: Finished initrd-parse-etc.service - Mountpoints Configured in the Real Root. Aug 5 22:16:31.527492 systemd[1]: Reached target initrd-fs.target - Initrd File Systems. Aug 5 22:16:31.529247 systemd[1]: Reached target initrd.target - Initrd Default Target. Aug 5 22:16:31.531013 systemd[1]: dracut-mount.service - dracut mount hook was skipped because no trigger condition checks were met. Aug 5 22:16:31.531787 systemd[1]: Starting dracut-pre-pivot.service - dracut pre-pivot and cleanup hook... Aug 5 22:16:31.549152 systemd[1]: Finished dracut-pre-pivot.service - dracut pre-pivot and cleanup hook. Aug 5 22:16:31.560531 systemd[1]: Starting initrd-cleanup.service - Cleaning Up and Shutting Down Daemons... Aug 5 22:16:31.567662 systemd[1]: Stopped target remote-cryptsetup.target - Remote Encrypted Volumes. Aug 5 22:16:31.568996 systemd[1]: Stopped target timers.target - Timer Units. Aug 5 22:16:31.570586 systemd[1]: dracut-pre-pivot.service: Deactivated successfully. Aug 5 22:16:31.570706 systemd[1]: Stopped dracut-pre-pivot.service - dracut pre-pivot and cleanup hook. Aug 5 22:16:31.573066 systemd[1]: Stopped target initrd.target - Initrd Default Target. Aug 5 22:16:31.575078 systemd[1]: Stopped target basic.target - Basic System. Aug 5 22:16:31.576664 systemd[1]: Stopped target ignition-subsequent.target - Subsequent (Not Ignition) boot complete. Aug 5 22:16:31.578552 systemd[1]: Stopped target ignition-diskful-subsequent.target - Ignition Subsequent Boot Disk Setup. Aug 5 22:16:31.580878 systemd[1]: Stopped target initrd-root-device.target - Initrd Root Device. Aug 5 22:16:31.583089 systemd[1]: Stopped target paths.target - Path Units. Aug 5 22:16:31.584957 systemd[1]: Stopped target remote-fs.target - Remote File Systems. Aug 5 22:16:31.586763 systemd[1]: Stopped target remote-fs-pre.target - Preparation for Remote File Systems. Aug 5 22:16:31.588631 systemd[1]: Stopped target slices.target - Slice Units. Aug 5 22:16:31.590312 systemd[1]: Stopped target sockets.target - Socket Units. Aug 5 22:16:31.591623 systemd[1]: Stopped target sysinit.target - System Initialization. Aug 5 22:16:31.593172 systemd[1]: Stopped target local-fs.target - Local File Systems. Aug 5 22:16:31.595043 systemd[1]: Stopped target swap.target - Swaps. Aug 5 22:16:31.596549 systemd[1]: iscsid.socket: Deactivated successfully. Aug 5 22:16:31.596642 systemd[1]: Closed iscsid.socket - Open-iSCSI iscsid Socket. Aug 5 22:16:31.598093 systemd[1]: iscsiuio.socket: Deactivated successfully. Aug 5 22:16:31.598174 systemd[1]: Closed iscsiuio.socket - Open-iSCSI iscsiuio Socket. Aug 5 22:16:31.599418 systemd[1]: dracut-pre-mount.service: Deactivated successfully. Aug 5 22:16:31.599526 systemd[1]: Stopped dracut-pre-mount.service - dracut pre-mount hook. Aug 5 22:16:31.601489 systemd[1]: Stopped target cryptsetup.target - Local Encrypted Volumes. Aug 5 22:16:31.603153 systemd[1]: systemd-ask-password-console.path: Deactivated successfully. Aug 5 22:16:31.607592 systemd[1]: Stopped systemd-ask-password-console.path - Dispatch Password Requests to Console Directory Watch. Aug 5 22:16:31.608766 systemd[1]: Stopped target cryptsetup-pre.target - Local Encrypted Volumes (Pre). Aug 5 22:16:31.610761 systemd[1]: clevis-luks-askpass.path: Deactivated successfully. Aug 5 22:16:31.610930 systemd[1]: Stopped clevis-luks-askpass.path - Forward Password Requests to Clevis Directory Watch. Aug 5 22:16:31.612653 systemd[1]: dracut-initqueue.service: Deactivated successfully. Aug 5 22:16:31.612786 systemd[1]: Stopped dracut-initqueue.service - dracut initqueue hook. Aug 5 22:16:31.615383 systemd[1]: decrypt-root.service: Deactivated successfully. Aug 5 22:16:31.615490 systemd[1]: Stopped decrypt-root.service - Generate and execute a systemd-cryptsetup service to decrypt the ROOT partition. Aug 5 22:16:31.617635 systemd[1]: ignition-setup-pre.service: Deactivated successfully. Aug 5 22:16:31.617747 systemd[1]: Stopped ignition-setup-pre.service - Ignition env setup. Aug 5 22:16:31.619455 systemd[1]: initrd-setup-root-after-ignition.service: Deactivated successfully. Aug 5 22:16:31.619560 systemd[1]: Stopped initrd-setup-root-after-ignition.service - Root filesystem completion. Aug 5 22:16:31.621450 systemd[1]: initrd-setup-root.service: Deactivated successfully. Aug 5 22:16:31.621556 systemd[1]: Stopped initrd-setup-root.service - Root filesystem setup. Aug 5 22:16:31.623527 systemd[1]: systemd-sysctl.service: Deactivated successfully. Aug 5 22:16:31.623630 systemd[1]: Stopped systemd-sysctl.service - Apply Kernel Variables. Aug 5 22:16:31.625247 systemd[1]: systemd-modules-load.service: Deactivated successfully. Aug 5 22:16:31.625348 systemd[1]: Stopped systemd-modules-load.service - Load Kernel Modules. Aug 5 22:16:31.627147 systemd[1]: systemd-tmpfiles-setup.service: Deactivated successfully. Aug 5 22:16:31.627250 systemd[1]: Stopped systemd-tmpfiles-setup.service - Create Volatile Files and Directories. Aug 5 22:16:31.629114 systemd[1]: systemd-udev-trigger.service: Deactivated successfully. Aug 5 22:16:31.629214 systemd[1]: Stopped systemd-udev-trigger.service - Coldplug All udev Devices. Aug 5 22:16:31.631137 systemd[1]: dracut-pre-trigger.service: Deactivated successfully. Aug 5 22:16:31.631241 systemd[1]: Stopped dracut-pre-trigger.service - dracut pre-trigger hook. Aug 5 22:16:31.633512 systemd[1]: Stopping systemd-udevd.service - Rule-based Manager for Device Events and Files... Aug 5 22:16:31.639177 systemd[1]: initrd-cleanup.service: Deactivated successfully. Aug 5 22:16:31.639262 systemd[1]: Finished initrd-cleanup.service - Cleaning Up and Shutting Down Daemons. Aug 5 22:16:31.648637 systemd[1]: systemd-udevd.service: Deactivated successfully. Aug 5 22:16:31.649450 systemd[1]: Stopped systemd-udevd.service - Rule-based Manager for Device Events and Files. Aug 5 22:16:31.651775 systemd[1]: systemd-udevd-control.socket: Deactivated successfully. Aug 5 22:16:31.651824 systemd[1]: Closed systemd-udevd-control.socket - udev Control Socket. Aug 5 22:16:31.654263 systemd[1]: systemd-udevd-kernel.socket: Deactivated successfully. Aug 5 22:16:31.654299 systemd[1]: Closed systemd-udevd-kernel.socket - udev Kernel Socket. Aug 5 22:16:31.656322 systemd[1]: dracut-pre-udev.service: Deactivated successfully. Aug 5 22:16:31.656384 systemd[1]: Stopped dracut-pre-udev.service - dracut pre-udev hook. Aug 5 22:16:31.658592 systemd[1]: dracut-cmdline.service: Deactivated successfully. Aug 5 22:16:31.658640 systemd[1]: Stopped dracut-cmdline.service - dracut cmdline hook. Aug 5 22:16:31.661055 systemd[1]: dracut-cmdline-ask.service: Deactivated successfully. Aug 5 22:16:31.661103 systemd[1]: Stopped dracut-cmdline-ask.service - dracut ask for additional cmdline parameters. Aug 5 22:16:31.683894 systemd[1]: Starting initrd-udevadm-cleanup-db.service - Cleanup udev Database... Aug 5 22:16:31.684792 systemd[1]: systemd-tmpfiles-setup-dev.service: Deactivated successfully. Aug 5 22:16:31.684856 systemd[1]: Stopped systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev. Aug 5 22:16:31.687155 systemd[1]: systemd-tmpfiles-setup-dev-early.service: Deactivated successfully. Aug 5 22:16:31.687204 systemd[1]: Stopped systemd-tmpfiles-setup-dev-early.service - Create Static Device Nodes in /dev gracefully. Aug 5 22:16:31.689296 systemd[1]: kmod-static-nodes.service: Deactivated successfully. Aug 5 22:16:31.689470 systemd[1]: Stopped kmod-static-nodes.service - Create List of Static Device Nodes. Aug 5 22:16:31.691445 systemd[1]: systemd-vconsole-setup.service: Deactivated successfully. Aug 5 22:16:31.691489 systemd[1]: Stopped systemd-vconsole-setup.service - Virtual Console Setup. Aug 5 22:16:31.694443 systemd[1]: initrd-udevadm-cleanup-db.service: Deactivated successfully. Aug 5 22:16:31.696416 systemd[1]: Finished initrd-udevadm-cleanup-db.service - Cleanup udev Database. Aug 5 22:16:31.698658 systemd[1]: Reached target initrd-switch-root.target - Switch Root. Aug 5 22:16:31.700530 systemd[1]: Starting initrd-switch-root.service - Switch Root... Aug 5 22:16:31.712449 systemd[1]: Switching root. Aug 5 22:16:31.746877 systemd-journald[231]: Journal stopped Aug 5 22:16:32.249667 systemd-journald[231]: Received SIGTERM from PID 1 (systemd). Aug 5 22:16:32.249728 kernel: SELinux: policy capability network_peer_controls=1 Aug 5 22:16:32.249742 kernel: SELinux: policy capability open_perms=1 Aug 5 22:16:32.249755 kernel: SELinux: policy capability extended_socket_class=1 Aug 5 22:16:32.249764 kernel: SELinux: policy capability always_check_network=0 Aug 5 22:16:32.249774 kernel: SELinux: policy capability cgroup_seclabel=1 Aug 5 22:16:32.249784 kernel: SELinux: policy capability nnp_nosuid_transition=1 Aug 5 22:16:32.249793 kernel: SELinux: policy capability genfs_seclabel_symlinks=0 Aug 5 22:16:32.249803 kernel: SELinux: policy capability ioctl_skip_cloexec=0 Aug 5 22:16:32.249812 kernel: audit: type=1403 audit(1722896191.822:2): auid=4294967295 ses=4294967295 lsm=selinux res=1 Aug 5 22:16:32.249823 systemd[1]: Successfully loaded SELinux policy in 29.817ms. Aug 5 22:16:32.249840 systemd[1]: Relabeled /dev, /dev/shm, /run, /sys/fs/cgroup in 9.311ms. Aug 5 22:16:32.249853 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:16:32.249864 systemd[1]: Detected virtualization kvm. Aug 5 22:16:32.249874 systemd[1]: Detected architecture arm64. Aug 5 22:16:32.249885 zram_generator::config[969]: No configuration found. Aug 5 22:16:32.249896 systemd[1]: initrd-switch-root.service: Deactivated successfully. Aug 5 22:16:32.249906 systemd[1]: Stopped initrd-switch-root.service - Switch Root. Aug 5 22:16:32.249917 systemd[1]: systemd-journald.service: Scheduled restart job, restart counter is at 1. Aug 5 22:16:32.249928 systemd[1]: Created slice system-addon\x2dconfig.slice - Slice /system/addon-config. Aug 5 22:16:32.249940 systemd[1]: Created slice system-addon\x2drun.slice - Slice /system/addon-run. Aug 5 22:16:32.249956 systemd[1]: Created slice system-getty.slice - Slice /system/getty. Aug 5 22:16:32.249966 systemd[1]: Created slice system-modprobe.slice - Slice /system/modprobe. Aug 5 22:16:32.249977 systemd[1]: Created slice system-serial\x2dgetty.slice - Slice /system/serial-getty. Aug 5 22:16:32.249987 systemd[1]: Created slice system-system\x2dcloudinit.slice - Slice /system/system-cloudinit. Aug 5 22:16:32.249998 systemd[1]: Created slice system-systemd\x2dfsck.slice - Slice /system/systemd-fsck. Aug 5 22:16:32.250008 systemd[1]: Created slice user.slice - User and Session Slice. Aug 5 22:16:32.250019 systemd[1]: Started clevis-luks-askpass.path - Forward Password Requests to Clevis Directory Watch. Aug 5 22:16:32.250030 systemd[1]: Started systemd-ask-password-console.path - Dispatch Password Requests to Console Directory Watch. Aug 5 22:16:32.250041 systemd[1]: Started systemd-ask-password-wall.path - Forward Password Requests to Wall Directory Watch. Aug 5 22:16:32.250052 systemd[1]: Set up automount boot.automount - Boot partition Automount Point. Aug 5 22:16:32.250062 systemd[1]: Set up automount proc-sys-fs-binfmt_misc.automount - Arbitrary Executable File Formats File System Automount Point. Aug 5 22:16:32.250073 systemd[1]: Expecting device dev-disk-by\x2dlabel-OEM.device - /dev/disk/by-label/OEM... Aug 5 22:16:32.250084 systemd[1]: Expecting device dev-ttyAMA0.device - /dev/ttyAMA0... Aug 5 22:16:32.250094 systemd[1]: Reached target blockdev@dev-mapper-rootencrypted.target - Block Device Preparation for /dev/mapper/rootencrypted. Aug 5 22:16:32.250105 systemd[1]: Reached target cryptsetup-pre.target - Local Encrypted Volumes (Pre). Aug 5 22:16:32.250115 systemd[1]: Stopped target initrd-switch-root.target - Switch Root. Aug 5 22:16:32.250127 systemd[1]: Stopped target initrd-fs.target - Initrd File Systems. Aug 5 22:16:32.250137 systemd[1]: Stopped target initrd-root-fs.target - Initrd Root File System. Aug 5 22:16:32.250147 systemd[1]: Reached target integritysetup.target - Local Integrity Protected Volumes. Aug 5 22:16:32.250158 systemd[1]: Reached target remote-cryptsetup.target - Remote Encrypted Volumes. Aug 5 22:16:32.250168 systemd[1]: Reached target remote-fs.target - Remote File Systems. Aug 5 22:16:32.250180 systemd[1]: Reached target slices.target - Slice Units. Aug 5 22:16:32.250190 systemd[1]: Reached target swap.target - Swaps. Aug 5 22:16:32.250200 systemd[1]: Reached target veritysetup.target - Local Verity Protected Volumes. Aug 5 22:16:32.250213 systemd[1]: Listening on systemd-coredump.socket - Process Core Dump Socket. Aug 5 22:16:32.250224 systemd[1]: Listening on systemd-networkd.socket - Network Service Netlink Socket. Aug 5 22:16:32.250234 systemd[1]: Listening on systemd-udevd-control.socket - udev Control Socket. Aug 5 22:16:32.250245 systemd[1]: Listening on systemd-udevd-kernel.socket - udev Kernel Socket. Aug 5 22:16:32.250256 systemd[1]: Listening on systemd-userdbd.socket - User Database Manager Socket. Aug 5 22:16:32.250266 systemd[1]: Mounting dev-hugepages.mount - Huge Pages File System... Aug 5 22:16:32.250276 systemd[1]: Mounting dev-mqueue.mount - POSIX Message Queue File System... Aug 5 22:16:32.250287 systemd[1]: Mounting media.mount - External Media Directory... Aug 5 22:16:32.250297 systemd[1]: Mounting sys-kernel-debug.mount - Kernel Debug File System... Aug 5 22:16:32.250309 systemd[1]: Mounting sys-kernel-tracing.mount - Kernel Trace File System... Aug 5 22:16:32.250320 systemd[1]: Mounting tmp.mount - Temporary Directory /tmp... Aug 5 22:16:32.250331 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:16:32.250342 systemd[1]: Reached target machines.target - Containers. Aug 5 22:16:32.250352 systemd[1]: Starting flatcar-tmpfiles.service - Create missing system files... Aug 5 22:16:32.250363 systemd[1]: ignition-delete-config.service - Ignition (delete config) was skipped because of an unmet condition check (ConditionFirstBoot=true). Aug 5 22:16:32.250421 systemd[1]: Starting kmod-static-nodes.service - Create List of Static Device Nodes... Aug 5 22:16:32.250435 systemd[1]: Starting modprobe@configfs.service - Load Kernel Module configfs... Aug 5 22:16:32.250449 systemd[1]: Starting modprobe@dm_mod.service - Load Kernel Module dm_mod... Aug 5 22:16:32.250461 systemd[1]: Starting modprobe@drm.service - Load Kernel Module drm... Aug 5 22:16:32.250471 systemd[1]: Starting modprobe@efi_pstore.service - Load Kernel Module efi_pstore... Aug 5 22:16:32.250481 systemd[1]: Starting modprobe@fuse.service - Load Kernel Module fuse... Aug 5 22:16:32.250491 systemd[1]: Starting modprobe@loop.service - Load Kernel Module loop... Aug 5 22:16:32.250502 systemd[1]: setup-nsswitch.service - Create /etc/nsswitch.conf was skipped because of an unmet condition check (ConditionPathExists=!/etc/nsswitch.conf). Aug 5 22:16:32.250513 systemd[1]: systemd-fsck-root.service: Deactivated successfully. Aug 5 22:16:32.250523 systemd[1]: Stopped systemd-fsck-root.service - File System Check on Root Device. Aug 5 22:16:32.250535 kernel: loop: module loaded Aug 5 22:16:32.250545 systemd[1]: systemd-fsck-usr.service: Deactivated successfully. Aug 5 22:16:32.250556 systemd[1]: Stopped systemd-fsck-usr.service. Aug 5 22:16:32.250565 kernel: fuse: init (API version 7.39) Aug 5 22:16:32.250575 kernel: ACPI: bus type drm_connector registered Aug 5 22:16:32.250585 systemd[1]: Starting systemd-journald.service - Journal Service... Aug 5 22:16:32.250595 systemd[1]: Starting systemd-modules-load.service - Load Kernel Modules... Aug 5 22:16:32.250606 systemd[1]: Starting systemd-network-generator.service - Generate network units from Kernel command line... Aug 5 22:16:32.250616 systemd[1]: Starting systemd-remount-fs.service - Remount Root and Kernel File Systems... Aug 5 22:16:32.250627 systemd[1]: Starting systemd-udev-trigger.service - Coldplug All udev Devices... Aug 5 22:16:32.250639 systemd[1]: verity-setup.service: Deactivated successfully. Aug 5 22:16:32.250665 systemd-journald[1036]: Collecting audit messages is disabled. Aug 5 22:16:32.250686 systemd[1]: Stopped verity-setup.service. Aug 5 22:16:32.250696 systemd-journald[1036]: Journal started Aug 5 22:16:32.250722 systemd-journald[1036]: Runtime Journal (/run/log/journal/34d35adb6cb64892a3f942ca92e347c0) is 5.9M, max 47.3M, 41.4M free. Aug 5 22:16:32.069056 systemd[1]: Queued start job for default target multi-user.target. Aug 5 22:16:32.082598 systemd[1]: Unnecessary job was removed for dev-vdb6.device - /dev/vdb6. Aug 5 22:16:32.082608 systemd[1]: Unnecessary job was removed for dev-disk-by\x2duuid-dfb25628\x2de29b\x2d470b\x2d9f0e\x2d77bf2c42124a.device - /dev/disk/by-uuid/dfb25628-e29b-470b-9f0e-77bf2c42124a. Aug 5 22:16:32.082984 systemd[1]: systemd-journald.service: Deactivated successfully. Aug 5 22:16:32.252727 systemd[1]: Started systemd-journald.service - Journal Service. Aug 5 22:16:32.253281 systemd[1]: Mounted dev-hugepages.mount - Huge Pages File System. Aug 5 22:16:32.254210 systemd[1]: Mounted dev-mqueue.mount - POSIX Message Queue File System. Aug 5 22:16:32.255165 systemd[1]: Mounted media.mount - External Media Directory. Aug 5 22:16:32.255987 systemd[1]: Mounted sys-kernel-debug.mount - Kernel Debug File System. Aug 5 22:16:32.256910 systemd[1]: Mounted sys-kernel-tracing.mount - Kernel Trace File System. Aug 5 22:16:32.257843 systemd[1]: Mounted tmp.mount - Temporary Directory /tmp. Aug 5 22:16:32.260404 systemd[1]: Finished flatcar-tmpfiles.service - Create missing system files. Aug 5 22:16:32.261819 systemd[1]: Finished kmod-static-nodes.service - Create List of Static Device Nodes. Aug 5 22:16:32.263248 systemd[1]: modprobe@configfs.service: Deactivated successfully. Aug 5 22:16:32.263436 systemd[1]: Finished modprobe@configfs.service - Load Kernel Module configfs. Aug 5 22:16:32.264771 systemd[1]: modprobe@dm_mod.service: Deactivated successfully. Aug 5 22:16:32.264907 systemd[1]: Finished modprobe@dm_mod.service - Load Kernel Module dm_mod. Aug 5 22:16:32.266141 systemd[1]: modprobe@drm.service: Deactivated successfully. Aug 5 22:16:32.266275 systemd[1]: Finished modprobe@drm.service - Load Kernel Module drm. Aug 5 22:16:32.267350 systemd[1]: modprobe@efi_pstore.service: Deactivated successfully. Aug 5 22:16:32.267522 systemd[1]: Finished modprobe@efi_pstore.service - Load Kernel Module efi_pstore. Aug 5 22:16:32.268596 systemd[1]: modprobe@fuse.service: Deactivated successfully. Aug 5 22:16:32.268742 systemd[1]: Finished modprobe@fuse.service - Load Kernel Module fuse. Aug 5 22:16:32.270167 systemd[1]: modprobe@loop.service: Deactivated successfully. Aug 5 22:16:32.270297 systemd[1]: Finished modprobe@loop.service - Load Kernel Module loop. Aug 5 22:16:32.271463 systemd[1]: Finished systemd-modules-load.service - Load Kernel Modules. Aug 5 22:16:32.272495 systemd[1]: Finished systemd-network-generator.service - Generate network units from Kernel command line. Aug 5 22:16:32.273752 systemd[1]: Finished systemd-remount-fs.service - Remount Root and Kernel File Systems. Aug 5 22:16:32.285574 systemd[1]: Reached target network-pre.target - Preparation for Network. Aug 5 22:16:32.299487 systemd[1]: Mounting sys-fs-fuse-connections.mount - FUSE Control File System... Aug 5 22:16:32.301525 systemd[1]: Mounting sys-kernel-config.mount - Kernel Configuration File System... Aug 5 22:16:32.302669 systemd[1]: remount-root.service - Remount Root File System was skipped because of an unmet condition check (ConditionPathIsReadWrite=!/). Aug 5 22:16:32.302706 systemd[1]: Reached target local-fs.target - Local File Systems. Aug 5 22:16:32.304730 systemd[1]: Listening on systemd-sysext.socket - System Extension Image Management (Varlink). Aug 5 22:16:32.306557 systemd[1]: Starting dracut-shutdown.service - Restore /run/initramfs on shutdown... Aug 5 22:16:32.308617 systemd[1]: Starting ldconfig.service - Rebuild Dynamic Linker Cache... Aug 5 22:16:32.309653 systemd[1]: systemd-binfmt.service - Set Up Additional Binary Formats was skipped because no trigger condition checks were met. Aug 5 22:16:32.311091 systemd[1]: Starting systemd-hwdb-update.service - Rebuild Hardware Database... Aug 5 22:16:32.312940 systemd[1]: Starting systemd-journal-flush.service - Flush Journal to Persistent Storage... Aug 5 22:16:32.313805 systemd[1]: systemd-pstore.service - Platform Persistent Storage Archival was skipped because of an unmet condition check (ConditionDirectoryNotEmpty=/sys/fs/pstore). Aug 5 22:16:32.316153 systemd[1]: Starting systemd-random-seed.service - Load/Save OS Random Seed... Aug 5 22:16:32.317103 systemd[1]: systemd-repart.service - Repartition Root Disk was skipped because no trigger condition checks were met. Aug 5 22:16:32.318569 systemd[1]: Starting systemd-sysctl.service - Apply Kernel Variables... Aug 5 22:16:32.323930 systemd-journald[1036]: Time spent on flushing to /var/log/journal/34d35adb6cb64892a3f942ca92e347c0 is 27.526ms for 669 entries. Aug 5 22:16:32.323930 systemd-journald[1036]: System Journal (/var/log/journal/34d35adb6cb64892a3f942ca92e347c0) is 12.4M, max 204.2M, 191.7M free. Aug 5 22:16:32.400945 systemd-journald[1036]: Received client request to flush runtime journal. Aug 5 22:16:32.400997 systemd-journald[1036]: /var/log/journal/34d35adb6cb64892a3f942ca92e347c0/system.journal: Journal file uses a different sequence number ID, rotating. Aug 5 22:16:32.401021 systemd-journald[1036]: Rotating system journal. Aug 5 22:16:32.401043 kernel: loop0: detected capacity change from 0 to 113672 Aug 5 22:16:32.401061 kernel: block loop0: the capability attribute has been deprecated. Aug 5 22:16:32.401195 kernel: squashfs: version 4.0 (2009/01/31) Phillip Lougher Aug 5 22:16:32.401220 kernel: loop1: detected capacity change from 0 to 59688 Aug 5 22:16:32.324814 systemd[1]: Starting systemd-sysext.service - Merge System Extension Images into /usr/ and /opt/... Aug 5 22:16:32.331700 systemd[1]: Starting systemd-tmpfiles-setup-dev-early.service - Create Static Device Nodes in /dev gracefully... Aug 5 22:16:32.334211 systemd[1]: Finished systemd-udev-trigger.service - Coldplug All udev Devices. Aug 5 22:16:32.335721 systemd[1]: Mounted sys-fs-fuse-connections.mount - FUSE Control File System. Aug 5 22:16:32.337078 systemd[1]: Mounted sys-kernel-config.mount - Kernel Configuration File System. Aug 5 22:16:32.342171 systemd[1]: Finished dracut-shutdown.service - Restore /run/initramfs on shutdown. Aug 5 22:16:32.345227 systemd[1]: Finished systemd-random-seed.service - Load/Save OS Random Seed. Aug 5 22:16:32.351727 systemd[1]: Finished systemd-sysctl.service - Apply Kernel Variables. Aug 5 22:16:32.359063 systemd[1]: first-boot-complete.target - First Boot Complete was skipped because of an unmet condition check (ConditionFirstBoot=yes). Aug 5 22:16:32.359137 systemd[1]: systemd-machine-id-commit.service - Commit a transient machine-id on disk was skipped because of an unmet condition check (ConditionPathIsMountPoint=/etc/machine-id). Aug 5 22:16:32.373252 systemd[1]: Starting systemd-udev-settle.service - Wait for udev To Complete Device Initialization... Aug 5 22:16:32.385754 udevadm[1091]: systemd-udev-settle.service is deprecated. Please fix lvm2-activation.service, lvm2-activation-early.service not to pull it in. Aug 5 22:16:32.396043 systemd-tmpfiles[1078]: ACLs are not supported, ignoring. Aug 5 22:16:32.396057 systemd-tmpfiles[1078]: ACLs are not supported, ignoring. Aug 5 22:16:32.403442 systemd[1]: Finished systemd-tmpfiles-setup-dev-early.service - Create Static Device Nodes in /dev gracefully. Aug 5 22:16:32.406419 systemd[1]: Finished systemd-journal-flush.service - Flush Journal to Persistent Storage. Aug 5 22:16:32.415735 systemd[1]: Starting systemd-sysusers.service - Create System Users... Aug 5 22:16:32.424649 kernel: loop2: detected capacity change from 0 to 113672 Aug 5 22:16:32.428480 kernel: loop3: detected capacity change from 0 to 59688 Aug 5 22:16:32.434738 (sd-merge)[1102]: Using extensions 'containerd-flatcar', 'docker-flatcar'. Aug 5 22:16:32.435126 (sd-merge)[1102]: Merged extensions into '/usr'. Aug 5 22:16:32.439425 systemd[1]: Finished systemd-sysext.service - Merge System Extension Images into /usr/ and /opt/. Aug 5 22:16:32.441951 systemd[1]: Finished systemd-sysusers.service - Create System Users. Aug 5 22:16:32.453559 systemd[1]: Starting ensure-sysext.service... Aug 5 22:16:32.456252 systemd[1]: Starting systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev... Aug 5 22:16:32.461448 systemd[1]: Starting systemd-tmpfiles-setup.service - Create Volatile Files and Directories... Aug 5 22:16:32.466084 ldconfig[1071]: /sbin/ldconfig: /lib/ld.so.conf is not an ELF file - it has the wrong magic bytes at the start. Aug 5 22:16:32.466646 systemd[1]: Reloading requested from client PID 1105 ('systemctl') (unit ensure-sysext.service)... Aug 5 22:16:32.466667 systemd[1]: Reloading... Aug 5 22:16:32.472177 systemd-tmpfiles[1106]: ACLs are not supported, ignoring. Aug 5 22:16:32.472435 systemd-tmpfiles[1106]: ACLs are not supported, ignoring. Aug 5 22:16:32.479845 systemd-tmpfiles[1107]: /usr/lib/tmpfiles.d/provision.conf:20: Duplicate line for path "/root", ignoring. Aug 5 22:16:32.480053 systemd-tmpfiles[1107]: /usr/lib/tmpfiles.d/systemd-flatcar.conf:6: Duplicate line for path "/var/log/journal", ignoring. Aug 5 22:16:32.480639 systemd-tmpfiles[1107]: /usr/lib/tmpfiles.d/systemd.conf:29: Duplicate line for path "/var/lib/systemd", ignoring. Aug 5 22:16:32.480845 systemd-tmpfiles[1107]: ACLs are not supported, ignoring. Aug 5 22:16:32.480898 systemd-tmpfiles[1107]: ACLs are not supported, ignoring. Aug 5 22:16:32.484524 systemd-tmpfiles[1107]: Detected autofs mount point /boot during canonicalization of boot. Aug 5 22:16:32.484537 systemd-tmpfiles[1107]: Skipping /boot Aug 5 22:16:32.493667 systemd-tmpfiles[1107]: Detected autofs mount point /boot during canonicalization of boot. Aug 5 22:16:32.493684 systemd-tmpfiles[1107]: Skipping /boot Aug 5 22:16:32.510396 zram_generator::config[1133]: No configuration found. Aug 5 22:16:32.597275 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:16:32.638574 systemd[1]: Reloading finished in 171 ms. Aug 5 22:16:32.665014 systemd[1]: Finished ldconfig.service - Rebuild Dynamic Linker Cache. Aug 5 22:16:32.666909 systemd[1]: Finished systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev. Aug 5 22:16:32.668415 systemd[1]: Finished systemd-tmpfiles-setup.service - Create Volatile Files and Directories. Aug 5 22:16:32.675108 systemd[1]: Starting audit-rules.service - Load Security Auditing Rules... Aug 5 22:16:32.677272 systemd[1]: Starting clean-ca-certificates.service - Clean up broken links in /etc/ssl/certs... Aug 5 22:16:32.680581 systemd[1]: Starting systemd-journal-catalog-update.service - Rebuild Journal Catalog... Aug 5 22:16:32.685548 systemd[1]: Starting systemd-resolved.service - Network Name Resolution... Aug 5 22:16:32.687288 systemd[1]: Starting systemd-update-utmp.service - Record System Boot/Shutdown in UTMP... Aug 5 22:16:32.694598 systemd[1]: ignition-delete-config.service - Ignition (delete config) was skipped because of an unmet condition check (ConditionFirstBoot=true). Aug 5 22:16:32.696815 systemd[1]: Starting modprobe@dm_mod.service - Load Kernel Module dm_mod... Aug 5 22:16:32.701090 systemd[1]: Starting modprobe@efi_pstore.service - Load Kernel Module efi_pstore... Aug 5 22:16:32.703291 systemd[1]: Starting modprobe@loop.service - Load Kernel Module loop... Aug 5 22:16:32.704498 systemd[1]: systemd-binfmt.service - Set Up Additional Binary Formats was skipped because no trigger condition checks were met. Aug 5 22:16:32.704623 systemd[1]: systemd-machine-id-commit.service - Commit a transient machine-id on disk was skipped because of an unmet condition check (ConditionPathIsMountPoint=/etc/machine-id). Aug 5 22:16:32.705305 systemd[1]: modprobe@dm_mod.service: Deactivated successfully. Aug 5 22:16:32.707424 systemd[1]: Finished modprobe@dm_mod.service - Load Kernel Module dm_mod. Aug 5 22:16:32.713694 systemd[1]: ignition-delete-config.service - Ignition (delete config) was skipped because of an unmet condition check (ConditionFirstBoot=true). Aug 5 22:16:32.723741 systemd[1]: Starting modprobe@dm_mod.service - Load Kernel Module dm_mod... Aug 5 22:16:32.724899 systemd[1]: systemd-binfmt.service - Set Up Additional Binary Formats was skipped because no trigger condition checks were met. Aug 5 22:16:32.725023 systemd[1]: systemd-machine-id-commit.service - Commit a transient machine-id on disk was skipped because of an unmet condition check (ConditionPathIsMountPoint=/etc/machine-id). Aug 5 22:16:32.726019 systemd[1]: Finished systemd-journal-catalog-update.service - Rebuild Journal Catalog. Aug 5 22:16:32.728739 systemd[1]: Finished systemd-update-utmp.service - Record System Boot/Shutdown in UTMP. Aug 5 22:16:32.731895 systemd[1]: modprobe@efi_pstore.service: Deactivated successfully. Aug 5 22:16:32.732024 systemd[1]: Finished modprobe@efi_pstore.service - Load Kernel Module efi_pstore. Aug 5 22:16:32.733623 systemd[1]: modprobe@loop.service: Deactivated successfully. Aug 5 22:16:32.733754 systemd[1]: Finished modprobe@loop.service - Load Kernel Module loop. Aug 5 22:16:32.735262 systemd[1]: modprobe@dm_mod.service: Deactivated successfully. Aug 5 22:16:32.735402 systemd[1]: Finished modprobe@dm_mod.service - Load Kernel Module dm_mod. Aug 5 22:16:32.740145 augenrules[1170]: /sbin/augenrules: No change Aug 5 22:16:32.740950 systemd[1]: Finished clean-ca-certificates.service - Clean up broken links in /etc/ssl/certs. Aug 5 22:16:32.748902 systemd[1]: ignition-delete-config.service - Ignition (delete config) was skipped because of an unmet condition check (ConditionFirstBoot=true). Aug 5 22:16:32.756891 systemd[1]: Starting modprobe@dm_mod.service - Load Kernel Module dm_mod... Aug 5 22:16:32.758943 systemd[1]: Starting modprobe@drm.service - Load Kernel Module drm... Aug 5 22:16:32.760227 augenrules[1193]: No rules Aug 5 22:16:32.761125 systemd[1]: Starting modprobe@efi_pstore.service - Load Kernel Module efi_pstore... Aug 5 22:16:32.765664 systemd[1]: Starting modprobe@loop.service - Load Kernel Module loop... Aug 5 22:16:32.766836 systemd[1]: systemd-binfmt.service - Set Up Additional Binary Formats was skipped because no trigger condition checks were met. Aug 5 22:16:32.766962 systemd[1]: systemd-machine-id-commit.service - Commit a transient machine-id on disk was skipped because of an unmet condition check (ConditionPathIsMountPoint=/etc/machine-id). Aug 5 22:16:32.768474 systemd[1]: Starting systemd-userdbd.service - User Database Manager... Aug 5 22:16:32.769201 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:16:32.771398 systemd[1]: Finished audit-rules.service - Load Security Auditing Rules. Aug 5 22:16:32.772621 systemd[1]: modprobe@dm_mod.service: Deactivated successfully. Aug 5 22:16:32.772753 systemd[1]: Finished modprobe@dm_mod.service - Load Kernel Module dm_mod. Aug 5 22:16:32.774892 systemd[1]: modprobe@drm.service: Deactivated successfully. Aug 5 22:16:32.775018 systemd[1]: Finished modprobe@drm.service - Load Kernel Module drm. Aug 5 22:16:32.776481 systemd[1]: modprobe@efi_pstore.service: Deactivated successfully. Aug 5 22:16:32.776599 systemd[1]: Finished modprobe@efi_pstore.service - Load Kernel Module efi_pstore. Aug 5 22:16:32.778146 systemd[1]: modprobe@loop.service: Deactivated successfully. Aug 5 22:16:32.778270 systemd[1]: Finished modprobe@loop.service - Load Kernel Module loop. Aug 5 22:16:32.782669 systemd[1]: Finished ensure-sysext.service. Aug 5 22:16:32.785641 systemd[1]: systemd-pstore.service - Platform Persistent Storage Archival was skipped because of an unmet condition check (ConditionDirectoryNotEmpty=/sys/fs/pstore). Aug 5 22:16:32.785701 systemd[1]: systemd-repart.service - Repartition Root Disk was skipped because no trigger condition checks were met. Aug 5 22:16:32.797608 systemd[1]: Starting systemd-timesyncd.service - Network Time Synchronization... Aug 5 22:16:32.798842 systemd[1]: Finished systemd-hwdb-update.service - Rebuild Hardware Database. Aug 5 22:16:32.803531 systemd[1]: Starting systemd-udevd.service - Rule-based Manager for Device Events and Files... Aug 5 22:16:32.813863 systemd[1]: Starting systemd-update-done.service - Update is Completed... Aug 5 22:16:32.814903 systemd[1]: Started systemd-userdbd.service - User Database Manager. Aug 5 22:16:32.828942 systemd[1]: Finished systemd-update-done.service - Update is Completed. Aug 5 22:16:32.831419 systemd-udevd[1213]: Using default interface naming scheme 'v255'. Aug 5 22:16:32.843862 systemd[1]: Started systemd-udevd.service - Rule-based Manager for Device Events and Files. Aug 5 22:16:32.857630 systemd[1]: Starting systemd-networkd.service - Network Configuration... Aug 5 22:16:32.858473 systemd[1]: Started systemd-timesyncd.service - Network Time Synchronization. Aug 5 22:16:32.864644 systemd[1]: Reached target time-set.target - System Time Set. Aug 5 22:16:32.870466 systemd-resolved[1174]: Positive Trust Anchors: Aug 5 22:16:32.870480 systemd-resolved[1174]: . IN DS 20326 8 2 e06d44b80b8f1d39a95c0b0d7c65d08458e880409bbc683457104237c7f8ec8d Aug 5 22:16:32.870511 systemd-resolved[1174]: 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:16:32.877637 systemd-resolved[1174]: Defaulting to hostname 'linux'. Aug 5 22:16:32.879116 systemd[1]: Started systemd-resolved.service - Network Name Resolution. Aug 5 22:16:32.881536 systemd[1]: Reached target nss-lookup.target - Host and Network Name Lookups. Aug 5 22:16:32.890604 systemd[1]: Condition check resulted in dev-ttyAMA0.device - /dev/ttyAMA0 being skipped. Aug 5 22:16:32.893387 kernel: BTRFS info: devid 1 device path /dev/mapper/usr changed to /dev/dm-0 scanned by (udev-worker) (1234) Aug 5 22:16:32.914400 kernel: BTRFS warning: duplicate device /dev/vdb3 devid 1 generation 41 scanned by (udev-worker) (1241) Aug 5 22:16:32.918968 systemd-networkd[1229]: lo: Link UP Aug 5 22:16:32.918981 systemd-networkd[1229]: lo: Gained carrier Aug 5 22:16:32.919989 systemd-networkd[1229]: Enumeration completed Aug 5 22:16:32.920749 systemd[1]: Started systemd-networkd.service - Network Configuration. Aug 5 22:16:32.920990 systemd-networkd[1229]: eth0: found matching network '/usr/lib/systemd/network/zz-default.network', based on potentially unpredictable interface name. Aug 5 22:16:32.921000 systemd-networkd[1229]: eth0: Configuring with /usr/lib/systemd/network/zz-default.network. Aug 5 22:16:32.921913 systemd[1]: Reached target network.target - Network. Aug 5 22:16:32.922728 systemd-networkd[1229]: eth0: found matching network '/usr/lib/systemd/network/zz-default.network', based on potentially unpredictable interface name. Aug 5 22:16:32.922764 systemd-networkd[1229]: eth0: Link UP Aug 5 22:16:32.922766 systemd-networkd[1229]: eth0: Gained carrier Aug 5 22:16:32.922776 systemd-networkd[1229]: eth0: found matching network '/usr/lib/systemd/network/zz-default.network', based on potentially unpredictable interface name. Aug 5 22:16:32.929553 systemd[1]: Starting systemd-networkd-wait-online.service - Wait for Network to be Configured... Aug 5 22:16:32.933450 systemd-networkd[1229]: eth0: DHCPv4 address 10.0.0.113/16, gateway 10.0.0.1 acquired from 10.0.0.1 Aug 5 22:16:32.934119 systemd-timesyncd[1211]: Network configuration changed, trying to establish connection. Aug 5 22:16:32.942892 systemd[1]: Found device dev-disk-by\x2dlabel-OEM.device - /dev/disk/by-label/OEM. Aug 5 22:16:32.949558 systemd[1]: Starting systemd-fsck@dev-disk-by\x2dlabel-OEM.service - File System Check on /dev/disk/by-label/OEM... Aug 5 22:16:32.964750 systemd[1]: Finished systemd-fsck@dev-disk-by\x2dlabel-OEM.service - File System Check on /dev/disk/by-label/OEM. Aug 5 22:16:32.980663 systemd[1]: Starting systemd-vconsole-setup.service - Virtual Console Setup... Aug 5 22:16:33.000863 systemd[1]: Finished systemd-udev-settle.service - Wait for udev To Complete Device Initialization. Aug 5 22:16:33.011546 systemd[1]: Starting lvm2-activation-early.service - Activation of LVM2 logical volumes... Aug 5 22:16:33.015605 systemd[1]: Finished systemd-vconsole-setup.service - Virtual Console Setup. Aug 5 22:16:33.027763 lvm[1261]: WARNING: Failed to connect to lvmetad. Falling back to device scanning. Aug 5 22:16:33.065414 systemd[1]: Finished lvm2-activation-early.service - Activation of LVM2 logical volumes. Aug 5 22:16:33.066773 systemd[1]: Reached target cryptsetup.target - Local Encrypted Volumes. Aug 5 22:16:33.067584 systemd[1]: Reached target sysinit.target - System Initialization. Aug 5 22:16:33.068390 systemd[1]: Started motdgen.path - Watch for update engine configuration changes. Aug 5 22:16:33.069264 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:16:33.070469 systemd[1]: Started logrotate.timer - Daily rotation of log files. Aug 5 22:16:33.071554 systemd[1]: Started mdadm.timer - Weekly check for MD array's redundancy information.. Aug 5 22:16:33.072511 systemd[1]: Started systemd-tmpfiles-clean.timer - Daily Cleanup of Temporary Directories. Aug 5 22:16:33.073366 systemd[1]: update-engine-stub.timer - Update Engine Stub Timer was skipped because of an unmet condition check (ConditionPathExists=/usr/.noupdate). Aug 5 22:16:33.073417 systemd[1]: Reached target paths.target - Path Units. Aug 5 22:16:33.074242 systemd[1]: Reached target timers.target - Timer Units. Aug 5 22:16:33.075662 systemd[1]: Listening on dbus.socket - D-Bus System Message Bus Socket. Aug 5 22:16:33.077912 systemd[1]: Starting docker.socket - Docker Socket for the API... Aug 5 22:16:33.092298 systemd[1]: Listening on sshd.socket - OpenSSH Server Socket. Aug 5 22:16:33.094247 systemd[1]: Starting lvm2-activation.service - Activation of LVM2 logical volumes... Aug 5 22:16:33.095596 systemd[1]: Listening on docker.socket - Docker Socket for the API. Aug 5 22:16:33.096464 systemd[1]: Reached target sockets.target - Socket Units. Aug 5 22:16:33.097136 systemd[1]: Reached target basic.target - Basic System. Aug 5 22:16:33.097877 systemd[1]: addon-config@oem.service - Configure Addon /oem was skipped because no trigger condition checks were met. Aug 5 22:16:33.097906 systemd[1]: addon-run@oem.service - Run Addon /oem was skipped because no trigger condition checks were met. Aug 5 22:16:33.098775 systemd[1]: Starting containerd.service - containerd container runtime... Aug 5 22:16:33.099810 systemd[1]: cryptenroll-helper-bind.service was skipped because of an unmet condition check (ConditionPathExists=/etc/luks/rootencrypted-bind). Aug 5 22:16:33.100773 systemd[1]: Starting dbus.service - D-Bus System Message Bus... Aug 5 22:16:33.101671 lvm[1268]: WARNING: Failed to connect to lvmetad. Falling back to device scanning. Aug 5 22:16:33.103511 systemd[1]: Starting enable-oem-cloudinit.service - Enable cloudinit... Aug 5 22:16:33.106477 systemd[1]: Starting extend-filesystems.service - Extend Filesystems... Aug 5 22:16:33.107285 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:16:33.113317 systemd[1]: Starting motdgen.service - Generate /run/flatcar/motd... Aug 5 22:16:33.115170 jq[1271]: false Aug 5 22:16:33.115231 systemd[1]: Starting ssh-key-proc-cmdline.service - Install an ssh key from /proc/cmdline... Aug 5 22:16:33.118043 systemd[1]: Starting sshd-keygen.service - Generate sshd host keys... Aug 5 22:16:33.124785 systemd[1]: Starting systemd-logind.service - User Login Management... Aug 5 22:16:33.127457 extend-filesystems[1272]: Found loop2 Aug 5 22:16:33.127457 extend-filesystems[1272]: Found loop3 Aug 5 22:16:33.127457 extend-filesystems[1272]: Found vda Aug 5 22:16:33.127457 extend-filesystems[1272]: Found vdb Aug 5 22:16:33.127457 extend-filesystems[1272]: Found vdb1 Aug 5 22:16:33.127457 extend-filesystems[1272]: Found vdb2 Aug 5 22:16:33.127457 extend-filesystems[1272]: Found vdb3 Aug 5 22:16:33.127457 extend-filesystems[1272]: Found usr Aug 5 22:16:33.127457 extend-filesystems[1272]: Found vdb4 Aug 5 22:16:33.127457 extend-filesystems[1272]: Found vdb6 Aug 5 22:16:33.127457 extend-filesystems[1272]: Found vdb7 Aug 5 22:16:33.127457 extend-filesystems[1272]: Found vdb9 Aug 5 22:16:33.127457 extend-filesystems[1272]: Found rootencrypted Aug 5 22:16:33.133940 dbus-daemon[1270]: [system] SELinux support is enabled Aug 5 22:16:33.131244 systemd[1]: tcsd.service - TCG Core Services Daemon was skipped because of an unmet condition check (ConditionSecurity=!tpm2). Aug 5 22:16:33.131651 systemd[1]: cgroup compatibility translation between legacy and unified hierarchy settings activated. See cgroup-compat debug messages for details. Aug 5 22:16:33.137567 systemd[1]: Starting update-engine.service - Update Engine... Aug 5 22:16:33.140997 systemd[1]: Starting update-ssh-keys-after-ignition.service - Run update-ssh-keys once after Ignition... Aug 5 22:16:33.144063 systemd[1]: Started dbus.service - D-Bus System Message Bus. Aug 5 22:16:33.146943 jq[1287]: true Aug 5 22:16:33.148629 systemd[1]: Finished lvm2-activation.service - Activation of LVM2 logical volumes. Aug 5 22:16:33.151768 systemd[1]: enable-oem-cloudinit.service: Skipped due to 'exec-condition'. Aug 5 22:16:33.154065 systemd[1]: Condition check resulted in enable-oem-cloudinit.service - Enable cloudinit being skipped. Aug 5 22:16:33.154326 systemd[1]: extend-filesystems.service: Deactivated successfully. Aug 5 22:16:33.155524 systemd[1]: Finished extend-filesystems.service - Extend Filesystems. Aug 5 22:16:33.156760 systemd[1]: motdgen.service: Deactivated successfully. Aug 5 22:16:33.156898 systemd[1]: Finished motdgen.service - Generate /run/flatcar/motd. Aug 5 22:16:33.158236 systemd[1]: ssh-key-proc-cmdline.service: Deactivated successfully. Aug 5 22:16:33.158501 systemd[1]: Finished ssh-key-proc-cmdline.service - Install an ssh key from /proc/cmdline. Aug 5 22:16:33.168011 jq[1295]: false Aug 5 22:16:33.168615 systemd[1]: update-ssh-keys-after-ignition.service: Skipped due to 'exec-condition'. Aug 5 22:16:33.170511 systemd[1]: Condition check resulted in update-ssh-keys-after-ignition.service - Run update-ssh-keys once after Ignition being skipped. Aug 5 22:16:33.171114 (ntainerd)[1296]: containerd.service: Referenced but unset environment variable evaluates to an empty string: TORCX_IMAGEDIR, TORCX_UNPACKDIR Aug 5 22:16:33.171927 systemd[1]: sshkeys.service was skipped because no trigger condition checks were met. Aug 5 22:16:33.172013 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:16:33.172035 systemd[1]: Reached target system-config.target - Load system-provided cloud configs. Aug 5 22:16:33.173306 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:16:33.173334 systemd[1]: Reached target user-config.target - Load user-provided cloud configs. Aug 5 22:16:33.175613 systemd-logind[1278]: Watching system buttons on /dev/input/event0 (Power Button) Aug 5 22:16:33.176002 systemd-logind[1278]: New seat seat0. Aug 5 22:16:33.180534 systemd[1]: Started systemd-logind.service - User Login Management. Aug 5 22:16:33.187222 systemd[1]: Finished sshd-keygen.service - Generate sshd host keys. Aug 5 22:16:33.195632 systemd[1]: Starting issuegen.service - Generate /run/issue... Aug 5 22:16:33.202061 systemd[1]: issuegen.service: Deactivated successfully. Aug 5 22:16:33.202216 systemd[1]: Finished issuegen.service - Generate /run/issue. Aug 5 22:16:33.205497 systemd[1]: Starting systemd-user-sessions.service - Permit User Sessions... Aug 5 22:16:33.212202 update_engine[1285]: I0805 22:16:33.211864 1285 main.cc:92] Flatcar Update Engine starting Aug 5 22:16:33.214202 systemd[1]: Started update-engine.service - Update Engine. Aug 5 22:16:33.216344 update_engine[1285]: I0805 22:16:33.214234 1285 update_check_scheduler.cc:74] Next update check in 2m0s Aug 5 22:16:33.216364 systemd[1]: Started locksmithd.service - Cluster reboot manager. Aug 5 22:16:33.221215 systemd[1]: Finished systemd-user-sessions.service - Permit User Sessions. Aug 5 22:16:33.223953 systemd[1]: Started getty@tty1.service - Getty on tty1. Aug 5 22:16:33.227666 systemd[1]: Started serial-getty@ttyAMA0.service - Serial Getty on ttyAMA0. Aug 5 22:16:33.229029 systemd[1]: Reached target getty.target - Login Prompts. Aug 5 22:16:33.259137 locksmithd[1313]: locksmithd starting currentOperation="UPDATE_STATUS_IDLE" strategy="reboot" Aug 5 22:16:33.359414 containerd[1296]: time="2024-08-05T22:16:33.359320280Z" level=info msg="starting containerd" revision=1fbfc07f8d28210e62bdbcbf7b950bac8028afbf version=v1.7.17 Aug 5 22:16:33.382526 containerd[1296]: time="2024-08-05T22:16:33.382424600Z" level=info msg="loading plugin \"io.containerd.warning.v1.deprecations\"..." type=io.containerd.warning.v1 Aug 5 22:16:33.382526 containerd[1296]: time="2024-08-05T22:16:33.382468720Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.aufs\"..." type=io.containerd.snapshotter.v1 Aug 5 22:16:33.383785 containerd[1296]: time="2024-08-05T22:16:33.383739760Z" 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:16:33.383785 containerd[1296]: time="2024-08-05T22:16:33.383770440Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.btrfs\"..." type=io.containerd.snapshotter.v1 Aug 5 22:16:33.383954 containerd[1296]: time="2024-08-05T22:16:33.383926920Z" 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:16:33.383954 containerd[1296]: time="2024-08-05T22:16:33.383947240Z" level=info msg="loading plugin \"io.containerd.content.v1.content\"..." type=io.containerd.content.v1 Aug 5 22:16:33.384161 containerd[1296]: time="2024-08-05T22:16:33.384132480Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.blockfile\"..." type=io.containerd.snapshotter.v1 Aug 5 22:16:33.384298 containerd[1296]: time="2024-08-05T22:16:33.384272120Z" 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:16:33.384298 containerd[1296]: time="2024-08-05T22:16:33.384292600Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.native\"..." type=io.containerd.snapshotter.v1 Aug 5 22:16:33.384428 containerd[1296]: time="2024-08-05T22:16:33.384405120Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.overlayfs\"..." type=io.containerd.snapshotter.v1 Aug 5 22:16:33.384638 containerd[1296]: time="2024-08-05T22:16:33.384613440Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.devmapper\"..." type=io.containerd.snapshotter.v1 Aug 5 22:16:33.384660 containerd[1296]: time="2024-08-05T22:16:33.384644120Z" level=warning msg="failed to load plugin io.containerd.snapshotter.v1.devmapper" error="devmapper not configured" Aug 5 22:16:33.384660 containerd[1296]: time="2024-08-05T22:16:33.384654440Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.zfs\"..." type=io.containerd.snapshotter.v1 Aug 5 22:16:33.384776 containerd[1296]: time="2024-08-05T22:16:33.384757880Z" 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:16:33.384798 containerd[1296]: time="2024-08-05T22:16:33.384775360Z" level=info msg="loading plugin \"io.containerd.metadata.v1.bolt\"..." type=io.containerd.metadata.v1 Aug 5 22:16:33.384820 containerd[1296]: time="2024-08-05T22:16:33.384800280Z" level=warning msg="could not use snapshotter devmapper in metadata plugin" error="devmapper not configured" Aug 5 22:16:33.384820 containerd[1296]: time="2024-08-05T22:16:33.384811120Z" level=info msg="metadata content store policy set" policy=shared Aug 5 22:16:33.385359 containerd[1296]: time="2024-08-05T22:16:33.385339400Z" level=info msg="loading plugin \"io.containerd.differ.v1.walking\"..." type=io.containerd.differ.v1 Aug 5 22:16:33.385399 containerd[1296]: time="2024-08-05T22:16:33.385364920Z" level=info msg="loading plugin \"io.containerd.event.v1.exchange\"..." type=io.containerd.event.v1 Aug 5 22:16:33.385399 containerd[1296]: time="2024-08-05T22:16:33.385393200Z" level=info msg="loading plugin \"io.containerd.gc.v1.scheduler\"..." type=io.containerd.gc.v1 Aug 5 22:16:33.385440 containerd[1296]: time="2024-08-05T22:16:33.385420560Z" level=info msg="loading plugin \"io.containerd.lease.v1.manager\"..." type=io.containerd.lease.v1 Aug 5 22:16:33.385440 containerd[1296]: time="2024-08-05T22:16:33.385433680Z" level=info msg="loading plugin \"io.containerd.nri.v1.nri\"..." type=io.containerd.nri.v1 Aug 5 22:16:33.385485 containerd[1296]: time="2024-08-05T22:16:33.385451520Z" level=info msg="NRI interface is disabled by configuration." Aug 5 22:16:33.385485 containerd[1296]: time="2024-08-05T22:16:33.385466960Z" level=info msg="loading plugin \"io.containerd.runtime.v2.task\"..." type=io.containerd.runtime.v2 Aug 5 22:16:33.385557 containerd[1296]: time="2024-08-05T22:16:33.385540480Z" level=info msg="loading plugin \"io.containerd.runtime.v2.shim\"..." type=io.containerd.runtime.v2 Aug 5 22:16:33.385587 containerd[1296]: time="2024-08-05T22:16:33.385559440Z" level=info msg="loading plugin \"io.containerd.sandbox.store.v1.local\"..." type=io.containerd.sandbox.store.v1 Aug 5 22:16:33.385587 containerd[1296]: time="2024-08-05T22:16:33.385573200Z" level=info msg="loading plugin \"io.containerd.sandbox.controller.v1.local\"..." type=io.containerd.sandbox.controller.v1 Aug 5 22:16:33.385587 containerd[1296]: time="2024-08-05T22:16:33.385586560Z" level=info msg="loading plugin \"io.containerd.streaming.v1.manager\"..." type=io.containerd.streaming.v1 Aug 5 22:16:33.385646 containerd[1296]: time="2024-08-05T22:16:33.385599400Z" level=info msg="loading plugin \"io.containerd.service.v1.introspection-service\"..." type=io.containerd.service.v1 Aug 5 22:16:33.385646 containerd[1296]: time="2024-08-05T22:16:33.385614160Z" level=info msg="loading plugin \"io.containerd.service.v1.containers-service\"..." type=io.containerd.service.v1 Aug 5 22:16:33.385646 containerd[1296]: time="2024-08-05T22:16:33.385626600Z" level=info msg="loading plugin \"io.containerd.service.v1.content-service\"..." type=io.containerd.service.v1 Aug 5 22:16:33.385742 containerd[1296]: time="2024-08-05T22:16:33.385724840Z" level=info msg="loading plugin \"io.containerd.service.v1.diff-service\"..." type=io.containerd.service.v1 Aug 5 22:16:33.385768 containerd[1296]: time="2024-08-05T22:16:33.385743920Z" level=info msg="loading plugin \"io.containerd.service.v1.images-service\"..." type=io.containerd.service.v1 Aug 5 22:16:33.385768 containerd[1296]: time="2024-08-05T22:16:33.385757120Z" level=info msg="loading plugin \"io.containerd.service.v1.namespaces-service\"..." type=io.containerd.service.v1 Aug 5 22:16:33.385808 containerd[1296]: time="2024-08-05T22:16:33.385768640Z" level=info msg="loading plugin \"io.containerd.service.v1.snapshots-service\"..." type=io.containerd.service.v1 Aug 5 22:16:33.385808 containerd[1296]: time="2024-08-05T22:16:33.385781640Z" level=info msg="loading plugin \"io.containerd.runtime.v1.linux\"..." type=io.containerd.runtime.v1 Aug 5 22:16:33.385860 containerd[1296]: time="2024-08-05T22:16:33.385844680Z" level=info msg="loading plugin \"io.containerd.monitor.v1.cgroups\"..." type=io.containerd.monitor.v1 Aug 5 22:16:33.386435 containerd[1296]: time="2024-08-05T22:16:33.386114040Z" level=info msg="loading plugin \"io.containerd.service.v1.tasks-service\"..." type=io.containerd.service.v1 Aug 5 22:16:33.386435 containerd[1296]: time="2024-08-05T22:16:33.386158880Z" level=info msg="loading plugin \"io.containerd.grpc.v1.introspection\"..." type=io.containerd.grpc.v1 Aug 5 22:16:33.386435 containerd[1296]: time="2024-08-05T22:16:33.386173080Z" level=info msg="loading plugin \"io.containerd.transfer.v1.local\"..." type=io.containerd.transfer.v1 Aug 5 22:16:33.386435 containerd[1296]: time="2024-08-05T22:16:33.386196680Z" level=info msg="loading plugin \"io.containerd.internal.v1.restart\"..." type=io.containerd.internal.v1 Aug 5 22:16:33.387040 containerd[1296]: time="2024-08-05T22:16:33.387006800Z" level=info msg="loading plugin \"io.containerd.grpc.v1.containers\"..." type=io.containerd.grpc.v1 Aug 5 22:16:33.387118 containerd[1296]: time="2024-08-05T22:16:33.387104920Z" level=info msg="loading plugin \"io.containerd.grpc.v1.content\"..." type=io.containerd.grpc.v1 Aug 5 22:16:33.387170 containerd[1296]: time="2024-08-05T22:16:33.387157680Z" level=info msg="loading plugin \"io.containerd.grpc.v1.diff\"..." type=io.containerd.grpc.v1 Aug 5 22:16:33.387220 containerd[1296]: time="2024-08-05T22:16:33.387208480Z" level=info msg="loading plugin \"io.containerd.grpc.v1.events\"..." type=io.containerd.grpc.v1 Aug 5 22:16:33.387273 containerd[1296]: time="2024-08-05T22:16:33.387261440Z" level=info msg="loading plugin \"io.containerd.grpc.v1.healthcheck\"..." type=io.containerd.grpc.v1 Aug 5 22:16:33.387329 containerd[1296]: time="2024-08-05T22:16:33.387316320Z" level=info msg="loading plugin \"io.containerd.grpc.v1.images\"..." type=io.containerd.grpc.v1 Aug 5 22:16:33.387400 containerd[1296]: time="2024-08-05T22:16:33.387368600Z" level=info msg="loading plugin \"io.containerd.grpc.v1.leases\"..." type=io.containerd.grpc.v1 Aug 5 22:16:33.387483 containerd[1296]: time="2024-08-05T22:16:33.387468920Z" level=info msg="loading plugin \"io.containerd.grpc.v1.namespaces\"..." type=io.containerd.grpc.v1 Aug 5 22:16:33.387537 containerd[1296]: time="2024-08-05T22:16:33.387525240Z" level=info msg="loading plugin \"io.containerd.internal.v1.opt\"..." type=io.containerd.internal.v1 Aug 5 22:16:33.387789 containerd[1296]: time="2024-08-05T22:16:33.387770320Z" level=info msg="loading plugin \"io.containerd.grpc.v1.sandbox-controllers\"..." type=io.containerd.grpc.v1 Aug 5 22:16:33.387856 containerd[1296]: time="2024-08-05T22:16:33.387843480Z" level=info msg="loading plugin \"io.containerd.grpc.v1.sandboxes\"..." type=io.containerd.grpc.v1 Aug 5 22:16:33.387909 containerd[1296]: time="2024-08-05T22:16:33.387896800Z" level=info msg="loading plugin \"io.containerd.grpc.v1.snapshots\"..." type=io.containerd.grpc.v1 Aug 5 22:16:33.387959 containerd[1296]: time="2024-08-05T22:16:33.387947880Z" level=info msg="loading plugin \"io.containerd.grpc.v1.streaming\"..." type=io.containerd.grpc.v1 Aug 5 22:16:33.388024 containerd[1296]: time="2024-08-05T22:16:33.388010760Z" level=info msg="loading plugin \"io.containerd.grpc.v1.tasks\"..." type=io.containerd.grpc.v1 Aug 5 22:16:33.388078 containerd[1296]: time="2024-08-05T22:16:33.388066880Z" level=info msg="loading plugin \"io.containerd.grpc.v1.transfer\"..." type=io.containerd.grpc.v1 Aug 5 22:16:33.388127 containerd[1296]: time="2024-08-05T22:16:33.388116040Z" level=info msg="loading plugin \"io.containerd.grpc.v1.version\"..." type=io.containerd.grpc.v1 Aug 5 22:16:33.388183 containerd[1296]: time="2024-08-05T22:16:33.388171280Z" level=info msg="loading plugin \"io.containerd.grpc.v1.cri\"..." type=io.containerd.grpc.v1 Aug 5 22:16:33.389090 containerd[1296]: time="2024-08-05T22:16:33.388450360Z" 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:16:33.389090 containerd[1296]: time="2024-08-05T22:16:33.388513120Z" level=info msg="Connect containerd service" Aug 5 22:16:33.389090 containerd[1296]: time="2024-08-05T22:16:33.388541760Z" level=info msg="using legacy CRI server" Aug 5 22:16:33.389090 containerd[1296]: time="2024-08-05T22:16:33.388548360Z" level=info msg="using experimental NRI integration - disable nri plugin to prevent this" Aug 5 22:16:33.389090 containerd[1296]: time="2024-08-05T22:16:33.388692840Z" level=info msg="Get image filesystem path \"/var/lib/containerd/io.containerd.snapshotter.v1.overlayfs\"" Aug 5 22:16:33.389321 containerd[1296]: time="2024-08-05T22:16:33.389192040Z" 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:16:33.389321 containerd[1296]: time="2024-08-05T22:16:33.389236560Z" level=info msg="loading plugin \"io.containerd.tracing.processor.v1.otlp\"..." type=io.containerd.tracing.processor.v1 Aug 5 22:16:33.389321 containerd[1296]: time="2024-08-05T22:16:33.389255000Z" 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:16:33.389321 containerd[1296]: time="2024-08-05T22:16:33.389265160Z" level=info msg="loading plugin \"io.containerd.internal.v1.tracing\"..." type=io.containerd.internal.v1 Aug 5 22:16:33.389321 containerd[1296]: time="2024-08-05T22:16:33.389277200Z" 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:16:33.389548 containerd[1296]: time="2024-08-05T22:16:33.389319440Z" level=info msg="Start subscribing containerd event" Aug 5 22:16:33.389548 containerd[1296]: time="2024-08-05T22:16:33.389543800Z" level=info msg="Start recovering state" Aug 5 22:16:33.389773 containerd[1296]: time="2024-08-05T22:16:33.389609640Z" level=info msg="Start event monitor" Aug 5 22:16:33.389773 containerd[1296]: time="2024-08-05T22:16:33.389625760Z" level=info msg="Start snapshots syncer" Aug 5 22:16:33.389773 containerd[1296]: time="2024-08-05T22:16:33.389635200Z" level=info msg="Start cni network conf syncer for default" Aug 5 22:16:33.389773 containerd[1296]: time="2024-08-05T22:16:33.389641960Z" level=info msg="Start streaming server" Aug 5 22:16:33.389879 containerd[1296]: time="2024-08-05T22:16:33.389815840Z" level=info msg=serving... address=/run/containerd/containerd.sock.ttrpc Aug 5 22:16:33.389879 containerd[1296]: time="2024-08-05T22:16:33.389864840Z" level=info msg=serving... address=/run/containerd/containerd.sock Aug 5 22:16:33.389923 containerd[1296]: time="2024-08-05T22:16:33.389914680Z" level=info msg="containerd successfully booted in 0.032035s" Aug 5 22:16:33.390019 systemd[1]: Started containerd.service - containerd container runtime. Aug 5 22:16:33.653311 systemd[1]: Created slice system-sshd.slice - Slice /system/sshd. Aug 5 22:16:33.655461 systemd[1]: Started sshd@0-10.0.0.113:22-10.0.0.1:36236.service - OpenSSH per-connection server daemon (10.0.0.1:36236). Aug 5 22:16:33.707298 sshd[1331]: Accepted publickey for core from 10.0.0.1 port 36236 ssh2: RSA SHA256:m+vSf9MZ8jyHy+Dz2uz+ngzM5NRoRVVH/LZDa5ltoPE Aug 5 22:16:33.709221 sshd[1331]: pam_unix(sshd:session): session opened for user core(uid=500) by (uid=0) Aug 5 22:16:33.717523 systemd-logind[1278]: New session 1 of user core. Aug 5 22:16:33.718553 systemd[1]: Created slice user-500.slice - User Slice of UID 500. Aug 5 22:16:33.729587 systemd[1]: Starting user-runtime-dir@500.service - User Runtime Directory /run/user/500... Aug 5 22:16:33.738628 systemd[1]: Finished user-runtime-dir@500.service - User Runtime Directory /run/user/500. Aug 5 22:16:33.742123 systemd[1]: Starting user@500.service - User Manager for UID 500... Aug 5 22:16:33.750584 (systemd)[1335]: pam_unix(systemd-user:session): session opened for user core(uid=500) by (uid=0) Aug 5 22:16:33.836619 systemd[1335]: Queued start job for default target default.target. Aug 5 22:16:33.850289 systemd[1335]: Created slice app.slice - User Application Slice. Aug 5 22:16:33.850321 systemd[1335]: Reached target paths.target - Paths. Aug 5 22:16:33.850333 systemd[1335]: Reached target timers.target - Timers. Aug 5 22:16:33.851622 systemd[1335]: Starting dbus.socket - D-Bus User Message Bus Socket... Aug 5 22:16:33.862081 systemd[1335]: Listening on dbus.socket - D-Bus User Message Bus Socket. Aug 5 22:16:33.862145 systemd[1335]: Reached target sockets.target - Sockets. Aug 5 22:16:33.862157 systemd[1335]: Reached target basic.target - Basic System. Aug 5 22:16:33.862192 systemd[1335]: Reached target default.target - Main User Target. Aug 5 22:16:33.862217 systemd[1335]: Startup finished in 106ms. Aug 5 22:16:33.862542 systemd[1]: Started user@500.service - User Manager for UID 500. Aug 5 22:16:33.865066 systemd[1]: Started session-1.scope - Session 1 of User core. Aug 5 22:16:33.930800 systemd[1]: Started sshd@1-10.0.0.113:22-10.0.0.1:36242.service - OpenSSH per-connection server daemon (10.0.0.1:36242). Aug 5 22:16:33.967825 sshd[1346]: Accepted publickey for core from 10.0.0.1 port 36242 ssh2: RSA SHA256:m+vSf9MZ8jyHy+Dz2uz+ngzM5NRoRVVH/LZDa5ltoPE Aug 5 22:16:33.968936 sshd[1346]: pam_unix(sshd:session): session opened for user core(uid=500) by (uid=0) Aug 5 22:16:33.972432 systemd-logind[1278]: New session 2 of user core. Aug 5 22:16:33.979514 systemd[1]: Started session-2.scope - Session 2 of User core. Aug 5 22:16:34.031619 sshd[1346]: pam_unix(sshd:session): session closed for user core Aug 5 22:16:34.045826 systemd[1]: sshd@1-10.0.0.113:22-10.0.0.1:36242.service: Deactivated successfully. Aug 5 22:16:34.047174 systemd[1]: session-2.scope: Deactivated successfully. Aug 5 22:16:34.048282 systemd-logind[1278]: Session 2 logged out. Waiting for processes to exit. Aug 5 22:16:34.049415 systemd[1]: Started sshd@2-10.0.0.113:22-10.0.0.1:36250.service - OpenSSH per-connection server daemon (10.0.0.1:36250). Aug 5 22:16:34.051075 systemd-logind[1278]: Removed session 2. Aug 5 22:16:34.086054 sshd[1353]: Accepted publickey for core from 10.0.0.1 port 36250 ssh2: RSA SHA256:m+vSf9MZ8jyHy+Dz2uz+ngzM5NRoRVVH/LZDa5ltoPE Aug 5 22:16:34.087138 sshd[1353]: pam_unix(sshd:session): session opened for user core(uid=500) by (uid=0) Aug 5 22:16:34.090533 systemd-logind[1278]: New session 3 of user core. Aug 5 22:16:34.100494 systemd[1]: Started session-3.scope - Session 3 of User core. Aug 5 22:16:34.151993 sshd[1353]: pam_unix(sshd:session): session closed for user core Aug 5 22:16:34.154679 systemd[1]: sshd@2-10.0.0.113:22-10.0.0.1:36250.service: Deactivated successfully. Aug 5 22:16:34.156551 systemd[1]: session-3.scope: Deactivated successfully. Aug 5 22:16:34.157195 systemd-logind[1278]: Session 3 logged out. Waiting for processes to exit. Aug 5 22:16:34.158127 systemd-logind[1278]: Removed session 3. Aug 5 22:16:34.521483 systemd-networkd[1229]: eth0: Gained IPv6LL Aug 5 22:16:34.522128 systemd-timesyncd[1211]: Network configuration changed, trying to establish connection. Aug 5 22:16:34.524258 systemd[1]: Finished systemd-networkd-wait-online.service - Wait for Network to be Configured. Aug 5 22:16:34.526000 systemd[1]: Reached target network-online.target - Network is Online. Aug 5 22:16:34.539614 systemd[1]: Starting coreos-metadata.service - QEMU metadata agent... Aug 5 22:16:34.541570 systemd[1]: Starting nvidia.service - NVIDIA Configure Service... Aug 5 22:16:34.556722 systemd[1]: coreos-metadata.service: Deactivated successfully. Aug 5 22:16:34.556899 systemd[1]: Finished coreos-metadata.service - QEMU metadata agent. Aug 5 22:16:34.558220 systemd[1]: packet-phone-home.service - Report Success to Packet was skipped because of an unmet condition check (ConditionFirstBoot=true). Aug 5 22:16:34.563932 systemd[1]: Finished nvidia.service - NVIDIA Configure Service. Aug 5 22:16:34.565185 systemd[1]: Reached target multi-user.target - Multi-User System. Aug 5 22:16:34.567590 systemd[1]: cryptenroll-helper-first.service was skipped because of an unmet condition check (ConditionFirstBoot=true). Aug 5 22:16:34.569469 systemd[1]: Startup finished in 555ms (kernel) + 2.119s (initrd) + 2.780s (userspace) = 5.456s. Aug 5 22:16:36.022450 systemd-timesyncd[1211]: Network configuration changed, trying to establish connection. Aug 5 22:16:38.041971 systemd-timesyncd[1211]: Network configuration changed, trying to establish connection. Aug 5 22:16:44.161795 systemd[1]: Started sshd@3-10.0.0.113:22-10.0.0.1:43782.service - OpenSSH per-connection server daemon (10.0.0.1:43782). Aug 5 22:16:44.199281 sshd[1378]: Accepted publickey for core from 10.0.0.1 port 43782 ssh2: RSA SHA256:m+vSf9MZ8jyHy+Dz2uz+ngzM5NRoRVVH/LZDa5ltoPE Aug 5 22:16:44.200512 sshd[1378]: pam_unix(sshd:session): session opened for user core(uid=500) by (uid=0) Aug 5 22:16:44.205246 systemd-logind[1278]: New session 4 of user core. Aug 5 22:16:44.214531 systemd[1]: Started session-4.scope - Session 4 of User core. Aug 5 22:16:44.302793 sshd[1378]: pam_unix(sshd:session): session closed for user core Aug 5 22:16:44.318399 systemd[1]: sshd@3-10.0.0.113:22-10.0.0.1:43782.service: Deactivated successfully. Aug 5 22:16:44.319850 systemd[1]: session-4.scope: Deactivated successfully. Aug 5 22:16:44.320415 systemd-logind[1278]: Session 4 logged out. Waiting for processes to exit. Aug 5 22:16:44.322097 systemd[1]: Started sshd@4-10.0.0.113:22-10.0.0.1:43788.service - OpenSSH per-connection server daemon (10.0.0.1:43788). Aug 5 22:16:44.323599 systemd-logind[1278]: Removed session 4. Aug 5 22:16:44.361029 sshd[1385]: Accepted publickey for core from 10.0.0.1 port 43788 ssh2: RSA SHA256:m+vSf9MZ8jyHy+Dz2uz+ngzM5NRoRVVH/LZDa5ltoPE Aug 5 22:16:44.362168 sshd[1385]: pam_unix(sshd:session): session opened for user core(uid=500) by (uid=0) Aug 5 22:16:44.365658 systemd-logind[1278]: New session 5 of user core. Aug 5 22:16:44.374514 systemd[1]: Started session-5.scope - Session 5 of User core. Aug 5 22:16:44.423475 sshd[1385]: pam_unix(sshd:session): session closed for user core Aug 5 22:16:44.441632 systemd[1]: sshd@4-10.0.0.113:22-10.0.0.1:43788.service: Deactivated successfully. Aug 5 22:16:44.443827 systemd[1]: session-5.scope: Deactivated successfully. Aug 5 22:16:44.444975 systemd-logind[1278]: Session 5 logged out. Waiting for processes to exit. Aug 5 22:16:44.446119 systemd[1]: Started sshd@5-10.0.0.113:22-10.0.0.1:43794.service - OpenSSH per-connection server daemon (10.0.0.1:43794). Aug 5 22:16:44.446843 systemd-logind[1278]: Removed session 5. Aug 5 22:16:44.482944 sshd[1392]: Accepted publickey for core from 10.0.0.1 port 43794 ssh2: RSA SHA256:m+vSf9MZ8jyHy+Dz2uz+ngzM5NRoRVVH/LZDa5ltoPE Aug 5 22:16:44.484044 sshd[1392]: pam_unix(sshd:session): session opened for user core(uid=500) by (uid=0) Aug 5 22:16:44.488075 systemd-logind[1278]: New session 6 of user core. Aug 5 22:16:44.505531 systemd[1]: Started session-6.scope - Session 6 of User core. Aug 5 22:16:44.557556 sshd[1392]: pam_unix(sshd:session): session closed for user core Aug 5 22:16:44.567585 systemd[1]: sshd@5-10.0.0.113:22-10.0.0.1:43794.service: Deactivated successfully. Aug 5 22:16:44.569002 systemd[1]: session-6.scope: Deactivated successfully. Aug 5 22:16:44.570561 systemd-logind[1278]: Session 6 logged out. Waiting for processes to exit. Aug 5 22:16:44.571613 systemd[1]: Started sshd@6-10.0.0.113:22-10.0.0.1:43804.service - OpenSSH per-connection server daemon (10.0.0.1:43804). Aug 5 22:16:44.572296 systemd-logind[1278]: Removed session 6. Aug 5 22:16:44.609938 sshd[1399]: Accepted publickey for core from 10.0.0.1 port 43804 ssh2: RSA SHA256:m+vSf9MZ8jyHy+Dz2uz+ngzM5NRoRVVH/LZDa5ltoPE Aug 5 22:16:44.611148 sshd[1399]: pam_unix(sshd:session): session opened for user core(uid=500) by (uid=0) Aug 5 22:16:44.615008 systemd-logind[1278]: New session 7 of user core. Aug 5 22:16:44.632144 systemd[1]: Started session-7.scope - Session 7 of User core. Aug 5 22:16:44.697947 sudo[1402]: core : PWD=/home/core ; USER=root ; COMMAND=/usr/sbin/setenforce 1 Aug 5 22:16:44.698170 sudo[1402]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=500) Aug 5 22:16:44.703399 kernel: audit: type=1404 audit(1722896204.701:3): enforcing=1 old_enforcing=0 auid=500 ses=7 enabled=1 old-enabled=1 lsm=selinux res=1 Aug 5 22:16:44.711062 sudo[1402]: pam_unix(sudo:session): session closed for user root Aug 5 22:16:44.712702 sshd[1399]: pam_unix(sshd:session): session closed for user core Aug 5 22:16:44.725698 systemd[1]: sshd@6-10.0.0.113:22-10.0.0.1:43804.service: Deactivated successfully. Aug 5 22:16:44.727015 systemd[1]: session-7.scope: Deactivated successfully. Aug 5 22:16:44.729474 systemd-logind[1278]: Session 7 logged out. Waiting for processes to exit. Aug 5 22:16:44.730607 systemd[1]: Started sshd@7-10.0.0.113:22-10.0.0.1:43820.service - OpenSSH per-connection server daemon (10.0.0.1:43820). Aug 5 22:16:44.731300 systemd-logind[1278]: Removed session 7. Aug 5 22:16:44.770015 sshd[1407]: Accepted publickey for core from 10.0.0.1 port 43820 ssh2: RSA SHA256:m+vSf9MZ8jyHy+Dz2uz+ngzM5NRoRVVH/LZDa5ltoPE Aug 5 22:16:44.771288 sshd[1407]: pam_unix(sshd:session): session opened for user core(uid=500) by (uid=0) Aug 5 22:16:44.775438 systemd-logind[1278]: New session 8 of user core. Aug 5 22:16:44.790546 systemd[1]: Started session-8.scope - Session 8 of User core. Aug 5 22:16:44.841774 sudo[1411]: 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:16:44.841994 sudo[1411]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=500) Aug 5 22:16:44.844767 sudo[1411]: pam_unix(sudo:session): session closed for user root Aug 5 22:16:44.849046 sudo[1410]: core : PWD=/home/core ; USER=root ; COMMAND=/usr/bin/systemctl restart audit-rules Aug 5 22:16:44.849268 sudo[1410]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=500) Aug 5 22:16:44.862613 systemd[1]: Stopping audit-rules.service - Load Security Auditing Rules... Aug 5 22:16:44.865225 auditctl[1414]: No rules Aug 5 22:16:44.865603 systemd[1]: audit-rules.service: Deactivated successfully. Aug 5 22:16:44.865805 systemd[1]: Stopped audit-rules.service - Load Security Auditing Rules. Aug 5 22:16:44.868022 systemd[1]: Starting audit-rules.service - Load Security Auditing Rules... Aug 5 22:16:44.880759 augenrules[1418]: /sbin/augenrules: No change Aug 5 22:16:44.882561 augenrules[1428]: No rules Aug 5 22:16:44.883738 systemd[1]: Finished audit-rules.service - Load Security Auditing Rules. Aug 5 22:16:44.884652 sudo[1410]: pam_unix(sudo:session): session closed for user root Aug 5 22:16:44.886193 sshd[1407]: pam_unix(sshd:session): session closed for user core Aug 5 22:16:44.896495 systemd[1]: sshd@7-10.0.0.113:22-10.0.0.1:43820.service: Deactivated successfully. Aug 5 22:16:44.897594 systemd[1]: session-8.scope: Deactivated successfully. Aug 5 22:16:44.899517 systemd-logind[1278]: Session 8 logged out. Waiting for processes to exit. Aug 5 22:16:44.900521 systemd[1]: Started sshd@8-10.0.0.113:22-10.0.0.1:43828.service - OpenSSH per-connection server daemon (10.0.0.1:43828). Aug 5 22:16:44.901202 systemd-logind[1278]: Removed session 8. Aug 5 22:16:44.941315 sshd[1436]: Accepted publickey for core from 10.0.0.1 port 43828 ssh2: RSA SHA256:m+vSf9MZ8jyHy+Dz2uz+ngzM5NRoRVVH/LZDa5ltoPE Aug 5 22:16:44.942459 sshd[1436]: pam_unix(sshd:session): session opened for user core(uid=500) by (uid=0) Aug 5 22:16:44.946429 systemd-logind[1278]: New session 9 of user core. Aug 5 22:16:44.966561 systemd[1]: Started session-9.scope - Session 9 of User core. Aug 5 22:16:45.018110 sshd[1436]: pam_unix(sshd:session): session closed for user core Aug 5 22:16:45.031694 systemd[1]: sshd@8-10.0.0.113:22-10.0.0.1:43828.service: Deactivated successfully. Aug 5 22:16:45.033179 systemd[1]: session-9.scope: Deactivated successfully. Aug 5 22:16:45.034453 systemd-logind[1278]: Session 9 logged out. Waiting for processes to exit. Aug 5 22:16:45.035552 systemd[1]: Started sshd@9-10.0.0.113:22-10.0.0.1:43840.service - OpenSSH per-connection server daemon (10.0.0.1:43840). Aug 5 22:16:45.036657 systemd-logind[1278]: Removed session 9. Aug 5 22:16:45.073296 sshd[1443]: Accepted publickey for core from 10.0.0.1 port 43840 ssh2: RSA SHA256:m+vSf9MZ8jyHy+Dz2uz+ngzM5NRoRVVH/LZDa5ltoPE Aug 5 22:16:45.074461 sshd[1443]: pam_unix(sshd:session): session opened for user core(uid=500) by (uid=0) Aug 5 22:16:45.079339 systemd-logind[1278]: New session 10 of user core. Aug 5 22:16:45.098552 systemd[1]: Started session-10.scope - Session 10 of User core. Aug 5 22:16:45.149910 sshd[1443]: pam_unix(sshd:session): session closed for user core Aug 5 22:16:45.152958 systemd[1]: sshd@9-10.0.0.113:22-10.0.0.1:43840.service: Deactivated successfully. Aug 5 22:16:45.154524 systemd[1]: session-10.scope: Deactivated successfully. Aug 5 22:16:45.155079 systemd-logind[1278]: Session 10 logged out. Waiting for processes to exit. Aug 5 22:16:45.155935 systemd-logind[1278]: Removed session 10.