Dec 13 01:38:07.914924 kernel: Booting Linux on physical CPU 0x0000000000 [0x413fd0c1] Dec 13 01:38:07.914946 kernel: Linux version 6.6.65-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 Thu Dec 12 23:24:21 -00 2024 Dec 13 01:38:07.914956 kernel: KASLR enabled Dec 13 01:38:07.914962 kernel: efi: EFI v2.7 by EDK II Dec 13 01:38:07.914967 kernel: efi: SMBIOS 3.0=0xdced0000 TPMFinalLog=0xd9760000 MEMATTR=0xdba62198 ACPI 2.0=0xd9700018 TPMEventLog=0xd9709098 RNG=0xd970e698 MEMRESERVE=0xd9b43e18 Dec 13 01:38:07.914973 kernel: random: crng init done Dec 13 01:38:07.914980 kernel: ACPI: Early table checksum verification disabled Dec 13 01:38:07.914985 kernel: ACPI: RSDP 0x00000000D9700018 000024 (v02 BOCHS ) Dec 13 01:38:07.914992 kernel: ACPI: XSDT 0x00000000D970FE98 00006C (v01 BOCHS BXPC 00000001 01000013) Dec 13 01:38:07.914999 kernel: ACPI: FACP 0x00000000D970FA98 000114 (v06 BOCHS BXPC 00000001 BXPC 00000001) Dec 13 01:38:07.915005 kernel: ACPI: DSDT 0x00000000D9707518 0014EB (v02 BOCHS BXPC 00000001 BXPC 00000001) Dec 13 01:38:07.915011 kernel: ACPI: APIC 0x00000000D970FC18 0001A8 (v04 BOCHS BXPC 00000001 BXPC 00000001) Dec 13 01:38:07.915017 kernel: ACPI: PPTT 0x00000000D970D898 00009C (v02 BOCHS BXPC 00000001 BXPC 00000001) Dec 13 01:38:07.915023 kernel: ACPI: GTDT 0x00000000D970E818 000060 (v02 BOCHS BXPC 00000001 BXPC 00000001) Dec 13 01:38:07.915030 kernel: ACPI: MCFG 0x00000000D970E918 00003C (v01 BOCHS BXPC 00000001 BXPC 00000001) Dec 13 01:38:07.915038 kernel: ACPI: SPCR 0x00000000D970FF98 000050 (v02 BOCHS BXPC 00000001 BXPC 00000001) Dec 13 01:38:07.915044 kernel: ACPI: DBG2 0x00000000D970E418 000057 (v00 BOCHS BXPC 00000001 BXPC 00000001) Dec 13 01:38:07.915050 kernel: ACPI: IORT 0x00000000D970E718 000080 (v03 BOCHS BXPC 00000001 BXPC 00000001) Dec 13 01:38:07.915057 kernel: ACPI: TPM2 0x00000000D970E498 00004C (v04 BOCHS BXPC 00000001 BXPC 00000001) Dec 13 01:38:07.915063 kernel: ACPI: SPCR: console: pl011,mmio,0x9000000,9600 Dec 13 01:38:07.915069 kernel: NUMA: Failed to initialise from firmware Dec 13 01:38:07.915075 kernel: NUMA: Faking a node at [mem 0x0000000040000000-0x00000000dcffffff] Dec 13 01:38:07.915081 kernel: NUMA: NODE_DATA [mem 0xdc958800-0xdc95dfff] Dec 13 01:38:07.915088 kernel: Zone ranges: Dec 13 01:38:07.915094 kernel: DMA [mem 0x0000000040000000-0x00000000dcffffff] Dec 13 01:38:07.915101 kernel: DMA32 empty Dec 13 01:38:07.915107 kernel: Normal empty Dec 13 01:38:07.915113 kernel: Movable zone start for each node Dec 13 01:38:07.915120 kernel: Early memory node ranges Dec 13 01:38:07.915126 kernel: node 0: [mem 0x0000000040000000-0x00000000d964ffff] Dec 13 01:38:07.915132 kernel: node 0: [mem 0x00000000d9650000-0x00000000d965ffff] Dec 13 01:38:07.915138 kernel: node 0: [mem 0x00000000d9660000-0x00000000d975ffff] Dec 13 01:38:07.915151 kernel: node 0: [mem 0x00000000d9760000-0x00000000d9b3ffff] Dec 13 01:38:07.915159 kernel: node 0: [mem 0x00000000d9b40000-0x00000000dce1ffff] Dec 13 01:38:07.915165 kernel: node 0: [mem 0x00000000dce20000-0x00000000dceaffff] Dec 13 01:38:07.915171 kernel: node 0: [mem 0x00000000dceb0000-0x00000000dcebffff] Dec 13 01:38:07.915178 kernel: node 0: [mem 0x00000000dcec0000-0x00000000dcfdffff] Dec 13 01:38:07.915186 kernel: node 0: [mem 0x00000000dcfe0000-0x00000000dcffffff] Dec 13 01:38:07.915192 kernel: Initmem setup node 0 [mem 0x0000000040000000-0x00000000dcffffff] Dec 13 01:38:07.915198 kernel: On node 0, zone DMA: 12288 pages in unavailable ranges Dec 13 01:38:07.915207 kernel: psci: probing for conduit method from ACPI. Dec 13 01:38:07.915214 kernel: psci: PSCIv1.1 detected in firmware. Dec 13 01:38:07.915221 kernel: psci: Using standard PSCI v0.2 function IDs Dec 13 01:38:07.915229 kernel: psci: Trusted OS migration not required Dec 13 01:38:07.915235 kernel: psci: SMC Calling Convention v1.1 Dec 13 01:38:07.915242 kernel: smccc: KVM: hypervisor services detected (0x00000000 0x00000000 0x00000000 0x00000003) Dec 13 01:38:07.915249 kernel: percpu: Embedded 31 pages/cpu s86696 r8192 d32088 u126976 Dec 13 01:38:07.915256 kernel: pcpu-alloc: s86696 r8192 d32088 u126976 alloc=31*4096 Dec 13 01:38:07.915262 kernel: pcpu-alloc: [0] 0 [0] 1 [0] 2 [0] 3 Dec 13 01:38:07.915269 kernel: Detected PIPT I-cache on CPU0 Dec 13 01:38:07.915276 kernel: CPU features: detected: GIC system register CPU interface Dec 13 01:38:07.915282 kernel: CPU features: detected: Hardware dirty bit management Dec 13 01:38:07.915289 kernel: CPU features: detected: Spectre-v4 Dec 13 01:38:07.915297 kernel: CPU features: detected: Spectre-BHB Dec 13 01:38:07.915304 kernel: CPU features: kernel page table isolation forced ON by KASLR Dec 13 01:38:07.915310 kernel: CPU features: detected: Kernel page table isolation (KPTI) Dec 13 01:38:07.915327 kernel: CPU features: detected: ARM erratum 1418040 Dec 13 01:38:07.915335 kernel: CPU features: detected: SSBS not fully self-synchronizing Dec 13 01:38:07.915342 kernel: alternatives: applying boot alternatives Dec 13 01:38:07.915350 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=9494f75a68cfbdce95d0d2f9b58d6d75bc38ee5b4e31dfc2a6da695ffafefba6 Dec 13 01:38:07.915357 kernel: Unknown kernel command line parameters "BOOT_IMAGE=/flatcar/vmlinuz-a", will be passed to user space. Dec 13 01:38:07.915363 kernel: Dentry cache hash table entries: 524288 (order: 10, 4194304 bytes, linear) Dec 13 01:38:07.915370 kernel: Inode-cache hash table entries: 262144 (order: 9, 2097152 bytes, linear) Dec 13 01:38:07.915377 kernel: Fallback order for Node 0: 0 Dec 13 01:38:07.915385 kernel: Built 1 zonelists, mobility grouping on. Total pages: 633024 Dec 13 01:38:07.915392 kernel: Policy zone: DMA Dec 13 01:38:07.915398 kernel: mem auto-init: stack:off, heap alloc:off, heap free:off Dec 13 01:38:07.915405 kernel: software IO TLB: area num 4. Dec 13 01:38:07.915412 kernel: software IO TLB: mapped [mem 0x00000000d2e00000-0x00000000d6e00000] (64MB) Dec 13 01:38:07.915419 kernel: Memory: 2386404K/2572288K available (10240K kernel code, 2184K rwdata, 8096K rodata, 39360K init, 897K bss, 185884K reserved, 0K cma-reserved) Dec 13 01:38:07.915426 kernel: SLUB: HWalign=64, Order=0-3, MinObjects=0, CPUs=4, Nodes=1 Dec 13 01:38:07.915432 kernel: trace event string verifier disabled Dec 13 01:38:07.915439 kernel: rcu: Preemptible hierarchical RCU implementation. Dec 13 01:38:07.915446 kernel: rcu: RCU event tracing is enabled. Dec 13 01:38:07.915453 kernel: rcu: RCU restricting CPUs from NR_CPUS=512 to nr_cpu_ids=4. Dec 13 01:38:07.915461 kernel: Trampoline variant of Tasks RCU enabled. Dec 13 01:38:07.915468 kernel: Tracing variant of Tasks RCU enabled. Dec 13 01:38:07.915475 kernel: rcu: RCU calculated value of scheduler-enlistment delay is 100 jiffies. Dec 13 01:38:07.915481 kernel: rcu: Adjusting geometry for rcu_fanout_leaf=16, nr_cpu_ids=4 Dec 13 01:38:07.915488 kernel: NR_IRQS: 64, nr_irqs: 64, preallocated irqs: 0 Dec 13 01:38:07.915495 kernel: GICv3: 256 SPIs implemented Dec 13 01:38:07.915501 kernel: GICv3: 0 Extended SPIs implemented Dec 13 01:38:07.915508 kernel: Root IRQ handler: gic_handle_irq Dec 13 01:38:07.915515 kernel: GICv3: GICv3 features: 16 PPIs, DirectLPI Dec 13 01:38:07.915521 kernel: GICv3: CPU0: found redistributor 0 region 0:0x00000000080a0000 Dec 13 01:38:07.915528 kernel: ITS [mem 0x08080000-0x0809ffff] Dec 13 01:38:07.915535 kernel: ITS@0x0000000008080000: allocated 8192 Devices @400c0000 (indirect, esz 8, psz 64K, shr 1) Dec 13 01:38:07.915543 kernel: ITS@0x0000000008080000: allocated 8192 Interrupt Collections @400d0000 (flat, esz 8, psz 64K, shr 1) Dec 13 01:38:07.915550 kernel: GICv3: using LPI property table @0x00000000400f0000 Dec 13 01:38:07.915557 kernel: GICv3: CPU0: using allocated LPI pending table @0x0000000040100000 Dec 13 01:38:07.915563 kernel: rcu: srcu_init: Setting srcu_struct sizes based on contention. Dec 13 01:38:07.915570 kernel: arch_timer: Enabling local workaround for ARM erratum 1418040 Dec 13 01:38:07.915577 kernel: arch_timer: cp15 timer(s) running at 25.00MHz (virt). Dec 13 01:38:07.915584 kernel: clocksource: arch_sys_counter: mask: 0xffffffffffffff max_cycles: 0x5c40939b5, max_idle_ns: 440795202646 ns Dec 13 01:38:07.915590 kernel: sched_clock: 56 bits at 25MHz, resolution 40ns, wraps every 4398046511100ns Dec 13 01:38:07.915597 kernel: arm-pv: using stolen time PV Dec 13 01:38:07.915604 kernel: Console: colour dummy device 80x25 Dec 13 01:38:07.915611 kernel: ACPI: Core revision 20230628 Dec 13 01:38:07.915619 kernel: Calibrating delay loop (skipped), value calculated using timer frequency.. 50.00 BogoMIPS (lpj=25000) Dec 13 01:38:07.915626 kernel: pid_max: default: 32768 minimum: 301 Dec 13 01:38:07.915633 kernel: LSM: initializing lsm=lockdown,capability,landlock,selinux,integrity Dec 13 01:38:07.915640 kernel: landlock: Up and running. Dec 13 01:38:07.915646 kernel: SELinux: Initializing. Dec 13 01:38:07.915653 kernel: Mount-cache hash table entries: 8192 (order: 4, 65536 bytes, linear) Dec 13 01:38:07.915660 kernel: Mountpoint-cache hash table entries: 8192 (order: 4, 65536 bytes, linear) Dec 13 01:38:07.915667 kernel: RCU Tasks: Setting shift to 2 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=4. Dec 13 01:38:07.915674 kernel: RCU Tasks Trace: Setting shift to 2 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=4. Dec 13 01:38:07.915682 kernel: rcu: Hierarchical SRCU implementation. Dec 13 01:38:07.915689 kernel: rcu: Max phase no-delay instances is 400. Dec 13 01:38:07.915695 kernel: Platform MSI: ITS@0x8080000 domain created Dec 13 01:38:07.915702 kernel: PCI/MSI: ITS@0x8080000 domain created Dec 13 01:38:07.915709 kernel: Remapping and enabling EFI services. Dec 13 01:38:07.915716 kernel: smp: Bringing up secondary CPUs ... Dec 13 01:38:07.915722 kernel: Detected PIPT I-cache on CPU1 Dec 13 01:38:07.915729 kernel: GICv3: CPU1: found redistributor 1 region 0:0x00000000080c0000 Dec 13 01:38:07.915736 kernel: GICv3: CPU1: using allocated LPI pending table @0x0000000040110000 Dec 13 01:38:07.915744 kernel: arch_timer: Enabling local workaround for ARM erratum 1418040 Dec 13 01:38:07.915752 kernel: CPU1: Booted secondary processor 0x0000000001 [0x413fd0c1] Dec 13 01:38:07.915763 kernel: Detected PIPT I-cache on CPU2 Dec 13 01:38:07.915771 kernel: GICv3: CPU2: found redistributor 2 region 0:0x00000000080e0000 Dec 13 01:38:07.915779 kernel: GICv3: CPU2: using allocated LPI pending table @0x0000000040120000 Dec 13 01:38:07.915786 kernel: arch_timer: Enabling local workaround for ARM erratum 1418040 Dec 13 01:38:07.915793 kernel: CPU2: Booted secondary processor 0x0000000002 [0x413fd0c1] Dec 13 01:38:07.915800 kernel: Detected PIPT I-cache on CPU3 Dec 13 01:38:07.915807 kernel: GICv3: CPU3: found redistributor 3 region 0:0x0000000008100000 Dec 13 01:38:07.915816 kernel: GICv3: CPU3: using allocated LPI pending table @0x0000000040130000 Dec 13 01:38:07.918082 kernel: arch_timer: Enabling local workaround for ARM erratum 1418040 Dec 13 01:38:07.918096 kernel: CPU3: Booted secondary processor 0x0000000003 [0x413fd0c1] Dec 13 01:38:07.918104 kernel: smp: Brought up 1 node, 4 CPUs Dec 13 01:38:07.918112 kernel: SMP: Total of 4 processors activated. Dec 13 01:38:07.918120 kernel: CPU features: detected: 32-bit EL0 Support Dec 13 01:38:07.918127 kernel: CPU features: detected: Data cache clean to the PoU not required for I/D coherence Dec 13 01:38:07.918142 kernel: CPU features: detected: Common not Private translations Dec 13 01:38:07.918166 kernel: CPU features: detected: CRC32 instructions Dec 13 01:38:07.918174 kernel: CPU features: detected: Enhanced Virtualization Traps Dec 13 01:38:07.918181 kernel: CPU features: detected: RCpc load-acquire (LDAPR) Dec 13 01:38:07.918188 kernel: CPU features: detected: LSE atomic instructions Dec 13 01:38:07.918196 kernel: CPU features: detected: Privileged Access Never Dec 13 01:38:07.918203 kernel: CPU features: detected: RAS Extension Support Dec 13 01:38:07.918210 kernel: CPU features: detected: Speculative Store Bypassing Safe (SSBS) Dec 13 01:38:07.918218 kernel: CPU: All CPU(s) started at EL1 Dec 13 01:38:07.918225 kernel: alternatives: applying system-wide alternatives Dec 13 01:38:07.918232 kernel: devtmpfs: initialized Dec 13 01:38:07.918241 kernel: clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1911260446275000 ns Dec 13 01:38:07.918249 kernel: futex hash table entries: 1024 (order: 4, 65536 bytes, linear) Dec 13 01:38:07.918256 kernel: pinctrl core: initialized pinctrl subsystem Dec 13 01:38:07.918263 kernel: SMBIOS 3.0.0 present. Dec 13 01:38:07.918270 kernel: DMI: QEMU KVM Virtual Machine, BIOS edk2-20230524-3.fc38 05/24/2023 Dec 13 01:38:07.918282 kernel: NET: Registered PF_NETLINK/PF_ROUTE protocol family Dec 13 01:38:07.918289 kernel: DMA: preallocated 512 KiB GFP_KERNEL pool for atomic allocations Dec 13 01:38:07.918297 kernel: DMA: preallocated 512 KiB GFP_KERNEL|GFP_DMA pool for atomic allocations Dec 13 01:38:07.918306 kernel: DMA: preallocated 512 KiB GFP_KERNEL|GFP_DMA32 pool for atomic allocations Dec 13 01:38:07.918313 kernel: audit: initializing netlink subsys (disabled) Dec 13 01:38:07.918333 kernel: audit: type=2000 audit(0.023:1): state=initialized audit_enabled=0 res=1 Dec 13 01:38:07.919921 kernel: thermal_sys: Registered thermal governor 'step_wise' Dec 13 01:38:07.919946 kernel: cpuidle: using governor menu Dec 13 01:38:07.919955 kernel: hw-breakpoint: found 6 breakpoint and 4 watchpoint registers. Dec 13 01:38:07.919962 kernel: ASID allocator initialised with 32768 entries Dec 13 01:38:07.919970 kernel: acpiphp: ACPI Hot Plug PCI Controller Driver version: 0.5 Dec 13 01:38:07.919977 kernel: Serial: AMBA PL011 UART driver Dec 13 01:38:07.919991 kernel: Modules: 2G module region forced by RANDOMIZE_MODULE_REGION_FULL Dec 13 01:38:07.919998 kernel: Modules: 0 pages in range for non-PLT usage Dec 13 01:38:07.920006 kernel: Modules: 509040 pages in range for PLT usage Dec 13 01:38:07.920013 kernel: HugeTLB: registered 1.00 GiB page size, pre-allocated 0 pages Dec 13 01:38:07.920020 kernel: HugeTLB: 0 KiB vmemmap can be freed for a 1.00 GiB page Dec 13 01:38:07.920028 kernel: HugeTLB: registered 32.0 MiB page size, pre-allocated 0 pages Dec 13 01:38:07.920035 kernel: HugeTLB: 0 KiB vmemmap can be freed for a 32.0 MiB page Dec 13 01:38:07.920042 kernel: HugeTLB: registered 2.00 MiB page size, pre-allocated 0 pages Dec 13 01:38:07.920049 kernel: HugeTLB: 0 KiB vmemmap can be freed for a 2.00 MiB page Dec 13 01:38:07.920057 kernel: HugeTLB: registered 64.0 KiB page size, pre-allocated 0 pages Dec 13 01:38:07.920066 kernel: HugeTLB: 0 KiB vmemmap can be freed for a 64.0 KiB page Dec 13 01:38:07.920073 kernel: ACPI: Added _OSI(Module Device) Dec 13 01:38:07.920080 kernel: ACPI: Added _OSI(Processor Device) Dec 13 01:38:07.920087 kernel: ACPI: Added _OSI(3.0 _SCP Extensions) Dec 13 01:38:07.920094 kernel: ACPI: Added _OSI(Processor Aggregator Device) Dec 13 01:38:07.920101 kernel: ACPI: 1 ACPI AML tables successfully acquired and loaded Dec 13 01:38:07.920109 kernel: ACPI: Interpreter enabled Dec 13 01:38:07.920116 kernel: ACPI: Using GIC for interrupt routing Dec 13 01:38:07.920123 kernel: ACPI: MCFG table detected, 1 entries Dec 13 01:38:07.920132 kernel: ARMH0011:00: ttyAMA0 at MMIO 0x9000000 (irq = 12, base_baud = 0) is a SBSA Dec 13 01:38:07.920139 kernel: printk: console [ttyAMA0] enabled Dec 13 01:38:07.920153 kernel: ACPI: PCI Root Bridge [PCI0] (domain 0000 [bus 00-ff]) Dec 13 01:38:07.920312 kernel: acpi PNP0A08:00: _OSC: OS supports [ExtendedConfig ASPM ClockPM Segments MSI HPX-Type3] Dec 13 01:38:07.920409 kernel: acpi PNP0A08:00: _OSC: platform does not support [LTR] Dec 13 01:38:07.920502 kernel: acpi PNP0A08:00: _OSC: OS now controls [PCIeHotplug PME AER PCIeCapability] Dec 13 01:38:07.920600 kernel: acpi PNP0A08:00: ECAM area [mem 0x4010000000-0x401fffffff] reserved by PNP0C02:00 Dec 13 01:38:07.920673 kernel: acpi PNP0A08:00: ECAM at [mem 0x4010000000-0x401fffffff] for [bus 00-ff] Dec 13 01:38:07.920683 kernel: ACPI: Remapped I/O 0x000000003eff0000 to [io 0x0000-0xffff window] Dec 13 01:38:07.920691 kernel: PCI host bridge to bus 0000:00 Dec 13 01:38:07.920761 kernel: pci_bus 0000:00: root bus resource [mem 0x10000000-0x3efeffff window] Dec 13 01:38:07.920843 kernel: pci_bus 0000:00: root bus resource [io 0x0000-0xffff window] Dec 13 01:38:07.920904 kernel: pci_bus 0000:00: root bus resource [mem 0x8000000000-0xffffffffff window] Dec 13 01:38:07.920965 kernel: pci_bus 0000:00: root bus resource [bus 00-ff] Dec 13 01:38:07.921064 kernel: pci 0000:00:00.0: [1b36:0008] type 00 class 0x060000 Dec 13 01:38:07.921141 kernel: pci 0000:00:01.0: [1af4:1005] type 00 class 0x00ff00 Dec 13 01:38:07.921226 kernel: pci 0000:00:01.0: reg 0x10: [io 0x0000-0x001f] Dec 13 01:38:07.921294 kernel: pci 0000:00:01.0: reg 0x14: [mem 0x10000000-0x10000fff] Dec 13 01:38:07.921413 kernel: pci 0000:00:01.0: reg 0x20: [mem 0x8000000000-0x8000003fff 64bit pref] Dec 13 01:38:07.921483 kernel: pci 0000:00:01.0: BAR 4: assigned [mem 0x8000000000-0x8000003fff 64bit pref] Dec 13 01:38:07.921549 kernel: pci 0000:00:01.0: BAR 1: assigned [mem 0x10000000-0x10000fff] Dec 13 01:38:07.921621 kernel: pci 0000:00:01.0: BAR 0: assigned [io 0x1000-0x101f] Dec 13 01:38:07.921683 kernel: pci_bus 0000:00: resource 4 [mem 0x10000000-0x3efeffff window] Dec 13 01:38:07.921741 kernel: pci_bus 0000:00: resource 5 [io 0x0000-0xffff window] Dec 13 01:38:07.921800 kernel: pci_bus 0000:00: resource 6 [mem 0x8000000000-0xffffffffff window] Dec 13 01:38:07.921810 kernel: ACPI: PCI: Interrupt link GSI0 configured for IRQ 35 Dec 13 01:38:07.921817 kernel: ACPI: PCI: Interrupt link GSI1 configured for IRQ 36 Dec 13 01:38:07.921824 kernel: ACPI: PCI: Interrupt link GSI2 configured for IRQ 37 Dec 13 01:38:07.921832 kernel: ACPI: PCI: Interrupt link GSI3 configured for IRQ 38 Dec 13 01:38:07.921841 kernel: iommu: Default domain type: Translated Dec 13 01:38:07.921848 kernel: iommu: DMA domain TLB invalidation policy: strict mode Dec 13 01:38:07.921856 kernel: efivars: Registered efivars operations Dec 13 01:38:07.921863 kernel: vgaarb: loaded Dec 13 01:38:07.921870 kernel: clocksource: Switched to clocksource arch_sys_counter Dec 13 01:38:07.921877 kernel: VFS: Disk quotas dquot_6.6.0 Dec 13 01:38:07.921885 kernel: VFS: Dquot-cache hash table entries: 512 (order 0, 4096 bytes) Dec 13 01:38:07.921892 kernel: pnp: PnP ACPI init Dec 13 01:38:07.921964 kernel: system 00:00: [mem 0x4010000000-0x401fffffff window] could not be reserved Dec 13 01:38:07.921976 kernel: pnp: PnP ACPI: found 1 devices Dec 13 01:38:07.921984 kernel: NET: Registered PF_INET protocol family Dec 13 01:38:07.921992 kernel: IP idents hash table entries: 65536 (order: 7, 524288 bytes, linear) Dec 13 01:38:07.921999 kernel: tcp_listen_portaddr_hash hash table entries: 2048 (order: 3, 32768 bytes, linear) Dec 13 01:38:07.922006 kernel: Table-perturb hash table entries: 65536 (order: 6, 262144 bytes, linear) Dec 13 01:38:07.922013 kernel: TCP established hash table entries: 32768 (order: 6, 262144 bytes, linear) Dec 13 01:38:07.922021 kernel: TCP bind hash table entries: 32768 (order: 8, 1048576 bytes, linear) Dec 13 01:38:07.922028 kernel: TCP: Hash tables configured (established 32768 bind 32768) Dec 13 01:38:07.922037 kernel: UDP hash table entries: 2048 (order: 4, 65536 bytes, linear) Dec 13 01:38:07.922044 kernel: UDP-Lite hash table entries: 2048 (order: 4, 65536 bytes, linear) Dec 13 01:38:07.922051 kernel: NET: Registered PF_UNIX/PF_LOCAL protocol family Dec 13 01:38:07.922058 kernel: PCI: CLS 0 bytes, default 64 Dec 13 01:38:07.922066 kernel: kvm [1]: HYP mode not available Dec 13 01:38:07.922073 kernel: Initialise system trusted keyrings Dec 13 01:38:07.922080 kernel: workingset: timestamp_bits=39 max_order=20 bucket_order=0 Dec 13 01:38:07.922087 kernel: Key type asymmetric registered Dec 13 01:38:07.922094 kernel: Asymmetric key parser 'x509' registered Dec 13 01:38:07.922103 kernel: Block layer SCSI generic (bsg) driver version 0.4 loaded (major 250) Dec 13 01:38:07.922110 kernel: io scheduler mq-deadline registered Dec 13 01:38:07.922117 kernel: io scheduler kyber registered Dec 13 01:38:07.922125 kernel: io scheduler bfq registered Dec 13 01:38:07.922132 kernel: input: Power Button as /devices/LNXSYSTM:00/LNXSYBUS:00/PNP0C0C:00/input/input0 Dec 13 01:38:07.922139 kernel: ACPI: button: Power Button [PWRB] Dec 13 01:38:07.922155 kernel: ACPI: \_SB_.PCI0.GSI1: Enabled at IRQ 36 Dec 13 01:38:07.922363 kernel: virtio-pci 0000:00:01.0: enabling device (0005 -> 0007) Dec 13 01:38:07.922382 kernel: Serial: 8250/16550 driver, 4 ports, IRQ sharing enabled Dec 13 01:38:07.922396 kernel: thunder_xcv, ver 1.0 Dec 13 01:38:07.922403 kernel: thunder_bgx, ver 1.0 Dec 13 01:38:07.922410 kernel: nicpf, ver 1.0 Dec 13 01:38:07.922418 kernel: nicvf, ver 1.0 Dec 13 01:38:07.922520 kernel: rtc-efi rtc-efi.0: registered as rtc0 Dec 13 01:38:07.922588 kernel: rtc-efi rtc-efi.0: setting system clock to 2024-12-13T01:38:07 UTC (1734053887) Dec 13 01:38:07.922598 kernel: hid: raw HID events driver (C) Jiri Kosina Dec 13 01:38:07.922606 kernel: hw perfevents: enabled with armv8_pmuv3_0 PMU driver, 7 counters available Dec 13 01:38:07.922616 kernel: watchdog: Delayed init of the lockup detector failed: -19 Dec 13 01:38:07.922623 kernel: watchdog: Hard watchdog permanently disabled Dec 13 01:38:07.922630 kernel: NET: Registered PF_INET6 protocol family Dec 13 01:38:07.922637 kernel: Segment Routing with IPv6 Dec 13 01:38:07.922645 kernel: In-situ OAM (IOAM) with IPv6 Dec 13 01:38:07.922652 kernel: NET: Registered PF_PACKET protocol family Dec 13 01:38:07.922659 kernel: Key type dns_resolver registered Dec 13 01:38:07.922666 kernel: registered taskstats version 1 Dec 13 01:38:07.922673 kernel: Loading compiled-in X.509 certificates Dec 13 01:38:07.922682 kernel: Loaded X.509 cert 'Kinvolk GmbH: Module signing key for 6.6.65-flatcar: d83da9ddb9e3c2439731828371f21d0232fd9ffb' Dec 13 01:38:07.922689 kernel: Key type .fscrypt registered Dec 13 01:38:07.922697 kernel: Key type fscrypt-provisioning registered Dec 13 01:38:07.922704 kernel: ima: No TPM chip found, activating TPM-bypass! Dec 13 01:38:07.922712 kernel: ima: Allocated hash algorithm: sha1 Dec 13 01:38:07.922719 kernel: ima: No architecture policies found Dec 13 01:38:07.922726 kernel: alg: No test for fips(ansi_cprng) (fips_ansi_cprng) Dec 13 01:38:07.922734 kernel: clk: Disabling unused clocks Dec 13 01:38:07.922741 kernel: Freeing unused kernel memory: 39360K Dec 13 01:38:07.922749 kernel: Run /init as init process Dec 13 01:38:07.922757 kernel: with arguments: Dec 13 01:38:07.922764 kernel: /init Dec 13 01:38:07.922771 kernel: with environment: Dec 13 01:38:07.922778 kernel: HOME=/ Dec 13 01:38:07.922785 kernel: TERM=linux Dec 13 01:38:07.922792 kernel: BOOT_IMAGE=/flatcar/vmlinuz-a Dec 13 01:38:07.922801 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) Dec 13 01:38:07.922812 systemd[1]: Detected virtualization kvm. Dec 13 01:38:07.922820 systemd[1]: Detected architecture arm64. Dec 13 01:38:07.922827 systemd[1]: Running in initrd. Dec 13 01:38:07.922835 systemd[1]: No hostname configured, using default hostname. Dec 13 01:38:07.922842 systemd[1]: Hostname set to . Dec 13 01:38:07.922850 systemd[1]: Initializing machine ID from VM UUID. Dec 13 01:38:07.922858 systemd[1]: Queued start job for default target initrd.target. Dec 13 01:38:07.922866 systemd[1]: Started clevis-luks-askpass.path - Forward Password Requests to Clevis Directory Watch. Dec 13 01:38:07.922875 systemd[1]: Started systemd-ask-password-console.path - Dispatch Password Requests to Console Directory Watch. Dec 13 01:38:07.922884 systemd[1]: Expecting device dev-disk-by\x2dlabel-EFI\x2dSYSTEM.device - /dev/disk/by-label/EFI-SYSTEM... Dec 13 01:38:07.922892 systemd[1]: Expecting device dev-disk-by\x2dlabel-OEM.device - /dev/disk/by-label/OEM... Dec 13 01:38:07.922899 systemd[1]: Expecting device dev-disk-by\x2dlabel-ROOT.device - /dev/disk/by-label/ROOT... Dec 13 01:38:07.922907 systemd[1]: Expecting device dev-disk-by\x2dpartlabel-USR\x2dA.device - /dev/disk/by-partlabel/USR-A... Dec 13 01:38:07.922916 systemd[1]: Expecting device dev-disk-by\x2dpartuuid-7130c94a\x2d213a\x2d4e5a\x2d8e26\x2d6cce9662f132.device - /dev/disk/by-partuuid/7130c94a-213a-4e5a-8e26-6cce9662f132... Dec 13 01:38:07.922926 systemd[1]: Expecting device dev-mapper-usr.device - /dev/mapper/usr... Dec 13 01:38:07.922934 systemd[1]: Reached target cryptsetup-pre.target - Local Encrypted Volumes (Pre). Dec 13 01:38:07.922952 systemd[1]: Reached target cryptsetup.target - Local Encrypted Volumes. Dec 13 01:38:07.922961 systemd[1]: Reached target paths.target - Path Units. Dec 13 01:38:07.922969 systemd[1]: Reached target slices.target - Slice Units. Dec 13 01:38:07.922976 systemd[1]: Reached target swap.target - Swaps. Dec 13 01:38:07.922984 systemd[1]: Reached target timers.target - Timer Units. Dec 13 01:38:07.922992 systemd[1]: Listening on iscsid.socket - Open-iSCSI iscsid Socket. Dec 13 01:38:07.923000 systemd[1]: Listening on iscsiuio.socket - Open-iSCSI iscsiuio Socket. Dec 13 01:38:07.923010 systemd[1]: Listening on systemd-journald-dev-log.socket - Journal Socket (/dev/log). Dec 13 01:38:07.923017 systemd[1]: Listening on systemd-journald.socket - Journal Socket. Dec 13 01:38:07.923025 systemd[1]: Listening on systemd-networkd.socket - Network Service Netlink Socket. Dec 13 01:38:07.923033 systemd[1]: Listening on systemd-udevd-control.socket - udev Control Socket. Dec 13 01:38:07.923041 systemd[1]: Listening on systemd-udevd-kernel.socket - udev Kernel Socket. Dec 13 01:38:07.923049 systemd[1]: Reached target sockets.target - Socket Units. Dec 13 01:38:07.923056 systemd[1]: Starting ignition-setup-pre.service - Ignition env setup... Dec 13 01:38:07.923064 systemd[1]: Starting kmod-static-nodes.service - Create List of Static Device Nodes... Dec 13 01:38:07.923072 systemd[1]: Finished network-cleanup.service - Network Cleanup. Dec 13 01:38:07.923081 systemd[1]: Starting systemd-fsck-usr.service... Dec 13 01:38:07.923089 systemd[1]: Starting systemd-journald.service - Journal Service... Dec 13 01:38:07.923097 systemd[1]: Starting systemd-modules-load.service - Load Kernel Modules... Dec 13 01:38:07.923105 systemd[1]: Starting systemd-vconsole-setup.service - Virtual Console Setup... Dec 13 01:38:07.923113 systemd[1]: Finished ignition-setup-pre.service - Ignition env setup. Dec 13 01:38:07.923121 systemd[1]: Finished kmod-static-nodes.service - Create List of Static Device Nodes. Dec 13 01:38:07.923128 systemd[1]: Finished systemd-fsck-usr.service. Dec 13 01:38:07.923168 systemd-journald[237]: Collecting audit messages is disabled. Dec 13 01:38:07.923193 systemd[1]: Starting systemd-tmpfiles-setup-dev-early.service - Create Static Device Nodes in /dev gracefully... Dec 13 01:38:07.923201 systemd[1]: Finished systemd-vconsole-setup.service - Virtual Console Setup. Dec 13 01:38:07.923209 kernel: bridge: filtering via arp/ip/ip6tables is no longer available by default. Update your scripts to load br_netfilter if you need this. Dec 13 01:38:07.923217 systemd[1]: Starting dracut-cmdline-ask.service - dracut ask for additional cmdline parameters... Dec 13 01:38:07.923225 kernel: Bridge firewalling registered Dec 13 01:38:07.923233 systemd-journald[237]: Journal started Dec 13 01:38:07.923253 systemd-journald[237]: Runtime Journal (/run/log/journal/a26735c2eb1c46a89ff13038877df638) is 5.9M, max 47.3M, 41.4M free. Dec 13 01:38:07.907312 systemd-modules-load[238]: Inserted module 'overlay' Dec 13 01:38:07.920980 systemd-modules-load[238]: Inserted module 'br_netfilter' Dec 13 01:38:07.926373 systemd[1]: Finished systemd-modules-load.service - Load Kernel Modules. Dec 13 01:38:07.926413 systemd[1]: Started systemd-journald.service - Journal Service. Dec 13 01:38:07.927951 systemd[1]: Finished systemd-tmpfiles-setup-dev-early.service - Create Static Device Nodes in /dev gracefully. Dec 13 01:38:07.931508 systemd[1]: Starting systemd-sysctl.service - Apply Kernel Variables... Dec 13 01:38:07.932850 systemd[1]: Starting systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev... Dec 13 01:38:07.936909 systemd[1]: Starting systemd-tmpfiles-setup.service - Create System Files and Directories... Dec 13 01:38:07.944364 systemd[1]: Finished systemd-sysctl.service - Apply Kernel Variables. Dec 13 01:38:07.946195 systemd[1]: Finished dracut-cmdline-ask.service - dracut ask for additional cmdline parameters. Dec 13 01:38:07.948262 systemd[1]: Finished systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev. Dec 13 01:38:07.950215 systemd[1]: Finished systemd-tmpfiles-setup.service - Create System Files and Directories. Dec 13 01:38:07.960541 systemd[1]: Starting dracut-cmdline.service - dracut cmdline hook... Dec 13 01:38:07.962553 systemd[1]: Starting systemd-resolved.service - Network Name Resolution... Dec 13 01:38:07.972153 dracut-cmdline[274]: dracut-dracut-053 Dec 13 01:38:07.974720 dracut-cmdline[274]: Using kernel command line parameters: rd.driver.pre=btrfs BOOT_IMAGE=/flatcar/vmlinuz-a mount.usr=/dev/mapper/usr verity.usr=PARTUUID=7130c94a-213a-4e5a-8e26-6cce9662f132 rootflags=rw mount.usrflags=ro consoleblank=0 root=LABEL=ROOT console=ttyS0,115200 flatcar.first_boot=detected acpi=force verity.usrhash=9494f75a68cfbdce95d0d2f9b58d6d75bc38ee5b4e31dfc2a6da695ffafefba6 Dec 13 01:38:07.991436 systemd-resolved[277]: Positive Trust Anchors: Dec 13 01:38:07.991452 systemd-resolved[277]: . IN DS 20326 8 2 e06d44b80b8f1d39a95c0b0d7c65d08458e880409bbc683457104237c7f8ec8d Dec 13 01:38:07.991484 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 Dec 13 01:38:07.996154 systemd-resolved[277]: Defaulting to hostname 'linux'. Dec 13 01:38:07.998450 systemd[1]: Started systemd-resolved.service - Network Name Resolution. Dec 13 01:38:07.999313 systemd[1]: Reached target nss-lookup.target - Host and Network Name Lookups. Dec 13 01:38:08.078329 kernel: SCSI subsystem initialized Dec 13 01:38:08.082332 kernel: Loading iSCSI transport class v2.0-870. Dec 13 01:38:08.091347 kernel: iscsi: registered transport (tcp) Dec 13 01:38:08.106726 kernel: iscsi: registered transport (qla4xxx) Dec 13 01:38:08.106767 kernel: QLogic iSCSI HBA Driver Dec 13 01:38:08.164354 systemd[1]: Finished dracut-cmdline.service - dracut cmdline hook. Dec 13 01:38:08.182579 systemd[1]: Starting dracut-pre-udev.service - dracut pre-udev hook... Dec 13 01:38:08.205053 kernel: device-mapper: core: CONFIG_IMA_DISABLE_HTABLE is disabled. Duplicate IMA measurements will not be recorded in the IMA log. Dec 13 01:38:08.205113 kernel: device-mapper: uevent: version 1.0.3 Dec 13 01:38:08.206364 kernel: device-mapper: ioctl: 4.48.0-ioctl (2023-03-01) initialised: dm-devel@redhat.com Dec 13 01:38:08.260357 kernel: raid6: neonx8 gen() 15761 MB/s Dec 13 01:38:08.277341 kernel: raid6: neonx4 gen() 15650 MB/s Dec 13 01:38:08.294343 kernel: raid6: neonx2 gen() 13239 MB/s Dec 13 01:38:08.311361 kernel: raid6: neonx1 gen() 10480 MB/s Dec 13 01:38:08.328364 kernel: raid6: int64x8 gen() 6956 MB/s Dec 13 01:38:08.346197 kernel: raid6: int64x4 gen() 7335 MB/s Dec 13 01:38:08.362362 kernel: raid6: int64x2 gen() 6123 MB/s Dec 13 01:38:08.379345 kernel: raid6: int64x1 gen() 5050 MB/s Dec 13 01:38:08.379384 kernel: raid6: using algorithm neonx8 gen() 15761 MB/s Dec 13 01:38:08.396353 kernel: raid6: .... xor() 11923 MB/s, rmw enabled Dec 13 01:38:08.396369 kernel: raid6: using neon recovery algorithm Dec 13 01:38:08.402340 kernel: xor: measuring software checksum speed Dec 13 01:38:08.402365 kernel: 8regs : 19759 MB/sec Dec 13 01:38:08.403338 kernel: 32regs : 18138 MB/sec Dec 13 01:38:08.403350 kernel: arm64_neon : 26989 MB/sec Dec 13 01:38:08.403359 kernel: xor: using function: arm64_neon (26989 MB/sec) Dec 13 01:38:08.459360 kernel: Btrfs loaded, zoned=no, fsverity=no Dec 13 01:38:08.472684 systemd[1]: Finished dracut-pre-udev.service - dracut pre-udev hook. Dec 13 01:38:08.484531 systemd[1]: Starting systemd-udevd.service - Rule-based Manager for Device Events and Files... Dec 13 01:38:08.496116 systemd-udevd[459]: Using default interface naming scheme 'v255'. Dec 13 01:38:08.499353 systemd[1]: Started systemd-udevd.service - Rule-based Manager for Device Events and Files. Dec 13 01:38:08.514616 systemd[1]: Starting dracut-pre-trigger.service - dracut pre-trigger hook... Dec 13 01:38:08.528897 dracut-pre-trigger[466]: rd.md=0: removing MD RAID activation Dec 13 01:38:08.562481 systemd[1]: Finished dracut-pre-trigger.service - dracut pre-trigger hook. Dec 13 01:38:08.573982 systemd[1]: Starting systemd-udev-trigger.service - Coldplug All udev Devices... Dec 13 01:38:08.612796 systemd[1]: Finished systemd-udev-trigger.service - Coldplug All udev Devices. Dec 13 01:38:08.620495 systemd[1]: Starting dracut-initqueue.service - dracut initqueue hook... Dec 13 01:38:08.635978 systemd[1]: Finished dracut-initqueue.service - dracut initqueue hook. Dec 13 01:38:08.637199 systemd[1]: Reached target remote-fs-pre.target - Preparation for Remote File Systems. Dec 13 01:38:08.640453 systemd[1]: Reached target remote-cryptsetup.target - Remote Encrypted Volumes. Dec 13 01:38:08.642156 systemd[1]: Reached target remote-fs.target - Remote File Systems. Dec 13 01:38:08.649469 systemd[1]: Starting dracut-pre-mount.service - dracut pre-mount hook... Dec 13 01:38:08.657741 kernel: virtio_blk virtio1: 1/0/0 default/read/poll queues Dec 13 01:38:08.671741 kernel: virtio_blk virtio1: [vda] 1064960 512-byte logical blocks (545 MB/520 MiB) Dec 13 01:38:08.669393 systemd[1]: Finished dracut-pre-mount.service - dracut pre-mount hook. Dec 13 01:38:08.673932 kernel: virtio_blk virtio2: 1/0/0 default/read/poll queues Dec 13 01:38:08.686938 kernel: tpm_tis MSFT0101:00: 2.0 TPM (device-id 0x1, rev-id 1) Dec 13 01:38:08.687053 kernel: virtio_blk virtio2: [vdb] 9289728 512-byte logical blocks (4.76 GB/4.43 GiB) Dec 13 01:38:08.687133 kernel: vdb: vdb1 vdb2 vdb3 vdb4 vdb6 vdb7 vdb9 Dec 13 01:38:08.673634 systemd[1]: dracut-cmdline-ask.service: Deactivated successfully. Dec 13 01:38:08.673739 systemd[1]: Stopped dracut-cmdline-ask.service - dracut ask for additional cmdline parameters. Dec 13 01:38:08.674943 systemd[1]: Stopping dracut-cmdline-ask.service - dracut ask for additional cmdline parameters... Dec 13 01:38:08.675711 systemd[1]: systemd-vconsole-setup.service: Deactivated successfully. Dec 13 01:38:08.675841 systemd[1]: Stopped systemd-vconsole-setup.service - Virtual Console Setup. Dec 13 01:38:08.676864 systemd[1]: Stopping systemd-vconsole-setup.service - Virtual Console Setup... Dec 13 01:38:08.688553 systemd[1]: Starting systemd-vconsole-setup.service - Virtual Console Setup... Dec 13 01:38:08.702379 systemd[1]: Finished systemd-vconsole-setup.service - Virtual Console Setup. Dec 13 01:38:08.710471 systemd[1]: Starting dracut-cmdline-ask.service - dracut ask for additional cmdline parameters... Dec 13 01:38:08.717441 kernel: BTRFS: device fsid 2893cd1e-612b-4262-912c-10787dc9c881 devid 1 transid 46 /dev/vdb3 scanned by (udev-worker) (510) Dec 13 01:38:08.720762 systemd[1]: Found device dev-disk-by\x2dlabel-EFI\x2dSYSTEM.device - /dev/disk/by-label/EFI-SYSTEM. Dec 13 01:38:08.724284 kernel: BTRFS: device label OEM devid 1 transid 12 /dev/vdb6 scanned by (udev-worker) (502) Dec 13 01:38:08.730479 systemd[1]: Found device dev-disk-by\x2dpartuuid-7130c94a\x2d213a\x2d4e5a\x2d8e26\x2d6cce9662f132.device - /dev/disk/by-partuuid/7130c94a-213a-4e5a-8e26-6cce9662f132. Dec 13 01:38:08.731351 systemd[1]: Found device dev-disk-by\x2dpartlabel-USR\x2dA.device - /dev/disk/by-partlabel/USR-A. Dec 13 01:38:08.735358 systemd[1]: Finished dracut-cmdline-ask.service - dracut ask for additional cmdline parameters. Dec 13 01:38:08.739545 systemd[1]: Found device dev-disk-by\x2dlabel-ROOT.device - /dev/disk/by-label/ROOT. Dec 13 01:38:08.743820 systemd[1]: Found device dev-disk-by\x2dlabel-OEM.device - /dev/disk/by-label/OEM. Dec 13 01:38:08.754466 systemd[1]: Starting disk-uuid.service - Generate new UUID for disk GPT if necessary... Dec 13 01:38:08.767421 kernel: vdb: vdb1 vdb2 vdb3 vdb4 vdb6 vdb7 vdb9 Dec 13 01:38:09.778941 disk-uuid[557]: The operation has completed successfully. Dec 13 01:38:09.779865 kernel: vdb: vdb1 vdb2 vdb3 vdb4 vdb6 vdb7 vdb9 Dec 13 01:38:09.822099 systemd[1]: disk-uuid.service: Deactivated successfully. Dec 13 01:38:09.822203 systemd[1]: Finished disk-uuid.service - Generate new UUID for disk GPT if necessary. Dec 13 01:38:09.837708 systemd[1]: Starting verity-setup.service - Verity Setup for /dev/mapper/usr... Dec 13 01:38:09.840717 sh[572]: Success Dec 13 01:38:09.859186 kernel: device-mapper: verity: sha256 using implementation "sha256-ce" Dec 13 01:38:09.920997 systemd[1]: Found device dev-mapper-usr.device - /dev/mapper/usr. Dec 13 01:38:09.923497 systemd[1]: Mounting sysusr-usr.mount - /sysusr/usr... Dec 13 01:38:09.924198 systemd[1]: Finished verity-setup.service - Verity Setup for /dev/mapper/usr. Dec 13 01:38:09.942711 kernel: BTRFS info (device dm-0): first mount of filesystem 2893cd1e-612b-4262-912c-10787dc9c881 Dec 13 01:38:09.942757 kernel: BTRFS info (device dm-0): using crc32c (crc32c-generic) checksum algorithm Dec 13 01:38:09.942768 kernel: BTRFS warning (device dm-0): 'nologreplay' is deprecated, use 'rescue=nologreplay' instead Dec 13 01:38:09.943607 kernel: BTRFS info (device dm-0): disabling log replay at mount time Dec 13 01:38:09.944634 kernel: BTRFS info (device dm-0): using free space tree Dec 13 01:38:09.949657 systemd[1]: Mounted sysusr-usr.mount - /sysusr/usr. Dec 13 01:38:09.950732 systemd[1]: afterburn-network-kargs.service - Afterburn Initrd Setup Network Kernel Arguments was skipped because no trigger condition checks were met. Dec 13 01:38:09.961526 systemd[1]: Starting ignition-setup.service - Ignition (setup)... Dec 13 01:38:09.962835 systemd[1]: Starting parse-ip-for-networkd.service - Write systemd-networkd units from cmdline... Dec 13 01:38:09.980226 kernel: BTRFS info (device vdb6): first mount of filesystem dbef6a22-a801-4c1e-a0cd-3fc525f899dd Dec 13 01:38:09.980273 kernel: BTRFS info (device vdb6): using crc32c (crc32c-generic) checksum algorithm Dec 13 01:38:09.980296 kernel: BTRFS info (device vdb6): using free space tree Dec 13 01:38:09.985398 kernel: BTRFS info (device vdb6): auto enabling async discard Dec 13 01:38:09.992222 systemd[1]: mnt-oem.mount: Deactivated successfully. Dec 13 01:38:09.993555 kernel: BTRFS info (device vdb6): last unmount of filesystem dbef6a22-a801-4c1e-a0cd-3fc525f899dd Dec 13 01:38:10.002903 systemd[1]: Finished ignition-setup.service - Ignition (setup). Dec 13 01:38:10.010488 systemd[1]: Starting ignition-fetch-offline.service - Ignition (fetch-offline)... Dec 13 01:38:10.084515 systemd[1]: Finished parse-ip-for-networkd.service - Write systemd-networkd units from cmdline. Dec 13 01:38:10.100534 systemd[1]: Starting systemd-networkd.service - Network Configuration... Dec 13 01:38:10.119366 ignition[672]: Ignition 2.19.0 Dec 13 01:38:10.119377 ignition[672]: Stage: fetch-offline Dec 13 01:38:10.119413 ignition[672]: no configs at "/usr/lib/ignition/base.d" Dec 13 01:38:10.119422 ignition[672]: no config dir at "/usr/lib/ignition/base.platform.d/qemu" Dec 13 01:38:10.119563 ignition[672]: parsed url from cmdline: "" Dec 13 01:38:10.119566 ignition[672]: no config URL provided Dec 13 01:38:10.119571 ignition[672]: reading system config file "/usr/lib/ignition/user.ign" Dec 13 01:38:10.122785 systemd-networkd[764]: lo: Link UP Dec 13 01:38:10.119578 ignition[672]: no config at "/usr/lib/ignition/user.ign" Dec 13 01:38:10.122788 systemd-networkd[764]: lo: Gained carrier Dec 13 01:38:10.119600 ignition[672]: op(1): [started] loading QEMU firmware config module Dec 13 01:38:10.123477 systemd-networkd[764]: Enumeration completed Dec 13 01:38:10.119605 ignition[672]: op(1): executing: "modprobe" "qemu_fw_cfg" Dec 13 01:38:10.123901 systemd-networkd[764]: eth0: found matching network '/usr/lib/systemd/network/zz-default.network', based on potentially unpredictable interface name. Dec 13 01:38:10.129056 ignition[672]: op(1): [finished] loading QEMU firmware config module Dec 13 01:38:10.123904 systemd-networkd[764]: eth0: Configuring with /usr/lib/systemd/network/zz-default.network. Dec 13 01:38:10.124721 systemd-networkd[764]: eth0: Link UP Dec 13 01:38:10.124724 systemd-networkd[764]: eth0: Gained carrier Dec 13 01:38:10.124731 systemd-networkd[764]: eth0: found matching network '/usr/lib/systemd/network/zz-default.network', based on potentially unpredictable interface name. Dec 13 01:38:10.125016 systemd[1]: Started systemd-networkd.service - Network Configuration. Dec 13 01:38:10.126305 systemd[1]: Reached target network.target - Network. Dec 13 01:38:10.140263 ignition[672]: parsing config with SHA512: 6952532752ffce466ccb732e3aa66c91a281c5bdf68252c604052fa90357e95c1855c58c5d9ad7fd43f8fd8bd15517194ce0315396bcb8fa42b4fdc7112b4a20 Dec 13 01:38:10.141377 systemd-networkd[764]: eth0: DHCPv4 address 10.0.0.104/16, gateway 10.0.0.1 acquired from 10.0.0.1 Dec 13 01:38:10.143476 unknown[672]: fetched base config from "system" Dec 13 01:38:10.143485 unknown[672]: fetched user config from "qemu" Dec 13 01:38:10.143729 ignition[672]: fetch-offline: fetch-offline passed Dec 13 01:38:10.143812 ignition[672]: Ignition finished successfully Dec 13 01:38:10.145966 systemd[1]: Finished ignition-fetch-offline.service - Ignition (fetch-offline). Dec 13 01:38:10.147154 systemd[1]: ignition-fetch.service - Ignition (fetch) was skipped because of an unmet condition check (ConditionPathExists=!/run/ignition.json). Dec 13 01:38:10.162751 systemd[1]: Starting ignition-kargs.service - Ignition (kargs)... Dec 13 01:38:10.172992 ignition[770]: Ignition 2.19.0 Dec 13 01:38:10.173012 ignition[770]: Stage: kargs Dec 13 01:38:10.173197 ignition[770]: no configs at "/usr/lib/ignition/base.d" Dec 13 01:38:10.173207 ignition[770]: no config dir at "/usr/lib/ignition/base.platform.d/qemu" Dec 13 01:38:10.173970 ignition[770]: kargs: kargs passed Dec 13 01:38:10.174015 ignition[770]: Ignition finished successfully Dec 13 01:38:10.177184 systemd[1]: Finished ignition-kargs.service - Ignition (kargs). Dec 13 01:38:10.179288 systemd[1]: Starting ignition-disks.service - Ignition (disks)... Dec 13 01:38:10.193798 ignition[777]: Ignition 2.19.0 Dec 13 01:38:10.193810 ignition[777]: Stage: disks Dec 13 01:38:10.193975 ignition[777]: no configs at "/usr/lib/ignition/base.d" Dec 13 01:38:10.193985 ignition[777]: no config dir at "/usr/lib/ignition/base.platform.d/qemu" Dec 13 01:38:10.194661 ignition[777]: disks: createLuks: op(1): [started] waiting for devices [/dev/disk/by-partlabel/ROOT] Dec 13 01:38:10.200122 ignition[777]: disks: createLuks: op(1): [finished] waiting for devices [/dev/disk/by-partlabel/ROOT] Dec 13 01:38:10.200215 ignition[777]: disks: createLuks: created device alias for "/dev/disk/by-partlabel/ROOT": "/run/ignition/dev_aliases/dev/disk/by-partlabel/ROOT" -> "/dev/vdb9" Dec 13 01:38:10.200373 ignition[777]: disks: createLuks: op(2): [started] wiping filesystem signatures from "/run/ignition/dev_aliases/dev/disk/by-partlabel/ROOT" Dec 13 01:38:10.200384 ignition[777]: disks: createLuks: op(2): executing: "wipefs" "-a" "/run/ignition/dev_aliases/dev/disk/by-partlabel/ROOT" Dec 13 01:38:10.210732 ignition[777]: disks: createLuks: op(2): [finished] wiping filesystem signatures from "/run/ignition/dev_aliases/dev/disk/by-partlabel/ROOT" Dec 13 01:38:10.210765 ignition[777]: disks: createLuks: op(3): [started] creating "rootencrypted" Dec 13 01:38:10.210783 ignition[777]: disks: createLuks: op(3): executing: "cryptsetup" "luksFormat" "--type" "luks2" "--key-file" "/tmp/ignition-luks-2532940490" "/run/ignition/dev_aliases/dev/disk/by-partlabel/ROOT" Dec 13 01:38:11.910519 systemd-networkd[764]: eth0: Gained IPv6LL Dec 13 01:38:16.818899 ignition[777]: disks: createLuks: op(3): [finished] creating "rootencrypted" Dec 13 01:38:16.818945 ignition[777]: disks: createLuks: op(4): [started] opening luks device rootencrypted Dec 13 01:38:16.818964 ignition[777]: disks: createLuks: op(4): executing: "cryptsetup" "luksOpen" "/run/ignition/dev_aliases/dev/disk/by-partlabel/ROOT" "rootencrypted" "--key-file" "/tmp/ignition-luks-2532940490" "--persistent" Dec 13 01:38:18.622359 kernel: Key type trusted registered Dec 13 01:38:18.624343 kernel: Key type encrypted registered Dec 13 01:38:18.647527 ignition[777]: disks: createLuks: op(4): [finished] opening luks device rootencrypted Dec 13 01:38:18.647591 ignition[777]: disks: createLuks: op(5): [started] waiting for triggered uevent Dec 13 01:38:18.647599 ignition[777]: disks: createLuks: op(5): executing: "udevadm" "trigger" "--settle" "/dev/vdb9" Dec 13 01:38:18.677656 ignition[777]: disks: createLuks: op(5): [finished] waiting for triggered uevent Dec 13 01:38:18.677692 ignition[777]: disks: createFilesystems: op(6): [started] waiting for devices [/dev/mapper/rootencrypted] Dec 13 01:38:18.682541 ignition[777]: disks: createFilesystems: op(6): [finished] waiting for devices [/dev/mapper/rootencrypted] Dec 13 01:38:18.682606 ignition[777]: disks: createFilesystems: created device alias for "/dev/mapper/rootencrypted": "/run/ignition/dev_aliases/dev/mapper/rootencrypted" -> "/dev/dm-1" Dec 13 01:38:18.682799 ignition[777]: disks: createFilesystems: op(7): [started] determining filesystem type of "/dev/mapper/rootencrypted" Dec 13 01:38:18.693699 ignition[777]: disks: createFilesystems: op(7): [finished] determining filesystem type of "/dev/mapper/rootencrypted" Dec 13 01:38:18.693715 ignition[777]: disks: createFilesystems: found filesystem at "/dev/mapper/rootencrypted" with uuid "" and label "" Dec 13 01:38:18.693748 ignition[777]: disks: createFilesystems: op(8): [started] wiping filesystem signatures from "/run/ignition/dev_aliases/dev/mapper/rootencrypted" Dec 13 01:38:18.693755 ignition[777]: disks: createFilesystems: op(8): executing: "wipefs" "-a" "/run/ignition/dev_aliases/dev/mapper/rootencrypted" Dec 13 01:38:18.698794 ignition[777]: disks: createFilesystems: op(8): [finished] wiping filesystem signatures from "/run/ignition/dev_aliases/dev/mapper/rootencrypted" Dec 13 01:38:18.698832 ignition[777]: disks: createFilesystems: op(9): [started] creating "ext4" filesystem on "/run/ignition/dev_aliases/dev/mapper/rootencrypted" Dec 13 01:38:18.698840 ignition[777]: disks: createFilesystems: op(9): executing: "mkfs.ext4" "-F" "-L" "ROOT" "/run/ignition/dev_aliases/dev/mapper/rootencrypted" Dec 13 01:38:18.803842 ignition[777]: disks: createFilesystems: op(9): [finished] creating "ext4" filesystem on "/run/ignition/dev_aliases/dev/mapper/rootencrypted" Dec 13 01:38:18.803899 ignition[777]: disks: createFilesystems: op(a): [started] waiting for triggered uevent Dec 13 01:38:18.803905 ignition[777]: disks: createFilesystems: op(a): executing: "udevadm" "trigger" "--settle" "/dev/dm-1" Dec 13 01:38:18.822308 ignition[777]: disks: createFilesystems: op(a): [finished] waiting for triggered uevent Dec 13 01:38:18.822351 ignition[777]: disks: disks passed Dec 13 01:38:18.822940 ignition[777]: Ignition finished successfully Dec 13 01:38:18.824680 systemd[1]: Finished ignition-disks.service - Ignition (disks). Dec 13 01:38:18.827850 systemd[1]: Reached target initrd-root-device.target - Initrd Root Device. Dec 13 01:38:18.828676 systemd[1]: Reached target local-fs-pre.target - Preparation for Local File Systems. Dec 13 01:38:18.830206 systemd[1]: Reached target local-fs.target - Local File Systems. Dec 13 01:38:18.831774 systemd[1]: Reached target sysinit.target - System Initialization. Dec 13 01:38:18.833139 systemd[1]: Reached target basic.target - Basic System. Dec 13 01:38:18.844458 systemd[1]: Starting systemd-fsck-root.service - File System Check on /dev/disk/by-label/ROOT... Dec 13 01:38:18.856804 systemd-fsck[1600]: ROOT: clean, 11/137360 files, 26629/549376 blocks Dec 13 01:38:18.859205 systemd[1]: Finished systemd-fsck-root.service - File System Check on /dev/disk/by-label/ROOT. Dec 13 01:38:18.861753 systemd[1]: Mounting sysroot.mount - /sysroot... Dec 13 01:38:18.912339 kernel: EXT4-fs (dm-1): mounted filesystem 290a8d7f-7418-49a6-bfbd-0417856e1f12 r/w with ordered data mode. Quota mode: none. Dec 13 01:38:18.913168 systemd[1]: Mounted sysroot.mount - /sysroot. Dec 13 01:38:18.914443 systemd[1]: Reached target initrd-root-fs.target - Initrd Root File System. Dec 13 01:38:18.924424 systemd[1]: Mounting sysroot-oem.mount - /sysroot/oem... Dec 13 01:38:18.925855 systemd[1]: Mounting sysroot-usr.mount - /sysroot/usr... Dec 13 01:38:18.926939 systemd[1]: flatcar-metadata-hostname.service - Flatcar Metadata Hostname Agent was skipped because no trigger condition checks were met. Dec 13 01:38:18.926988 systemd[1]: ignition-remount-sysroot.service - Remount /sysroot read-write for Ignition was skipped because of an unmet condition check (ConditionPathIsReadWrite=!/sysroot). Dec 13 01:38:18.932774 kernel: BTRFS: device label OEM devid 1 transid 13 /dev/vdb6 scanned by mount (1609) Dec 13 01:38:18.927012 systemd[1]: Reached target ignition-diskful.target - Ignition Boot Disk Setup. Dec 13 01:38:18.934447 systemd[1]: Mounted sysroot-usr.mount - /sysroot/usr. Dec 13 01:38:18.937933 kernel: BTRFS info (device vdb6): first mount of filesystem dbef6a22-a801-4c1e-a0cd-3fc525f899dd Dec 13 01:38:18.937954 kernel: BTRFS info (device vdb6): using crc32c (crc32c-generic) checksum algorithm Dec 13 01:38:18.937965 kernel: BTRFS info (device vdb6): using free space tree Dec 13 01:38:18.937985 kernel: BTRFS info (device vdb6): auto enabling async discard Dec 13 01:38:18.938260 systemd[1]: Mounted sysroot-oem.mount - /sysroot/oem. Dec 13 01:38:18.940937 systemd[1]: Starting initrd-setup-root.service - Root filesystem setup... Dec 13 01:38:18.960526 initrd-setup-root[1633]: cut: /sysroot/etc/passwd: No such file or directory Dec 13 01:38:18.965200 initrd-setup-root[1640]: cut: /sysroot/etc/group: No such file or directory Dec 13 01:38:18.970123 initrd-setup-root[1647]: cut: /sysroot/etc/shadow: No such file or directory Dec 13 01:38:18.974397 initrd-setup-root[1654]: cut: /sysroot/etc/gshadow: No such file or directory Dec 13 01:38:19.066483 systemd[1]: Finished initrd-setup-root.service - Root filesystem setup. Dec 13 01:38:19.072412 systemd[1]: Starting ignition-mount.service - Ignition (mount)... Dec 13 01:38:19.073768 systemd[1]: Starting sysroot-boot.service - /sysroot/boot... Dec 13 01:38:19.078345 kernel: BTRFS info (device vdb6): last unmount of filesystem dbef6a22-a801-4c1e-a0cd-3fc525f899dd Dec 13 01:38:19.078785 systemd[1]: sysroot-oem.mount: Deactivated successfully. Dec 13 01:38:19.095340 ignition[1721]: INFO : Ignition 2.19.0 Dec 13 01:38:19.095340 ignition[1721]: INFO : Stage: mount Dec 13 01:38:19.096901 ignition[1721]: INFO : no configs at "/usr/lib/ignition/base.d" Dec 13 01:38:19.096901 ignition[1721]: INFO : no config dir at "/usr/lib/ignition/base.platform.d/qemu" Dec 13 01:38:19.096901 ignition[1721]: INFO : mount: mount passed Dec 13 01:38:19.096901 ignition[1721]: INFO : Ignition finished successfully Dec 13 01:38:19.096685 systemd[1]: Finished sysroot-boot.service - /sysroot/boot. Dec 13 01:38:19.100558 systemd[1]: Finished ignition-mount.service - Ignition (mount). Dec 13 01:38:19.116447 systemd[1]: Starting ignition-files.service - Ignition (files)... Dec 13 01:38:19.922483 systemd[1]: Mounting sysroot-oem.mount - /sysroot/oem... Dec 13 01:38:19.928344 kernel: BTRFS: device label OEM devid 1 transid 14 /dev/vdb6 scanned by mount (1736) Dec 13 01:38:19.930515 kernel: BTRFS info (device vdb6): first mount of filesystem dbef6a22-a801-4c1e-a0cd-3fc525f899dd Dec 13 01:38:19.930544 kernel: BTRFS info (device vdb6): using crc32c (crc32c-generic) checksum algorithm Dec 13 01:38:19.930556 kernel: BTRFS info (device vdb6): using free space tree Dec 13 01:38:19.932337 kernel: BTRFS info (device vdb6): auto enabling async discard Dec 13 01:38:19.933814 systemd[1]: Mounted sysroot-oem.mount - /sysroot/oem. Dec 13 01:38:19.954930 ignition[1753]: INFO : Ignition 2.19.0 Dec 13 01:38:19.954930 ignition[1753]: INFO : Stage: files Dec 13 01:38:19.956630 ignition[1753]: INFO : no configs at "/usr/lib/ignition/base.d" Dec 13 01:38:19.956630 ignition[1753]: INFO : no config dir at "/usr/lib/ignition/base.platform.d/qemu" Dec 13 01:38:19.956630 ignition[1753]: DEBUG : files: compiled without relabeling support, skipping Dec 13 01:38:19.959432 ignition[1753]: INFO : files: ensureUsers: op(1): [started] creating or modifying user "core" Dec 13 01:38:19.959432 ignition[1753]: DEBUG : files: ensureUsers: op(1): executing: "usermod" "--root" "/sysroot" "core" Dec 13 01:38:19.959432 ignition[1753]: INFO : files: ensureUsers: op(1): [finished] creating or modifying user "core" Dec 13 01:38:19.959432 ignition[1753]: INFO : files: ensureUsers: op(2): [started] adding ssh keys to user "core" Dec 13 01:38:19.959432 ignition[1753]: INFO : files: ensureUsers: op(2): [finished] adding ssh keys to user "core" Dec 13 01:38:19.959132 unknown[1753]: wrote ssh authorized keys file for user: core Dec 13 01:38:19.965413 ignition[1753]: INFO : files: createFilesystemsFiles: createFiles: op(3): [started] writing file "/sysroot/etc/flatcar/update.conf" Dec 13 01:38:19.965413 ignition[1753]: INFO : files: createFilesystemsFiles: createFiles: op(3): [finished] writing file "/sysroot/etc/flatcar/update.conf" Dec 13 01:38:19.965413 ignition[1753]: INFO : files: op(4): [started] processing unit "cryptenroll-helper-first.service" Dec 13 01:38:19.965413 ignition[1753]: INFO : files: op(4): op(5): [started] writing unit "cryptenroll-helper-first.service" at "/sysroot/etc/systemd/system/cryptenroll-helper-first.service" Dec 13 01:38:19.965413 ignition[1753]: INFO : files: op(4): op(5): [finished] writing unit "cryptenroll-helper-first.service" at "/sysroot/etc/systemd/system/cryptenroll-helper-first.service" Dec 13 01:38:19.965413 ignition[1753]: INFO : files: op(4): [finished] processing unit "cryptenroll-helper-first.service" Dec 13 01:38:19.965413 ignition[1753]: INFO : files: op(6): [started] processing unit "cryptenroll-helper-bind.service" Dec 13 01:38:19.965413 ignition[1753]: INFO : files: op(6): op(7): [started] writing unit "cryptenroll-helper-bind.service" at "/sysroot/etc/systemd/system/cryptenroll-helper-bind.service" Dec 13 01:38:19.965413 ignition[1753]: INFO : files: op(6): op(7): [finished] writing unit "cryptenroll-helper-bind.service" at "/sysroot/etc/systemd/system/cryptenroll-helper-bind.service" Dec 13 01:38:19.965413 ignition[1753]: INFO : files: op(6): [finished] processing unit "cryptenroll-helper-bind.service" Dec 13 01:38:19.965413 ignition[1753]: INFO : files: op(8): [started] processing unit "coreos-metadata.service" Dec 13 01:38:19.965413 ignition[1753]: INFO : files: op(8): op(9): [started] writing unit "coreos-metadata.service" at "/sysroot/etc/systemd/system/coreos-metadata.service" Dec 13 01:38:19.965413 ignition[1753]: INFO : files: op(8): op(9): [finished] writing unit "coreos-metadata.service" at "/sysroot/etc/systemd/system/coreos-metadata.service" Dec 13 01:38:19.965413 ignition[1753]: INFO : files: op(8): [finished] processing unit "coreos-metadata.service" Dec 13 01:38:19.965413 ignition[1753]: INFO : files: op(a): [started] setting preset to disabled for "coreos-metadata.service" Dec 13 01:38:19.985942 ignition[1753]: INFO : files: op(a): op(b): [started] removing enablement symlink(s) for "coreos-metadata.service" Dec 13 01:38:19.985942 ignition[1753]: INFO : files: op(a): op(b): [finished] removing enablement symlink(s) for "coreos-metadata.service" Dec 13 01:38:19.985942 ignition[1753]: INFO : files: op(a): [finished] setting preset to disabled for "coreos-metadata.service" Dec 13 01:38:19.985942 ignition[1753]: INFO : files: op(c): [started] setting preset to enabled for "cryptenroll-helper-bind.service" Dec 13 01:38:19.985942 ignition[1753]: INFO : files: op(c): [finished] setting preset to enabled for "cryptenroll-helper-bind.service" Dec 13 01:38:19.985942 ignition[1753]: INFO : files: op(d): [started] setting preset to enabled for "cryptenroll-helper-first.service" Dec 13 01:38:19.985942 ignition[1753]: INFO : files: op(d): [finished] setting preset to enabled for "cryptenroll-helper-first.service" Dec 13 01:38:19.985942 ignition[1753]: INFO : files: createCrypttabEntries: createFiles: op(e): [started] writing file "/sysroot/etc/luks/rootencrypted" Dec 13 01:38:19.985942 ignition[1753]: INFO : files: createCrypttabEntries: createFiles: op(e): [finished] writing file "/sysroot/etc/luks/rootencrypted" Dec 13 01:38:19.985942 ignition[1753]: INFO : files: createCrypttabEntries: createFiles: op(f): [started] writing file "/sysroot/etc/crypttab" Dec 13 01:38:19.985942 ignition[1753]: INFO : files: createCrypttabEntries: createFiles: op(f): [finished] writing file "/sysroot/etc/crypttab" Dec 13 01:38:19.985942 ignition[1753]: INFO : files: createCrypttabEntries: createFiles: op(10): [started] appending to file "/sysroot/etc/crypttab" Dec 13 01:38:19.985942 ignition[1753]: INFO : files: createCrypttabEntries: createFiles: op(10): [finished] appending to file "/sysroot/etc/crypttab" Dec 13 01:38:19.985942 ignition[1753]: INFO : files: createResultFile: createFiles: op(11): [started] writing file "/sysroot/etc/.ignition-result.json" Dec 13 01:38:19.985942 ignition[1753]: INFO : files: createResultFile: createFiles: op(11): [finished] writing file "/sysroot/etc/.ignition-result.json" Dec 13 01:38:19.985942 ignition[1753]: INFO : files: files passed Dec 13 01:38:19.985942 ignition[1753]: INFO : Ignition finished successfully Dec 13 01:38:19.982063 systemd[1]: Finished ignition-files.service - Ignition (files). Dec 13 01:38:19.994511 systemd[1]: Starting ignition-quench.service - Ignition (record completion)... Dec 13 01:38:19.997103 systemd[1]: Starting initrd-setup-root-after-ignition.service - Root filesystem completion... Dec 13 01:38:19.998526 systemd[1]: ignition-quench.service: Deactivated successfully. Dec 13 01:38:20.009714 initrd-setup-root-after-ignition[1780]: grep: /sysroot/oem/oem-release: No such file or directory Dec 13 01:38:19.998611 systemd[1]: Finished ignition-quench.service - Ignition (record completion). Dec 13 01:38:20.012215 initrd-setup-root-after-ignition[1782]: grep: /sysroot/etc/flatcar/enabled-sysext.conf: No such file or directory Dec 13 01:38:20.012215 initrd-setup-root-after-ignition[1782]: grep: /sysroot/usr/share/flatcar/enabled-sysext.conf: No such file or directory Dec 13 01:38:20.010194 systemd[1]: Finished initrd-setup-root-after-ignition.service - Root filesystem completion. Dec 13 01:38:20.015836 initrd-setup-root-after-ignition[1786]: grep: /sysroot/etc/flatcar/enabled-sysext.conf: No such file or directory Dec 13 01:38:20.011703 systemd[1]: Reached target ignition-complete.target - Ignition Complete. Dec 13 01:38:20.025516 systemd[1]: Starting initrd-parse-etc.service - Mountpoints Configured in the Real Root... Dec 13 01:38:20.044765 systemd[1]: initrd-parse-etc.service: Deactivated successfully. Dec 13 01:38:20.044874 systemd[1]: Finished initrd-parse-etc.service - Mountpoints Configured in the Real Root. Dec 13 01:38:20.046508 systemd[1]: Reached target initrd-fs.target - Initrd File Systems. Dec 13 01:38:20.047893 systemd[1]: Reached target initrd.target - Initrd Default Target. Dec 13 01:38:20.049239 systemd[1]: dracut-mount.service - dracut mount hook was skipped because no trigger condition checks were met. Dec 13 01:38:20.050061 systemd[1]: Starting dracut-pre-pivot.service - dracut pre-pivot and cleanup hook... Dec 13 01:38:20.065708 systemd[1]: Finished dracut-pre-pivot.service - dracut pre-pivot and cleanup hook. Dec 13 01:38:20.079505 systemd[1]: Starting initrd-cleanup.service - Cleaning Up and Shutting Down Daemons... Dec 13 01:38:20.087583 systemd[1]: Stopped target nss-lookup.target - Host and Network Name Lookups. Dec 13 01:38:20.088545 systemd[1]: Stopped target remote-cryptsetup.target - Remote Encrypted Volumes. Dec 13 01:38:20.090071 systemd[1]: Stopped target timers.target - Timer Units. Dec 13 01:38:20.091415 systemd[1]: dracut-pre-pivot.service: Deactivated successfully. Dec 13 01:38:20.091539 systemd[1]: Stopped dracut-pre-pivot.service - dracut pre-pivot and cleanup hook. Dec 13 01:38:20.093353 systemd[1]: Stopped target initrd.target - Initrd Default Target. Dec 13 01:38:20.094860 systemd[1]: Stopped target basic.target - Basic System. Dec 13 01:38:20.096057 systemd[1]: Stopped target ignition-complete.target - Ignition Complete. Dec 13 01:38:20.097338 systemd[1]: Stopped target ignition-diskful.target - Ignition Boot Disk Setup. Dec 13 01:38:20.098778 systemd[1]: Stopped target initrd-root-device.target - Initrd Root Device. Dec 13 01:38:20.100168 systemd[1]: Stopped target remote-fs.target - Remote File Systems. Dec 13 01:38:20.101569 systemd[1]: Stopped target remote-fs-pre.target - Preparation for Remote File Systems. Dec 13 01:38:20.103039 systemd[1]: Stopped target sysinit.target - System Initialization. Dec 13 01:38:20.104509 systemd[1]: Stopped target local-fs.target - Local File Systems. Dec 13 01:38:20.105986 systemd[1]: Stopped target swap.target - Swaps. Dec 13 01:38:20.107076 systemd[1]: dracut-pre-mount.service: Deactivated successfully. Dec 13 01:38:20.107201 systemd[1]: Stopped dracut-pre-mount.service - dracut pre-mount hook. Dec 13 01:38:20.109006 systemd[1]: Stopped target cryptsetup.target - Local Encrypted Volumes. Dec 13 01:38:20.110437 systemd[1]: Stopped target cryptsetup-pre.target - Local Encrypted Volumes (Pre). Dec 13 01:38:20.111798 systemd[1]: clevis-luks-askpass.path: Deactivated successfully. Dec 13 01:38:20.113167 systemd[1]: Stopped clevis-luks-askpass.path - Forward Password Requests to Clevis Directory Watch. Dec 13 01:38:20.114101 systemd[1]: dracut-initqueue.service: Deactivated successfully. Dec 13 01:38:20.114210 systemd[1]: Stopped dracut-initqueue.service - dracut initqueue hook. Dec 13 01:38:20.116314 systemd[1]: ignition-fetch-offline.service: Deactivated successfully. Dec 13 01:38:20.116441 systemd[1]: Stopped ignition-fetch-offline.service - Ignition (fetch-offline). Dec 13 01:38:20.117861 systemd[1]: Stopped target paths.target - Path Units. Dec 13 01:38:20.119024 systemd[1]: systemd-ask-password-console.path: Deactivated successfully. Dec 13 01:38:20.119109 systemd[1]: Stopped systemd-ask-password-console.path - Dispatch Password Requests to Console Directory Watch. Dec 13 01:38:20.120548 systemd[1]: Stopped target slices.target - Slice Units. Dec 13 01:38:20.121616 systemd[1]: Stopped target sockets.target - Socket Units. Dec 13 01:38:20.122892 systemd[1]: iscsid.socket: Deactivated successfully. Dec 13 01:38:20.122980 systemd[1]: Closed iscsid.socket - Open-iSCSI iscsid Socket. Dec 13 01:38:20.124466 systemd[1]: iscsiuio.socket: Deactivated successfully. Dec 13 01:38:20.124543 systemd[1]: Closed iscsiuio.socket - Open-iSCSI iscsiuio Socket. Dec 13 01:38:20.125652 systemd[1]: initrd-setup-root-after-ignition.service: Deactivated successfully. Dec 13 01:38:20.125756 systemd[1]: Stopped initrd-setup-root-after-ignition.service - Root filesystem completion. Dec 13 01:38:20.126984 systemd[1]: ignition-files.service: Deactivated successfully. Dec 13 01:38:20.127092 systemd[1]: Stopped ignition-files.service - Ignition (files). Dec 13 01:38:20.138522 systemd[1]: Stopping ignition-mount.service - Ignition (mount)... Dec 13 01:38:20.139171 systemd[1]: kmod-static-nodes.service: Deactivated successfully. Dec 13 01:38:20.139288 systemd[1]: Stopped kmod-static-nodes.service - Create List of Static Device Nodes. Dec 13 01:38:20.142574 systemd[1]: Stopping sysroot-boot.service - /sysroot/boot... Dec 13 01:38:20.143223 systemd[1]: systemd-udev-trigger.service: Deactivated successfully. Dec 13 01:38:20.143362 systemd[1]: Stopped systemd-udev-trigger.service - Coldplug All udev Devices. Dec 13 01:38:20.144682 systemd[1]: dracut-pre-trigger.service: Deactivated successfully. Dec 13 01:38:20.144776 systemd[1]: Stopped dracut-pre-trigger.service - dracut pre-trigger hook. Dec 13 01:38:20.149565 systemd[1]: initrd-cleanup.service: Deactivated successfully. Dec 13 01:38:20.149686 systemd[1]: Finished initrd-cleanup.service - Cleaning Up and Shutting Down Daemons. Dec 13 01:38:20.152417 ignition[1807]: INFO : Ignition 2.19.0 Dec 13 01:38:20.152417 ignition[1807]: INFO : Stage: umount Dec 13 01:38:20.152417 ignition[1807]: INFO : no configs at "/usr/lib/ignition/base.d" Dec 13 01:38:20.152417 ignition[1807]: INFO : no config dir at "/usr/lib/ignition/base.platform.d/qemu" Dec 13 01:38:20.152417 ignition[1807]: INFO : umount: umount passed Dec 13 01:38:20.152417 ignition[1807]: INFO : Ignition finished successfully Dec 13 01:38:20.154340 systemd[1]: sysroot-boot.mount: Deactivated successfully. Dec 13 01:38:20.154789 systemd[1]: ignition-mount.service: Deactivated successfully. Dec 13 01:38:20.154873 systemd[1]: Stopped ignition-mount.service - Ignition (mount). Dec 13 01:38:20.156479 systemd[1]: Stopped target network.target - Network. Dec 13 01:38:20.157813 systemd[1]: ignition-disks.service: Deactivated successfully. Dec 13 01:38:20.157877 systemd[1]: Stopped ignition-disks.service - Ignition (disks). Dec 13 01:38:20.159037 systemd[1]: ignition-kargs.service: Deactivated successfully. Dec 13 01:38:20.159074 systemd[1]: Stopped ignition-kargs.service - Ignition (kargs). Dec 13 01:38:20.160233 systemd[1]: ignition-setup.service: Deactivated successfully. Dec 13 01:38:20.160271 systemd[1]: Stopped ignition-setup.service - Ignition (setup). Dec 13 01:38:20.161628 systemd[1]: ignition-setup-pre.service: Deactivated successfully. Dec 13 01:38:20.161668 systemd[1]: Stopped ignition-setup-pre.service - Ignition env setup. Dec 13 01:38:20.162944 systemd[1]: Stopping systemd-networkd.service - Network Configuration... Dec 13 01:38:20.164245 systemd[1]: Stopping systemd-resolved.service - Network Name Resolution... Dec 13 01:38:20.165666 systemd[1]: sysroot-boot.service: Deactivated successfully. Dec 13 01:38:20.165748 systemd[1]: Stopped sysroot-boot.service - /sysroot/boot. Dec 13 01:38:20.166781 systemd[1]: systemd-resolved.service: Deactivated successfully. Dec 13 01:38:20.166872 systemd[1]: Stopped systemd-resolved.service - Network Name Resolution. Dec 13 01:38:20.169652 systemd[1]: initrd-setup-root.service: Deactivated successfully. Dec 13 01:38:20.169705 systemd[1]: Stopped initrd-setup-root.service - Root filesystem setup. Dec 13 01:38:20.170756 systemd[1]: systemd-tmpfiles-setup.service: Deactivated successfully. Dec 13 01:38:20.170797 systemd[1]: Stopped systemd-tmpfiles-setup.service - Create System Files and Directories. Dec 13 01:38:20.174363 systemd-networkd[764]: eth0: DHCPv6 lease lost Dec 13 01:38:20.176223 systemd[1]: systemd-networkd.service: Deactivated successfully. Dec 13 01:38:20.176350 systemd[1]: Stopped systemd-networkd.service - Network Configuration. Dec 13 01:38:20.177921 systemd[1]: systemd-networkd.socket: Deactivated successfully. Dec 13 01:38:20.177951 systemd[1]: Closed systemd-networkd.socket - Network Service Netlink Socket. Dec 13 01:38:20.187413 systemd[1]: Stopping network-cleanup.service - Network Cleanup... Dec 13 01:38:20.188046 systemd[1]: parse-ip-for-networkd.service: Deactivated successfully. Dec 13 01:38:20.188106 systemd[1]: Stopped parse-ip-for-networkd.service - Write systemd-networkd units from cmdline. Dec 13 01:38:20.189566 systemd[1]: systemd-sysctl.service: Deactivated successfully. Dec 13 01:38:20.189606 systemd[1]: Stopped systemd-sysctl.service - Apply Kernel Variables. Dec 13 01:38:20.190972 systemd[1]: systemd-modules-load.service: Deactivated successfully. Dec 13 01:38:20.191010 systemd[1]: Stopped systemd-modules-load.service - Load Kernel Modules. Dec 13 01:38:20.192630 systemd[1]: Stopping systemd-udevd.service - Rule-based Manager for Device Events and Files... Dec 13 01:38:20.199682 systemd[1]: network-cleanup.service: Deactivated successfully. Dec 13 01:38:20.199815 systemd[1]: Stopped network-cleanup.service - Network Cleanup. Dec 13 01:38:20.206959 systemd[1]: systemd-udevd.service: Deactivated successfully. Dec 13 01:38:20.207106 systemd[1]: Stopped systemd-udevd.service - Rule-based Manager for Device Events and Files. Dec 13 01:38:20.208681 systemd[1]: systemd-udevd-control.socket: Deactivated successfully. Dec 13 01:38:20.208717 systemd[1]: Closed systemd-udevd-control.socket - udev Control Socket. Dec 13 01:38:20.210078 systemd[1]: systemd-udevd-kernel.socket: Deactivated successfully. Dec 13 01:38:20.210116 systemd[1]: Closed systemd-udevd-kernel.socket - udev Kernel Socket. Dec 13 01:38:20.211405 systemd[1]: dracut-pre-udev.service: Deactivated successfully. Dec 13 01:38:20.211444 systemd[1]: Stopped dracut-pre-udev.service - dracut pre-udev hook. Dec 13 01:38:20.213439 systemd[1]: dracut-cmdline.service: Deactivated successfully. Dec 13 01:38:20.213481 systemd[1]: Stopped dracut-cmdline.service - dracut cmdline hook. Dec 13 01:38:20.215433 systemd[1]: dracut-cmdline-ask.service: Deactivated successfully. Dec 13 01:38:20.215474 systemd[1]: Stopped dracut-cmdline-ask.service - dracut ask for additional cmdline parameters. Dec 13 01:38:20.230487 systemd[1]: Starting initrd-udevadm-cleanup-db.service - Cleanup udev Database... Dec 13 01:38:20.231237 systemd[1]: systemd-tmpfiles-setup-dev.service: Deactivated successfully. Dec 13 01:38:20.231289 systemd[1]: Stopped systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev. Dec 13 01:38:20.232856 systemd[1]: systemd-vconsole-setup.service: Deactivated successfully. Dec 13 01:38:20.232895 systemd[1]: Stopped systemd-vconsole-setup.service - Virtual Console Setup. Dec 13 01:38:20.234645 systemd[1]: initrd-udevadm-cleanup-db.service: Deactivated successfully. Dec 13 01:38:20.234738 systemd[1]: Finished initrd-udevadm-cleanup-db.service - Cleanup udev Database. Dec 13 01:38:20.236216 systemd[1]: Reached target initrd-switch-root.target - Switch Root. Dec 13 01:38:20.238831 systemd[1]: Starting initrd-switch-root.service - Switch Root... Dec 13 01:38:20.247958 systemd[1]: Switching root. Dec 13 01:38:20.273282 systemd-journald[237]: Journal stopped Dec 13 01:38:20.874461 systemd-journald[237]: Received SIGTERM from PID 1 (systemd). Dec 13 01:38:20.874518 kernel: SELinux: policy capability network_peer_controls=1 Dec 13 01:38:20.874530 kernel: SELinux: policy capability open_perms=1 Dec 13 01:38:20.874541 kernel: SELinux: policy capability extended_socket_class=1 Dec 13 01:38:20.874551 kernel: SELinux: policy capability always_check_network=0 Dec 13 01:38:20.874568 kernel: SELinux: policy capability cgroup_seclabel=1 Dec 13 01:38:20.874579 kernel: SELinux: policy capability nnp_nosuid_transition=1 Dec 13 01:38:20.874589 kernel: SELinux: policy capability genfs_seclabel_symlinks=0 Dec 13 01:38:20.874600 kernel: SELinux: policy capability ioctl_skip_cloexec=0 Dec 13 01:38:20.874615 kernel: audit: type=1403 audit(1734053900.339:2): auid=4294967295 ses=4294967295 lsm=selinux res=1 Dec 13 01:38:20.874626 systemd[1]: Successfully loaded SELinux policy in 32.348ms. Dec 13 01:38:20.874642 systemd[1]: Relabeled /dev, /dev/shm, /run, /sys/fs/cgroup in 10.170ms. Dec 13 01:38:20.874654 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) Dec 13 01:38:20.874668 systemd[1]: Detected virtualization kvm. Dec 13 01:38:20.874679 systemd[1]: Detected architecture arm64. Dec 13 01:38:20.874689 systemd[1]: Detected first boot. Dec 13 01:38:20.874700 systemd[1]: Initializing machine ID from VM UUID. Dec 13 01:38:20.874714 zram_generator::config[1852]: No configuration found. Dec 13 01:38:20.874724 systemd[1]: Populated /etc with preset unit settings. Dec 13 01:38:20.874735 systemd[1]: initrd-switch-root.service: Deactivated successfully. Dec 13 01:38:20.874745 systemd[1]: Stopped initrd-switch-root.service - Switch Root. Dec 13 01:38:20.874755 systemd[1]: systemd-journald.service: Scheduled restart job, restart counter is at 1. Dec 13 01:38:20.874768 systemd[1]: Created slice system-addon\x2dconfig.slice - Slice /system/addon-config. Dec 13 01:38:20.874778 systemd[1]: Created slice system-addon\x2drun.slice - Slice /system/addon-run. Dec 13 01:38:20.874790 systemd[1]: Created slice system-getty.slice - Slice /system/getty. Dec 13 01:38:20.874801 systemd[1]: Created slice system-modprobe.slice - Slice /system/modprobe. Dec 13 01:38:20.874811 systemd[1]: Created slice system-serial\x2dgetty.slice - Slice /system/serial-getty. Dec 13 01:38:20.874822 systemd[1]: Created slice system-system\x2dcloudinit.slice - Slice /system/system-cloudinit. Dec 13 01:38:20.874833 systemd[1]: Created slice system-systemd\x2dcryptsetup.slice - Encrypted Volume Units Service Slice. Dec 13 01:38:20.874844 systemd[1]: Created slice system-systemd\x2dfsck.slice - Slice /system/systemd-fsck. Dec 13 01:38:20.874854 systemd[1]: Created slice user.slice - User and Session Slice. Dec 13 01:38:20.874866 systemd[1]: Started clevis-luks-askpass.path - Forward Password Requests to Clevis Directory Watch. Dec 13 01:38:20.874878 systemd[1]: Started systemd-ask-password-console.path - Dispatch Password Requests to Console Directory Watch. Dec 13 01:38:20.874888 systemd[1]: Started systemd-ask-password-wall.path - Forward Password Requests to Wall Directory Watch. Dec 13 01:38:20.874899 systemd[1]: Set up automount boot.automount - Boot partition Automount Point. Dec 13 01:38:20.874910 systemd[1]: Set up automount proc-sys-fs-binfmt_misc.automount - Arbitrary Executable File Formats File System Automount Point. Dec 13 01:38:20.874920 systemd[1]: Expecting device dev-disk-by\x2dlabel-OEM.device - /dev/disk/by-label/OEM... Dec 13 01:38:20.874932 systemd[1]: Expecting device dev-disk-by\x2duuid-52ba323c\x2d2b67\x2d4c19\x2dbe09\x2df4aa08e60916.device - /dev/disk/by-uuid/52ba323c-2b67-4c19-be09-f4aa08e60916... Dec 13 01:38:20.874943 systemd[1]: Expecting device dev-ttyAMA0.device - /dev/ttyAMA0... Dec 13 01:38:20.874954 systemd[1]: Reached target cryptsetup-pre.target - Local Encrypted Volumes (Pre). Dec 13 01:38:20.874965 systemd[1]: Stopped target initrd-switch-root.target - Switch Root. Dec 13 01:38:20.874975 systemd[1]: Stopped target initrd-fs.target - Initrd File Systems. Dec 13 01:38:20.874985 systemd[1]: Stopped target initrd-root-fs.target - Initrd Root File System. Dec 13 01:38:20.874996 systemd[1]: Reached target integritysetup.target - Local Integrity Protected Volumes. Dec 13 01:38:20.875006 systemd[1]: Reached target remote-cryptsetup.target - Remote Encrypted Volumes. Dec 13 01:38:20.875018 systemd[1]: Reached target remote-fs.target - Remote File Systems. Dec 13 01:38:20.875029 systemd[1]: Reached target slices.target - Slice Units. Dec 13 01:38:20.875041 systemd[1]: Reached target swap.target - Swaps. Dec 13 01:38:20.875052 systemd[1]: Reached target veritysetup.target - Local Verity Protected Volumes. Dec 13 01:38:20.875062 systemd[1]: Listening on systemd-coredump.socket - Process Core Dump Socket. Dec 13 01:38:20.875073 systemd[1]: Listening on systemd-networkd.socket - Network Service Netlink Socket. Dec 13 01:38:20.875092 systemd[1]: Listening on systemd-udevd-control.socket - udev Control Socket. Dec 13 01:38:20.875105 systemd[1]: Listening on systemd-udevd-kernel.socket - udev Kernel Socket. Dec 13 01:38:20.875117 systemd[1]: Listening on systemd-userdbd.socket - User Database Manager Socket. Dec 13 01:38:20.875129 systemd[1]: Mounting dev-hugepages.mount - Huge Pages File System... Dec 13 01:38:20.875139 systemd[1]: Mounting dev-mqueue.mount - POSIX Message Queue File System... Dec 13 01:38:20.875152 systemd[1]: Mounting media.mount - External Media Directory... Dec 13 01:38:20.875163 systemd[1]: Mounting sys-kernel-debug.mount - Kernel Debug File System... Dec 13 01:38:20.875174 systemd[1]: Mounting sys-kernel-tracing.mount - Kernel Trace File System... Dec 13 01:38:20.875184 systemd[1]: Mounting tmp.mount - Temporary Directory /tmp... Dec 13 01:38:20.875195 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). Dec 13 01:38:20.875205 systemd[1]: Reached target machines.target - Containers. Dec 13 01:38:20.875216 systemd[1]: Starting flatcar-tmpfiles.service - Create missing system files... Dec 13 01:38:20.875227 systemd[1]: ignition-delete-config.service - Ignition (delete config) was skipped because no trigger condition checks were met. Dec 13 01:38:20.875239 systemd[1]: Starting kmod-static-nodes.service - Create List of Static Device Nodes... Dec 13 01:38:20.875251 systemd[1]: Starting modprobe@configfs.service - Load Kernel Module configfs... Dec 13 01:38:20.875263 systemd[1]: Starting modprobe@dm_mod.service - Load Kernel Module dm_mod... Dec 13 01:38:20.875274 systemd[1]: Starting modprobe@drm.service - Load Kernel Module drm... Dec 13 01:38:20.875285 systemd[1]: Starting modprobe@efi_pstore.service - Load Kernel Module efi_pstore... Dec 13 01:38:20.875363 systemd[1]: Starting modprobe@fuse.service - Load Kernel Module fuse... Dec 13 01:38:20.875379 systemd[1]: Starting modprobe@loop.service - Load Kernel Module loop... Dec 13 01:38:20.875390 systemd[1]: setup-nsswitch.service - Create /etc/nsswitch.conf was skipped because of an unmet condition check (ConditionPathExists=!/etc/nsswitch.conf). Dec 13 01:38:20.875401 systemd[1]: systemd-fsck-root.service: Deactivated successfully. Dec 13 01:38:20.875416 systemd[1]: Stopped systemd-fsck-root.service - File System Check on Root Device. Dec 13 01:38:20.875426 systemd[1]: systemd-fsck-usr.service: Deactivated successfully. Dec 13 01:38:20.875436 systemd[1]: Stopped systemd-fsck-usr.service. Dec 13 01:38:20.875447 systemd[1]: Starting systemd-journald.service - Journal Service... Dec 13 01:38:20.875492 kernel: loop: module loaded Dec 13 01:38:20.875507 kernel: fuse: init (API version 7.39) Dec 13 01:38:20.875517 systemd[1]: Starting systemd-modules-load.service - Load Kernel Modules... Dec 13 01:38:20.875529 systemd[1]: Starting systemd-network-generator.service - Generate network units from Kernel command line... Dec 13 01:38:20.875539 systemd[1]: Starting systemd-remount-fs.service - Remount Root and Kernel File Systems... Dec 13 01:38:20.875553 systemd[1]: Starting systemd-udev-trigger.service - Coldplug All udev Devices... Dec 13 01:38:20.875564 systemd[1]: verity-setup.service: Deactivated successfully. Dec 13 01:38:20.875575 systemd[1]: Stopped verity-setup.service. Dec 13 01:38:20.875586 systemd[1]: Mounted dev-hugepages.mount - Huge Pages File System. Dec 13 01:38:20.875596 kernel: ACPI: bus type drm_connector registered Dec 13 01:38:20.875610 systemd[1]: Mounted dev-mqueue.mount - POSIX Message Queue File System. Dec 13 01:38:20.875641 systemd-journald[1912]: Collecting audit messages is disabled. Dec 13 01:38:20.875662 systemd[1]: Mounted media.mount - External Media Directory. Dec 13 01:38:20.875673 systemd[1]: Mounted sys-kernel-debug.mount - Kernel Debug File System. Dec 13 01:38:20.875684 systemd-journald[1912]: Journal started Dec 13 01:38:20.875728 systemd-journald[1912]: Runtime Journal (/run/log/journal/a26735c2eb1c46a89ff13038877df638) is 5.9M, max 47.3M, 41.4M free. Dec 13 01:38:20.690564 systemd[1]: Queued start job for default target multi-user.target. Dec 13 01:38:20.707179 systemd[1]: Unnecessary job was removed for dev-vdb6.device - /dev/vdb6. Dec 13 01:38:20.707533 systemd[1]: systemd-journald.service: Deactivated successfully. Dec 13 01:38:20.878406 systemd[1]: Started systemd-journald.service - Journal Service. Dec 13 01:38:20.878989 systemd[1]: Mounted sys-kernel-tracing.mount - Kernel Trace File System. Dec 13 01:38:20.880025 systemd[1]: Mounted tmp.mount - Temporary Directory /tmp. Dec 13 01:38:20.881152 systemd[1]: Finished kmod-static-nodes.service - Create List of Static Device Nodes. Dec 13 01:38:20.882491 systemd[1]: modprobe@configfs.service: Deactivated successfully. Dec 13 01:38:20.883362 systemd[1]: Finished modprobe@configfs.service - Load Kernel Module configfs. Dec 13 01:38:20.884528 systemd[1]: modprobe@dm_mod.service: Deactivated successfully. Dec 13 01:38:20.884657 systemd[1]: Finished modprobe@dm_mod.service - Load Kernel Module dm_mod. Dec 13 01:38:20.885860 systemd[1]: modprobe@drm.service: Deactivated successfully. Dec 13 01:38:20.885990 systemd[1]: Finished modprobe@drm.service - Load Kernel Module drm. Dec 13 01:38:20.887149 systemd[1]: modprobe@efi_pstore.service: Deactivated successfully. Dec 13 01:38:20.888363 systemd[1]: Finished modprobe@efi_pstore.service - Load Kernel Module efi_pstore. Dec 13 01:38:20.889514 systemd[1]: Finished flatcar-tmpfiles.service - Create missing system files. Dec 13 01:38:20.890739 systemd[1]: modprobe@fuse.service: Deactivated successfully. Dec 13 01:38:20.890873 systemd[1]: Finished modprobe@fuse.service - Load Kernel Module fuse. Dec 13 01:38:20.892002 systemd[1]: modprobe@loop.service: Deactivated successfully. Dec 13 01:38:20.892139 systemd[1]: Finished modprobe@loop.service - Load Kernel Module loop. Dec 13 01:38:20.893235 systemd[1]: Finished systemd-modules-load.service - Load Kernel Modules. Dec 13 01:38:20.894445 systemd[1]: Finished systemd-network-generator.service - Generate network units from Kernel command line. Dec 13 01:38:20.895566 systemd[1]: Finished systemd-remount-fs.service - Remount Root and Kernel File Systems. Dec 13 01:38:20.907532 systemd[1]: Reached target network-pre.target - Preparation for Network. Dec 13 01:38:20.916421 systemd[1]: Mounting sys-fs-fuse-connections.mount - FUSE Control File System... Dec 13 01:38:20.918274 systemd[1]: Mounting sys-kernel-config.mount - Kernel Configuration File System... Dec 13 01:38:20.919154 systemd[1]: remount-root.service - Remount Root File System was skipped because of an unmet condition check (ConditionPathIsReadWrite=!/). Dec 13 01:38:20.919190 systemd[1]: Reached target local-fs.target - Local File Systems. Dec 13 01:38:20.920880 systemd[1]: Listening on systemd-sysext.socket - System Extension Image Management (Varlink). Dec 13 01:38:20.925557 systemd[1]: Starting dracut-shutdown.service - Restore /run/initramfs on shutdown... Dec 13 01:38:20.927445 systemd[1]: Starting ldconfig.service - Rebuild Dynamic Linker Cache... Dec 13 01:38:20.928364 systemd[1]: systemd-binfmt.service - Set Up Additional Binary Formats was skipped because no trigger condition checks were met. Dec 13 01:38:20.929955 systemd[1]: Starting systemd-hwdb-update.service - Rebuild Hardware Database... Dec 13 01:38:20.931692 systemd[1]: Starting systemd-journal-flush.service - Flush Journal to Persistent Storage... Dec 13 01:38:20.932538 systemd[1]: systemd-pstore.service - Platform Persistent Storage Archival was skipped because of an unmet condition check (ConditionDirectoryNotEmpty=/sys/fs/pstore). Dec 13 01:38:20.936513 systemd[1]: Starting systemd-random-seed.service - Load/Save OS Random Seed... Dec 13 01:38:20.937460 systemd[1]: systemd-repart.service - Repartition Root Disk was skipped because no trigger condition checks were met. Dec 13 01:38:20.941531 systemd[1]: Starting systemd-sysctl.service - Apply Kernel Variables... Dec 13 01:38:20.941858 systemd-journald[1912]: Time spent on flushing to /var/log/journal/a26735c2eb1c46a89ff13038877df638 is 14.052ms for 879 entries. Dec 13 01:38:20.941858 systemd-journald[1912]: System Journal (/var/log/journal/a26735c2eb1c46a89ff13038877df638) is 8.0M, max 204.2M, 196.1M free. Dec 13 01:38:20.963759 systemd-journald[1912]: Received client request to flush runtime journal. Dec 13 01:38:20.953414 systemd[1]: Starting systemd-sysext.service - Merge System Extension Images into /usr/ and /opt/... Dec 13 01:38:20.955687 systemd[1]: Starting systemd-sysusers.service - Create System Users... Dec 13 01:38:20.958104 systemd[1]: Finished systemd-udev-trigger.service - Coldplug All udev Devices. Dec 13 01:38:20.959693 systemd[1]: Mounted sys-fs-fuse-connections.mount - FUSE Control File System. Dec 13 01:38:20.960894 systemd[1]: Mounted sys-kernel-config.mount - Kernel Configuration File System. Dec 13 01:38:20.962290 systemd[1]: Finished dracut-shutdown.service - Restore /run/initramfs on shutdown. Dec 13 01:38:20.964036 systemd[1]: Finished systemd-random-seed.service - Load/Save OS Random Seed. Dec 13 01:38:20.972057 systemd[1]: Finished systemd-journal-flush.service - Flush Journal to Persistent Storage. Dec 13 01:38:20.973561 systemd[1]: Finished systemd-sysctl.service - Apply Kernel Variables. Dec 13 01:38:20.982598 systemd[1]: Reached target first-boot-complete.target - First Boot Complete. Dec 13 01:38:20.987427 kernel: loop0: detected capacity change from 0 to 114328 Dec 13 01:38:20.993594 systemd[1]: Starting systemd-machine-id-commit.service - Commit a transient machine-id on disk... Dec 13 01:38:20.995506 systemd[1]: Starting systemd-udev-settle.service - Wait for udev To Complete Device Initialization... Dec 13 01:38:21.000356 kernel: squashfs: version 4.0 (2009/01/31) Phillip Lougher Dec 13 01:38:21.009571 udevadm[1979]: systemd-udev-settle.service is deprecated. Please fix lvm2-activation.service, lvm2-activation-early.service not to pull it in. Dec 13 01:38:21.022346 kernel: loop1: detected capacity change from 0 to 114432 Dec 13 01:38:21.028175 systemd[1]: Finished systemd-sysusers.service - Create System Users. Dec 13 01:38:21.037542 systemd[1]: Starting systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev... Dec 13 01:38:21.039064 systemd[1]: etc-machine\x2did.mount: Deactivated successfully. Dec 13 01:38:21.040238 systemd[1]: Finished systemd-machine-id-commit.service - Commit a transient machine-id on disk. Dec 13 01:38:21.061346 kernel: loop2: detected capacity change from 0 to 114328 Dec 13 01:38:21.063475 systemd-tmpfiles[1982]: ACLs are not supported, ignoring. Dec 13 01:38:21.063496 systemd-tmpfiles[1982]: ACLs are not supported, ignoring. Dec 13 01:38:21.067954 systemd[1]: Finished systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev. Dec 13 01:38:21.070347 kernel: loop3: detected capacity change from 0 to 114432 Dec 13 01:38:21.073514 (sd-merge)[1986]: Using extensions 'containerd-flatcar', 'docker-flatcar'. Dec 13 01:38:21.073869 (sd-merge)[1986]: Merged extensions into '/usr'. Dec 13 01:38:21.077572 systemd[1]: Finished systemd-sysext.service - Merge System Extension Images into /usr/ and /opt/. Dec 13 01:38:21.090640 systemd[1]: Starting ensure-sysext.service... Dec 13 01:38:21.092480 systemd[1]: Starting systemd-tmpfiles-setup.service - Create System Files and Directories... Dec 13 01:38:21.102762 systemd[1]: Reloading requested from client PID 1989 ('systemctl') (unit ensure-sysext.service)... Dec 13 01:38:21.102780 systemd[1]: Reloading... Dec 13 01:38:21.119252 systemd-tmpfiles[1990]: /usr/lib/tmpfiles.d/provision.conf:20: Duplicate line for path "/root", ignoring. Dec 13 01:38:21.119548 systemd-tmpfiles[1990]: /usr/lib/tmpfiles.d/systemd-flatcar.conf:6: Duplicate line for path "/var/log/journal", ignoring. Dec 13 01:38:21.120209 systemd-tmpfiles[1990]: /usr/lib/tmpfiles.d/systemd.conf:29: Duplicate line for path "/var/lib/systemd", ignoring. Dec 13 01:38:21.120438 systemd-tmpfiles[1990]: ACLs are not supported, ignoring. Dec 13 01:38:21.120497 systemd-tmpfiles[1990]: ACLs are not supported, ignoring. Dec 13 01:38:21.123721 systemd-tmpfiles[1990]: Detected autofs mount point /boot during canonicalization of boot. Dec 13 01:38:21.123737 systemd-tmpfiles[1990]: Skipping /boot Dec 13 01:38:21.130894 systemd-tmpfiles[1990]: Detected autofs mount point /boot during canonicalization of boot. Dec 13 01:38:21.130911 systemd-tmpfiles[1990]: Skipping /boot Dec 13 01:38:21.170407 zram_generator::config[2018]: No configuration found. Dec 13 01:38:21.272162 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. Dec 13 01:38:21.301416 ldconfig[1958]: /sbin/ldconfig: /lib/ld.so.conf is not an ELF file - it has the wrong magic bytes at the start. Dec 13 01:38:21.316824 systemd[1]: Reloading finished in 213 ms. Dec 13 01:38:21.347428 systemd[1]: Finished ldconfig.service - Rebuild Dynamic Linker Cache. Dec 13 01:38:21.356742 systemd[1]: Finished systemd-tmpfiles-setup.service - Create System Files and Directories. Dec 13 01:38:21.365023 systemd[1]: Starting audit-rules.service - Load Security Auditing Rules... Dec 13 01:38:21.367580 systemd[1]: Starting clean-ca-certificates.service - Clean up broken links in /etc/ssl/certs... Dec 13 01:38:21.372613 systemd[1]: Starting systemd-journal-catalog-update.service - Rebuild Journal Catalog... Dec 13 01:38:21.390825 systemd[1]: Starting systemd-resolved.service - Network Name Resolution... Dec 13 01:38:21.393552 systemd[1]: Starting systemd-update-utmp.service - Record System Boot/Shutdown in UTMP... Dec 13 01:38:21.397280 systemd[1]: ignition-delete-config.service - Ignition (delete config) was skipped because no trigger condition checks were met. Dec 13 01:38:21.398718 systemd[1]: Starting modprobe@dm_mod.service - Load Kernel Module dm_mod... Dec 13 01:38:21.403571 systemd[1]: Starting modprobe@efi_pstore.service - Load Kernel Module efi_pstore... Dec 13 01:38:21.407725 systemd[1]: Starting modprobe@loop.service - Load Kernel Module loop... Dec 13 01:38:21.408658 systemd[1]: systemd-binfmt.service - Set Up Additional Binary Formats was skipped because no trigger condition checks were met. Dec 13 01:38:21.412164 systemd[1]: modprobe@efi_pstore.service: Deactivated successfully. Dec 13 01:38:21.413712 systemd[1]: Finished modprobe@efi_pstore.service - Load Kernel Module efi_pstore. Dec 13 01:38:21.415170 systemd[1]: modprobe@loop.service: Deactivated successfully. Dec 13 01:38:21.415289 systemd[1]: Finished modprobe@loop.service - Load Kernel Module loop. Dec 13 01:38:21.417042 systemd[1]: modprobe@dm_mod.service: Deactivated successfully. Dec 13 01:38:21.417828 systemd[1]: Finished modprobe@dm_mod.service - Load Kernel Module dm_mod. Dec 13 01:38:21.419517 systemd[1]: Finished systemd-journal-catalog-update.service - Rebuild Journal Catalog. Dec 13 01:38:21.425206 systemd[1]: ignition-delete-config.service - Ignition (delete config) was skipped because no trigger condition checks were met. Dec 13 01:38:21.431591 systemd[1]: Starting modprobe@dm_mod.service - Load Kernel Module dm_mod... Dec 13 01:38:21.433577 systemd[1]: Starting modprobe@efi_pstore.service - Load Kernel Module efi_pstore... Dec 13 01:38:21.437671 systemd[1]: Starting modprobe@loop.service - Load Kernel Module loop... Dec 13 01:38:21.439077 systemd[1]: systemd-binfmt.service - Set Up Additional Binary Formats was skipped because no trigger condition checks were met. Dec 13 01:38:21.441579 systemd[1]: Starting systemd-userdbd.service - User Database Manager... Dec 13 01:38:21.445358 systemd[1]: Finished systemd-update-utmp.service - Record System Boot/Shutdown in UTMP. Dec 13 01:38:21.447152 systemd[1]: modprobe@dm_mod.service: Deactivated successfully. Dec 13 01:38:21.447284 systemd[1]: Finished modprobe@dm_mod.service - Load Kernel Module dm_mod. Dec 13 01:38:21.448839 systemd[1]: modprobe@efi_pstore.service: Deactivated successfully. Dec 13 01:38:21.449077 systemd[1]: Finished modprobe@efi_pstore.service - Load Kernel Module efi_pstore. Dec 13 01:38:21.450800 systemd[1]: modprobe@loop.service: Deactivated successfully. Dec 13 01:38:21.450922 systemd[1]: Finished modprobe@loop.service - Load Kernel Module loop. Dec 13 01:38:21.458569 systemd[1]: Finished clean-ca-certificates.service - Clean up broken links in /etc/ssl/certs. Dec 13 01:38:21.459038 augenrules[2088]: No rules Dec 13 01:38:21.462256 systemd[1]: Finished audit-rules.service - Load Security Auditing Rules. Dec 13 01:38:21.464886 systemd[1]: ignition-delete-config.service - Ignition (delete config) was skipped because no trigger condition checks were met. Dec 13 01:38:21.472575 systemd[1]: Starting modprobe@dm_mod.service - Load Kernel Module dm_mod... Dec 13 01:38:21.474380 systemd[1]: Starting modprobe@drm.service - Load Kernel Module drm... Dec 13 01:38:21.476078 systemd[1]: Starting modprobe@efi_pstore.service - Load Kernel Module efi_pstore... Dec 13 01:38:21.477988 systemd[1]: Starting modprobe@loop.service - Load Kernel Module loop... Dec 13 01:38:21.478930 systemd[1]: systemd-binfmt.service - Set Up Additional Binary Formats was skipped because no trigger condition checks were met. Dec 13 01:38:21.479091 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). Dec 13 01:38:21.479907 systemd[1]: Finished systemd-hwdb-update.service - Rebuild Hardware Database. Dec 13 01:38:21.481261 systemd[1]: modprobe@dm_mod.service: Deactivated successfully. Dec 13 01:38:21.481456 systemd[1]: Finished modprobe@dm_mod.service - Load Kernel Module dm_mod. Dec 13 01:38:21.482630 systemd[1]: modprobe@drm.service: Deactivated successfully. Dec 13 01:38:21.482755 systemd[1]: Finished modprobe@drm.service - Load Kernel Module drm. Dec 13 01:38:21.483961 systemd[1]: modprobe@efi_pstore.service: Deactivated successfully. Dec 13 01:38:21.484073 systemd[1]: Finished modprobe@efi_pstore.service - Load Kernel Module efi_pstore. Dec 13 01:38:21.487447 systemd[1]: Started systemd-userdbd.service - User Database Manager. Dec 13 01:38:21.491707 systemd[1]: Finished ensure-sysext.service. Dec 13 01:38:21.492640 systemd[1]: modprobe@loop.service: Deactivated successfully. Dec 13 01:38:21.492763 systemd[1]: Finished modprobe@loop.service - Load Kernel Module loop. Dec 13 01:38:21.497404 systemd[1]: systemd-pstore.service - Platform Persistent Storage Archival was skipped because of an unmet condition check (ConditionDirectoryNotEmpty=/sys/fs/pstore). Dec 13 01:38:21.497464 systemd[1]: systemd-repart.service - Repartition Root Disk was skipped because no trigger condition checks were met. Dec 13 01:38:21.499289 systemd[1]: Starting systemd-timesyncd.service - Network Time Synchronization... Dec 13 01:38:21.501556 systemd[1]: Starting systemd-udevd.service - Rule-based Manager for Device Events and Files... Dec 13 01:38:21.503510 systemd[1]: Starting systemd-update-done.service - Update is Completed... Dec 13 01:38:21.516565 systemd[1]: Finished systemd-update-done.service - Update is Completed. Dec 13 01:38:21.527139 systemd-udevd[2112]: Using default interface naming scheme 'v255'. Dec 13 01:38:21.538415 systemd-resolved[2059]: Positive Trust Anchors: Dec 13 01:38:21.538432 systemd-resolved[2059]: . IN DS 20326 8 2 e06d44b80b8f1d39a95c0b0d7c65d08458e880409bbc683457104237c7f8ec8d Dec 13 01:38:21.538464 systemd-resolved[2059]: 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 Dec 13 01:38:21.540852 systemd[1]: Started systemd-udevd.service - Rule-based Manager for Device Events and Files. Dec 13 01:38:21.542741 systemd-resolved[2059]: Defaulting to hostname 'linux'. Dec 13 01:38:21.557514 systemd[1]: Starting systemd-networkd.service - Network Configuration... Dec 13 01:38:21.558707 systemd[1]: Started systemd-resolved.service - Network Name Resolution. Dec 13 01:38:21.564153 systemd[1]: Reached target nss-lookup.target - Host and Network Name Lookups. Dec 13 01:38:21.566051 systemd[1]: Started systemd-timesyncd.service - Network Time Synchronization. Dec 13 01:38:21.567071 systemd[1]: Reached target time-set.target - System Time Set. Dec 13 01:38:21.581366 systemd[1]: Condition check resulted in dev-ttyAMA0.device - /dev/ttyAMA0 being skipped. Dec 13 01:38:21.593608 systemd[1]: Condition check resulted in dev-disk-by\x2duuid-52ba323c\x2d2b67\x2d4c19\x2dbe09\x2df4aa08e60916.device - /dev/disk/by-uuid/52ba323c-2b67-4c19-be09-f4aa08e60916 being skipped. Dec 13 01:38:21.595344 kernel: BTRFS warning: duplicate device /dev/vdb3 devid 1 generation 46 scanned by (udev-worker) (2121) Dec 13 01:38:21.595416 kernel: BTRFS info: devid 1 device path /dev/mapper/usr changed to /dev/dm-0 scanned by (udev-worker) (2127) Dec 13 01:38:21.601532 systemd[1]: Starting systemd-cryptsetup@rootencrypted.service - Cryptography Setup for rootencrypted... Dec 13 01:38:21.604342 kernel: BTRFS info: devid 1 device path /dev/dm-0 changed to /dev/mapper/usr scanned by (udev-worker) (2127) Dec 13 01:38:21.622445 systemd-cryptsetup[2137]: Volume rootencrypted already active. Dec 13 01:38:21.624442 systemd[1]: Finished systemd-cryptsetup@rootencrypted.service - Cryptography Setup for rootencrypted. Dec 13 01:38:21.627184 systemd[1]: Reached target blockdev@dev-mapper-rootencrypted.target - Block Device Preparation for /dev/mapper/rootencrypted. Dec 13 01:38:21.643974 systemd-networkd[2119]: lo: Link UP Dec 13 01:38:21.643982 systemd-networkd[2119]: lo: Gained carrier Dec 13 01:38:21.645349 systemd-networkd[2119]: Enumeration completed Dec 13 01:38:21.645534 systemd[1]: Started systemd-networkd.service - Network Configuration. Dec 13 01:38:21.646547 systemd-networkd[2119]: eth0: found matching network '/usr/lib/systemd/network/zz-default.network', based on potentially unpredictable interface name. Dec 13 01:38:21.646557 systemd-networkd[2119]: eth0: Configuring with /usr/lib/systemd/network/zz-default.network. Dec 13 01:38:21.647609 systemd[1]: Found device dev-disk-by\x2dlabel-OEM.device - /dev/disk/by-label/OEM. Dec 13 01:38:21.648801 systemd[1]: Reached target network.target - Network. Dec 13 01:38:21.650440 systemd-networkd[2119]: eth0: Link UP Dec 13 01:38:21.650448 systemd-networkd[2119]: eth0: Gained carrier Dec 13 01:38:21.650463 systemd-networkd[2119]: eth0: found matching network '/usr/lib/systemd/network/zz-default.network', based on potentially unpredictable interface name. Dec 13 01:38:21.655479 systemd[1]: Starting systemd-fsck@dev-disk-by\x2dlabel-OEM.service - File System Check on /dev/disk/by-label/OEM... Dec 13 01:38:21.658087 systemd[1]: Starting systemd-networkd-wait-online.service - Wait for Network to be Configured... Dec 13 01:38:21.664412 systemd-networkd[2119]: eth0: DHCPv4 address 10.0.0.104/16, gateway 10.0.0.1 acquired from 10.0.0.1 Dec 13 01:38:21.666993 systemd-timesyncd[2111]: Network configuration changed, trying to establish connection. Dec 13 01:38:21.668708 systemd-timesyncd[2111]: Contacted time server 10.0.0.1:123 (10.0.0.1). Dec 13 01:38:21.668762 systemd-timesyncd[2111]: Initial clock synchronization to Fri 2024-12-13 01:38:21.490429 UTC. Dec 13 01:38:21.674568 systemd[1]: Finished systemd-fsck@dev-disk-by\x2dlabel-OEM.service - File System Check on /dev/disk/by-label/OEM. Dec 13 01:38:21.703600 systemd[1]: Starting systemd-vconsole-setup.service - Virtual Console Setup... Dec 13 01:38:21.709869 systemd[1]: Finished systemd-udev-settle.service - Wait for udev To Complete Device Initialization. Dec 13 01:38:21.714511 systemd[1]: Starting lvm2-activation-early.service - Activation of LVM2 logical volumes... Dec 13 01:38:21.736367 lvm[2154]: WARNING: Failed to connect to lvmetad. Falling back to device scanning. Dec 13 01:38:21.744103 systemd[1]: Finished systemd-vconsole-setup.service - Virtual Console Setup. Dec 13 01:38:21.770680 systemd[1]: Finished lvm2-activation-early.service - Activation of LVM2 logical volumes. Dec 13 01:38:21.771755 systemd[1]: Reached target cryptsetup.target - Local Encrypted Volumes. Dec 13 01:38:21.772578 systemd[1]: Reached target sysinit.target - System Initialization. Dec 13 01:38:21.773388 systemd[1]: Started motdgen.path - Watch for update engine configuration changes. Dec 13 01:38:21.774232 systemd[1]: Started user-cloudinit@var-lib-flatcar\x2dinstall-user_data.path - Watch for a cloud-config at /var/lib/flatcar-install/user_data. Dec 13 01:38:21.775290 systemd[1]: Started logrotate.timer - Daily rotation of log files. Dec 13 01:38:21.776117 systemd[1]: Started mdadm.timer - Weekly check for MD array's redundancy information.. Dec 13 01:38:21.777040 systemd[1]: Started systemd-tmpfiles-clean.timer - Daily Cleanup of Temporary Directories. Dec 13 01:38:21.777906 systemd[1]: update-engine-stub.timer - Update Engine Stub Timer was skipped because of an unmet condition check (ConditionPathExists=/usr/.noupdate). Dec 13 01:38:21.777939 systemd[1]: Reached target paths.target - Path Units. Dec 13 01:38:21.778565 systemd[1]: Reached target timers.target - Timer Units. Dec 13 01:38:21.780085 systemd[1]: Listening on dbus.socket - D-Bus System Message Bus Socket. Dec 13 01:38:21.782032 systemd[1]: Starting docker.socket - Docker Socket for the API... Dec 13 01:38:21.794038 systemd[1]: Listening on sshd.socket - OpenSSH Server Socket. Dec 13 01:38:21.795857 systemd[1]: Starting lvm2-activation.service - Activation of LVM2 logical volumes... Dec 13 01:38:21.797142 systemd[1]: Listening on docker.socket - Docker Socket for the API. Dec 13 01:38:21.798004 systemd[1]: Reached target sockets.target - Socket Units. Dec 13 01:38:21.798700 systemd[1]: Reached target basic.target - Basic System. Dec 13 01:38:21.799379 systemd[1]: addon-config@oem.service - Configure Addon /oem was skipped because no trigger condition checks were met. Dec 13 01:38:21.799408 systemd[1]: addon-run@oem.service - Run Addon /oem was skipped because no trigger condition checks were met. Dec 13 01:38:21.800212 systemd[1]: Starting containerd.service - containerd container runtime... Dec 13 01:38:21.800981 systemd[1]: cryptenroll-helper-bind.service was skipped because of an unmet condition check (ConditionPathExists=/etc/luks/rootencrypted-bind). Dec 13 01:38:21.801981 systemd[1]: Starting dbus.service - D-Bus System Message Bus... Dec 13 01:38:21.803058 lvm[2162]: WARNING: Failed to connect to lvmetad. Falling back to device scanning. Dec 13 01:38:21.804668 systemd[1]: Starting enable-oem-cloudinit.service - Enable cloudinit... Dec 13 01:38:21.807261 systemd[1]: Starting extend-filesystems.service - Extend Filesystems... Dec 13 01:38:21.809202 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). Dec 13 01:38:21.817916 systemd[1]: Starting motdgen.service - Generate /run/flatcar/motd... Dec 13 01:38:21.821036 jq[2165]: false Dec 13 01:38:21.821097 systemd[1]: Starting ssh-key-proc-cmdline.service - Install an ssh key from /proc/cmdline... Dec 13 01:38:21.823583 extend-filesystems[2166]: Found loop2 Dec 13 01:38:21.823583 extend-filesystems[2166]: Found loop3 Dec 13 01:38:21.823583 extend-filesystems[2166]: Found vda Dec 13 01:38:21.823583 extend-filesystems[2166]: Found vdb Dec 13 01:38:21.823583 extend-filesystems[2166]: Found vdb1 Dec 13 01:38:21.823583 extend-filesystems[2166]: Found vdb2 Dec 13 01:38:21.823583 extend-filesystems[2166]: Found vdb3 Dec 13 01:38:21.823583 extend-filesystems[2166]: Found usr Dec 13 01:38:21.823583 extend-filesystems[2166]: Found vdb4 Dec 13 01:38:21.823583 extend-filesystems[2166]: Found vdb6 Dec 13 01:38:21.823583 extend-filesystems[2166]: Found vdb7 Dec 13 01:38:21.823583 extend-filesystems[2166]: Found vdb9 Dec 13 01:38:21.823583 extend-filesystems[2166]: Found rootencrypted Dec 13 01:38:21.822873 systemd[1]: Starting sshd-keygen.service - Generate sshd host keys... Dec 13 01:38:21.829674 systemd[1]: Starting systemd-logind.service - User Login Management... Dec 13 01:38:21.836171 dbus-daemon[2164]: [system] SELinux support is enabled Dec 13 01:38:21.836979 systemd[1]: tcsd.service - TCG Core Services Daemon was skipped because of an unmet condition check (ConditionSecurity=!tpm2). Dec 13 01:38:21.837409 systemd[1]: cgroup compatibility translation between legacy and unified hierarchy settings activated. See cgroup-compat debug messages for details. Dec 13 01:38:21.848484 systemd[1]: Starting update-engine.service - Update Engine... Dec 13 01:38:21.850269 systemd[1]: Starting update-ssh-keys-after-ignition.service - Run update-ssh-keys once after Ignition... Dec 13 01:38:21.852786 systemd[1]: Started dbus.service - D-Bus System Message Bus. Dec 13 01:38:21.856146 jq[2181]: true Dec 13 01:38:21.856238 systemd[1]: Finished lvm2-activation.service - Activation of LVM2 logical volumes. Dec 13 01:38:21.861347 systemd[1]: enable-oem-cloudinit.service: Skipped due to 'exec-condition'. Dec 13 01:38:21.861511 systemd[1]: Condition check resulted in enable-oem-cloudinit.service - Enable cloudinit being skipped. Dec 13 01:38:21.861775 systemd[1]: extend-filesystems.service: Deactivated successfully. Dec 13 01:38:21.861909 systemd[1]: Finished extend-filesystems.service - Extend Filesystems. Dec 13 01:38:21.863990 systemd[1]: motdgen.service: Deactivated successfully. Dec 13 01:38:21.864171 systemd[1]: Finished motdgen.service - Generate /run/flatcar/motd. Dec 13 01:38:21.864618 systemd-logind[2173]: Watching system buttons on /dev/input/event0 (Power Button) Dec 13 01:38:21.867424 systemd-logind[2173]: New seat seat0. Dec 13 01:38:21.869005 systemd[1]: ssh-key-proc-cmdline.service: Deactivated successfully. Dec 13 01:38:21.869191 systemd[1]: Finished ssh-key-proc-cmdline.service - Install an ssh key from /proc/cmdline. Dec 13 01:38:21.872160 systemd[1]: Started systemd-logind.service - User Login Management. Dec 13 01:38:21.881878 jq[2183]: true Dec 13 01:38:21.883218 (ntainerd)[2184]: containerd.service: Referenced but unset environment variable evaluates to an empty string: TORCX_IMAGEDIR, TORCX_UNPACKDIR Dec 13 01:38:21.883405 dbus-daemon[2164]: [system] Successfully activated service 'org.freedesktop.systemd1' Dec 13 01:38:21.885236 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). Dec 13 01:38:21.885423 systemd[1]: Reached target system-config.target - Load system-provided cloud configs. Dec 13 01:38:21.886753 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). Dec 13 01:38:21.886868 systemd[1]: Reached target user-config.target - Load user-provided cloud configs. Dec 13 01:38:21.900433 update_engine[2180]: I20241213 01:38:21.900214 2180 main.cc:92] Flatcar Update Engine starting Dec 13 01:38:21.904870 update_engine[2180]: I20241213 01:38:21.904825 2180 update_check_scheduler.cc:74] Next update check in 4m11s Dec 13 01:38:21.905093 systemd[1]: Started update-engine.service - Update Engine. Dec 13 01:38:21.918869 systemd[1]: Started locksmithd.service - Cluster reboot manager. Dec 13 01:38:21.929768 bash[2208]: Updated "/home/core/.ssh/authorized_keys" Dec 13 01:38:21.931127 systemd[1]: Finished update-ssh-keys-after-ignition.service - Run update-ssh-keys once after Ignition. Dec 13 01:38:21.932827 systemd[1]: sshkeys.service was skipped because no trigger condition checks were met. Dec 13 01:38:21.951118 locksmithd[2209]: locksmithd starting currentOperation="UPDATE_STATUS_IDLE" strategy="reboot" Dec 13 01:38:22.054076 containerd[2184]: time="2024-12-13T01:38:22.053946730Z" level=info msg="starting containerd" revision=174e0d1785eeda18dc2beba45e1d5a188771636b version=v1.7.21 Dec 13 01:38:22.077128 containerd[2184]: time="2024-12-13T01:38:22.076945858Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.aufs\"..." type=io.containerd.snapshotter.v1 Dec 13 01:38:22.078153 containerd[2184]: time="2024-12-13T01:38:22.078123318Z" 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.65-flatcar\\n\"): skip plugin" type=io.containerd.snapshotter.v1 Dec 13 01:38:22.078547 containerd[2184]: time="2024-12-13T01:38:22.078211939Z" level=info msg="loading plugin \"io.containerd.event.v1.exchange\"..." type=io.containerd.event.v1 Dec 13 01:38:22.078547 containerd[2184]: time="2024-12-13T01:38:22.078230985Z" level=info msg="loading plugin \"io.containerd.internal.v1.opt\"..." type=io.containerd.internal.v1 Dec 13 01:38:22.078547 containerd[2184]: time="2024-12-13T01:38:22.078412178Z" level=info msg="loading plugin \"io.containerd.warning.v1.deprecations\"..." type=io.containerd.warning.v1 Dec 13 01:38:22.078547 containerd[2184]: time="2024-12-13T01:38:22.078430716Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.blockfile\"..." type=io.containerd.snapshotter.v1 Dec 13 01:38:22.078547 containerd[2184]: time="2024-12-13T01:38:22.078482027Z" level=info msg="skip loading plugin \"io.containerd.snapshotter.v1.blockfile\"..." error="no scratch file generator: skip plugin" type=io.containerd.snapshotter.v1 Dec 13 01:38:22.078547 containerd[2184]: time="2024-12-13T01:38:22.078493369Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.btrfs\"..." type=io.containerd.snapshotter.v1 Dec 13 01:38:22.078832 containerd[2184]: time="2024-12-13T01:38:22.078810935Z" 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 Dec 13 01:38:22.078894 containerd[2184]: time="2024-12-13T01:38:22.078881997Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.devmapper\"..." type=io.containerd.snapshotter.v1 Dec 13 01:38:22.078947 containerd[2184]: time="2024-12-13T01:38:22.078934716Z" level=info msg="skip loading plugin \"io.containerd.snapshotter.v1.devmapper\"..." error="devmapper not configured: skip plugin" type=io.containerd.snapshotter.v1 Dec 13 01:38:22.078993 containerd[2184]: time="2024-12-13T01:38:22.078982977Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.native\"..." type=io.containerd.snapshotter.v1 Dec 13 01:38:22.079132 containerd[2184]: time="2024-12-13T01:38:22.079116887Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.overlayfs\"..." type=io.containerd.snapshotter.v1 Dec 13 01:38:22.079404 systemd[1]: Created slice system-sshd.slice - Slice /system/sshd. Dec 13 01:38:22.079494 containerd[2184]: time="2024-12-13T01:38:22.079395813Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.zfs\"..." type=io.containerd.snapshotter.v1 Dec 13 01:38:22.079654 containerd[2184]: time="2024-12-13T01:38:22.079635396Z" 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 Dec 13 01:38:22.079708 containerd[2184]: time="2024-12-13T01:38:22.079696719Z" level=info msg="loading plugin \"io.containerd.content.v1.content\"..." type=io.containerd.content.v1 Dec 13 01:38:22.079852 containerd[2184]: time="2024-12-13T01:38:22.079836026Z" level=info msg="loading plugin \"io.containerd.metadata.v1.bolt\"..." type=io.containerd.metadata.v1 Dec 13 01:38:22.079946 containerd[2184]: time="2024-12-13T01:38:22.079933173Z" level=info msg="metadata content store policy set" policy=shared Dec 13 01:38:22.083676 containerd[2184]: time="2024-12-13T01:38:22.083652338Z" level=info msg="loading plugin \"io.containerd.gc.v1.scheduler\"..." type=io.containerd.gc.v1 Dec 13 01:38:22.083801 containerd[2184]: time="2024-12-13T01:38:22.083786014Z" level=info msg="loading plugin \"io.containerd.differ.v1.walking\"..." type=io.containerd.differ.v1 Dec 13 01:38:22.083923 containerd[2184]: time="2024-12-13T01:38:22.083909638Z" level=info msg="loading plugin \"io.containerd.lease.v1.manager\"..." type=io.containerd.lease.v1 Dec 13 01:38:22.084004 containerd[2184]: time="2024-12-13T01:38:22.083991102Z" level=info msg="loading plugin \"io.containerd.streaming.v1.manager\"..." type=io.containerd.streaming.v1 Dec 13 01:38:22.084140 containerd[2184]: time="2024-12-13T01:38:22.084064510Z" level=info msg="loading plugin \"io.containerd.runtime.v1.linux\"..." type=io.containerd.runtime.v1 Dec 13 01:38:22.084300 containerd[2184]: time="2024-12-13T01:38:22.084283991Z" level=info msg="loading plugin \"io.containerd.monitor.v1.cgroups\"..." type=io.containerd.monitor.v1 Dec 13 01:38:22.084733 containerd[2184]: time="2024-12-13T01:38:22.084704727Z" level=info msg="loading plugin \"io.containerd.runtime.v2.task\"..." type=io.containerd.runtime.v2 Dec 13 01:38:22.084922 containerd[2184]: time="2024-12-13T01:38:22.084905827Z" level=info msg="loading plugin \"io.containerd.runtime.v2.shim\"..." type=io.containerd.runtime.v2 Dec 13 01:38:22.085049 containerd[2184]: time="2024-12-13T01:38:22.084960501Z" level=info msg="loading plugin \"io.containerd.sandbox.store.v1.local\"..." type=io.containerd.sandbox.store.v1 Dec 13 01:38:22.085049 containerd[2184]: time="2024-12-13T01:38:22.084976575Z" level=info msg="loading plugin \"io.containerd.sandbox.controller.v1.local\"..." type=io.containerd.sandbox.controller.v1 Dec 13 01:38:22.085049 containerd[2184]: time="2024-12-13T01:38:22.084989872Z" level=info msg="loading plugin \"io.containerd.service.v1.containers-service\"..." type=io.containerd.service.v1 Dec 13 01:38:22.085049 containerd[2184]: time="2024-12-13T01:38:22.085002778Z" level=info msg="loading plugin \"io.containerd.service.v1.content-service\"..." type=io.containerd.service.v1 Dec 13 01:38:22.085165 containerd[2184]: time="2024-12-13T01:38:22.085141342Z" level=info msg="loading plugin \"io.containerd.service.v1.diff-service\"..." type=io.containerd.service.v1 Dec 13 01:38:22.085287 containerd[2184]: time="2024-12-13T01:38:22.085216627Z" level=info msg="loading plugin \"io.containerd.service.v1.images-service\"..." type=io.containerd.service.v1 Dec 13 01:38:22.085287 containerd[2184]: time="2024-12-13T01:38:22.085236143Z" level=info msg="loading plugin \"io.containerd.service.v1.introspection-service\"..." type=io.containerd.service.v1 Dec 13 01:38:22.085287 containerd[2184]: time="2024-12-13T01:38:22.085248071Z" level=info msg="loading plugin \"io.containerd.service.v1.namespaces-service\"..." type=io.containerd.service.v1 Dec 13 01:38:22.085287 containerd[2184]: time="2024-12-13T01:38:22.085260703Z" level=info msg="loading plugin \"io.containerd.service.v1.snapshots-service\"..." type=io.containerd.service.v1 Dec 13 01:38:22.085287 containerd[2184]: time="2024-12-13T01:38:22.085271537Z" level=info msg="loading plugin \"io.containerd.service.v1.tasks-service\"..." type=io.containerd.service.v1 Dec 13 01:38:22.085432 containerd[2184]: time="2024-12-13T01:38:22.085418900Z" level=info msg="loading plugin \"io.containerd.grpc.v1.containers\"..." type=io.containerd.grpc.v1 Dec 13 01:38:22.085553 containerd[2184]: time="2024-12-13T01:38:22.085480653Z" level=info msg="loading plugin \"io.containerd.grpc.v1.content\"..." type=io.containerd.grpc.v1 Dec 13 01:38:22.085553 containerd[2184]: time="2024-12-13T01:38:22.085497236Z" level=info msg="loading plugin \"io.containerd.grpc.v1.diff\"..." type=io.containerd.grpc.v1 Dec 13 01:38:22.085553 containerd[2184]: time="2024-12-13T01:38:22.085509242Z" level=info msg="loading plugin \"io.containerd.grpc.v1.events\"..." type=io.containerd.grpc.v1 Dec 13 01:38:22.085553 containerd[2184]: time="2024-12-13T01:38:22.085520936Z" level=info msg="loading plugin \"io.containerd.grpc.v1.images\"..." type=io.containerd.grpc.v1 Dec 13 01:38:22.085553 containerd[2184]: time="2024-12-13T01:38:22.085533333Z" level=info msg="loading plugin \"io.containerd.grpc.v1.introspection\"..." type=io.containerd.grpc.v1 Dec 13 01:38:22.085751 containerd[2184]: time="2024-12-13T01:38:22.085545379Z" level=info msg="loading plugin \"io.containerd.grpc.v1.leases\"..." type=io.containerd.grpc.v1 Dec 13 01:38:22.085751 containerd[2184]: time="2024-12-13T01:38:22.085680697Z" level=info msg="loading plugin \"io.containerd.grpc.v1.namespaces\"..." type=io.containerd.grpc.v1 Dec 13 01:38:22.085751 containerd[2184]: time="2024-12-13T01:38:22.085698882Z" level=info msg="loading plugin \"io.containerd.grpc.v1.sandbox-controllers\"..." type=io.containerd.grpc.v1 Dec 13 01:38:22.085751 containerd[2184]: time="2024-12-13T01:38:22.085713744Z" level=info msg="loading plugin \"io.containerd.grpc.v1.sandboxes\"..." type=io.containerd.grpc.v1 Dec 13 01:38:22.085846 containerd[2184]: time="2024-12-13T01:38:22.085725790Z" level=info msg="loading plugin \"io.containerd.grpc.v1.snapshots\"..." type=io.containerd.grpc.v1 Dec 13 01:38:22.085911 containerd[2184]: time="2024-12-13T01:38:22.085884416Z" level=info msg="loading plugin \"io.containerd.grpc.v1.streaming\"..." type=io.containerd.grpc.v1 Dec 13 01:38:22.085950 containerd[2184]: time="2024-12-13T01:38:22.085900920Z" level=info msg="loading plugin \"io.containerd.grpc.v1.tasks\"..." type=io.containerd.grpc.v1 Dec 13 01:38:22.086152 containerd[2184]: time="2024-12-13T01:38:22.085999280Z" level=info msg="loading plugin \"io.containerd.transfer.v1.local\"..." type=io.containerd.transfer.v1 Dec 13 01:38:22.086152 containerd[2184]: time="2024-12-13T01:38:22.086033501Z" level=info msg="loading plugin \"io.containerd.grpc.v1.transfer\"..." type=io.containerd.grpc.v1 Dec 13 01:38:22.086152 containerd[2184]: time="2024-12-13T01:38:22.086054815Z" level=info msg="loading plugin \"io.containerd.grpc.v1.version\"..." type=io.containerd.grpc.v1 Dec 13 01:38:22.086152 containerd[2184]: time="2024-12-13T01:38:22.086065766Z" level=info msg="loading plugin \"io.containerd.internal.v1.restart\"..." type=io.containerd.internal.v1 Dec 13 01:38:22.086308 containerd[2184]: time="2024-12-13T01:38:22.086274139Z" level=info msg="loading plugin \"io.containerd.tracing.processor.v1.otlp\"..." type=io.containerd.tracing.processor.v1 Dec 13 01:38:22.086546 containerd[2184]: time="2024-12-13T01:38:22.086294906Z" 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 Dec 13 01:38:22.086546 containerd[2184]: time="2024-12-13T01:38:22.086481222Z" level=info msg="loading plugin \"io.containerd.internal.v1.tracing\"..." type=io.containerd.internal.v1 Dec 13 01:38:22.086546 containerd[2184]: time="2024-12-13T01:38:22.086498900Z" level=info msg="skip loading plugin \"io.containerd.internal.v1.tracing\"..." error="skip plugin: tracing endpoint not configured" type=io.containerd.internal.v1 Dec 13 01:38:22.086546 containerd[2184]: time="2024-12-13T01:38:22.086507856Z" level=info msg="loading plugin \"io.containerd.grpc.v1.healthcheck\"..." type=io.containerd.grpc.v1 Dec 13 01:38:22.086546 containerd[2184]: time="2024-12-13T01:38:22.086527254Z" level=info msg="loading plugin \"io.containerd.nri.v1.nri\"..." type=io.containerd.nri.v1 Dec 13 01:38:22.086682 containerd[2184]: time="2024-12-13T01:38:22.086537109Z" level=info msg="NRI interface is disabled by configuration." Dec 13 01:38:22.086854 containerd[2184]: time="2024-12-13T01:38:22.086726593Z" level=info msg="loading plugin \"io.containerd.grpc.v1.cri\"..." type=io.containerd.grpc.v1 Dec 13 01:38:22.087418 containerd[2184]: time="2024-12-13T01:38:22.087333059Z" 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}" Dec 13 01:38:22.088136 containerd[2184]: time="2024-12-13T01:38:22.088013168Z" level=info msg="Connect containerd service" Dec 13 01:38:22.088136 containerd[2184]: time="2024-12-13T01:38:22.088088570Z" level=info msg="using legacy CRI server" Dec 13 01:38:22.088136 containerd[2184]: time="2024-12-13T01:38:22.088099325Z" level=info msg="using experimental NRI integration - disable nri plugin to prevent this" Dec 13 01:38:22.088557 containerd[2184]: time="2024-12-13T01:38:22.088456353Z" level=info msg="Get image filesystem path \"/var/lib/containerd/io.containerd.snapshotter.v1.overlayfs\"" Dec 13 01:38:22.089112 containerd[2184]: time="2024-12-13T01:38:22.089084916Z" 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" Dec 13 01:38:22.089313 containerd[2184]: time="2024-12-13T01:38:22.089277880Z" level=info msg="Start subscribing containerd event" Dec 13 01:38:22.089363 containerd[2184]: time="2024-12-13T01:38:22.089334823Z" level=info msg="Start recovering state" Dec 13 01:38:22.089416 containerd[2184]: time="2024-12-13T01:38:22.089397476Z" level=info msg="Start event monitor" Dec 13 01:38:22.089487 containerd[2184]: time="2024-12-13T01:38:22.089421411Z" level=info msg="Start snapshots syncer" Dec 13 01:38:22.089487 containerd[2184]: time="2024-12-13T01:38:22.089434591Z" level=info msg="Start cni network conf syncer for default" Dec 13 01:38:22.089487 containerd[2184]: time="2024-12-13T01:38:22.089442374Z" level=info msg="Start streaming server" Dec 13 01:38:22.089665 containerd[2184]: time="2024-12-13T01:38:22.089568227Z" level=info msg=serving... address=/run/containerd/containerd.sock.ttrpc Dec 13 01:38:22.089665 containerd[2184]: time="2024-12-13T01:38:22.089624036Z" level=info msg=serving... address=/run/containerd/containerd.sock Dec 13 01:38:22.089741 containerd[2184]: time="2024-12-13T01:38:22.089674447Z" level=info msg="containerd successfully booted in 0.036506s" Dec 13 01:38:22.089778 systemd[1]: Started containerd.service - containerd container runtime. Dec 13 01:38:22.423156 sshd_keygen[2179]: ssh-keygen: generating new host keys: RSA ECDSA ED25519 Dec 13 01:38:22.441240 systemd[1]: Finished sshd-keygen.service - Generate sshd host keys. Dec 13 01:38:22.453650 systemd[1]: Starting issuegen.service - Generate /run/issue... Dec 13 01:38:22.455369 systemd[1]: Started sshd@0-10.0.0.104:22-10.0.0.1:46240.service - OpenSSH per-connection server daemon (10.0.0.1:46240). Dec 13 01:38:22.458979 systemd[1]: issuegen.service: Deactivated successfully. Dec 13 01:38:22.459204 systemd[1]: Finished issuegen.service - Generate /run/issue. Dec 13 01:38:22.462616 systemd[1]: Starting systemd-user-sessions.service - Permit User Sessions... Dec 13 01:38:22.474885 systemd[1]: Finished systemd-user-sessions.service - Permit User Sessions. Dec 13 01:38:22.477508 systemd[1]: Started getty@tty1.service - Getty on tty1. Dec 13 01:38:22.479804 systemd[1]: Started serial-getty@ttyAMA0.service - Serial Getty on ttyAMA0. Dec 13 01:38:22.480907 systemd[1]: Reached target getty.target - Login Prompts. Dec 13 01:38:22.511165 sshd[2236]: Accepted publickey for core from 10.0.0.1 port 46240 ssh2: RSA SHA256:yVKhZEHbC7ylZ7bY3Y8pwdh1t/xp6Vz/y3yLFfd9j+Q Dec 13 01:38:22.512908 sshd[2236]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Dec 13 01:38:22.521529 systemd-logind[2173]: New session 1 of user core. Dec 13 01:38:22.522532 systemd[1]: Created slice user-500.slice - User Slice of UID 500. Dec 13 01:38:22.532550 systemd[1]: Starting user-runtime-dir@500.service - User Runtime Directory /run/user/500... Dec 13 01:38:22.541242 systemd[1]: Finished user-runtime-dir@500.service - User Runtime Directory /run/user/500. Dec 13 01:38:22.544251 systemd[1]: Starting user@500.service - User Manager for UID 500... Dec 13 01:38:22.553693 (systemd)[2247]: pam_unix(systemd-user:session): session opened for user core(uid=500) by (uid=0) Dec 13 01:38:22.652086 systemd[2247]: Queued start job for default target default.target. Dec 13 01:38:22.666376 systemd[2247]: Created slice app.slice - User Application Slice. Dec 13 01:38:22.666404 systemd[2247]: Reached target paths.target - Paths. Dec 13 01:38:22.666416 systemd[2247]: Reached target timers.target - Timers. Dec 13 01:38:22.667632 systemd[2247]: Starting dbus.socket - D-Bus User Message Bus Socket... Dec 13 01:38:22.677259 systemd[2247]: Listening on dbus.socket - D-Bus User Message Bus Socket. Dec 13 01:38:22.677332 systemd[2247]: Reached target sockets.target - Sockets. Dec 13 01:38:22.677346 systemd[2247]: Reached target basic.target - Basic System. Dec 13 01:38:22.677384 systemd[2247]: Reached target default.target - Main User Target. Dec 13 01:38:22.677409 systemd[2247]: Startup finished in 118ms. Dec 13 01:38:22.677693 systemd[1]: Started user@500.service - User Manager for UID 500. Dec 13 01:38:22.679677 systemd[1]: Started session-1.scope - Session 1 of User core. Dec 13 01:38:22.741391 systemd[1]: Started sshd@1-10.0.0.104:22-10.0.0.1:33058.service - OpenSSH per-connection server daemon (10.0.0.1:33058). Dec 13 01:38:22.782520 sshd[2258]: Accepted publickey for core from 10.0.0.1 port 33058 ssh2: RSA SHA256:yVKhZEHbC7ylZ7bY3Y8pwdh1t/xp6Vz/y3yLFfd9j+Q Dec 13 01:38:22.783801 sshd[2258]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Dec 13 01:38:22.787470 systemd-logind[2173]: New session 2 of user core. Dec 13 01:38:22.794457 systemd[1]: Started session-2.scope - Session 2 of User core. Dec 13 01:38:22.846193 sshd[2258]: pam_unix(sshd:session): session closed for user core Dec 13 01:38:22.852618 systemd[1]: sshd@1-10.0.0.104:22-10.0.0.1:33058.service: Deactivated successfully. Dec 13 01:38:22.854939 systemd[1]: session-2.scope: Deactivated successfully. Dec 13 01:38:22.856005 systemd-logind[2173]: Session 2 logged out. Waiting for processes to exit. Dec 13 01:38:22.857083 systemd[1]: Started sshd@2-10.0.0.104:22-10.0.0.1:33072.service - OpenSSH per-connection server daemon (10.0.0.1:33072). Dec 13 01:38:22.858852 systemd-logind[2173]: Removed session 2. Dec 13 01:38:22.893821 sshd[2265]: Accepted publickey for core from 10.0.0.1 port 33072 ssh2: RSA SHA256:yVKhZEHbC7ylZ7bY3Y8pwdh1t/xp6Vz/y3yLFfd9j+Q Dec 13 01:38:22.894988 sshd[2265]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Dec 13 01:38:22.898365 systemd-logind[2173]: New session 3 of user core. Dec 13 01:38:22.905474 systemd[1]: Started session-3.scope - Session 3 of User core. Dec 13 01:38:22.957268 sshd[2265]: pam_unix(sshd:session): session closed for user core Dec 13 01:38:22.960492 systemd[1]: sshd@2-10.0.0.104:22-10.0.0.1:33072.service: Deactivated successfully. Dec 13 01:38:22.962019 systemd[1]: session-3.scope: Deactivated successfully. Dec 13 01:38:22.962836 systemd-logind[2173]: Session 3 logged out. Waiting for processes to exit. Dec 13 01:38:22.963723 systemd-logind[2173]: Removed session 3. Dec 13 01:38:23.366477 systemd-networkd[2119]: eth0: Gained IPv6LL Dec 13 01:38:23.369437 systemd[1]: Finished systemd-networkd-wait-online.service - Wait for Network to be Configured. Dec 13 01:38:23.370923 systemd[1]: Reached target network-online.target - Network is Online. Dec 13 01:38:23.380572 systemd[1]: Starting coreos-metadata.service - QEMU metadata agent... Dec 13 01:38:23.382474 systemd[1]: Starting nvidia.service - NVIDIA Configure Service... Dec 13 01:38:23.398910 systemd[1]: coreos-metadata.service: Deactivated successfully. Dec 13 01:38:23.399113 systemd[1]: Finished coreos-metadata.service - QEMU metadata agent. Dec 13 01:38:23.400743 systemd[1]: packet-phone-home.service - Report Success to Packet was skipped because no trigger condition checks were met. Dec 13 01:38:23.406188 systemd[1]: Finished nvidia.service - NVIDIA Configure Service. Dec 13 01:38:23.407608 systemd[1]: Reached target multi-user.target - Multi-User System. Dec 13 01:38:23.425613 systemd[1]: Starting cryptenroll-helper-first.service... Dec 13 01:38:23.435697 systemd-cryptenroll[2285]: Warning: keyslot operation could fail as it requires more than available memory. Dec 13 01:38:25.482408 systemd-cryptenroll[2285]: New TPM2 token enrolled as key slot 1. Dec 13 01:38:32.850813 systemd[1]: Started sshd@3-10.0.0.104:22-10.0.0.1:58704.service - OpenSSH per-connection server daemon (10.0.0.1:58704). Dec 13 01:38:32.888034 sshd[2408]: Accepted publickey for core from 10.0.0.1 port 58704 ssh2: RSA SHA256:yVKhZEHbC7ylZ7bY3Y8pwdh1t/xp6Vz/y3yLFfd9j+Q Dec 13 01:38:32.889362 sshd[2408]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Dec 13 01:38:32.893383 systemd-logind[2173]: New session 4 of user core. Dec 13 01:38:32.907501 systemd[1]: Started session-4.scope - Session 4 of User core. Dec 13 01:38:32.958455 sshd[2408]: pam_unix(sshd:session): session closed for user core Dec 13 01:38:32.968643 systemd[1]: sshd@3-10.0.0.104:22-10.0.0.1:58704.service: Deactivated successfully. Dec 13 01:38:32.970734 systemd[1]: session-4.scope: Deactivated successfully. Dec 13 01:38:32.971906 systemd-logind[2173]: Session 4 logged out. Waiting for processes to exit. Dec 13 01:38:32.980595 systemd[1]: Started sshd@4-10.0.0.104:22-10.0.0.1:58710.service - OpenSSH per-connection server daemon (10.0.0.1:58710). Dec 13 01:38:32.981535 systemd-logind[2173]: Removed session 4. Dec 13 01:38:33.020981 sshd[2415]: Accepted publickey for core from 10.0.0.1 port 58710 ssh2: RSA SHA256:yVKhZEHbC7ylZ7bY3Y8pwdh1t/xp6Vz/y3yLFfd9j+Q Dec 13 01:38:33.022311 sshd[2415]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Dec 13 01:38:33.025948 systemd-logind[2173]: New session 5 of user core. Dec 13 01:38:33.037473 systemd[1]: Started session-5.scope - Session 5 of User core. Dec 13 01:38:33.089800 sshd[2415]: pam_unix(sshd:session): session closed for user core Dec 13 01:38:33.092107 systemd[1]: session-5.scope: Deactivated successfully. Dec 13 01:38:33.093359 systemd[1]: sshd@4-10.0.0.104:22-10.0.0.1:58710.service: Deactivated successfully. Dec 13 01:38:33.096467 systemd-logind[2173]: Session 5 logged out. Waiting for processes to exit. Dec 13 01:38:33.097414 systemd-logind[2173]: Removed session 5. -- Reboot -- Dec 13 01:40:09.896506 kernel: Booting Linux on physical CPU 0x0000000000 [0x413fd0c1] Dec 13 01:40:09.896528 kernel: Linux version 6.6.65-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 Thu Dec 12 23:24:21 -00 2024 Dec 13 01:40:09.896537 kernel: KASLR enabled Dec 13 01:40:09.896543 kernel: efi: EFI v2.7 by EDK II Dec 13 01:40:09.896550 kernel: efi: SMBIOS 3.0=0xdced0000 TPMFinalLog=0xd9740000 MEMATTR=0xdba82198 ACPI 2.0=0xd96e0018 TPMEventLog=0xd96e9098 RNG=0xd96ee698 MEMRESERVE=0xd9b43e18 Dec 13 01:40:09.896555 kernel: random: crng init done Dec 13 01:40:09.896563 kernel: ACPI: Early table checksum verification disabled Dec 13 01:40:09.896569 kernel: ACPI: RSDP 0x00000000D96E0018 000024 (v02 BOCHS ) Dec 13 01:40:09.896575 kernel: ACPI: XSDT 0x00000000D96EFE98 00006C (v01 BOCHS BXPC 00000001 01000013) Dec 13 01:40:09.896582 kernel: ACPI: FACP 0x00000000D96EFA98 000114 (v06 BOCHS BXPC 00000001 BXPC 00000001) Dec 13 01:40:09.896588 kernel: ACPI: DSDT 0x00000000D96E7518 0014EB (v02 BOCHS BXPC 00000001 BXPC 00000001) Dec 13 01:40:09.896594 kernel: ACPI: APIC 0x00000000D96EFC18 0001A8 (v04 BOCHS BXPC 00000001 BXPC 00000001) Dec 13 01:40:09.896600 kernel: ACPI: PPTT 0x00000000D96ED898 00009C (v02 BOCHS BXPC 00000001 BXPC 00000001) Dec 13 01:40:09.896606 kernel: ACPI: GTDT 0x00000000D96EE818 000060 (v02 BOCHS BXPC 00000001 BXPC 00000001) Dec 13 01:40:09.896614 kernel: ACPI: MCFG 0x00000000D96EE918 00003C (v01 BOCHS BXPC 00000001 BXPC 00000001) Dec 13 01:40:09.896621 kernel: ACPI: SPCR 0x00000000D96EFF98 000050 (v02 BOCHS BXPC 00000001 BXPC 00000001) Dec 13 01:40:09.896628 kernel: ACPI: DBG2 0x00000000D96EE418 000057 (v00 BOCHS BXPC 00000001 BXPC 00000001) Dec 13 01:40:09.896634 kernel: ACPI: IORT 0x00000000D96EE718 000080 (v03 BOCHS BXPC 00000001 BXPC 00000001) Dec 13 01:40:09.896641 kernel: ACPI: TPM2 0x00000000D96EE498 00004C (v04 BOCHS BXPC 00000001 BXPC 00000001) Dec 13 01:40:09.896647 kernel: ACPI: SPCR: console: pl011,mmio,0x9000000,9600 Dec 13 01:40:09.896653 kernel: NUMA: Failed to initialise from firmware Dec 13 01:40:09.896660 kernel: NUMA: Faking a node at [mem 0x0000000040000000-0x00000000dcffffff] Dec 13 01:40:09.896666 kernel: NUMA: NODE_DATA [mem 0xdc958800-0xdc95dfff] Dec 13 01:40:09.896672 kernel: Zone ranges: Dec 13 01:40:09.896678 kernel: DMA [mem 0x0000000040000000-0x00000000dcffffff] Dec 13 01:40:09.896686 kernel: DMA32 empty Dec 13 01:40:09.896692 kernel: Normal empty Dec 13 01:40:09.896698 kernel: Movable zone start for each node Dec 13 01:40:09.896704 kernel: Early memory node ranges Dec 13 01:40:09.896710 kernel: node 0: [mem 0x0000000040000000-0x00000000d962ffff] Dec 13 01:40:09.896717 kernel: node 0: [mem 0x00000000d9630000-0x00000000d963ffff] Dec 13 01:40:09.896723 kernel: node 0: [mem 0x00000000d9640000-0x00000000d973ffff] Dec 13 01:40:09.896729 kernel: node 0: [mem 0x00000000d9740000-0x00000000d9b3ffff] Dec 13 01:40:09.896736 kernel: node 0: [mem 0x00000000d9b40000-0x00000000dce1ffff] Dec 13 01:40:09.896742 kernel: node 0: [mem 0x00000000dce20000-0x00000000dceaffff] Dec 13 01:40:09.896748 kernel: node 0: [mem 0x00000000dceb0000-0x00000000dcebffff] Dec 13 01:40:09.896754 kernel: node 0: [mem 0x00000000dcec0000-0x00000000dcfdffff] Dec 13 01:40:09.896762 kernel: node 0: [mem 0x00000000dcfe0000-0x00000000dcffffff] Dec 13 01:40:09.896768 kernel: Initmem setup node 0 [mem 0x0000000040000000-0x00000000dcffffff] Dec 13 01:40:09.896775 kernel: On node 0, zone DMA: 12288 pages in unavailable ranges Dec 13 01:40:09.896784 kernel: psci: probing for conduit method from ACPI. Dec 13 01:40:09.896790 kernel: psci: PSCIv1.1 detected in firmware. Dec 13 01:40:09.896797 kernel: psci: Using standard PSCI v0.2 function IDs Dec 13 01:40:09.896805 kernel: psci: Trusted OS migration not required Dec 13 01:40:09.896812 kernel: psci: SMC Calling Convention v1.1 Dec 13 01:40:09.896818 kernel: smccc: KVM: hypervisor services detected (0x00000000 0x00000000 0x00000000 0x00000003) Dec 13 01:40:09.896825 kernel: percpu: Embedded 31 pages/cpu s86696 r8192 d32088 u126976 Dec 13 01:40:09.896832 kernel: pcpu-alloc: s86696 r8192 d32088 u126976 alloc=31*4096 Dec 13 01:40:09.896839 kernel: pcpu-alloc: [0] 0 [0] 1 [0] 2 [0] 3 Dec 13 01:40:09.896845 kernel: Detected PIPT I-cache on CPU0 Dec 13 01:40:09.896853 kernel: CPU features: detected: GIC system register CPU interface Dec 13 01:40:09.896860 kernel: CPU features: detected: Hardware dirty bit management Dec 13 01:40:09.896866 kernel: CPU features: detected: Spectre-v4 Dec 13 01:40:09.896875 kernel: CPU features: detected: Spectre-BHB Dec 13 01:40:09.896882 kernel: CPU features: kernel page table isolation forced ON by KASLR Dec 13 01:40:09.896889 kernel: CPU features: detected: Kernel page table isolation (KPTI) Dec 13 01:40:09.896895 kernel: CPU features: detected: ARM erratum 1418040 Dec 13 01:40:09.896902 kernel: CPU features: detected: SSBS not fully self-synchronizing Dec 13 01:40:09.896908 kernel: alternatives: applying boot alternatives Dec 13 01:40:09.896916 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=9494f75a68cfbdce95d0d2f9b58d6d75bc38ee5b4e31dfc2a6da695ffafefba6 Dec 13 01:40:09.896942 kernel: Unknown kernel command line parameters "BOOT_IMAGE=/flatcar/vmlinuz-a", will be passed to user space. Dec 13 01:40:09.896949 kernel: Dentry cache hash table entries: 524288 (order: 10, 4194304 bytes, linear) Dec 13 01:40:09.896956 kernel: Inode-cache hash table entries: 262144 (order: 9, 2097152 bytes, linear) Dec 13 01:40:09.896963 kernel: Fallback order for Node 0: 0 Dec 13 01:40:09.896972 kernel: Built 1 zonelists, mobility grouping on. Total pages: 633024 Dec 13 01:40:09.896978 kernel: Policy zone: DMA Dec 13 01:40:09.896985 kernel: mem auto-init: stack:off, heap alloc:off, heap free:off Dec 13 01:40:09.896992 kernel: software IO TLB: area num 4. Dec 13 01:40:09.896999 kernel: software IO TLB: mapped [mem 0x00000000d2e00000-0x00000000d6e00000] (64MB) Dec 13 01:40:09.897006 kernel: Memory: 2386276K/2572288K available (10240K kernel code, 2184K rwdata, 8096K rodata, 39360K init, 897K bss, 186012K reserved, 0K cma-reserved) Dec 13 01:40:09.897013 kernel: SLUB: HWalign=64, Order=0-3, MinObjects=0, CPUs=4, Nodes=1 Dec 13 01:40:09.897020 kernel: trace event string verifier disabled Dec 13 01:40:09.897026 kernel: rcu: Preemptible hierarchical RCU implementation. Dec 13 01:40:09.897034 kernel: rcu: RCU event tracing is enabled. Dec 13 01:40:09.897040 kernel: rcu: RCU restricting CPUs from NR_CPUS=512 to nr_cpu_ids=4. Dec 13 01:40:09.897049 kernel: Trampoline variant of Tasks RCU enabled. Dec 13 01:40:09.897055 kernel: Tracing variant of Tasks RCU enabled. Dec 13 01:40:09.897063 kernel: rcu: RCU calculated value of scheduler-enlistment delay is 100 jiffies. Dec 13 01:40:09.897070 kernel: rcu: Adjusting geometry for rcu_fanout_leaf=16, nr_cpu_ids=4 Dec 13 01:40:09.897076 kernel: NR_IRQS: 64, nr_irqs: 64, preallocated irqs: 0 Dec 13 01:40:09.897083 kernel: GICv3: 256 SPIs implemented Dec 13 01:40:09.897090 kernel: GICv3: 0 Extended SPIs implemented Dec 13 01:40:09.897096 kernel: Root IRQ handler: gic_handle_irq Dec 13 01:40:09.897103 kernel: GICv3: GICv3 features: 16 PPIs, DirectLPI Dec 13 01:40:09.897110 kernel: GICv3: CPU0: found redistributor 0 region 0:0x00000000080a0000 Dec 13 01:40:09.897116 kernel: ITS [mem 0x08080000-0x0809ffff] Dec 13 01:40:09.897124 kernel: ITS@0x0000000008080000: allocated 8192 Devices @400c0000 (indirect, esz 8, psz 64K, shr 1) Dec 13 01:40:09.897131 kernel: ITS@0x0000000008080000: allocated 8192 Interrupt Collections @400d0000 (flat, esz 8, psz 64K, shr 1) Dec 13 01:40:09.897138 kernel: GICv3: using LPI property table @0x00000000400f0000 Dec 13 01:40:09.897145 kernel: GICv3: CPU0: using allocated LPI pending table @0x0000000040100000 Dec 13 01:40:09.897152 kernel: rcu: srcu_init: Setting srcu_struct sizes based on contention. Dec 13 01:40:09.897159 kernel: arch_timer: Enabling local workaround for ARM erratum 1418040 Dec 13 01:40:09.897166 kernel: arch_timer: cp15 timer(s) running at 25.00MHz (virt). Dec 13 01:40:09.897172 kernel: clocksource: arch_sys_counter: mask: 0xffffffffffffff max_cycles: 0x5c40939b5, max_idle_ns: 440795202646 ns Dec 13 01:40:09.897184 kernel: sched_clock: 56 bits at 25MHz, resolution 40ns, wraps every 4398046511100ns Dec 13 01:40:09.897192 kernel: arm-pv: using stolen time PV Dec 13 01:40:09.897199 kernel: Console: colour dummy device 80x25 Dec 13 01:40:09.897206 kernel: ACPI: Core revision 20230628 Dec 13 01:40:09.897215 kernel: Calibrating delay loop (skipped), value calculated using timer frequency.. 50.00 BogoMIPS (lpj=25000) Dec 13 01:40:09.897222 kernel: pid_max: default: 32768 minimum: 301 Dec 13 01:40:09.897229 kernel: LSM: initializing lsm=lockdown,capability,landlock,selinux,integrity Dec 13 01:40:09.897236 kernel: landlock: Up and running. Dec 13 01:40:09.897243 kernel: SELinux: Initializing. Dec 13 01:40:09.897250 kernel: Mount-cache hash table entries: 8192 (order: 4, 65536 bytes, linear) Dec 13 01:40:09.897257 kernel: Mountpoint-cache hash table entries: 8192 (order: 4, 65536 bytes, linear) Dec 13 01:40:09.897264 kernel: RCU Tasks: Setting shift to 2 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=4. Dec 13 01:40:09.897271 kernel: RCU Tasks Trace: Setting shift to 2 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=4. Dec 13 01:40:09.897279 kernel: rcu: Hierarchical SRCU implementation. Dec 13 01:40:09.897286 kernel: rcu: Max phase no-delay instances is 400. Dec 13 01:40:09.897292 kernel: Platform MSI: ITS@0x8080000 domain created Dec 13 01:40:09.897299 kernel: PCI/MSI: ITS@0x8080000 domain created Dec 13 01:40:09.897306 kernel: Remapping and enabling EFI services. Dec 13 01:40:09.897313 kernel: smp: Bringing up secondary CPUs ... Dec 13 01:40:09.897320 kernel: Detected PIPT I-cache on CPU1 Dec 13 01:40:09.897327 kernel: GICv3: CPU1: found redistributor 1 region 0:0x00000000080c0000 Dec 13 01:40:09.897334 kernel: GICv3: CPU1: using allocated LPI pending table @0x0000000040110000 Dec 13 01:40:09.897342 kernel: arch_timer: Enabling local workaround for ARM erratum 1418040 Dec 13 01:40:09.897349 kernel: CPU1: Booted secondary processor 0x0000000001 [0x413fd0c1] Dec 13 01:40:09.897360 kernel: Detected PIPT I-cache on CPU2 Dec 13 01:40:09.897368 kernel: GICv3: CPU2: found redistributor 2 region 0:0x00000000080e0000 Dec 13 01:40:09.897375 kernel: GICv3: CPU2: using allocated LPI pending table @0x0000000040120000 Dec 13 01:40:09.897383 kernel: arch_timer: Enabling local workaround for ARM erratum 1418040 Dec 13 01:40:09.897390 kernel: CPU2: Booted secondary processor 0x0000000002 [0x413fd0c1] Dec 13 01:40:09.897397 kernel: Detected PIPT I-cache on CPU3 Dec 13 01:40:09.897404 kernel: GICv3: CPU3: found redistributor 3 region 0:0x0000000008100000 Dec 13 01:40:09.897412 kernel: GICv3: CPU3: using allocated LPI pending table @0x0000000040130000 Dec 13 01:40:09.897420 kernel: arch_timer: Enabling local workaround for ARM erratum 1418040 Dec 13 01:40:09.897427 kernel: CPU3: Booted secondary processor 0x0000000003 [0x413fd0c1] Dec 13 01:40:09.897434 kernel: smp: Brought up 1 node, 4 CPUs Dec 13 01:40:09.897441 kernel: SMP: Total of 4 processors activated. Dec 13 01:40:09.897448 kernel: CPU features: detected: 32-bit EL0 Support Dec 13 01:40:09.897456 kernel: CPU features: detected: Data cache clean to the PoU not required for I/D coherence Dec 13 01:40:09.897463 kernel: CPU features: detected: Common not Private translations Dec 13 01:40:09.897471 kernel: CPU features: detected: CRC32 instructions Dec 13 01:40:09.897478 kernel: CPU features: detected: Enhanced Virtualization Traps Dec 13 01:40:09.897486 kernel: CPU features: detected: RCpc load-acquire (LDAPR) Dec 13 01:40:09.897493 kernel: CPU features: detected: LSE atomic instructions Dec 13 01:40:09.897500 kernel: CPU features: detected: Privileged Access Never Dec 13 01:40:09.897507 kernel: CPU features: detected: RAS Extension Support Dec 13 01:40:09.897514 kernel: CPU features: detected: Speculative Store Bypassing Safe (SSBS) Dec 13 01:40:09.897521 kernel: CPU: All CPU(s) started at EL1 Dec 13 01:40:09.897528 kernel: alternatives: applying system-wide alternatives Dec 13 01:40:09.897537 kernel: devtmpfs: initialized Dec 13 01:40:09.897544 kernel: clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1911260446275000 ns Dec 13 01:40:09.897552 kernel: futex hash table entries: 1024 (order: 4, 65536 bytes, linear) Dec 13 01:40:09.897559 kernel: pinctrl core: initialized pinctrl subsystem Dec 13 01:40:09.897566 kernel: SMBIOS 3.0.0 present. Dec 13 01:40:09.897573 kernel: DMI: QEMU KVM Virtual Machine, BIOS edk2-20230524-3.fc38 05/24/2023 Dec 13 01:40:09.897580 kernel: NET: Registered PF_NETLINK/PF_ROUTE protocol family Dec 13 01:40:09.897588 kernel: DMA: preallocated 512 KiB GFP_KERNEL pool for atomic allocations Dec 13 01:40:09.897595 kernel: DMA: preallocated 512 KiB GFP_KERNEL|GFP_DMA pool for atomic allocations Dec 13 01:40:09.897604 kernel: DMA: preallocated 512 KiB GFP_KERNEL|GFP_DMA32 pool for atomic allocations Dec 13 01:40:09.897611 kernel: audit: initializing netlink subsys (disabled) Dec 13 01:40:09.897619 kernel: audit: type=2000 audit(0.023:1): state=initialized audit_enabled=0 res=1 Dec 13 01:40:09.897626 kernel: thermal_sys: Registered thermal governor 'step_wise' Dec 13 01:40:09.897633 kernel: cpuidle: using governor menu Dec 13 01:40:09.897640 kernel: hw-breakpoint: found 6 breakpoint and 4 watchpoint registers. Dec 13 01:40:09.897647 kernel: ASID allocator initialised with 32768 entries Dec 13 01:40:09.897655 kernel: acpiphp: ACPI Hot Plug PCI Controller Driver version: 0.5 Dec 13 01:40:09.897662 kernel: Serial: AMBA PL011 UART driver Dec 13 01:40:09.897670 kernel: Modules: 2G module region forced by RANDOMIZE_MODULE_REGION_FULL Dec 13 01:40:09.897677 kernel: Modules: 0 pages in range for non-PLT usage Dec 13 01:40:09.897684 kernel: Modules: 509040 pages in range for PLT usage Dec 13 01:40:09.897691 kernel: HugeTLB: registered 1.00 GiB page size, pre-allocated 0 pages Dec 13 01:40:09.897699 kernel: HugeTLB: 0 KiB vmemmap can be freed for a 1.00 GiB page Dec 13 01:40:09.897706 kernel: HugeTLB: registered 32.0 MiB page size, pre-allocated 0 pages Dec 13 01:40:09.897713 kernel: HugeTLB: 0 KiB vmemmap can be freed for a 32.0 MiB page Dec 13 01:40:09.897720 kernel: HugeTLB: registered 2.00 MiB page size, pre-allocated 0 pages Dec 13 01:40:09.897727 kernel: HugeTLB: 0 KiB vmemmap can be freed for a 2.00 MiB page Dec 13 01:40:09.897734 kernel: HugeTLB: registered 64.0 KiB page size, pre-allocated 0 pages Dec 13 01:40:09.897743 kernel: HugeTLB: 0 KiB vmemmap can be freed for a 64.0 KiB page Dec 13 01:40:09.897750 kernel: ACPI: Added _OSI(Module Device) Dec 13 01:40:09.897757 kernel: ACPI: Added _OSI(Processor Device) Dec 13 01:40:09.897764 kernel: ACPI: Added _OSI(3.0 _SCP Extensions) Dec 13 01:40:09.897771 kernel: ACPI: Added _OSI(Processor Aggregator Device) Dec 13 01:40:09.897779 kernel: ACPI: 1 ACPI AML tables successfully acquired and loaded Dec 13 01:40:09.897786 kernel: ACPI: Interpreter enabled Dec 13 01:40:09.897793 kernel: ACPI: Using GIC for interrupt routing Dec 13 01:40:09.897800 kernel: ACPI: MCFG table detected, 1 entries Dec 13 01:40:09.897809 kernel: ARMH0011:00: ttyAMA0 at MMIO 0x9000000 (irq = 12, base_baud = 0) is a SBSA Dec 13 01:40:09.897816 kernel: printk: console [ttyAMA0] enabled Dec 13 01:40:09.897823 kernel: ACPI: PCI Root Bridge [PCI0] (domain 0000 [bus 00-ff]) Dec 13 01:40:09.897992 kernel: acpi PNP0A08:00: _OSC: OS supports [ExtendedConfig ASPM ClockPM Segments MSI HPX-Type3] Dec 13 01:40:09.898070 kernel: acpi PNP0A08:00: _OSC: platform does not support [LTR] Dec 13 01:40:09.898136 kernel: acpi PNP0A08:00: _OSC: OS now controls [PCIeHotplug PME AER PCIeCapability] Dec 13 01:40:09.898215 kernel: acpi PNP0A08:00: ECAM area [mem 0x4010000000-0x401fffffff] reserved by PNP0C02:00 Dec 13 01:40:09.898287 kernel: acpi PNP0A08:00: ECAM at [mem 0x4010000000-0x401fffffff] for [bus 00-ff] Dec 13 01:40:09.898297 kernel: ACPI: Remapped I/O 0x000000003eff0000 to [io 0x0000-0xffff window] Dec 13 01:40:09.898304 kernel: PCI host bridge to bus 0000:00 Dec 13 01:40:09.898373 kernel: pci_bus 0000:00: root bus resource [mem 0x10000000-0x3efeffff window] Dec 13 01:40:09.898433 kernel: pci_bus 0000:00: root bus resource [io 0x0000-0xffff window] Dec 13 01:40:09.898490 kernel: pci_bus 0000:00: root bus resource [mem 0x8000000000-0xffffffffff window] Dec 13 01:40:09.898547 kernel: pci_bus 0000:00: root bus resource [bus 00-ff] Dec 13 01:40:09.898626 kernel: pci 0000:00:00.0: [1b36:0008] type 00 class 0x060000 Dec 13 01:40:09.898702 kernel: pci 0000:00:01.0: [1af4:1005] type 00 class 0x00ff00 Dec 13 01:40:09.898768 kernel: pci 0000:00:01.0: reg 0x10: [io 0x0000-0x001f] Dec 13 01:40:09.898833 kernel: pci 0000:00:01.0: reg 0x14: [mem 0x10000000-0x10000fff] Dec 13 01:40:09.898898 kernel: pci 0000:00:01.0: reg 0x20: [mem 0x8000000000-0x8000003fff 64bit pref] Dec 13 01:40:09.898985 kernel: pci 0000:00:01.0: BAR 4: assigned [mem 0x8000000000-0x8000003fff 64bit pref] Dec 13 01:40:09.899053 kernel: pci 0000:00:01.0: BAR 1: assigned [mem 0x10000000-0x10000fff] Dec 13 01:40:09.899122 kernel: pci 0000:00:01.0: BAR 0: assigned [io 0x1000-0x101f] Dec 13 01:40:09.899189 kernel: pci_bus 0000:00: resource 4 [mem 0x10000000-0x3efeffff window] Dec 13 01:40:09.899248 kernel: pci_bus 0000:00: resource 5 [io 0x0000-0xffff window] Dec 13 01:40:09.899306 kernel: pci_bus 0000:00: resource 6 [mem 0x8000000000-0xffffffffff window] Dec 13 01:40:09.899315 kernel: ACPI: PCI: Interrupt link GSI0 configured for IRQ 35 Dec 13 01:40:09.899323 kernel: ACPI: PCI: Interrupt link GSI1 configured for IRQ 36 Dec 13 01:40:09.899330 kernel: ACPI: PCI: Interrupt link GSI2 configured for IRQ 37 Dec 13 01:40:09.899340 kernel: ACPI: PCI: Interrupt link GSI3 configured for IRQ 38 Dec 13 01:40:09.899347 kernel: iommu: Default domain type: Translated Dec 13 01:40:09.899355 kernel: iommu: DMA domain TLB invalidation policy: strict mode Dec 13 01:40:09.899362 kernel: efivars: Registered efivars operations Dec 13 01:40:09.899369 kernel: vgaarb: loaded Dec 13 01:40:09.899376 kernel: clocksource: Switched to clocksource arch_sys_counter Dec 13 01:40:09.899383 kernel: VFS: Disk quotas dquot_6.6.0 Dec 13 01:40:09.899390 kernel: VFS: Dquot-cache hash table entries: 512 (order 0, 4096 bytes) Dec 13 01:40:09.899397 kernel: pnp: PnP ACPI init Dec 13 01:40:09.899471 kernel: system 00:00: [mem 0x4010000000-0x401fffffff window] could not be reserved Dec 13 01:40:09.899482 kernel: pnp: PnP ACPI: found 1 devices Dec 13 01:40:09.899489 kernel: NET: Registered PF_INET protocol family Dec 13 01:40:09.899497 kernel: IP idents hash table entries: 65536 (order: 7, 524288 bytes, linear) Dec 13 01:40:09.899504 kernel: tcp_listen_portaddr_hash hash table entries: 2048 (order: 3, 32768 bytes, linear) Dec 13 01:40:09.899511 kernel: Table-perturb hash table entries: 65536 (order: 6, 262144 bytes, linear) Dec 13 01:40:09.899519 kernel: TCP established hash table entries: 32768 (order: 6, 262144 bytes, linear) Dec 13 01:40:09.899526 kernel: TCP bind hash table entries: 32768 (order: 8, 1048576 bytes, linear) Dec 13 01:40:09.899533 kernel: TCP: Hash tables configured (established 32768 bind 32768) Dec 13 01:40:09.899543 kernel: UDP hash table entries: 2048 (order: 4, 65536 bytes, linear) Dec 13 01:40:09.899550 kernel: UDP-Lite hash table entries: 2048 (order: 4, 65536 bytes, linear) Dec 13 01:40:09.899557 kernel: NET: Registered PF_UNIX/PF_LOCAL protocol family Dec 13 01:40:09.899565 kernel: PCI: CLS 0 bytes, default 64 Dec 13 01:40:09.899572 kernel: kvm [1]: HYP mode not available Dec 13 01:40:09.899579 kernel: Initialise system trusted keyrings Dec 13 01:40:09.899586 kernel: workingset: timestamp_bits=39 max_order=20 bucket_order=0 Dec 13 01:40:09.899593 kernel: Key type asymmetric registered Dec 13 01:40:09.899600 kernel: Asymmetric key parser 'x509' registered Dec 13 01:40:09.899609 kernel: Block layer SCSI generic (bsg) driver version 0.4 loaded (major 250) Dec 13 01:40:09.899616 kernel: io scheduler mq-deadline registered Dec 13 01:40:09.899623 kernel: io scheduler kyber registered Dec 13 01:40:09.899630 kernel: io scheduler bfq registered Dec 13 01:40:09.899638 kernel: input: Power Button as /devices/LNXSYSTM:00/LNXSYBUS:00/PNP0C0C:00/input/input0 Dec 13 01:40:09.899645 kernel: ACPI: button: Power Button [PWRB] Dec 13 01:40:09.899652 kernel: ACPI: \_SB_.PCI0.GSI1: Enabled at IRQ 36 Dec 13 01:40:09.899719 kernel: virtio-pci 0000:00:01.0: enabling device (0005 -> 0007) Dec 13 01:40:09.899729 kernel: Serial: 8250/16550 driver, 4 ports, IRQ sharing enabled Dec 13 01:40:09.899737 kernel: thunder_xcv, ver 1.0 Dec 13 01:40:09.899744 kernel: thunder_bgx, ver 1.0 Dec 13 01:40:09.899752 kernel: nicpf, ver 1.0 Dec 13 01:40:09.899759 kernel: nicvf, ver 1.0 Dec 13 01:40:09.899831 kernel: rtc-efi rtc-efi.0: registered as rtc0 Dec 13 01:40:09.899893 kernel: rtc-efi rtc-efi.0: setting system clock to 2024-12-13T01:40:09 UTC (1734054009) Dec 13 01:40:09.899903 kernel: hid: raw HID events driver (C) Jiri Kosina Dec 13 01:40:09.899910 kernel: hw perfevents: enabled with armv8_pmuv3_0 PMU driver, 7 counters available Dec 13 01:40:09.900010 kernel: watchdog: Delayed init of the lockup detector failed: -19 Dec 13 01:40:09.900019 kernel: watchdog: Hard watchdog permanently disabled Dec 13 01:40:09.900027 kernel: NET: Registered PF_INET6 protocol family Dec 13 01:40:09.900034 kernel: Segment Routing with IPv6 Dec 13 01:40:09.900041 kernel: In-situ OAM (IOAM) with IPv6 Dec 13 01:40:09.900049 kernel: NET: Registered PF_PACKET protocol family Dec 13 01:40:09.900056 kernel: Key type dns_resolver registered Dec 13 01:40:09.900063 kernel: registered taskstats version 1 Dec 13 01:40:09.900070 kernel: Loading compiled-in X.509 certificates Dec 13 01:40:09.900081 kernel: Loaded X.509 cert 'Kinvolk GmbH: Module signing key for 6.6.65-flatcar: d83da9ddb9e3c2439731828371f21d0232fd9ffb' Dec 13 01:40:09.900088 kernel: Key type .fscrypt registered Dec 13 01:40:09.900095 kernel: Key type fscrypt-provisioning registered Dec 13 01:40:09.900103 kernel: ima: No TPM chip found, activating TPM-bypass! Dec 13 01:40:09.900110 kernel: ima: Allocated hash algorithm: sha1 Dec 13 01:40:09.900117 kernel: ima: No architecture policies found Dec 13 01:40:09.900125 kernel: alg: No test for fips(ansi_cprng) (fips_ansi_cprng) Dec 13 01:40:09.900132 kernel: clk: Disabling unused clocks Dec 13 01:40:09.900139 kernel: Freeing unused kernel memory: 39360K Dec 13 01:40:09.900147 kernel: Run /init as init process Dec 13 01:40:09.900154 kernel: with arguments: Dec 13 01:40:09.900162 kernel: /init Dec 13 01:40:09.900169 kernel: with environment: Dec 13 01:40:09.900175 kernel: HOME=/ Dec 13 01:40:09.900190 kernel: TERM=linux Dec 13 01:40:09.900197 kernel: BOOT_IMAGE=/flatcar/vmlinuz-a Dec 13 01:40:09.900207 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) Dec 13 01:40:09.900218 systemd[1]: Detected virtualization kvm. Dec 13 01:40:09.900226 systemd[1]: Detected architecture arm64. Dec 13 01:40:09.900233 systemd[1]: Running in initrd. Dec 13 01:40:09.900241 systemd[1]: No hostname configured, using default hostname. Dec 13 01:40:09.900248 systemd[1]: Hostname set to . Dec 13 01:40:09.900256 systemd[1]: Initializing machine ID from VM UUID. Dec 13 01:40:09.900264 systemd[1]: Queued start job for default target initrd.target. Dec 13 01:40:09.900272 systemd[1]: Started clevis-luks-askpass.path - Forward Password Requests to Clevis Directory Watch. Dec 13 01:40:09.900281 systemd[1]: Started systemd-ask-password-console.path - Dispatch Password Requests to Console Directory Watch. Dec 13 01:40:09.900290 systemd[1]: Expecting device dev-disk-by\x2dlabel-OEM.device - /dev/disk/by-label/OEM... Dec 13 01:40:09.900298 systemd[1]: Expecting device dev-disk-by\x2dlabel-ROOT.device - /dev/disk/by-label/ROOT... Dec 13 01:40:09.900306 systemd[1]: Expecting device dev-disk-by\x2dpartlabel-USR\x2dA.device - /dev/disk/by-partlabel/USR-A... Dec 13 01:40:09.900314 systemd[1]: Expecting device dev-disk-by\x2dpartuuid-7130c94a\x2d213a\x2d4e5a\x2d8e26\x2d6cce9662f132.device - /dev/disk/by-partuuid/7130c94a-213a-4e5a-8e26-6cce9662f132... Dec 13 01:40:09.900323 systemd[1]: Expecting device dev-mapper-usr.device - /dev/mapper/usr... Dec 13 01:40:09.900332 systemd[1]: Reached target cryptsetup-pre.target - Local Encrypted Volumes (Pre). Dec 13 01:40:09.900340 systemd[1]: Reached target cryptsetup.target - Local Encrypted Volumes. Dec 13 01:40:09.900348 systemd[1]: Reached target ignition-diskful-subsequent.target - Ignition Subsequent Boot Disk Setup. Dec 13 01:40:09.900356 systemd[1]: Reached target paths.target - Path Units. Dec 13 01:40:09.900363 systemd[1]: Reached target slices.target - Slice Units. Dec 13 01:40:09.900371 systemd[1]: Reached target swap.target - Swaps. Dec 13 01:40:09.900379 systemd[1]: Reached target timers.target - Timer Units. Dec 13 01:40:09.900387 systemd[1]: Listening on iscsid.socket - Open-iSCSI iscsid Socket. Dec 13 01:40:09.900395 systemd[1]: Listening on iscsiuio.socket - Open-iSCSI iscsiuio Socket. Dec 13 01:40:09.900404 systemd[1]: Listening on systemd-journald-dev-log.socket - Journal Socket (/dev/log). Dec 13 01:40:09.900412 systemd[1]: Listening on systemd-journald.socket - Journal Socket. Dec 13 01:40:09.900419 systemd[1]: Listening on systemd-udevd-control.socket - udev Control Socket. Dec 13 01:40:09.900427 systemd[1]: Listening on systemd-udevd-kernel.socket - udev Kernel Socket. Dec 13 01:40:09.900435 systemd[1]: Reached target sockets.target - Socket Units. Dec 13 01:40:09.900443 systemd[1]: Starting ignition-setup-pre.service - Ignition env setup... Dec 13 01:40:09.900451 systemd[1]: Starting kmod-static-nodes.service - Create List of Static Device Nodes... Dec 13 01:40:09.900459 systemd[1]: Starting systemd-fsck-usr.service... Dec 13 01:40:09.900468 systemd[1]: Starting systemd-journald.service - Journal Service... Dec 13 01:40:09.900476 systemd[1]: Starting systemd-modules-load.service - Load Kernel Modules... Dec 13 01:40:09.900484 systemd[1]: Starting systemd-vconsole-setup.service - Virtual Console Setup... Dec 13 01:40:09.900492 systemd[1]: Finished ignition-setup-pre.service - Ignition env setup. Dec 13 01:40:09.900499 systemd[1]: Finished kmod-static-nodes.service - Create List of Static Device Nodes. Dec 13 01:40:09.900507 systemd[1]: Finished systemd-fsck-usr.service. Dec 13 01:40:09.900515 systemd[1]: Starting systemd-tmpfiles-setup-dev-early.service - Create Static Device Nodes in /dev gracefully... Dec 13 01:40:09.900543 systemd-journald[230]: Collecting audit messages is disabled. Dec 13 01:40:09.900564 systemd[1]: Finished systemd-tmpfiles-setup-dev-early.service - Create Static Device Nodes in /dev gracefully. Dec 13 01:40:09.900572 systemd[1]: Finished systemd-vconsole-setup.service - Virtual Console Setup. Dec 13 01:40:09.900582 systemd-journald[230]: Journal started Dec 13 01:40:09.900601 systemd-journald[230]: Runtime Journal (/run/log/journal/a26735c2eb1c46a89ff13038877df638) is 5.9M, max 47.3M, 41.4M free. Dec 13 01:40:09.908997 kernel: bridge: filtering via arp/ip/ip6tables is no longer available by default. Update your scripts to load br_netfilter if you need this. Dec 13 01:40:09.909023 kernel: Bridge firewalling registered Dec 13 01:40:09.895015 systemd-modules-load[233]: Inserted module 'overlay' Dec 13 01:40:09.911391 systemd[1]: Starting dracut-cmdline-ask.service - dracut ask for additional cmdline parameters... Dec 13 01:40:09.909268 systemd-modules-load[233]: Inserted module 'br_netfilter' Dec 13 01:40:09.913561 systemd[1]: Starting systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev... Dec 13 01:40:09.915154 systemd[1]: Started systemd-journald.service - Journal Service. Dec 13 01:40:09.915327 systemd[1]: Finished systemd-modules-load.service - Load Kernel Modules. Dec 13 01:40:09.920071 systemd[1]: Starting systemd-sysctl.service - Apply Kernel Variables... Dec 13 01:40:09.922114 systemd[1]: Starting systemd-tmpfiles-setup.service - Create System Files and Directories... Dec 13 01:40:09.924947 systemd[1]: Finished systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev. Dec 13 01:40:09.927390 systemd[1]: Finished dracut-cmdline-ask.service - dracut ask for additional cmdline parameters. Dec 13 01:40:09.929802 systemd[1]: Starting dracut-cmdline.service - dracut cmdline hook... Dec 13 01:40:09.933969 systemd[1]: Finished systemd-sysctl.service - Apply Kernel Variables. Dec 13 01:40:09.935064 systemd[1]: Finished systemd-tmpfiles-setup.service - Create System Files and Directories. Dec 13 01:40:09.956639 dracut-cmdline[266]: dracut-dracut-053 Dec 13 01:40:09.958970 dracut-cmdline[266]: 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=9494f75a68cfbdce95d0d2f9b58d6d75bc38ee5b4e31dfc2a6da695ffafefba6 Dec 13 01:40:10.028006 kernel: SCSI subsystem initialized Dec 13 01:40:10.032943 kernel: Loading iSCSI transport class v2.0-870. Dec 13 01:40:10.041086 kernel: iscsi: registered transport (tcp) Dec 13 01:40:10.055985 kernel: iscsi: registered transport (qla4xxx) Dec 13 01:40:10.056019 kernel: QLogic iSCSI HBA Driver Dec 13 01:40:10.105856 systemd[1]: Finished dracut-cmdline.service - dracut cmdline hook. Dec 13 01:40:10.121209 systemd[1]: Starting dracut-pre-udev.service - dracut pre-udev hook... Dec 13 01:40:10.139402 kernel: device-mapper: core: CONFIG_IMA_DISABLE_HTABLE is disabled. Duplicate IMA measurements will not be recorded in the IMA log. Dec 13 01:40:10.139453 kernel: device-mapper: uevent: version 1.0.3 Dec 13 01:40:10.139464 kernel: device-mapper: ioctl: 4.48.0-ioctl (2023-03-01) initialised: dm-devel@redhat.com Dec 13 01:40:10.194955 kernel: raid6: neonx8 gen() 15439 MB/s Dec 13 01:40:10.211941 kernel: raid6: neonx4 gen() 15641 MB/s Dec 13 01:40:10.228952 kernel: raid6: neonx2 gen() 13230 MB/s Dec 13 01:40:10.245937 kernel: raid6: neonx1 gen() 10492 MB/s Dec 13 01:40:10.262943 kernel: raid6: int64x8 gen() 6958 MB/s Dec 13 01:40:10.279945 kernel: raid6: int64x4 gen() 7324 MB/s Dec 13 01:40:10.296945 kernel: raid6: int64x2 gen() 6127 MB/s Dec 13 01:40:10.313945 kernel: raid6: int64x1 gen() 5056 MB/s Dec 13 01:40:10.313972 kernel: raid6: using algorithm neonx4 gen() 15641 MB/s Dec 13 01:40:10.330951 kernel: raid6: .... xor() 12087 MB/s, rmw enabled Dec 13 01:40:10.330978 kernel: raid6: using neon recovery algorithm Dec 13 01:40:10.335939 kernel: xor: measuring software checksum speed Dec 13 01:40:10.335960 kernel: 8regs : 19826 MB/sec Dec 13 01:40:10.337384 kernel: 32regs : 18251 MB/sec Dec 13 01:40:10.337421 kernel: arm64_neon : 26919 MB/sec Dec 13 01:40:10.337440 kernel: xor: using function: arm64_neon (26919 MB/sec) Dec 13 01:40:10.386951 kernel: Btrfs loaded, zoned=no, fsverity=no Dec 13 01:40:10.397902 systemd[1]: Finished dracut-pre-udev.service - dracut pre-udev hook. Dec 13 01:40:10.407086 systemd[1]: Starting systemd-udevd.service - Rule-based Manager for Device Events and Files... Dec 13 01:40:10.421420 systemd-udevd[454]: Using default interface naming scheme 'v255'. Dec 13 01:40:10.424576 systemd[1]: Started systemd-udevd.service - Rule-based Manager for Device Events and Files. Dec 13 01:40:10.438352 systemd[1]: Starting dracut-pre-trigger.service - dracut pre-trigger hook... Dec 13 01:40:10.453106 dracut-pre-trigger[457]: rd.md=0: removing MD RAID activation Dec 13 01:40:10.482063 systemd[1]: Finished dracut-pre-trigger.service - dracut pre-trigger hook. Dec 13 01:40:10.493218 systemd[1]: Starting systemd-udev-trigger.service - Coldplug All udev Devices... Dec 13 01:40:10.534473 systemd[1]: Finished systemd-udev-trigger.service - Coldplug All udev Devices. Dec 13 01:40:10.540107 systemd[1]: Starting dracut-initqueue.service - dracut initqueue hook... Dec 13 01:40:10.550538 systemd[1]: Finished dracut-initqueue.service - dracut initqueue hook. Dec 13 01:40:10.552122 systemd[1]: Reached target remote-fs-pre.target - Preparation for Remote File Systems. Dec 13 01:40:10.553333 systemd[1]: Reached target remote-cryptsetup.target - Remote Encrypted Volumes. Dec 13 01:40:10.555207 systemd[1]: Reached target remote-fs.target - Remote File Systems. Dec 13 01:40:10.563109 systemd[1]: Starting dracut-pre-mount.service - dracut pre-mount hook... Dec 13 01:40:10.571690 systemd[1]: Finished dracut-pre-mount.service - dracut pre-mount hook. Dec 13 01:40:10.575952 kernel: tpm_tis MSFT0101:00: 2.0 TPM (device-id 0x1, rev-id 1) Dec 13 01:40:10.587949 kernel: virtio_blk virtio1: 1/0/0 default/read/poll queues Dec 13 01:40:10.590876 kernel: virtio_blk virtio1: [vda] 1064960 512-byte logical blocks (545 MB/520 MiB) Dec 13 01:40:10.591001 kernel: virtio_blk virtio2: 1/0/0 default/read/poll queues Dec 13 01:40:10.599493 kernel: virtio_blk virtio2: [vdb] 9289728 512-byte logical blocks (4.76 GB/4.43 GiB) Dec 13 01:40:10.599599 kernel: vdb: vdb1 vdb2 vdb3 vdb4 vdb6 vdb7 vdb9 Dec 13 01:40:10.591191 systemd[1]: dracut-cmdline-ask.service: Deactivated successfully. Dec 13 01:40:10.591296 systemd[1]: Stopped dracut-cmdline-ask.service - dracut ask for additional cmdline parameters. Dec 13 01:40:10.594189 systemd[1]: Stopping dracut-cmdline-ask.service - dracut ask for additional cmdline parameters... Dec 13 01:40:10.595196 systemd[1]: systemd-vconsole-setup.service: Deactivated successfully. Dec 13 01:40:10.595329 systemd[1]: Stopped systemd-vconsole-setup.service - Virtual Console Setup. Dec 13 01:40:10.597067 systemd[1]: Stopping systemd-vconsole-setup.service - Virtual Console Setup... Dec 13 01:40:10.602863 systemd[1]: Starting systemd-vconsole-setup.service - Virtual Console Setup... Dec 13 01:40:10.616426 systemd[1]: Finished systemd-vconsole-setup.service - Virtual Console Setup. Dec 13 01:40:10.620470 kernel: BTRFS: device fsid 2893cd1e-612b-4262-912c-10787dc9c881 devid 1 transid 46 /dev/vdb3 scanned by (udev-worker) (516) Dec 13 01:40:10.620491 kernel: BTRFS: device label OEM devid 1 transid 18 /dev/vdb6 scanned by (udev-worker) (514) Dec 13 01:40:10.638128 systemd[1]: Found device dev-disk-by\x2dpartuuid-7130c94a\x2d213a\x2d4e5a\x2d8e26\x2d6cce9662f132.device - /dev/disk/by-partuuid/7130c94a-213a-4e5a-8e26-6cce9662f132. Dec 13 01:40:10.639019 systemd[1]: Found device dev-disk-by\x2dpartlabel-USR\x2dA.device - /dev/disk/by-partlabel/USR-A. Dec 13 01:40:10.644407 systemd[1]: Found device dev-disk-by\x2dlabel-OEM.device - /dev/disk/by-label/OEM. Dec 13 01:40:10.660122 systemd[1]: Starting decrypt-root.service - Generate and execute a systemd-cryptsetup service to decrypt the ROOT partition... Dec 13 01:40:10.661619 systemd[1]: Starting disk-uuid.service - Generate new UUID for disk GPT if necessary... Dec 13 01:40:10.664100 systemd[1]: Starting dracut-cmdline-ask.service - dracut ask for additional cmdline parameters... Dec 13 01:40:10.667943 systemd[1]: disk-uuid.service: Deactivated successfully. Dec 13 01:40:10.668757 systemd[1]: Finished disk-uuid.service - Generate new UUID for disk GPT if necessary. Dec 13 01:40:10.671091 systemd[1]: Reached target local-fs-pre.target - Preparation for Local File Systems. Dec 13 01:40:10.672764 systemd[1]: Reached target local-fs.target - Local File Systems. Dec 13 01:40:10.673473 systemd[1]: Reached target sysinit.target - System Initialization. Dec 13 01:40:10.674159 systemd[1]: Reached target basic.target - Basic System. Dec 13 01:40:10.676860 systemd[1]: Starting verity-setup.service - Verity Setup for /dev/mapper/usr... Dec 13 01:40:10.679530 systemd[1]: Reloading requested from client PID 545 ('systemctl') (unit decrypt-root.service)... Dec 13 01:40:10.679543 systemd[1]: Reloading... Dec 13 01:40:10.682109 sh[559]: Success Dec 13 01:40:10.702939 kernel: device-mapper: verity: sha256 using implementation "sha256-ce" Dec 13 01:40:10.801740 systemd[1]: Found device dev-mapper-usr.device - /dev/mapper/usr. Dec 13 01:40:10.802667 systemd[1]: Reloading finished in 122 ms. Dec 13 01:40:10.815976 systemd[1]: Finished dracut-cmdline-ask.service - dracut ask for additional cmdline parameters. Dec 13 01:40:10.830897 systemd[1]: Finished verity-setup.service - Verity Setup for /dev/mapper/usr. Dec 13 01:40:10.833670 systemd[1]: Created slice system-systemd\x2dcryptsetup.slice - Slice /system/systemd-cryptsetup. Dec 13 01:40:10.836380 systemd[1]: Mounting sysusr-usr.mount - /sysusr/usr... Dec 13 01:40:10.837704 systemd[1]: Starting systemd-cryptsetup@rootencrypted.service - Cryptography Setup for rootencrypted... Dec 13 01:40:10.846977 kernel: BTRFS info (device dm-0): first mount of filesystem 2893cd1e-612b-4262-912c-10787dc9c881 Dec 13 01:40:10.847012 kernel: BTRFS info (device dm-0): using crc32c (crc32c-generic) checksum algorithm Dec 13 01:40:10.847029 kernel: BTRFS warning (device dm-0): 'nologreplay' is deprecated, use 'rescue=nologreplay' instead Dec 13 01:40:10.848827 kernel: BTRFS info (device dm-0): disabling log replay at mount time Dec 13 01:40:10.848888 kernel: BTRFS info (device dm-0): using free space tree Dec 13 01:40:10.852683 systemd[1]: Mounted sysusr-usr.mount - /sysusr/usr. Dec 13 01:40:11.133959 kernel: Key type trusted registered Dec 13 01:40:11.135956 kernel: Key type encrypted registered Dec 13 01:40:11.156507 systemd[1]: Found device dev-disk-by\x2dlabel-ROOT.device - /dev/disk/by-label/ROOT. Dec 13 01:40:11.158079 systemd[1]: Finished systemd-cryptsetup@rootencrypted.service - Cryptography Setup for rootencrypted. Dec 13 01:40:11.160083 systemd[1]: Reached target initrd-root-device.target - Initrd Root Device. Dec 13 01:40:11.170159 systemd[1]: Starting systemd-fsck-root.service - File System Check on /dev/disk/by-label/ROOT... Dec 13 01:40:11.171230 systemd[1]: Finished decrypt-root.service - Generate and execute a systemd-cryptsetup service to decrypt the ROOT partition. Dec 13 01:40:11.181750 systemd-fsck[708]: ROOT: clean, 203/137360 files, 32933/549376 blocks Dec 13 01:40:11.184428 systemd[1]: Finished systemd-fsck-root.service - File System Check on /dev/disk/by-label/ROOT. Dec 13 01:40:11.197010 systemd[1]: Mounting sysroot.mount - /sysroot... Dec 13 01:40:11.242801 systemd[1]: Mounted sysroot.mount - /sysroot. Dec 13 01:40:11.243940 kernel: EXT4-fs (dm-1): mounted filesystem 290a8d7f-7418-49a6-bfbd-0417856e1f12 r/w with ordered data mode. Quota mode: none. Dec 13 01:40:11.243823 systemd[1]: Reached target initrd-root-fs.target - Initrd Root File System. Dec 13 01:40:11.254003 systemd[1]: Mounting sysroot-oem.mount - /sysroot/oem... Dec 13 01:40:11.255545 systemd[1]: Mounting sysroot-usr.mount - /sysroot/usr... Dec 13 01:40:11.261178 kernel: BTRFS info (device vdb6): first mount of filesystem dbef6a22-a801-4c1e-a0cd-3fc525f899dd Dec 13 01:40:11.261206 kernel: BTRFS info (device vdb6): using crc32c (crc32c-generic) checksum algorithm Dec 13 01:40:11.261217 kernel: BTRFS info (device vdb6): using free space tree Dec 13 01:40:11.261859 systemd[1]: Mounted sysroot-usr.mount - /sysroot/usr. Dec 13 01:40:11.263667 systemd[1]: Starting initrd-setup-root.service - Root filesystem setup... Dec 13 01:40:11.266004 kernel: BTRFS info (device vdb6): auto enabling async discard Dec 13 01:40:11.266907 systemd[1]: Mounted sysroot-oem.mount - /sysroot/oem. Dec 13 01:40:11.568941 systemd[1]: Finished initrd-setup-root.service - Root filesystem setup. Dec 13 01:40:11.580080 systemd[1]: Starting initrd-setup-root-after-ignition.service - Root filesystem completion... Dec 13 01:40:11.584303 initrd-setup-root-after-ignition[1018]: grep: /sysroot/oem/oem-release: No such file or directory Dec 13 01:40:11.586454 initrd-setup-root-after-ignition[1020]: grep: /sysroot/etc/flatcar/enabled-sysext.conf: No such file or directory Dec 13 01:40:11.586454 initrd-setup-root-after-ignition[1020]: grep: /sysroot/usr/share/flatcar/enabled-sysext.conf: No such file or directory Dec 13 01:40:11.588710 initrd-setup-root-after-ignition[1024]: grep: /sysroot/etc/flatcar/enabled-sysext.conf: No such file or directory Dec 13 01:40:11.588626 systemd[1]: Finished initrd-setup-root-after-ignition.service - Root filesystem completion. Dec 13 01:40:11.589726 systemd[1]: Reached target ignition-subsequent.target - Subsequent (Not Ignition) boot complete. Dec 13 01:40:11.592036 systemd[1]: Starting initrd-parse-etc.service - Mountpoints Configured in the Real Root... Dec 13 01:40:11.613097 systemd[1]: initrd-parse-etc.service: Deactivated successfully. Dec 13 01:40:11.613225 systemd[1]: Finished initrd-parse-etc.service - Mountpoints Configured in the Real Root. Dec 13 01:40:11.614794 systemd[1]: Reached target initrd-fs.target - Initrd File Systems. Dec 13 01:40:11.616133 systemd[1]: Reached target initrd.target - Initrd Default Target. Dec 13 01:40:11.617434 systemd[1]: dracut-mount.service - dracut mount hook was skipped because no trigger condition checks were met. Dec 13 01:40:11.618137 systemd[1]: Starting dracut-pre-pivot.service - dracut pre-pivot and cleanup hook... Dec 13 01:40:11.632359 systemd[1]: Finished dracut-pre-pivot.service - dracut pre-pivot and cleanup hook. Dec 13 01:40:11.650085 systemd[1]: Starting initrd-cleanup.service - Cleaning Up and Shutting Down Daemons... Dec 13 01:40:11.656816 systemd[1]: Stopped target remote-cryptsetup.target - Remote Encrypted Volumes. Dec 13 01:40:11.657792 systemd[1]: Stopped target timers.target - Timer Units. Dec 13 01:40:11.659251 systemd[1]: decrypt-root.service: Deactivated successfully. Dec 13 01:40:11.659356 systemd[1]: Stopped decrypt-root.service - Generate and execute a systemd-cryptsetup service to decrypt the ROOT partition. Dec 13 01:40:11.660646 systemd[1]: dracut-pre-pivot.service: Deactivated successfully. Dec 13 01:40:11.660741 systemd[1]: Stopped dracut-pre-pivot.service - dracut pre-pivot and cleanup hook. Dec 13 01:40:11.663062 systemd[1]: Stopped target initrd.target - Initrd Default Target. Dec 13 01:40:11.664317 systemd[1]: Stopped target basic.target - Basic System. Dec 13 01:40:11.665630 systemd[1]: Stopped target ignition-subsequent.target - Subsequent (Not Ignition) boot complete. Dec 13 01:40:11.666999 systemd[1]: Stopped target ignition-diskful-subsequent.target - Ignition Subsequent Boot Disk Setup. Dec 13 01:40:11.668433 systemd[1]: Stopped target initrd-root-device.target - Initrd Root Device. Dec 13 01:40:11.669943 systemd[1]: Stopped target paths.target - Path Units. Dec 13 01:40:11.671509 systemd[1]: Stopped target remote-fs.target - Remote File Systems. Dec 13 01:40:11.672805 systemd[1]: Stopped target remote-fs-pre.target - Preparation for Remote File Systems. Dec 13 01:40:11.674095 systemd[1]: Stopped target slices.target - Slice Units. Dec 13 01:40:11.675266 systemd[1]: Stopped target sockets.target - Socket Units. Dec 13 01:40:11.676637 systemd[1]: Stopped target sysinit.target - System Initialization. Dec 13 01:40:11.677801 systemd[1]: Stopped target local-fs.target - Local File Systems. Dec 13 01:40:11.678983 systemd[1]: Stopped target swap.target - Swaps. Dec 13 01:40:11.680370 systemd[1]: iscsid.socket: Deactivated successfully. Dec 13 01:40:11.680445 systemd[1]: Closed iscsid.socket - Open-iSCSI iscsid Socket. Dec 13 01:40:11.681628 systemd[1]: iscsiuio.socket: Deactivated successfully. Dec 13 01:40:11.681698 systemd[1]: Closed iscsiuio.socket - Open-iSCSI iscsiuio Socket. Dec 13 01:40:11.682723 systemd[1]: dracut-pre-mount.service: Deactivated successfully. Dec 13 01:40:11.682821 systemd[1]: Stopped dracut-pre-mount.service - dracut pre-mount hook. Dec 13 01:40:11.684596 systemd[1]: Stopped target cryptsetup.target - Local Encrypted Volumes. Dec 13 01:40:11.686087 systemd[1]: systemd-ask-password-console.path: Deactivated successfully. Dec 13 01:40:11.686216 systemd[1]: Stopped systemd-ask-password-console.path - Dispatch Password Requests to Console Directory Watch. Dec 13 01:40:11.687498 systemd[1]: Stopped target cryptsetup-pre.target - Local Encrypted Volumes (Pre). Dec 13 01:40:11.688779 systemd[1]: clevis-luks-askpass.path: Deactivated successfully. Dec 13 01:40:11.688877 systemd[1]: Stopped clevis-luks-askpass.path - Forward Password Requests to Clevis Directory Watch. Dec 13 01:40:11.690229 systemd[1]: dracut-initqueue.service: Deactivated successfully. Dec 13 01:40:11.690336 systemd[1]: Stopped dracut-initqueue.service - dracut initqueue hook. Dec 13 01:40:11.692298 systemd[1]: ignition-setup-pre.service: Deactivated successfully. Dec 13 01:40:11.692411 systemd[1]: Stopped ignition-setup-pre.service - Ignition env setup. Dec 13 01:40:11.694004 systemd[1]: initrd-setup-root-after-ignition.service: Deactivated successfully. Dec 13 01:40:11.694099 systemd[1]: Stopped initrd-setup-root-after-ignition.service - Root filesystem completion. Dec 13 01:40:11.695622 systemd[1]: initrd-setup-root.service: Deactivated successfully. Dec 13 01:40:11.695717 systemd[1]: Stopped initrd-setup-root.service - Root filesystem setup. Dec 13 01:40:11.696883 systemd[1]: systemd-sysctl.service: Deactivated successfully. Dec 13 01:40:11.696991 systemd[1]: Stopped systemd-sysctl.service - Apply Kernel Variables. Dec 13 01:40:11.698418 systemd[1]: systemd-modules-load.service: Deactivated successfully. Dec 13 01:40:11.698508 systemd[1]: Stopped systemd-modules-load.service - Load Kernel Modules. Dec 13 01:40:11.699734 systemd[1]: systemd-tmpfiles-setup.service: Deactivated successfully. Dec 13 01:40:11.699828 systemd[1]: Stopped systemd-tmpfiles-setup.service - Create System Files and Directories. Dec 13 01:40:11.701228 systemd[1]: systemd-udev-trigger.service: Deactivated successfully. Dec 13 01:40:11.701320 systemd[1]: Stopped systemd-udev-trigger.service - Coldplug All udev Devices. Dec 13 01:40:11.702580 systemd[1]: dracut-pre-trigger.service: Deactivated successfully. Dec 13 01:40:11.702670 systemd[1]: Stopped dracut-pre-trigger.service - dracut pre-trigger hook. Dec 13 01:40:11.704707 systemd[1]: Stopping systemd-udevd.service - Rule-based Manager for Device Events and Files... Dec 13 01:40:11.708790 systemd[1]: initrd-cleanup.service: Deactivated successfully. Dec 13 01:40:11.708873 systemd[1]: Finished initrd-cleanup.service - Cleaning Up and Shutting Down Daemons. Dec 13 01:40:11.714517 systemd[1]: systemd-udevd.service: Deactivated successfully. Dec 13 01:40:11.714674 systemd[1]: Stopped systemd-udevd.service - Rule-based Manager for Device Events and Files. Dec 13 01:40:11.716324 systemd[1]: systemd-udevd-control.socket: Deactivated successfully. Dec 13 01:40:11.716363 systemd[1]: Closed systemd-udevd-control.socket - udev Control Socket. Dec 13 01:40:11.717393 systemd[1]: systemd-udevd-kernel.socket: Deactivated successfully. Dec 13 01:40:11.717419 systemd[1]: Closed systemd-udevd-kernel.socket - udev Kernel Socket. Dec 13 01:40:11.718815 systemd[1]: dracut-pre-udev.service: Deactivated successfully. Dec 13 01:40:11.718852 systemd[1]: Stopped dracut-pre-udev.service - dracut pre-udev hook. Dec 13 01:40:11.720872 systemd[1]: dracut-cmdline.service: Deactivated successfully. Dec 13 01:40:11.720951 systemd[1]: Stopped dracut-cmdline.service - dracut cmdline hook. Dec 13 01:40:11.722910 systemd[1]: dracut-cmdline-ask.service: Deactivated successfully. Dec 13 01:40:11.722960 systemd[1]: Stopped dracut-cmdline-ask.service - dracut ask for additional cmdline parameters. Dec 13 01:40:11.733112 systemd[1]: Starting initrd-udevadm-cleanup-db.service - Cleanup udev Database... Dec 13 01:40:11.733942 systemd[1]: systemd-tmpfiles-setup-dev.service: Deactivated successfully. Dec 13 01:40:11.733997 systemd[1]: Stopped systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev. Dec 13 01:40:11.735561 systemd[1]: systemd-tmpfiles-setup-dev-early.service: Deactivated successfully. Dec 13 01:40:11.735602 systemd[1]: Stopped systemd-tmpfiles-setup-dev-early.service - Create Static Device Nodes in /dev gracefully. Dec 13 01:40:11.736991 systemd[1]: kmod-static-nodes.service: Deactivated successfully. Dec 13 01:40:11.737026 systemd[1]: Stopped kmod-static-nodes.service - Create List of Static Device Nodes. Dec 13 01:40:11.738617 systemd[1]: systemd-vconsole-setup.service: Deactivated successfully. Dec 13 01:40:11.738655 systemd[1]: Stopped systemd-vconsole-setup.service - Virtual Console Setup. Dec 13 01:40:11.740269 systemd[1]: initrd-udevadm-cleanup-db.service: Deactivated successfully. Dec 13 01:40:11.740341 systemd[1]: Finished initrd-udevadm-cleanup-db.service - Cleanup udev Database. Dec 13 01:40:11.744163 systemd[1]: Reached target initrd-switch-root.target - Switch Root. Dec 13 01:40:11.746052 systemd[1]: Starting initrd-switch-root.service - Switch Root... Dec 13 01:40:11.754815 systemd[1]: Switching root. Dec 13 01:40:11.787138 systemd-journald[230]: Journal stopped Dec 13 01:40:12.268266 systemd-journald[230]: Received SIGTERM from PID 1 (systemd). Dec 13 01:40:12.268322 kernel: SELinux: policy capability network_peer_controls=1 Dec 13 01:40:12.268335 kernel: SELinux: policy capability open_perms=1 Dec 13 01:40:12.268344 kernel: SELinux: policy capability extended_socket_class=1 Dec 13 01:40:12.268354 kernel: SELinux: policy capability always_check_network=0 Dec 13 01:40:12.268363 kernel: SELinux: policy capability cgroup_seclabel=1 Dec 13 01:40:12.268373 kernel: SELinux: policy capability nnp_nosuid_transition=1 Dec 13 01:40:12.268382 kernel: SELinux: policy capability genfs_seclabel_symlinks=0 Dec 13 01:40:12.268394 kernel: SELinux: policy capability ioctl_skip_cloexec=0 Dec 13 01:40:12.268406 kernel: audit: type=1403 audit(1734054011.854:2): auid=4294967295 ses=4294967295 lsm=selinux res=1 Dec 13 01:40:12.268417 systemd[1]: Successfully loaded SELinux policy in 28.927ms. Dec 13 01:40:12.268434 systemd[1]: Relabeled /dev, /dev/shm, /run, /sys/fs/cgroup in 9.576ms. Dec 13 01:40:12.268446 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) Dec 13 01:40:12.268457 systemd[1]: Detected virtualization kvm. Dec 13 01:40:12.268467 systemd[1]: Detected architecture arm64. Dec 13 01:40:12.268478 zram_generator::config[1069]: No configuration found. Dec 13 01:40:12.268490 systemd[1]: initrd-switch-root.service: Deactivated successfully. Dec 13 01:40:12.268503 systemd[1]: Stopped initrd-switch-root.service - Switch Root. Dec 13 01:40:12.268513 systemd[1]: systemd-journald.service: Scheduled restart job, restart counter is at 1. Dec 13 01:40:12.268525 systemd[1]: Created slice system-addon\x2dconfig.slice - Slice /system/addon-config. Dec 13 01:40:12.268536 systemd[1]: Created slice system-addon\x2drun.slice - Slice /system/addon-run. Dec 13 01:40:12.268546 systemd[1]: Created slice system-getty.slice - Slice /system/getty. Dec 13 01:40:12.268557 systemd[1]: Created slice system-modprobe.slice - Slice /system/modprobe. Dec 13 01:40:12.268568 systemd[1]: Created slice system-serial\x2dgetty.slice - Slice /system/serial-getty. Dec 13 01:40:12.268579 systemd[1]: Created slice system-system\x2dcloudinit.slice - Slice /system/system-cloudinit. Dec 13 01:40:12.268590 systemd[1]: Created slice system-systemd\x2dfsck.slice - Slice /system/systemd-fsck. Dec 13 01:40:12.268602 systemd[1]: Created slice user.slice - User and Session Slice. Dec 13 01:40:12.268612 systemd[1]: Started clevis-luks-askpass.path - Forward Password Requests to Clevis Directory Watch. Dec 13 01:40:12.268623 systemd[1]: Started systemd-ask-password-console.path - Dispatch Password Requests to Console Directory Watch. Dec 13 01:40:12.268634 systemd[1]: Started systemd-ask-password-wall.path - Forward Password Requests to Wall Directory Watch. Dec 13 01:40:12.268645 systemd[1]: Set up automount boot.automount - Boot partition Automount Point. Dec 13 01:40:12.268656 systemd[1]: Set up automount proc-sys-fs-binfmt_misc.automount - Arbitrary Executable File Formats File System Automount Point. Dec 13 01:40:12.268667 systemd[1]: Expecting device dev-disk-by\x2dlabel-OEM.device - /dev/disk/by-label/OEM... Dec 13 01:40:12.268678 systemd[1]: Expecting device dev-ttyAMA0.device - /dev/ttyAMA0... Dec 13 01:40:12.268688 systemd[1]: Reached target blockdev@dev-mapper-rootencrypted.target - Block Device Preparation for /dev/mapper/rootencrypted. Dec 13 01:40:12.268700 systemd[1]: Reached target cryptsetup-pre.target - Local Encrypted Volumes (Pre). Dec 13 01:40:12.268711 systemd[1]: Stopped target initrd-switch-root.target - Switch Root. Dec 13 01:40:12.268721 systemd[1]: Stopped target initrd-fs.target - Initrd File Systems. Dec 13 01:40:12.268732 systemd[1]: Stopped target initrd-root-fs.target - Initrd Root File System. Dec 13 01:40:12.268743 systemd[1]: Reached target integritysetup.target - Local Integrity Protected Volumes. Dec 13 01:40:12.268753 systemd[1]: Reached target remote-cryptsetup.target - Remote Encrypted Volumes. Dec 13 01:40:12.268764 systemd[1]: Reached target remote-fs.target - Remote File Systems. Dec 13 01:40:12.268776 systemd[1]: Reached target slices.target - Slice Units. Dec 13 01:40:12.268786 systemd[1]: Reached target swap.target - Swaps. Dec 13 01:40:12.268797 systemd[1]: Reached target veritysetup.target - Local Verity Protected Volumes. Dec 13 01:40:12.268807 systemd[1]: Listening on systemd-coredump.socket - Process Core Dump Socket. Dec 13 01:40:12.268818 systemd[1]: Listening on systemd-networkd.socket - Network Service Netlink Socket. Dec 13 01:40:12.268828 systemd[1]: Listening on systemd-udevd-control.socket - udev Control Socket. Dec 13 01:40:12.268838 systemd[1]: Listening on systemd-udevd-kernel.socket - udev Kernel Socket. Dec 13 01:40:12.268849 systemd[1]: Listening on systemd-userdbd.socket - User Database Manager Socket. Dec 13 01:40:12.268861 systemd[1]: Mounting dev-hugepages.mount - Huge Pages File System... Dec 13 01:40:12.268873 systemd[1]: Mounting dev-mqueue.mount - POSIX Message Queue File System... Dec 13 01:40:12.268883 systemd[1]: Mounting media.mount - External Media Directory... Dec 13 01:40:12.268897 systemd[1]: Mounting sys-kernel-debug.mount - Kernel Debug File System... Dec 13 01:40:12.268908 systemd[1]: Mounting sys-kernel-tracing.mount - Kernel Trace File System... Dec 13 01:40:12.268937 systemd[1]: Mounting tmp.mount - Temporary Directory /tmp... Dec 13 01:40:12.268950 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). Dec 13 01:40:12.268961 systemd[1]: Reached target machines.target - Containers. Dec 13 01:40:12.268971 systemd[1]: Starting flatcar-tmpfiles.service - Create missing system files... Dec 13 01:40:12.268982 systemd[1]: ignition-delete-config.service - Ignition (delete config) was skipped because of an unmet condition check (ConditionFirstBoot=true). Dec 13 01:40:12.268995 systemd[1]: Starting kmod-static-nodes.service - Create List of Static Device Nodes... Dec 13 01:40:12.269005 systemd[1]: Starting modprobe@configfs.service - Load Kernel Module configfs... Dec 13 01:40:12.269016 systemd[1]: Starting modprobe@dm_mod.service - Load Kernel Module dm_mod... Dec 13 01:40:12.269026 systemd[1]: Starting modprobe@drm.service - Load Kernel Module drm... Dec 13 01:40:12.269037 systemd[1]: Starting modprobe@efi_pstore.service - Load Kernel Module efi_pstore... Dec 13 01:40:12.269047 systemd[1]: Starting modprobe@fuse.service - Load Kernel Module fuse... Dec 13 01:40:12.269057 systemd[1]: Starting modprobe@loop.service - Load Kernel Module loop... Dec 13 01:40:12.269068 systemd[1]: setup-nsswitch.service - Create /etc/nsswitch.conf was skipped because of an unmet condition check (ConditionPathExists=!/etc/nsswitch.conf). Dec 13 01:40:12.269080 systemd[1]: systemd-fsck-root.service: Deactivated successfully. Dec 13 01:40:12.269091 systemd[1]: Stopped systemd-fsck-root.service - File System Check on Root Device. Dec 13 01:40:12.269101 systemd[1]: systemd-fsck-usr.service: Deactivated successfully. Dec 13 01:40:12.269112 systemd[1]: Stopped systemd-fsck-usr.service. Dec 13 01:40:12.269122 systemd[1]: Starting systemd-journald.service - Journal Service... Dec 13 01:40:12.269132 systemd[1]: Starting systemd-modules-load.service - Load Kernel Modules... Dec 13 01:40:12.269142 kernel: fuse: init (API version 7.39) Dec 13 01:40:12.269152 systemd[1]: Starting systemd-network-generator.service - Generate network units from Kernel command line... Dec 13 01:40:12.269162 kernel: loop: module loaded Dec 13 01:40:12.269181 systemd[1]: Starting systemd-remount-fs.service - Remount Root and Kernel File Systems... Dec 13 01:40:12.269192 kernel: ACPI: bus type drm_connector registered Dec 13 01:40:12.269202 systemd[1]: Starting systemd-udev-trigger.service - Coldplug All udev Devices... Dec 13 01:40:12.269213 systemd[1]: verity-setup.service: Deactivated successfully. Dec 13 01:40:12.269223 systemd[1]: Stopped verity-setup.service. Dec 13 01:40:12.269234 systemd[1]: Mounted dev-hugepages.mount - Huge Pages File System. Dec 13 01:40:12.269244 systemd[1]: Mounted dev-mqueue.mount - POSIX Message Queue File System. Dec 13 01:40:12.269254 systemd[1]: Mounted media.mount - External Media Directory. Dec 13 01:40:12.269264 systemd[1]: Mounted sys-kernel-debug.mount - Kernel Debug File System. Dec 13 01:40:12.269276 systemd[1]: Mounted sys-kernel-tracing.mount - Kernel Trace File System. Dec 13 01:40:12.269287 systemd[1]: Mounted tmp.mount - Temporary Directory /tmp. Dec 13 01:40:12.269317 systemd-journald[1137]: Collecting audit messages is disabled. Dec 13 01:40:12.269341 systemd[1]: Finished kmod-static-nodes.service - Create List of Static Device Nodes. Dec 13 01:40:12.269353 systemd-journald[1137]: Journal started Dec 13 01:40:12.269373 systemd-journald[1137]: Runtime Journal (/run/log/journal/a26735c2eb1c46a89ff13038877df638) is 5.9M, max 47.3M, 41.4M free. Dec 13 01:40:12.094648 systemd[1]: Queued start job for default target multi-user.target. Dec 13 01:40:12.109076 systemd[1]: Unnecessary job was removed for dev-disk-by\x2duuid-52ba323c\x2d2b67\x2d4c19\x2dbe09\x2df4aa08e60916.device - /dev/disk/by-uuid/52ba323c-2b67-4c19-be09-f4aa08e60916. Dec 13 01:40:12.109086 systemd[1]: Unnecessary job was removed for dev-vdb6.device - /dev/vdb6. Dec 13 01:40:12.109451 systemd[1]: systemd-journald.service: Deactivated successfully. Dec 13 01:40:12.271980 systemd[1]: Started systemd-journald.service - Journal Service. Dec 13 01:40:12.272646 systemd[1]: Finished flatcar-tmpfiles.service - Create missing system files. Dec 13 01:40:12.273736 systemd[1]: modprobe@configfs.service: Deactivated successfully. Dec 13 01:40:12.273876 systemd[1]: Finished modprobe@configfs.service - Load Kernel Module configfs. Dec 13 01:40:12.275096 systemd[1]: modprobe@dm_mod.service: Deactivated successfully. Dec 13 01:40:12.275234 systemd[1]: Finished modprobe@dm_mod.service - Load Kernel Module dm_mod. Dec 13 01:40:12.276291 systemd[1]: modprobe@drm.service: Deactivated successfully. Dec 13 01:40:12.276424 systemd[1]: Finished modprobe@drm.service - Load Kernel Module drm. Dec 13 01:40:12.277413 systemd[1]: modprobe@efi_pstore.service: Deactivated successfully. Dec 13 01:40:12.277537 systemd[1]: Finished modprobe@efi_pstore.service - Load Kernel Module efi_pstore. Dec 13 01:40:12.278638 systemd[1]: modprobe@fuse.service: Deactivated successfully. Dec 13 01:40:12.278766 systemd[1]: Finished modprobe@fuse.service - Load Kernel Module fuse. Dec 13 01:40:12.279787 systemd[1]: modprobe@loop.service: Deactivated successfully. Dec 13 01:40:12.279910 systemd[1]: Finished modprobe@loop.service - Load Kernel Module loop. Dec 13 01:40:12.282254 systemd[1]: Finished systemd-modules-load.service - Load Kernel Modules. Dec 13 01:40:12.283297 systemd[1]: Finished systemd-network-generator.service - Generate network units from Kernel command line. Dec 13 01:40:12.284451 systemd[1]: Finished systemd-remount-fs.service - Remount Root and Kernel File Systems. Dec 13 01:40:12.295790 systemd[1]: Reached target network-pre.target - Preparation for Network. Dec 13 01:40:12.304026 systemd[1]: Mounting sys-fs-fuse-connections.mount - FUSE Control File System... Dec 13 01:40:12.305787 systemd[1]: Mounting sys-kernel-config.mount - Kernel Configuration File System... Dec 13 01:40:12.306632 systemd[1]: remount-root.service - Remount Root File System was skipped because of an unmet condition check (ConditionPathIsReadWrite=!/). Dec 13 01:40:12.306666 systemd[1]: Reached target local-fs.target - Local File Systems. Dec 13 01:40:12.308306 systemd[1]: Listening on systemd-sysext.socket - System Extension Image Management (Varlink). Dec 13 01:40:12.310157 systemd[1]: Starting dracut-shutdown.service - Restore /run/initramfs on shutdown... Dec 13 01:40:12.314151 systemd[1]: Starting ldconfig.service - Rebuild Dynamic Linker Cache... Dec 13 01:40:12.315134 systemd[1]: systemd-binfmt.service - Set Up Additional Binary Formats was skipped because no trigger condition checks were met. Dec 13 01:40:12.316615 systemd[1]: Starting systemd-hwdb-update.service - Rebuild Hardware Database... Dec 13 01:40:12.318409 systemd[1]: Starting systemd-journal-flush.service - Flush Journal to Persistent Storage... Dec 13 01:40:12.319286 systemd[1]: systemd-pstore.service - Platform Persistent Storage Archival was skipped because of an unmet condition check (ConditionDirectoryNotEmpty=/sys/fs/pstore). Dec 13 01:40:12.322999 systemd[1]: Starting systemd-random-seed.service - Load/Save OS Random Seed... Dec 13 01:40:12.323836 systemd[1]: systemd-repart.service - Repartition Root Disk was skipped because no trigger condition checks were met. Dec 13 01:40:12.325115 systemd[1]: Starting systemd-sysctl.service - Apply Kernel Variables... Dec 13 01:40:12.326658 systemd-journald[1137]: Time spent on flushing to /var/log/journal/a26735c2eb1c46a89ff13038877df638 is 38.083ms for 672 entries. Dec 13 01:40:12.326658 systemd-journald[1137]: System Journal (/var/log/journal/a26735c2eb1c46a89ff13038877df638) is 13.1M, max 204.2M, 191.0M free. Dec 13 01:40:12.368888 systemd-journald[1137]: Received client request to flush runtime journal. Dec 13 01:40:12.368938 systemd-journald[1137]: /var/log/journal/a26735c2eb1c46a89ff13038877df638/system.journal: Journal file uses a different sequence number ID, rotating. Dec 13 01:40:12.368972 systemd-journald[1137]: Rotating system journal. Dec 13 01:40:12.368992 kernel: loop0: detected capacity change from 0 to 114432 Dec 13 01:40:12.328699 systemd[1]: Starting systemd-sysext.service - Merge System Extension Images into /usr/ and /opt/... Dec 13 01:40:12.330961 systemd[1]: Starting systemd-tmpfiles-setup-dev-early.service - Create Static Device Nodes in /dev gracefully... Dec 13 01:40:12.334558 systemd[1]: Finished systemd-udev-trigger.service - Coldplug All udev Devices. Dec 13 01:40:12.337488 systemd[1]: Mounted sys-fs-fuse-connections.mount - FUSE Control File System. Dec 13 01:40:12.339033 systemd[1]: Mounted sys-kernel-config.mount - Kernel Configuration File System. Dec 13 01:40:12.340943 systemd[1]: Finished dracut-shutdown.service - Restore /run/initramfs on shutdown. Dec 13 01:40:12.346121 systemd[1]: Finished systemd-random-seed.service - Load/Save OS Random Seed. Dec 13 01:40:12.351477 systemd[1]: first-boot-complete.target - First Boot Complete was skipped because of an unmet condition check (ConditionFirstBoot=yes). Dec 13 01:40:12.351549 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). Dec 13 01:40:12.352857 systemd[1]: Starting systemd-udev-settle.service - Wait for udev To Complete Device Initialization... Dec 13 01:40:12.361983 systemd[1]: Finished systemd-sysctl.service - Apply Kernel Variables. Dec 13 01:40:12.369946 kernel: squashfs: version 4.0 (2009/01/31) Phillip Lougher Dec 13 01:40:12.371429 systemd[1]: Finished systemd-journal-flush.service - Flush Journal to Persistent Storage. Dec 13 01:40:12.377802 systemd-tmpfiles[1178]: ACLs are not supported, ignoring. Dec 13 01:40:12.377822 systemd-tmpfiles[1178]: ACLs are not supported, ignoring. Dec 13 01:40:12.379135 udevadm[1188]: systemd-udev-settle.service is deprecated. Please fix lvm2-activation-early.service, lvm2-activation.service not to pull it in. Dec 13 01:40:12.388678 systemd[1]: Finished systemd-tmpfiles-setup-dev-early.service - Create Static Device Nodes in /dev gracefully. Dec 13 01:40:12.397192 systemd[1]: Starting systemd-sysusers.service - Create System Users... Dec 13 01:40:12.403970 kernel: loop1: detected capacity change from 0 to 114328 Dec 13 01:40:12.422551 systemd[1]: Finished systemd-sysusers.service - Create System Users. Dec 13 01:40:12.434156 systemd[1]: Starting systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev... Dec 13 01:40:12.445405 systemd-tmpfiles[1201]: ACLs are not supported, ignoring. Dec 13 01:40:12.445423 systemd-tmpfiles[1201]: ACLs are not supported, ignoring. Dec 13 01:40:12.445940 kernel: loop2: detected capacity change from 0 to 114432 Dec 13 01:40:12.449870 systemd[1]: Finished systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev. Dec 13 01:40:12.452947 kernel: loop3: detected capacity change from 0 to 114328 Dec 13 01:40:12.455558 (sd-merge)[1204]: Using extensions 'containerd-flatcar', 'docker-flatcar'. Dec 13 01:40:12.456708 (sd-merge)[1204]: Merged extensions into '/usr'. Dec 13 01:40:12.459423 systemd[1]: Finished systemd-sysext.service - Merge System Extension Images into /usr/ and /opt/. Dec 13 01:40:12.467061 systemd[1]: Starting ensure-sysext.service... Dec 13 01:40:12.469233 ldconfig[1172]: /sbin/ldconfig: /lib/ld.so.conf is not an ELF file - it has the wrong magic bytes at the start. Dec 13 01:40:12.469757 systemd[1]: Starting systemd-tmpfiles-setup.service - Create System Files and Directories... Dec 13 01:40:12.474979 systemd[1]: Finished ldconfig.service - Rebuild Dynamic Linker Cache. Dec 13 01:40:12.479201 systemd[1]: Reloading requested from client PID 1207 ('systemctl') (unit ensure-sysext.service)... Dec 13 01:40:12.479216 systemd[1]: Reloading... Dec 13 01:40:12.494614 systemd-tmpfiles[1208]: /usr/lib/tmpfiles.d/provision.conf:20: Duplicate line for path "/root", ignoring. Dec 13 01:40:12.494874 systemd-tmpfiles[1208]: /usr/lib/tmpfiles.d/systemd-flatcar.conf:6: Duplicate line for path "/var/log/journal", ignoring. Dec 13 01:40:12.495530 systemd-tmpfiles[1208]: /usr/lib/tmpfiles.d/systemd.conf:29: Duplicate line for path "/var/lib/systemd", ignoring. Dec 13 01:40:12.495734 systemd-tmpfiles[1208]: ACLs are not supported, ignoring. Dec 13 01:40:12.495789 systemd-tmpfiles[1208]: ACLs are not supported, ignoring. Dec 13 01:40:12.499098 systemd-tmpfiles[1208]: Detected autofs mount point /boot during canonicalization of boot. Dec 13 01:40:12.499107 systemd-tmpfiles[1208]: Skipping /boot Dec 13 01:40:12.511362 systemd-tmpfiles[1208]: Detected autofs mount point /boot during canonicalization of boot. Dec 13 01:40:12.511377 systemd-tmpfiles[1208]: Skipping /boot Dec 13 01:40:12.524954 zram_generator::config[1237]: No configuration found. Dec 13 01:40:12.606405 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. Dec 13 01:40:12.645143 systemd[1]: Reloading finished in 165 ms. Dec 13 01:40:12.676601 systemd[1]: Finished systemd-tmpfiles-setup.service - Create System Files and Directories. Dec 13 01:40:12.682953 systemd[1]: Starting audit-rules.service - Load Security Auditing Rules... Dec 13 01:40:12.685094 systemd[1]: Starting clean-ca-certificates.service - Clean up broken links in /etc/ssl/certs... Dec 13 01:40:12.687200 systemd[1]: Starting systemd-journal-catalog-update.service - Rebuild Journal Catalog... Dec 13 01:40:12.698109 systemd[1]: Starting systemd-resolved.service - Network Name Resolution... Dec 13 01:40:12.704363 systemd[1]: Starting systemd-update-utmp.service - Record System Boot/Shutdown in UTMP... Dec 13 01:40:12.713422 systemd[1]: Starting systemd-userdbd.service - User Database Manager... Dec 13 01:40:12.717566 systemd[1]: ignition-delete-config.service - Ignition (delete config) was skipped because of an unmet condition check (ConditionFirstBoot=true). Dec 13 01:40:12.720601 systemd[1]: Starting modprobe@dm_mod.service - Load Kernel Module dm_mod... Dec 13 01:40:12.726027 systemd[1]: Starting modprobe@efi_pstore.service - Load Kernel Module efi_pstore... Dec 13 01:40:12.730295 systemd[1]: Starting modprobe@loop.service - Load Kernel Module loop... Dec 13 01:40:12.731165 systemd[1]: systemd-binfmt.service - Set Up Additional Binary Formats was skipped because no trigger condition checks were met. Dec 13 01:40:12.731357 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). Dec 13 01:40:12.732483 systemd[1]: modprobe@dm_mod.service: Deactivated successfully. Dec 13 01:40:12.732623 systemd[1]: Finished modprobe@dm_mod.service - Load Kernel Module dm_mod. Dec 13 01:40:12.733981 augenrules[1270]: /sbin/augenrules: No change Dec 13 01:40:12.734296 systemd[1]: modprobe@efi_pstore.service: Deactivated successfully. Dec 13 01:40:12.734412 systemd[1]: Finished modprobe@efi_pstore.service - Load Kernel Module efi_pstore. Dec 13 01:40:12.735992 systemd[1]: Finished systemd-journal-catalog-update.service - Rebuild Journal Catalog. Dec 13 01:40:12.740576 systemd[1]: modprobe@loop.service: Deactivated successfully. Dec 13 01:40:12.740734 systemd[1]: Finished modprobe@loop.service - Load Kernel Module loop. Dec 13 01:40:12.741904 augenrules[1288]: No rules Dec 13 01:40:12.743178 systemd[1]: Finished audit-rules.service - Load Security Auditing Rules. Dec 13 01:40:12.744654 systemd[1]: Finished systemd-update-utmp.service - Record System Boot/Shutdown in UTMP. Dec 13 01:40:12.751318 systemd[1]: ignition-delete-config.service - Ignition (delete config) was skipped because of an unmet condition check (ConditionFirstBoot=true). Dec 13 01:40:12.762244 systemd[1]: Starting modprobe@dm_mod.service - Load Kernel Module dm_mod... Dec 13 01:40:12.764302 systemd[1]: Starting modprobe@efi_pstore.service - Load Kernel Module efi_pstore... Dec 13 01:40:12.769735 systemd[1]: Starting modprobe@loop.service - Load Kernel Module loop... Dec 13 01:40:12.773511 systemd[1]: systemd-binfmt.service - Set Up Additional Binary Formats was skipped because no trigger condition checks were met. Dec 13 01:40:12.773637 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). Dec 13 01:40:12.774458 systemd[1]: Started systemd-userdbd.service - User Database Manager. Dec 13 01:40:12.776623 systemd[1]: Finished clean-ca-certificates.service - Clean up broken links in /etc/ssl/certs. Dec 13 01:40:12.779434 systemd[1]: modprobe@dm_mod.service: Deactivated successfully. Dec 13 01:40:12.779560 systemd[1]: Finished modprobe@dm_mod.service - Load Kernel Module dm_mod. Dec 13 01:40:12.780893 systemd[1]: Finished systemd-hwdb-update.service - Rebuild Hardware Database. Dec 13 01:40:12.782142 systemd[1]: modprobe@efi_pstore.service: Deactivated successfully. Dec 13 01:40:12.782275 systemd[1]: Finished modprobe@efi_pstore.service - Load Kernel Module efi_pstore. Dec 13 01:40:12.783585 systemd[1]: modprobe@loop.service: Deactivated successfully. Dec 13 01:40:12.783700 systemd[1]: Finished modprobe@loop.service - Load Kernel Module loop. Dec 13 01:40:12.789766 systemd[1]: ignition-delete-config.service - Ignition (delete config) was skipped because of an unmet condition check (ConditionFirstBoot=true). Dec 13 01:40:12.798159 systemd[1]: Starting modprobe@dm_mod.service - Load Kernel Module dm_mod... Dec 13 01:40:12.799855 systemd[1]: Starting modprobe@drm.service - Load Kernel Module drm... Dec 13 01:40:12.801586 systemd[1]: Starting modprobe@efi_pstore.service - Load Kernel Module efi_pstore... Dec 13 01:40:12.806192 systemd[1]: Starting modprobe@loop.service - Load Kernel Module loop... Dec 13 01:40:12.807000 systemd[1]: systemd-binfmt.service - Set Up Additional Binary Formats was skipped because no trigger condition checks were met. Dec 13 01:40:12.807134 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). Dec 13 01:40:12.808469 systemd[1]: Starting systemd-udevd.service - Rule-based Manager for Device Events and Files... Dec 13 01:40:12.810522 systemd[1]: Starting systemd-update-done.service - Update is Completed... Dec 13 01:40:12.811328 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). Dec 13 01:40:12.812434 systemd[1]: modprobe@dm_mod.service: Deactivated successfully. Dec 13 01:40:12.813974 systemd[1]: Finished modprobe@dm_mod.service - Load Kernel Module dm_mod. Dec 13 01:40:12.815269 systemd[1]: modprobe@drm.service: Deactivated successfully. Dec 13 01:40:12.815391 systemd[1]: Finished modprobe@drm.service - Load Kernel Module drm. Dec 13 01:40:12.818692 systemd[1]: modprobe@efi_pstore.service: Deactivated successfully. Dec 13 01:40:12.818805 systemd[1]: Finished modprobe@efi_pstore.service - Load Kernel Module efi_pstore. Dec 13 01:40:12.820115 systemd[1]: modprobe@loop.service: Deactivated successfully. Dec 13 01:40:12.820236 systemd[1]: Finished modprobe@loop.service - Load Kernel Module loop. Dec 13 01:40:12.824505 systemd[1]: Finished ensure-sysext.service. Dec 13 01:40:12.825615 systemd[1]: Finished systemd-update-done.service - Update is Completed. Dec 13 01:40:12.825764 systemd-resolved[1276]: Positive Trust Anchors: Dec 13 01:40:12.825774 systemd-resolved[1276]: . IN DS 20326 8 2 e06d44b80b8f1d39a95c0b0d7c65d08458e880409bbc683457104237c7f8ec8d Dec 13 01:40:12.825805 systemd-resolved[1276]: 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 Dec 13 01:40:12.829000 systemd[1]: systemd-pstore.service - Platform Persistent Storage Archival was skipped because of an unmet condition check (ConditionDirectoryNotEmpty=/sys/fs/pstore). Dec 13 01:40:12.829056 systemd[1]: systemd-repart.service - Repartition Root Disk was skipped because no trigger condition checks were met. Dec 13 01:40:12.835467 systemd-resolved[1276]: Defaulting to hostname 'linux'. Dec 13 01:40:12.837173 systemd[1]: Starting systemd-timesyncd.service - Network Time Synchronization... Dec 13 01:40:12.838792 systemd[1]: Started systemd-resolved.service - Network Name Resolution. Dec 13 01:40:12.838899 systemd-udevd[1315]: Using default interface naming scheme 'v255'. Dec 13 01:40:12.839837 systemd[1]: Reached target nss-lookup.target - Host and Network Name Lookups. Dec 13 01:40:12.854968 systemd[1]: Started systemd-udevd.service - Rule-based Manager for Device Events and Files. Dec 13 01:40:12.865149 systemd[1]: Starting systemd-networkd.service - Network Configuration... Dec 13 01:40:12.875210 systemd[1]: Started systemd-timesyncd.service - Network Time Synchronization. Dec 13 01:40:12.876964 systemd[1]: Reached target time-set.target - System Time Set. Dec 13 01:40:12.894968 kernel: BTRFS info: devid 1 device path /dev/mapper/usr changed to /dev/dm-0 scanned by (udev-worker) (1326) Dec 13 01:40:12.896940 kernel: BTRFS info: devid 1 device path /dev/dm-0 changed to /dev/mapper/usr scanned by (udev-worker) (1326) Dec 13 01:40:12.902036 systemd[1]: Condition check resulted in dev-ttyAMA0.device - /dev/ttyAMA0 being skipped. Dec 13 01:40:12.907948 kernel: BTRFS warning: duplicate device /dev/vdb3 devid 1 generation 46 scanned by (udev-worker) (1327) Dec 13 01:40:12.928212 systemd[1]: Found device dev-disk-by\x2dlabel-OEM.device - /dev/disk/by-label/OEM. Dec 13 01:40:12.935111 systemd-networkd[1330]: lo: Link UP Dec 13 01:40:12.935120 systemd-networkd[1330]: lo: Gained carrier Dec 13 01:40:12.935869 systemd-networkd[1330]: Enumeration completed Dec 13 01:40:12.936106 systemd[1]: Starting systemd-fsck@dev-disk-by\x2dlabel-OEM.service - File System Check on /dev/disk/by-label/OEM... Dec 13 01:40:12.937210 systemd[1]: Started systemd-networkd.service - Network Configuration. Dec 13 01:40:12.938755 systemd[1]: Reached target network.target - Network. Dec 13 01:40:12.946749 systemd[1]: Starting systemd-networkd-wait-online.service - Wait for Network to be Configured... Dec 13 01:40:12.948527 systemd-networkd[1330]: eth0: found matching network '/usr/lib/systemd/network/zz-default.network', based on potentially unpredictable interface name. Dec 13 01:40:12.948536 systemd-networkd[1330]: eth0: Configuring with /usr/lib/systemd/network/zz-default.network. Dec 13 01:40:12.950114 systemd-networkd[1330]: eth0: Link UP Dec 13 01:40:12.950124 systemd-networkd[1330]: eth0: Gained carrier Dec 13 01:40:12.950134 systemd-networkd[1330]: eth0: found matching network '/usr/lib/systemd/network/zz-default.network', based on potentially unpredictable interface name. Dec 13 01:40:12.957200 systemd[1]: Finished systemd-fsck@dev-disk-by\x2dlabel-OEM.service - File System Check on /dev/disk/by-label/OEM. Dec 13 01:40:12.957785 systemd-networkd[1330]: eth0: found matching network '/usr/lib/systemd/network/zz-default.network', based on potentially unpredictable interface name. Dec 13 01:40:12.964022 systemd-networkd[1330]: eth0: DHCPv4 address 10.0.0.104/16, gateway 10.0.0.1 acquired from 10.0.0.1 Dec 13 01:40:12.965092 systemd-timesyncd[1323]: Network configuration changed, trying to establish connection. Dec 13 01:40:12.988143 systemd[1]: Starting systemd-vconsole-setup.service - Virtual Console Setup... Dec 13 01:40:12.995029 systemd[1]: Finished systemd-udev-settle.service - Wait for udev To Complete Device Initialization. Dec 13 01:40:12.997255 systemd[1]: Starting lvm2-activation-early.service - Activation of LVM2 logical volumes... Dec 13 01:40:13.013203 lvm[1361]: WARNING: Failed to connect to lvmetad. Falling back to device scanning. Dec 13 01:40:13.030005 systemd[1]: Finished systemd-vconsole-setup.service - Virtual Console Setup. Dec 13 01:40:13.040986 systemd[1]: Finished lvm2-activation-early.service - Activation of LVM2 logical volumes. Dec 13 01:40:13.042071 systemd[1]: Reached target cryptsetup.target - Local Encrypted Volumes. Dec 13 01:40:13.042854 systemd[1]: Reached target sysinit.target - System Initialization. Dec 13 01:40:13.045107 systemd[1]: Started motdgen.path - Watch for update engine configuration changes. Dec 13 01:40:13.045978 systemd[1]: Started user-cloudinit@var-lib-flatcar\x2dinstall-user_data.path - Watch for a cloud-config at /var/lib/flatcar-install/user_data. Dec 13 01:40:13.047070 systemd[1]: Started logrotate.timer - Daily rotation of log files. Dec 13 01:40:13.047866 systemd[1]: Started mdadm.timer - Weekly check for MD array's redundancy information.. Dec 13 01:40:13.048789 systemd[1]: Started systemd-tmpfiles-clean.timer - Daily Cleanup of Temporary Directories. Dec 13 01:40:13.049731 systemd[1]: update-engine-stub.timer - Update Engine Stub Timer was skipped because of an unmet condition check (ConditionPathExists=/usr/.noupdate). Dec 13 01:40:13.049767 systemd[1]: Reached target paths.target - Path Units. Dec 13 01:40:13.050431 systemd[1]: Reached target timers.target - Timer Units. Dec 13 01:40:13.052083 systemd[1]: Listening on dbus.socket - D-Bus System Message Bus Socket. Dec 13 01:40:13.054160 systemd[1]: Starting docker.socket - Docker Socket for the API... Dec 13 01:40:13.067821 systemd[1]: Listening on sshd.socket - OpenSSH Server Socket. Dec 13 01:40:13.069735 systemd[1]: Starting lvm2-activation.service - Activation of LVM2 logical volumes... Dec 13 01:40:13.070985 systemd[1]: Listening on docker.socket - Docker Socket for the API. Dec 13 01:40:13.071832 systemd[1]: Reached target sockets.target - Socket Units. Dec 13 01:40:13.072588 systemd[1]: Reached target basic.target - Basic System. Dec 13 01:40:13.073299 systemd[1]: addon-config@oem.service - Configure Addon /oem was skipped because no trigger condition checks were met. Dec 13 01:40:13.073329 systemd[1]: addon-run@oem.service - Run Addon /oem was skipped because no trigger condition checks were met. Dec 13 01:40:13.074190 systemd[1]: Starting containerd.service - containerd container runtime... Dec 13 01:40:13.074964 systemd[1]: cryptenroll-helper-bind.service was skipped because of an unmet condition check (ConditionPathExists=/etc/luks/rootencrypted-bind). Dec 13 01:40:13.075987 systemd[1]: Starting dbus.service - D-Bus System Message Bus... Dec 13 01:40:13.079011 lvm[1369]: WARNING: Failed to connect to lvmetad. Falling back to device scanning. Dec 13 01:40:13.079182 systemd[1]: Starting enable-oem-cloudinit.service - Enable cloudinit... Dec 13 01:40:13.081139 systemd[1]: Starting extend-filesystems.service - Extend Filesystems... Dec 13 01:40:13.082572 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). Dec 13 01:40:13.093435 jq[1372]: false Dec 13 01:40:13.099079 systemd[1]: Starting motdgen.service - Generate /run/flatcar/motd... Dec 13 01:40:13.099994 dbus-daemon[1371]: [system] SELinux support is enabled Dec 13 01:40:13.101945 systemd[1]: Starting ssh-key-proc-cmdline.service - Install an ssh key from /proc/cmdline... Dec 13 01:40:13.103720 systemd[1]: Starting sshd-keygen.service - Generate sshd host keys... Dec 13 01:40:13.110984 systemd[1]: Starting systemd-logind.service - User Login Management... Dec 13 01:40:13.113528 systemd[1]: tcsd.service - TCG Core Services Daemon was skipped because of an unmet condition check (ConditionSecurity=!tpm2). Dec 13 01:40:13.113911 systemd[1]: cgroup compatibility translation between legacy and unified hierarchy settings activated. See cgroup-compat debug messages for details. Dec 13 01:40:13.117112 systemd[1]: Starting update-engine.service - Update Engine... Dec 13 01:40:13.120621 extend-filesystems[1373]: Found loop2 Dec 13 01:40:13.120621 extend-filesystems[1373]: Found loop3 Dec 13 01:40:13.120621 extend-filesystems[1373]: Found vda Dec 13 01:40:13.120621 extend-filesystems[1373]: Found vdb Dec 13 01:40:13.120621 extend-filesystems[1373]: Found vdb1 Dec 13 01:40:13.120621 extend-filesystems[1373]: Found vdb2 Dec 13 01:40:13.120621 extend-filesystems[1373]: Found vdb3 Dec 13 01:40:13.120621 extend-filesystems[1373]: Found usr Dec 13 01:40:13.120621 extend-filesystems[1373]: Found vdb4 Dec 13 01:40:13.120621 extend-filesystems[1373]: Found vdb6 Dec 13 01:40:13.120621 extend-filesystems[1373]: Found vdb7 Dec 13 01:40:13.120621 extend-filesystems[1373]: Found vdb9 Dec 13 01:40:13.120621 extend-filesystems[1373]: Found rootencrypted Dec 13 01:40:13.120059 systemd[1]: Starting update-ssh-keys-after-ignition.service - Run update-ssh-keys once after Ignition... Dec 13 01:40:13.121392 systemd[1]: Started dbus.service - D-Bus System Message Bus. Dec 13 01:40:13.137425 jq[1387]: true Dec 13 01:40:13.126867 systemd[1]: Finished lvm2-activation.service - Activation of LVM2 logical volumes. Dec 13 01:40:13.138325 systemd[1]: enable-oem-cloudinit.service: Skipped due to 'exec-condition'. Dec 13 01:40:13.138589 systemd[1]: Condition check resulted in enable-oem-cloudinit.service - Enable cloudinit being skipped. Dec 13 01:40:13.138846 systemd[1]: extend-filesystems.service: Deactivated successfully. Dec 13 01:40:13.139067 systemd[1]: Finished extend-filesystems.service - Extend Filesystems. Dec 13 01:40:13.140325 systemd[1]: motdgen.service: Deactivated successfully. Dec 13 01:40:13.141962 systemd[1]: Finished motdgen.service - Generate /run/flatcar/motd. Dec 13 01:40:13.143022 systemd[1]: ssh-key-proc-cmdline.service: Deactivated successfully. Dec 13 01:40:13.143162 systemd[1]: Finished ssh-key-proc-cmdline.service - Install an ssh key from /proc/cmdline. Dec 13 01:40:13.150102 (ntainerd)[1397]: containerd.service: Referenced but unset environment variable evaluates to an empty string: TORCX_IMAGEDIR, TORCX_UNPACKDIR Dec 13 01:40:13.152606 jq[1396]: false Dec 13 01:40:13.154962 systemd-logind[1380]: Watching system buttons on /dev/input/event0 (Power Button) Dec 13 01:40:13.155333 systemd[1]: update-ssh-keys-after-ignition.service: Skipped due to 'exec-condition'. Dec 13 01:40:13.155494 systemd[1]: Condition check resulted in update-ssh-keys-after-ignition.service - Run update-ssh-keys once after Ignition being skipped. Dec 13 01:40:13.155971 systemd-logind[1380]: New seat seat0. Dec 13 01:40:13.159051 systemd[1]: Started systemd-logind.service - User Login Management. Dec 13 01:40:13.165610 systemd[1]: Finished sshd-keygen.service - Generate sshd host keys. Dec 13 01:40:13.168295 dbus-daemon[1371]: [system] Successfully activated service 'org.freedesktop.systemd1' Dec 13 01:40:13.175121 systemd[1]: Starting issuegen.service - Generate /run/issue... Dec 13 01:40:13.176051 systemd[1]: sshkeys.service was skipped because no trigger condition checks were met. Dec 13 01:40:13.176148 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). Dec 13 01:40:13.176188 systemd[1]: Reached target system-config.target - Load system-provided cloud configs. Dec 13 01:40:13.177096 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). Dec 13 01:40:13.177111 systemd[1]: Reached target user-config.target - Load user-provided cloud configs. Dec 13 01:40:13.179576 update_engine[1385]: I20241213 01:40:13.179354 1385 main.cc:92] Flatcar Update Engine starting Dec 13 01:40:13.182899 systemd[1]: Started update-engine.service - Update Engine. Dec 13 01:40:13.183145 update_engine[1385]: I20241213 01:40:13.182876 1385 update_check_scheduler.cc:74] Next update check in 11m44s Dec 13 01:40:13.184074 systemd[1]: issuegen.service: Deactivated successfully. Dec 13 01:40:13.184958 systemd[1]: Finished issuegen.service - Generate /run/issue. Dec 13 01:40:13.195197 systemd[1]: Starting systemd-user-sessions.service - Permit User Sessions... Dec 13 01:40:13.201706 systemd[1]: Started locksmithd.service - Cluster reboot manager. Dec 13 01:40:13.206563 systemd[1]: Finished systemd-user-sessions.service - Permit User Sessions. Dec 13 01:40:13.222527 systemd[1]: Started getty@tty1.service - Getty on tty1. Dec 13 01:40:13.227898 systemd[1]: Started serial-getty@ttyAMA0.service - Serial Getty on ttyAMA0. Dec 13 01:40:13.229908 systemd[1]: Reached target getty.target - Login Prompts. Dec 13 01:40:13.265136 locksmithd[1415]: locksmithd starting currentOperation="UPDATE_STATUS_IDLE" strategy="reboot" Dec 13 01:40:13.332474 containerd[1397]: time="2024-12-13T01:40:13.332363240Z" level=info msg="starting containerd" revision=174e0d1785eeda18dc2beba45e1d5a188771636b version=v1.7.21 Dec 13 01:40:13.354698 containerd[1397]: time="2024-12-13T01:40:13.354641360Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.aufs\"..." type=io.containerd.snapshotter.v1 Dec 13 01:40:13.355995 containerd[1397]: time="2024-12-13T01:40:13.355958160Z" 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.65-flatcar\\n\"): skip plugin" type=io.containerd.snapshotter.v1 Dec 13 01:40:13.355995 containerd[1397]: time="2024-12-13T01:40:13.355988760Z" level=info msg="loading plugin \"io.containerd.event.v1.exchange\"..." type=io.containerd.event.v1 Dec 13 01:40:13.356041 containerd[1397]: time="2024-12-13T01:40:13.356003480Z" level=info msg="loading plugin \"io.containerd.internal.v1.opt\"..." type=io.containerd.internal.v1 Dec 13 01:40:13.356289 containerd[1397]: time="2024-12-13T01:40:13.356260040Z" level=info msg="loading plugin \"io.containerd.warning.v1.deprecations\"..." type=io.containerd.warning.v1 Dec 13 01:40:13.356320 containerd[1397]: time="2024-12-13T01:40:13.356293600Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.blockfile\"..." type=io.containerd.snapshotter.v1 Dec 13 01:40:13.356458 containerd[1397]: time="2024-12-13T01:40:13.356428040Z" level=info msg="skip loading plugin \"io.containerd.snapshotter.v1.blockfile\"..." error="no scratch file generator: skip plugin" type=io.containerd.snapshotter.v1 Dec 13 01:40:13.356458 containerd[1397]: time="2024-12-13T01:40:13.356449040Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.btrfs\"..." type=io.containerd.snapshotter.v1 Dec 13 01:40:13.356603 containerd[1397]: time="2024-12-13T01:40:13.356578840Z" 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 Dec 13 01:40:13.356603 containerd[1397]: time="2024-12-13T01:40:13.356598360Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.devmapper\"..." type=io.containerd.snapshotter.v1 Dec 13 01:40:13.356646 containerd[1397]: time="2024-12-13T01:40:13.356612040Z" level=info msg="skip loading plugin \"io.containerd.snapshotter.v1.devmapper\"..." error="devmapper not configured: skip plugin" type=io.containerd.snapshotter.v1 Dec 13 01:40:13.356646 containerd[1397]: time="2024-12-13T01:40:13.356621320Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.native\"..." type=io.containerd.snapshotter.v1 Dec 13 01:40:13.356802 containerd[1397]: time="2024-12-13T01:40:13.356777720Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.overlayfs\"..." type=io.containerd.snapshotter.v1 Dec 13 01:40:13.357030 containerd[1397]: time="2024-12-13T01:40:13.357005560Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.zfs\"..." type=io.containerd.snapshotter.v1 Dec 13 01:40:13.357129 containerd[1397]: time="2024-12-13T01:40:13.357111360Z" 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 Dec 13 01:40:13.357151 containerd[1397]: time="2024-12-13T01:40:13.357129520Z" level=info msg="loading plugin \"io.containerd.content.v1.content\"..." type=io.containerd.content.v1 Dec 13 01:40:13.357285 containerd[1397]: time="2024-12-13T01:40:13.357266320Z" level=info msg="loading plugin \"io.containerd.metadata.v1.bolt\"..." type=io.containerd.metadata.v1 Dec 13 01:40:13.357307 containerd[1397]: time="2024-12-13T01:40:13.357300840Z" level=info msg="metadata content store policy set" policy=shared Dec 13 01:40:13.357728 containerd[1397]: time="2024-12-13T01:40:13.357708200Z" level=info msg="loading plugin \"io.containerd.gc.v1.scheduler\"..." type=io.containerd.gc.v1 Dec 13 01:40:13.357764 containerd[1397]: time="2024-12-13T01:40:13.357744320Z" level=info msg="loading plugin \"io.containerd.differ.v1.walking\"..." type=io.containerd.differ.v1 Dec 13 01:40:13.357793 containerd[1397]: time="2024-12-13T01:40:13.357764640Z" level=info msg="loading plugin \"io.containerd.lease.v1.manager\"..." type=io.containerd.lease.v1 Dec 13 01:40:13.357793 containerd[1397]: time="2024-12-13T01:40:13.357779360Z" level=info msg="loading plugin \"io.containerd.streaming.v1.manager\"..." type=io.containerd.streaming.v1 Dec 13 01:40:13.357826 containerd[1397]: time="2024-12-13T01:40:13.357792480Z" level=info msg="loading plugin \"io.containerd.runtime.v1.linux\"..." type=io.containerd.runtime.v1 Dec 13 01:40:13.357894 containerd[1397]: time="2024-12-13T01:40:13.357876760Z" level=info msg="loading plugin \"io.containerd.monitor.v1.cgroups\"..." type=io.containerd.monitor.v1 Dec 13 01:40:13.358802 containerd[1397]: time="2024-12-13T01:40:13.358702240Z" level=info msg="loading plugin \"io.containerd.runtime.v2.task\"..." type=io.containerd.runtime.v2 Dec 13 01:40:13.358895 containerd[1397]: time="2024-12-13T01:40:13.358877880Z" level=info msg="loading plugin \"io.containerd.runtime.v2.shim\"..." type=io.containerd.runtime.v2 Dec 13 01:40:13.358952 containerd[1397]: time="2024-12-13T01:40:13.358904840Z" level=info msg="loading plugin \"io.containerd.sandbox.store.v1.local\"..." type=io.containerd.sandbox.store.v1 Dec 13 01:40:13.358952 containerd[1397]: time="2024-12-13T01:40:13.358932800Z" level=info msg="loading plugin \"io.containerd.sandbox.controller.v1.local\"..." type=io.containerd.sandbox.controller.v1 Dec 13 01:40:13.358952 containerd[1397]: time="2024-12-13T01:40:13.358949360Z" level=info msg="loading plugin \"io.containerd.service.v1.containers-service\"..." type=io.containerd.service.v1 Dec 13 01:40:13.359005 containerd[1397]: time="2024-12-13T01:40:13.358962720Z" level=info msg="loading plugin \"io.containerd.service.v1.content-service\"..." type=io.containerd.service.v1 Dec 13 01:40:13.359005 containerd[1397]: time="2024-12-13T01:40:13.358975000Z" level=info msg="loading plugin \"io.containerd.service.v1.diff-service\"..." type=io.containerd.service.v1 Dec 13 01:40:13.359005 containerd[1397]: time="2024-12-13T01:40:13.358987440Z" level=info msg="loading plugin \"io.containerd.service.v1.images-service\"..." type=io.containerd.service.v1 Dec 13 01:40:13.359005 containerd[1397]: time="2024-12-13T01:40:13.359001240Z" level=info msg="loading plugin \"io.containerd.service.v1.introspection-service\"..." type=io.containerd.service.v1 Dec 13 01:40:13.359072 containerd[1397]: time="2024-12-13T01:40:13.359014040Z" level=info msg="loading plugin \"io.containerd.service.v1.namespaces-service\"..." type=io.containerd.service.v1 Dec 13 01:40:13.359072 containerd[1397]: time="2024-12-13T01:40:13.359025440Z" level=info msg="loading plugin \"io.containerd.service.v1.snapshots-service\"..." type=io.containerd.service.v1 Dec 13 01:40:13.359072 containerd[1397]: time="2024-12-13T01:40:13.359035800Z" level=info msg="loading plugin \"io.containerd.service.v1.tasks-service\"..." type=io.containerd.service.v1 Dec 13 01:40:13.359072 containerd[1397]: time="2024-12-13T01:40:13.359054120Z" level=info msg="loading plugin \"io.containerd.grpc.v1.containers\"..." type=io.containerd.grpc.v1 Dec 13 01:40:13.359072 containerd[1397]: time="2024-12-13T01:40:13.359068120Z" level=info msg="loading plugin \"io.containerd.grpc.v1.content\"..." type=io.containerd.grpc.v1 Dec 13 01:40:13.359152 containerd[1397]: time="2024-12-13T01:40:13.359080240Z" level=info msg="loading plugin \"io.containerd.grpc.v1.diff\"..." type=io.containerd.grpc.v1 Dec 13 01:40:13.359152 containerd[1397]: time="2024-12-13T01:40:13.359091920Z" level=info msg="loading plugin \"io.containerd.grpc.v1.events\"..." type=io.containerd.grpc.v1 Dec 13 01:40:13.359152 containerd[1397]: time="2024-12-13T01:40:13.359103480Z" level=info msg="loading plugin \"io.containerd.grpc.v1.images\"..." type=io.containerd.grpc.v1 Dec 13 01:40:13.359152 containerd[1397]: time="2024-12-13T01:40:13.359115880Z" level=info msg="loading plugin \"io.containerd.grpc.v1.introspection\"..." type=io.containerd.grpc.v1 Dec 13 01:40:13.359152 containerd[1397]: time="2024-12-13T01:40:13.359127080Z" level=info msg="loading plugin \"io.containerd.grpc.v1.leases\"..." type=io.containerd.grpc.v1 Dec 13 01:40:13.359152 containerd[1397]: time="2024-12-13T01:40:13.359138960Z" level=info msg="loading plugin \"io.containerd.grpc.v1.namespaces\"..." type=io.containerd.grpc.v1 Dec 13 01:40:13.359152 containerd[1397]: time="2024-12-13T01:40:13.359150320Z" level=info msg="loading plugin \"io.containerd.grpc.v1.sandbox-controllers\"..." type=io.containerd.grpc.v1 Dec 13 01:40:13.359277 containerd[1397]: time="2024-12-13T01:40:13.359174680Z" level=info msg="loading plugin \"io.containerd.grpc.v1.sandboxes\"..." type=io.containerd.grpc.v1 Dec 13 01:40:13.359277 containerd[1397]: time="2024-12-13T01:40:13.359188120Z" level=info msg="loading plugin \"io.containerd.grpc.v1.snapshots\"..." type=io.containerd.grpc.v1 Dec 13 01:40:13.359277 containerd[1397]: time="2024-12-13T01:40:13.359199920Z" level=info msg="loading plugin \"io.containerd.grpc.v1.streaming\"..." type=io.containerd.grpc.v1 Dec 13 01:40:13.359277 containerd[1397]: time="2024-12-13T01:40:13.359211760Z" level=info msg="loading plugin \"io.containerd.grpc.v1.tasks\"..." type=io.containerd.grpc.v1 Dec 13 01:40:13.359277 containerd[1397]: time="2024-12-13T01:40:13.359226920Z" level=info msg="loading plugin \"io.containerd.transfer.v1.local\"..." type=io.containerd.transfer.v1 Dec 13 01:40:13.359277 containerd[1397]: time="2024-12-13T01:40:13.359246160Z" level=info msg="loading plugin \"io.containerd.grpc.v1.transfer\"..." type=io.containerd.grpc.v1 Dec 13 01:40:13.359277 containerd[1397]: time="2024-12-13T01:40:13.359257520Z" level=info msg="loading plugin \"io.containerd.grpc.v1.version\"..." type=io.containerd.grpc.v1 Dec 13 01:40:13.359277 containerd[1397]: time="2024-12-13T01:40:13.359267480Z" level=info msg="loading plugin \"io.containerd.internal.v1.restart\"..." type=io.containerd.internal.v1 Dec 13 01:40:13.359916 containerd[1397]: time="2024-12-13T01:40:13.359881080Z" level=info msg="loading plugin \"io.containerd.tracing.processor.v1.otlp\"..." type=io.containerd.tracing.processor.v1 Dec 13 01:40:13.359955 containerd[1397]: time="2024-12-13T01:40:13.359911440Z" 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 Dec 13 01:40:13.359955 containerd[1397]: time="2024-12-13T01:40:13.359949560Z" level=info msg="loading plugin \"io.containerd.internal.v1.tracing\"..." type=io.containerd.internal.v1 Dec 13 01:40:13.359991 containerd[1397]: time="2024-12-13T01:40:13.359963240Z" level=info msg="skip loading plugin \"io.containerd.internal.v1.tracing\"..." error="skip plugin: tracing endpoint not configured" type=io.containerd.internal.v1 Dec 13 01:40:13.359991 containerd[1397]: time="2024-12-13T01:40:13.359973240Z" level=info msg="loading plugin \"io.containerd.grpc.v1.healthcheck\"..." type=io.containerd.grpc.v1 Dec 13 01:40:13.360025 containerd[1397]: time="2024-12-13T01:40:13.359996160Z" level=info msg="loading plugin \"io.containerd.nri.v1.nri\"..." type=io.containerd.nri.v1 Dec 13 01:40:13.360025 containerd[1397]: time="2024-12-13T01:40:13.360006480Z" level=info msg="NRI interface is disabled by configuration." Dec 13 01:40:13.360025 containerd[1397]: time="2024-12-13T01:40:13.360017320Z" level=info msg="loading plugin \"io.containerd.grpc.v1.cri\"..." type=io.containerd.grpc.v1 Dec 13 01:40:13.360387 containerd[1397]: time="2024-12-13T01:40:13.360331880Z" 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}" Dec 13 01:40:13.360488 containerd[1397]: time="2024-12-13T01:40:13.360389800Z" level=info msg="Connect containerd service" Dec 13 01:40:13.360488 containerd[1397]: time="2024-12-13T01:40:13.360416920Z" level=info msg="using legacy CRI server" Dec 13 01:40:13.360488 containerd[1397]: time="2024-12-13T01:40:13.360423360Z" level=info msg="using experimental NRI integration - disable nri plugin to prevent this" Dec 13 01:40:13.360545 containerd[1397]: time="2024-12-13T01:40:13.360492480Z" level=info msg="Get image filesystem path \"/var/lib/containerd/io.containerd.snapshotter.v1.overlayfs\"" Dec 13 01:40:13.361021 containerd[1397]: time="2024-12-13T01:40:13.360997720Z" 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" Dec 13 01:40:13.361244 containerd[1397]: time="2024-12-13T01:40:13.361204480Z" level=info msg="Start subscribing containerd event" Dec 13 01:40:13.361265 containerd[1397]: time="2024-12-13T01:40:13.361258640Z" level=info msg="Start recovering state" Dec 13 01:40:13.361334 containerd[1397]: time="2024-12-13T01:40:13.361321080Z" level=info msg="Start event monitor" Dec 13 01:40:13.361354 containerd[1397]: time="2024-12-13T01:40:13.361336840Z" level=info msg="Start snapshots syncer" Dec 13 01:40:13.361354 containerd[1397]: time="2024-12-13T01:40:13.361346560Z" level=info msg="Start cni network conf syncer for default" Dec 13 01:40:13.361395 containerd[1397]: time="2024-12-13T01:40:13.361354360Z" level=info msg="Start streaming server" Dec 13 01:40:13.361521 containerd[1397]: time="2024-12-13T01:40:13.361461040Z" level=info msg=serving... address=/run/containerd/containerd.sock.ttrpc Dec 13 01:40:13.361521 containerd[1397]: time="2024-12-13T01:40:13.361506440Z" level=info msg=serving... address=/run/containerd/containerd.sock Dec 13 01:40:13.361577 containerd[1397]: time="2024-12-13T01:40:13.361556600Z" level=info msg="containerd successfully booted in 0.030648s" Dec 13 01:40:13.361679 systemd[1]: Started containerd.service - containerd container runtime. Dec 13 01:40:13.853707 systemd[1]: Created slice system-sshd.slice - Slice /system/sshd. Dec 13 01:40:13.855688 systemd[1]: Started sshd@0-10.0.0.104:22-10.0.0.1:60132.service - OpenSSH per-connection server daemon (10.0.0.1:60132). Dec 13 01:40:13.908467 sshd[1434]: Accepted publickey for core from 10.0.0.1 port 60132 ssh2: RSA SHA256:yVKhZEHbC7ylZ7bY3Y8pwdh1t/xp6Vz/y3yLFfd9j+Q Dec 13 01:40:13.910180 sshd[1434]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Dec 13 01:40:13.917333 systemd[1]: Created slice user-500.slice - User Slice of UID 500. Dec 13 01:40:13.928124 systemd[1]: Starting user-runtime-dir@500.service - User Runtime Directory /run/user/500... Dec 13 01:40:13.930484 systemd-logind[1380]: New session 1 of user core. Dec 13 01:40:13.938983 systemd[1]: Finished user-runtime-dir@500.service - User Runtime Directory /run/user/500. Dec 13 01:40:13.941965 systemd[1]: Starting user@500.service - User Manager for UID 500... Dec 13 01:40:13.949812 (systemd)[1438]: pam_unix(systemd-user:session): session opened for user core(uid=500) by (uid=0) Dec 13 01:40:14.023647 systemd[1438]: Queued start job for default target default.target. Dec 13 01:40:14.031844 systemd[1438]: Created slice app.slice - User Application Slice. Dec 13 01:40:14.031872 systemd[1438]: Reached target paths.target - Paths. Dec 13 01:40:14.031883 systemd[1438]: Reached target timers.target - Timers. Dec 13 01:40:14.033043 systemd[1438]: Starting dbus.socket - D-Bus User Message Bus Socket... Dec 13 01:40:14.041971 systemd[1438]: Listening on dbus.socket - D-Bus User Message Bus Socket. Dec 13 01:40:14.042024 systemd[1438]: Reached target sockets.target - Sockets. Dec 13 01:40:14.042036 systemd[1438]: Reached target basic.target - Basic System. Dec 13 01:40:14.042071 systemd[1438]: Reached target default.target - Main User Target. Dec 13 01:40:14.042095 systemd[1438]: Startup finished in 87ms. Dec 13 01:40:14.042355 systemd[1]: Started user@500.service - User Manager for UID 500. Dec 13 01:40:14.044201 systemd[1]: Started session-1.scope - Session 1 of User core. Dec 13 01:40:14.112360 systemd[1]: Started sshd@1-10.0.0.104:22-10.0.0.1:42314.service - OpenSSH per-connection server daemon (10.0.0.1:42314). Dec 13 01:40:14.148315 sshd[1449]: Accepted publickey for core from 10.0.0.1 port 42314 ssh2: RSA SHA256:yVKhZEHbC7ylZ7bY3Y8pwdh1t/xp6Vz/y3yLFfd9j+Q Dec 13 01:40:14.149528 sshd[1449]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Dec 13 01:40:14.153327 systemd-logind[1380]: New session 2 of user core. Dec 13 01:40:14.161065 systemd[1]: Started session-2.scope - Session 2 of User core. Dec 13 01:40:14.211898 sshd[1449]: pam_unix(sshd:session): session closed for user core Dec 13 01:40:14.223037 systemd[1]: sshd@1-10.0.0.104:22-10.0.0.1:42314.service: Deactivated successfully. Dec 13 01:40:14.225211 systemd[1]: session-2.scope: Deactivated successfully. Dec 13 01:40:14.226273 systemd-logind[1380]: Session 2 logged out. Waiting for processes to exit. Dec 13 01:40:14.232144 systemd[1]: Started sshd@2-10.0.0.104:22-10.0.0.1:42322.service - OpenSSH per-connection server daemon (10.0.0.1:42322). Dec 13 01:40:14.233842 systemd-logind[1380]: Removed session 2. Dec 13 01:40:14.265139 sshd[1456]: Accepted publickey for core from 10.0.0.1 port 42322 ssh2: RSA SHA256:yVKhZEHbC7ylZ7bY3Y8pwdh1t/xp6Vz/y3yLFfd9j+Q Dec 13 01:40:14.266233 sshd[1456]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Dec 13 01:40:14.269345 systemd-logind[1380]: New session 3 of user core. Dec 13 01:40:14.287039 systemd[1]: Started session-3.scope - Session 3 of User core. Dec 13 01:40:14.337792 sshd[1456]: pam_unix(sshd:session): session closed for user core Dec 13 01:40:14.340499 systemd[1]: sshd@2-10.0.0.104:22-10.0.0.1:42322.service: Deactivated successfully. Dec 13 01:40:14.343153 systemd[1]: session-3.scope: Deactivated successfully. Dec 13 01:40:14.343651 systemd-logind[1380]: Session 3 logged out. Waiting for processes to exit. Dec 13 01:40:14.344423 systemd-logind[1380]: Removed session 3. Dec 13 01:40:14.406047 systemd-networkd[1330]: eth0: Gained IPv6LL Dec 13 01:40:14.406606 systemd-timesyncd[1323]: Network configuration changed, trying to establish connection. Dec 13 01:40:14.407773 systemd[1]: Finished systemd-networkd-wait-online.service - Wait for Network to be Configured. Dec 13 01:40:14.409604 systemd[1]: Reached target network-online.target - Network is Online. Dec 13 01:40:14.423206 systemd[1]: Starting coreos-metadata.service - QEMU metadata agent... Dec 13 01:40:14.424878 systemd[1]: Starting nvidia.service - NVIDIA Configure Service... Dec 13 01:40:14.438808 systemd[1]: coreos-metadata.service: Deactivated successfully. Dec 13 01:40:14.438993 systemd[1]: Finished coreos-metadata.service - QEMU metadata agent. Dec 13 01:40:14.440186 systemd[1]: packet-phone-home.service - Report Success to Packet was skipped because of an unmet condition check (ConditionFirstBoot=true). Dec 13 01:40:14.445377 systemd[1]: Finished nvidia.service - NVIDIA Configure Service. Dec 13 01:40:14.448410 systemd[1]: Reached target multi-user.target - Multi-User System. Dec 13 01:40:14.449303 systemd[1]: cryptenroll-helper-first.service was skipped because of an unmet condition check (ConditionFirstBoot=true). Dec 13 01:40:14.452023 systemd[1]: Startup finished in 563ms (kernel) + 2.133s (initrd) + 2.627s (userspace) = 5.325s. Dec 13 01:40:15.145316 systemd-timesyncd[1323]: Network configuration changed, trying to establish connection. Dec 13 01:40:17.158603 systemd-timesyncd[1323]: Network configuration changed, trying to establish connection. Dec 13 01:40:24.352378 systemd[1]: Started sshd@3-10.0.0.104:22-10.0.0.1:60910.service - OpenSSH per-connection server daemon (10.0.0.1:60910). Dec 13 01:40:24.388892 sshd[1481]: Accepted publickey for core from 10.0.0.1 port 60910 ssh2: RSA SHA256:yVKhZEHbC7ylZ7bY3Y8pwdh1t/xp6Vz/y3yLFfd9j+Q Dec 13 01:40:24.390061 sshd[1481]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Dec 13 01:40:24.393703 systemd-logind[1380]: New session 4 of user core. Dec 13 01:40:24.402066 systemd[1]: Started session-4.scope - Session 4 of User core. Dec 13 01:40:24.452983 sshd[1481]: pam_unix(sshd:session): session closed for user core Dec 13 01:40:24.460872 systemd[1]: sshd@3-10.0.0.104:22-10.0.0.1:60910.service: Deactivated successfully. Dec 13 01:40:24.462168 systemd[1]: session-4.scope: Deactivated successfully. Dec 13 01:40:24.463263 systemd-logind[1380]: Session 4 logged out. Waiting for processes to exit. Dec 13 01:40:24.464347 systemd[1]: Started sshd@4-10.0.0.104:22-10.0.0.1:60914.service - OpenSSH per-connection server daemon (10.0.0.1:60914). Dec 13 01:40:24.467332 systemd-logind[1380]: Removed session 4. Dec 13 01:40:24.500132 sshd[1488]: Accepted publickey for core from 10.0.0.1 port 60914 ssh2: RSA SHA256:yVKhZEHbC7ylZ7bY3Y8pwdh1t/xp6Vz/y3yLFfd9j+Q Dec 13 01:40:24.501456 sshd[1488]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Dec 13 01:40:24.505567 systemd-logind[1380]: New session 5 of user core. Dec 13 01:40:24.514055 systemd[1]: Started session-5.scope - Session 5 of User core. Dec 13 01:40:24.562078 sshd[1488]: pam_unix(sshd:session): session closed for user core Dec 13 01:40:24.581558 systemd[1]: sshd@4-10.0.0.104:22-10.0.0.1:60914.service: Deactivated successfully. Dec 13 01:40:24.584182 systemd[1]: session-5.scope: Deactivated successfully. Dec 13 01:40:24.585347 systemd-logind[1380]: Session 5 logged out. Waiting for processes to exit. Dec 13 01:40:24.586420 systemd[1]: Started sshd@5-10.0.0.104:22-10.0.0.1:60930.service - OpenSSH per-connection server daemon (10.0.0.1:60930). Dec 13 01:40:24.587107 systemd-logind[1380]: Removed session 5. Dec 13 01:40:24.622573 sshd[1495]: Accepted publickey for core from 10.0.0.1 port 60930 ssh2: RSA SHA256:yVKhZEHbC7ylZ7bY3Y8pwdh1t/xp6Vz/y3yLFfd9j+Q Dec 13 01:40:24.624431 sshd[1495]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Dec 13 01:40:24.628603 systemd-logind[1380]: New session 6 of user core. Dec 13 01:40:24.639142 systemd[1]: Started session-6.scope - Session 6 of User core. Dec 13 01:40:24.690955 sshd[1495]: pam_unix(sshd:session): session closed for user core Dec 13 01:40:24.700038 systemd[1]: sshd@5-10.0.0.104:22-10.0.0.1:60930.service: Deactivated successfully. Dec 13 01:40:24.701246 systemd[1]: session-6.scope: Deactivated successfully. Dec 13 01:40:24.703971 systemd-logind[1380]: Session 6 logged out. Waiting for processes to exit. Dec 13 01:40:24.704506 systemd[1]: Started sshd@6-10.0.0.104:22-10.0.0.1:60940.service - OpenSSH per-connection server daemon (10.0.0.1:60940). Dec 13 01:40:24.705276 systemd-logind[1380]: Removed session 6. Dec 13 01:40:24.740357 sshd[1502]: Accepted publickey for core from 10.0.0.1 port 60940 ssh2: RSA SHA256:yVKhZEHbC7ylZ7bY3Y8pwdh1t/xp6Vz/y3yLFfd9j+Q Dec 13 01:40:24.741487 sshd[1502]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Dec 13 01:40:24.745511 systemd-logind[1380]: New session 7 of user core. Dec 13 01:40:24.751061 systemd[1]: Started session-7.scope - Session 7 of User core. Dec 13 01:40:24.811122 sudo[1505]: core : PWD=/home/core ; USER=root ; COMMAND=/usr/sbin/setenforce 1 Dec 13 01:40:24.811418 sudo[1505]: pam_unix(sudo:session): session opened for user root(uid=0) by core(uid=500) Dec 13 01:40:24.815969 kernel: audit: type=1404 audit(1734054024.813:3): enforcing=1 old_enforcing=0 auid=500 ses=7 enabled=1 old-enabled=1 lsm=selinux res=1 Dec 13 01:40:24.828809 sudo[1505]: pam_unix(sudo:session): session closed for user root Dec 13 01:40:24.832345 sshd[1502]: pam_unix(sshd:session): session closed for user core Dec 13 01:40:24.842372 systemd[1]: sshd@6-10.0.0.104:22-10.0.0.1:60940.service: Deactivated successfully. Dec 13 01:40:24.845148 systemd[1]: session-7.scope: Deactivated successfully. Dec 13 01:40:24.846315 systemd-logind[1380]: Session 7 logged out. Waiting for processes to exit. Dec 13 01:40:24.857245 systemd[1]: Started sshd@7-10.0.0.104:22-10.0.0.1:60956.service - OpenSSH per-connection server daemon (10.0.0.1:60956). Dec 13 01:40:24.858256 systemd-logind[1380]: Removed session 7. Dec 13 01:40:24.891718 sshd[1510]: Accepted publickey for core from 10.0.0.1 port 60956 ssh2: RSA SHA256:yVKhZEHbC7ylZ7bY3Y8pwdh1t/xp6Vz/y3yLFfd9j+Q Dec 13 01:40:24.893678 sshd[1510]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Dec 13 01:40:24.897777 systemd-logind[1380]: New session 8 of user core. Dec 13 01:40:24.907083 systemd[1]: Started session-8.scope - Session 8 of User core. Dec 13 01:40:24.957748 sudo[1514]: core : PWD=/home/core ; USER=root ; COMMAND=/usr/bin/rm -rf /etc/audit/rules.d/80-selinux.rules /etc/audit/rules.d/99-default.rules Dec 13 01:40:24.958038 sudo[1514]: pam_unix(sudo:session): session opened for user root(uid=0) by core(uid=500) Dec 13 01:40:24.960804 sudo[1514]: pam_unix(sudo:session): session closed for user root Dec 13 01:40:24.965204 sudo[1513]: core : PWD=/home/core ; USER=root ; COMMAND=/usr/bin/systemctl restart audit-rules Dec 13 01:40:24.965469 sudo[1513]: pam_unix(sudo:session): session opened for user root(uid=0) by core(uid=500) Dec 13 01:40:24.980192 systemd[1]: Stopping audit-rules.service - Load Security Auditing Rules... Dec 13 01:40:24.981273 auditctl[1517]: No rules Dec 13 01:40:24.982088 systemd[1]: audit-rules.service: Deactivated successfully. Dec 13 01:40:24.983964 systemd[1]: Stopped audit-rules.service - Load Security Auditing Rules. Dec 13 01:40:24.985579 systemd[1]: Starting audit-rules.service - Load Security Auditing Rules... Dec 13 01:40:24.999730 augenrules[1521]: /sbin/augenrules: No change Dec 13 01:40:25.001656 augenrules[1531]: No rules Dec 13 01:40:25.002741 systemd[1]: Finished audit-rules.service - Load Security Auditing Rules. Dec 13 01:40:25.003690 sudo[1513]: pam_unix(sudo:session): session closed for user root Dec 13 01:40:25.005147 sshd[1510]: pam_unix(sshd:session): session closed for user core Dec 13 01:40:25.015423 systemd[1]: sshd@7-10.0.0.104:22-10.0.0.1:60956.service: Deactivated successfully. Dec 13 01:40:25.016744 systemd[1]: session-8.scope: Deactivated successfully. Dec 13 01:40:25.017942 systemd-logind[1380]: Session 8 logged out. Waiting for processes to exit. Dec 13 01:40:25.019039 systemd[1]: Started sshd@8-10.0.0.104:22-10.0.0.1:60958.service - OpenSSH per-connection server daemon (10.0.0.1:60958). Dec 13 01:40:25.019680 systemd-logind[1380]: Removed session 8. Dec 13 01:40:25.055079 sshd[1539]: Accepted publickey for core from 10.0.0.1 port 60958 ssh2: RSA SHA256:yVKhZEHbC7ylZ7bY3Y8pwdh1t/xp6Vz/y3yLFfd9j+Q Dec 13 01:40:25.056317 sshd[1539]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Dec 13 01:40:25.059794 systemd-logind[1380]: New session 9 of user core. Dec 13 01:40:25.071062 systemd[1]: Started session-9.scope - Session 9 of User core. Dec 13 01:40:25.121636 sshd[1539]: pam_unix(sshd:session): session closed for user core Dec 13 01:40:25.131163 systemd[1]: sshd@8-10.0.0.104:22-10.0.0.1:60958.service: Deactivated successfully. Dec 13 01:40:25.132624 systemd[1]: session-9.scope: Deactivated successfully. Dec 13 01:40:25.133884 systemd-logind[1380]: Session 9 logged out. Waiting for processes to exit. Dec 13 01:40:25.153234 systemd[1]: Started sshd@9-10.0.0.104:22-10.0.0.1:60968.service - OpenSSH per-connection server daemon (10.0.0.1:60968). Dec 13 01:40:25.154133 systemd-logind[1380]: Removed session 9. Dec 13 01:40:25.185714 sshd[1546]: Accepted publickey for core from 10.0.0.1 port 60968 ssh2: RSA SHA256:yVKhZEHbC7ylZ7bY3Y8pwdh1t/xp6Vz/y3yLFfd9j+Q Dec 13 01:40:25.186836 sshd[1546]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Dec 13 01:40:25.190720 systemd-logind[1380]: New session 10 of user core. Dec 13 01:40:25.202126 systemd[1]: Started session-10.scope - Session 10 of User core. Dec 13 01:40:25.252378 sshd[1546]: pam_unix(sshd:session): session closed for user core Dec 13 01:40:25.255191 systemd[1]: sshd@9-10.0.0.104:22-10.0.0.1:60968.service: Deactivated successfully. Dec 13 01:40:25.256789 systemd[1]: session-10.scope: Deactivated successfully. Dec 13 01:40:25.257388 systemd-logind[1380]: Session 10 logged out. Waiting for processes to exit. Dec 13 01:40:25.258199 systemd-logind[1380]: Removed session 10.