May 13 00:08:14.972227 kernel: Booting Linux on physical CPU 0x0000000000 [0x413fd0c1] May 13 00:08:14.972407 kernel: Linux version 6.6.89-flatcar (build@pony-truck.infra.kinvolk.io) (aarch64-cros-linux-gnu-gcc (Gentoo Hardened 13.3.1_p20240614 p17) 13.3.1 20240614, GNU ld (Gentoo 2.42 p3) 2.42.0) #1 SMP PREEMPT Mon May 12 22:51:32 -00 2025 May 13 00:08:14.972429 kernel: KASLR enabled May 13 00:08:14.972436 kernel: efi: EFI v2.7 by EDK II May 13 00:08:14.972442 kernel: efi: SMBIOS 3.0=0xdced0000 MEMATTR=0xdba86018 ACPI 2.0=0xd9710018 RNG=0xd971e498 MEMRESERVE=0xd9b43d18 May 13 00:08:14.972447 kernel: random: crng init done May 13 00:08:14.972455 kernel: ACPI: Early table checksum verification disabled May 13 00:08:14.972460 kernel: ACPI: RSDP 0x00000000D9710018 000024 (v02 BOCHS ) May 13 00:08:14.972467 kernel: ACPI: XSDT 0x00000000D971FE98 000064 (v01 BOCHS BXPC 00000001 01000013) May 13 00:08:14.972475 kernel: ACPI: FACP 0x00000000D971FA98 000114 (v06 BOCHS BXPC 00000001 BXPC 00000001) May 13 00:08:14.972481 kernel: ACPI: DSDT 0x00000000D9717518 0014A2 (v02 BOCHS BXPC 00000001 BXPC 00000001) May 13 00:08:14.972487 kernel: ACPI: APIC 0x00000000D971FC18 0001A8 (v04 BOCHS BXPC 00000001 BXPC 00000001) May 13 00:08:14.972493 kernel: ACPI: PPTT 0x00000000D971D898 00009C (v02 BOCHS BXPC 00000001 BXPC 00000001) May 13 00:08:14.972499 kernel: ACPI: GTDT 0x00000000D971E818 000060 (v02 BOCHS BXPC 00000001 BXPC 00000001) May 13 00:08:14.972506 kernel: ACPI: MCFG 0x00000000D971E918 00003C (v01 BOCHS BXPC 00000001 BXPC 00000001) May 13 00:08:14.972514 kernel: ACPI: SPCR 0x00000000D971FF98 000050 (v02 BOCHS BXPC 00000001 BXPC 00000001) May 13 00:08:14.972521 kernel: ACPI: DBG2 0x00000000D971E418 000057 (v00 BOCHS BXPC 00000001 BXPC 00000001) May 13 00:08:14.972528 kernel: ACPI: IORT 0x00000000D971E718 000080 (v03 BOCHS BXPC 00000001 BXPC 00000001) May 13 00:08:14.972534 kernel: ACPI: SPCR: console: pl011,mmio,0x9000000,9600 May 13 00:08:14.972540 kernel: NUMA: Failed to initialise from firmware May 13 00:08:14.972547 kernel: NUMA: Faking a node at [mem 0x0000000040000000-0x00000000dcffffff] May 13 00:08:14.972553 kernel: NUMA: NODE_DATA [mem 0xdc957800-0xdc95cfff] May 13 00:08:14.972559 kernel: Zone ranges: May 13 00:08:14.972566 kernel: DMA [mem 0x0000000040000000-0x00000000dcffffff] May 13 00:08:14.972572 kernel: DMA32 empty May 13 00:08:14.972580 kernel: Normal empty May 13 00:08:14.972586 kernel: Movable zone start for each node May 13 00:08:14.972592 kernel: Early memory node ranges May 13 00:08:14.972599 kernel: node 0: [mem 0x0000000040000000-0x00000000d976ffff] May 13 00:08:14.972605 kernel: node 0: [mem 0x00000000d9770000-0x00000000d9b3ffff] May 13 00:08:14.972611 kernel: node 0: [mem 0x00000000d9b40000-0x00000000dce1ffff] May 13 00:08:14.972618 kernel: node 0: [mem 0x00000000dce20000-0x00000000dceaffff] May 13 00:08:14.972624 kernel: node 0: [mem 0x00000000dceb0000-0x00000000dcebffff] May 13 00:08:14.972630 kernel: node 0: [mem 0x00000000dcec0000-0x00000000dcfdffff] May 13 00:08:14.972636 kernel: node 0: [mem 0x00000000dcfe0000-0x00000000dcffffff] May 13 00:08:14.972643 kernel: Initmem setup node 0 [mem 0x0000000040000000-0x00000000dcffffff] May 13 00:08:14.972649 kernel: On node 0, zone DMA: 12288 pages in unavailable ranges May 13 00:08:14.972657 kernel: psci: probing for conduit method from ACPI. May 13 00:08:14.972663 kernel: psci: PSCIv1.1 detected in firmware. May 13 00:08:14.972670 kernel: psci: Using standard PSCI v0.2 function IDs May 13 00:08:14.972679 kernel: psci: Trusted OS migration not required May 13 00:08:14.972685 kernel: psci: SMC Calling Convention v1.1 May 13 00:08:14.972692 kernel: smccc: KVM: hypervisor services detected (0x00000000 0x00000000 0x00000000 0x00000003) May 13 00:08:14.972701 kernel: percpu: Embedded 31 pages/cpu s86632 r8192 d32152 u126976 May 13 00:08:14.972707 kernel: pcpu-alloc: s86632 r8192 d32152 u126976 alloc=31*4096 May 13 00:08:14.972714 kernel: pcpu-alloc: [0] 0 [0] 1 [0] 2 [0] 3 May 13 00:08:14.972721 kernel: Detected PIPT I-cache on CPU0 May 13 00:08:14.972728 kernel: CPU features: detected: GIC system register CPU interface May 13 00:08:14.972734 kernel: CPU features: detected: Hardware dirty bit management May 13 00:08:14.972741 kernel: CPU features: detected: Spectre-v4 May 13 00:08:14.972748 kernel: CPU features: detected: Spectre-BHB May 13 00:08:14.972754 kernel: CPU features: kernel page table isolation forced ON by KASLR May 13 00:08:14.972761 kernel: CPU features: detected: Kernel page table isolation (KPTI) May 13 00:08:14.972769 kernel: CPU features: detected: ARM erratum 1418040 May 13 00:08:14.972776 kernel: CPU features: detected: SSBS not fully self-synchronizing May 13 00:08:14.972783 kernel: alternatives: applying boot alternatives May 13 00:08:14.972791 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=c683f9f6a9915f3c14a7bce5c93750f29fcd5cf6eb0774e11e882c5681cc19c0 May 13 00:08:14.972798 kernel: Unknown kernel command line parameters "BOOT_IMAGE=/flatcar/vmlinuz-a", will be passed to user space. May 13 00:08:14.972804 kernel: Dentry cache hash table entries: 524288 (order: 10, 4194304 bytes, linear) May 13 00:08:14.972811 kernel: Inode-cache hash table entries: 262144 (order: 9, 2097152 bytes, linear) May 13 00:08:14.972818 kernel: Fallback order for Node 0: 0 May 13 00:08:14.972825 kernel: Built 1 zonelists, mobility grouping on. Total pages: 633024 May 13 00:08:14.972831 kernel: Policy zone: DMA May 13 00:08:14.972838 kernel: mem auto-init: stack:off, heap alloc:off, heap free:off May 13 00:08:14.972846 kernel: software IO TLB: area num 4. May 13 00:08:14.972853 kernel: software IO TLB: mapped [mem 0x00000000d2e00000-0x00000000d6e00000] (64MB) May 13 00:08:14.972860 kernel: Memory: 2386400K/2572288K available (10304K kernel code, 2186K rwdata, 8104K rodata, 39424K init, 897K bss, 185888K reserved, 0K cma-reserved) May 13 00:08:14.972867 kernel: SLUB: HWalign=64, Order=0-3, MinObjects=0, CPUs=4, Nodes=1 May 13 00:08:14.972874 kernel: rcu: Preemptible hierarchical RCU implementation. May 13 00:08:14.972881 kernel: rcu: RCU event tracing is enabled. May 13 00:08:14.972888 kernel: rcu: RCU restricting CPUs from NR_CPUS=512 to nr_cpu_ids=4. May 13 00:08:14.972895 kernel: Trampoline variant of Tasks RCU enabled. May 13 00:08:14.972901 kernel: Tracing variant of Tasks RCU enabled. May 13 00:08:14.972908 kernel: rcu: RCU calculated value of scheduler-enlistment delay is 100 jiffies. May 13 00:08:14.972915 kernel: rcu: Adjusting geometry for rcu_fanout_leaf=16, nr_cpu_ids=4 May 13 00:08:14.972921 kernel: NR_IRQS: 64, nr_irqs: 64, preallocated irqs: 0 May 13 00:08:14.972930 kernel: GICv3: 256 SPIs implemented May 13 00:08:14.972936 kernel: GICv3: 0 Extended SPIs implemented May 13 00:08:14.972943 kernel: Root IRQ handler: gic_handle_irq May 13 00:08:14.972950 kernel: GICv3: GICv3 features: 16 PPIs, DirectLPI May 13 00:08:14.972956 kernel: GICv3: CPU0: found redistributor 0 region 0:0x00000000080a0000 May 13 00:08:14.972963 kernel: ITS [mem 0x08080000-0x0809ffff] May 13 00:08:14.972969 kernel: ITS@0x0000000008080000: allocated 8192 Devices @400c0000 (indirect, esz 8, psz 64K, shr 1) May 13 00:08:14.972976 kernel: ITS@0x0000000008080000: allocated 8192 Interrupt Collections @400d0000 (flat, esz 8, psz 64K, shr 1) May 13 00:08:14.972983 kernel: GICv3: using LPI property table @0x00000000400f0000 May 13 00:08:14.972990 kernel: GICv3: CPU0: using allocated LPI pending table @0x0000000040100000 May 13 00:08:14.972997 kernel: rcu: srcu_init: Setting srcu_struct sizes based on contention. May 13 00:08:14.973005 kernel: arch_timer: Enabling local workaround for ARM erratum 1418040 May 13 00:08:14.973011 kernel: arch_timer: cp15 timer(s) running at 25.00MHz (virt). May 13 00:08:14.973019 kernel: clocksource: arch_sys_counter: mask: 0xffffffffffffff max_cycles: 0x5c40939b5, max_idle_ns: 440795202646 ns May 13 00:08:14.973026 kernel: sched_clock: 56 bits at 25MHz, resolution 40ns, wraps every 4398046511100ns May 13 00:08:14.973032 kernel: arm-pv: using stolen time PV May 13 00:08:14.973039 kernel: Console: colour dummy device 80x25 May 13 00:08:14.973046 kernel: ACPI: Core revision 20230628 May 13 00:08:14.973053 kernel: Calibrating delay loop (skipped), value calculated using timer frequency.. 50.00 BogoMIPS (lpj=25000) May 13 00:08:14.973060 kernel: pid_max: default: 32768 minimum: 301 May 13 00:08:14.973067 kernel: LSM: initializing lsm=lockdown,capability,landlock,selinux,integrity May 13 00:08:14.973075 kernel: landlock: Up and running. May 13 00:08:14.973082 kernel: SELinux: Initializing. May 13 00:08:14.973089 kernel: Mount-cache hash table entries: 8192 (order: 4, 65536 bytes, linear) May 13 00:08:14.973096 kernel: Mountpoint-cache hash table entries: 8192 (order: 4, 65536 bytes, linear) May 13 00:08:14.973102 kernel: ACPI PPTT: PPTT table found, but unable to locate core 3 (3) May 13 00:08:14.973110 kernel: RCU Tasks: Setting shift to 2 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=4. May 13 00:08:14.973117 kernel: RCU Tasks Trace: Setting shift to 2 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=4. May 13 00:08:14.973124 kernel: rcu: Hierarchical SRCU implementation. May 13 00:08:14.973131 kernel: rcu: Max phase no-delay instances is 400. May 13 00:08:14.973139 kernel: Platform MSI: ITS@0x8080000 domain created May 13 00:08:14.973146 kernel: PCI/MSI: ITS@0x8080000 domain created May 13 00:08:14.973153 kernel: Remapping and enabling EFI services. May 13 00:08:14.973159 kernel: smp: Bringing up secondary CPUs ... May 13 00:08:14.973166 kernel: Detected PIPT I-cache on CPU1 May 13 00:08:14.973173 kernel: GICv3: CPU1: found redistributor 1 region 0:0x00000000080c0000 May 13 00:08:14.973180 kernel: GICv3: CPU1: using allocated LPI pending table @0x0000000040110000 May 13 00:08:14.973187 kernel: arch_timer: Enabling local workaround for ARM erratum 1418040 May 13 00:08:14.973194 kernel: CPU1: Booted secondary processor 0x0000000001 [0x413fd0c1] May 13 00:08:14.973202 kernel: Detected PIPT I-cache on CPU2 May 13 00:08:14.973209 kernel: GICv3: CPU2: found redistributor 2 region 0:0x00000000080e0000 May 13 00:08:14.973216 kernel: GICv3: CPU2: using allocated LPI pending table @0x0000000040120000 May 13 00:08:14.973228 kernel: arch_timer: Enabling local workaround for ARM erratum 1418040 May 13 00:08:14.973237 kernel: CPU2: Booted secondary processor 0x0000000002 [0x413fd0c1] May 13 00:08:14.973244 kernel: Detected PIPT I-cache on CPU3 May 13 00:08:14.973268 kernel: GICv3: CPU3: found redistributor 3 region 0:0x0000000008100000 May 13 00:08:14.973275 kernel: GICv3: CPU3: using allocated LPI pending table @0x0000000040130000 May 13 00:08:14.973283 kernel: arch_timer: Enabling local workaround for ARM erratum 1418040 May 13 00:08:14.973290 kernel: CPU3: Booted secondary processor 0x0000000003 [0x413fd0c1] May 13 00:08:14.973297 kernel: smp: Brought up 1 node, 4 CPUs May 13 00:08:14.973307 kernel: SMP: Total of 4 processors activated. May 13 00:08:14.973314 kernel: CPU features: detected: 32-bit EL0 Support May 13 00:08:14.973322 kernel: CPU features: detected: Data cache clean to the PoU not required for I/D coherence May 13 00:08:14.973329 kernel: CPU features: detected: Common not Private translations May 13 00:08:14.973336 kernel: CPU features: detected: CRC32 instructions May 13 00:08:14.973344 kernel: CPU features: detected: Enhanced Virtualization Traps May 13 00:08:14.973352 kernel: CPU features: detected: RCpc load-acquire (LDAPR) May 13 00:08:14.973360 kernel: CPU features: detected: LSE atomic instructions May 13 00:08:14.973367 kernel: CPU features: detected: Privileged Access Never May 13 00:08:14.973374 kernel: CPU features: detected: RAS Extension Support May 13 00:08:14.973381 kernel: CPU features: detected: Speculative Store Bypassing Safe (SSBS) May 13 00:08:14.973388 kernel: CPU: All CPU(s) started at EL1 May 13 00:08:14.973396 kernel: alternatives: applying system-wide alternatives May 13 00:08:14.973403 kernel: devtmpfs: initialized May 13 00:08:14.973410 kernel: clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1911260446275000 ns May 13 00:08:14.973417 kernel: futex hash table entries: 1024 (order: 4, 65536 bytes, linear) May 13 00:08:14.973426 kernel: pinctrl core: initialized pinctrl subsystem May 13 00:08:14.973433 kernel: SMBIOS 3.0.0 present. May 13 00:08:14.973440 kernel: DMI: QEMU KVM Virtual Machine, BIOS edk2-20230524-3.fc38 05/24/2023 May 13 00:08:14.973447 kernel: NET: Registered PF_NETLINK/PF_ROUTE protocol family May 13 00:08:14.973454 kernel: DMA: preallocated 512 KiB GFP_KERNEL pool for atomic allocations May 13 00:08:14.973524 kernel: DMA: preallocated 512 KiB GFP_KERNEL|GFP_DMA pool for atomic allocations May 13 00:08:14.973533 kernel: DMA: preallocated 512 KiB GFP_KERNEL|GFP_DMA32 pool for atomic allocations May 13 00:08:14.973540 kernel: audit: initializing netlink subsys (disabled) May 13 00:08:14.973551 kernel: audit: type=2000 audit(0.034:1): state=initialized audit_enabled=0 res=1 May 13 00:08:14.973558 kernel: thermal_sys: Registered thermal governor 'step_wise' May 13 00:08:14.973565 kernel: cpuidle: using governor menu May 13 00:08:14.973573 kernel: hw-breakpoint: found 6 breakpoint and 4 watchpoint registers. May 13 00:08:14.973580 kernel: ASID allocator initialised with 32768 entries May 13 00:08:14.973587 kernel: acpiphp: ACPI Hot Plug PCI Controller Driver version: 0.5 May 13 00:08:14.973595 kernel: Serial: AMBA PL011 UART driver May 13 00:08:14.973602 kernel: Modules: 2G module region forced by RANDOMIZE_MODULE_REGION_FULL May 13 00:08:14.973609 kernel: Modules: 0 pages in range for non-PLT usage May 13 00:08:14.973616 kernel: Modules: 509008 pages in range for PLT usage May 13 00:08:14.973626 kernel: HugeTLB: registered 1.00 GiB page size, pre-allocated 0 pages May 13 00:08:14.973633 kernel: HugeTLB: 0 KiB vmemmap can be freed for a 1.00 GiB page May 13 00:08:14.973640 kernel: HugeTLB: registered 32.0 MiB page size, pre-allocated 0 pages May 13 00:08:14.973648 kernel: HugeTLB: 0 KiB vmemmap can be freed for a 32.0 MiB page May 13 00:08:14.973655 kernel: HugeTLB: registered 2.00 MiB page size, pre-allocated 0 pages May 13 00:08:14.973662 kernel: HugeTLB: 0 KiB vmemmap can be freed for a 2.00 MiB page May 13 00:08:14.973670 kernel: HugeTLB: registered 64.0 KiB page size, pre-allocated 0 pages May 13 00:08:14.973677 kernel: HugeTLB: 0 KiB vmemmap can be freed for a 64.0 KiB page May 13 00:08:14.973684 kernel: ACPI: Added _OSI(Module Device) May 13 00:08:14.973693 kernel: ACPI: Added _OSI(Processor Device) May 13 00:08:14.973700 kernel: ACPI: Added _OSI(3.0 _SCP Extensions) May 13 00:08:14.973707 kernel: ACPI: Added _OSI(Processor Aggregator Device) May 13 00:08:14.973714 kernel: ACPI: 1 ACPI AML tables successfully acquired and loaded May 13 00:08:14.973721 kernel: ACPI: Interpreter enabled May 13 00:08:14.973728 kernel: ACPI: Using GIC for interrupt routing May 13 00:08:14.973735 kernel: ACPI: MCFG table detected, 1 entries May 13 00:08:14.973743 kernel: ARMH0011:00: ttyAMA0 at MMIO 0x9000000 (irq = 12, base_baud = 0) is a SBSA May 13 00:08:14.973750 kernel: printk: console [ttyAMA0] enabled May 13 00:08:14.973759 kernel: ACPI: PCI Root Bridge [PCI0] (domain 0000 [bus 00-ff]) May 13 00:08:14.973906 kernel: acpi PNP0A08:00: _OSC: OS supports [ExtendedConfig ASPM ClockPM Segments MSI HPX-Type3] May 13 00:08:14.973982 kernel: acpi PNP0A08:00: _OSC: platform does not support [LTR] May 13 00:08:14.974049 kernel: acpi PNP0A08:00: _OSC: OS now controls [PCIeHotplug PME AER PCIeCapability] May 13 00:08:14.974189 kernel: acpi PNP0A08:00: ECAM area [mem 0x4010000000-0x401fffffff] reserved by PNP0C02:00 May 13 00:08:14.974287 kernel: acpi PNP0A08:00: ECAM at [mem 0x4010000000-0x401fffffff] for [bus 00-ff] May 13 00:08:14.974299 kernel: ACPI: Remapped I/O 0x000000003eff0000 to [io 0x0000-0xffff window] May 13 00:08:14.974311 kernel: PCI host bridge to bus 0000:00 May 13 00:08:14.974390 kernel: pci_bus 0000:00: root bus resource [mem 0x10000000-0x3efeffff window] May 13 00:08:14.974452 kernel: pci_bus 0000:00: root bus resource [io 0x0000-0xffff window] May 13 00:08:14.974511 kernel: pci_bus 0000:00: root bus resource [mem 0x8000000000-0xffffffffff window] May 13 00:08:14.974676 kernel: pci_bus 0000:00: root bus resource [bus 00-ff] May 13 00:08:14.974785 kernel: pci 0000:00:00.0: [1b36:0008] type 00 class 0x060000 May 13 00:08:14.974874 kernel: pci 0000:00:01.0: [1af4:1005] type 00 class 0x00ff00 May 13 00:08:14.974945 kernel: pci 0000:00:01.0: reg 0x10: [io 0x0000-0x001f] May 13 00:08:14.975015 kernel: pci 0000:00:01.0: reg 0x14: [mem 0x10000000-0x10000fff] May 13 00:08:14.975098 kernel: pci 0000:00:01.0: reg 0x20: [mem 0x8000000000-0x8000003fff 64bit pref] May 13 00:08:14.975167 kernel: pci 0000:00:01.0: BAR 4: assigned [mem 0x8000000000-0x8000003fff 64bit pref] May 13 00:08:14.975234 kernel: pci 0000:00:01.0: BAR 1: assigned [mem 0x10000000-0x10000fff] May 13 00:08:14.975341 kernel: pci 0000:00:01.0: BAR 0: assigned [io 0x1000-0x101f] May 13 00:08:14.975425 kernel: pci_bus 0000:00: resource 4 [mem 0x10000000-0x3efeffff window] May 13 00:08:14.975488 kernel: pci_bus 0000:00: resource 5 [io 0x0000-0xffff window] May 13 00:08:14.975546 kernel: pci_bus 0000:00: resource 6 [mem 0x8000000000-0xffffffffff window] May 13 00:08:14.975556 kernel: ACPI: PCI: Interrupt link GSI0 configured for IRQ 35 May 13 00:08:14.975563 kernel: ACPI: PCI: Interrupt link GSI1 configured for IRQ 36 May 13 00:08:14.975571 kernel: ACPI: PCI: Interrupt link GSI2 configured for IRQ 37 May 13 00:08:14.975578 kernel: ACPI: PCI: Interrupt link GSI3 configured for IRQ 38 May 13 00:08:14.975585 kernel: iommu: Default domain type: Translated May 13 00:08:14.975595 kernel: iommu: DMA domain TLB invalidation policy: strict mode May 13 00:08:14.975602 kernel: efivars: Registered efivars operations May 13 00:08:14.975609 kernel: vgaarb: loaded May 13 00:08:14.975617 kernel: clocksource: Switched to clocksource arch_sys_counter May 13 00:08:14.975624 kernel: VFS: Disk quotas dquot_6.6.0 May 13 00:08:14.975632 kernel: VFS: Dquot-cache hash table entries: 512 (order 0, 4096 bytes) May 13 00:08:14.975639 kernel: pnp: PnP ACPI init May 13 00:08:14.975718 kernel: system 00:00: [mem 0x4010000000-0x401fffffff window] could not be reserved May 13 00:08:14.975729 kernel: pnp: PnP ACPI: found 1 devices May 13 00:08:14.975738 kernel: NET: Registered PF_INET protocol family May 13 00:08:14.975746 kernel: IP idents hash table entries: 65536 (order: 7, 524288 bytes, linear) May 13 00:08:14.975754 kernel: tcp_listen_portaddr_hash hash table entries: 2048 (order: 3, 32768 bytes, linear) May 13 00:08:14.975761 kernel: Table-perturb hash table entries: 65536 (order: 6, 262144 bytes, linear) May 13 00:08:14.975768 kernel: TCP established hash table entries: 32768 (order: 6, 262144 bytes, linear) May 13 00:08:14.975776 kernel: TCP bind hash table entries: 32768 (order: 8, 1048576 bytes, linear) May 13 00:08:14.975783 kernel: TCP: Hash tables configured (established 32768 bind 32768) May 13 00:08:14.975790 kernel: UDP hash table entries: 2048 (order: 4, 65536 bytes, linear) May 13 00:08:14.975799 kernel: UDP-Lite hash table entries: 2048 (order: 4, 65536 bytes, linear) May 13 00:08:14.975807 kernel: NET: Registered PF_UNIX/PF_LOCAL protocol family May 13 00:08:14.975814 kernel: PCI: CLS 0 bytes, default 64 May 13 00:08:14.975821 kernel: kvm [1]: HYP mode not available May 13 00:08:14.975828 kernel: Initialise system trusted keyrings May 13 00:08:14.975836 kernel: workingset: timestamp_bits=39 max_order=20 bucket_order=0 May 13 00:08:14.975843 kernel: Key type asymmetric registered May 13 00:08:14.975850 kernel: Asymmetric key parser 'x509' registered May 13 00:08:14.975857 kernel: Block layer SCSI generic (bsg) driver version 0.4 loaded (major 250) May 13 00:08:14.975864 kernel: io scheduler mq-deadline registered May 13 00:08:14.975873 kernel: io scheduler kyber registered May 13 00:08:14.975880 kernel: io scheduler bfq registered May 13 00:08:14.975888 kernel: input: Power Button as /devices/LNXSYSTM:00/LNXSYBUS:00/PNP0C0C:00/input/input0 May 13 00:08:14.975895 kernel: ACPI: button: Power Button [PWRB] May 13 00:08:14.975903 kernel: ACPI: \_SB_.PCI0.GSI1: Enabled at IRQ 36 May 13 00:08:14.975970 kernel: virtio-pci 0000:00:01.0: enabling device (0005 -> 0007) May 13 00:08:14.975980 kernel: Serial: 8250/16550 driver, 4 ports, IRQ sharing enabled May 13 00:08:14.975988 kernel: thunder_xcv, ver 1.0 May 13 00:08:14.975995 kernel: thunder_bgx, ver 1.0 May 13 00:08:14.976004 kernel: nicpf, ver 1.0 May 13 00:08:14.976012 kernel: nicvf, ver 1.0 May 13 00:08:14.976087 kernel: rtc-efi rtc-efi.0: registered as rtc0 May 13 00:08:14.976156 kernel: rtc-efi rtc-efi.0: setting system clock to 2025-05-13T00:08:14 UTC (1747094894) May 13 00:08:14.976166 kernel: hid: raw HID events driver (C) Jiri Kosina May 13 00:08:14.976173 kernel: hw perfevents: enabled with armv8_pmuv3_0 PMU driver, 7 counters available May 13 00:08:14.976181 kernel: watchdog: Delayed init of the lockup detector failed: -19 May 13 00:08:14.976188 kernel: watchdog: Hard watchdog permanently disabled May 13 00:08:14.976197 kernel: NET: Registered PF_INET6 protocol family May 13 00:08:14.976204 kernel: Segment Routing with IPv6 May 13 00:08:14.976211 kernel: In-situ OAM (IOAM) with IPv6 May 13 00:08:14.976219 kernel: NET: Registered PF_PACKET protocol family May 13 00:08:14.976226 kernel: Key type dns_resolver registered May 13 00:08:14.976233 kernel: registered taskstats version 1 May 13 00:08:14.976240 kernel: Loading compiled-in X.509 certificates May 13 00:08:14.976254 kernel: Loaded X.509 cert 'Kinvolk GmbH: Module signing key for 6.6.89-flatcar: ce22d51a4ec909274ada9cb7da7d7cb78db539c6' May 13 00:08:14.976280 kernel: Key type .fscrypt registered May 13 00:08:14.976290 kernel: Key type fscrypt-provisioning registered May 13 00:08:14.976298 kernel: ima: No TPM chip found, activating TPM-bypass! May 13 00:08:14.976305 kernel: ima: Allocated hash algorithm: sha1 May 13 00:08:14.976312 kernel: ima: No architecture policies found May 13 00:08:14.976320 kernel: alg: No test for fips(ansi_cprng) (fips_ansi_cprng) May 13 00:08:14.976328 kernel: clk: Disabling unused clocks May 13 00:08:14.976335 kernel: Freeing unused kernel memory: 39424K May 13 00:08:14.976342 kernel: Run /init as init process May 13 00:08:14.976349 kernel: with arguments: May 13 00:08:14.976358 kernel: /init May 13 00:08:14.976365 kernel: with environment: May 13 00:08:14.976372 kernel: HOME=/ May 13 00:08:14.976379 kernel: TERM=linux May 13 00:08:14.976387 kernel: BOOT_IMAGE=/flatcar/vmlinuz-a May 13 00:08:14.976396 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) May 13 00:08:14.976406 systemd[1]: Detected virtualization kvm. May 13 00:08:14.976416 systemd[1]: Detected architecture arm64. May 13 00:08:14.976423 systemd[1]: Running in initrd. May 13 00:08:14.976514 systemd[1]: No hostname configured, using default hostname. May 13 00:08:14.976524 systemd[1]: Hostname set to . May 13 00:08:14.976532 systemd[1]: Initializing machine ID from VM UUID. May 13 00:08:14.976544 systemd[1]: Queued start job for default target initrd.target. May 13 00:08:14.976554 systemd[1]: Started clevis-luks-askpass.path - Forward Password Requests to Clevis Directory Watch. May 13 00:08:14.976565 systemd[1]: Started systemd-ask-password-console.path - Dispatch Password Requests to Console Directory Watch. May 13 00:08:14.976577 systemd[1]: Expecting device dev-disk-by\x2dlabel-EFI\x2dSYSTEM.device - /dev/disk/by-label/EFI-SYSTEM... May 13 00:08:14.976585 systemd[1]: Expecting device dev-disk-by\x2dlabel-OEM.device - /dev/disk/by-label/OEM... May 13 00:08:14.976593 systemd[1]: Expecting device dev-disk-by\x2dlabel-ROOT.device - /dev/disk/by-label/ROOT... May 13 00:08:14.976602 systemd[1]: Expecting device dev-disk-by\x2dpartlabel-USR\x2dA.device - /dev/disk/by-partlabel/USR-A... May 13 00:08:14.976611 systemd[1]: Expecting device dev-disk-by\x2dpartuuid-7130c94a\x2d213a\x2d4e5a\x2d8e26\x2d6cce9662f132.device - /dev/disk/by-partuuid/7130c94a-213a-4e5a-8e26-6cce9662f132... May 13 00:08:14.976620 systemd[1]: Expecting device dev-mapper-usr.device - /dev/mapper/usr... May 13 00:08:14.976628 systemd[1]: Reached target cryptsetup-pre.target - Local Encrypted Volumes (Pre). May 13 00:08:14.976637 systemd[1]: Reached target cryptsetup.target - Local Encrypted Volumes. May 13 00:08:14.976645 systemd[1]: Reached target paths.target - Path Units. May 13 00:08:14.976653 systemd[1]: Reached target slices.target - Slice Units. May 13 00:08:14.976661 systemd[1]: Reached target swap.target - Swaps. May 13 00:08:14.976669 systemd[1]: Reached target timers.target - Timer Units. May 13 00:08:14.976677 systemd[1]: Listening on iscsid.socket - Open-iSCSI iscsid Socket. May 13 00:08:14.976685 systemd[1]: Listening on iscsiuio.socket - Open-iSCSI iscsiuio Socket. May 13 00:08:14.976693 systemd[1]: Listening on systemd-journald-dev-log.socket - Journal Socket (/dev/log). May 13 00:08:14.976701 systemd[1]: Listening on systemd-journald.socket - Journal Socket. May 13 00:08:14.976710 systemd[1]: Listening on systemd-networkd.socket - Network Service Netlink Socket. May 13 00:08:14.976718 systemd[1]: Listening on systemd-udevd-control.socket - udev Control Socket. May 13 00:08:14.976726 systemd[1]: Listening on systemd-udevd-kernel.socket - udev Kernel Socket. May 13 00:08:14.976734 systemd[1]: Reached target sockets.target - Socket Units. May 13 00:08:14.976742 systemd[1]: Starting ignition-setup-pre.service - Ignition env setup... May 13 00:08:14.976750 systemd[1]: Starting kmod-static-nodes.service - Create List of Static Device Nodes... May 13 00:08:14.976758 systemd[1]: Finished network-cleanup.service - Network Cleanup. May 13 00:08:14.976766 systemd[1]: Starting systemd-fsck-usr.service... May 13 00:08:14.976775 systemd[1]: Starting systemd-journald.service - Journal Service... May 13 00:08:14.976783 systemd[1]: Starting systemd-modules-load.service - Load Kernel Modules... May 13 00:08:14.976807 systemd[1]: Starting systemd-vconsole-setup.service - Virtual Console Setup... May 13 00:08:14.976815 systemd[1]: Finished ignition-setup-pre.service - Ignition env setup. May 13 00:08:14.976823 systemd[1]: Finished kmod-static-nodes.service - Create List of Static Device Nodes. May 13 00:08:14.976831 systemd[1]: Finished systemd-fsck-usr.service. May 13 00:08:14.976841 systemd[1]: Starting systemd-tmpfiles-setup-dev-early.service - Create Static Device Nodes in /dev gracefully... May 13 00:08:14.976875 systemd-journald[238]: Collecting audit messages is disabled. May 13 00:08:14.976896 systemd[1]: Finished systemd-vconsole-setup.service - Virtual Console Setup. May 13 00:08:14.976907 systemd[1]: Starting dracut-cmdline-ask.service - dracut ask for additional cmdline parameters... May 13 00:08:14.976915 kernel: bridge: filtering via arp/ip/ip6tables is no longer available by default. Update your scripts to load br_netfilter if you need this. May 13 00:08:14.976923 systemd-journald[238]: Journal started May 13 00:08:14.976942 systemd-journald[238]: Runtime Journal (/run/log/journal/48e78331efc04cf7b5782fde4b6cddf4) is 5.9M, max 47.3M, 41.4M free. May 13 00:08:14.962405 systemd-modules-load[239]: Inserted module 'overlay' May 13 00:08:14.980723 systemd[1]: Finished systemd-tmpfiles-setup-dev-early.service - Create Static Device Nodes in /dev gracefully. May 13 00:08:14.982046 kernel: Bridge firewalling registered May 13 00:08:14.982573 systemd-modules-load[239]: Inserted module 'br_netfilter' May 13 00:08:14.984275 systemd[1]: Started systemd-journald.service - Journal Service. May 13 00:08:14.986799 systemd[1]: Finished systemd-modules-load.service - Load Kernel Modules. May 13 00:08:14.995463 systemd[1]: Starting systemd-sysctl.service - Apply Kernel Variables... May 13 00:08:14.997671 systemd[1]: Starting systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev... May 13 00:08:15.000462 systemd[1]: Starting systemd-tmpfiles-setup.service - Create System Files and Directories... May 13 00:08:15.001852 systemd[1]: Finished dracut-cmdline-ask.service - dracut ask for additional cmdline parameters. May 13 00:08:15.004707 systemd[1]: Finished systemd-sysctl.service - Apply Kernel Variables. May 13 00:08:15.009515 systemd[1]: Starting dracut-cmdline.service - dracut cmdline hook... May 13 00:08:15.010764 systemd[1]: Finished systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev. May 13 00:08:15.014714 systemd[1]: Finished systemd-tmpfiles-setup.service - Create System Files and Directories. May 13 00:08:15.017749 systemd[1]: Starting systemd-resolved.service - Network Name Resolution... May 13 00:08:15.025407 dracut-cmdline[273]: dracut-dracut-053 May 13 00:08:15.027905 dracut-cmdline[273]: 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=c683f9f6a9915f3c14a7bce5c93750f29fcd5cf6eb0774e11e882c5681cc19c0 May 13 00:08:15.065685 systemd-resolved[278]: Positive Trust Anchors: May 13 00:08:15.065702 systemd-resolved[278]: . IN DS 20326 8 2 e06d44b80b8f1d39a95c0b0d7c65d08458e880409bbc683457104237c7f8ec8d May 13 00:08:15.065734 systemd-resolved[278]: Negative trust anchors: home.arpa 10.in-addr.arpa 16.172.in-addr.arpa 17.172.in-addr.arpa 18.172.in-addr.arpa 19.172.in-addr.arpa 20.172.in-addr.arpa 21.172.in-addr.arpa 22.172.in-addr.arpa 23.172.in-addr.arpa 24.172.in-addr.arpa 25.172.in-addr.arpa 26.172.in-addr.arpa 27.172.in-addr.arpa 28.172.in-addr.arpa 29.172.in-addr.arpa 30.172.in-addr.arpa 31.172.in-addr.arpa 170.0.0.192.in-addr.arpa 171.0.0.192.in-addr.arpa 168.192.in-addr.arpa d.f.ip6.arpa ipv4only.arpa resolver.arpa corp home internal intranet lan local private test May 13 00:08:15.070818 systemd-resolved[278]: Defaulting to hostname 'linux'. May 13 00:08:15.071861 systemd[1]: Started systemd-resolved.service - Network Name Resolution. May 13 00:08:15.076014 systemd[1]: Reached target nss-lookup.target - Host and Network Name Lookups. May 13 00:08:15.103380 kernel: SCSI subsystem initialized May 13 00:08:15.109292 kernel: Loading iSCSI transport class v2.0-870. May 13 00:08:15.117285 kernel: iscsi: registered transport (tcp) May 13 00:08:15.130557 kernel: iscsi: registered transport (qla4xxx) May 13 00:08:15.130607 kernel: QLogic iSCSI HBA Driver May 13 00:08:15.171635 systemd[1]: Finished dracut-cmdline.service - dracut cmdline hook. May 13 00:08:15.183445 systemd[1]: Starting dracut-pre-udev.service - dracut pre-udev hook... May 13 00:08:15.200876 kernel: device-mapper: core: CONFIG_IMA_DISABLE_HTABLE is disabled. Duplicate IMA measurements will not be recorded in the IMA log. May 13 00:08:15.200942 kernel: device-mapper: uevent: version 1.0.3 May 13 00:08:15.204683 kernel: device-mapper: ioctl: 4.48.0-ioctl (2023-03-01) initialised: dm-devel@redhat.com May 13 00:08:15.252294 kernel: raid6: neonx8 gen() 14431 MB/s May 13 00:08:15.269283 kernel: raid6: neonx4 gen() 15281 MB/s May 13 00:08:15.286282 kernel: raid6: neonx2 gen() 12067 MB/s May 13 00:08:15.303282 kernel: raid6: neonx1 gen() 10293 MB/s May 13 00:08:15.320277 kernel: raid6: int64x8 gen() 6902 MB/s May 13 00:08:15.337283 kernel: raid6: int64x4 gen() 7300 MB/s May 13 00:08:15.354284 kernel: raid6: int64x2 gen() 6007 MB/s May 13 00:08:15.371490 kernel: raid6: int64x1 gen() 4989 MB/s May 13 00:08:15.371516 kernel: raid6: using algorithm neonx4 gen() 15281 MB/s May 13 00:08:15.389479 kernel: raid6: .... xor() 12171 MB/s, rmw enabled May 13 00:08:15.389510 kernel: raid6: using neon recovery algorithm May 13 00:08:15.395800 kernel: xor: measuring software checksum speed May 13 00:08:15.395819 kernel: 8regs : 19797 MB/sec May 13 00:08:15.395828 kernel: 32regs : 19622 MB/sec May 13 00:08:15.396454 kernel: arm64_neon : 26998 MB/sec May 13 00:08:15.396466 kernel: xor: using function: arm64_neon (26998 MB/sec) May 13 00:08:15.449120 kernel: Btrfs loaded, zoned=no, fsverity=no May 13 00:08:15.460445 systemd[1]: Finished dracut-pre-udev.service - dracut pre-udev hook. May 13 00:08:15.469470 systemd[1]: Starting systemd-udevd.service - Rule-based Manager for Device Events and Files... May 13 00:08:15.481748 systemd-udevd[460]: Using default interface naming scheme 'v255'. May 13 00:08:15.485139 systemd[1]: Started systemd-udevd.service - Rule-based Manager for Device Events and Files. May 13 00:08:15.497545 systemd[1]: Starting dracut-pre-trigger.service - dracut pre-trigger hook... May 13 00:08:15.510288 dracut-pre-trigger[468]: rd.md=0: removing MD RAID activation May 13 00:08:15.538854 systemd[1]: Finished dracut-pre-trigger.service - dracut pre-trigger hook. May 13 00:08:15.549505 systemd[1]: Starting systemd-udev-trigger.service - Coldplug All udev Devices... May 13 00:08:15.596401 systemd[1]: Finished systemd-udev-trigger.service - Coldplug All udev Devices. May 13 00:08:15.605477 systemd[1]: Starting dracut-initqueue.service - dracut initqueue hook... May 13 00:08:15.629302 systemd[1]: Finished dracut-initqueue.service - dracut initqueue hook. May 13 00:08:15.631607 systemd[1]: Reached target remote-fs-pre.target - Preparation for Remote File Systems. May 13 00:08:15.632964 systemd[1]: Reached target remote-cryptsetup.target - Remote Encrypted Volumes. May 13 00:08:15.635178 systemd[1]: Reached target remote-fs.target - Remote File Systems. May 13 00:08:15.644646 systemd[1]: Starting dracut-pre-mount.service - dracut pre-mount hook... May 13 00:08:15.654079 systemd[1]: Finished dracut-pre-mount.service - dracut pre-mount hook. May 13 00:08:15.663397 kernel: virtio_blk virtio1: 1/0/0 default/read/poll queues May 13 00:08:15.672338 kernel: virtio_blk virtio1: [vda] 19775488 512-byte logical blocks (10.1 GB/9.43 GiB) May 13 00:08:15.672487 kernel: GPT:Primary header thinks Alt. header is not at the end of the disk. May 13 00:08:15.672498 kernel: GPT:9289727 != 19775487 May 13 00:08:15.672507 kernel: GPT:Alternate GPT header not at the end of the disk. May 13 00:08:15.672516 kernel: GPT:9289727 != 19775487 May 13 00:08:15.672534 kernel: GPT: Use GNU Parted to correct GPT errors. May 13 00:08:15.672544 kernel: vda: vda1 vda2 vda3 vda4 vda6 vda7 vda9 May 13 00:08:15.664532 systemd[1]: dracut-cmdline-ask.service: Deactivated successfully. May 13 00:08:15.664645 systemd[1]: Stopped dracut-cmdline-ask.service - dracut ask for additional cmdline parameters. May 13 00:08:15.666038 systemd[1]: Stopping dracut-cmdline-ask.service - dracut ask for additional cmdline parameters... May 13 00:08:15.669352 systemd[1]: systemd-vconsole-setup.service: Deactivated successfully. May 13 00:08:15.669499 systemd[1]: Stopped systemd-vconsole-setup.service - Virtual Console Setup. May 13 00:08:15.672192 systemd[1]: Stopping systemd-vconsole-setup.service - Virtual Console Setup... May 13 00:08:15.684615 systemd[1]: Starting systemd-vconsole-setup.service - Virtual Console Setup... May 13 00:08:15.699349 systemd[1]: Finished systemd-vconsole-setup.service - Virtual Console Setup. May 13 00:08:15.714428 systemd[1]: Starting dracut-cmdline-ask.service - dracut ask for additional cmdline parameters... May 13 00:08:15.729486 kernel: BTRFS: device label OEM devid 1 transid 12 /dev/vda6 scanned by (udev-worker) (513) May 13 00:08:15.729543 kernel: BTRFS: device fsid ffc5eb33-beca-4ca0-9735-b9a50e66f21e devid 1 transid 40 /dev/vda3 scanned by (udev-worker) (506) May 13 00:08:15.738554 systemd[1]: Finished dracut-cmdline-ask.service - dracut ask for additional cmdline parameters. May 13 00:08:15.746688 systemd[1]: Found device dev-disk-by\x2dlabel-ROOT.device - /dev/disk/by-label/ROOT. May 13 00:08:15.750995 systemd[1]: Found device dev-disk-by\x2dpartuuid-7130c94a\x2d213a\x2d4e5a\x2d8e26\x2d6cce9662f132.device - /dev/disk/by-partuuid/7130c94a-213a-4e5a-8e26-6cce9662f132. May 13 00:08:15.752279 systemd[1]: Found device dev-disk-by\x2dpartlabel-USR\x2dA.device - /dev/disk/by-partlabel/USR-A. May 13 00:08:15.759003 systemd[1]: Found device dev-disk-by\x2dlabel-EFI\x2dSYSTEM.device - /dev/disk/by-label/EFI-SYSTEM. May 13 00:08:15.763919 systemd[1]: Found device dev-disk-by\x2dlabel-OEM.device - /dev/disk/by-label/OEM. May 13 00:08:15.775431 systemd[1]: Starting disk-uuid.service - Generate new UUID for disk GPT if necessary... May 13 00:08:15.780882 disk-uuid[559]: Primary Header is updated. May 13 00:08:15.780882 disk-uuid[559]: Secondary Entries is updated. May 13 00:08:15.780882 disk-uuid[559]: Secondary Header is updated. May 13 00:08:15.787288 kernel: vda: vda1 vda2 vda3 vda4 vda6 vda7 vda9 May 13 00:08:16.802282 kernel: vda: vda1 vda2 vda3 vda4 vda6 vda7 vda9 May 13 00:08:16.802373 disk-uuid[560]: The operation has completed successfully. May 13 00:08:16.832090 systemd[1]: disk-uuid.service: Deactivated successfully. May 13 00:08:16.832194 systemd[1]: Finished disk-uuid.service - Generate new UUID for disk GPT if necessary. May 13 00:08:16.855457 systemd[1]: Starting verity-setup.service - Verity Setup for /dev/mapper/usr... May 13 00:08:16.858676 sh[576]: Success May 13 00:08:16.870284 kernel: device-mapper: verity: sha256 using implementation "sha256-ce" May 13 00:08:16.925812 systemd[1]: Found device dev-mapper-usr.device - /dev/mapper/usr. May 13 00:08:16.927832 systemd[1]: Mounting sysusr-usr.mount - /sysusr/usr... May 13 00:08:16.928805 systemd[1]: Finished verity-setup.service - Verity Setup for /dev/mapper/usr. May 13 00:08:16.940563 kernel: BTRFS info (device dm-0): first mount of filesystem ffc5eb33-beca-4ca0-9735-b9a50e66f21e May 13 00:08:16.940614 kernel: BTRFS info (device dm-0): using crc32c (crc32c-generic) checksum algorithm May 13 00:08:16.940626 kernel: BTRFS warning (device dm-0): 'nologreplay' is deprecated, use 'rescue=nologreplay' instead May 13 00:08:16.942458 kernel: BTRFS info (device dm-0): disabling log replay at mount time May 13 00:08:16.942474 kernel: BTRFS info (device dm-0): using free space tree May 13 00:08:16.946801 systemd[1]: Mounted sysusr-usr.mount - /sysusr/usr. May 13 00:08:16.948237 systemd[1]: afterburn-network-kargs.service - Afterburn Initrd Setup Network Kernel Arguments was skipped because no trigger condition checks were met. May 13 00:08:16.959413 systemd[1]: Starting ignition-setup.service - Ignition (setup)... May 13 00:08:16.960997 systemd[1]: Starting parse-ip-for-networkd.service - Write systemd-networkd units from cmdline... May 13 00:08:16.970005 kernel: BTRFS info (device vda6): first mount of filesystem 0068254f-7e0d-4c83-ad3e-204802432981 May 13 00:08:16.970047 kernel: BTRFS info (device vda6): using crc32c (crc32c-generic) checksum algorithm May 13 00:08:16.970064 kernel: BTRFS info (device vda6): using free space tree May 13 00:08:16.973289 kernel: BTRFS info (device vda6): auto enabling async discard May 13 00:08:16.981012 systemd[1]: mnt-oem.mount: Deactivated successfully. May 13 00:08:16.983127 kernel: BTRFS info (device vda6): last unmount of filesystem 0068254f-7e0d-4c83-ad3e-204802432981 May 13 00:08:16.989097 systemd[1]: Finished ignition-setup.service - Ignition (setup). May 13 00:08:16.994587 systemd[1]: Starting ignition-fetch-offline.service - Ignition (fetch-offline)... May 13 00:08:17.082967 systemd[1]: Finished parse-ip-for-networkd.service - Write systemd-networkd units from cmdline. May 13 00:08:17.100438 systemd[1]: Starting systemd-networkd.service - Network Configuration... May 13 00:08:17.134817 systemd-networkd[762]: lo: Link UP May 13 00:08:17.134828 systemd-networkd[762]: lo: Gained carrier May 13 00:08:17.135535 systemd-networkd[762]: Enumeration completed May 13 00:08:17.135658 systemd[1]: Started systemd-networkd.service - Network Configuration. May 13 00:08:17.136386 systemd-networkd[762]: eth0: found matching network '/usr/lib/systemd/network/zz-default.network', based on potentially unpredictable interface name. May 13 00:08:17.136389 systemd-networkd[762]: eth0: Configuring with /usr/lib/systemd/network/zz-default.network. May 13 00:08:17.137203 systemd-networkd[762]: eth0: Link UP May 13 00:08:17.137206 systemd-networkd[762]: eth0: Gained carrier May 13 00:08:17.137213 systemd-networkd[762]: eth0: found matching network '/usr/lib/systemd/network/zz-default.network', based on potentially unpredictable interface name. May 13 00:08:17.137617 systemd[1]: Reached target network.target - Network. May 13 00:08:17.172315 systemd-networkd[762]: eth0: DHCPv4 address 10.0.0.15/16, gateway 10.0.0.1 acquired from 10.0.0.1 May 13 00:08:17.174504 ignition[669]: Ignition 2.19.0 May 13 00:08:17.174514 ignition[669]: Stage: fetch-offline May 13 00:08:17.174549 ignition[669]: no configs at "/usr/lib/ignition/base.d" May 13 00:08:17.174557 ignition[669]: no config dir at "/usr/lib/ignition/base.platform.d/qemu" May 13 00:08:17.174706 ignition[669]: parsed url from cmdline: "" May 13 00:08:17.174710 ignition[669]: no config URL provided May 13 00:08:17.174714 ignition[669]: reading system config file "/usr/lib/ignition/user.ign" May 13 00:08:17.174721 ignition[669]: no config at "/usr/lib/ignition/user.ign" May 13 00:08:17.174745 ignition[669]: op(1): [started] loading QEMU firmware config module May 13 00:08:17.174751 ignition[669]: op(1): executing: "modprobe" "qemu_fw_cfg" May 13 00:08:17.191005 ignition[669]: op(1): [finished] loading QEMU firmware config module May 13 00:08:17.220441 ignition[669]: parsing config with SHA512: 2150d176f316f3fb825327855771d7debade354b9a5a2be9d6311258c7e6064b619a15fc6174c81cbc85952325239b84605fa6dab9567a93b6dec42a9e155a32 May 13 00:08:17.237208 unknown[669]: fetched base config from "system" May 13 00:08:17.237219 unknown[669]: fetched user config from "qemu" May 13 00:08:17.237525 ignition[669]: fetch-offline: fetch-offline passed May 13 00:08:17.239833 systemd[1]: Finished ignition-fetch-offline.service - Ignition (fetch-offline). May 13 00:08:17.237707 ignition[669]: Ignition finished successfully May 13 00:08:17.241291 systemd[1]: ignition-fetch.service - Ignition (fetch) was skipped because of an unmet condition check (ConditionPathExists=!/run/ignition.json). May 13 00:08:17.260477 systemd[1]: Starting ignition-kargs.service - Ignition (kargs)... May 13 00:08:17.271199 ignition[773]: Ignition 2.19.0 May 13 00:08:17.271209 ignition[773]: Stage: kargs May 13 00:08:17.271412 ignition[773]: no configs at "/usr/lib/ignition/base.d" May 13 00:08:17.271423 ignition[773]: no config dir at "/usr/lib/ignition/base.platform.d/qemu" May 13 00:08:17.274874 systemd[1]: Finished ignition-kargs.service - Ignition (kargs). May 13 00:08:17.272156 ignition[773]: kargs: kargs passed May 13 00:08:17.272197 ignition[773]: Ignition finished successfully May 13 00:08:17.286445 systemd[1]: Starting ignition-disks.service - Ignition (disks)... May 13 00:08:17.295926 ignition[781]: Ignition 2.19.0 May 13 00:08:17.295938 ignition[781]: Stage: disks May 13 00:08:17.296104 ignition[781]: no configs at "/usr/lib/ignition/base.d" May 13 00:08:17.296114 ignition[781]: no config dir at "/usr/lib/ignition/base.platform.d/qemu" May 13 00:08:17.296887 ignition[781]: disks: disks passed May 13 00:08:17.296932 ignition[781]: Ignition finished successfully May 13 00:08:17.300338 systemd[1]: Finished ignition-disks.service - Ignition (disks). May 13 00:08:17.301909 systemd[1]: Reached target initrd-root-device.target - Initrd Root Device. May 13 00:08:17.303528 systemd[1]: Reached target local-fs-pre.target - Preparation for Local File Systems. May 13 00:08:17.305565 systemd[1]: Reached target local-fs.target - Local File Systems. May 13 00:08:17.307585 systemd[1]: Reached target sysinit.target - System Initialization. May 13 00:08:17.309447 systemd[1]: Reached target basic.target - Basic System. May 13 00:08:17.312047 systemd[1]: Starting systemd-fsck-root.service - File System Check on /dev/disk/by-label/ROOT... May 13 00:08:17.326975 systemd-fsck[790]: ROOT: clean, 14/553520 files, 52654/553472 blocks May 13 00:08:17.330975 systemd[1]: Finished systemd-fsck-root.service - File System Check on /dev/disk/by-label/ROOT. May 13 00:08:17.343374 systemd[1]: Mounting sysroot.mount - /sysroot... May 13 00:08:17.388281 kernel: EXT4-fs (vda9): mounted filesystem 9903c37e-4e5a-41d4-80e5-5c3428d04b7e r/w with ordered data mode. Quota mode: none. May 13 00:08:17.388405 systemd[1]: Mounted sysroot.mount - /sysroot. May 13 00:08:17.389777 systemd[1]: Reached target initrd-root-fs.target - Initrd Root File System. May 13 00:08:17.401397 systemd[1]: Mounting sysroot-oem.mount - /sysroot/oem... May 13 00:08:17.403996 systemd[1]: Mounting sysroot-usr.mount - /sysroot/usr... May 13 00:08:17.405190 systemd[1]: flatcar-metadata-hostname.service - Flatcar Metadata Hostname Agent was skipped because no trigger condition checks were met. May 13 00:08:17.405252 systemd[1]: ignition-remount-sysroot.service - Remount /sysroot read-write for Ignition was skipped because of an unmet condition check (ConditionPathIsReadWrite=!/sysroot). May 13 00:08:17.405288 systemd[1]: Reached target ignition-diskful.target - Ignition Boot Disk Setup. May 13 00:08:17.411770 systemd[1]: Mounted sysroot-usr.mount - /sysroot/usr. May 13 00:08:17.415374 kernel: BTRFS: device label OEM devid 1 transid 13 /dev/vda6 scanned by mount (798) May 13 00:08:17.414189 systemd[1]: Starting initrd-setup-root.service - Root filesystem setup... May 13 00:08:17.419272 kernel: BTRFS info (device vda6): first mount of filesystem 0068254f-7e0d-4c83-ad3e-204802432981 May 13 00:08:17.419302 kernel: BTRFS info (device vda6): using crc32c (crc32c-generic) checksum algorithm May 13 00:08:17.419348 kernel: BTRFS info (device vda6): using free space tree May 13 00:08:17.421288 kernel: BTRFS info (device vda6): auto enabling async discard May 13 00:08:17.423323 systemd[1]: Mounted sysroot-oem.mount - /sysroot/oem. May 13 00:08:17.483032 initrd-setup-root[824]: cut: /sysroot/etc/passwd: No such file or directory May 13 00:08:17.488127 initrd-setup-root[831]: cut: /sysroot/etc/group: No such file or directory May 13 00:08:17.492880 initrd-setup-root[838]: cut: /sysroot/etc/shadow: No such file or directory May 13 00:08:17.496539 initrd-setup-root[845]: cut: /sysroot/etc/gshadow: No such file or directory May 13 00:08:17.576389 systemd[1]: Finished initrd-setup-root.service - Root filesystem setup. May 13 00:08:17.587424 systemd[1]: Starting ignition-mount.service - Ignition (mount)... May 13 00:08:17.590170 systemd[1]: Starting sysroot-boot.service - /sysroot/boot... May 13 00:08:17.596279 kernel: BTRFS info (device vda6): last unmount of filesystem 0068254f-7e0d-4c83-ad3e-204802432981 May 13 00:08:17.612301 systemd[1]: Finished sysroot-boot.service - /sysroot/boot. May 13 00:08:17.614194 ignition[913]: INFO : Ignition 2.19.0 May 13 00:08:17.614194 ignition[913]: INFO : Stage: mount May 13 00:08:17.616931 ignition[913]: INFO : no configs at "/usr/lib/ignition/base.d" May 13 00:08:17.616931 ignition[913]: INFO : no config dir at "/usr/lib/ignition/base.platform.d/qemu" May 13 00:08:17.616931 ignition[913]: INFO : mount: mount passed May 13 00:08:17.616931 ignition[913]: INFO : Ignition finished successfully May 13 00:08:17.618324 systemd[1]: Finished ignition-mount.service - Ignition (mount). May 13 00:08:17.627419 systemd[1]: Starting ignition-files.service - Ignition (files)... May 13 00:08:17.939191 systemd[1]: sysroot-oem.mount: Deactivated successfully. May 13 00:08:17.948465 systemd[1]: Mounting sysroot-oem.mount - /sysroot/oem... May 13 00:08:17.954279 kernel: BTRFS: device label OEM devid 1 transid 14 /dev/vda6 scanned by mount (927) May 13 00:08:17.956639 kernel: BTRFS info (device vda6): first mount of filesystem 0068254f-7e0d-4c83-ad3e-204802432981 May 13 00:08:17.956674 kernel: BTRFS info (device vda6): using crc32c (crc32c-generic) checksum algorithm May 13 00:08:17.956685 kernel: BTRFS info (device vda6): using free space tree May 13 00:08:17.959272 kernel: BTRFS info (device vda6): auto enabling async discard May 13 00:08:17.960642 systemd[1]: Mounted sysroot-oem.mount - /sysroot/oem. May 13 00:08:17.977168 ignition[944]: INFO : Ignition 2.19.0 May 13 00:08:17.977168 ignition[944]: INFO : Stage: files May 13 00:08:17.978894 ignition[944]: INFO : no configs at "/usr/lib/ignition/base.d" May 13 00:08:17.978894 ignition[944]: INFO : no config dir at "/usr/lib/ignition/base.platform.d/qemu" May 13 00:08:17.978894 ignition[944]: DEBUG : files: compiled without relabeling support, skipping May 13 00:08:17.982461 ignition[944]: INFO : files: ensureUsers: op(1): [started] creating or modifying user "core" May 13 00:08:17.982461 ignition[944]: DEBUG : files: ensureUsers: op(1): executing: "usermod" "--root" "/sysroot" "core" May 13 00:08:17.985794 ignition[944]: INFO : files: ensureUsers: op(1): [finished] creating or modifying user "core" May 13 00:08:17.987229 ignition[944]: INFO : files: ensureUsers: op(2): [started] adding ssh keys to user "core" May 13 00:08:17.987229 ignition[944]: INFO : files: ensureUsers: op(2): [finished] adding ssh keys to user "core" May 13 00:08:17.986375 unknown[944]: wrote ssh authorized keys file for user: core May 13 00:08:17.991158 ignition[944]: INFO : files: createFilesystemsFiles: createFiles: op(3): [started] writing file "/sysroot/home/core/dev-container-script" May 13 00:08:17.991158 ignition[944]: INFO : files: createFilesystemsFiles: createFiles: op(3): [finished] writing file "/sysroot/home/core/dev-container-script" May 13 00:08:17.991158 ignition[944]: INFO : files: createFilesystemsFiles: createFiles: op(4): [started] writing file "/sysroot/home/core/download-library.sh" May 13 00:08:17.991158 ignition[944]: INFO : files: createFilesystemsFiles: createFiles: op(4): [finished] writing file "/sysroot/home/core/download-library.sh" May 13 00:08:17.991158 ignition[944]: INFO : files: createFilesystemsFiles: createFiles: op(5): [started] writing file "/sysroot/home/core/main-script" May 13 00:08:17.991158 ignition[944]: INFO : files: createFilesystemsFiles: createFiles: op(5): [finished] writing file "/sysroot/home/core/main-script" May 13 00:08:18.002142 ignition[944]: INFO : files: createFilesystemsFiles: createFiles: op(6): [started] writing file "/sysroot/etc/flatcar/update.conf" May 13 00:08:18.002142 ignition[944]: INFO : files: createFilesystemsFiles: createFiles: op(6): [finished] writing file "/sysroot/etc/flatcar/update.conf" May 13 00:08:18.002142 ignition[944]: INFO : files: op(7): [started] processing unit "coreos-metadata.service" May 13 00:08:18.002142 ignition[944]: INFO : files: op(7): op(8): [started] writing unit "coreos-metadata.service" at "/sysroot/etc/systemd/system/coreos-metadata.service" May 13 00:08:18.002142 ignition[944]: INFO : files: op(7): op(8): [finished] writing unit "coreos-metadata.service" at "/sysroot/etc/systemd/system/coreos-metadata.service" May 13 00:08:18.002142 ignition[944]: INFO : files: op(7): [finished] processing unit "coreos-metadata.service" May 13 00:08:18.002142 ignition[944]: INFO : files: op(9): [started] setting preset to disabled for "coreos-metadata.service" May 13 00:08:18.037758 ignition[944]: INFO : files: op(9): op(a): [started] removing enablement symlink(s) for "coreos-metadata.service" May 13 00:08:18.041749 ignition[944]: INFO : files: op(9): op(a): [finished] removing enablement symlink(s) for "coreos-metadata.service" May 13 00:08:18.044019 ignition[944]: INFO : files: op(9): [finished] setting preset to disabled for "coreos-metadata.service" May 13 00:08:18.044019 ignition[944]: INFO : files: createResultFile: createFiles: op(b): [started] writing file "/sysroot/etc/.ignition-result.json" May 13 00:08:18.044019 ignition[944]: INFO : files: createResultFile: createFiles: op(b): [finished] writing file "/sysroot/etc/.ignition-result.json" May 13 00:08:18.044019 ignition[944]: INFO : files: files passed May 13 00:08:18.044019 ignition[944]: INFO : Ignition finished successfully May 13 00:08:18.044730 systemd[1]: Finished ignition-files.service - Ignition (files). May 13 00:08:18.052437 systemd[1]: Starting ignition-quench.service - Ignition (record completion)... May 13 00:08:18.054113 systemd[1]: Starting initrd-setup-root-after-ignition.service - Root filesystem completion... May 13 00:08:18.055912 systemd[1]: ignition-quench.service: Deactivated successfully. May 13 00:08:18.057287 systemd[1]: Finished ignition-quench.service - Ignition (record completion). May 13 00:08:18.062177 initrd-setup-root-after-ignition[978]: grep: /sysroot/oem/oem-release: No such file or directory May 13 00:08:18.065553 initrd-setup-root-after-ignition[980]: grep: /sysroot/etc/flatcar/enabled-sysext.conf: No such file or directory May 13 00:08:18.065553 initrd-setup-root-after-ignition[980]: grep: /sysroot/usr/share/flatcar/enabled-sysext.conf: No such file or directory May 13 00:08:18.068591 initrd-setup-root-after-ignition[984]: grep: /sysroot/etc/flatcar/enabled-sysext.conf: No such file or directory May 13 00:08:18.067779 systemd[1]: Finished initrd-setup-root-after-ignition.service - Root filesystem completion. May 13 00:08:18.069923 systemd[1]: Reached target ignition-complete.target - Ignition Complete. May 13 00:08:18.076430 systemd[1]: Starting initrd-parse-etc.service - Mountpoints Configured in the Real Root... May 13 00:08:18.099079 systemd[1]: initrd-parse-etc.service: Deactivated successfully. May 13 00:08:18.099202 systemd[1]: Finished initrd-parse-etc.service - Mountpoints Configured in the Real Root. May 13 00:08:18.101559 systemd[1]: Reached target initrd-fs.target - Initrd File Systems. May 13 00:08:18.103492 systemd[1]: Reached target initrd.target - Initrd Default Target. May 13 00:08:18.105321 systemd[1]: dracut-mount.service - dracut mount hook was skipped because no trigger condition checks were met. May 13 00:08:18.106130 systemd[1]: Starting dracut-pre-pivot.service - dracut pre-pivot and cleanup hook... May 13 00:08:18.121786 systemd[1]: Finished dracut-pre-pivot.service - dracut pre-pivot and cleanup hook. May 13 00:08:18.134458 systemd[1]: Starting initrd-cleanup.service - Cleaning Up and Shutting Down Daemons... May 13 00:08:18.142615 systemd[1]: Stopped target nss-lookup.target - Host and Network Name Lookups. May 13 00:08:18.143855 systemd[1]: Stopped target remote-cryptsetup.target - Remote Encrypted Volumes. May 13 00:08:18.145890 systemd[1]: Stopped target timers.target - Timer Units. May 13 00:08:18.147698 systemd[1]: dracut-pre-pivot.service: Deactivated successfully. May 13 00:08:18.147832 systemd[1]: Stopped dracut-pre-pivot.service - dracut pre-pivot and cleanup hook. May 13 00:08:18.150346 systemd[1]: Stopped target initrd.target - Initrd Default Target. May 13 00:08:18.152339 systemd[1]: Stopped target basic.target - Basic System. May 13 00:08:18.154088 systemd[1]: Stopped target ignition-complete.target - Ignition Complete. May 13 00:08:18.155810 systemd[1]: Stopped target ignition-diskful.target - Ignition Boot Disk Setup. May 13 00:08:18.157706 systemd[1]: Stopped target initrd-root-device.target - Initrd Root Device. May 13 00:08:18.159744 systemd[1]: Stopped target remote-fs.target - Remote File Systems. May 13 00:08:18.161599 systemd[1]: Stopped target remote-fs-pre.target - Preparation for Remote File Systems. May 13 00:08:18.163502 systemd[1]: Stopped target sysinit.target - System Initialization. May 13 00:08:18.165463 systemd[1]: Stopped target local-fs.target - Local File Systems. May 13 00:08:18.167209 systemd[1]: Stopped target swap.target - Swaps. May 13 00:08:18.168796 systemd[1]: dracut-pre-mount.service: Deactivated successfully. May 13 00:08:18.168938 systemd[1]: Stopped dracut-pre-mount.service - dracut pre-mount hook. May 13 00:08:18.171335 systemd[1]: Stopped target cryptsetup.target - Local Encrypted Volumes. May 13 00:08:18.173440 systemd[1]: Stopped target cryptsetup-pre.target - Local Encrypted Volumes (Pre). May 13 00:08:18.175451 systemd[1]: clevis-luks-askpass.path: Deactivated successfully. May 13 00:08:18.179336 systemd[1]: Stopped clevis-luks-askpass.path - Forward Password Requests to Clevis Directory Watch. May 13 00:08:18.180728 systemd[1]: dracut-initqueue.service: Deactivated successfully. May 13 00:08:18.180857 systemd[1]: Stopped dracut-initqueue.service - dracut initqueue hook. May 13 00:08:18.183773 systemd[1]: ignition-fetch-offline.service: Deactivated successfully. May 13 00:08:18.183896 systemd[1]: Stopped ignition-fetch-offline.service - Ignition (fetch-offline). May 13 00:08:18.185940 systemd[1]: Stopped target paths.target - Path Units. May 13 00:08:18.187572 systemd[1]: systemd-ask-password-console.path: Deactivated successfully. May 13 00:08:18.192324 systemd[1]: Stopped systemd-ask-password-console.path - Dispatch Password Requests to Console Directory Watch. May 13 00:08:18.193581 systemd[1]: Stopped target slices.target - Slice Units. May 13 00:08:18.195646 systemd[1]: Stopped target sockets.target - Socket Units. May 13 00:08:18.197137 systemd[1]: iscsid.socket: Deactivated successfully. May 13 00:08:18.197245 systemd[1]: Closed iscsid.socket - Open-iSCSI iscsid Socket. May 13 00:08:18.198849 systemd[1]: iscsiuio.socket: Deactivated successfully. May 13 00:08:18.198943 systemd[1]: Closed iscsiuio.socket - Open-iSCSI iscsiuio Socket. May 13 00:08:18.200526 systemd[1]: initrd-setup-root-after-ignition.service: Deactivated successfully. May 13 00:08:18.200645 systemd[1]: Stopped initrd-setup-root-after-ignition.service - Root filesystem completion. May 13 00:08:18.202479 systemd[1]: ignition-files.service: Deactivated successfully. May 13 00:08:18.202590 systemd[1]: Stopped ignition-files.service - Ignition (files). May 13 00:08:18.212460 systemd[1]: Stopping ignition-mount.service - Ignition (mount)... May 13 00:08:18.213390 systemd[1]: kmod-static-nodes.service: Deactivated successfully. May 13 00:08:18.213531 systemd[1]: Stopped kmod-static-nodes.service - Create List of Static Device Nodes. May 13 00:08:18.216601 systemd[1]: Stopping sysroot-boot.service - /sysroot/boot... May 13 00:08:18.218196 systemd[1]: systemd-udev-trigger.service: Deactivated successfully. May 13 00:08:18.218370 systemd[1]: Stopped systemd-udev-trigger.service - Coldplug All udev Devices. May 13 00:08:18.220826 systemd[1]: dracut-pre-trigger.service: Deactivated successfully. May 13 00:08:18.224186 ignition[1004]: INFO : Ignition 2.19.0 May 13 00:08:18.224186 ignition[1004]: INFO : Stage: umount May 13 00:08:18.224186 ignition[1004]: INFO : no configs at "/usr/lib/ignition/base.d" May 13 00:08:18.224186 ignition[1004]: INFO : no config dir at "/usr/lib/ignition/base.platform.d/qemu" May 13 00:08:18.221788 systemd[1]: Stopped dracut-pre-trigger.service - dracut pre-trigger hook. May 13 00:08:18.232522 ignition[1004]: INFO : umount: umount passed May 13 00:08:18.232522 ignition[1004]: INFO : Ignition finished successfully May 13 00:08:18.228689 systemd[1]: ignition-mount.service: Deactivated successfully. May 13 00:08:18.228778 systemd[1]: Stopped ignition-mount.service - Ignition (mount). May 13 00:08:18.231971 systemd[1]: sysroot-boot.mount: Deactivated successfully. May 13 00:08:18.232976 systemd[1]: Stopped target network.target - Network. May 13 00:08:18.234163 systemd[1]: ignition-disks.service: Deactivated successfully. May 13 00:08:18.234248 systemd[1]: Stopped ignition-disks.service - Ignition (disks). May 13 00:08:18.235859 systemd[1]: ignition-kargs.service: Deactivated successfully. May 13 00:08:18.235900 systemd[1]: Stopped ignition-kargs.service - Ignition (kargs). May 13 00:08:18.237441 systemd[1]: ignition-setup.service: Deactivated successfully. May 13 00:08:18.237482 systemd[1]: Stopped ignition-setup.service - Ignition (setup). May 13 00:08:18.239118 systemd[1]: ignition-setup-pre.service: Deactivated successfully. May 13 00:08:18.239163 systemd[1]: Stopped ignition-setup-pre.service - Ignition env setup. May 13 00:08:18.241052 systemd[1]: Stopping systemd-networkd.service - Network Configuration... May 13 00:08:18.243300 systemd[1]: Stopping systemd-resolved.service - Network Name Resolution... May 13 00:08:18.245145 systemd[1]: initrd-cleanup.service: Deactivated successfully. May 13 00:08:18.245240 systemd[1]: Finished initrd-cleanup.service - Cleaning Up and Shutting Down Daemons. May 13 00:08:18.247119 systemd[1]: sysroot-boot.service: Deactivated successfully. May 13 00:08:18.247211 systemd[1]: Stopped sysroot-boot.service - /sysroot/boot. May 13 00:08:18.250447 systemd[1]: initrd-setup-root.service: Deactivated successfully. May 13 00:08:18.250522 systemd[1]: Stopped initrd-setup-root.service - Root filesystem setup. May 13 00:08:18.253216 systemd[1]: systemd-resolved.service: Deactivated successfully. May 13 00:08:18.253333 systemd-networkd[762]: eth0: DHCPv6 lease lost May 13 00:08:18.253452 systemd[1]: Stopped systemd-resolved.service - Network Name Resolution. May 13 00:08:18.256512 systemd[1]: systemd-networkd.service: Deactivated successfully. May 13 00:08:18.256638 systemd[1]: Stopped systemd-networkd.service - Network Configuration. May 13 00:08:18.259865 systemd[1]: systemd-networkd.socket: Deactivated successfully. May 13 00:08:18.259917 systemd[1]: Closed systemd-networkd.socket - Network Service Netlink Socket. May 13 00:08:18.275405 systemd[1]: Stopping network-cleanup.service - Network Cleanup... May 13 00:08:18.276394 systemd[1]: parse-ip-for-networkd.service: Deactivated successfully. May 13 00:08:18.276479 systemd[1]: Stopped parse-ip-for-networkd.service - Write systemd-networkd units from cmdline. May 13 00:08:18.278545 systemd[1]: systemd-sysctl.service: Deactivated successfully. May 13 00:08:18.278597 systemd[1]: Stopped systemd-sysctl.service - Apply Kernel Variables. May 13 00:08:18.280366 systemd[1]: systemd-modules-load.service: Deactivated successfully. May 13 00:08:18.280422 systemd[1]: Stopped systemd-modules-load.service - Load Kernel Modules. May 13 00:08:18.282584 systemd[1]: systemd-tmpfiles-setup.service: Deactivated successfully. May 13 00:08:18.282631 systemd[1]: Stopped systemd-tmpfiles-setup.service - Create System Files and Directories. May 13 00:08:18.284717 systemd[1]: Stopping systemd-udevd.service - Rule-based Manager for Device Events and Files... May 13 00:08:18.294511 systemd[1]: network-cleanup.service: Deactivated successfully. May 13 00:08:18.294639 systemd[1]: Stopped network-cleanup.service - Network Cleanup. May 13 00:08:18.306086 systemd[1]: systemd-udevd.service: Deactivated successfully. May 13 00:08:18.306251 systemd[1]: Stopped systemd-udevd.service - Rule-based Manager for Device Events and Files. May 13 00:08:18.308690 systemd[1]: systemd-udevd-control.socket: Deactivated successfully. May 13 00:08:18.308751 systemd[1]: Closed systemd-udevd-control.socket - udev Control Socket. May 13 00:08:18.310463 systemd[1]: systemd-udevd-kernel.socket: Deactivated successfully. May 13 00:08:18.310506 systemd[1]: Closed systemd-udevd-kernel.socket - udev Kernel Socket. May 13 00:08:18.312278 systemd[1]: dracut-pre-udev.service: Deactivated successfully. May 13 00:08:18.312331 systemd[1]: Stopped dracut-pre-udev.service - dracut pre-udev hook. May 13 00:08:18.315152 systemd[1]: dracut-cmdline.service: Deactivated successfully. May 13 00:08:18.315199 systemd[1]: Stopped dracut-cmdline.service - dracut cmdline hook. May 13 00:08:18.317814 systemd[1]: dracut-cmdline-ask.service: Deactivated successfully. May 13 00:08:18.317858 systemd[1]: Stopped dracut-cmdline-ask.service - dracut ask for additional cmdline parameters. May 13 00:08:18.331422 systemd[1]: Starting initrd-udevadm-cleanup-db.service - Cleanup udev Database... May 13 00:08:18.332417 systemd[1]: systemd-tmpfiles-setup-dev.service: Deactivated successfully. May 13 00:08:18.332479 systemd[1]: Stopped systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev. May 13 00:08:18.334676 systemd[1]: systemd-vconsole-setup.service: Deactivated successfully. May 13 00:08:18.334724 systemd[1]: Stopped systemd-vconsole-setup.service - Virtual Console Setup. May 13 00:08:18.336894 systemd[1]: initrd-udevadm-cleanup-db.service: Deactivated successfully. May 13 00:08:18.338291 systemd[1]: Finished initrd-udevadm-cleanup-db.service - Cleanup udev Database. May 13 00:08:18.340181 systemd[1]: Reached target initrd-switch-root.target - Switch Root. May 13 00:08:18.342512 systemd[1]: Starting initrd-switch-root.service - Switch Root... May 13 00:08:18.353166 systemd[1]: Switching root. May 13 00:08:18.377611 systemd-journald[238]: Journal stopped May 13 00:08:19.071690 systemd-journald[238]: Received SIGTERM from PID 1 (systemd). May 13 00:08:19.071753 kernel: SELinux: policy capability network_peer_controls=1 May 13 00:08:19.071767 kernel: SELinux: policy capability open_perms=1 May 13 00:08:19.071777 kernel: SELinux: policy capability extended_socket_class=1 May 13 00:08:19.071854 kernel: SELinux: policy capability always_check_network=0 May 13 00:08:19.071868 kernel: SELinux: policy capability cgroup_seclabel=1 May 13 00:08:19.071878 kernel: SELinux: policy capability nnp_nosuid_transition=1 May 13 00:08:19.071888 kernel: SELinux: policy capability genfs_seclabel_symlinks=0 May 13 00:08:19.071898 kernel: SELinux: policy capability ioctl_skip_cloexec=0 May 13 00:08:19.071911 kernel: audit: type=1403 audit(1747094898.451:2): auid=4294967295 ses=4294967295 lsm=selinux res=1 May 13 00:08:19.071927 systemd[1]: Successfully loaded SELinux policy in 33.898ms. May 13 00:08:19.071945 systemd[1]: Relabeled /dev, /dev/shm, /run, /sys/fs/cgroup in 9.876ms. May 13 00:08:19.071957 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) May 13 00:08:19.071968 systemd[1]: Detected virtualization kvm. May 13 00:08:19.071979 systemd[1]: Detected architecture arm64. May 13 00:08:19.071989 systemd[1]: Detected first boot. May 13 00:08:19.071999 systemd[1]: Initializing machine ID from VM UUID. May 13 00:08:19.072013 zram_generator::config[1048]: No configuration found. May 13 00:08:19.072025 systemd[1]: Populated /etc with preset unit settings. May 13 00:08:19.072036 systemd[1]: initrd-switch-root.service: Deactivated successfully. May 13 00:08:19.072046 systemd[1]: Stopped initrd-switch-root.service - Switch Root. May 13 00:08:19.072057 systemd[1]: systemd-journald.service: Scheduled restart job, restart counter is at 1. May 13 00:08:19.072068 systemd[1]: Created slice system-addon\x2dconfig.slice - Slice /system/addon-config. May 13 00:08:19.072079 systemd[1]: Created slice system-addon\x2drun.slice - Slice /system/addon-run. May 13 00:08:19.072091 systemd[1]: Created slice system-getty.slice - Slice /system/getty. May 13 00:08:19.072102 systemd[1]: Created slice system-modprobe.slice - Slice /system/modprobe. May 13 00:08:19.072113 systemd[1]: Created slice system-serial\x2dgetty.slice - Slice /system/serial-getty. May 13 00:08:19.072124 systemd[1]: Created slice system-system\x2dcloudinit.slice - Slice /system/system-cloudinit. May 13 00:08:19.072135 systemd[1]: Created slice system-systemd\x2dfsck.slice - Slice /system/systemd-fsck. May 13 00:08:19.072145 systemd[1]: Created slice user.slice - User and Session Slice. May 13 00:08:19.072155 systemd[1]: Started clevis-luks-askpass.path - Forward Password Requests to Clevis Directory Watch. May 13 00:08:19.072166 systemd[1]: Started systemd-ask-password-console.path - Dispatch Password Requests to Console Directory Watch. May 13 00:08:19.072178 systemd[1]: Started systemd-ask-password-wall.path - Forward Password Requests to Wall Directory Watch. May 13 00:08:19.072189 systemd[1]: Set up automount boot.automount - Boot partition Automount Point. May 13 00:08:19.072200 systemd[1]: Set up automount proc-sys-fs-binfmt_misc.automount - Arbitrary Executable File Formats File System Automount Point. May 13 00:08:19.072211 systemd[1]: Expecting device dev-disk-by\x2dlabel-OEM.device - /dev/disk/by-label/OEM... May 13 00:08:19.072221 systemd[1]: Expecting device dev-ttyAMA0.device - /dev/ttyAMA0... May 13 00:08:19.072238 systemd[1]: Reached target cryptsetup-pre.target - Local Encrypted Volumes (Pre). May 13 00:08:19.072252 systemd[1]: Stopped target initrd-switch-root.target - Switch Root. May 13 00:08:19.072275 systemd[1]: Stopped target initrd-fs.target - Initrd File Systems. May 13 00:08:19.072290 systemd[1]: Stopped target initrd-root-fs.target - Initrd Root File System. May 13 00:08:19.072300 systemd[1]: Reached target integritysetup.target - Local Integrity Protected Volumes. May 13 00:08:19.072311 systemd[1]: Reached target remote-cryptsetup.target - Remote Encrypted Volumes. May 13 00:08:19.072325 systemd[1]: Reached target remote-fs.target - Remote File Systems. May 13 00:08:19.072336 systemd[1]: Reached target slices.target - Slice Units. May 13 00:08:19.072346 systemd[1]: Reached target swap.target - Swaps. May 13 00:08:19.072357 systemd[1]: Reached target veritysetup.target - Local Verity Protected Volumes. May 13 00:08:19.072367 systemd[1]: Listening on systemd-coredump.socket - Process Core Dump Socket. May 13 00:08:19.072379 systemd[1]: Listening on systemd-networkd.socket - Network Service Netlink Socket. May 13 00:08:19.072389 systemd[1]: Listening on systemd-udevd-control.socket - udev Control Socket. May 13 00:08:19.072400 systemd[1]: Listening on systemd-udevd-kernel.socket - udev Kernel Socket. May 13 00:08:19.072410 systemd[1]: Listening on systemd-userdbd.socket - User Database Manager Socket. May 13 00:08:19.072421 systemd[1]: Mounting dev-hugepages.mount - Huge Pages File System... May 13 00:08:19.072431 systemd[1]: Mounting dev-mqueue.mount - POSIX Message Queue File System... May 13 00:08:19.072442 systemd[1]: Mounting media.mount - External Media Directory... May 13 00:08:19.072452 systemd[1]: Mounting sys-kernel-debug.mount - Kernel Debug File System... May 13 00:08:19.072462 systemd[1]: Mounting sys-kernel-tracing.mount - Kernel Trace File System... May 13 00:08:19.072474 systemd[1]: Mounting tmp.mount - Temporary Directory /tmp... May 13 00:08:19.072485 systemd[1]: var-lib-machines.mount - Virtual Machine and Container Storage (Compatibility) was skipped because of an unmet condition check (ConditionPathExists=/var/lib/machines.raw). May 13 00:08:19.072497 systemd[1]: Reached target machines.target - Containers. May 13 00:08:19.072507 systemd[1]: Starting flatcar-tmpfiles.service - Create missing system files... May 13 00:08:19.072518 systemd[1]: ignition-delete-config.service - Ignition (delete config) was skipped because no trigger condition checks were met. May 13 00:08:19.072528 systemd[1]: Starting kmod-static-nodes.service - Create List of Static Device Nodes... May 13 00:08:19.072539 systemd[1]: Starting modprobe@configfs.service - Load Kernel Module configfs... May 13 00:08:19.072549 systemd[1]: Starting modprobe@dm_mod.service - Load Kernel Module dm_mod... May 13 00:08:19.072559 systemd[1]: Starting modprobe@drm.service - Load Kernel Module drm... May 13 00:08:19.072572 systemd[1]: Starting modprobe@efi_pstore.service - Load Kernel Module efi_pstore... May 13 00:08:19.072582 systemd[1]: Starting modprobe@fuse.service - Load Kernel Module fuse... May 13 00:08:19.072593 systemd[1]: Starting modprobe@loop.service - Load Kernel Module loop... May 13 00:08:19.072603 systemd[1]: setup-nsswitch.service - Create /etc/nsswitch.conf was skipped because of an unmet condition check (ConditionPathExists=!/etc/nsswitch.conf). May 13 00:08:19.072614 systemd[1]: systemd-fsck-root.service: Deactivated successfully. May 13 00:08:19.072624 systemd[1]: Stopped systemd-fsck-root.service - File System Check on Root Device. May 13 00:08:19.072634 systemd[1]: systemd-fsck-usr.service: Deactivated successfully. May 13 00:08:19.072644 systemd[1]: Stopped systemd-fsck-usr.service. May 13 00:08:19.072655 kernel: loop: module loaded May 13 00:08:19.072665 kernel: ACPI: bus type drm_connector registered May 13 00:08:19.072674 kernel: fuse: init (API version 7.39) May 13 00:08:19.072684 systemd[1]: Starting systemd-journald.service - Journal Service... May 13 00:08:19.072694 systemd[1]: Starting systemd-modules-load.service - Load Kernel Modules... May 13 00:08:19.072704 systemd[1]: Starting systemd-network-generator.service - Generate network units from Kernel command line... May 13 00:08:19.072716 systemd[1]: Starting systemd-remount-fs.service - Remount Root and Kernel File Systems... May 13 00:08:19.072727 systemd[1]: Starting systemd-udev-trigger.service - Coldplug All udev Devices... May 13 00:08:19.072738 systemd[1]: verity-setup.service: Deactivated successfully. May 13 00:08:19.072750 systemd[1]: Stopped verity-setup.service. May 13 00:08:19.072795 systemd-journald[1115]: Collecting audit messages is disabled. May 13 00:08:19.072819 systemd[1]: Mounted dev-hugepages.mount - Huge Pages File System. May 13 00:08:19.072831 systemd-journald[1115]: Journal started May 13 00:08:19.072852 systemd-journald[1115]: Runtime Journal (/run/log/journal/48e78331efc04cf7b5782fde4b6cddf4) is 5.9M, max 47.3M, 41.4M free. May 13 00:08:18.840250 systemd[1]: Queued start job for default target multi-user.target. May 13 00:08:18.863853 systemd[1]: Unnecessary job was removed for dev-vda6.device - /dev/vda6. May 13 00:08:18.864285 systemd[1]: systemd-journald.service: Deactivated successfully. May 13 00:08:19.075957 systemd[1]: Started systemd-journald.service - Journal Service. May 13 00:08:19.076643 systemd[1]: Mounted dev-mqueue.mount - POSIX Message Queue File System. May 13 00:08:19.077913 systemd[1]: Mounted media.mount - External Media Directory. May 13 00:08:19.079041 systemd[1]: Mounted sys-kernel-debug.mount - Kernel Debug File System. May 13 00:08:19.080211 systemd[1]: Mounted sys-kernel-tracing.mount - Kernel Trace File System. May 13 00:08:19.081387 systemd[1]: Mounted tmp.mount - Temporary Directory /tmp. May 13 00:08:19.084296 systemd[1]: Finished flatcar-tmpfiles.service - Create missing system files. May 13 00:08:19.085725 systemd[1]: Finished kmod-static-nodes.service - Create List of Static Device Nodes. May 13 00:08:19.087303 systemd[1]: modprobe@configfs.service: Deactivated successfully. May 13 00:08:19.087442 systemd[1]: Finished modprobe@configfs.service - Load Kernel Module configfs. May 13 00:08:19.088803 systemd[1]: modprobe@dm_mod.service: Deactivated successfully. May 13 00:08:19.088940 systemd[1]: Finished modprobe@dm_mod.service - Load Kernel Module dm_mod. May 13 00:08:19.090357 systemd[1]: modprobe@drm.service: Deactivated successfully. May 13 00:08:19.090493 systemd[1]: Finished modprobe@drm.service - Load Kernel Module drm. May 13 00:08:19.091914 systemd[1]: modprobe@efi_pstore.service: Deactivated successfully. May 13 00:08:19.092047 systemd[1]: Finished modprobe@efi_pstore.service - Load Kernel Module efi_pstore. May 13 00:08:19.093472 systemd[1]: modprobe@fuse.service: Deactivated successfully. May 13 00:08:19.093596 systemd[1]: Finished modprobe@fuse.service - Load Kernel Module fuse. May 13 00:08:19.094942 systemd[1]: modprobe@loop.service: Deactivated successfully. May 13 00:08:19.095089 systemd[1]: Finished modprobe@loop.service - Load Kernel Module loop. May 13 00:08:19.096595 systemd[1]: Finished systemd-modules-load.service - Load Kernel Modules. May 13 00:08:19.097894 systemd[1]: Finished systemd-network-generator.service - Generate network units from Kernel command line. May 13 00:08:19.099360 systemd[1]: Finished systemd-remount-fs.service - Remount Root and Kernel File Systems. May 13 00:08:19.114923 systemd[1]: Reached target network-pre.target - Preparation for Network. May 13 00:08:19.136445 systemd[1]: Mounting sys-fs-fuse-connections.mount - FUSE Control File System... May 13 00:08:19.141413 systemd[1]: Mounting sys-kernel-config.mount - Kernel Configuration File System... May 13 00:08:19.142583 systemd[1]: remount-root.service - Remount Root File System was skipped because of an unmet condition check (ConditionPathIsReadWrite=!/). May 13 00:08:19.142629 systemd[1]: Reached target local-fs.target - Local File Systems. May 13 00:08:19.144643 systemd[1]: Listening on systemd-sysext.socket - System Extension Image Management (Varlink). May 13 00:08:19.146987 systemd[1]: Starting dracut-shutdown.service - Restore /run/initramfs on shutdown... May 13 00:08:19.149252 systemd[1]: Starting ldconfig.service - Rebuild Dynamic Linker Cache... May 13 00:08:19.150394 systemd[1]: systemd-binfmt.service - Set Up Additional Binary Formats was skipped because no trigger condition checks were met. May 13 00:08:19.153749 systemd[1]: Starting systemd-hwdb-update.service - Rebuild Hardware Database... May 13 00:08:19.155931 systemd[1]: Starting systemd-journal-flush.service - Flush Journal to Persistent Storage... May 13 00:08:19.157198 systemd[1]: systemd-pstore.service - Platform Persistent Storage Archival was skipped because of an unmet condition check (ConditionDirectoryNotEmpty=/sys/fs/pstore). May 13 00:08:19.158176 systemd[1]: Starting systemd-random-seed.service - Load/Save OS Random Seed... May 13 00:08:19.159322 systemd[1]: systemd-repart.service - Repartition Root Disk was skipped because no trigger condition checks were met. May 13 00:08:19.160215 systemd[1]: Starting systemd-sysctl.service - Apply Kernel Variables... May 13 00:08:19.162504 systemd[1]: Starting systemd-sysext.service - Merge System Extension Images into /usr/ and /opt/... May 13 00:08:19.168089 systemd-journald[1115]: Time spent on flushing to /var/log/journal/48e78331efc04cf7b5782fde4b6cddf4 is 23.132ms for 835 entries. May 13 00:08:19.168089 systemd-journald[1115]: System Journal (/var/log/journal/48e78331efc04cf7b5782fde4b6cddf4) is 8.0M, max 195.6M, 187.6M free. May 13 00:08:19.211186 systemd-journald[1115]: Received client request to flush runtime journal. May 13 00:08:19.211253 kernel: loop0: detected capacity change from 0 to 114432 May 13 00:08:19.167565 systemd[1]: Starting systemd-sysusers.service - Create System Users... May 13 00:08:19.171217 systemd[1]: Finished systemd-udev-trigger.service - Coldplug All udev Devices. May 13 00:08:19.172840 systemd[1]: Mounted sys-fs-fuse-connections.mount - FUSE Control File System. May 13 00:08:19.174294 systemd[1]: Mounted sys-kernel-config.mount - Kernel Configuration File System. May 13 00:08:19.175858 systemd[1]: Finished dracut-shutdown.service - Restore /run/initramfs on shutdown. May 13 00:08:19.181352 systemd[1]: Finished systemd-random-seed.service - Load/Save OS Random Seed. May 13 00:08:19.184128 systemd[1]: Reached target first-boot-complete.target - First Boot Complete. May 13 00:08:19.192590 systemd[1]: Starting systemd-machine-id-commit.service - Commit a transient machine-id on disk... May 13 00:08:19.197392 systemd[1]: Starting systemd-udev-settle.service - Wait for udev To Complete Device Initialization... May 13 00:08:19.201337 systemd[1]: Finished systemd-sysctl.service - Apply Kernel Variables. May 13 00:08:19.215189 systemd[1]: Finished systemd-journal-flush.service - Flush Journal to Persistent Storage. May 13 00:08:19.220393 kernel: squashfs: version 4.0 (2009/01/31) Phillip Lougher May 13 00:08:19.223159 udevadm[1170]: systemd-udev-settle.service is deprecated. Please fix lvm2-activation.service, lvm2-activation-early.service not to pull it in. May 13 00:08:19.224442 systemd[1]: etc-machine\x2did.mount: Deactivated successfully. May 13 00:08:19.225046 systemd[1]: Finished systemd-machine-id-commit.service - Commit a transient machine-id on disk. May 13 00:08:19.233497 systemd[1]: Finished systemd-sysusers.service - Create System Users. May 13 00:08:19.242427 systemd[1]: Starting systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev... May 13 00:08:19.248277 kernel: loop1: detected capacity change from 0 to 114328 May 13 00:08:19.270738 systemd-tmpfiles[1178]: ACLs are not supported, ignoring. May 13 00:08:19.270761 systemd-tmpfiles[1178]: ACLs are not supported, ignoring. May 13 00:08:19.275429 systemd[1]: Finished systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev. May 13 00:08:19.291515 kernel: loop2: detected capacity change from 0 to 114432 May 13 00:08:19.301276 kernel: loop3: detected capacity change from 0 to 114328 May 13 00:08:19.303915 (sd-merge)[1183]: Using extensions 'containerd-flatcar', 'docker-flatcar'. May 13 00:08:19.304369 (sd-merge)[1183]: Merged extensions into '/usr'. May 13 00:08:19.307839 systemd[1]: Finished systemd-sysext.service - Merge System Extension Images into /usr/ and /opt/. May 13 00:08:19.319499 systemd[1]: Starting ensure-sysext.service... May 13 00:08:19.324603 systemd[1]: Starting systemd-tmpfiles-setup.service - Create System Files and Directories... May 13 00:08:19.332614 systemd[1]: Reloading requested from client PID 1185 ('systemctl') (unit ensure-sysext.service)... May 13 00:08:19.332800 systemd[1]: Reloading... May 13 00:08:19.346042 systemd-tmpfiles[1186]: /usr/lib/tmpfiles.d/provision.conf:20: Duplicate line for path "/root", ignoring. May 13 00:08:19.346343 systemd-tmpfiles[1186]: /usr/lib/tmpfiles.d/systemd-flatcar.conf:6: Duplicate line for path "/var/log/journal", ignoring. May 13 00:08:19.346965 systemd-tmpfiles[1186]: /usr/lib/tmpfiles.d/systemd.conf:29: Duplicate line for path "/var/lib/systemd", ignoring. May 13 00:08:19.347166 systemd-tmpfiles[1186]: ACLs are not supported, ignoring. May 13 00:08:19.347214 systemd-tmpfiles[1186]: ACLs are not supported, ignoring. May 13 00:08:19.349748 systemd-tmpfiles[1186]: Detected autofs mount point /boot during canonicalization of boot. May 13 00:08:19.349762 systemd-tmpfiles[1186]: Skipping /boot May 13 00:08:19.356846 systemd-tmpfiles[1186]: Detected autofs mount point /boot during canonicalization of boot. May 13 00:08:19.356863 systemd-tmpfiles[1186]: Skipping /boot May 13 00:08:19.406293 zram_generator::config[1211]: No configuration found. May 13 00:08:19.466972 ldconfig[1154]: /sbin/ldconfig: /lib/ld.so.conf is not an ELF file - it has the wrong magic bytes at the start. May 13 00:08:19.515190 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. May 13 00:08:19.551106 systemd[1]: Reloading finished in 218 ms. May 13 00:08:19.577379 systemd[1]: Finished ldconfig.service - Rebuild Dynamic Linker Cache. May 13 00:08:19.586791 systemd[1]: Finished systemd-tmpfiles-setup.service - Create System Files and Directories. May 13 00:08:19.594637 systemd[1]: Starting audit-rules.service - Load Security Auditing Rules... May 13 00:08:19.597378 systemd[1]: Starting clean-ca-certificates.service - Clean up broken links in /etc/ssl/certs... May 13 00:08:19.600536 systemd[1]: Starting systemd-journal-catalog-update.service - Rebuild Journal Catalog... May 13 00:08:19.610670 systemd[1]: Starting systemd-resolved.service - Network Name Resolution... May 13 00:08:19.627392 systemd[1]: Starting systemd-update-utmp.service - Record System Boot/Shutdown in UTMP... May 13 00:08:19.632254 systemd[1]: Finished systemd-journal-catalog-update.service - Rebuild Journal Catalog. May 13 00:08:19.639436 systemd[1]: ignition-delete-config.service - Ignition (delete config) was skipped because no trigger condition checks were met. May 13 00:08:19.647631 systemd[1]: Starting modprobe@dm_mod.service - Load Kernel Module dm_mod... May 13 00:08:19.651607 systemd[1]: Starting modprobe@efi_pstore.service - Load Kernel Module efi_pstore... May 13 00:08:19.656648 systemd[1]: Starting modprobe@loop.service - Load Kernel Module loop... May 13 00:08:19.657829 systemd[1]: systemd-binfmt.service - Set Up Additional Binary Formats was skipped because no trigger condition checks were met. May 13 00:08:19.659664 augenrules[1273]: No rules May 13 00:08:19.662577 systemd[1]: Starting systemd-userdbd.service - User Database Manager... May 13 00:08:19.664876 systemd[1]: Finished systemd-hwdb-update.service - Rebuild Hardware Database. May 13 00:08:19.666751 systemd[1]: Finished audit-rules.service - Load Security Auditing Rules. May 13 00:08:19.668574 systemd[1]: modprobe@dm_mod.service: Deactivated successfully. May 13 00:08:19.668706 systemd[1]: Finished modprobe@dm_mod.service - Load Kernel Module dm_mod. May 13 00:08:19.670437 systemd[1]: modprobe@efi_pstore.service: Deactivated successfully. May 13 00:08:19.670586 systemd[1]: Finished modprobe@efi_pstore.service - Load Kernel Module efi_pstore. May 13 00:08:19.672446 systemd[1]: modprobe@loop.service: Deactivated successfully. May 13 00:08:19.672581 systemd[1]: Finished modprobe@loop.service - Load Kernel Module loop. May 13 00:08:19.676994 systemd[1]: Finished systemd-update-utmp.service - Record System Boot/Shutdown in UTMP. May 13 00:08:19.683325 systemd[1]: ignition-delete-config.service - Ignition (delete config) was skipped because no trigger condition checks were met. May 13 00:08:19.694542 systemd[1]: Starting modprobe@dm_mod.service - Load Kernel Module dm_mod... May 13 00:08:19.696659 systemd[1]: Starting modprobe@efi_pstore.service - Load Kernel Module efi_pstore... May 13 00:08:19.698754 systemd[1]: Starting modprobe@loop.service - Load Kernel Module loop... May 13 00:08:19.699840 systemd[1]: systemd-binfmt.service - Set Up Additional Binary Formats was skipped because no trigger condition checks were met. May 13 00:08:19.701534 systemd[1]: Starting systemd-udevd.service - Rule-based Manager for Device Events and Files... May 13 00:08:19.703755 systemd[1]: Starting systemd-update-done.service - Update is Completed... May 13 00:08:19.705535 systemd[1]: Started systemd-userdbd.service - User Database Manager. May 13 00:08:19.707159 systemd[1]: Finished clean-ca-certificates.service - Clean up broken links in /etc/ssl/certs. May 13 00:08:19.708840 systemd[1]: modprobe@dm_mod.service: Deactivated successfully. May 13 00:08:19.708974 systemd[1]: Finished modprobe@dm_mod.service - Load Kernel Module dm_mod. May 13 00:08:19.710634 systemd[1]: modprobe@efi_pstore.service: Deactivated successfully. May 13 00:08:19.710751 systemd[1]: Finished modprobe@efi_pstore.service - Load Kernel Module efi_pstore. May 13 00:08:19.712662 systemd[1]: modprobe@loop.service: Deactivated successfully. May 13 00:08:19.712790 systemd[1]: Finished modprobe@loop.service - Load Kernel Module loop. May 13 00:08:19.718710 systemd[1]: ignition-delete-config.service - Ignition (delete config) was skipped because no trigger condition checks were met. May 13 00:08:19.725505 systemd[1]: Starting modprobe@dm_mod.service - Load Kernel Module dm_mod... May 13 00:08:19.729190 systemd[1]: Starting modprobe@drm.service - Load Kernel Module drm... May 13 00:08:19.729564 systemd-udevd[1291]: Using default interface naming scheme 'v255'. May 13 00:08:19.732553 systemd[1]: Starting modprobe@efi_pstore.service - Load Kernel Module efi_pstore... May 13 00:08:19.735653 systemd[1]: Starting modprobe@loop.service - Load Kernel Module loop... May 13 00:08:19.736914 systemd[1]: systemd-binfmt.service - Set Up Additional Binary Formats was skipped because no trigger condition checks were met. May 13 00:08:19.737150 systemd[1]: update-ca-certificates.service - Update CA bundle at /etc/ssl/certs/ca-certificates.crt was skipped because of an unmet condition check (ConditionPathIsSymbolicLink=!/etc/ssl/certs/ca-certificates.crt). May 13 00:08:19.738285 systemd[1]: Finished systemd-update-done.service - Update is Completed. May 13 00:08:19.739991 systemd[1]: modprobe@dm_mod.service: Deactivated successfully. May 13 00:08:19.740146 systemd[1]: Finished modprobe@dm_mod.service - Load Kernel Module dm_mod. May 13 00:08:19.742003 systemd[1]: modprobe@drm.service: Deactivated successfully. May 13 00:08:19.742138 systemd[1]: Finished modprobe@drm.service - Load Kernel Module drm. May 13 00:08:19.743865 systemd[1]: modprobe@efi_pstore.service: Deactivated successfully. May 13 00:08:19.744031 systemd[1]: Finished modprobe@efi_pstore.service - Load Kernel Module efi_pstore. May 13 00:08:19.746032 systemd[1]: modprobe@loop.service: Deactivated successfully. May 13 00:08:19.746163 systemd[1]: Finished modprobe@loop.service - Load Kernel Module loop. May 13 00:08:19.750562 systemd[1]: Finished ensure-sysext.service. May 13 00:08:19.754573 systemd[1]: systemd-pstore.service - Platform Persistent Storage Archival was skipped because of an unmet condition check (ConditionDirectoryNotEmpty=/sys/fs/pstore). May 13 00:08:19.754644 systemd[1]: systemd-repart.service - Repartition Root Disk was skipped because no trigger condition checks were met. May 13 00:08:19.765591 systemd[1]: Starting systemd-timesyncd.service - Network Time Synchronization... May 13 00:08:19.766838 systemd[1]: Started systemd-udevd.service - Rule-based Manager for Device Events and Files. May 13 00:08:19.771502 systemd-resolved[1255]: Positive Trust Anchors: May 13 00:08:19.771521 systemd-resolved[1255]: . IN DS 20326 8 2 e06d44b80b8f1d39a95c0b0d7c65d08458e880409bbc683457104237c7f8ec8d May 13 00:08:19.771553 systemd-resolved[1255]: Negative trust anchors: home.arpa 10.in-addr.arpa 16.172.in-addr.arpa 17.172.in-addr.arpa 18.172.in-addr.arpa 19.172.in-addr.arpa 20.172.in-addr.arpa 21.172.in-addr.arpa 22.172.in-addr.arpa 23.172.in-addr.arpa 24.172.in-addr.arpa 25.172.in-addr.arpa 26.172.in-addr.arpa 27.172.in-addr.arpa 28.172.in-addr.arpa 29.172.in-addr.arpa 30.172.in-addr.arpa 31.172.in-addr.arpa 170.0.0.192.in-addr.arpa 171.0.0.192.in-addr.arpa 168.192.in-addr.arpa d.f.ip6.arpa ipv4only.arpa resolver.arpa corp home internal intranet lan local private test May 13 00:08:19.775466 systemd[1]: Starting systemd-networkd.service - Network Configuration... May 13 00:08:19.779033 systemd-resolved[1255]: Defaulting to hostname 'linux'. May 13 00:08:19.785551 systemd[1]: Started systemd-resolved.service - Network Name Resolution. May 13 00:08:19.786702 systemd[1]: Reached target nss-lookup.target - Host and Network Name Lookups. May 13 00:08:19.793526 systemd[1]: Condition check resulted in dev-ttyAMA0.device - /dev/ttyAMA0 being skipped. May 13 00:08:19.807327 kernel: BTRFS warning: duplicate device /dev/vda3 devid 1 generation 40 scanned by (udev-worker) (1322) May 13 00:08:19.848268 systemd[1]: Found device dev-disk-by\x2dlabel-OEM.device - /dev/disk/by-label/OEM. May 13 00:08:19.849836 systemd[1]: Started systemd-timesyncd.service - Network Time Synchronization. May 13 00:08:19.851389 systemd[1]: Reached target time-set.target - System Time Set. May 13 00:08:19.858473 systemd[1]: Starting systemd-fsck@dev-disk-by\x2dlabel-OEM.service - File System Check on /dev/disk/by-label/OEM... May 13 00:08:19.867903 systemd-networkd[1328]: lo: Link UP May 13 00:08:19.868201 systemd-networkd[1328]: lo: Gained carrier May 13 00:08:19.869210 systemd-networkd[1328]: Enumeration completed May 13 00:08:19.869867 systemd[1]: Started systemd-networkd.service - Network Configuration. May 13 00:08:19.870024 systemd-networkd[1328]: eth0: found matching network '/usr/lib/systemd/network/zz-default.network', based on potentially unpredictable interface name. May 13 00:08:19.870103 systemd-networkd[1328]: eth0: Configuring with /usr/lib/systemd/network/zz-default.network. May 13 00:08:19.871492 systemd[1]: Finished systemd-fsck@dev-disk-by\x2dlabel-OEM.service - File System Check on /dev/disk/by-label/OEM. May 13 00:08:19.873172 systemd[1]: Reached target network.target - Network. May 13 00:08:19.874400 systemd-networkd[1328]: eth0: Link UP May 13 00:08:19.874470 systemd-networkd[1328]: eth0: Gained carrier May 13 00:08:19.874487 systemd-networkd[1328]: eth0: found matching network '/usr/lib/systemd/network/zz-default.network', based on potentially unpredictable interface name. May 13 00:08:19.880436 systemd[1]: Starting systemd-networkd-wait-online.service - Wait for Network to be Configured... May 13 00:08:19.921328 systemd-networkd[1328]: eth0: DHCPv4 address 10.0.0.15/16, gateway 10.0.0.1 acquired from 10.0.0.1 May 13 00:08:19.924237 systemd-timesyncd[1311]: Network configuration changed, trying to establish connection. May 13 00:08:19.924532 systemd[1]: Starting systemd-vconsole-setup.service - Virtual Console Setup... May 13 00:08:19.928006 systemd-timesyncd[1311]: Contacted time server 10.0.0.1:123 (10.0.0.1). May 13 00:08:19.928059 systemd-timesyncd[1311]: Initial clock synchronization to Tue 2025-05-13 00:08:20.188205 UTC. May 13 00:08:19.934662 systemd[1]: Finished systemd-udev-settle.service - Wait for udev To Complete Device Initialization. May 13 00:08:19.937950 systemd[1]: Starting lvm2-activation-early.service - Activation of LVM2 logical volumes... May 13 00:08:19.957303 lvm[1349]: WARNING: Failed to connect to lvmetad. Falling back to device scanning. May 13 00:08:19.977829 systemd[1]: Finished systemd-vconsole-setup.service - Virtual Console Setup. May 13 00:08:20.006995 systemd[1]: Finished lvm2-activation-early.service - Activation of LVM2 logical volumes. May 13 00:08:20.008706 systemd[1]: Reached target cryptsetup.target - Local Encrypted Volumes. May 13 00:08:20.009867 systemd[1]: Reached target sysinit.target - System Initialization. May 13 00:08:20.011138 systemd[1]: Started motdgen.path - Watch for update engine configuration changes. May 13 00:08:20.012443 systemd[1]: Started user-cloudinit@var-lib-flatcar\x2dinstall-user_data.path - Watch for a cloud-config at /var/lib/flatcar-install/user_data. May 13 00:08:20.014013 systemd[1]: Started logrotate.timer - Daily rotation of log files. May 13 00:08:20.015193 systemd[1]: Started mdadm.timer - Weekly check for MD array's redundancy information.. May 13 00:08:20.016498 systemd[1]: Started systemd-tmpfiles-clean.timer - Daily Cleanup of Temporary Directories. May 13 00:08:20.017740 systemd[1]: update-engine-stub.timer - Update Engine Stub Timer was skipped because of an unmet condition check (ConditionPathExists=/usr/.noupdate). May 13 00:08:20.017797 systemd[1]: Reached target paths.target - Path Units. May 13 00:08:20.018685 systemd[1]: Reached target timers.target - Timer Units. May 13 00:08:20.022213 systemd[1]: Listening on dbus.socket - D-Bus System Message Bus Socket. May 13 00:08:20.024891 systemd[1]: Starting docker.socket - Docker Socket for the API... May 13 00:08:20.038765 systemd[1]: Listening on sshd.socket - OpenSSH Server Socket. May 13 00:08:20.042726 systemd[1]: Starting lvm2-activation.service - Activation of LVM2 logical volumes... May 13 00:08:20.045006 systemd[1]: Listening on docker.socket - Docker Socket for the API. May 13 00:08:20.046310 systemd[1]: Reached target sockets.target - Socket Units. May 13 00:08:20.047345 systemd[1]: Reached target basic.target - Basic System. May 13 00:08:20.048393 systemd[1]: addon-config@oem.service - Configure Addon /oem was skipped because no trigger condition checks were met. May 13 00:08:20.048425 systemd[1]: addon-run@oem.service - Run Addon /oem was skipped because no trigger condition checks were met. May 13 00:08:20.058440 systemd[1]: Starting containerd.service - containerd container runtime... May 13 00:08:20.060774 systemd[1]: Starting dbus.service - D-Bus System Message Bus... May 13 00:08:20.063410 lvm[1356]: WARNING: Failed to connect to lvmetad. Falling back to device scanning. May 13 00:08:20.062854 systemd[1]: Starting enable-oem-cloudinit.service - Enable cloudinit... May 13 00:08:20.067094 systemd[1]: Starting extend-filesystems.service - Extend Filesystems... May 13 00:08:20.069647 systemd[1]: flatcar-setup-environment.service - Modifies /etc/environment for CoreOS was skipped because of an unmet condition check (ConditionPathExists=/oem/bin/flatcar-setup-environment). May 13 00:08:20.073954 systemd[1]: Starting motdgen.service - Generate /run/flatcar/motd... May 13 00:08:20.084371 jq[1359]: false May 13 00:08:20.086558 systemd[1]: Starting ssh-key-proc-cmdline.service - Install an ssh key from /proc/cmdline... May 13 00:08:20.091993 systemd[1]: Starting sshd-keygen.service - Generate sshd host keys... May 13 00:08:20.097995 systemd[1]: Starting systemd-logind.service - User Login Management... May 13 00:08:20.107860 extend-filesystems[1360]: Found loop2 May 13 00:08:20.107860 extend-filesystems[1360]: Found loop3 May 13 00:08:20.107860 extend-filesystems[1360]: Found vda May 13 00:08:20.107860 extend-filesystems[1360]: Found vda1 May 13 00:08:20.107860 extend-filesystems[1360]: Found vda2 May 13 00:08:20.107860 extend-filesystems[1360]: Found vda3 May 13 00:08:20.107860 extend-filesystems[1360]: Found usr May 13 00:08:20.107860 extend-filesystems[1360]: Found vda4 May 13 00:08:20.107860 extend-filesystems[1360]: Found vda6 May 13 00:08:20.107860 extend-filesystems[1360]: Found vda7 May 13 00:08:20.107860 extend-filesystems[1360]: Found vda9 May 13 00:08:20.107860 extend-filesystems[1360]: Checking size of /dev/vda9 May 13 00:08:20.108240 systemd[1]: tcsd.service - TCG Core Services Daemon was skipped because of an unmet condition check (ConditionPathExists=/dev/tpm0). May 13 00:08:20.115272 dbus-daemon[1358]: [system] SELinux support is enabled May 13 00:08:20.108777 systemd[1]: cgroup compatibility translation between legacy and unified hierarchy settings activated. See cgroup-compat debug messages for details. May 13 00:08:20.109832 systemd[1]: Starting update-engine.service - Update Engine... May 13 00:08:20.116143 systemd[1]: Starting update-ssh-keys-after-ignition.service - Run update-ssh-keys once after Ignition... May 13 00:08:20.117918 systemd[1]: Started dbus.service - D-Bus System Message Bus. May 13 00:08:20.123715 systemd[1]: Finished lvm2-activation.service - Activation of LVM2 logical volumes. May 13 00:08:20.127660 systemd[1]: enable-oem-cloudinit.service: Skipped due to 'exec-condition'. May 13 00:08:20.127838 systemd[1]: Condition check resulted in enable-oem-cloudinit.service - Enable cloudinit being skipped. May 13 00:08:20.128102 systemd[1]: motdgen.service: Deactivated successfully. May 13 00:08:20.128241 systemd[1]: Finished motdgen.service - Generate /run/flatcar/motd. May 13 00:08:20.129812 systemd[1]: ssh-key-proc-cmdline.service: Deactivated successfully. May 13 00:08:20.129968 systemd[1]: Finished ssh-key-proc-cmdline.service - Install an ssh key from /proc/cmdline. May 13 00:08:20.138215 systemd[1]: system-cloudinit@usr-share-oem-cloud\x2dconfig.yml.service - Load cloud-config from /usr/share/oem/cloud-config.yml was skipped because of an unmet condition check (ConditionFileNotEmpty=/usr/share/oem/cloud-config.yml). May 13 00:08:20.138266 systemd[1]: Reached target system-config.target - Load system-provided cloud configs. May 13 00:08:20.143458 extend-filesystems[1360]: Resized partition /dev/vda9 May 13 00:08:20.139674 systemd[1]: user-cloudinit-proc-cmdline.service - Load cloud-config from url defined in /proc/cmdline was skipped because of an unmet condition check (ConditionKernelCommandLine=cloud-config-url). May 13 00:08:20.139729 systemd[1]: Reached target user-config.target - Load user-provided cloud configs. May 13 00:08:20.146809 jq[1375]: true May 13 00:08:20.147070 extend-filesystems[1386]: resize2fs 1.47.1 (20-May-2024) May 13 00:08:20.154586 kernel: BTRFS warning: duplicate device /dev/vda3 devid 1 generation 40 scanned by (udev-worker) (1318) May 13 00:08:20.161240 kernel: EXT4-fs (vda9): resizing filesystem from 553472 to 1864699 blocks May 13 00:08:20.173577 jq[1388]: true May 13 00:08:20.178654 (ntainerd)[1389]: containerd.service: Referenced but unset environment variable evaluates to an empty string: TORCX_IMAGEDIR, TORCX_UNPACKDIR May 13 00:08:20.179216 update_engine[1374]: I20250513 00:08:20.175329 1374 main.cc:92] Flatcar Update Engine starting May 13 00:08:20.181302 kernel: EXT4-fs (vda9): resized filesystem to 1864699 May 13 00:08:20.183036 systemd[1]: Started update-engine.service - Update Engine. May 13 00:08:20.186433 systemd[1]: Started locksmithd.service - Cluster reboot manager. May 13 00:08:20.192418 update_engine[1374]: I20250513 00:08:20.186451 1374 update_check_scheduler.cc:74] Next update check in 2m48s May 13 00:08:20.192871 extend-filesystems[1386]: Filesystem at /dev/vda9 is mounted on /; on-line resizing required May 13 00:08:20.192871 extend-filesystems[1386]: old_desc_blocks = 1, new_desc_blocks = 1 May 13 00:08:20.192871 extend-filesystems[1386]: The filesystem on /dev/vda9 is now 1864699 (4k) blocks long. May 13 00:08:20.196682 extend-filesystems[1360]: Resized filesystem in /dev/vda9 May 13 00:08:20.195184 systemd[1]: extend-filesystems.service: Deactivated successfully. May 13 00:08:20.195429 systemd[1]: Finished extend-filesystems.service - Extend Filesystems. May 13 00:08:20.201536 systemd-logind[1370]: Watching system buttons on /dev/input/event0 (Power Button) May 13 00:08:20.205739 systemd-logind[1370]: New seat seat0. May 13 00:08:20.208849 systemd[1]: Started systemd-logind.service - User Login Management. May 13 00:08:20.249245 locksmithd[1393]: locksmithd starting currentOperation="UPDATE_STATUS_IDLE" strategy="reboot" May 13 00:08:20.258337 bash[1410]: Updated "/home/core/.ssh/authorized_keys" May 13 00:08:20.259721 systemd[1]: Finished update-ssh-keys-after-ignition.service - Run update-ssh-keys once after Ignition. May 13 00:08:20.261727 systemd[1]: sshkeys.service was skipped because no trigger condition checks were met. May 13 00:08:20.387755 containerd[1389]: time="2025-05-13T00:08:20.387654396Z" level=info msg="starting containerd" revision=174e0d1785eeda18dc2beba45e1d5a188771636b version=v1.7.21 May 13 00:08:20.413719 containerd[1389]: time="2025-05-13T00:08:20.413653600Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.aufs\"..." type=io.containerd.snapshotter.v1 May 13 00:08:20.415112 containerd[1389]: time="2025-05-13T00:08:20.415073380Z" level=info msg="skip loading plugin \"io.containerd.snapshotter.v1.aufs\"..." error="aufs is not supported (modprobe aufs failed: exit status 1 \"modprobe: FATAL: Module aufs not found in directory /lib/modules/6.6.89-flatcar\\n\"): skip plugin" type=io.containerd.snapshotter.v1 May 13 00:08:20.415112 containerd[1389]: time="2025-05-13T00:08:20.415106711Z" level=info msg="loading plugin \"io.containerd.event.v1.exchange\"..." type=io.containerd.event.v1 May 13 00:08:20.415177 containerd[1389]: time="2025-05-13T00:08:20.415122570Z" level=info msg="loading plugin \"io.containerd.internal.v1.opt\"..." type=io.containerd.internal.v1 May 13 00:08:20.415332 containerd[1389]: time="2025-05-13T00:08:20.415285174Z" level=info msg="loading plugin \"io.containerd.warning.v1.deprecations\"..." type=io.containerd.warning.v1 May 13 00:08:20.415375 containerd[1389]: time="2025-05-13T00:08:20.415336182Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.blockfile\"..." type=io.containerd.snapshotter.v1 May 13 00:08:20.415415 containerd[1389]: time="2025-05-13T00:08:20.415398175Z" level=info msg="skip loading plugin \"io.containerd.snapshotter.v1.blockfile\"..." error="no scratch file generator: skip plugin" type=io.containerd.snapshotter.v1 May 13 00:08:20.415441 containerd[1389]: time="2025-05-13T00:08:20.415417257Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.btrfs\"..." type=io.containerd.snapshotter.v1 May 13 00:08:20.415621 containerd[1389]: time="2025-05-13T00:08:20.415592086Z" level=info msg="skip loading plugin \"io.containerd.snapshotter.v1.btrfs\"..." error="path /var/lib/containerd/io.containerd.snapshotter.v1.btrfs (ext4) must be a btrfs filesystem to be used with the btrfs snapshotter: skip plugin" type=io.containerd.snapshotter.v1 May 13 00:08:20.415621 containerd[1389]: time="2025-05-13T00:08:20.415613067Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.devmapper\"..." type=io.containerd.snapshotter.v1 May 13 00:08:20.415663 containerd[1389]: time="2025-05-13T00:08:20.415626696Z" level=info msg="skip loading plugin \"io.containerd.snapshotter.v1.devmapper\"..." error="devmapper not configured: skip plugin" type=io.containerd.snapshotter.v1 May 13 00:08:20.415663 containerd[1389]: time="2025-05-13T00:08:20.415636485Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.native\"..." type=io.containerd.snapshotter.v1 May 13 00:08:20.415726 containerd[1389]: time="2025-05-13T00:08:20.415711199Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.overlayfs\"..." type=io.containerd.snapshotter.v1 May 13 00:08:20.415935 containerd[1389]: time="2025-05-13T00:08:20.415909405Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.zfs\"..." type=io.containerd.snapshotter.v1 May 13 00:08:20.416037 containerd[1389]: time="2025-05-13T00:08:20.416019556Z" level=info msg="skip loading plugin \"io.containerd.snapshotter.v1.zfs\"..." error="path /var/lib/containerd/io.containerd.snapshotter.v1.zfs must be a zfs filesystem to be used with the zfs snapshotter: skip plugin" type=io.containerd.snapshotter.v1 May 13 00:08:20.416064 containerd[1389]: time="2025-05-13T00:08:20.416039092Z" level=info msg="loading plugin \"io.containerd.content.v1.content\"..." type=io.containerd.content.v1 May 13 00:08:20.416140 containerd[1389]: time="2025-05-13T00:08:20.416125247Z" level=info msg="loading plugin \"io.containerd.metadata.v1.bolt\"..." type=io.containerd.metadata.v1 May 13 00:08:20.416183 containerd[1389]: time="2025-05-13T00:08:20.416171752Z" level=info msg="metadata content store policy set" policy=shared May 13 00:08:20.419768 containerd[1389]: time="2025-05-13T00:08:20.419726571Z" level=info msg="loading plugin \"io.containerd.gc.v1.scheduler\"..." type=io.containerd.gc.v1 May 13 00:08:20.419768 containerd[1389]: time="2025-05-13T00:08:20.419775555Z" level=info msg="loading plugin \"io.containerd.differ.v1.walking\"..." type=io.containerd.differ.v1 May 13 00:08:20.419842 containerd[1389]: time="2025-05-13T00:08:20.419795462Z" level=info msg="loading plugin \"io.containerd.lease.v1.manager\"..." type=io.containerd.lease.v1 May 13 00:08:20.419842 containerd[1389]: time="2025-05-13T00:08:20.419810455Z" level=info msg="loading plugin \"io.containerd.streaming.v1.manager\"..." type=io.containerd.streaming.v1 May 13 00:08:20.419842 containerd[1389]: time="2025-05-13T00:08:20.419824249Z" level=info msg="loading plugin \"io.containerd.runtime.v1.linux\"..." type=io.containerd.runtime.v1 May 13 00:08:20.419977 containerd[1389]: time="2025-05-13T00:08:20.419954638Z" level=info msg="loading plugin \"io.containerd.monitor.v1.cgroups\"..." type=io.containerd.monitor.v1 May 13 00:08:20.420330 containerd[1389]: time="2025-05-13T00:08:20.420312598Z" level=info msg="loading plugin \"io.containerd.runtime.v2.task\"..." type=io.containerd.runtime.v2 May 13 00:08:20.420446 containerd[1389]: time="2025-05-13T00:08:20.420429440Z" level=info msg="loading plugin \"io.containerd.runtime.v2.shim\"..." type=io.containerd.runtime.v2 May 13 00:08:20.420478 containerd[1389]: time="2025-05-13T00:08:20.420449678Z" level=info msg="loading plugin \"io.containerd.sandbox.store.v1.local\"..." type=io.containerd.sandbox.store.v1 May 13 00:08:20.420478 containerd[1389]: time="2025-05-13T00:08:20.420462440Z" level=info msg="loading plugin \"io.containerd.sandbox.controller.v1.local\"..." type=io.containerd.sandbox.controller.v1 May 13 00:08:20.420530 containerd[1389]: time="2025-05-13T00:08:20.420483710Z" level=info msg="loading plugin \"io.containerd.service.v1.containers-service\"..." type=io.containerd.service.v1 May 13 00:08:20.420530 containerd[1389]: time="2025-05-13T00:08:20.420496431Z" level=info msg="loading plugin \"io.containerd.service.v1.content-service\"..." type=io.containerd.service.v1 May 13 00:08:20.420530 containerd[1389]: time="2025-05-13T00:08:20.420509069Z" level=info msg="loading plugin \"io.containerd.service.v1.diff-service\"..." type=io.containerd.service.v1 May 13 00:08:20.420530 containerd[1389]: time="2025-05-13T00:08:20.420525714Z" level=info msg="loading plugin \"io.containerd.service.v1.images-service\"..." type=io.containerd.service.v1 May 13 00:08:20.420613 containerd[1389]: time="2025-05-13T00:08:20.420540458Z" level=info msg="loading plugin \"io.containerd.service.v1.introspection-service\"..." type=io.containerd.service.v1 May 13 00:08:20.420613 containerd[1389]: time="2025-05-13T00:08:20.420553386Z" level=info msg="loading plugin \"io.containerd.service.v1.namespaces-service\"..." type=io.containerd.service.v1 May 13 00:08:20.420613 containerd[1389]: time="2025-05-13T00:08:20.420564950Z" level=info msg="loading plugin \"io.containerd.service.v1.snapshots-service\"..." type=io.containerd.service.v1 May 13 00:08:20.420613 containerd[1389]: time="2025-05-13T00:08:20.420577919Z" level=info msg="loading plugin \"io.containerd.service.v1.tasks-service\"..." type=io.containerd.service.v1 May 13 00:08:20.420613 containerd[1389]: time="2025-05-13T00:08:20.420600924Z" level=info msg="loading plugin \"io.containerd.grpc.v1.containers\"..." type=io.containerd.grpc.v1 May 13 00:08:20.420702 containerd[1389]: time="2025-05-13T00:08:20.420614553Z" level=info msg="loading plugin \"io.containerd.grpc.v1.content\"..." type=io.containerd.grpc.v1 May 13 00:08:20.420702 containerd[1389]: time="2025-05-13T00:08:20.420627274Z" level=info msg="loading plugin \"io.containerd.grpc.v1.diff\"..." type=io.containerd.grpc.v1 May 13 00:08:20.420702 containerd[1389]: time="2025-05-13T00:08:20.420638467Z" level=info msg="loading plugin \"io.containerd.grpc.v1.events\"..." type=io.containerd.grpc.v1 May 13 00:08:20.420702 containerd[1389]: time="2025-05-13T00:08:20.420650651Z" level=info msg="loading plugin \"io.containerd.grpc.v1.images\"..." type=io.containerd.grpc.v1 May 13 00:08:20.420702 containerd[1389]: time="2025-05-13T00:08:20.420664033Z" level=info msg="loading plugin \"io.containerd.grpc.v1.introspection\"..." type=io.containerd.grpc.v1 May 13 00:08:20.420702 containerd[1389]: time="2025-05-13T00:08:20.420675143Z" level=info msg="loading plugin \"io.containerd.grpc.v1.leases\"..." type=io.containerd.grpc.v1 May 13 00:08:20.420702 containerd[1389]: time="2025-05-13T00:08:20.420688607Z" level=info msg="loading plugin \"io.containerd.grpc.v1.namespaces\"..." type=io.containerd.grpc.v1 May 13 00:08:20.420702 containerd[1389]: time="2025-05-13T00:08:20.420700543Z" level=info msg="loading plugin \"io.containerd.grpc.v1.sandbox-controllers\"..." type=io.containerd.grpc.v1 May 13 00:08:20.420841 containerd[1389]: time="2025-05-13T00:08:20.420714255Z" level=info msg="loading plugin \"io.containerd.grpc.v1.sandboxes\"..." type=io.containerd.grpc.v1 May 13 00:08:20.420841 containerd[1389]: time="2025-05-13T00:08:20.420727802Z" level=info msg="loading plugin \"io.containerd.grpc.v1.snapshots\"..." type=io.containerd.grpc.v1 May 13 00:08:20.420841 containerd[1389]: time="2025-05-13T00:08:20.420738995Z" level=info msg="loading plugin \"io.containerd.grpc.v1.streaming\"..." type=io.containerd.grpc.v1 May 13 00:08:20.420841 containerd[1389]: time="2025-05-13T00:08:20.420752170Z" level=info msg="loading plugin \"io.containerd.grpc.v1.tasks\"..." type=io.containerd.grpc.v1 May 13 00:08:20.420841 containerd[1389]: time="2025-05-13T00:08:20.420767782Z" level=info msg="loading plugin \"io.containerd.transfer.v1.local\"..." type=io.containerd.transfer.v1 May 13 00:08:20.420841 containerd[1389]: time="2025-05-13T00:08:20.420790085Z" level=info msg="loading plugin \"io.containerd.grpc.v1.transfer\"..." type=io.containerd.grpc.v1 May 13 00:08:20.420841 containerd[1389]: time="2025-05-13T00:08:20.420801525Z" level=info msg="loading plugin \"io.containerd.grpc.v1.version\"..." type=io.containerd.grpc.v1 May 13 00:08:20.420841 containerd[1389]: time="2025-05-13T00:08:20.420812016Z" level=info msg="loading plugin \"io.containerd.internal.v1.restart\"..." type=io.containerd.internal.v1 May 13 00:08:20.421196 containerd[1389]: time="2025-05-13T00:08:20.420925967Z" level=info msg="loading plugin \"io.containerd.tracing.processor.v1.otlp\"..." type=io.containerd.tracing.processor.v1 May 13 00:08:20.421196 containerd[1389]: time="2025-05-13T00:08:20.420951284Z" level=info msg="skip loading plugin \"io.containerd.tracing.processor.v1.otlp\"..." error="skip plugin: tracing endpoint not configured" type=io.containerd.tracing.processor.v1 May 13 00:08:20.421196 containerd[1389]: time="2025-05-13T00:08:20.420963923Z" level=info msg="loading plugin \"io.containerd.internal.v1.tracing\"..." type=io.containerd.internal.v1 May 13 00:08:20.421196 containerd[1389]: time="2025-05-13T00:08:20.420976396Z" level=info msg="skip loading plugin \"io.containerd.internal.v1.tracing\"..." error="skip plugin: tracing endpoint not configured" type=io.containerd.internal.v1 May 13 00:08:20.421196 containerd[1389]: time="2025-05-13T00:08:20.420985482Z" level=info msg="loading plugin \"io.containerd.grpc.v1.healthcheck\"..." type=io.containerd.grpc.v1 May 13 00:08:20.421319 containerd[1389]: time="2025-05-13T00:08:20.421294087Z" level=info msg="loading plugin \"io.containerd.nri.v1.nri\"..." type=io.containerd.nri.v1 May 13 00:08:20.421348 containerd[1389]: time="2025-05-13T00:08:20.421318826Z" level=info msg="NRI interface is disabled by configuration." May 13 00:08:20.421348 containerd[1389]: time="2025-05-13T00:08:20.421338527Z" level=info msg="loading plugin \"io.containerd.grpc.v1.cri\"..." type=io.containerd.grpc.v1 May 13 00:08:20.422051 containerd[1389]: time="2025-05-13T00:08:20.421845338Z" 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}" May 13 00:08:20.422051 containerd[1389]: time="2025-05-13T00:08:20.421921291Z" level=info msg="Connect containerd service" May 13 00:08:20.422051 containerd[1389]: time="2025-05-13T00:08:20.421967053Z" level=info msg="using legacy CRI server" May 13 00:08:20.422051 containerd[1389]: time="2025-05-13T00:08:20.421975148Z" level=info msg="using experimental NRI integration - disable nri plugin to prevent this" May 13 00:08:20.422242 containerd[1389]: time="2025-05-13T00:08:20.422096822Z" level=info msg="Get image filesystem path \"/var/lib/containerd/io.containerd.snapshotter.v1.overlayfs\"" May 13 00:08:20.425285 containerd[1389]: time="2025-05-13T00:08:20.422950566Z" level=error msg="failed to load cni during init, please check CRI plugin status before setting up network for pods" error="cni config load failed: no network config found in /etc/cni/net.d: cni plugin not initialized: failed to load cni config" May 13 00:08:20.425285 containerd[1389]: time="2025-05-13T00:08:20.423085911Z" level=info msg="Start subscribing containerd event" May 13 00:08:20.425285 containerd[1389]: time="2025-05-13T00:08:20.423129442Z" level=info msg="Start recovering state" May 13 00:08:20.425285 containerd[1389]: time="2025-05-13T00:08:20.423359368Z" level=info msg="Start event monitor" May 13 00:08:20.425285 containerd[1389]: time="2025-05-13T00:08:20.423375640Z" level=info msg="Start snapshots syncer" May 13 00:08:20.425285 containerd[1389]: time="2025-05-13T00:08:20.423389972Z" level=info msg="Start cni network conf syncer for default" May 13 00:08:20.425285 containerd[1389]: time="2025-05-13T00:08:20.423402032Z" level=info msg="Start streaming server" May 13 00:08:20.425285 containerd[1389]: time="2025-05-13T00:08:20.423997311Z" level=info msg=serving... address=/run/containerd/containerd.sock.ttrpc May 13 00:08:20.425285 containerd[1389]: time="2025-05-13T00:08:20.424051250Z" level=info msg=serving... address=/run/containerd/containerd.sock May 13 00:08:20.425285 containerd[1389]: time="2025-05-13T00:08:20.424104694Z" level=info msg="containerd successfully booted in 0.037411s" May 13 00:08:20.424192 systemd[1]: Started containerd.service - containerd container runtime. May 13 00:08:20.777669 sshd_keygen[1376]: ssh-keygen: generating new host keys: RSA ECDSA ED25519 May 13 00:08:20.797204 systemd[1]: Finished sshd-keygen.service - Generate sshd host keys. May 13 00:08:20.809878 systemd[1]: Starting issuegen.service - Generate /run/issue... May 13 00:08:20.815008 systemd[1]: issuegen.service: Deactivated successfully. May 13 00:08:20.815205 systemd[1]: Finished issuegen.service - Generate /run/issue. May 13 00:08:20.818598 systemd[1]: Starting systemd-user-sessions.service - Permit User Sessions... May 13 00:08:20.832498 systemd[1]: Finished systemd-user-sessions.service - Permit User Sessions. May 13 00:08:20.835440 systemd[1]: Started getty@tty1.service - Getty on tty1. May 13 00:08:20.837558 systemd[1]: Started serial-getty@ttyAMA0.service - Serial Getty on ttyAMA0. May 13 00:08:20.838899 systemd[1]: Reached target getty.target - Login Prompts. May 13 00:08:21.049430 systemd-networkd[1328]: eth0: Gained IPv6LL May 13 00:08:21.051906 systemd[1]: Finished systemd-networkd-wait-online.service - Wait for Network to be Configured. May 13 00:08:21.053905 systemd[1]: Reached target network-online.target - Network is Online. May 13 00:08:21.065600 systemd[1]: Starting coreos-metadata.service - QEMU metadata agent... May 13 00:08:21.067651 systemd[1]: Starting nvidia.service - NVIDIA Configure Service... May 13 00:08:21.086166 systemd[1]: coreos-metadata.service: Deactivated successfully. May 13 00:08:21.086616 systemd[1]: Finished coreos-metadata.service - QEMU metadata agent. May 13 00:08:21.088844 systemd[1]: Finished nvidia.service - NVIDIA Configure Service. May 13 00:08:21.092223 systemd[1]: packet-phone-home.service - Report Success to Packet was skipped because no trigger condition checks were met. May 13 00:08:21.092548 systemd[1]: Reached target multi-user.target - Multi-User System. May 13 00:08:21.095444 systemd[1]: Startup finished in 665ms (kernel) + 3.705s (initrd) + 2.682s (userspace) = 7.054s. May 13 00:08:27.969639 systemd[1]: Created slice system-sshd.slice - Slice /system/sshd. May 13 00:08:27.970818 systemd[1]: Started sshd@0-10.0.0.15:22-10.0.0.1:53022.service - OpenSSH per-connection server daemon (10.0.0.1:53022). May 13 00:08:28.053615 sshd[1461]: Accepted publickey for core from 10.0.0.1 port 53022 ssh2: RSA SHA256:ilwLBGyeejLKSU0doRti0j2W4iQ88Tp+35jhkd0iwiU May 13 00:08:28.055734 sshd[1461]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) May 13 00:08:28.065702 systemd[1]: Created slice user-500.slice - User Slice of UID 500. May 13 00:08:28.075579 systemd[1]: Starting user-runtime-dir@500.service - User Runtime Directory /run/user/500... May 13 00:08:28.077613 systemd-logind[1370]: New session 1 of user core. May 13 00:08:28.089126 systemd[1]: Finished user-runtime-dir@500.service - User Runtime Directory /run/user/500. May 13 00:08:28.101587 systemd[1]: Starting user@500.service - User Manager for UID 500... May 13 00:08:28.104111 (systemd)[1466]: pam_unix(systemd-user:session): session opened for user core(uid=500) by (uid=0) May 13 00:08:28.185620 systemd[1466]: Queued start job for default target default.target. May 13 00:08:28.194254 systemd[1466]: Created slice app.slice - User Application Slice. May 13 00:08:28.194305 systemd[1466]: Reached target paths.target - Paths. May 13 00:08:28.194336 systemd[1466]: Reached target timers.target - Timers. May 13 00:08:28.195634 systemd[1466]: Starting dbus.socket - D-Bus User Message Bus Socket... May 13 00:08:28.206055 systemd[1466]: Listening on dbus.socket - D-Bus User Message Bus Socket. May 13 00:08:28.206123 systemd[1466]: Reached target sockets.target - Sockets. May 13 00:08:28.206136 systemd[1466]: Reached target basic.target - Basic System. May 13 00:08:28.206177 systemd[1466]: Reached target default.target - Main User Target. May 13 00:08:28.206206 systemd[1466]: Startup finished in 94ms. May 13 00:08:28.206618 systemd[1]: Started user@500.service - User Manager for UID 500. May 13 00:08:28.208146 systemd[1]: Started session-1.scope - Session 1 of User core. May 13 00:08:28.267732 systemd[1]: Started sshd@1-10.0.0.15:22-10.0.0.1:53038.service - OpenSSH per-connection server daemon (10.0.0.1:53038). May 13 00:08:28.303604 sshd[1477]: Accepted publickey for core from 10.0.0.1 port 53038 ssh2: RSA SHA256:ilwLBGyeejLKSU0doRti0j2W4iQ88Tp+35jhkd0iwiU May 13 00:08:28.304966 sshd[1477]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) May 13 00:08:28.308662 systemd-logind[1370]: New session 2 of user core. May 13 00:08:28.320456 systemd[1]: Started session-2.scope - Session 2 of User core. May 13 00:08:28.374892 sshd[1477]: pam_unix(sshd:session): session closed for user core May 13 00:08:28.385942 systemd[1]: sshd@1-10.0.0.15:22-10.0.0.1:53038.service: Deactivated successfully. May 13 00:08:28.392271 systemd[1]: session-2.scope: Deactivated successfully. May 13 00:08:28.396152 systemd-logind[1370]: Session 2 logged out. Waiting for processes to exit. May 13 00:08:28.408661 systemd[1]: Started sshd@2-10.0.0.15:22-10.0.0.1:53040.service - OpenSSH per-connection server daemon (10.0.0.1:53040). May 13 00:08:28.410905 systemd-logind[1370]: Removed session 2. May 13 00:08:28.442841 sshd[1484]: Accepted publickey for core from 10.0.0.1 port 53040 ssh2: RSA SHA256:ilwLBGyeejLKSU0doRti0j2W4iQ88Tp+35jhkd0iwiU May 13 00:08:28.444160 sshd[1484]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) May 13 00:08:28.448498 systemd-logind[1370]: New session 3 of user core. May 13 00:08:28.459485 systemd[1]: Started session-3.scope - Session 3 of User core. May 13 00:08:28.515998 sshd[1484]: pam_unix(sshd:session): session closed for user core May 13 00:08:28.527550 systemd[1]: sshd@2-10.0.0.15:22-10.0.0.1:53040.service: Deactivated successfully. May 13 00:08:28.530164 systemd[1]: session-3.scope: Deactivated successfully. May 13 00:08:28.533006 systemd-logind[1370]: Session 3 logged out. Waiting for processes to exit. May 13 00:08:28.544724 systemd[1]: Started sshd@3-10.0.0.15:22-10.0.0.1:53052.service - OpenSSH per-connection server daemon (10.0.0.1:53052). May 13 00:08:28.545692 systemd-logind[1370]: Removed session 3. May 13 00:08:28.580909 sshd[1491]: Accepted publickey for core from 10.0.0.1 port 53052 ssh2: RSA SHA256:ilwLBGyeejLKSU0doRti0j2W4iQ88Tp+35jhkd0iwiU May 13 00:08:28.582474 sshd[1491]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) May 13 00:08:28.587409 systemd-logind[1370]: New session 4 of user core. May 13 00:08:28.593451 systemd[1]: Started session-4.scope - Session 4 of User core. May 13 00:08:28.648420 sshd[1491]: pam_unix(sshd:session): session closed for user core May 13 00:08:28.660796 systemd[1]: sshd@3-10.0.0.15:22-10.0.0.1:53052.service: Deactivated successfully. May 13 00:08:28.662289 systemd[1]: session-4.scope: Deactivated successfully. May 13 00:08:28.665532 systemd-logind[1370]: Session 4 logged out. Waiting for processes to exit. May 13 00:08:28.676604 systemd[1]: Started sshd@4-10.0.0.15:22-10.0.0.1:53058.service - OpenSSH per-connection server daemon (10.0.0.1:53058). May 13 00:08:28.677560 systemd-logind[1370]: Removed session 4. May 13 00:08:28.709396 sshd[1498]: Accepted publickey for core from 10.0.0.1 port 53058 ssh2: RSA SHA256:ilwLBGyeejLKSU0doRti0j2W4iQ88Tp+35jhkd0iwiU May 13 00:08:28.710936 sshd[1498]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) May 13 00:08:28.715348 systemd-logind[1370]: New session 5 of user core. May 13 00:08:28.721456 systemd[1]: Started session-5.scope - Session 5 of User core. May 13 00:08:28.791645 sudo[1501]: core : PWD=/home/core ; USER=root ; COMMAND=/usr/sbin/setenforce 1 May 13 00:08:28.791963 sudo[1501]: pam_unix(sudo:session): session opened for user root(uid=0) by core(uid=500) May 13 00:08:28.806490 sudo[1501]: pam_unix(sudo:session): session closed for user root May 13 00:08:28.809257 sshd[1498]: pam_unix(sshd:session): session closed for user core May 13 00:08:28.825443 systemd[1]: sshd@4-10.0.0.15:22-10.0.0.1:53058.service: Deactivated successfully. May 13 00:08:28.828651 systemd[1]: session-5.scope: Deactivated successfully. May 13 00:08:28.831463 systemd-logind[1370]: Session 5 logged out. Waiting for processes to exit. May 13 00:08:28.844687 systemd[1]: Started sshd@5-10.0.0.15:22-10.0.0.1:53064.service - OpenSSH per-connection server daemon (10.0.0.1:53064). May 13 00:08:28.845849 systemd-logind[1370]: Removed session 5. May 13 00:08:28.881079 sshd[1506]: Accepted publickey for core from 10.0.0.1 port 53064 ssh2: RSA SHA256:ilwLBGyeejLKSU0doRti0j2W4iQ88Tp+35jhkd0iwiU May 13 00:08:28.882984 sshd[1506]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) May 13 00:08:28.886979 systemd-logind[1370]: New session 6 of user core. May 13 00:08:28.896460 systemd[1]: Started session-6.scope - Session 6 of User core. May 13 00:08:28.950261 sudo[1510]: core : PWD=/home/core ; USER=root ; COMMAND=/usr/bin/rm -rf /etc/audit/rules.d/80-selinux.rules /etc/audit/rules.d/99-default.rules May 13 00:08:28.950563 sudo[1510]: pam_unix(sudo:session): session opened for user root(uid=0) by core(uid=500) May 13 00:08:28.954065 sudo[1510]: pam_unix(sudo:session): session closed for user root May 13 00:08:28.959870 sudo[1509]: core : PWD=/home/core ; USER=root ; COMMAND=/usr/bin/systemctl restart audit-rules May 13 00:08:28.960162 sudo[1509]: pam_unix(sudo:session): session opened for user root(uid=0) by core(uid=500) May 13 00:08:28.978692 systemd[1]: Stopping audit-rules.service - Load Security Auditing Rules... May 13 00:08:28.980208 auditctl[1513]: No rules May 13 00:08:28.981283 systemd[1]: audit-rules.service: Deactivated successfully. May 13 00:08:28.981583 systemd[1]: Stopped audit-rules.service - Load Security Auditing Rules. May 13 00:08:28.984657 systemd[1]: Starting audit-rules.service - Load Security Auditing Rules... May 13 00:08:29.014073 augenrules[1531]: No rules May 13 00:08:29.015344 systemd[1]: Finished audit-rules.service - Load Security Auditing Rules. May 13 00:08:29.016504 sudo[1509]: pam_unix(sudo:session): session closed for user root May 13 00:08:29.020236 sshd[1506]: pam_unix(sshd:session): session closed for user core May 13 00:08:29.035134 systemd[1]: sshd@5-10.0.0.15:22-10.0.0.1:53064.service: Deactivated successfully. May 13 00:08:29.037123 systemd[1]: session-6.scope: Deactivated successfully. May 13 00:08:29.038615 systemd-logind[1370]: Session 6 logged out. Waiting for processes to exit. May 13 00:08:29.046739 systemd[1]: Started sshd@6-10.0.0.15:22-10.0.0.1:53068.service - OpenSSH per-connection server daemon (10.0.0.1:53068). May 13 00:08:29.048217 systemd-logind[1370]: Removed session 6. May 13 00:08:29.093522 sshd[1539]: Accepted publickey for core from 10.0.0.1 port 53068 ssh2: RSA SHA256:ilwLBGyeejLKSU0doRti0j2W4iQ88Tp+35jhkd0iwiU May 13 00:08:29.097022 sshd[1539]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) May 13 00:08:29.100949 systemd-logind[1370]: New session 7 of user core. May 13 00:08:29.109488 systemd[1]: Started session-7.scope - Session 7 of User core. May 13 00:08:56.081848 sudo[1557]: core : PWD=/home/core ; USER=root ; COMMAND=/usr/bin/systemd-nspawn --console=pipe --setenv=PORTAGE_BINHOST=http://bincache.flatcar-linux.net/boards/arm64-usr/4081.3.3+nightly-20250512-2100/pkgs --setenv=EXPECTED_VERSION=4081.3.3+nightly-20250512-2100 --bind-ro=/lib/modules --bind-ro=/home/core/dev-container-script --bind=/home/core/dev-container-workdir-16072/src:/usr/src --bind=/home/core/dev-container-workdir-16072/tmp:/var/tmp --image=flatcar_developer_container.bin --machine=flatcar-developer-container /bin/bash /home/core/dev-container-script May 13 00:08:56.082140 sudo[1557]: pam_unix(sudo:session): session opened for user root(uid=0) by core(uid=500) May 13 00:08:56.099290 kernel: loop4: detected capacity change from 0 to 12644352 May 13 00:08:56.104286 kernel: loop4: p9 May 13 00:08:56.523287 kernel: EXT4-fs (loop4p9): mounted filesystem f27ad939-1f2d-481b-ac4a-2d10dda8fa42 r/w with ordered data mode. Quota mode: none. May 13 00:08:56.530959 dbus-daemon[1358]: [system] Activating via systemd: service name='org.freedesktop.machine1' unit='dbus-org.freedesktop.machine1.service' requested by ':1.29' (uid=0 pid=1558 comm="systemd-nspawn --console=pipe --setenv=PORTAGE_BIN" label="system_u:system_r:kernel_t:s0") May 13 00:08:56.533476 systemd[1]: Created slice machine.slice - Virtual Machine and Container Slice. May 13 00:08:56.533539 systemd[1]: var-lib-machines.mount - Virtual Machine and Container Storage (Compatibility) was skipped because of an unmet condition check (ConditionPathExists=/var/lib/machines.raw). May 13 00:08:56.543594 systemd[1]: Starting systemd-machined.service - Virtual Machine and Container Registration Service... May 13 00:08:56.557690 dbus-daemon[1358]: [system] Successfully activated service 'org.freedesktop.machine1' May 13 00:08:56.558046 systemd[1]: Started systemd-machined.service - Virtual Machine and Container Registration Service. May 13 00:08:56.559415 systemd-machined[1568]: New machine flatcar-developer-container. May 13 00:08:56.561807 systemd[1]: Started machine-flatcar\x2ddeveloper\x2dcontainer.scope - Container flatcar-developer-container. May 13 00:08:56.565106 systemd-resolved[1255]: Failed to determine the local hostname and LLMNR/mDNS names, ignoring: No such device or address May 13 00:09:05.050959 update_engine[1374]: I20250513 00:09:05.050379 1374 update_attempter.cc:509] Updating boot flags... May 13 00:09:05.084007 kernel: BTRFS warning: duplicate device /dev/vda3 devid 1 generation 40 scanned by (udev-worker) (1628) May 13 00:09:05.110306 kernel: BTRFS warning: duplicate device /dev/vda3 devid 1 generation 40 scanned by (udev-worker) (1629) May 13 00:11:08.106573 update_engine[1374]: I20250513 00:11:08.104030 1374 prefs.cc:52] certificate-report-to-send-update not present in /var/lib/update_engine/prefs May 13 00:11:08.106573 update_engine[1374]: I20250513 00:11:08.106186 1374 prefs.cc:52] certificate-report-to-send-download not present in /var/lib/update_engine/prefs May 13 00:11:08.108804 update_engine[1374]: I20250513 00:11:08.108668 1374 prefs.cc:52] aleph-version not present in /var/lib/update_engine/prefs May 13 00:11:08.113893 update_engine[1374]: I20250513 00:11:08.109239 1374 omaha_request_params.cc:62] Current group set to lts May 13 00:11:08.151626 update_engine[1374]: I20250513 00:11:08.151580 1374 update_attempter.cc:499] Already updated boot flags. Skipping. May 13 00:11:08.151626 update_engine[1374]: I20250513 00:11:08.151611 1374 update_attempter.cc:643] Scheduling an action processor start. May 13 00:11:08.151626 update_engine[1374]: I20250513 00:11:08.151630 1374 action_processor.cc:36] ActionProcessor::StartProcessing: OmahaRequestAction May 13 00:11:08.151949 update_engine[1374]: I20250513 00:11:08.151924 1374 prefs.cc:52] previous-version not present in /var/lib/update_engine/prefs May 13 00:11:08.152010 update_engine[1374]: I20250513 00:11:08.151993 1374 omaha_request_action.cc:271] Posting an Omaha request to disabled May 13 00:11:08.152042 update_engine[1374]: I20250513 00:11:08.152007 1374 omaha_request_action.cc:272] Request: May 13 00:11:08.152042 update_engine[1374]: May 13 00:11:08.152042 update_engine[1374]: May 13 00:11:08.152042 update_engine[1374]: May 13 00:11:08.152042 update_engine[1374]: May 13 00:11:08.152042 update_engine[1374]: May 13 00:11:08.152042 update_engine[1374]: May 13 00:11:08.152042 update_engine[1374]: May 13 00:11:08.152042 update_engine[1374]: May 13 00:11:08.152042 update_engine[1374]: I20250513 00:11:08.152014 1374 libcurl_http_fetcher.cc:47] Starting/Resuming transfer May 13 00:11:08.158111 locksmithd[1393]: LastCheckedTime=0 Progress=0 CurrentOperation="UPDATE_STATUS_CHECKING_FOR_UPDATE" NewVersion=0.0.0 NewSize=0 May 13 00:11:08.166417 update_engine[1374]: I20250513 00:11:08.166077 1374 libcurl_http_fetcher.cc:151] Setting up curl options for HTTP May 13 00:11:08.172072 update_engine[1374]: I20250513 00:11:08.171697 1374 libcurl_http_fetcher.cc:449] Setting up timeout source: 1 seconds. May 13 00:11:08.214858 update_engine[1374]: E20250513 00:11:08.214691 1374 libcurl_http_fetcher.cc:266] Unable to get http response code: Could not resolve host: disabled May 13 00:11:08.214858 update_engine[1374]: I20250513 00:11:08.214807 1374 libcurl_http_fetcher.cc:283] No HTTP response, retry 1 May 13 00:11:18.051361 update_engine[1374]: I20250513 00:11:18.051304 1374 libcurl_http_fetcher.cc:47] Starting/Resuming transfer May 13 00:11:18.051722 update_engine[1374]: I20250513 00:11:18.051546 1374 libcurl_http_fetcher.cc:151] Setting up curl options for HTTP May 13 00:11:18.055918 update_engine[1374]: I20250513 00:11:18.055868 1374 libcurl_http_fetcher.cc:449] Setting up timeout source: 1 seconds. May 13 00:11:18.104907 update_engine[1374]: E20250513 00:11:18.104868 1374 libcurl_http_fetcher.cc:266] Unable to get http response code: Could not resolve host: disabled May 13 00:11:18.104989 update_engine[1374]: I20250513 00:11:18.104938 1374 libcurl_http_fetcher.cc:283] No HTTP response, retry 2 May 13 00:11:28.051561 update_engine[1374]: I20250513 00:11:28.051298 1374 libcurl_http_fetcher.cc:47] Starting/Resuming transfer May 13 00:11:28.051561 update_engine[1374]: I20250513 00:11:28.051550 1374 libcurl_http_fetcher.cc:151] Setting up curl options for HTTP May 13 00:11:28.051969 update_engine[1374]: I20250513 00:11:28.051734 1374 libcurl_http_fetcher.cc:449] Setting up timeout source: 1 seconds. May 13 00:11:28.117644 update_engine[1374]: E20250513 00:11:28.117511 1374 libcurl_http_fetcher.cc:266] Unable to get http response code: Could not resolve host: disabled May 13 00:11:28.117644 update_engine[1374]: I20250513 00:11:28.117600 1374 libcurl_http_fetcher.cc:283] No HTTP response, retry 3 May 13 00:11:38.052029 update_engine[1374]: I20250513 00:11:38.051311 1374 libcurl_http_fetcher.cc:47] Starting/Resuming transfer May 13 00:11:38.052029 update_engine[1374]: I20250513 00:11:38.051545 1374 libcurl_http_fetcher.cc:151] Setting up curl options for HTTP May 13 00:11:38.052029 update_engine[1374]: I20250513 00:11:38.051698 1374 libcurl_http_fetcher.cc:449] Setting up timeout source: 1 seconds. May 13 00:11:38.139956 update_engine[1374]: E20250513 00:11:38.135226 1374 libcurl_http_fetcher.cc:266] Unable to get http response code: Could not resolve host: disabled May 13 00:11:38.139956 update_engine[1374]: I20250513 00:11:38.135341 1374 libcurl_http_fetcher.cc:297] Transfer resulted in an error (0), 0 bytes downloaded May 13 00:11:38.139956 update_engine[1374]: I20250513 00:11:38.135350 1374 omaha_request_action.cc:617] Omaha request response: May 13 00:11:38.139956 update_engine[1374]: E20250513 00:11:38.135423 1374 omaha_request_action.cc:636] Omaha request network transfer failed. May 13 00:11:38.140458 update_engine[1374]: I20250513 00:11:38.140318 1374 action_processor.cc:68] ActionProcessor::ActionComplete: OmahaRequestAction action failed. Aborting processing. May 13 00:11:38.140458 update_engine[1374]: I20250513 00:11:38.140353 1374 action_processor.cc:73] ActionProcessor::ActionComplete: finished last action of type OmahaRequestAction May 13 00:11:38.140458 update_engine[1374]: I20250513 00:11:38.140359 1374 update_attempter.cc:306] Processing Done. May 13 00:11:38.141537 update_engine[1374]: E20250513 00:11:38.141486 1374 update_attempter.cc:619] Update failed. May 13 00:11:38.141537 update_engine[1374]: I20250513 00:11:38.141518 1374 utils.cc:600] Converting error code 2000 to kActionCodeOmahaErrorInHTTPResponse May 13 00:11:38.143310 update_engine[1374]: I20250513 00:11:38.141525 1374 payload_state.cc:97] Updating payload state for error code: 37 (kActionCodeOmahaErrorInHTTPResponse) May 13 00:11:38.143310 update_engine[1374]: I20250513 00:11:38.142163 1374 payload_state.cc:103] Ignoring failures until we get a valid Omaha response. May 13 00:11:38.143310 update_engine[1374]: I20250513 00:11:38.142241 1374 action_processor.cc:36] ActionProcessor::StartProcessing: OmahaRequestAction May 13 00:11:38.143310 update_engine[1374]: I20250513 00:11:38.142274 1374 omaha_request_action.cc:271] Posting an Omaha request to disabled May 13 00:11:38.143310 update_engine[1374]: I20250513 00:11:38.142282 1374 omaha_request_action.cc:272] Request: May 13 00:11:38.143310 update_engine[1374]: May 13 00:11:38.143310 update_engine[1374]: May 13 00:11:38.143310 update_engine[1374]: May 13 00:11:38.143310 update_engine[1374]: May 13 00:11:38.143310 update_engine[1374]: May 13 00:11:38.143310 update_engine[1374]: May 13 00:11:38.143310 update_engine[1374]: I20250513 00:11:38.142288 1374 libcurl_http_fetcher.cc:47] Starting/Resuming transfer May 13 00:11:38.143310 update_engine[1374]: I20250513 00:11:38.142469 1374 libcurl_http_fetcher.cc:151] Setting up curl options for HTTP May 13 00:11:38.143310 update_engine[1374]: I20250513 00:11:38.142618 1374 libcurl_http_fetcher.cc:449] Setting up timeout source: 1 seconds. May 13 00:11:38.143649 locksmithd[1393]: LastCheckedTime=0 Progress=0 CurrentOperation="UPDATE_STATUS_REPORTING_ERROR_EVENT" NewVersion=0.0.0 NewSize=0 May 13 00:11:38.186930 update_engine[1374]: E20250513 00:11:38.186874 1374 libcurl_http_fetcher.cc:266] Unable to get http response code: Could not resolve host: disabled May 13 00:11:38.187034 update_engine[1374]: I20250513 00:11:38.186952 1374 libcurl_http_fetcher.cc:297] Transfer resulted in an error (0), 0 bytes downloaded May 13 00:11:38.187034 update_engine[1374]: I20250513 00:11:38.186961 1374 omaha_request_action.cc:617] Omaha request response: May 13 00:11:38.187034 update_engine[1374]: I20250513 00:11:38.186968 1374 action_processor.cc:65] ActionProcessor::ActionComplete: finished last action of type OmahaRequestAction May 13 00:11:38.187034 update_engine[1374]: I20250513 00:11:38.186972 1374 action_processor.cc:73] ActionProcessor::ActionComplete: finished last action of type OmahaRequestAction May 13 00:11:38.187034 update_engine[1374]: I20250513 00:11:38.186977 1374 update_attempter.cc:306] Processing Done. May 13 00:11:38.187034 update_engine[1374]: I20250513 00:11:38.186983 1374 update_attempter.cc:310] Error event sent. May 13 00:11:38.187237 update_engine[1374]: I20250513 00:11:38.187103 1374 update_check_scheduler.cc:74] Next update check in 46m58s May 13 00:11:38.187558 locksmithd[1393]: LastCheckedTime=0 Progress=0 CurrentOperation="UPDATE_STATUS_IDLE" NewVersion=0.0.0 NewSize=0 May 13 00:11:44.732308 kernel: EXT4-fs (loop4p9): unmounting filesystem f27ad939-1f2d-481b-ac4a-2d10dda8fa42. May 13 00:11:44.753890 systemd[1]: machine-flatcar\x2ddeveloper\x2dcontainer.scope: Deactivated successfully. May 13 00:11:44.754168 systemd[1]: machine-flatcar\x2ddeveloper\x2dcontainer.scope: Consumed 4min 1.274s CPU time. May 13 00:11:44.754560 systemd-machined[1568]: Machine flatcar-developer-container terminated. May 13 00:11:44.801054 sudo[1557]: pam_unix(sudo:session): session closed for user root May 13 00:11:44.814397 sshd[1539]: pam_unix(sshd:session): session closed for user core May 13 00:11:44.818635 systemd[1]: sshd@6-10.0.0.15:22-10.0.0.1:53068.service: Deactivated successfully. May 13 00:11:44.820244 systemd[1]: session-7.scope: Deactivated successfully. May 13 00:11:44.820452 systemd[1]: session-7.scope: Consumed 1min 5.557s CPU time. May 13 00:11:44.821565 systemd-logind[1370]: Session 7 logged out. Waiting for processes to exit. May 13 00:11:44.822559 systemd-logind[1370]: Removed session 7.