Jan 29 11:05:27.048074 kernel: Booting Linux on physical CPU 0x0000000000 [0x413fd0c1] Jan 29 11:05:27.048096 kernel: Linux version 6.6.74-flatcar (build@pony-truck.infra.kinvolk.io) (aarch64-cros-linux-gnu-gcc (Gentoo Hardened 14.2.1_p20241116 p3) 14.2.1 20241116, GNU ld (Gentoo 2.42 p6) 2.42.0) #1 SMP PREEMPT Wed Jan 29 09:30:22 -00 2025 Jan 29 11:05:27.048106 kernel: KASLR enabled Jan 29 11:05:27.048112 kernel: efi: EFI v2.7 by EDK II Jan 29 11:05:27.048118 kernel: efi: SMBIOS 3.0=0xdced0000 MEMATTR=0xdbbae018 ACPI 2.0=0xd9b43018 RNG=0xd9b43a18 MEMRESERVE=0xd9b40218 Jan 29 11:05:27.048123 kernel: random: crng init done Jan 29 11:05:27.048130 kernel: secureboot: Secure boot disabled Jan 29 11:05:27.048135 kernel: ACPI: Early table checksum verification disabled Jan 29 11:05:27.048141 kernel: ACPI: RSDP 0x00000000D9B43018 000024 (v02 BOCHS ) Jan 29 11:05:27.048149 kernel: ACPI: XSDT 0x00000000D9B43F18 000064 (v01 BOCHS BXPC 00000001 01000013) Jan 29 11:05:27.048155 kernel: ACPI: FACP 0x00000000D9B43B18 000114 (v06 BOCHS BXPC 00000001 BXPC 00000001) Jan 29 11:05:27.048160 kernel: ACPI: DSDT 0x00000000D9B41018 0014A2 (v02 BOCHS BXPC 00000001 BXPC 00000001) Jan 29 11:05:27.048166 kernel: ACPI: APIC 0x00000000D9B43C98 0001A8 (v04 BOCHS BXPC 00000001 BXPC 00000001) Jan 29 11:05:27.048172 kernel: ACPI: PPTT 0x00000000D9B43098 00009C (v02 BOCHS BXPC 00000001 BXPC 00000001) Jan 29 11:05:27.048179 kernel: ACPI: GTDT 0x00000000D9B43818 000060 (v02 BOCHS BXPC 00000001 BXPC 00000001) Jan 29 11:05:27.048187 kernel: ACPI: MCFG 0x00000000D9B43A98 00003C (v01 BOCHS BXPC 00000001 BXPC 00000001) Jan 29 11:05:27.048193 kernel: ACPI: SPCR 0x00000000D9B43918 000050 (v02 BOCHS BXPC 00000001 BXPC 00000001) Jan 29 11:05:27.048199 kernel: ACPI: DBG2 0x00000000D9B43998 000057 (v00 BOCHS BXPC 00000001 BXPC 00000001) Jan 29 11:05:27.048205 kernel: ACPI: IORT 0x00000000D9B43198 000080 (v03 BOCHS BXPC 00000001 BXPC 00000001) Jan 29 11:05:27.048211 kernel: ACPI: SPCR: console: pl011,mmio,0x9000000,9600 Jan 29 11:05:27.048217 kernel: NUMA: Failed to initialise from firmware Jan 29 11:05:27.048223 kernel: NUMA: Faking a node at [mem 0x0000000040000000-0x00000000dcffffff] Jan 29 11:05:27.048229 kernel: NUMA: NODE_DATA [mem 0xdc958800-0xdc95dfff] Jan 29 11:05:27.048235 kernel: Zone ranges: Jan 29 11:05:27.048241 kernel: DMA [mem 0x0000000040000000-0x00000000dcffffff] Jan 29 11:05:27.048249 kernel: DMA32 empty Jan 29 11:05:27.048255 kernel: Normal empty Jan 29 11:05:27.048260 kernel: Movable zone start for each node Jan 29 11:05:27.048266 kernel: Early memory node ranges Jan 29 11:05:27.048272 kernel: node 0: [mem 0x0000000040000000-0x00000000d967ffff] Jan 29 11:05:27.048278 kernel: node 0: [mem 0x00000000d9680000-0x00000000d968ffff] Jan 29 11:05:27.048284 kernel: node 0: [mem 0x00000000d9690000-0x00000000d976ffff] Jan 29 11:05:27.048290 kernel: node 0: [mem 0x00000000d9770000-0x00000000d9b3ffff] Jan 29 11:05:27.048296 kernel: node 0: [mem 0x00000000d9b40000-0x00000000dce1ffff] Jan 29 11:05:27.048302 kernel: node 0: [mem 0x00000000dce20000-0x00000000dceaffff] Jan 29 11:05:27.048308 kernel: node 0: [mem 0x00000000dceb0000-0x00000000dcebffff] Jan 29 11:05:27.048314 kernel: node 0: [mem 0x00000000dcec0000-0x00000000dcfdffff] Jan 29 11:05:27.048322 kernel: node 0: [mem 0x00000000dcfe0000-0x00000000dcffffff] Jan 29 11:05:27.048328 kernel: Initmem setup node 0 [mem 0x0000000040000000-0x00000000dcffffff] Jan 29 11:05:27.048334 kernel: On node 0, zone DMA: 12288 pages in unavailable ranges Jan 29 11:05:27.048343 kernel: psci: probing for conduit method from ACPI. Jan 29 11:05:27.048350 kernel: psci: PSCIv1.1 detected in firmware. Jan 29 11:05:27.048356 kernel: psci: Using standard PSCI v0.2 function IDs Jan 29 11:05:27.048364 kernel: psci: Trusted OS migration not required Jan 29 11:05:27.048371 kernel: psci: SMC Calling Convention v1.1 Jan 29 11:05:27.048377 kernel: smccc: KVM: hypervisor services detected (0x00000000 0x00000000 0x00000000 0x00000003) Jan 29 11:05:27.048384 kernel: percpu: Embedded 31 pages/cpu s86696 r8192 d32088 u126976 Jan 29 11:05:27.048390 kernel: pcpu-alloc: s86696 r8192 d32088 u126976 alloc=31*4096 Jan 29 11:05:27.048397 kernel: pcpu-alloc: [0] 0 [0] 1 [0] 2 [0] 3 Jan 29 11:05:27.048403 kernel: Detected PIPT I-cache on CPU0 Jan 29 11:05:27.048410 kernel: CPU features: detected: GIC system register CPU interface Jan 29 11:05:27.048416 kernel: CPU features: detected: Hardware dirty bit management Jan 29 11:05:27.048423 kernel: CPU features: detected: Spectre-v4 Jan 29 11:05:27.048430 kernel: CPU features: detected: Spectre-BHB Jan 29 11:05:27.048437 kernel: CPU features: kernel page table isolation forced ON by KASLR Jan 29 11:05:27.048443 kernel: CPU features: detected: Kernel page table isolation (KPTI) Jan 29 11:05:27.048450 kernel: CPU features: detected: ARM erratum 1418040 Jan 29 11:05:27.048456 kernel: CPU features: detected: SSBS not fully self-synchronizing Jan 29 11:05:27.048462 kernel: alternatives: applying boot alternatives Jan 29 11:05:27.048470 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=e6957044c3256d96283265c263579aa4275d1d707b02496fcb081f5fc6356346 Jan 29 11:05:27.048477 kernel: Unknown kernel command line parameters "BOOT_IMAGE=/flatcar/vmlinuz-a", will be passed to user space. Jan 29 11:05:27.048486 kernel: Dentry cache hash table entries: 524288 (order: 10, 4194304 bytes, linear) Jan 29 11:05:27.048495 kernel: Inode-cache hash table entries: 262144 (order: 9, 2097152 bytes, linear) Jan 29 11:05:27.048503 kernel: Fallback order for Node 0: 0 Jan 29 11:05:27.048514 kernel: Built 1 zonelists, mobility grouping on. Total pages: 633024 Jan 29 11:05:27.048521 kernel: Policy zone: DMA Jan 29 11:05:27.048528 kernel: mem auto-init: stack:off, heap alloc:off, heap free:off Jan 29 11:05:27.048535 kernel: software IO TLB: area num 4. Jan 29 11:05:27.048541 kernel: software IO TLB: mapped [mem 0x00000000d2e00000-0x00000000d6e00000] (64MB) Jan 29 11:05:27.048548 kernel: Memory: 2385940K/2572288K available (10304K kernel code, 2186K rwdata, 8092K rodata, 39936K init, 897K bss, 186348K reserved, 0K cma-reserved) Jan 29 11:05:27.048555 kernel: SLUB: HWalign=64, Order=0-3, MinObjects=0, CPUs=4, Nodes=1 Jan 29 11:05:27.048562 kernel: rcu: Preemptible hierarchical RCU implementation. Jan 29 11:05:27.048569 kernel: rcu: RCU event tracing is enabled. Jan 29 11:05:27.048576 kernel: rcu: RCU restricting CPUs from NR_CPUS=512 to nr_cpu_ids=4. Jan 29 11:05:27.048583 kernel: Trampoline variant of Tasks RCU enabled. Jan 29 11:05:27.048589 kernel: Tracing variant of Tasks RCU enabled. Jan 29 11:05:27.048598 kernel: rcu: RCU calculated value of scheduler-enlistment delay is 100 jiffies. Jan 29 11:05:27.048604 kernel: rcu: Adjusting geometry for rcu_fanout_leaf=16, nr_cpu_ids=4 Jan 29 11:05:27.048611 kernel: NR_IRQS: 64, nr_irqs: 64, preallocated irqs: 0 Jan 29 11:05:27.048617 kernel: GICv3: 256 SPIs implemented Jan 29 11:05:27.048624 kernel: GICv3: 0 Extended SPIs implemented Jan 29 11:05:27.048630 kernel: Root IRQ handler: gic_handle_irq Jan 29 11:05:27.048636 kernel: GICv3: GICv3 features: 16 PPIs, DirectLPI Jan 29 11:05:27.048643 kernel: GICv3: CPU0: found redistributor 0 region 0:0x00000000080a0000 Jan 29 11:05:27.048650 kernel: ITS [mem 0x08080000-0x0809ffff] Jan 29 11:05:27.048656 kernel: ITS@0x0000000008080000: allocated 8192 Devices @400c0000 (indirect, esz 8, psz 64K, shr 1) Jan 29 11:05:27.048663 kernel: ITS@0x0000000008080000: allocated 8192 Interrupt Collections @400d0000 (flat, esz 8, psz 64K, shr 1) Jan 29 11:05:27.048671 kernel: GICv3: using LPI property table @0x00000000400f0000 Jan 29 11:05:27.048678 kernel: GICv3: CPU0: using allocated LPI pending table @0x0000000040100000 Jan 29 11:05:27.048685 kernel: rcu: srcu_init: Setting srcu_struct sizes based on contention. Jan 29 11:05:27.048691 kernel: arch_timer: Enabling local workaround for ARM erratum 1418040 Jan 29 11:05:27.048697 kernel: arch_timer: cp15 timer(s) running at 25.00MHz (virt). Jan 29 11:05:27.048704 kernel: clocksource: arch_sys_counter: mask: 0xffffffffffffff max_cycles: 0x5c40939b5, max_idle_ns: 440795202646 ns Jan 29 11:05:27.048711 kernel: sched_clock: 56 bits at 25MHz, resolution 40ns, wraps every 4398046511100ns Jan 29 11:05:27.048717 kernel: arm-pv: using stolen time PV Jan 29 11:05:27.048724 kernel: Console: colour dummy device 80x25 Jan 29 11:05:27.048731 kernel: ACPI: Core revision 20230628 Jan 29 11:05:27.048738 kernel: Calibrating delay loop (skipped), value calculated using timer frequency.. 50.00 BogoMIPS (lpj=25000) Jan 29 11:05:27.048747 kernel: pid_max: default: 32768 minimum: 301 Jan 29 11:05:27.048753 kernel: LSM: initializing lsm=lockdown,capability,landlock,selinux,integrity Jan 29 11:05:27.048760 kernel: landlock: Up and running. Jan 29 11:05:27.048766 kernel: SELinux: Initializing. Jan 29 11:05:27.048773 kernel: Mount-cache hash table entries: 8192 (order: 4, 65536 bytes, linear) Jan 29 11:05:27.048780 kernel: Mountpoint-cache hash table entries: 8192 (order: 4, 65536 bytes, linear) Jan 29 11:05:27.048787 kernel: RCU Tasks: Setting shift to 2 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=4. Jan 29 11:05:27.048802 kernel: RCU Tasks Trace: Setting shift to 2 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=4. Jan 29 11:05:27.048809 kernel: rcu: Hierarchical SRCU implementation. Jan 29 11:05:27.048818 kernel: rcu: Max phase no-delay instances is 400. Jan 29 11:05:27.048825 kernel: Platform MSI: ITS@0x8080000 domain created Jan 29 11:05:27.048831 kernel: PCI/MSI: ITS@0x8080000 domain created Jan 29 11:05:27.048838 kernel: Remapping and enabling EFI services. Jan 29 11:05:27.048844 kernel: smp: Bringing up secondary CPUs ... Jan 29 11:05:27.048851 kernel: Detected PIPT I-cache on CPU1 Jan 29 11:05:27.048858 kernel: GICv3: CPU1: found redistributor 1 region 0:0x00000000080c0000 Jan 29 11:05:27.048865 kernel: GICv3: CPU1: using allocated LPI pending table @0x0000000040110000 Jan 29 11:05:27.048872 kernel: arch_timer: Enabling local workaround for ARM erratum 1418040 Jan 29 11:05:27.048880 kernel: CPU1: Booted secondary processor 0x0000000001 [0x413fd0c1] Jan 29 11:05:27.048887 kernel: Detected PIPT I-cache on CPU2 Jan 29 11:05:27.048898 kernel: GICv3: CPU2: found redistributor 2 region 0:0x00000000080e0000 Jan 29 11:05:27.048907 kernel: GICv3: CPU2: using allocated LPI pending table @0x0000000040120000 Jan 29 11:05:27.048914 kernel: arch_timer: Enabling local workaround for ARM erratum 1418040 Jan 29 11:05:27.048921 kernel: CPU2: Booted secondary processor 0x0000000002 [0x413fd0c1] Jan 29 11:05:27.048928 kernel: Detected PIPT I-cache on CPU3 Jan 29 11:05:27.048935 kernel: GICv3: CPU3: found redistributor 3 region 0:0x0000000008100000 Jan 29 11:05:27.048943 kernel: GICv3: CPU3: using allocated LPI pending table @0x0000000040130000 Jan 29 11:05:27.048951 kernel: arch_timer: Enabling local workaround for ARM erratum 1418040 Jan 29 11:05:27.048958 kernel: CPU3: Booted secondary processor 0x0000000003 [0x413fd0c1] Jan 29 11:05:27.048965 kernel: smp: Brought up 1 node, 4 CPUs Jan 29 11:05:27.048972 kernel: SMP: Total of 4 processors activated. Jan 29 11:05:27.048979 kernel: CPU features: detected: 32-bit EL0 Support Jan 29 11:05:27.048986 kernel: CPU features: detected: Data cache clean to the PoU not required for I/D coherence Jan 29 11:05:27.048993 kernel: CPU features: detected: Common not Private translations Jan 29 11:05:27.049000 kernel: CPU features: detected: CRC32 instructions Jan 29 11:05:27.049009 kernel: CPU features: detected: Enhanced Virtualization Traps Jan 29 11:05:27.049016 kernel: CPU features: detected: RCpc load-acquire (LDAPR) Jan 29 11:05:27.049023 kernel: CPU features: detected: LSE atomic instructions Jan 29 11:05:27.049037 kernel: CPU features: detected: Privileged Access Never Jan 29 11:05:27.049044 kernel: CPU features: detected: RAS Extension Support Jan 29 11:05:27.049051 kernel: CPU features: detected: Speculative Store Bypassing Safe (SSBS) Jan 29 11:05:27.049058 kernel: CPU: All CPU(s) started at EL1 Jan 29 11:05:27.049065 kernel: alternatives: applying system-wide alternatives Jan 29 11:05:27.049072 kernel: devtmpfs: initialized Jan 29 11:05:27.049079 kernel: clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1911260446275000 ns Jan 29 11:05:27.049089 kernel: futex hash table entries: 1024 (order: 4, 65536 bytes, linear) Jan 29 11:05:27.049096 kernel: pinctrl core: initialized pinctrl subsystem Jan 29 11:05:27.049103 kernel: SMBIOS 3.0.0 present. Jan 29 11:05:27.049109 kernel: DMI: QEMU KVM Virtual Machine, BIOS unknown 02/02/2022 Jan 29 11:05:27.049116 kernel: NET: Registered PF_NETLINK/PF_ROUTE protocol family Jan 29 11:05:27.049124 kernel: DMA: preallocated 512 KiB GFP_KERNEL pool for atomic allocations Jan 29 11:05:27.049131 kernel: DMA: preallocated 512 KiB GFP_KERNEL|GFP_DMA pool for atomic allocations Jan 29 11:05:27.049138 kernel: DMA: preallocated 512 KiB GFP_KERNEL|GFP_DMA32 pool for atomic allocations Jan 29 11:05:27.049146 kernel: audit: initializing netlink subsys (disabled) Jan 29 11:05:27.049154 kernel: audit: type=2000 audit(0.019:1): state=initialized audit_enabled=0 res=1 Jan 29 11:05:27.049161 kernel: thermal_sys: Registered thermal governor 'step_wise' Jan 29 11:05:27.049168 kernel: cpuidle: using governor menu Jan 29 11:05:27.049175 kernel: hw-breakpoint: found 6 breakpoint and 4 watchpoint registers. Jan 29 11:05:27.049182 kernel: ASID allocator initialised with 32768 entries Jan 29 11:05:27.049195 kernel: acpiphp: ACPI Hot Plug PCI Controller Driver version: 0.5 Jan 29 11:05:27.049202 kernel: Serial: AMBA PL011 UART driver Jan 29 11:05:27.049210 kernel: Modules: 2G module region forced by RANDOMIZE_MODULE_REGION_FULL Jan 29 11:05:27.049219 kernel: Modules: 0 pages in range for non-PLT usage Jan 29 11:05:27.049226 kernel: Modules: 508880 pages in range for PLT usage Jan 29 11:05:27.049233 kernel: HugeTLB: registered 1.00 GiB page size, pre-allocated 0 pages Jan 29 11:05:27.049240 kernel: HugeTLB: 0 KiB vmemmap can be freed for a 1.00 GiB page Jan 29 11:05:27.049247 kernel: HugeTLB: registered 32.0 MiB page size, pre-allocated 0 pages Jan 29 11:05:27.049255 kernel: HugeTLB: 0 KiB vmemmap can be freed for a 32.0 MiB page Jan 29 11:05:27.049261 kernel: HugeTLB: registered 2.00 MiB page size, pre-allocated 0 pages Jan 29 11:05:27.049269 kernel: HugeTLB: 0 KiB vmemmap can be freed for a 2.00 MiB page Jan 29 11:05:27.049276 kernel: HugeTLB: registered 64.0 KiB page size, pre-allocated 0 pages Jan 29 11:05:27.049284 kernel: HugeTLB: 0 KiB vmemmap can be freed for a 64.0 KiB page Jan 29 11:05:27.049291 kernel: ACPI: Added _OSI(Module Device) Jan 29 11:05:27.049298 kernel: ACPI: Added _OSI(Processor Device) Jan 29 11:05:27.049305 kernel: ACPI: Added _OSI(3.0 _SCP Extensions) Jan 29 11:05:27.049312 kernel: ACPI: Added _OSI(Processor Aggregator Device) Jan 29 11:05:27.049319 kernel: ACPI: 1 ACPI AML tables successfully acquired and loaded Jan 29 11:05:27.049326 kernel: ACPI: Interpreter enabled Jan 29 11:05:27.049333 kernel: ACPI: Using GIC for interrupt routing Jan 29 11:05:27.049339 kernel: ACPI: MCFG table detected, 1 entries Jan 29 11:05:27.049346 kernel: ARMH0011:00: ttyAMA0 at MMIO 0x9000000 (irq = 12, base_baud = 0) is a SBSA Jan 29 11:05:27.049355 kernel: printk: console [ttyAMA0] enabled Jan 29 11:05:27.049362 kernel: ACPI: PCI Root Bridge [PCI0] (domain 0000 [bus 00-ff]) Jan 29 11:05:27.049506 kernel: acpi PNP0A08:00: _OSC: OS supports [ExtendedConfig ASPM ClockPM Segments MSI HPX-Type3] Jan 29 11:05:27.049581 kernel: acpi PNP0A08:00: _OSC: platform does not support [LTR] Jan 29 11:05:27.049647 kernel: acpi PNP0A08:00: _OSC: OS now controls [PCIeHotplug PME AER PCIeCapability] Jan 29 11:05:27.049712 kernel: acpi PNP0A08:00: ECAM area [mem 0x4010000000-0x401fffffff] reserved by PNP0C02:00 Jan 29 11:05:27.049803 kernel: acpi PNP0A08:00: ECAM at [mem 0x4010000000-0x401fffffff] for [bus 00-ff] Jan 29 11:05:27.049816 kernel: ACPI: Remapped I/O 0x000000003eff0000 to [io 0x0000-0xffff window] Jan 29 11:05:27.049826 kernel: PCI host bridge to bus 0000:00 Jan 29 11:05:27.049903 kernel: pci_bus 0000:00: root bus resource [mem 0x10000000-0x3efeffff window] Jan 29 11:05:27.049964 kernel: pci_bus 0000:00: root bus resource [io 0x0000-0xffff window] Jan 29 11:05:27.050025 kernel: pci_bus 0000:00: root bus resource [mem 0x8000000000-0xffffffffff window] Jan 29 11:05:27.050097 kernel: pci_bus 0000:00: root bus resource [bus 00-ff] Jan 29 11:05:27.050179 kernel: pci 0000:00:00.0: [1b36:0008] type 00 class 0x060000 Jan 29 11:05:27.050259 kernel: pci 0000:00:01.0: [1af4:1005] type 00 class 0x00ff00 Jan 29 11:05:27.050326 kernel: pci 0000:00:01.0: reg 0x10: [io 0x0000-0x001f] Jan 29 11:05:27.050390 kernel: pci 0000:00:01.0: reg 0x14: [mem 0x10000000-0x10000fff] Jan 29 11:05:27.050454 kernel: pci 0000:00:01.0: reg 0x20: [mem 0x8000000000-0x8000003fff 64bit pref] Jan 29 11:05:27.050518 kernel: pci 0000:00:01.0: BAR 4: assigned [mem 0x8000000000-0x8000003fff 64bit pref] Jan 29 11:05:27.050584 kernel: pci 0000:00:01.0: BAR 1: assigned [mem 0x10000000-0x10000fff] Jan 29 11:05:27.050649 kernel: pci 0000:00:01.0: BAR 0: assigned [io 0x1000-0x101f] Jan 29 11:05:27.050711 kernel: pci_bus 0000:00: resource 4 [mem 0x10000000-0x3efeffff window] Jan 29 11:05:27.050767 kernel: pci_bus 0000:00: resource 5 [io 0x0000-0xffff window] Jan 29 11:05:27.050856 kernel: pci_bus 0000:00: resource 6 [mem 0x8000000000-0xffffffffff window] Jan 29 11:05:27.050867 kernel: ACPI: PCI: Interrupt link GSI0 configured for IRQ 35 Jan 29 11:05:27.050874 kernel: ACPI: PCI: Interrupt link GSI1 configured for IRQ 36 Jan 29 11:05:27.050881 kernel: ACPI: PCI: Interrupt link GSI2 configured for IRQ 37 Jan 29 11:05:27.050888 kernel: ACPI: PCI: Interrupt link GSI3 configured for IRQ 38 Jan 29 11:05:27.050899 kernel: iommu: Default domain type: Translated Jan 29 11:05:27.050906 kernel: iommu: DMA domain TLB invalidation policy: strict mode Jan 29 11:05:27.050913 kernel: efivars: Registered efivars operations Jan 29 11:05:27.050920 kernel: vgaarb: loaded Jan 29 11:05:27.050927 kernel: clocksource: Switched to clocksource arch_sys_counter Jan 29 11:05:27.050934 kernel: VFS: Disk quotas dquot_6.6.0 Jan 29 11:05:27.050941 kernel: VFS: Dquot-cache hash table entries: 512 (order 0, 4096 bytes) Jan 29 11:05:27.050948 kernel: pnp: PnP ACPI init Jan 29 11:05:27.051024 kernel: system 00:00: [mem 0x4010000000-0x401fffffff window] could not be reserved Jan 29 11:05:27.051046 kernel: pnp: PnP ACPI: found 1 devices Jan 29 11:05:27.051053 kernel: NET: Registered PF_INET protocol family Jan 29 11:05:27.051060 kernel: IP idents hash table entries: 65536 (order: 7, 524288 bytes, linear) Jan 29 11:05:27.051068 kernel: tcp_listen_portaddr_hash hash table entries: 2048 (order: 3, 32768 bytes, linear) Jan 29 11:05:27.051075 kernel: Table-perturb hash table entries: 65536 (order: 6, 262144 bytes, linear) Jan 29 11:05:27.051082 kernel: TCP established hash table entries: 32768 (order: 6, 262144 bytes, linear) Jan 29 11:05:27.051089 kernel: TCP bind hash table entries: 32768 (order: 8, 1048576 bytes, linear) Jan 29 11:05:27.051096 kernel: TCP: Hash tables configured (established 32768 bind 32768) Jan 29 11:05:27.051103 kernel: UDP hash table entries: 2048 (order: 4, 65536 bytes, linear) Jan 29 11:05:27.051112 kernel: UDP-Lite hash table entries: 2048 (order: 4, 65536 bytes, linear) Jan 29 11:05:27.051119 kernel: NET: Registered PF_UNIX/PF_LOCAL protocol family Jan 29 11:05:27.051126 kernel: PCI: CLS 0 bytes, default 64 Jan 29 11:05:27.051133 kernel: kvm [1]: HYP mode not available Jan 29 11:05:27.051140 kernel: Initialise system trusted keyrings Jan 29 11:05:27.051147 kernel: workingset: timestamp_bits=39 max_order=20 bucket_order=0 Jan 29 11:05:27.051154 kernel: Key type asymmetric registered Jan 29 11:05:27.051161 kernel: Asymmetric key parser 'x509' registered Jan 29 11:05:27.051168 kernel: Block layer SCSI generic (bsg) driver version 0.4 loaded (major 250) Jan 29 11:05:27.051177 kernel: io scheduler mq-deadline registered Jan 29 11:05:27.051184 kernel: io scheduler kyber registered Jan 29 11:05:27.051191 kernel: io scheduler bfq registered Jan 29 11:05:27.051199 kernel: input: Power Button as /devices/LNXSYSTM:00/LNXSYBUS:00/PNP0C0C:00/input/input0 Jan 29 11:05:27.051206 kernel: ACPI: button: Power Button [PWRB] Jan 29 11:05:27.051213 kernel: ACPI: \_SB_.PCI0.GSI1: Enabled at IRQ 36 Jan 29 11:05:27.051286 kernel: virtio-pci 0000:00:01.0: enabling device (0005 -> 0007) Jan 29 11:05:27.051296 kernel: Serial: 8250/16550 driver, 4 ports, IRQ sharing enabled Jan 29 11:05:27.051303 kernel: thunder_xcv, ver 1.0 Jan 29 11:05:27.051312 kernel: thunder_bgx, ver 1.0 Jan 29 11:05:27.051319 kernel: nicpf, ver 1.0 Jan 29 11:05:27.051326 kernel: nicvf, ver 1.0 Jan 29 11:05:27.051408 kernel: rtc-efi rtc-efi.0: registered as rtc0 Jan 29 11:05:27.051470 kernel: rtc-efi rtc-efi.0: setting system clock to 2025-01-29T11:05:26 UTC (1738148726) Jan 29 11:05:27.051480 kernel: hid: raw HID events driver (C) Jiri Kosina Jan 29 11:05:27.051487 kernel: hw perfevents: enabled with armv8_pmuv3_0 PMU driver, 7 counters available Jan 29 11:05:27.051494 kernel: watchdog: Delayed init of the lockup detector failed: -19 Jan 29 11:05:27.051503 kernel: watchdog: Hard watchdog permanently disabled Jan 29 11:05:27.051511 kernel: NET: Registered PF_INET6 protocol family Jan 29 11:05:27.051518 kernel: Segment Routing with IPv6 Jan 29 11:05:27.051525 kernel: In-situ OAM (IOAM) with IPv6 Jan 29 11:05:27.051532 kernel: NET: Registered PF_PACKET protocol family Jan 29 11:05:27.051539 kernel: Key type dns_resolver registered Jan 29 11:05:27.051546 kernel: registered taskstats version 1 Jan 29 11:05:27.051553 kernel: Loading compiled-in X.509 certificates Jan 29 11:05:27.051560 kernel: Loaded X.509 cert 'Kinvolk GmbH: Module signing key for 6.6.74-flatcar: c31663d2c680b3b306c17f44b5295280d3a2e28a' Jan 29 11:05:27.051569 kernel: Key type .fscrypt registered Jan 29 11:05:27.051576 kernel: Key type fscrypt-provisioning registered Jan 29 11:05:27.051583 kernel: ima: No TPM chip found, activating TPM-bypass! Jan 29 11:05:27.051590 kernel: ima: Allocated hash algorithm: sha1 Jan 29 11:05:27.051597 kernel: ima: No architecture policies found Jan 29 11:05:27.051604 kernel: alg: No test for fips(ansi_cprng) (fips_ansi_cprng) Jan 29 11:05:27.051611 kernel: clk: Disabling unused clocks Jan 29 11:05:27.051617 kernel: Freeing unused kernel memory: 39936K Jan 29 11:05:27.051624 kernel: Run /init as init process Jan 29 11:05:27.051633 kernel: with arguments: Jan 29 11:05:27.051640 kernel: /init Jan 29 11:05:27.051647 kernel: with environment: Jan 29 11:05:27.051653 kernel: HOME=/ Jan 29 11:05:27.051660 kernel: TERM=linux Jan 29 11:05:27.051667 kernel: BOOT_IMAGE=/flatcar/vmlinuz-a Jan 29 11:05:27.051676 systemd[1]: systemd 255 running in system mode (+PAM +AUDIT +SELINUX -APPARMOR +IMA +SMACK +SECCOMP +GCRYPT -GNUTLS +OPENSSL -ACL +BLKID +CURL +ELFUTILS -FIDO2 +IDN2 -IDN +IPTC +KMOD +LIBCRYPTSETUP +LIBFDISK +PCRE2 -PWQUALITY -P11KIT -QRENCODE +TPM2 +BZIP2 +LZ4 +XZ +ZLIB +ZSTD -BPF_FRAMEWORK -XKBCOMMON +UTMP -SYSVINIT default-hierarchy=unified) Jan 29 11:05:27.051685 systemd[1]: Detected virtualization kvm. Jan 29 11:05:27.051694 systemd[1]: Detected architecture arm64. Jan 29 11:05:27.051701 systemd[1]: Running in initrd. Jan 29 11:05:27.051709 systemd[1]: No hostname configured, using default hostname. Jan 29 11:05:27.051716 systemd[1]: Hostname set to . Jan 29 11:05:27.051724 systemd[1]: Initializing machine ID from VM UUID. Jan 29 11:05:27.051731 systemd[1]: Queued start job for default target initrd.target. Jan 29 11:05:27.051739 systemd[1]: Started clevis-luks-askpass.path - Forward Password Requests to Clevis Directory Watch. Jan 29 11:05:27.051746 systemd[1]: Started systemd-ask-password-console.path - Dispatch Password Requests to Console Directory Watch. Jan 29 11:05:27.051756 systemd[1]: Expecting device dev-disk-by\x2dlabel-EFI\x2dSYSTEM.device - /dev/disk/by-label/EFI-SYSTEM... Jan 29 11:05:27.051764 systemd[1]: Expecting device dev-disk-by\x2dlabel-OEM.device - /dev/disk/by-label/OEM... Jan 29 11:05:27.051772 systemd[1]: Expecting device dev-disk-by\x2dlabel-ROOT.device - /dev/disk/by-label/ROOT... Jan 29 11:05:27.051780 systemd[1]: Expecting device dev-disk-by\x2dpartlabel-USR\x2dA.device - /dev/disk/by-partlabel/USR-A... Jan 29 11:05:27.051789 systemd[1]: Expecting device dev-disk-by\x2dpartuuid-7130c94a\x2d213a\x2d4e5a\x2d8e26\x2d6cce9662f132.device - /dev/disk/by-partuuid/7130c94a-213a-4e5a-8e26-6cce9662f132... Jan 29 11:05:27.051908 systemd[1]: Expecting device dev-mapper-usr.device - /dev/mapper/usr... Jan 29 11:05:27.051919 systemd[1]: Reached target cryptsetup-pre.target - Local Encrypted Volumes (Pre). Jan 29 11:05:27.051927 systemd[1]: Reached target cryptsetup.target - Local Encrypted Volumes. Jan 29 11:05:27.051934 systemd[1]: Reached target paths.target - Path Units. Jan 29 11:05:27.051942 systemd[1]: Reached target slices.target - Slice Units. Jan 29 11:05:27.051950 systemd[1]: Reached target swap.target - Swaps. Jan 29 11:05:27.051958 systemd[1]: Reached target timers.target - Timer Units. Jan 29 11:05:27.051965 systemd[1]: Listening on iscsid.socket - Open-iSCSI iscsid Socket. Jan 29 11:05:27.051973 systemd[1]: Listening on iscsiuio.socket - Open-iSCSI iscsiuio Socket. Jan 29 11:05:27.051981 systemd[1]: Listening on systemd-journald-dev-log.socket - Journal Socket (/dev/log). Jan 29 11:05:27.051990 systemd[1]: Listening on systemd-journald.socket - Journal Socket. Jan 29 11:05:27.051997 systemd[1]: Listening on systemd-networkd.socket - Network Service Netlink Socket. Jan 29 11:05:27.052005 systemd[1]: Listening on systemd-udevd-control.socket - udev Control Socket. Jan 29 11:05:27.052013 systemd[1]: Listening on systemd-udevd-kernel.socket - udev Kernel Socket. Jan 29 11:05:27.052020 systemd[1]: Reached target sockets.target - Socket Units. Jan 29 11:05:27.052034 systemd[1]: Starting ignition-setup-pre.service - Ignition env setup... Jan 29 11:05:27.052043 systemd[1]: Starting kmod-static-nodes.service - Create List of Static Device Nodes... Jan 29 11:05:27.052051 systemd[1]: Finished network-cleanup.service - Network Cleanup. Jan 29 11:05:27.052060 systemd[1]: Starting systemd-fsck-usr.service... Jan 29 11:05:27.052068 systemd[1]: Starting systemd-journald.service - Journal Service... Jan 29 11:05:27.052076 systemd[1]: Starting systemd-modules-load.service - Load Kernel Modules... Jan 29 11:05:27.052084 systemd[1]: Starting systemd-vconsole-setup.service - Virtual Console Setup... Jan 29 11:05:27.052091 systemd[1]: Finished ignition-setup-pre.service - Ignition env setup. Jan 29 11:05:27.052099 systemd[1]: Finished kmod-static-nodes.service - Create List of Static Device Nodes. Jan 29 11:05:27.052106 systemd[1]: Finished systemd-fsck-usr.service. Jan 29 11:05:27.052116 systemd[1]: Starting systemd-tmpfiles-setup-dev-early.service - Create Static Device Nodes in /dev gracefully... Jan 29 11:05:27.052124 systemd[1]: Finished systemd-tmpfiles-setup-dev-early.service - Create Static Device Nodes in /dev gracefully. Jan 29 11:05:27.052132 systemd[1]: Finished systemd-vconsole-setup.service - Virtual Console Setup. Jan 29 11:05:27.052140 systemd[1]: Starting dracut-cmdline-ask.service - dracut ask for additional cmdline parameters... Jan 29 11:05:27.052171 systemd-journald[240]: Collecting audit messages is disabled. Jan 29 11:05:27.052194 systemd[1]: Starting systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev... Jan 29 11:05:27.052202 systemd-journald[240]: Journal started Jan 29 11:05:27.052236 systemd-journald[240]: Runtime Journal (/run/log/journal/2cdb38fd44a84600b858f2b6727bb2e0) is 5.9M, max 47.3M, 41.4M free. Jan 29 11:05:27.044938 systemd-modules-load[241]: Inserted module 'overlay' Jan 29 11:05:27.055699 systemd[1]: Started systemd-journald.service - Journal Service. Jan 29 11:05:27.058319 systemd[1]: Starting systemd-tmpfiles-setup.service - Create System Files and Directories... Jan 29 11:05:27.065993 systemd[1]: Finished systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev. Jan 29 11:05:27.071529 kernel: bridge: filtering via arp/ip/ip6tables is no longer available by default. Update your scripts to load br_netfilter if you need this. Jan 29 11:05:27.071552 kernel: Bridge firewalling registered Jan 29 11:05:27.070195 systemd-modules-load[241]: Inserted module 'br_netfilter' Jan 29 11:05:27.071501 systemd[1]: Finished systemd-modules-load.service - Load Kernel Modules. Jan 29 11:05:27.084024 systemd[1]: Starting systemd-sysctl.service - Apply Kernel Variables... Jan 29 11:05:27.085342 systemd[1]: Finished dracut-cmdline-ask.service - dracut ask for additional cmdline parameters. Jan 29 11:05:27.087592 systemd[1]: Finished systemd-tmpfiles-setup.service - Create System Files and Directories. Jan 29 11:05:27.091287 systemd[1]: Starting dracut-cmdline.service - dracut cmdline hook... Jan 29 11:05:27.096925 systemd[1]: Finished systemd-sysctl.service - Apply Kernel Variables. Jan 29 11:05:27.099589 systemd[1]: Starting systemd-resolved.service - Network Name Resolution... Jan 29 11:05:27.106156 dracut-cmdline[275]: dracut-dracut-053 Jan 29 11:05:27.109105 dracut-cmdline[275]: Using kernel command line parameters: rd.driver.pre=btrfs BOOT_IMAGE=/flatcar/vmlinuz-a mount.usr=/dev/mapper/usr verity.usr=PARTUUID=7130c94a-213a-4e5a-8e26-6cce9662f132 rootflags=rw mount.usrflags=ro consoleblank=0 root=LABEL=ROOT console=ttyS0,115200 flatcar.first_boot=detected acpi=force verity.usrhash=e6957044c3256d96283265c263579aa4275d1d707b02496fcb081f5fc6356346 Jan 29 11:05:27.135976 systemd-resolved[280]: Positive Trust Anchors: Jan 29 11:05:27.136969 systemd-resolved[280]: . IN DS 20326 8 2 e06d44b80b8f1d39a95c0b0d7c65d08458e880409bbc683457104237c7f8ec8d Jan 29 11:05:27.137003 systemd-resolved[280]: Negative trust anchors: home.arpa 10.in-addr.arpa 16.172.in-addr.arpa 17.172.in-addr.arpa 18.172.in-addr.arpa 19.172.in-addr.arpa 20.172.in-addr.arpa 21.172.in-addr.arpa 22.172.in-addr.arpa 23.172.in-addr.arpa 24.172.in-addr.arpa 25.172.in-addr.arpa 26.172.in-addr.arpa 27.172.in-addr.arpa 28.172.in-addr.arpa 29.172.in-addr.arpa 30.172.in-addr.arpa 31.172.in-addr.arpa 170.0.0.192.in-addr.arpa 171.0.0.192.in-addr.arpa 168.192.in-addr.arpa d.f.ip6.arpa ipv4only.arpa resolver.arpa corp home internal intranet lan local private test Jan 29 11:05:27.151775 systemd-resolved[280]: Defaulting to hostname 'linux'. Jan 29 11:05:27.156266 systemd[1]: Started systemd-resolved.service - Network Name Resolution. Jan 29 11:05:27.157451 systemd[1]: Reached target nss-lookup.target - Host and Network Name Lookups. Jan 29 11:05:27.190823 kernel: SCSI subsystem initialized Jan 29 11:05:27.195812 kernel: Loading iSCSI transport class v2.0-870. Jan 29 11:05:27.202818 kernel: iscsi: registered transport (tcp) Jan 29 11:05:27.218816 kernel: iscsi: registered transport (qla4xxx) Jan 29 11:05:27.218831 kernel: QLogic iSCSI HBA Driver Jan 29 11:05:27.264692 systemd[1]: Finished dracut-cmdline.service - dracut cmdline hook. Jan 29 11:05:27.270978 systemd[1]: Starting dracut-pre-udev.service - dracut pre-udev hook... Jan 29 11:05:27.286327 kernel: device-mapper: core: CONFIG_IMA_DISABLE_HTABLE is disabled. Duplicate IMA measurements will not be recorded in the IMA log. Jan 29 11:05:27.286371 kernel: device-mapper: uevent: version 1.0.3 Jan 29 11:05:27.287436 kernel: device-mapper: ioctl: 4.48.0-ioctl (2023-03-01) initialised: dm-devel@redhat.com Jan 29 11:05:27.334872 kernel: raid6: neonx8 gen() 15782 MB/s Jan 29 11:05:27.351821 kernel: raid6: neonx4 gen() 15793 MB/s Jan 29 11:05:27.368818 kernel: raid6: neonx2 gen() 13190 MB/s Jan 29 11:05:27.385819 kernel: raid6: neonx1 gen() 10441 MB/s Jan 29 11:05:27.402828 kernel: raid6: int64x8 gen() 6785 MB/s Jan 29 11:05:27.419817 kernel: raid6: int64x4 gen() 7340 MB/s Jan 29 11:05:27.436818 kernel: raid6: int64x2 gen() 6105 MB/s Jan 29 11:05:27.453915 kernel: raid6: int64x1 gen() 5055 MB/s Jan 29 11:05:27.453926 kernel: raid6: using algorithm neonx4 gen() 15793 MB/s Jan 29 11:05:27.471902 kernel: raid6: .... xor() 12369 MB/s, rmw enabled Jan 29 11:05:27.471916 kernel: raid6: using neon recovery algorithm Jan 29 11:05:27.477258 kernel: xor: measuring software checksum speed Jan 29 11:05:27.477273 kernel: 8regs : 21618 MB/sec Jan 29 11:05:27.477912 kernel: 32regs : 21699 MB/sec Jan 29 11:05:27.479159 kernel: arm64_neon : 26510 MB/sec Jan 29 11:05:27.479181 kernel: xor: using function: arm64_neon (26510 MB/sec) Jan 29 11:05:27.529141 kernel: Btrfs loaded, zoned=no, fsverity=no Jan 29 11:05:27.540326 systemd[1]: Finished dracut-pre-udev.service - dracut pre-udev hook. Jan 29 11:05:27.549965 systemd[1]: Starting systemd-udevd.service - Rule-based Manager for Device Events and Files... Jan 29 11:05:27.561985 systemd-udevd[461]: Using default interface naming scheme 'v255'. Jan 29 11:05:27.565054 systemd[1]: Started systemd-udevd.service - Rule-based Manager for Device Events and Files. Jan 29 11:05:27.571944 systemd[1]: Starting dracut-pre-trigger.service - dracut pre-trigger hook... Jan 29 11:05:27.583076 dracut-pre-trigger[468]: rd.md=0: removing MD RAID activation Jan 29 11:05:27.609663 systemd[1]: Finished dracut-pre-trigger.service - dracut pre-trigger hook. Jan 29 11:05:27.620001 systemd[1]: Starting systemd-udev-trigger.service - Coldplug All udev Devices... Jan 29 11:05:27.659869 systemd[1]: Finished systemd-udev-trigger.service - Coldplug All udev Devices. Jan 29 11:05:27.665969 systemd[1]: Starting dracut-initqueue.service - dracut initqueue hook... Jan 29 11:05:27.678821 systemd[1]: Finished dracut-initqueue.service - dracut initqueue hook. Jan 29 11:05:27.680655 systemd[1]: Reached target remote-fs-pre.target - Preparation for Remote File Systems. Jan 29 11:05:27.681988 systemd[1]: Reached target remote-cryptsetup.target - Remote Encrypted Volumes. Jan 29 11:05:27.684231 systemd[1]: Reached target remote-fs.target - Remote File Systems. Jan 29 11:05:27.690954 systemd[1]: Starting dracut-pre-mount.service - dracut pre-mount hook... Jan 29 11:05:27.703247 systemd[1]: Finished dracut-pre-mount.service - dracut pre-mount hook. Jan 29 11:05:27.709258 kernel: virtio_blk virtio1: 1/0/0 default/read/poll queues Jan 29 11:05:27.718399 kernel: virtio_blk virtio1: [vda] 9289728 512-byte logical blocks (4.76 GB/4.43 GiB) Jan 29 11:05:27.718573 kernel: vda: vda1 vda2 vda3 vda4 vda6 vda7 vda9 Jan 29 11:05:27.715697 systemd[1]: dracut-cmdline-ask.service: Deactivated successfully. Jan 29 11:05:27.715923 systemd[1]: Stopped dracut-cmdline-ask.service - dracut ask for additional cmdline parameters. Jan 29 11:05:27.718295 systemd[1]: Stopping dracut-cmdline-ask.service - dracut ask for additional cmdline parameters... Jan 29 11:05:27.719447 systemd[1]: systemd-vconsole-setup.service: Deactivated successfully. Jan 29 11:05:27.719635 systemd[1]: Stopped systemd-vconsole-setup.service - Virtual Console Setup. Jan 29 11:05:27.721482 systemd[1]: Stopping systemd-vconsole-setup.service - Virtual Console Setup... Jan 29 11:05:27.734020 systemd[1]: Starting systemd-vconsole-setup.service - Virtual Console Setup... Jan 29 11:05:27.746813 kernel: BTRFS: device fsid 1e2e5fa7-c757-4d5d-af66-73afe98fbaae devid 1 transid 39 /dev/vda3 scanned by (udev-worker) (513) Jan 29 11:05:27.749810 kernel: BTRFS: device label OEM devid 1 transid 14 /dev/vda6 scanned by (udev-worker) (508) Jan 29 11:05:27.749790 systemd[1]: Finished systemd-vconsole-setup.service - Virtual Console Setup. Jan 29 11:05:27.755888 systemd[1]: Found device dev-disk-by\x2dlabel-ROOT.device - /dev/disk/by-label/ROOT. Jan 29 11:05:27.762992 systemd[1]: Found device dev-disk-by\x2dlabel-EFI\x2dSYSTEM.device - /dev/disk/by-label/EFI-SYSTEM. Jan 29 11:05:27.766921 systemd[1]: Found device dev-disk-by\x2dpartuuid-7130c94a\x2d213a\x2d4e5a\x2d8e26\x2d6cce9662f132.device - /dev/disk/by-partuuid/7130c94a-213a-4e5a-8e26-6cce9662f132. Jan 29 11:05:27.768149 systemd[1]: Found device dev-disk-by\x2dpartlabel-USR\x2dA.device - /dev/disk/by-partlabel/USR-A. Jan 29 11:05:27.774664 systemd[1]: Found device dev-disk-by\x2dlabel-OEM.device - /dev/disk/by-label/OEM. Jan 29 11:05:27.787990 systemd[1]: Starting disk-uuid.service - Generate new UUID for disk GPT if necessary... Jan 29 11:05:27.789917 systemd[1]: Starting dracut-cmdline-ask.service - dracut ask for additional cmdline parameters... Jan 29 11:05:27.799489 kernel: vda: vda1 vda2 vda3 vda4 vda6 vda7 vda9 Jan 29 11:05:27.811700 systemd[1]: Finished dracut-cmdline-ask.service - dracut ask for additional cmdline parameters. Jan 29 11:05:28.814829 kernel: vda: vda1 vda2 vda3 vda4 vda6 vda7 vda9 Jan 29 11:05:28.815185 disk-uuid[552]: The operation has completed successfully. Jan 29 11:05:28.840409 systemd[1]: disk-uuid.service: Deactivated successfully. Jan 29 11:05:28.841681 systemd[1]: Finished disk-uuid.service - Generate new UUID for disk GPT if necessary. Jan 29 11:05:28.867969 systemd[1]: Starting verity-setup.service - Verity Setup for /dev/mapper/usr... Jan 29 11:05:28.874538 sh[572]: Success Jan 29 11:05:28.890846 kernel: device-mapper: verity: sha256 using implementation "sha256-ce" Jan 29 11:05:28.930310 systemd[1]: Found device dev-mapper-usr.device - /dev/mapper/usr. Jan 29 11:05:28.932338 systemd[1]: Mounting sysusr-usr.mount - /sysusr/usr... Jan 29 11:05:28.933394 systemd[1]: Finished verity-setup.service - Verity Setup for /dev/mapper/usr. Jan 29 11:05:28.945296 kernel: BTRFS info (device dm-0): first mount of filesystem 1e2e5fa7-c757-4d5d-af66-73afe98fbaae Jan 29 11:05:28.945339 kernel: BTRFS info (device dm-0): using crc32c (crc32c-generic) checksum algorithm Jan 29 11:05:28.945350 kernel: BTRFS warning (device dm-0): 'nologreplay' is deprecated, use 'rescue=nologreplay' instead Jan 29 11:05:28.947306 kernel: BTRFS info (device dm-0): disabling log replay at mount time Jan 29 11:05:28.947323 kernel: BTRFS info (device dm-0): using free space tree Jan 29 11:05:28.951305 systemd[1]: Mounted sysusr-usr.mount - /sysusr/usr. Jan 29 11:05:28.952845 systemd[1]: afterburn-network-kargs.service - Afterburn Initrd Setup Network Kernel Arguments was skipped because no trigger condition checks were met. Jan 29 11:05:28.963972 systemd[1]: Starting ignition-setup.service - Ignition (setup)... Jan 29 11:05:28.965626 systemd[1]: Starting parse-ip-for-networkd.service - Write systemd-networkd units from cmdline... Jan 29 11:05:28.975238 kernel: BTRFS info (device vda6): first mount of filesystem 5265f28b-8d78-4be2-8b05-2145d9ab7cfa Jan 29 11:05:28.975285 kernel: BTRFS info (device vda6): using crc32c (crc32c-generic) checksum algorithm Jan 29 11:05:28.975302 kernel: BTRFS info (device vda6): using free space tree Jan 29 11:05:28.978851 kernel: BTRFS info (device vda6): auto enabling async discard Jan 29 11:05:28.985967 systemd[1]: mnt-oem.mount: Deactivated successfully. Jan 29 11:05:28.988030 kernel: BTRFS info (device vda6): last unmount of filesystem 5265f28b-8d78-4be2-8b05-2145d9ab7cfa Jan 29 11:05:29.023815 systemd[1]: Finished ignition-setup.service - Ignition (setup). Jan 29 11:05:29.029983 systemd[1]: Starting ignition-fetch-offline.service - Ignition (fetch-offline)... Jan 29 11:05:29.056841 systemd[1]: Finished parse-ip-for-networkd.service - Write systemd-networkd units from cmdline. Jan 29 11:05:29.068000 systemd[1]: Starting systemd-networkd.service - Network Configuration... Jan 29 11:05:29.098827 systemd-networkd[759]: lo: Link UP Jan 29 11:05:29.099737 systemd-networkd[759]: lo: Gained carrier Jan 29 11:05:29.101405 systemd-networkd[759]: Enumeration completed Jan 29 11:05:29.101521 systemd[1]: Started systemd-networkd.service - Network Configuration. Jan 29 11:05:29.101867 systemd-networkd[759]: eth0: found matching network '/usr/lib/systemd/network/zz-default.network', based on potentially unpredictable interface name. Jan 29 11:05:29.101870 systemd-networkd[759]: eth0: Configuring with /usr/lib/systemd/network/zz-default.network. Jan 29 11:05:29.102682 systemd-networkd[759]: eth0: Link UP Jan 29 11:05:29.102684 systemd-networkd[759]: eth0: Gained carrier Jan 29 11:05:29.102691 systemd-networkd[759]: eth0: found matching network '/usr/lib/systemd/network/zz-default.network', based on potentially unpredictable interface name. Jan 29 11:05:29.103583 systemd[1]: Reached target network.target - Network. Jan 29 11:05:29.124859 systemd-networkd[759]: eth0: DHCPv4 address 10.0.0.110/16, gateway 10.0.0.1 acquired from 10.0.0.1 Jan 29 11:05:29.149706 ignition[718]: Ignition 2.20.0 Jan 29 11:05:29.149717 ignition[718]: Stage: fetch-offline Jan 29 11:05:29.149753 ignition[718]: no configs at "/usr/lib/ignition/base.d" Jan 29 11:05:29.149762 ignition[718]: no config dir at "/usr/lib/ignition/base.platform.d/qemu" Jan 29 11:05:29.149966 ignition[718]: parsed url from cmdline: "" Jan 29 11:05:29.149970 ignition[718]: no config URL provided Jan 29 11:05:29.149974 ignition[718]: reading system config file "/usr/lib/ignition/user.ign" Jan 29 11:05:29.149984 ignition[718]: no config at "/usr/lib/ignition/user.ign" Jan 29 11:05:29.150011 ignition[718]: op(1): [started] loading QEMU firmware config module Jan 29 11:05:29.150015 ignition[718]: op(1): executing: "modprobe" "qemu_fw_cfg" Jan 29 11:05:29.154870 ignition[718]: op(1): [finished] loading QEMU firmware config module Jan 29 11:05:29.160588 ignition[718]: parsing config with SHA512: 06aaea81593a6ffc64c86bfa080f292f32033c9aaf9d50ded80f3cfa2263cc9eb7b5c2229e570c83593dd4872052843342c34002b87bed74de6a1fcbf787ea83 Jan 29 11:05:29.170409 unknown[718]: fetched base config from "system" Jan 29 11:05:29.170420 unknown[718]: fetched user config from "qemu" Jan 29 11:05:29.170676 ignition[718]: fetch-offline: fetch-offline passed Jan 29 11:05:29.172320 systemd[1]: Finished ignition-fetch-offline.service - Ignition (fetch-offline). Jan 29 11:05:29.170763 ignition[718]: Ignition finished successfully Jan 29 11:05:29.174304 systemd[1]: ignition-fetch.service - Ignition (fetch) was skipped because of an unmet condition check (ConditionPathExists=!/run/ignition.json). Jan 29 11:05:29.184986 systemd[1]: Starting ignition-kargs.service - Ignition (kargs)... Jan 29 11:05:29.194730 ignition[773]: Ignition 2.20.0 Jan 29 11:05:29.194740 ignition[773]: Stage: kargs Jan 29 11:05:29.194924 ignition[773]: no configs at "/usr/lib/ignition/base.d" Jan 29 11:05:29.194934 ignition[773]: no config dir at "/usr/lib/ignition/base.platform.d/qemu" Jan 29 11:05:29.198426 systemd[1]: Finished ignition-kargs.service - Ignition (kargs). Jan 29 11:05:29.195592 ignition[773]: kargs: kargs passed Jan 29 11:05:29.195632 ignition[773]: Ignition finished successfully Jan 29 11:05:29.209962 systemd[1]: Starting ignition-disks.service - Ignition (disks)... Jan 29 11:05:29.220444 ignition[782]: Ignition 2.20.0 Jan 29 11:05:29.220455 ignition[782]: Stage: disks Jan 29 11:05:29.220644 ignition[782]: no configs at "/usr/lib/ignition/base.d" Jan 29 11:05:29.223192 systemd[1]: Finished ignition-disks.service - Ignition (disks). Jan 29 11:05:29.220653 ignition[782]: no config dir at "/usr/lib/ignition/base.platform.d/qemu" Jan 29 11:05:29.224749 systemd[1]: Reached target initrd-root-device.target - Initrd Root Device. Jan 29 11:05:29.221384 ignition[782]: disks: disks passed Jan 29 11:05:29.226441 systemd[1]: Reached target local-fs-pre.target - Preparation for Local File Systems. Jan 29 11:05:29.221427 ignition[782]: Ignition finished successfully Jan 29 11:05:29.228476 systemd[1]: Reached target local-fs.target - Local File Systems. Jan 29 11:05:29.230327 systemd[1]: Reached target sysinit.target - System Initialization. Jan 29 11:05:29.231843 systemd[1]: Reached target basic.target - Basic System. Jan 29 11:05:29.242969 systemd[1]: Starting systemd-fsck-root.service - File System Check on /dev/disk/by-label/ROOT... Jan 29 11:05:29.253046 systemd-fsck[792]: ROOT: clean, 14/553520 files, 52654/553472 blocks Jan 29 11:05:29.257228 systemd[1]: Finished systemd-fsck-root.service - File System Check on /dev/disk/by-label/ROOT. Jan 29 11:05:29.259817 systemd[1]: Mounting sysroot.mount - /sysroot... Jan 29 11:05:29.314815 kernel: EXT4-fs (vda9): mounted filesystem 88903c49-366d-43ff-90b1-141790b6e85c r/w with ordered data mode. Quota mode: none. Jan 29 11:05:29.315595 systemd[1]: Mounted sysroot.mount - /sysroot. Jan 29 11:05:29.316950 systemd[1]: Reached target initrd-root-fs.target - Initrd Root File System. Jan 29 11:05:29.328883 systemd[1]: Mounting sysroot-oem.mount - /sysroot/oem... Jan 29 11:05:29.330627 systemd[1]: Mounting sysroot-usr.mount - /sysroot/usr... Jan 29 11:05:29.332026 systemd[1]: flatcar-metadata-hostname.service - Flatcar Metadata Hostname Agent was skipped because no trigger condition checks were met. Jan 29 11:05:29.332078 systemd[1]: ignition-remount-sysroot.service - Remount /sysroot read-write for Ignition was skipped because of an unmet condition check (ConditionPathIsReadWrite=!/sysroot). Jan 29 11:05:29.342393 kernel: BTRFS: device label OEM devid 1 transid 15 /dev/vda6 scanned by mount (800) Jan 29 11:05:29.342417 kernel: BTRFS info (device vda6): first mount of filesystem 5265f28b-8d78-4be2-8b05-2145d9ab7cfa Jan 29 11:05:29.342428 kernel: BTRFS info (device vda6): using crc32c (crc32c-generic) checksum algorithm Jan 29 11:05:29.342438 kernel: BTRFS info (device vda6): using free space tree Jan 29 11:05:29.332100 systemd[1]: Reached target ignition-diskful.target - Ignition Boot Disk Setup. Jan 29 11:05:29.345303 kernel: BTRFS info (device vda6): auto enabling async discard Jan 29 11:05:29.336789 systemd[1]: Mounted sysroot-usr.mount - /sysroot/usr. Jan 29 11:05:29.340585 systemd[1]: Starting initrd-setup-root.service - Root filesystem setup... Jan 29 11:05:29.346746 systemd[1]: Mounted sysroot-oem.mount - /sysroot/oem. Jan 29 11:05:29.383838 initrd-setup-root[824]: cut: /sysroot/etc/passwd: No such file or directory Jan 29 11:05:29.387950 initrd-setup-root[831]: cut: /sysroot/etc/group: No such file or directory Jan 29 11:05:29.392106 initrd-setup-root[838]: cut: /sysroot/etc/shadow: No such file or directory Jan 29 11:05:29.395698 initrd-setup-root[845]: cut: /sysroot/etc/gshadow: No such file or directory Jan 29 11:05:29.467870 systemd[1]: Finished initrd-setup-root.service - Root filesystem setup. Jan 29 11:05:29.477930 systemd[1]: Starting ignition-mount.service - Ignition (mount)... Jan 29 11:05:29.479554 systemd[1]: Starting sysroot-boot.service - /sysroot/boot... Jan 29 11:05:29.485811 kernel: BTRFS info (device vda6): last unmount of filesystem 5265f28b-8d78-4be2-8b05-2145d9ab7cfa Jan 29 11:05:29.501607 systemd[1]: Finished sysroot-boot.service - /sysroot/boot. Jan 29 11:05:29.504323 ignition[913]: INFO : Ignition 2.20.0 Jan 29 11:05:29.504323 ignition[913]: INFO : Stage: mount Jan 29 11:05:29.504323 ignition[913]: INFO : no configs at "/usr/lib/ignition/base.d" Jan 29 11:05:29.504323 ignition[913]: INFO : no config dir at "/usr/lib/ignition/base.platform.d/qemu" Jan 29 11:05:29.504323 ignition[913]: INFO : mount: mount passed Jan 29 11:05:29.504323 ignition[913]: INFO : Ignition finished successfully Jan 29 11:05:29.504737 systemd[1]: Finished ignition-mount.service - Ignition (mount). Jan 29 11:05:29.510889 systemd[1]: Starting ignition-files.service - Ignition (files)... Jan 29 11:05:29.944093 systemd[1]: sysroot-oem.mount: Deactivated successfully. Jan 29 11:05:29.954988 systemd[1]: Mounting sysroot-oem.mount - /sysroot/oem... Jan 29 11:05:29.960819 kernel: BTRFS: device label OEM devid 1 transid 16 /dev/vda6 scanned by mount (926) Jan 29 11:05:29.963420 kernel: BTRFS info (device vda6): first mount of filesystem 5265f28b-8d78-4be2-8b05-2145d9ab7cfa Jan 29 11:05:29.963450 kernel: BTRFS info (device vda6): using crc32c (crc32c-generic) checksum algorithm Jan 29 11:05:29.963460 kernel: BTRFS info (device vda6): using free space tree Jan 29 11:05:29.966824 kernel: BTRFS info (device vda6): auto enabling async discard Jan 29 11:05:29.967331 systemd[1]: Mounted sysroot-oem.mount - /sysroot/oem. Jan 29 11:05:29.983303 ignition[943]: INFO : Ignition 2.20.0 Jan 29 11:05:29.983303 ignition[943]: INFO : Stage: files Jan 29 11:05:29.985065 ignition[943]: INFO : no configs at "/usr/lib/ignition/base.d" Jan 29 11:05:29.985065 ignition[943]: INFO : no config dir at "/usr/lib/ignition/base.platform.d/qemu" Jan 29 11:05:29.985065 ignition[943]: DEBUG : files: compiled without relabeling support, skipping Jan 29 11:05:29.993335 ignition[943]: INFO : files: ensureUsers: op(1): [started] creating or modifying user "dockremap" Jan 29 11:05:29.993335 ignition[943]: DEBUG : files: ensureUsers: op(1): executing: "useradd" "--root" "/sysroot" "--create-home" "--password" "*" "dockremap" Jan 29 11:05:30.065368 ignition[943]: INFO : files: ensureUsers: op(1): [finished] creating or modifying user "dockremap" Jan 29 11:05:30.066874 ignition[943]: INFO : files: ensureUsers: op(2): [started] creating or modifying user "core" Jan 29 11:05:30.066874 ignition[943]: DEBUG : files: ensureUsers: op(2): executing: "usermod" "--root" "/sysroot" "core" Jan 29 11:05:30.066874 ignition[943]: INFO : files: ensureUsers: op(2): [finished] creating or modifying user "core" Jan 29 11:05:30.071303 ignition[943]: INFO : files: ensureUsers: op(3): [started] adding ssh keys to user "core" Jan 29 11:05:30.071303 ignition[943]: INFO : files: ensureUsers: op(3): [finished] adding ssh keys to user "core" Jan 29 11:05:30.071303 ignition[943]: INFO : files: createFilesystemsFiles: createFiles: op(4): [started] writing file "/sysroot/etc/subuid" Jan 29 11:05:30.071303 ignition[943]: INFO : files: createFilesystemsFiles: createFiles: op(4): [finished] writing file "/sysroot/etc/subuid" Jan 29 11:05:30.071303 ignition[943]: INFO : files: createFilesystemsFiles: createFiles: op(5): [started] writing file "/sysroot/etc/subgid" Jan 29 11:05:30.071303 ignition[943]: INFO : files: createFilesystemsFiles: createFiles: op(5): [finished] writing file "/sysroot/etc/subgid" Jan 29 11:05:30.071303 ignition[943]: INFO : files: createFilesystemsFiles: createFiles: op(6): [started] writing file "/sysroot/etc/flatcar/update.conf" Jan 29 11:05:30.071303 ignition[943]: INFO : files: createFilesystemsFiles: createFiles: op(6): [finished] writing file "/sysroot/etc/flatcar/update.conf" Jan 29 11:05:30.071303 ignition[943]: INFO : files: op(7): [started] processing unit "coreos-metadata.service" Jan 29 11:05:30.071303 ignition[943]: INFO : files: op(7): op(8): [started] writing unit "coreos-metadata.service" at "/sysroot/etc/systemd/system/coreos-metadata.service" Jan 29 11:05:30.071303 ignition[943]: INFO : files: op(7): op(8): [finished] writing unit "coreos-metadata.service" at "/sysroot/etc/systemd/system/coreos-metadata.service" Jan 29 11:05:30.071303 ignition[943]: INFO : files: op(7): [finished] processing unit "coreos-metadata.service" Jan 29 11:05:30.071303 ignition[943]: INFO : files: op(9): [started] processing unit "docker.service" Jan 29 11:05:30.071303 ignition[943]: INFO : files: op(9): op(a): [started] writing systemd drop-in "10-userns.conf" at "/sysroot/etc/systemd/system/docker.service.d/10-userns.conf" Jan 29 11:05:30.071303 ignition[943]: INFO : files: op(9): op(a): [finished] writing systemd drop-in "10-userns.conf" at "/sysroot/etc/systemd/system/docker.service.d/10-userns.conf" Jan 29 11:05:30.071303 ignition[943]: INFO : files: op(9): [finished] processing unit "docker.service" Jan 29 11:05:30.071303 ignition[943]: INFO : files: op(b): [started] setting preset to disabled for "coreos-metadata.service" Jan 29 11:05:30.067374 unknown[943]: wrote ssh authorized keys file for user: core Jan 29 11:05:30.099887 ignition[943]: INFO : files: op(b): op(c): [started] removing enablement symlink(s) for "coreos-metadata.service" Jan 29 11:05:30.099887 ignition[943]: INFO : files: op(b): op(c): [finished] removing enablement symlink(s) for "coreos-metadata.service" Jan 29 11:05:30.099887 ignition[943]: INFO : files: op(b): [finished] setting preset to disabled for "coreos-metadata.service" Jan 29 11:05:30.099887 ignition[943]: INFO : files: op(d): [started] setting preset to enabled for "docker.service" Jan 29 11:05:30.099887 ignition[943]: INFO : files: op(d): [finished] setting preset to enabled for "docker.service" Jan 29 11:05:30.099887 ignition[943]: INFO : files: createResultFile: createFiles: op(e): [started] writing file "/sysroot/etc/.ignition-result.json" Jan 29 11:05:30.099887 ignition[943]: INFO : files: createResultFile: createFiles: op(e): [finished] writing file "/sysroot/etc/.ignition-result.json" Jan 29 11:05:30.099887 ignition[943]: INFO : files: files passed Jan 29 11:05:30.099887 ignition[943]: INFO : Ignition finished successfully Jan 29 11:05:30.090835 systemd[1]: Finished ignition-files.service - Ignition (files). Jan 29 11:05:30.099965 systemd[1]: Starting ignition-quench.service - Ignition (record completion)... Jan 29 11:05:30.103755 systemd[1]: Starting initrd-setup-root-after-ignition.service - Root filesystem completion... Jan 29 11:05:30.106066 systemd[1]: ignition-quench.service: Deactivated successfully. Jan 29 11:05:30.120559 initrd-setup-root-after-ignition[981]: grep: /sysroot/oem/oem-release: No such file or directory Jan 29 11:05:30.106162 systemd[1]: Finished ignition-quench.service - Ignition (record completion). Jan 29 11:05:30.123962 initrd-setup-root-after-ignition[983]: grep: /sysroot/etc/flatcar/enabled-sysext.conf: No such file or directory Jan 29 11:05:30.123962 initrd-setup-root-after-ignition[983]: grep: /sysroot/usr/share/flatcar/enabled-sysext.conf: No such file or directory Jan 29 11:05:30.117834 systemd[1]: Finished initrd-setup-root-after-ignition.service - Root filesystem completion. Jan 29 11:05:30.129166 initrd-setup-root-after-ignition[987]: grep: /sysroot/etc/flatcar/enabled-sysext.conf: No such file or directory Jan 29 11:05:30.120227 systemd[1]: Reached target ignition-complete.target - Ignition Complete. Jan 29 11:05:30.125950 systemd[1]: Starting initrd-parse-etc.service - Mountpoints Configured in the Real Root... Jan 29 11:05:30.143942 systemd[1]: initrd-parse-etc.service: Deactivated successfully. Jan 29 11:05:30.144953 systemd[1]: Finished initrd-parse-etc.service - Mountpoints Configured in the Real Root. Jan 29 11:05:30.146416 systemd[1]: Reached target initrd-fs.target - Initrd File Systems. Jan 29 11:05:30.148850 systemd[1]: Reached target initrd.target - Initrd Default Target. Jan 29 11:05:30.150660 systemd[1]: dracut-mount.service - dracut mount hook was skipped because no trigger condition checks were met. Jan 29 11:05:30.151400 systemd[1]: Starting dracut-pre-pivot.service - dracut pre-pivot and cleanup hook... Jan 29 11:05:30.166257 systemd[1]: Finished dracut-pre-pivot.service - dracut pre-pivot and cleanup hook. Jan 29 11:05:30.171938 systemd[1]: Starting initrd-cleanup.service - Cleaning Up and Shutting Down Daemons... Jan 29 11:05:30.179106 systemd[1]: Stopped target nss-lookup.target - Host and Network Name Lookups. Jan 29 11:05:30.180320 systemd[1]: Stopped target remote-cryptsetup.target - Remote Encrypted Volumes. Jan 29 11:05:30.182327 systemd[1]: Stopped target timers.target - Timer Units. Jan 29 11:05:30.184084 systemd[1]: dracut-pre-pivot.service: Deactivated successfully. Jan 29 11:05:30.184201 systemd[1]: Stopped dracut-pre-pivot.service - dracut pre-pivot and cleanup hook. Jan 29 11:05:30.186659 systemd[1]: Stopped target initrd.target - Initrd Default Target. Jan 29 11:05:30.187754 systemd[1]: Stopped target basic.target - Basic System. Jan 29 11:05:30.189583 systemd[1]: Stopped target ignition-complete.target - Ignition Complete. Jan 29 11:05:30.191413 systemd[1]: Stopped target ignition-diskful.target - Ignition Boot Disk Setup. Jan 29 11:05:30.193189 systemd[1]: Stopped target initrd-root-device.target - Initrd Root Device. Jan 29 11:05:30.195091 systemd[1]: Stopped target remote-fs.target - Remote File Systems. Jan 29 11:05:30.196910 systemd[1]: Stopped target remote-fs-pre.target - Preparation for Remote File Systems. Jan 29 11:05:30.198950 systemd[1]: Stopped target sysinit.target - System Initialization. Jan 29 11:05:30.200674 systemd[1]: Stopped target local-fs.target - Local File Systems. Jan 29 11:05:30.202612 systemd[1]: Stopped target swap.target - Swaps. Jan 29 11:05:30.204158 systemd[1]: dracut-pre-mount.service: Deactivated successfully. Jan 29 11:05:30.204272 systemd[1]: Stopped dracut-pre-mount.service - dracut pre-mount hook. Jan 29 11:05:30.206498 systemd[1]: Stopped target cryptsetup.target - Local Encrypted Volumes. Jan 29 11:05:30.207694 systemd[1]: Stopped target cryptsetup-pre.target - Local Encrypted Volumes (Pre). Jan 29 11:05:30.209585 systemd[1]: clevis-luks-askpass.path: Deactivated successfully. Jan 29 11:05:30.212861 systemd[1]: Stopped clevis-luks-askpass.path - Forward Password Requests to Clevis Directory Watch. Jan 29 11:05:30.214867 systemd[1]: dracut-initqueue.service: Deactivated successfully. Jan 29 11:05:30.214976 systemd[1]: Stopped dracut-initqueue.service - dracut initqueue hook. Jan 29 11:05:30.217742 systemd[1]: ignition-fetch-offline.service: Deactivated successfully. Jan 29 11:05:30.217879 systemd[1]: Stopped ignition-fetch-offline.service - Ignition (fetch-offline). Jan 29 11:05:30.219897 systemd[1]: Stopped target paths.target - Path Units. Jan 29 11:05:30.221536 systemd[1]: systemd-ask-password-console.path: Deactivated successfully. Jan 29 11:05:30.226852 systemd[1]: Stopped systemd-ask-password-console.path - Dispatch Password Requests to Console Directory Watch. Jan 29 11:05:30.228124 systemd[1]: Stopped target slices.target - Slice Units. Jan 29 11:05:30.230163 systemd[1]: Stopped target sockets.target - Socket Units. Jan 29 11:05:30.231700 systemd[1]: iscsid.socket: Deactivated successfully. Jan 29 11:05:30.231788 systemd[1]: Closed iscsid.socket - Open-iSCSI iscsid Socket. Jan 29 11:05:30.233337 systemd[1]: iscsiuio.socket: Deactivated successfully. Jan 29 11:05:30.233419 systemd[1]: Closed iscsiuio.socket - Open-iSCSI iscsiuio Socket. Jan 29 11:05:30.234919 systemd[1]: initrd-setup-root-after-ignition.service: Deactivated successfully. Jan 29 11:05:30.235025 systemd[1]: Stopped initrd-setup-root-after-ignition.service - Root filesystem completion. Jan 29 11:05:30.236810 systemd[1]: ignition-files.service: Deactivated successfully. Jan 29 11:05:30.236913 systemd[1]: Stopped ignition-files.service - Ignition (files). Jan 29 11:05:30.248998 systemd[1]: Stopping ignition-mount.service - Ignition (mount)... Jan 29 11:05:30.249889 systemd[1]: kmod-static-nodes.service: Deactivated successfully. Jan 29 11:05:30.250018 systemd[1]: Stopped kmod-static-nodes.service - Create List of Static Device Nodes. Jan 29 11:05:30.253116 systemd[1]: Stopping sysroot-boot.service - /sysroot/boot... Jan 29 11:05:30.254605 systemd[1]: systemd-udev-trigger.service: Deactivated successfully. Jan 29 11:05:30.254732 systemd[1]: Stopped systemd-udev-trigger.service - Coldplug All udev Devices. Jan 29 11:05:30.258444 systemd[1]: dracut-pre-trigger.service: Deactivated successfully. Jan 29 11:05:30.258616 systemd[1]: Stopped dracut-pre-trigger.service - dracut pre-trigger hook. Jan 29 11:05:30.261933 ignition[1008]: INFO : Ignition 2.20.0 Jan 29 11:05:30.261933 ignition[1008]: INFO : Stage: umount Jan 29 11:05:30.261933 ignition[1008]: INFO : no configs at "/usr/lib/ignition/base.d" Jan 29 11:05:30.261933 ignition[1008]: INFO : no config dir at "/usr/lib/ignition/base.platform.d/qemu" Jan 29 11:05:30.261933 ignition[1008]: INFO : umount: umount passed Jan 29 11:05:30.261933 ignition[1008]: INFO : Ignition finished successfully Jan 29 11:05:30.263973 systemd[1]: ignition-mount.service: Deactivated successfully. Jan 29 11:05:30.264070 systemd[1]: Stopped ignition-mount.service - Ignition (mount). Jan 29 11:05:30.267747 systemd[1]: sysroot-boot.mount: Deactivated successfully. Jan 29 11:05:30.268244 systemd[1]: initrd-cleanup.service: Deactivated successfully. Jan 29 11:05:30.268327 systemd[1]: Finished initrd-cleanup.service - Cleaning Up and Shutting Down Daemons. Jan 29 11:05:30.270548 systemd[1]: sysroot-boot.service: Deactivated successfully. Jan 29 11:05:30.270625 systemd[1]: Stopped sysroot-boot.service - /sysroot/boot. Jan 29 11:05:30.273449 systemd[1]: Stopped target network.target - Network. Jan 29 11:05:30.274529 systemd[1]: ignition-disks.service: Deactivated successfully. Jan 29 11:05:30.274586 systemd[1]: Stopped ignition-disks.service - Ignition (disks). Jan 29 11:05:30.276546 systemd[1]: ignition-kargs.service: Deactivated successfully. Jan 29 11:05:30.276590 systemd[1]: Stopped ignition-kargs.service - Ignition (kargs). Jan 29 11:05:30.278242 systemd[1]: ignition-setup.service: Deactivated successfully. Jan 29 11:05:30.278284 systemd[1]: Stopped ignition-setup.service - Ignition (setup). Jan 29 11:05:30.279855 systemd[1]: ignition-setup-pre.service: Deactivated successfully. Jan 29 11:05:30.279901 systemd[1]: Stopped ignition-setup-pre.service - Ignition env setup. Jan 29 11:05:30.281502 systemd[1]: initrd-setup-root.service: Deactivated successfully. Jan 29 11:05:30.281546 systemd[1]: Stopped initrd-setup-root.service - Root filesystem setup. Jan 29 11:05:30.283447 systemd[1]: Stopping systemd-networkd.service - Network Configuration... Jan 29 11:05:30.285065 systemd[1]: Stopping systemd-resolved.service - Network Name Resolution... Jan 29 11:05:30.292827 systemd-networkd[759]: eth0: DHCPv6 lease lost Jan 29 11:05:30.293721 systemd[1]: systemd-resolved.service: Deactivated successfully. Jan 29 11:05:30.293870 systemd[1]: Stopped systemd-resolved.service - Network Name Resolution. Jan 29 11:05:30.298079 systemd[1]: systemd-networkd.service: Deactivated successfully. Jan 29 11:05:30.298176 systemd[1]: Stopped systemd-networkd.service - Network Configuration. Jan 29 11:05:30.300912 systemd[1]: systemd-networkd.socket: Deactivated successfully. Jan 29 11:05:30.300965 systemd[1]: Closed systemd-networkd.socket - Network Service Netlink Socket. Jan 29 11:05:30.315899 systemd[1]: Stopping network-cleanup.service - Network Cleanup... Jan 29 11:05:30.316773 systemd[1]: parse-ip-for-networkd.service: Deactivated successfully. Jan 29 11:05:30.316857 systemd[1]: Stopped parse-ip-for-networkd.service - Write systemd-networkd units from cmdline. Jan 29 11:05:30.318932 systemd[1]: systemd-sysctl.service: Deactivated successfully. Jan 29 11:05:30.318976 systemd[1]: Stopped systemd-sysctl.service - Apply Kernel Variables. Jan 29 11:05:30.320749 systemd[1]: systemd-modules-load.service: Deactivated successfully. Jan 29 11:05:30.320805 systemd[1]: Stopped systemd-modules-load.service - Load Kernel Modules. Jan 29 11:05:30.322906 systemd[1]: systemd-tmpfiles-setup.service: Deactivated successfully. Jan 29 11:05:30.322953 systemd[1]: Stopped systemd-tmpfiles-setup.service - Create System Files and Directories. Jan 29 11:05:30.324984 systemd[1]: Stopping systemd-udevd.service - Rule-based Manager for Device Events and Files... Jan 29 11:05:30.333868 systemd[1]: network-cleanup.service: Deactivated successfully. Jan 29 11:05:30.334855 systemd[1]: Stopped network-cleanup.service - Network Cleanup. Jan 29 11:05:30.348478 systemd[1]: systemd-udevd.service: Deactivated successfully. Jan 29 11:05:30.348622 systemd[1]: Stopped systemd-udevd.service - Rule-based Manager for Device Events and Files. Jan 29 11:05:30.350900 systemd[1]: systemd-udevd-control.socket: Deactivated successfully. Jan 29 11:05:30.350935 systemd[1]: Closed systemd-udevd-control.socket - udev Control Socket. Jan 29 11:05:30.352722 systemd[1]: systemd-udevd-kernel.socket: Deactivated successfully. Jan 29 11:05:30.352758 systemd[1]: Closed systemd-udevd-kernel.socket - udev Kernel Socket. Jan 29 11:05:30.354513 systemd[1]: dracut-pre-udev.service: Deactivated successfully. Jan 29 11:05:30.354558 systemd[1]: Stopped dracut-pre-udev.service - dracut pre-udev hook. Jan 29 11:05:30.357177 systemd[1]: dracut-cmdline.service: Deactivated successfully. Jan 29 11:05:30.357221 systemd[1]: Stopped dracut-cmdline.service - dracut cmdline hook. Jan 29 11:05:30.359754 systemd[1]: dracut-cmdline-ask.service: Deactivated successfully. Jan 29 11:05:30.359807 systemd[1]: Stopped dracut-cmdline-ask.service - dracut ask for additional cmdline parameters. Jan 29 11:05:30.372956 systemd[1]: Starting initrd-udevadm-cleanup-db.service - Cleanup udev Database... Jan 29 11:05:30.374005 systemd[1]: systemd-tmpfiles-setup-dev.service: Deactivated successfully. Jan 29 11:05:30.374080 systemd[1]: Stopped systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev. Jan 29 11:05:30.376196 systemd[1]: systemd-vconsole-setup.service: Deactivated successfully. Jan 29 11:05:30.376244 systemd[1]: Stopped systemd-vconsole-setup.service - Virtual Console Setup. Jan 29 11:05:30.378367 systemd[1]: initrd-udevadm-cleanup-db.service: Deactivated successfully. Jan 29 11:05:30.378451 systemd[1]: Finished initrd-udevadm-cleanup-db.service - Cleanup udev Database. Jan 29 11:05:30.380603 systemd[1]: Reached target initrd-switch-root.target - Switch Root. Jan 29 11:05:30.383560 systemd[1]: Starting initrd-switch-root.service - Switch Root... Jan 29 11:05:30.392387 systemd[1]: Switching root. Jan 29 11:05:30.414653 systemd-journald[240]: Journal stopped Jan 29 11:05:31.028336 systemd-journald[240]: Received SIGTERM from PID 1 (systemd). Jan 29 11:05:31.028392 kernel: SELinux: policy capability network_peer_controls=1 Jan 29 11:05:31.028404 kernel: SELinux: policy capability open_perms=1 Jan 29 11:05:31.028413 kernel: SELinux: policy capability extended_socket_class=1 Jan 29 11:05:31.028426 kernel: SELinux: policy capability always_check_network=0 Jan 29 11:05:31.028435 kernel: SELinux: policy capability cgroup_seclabel=1 Jan 29 11:05:31.028445 kernel: SELinux: policy capability nnp_nosuid_transition=1 Jan 29 11:05:31.028455 kernel: SELinux: policy capability genfs_seclabel_symlinks=0 Jan 29 11:05:31.028464 kernel: SELinux: policy capability ioctl_skip_cloexec=0 Jan 29 11:05:31.028478 kernel: audit: type=1403 audit(1738148730.480:2): auid=4294967295 ses=4294967295 lsm=selinux res=1 Jan 29 11:05:31.028489 systemd[1]: Successfully loaded SELinux policy in 39.027ms. Jan 29 11:05:31.028506 systemd[1]: Relabeled /dev, /dev/shm, /run, /sys/fs/cgroup in 9.475ms. Jan 29 11:05:31.028519 systemd[1]: systemd 255 running in system mode (+PAM +AUDIT +SELINUX -APPARMOR +IMA +SMACK +SECCOMP +GCRYPT -GNUTLS +OPENSSL -ACL +BLKID +CURL +ELFUTILS -FIDO2 +IDN2 -IDN +IPTC +KMOD +LIBCRYPTSETUP +LIBFDISK +PCRE2 -PWQUALITY -P11KIT -QRENCODE +TPM2 +BZIP2 +LZ4 +XZ +ZLIB +ZSTD -BPF_FRAMEWORK -XKBCOMMON +UTMP -SYSVINIT default-hierarchy=unified) Jan 29 11:05:31.028531 systemd[1]: Detected virtualization kvm. Jan 29 11:05:31.028541 systemd[1]: Detected architecture arm64. Jan 29 11:05:31.028552 systemd[1]: Detected first boot. Jan 29 11:05:31.028562 systemd[1]: Initializing machine ID from VM UUID. Jan 29 11:05:31.028573 zram_generator::config[1053]: No configuration found. Jan 29 11:05:31.028583 systemd[1]: Populated /etc with preset unit settings. Jan 29 11:05:31.028595 systemd[1]: initrd-switch-root.service: Deactivated successfully. Jan 29 11:05:31.028610 systemd[1]: Stopped initrd-switch-root.service - Switch Root. Jan 29 11:05:31.028621 systemd[1]: systemd-journald.service: Scheduled restart job, restart counter is at 1. Jan 29 11:05:31.028632 systemd[1]: Created slice system-addon\x2dconfig.slice - Slice /system/addon-config. Jan 29 11:05:31.028642 systemd[1]: Created slice system-addon\x2drun.slice - Slice /system/addon-run. Jan 29 11:05:31.028655 systemd[1]: Created slice system-getty.slice - Slice /system/getty. Jan 29 11:05:31.028665 systemd[1]: Created slice system-modprobe.slice - Slice /system/modprobe. Jan 29 11:05:31.028677 systemd[1]: Created slice system-serial\x2dgetty.slice - Slice /system/serial-getty. Jan 29 11:05:31.028688 systemd[1]: Created slice system-system\x2dcloudinit.slice - Slice /system/system-cloudinit. Jan 29 11:05:31.028699 systemd[1]: Created slice system-systemd\x2dfsck.slice - Slice /system/systemd-fsck. Jan 29 11:05:31.028709 systemd[1]: Created slice user.slice - User and Session Slice. Jan 29 11:05:31.028723 systemd[1]: Started clevis-luks-askpass.path - Forward Password Requests to Clevis Directory Watch. Jan 29 11:05:31.028734 systemd[1]: Started systemd-ask-password-console.path - Dispatch Password Requests to Console Directory Watch. Jan 29 11:05:31.028745 systemd[1]: Started systemd-ask-password-wall.path - Forward Password Requests to Wall Directory Watch. Jan 29 11:05:31.028755 systemd[1]: Set up automount boot.automount - Boot partition Automount Point. Jan 29 11:05:31.028766 systemd[1]: Set up automount proc-sys-fs-binfmt_misc.automount - Arbitrary Executable File Formats File System Automount Point. Jan 29 11:05:31.028778 systemd[1]: Expecting device dev-disk-by\x2dlabel-OEM.device - /dev/disk/by-label/OEM... Jan 29 11:05:31.028788 systemd[1]: Expecting device dev-ttyAMA0.device - /dev/ttyAMA0... Jan 29 11:05:31.028811 systemd[1]: Reached target cryptsetup-pre.target - Local Encrypted Volumes (Pre). Jan 29 11:05:31.028822 systemd[1]: Stopped target initrd-switch-root.target - Switch Root. Jan 29 11:05:31.028832 systemd[1]: Stopped target initrd-fs.target - Initrd File Systems. Jan 29 11:05:31.028842 systemd[1]: Stopped target initrd-root-fs.target - Initrd Root File System. Jan 29 11:05:31.028853 systemd[1]: Reached target integritysetup.target - Local Integrity Protected Volumes. Jan 29 11:05:31.028865 systemd[1]: Reached target remote-cryptsetup.target - Remote Encrypted Volumes. Jan 29 11:05:31.028876 systemd[1]: Reached target remote-fs.target - Remote File Systems. Jan 29 11:05:31.028887 systemd[1]: Reached target slices.target - Slice Units. Jan 29 11:05:31.028899 systemd[1]: Reached target swap.target - Swaps. Jan 29 11:05:31.028910 systemd[1]: Reached target veritysetup.target - Local Verity Protected Volumes. Jan 29 11:05:31.028920 systemd[1]: Listening on systemd-coredump.socket - Process Core Dump Socket. Jan 29 11:05:31.028930 systemd[1]: Listening on systemd-networkd.socket - Network Service Netlink Socket. Jan 29 11:05:31.028941 systemd[1]: Listening on systemd-udevd-control.socket - udev Control Socket. Jan 29 11:05:31.028951 systemd[1]: Listening on systemd-udevd-kernel.socket - udev Kernel Socket. Jan 29 11:05:31.028962 systemd[1]: Listening on systemd-userdbd.socket - User Database Manager Socket. Jan 29 11:05:31.028974 systemd[1]: Mounting dev-hugepages.mount - Huge Pages File System... Jan 29 11:05:31.028984 systemd[1]: Mounting dev-mqueue.mount - POSIX Message Queue File System... Jan 29 11:05:31.028994 systemd[1]: Mounting media.mount - External Media Directory... Jan 29 11:05:31.029004 systemd[1]: Mounting sys-kernel-debug.mount - Kernel Debug File System... Jan 29 11:05:31.029015 systemd[1]: Mounting sys-kernel-tracing.mount - Kernel Trace File System... Jan 29 11:05:31.029025 systemd[1]: Mounting tmp.mount - Temporary Directory /tmp... Jan 29 11:05:31.029036 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). Jan 29 11:05:31.029051 systemd[1]: Reached target machines.target - Containers. Jan 29 11:05:31.029064 systemd[1]: Starting flatcar-tmpfiles.service - Create missing system files... Jan 29 11:05:31.029074 systemd[1]: ignition-delete-config.service - Ignition (delete config) was skipped because no trigger condition checks were met. Jan 29 11:05:31.029085 systemd[1]: Starting kmod-static-nodes.service - Create List of Static Device Nodes... Jan 29 11:05:31.029095 systemd[1]: Starting modprobe@configfs.service - Load Kernel Module configfs... Jan 29 11:05:31.029105 systemd[1]: Starting modprobe@dm_mod.service - Load Kernel Module dm_mod... Jan 29 11:05:31.029115 systemd[1]: Starting modprobe@drm.service - Load Kernel Module drm... Jan 29 11:05:31.029127 systemd[1]: Starting modprobe@efi_pstore.service - Load Kernel Module efi_pstore... Jan 29 11:05:31.029137 systemd[1]: Starting modprobe@fuse.service - Load Kernel Module fuse... Jan 29 11:05:31.029147 systemd[1]: Starting modprobe@loop.service - Load Kernel Module loop... Jan 29 11:05:31.029160 systemd[1]: setup-nsswitch.service - Create /etc/nsswitch.conf was skipped because of an unmet condition check (ConditionPathExists=!/etc/nsswitch.conf). Jan 29 11:05:31.029170 systemd[1]: systemd-fsck-root.service: Deactivated successfully. Jan 29 11:05:31.029181 systemd[1]: Stopped systemd-fsck-root.service - File System Check on Root Device. Jan 29 11:05:31.029191 systemd[1]: systemd-fsck-usr.service: Deactivated successfully. Jan 29 11:05:31.029201 systemd[1]: Stopped systemd-fsck-usr.service. Jan 29 11:05:31.029211 systemd[1]: Starting systemd-journald.service - Journal Service... Jan 29 11:05:31.029221 kernel: loop: module loaded Jan 29 11:05:31.029231 systemd[1]: Starting systemd-modules-load.service - Load Kernel Modules... Jan 29 11:05:31.029241 systemd[1]: Starting systemd-network-generator.service - Generate network units from Kernel command line... Jan 29 11:05:31.029252 kernel: fuse: init (API version 7.39) Jan 29 11:05:31.029262 kernel: ACPI: bus type drm_connector registered Jan 29 11:05:31.029272 systemd[1]: Starting systemd-remount-fs.service - Remount Root and Kernel File Systems... Jan 29 11:05:31.029282 systemd[1]: Starting systemd-udev-trigger.service - Coldplug All udev Devices... Jan 29 11:05:31.029293 systemd[1]: verity-setup.service: Deactivated successfully. Jan 29 11:05:31.029304 systemd[1]: Stopped verity-setup.service. Jan 29 11:05:31.029314 systemd[1]: Mounted dev-hugepages.mount - Huge Pages File System. Jan 29 11:05:31.029324 systemd[1]: Mounted dev-mqueue.mount - POSIX Message Queue File System. Jan 29 11:05:31.029336 systemd[1]: Mounted media.mount - External Media Directory. Jan 29 11:05:31.029348 systemd[1]: Mounted sys-kernel-debug.mount - Kernel Debug File System. Jan 29 11:05:31.029361 systemd[1]: Mounted sys-kernel-tracing.mount - Kernel Trace File System. Jan 29 11:05:31.029390 systemd-journald[1127]: Collecting audit messages is disabled. Jan 29 11:05:31.029416 systemd[1]: Mounted tmp.mount - Temporary Directory /tmp. Jan 29 11:05:31.029434 systemd-journald[1127]: Journal started Jan 29 11:05:31.029465 systemd-journald[1127]: Runtime Journal (/run/log/journal/2cdb38fd44a84600b858f2b6727bb2e0) is 5.9M, max 47.3M, 41.4M free. Jan 29 11:05:30.820178 systemd[1]: Queued start job for default target multi-user.target. Jan 29 11:05:30.836636 systemd[1]: Unnecessary job was removed for dev-vda6.device - /dev/vda6. Jan 29 11:05:30.836983 systemd[1]: systemd-journald.service: Deactivated successfully. Jan 29 11:05:31.032146 systemd[1]: Started systemd-journald.service - Journal Service. Jan 29 11:05:31.034855 systemd[1]: Finished flatcar-tmpfiles.service - Create missing system files. Jan 29 11:05:31.036320 systemd[1]: Finished kmod-static-nodes.service - Create List of Static Device Nodes. Jan 29 11:05:31.037861 systemd[1]: modprobe@configfs.service: Deactivated successfully. Jan 29 11:05:31.038005 systemd[1]: Finished modprobe@configfs.service - Load Kernel Module configfs. Jan 29 11:05:31.039488 systemd[1]: modprobe@dm_mod.service: Deactivated successfully. Jan 29 11:05:31.039630 systemd[1]: Finished modprobe@dm_mod.service - Load Kernel Module dm_mod. Jan 29 11:05:31.041024 systemd[1]: modprobe@drm.service: Deactivated successfully. Jan 29 11:05:31.041169 systemd[1]: Finished modprobe@drm.service - Load Kernel Module drm. Jan 29 11:05:31.042463 systemd[1]: modprobe@efi_pstore.service: Deactivated successfully. Jan 29 11:05:31.042606 systemd[1]: Finished modprobe@efi_pstore.service - Load Kernel Module efi_pstore. Jan 29 11:05:31.044156 systemd[1]: modprobe@fuse.service: Deactivated successfully. Jan 29 11:05:31.044288 systemd[1]: Finished modprobe@fuse.service - Load Kernel Module fuse. Jan 29 11:05:31.045602 systemd[1]: modprobe@loop.service: Deactivated successfully. Jan 29 11:05:31.045738 systemd[1]: Finished modprobe@loop.service - Load Kernel Module loop. Jan 29 11:05:31.047103 systemd[1]: Finished systemd-modules-load.service - Load Kernel Modules. Jan 29 11:05:31.048557 systemd[1]: Finished systemd-network-generator.service - Generate network units from Kernel command line. Jan 29 11:05:31.050098 systemd[1]: Finished systemd-remount-fs.service - Remount Root and Kernel File Systems. Jan 29 11:05:31.062534 systemd[1]: Reached target network-pre.target - Preparation for Network. Jan 29 11:05:31.069900 systemd[1]: Mounting sys-fs-fuse-connections.mount - FUSE Control File System... Jan 29 11:05:31.071993 systemd[1]: Mounting sys-kernel-config.mount - Kernel Configuration File System... Jan 29 11:05:31.073108 systemd[1]: remount-root.service - Remount Root File System was skipped because of an unmet condition check (ConditionPathIsReadWrite=!/). Jan 29 11:05:31.073146 systemd[1]: Reached target local-fs.target - Local File Systems. Jan 29 11:05:31.075109 systemd[1]: Listening on systemd-sysext.socket - System Extension Image Management (Varlink). Jan 29 11:05:31.077271 systemd[1]: Starting dracut-shutdown.service - Restore /run/initramfs on shutdown... Jan 29 11:05:31.079399 systemd[1]: Starting ldconfig.service - Rebuild Dynamic Linker Cache... Jan 29 11:05:31.080526 systemd[1]: systemd-binfmt.service - Set Up Additional Binary Formats was skipped because no trigger condition checks were met. Jan 29 11:05:31.081771 systemd[1]: Starting systemd-hwdb-update.service - Rebuild Hardware Database... Jan 29 11:05:31.083673 systemd[1]: Starting systemd-journal-flush.service - Flush Journal to Persistent Storage... Jan 29 11:05:31.084929 systemd[1]: systemd-pstore.service - Platform Persistent Storage Archival was skipped because of an unmet condition check (ConditionDirectoryNotEmpty=/sys/fs/pstore). Jan 29 11:05:31.088946 systemd[1]: Starting systemd-random-seed.service - Load/Save OS Random Seed... Jan 29 11:05:31.090134 systemd[1]: systemd-repart.service - Repartition Root Disk was skipped because no trigger condition checks were met. Jan 29 11:05:31.090993 systemd-journald[1127]: Time spent on flushing to /var/log/journal/2cdb38fd44a84600b858f2b6727bb2e0 is 11.229ms for 834 entries. Jan 29 11:05:31.090993 systemd-journald[1127]: System Journal (/var/log/journal/2cdb38fd44a84600b858f2b6727bb2e0) is 8.0M, max 195.6M, 187.6M free. Jan 29 11:05:31.139469 systemd-journald[1127]: Received client request to flush runtime journal. Jan 29 11:05:31.139516 kernel: loop0: detected capacity change from 0 to 116784 Jan 29 11:05:31.139529 kernel: squashfs: version 4.0 (2009/01/31) Phillip Lougher Jan 29 11:05:31.092983 systemd[1]: Starting systemd-sysctl.service - Apply Kernel Variables... Jan 29 11:05:31.096344 systemd[1]: Starting systemd-sysext.service - Merge System Extension Images into /usr/ and /opt/... Jan 29 11:05:31.098416 systemd[1]: Starting systemd-sysusers.service - Create System Users... Jan 29 11:05:31.100766 systemd[1]: Finished systemd-udev-trigger.service - Coldplug All udev Devices. Jan 29 11:05:31.102251 systemd[1]: Mounted sys-fs-fuse-connections.mount - FUSE Control File System. Jan 29 11:05:31.103555 systemd[1]: Mounted sys-kernel-config.mount - Kernel Configuration File System. Jan 29 11:05:31.105029 systemd[1]: Finished dracut-shutdown.service - Restore /run/initramfs on shutdown. Jan 29 11:05:31.113012 systemd[1]: Starting systemd-udev-settle.service - Wait for udev To Complete Device Initialization... Jan 29 11:05:31.124498 udevadm[1172]: systemd-udev-settle.service is deprecated. Please fix lvm2-activation.service, lvm2-activation-early.service not to pull it in. Jan 29 11:05:31.127022 systemd[1]: Finished systemd-random-seed.service - Load/Save OS Random Seed. Jan 29 11:05:31.128908 systemd[1]: Finished systemd-sysctl.service - Apply Kernel Variables. Jan 29 11:05:31.130319 systemd[1]: Reached target first-boot-complete.target - First Boot Complete. Jan 29 11:05:31.138158 systemd[1]: Starting systemd-machine-id-commit.service - Commit a transient machine-id on disk... Jan 29 11:05:31.143213 systemd[1]: Finished systemd-journal-flush.service - Flush Journal to Persistent Storage. Jan 29 11:05:31.145051 systemd[1]: Finished systemd-sysusers.service - Create System Users. Jan 29 11:05:31.149184 systemd[1]: Starting systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev... Jan 29 11:05:31.157936 systemd[1]: etc-machine\x2did.mount: Deactivated successfully. Jan 29 11:05:31.158618 systemd[1]: Finished systemd-machine-id-commit.service - Commit a transient machine-id on disk. Jan 29 11:05:31.170822 kernel: loop1: detected capacity change from 0 to 113552 Jan 29 11:05:31.175290 systemd-tmpfiles[1183]: ACLs are not supported, ignoring. Jan 29 11:05:31.175305 systemd-tmpfiles[1183]: ACLs are not supported, ignoring. Jan 29 11:05:31.180021 systemd[1]: Finished systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev. Jan 29 11:05:31.198832 kernel: loop2: detected capacity change from 0 to 116784 Jan 29 11:05:31.203840 kernel: loop3: detected capacity change from 0 to 113552 Jan 29 11:05:31.207037 (sd-merge)[1189]: Using extensions 'containerd-flatcar', 'docker-flatcar'. Jan 29 11:05:31.207365 (sd-merge)[1189]: Merged extensions into '/usr'. Jan 29 11:05:31.211836 systemd[1]: Finished systemd-sysext.service - Merge System Extension Images into /usr/ and /opt/. Jan 29 11:05:31.219937 systemd[1]: Starting ensure-sysext.service... Jan 29 11:05:31.223973 systemd[1]: Starting systemd-tmpfiles-setup.service - Create System Files and Directories... Jan 29 11:05:31.229777 systemd[1]: Reloading requested from client PID 1191 ('systemctl') (unit ensure-sysext.service)... Jan 29 11:05:31.229801 systemd[1]: Reloading... Jan 29 11:05:31.258141 systemd-tmpfiles[1192]: /usr/lib/tmpfiles.d/provision.conf:20: Duplicate line for path "/root", ignoring. Jan 29 11:05:31.258393 systemd-tmpfiles[1192]: /usr/lib/tmpfiles.d/systemd-flatcar.conf:6: Duplicate line for path "/var/log/journal", ignoring. Jan 29 11:05:31.259072 systemd-tmpfiles[1192]: /usr/lib/tmpfiles.d/systemd.conf:29: Duplicate line for path "/var/lib/systemd", ignoring. Jan 29 11:05:31.259289 systemd-tmpfiles[1192]: ACLs are not supported, ignoring. Jan 29 11:05:31.259335 systemd-tmpfiles[1192]: ACLs are not supported, ignoring. Jan 29 11:05:31.263538 systemd-tmpfiles[1192]: Detected autofs mount point /boot during canonicalization of boot. Jan 29 11:05:31.263550 systemd-tmpfiles[1192]: Skipping /boot Jan 29 11:05:31.276779 systemd-tmpfiles[1192]: Detected autofs mount point /boot during canonicalization of boot. Jan 29 11:05:31.276805 systemd-tmpfiles[1192]: Skipping /boot Jan 29 11:05:31.280344 zram_generator::config[1217]: No configuration found. Jan 29 11:05:31.367882 ldconfig[1159]: /sbin/ldconfig: /usr/lib/ld.so.conf is not an ELF file - it has the wrong magic bytes at the start. Jan 29 11:05:31.387343 systemd[1]: /usr/lib/systemd/system/docker.socket:6: ListenStream= references a path below legacy directory /var/run/, updating /var/run/docker.sock → /run/docker.sock; please update the unit file accordingly. Jan 29 11:05:31.422131 systemd[1]: Reloading finished in 192 ms. Jan 29 11:05:31.450692 systemd[1]: Finished ldconfig.service - Rebuild Dynamic Linker Cache. Jan 29 11:05:31.452920 systemd[1]: Finished systemd-tmpfiles-setup.service - Create System Files and Directories. Jan 29 11:05:31.459368 systemd[1]: Starting audit-rules.service - Load Audit Rules... Jan 29 11:05:31.461712 systemd[1]: Starting clean-ca-certificates.service - Clean up broken links in /etc/ssl/certs... Jan 29 11:05:31.464232 systemd[1]: Starting systemd-journal-catalog-update.service - Rebuild Journal Catalog... Jan 29 11:05:31.467957 systemd[1]: Starting systemd-resolved.service - Network Name Resolution... Jan 29 11:05:31.471372 systemd[1]: Starting systemd-update-utmp.service - Record System Boot/Shutdown in UTMP... Jan 29 11:05:31.477776 systemd[1]: ignition-delete-config.service - Ignition (delete config) was skipped because no trigger condition checks were met. Jan 29 11:05:31.480006 systemd[1]: Starting modprobe@dm_mod.service - Load Kernel Module dm_mod... Jan 29 11:05:31.483840 systemd[1]: Starting modprobe@efi_pstore.service - Load Kernel Module efi_pstore... Jan 29 11:05:31.489621 systemd[1]: Starting modprobe@loop.service - Load Kernel Module loop... Jan 29 11:05:31.490936 systemd[1]: systemd-binfmt.service - Set Up Additional Binary Formats was skipped because no trigger condition checks were met. Jan 29 11:05:31.491634 systemd[1]: modprobe@dm_mod.service: Deactivated successfully. Jan 29 11:05:31.491937 systemd[1]: Finished modprobe@dm_mod.service - Load Kernel Module dm_mod. Jan 29 11:05:31.494088 systemd[1]: modprobe@loop.service: Deactivated successfully. Jan 29 11:05:31.494244 systemd[1]: Finished modprobe@loop.service - Load Kernel Module loop. Jan 29 11:05:31.501497 systemd[1]: Finished systemd-journal-catalog-update.service - Rebuild Journal Catalog. Jan 29 11:05:31.503559 systemd[1]: modprobe@efi_pstore.service: Deactivated successfully. Jan 29 11:05:31.503685 systemd[1]: Finished modprobe@efi_pstore.service - Load Kernel Module efi_pstore. Jan 29 11:05:31.510358 systemd[1]: ignition-delete-config.service - Ignition (delete config) was skipped because no trigger condition checks were met. Jan 29 11:05:31.519148 systemd[1]: Starting modprobe@dm_mod.service - Load Kernel Module dm_mod... Jan 29 11:05:31.521544 systemd[1]: Starting modprobe@efi_pstore.service - Load Kernel Module efi_pstore... Jan 29 11:05:31.524318 systemd[1]: Starting modprobe@loop.service - Load Kernel Module loop... Jan 29 11:05:31.525491 systemd[1]: systemd-binfmt.service - Set Up Additional Binary Formats was skipped because no trigger condition checks were met. Jan 29 11:05:31.527754 systemd[1]: Starting systemd-userdbd.service - User Database Manager... Jan 29 11:05:31.536808 systemd[1]: Finished clean-ca-certificates.service - Clean up broken links in /etc/ssl/certs. Jan 29 11:05:31.540839 systemd[1]: modprobe@dm_mod.service: Deactivated successfully. Jan 29 11:05:31.540980 systemd[1]: Finished modprobe@dm_mod.service - Load Kernel Module dm_mod. Jan 29 11:05:31.542846 systemd[1]: modprobe@efi_pstore.service: Deactivated successfully. Jan 29 11:05:31.542972 systemd[1]: Finished modprobe@efi_pstore.service - Load Kernel Module efi_pstore. Jan 29 11:05:31.546719 systemd[1]: modprobe@loop.service: Deactivated successfully. Jan 29 11:05:31.546878 systemd[1]: Finished modprobe@loop.service - Load Kernel Module loop. Jan 29 11:05:31.550938 augenrules[1292]: No rules Jan 29 11:05:31.552838 systemd[1]: Finished systemd-update-utmp.service - Record System Boot/Shutdown in UTMP. Jan 29 11:05:31.554673 systemd[1]: audit-rules.service: Deactivated successfully. Jan 29 11:05:31.554886 systemd[1]: Finished audit-rules.service - Load Audit Rules. Jan 29 11:05:31.574081 systemd[1]: Starting audit-rules.service - Load Audit Rules... Jan 29 11:05:31.575202 systemd[1]: ignition-delete-config.service - Ignition (delete config) was skipped because no trigger condition checks were met. Jan 29 11:05:31.576407 systemd[1]: Starting modprobe@dm_mod.service - Load Kernel Module dm_mod... Jan 29 11:05:31.582079 systemd[1]: Starting modprobe@drm.service - Load Kernel Module drm... Jan 29 11:05:31.586350 systemd[1]: Starting modprobe@efi_pstore.service - Load Kernel Module efi_pstore... Jan 29 11:05:31.590088 systemd[1]: Starting modprobe@loop.service - Load Kernel Module loop... Jan 29 11:05:31.591243 systemd[1]: systemd-binfmt.service - Set Up Additional Binary Formats was skipped because no trigger condition checks were met. Jan 29 11:05:31.591396 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). Jan 29 11:05:31.592151 systemd[1]: Started systemd-userdbd.service - User Database Manager. Jan 29 11:05:31.593846 systemd[1]: modprobe@dm_mod.service: Deactivated successfully. Jan 29 11:05:31.593976 systemd[1]: Finished modprobe@dm_mod.service - Load Kernel Module dm_mod. Jan 29 11:05:31.595459 systemd[1]: modprobe@drm.service: Deactivated successfully. Jan 29 11:05:31.595576 systemd[1]: Finished modprobe@drm.service - Load Kernel Module drm. Jan 29 11:05:31.597005 systemd[1]: modprobe@efi_pstore.service: Deactivated successfully. Jan 29 11:05:31.597141 systemd[1]: Finished modprobe@efi_pstore.service - Load Kernel Module efi_pstore. Jan 29 11:05:31.598684 systemd[1]: modprobe@loop.service: Deactivated successfully. Jan 29 11:05:31.598819 systemd[1]: Finished modprobe@loop.service - Load Kernel Module loop. Jan 29 11:05:31.599396 augenrules[1302]: /sbin/augenrules: No change Jan 29 11:05:31.602945 systemd[1]: Finished ensure-sysext.service. Jan 29 11:05:31.604200 systemd[1]: Finished systemd-hwdb-update.service - Rebuild Hardware Database. Jan 29 11:05:31.605573 augenrules[1332]: No rules Jan 29 11:05:31.606441 systemd[1]: audit-rules.service: Deactivated successfully. Jan 29 11:05:31.606601 systemd[1]: Finished audit-rules.service - Load Audit Rules. Jan 29 11:05:31.610202 systemd[1]: systemd-pstore.service - Platform Persistent Storage Archival was skipped because of an unmet condition check (ConditionDirectoryNotEmpty=/sys/fs/pstore). Jan 29 11:05:31.610276 systemd[1]: systemd-repart.service - Repartition Root Disk was skipped because no trigger condition checks were met. Jan 29 11:05:31.620999 systemd[1]: Starting systemd-timesyncd.service - Network Time Synchronization... Jan 29 11:05:31.623380 systemd[1]: Starting systemd-udevd.service - Rule-based Manager for Device Events and Files... Jan 29 11:05:31.625534 systemd[1]: Starting systemd-update-done.service - Update is Completed... Jan 29 11:05:31.630466 systemd-resolved[1259]: Positive Trust Anchors: Jan 29 11:05:31.630784 systemd-resolved[1259]: . IN DS 20326 8 2 e06d44b80b8f1d39a95c0b0d7c65d08458e880409bbc683457104237c7f8ec8d Jan 29 11:05:31.630897 systemd-resolved[1259]: 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 Jan 29 11:05:31.637199 systemd-resolved[1259]: Defaulting to hostname 'linux'. Jan 29 11:05:31.638980 systemd[1]: Started systemd-resolved.service - Network Name Resolution. Jan 29 11:05:31.640303 systemd[1]: Reached target nss-lookup.target - Host and Network Name Lookups. Jan 29 11:05:31.645104 systemd[1]: Finished systemd-update-done.service - Update is Completed. Jan 29 11:05:31.648006 systemd-udevd[1341]: Using default interface naming scheme 'v255'. Jan 29 11:05:31.661635 systemd[1]: Started systemd-udevd.service - Rule-based Manager for Device Events and Files. Jan 29 11:05:31.670969 systemd[1]: Starting systemd-networkd.service - Network Configuration... Jan 29 11:05:31.672378 systemd[1]: Started systemd-timesyncd.service - Network Time Synchronization. Jan 29 11:05:31.677583 systemd[1]: Reached target time-set.target - System Time Set. Jan 29 11:05:31.688160 systemd[1]: Condition check resulted in dev-ttyAMA0.device - /dev/ttyAMA0 being skipped. Jan 29 11:05:31.700018 kernel: BTRFS warning: duplicate device /dev/vda3 devid 1 generation 39 scanned by (udev-worker) (1348) Jan 29 11:05:31.741441 systemd[1]: Found device dev-disk-by\x2dlabel-OEM.device - /dev/disk/by-label/OEM. Jan 29 11:05:31.754089 systemd[1]: Starting systemd-fsck@dev-disk-by\x2dlabel-OEM.service - File System Check on /dev/disk/by-label/OEM... Jan 29 11:05:31.770594 systemd-networkd[1353]: lo: Link UP Jan 29 11:05:31.770602 systemd-networkd[1353]: lo: Gained carrier Jan 29 11:05:31.773744 systemd-networkd[1353]: Enumeration completed Jan 29 11:05:31.774083 systemd[1]: Started systemd-networkd.service - Network Configuration. Jan 29 11:05:31.776914 systemd[1]: Finished systemd-fsck@dev-disk-by\x2dlabel-OEM.service - File System Check on /dev/disk/by-label/OEM. Jan 29 11:05:31.778680 systemd[1]: Reached target network.target - Network. Jan 29 11:05:31.780597 systemd-networkd[1353]: eth0: found matching network '/usr/lib/systemd/network/zz-default.network', based on potentially unpredictable interface name. Jan 29 11:05:31.780607 systemd-networkd[1353]: eth0: Configuring with /usr/lib/systemd/network/zz-default.network. Jan 29 11:05:31.788702 systemd-networkd[1353]: eth0: found matching network '/usr/lib/systemd/network/zz-default.network', based on potentially unpredictable interface name. Jan 29 11:05:31.788740 systemd-networkd[1353]: eth0: Link UP Jan 29 11:05:31.788744 systemd-networkd[1353]: eth0: Gained carrier Jan 29 11:05:31.788752 systemd-networkd[1353]: eth0: found matching network '/usr/lib/systemd/network/zz-default.network', based on potentially unpredictable interface name. Jan 29 11:05:31.793028 systemd[1]: Starting systemd-networkd-wait-online.service - Wait for Network to be Configured... Jan 29 11:05:31.797618 systemd[1]: Starting systemd-vconsole-setup.service - Virtual Console Setup... Jan 29 11:05:31.808956 systemd[1]: Finished systemd-udev-settle.service - Wait for udev To Complete Device Initialization. Jan 29 11:05:31.811862 systemd[1]: Starting lvm2-activation-early.service - Activation of LVM2 logical volumes... Jan 29 11:05:31.813857 systemd-networkd[1353]: eth0: DHCPv4 address 10.0.0.110/16, gateway 10.0.0.1 acquired from 10.0.0.1 Jan 29 11:05:31.815335 systemd-timesyncd[1340]: Network configuration changed, trying to establish connection. Jan 29 11:05:31.816100 systemd-timesyncd[1340]: Contacted time server 10.0.0.1:123 (10.0.0.1). Jan 29 11:05:31.816153 systemd-timesyncd[1340]: Initial clock synchronization to Wed 2025-01-29 11:05:32.040394 UTC. Jan 29 11:05:31.828418 lvm[1381]: WARNING: Failed to connect to lvmetad. Falling back to device scanning. Jan 29 11:05:31.840388 systemd[1]: Finished systemd-vconsole-setup.service - Virtual Console Setup. Jan 29 11:05:31.854196 systemd[1]: Finished lvm2-activation-early.service - Activation of LVM2 logical volumes. Jan 29 11:05:31.855651 systemd[1]: Reached target cryptsetup.target - Local Encrypted Volumes. Jan 29 11:05:31.856827 systemd[1]: Reached target sysinit.target - System Initialization. Jan 29 11:05:31.858054 systemd[1]: Started motdgen.path - Watch for update engine configuration changes. Jan 29 11:05:31.859330 systemd[1]: Started user-cloudinit@var-lib-flatcar\x2dinstall-user_data.path - Watch for a cloud-config at /var/lib/flatcar-install/user_data. Jan 29 11:05:31.860813 systemd[1]: Started logrotate.timer - Daily rotation of log files. Jan 29 11:05:31.861971 systemd[1]: Started mdadm.timer - Weekly check for MD array's redundancy information.. Jan 29 11:05:31.863201 systemd[1]: Started systemd-tmpfiles-clean.timer - Daily Cleanup of Temporary Directories. Jan 29 11:05:31.864413 systemd[1]: update-engine-stub.timer - Update Engine Stub Timer was skipped because of an unmet condition check (ConditionPathExists=/usr/.noupdate). Jan 29 11:05:31.864453 systemd[1]: Reached target paths.target - Path Units. Jan 29 11:05:31.865347 systemd[1]: Reached target timers.target - Timer Units. Jan 29 11:05:31.867502 systemd[1]: Listening on dbus.socket - D-Bus System Message Bus Socket. Jan 29 11:05:31.869929 systemd[1]: Starting docker.socket - Docker Socket for the API... Jan 29 11:05:31.881695 systemd[1]: Listening on sshd.socket - OpenSSH Server Socket. Jan 29 11:05:31.883983 systemd[1]: Starting lvm2-activation.service - Activation of LVM2 logical volumes... Jan 29 11:05:31.885617 systemd[1]: Listening on docker.socket - Docker Socket for the API. Jan 29 11:05:31.886824 systemd[1]: Reached target sockets.target - Socket Units. Jan 29 11:05:31.887739 systemd[1]: Reached target basic.target - Basic System. Jan 29 11:05:31.888753 systemd[1]: addon-config@oem.service - Configure Addon /oem was skipped because no trigger condition checks were met. Jan 29 11:05:31.888783 systemd[1]: addon-run@oem.service - Run Addon /oem was skipped because no trigger condition checks were met. Jan 29 11:05:31.889718 systemd[1]: Starting containerd.service - containerd container runtime... Jan 29 11:05:31.892679 lvm[1389]: WARNING: Failed to connect to lvmetad. Falling back to device scanning. Jan 29 11:05:31.891778 systemd[1]: Starting dbus.service - D-Bus System Message Bus... Jan 29 11:05:31.894702 systemd[1]: Starting enable-oem-cloudinit.service - Enable cloudinit... Jan 29 11:05:31.896745 systemd[1]: Starting extend-filesystems.service - Extend Filesystems... Jan 29 11:05:31.898031 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). Jan 29 11:05:31.900216 systemd[1]: Starting motdgen.service - Generate /run/flatcar/motd... Jan 29 11:05:31.901904 jq[1392]: false Jan 29 11:05:31.902580 systemd[1]: Starting ssh-key-proc-cmdline.service - Install an ssh key from /proc/cmdline... Jan 29 11:05:31.907678 systemd[1]: Starting sshd-keygen.service - Generate sshd host keys... Jan 29 11:05:31.911570 systemd[1]: Starting systemd-logind.service - User Login Management... Jan 29 11:05:31.914580 systemd[1]: tcsd.service - TCG Core Services Daemon was skipped because of an unmet condition check (ConditionPathExists=/dev/tpm0). Jan 29 11:05:31.915002 systemd[1]: cgroup compatibility translation between legacy and unified hierarchy settings activated. See cgroup-compat debug messages for details. Jan 29 11:05:31.915921 systemd[1]: Starting update-engine.service - Update Engine... Jan 29 11:05:31.917940 extend-filesystems[1393]: Found loop2 Jan 29 11:05:31.917940 extend-filesystems[1393]: Found loop3 Jan 29 11:05:31.917940 extend-filesystems[1393]: Found vda Jan 29 11:05:31.917940 extend-filesystems[1393]: Found vda1 Jan 29 11:05:31.917940 extend-filesystems[1393]: Found vda2 Jan 29 11:05:31.917940 extend-filesystems[1393]: Found vda3 Jan 29 11:05:31.917940 extend-filesystems[1393]: Found usr Jan 29 11:05:31.917940 extend-filesystems[1393]: Found vda4 Jan 29 11:05:31.917940 extend-filesystems[1393]: Found vda6 Jan 29 11:05:31.917940 extend-filesystems[1393]: Found vda7 Jan 29 11:05:31.917940 extend-filesystems[1393]: Found vda9 Jan 29 11:05:31.917940 extend-filesystems[1393]: Checking size of /dev/vda9 Jan 29 11:05:31.917945 systemd[1]: Starting update-ssh-keys-after-ignition.service - Run update-ssh-keys once after Ignition... Jan 29 11:05:31.929110 dbus-daemon[1391]: [system] SELinux support is enabled Jan 29 11:05:31.919691 systemd[1]: Finished lvm2-activation.service - Activation of LVM2 logical volumes. Jan 29 11:05:31.923988 systemd[1]: enable-oem-cloudinit.service: Skipped due to 'exec-condition'. Jan 29 11:05:31.948430 jq[1407]: true Jan 29 11:05:31.924180 systemd[1]: Condition check resulted in enable-oem-cloudinit.service - Enable cloudinit being skipped. Jan 29 11:05:31.924436 systemd[1]: ssh-key-proc-cmdline.service: Deactivated successfully. Jan 29 11:05:31.924587 systemd[1]: Finished ssh-key-proc-cmdline.service - Install an ssh key from /proc/cmdline. Jan 29 11:05:31.930019 systemd[1]: Started dbus.service - D-Bus System Message Bus. Jan 29 11:05:31.937120 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). Jan 29 11:05:31.937179 systemd[1]: Reached target system-config.target - Load system-provided cloud configs. Jan 29 11:05:31.941595 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). Jan 29 11:05:31.941612 systemd[1]: Reached target user-config.target - Load user-provided cloud configs. Jan 29 11:05:31.945513 (ntainerd)[1413]: containerd.service: Referenced but unset environment variable evaluates to an empty string: TORCX_IMAGEDIR, TORCX_UNPACKDIR Jan 29 11:05:31.950864 systemd[1]: motdgen.service: Deactivated successfully. Jan 29 11:05:31.951034 systemd[1]: Finished motdgen.service - Generate /run/flatcar/motd. Jan 29 11:05:31.952921 extend-filesystems[1393]: Old size kept for /dev/vda9 Jan 29 11:05:31.961787 kernel: BTRFS warning: duplicate device /dev/vda3 devid 1 generation 39 scanned by (udev-worker) (1348) Jan 29 11:05:31.954320 systemd[1]: extend-filesystems.service: Deactivated successfully. Jan 29 11:05:31.954490 systemd[1]: Finished extend-filesystems.service - Extend Filesystems. Jan 29 11:05:31.973720 jq[1412]: true Jan 29 11:05:31.996676 update_engine[1405]: I20250129 11:05:31.996495 1405 main.cc:92] Flatcar Update Engine starting Jan 29 11:05:32.001882 systemd[1]: Started update-engine.service - Update Engine. Jan 29 11:05:32.007895 update_engine[1405]: I20250129 11:05:32.007615 1405 update_check_scheduler.cc:74] Next update check in 7m18s Jan 29 11:05:32.015686 systemd[1]: Started locksmithd.service - Cluster reboot manager. Jan 29 11:05:32.036151 systemd-logind[1400]: Watching system buttons on /dev/input/event0 (Power Button) Jan 29 11:05:32.041742 systemd-logind[1400]: New seat seat0. Jan 29 11:05:32.043159 systemd[1]: Started systemd-logind.service - User Login Management. Jan 29 11:05:32.053759 bash[1441]: Updated "/home/core/.ssh/authorized_keys" Jan 29 11:05:32.061887 systemd[1]: Finished update-ssh-keys-after-ignition.service - Run update-ssh-keys once after Ignition. Jan 29 11:05:32.064002 systemd[1]: sshkeys.service was skipped because no trigger condition checks were met. Jan 29 11:05:32.068058 locksmithd[1440]: locksmithd starting currentOperation="UPDATE_STATUS_IDLE" strategy="reboot" Jan 29 11:05:32.135026 containerd[1413]: time="2025-01-29T11:05:32.134888582Z" level=info msg="starting containerd" revision=9b2ad7760328148397346d10c7b2004271249db4 version=v1.7.23 Jan 29 11:05:32.164891 containerd[1413]: time="2025-01-29T11:05:32.164834696Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.aufs\"..." type=io.containerd.snapshotter.v1 Jan 29 11:05:32.166400 containerd[1413]: time="2025-01-29T11:05:32.166346847Z" 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.74-flatcar\\n\"): skip plugin" type=io.containerd.snapshotter.v1 Jan 29 11:05:32.166400 containerd[1413]: time="2025-01-29T11:05:32.166390436Z" level=info msg="loading plugin \"io.containerd.event.v1.exchange\"..." type=io.containerd.event.v1 Jan 29 11:05:32.166471 containerd[1413]: time="2025-01-29T11:05:32.166410710Z" level=info msg="loading plugin \"io.containerd.internal.v1.opt\"..." type=io.containerd.internal.v1 Jan 29 11:05:32.166620 containerd[1413]: time="2025-01-29T11:05:32.166588811Z" level=info msg="loading plugin \"io.containerd.warning.v1.deprecations\"..." type=io.containerd.warning.v1 Jan 29 11:05:32.166644 containerd[1413]: time="2025-01-29T11:05:32.166616486Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.blockfile\"..." type=io.containerd.snapshotter.v1 Jan 29 11:05:32.166716 containerd[1413]: time="2025-01-29T11:05:32.166689149Z" level=info msg="skip loading plugin \"io.containerd.snapshotter.v1.blockfile\"..." error="no scratch file generator: skip plugin" type=io.containerd.snapshotter.v1 Jan 29 11:05:32.166716 containerd[1413]: time="2025-01-29T11:05:32.166708065Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.btrfs\"..." type=io.containerd.snapshotter.v1 Jan 29 11:05:32.166928 containerd[1413]: time="2025-01-29T11:05:32.166897680Z" 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 Jan 29 11:05:32.166928 containerd[1413]: time="2025-01-29T11:05:32.166919393Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.devmapper\"..." type=io.containerd.snapshotter.v1 Jan 29 11:05:32.166967 containerd[1413]: time="2025-01-29T11:05:32.166933580Z" level=info msg="skip loading plugin \"io.containerd.snapshotter.v1.devmapper\"..." error="devmapper not configured: skip plugin" type=io.containerd.snapshotter.v1 Jan 29 11:05:32.166967 containerd[1413]: time="2025-01-29T11:05:32.166942792Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.native\"..." type=io.containerd.snapshotter.v1 Jan 29 11:05:32.167047 containerd[1413]: time="2025-01-29T11:05:32.167031863Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.overlayfs\"..." type=io.containerd.snapshotter.v1 Jan 29 11:05:32.167261 containerd[1413]: time="2025-01-29T11:05:32.167234596Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.zfs\"..." type=io.containerd.snapshotter.v1 Jan 29 11:05:32.167355 containerd[1413]: time="2025-01-29T11:05:32.167339211Z" 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 Jan 29 11:05:32.167375 containerd[1413]: time="2025-01-29T11:05:32.167356688Z" level=info msg="loading plugin \"io.containerd.content.v1.content\"..." type=io.containerd.content.v1 Jan 29 11:05:32.167444 containerd[1413]: time="2025-01-29T11:05:32.167430873Z" level=info msg="loading plugin \"io.containerd.metadata.v1.bolt\"..." type=io.containerd.metadata.v1 Jan 29 11:05:32.167506 containerd[1413]: time="2025-01-29T11:05:32.167477999Z" level=info msg="metadata content store policy set" policy=shared Jan 29 11:05:32.171023 containerd[1413]: time="2025-01-29T11:05:32.170985570Z" level=info msg="loading plugin \"io.containerd.gc.v1.scheduler\"..." type=io.containerd.gc.v1 Jan 29 11:05:32.171052 containerd[1413]: time="2025-01-29T11:05:32.171038413Z" level=info msg="loading plugin \"io.containerd.differ.v1.walking\"..." type=io.containerd.differ.v1 Jan 29 11:05:32.171070 containerd[1413]: time="2025-01-29T11:05:32.171055643Z" level=info msg="loading plugin \"io.containerd.lease.v1.manager\"..." type=io.containerd.lease.v1 Jan 29 11:05:32.171088 containerd[1413]: time="2025-01-29T11:05:32.171073449Z" level=info msg="loading plugin \"io.containerd.streaming.v1.manager\"..." type=io.containerd.streaming.v1 Jan 29 11:05:32.171138 containerd[1413]: time="2025-01-29T11:05:32.171090597Z" level=info msg="loading plugin \"io.containerd.runtime.v1.linux\"..." type=io.containerd.runtime.v1 Jan 29 11:05:32.171322 containerd[1413]: time="2025-01-29T11:05:32.171275689Z" level=info msg="loading plugin \"io.containerd.monitor.v1.cgroups\"..." type=io.containerd.monitor.v1 Jan 29 11:05:32.171619 containerd[1413]: time="2025-01-29T11:05:32.171592577Z" level=info msg="loading plugin \"io.containerd.runtime.v2.task\"..." type=io.containerd.runtime.v2 Jan 29 11:05:32.171781 containerd[1413]: time="2025-01-29T11:05:32.171755052Z" level=info msg="loading plugin \"io.containerd.runtime.v2.shim\"..." type=io.containerd.runtime.v2 Jan 29 11:05:32.171850 containerd[1413]: time="2025-01-29T11:05:32.171778327Z" level=info msg="loading plugin \"io.containerd.sandbox.store.v1.local\"..." type=io.containerd.sandbox.store.v1 Jan 29 11:05:32.171850 containerd[1413]: time="2025-01-29T11:05:32.171846138Z" level=info msg="loading plugin \"io.containerd.sandbox.controller.v1.local\"..." type=io.containerd.sandbox.controller.v1 Jan 29 11:05:32.171883 containerd[1413]: time="2025-01-29T11:05:32.171861559Z" level=info msg="loading plugin \"io.containerd.service.v1.containers-service\"..." type=io.containerd.service.v1 Jan 29 11:05:32.171883 containerd[1413]: time="2025-01-29T11:05:32.171876322Z" level=info msg="loading plugin \"io.containerd.service.v1.content-service\"..." type=io.containerd.service.v1 Jan 29 11:05:32.171958 containerd[1413]: time="2025-01-29T11:05:32.171888741Z" level=info msg="loading plugin \"io.containerd.service.v1.diff-service\"..." type=io.containerd.service.v1 Jan 29 11:05:32.171958 containerd[1413]: time="2025-01-29T11:05:32.171902599Z" level=info msg="loading plugin \"io.containerd.service.v1.images-service\"..." type=io.containerd.service.v1 Jan 29 11:05:32.171958 containerd[1413]: time="2025-01-29T11:05:32.171929781Z" level=info msg="loading plugin \"io.containerd.service.v1.introspection-service\"..." type=io.containerd.service.v1 Jan 29 11:05:32.172006 containerd[1413]: time="2025-01-29T11:05:32.171965146Z" level=info msg="loading plugin \"io.containerd.service.v1.namespaces-service\"..." type=io.containerd.service.v1 Jan 29 11:05:32.172006 containerd[1413]: time="2025-01-29T11:05:32.171978881Z" level=info msg="loading plugin \"io.containerd.service.v1.snapshots-service\"..." type=io.containerd.service.v1 Jan 29 11:05:32.172006 containerd[1413]: time="2025-01-29T11:05:32.171989943Z" level=info msg="loading plugin \"io.containerd.service.v1.tasks-service\"..." type=io.containerd.service.v1 Jan 29 11:05:32.172090 containerd[1413]: time="2025-01-29T11:05:32.172014493Z" level=info msg="loading plugin \"io.containerd.grpc.v1.containers\"..." type=io.containerd.grpc.v1 Jan 29 11:05:32.172090 containerd[1413]: time="2025-01-29T11:05:32.172028680Z" level=info msg="loading plugin \"io.containerd.grpc.v1.content\"..." type=io.containerd.grpc.v1 Jan 29 11:05:32.172090 containerd[1413]: time="2025-01-29T11:05:32.172063469Z" level=info msg="loading plugin \"io.containerd.grpc.v1.diff\"..." type=io.containerd.grpc.v1 Jan 29 11:05:32.172090 containerd[1413]: time="2025-01-29T11:05:32.172089500Z" level=info msg="loading plugin \"io.containerd.grpc.v1.events\"..." type=io.containerd.grpc.v1 Jan 29 11:05:32.172192 containerd[1413]: time="2025-01-29T11:05:32.172102988Z" level=info msg="loading plugin \"io.containerd.grpc.v1.images\"..." type=io.containerd.grpc.v1 Jan 29 11:05:32.173228 containerd[1413]: time="2025-01-29T11:05:32.172377932Z" level=info msg="loading plugin \"io.containerd.grpc.v1.introspection\"..." type=io.containerd.grpc.v1 Jan 29 11:05:32.173228 containerd[1413]: time="2025-01-29T11:05:32.172445784Z" level=info msg="loading plugin \"io.containerd.grpc.v1.leases\"..." type=io.containerd.grpc.v1 Jan 29 11:05:32.173228 containerd[1413]: time="2025-01-29T11:05:32.172466222Z" level=info msg="loading plugin \"io.containerd.grpc.v1.namespaces\"..." type=io.containerd.grpc.v1 Jan 29 11:05:32.173228 containerd[1413]: time="2025-01-29T11:05:32.172484932Z" level=info msg="loading plugin \"io.containerd.grpc.v1.sandbox-controllers\"..." type=io.containerd.grpc.v1 Jan 29 11:05:32.173228 containerd[1413]: time="2025-01-29T11:05:32.172576265Z" level=info msg="loading plugin \"io.containerd.grpc.v1.sandboxes\"..." type=io.containerd.grpc.v1 Jan 29 11:05:32.173228 containerd[1413]: time="2025-01-29T11:05:32.172626188Z" level=info msg="loading plugin \"io.containerd.grpc.v1.snapshots\"..." type=io.containerd.grpc.v1 Jan 29 11:05:32.173228 containerd[1413]: time="2025-01-29T11:05:32.172648517Z" level=info msg="loading plugin \"io.containerd.grpc.v1.streaming\"..." type=io.containerd.grpc.v1 Jan 29 11:05:32.173228 containerd[1413]: time="2025-01-29T11:05:32.172683265Z" level=info msg="loading plugin \"io.containerd.grpc.v1.tasks\"..." type=io.containerd.grpc.v1 Jan 29 11:05:32.173228 containerd[1413]: time="2025-01-29T11:05:32.172720851Z" level=info msg="loading plugin \"io.containerd.transfer.v1.local\"..." type=io.containerd.transfer.v1 Jan 29 11:05:32.173228 containerd[1413]: time="2025-01-29T11:05:32.172767977Z" level=info msg="loading plugin \"io.containerd.grpc.v1.transfer\"..." type=io.containerd.grpc.v1 Jan 29 11:05:32.173228 containerd[1413]: time="2025-01-29T11:05:32.172846439Z" level=info msg="loading plugin \"io.containerd.grpc.v1.version\"..." type=io.containerd.grpc.v1 Jan 29 11:05:32.173228 containerd[1413]: time="2025-01-29T11:05:32.172865684Z" level=info msg="loading plugin \"io.containerd.internal.v1.restart\"..." type=io.containerd.internal.v1 Jan 29 11:05:32.173859 containerd[1413]: time="2025-01-29T11:05:32.173736779Z" level=info msg="loading plugin \"io.containerd.tracing.processor.v1.otlp\"..." type=io.containerd.tracing.processor.v1 Jan 29 11:05:32.173859 containerd[1413]: time="2025-01-29T11:05:32.173785632Z" 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 Jan 29 11:05:32.173859 containerd[1413]: time="2025-01-29T11:05:32.173831607Z" level=info msg="loading plugin \"io.containerd.internal.v1.tracing\"..." type=io.containerd.internal.v1 Jan 29 11:05:32.174052 containerd[1413]: time="2025-01-29T11:05:32.173850852Z" level=info msg="skip loading plugin \"io.containerd.internal.v1.tracing\"..." error="skip plugin: tracing endpoint not configured" type=io.containerd.internal.v1 Jan 29 11:05:32.174293 containerd[1413]: time="2025-01-29T11:05:32.174169221Z" level=info msg="loading plugin \"io.containerd.grpc.v1.healthcheck\"..." type=io.containerd.grpc.v1 Jan 29 11:05:32.174293 containerd[1413]: time="2025-01-29T11:05:32.174234770Z" level=info msg="loading plugin \"io.containerd.nri.v1.nri\"..." type=io.containerd.nri.v1 Jan 29 11:05:32.174293 containerd[1413]: time="2025-01-29T11:05:32.174247971Z" level=info msg="NRI interface is disabled by configuration." Jan 29 11:05:32.174293 containerd[1413]: time="2025-01-29T11:05:32.174259115Z" level=info msg="loading plugin \"io.containerd.grpc.v1.cri\"..." type=io.containerd.grpc.v1 Jan 29 11:05:32.174757 containerd[1413]: time="2025-01-29T11:05:32.174682880Z" level=info msg="Start cri plugin with config {PluginConfig:{ContainerdConfig:{Snapshotter:overlayfs DefaultRuntimeName:runc DefaultRuntime:{Type: Path: Engine: PodAnnotations:[] ContainerAnnotations:[] Root: Options:map[] PrivilegedWithoutHostDevices:false PrivilegedWithoutHostDevicesAllDevicesAllowed:false BaseRuntimeSpec: NetworkPluginConfDir: NetworkPluginMaxConfNum:0 Snapshotter: SandboxMode:} UntrustedWorkloadRuntime:{Type: Path: Engine: PodAnnotations:[] ContainerAnnotations:[] Root: Options:map[] PrivilegedWithoutHostDevices:false PrivilegedWithoutHostDevicesAllDevicesAllowed:false BaseRuntimeSpec: NetworkPluginConfDir: NetworkPluginMaxConfNum:0 Snapshotter: SandboxMode:} Runtimes:map[runc:{Type:io.containerd.runc.v2 Path: Engine: PodAnnotations:[] ContainerAnnotations:[] Root: Options:map[SystemdCgroup:true] PrivilegedWithoutHostDevices:false PrivilegedWithoutHostDevicesAllDevicesAllowed:false BaseRuntimeSpec: NetworkPluginConfDir: NetworkPluginMaxConfNum:0 Snapshotter: SandboxMode:podsandbox}] NoPivot:false DisableSnapshotAnnotations:true DiscardUnpackedLayers:false IgnoreBlockIONotEnabledErrors:false IgnoreRdtNotEnabledErrors:false} CniConfig:{NetworkPluginBinDir:/opt/cni/bin NetworkPluginConfDir:/etc/cni/net.d NetworkPluginMaxConfNum:1 NetworkPluginSetupSerially:false NetworkPluginConfTemplate: IPPreference:} Registry:{ConfigPath: Mirrors:map[] Configs:map[] Auths:map[] Headers:map[]} ImageDecryption:{KeyModel:node} DisableTCPService:true StreamServerAddress:127.0.0.1 StreamServerPort:0 StreamIdleTimeout:4h0m0s EnableSelinux:true SelinuxCategoryRange:1024 SandboxImage:registry.k8s.io/pause:3.8 StatsCollectPeriod:10 SystemdCgroup:false EnableTLSStreaming:false X509KeyPairStreaming:{TLSCertFile: TLSKeyFile:} MaxContainerLogLineSize:16384 DisableCgroup:false DisableApparmor:false RestrictOOMScoreAdj:false MaxConcurrentDownloads:3 DisableProcMount:false UnsetSeccompProfile: TolerateMissingHugetlbController:true DisableHugetlbController:true DeviceOwnershipFromSecurityContext:false IgnoreImageDefinedVolumes:false NetNSMountsUnderStateDir:false EnableUnprivilegedPorts:false EnableUnprivilegedICMP:false EnableCDI:false CDISpecDirs:[/etc/cdi /var/run/cdi] ImagePullProgressTimeout:5m0s DrainExecSyncIOTimeout:0s ImagePullWithSyncFs:false IgnoreDeprecationWarnings:[]} ContainerdRootDir:/var/lib/containerd ContainerdEndpoint:/run/containerd/containerd.sock RootDir:/var/lib/containerd/io.containerd.grpc.v1.cri StateDir:/run/containerd/io.containerd.grpc.v1.cri}" Jan 29 11:05:32.174909 containerd[1413]: time="2025-01-29T11:05:32.174761794Z" level=info msg="Connect containerd service" Jan 29 11:05:32.174909 containerd[1413]: time="2025-01-29T11:05:32.174810072Z" level=info msg="using legacy CRI server" Jan 29 11:05:32.174909 containerd[1413]: time="2025-01-29T11:05:32.174839187Z" level=info msg="using experimental NRI integration - disable nri plugin to prevent this" Jan 29 11:05:32.175091 containerd[1413]: time="2025-01-29T11:05:32.175072350Z" level=info msg="Get image filesystem path \"/var/lib/containerd/io.containerd.snapshotter.v1.overlayfs\"" Jan 29 11:05:32.175750 containerd[1413]: time="2025-01-29T11:05:32.175725455Z" 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" Jan 29 11:05:32.176279 containerd[1413]: time="2025-01-29T11:05:32.175936207Z" level=info msg="Start subscribing containerd event" Jan 29 11:05:32.176279 containerd[1413]: time="2025-01-29T11:05:32.175989173Z" level=info msg="Start recovering state" Jan 29 11:05:32.176279 containerd[1413]: time="2025-01-29T11:05:32.176053118Z" level=info msg="Start event monitor" Jan 29 11:05:32.176279 containerd[1413]: time="2025-01-29T11:05:32.176071335Z" level=info msg="Start snapshots syncer" Jan 29 11:05:32.176279 containerd[1413]: time="2025-01-29T11:05:32.176089635Z" level=info msg="Start cni network conf syncer for default" Jan 29 11:05:32.176279 containerd[1413]: time="2025-01-29T11:05:32.176097366Z" level=info msg="Start streaming server" Jan 29 11:05:32.176430 containerd[1413]: time="2025-01-29T11:05:32.176289983Z" level=info msg=serving... address=/run/containerd/containerd.sock.ttrpc Jan 29 11:05:32.176430 containerd[1413]: time="2025-01-29T11:05:32.176337932Z" level=info msg=serving... address=/run/containerd/containerd.sock Jan 29 11:05:32.176430 containerd[1413]: time="2025-01-29T11:05:32.176386333Z" level=info msg="containerd successfully booted in 0.042989s" Jan 29 11:05:32.176474 systemd[1]: Started containerd.service - containerd container runtime. Jan 29 11:05:32.560182 sshd_keygen[1409]: ssh-keygen: generating new host keys: RSA ECDSA ED25519 Jan 29 11:05:32.580962 systemd[1]: Finished sshd-keygen.service - Generate sshd host keys. Jan 29 11:05:32.601134 systemd[1]: Starting issuegen.service - Generate /run/issue... Jan 29 11:05:32.606773 systemd[1]: issuegen.service: Deactivated successfully. Jan 29 11:05:32.606995 systemd[1]: Finished issuegen.service - Generate /run/issue. Jan 29 11:05:32.609813 systemd[1]: Starting systemd-user-sessions.service - Permit User Sessions... Jan 29 11:05:32.623579 systemd[1]: Finished systemd-user-sessions.service - Permit User Sessions. Jan 29 11:05:32.626871 systemd[1]: Started getty@tty1.service - Getty on tty1. Jan 29 11:05:32.629009 systemd[1]: Started serial-getty@ttyAMA0.service - Serial Getty on ttyAMA0. Jan 29 11:05:32.630521 systemd[1]: Reached target getty.target - Login Prompts. Jan 29 11:05:33.829635 systemd-networkd[1353]: eth0: Gained IPv6LL Jan 29 11:05:33.835486 systemd[1]: Finished systemd-networkd-wait-online.service - Wait for Network to be Configured. Jan 29 11:05:33.837351 systemd[1]: Reached target network-online.target - Network is Online. Jan 29 11:05:33.852110 systemd[1]: Starting coreos-metadata.service - QEMU metadata agent... Jan 29 11:05:33.854337 systemd[1]: Starting nvidia.service - NVIDIA Configure Service... Jan 29 11:05:33.875812 systemd[1]: coreos-metadata.service: Deactivated successfully. Jan 29 11:05:33.876076 systemd[1]: Finished coreos-metadata.service - QEMU metadata agent. Jan 29 11:05:33.877960 systemd[1]: packet-phone-home.service - Report Success to Packet was skipped because no trigger condition checks were met. Jan 29 11:05:33.879552 systemd[1]: Finished nvidia.service - NVIDIA Configure Service. Jan 29 11:05:33.882663 systemd[1]: Reached target multi-user.target - Multi-User System. Jan 29 11:05:33.884905 systemd[1]: Startup finished in 687ms (kernel) + 3.700s (initrd) + 3.443s (userspace) = 7.832s. Jan 29 11:05:33.910255 agetty[1477]: failed to open credentials directory Jan 29 11:05:33.910364 agetty[1478]: failed to open credentials directory Jan 29 11:05:40.043580 systemd[1]: Created slice system-sshd.slice - Slice /system/sshd. Jan 29 11:05:40.045056 systemd[1]: Started sshd@0-10.0.0.110:22-10.0.0.1:40804.service - OpenSSH per-connection server daemon (10.0.0.1:40804). Jan 29 11:05:40.117753 sshd[1499]: Accepted publickey for core from 10.0.0.1 port 40804 ssh2: RSA SHA256:sI8AI+xrXTR4mEEiShqASd95E8XwBKuT8obfVDWOoDw Jan 29 11:05:40.119628 sshd-session[1499]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Jan 29 11:05:40.130696 systemd[1]: Created slice user-500.slice - User Slice of UID 500. Jan 29 11:05:40.139104 systemd[1]: Starting user-runtime-dir@500.service - User Runtime Directory /run/user/500... Jan 29 11:05:40.140862 systemd-logind[1400]: New session 1 of user core. Jan 29 11:05:40.148622 systemd[1]: Finished user-runtime-dir@500.service - User Runtime Directory /run/user/500. Jan 29 11:05:40.153163 systemd[1]: Starting user@500.service - User Manager for UID 500... Jan 29 11:05:40.159067 (systemd)[1503]: pam_unix(systemd-user:session): session opened for user core(uid=500) by (uid=0) Jan 29 11:05:40.244613 systemd[1503]: Queued start job for default target default.target. Jan 29 11:05:40.253747 systemd[1503]: Created slice app.slice - User Application Slice. Jan 29 11:05:40.253776 systemd[1503]: Reached target paths.target - Paths. Jan 29 11:05:40.253788 systemd[1503]: Reached target timers.target - Timers. Jan 29 11:05:40.255110 systemd[1503]: Starting dbus.socket - D-Bus User Message Bus Socket... Jan 29 11:05:40.265637 systemd[1503]: Listening on dbus.socket - D-Bus User Message Bus Socket. Jan 29 11:05:40.265725 systemd[1503]: Reached target sockets.target - Sockets. Jan 29 11:05:40.265739 systemd[1503]: Reached target basic.target - Basic System. Jan 29 11:05:40.265780 systemd[1503]: Reached target default.target - Main User Target. Jan 29 11:05:40.265822 systemd[1503]: Startup finished in 97ms. Jan 29 11:05:40.266085 systemd[1]: Started user@500.service - User Manager for UID 500. Jan 29 11:05:40.267577 systemd[1]: Started session-1.scope - Session 1 of User core. Jan 29 11:05:40.349642 systemd[1]: Started sshd@1-10.0.0.110:22-10.0.0.1:40814.service - OpenSSH per-connection server daemon (10.0.0.1:40814). Jan 29 11:05:40.390331 sshd[1514]: Accepted publickey for core from 10.0.0.1 port 40814 ssh2: RSA SHA256:sI8AI+xrXTR4mEEiShqASd95E8XwBKuT8obfVDWOoDw Jan 29 11:05:40.391596 sshd-session[1514]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Jan 29 11:05:40.395750 systemd-logind[1400]: New session 2 of user core. Jan 29 11:05:40.405022 systemd[1]: Started session-2.scope - Session 2 of User core. Jan 29 11:05:40.457083 sshd[1516]: Connection closed by 10.0.0.1 port 40814 Jan 29 11:05:40.457585 sshd-session[1514]: pam_unix(sshd:session): session closed for user core Jan 29 11:05:40.467039 systemd[1]: sshd@1-10.0.0.110:22-10.0.0.1:40814.service: Deactivated successfully. Jan 29 11:05:40.468360 systemd[1]: session-2.scope: Deactivated successfully. Jan 29 11:05:40.471472 systemd-logind[1400]: Session 2 logged out. Waiting for processes to exit. Jan 29 11:05:40.485647 systemd[1]: Started sshd@2-10.0.0.110:22-10.0.0.1:40822.service - OpenSSH per-connection server daemon (10.0.0.1:40822). Jan 29 11:05:40.486702 systemd-logind[1400]: Removed session 2. Jan 29 11:05:40.527092 sshd[1521]: Accepted publickey for core from 10.0.0.1 port 40822 ssh2: RSA SHA256:sI8AI+xrXTR4mEEiShqASd95E8XwBKuT8obfVDWOoDw Jan 29 11:05:40.528582 sshd-session[1521]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Jan 29 11:05:40.532539 systemd-logind[1400]: New session 3 of user core. Jan 29 11:05:40.555004 systemd[1]: Started session-3.scope - Session 3 of User core. Jan 29 11:05:40.603341 sshd[1523]: Connection closed by 10.0.0.1 port 40822 Jan 29 11:05:40.603827 sshd-session[1521]: pam_unix(sshd:session): session closed for user core Jan 29 11:05:40.619128 systemd[1]: sshd@2-10.0.0.110:22-10.0.0.1:40822.service: Deactivated successfully. Jan 29 11:05:40.620648 systemd[1]: session-3.scope: Deactivated successfully. Jan 29 11:05:40.623955 systemd-logind[1400]: Session 3 logged out. Waiting for processes to exit. Jan 29 11:05:40.642136 systemd[1]: Started sshd@3-10.0.0.110:22-10.0.0.1:40830.service - OpenSSH per-connection server daemon (10.0.0.1:40830). Jan 29 11:05:40.643015 systemd-logind[1400]: Removed session 3. Jan 29 11:05:40.682652 sshd[1528]: Accepted publickey for core from 10.0.0.1 port 40830 ssh2: RSA SHA256:sI8AI+xrXTR4mEEiShqASd95E8XwBKuT8obfVDWOoDw Jan 29 11:05:40.683986 sshd-session[1528]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Jan 29 11:05:40.687869 systemd-logind[1400]: New session 4 of user core. Jan 29 11:05:40.698978 systemd[1]: Started session-4.scope - Session 4 of User core. Jan 29 11:05:40.750443 sshd[1530]: Connection closed by 10.0.0.1 port 40830 Jan 29 11:05:40.750949 sshd-session[1528]: pam_unix(sshd:session): session closed for user core Jan 29 11:05:40.765128 systemd[1]: sshd@3-10.0.0.110:22-10.0.0.1:40830.service: Deactivated successfully. Jan 29 11:05:40.766523 systemd[1]: session-4.scope: Deactivated successfully. Jan 29 11:05:40.768787 systemd-logind[1400]: Session 4 logged out. Waiting for processes to exit. Jan 29 11:05:40.773059 systemd[1]: Started sshd@4-10.0.0.110:22-10.0.0.1:40840.service - OpenSSH per-connection server daemon (10.0.0.1:40840). Jan 29 11:05:40.773858 systemd-logind[1400]: Removed session 4. Jan 29 11:05:40.814246 sshd[1535]: Accepted publickey for core from 10.0.0.1 port 40840 ssh2: RSA SHA256:sI8AI+xrXTR4mEEiShqASd95E8XwBKuT8obfVDWOoDw Jan 29 11:05:40.815547 sshd-session[1535]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Jan 29 11:05:40.819264 systemd-logind[1400]: New session 5 of user core. Jan 29 11:05:40.831974 systemd[1]: Started session-5.scope - Session 5 of User core. Jan 29 11:05:40.897113 sudo[1538]: core : PWD=/home/core ; USER=root ; COMMAND=/usr/sbin/setenforce 1 Jan 29 11:05:40.897428 sudo[1538]: pam_unix(sudo:session): session opened for user root(uid=0) by core(uid=500) Jan 29 11:05:40.911863 sudo[1538]: pam_unix(sudo:session): session closed for user root Jan 29 11:05:40.913681 sshd[1537]: Connection closed by 10.0.0.1 port 40840 Jan 29 11:05:40.914112 sshd-session[1535]: pam_unix(sshd:session): session closed for user core Jan 29 11:05:40.924180 systemd[1]: sshd@4-10.0.0.110:22-10.0.0.1:40840.service: Deactivated successfully. Jan 29 11:05:40.925445 systemd[1]: session-5.scope: Deactivated successfully. Jan 29 11:05:40.926753 systemd-logind[1400]: Session 5 logged out. Waiting for processes to exit. Jan 29 11:05:40.928065 systemd[1]: Started sshd@5-10.0.0.110:22-10.0.0.1:40856.service - OpenSSH per-connection server daemon (10.0.0.1:40856). Jan 29 11:05:40.928896 systemd-logind[1400]: Removed session 5. Jan 29 11:05:40.972264 sshd[1543]: Accepted publickey for core from 10.0.0.1 port 40856 ssh2: RSA SHA256:sI8AI+xrXTR4mEEiShqASd95E8XwBKuT8obfVDWOoDw Jan 29 11:05:40.973565 sshd-session[1543]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Jan 29 11:05:40.977595 systemd-logind[1400]: New session 6 of user core. Jan 29 11:05:40.986978 systemd[1]: Started session-6.scope - Session 6 of User core. Jan 29 11:05:41.038491 sudo[1547]: 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 Jan 29 11:05:41.038787 sudo[1547]: pam_unix(sudo:session): session opened for user root(uid=0) by core(uid=500) Jan 29 11:05:41.042101 sudo[1547]: pam_unix(sudo:session): session closed for user root Jan 29 11:05:41.046910 sudo[1546]: core : PWD=/home/core ; USER=root ; COMMAND=/usr/sbin/systemctl restart audit-rules Jan 29 11:05:41.047447 sudo[1546]: pam_unix(sudo:session): session opened for user root(uid=0) by core(uid=500) Jan 29 11:05:41.067134 systemd[1]: Starting audit-rules.service - Load Audit Rules... Jan 29 11:05:41.092043 augenrules[1569]: No rules Jan 29 11:05:41.093338 systemd[1]: audit-rules.service: Deactivated successfully. Jan 29 11:05:41.093527 systemd[1]: Finished audit-rules.service - Load Audit Rules. Jan 29 11:05:41.094859 sudo[1546]: pam_unix(sudo:session): session closed for user root Jan 29 11:05:41.096884 sshd[1545]: Connection closed by 10.0.0.1 port 40856 Jan 29 11:05:41.097140 sshd-session[1543]: pam_unix(sshd:session): session closed for user core Jan 29 11:05:41.106380 systemd[1]: sshd@5-10.0.0.110:22-10.0.0.1:40856.service: Deactivated successfully. Jan 29 11:05:41.107999 systemd[1]: session-6.scope: Deactivated successfully. Jan 29 11:05:41.109225 systemd-logind[1400]: Session 6 logged out. Waiting for processes to exit. Jan 29 11:05:41.116121 systemd[1]: Started sshd@6-10.0.0.110:22-10.0.0.1:40860.service - OpenSSH per-connection server daemon (10.0.0.1:40860). Jan 29 11:05:41.117137 systemd-logind[1400]: Removed session 6. Jan 29 11:05:41.158798 sshd[1577]: Accepted publickey for core from 10.0.0.1 port 40860 ssh2: RSA SHA256:sI8AI+xrXTR4mEEiShqASd95E8XwBKuT8obfVDWOoDw Jan 29 11:05:41.160199 sshd-session[1577]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Jan 29 11:05:41.164492 systemd-logind[1400]: New session 7 of user core. Jan 29 11:05:41.175982 systemd[1]: Started session-7.scope - Session 7 of User core. Jan 29 11:05:41.230955 sudo[1585]: core : PWD=/tmp/tmp.SFaTn0VIxI ; USER=root ; COMMAND=/usr/sbin/ldd /usr/bin/echo /usr/bin/sleep Jan 29 11:05:41.231239 sudo[1585]: pam_unix(sudo:session): session opened for user root(uid=0) by core(uid=500) Jan 29 11:05:41.241940 sudo[1585]: pam_unix(sudo:session): session closed for user root Jan 29 11:05:41.247701 sudo[1597]: core : PWD=/tmp/tmp.SFaTn0VIxI ; USER=root ; COMMAND=/usr/sbin/rsync -av --relative --copy-links /usr/bin/echo /usr/bin/sleep /lib/ld-linux-aarch64.so.1 /lib64/ld-linux-aarch64.so.1 /lib64/libc.so.6 ./ Jan 29 11:05:41.248008 sudo[1597]: pam_unix(sudo:session): session opened for user root(uid=0) by core(uid=500) Jan 29 11:05:41.308889 sudo[1597]: pam_unix(sudo:session): session closed for user root Jan 29 11:05:41.314099 sudo[1581]: core : PWD=/tmp/tmp.SFaTn0VIxI ; USER=root ; COMMAND=/usr/sbin/docker build -t userns-test . Jan 29 11:05:41.314372 sudo[1581]: pam_unix(sudo:session): session opened for user root(uid=0) by core(uid=500) Jan 29 11:05:41.459079 systemd[1]: Starting docker.service - Docker Application Container Engine... Jan 29 11:05:41.459251 (dockerd)[1609]: docker.service: Referenced but unset environment variable evaluates to an empty string: DOCKER_CGROUPS, DOCKER_OPT_BIP, DOCKER_OPT_IPMASQ, DOCKER_OPT_MTU Jan 29 11:05:41.713223 dockerd[1609]: time="2025-01-29T11:05:41.713096990Z" level=info msg="User namespaces: ID ranges will be mapped to subuid/subgid ranges of: dockremap" Jan 29 11:05:41.713223 dockerd[1609]: time="2025-01-29T11:05:41.713209087Z" level=info msg="Starting up" Jan 29 11:05:41.713511 dockerd[1609]: time="2025-01-29T11:05:41.713319128Z" level=info msg="User namespaces: ID ranges will be mapped to subuid/subgid ranges of: dockremap" Jan 29 11:05:41.715431 dockerd[1609]: time="2025-01-29T11:05:41.715393925Z" level=info msg="User namespaces: ID ranges will be mapped to subuid/subgid ranges of: dockremap" Jan 29 11:05:41.798514 dockerd[1609]: time="2025-01-29T11:05:41.798295112Z" level=info msg="Loading containers: start." Jan 29 11:05:41.955830 kernel: Initializing XFRM netlink socket Jan 29 11:05:42.031118 systemd-networkd[1353]: docker0: Link UP Jan 29 11:05:42.068739 dockerd[1609]: time="2025-01-29T11:05:42.068680404Z" level=info msg="Loading containers: done." Jan 29 11:05:42.085323 systemd[1]: var-lib-docker-100000.100000-overlay2-opaque\x2dbug\x2dcheck2416401026-merged.mount: Deactivated successfully. Jan 29 11:05:42.091230 dockerd[1609]: time="2025-01-29T11:05:42.091181198Z" 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 Jan 29 11:05:42.091341 dockerd[1609]: time="2025-01-29T11:05:42.091294951Z" level=info msg="Docker daemon" commit=41ca978a0a5400cc24b274137efa9f25517fcc0b containerd-snapshotter=false storage-driver=overlay2 version=27.3.1 Jan 29 11:05:42.091570 dockerd[1609]: time="2025-01-29T11:05:42.091541719Z" level=info msg="Daemon has completed initialization" Jan 29 11:05:42.122312 dockerd[1609]: time="2025-01-29T11:05:42.122252189Z" level=info msg="API listen on /run/docker.sock" Jan 29 11:05:42.122401 systemd[1]: Started docker.service - Docker Application Container Engine. Jan 29 11:05:42.572959 sudo[1581]: pam_unix(sudo:session): session closed for user root Jan 29 11:05:42.574249 sshd[1580]: Connection closed by 10.0.0.1 port 40860 Jan 29 11:05:42.574744 sshd-session[1577]: pam_unix(sshd:session): session closed for user core Jan 29 11:05:42.583134 systemd[1]: sshd@6-10.0.0.110:22-10.0.0.1:40860.service: Deactivated successfully. Jan 29 11:05:42.584586 systemd[1]: session-7.scope: Deactivated successfully. Jan 29 11:05:42.585186 systemd-logind[1400]: Session 7 logged out. Waiting for processes to exit. Jan 29 11:05:42.586935 systemd[1]: Started sshd@7-10.0.0.110:22-10.0.0.1:37226.service - OpenSSH per-connection server daemon (10.0.0.1:37226). Jan 29 11:05:42.588219 systemd-logind[1400]: Removed session 7. Jan 29 11:05:42.630531 sshd[1830]: Accepted publickey for core from 10.0.0.1 port 37226 ssh2: RSA SHA256:sI8AI+xrXTR4mEEiShqASd95E8XwBKuT8obfVDWOoDw Jan 29 11:05:42.631833 sshd-session[1830]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Jan 29 11:05:42.635579 systemd-logind[1400]: New session 8 of user core. Jan 29 11:05:42.643963 systemd[1]: Started session-8.scope - Session 8 of User core. Jan 29 11:05:42.735943 kernel: docker0: port 1(vetha8b3565) entered blocking state Jan 29 11:05:42.736056 kernel: docker0: port 1(vetha8b3565) entered disabled state Jan 29 11:05:42.736074 kernel: vetha8b3565: entered allmulticast mode Jan 29 11:05:42.737110 kernel: vetha8b3565: entered promiscuous mode Jan 29 11:05:42.737296 systemd-networkd[1353]: vetha8b3565: Link UP Jan 29 11:05:42.737953 kernel: docker0: port 1(vetha8b3565) entered blocking state Jan 29 11:05:42.737997 kernel: docker0: port 1(vetha8b3565) entered forwarding state Jan 29 11:05:42.738963 kernel: docker0: port 1(vetha8b3565) entered disabled state Jan 29 11:05:42.855297 containerd[1413]: time="2025-01-29T11:05:42.854680178Z" level=info msg="loading plugin \"io.containerd.event.v1.publisher\"..." runtime=io.containerd.runc.v2 type=io.containerd.event.v1 Jan 29 11:05:42.855297 containerd[1413]: time="2025-01-29T11:05:42.855121854Z" level=info msg="loading plugin \"io.containerd.internal.v1.shutdown\"..." runtime=io.containerd.runc.v2 type=io.containerd.internal.v1 Jan 29 11:05:42.855297 containerd[1413]: time="2025-01-29T11:05:42.855135313Z" level=info msg="loading plugin \"io.containerd.ttrpc.v1.task\"..." runtime=io.containerd.runc.v2 type=io.containerd.ttrpc.v1 Jan 29 11:05:42.855756 containerd[1413]: time="2025-01-29T11:05:42.855686189Z" level=info msg="loading plugin \"io.containerd.ttrpc.v1.pause\"..." runtime=io.containerd.runc.v2 type=io.containerd.ttrpc.v1 Jan 29 11:05:42.875991 systemd[1]: Started docker-d266b9c119811fe686ab51ebe12344f9fb1b8d2b6d063bc01c1555cbdaddc39e.scope - libcontainer container d266b9c119811fe686ab51ebe12344f9fb1b8d2b6d063bc01c1555cbdaddc39e. Jan 29 11:05:42.927824 kernel: eth0: renamed from veth62a3137 Jan 29 11:05:42.942187 kernel: docker0: port 1(vetha8b3565) entered blocking state Jan 29 11:05:42.942278 kernel: docker0: port 1(vetha8b3565) entered forwarding state Jan 29 11:05:42.942331 systemd-networkd[1353]: vetha8b3565: Gained carrier Jan 29 11:05:42.943041 systemd-networkd[1353]: docker0: Gained carrier Jan 29 11:05:42.944408 systemd-resolved[1259]: Failed to determine the local hostname and LLMNR/mDNS names, ignoring: No such device or address Jan 29 11:05:42.968403 systemd[1]: docker-d266b9c119811fe686ab51ebe12344f9fb1b8d2b6d063bc01c1555cbdaddc39e.scope: Deactivated successfully. Jan 29 11:05:42.982696 dockerd[1609]: time="2025-01-29T11:05:42.982648942Z" level=info msg="ignoring event" container=d266b9c119811fe686ab51ebe12344f9fb1b8d2b6d063bc01c1555cbdaddc39e module=libcontainerd namespace=moby-100000.100000 topic=/tasks/delete type="*events.TaskDelete" Jan 29 11:05:42.983034 containerd[1413]: time="2025-01-29T11:05:42.982750406Z" level=info msg="shim disconnected" id=d266b9c119811fe686ab51ebe12344f9fb1b8d2b6d063bc01c1555cbdaddc39e namespace=moby-100000.100000 Jan 29 11:05:42.983034 containerd[1413]: time="2025-01-29T11:05:42.982850056Z" level=warning msg="cleaning up after shim disconnected" id=d266b9c119811fe686ab51ebe12344f9fb1b8d2b6d063bc01c1555cbdaddc39e namespace=moby-100000.100000 Jan 29 11:05:42.983034 containerd[1413]: time="2025-01-29T11:05:42.982860936Z" level=info msg="cleaning up dead shim" namespace=moby-100000.100000 Jan 29 11:05:42.999037 kernel: docker0: port 1(vetha8b3565) entered disabled state Jan 29 11:05:42.999144 kernel: veth62a3137: renamed from eth0 Jan 29 11:05:42.998713 systemd-networkd[1353]: vetha8b3565: Lost carrier Jan 29 11:05:43.020657 systemd-networkd[1353]: vetha8b3565: Link DOWN Jan 29 11:05:43.022396 kernel: docker0: port 1(vetha8b3565) entered disabled state Jan 29 11:05:43.022453 kernel: vetha8b3565 (unregistering): left allmulticast mode Jan 29 11:05:43.023372 kernel: vetha8b3565 (unregistering): left promiscuous mode Jan 29 11:05:43.023402 kernel: docker0: port 1(vetha8b3565) entered disabled state Jan 29 11:05:43.048632 systemd[1]: run-docker-netns-16acc700225d.mount: Deactivated successfully. Jan 29 11:05:43.050493 systemd[1]: var-lib-docker-100000.100000-overlay2-cb56dbca6805f32f0641b2d0c6a931e6d4141e521b9e07381c6aa13af7468279-merged.mount: Deactivated successfully. Jan 29 11:05:43.060712 sshd[1832]: Connection closed by 10.0.0.1 port 37226 Jan 29 11:05:43.061044 sshd-session[1830]: pam_unix(sshd:session): session closed for user core Jan 29 11:05:43.071211 systemd[1]: sshd@7-10.0.0.110:22-10.0.0.1:37226.service: Deactivated successfully. Jan 29 11:05:43.072722 systemd[1]: session-8.scope: Deactivated successfully. Jan 29 11:05:43.075191 systemd-logind[1400]: Session 8 logged out. Waiting for processes to exit. Jan 29 11:05:43.081098 systemd[1]: Started sshd@8-10.0.0.110:22-10.0.0.1:37228.service - OpenSSH per-connection server daemon (10.0.0.1:37228). Jan 29 11:05:43.082309 systemd-logind[1400]: Removed session 8. Jan 29 11:05:43.121644 sshd[1928]: Accepted publickey for core from 10.0.0.1 port 37228 ssh2: RSA SHA256:sI8AI+xrXTR4mEEiShqASd95E8XwBKuT8obfVDWOoDw Jan 29 11:05:43.122462 sshd-session[1928]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Jan 29 11:05:43.126661 systemd-logind[1400]: New session 9 of user core. Jan 29 11:05:43.137987 systemd[1]: Started session-9.scope - Session 9 of User core. Jan 29 11:05:43.274373 kernel: docker0: port 1(veth9b77c97) entered blocking state Jan 29 11:05:43.274498 kernel: docker0: port 1(veth9b77c97) entered disabled state Jan 29 11:05:43.274519 kernel: veth9b77c97: entered allmulticast mode Jan 29 11:05:43.274535 kernel: veth9b77c97: entered promiscuous mode Jan 29 11:05:43.274550 kernel: docker0: port 1(veth9b77c97) entered blocking state Jan 29 11:05:43.274576 systemd-networkd[1353]: veth9b77c97: Link UP Jan 29 11:05:43.275987 kernel: docker0: port 1(veth9b77c97) entered forwarding state Jan 29 11:05:43.311706 containerd[1413]: time="2025-01-29T11:05:43.311565000Z" level=info msg="loading plugin \"io.containerd.event.v1.publisher\"..." runtime=io.containerd.runc.v2 type=io.containerd.event.v1 Jan 29 11:05:43.311706 containerd[1413]: time="2025-01-29T11:05:43.311655662Z" level=info msg="loading plugin \"io.containerd.internal.v1.shutdown\"..." runtime=io.containerd.runc.v2 type=io.containerd.internal.v1 Jan 29 11:05:43.311706 containerd[1413]: time="2025-01-29T11:05:43.311667901Z" level=info msg="loading plugin \"io.containerd.ttrpc.v1.task\"..." runtime=io.containerd.runc.v2 type=io.containerd.ttrpc.v1 Jan 29 11:05:43.312142 containerd[1413]: time="2025-01-29T11:05:43.312088762Z" level=info msg="loading plugin \"io.containerd.ttrpc.v1.pause\"..." runtime=io.containerd.runc.v2 type=io.containerd.ttrpc.v1 Jan 29 11:05:43.334011 systemd[1]: Started docker-1b703d2e3017caa0a6f66ca4fc4b5451e63ee1da7806f99c2ea87961fa0eaf36.scope - libcontainer container 1b703d2e3017caa0a6f66ca4fc4b5451e63ee1da7806f99c2ea87961fa0eaf36. Jan 29 11:05:43.382840 kernel: eth0: renamed from veth1ab25c4 Jan 29 11:05:43.391644 systemd-networkd[1353]: veth9b77c97: Gained carrier Jan 29 11:05:43.395183 systemd-resolved[1259]: Failed to determine the local hostname and LLMNR/mDNS names, ignoring: No such device or address Jan 29 11:05:43.417849 sshd[1930]: Connection closed by 10.0.0.1 port 37228 Jan 29 11:05:43.417915 sshd-session[1928]: pam_unix(sshd:session): session closed for user core Jan 29 11:05:43.432326 systemd[1]: sshd@8-10.0.0.110:22-10.0.0.1:37228.service: Deactivated successfully. Jan 29 11:05:43.434007 systemd[1]: session-9.scope: Deactivated successfully. Jan 29 11:05:43.435375 systemd-logind[1400]: Session 9 logged out. Waiting for processes to exit. Jan 29 11:05:43.449198 systemd[1]: Started sshd@9-10.0.0.110:22-10.0.0.1:37234.service - OpenSSH per-connection server daemon (10.0.0.1:37234). Jan 29 11:05:43.450234 systemd-logind[1400]: Removed session 9. Jan 29 11:05:43.490936 sshd[1997]: Accepted publickey for core from 10.0.0.1 port 37234 ssh2: RSA SHA256:sI8AI+xrXTR4mEEiShqASd95E8XwBKuT8obfVDWOoDw Jan 29 11:05:43.492278 sshd-session[1997]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Jan 29 11:05:43.496426 systemd-logind[1400]: New session 10 of user core. Jan 29 11:05:43.507991 systemd[1]: Started session-10.scope - Session 10 of User core. Jan 29 11:05:43.601256 systemd[1]: docker-1b703d2e3017caa0a6f66ca4fc4b5451e63ee1da7806f99c2ea87961fa0eaf36.scope: Deactivated successfully. Jan 29 11:05:43.613038 dockerd[1609]: time="2025-01-29T11:05:43.612965929Z" level=info msg="ignoring event" container=1b703d2e3017caa0a6f66ca4fc4b5451e63ee1da7806f99c2ea87961fa0eaf36 module=libcontainerd namespace=moby-100000.100000 topic=/tasks/delete type="*events.TaskDelete" Jan 29 11:05:43.613209 containerd[1413]: time="2025-01-29T11:05:43.613051881Z" level=info msg="shim disconnected" id=1b703d2e3017caa0a6f66ca4fc4b5451e63ee1da7806f99c2ea87961fa0eaf36 namespace=moby-100000.100000 Jan 29 11:05:43.613209 containerd[1413]: time="2025-01-29T11:05:43.613103895Z" level=warning msg="cleaning up after shim disconnected" id=1b703d2e3017caa0a6f66ca4fc4b5451e63ee1da7806f99c2ea87961fa0eaf36 namespace=moby-100000.100000 Jan 29 11:05:43.613209 containerd[1413]: time="2025-01-29T11:05:43.613126681Z" level=info msg="cleaning up dead shim" namespace=moby-100000.100000 Jan 29 11:05:43.627826 kernel: veth1ab25c4: renamed from eth0 Jan 29 11:05:43.635894 kernel: docker0: port 1(veth9b77c97) entered disabled state Jan 29 11:05:43.635887 systemd-networkd[1353]: veth9b77c97: Lost carrier Jan 29 11:05:43.649432 systemd-networkd[1353]: veth9b77c97: Link DOWN Jan 29 11:05:43.651778 kernel: docker0: port 1(veth9b77c97) entered disabled state Jan 29 11:05:43.651848 kernel: veth9b77c97 (unregistering): left allmulticast mode Jan 29 11:05:43.651862 kernel: veth9b77c97 (unregistering): left promiscuous mode Jan 29 11:05:43.653229 kernel: docker0: port 1(veth9b77c97) entered disabled state Jan 29 11:05:43.677673 sshd[1999]: Connection closed by 10.0.0.1 port 37234 Jan 29 11:05:43.678059 sshd-session[1997]: pam_unix(sshd:session): session closed for user core Jan 29 11:05:43.681860 systemd[1]: sshd@9-10.0.0.110:22-10.0.0.1:37234.service: Deactivated successfully. Jan 29 11:05:43.684228 systemd[1]: session-10.scope: Deactivated successfully. Jan 29 11:05:43.686094 systemd-logind[1400]: Session 10 logged out. Waiting for processes to exit. Jan 29 11:05:43.687235 systemd-logind[1400]: Removed session 10. Jan 29 11:05:44.004076 systemd-networkd[1353]: docker0: Lost carrier Jan 29 11:05:44.260369 systemd-networkd[1353]: docker0: Gained IPv6LL