May 12 13:22:32.912901 kernel: Booting Linux on physical CPU 0x0000000000 [0x413fd0c1] May 12 13:22:32.912921 kernel: Linux version 6.6.89-flatcar (build@pony-truck.infra.kinvolk.io) (aarch64-cros-linux-gnu-gcc (Gentoo Hardened 14.2.1_p20241221 p7) 14.2.1 20241221, GNU ld (Gentoo 2.44 p1) 2.44.0) #1 SMP PREEMPT Mon May 12 12:12:07 -00 2025 May 12 13:22:32.912931 kernel: KASLR enabled May 12 13:22:32.912936 kernel: efi: EFI v2.7 by EDK II May 12 13:22:32.912942 kernel: efi: SMBIOS 3.0=0xdced0000 MEMATTR=0xdb832018 ACPI 2.0=0xdbfd0018 RNG=0xdbfd0a18 MEMRESERVE=0xdb838218 May 12 13:22:32.912947 kernel: random: crng init done May 12 13:22:32.912954 kernel: secureboot: Secure boot disabled May 12 13:22:32.912959 kernel: ACPI: Early table checksum verification disabled May 12 13:22:32.912965 kernel: ACPI: RSDP 0x00000000DBFD0018 000024 (v02 BOCHS ) May 12 13:22:32.912972 kernel: ACPI: XSDT 0x00000000DBFD0F18 000064 (v01 BOCHS BXPC 00000001 01000013) May 12 13:22:32.912978 kernel: ACPI: FACP 0x00000000DBFD0B18 000114 (v06 BOCHS BXPC 00000001 BXPC 00000001) May 12 13:22:32.912984 kernel: ACPI: DSDT 0x00000000DBF0E018 0014A2 (v02 BOCHS BXPC 00000001 BXPC 00000001) May 12 13:22:32.912989 kernel: ACPI: APIC 0x00000000DBFD0C98 0001A8 (v04 BOCHS BXPC 00000001 BXPC 00000001) May 12 13:22:32.912995 kernel: ACPI: PPTT 0x00000000DBFD0098 00009C (v02 BOCHS BXPC 00000001 BXPC 00000001) May 12 13:22:32.913002 kernel: ACPI: GTDT 0x00000000DBFD0818 000060 (v02 BOCHS BXPC 00000001 BXPC 00000001) May 12 13:22:32.913009 kernel: ACPI: MCFG 0x00000000DBFD0A98 00003C (v01 BOCHS BXPC 00000001 BXPC 00000001) May 12 13:22:32.913015 kernel: ACPI: SPCR 0x00000000DBFD0918 000050 (v02 BOCHS BXPC 00000001 BXPC 00000001) May 12 13:22:32.913021 kernel: ACPI: DBG2 0x00000000DBFD0998 000057 (v00 BOCHS BXPC 00000001 BXPC 00000001) May 12 13:22:32.913027 kernel: ACPI: IORT 0x00000000DBFD0198 000080 (v03 BOCHS BXPC 00000001 BXPC 00000001) May 12 13:22:32.913043 kernel: ACPI: SPCR: console: pl011,mmio,0x9000000,9600 May 12 13:22:32.913050 kernel: NUMA: Failed to initialise from firmware May 12 13:22:32.913056 kernel: NUMA: Faking a node at [mem 0x0000000040000000-0x00000000dcffffff] May 12 13:22:32.913062 kernel: NUMA: NODE_DATA [mem 0xdc954e00-0xdc95bfff] May 12 13:22:32.913068 kernel: Zone ranges: May 12 13:22:32.913074 kernel: DMA [mem 0x0000000040000000-0x00000000dcffffff] May 12 13:22:32.913082 kernel: DMA32 empty May 12 13:22:32.913088 kernel: Normal empty May 12 13:22:32.913094 kernel: Device empty May 12 13:22:32.913100 kernel: Movable zone start for each node May 12 13:22:32.913106 kernel: Early memory node ranges May 12 13:22:32.913112 kernel: node 0: [mem 0x0000000040000000-0x00000000db81ffff] May 12 13:22:32.913118 kernel: node 0: [mem 0x00000000db820000-0x00000000db82ffff] May 12 13:22:32.913123 kernel: node 0: [mem 0x00000000db830000-0x00000000dc09ffff] May 12 13:22:32.913129 kernel: node 0: [mem 0x00000000dc0a0000-0x00000000dc2dffff] May 12 13:22:32.913135 kernel: node 0: [mem 0x00000000dc2e0000-0x00000000dc36ffff] May 12 13:22:32.913141 kernel: node 0: [mem 0x00000000dc370000-0x00000000dc45ffff] May 12 13:22:32.913147 kernel: node 0: [mem 0x00000000dc460000-0x00000000dc52ffff] May 12 13:22:32.913153 kernel: node 0: [mem 0x00000000dc530000-0x00000000dc5cffff] May 12 13:22:32.913160 kernel: node 0: [mem 0x00000000dc5d0000-0x00000000dce1ffff] May 12 13:22:32.913166 kernel: node 0: [mem 0x00000000dce20000-0x00000000dceaffff] May 12 13:22:32.913175 kernel: node 0: [mem 0x00000000dceb0000-0x00000000dcebffff] May 12 13:22:32.913181 kernel: node 0: [mem 0x00000000dcec0000-0x00000000dcfdffff] May 12 13:22:32.913187 kernel: node 0: [mem 0x00000000dcfe0000-0x00000000dcffffff] May 12 13:22:32.913195 kernel: Initmem setup node 0 [mem 0x0000000040000000-0x00000000dcffffff] May 12 13:22:32.913201 kernel: On node 0, zone DMA: 12288 pages in unavailable ranges May 12 13:22:32.913207 kernel: psci: probing for conduit method from ACPI. May 12 13:22:32.913214 kernel: psci: PSCIv1.1 detected in firmware. May 12 13:22:32.913220 kernel: psci: Using standard PSCI v0.2 function IDs May 12 13:22:32.913226 kernel: psci: Trusted OS migration not required May 12 13:22:32.913232 kernel: psci: SMC Calling Convention v1.1 May 12 13:22:32.913239 kernel: smccc: KVM: hypervisor services detected (0x00000000 0x00000000 0x00000000 0x00000003) May 12 13:22:32.913246 kernel: percpu: Embedded 31 pages/cpu s87016 r8192 d31768 u126976 May 12 13:22:32.913252 kernel: pcpu-alloc: s87016 r8192 d31768 u126976 alloc=31*4096 May 12 13:22:32.913258 kernel: pcpu-alloc: [0] 0 [0] 1 [0] 2 [0] 3 May 12 13:22:32.913266 kernel: Detected PIPT I-cache on CPU0 May 12 13:22:32.913272 kernel: CPU features: detected: GIC system register CPU interface May 12 13:22:32.913279 kernel: CPU features: detected: Hardware dirty bit management May 12 13:22:32.913285 kernel: CPU features: detected: Spectre-v4 May 12 13:22:32.913291 kernel: CPU features: detected: Spectre-BHB May 12 13:22:32.913297 kernel: CPU features: kernel page table isolation forced ON by KASLR May 12 13:22:32.913304 kernel: CPU features: detected: Kernel page table isolation (KPTI) May 12 13:22:32.913310 kernel: CPU features: detected: ARM erratum 1418040 May 12 13:22:32.913316 kernel: CPU features: detected: SSBS not fully self-synchronizing May 12 13:22:32.913322 kernel: alternatives: applying boot alternatives May 12 13:22:32.913330 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=653a96bf2da883847e3396e932e31f09e53181a834ffc22434c3993d29b70a16 May 12 13:22:32.913337 kernel: Unknown kernel command line parameters "BOOT_IMAGE=/flatcar/vmlinuz-a", will be passed to user space. May 12 13:22:32.913344 kernel: Dentry cache hash table entries: 524288 (order: 10, 4194304 bytes, linear) May 12 13:22:32.913350 kernel: Inode-cache hash table entries: 262144 (order: 9, 2097152 bytes, linear) May 12 13:22:32.913357 kernel: Fallback order for Node 0: 0 May 12 13:22:32.913363 kernel: Built 1 zonelists, mobility grouping on. Total pages: 633024 May 12 13:22:32.913369 kernel: Policy zone: DMA May 12 13:22:32.913375 kernel: mem auto-init: stack:off, heap alloc:off, heap free:off May 12 13:22:32.913382 kernel: software IO TLB: area num 4. May 12 13:22:32.913388 kernel: software IO TLB: mapped [mem 0x00000000d5000000-0x00000000d9000000] (64MB) May 12 13:22:32.913395 kernel: Memory: 2386496K/2572288K available (10432K kernel code, 2202K rwdata, 8168K rodata, 39040K init, 993K bss, 185792K reserved, 0K cma-reserved) May 12 13:22:32.913401 kernel: SLUB: HWalign=64, Order=0-3, MinObjects=0, CPUs=4, Nodes=1 May 12 13:22:32.913409 kernel: rcu: Preemptible hierarchical RCU implementation. May 12 13:22:32.913416 kernel: rcu: RCU event tracing is enabled. May 12 13:22:32.913422 kernel: rcu: RCU restricting CPUs from NR_CPUS=512 to nr_cpu_ids=4. May 12 13:22:32.913449 kernel: Trampoline variant of Tasks RCU enabled. May 12 13:22:32.913456 kernel: Tracing variant of Tasks RCU enabled. May 12 13:22:32.913463 kernel: rcu: RCU calculated value of scheduler-enlistment delay is 100 jiffies. May 12 13:22:32.913469 kernel: rcu: Adjusting geometry for rcu_fanout_leaf=16, nr_cpu_ids=4 May 12 13:22:32.913475 kernel: NR_IRQS: 64, nr_irqs: 64, preallocated irqs: 0 May 12 13:22:32.913482 kernel: GICv3: 256 SPIs implemented May 12 13:22:32.913488 kernel: GICv3: 0 Extended SPIs implemented May 12 13:22:32.913494 kernel: Root IRQ handler: gic_handle_irq May 12 13:22:32.913501 kernel: GICv3: GICv3 features: 16 PPIs, DirectLPI May 12 13:22:32.913509 kernel: GICv3: CPU0: found redistributor 0 region 0:0x00000000080a0000 May 12 13:22:32.913515 kernel: ITS [mem 0x08080000-0x0809ffff] May 12 13:22:32.913521 kernel: ITS@0x0000000008080000: allocated 8192 Devices @400d0000 (indirect, esz 8, psz 64K, shr 1) May 12 13:22:32.913528 kernel: ITS@0x0000000008080000: allocated 8192 Interrupt Collections @400e0000 (flat, esz 8, psz 64K, shr 1) May 12 13:22:32.913534 kernel: GICv3: using LPI property table @0x00000000400f0000 May 12 13:22:32.913541 kernel: GICv3: CPU0: using allocated LPI pending table @0x0000000040100000 May 12 13:22:32.913547 kernel: rcu: srcu_init: Setting srcu_struct sizes based on contention. May 12 13:22:32.913553 kernel: arch_timer: Enabling local workaround for ARM erratum 1418040 May 12 13:22:32.913560 kernel: arch_timer: cp15 timer(s) running at 25.00MHz (virt). May 12 13:22:32.913566 kernel: clocksource: arch_sys_counter: mask: 0xffffffffffffff max_cycles: 0x5c40939b5, max_idle_ns: 440795202646 ns May 12 13:22:32.913573 kernel: sched_clock: 56 bits at 25MHz, resolution 40ns, wraps every 4398046511100ns May 12 13:22:32.913580 kernel: arm-pv: using stolen time PV May 12 13:22:32.913587 kernel: Console: colour dummy device 80x25 May 12 13:22:32.913594 kernel: ACPI: Core revision 20230628 May 12 13:22:32.913600 kernel: Calibrating delay loop (skipped), value calculated using timer frequency.. 50.00 BogoMIPS (lpj=25000) May 12 13:22:32.913607 kernel: pid_max: default: 32768 minimum: 301 May 12 13:22:32.913613 kernel: LSM: initializing lsm=lockdown,capability,landlock,selinux,integrity May 12 13:22:32.913620 kernel: landlock: Up and running. May 12 13:22:32.913626 kernel: SELinux: Initializing. May 12 13:22:32.913633 kernel: Mount-cache hash table entries: 8192 (order: 4, 65536 bytes, linear) May 12 13:22:32.913640 kernel: Mountpoint-cache hash table entries: 8192 (order: 4, 65536 bytes, linear) May 12 13:22:32.913647 kernel: ACPI PPTT: PPTT table found, but unable to locate core 3 (3) May 12 13:22:32.913654 kernel: RCU Tasks: Setting shift to 2 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=4. May 12 13:22:32.913661 kernel: RCU Tasks Trace: Setting shift to 2 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=4. May 12 13:22:32.913667 kernel: rcu: Hierarchical SRCU implementation. May 12 13:22:32.913674 kernel: rcu: Max phase no-delay instances is 400. May 12 13:22:32.913680 kernel: Platform MSI: ITS@0x8080000 domain created May 12 13:22:32.913686 kernel: PCI/MSI: ITS@0x8080000 domain created May 12 13:22:32.913693 kernel: Remapping and enabling EFI services. May 12 13:22:32.913701 kernel: smp: Bringing up secondary CPUs ... May 12 13:22:32.913712 kernel: Detected PIPT I-cache on CPU1 May 12 13:22:32.913719 kernel: GICv3: CPU1: found redistributor 1 region 0:0x00000000080c0000 May 12 13:22:32.913727 kernel: GICv3: CPU1: using allocated LPI pending table @0x0000000040110000 May 12 13:22:32.913733 kernel: arch_timer: Enabling local workaround for ARM erratum 1418040 May 12 13:22:32.913740 kernel: CPU1: Booted secondary processor 0x0000000001 [0x413fd0c1] May 12 13:22:32.913747 kernel: Detected PIPT I-cache on CPU2 May 12 13:22:32.913754 kernel: GICv3: CPU2: found redistributor 2 region 0:0x00000000080e0000 May 12 13:22:32.913761 kernel: GICv3: CPU2: using allocated LPI pending table @0x0000000040120000 May 12 13:22:32.913770 kernel: arch_timer: Enabling local workaround for ARM erratum 1418040 May 12 13:22:32.913776 kernel: CPU2: Booted secondary processor 0x0000000002 [0x413fd0c1] May 12 13:22:32.913783 kernel: Detected PIPT I-cache on CPU3 May 12 13:22:32.913790 kernel: GICv3: CPU3: found redistributor 3 region 0:0x0000000008100000 May 12 13:22:32.913797 kernel: GICv3: CPU3: using allocated LPI pending table @0x0000000040130000 May 12 13:22:32.913804 kernel: arch_timer: Enabling local workaround for ARM erratum 1418040 May 12 13:22:32.913810 kernel: CPU3: Booted secondary processor 0x0000000003 [0x413fd0c1] May 12 13:22:32.913817 kernel: smp: Brought up 1 node, 4 CPUs May 12 13:22:32.913824 kernel: SMP: Total of 4 processors activated. May 12 13:22:32.913832 kernel: CPU features: detected: 32-bit EL0 Support May 12 13:22:32.913839 kernel: CPU features: detected: Data cache clean to the PoU not required for I/D coherence May 12 13:22:32.913846 kernel: CPU features: detected: Common not Private translations May 12 13:22:32.913853 kernel: CPU features: detected: CRC32 instructions May 12 13:22:32.913860 kernel: CPU features: detected: Enhanced Virtualization Traps May 12 13:22:32.913866 kernel: CPU features: detected: RCpc load-acquire (LDAPR) May 12 13:22:32.913873 kernel: CPU features: detected: LSE atomic instructions May 12 13:22:32.913884 kernel: CPU features: detected: Privileged Access Never May 12 13:22:32.913892 kernel: CPU features: detected: RAS Extension Support May 12 13:22:32.913901 kernel: CPU features: detected: Speculative Store Bypassing Safe (SSBS) May 12 13:22:32.913907 kernel: CPU: All CPU(s) started at EL1 May 12 13:22:32.913914 kernel: alternatives: applying system-wide alternatives May 12 13:22:32.913921 kernel: devtmpfs: initialized May 12 13:22:32.913928 kernel: clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1911260446275000 ns May 12 13:22:32.913935 kernel: futex hash table entries: 1024 (order: 4, 65536 bytes, linear) May 12 13:22:32.913942 kernel: pinctrl core: initialized pinctrl subsystem May 12 13:22:32.913948 kernel: SMBIOS 3.0.0 present. May 12 13:22:32.913955 kernel: DMI: QEMU KVM Virtual Machine, BIOS unknown 02/02/2022 May 12 13:22:32.913963 kernel: NET: Registered PF_NETLINK/PF_ROUTE protocol family May 12 13:22:32.913970 kernel: DMA: preallocated 512 KiB GFP_KERNEL pool for atomic allocations May 12 13:22:32.913977 kernel: DMA: preallocated 512 KiB GFP_KERNEL|GFP_DMA pool for atomic allocations May 12 13:22:32.913984 kernel: DMA: preallocated 512 KiB GFP_KERNEL|GFP_DMA32 pool for atomic allocations May 12 13:22:32.913991 kernel: audit: initializing netlink subsys (disabled) May 12 13:22:32.913998 kernel: audit: type=2000 audit(0.019:1): state=initialized audit_enabled=0 res=1 May 12 13:22:32.914005 kernel: thermal_sys: Registered thermal governor 'step_wise' May 12 13:22:32.914012 kernel: cpuidle: using governor menu May 12 13:22:32.914018 kernel: hw-breakpoint: found 6 breakpoint and 4 watchpoint registers. May 12 13:22:32.914026 kernel: ASID allocator initialised with 32768 entries May 12 13:22:32.914038 kernel: acpiphp: ACPI Hot Plug PCI Controller Driver version: 0.5 May 12 13:22:32.914045 kernel: Serial: AMBA PL011 UART driver May 12 13:22:32.914052 kernel: Modules: 2G module region forced by RANDOMIZE_MODULE_REGION_FULL May 12 13:22:32.914059 kernel: Modules: 0 pages in range for non-PLT usage May 12 13:22:32.914066 kernel: Modules: 509024 pages in range for PLT usage May 12 13:22:32.914073 kernel: HugeTLB: registered 1.00 GiB page size, pre-allocated 0 pages May 12 13:22:32.914080 kernel: HugeTLB: 0 KiB vmemmap can be freed for a 1.00 GiB page May 12 13:22:32.914087 kernel: HugeTLB: registered 32.0 MiB page size, pre-allocated 0 pages May 12 13:22:32.914095 kernel: HugeTLB: 0 KiB vmemmap can be freed for a 32.0 MiB page May 12 13:22:32.914102 kernel: HugeTLB: registered 2.00 MiB page size, pre-allocated 0 pages May 12 13:22:32.914109 kernel: HugeTLB: 0 KiB vmemmap can be freed for a 2.00 MiB page May 12 13:22:32.914116 kernel: HugeTLB: registered 64.0 KiB page size, pre-allocated 0 pages May 12 13:22:32.914123 kernel: HugeTLB: 0 KiB vmemmap can be freed for a 64.0 KiB page May 12 13:22:32.914129 kernel: ACPI: Added _OSI(Module Device) May 12 13:22:32.914136 kernel: ACPI: Added _OSI(Processor Device) May 12 13:22:32.914143 kernel: ACPI: Added _OSI(3.0 _SCP Extensions) May 12 13:22:32.914150 kernel: ACPI: Added _OSI(Processor Aggregator Device) May 12 13:22:32.914159 kernel: ACPI: 1 ACPI AML tables successfully acquired and loaded May 12 13:22:32.914166 kernel: ACPI: Interpreter enabled May 12 13:22:32.914172 kernel: ACPI: Using GIC for interrupt routing May 12 13:22:32.914179 kernel: ACPI: MCFG table detected, 1 entries May 12 13:22:32.914186 kernel: ARMH0011:00: ttyAMA0 at MMIO 0x9000000 (irq = 12, base_baud = 0) is a SBSA May 12 13:22:32.914193 kernel: printk: console [ttyAMA0] enabled May 12 13:22:32.914200 kernel: ACPI: PCI Root Bridge [PCI0] (domain 0000 [bus 00-ff]) May 12 13:22:32.914333 kernel: acpi PNP0A08:00: _OSC: OS supports [ExtendedConfig ASPM ClockPM Segments MSI HPX-Type3] May 12 13:22:32.914407 kernel: acpi PNP0A08:00: _OSC: platform does not support [LTR] May 12 13:22:32.914485 kernel: acpi PNP0A08:00: _OSC: OS now controls [PCIeHotplug PME AER PCIeCapability] May 12 13:22:32.914550 kernel: acpi PNP0A08:00: ECAM area [mem 0x4010000000-0x401fffffff] reserved by PNP0C02:00 May 12 13:22:32.914610 kernel: acpi PNP0A08:00: ECAM at [mem 0x4010000000-0x401fffffff] for [bus 00-ff] May 12 13:22:32.914619 kernel: ACPI: Remapped I/O 0x000000003eff0000 to [io 0x0000-0xffff window] May 12 13:22:32.914626 kernel: PCI host bridge to bus 0000:00 May 12 13:22:32.914693 kernel: pci_bus 0000:00: root bus resource [mem 0x10000000-0x3efeffff window] May 12 13:22:32.914759 kernel: pci_bus 0000:00: root bus resource [io 0x0000-0xffff window] May 12 13:22:32.914815 kernel: pci_bus 0000:00: root bus resource [mem 0x8000000000-0xffffffffff window] May 12 13:22:32.914870 kernel: pci_bus 0000:00: root bus resource [bus 00-ff] May 12 13:22:32.914948 kernel: pci 0000:00:00.0: [1b36:0008] type 00 class 0x060000 May 12 13:22:32.915021 kernel: pci 0000:00:01.0: [1af4:1005] type 00 class 0x00ff00 May 12 13:22:32.915098 kernel: pci 0000:00:01.0: reg 0x10: [io 0x0000-0x001f] May 12 13:22:32.915163 kernel: pci 0000:00:01.0: reg 0x14: [mem 0x10000000-0x10000fff] May 12 13:22:32.915230 kernel: pci 0000:00:01.0: reg 0x20: [mem 0x8000000000-0x8000003fff 64bit pref] May 12 13:22:32.915293 kernel: pci 0000:00:01.0: BAR 4: assigned [mem 0x8000000000-0x8000003fff 64bit pref] May 12 13:22:32.915357 kernel: pci 0000:00:01.0: BAR 1: assigned [mem 0x10000000-0x10000fff] May 12 13:22:32.915420 kernel: pci 0000:00:01.0: BAR 0: assigned [io 0x1000-0x101f] May 12 13:22:32.915497 kernel: pci_bus 0000:00: resource 4 [mem 0x10000000-0x3efeffff window] May 12 13:22:32.915555 kernel: pci_bus 0000:00: resource 5 [io 0x0000-0xffff window] May 12 13:22:32.915612 kernel: pci_bus 0000:00: resource 6 [mem 0x8000000000-0xffffffffff window] May 12 13:22:32.915624 kernel: ACPI: PCI: Interrupt link GSI0 configured for IRQ 35 May 12 13:22:32.915631 kernel: ACPI: PCI: Interrupt link GSI1 configured for IRQ 36 May 12 13:22:32.915638 kernel: ACPI: PCI: Interrupt link GSI2 configured for IRQ 37 May 12 13:22:32.915646 kernel: ACPI: PCI: Interrupt link GSI3 configured for IRQ 38 May 12 13:22:32.915653 kernel: iommu: Default domain type: Translated May 12 13:22:32.915660 kernel: iommu: DMA domain TLB invalidation policy: strict mode May 12 13:22:32.915668 kernel: efivars: Registered efivars operations May 12 13:22:32.915675 kernel: vgaarb: loaded May 12 13:22:32.915682 kernel: clocksource: Switched to clocksource arch_sys_counter May 12 13:22:32.915691 kernel: VFS: Disk quotas dquot_6.6.0 May 12 13:22:32.915698 kernel: VFS: Dquot-cache hash table entries: 512 (order 0, 4096 bytes) May 12 13:22:32.915705 kernel: pnp: PnP ACPI init May 12 13:22:32.915781 kernel: system 00:00: [mem 0x4010000000-0x401fffffff window] could not be reserved May 12 13:22:32.915791 kernel: pnp: PnP ACPI: found 1 devices May 12 13:22:32.915798 kernel: NET: Registered PF_INET protocol family May 12 13:22:32.915805 kernel: IP idents hash table entries: 65536 (order: 7, 524288 bytes, linear) May 12 13:22:32.915812 kernel: tcp_listen_portaddr_hash hash table entries: 2048 (order: 3, 32768 bytes, linear) May 12 13:22:32.915821 kernel: Table-perturb hash table entries: 65536 (order: 6, 262144 bytes, linear) May 12 13:22:32.915828 kernel: TCP established hash table entries: 32768 (order: 6, 262144 bytes, linear) May 12 13:22:32.915835 kernel: TCP bind hash table entries: 32768 (order: 8, 1048576 bytes, linear) May 12 13:22:32.915842 kernel: TCP: Hash tables configured (established 32768 bind 32768) May 12 13:22:32.915849 kernel: UDP hash table entries: 2048 (order: 4, 65536 bytes, linear) May 12 13:22:32.915856 kernel: UDP-Lite hash table entries: 2048 (order: 4, 65536 bytes, linear) May 12 13:22:32.915863 kernel: NET: Registered PF_UNIX/PF_LOCAL protocol family May 12 13:22:32.915869 kernel: PCI: CLS 0 bytes, default 64 May 12 13:22:32.915876 kernel: kvm [1]: HYP mode not available May 12 13:22:32.915885 kernel: Initialise system trusted keyrings May 12 13:22:32.915892 kernel: workingset: timestamp_bits=39 max_order=20 bucket_order=0 May 12 13:22:32.915898 kernel: Key type asymmetric registered May 12 13:22:32.915906 kernel: Asymmetric key parser 'x509' registered May 12 13:22:32.915913 kernel: Block layer SCSI generic (bsg) driver version 0.4 loaded (major 249) May 12 13:22:32.915920 kernel: io scheduler mq-deadline registered May 12 13:22:32.915928 kernel: io scheduler kyber registered May 12 13:22:32.915935 kernel: io scheduler bfq registered May 12 13:22:32.915942 kernel: input: Power Button as /devices/LNXSYSTM:00/LNXSYBUS:00/PNP0C0C:00/input/input0 May 12 13:22:32.915965 kernel: ACPI: button: Power Button [PWRB] May 12 13:22:32.915973 kernel: ACPI: \_SB_.PCI0.GSI1: Enabled at IRQ 36 May 12 13:22:32.916049 kernel: virtio-pci 0000:00:01.0: enabling device (0005 -> 0007) May 12 13:22:32.916059 kernel: Serial: 8250/16550 driver, 4 ports, IRQ sharing enabled May 12 13:22:32.916066 kernel: thunder_xcv, ver 1.0 May 12 13:22:32.916072 kernel: thunder_bgx, ver 1.0 May 12 13:22:32.916079 kernel: nicpf, ver 1.0 May 12 13:22:32.916086 kernel: nicvf, ver 1.0 May 12 13:22:32.916160 kernel: rtc-efi rtc-efi.0: registered as rtc0 May 12 13:22:32.916224 kernel: rtc-efi rtc-efi.0: setting system clock to 2025-05-12T13:22:32 UTC (1747056152) May 12 13:22:32.916233 kernel: hid: raw HID events driver (C) Jiri Kosina May 12 13:22:32.916241 kernel: hw perfevents: enabled with armv8_pmuv3_0 PMU driver, 7 counters available May 12 13:22:32.916248 kernel: watchdog: Delayed init of the lockup detector failed: -19 May 12 13:22:32.916255 kernel: watchdog: Hard watchdog permanently disabled May 12 13:22:32.916262 kernel: NET: Registered PF_INET6 protocol family May 12 13:22:32.916269 kernel: Segment Routing with IPv6 May 12 13:22:32.916275 kernel: In-situ OAM (IOAM) with IPv6 May 12 13:22:32.916284 kernel: NET: Registered PF_PACKET protocol family May 12 13:22:32.916291 kernel: Key type dns_resolver registered May 12 13:22:32.916298 kernel: registered taskstats version 1 May 12 13:22:32.916305 kernel: Loading compiled-in X.509 certificates May 12 13:22:32.916312 kernel: Loaded X.509 cert 'Kinvolk GmbH: Module signing key for 6.6.89-flatcar: 8a19376c4ffd0604cd5425566348a3f0eeb277da' May 12 13:22:32.916319 kernel: Key type .fscrypt registered May 12 13:22:32.916325 kernel: Key type fscrypt-provisioning registered May 12 13:22:32.916333 kernel: ima: No TPM chip found, activating TPM-bypass! May 12 13:22:32.916340 kernel: ima: Allocated hash algorithm: sha1 May 12 13:22:32.916348 kernel: ima: No architecture policies found May 12 13:22:32.916355 kernel: alg: No test for fips(ansi_cprng) (fips_ansi_cprng) May 12 13:22:32.916362 kernel: clk: Disabling unused clocks May 12 13:22:32.916369 kernel: Warning: unable to open an initial console. May 12 13:22:32.916376 kernel: Freeing unused kernel memory: 39040K May 12 13:22:32.916382 kernel: Run /init as init process May 12 13:22:32.916389 kernel: with arguments: May 12 13:22:32.916396 kernel: /init May 12 13:22:32.916402 kernel: with environment: May 12 13:22:32.916410 kernel: HOME=/ May 12 13:22:32.916417 kernel: TERM=linux May 12 13:22:32.916424 kernel: BOOT_IMAGE=/flatcar/vmlinuz-a May 12 13:22:32.916451 systemd[1]: Successfully made /usr/ read-only. May 12 13:22:32.916461 systemd[1]: systemd 256.8 running in system mode (+PAM +AUDIT +SELINUX -APPARMOR +IMA +SMACK +SECCOMP -GCRYPT -GNUTLS +OPENSSL -ACL +BLKID +CURL +ELFUTILS -FIDO2 +IDN2 -IDN +IPTC +KMOD +LIBCRYPTSETUP +LIBCRYPTSETUP_PLUGINS +LIBFDISK +PCRE2 -PWQUALITY -P11KIT -QRENCODE +TPM2 +BZIP2 +LZ4 +XZ +ZLIB +ZSTD -BPF_FRAMEWORK -XKBCOMMON +UTMP -SYSVINIT +LIBARCHIVE) May 12 13:22:32.916469 systemd[1]: Detected virtualization kvm. May 12 13:22:32.916476 systemd[1]: Detected architecture arm64. May 12 13:22:32.916486 systemd[1]: Running in initrd. May 12 13:22:32.916493 systemd[1]: No hostname configured, using default hostname. May 12 13:22:32.916501 systemd[1]: Hostname set to . May 12 13:22:32.916508 systemd[1]: Initializing machine ID from VM UUID. May 12 13:22:32.916515 systemd[1]: Queued start job for default target initrd.target. May 12 13:22:32.916522 systemd[1]: Started clevis-luks-askpass.path - Forward Password Requests to Clevis Directory Watch. May 12 13:22:32.916530 systemd[1]: Started systemd-ask-password-console.path - Dispatch Password Requests to Console Directory Watch. May 12 13:22:32.916538 systemd[1]: Expecting device dev-disk-by\x2dlabel-EFI\x2dSYSTEM.device - /dev/disk/by-label/EFI-SYSTEM... May 12 13:22:32.916547 systemd[1]: Expecting device dev-disk-by\x2dlabel-OEM.device - /dev/disk/by-label/OEM... May 12 13:22:32.916554 systemd[1]: Expecting device dev-disk-by\x2dlabel-ROOT.device - /dev/disk/by-label/ROOT... May 12 13:22:32.916562 systemd[1]: Expecting device dev-disk-by\x2dpartlabel-USR\x2dA.device - /dev/disk/by-partlabel/USR-A... May 12 13:22:32.916570 systemd[1]: Expecting device dev-disk-by\x2dpartuuid-7130c94a\x2d213a\x2d4e5a\x2d8e26\x2d6cce9662f132.device - /dev/disk/by-partuuid/7130c94a-213a-4e5a-8e26-6cce9662f132... May 12 13:22:32.916578 systemd[1]: Expecting device dev-mapper-usr.device - /dev/mapper/usr... May 12 13:22:32.916585 systemd[1]: Reached target cryptsetup-pre.target - Local Encrypted Volumes (Pre). May 12 13:22:32.916593 systemd[1]: Reached target cryptsetup.target - Local Encrypted Volumes. May 12 13:22:32.916602 systemd[1]: Reached target paths.target - Path Units. May 12 13:22:32.916609 systemd[1]: Reached target slices.target - Slice Units. May 12 13:22:32.916616 systemd[1]: Reached target swap.target - Swaps. May 12 13:22:32.916624 systemd[1]: Reached target timers.target - Timer Units. May 12 13:22:32.916631 systemd[1]: Listening on iscsid.socket - Open-iSCSI iscsid Socket. May 12 13:22:32.916638 systemd[1]: Listening on iscsiuio.socket - Open-iSCSI iscsiuio Socket. May 12 13:22:32.916646 systemd[1]: Listening on systemd-journald-dev-log.socket - Journal Socket (/dev/log). May 12 13:22:32.916653 systemd[1]: Listening on systemd-journald.socket - Journal Sockets. May 12 13:22:32.916660 systemd[1]: Listening on systemd-networkd.socket - Network Service Netlink Socket. May 12 13:22:32.916669 systemd[1]: Listening on systemd-udevd-control.socket - udev Control Socket. May 12 13:22:32.916677 systemd[1]: Listening on systemd-udevd-kernel.socket - udev Kernel Socket. May 12 13:22:32.916684 systemd[1]: Reached target sockets.target - Socket Units. May 12 13:22:32.916691 systemd[1]: Starting ignition-setup-pre.service - Ignition env setup... May 12 13:22:32.916699 systemd[1]: Starting kmod-static-nodes.service - Create List of Static Device Nodes... May 12 13:22:32.916706 systemd[1]: Finished network-cleanup.service - Network Cleanup. May 12 13:22:32.916714 systemd[1]: systemd-battery-check.service - Check battery level during early boot was skipped because of an unmet condition check (ConditionDirectoryNotEmpty=/sys/class/power_supply). May 12 13:22:32.916721 systemd[1]: Starting systemd-fsck-usr.service... May 12 13:22:32.916730 systemd[1]: Starting systemd-journald.service - Journal Service... May 12 13:22:32.916742 systemd[1]: Starting systemd-modules-load.service - Load Kernel Modules... May 12 13:22:32.916749 systemd[1]: Starting systemd-vconsole-setup.service - Virtual Console Setup... May 12 13:22:32.916756 systemd[1]: Finished kmod-static-nodes.service - Create List of Static Device Nodes. May 12 13:22:32.916764 systemd[1]: Finished ignition-setup-pre.service - Ignition env setup. May 12 13:22:32.916773 systemd[1]: Finished systemd-fsck-usr.service. May 12 13:22:32.916781 systemd[1]: Starting systemd-tmpfiles-setup-dev-early.service - Create Static Device Nodes in /dev gracefully... May 12 13:22:32.916807 systemd-journald[239]: Collecting audit messages is disabled. May 12 13:22:32.916826 systemd[1]: Finished systemd-vconsole-setup.service - Virtual Console Setup. May 12 13:22:32.916834 systemd[1]: Starting dracut-cmdline-ask.service - dracut ask for additional cmdline parameters... May 12 13:22:32.916842 systemd-journald[239]: Journal started May 12 13:22:32.916860 systemd-journald[239]: Runtime Journal (/run/log/journal/7de8cb7d084e4e63be46f860a926639e) is 5.9M, max 47.3M, 41.4M free. May 12 13:22:32.905397 systemd-modules-load[240]: Inserted module 'overlay' May 12 13:22:32.921551 systemd[1]: Started systemd-journald.service - Journal Service. May 12 13:22:32.923445 kernel: bridge: filtering via arp/ip/ip6tables is no longer available by default. Update your scripts to load br_netfilter if you need this. May 12 13:22:32.925213 systemd-modules-load[240]: Inserted module 'br_netfilter' May 12 13:22:32.926162 kernel: Bridge firewalling registered May 12 13:22:32.929794 systemd[1]: Finished systemd-modules-load.service - Load Kernel Modules. May 12 13:22:32.931012 systemd[1]: Finished systemd-tmpfiles-setup-dev-early.service - Create Static Device Nodes in /dev gracefully. May 12 13:22:32.935551 systemd[1]: Starting systemd-sysctl.service - Apply Kernel Variables... May 12 13:22:32.938580 systemd[1]: Starting systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev... May 12 13:22:32.946924 systemd[1]: Starting systemd-tmpfiles-setup.service - Create System Files and Directories... May 12 13:22:32.948419 systemd[1]: Finished dracut-cmdline-ask.service - dracut ask for additional cmdline parameters. May 12 13:22:32.952565 systemd[1]: Starting dracut-cmdline.service - dracut cmdline hook... May 12 13:22:32.956113 systemd[1]: Finished systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev. May 12 13:22:32.957982 systemd[1]: Finished systemd-sysctl.service - Apply Kernel Variables. May 12 13:22:32.961255 systemd-tmpfiles[275]: /usr/lib/tmpfiles.d/var.conf:14: Duplicate line for path "/var/log", ignoring. May 12 13:22:32.965170 systemd[1]: Finished systemd-tmpfiles-setup.service - Create System Files and Directories. May 12 13:22:32.969358 systemd[1]: Starting systemd-resolved.service - Network Name Resolution... May 12 13:22:32.972354 dracut-cmdline[277]: Using kernel command line parameters: rd.driver.pre=btrfs SYSTEMD_SULOGIN_FORCE=1 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=653a96bf2da883847e3396e932e31f09e53181a834ffc22434c3993d29b70a16 May 12 13:22:33.006713 systemd-resolved[290]: Positive Trust Anchors: May 12 13:22:33.006730 systemd-resolved[290]: . IN DS 20326 8 2 e06d44b80b8f1d39a95c0b0d7c65d08458e880409bbc683457104237c7f8ec8d May 12 13:22:33.006761 systemd-resolved[290]: 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 May 12 13:22:33.011495 systemd-resolved[290]: Defaulting to hostname 'linux'. May 12 13:22:33.012423 systemd[1]: Started systemd-resolved.service - Network Name Resolution. May 12 13:22:33.016182 systemd[1]: Reached target nss-lookup.target - Host and Network Name Lookups. May 12 13:22:33.052439 kernel: SCSI subsystem initialized May 12 13:22:33.055454 kernel: Loading iSCSI transport class v2.0-870. May 12 13:22:33.063455 kernel: iscsi: registered transport (tcp) May 12 13:22:33.076457 kernel: iscsi: registered transport (qla4xxx) May 12 13:22:33.076478 kernel: QLogic iSCSI HBA Driver May 12 13:22:33.092517 systemd[1]: Starting systemd-network-generator.service - Generate network units from Kernel command line... May 12 13:22:33.114484 systemd[1]: Finished systemd-network-generator.service - Generate network units from Kernel command line. May 12 13:22:33.116674 systemd[1]: Reached target network-pre.target - Preparation for Network. May 12 13:22:33.160478 systemd[1]: Finished dracut-cmdline.service - dracut cmdline hook. May 12 13:22:33.162721 systemd[1]: Starting dracut-pre-udev.service - dracut pre-udev hook... May 12 13:22:33.222466 kernel: raid6: neonx8 gen() 15802 MB/s May 12 13:22:33.239457 kernel: raid6: neonx4 gen() 15796 MB/s May 12 13:22:33.256457 kernel: raid6: neonx2 gen() 13171 MB/s May 12 13:22:33.273458 kernel: raid6: neonx1 gen() 10485 MB/s May 12 13:22:33.290453 kernel: raid6: int64x8 gen() 6779 MB/s May 12 13:22:33.307458 kernel: raid6: int64x4 gen() 7344 MB/s May 12 13:22:33.324454 kernel: raid6: int64x2 gen() 6106 MB/s May 12 13:22:33.341541 kernel: raid6: int64x1 gen() 5055 MB/s May 12 13:22:33.341564 kernel: raid6: using algorithm neonx8 gen() 15802 MB/s May 12 13:22:33.359535 kernel: raid6: .... xor() 12021 MB/s, rmw enabled May 12 13:22:33.359563 kernel: raid6: using neon recovery algorithm May 12 13:22:33.364880 kernel: xor: measuring software checksum speed May 12 13:22:33.364906 kernel: 8regs : 21584 MB/sec May 12 13:22:33.365544 kernel: 32regs : 21693 MB/sec May 12 13:22:33.366692 kernel: arm64_neon : 27860 MB/sec May 12 13:22:33.366707 kernel: xor: using function: arm64_neon (27860 MB/sec) May 12 13:22:33.417457 kernel: Btrfs loaded, zoned=no, fsverity=no May 12 13:22:33.424478 systemd[1]: Finished dracut-pre-udev.service - dracut pre-udev hook. May 12 13:22:33.426951 systemd[1]: Starting systemd-udevd.service - Rule-based Manager for Device Events and Files... May 12 13:22:33.455395 systemd-udevd[492]: Using default interface naming scheme 'v255'. May 12 13:22:33.460442 systemd[1]: Started systemd-udevd.service - Rule-based Manager for Device Events and Files. May 12 13:22:33.463344 systemd[1]: Starting dracut-pre-trigger.service - dracut pre-trigger hook... May 12 13:22:33.485681 dracut-pre-trigger[500]: rd.md=0: removing MD RAID activation May 12 13:22:33.506881 systemd[1]: Finished dracut-pre-trigger.service - dracut pre-trigger hook. May 12 13:22:33.509123 systemd[1]: Starting systemd-udev-trigger.service - Coldplug All udev Devices... May 12 13:22:33.562206 systemd[1]: Finished systemd-udev-trigger.service - Coldplug All udev Devices. May 12 13:22:33.565556 systemd[1]: Starting dracut-initqueue.service - dracut initqueue hook... May 12 13:22:33.612343 kernel: virtio_blk virtio1: 1/0/0 default/read/poll queues May 12 13:22:33.612550 kernel: virtio_blk virtio1: [vda] 9289728 512-byte logical blocks (4.76 GB/4.43 GiB) May 12 13:22:33.615471 kernel: vda: vda1 vda2 vda3 vda4 vda6 vda7 vda9 May 12 13:22:33.618286 systemd[1]: systemd-vconsole-setup.service: Deactivated successfully. May 12 13:22:33.618448 systemd[1]: Stopped systemd-vconsole-setup.service - Virtual Console Setup. May 12 13:22:33.621798 systemd[1]: Stopping systemd-vconsole-setup.service - Virtual Console Setup... May 12 13:22:33.623616 systemd[1]: Starting systemd-vconsole-setup.service - Virtual Console Setup... May 12 13:22:33.637480 kernel: BTRFS: device fsid 883e681e-770a-479b-951e-bb0dc342f721 devid 1 transid 42 /dev/vda3 scanned by (udev-worker) (538) May 12 13:22:33.644459 kernel: BTRFS: device label OEM devid 1 transid 14 /dev/vda6 scanned by (udev-worker) (551) May 12 13:22:33.649471 systemd[1]: Finished systemd-vconsole-setup.service - Virtual Console Setup. May 12 13:22:33.657312 systemd[1]: Found device dev-disk-by\x2dlabel-EFI\x2dSYSTEM.device - /dev/disk/by-label/EFI-SYSTEM. May 12 13:22:33.658793 systemd[1]: Finished dracut-initqueue.service - dracut initqueue hook. May 12 13:22:33.667886 systemd[1]: Found device dev-disk-by\x2dlabel-ROOT.device - /dev/disk/by-label/ROOT. May 12 13:22:33.674208 systemd[1]: Found device dev-disk-by\x2dpartlabel-USR\x2dA.device - /dev/disk/by-partlabel/USR-A. May 12 13:22:33.675492 systemd[1]: Found device dev-disk-by\x2dpartuuid-7130c94a\x2d213a\x2d4e5a\x2d8e26\x2d6cce9662f132.device - /dev/disk/by-partuuid/7130c94a-213a-4e5a-8e26-6cce9662f132. May 12 13:22:33.688268 systemd[1]: Found device dev-disk-by\x2dlabel-OEM.device - /dev/disk/by-label/OEM. May 12 13:22:33.689618 systemd[1]: Reached target remote-fs-pre.target - Preparation for Remote File Systems. May 12 13:22:33.691779 systemd[1]: Reached target remote-cryptsetup.target - Remote Encrypted Volumes. May 12 13:22:33.693949 systemd[1]: Reached target remote-fs.target - Remote File Systems. May 12 13:22:33.696684 systemd[1]: Starting disk-uuid.service - Generate new UUID for disk GPT if necessary... May 12 13:22:33.698513 systemd[1]: Starting dracut-pre-mount.service - dracut pre-mount hook... May 12 13:22:33.726956 systemd[1]: Finished dracut-pre-mount.service - dracut pre-mount hook. May 12 13:22:33.730443 kernel: vda: vda1 vda2 vda3 vda4 vda6 vda7 vda9 May 12 13:22:34.738456 kernel: vda: vda1 vda2 vda3 vda4 vda6 vda7 vda9 May 12 13:22:34.738770 disk-uuid[591]: The operation has completed successfully. May 12 13:22:34.762451 systemd[1]: disk-uuid.service: Deactivated successfully. May 12 13:22:34.763504 systemd[1]: Finished disk-uuid.service - Generate new UUID for disk GPT if necessary. May 12 13:22:34.791734 systemd[1]: Starting verity-setup.service - Verity Setup for /dev/mapper/usr... May 12 13:22:34.808164 sh[604]: Success May 12 13:22:34.821979 kernel: device-mapper: core: CONFIG_IMA_DISABLE_HTABLE is disabled. Duplicate IMA measurements will not be recorded in the IMA log. May 12 13:22:34.822021 kernel: device-mapper: uevent: version 1.0.3 May 12 13:22:34.823143 kernel: device-mapper: ioctl: 4.48.0-ioctl (2023-03-01) initialised: dm-devel@redhat.com May 12 13:22:34.836510 kernel: device-mapper: verity: sha256 using implementation "sha256-ce" May 12 13:22:34.861203 systemd[1]: Found device dev-mapper-usr.device - /dev/mapper/usr. May 12 13:22:34.863837 systemd[1]: Mounting sysusr-usr.mount - /sysusr/usr... May 12 13:22:34.875678 systemd[1]: Finished verity-setup.service - Verity Setup for /dev/mapper/usr. May 12 13:22:34.882649 kernel: BTRFS info (device dm-0): first mount of filesystem 883e681e-770a-479b-951e-bb0dc342f721 May 12 13:22:34.882675 kernel: BTRFS info (device dm-0): using crc32c (crc32c-generic) checksum algorithm May 12 13:22:34.882685 kernel: BTRFS warning (device dm-0): 'nologreplay' is deprecated, use 'rescue=nologreplay' instead May 12 13:22:34.884506 kernel: BTRFS info (device dm-0): disabling log replay at mount time May 12 13:22:34.884521 kernel: BTRFS info (device dm-0): using free space tree May 12 13:22:34.888902 systemd[1]: Mounted sysusr-usr.mount - /sysusr/usr. May 12 13:22:34.889912 systemd[1]: Reached target initrd-usr-fs.target - Initrd /usr File System. May 12 13:22:34.891534 systemd[1]: afterburn-network-kargs.service - Afterburn Initrd Setup Network Kernel Arguments was skipped because no trigger condition checks were met. May 12 13:22:34.892149 systemd[1]: Starting ignition-setup.service - Ignition (setup)... May 12 13:22:34.893800 systemd[1]: Starting parse-ip-for-networkd.service - Write systemd-networkd units from cmdline... May 12 13:22:34.924096 kernel: BTRFS info (device vda6): first mount of filesystem c2183054-24ef-4008-8a3e-033aff1dab63 May 12 13:22:34.924134 kernel: BTRFS info (device vda6): using crc32c (crc32c-generic) checksum algorithm May 12 13:22:34.924145 kernel: BTRFS info (device vda6): using free space tree May 12 13:22:34.926457 kernel: BTRFS info (device vda6): auto enabling async discard May 12 13:22:34.930459 kernel: BTRFS info (device vda6): last unmount of filesystem c2183054-24ef-4008-8a3e-033aff1dab63 May 12 13:22:34.933644 systemd[1]: Finished ignition-setup.service - Ignition (setup). May 12 13:22:34.935742 systemd[1]: Starting ignition-fetch-offline.service - Ignition (fetch-offline)... May 12 13:22:34.998339 systemd[1]: Finished parse-ip-for-networkd.service - Write systemd-networkd units from cmdline. May 12 13:22:35.001444 systemd[1]: Starting systemd-networkd.service - Network Configuration... May 12 13:22:35.044667 systemd-networkd[790]: lo: Link UP May 12 13:22:35.044675 systemd-networkd[790]: lo: Gained carrier May 12 13:22:35.047276 systemd-networkd[790]: Enumeration completed May 12 13:22:35.047373 systemd[1]: Started systemd-networkd.service - Network Configuration. May 12 13:22:35.047737 systemd-networkd[790]: eth0: found matching network '/usr/lib/systemd/network/zz-default.network', based on potentially unpredictable interface name. May 12 13:22:35.047740 systemd-networkd[790]: eth0: Configuring with /usr/lib/systemd/network/zz-default.network. May 12 13:22:35.048552 systemd[1]: Reached target network.target - Network. May 12 13:22:35.051182 systemd-networkd[790]: eth0: Link UP May 12 13:22:35.051185 systemd-networkd[790]: eth0: Gained carrier May 12 13:22:35.051194 systemd-networkd[790]: eth0: found matching network '/usr/lib/systemd/network/zz-default.network', based on potentially unpredictable interface name. May 12 13:22:35.073477 systemd-networkd[790]: eth0: DHCPv4 address 10.0.0.44/16, gateway 10.0.0.1 acquired from 10.0.0.1 May 12 13:22:35.076796 ignition[697]: Ignition 2.21.0 May 12 13:22:35.076810 ignition[697]: Stage: fetch-offline May 12 13:22:35.076843 ignition[697]: no configs at "/usr/lib/ignition/base.d" May 12 13:22:35.076852 ignition[697]: no config dir at "/usr/lib/ignition/base.platform.d/qemu" May 12 13:22:35.077163 ignition[697]: parsed url from cmdline: "" May 12 13:22:35.077167 ignition[697]: no config URL provided May 12 13:22:35.077172 ignition[697]: reading system config file "/usr/lib/ignition/user.ign" May 12 13:22:35.077181 ignition[697]: no config at "/usr/lib/ignition/user.ign" May 12 13:22:35.077199 ignition[697]: op(1): [started] loading QEMU firmware config module May 12 13:22:35.077204 ignition[697]: op(1): executing: "modprobe" "qemu_fw_cfg" May 12 13:22:35.087040 ignition[697]: op(1): [finished] loading QEMU firmware config module May 12 13:22:35.090632 ignition[697]: parsing config with SHA512: 1a12f2c9b0c9f510d879cd5c505afb2861466e0cf363870c918969aaf0929a059e53036dcc6b6d415c7359ae5426779406842f64707537307e6987fd5bc0b5d8 May 12 13:22:35.095059 unknown[697]: fetched base config from "system" May 12 13:22:35.095069 unknown[697]: fetched user config from "qemu" May 12 13:22:35.095250 ignition[697]: fetch-offline: fetch-offline passed May 12 13:22:35.095316 ignition[697]: Ignition finished successfully May 12 13:22:35.098375 systemd[1]: Finished ignition-fetch-offline.service - Ignition (fetch-offline). May 12 13:22:35.100951 systemd[1]: ignition-fetch.service - Ignition (fetch) was skipped because of an unmet condition check (ConditionPathExists=!/run/ignition.json). May 12 13:22:35.101790 systemd[1]: Starting ignition-kargs.service - Ignition (kargs)... May 12 13:22:35.125085 ignition[806]: Ignition 2.21.0 May 12 13:22:35.125101 ignition[806]: Stage: kargs May 12 13:22:35.125228 ignition[806]: no configs at "/usr/lib/ignition/base.d" May 12 13:22:35.125237 ignition[806]: no config dir at "/usr/lib/ignition/base.platform.d/qemu" May 12 13:22:35.126706 ignition[806]: kargs: kargs passed May 12 13:22:35.129271 systemd[1]: Finished ignition-kargs.service - Ignition (kargs). May 12 13:22:35.126757 ignition[806]: Ignition finished successfully May 12 13:22:35.131791 systemd[1]: Starting ignition-disks.service - Ignition (disks)... May 12 13:22:35.155708 ignition[814]: Ignition 2.21.0 May 12 13:22:35.155725 ignition[814]: Stage: disks May 12 13:22:35.155852 ignition[814]: no configs at "/usr/lib/ignition/base.d" May 12 13:22:35.155861 ignition[814]: no config dir at "/usr/lib/ignition/base.platform.d/qemu" May 12 13:22:35.159741 systemd[1]: Finished ignition-disks.service - Ignition (disks). May 12 13:22:35.157290 ignition[814]: disks: disks passed May 12 13:22:35.161125 systemd[1]: Reached target initrd-root-device.target - Initrd Root Device. May 12 13:22:35.157332 ignition[814]: Ignition finished successfully May 12 13:22:35.162872 systemd[1]: Reached target local-fs-pre.target - Preparation for Local File Systems. May 12 13:22:35.164540 systemd[1]: Reached target local-fs.target - Local File Systems. May 12 13:22:35.166376 systemd[1]: Reached target sysinit.target - System Initialization. May 12 13:22:35.167974 systemd[1]: Reached target basic.target - Basic System. May 12 13:22:35.170676 systemd[1]: Starting systemd-fsck-root.service - File System Check on /dev/disk/by-label/ROOT... May 12 13:22:35.190481 systemd-fsck[824]: ROOT: clean, 15/553520 files, 52789/553472 blocks May 12 13:22:35.194518 systemd[1]: Finished systemd-fsck-root.service - File System Check on /dev/disk/by-label/ROOT. May 12 13:22:35.196727 systemd[1]: Mounting sysroot.mount - /sysroot... May 12 13:22:35.263453 kernel: EXT4-fs (vda9): mounted filesystem bc1f18c3-3425-4388-a617-b7347003d935 r/w with ordered data mode. Quota mode: none. May 12 13:22:35.263788 systemd[1]: Mounted sysroot.mount - /sysroot. May 12 13:22:35.265017 systemd[1]: Reached target initrd-root-fs.target - Initrd Root File System. May 12 13:22:35.267316 systemd[1]: Mounting sysroot-oem.mount - /sysroot/oem... May 12 13:22:35.268956 systemd[1]: Mounting sysroot-usr.mount - /sysroot/usr... May 12 13:22:35.270003 systemd[1]: flatcar-metadata-hostname.service - Flatcar Metadata Hostname Agent was skipped because no trigger condition checks were met. May 12 13:22:35.270052 systemd[1]: ignition-remount-sysroot.service - Remount /sysroot read-write for Ignition was skipped because of an unmet condition check (ConditionPathIsReadWrite=!/sysroot). May 12 13:22:35.270075 systemd[1]: Reached target ignition-diskful.target - Ignition Boot Disk Setup. May 12 13:22:35.279831 systemd[1]: Mounted sysroot-usr.mount - /sysroot/usr. May 12 13:22:35.282200 systemd[1]: Starting initrd-setup-root.service - Root filesystem setup... May 12 13:22:35.287652 kernel: BTRFS: device label OEM devid 1 transid 15 /dev/vda6 scanned by mount (832) May 12 13:22:35.287672 kernel: BTRFS info (device vda6): first mount of filesystem c2183054-24ef-4008-8a3e-033aff1dab63 May 12 13:22:35.287682 kernel: BTRFS info (device vda6): using crc32c (crc32c-generic) checksum algorithm May 12 13:22:35.287692 kernel: BTRFS info (device vda6): using free space tree May 12 13:22:35.291344 kernel: BTRFS info (device vda6): auto enabling async discard May 12 13:22:35.290963 systemd[1]: Mounted sysroot-oem.mount - /sysroot/oem. May 12 13:22:35.325348 initrd-setup-root[856]: cut: /sysroot/etc/passwd: No such file or directory May 12 13:22:35.329506 initrd-setup-root[863]: cut: /sysroot/etc/group: No such file or directory May 12 13:22:35.333271 initrd-setup-root[870]: cut: /sysroot/etc/shadow: No such file or directory May 12 13:22:35.337165 initrd-setup-root[877]: cut: /sysroot/etc/gshadow: No such file or directory May 12 13:22:35.400980 systemd[1]: Finished initrd-setup-root.service - Root filesystem setup. May 12 13:22:35.403176 systemd[1]: Starting ignition-mount.service - Ignition (mount)... May 12 13:22:35.404718 systemd[1]: Starting sysroot-boot.service - /sysroot/boot... May 12 13:22:35.422443 kernel: BTRFS info (device vda6): last unmount of filesystem c2183054-24ef-4008-8a3e-033aff1dab63 May 12 13:22:35.444625 systemd[1]: Finished sysroot-boot.service - /sysroot/boot. May 12 13:22:35.456180 ignition[947]: INFO : Ignition 2.21.0 May 12 13:22:35.456180 ignition[947]: INFO : Stage: mount May 12 13:22:35.458259 ignition[947]: INFO : no configs at "/usr/lib/ignition/base.d" May 12 13:22:35.458259 ignition[947]: INFO : no config dir at "/usr/lib/ignition/base.platform.d/qemu" May 12 13:22:35.458259 ignition[947]: INFO : mount: mount passed May 12 13:22:35.458259 ignition[947]: INFO : Ignition finished successfully May 12 13:22:35.459784 systemd[1]: Finished ignition-mount.service - Ignition (mount). May 12 13:22:35.462238 systemd[1]: Starting ignition-files.service - Ignition (files)... May 12 13:22:36.016517 systemd[1]: sysroot-oem.mount: Deactivated successfully. May 12 13:22:36.017993 systemd[1]: Mounting sysroot-oem.mount - /sysroot/oem... May 12 13:22:36.036181 kernel: BTRFS: device label OEM devid 1 transid 16 /dev/vda6 scanned by mount (960) May 12 13:22:36.036218 kernel: BTRFS info (device vda6): first mount of filesystem c2183054-24ef-4008-8a3e-033aff1dab63 May 12 13:22:36.036228 kernel: BTRFS info (device vda6): using crc32c (crc32c-generic) checksum algorithm May 12 13:22:36.037170 kernel: BTRFS info (device vda6): using free space tree May 12 13:22:36.040450 kernel: BTRFS info (device vda6): auto enabling async discard May 12 13:22:36.041057 systemd[1]: Mounted sysroot-oem.mount - /sysroot/oem. May 12 13:22:36.063815 ignition[977]: INFO : Ignition 2.21.0 May 12 13:22:36.063815 ignition[977]: INFO : Stage: files May 12 13:22:36.065409 ignition[977]: INFO : no configs at "/usr/lib/ignition/base.d" May 12 13:22:36.065409 ignition[977]: INFO : no config dir at "/usr/lib/ignition/base.platform.d/qemu" May 12 13:22:36.065409 ignition[977]: DEBUG : files: compiled without relabeling support, skipping May 12 13:22:36.069368 ignition[977]: INFO : files: ensureUsers: op(1): [started] creating or modifying user "core" May 12 13:22:36.069368 ignition[977]: DEBUG : files: ensureUsers: op(1): executing: "usermod" "--root" "/sysroot" "core" May 12 13:22:36.071919 ignition[977]: INFO : files: ensureUsers: op(1): [finished] creating or modifying user "core" May 12 13:22:36.071919 ignition[977]: INFO : files: ensureUsers: op(2): [started] adding ssh keys to user "core" May 12 13:22:36.074742 ignition[977]: INFO : files: ensureUsers: op(2): [finished] adding ssh keys to user "core" May 12 13:22:36.074742 ignition[977]: INFO : files: createFilesystemsFiles: createFiles: op(3): [started] writing file "/sysroot/etc/flatcar/update.conf" May 12 13:22:36.074742 ignition[977]: INFO : files: createFilesystemsFiles: createFiles: op(3): [finished] writing file "/sysroot/etc/flatcar/update.conf" May 12 13:22:36.074742 ignition[977]: INFO : files: createFilesystemsFiles: createFiles: op(4): [started] writing link "/sysroot/etc/extensions/docker-flatcar.raw" -> "/dev/null" May 12 13:22:36.074742 ignition[977]: INFO : files: createFilesystemsFiles: createFiles: op(4): [finished] writing link "/sysroot/etc/extensions/docker-flatcar.raw" -> "/dev/null" May 12 13:22:36.074742 ignition[977]: INFO : files: createFilesystemsFiles: createFiles: op(5): [started] writing link "/sysroot/etc/extensions/containerd-flatcar.raw" -> "/dev/null" May 12 13:22:36.074742 ignition[977]: INFO : files: createFilesystemsFiles: createFiles: op(5): [finished] writing link "/sysroot/etc/extensions/containerd-flatcar.raw" -> "/dev/null" May 12 13:22:36.074742 ignition[977]: INFO : files: op(6): [started] processing unit "coreos-metadata.service" May 12 13:22:36.074742 ignition[977]: INFO : files: op(6): op(7): [started] writing unit "coreos-metadata.service" at "/sysroot/etc/systemd/system/coreos-metadata.service" May 12 13:22:36.074742 ignition[977]: INFO : files: op(6): op(7): [finished] writing unit "coreos-metadata.service" at "/sysroot/etc/systemd/system/coreos-metadata.service" May 12 13:22:36.074742 ignition[977]: INFO : files: op(6): [finished] processing unit "coreos-metadata.service" May 12 13:22:36.074742 ignition[977]: INFO : files: op(8): [started] setting preset to disabled for "coreos-metadata.service" May 12 13:22:36.072068 unknown[977]: wrote ssh authorized keys file for user: core May 12 13:22:36.098568 ignition[977]: INFO : files: op(8): op(9): [started] removing enablement symlink(s) for "coreos-metadata.service" May 12 13:22:36.098568 ignition[977]: INFO : files: op(8): op(9): [finished] removing enablement symlink(s) for "coreos-metadata.service" May 12 13:22:36.098568 ignition[977]: INFO : files: op(8): [finished] setting preset to disabled for "coreos-metadata.service" May 12 13:22:36.098568 ignition[977]: INFO : files: createResultFile: createFiles: op(a): [started] writing file "/sysroot/etc/.ignition-result.json" May 12 13:22:36.098568 ignition[977]: INFO : files: createResultFile: createFiles: op(a): [finished] writing file "/sysroot/etc/.ignition-result.json" May 12 13:22:36.098568 ignition[977]: INFO : files: files passed May 12 13:22:36.098568 ignition[977]: INFO : Ignition finished successfully May 12 13:22:36.099483 systemd[1]: Finished ignition-files.service - Ignition (files). May 12 13:22:36.101764 systemd[1]: Starting ignition-quench.service - Ignition (record completion)... May 12 13:22:36.103871 systemd[1]: Starting initrd-setup-root-after-ignition.service - Root filesystem completion... May 12 13:22:36.115389 systemd[1]: ignition-quench.service: Deactivated successfully. May 12 13:22:36.115511 systemd[1]: Finished ignition-quench.service - Ignition (record completion). May 12 13:22:36.119084 initrd-setup-root-after-ignition[1006]: grep: /sysroot/oem/oem-release: No such file or directory May 12 13:22:36.121059 initrd-setup-root-after-ignition[1008]: grep: /sysroot/etc/flatcar/enabled-sysext.conf: No such file or directory May 12 13:22:36.121059 initrd-setup-root-after-ignition[1008]: grep: /sysroot/usr/share/flatcar/enabled-sysext.conf: No such file or directory May 12 13:22:36.124343 initrd-setup-root-after-ignition[1012]: grep: /sysroot/etc/flatcar/enabled-sysext.conf: No such file or directory May 12 13:22:36.123661 systemd[1]: Finished initrd-setup-root-after-ignition.service - Root filesystem completion. May 12 13:22:36.125795 systemd[1]: Reached target ignition-complete.target - Ignition Complete. May 12 13:22:36.128419 systemd[1]: Starting initrd-parse-etc.service - Mountpoints Configured in the Real Root... May 12 13:22:36.172350 systemd[1]: initrd-parse-etc.service: Deactivated successfully. May 12 13:22:36.172464 systemd[1]: Finished initrd-parse-etc.service - Mountpoints Configured in the Real Root. May 12 13:22:36.174760 systemd[1]: Reached target initrd-fs.target - Initrd File Systems. May 12 13:22:36.176578 systemd[1]: Reached target initrd.target - Initrd Default Target. May 12 13:22:36.178458 systemd[1]: dracut-mount.service - dracut mount hook was skipped because no trigger condition checks were met. May 12 13:22:36.179157 systemd[1]: Starting dracut-pre-pivot.service - dracut pre-pivot and cleanup hook... May 12 13:22:36.200416 systemd[1]: Finished dracut-pre-pivot.service - dracut pre-pivot and cleanup hook. May 12 13:22:36.202701 systemd[1]: Starting initrd-cleanup.service - Cleaning Up and Shutting Down Daemons... May 12 13:22:36.221664 systemd[1]: Stopped target nss-lookup.target - Host and Network Name Lookups. May 12 13:22:36.222959 systemd[1]: Stopped target remote-cryptsetup.target - Remote Encrypted Volumes. May 12 13:22:36.225086 systemd[1]: Stopped target timers.target - Timer Units. May 12 13:22:36.226967 systemd[1]: dracut-pre-pivot.service: Deactivated successfully. May 12 13:22:36.227093 systemd[1]: Stopped dracut-pre-pivot.service - dracut pre-pivot and cleanup hook. May 12 13:22:36.229554 systemd[1]: Stopped target initrd.target - Initrd Default Target. May 12 13:22:36.231543 systemd[1]: Stopped target basic.target - Basic System. May 12 13:22:36.233197 systemd[1]: Stopped target ignition-complete.target - Ignition Complete. May 12 13:22:36.235029 systemd[1]: Stopped target ignition-diskful.target - Ignition Boot Disk Setup. May 12 13:22:36.237065 systemd[1]: Stopped target initrd-root-device.target - Initrd Root Device. May 12 13:22:36.239108 systemd[1]: Stopped target initrd-usr-fs.target - Initrd /usr File System. May 12 13:22:36.241089 systemd[1]: Stopped target remote-fs.target - Remote File Systems. May 12 13:22:36.242983 systemd[1]: Stopped target remote-fs-pre.target - Preparation for Remote File Systems. May 12 13:22:36.244952 systemd[1]: Stopped target sysinit.target - System Initialization. May 12 13:22:36.246887 systemd[1]: Stopped target local-fs.target - Local File Systems. May 12 13:22:36.248588 systemd[1]: Stopped target swap.target - Swaps. May 12 13:22:36.249994 systemd[1]: dracut-pre-mount.service: Deactivated successfully. May 12 13:22:36.250122 systemd[1]: Stopped dracut-pre-mount.service - dracut pre-mount hook. May 12 13:22:36.252388 systemd[1]: Stopped target cryptsetup.target - Local Encrypted Volumes. May 12 13:22:36.254378 systemd[1]: Stopped target cryptsetup-pre.target - Local Encrypted Volumes (Pre). May 12 13:22:36.256386 systemd[1]: clevis-luks-askpass.path: Deactivated successfully. May 12 13:22:36.257494 systemd[1]: Stopped clevis-luks-askpass.path - Forward Password Requests to Clevis Directory Watch. May 12 13:22:36.259557 systemd[1]: dracut-initqueue.service: Deactivated successfully. May 12 13:22:36.259671 systemd[1]: Stopped dracut-initqueue.service - dracut initqueue hook. May 12 13:22:36.262651 systemd[1]: ignition-fetch-offline.service: Deactivated successfully. May 12 13:22:36.262769 systemd[1]: Stopped ignition-fetch-offline.service - Ignition (fetch-offline). May 12 13:22:36.264743 systemd[1]: Stopped target paths.target - Path Units. May 12 13:22:36.266398 systemd[1]: systemd-ask-password-console.path: Deactivated successfully. May 12 13:22:36.270485 systemd[1]: Stopped systemd-ask-password-console.path - Dispatch Password Requests to Console Directory Watch. May 12 13:22:36.271737 systemd[1]: Stopped target slices.target - Slice Units. May 12 13:22:36.273795 systemd[1]: Stopped target sockets.target - Socket Units. May 12 13:22:36.275354 systemd[1]: iscsid.socket: Deactivated successfully. May 12 13:22:36.275454 systemd[1]: Closed iscsid.socket - Open-iSCSI iscsid Socket. May 12 13:22:36.276993 systemd[1]: iscsiuio.socket: Deactivated successfully. May 12 13:22:36.277084 systemd[1]: Closed iscsiuio.socket - Open-iSCSI iscsiuio Socket. May 12 13:22:36.278595 systemd[1]: initrd-setup-root-after-ignition.service: Deactivated successfully. May 12 13:22:36.278703 systemd[1]: Stopped initrd-setup-root-after-ignition.service - Root filesystem completion. May 12 13:22:36.280513 systemd[1]: ignition-files.service: Deactivated successfully. May 12 13:22:36.280618 systemd[1]: Stopped ignition-files.service - Ignition (files). May 12 13:22:36.282900 systemd[1]: Stopping ignition-mount.service - Ignition (mount)... May 12 13:22:36.285479 systemd[1]: Stopping sysroot-boot.service - /sysroot/boot... May 12 13:22:36.286677 systemd[1]: systemd-udev-trigger.service: Deactivated successfully. May 12 13:22:36.286810 systemd[1]: Stopped systemd-udev-trigger.service - Coldplug All udev Devices. May 12 13:22:36.288613 systemd[1]: dracut-pre-trigger.service: Deactivated successfully. May 12 13:22:36.288718 systemd[1]: Stopped dracut-pre-trigger.service - dracut pre-trigger hook. May 12 13:22:36.295600 systemd[1]: initrd-cleanup.service: Deactivated successfully. May 12 13:22:36.295680 systemd[1]: Finished initrd-cleanup.service - Cleaning Up and Shutting Down Daemons. May 12 13:22:36.303336 systemd[1]: sysroot-boot.mount: Deactivated successfully. May 12 13:22:36.307978 systemd[1]: sysroot-boot.service: Deactivated successfully. May 12 13:22:36.308097 systemd[1]: Stopped sysroot-boot.service - /sysroot/boot. May 12 13:22:36.312340 ignition[1032]: INFO : Ignition 2.21.0 May 12 13:22:36.312340 ignition[1032]: INFO : Stage: umount May 12 13:22:36.312340 ignition[1032]: INFO : no configs at "/usr/lib/ignition/base.d" May 12 13:22:36.312340 ignition[1032]: INFO : no config dir at "/usr/lib/ignition/base.platform.d/qemu" May 12 13:22:36.312340 ignition[1032]: INFO : umount: umount passed May 12 13:22:36.312340 ignition[1032]: INFO : Ignition finished successfully May 12 13:22:36.313159 systemd[1]: ignition-mount.service: Deactivated successfully. May 12 13:22:36.313238 systemd[1]: Stopped ignition-mount.service - Ignition (mount). May 12 13:22:36.314825 systemd[1]: Stopped target network.target - Network. May 12 13:22:36.316297 systemd[1]: ignition-disks.service: Deactivated successfully. May 12 13:22:36.316351 systemd[1]: Stopped ignition-disks.service - Ignition (disks). May 12 13:22:36.318288 systemd[1]: ignition-kargs.service: Deactivated successfully. May 12 13:22:36.318331 systemd[1]: Stopped ignition-kargs.service - Ignition (kargs). May 12 13:22:36.319876 systemd[1]: ignition-setup.service: Deactivated successfully. May 12 13:22:36.319917 systemd[1]: Stopped ignition-setup.service - Ignition (setup). May 12 13:22:36.321484 systemd[1]: ignition-setup-pre.service: Deactivated successfully. May 12 13:22:36.321525 systemd[1]: Stopped ignition-setup-pre.service - Ignition env setup. May 12 13:22:36.323238 systemd[1]: initrd-setup-root.service: Deactivated successfully. May 12 13:22:36.323283 systemd[1]: Stopped initrd-setup-root.service - Root filesystem setup. May 12 13:22:36.325136 systemd[1]: Stopping systemd-networkd.service - Network Configuration... May 12 13:22:36.326756 systemd[1]: Stopping systemd-resolved.service - Network Name Resolution... May 12 13:22:36.329756 systemd[1]: systemd-resolved.service: Deactivated successfully. May 12 13:22:36.329873 systemd[1]: Stopped systemd-resolved.service - Network Name Resolution. May 12 13:22:36.334058 systemd[1]: run-credentials-systemd\x2dresolved.service.mount: Deactivated successfully. May 12 13:22:36.334283 systemd[1]: systemd-tmpfiles-setup.service: Deactivated successfully. May 12 13:22:36.334319 systemd[1]: Stopped systemd-tmpfiles-setup.service - Create System Files and Directories. May 12 13:22:36.337794 systemd[1]: run-credentials-systemd\x2dtmpfiles\x2dsetup.service.mount: Deactivated successfully. May 12 13:22:36.338006 systemd[1]: systemd-networkd.service: Deactivated successfully. May 12 13:22:36.338107 systemd[1]: Stopped systemd-networkd.service - Network Configuration. May 12 13:22:36.341940 systemd[1]: Stopped target network-pre.target - Preparation for Network. May 12 13:22:36.343244 systemd[1]: systemd-networkd.socket: Deactivated successfully. May 12 13:22:36.343282 systemd[1]: Closed systemd-networkd.socket - Network Service Netlink Socket. May 12 13:22:36.345739 systemd[1]: Stopping network-cleanup.service - Network Cleanup... May 12 13:22:36.346875 systemd[1]: parse-ip-for-networkd.service: Deactivated successfully. May 12 13:22:36.346930 systemd[1]: Stopped parse-ip-for-networkd.service - Write systemd-networkd units from cmdline. May 12 13:22:36.349120 systemd[1]: systemd-sysctl.service: Deactivated successfully. May 12 13:22:36.349165 systemd[1]: Stopped systemd-sysctl.service - Apply Kernel Variables. May 12 13:22:36.352009 systemd[1]: systemd-modules-load.service: Deactivated successfully. May 12 13:22:36.352060 systemd[1]: Stopped systemd-modules-load.service - Load Kernel Modules. May 12 13:22:36.354486 systemd[1]: Stopping systemd-udevd.service - Rule-based Manager for Device Events and Files... May 12 13:22:36.367434 systemd[1]: network-cleanup.service: Deactivated successfully. May 12 13:22:36.367553 systemd[1]: Stopped network-cleanup.service - Network Cleanup. May 12 13:22:36.373064 systemd[1]: systemd-udevd.service: Deactivated successfully. May 12 13:22:36.373216 systemd[1]: Stopped systemd-udevd.service - Rule-based Manager for Device Events and Files. May 12 13:22:36.374863 systemd[1]: systemd-udevd-control.socket: Deactivated successfully. May 12 13:22:36.374903 systemd[1]: Closed systemd-udevd-control.socket - udev Control Socket. May 12 13:22:36.376361 systemd[1]: systemd-udevd-kernel.socket: Deactivated successfully. May 12 13:22:36.376393 systemd[1]: Closed systemd-udevd-kernel.socket - udev Kernel Socket. May 12 13:22:36.378169 systemd[1]: dracut-pre-udev.service: Deactivated successfully. May 12 13:22:36.378217 systemd[1]: Stopped dracut-pre-udev.service - dracut pre-udev hook. May 12 13:22:36.381136 systemd[1]: dracut-cmdline.service: Deactivated successfully. May 12 13:22:36.381179 systemd[1]: Stopped dracut-cmdline.service - dracut cmdline hook. May 12 13:22:36.383845 systemd[1]: dracut-cmdline-ask.service: Deactivated successfully. May 12 13:22:36.383888 systemd[1]: Stopped dracut-cmdline-ask.service - dracut ask for additional cmdline parameters. May 12 13:22:36.386723 systemd[1]: Starting initrd-udevadm-cleanup-db.service - Cleanup udev Database... May 12 13:22:36.387970 systemd[1]: systemd-network-generator.service: Deactivated successfully. May 12 13:22:36.388030 systemd[1]: Stopped systemd-network-generator.service - Generate network units from Kernel command line. May 12 13:22:36.390838 systemd[1]: systemd-tmpfiles-setup-dev.service: Deactivated successfully. May 12 13:22:36.390880 systemd[1]: Stopped systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev. May 12 13:22:36.393728 systemd[1]: systemd-tmpfiles-setup-dev-early.service: Deactivated successfully. May 12 13:22:36.393769 systemd[1]: Stopped systemd-tmpfiles-setup-dev-early.service - Create Static Device Nodes in /dev gracefully. May 12 13:22:36.396171 systemd[1]: kmod-static-nodes.service: Deactivated successfully. May 12 13:22:36.396211 systemd[1]: Stopped kmod-static-nodes.service - Create List of Static Device Nodes. May 12 13:22:36.398444 systemd[1]: systemd-vconsole-setup.service: Deactivated successfully. May 12 13:22:36.398488 systemd[1]: Stopped systemd-vconsole-setup.service - Virtual Console Setup. May 12 13:22:36.403697 systemd[1]: initrd-udevadm-cleanup-db.service: Deactivated successfully. May 12 13:22:36.403779 systemd[1]: Finished initrd-udevadm-cleanup-db.service - Cleanup udev Database. May 12 13:22:36.405421 systemd[1]: Reached target initrd-switch-root.target - Switch Root. May 12 13:22:36.407784 systemd[1]: Starting initrd-switch-root.service - Switch Root... May 12 13:22:36.424791 systemd[1]: Switching root. May 12 13:22:36.453519 systemd-journald[239]: Journal stopped May 12 13:22:37.099459 systemd-journald[239]: Received SIGTERM from PID 1 (systemd). May 12 13:22:37.099524 kernel: SELinux: policy capability network_peer_controls=1 May 12 13:22:37.099536 kernel: SELinux: policy capability open_perms=1 May 12 13:22:37.099546 kernel: SELinux: policy capability extended_socket_class=1 May 12 13:22:37.099558 kernel: SELinux: policy capability always_check_network=0 May 12 13:22:37.099567 kernel: SELinux: policy capability cgroup_seclabel=1 May 12 13:22:37.099577 kernel: SELinux: policy capability nnp_nosuid_transition=1 May 12 13:22:37.099586 kernel: SELinux: policy capability genfs_seclabel_symlinks=0 May 12 13:22:37.099595 kernel: SELinux: policy capability ioctl_skip_cloexec=0 May 12 13:22:37.099604 kernel: audit: type=1403 audit(1747056156.524:2): auid=4294967295 ses=4294967295 lsm=selinux res=1 May 12 13:22:37.099615 systemd[1]: Successfully loaded SELinux policy in 33.912ms. May 12 13:22:37.099635 systemd[1]: Relabeled /dev/, /dev/shm/, /run/ in 9.699ms. May 12 13:22:37.099647 systemd[1]: systemd 256.8 running in system mode (+PAM +AUDIT +SELINUX -APPARMOR +IMA +SMACK +SECCOMP -GCRYPT -GNUTLS +OPENSSL -ACL +BLKID +CURL +ELFUTILS -FIDO2 +IDN2 -IDN +IPTC +KMOD +LIBCRYPTSETUP +LIBCRYPTSETUP_PLUGINS +LIBFDISK +PCRE2 -PWQUALITY -P11KIT -QRENCODE +TPM2 +BZIP2 +LZ4 +XZ +ZLIB +ZSTD -BPF_FRAMEWORK -XKBCOMMON +UTMP -SYSVINIT +LIBARCHIVE) May 12 13:22:37.099660 systemd[1]: Detected virtualization kvm. May 12 13:22:37.099670 systemd[1]: Detected architecture arm64. May 12 13:22:37.099681 systemd[1]: Detected first boot. May 12 13:22:37.099691 systemd[1]: Initializing machine ID from VM UUID. May 12 13:22:37.099703 zram_generator::config[1076]: No configuration found. May 12 13:22:37.099714 kernel: NET: Registered PF_VSOCK protocol family May 12 13:22:37.099724 systemd[1]: Populated /etc with preset unit settings. May 12 13:22:37.099735 systemd[1]: run-credentials-systemd\x2djournald.service.mount: Deactivated successfully. May 12 13:22:37.099747 systemd[1]: initrd-switch-root.service: Deactivated successfully. May 12 13:22:37.099759 systemd[1]: Stopped initrd-switch-root.service - Switch Root. May 12 13:22:37.099771 systemd[1]: systemd-journald.service: Scheduled restart job, restart counter is at 1. May 12 13:22:37.099782 systemd[1]: Created slice system-addon\x2dconfig.slice - Slice /system/addon-config. May 12 13:22:37.099793 systemd[1]: Created slice system-addon\x2drun.slice - Slice /system/addon-run. May 12 13:22:37.099808 systemd[1]: Created slice system-getty.slice - Slice /system/getty. May 12 13:22:37.099819 systemd[1]: Created slice system-modprobe.slice - Slice /system/modprobe. May 12 13:22:37.099830 systemd[1]: Created slice system-serial\x2dgetty.slice - Slice /system/serial-getty. May 12 13:22:37.099840 systemd[1]: Created slice system-system\x2dcloudinit.slice - Slice /system/system-cloudinit. May 12 13:22:37.099851 systemd[1]: Created slice system-systemd\x2dfsck.slice - Slice /system/systemd-fsck. May 12 13:22:37.099861 systemd[1]: Created slice user.slice - User and Session Slice. May 12 13:22:37.099871 systemd[1]: Started clevis-luks-askpass.path - Forward Password Requests to Clevis Directory Watch. May 12 13:22:37.099882 systemd[1]: Started systemd-ask-password-console.path - Dispatch Password Requests to Console Directory Watch. May 12 13:22:37.099893 systemd[1]: Started systemd-ask-password-wall.path - Forward Password Requests to Wall Directory Watch. May 12 13:22:37.099905 systemd[1]: Set up automount boot.automount - Boot partition Automount Point. May 12 13:22:37.099916 systemd[1]: Set up automount proc-sys-fs-binfmt_misc.automount - Arbitrary Executable File Formats File System Automount Point. May 12 13:22:37.099926 systemd[1]: Expecting device dev-disk-by\x2dlabel-OEM.device - /dev/disk/by-label/OEM... May 12 13:22:37.099936 systemd[1]: Expecting device dev-ttyAMA0.device - /dev/ttyAMA0... May 12 13:22:37.099946 systemd[1]: Reached target cryptsetup-pre.target - Local Encrypted Volumes (Pre). May 12 13:22:37.099956 systemd[1]: Reached target cryptsetup.target - Local Encrypted Volumes. May 12 13:22:37.099966 systemd[1]: Stopped target initrd-switch-root.target - Switch Root. May 12 13:22:37.099977 systemd[1]: Stopped target initrd-fs.target - Initrd File Systems. May 12 13:22:37.099989 systemd[1]: Stopped target initrd-root-fs.target - Initrd Root File System. May 12 13:22:37.099999 systemd[1]: Reached target integritysetup.target - Local Integrity Protected Volumes. May 12 13:22:37.100009 systemd[1]: Reached target remote-cryptsetup.target - Remote Encrypted Volumes. May 12 13:22:37.100027 systemd[1]: Reached target remote-fs.target - Remote File Systems. May 12 13:22:37.100039 systemd[1]: Reached target slices.target - Slice Units. May 12 13:22:37.100049 systemd[1]: Reached target swap.target - Swaps. May 12 13:22:37.100059 systemd[1]: Reached target veritysetup.target - Local Verity Protected Volumes. May 12 13:22:37.100069 systemd[1]: Listening on systemd-coredump.socket - Process Core Dump Socket. May 12 13:22:37.100079 systemd[1]: Listening on systemd-creds.socket - Credential Encryption/Decryption. May 12 13:22:37.100091 systemd[1]: Listening on systemd-networkd.socket - Network Service Netlink Socket. May 12 13:22:37.100102 systemd[1]: Listening on systemd-udevd-control.socket - udev Control Socket. May 12 13:22:37.100112 systemd[1]: Listening on systemd-udevd-kernel.socket - udev Kernel Socket. May 12 13:22:37.100122 systemd[1]: Listening on systemd-userdbd.socket - User Database Manager Socket. May 12 13:22:37.100132 systemd[1]: Mounting dev-hugepages.mount - Huge Pages File System... May 12 13:22:37.100142 systemd[1]: Mounting dev-mqueue.mount - POSIX Message Queue File System... May 12 13:22:37.100152 systemd[1]: Mounting media.mount - External Media Directory... May 12 13:22:37.100162 systemd[1]: Mounting sys-kernel-debug.mount - Kernel Debug File System... May 12 13:22:37.100176 systemd[1]: Mounting sys-kernel-tracing.mount - Kernel Trace File System... May 12 13:22:37.100187 systemd[1]: Mounting tmp.mount - Temporary Directory /tmp... May 12 13:22:37.100198 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). May 12 13:22:37.100208 systemd[1]: Reached target machines.target - Containers. May 12 13:22:37.100220 systemd[1]: Starting flatcar-tmpfiles.service - Create missing system files... May 12 13:22:37.100230 systemd[1]: ignition-delete-config.service - Ignition (delete config) was skipped because no trigger condition checks were met. May 12 13:22:37.100245 systemd[1]: Starting kmod-static-nodes.service - Create List of Static Device Nodes... May 12 13:22:37.100256 systemd[1]: Starting modprobe@configfs.service - Load Kernel Module configfs... May 12 13:22:37.100266 systemd[1]: Starting modprobe@dm_mod.service - Load Kernel Module dm_mod... May 12 13:22:37.100278 systemd[1]: Starting modprobe@drm.service - Load Kernel Module drm... May 12 13:22:37.100288 systemd[1]: Starting modprobe@efi_pstore.service - Load Kernel Module efi_pstore... May 12 13:22:37.100298 systemd[1]: Starting modprobe@fuse.service - Load Kernel Module fuse... May 12 13:22:37.100308 systemd[1]: Starting modprobe@loop.service - Load Kernel Module loop... May 12 13:22:37.100318 systemd[1]: setup-nsswitch.service - Create /etc/nsswitch.conf was skipped because of an unmet condition check (ConditionPathExists=!/etc/nsswitch.conf). May 12 13:22:37.100330 systemd[1]: systemd-fsck-root.service: Deactivated successfully. May 12 13:22:37.100340 systemd[1]: Stopped systemd-fsck-root.service - File System Check on Root Device. May 12 13:22:37.100354 systemd[1]: systemd-fsck-usr.service: Deactivated successfully. May 12 13:22:37.100368 systemd[1]: Stopped systemd-fsck-usr.service. May 12 13:22:37.100382 systemd[1]: systemd-hibernate-clear.service - Clear Stale Hibernate Storage Info was skipped because of an unmet condition check (ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67). May 12 13:22:37.100392 kernel: loop: module loaded May 12 13:22:37.100401 kernel: ACPI: bus type drm_connector registered May 12 13:22:37.100410 kernel: fuse: init (API version 7.39) May 12 13:22:37.100421 systemd[1]: Starting systemd-journald.service - Journal Service... May 12 13:22:37.100441 systemd[1]: Starting systemd-modules-load.service - Load Kernel Modules... May 12 13:22:37.100453 systemd[1]: Starting systemd-network-generator.service - Generate network units from Kernel command line... May 12 13:22:37.100464 systemd[1]: Starting systemd-remount-fs.service - Remount Root and Kernel File Systems... May 12 13:22:37.100475 systemd[1]: Starting systemd-udev-load-credentials.service - Load udev Rules from Credentials... May 12 13:22:37.100485 systemd[1]: Starting systemd-udev-trigger.service - Coldplug All udev Devices... May 12 13:22:37.100517 systemd-journald[1148]: Collecting audit messages is disabled. May 12 13:22:37.100539 systemd[1]: verity-setup.service: Deactivated successfully. May 12 13:22:37.100550 systemd[1]: Stopped verity-setup.service. May 12 13:22:37.100560 systemd-journald[1148]: Journal started May 12 13:22:37.100581 systemd-journald[1148]: Runtime Journal (/run/log/journal/7de8cb7d084e4e63be46f860a926639e) is 5.9M, max 47.3M, 41.4M free. May 12 13:22:36.892486 systemd[1]: Queued start job for default target multi-user.target. May 12 13:22:36.904225 systemd[1]: Unnecessary job was removed for dev-vda6.device - /dev/vda6. May 12 13:22:36.904589 systemd[1]: systemd-journald.service: Deactivated successfully. May 12 13:22:37.106188 systemd[1]: Started systemd-journald.service - Journal Service. May 12 13:22:37.106840 systemd[1]: Mounted dev-hugepages.mount - Huge Pages File System. May 12 13:22:37.108067 systemd[1]: Mounted dev-mqueue.mount - POSIX Message Queue File System. May 12 13:22:37.109338 systemd[1]: Mounted media.mount - External Media Directory. May 12 13:22:37.110493 systemd[1]: Mounted sys-kernel-debug.mount - Kernel Debug File System. May 12 13:22:37.111686 systemd[1]: Mounted sys-kernel-tracing.mount - Kernel Trace File System. May 12 13:22:37.112911 systemd[1]: Mounted tmp.mount - Temporary Directory /tmp. May 12 13:22:37.115461 systemd[1]: Finished flatcar-tmpfiles.service - Create missing system files. May 12 13:22:37.116881 systemd[1]: Finished kmod-static-nodes.service - Create List of Static Device Nodes. May 12 13:22:37.118447 systemd[1]: modprobe@configfs.service: Deactivated successfully. May 12 13:22:37.118625 systemd[1]: Finished modprobe@configfs.service - Load Kernel Module configfs. May 12 13:22:37.120109 systemd[1]: modprobe@dm_mod.service: Deactivated successfully. May 12 13:22:37.120302 systemd[1]: Finished modprobe@dm_mod.service - Load Kernel Module dm_mod. May 12 13:22:37.123714 systemd[1]: modprobe@drm.service: Deactivated successfully. May 12 13:22:37.123893 systemd[1]: Finished modprobe@drm.service - Load Kernel Module drm. May 12 13:22:37.125227 systemd[1]: modprobe@efi_pstore.service: Deactivated successfully. May 12 13:22:37.125385 systemd[1]: Finished modprobe@efi_pstore.service - Load Kernel Module efi_pstore. May 12 13:22:37.126928 systemd[1]: modprobe@fuse.service: Deactivated successfully. May 12 13:22:37.127156 systemd[1]: Finished modprobe@fuse.service - Load Kernel Module fuse. May 12 13:22:37.128608 systemd[1]: modprobe@loop.service: Deactivated successfully. May 12 13:22:37.128788 systemd[1]: Finished modprobe@loop.service - Load Kernel Module loop. May 12 13:22:37.130232 systemd[1]: Finished systemd-modules-load.service - Load Kernel Modules. May 12 13:22:37.131736 systemd[1]: Finished systemd-network-generator.service - Generate network units from Kernel command line. May 12 13:22:37.133605 systemd[1]: Finished systemd-remount-fs.service - Remount Root and Kernel File Systems. May 12 13:22:37.136471 systemd[1]: Finished systemd-udev-load-credentials.service - Load udev Rules from Credentials. May 12 13:22:37.149744 systemd[1]: Reached target network-pre.target - Preparation for Network. May 12 13:22:37.152182 systemd[1]: Mounting sys-fs-fuse-connections.mount - FUSE Control File System... May 12 13:22:37.154247 systemd[1]: Mounting sys-kernel-config.mount - Kernel Configuration File System... May 12 13:22:37.155501 systemd[1]: remount-root.service - Remount Root File System was skipped because of an unmet condition check (ConditionPathIsReadWrite=!/). May 12 13:22:37.155540 systemd[1]: Reached target local-fs.target - Local File Systems. May 12 13:22:37.157393 systemd[1]: Listening on systemd-sysext.socket - System Extension Image Management. May 12 13:22:37.163441 systemd[1]: Starting ldconfig.service - Rebuild Dynamic Linker Cache... May 12 13:22:37.164670 systemd[1]: systemd-binfmt.service - Set Up Additional Binary Formats was skipped because no trigger condition checks were met. May 12 13:22:37.165663 systemd[1]: Starting systemd-hwdb-update.service - Rebuild Hardware Database... May 12 13:22:37.167585 systemd[1]: Starting systemd-journal-flush.service - Flush Journal to Persistent Storage... May 12 13:22:37.168902 systemd[1]: systemd-pstore.service - Platform Persistent Storage Archival was skipped because of an unmet condition check (ConditionDirectoryNotEmpty=/sys/fs/pstore). May 12 13:22:37.175936 systemd-journald[1148]: Time spent on flushing to /var/log/journal/7de8cb7d084e4e63be46f860a926639e is 17.495ms for 843 entries. May 12 13:22:37.175936 systemd-journald[1148]: System Journal (/var/log/journal/7de8cb7d084e4e63be46f860a926639e) is 8M, max 195.6M, 187.6M free. May 12 13:22:37.204995 systemd-journald[1148]: Received client request to flush runtime journal. May 12 13:22:37.173561 systemd[1]: Starting systemd-random-seed.service - Load/Save OS Random Seed... May 12 13:22:37.174745 systemd[1]: systemd-repart.service - Repartition Root Disk was skipped because no trigger condition checks were met. May 12 13:22:37.175697 systemd[1]: Starting systemd-sysctl.service - Apply Kernel Variables... May 12 13:22:37.178739 systemd[1]: Starting systemd-sysext.service - Merge System Extension Images into /usr/ and /opt/... May 12 13:22:37.181204 systemd[1]: Starting systemd-tmpfiles-setup-dev-early.service - Create Static Device Nodes in /dev gracefully... May 12 13:22:37.185490 systemd[1]: Finished systemd-udev-trigger.service - Coldplug All udev Devices. May 12 13:22:37.189698 systemd[1]: Mounted sys-fs-fuse-connections.mount - FUSE Control File System. May 12 13:22:37.190847 (sd-merge)[1195]: No extensions found. May 12 13:22:37.191222 systemd[1]: Mounted sys-kernel-config.mount - Kernel Configuration File System. May 12 13:22:37.198607 systemd[1]: Finished systemd-sysext.service - Merge System Extension Images into /usr/ and /opt/. May 12 13:22:37.206407 systemd[1]: Starting ensure-sysext.service... May 12 13:22:37.207615 systemd[1]: Finished systemd-journal-flush.service - Flush Journal to Persistent Storage. May 12 13:22:37.209919 systemd[1]: Finished systemd-random-seed.service - Load/Save OS Random Seed. May 12 13:22:37.212034 systemd[1]: Finished systemd-sysctl.service - Apply Kernel Variables. May 12 13:22:37.215265 systemd-tmpfiles[1193]: ACLs are not supported, ignoring. May 12 13:22:37.215283 systemd-tmpfiles[1193]: ACLs are not supported, ignoring. May 12 13:22:37.215326 systemd[1]: Reached target first-boot-complete.target - First Boot Complete. May 12 13:22:37.225960 systemd[1]: Starting systemd-machine-id-commit.service - Save Transient machine-id to Disk... May 12 13:22:37.227804 systemd[1]: Finished systemd-tmpfiles-setup-dev-early.service - Create Static Device Nodes in /dev gracefully. May 12 13:22:37.232752 systemd[1]: Starting systemd-sysusers.service - Create System Users... May 12 13:22:37.233994 systemd[1]: Reload requested from client PID 1201 ('systemctl') (unit ensure-sysext.service)... May 12 13:22:37.234001 systemd[1]: Reloading... May 12 13:22:37.294533 zram_generator::config[1238]: No configuration found. May 12 13:22:37.450689 systemd[1]: etc-machine\x2did.mount: Deactivated successfully. May 12 13:22:37.451120 systemd[1]: Reloading finished in 216 ms. May 12 13:22:37.452056 ldconfig[1187]: /sbin/ldconfig: /usr/lib/ld.so.conf is not an ELF file - it has the wrong magic bytes at the start. May 12 13:22:37.468182 systemd[1]: Finished ldconfig.service - Rebuild Dynamic Linker Cache. May 12 13:22:37.469714 systemd[1]: Finished systemd-machine-id-commit.service - Save Transient machine-id to Disk. May 12 13:22:37.475486 systemd[1]: Finished systemd-sysusers.service - Create System Users. May 12 13:22:37.492652 systemd[1]: Starting systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev... May 12 13:22:37.494912 systemd[1]: Starting systemd-tmpfiles-setup.service - Create System Files and Directories... May 12 13:22:37.497673 systemd[1]: ignition-delete-config.service - Ignition (delete config) was skipped because no trigger condition checks were met. May 12 13:22:37.506644 systemd[1]: Starting modprobe@dm_mod.service - Load Kernel Module dm_mod... May 12 13:22:37.509364 systemd[1]: Starting modprobe@efi_pstore.service - Load Kernel Module efi_pstore... May 12 13:22:37.514637 systemd[1]: Starting modprobe@loop.service - Load Kernel Module loop... May 12 13:22:37.515842 systemd[1]: systemd-binfmt.service - Set Up Additional Binary Formats was skipped because no trigger condition checks were met. May 12 13:22:37.515953 systemd[1]: systemd-hibernate-clear.service - Clear Stale Hibernate Storage Info was skipped because of an unmet condition check (ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67). May 12 13:22:37.517082 systemd[1]: modprobe@efi_pstore.service: Deactivated successfully. May 12 13:22:37.517247 systemd[1]: Finished modprobe@efi_pstore.service - Load Kernel Module efi_pstore. May 12 13:22:37.518670 systemd-tmpfiles[1276]: /usr/lib/tmpfiles.d/nfs-utils.conf:6: Duplicate line for path "/var/lib/nfs/sm", ignoring. May 12 13:22:37.518817 systemd-tmpfiles[1276]: /usr/lib/tmpfiles.d/nfs-utils.conf:7: Duplicate line for path "/var/lib/nfs/sm.bak", ignoring. May 12 13:22:37.518996 systemd-tmpfiles[1276]: /usr/lib/tmpfiles.d/provision.conf:20: Duplicate line for path "/root", ignoring. May 12 13:22:37.519150 systemd-tmpfiles[1276]: /usr/lib/tmpfiles.d/systemd-flatcar.conf:6: Duplicate line for path "/var/log/journal", ignoring. May 12 13:22:37.519697 systemd-tmpfiles[1276]: /usr/lib/tmpfiles.d/systemd.conf:29: Duplicate line for path "/var/lib/systemd", ignoring. May 12 13:22:37.519868 systemd-tmpfiles[1276]: ACLs are not supported, ignoring. May 12 13:22:37.519907 systemd-tmpfiles[1276]: ACLs are not supported, ignoring. May 12 13:22:37.522300 systemd-tmpfiles[1276]: Detected autofs mount point /boot during canonicalization of boot. May 12 13:22:37.522305 systemd-tmpfiles[1276]: Skipping /boot May 12 13:22:37.523684 systemd[1]: modprobe@dm_mod.service: Deactivated successfully. May 12 13:22:37.523941 systemd[1]: Finished modprobe@dm_mod.service - Load Kernel Module dm_mod. May 12 13:22:37.525772 systemd[1]: modprobe@loop.service: Deactivated successfully. May 12 13:22:37.525941 systemd[1]: Finished modprobe@loop.service - Load Kernel Module loop. May 12 13:22:37.527593 systemd-tmpfiles[1275]: ACLs are not supported, ignoring. May 12 13:22:37.527609 systemd-tmpfiles[1275]: ACLs are not supported, ignoring. May 12 13:22:37.529072 systemd[1]: ignition-delete-config.service - Ignition (delete config) was skipped because no trigger condition checks were met. May 12 13:22:37.531655 systemd[1]: Starting modprobe@dm_mod.service - Load Kernel Module dm_mod... May 12 13:22:37.534305 systemd-tmpfiles[1276]: Detected autofs mount point /boot during canonicalization of boot. May 12 13:22:37.534401 systemd-tmpfiles[1276]: Skipping /boot May 12 13:22:37.536664 systemd[1]: Starting modprobe@efi_pstore.service - Load Kernel Module efi_pstore... May 12 13:22:37.539686 systemd[1]: Starting modprobe@loop.service - Load Kernel Module loop... May 12 13:22:37.540796 systemd[1]: systemd-binfmt.service - Set Up Additional Binary Formats was skipped because no trigger condition checks were met. May 12 13:22:37.540906 systemd[1]: systemd-hibernate-clear.service - Clear Stale Hibernate Storage Info was skipped because of an unmet condition check (ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67). May 12 13:22:37.544422 systemd[1]: Finished systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev. May 12 13:22:37.546239 systemd[1]: modprobe@dm_mod.service: Deactivated successfully. May 12 13:22:37.546400 systemd[1]: Finished modprobe@dm_mod.service - Load Kernel Module dm_mod. May 12 13:22:37.547987 systemd[1]: modprobe@efi_pstore.service: Deactivated successfully. May 12 13:22:37.548144 systemd[1]: Finished modprobe@efi_pstore.service - Load Kernel Module efi_pstore. May 12 13:22:37.549891 systemd[1]: modprobe@loop.service: Deactivated successfully. May 12 13:22:37.550053 systemd[1]: Finished modprobe@loop.service - Load Kernel Module loop. May 12 13:22:37.551596 systemd[1]: Finished systemd-tmpfiles-setup.service - Create System Files and Directories. May 12 13:22:37.564874 systemd[1]: Starting audit-rules.service - Load Audit Rules... May 12 13:22:37.567133 systemd[1]: Starting clean-ca-certificates.service - Clean up broken links in /etc/ssl/certs... May 12 13:22:37.568455 systemd[1]: ignition-delete-config.service - Ignition (delete config) was skipped because no trigger condition checks were met. May 12 13:22:37.575285 systemd[1]: Starting modprobe@dm_mod.service - Load Kernel Module dm_mod... May 12 13:22:37.580468 systemd[1]: Starting modprobe@drm.service - Load Kernel Module drm... May 12 13:22:37.583596 systemd[1]: Starting modprobe@efi_pstore.service - Load Kernel Module efi_pstore... May 12 13:22:37.586697 systemd[1]: Starting modprobe@loop.service - Load Kernel Module loop... May 12 13:22:37.588565 systemd[1]: systemd-binfmt.service - Set Up Additional Binary Formats was skipped because no trigger condition checks were met. May 12 13:22:37.588801 systemd[1]: systemd-hibernate-clear.service - Clear Stale Hibernate Storage Info was skipped because of an unmet condition check (ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67). May 12 13:22:37.592379 systemd[1]: Starting systemd-journal-catalog-update.service - Rebuild Journal Catalog... May 12 13:22:37.595848 systemd[1]: Starting systemd-resolved.service - Network Name Resolution... May 12 13:22:37.597912 systemd[1]: Starting systemd-update-utmp.service - Record System Boot/Shutdown in UTMP... May 12 13:22:37.601004 systemd[1]: modprobe@dm_mod.service: Deactivated successfully. May 12 13:22:37.601191 systemd[1]: Finished modprobe@dm_mod.service - Load Kernel Module dm_mod. May 12 13:22:37.604062 systemd[1]: modprobe@drm.service: Deactivated successfully. May 12 13:22:37.604233 systemd[1]: Finished modprobe@drm.service - Load Kernel Module drm. May 12 13:22:37.605797 systemd[1]: modprobe@efi_pstore.service: Deactivated successfully. May 12 13:22:37.605944 systemd[1]: Finished modprobe@efi_pstore.service - Load Kernel Module efi_pstore. May 12 13:22:37.607509 systemd[1]: modprobe@loop.service: Deactivated successfully. May 12 13:22:37.607653 systemd[1]: Finished modprobe@loop.service - Load Kernel Module loop. May 12 13:22:37.610825 systemd[1]: Finished ensure-sysext.service. May 12 13:22:37.616361 systemd[1]: systemd-pstore.service - Platform Persistent Storage Archival was skipped because of an unmet condition check (ConditionDirectoryNotEmpty=/sys/fs/pstore). May 12 13:22:37.616409 systemd[1]: systemd-repart.service - Repartition Root Disk was skipped because no trigger condition checks were met. May 12 13:22:37.618073 systemd[1]: Starting systemd-timesyncd.service - Network Time Synchronization... May 12 13:22:37.621570 systemd[1]: Starting systemd-userdbd.service - User Database Manager... May 12 13:22:37.636007 systemd[1]: Finished systemd-update-utmp.service - Record System Boot/Shutdown in UTMP. May 12 13:22:37.641873 systemd[1]: Finished systemd-journal-catalog-update.service - Rebuild Journal Catalog. May 12 13:22:37.646893 systemd[1]: Finished clean-ca-certificates.service - Clean up broken links in /etc/ssl/certs. May 12 13:22:37.648332 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). May 12 13:22:37.656812 augenrules[1331]: No rules May 12 13:22:37.657868 systemd[1]: audit-rules.service: Deactivated successfully. May 12 13:22:37.659467 systemd[1]: Finished audit-rules.service - Load Audit Rules. May 12 13:22:37.662569 systemd[1]: Finished systemd-hwdb-update.service - Rebuild Hardware Database. May 12 13:22:37.665843 systemd[1]: Starting systemd-udevd.service - Rule-based Manager for Device Events and Files... May 12 13:22:37.668087 systemd[1]: Starting systemd-update-done.service - Update is Completed... May 12 13:22:37.686054 systemd[1]: Started systemd-userdbd.service - User Database Manager. May 12 13:22:37.693171 systemd[1]: Finished systemd-update-done.service - Update is Completed. May 12 13:22:37.713386 systemd-udevd[1338]: Using default interface naming scheme 'v255'. May 12 13:22:37.734746 systemd[1]: Started systemd-timesyncd.service - Network Time Synchronization. May 12 13:22:37.736290 systemd[1]: Reached target time-set.target - System Time Set. May 12 13:22:37.737629 systemd[1]: Started systemd-udevd.service - Rule-based Manager for Device Events and Files. May 12 13:22:37.741786 systemd[1]: Starting systemd-networkd.service - Network Configuration... May 12 13:22:37.742203 systemd-resolved[1306]: Positive Trust Anchors: May 12 13:22:37.742223 systemd-resolved[1306]: . IN DS 20326 8 2 e06d44b80b8f1d39a95c0b0d7c65d08458e880409bbc683457104237c7f8ec8d May 12 13:22:37.742255 systemd-resolved[1306]: 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 May 12 13:22:37.753998 systemd-resolved[1306]: Defaulting to hostname 'linux'. May 12 13:22:37.776977 systemd[1]: Started systemd-resolved.service - Network Name Resolution. May 12 13:22:37.780252 systemd[1]: Condition check resulted in dev-ttyAMA0.device - /dev/ttyAMA0 being skipped. May 12 13:22:37.780975 systemd[1]: Reached target nss-lookup.target - Host and Network Name Lookups. May 12 13:22:37.785993 systemd[1]: Reached target sysinit.target - System Initialization. May 12 13:22:37.786453 kernel: BTRFS warning: duplicate device /dev/vda3 devid 1 generation 42 scanned by (udev-worker) (1369) May 12 13:22:37.787382 systemd[1]: Started motdgen.path - Watch for update engine configuration changes. May 12 13:22:37.789236 systemd[1]: Started user-cloudinit@var-lib-flatcar\x2dinstall-user_data.path - Watch for a cloud-config at /var/lib/flatcar-install/user_data. May 12 13:22:37.792314 systemd[1]: Started logrotate.timer - Daily rotation of log files. May 12 13:22:37.793761 systemd[1]: Started mdadm.timer - Weekly check for MD array's redundancy information.. May 12 13:22:37.795503 systemd[1]: Started systemd-tmpfiles-clean.timer - Daily Cleanup of Temporary Directories. May 12 13:22:37.797585 systemd[1]: update-engine-stub.timer - Update Engine Stub Timer was skipped because of an unmet condition check (ConditionPathExists=/usr/.noupdate). May 12 13:22:37.797621 systemd[1]: Reached target paths.target - Path Units. May 12 13:22:37.798570 systemd[1]: Reached target timers.target - Timer Units. May 12 13:22:37.800386 systemd[1]: Listening on dbus.socket - D-Bus System Message Bus Socket. May 12 13:22:37.803766 systemd[1]: Listening on sshd-unix-local.socket - OpenSSH Server Socket (systemd-ssh-generator, AF_UNIX Local). May 12 13:22:37.805474 systemd[1]: Listening on sshd-vsock.socket - OpenSSH Server Socket (systemd-ssh-generator, AF_VSOCK). May 12 13:22:37.807123 systemd[1]: Reached target ssh-access.target - SSH Access Available. May 12 13:22:37.816389 systemd[1]: Listening on sshd.socket - OpenSSH Server Socket. May 12 13:22:37.818245 systemd[1]: Listening on systemd-hostnamed.socket - Hostname Service Socket. May 12 13:22:37.819882 systemd[1]: Reached target sockets.target - Socket Units. May 12 13:22:37.821067 systemd[1]: Reached target basic.target - Basic System. May 12 13:22:37.822503 systemd[1]: addon-config@oem.service - Configure Addon /oem was skipped because no trigger condition checks were met. May 12 13:22:37.822538 systemd[1]: addon-run@oem.service - Run Addon /oem was skipped because no trigger condition checks were met. May 12 13:22:37.823882 systemd[1]: Starting dbus.service - D-Bus System Message Bus... May 12 13:22:37.828670 systemd[1]: Starting dracut-shutdown.service - Restore /run/initramfs on shutdown... May 12 13:22:37.831363 systemd[1]: Starting enable-oem-cloudinit.service - Enable cloudinit... May 12 13:22:37.838613 systemd[1]: Starting extend-filesystems.service - Extend Filesystems... May 12 13:22:37.841523 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). May 12 13:22:37.842466 systemd[1]: Starting motdgen.service - Generate /run/flatcar/motd... May 12 13:22:37.846044 systemd[1]: Starting ssh-key-proc-cmdline.service - Install an ssh key from /proc/cmdline... May 12 13:22:37.849894 jq[1386]: false May 12 13:22:37.850729 systemd[1]: Starting sshd-keygen.service - Generate sshd host keys... May 12 13:22:37.854757 systemd[1]: Starting systemd-logind.service - User Login Management... May 12 13:22:37.856567 systemd[1]: tcsd.service - TCG Core Services Daemon was skipped because of an unmet condition check (ConditionPathExists=/dev/tpm0). May 12 13:22:37.856927 systemd[1]: cgroup compatibility translation between legacy and unified hierarchy settings activated. See cgroup-compat debug messages for details. May 12 13:22:37.858642 systemd[1]: Starting update-engine.service - Update Engine... May 12 13:22:37.861287 systemd[1]: Starting update-ssh-keys-after-ignition.service - Run update-ssh-keys once after Ignition... May 12 13:22:37.865297 systemd[1]: Finished dracut-shutdown.service - Restore /run/initramfs on shutdown. May 12 13:22:37.867960 systemd[1]: enable-oem-cloudinit.service: Skipped due to 'exec-condition'. May 12 13:22:37.868176 systemd[1]: Condition check resulted in enable-oem-cloudinit.service - Enable cloudinit being skipped. May 12 13:22:37.868411 systemd[1]: motdgen.service: Deactivated successfully. May 12 13:22:37.869509 jq[1399]: true May 12 13:22:37.868599 systemd[1]: Finished motdgen.service - Generate /run/flatcar/motd. May 12 13:22:37.872825 systemd[1]: ssh-key-proc-cmdline.service: Deactivated successfully. May 12 13:22:37.873019 systemd[1]: Finished ssh-key-proc-cmdline.service - Install an ssh key from /proc/cmdline. May 12 13:22:37.897906 jq[1402]: true May 12 13:22:37.913898 systemd[1]: Found device dev-disk-by\x2dlabel-OEM.device - /dev/disk/by-label/OEM. May 12 13:22:37.927088 update_engine[1394]: I20250512 13:22:37.926882 1394 main.cc:92] Flatcar Update Engine starting May 12 13:22:37.933261 systemd[1]: Starting systemd-fsck@dev-disk-by\x2dlabel-OEM.service - File System Check on /dev/disk/by-label/OEM... May 12 13:22:37.938493 extend-filesystems[1387]: Found vda May 12 13:22:37.938493 extend-filesystems[1387]: Found vda1 May 12 13:22:37.938493 extend-filesystems[1387]: Found vda2 May 12 13:22:37.938493 extend-filesystems[1387]: Found vda3 May 12 13:22:37.938493 extend-filesystems[1387]: Found usr May 12 13:22:37.938493 extend-filesystems[1387]: Found vda4 May 12 13:22:37.938493 extend-filesystems[1387]: Found vda6 May 12 13:22:37.938493 extend-filesystems[1387]: Found vda7 May 12 13:22:37.938493 extend-filesystems[1387]: Found vda9 May 12 13:22:37.936535 systemd[1]: extend-filesystems.service: Deactivated successfully. May 12 13:22:37.936753 systemd[1]: Finished extend-filesystems.service - Extend Filesystems. May 12 13:22:37.959790 systemd[1]: Finished systemd-fsck@dev-disk-by\x2dlabel-OEM.service - File System Check on /dev/disk/by-label/OEM. May 12 13:22:37.968800 dbus-daemon[1384]: [system] SELinux support is enabled May 12 13:22:37.968965 systemd[1]: Started dbus.service - D-Bus System Message Bus. May 12 13:22:37.970087 systemd-networkd[1358]: lo: Link UP May 12 13:22:37.970600 systemd-networkd[1358]: lo: Gained carrier May 12 13:22:37.972357 systemd-networkd[1358]: Enumeration completed May 12 13:22:37.972702 update_engine[1394]: I20250512 13:22:37.972646 1394 update_check_scheduler.cc:74] Next update check in 5m30s May 12 13:22:37.973110 systemd-networkd[1358]: eth0: found matching network '/usr/lib/systemd/network/zz-default.network', based on potentially unpredictable interface name. May 12 13:22:37.973228 systemd-networkd[1358]: eth0: Configuring with /usr/lib/systemd/network/zz-default.network. May 12 13:22:37.973699 systemd[1]: Started systemd-networkd.service - Network Configuration. May 12 13:22:37.974941 systemd[1]: Reached target network.target - Network. May 12 13:22:37.975958 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). May 12 13:22:37.975991 systemd[1]: Reached target system-config.target - Load system-provided cloud configs. May 12 13:22:37.976515 systemd-networkd[1358]: eth0: Link UP May 12 13:22:37.976596 systemd-networkd[1358]: eth0: Gained carrier May 12 13:22:37.976730 systemd-networkd[1358]: eth0: found matching network '/usr/lib/systemd/network/zz-default.network', based on potentially unpredictable interface name. May 12 13:22:37.979583 systemd[1]: Starting systemd-networkd-persistent-storage.service - Enable Persistent Storage in systemd-networkd... May 12 13:22:37.981841 systemd[1]: Starting systemd-networkd-wait-online.service - Wait for Network to be Configured... May 12 13:22:37.983054 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). May 12 13:22:37.983082 systemd[1]: Reached target user-config.target - Load user-provided cloud configs. May 12 13:22:37.984423 systemd[1]: Started update-engine.service - Update Engine. May 12 13:22:37.993764 bash[1429]: Updated "/home/core/.ssh/authorized_keys" May 12 13:22:37.994899 systemd[1]: Started locksmithd.service - Cluster reboot manager. May 12 13:22:37.996287 systemd-logind[1393]: New seat seat0. May 12 13:22:37.997493 systemd-networkd[1358]: eth0: DHCPv4 address 10.0.0.44/16, gateway 10.0.0.1 acquired from 10.0.0.1 May 12 13:22:37.997610 systemd[1]: Finished update-ssh-keys-after-ignition.service - Run update-ssh-keys once after Ignition. May 12 13:22:37.998321 systemd-timesyncd[1316]: Network configuration changed, trying to establish connection. May 12 13:22:38.000031 systemd-timesyncd[1316]: Contacted time server 10.0.0.1:123 (10.0.0.1). May 12 13:22:38.000082 systemd-timesyncd[1316]: Initial clock synchronization to Mon 2025-05-12 13:22:37.909425 UTC. May 12 13:22:38.001067 systemd[1]: Started systemd-logind.service - User Login Management. May 12 13:22:38.003644 systemd[1]: sshkeys.service was skipped because no trigger condition checks were met. May 12 13:22:38.035498 systemd[1]: Finished systemd-networkd-persistent-storage.service - Enable Persistent Storage in systemd-networkd. May 12 13:22:38.060033 systemd[1]: Starting systemd-vconsole-setup.service - Virtual Console Setup... May 12 13:22:38.069090 systemd-logind[1393]: Watching system buttons on /dev/input/event0 (Power Button) May 12 13:22:38.074730 locksmithd[1432]: locksmithd starting currentOperation="UPDATE_STATUS_IDLE" strategy="reboot" May 12 13:22:38.107229 systemd[1]: Finished systemd-vconsole-setup.service - Virtual Console Setup. May 12 13:22:39.055547 systemd-networkd[1358]: eth0: Gained IPv6LL May 12 13:22:39.057832 systemd[1]: Finished systemd-networkd-wait-online.service - Wait for Network to be Configured. May 12 13:22:39.061613 systemd[1]: Reached target network-online.target - Network is Online. May 12 13:22:39.063899 systemd[1]: Starting coreos-metadata.service - QEMU metadata agent... May 12 13:22:39.065756 systemd[1]: Starting nvidia.service - NVIDIA Configure Service... May 12 13:22:39.092289 systemd[1]: coreos-metadata.service: Deactivated successfully. May 12 13:22:39.092487 systemd[1]: Finished coreos-metadata.service - QEMU metadata agent. May 12 13:22:39.094138 systemd[1]: packet-phone-home.service - Report Success to Packet was skipped because no trigger condition checks were met. May 12 13:22:39.096580 systemd[1]: Finished nvidia.service - NVIDIA Configure Service. May 12 13:22:39.414495 sshd_keygen[1401]: ssh-keygen: generating new host keys: RSA ECDSA ED25519 May 12 13:22:39.432248 systemd[1]: Finished sshd-keygen.service - Generate sshd host keys. May 12 13:22:39.434846 systemd[1]: Starting issuegen.service - Generate /run/issue... May 12 13:22:39.454319 systemd[1]: issuegen.service: Deactivated successfully. May 12 13:22:39.455544 systemd[1]: Finished issuegen.service - Generate /run/issue. May 12 13:22:39.458006 systemd[1]: Starting systemd-user-sessions.service - Permit User Sessions... May 12 13:22:39.474194 systemd[1]: Finished systemd-user-sessions.service - Permit User Sessions. May 12 13:22:39.476739 systemd[1]: Started getty@tty1.service - Getty on tty1. May 12 13:22:39.478649 systemd[1]: Started serial-getty@ttyAMA0.service - Serial Getty on ttyAMA0. May 12 13:22:39.479960 systemd[1]: Reached target getty.target - Login Prompts. May 12 13:22:39.481009 systemd[1]: Reached target multi-user.target - Multi-User System. May 12 13:22:39.484495 systemd[1]: Startup finished in 2.153s (kernel) + 3.823s (initrd) + 2.995s (userspace) = 8.972s. May 12 13:22:45.969076 systemd[1]: Created slice system-sshd.slice - Slice /system/sshd. May 12 13:22:45.970179 systemd[1]: Started sshd@0-10.0.0.44:22-10.0.0.1:60490.service - OpenSSH per-connection server daemon (10.0.0.1:60490). May 12 13:22:46.038936 sshd[1496]: Accepted publickey for core from 10.0.0.1 port 60490 ssh2: RSA SHA256:jEPoW5jmVqQGUqKP3XswdpHQkuwhsPJWJAB8YbEjhZ8 May 12 13:22:46.040442 sshd-session[1496]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) May 12 13:22:46.045969 systemd[1]: Created slice user-500.slice - User Slice of UID 500. May 12 13:22:46.046869 systemd[1]: Starting user-runtime-dir@500.service - User Runtime Directory /run/user/500... May 12 13:22:46.051798 systemd-logind[1393]: New session 1 of user core. May 12 13:22:46.071471 systemd[1]: Finished user-runtime-dir@500.service - User Runtime Directory /run/user/500. May 12 13:22:46.074331 systemd[1]: Starting user@500.service - User Manager for UID 500... May 12 13:22:46.089246 (systemd)[1500]: pam_unix(systemd-user:session): session opened for user core(uid=500) by (uid=0) May 12 13:22:46.091521 systemd-logind[1393]: New session c1 of user core. May 12 13:22:46.201542 systemd[1500]: Queued start job for default target default.target. May 12 13:22:46.211407 systemd[1500]: Created slice app.slice - User Application Slice. May 12 13:22:46.211462 systemd[1500]: Reached target paths.target - Paths. May 12 13:22:46.211499 systemd[1500]: Reached target timers.target - Timers. May 12 13:22:46.212654 systemd[1500]: Starting dbus.socket - D-Bus User Message Bus Socket... May 12 13:22:46.221098 systemd[1500]: Listening on dbus.socket - D-Bus User Message Bus Socket. May 12 13:22:46.221160 systemd[1500]: Reached target sockets.target - Sockets. May 12 13:22:46.221196 systemd[1500]: Reached target basic.target - Basic System. May 12 13:22:46.221224 systemd[1500]: Reached target default.target - Main User Target. May 12 13:22:46.221249 systemd[1500]: Startup finished in 124ms. May 12 13:22:46.221396 systemd[1]: Started user@500.service - User Manager for UID 500. May 12 13:22:46.230578 systemd[1]: Started session-1.scope - Session 1 of User core. May 12 13:22:46.289458 systemd[1]: Started sshd@1-10.0.0.44:22-10.0.0.1:60502.service - OpenSSH per-connection server daemon (10.0.0.1:60502). May 12 13:22:46.329643 sshd[1511]: Accepted publickey for core from 10.0.0.1 port 60502 ssh2: RSA SHA256:jEPoW5jmVqQGUqKP3XswdpHQkuwhsPJWJAB8YbEjhZ8 May 12 13:22:46.330796 sshd-session[1511]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) May 12 13:22:46.335469 systemd-logind[1393]: New session 2 of user core. May 12 13:22:46.349584 systemd[1]: Started session-2.scope - Session 2 of User core. May 12 13:22:46.400540 sshd[1513]: Connection closed by 10.0.0.1 port 60502 May 12 13:22:46.400967 sshd-session[1511]: pam_unix(sshd:session): session closed for user core May 12 13:22:46.414542 systemd[1]: sshd@1-10.0.0.44:22-10.0.0.1:60502.service: Deactivated successfully. May 12 13:22:46.417927 systemd[1]: session-2.scope: Deactivated successfully. May 12 13:22:46.419481 systemd-logind[1393]: Session 2 logged out. Waiting for processes to exit. May 12 13:22:46.420776 systemd[1]: Started sshd@2-10.0.0.44:22-10.0.0.1:60512.service - OpenSSH per-connection server daemon (10.0.0.1:60512). May 12 13:22:46.422236 systemd-logind[1393]: Removed session 2. May 12 13:22:46.461795 sshd[1518]: Accepted publickey for core from 10.0.0.1 port 60512 ssh2: RSA SHA256:jEPoW5jmVqQGUqKP3XswdpHQkuwhsPJWJAB8YbEjhZ8 May 12 13:22:46.462927 sshd-session[1518]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) May 12 13:22:46.468191 systemd-logind[1393]: New session 3 of user core. May 12 13:22:46.482777 systemd[1]: Started session-3.scope - Session 3 of User core. May 12 13:22:46.529728 sshd[1521]: Connection closed by 10.0.0.1 port 60512 May 12 13:22:46.530082 sshd-session[1518]: pam_unix(sshd:session): session closed for user core May 12 13:22:46.539300 systemd[1]: sshd@2-10.0.0.44:22-10.0.0.1:60512.service: Deactivated successfully. May 12 13:22:46.540752 systemd[1]: session-3.scope: Deactivated successfully. May 12 13:22:46.542004 systemd-logind[1393]: Session 3 logged out. Waiting for processes to exit. May 12 13:22:46.543040 systemd[1]: Started sshd@3-10.0.0.44:22-10.0.0.1:60528.service - OpenSSH per-connection server daemon (10.0.0.1:60528). May 12 13:22:46.543955 systemd-logind[1393]: Removed session 3. May 12 13:22:46.584104 sshd[1526]: Accepted publickey for core from 10.0.0.1 port 60528 ssh2: RSA SHA256:jEPoW5jmVqQGUqKP3XswdpHQkuwhsPJWJAB8YbEjhZ8 May 12 13:22:46.585135 sshd-session[1526]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) May 12 13:22:46.589300 systemd-logind[1393]: New session 4 of user core. May 12 13:22:46.603551 systemd[1]: Started session-4.scope - Session 4 of User core. May 12 13:22:46.653134 sshd[1529]: Connection closed by 10.0.0.1 port 60528 May 12 13:22:46.653481 sshd-session[1526]: pam_unix(sshd:session): session closed for user core May 12 13:22:46.666349 systemd[1]: sshd@3-10.0.0.44:22-10.0.0.1:60528.service: Deactivated successfully. May 12 13:22:46.668523 systemd[1]: session-4.scope: Deactivated successfully. May 12 13:22:46.669957 systemd-logind[1393]: Session 4 logged out. Waiting for processes to exit. May 12 13:22:46.671492 systemd[1]: Started sshd@4-10.0.0.44:22-10.0.0.1:60534.service - OpenSSH per-connection server daemon (10.0.0.1:60534). May 12 13:22:46.672314 systemd-logind[1393]: Removed session 4. May 12 13:22:46.721136 sshd[1534]: Accepted publickey for core from 10.0.0.1 port 60534 ssh2: RSA SHA256:jEPoW5jmVqQGUqKP3XswdpHQkuwhsPJWJAB8YbEjhZ8 May 12 13:22:46.722191 sshd-session[1534]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) May 12 13:22:46.726746 systemd-logind[1393]: New session 5 of user core. May 12 13:22:46.732642 systemd[1]: Started session-5.scope - Session 5 of User core. May 12 13:22:46.791576 sudo[1538]: core : PWD=/home/core ; USER=root ; COMMAND=/usr/sbin/setenforce 1 May 12 13:22:46.791851 sudo[1538]: pam_unix(sudo:session): session opened for user root(uid=0) by core(uid=500) May 12 13:22:46.804287 sudo[1538]: pam_unix(sudo:session): session closed for user root May 12 13:22:46.805928 sshd[1537]: Connection closed by 10.0.0.1 port 60534 May 12 13:22:46.806475 sshd-session[1534]: pam_unix(sshd:session): session closed for user core May 12 13:22:46.826357 systemd[1]: sshd@4-10.0.0.44:22-10.0.0.1:60534.service: Deactivated successfully. May 12 13:22:46.828005 systemd[1]: session-5.scope: Deactivated successfully. May 12 13:22:46.829466 systemd-logind[1393]: Session 5 logged out. Waiting for processes to exit. May 12 13:22:46.830723 systemd[1]: Started sshd@5-10.0.0.44:22-10.0.0.1:60542.service - OpenSSH per-connection server daemon (10.0.0.1:60542). May 12 13:22:46.832164 systemd-logind[1393]: Removed session 5. May 12 13:22:46.880368 sshd[1543]: Accepted publickey for core from 10.0.0.1 port 60542 ssh2: RSA SHA256:jEPoW5jmVqQGUqKP3XswdpHQkuwhsPJWJAB8YbEjhZ8 May 12 13:22:46.881491 sshd-session[1543]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) May 12 13:22:46.887147 systemd-logind[1393]: New session 6 of user core. May 12 13:22:46.896579 systemd[1]: Started session-6.scope - Session 6 of User core. May 12 13:22:46.946064 sudo[1548]: core : PWD=/home/core ; USER=root ; COMMAND=/usr/sbin/rm -rf /etc/audit/rules.d/80-selinux.rules /etc/audit/rules.d/99-default.rules May 12 13:22:46.946316 sudo[1548]: pam_unix(sudo:session): session opened for user root(uid=0) by core(uid=500) May 12 13:22:46.949163 sudo[1548]: pam_unix(sudo:session): session closed for user root May 12 13:22:46.953500 sudo[1547]: core : PWD=/home/core ; USER=root ; COMMAND=/usr/sbin/systemctl restart audit-rules May 12 13:22:46.953744 sudo[1547]: pam_unix(sudo:session): session opened for user root(uid=0) by core(uid=500) May 12 13:22:46.961788 systemd[1]: Starting audit-rules.service - Load Audit Rules... May 12 13:22:46.996187 augenrules[1570]: No rules May 12 13:22:46.997636 systemd[1]: audit-rules.service: Deactivated successfully. May 12 13:22:46.997908 systemd[1]: Finished audit-rules.service - Load Audit Rules. May 12 13:22:46.998841 sudo[1547]: pam_unix(sudo:session): session closed for user root May 12 13:22:47.000098 sshd[1546]: Connection closed by 10.0.0.1 port 60542 May 12 13:22:47.000661 sshd-session[1543]: pam_unix(sshd:session): session closed for user core May 12 13:22:47.016683 systemd[1]: sshd@5-10.0.0.44:22-10.0.0.1:60542.service: Deactivated successfully. May 12 13:22:47.018359 systemd[1]: session-6.scope: Deactivated successfully. May 12 13:22:47.019717 systemd-logind[1393]: Session 6 logged out. Waiting for processes to exit. May 12 13:22:47.022025 systemd[1]: Started sshd@6-10.0.0.44:22-10.0.0.1:60558.service - OpenSSH per-connection server daemon (10.0.0.1:60558). May 12 13:22:47.023064 systemd-logind[1393]: Removed session 6. May 12 13:22:47.077123 sshd[1578]: Accepted publickey for core from 10.0.0.1 port 60558 ssh2: RSA SHA256:jEPoW5jmVqQGUqKP3XswdpHQkuwhsPJWJAB8YbEjhZ8 May 12 13:22:47.077758 sshd-session[1578]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) May 12 13:22:47.082504 systemd-logind[1393]: New session 7 of user core. May 12 13:22:47.091614 systemd[1]: Started session-7.scope - Session 7 of User core. May 12 13:22:47.138998 sshd[1581]: Connection closed by 10.0.0.1 port 60558 May 12 13:22:47.139330 sshd-session[1578]: pam_unix(sshd:session): session closed for user core May 12 13:22:47.149398 systemd[1]: sshd@6-10.0.0.44:22-10.0.0.1:60558.service: Deactivated successfully. May 12 13:22:47.150908 systemd[1]: session-7.scope: Deactivated successfully. May 12 13:22:47.153030 systemd-logind[1393]: Session 7 logged out. Waiting for processes to exit. May 12 13:22:47.154703 systemd[1]: Started sshd@7-10.0.0.44:22-10.0.0.1:60572.service - OpenSSH per-connection server daemon (10.0.0.1:60572). May 12 13:22:47.155566 systemd-logind[1393]: Removed session 7. May 12 13:22:47.213529 sshd[1587]: Accepted publickey for core from 10.0.0.1 port 60572 ssh2: RSA SHA256:jEPoW5jmVqQGUqKP3XswdpHQkuwhsPJWJAB8YbEjhZ8 May 12 13:22:47.214648 sshd-session[1587]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) May 12 13:22:47.219378 systemd-logind[1393]: New session 8 of user core. May 12 13:22:47.230560 systemd[1]: Started session-8.scope - Session 8 of User core. May 12 13:22:47.703503 sshd[1590]: Connection closed by 10.0.0.1 port 60572 May 12 13:22:47.703620 sshd-session[1587]: pam_unix(sshd:session): session closed for user core May 12 13:22:47.720340 systemd[1]: sshd@7-10.0.0.44:22-10.0.0.1:60572.service: Deactivated successfully. May 12 13:22:47.721664 systemd[1]: session-8.scope: Deactivated successfully. May 12 13:22:47.722889 systemd-logind[1393]: Session 8 logged out. Waiting for processes to exit. May 12 13:22:47.723867 systemd[1]: Started sshd@8-10.0.0.44:22-10.0.0.1:60584.service - OpenSSH per-connection server daemon (10.0.0.1:60584). May 12 13:22:47.724784 systemd-logind[1393]: Removed session 8. May 12 13:22:47.770293 sshd[1604]: Accepted publickey for core from 10.0.0.1 port 60584 ssh2: RSA SHA256:jEPoW5jmVqQGUqKP3XswdpHQkuwhsPJWJAB8YbEjhZ8 May 12 13:22:47.771343 sshd-session[1604]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) May 12 13:22:47.775952 systemd-logind[1393]: New session 9 of user core. May 12 13:22:47.788634 systemd[1]: Started session-9.scope - Session 9 of User core. May 12 13:22:51.810370 sudo[1608]: core : PWD=/home/core ; USER=root ; COMMAND=/usr/sbin/mv docker.raw containerd.raw /etc/extensions/ May 12 13:22:51.810650 sudo[1608]: pam_unix(sudo:session): session opened for user root(uid=0) by core(uid=500) May 12 13:22:51.981471 sudo[1608]: pam_unix(sudo:session): session closed for user root May 12 13:22:51.983072 sshd[1607]: Connection closed by 10.0.0.1 port 60584 May 12 13:22:51.983544 sshd-session[1604]: pam_unix(sshd:session): session closed for user core May 12 13:22:51.996471 systemd[1]: sshd@8-10.0.0.44:22-10.0.0.1:60584.service: Deactivated successfully. May 12 13:22:51.997746 systemd[1]: session-9.scope: Deactivated successfully. May 12 13:22:51.998495 systemd[1]: session-9.scope: Consumed 3.601s CPU time, 397.3M memory peak. May 12 13:22:51.999096 systemd-logind[1393]: Session 9 logged out. Waiting for processes to exit. May 12 13:22:52.002245 systemd[1]: Started sshd@9-10.0.0.44:22-10.0.0.1:60586.service - OpenSSH per-connection server daemon (10.0.0.1:60586). May 12 13:22:52.003063 systemd-logind[1393]: Removed session 9. May 12 13:22:52.050928 sshd[1666]: Accepted publickey for core from 10.0.0.1 port 60586 ssh2: RSA SHA256:jEPoW5jmVqQGUqKP3XswdpHQkuwhsPJWJAB8YbEjhZ8 May 12 13:22:52.051932 sshd-session[1666]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) May 12 13:22:52.055741 systemd-logind[1393]: New session 10 of user core. May 12 13:22:52.066546 systemd[1]: Started session-10.scope - Session 10 of User core. May 12 13:22:52.115886 sudo[1670]: core : PWD=/home/core ; USER=root ; COMMAND=/usr/sbin/systemctl restart systemd-sysext May 12 13:22:52.116116 sudo[1670]: pam_unix(sudo:session): session opened for user root(uid=0) by core(uid=500) May 12 13:22:52.122961 systemd[1]: ensure-sysext.service: Deactivated successfully. May 12 13:22:52.123126 systemd[1]: Stopped ensure-sysext.service. May 12 13:22:52.123171 systemd[1]: Stopping ensure-sysext.service... May 12 13:22:52.124022 systemd[1]: Stopping systemd-sysext.service - Merge System Extension Images into /usr/ and /opt/... May 12 13:22:52.135985 systemd[1]: systemd-sysext.service: Deactivated successfully. May 12 13:22:52.136161 systemd[1]: Stopped systemd-sysext.service - Merge System Extension Images into /usr/ and /opt/. May 12 13:22:52.137682 systemd[1]: Starting systemd-sysext.service - Merge System Extension Images into /usr/ and /opt/... May 12 13:22:52.144449 kernel: loop0: detected capacity change from 0 to 315600 May 12 13:22:52.154853 kernel: EXT4-fs (loop0): write access unavailable, skipping orphan cleanup May 12 13:22:52.154916 kernel: EXT4-fs (loop0): mounted filesystem a296d181-9817-4d73-97cb-93b0cc10f674 ro without journal. Quota mode: none. May 12 13:22:52.158439 kernel: EXT4-fs (loop0): unmounting filesystem a296d181-9817-4d73-97cb-93b0cc10f674. May 12 13:22:52.197458 kernel: loop1: detected capacity change from 0 to 301296 May 12 13:22:52.209485 kernel: EXT4-fs (loop1): write access unavailable, skipping orphan cleanup May 12 13:22:52.209519 kernel: EXT4-fs (loop1): mounted filesystem 6de35f4d-4722-4f06-b152-e59a88382c74 ro without journal. Quota mode: none. May 12 13:22:52.213459 kernel: EXT4-fs (loop1): unmounting filesystem 6de35f4d-4722-4f06-b152-e59a88382c74. May 12 13:22:52.244480 kernel: loop2: detected capacity change from 0 to 315600 May 12 13:22:52.254401 kernel: EXT4-fs (loop2): write access unavailable, skipping orphan cleanup May 12 13:22:52.254462 kernel: EXT4-fs (loop2): mounted filesystem a296d181-9817-4d73-97cb-93b0cc10f674 ro without journal. Quota mode: none. May 12 13:22:52.256448 kernel: loop3: detected capacity change from 0 to 301296 May 12 13:22:52.266269 kernel: EXT4-fs (loop3): write access unavailable, skipping orphan cleanup May 12 13:22:52.266296 kernel: EXT4-fs (loop3): mounted filesystem 6de35f4d-4722-4f06-b152-e59a88382c74 ro without journal. Quota mode: none. May 12 13:22:52.266858 (sd-merge)[1681]: Using extensions 'containerd', 'docker'. May 12 13:22:52.267296 (sd-merge)[1681]: Merged extensions into '/usr'. May 12 13:22:52.269652 systemd[1]: Finished systemd-sysext.service - Merge System Extension Images into /usr/ and /opt/. May 12 13:22:52.270604 sudo[1670]: pam_unix(sudo:session): session closed for user root May 12 13:22:52.272475 sshd[1669]: Connection closed by 10.0.0.1 port 60586 May 12 13:22:52.272702 sshd-session[1666]: pam_unix(sshd:session): session closed for user core May 12 13:22:52.273183 systemd[1]: Starting ensure-sysext.service... May 12 13:22:52.291469 systemd[1]: sshd@9-10.0.0.44:22-10.0.0.1:60586.service: Deactivated successfully. May 12 13:22:52.292883 systemd[1]: session-10.scope: Deactivated successfully. May 12 13:22:52.296022 systemd-logind[1393]: Session 10 logged out. Waiting for processes to exit. May 12 13:22:52.297088 systemd[1]: Started sshd@10-10.0.0.44:22-10.0.0.1:60596.service - OpenSSH per-connection server daemon (10.0.0.1:60596). May 12 13:22:52.297548 systemd[1]: Reload requested from client PID 1685 ('systemctl') (unit ensure-sysext.service)... May 12 13:22:52.297565 systemd[1]: Reloading... May 12 13:22:52.349654 zram_generator::config[1730]: No configuration found. May 12 13:22:52.484361 systemd[1]: /usr/lib/systemd/system/docker.socket:5: ListenStream= references a path below legacy directory /var/run/, updating /var/run/docker.sock → /run/docker.sock; please update the unit file accordingly. May 12 13:22:52.565994 systemd[1]: Reloading finished in 268 ms. May 12 13:22:52.621979 systemd-logind[1393]: Removed session 10. May 12 13:22:52.627588 systemd[1]: Stopped target sockets.target - Socket Units. May 12 13:22:52.627610 systemd[1]: Stopping sockets.target - Socket Units... May 12 13:22:52.627677 systemd[1]: Stopped target timers.target - Timer Units. May 12 13:22:52.627685 systemd[1]: Stopping timers.target - Timer Units... May 12 13:22:52.627753 systemd[1]: Reached target timers.target - Timer Units. May 12 13:22:52.629202 systemd[1]: Starting docker.socket - Docker Socket for the API... May 12 13:22:52.639559 systemd[1]: Starting containerd.service - containerd container runtime... May 12 13:22:52.640003 systemd[1]: Listening on docker.socket - Docker Socket for the API. May 12 13:22:52.642198 systemd[1]: Stopped target multi-user.target - Multi-User System. May 12 13:22:52.642217 systemd[1]: Stopping multi-user.target - Multi-User System... May 12 13:22:52.642253 systemd[1]: update-engine-stub.timer - Update Engine Stub Timer was skipped because of an unmet condition check (ConditionPathExists=/usr/.noupdate). May 12 13:22:52.642411 systemd[1]: Reached target sockets.target - Socket Units. May 12 13:22:52.643608 systemd[1]: Starting audit-rules.service - Load Audit Rules... May 12 13:22:52.644792 systemd[1]: Starting coreos-metadata.service - QEMU metadata agent... May 12 13:22:52.645798 systemd[1]: Starting enable-oem-cloudinit.service - Enable cloudinit... May 12 13:22:52.649660 systemd[1]: Starting extend-filesystems.service - Extend Filesystems... May 12 13:22:52.650627 systemd[1]: Starting issuegen.service - Generate /run/issue... May 12 13:22:52.652476 jq[1769]: false May 12 13:22:52.652916 systemd[1]: Starting motdgen.service - Generate /run/flatcar/motd... May 12 13:22:52.654717 systemd[1]: Starting ssh-key-proc-cmdline.service - Install an ssh key from /proc/cmdline... May 12 13:22:52.654911 systemd[1]: sshkeys.service was skipped because no trigger condition checks were met. May 12 13:22:52.655044 systemd[1]: tcsd.service - TCG Core Services Daemon was skipped because of an unmet condition check (ConditionPathExists=/dev/tpm0). May 12 13:22:52.659764 systemd[1]: enable-oem-cloudinit.service: Skipped due to 'exec-condition'. May 12 13:22:52.661461 systemd[1]: Condition check resulted in enable-oem-cloudinit.service - Enable cloudinit being skipped. May 12 13:22:52.668999 extend-filesystems[1770]: Found loop2 May 12 13:22:52.670091 extend-filesystems[1770]: Found loop3 May 12 13:22:52.670091 extend-filesystems[1770]: Found vda May 12 13:22:52.670091 extend-filesystems[1770]: Found vda1 May 12 13:22:52.670091 extend-filesystems[1770]: Found vda2 May 12 13:22:52.670091 extend-filesystems[1770]: Found vda3 May 12 13:22:52.670091 extend-filesystems[1770]: Found usr May 12 13:22:52.670091 extend-filesystems[1770]: Found vda4 May 12 13:22:52.670091 extend-filesystems[1770]: Found vda6 May 12 13:22:52.670091 extend-filesystems[1770]: Found vda7 May 12 13:22:52.670091 extend-filesystems[1770]: Found vda9 May 12 13:22:52.670091 extend-filesystems[1770]: Checking size of /dev/vda9 May 12 13:22:52.682337 augenrules[1767]: /sbin/augenrules: No change May 12 13:22:52.669338 systemd[1]: issuegen.service: Deactivated successfully. May 12 13:22:52.669534 systemd[1]: Finished issuegen.service - Generate /run/issue. May 12 13:22:52.674855 systemd[1]: Finished ensure-sysext.service. May 12 13:22:52.679078 systemd[1]: motdgen.service: Deactivated successfully. May 12 13:22:52.680436 systemd[1]: Finished motdgen.service - Generate /run/flatcar/motd. May 12 13:22:52.682797 systemd[1]: ssh-key-proc-cmdline.service: Deactivated successfully. May 12 13:22:52.682956 systemd[1]: Finished ssh-key-proc-cmdline.service - Install an ssh key from /proc/cmdline. May 12 13:22:52.683942 systemd[1]: Started containerd.service - containerd container runtime. May 12 13:22:52.686575 augenrules[1804]: No rules May 12 13:22:52.688080 systemd[1]: audit-rules.service: Deactivated successfully. May 12 13:22:52.688277 systemd[1]: Finished audit-rules.service - Load Audit Rules. May 12 13:22:52.697939 extend-filesystems[1770]: Old size kept for /dev/vda9 May 12 13:22:52.704154 systemd[1]: extend-filesystems.service: Deactivated successfully. May 12 13:22:52.704359 systemd[1]: Finished extend-filesystems.service - Extend Filesystems. May 12 13:22:52.704945 systemd[1]: coreos-metadata.service: Deactivated successfully. May 12 13:22:52.705106 systemd[1]: Finished coreos-metadata.service - QEMU metadata agent. May 12 13:22:52.707497 kernel: BTRFS warning: duplicate device /dev/vda3 devid 1 generation 42 scanned by (udev-worker) (1815) May 12 13:22:52.729017 systemd[1]: packet-phone-home.service - Report Success to Packet was skipped because of an unmet condition check (ConditionFirstBoot=true). May 12 13:22:52.729308 systemd[1]: Reached target multi-user.target - Multi-User System. May 12 13:22:52.780265 sshd[1689]: Accepted publickey for core from 10.0.0.1 port 60596 ssh2: RSA SHA256:jEPoW5jmVqQGUqKP3XswdpHQkuwhsPJWJAB8YbEjhZ8 May 12 13:22:52.781698 sshd-session[1689]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) May 12 13:22:52.787171 systemd-logind[1393]: New session 11 of user core. May 12 13:22:52.792570 systemd[1]: Started session-11.scope - Session 11 of User core. May 12 13:22:52.893915 containerd[1805]: time="2025-05-12T13:22:52.891104015Z" level=info msg="starting containerd" revision=1c90a442489720eec95342e1789ee8a5e1b9536f version=v1.6.9 May 12 13:22:52.911108 containerd[1805]: time="2025-05-12T13:22:52.911061849Z" level=info msg="loading plugin \"io.containerd.content.v1.content\"..." type=io.containerd.content.v1 May 12 13:22:52.911368 containerd[1805]: time="2025-05-12T13:22:52.911212463Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.aufs\"..." type=io.containerd.snapshotter.v1 May 12 13:22:52.914258 containerd[1805]: time="2025-05-12T13:22:52.913171044Z" 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.89-flatcar\\n\"): skip plugin" type=io.containerd.snapshotter.v1 May 12 13:22:52.914258 containerd[1805]: time="2025-05-12T13:22:52.913975436Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.btrfs\"..." type=io.containerd.snapshotter.v1 May 12 13:22:52.914258 containerd[1805]: time="2025-05-12T13:22:52.914248090Z" 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 May 12 13:22:52.914346 containerd[1805]: time="2025-05-12T13:22:52.914266887Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.devmapper\"..." type=io.containerd.snapshotter.v1 May 12 13:22:52.914346 containerd[1805]: time="2025-05-12T13:22:52.914280935Z" level=warning msg="failed to load plugin io.containerd.snapshotter.v1.devmapper" error="devmapper not configured" May 12 13:22:52.914346 containerd[1805]: time="2025-05-12T13:22:52.914294703Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.native\"..." type=io.containerd.snapshotter.v1 May 12 13:22:52.914411 containerd[1805]: time="2025-05-12T13:22:52.914367256Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.overlayfs\"..." type=io.containerd.snapshotter.v1 May 12 13:22:52.914638 containerd[1805]: time="2025-05-12T13:22:52.914603593Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.zfs\"..." type=io.containerd.snapshotter.v1 May 12 13:22:52.915138 containerd[1805]: time="2025-05-12T13:22:52.915101929Z" 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 May 12 13:22:52.915138 containerd[1805]: time="2025-05-12T13:22:52.915130503Z" level=info msg="loading plugin \"io.containerd.metadata.v1.bolt\"..." type=io.containerd.metadata.v1 May 12 13:22:52.915211 containerd[1805]: time="2025-05-12T13:22:52.915193798Z" level=warning msg="could not use snapshotter devmapper in metadata plugin" error="devmapper not configured" May 12 13:22:52.915242 containerd[1805]: time="2025-05-12T13:22:52.915211677Z" level=info msg="metadata content store policy set" policy=shared May 12 13:22:52.918854 containerd[1805]: time="2025-05-12T13:22:52.918826373Z" level=info msg="loading plugin \"io.containerd.differ.v1.walking\"..." type=io.containerd.differ.v1 May 12 13:22:52.918906 containerd[1805]: time="2025-05-12T13:22:52.918859776Z" level=info msg="loading plugin \"io.containerd.event.v1.exchange\"..." type=io.containerd.event.v1 May 12 13:22:52.918906 containerd[1805]: time="2025-05-12T13:22:52.918873345Z" level=info msg="loading plugin \"io.containerd.gc.v1.scheduler\"..." type=io.containerd.gc.v1 May 12 13:22:52.918940 containerd[1805]: time="2025-05-12T13:22:52.918927221Z" level=info msg="loading plugin \"io.containerd.service.v1.introspection-service\"..." type=io.containerd.service.v1 May 12 13:22:52.918958 containerd[1805]: time="2025-05-12T13:22:52.918941988Z" level=info msg="loading plugin \"io.containerd.service.v1.containers-service\"..." type=io.containerd.service.v1 May 12 13:22:52.918977 containerd[1805]: time="2025-05-12T13:22:52.918956474Z" level=info msg="loading plugin \"io.containerd.service.v1.content-service\"..." type=io.containerd.service.v1 May 12 13:22:52.918977 containerd[1805]: time="2025-05-12T13:22:52.918970003Z" level=info msg="loading plugin \"io.containerd.service.v1.diff-service\"..." type=io.containerd.service.v1 May 12 13:22:52.919344 containerd[1805]: time="2025-05-12T13:22:52.919324828Z" level=info msg="loading plugin \"io.containerd.service.v1.images-service\"..." type=io.containerd.service.v1 May 12 13:22:52.919371 containerd[1805]: time="2025-05-12T13:22:52.919348613Z" level=info msg="loading plugin \"io.containerd.service.v1.leases-service\"..." type=io.containerd.service.v1 May 12 13:22:52.919371 containerd[1805]: time="2025-05-12T13:22:52.919361823Z" level=info msg="loading plugin \"io.containerd.service.v1.namespaces-service\"..." type=io.containerd.service.v1 May 12 13:22:52.919405 containerd[1805]: time="2025-05-12T13:22:52.919374594Z" level=info msg="loading plugin \"io.containerd.service.v1.snapshots-service\"..." type=io.containerd.service.v1 May 12 13:22:52.919405 containerd[1805]: time="2025-05-12T13:22:52.919387125Z" level=info msg="loading plugin \"io.containerd.runtime.v1.linux\"..." type=io.containerd.runtime.v1 May 12 13:22:52.919539 containerd[1805]: time="2025-05-12T13:22:52.919518064Z" level=info msg="loading plugin \"io.containerd.runtime.v2.task\"..." type=io.containerd.runtime.v2 May 12 13:22:52.919611 containerd[1805]: time="2025-05-12T13:22:52.919597881Z" level=info msg="loading plugin \"io.containerd.monitor.v1.cgroups\"..." type=io.containerd.monitor.v1 May 12 13:22:52.920033 containerd[1805]: time="2025-05-12T13:22:52.920011491Z" level=info msg="loading plugin \"io.containerd.service.v1.tasks-service\"..." type=io.containerd.service.v1 May 12 13:22:52.920056 containerd[1805]: time="2025-05-12T13:22:52.920046171Z" level=info msg="loading plugin \"io.containerd.grpc.v1.introspection\"..." type=io.containerd.grpc.v1 May 12 13:22:52.920074 containerd[1805]: time="2025-05-12T13:22:52.920059580Z" level=info msg="loading plugin \"io.containerd.internal.v1.restart\"..." type=io.containerd.internal.v1 May 12 13:22:52.920230 containerd[1805]: time="2025-05-12T13:22:52.920218495Z" level=info msg="loading plugin \"io.containerd.grpc.v1.containers\"..." type=io.containerd.grpc.v1 May 12 13:22:52.920249 containerd[1805]: time="2025-05-12T13:22:52.920234658Z" level=info msg="loading plugin \"io.containerd.grpc.v1.content\"..." type=io.containerd.grpc.v1 May 12 13:22:52.920273 containerd[1805]: time="2025-05-12T13:22:52.920247309Z" level=info msg="loading plugin \"io.containerd.grpc.v1.diff\"..." type=io.containerd.grpc.v1 May 12 13:22:52.920273 containerd[1805]: time="2025-05-12T13:22:52.920259920Z" level=info msg="loading plugin \"io.containerd.grpc.v1.events\"..." type=io.containerd.grpc.v1 May 12 13:22:52.920306 containerd[1805]: time="2025-05-12T13:22:52.920271933Z" level=info msg="loading plugin \"io.containerd.grpc.v1.healthcheck\"..." type=io.containerd.grpc.v1 May 12 13:22:52.920306 containerd[1805]: time="2025-05-12T13:22:52.920284544Z" level=info msg="loading plugin \"io.containerd.grpc.v1.images\"..." type=io.containerd.grpc.v1 May 12 13:22:52.920337 containerd[1805]: time="2025-05-12T13:22:52.920307132Z" level=info msg="loading plugin \"io.containerd.grpc.v1.leases\"..." type=io.containerd.grpc.v1 May 12 13:22:52.920337 containerd[1805]: time="2025-05-12T13:22:52.920319783Z" level=info msg="loading plugin \"io.containerd.grpc.v1.namespaces\"..." type=io.containerd.grpc.v1 May 12 13:22:52.920337 containerd[1805]: time="2025-05-12T13:22:52.920332394Z" level=info msg="loading plugin \"io.containerd.internal.v1.opt\"..." type=io.containerd.internal.v1 May 12 13:22:52.920500 containerd[1805]: time="2025-05-12T13:22:52.920483367Z" level=info msg="loading plugin \"io.containerd.grpc.v1.snapshots\"..." type=io.containerd.grpc.v1 May 12 13:22:52.920521 containerd[1805]: time="2025-05-12T13:22:52.920505037Z" level=info msg="loading plugin \"io.containerd.grpc.v1.tasks\"..." type=io.containerd.grpc.v1 May 12 13:22:52.920538 containerd[1805]: time="2025-05-12T13:22:52.920518965Z" level=info msg="loading plugin \"io.containerd.grpc.v1.version\"..." type=io.containerd.grpc.v1 May 12 13:22:52.920538 containerd[1805]: time="2025-05-12T13:22:52.920532733Z" level=info msg="loading plugin \"io.containerd.tracing.processor.v1.otlp\"..." type=io.containerd.tracing.processor.v1 May 12 13:22:52.920578 containerd[1805]: time="2025-05-12T13:22:52.920546542Z" level=info msg="skip loading plugin \"io.containerd.tracing.processor.v1.otlp\"..." error="no OpenTelemetry endpoint: skip plugin" type=io.containerd.tracing.processor.v1 May 12 13:22:52.920578 containerd[1805]: time="2025-05-12T13:22:52.920557636Z" level=info msg="loading plugin \"io.containerd.internal.v1.tracing\"..." type=io.containerd.internal.v1 May 12 13:22:52.920616 containerd[1805]: time="2025-05-12T13:22:52.920579346Z" level=error msg="failed to initialize a tracing processor \"otlp\"" error="no OpenTelemetry endpoint: skip plugin" May 12 13:22:52.920616 containerd[1805]: time="2025-05-12T13:22:52.920612550Z" level=info msg="loading plugin \"io.containerd.grpc.v1.cri\"..." type=io.containerd.grpc.v1 May 12 13:22:52.921130 containerd[1805]: time="2025-05-12T13:22:52.921074569Z" 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 BaseRuntimeSpec: NetworkPluginConfDir: NetworkPluginMaxConfNum:0} UntrustedWorkloadRuntime:{Type: Path: Engine: PodAnnotations:[] ContainerAnnotations:[] Root: Options:map[] PrivilegedWithoutHostDevices:false BaseRuntimeSpec: NetworkPluginConfDir: NetworkPluginMaxConfNum:0} Runtimes:map[runc:{Type:io.containerd.runc.v2 Path: Engine: PodAnnotations:[] ContainerAnnotations:[] Root: Options:map[SystemdCgroup:true] PrivilegedWithoutHostDevices:false BaseRuntimeSpec: NetworkPluginConfDir: NetworkPluginMaxConfNum:0}] NoPivot:false DisableSnapshotAnnotations:true DiscardUnpackedLayers:false IgnoreRdtNotEnabledErrors:false} CniConfig:{NetworkPluginBinDir:/opt/cni/bin NetworkPluginConfDir:/etc/cni/net.d NetworkPluginMaxConfNum:1 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:false SelinuxCategoryRange:1024 SandboxImage:registry.k8s.io/pause:3.6 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} 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}" May 12 13:22:52.921220 containerd[1805]: time="2025-05-12T13:22:52.921140577Z" level=info msg="Connect containerd service" May 12 13:22:52.921220 containerd[1805]: time="2025-05-12T13:22:52.921171506Z" level=info msg="Get image filesystem path \"/var/lib/containerd/io.containerd.snapshotter.v1.overlayfs\"" May 12 13:22:52.925786 containerd[1805]: time="2025-05-12T13:22:52.925738455Z" 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" May 12 13:22:52.926463 containerd[1805]: time="2025-05-12T13:22:52.926403328Z" level=info msg="Start subscribing containerd event" May 12 13:22:52.926496 containerd[1805]: time="2025-05-12T13:22:52.926481668Z" level=info msg="Start recovering state" May 12 13:22:52.926576 containerd[1805]: time="2025-05-12T13:22:52.926556137Z" level=info msg="Start event monitor" May 12 13:22:52.926741 containerd[1805]: time="2025-05-12T13:22:52.926711939Z" level=info msg="Start snapshots syncer" May 12 13:22:52.926741 containerd[1805]: time="2025-05-12T13:22:52.926736762Z" level=info msg="Start cni network conf syncer for default" May 12 13:22:52.926782 containerd[1805]: time="2025-05-12T13:22:52.926746101Z" level=info msg="Start streaming server" May 12 13:22:52.927080 containerd[1805]: time="2025-05-12T13:22:52.926903100Z" level=info msg=serving... address=/run/containerd/containerd.sock.ttrpc May 12 13:22:52.927080 containerd[1805]: time="2025-05-12T13:22:52.926981240Z" level=info msg=serving... address=/run/containerd/containerd.sock May 12 13:22:52.927080 containerd[1805]: time="2025-05-12T13:22:52.927008817Z" level=info msg="containerd successfully booted in 0.037523s" May 12 13:22:52.937028 systemd[1]: Starting docker.service - Docker Application Container Engine... May 12 13:22:52.950777 (dockerd)[1846]: docker.service: Referenced but unset environment variable evaluates to an empty string: DOCKER_CGROUPS, DOCKER_OPTS, DOCKER_OPT_BIP, DOCKER_OPT_IPMASQ, DOCKER_OPT_MTU May 12 13:22:53.180745 dockerd[1846]: time="2025-05-12T13:22:53.180690828Z" level=info msg="Starting up" May 12 13:22:53.185684 dockerd[1846]: time="2025-05-12T13:22:53.185655498Z" level=info msg="parsed scheme: \"unix\"" module=grpc May 12 13:22:53.185684 dockerd[1846]: time="2025-05-12T13:22:53.185681362Z" level=info msg="scheme \"unix\" not registered, fallback to default scheme" module=grpc May 12 13:22:53.185771 dockerd[1846]: time="2025-05-12T13:22:53.185701319Z" level=info msg="ccResolverWrapper: sending update to cc: {[{unix:///run/containerd/containerd.sock 0 }] }" module=grpc May 12 13:22:53.185771 dockerd[1846]: time="2025-05-12T13:22:53.185712216Z" level=info msg="ClientConn switching balancer to \"pick_first\"" module=grpc May 12 13:22:53.192652 dockerd[1846]: time="2025-05-12T13:22:53.192454937Z" level=info msg="parsed scheme: \"unix\"" module=grpc May 12 13:22:53.192652 dockerd[1846]: time="2025-05-12T13:22:53.192477688Z" level=info msg="scheme \"unix\" not registered, fallback to default scheme" module=grpc May 12 13:22:53.192652 dockerd[1846]: time="2025-05-12T13:22:53.192494452Z" level=info msg="ccResolverWrapper: sending update to cc: {[{unix:///run/containerd/containerd.sock 0 }] }" module=grpc May 12 13:22:53.192652 dockerd[1846]: time="2025-05-12T13:22:53.192504311Z" level=info msg="ClientConn switching balancer to \"pick_first\"" module=grpc May 12 13:22:53.351052 dockerd[1846]: time="2025-05-12T13:22:53.351010928Z" level=info msg="Loading containers: start." May 12 13:22:53.436474 kernel: Initializing XFRM netlink socket May 12 13:22:53.452468 dockerd[1846]: time="2025-05-12T13:22:53.452094472Z" level=info msg="Default bridge (docker0) is assigned with an IP address 172.17.0.0/16. Daemon option --bip can be used to set a preferred IP address" May 12 13:22:53.498732 systemd-networkd[1358]: docker0: Link UP May 12 13:22:53.523871 dockerd[1846]: time="2025-05-12T13:22:53.523819630Z" level=info msg="Loading containers: done." May 12 13:22:53.554183 systemd[1]: var-lib-docker-overlay2-opaque\x2dbug\x2dcheck1770664601-merged.mount: Deactivated successfully. May 12 13:22:53.555735 dockerd[1846]: time="2025-05-12T13:22:53.555692720Z" level=warning msg="Not using native diff for overlay2, this may cause degraded performance for building images: kernel has CONFIG_OVERLAY_FS_REDIRECT_DIR enabled" storage-driver=overlay2 May 12 13:22:53.555940 dockerd[1846]: time="2025-05-12T13:22:53.555916478Z" level=info msg="Docker daemon" commit=3056208 graphdriver(s)=overlay2 version=20.10.21 May 12 13:22:53.556033 dockerd[1846]: time="2025-05-12T13:22:53.556017980Z" level=info msg="Daemon has completed initialization" May 12 13:22:53.569530 systemd[1]: Started docker.service - Docker Application Container Engine. May 12 13:22:53.577045 dockerd[1846]: time="2025-05-12T13:22:53.576980243Z" level=info msg="API listen on /run/docker.sock" May 12 13:23:02.150708 systemd[1]: var-lib-docker-overlay2-16123d781e5929a6e944c4f741dac21b53f5de38cdee87075027b2562f3168e8\x2dinit-merged.mount: Deactivated successfully. May 12 13:23:02.180965 kernel: docker0: port 1(vethef3728e) entered blocking state May 12 13:23:02.181069 kernel: docker0: port 1(vethef3728e) entered disabled state May 12 13:23:02.181089 kernel: vethef3728e: entered allmulticast mode May 12 13:23:02.181105 kernel: vethef3728e: entered promiscuous mode May 12 13:23:02.181607 systemd-networkd[1358]: vethef3728e: Link UP May 12 13:23:02.238894 containerd[1805]: time="2025-05-12T13:23:02.238802638Z" level=info msg="loading plugin \"io.containerd.event.v1.publisher\"..." runtime=io.containerd.runc.v2 type=io.containerd.event.v1 May 12 13:23:02.238894 containerd[1805]: time="2025-05-12T13:23:02.238861607Z" level=info msg="loading plugin \"io.containerd.internal.v1.shutdown\"..." runtime=io.containerd.runc.v2 type=io.containerd.internal.v1 May 12 13:23:02.238894 containerd[1805]: time="2025-05-12T13:23:02.238872994Z" level=info msg="loading plugin \"io.containerd.ttrpc.v1.task\"..." runtime=io.containerd.runc.v2 type=io.containerd.ttrpc.v1 May 12 13:23:02.239393 containerd[1805]: time="2025-05-12T13:23:02.239057492Z" level=info msg="starting signal loop" namespace=moby path=/run/containerd/io.containerd.runtime.v2.task/moby/19152c0094ebaf8343d8e634e6e57241989d8f872efca9d61ee63f0b7012954d pid=1987 runtime=io.containerd.runc.v2 May 12 13:23:02.258634 systemd[1]: Started docker-19152c0094ebaf8343d8e634e6e57241989d8f872efca9d61ee63f0b7012954d.scope - libcontainer container 19152c0094ebaf8343d8e634e6e57241989d8f872efca9d61ee63f0b7012954d. May 12 13:23:02.330464 kernel: eth0: renamed from veth8617036 May 12 13:23:02.344526 kernel: docker0: port 1(vethef3728e) entered blocking state May 12 13:23:02.344593 kernel: docker0: port 1(vethef3728e) entered forwarding state May 12 13:23:02.344735 systemd-networkd[1358]: vethef3728e: Gained carrier May 12 13:23:02.345187 systemd-networkd[1358]: docker0: Gained carrier May 12 13:23:02.346513 systemd-resolved[1306]: Failed to determine the local hostname and LLMNR/mDNS names, ignoring: No such device or address May 12 13:23:02.367404 systemd[1]: docker-19152c0094ebaf8343d8e634e6e57241989d8f872efca9d61ee63f0b7012954d.scope: Deactivated successfully. May 12 13:23:02.378379 dockerd[1846]: time="2025-05-12T13:23:02.378053899Z" level=info msg="ignoring event" container=19152c0094ebaf8343d8e634e6e57241989d8f872efca9d61ee63f0b7012954d module=libcontainerd namespace=moby topic=/tasks/delete type="*events.TaskDelete" May 12 13:23:02.378650 containerd[1805]: time="2025-05-12T13:23:02.378055856Z" level=info msg="shim disconnected" id=19152c0094ebaf8343d8e634e6e57241989d8f872efca9d61ee63f0b7012954d May 12 13:23:02.378650 containerd[1805]: time="2025-05-12T13:23:02.378239316Z" level=warning msg="cleaning up after shim disconnected" id=19152c0094ebaf8343d8e634e6e57241989d8f872efca9d61ee63f0b7012954d namespace=moby May 12 13:23:02.378650 containerd[1805]: time="2025-05-12T13:23:02.378248704Z" level=info msg="cleaning up dead shim" May 12 13:23:02.383830 containerd[1805]: time="2025-05-12T13:23:02.383750683Z" level=warning msg="cleanup warnings time=\"2025-05-12T13:23:02Z\" level=info msg=\"starting signal loop\" namespace=moby pid=2040 runtime=io.containerd.runc.v2\n" May 12 13:23:02.387496 kernel: docker0: port 1(vethef3728e) entered disabled state May 12 13:23:02.387453 systemd-networkd[1358]: vethef3728e: Lost carrier May 12 13:23:02.388456 kernel: veth8617036: renamed from eth0 May 12 13:23:02.410971 systemd-networkd[1358]: vethef3728e: Link DOWN May 12 13:23:02.412997 kernel: docker0: port 1(vethef3728e) entered disabled state May 12 13:23:02.413035 kernel: vethef3728e (unregistering): left allmulticast mode May 12 13:23:02.413064 kernel: vethef3728e (unregistering): left promiscuous mode May 12 13:23:02.414459 kernel: docker0: port 1(vethef3728e) entered disabled state May 12 13:23:02.451702 sshd[1832]: Connection closed by 10.0.0.1 port 60596 May 12 13:23:02.452592 sshd-session[1689]: pam_unix(sshd:session): session closed for user core May 12 13:23:02.466453 systemd[1]: sshd@10-10.0.0.44:22-10.0.0.1:60596.service: Deactivated successfully. May 12 13:23:02.468061 systemd[1]: session-11.scope: Deactivated successfully. May 12 13:23:02.468688 systemd-logind[1393]: Session 11 logged out. Waiting for processes to exit. May 12 13:23:02.470289 systemd[1]: Started sshd@11-10.0.0.44:22-10.0.0.1:51808.service - OpenSSH per-connection server daemon (10.0.0.1:51808). May 12 13:23:02.471194 systemd-logind[1393]: Removed session 11. May 12 13:23:02.510025 sshd[2060]: Accepted publickey for core from 10.0.0.1 port 51808 ssh2: RSA SHA256:jEPoW5jmVqQGUqKP3XswdpHQkuwhsPJWJAB8YbEjhZ8 May 12 13:23:02.511028 sshd-session[2060]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) May 12 13:23:02.515445 systemd-logind[1393]: New session 12 of user core. May 12 13:23:02.529663 systemd[1]: Started session-12.scope - Session 12 of User core. May 12 13:23:02.593461 sshd[2063]: Connection closed by 10.0.0.1 port 51808 May 12 13:23:02.593755 sshd-session[2060]: pam_unix(sshd:session): session closed for user core May 12 13:23:02.609687 systemd[1]: Started sshd@12-10.0.0.44:22-10.0.0.1:33010.service - OpenSSH per-connection server daemon (10.0.0.1:33010). May 12 13:23:02.610096 systemd[1]: sshd@11-10.0.0.44:22-10.0.0.1:51808.service: Deactivated successfully. May 12 13:23:02.612648 systemd[1]: session-12.scope: Deactivated successfully. May 12 13:23:02.614037 systemd-logind[1393]: Session 12 logged out. Waiting for processes to exit. May 12 13:23:02.614987 systemd-logind[1393]: Removed session 12. May 12 13:23:02.649844 sshd[2069]: Accepted publickey for core from 10.0.0.1 port 33010 ssh2: RSA SHA256:jEPoW5jmVqQGUqKP3XswdpHQkuwhsPJWJAB8YbEjhZ8 May 12 13:23:02.650896 sshd-session[2069]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) May 12 13:23:02.654900 systemd-logind[1393]: New session 13 of user core. May 12 13:23:02.665588 systemd[1]: Started session-13.scope - Session 13 of User core. May 12 13:23:03.148379 systemd[1]: var-lib-docker-overlay2-16123d781e5929a6e944c4f741dac21b53f5de38cdee87075027b2562f3168e8-merged.mount: Deactivated successfully. May 12 13:23:03.183659 systemd-networkd[1358]: docker0: Lost carrier May 12 13:23:04.143555 systemd-networkd[1358]: docker0: Gained IPv6LL May 12 13:23:07.038659 sudo[2075]: core : PWD=/home/core ; USER=root ; COMMAND=/usr/sbin/mv docker.raw containerd.raw /etc/extensions/ May 12 13:23:07.038940 sudo[2075]: pam_unix(sudo:session): session opened for user root(uid=0) by core(uid=500) May 12 13:23:07.217705 sudo[2075]: pam_unix(sudo:session): session closed for user root May 12 13:23:07.219093 sshd[2074]: Connection closed by 10.0.0.1 port 33010 May 12 13:23:07.220325 sshd-session[2069]: pam_unix(sshd:session): session closed for user core May 12 13:23:07.230903 systemd[1]: Started sshd@13-10.0.0.44:22-10.0.0.1:33022.service - OpenSSH per-connection server daemon (10.0.0.1:33022). May 12 13:23:07.231316 systemd[1]: sshd@12-10.0.0.44:22-10.0.0.1:33010.service: Deactivated successfully. May 12 13:23:07.240687 systemd[1]: session-13.scope: Deactivated successfully. May 12 13:23:07.240890 systemd[1]: session-13.scope: Consumed 4.003s CPU time, 423.6M memory peak. May 12 13:23:07.242466 systemd-logind[1393]: Session 13 logged out. Waiting for processes to exit. May 12 13:23:07.243781 systemd-logind[1393]: Removed session 13. May 12 13:23:07.278588 sshd[2130]: Accepted publickey for core from 10.0.0.1 port 33022 ssh2: RSA SHA256:jEPoW5jmVqQGUqKP3XswdpHQkuwhsPJWJAB8YbEjhZ8 May 12 13:23:07.279877 sshd-session[2130]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) May 12 13:23:07.284493 systemd-logind[1393]: New session 14 of user core. May 12 13:23:07.292600 systemd[1]: Started session-14.scope - Session 14 of User core. May 12 13:23:07.343373 sudo[2137]: core : PWD=/home/core ; USER=root ; COMMAND=/usr/sbin/systemctl restart systemd-sysext May 12 13:23:07.343694 sudo[2137]: pam_unix(sudo:session): session opened for user root(uid=0) by core(uid=500) May 12 13:23:07.351060 systemd[1]: ensure-sysext.service: Deactivated successfully. May 12 13:23:07.351232 systemd[1]: Stopped ensure-sysext.service. May 12 13:23:07.351285 systemd[1]: Stopping ensure-sysext.service... May 12 13:23:07.352388 systemd[1]: Stopping systemd-sysext.service - Merge System Extension Images into /usr/ and /opt/... May 12 13:23:07.373598 systemd-sysext[2139]: Unmerged '/usr'. May 12 13:23:07.377315 systemd[1]: systemd-sysext.service: Deactivated successfully. May 12 13:23:07.377550 systemd[1]: Stopped systemd-sysext.service - Merge System Extension Images into /usr/ and /opt/. May 12 13:23:07.380078 systemd[1]: Starting systemd-sysext.service - Merge System Extension Images into /usr/ and /opt/... May 12 13:23:07.398688 kernel: loop4: detected capacity change from 0 to 338656 May 12 13:23:07.409116 kernel: EXT4-fs (loop4): write access unavailable, skipping orphan cleanup May 12 13:23:07.409188 kernel: EXT4-fs (loop4): mounted filesystem 2d238eae-8b57-4f2a-94ad-edc82d408e92 ro without journal. Quota mode: none. May 12 13:23:07.412482 kernel: EXT4-fs (loop4): unmounting filesystem 2d238eae-8b57-4f2a-94ad-edc82d408e92. May 12 13:23:07.443453 kernel: loop5: detected capacity change from 0 to 301296 May 12 13:23:07.454356 kernel: EXT4-fs (loop5): write access unavailable, skipping orphan cleanup May 12 13:23:07.454456 kernel: EXT4-fs (loop5): mounted filesystem d191274e-2fff-4069-8c3c-71aba5cec5c2 ro without journal. Quota mode: none. May 12 13:23:07.457462 kernel: EXT4-fs (loop5): unmounting filesystem d191274e-2fff-4069-8c3c-71aba5cec5c2. May 12 13:23:07.489457 kernel: loop6: detected capacity change from 0 to 338656 May 12 13:23:07.498376 kernel: EXT4-fs (loop6): write access unavailable, skipping orphan cleanup May 12 13:23:07.498446 kernel: EXT4-fs (loop6): mounted filesystem 2d238eae-8b57-4f2a-94ad-edc82d408e92 ro without journal. Quota mode: none. May 12 13:23:07.500449 kernel: loop7: detected capacity change from 0 to 301296 May 12 13:23:07.508646 kernel: EXT4-fs (loop7): write access unavailable, skipping orphan cleanup May 12 13:23:07.508743 kernel: EXT4-fs (loop7): mounted filesystem d191274e-2fff-4069-8c3c-71aba5cec5c2 ro without journal. Quota mode: none. May 12 13:23:07.509161 (sd-merge)[2148]: Using extensions 'containerd', 'docker'. May 12 13:23:07.509585 (sd-merge)[2148]: Merged extensions into '/usr'. May 12 13:23:07.512079 systemd[1]: Finished systemd-sysext.service - Merge System Extension Images into /usr/ and /opt/. May 12 13:23:07.513260 sudo[2137]: pam_unix(sudo:session): session closed for user root May 12 13:23:07.515000 systemd[1]: Starting ensure-sysext.service... May 12 13:23:07.521028 sudo[2136]: core : PWD=/home/core ; USER=root ; COMMAND=/usr/sbin/systemctl restart docker containerd May 12 13:23:07.521308 sudo[2136]: pam_unix(sudo:session): session opened for user root(uid=0) by core(uid=500) May 12 13:23:07.539953 systemd[1]: Reload requested from client PID 2152 ('systemctl') (unit ensure-sysext.service)... May 12 13:23:07.539969 systemd[1]: Reloading... May 12 13:23:07.605456 zram_generator::config[2196]: No configuration found. May 12 13:23:07.740043 systemd[1]: /usr/lib/systemd/system/docker.socket:5: ListenStream= references a path below legacy directory /var/run/, updating /var/run/docker.sock → /run/docker.sock; please update the unit file accordingly. May 12 13:23:07.825345 systemd[1]: Reloading finished in 285 ms. May 12 13:23:07.867264 systemd[1]: Stopped target sockets.target - Socket Units. May 12 13:23:07.867647 systemd[1]: Stopping sockets.target - Socket Units... May 12 13:23:07.867928 dockerd[1846]: time="2025-05-12T13:23:07.867873107Z" level=info msg="Processing signal 'terminated'" May 12 13:23:07.868229 systemd[1]: Stopping docker.service - Docker Application Container Engine... May 12 13:23:07.868688 dockerd[1846]: time="2025-05-12T13:23:07.868658303Z" level=info msg="Daemon shutdown complete" May 12 13:23:07.869553 systemd[1]: Stopped target timers.target - Timer Units. May 12 13:23:07.869677 systemd[1]: Stopping timers.target - Timer Units... May 12 13:23:07.869858 systemd[1]: Reached target timers.target - Timer Units. May 12 13:23:07.873258 systemd[1]: docker.service: Deactivated successfully. May 12 13:23:07.873642 systemd[1]: Stopped docker.service - Docker Application Container Engine. May 12 13:23:07.873774 systemd[1]: docker.service: Consumed 517ms CPU time, 98.3M memory peak. May 12 13:23:07.874838 systemd[1]: Stopped target multi-user.target - Multi-User System. May 12 13:23:07.874874 systemd[1]: Stopping multi-user.target - Multi-User System... May 12 13:23:07.874917 systemd[1]: update-engine-stub.timer - Update Engine Stub Timer was skipped because of an unmet condition check (ConditionPathExists=/usr/.noupdate). May 12 13:23:07.875179 systemd[1]: docker.socket: Deactivated successfully. May 12 13:23:07.875609 systemd[1]: Closed docker.socket - Docker Socket for the API. May 12 13:23:07.875650 systemd[1]: Stopping docker.socket - Docker Socket for the API... May 12 13:23:07.877124 systemd[1]: Starting docker.socket - Docker Socket for the API... May 12 13:23:07.888660 systemd[1]: Starting audit-rules.service - Load Audit Rules... May 12 13:23:07.889759 containerd[1805]: time="2025-05-12T13:23:07.888909140Z" level=info msg="Stop CRI service" May 12 13:23:07.888862 systemd[1]: Stopping containerd.service - containerd container runtime... May 12 13:23:07.891458 systemd[1]: Starting coreos-metadata.service - QEMU metadata agent... May 12 13:23:07.892583 systemd[1]: Starting enable-oem-cloudinit.service - Enable cloudinit... May 12 13:23:07.895715 systemd[1]: Starting extend-filesystems.service - Extend Filesystems... May 12 13:23:07.899706 systemd[1]: Starting issuegen.service - Generate /run/issue... May 12 13:23:07.900809 systemd[1]: Starting motdgen.service - Generate /run/flatcar/motd... May 12 13:23:07.901825 jq[2234]: false May 12 13:23:07.902691 systemd[1]: Starting ssh-key-proc-cmdline.service - Install an ssh key from /proc/cmdline... May 12 13:23:07.902890 systemd[1]: sshkeys.service was skipped because no trigger condition checks were met. May 12 13:23:07.903077 systemd[1]: tcsd.service - TCG Core Services Daemon was skipped because of an unmet condition check (ConditionPathExists=/dev/tpm0). May 12 13:23:07.906218 systemd[1]: containerd.service: Deactivated successfully. May 12 13:23:07.906381 extend-filesystems[2235]: Found loop2 May 12 13:23:07.915516 extend-filesystems[2235]: Found loop3 May 12 13:23:07.915516 extend-filesystems[2235]: Found loop6 May 12 13:23:07.915516 extend-filesystems[2235]: Found loop7 May 12 13:23:07.915516 extend-filesystems[2235]: Found vda May 12 13:23:07.915516 extend-filesystems[2235]: Found vda1 May 12 13:23:07.915516 extend-filesystems[2235]: Found vda2 May 12 13:23:07.915516 extend-filesystems[2235]: Found vda3 May 12 13:23:07.915516 extend-filesystems[2235]: Found usr May 12 13:23:07.915516 extend-filesystems[2235]: Found vda4 May 12 13:23:07.915516 extend-filesystems[2235]: Found vda6 May 12 13:23:07.915516 extend-filesystems[2235]: Found vda7 May 12 13:23:07.915516 extend-filesystems[2235]: Found vda9 May 12 13:23:07.915516 extend-filesystems[2235]: Checking size of /dev/vda9 May 12 13:23:07.906463 systemd[1]: Stopped containerd.service - containerd container runtime. May 12 13:23:07.931101 augenrules[2232]: /sbin/augenrules: No change May 12 13:23:07.931322 extend-filesystems[2235]: Old size kept for /dev/vda9 May 12 13:23:07.906502 systemd[1]: containerd.service: Consumed 349ms CPU time, 80.7M memory peak. May 12 13:23:07.932339 augenrules[2269]: No rules May 12 13:23:07.914701 systemd[1]: Listening on docker.socket - Docker Socket for the API. May 12 13:23:07.918552 systemd[1]: enable-oem-cloudinit.service: Skipped due to 'exec-condition'. May 12 13:23:07.920713 systemd[1]: Condition check resulted in enable-oem-cloudinit.service - Enable cloudinit being skipped. May 12 13:23:07.921335 systemd[1]: issuegen.service: Deactivated successfully. May 12 13:23:07.921523 systemd[1]: Finished issuegen.service - Generate /run/issue. May 12 13:23:07.923701 systemd[1]: ssh-key-proc-cmdline.service: Deactivated successfully. May 12 13:23:07.923899 systemd[1]: Finished ssh-key-proc-cmdline.service - Install an ssh key from /proc/cmdline. May 12 13:23:07.925479 systemd[1]: Finished ensure-sysext.service. May 12 13:23:07.930937 systemd[1]: extend-filesystems.service: Deactivated successfully. May 12 13:23:07.931146 systemd[1]: Finished extend-filesystems.service - Extend Filesystems. May 12 13:23:07.938455 kernel: BTRFS warning: duplicate device /dev/vda3 devid 1 generation 42 scanned by (udev-worker) (2145) May 12 13:23:07.938754 systemd[1]: audit-rules.service: Deactivated successfully. May 12 13:23:07.938950 systemd[1]: Finished audit-rules.service - Load Audit Rules. May 12 13:23:07.939824 systemd[1]: motdgen.service: Deactivated successfully. May 12 13:23:07.940009 systemd[1]: Finished motdgen.service - Generate /run/flatcar/motd. May 12 13:23:07.940548 systemd[1]: coreos-metadata.service: Deactivated successfully. May 12 13:23:07.940727 systemd[1]: Finished coreos-metadata.service - QEMU metadata agent. May 12 13:23:07.969492 systemd[1]: Reached target sockets.target - Socket Units. May 12 13:23:07.970763 systemd[1]: Starting containerd.service - containerd container runtime... May 12 13:23:07.970790 systemd[1]: packet-phone-home.service - Report Success to Packet was skipped because of an unmet condition check (ConditionFirstBoot=true). May 12 13:23:07.995954 systemd[1]: Started containerd.service - containerd container runtime. May 12 13:23:07.996534 systemd[1]: Reached target multi-user.target - Multi-User System. May 12 13:23:07.997860 systemd[1]: Starting docker.service - Docker Application Container Engine... May 12 13:23:08.001113 (dockerd)[2293]: docker.service: Referenced but unset environment variable evaluates to an empty string: DOCKER_CGROUPS, DOCKER_OPTS, DOCKER_OPT_BIP, DOCKER_OPT_IPMASQ, DOCKER_OPT_MTU May 12 13:23:08.213356 containerd[2292]: time="2025-05-12T13:23:08.213277779Z" level=info msg="starting containerd" revision=bcc810d6b9066471b0b6fa75f557a15a1cbf31bb version=v1.7.25 May 12 13:23:08.240717 containerd[2292]: time="2025-05-12T13:23:08.240473887Z" level=info msg="loading plugin \"io.containerd.event.v1.exchange\"..." type=io.containerd.event.v1 May 12 13:23:08.240717 containerd[2292]: time="2025-05-12T13:23:08.240516212Z" level=info msg="loading plugin \"io.containerd.internal.v1.opt\"..." type=io.containerd.internal.v1 May 12 13:23:08.240717 containerd[2292]: time="2025-05-12T13:23:08.240546268Z" level=info msg="loading plugin \"io.containerd.warning.v1.deprecations\"..." type=io.containerd.warning.v1 May 12 13:23:08.240717 containerd[2292]: time="2025-05-12T13:23:08.240559137Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.blockfile\"..." type=io.containerd.snapshotter.v1 May 12 13:23:08.240717 containerd[2292]: time="2025-05-12T13:23:08.240656458Z" level=info msg="skip loading plugin \"io.containerd.snapshotter.v1.blockfile\"..." error="no scratch file generator: skip plugin" type=io.containerd.snapshotter.v1 May 12 13:23:08.240717 containerd[2292]: time="2025-05-12T13:23:08.240668968Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.devmapper\"..." type=io.containerd.snapshotter.v1 May 12 13:23:08.240717 containerd[2292]: time="2025-05-12T13:23:08.240680638Z" level=info msg="skip loading plugin \"io.containerd.snapshotter.v1.devmapper\"..." error="devmapper not configured: skip plugin" type=io.containerd.snapshotter.v1 May 12 13:23:08.240717 containerd[2292]: time="2025-05-12T13:23:08.240690110Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.native\"..." type=io.containerd.snapshotter.v1 May 12 13:23:08.240717 containerd[2292]: time="2025-05-12T13:23:08.240716689Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.overlayfs\"..." type=io.containerd.snapshotter.v1 May 12 13:23:08.241014 containerd[2292]: time="2025-05-12T13:23:08.240819884Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.aufs\"..." type=io.containerd.snapshotter.v1 May 12 13:23:08.242414 containerd[2292]: time="2025-05-12T13:23:08.242380610Z" 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.89-flatcar\\n\"): skip plugin" type=io.containerd.snapshotter.v1 May 12 13:23:08.242414 containerd[2292]: time="2025-05-12T13:23:08.242407947Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.zfs\"..." type=io.containerd.snapshotter.v1 May 12 13:23:08.242618 containerd[2292]: time="2025-05-12T13:23:08.242598392Z" 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 May 12 13:23:08.242618 containerd[2292]: time="2025-05-12T13:23:08.242616377Z" level=info msg="loading plugin \"io.containerd.content.v1.content\"..." type=io.containerd.content.v1 May 12 13:23:08.242660 containerd[2292]: time="2025-05-12T13:23:08.242632084Z" level=info msg="loading plugin \"io.containerd.metadata.v1.bolt\"..." type=io.containerd.metadata.v1 May 12 13:23:08.242660 containerd[2292]: time="2025-05-12T13:23:08.242651868Z" level=info msg="metadata content store policy set" policy=shared May 12 13:23:08.247236 containerd[2292]: time="2025-05-12T13:23:08.246901038Z" level=info msg="loading plugin \"io.containerd.gc.v1.scheduler\"..." type=io.containerd.gc.v1 May 12 13:23:08.247236 containerd[2292]: time="2025-05-12T13:23:08.246940206Z" level=info msg="loading plugin \"io.containerd.differ.v1.walking\"..." type=io.containerd.differ.v1 May 12 13:23:08.247236 containerd[2292]: time="2025-05-12T13:23:08.246955673Z" level=info msg="loading plugin \"io.containerd.lease.v1.manager\"..." type=io.containerd.lease.v1 May 12 13:23:08.247236 containerd[2292]: time="2025-05-12T13:23:08.246970141Z" level=info msg="loading plugin \"io.containerd.streaming.v1.manager\"..." type=io.containerd.streaming.v1 May 12 13:23:08.247236 containerd[2292]: time="2025-05-12T13:23:08.246983850Z" level=info msg="loading plugin \"io.containerd.runtime.v1.linux\"..." type=io.containerd.runtime.v1 May 12 13:23:08.247236 containerd[2292]: time="2025-05-12T13:23:08.247025976Z" level=info msg="loading plugin \"io.containerd.monitor.v1.cgroups\"..." type=io.containerd.monitor.v1 May 12 13:23:08.248239 containerd[2292]: time="2025-05-12T13:23:08.248097500Z" level=info msg="loading plugin \"io.containerd.runtime.v2.task\"..." type=io.containerd.runtime.v2 May 12 13:23:08.248239 containerd[2292]: time="2025-05-12T13:23:08.248199257Z" level=info msg="loading plugin \"io.containerd.runtime.v2.shim\"..." type=io.containerd.runtime.v2 May 12 13:23:08.248239 containerd[2292]: time="2025-05-12T13:23:08.248211967Z" level=info msg="loading plugin \"io.containerd.sandbox.store.v1.local\"..." type=io.containerd.sandbox.store.v1 May 12 13:23:08.248239 containerd[2292]: time="2025-05-12T13:23:08.248225796Z" level=info msg="loading plugin \"io.containerd.sandbox.controller.v1.local\"..." type=io.containerd.sandbox.controller.v1 May 12 13:23:08.248239 containerd[2292]: time="2025-05-12T13:23:08.248237906Z" level=info msg="loading plugin \"io.containerd.service.v1.containers-service\"..." type=io.containerd.service.v1 May 12 13:23:08.248388 containerd[2292]: time="2025-05-12T13:23:08.248249656Z" level=info msg="loading plugin \"io.containerd.service.v1.content-service\"..." type=io.containerd.service.v1 May 12 13:23:08.248388 containerd[2292]: time="2025-05-12T13:23:08.248261566Z" level=info msg="loading plugin \"io.containerd.service.v1.diff-service\"..." type=io.containerd.service.v1 May 12 13:23:08.248388 containerd[2292]: time="2025-05-12T13:23:08.248274036Z" level=info msg="loading plugin \"io.containerd.service.v1.images-service\"..." type=io.containerd.service.v1 May 12 13:23:08.248388 containerd[2292]: time="2025-05-12T13:23:08.248287625Z" level=info msg="loading plugin \"io.containerd.service.v1.introspection-service\"..." type=io.containerd.service.v1 May 12 13:23:08.248388 containerd[2292]: time="2025-05-12T13:23:08.248302053Z" level=info msg="loading plugin \"io.containerd.service.v1.namespaces-service\"..." type=io.containerd.service.v1 May 12 13:23:08.248388 containerd[2292]: time="2025-05-12T13:23:08.248313324Z" level=info msg="loading plugin \"io.containerd.service.v1.snapshots-service\"..." type=io.containerd.service.v1 May 12 13:23:08.248388 containerd[2292]: time="2025-05-12T13:23:08.248325274Z" level=info msg="loading plugin \"io.containerd.service.v1.tasks-service\"..." type=io.containerd.service.v1 May 12 13:23:08.248388 containerd[2292]: time="2025-05-12T13:23:08.248343260Z" level=info msg="loading plugin \"io.containerd.grpc.v1.containers\"..." type=io.containerd.grpc.v1 May 12 13:23:08.248388 containerd[2292]: time="2025-05-12T13:23:08.248356249Z" level=info msg="loading plugin \"io.containerd.grpc.v1.content\"..." type=io.containerd.grpc.v1 May 12 13:23:08.248388 containerd[2292]: time="2025-05-12T13:23:08.248368879Z" level=info msg="loading plugin \"io.containerd.grpc.v1.diff\"..." type=io.containerd.grpc.v1 May 12 13:23:08.248388 containerd[2292]: time="2025-05-12T13:23:08.248379870Z" level=info msg="loading plugin \"io.containerd.grpc.v1.events\"..." type=io.containerd.grpc.v1 May 12 13:23:08.248388 containerd[2292]: time="2025-05-12T13:23:08.248390981Z" level=info msg="loading plugin \"io.containerd.grpc.v1.images\"..." type=io.containerd.grpc.v1 May 12 13:23:08.248615 containerd[2292]: time="2025-05-12T13:23:08.248403091Z" level=info msg="loading plugin \"io.containerd.grpc.v1.introspection\"..." type=io.containerd.grpc.v1 May 12 13:23:08.248615 containerd[2292]: time="2025-05-12T13:23:08.248413962Z" level=info msg="loading plugin \"io.containerd.grpc.v1.leases\"..." type=io.containerd.grpc.v1 May 12 13:23:08.248615 containerd[2292]: time="2025-05-12T13:23:08.248444737Z" level=info msg="loading plugin \"io.containerd.grpc.v1.namespaces\"..." type=io.containerd.grpc.v1 May 12 13:23:08.248615 containerd[2292]: time="2025-05-12T13:23:08.248458805Z" level=info msg="loading plugin \"io.containerd.grpc.v1.sandbox-controllers\"..." type=io.containerd.grpc.v1 May 12 13:23:08.248615 containerd[2292]: time="2025-05-12T13:23:08.248493097Z" level=info msg="loading plugin \"io.containerd.grpc.v1.sandboxes\"..." type=io.containerd.grpc.v1 May 12 13:23:08.248615 containerd[2292]: time="2025-05-12T13:23:08.248507965Z" level=info msg="loading plugin \"io.containerd.grpc.v1.snapshots\"..." type=io.containerd.grpc.v1 May 12 13:23:08.248615 containerd[2292]: time="2025-05-12T13:23:08.248519196Z" level=info msg="loading plugin \"io.containerd.grpc.v1.streaming\"..." type=io.containerd.grpc.v1 May 12 13:23:08.248615 containerd[2292]: time="2025-05-12T13:23:08.248530667Z" level=info msg="loading plugin \"io.containerd.grpc.v1.tasks\"..." type=io.containerd.grpc.v1 May 12 13:23:08.248615 containerd[2292]: time="2025-05-12T13:23:08.248544176Z" level=info msg="loading plugin \"io.containerd.transfer.v1.local\"..." type=io.containerd.transfer.v1 May 12 13:23:08.248816 containerd[2292]: time="2025-05-12T13:23:08.248618395Z" level=info msg="loading plugin \"io.containerd.grpc.v1.transfer\"..." type=io.containerd.grpc.v1 May 12 13:23:08.248816 containerd[2292]: time="2025-05-12T13:23:08.248635621Z" level=info msg="loading plugin \"io.containerd.grpc.v1.version\"..." type=io.containerd.grpc.v1 May 12 13:23:08.248816 containerd[2292]: time="2025-05-12T13:23:08.248646572Z" level=info msg="loading plugin \"io.containerd.internal.v1.restart\"..." type=io.containerd.internal.v1 May 12 13:23:08.249079 containerd[2292]: time="2025-05-12T13:23:08.249040490Z" level=info msg="loading plugin \"io.containerd.tracing.processor.v1.otlp\"..." type=io.containerd.tracing.processor.v1 May 12 13:23:08.249079 containerd[2292]: time="2025-05-12T13:23:08.249068028Z" 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 May 12 13:23:08.249079 containerd[2292]: time="2025-05-12T13:23:08.249078579Z" level=info msg="loading plugin \"io.containerd.internal.v1.tracing\"..." type=io.containerd.internal.v1 May 12 13:23:08.249216 containerd[2292]: time="2025-05-12T13:23:08.249198601Z" level=info msg="skip loading plugin \"io.containerd.internal.v1.tracing\"..." error="skip plugin: tracing endpoint not configured" type=io.containerd.internal.v1 May 12 13:23:08.249216 containerd[2292]: time="2025-05-12T13:23:08.249214028Z" level=info msg="loading plugin \"io.containerd.grpc.v1.healthcheck\"..." type=io.containerd.grpc.v1 May 12 13:23:08.249289 containerd[2292]: time="2025-05-12T13:23:08.249228137Z" level=info msg="loading plugin \"io.containerd.nri.v1.nri\"..." type=io.containerd.nri.v1 May 12 13:23:08.249289 containerd[2292]: time="2025-05-12T13:23:08.249243085Z" level=info msg="NRI interface is disabled by configuration." May 12 13:23:08.249332 containerd[2292]: time="2025-05-12T13:23:08.249298360Z" level=info msg="loading plugin \"io.containerd.grpc.v1.cri\"..." type=io.containerd.grpc.v1 May 12 13:23:08.249819 containerd[2292]: time="2025-05-12T13:23:08.249768695Z" 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:false 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}" May 12 13:23:08.249970 containerd[2292]: time="2025-05-12T13:23:08.249822052Z" level=info msg="Connect containerd service" May 12 13:23:08.249970 containerd[2292]: time="2025-05-12T13:23:08.249857263Z" level=info msg="using legacy CRI server" May 12 13:23:08.249970 containerd[2292]: time="2025-05-12T13:23:08.249865976Z" level=info msg="using experimental NRI integration - disable nri plugin to prevent this" May 12 13:23:08.250416 containerd[2292]: time="2025-05-12T13:23:08.250392906Z" level=info msg="Get image filesystem path \"/var/lib/containerd/io.containerd.snapshotter.v1.overlayfs\"" May 12 13:23:08.253182 containerd[2292]: time="2025-05-12T13:23:08.253142260Z" 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" May 12 13:23:08.253906 containerd[2292]: time="2025-05-12T13:23:08.253684377Z" level=info msg="Start subscribing containerd event" May 12 13:23:08.253906 containerd[2292]: time="2025-05-12T13:23:08.253744528Z" level=info msg="Start recovering state" May 12 13:23:08.253906 containerd[2292]: time="2025-05-12T13:23:08.253803160Z" level=info msg="Start event monitor" May 12 13:23:08.253906 containerd[2292]: time="2025-05-12T13:23:08.253813792Z" level=info msg="Start snapshots syncer" May 12 13:23:08.253906 containerd[2292]: time="2025-05-12T13:23:08.253823184Z" level=info msg="Start cni network conf syncer for default" May 12 13:23:08.253906 containerd[2292]: time="2025-05-12T13:23:08.253830618Z" level=info msg="Start streaming server" May 12 13:23:08.254121 containerd[2292]: time="2025-05-12T13:23:08.254059951Z" level=info msg=serving... address=/run/containerd/containerd.sock.ttrpc May 12 13:23:08.254121 containerd[2292]: time="2025-05-12T13:23:08.254114306Z" level=info msg=serving... address=/run/containerd/containerd.sock May 12 13:23:08.254161 containerd[2292]: time="2025-05-12T13:23:08.254134849Z" level=info msg="containerd successfully booted in 0.042391s" May 12 13:23:08.378540 dockerd[2293]: time="2025-05-12T13:23:08.378469621Z" level=info msg="Starting up" May 12 13:23:08.382999 dockerd[2293]: time="2025-05-12T13:23:08.382960993Z" level=info msg="OTEL tracing is not configured, using no-op tracer provider" May 12 13:23:08.581208 dockerd[2293]: time="2025-05-12T13:23:08.581061117Z" level=info msg="[graphdriver] using prior storage driver: overlay2" May 12 13:23:08.587508 dockerd[2293]: time="2025-05-12T13:23:08.587441026Z" level=info msg="Loading containers: start." May 12 13:23:09.043048 dockerd[2293]: time="2025-05-12T13:23:09.043000489Z" level=info msg="Loading containers: done." May 12 13:23:09.055017 systemd[1]: var-lib-docker-overlay2-opaque\x2dbug\x2dcheck2630612244-merged.mount: Deactivated successfully. May 12 13:23:09.057133 dockerd[2293]: time="2025-05-12T13:23:09.056747244Z" level=warning msg="Not using native diff for overlay2, this may cause degraded performance for building images: kernel has CONFIG_OVERLAY_FS_REDIRECT_DIR enabled" storage-driver=overlay2 May 12 13:23:09.057133 dockerd[2293]: time="2025-05-12T13:23:09.056838135Z" level=info msg="Docker daemon" commit=bbd0a17 containerd-snapshotter=false storage-driver=overlay2 version=28.0.1 May 12 13:23:09.057133 dockerd[2293]: time="2025-05-12T13:23:09.056876106Z" level=info msg="Initializing buildkit" May 12 13:23:09.074997 dockerd[2293]: time="2025-05-12T13:23:09.074949707Z" level=info msg="Completed buildkit initialization" May 12 13:23:09.082749 dockerd[2293]: time="2025-05-12T13:23:09.082704890Z" level=info msg="Daemon has completed initialization" May 12 13:23:09.082824 dockerd[2293]: time="2025-05-12T13:23:09.082774197Z" level=info msg="API listen on /run/docker.sock" May 12 13:23:09.082922 systemd[1]: Started docker.service - Docker Application Container Engine. May 12 13:23:09.084641 sudo[2136]: pam_unix(sudo:session): session closed for user root May 12 13:23:09.086155 sshd[2135]: Connection closed by 10.0.0.1 port 33022 May 12 13:23:09.087416 sshd-session[2130]: pam_unix(sshd:session): session closed for user core May 12 13:23:09.100782 systemd-logind[1393]: Session 14 logged out. Waiting for processes to exit. May 12 13:23:09.103414 systemd[1]: Started sshd@14-10.0.0.44:22-10.0.0.1:33032.service - OpenSSH per-connection server daemon (10.0.0.1:33032). May 12 13:23:09.106581 kernel: EXT4-fs (loop3): unmounting filesystem 6de35f4d-4722-4f06-b152-e59a88382c74. May 12 13:23:09.112458 kernel: EXT4-fs (loop2): unmounting filesystem a296d181-9817-4d73-97cb-93b0cc10f674. May 12 13:23:09.139196 systemd[1]: sshd@13-10.0.0.44:22-10.0.0.1:33022.service: Deactivated successfully. May 12 13:23:09.140929 systemd[1]: session-14.scope: Deactivated successfully. May 12 13:23:09.142361 systemd-logind[1393]: Removed session 14. May 12 13:23:09.153563 sshd[2536]: Accepted publickey for core from 10.0.0.1 port 33032 ssh2: RSA SHA256:jEPoW5jmVqQGUqKP3XswdpHQkuwhsPJWJAB8YbEjhZ8 May 12 13:23:09.155179 sshd-session[2536]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) May 12 13:23:09.162291 systemd-logind[1393]: New session 15 of user core. May 12 13:23:09.169627 systemd[1]: Started session-15.scope - Session 15 of User core. May 12 13:23:09.374638 systemd[1]: Started docker-8ee17257d3c55a40a5d6265097d6a59d7cf77a7eaad229c3a290884f2cb8ab3c.scope - libcontainer container 8ee17257d3c55a40a5d6265097d6a59d7cf77a7eaad229c3a290884f2cb8ab3c. May 12 13:23:09.385241 systemd-resolved[1306]: Failed to determine the local hostname and LLMNR/mDNS names, ignoring: No such device or address May 12 13:23:09.401101 kernel: docker0: port 1(vethd972e60) entered blocking state May 12 13:23:09.401191 kernel: docker0: port 1(vethd972e60) entered disabled state May 12 13:23:09.401211 kernel: vethd972e60: entered allmulticast mode May 12 13:23:09.402445 kernel: vethd972e60: entered promiscuous mode May 12 13:23:09.402432 systemd-networkd[1358]: vethd972e60: Link UP May 12 13:23:09.409459 kernel: eth0: renamed from vetha7e979a May 12 13:23:09.420632 kernel: docker0: port 1(vethd972e60) entered blocking state May 12 13:23:09.420699 kernel: docker0: port 1(vethd972e60) entered forwarding state May 12 13:23:09.420771 systemd-networkd[1358]: vethd972e60: Gained carrier May 12 13:23:09.421008 systemd-networkd[1358]: docker0: Gained carrier May 12 13:23:09.433529 systemd[1]: docker-8ee17257d3c55a40a5d6265097d6a59d7cf77a7eaad229c3a290884f2cb8ab3c.scope: Deactivated successfully. May 12 13:23:09.447148 containerd[2292]: time="2025-05-12T13:23:09.447050568Z" level=info msg="shim disconnected" id=8ee17257d3c55a40a5d6265097d6a59d7cf77a7eaad229c3a290884f2cb8ab3c namespace=moby May 12 13:23:09.447148 containerd[2292]: time="2025-05-12T13:23:09.447110123Z" level=warning msg="cleaning up after shim disconnected" id=8ee17257d3c55a40a5d6265097d6a59d7cf77a7eaad229c3a290884f2cb8ab3c namespace=moby May 12 13:23:09.447148 containerd[2292]: time="2025-05-12T13:23:09.447118716Z" level=info msg="cleaning up dead shim" namespace=moby May 12 13:23:09.447552 dockerd[2293]: time="2025-05-12T13:23:09.447297659Z" level=info msg="ignoring event" container=8ee17257d3c55a40a5d6265097d6a59d7cf77a7eaad229c3a290884f2cb8ab3c module=libcontainerd namespace=moby topic=/tasks/delete type="*events.TaskDelete" May 12 13:23:09.461453 kernel: docker0: port 1(vethd972e60) entered disabled state May 12 13:23:09.461528 kernel: vetha7e979a: renamed from eth0 May 12 13:23:09.462128 systemd-networkd[1358]: vethd972e60: Lost carrier May 12 13:23:09.484018 systemd-networkd[1358]: vethd972e60: Link DOWN May 12 13:23:09.485931 kernel: docker0: port 1(vethd972e60) entered disabled state May 12 13:23:09.485993 kernel: vethd972e60 (unregistering): left allmulticast mode May 12 13:23:09.486012 kernel: vethd972e60 (unregistering): left promiscuous mode May 12 13:23:09.487461 kernel: docker0: port 1(vethd972e60) entered disabled state May 12 13:23:09.515980 systemd[1]: run-docker-netns-4fac79280e08.mount: Deactivated successfully. May 12 13:23:09.517790 systemd[1]: var-lib-docker-overlay2-2dbd1eabdff64ed4ce16b15d9a448d91f7b7579a66d19cbb98b3a1285b7b30c2-merged.mount: Deactivated successfully. May 12 13:23:09.529895 sshd[2540]: Connection closed by 10.0.0.1 port 33032 May 12 13:23:09.530229 sshd-session[2536]: pam_unix(sshd:session): session closed for user core May 12 13:23:09.532763 systemd[1]: sshd@14-10.0.0.44:22-10.0.0.1:33032.service: Deactivated successfully. May 12 13:23:09.534324 systemd[1]: session-15.scope: Deactivated successfully. May 12 13:23:09.535576 systemd-logind[1393]: Session 15 logged out. Waiting for processes to exit. May 12 13:23:09.536648 systemd-logind[1393]: Removed session 15. May 12 13:23:10.415693 systemd-networkd[1358]: docker0: Lost carrier