Oct 9 00:40:19.918042 kernel: Booting Linux on physical CPU 0x0000000000 [0x413fd0c1] Oct 9 00:40:19.918063 kernel: Linux version 6.6.54-flatcar (build@pony-truck.infra.kinvolk.io) (aarch64-cros-linux-gnu-gcc (Gentoo Hardened 13.3.1_p20240614 p17) 13.3.1 20240614, GNU ld (Gentoo 2.42 p3) 2.42.0) #1 SMP PREEMPT Tue Oct 8 23:34:40 -00 2024 Oct 9 00:40:19.918072 kernel: KASLR enabled Oct 9 00:40:19.918078 kernel: efi: EFI v2.7 by EDK II Oct 9 00:40:19.918084 kernel: efi: SMBIOS 3.0=0xdced0000 TPMFinalLog=0xd9760000 MEMATTR=0xdba62198 ACPI 2.0=0xd9700018 TPMEventLog=0xd9709098 RNG=0xd970e698 MEMRESERVE=0xd9b43b98 Oct 9 00:40:19.918090 kernel: random: crng init done Oct 9 00:40:19.918097 kernel: secureboot: Secure boot disabled Oct 9 00:40:19.918103 kernel: ACPI: Early table checksum verification disabled Oct 9 00:40:19.918109 kernel: ACPI: RSDP 0x00000000D9700018 000024 (v02 BOCHS ) Oct 9 00:40:19.918116 kernel: ACPI: XSDT 0x00000000D970FE98 00006C (v01 BOCHS BXPC 00000001 01000013) Oct 9 00:40:19.918122 kernel: ACPI: FACP 0x00000000D970FA98 000114 (v06 BOCHS BXPC 00000001 BXPC 00000001) Oct 9 00:40:19.918128 kernel: ACPI: DSDT 0x00000000D9707518 0014EB (v02 BOCHS BXPC 00000001 BXPC 00000001) Oct 9 00:40:19.918134 kernel: ACPI: APIC 0x00000000D970FC18 0001A8 (v04 BOCHS BXPC 00000001 BXPC 00000001) Oct 9 00:40:19.918140 kernel: ACPI: PPTT 0x00000000D970D898 00009C (v02 BOCHS BXPC 00000001 BXPC 00000001) Oct 9 00:40:19.918147 kernel: ACPI: GTDT 0x00000000D970E818 000060 (v02 BOCHS BXPC 00000001 BXPC 00000001) Oct 9 00:40:19.918154 kernel: ACPI: MCFG 0x00000000D970E918 00003C (v01 BOCHS BXPC 00000001 BXPC 00000001) Oct 9 00:40:19.918161 kernel: ACPI: SPCR 0x00000000D970FF98 000050 (v02 BOCHS BXPC 00000001 BXPC 00000001) Oct 9 00:40:19.918167 kernel: ACPI: DBG2 0x00000000D970E418 000057 (v00 BOCHS BXPC 00000001 BXPC 00000001) Oct 9 00:40:19.918173 kernel: ACPI: IORT 0x00000000D970E718 000080 (v03 BOCHS BXPC 00000001 BXPC 00000001) Oct 9 00:40:19.918179 kernel: ACPI: TPM2 0x00000000D970E498 00004C (v04 BOCHS BXPC 00000001 BXPC 00000001) Oct 9 00:40:19.918185 kernel: ACPI: SPCR: console: pl011,mmio,0x9000000,9600 Oct 9 00:40:19.918191 kernel: NUMA: Failed to initialise from firmware Oct 9 00:40:19.918197 kernel: NUMA: Faking a node at [mem 0x0000000040000000-0x00000000dcffffff] Oct 9 00:40:19.918204 kernel: NUMA: NODE_DATA [mem 0xdc958800-0xdc95dfff] Oct 9 00:40:19.918209 kernel: Zone ranges: Oct 9 00:40:19.918217 kernel: DMA [mem 0x0000000040000000-0x00000000dcffffff] Oct 9 00:40:19.918223 kernel: DMA32 empty Oct 9 00:40:19.918229 kernel: Normal empty Oct 9 00:40:19.918235 kernel: Movable zone start for each node Oct 9 00:40:19.918241 kernel: Early memory node ranges Oct 9 00:40:19.918247 kernel: node 0: [mem 0x0000000040000000-0x00000000d964ffff] Oct 9 00:40:19.918253 kernel: node 0: [mem 0x00000000d9650000-0x00000000d965ffff] Oct 9 00:40:19.918259 kernel: node 0: [mem 0x00000000d9660000-0x00000000d975ffff] Oct 9 00:40:19.918265 kernel: node 0: [mem 0x00000000d9760000-0x00000000d9b3ffff] Oct 9 00:40:19.918272 kernel: node 0: [mem 0x00000000d9b40000-0x00000000dce1ffff] Oct 9 00:40:19.918278 kernel: node 0: [mem 0x00000000dce20000-0x00000000dceaffff] Oct 9 00:40:19.918284 kernel: node 0: [mem 0x00000000dceb0000-0x00000000dcebffff] Oct 9 00:40:19.918292 kernel: node 0: [mem 0x00000000dcec0000-0x00000000dcfdffff] Oct 9 00:40:19.918298 kernel: node 0: [mem 0x00000000dcfe0000-0x00000000dcffffff] Oct 9 00:40:19.918305 kernel: Initmem setup node 0 [mem 0x0000000040000000-0x00000000dcffffff] Oct 9 00:40:19.918328 kernel: On node 0, zone DMA: 12288 pages in unavailable ranges Oct 9 00:40:19.918335 kernel: psci: probing for conduit method from ACPI. Oct 9 00:40:19.918342 kernel: psci: PSCIv1.1 detected in firmware. Oct 9 00:40:19.918350 kernel: psci: Using standard PSCI v0.2 function IDs Oct 9 00:40:19.918357 kernel: psci: Trusted OS migration not required Oct 9 00:40:19.918363 kernel: psci: SMC Calling Convention v1.1 Oct 9 00:40:19.918370 kernel: smccc: KVM: hypervisor services detected (0x00000000 0x00000000 0x00000000 0x00000003) Oct 9 00:40:19.918377 kernel: percpu: Embedded 31 pages/cpu s86632 r8192 d32152 u126976 Oct 9 00:40:19.918383 kernel: pcpu-alloc: s86632 r8192 d32152 u126976 alloc=31*4096 Oct 9 00:40:19.918390 kernel: pcpu-alloc: [0] 0 [0] 1 [0] 2 [0] 3 Oct 9 00:40:19.918397 kernel: Detected PIPT I-cache on CPU0 Oct 9 00:40:19.918403 kernel: CPU features: detected: GIC system register CPU interface Oct 9 00:40:19.918410 kernel: CPU features: detected: Hardware dirty bit management Oct 9 00:40:19.918418 kernel: CPU features: detected: Spectre-v4 Oct 9 00:40:19.918425 kernel: CPU features: detected: Spectre-BHB Oct 9 00:40:19.918432 kernel: CPU features: kernel page table isolation forced ON by KASLR Oct 9 00:40:19.918439 kernel: CPU features: detected: Kernel page table isolation (KPTI) Oct 9 00:40:19.918446 kernel: CPU features: detected: ARM erratum 1418040 Oct 9 00:40:19.918453 kernel: CPU features: detected: SSBS not fully self-synchronizing Oct 9 00:40:19.918459 kernel: alternatives: applying boot alternatives Oct 9 00:40:19.918467 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=d2d67b5440410ae2d0aa86eba97891969be0a7a421fa55f13442706ef7ed2a5e Oct 9 00:40:19.918474 kernel: Unknown kernel command line parameters "BOOT_IMAGE=/flatcar/vmlinuz-a", will be passed to user space. Oct 9 00:40:19.918481 kernel: Dentry cache hash table entries: 524288 (order: 10, 4194304 bytes, linear) Oct 9 00:40:19.918488 kernel: Inode-cache hash table entries: 262144 (order: 9, 2097152 bytes, linear) Oct 9 00:40:19.918496 kernel: Fallback order for Node 0: 0 Oct 9 00:40:19.918502 kernel: Built 1 zonelists, mobility grouping on. Total pages: 633024 Oct 9 00:40:19.918509 kernel: Policy zone: DMA Oct 9 00:40:19.918515 kernel: mem auto-init: stack:off, heap alloc:off, heap free:off Oct 9 00:40:19.918522 kernel: software IO TLB: area num 4. Oct 9 00:40:19.918528 kernel: software IO TLB: mapped [mem 0x00000000d2e00000-0x00000000d6e00000] (64MB) Oct 9 00:40:19.918535 kernel: Memory: 2386276K/2572288K available (10240K kernel code, 2184K rwdata, 8092K rodata, 39552K init, 897K bss, 186012K reserved, 0K cma-reserved) Oct 9 00:40:19.918542 kernel: SLUB: HWalign=64, Order=0-3, MinObjects=0, CPUs=4, Nodes=1 Oct 9 00:40:19.918548 kernel: trace event string verifier disabled Oct 9 00:40:19.918555 kernel: rcu: Preemptible hierarchical RCU implementation. Oct 9 00:40:19.918562 kernel: rcu: RCU event tracing is enabled. Oct 9 00:40:19.918570 kernel: rcu: RCU restricting CPUs from NR_CPUS=512 to nr_cpu_ids=4. Oct 9 00:40:19.918577 kernel: Trampoline variant of Tasks RCU enabled. Oct 9 00:40:19.918583 kernel: Tracing variant of Tasks RCU enabled. Oct 9 00:40:19.918590 kernel: rcu: RCU calculated value of scheduler-enlistment delay is 100 jiffies. Oct 9 00:40:19.918596 kernel: rcu: Adjusting geometry for rcu_fanout_leaf=16, nr_cpu_ids=4 Oct 9 00:40:19.918603 kernel: NR_IRQS: 64, nr_irqs: 64, preallocated irqs: 0 Oct 9 00:40:19.918610 kernel: GICv3: 256 SPIs implemented Oct 9 00:40:19.918616 kernel: GICv3: 0 Extended SPIs implemented Oct 9 00:40:19.918623 kernel: Root IRQ handler: gic_handle_irq Oct 9 00:40:19.918629 kernel: GICv3: GICv3 features: 16 PPIs, DirectLPI Oct 9 00:40:19.918636 kernel: GICv3: CPU0: found redistributor 0 region 0:0x00000000080a0000 Oct 9 00:40:19.918642 kernel: ITS [mem 0x08080000-0x0809ffff] Oct 9 00:40:19.918650 kernel: ITS@0x0000000008080000: allocated 8192 Devices @400d0000 (indirect, esz 8, psz 64K, shr 1) Oct 9 00:40:19.918657 kernel: ITS@0x0000000008080000: allocated 8192 Interrupt Collections @400e0000 (flat, esz 8, psz 64K, shr 1) Oct 9 00:40:19.918663 kernel: GICv3: using LPI property table @0x00000000400f0000 Oct 9 00:40:19.918670 kernel: GICv3: CPU0: using allocated LPI pending table @0x0000000040100000 Oct 9 00:40:19.918677 kernel: rcu: srcu_init: Setting srcu_struct sizes based on contention. Oct 9 00:40:19.918683 kernel: arch_timer: Enabling local workaround for ARM erratum 1418040 Oct 9 00:40:19.918690 kernel: arch_timer: cp15 timer(s) running at 25.00MHz (virt). Oct 9 00:40:19.918696 kernel: clocksource: arch_sys_counter: mask: 0xffffffffffffff max_cycles: 0x5c40939b5, max_idle_ns: 440795202646 ns Oct 9 00:40:19.918703 kernel: sched_clock: 56 bits at 25MHz, resolution 40ns, wraps every 4398046511100ns Oct 9 00:40:19.918709 kernel: arm-pv: using stolen time PV Oct 9 00:40:19.918716 kernel: Console: colour dummy device 80x25 Oct 9 00:40:19.918724 kernel: ACPI: Core revision 20230628 Oct 9 00:40:19.918731 kernel: Calibrating delay loop (skipped), value calculated using timer frequency.. 50.00 BogoMIPS (lpj=25000) Oct 9 00:40:19.918738 kernel: pid_max: default: 32768 minimum: 301 Oct 9 00:40:19.918745 kernel: LSM: initializing lsm=lockdown,capability,landlock,selinux,integrity Oct 9 00:40:19.918752 kernel: landlock: Up and running. Oct 9 00:40:19.918758 kernel: SELinux: Initializing. Oct 9 00:40:19.918765 kernel: Mount-cache hash table entries: 8192 (order: 4, 65536 bytes, linear) Oct 9 00:40:19.918771 kernel: Mountpoint-cache hash table entries: 8192 (order: 4, 65536 bytes, linear) Oct 9 00:40:19.918785 kernel: RCU Tasks: Setting shift to 2 and lim to 1 rcu_task_cb_adjust=1. Oct 9 00:40:19.918795 kernel: RCU Tasks Trace: Setting shift to 2 and lim to 1 rcu_task_cb_adjust=1. Oct 9 00:40:19.918802 kernel: rcu: Hierarchical SRCU implementation. Oct 9 00:40:19.918809 kernel: rcu: Max phase no-delay instances is 400. Oct 9 00:40:19.918815 kernel: Platform MSI: ITS@0x8080000 domain created Oct 9 00:40:19.918822 kernel: PCI/MSI: ITS@0x8080000 domain created Oct 9 00:40:19.918828 kernel: Remapping and enabling EFI services. Oct 9 00:40:19.918835 kernel: smp: Bringing up secondary CPUs ... Oct 9 00:40:19.918842 kernel: Detected PIPT I-cache on CPU1 Oct 9 00:40:19.918848 kernel: GICv3: CPU1: found redistributor 1 region 0:0x00000000080c0000 Oct 9 00:40:19.918866 kernel: GICv3: CPU1: using allocated LPI pending table @0x0000000040110000 Oct 9 00:40:19.918877 kernel: arch_timer: Enabling local workaround for ARM erratum 1418040 Oct 9 00:40:19.918888 kernel: CPU1: Booted secondary processor 0x0000000001 [0x413fd0c1] Oct 9 00:40:19.918897 kernel: Detected PIPT I-cache on CPU2 Oct 9 00:40:19.918904 kernel: GICv3: CPU2: found redistributor 2 region 0:0x00000000080e0000 Oct 9 00:40:19.918911 kernel: GICv3: CPU2: using allocated LPI pending table @0x0000000040120000 Oct 9 00:40:19.918918 kernel: arch_timer: Enabling local workaround for ARM erratum 1418040 Oct 9 00:40:19.918925 kernel: CPU2: Booted secondary processor 0x0000000002 [0x413fd0c1] Oct 9 00:40:19.918932 kernel: Detected PIPT I-cache on CPU3 Oct 9 00:40:19.918941 kernel: GICv3: CPU3: found redistributor 3 region 0:0x0000000008100000 Oct 9 00:40:19.918948 kernel: GICv3: CPU3: using allocated LPI pending table @0x0000000040130000 Oct 9 00:40:19.918955 kernel: arch_timer: Enabling local workaround for ARM erratum 1418040 Oct 9 00:40:19.918962 kernel: CPU3: Booted secondary processor 0x0000000003 [0x413fd0c1] Oct 9 00:40:19.918969 kernel: smp: Brought up 1 node, 4 CPUs Oct 9 00:40:19.918976 kernel: SMP: Total of 4 processors activated. Oct 9 00:40:19.918983 kernel: CPU features: detected: 32-bit EL0 Support Oct 9 00:40:19.918990 kernel: CPU features: detected: Data cache clean to the PoU not required for I/D coherence Oct 9 00:40:19.918997 kernel: CPU features: detected: Common not Private translations Oct 9 00:40:19.919006 kernel: CPU features: detected: CRC32 instructions Oct 9 00:40:19.919013 kernel: CPU features: detected: Enhanced Virtualization Traps Oct 9 00:40:19.919020 kernel: CPU features: detected: RCpc load-acquire (LDAPR) Oct 9 00:40:19.919027 kernel: CPU features: detected: LSE atomic instructions Oct 9 00:40:19.919034 kernel: CPU features: detected: Privileged Access Never Oct 9 00:40:19.919041 kernel: CPU features: detected: RAS Extension Support Oct 9 00:40:19.919048 kernel: CPU features: detected: Speculative Store Bypassing Safe (SSBS) Oct 9 00:40:19.919055 kernel: CPU: All CPU(s) started at EL1 Oct 9 00:40:19.919062 kernel: alternatives: applying system-wide alternatives Oct 9 00:40:19.919071 kernel: devtmpfs: initialized Oct 9 00:40:19.919078 kernel: clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1911260446275000 ns Oct 9 00:40:19.919090 kernel: futex hash table entries: 1024 (order: 4, 65536 bytes, linear) Oct 9 00:40:19.919097 kernel: pinctrl core: initialized pinctrl subsystem Oct 9 00:40:19.919104 kernel: SMBIOS 3.0.0 present. Oct 9 00:40:19.919111 kernel: DMI: QEMU KVM Virtual Machine, BIOS edk2-20230524-3.fc38 05/24/2023 Oct 9 00:40:19.919118 kernel: NET: Registered PF_NETLINK/PF_ROUTE protocol family Oct 9 00:40:19.919125 kernel: DMA: preallocated 512 KiB GFP_KERNEL pool for atomic allocations Oct 9 00:40:19.919133 kernel: DMA: preallocated 512 KiB GFP_KERNEL|GFP_DMA pool for atomic allocations Oct 9 00:40:19.919141 kernel: DMA: preallocated 512 KiB GFP_KERNEL|GFP_DMA32 pool for atomic allocations Oct 9 00:40:19.919148 kernel: audit: initializing netlink subsys (disabled) Oct 9 00:40:19.919155 kernel: audit: type=2000 audit(0.023:1): state=initialized audit_enabled=0 res=1 Oct 9 00:40:19.919162 kernel: thermal_sys: Registered thermal governor 'step_wise' Oct 9 00:40:19.919170 kernel: cpuidle: using governor menu Oct 9 00:40:19.919177 kernel: hw-breakpoint: found 6 breakpoint and 4 watchpoint registers. Oct 9 00:40:19.919184 kernel: ASID allocator initialised with 32768 entries Oct 9 00:40:19.919191 kernel: acpiphp: ACPI Hot Plug PCI Controller Driver version: 0.5 Oct 9 00:40:19.919198 kernel: Serial: AMBA PL011 UART driver Oct 9 00:40:19.919207 kernel: Modules: 2G module region forced by RANDOMIZE_MODULE_REGION_FULL Oct 9 00:40:19.919214 kernel: Modules: 0 pages in range for non-PLT usage Oct 9 00:40:19.919221 kernel: Modules: 508992 pages in range for PLT usage Oct 9 00:40:19.919228 kernel: HugeTLB: registered 1.00 GiB page size, pre-allocated 0 pages Oct 9 00:40:19.919235 kernel: HugeTLB: 0 KiB vmemmap can be freed for a 1.00 GiB page Oct 9 00:40:19.919242 kernel: HugeTLB: registered 32.0 MiB page size, pre-allocated 0 pages Oct 9 00:40:19.919249 kernel: HugeTLB: 0 KiB vmemmap can be freed for a 32.0 MiB page Oct 9 00:40:19.919256 kernel: HugeTLB: registered 2.00 MiB page size, pre-allocated 0 pages Oct 9 00:40:19.919263 kernel: HugeTLB: 0 KiB vmemmap can be freed for a 2.00 MiB page Oct 9 00:40:19.919272 kernel: HugeTLB: registered 64.0 KiB page size, pre-allocated 0 pages Oct 9 00:40:19.919279 kernel: HugeTLB: 0 KiB vmemmap can be freed for a 64.0 KiB page Oct 9 00:40:19.919286 kernel: ACPI: Added _OSI(Module Device) Oct 9 00:40:19.919293 kernel: ACPI: Added _OSI(Processor Device) Oct 9 00:40:19.919300 kernel: ACPI: Added _OSI(3.0 _SCP Extensions) Oct 9 00:40:19.919307 kernel: ACPI: Added _OSI(Processor Aggregator Device) Oct 9 00:40:19.919314 kernel: ACPI: 1 ACPI AML tables successfully acquired and loaded Oct 9 00:40:19.919321 kernel: ACPI: Interpreter enabled Oct 9 00:40:19.919328 kernel: ACPI: Using GIC for interrupt routing Oct 9 00:40:19.919336 kernel: ACPI: MCFG table detected, 1 entries Oct 9 00:40:19.919344 kernel: ARMH0011:00: ttyAMA0 at MMIO 0x9000000 (irq = 12, base_baud = 0) is a SBSA Oct 9 00:40:19.919351 kernel: printk: console [ttyAMA0] enabled Oct 9 00:40:19.919358 kernel: ACPI: PCI Root Bridge [PCI0] (domain 0000 [bus 00-ff]) Oct 9 00:40:19.919485 kernel: acpi PNP0A08:00: _OSC: OS supports [ExtendedConfig ASPM ClockPM Segments MSI HPX-Type3] Oct 9 00:40:19.919558 kernel: acpi PNP0A08:00: _OSC: platform does not support [LTR] Oct 9 00:40:19.919623 kernel: acpi PNP0A08:00: _OSC: OS now controls [PCIeHotplug PME AER PCIeCapability] Oct 9 00:40:19.919684 kernel: acpi PNP0A08:00: ECAM area [mem 0x4010000000-0x401fffffff] reserved by PNP0C02:00 Oct 9 00:40:19.919747 kernel: acpi PNP0A08:00: ECAM at [mem 0x4010000000-0x401fffffff] for [bus 00-ff] Oct 9 00:40:19.919757 kernel: ACPI: Remapped I/O 0x000000003eff0000 to [io 0x0000-0xffff window] Oct 9 00:40:19.919764 kernel: PCI host bridge to bus 0000:00 Oct 9 00:40:19.919844 kernel: pci_bus 0000:00: root bus resource [mem 0x10000000-0x3efeffff window] Oct 9 00:40:19.919918 kernel: pci_bus 0000:00: root bus resource [io 0x0000-0xffff window] Oct 9 00:40:19.919979 kernel: pci_bus 0000:00: root bus resource [mem 0x8000000000-0xffffffffff window] Oct 9 00:40:19.920036 kernel: pci_bus 0000:00: root bus resource [bus 00-ff] Oct 9 00:40:19.920116 kernel: pci 0000:00:00.0: [1b36:0008] type 00 class 0x060000 Oct 9 00:40:19.920192 kernel: pci 0000:00:01.0: [1af4:1005] type 00 class 0x00ff00 Oct 9 00:40:19.920259 kernel: pci 0000:00:01.0: reg 0x10: [io 0x0000-0x001f] Oct 9 00:40:19.920323 kernel: pci 0000:00:01.0: reg 0x14: [mem 0x10000000-0x10000fff] Oct 9 00:40:19.920387 kernel: pci 0000:00:01.0: reg 0x20: [mem 0x8000000000-0x8000003fff 64bit pref] Oct 9 00:40:19.920450 kernel: pci 0000:00:01.0: BAR 4: assigned [mem 0x8000000000-0x8000003fff 64bit pref] Oct 9 00:40:19.920514 kernel: pci 0000:00:01.0: BAR 1: assigned [mem 0x10000000-0x10000fff] Oct 9 00:40:19.920580 kernel: pci 0000:00:01.0: BAR 0: assigned [io 0x1000-0x101f] Oct 9 00:40:19.920637 kernel: pci_bus 0000:00: resource 4 [mem 0x10000000-0x3efeffff window] Oct 9 00:40:19.920692 kernel: pci_bus 0000:00: resource 5 [io 0x0000-0xffff window] Oct 9 00:40:19.920748 kernel: pci_bus 0000:00: resource 6 [mem 0x8000000000-0xffffffffff window] Oct 9 00:40:19.920758 kernel: ACPI: PCI: Interrupt link GSI0 configured for IRQ 35 Oct 9 00:40:19.920765 kernel: ACPI: PCI: Interrupt link GSI1 configured for IRQ 36 Oct 9 00:40:19.920773 kernel: ACPI: PCI: Interrupt link GSI2 configured for IRQ 37 Oct 9 00:40:19.920790 kernel: ACPI: PCI: Interrupt link GSI3 configured for IRQ 38 Oct 9 00:40:19.920798 kernel: iommu: Default domain type: Translated Oct 9 00:40:19.920805 kernel: iommu: DMA domain TLB invalidation policy: strict mode Oct 9 00:40:19.920812 kernel: efivars: Registered efivars operations Oct 9 00:40:19.920819 kernel: vgaarb: loaded Oct 9 00:40:19.920827 kernel: clocksource: Switched to clocksource arch_sys_counter Oct 9 00:40:19.920834 kernel: VFS: Disk quotas dquot_6.6.0 Oct 9 00:40:19.920841 kernel: VFS: Dquot-cache hash table entries: 512 (order 0, 4096 bytes) Oct 9 00:40:19.920848 kernel: pnp: PnP ACPI init Oct 9 00:40:19.920938 kernel: system 00:00: [mem 0x4010000000-0x401fffffff window] could not be reserved Oct 9 00:40:19.920949 kernel: pnp: PnP ACPI: found 1 devices Oct 9 00:40:19.920956 kernel: NET: Registered PF_INET protocol family Oct 9 00:40:19.920964 kernel: IP idents hash table entries: 65536 (order: 7, 524288 bytes, linear) Oct 9 00:40:19.920971 kernel: tcp_listen_portaddr_hash hash table entries: 2048 (order: 3, 32768 bytes, linear) Oct 9 00:40:19.920978 kernel: Table-perturb hash table entries: 65536 (order: 6, 262144 bytes, linear) Oct 9 00:40:19.920985 kernel: TCP established hash table entries: 32768 (order: 6, 262144 bytes, linear) Oct 9 00:40:19.920993 kernel: TCP bind hash table entries: 32768 (order: 8, 1048576 bytes, linear) Oct 9 00:40:19.921002 kernel: TCP: Hash tables configured (established 32768 bind 32768) Oct 9 00:40:19.921010 kernel: UDP hash table entries: 2048 (order: 4, 65536 bytes, linear) Oct 9 00:40:19.921017 kernel: UDP-Lite hash table entries: 2048 (order: 4, 65536 bytes, linear) Oct 9 00:40:19.921024 kernel: NET: Registered PF_UNIX/PF_LOCAL protocol family Oct 9 00:40:19.921031 kernel: PCI: CLS 0 bytes, default 64 Oct 9 00:40:19.921038 kernel: kvm [1]: HYP mode not available Oct 9 00:40:19.921045 kernel: Initialise system trusted keyrings Oct 9 00:40:19.921052 kernel: workingset: timestamp_bits=39 max_order=20 bucket_order=0 Oct 9 00:40:19.921059 kernel: Key type asymmetric registered Oct 9 00:40:19.921067 kernel: Asymmetric key parser 'x509' registered Oct 9 00:40:19.921075 kernel: Block layer SCSI generic (bsg) driver version 0.4 loaded (major 250) Oct 9 00:40:19.921082 kernel: io scheduler mq-deadline registered Oct 9 00:40:19.921089 kernel: io scheduler kyber registered Oct 9 00:40:19.921096 kernel: io scheduler bfq registered Oct 9 00:40:19.921103 kernel: input: Power Button as /devices/LNXSYSTM:00/LNXSYBUS:00/PNP0C0C:00/input/input0 Oct 9 00:40:19.921110 kernel: ACPI: button: Power Button [PWRB] Oct 9 00:40:19.921117 kernel: ACPI: \_SB_.PCI0.GSI1: Enabled at IRQ 36 Oct 9 00:40:19.921183 kernel: virtio-pci 0000:00:01.0: enabling device (0005 -> 0007) Oct 9 00:40:19.921194 kernel: Serial: 8250/16550 driver, 4 ports, IRQ sharing enabled Oct 9 00:40:19.921202 kernel: thunder_xcv, ver 1.0 Oct 9 00:40:19.921209 kernel: thunder_bgx, ver 1.0 Oct 9 00:40:19.921216 kernel: nicpf, ver 1.0 Oct 9 00:40:19.921223 kernel: nicvf, ver 1.0 Oct 9 00:40:19.921292 kernel: rtc-efi rtc-efi.0: registered as rtc0 Oct 9 00:40:19.921353 kernel: rtc-efi rtc-efi.0: setting system clock to 2024-10-09T00:40:19 UTC (1728434419) Oct 9 00:40:19.921363 kernel: hid: raw HID events driver (C) Jiri Kosina Oct 9 00:40:19.921372 kernel: hw perfevents: enabled with armv8_pmuv3_0 PMU driver, 7 counters available Oct 9 00:40:19.921380 kernel: watchdog: Delayed init of the lockup detector failed: -19 Oct 9 00:40:19.921387 kernel: watchdog: Hard watchdog permanently disabled Oct 9 00:40:19.921394 kernel: NET: Registered PF_INET6 protocol family Oct 9 00:40:19.921401 kernel: Segment Routing with IPv6 Oct 9 00:40:19.921408 kernel: In-situ OAM (IOAM) with IPv6 Oct 9 00:40:19.921415 kernel: NET: Registered PF_PACKET protocol family Oct 9 00:40:19.921422 kernel: Key type dns_resolver registered Oct 9 00:40:19.921429 kernel: registered taskstats version 1 Oct 9 00:40:19.921437 kernel: Loading compiled-in X.509 certificates Oct 9 00:40:19.921445 kernel: Loaded X.509 cert 'Kinvolk GmbH: Module signing key for 6.6.54-flatcar: 80611b0a9480eaf6d787b908c6349fdb5d07fa81' Oct 9 00:40:19.921452 kernel: Key type .fscrypt registered Oct 9 00:40:19.921459 kernel: Key type fscrypt-provisioning registered Oct 9 00:40:19.921466 kernel: ima: No TPM chip found, activating TPM-bypass! Oct 9 00:40:19.921473 kernel: ima: Allocated hash algorithm: sha1 Oct 9 00:40:19.921480 kernel: ima: No architecture policies found Oct 9 00:40:19.921487 kernel: alg: No test for fips(ansi_cprng) (fips_ansi_cprng) Oct 9 00:40:19.921494 kernel: clk: Disabling unused clocks Oct 9 00:40:19.921502 kernel: Freeing unused kernel memory: 39552K Oct 9 00:40:19.921510 kernel: Run /init as init process Oct 9 00:40:19.921516 kernel: with arguments: Oct 9 00:40:19.921523 kernel: /init Oct 9 00:40:19.921530 kernel: with environment: Oct 9 00:40:19.921537 kernel: HOME=/ Oct 9 00:40:19.921544 kernel: TERM=linux Oct 9 00:40:19.921551 kernel: BOOT_IMAGE=/flatcar/vmlinuz-a Oct 9 00:40:19.921560 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 9 00:40:19.921570 systemd[1]: Detected virtualization kvm. Oct 9 00:40:19.921578 systemd[1]: Detected architecture arm64. Oct 9 00:40:19.921585 systemd[1]: Running in initrd. Oct 9 00:40:19.921592 systemd[1]: No hostname configured, using default hostname. Oct 9 00:40:19.921600 systemd[1]: Hostname set to . Oct 9 00:40:19.921607 systemd[1]: Initializing machine ID from VM UUID. Oct 9 00:40:19.921615 systemd[1]: Queued start job for default target initrd.target. Oct 9 00:40:19.921624 systemd[1]: Started clevis-luks-askpass.path - Forward Password Requests to Clevis Directory Watch. Oct 9 00:40:19.921632 systemd[1]: Started systemd-ask-password-console.path - Dispatch Password Requests to Console Directory Watch. Oct 9 00:40:19.921640 systemd[1]: Expecting device dev-disk-by\x2dlabel-EFI\x2dSYSTEM.device - /dev/disk/by-label/EFI-SYSTEM... Oct 9 00:40:19.921647 systemd[1]: Expecting device dev-disk-by\x2dlabel-OEM.device - /dev/disk/by-label/OEM... Oct 9 00:40:19.921655 systemd[1]: Expecting device dev-disk-by\x2dlabel-ROOT.device - /dev/disk/by-label/ROOT... Oct 9 00:40:19.921663 systemd[1]: Expecting device dev-disk-by\x2dpartlabel-USR\x2dA.device - /dev/disk/by-partlabel/USR-A... Oct 9 00:40:19.921672 systemd[1]: Expecting device dev-disk-by\x2dpartuuid-7130c94a\x2d213a\x2d4e5a\x2d8e26\x2d6cce9662f132.device - /dev/disk/by-partuuid/7130c94a-213a-4e5a-8e26-6cce9662f132... Oct 9 00:40:19.921681 systemd[1]: Expecting device dev-mapper-usr.device - /dev/mapper/usr... Oct 9 00:40:19.921689 systemd[1]: Reached target cryptsetup-pre.target - Local Encrypted Volumes (Pre). Oct 9 00:40:19.921697 systemd[1]: Reached target cryptsetup.target - Local Encrypted Volumes. Oct 9 00:40:19.921704 systemd[1]: Reached target paths.target - Path Units. Oct 9 00:40:19.921712 systemd[1]: Reached target slices.target - Slice Units. Oct 9 00:40:19.921719 systemd[1]: Reached target swap.target - Swaps. Oct 9 00:40:19.921727 systemd[1]: Reached target timers.target - Timer Units. Oct 9 00:40:19.921734 systemd[1]: Listening on iscsid.socket - Open-iSCSI iscsid Socket. Oct 9 00:40:19.921743 systemd[1]: Listening on iscsiuio.socket - Open-iSCSI iscsiuio Socket. Oct 9 00:40:19.921751 systemd[1]: Listening on systemd-journald-dev-log.socket - Journal Socket (/dev/log). Oct 9 00:40:19.921758 systemd[1]: Listening on systemd-journald.socket - Journal Socket. Oct 9 00:40:19.921766 systemd[1]: Listening on systemd-networkd.socket - Network Service Netlink Socket. Oct 9 00:40:19.921774 systemd[1]: Listening on systemd-udevd-control.socket - udev Control Socket. Oct 9 00:40:19.921788 systemd[1]: Listening on systemd-udevd-kernel.socket - udev Kernel Socket. Oct 9 00:40:19.921796 systemd[1]: Reached target sockets.target - Socket Units. Oct 9 00:40:19.921804 systemd[1]: Starting ignition-setup-pre.service - Ignition env setup... Oct 9 00:40:19.921812 systemd[1]: Starting kmod-static-nodes.service - Create List of Static Device Nodes... Oct 9 00:40:19.921821 systemd[1]: Finished network-cleanup.service - Network Cleanup. Oct 9 00:40:19.921829 systemd[1]: Starting systemd-fsck-usr.service... Oct 9 00:40:19.921837 systemd[1]: Starting systemd-journald.service - Journal Service... Oct 9 00:40:19.921844 systemd[1]: Starting systemd-modules-load.service - Load Kernel Modules... Oct 9 00:40:19.921852 systemd[1]: Starting systemd-vconsole-setup.service - Virtual Console Setup... Oct 9 00:40:19.921868 systemd[1]: Finished ignition-setup-pre.service - Ignition env setup. Oct 9 00:40:19.921876 systemd[1]: Finished kmod-static-nodes.service - Create List of Static Device Nodes. Oct 9 00:40:19.921884 systemd[1]: Finished systemd-fsck-usr.service. Oct 9 00:40:19.921910 systemd-journald[237]: Collecting audit messages is disabled. Oct 9 00:40:19.921930 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 9 00:40:19.921938 systemd[1]: Starting systemd-tmpfiles-setup-dev-early.service - Create Static Device Nodes in /dev gracefully... Oct 9 00:40:19.921945 kernel: Bridge firewalling registered Oct 9 00:40:19.921953 systemd[1]: Finished systemd-vconsole-setup.service - Virtual Console Setup. Oct 9 00:40:19.921961 systemd[1]: Finished systemd-modules-load.service - Load Kernel Modules. Oct 9 00:40:19.921969 systemd[1]: Finished systemd-tmpfiles-setup-dev-early.service - Create Static Device Nodes in /dev gracefully. Oct 9 00:40:19.921977 systemd-journald[237]: Journal started Oct 9 00:40:19.921996 systemd-journald[237]: Runtime Journal (/run/log/journal/77d3fb4d0fc34e56a5becad83947f740) is 5.9M, max 47.3M, 41.4M free. Oct 9 00:40:19.900199 systemd-modules-load[238]: Inserted module 'overlay' Oct 9 00:40:19.924346 systemd[1]: Started systemd-journald.service - Journal Service. Oct 9 00:40:19.917282 systemd-modules-load[238]: Inserted module 'br_netfilter' Oct 9 00:40:19.926317 systemd[1]: Starting dracut-cmdline-ask.service - dracut ask for additional cmdline parameters... Oct 9 00:40:19.930996 systemd[1]: Starting systemd-sysctl.service - Apply Kernel Variables... Oct 9 00:40:19.932516 systemd[1]: Starting systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev... Oct 9 00:40:19.935062 systemd[1]: Starting systemd-tmpfiles-setup.service - Create System Files and Directories... Oct 9 00:40:19.943234 systemd[1]: Finished systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev. Oct 9 00:40:19.944369 systemd[1]: Finished systemd-sysctl.service - Apply Kernel Variables. Oct 9 00:40:19.947617 systemd[1]: Finished dracut-cmdline-ask.service - dracut ask for additional cmdline parameters. Oct 9 00:40:19.949404 systemd[1]: Starting dracut-cmdline.service - dracut cmdline hook... Oct 9 00:40:19.951158 systemd[1]: Finished systemd-tmpfiles-setup.service - Create System Files and Directories. Oct 9 00:40:19.953402 systemd[1]: Starting systemd-resolved.service - Network Name Resolution... Oct 9 00:40:19.962719 dracut-cmdline[275]: dracut-dracut-053 Oct 9 00:40:19.965170 dracut-cmdline[275]: Using kernel command line parameters: rd.driver.pre=btrfs BOOT_IMAGE=/flatcar/vmlinuz-a mount.usr=/dev/mapper/usr verity.usr=PARTUUID=7130c94a-213a-4e5a-8e26-6cce9662f132 rootflags=rw mount.usrflags=ro consoleblank=0 root=LABEL=ROOT console=ttyS0,115200 flatcar.first_boot=detected acpi=force verity.usrhash=d2d67b5440410ae2d0aa86eba97891969be0a7a421fa55f13442706ef7ed2a5e Oct 9 00:40:19.980916 systemd-resolved[277]: Positive Trust Anchors: Oct 9 00:40:19.980990 systemd-resolved[277]: . IN DS 20326 8 2 e06d44b80b8f1d39a95c0b0d7c65d08458e880409bbc683457104237c7f8ec8d Oct 9 00:40:19.981021 systemd-resolved[277]: Negative trust anchors: home.arpa 10.in-addr.arpa 16.172.in-addr.arpa 17.172.in-addr.arpa 18.172.in-addr.arpa 19.172.in-addr.arpa 20.172.in-addr.arpa 21.172.in-addr.arpa 22.172.in-addr.arpa 23.172.in-addr.arpa 24.172.in-addr.arpa 25.172.in-addr.arpa 26.172.in-addr.arpa 27.172.in-addr.arpa 28.172.in-addr.arpa 29.172.in-addr.arpa 30.172.in-addr.arpa 31.172.in-addr.arpa 170.0.0.192.in-addr.arpa 171.0.0.192.in-addr.arpa 168.192.in-addr.arpa d.f.ip6.arpa ipv4only.arpa resolver.arpa corp home internal intranet lan local private test Oct 9 00:40:19.985614 systemd-resolved[277]: Defaulting to hostname 'linux'. Oct 9 00:40:19.986643 systemd[1]: Started systemd-resolved.service - Network Name Resolution. Oct 9 00:40:19.988250 systemd[1]: Reached target nss-lookup.target - Host and Network Name Lookups. Oct 9 00:40:20.043885 kernel: SCSI subsystem initialized Oct 9 00:40:20.048882 kernel: Loading iSCSI transport class v2.0-870. Oct 9 00:40:20.056885 kernel: iscsi: registered transport (tcp) Oct 9 00:40:20.070981 kernel: iscsi: registered transport (qla4xxx) Oct 9 00:40:20.071006 kernel: QLogic iSCSI HBA Driver Oct 9 00:40:20.120462 systemd[1]: Finished dracut-cmdline.service - dracut cmdline hook. Oct 9 00:40:20.131953 systemd[1]: Starting dracut-pre-udev.service - dracut pre-udev hook... Oct 9 00:40:20.150326 kernel: device-mapper: core: CONFIG_IMA_DISABLE_HTABLE is disabled. Duplicate IMA measurements will not be recorded in the IMA log. Oct 9 00:40:20.150374 kernel: device-mapper: uevent: version 1.0.3 Oct 9 00:40:20.150398 kernel: device-mapper: ioctl: 4.48.0-ioctl (2023-03-01) initialised: dm-devel@redhat.com Oct 9 00:40:20.199919 kernel: raid6: neonx8 gen() 15733 MB/s Oct 9 00:40:20.216882 kernel: raid6: neonx4 gen() 15629 MB/s Oct 9 00:40:20.233912 kernel: raid6: neonx2 gen() 13218 MB/s Oct 9 00:40:20.250877 kernel: raid6: neonx1 gen() 10445 MB/s Oct 9 00:40:20.267893 kernel: raid6: int64x8 gen() 6962 MB/s Oct 9 00:40:20.284881 kernel: raid6: int64x4 gen() 7341 MB/s Oct 9 00:40:20.301889 kernel: raid6: int64x2 gen() 6127 MB/s Oct 9 00:40:20.318878 kernel: raid6: int64x1 gen() 5056 MB/s Oct 9 00:40:20.318919 kernel: raid6: using algorithm neonx8 gen() 15733 MB/s Oct 9 00:40:20.335944 kernel: raid6: .... xor() 11935 MB/s, rmw enabled Oct 9 00:40:20.335986 kernel: raid6: using neon recovery algorithm Oct 9 00:40:20.341049 kernel: xor: measuring software checksum speed Oct 9 00:40:20.341071 kernel: 8regs : 19840 MB/sec Oct 9 00:40:20.342149 kernel: 32regs : 19683 MB/sec Oct 9 00:40:20.342162 kernel: arm64_neon : 26945 MB/sec Oct 9 00:40:20.342171 kernel: xor: using function: arm64_neon (26945 MB/sec) Oct 9 00:40:20.391900 kernel: Btrfs loaded, zoned=no, fsverity=no Oct 9 00:40:20.403263 systemd[1]: Finished dracut-pre-udev.service - dracut pre-udev hook. Oct 9 00:40:20.417036 systemd[1]: Starting systemd-udevd.service - Rule-based Manager for Device Events and Files... Oct 9 00:40:20.430311 systemd-udevd[460]: Using default interface naming scheme 'v255'. Oct 9 00:40:20.433626 systemd[1]: Started systemd-udevd.service - Rule-based Manager for Device Events and Files. Oct 9 00:40:20.444092 systemd[1]: Starting dracut-pre-trigger.service - dracut pre-trigger hook... Oct 9 00:40:20.455349 dracut-pre-trigger[463]: rd.md=0: removing MD RAID activation Oct 9 00:40:20.481873 systemd[1]: Finished dracut-pre-trigger.service - dracut pre-trigger hook. Oct 9 00:40:20.492018 systemd[1]: Starting systemd-udev-trigger.service - Coldplug All udev Devices... Oct 9 00:40:20.529424 systemd[1]: Finished systemd-udev-trigger.service - Coldplug All udev Devices. Oct 9 00:40:20.544079 systemd[1]: Starting dracut-initqueue.service - dracut initqueue hook... Oct 9 00:40:20.562897 systemd[1]: Finished dracut-initqueue.service - dracut initqueue hook. Oct 9 00:40:20.564197 systemd[1]: Reached target remote-fs-pre.target - Preparation for Remote File Systems. Oct 9 00:40:20.565566 systemd[1]: Reached target remote-cryptsetup.target - Remote Encrypted Volumes. Oct 9 00:40:20.566418 systemd[1]: Reached target remote-fs.target - Remote File Systems. Oct 9 00:40:20.575006 systemd[1]: Starting dracut-pre-mount.service - dracut pre-mount hook... Oct 9 00:40:20.584330 systemd[1]: Finished dracut-pre-mount.service - dracut pre-mount hook. Oct 9 00:40:20.587022 kernel: tpm_tis MSFT0101:00: 2.0 TPM (device-id 0x1, rev-id 1) Oct 9 00:40:20.599068 systemd[1]: dracut-cmdline-ask.service: Deactivated successfully. Oct 9 00:40:20.599185 systemd[1]: Stopped dracut-cmdline-ask.service - dracut ask for additional cmdline parameters. Oct 9 00:40:20.602350 systemd[1]: Stopping dracut-cmdline-ask.service - dracut ask for additional cmdline parameters... Oct 9 00:40:20.609011 kernel: virtio_blk virtio1: 1/0/0 default/read/poll queues Oct 9 00:40:20.609147 kernel: virtio_blk virtio1: [vda] 1064960 512-byte logical blocks (545 MB/520 MiB) Oct 9 00:40:20.609222 kernel: virtio_blk virtio2: 1/0/0 default/read/poll queues Oct 9 00:40:20.608056 systemd[1]: systemd-vconsole-setup.service: Deactivated successfully. Oct 9 00:40:20.615897 kernel: virtio_blk virtio2: [vdb] 9289728 512-byte logical blocks (4.76 GB/4.43 GiB) Oct 9 00:40:20.608238 systemd[1]: Stopped systemd-vconsole-setup.service - Virtual Console Setup. Oct 9 00:40:20.610668 systemd[1]: Stopping systemd-vconsole-setup.service - Virtual Console Setup... Oct 9 00:40:20.619879 kernel: vdb: vdb1 vdb2 vdb3 vdb4 vdb6 vdb7 vdb9 Oct 9 00:40:20.627597 systemd[1]: Starting systemd-vconsole-setup.service - Virtual Console Setup... Oct 9 00:40:20.636692 kernel: BTRFS: device label OEM devid 1 transid 12 /dev/vdb6 scanned by (udev-worker) (519) Oct 9 00:40:20.636730 kernel: BTRFS: device fsid c25b3a2f-539f-42a7-8842-97b35e474647 devid 1 transid 37 /dev/vdb3 scanned by (udev-worker) (510) Oct 9 00:40:20.639963 systemd[1]: Found device dev-disk-by\x2dlabel-EFI\x2dSYSTEM.device - /dev/disk/by-label/EFI-SYSTEM. Oct 9 00:40:20.641058 systemd[1]: Finished systemd-vconsole-setup.service - Virtual Console Setup. Oct 9 00:40:20.649927 systemd[1]: Found device dev-disk-by\x2dlabel-ROOT.device - /dev/disk/by-label/ROOT. Oct 9 00:40:20.656706 systemd[1]: Found device dev-disk-by\x2dlabel-OEM.device - /dev/disk/by-label/OEM. Oct 9 00:40:20.660635 systemd[1]: Found device dev-disk-by\x2dpartuuid-7130c94a\x2d213a\x2d4e5a\x2d8e26\x2d6cce9662f132.device - /dev/disk/by-partuuid/7130c94a-213a-4e5a-8e26-6cce9662f132. Oct 9 00:40:20.661518 systemd[1]: Found device dev-disk-by\x2dpartlabel-USR\x2dA.device - /dev/disk/by-partlabel/USR-A. Oct 9 00:40:20.675998 systemd[1]: Starting disk-uuid.service - Generate new UUID for disk GPT if necessary... Oct 9 00:40:20.677926 systemd[1]: Starting dracut-cmdline-ask.service - dracut ask for additional cmdline parameters... Oct 9 00:40:20.685341 kernel: vdb: vdb1 vdb2 vdb3 vdb4 vdb6 vdb7 vdb9 Oct 9 00:40:20.701020 systemd[1]: Finished dracut-cmdline-ask.service - dracut ask for additional cmdline parameters. Oct 9 00:40:21.696695 kernel: vdb: vdb1 vdb2 vdb3 vdb4 vdb6 vdb7 vdb9 Oct 9 00:40:21.696790 disk-uuid[551]: The operation has completed successfully. Oct 9 00:40:21.719078 systemd[1]: disk-uuid.service: Deactivated successfully. Oct 9 00:40:21.719178 systemd[1]: Finished disk-uuid.service - Generate new UUID for disk GPT if necessary. Oct 9 00:40:21.747041 systemd[1]: Starting verity-setup.service - Verity Setup for /dev/mapper/usr... Oct 9 00:40:21.750086 sh[572]: Success Oct 9 00:40:21.763163 kernel: device-mapper: verity: sha256 using implementation "sha256-ce" Oct 9 00:40:21.810601 systemd[1]: Found device dev-mapper-usr.device - /dev/mapper/usr. Oct 9 00:40:21.813480 systemd[1]: Mounting sysusr-usr.mount - /sysusr/usr... Oct 9 00:40:21.816895 systemd[1]: Finished verity-setup.service - Verity Setup for /dev/mapper/usr. Oct 9 00:40:21.824990 kernel: BTRFS info (device dm-0): first mount of filesystem c25b3a2f-539f-42a7-8842-97b35e474647 Oct 9 00:40:21.825021 kernel: BTRFS info (device dm-0): using crc32c (crc32c-generic) checksum algorithm Oct 9 00:40:21.825031 kernel: BTRFS warning (device dm-0): 'nologreplay' is deprecated, use 'rescue=nologreplay' instead Oct 9 00:40:21.826501 kernel: BTRFS info (device dm-0): disabling log replay at mount time Oct 9 00:40:21.826525 kernel: BTRFS info (device dm-0): using free space tree Oct 9 00:40:21.830442 systemd[1]: Mounted sysusr-usr.mount - /sysusr/usr. Oct 9 00:40:21.831536 systemd[1]: afterburn-network-kargs.service - Afterburn Initrd Setup Network Kernel Arguments was skipped because no trigger condition checks were met. Oct 9 00:40:21.850075 systemd[1]: Starting ignition-setup.service - Ignition (setup)... Oct 9 00:40:21.851732 systemd[1]: Starting parse-ip-for-networkd.service - Write systemd-networkd units from cmdline... Oct 9 00:40:21.860554 kernel: BTRFS info (device vdb6): first mount of filesystem 6fd98f99-a3f6-49b2-9c3b-44aa7ae4e99b Oct 9 00:40:21.860587 kernel: BTRFS info (device vdb6): using crc32c (crc32c-generic) checksum algorithm Oct 9 00:40:21.860597 kernel: BTRFS info (device vdb6): using free space tree Oct 9 00:40:21.866880 kernel: BTRFS info (device vdb6): auto enabling async discard Oct 9 00:40:21.874608 systemd[1]: mnt-oem.mount: Deactivated successfully. Oct 9 00:40:21.876102 kernel: BTRFS info (device vdb6): last unmount of filesystem 6fd98f99-a3f6-49b2-9c3b-44aa7ae4e99b Oct 9 00:40:21.884931 systemd[1]: Finished ignition-setup.service - Ignition (setup). Oct 9 00:40:21.897064 systemd[1]: Starting ignition-fetch-offline.service - Ignition (fetch-offline)... Oct 9 00:40:21.954700 systemd[1]: Finished parse-ip-for-networkd.service - Write systemd-networkd units from cmdline. Oct 9 00:40:21.965037 systemd[1]: Starting systemd-networkd.service - Network Configuration... Oct 9 00:40:22.001542 ignition[675]: Ignition 2.19.0 Oct 9 00:40:22.001552 ignition[675]: Stage: fetch-offline Oct 9 00:40:22.003230 systemd-networkd[754]: lo: Link UP Oct 9 00:40:22.001586 ignition[675]: no configs at "/usr/lib/ignition/base.d" Oct 9 00:40:22.003234 systemd-networkd[754]: lo: Gained carrier Oct 9 00:40:22.001594 ignition[675]: no config dir at "/usr/lib/ignition/base.platform.d/qemu" Oct 9 00:40:22.006558 systemd-networkd[754]: Enumeration completed Oct 9 00:40:22.001794 ignition[675]: parsed url from cmdline: "" Oct 9 00:40:22.006821 systemd[1]: Started systemd-networkd.service - Network Configuration. Oct 9 00:40:22.001797 ignition[675]: no config URL provided Oct 9 00:40:22.006993 systemd-networkd[754]: eth0: found matching network '/usr/lib/systemd/network/zz-default.network', based on potentially unpredictable interface name. Oct 9 00:40:22.001802 ignition[675]: reading system config file "/usr/lib/ignition/user.ign" Oct 9 00:40:22.006996 systemd-networkd[754]: eth0: Configuring with /usr/lib/systemd/network/zz-default.network. Oct 9 00:40:22.001810 ignition[675]: no config at "/usr/lib/ignition/user.ign" Oct 9 00:40:22.008029 systemd-networkd[754]: eth0: Link UP Oct 9 00:40:22.001836 ignition[675]: op(1): [started] loading QEMU firmware config module Oct 9 00:40:22.008032 systemd-networkd[754]: eth0: Gained carrier Oct 9 00:40:22.001840 ignition[675]: op(1): executing: "modprobe" "qemu_fw_cfg" Oct 9 00:40:22.008039 systemd-networkd[754]: eth0: found matching network '/usr/lib/systemd/network/zz-default.network', based on potentially unpredictable interface name. Oct 9 00:40:22.010468 ignition[675]: op(1): [finished] loading QEMU firmware config module Oct 9 00:40:22.008703 systemd[1]: Reached target network.target - Network. Oct 9 00:40:22.025265 ignition[675]: parsing config with SHA512: 41e7a43d21f0db00d8e43d5feaf6d39bf241fa377a334f38b928eb05a6fa30eab88298a8cafbc31c22f845d0e6e480f2479d7d6459d88c50384ad3a51f7a55ea Oct 9 00:40:22.028366 unknown[675]: fetched base config from "system" Oct 9 00:40:22.028914 systemd-networkd[754]: eth0: DHCPv4 address 10.0.0.31/16, gateway 10.0.0.1 acquired from 10.0.0.1 Oct 9 00:40:22.029945 unknown[675]: fetched user config from "qemu" Oct 9 00:40:22.030192 ignition[675]: fetch-offline: fetch-offline passed Oct 9 00:40:22.030294 ignition[675]: Ignition finished successfully Oct 9 00:40:22.033189 systemd[1]: Finished ignition-fetch-offline.service - Ignition (fetch-offline). Oct 9 00:40:22.034311 systemd[1]: ignition-fetch.service - Ignition (fetch) was skipped because of an unmet condition check (ConditionPathExists=!/run/ignition.json). Oct 9 00:40:22.046990 systemd[1]: Starting ignition-kargs.service - Ignition (kargs)... Oct 9 00:40:22.056586 ignition[767]: Ignition 2.19.0 Oct 9 00:40:22.056596 ignition[767]: Stage: kargs Oct 9 00:40:22.056754 ignition[767]: no configs at "/usr/lib/ignition/base.d" Oct 9 00:40:22.056764 ignition[767]: no config dir at "/usr/lib/ignition/base.platform.d/qemu" Oct 9 00:40:22.057426 ignition[767]: kargs: kargs passed Oct 9 00:40:22.057467 ignition[767]: Ignition finished successfully Oct 9 00:40:22.061314 systemd[1]: Finished ignition-kargs.service - Ignition (kargs). Oct 9 00:40:22.068066 systemd[1]: Starting ignition-disks.service - Ignition (disks)... Oct 9 00:40:22.077084 ignition[776]: Ignition 2.19.0 Oct 9 00:40:22.077093 ignition[776]: Stage: disks Oct 9 00:40:22.077258 ignition[776]: no configs at "/usr/lib/ignition/base.d" Oct 9 00:40:22.077267 ignition[776]: no config dir at "/usr/lib/ignition/base.platform.d/qemu" Oct 9 00:40:22.077932 ignition[776]: disks: createLuks: op(1): [started] waiting for devices [/dev/disk/by-partlabel/ROOT] Oct 9 00:40:22.082121 ignition[776]: disks: createLuks: op(1): [finished] waiting for devices [/dev/disk/by-partlabel/ROOT] Oct 9 00:40:22.082195 ignition[776]: disks: createLuks: created device alias for "/dev/disk/by-partlabel/ROOT": "/run/ignition/dev_aliases/dev/disk/by-partlabel/ROOT" -> "/dev/vdb9" Oct 9 00:40:22.082321 ignition[776]: disks: createLuks: op(2): [started] wiping filesystem signatures from "/run/ignition/dev_aliases/dev/disk/by-partlabel/ROOT" Oct 9 00:40:22.082327 ignition[776]: disks: createLuks: op(2): executing: "wipefs" "-a" "/run/ignition/dev_aliases/dev/disk/by-partlabel/ROOT" Oct 9 00:40:22.096841 ignition[776]: disks: createLuks: op(2): [finished] wiping filesystem signatures from "/run/ignition/dev_aliases/dev/disk/by-partlabel/ROOT" Oct 9 00:40:22.096915 ignition[776]: disks: createLuks: op(3): [started] creating "rootencrypted" Oct 9 00:40:22.096925 ignition[776]: disks: createLuks: op(3): executing: "cryptsetup" "luksFormat" "--type" "luks2" "--key-file" "/tmp/ignition-luks-1377313037" "/run/ignition/dev_aliases/dev/disk/by-partlabel/ROOT" Oct 9 00:40:23.906034 systemd-networkd[754]: eth0: Gained IPv6LL Oct 9 00:40:29.378185 ignition[776]: disks: createLuks: op(3): [finished] creating "rootencrypted" Oct 9 00:40:29.378228 ignition[776]: disks: createLuks: op(4): [started] opening luks device rootencrypted Oct 9 00:40:29.378244 ignition[776]: disks: createLuks: op(4): executing: "cryptsetup" "luksOpen" "/run/ignition/dev_aliases/dev/disk/by-partlabel/ROOT" "rootencrypted" "--key-file" "/tmp/ignition-luks-1377313037" "--persistent" Oct 9 00:40:31.328462 kernel: Key type trusted registered Oct 9 00:40:31.328511 kernel: Key type encrypted registered Oct 9 00:40:31.351900 ignition[776]: disks: createLuks: op(4): [finished] opening luks device rootencrypted Oct 9 00:40:31.351964 ignition[776]: disks: createLuks: op(5): [started] waiting for triggered uevent Oct 9 00:40:31.351972 ignition[776]: disks: createLuks: op(5): executing: "udevadm" "trigger" "--settle" "/dev/vdb9" Oct 9 00:40:31.383688 ignition[776]: disks: createLuks: op(5): [finished] waiting for triggered uevent Oct 9 00:40:31.383724 ignition[776]: disks: createFilesystems: op(6): [started] waiting for devices [/dev/mapper/rootencrypted] Oct 9 00:40:31.387792 ignition[776]: disks: createFilesystems: op(6): [finished] waiting for devices [/dev/mapper/rootencrypted] Oct 9 00:40:31.387853 ignition[776]: disks: createFilesystems: created device alias for "/dev/mapper/rootencrypted": "/run/ignition/dev_aliases/dev/mapper/rootencrypted" -> "/dev/dm-1" Oct 9 00:40:31.388055 ignition[776]: disks: createFilesystems: op(7): [started] determining filesystem type of "/dev/mapper/rootencrypted" Oct 9 00:40:31.401243 ignition[776]: disks: createFilesystems: op(7): [finished] determining filesystem type of "/dev/mapper/rootencrypted" Oct 9 00:40:31.401257 ignition[776]: disks: createFilesystems: found filesystem at "/dev/mapper/rootencrypted" with uuid "" and label "" Oct 9 00:40:31.401291 ignition[776]: disks: createFilesystems: op(8): [started] wiping filesystem signatures from "/run/ignition/dev_aliases/dev/mapper/rootencrypted" Oct 9 00:40:31.401299 ignition[776]: disks: createFilesystems: op(8): executing: "wipefs" "-a" "/run/ignition/dev_aliases/dev/mapper/rootencrypted" Oct 9 00:40:31.408420 ignition[776]: disks: createFilesystems: op(8): [finished] wiping filesystem signatures from "/run/ignition/dev_aliases/dev/mapper/rootencrypted" Oct 9 00:40:31.408454 ignition[776]: disks: createFilesystems: op(9): [started] creating "ext4" filesystem on "/run/ignition/dev_aliases/dev/mapper/rootencrypted" Oct 9 00:40:31.408462 ignition[776]: disks: createFilesystems: op(9): executing: "mkfs.ext4" "-F" "-L" "ROOT" "/run/ignition/dev_aliases/dev/mapper/rootencrypted" Oct 9 00:40:31.507821 ignition[776]: disks: createFilesystems: op(9): [finished] creating "ext4" filesystem on "/run/ignition/dev_aliases/dev/mapper/rootencrypted" Oct 9 00:40:31.507896 ignition[776]: disks: createFilesystems: op(a): [started] waiting for triggered uevent Oct 9 00:40:31.507905 ignition[776]: disks: createFilesystems: op(a): executing: "udevadm" "trigger" "--settle" "/dev/dm-1" Oct 9 00:40:31.521836 ignition[776]: disks: createFilesystems: op(a): [finished] waiting for triggered uevent Oct 9 00:40:31.521853 ignition[776]: disks: disks passed Oct 9 00:40:31.521951 ignition[776]: Ignition finished successfully Oct 9 00:40:31.524355 systemd[1]: Finished ignition-disks.service - Ignition (disks). Oct 9 00:40:31.527616 systemd[1]: Reached target initrd-root-device.target - Initrd Root Device. Oct 9 00:40:31.528537 systemd[1]: Reached target local-fs-pre.target - Preparation for Local File Systems. Oct 9 00:40:31.530134 systemd[1]: Reached target local-fs.target - Local File Systems. Oct 9 00:40:31.531698 systemd[1]: Reached target sysinit.target - System Initialization. Oct 9 00:40:31.533068 systemd[1]: Reached target basic.target - Basic System. Oct 9 00:40:31.542973 systemd[1]: Starting systemd-fsck-root.service - File System Check on /dev/disk/by-label/ROOT... Oct 9 00:40:31.553117 systemd-fsck[1778]: ROOT: clean, 11/137360 files, 26629/549376 blocks Oct 9 00:40:31.556907 systemd[1]: Finished systemd-fsck-root.service - File System Check on /dev/disk/by-label/ROOT. Oct 9 00:40:31.559038 systemd[1]: Mounting sysroot.mount - /sysroot... Oct 9 00:40:31.605642 systemd[1]: Mounted sysroot.mount - /sysroot. Oct 9 00:40:31.606771 kernel: EXT4-fs (dm-1): mounted filesystem ba886bd3-2113-4b4c-bde3-dddc7184a4a3 r/w with ordered data mode. Quota mode: none. Oct 9 00:40:31.606673 systemd[1]: Reached target initrd-root-fs.target - Initrd Root File System. Oct 9 00:40:31.616974 systemd[1]: Mounting sysroot-oem.mount - /sysroot/oem... Oct 9 00:40:31.618323 systemd[1]: Mounting sysroot-usr.mount - /sysroot/usr... Oct 9 00:40:31.619335 systemd[1]: flatcar-metadata-hostname.service - Flatcar Metadata Hostname Agent was skipped because no trigger condition checks were met. Oct 9 00:40:31.619376 systemd[1]: ignition-remount-sysroot.service - Remount /sysroot read-write for Ignition was skipped because of an unmet condition check (ConditionPathIsReadWrite=!/sysroot). Oct 9 00:40:31.624401 kernel: BTRFS: device label OEM devid 1 transid 13 /dev/vdb6 scanned by mount (1787) Oct 9 00:40:31.619400 systemd[1]: Reached target ignition-diskful.target - Ignition Boot Disk Setup. Oct 9 00:40:31.627781 kernel: BTRFS info (device vdb6): first mount of filesystem 6fd98f99-a3f6-49b2-9c3b-44aa7ae4e99b Oct 9 00:40:31.627797 kernel: BTRFS info (device vdb6): using crc32c (crc32c-generic) checksum algorithm Oct 9 00:40:31.627807 kernel: BTRFS info (device vdb6): using free space tree Oct 9 00:40:31.627820 kernel: BTRFS info (device vdb6): auto enabling async discard Oct 9 00:40:31.624641 systemd[1]: Mounted sysroot-usr.mount - /sysroot/usr. Oct 9 00:40:31.629249 systemd[1]: Mounted sysroot-oem.mount - /sysroot/oem. Oct 9 00:40:31.636999 systemd[1]: Starting initrd-setup-root.service - Root filesystem setup... Oct 9 00:40:31.649379 initrd-setup-root[1811]: cut: /sysroot/etc/passwd: No such file or directory Oct 9 00:40:31.653271 initrd-setup-root[1818]: cut: /sysroot/etc/group: No such file or directory Oct 9 00:40:31.656774 initrd-setup-root[1825]: cut: /sysroot/etc/shadow: No such file or directory Oct 9 00:40:31.660461 initrd-setup-root[1832]: cut: /sysroot/etc/gshadow: No such file or directory Oct 9 00:40:31.729301 systemd[1]: Finished initrd-setup-root.service - Root filesystem setup. Oct 9 00:40:31.740004 systemd[1]: Starting ignition-mount.service - Ignition (mount)... Oct 9 00:40:31.741342 systemd[1]: Starting sysroot-boot.service - /sysroot/boot... Oct 9 00:40:31.745300 systemd[1]: sysroot-oem.mount: Deactivated successfully. Oct 9 00:40:31.747879 kernel: BTRFS info (device vdb6): last unmount of filesystem 6fd98f99-a3f6-49b2-9c3b-44aa7ae4e99b Oct 9 00:40:31.760487 systemd[1]: Finished sysroot-boot.service - /sysroot/boot. Oct 9 00:40:31.768346 ignition[1902]: INFO : Ignition 2.19.0 Oct 9 00:40:31.768346 ignition[1902]: INFO : Stage: mount Oct 9 00:40:31.770314 ignition[1902]: INFO : no configs at "/usr/lib/ignition/base.d" Oct 9 00:40:31.770314 ignition[1902]: INFO : no config dir at "/usr/lib/ignition/base.platform.d/qemu" Oct 9 00:40:31.770314 ignition[1902]: INFO : mount: mount passed Oct 9 00:40:31.770314 ignition[1902]: INFO : Ignition finished successfully Oct 9 00:40:31.771036 systemd[1]: Finished ignition-mount.service - Ignition (mount). Oct 9 00:40:31.779978 systemd[1]: Starting ignition-files.service - Ignition (files)... Oct 9 00:40:32.615041 systemd[1]: Mounting sysroot-oem.mount - /sysroot/oem... Oct 9 00:40:32.619876 kernel: BTRFS: device label OEM devid 1 transid 14 /dev/vdb6 scanned by mount (1915) Oct 9 00:40:32.622027 kernel: BTRFS info (device vdb6): first mount of filesystem 6fd98f99-a3f6-49b2-9c3b-44aa7ae4e99b Oct 9 00:40:32.622047 kernel: BTRFS info (device vdb6): using crc32c (crc32c-generic) checksum algorithm Oct 9 00:40:32.622058 kernel: BTRFS info (device vdb6): using free space tree Oct 9 00:40:32.623884 kernel: BTRFS info (device vdb6): auto enabling async discard Oct 9 00:40:32.625040 systemd[1]: Mounted sysroot-oem.mount - /sysroot/oem. Oct 9 00:40:32.640416 ignition[1932]: INFO : Ignition 2.19.0 Oct 9 00:40:32.640416 ignition[1932]: INFO : Stage: files Oct 9 00:40:32.641737 ignition[1932]: INFO : no configs at "/usr/lib/ignition/base.d" Oct 9 00:40:32.641737 ignition[1932]: INFO : no config dir at "/usr/lib/ignition/base.platform.d/qemu" Oct 9 00:40:32.641737 ignition[1932]: DEBUG : files: compiled without relabeling support, skipping Oct 9 00:40:32.644396 ignition[1932]: INFO : files: ensureUsers: op(1): [started] creating or modifying user "core" Oct 9 00:40:32.644396 ignition[1932]: DEBUG : files: ensureUsers: op(1): executing: "usermod" "--root" "/sysroot" "core" Oct 9 00:40:32.644396 ignition[1932]: INFO : files: ensureUsers: op(1): [finished] creating or modifying user "core" Oct 9 00:40:32.644396 ignition[1932]: INFO : files: ensureUsers: op(2): [started] adding ssh keys to user "core" Oct 9 00:40:32.644396 ignition[1932]: INFO : files: ensureUsers: op(2): [finished] adding ssh keys to user "core" Oct 9 00:40:32.644350 unknown[1932]: wrote ssh authorized keys file for user: core Oct 9 00:40:32.650579 ignition[1932]: INFO : files: createFilesystemsFiles: createFiles: op(3): [started] writing file "/sysroot/etc/flatcar/update.conf" Oct 9 00:40:32.650579 ignition[1932]: INFO : files: createFilesystemsFiles: createFiles: op(3): [finished] writing file "/sysroot/etc/flatcar/update.conf" Oct 9 00:40:32.650579 ignition[1932]: INFO : files: op(4): [started] processing unit "cryptenroll-helper-first.service" Oct 9 00:40:32.650579 ignition[1932]: INFO : files: op(4): op(5): [started] writing unit "cryptenroll-helper-first.service" at "/sysroot/etc/systemd/system/cryptenroll-helper-first.service" Oct 9 00:40:32.650579 ignition[1932]: INFO : files: op(4): op(5): [finished] writing unit "cryptenroll-helper-first.service" at "/sysroot/etc/systemd/system/cryptenroll-helper-first.service" Oct 9 00:40:32.650579 ignition[1932]: INFO : files: op(4): [finished] processing unit "cryptenroll-helper-first.service" Oct 9 00:40:32.650579 ignition[1932]: INFO : files: op(6): [started] processing unit "cryptenroll-helper-bind.service" Oct 9 00:40:32.650579 ignition[1932]: INFO : files: op(6): op(7): [started] writing unit "cryptenroll-helper-bind.service" at "/sysroot/etc/systemd/system/cryptenroll-helper-bind.service" Oct 9 00:40:32.650579 ignition[1932]: INFO : files: op(6): op(7): [finished] writing unit "cryptenroll-helper-bind.service" at "/sysroot/etc/systemd/system/cryptenroll-helper-bind.service" Oct 9 00:40:32.650579 ignition[1932]: INFO : files: op(6): [finished] processing unit "cryptenroll-helper-bind.service" Oct 9 00:40:32.650579 ignition[1932]: INFO : files: op(8): [started] processing unit "coreos-metadata.service" Oct 9 00:40:32.650579 ignition[1932]: INFO : files: op(8): op(9): [started] writing unit "coreos-metadata.service" at "/sysroot/etc/systemd/system/coreos-metadata.service" Oct 9 00:40:32.650579 ignition[1932]: INFO : files: op(8): op(9): [finished] writing unit "coreos-metadata.service" at "/sysroot/etc/systemd/system/coreos-metadata.service" Oct 9 00:40:32.650579 ignition[1932]: INFO : files: op(8): [finished] processing unit "coreos-metadata.service" Oct 9 00:40:32.650579 ignition[1932]: INFO : files: op(a): [started] setting preset to disabled for "coreos-metadata.service" Oct 9 00:40:32.671598 ignition[1932]: INFO : files: op(a): op(b): [started] removing enablement symlink(s) for "coreos-metadata.service" Oct 9 00:40:32.671598 ignition[1932]: INFO : files: op(a): op(b): [finished] removing enablement symlink(s) for "coreos-metadata.service" Oct 9 00:40:32.671598 ignition[1932]: INFO : files: op(a): [finished] setting preset to disabled for "coreos-metadata.service" Oct 9 00:40:32.671598 ignition[1932]: INFO : files: op(c): [started] setting preset to enabled for "cryptenroll-helper-bind.service" Oct 9 00:40:32.671598 ignition[1932]: INFO : files: op(c): [finished] setting preset to enabled for "cryptenroll-helper-bind.service" Oct 9 00:40:32.671598 ignition[1932]: INFO : files: op(d): [started] setting preset to enabled for "cryptenroll-helper-first.service" Oct 9 00:40:32.671598 ignition[1932]: INFO : files: op(d): [finished] setting preset to enabled for "cryptenroll-helper-first.service" Oct 9 00:40:32.671598 ignition[1932]: INFO : files: createCrypttabEntries: createFiles: op(e): [started] writing file "/sysroot/etc/luks/rootencrypted" Oct 9 00:40:32.671598 ignition[1932]: INFO : files: createCrypttabEntries: createFiles: op(e): [finished] writing file "/sysroot/etc/luks/rootencrypted" Oct 9 00:40:32.671598 ignition[1932]: INFO : files: createCrypttabEntries: createFiles: op(f): [started] writing file "/sysroot/etc/crypttab" Oct 9 00:40:32.671598 ignition[1932]: INFO : files: createCrypttabEntries: createFiles: op(f): [finished] writing file "/sysroot/etc/crypttab" Oct 9 00:40:32.671598 ignition[1932]: INFO : files: createCrypttabEntries: createFiles: op(10): [started] appending to file "/sysroot/etc/crypttab" Oct 9 00:40:32.671598 ignition[1932]: INFO : files: createCrypttabEntries: createFiles: op(10): [finished] appending to file "/sysroot/etc/crypttab" Oct 9 00:40:32.671598 ignition[1932]: INFO : files: createResultFile: createFiles: op(11): [started] writing file "/sysroot/etc/.ignition-result.json" Oct 9 00:40:32.671598 ignition[1932]: INFO : files: createResultFile: createFiles: op(11): [finished] writing file "/sysroot/etc/.ignition-result.json" Oct 9 00:40:32.671598 ignition[1932]: INFO : files: files passed Oct 9 00:40:32.671598 ignition[1932]: INFO : Ignition finished successfully Oct 9 00:40:32.665650 systemd[1]: Finished ignition-files.service - Ignition (files). Oct 9 00:40:32.671023 systemd[1]: Starting ignition-quench.service - Ignition (record completion)... Oct 9 00:40:32.673041 systemd[1]: Starting initrd-setup-root-after-ignition.service - Root filesystem completion... Oct 9 00:40:32.677528 systemd[1]: ignition-quench.service: Deactivated successfully. Oct 9 00:40:32.698021 initrd-setup-root-after-ignition[1961]: grep: /sysroot/oem/oem-release: No such file or directory Oct 9 00:40:32.677615 systemd[1]: Finished ignition-quench.service - Ignition (record completion). Oct 9 00:40:32.699763 initrd-setup-root-after-ignition[1963]: grep: /sysroot/etc/flatcar/enabled-sysext.conf: No such file or directory Oct 9 00:40:32.699763 initrd-setup-root-after-ignition[1963]: grep: /sysroot/usr/share/flatcar/enabled-sysext.conf: No such file or directory Oct 9 00:40:32.690437 systemd[1]: Finished initrd-setup-root-after-ignition.service - Root filesystem completion. Oct 9 00:40:32.702963 initrd-setup-root-after-ignition[1967]: grep: /sysroot/etc/flatcar/enabled-sysext.conf: No such file or directory Oct 9 00:40:32.691910 systemd[1]: Reached target ignition-complete.target - Ignition Complete. Oct 9 00:40:32.704007 systemd[1]: Starting initrd-parse-etc.service - Mountpoints Configured in the Real Root... Oct 9 00:40:32.722980 systemd[1]: initrd-parse-etc.service: Deactivated successfully. Oct 9 00:40:32.723100 systemd[1]: Finished initrd-parse-etc.service - Mountpoints Configured in the Real Root. Oct 9 00:40:32.724798 systemd[1]: Reached target initrd-fs.target - Initrd File Systems. Oct 9 00:40:32.726246 systemd[1]: Reached target initrd.target - Initrd Default Target. Oct 9 00:40:32.727631 systemd[1]: dracut-mount.service - dracut mount hook was skipped because no trigger condition checks were met. Oct 9 00:40:32.728403 systemd[1]: Starting dracut-pre-pivot.service - dracut pre-pivot and cleanup hook... Oct 9 00:40:32.744286 systemd[1]: Finished dracut-pre-pivot.service - dracut pre-pivot and cleanup hook. Oct 9 00:40:32.746473 systemd[1]: Starting initrd-cleanup.service - Cleaning Up and Shutting Down Daemons... Oct 9 00:40:32.757378 systemd[1]: Stopped target nss-lookup.target - Host and Network Name Lookups. Oct 9 00:40:32.758436 systemd[1]: Stopped target remote-cryptsetup.target - Remote Encrypted Volumes. Oct 9 00:40:32.760987 systemd[1]: Stopped target timers.target - Timer Units. Oct 9 00:40:32.762385 systemd[1]: dracut-pre-pivot.service: Deactivated successfully. Oct 9 00:40:32.762510 systemd[1]: Stopped dracut-pre-pivot.service - dracut pre-pivot and cleanup hook. Oct 9 00:40:32.765007 systemd[1]: Stopped target initrd.target - Initrd Default Target. Oct 9 00:40:32.765790 systemd[1]: Stopped target basic.target - Basic System. Oct 9 00:40:32.767005 systemd[1]: Stopped target ignition-complete.target - Ignition Complete. Oct 9 00:40:32.768239 systemd[1]: Stopped target ignition-diskful.target - Ignition Boot Disk Setup. Oct 9 00:40:32.769636 systemd[1]: Stopped target initrd-root-device.target - Initrd Root Device. Oct 9 00:40:32.771051 systemd[1]: Stopped target remote-fs.target - Remote File Systems. Oct 9 00:40:32.772398 systemd[1]: Stopped target remote-fs-pre.target - Preparation for Remote File Systems. Oct 9 00:40:32.773867 systemd[1]: Stopped target sysinit.target - System Initialization. Oct 9 00:40:32.775423 systemd[1]: Stopped target local-fs.target - Local File Systems. Oct 9 00:40:32.776768 systemd[1]: Stopped target swap.target - Swaps. Oct 9 00:40:32.778010 systemd[1]: dracut-pre-mount.service: Deactivated successfully. Oct 9 00:40:32.778130 systemd[1]: Stopped dracut-pre-mount.service - dracut pre-mount hook. Oct 9 00:40:32.779954 systemd[1]: Stopped target cryptsetup.target - Local Encrypted Volumes. Oct 9 00:40:32.781441 systemd[1]: Stopped target cryptsetup-pre.target - Local Encrypted Volumes (Pre). Oct 9 00:40:32.782895 systemd[1]: clevis-luks-askpass.path: Deactivated successfully. Oct 9 00:40:32.784391 systemd[1]: Stopped clevis-luks-askpass.path - Forward Password Requests to Clevis Directory Watch. Oct 9 00:40:32.785388 systemd[1]: dracut-initqueue.service: Deactivated successfully. Oct 9 00:40:32.785507 systemd[1]: Stopped dracut-initqueue.service - dracut initqueue hook. Oct 9 00:40:32.787706 systemd[1]: ignition-fetch-offline.service: Deactivated successfully. Oct 9 00:40:32.787819 systemd[1]: Stopped ignition-fetch-offline.service - Ignition (fetch-offline). Oct 9 00:40:32.789349 systemd[1]: Stopped target paths.target - Path Units. Oct 9 00:40:32.790526 systemd[1]: systemd-ask-password-console.path: Deactivated successfully. Oct 9 00:40:32.794914 systemd[1]: Stopped systemd-ask-password-console.path - Dispatch Password Requests to Console Directory Watch. Oct 9 00:40:32.795898 systemd[1]: Stopped target slices.target - Slice Units. Oct 9 00:40:32.797529 systemd[1]: Stopped target sockets.target - Socket Units. Oct 9 00:40:32.798743 systemd[1]: iscsid.socket: Deactivated successfully. Oct 9 00:40:32.798828 systemd[1]: Closed iscsid.socket - Open-iSCSI iscsid Socket. Oct 9 00:40:32.799954 systemd[1]: iscsiuio.socket: Deactivated successfully. Oct 9 00:40:32.800039 systemd[1]: Closed iscsiuio.socket - Open-iSCSI iscsiuio Socket. Oct 9 00:40:32.801366 systemd[1]: initrd-setup-root-after-ignition.service: Deactivated successfully. Oct 9 00:40:32.801548 systemd[1]: Stopped initrd-setup-root-after-ignition.service - Root filesystem completion. Oct 9 00:40:32.802700 systemd[1]: ignition-files.service: Deactivated successfully. Oct 9 00:40:32.802802 systemd[1]: Stopped ignition-files.service - Ignition (files). Oct 9 00:40:32.815061 systemd[1]: Stopping ignition-mount.service - Ignition (mount)... Oct 9 00:40:32.815785 systemd[1]: kmod-static-nodes.service: Deactivated successfully. Oct 9 00:40:32.815919 systemd[1]: Stopped kmod-static-nodes.service - Create List of Static Device Nodes. Oct 9 00:40:32.819039 systemd[1]: Stopping sysroot-boot.service - /sysroot/boot... Oct 9 00:40:32.819718 systemd[1]: systemd-udev-trigger.service: Deactivated successfully. Oct 9 00:40:32.819835 systemd[1]: Stopped systemd-udev-trigger.service - Coldplug All udev Devices. Oct 9 00:40:32.821401 systemd[1]: dracut-pre-trigger.service: Deactivated successfully. Oct 9 00:40:32.821502 systemd[1]: Stopped dracut-pre-trigger.service - dracut pre-trigger hook. Oct 9 00:40:32.827344 systemd[1]: initrd-cleanup.service: Deactivated successfully. Oct 9 00:40:32.827467 systemd[1]: Finished initrd-cleanup.service - Cleaning Up and Shutting Down Daemons. Oct 9 00:40:32.831610 ignition[1988]: INFO : Ignition 2.19.0 Oct 9 00:40:32.831610 ignition[1988]: INFO : Stage: umount Oct 9 00:40:32.831610 ignition[1988]: INFO : no configs at "/usr/lib/ignition/base.d" Oct 9 00:40:32.831610 ignition[1988]: INFO : no config dir at "/usr/lib/ignition/base.platform.d/qemu" Oct 9 00:40:32.831610 ignition[1988]: INFO : umount: umount passed Oct 9 00:40:32.831610 ignition[1988]: INFO : Ignition finished successfully Oct 9 00:40:32.832142 systemd[1]: sysroot-boot.mount: Deactivated successfully. Oct 9 00:40:32.834493 systemd[1]: sysroot-boot.service: Deactivated successfully. Oct 9 00:40:32.834584 systemd[1]: Stopped sysroot-boot.service - /sysroot/boot. Oct 9 00:40:32.835775 systemd[1]: ignition-mount.service: Deactivated successfully. Oct 9 00:40:32.835840 systemd[1]: Stopped ignition-mount.service - Ignition (mount). Oct 9 00:40:32.837260 systemd[1]: Stopped target network.target - Network. Oct 9 00:40:32.838024 systemd[1]: ignition-disks.service: Deactivated successfully. Oct 9 00:40:32.838081 systemd[1]: Stopped ignition-disks.service - Ignition (disks). Oct 9 00:40:32.839250 systemd[1]: ignition-kargs.service: Deactivated successfully. Oct 9 00:40:32.839285 systemd[1]: Stopped ignition-kargs.service - Ignition (kargs). Oct 9 00:40:32.840591 systemd[1]: ignition-setup.service: Deactivated successfully. Oct 9 00:40:32.840644 systemd[1]: Stopped ignition-setup.service - Ignition (setup). Oct 9 00:40:32.841821 systemd[1]: ignition-setup-pre.service: Deactivated successfully. Oct 9 00:40:32.841854 systemd[1]: Stopped ignition-setup-pre.service - Ignition env setup. Oct 9 00:40:32.843165 systemd[1]: initrd-setup-root.service: Deactivated successfully. Oct 9 00:40:32.843201 systemd[1]: Stopped initrd-setup-root.service - Root filesystem setup. Oct 9 00:40:32.844641 systemd[1]: Stopping systemd-networkd.service - Network Configuration... Oct 9 00:40:32.845967 systemd[1]: Stopping systemd-resolved.service - Network Name Resolution... Oct 9 00:40:32.853933 systemd-networkd[754]: eth0: DHCPv6 lease lost Oct 9 00:40:32.855123 systemd[1]: systemd-networkd.service: Deactivated successfully. Oct 9 00:40:32.855221 systemd[1]: Stopped systemd-networkd.service - Network Configuration. Oct 9 00:40:32.856968 systemd[1]: systemd-networkd.socket: Deactivated successfully. Oct 9 00:40:32.857039 systemd[1]: Closed systemd-networkd.socket - Network Service Netlink Socket. Oct 9 00:40:32.865986 systemd[1]: Stopping network-cleanup.service - Network Cleanup... Oct 9 00:40:32.866691 systemd[1]: parse-ip-for-networkd.service: Deactivated successfully. Oct 9 00:40:32.866753 systemd[1]: Stopped parse-ip-for-networkd.service - Write systemd-networkd units from cmdline. Oct 9 00:40:32.868614 systemd[1]: Stopping systemd-udevd.service - Rule-based Manager for Device Events and Files... Oct 9 00:40:32.870287 systemd[1]: systemd-resolved.service: Deactivated successfully. Oct 9 00:40:32.870374 systemd[1]: Stopped systemd-resolved.service - Network Name Resolution. Oct 9 00:40:32.873871 systemd[1]: systemd-sysctl.service: Deactivated successfully. Oct 9 00:40:32.873923 systemd[1]: Stopped systemd-sysctl.service - Apply Kernel Variables. Oct 9 00:40:32.875129 systemd[1]: systemd-modules-load.service: Deactivated successfully. Oct 9 00:40:32.875169 systemd[1]: Stopped systemd-modules-load.service - Load Kernel Modules. Oct 9 00:40:32.876590 systemd[1]: systemd-tmpfiles-setup.service: Deactivated successfully. Oct 9 00:40:32.876624 systemd[1]: Stopped systemd-tmpfiles-setup.service - Create System Files and Directories. Oct 9 00:40:32.879247 systemd[1]: network-cleanup.service: Deactivated successfully. Oct 9 00:40:32.879334 systemd[1]: Stopped network-cleanup.service - Network Cleanup. Oct 9 00:40:32.881279 systemd[1]: systemd-udevd.service: Deactivated successfully. Oct 9 00:40:32.881400 systemd[1]: Stopped systemd-udevd.service - Rule-based Manager for Device Events and Files. Oct 9 00:40:32.882995 systemd[1]: systemd-udevd-control.socket: Deactivated successfully. Oct 9 00:40:32.883051 systemd[1]: Closed systemd-udevd-control.socket - udev Control Socket. Oct 9 00:40:32.883941 systemd[1]: systemd-udevd-kernel.socket: Deactivated successfully. Oct 9 00:40:32.883972 systemd[1]: Closed systemd-udevd-kernel.socket - udev Kernel Socket. Oct 9 00:40:32.885293 systemd[1]: dracut-pre-udev.service: Deactivated successfully. Oct 9 00:40:32.885333 systemd[1]: Stopped dracut-pre-udev.service - dracut pre-udev hook. Oct 9 00:40:32.887340 systemd[1]: dracut-cmdline.service: Deactivated successfully. Oct 9 00:40:32.887384 systemd[1]: Stopped dracut-cmdline.service - dracut cmdline hook. Oct 9 00:40:32.889735 systemd[1]: dracut-cmdline-ask.service: Deactivated successfully. Oct 9 00:40:32.889777 systemd[1]: Stopped dracut-cmdline-ask.service - dracut ask for additional cmdline parameters. Oct 9 00:40:32.905018 systemd[1]: Starting initrd-udevadm-cleanup-db.service - Cleanup udev Database... Oct 9 00:40:32.905799 systemd[1]: systemd-tmpfiles-setup-dev.service: Deactivated successfully. Oct 9 00:40:32.905849 systemd[1]: Stopped systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev. Oct 9 00:40:32.907547 systemd[1]: systemd-vconsole-setup.service: Deactivated successfully. Oct 9 00:40:32.907587 systemd[1]: Stopped systemd-vconsole-setup.service - Virtual Console Setup. Oct 9 00:40:32.910039 systemd[1]: initrd-udevadm-cleanup-db.service: Deactivated successfully. Oct 9 00:40:32.910927 systemd[1]: Finished initrd-udevadm-cleanup-db.service - Cleanup udev Database. Oct 9 00:40:32.912386 systemd[1]: Reached target initrd-switch-root.target - Switch Root. Oct 9 00:40:32.914191 systemd[1]: Starting initrd-switch-root.service - Switch Root... Oct 9 00:40:32.922757 systemd[1]: Switching root. Oct 9 00:40:32.951883 systemd-journald[237]: Received SIGTERM from PID 1 (systemd). Oct 9 00:40:32.951926 systemd-journald[237]: Journal stopped Oct 9 00:40:33.542492 kernel: SELinux: policy capability network_peer_controls=1 Oct 9 00:40:33.542545 kernel: SELinux: policy capability open_perms=1 Oct 9 00:40:33.542557 kernel: SELinux: policy capability extended_socket_class=1 Oct 9 00:40:33.542570 kernel: SELinux: policy capability always_check_network=0 Oct 9 00:40:33.542580 kernel: SELinux: policy capability cgroup_seclabel=1 Oct 9 00:40:33.542596 kernel: SELinux: policy capability nnp_nosuid_transition=1 Oct 9 00:40:33.542608 kernel: SELinux: policy capability genfs_seclabel_symlinks=0 Oct 9 00:40:33.542618 kernel: SELinux: policy capability ioctl_skip_cloexec=0 Oct 9 00:40:33.542627 kernel: audit: type=1403 audit(1728434433.014:2): auid=4294967295 ses=4294967295 lsm=selinux res=1 Oct 9 00:40:33.542642 systemd[1]: Successfully loaded SELinux policy in 29.949ms. Oct 9 00:40:33.542659 systemd[1]: Relabeled /dev, /dev/shm, /run, /sys/fs/cgroup in 10.342ms. Oct 9 00:40:33.542671 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 9 00:40:33.542683 systemd[1]: Detected virtualization kvm. Oct 9 00:40:33.542694 systemd[1]: Detected architecture arm64. Oct 9 00:40:33.542704 systemd[1]: Detected first boot. Oct 9 00:40:33.542715 systemd[1]: Initializing machine ID from VM UUID. Oct 9 00:40:33.542725 zram_generator::config[2036]: No configuration found. Oct 9 00:40:33.542738 systemd[1]: Populated /etc with preset unit settings. Oct 9 00:40:33.542748 systemd[1]: initrd-switch-root.service: Deactivated successfully. Oct 9 00:40:33.542758 systemd[1]: Stopped initrd-switch-root.service - Switch Root. Oct 9 00:40:33.542769 systemd[1]: systemd-journald.service: Scheduled restart job, restart counter is at 1. Oct 9 00:40:33.542780 systemd[1]: Created slice system-addon\x2dconfig.slice - Slice /system/addon-config. Oct 9 00:40:33.542790 systemd[1]: Created slice system-addon\x2drun.slice - Slice /system/addon-run. Oct 9 00:40:33.542800 systemd[1]: Created slice system-getty.slice - Slice /system/getty. Oct 9 00:40:33.542810 systemd[1]: Created slice system-modprobe.slice - Slice /system/modprobe. Oct 9 00:40:33.542821 systemd[1]: Created slice system-serial\x2dgetty.slice - Slice /system/serial-getty. Oct 9 00:40:33.542833 systemd[1]: Created slice system-system\x2dcloudinit.slice - Slice /system/system-cloudinit. Oct 9 00:40:33.542844 systemd[1]: Created slice system-systemd\x2dcryptsetup.slice - Encrypted Volume Units Service Slice. Oct 9 00:40:33.542854 systemd[1]: Created slice system-systemd\x2dfsck.slice - Slice /system/systemd-fsck. Oct 9 00:40:33.542893 systemd[1]: Created slice user.slice - User and Session Slice. Oct 9 00:40:33.542904 systemd[1]: Started clevis-luks-askpass.path - Forward Password Requests to Clevis Directory Watch. Oct 9 00:40:33.542915 systemd[1]: Started systemd-ask-password-console.path - Dispatch Password Requests to Console Directory Watch. Oct 9 00:40:33.542926 systemd[1]: Started systemd-ask-password-wall.path - Forward Password Requests to Wall Directory Watch. Oct 9 00:40:33.542936 systemd[1]: Set up automount boot.automount - Boot partition Automount Point. Oct 9 00:40:33.542950 systemd[1]: Set up automount proc-sys-fs-binfmt_misc.automount - Arbitrary Executable File Formats File System Automount Point. Oct 9 00:40:33.542961 systemd[1]: Expecting device dev-disk-by\x2dlabel-OEM.device - /dev/disk/by-label/OEM... Oct 9 00:40:33.542972 systemd[1]: Expecting device dev-disk-by\x2duuid-a7656c31\x2d7c51\x2d4be3\x2d8fb7\x2d805a18f1d3f6.device - /dev/disk/by-uuid/a7656c31-7c51-4be3-8fb7-805a18f1d3f6... Oct 9 00:40:33.542983 systemd[1]: Expecting device dev-ttyAMA0.device - /dev/ttyAMA0... Oct 9 00:40:33.542994 systemd[1]: Reached target cryptsetup-pre.target - Local Encrypted Volumes (Pre). Oct 9 00:40:33.543004 systemd[1]: Stopped target initrd-switch-root.target - Switch Root. Oct 9 00:40:33.543014 systemd[1]: Stopped target initrd-fs.target - Initrd File Systems. Oct 9 00:40:33.543025 systemd[1]: Stopped target initrd-root-fs.target - Initrd Root File System. Oct 9 00:40:33.543037 systemd[1]: Reached target integritysetup.target - Local Integrity Protected Volumes. Oct 9 00:40:33.543047 systemd[1]: Reached target remote-cryptsetup.target - Remote Encrypted Volumes. Oct 9 00:40:33.543057 systemd[1]: Reached target remote-fs.target - Remote File Systems. Oct 9 00:40:33.543068 systemd[1]: Reached target slices.target - Slice Units. Oct 9 00:40:33.543079 systemd[1]: Reached target swap.target - Swaps. Oct 9 00:40:33.543090 systemd[1]: Reached target veritysetup.target - Local Verity Protected Volumes. Oct 9 00:40:33.543102 systemd[1]: Listening on systemd-coredump.socket - Process Core Dump Socket. Oct 9 00:40:33.543112 systemd[1]: Listening on systemd-networkd.socket - Network Service Netlink Socket. Oct 9 00:40:33.543123 systemd[1]: Listening on systemd-udevd-control.socket - udev Control Socket. Oct 9 00:40:33.543135 systemd[1]: Listening on systemd-udevd-kernel.socket - udev Kernel Socket. Oct 9 00:40:33.543146 systemd[1]: Listening on systemd-userdbd.socket - User Database Manager Socket. Oct 9 00:40:33.543156 systemd[1]: Mounting dev-hugepages.mount - Huge Pages File System... Oct 9 00:40:33.543166 systemd[1]: Mounting dev-mqueue.mount - POSIX Message Queue File System... Oct 9 00:40:33.543176 systemd[1]: Mounting media.mount - External Media Directory... Oct 9 00:40:33.543187 systemd[1]: Mounting sys-kernel-debug.mount - Kernel Debug File System... Oct 9 00:40:33.543197 systemd[1]: Mounting sys-kernel-tracing.mount - Kernel Trace File System... Oct 9 00:40:33.543207 systemd[1]: Mounting tmp.mount - Temporary Directory /tmp... Oct 9 00:40:33.543218 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 9 00:40:33.543230 systemd[1]: Reached target machines.target - Containers. Oct 9 00:40:33.543240 systemd[1]: Starting flatcar-tmpfiles.service - Create missing system files... Oct 9 00:40:33.543251 systemd[1]: ignition-delete-config.service - Ignition (delete config) was skipped because no trigger condition checks were met. Oct 9 00:40:33.543261 systemd[1]: Starting kmod-static-nodes.service - Create List of Static Device Nodes... Oct 9 00:40:33.543271 systemd[1]: Starting modprobe@configfs.service - Load Kernel Module configfs... Oct 9 00:40:33.543281 systemd[1]: Starting modprobe@dm_mod.service - Load Kernel Module dm_mod... Oct 9 00:40:33.543292 systemd[1]: Starting modprobe@drm.service - Load Kernel Module drm... Oct 9 00:40:33.543302 systemd[1]: Starting modprobe@efi_pstore.service - Load Kernel Module efi_pstore... Oct 9 00:40:33.543314 systemd[1]: Starting modprobe@fuse.service - Load Kernel Module fuse... Oct 9 00:40:33.543326 systemd[1]: Starting modprobe@loop.service - Load Kernel Module loop... Oct 9 00:40:33.543336 systemd[1]: setup-nsswitch.service - Create /etc/nsswitch.conf was skipped because of an unmet condition check (ConditionPathExists=!/etc/nsswitch.conf). Oct 9 00:40:33.543376 systemd[1]: systemd-fsck-root.service: Deactivated successfully. Oct 9 00:40:33.543386 systemd[1]: Stopped systemd-fsck-root.service - File System Check on Root Device. Oct 9 00:40:33.543396 systemd[1]: systemd-fsck-usr.service: Deactivated successfully. Oct 9 00:40:33.543406 systemd[1]: Stopped systemd-fsck-usr.service. Oct 9 00:40:33.543416 kernel: fuse: init (API version 7.39) Oct 9 00:40:33.543426 kernel: loop: module loaded Oct 9 00:40:33.543438 systemd[1]: Starting systemd-journald.service - Journal Service... Oct 9 00:40:33.543448 systemd[1]: Starting systemd-modules-load.service - Load Kernel Modules... Oct 9 00:40:33.543459 systemd[1]: Starting systemd-network-generator.service - Generate network units from Kernel command line... Oct 9 00:40:33.543477 systemd[1]: Starting systemd-remount-fs.service - Remount Root and Kernel File Systems... Oct 9 00:40:33.543487 kernel: ACPI: bus type drm_connector registered Oct 9 00:40:33.543512 systemd-journald[2100]: Collecting audit messages is disabled. Oct 9 00:40:33.543539 systemd[1]: Starting systemd-udev-trigger.service - Coldplug All udev Devices... Oct 9 00:40:33.543551 systemd-journald[2100]: Journal started Oct 9 00:40:33.543572 systemd-journald[2100]: Runtime Journal (/run/log/journal/77d3fb4d0fc34e56a5becad83947f740) is 5.9M, max 47.3M, 41.4M free. Oct 9 00:40:33.366263 systemd[1]: Queued start job for default target multi-user.target. Oct 9 00:40:33.387836 systemd[1]: Unnecessary job was removed for dev-vdb6.device - /dev/vdb6. Oct 9 00:40:33.388186 systemd[1]: systemd-journald.service: Deactivated successfully. Oct 9 00:40:33.544281 systemd[1]: verity-setup.service: Deactivated successfully. Oct 9 00:40:33.545981 systemd[1]: Stopped verity-setup.service. Oct 9 00:40:33.551865 systemd[1]: Started systemd-journald.service - Journal Service. Oct 9 00:40:33.551327 systemd[1]: Mounted dev-hugepages.mount - Huge Pages File System. Oct 9 00:40:33.552202 systemd[1]: Mounted dev-mqueue.mount - POSIX Message Queue File System. Oct 9 00:40:33.553135 systemd[1]: Mounted media.mount - External Media Directory. Oct 9 00:40:33.553976 systemd[1]: Mounted sys-kernel-debug.mount - Kernel Debug File System. Oct 9 00:40:33.554824 systemd[1]: Mounted sys-kernel-tracing.mount - Kernel Trace File System. Oct 9 00:40:33.555755 systemd[1]: Mounted tmp.mount - Temporary Directory /tmp. Oct 9 00:40:33.557887 systemd[1]: Finished flatcar-tmpfiles.service - Create missing system files. Oct 9 00:40:33.559086 systemd[1]: Finished kmod-static-nodes.service - Create List of Static Device Nodes. Oct 9 00:40:33.560384 systemd[1]: modprobe@configfs.service: Deactivated successfully. Oct 9 00:40:33.560532 systemd[1]: Finished modprobe@configfs.service - Load Kernel Module configfs. Oct 9 00:40:33.561908 systemd[1]: modprobe@dm_mod.service: Deactivated successfully. Oct 9 00:40:33.562045 systemd[1]: Finished modprobe@dm_mod.service - Load Kernel Module dm_mod. Oct 9 00:40:33.563187 systemd[1]: modprobe@drm.service: Deactivated successfully. Oct 9 00:40:33.563312 systemd[1]: Finished modprobe@drm.service - Load Kernel Module drm. Oct 9 00:40:33.566172 systemd[1]: modprobe@efi_pstore.service: Deactivated successfully. Oct 9 00:40:33.566304 systemd[1]: Finished modprobe@efi_pstore.service - Load Kernel Module efi_pstore. Oct 9 00:40:33.567504 systemd[1]: modprobe@fuse.service: Deactivated successfully. Oct 9 00:40:33.567629 systemd[1]: Finished modprobe@fuse.service - Load Kernel Module fuse. Oct 9 00:40:33.568746 systemd[1]: modprobe@loop.service: Deactivated successfully. Oct 9 00:40:33.568887 systemd[1]: Finished modprobe@loop.service - Load Kernel Module loop. Oct 9 00:40:33.569986 systemd[1]: Finished systemd-modules-load.service - Load Kernel Modules. Oct 9 00:40:33.571048 systemd[1]: Finished systemd-network-generator.service - Generate network units from Kernel command line. Oct 9 00:40:33.572271 systemd[1]: Finished systemd-remount-fs.service - Remount Root and Kernel File Systems. Oct 9 00:40:33.584274 systemd[1]: Reached target network-pre.target - Preparation for Network. Oct 9 00:40:33.593964 systemd[1]: Mounting sys-fs-fuse-connections.mount - FUSE Control File System... Oct 9 00:40:33.595725 systemd[1]: Mounting sys-kernel-config.mount - Kernel Configuration File System... Oct 9 00:40:33.596663 systemd[1]: remount-root.service - Remount Root File System was skipped because of an unmet condition check (ConditionPathIsReadWrite=!/). Oct 9 00:40:33.596700 systemd[1]: Reached target local-fs.target - Local File Systems. Oct 9 00:40:33.598344 systemd[1]: Listening on systemd-sysext.socket - System Extension Image Management (Varlink). Oct 9 00:40:33.600162 systemd[1]: Starting dracut-shutdown.service - Restore /run/initramfs on shutdown... Oct 9 00:40:33.601973 systemd[1]: Starting ldconfig.service - Rebuild Dynamic Linker Cache... Oct 9 00:40:33.602845 systemd[1]: systemd-binfmt.service - Set Up Additional Binary Formats was skipped because no trigger condition checks were met. Oct 9 00:40:33.604160 systemd[1]: Starting systemd-hwdb-update.service - Rebuild Hardware Database... Oct 9 00:40:33.606407 systemd[1]: Starting systemd-journal-flush.service - Flush Journal to Persistent Storage... Oct 9 00:40:33.607508 systemd[1]: systemd-pstore.service - Platform Persistent Storage Archival was skipped because of an unmet condition check (ConditionDirectoryNotEmpty=/sys/fs/pstore). Oct 9 00:40:33.608557 systemd[1]: Starting systemd-random-seed.service - Load/Save OS Random Seed... Oct 9 00:40:33.609486 systemd[1]: systemd-repart.service - Repartition Root Disk was skipped because no trigger condition checks were met. Oct 9 00:40:33.613025 systemd[1]: Starting systemd-sysctl.service - Apply Kernel Variables... Oct 9 00:40:33.618062 systemd[1]: Starting systemd-sysext.service - Merge System Extension Images into /usr/ and /opt/... Oct 9 00:40:33.621043 systemd-journald[2100]: Time spent on flushing to /var/log/journal/77d3fb4d0fc34e56a5becad83947f740 is 16.355ms for 881 entries. Oct 9 00:40:33.621043 systemd-journald[2100]: System Journal (/var/log/journal/77d3fb4d0fc34e56a5becad83947f740) is 8.0M, max 204.2M, 196.1M free. Oct 9 00:40:33.653744 systemd-journald[2100]: Received client request to flush runtime journal. Oct 9 00:40:33.653783 kernel: loop0: detected capacity change from 0 to 116808 Oct 9 00:40:33.653815 kernel: squashfs: version 4.0 (2009/01/31) Phillip Lougher Oct 9 00:40:33.622952 systemd[1]: Starting systemd-sysusers.service - Create System Users... Oct 9 00:40:33.627146 systemd[1]: Finished systemd-udev-trigger.service - Coldplug All udev Devices. Oct 9 00:40:33.628402 systemd[1]: Mounted sys-fs-fuse-connections.mount - FUSE Control File System. Oct 9 00:40:33.629968 systemd[1]: Mounted sys-kernel-config.mount - Kernel Configuration File System. Oct 9 00:40:33.631995 systemd[1]: Finished dracut-shutdown.service - Restore /run/initramfs on shutdown. Oct 9 00:40:33.633285 systemd[1]: Finished systemd-random-seed.service - Load/Save OS Random Seed. Oct 9 00:40:33.639876 systemd[1]: Reached target first-boot-complete.target - First Boot Complete. Oct 9 00:40:33.658049 systemd[1]: Starting systemd-machine-id-commit.service - Commit a transient machine-id on disk... Oct 9 00:40:33.660476 systemd[1]: Starting systemd-udev-settle.service - Wait for udev To Complete Device Initialization... Oct 9 00:40:33.662917 systemd[1]: Finished systemd-journal-flush.service - Flush Journal to Persistent Storage. Oct 9 00:40:33.664479 systemd[1]: Finished systemd-sysctl.service - Apply Kernel Variables. Oct 9 00:40:33.674892 systemd[1]: Finished systemd-sysusers.service - Create System Users. Oct 9 00:40:33.677259 systemd[1]: Starting systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev... Oct 9 00:40:33.680971 kernel: loop1: detected capacity change from 0 to 113456 Oct 9 00:40:33.685169 udevadm[2163]: systemd-udev-settle.service is deprecated. Please fix lvm2-activation.service, lvm2-activation-early.service not to pull it in. Oct 9 00:40:33.691644 systemd[1]: etc-machine\x2did.mount: Deactivated successfully. Oct 9 00:40:33.693415 systemd[1]: Finished systemd-machine-id-commit.service - Commit a transient machine-id on disk. Oct 9 00:40:33.701788 systemd-tmpfiles[2167]: ACLs are not supported, ignoring. Oct 9 00:40:33.702087 systemd-tmpfiles[2167]: ACLs are not supported, ignoring. Oct 9 00:40:33.705996 systemd[1]: Finished systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev. Oct 9 00:40:33.709949 kernel: loop2: detected capacity change from 0 to 116808 Oct 9 00:40:33.714875 kernel: loop3: detected capacity change from 0 to 113456 Oct 9 00:40:33.717264 (sd-merge)[2172]: Using extensions 'containerd-flatcar', 'docker-flatcar'. Oct 9 00:40:33.717592 (sd-merge)[2172]: Merged extensions into '/usr'. Oct 9 00:40:33.720565 systemd[1]: Finished systemd-sysext.service - Merge System Extension Images into /usr/ and /opt/. Oct 9 00:40:33.730099 systemd[1]: Starting ensure-sysext.service... Oct 9 00:40:33.733019 systemd[1]: Starting systemd-tmpfiles-setup.service - Create System Files and Directories... Oct 9 00:40:33.741370 systemd[1]: Reloading requested from client PID 2174 ('systemctl') (unit ensure-sysext.service)... Oct 9 00:40:33.741385 systemd[1]: Reloading... Oct 9 00:40:33.753637 systemd-tmpfiles[2175]: /usr/lib/tmpfiles.d/provision.conf:20: Duplicate line for path "/root", ignoring. Oct 9 00:40:33.753974 systemd-tmpfiles[2175]: /usr/lib/tmpfiles.d/systemd-flatcar.conf:6: Duplicate line for path "/var/log/journal", ignoring. Oct 9 00:40:33.754672 systemd-tmpfiles[2175]: /usr/lib/tmpfiles.d/systemd.conf:29: Duplicate line for path "/var/lib/systemd", ignoring. Oct 9 00:40:33.754966 systemd-tmpfiles[2175]: ACLs are not supported, ignoring. Oct 9 00:40:33.755064 systemd-tmpfiles[2175]: ACLs are not supported, ignoring. Oct 9 00:40:33.758007 systemd-tmpfiles[2175]: Detected autofs mount point /boot during canonicalization of boot. Oct 9 00:40:33.758018 systemd-tmpfiles[2175]: Skipping /boot Oct 9 00:40:33.766424 systemd-tmpfiles[2175]: Detected autofs mount point /boot during canonicalization of boot. Oct 9 00:40:33.766442 systemd-tmpfiles[2175]: Skipping /boot Oct 9 00:40:33.804929 zram_generator::config[2199]: No configuration found. Oct 9 00:40:33.887828 ldconfig[2142]: /sbin/ldconfig: /usr/lib/ld.so.conf is not an ELF file - it has the wrong magic bytes at the start. Oct 9 00:40:33.904183 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 9 00:40:33.945022 systemd[1]: Reloading finished in 203 ms. Oct 9 00:40:33.974753 systemd[1]: Finished ldconfig.service - Rebuild Dynamic Linker Cache. Oct 9 00:40:33.982473 systemd[1]: Finished systemd-tmpfiles-setup.service - Create System Files and Directories. Oct 9 00:40:33.992126 systemd[1]: Starting audit-rules.service - Load Audit Rules... Oct 9 00:40:33.994292 systemd[1]: Starting clean-ca-certificates.service - Clean up broken links in /etc/ssl/certs... Oct 9 00:40:33.999207 systemd[1]: Starting systemd-journal-catalog-update.service - Rebuild Journal Catalog... Oct 9 00:40:34.007647 systemd[1]: Starting systemd-resolved.service - Network Name Resolution... Oct 9 00:40:34.012233 systemd[1]: Starting systemd-update-utmp.service - Record System Boot/Shutdown in UTMP... Oct 9 00:40:34.017712 systemd[1]: ignition-delete-config.service - Ignition (delete config) was skipped because no trigger condition checks were met. Oct 9 00:40:34.022313 systemd[1]: Starting modprobe@dm_mod.service - Load Kernel Module dm_mod... Oct 9 00:40:34.027374 systemd[1]: Starting modprobe@efi_pstore.service - Load Kernel Module efi_pstore... Oct 9 00:40:34.032691 systemd[1]: Starting modprobe@loop.service - Load Kernel Module loop... Oct 9 00:40:34.033651 systemd[1]: systemd-binfmt.service - Set Up Additional Binary Formats was skipped because no trigger condition checks were met. Oct 9 00:40:34.034430 systemd[1]: Finished systemd-journal-catalog-update.service - Rebuild Journal Catalog. Oct 9 00:40:34.035811 systemd[1]: modprobe@dm_mod.service: Deactivated successfully. Oct 9 00:40:34.036937 systemd[1]: Finished modprobe@dm_mod.service - Load Kernel Module dm_mod. Oct 9 00:40:34.038336 systemd[1]: modprobe@efi_pstore.service: Deactivated successfully. Oct 9 00:40:34.039036 systemd[1]: Finished modprobe@efi_pstore.service - Load Kernel Module efi_pstore. Oct 9 00:40:34.040315 systemd[1]: modprobe@loop.service: Deactivated successfully. Oct 9 00:40:34.040441 systemd[1]: Finished modprobe@loop.service - Load Kernel Module loop. Oct 9 00:40:34.047995 systemd[1]: Finished systemd-update-utmp.service - Record System Boot/Shutdown in UTMP. Oct 9 00:40:34.051183 systemd[1]: ignition-delete-config.service - Ignition (delete config) was skipped because no trigger condition checks were met. Oct 9 00:40:34.060129 systemd[1]: Starting modprobe@dm_mod.service - Load Kernel Module dm_mod... Oct 9 00:40:34.065117 systemd[1]: Starting modprobe@efi_pstore.service - Load Kernel Module efi_pstore... Oct 9 00:40:34.069709 systemd[1]: Starting modprobe@loop.service - Load Kernel Module loop... Oct 9 00:40:34.070895 systemd[1]: systemd-binfmt.service - Set Up Additional Binary Formats was skipped because no trigger condition checks were met. Oct 9 00:40:34.076184 systemd[1]: Starting systemd-userdbd.service - User Database Manager... Oct 9 00:40:34.077869 systemd[1]: Finished clean-ca-certificates.service - Clean up broken links in /etc/ssl/certs. Oct 9 00:40:34.079154 systemd[1]: modprobe@dm_mod.service: Deactivated successfully. Oct 9 00:40:34.079296 systemd[1]: Finished modprobe@dm_mod.service - Load Kernel Module dm_mod. Oct 9 00:40:34.080695 systemd[1]: modprobe@efi_pstore.service: Deactivated successfully. Oct 9 00:40:34.080825 systemd[1]: Finished modprobe@efi_pstore.service - Load Kernel Module efi_pstore. Oct 9 00:40:34.082204 systemd[1]: modprobe@loop.service: Deactivated successfully. Oct 9 00:40:34.082321 systemd[1]: Finished modprobe@loop.service - Load Kernel Module loop. Oct 9 00:40:34.083577 augenrules[2276]: No rules Oct 9 00:40:34.086918 systemd[1]: audit-rules.service: Deactivated successfully. Oct 9 00:40:34.087957 systemd[1]: Finished audit-rules.service - Load Audit Rules. Oct 9 00:40:34.092049 systemd[1]: ignition-delete-config.service - Ignition (delete config) was skipped because no trigger condition checks were met. Oct 9 00:40:34.100156 systemd[1]: Starting modprobe@dm_mod.service - Load Kernel Module dm_mod... Oct 9 00:40:34.105137 systemd[1]: Starting modprobe@drm.service - Load Kernel Module drm... Oct 9 00:40:34.107875 systemd[1]: Starting modprobe@efi_pstore.service - Load Kernel Module efi_pstore... Oct 9 00:40:34.109908 systemd[1]: Starting modprobe@loop.service - Load Kernel Module loop... Oct 9 00:40:34.110801 systemd[1]: systemd-binfmt.service - Set Up Additional Binary Formats was skipped because no trigger condition checks were met. Oct 9 00:40:34.111237 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 9 00:40:34.112928 systemd[1]: Finished systemd-hwdb-update.service - Rebuild Hardware Database. Oct 9 00:40:34.114469 systemd[1]: Started systemd-userdbd.service - User Database Manager. Oct 9 00:40:34.115936 systemd[1]: modprobe@dm_mod.service: Deactivated successfully. Oct 9 00:40:34.116154 systemd[1]: Finished modprobe@dm_mod.service - Load Kernel Module dm_mod. Oct 9 00:40:34.117467 systemd[1]: modprobe@drm.service: Deactivated successfully. Oct 9 00:40:34.117777 systemd[1]: Finished modprobe@drm.service - Load Kernel Module drm. Oct 9 00:40:34.119192 systemd[1]: modprobe@efi_pstore.service: Deactivated successfully. Oct 9 00:40:34.120900 systemd[1]: Finished modprobe@efi_pstore.service - Load Kernel Module efi_pstore. Oct 9 00:40:34.122350 systemd[1]: modprobe@loop.service: Deactivated successfully. Oct 9 00:40:34.122591 systemd[1]: Finished modprobe@loop.service - Load Kernel Module loop. Oct 9 00:40:34.126276 systemd[1]: Finished ensure-sysext.service. Oct 9 00:40:34.129987 systemd[1]: systemd-pstore.service - Platform Persistent Storage Archival was skipped because of an unmet condition check (ConditionDirectoryNotEmpty=/sys/fs/pstore). Oct 9 00:40:34.130141 systemd[1]: systemd-repart.service - Repartition Root Disk was skipped because no trigger condition checks were met. Oct 9 00:40:34.140009 systemd[1]: Starting systemd-timesyncd.service - Network Time Synchronization... Oct 9 00:40:34.142122 systemd[1]: Starting systemd-udevd.service - Rule-based Manager for Device Events and Files... Oct 9 00:40:34.144026 systemd[1]: Starting systemd-update-done.service - Update is Completed... Oct 9 00:40:34.159674 systemd[1]: Finished systemd-update-done.service - Update is Completed. Oct 9 00:40:34.167205 systemd-resolved[2244]: Positive Trust Anchors: Oct 9 00:40:34.167278 systemd-resolved[2244]: . IN DS 20326 8 2 e06d44b80b8f1d39a95c0b0d7c65d08458e880409bbc683457104237c7f8ec8d Oct 9 00:40:34.167309 systemd-resolved[2244]: 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 resolver.arpa corp home internal intranet lan local private test Oct 9 00:40:34.170142 systemd-udevd[2302]: Using default interface naming scheme 'v255'. Oct 9 00:40:34.171198 systemd-resolved[2244]: Defaulting to hostname 'linux'. Oct 9 00:40:34.174670 systemd[1]: Started systemd-resolved.service - Network Name Resolution. Oct 9 00:40:34.175839 systemd[1]: Reached target nss-lookup.target - Host and Network Name Lookups. Oct 9 00:40:34.184309 systemd[1]: Started systemd-udevd.service - Rule-based Manager for Device Events and Files. Oct 9 00:40:34.197019 systemd[1]: Starting systemd-networkd.service - Network Configuration... Oct 9 00:40:34.197929 systemd[1]: Started systemd-timesyncd.service - Network Time Synchronization. Oct 9 00:40:34.202816 systemd[1]: Reached target time-set.target - System Time Set. Oct 9 00:40:34.210012 systemd[1]: Condition check resulted in dev-ttyAMA0.device - /dev/ttyAMA0 being skipped. Oct 9 00:40:34.218628 kernel: BTRFS info: devid 1 device path /dev/mapper/usr changed to /dev/dm-0 scanned by (udev-worker) (2310) Oct 9 00:40:34.218680 kernel: BTRFS info: devid 1 device path /dev/dm-0 changed to /dev/mapper/usr scanned by (udev-worker) (2310) Oct 9 00:40:34.237988 kernel: BTRFS warning: duplicate device /dev/vdb3 devid 1 generation 37 scanned by (udev-worker) (2318) Oct 9 00:40:34.240314 systemd[1]: Condition check resulted in dev-disk-by\x2duuid-a7656c31\x2d7c51\x2d4be3\x2d8fb7\x2d805a18f1d3f6.device - /dev/disk/by-uuid/a7656c31-7c51-4be3-8fb7-805a18f1d3f6 being skipped. Oct 9 00:40:34.245051 systemd[1]: Starting systemd-cryptsetup@rootencrypted.service - Cryptography Setup for rootencrypted... Oct 9 00:40:34.255325 systemd-networkd[2312]: lo: Link UP Oct 9 00:40:34.255333 systemd-networkd[2312]: lo: Gained carrier Oct 9 00:40:34.256182 systemd-networkd[2312]: Enumeration completed Oct 9 00:40:34.257409 systemd[1]: Started systemd-networkd.service - Network Configuration. Oct 9 00:40:34.258767 systemd[1]: Reached target network.target - Network. Oct 9 00:40:34.258902 systemd-networkd[2312]: eth0: found matching network '/usr/lib/systemd/network/zz-default.network', based on potentially unpredictable interface name. Oct 9 00:40:34.258908 systemd-networkd[2312]: eth0: Configuring with /usr/lib/systemd/network/zz-default.network. Oct 9 00:40:34.259489 systemd-networkd[2312]: eth0: Link UP Oct 9 00:40:34.259493 systemd-networkd[2312]: eth0: Gained carrier Oct 9 00:40:34.259506 systemd-networkd[2312]: eth0: found matching network '/usr/lib/systemd/network/zz-default.network', based on potentially unpredictable interface name. Oct 9 00:40:34.261667 systemd[1]: Starting systemd-networkd-wait-online.service - Wait for Network to be Configured... Oct 9 00:40:34.262787 systemd-cryptsetup[2330]: Volume rootencrypted already active. Oct 9 00:40:34.266113 systemd[1]: Finished systemd-cryptsetup@rootencrypted.service - Cryptography Setup for rootencrypted. Oct 9 00:40:34.268397 systemd[1]: Found device dev-disk-by\x2dlabel-OEM.device - /dev/disk/by-label/OEM. Oct 9 00:40:34.271224 systemd[1]: Reached target blockdev@dev-mapper-rootencrypted.target - Block Device Preparation for /dev/mapper/rootencrypted. Oct 9 00:40:34.273700 systemd[1]: Starting systemd-fsck@dev-disk-by\x2dlabel-OEM.service - File System Check on /dev/disk/by-label/OEM... Oct 9 00:40:34.294849 systemd-networkd[2312]: eth0: DHCPv4 address 10.0.0.31/16, gateway 10.0.0.1 acquired from 10.0.0.1 Oct 9 00:40:34.296757 systemd-timesyncd[2301]: Network configuration changed, trying to establish connection. Oct 9 00:40:34.296795 systemd-networkd[2312]: eth0: found matching network '/usr/lib/systemd/network/zz-default.network', based on potentially unpredictable interface name. Oct 9 00:40:34.297812 systemd[1]: Finished systemd-fsck@dev-disk-by\x2dlabel-OEM.service - File System Check on /dev/disk/by-label/OEM. Oct 9 00:40:34.297997 systemd-timesyncd[2301]: Contacted time server 10.0.0.1:123 (10.0.0.1). Oct 9 00:40:34.298039 systemd-timesyncd[2301]: Initial clock synchronization to Wed 2024-10-09 00:40:34.405956 UTC. Oct 9 00:40:34.325075 systemd[1]: Starting systemd-vconsole-setup.service - Virtual Console Setup... Oct 9 00:40:34.333223 systemd[1]: Finished systemd-udev-settle.service - Wait for udev To Complete Device Initialization. Oct 9 00:40:34.336010 systemd[1]: Starting lvm2-activation-early.service - Activation of LVM2 logical volumes... Oct 9 00:40:34.352181 lvm[2345]: WARNING: Failed to connect to lvmetad. Falling back to device scanning. Oct 9 00:40:34.367905 systemd[1]: Finished systemd-vconsole-setup.service - Virtual Console Setup. Oct 9 00:40:34.383363 systemd[1]: Finished lvm2-activation-early.service - Activation of LVM2 logical volumes. Oct 9 00:40:34.384604 systemd[1]: Reached target cryptsetup.target - Local Encrypted Volumes. Oct 9 00:40:34.386964 systemd[1]: Reached target sysinit.target - System Initialization. Oct 9 00:40:34.387885 systemd[1]: Started motdgen.path - Watch for update engine configuration changes. Oct 9 00:40:34.388833 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 9 00:40:34.390004 systemd[1]: Started logrotate.timer - Daily rotation of log files. Oct 9 00:40:34.390959 systemd[1]: Started mdadm.timer - Weekly check for MD array's redundancy information.. Oct 9 00:40:34.391937 systemd[1]: Started systemd-tmpfiles-clean.timer - Daily Cleanup of Temporary Directories. Oct 9 00:40:34.393012 systemd[1]: update-engine-stub.timer - Update Engine Stub Timer was skipped because of an unmet condition check (ConditionPathExists=/usr/.noupdate). Oct 9 00:40:34.393043 systemd[1]: Reached target paths.target - Path Units. Oct 9 00:40:34.393760 systemd[1]: Reached target timers.target - Timer Units. Oct 9 00:40:34.395343 systemd[1]: Listening on dbus.socket - D-Bus System Message Bus Socket. Oct 9 00:40:34.397454 systemd[1]: Starting docker.socket - Docker Socket for the API... Oct 9 00:40:34.407510 systemd[1]: Listening on sshd.socket - OpenSSH Server Socket. Oct 9 00:40:34.409486 systemd[1]: Starting lvm2-activation.service - Activation of LVM2 logical volumes... Oct 9 00:40:34.410765 systemd[1]: Listening on docker.socket - Docker Socket for the API. Oct 9 00:40:34.411730 systemd[1]: Reached target sockets.target - Socket Units. Oct 9 00:40:34.412507 systemd[1]: Reached target basic.target - Basic System. Oct 9 00:40:34.413281 systemd[1]: addon-config@oem.service - Configure Addon /oem was skipped because no trigger condition checks were met. Oct 9 00:40:34.413311 systemd[1]: addon-run@oem.service - Run Addon /oem was skipped because no trigger condition checks were met. Oct 9 00:40:34.414138 systemd[1]: Starting containerd.service - containerd container runtime... Oct 9 00:40:34.415060 systemd[1]: cryptenroll-helper-bind.service was skipped because of an unmet condition check (ConditionPathExists=/etc/luks/rootencrypted-bind). Oct 9 00:40:34.415991 systemd[1]: Starting dbus.service - D-Bus System Message Bus... Oct 9 00:40:34.417490 lvm[2352]: WARNING: Failed to connect to lvmetad. Falling back to device scanning. Oct 9 00:40:34.419991 systemd[1]: Starting enable-oem-cloudinit.service - Enable cloudinit... Oct 9 00:40:34.423158 systemd[1]: Starting extend-filesystems.service - Extend Filesystems... Oct 9 00:40:34.423990 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 9 00:40:34.425113 systemd[1]: Starting motdgen.service - Generate /run/flatcar/motd... Oct 9 00:40:34.427233 systemd[1]: Starting ssh-key-proc-cmdline.service - Install an ssh key from /proc/cmdline... Oct 9 00:40:34.430183 jq[2355]: false Oct 9 00:40:34.431407 systemd[1]: Starting sshd-keygen.service - Generate sshd host keys... Oct 9 00:40:34.435111 systemd[1]: Starting systemd-logind.service - User Login Management... Oct 9 00:40:34.442658 systemd[1]: tcsd.service - TCG Core Services Daemon was skipped because of an unmet condition check (ConditionSecurity=!tpm2). Oct 9 00:40:34.443102 systemd[1]: cgroup compatibility translation between legacy and unified hierarchy settings activated. See cgroup-compat debug messages for details. Oct 9 00:40:34.447095 systemd[1]: Starting update-engine.service - Update Engine... Oct 9 00:40:34.450534 extend-filesystems[2356]: Found loop2 Oct 9 00:40:34.450534 extend-filesystems[2356]: Found loop3 Oct 9 00:40:34.450534 extend-filesystems[2356]: Found vda Oct 9 00:40:34.450534 extend-filesystems[2356]: Found vdb Oct 9 00:40:34.450534 extend-filesystems[2356]: Found vdb1 Oct 9 00:40:34.450534 extend-filesystems[2356]: Found vdb2 Oct 9 00:40:34.450534 extend-filesystems[2356]: Found vdb3 Oct 9 00:40:34.450534 extend-filesystems[2356]: Found usr Oct 9 00:40:34.450534 extend-filesystems[2356]: Found vdb4 Oct 9 00:40:34.450534 extend-filesystems[2356]: Found vdb6 Oct 9 00:40:34.450534 extend-filesystems[2356]: Found vdb7 Oct 9 00:40:34.450534 extend-filesystems[2356]: Found vdb9 Oct 9 00:40:34.450534 extend-filesystems[2356]: Found rootencrypted Oct 9 00:40:34.450849 systemd[1]: Starting update-ssh-keys-after-ignition.service - Run update-ssh-keys once after Ignition... Oct 9 00:40:34.451258 dbus-daemon[2354]: [system] SELinux support is enabled Oct 9 00:40:34.454380 systemd[1]: Started dbus.service - D-Bus System Message Bus. Oct 9 00:40:34.471682 jq[2368]: true Oct 9 00:40:34.462884 systemd[1]: Finished lvm2-activation.service - Activation of LVM2 logical volumes. Oct 9 00:40:34.465314 systemd[1]: enable-oem-cloudinit.service: Skipped due to 'exec-condition'. Oct 9 00:40:34.465476 systemd[1]: Condition check resulted in enable-oem-cloudinit.service - Enable cloudinit being skipped. Oct 9 00:40:34.465734 systemd[1]: extend-filesystems.service: Deactivated successfully. Oct 9 00:40:34.465883 systemd[1]: Finished extend-filesystems.service - Extend Filesystems. Oct 9 00:40:34.467383 systemd[1]: motdgen.service: Deactivated successfully. Oct 9 00:40:34.467525 systemd[1]: Finished motdgen.service - Generate /run/flatcar/motd. Oct 9 00:40:34.471269 systemd[1]: ssh-key-proc-cmdline.service: Deactivated successfully. Oct 9 00:40:34.471428 systemd[1]: Finished ssh-key-proc-cmdline.service - Install an ssh key from /proc/cmdline. Oct 9 00:40:34.489979 systemd-logind[2361]: Watching system buttons on /dev/input/event0 (Power Button) Oct 9 00:40:34.490435 systemd-logind[2361]: New seat seat0. Oct 9 00:40:34.491241 systemd[1]: Started systemd-logind.service - User Login Management. Oct 9 00:40:34.496057 jq[2373]: true Oct 9 00:40:34.497394 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 9 00:40:34.498068 systemd[1]: Reached target system-config.target - Load system-provided cloud configs. Oct 9 00:40:34.500067 (ntainerd)[2382]: containerd.service: Referenced but unset environment variable evaluates to an empty string: TORCX_IMAGEDIR, TORCX_UNPACKDIR Oct 9 00:40:34.500139 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 9 00:40:34.500258 systemd[1]: Reached target user-config.target - Load user-provided cloud configs. Oct 9 00:40:34.503280 update_engine[2364]: I20241009 00:40:34.501744 2364 main.cc:92] Flatcar Update Engine starting Oct 9 00:40:34.506301 systemd[1]: Started update-engine.service - Update Engine. Oct 9 00:40:34.509080 update_engine[2364]: I20241009 00:40:34.508774 2364 update_check_scheduler.cc:74] Next update check in 5m42s Oct 9 00:40:34.509395 systemd[1]: Started locksmithd.service - Cluster reboot manager. Oct 9 00:40:34.558887 bash[2399]: Updated "/home/core/.ssh/authorized_keys" Oct 9 00:40:34.559255 locksmithd[2385]: locksmithd starting currentOperation="UPDATE_STATUS_IDLE" strategy="reboot" Oct 9 00:40:34.561109 systemd[1]: Finished update-ssh-keys-after-ignition.service - Run update-ssh-keys once after Ignition. Oct 9 00:40:34.564108 systemd[1]: sshkeys.service was skipped because no trigger condition checks were met. Oct 9 00:40:34.695488 containerd[2382]: time="2024-10-09T00:40:34.695357680Z" level=info msg="starting containerd" revision=b2ce781edcbd6cb758f172ecab61c79d607cc41d version=v1.7.22 Oct 9 00:40:34.721085 containerd[2382]: time="2024-10-09T00:40:34.720975960Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.aufs\"..." type=io.containerd.snapshotter.v1 Oct 9 00:40:34.722408 containerd[2382]: time="2024-10-09T00:40:34.722366280Z" 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 9 00:40:34.722408 containerd[2382]: time="2024-10-09T00:40:34.722403040Z" level=info msg="loading plugin \"io.containerd.event.v1.exchange\"..." type=io.containerd.event.v1 Oct 9 00:40:34.722497 containerd[2382]: time="2024-10-09T00:40:34.722419600Z" level=info msg="loading plugin \"io.containerd.internal.v1.opt\"..." type=io.containerd.internal.v1 Oct 9 00:40:34.722611 containerd[2382]: time="2024-10-09T00:40:34.722592240Z" level=info msg="loading plugin \"io.containerd.warning.v1.deprecations\"..." type=io.containerd.warning.v1 Oct 9 00:40:34.722633 containerd[2382]: time="2024-10-09T00:40:34.722615160Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.blockfile\"..." type=io.containerd.snapshotter.v1 Oct 9 00:40:34.722684 containerd[2382]: time="2024-10-09T00:40:34.722670520Z" level=info msg="skip loading plugin \"io.containerd.snapshotter.v1.blockfile\"..." error="no scratch file generator: skip plugin" type=io.containerd.snapshotter.v1 Oct 9 00:40:34.722703 containerd[2382]: time="2024-10-09T00:40:34.722685440Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.btrfs\"..." type=io.containerd.snapshotter.v1 Oct 9 00:40:34.722871 containerd[2382]: time="2024-10-09T00:40:34.722842920Z" 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 9 00:40:34.722896 containerd[2382]: time="2024-10-09T00:40:34.722877840Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.devmapper\"..." type=io.containerd.snapshotter.v1 Oct 9 00:40:34.722914 containerd[2382]: time="2024-10-09T00:40:34.722891800Z" level=info msg="skip loading plugin \"io.containerd.snapshotter.v1.devmapper\"..." error="devmapper not configured: skip plugin" type=io.containerd.snapshotter.v1 Oct 9 00:40:34.722914 containerd[2382]: time="2024-10-09T00:40:34.722901040Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.native\"..." type=io.containerd.snapshotter.v1 Oct 9 00:40:34.722988 containerd[2382]: time="2024-10-09T00:40:34.722972720Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.overlayfs\"..." type=io.containerd.snapshotter.v1 Oct 9 00:40:34.723177 containerd[2382]: time="2024-10-09T00:40:34.723160640Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.zfs\"..." type=io.containerd.snapshotter.v1 Oct 9 00:40:34.723274 containerd[2382]: time="2024-10-09T00:40:34.723257160Z" 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 9 00:40:34.723295 containerd[2382]: time="2024-10-09T00:40:34.723277360Z" level=info msg="loading plugin \"io.containerd.content.v1.content\"..." type=io.containerd.content.v1 Oct 9 00:40:34.723367 containerd[2382]: time="2024-10-09T00:40:34.723353800Z" level=info msg="loading plugin \"io.containerd.metadata.v1.bolt\"..." type=io.containerd.metadata.v1 Oct 9 00:40:34.723410 containerd[2382]: time="2024-10-09T00:40:34.723398520Z" level=info msg="metadata content store policy set" policy=shared Oct 9 00:40:34.726356 containerd[2382]: time="2024-10-09T00:40:34.726323360Z" level=info msg="loading plugin \"io.containerd.gc.v1.scheduler\"..." type=io.containerd.gc.v1 Oct 9 00:40:34.726395 containerd[2382]: time="2024-10-09T00:40:34.726369160Z" level=info msg="loading plugin \"io.containerd.differ.v1.walking\"..." type=io.containerd.differ.v1 Oct 9 00:40:34.726395 containerd[2382]: time="2024-10-09T00:40:34.726384080Z" level=info msg="loading plugin \"io.containerd.lease.v1.manager\"..." type=io.containerd.lease.v1 Oct 9 00:40:34.726429 containerd[2382]: time="2024-10-09T00:40:34.726400520Z" level=info msg="loading plugin \"io.containerd.streaming.v1.manager\"..." type=io.containerd.streaming.v1 Oct 9 00:40:34.726429 containerd[2382]: time="2024-10-09T00:40:34.726414880Z" level=info msg="loading plugin \"io.containerd.runtime.v1.linux\"..." type=io.containerd.runtime.v1 Oct 9 00:40:34.726595 containerd[2382]: time="2024-10-09T00:40:34.726567240Z" level=info msg="loading plugin \"io.containerd.monitor.v1.cgroups\"..." type=io.containerd.monitor.v1 Oct 9 00:40:34.726884 containerd[2382]: time="2024-10-09T00:40:34.726845400Z" level=info msg="loading plugin \"io.containerd.runtime.v2.task\"..." type=io.containerd.runtime.v2 Oct 9 00:40:34.729458 containerd[2382]: time="2024-10-09T00:40:34.727051440Z" level=info msg="loading plugin \"io.containerd.runtime.v2.shim\"..." type=io.containerd.runtime.v2 Oct 9 00:40:34.729458 containerd[2382]: time="2024-10-09T00:40:34.727074440Z" level=info msg="loading plugin \"io.containerd.sandbox.store.v1.local\"..." type=io.containerd.sandbox.store.v1 Oct 9 00:40:34.729458 containerd[2382]: time="2024-10-09T00:40:34.727090280Z" level=info msg="loading plugin \"io.containerd.sandbox.controller.v1.local\"..." type=io.containerd.sandbox.controller.v1 Oct 9 00:40:34.729458 containerd[2382]: time="2024-10-09T00:40:34.727106480Z" level=info msg="loading plugin \"io.containerd.service.v1.containers-service\"..." type=io.containerd.service.v1 Oct 9 00:40:34.729458 containerd[2382]: time="2024-10-09T00:40:34.727119400Z" level=info msg="loading plugin \"io.containerd.service.v1.content-service\"..." type=io.containerd.service.v1 Oct 9 00:40:34.729458 containerd[2382]: time="2024-10-09T00:40:34.727131520Z" level=info msg="loading plugin \"io.containerd.service.v1.diff-service\"..." type=io.containerd.service.v1 Oct 9 00:40:34.729458 containerd[2382]: time="2024-10-09T00:40:34.727145360Z" level=info msg="loading plugin \"io.containerd.service.v1.images-service\"..." type=io.containerd.service.v1 Oct 9 00:40:34.729458 containerd[2382]: time="2024-10-09T00:40:34.727159760Z" level=info msg="loading plugin \"io.containerd.service.v1.introspection-service\"..." type=io.containerd.service.v1 Oct 9 00:40:34.729458 containerd[2382]: time="2024-10-09T00:40:34.727173120Z" level=info msg="loading plugin \"io.containerd.service.v1.namespaces-service\"..." type=io.containerd.service.v1 Oct 9 00:40:34.729458 containerd[2382]: time="2024-10-09T00:40:34.727186360Z" level=info msg="loading plugin \"io.containerd.service.v1.snapshots-service\"..." type=io.containerd.service.v1 Oct 9 00:40:34.729458 containerd[2382]: time="2024-10-09T00:40:34.727197520Z" level=info msg="loading plugin \"io.containerd.service.v1.tasks-service\"..." type=io.containerd.service.v1 Oct 9 00:40:34.729458 containerd[2382]: time="2024-10-09T00:40:34.727218680Z" level=info msg="loading plugin \"io.containerd.grpc.v1.containers\"..." type=io.containerd.grpc.v1 Oct 9 00:40:34.729458 containerd[2382]: time="2024-10-09T00:40:34.727232560Z" level=info msg="loading plugin \"io.containerd.grpc.v1.content\"..." type=io.containerd.grpc.v1 Oct 9 00:40:34.729458 containerd[2382]: time="2024-10-09T00:40:34.727244720Z" level=info msg="loading plugin \"io.containerd.grpc.v1.diff\"..." type=io.containerd.grpc.v1 Oct 9 00:40:34.729774 containerd[2382]: time="2024-10-09T00:40:34.727257160Z" level=info msg="loading plugin \"io.containerd.grpc.v1.events\"..." type=io.containerd.grpc.v1 Oct 9 00:40:34.729774 containerd[2382]: time="2024-10-09T00:40:34.727269280Z" level=info msg="loading plugin \"io.containerd.grpc.v1.images\"..." type=io.containerd.grpc.v1 Oct 9 00:40:34.729774 containerd[2382]: time="2024-10-09T00:40:34.727282720Z" level=info msg="loading plugin \"io.containerd.grpc.v1.introspection\"..." type=io.containerd.grpc.v1 Oct 9 00:40:34.729774 containerd[2382]: time="2024-10-09T00:40:34.727294480Z" level=info msg="loading plugin \"io.containerd.grpc.v1.leases\"..." type=io.containerd.grpc.v1 Oct 9 00:40:34.729774 containerd[2382]: time="2024-10-09T00:40:34.727306800Z" level=info msg="loading plugin \"io.containerd.grpc.v1.namespaces\"..." type=io.containerd.grpc.v1 Oct 9 00:40:34.729774 containerd[2382]: time="2024-10-09T00:40:34.727319760Z" level=info msg="loading plugin \"io.containerd.grpc.v1.sandbox-controllers\"..." type=io.containerd.grpc.v1 Oct 9 00:40:34.729774 containerd[2382]: time="2024-10-09T00:40:34.727336000Z" level=info msg="loading plugin \"io.containerd.grpc.v1.sandboxes\"..." type=io.containerd.grpc.v1 Oct 9 00:40:34.729774 containerd[2382]: time="2024-10-09T00:40:34.727347560Z" level=info msg="loading plugin \"io.containerd.grpc.v1.snapshots\"..." type=io.containerd.grpc.v1 Oct 9 00:40:34.729774 containerd[2382]: time="2024-10-09T00:40:34.727367320Z" level=info msg="loading plugin \"io.containerd.grpc.v1.streaming\"..." type=io.containerd.grpc.v1 Oct 9 00:40:34.729774 containerd[2382]: time="2024-10-09T00:40:34.727385200Z" level=info msg="loading plugin \"io.containerd.grpc.v1.tasks\"..." type=io.containerd.grpc.v1 Oct 9 00:40:34.729774 containerd[2382]: time="2024-10-09T00:40:34.727401040Z" level=info msg="loading plugin \"io.containerd.transfer.v1.local\"..." type=io.containerd.transfer.v1 Oct 9 00:40:34.729774 containerd[2382]: time="2024-10-09T00:40:34.727421960Z" level=info msg="loading plugin \"io.containerd.grpc.v1.transfer\"..." type=io.containerd.grpc.v1 Oct 9 00:40:34.729774 containerd[2382]: time="2024-10-09T00:40:34.727443320Z" level=info msg="loading plugin \"io.containerd.grpc.v1.version\"..." type=io.containerd.grpc.v1 Oct 9 00:40:34.729774 containerd[2382]: time="2024-10-09T00:40:34.727461160Z" level=info msg="loading plugin \"io.containerd.internal.v1.restart\"..." type=io.containerd.internal.v1 Oct 9 00:40:34.730031 containerd[2382]: time="2024-10-09T00:40:34.727634560Z" level=info msg="loading plugin \"io.containerd.tracing.processor.v1.otlp\"..." type=io.containerd.tracing.processor.v1 Oct 9 00:40:34.730031 containerd[2382]: time="2024-10-09T00:40:34.727652400Z" 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 9 00:40:34.730031 containerd[2382]: time="2024-10-09T00:40:34.727663800Z" level=info msg="loading plugin \"io.containerd.internal.v1.tracing\"..." type=io.containerd.internal.v1 Oct 9 00:40:34.730031 containerd[2382]: time="2024-10-09T00:40:34.727677360Z" level=info msg="skip loading plugin \"io.containerd.internal.v1.tracing\"..." error="skip plugin: tracing endpoint not configured" type=io.containerd.internal.v1 Oct 9 00:40:34.730031 containerd[2382]: time="2024-10-09T00:40:34.727687640Z" level=info msg="loading plugin \"io.containerd.grpc.v1.healthcheck\"..." type=io.containerd.grpc.v1 Oct 9 00:40:34.730031 containerd[2382]: time="2024-10-09T00:40:34.727699800Z" level=info msg="loading plugin \"io.containerd.nri.v1.nri\"..." type=io.containerd.nri.v1 Oct 9 00:40:34.730031 containerd[2382]: time="2024-10-09T00:40:34.727713240Z" level=info msg="NRI interface is disabled by configuration." Oct 9 00:40:34.730031 containerd[2382]: time="2024-10-09T00:40:34.727724120Z" level=info msg="loading plugin \"io.containerd.grpc.v1.cri\"..." type=io.containerd.grpc.v1 Oct 9 00:40:34.730168 containerd[2382]: time="2024-10-09T00:40:34.728140520Z" 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 9 00:40:34.730168 containerd[2382]: time="2024-10-09T00:40:34.728190760Z" level=info msg="Connect containerd service" Oct 9 00:40:34.730168 containerd[2382]: time="2024-10-09T00:40:34.728217800Z" level=info msg="using legacy CRI server" Oct 9 00:40:34.730168 containerd[2382]: time="2024-10-09T00:40:34.728224400Z" level=info msg="using experimental NRI integration - disable nri plugin to prevent this" Oct 9 00:40:34.730168 containerd[2382]: time="2024-10-09T00:40:34.728296800Z" level=info msg="Get image filesystem path \"/var/lib/containerd/io.containerd.snapshotter.v1.overlayfs\"" Oct 9 00:40:34.730168 containerd[2382]: time="2024-10-09T00:40:34.728993600Z" 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 9 00:40:34.730168 containerd[2382]: time="2024-10-09T00:40:34.729198320Z" level=info msg="Start subscribing containerd event" Oct 9 00:40:34.730168 containerd[2382]: time="2024-10-09T00:40:34.729241080Z" level=info msg="Start recovering state" Oct 9 00:40:34.730168 containerd[2382]: time="2024-10-09T00:40:34.729297520Z" level=info msg="Start event monitor" Oct 9 00:40:34.730168 containerd[2382]: time="2024-10-09T00:40:34.729314880Z" level=info msg="Start snapshots syncer" Oct 9 00:40:34.730168 containerd[2382]: time="2024-10-09T00:40:34.729324000Z" level=info msg="Start cni network conf syncer for default" Oct 9 00:40:34.730168 containerd[2382]: time="2024-10-09T00:40:34.729331040Z" level=info msg="Start streaming server" Oct 9 00:40:34.730652 containerd[2382]: time="2024-10-09T00:40:34.730631080Z" level=info msg=serving... address=/run/containerd/containerd.sock.ttrpc Oct 9 00:40:34.730778 containerd[2382]: time="2024-10-09T00:40:34.730763800Z" level=info msg=serving... address=/run/containerd/containerd.sock Oct 9 00:40:34.730923 containerd[2382]: time="2024-10-09T00:40:34.730909960Z" level=info msg="containerd successfully booted in 0.036373s" Oct 9 00:40:34.731001 systemd[1]: Started containerd.service - containerd container runtime. Oct 9 00:40:35.158736 sshd_keygen[2367]: ssh-keygen: generating new host keys: RSA ECDSA ED25519 Oct 9 00:40:35.178697 systemd[1]: Finished sshd-keygen.service - Generate sshd host keys. Oct 9 00:40:35.190125 systemd[1]: Starting issuegen.service - Generate /run/issue... Oct 9 00:40:35.195731 systemd[1]: issuegen.service: Deactivated successfully. Oct 9 00:40:35.195975 systemd[1]: Finished issuegen.service - Generate /run/issue. Oct 9 00:40:35.198430 systemd[1]: Starting systemd-user-sessions.service - Permit User Sessions... Oct 9 00:40:35.210726 systemd[1]: Finished systemd-user-sessions.service - Permit User Sessions. Oct 9 00:40:35.213533 systemd[1]: Started getty@tty1.service - Getty on tty1. Oct 9 00:40:35.215558 systemd[1]: Started serial-getty@ttyAMA0.service - Serial Getty on ttyAMA0. Oct 9 00:40:35.216759 systemd[1]: Reached target getty.target - Login Prompts. Oct 9 00:40:35.490833 systemd-networkd[2312]: eth0: Gained IPv6LL Oct 9 00:40:35.496452 systemd[1]: Finished systemd-networkd-wait-online.service - Wait for Network to be Configured. Oct 9 00:40:35.498297 systemd[1]: Reached target network-online.target - Network is Online. Oct 9 00:40:35.510488 systemd[1]: Starting coreos-metadata.service - QEMU metadata agent... Oct 9 00:40:35.512681 systemd[1]: Starting nvidia.service - NVIDIA Configure Service... Oct 9 00:40:35.528130 systemd[1]: coreos-metadata.service: Deactivated successfully. Oct 9 00:40:35.528338 systemd[1]: Finished coreos-metadata.service - QEMU metadata agent. Oct 9 00:40:35.529573 systemd[1]: packet-phone-home.service - Report Success to Packet was skipped because no trigger condition checks were met. Oct 9 00:40:35.533300 systemd[1]: Finished nvidia.service - NVIDIA Configure Service. Oct 9 00:40:35.534469 systemd[1]: Reached target multi-user.target - Multi-User System. Oct 9 00:40:35.546124 systemd[1]: Starting cryptenroll-helper-first.service... Oct 9 00:40:35.554313 systemd-cryptenroll[2445]: Warning: keyslot operation could fail as it requires more than available memory. Oct 9 00:40:37.771667 systemd-cryptenroll[2445]: New TPM2 token enrolled as key slot 1. Oct 9 00:40:42.669518 systemd[1]: Created slice system-sshd.slice - Slice /system/sshd. Oct 9 00:40:42.670600 systemd[1]: Started sshd@0-10.0.0.31:22-10.0.0.1:54820.service - OpenSSH per-connection server daemon (10.0.0.1:54820). Oct 9 00:40:42.720853 sshd[2584]: Accepted publickey for core from 10.0.0.1 port 54820 ssh2: RSA SHA256:nRWADPtu01909VH1n4/VEkamAOeuD1sYuu1knWF4jhs Oct 9 00:40:42.722433 sshd[2584]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Oct 9 00:40:42.731171 systemd[1]: Created slice user-500.slice - User Slice of UID 500. Oct 9 00:40:42.741135 systemd[1]: Starting user-runtime-dir@500.service - User Runtime Directory /run/user/500... Oct 9 00:40:42.742622 systemd-logind[2361]: New session 1 of user core. Oct 9 00:40:42.749350 systemd[1]: Finished user-runtime-dir@500.service - User Runtime Directory /run/user/500. Oct 9 00:40:42.752497 systemd[1]: Starting user@500.service - User Manager for UID 500... Oct 9 00:40:42.760348 (systemd)[2588]: pam_unix(systemd-user:session): session opened for user core(uid=500) by (uid=0) Oct 9 00:40:42.834612 systemd[2588]: Queued start job for default target default.target. Oct 9 00:40:42.845918 systemd[2588]: Created slice app.slice - User Application Slice. Oct 9 00:40:42.845942 systemd[2588]: Reached target paths.target - Paths. Oct 9 00:40:42.845953 systemd[2588]: Reached target timers.target - Timers. Oct 9 00:40:42.847174 systemd[2588]: Starting dbus.socket - D-Bus User Message Bus Socket... Oct 9 00:40:42.856586 systemd[2588]: Listening on dbus.socket - D-Bus User Message Bus Socket. Oct 9 00:40:42.856648 systemd[2588]: Reached target sockets.target - Sockets. Oct 9 00:40:42.856660 systemd[2588]: Reached target basic.target - Basic System. Oct 9 00:40:42.856695 systemd[2588]: Reached target default.target - Main User Target. Oct 9 00:40:42.856719 systemd[2588]: Startup finished in 91ms. Oct 9 00:40:42.857092 systemd[1]: Started user@500.service - User Manager for UID 500. Oct 9 00:40:42.858257 systemd[1]: Started session-1.scope - Session 1 of User core. Oct 9 00:40:42.921068 systemd[1]: Started sshd@1-10.0.0.31:22-10.0.0.1:54830.service - OpenSSH per-connection server daemon (10.0.0.1:54830). Oct 9 00:40:42.960416 sshd[2599]: Accepted publickey for core from 10.0.0.1 port 54830 ssh2: RSA SHA256:nRWADPtu01909VH1n4/VEkamAOeuD1sYuu1knWF4jhs Oct 9 00:40:42.961601 sshd[2599]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Oct 9 00:40:42.965609 systemd-logind[2361]: New session 2 of user core. Oct 9 00:40:42.978070 systemd[1]: Started session-2.scope - Session 2 of User core. Oct 9 00:40:43.028427 sshd[2599]: pam_unix(sshd:session): session closed for user core Oct 9 00:40:43.045257 systemd[1]: sshd@1-10.0.0.31:22-10.0.0.1:54830.service: Deactivated successfully. Oct 9 00:40:43.046565 systemd[1]: session-2.scope: Deactivated successfully. Oct 9 00:40:43.047678 systemd-logind[2361]: Session 2 logged out. Waiting for processes to exit. Oct 9 00:40:43.048668 systemd[1]: Started sshd@2-10.0.0.31:22-10.0.0.1:54834.service - OpenSSH per-connection server daemon (10.0.0.1:54834). Oct 9 00:40:43.049393 systemd-logind[2361]: Removed session 2. Oct 9 00:40:43.084116 sshd[2606]: Accepted publickey for core from 10.0.0.1 port 54834 ssh2: RSA SHA256:nRWADPtu01909VH1n4/VEkamAOeuD1sYuu1knWF4jhs Oct 9 00:40:43.085188 sshd[2606]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Oct 9 00:40:43.088706 systemd-logind[2361]: New session 3 of user core. Oct 9 00:40:43.100978 systemd[1]: Started session-3.scope - Session 3 of User core. Oct 9 00:40:43.151875 sshd[2606]: pam_unix(sshd:session): session closed for user core Oct 9 00:40:43.154033 systemd[1]: sshd@2-10.0.0.31:22-10.0.0.1:54834.service: Deactivated successfully. Oct 9 00:40:43.155316 systemd[1]: session-3.scope: Deactivated successfully. Oct 9 00:40:43.156530 systemd-logind[2361]: Session 3 logged out. Waiting for processes to exit. Oct 9 00:40:43.157351 systemd-logind[2361]: Removed session 3. -- Reboot -- Oct 9 00:42:20.874566 kernel: Booting Linux on physical CPU 0x0000000000 [0x413fd0c1] Oct 9 00:42:20.874588 kernel: Linux version 6.6.54-flatcar (build@pony-truck.infra.kinvolk.io) (aarch64-cros-linux-gnu-gcc (Gentoo Hardened 13.3.1_p20240614 p17) 13.3.1 20240614, GNU ld (Gentoo 2.42 p3) 2.42.0) #1 SMP PREEMPT Tue Oct 8 23:34:40 -00 2024 Oct 9 00:42:20.874598 kernel: KASLR enabled Oct 9 00:42:20.874603 kernel: efi: EFI v2.7 by EDK II Oct 9 00:42:20.874609 kernel: efi: SMBIOS 3.0=0xdced0000 TPMFinalLog=0xd9740000 MEMATTR=0xdba82198 ACPI 2.0=0xd96e0018 TPMEventLog=0xd96e9098 RNG=0xd96ee698 MEMRESERVE=0xd9b43b98 Oct 9 00:42:20.874615 kernel: random: crng init done Oct 9 00:42:20.874622 kernel: secureboot: Secure boot disabled Oct 9 00:42:20.874628 kernel: ACPI: Early table checksum verification disabled Oct 9 00:42:20.874634 kernel: ACPI: RSDP 0x00000000D96E0018 000024 (v02 BOCHS ) Oct 9 00:42:20.874642 kernel: ACPI: XSDT 0x00000000D96EFE98 00006C (v01 BOCHS BXPC 00000001 01000013) Oct 9 00:42:20.874648 kernel: ACPI: FACP 0x00000000D96EFA98 000114 (v06 BOCHS BXPC 00000001 BXPC 00000001) Oct 9 00:42:20.874654 kernel: ACPI: DSDT 0x00000000D96E7518 0014EB (v02 BOCHS BXPC 00000001 BXPC 00000001) Oct 9 00:42:20.874659 kernel: ACPI: APIC 0x00000000D96EFC18 0001A8 (v04 BOCHS BXPC 00000001 BXPC 00000001) Oct 9 00:42:20.874665 kernel: ACPI: PPTT 0x00000000D96ED898 00009C (v02 BOCHS BXPC 00000001 BXPC 00000001) Oct 9 00:42:20.874673 kernel: ACPI: GTDT 0x00000000D96EE818 000060 (v02 BOCHS BXPC 00000001 BXPC 00000001) Oct 9 00:42:20.874680 kernel: ACPI: MCFG 0x00000000D96EE918 00003C (v01 BOCHS BXPC 00000001 BXPC 00000001) Oct 9 00:42:20.874686 kernel: ACPI: SPCR 0x00000000D96EFF98 000050 (v02 BOCHS BXPC 00000001 BXPC 00000001) Oct 9 00:42:20.874693 kernel: ACPI: DBG2 0x00000000D96EE418 000057 (v00 BOCHS BXPC 00000001 BXPC 00000001) Oct 9 00:42:20.874699 kernel: ACPI: IORT 0x00000000D96EE718 000080 (v03 BOCHS BXPC 00000001 BXPC 00000001) Oct 9 00:42:20.874705 kernel: ACPI: TPM2 0x00000000D96EE498 00004C (v04 BOCHS BXPC 00000001 BXPC 00000001) Oct 9 00:42:20.874711 kernel: ACPI: SPCR: console: pl011,mmio,0x9000000,9600 Oct 9 00:42:20.874717 kernel: NUMA: Failed to initialise from firmware Oct 9 00:42:20.874723 kernel: NUMA: Faking a node at [mem 0x0000000040000000-0x00000000dcffffff] Oct 9 00:42:20.874729 kernel: NUMA: NODE_DATA [mem 0xdc958800-0xdc95dfff] Oct 9 00:42:20.874735 kernel: Zone ranges: Oct 9 00:42:20.874743 kernel: DMA [mem 0x0000000040000000-0x00000000dcffffff] Oct 9 00:42:20.874749 kernel: DMA32 empty Oct 9 00:42:20.874755 kernel: Normal empty Oct 9 00:42:20.874761 kernel: Movable zone start for each node Oct 9 00:42:20.874767 kernel: Early memory node ranges Oct 9 00:42:20.874773 kernel: node 0: [mem 0x0000000040000000-0x00000000d962ffff] Oct 9 00:42:20.874779 kernel: node 0: [mem 0x00000000d9630000-0x00000000d963ffff] Oct 9 00:42:20.874785 kernel: node 0: [mem 0x00000000d9640000-0x00000000d973ffff] Oct 9 00:42:20.874791 kernel: node 0: [mem 0x00000000d9740000-0x00000000d9b3ffff] Oct 9 00:42:20.874798 kernel: node 0: [mem 0x00000000d9b40000-0x00000000dce1ffff] Oct 9 00:42:20.874804 kernel: node 0: [mem 0x00000000dce20000-0x00000000dceaffff] Oct 9 00:42:20.874810 kernel: node 0: [mem 0x00000000dceb0000-0x00000000dcebffff] Oct 9 00:42:20.874817 kernel: node 0: [mem 0x00000000dcec0000-0x00000000dcfdffff] Oct 9 00:42:20.874823 kernel: node 0: [mem 0x00000000dcfe0000-0x00000000dcffffff] Oct 9 00:42:20.874830 kernel: Initmem setup node 0 [mem 0x0000000040000000-0x00000000dcffffff] Oct 9 00:42:20.874847 kernel: On node 0, zone DMA: 12288 pages in unavailable ranges Oct 9 00:42:20.874854 kernel: psci: probing for conduit method from ACPI. Oct 9 00:42:20.874861 kernel: psci: PSCIv1.1 detected in firmware. Oct 9 00:42:20.874869 kernel: psci: Using standard PSCI v0.2 function IDs Oct 9 00:42:20.874876 kernel: psci: Trusted OS migration not required Oct 9 00:42:20.874882 kernel: psci: SMC Calling Convention v1.1 Oct 9 00:42:20.874889 kernel: smccc: KVM: hypervisor services detected (0x00000000 0x00000000 0x00000000 0x00000003) Oct 9 00:42:20.874896 kernel: percpu: Embedded 31 pages/cpu s86632 r8192 d32152 u126976 Oct 9 00:42:20.874902 kernel: pcpu-alloc: s86632 r8192 d32152 u126976 alloc=31*4096 Oct 9 00:42:20.874909 kernel: pcpu-alloc: [0] 0 [0] 1 [0] 2 [0] 3 Oct 9 00:42:20.874915 kernel: Detected PIPT I-cache on CPU0 Oct 9 00:42:20.874922 kernel: CPU features: detected: GIC system register CPU interface Oct 9 00:42:20.874929 kernel: CPU features: detected: Hardware dirty bit management Oct 9 00:42:20.874936 kernel: CPU features: detected: Spectre-v4 Oct 9 00:42:20.874943 kernel: CPU features: detected: Spectre-BHB Oct 9 00:42:20.874950 kernel: CPU features: kernel page table isolation forced ON by KASLR Oct 9 00:42:20.874968 kernel: CPU features: detected: Kernel page table isolation (KPTI) Oct 9 00:42:20.874975 kernel: CPU features: detected: ARM erratum 1418040 Oct 9 00:42:20.874982 kernel: CPU features: detected: SSBS not fully self-synchronizing Oct 9 00:42:20.874988 kernel: alternatives: applying boot alternatives Oct 9 00:42:20.874996 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=d2d67b5440410ae2d0aa86eba97891969be0a7a421fa55f13442706ef7ed2a5e Oct 9 00:42:20.875003 kernel: Unknown kernel command line parameters "BOOT_IMAGE=/flatcar/vmlinuz-a", will be passed to user space. Oct 9 00:42:20.875009 kernel: Dentry cache hash table entries: 524288 (order: 10, 4194304 bytes, linear) Oct 9 00:42:20.875016 kernel: Inode-cache hash table entries: 262144 (order: 9, 2097152 bytes, linear) Oct 9 00:42:20.875024 kernel: Fallback order for Node 0: 0 Oct 9 00:42:20.875031 kernel: Built 1 zonelists, mobility grouping on. Total pages: 633024 Oct 9 00:42:20.875037 kernel: Policy zone: DMA Oct 9 00:42:20.875044 kernel: mem auto-init: stack:off, heap alloc:off, heap free:off Oct 9 00:42:20.875050 kernel: software IO TLB: area num 4. Oct 9 00:42:20.875057 kernel: software IO TLB: mapped [mem 0x00000000d2e00000-0x00000000d6e00000] (64MB) Oct 9 00:42:20.875064 kernel: Memory: 2386148K/2572288K available (10240K kernel code, 2184K rwdata, 8092K rodata, 39552K init, 897K bss, 186140K reserved, 0K cma-reserved) Oct 9 00:42:20.875070 kernel: SLUB: HWalign=64, Order=0-3, MinObjects=0, CPUs=4, Nodes=1 Oct 9 00:42:20.875077 kernel: trace event string verifier disabled Oct 9 00:42:20.875084 kernel: rcu: Preemptible hierarchical RCU implementation. Oct 9 00:42:20.875091 kernel: rcu: RCU event tracing is enabled. Oct 9 00:42:20.875098 kernel: rcu: RCU restricting CPUs from NR_CPUS=512 to nr_cpu_ids=4. Oct 9 00:42:20.875105 kernel: Trampoline variant of Tasks RCU enabled. Oct 9 00:42:20.875112 kernel: Tracing variant of Tasks RCU enabled. Oct 9 00:42:20.875119 kernel: rcu: RCU calculated value of scheduler-enlistment delay is 100 jiffies. Oct 9 00:42:20.875125 kernel: rcu: Adjusting geometry for rcu_fanout_leaf=16, nr_cpu_ids=4 Oct 9 00:42:20.875132 kernel: NR_IRQS: 64, nr_irqs: 64, preallocated irqs: 0 Oct 9 00:42:20.875138 kernel: GICv3: 256 SPIs implemented Oct 9 00:42:20.875145 kernel: GICv3: 0 Extended SPIs implemented Oct 9 00:42:20.875151 kernel: Root IRQ handler: gic_handle_irq Oct 9 00:42:20.875158 kernel: GICv3: GICv3 features: 16 PPIs, DirectLPI Oct 9 00:42:20.875164 kernel: GICv3: CPU0: found redistributor 0 region 0:0x00000000080a0000 Oct 9 00:42:20.875171 kernel: ITS [mem 0x08080000-0x0809ffff] Oct 9 00:42:20.875179 kernel: ITS@0x0000000008080000: allocated 8192 Devices @400d0000 (indirect, esz 8, psz 64K, shr 1) Oct 9 00:42:20.875186 kernel: ITS@0x0000000008080000: allocated 8192 Interrupt Collections @400e0000 (flat, esz 8, psz 64K, shr 1) Oct 9 00:42:20.875192 kernel: GICv3: using LPI property table @0x00000000400f0000 Oct 9 00:42:20.875199 kernel: GICv3: CPU0: using allocated LPI pending table @0x0000000040100000 Oct 9 00:42:20.875205 kernel: rcu: srcu_init: Setting srcu_struct sizes based on contention. Oct 9 00:42:20.875212 kernel: arch_timer: Enabling local workaround for ARM erratum 1418040 Oct 9 00:42:20.875219 kernel: arch_timer: cp15 timer(s) running at 25.00MHz (virt). Oct 9 00:42:20.875225 kernel: clocksource: arch_sys_counter: mask: 0xffffffffffffff max_cycles: 0x5c40939b5, max_idle_ns: 440795202646 ns Oct 9 00:42:20.875232 kernel: sched_clock: 56 bits at 25MHz, resolution 40ns, wraps every 4398046511100ns Oct 9 00:42:20.875239 kernel: arm-pv: using stolen time PV Oct 9 00:42:20.875245 kernel: Console: colour dummy device 80x25 Oct 9 00:42:20.875253 kernel: ACPI: Core revision 20230628 Oct 9 00:42:20.875260 kernel: Calibrating delay loop (skipped), value calculated using timer frequency.. 50.00 BogoMIPS (lpj=25000) Oct 9 00:42:20.875267 kernel: pid_max: default: 32768 minimum: 301 Oct 9 00:42:20.875274 kernel: LSM: initializing lsm=lockdown,capability,landlock,selinux,integrity Oct 9 00:42:20.875281 kernel: landlock: Up and running. Oct 9 00:42:20.875287 kernel: SELinux: Initializing. Oct 9 00:42:20.875294 kernel: Mount-cache hash table entries: 8192 (order: 4, 65536 bytes, linear) Oct 9 00:42:20.875301 kernel: Mountpoint-cache hash table entries: 8192 (order: 4, 65536 bytes, linear) Oct 9 00:42:20.875307 kernel: RCU Tasks: Setting shift to 2 and lim to 1 rcu_task_cb_adjust=1. Oct 9 00:42:20.875315 kernel: RCU Tasks Trace: Setting shift to 2 and lim to 1 rcu_task_cb_adjust=1. Oct 9 00:42:20.875322 kernel: rcu: Hierarchical SRCU implementation. Oct 9 00:42:20.875329 kernel: rcu: Max phase no-delay instances is 400. Oct 9 00:42:20.875336 kernel: Platform MSI: ITS@0x8080000 domain created Oct 9 00:42:20.875343 kernel: PCI/MSI: ITS@0x8080000 domain created Oct 9 00:42:20.875349 kernel: Remapping and enabling EFI services. Oct 9 00:42:20.875356 kernel: smp: Bringing up secondary CPUs ... Oct 9 00:42:20.875363 kernel: Detected PIPT I-cache on CPU1 Oct 9 00:42:20.875369 kernel: GICv3: CPU1: found redistributor 1 region 0:0x00000000080c0000 Oct 9 00:42:20.875376 kernel: GICv3: CPU1: using allocated LPI pending table @0x0000000040110000 Oct 9 00:42:20.875384 kernel: arch_timer: Enabling local workaround for ARM erratum 1418040 Oct 9 00:42:20.875396 kernel: CPU1: Booted secondary processor 0x0000000001 [0x413fd0c1] Oct 9 00:42:20.875404 kernel: Detected PIPT I-cache on CPU2 Oct 9 00:42:20.875411 kernel: GICv3: CPU2: found redistributor 2 region 0:0x00000000080e0000 Oct 9 00:42:20.875419 kernel: GICv3: CPU2: using allocated LPI pending table @0x0000000040120000 Oct 9 00:42:20.875426 kernel: arch_timer: Enabling local workaround for ARM erratum 1418040 Oct 9 00:42:20.875433 kernel: CPU2: Booted secondary processor 0x0000000002 [0x413fd0c1] Oct 9 00:42:20.875440 kernel: Detected PIPT I-cache on CPU3 Oct 9 00:42:20.875448 kernel: GICv3: CPU3: found redistributor 3 region 0:0x0000000008100000 Oct 9 00:42:20.875455 kernel: GICv3: CPU3: using allocated LPI pending table @0x0000000040130000 Oct 9 00:42:20.875463 kernel: arch_timer: Enabling local workaround for ARM erratum 1418040 Oct 9 00:42:20.875470 kernel: CPU3: Booted secondary processor 0x0000000003 [0x413fd0c1] Oct 9 00:42:20.875477 kernel: smp: Brought up 1 node, 4 CPUs Oct 9 00:42:20.875484 kernel: SMP: Total of 4 processors activated. Oct 9 00:42:20.875491 kernel: CPU features: detected: 32-bit EL0 Support Oct 9 00:42:20.875499 kernel: CPU features: detected: Data cache clean to the PoU not required for I/D coherence Oct 9 00:42:20.875506 kernel: CPU features: detected: Common not Private translations Oct 9 00:42:20.875514 kernel: CPU features: detected: CRC32 instructions Oct 9 00:42:20.875521 kernel: CPU features: detected: Enhanced Virtualization Traps Oct 9 00:42:20.875528 kernel: CPU features: detected: RCpc load-acquire (LDAPR) Oct 9 00:42:20.875535 kernel: CPU features: detected: LSE atomic instructions Oct 9 00:42:20.875542 kernel: CPU features: detected: Privileged Access Never Oct 9 00:42:20.875549 kernel: CPU features: detected: RAS Extension Support Oct 9 00:42:20.875556 kernel: CPU features: detected: Speculative Store Bypassing Safe (SSBS) Oct 9 00:42:20.875563 kernel: CPU: All CPU(s) started at EL1 Oct 9 00:42:20.875570 kernel: alternatives: applying system-wide alternatives Oct 9 00:42:20.875579 kernel: devtmpfs: initialized Oct 9 00:42:20.875586 kernel: clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1911260446275000 ns Oct 9 00:42:20.875593 kernel: futex hash table entries: 1024 (order: 4, 65536 bytes, linear) Oct 9 00:42:20.875600 kernel: pinctrl core: initialized pinctrl subsystem Oct 9 00:42:20.875607 kernel: SMBIOS 3.0.0 present. Oct 9 00:42:20.875614 kernel: DMI: QEMU KVM Virtual Machine, BIOS edk2-20230524-3.fc38 05/24/2023 Oct 9 00:42:20.875622 kernel: NET: Registered PF_NETLINK/PF_ROUTE protocol family Oct 9 00:42:20.875629 kernel: DMA: preallocated 512 KiB GFP_KERNEL pool for atomic allocations Oct 9 00:42:20.875636 kernel: DMA: preallocated 512 KiB GFP_KERNEL|GFP_DMA pool for atomic allocations Oct 9 00:42:20.875644 kernel: DMA: preallocated 512 KiB GFP_KERNEL|GFP_DMA32 pool for atomic allocations Oct 9 00:42:20.875651 kernel: audit: initializing netlink subsys (disabled) Oct 9 00:42:20.875658 kernel: audit: type=2000 audit(0.023:1): state=initialized audit_enabled=0 res=1 Oct 9 00:42:20.875666 kernel: thermal_sys: Registered thermal governor 'step_wise' Oct 9 00:42:20.875673 kernel: cpuidle: using governor menu Oct 9 00:42:20.875680 kernel: hw-breakpoint: found 6 breakpoint and 4 watchpoint registers. Oct 9 00:42:20.875687 kernel: ASID allocator initialised with 32768 entries Oct 9 00:42:20.875694 kernel: acpiphp: ACPI Hot Plug PCI Controller Driver version: 0.5 Oct 9 00:42:20.875702 kernel: Serial: AMBA PL011 UART driver Oct 9 00:42:20.875710 kernel: Modules: 2G module region forced by RANDOMIZE_MODULE_REGION_FULL Oct 9 00:42:20.875717 kernel: Modules: 0 pages in range for non-PLT usage Oct 9 00:42:20.875724 kernel: Modules: 508992 pages in range for PLT usage Oct 9 00:42:20.875731 kernel: HugeTLB: registered 1.00 GiB page size, pre-allocated 0 pages Oct 9 00:42:20.875738 kernel: HugeTLB: 0 KiB vmemmap can be freed for a 1.00 GiB page Oct 9 00:42:20.875746 kernel: HugeTLB: registered 32.0 MiB page size, pre-allocated 0 pages Oct 9 00:42:20.875753 kernel: HugeTLB: 0 KiB vmemmap can be freed for a 32.0 MiB page Oct 9 00:42:20.875760 kernel: HugeTLB: registered 2.00 MiB page size, pre-allocated 0 pages Oct 9 00:42:20.875767 kernel: HugeTLB: 0 KiB vmemmap can be freed for a 2.00 MiB page Oct 9 00:42:20.875775 kernel: HugeTLB: registered 64.0 KiB page size, pre-allocated 0 pages Oct 9 00:42:20.875782 kernel: HugeTLB: 0 KiB vmemmap can be freed for a 64.0 KiB page Oct 9 00:42:20.875789 kernel: ACPI: Added _OSI(Module Device) Oct 9 00:42:20.875796 kernel: ACPI: Added _OSI(Processor Device) Oct 9 00:42:20.875803 kernel: ACPI: Added _OSI(3.0 _SCP Extensions) Oct 9 00:42:20.875810 kernel: ACPI: Added _OSI(Processor Aggregator Device) Oct 9 00:42:20.875817 kernel: ACPI: 1 ACPI AML tables successfully acquired and loaded Oct 9 00:42:20.875824 kernel: ACPI: Interpreter enabled Oct 9 00:42:20.875831 kernel: ACPI: Using GIC for interrupt routing Oct 9 00:42:20.875846 kernel: ACPI: MCFG table detected, 1 entries Oct 9 00:42:20.875854 kernel: ARMH0011:00: ttyAMA0 at MMIO 0x9000000 (irq = 12, base_baud = 0) is a SBSA Oct 9 00:42:20.875861 kernel: printk: console [ttyAMA0] enabled Oct 9 00:42:20.875868 kernel: ACPI: PCI Root Bridge [PCI0] (domain 0000 [bus 00-ff]) Oct 9 00:42:20.876068 kernel: acpi PNP0A08:00: _OSC: OS supports [ExtendedConfig ASPM ClockPM Segments MSI HPX-Type3] Oct 9 00:42:20.876146 kernel: acpi PNP0A08:00: _OSC: platform does not support [LTR] Oct 9 00:42:20.876216 kernel: acpi PNP0A08:00: _OSC: OS now controls [PCIeHotplug PME AER PCIeCapability] Oct 9 00:42:20.876282 kernel: acpi PNP0A08:00: ECAM area [mem 0x4010000000-0x401fffffff] reserved by PNP0C02:00 Oct 9 00:42:20.876343 kernel: acpi PNP0A08:00: ECAM at [mem 0x4010000000-0x401fffffff] for [bus 00-ff] Oct 9 00:42:20.876352 kernel: ACPI: Remapped I/O 0x000000003eff0000 to [io 0x0000-0xffff window] Oct 9 00:42:20.876360 kernel: PCI host bridge to bus 0000:00 Oct 9 00:42:20.876427 kernel: pci_bus 0000:00: root bus resource [mem 0x10000000-0x3efeffff window] Oct 9 00:42:20.876485 kernel: pci_bus 0000:00: root bus resource [io 0x0000-0xffff window] Oct 9 00:42:20.876542 kernel: pci_bus 0000:00: root bus resource [mem 0x8000000000-0xffffffffff window] Oct 9 00:42:20.876599 kernel: pci_bus 0000:00: root bus resource [bus 00-ff] Oct 9 00:42:20.876677 kernel: pci 0000:00:00.0: [1b36:0008] type 00 class 0x060000 Oct 9 00:42:20.876751 kernel: pci 0000:00:01.0: [1af4:1005] type 00 class 0x00ff00 Oct 9 00:42:20.876816 kernel: pci 0000:00:01.0: reg 0x10: [io 0x0000-0x001f] Oct 9 00:42:20.876890 kernel: pci 0000:00:01.0: reg 0x14: [mem 0x10000000-0x10000fff] Oct 9 00:42:20.876968 kernel: pci 0000:00:01.0: reg 0x20: [mem 0x8000000000-0x8000003fff 64bit pref] Oct 9 00:42:20.877042 kernel: pci 0000:00:01.0: BAR 4: assigned [mem 0x8000000000-0x8000003fff 64bit pref] Oct 9 00:42:20.877111 kernel: pci 0000:00:01.0: BAR 1: assigned [mem 0x10000000-0x10000fff] Oct 9 00:42:20.877176 kernel: pci 0000:00:01.0: BAR 0: assigned [io 0x1000-0x101f] Oct 9 00:42:20.877234 kernel: pci_bus 0000:00: resource 4 [mem 0x10000000-0x3efeffff window] Oct 9 00:42:20.877292 kernel: pci_bus 0000:00: resource 5 [io 0x0000-0xffff window] Oct 9 00:42:20.877349 kernel: pci_bus 0000:00: resource 6 [mem 0x8000000000-0xffffffffff window] Oct 9 00:42:20.877359 kernel: ACPI: PCI: Interrupt link GSI0 configured for IRQ 35 Oct 9 00:42:20.877366 kernel: ACPI: PCI: Interrupt link GSI1 configured for IRQ 36 Oct 9 00:42:20.877373 kernel: ACPI: PCI: Interrupt link GSI2 configured for IRQ 37 Oct 9 00:42:20.877382 kernel: ACPI: PCI: Interrupt link GSI3 configured for IRQ 38 Oct 9 00:42:20.877390 kernel: iommu: Default domain type: Translated Oct 9 00:42:20.877397 kernel: iommu: DMA domain TLB invalidation policy: strict mode Oct 9 00:42:20.877404 kernel: efivars: Registered efivars operations Oct 9 00:42:20.877411 kernel: vgaarb: loaded Oct 9 00:42:20.877418 kernel: clocksource: Switched to clocksource arch_sys_counter Oct 9 00:42:20.877425 kernel: VFS: Disk quotas dquot_6.6.0 Oct 9 00:42:20.877432 kernel: VFS: Dquot-cache hash table entries: 512 (order 0, 4096 bytes) Oct 9 00:42:20.877439 kernel: pnp: PnP ACPI init Oct 9 00:42:20.877511 kernel: system 00:00: [mem 0x4010000000-0x401fffffff window] could not be reserved Oct 9 00:42:20.877521 kernel: pnp: PnP ACPI: found 1 devices Oct 9 00:42:20.877528 kernel: NET: Registered PF_INET protocol family Oct 9 00:42:20.877536 kernel: IP idents hash table entries: 65536 (order: 7, 524288 bytes, linear) Oct 9 00:42:20.877543 kernel: tcp_listen_portaddr_hash hash table entries: 2048 (order: 3, 32768 bytes, linear) Oct 9 00:42:20.877550 kernel: Table-perturb hash table entries: 65536 (order: 6, 262144 bytes, linear) Oct 9 00:42:20.877558 kernel: TCP established hash table entries: 32768 (order: 6, 262144 bytes, linear) Oct 9 00:42:20.877565 kernel: TCP bind hash table entries: 32768 (order: 8, 1048576 bytes, linear) Oct 9 00:42:20.877574 kernel: TCP: Hash tables configured (established 32768 bind 32768) Oct 9 00:42:20.877581 kernel: UDP hash table entries: 2048 (order: 4, 65536 bytes, linear) Oct 9 00:42:20.877588 kernel: UDP-Lite hash table entries: 2048 (order: 4, 65536 bytes, linear) Oct 9 00:42:20.877595 kernel: NET: Registered PF_UNIX/PF_LOCAL protocol family Oct 9 00:42:20.877602 kernel: PCI: CLS 0 bytes, default 64 Oct 9 00:42:20.877610 kernel: kvm [1]: HYP mode not available Oct 9 00:42:20.877617 kernel: Initialise system trusted keyrings Oct 9 00:42:20.877624 kernel: workingset: timestamp_bits=39 max_order=20 bucket_order=0 Oct 9 00:42:20.877631 kernel: Key type asymmetric registered Oct 9 00:42:20.877640 kernel: Asymmetric key parser 'x509' registered Oct 9 00:42:20.877647 kernel: Block layer SCSI generic (bsg) driver version 0.4 loaded (major 250) Oct 9 00:42:20.877654 kernel: io scheduler mq-deadline registered Oct 9 00:42:20.877661 kernel: io scheduler kyber registered Oct 9 00:42:20.877668 kernel: io scheduler bfq registered Oct 9 00:42:20.877676 kernel: input: Power Button as /devices/LNXSYSTM:00/LNXSYBUS:00/PNP0C0C:00/input/input0 Oct 9 00:42:20.877683 kernel: ACPI: button: Power Button [PWRB] Oct 9 00:42:20.877695 kernel: ACPI: \_SB_.PCI0.GSI1: Enabled at IRQ 36 Oct 9 00:42:20.877771 kernel: virtio-pci 0000:00:01.0: enabling device (0005 -> 0007) Oct 9 00:42:20.877783 kernel: Serial: 8250/16550 driver, 4 ports, IRQ sharing enabled Oct 9 00:42:20.877791 kernel: thunder_xcv, ver 1.0 Oct 9 00:42:20.877798 kernel: thunder_bgx, ver 1.0 Oct 9 00:42:20.877805 kernel: nicpf, ver 1.0 Oct 9 00:42:20.877816 kernel: nicvf, ver 1.0 Oct 9 00:42:20.877905 kernel: rtc-efi rtc-efi.0: registered as rtc0 Oct 9 00:42:20.877992 kernel: rtc-efi rtc-efi.0: setting system clock to 2024-10-09T00:42:20 UTC (1728434540) Oct 9 00:42:20.878004 kernel: hid: raw HID events driver (C) Jiri Kosina Oct 9 00:42:20.878013 kernel: hw perfevents: enabled with armv8_pmuv3_0 PMU driver, 7 counters available Oct 9 00:42:20.878021 kernel: watchdog: Delayed init of the lockup detector failed: -19 Oct 9 00:42:20.878028 kernel: watchdog: Hard watchdog permanently disabled Oct 9 00:42:20.878035 kernel: NET: Registered PF_INET6 protocol family Oct 9 00:42:20.878042 kernel: Segment Routing with IPv6 Oct 9 00:42:20.878049 kernel: In-situ OAM (IOAM) with IPv6 Oct 9 00:42:20.878056 kernel: NET: Registered PF_PACKET protocol family Oct 9 00:42:20.878063 kernel: Key type dns_resolver registered Oct 9 00:42:20.878070 kernel: registered taskstats version 1 Oct 9 00:42:20.878079 kernel: Loading compiled-in X.509 certificates Oct 9 00:42:20.878086 kernel: Loaded X.509 cert 'Kinvolk GmbH: Module signing key for 6.6.54-flatcar: 80611b0a9480eaf6d787b908c6349fdb5d07fa81' Oct 9 00:42:20.878093 kernel: Key type .fscrypt registered Oct 9 00:42:20.878100 kernel: Key type fscrypt-provisioning registered Oct 9 00:42:20.878107 kernel: ima: No TPM chip found, activating TPM-bypass! Oct 9 00:42:20.878115 kernel: ima: Allocated hash algorithm: sha1 Oct 9 00:42:20.878122 kernel: ima: No architecture policies found Oct 9 00:42:20.878129 kernel: alg: No test for fips(ansi_cprng) (fips_ansi_cprng) Oct 9 00:42:20.878136 kernel: clk: Disabling unused clocks Oct 9 00:42:20.878145 kernel: Freeing unused kernel memory: 39552K Oct 9 00:42:20.878152 kernel: Run /init as init process Oct 9 00:42:20.878159 kernel: with arguments: Oct 9 00:42:20.878166 kernel: /init Oct 9 00:42:20.878173 kernel: with environment: Oct 9 00:42:20.878180 kernel: HOME=/ Oct 9 00:42:20.878187 kernel: TERM=linux Oct 9 00:42:20.878194 kernel: BOOT_IMAGE=/flatcar/vmlinuz-a Oct 9 00:42:20.878203 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 9 00:42:20.878214 systemd[1]: Detected virtualization kvm. Oct 9 00:42:20.878221 systemd[1]: Detected architecture arm64. Oct 9 00:42:20.878229 systemd[1]: Running in initrd. Oct 9 00:42:20.878236 systemd[1]: No hostname configured, using default hostname. Oct 9 00:42:20.878244 systemd[1]: Hostname set to . Oct 9 00:42:20.878251 systemd[1]: Initializing machine ID from VM UUID. Oct 9 00:42:20.878259 systemd[1]: Queued start job for default target initrd.target. Oct 9 00:42:20.878268 systemd[1]: Started clevis-luks-askpass.path - Forward Password Requests to Clevis Directory Watch. Oct 9 00:42:20.878275 systemd[1]: Started systemd-ask-password-console.path - Dispatch Password Requests to Console Directory Watch. Oct 9 00:42:20.878283 systemd[1]: Expecting device dev-disk-by\x2dlabel-OEM.device - /dev/disk/by-label/OEM... Oct 9 00:42:20.878291 systemd[1]: Expecting device dev-disk-by\x2dlabel-ROOT.device - /dev/disk/by-label/ROOT... Oct 9 00:42:20.878299 systemd[1]: Expecting device dev-disk-by\x2dpartlabel-USR\x2dA.device - /dev/disk/by-partlabel/USR-A... Oct 9 00:42:20.878307 systemd[1]: Expecting device dev-disk-by\x2dpartuuid-7130c94a\x2d213a\x2d4e5a\x2d8e26\x2d6cce9662f132.device - /dev/disk/by-partuuid/7130c94a-213a-4e5a-8e26-6cce9662f132... Oct 9 00:42:20.878315 systemd[1]: Expecting device dev-mapper-usr.device - /dev/mapper/usr... Oct 9 00:42:20.878325 systemd[1]: Reached target cryptsetup-pre.target - Local Encrypted Volumes (Pre). Oct 9 00:42:20.878333 systemd[1]: Reached target cryptsetup.target - Local Encrypted Volumes. Oct 9 00:42:20.878340 systemd[1]: Reached target ignition-diskful-subsequent.target - Ignition Subsequent Boot Disk Setup. Oct 9 00:42:20.878348 systemd[1]: Reached target paths.target - Path Units. Oct 9 00:42:20.878355 systemd[1]: Reached target slices.target - Slice Units. Oct 9 00:42:20.878363 systemd[1]: Reached target swap.target - Swaps. Oct 9 00:42:20.878371 systemd[1]: Reached target timers.target - Timer Units. Oct 9 00:42:20.878378 systemd[1]: Listening on iscsid.socket - Open-iSCSI iscsid Socket. Oct 9 00:42:20.878387 systemd[1]: Listening on iscsiuio.socket - Open-iSCSI iscsiuio Socket. Oct 9 00:42:20.878395 systemd[1]: Listening on systemd-journald-dev-log.socket - Journal Socket (/dev/log). Oct 9 00:42:20.878403 systemd[1]: Listening on systemd-journald.socket - Journal Socket. Oct 9 00:42:20.878410 systemd[1]: Listening on systemd-udevd-control.socket - udev Control Socket. Oct 9 00:42:20.878418 systemd[1]: Listening on systemd-udevd-kernel.socket - udev Kernel Socket. Oct 9 00:42:20.878426 systemd[1]: Reached target sockets.target - Socket Units. Oct 9 00:42:20.878434 systemd[1]: Starting ignition-setup-pre.service - Ignition env setup... Oct 9 00:42:20.878441 systemd[1]: Starting kmod-static-nodes.service - Create List of Static Device Nodes... Oct 9 00:42:20.878449 systemd[1]: Starting systemd-fsck-usr.service... Oct 9 00:42:20.878458 systemd[1]: Starting systemd-journald.service - Journal Service... Oct 9 00:42:20.878465 systemd[1]: Starting systemd-modules-load.service - Load Kernel Modules... Oct 9 00:42:20.878473 systemd[1]: Starting systemd-vconsole-setup.service - Virtual Console Setup... Oct 9 00:42:20.878480 systemd[1]: Finished ignition-setup-pre.service - Ignition env setup. Oct 9 00:42:20.878488 systemd[1]: Finished kmod-static-nodes.service - Create List of Static Device Nodes. Oct 9 00:42:20.878496 systemd[1]: Finished systemd-fsck-usr.service. Oct 9 00:42:20.878503 systemd[1]: Starting systemd-tmpfiles-setup-dev-early.service - Create Static Device Nodes in /dev gracefully... Oct 9 00:42:20.878511 systemd[1]: Finished systemd-vconsole-setup.service - Virtual Console Setup. Oct 9 00:42:20.878520 systemd[1]: Finished systemd-tmpfiles-setup-dev-early.service - Create Static Device Nodes in /dev gracefully. Oct 9 00:42:20.878544 systemd-journald[231]: Collecting audit messages is disabled. Oct 9 00:42:20.878564 systemd[1]: Starting dracut-cmdline-ask.service - dracut ask for additional cmdline parameters... Oct 9 00:42:20.878572 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 9 00:42:20.878580 systemd-journald[231]: Journal started Oct 9 00:42:20.878598 systemd-journald[231]: Runtime Journal (/run/log/journal/77d3fb4d0fc34e56a5becad83947f740) is 5.9M, max 47.3M, 41.4M free. Oct 9 00:42:20.862922 systemd-modules-load[233]: Inserted module 'overlay' Oct 9 00:42:20.880975 systemd[1]: Starting systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev... Oct 9 00:42:20.881396 kernel: Bridge firewalling registered Oct 9 00:42:20.882066 systemd-modules-load[233]: Inserted module 'br_netfilter' Oct 9 00:42:20.883300 systemd[1]: Started systemd-journald.service - Journal Service. Oct 9 00:42:20.885943 systemd[1]: Finished systemd-modules-load.service - Load Kernel Modules. Oct 9 00:42:20.889489 systemd[1]: Starting systemd-sysctl.service - Apply Kernel Variables... Oct 9 00:42:20.890864 systemd[1]: Starting systemd-tmpfiles-setup.service - Create System Files and Directories... Oct 9 00:42:20.892973 systemd[1]: Finished dracut-cmdline-ask.service - dracut ask for additional cmdline parameters. Oct 9 00:42:20.895021 systemd[1]: Finished systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev. Oct 9 00:42:20.908166 systemd[1]: Starting dracut-cmdline.service - dracut cmdline hook... Oct 9 00:42:20.909120 systemd[1]: Finished systemd-sysctl.service - Apply Kernel Variables. Oct 9 00:42:20.910454 systemd[1]: Finished systemd-tmpfiles-setup.service - Create System Files and Directories. Oct 9 00:42:20.917751 dracut-cmdline[268]: dracut-dracut-053 Oct 9 00:42:20.920128 dracut-cmdline[268]: 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=d2d67b5440410ae2d0aa86eba97891969be0a7a421fa55f13442706ef7ed2a5e Oct 9 00:42:20.986986 kernel: SCSI subsystem initialized Oct 9 00:42:20.990972 kernel: Loading iSCSI transport class v2.0-870. Oct 9 00:42:21.001994 kernel: iscsi: registered transport (tcp) Oct 9 00:42:21.015013 kernel: iscsi: registered transport (qla4xxx) Oct 9 00:42:21.015050 kernel: QLogic iSCSI HBA Driver Oct 9 00:42:21.055022 systemd[1]: Finished dracut-cmdline.service - dracut cmdline hook. Oct 9 00:42:21.063117 systemd[1]: Starting dracut-pre-udev.service - dracut pre-udev hook... Oct 9 00:42:21.080490 kernel: device-mapper: core: CONFIG_IMA_DISABLE_HTABLE is disabled. Duplicate IMA measurements will not be recorded in the IMA log. Oct 9 00:42:21.080527 kernel: device-mapper: uevent: version 1.0.3 Oct 9 00:42:21.080539 kernel: device-mapper: ioctl: 4.48.0-ioctl (2023-03-01) initialised: dm-devel@redhat.com Oct 9 00:42:21.126975 kernel: raid6: neonx8 gen() 15739 MB/s Oct 9 00:42:21.143968 kernel: raid6: neonx4 gen() 15621 MB/s Oct 9 00:42:21.160967 kernel: raid6: neonx2 gen() 13182 MB/s Oct 9 00:42:21.177968 kernel: raid6: neonx1 gen() 10423 MB/s Oct 9 00:42:21.194970 kernel: raid6: int64x8 gen() 6938 MB/s Oct 9 00:42:21.211967 kernel: raid6: int64x4 gen() 7331 MB/s Oct 9 00:42:21.228964 kernel: raid6: int64x2 gen() 6114 MB/s Oct 9 00:42:21.245962 kernel: raid6: int64x1 gen() 5033 MB/s Oct 9 00:42:21.245977 kernel: raid6: using algorithm neonx8 gen() 15739 MB/s Oct 9 00:42:21.262982 kernel: raid6: .... xor() 12026 MB/s, rmw enabled Oct 9 00:42:21.263016 kernel: raid6: using neon recovery algorithm Oct 9 00:42:21.268289 kernel: xor: measuring software checksum speed Oct 9 00:42:21.268307 kernel: 8regs : 19783 MB/sec Oct 9 00:42:21.268316 kernel: 32regs : 19313 MB/sec Oct 9 00:42:21.269224 kernel: arm64_neon : 26883 MB/sec Oct 9 00:42:21.269237 kernel: xor: using function: arm64_neon (26883 MB/sec) Oct 9 00:42:21.318977 kernel: Btrfs loaded, zoned=no, fsverity=no Oct 9 00:42:21.328911 systemd[1]: Finished dracut-pre-udev.service - dracut pre-udev hook. Oct 9 00:42:21.340145 systemd[1]: Starting systemd-udevd.service - Rule-based Manager for Device Events and Files... Oct 9 00:42:21.350940 systemd-udevd[454]: Using default interface naming scheme 'v255'. Oct 9 00:42:21.354069 systemd[1]: Started systemd-udevd.service - Rule-based Manager for Device Events and Files. Oct 9 00:42:21.360089 systemd[1]: Starting dracut-pre-trigger.service - dracut pre-trigger hook... Oct 9 00:42:21.371065 dracut-pre-trigger[461]: rd.md=0: removing MD RAID activation Oct 9 00:42:21.395524 systemd[1]: Finished dracut-pre-trigger.service - dracut pre-trigger hook. Oct 9 00:42:21.411098 systemd[1]: Starting systemd-udev-trigger.service - Coldplug All udev Devices... Oct 9 00:42:21.449600 systemd[1]: Finished systemd-udev-trigger.service - Coldplug All udev Devices. Oct 9 00:42:21.457094 systemd[1]: Starting dracut-initqueue.service - dracut initqueue hook... Oct 9 00:42:21.471093 systemd[1]: Finished dracut-initqueue.service - dracut initqueue hook. Oct 9 00:42:21.472469 systemd[1]: Reached target remote-fs-pre.target - Preparation for Remote File Systems. Oct 9 00:42:21.473703 systemd[1]: Reached target remote-cryptsetup.target - Remote Encrypted Volumes. Oct 9 00:42:21.475464 systemd[1]: Reached target remote-fs.target - Remote File Systems. Oct 9 00:42:21.481108 systemd[1]: Starting dracut-pre-mount.service - dracut pre-mount hook... Oct 9 00:42:21.492067 systemd[1]: Finished dracut-pre-mount.service - dracut pre-mount hook. Oct 9 00:42:21.494993 kernel: tpm_tis MSFT0101:00: 2.0 TPM (device-id 0x1, rev-id 1) Oct 9 00:42:21.500112 kernel: virtio_blk virtio1: 1/0/0 default/read/poll queues Oct 9 00:42:21.511338 systemd[1]: dracut-cmdline-ask.service: Deactivated successfully. Oct 9 00:42:21.512844 kernel: virtio_blk virtio1: [vda] 1064960 512-byte logical blocks (545 MB/520 MiB) Oct 9 00:42:21.511446 systemd[1]: Stopped dracut-cmdline-ask.service - dracut ask for additional cmdline parameters. Oct 9 00:42:21.516390 kernel: virtio_blk virtio2: 1/0/0 default/read/poll queues Oct 9 00:42:21.516514 kernel: virtio_blk virtio2: [vdb] 9289728 512-byte logical blocks (4.76 GB/4.43 GiB) Oct 9 00:42:21.515510 systemd[1]: Stopping dracut-cmdline-ask.service - dracut ask for additional cmdline parameters... Oct 9 00:42:21.518906 kernel: vdb: vdb1 vdb2 vdb3 vdb4 vdb6 vdb7 vdb9 Oct 9 00:42:21.517473 systemd[1]: systemd-vconsole-setup.service: Deactivated successfully. Oct 9 00:42:21.517600 systemd[1]: Stopped systemd-vconsole-setup.service - Virtual Console Setup. Oct 9 00:42:21.520412 systemd[1]: Stopping systemd-vconsole-setup.service - Virtual Console Setup... Oct 9 00:42:21.530196 systemd[1]: Starting systemd-vconsole-setup.service - Virtual Console Setup... Oct 9 00:42:21.536091 kernel: BTRFS: device fsid c25b3a2f-539f-42a7-8842-97b35e474647 devid 1 transid 37 /dev/vdb3 scanned by (udev-worker) (512) Oct 9 00:42:21.536416 kernel: BTRFS: device label OEM devid 1 transid 18 /dev/vdb6 scanned by (udev-worker) (503) Oct 9 00:42:21.540145 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 9 00:42:21.540164 systemd[1]: Condition check resulted in dev-disk-by\x2duuid-a7656c31\x2d7c51\x2d4be3\x2d8fb7\x2d805a18f1d3f6.device - /dev/disk/by-uuid/a7656c31-7c51-4be3-8fb7-805a18f1d3f6 being skipped. Oct 9 00:42:21.540171 systemd[1]: Condition check resulted in dev-vdb9.device - /dev/vdb9 being skipped. Oct 9 00:42:21.540370 systemd[1]: Finished systemd-vconsole-setup.service - Virtual Console Setup. Oct 9 00:42:21.557201 systemd[1]: Found device dev-disk-by\x2dpartlabel-USR\x2dA.device - /dev/disk/by-partlabel/USR-A. Oct 9 00:42:21.558105 systemd[1]: Found device dev-disk-by\x2dpartuuid-7130c94a\x2d213a\x2d4e5a\x2d8e26\x2d6cce9662f132.device - /dev/disk/by-partuuid/7130c94a-213a-4e5a-8e26-6cce9662f132. Oct 9 00:42:21.563096 systemd[1]: Found device dev-disk-by\x2dlabel-OEM.device - /dev/disk/by-label/OEM. Oct 9 00:42:21.576143 systemd[1]: Starting decrypt-root.service - Generate and execute a systemd-cryptsetup service to decrypt the ROOT partition... Oct 9 00:42:21.577543 systemd[1]: Starting disk-uuid.service - Generate new UUID for disk GPT if necessary... Oct 9 00:42:21.579408 systemd[1]: Starting dracut-cmdline-ask.service - dracut ask for additional cmdline parameters... Oct 9 00:42:21.583253 systemd[1]: disk-uuid.service: Deactivated successfully. Oct 9 00:42:21.583341 systemd[1]: Finished disk-uuid.service - Generate new UUID for disk GPT if necessary. Oct 9 00:42:21.585295 systemd[1]: Reached target local-fs-pre.target - Preparation for Local File Systems. Oct 9 00:42:21.586468 systemd[1]: Reached target local-fs.target - Local File Systems. Oct 9 00:42:21.587865 systemd[1]: Reached target sysinit.target - System Initialization. Oct 9 00:42:21.589221 systemd[1]: Reached target basic.target - Basic System. Oct 9 00:42:21.596094 systemd[1]: Starting verity-setup.service - Verity Setup for /dev/mapper/usr... Oct 9 00:42:21.598640 sh[558]: Success Oct 9 00:42:21.598667 systemd[1]: Finished dracut-cmdline-ask.service - dracut ask for additional cmdline parameters. Oct 9 00:42:21.599736 systemd[1]: Reloading requested from client PID 544 ('systemctl') (unit decrypt-root.service)... Oct 9 00:42:21.599744 systemd[1]: Reloading... Oct 9 00:42:21.614462 kernel: device-mapper: verity: sha256 using implementation "sha256-ce" Oct 9 00:42:21.713169 systemd[1]: Found device dev-mapper-usr.device - /dev/mapper/usr. Oct 9 00:42:21.714222 systemd[1]: Reloading finished in 114 ms. Oct 9 00:42:21.737995 systemd[1]: Finished verity-setup.service - Verity Setup for /dev/mapper/usr. Oct 9 00:42:21.744519 systemd[1]: Mounting sysusr-usr.mount - /sysusr/usr... Oct 9 00:42:21.746138 systemd[1]: Created slice system-systemd\x2dcryptsetup.slice - Slice /system/systemd-cryptsetup. Oct 9 00:42:21.747686 systemd[1]: Starting systemd-cryptsetup@rootencrypted.service - Cryptography Setup for rootencrypted... Oct 9 00:42:21.755630 kernel: BTRFS info (device dm-0): first mount of filesystem c25b3a2f-539f-42a7-8842-97b35e474647 Oct 9 00:42:21.755658 kernel: BTRFS info (device dm-0): using crc32c (crc32c-generic) checksum algorithm Oct 9 00:42:21.756478 kernel: BTRFS warning (device dm-0): 'nologreplay' is deprecated, use 'rescue=nologreplay' instead Oct 9 00:42:21.757086 kernel: BTRFS info (device dm-0): disabling log replay at mount time Oct 9 00:42:21.757102 kernel: BTRFS info (device dm-0): using free space tree Oct 9 00:42:21.760733 systemd[1]: Mounted sysusr-usr.mount - /sysusr/usr. Oct 9 00:42:22.044983 kernel: Key type trusted registered Oct 9 00:42:22.046980 kernel: Key type encrypted registered Oct 9 00:42:22.067978 systemd[1]: Found device dev-disk-by\x2dlabel-ROOT.device - /dev/disk/by-label/ROOT. Oct 9 00:42:22.069488 systemd[1]: Finished systemd-cryptsetup@rootencrypted.service - Cryptography Setup for rootencrypted. Oct 9 00:42:22.071626 systemd[1]: Reached target initrd-root-device.target - Initrd Root Device. Oct 9 00:42:22.084098 systemd[1]: Starting systemd-fsck-root.service - File System Check on /dev/disk/by-label/ROOT... Oct 9 00:42:22.085074 systemd[1]: Finished decrypt-root.service - Generate and execute a systemd-cryptsetup service to decrypt the ROOT partition. Oct 9 00:42:22.095721 systemd-fsck[711]: ROOT: clean, 202/137360 files, 32562/549376 blocks Oct 9 00:42:22.097908 systemd[1]: Finished systemd-fsck-root.service - File System Check on /dev/disk/by-label/ROOT. Oct 9 00:42:22.100156 systemd[1]: Mounting sysroot.mount - /sysroot... Oct 9 00:42:22.144967 kernel: EXT4-fs (dm-1): mounted filesystem ba886bd3-2113-4b4c-bde3-dddc7184a4a3 r/w with ordered data mode. Quota mode: none. Oct 9 00:42:22.145290 systemd[1]: Mounted sysroot.mount - /sysroot. Oct 9 00:42:22.146270 systemd[1]: Reached target initrd-root-fs.target - Initrd Root File System. Oct 9 00:42:22.164039 systemd[1]: Mounting sysroot-oem.mount - /sysroot/oem... Oct 9 00:42:22.165539 systemd[1]: Mounting sysroot-usr.mount - /sysroot/usr... Oct 9 00:42:22.170004 kernel: BTRFS info (device vdb6): first mount of filesystem 6fd98f99-a3f6-49b2-9c3b-44aa7ae4e99b Oct 9 00:42:22.170030 kernel: BTRFS info (device vdb6): using crc32c (crc32c-generic) checksum algorithm Oct 9 00:42:22.170041 kernel: BTRFS info (device vdb6): using free space tree Oct 9 00:42:22.170822 systemd[1]: Mounted sysroot-usr.mount - /sysroot/usr. Oct 9 00:42:22.172971 kernel: BTRFS info (device vdb6): auto enabling async discard Oct 9 00:42:22.172724 systemd[1]: Starting initrd-setup-root.service - Root filesystem setup... Oct 9 00:42:22.174498 systemd[1]: Mounted sysroot-oem.mount - /sysroot/oem. Oct 9 00:42:22.465835 systemd[1]: Finished initrd-setup-root.service - Root filesystem setup. Oct 9 00:42:22.484109 systemd[1]: Starting initrd-setup-root-after-ignition.service - Root filesystem completion... Oct 9 00:42:22.488124 initrd-setup-root-after-ignition[1019]: grep: /sysroot/oem/oem-release: No such file or directory Oct 9 00:42:22.490195 initrd-setup-root-after-ignition[1021]: grep: /sysroot/etc/flatcar/enabled-sysext.conf: No such file or directory Oct 9 00:42:22.490195 initrd-setup-root-after-ignition[1021]: grep: /sysroot/usr/share/flatcar/enabled-sysext.conf: No such file or directory Oct 9 00:42:22.492397 initrd-setup-root-after-ignition[1025]: grep: /sysroot/etc/flatcar/enabled-sysext.conf: No such file or directory Oct 9 00:42:22.492487 systemd[1]: Finished initrd-setup-root-after-ignition.service - Root filesystem completion. Oct 9 00:42:22.494377 systemd[1]: Reached target ignition-subsequent.target - Subsequent (Not Ignition) boot complete. Oct 9 00:42:22.506147 systemd[1]: Starting initrd-parse-etc.service - Mountpoints Configured in the Real Root... Oct 9 00:42:22.523010 systemd[1]: initrd-parse-etc.service: Deactivated successfully. Oct 9 00:42:22.523111 systemd[1]: Finished initrd-parse-etc.service - Mountpoints Configured in the Real Root. Oct 9 00:42:22.524665 systemd[1]: Reached target initrd-fs.target - Initrd File Systems. Oct 9 00:42:22.526075 systemd[1]: Reached target initrd.target - Initrd Default Target. Oct 9 00:42:22.527335 systemd[1]: dracut-mount.service - dracut mount hook was skipped because no trigger condition checks were met. Oct 9 00:42:22.528000 systemd[1]: Starting dracut-pre-pivot.service - dracut pre-pivot and cleanup hook... Oct 9 00:42:22.541759 systemd[1]: Finished dracut-pre-pivot.service - dracut pre-pivot and cleanup hook. Oct 9 00:42:22.554120 systemd[1]: Starting initrd-cleanup.service - Cleaning Up and Shutting Down Daemons... Oct 9 00:42:22.561699 systemd[1]: Stopped target remote-cryptsetup.target - Remote Encrypted Volumes. Oct 9 00:42:22.562669 systemd[1]: Stopped target timers.target - Timer Units. Oct 9 00:42:22.563897 systemd[1]: decrypt-root.service: Deactivated successfully. Oct 9 00:42:22.564013 systemd[1]: Stopped decrypt-root.service - Generate and execute a systemd-cryptsetup service to decrypt the ROOT partition. Oct 9 00:42:22.565306 systemd[1]: dracut-pre-pivot.service: Deactivated successfully. Oct 9 00:42:22.565398 systemd[1]: Stopped dracut-pre-pivot.service - dracut pre-pivot and cleanup hook. Oct 9 00:42:22.567617 systemd[1]: Stopped target initrd.target - Initrd Default Target. Oct 9 00:42:22.568877 systemd[1]: Stopped target basic.target - Basic System. Oct 9 00:42:22.570213 systemd[1]: Stopped target ignition-subsequent.target - Subsequent (Not Ignition) boot complete. Oct 9 00:42:22.571578 systemd[1]: Stopped target ignition-diskful-subsequent.target - Ignition Subsequent Boot Disk Setup. Oct 9 00:42:22.572838 systemd[1]: Stopped target initrd-root-device.target - Initrd Root Device. Oct 9 00:42:22.574504 systemd[1]: Stopped target paths.target - Path Units. Oct 9 00:42:22.575890 systemd[1]: Stopped target remote-fs.target - Remote File Systems. Oct 9 00:42:22.577198 systemd[1]: Stopped target remote-fs-pre.target - Preparation for Remote File Systems. Oct 9 00:42:22.578468 systemd[1]: Stopped target slices.target - Slice Units. Oct 9 00:42:22.579710 systemd[1]: Stopped target sockets.target - Socket Units. Oct 9 00:42:22.581037 systemd[1]: Stopped target sysinit.target - System Initialization. Oct 9 00:42:22.582220 systemd[1]: Stopped target local-fs.target - Local File Systems. Oct 9 00:42:22.583377 systemd[1]: Stopped target swap.target - Swaps. Oct 9 00:42:22.584575 systemd[1]: iscsid.socket: Deactivated successfully. Oct 9 00:42:22.584655 systemd[1]: Closed iscsid.socket - Open-iSCSI iscsid Socket. Oct 9 00:42:22.585766 systemd[1]: iscsiuio.socket: Deactivated successfully. Oct 9 00:42:22.585851 systemd[1]: Closed iscsiuio.socket - Open-iSCSI iscsiuio Socket. Oct 9 00:42:22.586858 systemd[1]: dracut-pre-mount.service: Deactivated successfully. Oct 9 00:42:22.586961 systemd[1]: Stopped dracut-pre-mount.service - dracut pre-mount hook. Oct 9 00:42:22.588734 systemd[1]: Stopped target cryptsetup.target - Local Encrypted Volumes. Oct 9 00:42:22.589948 systemd[1]: systemd-ask-password-console.path: Deactivated successfully. Oct 9 00:42:22.591060 systemd[1]: Stopped systemd-ask-password-console.path - Dispatch Password Requests to Console Directory Watch. Oct 9 00:42:22.592010 systemd[1]: Stopped target cryptsetup-pre.target - Local Encrypted Volumes (Pre). Oct 9 00:42:22.593344 systemd[1]: clevis-luks-askpass.path: Deactivated successfully. Oct 9 00:42:22.593435 systemd[1]: Stopped clevis-luks-askpass.path - Forward Password Requests to Clevis Directory Watch. Oct 9 00:42:22.594783 systemd[1]: dracut-initqueue.service: Deactivated successfully. Oct 9 00:42:22.594893 systemd[1]: Stopped dracut-initqueue.service - dracut initqueue hook. Oct 9 00:42:22.597191 systemd[1]: ignition-setup-pre.service: Deactivated successfully. Oct 9 00:42:22.597299 systemd[1]: Stopped ignition-setup-pre.service - Ignition env setup. Oct 9 00:42:22.598673 systemd[1]: initrd-setup-root-after-ignition.service: Deactivated successfully. Oct 9 00:42:22.598769 systemd[1]: Stopped initrd-setup-root-after-ignition.service - Root filesystem completion. Oct 9 00:42:22.600031 systemd[1]: initrd-setup-root.service: Deactivated successfully. Oct 9 00:42:22.600123 systemd[1]: Stopped initrd-setup-root.service - Root filesystem setup. Oct 9 00:42:22.601575 systemd[1]: systemd-sysctl.service: Deactivated successfully. Oct 9 00:42:22.601667 systemd[1]: Stopped systemd-sysctl.service - Apply Kernel Variables. Oct 9 00:42:22.602787 systemd[1]: systemd-modules-load.service: Deactivated successfully. Oct 9 00:42:22.602890 systemd[1]: Stopped systemd-modules-load.service - Load Kernel Modules. Oct 9 00:42:22.604204 systemd[1]: systemd-tmpfiles-setup.service: Deactivated successfully. Oct 9 00:42:22.604300 systemd[1]: Stopped systemd-tmpfiles-setup.service - Create System Files and Directories. Oct 9 00:42:22.605566 systemd[1]: systemd-udev-trigger.service: Deactivated successfully. Oct 9 00:42:22.605655 systemd[1]: Stopped systemd-udev-trigger.service - Coldplug All udev Devices. Oct 9 00:42:22.606897 systemd[1]: dracut-pre-trigger.service: Deactivated successfully. Oct 9 00:42:22.607000 systemd[1]: Stopped dracut-pre-trigger.service - dracut pre-trigger hook. Oct 9 00:42:22.609219 systemd[1]: Stopping systemd-udevd.service - Rule-based Manager for Device Events and Files... Oct 9 00:42:22.614142 systemd[1]: initrd-cleanup.service: Deactivated successfully. Oct 9 00:42:22.614209 systemd[1]: Finished initrd-cleanup.service - Cleaning Up and Shutting Down Daemons. Oct 9 00:42:22.630576 systemd[1]: systemd-udevd.service: Deactivated successfully. Oct 9 00:42:22.630721 systemd[1]: Stopped systemd-udevd.service - Rule-based Manager for Device Events and Files. Oct 9 00:42:22.632227 systemd[1]: systemd-udevd-control.socket: Deactivated successfully. Oct 9 00:42:22.632260 systemd[1]: Closed systemd-udevd-control.socket - udev Control Socket. Oct 9 00:42:22.633669 systemd[1]: systemd-udevd-kernel.socket: Deactivated successfully. Oct 9 00:42:22.633697 systemd[1]: Closed systemd-udevd-kernel.socket - udev Kernel Socket. Oct 9 00:42:22.634915 systemd[1]: dracut-pre-udev.service: Deactivated successfully. Oct 9 00:42:22.634963 systemd[1]: Stopped dracut-pre-udev.service - dracut pre-udev hook. Oct 9 00:42:22.636873 systemd[1]: dracut-cmdline.service: Deactivated successfully. Oct 9 00:42:22.636912 systemd[1]: Stopped dracut-cmdline.service - dracut cmdline hook. Oct 9 00:42:22.638941 systemd[1]: dracut-cmdline-ask.service: Deactivated successfully. Oct 9 00:42:22.638992 systemd[1]: Stopped dracut-cmdline-ask.service - dracut ask for additional cmdline parameters. Oct 9 00:42:22.647091 systemd[1]: Starting initrd-udevadm-cleanup-db.service - Cleanup udev Database... Oct 9 00:42:22.647824 systemd[1]: systemd-tmpfiles-setup-dev.service: Deactivated successfully. Oct 9 00:42:22.647870 systemd[1]: Stopped systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev. Oct 9 00:42:22.649422 systemd[1]: systemd-tmpfiles-setup-dev-early.service: Deactivated successfully. Oct 9 00:42:22.649459 systemd[1]: Stopped systemd-tmpfiles-setup-dev-early.service - Create Static Device Nodes in /dev gracefully. Oct 9 00:42:22.650794 systemd[1]: kmod-static-nodes.service: Deactivated successfully. Oct 9 00:42:22.650837 systemd[1]: Stopped kmod-static-nodes.service - Create List of Static Device Nodes. Oct 9 00:42:22.652434 systemd[1]: systemd-vconsole-setup.service: Deactivated successfully. Oct 9 00:42:22.652471 systemd[1]: Stopped systemd-vconsole-setup.service - Virtual Console Setup. Oct 9 00:42:22.654095 systemd[1]: initrd-udevadm-cleanup-db.service: Deactivated successfully. Oct 9 00:42:22.655169 systemd[1]: Finished initrd-udevadm-cleanup-db.service - Cleanup udev Database. Oct 9 00:42:22.656597 systemd[1]: Reached target initrd-switch-root.target - Switch Root. Oct 9 00:42:22.660068 systemd[1]: Starting initrd-switch-root.service - Switch Root... Oct 9 00:42:22.666800 systemd[1]: Switching root. Oct 9 00:42:22.703042 systemd-journald[231]: Journal stopped Oct 9 00:42:23.165609 systemd-journald[231]: Received SIGTERM from PID 1 (systemd). Oct 9 00:42:23.165663 kernel: SELinux: policy capability network_peer_controls=1 Oct 9 00:42:23.165675 kernel: SELinux: policy capability open_perms=1 Oct 9 00:42:23.165685 kernel: SELinux: policy capability extended_socket_class=1 Oct 9 00:42:23.165694 kernel: SELinux: policy capability always_check_network=0 Oct 9 00:42:23.165704 kernel: SELinux: policy capability cgroup_seclabel=1 Oct 9 00:42:23.165713 kernel: SELinux: policy capability nnp_nosuid_transition=1 Oct 9 00:42:23.165723 kernel: SELinux: policy capability genfs_seclabel_symlinks=0 Oct 9 00:42:23.165732 kernel: SELinux: policy capability ioctl_skip_cloexec=0 Oct 9 00:42:23.165742 kernel: audit: type=1403 audit(1728434542.773:2): auid=4294967295 ses=4294967295 lsm=selinux res=1 Oct 9 00:42:23.165756 systemd[1]: Successfully loaded SELinux policy in 29.334ms. Oct 9 00:42:23.165776 systemd[1]: Relabeled /dev, /dev/shm, /run, /sys/fs/cgroup in 9.424ms. Oct 9 00:42:23.165787 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 9 00:42:23.165806 systemd[1]: Detected virtualization kvm. Oct 9 00:42:23.165818 systemd[1]: Detected architecture arm64. Oct 9 00:42:23.165828 zram_generator::config[1069]: No configuration found. Oct 9 00:42:23.165839 systemd[1]: initrd-switch-root.service: Deactivated successfully. Oct 9 00:42:23.165849 systemd[1]: Stopped initrd-switch-root.service - Switch Root. Oct 9 00:42:23.165862 systemd[1]: systemd-journald.service: Scheduled restart job, restart counter is at 1. Oct 9 00:42:23.165872 systemd[1]: Created slice system-addon\x2dconfig.slice - Slice /system/addon-config. Oct 9 00:42:23.165884 systemd[1]: Created slice system-addon\x2drun.slice - Slice /system/addon-run. Oct 9 00:42:23.165894 systemd[1]: Created slice system-getty.slice - Slice /system/getty. Oct 9 00:42:23.165904 systemd[1]: Created slice system-modprobe.slice - Slice /system/modprobe. Oct 9 00:42:23.165914 systemd[1]: Created slice system-serial\x2dgetty.slice - Slice /system/serial-getty. Oct 9 00:42:23.165924 systemd[1]: Created slice system-system\x2dcloudinit.slice - Slice /system/system-cloudinit. Oct 9 00:42:23.165934 systemd[1]: Created slice system-systemd\x2dfsck.slice - Slice /system/systemd-fsck. Oct 9 00:42:23.165946 systemd[1]: Created slice user.slice - User and Session Slice. Oct 9 00:42:23.165965 systemd[1]: Started clevis-luks-askpass.path - Forward Password Requests to Clevis Directory Watch. Oct 9 00:42:23.165979 systemd[1]: Started systemd-ask-password-console.path - Dispatch Password Requests to Console Directory Watch. Oct 9 00:42:23.165989 systemd[1]: Started systemd-ask-password-wall.path - Forward Password Requests to Wall Directory Watch. Oct 9 00:42:23.166000 systemd[1]: Set up automount boot.automount - Boot partition Automount Point. Oct 9 00:42:23.166011 systemd[1]: Set up automount proc-sys-fs-binfmt_misc.automount - Arbitrary Executable File Formats File System Automount Point. Oct 9 00:42:23.166022 systemd[1]: Expecting device dev-disk-by\x2dlabel-OEM.device - /dev/disk/by-label/OEM... Oct 9 00:42:23.166032 systemd[1]: Expecting device dev-ttyAMA0.device - /dev/ttyAMA0... Oct 9 00:42:23.166042 systemd[1]: Reached target blockdev@dev-mapper-rootencrypted.target - Block Device Preparation for /dev/mapper/rootencrypted. Oct 9 00:42:23.166054 systemd[1]: Reached target cryptsetup-pre.target - Local Encrypted Volumes (Pre). Oct 9 00:42:23.166065 systemd[1]: Stopped target initrd-switch-root.target - Switch Root. Oct 9 00:42:23.166074 systemd[1]: Stopped target initrd-fs.target - Initrd File Systems. Oct 9 00:42:23.166084 systemd[1]: Stopped target initrd-root-fs.target - Initrd Root File System. Oct 9 00:42:23.166095 systemd[1]: Reached target integritysetup.target - Local Integrity Protected Volumes. Oct 9 00:42:23.166105 systemd[1]: Reached target remote-cryptsetup.target - Remote Encrypted Volumes. Oct 9 00:42:23.166116 systemd[1]: Reached target remote-fs.target - Remote File Systems. Oct 9 00:42:23.166126 systemd[1]: Reached target slices.target - Slice Units. Oct 9 00:42:23.166137 systemd[1]: Reached target swap.target - Swaps. Oct 9 00:42:23.166148 systemd[1]: Reached target veritysetup.target - Local Verity Protected Volumes. Oct 9 00:42:23.166158 systemd[1]: Listening on systemd-coredump.socket - Process Core Dump Socket. Oct 9 00:42:23.166168 systemd[1]: Listening on systemd-networkd.socket - Network Service Netlink Socket. Oct 9 00:42:23.166178 systemd[1]: Listening on systemd-udevd-control.socket - udev Control Socket. Oct 9 00:42:23.166188 systemd[1]: Listening on systemd-udevd-kernel.socket - udev Kernel Socket. Oct 9 00:42:23.166198 systemd[1]: Listening on systemd-userdbd.socket - User Database Manager Socket. Oct 9 00:42:23.166208 systemd[1]: Mounting dev-hugepages.mount - Huge Pages File System... Oct 9 00:42:23.166218 systemd[1]: Mounting dev-mqueue.mount - POSIX Message Queue File System... Oct 9 00:42:23.166230 systemd[1]: Mounting media.mount - External Media Directory... Oct 9 00:42:23.166241 systemd[1]: Mounting sys-kernel-debug.mount - Kernel Debug File System... Oct 9 00:42:23.166255 systemd[1]: Mounting sys-kernel-tracing.mount - Kernel Trace File System... Oct 9 00:42:23.166266 systemd[1]: Mounting tmp.mount - Temporary Directory /tmp... Oct 9 00:42:23.166276 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 9 00:42:23.166287 systemd[1]: Reached target machines.target - Containers. Oct 9 00:42:23.166297 systemd[1]: Starting flatcar-tmpfiles.service - Create missing system files... Oct 9 00:42:23.166309 systemd[1]: ignition-delete-config.service - Ignition (delete config) was skipped because of an unmet condition check (ConditionFirstBoot=true). Oct 9 00:42:23.166321 systemd[1]: Starting kmod-static-nodes.service - Create List of Static Device Nodes... Oct 9 00:42:23.166331 systemd[1]: Starting modprobe@configfs.service - Load Kernel Module configfs... Oct 9 00:42:23.166341 systemd[1]: Starting modprobe@dm_mod.service - Load Kernel Module dm_mod... Oct 9 00:42:23.166351 systemd[1]: Starting modprobe@drm.service - Load Kernel Module drm... Oct 9 00:42:23.166362 systemd[1]: Starting modprobe@efi_pstore.service - Load Kernel Module efi_pstore... Oct 9 00:42:23.166372 systemd[1]: Starting modprobe@fuse.service - Load Kernel Module fuse... Oct 9 00:42:23.166382 systemd[1]: Starting modprobe@loop.service - Load Kernel Module loop... Oct 9 00:42:23.166392 systemd[1]: setup-nsswitch.service - Create /etc/nsswitch.conf was skipped because of an unmet condition check (ConditionPathExists=!/etc/nsswitch.conf). Oct 9 00:42:23.166404 systemd[1]: systemd-fsck-root.service: Deactivated successfully. Oct 9 00:42:23.166414 systemd[1]: Stopped systemd-fsck-root.service - File System Check on Root Device. Oct 9 00:42:23.166424 kernel: fuse: init (API version 7.39) Oct 9 00:42:23.166433 systemd[1]: systemd-fsck-usr.service: Deactivated successfully. Oct 9 00:42:23.166443 systemd[1]: Stopped systemd-fsck-usr.service. Oct 9 00:42:23.166454 systemd[1]: Starting systemd-journald.service - Journal Service... Oct 9 00:42:23.166464 kernel: loop: module loaded Oct 9 00:42:23.166474 systemd[1]: Starting systemd-modules-load.service - Load Kernel Modules... Oct 9 00:42:23.166484 kernel: ACPI: bus type drm_connector registered Oct 9 00:42:23.166494 systemd[1]: Starting systemd-network-generator.service - Generate network units from Kernel command line... Oct 9 00:42:23.166505 systemd[1]: Starting systemd-remount-fs.service - Remount Root and Kernel File Systems... Oct 9 00:42:23.166515 systemd[1]: Starting systemd-udev-trigger.service - Coldplug All udev Devices... Oct 9 00:42:23.166547 systemd-journald[1134]: Collecting audit messages is disabled. Oct 9 00:42:23.166570 systemd[1]: verity-setup.service: Deactivated successfully. Oct 9 00:42:23.166580 systemd[1]: Stopped verity-setup.service. Oct 9 00:42:23.166591 systemd-journald[1134]: Journal started Oct 9 00:42:23.166612 systemd-journald[1134]: Runtime Journal (/run/log/journal/77d3fb4d0fc34e56a5becad83947f740) is 5.9M, max 47.3M, 41.4M free. Oct 9 00:42:23.000612 systemd[1]: Queued start job for default target multi-user.target. Oct 9 00:42:23.020624 systemd[1]: Unnecessary job was removed for dev-disk-by\x2duuid-a7656c31\x2d7c51\x2d4be3\x2d8fb7\x2d805a18f1d3f6.device - /dev/disk/by-uuid/a7656c31-7c51-4be3-8fb7-805a18f1d3f6. Oct 9 00:42:23.020636 systemd[1]: Unnecessary job was removed for dev-vdb6.device - /dev/vdb6. Oct 9 00:42:23.021014 systemd[1]: systemd-journald.service: Deactivated successfully. Oct 9 00:42:23.171017 systemd[1]: Started systemd-journald.service - Journal Service. Oct 9 00:42:23.170428 systemd[1]: Mounted dev-hugepages.mount - Huge Pages File System. Oct 9 00:42:23.171345 systemd[1]: Mounted dev-mqueue.mount - POSIX Message Queue File System. Oct 9 00:42:23.172367 systemd[1]: Mounted media.mount - External Media Directory. Oct 9 00:42:23.173302 systemd[1]: Mounted sys-kernel-debug.mount - Kernel Debug File System. Oct 9 00:42:23.174165 systemd[1]: Mounted sys-kernel-tracing.mount - Kernel Trace File System. Oct 9 00:42:23.175031 systemd[1]: Mounted tmp.mount - Temporary Directory /tmp. Oct 9 00:42:23.175967 systemd[1]: Finished kmod-static-nodes.service - Create List of Static Device Nodes. Oct 9 00:42:23.178154 systemd[1]: Finished flatcar-tmpfiles.service - Create missing system files. Oct 9 00:42:23.179182 systemd[1]: modprobe@configfs.service: Deactivated successfully. Oct 9 00:42:23.179345 systemd[1]: Finished modprobe@configfs.service - Load Kernel Module configfs. Oct 9 00:42:23.180471 systemd[1]: modprobe@dm_mod.service: Deactivated successfully. Oct 9 00:42:23.180620 systemd[1]: Finished modprobe@dm_mod.service - Load Kernel Module dm_mod. Oct 9 00:42:23.181650 systemd[1]: modprobe@drm.service: Deactivated successfully. Oct 9 00:42:23.181782 systemd[1]: Finished modprobe@drm.service - Load Kernel Module drm. Oct 9 00:42:23.182847 systemd[1]: modprobe@efi_pstore.service: Deactivated successfully. Oct 9 00:42:23.183003 systemd[1]: Finished modprobe@efi_pstore.service - Load Kernel Module efi_pstore. Oct 9 00:42:23.184055 systemd[1]: modprobe@fuse.service: Deactivated successfully. Oct 9 00:42:23.184182 systemd[1]: Finished modprobe@fuse.service - Load Kernel Module fuse. Oct 9 00:42:23.185274 systemd[1]: modprobe@loop.service: Deactivated successfully. Oct 9 00:42:23.185407 systemd[1]: Finished modprobe@loop.service - Load Kernel Module loop. Oct 9 00:42:23.186408 systemd[1]: Finished systemd-modules-load.service - Load Kernel Modules. Oct 9 00:42:23.187445 systemd[1]: Finished systemd-network-generator.service - Generate network units from Kernel command line. Oct 9 00:42:23.188578 systemd[1]: Finished systemd-remount-fs.service - Remount Root and Kernel File Systems. Oct 9 00:42:23.200421 systemd[1]: Reached target network-pre.target - Preparation for Network. Oct 9 00:42:23.212053 systemd[1]: Mounting sys-fs-fuse-connections.mount - FUSE Control File System... Oct 9 00:42:23.213874 systemd[1]: Mounting sys-kernel-config.mount - Kernel Configuration File System... Oct 9 00:42:23.214832 systemd[1]: remount-root.service - Remount Root File System was skipped because of an unmet condition check (ConditionPathIsReadWrite=!/). Oct 9 00:42:23.214866 systemd[1]: Reached target local-fs.target - Local File Systems. Oct 9 00:42:23.216522 systemd[1]: Listening on systemd-sysext.socket - System Extension Image Management (Varlink). Oct 9 00:42:23.218365 systemd[1]: Starting dracut-shutdown.service - Restore /run/initramfs on shutdown... Oct 9 00:42:23.220202 systemd[1]: Starting ldconfig.service - Rebuild Dynamic Linker Cache... Oct 9 00:42:23.221204 systemd[1]: systemd-binfmt.service - Set Up Additional Binary Formats was skipped because no trigger condition checks were met. Oct 9 00:42:23.222497 systemd[1]: Starting systemd-hwdb-update.service - Rebuild Hardware Database... Oct 9 00:42:23.225128 systemd[1]: Starting systemd-journal-flush.service - Flush Journal to Persistent Storage... Oct 9 00:42:23.226081 systemd[1]: systemd-pstore.service - Platform Persistent Storage Archival was skipped because of an unmet condition check (ConditionDirectoryNotEmpty=/sys/fs/pstore). Oct 9 00:42:23.227108 systemd[1]: Starting systemd-random-seed.service - Load/Save OS Random Seed... Oct 9 00:42:23.227899 systemd[1]: systemd-repart.service - Repartition Root Disk was skipped because no trigger condition checks were met. Oct 9 00:42:23.229110 systemd[1]: Starting systemd-sysctl.service - Apply Kernel Variables... Oct 9 00:42:23.233152 systemd[1]: Starting systemd-sysext.service - Merge System Extension Images into /usr/ and /opt/... Oct 9 00:42:23.235887 systemd-journald[1134]: Time spent on flushing to /var/log/journal/77d3fb4d0fc34e56a5becad83947f740 is 27.433ms for 677 entries. Oct 9 00:42:23.235887 systemd-journald[1134]: System Journal (/var/log/journal/77d3fb4d0fc34e56a5becad83947f740) is 12.3M, max 204.2M, 191.8M free. Oct 9 00:42:23.297498 systemd-journald[1134]: Received client request to flush runtime journal. Oct 9 00:42:23.297533 systemd-journald[1134]: /var/log/journal/77d3fb4d0fc34e56a5becad83947f740/system.journal: Journal file uses a different sequence number ID, rotating. Oct 9 00:42:23.297551 systemd-journald[1134]: Rotating system journal. Oct 9 00:42:23.297568 kernel: loop0: detected capacity change from 0 to 116808 Oct 9 00:42:23.297580 kernel: squashfs: version 4.0 (2009/01/31) Phillip Lougher Oct 9 00:42:23.236169 systemd[1]: Starting systemd-tmpfiles-setup-dev-early.service - Create Static Device Nodes in /dev gracefully... Oct 9 00:42:23.239349 systemd[1]: Finished systemd-udev-trigger.service - Coldplug All udev Devices. Oct 9 00:42:23.241374 systemd[1]: Mounted sys-fs-fuse-connections.mount - FUSE Control File System. Oct 9 00:42:23.242309 systemd[1]: Mounted sys-kernel-config.mount - Kernel Configuration File System. Oct 9 00:42:23.243518 systemd[1]: Finished dracut-shutdown.service - Restore /run/initramfs on shutdown. Oct 9 00:42:23.250368 systemd[1]: Starting systemd-udev-settle.service - Wait for udev To Complete Device Initialization... Oct 9 00:42:23.255260 systemd[1]: Finished systemd-random-seed.service - Load/Save OS Random Seed. Oct 9 00:42:23.256394 systemd[1]: first-boot-complete.target - First Boot Complete was skipped because of an unmet condition check (ConditionFirstBoot=yes). Oct 9 00:42:23.256441 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 9 00:42:23.275412 systemd-tmpfiles[1179]: ACLs are not supported, ignoring. Oct 9 00:42:23.275422 systemd-tmpfiles[1179]: ACLs are not supported, ignoring. Oct 9 00:42:23.276986 systemd[1]: Finished systemd-sysctl.service - Apply Kernel Variables. Oct 9 00:42:23.278842 systemd[1]: Finished systemd-tmpfiles-setup-dev-early.service - Create Static Device Nodes in /dev gracefully. Oct 9 00:42:23.280733 udevadm[1187]: systemd-udev-settle.service is deprecated. Please fix lvm2-activation.service, lvm2-activation-early.service not to pull it in. Oct 9 00:42:23.291257 systemd[1]: Starting systemd-sysusers.service - Create System Users... Oct 9 00:42:23.301016 kernel: loop1: detected capacity change from 0 to 113456 Oct 9 00:42:23.301720 systemd[1]: Finished systemd-journal-flush.service - Flush Journal to Persistent Storage. Oct 9 00:42:23.318003 systemd[1]: Finished systemd-sysusers.service - Create System Users. Oct 9 00:42:23.325139 systemd[1]: Starting systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev... Oct 9 00:42:23.331727 kernel: loop2: detected capacity change from 0 to 116808 Oct 9 00:42:23.336506 systemd-tmpfiles[1201]: ACLs are not supported, ignoring. Oct 9 00:42:23.336528 systemd-tmpfiles[1201]: ACLs are not supported, ignoring. Oct 9 00:42:23.340984 kernel: loop3: detected capacity change from 0 to 113456 Oct 9 00:42:23.340985 systemd[1]: Finished systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev. Oct 9 00:42:23.343697 (sd-merge)[1203]: Using extensions 'containerd-flatcar', 'docker-flatcar'. Oct 9 00:42:23.344097 (sd-merge)[1203]: Merged extensions into '/usr'. Oct 9 00:42:23.347572 systemd[1]: Finished systemd-sysext.service - Merge System Extension Images into /usr/ and /opt/. Oct 9 00:42:23.355197 systemd[1]: Starting ensure-sysext.service... Oct 9 00:42:23.356834 systemd[1]: Starting systemd-tmpfiles-setup.service - Create System Files and Directories... Oct 9 00:42:23.365347 systemd[1]: Reloading requested from client PID 1206 ('systemctl') (unit ensure-sysext.service)... Oct 9 00:42:23.365364 systemd[1]: Reloading... Oct 9 00:42:23.367389 ldconfig[1173]: /sbin/ldconfig: /usr/lib/ld.so.conf is not an ELF file - it has the wrong magic bytes at the start. Oct 9 00:42:23.372329 systemd-tmpfiles[1208]: /usr/lib/tmpfiles.d/provision.conf:20: Duplicate line for path "/root", ignoring. Oct 9 00:42:23.372584 systemd-tmpfiles[1208]: /usr/lib/tmpfiles.d/systemd-flatcar.conf:6: Duplicate line for path "/var/log/journal", ignoring. Oct 9 00:42:23.373245 systemd-tmpfiles[1208]: /usr/lib/tmpfiles.d/systemd.conf:29: Duplicate line for path "/var/lib/systemd", ignoring. Oct 9 00:42:23.373459 systemd-tmpfiles[1208]: ACLs are not supported, ignoring. Oct 9 00:42:23.373507 systemd-tmpfiles[1208]: ACLs are not supported, ignoring. Oct 9 00:42:23.377280 systemd-tmpfiles[1208]: Detected autofs mount point /boot during canonicalization of boot. Oct 9 00:42:23.377291 systemd-tmpfiles[1208]: Skipping /boot Oct 9 00:42:23.385934 systemd-tmpfiles[1208]: Detected autofs mount point /boot during canonicalization of boot. Oct 9 00:42:23.385950 systemd-tmpfiles[1208]: Skipping /boot Oct 9 00:42:23.412050 zram_generator::config[1242]: No configuration found. Oct 9 00:42:23.488563 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 9 00:42:23.527426 systemd[1]: Reloading finished in 161 ms. Oct 9 00:42:23.553111 systemd[1]: Finished ldconfig.service - Rebuild Dynamic Linker Cache. Oct 9 00:42:23.564318 systemd[1]: Finished systemd-tmpfiles-setup.service - Create System Files and Directories. Oct 9 00:42:23.573466 systemd[1]: Starting audit-rules.service - Load Audit Rules... Oct 9 00:42:23.575677 systemd[1]: Starting clean-ca-certificates.service - Clean up broken links in /etc/ssl/certs... Oct 9 00:42:23.580216 systemd[1]: Starting systemd-journal-catalog-update.service - Rebuild Journal Catalog... Oct 9 00:42:23.582732 systemd[1]: Starting systemd-resolved.service - Network Name Resolution... Oct 9 00:42:23.586293 systemd[1]: Starting systemd-update-utmp.service - Record System Boot/Shutdown in UTMP... Oct 9 00:42:23.589041 systemd[1]: ignition-delete-config.service - Ignition (delete config) was skipped because of an unmet condition check (ConditionFirstBoot=true). Oct 9 00:42:23.592307 systemd[1]: Starting modprobe@dm_mod.service - Load Kernel Module dm_mod... Oct 9 00:42:23.600369 systemd[1]: Starting modprobe@efi_pstore.service - Load Kernel Module efi_pstore... Oct 9 00:42:23.602753 systemd[1]: Starting modprobe@loop.service - Load Kernel Module loop... Oct 9 00:42:23.603865 systemd[1]: systemd-binfmt.service - Set Up Additional Binary Formats was skipped because no trigger condition checks were met. Oct 9 00:42:23.604006 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 9 00:42:23.604717 systemd[1]: modprobe@dm_mod.service: Deactivated successfully. Oct 9 00:42:23.606259 systemd[1]: Finished modprobe@dm_mod.service - Load Kernel Module dm_mod. Oct 9 00:42:23.608321 systemd[1]: modprobe@efi_pstore.service: Deactivated successfully. Oct 9 00:42:23.608437 systemd[1]: Finished modprobe@efi_pstore.service - Load Kernel Module efi_pstore. Oct 9 00:42:23.609929 systemd[1]: modprobe@loop.service: Deactivated successfully. Oct 9 00:42:23.610065 systemd[1]: Finished modprobe@loop.service - Load Kernel Module loop. Oct 9 00:42:23.615076 augenrules[1269]: /sbin/augenrules: No change Oct 9 00:42:23.616328 systemd[1]: ignition-delete-config.service - Ignition (delete config) was skipped because of an unmet condition check (ConditionFirstBoot=true). Oct 9 00:42:23.617638 systemd[1]: Starting modprobe@dm_mod.service - Load Kernel Module dm_mod... Oct 9 00:42:23.620260 systemd[1]: Starting modprobe@efi_pstore.service - Load Kernel Module efi_pstore... Oct 9 00:42:23.623233 systemd[1]: Starting modprobe@loop.service - Load Kernel Module loop... Oct 9 00:42:23.624266 systemd[1]: systemd-binfmt.service - Set Up Additional Binary Formats was skipped because no trigger condition checks were met. Oct 9 00:42:23.624435 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 9 00:42:23.629290 systemd[1]: Starting systemd-userdbd.service - User Database Manager... Oct 9 00:42:23.632122 systemd[1]: Finished systemd-journal-catalog-update.service - Rebuild Journal Catalog. Oct 9 00:42:23.633680 systemd[1]: modprobe@dm_mod.service: Deactivated successfully. Oct 9 00:42:23.633821 augenrules[1298]: No rules Oct 9 00:42:23.633824 systemd[1]: Finished modprobe@dm_mod.service - Load Kernel Module dm_mod. Oct 9 00:42:23.636611 systemd[1]: audit-rules.service: Deactivated successfully. Oct 9 00:42:23.636746 systemd[1]: Finished audit-rules.service - Load Audit Rules. Oct 9 00:42:23.638048 systemd[1]: modprobe@efi_pstore.service: Deactivated successfully. Oct 9 00:42:23.638166 systemd[1]: Finished modprobe@efi_pstore.service - Load Kernel Module efi_pstore. Oct 9 00:42:23.639502 systemd[1]: modprobe@loop.service: Deactivated successfully. Oct 9 00:42:23.639617 systemd[1]: Finished modprobe@loop.service - Load Kernel Module loop. Oct 9 00:42:23.643585 systemd[1]: Finished systemd-update-utmp.service - Record System Boot/Shutdown in UTMP. Oct 9 00:42:23.652304 systemd[1]: Finished clean-ca-certificates.service - Clean up broken links in /etc/ssl/certs. Oct 9 00:42:23.664253 systemd[1]: Starting audit-rules.service - Load Audit Rules... Oct 9 00:42:23.665032 systemd[1]: ignition-delete-config.service - Ignition (delete config) was skipped because of an unmet condition check (ConditionFirstBoot=true). Oct 9 00:42:23.667205 systemd[1]: Starting modprobe@dm_mod.service - Load Kernel Module dm_mod... Oct 9 00:42:23.668921 systemd[1]: Starting modprobe@drm.service - Load Kernel Module drm... Oct 9 00:42:23.673247 systemd[1]: Starting modprobe@efi_pstore.service - Load Kernel Module efi_pstore... Oct 9 00:42:23.676681 systemd[1]: Starting modprobe@loop.service - Load Kernel Module loop... Oct 9 00:42:23.678042 systemd[1]: systemd-binfmt.service - Set Up Additional Binary Formats was skipped because no trigger condition checks were met. Oct 9 00:42:23.678170 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 9 00:42:23.678283 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 9 00:42:23.679256 systemd[1]: modprobe@drm.service: Deactivated successfully. Oct 9 00:42:23.679412 systemd[1]: Finished modprobe@drm.service - Load Kernel Module drm. Oct 9 00:42:23.683558 systemd[1]: Finished ensure-sysext.service. Oct 9 00:42:23.684675 systemd[1]: Started systemd-userdbd.service - User Database Manager. Oct 9 00:42:23.685837 systemd[1]: modprobe@dm_mod.service: Deactivated successfully. Oct 9 00:42:23.686009 systemd[1]: Finished modprobe@dm_mod.service - Load Kernel Module dm_mod. Oct 9 00:42:23.687208 systemd[1]: modprobe@loop.service: Deactivated successfully. Oct 9 00:42:23.687324 systemd[1]: Finished modprobe@loop.service - Load Kernel Module loop. Oct 9 00:42:23.687945 augenrules[1309]: /sbin/augenrules: No change Oct 9 00:42:23.688430 systemd[1]: modprobe@efi_pstore.service: Deactivated successfully. Oct 9 00:42:23.688550 systemd[1]: Finished modprobe@efi_pstore.service - Load Kernel Module efi_pstore. Oct 9 00:42:23.693517 systemd[1]: systemd-pstore.service - Platform Persistent Storage Archival was skipped because of an unmet condition check (ConditionDirectoryNotEmpty=/sys/fs/pstore). Oct 9 00:42:23.693583 systemd[1]: systemd-repart.service - Repartition Root Disk was skipped because no trigger condition checks were met. Oct 9 00:42:23.695284 augenrules[1336]: No rules Oct 9 00:42:23.702118 systemd[1]: Starting systemd-timesyncd.service - Network Time Synchronization... Oct 9 00:42:23.703159 systemd[1]: audit-rules.service: Deactivated successfully. Oct 9 00:42:23.703389 systemd[1]: Finished audit-rules.service - Load Audit Rules. Oct 9 00:42:23.735472 systemd[1]: Finished systemd-hwdb-update.service - Rebuild Hardware Database. Oct 9 00:42:23.744307 systemd-resolved[1273]: Positive Trust Anchors: Oct 9 00:42:23.744639 systemd-resolved[1273]: . IN DS 20326 8 2 e06d44b80b8f1d39a95c0b0d7c65d08458e880409bbc683457104237c7f8ec8d Oct 9 00:42:23.744672 systemd-resolved[1273]: 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 resolver.arpa corp home internal intranet lan local private test Oct 9 00:42:23.750756 systemd-resolved[1273]: Defaulting to hostname 'linux'. Oct 9 00:42:23.756161 systemd[1]: Starting systemd-udevd.service - Rule-based Manager for Device Events and Files... Oct 9 00:42:23.758321 systemd[1]: Starting systemd-update-done.service - Update is Completed... Oct 9 00:42:23.759311 systemd[1]: Started systemd-timesyncd.service - Network Time Synchronization. Oct 9 00:42:23.760302 systemd[1]: Started systemd-resolved.service - Network Name Resolution. Oct 9 00:42:23.761356 systemd[1]: Reached target nss-lookup.target - Host and Network Name Lookups. Oct 9 00:42:23.762212 systemd[1]: Reached target time-set.target - System Time Set. Oct 9 00:42:23.776550 systemd[1]: Finished systemd-update-done.service - Update is Completed. Oct 9 00:42:23.777355 systemd-udevd[1345]: Using default interface naming scheme 'v255'. Oct 9 00:42:23.809020 systemd[1]: Started systemd-udevd.service - Rule-based Manager for Device Events and Files. Oct 9 00:42:23.818142 systemd[1]: Starting systemd-networkd.service - Network Configuration... Oct 9 00:42:23.842977 kernel: BTRFS info: devid 1 device path /dev/mapper/usr changed to /dev/dm-0 scanned by (udev-worker) (1354) Oct 9 00:42:23.842609 systemd[1]: Condition check resulted in dev-ttyAMA0.device - /dev/ttyAMA0 being skipped. Oct 9 00:42:23.847026 kernel: BTRFS info: devid 1 device path /dev/dm-0 changed to /dev/mapper/usr scanned by (udev-worker) (1354) Oct 9 00:42:23.858035 kernel: BTRFS warning: duplicate device /dev/vdb3 devid 1 generation 37 scanned by (udev-worker) (1351) Oct 9 00:42:23.882059 systemd[1]: Found device dev-disk-by\x2dlabel-OEM.device - /dev/disk/by-label/OEM. Oct 9 00:42:23.890179 systemd[1]: Starting systemd-fsck@dev-disk-by\x2dlabel-OEM.service - File System Check on /dev/disk/by-label/OEM... Oct 9 00:42:23.894524 systemd-networkd[1356]: lo: Link UP Oct 9 00:42:23.894531 systemd-networkd[1356]: lo: Gained carrier Oct 9 00:42:23.895401 systemd-networkd[1356]: Enumeration completed Oct 9 00:42:23.895486 systemd[1]: Started systemd-networkd.service - Network Configuration. Oct 9 00:42:23.896410 systemd[1]: Reached target network.target - Network. Oct 9 00:42:23.897086 systemd-networkd[1356]: eth0: found matching network '/usr/lib/systemd/network/zz-default.network', based on potentially unpredictable interface name. Oct 9 00:42:23.897090 systemd-networkd[1356]: eth0: Configuring with /usr/lib/systemd/network/zz-default.network. Oct 9 00:42:23.897853 systemd-networkd[1356]: eth0: found matching network '/usr/lib/systemd/network/zz-default.network', based on potentially unpredictable interface name. Oct 9 00:42:23.897886 systemd-networkd[1356]: eth0: Link UP Oct 9 00:42:23.897888 systemd-networkd[1356]: eth0: Gained carrier Oct 9 00:42:23.897896 systemd-networkd[1356]: eth0: found matching network '/usr/lib/systemd/network/zz-default.network', based on potentially unpredictable interface name. Oct 9 00:42:23.898867 systemd[1]: Starting systemd-networkd-wait-online.service - Wait for Network to be Configured... Oct 9 00:42:23.915023 systemd-networkd[1356]: eth0: DHCPv4 address 10.0.0.31/16, gateway 10.0.0.1 acquired from 10.0.0.1 Oct 9 00:42:23.917817 systemd[1]: Finished systemd-fsck@dev-disk-by\x2dlabel-OEM.service - File System Check on /dev/disk/by-label/OEM. Oct 9 00:42:23.919598 systemd-timesyncd[1342]: Network configuration changed, trying to establish connection. Oct 9 00:42:23.938221 systemd[1]: Starting systemd-vconsole-setup.service - Virtual Console Setup... Oct 9 00:42:23.944478 systemd[1]: Finished systemd-udev-settle.service - Wait for udev To Complete Device Initialization. Oct 9 00:42:23.946806 systemd[1]: Starting lvm2-activation-early.service - Activation of LVM2 logical volumes... Oct 9 00:42:23.961985 lvm[1385]: WARNING: Failed to connect to lvmetad. Falling back to device scanning. Oct 9 00:42:23.975941 systemd[1]: Finished systemd-vconsole-setup.service - Virtual Console Setup. Oct 9 00:42:23.991435 systemd[1]: Finished lvm2-activation-early.service - Activation of LVM2 logical volumes. Oct 9 00:42:23.992547 systemd[1]: Reached target cryptsetup.target - Local Encrypted Volumes. Oct 9 00:42:23.993405 systemd[1]: Reached target sysinit.target - System Initialization. Oct 9 00:42:23.994296 systemd[1]: Started motdgen.path - Watch for update engine configuration changes. Oct 9 00:42:23.995239 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 9 00:42:23.996408 systemd[1]: Started logrotate.timer - Daily rotation of log files. Oct 9 00:42:23.997348 systemd[1]: Started mdadm.timer - Weekly check for MD array's redundancy information.. Oct 9 00:42:23.998249 systemd[1]: Started systemd-tmpfiles-clean.timer - Daily Cleanup of Temporary Directories. Oct 9 00:42:23.999111 systemd[1]: update-engine-stub.timer - Update Engine Stub Timer was skipped because of an unmet condition check (ConditionPathExists=/usr/.noupdate). Oct 9 00:42:23.999145 systemd[1]: Reached target paths.target - Path Units. Oct 9 00:42:23.999782 systemd[1]: Reached target timers.target - Timer Units. Oct 9 00:42:24.001359 systemd[1]: Listening on dbus.socket - D-Bus System Message Bus Socket. Oct 9 00:42:24.003483 systemd[1]: Starting docker.socket - Docker Socket for the API... Oct 9 00:42:24.010759 systemd[1]: Listening on sshd.socket - OpenSSH Server Socket. Oct 9 00:42:24.012707 systemd[1]: Starting lvm2-activation.service - Activation of LVM2 logical volumes... Oct 9 00:42:24.014051 systemd[1]: Listening on docker.socket - Docker Socket for the API. Oct 9 00:42:24.014917 systemd[1]: Reached target sockets.target - Socket Units. Oct 9 00:42:24.015634 systemd[1]: Reached target basic.target - Basic System. Oct 9 00:42:24.016330 systemd[1]: addon-config@oem.service - Configure Addon /oem was skipped because no trigger condition checks were met. Oct 9 00:42:24.016362 systemd[1]: addon-run@oem.service - Run Addon /oem was skipped because no trigger condition checks were met. Oct 9 00:42:24.017202 systemd[1]: Starting containerd.service - containerd container runtime... Oct 9 00:42:24.017982 systemd[1]: cryptenroll-helper-bind.service was skipped because of an unmet condition check (ConditionPathExists=/etc/luks/rootencrypted-bind). Oct 9 00:42:24.018887 systemd[1]: Starting dbus.service - D-Bus System Message Bus... Oct 9 00:42:24.020268 lvm[1393]: WARNING: Failed to connect to lvmetad. Falling back to device scanning. Oct 9 00:42:24.022057 systemd[1]: Starting enable-oem-cloudinit.service - Enable cloudinit... Oct 9 00:42:24.023767 systemd[1]: Starting extend-filesystems.service - Extend Filesystems... Oct 9 00:42:24.024650 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 9 00:42:24.026138 systemd[1]: Starting motdgen.service - Generate /run/flatcar/motd... Oct 9 00:42:24.037037 jq[1396]: false Oct 9 00:42:24.050531 systemd[1]: Starting ssh-key-proc-cmdline.service - Install an ssh key from /proc/cmdline... Oct 9 00:42:24.053743 systemd[1]: Starting sshd-keygen.service - Generate sshd host keys... Oct 9 00:42:24.056374 dbus-daemon[1395]: [system] SELinux support is enabled Oct 9 00:42:24.059118 systemd[1]: Starting systemd-logind.service - User Login Management... Oct 9 00:42:24.062121 extend-filesystems[1397]: Found loop2 Oct 9 00:42:24.062121 extend-filesystems[1397]: Found loop3 Oct 9 00:42:24.062121 extend-filesystems[1397]: Found vda Oct 9 00:42:24.062121 extend-filesystems[1397]: Found vdb Oct 9 00:42:24.062121 extend-filesystems[1397]: Found vdb1 Oct 9 00:42:24.062121 extend-filesystems[1397]: Found vdb2 Oct 9 00:42:24.062121 extend-filesystems[1397]: Found vdb3 Oct 9 00:42:24.062121 extend-filesystems[1397]: Found usr Oct 9 00:42:24.062121 extend-filesystems[1397]: Found vdb4 Oct 9 00:42:24.062121 extend-filesystems[1397]: Found vdb6 Oct 9 00:42:24.062121 extend-filesystems[1397]: Found vdb7 Oct 9 00:42:24.062121 extend-filesystems[1397]: Found vdb9 Oct 9 00:42:24.062121 extend-filesystems[1397]: Found rootencrypted Oct 9 00:42:24.064669 systemd[1]: tcsd.service - TCG Core Services Daemon was skipped because of an unmet condition check (ConditionSecurity=!tpm2). Oct 9 00:42:24.065106 systemd[1]: cgroup compatibility translation between legacy and unified hierarchy settings activated. See cgroup-compat debug messages for details. Oct 9 00:42:24.065716 systemd[1]: Starting update-engine.service - Update Engine... Oct 9 00:42:24.070098 systemd[1]: Starting update-ssh-keys-after-ignition.service - Run update-ssh-keys once after Ignition... Oct 9 00:42:24.071485 systemd[1]: Started dbus.service - D-Bus System Message Bus. Oct 9 00:42:24.075212 systemd[1]: Finished lvm2-activation.service - Activation of LVM2 logical volumes. Oct 9 00:42:24.080432 jq[1412]: true Oct 9 00:42:24.080700 systemd[1]: enable-oem-cloudinit.service: Skipped due to 'exec-condition'. Oct 9 00:42:24.081015 systemd[1]: Condition check resulted in enable-oem-cloudinit.service - Enable cloudinit being skipped. Oct 9 00:42:24.081365 systemd[1]: extend-filesystems.service: Deactivated successfully. Oct 9 00:42:24.081511 systemd[1]: Finished extend-filesystems.service - Extend Filesystems. Oct 9 00:42:24.082945 systemd[1]: motdgen.service: Deactivated successfully. Oct 9 00:42:24.083115 systemd[1]: Finished motdgen.service - Generate /run/flatcar/motd. Oct 9 00:42:24.084416 systemd[1]: ssh-key-proc-cmdline.service: Deactivated successfully. Oct 9 00:42:24.084549 systemd[1]: Finished ssh-key-proc-cmdline.service - Install an ssh key from /proc/cmdline. Oct 9 00:42:24.095254 jq[1419]: false Oct 9 00:42:24.105302 (ntainerd)[1420]: containerd.service: Referenced but unset environment variable evaluates to an empty string: TORCX_IMAGEDIR, TORCX_UNPACKDIR Oct 9 00:42:24.105921 systemd[1]: Finished sshd-keygen.service - Generate sshd host keys. Oct 9 00:42:24.107102 systemd[1]: update-ssh-keys-after-ignition.service: Skipped due to 'exec-condition'. Oct 9 00:42:24.107253 systemd[1]: Condition check resulted in update-ssh-keys-after-ignition.service - Run update-ssh-keys once after Ignition being skipped. Oct 9 00:42:24.111032 systemd[1]: Starting issuegen.service - Generate /run/issue... Oct 9 00:42:24.111914 systemd[1]: sshkeys.service was skipped because no trigger condition checks were met. Oct 9 00:42:24.112151 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 9 00:42:24.112180 systemd[1]: Reached target system-config.target - Load system-provided cloud configs. Oct 9 00:42:24.113313 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 9 00:42:24.113340 systemd[1]: Reached target user-config.target - Load user-provided cloud configs. Oct 9 00:42:24.116020 systemd-logind[1407]: Watching system buttons on /dev/input/event0 (Power Button) Oct 9 00:42:24.118053 systemd-logind[1407]: New seat seat0. Oct 9 00:42:24.127298 systemd[1]: Started systemd-logind.service - User Login Management. Oct 9 00:42:24.150452 systemd[1]: issuegen.service: Deactivated successfully. Oct 9 00:42:24.150673 systemd[1]: Finished issuegen.service - Generate /run/issue. Oct 9 00:42:24.154209 update_engine[1410]: I20241009 00:42:24.151579 1410 main.cc:92] Flatcar Update Engine starting Oct 9 00:42:24.153493 systemd[1]: Starting systemd-user-sessions.service - Permit User Sessions... Oct 9 00:42:24.156447 systemd[1]: Started update-engine.service - Update Engine. Oct 9 00:42:24.157360 update_engine[1410]: I20241009 00:42:24.156488 1410 update_check_scheduler.cc:74] Next update check in 7m43s Oct 9 00:42:24.158527 systemd[1]: Started locksmithd.service - Cluster reboot manager. Oct 9 00:42:24.166521 systemd[1]: Finished systemd-user-sessions.service - Permit User Sessions. Oct 9 00:42:24.174486 systemd[1]: Started getty@tty1.service - Getty on tty1. Oct 9 00:42:24.187827 systemd[1]: Started serial-getty@ttyAMA0.service - Serial Getty on ttyAMA0. Oct 9 00:42:24.188956 systemd[1]: Reached target getty.target - Login Prompts. Oct 9 00:42:24.204702 locksmithd[1439]: locksmithd starting currentOperation="UPDATE_STATUS_IDLE" strategy="reboot" Oct 9 00:42:24.308024 containerd[1420]: time="2024-10-09T00:42:24.307878240Z" level=info msg="starting containerd" revision=b2ce781edcbd6cb758f172ecab61c79d607cc41d version=v1.7.22 Oct 9 00:42:24.330505 containerd[1420]: time="2024-10-09T00:42:24.330457720Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.aufs\"..." type=io.containerd.snapshotter.v1 Oct 9 00:42:24.331788 containerd[1420]: time="2024-10-09T00:42:24.331747280Z" 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 9 00:42:24.331788 containerd[1420]: time="2024-10-09T00:42:24.331782240Z" level=info msg="loading plugin \"io.containerd.event.v1.exchange\"..." type=io.containerd.event.v1 Oct 9 00:42:24.331843 containerd[1420]: time="2024-10-09T00:42:24.331798600Z" level=info msg="loading plugin \"io.containerd.internal.v1.opt\"..." type=io.containerd.internal.v1 Oct 9 00:42:24.332084 containerd[1420]: time="2024-10-09T00:42:24.332057720Z" level=info msg="loading plugin \"io.containerd.warning.v1.deprecations\"..." type=io.containerd.warning.v1 Oct 9 00:42:24.332128 containerd[1420]: time="2024-10-09T00:42:24.332085320Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.blockfile\"..." type=io.containerd.snapshotter.v1 Oct 9 00:42:24.332312 containerd[1420]: time="2024-10-09T00:42:24.332289440Z" level=info msg="skip loading plugin \"io.containerd.snapshotter.v1.blockfile\"..." error="no scratch file generator: skip plugin" type=io.containerd.snapshotter.v1 Oct 9 00:42:24.332340 containerd[1420]: time="2024-10-09T00:42:24.332316000Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.btrfs\"..." type=io.containerd.snapshotter.v1 Oct 9 00:42:24.332487 containerd[1420]: time="2024-10-09T00:42:24.332460240Z" 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 9 00:42:24.332487 containerd[1420]: time="2024-10-09T00:42:24.332479960Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.devmapper\"..." type=io.containerd.snapshotter.v1 Oct 9 00:42:24.332527 containerd[1420]: time="2024-10-09T00:42:24.332493120Z" level=info msg="skip loading plugin \"io.containerd.snapshotter.v1.devmapper\"..." error="devmapper not configured: skip plugin" type=io.containerd.snapshotter.v1 Oct 9 00:42:24.332527 containerd[1420]: time="2024-10-09T00:42:24.332503120Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.native\"..." type=io.containerd.snapshotter.v1 Oct 9 00:42:24.335965 containerd[1420]: time="2024-10-09T00:42:24.335930760Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.overlayfs\"..." type=io.containerd.snapshotter.v1 Oct 9 00:42:24.336253 containerd[1420]: time="2024-10-09T00:42:24.336224520Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.zfs\"..." type=io.containerd.snapshotter.v1 Oct 9 00:42:24.336358 containerd[1420]: time="2024-10-09T00:42:24.336334560Z" 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 9 00:42:24.336358 containerd[1420]: time="2024-10-09T00:42:24.336352200Z" level=info msg="loading plugin \"io.containerd.content.v1.content\"..." type=io.containerd.content.v1 Oct 9 00:42:24.336545 containerd[1420]: time="2024-10-09T00:42:24.336526280Z" level=info msg="loading plugin \"io.containerd.metadata.v1.bolt\"..." type=io.containerd.metadata.v1 Oct 9 00:42:24.336572 containerd[1420]: time="2024-10-09T00:42:24.336563920Z" level=info msg="metadata content store policy set" policy=shared Oct 9 00:42:24.337391 containerd[1420]: time="2024-10-09T00:42:24.337370560Z" level=info msg="loading plugin \"io.containerd.gc.v1.scheduler\"..." type=io.containerd.gc.v1 Oct 9 00:42:24.337428 containerd[1420]: time="2024-10-09T00:42:24.337413560Z" level=info msg="loading plugin \"io.containerd.differ.v1.walking\"..." type=io.containerd.differ.v1 Oct 9 00:42:24.337460 containerd[1420]: time="2024-10-09T00:42:24.337427560Z" level=info msg="loading plugin \"io.containerd.lease.v1.manager\"..." type=io.containerd.lease.v1 Oct 9 00:42:24.337460 containerd[1420]: time="2024-10-09T00:42:24.337442720Z" level=info msg="loading plugin \"io.containerd.streaming.v1.manager\"..." type=io.containerd.streaming.v1 Oct 9 00:42:24.337460 containerd[1420]: time="2024-10-09T00:42:24.337455480Z" level=info msg="loading plugin \"io.containerd.runtime.v1.linux\"..." type=io.containerd.runtime.v1 Oct 9 00:42:24.337555 containerd[1420]: time="2024-10-09T00:42:24.337541000Z" level=info msg="loading plugin \"io.containerd.monitor.v1.cgroups\"..." type=io.containerd.monitor.v1 Oct 9 00:42:24.337780 containerd[1420]: time="2024-10-09T00:42:24.337756840Z" level=info msg="loading plugin \"io.containerd.runtime.v2.task\"..." type=io.containerd.runtime.v2 Oct 9 00:42:24.337851 containerd[1420]: time="2024-10-09T00:42:24.337835240Z" level=info msg="loading plugin \"io.containerd.runtime.v2.shim\"..." type=io.containerd.runtime.v2 Oct 9 00:42:24.337875 containerd[1420]: time="2024-10-09T00:42:24.337854160Z" level=info msg="loading plugin \"io.containerd.sandbox.store.v1.local\"..." type=io.containerd.sandbox.store.v1 Oct 9 00:42:24.337901 containerd[1420]: time="2024-10-09T00:42:24.337877040Z" level=info msg="loading plugin \"io.containerd.sandbox.controller.v1.local\"..." type=io.containerd.sandbox.controller.v1 Oct 9 00:42:24.337901 containerd[1420]: time="2024-10-09T00:42:24.337890640Z" level=info msg="loading plugin \"io.containerd.service.v1.containers-service\"..." type=io.containerd.service.v1 Oct 9 00:42:24.337935 containerd[1420]: time="2024-10-09T00:42:24.337902600Z" level=info msg="loading plugin \"io.containerd.service.v1.content-service\"..." type=io.containerd.service.v1 Oct 9 00:42:24.337935 containerd[1420]: time="2024-10-09T00:42:24.337914040Z" level=info msg="loading plugin \"io.containerd.service.v1.diff-service\"..." type=io.containerd.service.v1 Oct 9 00:42:24.337935 containerd[1420]: time="2024-10-09T00:42:24.337926840Z" level=info msg="loading plugin \"io.containerd.service.v1.images-service\"..." type=io.containerd.service.v1 Oct 9 00:42:24.337992 containerd[1420]: time="2024-10-09T00:42:24.337940480Z" level=info msg="loading plugin \"io.containerd.service.v1.introspection-service\"..." type=io.containerd.service.v1 Oct 9 00:42:24.337992 containerd[1420]: time="2024-10-09T00:42:24.337970240Z" level=info msg="loading plugin \"io.containerd.service.v1.namespaces-service\"..." type=io.containerd.service.v1 Oct 9 00:42:24.337992 containerd[1420]: time="2024-10-09T00:42:24.337984400Z" level=info msg="loading plugin \"io.containerd.service.v1.snapshots-service\"..." type=io.containerd.service.v1 Oct 9 00:42:24.338047 containerd[1420]: time="2024-10-09T00:42:24.337994520Z" level=info msg="loading plugin \"io.containerd.service.v1.tasks-service\"..." type=io.containerd.service.v1 Oct 9 00:42:24.338047 containerd[1420]: time="2024-10-09T00:42:24.338014560Z" level=info msg="loading plugin \"io.containerd.grpc.v1.containers\"..." type=io.containerd.grpc.v1 Oct 9 00:42:24.338047 containerd[1420]: time="2024-10-09T00:42:24.338027440Z" level=info msg="loading plugin \"io.containerd.grpc.v1.content\"..." type=io.containerd.grpc.v1 Oct 9 00:42:24.338047 containerd[1420]: time="2024-10-09T00:42:24.338039840Z" level=info msg="loading plugin \"io.containerd.grpc.v1.diff\"..." type=io.containerd.grpc.v1 Oct 9 00:42:24.338116 containerd[1420]: time="2024-10-09T00:42:24.338052600Z" level=info msg="loading plugin \"io.containerd.grpc.v1.events\"..." type=io.containerd.grpc.v1 Oct 9 00:42:24.338116 containerd[1420]: time="2024-10-09T00:42:24.338064480Z" level=info msg="loading plugin \"io.containerd.grpc.v1.images\"..." type=io.containerd.grpc.v1 Oct 9 00:42:24.338116 containerd[1420]: time="2024-10-09T00:42:24.338076360Z" level=info msg="loading plugin \"io.containerd.grpc.v1.introspection\"..." type=io.containerd.grpc.v1 Oct 9 00:42:24.338116 containerd[1420]: time="2024-10-09T00:42:24.338087840Z" level=info msg="loading plugin \"io.containerd.grpc.v1.leases\"..." type=io.containerd.grpc.v1 Oct 9 00:42:24.338116 containerd[1420]: time="2024-10-09T00:42:24.338100600Z" level=info msg="loading plugin \"io.containerd.grpc.v1.namespaces\"..." type=io.containerd.grpc.v1 Oct 9 00:42:24.338116 containerd[1420]: time="2024-10-09T00:42:24.338112480Z" level=info msg="loading plugin \"io.containerd.grpc.v1.sandbox-controllers\"..." type=io.containerd.grpc.v1 Oct 9 00:42:24.338212 containerd[1420]: time="2024-10-09T00:42:24.338126960Z" level=info msg="loading plugin \"io.containerd.grpc.v1.sandboxes\"..." type=io.containerd.grpc.v1 Oct 9 00:42:24.338212 containerd[1420]: time="2024-10-09T00:42:24.338138400Z" level=info msg="loading plugin \"io.containerd.grpc.v1.snapshots\"..." type=io.containerd.grpc.v1 Oct 9 00:42:24.338212 containerd[1420]: time="2024-10-09T00:42:24.338151200Z" level=info msg="loading plugin \"io.containerd.grpc.v1.streaming\"..." type=io.containerd.grpc.v1 Oct 9 00:42:24.338212 containerd[1420]: time="2024-10-09T00:42:24.338162720Z" level=info msg="loading plugin \"io.containerd.grpc.v1.tasks\"..." type=io.containerd.grpc.v1 Oct 9 00:42:24.338212 containerd[1420]: time="2024-10-09T00:42:24.338185200Z" level=info msg="loading plugin \"io.containerd.transfer.v1.local\"..." type=io.containerd.transfer.v1 Oct 9 00:42:24.338212 containerd[1420]: time="2024-10-09T00:42:24.338206120Z" level=info msg="loading plugin \"io.containerd.grpc.v1.transfer\"..." type=io.containerd.grpc.v1 Oct 9 00:42:24.338346 containerd[1420]: time="2024-10-09T00:42:24.338219720Z" level=info msg="loading plugin \"io.containerd.grpc.v1.version\"..." type=io.containerd.grpc.v1 Oct 9 00:42:24.338346 containerd[1420]: time="2024-10-09T00:42:24.338230240Z" level=info msg="loading plugin \"io.containerd.internal.v1.restart\"..." type=io.containerd.internal.v1 Oct 9 00:42:24.338388 containerd[1420]: time="2024-10-09T00:42:24.338366720Z" level=info msg="loading plugin \"io.containerd.tracing.processor.v1.otlp\"..." type=io.containerd.tracing.processor.v1 Oct 9 00:42:24.338388 containerd[1420]: time="2024-10-09T00:42:24.338382920Z" 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 9 00:42:24.338427 containerd[1420]: time="2024-10-09T00:42:24.338406200Z" level=info msg="loading plugin \"io.containerd.internal.v1.tracing\"..." type=io.containerd.internal.v1 Oct 9 00:42:24.338427 containerd[1420]: time="2024-10-09T00:42:24.338419240Z" level=info msg="skip loading plugin \"io.containerd.internal.v1.tracing\"..." error="skip plugin: tracing endpoint not configured" type=io.containerd.internal.v1 Oct 9 00:42:24.338461 containerd[1420]: time="2024-10-09T00:42:24.338429440Z" level=info msg="loading plugin \"io.containerd.grpc.v1.healthcheck\"..." type=io.containerd.grpc.v1 Oct 9 00:42:24.338461 containerd[1420]: time="2024-10-09T00:42:24.338442080Z" level=info msg="loading plugin \"io.containerd.nri.v1.nri\"..." type=io.containerd.nri.v1 Oct 9 00:42:24.338461 containerd[1420]: time="2024-10-09T00:42:24.338451120Z" level=info msg="NRI interface is disabled by configuration." Oct 9 00:42:24.338511 containerd[1420]: time="2024-10-09T00:42:24.338460760Z" level=info msg="loading plugin \"io.containerd.grpc.v1.cri\"..." type=io.containerd.grpc.v1 Oct 9 00:42:24.338819 containerd[1420]: time="2024-10-09T00:42:24.338764760Z" 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 9 00:42:24.338819 containerd[1420]: time="2024-10-09T00:42:24.338823280Z" level=info msg="Connect containerd service" Oct 9 00:42:24.338962 containerd[1420]: time="2024-10-09T00:42:24.338848800Z" level=info msg="using legacy CRI server" Oct 9 00:42:24.338962 containerd[1420]: time="2024-10-09T00:42:24.338855040Z" level=info msg="using experimental NRI integration - disable nri plugin to prevent this" Oct 9 00:42:24.338962 containerd[1420]: time="2024-10-09T00:42:24.338929160Z" level=info msg="Get image filesystem path \"/var/lib/containerd/io.containerd.snapshotter.v1.overlayfs\"" Oct 9 00:42:24.341980 containerd[1420]: time="2024-10-09T00:42:24.341926880Z" 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 9 00:42:24.342107 containerd[1420]: time="2024-10-09T00:42:24.342063760Z" level=info msg="Start subscribing containerd event" Oct 9 00:42:24.342134 containerd[1420]: time="2024-10-09T00:42:24.342113840Z" level=info msg="Start recovering state" Oct 9 00:42:24.342196 containerd[1420]: time="2024-10-09T00:42:24.342177800Z" level=info msg="Start event monitor" Oct 9 00:42:24.342218 containerd[1420]: time="2024-10-09T00:42:24.342200200Z" level=info msg="Start snapshots syncer" Oct 9 00:42:24.342218 containerd[1420]: time="2024-10-09T00:42:24.342212400Z" level=info msg="Start cni network conf syncer for default" Oct 9 00:42:24.342270 containerd[1420]: time="2024-10-09T00:42:24.342220160Z" level=info msg="Start streaming server" Oct 9 00:42:24.342484 containerd[1420]: time="2024-10-09T00:42:24.342456440Z" level=info msg=serving... address=/run/containerd/containerd.sock.ttrpc Oct 9 00:42:24.342522 containerd[1420]: time="2024-10-09T00:42:24.342509880Z" level=info msg=serving... address=/run/containerd/containerd.sock Oct 9 00:42:24.342573 containerd[1420]: time="2024-10-09T00:42:24.342562600Z" level=info msg="containerd successfully booted in 0.035570s" Oct 9 00:42:24.342662 systemd[1]: Started containerd.service - containerd container runtime. Oct 9 00:42:24.880906 systemd[1]: Created slice system-sshd.slice - Slice /system/sshd. Oct 9 00:42:24.882832 systemd[1]: Started sshd@0-10.0.0.31:22-10.0.0.1:45876.service - OpenSSH per-connection server daemon (10.0.0.1:45876). Oct 9 00:42:24.934152 sshd[1457]: Accepted publickey for core from 10.0.0.1 port 45876 ssh2: RSA SHA256:nRWADPtu01909VH1n4/VEkamAOeuD1sYuu1knWF4jhs Oct 9 00:42:24.935784 sshd[1457]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Oct 9 00:42:24.943843 systemd-logind[1407]: New session 1 of user core. Oct 9 00:42:24.944813 systemd[1]: Created slice user-500.slice - User Slice of UID 500. Oct 9 00:42:24.957171 systemd[1]: Starting user-runtime-dir@500.service - User Runtime Directory /run/user/500... Oct 9 00:42:24.967622 systemd[1]: Finished user-runtime-dir@500.service - User Runtime Directory /run/user/500. Oct 9 00:42:24.978189 systemd[1]: Starting user@500.service - User Manager for UID 500... Oct 9 00:42:24.983080 (systemd)[1461]: pam_unix(systemd-user:session): session opened for user core(uid=500) by (uid=0) Oct 9 00:42:25.057773 systemd[1461]: Queued start job for default target default.target. Oct 9 00:42:25.066855 systemd[1461]: Created slice app.slice - User Application Slice. Oct 9 00:42:25.066884 systemd[1461]: Reached target paths.target - Paths. Oct 9 00:42:25.066896 systemd[1461]: Reached target timers.target - Timers. Oct 9 00:42:25.068105 systemd[1461]: Starting dbus.socket - D-Bus User Message Bus Socket... Oct 9 00:42:25.077532 systemd[1461]: Listening on dbus.socket - D-Bus User Message Bus Socket. Oct 9 00:42:25.077591 systemd[1461]: Reached target sockets.target - Sockets. Oct 9 00:42:25.077603 systemd[1461]: Reached target basic.target - Basic System. Oct 9 00:42:25.077636 systemd[1461]: Reached target default.target - Main User Target. Oct 9 00:42:25.077661 systemd[1461]: Startup finished in 89ms. Oct 9 00:42:25.078035 systemd[1]: Started user@500.service - User Manager for UID 500. Oct 9 00:42:25.079942 systemd[1]: Started session-1.scope - Session 1 of User core. Oct 9 00:42:25.140653 systemd[1]: Started sshd@1-10.0.0.31:22-10.0.0.1:55742.service - OpenSSH per-connection server daemon (10.0.0.1:55742). Oct 9 00:42:25.179644 sshd[1472]: Accepted publickey for core from 10.0.0.1 port 55742 ssh2: RSA SHA256:nRWADPtu01909VH1n4/VEkamAOeuD1sYuu1knWF4jhs Oct 9 00:42:25.180837 sshd[1472]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Oct 9 00:42:25.184750 systemd-logind[1407]: New session 2 of user core. Oct 9 00:42:25.198100 systemd[1]: Started session-2.scope - Session 2 of User core. Oct 9 00:42:25.249924 sshd[1472]: pam_unix(sshd:session): session closed for user core Oct 9 00:42:25.262108 systemd[1]: sshd@1-10.0.0.31:22-10.0.0.1:55742.service: Deactivated successfully. Oct 9 00:42:25.263336 systemd[1]: session-2.scope: Deactivated successfully. Oct 9 00:42:25.265116 systemd-logind[1407]: Session 2 logged out. Waiting for processes to exit. Oct 9 00:42:25.271365 systemd[1]: Started sshd@2-10.0.0.31:22-10.0.0.1:55754.service - OpenSSH per-connection server daemon (10.0.0.1:55754). Oct 9 00:42:25.273372 systemd-logind[1407]: Removed session 2. Oct 9 00:42:25.305341 sshd[1479]: Accepted publickey for core from 10.0.0.1 port 55754 ssh2: RSA SHA256:nRWADPtu01909VH1n4/VEkamAOeuD1sYuu1knWF4jhs Oct 9 00:42:25.306625 sshd[1479]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Oct 9 00:42:25.310265 systemd-logind[1407]: New session 3 of user core. Oct 9 00:42:25.322123 systemd[1]: Started session-3.scope - Session 3 of User core. Oct 9 00:42:25.374288 sshd[1479]: pam_unix(sshd:session): session closed for user core Oct 9 00:42:25.377371 systemd[1]: sshd@2-10.0.0.31:22-10.0.0.1:55754.service: Deactivated successfully. Oct 9 00:42:25.378890 systemd[1]: session-3.scope: Deactivated successfully. Oct 9 00:42:25.379426 systemd-logind[1407]: Session 3 logged out. Waiting for processes to exit. Oct 9 00:42:25.380208 systemd-logind[1407]: Removed session 3. Oct 9 00:42:25.545165 systemd-networkd[1356]: eth0: Gained IPv6LL Oct 9 00:42:25.545813 systemd-timesyncd[1342]: Network configuration changed, trying to establish connection. Oct 9 00:42:25.547262 systemd[1]: Finished systemd-networkd-wait-online.service - Wait for Network to be Configured. Oct 9 00:42:25.549200 systemd[1]: Reached target network-online.target - Network is Online. Oct 9 00:42:25.557245 systemd[1]: Starting coreos-metadata.service - QEMU metadata agent... Oct 9 00:42:25.559015 systemd[1]: Starting nvidia.service - NVIDIA Configure Service... Oct 9 00:42:25.572691 systemd[1]: coreos-metadata.service: Deactivated successfully. Oct 9 00:42:25.572885 systemd[1]: Finished coreos-metadata.service - QEMU metadata agent. Oct 9 00:42:25.574320 systemd[1]: packet-phone-home.service - Report Success to Packet was skipped because of an unmet condition check (ConditionFirstBoot=true). Oct 9 00:42:25.581036 systemd[1]: Finished nvidia.service - NVIDIA Configure Service. Oct 9 00:42:25.582185 systemd[1]: Reached target multi-user.target - Multi-User System. Oct 9 00:42:25.582987 systemd[1]: cryptenroll-helper-first.service was skipped because of an unmet condition check (ConditionFirstBoot=true). Oct 9 00:42:25.583400 systemd[1]: Startup finished in 525ms (kernel) + 2.081s (initrd) + 2.838s (userspace) = 5.445s. Oct 9 00:42:27.048179 systemd-timesyncd[1342]: Network configuration changed, trying to establish connection. Oct 9 00:42:28.809572 systemd-timesyncd[1342]: Network configuration changed, trying to establish connection. Oct 9 00:42:35.383870 systemd[1]: Started sshd@3-10.0.0.31:22-10.0.0.1:54328.service - OpenSSH per-connection server daemon (10.0.0.1:54328). Oct 9 00:42:35.419936 sshd[1506]: Accepted publickey for core from 10.0.0.1 port 54328 ssh2: RSA SHA256:nRWADPtu01909VH1n4/VEkamAOeuD1sYuu1knWF4jhs Oct 9 00:42:35.421105 sshd[1506]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Oct 9 00:42:35.424621 systemd-logind[1407]: New session 4 of user core. Oct 9 00:42:35.434157 systemd[1]: Started session-4.scope - Session 4 of User core. Oct 9 00:42:35.484762 sshd[1506]: pam_unix(sshd:session): session closed for user core Oct 9 00:42:35.502131 systemd[1]: sshd@3-10.0.0.31:22-10.0.0.1:54328.service: Deactivated successfully. Oct 9 00:42:35.503471 systemd[1]: session-4.scope: Deactivated successfully. Oct 9 00:42:35.506067 systemd-logind[1407]: Session 4 logged out. Waiting for processes to exit. Oct 9 00:42:35.507170 systemd[1]: Started sshd@4-10.0.0.31:22-10.0.0.1:54342.service - OpenSSH per-connection server daemon (10.0.0.1:54342). Oct 9 00:42:35.507847 systemd-logind[1407]: Removed session 4. Oct 9 00:42:35.544883 sshd[1513]: Accepted publickey for core from 10.0.0.1 port 54342 ssh2: RSA SHA256:nRWADPtu01909VH1n4/VEkamAOeuD1sYuu1knWF4jhs Oct 9 00:42:35.546172 sshd[1513]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Oct 9 00:42:35.550262 systemd-logind[1407]: New session 5 of user core. Oct 9 00:42:35.563140 systemd[1]: Started session-5.scope - Session 5 of User core. Oct 9 00:42:35.610463 sshd[1513]: pam_unix(sshd:session): session closed for user core Oct 9 00:42:35.623043 systemd[1]: sshd@4-10.0.0.31:22-10.0.0.1:54342.service: Deactivated successfully. Oct 9 00:42:35.624215 systemd[1]: session-5.scope: Deactivated successfully. Oct 9 00:42:35.625933 systemd-logind[1407]: Session 5 logged out. Waiting for processes to exit. Oct 9 00:42:35.626994 systemd[1]: Started sshd@5-10.0.0.31:22-10.0.0.1:54350.service - OpenSSH per-connection server daemon (10.0.0.1:54350). Oct 9 00:42:35.627673 systemd-logind[1407]: Removed session 5. Oct 9 00:42:35.663327 sshd[1520]: Accepted publickey for core from 10.0.0.1 port 54350 ssh2: RSA SHA256:nRWADPtu01909VH1n4/VEkamAOeuD1sYuu1knWF4jhs Oct 9 00:42:35.664363 sshd[1520]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Oct 9 00:42:35.667944 systemd-logind[1407]: New session 6 of user core. Oct 9 00:42:35.674078 systemd[1]: Started session-6.scope - Session 6 of User core. Oct 9 00:42:35.724846 sshd[1520]: pam_unix(sshd:session): session closed for user core Oct 9 00:42:35.736273 systemd[1]: sshd@5-10.0.0.31:22-10.0.0.1:54350.service: Deactivated successfully. Oct 9 00:42:35.737688 systemd[1]: session-6.scope: Deactivated successfully. Oct 9 00:42:35.738880 systemd-logind[1407]: Session 6 logged out. Waiting for processes to exit. Oct 9 00:42:35.740027 systemd[1]: Started sshd@6-10.0.0.31:22-10.0.0.1:54366.service - OpenSSH per-connection server daemon (10.0.0.1:54366). Oct 9 00:42:35.742024 systemd-logind[1407]: Removed session 6. Oct 9 00:42:35.776770 sshd[1527]: Accepted publickey for core from 10.0.0.1 port 54366 ssh2: RSA SHA256:nRWADPtu01909VH1n4/VEkamAOeuD1sYuu1knWF4jhs Oct 9 00:42:35.778087 sshd[1527]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Oct 9 00:42:35.781998 systemd-logind[1407]: New session 7 of user core. Oct 9 00:42:35.791151 systemd[1]: Started session-7.scope - Session 7 of User core. Oct 9 00:42:35.855989 sudo[1530]: core : PWD=/home/core ; USER=root ; COMMAND=/usr/sbin/setenforce 1 Oct 9 00:42:35.856254 sudo[1530]: pam_unix(sudo:session): session opened for user root(uid=0) by core(uid=500) Oct 9 00:42:35.860976 kernel: audit: type=1404 audit(1728434555.858:3): enforcing=1 old_enforcing=0 auid=500 ses=7 enabled=1 old-enabled=1 lsm=selinux res=1 Oct 9 00:42:35.871732 sudo[1530]: pam_unix(sudo:session): session closed for user root Oct 9 00:42:35.873304 sshd[1527]: pam_unix(sshd:session): session closed for user core Oct 9 00:42:35.886206 systemd[1]: sshd@6-10.0.0.31:22-10.0.0.1:54366.service: Deactivated successfully. Oct 9 00:42:35.887636 systemd[1]: session-7.scope: Deactivated successfully. Oct 9 00:42:35.888897 systemd-logind[1407]: Session 7 logged out. Waiting for processes to exit. Oct 9 00:42:35.900306 systemd[1]: Started sshd@7-10.0.0.31:22-10.0.0.1:54376.service - OpenSSH per-connection server daemon (10.0.0.1:54376). Oct 9 00:42:35.901335 systemd-logind[1407]: Removed session 7. Oct 9 00:42:35.935801 sshd[1535]: Accepted publickey for core from 10.0.0.1 port 54376 ssh2: RSA SHA256:nRWADPtu01909VH1n4/VEkamAOeuD1sYuu1knWF4jhs Oct 9 00:42:35.937122 sshd[1535]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Oct 9 00:42:35.942256 systemd-logind[1407]: New session 8 of user core. Oct 9 00:42:35.955156 systemd[1]: Started session-8.scope - Session 8 of User core. Oct 9 00:42:36.005295 sudo[1540]: core : PWD=/home/core ; USER=root ; COMMAND=/usr/sbin/rm -rf /etc/audit/rules.d/80-selinux.rules /etc/audit/rules.d/99-default.rules Oct 9 00:42:36.005572 sudo[1540]: pam_unix(sudo:session): session opened for user root(uid=0) by core(uid=500) Oct 9 00:42:36.008438 sudo[1540]: pam_unix(sudo:session): session closed for user root Oct 9 00:42:36.012733 sudo[1539]: core : PWD=/home/core ; USER=root ; COMMAND=/usr/sbin/systemctl restart audit-rules Oct 9 00:42:36.013240 sudo[1539]: pam_unix(sudo:session): session opened for user root(uid=0) by core(uid=500) Oct 9 00:42:36.030275 systemd[1]: Starting audit-rules.service - Load Audit Rules... Oct 9 00:42:36.039639 augenrules[1543]: /sbin/augenrules: No change Oct 9 00:42:36.044795 augenrules[1558]: No rules Oct 9 00:42:36.046023 systemd[1]: audit-rules.service: Deactivated successfully. Oct 9 00:42:36.046226 systemd[1]: Finished audit-rules.service - Load Audit Rules. Oct 9 00:42:36.047167 sudo[1539]: pam_unix(sudo:session): session closed for user root Oct 9 00:42:36.048588 sshd[1535]: pam_unix(sshd:session): session closed for user core Oct 9 00:42:36.065454 systemd[1]: sshd@7-10.0.0.31:22-10.0.0.1:54376.service: Deactivated successfully. Oct 9 00:42:36.067033 systemd[1]: session-8.scope: Deactivated successfully. Oct 9 00:42:36.068336 systemd-logind[1407]: Session 8 logged out. Waiting for processes to exit. Oct 9 00:42:36.069452 systemd[1]: Started sshd@8-10.0.0.31:22-10.0.0.1:54392.service - OpenSSH per-connection server daemon (10.0.0.1:54392). Oct 9 00:42:36.070160 systemd-logind[1407]: Removed session 8. Oct 9 00:42:36.105733 sshd[1566]: Accepted publickey for core from 10.0.0.1 port 54392 ssh2: RSA SHA256:nRWADPtu01909VH1n4/VEkamAOeuD1sYuu1knWF4jhs Oct 9 00:42:36.106976 sshd[1566]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Oct 9 00:42:36.110907 systemd-logind[1407]: New session 9 of user core. Oct 9 00:42:36.120997 systemd[1]: Started session-9.scope - Session 9 of User core. Oct 9 00:42:36.173194 sshd[1566]: pam_unix(sshd:session): session closed for user core Oct 9 00:42:36.184325 systemd[1]: sshd@8-10.0.0.31:22-10.0.0.1:54392.service: Deactivated successfully. Oct 9 00:42:36.185641 systemd[1]: session-9.scope: Deactivated successfully. Oct 9 00:42:36.188005 systemd-logind[1407]: Session 9 logged out. Waiting for processes to exit. Oct 9 00:42:36.198279 systemd[1]: Started sshd@9-10.0.0.31:22-10.0.0.1:54406.service - OpenSSH per-connection server daemon (10.0.0.1:54406). Oct 9 00:42:36.199136 systemd-logind[1407]: Removed session 9. Oct 9 00:42:36.230537 sshd[1573]: Accepted publickey for core from 10.0.0.1 port 54406 ssh2: RSA SHA256:nRWADPtu01909VH1n4/VEkamAOeuD1sYuu1knWF4jhs Oct 9 00:42:36.231744 sshd[1573]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Oct 9 00:42:36.235818 systemd-logind[1407]: New session 10 of user core. Oct 9 00:42:36.242113 systemd[1]: Started session-10.scope - Session 10 of User core. Oct 9 00:42:36.294027 sshd[1573]: pam_unix(sshd:session): session closed for user core Oct 9 00:42:36.297015 systemd[1]: sshd@9-10.0.0.31:22-10.0.0.1:54406.service: Deactivated successfully. Oct 9 00:42:36.299237 systemd[1]: session-10.scope: Deactivated successfully. Oct 9 00:42:36.299790 systemd-logind[1407]: Session 10 logged out. Waiting for processes to exit. Oct 9 00:42:36.300659 systemd-logind[1407]: Removed session 10.