Oct 8 19:48:42.919163 kernel: Booting Linux on physical CPU 0x0000000000 [0x413fd0c1] Oct 8 19:48:42.919184 kernel: Linux version 6.6.54-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 Tue Oct 8 18:22:02 -00 2024 Oct 8 19:48:42.919195 kernel: KASLR enabled Oct 8 19:48:42.919201 kernel: efi: EFI v2.7 by EDK II Oct 8 19:48:42.919206 kernel: efi: SMBIOS 3.0=0xdced0000 TPMFinalLog=0xd9760000 MEMATTR=0xdba62198 ACPI 2.0=0xd9700018 TPMEventLog=0xd9709098 RNG=0xd970e698 MEMRESERVE=0xd9b43e18 Oct 8 19:48:42.919212 kernel: random: crng init done Oct 8 19:48:42.919219 kernel: ACPI: Early table checksum verification disabled Oct 8 19:48:42.919225 kernel: ACPI: RSDP 0x00000000D9700018 000024 (v02 BOCHS ) Oct 8 19:48:42.919231 kernel: ACPI: XSDT 0x00000000D970FE98 00006C (v01 BOCHS BXPC 00000001 01000013) Oct 8 19:48:42.919238 kernel: ACPI: FACP 0x00000000D970FA98 000114 (v06 BOCHS BXPC 00000001 BXPC 00000001) Oct 8 19:48:42.919245 kernel: ACPI: DSDT 0x00000000D9707518 0014EB (v02 BOCHS BXPC 00000001 BXPC 00000001) Oct 8 19:48:42.919250 kernel: ACPI: APIC 0x00000000D970FC18 0001A8 (v04 BOCHS BXPC 00000001 BXPC 00000001) Oct 8 19:48:42.919256 kernel: ACPI: PPTT 0x00000000D970D898 00009C (v02 BOCHS BXPC 00000001 BXPC 00000001) Oct 8 19:48:42.919262 kernel: ACPI: GTDT 0x00000000D970E818 000060 (v02 BOCHS BXPC 00000001 BXPC 00000001) Oct 8 19:48:42.919277 kernel: ACPI: MCFG 0x00000000D970E918 00003C (v01 BOCHS BXPC 00000001 BXPC 00000001) Oct 8 19:48:42.919285 kernel: ACPI: SPCR 0x00000000D970FF98 000050 (v02 BOCHS BXPC 00000001 BXPC 00000001) Oct 8 19:48:42.919292 kernel: ACPI: DBG2 0x00000000D970E418 000057 (v00 BOCHS BXPC 00000001 BXPC 00000001) Oct 8 19:48:42.919298 kernel: ACPI: IORT 0x00000000D970E718 000080 (v03 BOCHS BXPC 00000001 BXPC 00000001) Oct 8 19:48:42.919304 kernel: ACPI: TPM2 0x00000000D970E498 00004C (v04 BOCHS BXPC 00000001 BXPC 00000001) Oct 8 19:48:42.919311 kernel: ACPI: SPCR: console: pl011,mmio,0x9000000,9600 Oct 8 19:48:42.919317 kernel: NUMA: Failed to initialise from firmware Oct 8 19:48:42.919323 kernel: NUMA: Faking a node at [mem 0x0000000040000000-0x00000000dcffffff] Oct 8 19:48:42.919330 kernel: NUMA: NODE_DATA [mem 0xdc958800-0xdc95dfff] Oct 8 19:48:42.919336 kernel: Zone ranges: Oct 8 19:48:42.919342 kernel: DMA [mem 0x0000000040000000-0x00000000dcffffff] Oct 8 19:48:42.919349 kernel: DMA32 empty Oct 8 19:48:42.919356 kernel: Normal empty Oct 8 19:48:42.919362 kernel: Movable zone start for each node Oct 8 19:48:42.919368 kernel: Early memory node ranges Oct 8 19:48:42.919374 kernel: node 0: [mem 0x0000000040000000-0x00000000d964ffff] Oct 8 19:48:42.919381 kernel: node 0: [mem 0x00000000d9650000-0x00000000d965ffff] Oct 8 19:48:42.919387 kernel: node 0: [mem 0x00000000d9660000-0x00000000d975ffff] Oct 8 19:48:42.919393 kernel: node 0: [mem 0x00000000d9760000-0x00000000d9b3ffff] Oct 8 19:48:42.919400 kernel: node 0: [mem 0x00000000d9b40000-0x00000000dce1ffff] Oct 8 19:48:42.919406 kernel: node 0: [mem 0x00000000dce20000-0x00000000dceaffff] Oct 8 19:48:42.919412 kernel: node 0: [mem 0x00000000dceb0000-0x00000000dcebffff] Oct 8 19:48:42.919419 kernel: node 0: [mem 0x00000000dcec0000-0x00000000dcfdffff] Oct 8 19:48:42.919426 kernel: node 0: [mem 0x00000000dcfe0000-0x00000000dcffffff] Oct 8 19:48:42.919432 kernel: Initmem setup node 0 [mem 0x0000000040000000-0x00000000dcffffff] Oct 8 19:48:42.919439 kernel: On node 0, zone DMA: 12288 pages in unavailable ranges Oct 8 19:48:42.919447 kernel: psci: probing for conduit method from ACPI. Oct 8 19:48:42.919454 kernel: psci: PSCIv1.1 detected in firmware. Oct 8 19:48:42.919461 kernel: psci: Using standard PSCI v0.2 function IDs Oct 8 19:48:42.919468 kernel: psci: Trusted OS migration not required Oct 8 19:48:42.919475 kernel: psci: SMC Calling Convention v1.1 Oct 8 19:48:42.919482 kernel: smccc: KVM: hypervisor services detected (0x00000000 0x00000000 0x00000000 0x00000003) Oct 8 19:48:42.919489 kernel: percpu: Embedded 31 pages/cpu s86632 r8192 d32152 u126976 Oct 8 19:48:42.919496 kernel: pcpu-alloc: s86632 r8192 d32152 u126976 alloc=31*4096 Oct 8 19:48:42.919502 kernel: pcpu-alloc: [0] 0 [0] 1 [0] 2 [0] 3 Oct 8 19:48:42.919509 kernel: Detected PIPT I-cache on CPU0 Oct 8 19:48:42.919516 kernel: CPU features: detected: GIC system register CPU interface Oct 8 19:48:42.919523 kernel: CPU features: detected: Hardware dirty bit management Oct 8 19:48:42.919529 kernel: CPU features: detected: Spectre-v4 Oct 8 19:48:42.919537 kernel: CPU features: detected: Spectre-BHB Oct 8 19:48:42.919544 kernel: CPU features: kernel page table isolation forced ON by KASLR Oct 8 19:48:42.919551 kernel: CPU features: detected: Kernel page table isolation (KPTI) Oct 8 19:48:42.919557 kernel: CPU features: detected: ARM erratum 1418040 Oct 8 19:48:42.919564 kernel: CPU features: detected: SSBS not fully self-synchronizing Oct 8 19:48:42.919571 kernel: alternatives: applying boot alternatives Oct 8 19:48:42.919578 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=c838587f25bc3913a152d0e9ed071e943b77b8dea81b67c254bbd10c29051fd2 Oct 8 19:48:42.919586 kernel: Unknown kernel command line parameters "BOOT_IMAGE=/flatcar/vmlinuz-a", will be passed to user space. Oct 8 19:48:42.919592 kernel: Dentry cache hash table entries: 524288 (order: 10, 4194304 bytes, linear) Oct 8 19:48:42.919599 kernel: Inode-cache hash table entries: 262144 (order: 9, 2097152 bytes, linear) Oct 8 19:48:42.919606 kernel: Fallback order for Node 0: 0 Oct 8 19:48:42.919614 kernel: Built 1 zonelists, mobility grouping on. Total pages: 633024 Oct 8 19:48:42.919621 kernel: Policy zone: DMA Oct 8 19:48:42.919627 kernel: mem auto-init: stack:off, heap alloc:off, heap free:off Oct 8 19:48:42.919634 kernel: software IO TLB: area num 4. Oct 8 19:48:42.919641 kernel: software IO TLB: mapped [mem 0x00000000d2e00000-0x00000000d6e00000] (64MB) Oct 8 19:48:42.919648 kernel: Memory: 2386660K/2572288K available (10240K kernel code, 2184K rwdata, 8080K rodata, 39104K init, 897K bss, 185628K reserved, 0K cma-reserved) Oct 8 19:48:42.919655 kernel: SLUB: HWalign=64, Order=0-3, MinObjects=0, CPUs=4, Nodes=1 Oct 8 19:48:42.919661 kernel: trace event string verifier disabled Oct 8 19:48:42.919668 kernel: rcu: Preemptible hierarchical RCU implementation. Oct 8 19:48:42.919675 kernel: rcu: RCU event tracing is enabled. Oct 8 19:48:42.919682 kernel: rcu: RCU restricting CPUs from NR_CPUS=512 to nr_cpu_ids=4. Oct 8 19:48:42.919690 kernel: Trampoline variant of Tasks RCU enabled. Oct 8 19:48:42.919697 kernel: Tracing variant of Tasks RCU enabled. Oct 8 19:48:42.919703 kernel: rcu: RCU calculated value of scheduler-enlistment delay is 100 jiffies. Oct 8 19:48:42.919710 kernel: rcu: Adjusting geometry for rcu_fanout_leaf=16, nr_cpu_ids=4 Oct 8 19:48:42.919717 kernel: NR_IRQS: 64, nr_irqs: 64, preallocated irqs: 0 Oct 8 19:48:42.919724 kernel: GICv3: 256 SPIs implemented Oct 8 19:48:42.919730 kernel: GICv3: 0 Extended SPIs implemented Oct 8 19:48:42.919737 kernel: Root IRQ handler: gic_handle_irq Oct 8 19:48:42.919743 kernel: GICv3: GICv3 features: 16 PPIs, DirectLPI Oct 8 19:48:42.919750 kernel: GICv3: CPU0: found redistributor 0 region 0:0x00000000080a0000 Oct 8 19:48:42.919757 kernel: ITS [mem 0x08080000-0x0809ffff] Oct 8 19:48:42.919764 kernel: ITS@0x0000000008080000: allocated 8192 Devices @400d0000 (indirect, esz 8, psz 64K, shr 1) Oct 8 19:48:42.919772 kernel: ITS@0x0000000008080000: allocated 8192 Interrupt Collections @400e0000 (flat, esz 8, psz 64K, shr 1) Oct 8 19:48:42.919779 kernel: GICv3: using LPI property table @0x00000000400f0000 Oct 8 19:48:42.919786 kernel: GICv3: CPU0: using allocated LPI pending table @0x0000000040100000 Oct 8 19:48:42.919792 kernel: rcu: srcu_init: Setting srcu_struct sizes based on contention. Oct 8 19:48:42.919799 kernel: arch_timer: Enabling local workaround for ARM erratum 1418040 Oct 8 19:48:42.919806 kernel: arch_timer: cp15 timer(s) running at 25.00MHz (virt). Oct 8 19:48:42.919813 kernel: clocksource: arch_sys_counter: mask: 0xffffffffffffff max_cycles: 0x5c40939b5, max_idle_ns: 440795202646 ns Oct 8 19:48:42.919820 kernel: sched_clock: 56 bits at 25MHz, resolution 40ns, wraps every 4398046511100ns Oct 8 19:48:42.919826 kernel: arm-pv: using stolen time PV Oct 8 19:48:42.919833 kernel: Console: colour dummy device 80x25 Oct 8 19:48:42.919840 kernel: ACPI: Core revision 20230628 Oct 8 19:48:42.919849 kernel: Calibrating delay loop (skipped), value calculated using timer frequency.. 50.00 BogoMIPS (lpj=25000) Oct 8 19:48:42.919856 kernel: pid_max: default: 32768 minimum: 301 Oct 8 19:48:42.919863 kernel: LSM: initializing lsm=lockdown,capability,selinux,integrity Oct 8 19:48:42.919869 kernel: SELinux: Initializing. Oct 8 19:48:42.919876 kernel: Mount-cache hash table entries: 8192 (order: 4, 65536 bytes, linear) Oct 8 19:48:42.919888 kernel: Mountpoint-cache hash table entries: 8192 (order: 4, 65536 bytes, linear) Oct 8 19:48:42.919895 kernel: RCU Tasks: Setting shift to 2 and lim to 1 rcu_task_cb_adjust=1. Oct 8 19:48:42.919902 kernel: RCU Tasks Trace: Setting shift to 2 and lim to 1 rcu_task_cb_adjust=1. Oct 8 19:48:42.919909 kernel: rcu: Hierarchical SRCU implementation. Oct 8 19:48:42.919917 kernel: rcu: Max phase no-delay instances is 400. Oct 8 19:48:42.919924 kernel: Platform MSI: ITS@0x8080000 domain created Oct 8 19:48:42.919931 kernel: PCI/MSI: ITS@0x8080000 domain created Oct 8 19:48:42.919937 kernel: Remapping and enabling EFI services. Oct 8 19:48:42.919944 kernel: smp: Bringing up secondary CPUs ... Oct 8 19:48:42.919951 kernel: Detected PIPT I-cache on CPU1 Oct 8 19:48:42.919958 kernel: GICv3: CPU1: found redistributor 1 region 0:0x00000000080c0000 Oct 8 19:48:42.919965 kernel: GICv3: CPU1: using allocated LPI pending table @0x0000000040110000 Oct 8 19:48:42.919972 kernel: arch_timer: Enabling local workaround for ARM erratum 1418040 Oct 8 19:48:42.919980 kernel: CPU1: Booted secondary processor 0x0000000001 [0x413fd0c1] Oct 8 19:48:42.919987 kernel: Detected PIPT I-cache on CPU2 Oct 8 19:48:42.919998 kernel: GICv3: CPU2: found redistributor 2 region 0:0x00000000080e0000 Oct 8 19:48:42.920006 kernel: GICv3: CPU2: using allocated LPI pending table @0x0000000040120000 Oct 8 19:48:42.920014 kernel: arch_timer: Enabling local workaround for ARM erratum 1418040 Oct 8 19:48:42.920021 kernel: CPU2: Booted secondary processor 0x0000000002 [0x413fd0c1] Oct 8 19:48:42.920028 kernel: Detected PIPT I-cache on CPU3 Oct 8 19:48:42.920035 kernel: GICv3: CPU3: found redistributor 3 region 0:0x0000000008100000 Oct 8 19:48:42.920043 kernel: GICv3: CPU3: using allocated LPI pending table @0x0000000040130000 Oct 8 19:48:42.920051 kernel: arch_timer: Enabling local workaround for ARM erratum 1418040 Oct 8 19:48:42.920058 kernel: CPU3: Booted secondary processor 0x0000000003 [0x413fd0c1] Oct 8 19:48:42.920065 kernel: smp: Brought up 1 node, 4 CPUs Oct 8 19:48:42.920073 kernel: SMP: Total of 4 processors activated. Oct 8 19:48:42.920080 kernel: CPU features: detected: 32-bit EL0 Support Oct 8 19:48:42.920087 kernel: CPU features: detected: Data cache clean to the PoU not required for I/D coherence Oct 8 19:48:42.920094 kernel: CPU features: detected: Common not Private translations Oct 8 19:48:42.920101 kernel: CPU features: detected: CRC32 instructions Oct 8 19:48:42.920109 kernel: CPU features: detected: Enhanced Virtualization Traps Oct 8 19:48:42.920117 kernel: CPU features: detected: RCpc load-acquire (LDAPR) Oct 8 19:48:42.920124 kernel: CPU features: detected: LSE atomic instructions Oct 8 19:48:42.920131 kernel: CPU features: detected: Privileged Access Never Oct 8 19:48:42.920138 kernel: CPU features: detected: RAS Extension Support Oct 8 19:48:42.920152 kernel: CPU features: detected: Speculative Store Bypassing Safe (SSBS) Oct 8 19:48:42.920159 kernel: CPU: All CPU(s) started at EL1 Oct 8 19:48:42.920166 kernel: alternatives: applying system-wide alternatives Oct 8 19:48:42.920173 kernel: devtmpfs: initialized Oct 8 19:48:42.920181 kernel: clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1911260446275000 ns Oct 8 19:48:42.920190 kernel: futex hash table entries: 1024 (order: 4, 65536 bytes, linear) Oct 8 19:48:42.920197 kernel: pinctrl core: initialized pinctrl subsystem Oct 8 19:48:42.920204 kernel: SMBIOS 3.0.0 present. Oct 8 19:48:42.920211 kernel: DMI: QEMU KVM Virtual Machine, BIOS edk2-20230524-3.fc38 05/24/2023 Oct 8 19:48:42.920219 kernel: NET: Registered PF_NETLINK/PF_ROUTE protocol family Oct 8 19:48:42.920226 kernel: DMA: preallocated 512 KiB GFP_KERNEL pool for atomic allocations Oct 8 19:48:42.920233 kernel: DMA: preallocated 512 KiB GFP_KERNEL|GFP_DMA pool for atomic allocations Oct 8 19:48:42.920241 kernel: DMA: preallocated 512 KiB GFP_KERNEL|GFP_DMA32 pool for atomic allocations Oct 8 19:48:42.920249 kernel: audit: initializing netlink subsys (disabled) Oct 8 19:48:42.920257 kernel: audit: type=2000 audit(0.023:1): state=initialized audit_enabled=0 res=1 Oct 8 19:48:42.920268 kernel: thermal_sys: Registered thermal governor 'step_wise' Oct 8 19:48:42.920276 kernel: cpuidle: using governor menu Oct 8 19:48:42.920284 kernel: hw-breakpoint: found 6 breakpoint and 4 watchpoint registers. Oct 8 19:48:42.920291 kernel: ASID allocator initialised with 32768 entries Oct 8 19:48:42.920298 kernel: acpiphp: ACPI Hot Plug PCI Controller Driver version: 0.5 Oct 8 19:48:42.920305 kernel: Serial: AMBA PL011 UART driver Oct 8 19:48:42.920313 kernel: Modules: 2G module region forced by RANDOMIZE_MODULE_REGION_FULL Oct 8 19:48:42.920321 kernel: Modules: 0 pages in range for non-PLT usage Oct 8 19:48:42.920328 kernel: Modules: 509104 pages in range for PLT usage Oct 8 19:48:42.920336 kernel: HugeTLB: registered 1.00 GiB page size, pre-allocated 0 pages Oct 8 19:48:42.920343 kernel: HugeTLB: 0 KiB vmemmap can be freed for a 1.00 GiB page Oct 8 19:48:42.920350 kernel: HugeTLB: registered 32.0 MiB page size, pre-allocated 0 pages Oct 8 19:48:42.920358 kernel: HugeTLB: 0 KiB vmemmap can be freed for a 32.0 MiB page Oct 8 19:48:42.920365 kernel: HugeTLB: registered 2.00 MiB page size, pre-allocated 0 pages Oct 8 19:48:42.920372 kernel: HugeTLB: 0 KiB vmemmap can be freed for a 2.00 MiB page Oct 8 19:48:42.920379 kernel: HugeTLB: registered 64.0 KiB page size, pre-allocated 0 pages Oct 8 19:48:42.920387 kernel: HugeTLB: 0 KiB vmemmap can be freed for a 64.0 KiB page Oct 8 19:48:42.920395 kernel: ACPI: Added _OSI(Module Device) Oct 8 19:48:42.920402 kernel: ACPI: Added _OSI(Processor Device) Oct 8 19:48:42.920409 kernel: ACPI: Added _OSI(3.0 _SCP Extensions) Oct 8 19:48:42.920416 kernel: ACPI: Added _OSI(Processor Aggregator Device) Oct 8 19:48:42.920424 kernel: ACPI: 1 ACPI AML tables successfully acquired and loaded Oct 8 19:48:42.920431 kernel: ACPI: Interpreter enabled Oct 8 19:48:42.920438 kernel: ACPI: Using GIC for interrupt routing Oct 8 19:48:42.920445 kernel: ACPI: MCFG table detected, 1 entries Oct 8 19:48:42.920453 kernel: ARMH0011:00: ttyAMA0 at MMIO 0x9000000 (irq = 12, base_baud = 0) is a SBSA Oct 8 19:48:42.920461 kernel: printk: console [ttyAMA0] enabled Oct 8 19:48:42.920468 kernel: ACPI: PCI Root Bridge [PCI0] (domain 0000 [bus 00-ff]) Oct 8 19:48:42.920597 kernel: acpi PNP0A08:00: _OSC: OS supports [ExtendedConfig ASPM ClockPM Segments MSI HPX-Type3] Oct 8 19:48:42.920667 kernel: acpi PNP0A08:00: _OSC: platform does not support [LTR] Oct 8 19:48:42.920731 kernel: acpi PNP0A08:00: _OSC: OS now controls [PCIeHotplug PME AER PCIeCapability] Oct 8 19:48:42.920793 kernel: acpi PNP0A08:00: ECAM area [mem 0x4010000000-0x401fffffff] reserved by PNP0C02:00 Oct 8 19:48:42.920855 kernel: acpi PNP0A08:00: ECAM at [mem 0x4010000000-0x401fffffff] for [bus 00-ff] Oct 8 19:48:42.920867 kernel: ACPI: Remapped I/O 0x000000003eff0000 to [io 0x0000-0xffff window] Oct 8 19:48:42.920874 kernel: PCI host bridge to bus 0000:00 Oct 8 19:48:42.920942 kernel: pci_bus 0000:00: root bus resource [mem 0x10000000-0x3efeffff window] Oct 8 19:48:42.921003 kernel: pci_bus 0000:00: root bus resource [io 0x0000-0xffff window] Oct 8 19:48:42.921060 kernel: pci_bus 0000:00: root bus resource [mem 0x8000000000-0xffffffffff window] Oct 8 19:48:42.921117 kernel: pci_bus 0000:00: root bus resource [bus 00-ff] Oct 8 19:48:42.921214 kernel: pci 0000:00:00.0: [1b36:0008] type 00 class 0x060000 Oct 8 19:48:42.921310 kernel: pci 0000:00:01.0: [1af4:1005] type 00 class 0x00ff00 Oct 8 19:48:42.921379 kernel: pci 0000:00:01.0: reg 0x10: [io 0x0000-0x001f] Oct 8 19:48:42.921444 kernel: pci 0000:00:01.0: reg 0x14: [mem 0x10000000-0x10000fff] Oct 8 19:48:42.921509 kernel: pci 0000:00:01.0: reg 0x20: [mem 0x8000000000-0x8000003fff 64bit pref] Oct 8 19:48:42.921573 kernel: pci 0000:00:01.0: BAR 4: assigned [mem 0x8000000000-0x8000003fff 64bit pref] Oct 8 19:48:42.921637 kernel: pci 0000:00:01.0: BAR 1: assigned [mem 0x10000000-0x10000fff] Oct 8 19:48:42.921704 kernel: pci 0000:00:01.0: BAR 0: assigned [io 0x1000-0x101f] Oct 8 19:48:42.921763 kernel: pci_bus 0000:00: resource 4 [mem 0x10000000-0x3efeffff window] Oct 8 19:48:42.921821 kernel: pci_bus 0000:00: resource 5 [io 0x0000-0xffff window] Oct 8 19:48:42.921878 kernel: pci_bus 0000:00: resource 6 [mem 0x8000000000-0xffffffffff window] Oct 8 19:48:42.921887 kernel: ACPI: PCI: Interrupt link GSI0 configured for IRQ 35 Oct 8 19:48:42.921895 kernel: ACPI: PCI: Interrupt link GSI1 configured for IRQ 36 Oct 8 19:48:42.921902 kernel: ACPI: PCI: Interrupt link GSI2 configured for IRQ 37 Oct 8 19:48:42.921910 kernel: ACPI: PCI: Interrupt link GSI3 configured for IRQ 38 Oct 8 19:48:42.921919 kernel: iommu: Default domain type: Translated Oct 8 19:48:42.921927 kernel: iommu: DMA domain TLB invalidation policy: strict mode Oct 8 19:48:42.921934 kernel: efivars: Registered efivars operations Oct 8 19:48:42.921941 kernel: vgaarb: loaded Oct 8 19:48:42.921949 kernel: clocksource: Switched to clocksource arch_sys_counter Oct 8 19:48:42.921956 kernel: VFS: Disk quotas dquot_6.6.0 Oct 8 19:48:42.921963 kernel: VFS: Dquot-cache hash table entries: 512 (order 0, 4096 bytes) Oct 8 19:48:42.921970 kernel: pnp: PnP ACPI init Oct 8 19:48:42.922045 kernel: system 00:00: [mem 0x4010000000-0x401fffffff window] could not be reserved Oct 8 19:48:42.922058 kernel: pnp: PnP ACPI: found 1 devices Oct 8 19:48:42.922065 kernel: NET: Registered PF_INET protocol family Oct 8 19:48:42.922076 kernel: IP idents hash table entries: 65536 (order: 7, 524288 bytes, linear) Oct 8 19:48:42.922095 kernel: tcp_listen_portaddr_hash hash table entries: 2048 (order: 3, 32768 bytes, linear) Oct 8 19:48:42.922103 kernel: Table-perturb hash table entries: 65536 (order: 6, 262144 bytes, linear) Oct 8 19:48:42.922110 kernel: TCP established hash table entries: 32768 (order: 6, 262144 bytes, linear) Oct 8 19:48:42.922118 kernel: TCP bind hash table entries: 32768 (order: 8, 1048576 bytes, linear) Oct 8 19:48:42.922125 kernel: TCP: Hash tables configured (established 32768 bind 32768) Oct 8 19:48:42.922134 kernel: UDP hash table entries: 2048 (order: 4, 65536 bytes, linear) Oct 8 19:48:42.922157 kernel: UDP-Lite hash table entries: 2048 (order: 4, 65536 bytes, linear) Oct 8 19:48:42.922167 kernel: NET: Registered PF_UNIX/PF_LOCAL protocol family Oct 8 19:48:42.922175 kernel: PCI: CLS 0 bytes, default 64 Oct 8 19:48:42.922182 kernel: kvm [1]: HYP mode not available Oct 8 19:48:42.922189 kernel: Initialise system trusted keyrings Oct 8 19:48:42.922196 kernel: workingset: timestamp_bits=39 max_order=20 bucket_order=0 Oct 8 19:48:42.922203 kernel: Key type asymmetric registered Oct 8 19:48:42.922210 kernel: Asymmetric key parser 'x509' registered Oct 8 19:48:42.922218 kernel: Block layer SCSI generic (bsg) driver version 0.4 loaded (major 250) Oct 8 19:48:42.922227 kernel: io scheduler mq-deadline registered Oct 8 19:48:42.922235 kernel: io scheduler kyber registered Oct 8 19:48:42.922242 kernel: io scheduler bfq registered Oct 8 19:48:42.922249 kernel: input: Power Button as /devices/LNXSYSTM:00/LNXSYBUS:00/PNP0C0C:00/input/input0 Oct 8 19:48:42.922257 kernel: ACPI: button: Power Button [PWRB] Oct 8 19:48:42.922269 kernel: ACPI: \_SB_.PCI0.GSI1: Enabled at IRQ 36 Oct 8 19:48:42.922348 kernel: virtio-pci 0000:00:01.0: enabling device (0005 -> 0007) Oct 8 19:48:42.922359 kernel: Serial: 8250/16550 driver, 4 ports, IRQ sharing enabled Oct 8 19:48:42.922366 kernel: thunder_xcv, ver 1.0 Oct 8 19:48:42.922375 kernel: thunder_bgx, ver 1.0 Oct 8 19:48:42.922383 kernel: nicpf, ver 1.0 Oct 8 19:48:42.922390 kernel: nicvf, ver 1.0 Oct 8 19:48:42.922466 kernel: rtc-efi rtc-efi.0: registered as rtc0 Oct 8 19:48:42.922529 kernel: rtc-efi rtc-efi.0: setting system clock to 2024-10-08T19:48:42 UTC (1728416922) Oct 8 19:48:42.922538 kernel: hid: raw HID events driver (C) Jiri Kosina Oct 8 19:48:42.922546 kernel: hw perfevents: enabled with armv8_pmuv3_0 PMU driver, 7 counters available Oct 8 19:48:42.922553 kernel: watchdog: Delayed init of the lockup detector failed: -19 Oct 8 19:48:42.922562 kernel: watchdog: Hard watchdog permanently disabled Oct 8 19:48:42.922569 kernel: NET: Registered PF_INET6 protocol family Oct 8 19:48:42.922577 kernel: Segment Routing with IPv6 Oct 8 19:48:42.922584 kernel: In-situ OAM (IOAM) with IPv6 Oct 8 19:48:42.922591 kernel: NET: Registered PF_PACKET protocol family Oct 8 19:48:42.922598 kernel: Key type dns_resolver registered Oct 8 19:48:42.922605 kernel: registered taskstats version 1 Oct 8 19:48:42.922613 kernel: Loading compiled-in X.509 certificates Oct 8 19:48:42.922620 kernel: Loaded X.509 cert 'Kinvolk GmbH: Module signing key for 6.6.54-flatcar: e5b54c43c129014ce5ace0e8cd7b641a0fcb136e' Oct 8 19:48:42.922628 kernel: Key type .fscrypt registered Oct 8 19:48:42.922636 kernel: Key type fscrypt-provisioning registered Oct 8 19:48:42.922643 kernel: ima: No TPM chip found, activating TPM-bypass! Oct 8 19:48:42.922650 kernel: ima: Allocated hash algorithm: sha1 Oct 8 19:48:42.922657 kernel: ima: No architecture policies found Oct 8 19:48:42.922665 kernel: alg: No test for fips(ansi_cprng) (fips_ansi_cprng) Oct 8 19:48:42.922672 kernel: clk: Disabling unused clocks Oct 8 19:48:42.922679 kernel: Freeing unused kernel memory: 39104K Oct 8 19:48:42.922687 kernel: Run /init as init process Oct 8 19:48:42.922694 kernel: with arguments: Oct 8 19:48:42.922701 kernel: /init Oct 8 19:48:42.922708 kernel: with environment: Oct 8 19:48:42.922715 kernel: HOME=/ Oct 8 19:48:42.922723 kernel: TERM=linux Oct 8 19:48:42.922729 kernel: BOOT_IMAGE=/flatcar/vmlinuz-a Oct 8 19:48:42.922738 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) Oct 8 19:48:42.922749 systemd[1]: Detected virtualization kvm. Oct 8 19:48:42.922757 systemd[1]: Detected architecture arm64. Oct 8 19:48:42.922765 systemd[1]: Running in initrd. Oct 8 19:48:42.922772 systemd[1]: No hostname configured, using default hostname. Oct 8 19:48:42.922779 systemd[1]: Hostname set to . Oct 8 19:48:42.922788 systemd[1]: Initializing machine ID from VM UUID. Oct 8 19:48:42.922795 systemd[1]: Queued start job for default target initrd.target. Oct 8 19:48:42.922803 systemd[1]: Started clevis-luks-askpass.path - Forward Password Requests to Clevis Directory Watch. Oct 8 19:48:42.922812 systemd[1]: Started systemd-ask-password-console.path - Dispatch Password Requests to Console Directory Watch. Oct 8 19:48:42.922821 systemd[1]: Expecting device dev-disk-by\x2dlabel-EFI\x2dSYSTEM.device - /dev/disk/by-label/EFI-SYSTEM... Oct 8 19:48:42.922829 systemd[1]: Expecting device dev-disk-by\x2dlabel-OEM.device - /dev/disk/by-label/OEM... Oct 8 19:48:42.922837 systemd[1]: Expecting device dev-disk-by\x2dlabel-ROOT.device - /dev/disk/by-label/ROOT... Oct 8 19:48:42.922845 systemd[1]: Expecting device dev-disk-by\x2dpartlabel-USR\x2dA.device - /dev/disk/by-partlabel/USR-A... Oct 8 19:48:42.922854 systemd[1]: Expecting device dev-disk-by\x2dpartuuid-7130c94a\x2d213a\x2d4e5a\x2d8e26\x2d6cce9662f132.device - /dev/disk/by-partuuid/7130c94a-213a-4e5a-8e26-6cce9662f132... Oct 8 19:48:42.922862 systemd[1]: Expecting device dev-mapper-usr.device - /dev/mapper/usr... Oct 8 19:48:42.922871 systemd[1]: Reached target cryptsetup-pre.target - Local Encrypted Volumes (Pre). Oct 8 19:48:42.922879 systemd[1]: Reached target cryptsetup.target - Local Encrypted Volumes. Oct 8 19:48:42.922887 systemd[1]: Reached target paths.target - Path Units. Oct 8 19:48:42.922895 systemd[1]: Reached target slices.target - Slice Units. Oct 8 19:48:42.922902 systemd[1]: Reached target swap.target - Swaps. Oct 8 19:48:42.922910 systemd[1]: Reached target timers.target - Timer Units. Oct 8 19:48:42.922918 systemd[1]: Listening on iscsid.socket - Open-iSCSI iscsid Socket. Oct 8 19:48:42.922926 systemd[1]: Listening on iscsiuio.socket - Open-iSCSI iscsiuio Socket. Oct 8 19:48:42.922934 systemd[1]: Listening on systemd-journald-dev-log.socket - Journal Socket (/dev/log). Oct 8 19:48:42.922943 systemd[1]: Listening on systemd-journald.socket - Journal Socket. Oct 8 19:48:42.922951 systemd[1]: Listening on systemd-networkd.socket - Network Service Netlink Socket. Oct 8 19:48:42.922963 systemd[1]: Listening on systemd-udevd-control.socket - udev Control Socket. Oct 8 19:48:42.922971 systemd[1]: Listening on systemd-udevd-kernel.socket - udev Kernel Socket. Oct 8 19:48:42.922979 systemd[1]: Reached target sockets.target - Socket Units. Oct 8 19:48:42.922987 systemd[1]: Starting ignition-setup-pre.service - Ignition env setup... Oct 8 19:48:42.922995 systemd[1]: Starting kmod-static-nodes.service - Create List of Static Device Nodes... Oct 8 19:48:42.923003 systemd[1]: Finished network-cleanup.service - Network Cleanup. Oct 8 19:48:42.923012 systemd[1]: Starting systemd-fsck-usr.service... Oct 8 19:48:42.923020 systemd[1]: Starting systemd-journald.service - Journal Service... Oct 8 19:48:42.923028 systemd[1]: Starting systemd-modules-load.service - Load Kernel Modules... Oct 8 19:48:42.923036 systemd[1]: Starting systemd-vconsole-setup.service - Virtual Console Setup... Oct 8 19:48:42.923044 systemd[1]: Finished ignition-setup-pre.service - Ignition env setup. Oct 8 19:48:42.923051 systemd[1]: Finished kmod-static-nodes.service - Create List of Static Device Nodes. Oct 8 19:48:42.923059 systemd[1]: Finished systemd-fsck-usr.service. Oct 8 19:48:42.923069 systemd[1]: Starting systemd-tmpfiles-setup-dev-early.service - Create Static Device Nodes in /dev gracefully... Oct 8 19:48:42.923091 systemd-journald[237]: Collecting audit messages is disabled. Oct 8 19:48:42.923111 systemd[1]: Finished systemd-vconsole-setup.service - Virtual Console Setup. Oct 8 19:48:42.923120 systemd-journald[237]: Journal started Oct 8 19:48:42.923138 systemd-journald[237]: Runtime Journal (/run/log/journal/e441de33a5d54a67a2279c2da78f43d2) is 5.9M, max 47.3M, 41.4M free. Oct 8 19:48:42.914876 systemd-modules-load[239]: Inserted module 'overlay' Oct 8 19:48:42.925312 systemd[1]: Starting dracut-cmdline-ask.service - dracut ask for additional cmdline parameters... Oct 8 19:48:42.928183 systemd[1]: Started systemd-journald.service - Journal Service. Oct 8 19:48:42.928210 kernel: bridge: filtering via arp/ip/ip6tables is no longer available by default. Update your scripts to load br_netfilter if you need this. Oct 8 19:48:42.930111 systemd[1]: Finished systemd-tmpfiles-setup-dev-early.service - Create Static Device Nodes in /dev gracefully. Oct 8 19:48:42.933061 systemd-modules-load[239]: Inserted module 'br_netfilter' Oct 8 19:48:42.933932 kernel: Bridge firewalling registered Oct 8 19:48:42.933438 systemd[1]: Starting systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev... Oct 8 19:48:42.936374 systemd[1]: Starting systemd-tmpfiles-setup.service - Create Volatile Files and Directories... Oct 8 19:48:42.937708 systemd[1]: Finished systemd-modules-load.service - Load Kernel Modules. Oct 8 19:48:42.943343 systemd[1]: Starting systemd-sysctl.service - Apply Kernel Variables... Oct 8 19:48:42.944486 systemd[1]: Finished systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev. Oct 8 19:48:42.949119 systemd[1]: Finished systemd-tmpfiles-setup.service - Create Volatile Files and Directories. Oct 8 19:48:42.950537 systemd[1]: Finished dracut-cmdline-ask.service - dracut ask for additional cmdline parameters. Oct 8 19:48:42.959091 systemd[1]: Starting dracut-cmdline.service - dracut cmdline hook... Oct 8 19:48:42.965409 systemd[1]: Finished systemd-sysctl.service - Apply Kernel Variables. Oct 8 19:48:42.967966 systemd[1]: Starting systemd-resolved.service - Network Name Resolution... Oct 8 19:48:42.973887 dracut-cmdline[274]: dracut-dracut-053 Oct 8 19:48:42.977155 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=c838587f25bc3913a152d0e9ed071e943b77b8dea81b67c254bbd10c29051fd2 Oct 8 19:48:43.000357 systemd-resolved[280]: Positive Trust Anchors: Oct 8 19:48:43.000372 systemd-resolved[280]: . IN DS 20326 8 2 e06d44b80b8f1d39a95c0b0d7c65d08458e880409bbc683457104237c7f8ec8d Oct 8 19:48:43.000403 systemd-resolved[280]: 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 Oct 8 19:48:43.006939 systemd-resolved[280]: Defaulting to hostname 'linux'. Oct 8 19:48:43.013341 systemd[1]: Started systemd-resolved.service - Network Name Resolution. Oct 8 19:48:43.014573 systemd[1]: Reached target nss-lookup.target - Host and Network Name Lookups. Oct 8 19:48:43.052172 kernel: SCSI subsystem initialized Oct 8 19:48:43.057162 kernel: Loading iSCSI transport class v2.0-870. Oct 8 19:48:43.064168 kernel: iscsi: registered transport (tcp) Oct 8 19:48:43.077489 kernel: iscsi: registered transport (qla4xxx) Oct 8 19:48:43.077530 kernel: QLogic iSCSI HBA Driver Oct 8 19:48:43.121943 systemd[1]: Finished dracut-cmdline.service - dracut cmdline hook. Oct 8 19:48:43.133290 systemd[1]: Starting dracut-pre-udev.service - dracut pre-udev hook... Oct 8 19:48:43.150205 kernel: device-mapper: core: CONFIG_IMA_DISABLE_HTABLE is disabled. Duplicate IMA measurements will not be recorded in the IMA log. Oct 8 19:48:43.150249 kernel: device-mapper: uevent: version 1.0.3 Oct 8 19:48:43.151281 kernel: device-mapper: ioctl: 4.48.0-ioctl (2023-03-01) initialised: dm-devel@redhat.com Oct 8 19:48:43.201180 kernel: raid6: neonx8 gen() 15767 MB/s Oct 8 19:48:43.218171 kernel: raid6: neonx4 gen() 15628 MB/s Oct 8 19:48:43.235169 kernel: raid6: neonx2 gen() 13211 MB/s Oct 8 19:48:43.252167 kernel: raid6: neonx1 gen() 10473 MB/s Oct 8 19:48:43.269166 kernel: raid6: int64x8 gen() 6944 MB/s Oct 8 19:48:43.286167 kernel: raid6: int64x4 gen() 7335 MB/s Oct 8 19:48:43.303168 kernel: raid6: int64x2 gen() 6123 MB/s Oct 8 19:48:43.320437 kernel: raid6: int64x1 gen() 5043 MB/s Oct 8 19:48:43.320456 kernel: raid6: using algorithm neonx8 gen() 15767 MB/s Oct 8 19:48:43.338259 kernel: raid6: .... xor() 11931 MB/s, rmw enabled Oct 8 19:48:43.338278 kernel: raid6: using neon recovery algorithm Oct 8 19:48:43.343163 kernel: xor: measuring software checksum speed Oct 8 19:48:43.344353 kernel: 8regs : 17410 MB/sec Oct 8 19:48:43.344378 kernel: 32regs : 19650 MB/sec Oct 8 19:48:43.345592 kernel: arm64_neon : 26883 MB/sec Oct 8 19:48:43.345605 kernel: xor: using function: arm64_neon (26883 MB/sec) Oct 8 19:48:43.397168 kernel: Btrfs loaded, zoned=no, fsverity=no Oct 8 19:48:43.410174 systemd[1]: Finished dracut-pre-udev.service - dracut pre-udev hook. Oct 8 19:48:43.422330 systemd[1]: Starting systemd-udevd.service - Rule-based Manager for Device Events and Files... Oct 8 19:48:43.436340 systemd-udevd[459]: Using default interface naming scheme 'v255'. Oct 8 19:48:43.439558 systemd[1]: Started systemd-udevd.service - Rule-based Manager for Device Events and Files. Oct 8 19:48:43.450429 systemd[1]: Starting dracut-pre-trigger.service - dracut pre-trigger hook... Oct 8 19:48:43.461798 dracut-pre-trigger[467]: rd.md=0: removing MD RAID activation Oct 8 19:48:43.488743 systemd[1]: Finished dracut-pre-trigger.service - dracut pre-trigger hook. Oct 8 19:48:43.497322 systemd[1]: Starting systemd-udev-trigger.service - Coldplug All udev Devices... Oct 8 19:48:43.539937 systemd[1]: Finished systemd-udev-trigger.service - Coldplug All udev Devices. Oct 8 19:48:43.550310 systemd[1]: Starting dracut-initqueue.service - dracut initqueue hook... Oct 8 19:48:43.563583 systemd[1]: Finished dracut-initqueue.service - dracut initqueue hook. Oct 8 19:48:43.565185 systemd[1]: Reached target remote-fs-pre.target - Preparation for Remote File Systems. Oct 8 19:48:43.566836 systemd[1]: Reached target remote-cryptsetup.target - Remote Encrypted Volumes. Oct 8 19:48:43.569020 systemd[1]: Reached target remote-fs.target - Remote File Systems. Oct 8 19:48:43.581318 systemd[1]: Starting dracut-pre-mount.service - dracut pre-mount hook... Oct 8 19:48:43.586165 kernel: tpm_tis MSFT0101:00: 2.0 TPM (device-id 0x1, rev-id 1) Oct 8 19:48:43.589701 kernel: virtio_blk virtio1: 1/0/0 default/read/poll queues Oct 8 19:48:43.589832 kernel: virtio_blk virtio1: [vda] 1064960 512-byte logical blocks (545 MB/520 MiB) Oct 8 19:48:43.599411 kernel: virtio_blk virtio2: 1/0/0 default/read/poll queues Oct 8 19:48:43.599604 kernel: virtio_blk virtio2: [vdb] 9289728 512-byte logical blocks (4.76 GB/4.43 GiB) Oct 8 19:48:43.591050 systemd[1]: Finished dracut-pre-mount.service - dracut pre-mount hook. Oct 8 19:48:43.603167 kernel: vdb: vdb1 vdb2 vdb3 vdb4 vdb6 vdb7 vdb9 Oct 8 19:48:43.605563 systemd[1]: dracut-cmdline-ask.service: Deactivated successfully. Oct 8 19:48:43.606317 systemd[1]: Stopped dracut-cmdline-ask.service - dracut ask for additional cmdline parameters. Oct 8 19:48:43.612382 systemd[1]: Stopping dracut-cmdline-ask.service - dracut ask for additional cmdline parameters... Oct 8 19:48:43.617257 kernel: BTRFS: device label OEM devid 1 transid 12 /dev/vdb6 scanned by (udev-worker) (511) Oct 8 19:48:43.614481 systemd[1]: systemd-vconsole-setup.service: Deactivated successfully. Oct 8 19:48:43.621291 kernel: BTRFS: device fsid a2a78d47-736b-4018-a518-3cfb16920575 devid 1 transid 36 /dev/vdb3 scanned by (udev-worker) (504) Oct 8 19:48:43.614631 systemd[1]: Stopped systemd-vconsole-setup.service - Virtual Console Setup. Oct 8 19:48:43.620278 systemd[1]: Stopping systemd-vconsole-setup.service - Virtual Console Setup... Oct 8 19:48:43.629390 systemd[1]: Starting systemd-vconsole-setup.service - Virtual Console Setup... Oct 8 19:48:43.638941 systemd[1]: Finished systemd-vconsole-setup.service - Virtual Console Setup. Oct 8 19:48:43.646378 systemd[1]: Found device dev-disk-by\x2dlabel-ROOT.device - /dev/disk/by-label/ROOT. Oct 8 19:48:43.650893 systemd[1]: Found device dev-disk-by\x2dlabel-EFI\x2dSYSTEM.device - /dev/disk/by-label/EFI-SYSTEM. Oct 8 19:48:43.657315 systemd[1]: Found device dev-disk-by\x2dpartuuid-7130c94a\x2d213a\x2d4e5a\x2d8e26\x2d6cce9662f132.device - /dev/disk/by-partuuid/7130c94a-213a-4e5a-8e26-6cce9662f132. Oct 8 19:48:43.658505 systemd[1]: Found device dev-disk-by\x2dpartlabel-USR\x2dA.device - /dev/disk/by-partlabel/USR-A. Oct 8 19:48:43.664636 systemd[1]: Found device dev-disk-by\x2dlabel-OEM.device - /dev/disk/by-label/OEM. Oct 8 19:48:43.676294 systemd[1]: Starting disk-uuid.service - Generate new UUID for disk GPT if necessary... Oct 8 19:48:43.678022 systemd[1]: Starting dracut-cmdline-ask.service - dracut ask for additional cmdline parameters... Oct 8 19:48:43.685160 kernel: vdb: vdb1 vdb2 vdb3 vdb4 vdb6 vdb7 vdb9 Oct 8 19:48:43.699197 kernel: vdb: vdb1 vdb2 vdb3 vdb4 vdb6 vdb7 vdb9 Oct 8 19:48:43.702091 systemd[1]: Finished dracut-cmdline-ask.service - dracut ask for additional cmdline parameters. Oct 8 19:48:44.701166 kernel: vdb: vdb1 vdb2 vdb3 vdb4 vdb6 vdb7 vdb9 Oct 8 19:48:44.701807 disk-uuid[551]: The operation has completed successfully. Oct 8 19:48:44.725916 systemd[1]: disk-uuid.service: Deactivated successfully. Oct 8 19:48:44.726008 systemd[1]: Finished disk-uuid.service - Generate new UUID for disk GPT if necessary. Oct 8 19:48:44.747337 systemd[1]: Starting verity-setup.service - Verity Setup for /dev/mapper/usr... Oct 8 19:48:44.750290 sh[575]: Success Oct 8 19:48:44.766170 kernel: device-mapper: verity: sha256 using implementation "sha256-ce" Oct 8 19:48:44.794182 systemd[1]: Found device dev-mapper-usr.device - /dev/mapper/usr. Oct 8 19:48:44.802409 systemd[1]: Mounting sysusr-usr.mount - /sysusr/usr... Oct 8 19:48:44.803876 systemd[1]: Finished verity-setup.service - Verity Setup for /dev/mapper/usr. Oct 8 19:48:44.813801 kernel: BTRFS info (device dm-0): first mount of filesystem a2a78d47-736b-4018-a518-3cfb16920575 Oct 8 19:48:44.813859 kernel: BTRFS info (device dm-0): using crc32c (crc32c-generic) checksum algorithm Oct 8 19:48:44.813880 kernel: BTRFS warning (device dm-0): 'nologreplay' is deprecated, use 'rescue=nologreplay' instead Oct 8 19:48:44.815652 kernel: BTRFS info (device dm-0): disabling log replay at mount time Oct 8 19:48:44.815668 kernel: BTRFS info (device dm-0): using free space tree Oct 8 19:48:44.819247 systemd[1]: Mounted sysusr-usr.mount - /sysusr/usr. Oct 8 19:48:44.820525 systemd[1]: afterburn-network-kargs.service - Afterburn Initrd Setup Network Kernel Arguments was skipped because no trigger condition checks were met. Oct 8 19:48:44.836357 systemd[1]: Starting ignition-setup.service - Ignition (setup)... Oct 8 19:48:44.837834 systemd[1]: Starting parse-ip-for-networkd.service - Write systemd-networkd units from cmdline... Oct 8 19:48:44.845369 kernel: BTRFS info (device vdb6): first mount of filesystem 95ed8f66-d8c4-4374-b329-28c20748d95f Oct 8 19:48:44.845405 kernel: BTRFS info (device vdb6): using crc32c (crc32c-generic) checksum algorithm Oct 8 19:48:44.845415 kernel: BTRFS info (device vdb6): using free space tree Oct 8 19:48:44.848163 kernel: BTRFS info (device vdb6): auto enabling async discard Oct 8 19:48:44.854871 systemd[1]: mnt-oem.mount: Deactivated successfully. Oct 8 19:48:44.857159 kernel: BTRFS info (device vdb6): last unmount of filesystem 95ed8f66-d8c4-4374-b329-28c20748d95f Oct 8 19:48:44.862622 systemd[1]: Finished ignition-setup.service - Ignition (setup). Oct 8 19:48:44.870315 systemd[1]: Starting ignition-fetch-offline.service - Ignition (fetch-offline)... Oct 8 19:48:44.923184 systemd[1]: Finished parse-ip-for-networkd.service - Write systemd-networkd units from cmdline. Oct 8 19:48:44.934366 systemd[1]: Starting systemd-networkd.service - Network Configuration... Oct 8 19:48:44.962642 systemd-networkd[760]: lo: Link UP Oct 8 19:48:44.962651 systemd-networkd[760]: lo: Gained carrier Oct 8 19:48:44.963310 systemd-networkd[760]: Enumeration completed Oct 8 19:48:44.965967 ignition[675]: Ignition 2.18.0 Oct 8 19:48:44.963574 systemd[1]: Started systemd-networkd.service - Network Configuration. Oct 8 19:48:44.965973 ignition[675]: Stage: fetch-offline Oct 8 19:48:44.963870 systemd-networkd[760]: eth0: found matching network '/usr/lib/systemd/network/zz-default.network', based on potentially unpredictable interface name. Oct 8 19:48:44.966006 ignition[675]: no configs at "/usr/lib/ignition/base.d" Oct 8 19:48:44.963873 systemd-networkd[760]: eth0: Configuring with /usr/lib/systemd/network/zz-default.network. Oct 8 19:48:44.966015 ignition[675]: no config dir at "/usr/lib/ignition/base.platform.d/qemu" Oct 8 19:48:44.964840 systemd-networkd[760]: eth0: Link UP Oct 8 19:48:44.966104 ignition[675]: parsed url from cmdline: "" Oct 8 19:48:44.964843 systemd-networkd[760]: eth0: Gained carrier Oct 8 19:48:44.966108 ignition[675]: no config URL provided Oct 8 19:48:44.964850 systemd-networkd[760]: eth0: found matching network '/usr/lib/systemd/network/zz-default.network', based on potentially unpredictable interface name. Oct 8 19:48:44.966112 ignition[675]: reading system config file "/usr/lib/ignition/user.ign" Oct 8 19:48:44.965307 systemd[1]: Reached target network.target - Network. Oct 8 19:48:44.966119 ignition[675]: no config at "/usr/lib/ignition/user.ign" Oct 8 19:48:44.966153 ignition[675]: op(1): [started] loading QEMU firmware config module Oct 8 19:48:44.966158 ignition[675]: op(1): executing: "modprobe" "qemu_fw_cfg" Oct 8 19:48:44.976655 ignition[675]: op(1): [finished] loading QEMU firmware config module Oct 8 19:48:44.987216 systemd-networkd[760]: eth0: DHCPv4 address 10.0.0.104/16, gateway 10.0.0.1 acquired from 10.0.0.1 Oct 8 19:48:44.989201 ignition[675]: parsing config with SHA512: 8d2ee5a4a00e94bdc36abae6fcd132418d25097f80abc95064bd35b9fd302f2ea02a31a87c244267c9ecb50e8221f987b4ddaee05f583f01530973bcaca46d89 Oct 8 19:48:44.992962 unknown[675]: fetched base config from "system" Oct 8 19:48:44.992972 unknown[675]: fetched user config from "qemu" Oct 8 19:48:44.993242 ignition[675]: fetch-offline: fetch-offline passed Oct 8 19:48:44.994838 systemd[1]: Finished ignition-fetch-offline.service - Ignition (fetch-offline). Oct 8 19:48:44.993334 ignition[675]: Ignition finished successfully Oct 8 19:48:44.997069 systemd[1]: ignition-fetch.service - Ignition (fetch) was skipped because of an unmet condition check (ConditionPathExists=!/run/ignition.json). Oct 8 19:48:45.007340 systemd[1]: Starting ignition-kargs.service - Ignition (kargs)... Oct 8 19:48:45.017913 ignition[773]: Ignition 2.18.0 Oct 8 19:48:45.017923 ignition[773]: Stage: kargs Oct 8 19:48:45.018083 ignition[773]: no configs at "/usr/lib/ignition/base.d" Oct 8 19:48:45.018093 ignition[773]: no config dir at "/usr/lib/ignition/base.platform.d/qemu" Oct 8 19:48:45.018783 ignition[773]: kargs: kargs passed Oct 8 19:48:45.018827 ignition[773]: Ignition finished successfully Oct 8 19:48:45.023787 systemd[1]: Finished ignition-kargs.service - Ignition (kargs). Oct 8 19:48:45.036292 systemd[1]: Starting ignition-disks.service - Ignition (disks)... Oct 8 19:48:45.046820 ignition[782]: Ignition 2.18.0 Oct 8 19:48:45.046829 ignition[782]: Stage: disks Oct 8 19:48:45.047002 ignition[782]: no configs at "/usr/lib/ignition/base.d" Oct 8 19:48:45.047012 ignition[782]: no config dir at "/usr/lib/ignition/base.platform.d/qemu" Oct 8 19:48:45.047673 ignition[782]: disks: createLuks: op(1): [started] waiting for devices [/dev/disk/by-partlabel/ROOT] Oct 8 19:48:45.052116 ignition[782]: disks: createLuks: op(1): [finished] waiting for devices [/dev/disk/by-partlabel/ROOT] Oct 8 19:48:45.052216 ignition[782]: disks: createLuks: created device alias for "/dev/disk/by-partlabel/ROOT": "/run/ignition/dev_aliases/dev/disk/by-partlabel/ROOT" -> "/dev/vdb9" Oct 8 19:48:45.052364 ignition[782]: disks: createLuks: op(2): [started] wiping filesystem signatures from "/run/ignition/dev_aliases/dev/disk/by-partlabel/ROOT" Oct 8 19:48:45.052371 ignition[782]: disks: createLuks: op(2): executing: "wipefs" "-a" "/run/ignition/dev_aliases/dev/disk/by-partlabel/ROOT" Oct 8 19:48:45.067206 ignition[782]: disks: createLuks: op(2): [finished] wiping filesystem signatures from "/run/ignition/dev_aliases/dev/disk/by-partlabel/ROOT" Oct 8 19:48:45.067239 ignition[782]: disks: createLuks: op(3): [started] creating "rootencrypted" Oct 8 19:48:45.067266 ignition[782]: disks: createLuks: op(3): executing: "cryptsetup" "luksFormat" "--type" "luks2" "--key-file" "/tmp/ignition-luks-1754966689" "/run/ignition/dev_aliases/dev/disk/by-partlabel/ROOT" Oct 8 19:48:46.677342 systemd-networkd[760]: eth0: Gained IPv6LL Oct 8 19:48:52.308430 ignition[782]: disks: createLuks: op(3): [finished] creating "rootencrypted" Oct 8 19:48:52.308467 ignition[782]: disks: createLuks: op(4): [started] opening luks device rootencrypted Oct 8 19:48:52.308505 ignition[782]: disks: createLuks: op(4): executing: "cryptsetup" "luksOpen" "/run/ignition/dev_aliases/dev/disk/by-partlabel/ROOT" "rootencrypted" "--key-file" "/tmp/ignition-luks-1754966689" "--persistent" Oct 8 19:48:54.239174 kernel: Key type trusted registered Oct 8 19:48:54.241157 kernel: Key type encrypted registered Oct 8 19:48:54.266305 ignition[782]: disks: createLuks: op(4): [finished] opening luks device rootencrypted Oct 8 19:48:54.266376 ignition[782]: disks: createLuks: op(5): [started] waiting for triggered uevent Oct 8 19:48:54.266384 ignition[782]: disks: createLuks: op(5): executing: "udevadm" "trigger" "--settle" "/dev/vdb9" Oct 8 19:48:54.284799 ignition[782]: disks: createLuks: op(5): [finished] waiting for triggered uevent Oct 8 19:48:54.284829 ignition[782]: disks: createFilesystems: op(6): [started] waiting for devices [/dev/mapper/rootencrypted] Oct 8 19:48:54.290383 ignition[782]: disks: createFilesystems: op(6): [finished] waiting for devices [/dev/mapper/rootencrypted] Oct 8 19:48:54.290437 ignition[782]: disks: createFilesystems: created device alias for "/dev/mapper/rootencrypted": "/run/ignition/dev_aliases/dev/mapper/rootencrypted" -> "/dev/dm-1" Oct 8 19:48:54.292582 ignition[782]: disks: createFilesystems: op(7): [started] determining filesystem type of "/dev/mapper/rootencrypted" Oct 8 19:48:54.305180 ignition[782]: disks: createFilesystems: op(7): [finished] determining filesystem type of "/dev/mapper/rootencrypted" Oct 8 19:48:54.305191 ignition[782]: disks: createFilesystems: found filesystem at "/dev/mapper/rootencrypted" with uuid "" and label "" Oct 8 19:48:54.305218 ignition[782]: disks: createFilesystems: op(8): [started] wiping filesystem signatures from "/run/ignition/dev_aliases/dev/mapper/rootencrypted" Oct 8 19:48:54.305224 ignition[782]: disks: createFilesystems: op(8): executing: "wipefs" "-a" "/run/ignition/dev_aliases/dev/mapper/rootencrypted" Oct 8 19:48:54.313453 ignition[782]: disks: createFilesystems: op(8): [finished] wiping filesystem signatures from "/run/ignition/dev_aliases/dev/mapper/rootencrypted" Oct 8 19:48:54.313495 ignition[782]: disks: createFilesystems: op(9): [started] creating "ext4" filesystem on "/run/ignition/dev_aliases/dev/mapper/rootencrypted" Oct 8 19:48:54.313502 ignition[782]: disks: createFilesystems: op(9): executing: "mkfs.ext4" "-F" "-L" "ROOT" "/run/ignition/dev_aliases/dev/mapper/rootencrypted" Oct 8 19:48:54.406593 ignition[782]: disks: createFilesystems: op(9): [finished] creating "ext4" filesystem on "/run/ignition/dev_aliases/dev/mapper/rootencrypted" Oct 8 19:48:54.406665 ignition[782]: disks: createFilesystems: op(a): [started] waiting for triggered uevent Oct 8 19:48:54.406672 ignition[782]: disks: createFilesystems: op(a): executing: "udevadm" "trigger" "--settle" "/dev/dm-1" Oct 8 19:48:54.424545 ignition[782]: disks: createFilesystems: op(a): [finished] waiting for triggered uevent Oct 8 19:48:54.424558 ignition[782]: disks: disks passed Oct 8 19:48:54.426337 systemd[1]: Finished ignition-disks.service - Ignition (disks). Oct 8 19:48:54.424651 ignition[782]: Ignition finished successfully Oct 8 19:48:54.429684 systemd[1]: Reached target initrd-root-device.target - Initrd Root Device. Oct 8 19:48:54.430802 systemd[1]: Reached target local-fs-pre.target - Preparation for Local File Systems. Oct 8 19:48:54.432903 systemd[1]: Reached target local-fs.target - Local File Systems. Oct 8 19:48:54.434831 systemd[1]: Reached target sysinit.target - System Initialization. Oct 8 19:48:54.436583 systemd[1]: Reached target basic.target - Basic System. Oct 8 19:48:54.450342 systemd[1]: Starting systemd-fsck-root.service - File System Check on /dev/disk/by-label/ROOT... Oct 8 19:48:54.466930 systemd-fsck[1779]: ROOT: clean, 11/137360 files, 26629/549376 blocks Oct 8 19:48:54.472180 systemd[1]: Finished systemd-fsck-root.service - File System Check on /dev/disk/by-label/ROOT. Oct 8 19:48:54.481249 systemd[1]: Mounting sysroot.mount - /sysroot... Oct 8 19:48:54.532162 kernel: EXT4-fs (dm-1): mounted filesystem 873ea13e-9333-492d-bddd-47dcc9a29c84 r/w with ordered data mode. Quota mode: none. Oct 8 19:48:54.532450 systemd[1]: Mounted sysroot.mount - /sysroot. Oct 8 19:48:54.533648 systemd[1]: Reached target initrd-root-fs.target - Initrd Root File System. Oct 8 19:48:54.546227 systemd[1]: Mounting sysroot-oem.mount - /sysroot/oem... Oct 8 19:48:54.547823 systemd[1]: Mounting sysroot-usr.mount - /sysroot/usr... Oct 8 19:48:54.549392 systemd[1]: flatcar-metadata-hostname.service - Flatcar Metadata Hostname Agent was skipped because no trigger condition checks were met. Oct 8 19:48:54.549441 systemd[1]: ignition-remount-sysroot.service - Remount /sysroot read-write for Ignition was skipped because of an unmet condition check (ConditionPathIsReadWrite=!/sysroot). Oct 8 19:48:54.559449 kernel: BTRFS: device label OEM devid 1 transid 13 /dev/vdb6 scanned by mount (1789) Oct 8 19:48:54.559471 kernel: BTRFS info (device vdb6): first mount of filesystem 95ed8f66-d8c4-4374-b329-28c20748d95f Oct 8 19:48:54.559481 kernel: BTRFS info (device vdb6): using crc32c (crc32c-generic) checksum algorithm Oct 8 19:48:54.559491 kernel: BTRFS info (device vdb6): using free space tree Oct 8 19:48:54.549464 systemd[1]: Reached target ignition-diskful.target - Ignition Boot Disk Setup. Oct 8 19:48:54.562459 kernel: BTRFS info (device vdb6): auto enabling async discard Oct 8 19:48:54.553833 systemd[1]: Mounted sysroot-usr.mount - /sysroot/usr. Oct 8 19:48:54.555735 systemd[1]: Starting initrd-setup-root.service - Root filesystem setup... Oct 8 19:48:54.563319 systemd[1]: Mounted sysroot-oem.mount - /sysroot/oem. Oct 8 19:48:54.572123 initrd-setup-root[1813]: cut: /sysroot/etc/passwd: No such file or directory Oct 8 19:48:54.575738 initrd-setup-root[1820]: cut: /sysroot/etc/group: No such file or directory Oct 8 19:48:54.578706 initrd-setup-root[1827]: cut: /sysroot/etc/shadow: No such file or directory Oct 8 19:48:54.581702 initrd-setup-root[1834]: cut: /sysroot/etc/gshadow: No such file or directory Oct 8 19:48:54.645095 systemd[1]: Finished initrd-setup-root.service - Root filesystem setup. Oct 8 19:48:54.655276 systemd[1]: Starting ignition-mount.service - Ignition (mount)... Oct 8 19:48:54.658546 systemd[1]: Starting sysroot-boot.service - /sysroot/boot... Oct 8 19:48:54.660521 systemd[1]: sysroot-oem.mount: Deactivated successfully. Oct 8 19:48:54.662714 kernel: BTRFS info (device vdb6): last unmount of filesystem 95ed8f66-d8c4-4374-b329-28c20748d95f Oct 8 19:48:54.678089 systemd[1]: Finished sysroot-boot.service - /sysroot/boot. Oct 8 19:48:54.679958 ignition[1903]: INFO : Ignition 2.18.0 Oct 8 19:48:54.679958 ignition[1903]: INFO : Stage: mount Oct 8 19:48:54.679958 ignition[1903]: INFO : no configs at "/usr/lib/ignition/base.d" Oct 8 19:48:54.679958 ignition[1903]: INFO : no config dir at "/usr/lib/ignition/base.platform.d/qemu" Oct 8 19:48:54.679958 ignition[1903]: INFO : mount: mount passed Oct 8 19:48:54.679958 ignition[1903]: INFO : Ignition finished successfully Oct 8 19:48:54.680790 systemd[1]: Finished ignition-mount.service - Ignition (mount). Oct 8 19:48:54.691308 systemd[1]: Starting ignition-files.service - Ignition (files)... Oct 8 19:48:55.542365 systemd[1]: Mounting sysroot-oem.mount - /sysroot/oem... Oct 8 19:48:55.548166 kernel: BTRFS: device label OEM devid 1 transid 14 /dev/vdb6 scanned by mount (1918) Oct 8 19:48:55.550450 kernel: BTRFS info (device vdb6): first mount of filesystem 95ed8f66-d8c4-4374-b329-28c20748d95f Oct 8 19:48:55.550466 kernel: BTRFS info (device vdb6): using crc32c (crc32c-generic) checksum algorithm Oct 8 19:48:55.550477 kernel: BTRFS info (device vdb6): using free space tree Oct 8 19:48:55.553171 kernel: BTRFS info (device vdb6): auto enabling async discard Oct 8 19:48:55.554435 systemd[1]: Mounted sysroot-oem.mount - /sysroot/oem. Oct 8 19:48:55.570391 ignition[1935]: INFO : Ignition 2.18.0 Oct 8 19:48:55.570391 ignition[1935]: INFO : Stage: files Oct 8 19:48:55.571909 ignition[1935]: INFO : no configs at "/usr/lib/ignition/base.d" Oct 8 19:48:55.571909 ignition[1935]: INFO : no config dir at "/usr/lib/ignition/base.platform.d/qemu" Oct 8 19:48:55.571909 ignition[1935]: DEBUG : files: compiled without relabeling support, skipping Oct 8 19:48:55.575223 ignition[1935]: INFO : files: ensureUsers: op(1): [started] creating or modifying user "core" Oct 8 19:48:55.575223 ignition[1935]: DEBUG : files: ensureUsers: op(1): executing: "usermod" "--root" "/sysroot" "core" Oct 8 19:48:55.577998 ignition[1935]: INFO : files: ensureUsers: op(1): [finished] creating or modifying user "core" Oct 8 19:48:55.579303 ignition[1935]: INFO : files: ensureUsers: op(2): [started] adding ssh keys to user "core" Oct 8 19:48:55.579303 ignition[1935]: INFO : files: ensureUsers: op(2): [finished] adding ssh keys to user "core" Oct 8 19:48:55.578574 unknown[1935]: wrote ssh authorized keys file for user: core Oct 8 19:48:55.582894 ignition[1935]: INFO : files: createFilesystemsFiles: createFiles: op(3): [started] writing file "/sysroot/etc/flatcar/update.conf" Oct 8 19:48:55.582894 ignition[1935]: INFO : files: createFilesystemsFiles: createFiles: op(3): [finished] writing file "/sysroot/etc/flatcar/update.conf" Oct 8 19:48:55.582894 ignition[1935]: INFO : files: op(4): [started] processing unit "cryptenroll-helper-first.service" Oct 8 19:48:55.582894 ignition[1935]: INFO : files: op(4): op(5): [started] writing unit "cryptenroll-helper-first.service" at "/sysroot/etc/systemd/system/cryptenroll-helper-first.service" Oct 8 19:48:55.582894 ignition[1935]: INFO : files: op(4): op(5): [finished] writing unit "cryptenroll-helper-first.service" at "/sysroot/etc/systemd/system/cryptenroll-helper-first.service" Oct 8 19:48:55.582894 ignition[1935]: INFO : files: op(4): [finished] processing unit "cryptenroll-helper-first.service" Oct 8 19:48:55.582894 ignition[1935]: INFO : files: op(6): [started] processing unit "cryptenroll-helper-bind.service" Oct 8 19:48:55.582894 ignition[1935]: INFO : files: op(6): op(7): [started] writing unit "cryptenroll-helper-bind.service" at "/sysroot/etc/systemd/system/cryptenroll-helper-bind.service" Oct 8 19:48:55.582894 ignition[1935]: INFO : files: op(6): op(7): [finished] writing unit "cryptenroll-helper-bind.service" at "/sysroot/etc/systemd/system/cryptenroll-helper-bind.service" Oct 8 19:48:55.582894 ignition[1935]: INFO : files: op(6): [finished] processing unit "cryptenroll-helper-bind.service" Oct 8 19:48:55.582894 ignition[1935]: INFO : files: op(8): [started] processing unit "coreos-metadata.service" Oct 8 19:48:55.582894 ignition[1935]: INFO : files: op(8): op(9): [started] writing unit "coreos-metadata.service" at "/sysroot/etc/systemd/system/coreos-metadata.service" Oct 8 19:48:55.582894 ignition[1935]: INFO : files: op(8): op(9): [finished] writing unit "coreos-metadata.service" at "/sysroot/etc/systemd/system/coreos-metadata.service" Oct 8 19:48:55.582894 ignition[1935]: INFO : files: op(8): [finished] processing unit "coreos-metadata.service" Oct 8 19:48:55.582894 ignition[1935]: INFO : files: op(a): [started] setting preset to disabled for "coreos-metadata.service" Oct 8 19:48:55.610284 ignition[1935]: INFO : files: op(a): op(b): [started] removing enablement symlink(s) for "coreos-metadata.service" Oct 8 19:48:55.613869 ignition[1935]: INFO : files: op(a): op(b): [finished] removing enablement symlink(s) for "coreos-metadata.service" Oct 8 19:48:55.615319 ignition[1935]: INFO : files: op(a): [finished] setting preset to disabled for "coreos-metadata.service" Oct 8 19:48:55.615319 ignition[1935]: INFO : files: op(c): [started] setting preset to enabled for "cryptenroll-helper-bind.service" Oct 8 19:48:55.615319 ignition[1935]: INFO : files: op(c): [finished] setting preset to enabled for "cryptenroll-helper-bind.service" Oct 8 19:48:55.615319 ignition[1935]: INFO : files: op(d): [started] setting preset to enabled for "cryptenroll-helper-first.service" Oct 8 19:48:55.615319 ignition[1935]: INFO : files: op(d): [finished] setting preset to enabled for "cryptenroll-helper-first.service" Oct 8 19:48:55.623040 ignition[1935]: INFO : files: createCrypttabEntries: createFiles: op(e): [started] writing file "/sysroot/etc/luks/rootencrypted" Oct 8 19:48:55.623040 ignition[1935]: INFO : files: createCrypttabEntries: createFiles: op(e): [finished] writing file "/sysroot/etc/luks/rootencrypted" Oct 8 19:48:55.623040 ignition[1935]: INFO : files: createCrypttabEntries: createFiles: op(f): [started] writing file "/sysroot/etc/crypttab" Oct 8 19:48:55.623040 ignition[1935]: INFO : files: createCrypttabEntries: createFiles: op(f): [finished] writing file "/sysroot/etc/crypttab" Oct 8 19:48:55.623040 ignition[1935]: INFO : files: createCrypttabEntries: createFiles: op(10): [started] appending to file "/sysroot/etc/crypttab" Oct 8 19:48:55.623040 ignition[1935]: INFO : files: createCrypttabEntries: createFiles: op(10): [finished] appending to file "/sysroot/etc/crypttab" Oct 8 19:48:55.623040 ignition[1935]: INFO : files: createResultFile: createFiles: op(11): [started] writing file "/sysroot/etc/.ignition-result.json" Oct 8 19:48:55.623040 ignition[1935]: INFO : files: createResultFile: createFiles: op(11): [finished] writing file "/sysroot/etc/.ignition-result.json" Oct 8 19:48:55.623040 ignition[1935]: INFO : files: files passed Oct 8 19:48:55.623040 ignition[1935]: INFO : Ignition finished successfully Oct 8 19:48:55.623906 systemd[1]: Finished ignition-files.service - Ignition (files). Oct 8 19:48:55.636276 systemd[1]: Starting ignition-quench.service - Ignition (record completion)... Oct 8 19:48:55.637979 systemd[1]: Starting initrd-setup-root-after-ignition.service - Root filesystem completion... Oct 8 19:48:55.641761 systemd[1]: ignition-quench.service: Deactivated successfully. Oct 8 19:48:55.641840 systemd[1]: Finished ignition-quench.service - Ignition (record completion). Oct 8 19:48:55.646630 initrd-setup-root-after-ignition[1964]: grep: /sysroot/oem/oem-release: No such file or directory Oct 8 19:48:55.650012 initrd-setup-root-after-ignition[1966]: grep: /sysroot/etc/flatcar/enabled-sysext.conf: No such file or directory Oct 8 19:48:55.650012 initrd-setup-root-after-ignition[1966]: grep: /sysroot/usr/share/flatcar/enabled-sysext.conf: No such file or directory Oct 8 19:48:55.653074 initrd-setup-root-after-ignition[1970]: grep: /sysroot/etc/flatcar/enabled-sysext.conf: No such file or directory Oct 8 19:48:55.652752 systemd[1]: Finished initrd-setup-root-after-ignition.service - Root filesystem completion. Oct 8 19:48:55.654516 systemd[1]: Reached target ignition-complete.target - Ignition Complete. Oct 8 19:48:55.663301 systemd[1]: Starting initrd-parse-etc.service - Mountpoints Configured in the Real Root... Oct 8 19:48:55.680049 systemd[1]: initrd-parse-etc.service: Deactivated successfully. Oct 8 19:48:55.680135 systemd[1]: Finished initrd-parse-etc.service - Mountpoints Configured in the Real Root. Oct 8 19:48:55.682185 systemd[1]: Reached target initrd-fs.target - Initrd File Systems. Oct 8 19:48:55.683926 systemd[1]: Reached target initrd.target - Initrd Default Target. Oct 8 19:48:55.685611 systemd[1]: dracut-mount.service - dracut mount hook was skipped because no trigger condition checks were met. Oct 8 19:48:55.686255 systemd[1]: Starting dracut-pre-pivot.service - dracut pre-pivot and cleanup hook... Oct 8 19:48:55.700741 systemd[1]: Finished dracut-pre-pivot.service - dracut pre-pivot and cleanup hook. Oct 8 19:48:55.708369 systemd[1]: Starting initrd-cleanup.service - Cleaning Up and Shutting Down Daemons... Oct 8 19:48:55.715598 systemd[1]: Stopped target nss-lookup.target - Host and Network Name Lookups. Oct 8 19:48:55.716734 systemd[1]: Stopped target remote-cryptsetup.target - Remote Encrypted Volumes. Oct 8 19:48:55.718619 systemd[1]: Stopped target timers.target - Timer Units. Oct 8 19:48:55.720271 systemd[1]: dracut-pre-pivot.service: Deactivated successfully. Oct 8 19:48:55.720378 systemd[1]: Stopped dracut-pre-pivot.service - dracut pre-pivot and cleanup hook. Oct 8 19:48:55.722742 systemd[1]: Stopped target initrd.target - Initrd Default Target. Oct 8 19:48:55.724603 systemd[1]: Stopped target basic.target - Basic System. Oct 8 19:48:55.726162 systemd[1]: Stopped target ignition-complete.target - Ignition Complete. Oct 8 19:48:55.727833 systemd[1]: Stopped target ignition-diskful.target - Ignition Boot Disk Setup. Oct 8 19:48:55.729637 systemd[1]: Stopped target initrd-root-device.target - Initrd Root Device. Oct 8 19:48:55.731450 systemd[1]: Stopped target remote-fs.target - Remote File Systems. Oct 8 19:48:55.733138 systemd[1]: Stopped target remote-fs-pre.target - Preparation for Remote File Systems. Oct 8 19:48:55.734985 systemd[1]: Stopped target sysinit.target - System Initialization. Oct 8 19:48:55.736834 systemd[1]: Stopped target local-fs.target - Local File Systems. Oct 8 19:48:55.738445 systemd[1]: Stopped target swap.target - Swaps. Oct 8 19:48:55.739848 systemd[1]: dracut-pre-mount.service: Deactivated successfully. Oct 8 19:48:55.739962 systemd[1]: Stopped dracut-pre-mount.service - dracut pre-mount hook. Oct 8 19:48:55.742096 systemd[1]: Stopped target cryptsetup.target - Local Encrypted Volumes. Oct 8 19:48:55.743948 systemd[1]: Stopped target cryptsetup-pre.target - Local Encrypted Volumes (Pre). Oct 8 19:48:55.745812 systemd[1]: clevis-luks-askpass.path: Deactivated successfully. Oct 8 19:48:55.749193 systemd[1]: Stopped clevis-luks-askpass.path - Forward Password Requests to Clevis Directory Watch. Oct 8 19:48:55.750348 systemd[1]: dracut-initqueue.service: Deactivated successfully. Oct 8 19:48:55.750460 systemd[1]: Stopped dracut-initqueue.service - dracut initqueue hook. Oct 8 19:48:55.753024 systemd[1]: ignition-fetch-offline.service: Deactivated successfully. Oct 8 19:48:55.753139 systemd[1]: Stopped ignition-fetch-offline.service - Ignition (fetch-offline). Oct 8 19:48:55.755069 systemd[1]: Stopped target paths.target - Path Units. Oct 8 19:48:55.756578 systemd[1]: systemd-ask-password-console.path: Deactivated successfully. Oct 8 19:48:55.762206 systemd[1]: Stopped systemd-ask-password-console.path - Dispatch Password Requests to Console Directory Watch. Oct 8 19:48:55.765179 systemd[1]: Stopped target slices.target - Slice Units. Oct 8 19:48:55.766101 systemd[1]: Stopped target sockets.target - Socket Units. Oct 8 19:48:55.767626 systemd[1]: iscsid.socket: Deactivated successfully. Oct 8 19:48:55.767710 systemd[1]: Closed iscsid.socket - Open-iSCSI iscsid Socket. Oct 8 19:48:55.769242 systemd[1]: iscsiuio.socket: Deactivated successfully. Oct 8 19:48:55.769328 systemd[1]: Closed iscsiuio.socket - Open-iSCSI iscsiuio Socket. Oct 8 19:48:55.770827 systemd[1]: initrd-setup-root-after-ignition.service: Deactivated successfully. Oct 8 19:48:55.770929 systemd[1]: Stopped initrd-setup-root-after-ignition.service - Root filesystem completion. Oct 8 19:48:55.772711 systemd[1]: ignition-files.service: Deactivated successfully. Oct 8 19:48:55.772806 systemd[1]: Stopped ignition-files.service - Ignition (files). Oct 8 19:48:55.786323 systemd[1]: Stopping ignition-mount.service - Ignition (mount)... Oct 8 19:48:55.787863 systemd[1]: Stopping sysroot-boot.service - /sysroot/boot... Oct 8 19:48:55.788824 systemd[1]: systemd-udev-trigger.service: Deactivated successfully. Oct 8 19:48:55.788968 systemd[1]: Stopped systemd-udev-trigger.service - Coldplug All udev Devices. Oct 8 19:48:55.790898 systemd[1]: dracut-pre-trigger.service: Deactivated successfully. Oct 8 19:48:55.790993 systemd[1]: Stopped dracut-pre-trigger.service - dracut pre-trigger hook. Oct 8 19:48:55.796980 systemd[1]: initrd-cleanup.service: Deactivated successfully. Oct 8 19:48:55.797077 systemd[1]: Finished initrd-cleanup.service - Cleaning Up and Shutting Down Daemons. Oct 8 19:48:55.800253 ignition[1991]: INFO : Ignition 2.18.0 Oct 8 19:48:55.800253 ignition[1991]: INFO : Stage: umount Oct 8 19:48:55.800253 ignition[1991]: INFO : no configs at "/usr/lib/ignition/base.d" Oct 8 19:48:55.800253 ignition[1991]: INFO : no config dir at "/usr/lib/ignition/base.platform.d/qemu" Oct 8 19:48:55.800253 ignition[1991]: INFO : umount: umount passed Oct 8 19:48:55.800253 ignition[1991]: INFO : Ignition finished successfully Oct 8 19:48:55.800945 systemd[1]: ignition-mount.service: Deactivated successfully. Oct 8 19:48:55.801033 systemd[1]: Stopped ignition-mount.service - Ignition (mount). Oct 8 19:48:55.803982 systemd[1]: sysroot-boot.mount: Deactivated successfully. Oct 8 19:48:55.804362 systemd[1]: Stopped target network.target - Network. Oct 8 19:48:55.805677 systemd[1]: ignition-disks.service: Deactivated successfully. Oct 8 19:48:55.805726 systemd[1]: Stopped ignition-disks.service - Ignition (disks). Oct 8 19:48:55.807117 systemd[1]: ignition-kargs.service: Deactivated successfully. Oct 8 19:48:55.807171 systemd[1]: Stopped ignition-kargs.service - Ignition (kargs). Oct 8 19:48:55.808665 systemd[1]: ignition-setup.service: Deactivated successfully. Oct 8 19:48:55.808705 systemd[1]: Stopped ignition-setup.service - Ignition (setup). Oct 8 19:48:55.810216 systemd[1]: ignition-setup-pre.service: Deactivated successfully. Oct 8 19:48:55.810267 systemd[1]: Stopped ignition-setup-pre.service - Ignition env setup. Oct 8 19:48:55.812113 systemd[1]: Stopping systemd-networkd.service - Network Configuration... Oct 8 19:48:55.813721 systemd[1]: Stopping systemd-resolved.service - Network Name Resolution... Oct 8 19:48:55.815302 systemd[1]: sysroot-boot.service: Deactivated successfully. Oct 8 19:48:55.815379 systemd[1]: Stopped sysroot-boot.service - /sysroot/boot. Oct 8 19:48:55.817398 systemd[1]: initrd-setup-root.service: Deactivated successfully. Oct 8 19:48:55.817474 systemd[1]: Stopped initrd-setup-root.service - Root filesystem setup. Oct 8 19:48:55.820184 systemd-networkd[760]: eth0: DHCPv6 lease lost Oct 8 19:48:55.821271 systemd[1]: systemd-resolved.service: Deactivated successfully. Oct 8 19:48:55.821781 systemd[1]: Stopped systemd-resolved.service - Network Name Resolution. Oct 8 19:48:55.823906 systemd[1]: systemd-networkd.service: Deactivated successfully. Oct 8 19:48:55.824012 systemd[1]: Stopped systemd-networkd.service - Network Configuration. Oct 8 19:48:55.827666 systemd[1]: systemd-networkd.socket: Deactivated successfully. Oct 8 19:48:55.827717 systemd[1]: Closed systemd-networkd.socket - Network Service Netlink Socket. Oct 8 19:48:55.838258 systemd[1]: Stopping network-cleanup.service - Network Cleanup... Oct 8 19:48:55.839722 systemd[1]: parse-ip-for-networkd.service: Deactivated successfully. Oct 8 19:48:55.839779 systemd[1]: Stopped parse-ip-for-networkd.service - Write systemd-networkd units from cmdline. Oct 8 19:48:55.841708 systemd[1]: systemd-sysctl.service: Deactivated successfully. Oct 8 19:48:55.841753 systemd[1]: Stopped systemd-sysctl.service - Apply Kernel Variables. Oct 8 19:48:55.843378 systemd[1]: systemd-modules-load.service: Deactivated successfully. Oct 8 19:48:55.843421 systemd[1]: Stopped systemd-modules-load.service - Load Kernel Modules. Oct 8 19:48:55.845103 systemd[1]: systemd-tmpfiles-setup.service: Deactivated successfully. Oct 8 19:48:55.845153 systemd[1]: Stopped systemd-tmpfiles-setup.service - Create Volatile Files and Directories. Oct 8 19:48:55.847307 systemd[1]: Stopping systemd-udevd.service - Rule-based Manager for Device Events and Files... Oct 8 19:48:55.856242 systemd[1]: network-cleanup.service: Deactivated successfully. Oct 8 19:48:55.856334 systemd[1]: Stopped network-cleanup.service - Network Cleanup. Oct 8 19:48:55.860748 systemd[1]: systemd-udevd.service: Deactivated successfully. Oct 8 19:48:55.860877 systemd[1]: Stopped systemd-udevd.service - Rule-based Manager for Device Events and Files. Oct 8 19:48:55.862995 systemd[1]: systemd-udevd-control.socket: Deactivated successfully. Oct 8 19:48:55.863031 systemd[1]: Closed systemd-udevd-control.socket - udev Control Socket. Oct 8 19:48:55.864709 systemd[1]: systemd-udevd-kernel.socket: Deactivated successfully. Oct 8 19:48:55.864739 systemd[1]: Closed systemd-udevd-kernel.socket - udev Kernel Socket. Oct 8 19:48:55.866401 systemd[1]: dracut-pre-udev.service: Deactivated successfully. Oct 8 19:48:55.866446 systemd[1]: Stopped dracut-pre-udev.service - dracut pre-udev hook. Oct 8 19:48:55.868911 systemd[1]: dracut-cmdline.service: Deactivated successfully. Oct 8 19:48:55.868953 systemd[1]: Stopped dracut-cmdline.service - dracut cmdline hook. Oct 8 19:48:55.871541 systemd[1]: dracut-cmdline-ask.service: Deactivated successfully. Oct 8 19:48:55.871585 systemd[1]: Stopped dracut-cmdline-ask.service - dracut ask for additional cmdline parameters. Oct 8 19:48:55.884324 systemd[1]: Starting initrd-udevadm-cleanup-db.service - Cleanup udev Database... Oct 8 19:48:55.885307 systemd[1]: systemd-tmpfiles-setup-dev.service: Deactivated successfully. Oct 8 19:48:55.885358 systemd[1]: Stopped systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev. Oct 8 19:48:55.887329 systemd[1]: systemd-tmpfiles-setup-dev-early.service: Deactivated successfully. Oct 8 19:48:55.887373 systemd[1]: Stopped systemd-tmpfiles-setup-dev-early.service - Create Static Device Nodes in /dev gracefully. Oct 8 19:48:55.889205 systemd[1]: kmod-static-nodes.service: Deactivated successfully. Oct 8 19:48:55.889260 systemd[1]: Stopped kmod-static-nodes.service - Create List of Static Device Nodes. Oct 8 19:48:55.891253 systemd[1]: systemd-vconsole-setup.service: Deactivated successfully. Oct 8 19:48:55.891296 systemd[1]: Stopped systemd-vconsole-setup.service - Virtual Console Setup. Oct 8 19:48:55.893351 systemd[1]: initrd-udevadm-cleanup-db.service: Deactivated successfully. Oct 8 19:48:55.895174 systemd[1]: Finished initrd-udevadm-cleanup-db.service - Cleanup udev Database. Oct 8 19:48:55.897575 systemd[1]: Reached target initrd-switch-root.target - Switch Root. Oct 8 19:48:55.909354 systemd[1]: Starting initrd-switch-root.service - Switch Root... Oct 8 19:48:55.916109 systemd[1]: Switching root. Oct 8 19:48:55.944344 systemd-journald[237]: Journal stopped Oct 8 19:48:56.545961 systemd-journald[237]: Received SIGTERM from PID 1 (systemd). Oct 8 19:48:56.546013 kernel: SELinux: policy capability network_peer_controls=1 Oct 8 19:48:56.546025 kernel: SELinux: policy capability open_perms=1 Oct 8 19:48:56.546034 kernel: SELinux: policy capability extended_socket_class=1 Oct 8 19:48:56.546044 kernel: SELinux: policy capability always_check_network=0 Oct 8 19:48:56.546053 kernel: SELinux: policy capability cgroup_seclabel=1 Oct 8 19:48:56.546062 kernel: SELinux: policy capability nnp_nosuid_transition=1 Oct 8 19:48:56.546075 kernel: SELinux: policy capability genfs_seclabel_symlinks=0 Oct 8 19:48:56.546085 kernel: SELinux: policy capability ioctl_skip_cloexec=0 Oct 8 19:48:56.546094 kernel: audit: type=1403 audit(1728416936.006:2): auid=4294967295 ses=4294967295 lsm=selinux res=1 Oct 8 19:48:56.546108 systemd[1]: Successfully loaded SELinux policy in 30.519ms. Oct 8 19:48:56.546127 systemd[1]: Relabeled /dev, /dev/shm, /run, /sys/fs/cgroup in 9.943ms. Oct 8 19:48:56.546139 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) Oct 8 19:48:56.546284 systemd[1]: Detected virtualization kvm. Oct 8 19:48:56.546298 systemd[1]: Detected architecture arm64. Oct 8 19:48:56.546309 systemd[1]: Detected first boot. Oct 8 19:48:56.546319 systemd[1]: Initializing machine ID from VM UUID. Oct 8 19:48:56.546330 zram_generator::config[2035]: No configuration found. Oct 8 19:48:56.546343 systemd[1]: Populated /etc with preset unit settings. Oct 8 19:48:56.546354 systemd[1]: initrd-switch-root.service: Deactivated successfully. Oct 8 19:48:56.546367 systemd[1]: Stopped initrd-switch-root.service - Switch Root. Oct 8 19:48:56.546377 systemd[1]: systemd-journald.service: Scheduled restart job, restart counter is at 1. Oct 8 19:48:56.546388 systemd[1]: Created slice system-addon\x2dconfig.slice - Slice /system/addon-config. Oct 8 19:48:56.546399 systemd[1]: Created slice system-addon\x2drun.slice - Slice /system/addon-run. Oct 8 19:48:56.546409 systemd[1]: Created slice system-getty.slice - Slice /system/getty. Oct 8 19:48:56.546422 systemd[1]: Created slice system-modprobe.slice - Slice /system/modprobe. Oct 8 19:48:56.546434 systemd[1]: Created slice system-serial\x2dgetty.slice - Slice /system/serial-getty. Oct 8 19:48:56.546444 systemd[1]: Created slice system-system\x2dcloudinit.slice - Slice /system/system-cloudinit. Oct 8 19:48:56.546454 systemd[1]: Created slice system-systemd\x2dcryptsetup.slice - Encrypted Volume Units Service Slice. Oct 8 19:48:56.546465 systemd[1]: Created slice system-systemd\x2dfsck.slice - Slice /system/systemd-fsck. Oct 8 19:48:56.546475 systemd[1]: Created slice user.slice - User and Session Slice. Oct 8 19:48:56.546485 systemd[1]: Started clevis-luks-askpass.path - Forward Password Requests to Clevis Directory Watch. Oct 8 19:48:56.546495 systemd[1]: Started systemd-ask-password-console.path - Dispatch Password Requests to Console Directory Watch. Oct 8 19:48:56.546505 systemd[1]: Started systemd-ask-password-wall.path - Forward Password Requests to Wall Directory Watch. Oct 8 19:48:56.546516 systemd[1]: Set up automount boot.automount - Boot partition Automount Point. Oct 8 19:48:56.546528 systemd[1]: Set up automount proc-sys-fs-binfmt_misc.automount - Arbitrary Executable File Formats File System Automount Point. Oct 8 19:48:56.546538 systemd[1]: Expecting device dev-disk-by\x2dlabel-OEM.device - /dev/disk/by-label/OEM... Oct 8 19:48:56.546549 systemd[1]: Expecting device dev-disk-by\x2duuid-e76368d9\x2d280c\x2d4d35\x2d9cf5\x2d9509759dd5b0.device - /dev/disk/by-uuid/e76368d9-280c-4d35-9cf5-9509759dd5b0... Oct 8 19:48:56.546560 systemd[1]: Expecting device dev-ttyAMA0.device - /dev/ttyAMA0... Oct 8 19:48:56.546570 systemd[1]: Reached target cryptsetup-pre.target - Local Encrypted Volumes (Pre). Oct 8 19:48:56.546581 systemd[1]: Stopped target initrd-switch-root.target - Switch Root. Oct 8 19:48:56.546591 systemd[1]: Stopped target initrd-fs.target - Initrd File Systems. Oct 8 19:48:56.546603 systemd[1]: Stopped target initrd-root-fs.target - Initrd Root File System. Oct 8 19:48:56.546613 systemd[1]: Reached target integritysetup.target - Local Integrity Protected Volumes. Oct 8 19:48:56.546623 systemd[1]: Reached target remote-cryptsetup.target - Remote Encrypted Volumes. Oct 8 19:48:56.546634 systemd[1]: Reached target remote-fs.target - Remote File Systems. Oct 8 19:48:56.546645 systemd[1]: Reached target slices.target - Slice Units. Oct 8 19:48:56.546656 systemd[1]: Reached target swap.target - Swaps. Oct 8 19:48:56.546666 systemd[1]: Reached target veritysetup.target - Local Verity Protected Volumes. Oct 8 19:48:56.546676 systemd[1]: Listening on systemd-coredump.socket - Process Core Dump Socket. Oct 8 19:48:56.546687 systemd[1]: Listening on systemd-networkd.socket - Network Service Netlink Socket. Oct 8 19:48:56.546697 systemd[1]: Listening on systemd-udevd-control.socket - udev Control Socket. Oct 8 19:48:56.546709 systemd[1]: Listening on systemd-udevd-kernel.socket - udev Kernel Socket. Oct 8 19:48:56.546719 systemd[1]: Listening on systemd-userdbd.socket - User Database Manager Socket. Oct 8 19:48:56.546729 systemd[1]: Mounting dev-hugepages.mount - Huge Pages File System... Oct 8 19:48:56.546740 systemd[1]: Mounting dev-mqueue.mount - POSIX Message Queue File System... Oct 8 19:48:56.546750 systemd[1]: Mounting media.mount - External Media Directory... Oct 8 19:48:56.546760 systemd[1]: Mounting sys-kernel-debug.mount - Kernel Debug File System... Oct 8 19:48:56.546770 systemd[1]: Mounting sys-kernel-tracing.mount - Kernel Trace File System... Oct 8 19:48:56.546780 systemd[1]: Mounting tmp.mount - Temporary Directory /tmp... Oct 8 19:48:56.546791 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). Oct 8 19:48:56.546803 systemd[1]: Reached target machines.target - Containers. Oct 8 19:48:56.546813 systemd[1]: Starting flatcar-tmpfiles.service - Create missing system files... Oct 8 19:48:56.546824 systemd[1]: ignition-delete-config.service - Ignition (delete config) was skipped because no trigger condition checks were met. Oct 8 19:48:56.546834 systemd[1]: Starting kmod-static-nodes.service - Create List of Static Device Nodes... Oct 8 19:48:56.546845 systemd[1]: Starting modprobe@configfs.service - Load Kernel Module configfs... Oct 8 19:48:56.546855 systemd[1]: Starting modprobe@dm_mod.service - Load Kernel Module dm_mod... Oct 8 19:48:56.546866 systemd[1]: Starting modprobe@drm.service - Load Kernel Module drm... Oct 8 19:48:56.546876 systemd[1]: Starting modprobe@efi_pstore.service - Load Kernel Module efi_pstore... Oct 8 19:48:56.546888 systemd[1]: Starting modprobe@fuse.service - Load Kernel Module fuse... Oct 8 19:48:56.546899 systemd[1]: Starting modprobe@loop.service - Load Kernel Module loop... Oct 8 19:48:56.546909 systemd[1]: setup-nsswitch.service - Create /etc/nsswitch.conf was skipped because of an unmet condition check (ConditionPathExists=!/etc/nsswitch.conf). Oct 8 19:48:56.546920 systemd[1]: systemd-fsck-root.service: Deactivated successfully. Oct 8 19:48:56.546930 systemd[1]: Stopped systemd-fsck-root.service - File System Check on Root Device. Oct 8 19:48:56.546940 systemd[1]: systemd-fsck-usr.service: Deactivated successfully. Oct 8 19:48:56.546950 systemd[1]: Stopped systemd-fsck-usr.service. Oct 8 19:48:56.546960 kernel: fuse: init (API version 7.39) Oct 8 19:48:56.546971 systemd[1]: Starting systemd-journald.service - Journal Service... Oct 8 19:48:56.546981 kernel: loop: module loaded Oct 8 19:48:56.546991 systemd[1]: Starting systemd-modules-load.service - Load Kernel Modules... Oct 8 19:48:56.547002 systemd[1]: Starting systemd-network-generator.service - Generate network units from Kernel command line... Oct 8 19:48:56.547011 kernel: ACPI: bus type drm_connector registered Oct 8 19:48:56.547021 systemd[1]: Starting systemd-remount-fs.service - Remount Root and Kernel File Systems... Oct 8 19:48:56.547031 systemd[1]: Starting systemd-udev-trigger.service - Coldplug All udev Devices... Oct 8 19:48:56.547058 systemd-journald[2094]: Collecting audit messages is disabled. Oct 8 19:48:56.547082 systemd[1]: verity-setup.service: Deactivated successfully. Oct 8 19:48:56.547093 systemd[1]: Stopped verity-setup.service. Oct 8 19:48:56.547103 systemd-journald[2094]: Journal started Oct 8 19:48:56.547125 systemd-journald[2094]: Runtime Journal (/run/log/journal/e441de33a5d54a67a2279c2da78f43d2) is 5.9M, max 47.3M, 41.4M free. Oct 8 19:48:56.348740 systemd[1]: Queued start job for default target multi-user.target. Oct 8 19:48:56.364624 systemd[1]: Unnecessary job was removed for dev-vdb6.device - /dev/vdb6. Oct 8 19:48:56.364961 systemd[1]: systemd-journald.service: Deactivated successfully. Oct 8 19:48:56.550883 systemd[1]: Started systemd-journald.service - Journal Service. Oct 8 19:48:56.551501 systemd[1]: Mounted dev-hugepages.mount - Huge Pages File System. Oct 8 19:48:56.552661 systemd[1]: Mounted dev-mqueue.mount - POSIX Message Queue File System. Oct 8 19:48:56.553795 systemd[1]: Mounted media.mount - External Media Directory. Oct 8 19:48:56.555059 systemd[1]: Mounted sys-kernel-debug.mount - Kernel Debug File System. Oct 8 19:48:56.556334 systemd[1]: Mounted sys-kernel-tracing.mount - Kernel Trace File System. Oct 8 19:48:56.557528 systemd[1]: Mounted tmp.mount - Temporary Directory /tmp. Oct 8 19:48:56.559892 systemd[1]: Finished kmod-static-nodes.service - Create List of Static Device Nodes. Oct 8 19:48:56.561413 systemd[1]: Finished flatcar-tmpfiles.service - Create missing system files. Oct 8 19:48:56.562767 systemd[1]: modprobe@configfs.service: Deactivated successfully. Oct 8 19:48:56.562911 systemd[1]: Finished modprobe@configfs.service - Load Kernel Module configfs. Oct 8 19:48:56.564359 systemd[1]: modprobe@dm_mod.service: Deactivated successfully. Oct 8 19:48:56.564494 systemd[1]: Finished modprobe@dm_mod.service - Load Kernel Module dm_mod. Oct 8 19:48:56.565858 systemd[1]: modprobe@drm.service: Deactivated successfully. Oct 8 19:48:56.565993 systemd[1]: Finished modprobe@drm.service - Load Kernel Module drm. Oct 8 19:48:56.567299 systemd[1]: modprobe@efi_pstore.service: Deactivated successfully. Oct 8 19:48:56.567430 systemd[1]: Finished modprobe@efi_pstore.service - Load Kernel Module efi_pstore. Oct 8 19:48:56.568798 systemd[1]: modprobe@fuse.service: Deactivated successfully. Oct 8 19:48:56.568935 systemd[1]: Finished modprobe@fuse.service - Load Kernel Module fuse. Oct 8 19:48:56.570415 systemd[1]: modprobe@loop.service: Deactivated successfully. Oct 8 19:48:56.570545 systemd[1]: Finished modprobe@loop.service - Load Kernel Module loop. Oct 8 19:48:56.571809 systemd[1]: Finished systemd-modules-load.service - Load Kernel Modules. Oct 8 19:48:56.573137 systemd[1]: Finished systemd-network-generator.service - Generate network units from Kernel command line. Oct 8 19:48:56.574646 systemd[1]: Finished systemd-remount-fs.service - Remount Root and Kernel File Systems. Oct 8 19:48:56.586506 systemd[1]: Reached target network-pre.target - Preparation for Network. Oct 8 19:48:56.610257 systemd[1]: Mounting sys-fs-fuse-connections.mount - FUSE Control File System... Oct 8 19:48:56.612268 systemd[1]: Mounting sys-kernel-config.mount - Kernel Configuration File System... Oct 8 19:48:56.613325 systemd[1]: remount-root.service - Remount Root File System was skipped because of an unmet condition check (ConditionPathIsReadWrite=!/). Oct 8 19:48:56.613365 systemd[1]: Reached target local-fs.target - Local File Systems. Oct 8 19:48:56.615241 systemd[1]: Listening on systemd-sysext.socket - System Extension Image Management (Varlink). Oct 8 19:48:56.617325 systemd[1]: Starting dracut-shutdown.service - Restore /run/initramfs on shutdown... Oct 8 19:48:56.619312 systemd[1]: Starting ldconfig.service - Rebuild Dynamic Linker Cache... Oct 8 19:48:56.620366 systemd[1]: systemd-binfmt.service - Set Up Additional Binary Formats was skipped because no trigger condition checks were met. Oct 8 19:48:56.621857 systemd[1]: Starting systemd-hwdb-update.service - Rebuild Hardware Database... Oct 8 19:48:56.623880 systemd[1]: Starting systemd-journal-flush.service - Flush Journal to Persistent Storage... Oct 8 19:48:56.625134 systemd[1]: systemd-pstore.service - Platform Persistent Storage Archival was skipped because of an unmet condition check (ConditionDirectoryNotEmpty=/sys/fs/pstore). Oct 8 19:48:56.629314 systemd[1]: Starting systemd-random-seed.service - Load/Save OS Random Seed... Oct 8 19:48:56.630933 systemd[1]: systemd-repart.service - Repartition Root Disk was skipped because no trigger condition checks were met. Oct 8 19:48:56.631593 systemd-journald[2094]: Time spent on flushing to /var/log/journal/e441de33a5d54a67a2279c2da78f43d2 is 20.388ms for 880 entries. Oct 8 19:48:56.631593 systemd-journald[2094]: System Journal (/var/log/journal/e441de33a5d54a67a2279c2da78f43d2) is 8.0M, max 204.2M, 196.1M free. Oct 8 19:48:56.659559 systemd-journald[2094]: Received client request to flush runtime journal. Oct 8 19:48:56.659601 kernel: loop0: detected capacity change from 0 to 113672 Oct 8 19:48:56.659614 kernel: block loop0: the capability attribute has been deprecated. Oct 8 19:48:56.632390 systemd[1]: Starting systemd-sysctl.service - Apply Kernel Variables... Oct 8 19:48:56.634976 systemd[1]: Starting systemd-sysext.service - Merge System Extension Images into /usr/ and /opt/... Oct 8 19:48:56.640319 systemd[1]: Starting systemd-tmpfiles-setup-dev-early.service - Create Static Device Nodes in /dev gracefully... Oct 8 19:48:56.645755 systemd[1]: Finished systemd-udev-trigger.service - Coldplug All udev Devices. Oct 8 19:48:56.647987 systemd[1]: Mounted sys-fs-fuse-connections.mount - FUSE Control File System. Oct 8 19:48:56.650981 systemd[1]: Mounted sys-kernel-config.mount - Kernel Configuration File System. Oct 8 19:48:56.652669 systemd[1]: Finished dracut-shutdown.service - Restore /run/initramfs on shutdown. Oct 8 19:48:56.663315 systemd[1]: Starting systemd-udev-settle.service - Wait for udev To Complete Device Initialization... Oct 8 19:48:56.665276 systemd[1]: Finished systemd-journal-flush.service - Flush Journal to Persistent Storage. Oct 8 19:48:56.669439 kernel: squashfs: version 4.0 (2009/01/31) Phillip Lougher Oct 8 19:48:56.670266 systemd[1]: Finished systemd-random-seed.service - Load/Save OS Random Seed. Oct 8 19:48:56.671999 systemd[1]: Finished systemd-sysctl.service - Apply Kernel Variables. Oct 8 19:48:56.677290 systemd[1]: Reached target first-boot-complete.target - First Boot Complete. Oct 8 19:48:56.685488 systemd[1]: Starting systemd-machine-id-commit.service - Commit a transient machine-id on disk... Oct 8 19:48:56.687554 systemd-tmpfiles[2146]: ACLs are not supported, ignoring. Oct 8 19:48:56.687564 systemd-tmpfiles[2146]: ACLs are not supported, ignoring. Oct 8 19:48:56.688106 udevadm[2154]: systemd-udev-settle.service is deprecated. Please fix lvm2-activation.service, lvm2-activation-early.service not to pull it in. Oct 8 19:48:56.691185 kernel: loop1: detected capacity change from 0 to 59688 Oct 8 19:48:56.693199 systemd[1]: Finished systemd-tmpfiles-setup-dev-early.service - Create Static Device Nodes in /dev gracefully. Oct 8 19:48:56.696558 systemd[1]: Starting systemd-sysusers.service - Create System Users... Oct 8 19:48:56.707981 systemd[1]: etc-machine\x2did.mount: Deactivated successfully. Oct 8 19:48:56.711174 systemd[1]: Finished systemd-machine-id-commit.service - Commit a transient machine-id on disk. Oct 8 19:48:56.730056 systemd[1]: Finished systemd-sysusers.service - Create System Users. Oct 8 19:48:56.736161 kernel: loop2: detected capacity change from 0 to 113672 Oct 8 19:48:56.737381 systemd[1]: Starting systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev... Oct 8 19:48:56.740248 kernel: loop3: detected capacity change from 0 to 59688 Oct 8 19:48:56.743127 (sd-merge)[2170]: Using extensions 'containerd-flatcar', 'docker-flatcar'. Oct 8 19:48:56.743712 (sd-merge)[2170]: Merged extensions into '/usr'. Oct 8 19:48:56.750236 systemd[1]: Finished systemd-sysext.service - Merge System Extension Images into /usr/ and /opt/. Oct 8 19:48:56.750641 systemd-tmpfiles[2169]: ACLs are not supported, ignoring. Oct 8 19:48:56.750652 systemd-tmpfiles[2169]: ACLs are not supported, ignoring. Oct 8 19:48:56.763752 systemd[1]: Starting ensure-sysext.service... Oct 8 19:48:56.768326 systemd[1]: Starting systemd-tmpfiles-setup.service - Create Volatile Files and Directories... Oct 8 19:48:56.770521 systemd[1]: Finished systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev. Oct 8 19:48:56.790996 systemd[1]: Reloading requested from client PID 2174 ('systemctl') (unit ensure-sysext.service)... Oct 8 19:48:56.791901 systemd[1]: Reloading... Oct 8 19:48:56.795040 systemd-tmpfiles[2175]: /usr/lib/tmpfiles.d/provision.conf:20: Duplicate line for path "/root", ignoring. Oct 8 19:48:56.795311 systemd-tmpfiles[2175]: /usr/lib/tmpfiles.d/systemd-flatcar.conf:6: Duplicate line for path "/var/log/journal", ignoring. Oct 8 19:48:56.795909 systemd-tmpfiles[2175]: /usr/lib/tmpfiles.d/systemd.conf:29: Duplicate line for path "/var/lib/systemd", ignoring. Oct 8 19:48:56.796703 systemd-tmpfiles[2175]: ACLs are not supported, ignoring. Oct 8 19:48:56.796786 systemd-tmpfiles[2175]: ACLs are not supported, ignoring. Oct 8 19:48:56.799161 systemd-tmpfiles[2175]: Detected autofs mount point /boot during canonicalization of boot. Oct 8 19:48:56.799171 systemd-tmpfiles[2175]: Skipping /boot Oct 8 19:48:56.805547 systemd-tmpfiles[2175]: Detected autofs mount point /boot during canonicalization of boot. Oct 8 19:48:56.805560 systemd-tmpfiles[2175]: Skipping /boot Oct 8 19:48:56.845171 zram_generator::config[2202]: No configuration found. Oct 8 19:48:56.913822 ldconfig[2140]: /sbin/ldconfig: /lib/ld.so.conf is not an ELF file - it has the wrong magic bytes at the start. Oct 8 19:48:56.940917 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. Oct 8 19:48:56.982957 systemd[1]: Reloading finished in 189 ms. Oct 8 19:48:57.022249 systemd[1]: Finished ldconfig.service - Rebuild Dynamic Linker Cache. Oct 8 19:48:57.024403 systemd[1]: Finished systemd-tmpfiles-setup.service - Create Volatile Files and Directories. Oct 8 19:48:57.030926 systemd[1]: Starting audit-rules.service - Load Security Auditing Rules... Oct 8 19:48:57.033492 systemd[1]: Starting clean-ca-certificates.service - Clean up broken links in /etc/ssl/certs... Oct 8 19:48:57.037340 systemd[1]: Starting systemd-journal-catalog-update.service - Rebuild Journal Catalog... Oct 8 19:48:57.044332 systemd[1]: Starting systemd-resolved.service - Network Name Resolution... Oct 8 19:48:57.047033 systemd[1]: Starting systemd-update-utmp.service - Record System Boot/Shutdown in UTMP... Oct 8 19:48:57.056862 systemd[1]: ignition-delete-config.service - Ignition (delete config) was skipped because no trigger condition checks were met. Oct 8 19:48:57.058341 systemd[1]: Starting modprobe@dm_mod.service - Load Kernel Module dm_mod... Oct 8 19:48:57.062976 systemd[1]: Starting modprobe@efi_pstore.service - Load Kernel Module efi_pstore... Oct 8 19:48:57.065035 systemd[1]: Starting modprobe@loop.service - Load Kernel Module loop... Oct 8 19:48:57.066112 systemd[1]: systemd-binfmt.service - Set Up Additional Binary Formats was skipped because no trigger condition checks were met. Oct 8 19:48:57.066882 systemd[1]: modprobe@dm_mod.service: Deactivated successfully. Oct 8 19:48:57.067011 systemd[1]: Finished modprobe@dm_mod.service - Load Kernel Module dm_mod. Oct 8 19:48:57.068531 systemd[1]: modprobe@efi_pstore.service: Deactivated successfully. Oct 8 19:48:57.068657 systemd[1]: Finished modprobe@efi_pstore.service - Load Kernel Module efi_pstore. Oct 8 19:48:57.070254 systemd[1]: modprobe@loop.service: Deactivated successfully. Oct 8 19:48:57.070364 systemd[1]: Finished modprobe@loop.service - Load Kernel Module loop. Oct 8 19:48:57.078268 systemd[1]: Finished systemd-journal-catalog-update.service - Rebuild Journal Catalog. Oct 8 19:48:57.083320 systemd[1]: ignition-delete-config.service - Ignition (delete config) was skipped because no trigger condition checks were met. Oct 8 19:48:57.090841 systemd[1]: Starting modprobe@dm_mod.service - Load Kernel Module dm_mod... Oct 8 19:48:57.093411 systemd[1]: Starting modprobe@efi_pstore.service - Load Kernel Module efi_pstore... Oct 8 19:48:57.098486 systemd[1]: Starting modprobe@loop.service - Load Kernel Module loop... Oct 8 19:48:57.099621 systemd[1]: systemd-binfmt.service - Set Up Additional Binary Formats was skipped because no trigger condition checks were met. Oct 8 19:48:57.102408 systemd[1]: Starting systemd-userdbd.service - User Database Manager... Oct 8 19:48:57.104429 systemd[1]: Finished systemd-update-utmp.service - Record System Boot/Shutdown in UTMP. Oct 8 19:48:57.106334 systemd[1]: Finished clean-ca-certificates.service - Clean up broken links in /etc/ssl/certs. Oct 8 19:48:57.108217 systemd[1]: modprobe@dm_mod.service: Deactivated successfully. Oct 8 19:48:57.108375 systemd[1]: Finished modprobe@dm_mod.service - Load Kernel Module dm_mod. Oct 8 19:48:57.109944 systemd[1]: modprobe@efi_pstore.service: Deactivated successfully. Oct 8 19:48:57.110064 systemd[1]: Finished modprobe@efi_pstore.service - Load Kernel Module efi_pstore. Oct 8 19:48:57.111788 systemd[1]: modprobe@loop.service: Deactivated successfully. Oct 8 19:48:57.111903 systemd[1]: Finished modprobe@loop.service - Load Kernel Module loop. Oct 8 19:48:57.113332 augenrules[2269]: No rules Oct 8 19:48:57.114544 systemd[1]: Finished audit-rules.service - Load Security Auditing Rules. Oct 8 19:48:57.118721 systemd[1]: Finished systemd-hwdb-update.service - Rebuild Hardware Database. Oct 8 19:48:57.124304 systemd[1]: ignition-delete-config.service - Ignition (delete config) was skipped because no trigger condition checks were met. Oct 8 19:48:57.138373 systemd[1]: Starting modprobe@dm_mod.service - Load Kernel Module dm_mod... Oct 8 19:48:57.140375 systemd[1]: Starting modprobe@drm.service - Load Kernel Module drm... Oct 8 19:48:57.142528 systemd[1]: Starting modprobe@efi_pstore.service - Load Kernel Module efi_pstore... Oct 8 19:48:57.147458 systemd[1]: Starting modprobe@loop.service - Load Kernel Module loop... Oct 8 19:48:57.149260 systemd[1]: systemd-binfmt.service - Set Up Additional Binary Formats was skipped because no trigger condition checks were met. Oct 8 19:48:57.150715 systemd[1]: Starting systemd-udevd.service - Rule-based Manager for Device Events and Files... Oct 8 19:48:57.152863 systemd[1]: Starting systemd-update-done.service - Update is Completed... Oct 8 19:48:57.154077 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). Oct 8 19:48:57.154995 systemd[1]: Started systemd-userdbd.service - User Database Manager. Oct 8 19:48:57.156696 systemd[1]: modprobe@dm_mod.service: Deactivated successfully. Oct 8 19:48:57.158179 systemd[1]: Finished modprobe@dm_mod.service - Load Kernel Module dm_mod. Oct 8 19:48:57.159722 systemd[1]: modprobe@drm.service: Deactivated successfully. Oct 8 19:48:57.159839 systemd[1]: Finished modprobe@drm.service - Load Kernel Module drm. Oct 8 19:48:57.161295 systemd[1]: modprobe@efi_pstore.service: Deactivated successfully. Oct 8 19:48:57.161407 systemd[1]: Finished modprobe@efi_pstore.service - Load Kernel Module efi_pstore. Oct 8 19:48:57.163035 systemd[1]: modprobe@loop.service: Deactivated successfully. Oct 8 19:48:57.163157 systemd[1]: Finished modprobe@loop.service - Load Kernel Module loop. Oct 8 19:48:57.166107 systemd[1]: Finished ensure-sysext.service. Oct 8 19:48:57.167620 systemd[1]: Finished systemd-update-done.service - Update is Completed. Oct 8 19:48:57.171871 systemd[1]: systemd-pstore.service - Platform Persistent Storage Archival was skipped because of an unmet condition check (ConditionDirectoryNotEmpty=/sys/fs/pstore). Oct 8 19:48:57.171984 systemd[1]: systemd-repart.service - Repartition Root Disk was skipped because no trigger condition checks were met. Oct 8 19:48:57.181296 systemd[1]: Starting systemd-timesyncd.service - Network Time Synchronization... Oct 8 19:48:57.184461 systemd-udevd[2289]: Using default interface naming scheme 'v255'. Oct 8 19:48:57.201410 systemd-resolved[2248]: Positive Trust Anchors: Oct 8 19:48:57.201427 systemd-resolved[2248]: . IN DS 20326 8 2 e06d44b80b8f1d39a95c0b0d7c65d08458e880409bbc683457104237c7f8ec8d Oct 8 19:48:57.201457 systemd-resolved[2248]: 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 Oct 8 19:48:57.206856 systemd-resolved[2248]: Defaulting to hostname 'linux'. Oct 8 19:48:57.208363 systemd[1]: Started systemd-resolved.service - Network Name Resolution. Oct 8 19:48:57.209579 systemd[1]: Started systemd-udevd.service - Rule-based Manager for Device Events and Files. Oct 8 19:48:57.211138 systemd[1]: Reached target nss-lookup.target - Host and Network Name Lookups. Oct 8 19:48:57.222358 systemd[1]: Starting systemd-networkd.service - Network Configuration... Oct 8 19:48:57.223423 systemd[1]: Started systemd-timesyncd.service - Network Time Synchronization. Oct 8 19:48:57.229849 systemd[1]: Reached target time-set.target - System Time Set. Oct 8 19:48:57.237944 systemd[1]: Condition check resulted in dev-ttyAMA0.device - /dev/ttyAMA0 being skipped. Oct 8 19:48:57.241163 kernel: BTRFS info: devid 1 device path /dev/mapper/usr changed to /dev/dm-0 scanned by (udev-worker) (2310) Oct 8 19:48:57.263137 systemd[1]: Condition check resulted in dev-disk-by\x2duuid-e76368d9\x2d280c\x2d4d35\x2d9cf5\x2d9509759dd5b0.device - /dev/disk/by-uuid/e76368d9-280c-4d35-9cf5-9509759dd5b0 being skipped. Oct 8 19:48:57.264337 kernel: BTRFS warning: duplicate device /dev/vdb3 devid 1 generation 36 scanned by (udev-worker) (2301) Oct 8 19:48:57.274737 systemd[1]: Starting systemd-cryptsetup@rootencrypted.service - Cryptography Setup for rootencrypted... Oct 8 19:48:57.293177 systemd[1]: Found device dev-disk-by\x2dlabel-OEM.device - /dev/disk/by-label/OEM. Oct 8 19:48:57.297028 systemd-cryptsetup[2321]: Volume rootencrypted already active. Oct 8 19:48:57.300537 systemd[1]: Finished systemd-cryptsetup@rootencrypted.service - Cryptography Setup for rootencrypted. Oct 8 19:48:57.303339 systemd-networkd[2307]: lo: Link UP Oct 8 19:48:57.303345 systemd-networkd[2307]: lo: Gained carrier Oct 8 19:48:57.303961 systemd[1]: Reached target blockdev@dev-mapper-rootencrypted.target - Block Device Preparation for /dev/mapper/rootencrypted. Oct 8 19:48:57.303967 systemd-networkd[2307]: Enumeration completed Oct 8 19:48:57.304469 systemd-networkd[2307]: eth0: found matching network '/usr/lib/systemd/network/zz-default.network', based on potentially unpredictable interface name. Oct 8 19:48:57.304477 systemd-networkd[2307]: eth0: Configuring with /usr/lib/systemd/network/zz-default.network. Oct 8 19:48:57.308580 systemd-networkd[2307]: eth0: Link UP Oct 8 19:48:57.308668 systemd-networkd[2307]: eth0: Gained carrier Oct 8 19:48:57.308722 systemd-networkd[2307]: eth0: found matching network '/usr/lib/systemd/network/zz-default.network', based on potentially unpredictable interface name. Oct 8 19:48:57.312308 systemd[1]: Starting systemd-fsck@dev-disk-by\x2dlabel-OEM.service - File System Check on /dev/disk/by-label/OEM... Oct 8 19:48:57.313530 systemd[1]: Started systemd-networkd.service - Network Configuration. Oct 8 19:48:57.315671 systemd[1]: Reached target network.target - Network. Oct 8 19:48:57.315744 systemd-networkd[2307]: eth0: found matching network '/usr/lib/systemd/network/zz-default.network', based on potentially unpredictable interface name. Oct 8 19:48:57.320317 systemd[1]: Starting systemd-networkd-wait-online.service - Wait for Network to be Configured... Oct 8 19:48:57.327164 systemd-networkd[2307]: eth0: DHCPv4 address 10.0.0.104/16, gateway 10.0.0.1 acquired from 10.0.0.1 Oct 8 19:48:57.328593 systemd-timesyncd[2298]: Network configuration changed, trying to establish connection. Oct 8 19:48:57.329221 systemd-timesyncd[2298]: Contacted time server 10.0.0.1:123 (10.0.0.1). Oct 8 19:48:57.329291 systemd-timesyncd[2298]: Initial clock synchronization to Tue 2024-10-08 19:48:57.327390 UTC. Oct 8 19:48:57.337200 systemd[1]: Finished systemd-fsck@dev-disk-by\x2dlabel-OEM.service - File System Check on /dev/disk/by-label/OEM. Oct 8 19:48:57.353360 systemd[1]: Starting systemd-vconsole-setup.service - Virtual Console Setup... Oct 8 19:48:57.363573 systemd[1]: Finished systemd-udev-settle.service - Wait for udev To Complete Device Initialization. Oct 8 19:48:57.367769 systemd[1]: Starting lvm2-activation-early.service - Activation of LVM2 logical volumes... Oct 8 19:48:57.387195 lvm[2339]: WARNING: Failed to connect to lvmetad. Falling back to device scanning. Oct 8 19:48:57.393319 systemd[1]: Finished systemd-vconsole-setup.service - Virtual Console Setup. Oct 8 19:48:57.420940 systemd[1]: Finished lvm2-activation-early.service - Activation of LVM2 logical volumes. Oct 8 19:48:57.422521 systemd[1]: Reached target cryptsetup.target - Local Encrypted Volumes. Oct 8 19:48:57.423697 systemd[1]: Reached target sysinit.target - System Initialization. Oct 8 19:48:57.424941 systemd[1]: Started motdgen.path - Watch for update engine configuration changes. Oct 8 19:48:57.426240 systemd[1]: Started user-cloudinit@var-lib-flatcar\x2dinstall-user_data.path - Watch for a cloud-config at /var/lib/flatcar-install/user_data. Oct 8 19:48:57.427688 systemd[1]: Started logrotate.timer - Daily rotation of log files. Oct 8 19:48:57.428879 systemd[1]: Started mdadm.timer - Weekly check for MD array's redundancy information.. Oct 8 19:48:57.430195 systemd[1]: Started systemd-tmpfiles-clean.timer - Daily Cleanup of Temporary Directories. Oct 8 19:48:57.431563 systemd[1]: update-engine-stub.timer - Update Engine Stub Timer was skipped because of an unmet condition check (ConditionPathExists=/usr/.noupdate). Oct 8 19:48:57.431595 systemd[1]: Reached target paths.target - Path Units. Oct 8 19:48:57.432665 systemd[1]: Reached target timers.target - Timer Units. Oct 8 19:48:57.438947 systemd[1]: Listening on dbus.socket - D-Bus System Message Bus Socket. Oct 8 19:48:57.441603 systemd[1]: Starting docker.socket - Docker Socket for the API... Oct 8 19:48:57.452102 systemd[1]: Listening on sshd.socket - OpenSSH Server Socket. Oct 8 19:48:57.454318 systemd[1]: Starting lvm2-activation.service - Activation of LVM2 logical volumes... Oct 8 19:48:57.455920 systemd[1]: Listening on docker.socket - Docker Socket for the API. Oct 8 19:48:57.457111 systemd[1]: Reached target sockets.target - Socket Units. Oct 8 19:48:57.458063 systemd[1]: Reached target basic.target - Basic System. Oct 8 19:48:57.459100 systemd[1]: addon-config@oem.service - Configure Addon /oem was skipped because no trigger condition checks were met. Oct 8 19:48:57.459131 systemd[1]: addon-run@oem.service - Run Addon /oem was skipped because no trigger condition checks were met. Oct 8 19:48:57.460035 systemd[1]: Starting containerd.service - containerd container runtime... Oct 8 19:48:57.461130 systemd[1]: cryptenroll-helper-bind.service was skipped because of an unmet condition check (ConditionPathExists=/etc/luks/rootencrypted-bind). Oct 8 19:48:57.461965 lvm[2346]: WARNING: Failed to connect to lvmetad. Falling back to device scanning. Oct 8 19:48:57.463357 systemd[1]: Starting dbus.service - D-Bus System Message Bus... Oct 8 19:48:57.465609 systemd[1]: Starting enable-oem-cloudinit.service - Enable cloudinit... Oct 8 19:48:57.469994 systemd[1]: Starting extend-filesystems.service - Extend Filesystems... Oct 8 19:48:57.471065 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). Oct 8 19:48:57.473879 systemd[1]: Starting motdgen.service - Generate /run/flatcar/motd... Oct 8 19:48:57.475331 jq[2349]: false Oct 8 19:48:57.480637 systemd[1]: Starting ssh-key-proc-cmdline.service - Install an ssh key from /proc/cmdline... Oct 8 19:48:57.485351 systemd[1]: Starting sshd-keygen.service - Generate sshd host keys... Oct 8 19:48:57.488255 extend-filesystems[2350]: Found loop2 Oct 8 19:48:57.492019 extend-filesystems[2350]: Found loop3 Oct 8 19:48:57.492019 extend-filesystems[2350]: Found vda Oct 8 19:48:57.492019 extend-filesystems[2350]: Found vdb Oct 8 19:48:57.492019 extend-filesystems[2350]: Found vdb1 Oct 8 19:48:57.492019 extend-filesystems[2350]: Found vdb2 Oct 8 19:48:57.492019 extend-filesystems[2350]: Found vdb3 Oct 8 19:48:57.492019 extend-filesystems[2350]: Found usr Oct 8 19:48:57.492019 extend-filesystems[2350]: Found vdb4 Oct 8 19:48:57.492019 extend-filesystems[2350]: Found vdb6 Oct 8 19:48:57.492019 extend-filesystems[2350]: Found vdb7 Oct 8 19:48:57.492019 extend-filesystems[2350]: Found vdb9 Oct 8 19:48:57.492019 extend-filesystems[2350]: Found rootencrypted Oct 8 19:48:57.495821 dbus-daemon[2348]: [system] SELinux support is enabled Oct 8 19:48:57.493459 systemd[1]: Starting systemd-logind.service - User Login Management... Oct 8 19:48:57.501279 systemd[1]: tcsd.service - TCG Core Services Daemon was skipped because of an unmet condition check (ConditionSecurity=!tpm2). Oct 8 19:48:57.501795 systemd[1]: cgroup compatibility translation between legacy and unified hierarchy settings activated. See cgroup-compat debug messages for details. Oct 8 19:48:57.502451 systemd[1]: Starting update-engine.service - Update Engine... Oct 8 19:48:57.506703 systemd[1]: Starting update-ssh-keys-after-ignition.service - Run update-ssh-keys once after Ignition... Oct 8 19:48:57.508440 systemd[1]: Started dbus.service - D-Bus System Message Bus. Oct 8 19:48:57.514148 jq[2365]: true Oct 8 19:48:57.513186 systemd[1]: Finished lvm2-activation.service - Activation of LVM2 logical volumes. Oct 8 19:48:57.515496 systemd[1]: enable-oem-cloudinit.service: Skipped due to 'exec-condition'. Oct 8 19:48:57.517269 systemd[1]: Condition check resulted in enable-oem-cloudinit.service - Enable cloudinit being skipped. Oct 8 19:48:57.517569 systemd[1]: extend-filesystems.service: Deactivated successfully. Oct 8 19:48:57.517715 systemd[1]: Finished extend-filesystems.service - Extend Filesystems. Oct 8 19:48:57.519204 systemd[1]: motdgen.service: Deactivated successfully. Oct 8 19:48:57.519372 systemd[1]: Finished motdgen.service - Generate /run/flatcar/motd. Oct 8 19:48:57.521603 systemd[1]: ssh-key-proc-cmdline.service: Deactivated successfully. Oct 8 19:48:57.521762 systemd[1]: Finished ssh-key-proc-cmdline.service - Install an ssh key from /proc/cmdline. Oct 8 19:48:57.550102 (ntainerd)[2368]: containerd.service: Referenced but unset environment variable evaluates to an empty string: TORCX_IMAGEDIR, TORCX_UNPACKDIR Oct 8 19:48:57.551174 jq[2367]: true Oct 8 19:48:57.555876 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). Oct 8 19:48:57.555991 systemd[1]: Reached target system-config.target - Load system-provided cloud configs. Oct 8 19:48:57.557467 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). Oct 8 19:48:57.557506 systemd[1]: Reached target user-config.target - Load user-provided cloud configs. Oct 8 19:48:57.560677 systemd-logind[2360]: Watching system buttons on /dev/input/event0 (Power Button) Oct 8 19:48:57.564448 systemd-logind[2360]: New seat seat0. Oct 8 19:48:57.574216 systemd[1]: Started systemd-logind.service - User Login Management. Oct 8 19:48:57.602258 update_engine[2364]: I1008 19:48:57.601823 2364 main.cc:92] Flatcar Update Engine starting Oct 8 19:48:57.610636 update_engine[2364]: I1008 19:48:57.610601 2364 update_check_scheduler.cc:74] Next update check in 4m12s Oct 8 19:48:57.611963 systemd[1]: Started update-engine.service - Update Engine. Oct 8 19:48:57.621451 systemd[1]: Started locksmithd.service - Cluster reboot manager. Oct 8 19:48:57.642593 bash[2392]: Updated "/home/core/.ssh/authorized_keys" Oct 8 19:48:57.643633 systemd[1]: Finished update-ssh-keys-after-ignition.service - Run update-ssh-keys once after Ignition. Oct 8 19:48:57.648512 systemd[1]: sshkeys.service was skipped because no trigger condition checks were met. Oct 8 19:48:57.655335 locksmithd[2393]: locksmithd starting currentOperation="UPDATE_STATUS_IDLE" strategy="reboot" Oct 8 19:48:57.752996 containerd[2368]: time="2024-10-08T19:48:57.752870320Z" level=info msg="starting containerd" revision=1fbfc07f8d28210e62bdbcbf7b950bac8028afbf version=v1.7.17 Oct 8 19:48:57.787925 containerd[2368]: time="2024-10-08T19:48:57.787889760Z" level=info msg="loading plugin \"io.containerd.warning.v1.deprecations\"..." type=io.containerd.warning.v1 Oct 8 19:48:57.787984 containerd[2368]: time="2024-10-08T19:48:57.787930520Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.aufs\"..." type=io.containerd.snapshotter.v1 Oct 8 19:48:57.792245 containerd[2368]: time="2024-10-08T19:48:57.792208360Z" 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.54-flatcar\\n\"): skip plugin" type=io.containerd.snapshotter.v1 Oct 8 19:48:57.792272 containerd[2368]: time="2024-10-08T19:48:57.792244600Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.btrfs\"..." type=io.containerd.snapshotter.v1 Oct 8 19:48:57.792467 containerd[2368]: time="2024-10-08T19:48:57.792444600Z" 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 Oct 8 19:48:57.792505 containerd[2368]: time="2024-10-08T19:48:57.792465400Z" level=info msg="loading plugin \"io.containerd.content.v1.content\"..." type=io.containerd.content.v1 Oct 8 19:48:57.792555 containerd[2368]: time="2024-10-08T19:48:57.792539000Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.blockfile\"..." type=io.containerd.snapshotter.v1 Oct 8 19:48:57.792601 containerd[2368]: time="2024-10-08T19:48:57.792586080Z" level=info msg="skip loading plugin \"io.containerd.snapshotter.v1.blockfile\"..." error="no scratch file generator: skip plugin" type=io.containerd.snapshotter.v1 Oct 8 19:48:57.792626 containerd[2368]: time="2024-10-08T19:48:57.792600680Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.native\"..." type=io.containerd.snapshotter.v1 Oct 8 19:48:57.792673 containerd[2368]: time="2024-10-08T19:48:57.792658120Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.overlayfs\"..." type=io.containerd.snapshotter.v1 Oct 8 19:48:57.792850 containerd[2368]: time="2024-10-08T19:48:57.792832760Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.devmapper\"..." type=io.containerd.snapshotter.v1 Oct 8 19:48:57.792876 containerd[2368]: time="2024-10-08T19:48:57.792853960Z" level=warning msg="failed to load plugin io.containerd.snapshotter.v1.devmapper" error="devmapper not configured" Oct 8 19:48:57.792876 containerd[2368]: time="2024-10-08T19:48:57.792864880Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.zfs\"..." type=io.containerd.snapshotter.v1 Oct 8 19:48:57.792970 containerd[2368]: time="2024-10-08T19:48:57.792951560Z" 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 Oct 8 19:48:57.792970 containerd[2368]: time="2024-10-08T19:48:57.792967600Z" level=info msg="loading plugin \"io.containerd.metadata.v1.bolt\"..." type=io.containerd.metadata.v1 Oct 8 19:48:57.793031 containerd[2368]: time="2024-10-08T19:48:57.793015480Z" level=warning msg="could not use snapshotter devmapper in metadata plugin" error="devmapper not configured" Oct 8 19:48:57.793031 containerd[2368]: time="2024-10-08T19:48:57.793029240Z" level=info msg="metadata content store policy set" policy=shared Oct 8 19:48:57.800567 containerd[2368]: time="2024-10-08T19:48:57.800541800Z" level=info msg="loading plugin \"io.containerd.differ.v1.walking\"..." type=io.containerd.differ.v1 Oct 8 19:48:57.800605 containerd[2368]: time="2024-10-08T19:48:57.800574360Z" level=info msg="loading plugin \"io.containerd.event.v1.exchange\"..." type=io.containerd.event.v1 Oct 8 19:48:57.800605 containerd[2368]: time="2024-10-08T19:48:57.800587960Z" level=info msg="loading plugin \"io.containerd.gc.v1.scheduler\"..." type=io.containerd.gc.v1 Oct 8 19:48:57.800654 containerd[2368]: time="2024-10-08T19:48:57.800621200Z" level=info msg="loading plugin \"io.containerd.lease.v1.manager\"..." type=io.containerd.lease.v1 Oct 8 19:48:57.800654 containerd[2368]: time="2024-10-08T19:48:57.800640640Z" level=info msg="loading plugin \"io.containerd.nri.v1.nri\"..." type=io.containerd.nri.v1 Oct 8 19:48:57.800654 containerd[2368]: time="2024-10-08T19:48:57.800651200Z" level=info msg="NRI interface is disabled by configuration." Oct 8 19:48:57.801686 containerd[2368]: time="2024-10-08T19:48:57.800663640Z" level=info msg="loading plugin \"io.containerd.runtime.v2.task\"..." type=io.containerd.runtime.v2 Oct 8 19:48:57.801686 containerd[2368]: time="2024-10-08T19:48:57.800847160Z" level=info msg="loading plugin \"io.containerd.runtime.v2.shim\"..." type=io.containerd.runtime.v2 Oct 8 19:48:57.801686 containerd[2368]: time="2024-10-08T19:48:57.800864840Z" level=info msg="loading plugin \"io.containerd.sandbox.store.v1.local\"..." type=io.containerd.sandbox.store.v1 Oct 8 19:48:57.801686 containerd[2368]: time="2024-10-08T19:48:57.800877120Z" level=info msg="loading plugin \"io.containerd.sandbox.controller.v1.local\"..." type=io.containerd.sandbox.controller.v1 Oct 8 19:48:57.801686 containerd[2368]: time="2024-10-08T19:48:57.800889280Z" level=info msg="loading plugin \"io.containerd.streaming.v1.manager\"..." type=io.containerd.streaming.v1 Oct 8 19:48:57.801686 containerd[2368]: time="2024-10-08T19:48:57.800905400Z" level=info msg="loading plugin \"io.containerd.service.v1.introspection-service\"..." type=io.containerd.service.v1 Oct 8 19:48:57.801686 containerd[2368]: time="2024-10-08T19:48:57.800920560Z" level=info msg="loading plugin \"io.containerd.service.v1.containers-service\"..." type=io.containerd.service.v1 Oct 8 19:48:57.801686 containerd[2368]: time="2024-10-08T19:48:57.800933640Z" level=info msg="loading plugin \"io.containerd.service.v1.content-service\"..." type=io.containerd.service.v1 Oct 8 19:48:57.801686 containerd[2368]: time="2024-10-08T19:48:57.800945440Z" level=info msg="loading plugin \"io.containerd.service.v1.diff-service\"..." type=io.containerd.service.v1 Oct 8 19:48:57.801686 containerd[2368]: time="2024-10-08T19:48:57.800958920Z" level=info msg="loading plugin \"io.containerd.service.v1.images-service\"..." type=io.containerd.service.v1 Oct 8 19:48:57.801686 containerd[2368]: time="2024-10-08T19:48:57.800971880Z" level=info msg="loading plugin \"io.containerd.service.v1.namespaces-service\"..." type=io.containerd.service.v1 Oct 8 19:48:57.801686 containerd[2368]: time="2024-10-08T19:48:57.800983360Z" level=info msg="loading plugin \"io.containerd.service.v1.snapshots-service\"..." type=io.containerd.service.v1 Oct 8 19:48:57.801686 containerd[2368]: time="2024-10-08T19:48:57.800994840Z" level=info msg="loading plugin \"io.containerd.runtime.v1.linux\"..." type=io.containerd.runtime.v1 Oct 8 19:48:57.801686 containerd[2368]: time="2024-10-08T19:48:57.801081200Z" level=info msg="loading plugin \"io.containerd.monitor.v1.cgroups\"..." type=io.containerd.monitor.v1 Oct 8 19:48:57.801973 containerd[2368]: time="2024-10-08T19:48:57.801415160Z" level=info msg="loading plugin \"io.containerd.service.v1.tasks-service\"..." type=io.containerd.service.v1 Oct 8 19:48:57.801973 containerd[2368]: time="2024-10-08T19:48:57.801452960Z" level=info msg="loading plugin \"io.containerd.grpc.v1.introspection\"..." type=io.containerd.grpc.v1 Oct 8 19:48:57.801973 containerd[2368]: time="2024-10-08T19:48:57.801467120Z" level=info msg="loading plugin \"io.containerd.transfer.v1.local\"..." type=io.containerd.transfer.v1 Oct 8 19:48:57.801973 containerd[2368]: time="2024-10-08T19:48:57.801491480Z" level=info msg="loading plugin \"io.containerd.internal.v1.restart\"..." type=io.containerd.internal.v1 Oct 8 19:48:57.801973 containerd[2368]: time="2024-10-08T19:48:57.801605120Z" level=info msg="loading plugin \"io.containerd.grpc.v1.containers\"..." type=io.containerd.grpc.v1 Oct 8 19:48:57.801973 containerd[2368]: time="2024-10-08T19:48:57.801617920Z" level=info msg="loading plugin \"io.containerd.grpc.v1.content\"..." type=io.containerd.grpc.v1 Oct 8 19:48:57.801973 containerd[2368]: time="2024-10-08T19:48:57.801629000Z" level=info msg="loading plugin \"io.containerd.grpc.v1.diff\"..." type=io.containerd.grpc.v1 Oct 8 19:48:57.801973 containerd[2368]: time="2024-10-08T19:48:57.801639600Z" level=info msg="loading plugin \"io.containerd.grpc.v1.events\"..." type=io.containerd.grpc.v1 Oct 8 19:48:57.801973 containerd[2368]: time="2024-10-08T19:48:57.801651680Z" level=info msg="loading plugin \"io.containerd.grpc.v1.healthcheck\"..." type=io.containerd.grpc.v1 Oct 8 19:48:57.801973 containerd[2368]: time="2024-10-08T19:48:57.801726000Z" level=info msg="loading plugin \"io.containerd.grpc.v1.images\"..." type=io.containerd.grpc.v1 Oct 8 19:48:57.801973 containerd[2368]: time="2024-10-08T19:48:57.801740440Z" level=info msg="loading plugin \"io.containerd.grpc.v1.leases\"..." type=io.containerd.grpc.v1 Oct 8 19:48:57.801973 containerd[2368]: time="2024-10-08T19:48:57.801755760Z" level=info msg="loading plugin \"io.containerd.grpc.v1.namespaces\"..." type=io.containerd.grpc.v1 Oct 8 19:48:57.801973 containerd[2368]: time="2024-10-08T19:48:57.801769000Z" level=info msg="loading plugin \"io.containerd.internal.v1.opt\"..." type=io.containerd.internal.v1 Oct 8 19:48:57.801973 containerd[2368]: time="2024-10-08T19:48:57.801892600Z" level=info msg="loading plugin \"io.containerd.grpc.v1.sandbox-controllers\"..." type=io.containerd.grpc.v1 Oct 8 19:48:57.802214 containerd[2368]: time="2024-10-08T19:48:57.801915280Z" level=info msg="loading plugin \"io.containerd.grpc.v1.sandboxes\"..." type=io.containerd.grpc.v1 Oct 8 19:48:57.802214 containerd[2368]: time="2024-10-08T19:48:57.801928080Z" level=info msg="loading plugin \"io.containerd.grpc.v1.snapshots\"..." type=io.containerd.grpc.v1 Oct 8 19:48:57.802214 containerd[2368]: time="2024-10-08T19:48:57.801940640Z" level=info msg="loading plugin \"io.containerd.grpc.v1.streaming\"..." type=io.containerd.grpc.v1 Oct 8 19:48:57.802214 containerd[2368]: time="2024-10-08T19:48:57.801954120Z" level=info msg="loading plugin \"io.containerd.grpc.v1.tasks\"..." type=io.containerd.grpc.v1 Oct 8 19:48:57.802214 containerd[2368]: time="2024-10-08T19:48:57.801968160Z" level=info msg="loading plugin \"io.containerd.grpc.v1.transfer\"..." type=io.containerd.grpc.v1 Oct 8 19:48:57.802214 containerd[2368]: time="2024-10-08T19:48:57.801982000Z" level=info msg="loading plugin \"io.containerd.grpc.v1.version\"..." type=io.containerd.grpc.v1 Oct 8 19:48:57.802214 containerd[2368]: time="2024-10-08T19:48:57.801992560Z" level=info msg="loading plugin \"io.containerd.grpc.v1.cri\"..." type=io.containerd.grpc.v1 Oct 8 19:48:57.803132 containerd[2368]: time="2024-10-08T19:48:57.802425680Z" 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}" Oct 8 19:48:57.803132 containerd[2368]: time="2024-10-08T19:48:57.802496280Z" level=info msg="Connect containerd service" Oct 8 19:48:57.803132 containerd[2368]: time="2024-10-08T19:48:57.802525920Z" level=info msg="using legacy CRI server" Oct 8 19:48:57.803132 containerd[2368]: time="2024-10-08T19:48:57.802532600Z" level=info msg="using experimental NRI integration - disable nri plugin to prevent this" Oct 8 19:48:57.803132 containerd[2368]: time="2024-10-08T19:48:57.802697640Z" level=info msg="Get image filesystem path \"/var/lib/containerd/io.containerd.snapshotter.v1.overlayfs\"" Oct 8 19:48:57.803356 containerd[2368]: time="2024-10-08T19:48:57.803307920Z" 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" Oct 8 19:48:57.803356 containerd[2368]: time="2024-10-08T19:48:57.803348520Z" level=info msg="loading plugin \"io.containerd.tracing.processor.v1.otlp\"..." type=io.containerd.tracing.processor.v1 Oct 8 19:48:57.803397 containerd[2368]: time="2024-10-08T19:48:57.803368040Z" 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 Oct 8 19:48:57.803397 containerd[2368]: time="2024-10-08T19:48:57.803378360Z" level=info msg="loading plugin \"io.containerd.internal.v1.tracing\"..." type=io.containerd.internal.v1 Oct 8 19:48:57.803397 containerd[2368]: time="2024-10-08T19:48:57.803391600Z" level=info msg="skip loading plugin \"io.containerd.internal.v1.tracing\"..." error="skip plugin: tracing endpoint not configured" type=io.containerd.internal.v1 Oct 8 19:48:57.803842 containerd[2368]: time="2024-10-08T19:48:57.803724160Z" level=info msg="Start subscribing containerd event" Oct 8 19:48:57.803970 containerd[2368]: time="2024-10-08T19:48:57.803920040Z" level=info msg="Start recovering state" Oct 8 19:48:57.804509 containerd[2368]: time="2024-10-08T19:48:57.804052520Z" level=info msg="Start event monitor" Oct 8 19:48:57.804509 containerd[2368]: time="2024-10-08T19:48:57.803923200Z" level=info msg=serving... address=/run/containerd/containerd.sock.ttrpc Oct 8 19:48:57.804584 containerd[2368]: time="2024-10-08T19:48:57.804082040Z" level=info msg="Start snapshots syncer" Oct 8 19:48:57.804640 containerd[2368]: time="2024-10-08T19:48:57.804624640Z" level=info msg="Start cni network conf syncer for default" Oct 8 19:48:57.804684 containerd[2368]: time="2024-10-08T19:48:57.804672400Z" level=info msg="Start streaming server" Oct 8 19:48:57.804861 containerd[2368]: time="2024-10-08T19:48:57.804120880Z" level=info msg=serving... address=/run/containerd/containerd.sock Oct 8 19:48:57.806862 containerd[2368]: time="2024-10-08T19:48:57.804971360Z" level=info msg="containerd successfully booted in 0.053033s" Oct 8 19:48:57.805125 systemd[1]: Started containerd.service - containerd container runtime. Oct 8 19:48:57.856190 sshd_keygen[2363]: ssh-keygen: generating new host keys: RSA ECDSA ED25519 Oct 8 19:48:57.873897 systemd[1]: Finished sshd-keygen.service - Generate sshd host keys. Oct 8 19:48:57.882437 systemd[1]: Starting issuegen.service - Generate /run/issue... Oct 8 19:48:57.887429 systemd[1]: issuegen.service: Deactivated successfully. Oct 8 19:48:57.887607 systemd[1]: Finished issuegen.service - Generate /run/issue. Oct 8 19:48:57.890514 systemd[1]: Starting systemd-user-sessions.service - Permit User Sessions... Oct 8 19:48:57.903905 systemd[1]: Finished systemd-user-sessions.service - Permit User Sessions. Oct 8 19:48:57.912513 systemd[1]: Started getty@tty1.service - Getty on tty1. Oct 8 19:48:57.914955 systemd[1]: Started serial-getty@ttyAMA0.service - Serial Getty on ttyAMA0. Oct 8 19:48:57.916677 systemd[1]: Reached target getty.target - Login Prompts. Oct 8 19:48:59.157295 systemd-networkd[2307]: eth0: Gained IPv6LL Oct 8 19:48:59.159910 systemd[1]: Finished systemd-networkd-wait-online.service - Wait for Network to be Configured. Oct 8 19:48:59.161711 systemd[1]: Reached target network-online.target - Network is Online. Oct 8 19:48:59.176394 systemd[1]: Starting coreos-metadata.service - QEMU metadata agent... Oct 8 19:48:59.178533 systemd[1]: Starting nvidia.service - NVIDIA Configure Service... Oct 8 19:48:59.195713 systemd[1]: coreos-metadata.service: Deactivated successfully. Oct 8 19:48:59.195898 systemd[1]: Finished coreos-metadata.service - QEMU metadata agent. Oct 8 19:48:59.198035 systemd[1]: packet-phone-home.service - Report Success to Packet was skipped because no trigger condition checks were met. Oct 8 19:48:59.209107 systemd[1]: Finished nvidia.service - NVIDIA Configure Service. Oct 8 19:48:59.210499 systemd[1]: Reached target multi-user.target - Multi-User System. Oct 8 19:48:59.223409 systemd[1]: Starting cryptenroll-helper-first.service... Oct 8 19:49:01.458219 systemd-cryptenroll[2438]: New TPM2 token enrolled as key slot 1. Oct 8 19:49:05.773930 systemd[1]: Created slice system-sshd.slice - Slice /system/sshd. Oct 8 19:49:05.775014 systemd[1]: Started sshd@0-10.0.0.104:22-10.0.0.1:34026.service - OpenSSH per-connection server daemon (10.0.0.1:34026). Oct 8 19:49:05.827682 sshd[2577]: Accepted publickey for core from 10.0.0.1 port 34026 ssh2: RSA SHA256:7GlzoUcthdqM2/gWbc3rpA5Lm+7Qkd3pe7wSn/JGGIM Oct 8 19:49:05.829237 sshd[2577]: pam_unix(sshd:session): session opened for user core(uid=500) by (uid=0) Oct 8 19:49:05.839263 systemd[1]: Created slice user-500.slice - User Slice of UID 500. Oct 8 19:49:05.850369 systemd[1]: Starting user-runtime-dir@500.service - User Runtime Directory /run/user/500... Oct 8 19:49:05.852193 systemd-logind[2360]: New session 1 of user core. Oct 8 19:49:05.859179 systemd[1]: Finished user-runtime-dir@500.service - User Runtime Directory /run/user/500. Oct 8 19:49:05.861266 systemd[1]: Starting user@500.service - User Manager for UID 500... Oct 8 19:49:05.867101 (systemd)[2581]: pam_unix(systemd-user:session): session opened for user core(uid=500) by (uid=0) Oct 8 19:49:05.956367 systemd[2581]: Queued start job for default target default.target. Oct 8 19:49:05.964110 systemd[2581]: Created slice app.slice - User Application Slice. Oct 8 19:49:05.964138 systemd[2581]: Reached target paths.target - Paths. Oct 8 19:49:05.964163 systemd[2581]: Reached target timers.target - Timers. Oct 8 19:49:05.965310 systemd[2581]: Starting dbus.socket - D-Bus User Message Bus Socket... Oct 8 19:49:05.974552 systemd[2581]: Listening on dbus.socket - D-Bus User Message Bus Socket. Oct 8 19:49:05.974600 systemd[2581]: Reached target sockets.target - Sockets. Oct 8 19:49:05.974612 systemd[2581]: Reached target basic.target - Basic System. Oct 8 19:49:05.974644 systemd[2581]: Reached target default.target - Main User Target. Oct 8 19:49:05.974667 systemd[2581]: Startup finished in 102ms. Oct 8 19:49:05.974901 systemd[1]: Started user@500.service - User Manager for UID 500. Oct 8 19:49:05.976035 systemd[1]: Started session-1.scope - Session 1 of User core. Oct 8 19:49:06.041256 systemd[1]: Started sshd@1-10.0.0.104:22-10.0.0.1:34030.service - OpenSSH per-connection server daemon (10.0.0.1:34030). Oct 8 19:49:06.082473 sshd[2592]: Accepted publickey for core from 10.0.0.1 port 34030 ssh2: RSA SHA256:7GlzoUcthdqM2/gWbc3rpA5Lm+7Qkd3pe7wSn/JGGIM Oct 8 19:49:06.084276 sshd[2592]: pam_unix(sshd:session): session opened for user core(uid=500) by (uid=0) Oct 8 19:49:06.088204 systemd-logind[2360]: New session 2 of user core. Oct 8 19:49:06.100337 systemd[1]: Started session-2.scope - Session 2 of User core. Oct 8 19:49:06.151535 sshd[2592]: pam_unix(sshd:session): session closed for user core Oct 8 19:49:06.164347 systemd[1]: sshd@1-10.0.0.104:22-10.0.0.1:34030.service: Deactivated successfully. Oct 8 19:49:06.165591 systemd[1]: session-2.scope: Deactivated successfully. Oct 8 19:49:06.166929 systemd-logind[2360]: Session 2 logged out. Waiting for processes to exit. Oct 8 19:49:06.167946 systemd[1]: Started sshd@2-10.0.0.104:22-10.0.0.1:34032.service - OpenSSH per-connection server daemon (10.0.0.1:34032). Oct 8 19:49:06.168668 systemd-logind[2360]: Removed session 2. Oct 8 19:49:06.204322 sshd[2599]: Accepted publickey for core from 10.0.0.1 port 34032 ssh2: RSA SHA256:7GlzoUcthdqM2/gWbc3rpA5Lm+7Qkd3pe7wSn/JGGIM Oct 8 19:49:06.205691 sshd[2599]: pam_unix(sshd:session): session opened for user core(uid=500) by (uid=0) Oct 8 19:49:06.209755 systemd-logind[2360]: New session 3 of user core. Oct 8 19:49:06.220280 systemd[1]: Started session-3.scope - Session 3 of User core. Oct 8 19:49:06.272731 sshd[2599]: pam_unix(sshd:session): session closed for user core Oct 8 19:49:06.275865 systemd[1]: sshd@2-10.0.0.104:22-10.0.0.1:34032.service: Deactivated successfully. Oct 8 19:49:06.278619 systemd[1]: session-3.scope: Deactivated successfully. Oct 8 19:49:06.279326 systemd-logind[2360]: Session 3 logged out. Waiting for processes to exit. Oct 8 19:49:06.280129 systemd-logind[2360]: Removed session 3. -- Reboot -- Oct 8 19:50:46.921520 kernel: Booting Linux on physical CPU 0x0000000000 [0x413fd0c1] Oct 8 19:50:46.921541 kernel: Linux version 6.6.54-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 Tue Oct 8 18:22:02 -00 2024 Oct 8 19:50:46.921550 kernel: KASLR enabled Oct 8 19:50:46.921556 kernel: efi: EFI v2.7 by EDK II Oct 8 19:50:46.921562 kernel: efi: SMBIOS 3.0=0xdced0000 TPMFinalLog=0xd9740000 MEMATTR=0xdba82198 ACPI 2.0=0xd96e0018 TPMEventLog=0xd96e9098 RNG=0xd96ee698 MEMRESERVE=0xd9b43e18 Oct 8 19:50:46.921568 kernel: random: crng init done Oct 8 19:50:46.921574 kernel: ACPI: Early table checksum verification disabled Oct 8 19:50:46.921580 kernel: ACPI: RSDP 0x00000000D96E0018 000024 (v02 BOCHS ) Oct 8 19:50:46.921586 kernel: ACPI: XSDT 0x00000000D96EFE98 00006C (v01 BOCHS BXPC 00000001 01000013) Oct 8 19:50:46.921594 kernel: ACPI: FACP 0x00000000D96EFA98 000114 (v06 BOCHS BXPC 00000001 BXPC 00000001) Oct 8 19:50:46.921600 kernel: ACPI: DSDT 0x00000000D96E7518 0014EB (v02 BOCHS BXPC 00000001 BXPC 00000001) Oct 8 19:50:46.921606 kernel: ACPI: APIC 0x00000000D96EFC18 0001A8 (v04 BOCHS BXPC 00000001 BXPC 00000001) Oct 8 19:50:46.921611 kernel: ACPI: PPTT 0x00000000D96ED898 00009C (v02 BOCHS BXPC 00000001 BXPC 00000001) Oct 8 19:50:46.921617 kernel: ACPI: GTDT 0x00000000D96EE818 000060 (v02 BOCHS BXPC 00000001 BXPC 00000001) Oct 8 19:50:46.921625 kernel: ACPI: MCFG 0x00000000D96EE918 00003C (v01 BOCHS BXPC 00000001 BXPC 00000001) Oct 8 19:50:46.921633 kernel: ACPI: SPCR 0x00000000D96EFF98 000050 (v02 BOCHS BXPC 00000001 BXPC 00000001) Oct 8 19:50:46.921639 kernel: ACPI: DBG2 0x00000000D96EE418 000057 (v00 BOCHS BXPC 00000001 BXPC 00000001) Oct 8 19:50:46.921645 kernel: ACPI: IORT 0x00000000D96EE718 000080 (v03 BOCHS BXPC 00000001 BXPC 00000001) Oct 8 19:50:46.921652 kernel: ACPI: TPM2 0x00000000D96EE498 00004C (v04 BOCHS BXPC 00000001 BXPC 00000001) Oct 8 19:50:46.921658 kernel: ACPI: SPCR: console: pl011,mmio,0x9000000,9600 Oct 8 19:50:46.921664 kernel: NUMA: Failed to initialise from firmware Oct 8 19:50:46.921671 kernel: NUMA: Faking a node at [mem 0x0000000040000000-0x00000000dcffffff] Oct 8 19:50:46.921677 kernel: NUMA: NODE_DATA [mem 0xdc958800-0xdc95dfff] Oct 8 19:50:46.921683 kernel: Zone ranges: Oct 8 19:50:46.921689 kernel: DMA [mem 0x0000000040000000-0x00000000dcffffff] Oct 8 19:50:46.921697 kernel: DMA32 empty Oct 8 19:50:46.921703 kernel: Normal empty Oct 8 19:50:46.921709 kernel: Movable zone start for each node Oct 8 19:50:46.921715 kernel: Early memory node ranges Oct 8 19:50:46.921722 kernel: node 0: [mem 0x0000000040000000-0x00000000d962ffff] Oct 8 19:50:46.921728 kernel: node 0: [mem 0x00000000d9630000-0x00000000d963ffff] Oct 8 19:50:46.921734 kernel: node 0: [mem 0x00000000d9640000-0x00000000d973ffff] Oct 8 19:50:46.921741 kernel: node 0: [mem 0x00000000d9740000-0x00000000d9b3ffff] Oct 8 19:50:46.921747 kernel: node 0: [mem 0x00000000d9b40000-0x00000000dce1ffff] Oct 8 19:50:46.921753 kernel: node 0: [mem 0x00000000dce20000-0x00000000dceaffff] Oct 8 19:50:46.921760 kernel: node 0: [mem 0x00000000dceb0000-0x00000000dcebffff] Oct 8 19:50:46.921766 kernel: node 0: [mem 0x00000000dcec0000-0x00000000dcfdffff] Oct 8 19:50:46.921773 kernel: node 0: [mem 0x00000000dcfe0000-0x00000000dcffffff] Oct 8 19:50:46.921780 kernel: Initmem setup node 0 [mem 0x0000000040000000-0x00000000dcffffff] Oct 8 19:50:46.921786 kernel: On node 0, zone DMA: 12288 pages in unavailable ranges Oct 8 19:50:46.921795 kernel: psci: probing for conduit method from ACPI. Oct 8 19:50:46.921802 kernel: psci: PSCIv1.1 detected in firmware. Oct 8 19:50:46.921808 kernel: psci: Using standard PSCI v0.2 function IDs Oct 8 19:50:46.921816 kernel: psci: Trusted OS migration not required Oct 8 19:50:46.921823 kernel: psci: SMC Calling Convention v1.1 Oct 8 19:50:46.921830 kernel: smccc: KVM: hypervisor services detected (0x00000000 0x00000000 0x00000000 0x00000003) Oct 8 19:50:46.921836 kernel: percpu: Embedded 31 pages/cpu s86632 r8192 d32152 u126976 Oct 8 19:50:46.921843 kernel: pcpu-alloc: s86632 r8192 d32152 u126976 alloc=31*4096 Oct 8 19:50:46.921850 kernel: pcpu-alloc: [0] 0 [0] 1 [0] 2 [0] 3 Oct 8 19:50:46.921857 kernel: Detected PIPT I-cache on CPU0 Oct 8 19:50:46.921863 kernel: CPU features: detected: GIC system register CPU interface Oct 8 19:50:46.921870 kernel: CPU features: detected: Hardware dirty bit management Oct 8 19:50:46.921877 kernel: CPU features: detected: Spectre-v4 Oct 8 19:50:46.921885 kernel: CPU features: detected: Spectre-BHB Oct 8 19:50:46.921892 kernel: CPU features: kernel page table isolation forced ON by KASLR Oct 8 19:50:46.921899 kernel: CPU features: detected: Kernel page table isolation (KPTI) Oct 8 19:50:46.921905 kernel: CPU features: detected: ARM erratum 1418040 Oct 8 19:50:46.921912 kernel: CPU features: detected: SSBS not fully self-synchronizing Oct 8 19:50:46.921919 kernel: alternatives: applying boot alternatives Oct 8 19:50:46.921926 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=c838587f25bc3913a152d0e9ed071e943b77b8dea81b67c254bbd10c29051fd2 Oct 8 19:50:46.921934 kernel: Unknown kernel command line parameters "BOOT_IMAGE=/flatcar/vmlinuz-a", will be passed to user space. Oct 8 19:50:46.921940 kernel: Dentry cache hash table entries: 524288 (order: 10, 4194304 bytes, linear) Oct 8 19:50:46.921947 kernel: Inode-cache hash table entries: 262144 (order: 9, 2097152 bytes, linear) Oct 8 19:50:46.921954 kernel: Fallback order for Node 0: 0 Oct 8 19:50:46.921962 kernel: Built 1 zonelists, mobility grouping on. Total pages: 633024 Oct 8 19:50:46.921968 kernel: Policy zone: DMA Oct 8 19:50:46.921975 kernel: mem auto-init: stack:off, heap alloc:off, heap free:off Oct 8 19:50:46.921982 kernel: software IO TLB: area num 4. Oct 8 19:50:46.921988 kernel: software IO TLB: mapped [mem 0x00000000d2e00000-0x00000000d6e00000] (64MB) Oct 8 19:50:46.921995 kernel: Memory: 2386532K/2572288K available (10240K kernel code, 2184K rwdata, 8080K rodata, 39104K init, 897K bss, 185756K reserved, 0K cma-reserved) Oct 8 19:50:46.922002 kernel: SLUB: HWalign=64, Order=0-3, MinObjects=0, CPUs=4, Nodes=1 Oct 8 19:50:46.922009 kernel: trace event string verifier disabled Oct 8 19:50:46.922015 kernel: rcu: Preemptible hierarchical RCU implementation. Oct 8 19:50:46.922023 kernel: rcu: RCU event tracing is enabled. Oct 8 19:50:46.922029 kernel: rcu: RCU restricting CPUs from NR_CPUS=512 to nr_cpu_ids=4. Oct 8 19:50:46.922037 kernel: Trampoline variant of Tasks RCU enabled. Oct 8 19:50:46.922044 kernel: Tracing variant of Tasks RCU enabled. Oct 8 19:50:46.922051 kernel: rcu: RCU calculated value of scheduler-enlistment delay is 100 jiffies. Oct 8 19:50:46.922058 kernel: rcu: Adjusting geometry for rcu_fanout_leaf=16, nr_cpu_ids=4 Oct 8 19:50:46.922064 kernel: NR_IRQS: 64, nr_irqs: 64, preallocated irqs: 0 Oct 8 19:50:46.922071 kernel: GICv3: 256 SPIs implemented Oct 8 19:50:46.922078 kernel: GICv3: 0 Extended SPIs implemented Oct 8 19:50:46.922084 kernel: Root IRQ handler: gic_handle_irq Oct 8 19:50:46.922091 kernel: GICv3: GICv3 features: 16 PPIs, DirectLPI Oct 8 19:50:46.922098 kernel: GICv3: CPU0: found redistributor 0 region 0:0x00000000080a0000 Oct 8 19:50:46.922104 kernel: ITS [mem 0x08080000-0x0809ffff] Oct 8 19:50:46.922111 kernel: ITS@0x0000000008080000: allocated 8192 Devices @400d0000 (indirect, esz 8, psz 64K, shr 1) Oct 8 19:50:46.922119 kernel: ITS@0x0000000008080000: allocated 8192 Interrupt Collections @400e0000 (flat, esz 8, psz 64K, shr 1) Oct 8 19:50:46.922126 kernel: GICv3: using LPI property table @0x00000000400f0000 Oct 8 19:50:46.922133 kernel: GICv3: CPU0: using allocated LPI pending table @0x0000000040100000 Oct 8 19:50:46.922157 kernel: rcu: srcu_init: Setting srcu_struct sizes based on contention. Oct 8 19:50:46.922164 kernel: arch_timer: Enabling local workaround for ARM erratum 1418040 Oct 8 19:50:46.922171 kernel: arch_timer: cp15 timer(s) running at 25.00MHz (virt). Oct 8 19:50:46.922178 kernel: clocksource: arch_sys_counter: mask: 0xffffffffffffff max_cycles: 0x5c40939b5, max_idle_ns: 440795202646 ns Oct 8 19:50:46.922185 kernel: sched_clock: 56 bits at 25MHz, resolution 40ns, wraps every 4398046511100ns Oct 8 19:50:46.922192 kernel: arm-pv: using stolen time PV Oct 8 19:50:46.922199 kernel: Console: colour dummy device 80x25 Oct 8 19:50:46.922206 kernel: ACPI: Core revision 20230628 Oct 8 19:50:46.922215 kernel: Calibrating delay loop (skipped), value calculated using timer frequency.. 50.00 BogoMIPS (lpj=25000) Oct 8 19:50:46.922222 kernel: pid_max: default: 32768 minimum: 301 Oct 8 19:50:46.922229 kernel: LSM: initializing lsm=lockdown,capability,selinux,integrity Oct 8 19:50:46.922236 kernel: SELinux: Initializing. Oct 8 19:50:46.922243 kernel: Mount-cache hash table entries: 8192 (order: 4, 65536 bytes, linear) Oct 8 19:50:46.922250 kernel: Mountpoint-cache hash table entries: 8192 (order: 4, 65536 bytes, linear) Oct 8 19:50:46.922257 kernel: RCU Tasks: Setting shift to 2 and lim to 1 rcu_task_cb_adjust=1. Oct 8 19:50:46.922264 kernel: RCU Tasks Trace: Setting shift to 2 and lim to 1 rcu_task_cb_adjust=1. Oct 8 19:50:46.922270 kernel: rcu: Hierarchical SRCU implementation. Oct 8 19:50:46.922279 kernel: rcu: Max phase no-delay instances is 400. Oct 8 19:50:46.922286 kernel: Platform MSI: ITS@0x8080000 domain created Oct 8 19:50:46.922292 kernel: PCI/MSI: ITS@0x8080000 domain created Oct 8 19:50:46.922299 kernel: Remapping and enabling EFI services. Oct 8 19:50:46.922306 kernel: smp: Bringing up secondary CPUs ... Oct 8 19:50:46.922313 kernel: Detected PIPT I-cache on CPU1 Oct 8 19:50:46.922320 kernel: GICv3: CPU1: found redistributor 1 region 0:0x00000000080c0000 Oct 8 19:50:46.922327 kernel: GICv3: CPU1: using allocated LPI pending table @0x0000000040110000 Oct 8 19:50:46.922334 kernel: arch_timer: Enabling local workaround for ARM erratum 1418040 Oct 8 19:50:46.922342 kernel: CPU1: Booted secondary processor 0x0000000001 [0x413fd0c1] Oct 8 19:50:46.922349 kernel: Detected PIPT I-cache on CPU2 Oct 8 19:50:46.922361 kernel: GICv3: CPU2: found redistributor 2 region 0:0x00000000080e0000 Oct 8 19:50:46.922369 kernel: GICv3: CPU2: using allocated LPI pending table @0x0000000040120000 Oct 8 19:50:46.922377 kernel: arch_timer: Enabling local workaround for ARM erratum 1418040 Oct 8 19:50:46.922384 kernel: CPU2: Booted secondary processor 0x0000000002 [0x413fd0c1] Oct 8 19:50:46.922391 kernel: Detected PIPT I-cache on CPU3 Oct 8 19:50:46.922398 kernel: GICv3: CPU3: found redistributor 3 region 0:0x0000000008100000 Oct 8 19:50:46.922406 kernel: GICv3: CPU3: using allocated LPI pending table @0x0000000040130000 Oct 8 19:50:46.922414 kernel: arch_timer: Enabling local workaround for ARM erratum 1418040 Oct 8 19:50:46.922421 kernel: CPU3: Booted secondary processor 0x0000000003 [0x413fd0c1] Oct 8 19:50:46.922428 kernel: smp: Brought up 1 node, 4 CPUs Oct 8 19:50:46.922435 kernel: SMP: Total of 4 processors activated. Oct 8 19:50:46.922443 kernel: CPU features: detected: 32-bit EL0 Support Oct 8 19:50:46.922450 kernel: CPU features: detected: Data cache clean to the PoU not required for I/D coherence Oct 8 19:50:46.922457 kernel: CPU features: detected: Common not Private translations Oct 8 19:50:46.922464 kernel: CPU features: detected: CRC32 instructions Oct 8 19:50:46.922473 kernel: CPU features: detected: Enhanced Virtualization Traps Oct 8 19:50:46.922480 kernel: CPU features: detected: RCpc load-acquire (LDAPR) Oct 8 19:50:46.922487 kernel: CPU features: detected: LSE atomic instructions Oct 8 19:50:46.922494 kernel: CPU features: detected: Privileged Access Never Oct 8 19:50:46.922502 kernel: CPU features: detected: RAS Extension Support Oct 8 19:50:46.922509 kernel: CPU features: detected: Speculative Store Bypassing Safe (SSBS) Oct 8 19:50:46.922516 kernel: CPU: All CPU(s) started at EL1 Oct 8 19:50:46.922523 kernel: alternatives: applying system-wide alternatives Oct 8 19:50:46.922530 kernel: devtmpfs: initialized Oct 8 19:50:46.922538 kernel: clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1911260446275000 ns Oct 8 19:50:46.922546 kernel: futex hash table entries: 1024 (order: 4, 65536 bytes, linear) Oct 8 19:50:46.922554 kernel: pinctrl core: initialized pinctrl subsystem Oct 8 19:50:46.922561 kernel: SMBIOS 3.0.0 present. Oct 8 19:50:46.922568 kernel: DMI: QEMU KVM Virtual Machine, BIOS edk2-20230524-3.fc38 05/24/2023 Oct 8 19:50:46.922575 kernel: NET: Registered PF_NETLINK/PF_ROUTE protocol family Oct 8 19:50:46.922583 kernel: DMA: preallocated 512 KiB GFP_KERNEL pool for atomic allocations Oct 8 19:50:46.922590 kernel: DMA: preallocated 512 KiB GFP_KERNEL|GFP_DMA pool for atomic allocations Oct 8 19:50:46.922598 kernel: DMA: preallocated 512 KiB GFP_KERNEL|GFP_DMA32 pool for atomic allocations Oct 8 19:50:46.922605 kernel: audit: initializing netlink subsys (disabled) Oct 8 19:50:46.922614 kernel: audit: type=2000 audit(0.036:1): state=initialized audit_enabled=0 res=1 Oct 8 19:50:46.922621 kernel: thermal_sys: Registered thermal governor 'step_wise' Oct 8 19:50:46.922628 kernel: cpuidle: using governor menu Oct 8 19:50:46.922635 kernel: hw-breakpoint: found 6 breakpoint and 4 watchpoint registers. Oct 8 19:50:46.922643 kernel: ASID allocator initialised with 32768 entries Oct 8 19:50:46.922650 kernel: acpiphp: ACPI Hot Plug PCI Controller Driver version: 0.5 Oct 8 19:50:46.922657 kernel: Serial: AMBA PL011 UART driver Oct 8 19:50:46.922664 kernel: Modules: 2G module region forced by RANDOMIZE_MODULE_REGION_FULL Oct 8 19:50:46.922672 kernel: Modules: 0 pages in range for non-PLT usage Oct 8 19:50:46.922680 kernel: Modules: 509104 pages in range for PLT usage Oct 8 19:50:46.922687 kernel: HugeTLB: registered 1.00 GiB page size, pre-allocated 0 pages Oct 8 19:50:46.922694 kernel: HugeTLB: 0 KiB vmemmap can be freed for a 1.00 GiB page Oct 8 19:50:46.922702 kernel: HugeTLB: registered 32.0 MiB page size, pre-allocated 0 pages Oct 8 19:50:46.922709 kernel: HugeTLB: 0 KiB vmemmap can be freed for a 32.0 MiB page Oct 8 19:50:46.922716 kernel: HugeTLB: registered 2.00 MiB page size, pre-allocated 0 pages Oct 8 19:50:46.922723 kernel: HugeTLB: 0 KiB vmemmap can be freed for a 2.00 MiB page Oct 8 19:50:46.922731 kernel: HugeTLB: registered 64.0 KiB page size, pre-allocated 0 pages Oct 8 19:50:46.922738 kernel: HugeTLB: 0 KiB vmemmap can be freed for a 64.0 KiB page Oct 8 19:50:46.922746 kernel: ACPI: Added _OSI(Module Device) Oct 8 19:50:46.922754 kernel: ACPI: Added _OSI(Processor Device) Oct 8 19:50:46.922761 kernel: ACPI: Added _OSI(3.0 _SCP Extensions) Oct 8 19:50:46.922768 kernel: ACPI: Added _OSI(Processor Aggregator Device) Oct 8 19:50:46.922776 kernel: ACPI: 1 ACPI AML tables successfully acquired and loaded Oct 8 19:50:46.922783 kernel: ACPI: Interpreter enabled Oct 8 19:50:46.922790 kernel: ACPI: Using GIC for interrupt routing Oct 8 19:50:46.922797 kernel: ACPI: MCFG table detected, 1 entries Oct 8 19:50:46.922804 kernel: ARMH0011:00: ttyAMA0 at MMIO 0x9000000 (irq = 12, base_baud = 0) is a SBSA Oct 8 19:50:46.922813 kernel: printk: console [ttyAMA0] enabled Oct 8 19:50:46.922820 kernel: ACPI: PCI Root Bridge [PCI0] (domain 0000 [bus 00-ff]) Oct 8 19:50:46.922951 kernel: acpi PNP0A08:00: _OSC: OS supports [ExtendedConfig ASPM ClockPM Segments MSI HPX-Type3] Oct 8 19:50:46.923024 kernel: acpi PNP0A08:00: _OSC: platform does not support [LTR] Oct 8 19:50:46.923089 kernel: acpi PNP0A08:00: _OSC: OS now controls [PCIeHotplug PME AER PCIeCapability] Oct 8 19:50:46.923175 kernel: acpi PNP0A08:00: ECAM area [mem 0x4010000000-0x401fffffff] reserved by PNP0C02:00 Oct 8 19:50:46.923242 kernel: acpi PNP0A08:00: ECAM at [mem 0x4010000000-0x401fffffff] for [bus 00-ff] Oct 8 19:50:46.923256 kernel: ACPI: Remapped I/O 0x000000003eff0000 to [io 0x0000-0xffff window] Oct 8 19:50:46.923263 kernel: PCI host bridge to bus 0000:00 Oct 8 19:50:46.923336 kernel: pci_bus 0000:00: root bus resource [mem 0x10000000-0x3efeffff window] Oct 8 19:50:46.923395 kernel: pci_bus 0000:00: root bus resource [io 0x0000-0xffff window] Oct 8 19:50:46.923453 kernel: pci_bus 0000:00: root bus resource [mem 0x8000000000-0xffffffffff window] Oct 8 19:50:46.923511 kernel: pci_bus 0000:00: root bus resource [bus 00-ff] Oct 8 19:50:46.923588 kernel: pci 0000:00:00.0: [1b36:0008] type 00 class 0x060000 Oct 8 19:50:46.923665 kernel: pci 0000:00:01.0: [1af4:1005] type 00 class 0x00ff00 Oct 8 19:50:46.923731 kernel: pci 0000:00:01.0: reg 0x10: [io 0x0000-0x001f] Oct 8 19:50:46.923797 kernel: pci 0000:00:01.0: reg 0x14: [mem 0x10000000-0x10000fff] Oct 8 19:50:46.923863 kernel: pci 0000:00:01.0: reg 0x20: [mem 0x8000000000-0x8000003fff 64bit pref] Oct 8 19:50:46.923928 kernel: pci 0000:00:01.0: BAR 4: assigned [mem 0x8000000000-0x8000003fff 64bit pref] Oct 8 19:50:46.923993 kernel: pci 0000:00:01.0: BAR 1: assigned [mem 0x10000000-0x10000fff] Oct 8 19:50:46.924059 kernel: pci 0000:00:01.0: BAR 0: assigned [io 0x1000-0x101f] Oct 8 19:50:46.924119 kernel: pci_bus 0000:00: resource 4 [mem 0x10000000-0x3efeffff window] Oct 8 19:50:46.924196 kernel: pci_bus 0000:00: resource 5 [io 0x0000-0xffff window] Oct 8 19:50:46.924259 kernel: pci_bus 0000:00: resource 6 [mem 0x8000000000-0xffffffffff window] Oct 8 19:50:46.924268 kernel: ACPI: PCI: Interrupt link GSI0 configured for IRQ 35 Oct 8 19:50:46.924276 kernel: ACPI: PCI: Interrupt link GSI1 configured for IRQ 36 Oct 8 19:50:46.924283 kernel: ACPI: PCI: Interrupt link GSI2 configured for IRQ 37 Oct 8 19:50:46.924291 kernel: ACPI: PCI: Interrupt link GSI3 configured for IRQ 38 Oct 8 19:50:46.924301 kernel: iommu: Default domain type: Translated Oct 8 19:50:46.924308 kernel: iommu: DMA domain TLB invalidation policy: strict mode Oct 8 19:50:46.924315 kernel: efivars: Registered efivars operations Oct 8 19:50:46.924322 kernel: vgaarb: loaded Oct 8 19:50:46.924330 kernel: clocksource: Switched to clocksource arch_sys_counter Oct 8 19:50:46.924337 kernel: VFS: Disk quotas dquot_6.6.0 Oct 8 19:50:46.924344 kernel: VFS: Dquot-cache hash table entries: 512 (order 0, 4096 bytes) Oct 8 19:50:46.924352 kernel: pnp: PnP ACPI init Oct 8 19:50:46.924423 kernel: system 00:00: [mem 0x4010000000-0x401fffffff window] could not be reserved Oct 8 19:50:46.924435 kernel: pnp: PnP ACPI: found 1 devices Oct 8 19:50:46.924443 kernel: NET: Registered PF_INET protocol family Oct 8 19:50:46.924450 kernel: IP idents hash table entries: 65536 (order: 7, 524288 bytes, linear) Oct 8 19:50:46.924457 kernel: tcp_listen_portaddr_hash hash table entries: 2048 (order: 3, 32768 bytes, linear) Oct 8 19:50:46.924465 kernel: Table-perturb hash table entries: 65536 (order: 6, 262144 bytes, linear) Oct 8 19:50:46.924472 kernel: TCP established hash table entries: 32768 (order: 6, 262144 bytes, linear) Oct 8 19:50:46.924480 kernel: TCP bind hash table entries: 32768 (order: 8, 1048576 bytes, linear) Oct 8 19:50:46.924487 kernel: TCP: Hash tables configured (established 32768 bind 32768) Oct 8 19:50:46.924494 kernel: UDP hash table entries: 2048 (order: 4, 65536 bytes, linear) Oct 8 19:50:46.924503 kernel: UDP-Lite hash table entries: 2048 (order: 4, 65536 bytes, linear) Oct 8 19:50:46.924510 kernel: NET: Registered PF_UNIX/PF_LOCAL protocol family Oct 8 19:50:46.924518 kernel: PCI: CLS 0 bytes, default 64 Oct 8 19:50:46.924525 kernel: kvm [1]: HYP mode not available Oct 8 19:50:46.924532 kernel: Initialise system trusted keyrings Oct 8 19:50:46.924539 kernel: workingset: timestamp_bits=39 max_order=20 bucket_order=0 Oct 8 19:50:46.924547 kernel: Key type asymmetric registered Oct 8 19:50:46.924554 kernel: Asymmetric key parser 'x509' registered Oct 8 19:50:46.924561 kernel: Block layer SCSI generic (bsg) driver version 0.4 loaded (major 250) Oct 8 19:50:46.924570 kernel: io scheduler mq-deadline registered Oct 8 19:50:46.924577 kernel: io scheduler kyber registered Oct 8 19:50:46.924590 kernel: io scheduler bfq registered Oct 8 19:50:46.924598 kernel: input: Power Button as /devices/LNXSYSTM:00/LNXSYBUS:00/PNP0C0C:00/input/input0 Oct 8 19:50:46.924605 kernel: ACPI: button: Power Button [PWRB] Oct 8 19:50:46.924615 kernel: ACPI: \_SB_.PCI0.GSI1: Enabled at IRQ 36 Oct 8 19:50:46.924696 kernel: virtio-pci 0000:00:01.0: enabling device (0005 -> 0007) Oct 8 19:50:46.924708 kernel: Serial: 8250/16550 driver, 4 ports, IRQ sharing enabled Oct 8 19:50:46.924717 kernel: thunder_xcv, ver 1.0 Oct 8 19:50:46.924727 kernel: thunder_bgx, ver 1.0 Oct 8 19:50:46.924734 kernel: nicpf, ver 1.0 Oct 8 19:50:46.924741 kernel: nicvf, ver 1.0 Oct 8 19:50:46.925050 kernel: rtc-efi rtc-efi.0: registered as rtc0 Oct 8 19:50:46.925162 kernel: rtc-efi rtc-efi.0: setting system clock to 2024-10-08T19:50:46 UTC (1728417046) Oct 8 19:50:46.925176 kernel: hid: raw HID events driver (C) Jiri Kosina Oct 8 19:50:46.925184 kernel: hw perfevents: enabled with armv8_pmuv3_0 PMU driver, 7 counters available Oct 8 19:50:46.925191 kernel: watchdog: Delayed init of the lockup detector failed: -19 Oct 8 19:50:46.925205 kernel: watchdog: Hard watchdog permanently disabled Oct 8 19:50:46.925212 kernel: NET: Registered PF_INET6 protocol family Oct 8 19:50:46.925220 kernel: Segment Routing with IPv6 Oct 8 19:50:46.925227 kernel: In-situ OAM (IOAM) with IPv6 Oct 8 19:50:46.925234 kernel: NET: Registered PF_PACKET protocol family Oct 8 19:50:46.925241 kernel: Key type dns_resolver registered Oct 8 19:50:46.925249 kernel: registered taskstats version 1 Oct 8 19:50:46.925256 kernel: Loading compiled-in X.509 certificates Oct 8 19:50:46.925263 kernel: Loaded X.509 cert 'Kinvolk GmbH: Module signing key for 6.6.54-flatcar: e5b54c43c129014ce5ace0e8cd7b641a0fcb136e' Oct 8 19:50:46.925272 kernel: Key type .fscrypt registered Oct 8 19:50:46.925279 kernel: Key type fscrypt-provisioning registered Oct 8 19:50:46.925287 kernel: ima: No TPM chip found, activating TPM-bypass! Oct 8 19:50:46.925295 kernel: ima: Allocated hash algorithm: sha1 Oct 8 19:50:46.925302 kernel: ima: No architecture policies found Oct 8 19:50:46.925309 kernel: alg: No test for fips(ansi_cprng) (fips_ansi_cprng) Oct 8 19:50:46.925317 kernel: clk: Disabling unused clocks Oct 8 19:50:46.925324 kernel: Freeing unused kernel memory: 39104K Oct 8 19:50:46.925332 kernel: Run /init as init process Oct 8 19:50:46.925340 kernel: with arguments: Oct 8 19:50:46.925348 kernel: /init Oct 8 19:50:46.925355 kernel: with environment: Oct 8 19:50:46.925362 kernel: HOME=/ Oct 8 19:50:46.925369 kernel: TERM=linux Oct 8 19:50:46.925377 kernel: BOOT_IMAGE=/flatcar/vmlinuz-a Oct 8 19:50:46.925387 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) Oct 8 19:50:46.925396 systemd[1]: Detected virtualization kvm. Oct 8 19:50:46.925406 systemd[1]: Detected architecture arm64. Oct 8 19:50:46.925414 systemd[1]: Running in initrd. Oct 8 19:50:46.925421 systemd[1]: No hostname configured, using default hostname. Oct 8 19:50:46.925429 systemd[1]: Hostname set to . Oct 8 19:50:46.925437 systemd[1]: Initializing machine ID from VM UUID. Oct 8 19:50:46.925445 systemd[1]: Queued start job for default target initrd.target. Oct 8 19:50:46.925453 systemd[1]: Started clevis-luks-askpass.path - Forward Password Requests to Clevis Directory Watch. Oct 8 19:50:46.925461 systemd[1]: Started systemd-ask-password-console.path - Dispatch Password Requests to Console Directory Watch. Oct 8 19:50:46.925472 systemd[1]: Expecting device dev-disk-by\x2dlabel-OEM.device - /dev/disk/by-label/OEM... Oct 8 19:50:46.925480 systemd[1]: Expecting device dev-disk-by\x2dlabel-ROOT.device - /dev/disk/by-label/ROOT... Oct 8 19:50:46.925488 systemd[1]: Expecting device dev-disk-by\x2dpartlabel-USR\x2dA.device - /dev/disk/by-partlabel/USR-A... Oct 8 19:50:46.925497 systemd[1]: Expecting device dev-disk-by\x2dpartuuid-7130c94a\x2d213a\x2d4e5a\x2d8e26\x2d6cce9662f132.device - /dev/disk/by-partuuid/7130c94a-213a-4e5a-8e26-6cce9662f132... Oct 8 19:50:46.925506 systemd[1]: Expecting device dev-mapper-usr.device - /dev/mapper/usr... Oct 8 19:50:46.925514 systemd[1]: Reached target cryptsetup-pre.target - Local Encrypted Volumes (Pre). Oct 8 19:50:46.925524 systemd[1]: Reached target cryptsetup.target - Local Encrypted Volumes. Oct 8 19:50:46.925532 systemd[1]: Reached target ignition-diskful-subsequent.target - Ignition Subsequent Boot Disk Setup. Oct 8 19:50:46.925540 systemd[1]: Reached target paths.target - Path Units. Oct 8 19:50:46.925548 systemd[1]: Reached target slices.target - Slice Units. Oct 8 19:50:46.925556 systemd[1]: Reached target swap.target - Swaps. Oct 8 19:50:46.925564 systemd[1]: Reached target timers.target - Timer Units. Oct 8 19:50:46.925572 systemd[1]: Listening on iscsid.socket - Open-iSCSI iscsid Socket. Oct 8 19:50:46.925580 systemd[1]: Listening on iscsiuio.socket - Open-iSCSI iscsiuio Socket. Oct 8 19:50:46.925588 systemd[1]: Listening on systemd-journald-dev-log.socket - Journal Socket (/dev/log). Oct 8 19:50:46.925598 systemd[1]: Listening on systemd-journald.socket - Journal Socket. Oct 8 19:50:46.925607 systemd[1]: Listening on systemd-udevd-control.socket - udev Control Socket. Oct 8 19:50:46.925615 systemd[1]: Listening on systemd-udevd-kernel.socket - udev Kernel Socket. Oct 8 19:50:46.925623 systemd[1]: Reached target sockets.target - Socket Units. Oct 8 19:50:46.925631 systemd[1]: Starting ignition-setup-pre.service - Ignition env setup... Oct 8 19:50:46.925639 systemd[1]: Starting kmod-static-nodes.service - Create List of Static Device Nodes... Oct 8 19:50:46.925647 systemd[1]: Starting systemd-fsck-usr.service... Oct 8 19:50:46.925655 systemd[1]: Starting systemd-journald.service - Journal Service... Oct 8 19:50:46.925665 systemd[1]: Starting systemd-modules-load.service - Load Kernel Modules... Oct 8 19:50:46.925673 systemd[1]: Starting systemd-vconsole-setup.service - Virtual Console Setup... Oct 8 19:50:46.925681 systemd[1]: Finished ignition-setup-pre.service - Ignition env setup. Oct 8 19:50:46.925689 systemd[1]: Finished kmod-static-nodes.service - Create List of Static Device Nodes. Oct 8 19:50:46.925697 systemd[1]: Finished systemd-fsck-usr.service. Oct 8 19:50:46.925705 systemd[1]: Starting systemd-tmpfiles-setup-dev-early.service - Create Static Device Nodes in /dev gracefully... Oct 8 19:50:46.925733 systemd-journald[233]: Collecting audit messages is disabled. Oct 8 19:50:46.925755 systemd-journald[233]: Journal started Oct 8 19:50:46.925774 systemd-journald[233]: Runtime Journal (/run/log/journal/e441de33a5d54a67a2279c2da78f43d2) is 5.9M, max 47.3M, 41.4M free. Oct 8 19:50:46.929200 systemd[1]: Started systemd-journald.service - Journal Service. Oct 8 19:50:46.929997 systemd-modules-load[234]: Inserted module 'overlay' Oct 8 19:50:46.934188 systemd[1]: Finished systemd-tmpfiles-setup-dev-early.service - Create Static Device Nodes in /dev gracefully. Oct 8 19:50:46.935623 systemd[1]: Finished systemd-vconsole-setup.service - Virtual Console Setup. Oct 8 19:50:46.945173 kernel: bridge: filtering via arp/ip/ip6tables is no longer available by default. Update your scripts to load br_netfilter if you need this. Oct 8 19:50:46.946527 systemd-modules-load[234]: Inserted module 'br_netfilter' Oct 8 19:50:46.947476 kernel: Bridge firewalling registered Oct 8 19:50:46.949425 systemd[1]: Starting dracut-cmdline-ask.service - dracut ask for additional cmdline parameters... Oct 8 19:50:46.951944 systemd[1]: Starting systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev... Oct 8 19:50:46.954315 systemd[1]: Starting systemd-tmpfiles-setup.service - Create Volatile Files and Directories... Oct 8 19:50:46.957745 systemd[1]: Finished systemd-modules-load.service - Load Kernel Modules. Oct 8 19:50:46.961342 systemd[1]: Starting systemd-sysctl.service - Apply Kernel Variables... Oct 8 19:50:46.966065 systemd[1]: Finished dracut-cmdline-ask.service - dracut ask for additional cmdline parameters. Oct 8 19:50:46.968902 systemd[1]: Finished systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev. Oct 8 19:50:46.970338 systemd[1]: Finished systemd-tmpfiles-setup.service - Create Volatile Files and Directories. Oct 8 19:50:46.972858 systemd[1]: Finished systemd-sysctl.service - Apply Kernel Variables. Oct 8 19:50:46.987299 systemd[1]: Starting dracut-cmdline.service - dracut cmdline hook... Oct 8 19:50:46.998164 dracut-cmdline[271]: dracut-dracut-053 Oct 8 19:50:47.000730 dracut-cmdline[271]: 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=c838587f25bc3913a152d0e9ed071e943b77b8dea81b67c254bbd10c29051fd2 Oct 8 19:50:47.068174 kernel: SCSI subsystem initialized Oct 8 19:50:47.072162 kernel: Loading iSCSI transport class v2.0-870. Oct 8 19:50:47.080207 kernel: iscsi: registered transport (tcp) Oct 8 19:50:47.093162 kernel: iscsi: registered transport (qla4xxx) Oct 8 19:50:47.093194 kernel: QLogic iSCSI HBA Driver Oct 8 19:50:47.136647 systemd[1]: Finished dracut-cmdline.service - dracut cmdline hook. Oct 8 19:50:47.144367 systemd[1]: Starting dracut-pre-udev.service - dracut pre-udev hook... Oct 8 19:50:47.160733 kernel: device-mapper: core: CONFIG_IMA_DISABLE_HTABLE is disabled. Duplicate IMA measurements will not be recorded in the IMA log. Oct 8 19:50:47.160777 kernel: device-mapper: uevent: version 1.0.3 Oct 8 19:50:47.162389 kernel: device-mapper: ioctl: 4.48.0-ioctl (2023-03-01) initialised: dm-devel@redhat.com Oct 8 19:50:47.210209 kernel: raid6: neonx8 gen() 15757 MB/s Oct 8 19:50:47.227178 kernel: raid6: neonx4 gen() 15632 MB/s Oct 8 19:50:47.244183 kernel: raid6: neonx2 gen() 13226 MB/s Oct 8 19:50:47.261171 kernel: raid6: neonx1 gen() 10501 MB/s Oct 8 19:50:47.278170 kernel: raid6: int64x8 gen() 6955 MB/s Oct 8 19:50:47.295172 kernel: raid6: int64x4 gen() 7346 MB/s Oct 8 19:50:47.312170 kernel: raid6: int64x2 gen() 6124 MB/s Oct 8 19:50:47.329279 kernel: raid6: int64x1 gen() 5053 MB/s Oct 8 19:50:47.329291 kernel: raid6: using algorithm neonx8 gen() 15757 MB/s Oct 8 19:50:47.347259 kernel: raid6: .... xor() 11934 MB/s, rmw enabled Oct 8 19:50:47.347282 kernel: raid6: using neon recovery algorithm Oct 8 19:50:47.352172 kernel: xor: measuring software checksum speed Oct 8 19:50:47.352190 kernel: 8regs : 16873 MB/sec Oct 8 19:50:47.353365 kernel: 32regs : 19627 MB/sec Oct 8 19:50:47.354631 kernel: arm64_neon : 26848 MB/sec Oct 8 19:50:47.354645 kernel: xor: using function: arm64_neon (26848 MB/sec) Oct 8 19:50:47.407432 kernel: Btrfs loaded, zoned=no, fsverity=no Oct 8 19:50:47.418474 systemd[1]: Finished dracut-pre-udev.service - dracut pre-udev hook. Oct 8 19:50:47.430366 systemd[1]: Starting systemd-udevd.service - Rule-based Manager for Device Events and Files... Oct 8 19:50:47.442326 systemd-udevd[453]: Using default interface naming scheme 'v255'. Oct 8 19:50:47.445437 systemd[1]: Started systemd-udevd.service - Rule-based Manager for Device Events and Files. Oct 8 19:50:47.459328 systemd[1]: Starting dracut-pre-trigger.service - dracut pre-trigger hook... Oct 8 19:50:47.470635 dracut-pre-trigger[460]: rd.md=0: removing MD RAID activation Oct 8 19:50:47.497506 systemd[1]: Finished dracut-pre-trigger.service - dracut pre-trigger hook. Oct 8 19:50:47.510280 systemd[1]: Starting systemd-udev-trigger.service - Coldplug All udev Devices... Oct 8 19:50:47.549926 systemd[1]: Finished systemd-udev-trigger.service - Coldplug All udev Devices. Oct 8 19:50:47.557351 systemd[1]: Starting dracut-initqueue.service - dracut initqueue hook... Oct 8 19:50:47.569034 systemd[1]: Finished dracut-initqueue.service - dracut initqueue hook. Oct 8 19:50:47.571596 systemd[1]: Reached target remote-fs-pre.target - Preparation for Remote File Systems. Oct 8 19:50:47.573062 systemd[1]: Reached target remote-cryptsetup.target - Remote Encrypted Volumes. Oct 8 19:50:47.575495 systemd[1]: Reached target remote-fs.target - Remote File Systems. Oct 8 19:50:47.581296 systemd[1]: Starting dracut-pre-mount.service - dracut pre-mount hook... Oct 8 19:50:47.591443 systemd[1]: Finished dracut-pre-mount.service - dracut pre-mount hook. Oct 8 19:50:47.604160 kernel: tpm_tis MSFT0101:00: 2.0 TPM (device-id 0x1, rev-id 1) Oct 8 19:50:47.607290 kernel: virtio_blk virtio1: 1/0/0 default/read/poll queues Oct 8 19:50:47.607430 kernel: virtio_blk virtio1: [vda] 1064960 512-byte logical blocks (545 MB/520 MiB) Oct 8 19:50:47.615172 kernel: virtio_blk virtio2: 1/0/0 default/read/poll queues Oct 8 19:50:47.615324 kernel: virtio_blk virtio2: [vdb] 9289728 512-byte logical blocks (4.76 GB/4.43 GiB) Oct 8 19:50:47.623281 systemd[1]: dracut-cmdline-ask.service: Deactivated successfully. Oct 8 19:50:47.623392 systemd[1]: Stopped dracut-cmdline-ask.service - dracut ask for additional cmdline parameters. Oct 8 19:50:47.626844 systemd[1]: Stopping dracut-cmdline-ask.service - dracut ask for additional cmdline parameters... Oct 8 19:50:47.628003 systemd[1]: systemd-vconsole-setup.service: Deactivated successfully. Oct 8 19:50:47.630866 kernel: vdb: vdb1 vdb2 vdb3 vdb4 vdb6 vdb7 vdb9 Oct 8 19:50:47.628141 systemd[1]: Stopped systemd-vconsole-setup.service - Virtual Console Setup. Oct 8 19:50:47.631938 systemd[1]: Stopping systemd-vconsole-setup.service - Virtual Console Setup... Oct 8 19:50:47.645164 kernel: BTRFS: device label OEM devid 1 transid 18 /dev/vdb6 scanned by (udev-worker) (512) Oct 8 19:50:47.649175 kernel: BTRFS: device fsid a2a78d47-736b-4018-a518-3cfb16920575 devid 1 transid 36 /dev/vdb3 scanned by (udev-worker) (504) Oct 8 19:50:47.649394 systemd[1]: Starting systemd-vconsole-setup.service - Virtual Console Setup... Oct 8 19:50:47.659110 systemd[1]: Condition check resulted in dev-disk-by\x2dpartuuid-85fb8daf\x2dda12\x2d42d0\x2da639\x2db72d8c3c8d9b.device - /dev/disk/by-partuuid/85fb8daf-da12-42d0-a639-b72d8c3c8d9b being skipped. Oct 8 19:50:47.659126 systemd[1]: Condition check resulted in dev-disk-by\x2did-virtio\x2dprimary\x2ddisk\x2dpart9.device - /dev/disk/by-id/virtio-primary-disk-part9 being skipped. Oct 8 19:50:47.659137 systemd[1]: Condition check resulted in dev-disk-by\x2dpath-platform\x2dLNRO0005:1f\x2dpart9.device - /dev/disk/by-path/platform-LNRO0005:1f-part9 being skipped. Oct 8 19:50:47.659152 systemd[1]: Condition check resulted in dev-disk-by\x2ddiskseq-2\x2dpart9.device - /dev/disk/by-diskseq/2-part9 being skipped. Oct 8 19:50:47.659160 systemd[1]: Condition check resulted in dev-vdb9.device - /dev/vdb9 being skipped. Oct 8 19:50:47.659166 systemd[1]: Condition check resulted in dev-disk-by\x2dpartlabel-ROOT.device - /dev/disk/by-partlabel/ROOT being skipped. Oct 8 19:50:47.659173 systemd[1]: Condition check resulted in dev-disk-by\x2duuid-e76368d9\x2d280c\x2d4d35\x2d9cf5\x2d9509759dd5b0.device - /dev/disk/by-uuid/e76368d9-280c-4d35-9cf5-9509759dd5b0 being skipped. Oct 8 19:50:47.669841 systemd[1]: Finished systemd-vconsole-setup.service - Virtual Console Setup. Oct 8 19:50:47.677198 systemd[1]: Found device dev-disk-by\x2dpartlabel-USR\x2dA.device - /dev/disk/by-partlabel/USR-A. Oct 8 19:50:47.678394 systemd[1]: Found device dev-disk-by\x2dpartuuid-7130c94a\x2d213a\x2d4e5a\x2d8e26\x2d6cce9662f132.device - /dev/disk/by-partuuid/7130c94a-213a-4e5a-8e26-6cce9662f132. Oct 8 19:50:47.683826 systemd[1]: Found device dev-disk-by\x2dlabel-OEM.device - /dev/disk/by-label/OEM. Oct 8 19:50:47.698320 systemd[1]: Starting decrypt-root.service - Generate and execute a systemd-cryptsetup service to decrypt the ROOT partition... Oct 8 19:50:47.700101 systemd[1]: Starting disk-uuid.service - Generate new UUID for disk GPT if necessary... Oct 8 19:50:47.704314 systemd[1]: Starting dracut-cmdline-ask.service - dracut ask for additional cmdline parameters... Oct 8 19:50:47.708408 systemd[1]: disk-uuid.service: Deactivated successfully. Oct 8 19:50:47.708501 systemd[1]: Finished disk-uuid.service - Generate new UUID for disk GPT if necessary. Oct 8 19:50:47.711069 systemd[1]: Reached target local-fs-pre.target - Preparation for Local File Systems. Oct 8 19:50:47.713773 systemd[1]: Reached target local-fs.target - Local File Systems. Oct 8 19:50:47.714749 systemd[1]: Reached target sysinit.target - System Initialization. Oct 8 19:50:47.716576 systemd[1]: Reached target basic.target - Basic System. Oct 8 19:50:47.718947 systemd[1]: Starting verity-setup.service - Verity Setup for /dev/mapper/usr... Oct 8 19:50:47.721806 systemd[1]: Reloading requested from client PID 544 ('systemctl') (unit decrypt-root.service)... Oct 8 19:50:47.721820 systemd[1]: Reloading... Oct 8 19:50:47.726221 sh[558]: Success Oct 8 19:50:47.743336 kernel: device-mapper: verity: sha256 using implementation "sha256-ce" Oct 8 19:50:47.853759 systemd[1]: Found device dev-mapper-usr.device - /dev/mapper/usr. Oct 8 19:50:47.854889 systemd[1]: Reloading finished in 132 ms. Oct 8 19:50:47.865670 systemd[1]: Finished dracut-cmdline-ask.service - dracut ask for additional cmdline parameters. Oct 8 19:50:47.885212 systemd[1]: Finished verity-setup.service - Verity Setup for /dev/mapper/usr. Oct 8 19:50:47.887575 systemd[1]: Created slice system-systemd\x2dcryptsetup.slice - Slice /system/systemd-cryptsetup. Oct 8 19:50:47.889699 systemd[1]: Mounting sysusr-usr.mount - /sysusr/usr... Oct 8 19:50:47.891524 systemd[1]: Starting systemd-cryptsetup@rootencrypted.service - Cryptography Setup for rootencrypted... Oct 8 19:50:47.903194 kernel: BTRFS info (device dm-0): first mount of filesystem a2a78d47-736b-4018-a518-3cfb16920575 Oct 8 19:50:47.903231 kernel: BTRFS info (device dm-0): using crc32c (crc32c-generic) checksum algorithm Oct 8 19:50:47.903242 kernel: BTRFS warning (device dm-0): 'nologreplay' is deprecated, use 'rescue=nologreplay' instead Oct 8 19:50:47.905848 kernel: BTRFS info (device dm-0): disabling log replay at mount time Oct 8 19:50:47.905863 kernel: BTRFS info (device dm-0): using free space tree Oct 8 19:50:47.909573 systemd[1]: Mounted sysusr-usr.mount - /sysusr/usr. Oct 8 19:50:48.132178 kernel: Key type trusted registered Oct 8 19:50:48.136165 kernel: Key type encrypted registered Oct 8 19:50:48.159174 systemd[1]: Found device dev-disk-by\x2dlabel-ROOT.device - /dev/disk/by-label/ROOT. Oct 8 19:50:48.160998 systemd[1]: Finished systemd-cryptsetup@rootencrypted.service - Cryptography Setup for rootencrypted. Oct 8 19:50:48.166268 systemd[1]: Finished decrypt-root.service - Generate and execute a systemd-cryptsetup service to decrypt the ROOT partition. Oct 8 19:50:48.168617 systemd[1]: Reached target initrd-root-device.target - Initrd Root Device. Oct 8 19:50:48.180357 systemd[1]: Starting systemd-fsck-root.service - File System Check on /dev/disk/by-label/ROOT... Oct 8 19:50:48.192494 systemd-fsck[708]: ROOT: clean, 201/137360 files, 32864/549376 blocks Oct 8 19:50:48.197223 systemd[1]: Finished systemd-fsck-root.service - File System Check on /dev/disk/by-label/ROOT. Oct 8 19:50:48.205242 systemd[1]: Mounting sysroot.mount - /sysroot... Oct 8 19:50:48.252169 kernel: EXT4-fs (dm-1): mounted filesystem 873ea13e-9333-492d-bddd-47dcc9a29c84 r/w with ordered data mode. Quota mode: none. Oct 8 19:50:48.252598 systemd[1]: Mounted sysroot.mount - /sysroot. Oct 8 19:50:48.254024 systemd[1]: Reached target initrd-root-fs.target - Initrd Root File System. Oct 8 19:50:48.261257 systemd[1]: Mounting sysroot-oem.mount - /sysroot/oem... Oct 8 19:50:48.263117 systemd[1]: Mounting sysroot-usr.mount - /sysroot/usr... Oct 8 19:50:48.268583 kernel: BTRFS info (device vdb6): first mount of filesystem 95ed8f66-d8c4-4374-b329-28c20748d95f Oct 8 19:50:48.268615 kernel: BTRFS info (device vdb6): using crc32c (crc32c-generic) checksum algorithm Oct 8 19:50:48.269362 kernel: BTRFS info (device vdb6): using free space tree Oct 8 19:50:48.272171 kernel: BTRFS info (device vdb6): auto enabling async discard Oct 8 19:50:48.272903 systemd[1]: Mounted sysroot-oem.mount - /sysroot/oem. Oct 8 19:50:48.274033 systemd[1]: Mounted sysroot-usr.mount - /sysroot/usr. Oct 8 19:50:48.277508 systemd[1]: Starting initrd-setup-root.service - Root filesystem setup... Oct 8 19:50:48.612057 systemd[1]: Finished initrd-setup-root.service - Root filesystem setup. Oct 8 19:50:48.621377 systemd[1]: Starting initrd-setup-root-after-ignition.service - Root filesystem completion... Oct 8 19:50:48.625714 initrd-setup-root-after-ignition[1015]: grep: /sysroot/oem/oem-release: No such file or directory Oct 8 19:50:48.631248 initrd-setup-root-after-ignition[1017]: grep: Oct 8 19:50:48.632238 initrd-setup-root-after-ignition[1021]: grep: Oct 8 19:50:48.633004 initrd-setup-root-after-ignition[1017]: /sysroot/etc/flatcar/enabled-sysext.conf Oct 8 19:50:48.634201 initrd-setup-root-after-ignition[1021]: /sysroot/etc/flatcar/enabled-sysext.conf Oct 8 19:50:48.633031 systemd[1]: Finished initrd-setup-root-after-ignition.service - Root filesystem completion. Oct 8 19:50:48.638879 initrd-setup-root-after-ignition[1017]: : No such file or directory Oct 8 19:50:48.635922 systemd[1]: Reached target ignition-subsequent.target - Subsequent (Not Ignition) boot complete. Oct 8 19:50:48.641229 initrd-setup-root-after-ignition[1021]: : No such file or directory Oct 8 19:50:48.642277 initrd-setup-root-after-ignition[1017]: grep: /sysroot/usr/share/flatcar/enabled-sysext.conf: No such file or directory Oct 8 19:50:48.646309 systemd[1]: Starting initrd-parse-etc.service - Mountpoints Configured in the Real Root... Oct 8 19:50:48.667998 systemd[1]: initrd-parse-etc.service: Deactivated successfully. Oct 8 19:50:48.668123 systemd[1]: Finished initrd-parse-etc.service - Mountpoints Configured in the Real Root. Oct 8 19:50:48.670561 systemd[1]: Reached target initrd-fs.target - Initrd File Systems. Oct 8 19:50:48.672420 systemd[1]: Reached target initrd.target - Initrd Default Target. Oct 8 19:50:48.674242 systemd[1]: dracut-mount.service - dracut mount hook was skipped because no trigger condition checks were met. Oct 8 19:50:48.675090 systemd[1]: Starting dracut-pre-pivot.service - dracut pre-pivot and cleanup hook... Oct 8 19:50:48.691428 systemd[1]: Finished dracut-pre-pivot.service - dracut pre-pivot and cleanup hook. Oct 8 19:50:48.703360 systemd[1]: Starting initrd-cleanup.service - Cleaning Up and Shutting Down Daemons... Oct 8 19:50:48.714781 systemd[1]: Stopped target remote-cryptsetup.target - Remote Encrypted Volumes. Oct 8 19:50:48.716248 systemd[1]: Stopped target timers.target - Timer Units. Oct 8 19:50:48.718115 systemd[1]: decrypt-root.service: Deactivated successfully. Oct 8 19:50:48.718271 systemd[1]: Stopped decrypt-root.service - Generate and execute a systemd-cryptsetup service to decrypt the ROOT partition. Oct 8 19:50:48.720163 systemd[1]: dracut-pre-pivot.service: Deactivated successfully. Oct 8 19:50:48.720281 systemd[1]: Stopped dracut-pre-pivot.service - dracut pre-pivot and cleanup hook. Oct 8 19:50:48.723593 systemd[1]: Stopped target initrd.target - Initrd Default Target. Oct 8 19:50:48.725540 systemd[1]: Stopped target basic.target - Basic System. Oct 8 19:50:48.727469 systemd[1]: Stopped target ignition-subsequent.target - Subsequent (Not Ignition) boot complete. Oct 8 19:50:48.729463 systemd[1]: Stopped target ignition-diskful-subsequent.target - Ignition Subsequent Boot Disk Setup. Oct 8 19:50:48.731440 systemd[1]: Stopped target initrd-root-device.target - Initrd Root Device. Oct 8 19:50:48.733709 systemd[1]: Stopped target paths.target - Path Units. Oct 8 19:50:48.735927 systemd[1]: Stopped target remote-fs.target - Remote File Systems. Oct 8 19:50:48.737976 systemd[1]: Stopped target remote-fs-pre.target - Preparation for Remote File Systems. Oct 8 19:50:48.740083 systemd[1]: Stopped target slices.target - Slice Units. Oct 8 19:50:48.741928 systemd[1]: Stopped target sockets.target - Socket Units. Oct 8 19:50:48.744021 systemd[1]: Stopped target sysinit.target - System Initialization. Oct 8 19:50:48.745929 systemd[1]: Stopped target local-fs.target - Local File Systems. Oct 8 19:50:48.747683 systemd[1]: Stopped target swap.target - Swaps. Oct 8 19:50:48.749313 systemd[1]: iscsid.socket: Deactivated successfully. Oct 8 19:50:48.749417 systemd[1]: Closed iscsid.socket - Open-iSCSI iscsid Socket. Oct 8 19:50:48.751178 systemd[1]: iscsiuio.socket: Deactivated successfully. Oct 8 19:50:48.751274 systemd[1]: Closed iscsiuio.socket - Open-iSCSI iscsiuio Socket. Oct 8 19:50:48.752828 systemd[1]: dracut-pre-mount.service: Deactivated successfully. Oct 8 19:50:48.752939 systemd[1]: Stopped dracut-pre-mount.service - dracut pre-mount hook. Oct 8 19:50:48.755382 systemd[1]: Stopped target cryptsetup.target - Local Encrypted Volumes. Oct 8 19:50:48.757307 systemd[1]: systemd-ask-password-console.path: Deactivated successfully. Oct 8 19:50:48.761203 systemd[1]: Stopped systemd-ask-password-console.path - Dispatch Password Requests to Console Directory Watch. Oct 8 19:50:48.762531 systemd[1]: Stopped target cryptsetup-pre.target - Local Encrypted Volumes (Pre). Oct 8 19:50:48.764734 systemd[1]: clevis-luks-askpass.path: Deactivated successfully. Oct 8 19:50:48.764855 systemd[1]: Stopped clevis-luks-askpass.path - Forward Password Requests to Clevis Directory Watch. Oct 8 19:50:48.767201 systemd[1]: dracut-initqueue.service: Deactivated successfully. Oct 8 19:50:48.767337 systemd[1]: Stopped dracut-initqueue.service - dracut initqueue hook. Oct 8 19:50:48.770872 systemd[1]: ignition-setup-pre.service: Deactivated successfully. Oct 8 19:50:48.771005 systemd[1]: Stopped ignition-setup-pre.service - Ignition env setup. Oct 8 19:50:48.773676 systemd[1]: initrd-setup-root-after-ignition.service: Deactivated successfully. Oct 8 19:50:48.773791 systemd[1]: Stopped initrd-setup-root-after-ignition.service - Root filesystem completion. Oct 8 19:50:48.775691 systemd[1]: initrd-setup-root.service: Deactivated successfully. Oct 8 19:50:48.775798 systemd[1]: Stopped initrd-setup-root.service - Root filesystem setup. Oct 8 19:50:48.777631 systemd[1]: kmod-static-nodes.service: Deactivated successfully. Oct 8 19:50:48.777736 systemd[1]: Stopped kmod-static-nodes.service - Create List of Static Device Nodes. Oct 8 19:50:48.779646 systemd[1]: systemd-sysctl.service: Deactivated successfully. Oct 8 19:50:48.779763 systemd[1]: Stopped systemd-sysctl.service - Apply Kernel Variables. Oct 8 19:50:48.781518 systemd[1]: systemd-modules-load.service: Deactivated successfully. Oct 8 19:50:48.781622 systemd[1]: Stopped systemd-modules-load.service - Load Kernel Modules. Oct 8 19:50:48.783522 systemd[1]: systemd-tmpfiles-setup.service: Deactivated successfully. Oct 8 19:50:48.783625 systemd[1]: Stopped systemd-tmpfiles-setup.service - Create Volatile Files and Directories. Oct 8 19:50:48.785799 systemd[1]: systemd-udev-trigger.service: Deactivated successfully. Oct 8 19:50:48.785903 systemd[1]: Stopped systemd-udev-trigger.service - Coldplug All udev Devices. Oct 8 19:50:48.787810 systemd[1]: dracut-pre-trigger.service: Deactivated successfully. Oct 8 19:50:48.787916 systemd[1]: Stopped dracut-pre-trigger.service - dracut pre-trigger hook. Oct 8 19:50:48.791183 systemd[1]: Stopping systemd-udevd.service - Rule-based Manager for Device Events and Files... Oct 8 19:50:48.796473 systemd[1]: initrd-cleanup.service: Deactivated successfully. Oct 8 19:50:48.796564 systemd[1]: Finished initrd-cleanup.service - Cleaning Up and Shutting Down Daemons. Oct 8 19:50:48.812831 systemd[1]: systemd-udevd.service: Deactivated successfully. Oct 8 19:50:48.812975 systemd[1]: Stopped systemd-udevd.service - Rule-based Manager for Device Events and Files. Oct 8 19:50:48.815504 systemd[1]: systemd-udevd-control.socket: Deactivated successfully. Oct 8 19:50:48.815548 systemd[1]: Closed systemd-udevd-control.socket - udev Control Socket. Oct 8 19:50:48.817235 systemd[1]: systemd-udevd-kernel.socket: Deactivated successfully. Oct 8 19:50:48.817266 systemd[1]: Closed systemd-udevd-kernel.socket - udev Kernel Socket. Oct 8 19:50:48.819078 systemd[1]: dracut-pre-udev.service: Deactivated successfully. Oct 8 19:50:48.819139 systemd[1]: Stopped dracut-pre-udev.service - dracut pre-udev hook. Oct 8 19:50:48.822042 systemd[1]: dracut-cmdline.service: Deactivated successfully. Oct 8 19:50:48.822092 systemd[1]: Stopped dracut-cmdline.service - dracut cmdline hook. Oct 8 19:50:48.825405 systemd[1]: dracut-cmdline-ask.service: Deactivated successfully. Oct 8 19:50:48.825453 systemd[1]: Stopped dracut-cmdline-ask.service - dracut ask for additional cmdline parameters. Oct 8 19:50:48.838661 systemd[1]: Starting initrd-udevadm-cleanup-db.service - Cleanup udev Database... Oct 8 19:50:48.839803 systemd[1]: systemd-tmpfiles-setup-dev.service: Deactivated successfully. Oct 8 19:50:48.839873 systemd[1]: Stopped systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev. Oct 8 19:50:48.842183 systemd[1]: systemd-vconsole-setup.service: Deactivated successfully. Oct 8 19:50:48.842241 systemd[1]: Stopped systemd-vconsole-setup.service - Virtual Console Setup. Oct 8 19:50:48.844677 systemd[1]: initrd-udevadm-cleanup-db.service: Deactivated successfully. Oct 8 19:50:48.844785 systemd[1]: Finished initrd-udevadm-cleanup-db.service - Cleanup udev Database. Oct 8 19:50:48.848007 systemd[1]: Reached target initrd-switch-root.target - Switch Root. Oct 8 19:50:48.850427 systemd[1]: Starting initrd-switch-root.service - Switch Root... Oct 8 19:50:48.881620 systemd[1]: Switching root. Oct 8 19:50:48.912828 systemd-journald[233]: Journal stopped Oct 8 19:50:49.429719 systemd-journald[233]: Received SIGTERM from PID 1 (systemd). Oct 8 19:50:49.429776 kernel: SELinux: policy capability network_peer_controls=1 Oct 8 19:50:49.429788 kernel: SELinux: policy capability open_perms=1 Oct 8 19:50:49.429798 kernel: SELinux: policy capability extended_socket_class=1 Oct 8 19:50:49.429807 kernel: SELinux: policy capability always_check_network=0 Oct 8 19:50:49.429820 kernel: SELinux: policy capability cgroup_seclabel=1 Oct 8 19:50:49.429829 kernel: SELinux: policy capability nnp_nosuid_transition=1 Oct 8 19:50:49.429838 kernel: SELinux: policy capability genfs_seclabel_symlinks=0 Oct 8 19:50:49.429848 kernel: SELinux: policy capability ioctl_skip_cloexec=0 Oct 8 19:50:49.429857 kernel: audit: type=1403 audit(1728417048.981:2): auid=4294967295 ses=4294967295 lsm=selinux res=1 Oct 8 19:50:49.429868 systemd[1]: Successfully loaded SELinux policy in 31.230ms. Oct 8 19:50:49.429885 systemd[1]: Relabeled /dev, /dev/shm, /run, /sys/fs/cgroup in 9.556ms. Oct 8 19:50:49.429897 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) Oct 8 19:50:49.429909 systemd[1]: Detected virtualization kvm. Oct 8 19:50:49.429920 systemd[1]: Detected architecture arm64. Oct 8 19:50:49.429932 zram_generator::config[1064]: No configuration found. Oct 8 19:50:49.429942 systemd[1]: initrd-switch-root.service: Deactivated successfully. Oct 8 19:50:49.429953 systemd[1]: Stopped initrd-switch-root.service - Switch Root. Oct 8 19:50:49.429968 systemd[1]: systemd-journald.service: Scheduled restart job, restart counter is at 1. Oct 8 19:50:49.429979 systemd[1]: Created slice system-addon\x2dconfig.slice - Slice /system/addon-config. Oct 8 19:50:49.429989 systemd[1]: Created slice system-addon\x2drun.slice - Slice /system/addon-run. Oct 8 19:50:49.430002 systemd[1]: Created slice system-getty.slice - Slice /system/getty. Oct 8 19:50:49.430012 systemd[1]: Created slice system-modprobe.slice - Slice /system/modprobe. Oct 8 19:50:49.430023 systemd[1]: Created slice system-serial\x2dgetty.slice - Slice /system/serial-getty. Oct 8 19:50:49.430033 systemd[1]: Created slice system-system\x2dcloudinit.slice - Slice /system/system-cloudinit. Oct 8 19:50:49.430043 systemd[1]: Created slice system-systemd\x2dfsck.slice - Slice /system/systemd-fsck. Oct 8 19:50:49.430053 systemd[1]: Created slice user.slice - User and Session Slice. Oct 8 19:50:49.430063 systemd[1]: Started clevis-luks-askpass.path - Forward Password Requests to Clevis Directory Watch. Oct 8 19:50:49.430074 systemd[1]: Started systemd-ask-password-console.path - Dispatch Password Requests to Console Directory Watch. Oct 8 19:50:49.430085 systemd[1]: Started systemd-ask-password-wall.path - Forward Password Requests to Wall Directory Watch. Oct 8 19:50:49.430096 systemd[1]: Set up automount boot.automount - Boot partition Automount Point. Oct 8 19:50:49.430107 systemd[1]: Set up automount proc-sys-fs-binfmt_misc.automount - Arbitrary Executable File Formats File System Automount Point. Oct 8 19:50:49.430118 systemd[1]: Expecting device dev-disk-by\x2dlabel-OEM.device - /dev/disk/by-label/OEM... Oct 8 19:50:49.430128 systemd[1]: Expecting device dev-ttyAMA0.device - /dev/ttyAMA0... Oct 8 19:50:49.430173 systemd[1]: Reached target blockdev@dev-mapper-rootencrypted.target - Block Device Preparation for /dev/mapper/rootencrypted. Oct 8 19:50:49.430186 systemd[1]: Reached target cryptsetup-pre.target - Local Encrypted Volumes (Pre). Oct 8 19:50:49.430199 systemd[1]: Stopped target initrd-switch-root.target - Switch Root. Oct 8 19:50:49.430209 systemd[1]: Stopped target initrd-fs.target - Initrd File Systems. Oct 8 19:50:49.430219 systemd[1]: Stopped target initrd-root-fs.target - Initrd Root File System. Oct 8 19:50:49.430232 systemd[1]: Reached target integritysetup.target - Local Integrity Protected Volumes. Oct 8 19:50:49.430243 systemd[1]: Reached target remote-cryptsetup.target - Remote Encrypted Volumes. Oct 8 19:50:49.430253 systemd[1]: Reached target remote-fs.target - Remote File Systems. Oct 8 19:50:49.430264 systemd[1]: Reached target slices.target - Slice Units. Oct 8 19:50:49.430274 systemd[1]: Reached target swap.target - Swaps. Oct 8 19:50:49.430284 systemd[1]: Reached target veritysetup.target - Local Verity Protected Volumes. Oct 8 19:50:49.430295 systemd[1]: Listening on systemd-coredump.socket - Process Core Dump Socket. Oct 8 19:50:49.430306 systemd[1]: Listening on systemd-networkd.socket - Network Service Netlink Socket. Oct 8 19:50:49.430318 systemd[1]: Listening on systemd-udevd-control.socket - udev Control Socket. Oct 8 19:50:49.430328 systemd[1]: Listening on systemd-udevd-kernel.socket - udev Kernel Socket. Oct 8 19:50:49.430339 systemd[1]: Listening on systemd-userdbd.socket - User Database Manager Socket. Oct 8 19:50:49.430349 systemd[1]: Mounting dev-hugepages.mount - Huge Pages File System... Oct 8 19:50:49.430359 systemd[1]: Mounting dev-mqueue.mount - POSIX Message Queue File System... Oct 8 19:50:49.430369 systemd[1]: Mounting media.mount - External Media Directory... Oct 8 19:50:49.430380 systemd[1]: Mounting sys-kernel-debug.mount - Kernel Debug File System... Oct 8 19:50:49.430390 systemd[1]: Mounting sys-kernel-tracing.mount - Kernel Trace File System... Oct 8 19:50:49.430401 systemd[1]: Mounting tmp.mount - Temporary Directory /tmp... Oct 8 19:50:49.430412 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). Oct 8 19:50:49.430424 systemd[1]: Reached target machines.target - Containers. Oct 8 19:50:49.430434 systemd[1]: Starting flatcar-tmpfiles.service - Create missing system files... Oct 8 19:50:49.430445 systemd[1]: ignition-delete-config.service - Ignition (delete config) was skipped because of an unmet condition check (ConditionFirstBoot=true). Oct 8 19:50:49.430455 systemd[1]: Starting kmod-static-nodes.service - Create List of Static Device Nodes... Oct 8 19:50:49.430465 systemd[1]: Starting modprobe@configfs.service - Load Kernel Module configfs... Oct 8 19:50:49.430476 systemd[1]: Starting modprobe@dm_mod.service - Load Kernel Module dm_mod... Oct 8 19:50:49.430486 systemd[1]: Starting modprobe@drm.service - Load Kernel Module drm... Oct 8 19:50:49.430498 systemd[1]: Starting modprobe@efi_pstore.service - Load Kernel Module efi_pstore... Oct 8 19:50:49.430509 systemd[1]: Starting modprobe@fuse.service - Load Kernel Module fuse... Oct 8 19:50:49.430519 systemd[1]: Starting modprobe@loop.service - Load Kernel Module loop... Oct 8 19:50:49.430530 systemd[1]: setup-nsswitch.service - Create /etc/nsswitch.conf was skipped because of an unmet condition check (ConditionPathExists=!/etc/nsswitch.conf). Oct 8 19:50:49.430540 systemd[1]: systemd-fsck-root.service: Deactivated successfully. Oct 8 19:50:49.430550 systemd[1]: Stopped systemd-fsck-root.service - File System Check on Root Device. Oct 8 19:50:49.430561 systemd[1]: systemd-fsck-usr.service: Deactivated successfully. Oct 8 19:50:49.430571 kernel: fuse: init (API version 7.39) Oct 8 19:50:49.430582 systemd[1]: Stopped systemd-fsck-usr.service. Oct 8 19:50:49.430592 systemd[1]: Starting systemd-journald.service - Journal Service... Oct 8 19:50:49.430603 kernel: ACPI: bus type drm_connector registered Oct 8 19:50:49.430612 kernel: loop: module loaded Oct 8 19:50:49.430622 systemd[1]: Starting systemd-modules-load.service - Load Kernel Modules... Oct 8 19:50:49.430633 systemd[1]: Starting systemd-network-generator.service - Generate network units from Kernel command line... Oct 8 19:50:49.430644 systemd[1]: Starting systemd-remount-fs.service - Remount Root and Kernel File Systems... Oct 8 19:50:49.430655 systemd[1]: Starting systemd-udev-trigger.service - Coldplug All udev Devices... Oct 8 19:50:49.430665 systemd[1]: verity-setup.service: Deactivated successfully. Oct 8 19:50:49.430678 systemd[1]: Stopped verity-setup.service. Oct 8 19:50:49.430706 systemd-journald[1127]: Collecting audit messages is disabled. Oct 8 19:50:49.430728 systemd[1]: Mounted dev-hugepages.mount - Huge Pages File System. Oct 8 19:50:49.430738 systemd-journald[1127]: Journal started Oct 8 19:50:49.430759 systemd-journald[1127]: Runtime Journal (/run/log/journal/e441de33a5d54a67a2279c2da78f43d2) is 5.9M, max 47.3M, 41.4M free. Oct 8 19:50:49.221522 systemd[1]: Queued start job for default target multi-user.target. Oct 8 19:50:49.235285 systemd[1]: Unnecessary job was removed for dev-disk-by\x2duuid-e76368d9\x2d280c\x2d4d35\x2d9cf5\x2d9509759dd5b0.device - /dev/disk/by-uuid/e76368d9-280c-4d35-9cf5-9509759dd5b0. Oct 8 19:50:49.235299 systemd[1]: Unnecessary job was removed for dev-vdb6.device - /dev/vdb6. Oct 8 19:50:49.235701 systemd[1]: systemd-journald.service: Deactivated successfully. Oct 8 19:50:49.433050 systemd[1]: Started systemd-journald.service - Journal Service. Oct 8 19:50:49.433443 systemd[1]: Mounted dev-mqueue.mount - POSIX Message Queue File System. Oct 8 19:50:49.434822 systemd[1]: Mounted media.mount - External Media Directory. Oct 8 19:50:49.436120 systemd[1]: Mounted sys-kernel-debug.mount - Kernel Debug File System. Oct 8 19:50:49.437417 systemd[1]: Mounted sys-kernel-tracing.mount - Kernel Trace File System. Oct 8 19:50:49.438724 systemd[1]: Mounted tmp.mount - Temporary Directory /tmp. Oct 8 19:50:49.441180 systemd[1]: Finished flatcar-tmpfiles.service - Create missing system files. Oct 8 19:50:49.442694 systemd[1]: Finished kmod-static-nodes.service - Create List of Static Device Nodes. Oct 8 19:50:49.445503 systemd[1]: modprobe@configfs.service: Deactivated successfully. Oct 8 19:50:49.445658 systemd[1]: Finished modprobe@configfs.service - Load Kernel Module configfs. Oct 8 19:50:49.447121 systemd[1]: modprobe@dm_mod.service: Deactivated successfully. Oct 8 19:50:49.447331 systemd[1]: Finished modprobe@dm_mod.service - Load Kernel Module dm_mod. Oct 8 19:50:49.448815 systemd[1]: modprobe@drm.service: Deactivated successfully. Oct 8 19:50:49.448949 systemd[1]: Finished modprobe@drm.service - Load Kernel Module drm. Oct 8 19:50:49.450319 systemd[1]: modprobe@efi_pstore.service: Deactivated successfully. Oct 8 19:50:49.450444 systemd[1]: Finished modprobe@efi_pstore.service - Load Kernel Module efi_pstore. Oct 8 19:50:49.452037 systemd[1]: modprobe@fuse.service: Deactivated successfully. Oct 8 19:50:49.452225 systemd[1]: Finished modprobe@fuse.service - Load Kernel Module fuse. Oct 8 19:50:49.453573 systemd[1]: modprobe@loop.service: Deactivated successfully. Oct 8 19:50:49.453715 systemd[1]: Finished modprobe@loop.service - Load Kernel Module loop. Oct 8 19:50:49.455067 systemd[1]: Finished systemd-modules-load.service - Load Kernel Modules. Oct 8 19:50:49.456557 systemd[1]: Finished systemd-network-generator.service - Generate network units from Kernel command line. Oct 8 19:50:49.458025 systemd[1]: Finished systemd-remount-fs.service - Remount Root and Kernel File Systems. Oct 8 19:50:49.469710 systemd[1]: Reached target network-pre.target - Preparation for Network. Oct 8 19:50:49.483299 systemd[1]: Mounting sys-fs-fuse-connections.mount - FUSE Control File System... Oct 8 19:50:49.485511 systemd[1]: Mounting sys-kernel-config.mount - Kernel Configuration File System... Oct 8 19:50:49.486682 systemd[1]: remount-root.service - Remount Root File System was skipped because of an unmet condition check (ConditionPathIsReadWrite=!/). Oct 8 19:50:49.486728 systemd[1]: Reached target local-fs.target - Local File Systems. Oct 8 19:50:49.488799 systemd[1]: Listening on systemd-sysext.socket - System Extension Image Management (Varlink). Oct 8 19:50:49.491107 systemd[1]: Starting dracut-shutdown.service - Restore /run/initramfs on shutdown... Oct 8 19:50:49.493530 systemd[1]: Starting ldconfig.service - Rebuild Dynamic Linker Cache... Oct 8 19:50:49.494981 systemd[1]: systemd-binfmt.service - Set Up Additional Binary Formats was skipped because no trigger condition checks were met. Oct 8 19:50:49.496321 systemd[1]: Starting systemd-hwdb-update.service - Rebuild Hardware Database... Oct 8 19:50:49.499342 systemd[1]: Starting systemd-journal-flush.service - Flush Journal to Persistent Storage... Oct 8 19:50:49.500745 systemd[1]: systemd-pstore.service - Platform Persistent Storage Archival was skipped because of an unmet condition check (ConditionDirectoryNotEmpty=/sys/fs/pstore). Oct 8 19:50:49.501901 systemd[1]: Starting systemd-random-seed.service - Load/Save OS Random Seed... Oct 8 19:50:49.503209 systemd[1]: systemd-repart.service - Repartition Root Disk was skipped because no trigger condition checks were met. Oct 8 19:50:49.507116 systemd[1]: Starting systemd-sysctl.service - Apply Kernel Variables... Oct 8 19:50:49.510544 systemd-journald[1127]: Time spent on flushing to /var/log/journal/e441de33a5d54a67a2279c2da78f43d2 is 49.017ms for 680 entries. Oct 8 19:50:49.510544 systemd-journald[1127]: System Journal (/var/log/journal/e441de33a5d54a67a2279c2da78f43d2) is 13.0M, max 204.2M, 191.1M free. Oct 8 19:50:49.572928 systemd-journald[1127]: Received client request to flush runtime journal. Oct 8 19:50:49.572989 systemd-journald[1127]: /var/log/journal/e441de33a5d54a67a2279c2da78f43d2/system.journal: Journal file uses a different sequence number ID, rotating. Oct 8 19:50:49.573015 systemd-journald[1127]: Rotating system journal. Oct 8 19:50:49.573038 kernel: loop0: detected capacity change from 0 to 59688 Oct 8 19:50:49.573059 kernel: block loop0: the capability attribute has been deprecated. Oct 8 19:50:49.573179 kernel: squashfs: version 4.0 (2009/01/31) Phillip Lougher Oct 8 19:50:49.512366 systemd[1]: Starting systemd-sysext.service - Merge System Extension Images into /usr/ and /opt/... Oct 8 19:50:49.515345 systemd[1]: Starting systemd-sysusers.service - Create System Users... Oct 8 19:50:49.518116 systemd[1]: Finished systemd-udev-trigger.service - Coldplug All udev Devices. Oct 8 19:50:49.522483 systemd[1]: Mounted sys-fs-fuse-connections.mount - FUSE Control File System. Oct 8 19:50:49.524202 systemd[1]: Mounted sys-kernel-config.mount - Kernel Configuration File System. Oct 8 19:50:49.528618 systemd[1]: Finished dracut-shutdown.service - Restore /run/initramfs on shutdown. Oct 8 19:50:49.531420 systemd[1]: Finished systemd-random-seed.service - Load/Save OS Random Seed. Oct 8 19:50:49.536542 systemd[1]: first-boot-complete.target - First Boot Complete was skipped because of an unmet condition check (ConditionFirstBoot=yes). Oct 8 19:50:49.536636 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). Oct 8 19:50:49.543431 systemd[1]: Starting systemd-udev-settle.service - Wait for udev To Complete Device Initialization... Oct 8 19:50:49.545057 systemd[1]: Finished systemd-sysctl.service - Apply Kernel Variables. Oct 8 19:50:49.554103 udevadm[1183]: systemd-udev-settle.service is deprecated. Please fix lvm2-activation.service, lvm2-activation-early.service not to pull it in. Oct 8 19:50:49.575574 systemd[1]: Finished systemd-journal-flush.service - Flush Journal to Persistent Storage. Oct 8 19:50:49.584232 systemd[1]: Finished systemd-sysusers.service - Create System Users. Oct 8 19:50:49.586171 kernel: loop1: detected capacity change from 0 to 113672 Oct 8 19:50:49.593598 systemd[1]: Starting systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev... Oct 8 19:50:49.611179 kernel: loop2: detected capacity change from 0 to 59688 Oct 8 19:50:49.613766 systemd-tmpfiles[1192]: ACLs are not supported, ignoring. Oct 8 19:50:49.613788 systemd-tmpfiles[1192]: ACLs are not supported, ignoring. Oct 8 19:50:49.618542 systemd[1]: Finished systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev. Oct 8 19:50:49.630194 kernel: loop3: detected capacity change from 0 to 113672 Oct 8 19:50:49.634485 (sd-merge)[1196]: Using extensions 'containerd-flatcar', 'docker-flatcar'. Oct 8 19:50:49.634918 (sd-merge)[1196]: Merged extensions into '/usr'. Oct 8 19:50:49.638379 systemd[1]: Finished systemd-sysext.service - Merge System Extension Images into /usr/ and /opt/. Oct 8 19:50:49.648366 systemd[1]: Starting ensure-sysext.service... Oct 8 19:50:49.651261 systemd[1]: Starting systemd-tmpfiles-setup.service - Create Volatile Files and Directories... Oct 8 19:50:49.655987 ldconfig[1166]: /sbin/ldconfig: /lib/ld.so.conf is not an ELF file - it has the wrong magic bytes at the start. Oct 8 19:50:49.662388 systemd[1]: Reloading requested from client PID 1199 ('systemctl') (unit ensure-sysext.service)... Oct 8 19:50:49.662402 systemd[1]: Reloading... Oct 8 19:50:49.670345 systemd-tmpfiles[1200]: /usr/lib/tmpfiles.d/provision.conf:20: Duplicate line for path "/root", ignoring. Oct 8 19:50:49.670603 systemd-tmpfiles[1200]: /usr/lib/tmpfiles.d/systemd-flatcar.conf:6: Duplicate line for path "/var/log/journal", ignoring. Oct 8 19:50:49.671308 systemd-tmpfiles[1200]: /usr/lib/tmpfiles.d/systemd.conf:29: Duplicate line for path "/var/lib/systemd", ignoring. Oct 8 19:50:49.671533 systemd-tmpfiles[1200]: ACLs are not supported, ignoring. Oct 8 19:50:49.671579 systemd-tmpfiles[1200]: ACLs are not supported, ignoring. Oct 8 19:50:49.675041 systemd-tmpfiles[1200]: Detected autofs mount point /boot during canonicalization of boot. Oct 8 19:50:49.675054 systemd-tmpfiles[1200]: Skipping /boot Oct 8 19:50:49.683296 systemd-tmpfiles[1200]: Detected autofs mount point /boot during canonicalization of boot. Oct 8 19:50:49.683312 systemd-tmpfiles[1200]: Skipping /boot Oct 8 19:50:49.712948 zram_generator::config[1226]: No configuration found. Oct 8 19:50:49.794896 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. Oct 8 19:50:49.838167 systemd[1]: Reloading finished in 175 ms. Oct 8 19:50:49.864910 systemd[1]: Finished ldconfig.service - Rebuild Dynamic Linker Cache. Oct 8 19:50:49.876559 systemd[1]: Finished systemd-tmpfiles-setup.service - Create Volatile Files and Directories. Oct 8 19:50:49.883172 systemd[1]: Starting audit-rules.service - Load Security Auditing Rules... Oct 8 19:50:49.885458 systemd[1]: Starting clean-ca-certificates.service - Clean up broken links in /etc/ssl/certs... Oct 8 19:50:49.889336 systemd[1]: Starting systemd-journal-catalog-update.service - Rebuild Journal Catalog... Oct 8 19:50:49.897342 systemd[1]: Starting systemd-resolved.service - Network Name Resolution... Oct 8 19:50:49.899605 systemd[1]: Starting systemd-update-utmp.service - Record System Boot/Shutdown in UTMP... Oct 8 19:50:49.904024 systemd[1]: ignition-delete-config.service - Ignition (delete config) was skipped because of an unmet condition check (ConditionFirstBoot=true). Oct 8 19:50:49.905120 systemd[1]: Starting modprobe@dm_mod.service - Load Kernel Module dm_mod... Oct 8 19:50:49.909477 systemd[1]: Starting modprobe@efi_pstore.service - Load Kernel Module efi_pstore... Oct 8 19:50:49.917512 systemd[1]: Starting modprobe@loop.service - Load Kernel Module loop... Oct 8 19:50:49.921294 systemd[1]: systemd-binfmt.service - Set Up Additional Binary Formats was skipped because no trigger condition checks were met. Oct 8 19:50:49.921443 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). Oct 8 19:50:49.922298 systemd[1]: modprobe@dm_mod.service: Deactivated successfully. Oct 8 19:50:49.922593 systemd[1]: Finished modprobe@dm_mod.service - Load Kernel Module dm_mod. Oct 8 19:50:49.924378 systemd[1]: modprobe@efi_pstore.service: Deactivated successfully. Oct 8 19:50:49.926195 systemd[1]: Finished modprobe@efi_pstore.service - Load Kernel Module efi_pstore. Oct 8 19:50:49.928258 systemd[1]: modprobe@loop.service: Deactivated successfully. Oct 8 19:50:49.928378 systemd[1]: Finished modprobe@loop.service - Load Kernel Module loop. Oct 8 19:50:49.930198 systemd[1]: Finished systemd-journal-catalog-update.service - Rebuild Journal Catalog. Oct 8 19:50:49.936064 augenrules[1260]: /sbin/augenrules: No change Oct 8 19:50:49.938499 systemd[1]: ignition-delete-config.service - Ignition (delete config) was skipped because of an unmet condition check (ConditionFirstBoot=true). Oct 8 19:50:49.946910 augenrules[1282]: No rules Oct 8 19:50:49.947071 systemd[1]: Starting modprobe@dm_mod.service - Load Kernel Module dm_mod... Oct 8 19:50:49.949377 systemd[1]: Starting modprobe@efi_pstore.service - Load Kernel Module efi_pstore... Oct 8 19:50:49.951591 systemd[1]: Starting modprobe@loop.service - Load Kernel Module loop... Oct 8 19:50:49.952798 systemd[1]: systemd-binfmt.service - Set Up Additional Binary Formats was skipped because no trigger condition checks were met. Oct 8 19:50:49.952945 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). Oct 8 19:50:49.955266 systemd[1]: Starting systemd-userdbd.service - User Database Manager... Oct 8 19:50:49.958030 systemd[1]: Finished audit-rules.service - Load Security Auditing Rules. Oct 8 19:50:49.959874 systemd[1]: Finished clean-ca-certificates.service - Clean up broken links in /etc/ssl/certs. Oct 8 19:50:49.963054 systemd[1]: Finished systemd-update-utmp.service - Record System Boot/Shutdown in UTMP. Oct 8 19:50:49.964928 systemd[1]: modprobe@dm_mod.service: Deactivated successfully. Oct 8 19:50:49.965050 systemd[1]: Finished modprobe@dm_mod.service - Load Kernel Module dm_mod. Oct 8 19:50:49.966692 systemd[1]: modprobe@efi_pstore.service: Deactivated successfully. Oct 8 19:50:49.966822 systemd[1]: Finished modprobe@efi_pstore.service - Load Kernel Module efi_pstore. Oct 8 19:50:49.968644 systemd[1]: modprobe@loop.service: Deactivated successfully. Oct 8 19:50:49.968782 systemd[1]: Finished modprobe@loop.service - Load Kernel Module loop. Oct 8 19:50:49.977276 systemd[1]: ignition-delete-config.service - Ignition (delete config) was skipped because of an unmet condition check (ConditionFirstBoot=true). Oct 8 19:50:49.984726 systemd[1]: Starting modprobe@dm_mod.service - Load Kernel Module dm_mod... Oct 8 19:50:49.987312 systemd[1]: Starting modprobe@drm.service - Load Kernel Module drm... Oct 8 19:50:49.994435 systemd[1]: Starting modprobe@efi_pstore.service - Load Kernel Module efi_pstore... Oct 8 19:50:49.999593 systemd[1]: Starting modprobe@loop.service - Load Kernel Module loop... Oct 8 19:50:50.000823 systemd[1]: systemd-binfmt.service - Set Up Additional Binary Formats was skipped because no trigger condition checks were met. Oct 8 19:50:50.001031 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). Oct 8 19:50:50.001247 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). Oct 8 19:50:50.002097 systemd[1]: Started systemd-userdbd.service - User Database Manager. Oct 8 19:50:50.004189 systemd[1]: modprobe@dm_mod.service: Deactivated successfully. Oct 8 19:50:50.004360 systemd[1]: Finished modprobe@dm_mod.service - Load Kernel Module dm_mod. Oct 8 19:50:50.006283 systemd[1]: modprobe@drm.service: Deactivated successfully. Oct 8 19:50:50.006432 systemd[1]: Finished modprobe@drm.service - Load Kernel Module drm. Oct 8 19:50:50.008106 systemd[1]: modprobe@efi_pstore.service: Deactivated successfully. Oct 8 19:50:50.008340 systemd[1]: Finished modprobe@efi_pstore.service - Load Kernel Module efi_pstore. Oct 8 19:50:50.010255 systemd[1]: modprobe@loop.service: Deactivated successfully. Oct 8 19:50:50.010394 systemd[1]: Finished modprobe@loop.service - Load Kernel Module loop. Oct 8 19:50:50.015109 systemd[1]: systemd-pstore.service - Platform Persistent Storage Archival was skipped because of an unmet condition check (ConditionDirectoryNotEmpty=/sys/fs/pstore). Oct 8 19:50:50.015262 systemd[1]: systemd-repart.service - Repartition Root Disk was skipped because no trigger condition checks were met. Oct 8 19:50:50.016416 systemd[1]: Finished ensure-sysext.service. Oct 8 19:50:50.026448 systemd[1]: Starting systemd-timesyncd.service - Network Time Synchronization... Oct 8 19:50:50.029189 systemd[1]: Finished systemd-hwdb-update.service - Rebuild Hardware Database. Oct 8 19:50:50.033094 systemd[1]: Starting systemd-udevd.service - Rule-based Manager for Device Events and Files... Oct 8 19:50:50.036485 systemd[1]: Starting systemd-update-done.service - Update is Completed... Oct 8 19:50:50.047759 systemd-resolved[1267]: Positive Trust Anchors: Oct 8 19:50:50.047780 systemd-resolved[1267]: . IN DS 20326 8 2 e06d44b80b8f1d39a95c0b0d7c65d08458e880409bbc683457104237c7f8ec8d Oct 8 19:50:50.047812 systemd-resolved[1267]: 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 Oct 8 19:50:50.054403 systemd[1]: Finished systemd-update-done.service - Update is Completed. Oct 8 19:50:50.055647 systemd-resolved[1267]: Defaulting to hostname 'linux'. Oct 8 19:50:50.059857 systemd[1]: Started systemd-resolved.service - Network Name Resolution. Oct 8 19:50:50.061288 systemd-udevd[1311]: Using default interface naming scheme 'v255'. Oct 8 19:50:50.061523 systemd[1]: Reached target nss-lookup.target - Host and Network Name Lookups. Oct 8 19:50:50.071952 systemd[1]: Started systemd-timesyncd.service - Network Time Synchronization. Oct 8 19:50:50.073528 systemd[1]: Reached target time-set.target - System Time Set. Oct 8 19:50:50.076920 systemd[1]: Started systemd-udevd.service - Rule-based Manager for Device Events and Files. Oct 8 19:50:50.087432 systemd[1]: Starting systemd-networkd.service - Network Configuration... Oct 8 19:50:50.109876 systemd[1]: Condition check resulted in dev-ttyAMA0.device - /dev/ttyAMA0 being skipped. Oct 8 19:50:50.118219 kernel: BTRFS warning: duplicate device /dev/vdb3 devid 1 generation 36 scanned by (udev-worker) (1330) Oct 8 19:50:50.118306 kernel: BTRFS info: devid 1 device path /dev/mapper/usr changed to /dev/dm-0 scanned by (udev-worker) (1321) Oct 8 19:50:50.148558 systemd-networkd[1324]: lo: Link UP Oct 8 19:50:50.148566 systemd-networkd[1324]: lo: Gained carrier Oct 8 19:50:50.149806 systemd-networkd[1324]: Enumeration completed Oct 8 19:50:50.149920 systemd[1]: Started systemd-networkd.service - Network Configuration. Oct 8 19:50:50.150724 systemd-networkd[1324]: eth0: found matching network '/usr/lib/systemd/network/zz-default.network', based on potentially unpredictable interface name. Oct 8 19:50:50.150732 systemd-networkd[1324]: eth0: Configuring with /usr/lib/systemd/network/zz-default.network. Oct 8 19:50:50.151277 systemd[1]: Reached target network.target - Network. Oct 8 19:50:50.151544 systemd-networkd[1324]: eth0: Link UP Oct 8 19:50:50.151548 systemd-networkd[1324]: eth0: Gained carrier Oct 8 19:50:50.151561 systemd-networkd[1324]: eth0: found matching network '/usr/lib/systemd/network/zz-default.network', based on potentially unpredictable interface name. Oct 8 19:50:50.161616 systemd[1]: Starting systemd-networkd-wait-online.service - Wait for Network to be Configured... Oct 8 19:50:50.164224 systemd[1]: Found device dev-disk-by\x2dlabel-OEM.device - /dev/disk/by-label/OEM. Oct 8 19:50:50.166740 systemd[1]: Starting systemd-fsck@dev-disk-by\x2dlabel-OEM.service - File System Check on /dev/disk/by-label/OEM... Oct 8 19:50:50.167700 systemd-networkd[1324]: eth0: DHCPv4 address 10.0.0.104/16, gateway 10.0.0.1 acquired from 10.0.0.1 Oct 8 19:50:50.168815 systemd-networkd[1324]: eth0: found matching network '/usr/lib/systemd/network/zz-default.network', based on potentially unpredictable interface name. Oct 8 19:50:50.169397 systemd-timesyncd[1309]: Network configuration changed, trying to establish connection. Oct 8 19:50:50.192465 systemd[1]: Finished systemd-fsck@dev-disk-by\x2dlabel-OEM.service - File System Check on /dev/disk/by-label/OEM. Oct 8 19:50:50.220469 systemd[1]: Starting systemd-vconsole-setup.service - Virtual Console Setup... Oct 8 19:50:50.227628 systemd[1]: Finished systemd-udev-settle.service - Wait for udev To Complete Device Initialization. Oct 8 19:50:50.231028 systemd[1]: Starting lvm2-activation-early.service - Activation of LVM2 logical volumes... Oct 8 19:50:50.244266 lvm[1351]: WARNING: Failed to connect to lvmetad. Falling back to device scanning. Oct 8 19:50:50.266172 systemd[1]: Finished systemd-vconsole-setup.service - Virtual Console Setup. Oct 8 19:50:50.278698 systemd[1]: Finished lvm2-activation-early.service - Activation of LVM2 logical volumes. Oct 8 19:50:50.280284 systemd[1]: Reached target cryptsetup.target - Local Encrypted Volumes. Oct 8 19:50:50.281453 systemd[1]: Reached target sysinit.target - System Initialization. Oct 8 19:50:50.282614 systemd[1]: Started motdgen.path - Watch for update engine configuration changes. Oct 8 19:50:50.283895 systemd[1]: Started user-cloudinit@var-lib-flatcar\x2dinstall-user_data.path - Watch for a cloud-config at /var/lib/flatcar-install/user_data. Oct 8 19:50:50.285483 systemd[1]: Started logrotate.timer - Daily rotation of log files. Oct 8 19:50:50.286619 systemd[1]: Started mdadm.timer - Weekly check for MD array's redundancy information.. Oct 8 19:50:50.287910 systemd[1]: Started systemd-tmpfiles-clean.timer - Daily Cleanup of Temporary Directories. Oct 8 19:50:50.289166 systemd[1]: update-engine-stub.timer - Update Engine Stub Timer was skipped because of an unmet condition check (ConditionPathExists=/usr/.noupdate). Oct 8 19:50:50.289205 systemd[1]: Reached target paths.target - Path Units. Oct 8 19:50:50.290087 systemd[1]: Reached target timers.target - Timer Units. Oct 8 19:50:50.292245 systemd[1]: Listening on dbus.socket - D-Bus System Message Bus Socket. Oct 8 19:50:50.294683 systemd[1]: Starting docker.socket - Docker Socket for the API... Oct 8 19:50:50.305196 systemd[1]: Listening on sshd.socket - OpenSSH Server Socket. Oct 8 19:50:50.307539 systemd[1]: Starting lvm2-activation.service - Activation of LVM2 logical volumes... Oct 8 19:50:50.309322 systemd[1]: Listening on docker.socket - Docker Socket for the API. Oct 8 19:50:50.310561 systemd[1]: Reached target sockets.target - Socket Units. Oct 8 19:50:50.311555 systemd[1]: Reached target basic.target - Basic System. Oct 8 19:50:50.312567 systemd[1]: addon-config@oem.service - Configure Addon /oem was skipped because no trigger condition checks were met. Oct 8 19:50:50.312598 systemd[1]: addon-run@oem.service - Run Addon /oem was skipped because no trigger condition checks were met. Oct 8 19:50:50.313613 systemd[1]: Starting containerd.service - containerd container runtime... Oct 8 19:50:50.314724 systemd[1]: cryptenroll-helper-bind.service was skipped because of an unmet condition check (ConditionPathExists=/etc/luks/rootencrypted-bind). Oct 8 19:50:50.315788 systemd[1]: Starting dbus.service - D-Bus System Message Bus... Oct 8 19:50:50.318285 lvm[1359]: WARNING: Failed to connect to lvmetad. Falling back to device scanning. Oct 8 19:50:50.319036 systemd[1]: Starting enable-oem-cloudinit.service - Enable cloudinit... Oct 8 19:50:50.322009 systemd[1]: Starting extend-filesystems.service - Extend Filesystems... Oct 8 19:50:50.324236 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). Oct 8 19:50:50.325448 systemd[1]: Starting motdgen.service - Generate /run/flatcar/motd... Oct 8 19:50:50.327929 systemd[1]: Starting ssh-key-proc-cmdline.service - Install an ssh key from /proc/cmdline... Oct 8 19:50:50.332311 systemd[1]: Starting sshd-keygen.service - Generate sshd host keys... Oct 8 19:50:50.337164 jq[1362]: false Oct 8 19:50:50.336224 systemd[1]: Starting systemd-logind.service - User Login Management... Oct 8 19:50:50.344262 systemd[1]: tcsd.service - TCG Core Services Daemon was skipped because of an unmet condition check (ConditionSecurity=!tpm2). Oct 8 19:50:50.345320 systemd[1]: cgroup compatibility translation between legacy and unified hierarchy settings activated. See cgroup-compat debug messages for details. Oct 8 19:50:50.346838 systemd[1]: Starting update-engine.service - Update Engine... Oct 8 19:50:50.350265 systemd[1]: Starting update-ssh-keys-after-ignition.service - Run update-ssh-keys once after Ignition... Oct 8 19:50:50.353574 systemd[1]: Finished lvm2-activation.service - Activation of LVM2 logical volumes. Oct 8 19:50:50.359797 systemd[1]: enable-oem-cloudinit.service: Skipped due to 'exec-condition'. Oct 8 19:50:50.359976 systemd[1]: Condition check resulted in enable-oem-cloudinit.service - Enable cloudinit being skipped. Oct 8 19:50:50.360288 systemd[1]: ssh-key-proc-cmdline.service: Deactivated successfully. Oct 8 19:50:50.360454 systemd[1]: Finished ssh-key-proc-cmdline.service - Install an ssh key from /proc/cmdline. Oct 8 19:50:50.362168 extend-filesystems[1363]: Found loop2 Oct 8 19:50:50.362168 extend-filesystems[1363]: Found loop3 Oct 8 19:50:50.362168 extend-filesystems[1363]: Found vda Oct 8 19:50:50.362168 extend-filesystems[1363]: Found vdb Oct 8 19:50:50.362168 extend-filesystems[1363]: Found vdb1 Oct 8 19:50:50.362168 extend-filesystems[1363]: Found vdb2 Oct 8 19:50:50.362168 extend-filesystems[1363]: Found vdb3 Oct 8 19:50:50.362168 extend-filesystems[1363]: Found usr Oct 8 19:50:50.362168 extend-filesystems[1363]: Found vdb4 Oct 8 19:50:50.362168 extend-filesystems[1363]: Found vdb6 Oct 8 19:50:50.362168 extend-filesystems[1363]: Found vdb7 Oct 8 19:50:50.362168 extend-filesystems[1363]: Found vdb9 Oct 8 19:50:50.362168 extend-filesystems[1363]: Found rootencrypted Oct 8 19:50:50.395630 jq[1375]: true Oct 8 19:50:50.376572 dbus-daemon[1361]: [system] SELinux support is enabled Oct 8 19:50:50.364614 systemd[1]: extend-filesystems.service: Deactivated successfully. Oct 8 19:50:50.364791 systemd[1]: Finished extend-filesystems.service - Extend Filesystems. Oct 8 19:50:50.396274 jq[1380]: false Oct 8 19:50:50.375832 systemd[1]: update-ssh-keys-after-ignition.service: Skipped due to 'exec-condition'. Oct 8 19:50:50.376022 systemd[1]: Condition check resulted in update-ssh-keys-after-ignition.service - Run update-ssh-keys once after Ignition being skipped. Oct 8 19:50:50.377290 systemd[1]: Started dbus.service - D-Bus System Message Bus. Oct 8 19:50:50.377830 (ntainerd)[1382]: containerd.service: Referenced but unset environment variable evaluates to an empty string: TORCX_IMAGEDIR, TORCX_UNPACKDIR Oct 8 19:50:50.383753 systemd[1]: motdgen.service: Deactivated successfully. Oct 8 19:50:50.384003 systemd[1]: Finished motdgen.service - Generate /run/flatcar/motd. Oct 8 19:50:50.390484 systemd[1]: Created slice system-sshd.slice - Slice /system/sshd. Oct 8 19:50:50.391877 systemd[1]: sshkeys.service was skipped because no trigger condition checks were met. Oct 8 19:50:50.391967 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). Oct 8 19:50:50.391990 systemd[1]: Reached target system-config.target - Load system-provided cloud configs. Oct 8 19:50:50.393612 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). Oct 8 19:50:50.393628 systemd[1]: Reached target user-config.target - Load user-provided cloud configs. Oct 8 19:50:50.404240 systemd-logind[1368]: Watching system buttons on /dev/input/event0 (Power Button) Oct 8 19:50:50.405473 systemd-logind[1368]: New seat seat0. Oct 8 19:50:50.408259 systemd[1]: Started systemd-logind.service - User Login Management. Oct 8 19:50:50.418321 systemd[1]: Finished sshd-keygen.service - Generate sshd host keys. Oct 8 19:50:50.435800 systemd[1]: Starting issuegen.service - Generate /run/issue... Oct 8 19:50:50.440500 systemd[1]: Started sshd@0-10.0.0.104:22-10.0.0.1:38050.service - OpenSSH per-connection server daemon (10.0.0.1:38050). Oct 8 19:50:50.440840 update_engine[1373]: I1008 19:50:50.440215 1373 main.cc:92] Flatcar Update Engine starting Oct 8 19:50:50.442495 update_engine[1373]: I1008 19:50:50.442445 1373 update_check_scheduler.cc:74] Next update check in 10m19s Oct 8 19:50:50.443395 systemd[1]: issuegen.service: Deactivated successfully. Oct 8 19:50:50.444209 systemd[1]: Finished issuegen.service - Generate /run/issue. Oct 8 19:50:50.446261 systemd[1]: Started update-engine.service - Update Engine. Oct 8 19:50:50.449717 systemd[1]: Starting systemd-user-sessions.service - Permit User Sessions... Oct 8 19:50:50.455067 systemd[1]: Started locksmithd.service - Cluster reboot manager. Oct 8 19:50:50.464263 systemd[1]: Finished systemd-user-sessions.service - Permit User Sessions. Oct 8 19:50:50.482795 systemd[1]: Started getty@tty1.service - Getty on tty1. Oct 8 19:50:50.485516 systemd[1]: Started serial-getty@ttyAMA0.service - Serial Getty on ttyAMA0. Oct 8 19:50:50.486865 systemd[1]: Reached target getty.target - Login Prompts. Oct 8 19:50:50.500159 locksmithd[1411]: locksmithd starting currentOperation="UPDATE_STATUS_IDLE" strategy="reboot" Oct 8 19:50:50.525009 sshd[1401]: Accepted publickey for core from 10.0.0.1 port 38050 ssh2: RSA SHA256:7GlzoUcthdqM2/gWbc3rpA5Lm+7Qkd3pe7wSn/JGGIM Oct 8 19:50:50.527754 sshd[1401]: pam_unix(sshd:session): session opened for user core(uid=500) by (uid=0) Oct 8 19:50:50.539333 systemd[1]: Created slice user-500.slice - User Slice of UID 500. Oct 8 19:50:50.557505 systemd[1]: Starting user-runtime-dir@500.service - User Runtime Directory /run/user/500... Oct 8 19:50:50.562247 systemd-logind[1368]: New session 1 of user core. Oct 8 19:50:50.570164 systemd[1]: Finished user-runtime-dir@500.service - User Runtime Directory /run/user/500. Oct 8 19:50:50.577488 systemd[1]: Starting user@500.service - User Manager for UID 500... Oct 8 19:50:50.583685 (systemd)[1424]: pam_unix(systemd-user:session): session opened for user core(uid=500) by (uid=0) Oct 8 19:50:50.599194 containerd[1382]: time="2024-10-08T19:50:50.599085000Z" level=info msg="starting containerd" revision=1fbfc07f8d28210e62bdbcbf7b950bac8028afbf version=v1.7.17 Oct 8 19:50:50.623334 containerd[1382]: time="2024-10-08T19:50:50.623273480Z" level=info msg="loading plugin \"io.containerd.warning.v1.deprecations\"..." type=io.containerd.warning.v1 Oct 8 19:50:50.623334 containerd[1382]: time="2024-10-08T19:50:50.623324880Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.aufs\"..." type=io.containerd.snapshotter.v1 Oct 8 19:50:50.624911 containerd[1382]: time="2024-10-08T19:50:50.624576200Z" 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.54-flatcar\\n\"): skip plugin" type=io.containerd.snapshotter.v1 Oct 8 19:50:50.624911 containerd[1382]: time="2024-10-08T19:50:50.624614680Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.btrfs\"..." type=io.containerd.snapshotter.v1 Oct 8 19:50:50.624911 containerd[1382]: time="2024-10-08T19:50:50.624802680Z" 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 Oct 8 19:50:50.624911 containerd[1382]: time="2024-10-08T19:50:50.624819160Z" level=info msg="loading plugin \"io.containerd.content.v1.content\"..." type=io.containerd.content.v1 Oct 8 19:50:50.625208 containerd[1382]: time="2024-10-08T19:50:50.625118840Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.blockfile\"..." type=io.containerd.snapshotter.v1 Oct 8 19:50:50.625321 containerd[1382]: time="2024-10-08T19:50:50.625302000Z" level=info msg="skip loading plugin \"io.containerd.snapshotter.v1.blockfile\"..." error="no scratch file generator: skip plugin" type=io.containerd.snapshotter.v1 Oct 8 19:50:50.625451 containerd[1382]: time="2024-10-08T19:50:50.625377640Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.native\"..." type=io.containerd.snapshotter.v1 Oct 8 19:50:50.625561 containerd[1382]: time="2024-10-08T19:50:50.625545480Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.overlayfs\"..." type=io.containerd.snapshotter.v1 Oct 8 19:50:50.625847 containerd[1382]: time="2024-10-08T19:50:50.625827280Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.devmapper\"..." type=io.containerd.snapshotter.v1 Oct 8 19:50:50.625922 containerd[1382]: time="2024-10-08T19:50:50.625908040Z" level=warning msg="failed to load plugin io.containerd.snapshotter.v1.devmapper" error="devmapper not configured" Oct 8 19:50:50.626259 containerd[1382]: time="2024-10-08T19:50:50.625968360Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.zfs\"..." type=io.containerd.snapshotter.v1 Oct 8 19:50:50.626259 containerd[1382]: time="2024-10-08T19:50:50.626091240Z" 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 Oct 8 19:50:50.626259 containerd[1382]: time="2024-10-08T19:50:50.626106360Z" level=info msg="loading plugin \"io.containerd.metadata.v1.bolt\"..." type=io.containerd.metadata.v1 Oct 8 19:50:50.626259 containerd[1382]: time="2024-10-08T19:50:50.626171480Z" level=warning msg="could not use snapshotter devmapper in metadata plugin" error="devmapper not configured" Oct 8 19:50:50.626259 containerd[1382]: time="2024-10-08T19:50:50.626185160Z" level=info msg="metadata content store policy set" policy=shared Oct 8 19:50:50.626897 containerd[1382]: time="2024-10-08T19:50:50.626874200Z" level=info msg="loading plugin \"io.containerd.differ.v1.walking\"..." type=io.containerd.differ.v1 Oct 8 19:50:50.626978 containerd[1382]: time="2024-10-08T19:50:50.626965000Z" level=info msg="loading plugin \"io.containerd.event.v1.exchange\"..." type=io.containerd.event.v1 Oct 8 19:50:50.627029 containerd[1382]: time="2024-10-08T19:50:50.627017760Z" level=info msg="loading plugin \"io.containerd.gc.v1.scheduler\"..." type=io.containerd.gc.v1 Oct 8 19:50:50.627122 containerd[1382]: time="2024-10-08T19:50:50.627107760Z" level=info msg="loading plugin \"io.containerd.lease.v1.manager\"..." type=io.containerd.lease.v1 Oct 8 19:50:50.627212 containerd[1382]: time="2024-10-08T19:50:50.627198840Z" level=info msg="loading plugin \"io.containerd.nri.v1.nri\"..." type=io.containerd.nri.v1 Oct 8 19:50:50.627261 containerd[1382]: time="2024-10-08T19:50:50.627250680Z" level=info msg="NRI interface is disabled by configuration." Oct 8 19:50:50.627314 containerd[1382]: time="2024-10-08T19:50:50.627301680Z" level=info msg="loading plugin \"io.containerd.runtime.v2.task\"..." type=io.containerd.runtime.v2 Oct 8 19:50:50.627457 containerd[1382]: time="2024-10-08T19:50:50.627439320Z" level=info msg="loading plugin \"io.containerd.runtime.v2.shim\"..." type=io.containerd.runtime.v2 Oct 8 19:50:50.627518 containerd[1382]: time="2024-10-08T19:50:50.627505320Z" level=info msg="loading plugin \"io.containerd.sandbox.store.v1.local\"..." type=io.containerd.sandbox.store.v1 Oct 8 19:50:50.627569 containerd[1382]: time="2024-10-08T19:50:50.627557080Z" level=info msg="loading plugin \"io.containerd.sandbox.controller.v1.local\"..." type=io.containerd.sandbox.controller.v1 Oct 8 19:50:50.627622 containerd[1382]: time="2024-10-08T19:50:50.627609560Z" level=info msg="loading plugin \"io.containerd.streaming.v1.manager\"..." type=io.containerd.streaming.v1 Oct 8 19:50:50.627675 containerd[1382]: time="2024-10-08T19:50:50.627662360Z" level=info msg="loading plugin \"io.containerd.service.v1.introspection-service\"..." type=io.containerd.service.v1 Oct 8 19:50:50.627731 containerd[1382]: time="2024-10-08T19:50:50.627718560Z" level=info msg="loading plugin \"io.containerd.service.v1.containers-service\"..." type=io.containerd.service.v1 Oct 8 19:50:50.627797 containerd[1382]: time="2024-10-08T19:50:50.627783840Z" level=info msg="loading plugin \"io.containerd.service.v1.content-service\"..." type=io.containerd.service.v1 Oct 8 19:50:50.627851 containerd[1382]: time="2024-10-08T19:50:50.627837880Z" level=info msg="loading plugin \"io.containerd.service.v1.diff-service\"..." type=io.containerd.service.v1 Oct 8 19:50:50.627904 containerd[1382]: time="2024-10-08T19:50:50.627892360Z" level=info msg="loading plugin \"io.containerd.service.v1.images-service\"..." type=io.containerd.service.v1 Oct 8 19:50:50.627960 containerd[1382]: time="2024-10-08T19:50:50.627947440Z" level=info msg="loading plugin \"io.containerd.service.v1.namespaces-service\"..." type=io.containerd.service.v1 Oct 8 19:50:50.628011 containerd[1382]: time="2024-10-08T19:50:50.627998720Z" level=info msg="loading plugin \"io.containerd.service.v1.snapshots-service\"..." type=io.containerd.service.v1 Oct 8 19:50:50.628592 containerd[1382]: time="2024-10-08T19:50:50.628051000Z" level=info msg="loading plugin \"io.containerd.runtime.v1.linux\"..." type=io.containerd.runtime.v1 Oct 8 19:50:50.628592 containerd[1382]: time="2024-10-08T19:50:50.628168320Z" level=info msg="loading plugin \"io.containerd.monitor.v1.cgroups\"..." type=io.containerd.monitor.v1 Oct 8 19:50:50.628592 containerd[1382]: time="2024-10-08T19:50:50.628391120Z" level=info msg="loading plugin \"io.containerd.service.v1.tasks-service\"..." type=io.containerd.service.v1 Oct 8 19:50:50.628592 containerd[1382]: time="2024-10-08T19:50:50.628417240Z" level=info msg="loading plugin \"io.containerd.grpc.v1.introspection\"..." type=io.containerd.grpc.v1 Oct 8 19:50:50.628592 containerd[1382]: time="2024-10-08T19:50:50.628431200Z" level=info msg="loading plugin \"io.containerd.transfer.v1.local\"..." type=io.containerd.transfer.v1 Oct 8 19:50:50.628592 containerd[1382]: time="2024-10-08T19:50:50.628454520Z" level=info msg="loading plugin \"io.containerd.internal.v1.restart\"..." type=io.containerd.internal.v1 Oct 8 19:50:50.628592 containerd[1382]: time="2024-10-08T19:50:50.628578600Z" level=info msg="loading plugin \"io.containerd.grpc.v1.containers\"..." type=io.containerd.grpc.v1 Oct 8 19:50:50.628592 containerd[1382]: time="2024-10-08T19:50:50.628592520Z" level=info msg="loading plugin \"io.containerd.grpc.v1.content\"..." type=io.containerd.grpc.v1 Oct 8 19:50:50.628872 containerd[1382]: time="2024-10-08T19:50:50.628605040Z" level=info msg="loading plugin \"io.containerd.grpc.v1.diff\"..." type=io.containerd.grpc.v1 Oct 8 19:50:50.628872 containerd[1382]: time="2024-10-08T19:50:50.628616560Z" level=info msg="loading plugin \"io.containerd.grpc.v1.events\"..." type=io.containerd.grpc.v1 Oct 8 19:50:50.628872 containerd[1382]: time="2024-10-08T19:50:50.628628120Z" level=info msg="loading plugin \"io.containerd.grpc.v1.healthcheck\"..." type=io.containerd.grpc.v1 Oct 8 19:50:50.628872 containerd[1382]: time="2024-10-08T19:50:50.628641280Z" level=info msg="loading plugin \"io.containerd.grpc.v1.images\"..." type=io.containerd.grpc.v1 Oct 8 19:50:50.628872 containerd[1382]: time="2024-10-08T19:50:50.628652240Z" level=info msg="loading plugin \"io.containerd.grpc.v1.leases\"..." type=io.containerd.grpc.v1 Oct 8 19:50:50.628872 containerd[1382]: time="2024-10-08T19:50:50.628663160Z" level=info msg="loading plugin \"io.containerd.grpc.v1.namespaces\"..." type=io.containerd.grpc.v1 Oct 8 19:50:50.628872 containerd[1382]: time="2024-10-08T19:50:50.628677640Z" level=info msg="loading plugin \"io.containerd.internal.v1.opt\"..." type=io.containerd.internal.v1 Oct 8 19:50:50.628994 containerd[1382]: time="2024-10-08T19:50:50.628879400Z" level=info msg="loading plugin \"io.containerd.grpc.v1.sandbox-controllers\"..." type=io.containerd.grpc.v1 Oct 8 19:50:50.628994 containerd[1382]: time="2024-10-08T19:50:50.628898680Z" level=info msg="loading plugin \"io.containerd.grpc.v1.sandboxes\"..." type=io.containerd.grpc.v1 Oct 8 19:50:50.628994 containerd[1382]: time="2024-10-08T19:50:50.628912600Z" level=info msg="loading plugin \"io.containerd.grpc.v1.snapshots\"..." type=io.containerd.grpc.v1 Oct 8 19:50:50.628994 containerd[1382]: time="2024-10-08T19:50:50.628925080Z" level=info msg="loading plugin \"io.containerd.grpc.v1.streaming\"..." type=io.containerd.grpc.v1 Oct 8 19:50:50.628994 containerd[1382]: time="2024-10-08T19:50:50.628939360Z" level=info msg="loading plugin \"io.containerd.grpc.v1.tasks\"..." type=io.containerd.grpc.v1 Oct 8 19:50:50.628994 containerd[1382]: time="2024-10-08T19:50:50.628954360Z" level=info msg="loading plugin \"io.containerd.grpc.v1.transfer\"..." type=io.containerd.grpc.v1 Oct 8 19:50:50.628994 containerd[1382]: time="2024-10-08T19:50:50.628966520Z" level=info msg="loading plugin \"io.containerd.grpc.v1.version\"..." type=io.containerd.grpc.v1 Oct 8 19:50:50.628994 containerd[1382]: time="2024-10-08T19:50:50.628977400Z" level=info msg="loading plugin \"io.containerd.grpc.v1.cri\"..." type=io.containerd.grpc.v1 Oct 8 19:50:50.629291 containerd[1382]: time="2024-10-08T19:50:50.629229320Z" 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}" Oct 8 19:50:50.629291 containerd[1382]: time="2024-10-08T19:50:50.629292360Z" level=info msg="Connect containerd service" Oct 8 19:50:50.629417 containerd[1382]: time="2024-10-08T19:50:50.629320760Z" level=info msg="using legacy CRI server" Oct 8 19:50:50.629417 containerd[1382]: time="2024-10-08T19:50:50.629328080Z" level=info msg="using experimental NRI integration - disable nri plugin to prevent this" Oct 8 19:50:50.629488 containerd[1382]: time="2024-10-08T19:50:50.629465320Z" level=info msg="Get image filesystem path \"/var/lib/containerd/io.containerd.snapshotter.v1.overlayfs\"" Oct 8 19:50:50.629988 containerd[1382]: time="2024-10-08T19:50:50.629960840Z" 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" Oct 8 19:50:50.630035 containerd[1382]: time="2024-10-08T19:50:50.630006120Z" level=info msg="loading plugin \"io.containerd.tracing.processor.v1.otlp\"..." type=io.containerd.tracing.processor.v1 Oct 8 19:50:50.630035 containerd[1382]: time="2024-10-08T19:50:50.630023320Z" 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 Oct 8 19:50:50.630077 containerd[1382]: time="2024-10-08T19:50:50.630038200Z" level=info msg="loading plugin \"io.containerd.internal.v1.tracing\"..." type=io.containerd.internal.v1 Oct 8 19:50:50.630077 containerd[1382]: time="2024-10-08T19:50:50.630051440Z" level=info msg="skip loading plugin \"io.containerd.internal.v1.tracing\"..." error="skip plugin: tracing endpoint not configured" type=io.containerd.internal.v1 Oct 8 19:50:50.630644 containerd[1382]: time="2024-10-08T19:50:50.630388280Z" level=info msg="Start subscribing containerd event" Oct 8 19:50:50.630644 containerd[1382]: time="2024-10-08T19:50:50.630639560Z" level=info msg="Start recovering state" Oct 8 19:50:50.630725 containerd[1382]: time="2024-10-08T19:50:50.630665880Z" level=info msg=serving... address=/run/containerd/containerd.sock.ttrpc Oct 8 19:50:50.630725 containerd[1382]: time="2024-10-08T19:50:50.630710760Z" level=info msg=serving... address=/run/containerd/containerd.sock Oct 8 19:50:50.630782 containerd[1382]: time="2024-10-08T19:50:50.630746400Z" level=info msg="Start event monitor" Oct 8 19:50:50.630782 containerd[1382]: time="2024-10-08T19:50:50.630758960Z" level=info msg="Start snapshots syncer" Oct 8 19:50:50.630782 containerd[1382]: time="2024-10-08T19:50:50.630768400Z" level=info msg="Start cni network conf syncer for default" Oct 8 19:50:50.630782 containerd[1382]: time="2024-10-08T19:50:50.630777280Z" level=info msg="Start streaming server" Oct 8 19:50:50.631014 containerd[1382]: time="2024-10-08T19:50:50.631000640Z" level=info msg="containerd successfully booted in 0.032739s" Oct 8 19:50:50.631138 systemd[1]: Started containerd.service - containerd container runtime. Oct 8 19:50:50.673707 systemd[1424]: Queued start job for default target default.target. Oct 8 19:50:50.682461 systemd[1424]: Created slice app.slice - User Application Slice. Oct 8 19:50:50.682489 systemd[1424]: Reached target paths.target - Paths. Oct 8 19:50:50.682502 systemd[1424]: Reached target timers.target - Timers. Oct 8 19:50:50.683804 systemd[1424]: Starting dbus.socket - D-Bus User Message Bus Socket... Oct 8 19:50:50.694818 systemd[1424]: Listening on dbus.socket - D-Bus User Message Bus Socket. Oct 8 19:50:50.694939 systemd[1424]: Reached target sockets.target - Sockets. Oct 8 19:50:50.694957 systemd[1424]: Reached target basic.target - Basic System. Oct 8 19:50:50.695000 systemd[1424]: Reached target default.target - Main User Target. Oct 8 19:50:50.695030 systemd[1424]: Startup finished in 104ms. Oct 8 19:50:50.695315 systemd[1]: Started user@500.service - User Manager for UID 500. Oct 8 19:50:50.697837 systemd[1]: Started session-1.scope - Session 1 of User core. Oct 8 19:50:50.756542 systemd[1]: Started sshd@1-10.0.0.104:22-10.0.0.1:38062.service - OpenSSH per-connection server daemon (10.0.0.1:38062). Oct 8 19:50:50.794191 sshd[1438]: Accepted publickey for core from 10.0.0.1 port 38062 ssh2: RSA SHA256:7GlzoUcthdqM2/gWbc3rpA5Lm+7Qkd3pe7wSn/JGGIM Oct 8 19:50:50.795513 sshd[1438]: pam_unix(sshd:session): session opened for user core(uid=500) by (uid=0) Oct 8 19:50:50.799800 systemd-logind[1368]: New session 2 of user core. Oct 8 19:50:50.810320 systemd[1]: Started session-2.scope - Session 2 of User core. Oct 8 19:50:50.864000 sshd[1438]: pam_unix(sshd:session): session closed for user core Oct 8 19:50:50.874888 systemd[1]: sshd@1-10.0.0.104:22-10.0.0.1:38062.service: Deactivated successfully. Oct 8 19:50:50.876413 systemd[1]: session-2.scope: Deactivated successfully. Oct 8 19:50:50.877689 systemd-logind[1368]: Session 2 logged out. Waiting for processes to exit. Oct 8 19:50:50.878851 systemd[1]: Started sshd@2-10.0.0.104:22-10.0.0.1:38064.service - OpenSSH per-connection server daemon (10.0.0.1:38064). Oct 8 19:50:50.881367 systemd-logind[1368]: Removed session 2. Oct 8 19:50:50.916501 sshd[1445]: Accepted publickey for core from 10.0.0.1 port 38064 ssh2: RSA SHA256:7GlzoUcthdqM2/gWbc3rpA5Lm+7Qkd3pe7wSn/JGGIM Oct 8 19:50:50.917748 sshd[1445]: pam_unix(sshd:session): session opened for user core(uid=500) by (uid=0) Oct 8 19:50:50.921727 systemd-logind[1368]: New session 3 of user core. Oct 8 19:50:50.936340 systemd[1]: Started session-3.scope - Session 3 of User core. Oct 8 19:50:50.989998 sshd[1445]: pam_unix(sshd:session): session closed for user core Oct 8 19:50:50.993417 systemd[1]: sshd@2-10.0.0.104:22-10.0.0.1:38064.service: Deactivated successfully. Oct 8 19:50:50.995665 systemd[1]: session-3.scope: Deactivated successfully. Oct 8 19:50:50.996231 systemd-logind[1368]: Session 3 logged out. Waiting for processes to exit. Oct 8 19:50:50.997201 systemd-logind[1368]: Removed session 3. Oct 8 19:50:51.883313 systemd-networkd[1324]: eth0: Gained IPv6LL Oct 8 19:50:51.883902 systemd-timesyncd[1309]: Network configuration changed, trying to establish connection. Oct 8 19:50:51.887222 systemd[1]: Finished systemd-networkd-wait-online.service - Wait for Network to be Configured. Oct 8 19:50:51.888955 systemd[1]: Reached target network-online.target - Network is Online. Oct 8 19:50:51.905402 systemd[1]: Starting coreos-metadata.service - QEMU metadata agent... Oct 8 19:50:51.907516 systemd[1]: Starting nvidia.service - NVIDIA Configure Service... Oct 8 19:50:51.922414 systemd[1]: coreos-metadata.service: Deactivated successfully. Oct 8 19:50:51.923305 systemd[1]: Finished coreos-metadata.service - QEMU metadata agent. Oct 8 19:50:51.924867 systemd[1]: packet-phone-home.service - Report Success to Packet was skipped because of an unmet condition check (ConditionFirstBoot=true). Oct 8 19:50:51.929667 systemd[1]: Finished nvidia.service - NVIDIA Configure Service. Oct 8 19:50:51.931082 systemd[1]: Reached target multi-user.target - Multi-User System. Oct 8 19:50:51.932383 systemd[1]: cryptenroll-helper-first.service was skipped because of an unmet condition check (ConditionFirstBoot=true). Oct 8 19:50:51.936227 systemd[1]: Startup finished in 584ms (kernel) + 2.273s (initrd) + 2.985s (userspace) = 5.844s. Oct 8 19:50:53.384436 systemd-timesyncd[1309]: Network configuration changed, trying to establish connection. Oct 8 19:50:54.443701 systemd-timesyncd[1309]: Network configuration changed, trying to establish connection. Oct 8 19:51:00.999588 systemd[1]: Started sshd@3-10.0.0.104:22-10.0.0.1:47956.service - OpenSSH per-connection server daemon (10.0.0.1:47956). Oct 8 19:51:01.037798 sshd[1470]: Accepted publickey for core from 10.0.0.1 port 47956 ssh2: RSA SHA256:7GlzoUcthdqM2/gWbc3rpA5Lm+7Qkd3pe7wSn/JGGIM Oct 8 19:51:01.039335 sshd[1470]: pam_unix(sshd:session): session opened for user core(uid=500) by (uid=0) Oct 8 19:51:01.043325 systemd-logind[1368]: New session 4 of user core. Oct 8 19:51:01.054325 systemd[1]: Started session-4.scope - Session 4 of User core. Oct 8 19:51:01.107115 sshd[1470]: pam_unix(sshd:session): session closed for user core Oct 8 19:51:01.121268 systemd[1]: sshd@3-10.0.0.104:22-10.0.0.1:47956.service: Deactivated successfully. Oct 8 19:51:01.122951 systemd[1]: session-4.scope: Deactivated successfully. Oct 8 19:51:01.125236 systemd-logind[1368]: Session 4 logged out. Waiting for processes to exit. Oct 8 19:51:01.138519 systemd[1]: Started sshd@4-10.0.0.104:22-10.0.0.1:47958.service - OpenSSH per-connection server daemon (10.0.0.1:47958). Oct 8 19:51:01.139402 systemd-logind[1368]: Removed session 4. Oct 8 19:51:01.170866 sshd[1477]: Accepted publickey for core from 10.0.0.1 port 47958 ssh2: RSA SHA256:7GlzoUcthdqM2/gWbc3rpA5Lm+7Qkd3pe7wSn/JGGIM Oct 8 19:51:01.172200 sshd[1477]: pam_unix(sshd:session): session opened for user core(uid=500) by (uid=0) Oct 8 19:51:01.175810 systemd-logind[1368]: New session 5 of user core. Oct 8 19:51:01.187347 systemd[1]: Started session-5.scope - Session 5 of User core. Oct 8 19:51:01.235037 sshd[1477]: pam_unix(sshd:session): session closed for user core Oct 8 19:51:01.252557 systemd[1]: sshd@4-10.0.0.104:22-10.0.0.1:47958.service: Deactivated successfully. Oct 8 19:51:01.254026 systemd[1]: session-5.scope: Deactivated successfully. Oct 8 19:51:01.256222 systemd-logind[1368]: Session 5 logged out. Waiting for processes to exit. Oct 8 19:51:01.257327 systemd[1]: Started sshd@5-10.0.0.104:22-10.0.0.1:47960.service - OpenSSH per-connection server daemon (10.0.0.1:47960). Oct 8 19:51:01.257956 systemd-logind[1368]: Removed session 5. Oct 8 19:51:01.293932 sshd[1484]: Accepted publickey for core from 10.0.0.1 port 47960 ssh2: RSA SHA256:7GlzoUcthdqM2/gWbc3rpA5Lm+7Qkd3pe7wSn/JGGIM Oct 8 19:51:01.295208 sshd[1484]: pam_unix(sshd:session): session opened for user core(uid=500) by (uid=0) Oct 8 19:51:01.299371 systemd-logind[1368]: New session 6 of user core. Oct 8 19:51:01.311349 systemd[1]: Started session-6.scope - Session 6 of User core. Oct 8 19:51:01.365183 sshd[1484]: pam_unix(sshd:session): session closed for user core Oct 8 19:51:01.376644 systemd[1]: sshd@5-10.0.0.104:22-10.0.0.1:47960.service: Deactivated successfully. Oct 8 19:51:01.378037 systemd[1]: session-6.scope: Deactivated successfully. Oct 8 19:51:01.380234 systemd-logind[1368]: Session 6 logged out. Waiting for processes to exit. Oct 8 19:51:01.381320 systemd[1]: Started sshd@6-10.0.0.104:22-10.0.0.1:47972.service - OpenSSH per-connection server daemon (10.0.0.1:47972). Oct 8 19:51:01.382468 systemd-logind[1368]: Removed session 6. Oct 8 19:51:01.418365 sshd[1491]: Accepted publickey for core from 10.0.0.1 port 47972 ssh2: RSA SHA256:7GlzoUcthdqM2/gWbc3rpA5Lm+7Qkd3pe7wSn/JGGIM Oct 8 19:51:01.419597 sshd[1491]: pam_unix(sshd:session): session opened for user core(uid=500) by (uid=0) Oct 8 19:51:01.423774 systemd-logind[1368]: New session 7 of user core. Oct 8 19:51:01.442335 systemd[1]: Started session-7.scope - Session 7 of User core. Oct 8 19:51:01.511615 sudo[1494]: core : PWD=/home/core ; USER=root ; COMMAND=/usr/sbin/setenforce 1 Oct 8 19:51:01.511876 sudo[1494]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=500) Oct 8 19:51:01.518189 kernel: audit: type=1404 audit(1728417061.515:3): enforcing=1 old_enforcing=0 auid=500 ses=7 enabled=1 old-enabled=1 lsm=selinux res=1 Oct 8 19:51:01.531870 sudo[1494]: pam_unix(sudo:session): session closed for user root Oct 8 19:51:01.533581 sshd[1491]: pam_unix(sshd:session): session closed for user core Oct 8 19:51:01.544461 systemd[1]: sshd@6-10.0.0.104:22-10.0.0.1:47972.service: Deactivated successfully. Oct 8 19:51:01.545868 systemd[1]: session-7.scope: Deactivated successfully. Oct 8 19:51:01.547112 systemd-logind[1368]: Session 7 logged out. Waiting for processes to exit. Oct 8 19:51:01.548316 systemd[1]: Started sshd@7-10.0.0.104:22-10.0.0.1:47988.service - OpenSSH per-connection server daemon (10.0.0.1:47988). Oct 8 19:51:01.549033 systemd-logind[1368]: Removed session 7. Oct 8 19:51:01.585162 sshd[1499]: Accepted publickey for core from 10.0.0.1 port 47988 ssh2: RSA SHA256:7GlzoUcthdqM2/gWbc3rpA5Lm+7Qkd3pe7wSn/JGGIM Oct 8 19:51:01.586441 sshd[1499]: pam_unix(sshd:session): session opened for user core(uid=500) by (uid=0) Oct 8 19:51:01.590420 systemd-logind[1368]: New session 8 of user core. Oct 8 19:51:01.596309 systemd[1]: Started session-8.scope - Session 8 of User core. Oct 8 19:51:01.648288 sudo[1503]: 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 Oct 8 19:51:01.648536 sudo[1503]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=500) Oct 8 19:51:01.651318 sudo[1503]: pam_unix(sudo:session): session closed for user root Oct 8 19:51:01.655965 sudo[1502]: core : PWD=/home/core ; USER=root ; COMMAND=/usr/bin/systemctl restart audit-rules Oct 8 19:51:01.656494 sudo[1502]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=500) Oct 8 19:51:01.671381 systemd[1]: Stopping audit-rules.service - Load Security Auditing Rules... Oct 8 19:51:01.672557 auditctl[1506]: No rules Oct 8 19:51:01.673429 systemd[1]: audit-rules.service: Deactivated successfully. Oct 8 19:51:01.673656 systemd[1]: Stopped audit-rules.service - Load Security Auditing Rules. Oct 8 19:51:01.675527 systemd[1]: Starting audit-rules.service - Load Security Auditing Rules... Oct 8 19:51:01.689192 augenrules[1510]: /sbin/augenrules: No change Oct 8 19:51:01.691099 augenrules[1520]: No rules Oct 8 19:51:01.692324 systemd[1]: Finished audit-rules.service - Load Security Auditing Rules. Oct 8 19:51:01.694416 sudo[1502]: pam_unix(sudo:session): session closed for user root Oct 8 19:51:01.695978 sshd[1499]: pam_unix(sshd:session): session closed for user core Oct 8 19:51:01.718641 systemd[1]: sshd@7-10.0.0.104:22-10.0.0.1:47988.service: Deactivated successfully. Oct 8 19:51:01.720099 systemd[1]: session-8.scope: Deactivated successfully. Oct 8 19:51:01.721383 systemd-logind[1368]: Session 8 logged out. Waiting for processes to exit. Oct 8 19:51:01.738429 systemd[1]: Started sshd@8-10.0.0.104:22-10.0.0.1:47996.service - OpenSSH per-connection server daemon (10.0.0.1:47996). Oct 8 19:51:01.739260 systemd-logind[1368]: Removed session 8. Oct 8 19:51:01.791946 sshd[1528]: Accepted publickey for core from 10.0.0.1 port 47996 ssh2: RSA SHA256:7GlzoUcthdqM2/gWbc3rpA5Lm+7Qkd3pe7wSn/JGGIM Oct 8 19:51:01.793020 sshd[1528]: pam_unix(sshd:session): session opened for user core(uid=500) by (uid=0) Oct 8 19:51:01.796883 systemd-logind[1368]: New session 9 of user core. Oct 8 19:51:01.810361 systemd[1]: Started session-9.scope - Session 9 of User core. Oct 8 19:51:01.863019 sshd[1528]: pam_unix(sshd:session): session closed for user core Oct 8 19:51:01.882670 systemd[1]: sshd@8-10.0.0.104:22-10.0.0.1:47996.service: Deactivated successfully. Oct 8 19:51:01.884241 systemd[1]: session-9.scope: Deactivated successfully. Oct 8 19:51:01.885448 systemd-logind[1368]: Session 9 logged out. Waiting for processes to exit. Oct 8 19:51:01.886545 systemd[1]: Started sshd@9-10.0.0.104:22-10.0.0.1:48012.service - OpenSSH per-connection server daemon (10.0.0.1:48012). Oct 8 19:51:01.887304 systemd-logind[1368]: Removed session 9. Oct 8 19:51:01.923338 sshd[1537]: Accepted publickey for core from 10.0.0.1 port 48012 ssh2: RSA SHA256:7GlzoUcthdqM2/gWbc3rpA5Lm+7Qkd3pe7wSn/JGGIM Oct 8 19:51:01.924569 sshd[1537]: pam_unix(sshd:session): session opened for user core(uid=500) by (uid=0) Oct 8 19:51:01.928733 systemd-logind[1368]: New session 10 of user core. Oct 8 19:51:01.941296 systemd[1]: Started session-10.scope - Session 10 of User core. Oct 8 19:51:01.993344 sshd[1537]: pam_unix(sshd:session): session closed for user core Oct 8 19:51:01.996250 systemd-logind[1368]: Session 10 logged out. Waiting for processes to exit. Oct 8 19:51:01.996469 systemd[1]: sshd@9-10.0.0.104:22-10.0.0.1:48012.service: Deactivated successfully. Oct 8 19:51:01.998192 systemd[1]: session-10.scope: Deactivated successfully. Oct 8 19:51:01.999815 systemd-logind[1368]: Removed session 10.