Nov 12 17:58:09.906208 kernel: Booting Linux on physical CPU 0x0000000000 [0x413fd0c1] Nov 12 17:58:09.906228 kernel: Linux version 6.6.60-flatcar (build@pony-truck.infra.kinvolk.io) (aarch64-cros-linux-gnu-gcc (Gentoo Hardened 13.3.1_p20240614 p17) 13.3.1 20240614, GNU ld (Gentoo 2.42 p3) 2.42.0) #1 SMP PREEMPT Tue Nov 12 16:24:35 -00 2024 Nov 12 17:58:09.906238 kernel: KASLR enabled Nov 12 17:58:09.906243 kernel: efi: EFI v2.7 by EDK II Nov 12 17:58:09.906249 kernel: efi: SMBIOS 3.0=0xdced0000 MEMATTR=0xdba86018 ACPI 2.0=0xd9710018 RNG=0xd971e498 MEMRESERVE=0xd9b43d18 Nov 12 17:58:09.906255 kernel: random: crng init done Nov 12 17:58:09.906262 kernel: ACPI: Early table checksum verification disabled Nov 12 17:58:09.906268 kernel: ACPI: RSDP 0x00000000D9710018 000024 (v02 BOCHS ) Nov 12 17:58:09.906274 kernel: ACPI: XSDT 0x00000000D971FE98 000064 (v01 BOCHS BXPC 00000001 01000013) Nov 12 17:58:09.906281 kernel: ACPI: FACP 0x00000000D971FA98 000114 (v06 BOCHS BXPC 00000001 BXPC 00000001) Nov 12 17:58:09.906287 kernel: ACPI: DSDT 0x00000000D9717518 0014A2 (v02 BOCHS BXPC 00000001 BXPC 00000001) Nov 12 17:58:09.906293 kernel: ACPI: APIC 0x00000000D971FC18 0001A8 (v04 BOCHS BXPC 00000001 BXPC 00000001) Nov 12 17:58:09.906299 kernel: ACPI: PPTT 0x00000000D971D898 00009C (v02 BOCHS BXPC 00000001 BXPC 00000001) Nov 12 17:58:09.906305 kernel: ACPI: GTDT 0x00000000D971E818 000060 (v02 BOCHS BXPC 00000001 BXPC 00000001) Nov 12 17:58:09.906312 kernel: ACPI: MCFG 0x00000000D971E918 00003C (v01 BOCHS BXPC 00000001 BXPC 00000001) Nov 12 17:58:09.906320 kernel: ACPI: SPCR 0x00000000D971FF98 000050 (v02 BOCHS BXPC 00000001 BXPC 00000001) Nov 12 17:58:09.906326 kernel: ACPI: DBG2 0x00000000D971E418 000057 (v00 BOCHS BXPC 00000001 BXPC 00000001) Nov 12 17:58:09.906333 kernel: ACPI: IORT 0x00000000D971E718 000080 (v03 BOCHS BXPC 00000001 BXPC 00000001) Nov 12 17:58:09.906339 kernel: ACPI: SPCR: console: pl011,mmio,0x9000000,9600 Nov 12 17:58:09.906345 kernel: NUMA: Failed to initialise from firmware Nov 12 17:58:09.906352 kernel: NUMA: Faking a node at [mem 0x0000000040000000-0x00000000dcffffff] Nov 12 17:58:09.906376 kernel: NUMA: NODE_DATA [mem 0xdc958800-0xdc95dfff] Nov 12 17:58:09.906383 kernel: Zone ranges: Nov 12 17:58:09.906389 kernel: DMA [mem 0x0000000040000000-0x00000000dcffffff] Nov 12 17:58:09.906396 kernel: DMA32 empty Nov 12 17:58:09.906403 kernel: Normal empty Nov 12 17:58:09.906409 kernel: Movable zone start for each node Nov 12 17:58:09.906416 kernel: Early memory node ranges Nov 12 17:58:09.906422 kernel: node 0: [mem 0x0000000040000000-0x00000000d976ffff] Nov 12 17:58:09.906428 kernel: node 0: [mem 0x00000000d9770000-0x00000000d9b3ffff] Nov 12 17:58:09.906434 kernel: node 0: [mem 0x00000000d9b40000-0x00000000dce1ffff] Nov 12 17:58:09.906441 kernel: node 0: [mem 0x00000000dce20000-0x00000000dceaffff] Nov 12 17:58:09.906447 kernel: node 0: [mem 0x00000000dceb0000-0x00000000dcebffff] Nov 12 17:58:09.906453 kernel: node 0: [mem 0x00000000dcec0000-0x00000000dcfdffff] Nov 12 17:58:09.906459 kernel: node 0: [mem 0x00000000dcfe0000-0x00000000dcffffff] Nov 12 17:58:09.906466 kernel: Initmem setup node 0 [mem 0x0000000040000000-0x00000000dcffffff] Nov 12 17:58:09.906472 kernel: On node 0, zone DMA: 12288 pages in unavailable ranges Nov 12 17:58:09.906480 kernel: psci: probing for conduit method from ACPI. Nov 12 17:58:09.906486 kernel: psci: PSCIv1.1 detected in firmware. Nov 12 17:58:09.906493 kernel: psci: Using standard PSCI v0.2 function IDs Nov 12 17:58:09.906501 kernel: psci: Trusted OS migration not required Nov 12 17:58:09.906508 kernel: psci: SMC Calling Convention v1.1 Nov 12 17:58:09.906515 kernel: smccc: KVM: hypervisor services detected (0x00000000 0x00000000 0x00000000 0x00000003) Nov 12 17:58:09.906522 kernel: percpu: Embedded 31 pages/cpu s86696 r8192 d32088 u126976 Nov 12 17:58:09.906529 kernel: pcpu-alloc: s86696 r8192 d32088 u126976 alloc=31*4096 Nov 12 17:58:09.906536 kernel: pcpu-alloc: [0] 0 [0] 1 [0] 2 [0] 3 Nov 12 17:58:09.906543 kernel: Detected PIPT I-cache on CPU0 Nov 12 17:58:09.906549 kernel: CPU features: detected: GIC system register CPU interface Nov 12 17:58:09.906556 kernel: CPU features: detected: Hardware dirty bit management Nov 12 17:58:09.906563 kernel: CPU features: detected: Spectre-v4 Nov 12 17:58:09.906569 kernel: CPU features: detected: Spectre-BHB Nov 12 17:58:09.906576 kernel: CPU features: kernel page table isolation forced ON by KASLR Nov 12 17:58:09.906583 kernel: CPU features: detected: Kernel page table isolation (KPTI) Nov 12 17:58:09.906597 kernel: CPU features: detected: ARM erratum 1418040 Nov 12 17:58:09.906604 kernel: CPU features: detected: SSBS not fully self-synchronizing Nov 12 17:58:09.906610 kernel: alternatives: applying boot alternatives Nov 12 17:58:09.906618 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=8c276c03cfeb31103ba0b5f1af613bdc698463ad3d29e6750e34154929bf187e Nov 12 17:58:09.906626 kernel: Unknown kernel command line parameters "BOOT_IMAGE=/flatcar/vmlinuz-a", will be passed to user space. Nov 12 17:58:09.906633 kernel: Dentry cache hash table entries: 524288 (order: 10, 4194304 bytes, linear) Nov 12 17:58:09.906639 kernel: Inode-cache hash table entries: 262144 (order: 9, 2097152 bytes, linear) Nov 12 17:58:09.906646 kernel: Fallback order for Node 0: 0 Nov 12 17:58:09.906653 kernel: Built 1 zonelists, mobility grouping on. Total pages: 633024 Nov 12 17:58:09.906659 kernel: Policy zone: DMA Nov 12 17:58:09.906666 kernel: mem auto-init: stack:off, heap alloc:off, heap free:off Nov 12 17:58:09.906674 kernel: software IO TLB: area num 4. Nov 12 17:58:09.906680 kernel: software IO TLB: mapped [mem 0x00000000d2e00000-0x00000000d6e00000] (64MB) Nov 12 17:58:09.906687 kernel: Memory: 2386532K/2572288K available (10240K kernel code, 2184K rwdata, 8096K rodata, 39360K init, 897K bss, 185756K reserved, 0K cma-reserved) Nov 12 17:58:09.906694 kernel: SLUB: HWalign=64, Order=0-3, MinObjects=0, CPUs=4, Nodes=1 Nov 12 17:58:09.906701 kernel: trace event string verifier disabled Nov 12 17:58:09.906708 kernel: rcu: Preemptible hierarchical RCU implementation. Nov 12 17:58:09.906715 kernel: rcu: RCU event tracing is enabled. Nov 12 17:58:09.906722 kernel: rcu: RCU restricting CPUs from NR_CPUS=512 to nr_cpu_ids=4. Nov 12 17:58:09.906728 kernel: Trampoline variant of Tasks RCU enabled. Nov 12 17:58:09.906735 kernel: Tracing variant of Tasks RCU enabled. Nov 12 17:58:09.906742 kernel: rcu: RCU calculated value of scheduler-enlistment delay is 100 jiffies. Nov 12 17:58:09.906749 kernel: rcu: Adjusting geometry for rcu_fanout_leaf=16, nr_cpu_ids=4 Nov 12 17:58:09.906756 kernel: NR_IRQS: 64, nr_irqs: 64, preallocated irqs: 0 Nov 12 17:58:09.906763 kernel: GICv3: 256 SPIs implemented Nov 12 17:58:09.906770 kernel: GICv3: 0 Extended SPIs implemented Nov 12 17:58:09.906776 kernel: Root IRQ handler: gic_handle_irq Nov 12 17:58:09.906783 kernel: GICv3: GICv3 features: 16 PPIs, DirectLPI Nov 12 17:58:09.906790 kernel: GICv3: CPU0: found redistributor 0 region 0:0x00000000080a0000 Nov 12 17:58:09.906797 kernel: ITS [mem 0x08080000-0x0809ffff] Nov 12 17:58:09.906803 kernel: ITS@0x0000000008080000: allocated 8192 Devices @400c0000 (indirect, esz 8, psz 64K, shr 1) Nov 12 17:58:09.906810 kernel: ITS@0x0000000008080000: allocated 8192 Interrupt Collections @400d0000 (flat, esz 8, psz 64K, shr 1) Nov 12 17:58:09.906817 kernel: GICv3: using LPI property table @0x00000000400f0000 Nov 12 17:58:09.906824 kernel: GICv3: CPU0: using allocated LPI pending table @0x0000000040100000 Nov 12 17:58:09.906832 kernel: rcu: srcu_init: Setting srcu_struct sizes based on contention. Nov 12 17:58:09.906839 kernel: arch_timer: Enabling local workaround for ARM erratum 1418040 Nov 12 17:58:09.906845 kernel: arch_timer: cp15 timer(s) running at 25.00MHz (virt). Nov 12 17:58:09.906852 kernel: clocksource: arch_sys_counter: mask: 0xffffffffffffff max_cycles: 0x5c40939b5, max_idle_ns: 440795202646 ns Nov 12 17:58:09.906859 kernel: sched_clock: 56 bits at 25MHz, resolution 40ns, wraps every 4398046511100ns Nov 12 17:58:09.906866 kernel: arm-pv: using stolen time PV Nov 12 17:58:09.906873 kernel: Console: colour dummy device 80x25 Nov 12 17:58:09.906880 kernel: ACPI: Core revision 20230628 Nov 12 17:58:09.906887 kernel: Calibrating delay loop (skipped), value calculated using timer frequency.. 50.00 BogoMIPS (lpj=25000) Nov 12 17:58:09.906893 kernel: pid_max: default: 32768 minimum: 301 Nov 12 17:58:09.906901 kernel: LSM: initializing lsm=lockdown,capability,landlock,selinux,integrity Nov 12 17:58:09.906908 kernel: landlock: Up and running. Nov 12 17:58:09.906915 kernel: SELinux: Initializing. Nov 12 17:58:09.906922 kernel: Mount-cache hash table entries: 8192 (order: 4, 65536 bytes, linear) Nov 12 17:58:09.906929 kernel: Mountpoint-cache hash table entries: 8192 (order: 4, 65536 bytes, linear) Nov 12 17:58:09.906936 kernel: RCU Tasks: Setting shift to 2 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=4. Nov 12 17:58:09.906943 kernel: RCU Tasks Trace: Setting shift to 2 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=4. Nov 12 17:58:09.906950 kernel: rcu: Hierarchical SRCU implementation. Nov 12 17:58:09.906957 kernel: rcu: Max phase no-delay instances is 400. Nov 12 17:58:09.906964 kernel: Platform MSI: ITS@0x8080000 domain created Nov 12 17:58:09.906971 kernel: PCI/MSI: ITS@0x8080000 domain created Nov 12 17:58:09.906978 kernel: Remapping and enabling EFI services. Nov 12 17:58:09.906985 kernel: smp: Bringing up secondary CPUs ... Nov 12 17:58:09.906992 kernel: Detected PIPT I-cache on CPU1 Nov 12 17:58:09.906999 kernel: GICv3: CPU1: found redistributor 1 region 0:0x00000000080c0000 Nov 12 17:58:09.907006 kernel: GICv3: CPU1: using allocated LPI pending table @0x0000000040110000 Nov 12 17:58:09.907013 kernel: arch_timer: Enabling local workaround for ARM erratum 1418040 Nov 12 17:58:09.907019 kernel: CPU1: Booted secondary processor 0x0000000001 [0x413fd0c1] Nov 12 17:58:09.907026 kernel: Detected PIPT I-cache on CPU2 Nov 12 17:58:09.907035 kernel: GICv3: CPU2: found redistributor 2 region 0:0x00000000080e0000 Nov 12 17:58:09.907042 kernel: GICv3: CPU2: using allocated LPI pending table @0x0000000040120000 Nov 12 17:58:09.907053 kernel: arch_timer: Enabling local workaround for ARM erratum 1418040 Nov 12 17:58:09.907062 kernel: CPU2: Booted secondary processor 0x0000000002 [0x413fd0c1] Nov 12 17:58:09.907069 kernel: Detected PIPT I-cache on CPU3 Nov 12 17:58:09.907076 kernel: GICv3: CPU3: found redistributor 3 region 0:0x0000000008100000 Nov 12 17:58:09.907083 kernel: GICv3: CPU3: using allocated LPI pending table @0x0000000040130000 Nov 12 17:58:09.907090 kernel: arch_timer: Enabling local workaround for ARM erratum 1418040 Nov 12 17:58:09.907098 kernel: CPU3: Booted secondary processor 0x0000000003 [0x413fd0c1] Nov 12 17:58:09.907106 kernel: smp: Brought up 1 node, 4 CPUs Nov 12 17:58:09.907113 kernel: SMP: Total of 4 processors activated. Nov 12 17:58:09.907120 kernel: CPU features: detected: 32-bit EL0 Support Nov 12 17:58:09.907128 kernel: CPU features: detected: Data cache clean to the PoU not required for I/D coherence Nov 12 17:58:09.907135 kernel: CPU features: detected: Common not Private translations Nov 12 17:58:09.907143 kernel: CPU features: detected: CRC32 instructions Nov 12 17:58:09.907150 kernel: CPU features: detected: Enhanced Virtualization Traps Nov 12 17:58:09.907157 kernel: CPU features: detected: RCpc load-acquire (LDAPR) Nov 12 17:58:09.907165 kernel: CPU features: detected: LSE atomic instructions Nov 12 17:58:09.907173 kernel: CPU features: detected: Privileged Access Never Nov 12 17:58:09.907180 kernel: CPU features: detected: RAS Extension Support Nov 12 17:58:09.907187 kernel: CPU features: detected: Speculative Store Bypassing Safe (SSBS) Nov 12 17:58:09.907195 kernel: CPU: All CPU(s) started at EL1 Nov 12 17:58:09.907202 kernel: alternatives: applying system-wide alternatives Nov 12 17:58:09.907209 kernel: devtmpfs: initialized Nov 12 17:58:09.907216 kernel: clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1911260446275000 ns Nov 12 17:58:09.907224 kernel: futex hash table entries: 1024 (order: 4, 65536 bytes, linear) Nov 12 17:58:09.907232 kernel: pinctrl core: initialized pinctrl subsystem Nov 12 17:58:09.907239 kernel: SMBIOS 3.0.0 present. Nov 12 17:58:09.907247 kernel: DMI: QEMU KVM Virtual Machine, BIOS edk2-20230524-3.fc38 05/24/2023 Nov 12 17:58:09.907254 kernel: NET: Registered PF_NETLINK/PF_ROUTE protocol family Nov 12 17:58:09.907261 kernel: DMA: preallocated 512 KiB GFP_KERNEL pool for atomic allocations Nov 12 17:58:09.907269 kernel: DMA: preallocated 512 KiB GFP_KERNEL|GFP_DMA pool for atomic allocations Nov 12 17:58:09.907276 kernel: DMA: preallocated 512 KiB GFP_KERNEL|GFP_DMA32 pool for atomic allocations Nov 12 17:58:09.907283 kernel: audit: initializing netlink subsys (disabled) Nov 12 17:58:09.907291 kernel: audit: type=2000 audit(0.022:1): state=initialized audit_enabled=0 res=1 Nov 12 17:58:09.907299 kernel: thermal_sys: Registered thermal governor 'step_wise' Nov 12 17:58:09.907306 kernel: cpuidle: using governor menu Nov 12 17:58:09.907313 kernel: hw-breakpoint: found 6 breakpoint and 4 watchpoint registers. Nov 12 17:58:09.907321 kernel: ASID allocator initialised with 32768 entries Nov 12 17:58:09.907328 kernel: acpiphp: ACPI Hot Plug PCI Controller Driver version: 0.5 Nov 12 17:58:09.907336 kernel: Serial: AMBA PL011 UART driver Nov 12 17:58:09.907343 kernel: Modules: 2G module region forced by RANDOMIZE_MODULE_REGION_FULL Nov 12 17:58:09.907350 kernel: Modules: 0 pages in range for non-PLT usage Nov 12 17:58:09.907364 kernel: Modules: 509040 pages in range for PLT usage Nov 12 17:58:09.907373 kernel: HugeTLB: registered 1.00 GiB page size, pre-allocated 0 pages Nov 12 17:58:09.907380 kernel: HugeTLB: 0 KiB vmemmap can be freed for a 1.00 GiB page Nov 12 17:58:09.907387 kernel: HugeTLB: registered 32.0 MiB page size, pre-allocated 0 pages Nov 12 17:58:09.907394 kernel: HugeTLB: 0 KiB vmemmap can be freed for a 32.0 MiB page Nov 12 17:58:09.907402 kernel: HugeTLB: registered 2.00 MiB page size, pre-allocated 0 pages Nov 12 17:58:09.907409 kernel: HugeTLB: 0 KiB vmemmap can be freed for a 2.00 MiB page Nov 12 17:58:09.907416 kernel: HugeTLB: registered 64.0 KiB page size, pre-allocated 0 pages Nov 12 17:58:09.907424 kernel: HugeTLB: 0 KiB vmemmap can be freed for a 64.0 KiB page Nov 12 17:58:09.907431 kernel: ACPI: Added _OSI(Module Device) Nov 12 17:58:09.907439 kernel: ACPI: Added _OSI(Processor Device) Nov 12 17:58:09.907446 kernel: ACPI: Added _OSI(3.0 _SCP Extensions) Nov 12 17:58:09.907453 kernel: ACPI: Added _OSI(Processor Aggregator Device) Nov 12 17:58:09.907461 kernel: ACPI: 1 ACPI AML tables successfully acquired and loaded Nov 12 17:58:09.907468 kernel: ACPI: Interpreter enabled Nov 12 17:58:09.907475 kernel: ACPI: Using GIC for interrupt routing Nov 12 17:58:09.907482 kernel: ACPI: MCFG table detected, 1 entries Nov 12 17:58:09.907490 kernel: ARMH0011:00: ttyAMA0 at MMIO 0x9000000 (irq = 12, base_baud = 0) is a SBSA Nov 12 17:58:09.907497 kernel: printk: console [ttyAMA0] enabled Nov 12 17:58:09.907505 kernel: ACPI: PCI Root Bridge [PCI0] (domain 0000 [bus 00-ff]) Nov 12 17:58:09.907631 kernel: acpi PNP0A08:00: _OSC: OS supports [ExtendedConfig ASPM ClockPM Segments MSI HPX-Type3] Nov 12 17:58:09.907703 kernel: acpi PNP0A08:00: _OSC: platform does not support [LTR] Nov 12 17:58:09.907766 kernel: acpi PNP0A08:00: _OSC: OS now controls [PCIeHotplug PME AER PCIeCapability] Nov 12 17:58:09.907828 kernel: acpi PNP0A08:00: ECAM area [mem 0x4010000000-0x401fffffff] reserved by PNP0C02:00 Nov 12 17:58:09.907889 kernel: acpi PNP0A08:00: ECAM at [mem 0x4010000000-0x401fffffff] for [bus 00-ff] Nov 12 17:58:09.907899 kernel: ACPI: Remapped I/O 0x000000003eff0000 to [io 0x0000-0xffff window] Nov 12 17:58:09.907909 kernel: PCI host bridge to bus 0000:00 Nov 12 17:58:09.907976 kernel: pci_bus 0000:00: root bus resource [mem 0x10000000-0x3efeffff window] Nov 12 17:58:09.908033 kernel: pci_bus 0000:00: root bus resource [io 0x0000-0xffff window] Nov 12 17:58:09.908089 kernel: pci_bus 0000:00: root bus resource [mem 0x8000000000-0xffffffffff window] Nov 12 17:58:09.908145 kernel: pci_bus 0000:00: root bus resource [bus 00-ff] Nov 12 17:58:09.908220 kernel: pci 0000:00:00.0: [1b36:0008] type 00 class 0x060000 Nov 12 17:58:09.908293 kernel: pci 0000:00:01.0: [1af4:1005] type 00 class 0x00ff00 Nov 12 17:58:09.908372 kernel: pci 0000:00:01.0: reg 0x10: [io 0x0000-0x001f] Nov 12 17:58:09.908439 kernel: pci 0000:00:01.0: reg 0x14: [mem 0x10000000-0x10000fff] Nov 12 17:58:09.908504 kernel: pci 0000:00:01.0: reg 0x20: [mem 0x8000000000-0x8000003fff 64bit pref] Nov 12 17:58:09.908569 kernel: pci 0000:00:01.0: BAR 4: assigned [mem 0x8000000000-0x8000003fff 64bit pref] Nov 12 17:58:09.908643 kernel: pci 0000:00:01.0: BAR 1: assigned [mem 0x10000000-0x10000fff] Nov 12 17:58:09.908709 kernel: pci 0000:00:01.0: BAR 0: assigned [io 0x1000-0x101f] Nov 12 17:58:09.908768 kernel: pci_bus 0000:00: resource 4 [mem 0x10000000-0x3efeffff window] Nov 12 17:58:09.908828 kernel: pci_bus 0000:00: resource 5 [io 0x0000-0xffff window] Nov 12 17:58:09.908886 kernel: pci_bus 0000:00: resource 6 [mem 0x8000000000-0xffffffffff window] Nov 12 17:58:09.908895 kernel: ACPI: PCI: Interrupt link GSI0 configured for IRQ 35 Nov 12 17:58:09.908903 kernel: ACPI: PCI: Interrupt link GSI1 configured for IRQ 36 Nov 12 17:58:09.908910 kernel: ACPI: PCI: Interrupt link GSI2 configured for IRQ 37 Nov 12 17:58:09.908918 kernel: ACPI: PCI: Interrupt link GSI3 configured for IRQ 38 Nov 12 17:58:09.908925 kernel: iommu: Default domain type: Translated Nov 12 17:58:09.908932 kernel: iommu: DMA domain TLB invalidation policy: strict mode Nov 12 17:58:09.908941 kernel: efivars: Registered efivars operations Nov 12 17:58:09.908948 kernel: vgaarb: loaded Nov 12 17:58:09.908955 kernel: clocksource: Switched to clocksource arch_sys_counter Nov 12 17:58:09.908963 kernel: VFS: Disk quotas dquot_6.6.0 Nov 12 17:58:09.908970 kernel: VFS: Dquot-cache hash table entries: 512 (order 0, 4096 bytes) Nov 12 17:58:09.908977 kernel: pnp: PnP ACPI init Nov 12 17:58:09.909100 kernel: system 00:00: [mem 0x4010000000-0x401fffffff window] could not be reserved Nov 12 17:58:09.909113 kernel: pnp: PnP ACPI: found 1 devices Nov 12 17:58:09.909123 kernel: NET: Registered PF_INET protocol family Nov 12 17:58:09.909131 kernel: IP idents hash table entries: 65536 (order: 7, 524288 bytes, linear) Nov 12 17:58:09.909138 kernel: tcp_listen_portaddr_hash hash table entries: 2048 (order: 3, 32768 bytes, linear) Nov 12 17:58:09.909146 kernel: Table-perturb hash table entries: 65536 (order: 6, 262144 bytes, linear) Nov 12 17:58:09.909153 kernel: TCP established hash table entries: 32768 (order: 6, 262144 bytes, linear) Nov 12 17:58:09.909161 kernel: TCP bind hash table entries: 32768 (order: 8, 1048576 bytes, linear) Nov 12 17:58:09.909168 kernel: TCP: Hash tables configured (established 32768 bind 32768) Nov 12 17:58:09.909175 kernel: UDP hash table entries: 2048 (order: 4, 65536 bytes, linear) Nov 12 17:58:09.909183 kernel: UDP-Lite hash table entries: 2048 (order: 4, 65536 bytes, linear) Nov 12 17:58:09.909191 kernel: NET: Registered PF_UNIX/PF_LOCAL protocol family Nov 12 17:58:09.909199 kernel: PCI: CLS 0 bytes, default 64 Nov 12 17:58:09.909206 kernel: kvm [1]: HYP mode not available Nov 12 17:58:09.909213 kernel: Initialise system trusted keyrings Nov 12 17:58:09.909220 kernel: workingset: timestamp_bits=39 max_order=20 bucket_order=0 Nov 12 17:58:09.909228 kernel: Key type asymmetric registered Nov 12 17:58:09.909235 kernel: Asymmetric key parser 'x509' registered Nov 12 17:58:09.909242 kernel: Block layer SCSI generic (bsg) driver version 0.4 loaded (major 250) Nov 12 17:58:09.909249 kernel: io scheduler mq-deadline registered Nov 12 17:58:09.909258 kernel: io scheduler kyber registered Nov 12 17:58:09.909265 kernel: io scheduler bfq registered Nov 12 17:58:09.909272 kernel: input: Power Button as /devices/LNXSYSTM:00/LNXSYBUS:00/PNP0C0C:00/input/input0 Nov 12 17:58:09.909280 kernel: ACPI: button: Power Button [PWRB] Nov 12 17:58:09.909288 kernel: ACPI: \_SB_.PCI0.GSI1: Enabled at IRQ 36 Nov 12 17:58:09.909367 kernel: virtio-pci 0000:00:01.0: enabling device (0005 -> 0007) Nov 12 17:58:09.909378 kernel: Serial: 8250/16550 driver, 4 ports, IRQ sharing enabled Nov 12 17:58:09.909385 kernel: thunder_xcv, ver 1.0 Nov 12 17:58:09.909392 kernel: thunder_bgx, ver 1.0 Nov 12 17:58:09.909401 kernel: nicpf, ver 1.0 Nov 12 17:58:09.909409 kernel: nicvf, ver 1.0 Nov 12 17:58:09.909485 kernel: rtc-efi rtc-efi.0: registered as rtc0 Nov 12 17:58:09.909548 kernel: rtc-efi rtc-efi.0: setting system clock to 2024-11-12T17:58:09 UTC (1731434289) Nov 12 17:58:09.909558 kernel: hid: raw HID events driver (C) Jiri Kosina Nov 12 17:58:09.909565 kernel: hw perfevents: enabled with armv8_pmuv3_0 PMU driver, 7 counters available Nov 12 17:58:09.909572 kernel: watchdog: Delayed init of the lockup detector failed: -19 Nov 12 17:58:09.909580 kernel: watchdog: Hard watchdog permanently disabled Nov 12 17:58:09.909596 kernel: NET: Registered PF_INET6 protocol family Nov 12 17:58:09.909604 kernel: Segment Routing with IPv6 Nov 12 17:58:09.909611 kernel: In-situ OAM (IOAM) with IPv6 Nov 12 17:58:09.909619 kernel: NET: Registered PF_PACKET protocol family Nov 12 17:58:09.909626 kernel: Key type dns_resolver registered Nov 12 17:58:09.909633 kernel: registered taskstats version 1 Nov 12 17:58:09.909640 kernel: Loading compiled-in X.509 certificates Nov 12 17:58:09.909648 kernel: Loaded X.509 cert 'Kinvolk GmbH: Module signing key for 6.6.60-flatcar: 277bea35d8d47c9841f307ab609d4271c3622dcb' Nov 12 17:58:09.909655 kernel: Key type .fscrypt registered Nov 12 17:58:09.909663 kernel: Key type fscrypt-provisioning registered Nov 12 17:58:09.909671 kernel: ima: No TPM chip found, activating TPM-bypass! Nov 12 17:58:09.909678 kernel: ima: Allocated hash algorithm: sha1 Nov 12 17:58:09.909686 kernel: ima: No architecture policies found Nov 12 17:58:09.909693 kernel: alg: No test for fips(ansi_cprng) (fips_ansi_cprng) Nov 12 17:58:09.909700 kernel: clk: Disabling unused clocks Nov 12 17:58:09.909707 kernel: Freeing unused kernel memory: 39360K Nov 12 17:58:09.909714 kernel: Run /init as init process Nov 12 17:58:09.909722 kernel: with arguments: Nov 12 17:58:09.909730 kernel: /init Nov 12 17:58:09.909737 kernel: with environment: Nov 12 17:58:09.909744 kernel: HOME=/ Nov 12 17:58:09.909751 kernel: TERM=linux Nov 12 17:58:09.909758 kernel: BOOT_IMAGE=/flatcar/vmlinuz-a Nov 12 17:58:09.909767 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) Nov 12 17:58:09.909777 systemd[1]: Detected virtualization kvm. Nov 12 17:58:09.909785 systemd[1]: Detected architecture arm64. Nov 12 17:58:09.909793 systemd[1]: Running in initrd. Nov 12 17:58:09.909801 systemd[1]: No hostname configured, using default hostname. Nov 12 17:58:09.909809 systemd[1]: Hostname set to . Nov 12 17:58:09.909817 systemd[1]: Initializing machine ID from VM UUID. Nov 12 17:58:09.909824 systemd[1]: Queued start job for default target initrd.target. Nov 12 17:58:09.909832 systemd[1]: Started clevis-luks-askpass.path - Forward Password Requests to Clevis Directory Watch. Nov 12 17:58:09.909840 systemd[1]: Started systemd-ask-password-console.path - Dispatch Password Requests to Console Directory Watch. Nov 12 17:58:09.909848 systemd[1]: Expecting device dev-disk-by\x2dlabel-EFI\x2dSYSTEM.device - /dev/disk/by-label/EFI-SYSTEM... Nov 12 17:58:09.909857 systemd[1]: Expecting device dev-disk-by\x2dlabel-OEM.device - /dev/disk/by-label/OEM... Nov 12 17:58:09.909866 systemd[1]: Expecting device dev-disk-by\x2dlabel-ROOT.device - /dev/disk/by-label/ROOT... Nov 12 17:58:09.909874 systemd[1]: Expecting device dev-disk-by\x2dpartlabel-USR\x2dA.device - /dev/disk/by-partlabel/USR-A... Nov 12 17:58:09.909884 systemd[1]: Expecting device dev-disk-by\x2dpartuuid-7130c94a\x2d213a\x2d4e5a\x2d8e26\x2d6cce9662f132.device - /dev/disk/by-partuuid/7130c94a-213a-4e5a-8e26-6cce9662f132... Nov 12 17:58:09.909892 systemd[1]: Expecting device dev-mapper-usr.device - /dev/mapper/usr... Nov 12 17:58:09.909900 systemd[1]: Reached target cryptsetup-pre.target - Local Encrypted Volumes (Pre). Nov 12 17:58:09.909909 systemd[1]: Reached target cryptsetup.target - Local Encrypted Volumes. Nov 12 17:58:09.909917 systemd[1]: Reached target paths.target - Path Units. Nov 12 17:58:09.909925 systemd[1]: Reached target slices.target - Slice Units. Nov 12 17:58:09.909933 systemd[1]: Reached target swap.target - Swaps. Nov 12 17:58:09.909941 systemd[1]: Reached target timers.target - Timer Units. Nov 12 17:58:09.909949 systemd[1]: Listening on iscsid.socket - Open-iSCSI iscsid Socket. Nov 12 17:58:09.909957 systemd[1]: Listening on iscsiuio.socket - Open-iSCSI iscsiuio Socket. Nov 12 17:58:09.909965 systemd[1]: Listening on systemd-journald-dev-log.socket - Journal Socket (/dev/log). Nov 12 17:58:09.909973 systemd[1]: Listening on systemd-journald.socket - Journal Socket. Nov 12 17:58:09.909983 systemd[1]: Listening on systemd-networkd.socket - Network Service Netlink Socket. Nov 12 17:58:09.909991 systemd[1]: Listening on systemd-udevd-control.socket - udev Control Socket. Nov 12 17:58:09.909999 systemd[1]: Listening on systemd-udevd-kernel.socket - udev Kernel Socket. Nov 12 17:58:09.910010 systemd[1]: Reached target sockets.target - Socket Units. Nov 12 17:58:09.910018 systemd[1]: Starting ignition-setup-pre.service - Ignition env setup... Nov 12 17:58:09.910026 systemd[1]: Starting kmod-static-nodes.service - Create List of Static Device Nodes... Nov 12 17:58:09.910033 systemd[1]: Finished network-cleanup.service - Network Cleanup. Nov 12 17:58:09.910041 systemd[1]: Starting systemd-fsck-usr.service... Nov 12 17:58:09.910049 systemd[1]: Starting systemd-journald.service - Journal Service... Nov 12 17:58:09.910058 systemd[1]: Starting systemd-modules-load.service - Load Kernel Modules... Nov 12 17:58:09.910066 systemd[1]: Starting systemd-vconsole-setup.service - Virtual Console Setup... Nov 12 17:58:09.910073 systemd[1]: Finished ignition-setup-pre.service - Ignition env setup. Nov 12 17:58:09.910081 systemd[1]: Finished kmod-static-nodes.service - Create List of Static Device Nodes. Nov 12 17:58:09.910089 systemd[1]: Finished systemd-fsck-usr.service. Nov 12 17:58:09.910098 systemd[1]: Starting systemd-tmpfiles-setup-dev-early.service - Create Static Device Nodes in /dev gracefully... Nov 12 17:58:09.910106 systemd[1]: Finished systemd-vconsole-setup.service - Virtual Console Setup. Nov 12 17:58:09.910130 systemd-journald[239]: Collecting audit messages is disabled. Nov 12 17:58:09.910150 systemd[1]: Starting dracut-cmdline-ask.service - dracut ask for additional cmdline parameters... Nov 12 17:58:09.910158 systemd[1]: Finished systemd-tmpfiles-setup-dev-early.service - Create Static Device Nodes in /dev gracefully. Nov 12 17:58:09.910166 systemd[1]: Starting systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev... Nov 12 17:58:09.910175 systemd-journald[239]: Journal started Nov 12 17:58:09.910193 systemd-journald[239]: Runtime Journal (/run/log/journal/428dc414e6b54f21afd58703fdd557ca) is 5.9M, max 47.3M, 41.4M free. Nov 12 17:58:09.895948 systemd-modules-load[240]: Inserted module 'overlay' Nov 12 17:58:09.913385 systemd[1]: Started systemd-journald.service - Journal Service. Nov 12 17:58:09.913410 kernel: bridge: filtering via arp/ip/ip6tables is no longer available by default. Update your scripts to load br_netfilter if you need this. Nov 12 17:58:09.915649 kernel: Bridge firewalling registered Nov 12 17:58:09.916208 systemd-modules-load[240]: Inserted module 'br_netfilter' Nov 12 17:58:09.917058 systemd[1]: Starting systemd-tmpfiles-setup.service - Create System Files and Directories... Nov 12 17:58:09.919169 systemd[1]: Finished systemd-modules-load.service - Load Kernel Modules. Nov 12 17:58:09.922723 systemd[1]: Starting systemd-sysctl.service - Apply Kernel Variables... Nov 12 17:58:09.923570 systemd[1]: Finished systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev. Nov 12 17:58:09.925734 systemd[1]: Finished systemd-tmpfiles-setup.service - Create System Files and Directories. Nov 12 17:58:09.928131 systemd[1]: Finished dracut-cmdline-ask.service - dracut ask for additional cmdline parameters. Nov 12 17:58:09.929826 systemd[1]: Starting dracut-cmdline.service - dracut cmdline hook... Nov 12 17:58:09.935404 systemd[1]: Finished systemd-sysctl.service - Apply Kernel Variables. Nov 12 17:58:09.937303 systemd[1]: Starting systemd-resolved.service - Network Name Resolution... Nov 12 17:58:09.943228 dracut-cmdline[273]: dracut-dracut-053 Nov 12 17:58:09.947630 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=8c276c03cfeb31103ba0b5f1af613bdc698463ad3d29e6750e34154929bf187e Nov 12 17:58:09.964303 systemd-resolved[278]: Positive Trust Anchors: Nov 12 17:58:09.964322 systemd-resolved[278]: . IN DS 20326 8 2 e06d44b80b8f1d39a95c0b0d7c65d08458e880409bbc683457104237c7f8ec8d Nov 12 17:58:09.964355 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 Nov 12 17:58:09.969106 systemd-resolved[278]: Defaulting to hostname 'linux'. Nov 12 17:58:09.972269 systemd[1]: Started systemd-resolved.service - Network Name Resolution. Nov 12 17:58:09.973384 systemd[1]: Reached target nss-lookup.target - Host and Network Name Lookups. Nov 12 17:58:10.011385 kernel: SCSI subsystem initialized Nov 12 17:58:10.016377 kernel: Loading iSCSI transport class v2.0-870. Nov 12 17:58:10.023398 kernel: iscsi: registered transport (tcp) Nov 12 17:58:10.035547 kernel: iscsi: registered transport (qla4xxx) Nov 12 17:58:10.035581 kernel: QLogic iSCSI HBA Driver Nov 12 17:58:10.077520 systemd[1]: Finished dracut-cmdline.service - dracut cmdline hook. Nov 12 17:58:10.089504 systemd[1]: Starting dracut-pre-udev.service - dracut pre-udev hook... Nov 12 17:58:10.106603 kernel: device-mapper: core: CONFIG_IMA_DISABLE_HTABLE is disabled. Duplicate IMA measurements will not be recorded in the IMA log. Nov 12 17:58:10.106676 kernel: device-mapper: uevent: version 1.0.3 Nov 12 17:58:10.106726 kernel: device-mapper: ioctl: 4.48.0-ioctl (2023-03-01) initialised: dm-devel@redhat.com Nov 12 17:58:10.153402 kernel: raid6: neonx8 gen() 15708 MB/s Nov 12 17:58:10.170381 kernel: raid6: neonx4 gen() 15571 MB/s Nov 12 17:58:10.187377 kernel: raid6: neonx2 gen() 13198 MB/s Nov 12 17:58:10.204383 kernel: raid6: neonx1 gen() 10444 MB/s Nov 12 17:58:10.221386 kernel: raid6: int64x8 gen() 6921 MB/s Nov 12 17:58:10.238383 kernel: raid6: int64x4 gen() 7319 MB/s Nov 12 17:58:10.255381 kernel: raid6: int64x2 gen() 6120 MB/s Nov 12 17:58:10.272383 kernel: raid6: int64x1 gen() 5034 MB/s Nov 12 17:58:10.272409 kernel: raid6: using algorithm neonx8 gen() 15708 MB/s Nov 12 17:58:10.289390 kernel: raid6: .... xor() 11860 MB/s, rmw enabled Nov 12 17:58:10.289416 kernel: raid6: using neon recovery algorithm Nov 12 17:58:10.294384 kernel: xor: measuring software checksum speed Nov 12 17:58:10.294411 kernel: 8regs : 19759 MB/sec Nov 12 17:58:10.295812 kernel: 32regs : 17738 MB/sec Nov 12 17:58:10.295828 kernel: arm64_neon : 26407 MB/sec Nov 12 17:58:10.295841 kernel: xor: using function: arm64_neon (26407 MB/sec) Nov 12 17:58:10.347393 kernel: Btrfs loaded, zoned=no, fsverity=no Nov 12 17:58:10.358745 systemd[1]: Finished dracut-pre-udev.service - dracut pre-udev hook. Nov 12 17:58:10.370573 systemd[1]: Starting systemd-udevd.service - Rule-based Manager for Device Events and Files... Nov 12 17:58:10.381342 systemd-udevd[458]: Using default interface naming scheme 'v255'. Nov 12 17:58:10.384427 systemd[1]: Started systemd-udevd.service - Rule-based Manager for Device Events and Files. Nov 12 17:58:10.386512 systemd[1]: Starting dracut-pre-trigger.service - dracut pre-trigger hook... Nov 12 17:58:10.401492 dracut-pre-trigger[463]: rd.md=0: removing MD RAID activation Nov 12 17:58:10.428651 systemd[1]: Finished dracut-pre-trigger.service - dracut pre-trigger hook. Nov 12 17:58:10.442607 systemd[1]: Starting systemd-udev-trigger.service - Coldplug All udev Devices... Nov 12 17:58:10.483224 systemd[1]: Finished systemd-udev-trigger.service - Coldplug All udev Devices. Nov 12 17:58:10.494531 systemd[1]: Starting dracut-initqueue.service - dracut initqueue hook... Nov 12 17:58:10.506212 systemd[1]: Finished dracut-initqueue.service - dracut initqueue hook. Nov 12 17:58:10.507924 systemd[1]: Reached target remote-fs-pre.target - Preparation for Remote File Systems. Nov 12 17:58:10.509647 systemd[1]: Reached target remote-cryptsetup.target - Remote Encrypted Volumes. Nov 12 17:58:10.511050 systemd[1]: Reached target remote-fs.target - Remote File Systems. Nov 12 17:58:10.521680 systemd[1]: Starting dracut-pre-mount.service - dracut pre-mount hook... Nov 12 17:58:10.529854 kernel: virtio_blk virtio1: 1/0/0 default/read/poll queues Nov 12 17:58:10.533478 kernel: virtio_blk virtio1: [vda] 9289728 512-byte logical blocks (4.76 GB/4.43 GiB) Nov 12 17:58:10.533579 kernel: vda: vda1 vda2 vda3 vda4 vda6 vda7 vda9 Nov 12 17:58:10.531250 systemd[1]: Finished dracut-pre-mount.service - dracut pre-mount hook. Nov 12 17:58:10.543737 systemd[1]: dracut-cmdline-ask.service: Deactivated successfully. Nov 12 17:58:10.543852 systemd[1]: Stopped dracut-cmdline-ask.service - dracut ask for additional cmdline parameters. Nov 12 17:58:10.547988 systemd[1]: Stopping dracut-cmdline-ask.service - dracut ask for additional cmdline parameters... Nov 12 17:58:10.549097 systemd[1]: systemd-vconsole-setup.service: Deactivated successfully. Nov 12 17:58:10.549228 systemd[1]: Stopped systemd-vconsole-setup.service - Virtual Console Setup. Nov 12 17:58:10.551495 systemd[1]: Stopping systemd-vconsole-setup.service - Virtual Console Setup... Nov 12 17:58:10.560079 kernel: BTRFS: device fsid 93a9d474-e751-47b7-a65f-e39ca9abd47a devid 1 transid 40 /dev/vda3 scanned by (udev-worker) (516) Nov 12 17:58:10.560115 kernel: BTRFS: device label OEM devid 1 transid 12 /dev/vda6 scanned by (udev-worker) (513) Nov 12 17:58:10.559601 systemd[1]: Starting systemd-vconsole-setup.service - Virtual Console Setup... Nov 12 17:58:10.569437 systemd[1]: Found device dev-disk-by\x2dlabel-EFI\x2dSYSTEM.device - /dev/disk/by-label/EFI-SYSTEM. Nov 12 17:58:10.576495 systemd[1]: Finished systemd-vconsole-setup.service - Virtual Console Setup. Nov 12 17:58:10.582130 systemd[1]: Found device dev-disk-by\x2dlabel-ROOT.device - /dev/disk/by-label/ROOT. Nov 12 17:58:10.586423 systemd[1]: Found device dev-disk-by\x2dlabel-OEM.device - /dev/disk/by-label/OEM. Nov 12 17:58:10.590083 systemd[1]: Found device dev-disk-by\x2dpartuuid-7130c94a\x2d213a\x2d4e5a\x2d8e26\x2d6cce9662f132.device - /dev/disk/by-partuuid/7130c94a-213a-4e5a-8e26-6cce9662f132. Nov 12 17:58:10.590975 systemd[1]: Found device dev-disk-by\x2dpartlabel-USR\x2dA.device - /dev/disk/by-partlabel/USR-A. Nov 12 17:58:10.605602 systemd[1]: Starting disk-uuid.service - Generate new UUID for disk GPT if necessary... Nov 12 17:58:10.607533 systemd[1]: Starting dracut-cmdline-ask.service - dracut ask for additional cmdline parameters... Nov 12 17:58:10.619954 kernel: vda: vda1 vda2 vda3 vda4 vda6 vda7 vda9 Nov 12 17:58:10.624813 systemd[1]: Finished dracut-cmdline-ask.service - dracut ask for additional cmdline parameters. Nov 12 17:58:10.630376 kernel: vda: vda1 vda2 vda3 vda4 vda6 vda7 vda9 Nov 12 17:58:11.634396 kernel: vda: vda1 vda2 vda3 vda4 vda6 vda7 vda9 Nov 12 17:58:11.634971 disk-uuid[552]: The operation has completed successfully. Nov 12 17:58:11.654944 systemd[1]: disk-uuid.service: Deactivated successfully. Nov 12 17:58:11.655036 systemd[1]: Finished disk-uuid.service - Generate new UUID for disk GPT if necessary. Nov 12 17:58:11.675510 systemd[1]: Starting verity-setup.service - Verity Setup for /dev/mapper/usr... Nov 12 17:58:11.679968 sh[575]: Success Nov 12 17:58:11.693649 kernel: device-mapper: verity: sha256 using implementation "sha256-ce" Nov 12 17:58:11.730805 systemd[1]: Found device dev-mapper-usr.device - /dev/mapper/usr. Nov 12 17:58:11.732219 systemd[1]: Mounting sysusr-usr.mount - /sysusr/usr... Nov 12 17:58:11.733497 systemd[1]: Finished verity-setup.service - Verity Setup for /dev/mapper/usr. Nov 12 17:58:11.742871 kernel: BTRFS info (device dm-0): first mount of filesystem 93a9d474-e751-47b7-a65f-e39ca9abd47a Nov 12 17:58:11.742914 kernel: BTRFS info (device dm-0): using crc32c (crc32c-generic) checksum algorithm Nov 12 17:58:11.742925 kernel: BTRFS warning (device dm-0): 'nologreplay' is deprecated, use 'rescue=nologreplay' instead Nov 12 17:58:11.743637 kernel: BTRFS info (device dm-0): disabling log replay at mount time Nov 12 17:58:11.744645 kernel: BTRFS info (device dm-0): using free space tree Nov 12 17:58:11.748346 systemd[1]: Mounted sysusr-usr.mount - /sysusr/usr. Nov 12 17:58:11.749155 systemd[1]: afterburn-network-kargs.service - Afterburn Initrd Setup Network Kernel Arguments was skipped because no trigger condition checks were met. Nov 12 17:58:11.757499 systemd[1]: Starting ignition-setup.service - Ignition (setup)... Nov 12 17:58:11.758724 systemd[1]: Starting parse-ip-for-networkd.service - Write systemd-networkd units from cmdline... Nov 12 17:58:11.767762 kernel: BTRFS info (device vda6): first mount of filesystem 936a2172-6c61-4af6-a047-e38e0a3ff18b Nov 12 17:58:11.767801 kernel: BTRFS info (device vda6): using crc32c (crc32c-generic) checksum algorithm Nov 12 17:58:11.768375 kernel: BTRFS info (device vda6): using free space tree Nov 12 17:58:11.770378 kernel: BTRFS info (device vda6): auto enabling async discard Nov 12 17:58:11.776800 systemd[1]: mnt-oem.mount: Deactivated successfully. Nov 12 17:58:11.778377 kernel: BTRFS info (device vda6): last unmount of filesystem 936a2172-6c61-4af6-a047-e38e0a3ff18b Nov 12 17:58:11.784725 systemd[1]: Finished ignition-setup.service - Ignition (setup). Nov 12 17:58:11.790517 systemd[1]: Starting ignition-fetch-offline.service - Ignition (fetch-offline)... Nov 12 17:58:11.865703 systemd[1]: Finished parse-ip-for-networkd.service - Write systemd-networkd units from cmdline. Nov 12 17:58:11.874522 systemd[1]: Starting systemd-networkd.service - Network Configuration... Nov 12 17:58:11.883661 ignition[671]: Ignition 2.19.0 Nov 12 17:58:11.883671 ignition[671]: Stage: fetch-offline Nov 12 17:58:11.883749 ignition[671]: no configs at "/usr/lib/ignition/base.d" Nov 12 17:58:11.883760 ignition[671]: no config dir at "/usr/lib/ignition/base.platform.d/qemu" Nov 12 17:58:11.883929 ignition[671]: parsed url from cmdline: "" Nov 12 17:58:11.883932 ignition[671]: no config URL provided Nov 12 17:58:11.883937 ignition[671]: reading system config file "/usr/lib/ignition/user.ign" Nov 12 17:58:11.883945 ignition[671]: no config at "/usr/lib/ignition/user.ign" Nov 12 17:58:11.883966 ignition[671]: op(1): [started] loading QEMU firmware config module Nov 12 17:58:11.883970 ignition[671]: op(1): executing: "modprobe" "qemu_fw_cfg" Nov 12 17:58:11.892636 systemd-networkd[766]: lo: Link UP Nov 12 17:58:11.892646 systemd-networkd[766]: lo: Gained carrier Nov 12 17:58:11.893316 systemd-networkd[766]: Enumeration completed Nov 12 17:58:11.893850 systemd-networkd[766]: eth0: found matching network '/usr/lib/systemd/network/zz-default.network', based on potentially unpredictable interface name. Nov 12 17:58:11.893853 systemd-networkd[766]: eth0: Configuring with /usr/lib/systemd/network/zz-default.network. Nov 12 17:58:11.894767 systemd-networkd[766]: eth0: Link UP Nov 12 17:58:11.898096 ignition[671]: op(1): [finished] loading QEMU firmware config module Nov 12 17:58:11.894770 systemd-networkd[766]: eth0: Gained carrier Nov 12 17:58:11.898116 ignition[671]: QEMU firmware config was not found. Ignoring... Nov 12 17:58:11.894777 systemd-networkd[766]: eth0: found matching network '/usr/lib/systemd/network/zz-default.network', based on potentially unpredictable interface name. Nov 12 17:58:11.895598 systemd[1]: Started systemd-networkd.service - Network Configuration. Nov 12 17:58:11.898190 systemd[1]: Reached target network.target - Network. Nov 12 17:58:11.906759 ignition[671]: parsing config with SHA512: d66aaa572c74ecd055f8bbaaa2124a18feda273d7129ef53c21702769cf2811376aca79efb80f047e6bc7da8d2e7c4811cbe66f2658675f492295c2d1218c8ef Nov 12 17:58:11.910544 unknown[671]: fetched base config from "system" Nov 12 17:58:11.910818 ignition[671]: fetch-offline: fetch-offline passed Nov 12 17:58:11.910554 unknown[671]: fetched user config from "qemu" Nov 12 17:58:11.911238 ignition[671]: Ignition finished successfully Nov 12 17:58:11.913795 systemd[1]: Finished ignition-fetch-offline.service - Ignition (fetch-offline). Nov 12 17:58:11.914819 systemd[1]: ignition-fetch.service - Ignition (fetch) was skipped because of an unmet condition check (ConditionPathExists=!/run/ignition.json). Nov 12 17:58:11.917428 systemd-networkd[766]: eth0: DHCPv4 address 10.0.0.114/16, gateway 10.0.0.1 acquired from 10.0.0.1 Nov 12 17:58:11.928622 systemd[1]: Starting ignition-kargs.service - Ignition (kargs)... Nov 12 17:58:11.939388 ignition[771]: Ignition 2.19.0 Nov 12 17:58:11.939399 ignition[771]: Stage: kargs Nov 12 17:58:11.939585 ignition[771]: no configs at "/usr/lib/ignition/base.d" Nov 12 17:58:11.939598 ignition[771]: no config dir at "/usr/lib/ignition/base.platform.d/qemu" Nov 12 17:58:11.940219 ignition[771]: kargs: kargs passed Nov 12 17:58:11.943053 systemd[1]: Finished ignition-kargs.service - Ignition (kargs). Nov 12 17:58:11.940261 ignition[771]: Ignition finished successfully Nov 12 17:58:11.945278 systemd[1]: Starting ignition-disks.service - Ignition (disks)... Nov 12 17:58:11.959802 ignition[780]: Ignition 2.19.0 Nov 12 17:58:11.959812 ignition[780]: Stage: disks Nov 12 17:58:11.959976 ignition[780]: no configs at "/usr/lib/ignition/base.d" Nov 12 17:58:11.959985 ignition[780]: no config dir at "/usr/lib/ignition/base.platform.d/qemu" Nov 12 17:58:11.960629 ignition[780]: disks: disks passed Nov 12 17:58:11.962529 systemd[1]: Finished ignition-disks.service - Ignition (disks). Nov 12 17:58:11.960673 ignition[780]: Ignition finished successfully Nov 12 17:58:11.963990 systemd[1]: Reached target initrd-root-device.target - Initrd Root Device. Nov 12 17:58:11.965063 systemd[1]: Reached target local-fs-pre.target - Preparation for Local File Systems. Nov 12 17:58:11.966507 systemd[1]: Reached target local-fs.target - Local File Systems. Nov 12 17:58:11.967631 systemd[1]: Reached target sysinit.target - System Initialization. Nov 12 17:58:11.968986 systemd[1]: Reached target basic.target - Basic System. Nov 12 17:58:11.982558 systemd[1]: Starting systemd-fsck-root.service - File System Check on /dev/disk/by-label/ROOT... Nov 12 17:58:11.992699 systemd-fsck[790]: ROOT: clean, 14/553520 files, 52654/553472 blocks Nov 12 17:58:11.996548 systemd[1]: Finished systemd-fsck-root.service - File System Check on /dev/disk/by-label/ROOT. Nov 12 17:58:11.999067 systemd[1]: Mounting sysroot.mount - /sysroot... Nov 12 17:58:12.049372 kernel: EXT4-fs (vda9): mounted filesystem b3af0fd7-3c7c-4cdc-9b88-dae3d10ea922 r/w with ordered data mode. Quota mode: none. Nov 12 17:58:12.049677 systemd[1]: Mounted sysroot.mount - /sysroot. Nov 12 17:58:12.050776 systemd[1]: Reached target initrd-root-fs.target - Initrd Root File System. Nov 12 17:58:12.060436 systemd[1]: Mounting sysroot-oem.mount - /sysroot/oem... Nov 12 17:58:12.061884 systemd[1]: Mounting sysroot-usr.mount - /sysroot/usr... Nov 12 17:58:12.062995 systemd[1]: flatcar-metadata-hostname.service - Flatcar Metadata Hostname Agent was skipped because no trigger condition checks were met. Nov 12 17:58:12.063032 systemd[1]: ignition-remount-sysroot.service - Remount /sysroot read-write for Ignition was skipped because of an unmet condition check (ConditionPathIsReadWrite=!/sysroot). Nov 12 17:58:12.070355 kernel: BTRFS: device label OEM devid 1 transid 13 /dev/vda6 scanned by mount (798) Nov 12 17:58:12.070394 kernel: BTRFS info (device vda6): first mount of filesystem 936a2172-6c61-4af6-a047-e38e0a3ff18b Nov 12 17:58:12.070405 kernel: BTRFS info (device vda6): using crc32c (crc32c-generic) checksum algorithm Nov 12 17:58:12.063053 systemd[1]: Reached target ignition-diskful.target - Ignition Boot Disk Setup. Nov 12 17:58:12.073145 kernel: BTRFS info (device vda6): using free space tree Nov 12 17:58:12.073168 kernel: BTRFS info (device vda6): auto enabling async discard Nov 12 17:58:12.071945 systemd[1]: Mounted sysroot-usr.mount - /sysroot/usr. Nov 12 17:58:12.074905 systemd[1]: Mounted sysroot-oem.mount - /sysroot/oem. Nov 12 17:58:12.078354 systemd[1]: Starting initrd-setup-root.service - Root filesystem setup... Nov 12 17:58:12.117134 initrd-setup-root[822]: cut: /sysroot/etc/passwd: No such file or directory Nov 12 17:58:12.121523 initrd-setup-root[829]: cut: /sysroot/etc/group: No such file or directory Nov 12 17:58:12.125282 initrd-setup-root[836]: cut: /sysroot/etc/shadow: No such file or directory Nov 12 17:58:12.128963 initrd-setup-root[843]: cut: /sysroot/etc/gshadow: No such file or directory Nov 12 17:58:12.202390 systemd[1]: Finished initrd-setup-root.service - Root filesystem setup. Nov 12 17:58:12.209497 systemd[1]: Starting ignition-mount.service - Ignition (mount)... Nov 12 17:58:12.210818 systemd[1]: Starting sysroot-boot.service - /sysroot/boot... Nov 12 17:58:12.218433 kernel: BTRFS info (device vda6): last unmount of filesystem 936a2172-6c61-4af6-a047-e38e0a3ff18b Nov 12 17:58:12.237080 systemd[1]: Finished sysroot-boot.service - /sysroot/boot. Nov 12 17:58:12.241790 ignition[911]: INFO : Ignition 2.19.0 Nov 12 17:58:12.241790 ignition[911]: INFO : Stage: mount Nov 12 17:58:12.243858 ignition[911]: INFO : no configs at "/usr/lib/ignition/base.d" Nov 12 17:58:12.243858 ignition[911]: INFO : no config dir at "/usr/lib/ignition/base.platform.d/qemu" Nov 12 17:58:12.243858 ignition[911]: INFO : mount: mount passed Nov 12 17:58:12.243858 ignition[911]: INFO : Ignition finished successfully Nov 12 17:58:12.244217 systemd[1]: Finished ignition-mount.service - Ignition (mount). Nov 12 17:58:12.257137 systemd[1]: Starting ignition-files.service - Ignition (files)... Nov 12 17:58:12.742001 systemd[1]: sysroot-oem.mount: Deactivated successfully. Nov 12 17:58:12.756539 systemd[1]: Mounting sysroot-oem.mount - /sysroot/oem... Nov 12 17:58:12.763387 kernel: BTRFS: device label OEM devid 1 transid 14 /dev/vda6 scanned by mount (924) Nov 12 17:58:12.765399 kernel: BTRFS info (device vda6): first mount of filesystem 936a2172-6c61-4af6-a047-e38e0a3ff18b Nov 12 17:58:12.765416 kernel: BTRFS info (device vda6): using crc32c (crc32c-generic) checksum algorithm Nov 12 17:58:12.765426 kernel: BTRFS info (device vda6): using free space tree Nov 12 17:58:12.769427 kernel: BTRFS info (device vda6): auto enabling async discard Nov 12 17:58:12.770309 systemd[1]: Mounted sysroot-oem.mount - /sysroot/oem. Nov 12 17:58:12.790069 ignition[941]: INFO : Ignition 2.19.0 Nov 12 17:58:12.790069 ignition[941]: INFO : Stage: files Nov 12 17:58:12.791363 ignition[941]: INFO : no configs at "/usr/lib/ignition/base.d" Nov 12 17:58:12.791363 ignition[941]: INFO : no config dir at "/usr/lib/ignition/base.platform.d/qemu" Nov 12 17:58:12.791363 ignition[941]: DEBUG : files: compiled without relabeling support, skipping Nov 12 17:58:12.794251 ignition[941]: INFO : files: ensureUsers: op(1): [started] creating or modifying user "core" Nov 12 17:58:12.794251 ignition[941]: DEBUG : files: ensureUsers: op(1): executing: "usermod" "--root" "/sysroot" "core" Nov 12 17:58:12.797637 ignition[941]: INFO : files: ensureUsers: op(1): [finished] creating or modifying user "core" Nov 12 17:58:12.798669 ignition[941]: INFO : files: ensureUsers: op(2): [started] adding ssh keys to user "core" Nov 12 17:58:12.798669 ignition[941]: INFO : files: ensureUsers: op(2): [finished] adding ssh keys to user "core" Nov 12 17:58:12.798151 unknown[941]: wrote ssh authorized keys file for user: core Nov 12 17:58:12.801962 ignition[941]: INFO : files: createFilesystemsFiles: createFiles: op(3): [started] writing file "/sysroot/etc/flatcar/update.conf" Nov 12 17:58:12.801962 ignition[941]: INFO : files: createFilesystemsFiles: createFiles: op(3): [finished] writing file "/sysroot/etc/flatcar/update.conf" Nov 12 17:58:12.801962 ignition[941]: INFO : files: createFilesystemsFiles: createFiles: op(4): [started] writing link "/sysroot/etc/extensions/docker-flatcar.raw" -> "/dev/null" Nov 12 17:58:12.801962 ignition[941]: INFO : files: createFilesystemsFiles: createFiles: op(4): [finished] writing link "/sysroot/etc/extensions/docker-flatcar.raw" -> "/dev/null" Nov 12 17:58:12.801962 ignition[941]: INFO : files: createFilesystemsFiles: createFiles: op(5): [started] writing link "/sysroot/etc/extensions/containerd-flatcar.raw" -> "/dev/null" Nov 12 17:58:12.801962 ignition[941]: INFO : files: createFilesystemsFiles: createFiles: op(5): [finished] writing link "/sysroot/etc/extensions/containerd-flatcar.raw" -> "/dev/null" Nov 12 17:58:12.801962 ignition[941]: INFO : files: op(6): [started] processing unit "coreos-metadata.service" Nov 12 17:58:12.801962 ignition[941]: INFO : files: op(6): op(7): [started] writing unit "coreos-metadata.service" at "/sysroot/etc/systemd/system/coreos-metadata.service" Nov 12 17:58:12.801962 ignition[941]: INFO : files: op(6): op(7): [finished] writing unit "coreos-metadata.service" at "/sysroot/etc/systemd/system/coreos-metadata.service" Nov 12 17:58:12.801962 ignition[941]: INFO : files: op(6): [finished] processing unit "coreos-metadata.service" Nov 12 17:58:12.801962 ignition[941]: INFO : files: op(8): [started] setting preset to disabled for "coreos-metadata.service" Nov 12 17:58:12.844489 ignition[941]: INFO : files: op(8): op(9): [started] removing enablement symlink(s) for "coreos-metadata.service" Nov 12 17:58:12.849120 ignition[941]: INFO : files: op(8): op(9): [finished] removing enablement symlink(s) for "coreos-metadata.service" Nov 12 17:58:12.850249 ignition[941]: INFO : files: op(8): [finished] setting preset to disabled for "coreos-metadata.service" Nov 12 17:58:12.850249 ignition[941]: INFO : files: createResultFile: createFiles: op(a): [started] writing file "/sysroot/etc/.ignition-result.json" Nov 12 17:58:12.850249 ignition[941]: INFO : files: createResultFile: createFiles: op(a): [finished] writing file "/sysroot/etc/.ignition-result.json" Nov 12 17:58:12.850249 ignition[941]: INFO : files: files passed Nov 12 17:58:12.850249 ignition[941]: INFO : Ignition finished successfully Nov 12 17:58:12.853932 systemd[1]: Finished ignition-files.service - Ignition (files). Nov 12 17:58:12.864634 systemd[1]: Starting ignition-quench.service - Ignition (record completion)... Nov 12 17:58:12.866383 systemd[1]: Starting initrd-setup-root-after-ignition.service - Root filesystem completion... Nov 12 17:58:12.868980 systemd[1]: ignition-quench.service: Deactivated successfully. Nov 12 17:58:12.869074 systemd[1]: Finished ignition-quench.service - Ignition (record completion). Nov 12 17:58:12.873966 initrd-setup-root-after-ignition[969]: grep: /sysroot/oem/oem-release: No such file or directory Nov 12 17:58:12.876935 initrd-setup-root-after-ignition[971]: grep: /sysroot/etc/flatcar/enabled-sysext.conf: No such file or directory Nov 12 17:58:12.876935 initrd-setup-root-after-ignition[971]: grep: /sysroot/usr/share/flatcar/enabled-sysext.conf: No such file or directory Nov 12 17:58:12.879769 initrd-setup-root-after-ignition[975]: grep: /sysroot/etc/flatcar/enabled-sysext.conf: No such file or directory Nov 12 17:58:12.881195 systemd[1]: Finished initrd-setup-root-after-ignition.service - Root filesystem completion. Nov 12 17:58:12.882586 systemd[1]: Reached target ignition-complete.target - Ignition Complete. Nov 12 17:58:12.892513 systemd[1]: Starting initrd-parse-etc.service - Mountpoints Configured in the Real Root... Nov 12 17:58:12.911266 systemd[1]: initrd-parse-etc.service: Deactivated successfully. Nov 12 17:58:12.911386 systemd[1]: Finished initrd-parse-etc.service - Mountpoints Configured in the Real Root. Nov 12 17:58:12.912969 systemd[1]: Reached target initrd-fs.target - Initrd File Systems. Nov 12 17:58:12.914322 systemd[1]: Reached target initrd.target - Initrd Default Target. Nov 12 17:58:12.915670 systemd[1]: dracut-mount.service - dracut mount hook was skipped because no trigger condition checks were met. Nov 12 17:58:12.918111 systemd[1]: Starting dracut-pre-pivot.service - dracut pre-pivot and cleanup hook... Nov 12 17:58:12.932659 systemd[1]: Finished dracut-pre-pivot.service - dracut pre-pivot and cleanup hook. Nov 12 17:58:12.938509 systemd[1]: Starting initrd-cleanup.service - Cleaning Up and Shutting Down Daemons... Nov 12 17:58:12.946344 systemd[1]: Stopped target nss-lookup.target - Host and Network Name Lookups. Nov 12 17:58:12.948127 systemd[1]: Stopped target remote-cryptsetup.target - Remote Encrypted Volumes. Nov 12 17:58:12.949107 systemd[1]: Stopped target timers.target - Timer Units. Nov 12 17:58:12.950419 systemd[1]: dracut-pre-pivot.service: Deactivated successfully. Nov 12 17:58:12.950532 systemd[1]: Stopped dracut-pre-pivot.service - dracut pre-pivot and cleanup hook. Nov 12 17:58:12.952444 systemd[1]: Stopped target initrd.target - Initrd Default Target. Nov 12 17:58:12.953875 systemd[1]: Stopped target basic.target - Basic System. Nov 12 17:58:12.955028 systemd[1]: Stopped target ignition-complete.target - Ignition Complete. Nov 12 17:58:12.956263 systemd[1]: Stopped target ignition-diskful.target - Ignition Boot Disk Setup. Nov 12 17:58:12.957675 systemd[1]: Stopped target initrd-root-device.target - Initrd Root Device. Nov 12 17:58:12.959092 systemd[1]: Stopped target remote-fs.target - Remote File Systems. Nov 12 17:58:12.960429 systemd[1]: Stopped target remote-fs-pre.target - Preparation for Remote File Systems. Nov 12 17:58:12.962162 systemd[1]: Stopped target sysinit.target - System Initialization. Nov 12 17:58:12.963630 systemd[1]: Stopped target local-fs.target - Local File Systems. Nov 12 17:58:12.964880 systemd[1]: Stopped target swap.target - Swaps. Nov 12 17:58:12.965939 systemd[1]: dracut-pre-mount.service: Deactivated successfully. Nov 12 17:58:12.966057 systemd[1]: Stopped dracut-pre-mount.service - dracut pre-mount hook. Nov 12 17:58:12.967847 systemd[1]: Stopped target cryptsetup.target - Local Encrypted Volumes. Nov 12 17:58:12.969213 systemd[1]: Stopped target cryptsetup-pre.target - Local Encrypted Volumes (Pre). Nov 12 17:58:12.970644 systemd[1]: clevis-luks-askpass.path: Deactivated successfully. Nov 12 17:58:12.971346 systemd[1]: Stopped clevis-luks-askpass.path - Forward Password Requests to Clevis Directory Watch. Nov 12 17:58:12.972241 systemd[1]: dracut-initqueue.service: Deactivated successfully. Nov 12 17:58:12.972354 systemd[1]: Stopped dracut-initqueue.service - dracut initqueue hook. Nov 12 17:58:12.974355 systemd[1]: ignition-fetch-offline.service: Deactivated successfully. Nov 12 17:58:12.974545 systemd[1]: Stopped ignition-fetch-offline.service - Ignition (fetch-offline). Nov 12 17:58:12.975840 systemd[1]: Stopped target paths.target - Path Units. Nov 12 17:58:12.976996 systemd[1]: systemd-ask-password-console.path: Deactivated successfully. Nov 12 17:58:12.978949 systemd[1]: Stopped systemd-ask-password-console.path - Dispatch Password Requests to Console Directory Watch. Nov 12 17:58:12.979924 systemd[1]: Stopped target slices.target - Slice Units. Nov 12 17:58:12.981148 systemd[1]: Stopped target sockets.target - Socket Units. Nov 12 17:58:12.983021 systemd[1]: iscsid.socket: Deactivated successfully. Nov 12 17:58:12.983107 systemd[1]: Closed iscsid.socket - Open-iSCSI iscsid Socket. Nov 12 17:58:12.984239 systemd[1]: iscsiuio.socket: Deactivated successfully. Nov 12 17:58:12.984317 systemd[1]: Closed iscsiuio.socket - Open-iSCSI iscsiuio Socket. Nov 12 17:58:12.985450 systemd[1]: initrd-setup-root-after-ignition.service: Deactivated successfully. Nov 12 17:58:12.985552 systemd[1]: Stopped initrd-setup-root-after-ignition.service - Root filesystem completion. Nov 12 17:58:12.986789 systemd[1]: ignition-files.service: Deactivated successfully. Nov 12 17:58:12.986880 systemd[1]: Stopped ignition-files.service - Ignition (files). Nov 12 17:58:12.999621 systemd[1]: Stopping ignition-mount.service - Ignition (mount)... Nov 12 17:58:13.000279 systemd[1]: kmod-static-nodes.service: Deactivated successfully. Nov 12 17:58:13.000421 systemd[1]: Stopped kmod-static-nodes.service - Create List of Static Device Nodes. Nov 12 17:58:13.011668 systemd[1]: Stopping sysroot-boot.service - /sysroot/boot... Nov 12 17:58:13.012284 systemd[1]: systemd-udev-trigger.service: Deactivated successfully. Nov 12 17:58:13.012424 systemd[1]: Stopped systemd-udev-trigger.service - Coldplug All udev Devices. Nov 12 17:58:13.013732 systemd[1]: dracut-pre-trigger.service: Deactivated successfully. Nov 12 17:58:13.013823 systemd[1]: Stopped dracut-pre-trigger.service - dracut pre-trigger hook. Nov 12 17:58:13.020173 ignition[995]: INFO : Ignition 2.19.0 Nov 12 17:58:13.020173 ignition[995]: INFO : Stage: umount Nov 12 17:58:13.020173 ignition[995]: INFO : no configs at "/usr/lib/ignition/base.d" Nov 12 17:58:13.020173 ignition[995]: INFO : no config dir at "/usr/lib/ignition/base.platform.d/qemu" Nov 12 17:58:13.020136 systemd[1]: initrd-cleanup.service: Deactivated successfully. Nov 12 17:58:13.024242 ignition[995]: INFO : umount: umount passed Nov 12 17:58:13.024242 ignition[995]: INFO : Ignition finished successfully Nov 12 17:58:13.021617 systemd[1]: Finished initrd-cleanup.service - Cleaning Up and Shutting Down Daemons. Nov 12 17:58:13.025684 systemd[1]: ignition-mount.service: Deactivated successfully. Nov 12 17:58:13.025763 systemd[1]: Stopped ignition-mount.service - Ignition (mount). Nov 12 17:58:13.027582 systemd[1]: Stopped target network.target - Network. Nov 12 17:58:13.028587 systemd[1]: ignition-disks.service: Deactivated successfully. Nov 12 17:58:13.028648 systemd[1]: Stopped ignition-disks.service - Ignition (disks). Nov 12 17:58:13.029471 systemd[1]: ignition-kargs.service: Deactivated successfully. Nov 12 17:58:13.029508 systemd[1]: Stopped ignition-kargs.service - Ignition (kargs). Nov 12 17:58:13.030682 systemd[1]: ignition-setup.service: Deactivated successfully. Nov 12 17:58:13.030718 systemd[1]: Stopped ignition-setup.service - Ignition (setup). Nov 12 17:58:13.031784 systemd[1]: ignition-setup-pre.service: Deactivated successfully. Nov 12 17:58:13.031826 systemd[1]: Stopped ignition-setup-pre.service - Ignition env setup. Nov 12 17:58:13.033262 systemd[1]: Stopping systemd-networkd.service - Network Configuration... Nov 12 17:58:13.036621 systemd[1]: Stopping systemd-resolved.service - Network Name Resolution... Nov 12 17:58:13.038514 systemd[1]: sysroot-boot.mount: Deactivated successfully. Nov 12 17:58:13.040189 systemd[1]: sysroot-boot.service: Deactivated successfully. Nov 12 17:58:13.040281 systemd[1]: Stopped sysroot-boot.service - /sysroot/boot. Nov 12 17:58:13.042223 systemd[1]: initrd-setup-root.service: Deactivated successfully. Nov 12 17:58:13.042261 systemd[1]: Stopped initrd-setup-root.service - Root filesystem setup. Nov 12 17:58:13.045635 systemd-networkd[766]: eth0: DHCPv6 lease lost Nov 12 17:58:13.048042 systemd[1]: systemd-networkd.service: Deactivated successfully. Nov 12 17:58:13.048147 systemd[1]: Stopped systemd-networkd.service - Network Configuration. Nov 12 17:58:13.049450 systemd[1]: systemd-networkd.socket: Deactivated successfully. Nov 12 17:58:13.049480 systemd[1]: Closed systemd-networkd.socket - Network Service Netlink Socket. Nov 12 17:58:13.059529 systemd[1]: Stopping network-cleanup.service - Network Cleanup... Nov 12 17:58:13.060164 systemd[1]: parse-ip-for-networkd.service: Deactivated successfully. Nov 12 17:58:13.060214 systemd[1]: Stopped parse-ip-for-networkd.service - Write systemd-networkd units from cmdline. Nov 12 17:58:13.061758 systemd[1]: Stopping systemd-udevd.service - Rule-based Manager for Device Events and Files... Nov 12 17:58:13.069149 systemd[1]: systemd-resolved.service: Deactivated successfully. Nov 12 17:58:13.069246 systemd[1]: Stopped systemd-resolved.service - Network Name Resolution. Nov 12 17:58:13.074256 systemd[1]: systemd-sysctl.service: Deactivated successfully. Nov 12 17:58:13.074338 systemd[1]: Stopped systemd-sysctl.service - Apply Kernel Variables. Nov 12 17:58:13.075710 systemd[1]: systemd-modules-load.service: Deactivated successfully. Nov 12 17:58:13.075752 systemd[1]: Stopped systemd-modules-load.service - Load Kernel Modules. Nov 12 17:58:13.077111 systemd[1]: systemd-tmpfiles-setup.service: Deactivated successfully. Nov 12 17:58:13.077149 systemd[1]: Stopped systemd-tmpfiles-setup.service - Create System Files and Directories. Nov 12 17:58:13.080761 systemd[1]: network-cleanup.service: Deactivated successfully. Nov 12 17:58:13.080847 systemd[1]: Stopped network-cleanup.service - Network Cleanup. Nov 12 17:58:13.084929 systemd[1]: systemd-udevd.service: Deactivated successfully. Nov 12 17:58:13.085064 systemd[1]: Stopped systemd-udevd.service - Rule-based Manager for Device Events and Files. Nov 12 17:58:13.086664 systemd[1]: systemd-udevd-control.socket: Deactivated successfully. Nov 12 17:58:13.086700 systemd[1]: Closed systemd-udevd-control.socket - udev Control Socket. Nov 12 17:58:13.088082 systemd[1]: systemd-udevd-kernel.socket: Deactivated successfully. Nov 12 17:58:13.088109 systemd[1]: Closed systemd-udevd-kernel.socket - udev Kernel Socket. Nov 12 17:58:13.089342 systemd[1]: dracut-pre-udev.service: Deactivated successfully. Nov 12 17:58:13.089414 systemd[1]: Stopped dracut-pre-udev.service - dracut pre-udev hook. Nov 12 17:58:13.091330 systemd[1]: dracut-cmdline.service: Deactivated successfully. Nov 12 17:58:13.091391 systemd[1]: Stopped dracut-cmdline.service - dracut cmdline hook. Nov 12 17:58:13.093289 systemd[1]: dracut-cmdline-ask.service: Deactivated successfully. Nov 12 17:58:13.093331 systemd[1]: Stopped dracut-cmdline-ask.service - dracut ask for additional cmdline parameters. Nov 12 17:58:13.096303 systemd[1]: Starting initrd-udevadm-cleanup-db.service - Cleanup udev Database... Nov 12 17:58:13.097225 systemd[1]: systemd-tmpfiles-setup-dev.service: Deactivated successfully. Nov 12 17:58:13.097281 systemd[1]: Stopped systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev. Nov 12 17:58:13.098836 systemd[1]: systemd-vconsole-setup.service: Deactivated successfully. Nov 12 17:58:13.098877 systemd[1]: Stopped systemd-vconsole-setup.service - Virtual Console Setup. Nov 12 17:58:13.106254 systemd[1]: initrd-udevadm-cleanup-db.service: Deactivated successfully. Nov 12 17:58:13.106349 systemd[1]: Finished initrd-udevadm-cleanup-db.service - Cleanup udev Database. Nov 12 17:58:13.108121 systemd[1]: Reached target initrd-switch-root.target - Switch Root. Nov 12 17:58:13.110080 systemd[1]: Starting initrd-switch-root.service - Switch Root... Nov 12 17:58:13.119770 systemd[1]: Switching root. Nov 12 17:58:13.153347 systemd-journald[239]: Journal stopped Nov 12 17:58:13.824246 systemd-journald[239]: Received SIGTERM from PID 1 (systemd). Nov 12 17:58:13.824296 kernel: SELinux: policy capability network_peer_controls=1 Nov 12 17:58:13.824309 kernel: SELinux: policy capability open_perms=1 Nov 12 17:58:13.824322 kernel: SELinux: policy capability extended_socket_class=1 Nov 12 17:58:13.824332 kernel: SELinux: policy capability always_check_network=0 Nov 12 17:58:13.824345 kernel: SELinux: policy capability cgroup_seclabel=1 Nov 12 17:58:13.824354 kernel: SELinux: policy capability nnp_nosuid_transition=1 Nov 12 17:58:13.824390 kernel: SELinux: policy capability genfs_seclabel_symlinks=0 Nov 12 17:58:13.824401 kernel: SELinux: policy capability ioctl_skip_cloexec=0 Nov 12 17:58:13.824410 kernel: audit: type=1403 audit(1731434293.218:2): auid=4294967295 ses=4294967295 lsm=selinux res=1 Nov 12 17:58:13.824425 systemd[1]: Successfully loaded SELinux policy in 29.681ms. Nov 12 17:58:13.824445 systemd[1]: Relabeled /dev, /dev/shm, /run, /sys/fs/cgroup in 10.157ms. Nov 12 17:58:13.824457 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) Nov 12 17:58:13.824474 systemd[1]: Detected virtualization kvm. Nov 12 17:58:13.824484 systemd[1]: Detected architecture arm64. Nov 12 17:58:13.824494 systemd[1]: Detected first boot. Nov 12 17:58:13.824504 systemd[1]: Initializing machine ID from VM UUID. Nov 12 17:58:13.824515 zram_generator::config[1039]: No configuration found. Nov 12 17:58:13.824526 systemd[1]: Populated /etc with preset unit settings. Nov 12 17:58:13.824537 systemd[1]: initrd-switch-root.service: Deactivated successfully. Nov 12 17:58:13.824549 systemd[1]: Stopped initrd-switch-root.service - Switch Root. Nov 12 17:58:13.824559 systemd[1]: systemd-journald.service: Scheduled restart job, restart counter is at 1. Nov 12 17:58:13.824579 systemd[1]: Created slice system-addon\x2dconfig.slice - Slice /system/addon-config. Nov 12 17:58:13.824592 systemd[1]: Created slice system-addon\x2drun.slice - Slice /system/addon-run. Nov 12 17:58:13.824602 systemd[1]: Created slice system-getty.slice - Slice /system/getty. Nov 12 17:58:13.824612 systemd[1]: Created slice system-modprobe.slice - Slice /system/modprobe. Nov 12 17:58:13.824623 systemd[1]: Created slice system-serial\x2dgetty.slice - Slice /system/serial-getty. Nov 12 17:58:13.824633 systemd[1]: Created slice system-system\x2dcloudinit.slice - Slice /system/system-cloudinit. Nov 12 17:58:13.824646 systemd[1]: Created slice system-systemd\x2dfsck.slice - Slice /system/systemd-fsck. Nov 12 17:58:13.824658 systemd[1]: Created slice user.slice - User and Session Slice. Nov 12 17:58:13.824669 systemd[1]: Started clevis-luks-askpass.path - Forward Password Requests to Clevis Directory Watch. Nov 12 17:58:13.824679 systemd[1]: Started systemd-ask-password-console.path - Dispatch Password Requests to Console Directory Watch. Nov 12 17:58:13.824690 systemd[1]: Started systemd-ask-password-wall.path - Forward Password Requests to Wall Directory Watch. Nov 12 17:58:13.824700 systemd[1]: Set up automount boot.automount - Boot partition Automount Point. Nov 12 17:58:13.824714 systemd[1]: Set up automount proc-sys-fs-binfmt_misc.automount - Arbitrary Executable File Formats File System Automount Point. Nov 12 17:58:13.824725 systemd[1]: Expecting device dev-disk-by\x2dlabel-OEM.device - /dev/disk/by-label/OEM... Nov 12 17:58:13.824735 systemd[1]: Expecting device dev-ttyAMA0.device - /dev/ttyAMA0... Nov 12 17:58:13.824746 systemd[1]: Reached target cryptsetup-pre.target - Local Encrypted Volumes (Pre). Nov 12 17:58:13.824756 systemd[1]: Stopped target initrd-switch-root.target - Switch Root. Nov 12 17:58:13.824767 systemd[1]: Stopped target initrd-fs.target - Initrd File Systems. Nov 12 17:58:13.824777 systemd[1]: Stopped target initrd-root-fs.target - Initrd Root File System. Nov 12 17:58:13.824789 systemd[1]: Reached target integritysetup.target - Local Integrity Protected Volumes. Nov 12 17:58:13.824799 systemd[1]: Reached target remote-cryptsetup.target - Remote Encrypted Volumes. Nov 12 17:58:13.824811 systemd[1]: Reached target remote-fs.target - Remote File Systems. Nov 12 17:58:13.824822 systemd[1]: Reached target slices.target - Slice Units. Nov 12 17:58:13.824832 systemd[1]: Reached target swap.target - Swaps. Nov 12 17:58:13.824843 systemd[1]: Reached target veritysetup.target - Local Verity Protected Volumes. Nov 12 17:58:13.824853 systemd[1]: Listening on systemd-coredump.socket - Process Core Dump Socket. Nov 12 17:58:13.824864 systemd[1]: Listening on systemd-networkd.socket - Network Service Netlink Socket. Nov 12 17:58:13.824875 systemd[1]: Listening on systemd-udevd-control.socket - udev Control Socket. Nov 12 17:58:13.824886 systemd[1]: Listening on systemd-udevd-kernel.socket - udev Kernel Socket. Nov 12 17:58:13.824898 systemd[1]: Listening on systemd-userdbd.socket - User Database Manager Socket. Nov 12 17:58:13.824908 systemd[1]: Mounting dev-hugepages.mount - Huge Pages File System... Nov 12 17:58:13.824918 systemd[1]: Mounting dev-mqueue.mount - POSIX Message Queue File System... Nov 12 17:58:13.824929 systemd[1]: Mounting media.mount - External Media Directory... Nov 12 17:58:13.824940 systemd[1]: Mounting sys-kernel-debug.mount - Kernel Debug File System... Nov 12 17:58:13.824950 systemd[1]: Mounting sys-kernel-tracing.mount - Kernel Trace File System... Nov 12 17:58:13.824961 systemd[1]: Mounting tmp.mount - Temporary Directory /tmp... Nov 12 17:58:13.824971 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). Nov 12 17:58:13.824983 systemd[1]: Reached target machines.target - Containers. Nov 12 17:58:13.824994 systemd[1]: Starting flatcar-tmpfiles.service - Create missing system files... Nov 12 17:58:13.825004 systemd[1]: ignition-delete-config.service - Ignition (delete config) was skipped because no trigger condition checks were met. Nov 12 17:58:13.825015 systemd[1]: Starting kmod-static-nodes.service - Create List of Static Device Nodes... Nov 12 17:58:13.825025 systemd[1]: Starting modprobe@configfs.service - Load Kernel Module configfs... Nov 12 17:58:13.825036 systemd[1]: Starting modprobe@dm_mod.service - Load Kernel Module dm_mod... Nov 12 17:58:13.825046 systemd[1]: Starting modprobe@drm.service - Load Kernel Module drm... Nov 12 17:58:13.825056 systemd[1]: Starting modprobe@efi_pstore.service - Load Kernel Module efi_pstore... Nov 12 17:58:13.825067 systemd[1]: Starting modprobe@fuse.service - Load Kernel Module fuse... Nov 12 17:58:13.825079 systemd[1]: Starting modprobe@loop.service - Load Kernel Module loop... Nov 12 17:58:13.825090 systemd[1]: setup-nsswitch.service - Create /etc/nsswitch.conf was skipped because of an unmet condition check (ConditionPathExists=!/etc/nsswitch.conf). Nov 12 17:58:13.825100 systemd[1]: systemd-fsck-root.service: Deactivated successfully. Nov 12 17:58:13.825110 systemd[1]: Stopped systemd-fsck-root.service - File System Check on Root Device. Nov 12 17:58:13.825121 systemd[1]: systemd-fsck-usr.service: Deactivated successfully. Nov 12 17:58:13.825131 systemd[1]: Stopped systemd-fsck-usr.service. Nov 12 17:58:13.825141 kernel: fuse: init (API version 7.39) Nov 12 17:58:13.825150 kernel: loop: module loaded Nov 12 17:58:13.825163 systemd[1]: Starting systemd-journald.service - Journal Service... Nov 12 17:58:13.825173 systemd[1]: Starting systemd-modules-load.service - Load Kernel Modules... Nov 12 17:58:13.825184 systemd[1]: Starting systemd-network-generator.service - Generate network units from Kernel command line... Nov 12 17:58:13.825195 systemd[1]: Starting systemd-remount-fs.service - Remount Root and Kernel File Systems... Nov 12 17:58:13.825205 kernel: ACPI: bus type drm_connector registered Nov 12 17:58:13.825215 systemd[1]: Starting systemd-udev-trigger.service - Coldplug All udev Devices... Nov 12 17:58:13.825226 systemd[1]: verity-setup.service: Deactivated successfully. Nov 12 17:58:13.825236 systemd[1]: Stopped verity-setup.service. Nov 12 17:58:13.825247 systemd[1]: Mounted dev-hugepages.mount - Huge Pages File System. Nov 12 17:58:13.825257 systemd[1]: Mounted dev-mqueue.mount - POSIX Message Queue File System. Nov 12 17:58:13.825287 systemd-journald[1106]: Collecting audit messages is disabled. Nov 12 17:58:13.825310 systemd[1]: Mounted media.mount - External Media Directory. Nov 12 17:58:13.825321 systemd-journald[1106]: Journal started Nov 12 17:58:13.825345 systemd-journald[1106]: Runtime Journal (/run/log/journal/428dc414e6b54f21afd58703fdd557ca) is 5.9M, max 47.3M, 41.4M free. Nov 12 17:58:13.610233 systemd[1]: Queued start job for default target multi-user.target. Nov 12 17:58:13.644552 systemd[1]: Unnecessary job was removed for dev-vda6.device - /dev/vda6. Nov 12 17:58:13.644930 systemd[1]: systemd-journald.service: Deactivated successfully. Nov 12 17:58:13.827673 systemd[1]: Started systemd-journald.service - Journal Service. Nov 12 17:58:13.828243 systemd[1]: Mounted sys-kernel-debug.mount - Kernel Debug File System. Nov 12 17:58:13.829480 systemd[1]: Mounted sys-kernel-tracing.mount - Kernel Trace File System. Nov 12 17:58:13.830542 systemd[1]: Mounted tmp.mount - Temporary Directory /tmp. Nov 12 17:58:13.831706 systemd[1]: Finished flatcar-tmpfiles.service - Create missing system files. Nov 12 17:58:13.834394 systemd[1]: Finished kmod-static-nodes.service - Create List of Static Device Nodes. Nov 12 17:58:13.835847 systemd[1]: modprobe@configfs.service: Deactivated successfully. Nov 12 17:58:13.835986 systemd[1]: Finished modprobe@configfs.service - Load Kernel Module configfs. Nov 12 17:58:13.837343 systemd[1]: modprobe@dm_mod.service: Deactivated successfully. Nov 12 17:58:13.837491 systemd[1]: Finished modprobe@dm_mod.service - Load Kernel Module dm_mod. Nov 12 17:58:13.838852 systemd[1]: modprobe@drm.service: Deactivated successfully. Nov 12 17:58:13.838992 systemd[1]: Finished modprobe@drm.service - Load Kernel Module drm. Nov 12 17:58:13.840285 systemd[1]: modprobe@efi_pstore.service: Deactivated successfully. Nov 12 17:58:13.840585 systemd[1]: Finished modprobe@efi_pstore.service - Load Kernel Module efi_pstore. Nov 12 17:58:13.841962 systemd[1]: modprobe@fuse.service: Deactivated successfully. Nov 12 17:58:13.842096 systemd[1]: Finished modprobe@fuse.service - Load Kernel Module fuse. Nov 12 17:58:13.843451 systemd[1]: modprobe@loop.service: Deactivated successfully. Nov 12 17:58:13.843595 systemd[1]: Finished modprobe@loop.service - Load Kernel Module loop. Nov 12 17:58:13.845171 systemd[1]: Finished systemd-modules-load.service - Load Kernel Modules. Nov 12 17:58:13.847721 systemd[1]: Finished systemd-network-generator.service - Generate network units from Kernel command line. Nov 12 17:58:13.849176 systemd[1]: Finished systemd-remount-fs.service - Remount Root and Kernel File Systems. Nov 12 17:58:13.861604 systemd[1]: Reached target network-pre.target - Preparation for Network. Nov 12 17:58:13.868470 systemd[1]: Mounting sys-fs-fuse-connections.mount - FUSE Control File System... Nov 12 17:58:13.870208 systemd[1]: Mounting sys-kernel-config.mount - Kernel Configuration File System... Nov 12 17:58:13.871040 systemd[1]: remount-root.service - Remount Root File System was skipped because of an unmet condition check (ConditionPathIsReadWrite=!/). Nov 12 17:58:13.871076 systemd[1]: Reached target local-fs.target - Local File Systems. Nov 12 17:58:13.872713 systemd[1]: Listening on systemd-sysext.socket - System Extension Image Management (Varlink). Nov 12 17:58:13.874594 systemd[1]: Starting dracut-shutdown.service - Restore /run/initramfs on shutdown... Nov 12 17:58:13.876403 systemd[1]: Starting ldconfig.service - Rebuild Dynamic Linker Cache... Nov 12 17:58:13.877236 systemd[1]: systemd-binfmt.service - Set Up Additional Binary Formats was skipped because no trigger condition checks were met. Nov 12 17:58:13.878671 systemd[1]: Starting systemd-hwdb-update.service - Rebuild Hardware Database... Nov 12 17:58:13.880522 systemd[1]: Starting systemd-journal-flush.service - Flush Journal to Persistent Storage... Nov 12 17:58:13.881477 systemd[1]: systemd-pstore.service - Platform Persistent Storage Archival was skipped because of an unmet condition check (ConditionDirectoryNotEmpty=/sys/fs/pstore). Nov 12 17:58:13.883640 systemd[1]: Starting systemd-random-seed.service - Load/Save OS Random Seed... Nov 12 17:58:13.884827 systemd[1]: systemd-repart.service - Repartition Root Disk was skipped because no trigger condition checks were met. Nov 12 17:58:13.885922 systemd[1]: Starting systemd-sysctl.service - Apply Kernel Variables... Nov 12 17:58:13.888230 systemd-journald[1106]: Time spent on flushing to /var/log/journal/428dc414e6b54f21afd58703fdd557ca is 15.664ms for 826 entries. Nov 12 17:58:13.888230 systemd-journald[1106]: System Journal (/var/log/journal/428dc414e6b54f21afd58703fdd557ca) is 8.0M, max 195.6M, 187.6M free. Nov 12 17:58:13.938106 systemd-journald[1106]: Received client request to flush runtime journal. Nov 12 17:58:13.891183 systemd[1]: Starting systemd-sysext.service - Merge System Extension Images into /usr/ and /opt/... Nov 12 17:58:13.897557 systemd[1]: Starting systemd-sysusers.service - Create System Users... Nov 12 17:58:13.901416 systemd[1]: Finished systemd-udev-trigger.service - Coldplug All udev Devices. Nov 12 17:58:13.902605 systemd[1]: Mounted sys-fs-fuse-connections.mount - FUSE Control File System. Nov 12 17:58:13.903510 systemd[1]: Mounted sys-kernel-config.mount - Kernel Configuration File System. Nov 12 17:58:13.904616 (sd-merge)[1153]: No extensions found. Nov 12 17:58:13.904643 systemd[1]: Finished dracut-shutdown.service - Restore /run/initramfs on shutdown. Nov 12 17:58:13.910987 systemd[1]: Finished systemd-sysext.service - Merge System Extension Images into /usr/ and /opt/. Nov 12 17:58:13.924544 systemd[1]: Starting ensure-sysext.service... Nov 12 17:58:13.927653 systemd[1]: Starting systemd-udev-settle.service - Wait for udev To Complete Device Initialization... Nov 12 17:58:13.929714 systemd[1]: Finished systemd-random-seed.service - Load/Save OS Random Seed. Nov 12 17:58:13.931042 systemd[1]: Finished systemd-sysctl.service - Apply Kernel Variables. Nov 12 17:58:13.936255 systemd[1]: Reached target first-boot-complete.target - First Boot Complete. Nov 12 17:58:13.947732 systemd[1]: Starting systemd-machine-id-commit.service - Commit a transient machine-id on disk... Nov 12 17:58:13.949159 systemd[1]: Finished systemd-journal-flush.service - Flush Journal to Persistent Storage. Nov 12 17:58:13.952755 systemd[1]: Finished systemd-sysusers.service - Create System Users. Nov 12 17:58:13.954012 systemd[1]: Reloading requested from client PID 1159 ('systemctl') (unit ensure-sysext.service)... Nov 12 17:58:13.954024 systemd[1]: Reloading... Nov 12 17:58:14.004524 zram_generator::config[1195]: No configuration found. Nov 12 17:58:14.117642 systemd[1]: etc-machine\x2did.mount: Deactivated successfully. Nov 12 17:58:14.118020 systemd[1]: Reloading finished in 163 ms. Nov 12 17:58:14.141816 systemd[1]: Finished systemd-machine-id-commit.service - Commit a transient machine-id on disk. Nov 12 17:58:14.152797 udevadm[1162]: systemd-udev-settle.service is deprecated. Please fix lvm2-activation-early.service, lvm2-activation.service not to pull it in. Nov 12 17:58:14.152809 systemd[1]: ignition-delete-config.service - Ignition (delete config) was skipped because no trigger condition checks were met. Nov 12 17:58:14.153968 systemd[1]: Starting modprobe@dm_mod.service - Load Kernel Module dm_mod... Nov 12 17:58:14.157695 systemd[1]: Starting modprobe@efi_pstore.service - Load Kernel Module efi_pstore... Nov 12 17:58:14.161677 systemd[1]: Starting modprobe@loop.service - Load Kernel Module loop... Nov 12 17:58:14.163618 systemd[1]: systemd-binfmt.service - Set Up Additional Binary Formats was skipped because no trigger condition checks were met. Nov 12 17:58:14.164630 systemd[1]: Starting systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev... Nov 12 17:58:14.167652 systemd[1]: Starting systemd-tmpfiles-setup.service - Create System Files and Directories... Nov 12 17:58:14.169336 systemd[1]: modprobe@dm_mod.service: Deactivated successfully. Nov 12 17:58:14.169506 systemd[1]: Finished modprobe@dm_mod.service - Load Kernel Module dm_mod. Nov 12 17:58:14.170861 systemd[1]: modprobe@efi_pstore.service: Deactivated successfully. Nov 12 17:58:14.170983 systemd[1]: Finished modprobe@efi_pstore.service - Load Kernel Module efi_pstore. Nov 12 17:58:14.172328 systemd[1]: modprobe@loop.service: Deactivated successfully. Nov 12 17:58:14.172452 systemd[1]: Finished modprobe@loop.service - Load Kernel Module loop. Nov 12 17:58:14.177226 systemd[1]: ignition-delete-config.service - Ignition (delete config) was skipped because no trigger condition checks were met. Nov 12 17:58:14.182617 systemd[1]: Starting modprobe@dm_mod.service - Load Kernel Module dm_mod... Nov 12 17:58:14.185464 systemd[1]: Starting modprobe@efi_pstore.service - Load Kernel Module efi_pstore... Nov 12 17:58:14.189605 systemd[1]: Starting modprobe@loop.service - Load Kernel Module loop... Nov 12 17:58:14.190407 systemd[1]: systemd-binfmt.service - Set Up Additional Binary Formats was skipped because no trigger condition checks were met. Nov 12 17:58:14.191182 systemd[1]: modprobe@dm_mod.service: Deactivated successfully. Nov 12 17:58:14.191334 systemd[1]: Finished modprobe@dm_mod.service - Load Kernel Module dm_mod. Nov 12 17:58:14.195733 systemd[1]: ignition-delete-config.service - Ignition (delete config) was skipped because no trigger condition checks were met. Nov 12 17:58:14.200340 systemd-tmpfiles[1238]: ACLs are not supported, ignoring. Nov 12 17:58:14.200595 systemd-tmpfiles[1238]: ACLs are not supported, ignoring. Nov 12 17:58:14.201150 systemd[1]: Starting modprobe@dm_mod.service - Load Kernel Module dm_mod... Nov 12 17:58:14.204444 ldconfig[1145]: /sbin/ldconfig: /lib/ld.so.conf is not an ELF file - it has the wrong magic bytes at the start. Nov 12 17:58:14.205082 systemd-tmpfiles[1239]: /usr/lib/tmpfiles.d/provision.conf:20: Duplicate line for path "/root", ignoring. Nov 12 17:58:14.205265 systemd-tmpfiles[1239]: /usr/lib/tmpfiles.d/systemd-flatcar.conf:6: Duplicate line for path "/var/log/journal", ignoring. Nov 12 17:58:14.205857 systemd-tmpfiles[1239]: /usr/lib/tmpfiles.d/systemd.conf:29: Duplicate line for path "/var/lib/systemd", ignoring. Nov 12 17:58:14.206104 systemd-tmpfiles[1239]: ACLs are not supported, ignoring. Nov 12 17:58:14.206190 systemd-tmpfiles[1239]: ACLs are not supported, ignoring. Nov 12 17:58:14.207659 systemd[1]: Starting modprobe@drm.service - Load Kernel Module drm... Nov 12 17:58:14.208305 systemd-tmpfiles[1239]: Detected autofs mount point /boot during canonicalization of boot. Nov 12 17:58:14.208319 systemd-tmpfiles[1239]: Skipping /boot Nov 12 17:58:14.209639 systemd[1]: systemd-binfmt.service - Set Up Additional Binary Formats was skipped because no trigger condition checks were met. Nov 12 17:58:14.210481 systemd[1]: Finished ldconfig.service - Rebuild Dynamic Linker Cache. Nov 12 17:58:14.211762 systemd[1]: Finished systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev. Nov 12 17:58:14.213082 systemd[1]: modprobe@efi_pstore.service: Deactivated successfully. Nov 12 17:58:14.213401 systemd[1]: Finished modprobe@efi_pstore.service - Load Kernel Module efi_pstore. Nov 12 17:58:14.214874 systemd-tmpfiles[1239]: Detected autofs mount point /boot during canonicalization of boot. Nov 12 17:58:14.214889 systemd-tmpfiles[1239]: Skipping /boot Nov 12 17:58:14.215102 systemd[1]: modprobe@loop.service: Deactivated successfully. Nov 12 17:58:14.215211 systemd[1]: Finished modprobe@loop.service - Load Kernel Module loop. Nov 12 17:58:14.216583 systemd[1]: modprobe@dm_mod.service: Deactivated successfully. Nov 12 17:58:14.216703 systemd[1]: Finished modprobe@dm_mod.service - Load Kernel Module dm_mod. Nov 12 17:58:14.217961 systemd[1]: modprobe@drm.service: Deactivated successfully. Nov 12 17:58:14.218070 systemd[1]: Finished modprobe@drm.service - Load Kernel Module drm. Nov 12 17:58:14.222422 systemd[1]: Finished ensure-sysext.service. Nov 12 17:58:14.225870 systemd[1]: systemd-pstore.service - Platform Persistent Storage Archival was skipped because of an unmet condition check (ConditionDirectoryNotEmpty=/sys/fs/pstore). Nov 12 17:58:14.225919 systemd[1]: systemd-repart.service - Repartition Root Disk was skipped because no trigger condition checks were met. Nov 12 17:58:14.232561 systemd[1]: Finished systemd-tmpfiles-setup.service - Create System Files and Directories. Nov 12 17:58:14.250541 systemd[1]: Starting audit-rules.service - Load Security Auditing Rules... Nov 12 17:58:14.252717 systemd[1]: Starting clean-ca-certificates.service - Clean up broken links in /etc/ssl/certs... Nov 12 17:58:14.254562 systemd[1]: Starting systemd-journal-catalog-update.service - Rebuild Journal Catalog... Nov 12 17:58:14.259554 systemd[1]: Starting systemd-resolved.service - Network Name Resolution... Nov 12 17:58:14.264525 systemd[1]: Starting systemd-timesyncd.service - Network Time Synchronization... Nov 12 17:58:14.270577 systemd[1]: Starting systemd-update-utmp.service - Record System Boot/Shutdown in UTMP... Nov 12 17:58:14.274560 systemd[1]: Starting systemd-userdbd.service - User Database Manager... Nov 12 17:58:14.289899 systemd[1]: Finished systemd-journal-catalog-update.service - Rebuild Journal Catalog. Nov 12 17:58:14.291203 systemd[1]: Finished systemd-update-utmp.service - Record System Boot/Shutdown in UTMP. Nov 12 17:58:14.325687 systemd[1]: Started systemd-userdbd.service - User Database Manager. Nov 12 17:58:14.337708 augenrules[1289]: No rules Nov 12 17:58:14.338838 systemd[1]: Finished audit-rules.service - Load Security Auditing Rules. Nov 12 17:58:14.343932 systemd[1]: Finished clean-ca-certificates.service - Clean up broken links in /etc/ssl/certs. Nov 12 17:58:14.345131 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). Nov 12 17:58:14.362436 systemd[1]: Finished systemd-hwdb-update.service - Rebuild Hardware Database. Nov 12 17:58:14.373632 systemd[1]: Starting systemd-udevd.service - Rule-based Manager for Device Events and Files... Nov 12 17:58:14.375815 systemd[1]: Starting systemd-update-done.service - Update is Completed... Nov 12 17:58:14.382595 systemd[1]: Started systemd-timesyncd.service - Network Time Synchronization. Nov 12 17:58:14.383624 systemd[1]: Reached target time-set.target - System Time Set. Nov 12 17:58:14.389206 systemd[1]: Finished systemd-update-done.service - Update is Completed. Nov 12 17:58:14.389455 systemd-resolved[1265]: Positive Trust Anchors: Nov 12 17:58:14.389468 systemd-resolved[1265]: . IN DS 20326 8 2 e06d44b80b8f1d39a95c0b0d7c65d08458e880409bbc683457104237c7f8ec8d Nov 12 17:58:14.389499 systemd-resolved[1265]: 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 Nov 12 17:58:14.393771 systemd-udevd[1298]: Using default interface naming scheme 'v255'. Nov 12 17:58:14.399522 systemd-resolved[1265]: Defaulting to hostname 'linux'. Nov 12 17:58:14.400823 systemd[1]: Started systemd-resolved.service - Network Name Resolution. Nov 12 17:58:14.401679 systemd[1]: Reached target nss-lookup.target - Host and Network Name Lookups. Nov 12 17:58:14.409076 systemd[1]: Started systemd-udevd.service - Rule-based Manager for Device Events and Files. Nov 12 17:58:14.420602 systemd[1]: Starting systemd-networkd.service - Network Configuration... Nov 12 17:58:14.436387 kernel: BTRFS info: devid 1 device path /dev/mapper/usr changed to /dev/dm-0 scanned by (udev-worker) (1313) Nov 12 17:58:14.440287 kernel: BTRFS info: devid 1 device path /dev/dm-0 changed to /dev/mapper/usr scanned by (udev-worker) (1313) Nov 12 17:58:14.444389 kernel: BTRFS warning: duplicate device /dev/vda3 devid 1 generation 40 scanned by (udev-worker) (1309) Nov 12 17:58:14.449489 systemd[1]: Condition check resulted in dev-ttyAMA0.device - /dev/ttyAMA0 being skipped. Nov 12 17:58:14.486694 systemd[1]: Found device dev-disk-by\x2dlabel-OEM.device - /dev/disk/by-label/OEM. Nov 12 17:58:14.491582 systemd[1]: Starting systemd-fsck@dev-disk-by\x2dlabel-OEM.service - File System Check on /dev/disk/by-label/OEM... Nov 12 17:58:14.499284 systemd-networkd[1311]: lo: Link UP Nov 12 17:58:14.499295 systemd-networkd[1311]: lo: Gained carrier Nov 12 17:58:14.502277 systemd-networkd[1311]: Enumeration completed Nov 12 17:58:14.502763 systemd[1]: Started systemd-networkd.service - Network Configuration. Nov 12 17:58:14.503643 systemd[1]: Reached target network.target - Network. Nov 12 17:58:14.507811 systemd-networkd[1311]: eth0: found matching network '/usr/lib/systemd/network/zz-default.network', based on potentially unpredictable interface name. Nov 12 17:58:14.507822 systemd-networkd[1311]: eth0: Configuring with /usr/lib/systemd/network/zz-default.network. Nov 12 17:58:14.510062 systemd-networkd[1311]: eth0: Link UP Nov 12 17:58:14.510072 systemd-networkd[1311]: eth0: Gained carrier Nov 12 17:58:14.510085 systemd-networkd[1311]: eth0: found matching network '/usr/lib/systemd/network/zz-default.network', based on potentially unpredictable interface name. Nov 12 17:58:14.515551 systemd[1]: Starting systemd-networkd-wait-online.service - Wait for Network to be Configured... Nov 12 17:58:14.519869 systemd[1]: Finished systemd-fsck@dev-disk-by\x2dlabel-OEM.service - File System Check on /dev/disk/by-label/OEM. Nov 12 17:58:14.526447 systemd-networkd[1311]: eth0: DHCPv4 address 10.0.0.114/16, gateway 10.0.0.1 acquired from 10.0.0.1 Nov 12 17:58:14.527271 systemd-timesyncd[1266]: Network configuration changed, trying to establish connection. Nov 12 17:58:14.527892 systemd-timesyncd[1266]: Contacted time server 10.0.0.1:123 (10.0.0.1). Nov 12 17:58:14.527947 systemd-timesyncd[1266]: Initial clock synchronization to Tue 2024-11-12 17:58:14.849771 UTC. Nov 12 17:58:14.552731 systemd[1]: Starting systemd-vconsole-setup.service - Virtual Console Setup... Nov 12 17:58:14.569420 systemd[1]: Finished systemd-udev-settle.service - Wait for udev To Complete Device Initialization. Nov 12 17:58:14.581157 systemd[1]: Starting lvm2-activation-early.service - Activation of LVM2 logical volumes... Nov 12 17:58:14.601697 lvm[1339]: WARNING: Failed to connect to lvmetad. Falling back to device scanning. Nov 12 17:58:14.604131 systemd[1]: Finished systemd-vconsole-setup.service - Virtual Console Setup. Nov 12 17:58:14.636373 systemd[1]: Finished lvm2-activation-early.service - Activation of LVM2 logical volumes. Nov 12 17:58:14.638171 systemd[1]: Reached target cryptsetup.target - Local Encrypted Volumes. Nov 12 17:58:14.639274 systemd[1]: Reached target sysinit.target - System Initialization. Nov 12 17:58:14.640408 systemd[1]: Started motdgen.path - Watch for update engine configuration changes. Nov 12 17:58:14.641617 systemd[1]: Started user-cloudinit@var-lib-flatcar\x2dinstall-user_data.path - Watch for a cloud-config at /var/lib/flatcar-install/user_data. Nov 12 17:58:14.643020 systemd[1]: Started logrotate.timer - Daily rotation of log files. Nov 12 17:58:14.644269 systemd[1]: Started mdadm.timer - Weekly check for MD array's redundancy information.. Nov 12 17:58:14.645466 systemd[1]: Started systemd-tmpfiles-clean.timer - Daily Cleanup of Temporary Directories. Nov 12 17:58:14.646621 systemd[1]: update-engine-stub.timer - Update Engine Stub Timer was skipped because of an unmet condition check (ConditionPathExists=/usr/.noupdate). Nov 12 17:58:14.646654 systemd[1]: Reached target paths.target - Path Units. Nov 12 17:58:14.647550 systemd[1]: Reached target timers.target - Timer Units. Nov 12 17:58:14.649155 systemd[1]: Listening on dbus.socket - D-Bus System Message Bus Socket. Nov 12 17:58:14.660099 systemd[1]: Listening on sshd.socket - OpenSSH Server Socket. Nov 12 17:58:14.660865 systemd[1]: Reached target sockets.target - Socket Units. Nov 12 17:58:14.661506 systemd[1]: Reached target basic.target - Basic System. Nov 12 17:58:14.662145 systemd[1]: addon-config@oem.service - Configure Addon /oem was skipped because no trigger condition checks were met. Nov 12 17:58:14.662177 systemd[1]: addon-run@oem.service - Run Addon /oem was skipped because no trigger condition checks were met. Nov 12 17:58:14.663827 systemd[1]: Starting dbus.service - D-Bus System Message Bus... Nov 12 17:58:14.666145 systemd[1]: Starting enable-oem-cloudinit.service - Enable cloudinit... Nov 12 17:58:14.668128 systemd[1]: Starting extend-filesystems.service - Extend Filesystems... Nov 12 17:58:14.669815 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). Nov 12 17:58:14.671537 systemd[1]: Starting lvm2-activation.service - Activation of LVM2 logical volumes... Nov 12 17:58:14.675536 systemd[1]: Starting motdgen.service - Generate /run/flatcar/motd... Nov 12 17:58:14.681575 systemd[1]: Starting ssh-key-proc-cmdline.service - Install an ssh key from /proc/cmdline... Nov 12 17:58:14.683424 lvm[1348]: WARNING: Failed to connect to lvmetad. Falling back to device scanning. Nov 12 17:58:14.684613 jq[1346]: false Nov 12 17:58:14.684659 systemd[1]: Starting sshd-keygen.service - Generate sshd host keys... Nov 12 17:58:14.688776 systemd[1]: Starting systemd-logind.service - User Login Management... Nov 12 17:58:14.692664 systemd[1]: tcsd.service - TCG Core Services Daemon was skipped because of an unmet condition check (ConditionPathExists=/dev/tpm0). Nov 12 17:58:14.693079 systemd[1]: cgroup compatibility translation between legacy and unified hierarchy settings activated. See cgroup-compat debug messages for details. Nov 12 17:58:14.694559 systemd[1]: Starting update-engine.service - Update Engine... Nov 12 17:58:14.698368 extend-filesystems[1347]: Found vda Nov 12 17:58:14.698368 extend-filesystems[1347]: Found vda1 Nov 12 17:58:14.698368 extend-filesystems[1347]: Found vda2 Nov 12 17:58:14.698368 extend-filesystems[1347]: Found vda3 Nov 12 17:58:14.698368 extend-filesystems[1347]: Found usr Nov 12 17:58:14.698368 extend-filesystems[1347]: Found vda4 Nov 12 17:58:14.698368 extend-filesystems[1347]: Found vda6 Nov 12 17:58:14.698368 extend-filesystems[1347]: Found vda7 Nov 12 17:58:14.698368 extend-filesystems[1347]: Found vda9 Nov 12 17:58:14.698368 extend-filesystems[1347]: Checking size of /dev/vda9 Nov 12 17:58:14.696355 systemd[1]: Starting update-ssh-keys-after-ignition.service - Run update-ssh-keys once after Ignition... Nov 12 17:58:14.698185 systemd[1]: enable-oem-cloudinit.service: Skipped due to 'exec-condition'. Nov 12 17:58:14.699309 systemd[1]: Condition check resulted in enable-oem-cloudinit.service - Enable cloudinit being skipped. Nov 12 17:58:14.711375 jq[1356]: true Nov 12 17:58:14.701916 systemd[1]: ssh-key-proc-cmdline.service: Deactivated successfully. Nov 12 17:58:14.702073 systemd[1]: Finished ssh-key-proc-cmdline.service - Install an ssh key from /proc/cmdline. Nov 12 17:58:14.710509 systemd[1]: Finished lvm2-activation.service - Activation of LVM2 logical volumes. Nov 12 17:58:14.715727 dbus-daemon[1345]: [system] SELinux support is enabled Nov 12 17:58:14.728618 kernel: BTRFS warning: duplicate device /dev/vda3 devid 1 generation 40 scanned by (udev-worker) (1309) Nov 12 17:58:14.728653 extend-filesystems[1347]: Old size kept for /dev/vda9 Nov 12 17:58:14.724736 systemd[1]: Started dbus.service - D-Bus System Message Bus. Nov 12 17:58:14.731941 jq[1364]: true Nov 12 17:58:14.730595 systemd[1]: extend-filesystems.service: Deactivated successfully. Nov 12 17:58:14.732389 systemd[1]: Finished extend-filesystems.service - Extend Filesystems. Nov 12 17:58:14.734257 systemd[1]: motdgen.service: Deactivated successfully. Nov 12 17:58:14.736396 systemd[1]: Finished motdgen.service - Generate /run/flatcar/motd. Nov 12 17:58:14.744580 update_engine[1354]: I20241112 17:58:14.744369 1354 main.cc:92] Flatcar Update Engine starting Nov 12 17:58:14.754021 update_engine[1354]: I20241112 17:58:14.746117 1354 update_check_scheduler.cc:74] Next update check in 11m45s Nov 12 17:58:14.759072 systemd[1]: Started update-engine.service - Update Engine. Nov 12 17:58:14.759766 systemd-logind[1353]: Watching system buttons on /dev/input/event0 (Power Button) Nov 12 17:58:14.760156 systemd-logind[1353]: New seat seat0. Nov 12 17:58:14.760269 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). Nov 12 17:58:14.760304 systemd[1]: Reached target system-config.target - Load system-provided cloud configs. Nov 12 17:58:14.762059 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). Nov 12 17:58:14.762087 systemd[1]: Reached target user-config.target - Load user-provided cloud configs. Nov 12 17:58:14.774950 systemd[1]: Started locksmithd.service - Cluster reboot manager. Nov 12 17:58:14.776047 systemd[1]: Started systemd-logind.service - User Login Management. Nov 12 17:58:14.796040 bash[1392]: Updated "/home/core/.ssh/authorized_keys" Nov 12 17:58:14.797342 systemd[1]: Finished update-ssh-keys-after-ignition.service - Run update-ssh-keys once after Ignition. Nov 12 17:58:14.798933 systemd[1]: sshkeys.service was skipped because no trigger condition checks were met. Nov 12 17:58:14.813326 locksmithd[1385]: locksmithd starting currentOperation="UPDATE_STATUS_IDLE" strategy="reboot" Nov 12 17:58:15.135447 sshd_keygen[1363]: ssh-keygen: generating new host keys: RSA ECDSA ED25519 Nov 12 17:58:15.154583 systemd[1]: Finished sshd-keygen.service - Generate sshd host keys. Nov 12 17:58:15.168948 systemd[1]: Starting issuegen.service - Generate /run/issue... Nov 12 17:58:15.174702 systemd[1]: issuegen.service: Deactivated successfully. Nov 12 17:58:15.174862 systemd[1]: Finished issuegen.service - Generate /run/issue. Nov 12 17:58:15.178094 systemd[1]: Starting systemd-user-sessions.service - Permit User Sessions... Nov 12 17:58:15.195280 systemd[1]: Finished systemd-user-sessions.service - Permit User Sessions. Nov 12 17:58:15.198926 systemd[1]: Started getty@tty1.service - Getty on tty1. Nov 12 17:58:15.201043 systemd[1]: Started serial-getty@ttyAMA0.service - Serial Getty on ttyAMA0. Nov 12 17:58:15.202084 systemd[1]: Reached target getty.target - Login Prompts. Nov 12 17:58:16.402574 systemd-networkd[1311]: eth0: Gained IPv6LL Nov 12 17:58:16.405478 systemd[1]: Finished systemd-networkd-wait-online.service - Wait for Network to be Configured. Nov 12 17:58:16.407640 systemd[1]: Reached target network-online.target - Network is Online. Nov 12 17:58:16.422092 systemd[1]: Starting coreos-metadata.service - QEMU metadata agent... Nov 12 17:58:16.425614 systemd[1]: Starting nvidia.service - NVIDIA Configure Service... Nov 12 17:58:16.450351 systemd[1]: coreos-metadata.service: Deactivated successfully. Nov 12 17:58:16.450575 systemd[1]: Finished coreos-metadata.service - QEMU metadata agent. Nov 12 17:58:16.452591 systemd[1]: packet-phone-home.service - Report Success to Packet was skipped because no trigger condition checks were met. Nov 12 17:58:16.458943 systemd[1]: Finished nvidia.service - NVIDIA Configure Service. Nov 12 17:58:16.460789 systemd[1]: Reached target multi-user.target - Multi-User System. Nov 12 17:58:16.466475 systemd[1]: Startup finished in 531ms (kernel) + 3.517s (initrd) + 3.281s (userspace) = 7.331s. Nov 12 17:58:22.364934 systemd[1]: Created slice system-sshd.slice - Slice /system/sshd. Nov 12 17:58:22.365985 systemd[1]: Started sshd@0-10.0.0.114:22-10.0.0.1:59102.service - OpenSSH per-connection server daemon (10.0.0.1:59102). Nov 12 17:58:22.414419 sshd[1435]: Accepted publickey for core from 10.0.0.1 port 59102 ssh2: RSA SHA256:0/Njp3Vk1MHv0WcCO9/UA+beq4MlL3BRl9mBP4xwGAg Nov 12 17:58:22.416127 sshd[1435]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Nov 12 17:58:22.424418 systemd-logind[1353]: New session 1 of user core. Nov 12 17:58:22.425423 systemd[1]: Created slice user-500.slice - User Slice of UID 500. Nov 12 17:58:22.437632 systemd[1]: Starting user-runtime-dir@500.service - User Runtime Directory /run/user/500... Nov 12 17:58:22.446349 systemd[1]: Finished user-runtime-dir@500.service - User Runtime Directory /run/user/500. Nov 12 17:58:22.448541 systemd[1]: Starting user@500.service - User Manager for UID 500... Nov 12 17:58:22.455021 (systemd)[1439]: pam_unix(systemd-user:session): session opened for user core(uid=500) by (uid=0) Nov 12 17:58:22.531555 systemd[1439]: Queued start job for default target default.target. Nov 12 17:58:22.542303 systemd[1439]: Created slice app.slice - User Application Slice. Nov 12 17:58:22.542332 systemd[1439]: Reached target paths.target - Paths. Nov 12 17:58:22.542344 systemd[1439]: Reached target timers.target - Timers. Nov 12 17:58:22.543552 systemd[1439]: Starting dbus.socket - D-Bus User Message Bus Socket... Nov 12 17:58:22.552885 systemd[1439]: Listening on dbus.socket - D-Bus User Message Bus Socket. Nov 12 17:58:22.552946 systemd[1439]: Reached target sockets.target - Sockets. Nov 12 17:58:22.552959 systemd[1439]: Reached target basic.target - Basic System. Nov 12 17:58:22.552992 systemd[1439]: Reached target default.target - Main User Target. Nov 12 17:58:22.553018 systemd[1439]: Startup finished in 92ms. Nov 12 17:58:22.553241 systemd[1]: Started user@500.service - User Manager for UID 500. Nov 12 17:58:22.554489 systemd[1]: Started session-1.scope - Session 1 of User core. Nov 12 17:58:22.617070 systemd[1]: Started sshd@1-10.0.0.114:22-10.0.0.1:59104.service - OpenSSH per-connection server daemon (10.0.0.1:59104). Nov 12 17:58:22.654768 sshd[1450]: Accepted publickey for core from 10.0.0.1 port 59104 ssh2: RSA SHA256:0/Njp3Vk1MHv0WcCO9/UA+beq4MlL3BRl9mBP4xwGAg Nov 12 17:58:22.656122 sshd[1450]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Nov 12 17:58:22.659794 systemd-logind[1353]: New session 2 of user core. Nov 12 17:58:22.675545 systemd[1]: Started session-2.scope - Session 2 of User core. Nov 12 17:58:22.727962 sshd[1450]: pam_unix(sshd:session): session closed for user core Nov 12 17:58:22.740826 systemd[1]: sshd@1-10.0.0.114:22-10.0.0.1:59104.service: Deactivated successfully. Nov 12 17:58:22.742220 systemd[1]: session-2.scope: Deactivated successfully. Nov 12 17:58:22.743445 systemd-logind[1353]: Session 2 logged out. Waiting for processes to exit. Nov 12 17:58:22.744563 systemd[1]: Started sshd@2-10.0.0.114:22-10.0.0.1:59110.service - OpenSSH per-connection server daemon (10.0.0.1:59110). Nov 12 17:58:22.745282 systemd-logind[1353]: Removed session 2. Nov 12 17:58:22.783551 sshd[1457]: Accepted publickey for core from 10.0.0.1 port 59110 ssh2: RSA SHA256:0/Njp3Vk1MHv0WcCO9/UA+beq4MlL3BRl9mBP4xwGAg Nov 12 17:58:22.784972 sshd[1457]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Nov 12 17:58:22.789189 systemd-logind[1353]: New session 3 of user core. Nov 12 17:58:22.799550 systemd[1]: Started session-3.scope - Session 3 of User core. Nov 12 17:58:22.849480 sshd[1457]: pam_unix(sshd:session): session closed for user core Nov 12 17:58:22.863052 systemd[1]: sshd@2-10.0.0.114:22-10.0.0.1:59110.service: Deactivated successfully. Nov 12 17:58:22.864750 systemd[1]: session-3.scope: Deactivated successfully. Nov 12 17:58:22.866075 systemd-logind[1353]: Session 3 logged out. Waiting for processes to exit. Nov 12 17:58:22.867447 systemd[1]: Started sshd@3-10.0.0.114:22-10.0.0.1:59126.service - OpenSSH per-connection server daemon (10.0.0.1:59126). Nov 12 17:58:22.868251 systemd-logind[1353]: Removed session 3. Nov 12 17:58:22.906283 sshd[1464]: Accepted publickey for core from 10.0.0.1 port 59126 ssh2: RSA SHA256:0/Njp3Vk1MHv0WcCO9/UA+beq4MlL3BRl9mBP4xwGAg Nov 12 17:58:22.907734 sshd[1464]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Nov 12 17:58:22.912284 systemd-logind[1353]: New session 4 of user core. Nov 12 17:58:22.921532 systemd[1]: Started session-4.scope - Session 4 of User core. Nov 12 17:58:22.974507 sshd[1464]: pam_unix(sshd:session): session closed for user core Nov 12 17:58:22.985931 systemd[1]: sshd@3-10.0.0.114:22-10.0.0.1:59126.service: Deactivated successfully. Nov 12 17:58:22.987558 systemd[1]: session-4.scope: Deactivated successfully. Nov 12 17:58:22.990639 systemd-logind[1353]: Session 4 logged out. Waiting for processes to exit. Nov 12 17:58:22.991959 systemd[1]: Started sshd@4-10.0.0.114:22-10.0.0.1:59138.service - OpenSSH per-connection server daemon (10.0.0.1:59138). Nov 12 17:58:22.992755 systemd-logind[1353]: Removed session 4. Nov 12 17:58:23.029706 sshd[1471]: Accepted publickey for core from 10.0.0.1 port 59138 ssh2: RSA SHA256:0/Njp3Vk1MHv0WcCO9/UA+beq4MlL3BRl9mBP4xwGAg Nov 12 17:58:23.031087 sshd[1471]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Nov 12 17:58:23.035194 systemd-logind[1353]: New session 5 of user core. Nov 12 17:58:23.055596 systemd[1]: Started session-5.scope - Session 5 of User core. Nov 12 17:58:23.113785 sudo[1474]: core : PWD=/home/core ; USER=root ; COMMAND=/usr/sbin/setenforce 1 Nov 12 17:58:23.114042 sudo[1474]: pam_unix(sudo:session): session opened for user root(uid=0) by core(uid=500) Nov 12 17:58:23.126341 sudo[1474]: pam_unix(sudo:session): session closed for user root Nov 12 17:58:23.128445 sshd[1471]: pam_unix(sshd:session): session closed for user core Nov 12 17:58:23.136773 systemd[1]: sshd@4-10.0.0.114:22-10.0.0.1:59138.service: Deactivated successfully. Nov 12 17:58:23.139763 systemd[1]: session-5.scope: Deactivated successfully. Nov 12 17:58:23.141405 systemd-logind[1353]: Session 5 logged out. Waiting for processes to exit. Nov 12 17:58:23.152643 systemd[1]: Started sshd@5-10.0.0.114:22-10.0.0.1:59148.service - OpenSSH per-connection server daemon (10.0.0.1:59148). Nov 12 17:58:23.153774 systemd-logind[1353]: Removed session 5. Nov 12 17:58:23.191694 sshd[1479]: Accepted publickey for core from 10.0.0.1 port 59148 ssh2: RSA SHA256:0/Njp3Vk1MHv0WcCO9/UA+beq4MlL3BRl9mBP4xwGAg Nov 12 17:58:23.193025 sshd[1479]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Nov 12 17:58:23.196925 systemd-logind[1353]: New session 6 of user core. Nov 12 17:58:23.206567 systemd[1]: Started session-6.scope - Session 6 of User core. Nov 12 17:58:23.258047 sudo[1483]: 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 Nov 12 17:58:23.258308 sudo[1483]: pam_unix(sudo:session): session opened for user root(uid=0) by core(uid=500) Nov 12 17:58:23.261299 sudo[1483]: pam_unix(sudo:session): session closed for user root Nov 12 17:58:23.265764 sudo[1482]: core : PWD=/home/core ; USER=root ; COMMAND=/usr/bin/systemctl restart audit-rules Nov 12 17:58:23.266023 sudo[1482]: pam_unix(sudo:session): session opened for user root(uid=0) by core(uid=500) Nov 12 17:58:23.291665 systemd[1]: Stopping audit-rules.service - Load Security Auditing Rules... Nov 12 17:58:23.293044 auditctl[1486]: No rules Nov 12 17:58:23.293350 systemd[1]: audit-rules.service: Deactivated successfully. Nov 12 17:58:23.293543 systemd[1]: Stopped audit-rules.service - Load Security Auditing Rules. Nov 12 17:58:23.295710 systemd[1]: Starting audit-rules.service - Load Security Auditing Rules... Nov 12 17:58:23.319652 augenrules[1504]: No rules Nov 12 17:58:23.322423 systemd[1]: Finished audit-rules.service - Load Security Auditing Rules. Nov 12 17:58:23.323463 sudo[1482]: pam_unix(sudo:session): session closed for user root Nov 12 17:58:23.325122 sshd[1479]: pam_unix(sshd:session): session closed for user core Nov 12 17:58:23.342741 systemd[1]: sshd@5-10.0.0.114:22-10.0.0.1:59148.service: Deactivated successfully. Nov 12 17:58:23.344056 systemd[1]: session-6.scope: Deactivated successfully. Nov 12 17:58:23.346543 systemd-logind[1353]: Session 6 logged out. Waiting for processes to exit. Nov 12 17:58:23.355685 systemd[1]: Started sshd@6-10.0.0.114:22-10.0.0.1:59154.service - OpenSSH per-connection server daemon (10.0.0.1:59154). Nov 12 17:58:23.356519 systemd-logind[1353]: Removed session 6. Nov 12 17:58:23.389896 sshd[1512]: Accepted publickey for core from 10.0.0.1 port 59154 ssh2: RSA SHA256:0/Njp3Vk1MHv0WcCO9/UA+beq4MlL3BRl9mBP4xwGAg Nov 12 17:58:23.391403 sshd[1512]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Nov 12 17:58:23.395696 systemd-logind[1353]: New session 7 of user core. Nov 12 17:58:23.405520 systemd[1]: Started session-7.scope - Session 7 of User core. Nov 12 17:58:23.454058 sshd[1512]: pam_unix(sshd:session): session closed for user core Nov 12 17:58:23.466666 systemd[1]: sshd@6-10.0.0.114:22-10.0.0.1:59154.service: Deactivated successfully. Nov 12 17:58:23.468039 systemd[1]: session-7.scope: Deactivated successfully. Nov 12 17:58:23.470409 systemd-logind[1353]: Session 7 logged out. Waiting for processes to exit. Nov 12 17:58:23.471522 systemd[1]: Started sshd@7-10.0.0.114:22-10.0.0.1:59164.service - OpenSSH per-connection server daemon (10.0.0.1:59164). Nov 12 17:58:23.472156 systemd-logind[1353]: Removed session 7. Nov 12 17:58:23.508479 sshd[1520]: Accepted publickey for core from 10.0.0.1 port 59164 ssh2: RSA SHA256:0/Njp3Vk1MHv0WcCO9/UA+beq4MlL3BRl9mBP4xwGAg Nov 12 17:58:23.509733 sshd[1520]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Nov 12 17:58:23.513444 systemd-logind[1353]: New session 8 of user core. Nov 12 17:58:23.523534 systemd[1]: Started session-8.scope - Session 8 of User core. Nov 12 17:58:23.977854 sshd[1520]: pam_unix(sshd:session): session closed for user core Nov 12 17:58:23.993019 systemd[1]: sshd@7-10.0.0.114:22-10.0.0.1:59164.service: Deactivated successfully. Nov 12 17:58:23.995884 systemd[1]: session-8.scope: Deactivated successfully. Nov 12 17:58:23.997255 systemd-logind[1353]: Session 8 logged out. Waiting for processes to exit. Nov 12 17:58:24.006682 systemd[1]: Started sshd@8-10.0.0.114:22-10.0.0.1:59180.service - OpenSSH per-connection server daemon (10.0.0.1:59180). Nov 12 17:58:24.007543 systemd-logind[1353]: Removed session 8. Nov 12 17:58:24.042053 sshd[1536]: Accepted publickey for core from 10.0.0.1 port 59180 ssh2: RSA SHA256:0/Njp3Vk1MHv0WcCO9/UA+beq4MlL3BRl9mBP4xwGAg Nov 12 17:58:24.043428 sshd[1536]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Nov 12 17:58:24.047889 systemd-logind[1353]: New session 9 of user core. Nov 12 17:58:24.058572 systemd[1]: Started session-9.scope - Session 9 of User core. Nov 12 17:58:28.304825 sudo[1539]: core : PWD=/home/core ; USER=root ; COMMAND=/usr/bin/mv docker.raw containerd.raw /etc/extensions/ Nov 12 17:58:28.305078 sudo[1539]: pam_unix(sudo:session): session opened for user root(uid=0) by core(uid=500) Nov 12 17:58:28.470459 sudo[1539]: pam_unix(sudo:session): session closed for user root Nov 12 17:58:28.472296 sshd[1536]: pam_unix(sshd:session): session closed for user core Nov 12 17:58:28.486349 systemd[1]: sshd@8-10.0.0.114:22-10.0.0.1:59180.service: Deactivated successfully. Nov 12 17:58:28.488114 systemd[1]: session-9.scope: Deactivated successfully. Nov 12 17:58:28.488280 systemd[1]: session-9.scope: Consumed 3.560s CPU time. Nov 12 17:58:28.489511 systemd-logind[1353]: Session 9 logged out. Waiting for processes to exit. Nov 12 17:58:28.505720 systemd[1]: Started sshd@9-10.0.0.114:22-10.0.0.1:59186.service - OpenSSH per-connection server daemon (10.0.0.1:59186). Nov 12 17:58:28.506728 systemd-logind[1353]: Removed session 9. Nov 12 17:58:28.541405 sshd[1597]: Accepted publickey for core from 10.0.0.1 port 59186 ssh2: RSA SHA256:0/Njp3Vk1MHv0WcCO9/UA+beq4MlL3BRl9mBP4xwGAg Nov 12 17:58:28.542213 sshd[1597]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Nov 12 17:58:28.546473 systemd-logind[1353]: New session 10 of user core. Nov 12 17:58:28.556555 systemd[1]: Started session-10.scope - Session 10 of User core. Nov 12 17:58:28.607945 sudo[1600]: core : PWD=/home/core ; USER=root ; COMMAND=/usr/bin/systemctl restart systemd-sysext Nov 12 17:58:28.608568 sudo[1600]: pam_unix(sudo:session): session opened for user root(uid=0) by core(uid=500) Nov 12 17:58:28.615793 systemd[1]: ensure-sysext.service: Deactivated successfully. Nov 12 17:58:28.615966 systemd[1]: Stopped ensure-sysext.service. Nov 12 17:58:28.616023 systemd[1]: Stopping ensure-sysext.service... Nov 12 17:58:28.626686 systemd[1]: Stopping systemd-sysext.service - Merge System Extension Images into /usr/ and /opt/... Nov 12 17:58:28.631936 systemd[1]: systemd-sysext.service: Deactivated successfully. Nov 12 17:58:28.632165 systemd[1]: Stopped systemd-sysext.service - Merge System Extension Images into /usr/ and /opt/. Nov 12 17:58:28.634208 systemd[1]: Starting systemd-sysext.service - Merge System Extension Images into /usr/ and /opt/... Nov 12 17:58:28.643489 kernel: loop0: detected capacity change from 0 to 301296 Nov 12 17:58:28.648411 kernel: EXT4-fs (loop0): mounted filesystem 69303782-95eb-4e60-9df1-7a17fe2a6733 ro without journal. Quota mode: none. Nov 12 17:58:28.672751 kernel: EXT4-fs (loop0): unmounting filesystem 69303782-95eb-4e60-9df1-7a17fe2a6733. Nov 12 17:58:28.704394 kernel: loop1: detected capacity change from 0 to 315088 Nov 12 17:58:28.709408 kernel: EXT4-fs (loop1): mounted filesystem 1b886f42-7890-445d-b61d-62de1782cd8c ro without journal. Quota mode: none. Nov 12 17:58:28.712413 kernel: EXT4-fs (loop1): unmounting filesystem 1b886f42-7890-445d-b61d-62de1782cd8c. Nov 12 17:58:28.741449 kernel: loop2: detected capacity change from 0 to 301296 Nov 12 17:58:28.746432 kernel: EXT4-fs (loop2): mounted filesystem 69303782-95eb-4e60-9df1-7a17fe2a6733 ro without journal. Quota mode: none. Nov 12 17:58:28.748445 kernel: loop3: detected capacity change from 0 to 315088 Nov 12 17:58:28.752413 kernel: EXT4-fs (loop3): mounted filesystem 1b886f42-7890-445d-b61d-62de1782cd8c ro without journal. Quota mode: none. Nov 12 17:58:28.752455 (sd-merge)[1611]: Using extensions 'containerd', 'docker'. Nov 12 17:58:28.752852 (sd-merge)[1611]: Merged extensions into '/usr'. Nov 12 17:58:28.754936 systemd[1]: Finished systemd-sysext.service - Merge System Extension Images into /usr/ and /opt/. Nov 12 17:58:28.758746 sudo[1600]: pam_unix(sudo:session): session closed for user root Nov 12 17:58:28.760597 sshd[1597]: pam_unix(sshd:session): session closed for user core Nov 12 17:58:28.766640 systemd[1]: Starting ensure-sysext.service... Nov 12 17:58:28.767062 systemd[1]: sshd@9-10.0.0.114:22-10.0.0.1:59186.service: Deactivated successfully. Nov 12 17:58:28.769566 systemd[1]: session-10.scope: Deactivated successfully. Nov 12 17:58:28.771517 systemd-logind[1353]: Session 10 logged out. Waiting for processes to exit. Nov 12 17:58:28.796693 systemd[1]: Started sshd@10-10.0.0.114:22-10.0.0.1:59190.service - OpenSSH per-connection server daemon (10.0.0.1:59190). Nov 12 17:58:28.797117 systemd[1]: Reloading requested from client PID 1615 ('systemctl') (unit ensure-sysext.service)... Nov 12 17:58:28.797127 systemd[1]: Reloading... Nov 12 17:58:28.857491 zram_generator::config[1658]: No configuration found. Nov 12 17:58:28.938781 systemd[1]: /usr/lib/systemd/system/docker.socket:5: ListenStream= references a path below legacy directory /var/run/, updating /var/run/docker.sock → /run/docker.sock; please update the unit file accordingly. Nov 12 17:58:28.986864 systemd[1]: Reloading finished in 189 ms. Nov 12 17:58:29.032148 systemd-logind[1353]: Removed session 10. Nov 12 17:58:29.035127 systemd[1]: Starting docker.socket - Docker Socket for the API... Nov 12 17:58:29.036520 systemd[1]: Starting containerd.service - containerd container runtime... Nov 12 17:58:29.036784 systemd[1]: Listening on docker.socket - Docker Socket for the API. Nov 12 17:58:29.041161 systemd[1]: Stopped target sockets.target - Socket Units. Nov 12 17:58:29.041179 systemd[1]: Stopping sockets.target - Socket Units... Nov 12 17:58:29.041248 systemd[1]: Reached target sockets.target - Socket Units. Nov 12 17:58:29.042016 systemd[1]: Stopped target timers.target - Timer Units. Nov 12 17:58:29.042032 systemd[1]: Stopping timers.target - Timer Units... Nov 12 17:58:29.042101 systemd[1]: Reached target timers.target - Timer Units. Nov 12 17:58:29.045640 systemd[1]: Stopped target multi-user.target - Multi-User System. Nov 12 17:58:29.045659 systemd[1]: Stopping multi-user.target - Multi-User System... Nov 12 17:58:29.045702 systemd[1]: update-engine-stub.timer - Update Engine Stub Timer was skipped because of an unmet condition check (ConditionPathExists=/usr/.noupdate). Nov 12 17:58:29.046990 systemd[1]: Starting coreos-metadata.service - QEMU metadata agent... Nov 12 17:58:29.047998 systemd[1]: Starting enable-oem-cloudinit.service - Enable cloudinit... Nov 12 17:58:29.049050 systemd[1]: Starting extend-filesystems.service - Extend Filesystems... Nov 12 17:58:29.051684 systemd[1]: Starting issuegen.service - Generate /run/issue... Nov 12 17:58:29.054520 jq[1696]: false Nov 12 17:58:29.054776 systemd[1]: Starting motdgen.service - Generate /run/flatcar/motd... Nov 12 17:58:29.057696 systemd[1]: Starting ssh-key-proc-cmdline.service - Install an ssh key from /proc/cmdline... Nov 12 17:58:29.057890 systemd[1]: sshkeys.service was skipped because no trigger condition checks were met. Nov 12 17:58:29.058029 systemd[1]: tcsd.service - TCG Core Services Daemon was skipped because of an unmet condition check (ConditionPathExists=/dev/tpm0). Nov 12 17:58:29.060506 systemd[1]: Started containerd.service - containerd container runtime. Nov 12 17:58:29.061741 systemd[1]: enable-oem-cloudinit.service: Skipped due to 'exec-condition'. Nov 12 17:58:29.061931 systemd[1]: Condition check resulted in enable-oem-cloudinit.service - Enable cloudinit being skipped. Nov 12 17:58:29.062420 systemd[1]: issuegen.service: Deactivated successfully. Nov 12 17:58:29.062562 systemd[1]: Finished issuegen.service - Generate /run/issue. Nov 12 17:58:29.065438 extend-filesystems[1697]: Found loop2 Nov 12 17:58:29.065438 extend-filesystems[1697]: Found loop3 Nov 12 17:58:29.065438 extend-filesystems[1697]: Found vda Nov 12 17:58:29.065438 extend-filesystems[1697]: Found vda1 Nov 12 17:58:29.065438 extend-filesystems[1697]: Found vda2 Nov 12 17:58:29.065438 extend-filesystems[1697]: Found vda3 Nov 12 17:58:29.065438 extend-filesystems[1697]: Found usr Nov 12 17:58:29.065438 extend-filesystems[1697]: Found vda4 Nov 12 17:58:29.065438 extend-filesystems[1697]: Found vda6 Nov 12 17:58:29.065438 extend-filesystems[1697]: Found vda7 Nov 12 17:58:29.065438 extend-filesystems[1697]: Found vda9 Nov 12 17:58:29.065438 extend-filesystems[1697]: Checking size of /dev/vda9 Nov 12 17:58:29.067614 systemd[1]: Finished ensure-sysext.service. Nov 12 17:58:29.075544 extend-filesystems[1697]: Old size kept for /dev/vda9 Nov 12 17:58:29.077443 systemd[1]: motdgen.service: Deactivated successfully. Nov 12 17:58:29.077657 systemd[1]: Finished motdgen.service - Generate /run/flatcar/motd. Nov 12 17:58:29.078189 systemd[1]: extend-filesystems.service: Deactivated successfully. Nov 12 17:58:29.078330 systemd[1]: Finished extend-filesystems.service - Extend Filesystems. Nov 12 17:58:29.086406 systemd[1]: ssh-key-proc-cmdline.service: Deactivated successfully. Nov 12 17:58:29.086646 systemd[1]: Finished ssh-key-proc-cmdline.service - Install an ssh key from /proc/cmdline. Nov 12 17:58:29.093289 kernel: BTRFS warning: duplicate device /dev/vda3 devid 1 generation 40 scanned by (udev-worker) (1721) Nov 12 17:58:29.109745 sshd[1619]: Accepted publickey for core from 10.0.0.1 port 59190 ssh2: RSA SHA256:0/Njp3Vk1MHv0WcCO9/UA+beq4MlL3BRl9mBP4xwGAg Nov 12 17:58:29.109992 sshd[1619]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Nov 12 17:58:29.110411 systemd[1]: coreos-metadata.service: Deactivated successfully. Nov 12 17:58:29.110620 systemd[1]: Finished coreos-metadata.service - QEMU metadata agent. Nov 12 17:58:29.111188 systemd[1]: packet-phone-home.service - Report Success to Packet was skipped because of an unmet condition check (ConditionFirstBoot=true). Nov 12 17:58:29.111339 systemd[1]: Reached target multi-user.target - Multi-User System. Nov 12 17:58:29.119578 systemd-logind[1353]: New session 11 of user core. Nov 12 17:58:29.132519 systemd[1]: Started session-11.scope - Session 11 of User core. Nov 12 17:58:29.289804 containerd[1703]: time="2024-11-12T17:58:29.289737016Z" level=info msg="starting containerd" revision=1c90a442489720eec95342e1789ee8a5e1b9536f version=v1.6.9 Nov 12 17:58:29.308566 containerd[1703]: time="2024-11-12T17:58:29.308518982Z" level=info msg="loading plugin \"io.containerd.content.v1.content\"..." type=io.containerd.content.v1 Nov 12 17:58:29.308670 containerd[1703]: time="2024-11-12T17:58:29.308655102Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.aufs\"..." type=io.containerd.snapshotter.v1 Nov 12 17:58:29.310164 containerd[1703]: time="2024-11-12T17:58:29.310032357Z" 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.60-flatcar\\n\"): skip plugin" type=io.containerd.snapshotter.v1 Nov 12 17:58:29.311060 containerd[1703]: time="2024-11-12T17:58:29.310230217Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.btrfs\"..." type=io.containerd.snapshotter.v1 Nov 12 17:58:29.311060 containerd[1703]: time="2024-11-12T17:58:29.310476375Z" 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 Nov 12 17:58:29.311060 containerd[1703]: time="2024-11-12T17:58:29.310495292Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.devmapper\"..." type=io.containerd.snapshotter.v1 Nov 12 17:58:29.311060 containerd[1703]: time="2024-11-12T17:58:29.310508695Z" level=warning msg="failed to load plugin io.containerd.snapshotter.v1.devmapper" error="devmapper not configured" Nov 12 17:58:29.311060 containerd[1703]: time="2024-11-12T17:58:29.310518878Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.native\"..." type=io.containerd.snapshotter.v1 Nov 12 17:58:29.311060 containerd[1703]: time="2024-11-12T17:58:29.310605049Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.overlayfs\"..." type=io.containerd.snapshotter.v1 Nov 12 17:58:29.311060 containerd[1703]: time="2024-11-12T17:58:29.310824402Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.zfs\"..." type=io.containerd.snapshotter.v1 Nov 12 17:58:29.311060 containerd[1703]: time="2024-11-12T17:58:29.310946233Z" 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 Nov 12 17:58:29.311060 containerd[1703]: time="2024-11-12T17:58:29.310962293Z" level=info msg="loading plugin \"io.containerd.metadata.v1.bolt\"..." type=io.containerd.metadata.v1 Nov 12 17:58:29.311060 containerd[1703]: time="2024-11-12T17:58:29.311011516Z" level=warning msg="could not use snapshotter devmapper in metadata plugin" error="devmapper not configured" Nov 12 17:58:29.311060 containerd[1703]: time="2024-11-12T17:58:29.311025321Z" level=info msg="metadata content store policy set" policy=shared Nov 12 17:58:29.314907 containerd[1703]: time="2024-11-12T17:58:29.314878528Z" level=info msg="loading plugin \"io.containerd.differ.v1.walking\"..." type=io.containerd.differ.v1 Nov 12 17:58:29.314907 containerd[1703]: time="2024-11-12T17:58:29.314907667Z" level=info msg="loading plugin \"io.containerd.event.v1.exchange\"..." type=io.containerd.event.v1 Nov 12 17:58:29.314966 containerd[1703]: time="2024-11-12T17:58:29.314918736Z" level=info msg="loading plugin \"io.containerd.gc.v1.scheduler\"..." type=io.containerd.gc.v1 Nov 12 17:58:29.314988 containerd[1703]: time="2024-11-12T17:58:29.314965947Z" level=info msg="loading plugin \"io.containerd.service.v1.introspection-service\"..." type=io.containerd.service.v1 Nov 12 17:58:29.314988 containerd[1703]: time="2024-11-12T17:58:29.314979390Z" level=info msg="loading plugin \"io.containerd.service.v1.containers-service\"..." type=io.containerd.service.v1 Nov 12 17:58:29.315051 containerd[1703]: time="2024-11-12T17:58:29.314991182Z" level=info msg="loading plugin \"io.containerd.service.v1.content-service\"..." type=io.containerd.service.v1 Nov 12 17:58:29.315051 containerd[1703]: time="2024-11-12T17:58:29.315006879Z" level=info msg="loading plugin \"io.containerd.service.v1.diff-service\"..." type=io.containerd.service.v1 Nov 12 17:58:29.315374 containerd[1703]: time="2024-11-12T17:58:29.315340537Z" level=info msg="loading plugin \"io.containerd.service.v1.images-service\"..." type=io.containerd.service.v1 Nov 12 17:58:29.315407 containerd[1703]: time="2024-11-12T17:58:29.315384046Z" level=info msg="loading plugin \"io.containerd.service.v1.leases-service\"..." type=io.containerd.service.v1 Nov 12 17:58:29.315426 containerd[1703]: time="2024-11-12T17:58:29.315405739Z" level=info msg="loading plugin \"io.containerd.service.v1.namespaces-service\"..." type=io.containerd.service.v1 Nov 12 17:58:29.315426 containerd[1703]: time="2024-11-12T17:58:29.315418136Z" level=info msg="loading plugin \"io.containerd.service.v1.snapshots-service\"..." type=io.containerd.service.v1 Nov 12 17:58:29.315471 containerd[1703]: time="2024-11-12T17:58:29.315429244Z" level=info msg="loading plugin \"io.containerd.runtime.v1.linux\"..." type=io.containerd.runtime.v1 Nov 12 17:58:29.315563 containerd[1703]: time="2024-11-12T17:58:29.315535540Z" level=info msg="loading plugin \"io.containerd.runtime.v2.task\"..." type=io.containerd.runtime.v2 Nov 12 17:58:29.315625 containerd[1703]: time="2024-11-12T17:58:29.315611971Z" level=info msg="loading plugin \"io.containerd.monitor.v1.cgroups\"..." type=io.containerd.monitor.v1 Nov 12 17:58:29.315991 containerd[1703]: time="2024-11-12T17:58:29.315974286Z" level=info msg="loading plugin \"io.containerd.service.v1.tasks-service\"..." type=io.containerd.service.v1 Nov 12 17:58:29.316020 containerd[1703]: time="2024-11-12T17:58:29.316006324Z" level=info msg="loading plugin \"io.containerd.grpc.v1.introspection\"..." type=io.containerd.grpc.v1 Nov 12 17:58:29.316039 containerd[1703]: time="2024-11-12T17:58:29.316020934Z" level=info msg="loading plugin \"io.containerd.internal.v1.restart\"..." type=io.containerd.internal.v1 Nov 12 17:58:29.316136 containerd[1703]: time="2024-11-12T17:58:29.316123285Z" level=info msg="loading plugin \"io.containerd.grpc.v1.containers\"..." type=io.containerd.grpc.v1 Nov 12 17:58:29.316163 containerd[1703]: time="2024-11-12T17:58:29.316139103Z" level=info msg="loading plugin \"io.containerd.grpc.v1.content\"..." type=io.containerd.grpc.v1 Nov 12 17:58:29.316163 containerd[1703]: time="2024-11-12T17:58:29.316151620Z" level=info msg="loading plugin \"io.containerd.grpc.v1.diff\"..." type=io.containerd.grpc.v1 Nov 12 17:58:29.316205 containerd[1703]: time="2024-11-12T17:58:29.316161561Z" level=info msg="loading plugin \"io.containerd.grpc.v1.events\"..." type=io.containerd.grpc.v1 Nov 12 17:58:29.316205 containerd[1703]: time="2024-11-12T17:58:29.316172428Z" level=info msg="loading plugin \"io.containerd.grpc.v1.healthcheck\"..." type=io.containerd.grpc.v1 Nov 12 17:58:29.316205 containerd[1703]: time="2024-11-12T17:58:29.316189977Z" level=info msg="loading plugin \"io.containerd.grpc.v1.images\"..." type=io.containerd.grpc.v1 Nov 12 17:58:29.316205 containerd[1703]: time="2024-11-12T17:58:29.316199958Z" level=info msg="loading plugin \"io.containerd.grpc.v1.leases\"..." type=io.containerd.grpc.v1 Nov 12 17:58:29.316274 containerd[1703]: time="2024-11-12T17:58:29.316210181Z" level=info msg="loading plugin \"io.containerd.grpc.v1.namespaces\"..." type=io.containerd.grpc.v1 Nov 12 17:58:29.316274 containerd[1703]: time="2024-11-12T17:58:29.316225797Z" level=info msg="loading plugin \"io.containerd.internal.v1.opt\"..." type=io.containerd.internal.v1 Nov 12 17:58:29.316501 containerd[1703]: time="2024-11-12T17:58:29.316361193Z" level=info msg="loading plugin \"io.containerd.grpc.v1.snapshots\"..." type=io.containerd.grpc.v1 Nov 12 17:58:29.316501 containerd[1703]: time="2024-11-12T17:58:29.316399308Z" level=info msg="loading plugin \"io.containerd.grpc.v1.tasks\"..." type=io.containerd.grpc.v1 Nov 12 17:58:29.316501 containerd[1703]: time="2024-11-12T17:58:29.316415809Z" level=info msg="loading plugin \"io.containerd.grpc.v1.version\"..." type=io.containerd.grpc.v1 Nov 12 17:58:29.316501 containerd[1703]: time="2024-11-12T17:58:29.316427401Z" level=info msg="loading plugin \"io.containerd.tracing.processor.v1.otlp\"..." type=io.containerd.tracing.processor.v1 Nov 12 17:58:29.316501 containerd[1703]: time="2024-11-12T17:58:29.316440441Z" level=info msg="skip loading plugin \"io.containerd.tracing.processor.v1.otlp\"..." error="no OpenTelemetry endpoint: skip plugin" type=io.containerd.tracing.processor.v1 Nov 12 17:58:29.316501 containerd[1703]: time="2024-11-12T17:58:29.316450020Z" level=info msg="loading plugin \"io.containerd.internal.v1.tracing\"..." type=io.containerd.internal.v1 Nov 12 17:58:29.316501 containerd[1703]: time="2024-11-12T17:58:29.316464832Z" level=error msg="failed to initialize a tracing processor \"otlp\"" error="no OpenTelemetry endpoint: skip plugin" Nov 12 17:58:29.316501 containerd[1703]: time="2024-11-12T17:58:29.316496306Z" level=info msg="loading plugin \"io.containerd.grpc.v1.cri\"..." type=io.containerd.grpc.v1 Nov 12 17:58:29.317553 containerd[1703]: time="2024-11-12T17:58:29.317254060Z" level=info msg="Start cri plugin with config {PluginConfig:{ContainerdConfig:{Snapshotter:overlayfs DefaultRuntimeName:runc DefaultRuntime:{Type: Path: Engine: PodAnnotations:[] ContainerAnnotations:[] Root: Options:map[] PrivilegedWithoutHostDevices:false BaseRuntimeSpec: NetworkPluginConfDir: NetworkPluginMaxConfNum:0} UntrustedWorkloadRuntime:{Type: Path: Engine: PodAnnotations:[] ContainerAnnotations:[] Root: Options:map[] PrivilegedWithoutHostDevices:false BaseRuntimeSpec: NetworkPluginConfDir: NetworkPluginMaxConfNum:0} Runtimes:map[runc:{Type:io.containerd.runc.v2 Path: Engine: PodAnnotations:[] ContainerAnnotations:[] Root: Options:map[SystemdCgroup:true] PrivilegedWithoutHostDevices:false BaseRuntimeSpec: NetworkPluginConfDir: NetworkPluginMaxConfNum:0}] NoPivot:false DisableSnapshotAnnotations:true DiscardUnpackedLayers:false IgnoreRdtNotEnabledErrors:false} CniConfig:{NetworkPluginBinDir:/opt/cni/bin NetworkPluginConfDir:/etc/cni/net.d NetworkPluginMaxConfNum:1 NetworkPluginConfTemplate: IPPreference:} Registry:{ConfigPath: Mirrors:map[] Configs:map[] Auths:map[] Headers:map[]} ImageDecryption:{KeyModel:node} DisableTCPService:true StreamServerAddress:127.0.0.1 StreamServerPort:0 StreamIdleTimeout:4h0m0s EnableSelinux:false SelinuxCategoryRange:1024 SandboxImage:registry.k8s.io/pause:3.6 StatsCollectPeriod:10 SystemdCgroup:false EnableTLSStreaming:false X509KeyPairStreaming:{TLSCertFile: TLSKeyFile:} MaxContainerLogLineSize:16384 DisableCgroup:false DisableApparmor:false RestrictOOMScoreAdj:false MaxConcurrentDownloads:3 DisableProcMount:false UnsetSeccompProfile: TolerateMissingHugetlbController:true DisableHugetlbController:true DeviceOwnershipFromSecurityContext:false IgnoreImageDefinedVolumes:false NetNSMountsUnderStateDir:false EnableUnprivilegedPorts:false EnableUnprivilegedICMP:false} ContainerdRootDir:/var/lib/containerd ContainerdEndpoint:/run/containerd/containerd.sock RootDir:/var/lib/containerd/io.containerd.grpc.v1.cri StateDir:/run/containerd/io.containerd.grpc.v1.cri}" Nov 12 17:58:29.317553 containerd[1703]: time="2024-11-12T17:58:29.317340271Z" level=info msg="Connect containerd service" Nov 12 17:58:29.317553 containerd[1703]: time="2024-11-12T17:58:29.317405272Z" level=info msg="Get image filesystem path \"/var/lib/containerd/io.containerd.snapshotter.v1.overlayfs\"" Nov 12 17:58:29.318678 containerd[1703]: time="2024-11-12T17:58:29.318646528Z" 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" Nov 12 17:58:29.319048 containerd[1703]: time="2024-11-12T17:58:29.319026552Z" level=info msg=serving... address=/run/containerd/containerd.sock.ttrpc Nov 12 17:58:29.319108 containerd[1703]: time="2024-11-12T17:58:29.319079036Z" level=info msg=serving... address=/run/containerd/containerd.sock Nov 12 17:58:29.319108 containerd[1703]: time="2024-11-12T17:58:29.319093928Z" level=info msg="containerd successfully booted in 0.030709s" Nov 12 17:58:29.319515 containerd[1703]: time="2024-11-12T17:58:29.319177322Z" level=info msg="Start subscribing containerd event" Nov 12 17:58:29.319515 containerd[1703]: time="2024-11-12T17:58:29.319241921Z" level=info msg="Start recovering state" Nov 12 17:58:29.319515 containerd[1703]: time="2024-11-12T17:58:29.319301891Z" level=info msg="Start event monitor" Nov 12 17:58:29.319515 containerd[1703]: time="2024-11-12T17:58:29.319399895Z" level=info msg="Start snapshots syncer" Nov 12 17:58:29.319515 containerd[1703]: time="2024-11-12T17:58:29.319411768Z" level=info msg="Start cni network conf syncer for default" Nov 12 17:58:29.319515 containerd[1703]: time="2024-11-12T17:58:29.319418530Z" level=info msg="Start streaming server" Nov 12 17:58:29.320607 systemd[1]: Starting docker.service - Docker Application Container Engine... Nov 12 17:58:29.320696 (dockerd)[1749]: docker.service: Referenced but unset environment variable evaluates to an empty string: DOCKER_CGROUPS, DOCKER_OPTS, DOCKER_OPT_BIP, DOCKER_OPT_IPMASQ, DOCKER_OPT_MTU Nov 12 17:58:29.552826 dockerd[1749]: time="2024-11-12T17:58:29.552703013Z" level=info msg="Starting up" Nov 12 17:58:29.560411 dockerd[1749]: time="2024-11-12T17:58:29.560244528Z" level=info msg="parsed scheme: \"unix\"" module=grpc Nov 12 17:58:29.560411 dockerd[1749]: time="2024-11-12T17:58:29.560268235Z" level=info msg="scheme \"unix\" not registered, fallback to default scheme" module=grpc Nov 12 17:58:29.560411 dockerd[1749]: time="2024-11-12T17:58:29.560288801Z" level=info msg="ccResolverWrapper: sending update to cc: {[{unix:///run/containerd/containerd.sock 0 }] }" module=grpc Nov 12 17:58:29.560411 dockerd[1749]: time="2024-11-12T17:58:29.560298743Z" level=info msg="ClientConn switching balancer to \"pick_first\"" module=grpc Nov 12 17:58:29.567952 dockerd[1749]: time="2024-11-12T17:58:29.567760688Z" level=info msg="parsed scheme: \"unix\"" module=grpc Nov 12 17:58:29.567952 dockerd[1749]: time="2024-11-12T17:58:29.567789143Z" level=info msg="scheme \"unix\" not registered, fallback to default scheme" module=grpc Nov 12 17:58:29.567952 dockerd[1749]: time="2024-11-12T17:58:29.567805363Z" level=info msg="ccResolverWrapper: sending update to cc: {[{unix:///run/containerd/containerd.sock 0 }] }" module=grpc Nov 12 17:58:29.567952 dockerd[1749]: time="2024-11-12T17:58:29.567814499Z" level=info msg="ClientConn switching balancer to \"pick_first\"" module=grpc Nov 12 17:58:29.574113 systemd[1]: var-lib-docker-check\x2doverlayfs\x2dsupport2690208276-merged.mount: Deactivated successfully. Nov 12 17:58:29.722145 dockerd[1749]: time="2024-11-12T17:58:29.722031660Z" level=info msg="Loading containers: start." Nov 12 17:58:29.808419 kernel: Initializing XFRM netlink socket Nov 12 17:58:29.823427 dockerd[1749]: time="2024-11-12T17:58:29.823395143Z" level=info msg="Default bridge (docker0) is assigned with an IP address 172.17.0.0/16. Daemon option --bip can be used to set a preferred IP address" Nov 12 17:58:29.867438 systemd-networkd[1311]: docker0: Link UP Nov 12 17:58:29.888551 dockerd[1749]: time="2024-11-12T17:58:29.888523410Z" level=info msg="Loading containers: done." Nov 12 17:58:29.920496 systemd[1]: var-lib-docker-overlay2-opaque\x2dbug\x2dcheck590429622-merged.mount: Deactivated successfully. Nov 12 17:58:29.921778 dockerd[1749]: time="2024-11-12T17:58:29.921744274Z" level=warning msg="Not using native diff for overlay2, this may cause degraded performance for building images: kernel has CONFIG_OVERLAY_FS_REDIRECT_DIR enabled" storage-driver=overlay2 Nov 12 17:58:29.922116 dockerd[1749]: time="2024-11-12T17:58:29.922057285Z" level=info msg="Docker daemon" commit=3056208 graphdriver(s)=overlay2 version=20.10.21 Nov 12 17:58:29.922294 dockerd[1749]: time="2024-11-12T17:58:29.922274786Z" level=info msg="Daemon has completed initialization" Nov 12 17:58:29.937905 systemd[1]: Started docker.service - Docker Application Container Engine. Nov 12 17:58:29.943903 dockerd[1749]: time="2024-11-12T17:58:29.943857346Z" level=info msg="API listen on /run/docker.sock" Nov 12 17:58:30.951923 kernel: docker0: port 1(veth3926788) entered blocking state Nov 12 17:58:30.952082 kernel: docker0: port 1(veth3926788) entered disabled state Nov 12 17:58:30.952550 kernel: veth3926788: entered allmulticast mode Nov 12 17:58:30.953625 kernel: veth3926788: entered promiscuous mode Nov 12 17:58:30.953871 systemd-networkd[1311]: veth3926788: Link UP Nov 12 17:58:31.001871 containerd[1703]: time="2024-11-12T17:58:31.001738440Z" level=info msg="loading plugin \"io.containerd.event.v1.publisher\"..." runtime=io.containerd.runc.v2 type=io.containerd.event.v1 Nov 12 17:58:31.001871 containerd[1703]: time="2024-11-12T17:58:31.001786989Z" level=info msg="loading plugin \"io.containerd.internal.v1.shutdown\"..." runtime=io.containerd.runc.v2 type=io.containerd.internal.v1 Nov 12 17:58:31.001871 containerd[1703]: time="2024-11-12T17:58:31.001797881Z" level=info msg="loading plugin \"io.containerd.ttrpc.v1.task\"..." runtime=io.containerd.runc.v2 type=io.containerd.ttrpc.v1 Nov 12 17:58:31.002276 containerd[1703]: time="2024-11-12T17:58:31.002010165Z" level=info msg="starting signal loop" namespace=moby path=/run/containerd/io.containerd.runtime.v2.task/moby/8e5bd2f82bc4ee116a04830a944147fd5966def02d274af4800f6871fde18907 pid=1883 runtime=io.containerd.runc.v2 Nov 12 17:58:31.025522 systemd[1]: Started docker-8e5bd2f82bc4ee116a04830a944147fd5966def02d274af4800f6871fde18907.scope - libcontainer container 8e5bd2f82bc4ee116a04830a944147fd5966def02d274af4800f6871fde18907. Nov 12 17:58:31.104387 kernel: eth0: renamed from veth32726f2 Nov 12 17:58:31.110830 kernel: docker0: port 1(veth3926788) entered blocking state Nov 12 17:58:31.110875 kernel: docker0: port 1(veth3926788) entered forwarding state Nov 12 17:58:31.110818 systemd-networkd[1311]: veth3926788: Gained carrier Nov 12 17:58:31.111038 systemd-networkd[1311]: docker0: Gained carrier Nov 12 17:58:31.113338 systemd-resolved[1265]: Failed to determine the local hostname and LLMNR/mDNS names, ignoring: No such device or address Nov 12 17:58:31.131622 systemd[1]: docker-8e5bd2f82bc4ee116a04830a944147fd5966def02d274af4800f6871fde18907.scope: Deactivated successfully. Nov 12 17:58:31.142351 containerd[1703]: time="2024-11-12T17:58:31.142253719Z" level=info msg="shim disconnected" id=8e5bd2f82bc4ee116a04830a944147fd5966def02d274af4800f6871fde18907 Nov 12 17:58:31.142351 containerd[1703]: time="2024-11-12T17:58:31.142310025Z" level=warning msg="cleaning up after shim disconnected" id=8e5bd2f82bc4ee116a04830a944147fd5966def02d274af4800f6871fde18907 namespace=moby Nov 12 17:58:31.142351 containerd[1703]: time="2024-11-12T17:58:31.142319711Z" level=info msg="cleaning up dead shim" Nov 12 17:58:31.142480 dockerd[1749]: time="2024-11-12T17:58:31.142312718Z" level=info msg="ignoring event" container=8e5bd2f82bc4ee116a04830a944147fd5966def02d274af4800f6871fde18907 module=libcontainerd namespace=moby topic=/tasks/delete type="*events.TaskDelete" Nov 12 17:58:31.147717 containerd[1703]: time="2024-11-12T17:58:31.147688139Z" level=warning msg="cleanup warnings time=\"2024-11-12T17:58:31Z\" level=info msg=\"starting signal loop\" namespace=moby pid=1938 runtime=io.containerd.runc.v2\n" Nov 12 17:58:31.151403 systemd-networkd[1311]: veth3926788: Lost carrier Nov 12 17:58:31.151714 kernel: docker0: port 1(veth3926788) entered disabled state Nov 12 17:58:31.151739 kernel: veth32726f2: renamed from eth0 Nov 12 17:58:31.173394 systemd-networkd[1311]: veth3926788: Link DOWN Nov 12 17:58:31.174780 kernel: docker0: port 1(veth3926788) entered disabled state Nov 12 17:58:31.174825 kernel: veth3926788 (unregistering): left allmulticast mode Nov 12 17:58:31.174841 kernel: veth3926788 (unregistering): left promiscuous mode Nov 12 17:58:31.175747 kernel: docker0: port 1(veth3926788) entered disabled state Nov 12 17:58:31.207298 sshd[1619]: pam_unix(sshd:session): session closed for user core Nov 12 17:58:31.219678 systemd[1]: sshd@10-10.0.0.114:22-10.0.0.1:59190.service: Deactivated successfully. Nov 12 17:58:31.221160 systemd[1]: session-11.scope: Deactivated successfully. Nov 12 17:58:31.221845 systemd-logind[1353]: Session 11 logged out. Waiting for processes to exit. Nov 12 17:58:31.223463 systemd[1]: Started sshd@11-10.0.0.114:22-10.0.0.1:59200.service - OpenSSH per-connection server daemon (10.0.0.1:59200). Nov 12 17:58:31.225100 systemd-logind[1353]: Removed session 11. Nov 12 17:58:31.260203 sshd[1957]: Accepted publickey for core from 10.0.0.1 port 59200 ssh2: RSA SHA256:0/Njp3Vk1MHv0WcCO9/UA+beq4MlL3BRl9mBP4xwGAg Nov 12 17:58:31.261348 sshd[1957]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Nov 12 17:58:31.264786 systemd-logind[1353]: New session 12 of user core. Nov 12 17:58:31.274505 systemd[1]: Started session-12.scope - Session 12 of User core. Nov 12 17:58:31.341551 sshd[1957]: pam_unix(sshd:session): session closed for user core Nov 12 17:58:31.353771 systemd[1]: sshd@11-10.0.0.114:22-10.0.0.1:59200.service: Deactivated successfully. Nov 12 17:58:31.355186 systemd[1]: session-12.scope: Deactivated successfully. Nov 12 17:58:31.355762 systemd-logind[1353]: Session 12 logged out. Waiting for processes to exit. Nov 12 17:58:31.364612 systemd[1]: Started sshd@12-10.0.0.114:22-10.0.0.1:59206.service - OpenSSH per-connection server daemon (10.0.0.1:59206). Nov 12 17:58:31.365468 systemd-logind[1353]: Removed session 12. Nov 12 17:58:31.398009 sshd[1967]: Accepted publickey for core from 10.0.0.1 port 59206 ssh2: RSA SHA256:0/Njp3Vk1MHv0WcCO9/UA+beq4MlL3BRl9mBP4xwGAg Nov 12 17:58:31.399122 sshd[1967]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Nov 12 17:58:31.402352 systemd-logind[1353]: New session 13 of user core. Nov 12 17:58:31.415507 systemd[1]: Started session-13.scope - Session 13 of User core. Nov 12 17:58:31.921666 systemd[1]: run-docker-netns-2f0ebd4ce87b.mount: Deactivated successfully. Nov 12 17:58:31.921767 systemd[1]: var-lib-docker-overlay2-dadc1b247686bbc1fb4dc3d2e5400fd3153b5f273594896311ed577a7a5a8d8a-merged.mount: Deactivated successfully. Nov 12 17:58:31.950672 systemd-networkd[1311]: docker0: Lost carrier Nov 12 17:58:32.462608 systemd-networkd[1311]: docker0: Gained IPv6LL Nov 12 17:58:37.722115 sudo[1970]: core : PWD=/home/core ; USER=root ; COMMAND=/usr/bin/mv docker.raw containerd.raw /etc/extensions/ Nov 12 17:58:37.722440 sudo[1970]: pam_unix(sudo:session): session opened for user root(uid=0) by core(uid=500) Nov 12 17:58:37.883812 sudo[1970]: pam_unix(sudo:session): session closed for user root Nov 12 17:58:37.885556 sshd[1967]: pam_unix(sshd:session): session closed for user core Nov 12 17:58:37.897738 systemd[1]: sshd@12-10.0.0.114:22-10.0.0.1:59206.service: Deactivated successfully. Nov 12 17:58:37.899270 systemd[1]: session-13.scope: Deactivated successfully. Nov 12 17:58:37.899431 systemd[1]: session-13.scope: Consumed 3.722s CPU time. Nov 12 17:58:37.900431 systemd-logind[1353]: Session 13 logged out. Waiting for processes to exit. Nov 12 17:58:37.908615 systemd[1]: Started sshd@13-10.0.0.114:22-10.0.0.1:44080.service - OpenSSH per-connection server daemon (10.0.0.1:44080). Nov 12 17:58:37.909740 systemd-logind[1353]: Removed session 13. Nov 12 17:58:37.942183 sshd[2027]: Accepted publickey for core from 10.0.0.1 port 44080 ssh2: RSA SHA256:0/Njp3Vk1MHv0WcCO9/UA+beq4MlL3BRl9mBP4xwGAg Nov 12 17:58:37.943446 sshd[2027]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Nov 12 17:58:37.947019 systemd-logind[1353]: New session 14 of user core. Nov 12 17:58:37.958557 systemd[1]: Started session-14.scope - Session 14 of User core. Nov 12 17:58:38.008756 sudo[2031]: core : PWD=/home/core ; USER=root ; COMMAND=/usr/bin/systemctl restart systemd-sysext Nov 12 17:58:38.009057 sudo[2031]: pam_unix(sudo:session): session opened for user root(uid=0) by core(uid=500) Nov 12 17:58:38.016391 systemd[1]: ensure-sysext.service: Deactivated successfully. Nov 12 17:58:38.016564 systemd[1]: Stopped ensure-sysext.service. Nov 12 17:58:38.016615 systemd[1]: Stopping ensure-sysext.service... Nov 12 17:58:38.030585 systemd[1]: Stopping systemd-sysext.service - Merge System Extension Images into /usr/ and /opt/... Nov 12 17:58:38.034642 systemd-sysext[2033]: Unmerged '/usr'. Nov 12 17:58:38.038174 systemd[1]: systemd-sysext.service: Deactivated successfully. Nov 12 17:58:38.038377 systemd[1]: Stopped systemd-sysext.service - Merge System Extension Images into /usr/ and /opt/. Nov 12 17:58:38.041721 systemd[1]: Starting systemd-sysext.service - Merge System Extension Images into /usr/ and /opt/... Nov 12 17:58:38.049395 kernel: loop4: detected capacity change from 0 to 301272 Nov 12 17:58:38.053383 kernel: EXT4-fs (loop4): mounted filesystem 05db55c2-5928-40ca-9be7-51b2289e1f81 ro without journal. Quota mode: none. Nov 12 17:58:38.056378 kernel: EXT4-fs (loop4): unmounting filesystem 05db55c2-5928-40ca-9be7-51b2289e1f81. Nov 12 17:58:38.093379 kernel: loop5: detected capacity change from 0 to 320944 Nov 12 17:58:38.097380 kernel: EXT4-fs (loop5): mounted filesystem a9d3a5d7-9e1d-4482-a0bf-9ecd5608d818 ro without journal. Quota mode: none. Nov 12 17:58:38.099376 kernel: EXT4-fs (loop5): unmounting filesystem a9d3a5d7-9e1d-4482-a0bf-9ecd5608d818. Nov 12 17:58:38.128387 kernel: loop6: detected capacity change from 0 to 301272 Nov 12 17:58:38.132380 kernel: EXT4-fs (loop6): mounted filesystem 05db55c2-5928-40ca-9be7-51b2289e1f81 ro without journal. Quota mode: none. Nov 12 17:58:38.134385 kernel: loop7: detected capacity change from 0 to 320944 Nov 12 17:58:38.137303 (sd-merge)[2042]: Using extensions 'containerd', 'docker'. Nov 12 17:58:38.137558 kernel: EXT4-fs (loop7): mounted filesystem a9d3a5d7-9e1d-4482-a0bf-9ecd5608d818 ro without journal. Quota mode: none. Nov 12 17:58:38.137664 (sd-merge)[2042]: Merged extensions into '/usr'. Nov 12 17:58:38.140709 systemd[1]: Finished systemd-sysext.service - Merge System Extension Images into /usr/ and /opt/. Nov 12 17:58:38.142043 sudo[2031]: pam_unix(sudo:session): session closed for user root Nov 12 17:58:38.147513 sudo[2030]: core : PWD=/home/core ; USER=root ; COMMAND=/usr/bin/systemctl restart docker containerd Nov 12 17:58:38.147595 systemd[1]: Starting ensure-sysext.service... Nov 12 17:58:38.147786 sudo[2030]: pam_unix(sudo:session): session opened for user root(uid=0) by core(uid=500) Nov 12 17:58:38.162301 systemd[1]: Reloading requested from client PID 2046 ('systemctl') (unit ensure-sysext.service)... Nov 12 17:58:38.162316 systemd[1]: Reloading... Nov 12 17:58:38.229407 zram_generator::config[2087]: No configuration found. Nov 12 17:58:38.372016 systemd[1]: /usr/lib/systemd/system/docker.socket:5: ListenStream= references a path below legacy directory /var/run/, updating /var/run/docker.sock → /run/docker.sock; please update the unit file accordingly. Nov 12 17:58:38.421623 systemd[1]: Reloading finished in 259 ms. Nov 12 17:58:38.457372 systemd[1]: Stopped target sockets.target - Socket Units. Nov 12 17:58:38.457391 systemd[1]: Stopping sockets.target - Socket Units... Nov 12 17:58:38.457480 systemd[1]: Stopped target timers.target - Timer Units. Nov 12 17:58:38.457486 systemd[1]: Stopping timers.target - Timer Units... Nov 12 17:58:38.457578 systemd[1]: Reached target timers.target - Timer Units. Nov 12 17:58:38.457940 systemd[1]: Stopping docker.service - Docker Application Container Engine... Nov 12 17:58:38.458113 dockerd[1749]: time="2024-11-12T17:58:38.457857338Z" level=info msg="Processing signal 'terminated'" Nov 12 17:58:38.458991 dockerd[1749]: time="2024-11-12T17:58:38.458921280Z" level=info msg="stopping event stream following graceful shutdown" error="" module=libcontainerd namespace=moby Nov 12 17:58:38.459166 dockerd[1749]: time="2024-11-12T17:58:38.459092038Z" level=info msg="Daemon shutdown complete" Nov 12 17:58:38.459166 dockerd[1749]: time="2024-11-12T17:58:38.459111514Z" level=info msg="stopping event stream following graceful shutdown" error="context canceled" module=libcontainerd namespace=plugins.moby Nov 12 17:58:38.460802 systemd[1]: Stopped target multi-user.target - Multi-User System. Nov 12 17:58:38.460821 systemd[1]: Stopping multi-user.target - Multi-User System... Nov 12 17:58:38.460858 systemd[1]: update-engine-stub.timer - Update Engine Stub Timer was skipped because of an unmet condition check (ConditionPathExists=/usr/.noupdate). Nov 12 17:58:38.462256 systemd[1]: Starting coreos-metadata.service - QEMU metadata agent... Nov 12 17:58:38.463308 systemd[1]: Starting enable-oem-cloudinit.service - Enable cloudinit... Nov 12 17:58:38.464537 systemd[1]: Starting extend-filesystems.service - Extend Filesystems... Nov 12 17:58:38.467751 systemd[1]: Starting issuegen.service - Generate /run/issue... Nov 12 17:58:38.469619 jq[2121]: false Nov 12 17:58:38.469752 systemd[1]: Starting motdgen.service - Generate /run/flatcar/motd... Nov 12 17:58:38.471710 systemd[1]: Starting ssh-key-proc-cmdline.service - Install an ssh key from /proc/cmdline... Nov 12 17:58:38.471906 systemd[1]: sshkeys.service was skipped because no trigger condition checks were met. Nov 12 17:58:38.472102 systemd[1]: tcsd.service - TCG Core Services Daemon was skipped because of an unmet condition check (ConditionPathExists=/dev/tpm0). Nov 12 17:58:38.474022 systemd[1]: docker.service: Deactivated successfully. Nov 12 17:58:38.474322 systemd[1]: Stopped docker.service - Docker Application Container Engine. Nov 12 17:58:38.475933 systemd[1]: enable-oem-cloudinit.service: Skipped due to 'exec-condition'. Nov 12 17:58:38.476102 systemd[1]: Condition check resulted in enable-oem-cloudinit.service - Enable cloudinit being skipped. Nov 12 17:58:38.476690 systemd[1]: issuegen.service: Deactivated successfully. Nov 12 17:58:38.476852 systemd[1]: Finished issuegen.service - Generate /run/issue. Nov 12 17:58:38.479403 systemd[1]: Finished ensure-sysext.service. Nov 12 17:58:38.483877 systemd[1]: ssh-key-proc-cmdline.service: Deactivated successfully. Nov 12 17:58:38.484071 systemd[1]: Finished ssh-key-proc-cmdline.service - Install an ssh key from /proc/cmdline. Nov 12 17:58:38.485149 systemd[1]: docker.socket: Deactivated successfully. Nov 12 17:58:38.485608 systemd[1]: Closed docker.socket - Docker Socket for the API. Nov 12 17:58:38.485657 systemd[1]: Stopping docker.socket - Docker Socket for the API... Nov 12 17:58:38.486552 extend-filesystems[2122]: Found loop2 Nov 12 17:58:38.487979 extend-filesystems[2122]: Found loop3 Nov 12 17:58:38.487979 extend-filesystems[2122]: Found loop6 Nov 12 17:58:38.487979 extend-filesystems[2122]: Found loop7 Nov 12 17:58:38.487979 extend-filesystems[2122]: Found vda Nov 12 17:58:38.487979 extend-filesystems[2122]: Found vda1 Nov 12 17:58:38.487979 extend-filesystems[2122]: Found vda2 Nov 12 17:58:38.487979 extend-filesystems[2122]: Found vda3 Nov 12 17:58:38.487979 extend-filesystems[2122]: Found usr Nov 12 17:58:38.492644 containerd[1703]: time="2024-11-12T17:58:38.487692746Z" level=info msg="Stop CRI service" Nov 12 17:58:38.487197 systemd[1]: Starting docker.socket - Docker Socket for the API... Nov 12 17:58:38.492923 extend-filesystems[2122]: Found vda4 Nov 12 17:58:38.492923 extend-filesystems[2122]: Found vda6 Nov 12 17:58:38.492923 extend-filesystems[2122]: Found vda7 Nov 12 17:58:38.492923 extend-filesystems[2122]: Found vda9 Nov 12 17:58:38.492923 extend-filesystems[2122]: Checking size of /dev/vda9 Nov 12 17:58:38.487632 systemd[1]: Stopping containerd.service - containerd container runtime... Nov 12 17:58:38.488887 systemd[1]: Listening on docker.socket - Docker Socket for the API. Nov 12 17:58:38.489923 systemd[1]: motdgen.service: Deactivated successfully. Nov 12 17:58:38.490101 systemd[1]: Finished motdgen.service - Generate /run/flatcar/motd. Nov 12 17:58:38.491327 systemd[1]: Reached target sockets.target - Socket Units. Nov 12 17:58:38.495277 systemd[1]: coreos-metadata.service: Deactivated successfully. Nov 12 17:58:38.495639 systemd[1]: Finished coreos-metadata.service - QEMU metadata agent. Nov 12 17:58:38.496039 systemd[1]: packet-phone-home.service - Report Success to Packet was skipped because of an unmet condition check (ConditionFirstBoot=true). Nov 12 17:58:38.498016 systemd[1]: containerd.service: Deactivated successfully. Nov 12 17:58:38.498280 systemd[1]: Stopped containerd.service - containerd container runtime. Nov 12 17:58:38.499124 extend-filesystems[2122]: Old size kept for /dev/vda9 Nov 12 17:58:38.504936 kernel: BTRFS warning: duplicate device /dev/vda3 devid 1 generation 40 scanned by (udev-worker) (2152) Nov 12 17:58:38.507842 systemd[1]: Starting containerd.service - containerd container runtime... Nov 12 17:58:38.508417 systemd[1]: extend-filesystems.service: Deactivated successfully. Nov 12 17:58:38.508898 systemd[1]: Finished extend-filesystems.service - Extend Filesystems. Nov 12 17:58:38.518314 systemd[1]: Started containerd.service - containerd container runtime. Nov 12 17:58:38.525004 systemd[1]: Reached target multi-user.target - Multi-User System. Nov 12 17:58:38.526559 systemd[1]: Starting docker.service - Docker Application Container Engine... Nov 12 17:58:38.534882 (dockerd)[2164]: docker.service: Referenced but unset environment variable evaluates to an empty string: DOCKER_CGROUPS, DOCKER_OPTS, DOCKER_OPT_BIP, DOCKER_OPT_IPMASQ, DOCKER_OPT_MTU Nov 12 17:58:38.769304 containerd[2162]: time="2024-11-12T17:58:38.769142618Z" level=info msg="starting containerd" revision=926c9586fe4a6236699318391cd44976a98e31f1 version=v1.7.15 Nov 12 17:58:38.797264 containerd[2162]: time="2024-11-12T17:58:38.797156072Z" level=info msg="loading plugin \"io.containerd.event.v1.exchange\"..." type=io.containerd.event.v1 Nov 12 17:58:38.797264 containerd[2162]: time="2024-11-12T17:58:38.797208810Z" level=info msg="loading plugin \"io.containerd.internal.v1.opt\"..." type=io.containerd.internal.v1 Nov 12 17:58:38.797264 containerd[2162]: time="2024-11-12T17:58:38.797241912Z" level=info msg="loading plugin \"io.containerd.warning.v1.deprecations\"..." type=io.containerd.warning.v1 Nov 12 17:58:38.797264 containerd[2162]: time="2024-11-12T17:58:38.797255938Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.blockfile\"..." type=io.containerd.snapshotter.v1 Nov 12 17:58:38.797473 containerd[2162]: time="2024-11-12T17:58:38.797387904Z" level=info msg="skip loading plugin \"io.containerd.snapshotter.v1.blockfile\"..." error="no scratch file generator: skip plugin" type=io.containerd.snapshotter.v1 Nov 12 17:58:38.797473 containerd[2162]: time="2024-11-12T17:58:38.797403292Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.devmapper\"..." type=io.containerd.snapshotter.v1 Nov 12 17:58:38.797473 containerd[2162]: time="2024-11-12T17:58:38.797423249Z" level=warning msg="failed to load plugin io.containerd.snapshotter.v1.devmapper" error="devmapper not configured" Nov 12 17:58:38.797473 containerd[2162]: time="2024-11-12T17:58:38.797432747Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.native\"..." type=io.containerd.snapshotter.v1 Nov 12 17:58:38.797473 containerd[2162]: time="2024-11-12T17:58:38.797453626Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.overlayfs\"..." type=io.containerd.snapshotter.v1 Nov 12 17:58:38.797590 containerd[2162]: time="2024-11-12T17:58:38.797567558Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.aufs\"..." type=io.containerd.snapshotter.v1 Nov 12 17:58:38.799079 containerd[2162]: time="2024-11-12T17:58:38.799019382Z" 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.60-flatcar\\n\"): skip plugin" type=io.containerd.snapshotter.v1 Nov 12 17:58:38.799079 containerd[2162]: time="2024-11-12T17:58:38.799057012Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.zfs\"..." type=io.containerd.snapshotter.v1 Nov 12 17:58:38.799200 containerd[2162]: time="2024-11-12T17:58:38.799181524Z" 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 Nov 12 17:58:38.799242 containerd[2162]: time="2024-11-12T17:58:38.799198957Z" level=info msg="loading plugin \"io.containerd.content.v1.content\"..." type=io.containerd.content.v1 Nov 12 17:58:38.799242 containerd[2162]: time="2024-11-12T17:58:38.799225967Z" level=info msg="loading plugin \"io.containerd.metadata.v1.bolt\"..." type=io.containerd.metadata.v1 Nov 12 17:58:38.799294 containerd[2162]: time="2024-11-12T17:58:38.799241837Z" level=warning msg="could not use snapshotter devmapper in metadata plugin" error="devmapper not configured" Nov 12 17:58:38.799294 containerd[2162]: time="2024-11-12T17:58:38.799250533Z" level=info msg="metadata content store policy set" policy=shared Nov 12 17:58:38.799495 containerd[2162]: time="2024-11-12T17:58:38.799464411Z" level=info msg="loading plugin \"io.containerd.gc.v1.scheduler\"..." type=io.containerd.gc.v1 Nov 12 17:58:38.799533 containerd[2162]: time="2024-11-12T17:58:38.799503404Z" level=info msg="loading plugin \"io.containerd.differ.v1.walking\"..." type=io.containerd.differ.v1 Nov 12 17:58:38.799533 containerd[2162]: time="2024-11-12T17:58:38.799518953Z" level=info msg="loading plugin \"io.containerd.lease.v1.manager\"..." type=io.containerd.lease.v1 Nov 12 17:58:38.799568 containerd[2162]: time="2024-11-12T17:58:38.799533019Z" level=info msg="loading plugin \"io.containerd.streaming.v1.manager\"..." type=io.containerd.streaming.v1 Nov 12 17:58:38.799568 containerd[2162]: time="2024-11-12T17:58:38.799547726Z" level=info msg="loading plugin \"io.containerd.runtime.v1.linux\"..." type=io.containerd.runtime.v1 Nov 12 17:58:38.799604 containerd[2162]: time="2024-11-12T17:58:38.799585436Z" level=info msg="loading plugin \"io.containerd.monitor.v1.cgroups\"..." type=io.containerd.monitor.v1 Nov 12 17:58:38.800380 containerd[2162]: time="2024-11-12T17:58:38.800135220Z" level=info msg="loading plugin \"io.containerd.runtime.v2.task\"..." type=io.containerd.runtime.v2 Nov 12 17:58:38.800380 containerd[2162]: time="2024-11-12T17:58:38.800263660Z" level=info msg="loading plugin \"io.containerd.runtime.v2.shim\"..." type=io.containerd.runtime.v2 Nov 12 17:58:38.800380 containerd[2162]: time="2024-11-12T17:58:38.800279489Z" level=info msg="loading plugin \"io.containerd.sandbox.store.v1.local\"..." type=io.containerd.sandbox.store.v1 Nov 12 17:58:38.800380 containerd[2162]: time="2024-11-12T17:58:38.800293115Z" level=info msg="loading plugin \"io.containerd.sandbox.controller.v1.local\"..." type=io.containerd.sandbox.controller.v1 Nov 12 17:58:38.800380 containerd[2162]: time="2024-11-12T17:58:38.800306459Z" level=info msg="loading plugin \"io.containerd.service.v1.containers-service\"..." type=io.containerd.service.v1 Nov 12 17:58:38.800380 containerd[2162]: time="2024-11-12T17:58:38.800319243Z" level=info msg="loading plugin \"io.containerd.service.v1.content-service\"..." type=io.containerd.service.v1 Nov 12 17:58:38.800380 containerd[2162]: time="2024-11-12T17:58:38.800331426Z" level=info msg="loading plugin \"io.containerd.service.v1.diff-service\"..." type=io.containerd.service.v1 Nov 12 17:58:38.800380 containerd[2162]: time="2024-11-12T17:58:38.800345292Z" level=info msg="loading plugin \"io.containerd.service.v1.images-service\"..." type=io.containerd.service.v1 Nov 12 17:58:38.800380 containerd[2162]: time="2024-11-12T17:58:38.800371340Z" level=info msg="loading plugin \"io.containerd.service.v1.introspection-service\"..." type=io.containerd.service.v1 Nov 12 17:58:38.800380 containerd[2162]: time="2024-11-12T17:58:38.800385927Z" level=info msg="loading plugin \"io.containerd.service.v1.namespaces-service\"..." type=io.containerd.service.v1 Nov 12 17:58:38.800612 containerd[2162]: time="2024-11-12T17:58:38.800398471Z" level=info msg="loading plugin \"io.containerd.service.v1.snapshots-service\"..." type=io.containerd.service.v1 Nov 12 17:58:38.800612 containerd[2162]: time="2024-11-12T17:58:38.800409852Z" level=info msg="loading plugin \"io.containerd.service.v1.tasks-service\"..." type=io.containerd.service.v1 Nov 12 17:58:38.800612 containerd[2162]: time="2024-11-12T17:58:38.800436942Z" level=info msg="loading plugin \"io.containerd.grpc.v1.containers\"..." type=io.containerd.grpc.v1 Nov 12 17:58:38.800612 containerd[2162]: time="2024-11-12T17:58:38.800453694Z" level=info msg="loading plugin \"io.containerd.grpc.v1.content\"..." type=io.containerd.grpc.v1 Nov 12 17:58:38.800612 containerd[2162]: time="2024-11-12T17:58:38.800466958Z" level=info msg="loading plugin \"io.containerd.grpc.v1.diff\"..." type=io.containerd.grpc.v1 Nov 12 17:58:38.800612 containerd[2162]: time="2024-11-12T17:58:38.800482948Z" level=info msg="loading plugin \"io.containerd.grpc.v1.events\"..." type=io.containerd.grpc.v1 Nov 12 17:58:38.800612 containerd[2162]: time="2024-11-12T17:58:38.800494890Z" level=info msg="loading plugin \"io.containerd.grpc.v1.images\"..." type=io.containerd.grpc.v1 Nov 12 17:58:38.800612 containerd[2162]: time="2024-11-12T17:58:38.800507153Z" level=info msg="loading plugin \"io.containerd.grpc.v1.introspection\"..." type=io.containerd.grpc.v1 Nov 12 17:58:38.800612 containerd[2162]: time="2024-11-12T17:58:38.800518334Z" level=info msg="loading plugin \"io.containerd.grpc.v1.leases\"..." type=io.containerd.grpc.v1 Nov 12 17:58:38.800612 containerd[2162]: time="2024-11-12T17:58:38.800531519Z" level=info msg="loading plugin \"io.containerd.grpc.v1.namespaces\"..." type=io.containerd.grpc.v1 Nov 12 17:58:38.800612 containerd[2162]: time="2024-11-12T17:58:38.800544503Z" level=info msg="loading plugin \"io.containerd.grpc.v1.sandbox-controllers\"..." type=io.containerd.grpc.v1 Nov 12 17:58:38.800612 containerd[2162]: time="2024-11-12T17:58:38.800557968Z" level=info msg="loading plugin \"io.containerd.grpc.v1.sandboxes\"..." type=io.containerd.grpc.v1 Nov 12 17:58:38.800612 containerd[2162]: time="2024-11-12T17:58:38.800568908Z" level=info msg="loading plugin \"io.containerd.grpc.v1.snapshots\"..." type=io.containerd.grpc.v1 Nov 12 17:58:38.800612 containerd[2162]: time="2024-11-12T17:58:38.800580209Z" level=info msg="loading plugin \"io.containerd.grpc.v1.streaming\"..." type=io.containerd.grpc.v1 Nov 12 17:58:38.800916 containerd[2162]: time="2024-11-12T17:58:38.800591510Z" level=info msg="loading plugin \"io.containerd.grpc.v1.tasks\"..." type=io.containerd.grpc.v1 Nov 12 17:58:38.800916 containerd[2162]: time="2024-11-12T17:58:38.800607019Z" level=info msg="loading plugin \"io.containerd.transfer.v1.local\"..." type=io.containerd.transfer.v1 Nov 12 17:58:38.800916 containerd[2162]: time="2024-11-12T17:58:38.800637676Z" level=info msg="loading plugin \"io.containerd.grpc.v1.transfer\"..." type=io.containerd.grpc.v1 Nov 12 17:58:38.800916 containerd[2162]: time="2024-11-12T17:58:38.800650701Z" level=info msg="loading plugin \"io.containerd.grpc.v1.version\"..." type=io.containerd.grpc.v1 Nov 12 17:58:38.800916 containerd[2162]: time="2024-11-12T17:58:38.800663164Z" level=info msg="loading plugin \"io.containerd.internal.v1.restart\"..." type=io.containerd.internal.v1 Nov 12 17:58:38.801424 containerd[2162]: time="2024-11-12T17:58:38.801393724Z" level=info msg="loading plugin \"io.containerd.tracing.processor.v1.otlp\"..." type=io.containerd.tracing.processor.v1 Nov 12 17:58:38.801484 containerd[2162]: time="2024-11-12T17:58:38.801435121Z" level=info msg="skip loading plugin \"io.containerd.tracing.processor.v1.otlp\"..." error="no OpenTelemetry endpoint: skip plugin" type=io.containerd.tracing.processor.v1 Nov 12 17:58:38.801484 containerd[2162]: time="2024-11-12T17:58:38.801452754Z" level=info msg="loading plugin \"io.containerd.internal.v1.tracing\"..." type=io.containerd.internal.v1 Nov 12 17:58:38.801537 containerd[2162]: time="2024-11-12T17:58:38.801482570Z" level=info msg="skipping tracing processor initialization (no tracing plugin)" error="no OpenTelemetry endpoint: skip plugin" Nov 12 17:58:38.801937 containerd[2162]: time="2024-11-12T17:58:38.801902472Z" level=info msg="loading plugin \"io.containerd.grpc.v1.healthcheck\"..." type=io.containerd.grpc.v1 Nov 12 17:58:38.801937 containerd[2162]: time="2024-11-12T17:58:38.801923070Z" level=info msg="loading plugin \"io.containerd.nri.v1.nri\"..." type=io.containerd.nri.v1 Nov 12 17:58:38.801937 containerd[2162]: time="2024-11-12T17:58:38.801933570Z" level=info msg="NRI interface is disabled by configuration." Nov 12 17:58:38.802030 containerd[2162]: time="2024-11-12T17:58:38.801944390Z" level=info msg="loading plugin \"io.containerd.grpc.v1.cri\"..." type=io.containerd.grpc.v1 Nov 12 17:58:38.802594 containerd[2162]: time="2024-11-12T17:58:38.802307787Z" level=info msg="Start cri plugin with config {PluginConfig:{ContainerdConfig:{Snapshotter:overlayfs DefaultRuntimeName:runc DefaultRuntime:{Type: Path: Engine: PodAnnotations:[] ContainerAnnotations:[] Root: Options:map[] PrivilegedWithoutHostDevices:false PrivilegedWithoutHostDevicesAllDevicesAllowed:false BaseRuntimeSpec: NetworkPluginConfDir: NetworkPluginMaxConfNum:0 Snapshotter: SandboxMode:} UntrustedWorkloadRuntime:{Type: Path: Engine: PodAnnotations:[] ContainerAnnotations:[] Root: Options:map[] PrivilegedWithoutHostDevices:false PrivilegedWithoutHostDevicesAllDevicesAllowed:false BaseRuntimeSpec: NetworkPluginConfDir: NetworkPluginMaxConfNum:0 Snapshotter: SandboxMode:} Runtimes:map[runc:{Type:io.containerd.runc.v2 Path: Engine: PodAnnotations:[] ContainerAnnotations:[] Root: Options:map[SystemdCgroup:true] PrivilegedWithoutHostDevices:false PrivilegedWithoutHostDevicesAllDevicesAllowed:false BaseRuntimeSpec: NetworkPluginConfDir: NetworkPluginMaxConfNum:0 Snapshotter: SandboxMode:podsandbox}] NoPivot:false DisableSnapshotAnnotations:true DiscardUnpackedLayers:false IgnoreBlockIONotEnabledErrors:false IgnoreRdtNotEnabledErrors:false} CniConfig:{NetworkPluginBinDir:/opt/cni/bin NetworkPluginConfDir:/etc/cni/net.d NetworkPluginMaxConfNum:1 NetworkPluginSetupSerially:false NetworkPluginConfTemplate: IPPreference:} Registry:{ConfigPath: Mirrors:map[] Configs:map[] Auths:map[] Headers:map[]} ImageDecryption:{KeyModel:node} DisableTCPService:true StreamServerAddress:127.0.0.1 StreamServerPort:0 StreamIdleTimeout:4h0m0s EnableSelinux:false SelinuxCategoryRange:1024 SandboxImage:registry.k8s.io/pause:3.8 StatsCollectPeriod:10 SystemdCgroup:false EnableTLSStreaming:false X509KeyPairStreaming:{TLSCertFile: TLSKeyFile:} MaxContainerLogLineSize:16384 DisableCgroup:false DisableApparmor:false RestrictOOMScoreAdj:false MaxConcurrentDownloads:3 DisableProcMount:false UnsetSeccompProfile: TolerateMissingHugetlbController:true DisableHugetlbController:true DeviceOwnershipFromSecurityContext:false IgnoreImageDefinedVolumes:false NetNSMountsUnderStateDir:false EnableUnprivilegedPorts:false EnableUnprivilegedICMP:false EnableCDI:false CDISpecDirs:[/etc/cdi /var/run/cdi] ImagePullProgressTimeout:5m0s DrainExecSyncIOTimeout:0s ImagePullWithSyncFs:false IgnoreDeprecationWarnings:[]} ContainerdRootDir:/var/lib/containerd ContainerdEndpoint:/run/containerd/containerd.sock RootDir:/var/lib/containerd/io.containerd.grpc.v1.cri StateDir:/run/containerd/io.containerd.grpc.v1.cri}" Nov 12 17:58:38.802594 containerd[2162]: time="2024-11-12T17:58:38.802386854Z" level=info msg="Connect containerd service" Nov 12 17:58:38.802594 containerd[2162]: time="2024-11-12T17:58:38.802431537Z" level=info msg="using legacy CRI server" Nov 12 17:58:38.802594 containerd[2162]: time="2024-11-12T17:58:38.802442117Z" level=info msg="using experimental NRI integration - disable nri plugin to prevent this" Nov 12 17:58:38.802755 containerd[2162]: time="2024-11-12T17:58:38.802617403Z" level=info msg="Get image filesystem path \"/var/lib/containerd/io.containerd.snapshotter.v1.overlayfs\"" Nov 12 17:58:38.803341 containerd[2162]: time="2024-11-12T17:58:38.803230185Z" 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" Nov 12 17:58:38.803716 containerd[2162]: time="2024-11-12T17:58:38.803668120Z" level=info msg="Start subscribing containerd event" Nov 12 17:58:38.803754 containerd[2162]: time="2024-11-12T17:58:38.803739213Z" level=info msg="Start recovering state" Nov 12 17:58:38.805299 containerd[2162]: time="2024-11-12T17:58:38.805249626Z" level=info msg="Start event monitor" Nov 12 17:58:38.805501 containerd[2162]: time="2024-11-12T17:58:38.805480095Z" level=info msg="Start snapshots syncer" Nov 12 17:58:38.805540 containerd[2162]: time="2024-11-12T17:58:38.805504981Z" level=info msg="Start cni network conf syncer for default" Nov 12 17:58:38.805540 containerd[2162]: time="2024-11-12T17:58:38.805513036Z" level=info msg="Start streaming server" Nov 12 17:58:38.805719 containerd[2162]: time="2024-11-12T17:58:38.805683474Z" level=info msg=serving... address=/run/containerd/containerd.sock.ttrpc Nov 12 17:58:38.805771 containerd[2162]: time="2024-11-12T17:58:38.805757933Z" level=info msg=serving... address=/run/containerd/containerd.sock Nov 12 17:58:38.805937 containerd[2162]: time="2024-11-12T17:58:38.805808346Z" level=info msg="containerd successfully booted in 0.037913s" Nov 12 17:58:38.841787 dockerd[2164]: time="2024-11-12T17:58:38.841734257Z" level=info msg="Starting up" Nov 12 17:58:39.023247 dockerd[2164]: time="2024-11-12T17:58:39.022949374Z" level=info msg="[graphdriver] using prior storage driver: overlay2" Nov 12 17:58:39.029761 dockerd[2164]: time="2024-11-12T17:58:39.029723336Z" level=info msg="Loading containers: start." Nov 12 17:58:39.301868 dockerd[2164]: time="2024-11-12T17:58:39.301754278Z" level=info msg="Default bridge (docker0) is assigned with an IP address 172.17.0.0/16. Daemon option --bip can be used to set a preferred IP address" Nov 12 17:58:39.349899 dockerd[2164]: time="2024-11-12T17:58:39.349795868Z" level=info msg="Loading containers: done." Nov 12 17:58:39.360834 systemd[1]: var-lib-docker-overlay2-opaque\x2dbug\x2dcheck2075363436-merged.mount: Deactivated successfully. Nov 12 17:58:39.362001 dockerd[2164]: time="2024-11-12T17:58:39.361958653Z" level=warning msg="Not using native diff for overlay2, this may cause degraded performance for building images: kernel has CONFIG_OVERLAY_FS_REDIRECT_DIR enabled" storage-driver=overlay2 Nov 12 17:58:39.362109 dockerd[2164]: time="2024-11-12T17:58:39.362070676Z" level=info msg="Docker daemon" commit=c8af8eb containerd-snapshotter=false storage-driver=overlay2 version=26.1.0 Nov 12 17:58:39.362164 dockerd[2164]: time="2024-11-12T17:58:39.362109059Z" level=info msg="Daemon has completed initialization" Nov 12 17:58:39.384514 dockerd[2164]: time="2024-11-12T17:58:39.384408488Z" level=info msg="API listen on /run/docker.sock" Nov 12 17:58:39.384544 systemd[1]: Started docker.service - Docker Application Container Engine. Nov 12 17:58:39.385715 sudo[2030]: pam_unix(sudo:session): session closed for user root Nov 12 17:58:39.387319 sshd[2027]: pam_unix(sshd:session): session closed for user core Nov 12 17:58:39.395385 kernel: EXT4-fs (loop2): unmounting filesystem 69303782-95eb-4e60-9df1-7a17fe2a6733. Nov 12 17:58:39.395964 systemd-logind[1353]: Session 14 logged out. Waiting for processes to exit. Nov 12 17:58:39.397607 systemd[1]: Started sshd@14-10.0.0.114:22-10.0.0.1:44090.service - OpenSSH per-connection server daemon (10.0.0.1:44090). Nov 12 17:58:39.402472 kernel: EXT4-fs (loop3): unmounting filesystem 1b886f42-7890-445d-b61d-62de1782cd8c. Nov 12 17:58:39.428689 systemd[1]: sshd@13-10.0.0.114:22-10.0.0.1:44080.service: Deactivated successfully. Nov 12 17:58:39.430605 systemd[1]: session-14.scope: Deactivated successfully. Nov 12 17:58:39.431691 systemd-logind[1353]: Removed session 14. Nov 12 17:58:39.435489 sshd[2323]: Accepted publickey for core from 10.0.0.1 port 44090 ssh2: RSA SHA256:0/Njp3Vk1MHv0WcCO9/UA+beq4MlL3BRl9mBP4xwGAg Nov 12 17:58:39.436846 sshd[2323]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Nov 12 17:58:39.440835 systemd-logind[1353]: New session 15 of user core. Nov 12 17:58:39.452554 systemd[1]: Started session-15.scope - Session 15 of User core. Nov 12 17:58:39.561055 systemd[1]: var-lib-docker-overlay2-6955fdc5151cbe763d6f9cc22e6b5df2f6471c6b237cef769d988917b514b1d7\x2dinit-merged.mount: Deactivated successfully. Nov 12 17:58:39.587554 kernel: docker0: port 1(veth73f9f29) entered blocking state Nov 12 17:58:39.587656 kernel: docker0: port 1(veth73f9f29) entered disabled state Nov 12 17:58:39.587673 kernel: veth73f9f29: entered allmulticast mode Nov 12 17:58:39.588392 kernel: veth73f9f29: entered promiscuous mode Nov 12 17:58:39.589573 systemd-networkd[1311]: veth73f9f29: Link UP Nov 12 17:58:39.644822 containerd[2162]: time="2024-11-12T17:58:39.644729502Z" level=info msg="loading plugin \"io.containerd.event.v1.publisher\"..." runtime=io.containerd.runc.v2 type=io.containerd.event.v1 Nov 12 17:58:39.644822 containerd[2162]: time="2024-11-12T17:58:39.644790201Z" level=info msg="loading plugin \"io.containerd.internal.v1.shutdown\"..." runtime=io.containerd.runc.v2 type=io.containerd.internal.v1 Nov 12 17:58:39.644822 containerd[2162]: time="2024-11-12T17:58:39.644801419Z" level=info msg="loading plugin \"io.containerd.ttrpc.v1.task\"..." runtime=io.containerd.runc.v2 type=io.containerd.ttrpc.v1 Nov 12 17:58:39.645183 containerd[2162]: time="2024-11-12T17:58:39.645141052Z" level=info msg="loading plugin \"io.containerd.ttrpc.v1.pause\"..." runtime=io.containerd.runc.v2 type=io.containerd.ttrpc.v1 Nov 12 17:58:39.667041 systemd[1]: Started docker-5f6260d435bf84f3702ceed18ce7f9e4cf84ff29ffbc6c47ea8395d1f6664229.scope - libcontainer container 5f6260d435bf84f3702ceed18ce7f9e4cf84ff29ffbc6c47ea8395d1f6664229. Nov 12 17:58:39.722468 kernel: eth0: renamed from veth449d2ba Nov 12 17:58:39.730291 kernel: docker0: port 1(veth73f9f29) entered blocking state Nov 12 17:58:39.730351 kernel: docker0: port 1(veth73f9f29) entered forwarding state Nov 12 17:58:39.730002 systemd-networkd[1311]: veth73f9f29: Gained carrier Nov 12 17:58:39.730195 systemd-networkd[1311]: docker0: Gained carrier Nov 12 17:58:39.733034 systemd-resolved[1265]: Failed to determine the local hostname and LLMNR/mDNS names, ignoring: No such device or address Nov 12 17:58:39.751819 systemd[1]: docker-5f6260d435bf84f3702ceed18ce7f9e4cf84ff29ffbc6c47ea8395d1f6664229.scope: Deactivated successfully. Nov 12 17:58:39.766114 dockerd[2164]: time="2024-11-12T17:58:39.766049498Z" level=info msg="ignoring event" container=5f6260d435bf84f3702ceed18ce7f9e4cf84ff29ffbc6c47ea8395d1f6664229 module=libcontainerd namespace=moby topic=/tasks/delete type="*events.TaskDelete" Nov 12 17:58:39.766729 containerd[2162]: time="2024-11-12T17:58:39.766567903Z" level=info msg="shim disconnected" id=5f6260d435bf84f3702ceed18ce7f9e4cf84ff29ffbc6c47ea8395d1f6664229 namespace=moby Nov 12 17:58:39.766729 containerd[2162]: time="2024-11-12T17:58:39.766604443Z" level=warning msg="cleaning up after shim disconnected" id=5f6260d435bf84f3702ceed18ce7f9e4cf84ff29ffbc6c47ea8395d1f6664229 namespace=moby Nov 12 17:58:39.766729 containerd[2162]: time="2024-11-12T17:58:39.766613217Z" level=info msg="cleaning up dead shim" namespace=moby Nov 12 17:58:39.783389 kernel: veth449d2ba: renamed from eth0 Nov 12 17:58:39.792184 systemd-networkd[1311]: veth73f9f29: Lost carrier Nov 12 17:58:39.792818 kernel: docker0: port 1(veth73f9f29) entered disabled state Nov 12 17:58:39.800458 kernel: docker0: port 1(veth73f9f29) entered disabled state Nov 12 17:58:39.799857 systemd-networkd[1311]: veth73f9f29: Link DOWN Nov 12 17:58:39.801590 kernel: veth73f9f29 (unregistering): left allmulticast mode Nov 12 17:58:39.801641 kernel: veth73f9f29 (unregistering): left promiscuous mode Nov 12 17:58:39.801657 kernel: docker0: port 1(veth73f9f29) entered disabled state Nov 12 17:58:39.840949 sshd[2323]: pam_unix(sshd:session): session closed for user core Nov 12 17:58:39.844903 systemd[1]: sshd@14-10.0.0.114:22-10.0.0.1:44090.service: Deactivated successfully. Nov 12 17:58:39.846652 systemd[1]: session-15.scope: Deactivated successfully. Nov 12 17:58:39.847885 systemd-logind[1353]: Session 15 logged out. Waiting for processes to exit. Nov 12 17:58:39.848853 systemd-logind[1353]: Removed session 15. Nov 12 17:58:40.590751 systemd-networkd[1311]: docker0: Lost carrier