Nov 12 22:20:52.895133 kernel: Booting Linux on physical CPU 0x0000000000 [0x413fd0c1] Nov 12 22:20:52.895156 kernel: Linux version 6.6.60-flatcar (build@pony-truck.infra.kinvolk.io) (aarch64-cros-linux-gnu-gcc (Gentoo Hardened 13.3.1_p20240614 p1) 13.3.1 20240614, GNU ld (Gentoo 2.42 p6) 2.42.0) #1 SMP PREEMPT Tue Nov 12 21:07:55 -00 2024 Nov 12 22:20:52.895166 kernel: KASLR enabled Nov 12 22:20:52.895178 kernel: efi: EFI v2.7 by EDK II Nov 12 22:20:52.895184 kernel: efi: SMBIOS 3.0=0xdced0000 MEMATTR=0xdbbbf018 ACPI 2.0=0xd9b43018 RNG=0xd9b43a18 MEMRESERVE=0xd9b40d98 Nov 12 22:20:52.895190 kernel: random: crng init done Nov 12 22:20:52.895197 kernel: secureboot: Secure boot disabled Nov 12 22:20:52.895203 kernel: ACPI: Early table checksum verification disabled Nov 12 22:20:52.895208 kernel: ACPI: RSDP 0x00000000D9B43018 000024 (v02 BOCHS ) Nov 12 22:20:52.895216 kernel: ACPI: XSDT 0x00000000D9B43F18 000064 (v01 BOCHS BXPC 00000001 01000013) Nov 12 22:20:52.895222 kernel: ACPI: FACP 0x00000000D9B43B18 000114 (v06 BOCHS BXPC 00000001 BXPC 00000001) Nov 12 22:20:52.895228 kernel: ACPI: DSDT 0x00000000D9B41018 0014A2 (v02 BOCHS BXPC 00000001 BXPC 00000001) Nov 12 22:20:52.895233 kernel: ACPI: APIC 0x00000000D9B43C98 0001A8 (v04 BOCHS BXPC 00000001 BXPC 00000001) Nov 12 22:20:52.895239 kernel: ACPI: PPTT 0x00000000D9B43098 00009C (v02 BOCHS BXPC 00000001 BXPC 00000001) Nov 12 22:20:52.895247 kernel: ACPI: GTDT 0x00000000D9B43818 000060 (v02 BOCHS BXPC 00000001 BXPC 00000001) Nov 12 22:20:52.895254 kernel: ACPI: MCFG 0x00000000D9B43A98 00003C (v01 BOCHS BXPC 00000001 BXPC 00000001) Nov 12 22:20:52.895260 kernel: ACPI: SPCR 0x00000000D9B43918 000050 (v02 BOCHS BXPC 00000001 BXPC 00000001) Nov 12 22:20:52.895266 kernel: ACPI: DBG2 0x00000000D9B43998 000057 (v00 BOCHS BXPC 00000001 BXPC 00000001) Nov 12 22:20:52.895272 kernel: ACPI: IORT 0x00000000D9B43198 000080 (v03 BOCHS BXPC 00000001 BXPC 00000001) Nov 12 22:20:52.895278 kernel: ACPI: SPCR: console: pl011,mmio,0x9000000,9600 Nov 12 22:20:52.895285 kernel: NUMA: Failed to initialise from firmware Nov 12 22:20:52.895291 kernel: NUMA: Faking a node at [mem 0x0000000040000000-0x00000000dcffffff] Nov 12 22:20:52.895297 kernel: NUMA: NODE_DATA [mem 0xdc958800-0xdc95dfff] Nov 12 22:20:52.895303 kernel: Zone ranges: Nov 12 22:20:52.895309 kernel: DMA [mem 0x0000000040000000-0x00000000dcffffff] Nov 12 22:20:52.895316 kernel: DMA32 empty Nov 12 22:20:52.895325 kernel: Normal empty Nov 12 22:20:52.895331 kernel: Movable zone start for each node Nov 12 22:20:52.895337 kernel: Early memory node ranges Nov 12 22:20:52.895343 kernel: node 0: [mem 0x0000000040000000-0x00000000d976ffff] Nov 12 22:20:52.895349 kernel: node 0: [mem 0x00000000d9770000-0x00000000d9b3ffff] Nov 12 22:20:52.895356 kernel: node 0: [mem 0x00000000d9b40000-0x00000000dce1ffff] Nov 12 22:20:52.895362 kernel: node 0: [mem 0x00000000dce20000-0x00000000dceaffff] Nov 12 22:20:52.895368 kernel: node 0: [mem 0x00000000dceb0000-0x00000000dcebffff] Nov 12 22:20:52.895374 kernel: node 0: [mem 0x00000000dcec0000-0x00000000dcfdffff] Nov 12 22:20:52.895380 kernel: node 0: [mem 0x00000000dcfe0000-0x00000000dcffffff] Nov 12 22:20:52.895386 kernel: Initmem setup node 0 [mem 0x0000000040000000-0x00000000dcffffff] Nov 12 22:20:52.895393 kernel: On node 0, zone DMA: 12288 pages in unavailable ranges Nov 12 22:20:52.895400 kernel: psci: probing for conduit method from ACPI. Nov 12 22:20:52.895406 kernel: psci: PSCIv1.1 detected in firmware. Nov 12 22:20:52.895414 kernel: psci: Using standard PSCI v0.2 function IDs Nov 12 22:20:52.895421 kernel: psci: Trusted OS migration not required Nov 12 22:20:52.895428 kernel: psci: SMC Calling Convention v1.1 Nov 12 22:20:52.895435 kernel: smccc: KVM: hypervisor services detected (0x00000000 0x00000000 0x00000000 0x00000003) Nov 12 22:20:52.895442 kernel: percpu: Embedded 31 pages/cpu s86696 r8192 d32088 u126976 Nov 12 22:20:52.895449 kernel: pcpu-alloc: s86696 r8192 d32088 u126976 alloc=31*4096 Nov 12 22:20:52.895456 kernel: pcpu-alloc: [0] 0 [0] 1 [0] 2 [0] 3 Nov 12 22:20:52.895462 kernel: Detected PIPT I-cache on CPU0 Nov 12 22:20:52.895469 kernel: CPU features: detected: GIC system register CPU interface Nov 12 22:20:52.895475 kernel: CPU features: detected: Hardware dirty bit management Nov 12 22:20:52.895482 kernel: CPU features: detected: Spectre-v4 Nov 12 22:20:52.895488 kernel: CPU features: detected: Spectre-BHB Nov 12 22:20:52.895495 kernel: CPU features: kernel page table isolation forced ON by KASLR Nov 12 22:20:52.895503 kernel: CPU features: detected: Kernel page table isolation (KPTI) Nov 12 22:20:52.895509 kernel: CPU features: detected: ARM erratum 1418040 Nov 12 22:20:52.895516 kernel: CPU features: detected: SSBS not fully self-synchronizing Nov 12 22:20:52.895522 kernel: alternatives: applying boot alternatives Nov 12 22:20:52.895530 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=054b3f497d0699ec5dd6f755e221ed9e2d4f35054d20dd4fb5abe997efb88cfb Nov 12 22:20:52.895537 kernel: Unknown kernel command line parameters "BOOT_IMAGE=/flatcar/vmlinuz-a", will be passed to user space. Nov 12 22:20:52.895544 kernel: Dentry cache hash table entries: 524288 (order: 10, 4194304 bytes, linear) Nov 12 22:20:52.895550 kernel: Inode-cache hash table entries: 262144 (order: 9, 2097152 bytes, linear) Nov 12 22:20:52.895557 kernel: Fallback order for Node 0: 0 Nov 12 22:20:52.895563 kernel: Built 1 zonelists, mobility grouping on. Total pages: 633024 Nov 12 22:20:52.895570 kernel: Policy zone: DMA Nov 12 22:20:52.895578 kernel: mem auto-init: stack:off, heap alloc:off, heap free:off Nov 12 22:20:52.895584 kernel: software IO TLB: area num 4. Nov 12 22:20:52.895591 kernel: software IO TLB: mapped [mem 0x00000000d2e00000-0x00000000d6e00000] (64MB) Nov 12 22:20:52.895598 kernel: Memory: 2386324K/2572288K available (10240K kernel code, 2184K rwdata, 8096K rodata, 39680K init, 897K bss, 185964K reserved, 0K cma-reserved) Nov 12 22:20:52.895605 kernel: SLUB: HWalign=64, Order=0-3, MinObjects=0, CPUs=4, Nodes=1 Nov 12 22:20:52.895612 kernel: trace event string verifier disabled Nov 12 22:20:52.895618 kernel: rcu: Preemptible hierarchical RCU implementation. Nov 12 22:20:52.895625 kernel: rcu: RCU event tracing is enabled. Nov 12 22:20:52.895632 kernel: rcu: RCU restricting CPUs from NR_CPUS=512 to nr_cpu_ids=4. Nov 12 22:20:52.895639 kernel: Trampoline variant of Tasks RCU enabled. Nov 12 22:20:52.895645 kernel: Tracing variant of Tasks RCU enabled. Nov 12 22:20:52.895652 kernel: rcu: RCU calculated value of scheduler-enlistment delay is 100 jiffies. Nov 12 22:20:52.895660 kernel: rcu: Adjusting geometry for rcu_fanout_leaf=16, nr_cpu_ids=4 Nov 12 22:20:52.895667 kernel: NR_IRQS: 64, nr_irqs: 64, preallocated irqs: 0 Nov 12 22:20:52.895673 kernel: GICv3: 256 SPIs implemented Nov 12 22:20:52.895680 kernel: GICv3: 0 Extended SPIs implemented Nov 12 22:20:52.895686 kernel: Root IRQ handler: gic_handle_irq Nov 12 22:20:52.895693 kernel: GICv3: GICv3 features: 16 PPIs, DirectLPI Nov 12 22:20:52.895699 kernel: GICv3: CPU0: found redistributor 0 region 0:0x00000000080a0000 Nov 12 22:20:52.895706 kernel: ITS [mem 0x08080000-0x0809ffff] Nov 12 22:20:52.895712 kernel: ITS@0x0000000008080000: allocated 8192 Devices @400c0000 (indirect, esz 8, psz 64K, shr 1) Nov 12 22:20:52.895719 kernel: ITS@0x0000000008080000: allocated 8192 Interrupt Collections @400d0000 (flat, esz 8, psz 64K, shr 1) Nov 12 22:20:52.895726 kernel: GICv3: using LPI property table @0x00000000400f0000 Nov 12 22:20:52.895734 kernel: GICv3: CPU0: using allocated LPI pending table @0x0000000040100000 Nov 12 22:20:52.895740 kernel: rcu: srcu_init: Setting srcu_struct sizes based on contention. Nov 12 22:20:52.895747 kernel: arch_timer: Enabling local workaround for ARM erratum 1418040 Nov 12 22:20:52.895754 kernel: arch_timer: cp15 timer(s) running at 25.00MHz (virt). Nov 12 22:20:52.895760 kernel: clocksource: arch_sys_counter: mask: 0xffffffffffffff max_cycles: 0x5c40939b5, max_idle_ns: 440795202646 ns Nov 12 22:20:52.895767 kernel: sched_clock: 56 bits at 25MHz, resolution 40ns, wraps every 4398046511100ns Nov 12 22:20:52.895773 kernel: arm-pv: using stolen time PV Nov 12 22:20:52.895780 kernel: Console: colour dummy device 80x25 Nov 12 22:20:52.895787 kernel: ACPI: Core revision 20230628 Nov 12 22:20:52.895794 kernel: Calibrating delay loop (skipped), value calculated using timer frequency.. 50.00 BogoMIPS (lpj=25000) Nov 12 22:20:52.895801 kernel: pid_max: default: 32768 minimum: 301 Nov 12 22:20:52.895809 kernel: LSM: initializing lsm=lockdown,capability,landlock,selinux,integrity Nov 12 22:20:52.895816 kernel: landlock: Up and running. Nov 12 22:20:52.895822 kernel: SELinux: Initializing. Nov 12 22:20:52.895829 kernel: Mount-cache hash table entries: 8192 (order: 4, 65536 bytes, linear) Nov 12 22:20:52.895836 kernel: Mountpoint-cache hash table entries: 8192 (order: 4, 65536 bytes, linear) Nov 12 22:20:52.895843 kernel: RCU Tasks: Setting shift to 2 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=4. Nov 12 22:20:52.895850 kernel: RCU Tasks Trace: Setting shift to 2 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=4. Nov 12 22:20:52.895856 kernel: rcu: Hierarchical SRCU implementation. Nov 12 22:20:52.895863 kernel: rcu: Max phase no-delay instances is 400. Nov 12 22:20:52.895871 kernel: Platform MSI: ITS@0x8080000 domain created Nov 12 22:20:52.895878 kernel: PCI/MSI: ITS@0x8080000 domain created Nov 12 22:20:52.895885 kernel: Remapping and enabling EFI services. Nov 12 22:20:52.895891 kernel: smp: Bringing up secondary CPUs ... Nov 12 22:20:52.895898 kernel: Detected PIPT I-cache on CPU1 Nov 12 22:20:52.895905 kernel: GICv3: CPU1: found redistributor 1 region 0:0x00000000080c0000 Nov 12 22:20:52.895912 kernel: GICv3: CPU1: using allocated LPI pending table @0x0000000040110000 Nov 12 22:20:52.895918 kernel: arch_timer: Enabling local workaround for ARM erratum 1418040 Nov 12 22:20:52.895925 kernel: CPU1: Booted secondary processor 0x0000000001 [0x413fd0c1] Nov 12 22:20:52.895933 kernel: Detected PIPT I-cache on CPU2 Nov 12 22:20:52.895940 kernel: GICv3: CPU2: found redistributor 2 region 0:0x00000000080e0000 Nov 12 22:20:52.895952 kernel: GICv3: CPU2: using allocated LPI pending table @0x0000000040120000 Nov 12 22:20:52.895960 kernel: arch_timer: Enabling local workaround for ARM erratum 1418040 Nov 12 22:20:52.895967 kernel: CPU2: Booted secondary processor 0x0000000002 [0x413fd0c1] Nov 12 22:20:52.895974 kernel: Detected PIPT I-cache on CPU3 Nov 12 22:20:52.895981 kernel: GICv3: CPU3: found redistributor 3 region 0:0x0000000008100000 Nov 12 22:20:52.895989 kernel: GICv3: CPU3: using allocated LPI pending table @0x0000000040130000 Nov 12 22:20:52.895996 kernel: arch_timer: Enabling local workaround for ARM erratum 1418040 Nov 12 22:20:52.896004 kernel: CPU3: Booted secondary processor 0x0000000003 [0x413fd0c1] Nov 12 22:20:52.896011 kernel: smp: Brought up 1 node, 4 CPUs Nov 12 22:20:52.896018 kernel: SMP: Total of 4 processors activated. Nov 12 22:20:52.896026 kernel: CPU features: detected: 32-bit EL0 Support Nov 12 22:20:52.896033 kernel: CPU features: detected: Data cache clean to the PoU not required for I/D coherence Nov 12 22:20:52.896040 kernel: CPU features: detected: Common not Private translations Nov 12 22:20:52.896047 kernel: CPU features: detected: CRC32 instructions Nov 12 22:20:52.896054 kernel: CPU features: detected: Enhanced Virtualization Traps Nov 12 22:20:52.896063 kernel: CPU features: detected: RCpc load-acquire (LDAPR) Nov 12 22:20:52.896070 kernel: CPU features: detected: LSE atomic instructions Nov 12 22:20:52.896077 kernel: CPU features: detected: Privileged Access Never Nov 12 22:20:52.896084 kernel: CPU features: detected: RAS Extension Support Nov 12 22:20:52.896091 kernel: CPU features: detected: Speculative Store Bypassing Safe (SSBS) Nov 12 22:20:52.896099 kernel: CPU: All CPU(s) started at EL1 Nov 12 22:20:52.896106 kernel: alternatives: applying system-wide alternatives Nov 12 22:20:52.896134 kernel: devtmpfs: initialized Nov 12 22:20:52.896142 kernel: clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1911260446275000 ns Nov 12 22:20:52.896150 kernel: futex hash table entries: 1024 (order: 4, 65536 bytes, linear) Nov 12 22:20:52.896157 kernel: pinctrl core: initialized pinctrl subsystem Nov 12 22:20:52.896164 kernel: SMBIOS 3.0.0 present. Nov 12 22:20:52.896177 kernel: DMI: QEMU KVM Virtual Machine, BIOS unknown 02/02/2022 Nov 12 22:20:52.896185 kernel: NET: Registered PF_NETLINK/PF_ROUTE protocol family Nov 12 22:20:52.896192 kernel: DMA: preallocated 512 KiB GFP_KERNEL pool for atomic allocations Nov 12 22:20:52.896199 kernel: DMA: preallocated 512 KiB GFP_KERNEL|GFP_DMA pool for atomic allocations Nov 12 22:20:52.896206 kernel: DMA: preallocated 512 KiB GFP_KERNEL|GFP_DMA32 pool for atomic allocations Nov 12 22:20:52.896213 kernel: audit: initializing netlink subsys (disabled) Nov 12 22:20:52.896235 kernel: audit: type=2000 audit(0.018:1): state=initialized audit_enabled=0 res=1 Nov 12 22:20:52.896242 kernel: thermal_sys: Registered thermal governor 'step_wise' Nov 12 22:20:52.896250 kernel: cpuidle: using governor menu Nov 12 22:20:52.896257 kernel: hw-breakpoint: found 6 breakpoint and 4 watchpoint registers. Nov 12 22:20:52.896264 kernel: ASID allocator initialised with 32768 entries Nov 12 22:20:52.896271 kernel: acpiphp: ACPI Hot Plug PCI Controller Driver version: 0.5 Nov 12 22:20:52.896278 kernel: Serial: AMBA PL011 UART driver Nov 12 22:20:52.896285 kernel: Modules: 2G module region forced by RANDOMIZE_MODULE_REGION_FULL Nov 12 22:20:52.896292 kernel: Modules: 0 pages in range for non-PLT usage Nov 12 22:20:52.896299 kernel: Modules: 508960 pages in range for PLT usage Nov 12 22:20:52.896308 kernel: HugeTLB: registered 1.00 GiB page size, pre-allocated 0 pages Nov 12 22:20:52.896315 kernel: HugeTLB: 0 KiB vmemmap can be freed for a 1.00 GiB page Nov 12 22:20:52.896322 kernel: HugeTLB: registered 32.0 MiB page size, pre-allocated 0 pages Nov 12 22:20:52.896333 kernel: HugeTLB: 0 KiB vmemmap can be freed for a 32.0 MiB page Nov 12 22:20:52.896340 kernel: HugeTLB: registered 2.00 MiB page size, pre-allocated 0 pages Nov 12 22:20:52.896347 kernel: HugeTLB: 0 KiB vmemmap can be freed for a 2.00 MiB page Nov 12 22:20:52.896354 kernel: HugeTLB: registered 64.0 KiB page size, pre-allocated 0 pages Nov 12 22:20:52.896361 kernel: HugeTLB: 0 KiB vmemmap can be freed for a 64.0 KiB page Nov 12 22:20:52.896368 kernel: ACPI: Added _OSI(Module Device) Nov 12 22:20:52.896376 kernel: ACPI: Added _OSI(Processor Device) Nov 12 22:20:52.896383 kernel: ACPI: Added _OSI(3.0 _SCP Extensions) Nov 12 22:20:52.896391 kernel: ACPI: Added _OSI(Processor Aggregator Device) Nov 12 22:20:52.896398 kernel: ACPI: 1 ACPI AML tables successfully acquired and loaded Nov 12 22:20:52.896405 kernel: ACPI: Interpreter enabled Nov 12 22:20:52.896412 kernel: ACPI: Using GIC for interrupt routing Nov 12 22:20:52.896419 kernel: ACPI: MCFG table detected, 1 entries Nov 12 22:20:52.896429 kernel: ARMH0011:00: ttyAMA0 at MMIO 0x9000000 (irq = 12, base_baud = 0) is a SBSA Nov 12 22:20:52.896436 kernel: printk: console [ttyAMA0] enabled Nov 12 22:20:52.896445 kernel: ACPI: PCI Root Bridge [PCI0] (domain 0000 [bus 00-ff]) Nov 12 22:20:52.896571 kernel: acpi PNP0A08:00: _OSC: OS supports [ExtendedConfig ASPM ClockPM Segments MSI HPX-Type3] Nov 12 22:20:52.896649 kernel: acpi PNP0A08:00: _OSC: platform does not support [LTR] Nov 12 22:20:52.896712 kernel: acpi PNP0A08:00: _OSC: OS now controls [PCIeHotplug PME AER PCIeCapability] Nov 12 22:20:52.896775 kernel: acpi PNP0A08:00: ECAM area [mem 0x4010000000-0x401fffffff] reserved by PNP0C02:00 Nov 12 22:20:52.896836 kernel: acpi PNP0A08:00: ECAM at [mem 0x4010000000-0x401fffffff] for [bus 00-ff] Nov 12 22:20:52.896846 kernel: ACPI: Remapped I/O 0x000000003eff0000 to [io 0x0000-0xffff window] Nov 12 22:20:52.896856 kernel: PCI host bridge to bus 0000:00 Nov 12 22:20:52.896922 kernel: pci_bus 0000:00: root bus resource [mem 0x10000000-0x3efeffff window] Nov 12 22:20:52.896980 kernel: pci_bus 0000:00: root bus resource [io 0x0000-0xffff window] Nov 12 22:20:52.897043 kernel: pci_bus 0000:00: root bus resource [mem 0x8000000000-0xffffffffff window] Nov 12 22:20:52.897100 kernel: pci_bus 0000:00: root bus resource [bus 00-ff] Nov 12 22:20:52.897254 kernel: pci 0000:00:00.0: [1b36:0008] type 00 class 0x060000 Nov 12 22:20:52.897336 kernel: pci 0000:00:01.0: [1af4:1005] type 00 class 0x00ff00 Nov 12 22:20:52.897406 kernel: pci 0000:00:01.0: reg 0x10: [io 0x0000-0x001f] Nov 12 22:20:52.897471 kernel: pci 0000:00:01.0: reg 0x14: [mem 0x10000000-0x10000fff] Nov 12 22:20:52.897542 kernel: pci 0000:00:01.0: reg 0x20: [mem 0x8000000000-0x8000003fff 64bit pref] Nov 12 22:20:52.897605 kernel: pci 0000:00:01.0: BAR 4: assigned [mem 0x8000000000-0x8000003fff 64bit pref] Nov 12 22:20:52.897667 kernel: pci 0000:00:01.0: BAR 1: assigned [mem 0x10000000-0x10000fff] Nov 12 22:20:52.897730 kernel: pci 0000:00:01.0: BAR 0: assigned [io 0x1000-0x101f] Nov 12 22:20:52.897791 kernel: pci_bus 0000:00: resource 4 [mem 0x10000000-0x3efeffff window] Nov 12 22:20:52.897847 kernel: pci_bus 0000:00: resource 5 [io 0x0000-0xffff window] Nov 12 22:20:52.897903 kernel: pci_bus 0000:00: resource 6 [mem 0x8000000000-0xffffffffff window] Nov 12 22:20:52.897913 kernel: ACPI: PCI: Interrupt link GSI0 configured for IRQ 35 Nov 12 22:20:52.897920 kernel: ACPI: PCI: Interrupt link GSI1 configured for IRQ 36 Nov 12 22:20:52.897927 kernel: ACPI: PCI: Interrupt link GSI2 configured for IRQ 37 Nov 12 22:20:52.897934 kernel: ACPI: PCI: Interrupt link GSI3 configured for IRQ 38 Nov 12 22:20:52.897942 kernel: iommu: Default domain type: Translated Nov 12 22:20:52.897951 kernel: iommu: DMA domain TLB invalidation policy: strict mode Nov 12 22:20:52.897958 kernel: efivars: Registered efivars operations Nov 12 22:20:52.897965 kernel: vgaarb: loaded Nov 12 22:20:52.897972 kernel: clocksource: Switched to clocksource arch_sys_counter Nov 12 22:20:52.897979 kernel: VFS: Disk quotas dquot_6.6.0 Nov 12 22:20:52.897986 kernel: VFS: Dquot-cache hash table entries: 512 (order 0, 4096 bytes) Nov 12 22:20:52.897993 kernel: pnp: PnP ACPI init Nov 12 22:20:52.898059 kernel: system 00:00: [mem 0x4010000000-0x401fffffff window] could not be reserved Nov 12 22:20:52.898070 kernel: pnp: PnP ACPI: found 1 devices Nov 12 22:20:52.898079 kernel: NET: Registered PF_INET protocol family Nov 12 22:20:52.898086 kernel: IP idents hash table entries: 65536 (order: 7, 524288 bytes, linear) Nov 12 22:20:52.898093 kernel: tcp_listen_portaddr_hash hash table entries: 2048 (order: 3, 32768 bytes, linear) Nov 12 22:20:52.898101 kernel: Table-perturb hash table entries: 65536 (order: 6, 262144 bytes, linear) Nov 12 22:20:52.898130 kernel: TCP established hash table entries: 32768 (order: 6, 262144 bytes, linear) Nov 12 22:20:52.898138 kernel: TCP bind hash table entries: 32768 (order: 8, 1048576 bytes, linear) Nov 12 22:20:52.898146 kernel: TCP: Hash tables configured (established 32768 bind 32768) Nov 12 22:20:52.898153 kernel: UDP hash table entries: 2048 (order: 4, 65536 bytes, linear) Nov 12 22:20:52.898162 kernel: UDP-Lite hash table entries: 2048 (order: 4, 65536 bytes, linear) Nov 12 22:20:52.898170 kernel: NET: Registered PF_UNIX/PF_LOCAL protocol family Nov 12 22:20:52.898182 kernel: PCI: CLS 0 bytes, default 64 Nov 12 22:20:52.898190 kernel: kvm [1]: HYP mode not available Nov 12 22:20:52.898197 kernel: Initialise system trusted keyrings Nov 12 22:20:52.898204 kernel: workingset: timestamp_bits=39 max_order=20 bucket_order=0 Nov 12 22:20:52.898212 kernel: Key type asymmetric registered Nov 12 22:20:52.898219 kernel: Asymmetric key parser 'x509' registered Nov 12 22:20:52.898226 kernel: Block layer SCSI generic (bsg) driver version 0.4 loaded (major 250) Nov 12 22:20:52.898233 kernel: io scheduler mq-deadline registered Nov 12 22:20:52.898242 kernel: io scheduler kyber registered Nov 12 22:20:52.898249 kernel: io scheduler bfq registered Nov 12 22:20:52.898256 kernel: input: Power Button as /devices/LNXSYSTM:00/LNXSYBUS:00/PNP0C0C:00/input/input0 Nov 12 22:20:52.898263 kernel: ACPI: button: Power Button [PWRB] Nov 12 22:20:52.898271 kernel: ACPI: \_SB_.PCI0.GSI1: Enabled at IRQ 36 Nov 12 22:20:52.898347 kernel: virtio-pci 0000:00:01.0: enabling device (0005 -> 0007) Nov 12 22:20:52.898357 kernel: Serial: 8250/16550 driver, 4 ports, IRQ sharing enabled Nov 12 22:20:52.898365 kernel: thunder_xcv, ver 1.0 Nov 12 22:20:52.898372 kernel: thunder_bgx, ver 1.0 Nov 12 22:20:52.898381 kernel: nicpf, ver 1.0 Nov 12 22:20:52.898388 kernel: nicvf, ver 1.0 Nov 12 22:20:52.898475 kernel: rtc-efi rtc-efi.0: registered as rtc0 Nov 12 22:20:52.898548 kernel: rtc-efi rtc-efi.0: setting system clock to 2024-11-12T22:20:52 UTC (1731450052) Nov 12 22:20:52.898559 kernel: hid: raw HID events driver (C) Jiri Kosina Nov 12 22:20:52.898566 kernel: hw perfevents: enabled with armv8_pmuv3_0 PMU driver, 7 counters available Nov 12 22:20:52.898574 kernel: watchdog: Delayed init of the lockup detector failed: -19 Nov 12 22:20:52.898581 kernel: watchdog: Hard watchdog permanently disabled Nov 12 22:20:52.898591 kernel: NET: Registered PF_INET6 protocol family Nov 12 22:20:52.898600 kernel: Segment Routing with IPv6 Nov 12 22:20:52.898607 kernel: In-situ OAM (IOAM) with IPv6 Nov 12 22:20:52.898615 kernel: NET: Registered PF_PACKET protocol family Nov 12 22:20:52.898623 kernel: Key type dns_resolver registered Nov 12 22:20:52.898630 kernel: registered taskstats version 1 Nov 12 22:20:52.898640 kernel: Loading compiled-in X.509 certificates Nov 12 22:20:52.898653 kernel: Loaded X.509 cert 'Kinvolk GmbH: Module signing key for 6.6.60-flatcar: 27dd0d090d7a0971a24582c9198f7e80123ea69f' Nov 12 22:20:52.898660 kernel: Key type .fscrypt registered Nov 12 22:20:52.898668 kernel: Key type fscrypt-provisioning registered Nov 12 22:20:52.898676 kernel: ima: No TPM chip found, activating TPM-bypass! Nov 12 22:20:52.898683 kernel: ima: Allocated hash algorithm: sha1 Nov 12 22:20:52.898690 kernel: ima: No architecture policies found Nov 12 22:20:52.898697 kernel: alg: No test for fips(ansi_cprng) (fips_ansi_cprng) Nov 12 22:20:52.898704 kernel: clk: Disabling unused clocks Nov 12 22:20:52.898711 kernel: Freeing unused kernel memory: 39680K Nov 12 22:20:52.898718 kernel: Run /init as init process Nov 12 22:20:52.898725 kernel: with arguments: Nov 12 22:20:52.898733 kernel: /init Nov 12 22:20:52.898740 kernel: with environment: Nov 12 22:20:52.898747 kernel: HOME=/ Nov 12 22:20:52.898754 kernel: TERM=linux Nov 12 22:20:52.898761 kernel: BOOT_IMAGE=/flatcar/vmlinuz-a Nov 12 22:20:52.898770 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 22:20:52.898779 systemd[1]: Detected virtualization kvm. Nov 12 22:20:52.898788 systemd[1]: Detected architecture arm64. Nov 12 22:20:52.898795 systemd[1]: Running in initrd. Nov 12 22:20:52.898803 systemd[1]: No hostname configured, using default hostname. Nov 12 22:20:52.898810 systemd[1]: Hostname set to . Nov 12 22:20:52.898818 systemd[1]: Initializing machine ID from VM UUID. Nov 12 22:20:52.898826 systemd[1]: Queued start job for default target initrd.target. Nov 12 22:20:52.898834 systemd[1]: Started clevis-luks-askpass.path - Forward Password Requests to Clevis Directory Watch. Nov 12 22:20:52.898842 systemd[1]: Started systemd-ask-password-console.path - Dispatch Password Requests to Console Directory Watch. Nov 12 22:20:52.898851 systemd[1]: Expecting device dev-disk-by\x2dlabel-EFI\x2dSYSTEM.device - /dev/disk/by-label/EFI-SYSTEM... Nov 12 22:20:52.898859 systemd[1]: Expecting device dev-disk-by\x2dlabel-OEM.device - /dev/disk/by-label/OEM... Nov 12 22:20:52.898867 systemd[1]: Expecting device dev-disk-by\x2dlabel-ROOT.device - /dev/disk/by-label/ROOT... Nov 12 22:20:52.898875 systemd[1]: Expecting device dev-disk-by\x2dpartlabel-USR\x2dA.device - /dev/disk/by-partlabel/USR-A... Nov 12 22:20:52.898885 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 22:20:52.898893 systemd[1]: Expecting device dev-mapper-usr.device - /dev/mapper/usr... Nov 12 22:20:52.898901 systemd[1]: Reached target cryptsetup-pre.target - Local Encrypted Volumes (Pre). Nov 12 22:20:52.898910 systemd[1]: Reached target cryptsetup.target - Local Encrypted Volumes. Nov 12 22:20:52.898918 systemd[1]: Reached target paths.target - Path Units. Nov 12 22:20:52.898925 systemd[1]: Reached target slices.target - Slice Units. Nov 12 22:20:52.898933 systemd[1]: Reached target swap.target - Swaps. Nov 12 22:20:52.898941 systemd[1]: Reached target timers.target - Timer Units. Nov 12 22:20:52.898949 systemd[1]: Listening on iscsid.socket - Open-iSCSI iscsid Socket. Nov 12 22:20:52.898957 systemd[1]: Listening on iscsiuio.socket - Open-iSCSI iscsiuio Socket. Nov 12 22:20:52.898965 systemd[1]: Listening on systemd-journald-dev-log.socket - Journal Socket (/dev/log). Nov 12 22:20:52.898972 systemd[1]: Listening on systemd-journald.socket - Journal Socket. Nov 12 22:20:52.898982 systemd[1]: Listening on systemd-networkd.socket - Network Service Netlink Socket. Nov 12 22:20:52.898990 systemd[1]: Listening on systemd-udevd-control.socket - udev Control Socket. Nov 12 22:20:52.898997 systemd[1]: Listening on systemd-udevd-kernel.socket - udev Kernel Socket. Nov 12 22:20:52.899005 systemd[1]: Reached target sockets.target - Socket Units. Nov 12 22:20:52.899013 systemd[1]: Starting ignition-setup-pre.service - Ignition env setup... Nov 12 22:20:52.899021 systemd[1]: Starting kmod-static-nodes.service - Create List of Static Device Nodes... Nov 12 22:20:52.899029 systemd[1]: Finished network-cleanup.service - Network Cleanup. Nov 12 22:20:52.899037 systemd[1]: Starting systemd-fsck-usr.service... Nov 12 22:20:52.899046 systemd[1]: Starting systemd-journald.service - Journal Service... Nov 12 22:20:52.899054 systemd[1]: Starting systemd-modules-load.service - Load Kernel Modules... Nov 12 22:20:52.899062 systemd[1]: Starting systemd-vconsole-setup.service - Virtual Console Setup... Nov 12 22:20:52.899069 systemd[1]: Finished ignition-setup-pre.service - Ignition env setup. Nov 12 22:20:52.899077 systemd[1]: Finished kmod-static-nodes.service - Create List of Static Device Nodes. Nov 12 22:20:52.899085 systemd[1]: Finished systemd-fsck-usr.service. Nov 12 22:20:52.899095 systemd[1]: Starting systemd-tmpfiles-setup-dev-early.service - Create Static Device Nodes in /dev gracefully... Nov 12 22:20:52.899103 systemd[1]: Finished systemd-tmpfiles-setup-dev-early.service - Create Static Device Nodes in /dev gracefully. Nov 12 22:20:52.899127 systemd[1]: Starting systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev... Nov 12 22:20:52.899166 systemd-journald[239]: Collecting audit messages is disabled. Nov 12 22:20:52.899194 systemd[1]: Finished systemd-vconsole-setup.service - Virtual Console Setup. Nov 12 22:20:52.899203 systemd-journald[239]: Journal started Nov 12 22:20:52.899222 systemd-journald[239]: Runtime Journal (/run/log/journal/19832b3ceddd43c390ae4f5441105dd0) is 5.9M, max 47.3M, 41.4M free. Nov 12 22:20:52.884150 systemd-modules-load[240]: Inserted module 'overlay' Nov 12 22:20:52.901985 systemd[1]: Starting dracut-cmdline-ask.service - dracut ask for additional cmdline parameters... Nov 12 22:20:52.902002 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 22:20:52.904775 systemd[1]: Started systemd-journald.service - Journal Service. Nov 12 22:20:52.904809 kernel: Bridge firewalling registered Nov 12 22:20:52.905165 systemd-modules-load[240]: Inserted module 'br_netfilter' Nov 12 22:20:52.905980 systemd[1]: Finished systemd-modules-load.service - Load Kernel Modules. Nov 12 22:20:52.909017 systemd[1]: Finished systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev. Nov 12 22:20:52.916306 systemd[1]: Starting systemd-sysctl.service - Apply Kernel Variables... Nov 12 22:20:52.917850 systemd[1]: Starting systemd-tmpfiles-setup.service - Create System Files and Directories... Nov 12 22:20:52.918855 systemd[1]: Finished dracut-cmdline-ask.service - dracut ask for additional cmdline parameters. Nov 12 22:20:52.921655 systemd[1]: Starting dracut-cmdline.service - dracut cmdline hook... Nov 12 22:20:52.927037 systemd[1]: Finished systemd-tmpfiles-setup.service - Create System Files and Directories. Nov 12 22:20:52.929091 systemd[1]: Finished systemd-sysctl.service - Apply Kernel Variables. Nov 12 22:20:52.931773 systemd[1]: Starting systemd-resolved.service - Network Name Resolution... Nov 12 22:20:52.933929 dracut-cmdline[274]: dracut-dracut-053 Nov 12 22:20:52.937170 dracut-cmdline[274]: Using kernel command line parameters: rd.driver.pre=btrfs BOOT_IMAGE=/flatcar/vmlinuz-a mount.usr=/dev/mapper/usr verity.usr=PARTUUID=7130c94a-213a-4e5a-8e26-6cce9662f132 rootflags=rw mount.usrflags=ro consoleblank=0 root=LABEL=ROOT console=ttyS0,115200 flatcar.first_boot=detected acpi=force verity.usrhash=054b3f497d0699ec5dd6f755e221ed9e2d4f35054d20dd4fb5abe997efb88cfb Nov 12 22:20:52.962657 systemd-resolved[285]: Positive Trust Anchors: Nov 12 22:20:52.962731 systemd-resolved[285]: . IN DS 20326 8 2 e06d44b80b8f1d39a95c0b0d7c65d08458e880409bbc683457104237c7f8ec8d Nov 12 22:20:52.962762 systemd-resolved[285]: 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 22:20:52.967381 systemd-resolved[285]: Defaulting to hostname 'linux'. Nov 12 22:20:52.968276 systemd[1]: Started systemd-resolved.service - Network Name Resolution. Nov 12 22:20:52.969546 systemd[1]: Reached target nss-lookup.target - Host and Network Name Lookups. Nov 12 22:20:53.003144 kernel: SCSI subsystem initialized Nov 12 22:20:53.008136 kernel: Loading iSCSI transport class v2.0-870. Nov 12 22:20:53.015138 kernel: iscsi: registered transport (tcp) Nov 12 22:20:53.028145 kernel: iscsi: registered transport (qla4xxx) Nov 12 22:20:53.028198 kernel: QLogic iSCSI HBA Driver Nov 12 22:20:53.069570 systemd[1]: Finished dracut-cmdline.service - dracut cmdline hook. Nov 12 22:20:53.077235 systemd[1]: Starting dracut-pre-udev.service - dracut pre-udev hook... Nov 12 22:20:53.094386 kernel: device-mapper: core: CONFIG_IMA_DISABLE_HTABLE is disabled. Duplicate IMA measurements will not be recorded in the IMA log. Nov 12 22:20:53.094439 kernel: device-mapper: uevent: version 1.0.3 Nov 12 22:20:53.095161 kernel: device-mapper: ioctl: 4.48.0-ioctl (2023-03-01) initialised: dm-devel@redhat.com Nov 12 22:20:53.142150 kernel: raid6: neonx8 gen() 15684 MB/s Nov 12 22:20:53.159132 kernel: raid6: neonx4 gen() 15604 MB/s Nov 12 22:20:53.176127 kernel: raid6: neonx2 gen() 13227 MB/s Nov 12 22:20:53.193127 kernel: raid6: neonx1 gen() 10439 MB/s Nov 12 22:20:53.210126 kernel: raid6: int64x8 gen() 6947 MB/s Nov 12 22:20:53.227126 kernel: raid6: int64x4 gen() 7330 MB/s Nov 12 22:20:53.244134 kernel: raid6: int64x2 gen() 6120 MB/s Nov 12 22:20:53.261125 kernel: raid6: int64x1 gen() 5047 MB/s Nov 12 22:20:53.261139 kernel: raid6: using algorithm neonx8 gen() 15684 MB/s Nov 12 22:20:53.278151 kernel: raid6: .... xor() 11881 MB/s, rmw enabled Nov 12 22:20:53.278191 kernel: raid6: using neon recovery algorithm Nov 12 22:20:53.283194 kernel: xor: measuring software checksum speed Nov 12 22:20:53.283217 kernel: 8regs : 19750 MB/sec Nov 12 22:20:53.284271 kernel: 32regs : 19669 MB/sec Nov 12 22:20:53.284283 kernel: arm64_neon : 26936 MB/sec Nov 12 22:20:53.284299 kernel: xor: using function: arm64_neon (26936 MB/sec) Nov 12 22:20:53.336149 kernel: Btrfs loaded, zoned=no, fsverity=no Nov 12 22:20:53.346511 systemd[1]: Finished dracut-pre-udev.service - dracut pre-udev hook. Nov 12 22:20:53.359246 systemd[1]: Starting systemd-udevd.service - Rule-based Manager for Device Events and Files... Nov 12 22:20:53.369948 systemd-udevd[463]: Using default interface naming scheme 'v255'. Nov 12 22:20:53.373081 systemd[1]: Started systemd-udevd.service - Rule-based Manager for Device Events and Files. Nov 12 22:20:53.387285 systemd[1]: Starting dracut-pre-trigger.service - dracut pre-trigger hook... Nov 12 22:20:53.398252 dracut-pre-trigger[469]: rd.md=0: removing MD RAID activation Nov 12 22:20:53.423774 systemd[1]: Finished dracut-pre-trigger.service - dracut pre-trigger hook. Nov 12 22:20:53.431280 systemd[1]: Starting systemd-udev-trigger.service - Coldplug All udev Devices... Nov 12 22:20:53.468553 systemd[1]: Finished systemd-udev-trigger.service - Coldplug All udev Devices. Nov 12 22:20:53.476016 systemd[1]: Starting dracut-initqueue.service - dracut initqueue hook... Nov 12 22:20:53.486672 systemd[1]: Finished dracut-initqueue.service - dracut initqueue hook. Nov 12 22:20:53.488949 systemd[1]: Reached target remote-fs-pre.target - Preparation for Remote File Systems. Nov 12 22:20:53.490641 systemd[1]: Reached target remote-cryptsetup.target - Remote Encrypted Volumes. Nov 12 22:20:53.492908 systemd[1]: Reached target remote-fs.target - Remote File Systems. Nov 12 22:20:53.502302 systemd[1]: Starting dracut-pre-mount.service - dracut pre-mount hook... Nov 12 22:20:53.511540 systemd[1]: Finished dracut-pre-mount.service - dracut pre-mount hook. Nov 12 22:20:53.521239 kernel: virtio_blk virtio1: 1/0/0 default/read/poll queues Nov 12 22:20:53.529225 kernel: virtio_blk virtio1: [vda] 9289728 512-byte logical blocks (4.76 GB/4.43 GiB) Nov 12 22:20:53.529326 kernel: vda: vda1 vda2 vda3 vda4 vda6 vda7 vda9 Nov 12 22:20:53.531993 systemd[1]: dracut-cmdline-ask.service: Deactivated successfully. Nov 12 22:20:53.533455 systemd[1]: Stopped dracut-cmdline-ask.service - dracut ask for additional cmdline parameters. Nov 12 22:20:53.535836 systemd[1]: Stopping dracut-cmdline-ask.service - dracut ask for additional cmdline parameters... Nov 12 22:20:53.536631 systemd[1]: systemd-vconsole-setup.service: Deactivated successfully. Nov 12 22:20:53.536787 systemd[1]: Stopped systemd-vconsole-setup.service - Virtual Console Setup. Nov 12 22:20:53.538574 systemd[1]: Stopping systemd-vconsole-setup.service - Virtual Console Setup... Nov 12 22:20:53.545512 systemd[1]: Starting systemd-vconsole-setup.service - Virtual Console Setup... Nov 12 22:20:53.554139 kernel: BTRFS: device fsid 337794e4-53df-462b-aefc-e93e6a958f34 devid 1 transid 41 /dev/vda3 scanned by (udev-worker) (527) Nov 12 22:20:53.555379 systemd[1]: Finished systemd-vconsole-setup.service - Virtual Console Setup. Nov 12 22:20:53.560159 kernel: BTRFS: device label OEM devid 1 transid 14 /dev/vda6 scanned by (udev-worker) (509) Nov 12 22:20:53.565288 systemd[1]: Starting dracut-cmdline-ask.service - dracut ask for additional cmdline parameters... Nov 12 22:20:53.571933 systemd[1]: Found device dev-disk-by\x2dlabel-ROOT.device - /dev/disk/by-label/ROOT. Nov 12 22:20:53.578617 systemd[1]: Found device dev-disk-by\x2dlabel-EFI\x2dSYSTEM.device - /dev/disk/by-label/EFI-SYSTEM. Nov 12 22:20:53.579693 systemd[1]: Finished dracut-cmdline-ask.service - dracut ask for additional cmdline parameters. Nov 12 22:20:53.584899 systemd[1]: Found device dev-disk-by\x2dpartlabel-USR\x2dA.device - /dev/disk/by-partlabel/USR-A. Nov 12 22:20:53.586056 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 22:20:53.591247 systemd[1]: Found device dev-disk-by\x2dlabel-OEM.device - /dev/disk/by-label/OEM. Nov 12 22:20:53.602335 systemd[1]: Starting disk-uuid.service - Generate new UUID for disk GPT if necessary... Nov 12 22:20:53.610138 kernel: vda: vda1 vda2 vda3 vda4 vda6 vda7 vda9 Nov 12 22:20:54.622144 kernel: vda: vda1 vda2 vda3 vda4 vda6 vda7 vda9 Nov 12 22:20:54.624737 disk-uuid[564]: The operation has completed successfully. Nov 12 22:20:54.651908 systemd[1]: disk-uuid.service: Deactivated successfully. Nov 12 22:20:54.652011 systemd[1]: Finished disk-uuid.service - Generate new UUID for disk GPT if necessary. Nov 12 22:20:54.673323 systemd[1]: Starting verity-setup.service - Verity Setup for /dev/mapper/usr... Nov 12 22:20:54.676947 sh[576]: Success Nov 12 22:20:54.692154 kernel: device-mapper: verity: sha256 using implementation "sha256-ce" Nov 12 22:20:54.721842 systemd[1]: Found device dev-mapper-usr.device - /dev/mapper/usr. Nov 12 22:20:54.734422 systemd[1]: Mounting sysusr-usr.mount - /sysusr/usr... Nov 12 22:20:54.735925 systemd[1]: Finished verity-setup.service - Verity Setup for /dev/mapper/usr. Nov 12 22:20:54.746888 kernel: BTRFS info (device dm-0): first mount of filesystem 337794e4-53df-462b-aefc-e93e6a958f34 Nov 12 22:20:54.746924 kernel: BTRFS info (device dm-0): using crc32c (crc32c-generic) checksum algorithm Nov 12 22:20:54.746935 kernel: BTRFS warning (device dm-0): 'nologreplay' is deprecated, use 'rescue=nologreplay' instead Nov 12 22:20:54.746944 kernel: BTRFS info (device dm-0): disabling log replay at mount time Nov 12 22:20:54.747456 kernel: BTRFS info (device dm-0): using free space tree Nov 12 22:20:54.751370 systemd[1]: Mounted sysusr-usr.mount - /sysusr/usr. Nov 12 22:20:54.752539 systemd[1]: afterburn-network-kargs.service - Afterburn Initrd Setup Network Kernel Arguments was skipped because no trigger condition checks were met. Nov 12 22:20:54.759242 systemd[1]: Starting ignition-setup.service - Ignition (setup)... Nov 12 22:20:54.760551 systemd[1]: Starting parse-ip-for-networkd.service - Write systemd-networkd units from cmdline... Nov 12 22:20:54.769324 kernel: BTRFS info (device vda6): first mount of filesystem e7e17182-4510-4c0b-82ae-ebdf6a7625d9 Nov 12 22:20:54.769365 kernel: BTRFS info (device vda6): using crc32c (crc32c-generic) checksum algorithm Nov 12 22:20:54.769375 kernel: BTRFS info (device vda6): using free space tree Nov 12 22:20:54.772140 kernel: BTRFS info (device vda6): auto enabling async discard Nov 12 22:20:54.778094 systemd[1]: mnt-oem.mount: Deactivated successfully. Nov 12 22:20:54.779403 kernel: BTRFS info (device vda6): last unmount of filesystem e7e17182-4510-4c0b-82ae-ebdf6a7625d9 Nov 12 22:20:54.785365 systemd[1]: Finished ignition-setup.service - Ignition (setup). Nov 12 22:20:54.793268 systemd[1]: Starting ignition-fetch-offline.service - Ignition (fetch-offline)... Nov 12 22:20:54.852820 systemd[1]: Finished parse-ip-for-networkd.service - Write systemd-networkd units from cmdline. Nov 12 22:20:54.863293 systemd[1]: Starting systemd-networkd.service - Network Configuration... Nov 12 22:20:54.888431 systemd-networkd[768]: lo: Link UP Nov 12 22:20:54.888440 systemd-networkd[768]: lo: Gained carrier Nov 12 22:20:54.889255 systemd-networkd[768]: Enumeration completed Nov 12 22:20:54.889348 systemd[1]: Started systemd-networkd.service - Network Configuration. Nov 12 22:20:54.890257 systemd[1]: Reached target network.target - Network. Nov 12 22:20:54.892224 systemd-networkd[768]: eth0: found matching network '/usr/lib/systemd/network/zz-default.network', based on potentially unpredictable interface name. Nov 12 22:20:54.894239 ignition[670]: Ignition 2.20.0 Nov 12 22:20:54.892227 systemd-networkd[768]: eth0: Configuring with /usr/lib/systemd/network/zz-default.network. Nov 12 22:20:54.894246 ignition[670]: Stage: fetch-offline Nov 12 22:20:54.896750 systemd-networkd[768]: eth0: Link UP Nov 12 22:20:54.894288 ignition[670]: no configs at "/usr/lib/ignition/base.d" Nov 12 22:20:54.896753 systemd-networkd[768]: eth0: Gained carrier Nov 12 22:20:54.894295 ignition[670]: no config dir at "/usr/lib/ignition/base.platform.d/qemu" Nov 12 22:20:54.896761 systemd-networkd[768]: eth0: found matching network '/usr/lib/systemd/network/zz-default.network', based on potentially unpredictable interface name. Nov 12 22:20:54.896294 ignition[670]: parsed url from cmdline: "" Nov 12 22:20:54.896297 ignition[670]: no config URL provided Nov 12 22:20:54.896303 ignition[670]: reading system config file "/usr/lib/ignition/user.ign" Nov 12 22:20:54.896311 ignition[670]: no config at "/usr/lib/ignition/user.ign" Nov 12 22:20:54.896340 ignition[670]: op(1): [started] loading QEMU firmware config module Nov 12 22:20:54.896351 ignition[670]: op(1): executing: "modprobe" "qemu_fw_cfg" Nov 12 22:20:54.915164 ignition[670]: op(1): [finished] loading QEMU firmware config module Nov 12 22:20:54.918837 ignition[670]: parsing config with SHA512: 2747ac42e17f8cc9ef6c18672ee3a3d762c8a51e92255e57256705b5ddd2683ef0953fc1b4676241aaf0df6365922769b912ebde2d6b2d159155b8ea3fd6bce4 Nov 12 22:20:54.921162 systemd-networkd[768]: eth0: DHCPv4 address 10.0.0.27/16, gateway 10.0.0.1 acquired from 10.0.0.1 Nov 12 22:20:54.921867 unknown[670]: fetched base config from "system" Nov 12 22:20:54.922064 ignition[670]: fetch-offline: fetch-offline passed Nov 12 22:20:54.921875 unknown[670]: fetched user config from "qemu" Nov 12 22:20:54.922162 ignition[670]: Ignition finished successfully Nov 12 22:20:54.924171 systemd[1]: Finished ignition-fetch-offline.service - Ignition (fetch-offline). Nov 12 22:20:54.925488 systemd[1]: ignition-fetch.service - Ignition (fetch) was skipped because of an unmet condition check (ConditionPathExists=!/run/ignition.json). Nov 12 22:20:54.930345 systemd[1]: Starting ignition-kargs.service - Ignition (kargs)... Nov 12 22:20:54.941271 ignition[775]: Ignition 2.20.0 Nov 12 22:20:54.941282 ignition[775]: Stage: kargs Nov 12 22:20:54.941454 ignition[775]: no configs at "/usr/lib/ignition/base.d" Nov 12 22:20:54.941464 ignition[775]: no config dir at "/usr/lib/ignition/base.platform.d/qemu" Nov 12 22:20:54.942075 ignition[775]: kargs: kargs passed Nov 12 22:20:54.944139 systemd[1]: Finished ignition-kargs.service - Ignition (kargs). Nov 12 22:20:54.942135 ignition[775]: Ignition finished successfully Nov 12 22:20:54.955282 systemd[1]: Starting ignition-disks.service - Ignition (disks)... Nov 12 22:20:54.964942 ignition[784]: Ignition 2.20.0 Nov 12 22:20:54.964953 ignition[784]: Stage: disks Nov 12 22:20:54.965151 ignition[784]: no configs at "/usr/lib/ignition/base.d" Nov 12 22:20:54.965161 ignition[784]: no config dir at "/usr/lib/ignition/base.platform.d/qemu" Nov 12 22:20:54.965778 ignition[784]: disks: disks passed Nov 12 22:20:54.965820 ignition[784]: Ignition finished successfully Nov 12 22:20:54.968204 systemd[1]: Finished ignition-disks.service - Ignition (disks). Nov 12 22:20:54.969610 systemd[1]: Reached target initrd-root-device.target - Initrd Root Device. Nov 12 22:20:54.970919 systemd[1]: Reached target local-fs-pre.target - Preparation for Local File Systems. Nov 12 22:20:54.972554 systemd[1]: Reached target local-fs.target - Local File Systems. Nov 12 22:20:54.974075 systemd[1]: Reached target sysinit.target - System Initialization. Nov 12 22:20:54.975510 systemd[1]: Reached target basic.target - Basic System. Nov 12 22:20:54.988265 systemd[1]: Starting systemd-fsck-root.service - File System Check on /dev/disk/by-label/ROOT... Nov 12 22:20:54.998911 systemd-fsck[796]: ROOT: clean, 14/553520 files, 52654/553472 blocks Nov 12 22:20:55.002355 systemd[1]: Finished systemd-fsck-root.service - File System Check on /dev/disk/by-label/ROOT. Nov 12 22:20:55.011241 systemd[1]: Mounting sysroot.mount - /sysroot... Nov 12 22:20:55.056150 kernel: EXT4-fs (vda9): mounted filesystem be7e07bb-77fc-4aec-a4f6-d76dc4498784 r/w with ordered data mode. Quota mode: none. Nov 12 22:20:55.056362 systemd[1]: Mounted sysroot.mount - /sysroot. Nov 12 22:20:55.057411 systemd[1]: Reached target initrd-root-fs.target - Initrd Root File System. Nov 12 22:20:55.072200 systemd[1]: Mounting sysroot-oem.mount - /sysroot/oem... Nov 12 22:20:55.074823 systemd[1]: Mounting sysroot-usr.mount - /sysroot/usr... Nov 12 22:20:55.076643 systemd[1]: flatcar-metadata-hostname.service - Flatcar Metadata Hostname Agent was skipped because no trigger condition checks were met. Nov 12 22:20:55.076682 systemd[1]: ignition-remount-sysroot.service - Remount /sysroot read-write for Ignition was skipped because of an unmet condition check (ConditionPathIsReadWrite=!/sysroot). Nov 12 22:20:55.076704 systemd[1]: Reached target ignition-diskful.target - Ignition Boot Disk Setup. Nov 12 22:20:55.080501 systemd[1]: Mounted sysroot-usr.mount - /sysroot/usr. Nov 12 22:20:55.083081 systemd[1]: Starting initrd-setup-root.service - Root filesystem setup... Nov 12 22:20:55.086388 kernel: BTRFS: device label OEM devid 1 transid 15 /dev/vda6 scanned by mount (804) Nov 12 22:20:55.086408 kernel: BTRFS info (device vda6): first mount of filesystem e7e17182-4510-4c0b-82ae-ebdf6a7625d9 Nov 12 22:20:55.086419 kernel: BTRFS info (device vda6): using crc32c (crc32c-generic) checksum algorithm Nov 12 22:20:55.087480 kernel: BTRFS info (device vda6): using free space tree Nov 12 22:20:55.090129 kernel: BTRFS info (device vda6): auto enabling async discard Nov 12 22:20:55.091087 systemd[1]: Mounted sysroot-oem.mount - /sysroot/oem. Nov 12 22:20:55.126613 initrd-setup-root[828]: cut: /sysroot/etc/passwd: No such file or directory Nov 12 22:20:55.129592 initrd-setup-root[835]: cut: /sysroot/etc/group: No such file or directory Nov 12 22:20:55.132592 initrd-setup-root[842]: cut: /sysroot/etc/shadow: No such file or directory Nov 12 22:20:55.135403 initrd-setup-root[849]: cut: /sysroot/etc/gshadow: No such file or directory Nov 12 22:20:55.202977 systemd[1]: Finished initrd-setup-root.service - Root filesystem setup. Nov 12 22:20:55.215245 systemd[1]: Starting ignition-mount.service - Ignition (mount)... Nov 12 22:20:55.217455 systemd[1]: Starting sysroot-boot.service - /sysroot/boot... Nov 12 22:20:55.221128 kernel: BTRFS info (device vda6): last unmount of filesystem e7e17182-4510-4c0b-82ae-ebdf6a7625d9 Nov 12 22:20:55.238139 ignition[917]: INFO : Ignition 2.20.0 Nov 12 22:20:55.238139 ignition[917]: INFO : Stage: mount Nov 12 22:20:55.238139 ignition[917]: INFO : no configs at "/usr/lib/ignition/base.d" Nov 12 22:20:55.238139 ignition[917]: INFO : no config dir at "/usr/lib/ignition/base.platform.d/qemu" Nov 12 22:20:55.240969 ignition[917]: INFO : mount: mount passed Nov 12 22:20:55.240969 ignition[917]: INFO : Ignition finished successfully Nov 12 22:20:55.241700 systemd[1]: Finished sysroot-boot.service - /sysroot/boot. Nov 12 22:20:55.243156 systemd[1]: Finished ignition-mount.service - Ignition (mount). Nov 12 22:20:55.252265 systemd[1]: Starting ignition-files.service - Ignition (files)... Nov 12 22:20:55.745245 systemd[1]: sysroot-oem.mount: Deactivated successfully. Nov 12 22:20:55.757311 systemd[1]: Mounting sysroot-oem.mount - /sysroot/oem... Nov 12 22:20:55.763613 kernel: BTRFS: device label OEM devid 1 transid 16 /dev/vda6 scanned by mount (932) Nov 12 22:20:55.763643 kernel: BTRFS info (device vda6): first mount of filesystem e7e17182-4510-4c0b-82ae-ebdf6a7625d9 Nov 12 22:20:55.763654 kernel: BTRFS info (device vda6): using crc32c (crc32c-generic) checksum algorithm Nov 12 22:20:55.764298 kernel: BTRFS info (device vda6): using free space tree Nov 12 22:20:55.767130 kernel: BTRFS info (device vda6): auto enabling async discard Nov 12 22:20:55.767646 systemd[1]: Mounted sysroot-oem.mount - /sysroot/oem. Nov 12 22:20:55.786993 ignition[949]: INFO : Ignition 2.20.0 Nov 12 22:20:55.786993 ignition[949]: INFO : Stage: files Nov 12 22:20:55.788241 ignition[949]: INFO : no configs at "/usr/lib/ignition/base.d" Nov 12 22:20:55.788241 ignition[949]: INFO : no config dir at "/usr/lib/ignition/base.platform.d/qemu" Nov 12 22:20:55.788241 ignition[949]: DEBUG : files: compiled without relabeling support, skipping Nov 12 22:20:55.790936 ignition[949]: INFO : files: ensureUsers: op(1): [started] creating or modifying user "core" Nov 12 22:20:55.790936 ignition[949]: DEBUG : files: ensureUsers: op(1): executing: "usermod" "--root" "/sysroot" "core" Nov 12 22:20:55.790936 ignition[949]: INFO : files: ensureUsers: op(1): [finished] creating or modifying user "core" Nov 12 22:20:55.790936 ignition[949]: INFO : files: ensureUsers: op(2): [started] adding ssh keys to user "core" Nov 12 22:20:55.795144 ignition[949]: INFO : files: ensureUsers: op(2): [finished] adding ssh keys to user "core" Nov 12 22:20:55.795144 ignition[949]: INFO : files: createFilesystemsFiles: createFiles: op(3): [started] writing file "/sysroot/etc/flatcar/update.conf" Nov 12 22:20:55.795144 ignition[949]: INFO : files: createFilesystemsFiles: createFiles: op(3): [finished] writing file "/sysroot/etc/flatcar/update.conf" Nov 12 22:20:55.795144 ignition[949]: INFO : files: createFilesystemsFiles: createFiles: op(4): [started] writing link "/sysroot/etc/extensions/docker-flatcar.raw" -> "/dev/null" Nov 12 22:20:55.795144 ignition[949]: INFO : files: createFilesystemsFiles: createFiles: op(4): [finished] writing link "/sysroot/etc/extensions/docker-flatcar.raw" -> "/dev/null" Nov 12 22:20:55.795144 ignition[949]: INFO : files: createFilesystemsFiles: createFiles: op(5): [started] writing link "/sysroot/etc/extensions/containerd-flatcar.raw" -> "/dev/null" Nov 12 22:20:55.795144 ignition[949]: INFO : files: createFilesystemsFiles: createFiles: op(5): [finished] writing link "/sysroot/etc/extensions/containerd-flatcar.raw" -> "/dev/null" Nov 12 22:20:55.795144 ignition[949]: INFO : files: op(6): [started] processing unit "coreos-metadata.service" Nov 12 22:20:55.795144 ignition[949]: INFO : files: op(6): op(7): [started] writing unit "coreos-metadata.service" at "/sysroot/etc/systemd/system/coreos-metadata.service" Nov 12 22:20:55.795144 ignition[949]: INFO : files: op(6): op(7): [finished] writing unit "coreos-metadata.service" at "/sysroot/etc/systemd/system/coreos-metadata.service" Nov 12 22:20:55.795144 ignition[949]: INFO : files: op(6): [finished] processing unit "coreos-metadata.service" Nov 12 22:20:55.795144 ignition[949]: INFO : files: op(8): [started] setting preset to disabled for "coreos-metadata.service" Nov 12 22:20:55.791213 unknown[949]: wrote ssh authorized keys file for user: core Nov 12 22:20:55.816067 ignition[949]: INFO : files: op(8): op(9): [started] removing enablement symlink(s) for "coreos-metadata.service" Nov 12 22:20:55.819353 ignition[949]: INFO : files: op(8): op(9): [finished] removing enablement symlink(s) for "coreos-metadata.service" Nov 12 22:20:55.821179 ignition[949]: INFO : files: op(8): [finished] setting preset to disabled for "coreos-metadata.service" Nov 12 22:20:55.821179 ignition[949]: INFO : files: createResultFile: createFiles: op(a): [started] writing file "/sysroot/etc/.ignition-result.json" Nov 12 22:20:55.821179 ignition[949]: INFO : files: createResultFile: createFiles: op(a): [finished] writing file "/sysroot/etc/.ignition-result.json" Nov 12 22:20:55.821179 ignition[949]: INFO : files: files passed Nov 12 22:20:55.821179 ignition[949]: INFO : Ignition finished successfully Nov 12 22:20:55.821609 systemd[1]: Finished ignition-files.service - Ignition (files). Nov 12 22:20:55.834349 systemd[1]: Starting ignition-quench.service - Ignition (record completion)... Nov 12 22:20:55.835739 systemd[1]: Starting initrd-setup-root-after-ignition.service - Root filesystem completion... Nov 12 22:20:55.840456 systemd[1]: ignition-quench.service: Deactivated successfully. Nov 12 22:20:55.840540 systemd[1]: Finished ignition-quench.service - Ignition (record completion). Nov 12 22:20:55.842711 initrd-setup-root-after-ignition[977]: grep: /sysroot/oem/oem-release: No such file or directory Nov 12 22:20:55.844594 initrd-setup-root-after-ignition[980]: grep: /sysroot/etc/flatcar/enabled-sysext.conf: No such file or directory Nov 12 22:20:55.844594 initrd-setup-root-after-ignition[980]: grep: /sysroot/usr/share/flatcar/enabled-sysext.conf: No such file or directory Nov 12 22:20:55.846763 initrd-setup-root-after-ignition[984]: grep: /sysroot/etc/flatcar/enabled-sysext.conf: No such file or directory Nov 12 22:20:55.846690 systemd[1]: Finished initrd-setup-root-after-ignition.service - Root filesystem completion. Nov 12 22:20:55.847755 systemd[1]: Reached target ignition-complete.target - Ignition Complete. Nov 12 22:20:55.865226 systemd[1]: Starting initrd-parse-etc.service - Mountpoints Configured in the Real Root... Nov 12 22:20:55.881292 systemd[1]: initrd-parse-etc.service: Deactivated successfully. Nov 12 22:20:55.881384 systemd[1]: Finished initrd-parse-etc.service - Mountpoints Configured in the Real Root. Nov 12 22:20:55.882993 systemd[1]: Reached target initrd-fs.target - Initrd File Systems. Nov 12 22:20:55.884459 systemd[1]: Reached target initrd.target - Initrd Default Target. Nov 12 22:20:55.885764 systemd[1]: dracut-mount.service - dracut mount hook was skipped because no trigger condition checks were met. Nov 12 22:20:55.886441 systemd[1]: Starting dracut-pre-pivot.service - dracut pre-pivot and cleanup hook... Nov 12 22:20:55.899924 systemd[1]: Finished dracut-pre-pivot.service - dracut pre-pivot and cleanup hook. Nov 12 22:20:55.909256 systemd[1]: Starting initrd-cleanup.service - Cleaning Up and Shutting Down Daemons... Nov 12 22:20:55.916380 systemd[1]: Stopped target nss-lookup.target - Host and Network Name Lookups. Nov 12 22:20:55.917276 systemd[1]: Stopped target remote-cryptsetup.target - Remote Encrypted Volumes. Nov 12 22:20:55.918829 systemd[1]: Stopped target timers.target - Timer Units. Nov 12 22:20:55.920108 systemd[1]: dracut-pre-pivot.service: Deactivated successfully. Nov 12 22:20:55.920234 systemd[1]: Stopped dracut-pre-pivot.service - dracut pre-pivot and cleanup hook. Nov 12 22:20:55.922026 systemd[1]: Stopped target initrd.target - Initrd Default Target. Nov 12 22:20:55.923467 systemd[1]: Stopped target basic.target - Basic System. Nov 12 22:20:55.924644 systemd[1]: Stopped target ignition-complete.target - Ignition Complete. Nov 12 22:20:55.925884 systemd[1]: Stopped target ignition-diskful.target - Ignition Boot Disk Setup. Nov 12 22:20:55.927257 systemd[1]: Stopped target initrd-root-device.target - Initrd Root Device. Nov 12 22:20:55.928658 systemd[1]: Stopped target remote-fs.target - Remote File Systems. Nov 12 22:20:55.930099 systemd[1]: Stopped target remote-fs-pre.target - Preparation for Remote File Systems. Nov 12 22:20:55.931514 systemd[1]: Stopped target sysinit.target - System Initialization. Nov 12 22:20:55.932874 systemd[1]: Stopped target local-fs.target - Local File Systems. Nov 12 22:20:55.934095 systemd[1]: Stopped target swap.target - Swaps. Nov 12 22:20:55.935196 systemd[1]: dracut-pre-mount.service: Deactivated successfully. Nov 12 22:20:55.935297 systemd[1]: Stopped dracut-pre-mount.service - dracut pre-mount hook. Nov 12 22:20:55.937171 systemd[1]: Stopped target cryptsetup.target - Local Encrypted Volumes. Nov 12 22:20:55.938577 systemd[1]: Stopped target cryptsetup-pre.target - Local Encrypted Volumes (Pre). Nov 12 22:20:55.939961 systemd[1]: clevis-luks-askpass.path: Deactivated successfully. Nov 12 22:20:55.943138 systemd[1]: Stopped clevis-luks-askpass.path - Forward Password Requests to Clevis Directory Watch. Nov 12 22:20:55.944003 systemd[1]: dracut-initqueue.service: Deactivated successfully. Nov 12 22:20:55.944100 systemd[1]: Stopped dracut-initqueue.service - dracut initqueue hook. Nov 12 22:20:55.946417 systemd[1]: ignition-fetch-offline.service: Deactivated successfully. Nov 12 22:20:55.946523 systemd[1]: Stopped ignition-fetch-offline.service - Ignition (fetch-offline). Nov 12 22:20:55.947982 systemd[1]: Stopped target paths.target - Path Units. Nov 12 22:20:55.949081 systemd[1]: systemd-ask-password-console.path: Deactivated successfully. Nov 12 22:20:55.955183 systemd[1]: Stopped systemd-ask-password-console.path - Dispatch Password Requests to Console Directory Watch. Nov 12 22:20:55.956214 systemd[1]: Stopped target slices.target - Slice Units. Nov 12 22:20:55.957733 systemd[1]: Stopped target sockets.target - Socket Units. Nov 12 22:20:55.958814 systemd[1]: iscsid.socket: Deactivated successfully. Nov 12 22:20:55.958895 systemd[1]: Closed iscsid.socket - Open-iSCSI iscsid Socket. Nov 12 22:20:55.960075 systemd[1]: iscsiuio.socket: Deactivated successfully. Nov 12 22:20:55.960160 systemd[1]: Closed iscsiuio.socket - Open-iSCSI iscsiuio Socket. Nov 12 22:20:55.961250 systemd[1]: initrd-setup-root-after-ignition.service: Deactivated successfully. Nov 12 22:20:55.961354 systemd[1]: Stopped initrd-setup-root-after-ignition.service - Root filesystem completion. Nov 12 22:20:55.962691 systemd[1]: ignition-files.service: Deactivated successfully. Nov 12 22:20:55.962783 systemd[1]: Stopped ignition-files.service - Ignition (files). Nov 12 22:20:55.974339 systemd[1]: Stopping ignition-mount.service - Ignition (mount)... Nov 12 22:20:55.975021 systemd[1]: kmod-static-nodes.service: Deactivated successfully. Nov 12 22:20:55.975151 systemd[1]: Stopped kmod-static-nodes.service - Create List of Static Device Nodes. Nov 12 22:20:55.980010 systemd[1]: Stopping sysroot-boot.service - /sysroot/boot... Nov 12 22:20:55.980891 systemd[1]: systemd-udev-trigger.service: Deactivated successfully. Nov 12 22:20:55.981023 systemd[1]: Stopped systemd-udev-trigger.service - Coldplug All udev Devices. Nov 12 22:20:55.982704 systemd[1]: dracut-pre-trigger.service: Deactivated successfully. Nov 12 22:20:55.982799 systemd[1]: Stopped dracut-pre-trigger.service - dracut pre-trigger hook. Nov 12 22:20:55.988210 systemd[1]: initrd-cleanup.service: Deactivated successfully. Nov 12 22:20:55.988299 systemd[1]: Finished initrd-cleanup.service - Cleaning Up and Shutting Down Daemons. Nov 12 22:20:55.991394 ignition[1004]: INFO : Ignition 2.20.0 Nov 12 22:20:55.991394 ignition[1004]: INFO : Stage: umount Nov 12 22:20:55.991394 ignition[1004]: INFO : no configs at "/usr/lib/ignition/base.d" Nov 12 22:20:55.991394 ignition[1004]: INFO : no config dir at "/usr/lib/ignition/base.platform.d/qemu" Nov 12 22:20:55.991394 ignition[1004]: INFO : umount: umount passed Nov 12 22:20:55.991394 ignition[1004]: INFO : Ignition finished successfully Nov 12 22:20:55.991407 systemd[1]: sysroot-boot.mount: Deactivated successfully. Nov 12 22:20:55.991824 systemd[1]: ignition-mount.service: Deactivated successfully. Nov 12 22:20:55.991901 systemd[1]: Stopped ignition-mount.service - Ignition (mount). Nov 12 22:20:55.992968 systemd[1]: sysroot-boot.service: Deactivated successfully. Nov 12 22:20:55.993034 systemd[1]: Stopped sysroot-boot.service - /sysroot/boot. Nov 12 22:20:55.994655 systemd[1]: Stopped target network.target - Network. Nov 12 22:20:55.996002 systemd[1]: ignition-disks.service: Deactivated successfully. Nov 12 22:20:55.996051 systemd[1]: Stopped ignition-disks.service - Ignition (disks). Nov 12 22:20:55.997173 systemd[1]: ignition-kargs.service: Deactivated successfully. Nov 12 22:20:55.997211 systemd[1]: Stopped ignition-kargs.service - Ignition (kargs). Nov 12 22:20:55.998353 systemd[1]: ignition-setup.service: Deactivated successfully. Nov 12 22:20:55.998388 systemd[1]: Stopped ignition-setup.service - Ignition (setup). Nov 12 22:20:55.999570 systemd[1]: ignition-setup-pre.service: Deactivated successfully. Nov 12 22:20:55.999606 systemd[1]: Stopped ignition-setup-pre.service - Ignition env setup. Nov 12 22:20:56.000837 systemd[1]: initrd-setup-root.service: Deactivated successfully. Nov 12 22:20:56.000872 systemd[1]: Stopped initrd-setup-root.service - Root filesystem setup. Nov 12 22:20:56.002310 systemd[1]: Stopping systemd-networkd.service - Network Configuration... Nov 12 22:20:56.003500 systemd[1]: Stopping systemd-resolved.service - Network Name Resolution... Nov 12 22:20:56.012602 systemd[1]: systemd-resolved.service: Deactivated successfully. Nov 12 22:20:56.012727 systemd[1]: Stopped systemd-resolved.service - Network Name Resolution. Nov 12 22:20:56.014573 systemd-networkd[768]: eth0: DHCPv6 lease lost Nov 12 22:20:56.015407 systemd[1]: systemd-tmpfiles-setup.service: Deactivated successfully. Nov 12 22:20:56.015453 systemd[1]: Stopped systemd-tmpfiles-setup.service - Create System Files and Directories. Nov 12 22:20:56.016648 systemd[1]: systemd-networkd.service: Deactivated successfully. Nov 12 22:20:56.016740 systemd[1]: Stopped systemd-networkd.service - Network Configuration. Nov 12 22:20:56.018053 systemd[1]: systemd-networkd.socket: Deactivated successfully. Nov 12 22:20:56.018103 systemd[1]: Closed systemd-networkd.socket - Network Service Netlink Socket. Nov 12 22:20:56.030285 systemd[1]: Stopping network-cleanup.service - Network Cleanup... Nov 12 22:20:56.031596 systemd[1]: parse-ip-for-networkd.service: Deactivated successfully. Nov 12 22:20:56.031659 systemd[1]: Stopped parse-ip-for-networkd.service - Write systemd-networkd units from cmdline. Nov 12 22:20:56.033290 systemd[1]: systemd-sysctl.service: Deactivated successfully. Nov 12 22:20:56.033331 systemd[1]: Stopped systemd-sysctl.service - Apply Kernel Variables. Nov 12 22:20:56.034868 systemd[1]: systemd-modules-load.service: Deactivated successfully. Nov 12 22:20:56.034911 systemd[1]: Stopped systemd-modules-load.service - Load Kernel Modules. Nov 12 22:20:56.036249 systemd[1]: Stopping systemd-udevd.service - Rule-based Manager for Device Events and Files... Nov 12 22:20:56.046568 systemd[1]: network-cleanup.service: Deactivated successfully. Nov 12 22:20:56.046668 systemd[1]: Stopped network-cleanup.service - Network Cleanup. Nov 12 22:20:56.049516 systemd[1]: systemd-udevd.service: Deactivated successfully. Nov 12 22:20:56.049643 systemd[1]: Stopped systemd-udevd.service - Rule-based Manager for Device Events and Files. Nov 12 22:20:56.051624 systemd[1]: systemd-udevd-control.socket: Deactivated successfully. Nov 12 22:20:56.051682 systemd[1]: Closed systemd-udevd-control.socket - udev Control Socket. Nov 12 22:20:56.052810 systemd[1]: systemd-udevd-kernel.socket: Deactivated successfully. Nov 12 22:20:56.052837 systemd[1]: Closed systemd-udevd-kernel.socket - udev Kernel Socket. Nov 12 22:20:56.054102 systemd[1]: dracut-pre-udev.service: Deactivated successfully. Nov 12 22:20:56.054238 systemd[1]: Stopped dracut-pre-udev.service - dracut pre-udev hook. Nov 12 22:20:56.057693 systemd[1]: dracut-cmdline.service: Deactivated successfully. Nov 12 22:20:56.057733 systemd[1]: Stopped dracut-cmdline.service - dracut cmdline hook. Nov 12 22:20:56.059825 systemd[1]: dracut-cmdline-ask.service: Deactivated successfully. Nov 12 22:20:56.059867 systemd[1]: Stopped dracut-cmdline-ask.service - dracut ask for additional cmdline parameters. Nov 12 22:20:56.062532 systemd[1]: Starting initrd-udevadm-cleanup-db.service - Cleanup udev Database... Nov 12 22:20:56.063403 systemd[1]: systemd-tmpfiles-setup-dev.service: Deactivated successfully. Nov 12 22:20:56.063451 systemd[1]: Stopped systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev. Nov 12 22:20:56.065004 systemd[1]: systemd-vconsole-setup.service: Deactivated successfully. Nov 12 22:20:56.065042 systemd[1]: Stopped systemd-vconsole-setup.service - Virtual Console Setup. Nov 12 22:20:56.070449 systemd[1]: initrd-udevadm-cleanup-db.service: Deactivated successfully. Nov 12 22:20:56.070545 systemd[1]: Finished initrd-udevadm-cleanup-db.service - Cleanup udev Database. Nov 12 22:20:56.072280 systemd[1]: Reached target initrd-switch-root.target - Switch Root. Nov 12 22:20:56.078251 systemd[1]: Starting initrd-switch-root.service - Switch Root... Nov 12 22:20:56.084251 systemd[1]: Switching root. Nov 12 22:20:56.117009 systemd-journald[239]: Journal stopped Nov 12 22:20:56.701204 systemd-journald[239]: Received SIGTERM from PID 1 (systemd). Nov 12 22:20:56.701258 kernel: SELinux: policy capability network_peer_controls=1 Nov 12 22:20:56.701270 kernel: SELinux: policy capability open_perms=1 Nov 12 22:20:56.701279 kernel: SELinux: policy capability extended_socket_class=1 Nov 12 22:20:56.701289 kernel: SELinux: policy capability always_check_network=0 Nov 12 22:20:56.701298 kernel: SELinux: policy capability cgroup_seclabel=1 Nov 12 22:20:56.701310 kernel: SELinux: policy capability nnp_nosuid_transition=1 Nov 12 22:20:56.701320 kernel: SELinux: policy capability genfs_seclabel_symlinks=0 Nov 12 22:20:56.701329 kernel: SELinux: policy capability ioctl_skip_cloexec=0 Nov 12 22:20:56.701338 kernel: audit: type=1403 audit(1731450056.180:2): auid=4294967295 ses=4294967295 lsm=selinux res=1 Nov 12 22:20:56.701349 systemd[1]: Successfully loaded SELinux policy in 34.353ms. Nov 12 22:20:56.701368 systemd[1]: Relabeled /dev, /dev/shm, /run, /sys/fs/cgroup in 9.085ms. Nov 12 22:20:56.701379 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 22:20:56.701390 systemd[1]: Detected virtualization kvm. Nov 12 22:20:56.701402 systemd[1]: Detected architecture arm64. Nov 12 22:20:56.701414 systemd[1]: Detected first boot. Nov 12 22:20:56.701424 systemd[1]: Initializing machine ID from VM UUID. Nov 12 22:20:56.701434 zram_generator::config[1048]: No configuration found. Nov 12 22:20:56.701445 systemd[1]: Populated /etc with preset unit settings. Nov 12 22:20:56.701456 systemd[1]: initrd-switch-root.service: Deactivated successfully. Nov 12 22:20:56.701465 systemd[1]: Stopped initrd-switch-root.service - Switch Root. Nov 12 22:20:56.701476 systemd[1]: systemd-journald.service: Scheduled restart job, restart counter is at 1. Nov 12 22:20:56.701487 systemd[1]: Created slice system-addon\x2dconfig.slice - Slice /system/addon-config. Nov 12 22:20:56.701498 systemd[1]: Created slice system-addon\x2drun.slice - Slice /system/addon-run. Nov 12 22:20:56.701508 systemd[1]: Created slice system-getty.slice - Slice /system/getty. Nov 12 22:20:56.701519 systemd[1]: Created slice system-modprobe.slice - Slice /system/modprobe. Nov 12 22:20:56.701529 systemd[1]: Created slice system-serial\x2dgetty.slice - Slice /system/serial-getty. Nov 12 22:20:56.701539 systemd[1]: Created slice system-system\x2dcloudinit.slice - Slice /system/system-cloudinit. Nov 12 22:20:56.701549 systemd[1]: Created slice system-systemd\x2dfsck.slice - Slice /system/systemd-fsck. Nov 12 22:20:56.701562 systemd[1]: Created slice user.slice - User and Session Slice. Nov 12 22:20:56.701572 systemd[1]: Started clevis-luks-askpass.path - Forward Password Requests to Clevis Directory Watch. Nov 12 22:20:56.701582 systemd[1]: Started systemd-ask-password-console.path - Dispatch Password Requests to Console Directory Watch. Nov 12 22:20:56.701593 systemd[1]: Started systemd-ask-password-wall.path - Forward Password Requests to Wall Directory Watch. Nov 12 22:20:56.701603 systemd[1]: Set up automount boot.automount - Boot partition Automount Point. Nov 12 22:20:56.701613 systemd[1]: Set up automount proc-sys-fs-binfmt_misc.automount - Arbitrary Executable File Formats File System Automount Point. Nov 12 22:20:56.701625 systemd[1]: Expecting device dev-disk-by\x2dlabel-OEM.device - /dev/disk/by-label/OEM... Nov 12 22:20:56.701635 systemd[1]: Expecting device dev-ttyAMA0.device - /dev/ttyAMA0... Nov 12 22:20:56.701647 systemd[1]: Reached target cryptsetup-pre.target - Local Encrypted Volumes (Pre). Nov 12 22:20:56.701657 systemd[1]: Stopped target initrd-switch-root.target - Switch Root. Nov 12 22:20:56.701667 systemd[1]: Stopped target initrd-fs.target - Initrd File Systems. Nov 12 22:20:56.701677 systemd[1]: Stopped target initrd-root-fs.target - Initrd Root File System. Nov 12 22:20:56.701691 systemd[1]: Reached target integritysetup.target - Local Integrity Protected Volumes. Nov 12 22:20:56.701701 systemd[1]: Reached target remote-cryptsetup.target - Remote Encrypted Volumes. Nov 12 22:20:56.701711 systemd[1]: Reached target remote-fs.target - Remote File Systems. Nov 12 22:20:56.701721 systemd[1]: Reached target slices.target - Slice Units. Nov 12 22:20:56.701732 systemd[1]: Reached target swap.target - Swaps. Nov 12 22:20:56.701743 systemd[1]: Reached target veritysetup.target - Local Verity Protected Volumes. Nov 12 22:20:56.701754 systemd[1]: Listening on systemd-coredump.socket - Process Core Dump Socket. Nov 12 22:20:56.701764 systemd[1]: Listening on systemd-networkd.socket - Network Service Netlink Socket. Nov 12 22:20:56.701775 systemd[1]: Listening on systemd-udevd-control.socket - udev Control Socket. Nov 12 22:20:56.701785 systemd[1]: Listening on systemd-udevd-kernel.socket - udev Kernel Socket. Nov 12 22:20:56.701795 systemd[1]: Listening on systemd-userdbd.socket - User Database Manager Socket. Nov 12 22:20:56.701805 systemd[1]: Mounting dev-hugepages.mount - Huge Pages File System... Nov 12 22:20:56.701815 systemd[1]: Mounting dev-mqueue.mount - POSIX Message Queue File System... Nov 12 22:20:56.701828 systemd[1]: Mounting media.mount - External Media Directory... Nov 12 22:20:56.701838 systemd[1]: Mounting sys-kernel-debug.mount - Kernel Debug File System... Nov 12 22:20:56.701849 systemd[1]: Mounting sys-kernel-tracing.mount - Kernel Trace File System... Nov 12 22:20:56.701859 systemd[1]: Mounting tmp.mount - Temporary Directory /tmp... Nov 12 22:20:56.701870 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 22:20:56.701880 systemd[1]: Reached target machines.target - Containers. Nov 12 22:20:56.701890 systemd[1]: Starting flatcar-tmpfiles.service - Create missing system files... Nov 12 22:20:56.701901 systemd[1]: ignition-delete-config.service - Ignition (delete config) was skipped because no trigger condition checks were met. Nov 12 22:20:56.701912 systemd[1]: Starting kmod-static-nodes.service - Create List of Static Device Nodes... Nov 12 22:20:56.701922 systemd[1]: Starting modprobe@configfs.service - Load Kernel Module configfs... Nov 12 22:20:56.701932 systemd[1]: Starting modprobe@dm_mod.service - Load Kernel Module dm_mod... Nov 12 22:20:56.701943 systemd[1]: Starting modprobe@drm.service - Load Kernel Module drm... Nov 12 22:20:56.701953 systemd[1]: Starting modprobe@efi_pstore.service - Load Kernel Module efi_pstore... Nov 12 22:20:56.701963 systemd[1]: Starting modprobe@fuse.service - Load Kernel Module fuse... Nov 12 22:20:56.701973 systemd[1]: Starting modprobe@loop.service - Load Kernel Module loop... Nov 12 22:20:56.701984 systemd[1]: setup-nsswitch.service - Create /etc/nsswitch.conf was skipped because of an unmet condition check (ConditionPathExists=!/etc/nsswitch.conf). Nov 12 22:20:56.701994 systemd[1]: systemd-fsck-root.service: Deactivated successfully. Nov 12 22:20:56.702007 systemd[1]: Stopped systemd-fsck-root.service - File System Check on Root Device. Nov 12 22:20:56.702017 systemd[1]: systemd-fsck-usr.service: Deactivated successfully. Nov 12 22:20:56.702027 systemd[1]: Stopped systemd-fsck-usr.service. Nov 12 22:20:56.702037 kernel: fuse: init (API version 7.39) Nov 12 22:20:56.702046 systemd[1]: Starting systemd-journald.service - Journal Service... Nov 12 22:20:56.702056 kernel: loop: module loaded Nov 12 22:20:56.702067 systemd[1]: Starting systemd-modules-load.service - Load Kernel Modules... Nov 12 22:20:56.702077 systemd[1]: Starting systemd-network-generator.service - Generate network units from Kernel command line... Nov 12 22:20:56.702087 kernel: ACPI: bus type drm_connector registered Nov 12 22:20:56.702101 systemd[1]: Starting systemd-remount-fs.service - Remount Root and Kernel File Systems... Nov 12 22:20:56.702189 systemd[1]: Starting systemd-udev-trigger.service - Coldplug All udev Devices... Nov 12 22:20:56.702202 systemd[1]: verity-setup.service: Deactivated successfully. Nov 12 22:20:56.702212 systemd[1]: Stopped verity-setup.service. Nov 12 22:20:56.702222 systemd[1]: Mounted dev-hugepages.mount - Huge Pages File System. Nov 12 22:20:56.702232 systemd[1]: Mounted dev-mqueue.mount - POSIX Message Queue File System. Nov 12 22:20:56.702242 systemd[1]: Mounted media.mount - External Media Directory. Nov 12 22:20:56.702271 systemd-journald[1122]: Collecting audit messages is disabled. Nov 12 22:20:56.702292 systemd[1]: Mounted sys-kernel-debug.mount - Kernel Debug File System. Nov 12 22:20:56.702303 systemd[1]: Mounted sys-kernel-tracing.mount - Kernel Trace File System. Nov 12 22:20:56.702313 systemd-journald[1122]: Journal started Nov 12 22:20:56.702334 systemd-journald[1122]: Runtime Journal (/run/log/journal/19832b3ceddd43c390ae4f5441105dd0) is 5.9M, max 47.3M, 41.4M free. Nov 12 22:20:56.525661 systemd[1]: Queued start job for default target multi-user.target. Nov 12 22:20:56.542013 systemd[1]: Unnecessary job was removed for dev-vda6.device - /dev/vda6. Nov 12 22:20:56.542372 systemd[1]: systemd-journald.service: Deactivated successfully. Nov 12 22:20:56.705137 systemd[1]: Started systemd-journald.service - Journal Service. Nov 12 22:20:56.705359 systemd[1]: Mounted tmp.mount - Temporary Directory /tmp. Nov 12 22:20:56.706329 systemd[1]: Finished flatcar-tmpfiles.service - Create missing system files. Nov 12 22:20:56.707379 systemd[1]: Finished kmod-static-nodes.service - Create List of Static Device Nodes. Nov 12 22:20:56.708490 systemd[1]: modprobe@configfs.service: Deactivated successfully. Nov 12 22:20:56.708621 systemd[1]: Finished modprobe@configfs.service - Load Kernel Module configfs. Nov 12 22:20:56.709733 systemd[1]: modprobe@dm_mod.service: Deactivated successfully. Nov 12 22:20:56.709859 systemd[1]: Finished modprobe@dm_mod.service - Load Kernel Module dm_mod. Nov 12 22:20:56.710931 systemd[1]: modprobe@drm.service: Deactivated successfully. Nov 12 22:20:56.711065 systemd[1]: Finished modprobe@drm.service - Load Kernel Module drm. Nov 12 22:20:56.712087 systemd[1]: modprobe@efi_pstore.service: Deactivated successfully. Nov 12 22:20:56.712268 systemd[1]: Finished modprobe@efi_pstore.service - Load Kernel Module efi_pstore. Nov 12 22:20:56.713471 systemd[1]: modprobe@fuse.service: Deactivated successfully. Nov 12 22:20:56.713596 systemd[1]: Finished modprobe@fuse.service - Load Kernel Module fuse. Nov 12 22:20:56.714613 systemd[1]: modprobe@loop.service: Deactivated successfully. Nov 12 22:20:56.714748 systemd[1]: Finished modprobe@loop.service - Load Kernel Module loop. Nov 12 22:20:56.715754 systemd[1]: Finished systemd-modules-load.service - Load Kernel Modules. Nov 12 22:20:56.716828 systemd[1]: Finished systemd-network-generator.service - Generate network units from Kernel command line. Nov 12 22:20:56.718186 systemd[1]: Finished systemd-remount-fs.service - Remount Root and Kernel File Systems. Nov 12 22:20:56.729037 systemd[1]: Reached target network-pre.target - Preparation for Network. Nov 12 22:20:56.737213 systemd[1]: Mounting sys-fs-fuse-connections.mount - FUSE Control File System... Nov 12 22:20:56.738864 systemd[1]: Mounting sys-kernel-config.mount - Kernel Configuration File System... Nov 12 22:20:56.739701 systemd[1]: remount-root.service - Remount Root File System was skipped because of an unmet condition check (ConditionPathIsReadWrite=!/). Nov 12 22:20:56.739727 systemd[1]: Reached target local-fs.target - Local File Systems. Nov 12 22:20:56.741328 systemd[1]: Listening on systemd-sysext.socket - System Extension Image Management (Varlink). Nov 12 22:20:56.743192 systemd[1]: Starting dracut-shutdown.service - Restore /run/initramfs on shutdown... Nov 12 22:20:56.744936 systemd[1]: Starting ldconfig.service - Rebuild Dynamic Linker Cache... Nov 12 22:20:56.745832 systemd[1]: systemd-binfmt.service - Set Up Additional Binary Formats was skipped because no trigger condition checks were met. Nov 12 22:20:56.747053 systemd[1]: Starting systemd-hwdb-update.service - Rebuild Hardware Database... Nov 12 22:20:56.749266 systemd[1]: Starting systemd-journal-flush.service - Flush Journal to Persistent Storage... Nov 12 22:20:56.750070 systemd[1]: systemd-pstore.service - Platform Persistent Storage Archival was skipped because of an unmet condition check (ConditionDirectoryNotEmpty=/sys/fs/pstore). Nov 12 22:20:56.751327 systemd[1]: Starting systemd-random-seed.service - Load/Save OS Random Seed... Nov 12 22:20:56.752102 systemd[1]: systemd-repart.service - Repartition Root Disk was skipped because no trigger condition checks were met. Nov 12 22:20:56.753352 systemd[1]: Starting systemd-sysctl.service - Apply Kernel Variables... Nov 12 22:20:56.758938 systemd[1]: Starting systemd-sysext.service - Merge System Extension Images into /usr/ and /opt/... Nov 12 22:20:56.759500 systemd-journald[1122]: Time spent on flushing to /var/log/journal/19832b3ceddd43c390ae4f5441105dd0 is 30.335ms for 826 entries. Nov 12 22:20:56.759500 systemd-journald[1122]: System Journal (/var/log/journal/19832b3ceddd43c390ae4f5441105dd0) is 8.0M, max 195.6M, 187.6M free. Nov 12 22:20:56.806283 systemd-journald[1122]: Received client request to flush runtime journal. Nov 12 22:20:56.762266 systemd[1]: Starting systemd-sysusers.service - Create System Users... Nov 12 22:20:56.764711 systemd[1]: Finished systemd-udev-trigger.service - Coldplug All udev Devices. Nov 12 22:20:56.765711 systemd[1]: Mounted sys-fs-fuse-connections.mount - FUSE Control File System. Nov 12 22:20:56.768349 systemd[1]: Mounted sys-kernel-config.mount - Kernel Configuration File System. Nov 12 22:20:56.769541 systemd[1]: Finished dracut-shutdown.service - Restore /run/initramfs on shutdown. Nov 12 22:20:56.774009 systemd[1]: Starting systemd-udev-settle.service - Wait for udev To Complete Device Initialization... Nov 12 22:20:56.781649 systemd[1]: Finished systemd-random-seed.service - Load/Save OS Random Seed. Nov 12 22:20:56.782698 systemd[1]: Reached target first-boot-complete.target - First Boot Complete. Nov 12 22:20:56.786408 systemd[1]: Starting systemd-machine-id-commit.service - Commit a transient machine-id on disk... Nov 12 22:20:56.788976 (sd-merge)[1170]: No extensions found. Nov 12 22:20:56.792224 systemd[1]: Finished systemd-sysext.service - Merge System Extension Images into /usr/ and /opt/. Nov 12 22:20:56.794954 udevadm[1166]: systemd-udev-settle.service is deprecated. Please fix lvm2-activation-early.service, lvm2-activation.service not to pull it in. Nov 12 22:20:56.796227 systemd[1]: Starting ensure-sysext.service... Nov 12 22:20:56.801535 systemd[1]: Finished systemd-sysctl.service - Apply Kernel Variables. Nov 12 22:20:56.803677 systemd[1]: etc-machine\x2did.mount: Deactivated successfully. Nov 12 22:20:56.807382 systemd[1]: Finished systemd-machine-id-commit.service - Commit a transient machine-id on disk. Nov 12 22:20:56.809158 systemd[1]: Finished systemd-journal-flush.service - Flush Journal to Persistent Storage. Nov 12 22:20:56.816011 systemd[1]: Reloading requested from client PID 1171 ('systemctl') (unit ensure-sysext.service)... Nov 12 22:20:56.816167 systemd[1]: Reloading... Nov 12 22:20:56.874146 zram_generator::config[1204]: No configuration found. Nov 12 22:20:56.996266 systemd[1]: Reloading finished in 179 ms. Nov 12 22:20:57.003713 ldconfig[1154]: /sbin/ldconfig: /usr/lib/ld.so.conf is not an ELF file - it has the wrong magic bytes at the start. Nov 12 22:20:57.010827 systemd[1]: Finished ldconfig.service - Rebuild Dynamic Linker Cache. Nov 12 22:20:57.011944 systemd[1]: Finished systemd-sysusers.service - Create System Users. Nov 12 22:20:57.027862 systemd[1]: Starting systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev... Nov 12 22:20:57.029592 systemd[1]: Starting systemd-tmpfiles-setup.service - Create System Files and Directories... Nov 12 22:20:57.033585 systemd[1]: ignition-delete-config.service - Ignition (delete config) was skipped because no trigger condition checks were met. Nov 12 22:20:57.036420 systemd[1]: Starting modprobe@dm_mod.service - Load Kernel Module dm_mod... Nov 12 22:20:57.040332 systemd[1]: Starting modprobe@efi_pstore.service - Load Kernel Module efi_pstore... Nov 12 22:20:57.043809 systemd[1]: Starting modprobe@loop.service - Load Kernel Module loop... Nov 12 22:20:57.044772 systemd[1]: systemd-binfmt.service - Set Up Additional Binary Formats was skipped because no trigger condition checks were met. Nov 12 22:20:57.045417 systemd[1]: modprobe@dm_mod.service: Deactivated successfully. Nov 12 22:20:57.045528 systemd[1]: Finished modprobe@dm_mod.service - Load Kernel Module dm_mod. Nov 12 22:20:57.048632 systemd[1]: ignition-delete-config.service - Ignition (delete config) was skipped because no trigger condition checks were met. Nov 12 22:20:57.055523 systemd-tmpfiles[1241]: /usr/lib/tmpfiles.d/provision.conf:20: Duplicate line for path "/root", ignoring. Nov 12 22:20:57.055915 systemd-tmpfiles[1241]: /usr/lib/tmpfiles.d/systemd-flatcar.conf:6: Duplicate line for path "/var/log/journal", ignoring. Nov 12 22:20:57.056664 systemd-tmpfiles[1241]: /usr/lib/tmpfiles.d/systemd.conf:29: Duplicate line for path "/var/lib/systemd", ignoring. Nov 12 22:20:57.056672 systemd-tmpfiles[1240]: ACLs are not supported, ignoring. Nov 12 22:20:57.056682 systemd-tmpfiles[1240]: ACLs are not supported, ignoring. Nov 12 22:20:57.056860 systemd-tmpfiles[1241]: ACLs are not supported, ignoring. Nov 12 22:20:57.056899 systemd-tmpfiles[1241]: ACLs are not supported, ignoring. Nov 12 22:20:57.058739 systemd-tmpfiles[1241]: Detected autofs mount point /boot during canonicalization of boot. Nov 12 22:20:57.058744 systemd-tmpfiles[1241]: Skipping /boot Nov 12 22:20:57.061486 systemd[1]: Starting modprobe@dm_mod.service - Load Kernel Module dm_mod... Nov 12 22:20:57.062534 systemd[1]: systemd-binfmt.service - Set Up Additional Binary Formats was skipped because no trigger condition checks were met. Nov 12 22:20:57.063084 systemd[1]: Finished systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev. Nov 12 22:20:57.065746 systemd[1]: modprobe@efi_pstore.service: Deactivated successfully. Nov 12 22:20:57.065874 systemd[1]: Finished modprobe@efi_pstore.service - Load Kernel Module efi_pstore. Nov 12 22:20:57.066516 systemd-tmpfiles[1241]: Detected autofs mount point /boot during canonicalization of boot. Nov 12 22:20:57.066533 systemd-tmpfiles[1241]: Skipping /boot Nov 12 22:20:57.067107 systemd[1]: modprobe@loop.service: Deactivated successfully. Nov 12 22:20:57.067334 systemd[1]: Finished modprobe@loop.service - Load Kernel Module loop. Nov 12 22:20:57.068440 systemd[1]: modprobe@dm_mod.service: Deactivated successfully. Nov 12 22:20:57.068547 systemd[1]: Finished modprobe@dm_mod.service - Load Kernel Module dm_mod. Nov 12 22:20:57.073745 systemd[1]: ignition-delete-config.service - Ignition (delete config) was skipped because no trigger condition checks were met. Nov 12 22:20:57.079314 systemd[1]: Starting modprobe@dm_mod.service - Load Kernel Module dm_mod... Nov 12 22:20:57.083358 systemd[1]: Starting modprobe@drm.service - Load Kernel Module drm... Nov 12 22:20:57.084916 systemd[1]: Starting modprobe@efi_pstore.service - Load Kernel Module efi_pstore... Nov 12 22:20:57.088371 systemd[1]: Starting modprobe@loop.service - Load Kernel Module loop... Nov 12 22:20:57.089367 systemd[1]: systemd-binfmt.service - Set Up Additional Binary Formats was skipped because no trigger condition checks were met. Nov 12 22:20:57.090251 systemd[1]: Finished systemd-tmpfiles-setup.service - Create System Files and Directories. Nov 12 22:20:57.091596 systemd[1]: modprobe@dm_mod.service: Deactivated successfully. Nov 12 22:20:57.091712 systemd[1]: Finished modprobe@dm_mod.service - Load Kernel Module dm_mod. Nov 12 22:20:57.092915 systemd[1]: modprobe@drm.service: Deactivated successfully. Nov 12 22:20:57.093034 systemd[1]: Finished modprobe@drm.service - Load Kernel Module drm. Nov 12 22:20:57.094206 systemd[1]: modprobe@efi_pstore.service: Deactivated successfully. Nov 12 22:20:57.094316 systemd[1]: Finished modprobe@efi_pstore.service - Load Kernel Module efi_pstore. Nov 12 22:20:57.095569 systemd[1]: modprobe@loop.service: Deactivated successfully. Nov 12 22:20:57.095677 systemd[1]: Finished modprobe@loop.service - Load Kernel Module loop. Nov 12 22:20:57.103821 systemd[1]: Finished ensure-sysext.service. Nov 12 22:20:57.117264 systemd[1]: Starting audit-rules.service - Load Audit Rules... Nov 12 22:20:57.119130 systemd[1]: Starting clean-ca-certificates.service - Clean up broken links in /etc/ssl/certs... Nov 12 22:20:57.121285 systemd[1]: Starting systemd-journal-catalog-update.service - Rebuild Journal Catalog... Nov 12 22:20:57.125278 systemd[1]: systemd-pstore.service - Platform Persistent Storage Archival was skipped because of an unmet condition check (ConditionDirectoryNotEmpty=/sys/fs/pstore). Nov 12 22:20:57.125340 systemd[1]: systemd-repart.service - Repartition Root Disk was skipped because no trigger condition checks were met. Nov 12 22:20:57.130374 systemd[1]: Starting systemd-resolved.service - Network Name Resolution... Nov 12 22:20:57.133315 systemd[1]: Starting systemd-timesyncd.service - Network Time Synchronization... Nov 12 22:20:57.136398 systemd[1]: Starting systemd-update-utmp.service - Record System Boot/Shutdown in UTMP... Nov 12 22:20:57.168445 systemd[1]: Starting systemd-userdbd.service - User Database Manager... Nov 12 22:20:57.169610 systemd[1]: Finished systemd-journal-catalog-update.service - Rebuild Journal Catalog. Nov 12 22:20:57.173890 systemd[1]: Finished systemd-update-utmp.service - Record System Boot/Shutdown in UTMP. Nov 12 22:20:57.191235 systemd[1]: Finished clean-ca-certificates.service - Clean up broken links in /etc/ssl/certs. Nov 12 22:20:57.192770 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 22:20:57.193317 augenrules[1292]: No rules Nov 12 22:20:57.193995 systemd[1]: audit-rules.service: Deactivated successfully. Nov 12 22:20:57.194191 systemd[1]: Finished audit-rules.service - Load Audit Rules. Nov 12 22:20:57.206680 systemd[1]: Started systemd-userdbd.service - User Database Manager. Nov 12 22:20:57.213244 systemd[1]: Finished systemd-hwdb-update.service - Rebuild Hardware Database. Nov 12 22:20:57.223757 systemd[1]: Starting systemd-udevd.service - Rule-based Manager for Device Events and Files... Nov 12 22:20:57.225585 systemd[1]: Starting systemd-update-done.service - Update is Completed... Nov 12 22:20:57.236364 systemd[1]: Finished systemd-update-done.service - Update is Completed. Nov 12 22:20:57.249523 systemd-udevd[1306]: Using default interface naming scheme 'v255'. Nov 12 22:20:57.257216 systemd[1]: Started systemd-timesyncd.service - Network Time Synchronization. Nov 12 22:20:57.258268 systemd[1]: Reached target time-set.target - System Time Set. Nov 12 22:20:57.262139 systemd[1]: Started systemd-udevd.service - Rule-based Manager for Device Events and Files. Nov 12 22:20:57.262167 systemd-resolved[1268]: Positive Trust Anchors: Nov 12 22:20:57.262234 systemd-resolved[1268]: . IN DS 20326 8 2 e06d44b80b8f1d39a95c0b0d7c65d08458e880409bbc683457104237c7f8ec8d Nov 12 22:20:57.262266 systemd-resolved[1268]: 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 22:20:57.271178 systemd-resolved[1268]: Defaulting to hostname 'linux'. Nov 12 22:20:57.272277 systemd[1]: Starting systemd-networkd.service - Network Configuration... Nov 12 22:20:57.273056 systemd[1]: Started systemd-resolved.service - Network Name Resolution. Nov 12 22:20:57.277544 systemd[1]: Reached target nss-lookup.target - Host and Network Name Lookups. Nov 12 22:20:57.287140 kernel: BTRFS info: devid 1 device path /dev/mapper/usr changed to /dev/dm-0 scanned by (udev-worker) (1321) Nov 12 22:20:57.299197 kernel: BTRFS info: devid 1 device path /dev/dm-0 changed to /dev/mapper/usr scanned by (udev-worker) (1321) Nov 12 22:20:57.299222 systemd[1]: Condition check resulted in dev-ttyAMA0.device - /dev/ttyAMA0 being skipped. Nov 12 22:20:57.316412 kernel: BTRFS warning: duplicate device /dev/vda3 devid 1 generation 41 scanned by (udev-worker) (1329) Nov 12 22:20:57.333853 systemd[1]: Found device dev-disk-by\x2dlabel-OEM.device - /dev/disk/by-label/OEM. Nov 12 22:20:57.335878 systemd-networkd[1317]: lo: Link UP Nov 12 22:20:57.335885 systemd-networkd[1317]: lo: Gained carrier Nov 12 22:20:57.339076 systemd-networkd[1317]: Enumeration completed Nov 12 22:20:57.347285 systemd[1]: Starting systemd-fsck@dev-disk-by\x2dlabel-OEM.service - File System Check on /dev/disk/by-label/OEM... Nov 12 22:20:57.348650 systemd[1]: Started systemd-networkd.service - Network Configuration. Nov 12 22:20:57.349183 systemd-networkd[1317]: eth0: found matching network '/usr/lib/systemd/network/zz-default.network', based on potentially unpredictable interface name. Nov 12 22:20:57.349192 systemd-networkd[1317]: eth0: Configuring with /usr/lib/systemd/network/zz-default.network. Nov 12 22:20:57.349870 systemd-networkd[1317]: eth0: found matching network '/usr/lib/systemd/network/zz-default.network', based on potentially unpredictable interface name. Nov 12 22:20:57.349902 systemd-networkd[1317]: eth0: Link UP Nov 12 22:20:57.349906 systemd-networkd[1317]: eth0: Gained carrier Nov 12 22:20:57.349914 systemd-networkd[1317]: eth0: found matching network '/usr/lib/systemd/network/zz-default.network', based on potentially unpredictable interface name. Nov 12 22:20:57.349962 systemd[1]: Reached target network.target - Network. Nov 12 22:20:57.352298 systemd[1]: Starting systemd-networkd-wait-online.service - Wait for Network to be Configured... Nov 12 22:20:57.373065 systemd-networkd[1317]: eth0: DHCPv4 address 10.0.0.27/16, gateway 10.0.0.1 acquired from 10.0.0.1 Nov 12 22:20:57.375153 systemd[1]: Finished systemd-fsck@dev-disk-by\x2dlabel-OEM.service - File System Check on /dev/disk/by-label/OEM. Nov 12 22:20:57.376939 systemd-timesyncd[1272]: Network configuration changed, trying to establish connection. Nov 12 22:20:57.377701 systemd-timesyncd[1272]: Contacted time server 10.0.0.1:123 (10.0.0.1). Nov 12 22:20:57.377821 systemd-timesyncd[1272]: Initial clock synchronization to Tue 2024-11-12 22:20:57.617960 UTC. Nov 12 22:20:57.398390 systemd[1]: Starting systemd-vconsole-setup.service - Virtual Console Setup... Nov 12 22:20:57.409467 systemd[1]: Finished systemd-udev-settle.service - Wait for udev To Complete Device Initialization. Nov 12 22:20:57.411873 systemd[1]: Starting lvm2-activation-early.service - Activation of LVM2 logical volumes... Nov 12 22:20:57.433078 lvm[1347]: WARNING: Failed to connect to lvmetad. Falling back to device scanning. Nov 12 22:20:57.435622 systemd[1]: Finished systemd-vconsole-setup.service - Virtual Console Setup. Nov 12 22:20:57.469907 systemd[1]: Finished lvm2-activation-early.service - Activation of LVM2 logical volumes. Nov 12 22:20:57.471191 systemd[1]: Reached target cryptsetup.target - Local Encrypted Volumes. Nov 12 22:20:57.472216 systemd[1]: Reached target sysinit.target - System Initialization. Nov 12 22:20:57.473185 systemd[1]: Started motdgen.path - Watch for update engine configuration changes. Nov 12 22:20:57.474105 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 22:20:57.475224 systemd[1]: Started logrotate.timer - Daily rotation of log files. Nov 12 22:20:57.476103 systemd[1]: Started mdadm.timer - Weekly check for MD array's redundancy information.. Nov 12 22:20:57.476990 systemd[1]: Started systemd-tmpfiles-clean.timer - Daily Cleanup of Temporary Directories. Nov 12 22:20:57.478032 systemd[1]: update-engine-stub.timer - Update Engine Stub Timer was skipped because of an unmet condition check (ConditionPathExists=/usr/.noupdate). Nov 12 22:20:57.478064 systemd[1]: Reached target paths.target - Path Units. Nov 12 22:20:57.478749 systemd[1]: Reached target timers.target - Timer Units. Nov 12 22:20:57.480167 systemd[1]: Listening on dbus.socket - D-Bus System Message Bus Socket. Nov 12 22:20:57.496817 systemd[1]: Listening on sshd.socket - OpenSSH Server Socket. Nov 12 22:20:57.497656 systemd[1]: Reached target sockets.target - Socket Units. Nov 12 22:20:57.498364 systemd[1]: Reached target basic.target - Basic System. Nov 12 22:20:57.499044 systemd[1]: addon-config@oem.service - Configure Addon /oem was skipped because no trigger condition checks were met. Nov 12 22:20:57.499079 systemd[1]: addon-run@oem.service - Run Addon /oem was skipped because no trigger condition checks were met. Nov 12 22:20:57.500268 systemd[1]: Starting dbus.service - D-Bus System Message Bus... Nov 12 22:20:57.501828 systemd[1]: Starting enable-oem-cloudinit.service - Enable cloudinit... Nov 12 22:20:57.503654 systemd[1]: Starting extend-filesystems.service - Extend Filesystems... Nov 12 22:20:57.504781 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 22:20:57.505877 systemd[1]: Starting lvm2-activation.service - Activation of LVM2 logical volumes... Nov 12 22:20:57.510294 systemd[1]: Starting motdgen.service - Generate /run/flatcar/motd... Nov 12 22:20:57.516691 systemd[1]: Starting ssh-key-proc-cmdline.service - Install an ssh key from /proc/cmdline... Nov 12 22:20:57.519350 systemd[1]: Starting sshd-keygen.service - Generate sshd host keys... Nov 12 22:20:57.522068 extend-filesystems[1355]: Found vda Nov 12 22:20:57.522068 extend-filesystems[1355]: Found vda1 Nov 12 22:20:57.522068 extend-filesystems[1355]: Found vda2 Nov 12 22:20:57.522068 extend-filesystems[1355]: Found vda3 Nov 12 22:20:57.522068 extend-filesystems[1355]: Found usr Nov 12 22:20:57.522068 extend-filesystems[1355]: Found vda4 Nov 12 22:20:57.522068 extend-filesystems[1355]: Found vda6 Nov 12 22:20:57.522068 extend-filesystems[1355]: Found vda7 Nov 12 22:20:57.522068 extend-filesystems[1355]: Found vda9 Nov 12 22:20:57.522068 extend-filesystems[1355]: Checking size of /dev/vda9 Nov 12 22:20:57.534762 jq[1354]: false Nov 12 22:20:57.534929 lvm[1356]: WARNING: Failed to connect to lvmetad. Falling back to device scanning. Nov 12 22:20:57.525300 systemd[1]: Starting systemd-logind.service - User Login Management... Nov 12 22:20:57.528889 systemd[1]: tcsd.service - TCG Core Services Daemon was skipped because of an unmet condition check (ConditionPathExists=/dev/tpm0). Nov 12 22:20:57.529288 systemd[1]: cgroup compatibility translation between legacy and unified hierarchy settings activated. See cgroup-compat debug messages for details. Nov 12 22:20:57.532256 systemd[1]: Starting update-engine.service - Update Engine... Nov 12 22:20:57.540268 extend-filesystems[1355]: Old size kept for /dev/vda9 Nov 12 22:20:57.536685 systemd[1]: Starting update-ssh-keys-after-ignition.service - Run update-ssh-keys once after Ignition... Nov 12 22:20:57.538513 systemd[1]: enable-oem-cloudinit.service: Skipped due to 'exec-condition'. Nov 12 22:20:57.538706 systemd[1]: Condition check resulted in enable-oem-cloudinit.service - Enable cloudinit being skipped. Nov 12 22:20:57.538972 systemd[1]: extend-filesystems.service: Deactivated successfully. Nov 12 22:20:57.540150 systemd[1]: Finished extend-filesystems.service - Extend Filesystems. Nov 12 22:20:57.541779 systemd[1]: ssh-key-proc-cmdline.service: Deactivated successfully. Nov 12 22:20:57.541906 systemd[1]: Finished ssh-key-proc-cmdline.service - Install an ssh key from /proc/cmdline. Nov 12 22:20:57.547281 dbus-daemon[1353]: [system] SELinux support is enabled Nov 12 22:20:57.548480 systemd[1]: Started dbus.service - D-Bus System Message Bus. Nov 12 22:20:57.550318 jq[1369]: true Nov 12 22:20:57.552896 systemd[1]: motdgen.service: Deactivated successfully. Nov 12 22:20:57.553418 systemd[1]: Finished motdgen.service - Generate /run/flatcar/motd. Nov 12 22:20:57.554906 systemd[1]: Finished lvm2-activation.service - Activation of LVM2 logical volumes. Nov 12 22:20:57.560060 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 22:20:57.560157 kernel: BTRFS warning: duplicate device /dev/vda3 devid 1 generation 41 scanned by (udev-worker) (1326) Nov 12 22:20:57.560094 systemd[1]: Reached target system-config.target - Load system-provided cloud configs. Nov 12 22:20:57.562425 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 22:20:57.562452 systemd[1]: Reached target user-config.target - Load user-provided cloud configs. Nov 12 22:20:57.579002 jq[1379]: true Nov 12 22:20:57.581860 update_engine[1366]: I20241112 22:20:57.580868 1366 main.cc:92] Flatcar Update Engine starting Nov 12 22:20:57.586360 update_engine[1366]: I20241112 22:20:57.586273 1366 update_check_scheduler.cc:74] Next update check in 6m23s Nov 12 22:20:57.586501 systemd[1]: Started update-engine.service - Update Engine. Nov 12 22:20:57.587811 systemd-logind[1363]: Watching system buttons on /dev/input/event0 (Power Button) Nov 12 22:20:57.588369 systemd-logind[1363]: New seat seat0. Nov 12 22:20:57.588806 systemd[1]: Started locksmithd.service - Cluster reboot manager. Nov 12 22:20:57.590518 systemd[1]: Started systemd-logind.service - User Login Management. Nov 12 22:20:57.615735 bash[1400]: Updated "/home/core/.ssh/authorized_keys" Nov 12 22:20:57.619303 systemd[1]: Finished update-ssh-keys-after-ignition.service - Run update-ssh-keys once after Ignition. Nov 12 22:20:57.620852 systemd[1]: sshkeys.service was skipped because no trigger condition checks were met. Nov 12 22:20:57.625886 locksmithd[1386]: locksmithd starting currentOperation="UPDATE_STATUS_IDLE" strategy="reboot" Nov 12 22:20:58.511459 systemd-networkd[1317]: eth0: Gained IPv6LL Nov 12 22:20:59.014325 systemd[1]: Finished systemd-networkd-wait-online.service - Wait for Network to be Configured. Nov 12 22:20:59.016248 systemd[1]: Reached target network-online.target - Network is Online. Nov 12 22:20:59.022440 systemd[1]: Starting coreos-metadata.service - QEMU metadata agent... Nov 12 22:20:59.024129 systemd[1]: Starting nvidia.service - NVIDIA Configure Service... Nov 12 22:20:59.038195 systemd[1]: coreos-metadata.service: Deactivated successfully. Nov 12 22:20:59.038366 systemd[1]: Finished coreos-metadata.service - QEMU metadata agent. Nov 12 22:20:59.039527 systemd[1]: packet-phone-home.service - Report Success to Packet was skipped because no trigger condition checks were met. Nov 12 22:20:59.043175 systemd[1]: Finished nvidia.service - NVIDIA Configure Service. Nov 12 22:21:01.038375 sshd_keygen[1378]: ssh-keygen: generating new host keys: RSA ECDSA ED25519 Nov 12 22:21:01.056661 systemd[1]: Finished sshd-keygen.service - Generate sshd host keys. Nov 12 22:21:01.066574 systemd[1]: Starting issuegen.service - Generate /run/issue... Nov 12 22:21:01.070785 systemd[1]: issuegen.service: Deactivated successfully. Nov 12 22:21:01.070964 systemd[1]: Finished issuegen.service - Generate /run/issue. Nov 12 22:21:01.073645 systemd[1]: Starting systemd-user-sessions.service - Permit User Sessions... Nov 12 22:21:01.085914 systemd[1]: Finished systemd-user-sessions.service - Permit User Sessions. Nov 12 22:21:01.088278 systemd[1]: Started getty@tty1.service - Getty on tty1. Nov 12 22:21:01.089997 systemd[1]: Started serial-getty@ttyAMA0.service - Serial Getty on ttyAMA0. Nov 12 22:21:01.091151 systemd[1]: Reached target getty.target - Login Prompts. Nov 12 22:21:01.091910 systemd[1]: Reached target multi-user.target - Multi-User System. Nov 12 22:21:01.092828 systemd[1]: Startup finished in 520ms (kernel) + 3.478s (initrd) + 4.949s (userspace) = 8.948s. Nov 12 22:21:05.559625 systemd[1]: Created slice system-sshd.slice - Slice /system/sshd. Nov 12 22:21:05.560693 systemd[1]: Started sshd@0-10.0.0.27:22-10.0.0.1:44228.service - OpenSSH per-connection server daemon (10.0.0.1:44228). Nov 12 22:21:05.624185 sshd[1441]: Accepted publickey for core from 10.0.0.1 port 44228 ssh2: RSA SHA256:KPgpt/5uXhXBYNY6jU95wYzOWgpCWHnSiDnDh5jQRRc Nov 12 22:21:05.625775 sshd-session[1441]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Nov 12 22:21:05.639459 systemd-logind[1363]: New session 1 of user core. Nov 12 22:21:05.640434 systemd[1]: Created slice user-500.slice - User Slice of UID 500. Nov 12 22:21:05.653344 systemd[1]: Starting user-runtime-dir@500.service - User Runtime Directory /run/user/500... Nov 12 22:21:05.662177 systemd[1]: Finished user-runtime-dir@500.service - User Runtime Directory /run/user/500. Nov 12 22:21:05.664338 systemd[1]: Starting user@500.service - User Manager for UID 500... Nov 12 22:21:05.670544 (systemd)[1445]: pam_unix(systemd-user:session): session opened for user core(uid=500) by (uid=0) Nov 12 22:21:05.750442 systemd[1445]: Queued start job for default target default.target. Nov 12 22:21:05.762111 systemd[1445]: Created slice app.slice - User Application Slice. Nov 12 22:21:05.762164 systemd[1445]: Reached target paths.target - Paths. Nov 12 22:21:05.762176 systemd[1445]: Reached target timers.target - Timers. Nov 12 22:21:05.763347 systemd[1445]: Starting dbus.socket - D-Bus User Message Bus Socket... Nov 12 22:21:05.772605 systemd[1445]: Listening on dbus.socket - D-Bus User Message Bus Socket. Nov 12 22:21:05.772677 systemd[1445]: Reached target sockets.target - Sockets. Nov 12 22:21:05.772691 systemd[1445]: Reached target basic.target - Basic System. Nov 12 22:21:05.772728 systemd[1445]: Reached target default.target - Main User Target. Nov 12 22:21:05.772762 systemd[1445]: Startup finished in 97ms. Nov 12 22:21:05.773037 systemd[1]: Started user@500.service - User Manager for UID 500. Nov 12 22:21:05.774423 systemd[1]: Started session-1.scope - Session 1 of User core. Nov 12 22:21:05.838797 systemd[1]: Started sshd@1-10.0.0.27:22-10.0.0.1:44238.service - OpenSSH per-connection server daemon (10.0.0.1:44238). Nov 12 22:21:05.881635 sshd[1456]: Accepted publickey for core from 10.0.0.1 port 44238 ssh2: RSA SHA256:KPgpt/5uXhXBYNY6jU95wYzOWgpCWHnSiDnDh5jQRRc Nov 12 22:21:05.882878 sshd-session[1456]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Nov 12 22:21:05.887334 systemd-logind[1363]: New session 2 of user core. Nov 12 22:21:05.896310 systemd[1]: Started session-2.scope - Session 2 of User core. Nov 12 22:21:05.948363 sshd[1458]: Connection closed by 10.0.0.1 port 44238 Nov 12 22:21:05.948776 sshd-session[1456]: pam_unix(sshd:session): session closed for user core Nov 12 22:21:05.957394 systemd[1]: sshd@1-10.0.0.27:22-10.0.0.1:44238.service: Deactivated successfully. Nov 12 22:21:05.958686 systemd[1]: session-2.scope: Deactivated successfully. Nov 12 22:21:05.961183 systemd-logind[1363]: Session 2 logged out. Waiting for processes to exit. Nov 12 22:21:05.962226 systemd[1]: Started sshd@2-10.0.0.27:22-10.0.0.1:44240.service - OpenSSH per-connection server daemon (10.0.0.1:44240). Nov 12 22:21:05.962920 systemd-logind[1363]: Removed session 2. Nov 12 22:21:06.002650 sshd[1463]: Accepted publickey for core from 10.0.0.1 port 44240 ssh2: RSA SHA256:KPgpt/5uXhXBYNY6jU95wYzOWgpCWHnSiDnDh5jQRRc Nov 12 22:21:06.003718 sshd-session[1463]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Nov 12 22:21:06.007173 systemd-logind[1363]: New session 3 of user core. Nov 12 22:21:06.018264 systemd[1]: Started session-3.scope - Session 3 of User core. Nov 12 22:21:06.066392 sshd[1465]: Connection closed by 10.0.0.1 port 44240 Nov 12 22:21:06.066778 sshd-session[1463]: pam_unix(sshd:session): session closed for user core Nov 12 22:21:06.077401 systemd[1]: sshd@2-10.0.0.27:22-10.0.0.1:44240.service: Deactivated successfully. Nov 12 22:21:06.078619 systemd[1]: session-3.scope: Deactivated successfully. Nov 12 22:21:06.080134 systemd-logind[1363]: Session 3 logged out. Waiting for processes to exit. Nov 12 22:21:06.081164 systemd[1]: Started sshd@3-10.0.0.27:22-10.0.0.1:44242.service - OpenSSH per-connection server daemon (10.0.0.1:44242). Nov 12 22:21:06.081829 systemd-logind[1363]: Removed session 3. Nov 12 22:21:06.118251 sshd[1470]: Accepted publickey for core from 10.0.0.1 port 44242 ssh2: RSA SHA256:KPgpt/5uXhXBYNY6jU95wYzOWgpCWHnSiDnDh5jQRRc Nov 12 22:21:06.119343 sshd-session[1470]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Nov 12 22:21:06.123155 systemd-logind[1363]: New session 4 of user core. Nov 12 22:21:06.132255 systemd[1]: Started session-4.scope - Session 4 of User core. Nov 12 22:21:06.183890 sshd[1472]: Connection closed by 10.0.0.1 port 44242 Nov 12 22:21:06.184254 sshd-session[1470]: pam_unix(sshd:session): session closed for user core Nov 12 22:21:06.191282 systemd[1]: sshd@3-10.0.0.27:22-10.0.0.1:44242.service: Deactivated successfully. Nov 12 22:21:06.192414 systemd[1]: session-4.scope: Deactivated successfully. Nov 12 22:21:06.193637 systemd-logind[1363]: Session 4 logged out. Waiting for processes to exit. Nov 12 22:21:06.201505 systemd[1]: Started sshd@4-10.0.0.27:22-10.0.0.1:44258.service - OpenSSH per-connection server daemon (10.0.0.1:44258). Nov 12 22:21:06.203922 systemd-logind[1363]: Removed session 4. Nov 12 22:21:06.235536 sshd[1477]: Accepted publickey for core from 10.0.0.1 port 44258 ssh2: RSA SHA256:KPgpt/5uXhXBYNY6jU95wYzOWgpCWHnSiDnDh5jQRRc Nov 12 22:21:06.236621 sshd-session[1477]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Nov 12 22:21:06.240942 systemd-logind[1363]: New session 5 of user core. Nov 12 22:21:06.248268 systemd[1]: Started session-5.scope - Session 5 of User core. Nov 12 22:21:06.305318 sudo[1480]: core : PWD=/home/core ; USER=root ; COMMAND=/usr/sbin/setenforce 1 Nov 12 22:21:06.305573 sudo[1480]: pam_unix(sudo:session): session opened for user root(uid=0) by core(uid=500) Nov 12 22:21:06.319906 sudo[1480]: pam_unix(sudo:session): session closed for user root Nov 12 22:21:06.321932 sshd[1479]: Connection closed by 10.0.0.1 port 44258 Nov 12 22:21:06.321857 sshd-session[1477]: pam_unix(sshd:session): session closed for user core Nov 12 22:21:06.328202 systemd[1]: sshd@4-10.0.0.27:22-10.0.0.1:44258.service: Deactivated successfully. Nov 12 22:21:06.329474 systemd[1]: session-5.scope: Deactivated successfully. Nov 12 22:21:06.330654 systemd-logind[1363]: Session 5 logged out. Waiting for processes to exit. Nov 12 22:21:06.331777 systemd[1]: Started sshd@5-10.0.0.27:22-10.0.0.1:44262.service - OpenSSH per-connection server daemon (10.0.0.1:44262). Nov 12 22:21:06.332466 systemd-logind[1363]: Removed session 5. Nov 12 22:21:06.369458 sshd[1485]: Accepted publickey for core from 10.0.0.1 port 44262 ssh2: RSA SHA256:KPgpt/5uXhXBYNY6jU95wYzOWgpCWHnSiDnDh5jQRRc Nov 12 22:21:06.370839 sshd-session[1485]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Nov 12 22:21:06.374186 systemd-logind[1363]: New session 6 of user core. Nov 12 22:21:06.390257 systemd[1]: Started session-6.scope - Session 6 of User core. Nov 12 22:21:06.439594 sudo[1489]: core : PWD=/home/core ; USER=root ; COMMAND=/usr/sbin/rm -rf /etc/audit/rules.d/80-selinux.rules /etc/audit/rules.d/99-default.rules Nov 12 22:21:06.439843 sudo[1489]: pam_unix(sudo:session): session opened for user root(uid=0) by core(uid=500) Nov 12 22:21:06.442616 sudo[1489]: pam_unix(sudo:session): session closed for user root Nov 12 22:21:06.446616 sudo[1488]: core : PWD=/home/core ; USER=root ; COMMAND=/usr/sbin/systemctl restart audit-rules Nov 12 22:21:06.447091 sudo[1488]: pam_unix(sudo:session): session opened for user root(uid=0) by core(uid=500) Nov 12 22:21:06.470385 systemd[1]: Starting audit-rules.service - Load Audit Rules... Nov 12 22:21:06.491539 augenrules[1511]: No rules Nov 12 22:21:06.492544 systemd[1]: audit-rules.service: Deactivated successfully. Nov 12 22:21:06.492701 systemd[1]: Finished audit-rules.service - Load Audit Rules. Nov 12 22:21:06.493701 sudo[1488]: pam_unix(sudo:session): session closed for user root Nov 12 22:21:06.495161 sshd[1487]: Connection closed by 10.0.0.1 port 44262 Nov 12 22:21:06.495071 sshd-session[1485]: pam_unix(sshd:session): session closed for user core Nov 12 22:21:06.504299 systemd[1]: sshd@5-10.0.0.27:22-10.0.0.1:44262.service: Deactivated successfully. Nov 12 22:21:06.505530 systemd[1]: session-6.scope: Deactivated successfully. Nov 12 22:21:06.506675 systemd-logind[1363]: Session 6 logged out. Waiting for processes to exit. Nov 12 22:21:06.516352 systemd[1]: Started sshd@6-10.0.0.27:22-10.0.0.1:44274.service - OpenSSH per-connection server daemon (10.0.0.1:44274). Nov 12 22:21:06.518169 systemd-logind[1363]: Removed session 6. Nov 12 22:21:06.550375 sshd[1519]: Accepted publickey for core from 10.0.0.1 port 44274 ssh2: RSA SHA256:KPgpt/5uXhXBYNY6jU95wYzOWgpCWHnSiDnDh5jQRRc Nov 12 22:21:06.551371 sshd-session[1519]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Nov 12 22:21:06.554519 systemd-logind[1363]: New session 7 of user core. Nov 12 22:21:06.567239 systemd[1]: Started session-7.scope - Session 7 of User core. Nov 12 22:21:06.613683 sshd[1521]: Connection closed by 10.0.0.1 port 44274 Nov 12 22:21:06.614056 sshd-session[1519]: pam_unix(sshd:session): session closed for user core Nov 12 22:21:06.626170 systemd[1]: sshd@6-10.0.0.27:22-10.0.0.1:44274.service: Deactivated successfully. Nov 12 22:21:06.627360 systemd[1]: session-7.scope: Deactivated successfully. Nov 12 22:21:06.630103 systemd-logind[1363]: Session 7 logged out. Waiting for processes to exit. Nov 12 22:21:06.631104 systemd[1]: Started sshd@7-10.0.0.27:22-10.0.0.1:44284.service - OpenSSH per-connection server daemon (10.0.0.1:44284). Nov 12 22:21:06.631765 systemd-logind[1363]: Removed session 7. Nov 12 22:21:06.667675 sshd[1527]: Accepted publickey for core from 10.0.0.1 port 44284 ssh2: RSA SHA256:KPgpt/5uXhXBYNY6jU95wYzOWgpCWHnSiDnDh5jQRRc Nov 12 22:21:06.668630 sshd-session[1527]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Nov 12 22:21:06.672174 systemd-logind[1363]: New session 8 of user core. Nov 12 22:21:06.685318 systemd[1]: Started session-8.scope - Session 8 of User core. Nov 12 22:21:07.236461 sshd[1529]: Connection closed by 10.0.0.1 port 44284 Nov 12 22:21:07.236847 sshd-session[1527]: pam_unix(sshd:session): session closed for user core Nov 12 22:21:07.247314 systemd[1]: sshd@7-10.0.0.27:22-10.0.0.1:44284.service: Deactivated successfully. Nov 12 22:21:07.248698 systemd[1]: session-8.scope: Deactivated successfully. Nov 12 22:21:07.249966 systemd-logind[1363]: Session 8 logged out. Waiting for processes to exit. Nov 12 22:21:07.250985 systemd[1]: Started sshd@8-10.0.0.27:22-10.0.0.1:44290.service - OpenSSH per-connection server daemon (10.0.0.1:44290). Nov 12 22:21:07.251748 systemd-logind[1363]: Removed session 8. Nov 12 22:21:07.288354 sshd[1543]: Accepted publickey for core from 10.0.0.1 port 44290 ssh2: RSA SHA256:KPgpt/5uXhXBYNY6jU95wYzOWgpCWHnSiDnDh5jQRRc Nov 12 22:21:07.289397 sshd-session[1543]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Nov 12 22:21:07.292830 systemd-logind[1363]: New session 9 of user core. Nov 12 22:21:07.299253 systemd[1]: Started session-9.scope - Session 9 of User core. Nov 12 22:21:12.225289 sudo[1546]: core : PWD=/home/core ; USER=root ; COMMAND=/usr/sbin/mv docker.raw containerd.raw /etc/extensions/ Nov 12 22:21:12.225544 sudo[1546]: pam_unix(sudo:session): session opened for user root(uid=0) by core(uid=500) Nov 12 22:21:12.388684 sudo[1546]: pam_unix(sudo:session): session closed for user root Nov 12 22:21:12.390517 sshd[1545]: Connection closed by 10.0.0.1 port 44290 Nov 12 22:21:12.390897 sshd-session[1543]: pam_unix(sshd:session): session closed for user core Nov 12 22:21:12.399400 systemd[1]: sshd@8-10.0.0.27:22-10.0.0.1:44290.service: Deactivated successfully. Nov 12 22:21:12.400718 systemd[1]: session-9.scope: Deactivated successfully. Nov 12 22:21:12.400860 systemd[1]: session-9.scope: Consumed 3.559s CPU time. Nov 12 22:21:12.401830 systemd-logind[1363]: Session 9 logged out. Waiting for processes to exit. Nov 12 22:21:12.411399 systemd[1]: Started sshd@9-10.0.0.27:22-10.0.0.1:44292.service - OpenSSH per-connection server daemon (10.0.0.1:44292). Nov 12 22:21:12.412480 systemd-logind[1363]: Removed session 9. Nov 12 22:21:12.445236 sshd[1604]: Accepted publickey for core from 10.0.0.1 port 44292 ssh2: RSA SHA256:KPgpt/5uXhXBYNY6jU95wYzOWgpCWHnSiDnDh5jQRRc Nov 12 22:21:12.446245 sshd-session[1604]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Nov 12 22:21:12.449875 systemd-logind[1363]: New session 10 of user core. Nov 12 22:21:12.463353 systemd[1]: Started session-10.scope - Session 10 of User core. Nov 12 22:21:12.512946 sudo[1607]: core : PWD=/home/core ; USER=root ; COMMAND=/usr/sbin/systemctl restart systemd-sysext Nov 12 22:21:12.513966 sudo[1607]: pam_unix(sudo:session): session opened for user root(uid=0) by core(uid=500) Nov 12 22:21:12.521640 systemd[1]: ensure-sysext.service: Deactivated successfully. Nov 12 22:21:12.521869 systemd[1]: Stopped ensure-sysext.service. Nov 12 22:21:12.521932 systemd[1]: Stopping ensure-sysext.service... Nov 12 22:21:12.539411 systemd[1]: Stopping systemd-sysext.service - Merge System Extension Images into /usr/ and /opt/... Nov 12 22:21:12.543185 systemd[1]: systemd-sysext.service: Deactivated successfully. Nov 12 22:21:12.543381 systemd[1]: Stopped systemd-sysext.service - Merge System Extension Images into /usr/ and /opt/. Nov 12 22:21:12.545195 systemd[1]: Starting systemd-sysext.service - Merge System Extension Images into /usr/ and /opt/... Nov 12 22:21:12.552151 kernel: loop0: detected capacity change from 0 to 315088 Nov 12 22:21:12.557144 kernel: EXT4-fs (loop0): mounted filesystem 8f7006c0-b97b-47d5-bb76-32ad5d61aefe ro without journal. Quota mode: none. Nov 12 22:21:12.560134 kernel: EXT4-fs (loop0): unmounting filesystem 8f7006c0-b97b-47d5-bb76-32ad5d61aefe. Nov 12 22:21:12.590142 kernel: loop1: detected capacity change from 0 to 301296 Nov 12 22:21:12.594153 kernel: EXT4-fs (loop1): mounted filesystem 4ce96e51-c58f-432e-b85f-d5ad50edcc90 ro without journal. Quota mode: none. Nov 12 22:21:12.596134 kernel: EXT4-fs (loop1): unmounting filesystem 4ce96e51-c58f-432e-b85f-d5ad50edcc90. Nov 12 22:21:12.628141 kernel: loop2: detected capacity change from 0 to 315088 Nov 12 22:21:12.632133 kernel: EXT4-fs (loop2): mounted filesystem 8f7006c0-b97b-47d5-bb76-32ad5d61aefe ro without journal. Quota mode: none. Nov 12 22:21:12.634146 kernel: loop3: detected capacity change from 0 to 301296 Nov 12 22:21:12.636784 (sd-merge)[1618]: Using extensions 'containerd', 'docker'. Nov 12 22:21:12.637144 kernel: EXT4-fs (loop3): mounted filesystem 4ce96e51-c58f-432e-b85f-d5ad50edcc90 ro without journal. Quota mode: none. Nov 12 22:21:12.637179 (sd-merge)[1618]: Merged extensions into '/usr'. Nov 12 22:21:12.639624 systemd[1]: Finished systemd-sysext.service - Merge System Extension Images into /usr/ and /opt/. Nov 12 22:21:12.641287 sudo[1607]: pam_unix(sudo:session): session closed for user root Nov 12 22:21:12.642909 sshd[1606]: Connection closed by 10.0.0.1 port 44292 Nov 12 22:21:12.642819 sshd-session[1604]: pam_unix(sshd:session): session closed for user core Nov 12 22:21:12.650362 systemd[1]: Starting ensure-sysext.service... Nov 12 22:21:12.650667 systemd[1]: sshd@9-10.0.0.27:22-10.0.0.1:44292.service: Deactivated successfully. Nov 12 22:21:12.652079 systemd[1]: session-10.scope: Deactivated successfully. Nov 12 22:21:12.652735 systemd-logind[1363]: Session 10 logged out. Waiting for processes to exit. Nov 12 22:21:12.674469 systemd[1]: Started sshd@10-10.0.0.27:22-10.0.0.1:58918.service - OpenSSH per-connection server daemon (10.0.0.1:58918). Nov 12 22:21:12.674956 systemd[1]: Reloading requested from client PID 1622 ('systemctl') (unit ensure-sysext.service)... Nov 12 22:21:12.674970 systemd[1]: Reloading... Nov 12 22:21:12.674994 systemd-logind[1363]: Removed session 10. Nov 12 22:21:12.734140 zram_generator::config[1664]: No configuration found. Nov 12 22:21:12.889308 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 22:21:12.937406 systemd[1]: Reloading finished in 262 ms. Nov 12 22:21:12.984270 systemd[1]: Stopped target sockets.target - Socket Units. Nov 12 22:21:12.984416 systemd[1]: Stopping sockets.target - Socket Units... Nov 12 22:21:12.986094 systemd[1]: Starting docker.socket - Docker Socket for the API... Nov 12 22:21:12.987426 systemd[1]: Starting containerd.service - containerd container runtime... Nov 12 22:21:12.987820 systemd[1]: Listening on docker.socket - Docker Socket for the API. Nov 12 22:21:12.988284 systemd[1]: Reached target sockets.target - Socket Units. Nov 12 22:21:12.988946 systemd[1]: Stopped target timers.target - Timer Units. Nov 12 22:21:12.988960 systemd[1]: Stopping timers.target - Timer Units... Nov 12 22:21:12.989024 systemd[1]: Reached target timers.target - Timer Units. Nov 12 22:21:12.993456 systemd[1]: Stopped target multi-user.target - Multi-User System. Nov 12 22:21:12.993478 systemd[1]: Stopping multi-user.target - Multi-User System... Nov 12 22:21:12.993511 systemd[1]: update-engine-stub.timer - Update Engine Stub Timer was skipped because of an unmet condition check (ConditionPathExists=/usr/.noupdate). Nov 12 22:21:12.994873 systemd[1]: Starting audit-rules.service - Load Audit Rules... Nov 12 22:21:12.995891 systemd[1]: Starting coreos-metadata.service - QEMU metadata agent... Nov 12 22:21:12.998346 systemd[1]: Starting enable-oem-cloudinit.service - Enable cloudinit... Nov 12 22:21:13.001377 systemd[1]: Starting extend-filesystems.service - Extend Filesystems... Nov 12 22:21:13.005092 jq[1704]: false Nov 12 22:21:13.005286 systemd[1]: Starting issuegen.service - Generate /run/issue... Nov 12 22:21:13.006904 systemd[1]: Starting motdgen.service - Generate /run/flatcar/motd... Nov 12 22:21:13.008410 systemd[1]: Starting ssh-key-proc-cmdline.service - Install an ssh key from /proc/cmdline... Nov 12 22:21:13.008617 systemd[1]: sshkeys.service was skipped because no trigger condition checks were met. Nov 12 22:21:13.011941 augenrules[1702]: /sbin/augenrules: No change Nov 12 22:21:13.008718 systemd[1]: tcsd.service - TCG Core Services Daemon was skipped because of an unmet condition check (ConditionPathExists=/dev/tpm0). Nov 12 22:21:13.009875 systemd[1]: Finished ensure-sysext.service. Nov 12 22:21:13.014387 systemd[1]: Started containerd.service - containerd container runtime. Nov 12 22:21:13.015631 systemd[1]: enable-oem-cloudinit.service: Skipped due to 'exec-condition'. Nov 12 22:21:13.015790 systemd[1]: Condition check resulted in enable-oem-cloudinit.service - Enable cloudinit being skipped. Nov 12 22:21:13.019870 systemd[1]: issuegen.service: Deactivated successfully. Nov 12 22:21:13.020063 systemd[1]: Finished issuegen.service - Generate /run/issue. Nov 12 22:21:13.022775 extend-filesystems[1705]: Found loop2 Nov 12 22:21:13.022775 extend-filesystems[1705]: Found loop3 Nov 12 22:21:13.022775 extend-filesystems[1705]: Found vda Nov 12 22:21:13.022775 extend-filesystems[1705]: Found vda1 Nov 12 22:21:13.022775 extend-filesystems[1705]: Found vda2 Nov 12 22:21:13.022775 extend-filesystems[1705]: Found vda3 Nov 12 22:21:13.022775 extend-filesystems[1705]: Found usr Nov 12 22:21:13.022775 extend-filesystems[1705]: Found vda4 Nov 12 22:21:13.026664 extend-filesystems[1705]: Found vda6 Nov 12 22:21:13.026664 extend-filesystems[1705]: Found vda7 Nov 12 22:21:13.026664 extend-filesystems[1705]: Found vda9 Nov 12 22:21:13.026664 extend-filesystems[1705]: Checking size of /dev/vda9 Nov 12 22:21:13.030035 augenrules[1732]: No rules Nov 12 22:21:13.027340 systemd[1]: audit-rules.service: Deactivated successfully. Nov 12 22:21:13.027528 systemd[1]: Finished audit-rules.service - Load Audit Rules. Nov 12 22:21:13.031425 systemd[1]: motdgen.service: Deactivated successfully. Nov 12 22:21:13.032064 systemd[1]: Finished motdgen.service - Generate /run/flatcar/motd. Nov 12 22:21:13.033685 systemd[1]: ssh-key-proc-cmdline.service: Deactivated successfully. Nov 12 22:21:13.033883 systemd[1]: Finished ssh-key-proc-cmdline.service - Install an ssh key from /proc/cmdline. Nov 12 22:21:13.034664 extend-filesystems[1705]: Old size kept for /dev/vda9 Nov 12 22:21:13.038498 systemd[1]: extend-filesystems.service: Deactivated successfully. Nov 12 22:21:13.038668 systemd[1]: Finished extend-filesystems.service - Extend Filesystems. Nov 12 22:21:13.040395 systemd[1]: coreos-metadata.service: Deactivated successfully. Nov 12 22:21:13.040612 systemd[1]: Finished coreos-metadata.service - QEMU metadata agent. Nov 12 22:21:13.041949 systemd[1]: packet-phone-home.service - Report Success to Packet was skipped because of an unmet condition check (ConditionFirstBoot=true). Nov 12 22:21:13.042196 systemd[1]: Reached target multi-user.target - Multi-User System. Nov 12 22:21:13.044806 sshd[1626]: Accepted publickey for core from 10.0.0.1 port 58918 ssh2: RSA SHA256:KPgpt/5uXhXBYNY6jU95wYzOWgpCWHnSiDnDh5jQRRc Nov 12 22:21:13.045541 sshd-session[1626]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Nov 12 22:21:13.046137 kernel: BTRFS warning: duplicate device /dev/vda3 devid 1 generation 41 scanned by (udev-worker) (1752) Nov 12 22:21:13.061835 systemd-logind[1363]: New session 11 of user core. Nov 12 22:21:13.073277 systemd[1]: Started session-11.scope - Session 11 of User core. Nov 12 22:21:13.217179 containerd[1722]: time="2024-11-12T22:21:13.217047278Z" level=info msg="starting containerd" revision=1c90a442489720eec95342e1789ee8a5e1b9536f version=v1.6.9 Nov 12 22:21:13.235598 containerd[1722]: time="2024-11-12T22:21:13.235498216Z" level=info msg="loading plugin \"io.containerd.content.v1.content\"..." type=io.containerd.content.v1 Nov 12 22:21:13.235701 containerd[1722]: time="2024-11-12T22:21:13.235632237Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.aufs\"..." type=io.containerd.snapshotter.v1 Nov 12 22:21:13.237649 containerd[1722]: time="2024-11-12T22:21:13.237189966Z" 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 22:21:13.237649 containerd[1722]: time="2024-11-12T22:21:13.237636529Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.btrfs\"..." type=io.containerd.snapshotter.v1 Nov 12 22:21:13.238030 containerd[1722]: time="2024-11-12T22:21:13.237992647Z" 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 22:21:13.238030 containerd[1722]: time="2024-11-12T22:21:13.238021122Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.devmapper\"..." type=io.containerd.snapshotter.v1 Nov 12 22:21:13.238096 containerd[1722]: time="2024-11-12T22:21:13.238037187Z" level=warning msg="failed to load plugin io.containerd.snapshotter.v1.devmapper" error="devmapper not configured" Nov 12 22:21:13.238096 containerd[1722]: time="2024-11-12T22:21:13.238048192Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.native\"..." type=io.containerd.snapshotter.v1 Nov 12 22:21:13.238186 containerd[1722]: time="2024-11-12T22:21:13.238159682Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.overlayfs\"..." type=io.containerd.snapshotter.v1 Nov 12 22:21:13.238403 containerd[1722]: time="2024-11-12T22:21:13.238376758Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.zfs\"..." type=io.containerd.snapshotter.v1 Nov 12 22:21:13.238532 containerd[1722]: time="2024-11-12T22:21:13.238507205Z" 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 22:21:13.238532 containerd[1722]: time="2024-11-12T22:21:13.238528772Z" level=info msg="loading plugin \"io.containerd.metadata.v1.bolt\"..." type=io.containerd.metadata.v1 Nov 12 22:21:13.238592 containerd[1722]: time="2024-11-12T22:21:13.238577047Z" level=warning msg="could not use snapshotter devmapper in metadata plugin" error="devmapper not configured" Nov 12 22:21:13.238657 containerd[1722]: time="2024-11-12T22:21:13.238592991Z" level=info msg="metadata content store policy set" policy=shared Nov 12 22:21:13.242305 containerd[1722]: time="2024-11-12T22:21:13.242273813Z" level=info msg="loading plugin \"io.containerd.differ.v1.walking\"..." type=io.containerd.differ.v1 Nov 12 22:21:13.242305 containerd[1722]: time="2024-11-12T22:21:13.242308192Z" level=info msg="loading plugin \"io.containerd.event.v1.exchange\"..." type=io.containerd.event.v1 Nov 12 22:21:13.242377 containerd[1722]: time="2024-11-12T22:21:13.242321084Z" level=info msg="loading plugin \"io.containerd.gc.v1.scheduler\"..." type=io.containerd.gc.v1 Nov 12 22:21:13.242377 containerd[1722]: time="2024-11-12T22:21:13.242365544Z" level=info msg="loading plugin \"io.containerd.service.v1.introspection-service\"..." type=io.containerd.service.v1 Nov 12 22:21:13.242411 containerd[1722]: time="2024-11-12T22:21:13.242379199Z" level=info msg="loading plugin \"io.containerd.service.v1.containers-service\"..." type=io.containerd.service.v1 Nov 12 22:21:13.242411 containerd[1722]: time="2024-11-12T22:21:13.242393255Z" level=info msg="loading plugin \"io.containerd.service.v1.content-service\"..." type=io.containerd.service.v1 Nov 12 22:21:13.242411 containerd[1722]: time="2024-11-12T22:21:13.242405425Z" level=info msg="loading plugin \"io.containerd.service.v1.diff-service\"..." type=io.containerd.service.v1 Nov 12 22:21:13.242738 containerd[1722]: time="2024-11-12T22:21:13.242720256Z" level=info msg="loading plugin \"io.containerd.service.v1.images-service\"..." type=io.containerd.service.v1 Nov 12 22:21:13.242764 containerd[1722]: time="2024-11-12T22:21:13.242741662Z" level=info msg="loading plugin \"io.containerd.service.v1.leases-service\"..." type=io.containerd.service.v1 Nov 12 22:21:13.242764 containerd[1722]: time="2024-11-12T22:21:13.242756362Z" level=info msg="loading plugin \"io.containerd.service.v1.namespaces-service\"..." type=io.containerd.service.v1 Nov 12 22:21:13.242804 containerd[1722]: time="2024-11-12T22:21:13.242767808Z" level=info msg="loading plugin \"io.containerd.service.v1.snapshots-service\"..." type=io.containerd.service.v1 Nov 12 22:21:13.242804 containerd[1722]: time="2024-11-12T22:21:13.242780097Z" level=info msg="loading plugin \"io.containerd.runtime.v1.linux\"..." type=io.containerd.runtime.v1 Nov 12 22:21:13.242911 containerd[1722]: time="2024-11-12T22:21:13.242894359Z" level=info msg="loading plugin \"io.containerd.runtime.v2.task\"..." type=io.containerd.runtime.v2 Nov 12 22:21:13.242982 containerd[1722]: time="2024-11-12T22:21:13.242969341Z" level=info msg="loading plugin \"io.containerd.monitor.v1.cgroups\"..." type=io.containerd.monitor.v1 Nov 12 22:21:13.243437 containerd[1722]: time="2024-11-12T22:21:13.243414057Z" level=info msg="loading plugin \"io.containerd.service.v1.tasks-service\"..." type=io.containerd.service.v1 Nov 12 22:21:13.243468 containerd[1722]: time="2024-11-12T22:21:13.243451568Z" level=info msg="loading plugin \"io.containerd.grpc.v1.introspection\"..." type=io.containerd.grpc.v1 Nov 12 22:21:13.243487 containerd[1722]: time="2024-11-12T22:21:13.243467232Z" level=info msg="loading plugin \"io.containerd.internal.v1.restart\"..." type=io.containerd.internal.v1 Nov 12 22:21:13.243605 containerd[1722]: time="2024-11-12T22:21:13.243592819Z" level=info msg="loading plugin \"io.containerd.grpc.v1.containers\"..." type=io.containerd.grpc.v1 Nov 12 22:21:13.243634 containerd[1722]: time="2024-11-12T22:21:13.243609486Z" level=info msg="loading plugin \"io.containerd.grpc.v1.content\"..." type=io.containerd.grpc.v1 Nov 12 22:21:13.243634 containerd[1722]: time="2024-11-12T22:21:13.243622057Z" level=info msg="loading plugin \"io.containerd.grpc.v1.diff\"..." type=io.containerd.grpc.v1 Nov 12 22:21:13.243672 containerd[1722]: time="2024-11-12T22:21:13.243633101Z" level=info msg="loading plugin \"io.containerd.grpc.v1.events\"..." type=io.containerd.grpc.v1 Nov 12 22:21:13.243672 containerd[1722]: time="2024-11-12T22:21:13.243644708Z" level=info msg="loading plugin \"io.containerd.grpc.v1.healthcheck\"..." type=io.containerd.grpc.v1 Nov 12 22:21:13.243709 containerd[1722]: time="2024-11-12T22:21:13.243670573Z" level=info msg="loading plugin \"io.containerd.grpc.v1.images\"..." type=io.containerd.grpc.v1 Nov 12 22:21:13.243709 containerd[1722]: time="2024-11-12T22:21:13.243682139Z" level=info msg="loading plugin \"io.containerd.grpc.v1.leases\"..." type=io.containerd.grpc.v1 Nov 12 22:21:13.243709 containerd[1722]: time="2024-11-12T22:21:13.243693305Z" level=info msg="loading plugin \"io.containerd.grpc.v1.namespaces\"..." type=io.containerd.grpc.v1 Nov 12 22:21:13.243709 containerd[1722]: time="2024-11-12T22:21:13.243705835Z" level=info msg="loading plugin \"io.containerd.internal.v1.opt\"..." type=io.containerd.internal.v1 Nov 12 22:21:13.243845 containerd[1722]: time="2024-11-12T22:21:13.243828490Z" level=info msg="loading plugin \"io.containerd.grpc.v1.snapshots\"..." type=io.containerd.grpc.v1 Nov 12 22:21:13.243865 containerd[1722]: time="2024-11-12T22:21:13.243857046Z" level=info msg="loading plugin \"io.containerd.grpc.v1.tasks\"..." type=io.containerd.grpc.v1 Nov 12 22:21:13.243890 containerd[1722]: time="2024-11-12T22:21:13.243870500Z" level=info msg="loading plugin \"io.containerd.grpc.v1.version\"..." type=io.containerd.grpc.v1 Nov 12 22:21:13.243890 containerd[1722]: time="2024-11-12T22:21:13.243882308Z" level=info msg="loading plugin \"io.containerd.tracing.processor.v1.otlp\"..." type=io.containerd.tracing.processor.v1 Nov 12 22:21:13.243925 containerd[1722]: time="2024-11-12T22:21:13.243897449Z" 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 22:21:13.243925 containerd[1722]: time="2024-11-12T22:21:13.243908413Z" level=info msg="loading plugin \"io.containerd.internal.v1.tracing\"..." type=io.containerd.internal.v1 Nov 12 22:21:13.243961 containerd[1722]: time="2024-11-12T22:21:13.243924277Z" level=error msg="failed to initialize a tracing processor \"otlp\"" error="no OpenTelemetry endpoint: skip plugin" Nov 12 22:21:13.243961 containerd[1722]: time="2024-11-12T22:21:13.243956728Z" level=info msg="loading plugin \"io.containerd.grpc.v1.cri\"..." type=io.containerd.grpc.v1 Nov 12 22:21:13.244234 containerd[1722]: time="2024-11-12T22:21:13.244185211Z" 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 22:21:13.244340 containerd[1722]: time="2024-11-12T22:21:13.244245213Z" level=info msg="Connect containerd service" Nov 12 22:21:13.244340 containerd[1722]: time="2024-11-12T22:21:13.244277343Z" level=info msg="Get image filesystem path \"/var/lib/containerd/io.containerd.snapshotter.v1.overlayfs\"" Nov 12 22:21:13.246239 containerd[1722]: time="2024-11-12T22:21:13.246210428Z" 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 22:21:13.247135 containerd[1722]: time="2024-11-12T22:21:13.246967123Z" level=info msg="Start subscribing containerd event" Nov 12 22:21:13.247135 containerd[1722]: time="2024-11-12T22:21:13.247031784Z" level=info msg="Start recovering state" Nov 12 22:21:13.247224 containerd[1722]: time="2024-11-12T22:21:13.247138856Z" level=info msg=serving... address=/run/containerd/containerd.sock.ttrpc Nov 12 22:21:13.247224 containerd[1722]: time="2024-11-12T22:21:13.247192232Z" level=info msg=serving... address=/run/containerd/containerd.sock Nov 12 22:21:13.247224 containerd[1722]: time="2024-11-12T22:21:13.247213919Z" level=info msg="containerd successfully booted in 0.032238s" Nov 12 22:21:13.247735 containerd[1722]: time="2024-11-12T22:21:13.247704942Z" level=info msg="Start event monitor" Nov 12 22:21:13.249314 containerd[1722]: time="2024-11-12T22:21:13.249286006Z" level=info msg="Start snapshots syncer" Nov 12 22:21:13.249314 containerd[1722]: time="2024-11-12T22:21:13.249315405Z" level=info msg="Start cni network conf syncer for default" Nov 12 22:21:13.249395 containerd[1722]: time="2024-11-12T22:21:13.249323919Z" level=info msg="Start streaming server" Nov 12 22:21:13.259345 systemd[1]: Starting docker.service - Docker Application Container Engine... Nov 12 22:21:13.259493 (dockerd)[1777]: 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 22:21:13.499326 dockerd[1777]: time="2024-11-12T22:21:13.499209465Z" level=info msg="Starting up" Nov 12 22:21:13.503167 dockerd[1777]: time="2024-11-12T22:21:13.503135276Z" level=info msg="parsed scheme: \"unix\"" module=grpc Nov 12 22:21:13.503167 dockerd[1777]: time="2024-11-12T22:21:13.503161502Z" level=info msg="scheme \"unix\" not registered, fallback to default scheme" module=grpc Nov 12 22:21:13.503304 dockerd[1777]: time="2024-11-12T22:21:13.503184314Z" level=info msg="ccResolverWrapper: sending update to cc: {[{unix:///run/containerd/containerd.sock 0 }] }" module=grpc Nov 12 22:21:13.503304 dockerd[1777]: time="2024-11-12T22:21:13.503200098Z" level=info msg="ClientConn switching balancer to \"pick_first\"" module=grpc Nov 12 22:21:13.510145 dockerd[1777]: time="2024-11-12T22:21:13.510104776Z" level=info msg="parsed scheme: \"unix\"" module=grpc Nov 12 22:21:13.510145 dockerd[1777]: time="2024-11-12T22:21:13.510139517Z" level=info msg="scheme \"unix\" not registered, fallback to default scheme" module=grpc Nov 12 22:21:13.510252 dockerd[1777]: time="2024-11-12T22:21:13.510162329Z" level=info msg="ccResolverWrapper: sending update to cc: {[{unix:///run/containerd/containerd.sock 0 }] }" module=grpc Nov 12 22:21:13.510252 dockerd[1777]: time="2024-11-12T22:21:13.510172731Z" level=info msg="ClientConn switching balancer to \"pick_first\"" module=grpc Nov 12 22:21:13.656256 dockerd[1777]: time="2024-11-12T22:21:13.656209413Z" level=info msg="Loading containers: start." Nov 12 22:21:13.740148 kernel: Initializing XFRM netlink socket Nov 12 22:21:13.754495 dockerd[1777]: time="2024-11-12T22:21:13.754388665Z" 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 22:21:13.796980 systemd-networkd[1317]: docker0: Link UP Nov 12 22:21:13.814746 dockerd[1777]: time="2024-11-12T22:21:13.814657931Z" level=info msg="Loading containers: done." Nov 12 22:21:13.848100 systemd[1]: var-lib-docker-overlay2-opaque\x2dbug\x2dcheck530133186-merged.mount: Deactivated successfully. Nov 12 22:21:13.849920 dockerd[1777]: time="2024-11-12T22:21:13.849877012Z" 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 22:21:13.850209 dockerd[1777]: time="2024-11-12T22:21:13.850181522Z" level=info msg="Docker daemon" commit=3056208 graphdriver(s)=overlay2 version=20.10.21 Nov 12 22:21:13.850307 dockerd[1777]: time="2024-11-12T22:21:13.850285542Z" level=info msg="Daemon has completed initialization" Nov 12 22:21:13.864066 systemd[1]: Started docker.service - Docker Application Container Engine. Nov 12 22:21:13.867702 dockerd[1777]: time="2024-11-12T22:21:13.867599610Z" level=info msg="API listen on /run/docker.sock" Nov 12 22:21:14.994530 kernel: docker0: port 1(veth2995fcd) entered blocking state Nov 12 22:21:14.994698 kernel: docker0: port 1(veth2995fcd) entered disabled state Nov 12 22:21:14.994721 kernel: veth2995fcd: entered allmulticast mode Nov 12 22:21:14.994739 kernel: veth2995fcd: entered promiscuous mode Nov 12 22:21:14.995547 systemd-networkd[1317]: veth2995fcd: Link UP Nov 12 22:21:15.044012 containerd[1722]: time="2024-11-12T22:21:15.043926985Z" level=info msg="loading plugin \"io.containerd.event.v1.publisher\"..." runtime=io.containerd.runc.v2 type=io.containerd.event.v1 Nov 12 22:21:15.044012 containerd[1722]: time="2024-11-12T22:21:15.043974452Z" level=info msg="loading plugin \"io.containerd.internal.v1.shutdown\"..." runtime=io.containerd.runc.v2 type=io.containerd.internal.v1 Nov 12 22:21:15.044370 containerd[1722]: time="2024-11-12T22:21:15.043984804Z" level=info msg="loading plugin \"io.containerd.ttrpc.v1.task\"..." runtime=io.containerd.runc.v2 type=io.containerd.ttrpc.v1 Nov 12 22:21:15.044438 containerd[1722]: time="2024-11-12T22:21:15.044247135Z" level=info msg="starting signal loop" namespace=moby path=/run/containerd/io.containerd.runtime.v2.task/moby/3c75e48903fa1eb67e09a4c3122891066d3c0b753fa1645b9a01dcde14259aef pid=1912 runtime=io.containerd.runc.v2 Nov 12 22:21:15.062239 systemd[1]: Started docker-3c75e48903fa1eb67e09a4c3122891066d3c0b753fa1645b9a01dcde14259aef.scope - libcontainer container 3c75e48903fa1eb67e09a4c3122891066d3c0b753fa1645b9a01dcde14259aef. Nov 12 22:21:15.134138 kernel: eth0: renamed from vethb48806a Nov 12 22:21:15.147737 systemd-networkd[1317]: veth2995fcd: Gained carrier Nov 12 22:21:15.148409 kernel: docker0: port 1(veth2995fcd) entered blocking state Nov 12 22:21:15.148464 kernel: docker0: port 1(veth2995fcd) entered forwarding state Nov 12 22:21:15.148375 systemd-networkd[1317]: docker0: Gained carrier Nov 12 22:21:15.149826 systemd-resolved[1268]: Failed to determine the local hostname and LLMNR/mDNS names, ignoring: No such device or address Nov 12 22:21:15.168376 systemd[1]: docker-3c75e48903fa1eb67e09a4c3122891066d3c0b753fa1645b9a01dcde14259aef.scope: Deactivated successfully. Nov 12 22:21:15.178452 dockerd[1777]: time="2024-11-12T22:21:15.178399395Z" level=info msg="ignoring event" container=3c75e48903fa1eb67e09a4c3122891066d3c0b753fa1645b9a01dcde14259aef module=libcontainerd namespace=moby topic=/tasks/delete type="*events.TaskDelete" Nov 12 22:21:15.179308 containerd[1722]: time="2024-11-12T22:21:15.178567395Z" level=info msg="shim disconnected" id=3c75e48903fa1eb67e09a4c3122891066d3c0b753fa1645b9a01dcde14259aef Nov 12 22:21:15.179308 containerd[1722]: time="2024-11-12T22:21:15.178622044Z" level=warning msg="cleaning up after shim disconnected" id=3c75e48903fa1eb67e09a4c3122891066d3c0b753fa1645b9a01dcde14259aef namespace=moby Nov 12 22:21:15.179308 containerd[1722]: time="2024-11-12T22:21:15.178634041Z" level=info msg="cleaning up dead shim" Nov 12 22:21:15.184029 containerd[1722]: time="2024-11-12T22:21:15.183986844Z" level=warning msg="cleanup warnings time=\"2024-11-12T22:21:15Z\" level=info msg=\"starting signal loop\" namespace=moby pid=1966 runtime=io.containerd.runc.v2\n" Nov 12 22:21:15.187675 systemd-networkd[1317]: veth2995fcd: Lost carrier Nov 12 22:21:15.188162 kernel: docker0: port 1(veth2995fcd) entered disabled state Nov 12 22:21:15.188202 kernel: vethb48806a: renamed from eth0 Nov 12 22:21:15.208136 systemd-networkd[1317]: veth2995fcd: Link DOWN Nov 12 22:21:15.209551 kernel: docker0: port 1(veth2995fcd) entered disabled state Nov 12 22:21:15.209602 kernel: veth2995fcd (unregistering): left allmulticast mode Nov 12 22:21:15.209620 kernel: veth2995fcd (unregistering): left promiscuous mode Nov 12 22:21:15.210485 kernel: docker0: port 1(veth2995fcd) entered disabled state Nov 12 22:21:15.245325 sshd[1764]: Connection closed by 10.0.0.1 port 58918 Nov 12 22:21:15.245628 sshd-session[1626]: pam_unix(sshd:session): session closed for user core Nov 12 22:21:15.257365 systemd[1]: sshd@10-10.0.0.27:22-10.0.0.1:58918.service: Deactivated successfully. Nov 12 22:21:15.258727 systemd[1]: session-11.scope: Deactivated successfully. Nov 12 22:21:15.260698 systemd-logind[1363]: Session 11 logged out. Waiting for processes to exit. Nov 12 22:21:15.267356 systemd[1]: Started sshd@11-10.0.0.27:22-10.0.0.1:58934.service - OpenSSH per-connection server daemon (10.0.0.1:58934). Nov 12 22:21:15.268186 systemd-logind[1363]: Removed session 11. Nov 12 22:21:15.300790 sshd[1985]: Accepted publickey for core from 10.0.0.1 port 58934 ssh2: RSA SHA256:KPgpt/5uXhXBYNY6jU95wYzOWgpCWHnSiDnDh5jQRRc Nov 12 22:21:15.301855 sshd-session[1985]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Nov 12 22:21:15.305276 systemd-logind[1363]: New session 12 of user core. Nov 12 22:21:15.313229 systemd[1]: Started session-12.scope - Session 12 of User core. Nov 12 22:21:15.378446 sshd[1987]: Connection closed by 10.0.0.1 port 58934 Nov 12 22:21:15.379166 sshd-session[1985]: pam_unix(sshd:session): session closed for user core Nov 12 22:21:15.394480 systemd[1]: sshd@11-10.0.0.27:22-10.0.0.1:58934.service: Deactivated successfully. Nov 12 22:21:15.396026 systemd[1]: session-12.scope: Deactivated successfully. Nov 12 22:21:15.399422 systemd-logind[1363]: Session 12 logged out. Waiting for processes to exit. Nov 12 22:21:15.400524 systemd[1]: Started sshd@12-10.0.0.27:22-10.0.0.1:58944.service - OpenSSH per-connection server daemon (10.0.0.1:58944). Nov 12 22:21:15.401268 systemd-logind[1363]: Removed session 12. Nov 12 22:21:15.438437 sshd[1995]: Accepted publickey for core from 10.0.0.1 port 58944 ssh2: RSA SHA256:KPgpt/5uXhXBYNY6jU95wYzOWgpCWHnSiDnDh5jQRRc Nov 12 22:21:15.439675 sshd-session[1995]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Nov 12 22:21:15.443525 systemd-logind[1363]: New session 13 of user core. Nov 12 22:21:15.459338 systemd[1]: Started session-13.scope - Session 13 of User core. Nov 12 22:21:15.962232 systemd[1]: var-lib-docker-overlay2-5d995292679be6d553b08cb72377608ab01f4706fbaa150a6815271eebd22a34-merged.mount: Deactivated successfully. Nov 12 22:21:16.047413 systemd-networkd[1317]: docker0: Lost carrier Nov 12 22:21:16.559255 systemd-networkd[1317]: docker0: Gained IPv6LL Nov 12 22:21:20.677710 sudo[1998]: core : PWD=/home/core ; USER=root ; COMMAND=/usr/sbin/mv docker.raw containerd.raw /etc/extensions/ Nov 12 22:21:20.677994 sudo[1998]: pam_unix(sudo:session): session opened for user root(uid=0) by core(uid=500) Nov 12 22:21:20.845126 sudo[1998]: pam_unix(sudo:session): session closed for user root Nov 12 22:21:20.847397 sshd[1997]: Connection closed by 10.0.0.1 port 58944 Nov 12 22:21:20.847851 sshd-session[1995]: pam_unix(sshd:session): session closed for user core Nov 12 22:21:20.859537 systemd[1]: sshd@12-10.0.0.27:22-10.0.0.1:58944.service: Deactivated successfully. Nov 12 22:21:20.860814 systemd[1]: session-13.scope: Deactivated successfully. Nov 12 22:21:20.862153 systemd[1]: session-13.scope: Consumed 3.759s CPU time. Nov 12 22:21:20.864295 systemd-logind[1363]: Session 13 logged out. Waiting for processes to exit. Nov 12 22:21:20.864674 systemd[1]: Started sshd@13-10.0.0.27:22-10.0.0.1:58960.service - OpenSSH per-connection server daemon (10.0.0.1:58960). Nov 12 22:21:20.865734 systemd-logind[1363]: Removed session 13. Nov 12 22:21:20.907898 sshd[2055]: Accepted publickey for core from 10.0.0.1 port 58960 ssh2: RSA SHA256:KPgpt/5uXhXBYNY6jU95wYzOWgpCWHnSiDnDh5jQRRc Nov 12 22:21:20.908973 sshd-session[2055]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Nov 12 22:21:20.912921 systemd-logind[1363]: New session 14 of user core. Nov 12 22:21:20.924263 systemd[1]: Started session-14.scope - Session 14 of User core. Nov 12 22:21:20.974647 sudo[2059]: core : PWD=/home/core ; USER=root ; COMMAND=/usr/sbin/systemctl restart systemd-sysext Nov 12 22:21:20.975293 sudo[2059]: pam_unix(sudo:session): session opened for user root(uid=0) by core(uid=500) Nov 12 22:21:20.982251 systemd[1]: ensure-sysext.service: Deactivated successfully. Nov 12 22:21:20.982438 systemd[1]: Stopped ensure-sysext.service. Nov 12 22:21:20.982491 systemd[1]: Stopping ensure-sysext.service... Nov 12 22:21:20.991383 systemd[1]: Stopping systemd-sysext.service - Merge System Extension Images into /usr/ and /opt/... Nov 12 22:21:20.994415 systemd-sysext[2061]: Unmerged '/usr'. Nov 12 22:21:20.998686 systemd[1]: systemd-sysext.service: Deactivated successfully. Nov 12 22:21:20.998875 systemd[1]: Stopped systemd-sysext.service - Merge System Extension Images into /usr/ and /opt/. Nov 12 22:21:21.002425 systemd[1]: Starting systemd-sysext.service - Merge System Extension Images into /usr/ and /opt/... Nov 12 22:21:21.008128 kernel: loop4: detected capacity change from 0 to 325776 Nov 12 22:21:21.013125 kernel: EXT4-fs (loop4): mounted filesystem f135729e-6a96-4413-a79e-0a67d0dcdcf1 ro without journal. Quota mode: none. Nov 12 22:21:21.015145 kernel: EXT4-fs (loop4): unmounting filesystem f135729e-6a96-4413-a79e-0a67d0dcdcf1. Nov 12 22:21:21.048148 kernel: loop5: detected capacity change from 0 to 301288 Nov 12 22:21:21.052132 kernel: EXT4-fs (loop5): mounted filesystem 4b5361f2-ee59-49f7-80c5-abec3aac9f11 ro without journal. Quota mode: none. Nov 12 22:21:21.055138 kernel: EXT4-fs (loop5): unmounting filesystem 4b5361f2-ee59-49f7-80c5-abec3aac9f11. Nov 12 22:21:21.084134 kernel: loop6: detected capacity change from 0 to 325776 Nov 12 22:21:21.088125 kernel: EXT4-fs (loop6): mounted filesystem f135729e-6a96-4413-a79e-0a67d0dcdcf1 ro without journal. Quota mode: none. Nov 12 22:21:21.090128 kernel: loop7: detected capacity change from 0 to 301288 Nov 12 22:21:21.092921 (sd-merge)[2070]: Using extensions 'containerd', 'docker'. Nov 12 22:21:21.093189 kernel: EXT4-fs (loop7): mounted filesystem 4b5361f2-ee59-49f7-80c5-abec3aac9f11 ro without journal. Quota mode: none. Nov 12 22:21:21.093306 (sd-merge)[2070]: Merged extensions into '/usr'. Nov 12 22:21:21.096379 systemd[1]: Finished systemd-sysext.service - Merge System Extension Images into /usr/ and /opt/. Nov 12 22:21:21.097820 sudo[2059]: pam_unix(sudo:session): session closed for user root Nov 12 22:21:21.103051 sudo[2058]: core : PWD=/home/core ; USER=root ; COMMAND=/usr/sbin/systemctl restart docker containerd Nov 12 22:21:21.103356 sudo[2058]: pam_unix(sudo:session): session opened for user root(uid=0) by core(uid=500) Nov 12 22:21:21.104419 systemd[1]: Starting ensure-sysext.service... Nov 12 22:21:21.111087 systemd[1]: Reloading requested from client PID 2074 ('systemctl') (unit ensure-sysext.service)... Nov 12 22:21:21.111100 systemd[1]: Reloading... Nov 12 22:21:21.180208 zram_generator::config[2115]: No configuration found. Nov 12 22:21:21.323009 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 22:21:21.371959 systemd[1]: Reloading finished in 260 ms. Nov 12 22:21:21.415618 systemd[1]: Stopped target sockets.target - Socket Units. Nov 12 22:21:21.415635 systemd[1]: Stopping sockets.target - Socket Units... Nov 12 22:21:21.415722 systemd[1]: Stopped target timers.target - Timer Units. Nov 12 22:21:21.415729 systemd[1]: Stopping timers.target - Timer Units... Nov 12 22:21:21.415818 systemd[1]: Reached target timers.target - Timer Units. Nov 12 22:21:21.416157 systemd[1]: Stopping docker.service - Docker Application Container Engine... Nov 12 22:21:21.416520 dockerd[1777]: time="2024-11-12T22:21:21.416166153Z" level=info msg="Processing signal 'terminated'" Nov 12 22:21:21.416924 dockerd[1777]: time="2024-11-12T22:21:21.416777523Z" level=info msg="Daemon shutdown complete" Nov 12 22:21:21.419131 systemd[1]: docker.service: Deactivated successfully. Nov 12 22:21:21.419430 systemd[1]: Stopped docker.service - Docker Application Container Engine. Nov 12 22:21:21.420437 systemd[1]: Stopped target multi-user.target - Multi-User System. Nov 12 22:21:21.420467 systemd[1]: Stopping multi-user.target - Multi-User System... Nov 12 22:21:21.420508 systemd[1]: update-engine-stub.timer - Update Engine Stub Timer was skipped because of an unmet condition check (ConditionPathExists=/usr/.noupdate). Nov 12 22:21:21.420793 systemd[1]: docker.socket: Deactivated successfully. Nov 12 22:21:21.421131 systemd[1]: Closed docker.socket - Docker Socket for the API. Nov 12 22:21:21.421168 systemd[1]: Stopping docker.socket - Docker Socket for the API... Nov 12 22:21:21.422614 systemd[1]: Starting docker.socket - Docker Socket for the API... Nov 12 22:21:21.435317 systemd[1]: Starting audit-rules.service - Load Audit Rules... Nov 12 22:21:21.435550 systemd[1]: Stopping containerd.service - containerd container runtime... Nov 12 22:21:21.435804 containerd[1722]: time="2024-11-12T22:21:21.435675011Z" level=info msg="Stop CRI service" Nov 12 22:21:21.437451 containerd[1722]: time="2024-11-12T22:21:21.436146066Z" level=info msg="Stop CRI service" Nov 12 22:21:21.437908 systemd[1]: Starting coreos-metadata.service - QEMU metadata agent... Nov 12 22:21:21.439189 systemd[1]: Starting enable-oem-cloudinit.service - Enable cloudinit... Nov 12 22:21:21.441355 systemd[1]: Starting extend-filesystems.service - Extend Filesystems... Nov 12 22:21:21.442694 systemd[1]: Starting issuegen.service - Generate /run/issue... Nov 12 22:21:21.445108 jq[2152]: false Nov 12 22:21:21.446206 systemd[1]: Starting motdgen.service - Generate /run/flatcar/motd... Nov 12 22:21:21.448494 systemd[1]: Starting ssh-key-proc-cmdline.service - Install an ssh key from /proc/cmdline... Nov 12 22:21:21.448689 systemd[1]: sshkeys.service was skipped because no trigger condition checks were met. Nov 12 22:21:21.448873 systemd[1]: tcsd.service - TCG Core Services Daemon was skipped because of an unmet condition check (ConditionPathExists=/dev/tpm0). Nov 12 22:21:21.451061 systemd[1]: containerd.service: Deactivated successfully. Nov 12 22:21:21.451370 systemd[1]: Stopped containerd.service - containerd container runtime. Nov 12 22:21:21.451791 systemd[1]: Listening on docker.socket - Docker Socket for the API. Nov 12 22:21:21.454038 augenrules[2150]: /sbin/augenrules: No change Nov 12 22:21:21.457458 systemd[1]: enable-oem-cloudinit.service: Skipped due to 'exec-condition'. Nov 12 22:21:21.457621 systemd[1]: Condition check resulted in enable-oem-cloudinit.service - Enable cloudinit being skipped. Nov 12 22:21:21.460273 systemd[1]: issuegen.service: Deactivated successfully. Nov 12 22:21:21.460438 systemd[1]: Finished issuegen.service - Generate /run/issue. Nov 12 22:21:21.461427 systemd[1]: ssh-key-proc-cmdline.service: Deactivated successfully. Nov 12 22:21:21.461592 systemd[1]: Finished ssh-key-proc-cmdline.service - Install an ssh key from /proc/cmdline. Nov 12 22:21:21.462445 augenrules[2177]: No rules Nov 12 22:21:21.463352 extend-filesystems[2153]: Found loop2 Nov 12 22:21:21.464777 extend-filesystems[2153]: Found loop3 Nov 12 22:21:21.464777 extend-filesystems[2153]: Found loop6 Nov 12 22:21:21.464777 extend-filesystems[2153]: Found loop7 Nov 12 22:21:21.464777 extend-filesystems[2153]: Found vda Nov 12 22:21:21.464777 extend-filesystems[2153]: Found vda1 Nov 12 22:21:21.464777 extend-filesystems[2153]: Found vda2 Nov 12 22:21:21.464777 extend-filesystems[2153]: Found vda3 Nov 12 22:21:21.464777 extend-filesystems[2153]: Found usr Nov 12 22:21:21.464777 extend-filesystems[2153]: Found vda4 Nov 12 22:21:21.464777 extend-filesystems[2153]: Found vda6 Nov 12 22:21:21.464777 extend-filesystems[2153]: Found vda7 Nov 12 22:21:21.464777 extend-filesystems[2153]: Found vda9 Nov 12 22:21:21.464777 extend-filesystems[2153]: Checking size of /dev/vda9 Nov 12 22:21:21.472611 extend-filesystems[2153]: Old size kept for /dev/vda9 Nov 12 22:21:21.465067 systemd[1]: Finished ensure-sysext.service. Nov 12 22:21:21.465698 systemd[1]: audit-rules.service: Deactivated successfully. Nov 12 22:21:21.466189 systemd[1]: Finished audit-rules.service - Load Audit Rules. Nov 12 22:21:21.476177 systemd[1]: extend-filesystems.service: Deactivated successfully. Nov 12 22:21:21.476352 systemd[1]: Finished extend-filesystems.service - Extend Filesystems. Nov 12 22:21:21.476931 systemd[1]: motdgen.service: Deactivated successfully. Nov 12 22:21:21.477104 systemd[1]: Finished motdgen.service - Generate /run/flatcar/motd. Nov 12 22:21:21.477698 systemd[1]: coreos-metadata.service: Deactivated successfully. Nov 12 22:21:21.477865 systemd[1]: Finished coreos-metadata.service - QEMU metadata agent. Nov 12 22:21:21.482393 kernel: BTRFS warning: duplicate device /dev/vda3 devid 1 generation 41 scanned by (udev-worker) (2190) Nov 12 22:21:21.496974 systemd[1]: Reached target sockets.target - Socket Units. Nov 12 22:21:21.513636 systemd[1]: Starting containerd.service - containerd container runtime... Nov 12 22:21:21.513666 systemd[1]: packet-phone-home.service - Report Success to Packet was skipped because of an unmet condition check (ConditionFirstBoot=true). Nov 12 22:21:21.522841 systemd[1]: Started containerd.service - containerd container runtime. Nov 12 22:21:21.523426 systemd[1]: Reached target multi-user.target - Multi-User System. Nov 12 22:21:21.524733 systemd[1]: Starting docker.service - Docker Application Container Engine... Nov 12 22:21:21.528013 (dockerd)[2211]: 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 22:21:21.720670 containerd[2210]: time="2024-11-12T22:21:21.720539593Z" level=info msg="starting containerd" revision=472731909fa34bd7bc9c087e4c27943f9835f111 version=v1.7.21 Nov 12 22:21:21.744486 containerd[2210]: time="2024-11-12T22:21:21.744440280Z" level=info msg="loading plugin \"io.containerd.event.v1.exchange\"..." type=io.containerd.event.v1 Nov 12 22:21:21.744486 containerd[2210]: time="2024-11-12T22:21:21.744482819Z" level=info msg="loading plugin \"io.containerd.internal.v1.opt\"..." type=io.containerd.internal.v1 Nov 12 22:21:21.744626 containerd[2210]: time="2024-11-12T22:21:21.744511499Z" level=info msg="loading plugin \"io.containerd.warning.v1.deprecations\"..." type=io.containerd.warning.v1 Nov 12 22:21:21.744626 containerd[2210]: time="2024-11-12T22:21:21.744524878Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.blockfile\"..." type=io.containerd.snapshotter.v1 Nov 12 22:21:21.744665 containerd[2210]: time="2024-11-12T22:21:21.744624216Z" 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 22:21:21.744665 containerd[2210]: time="2024-11-12T22:21:21.744636913Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.devmapper\"..." type=io.containerd.snapshotter.v1 Nov 12 22:21:21.744665 containerd[2210]: time="2024-11-12T22:21:21.744649130Z" level=info msg="skip loading plugin \"io.containerd.snapshotter.v1.devmapper\"..." error="devmapper not configured: skip plugin" type=io.containerd.snapshotter.v1 Nov 12 22:21:21.744665 containerd[2210]: time="2024-11-12T22:21:21.744657702Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.native\"..." type=io.containerd.snapshotter.v1 Nov 12 22:21:21.744733 containerd[2210]: time="2024-11-12T22:21:21.744676448Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.overlayfs\"..." type=io.containerd.snapshotter.v1 Nov 12 22:21:21.744800 containerd[2210]: time="2024-11-12T22:21:21.744779952Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.aufs\"..." type=io.containerd.snapshotter.v1 Nov 12 22:21:21.746608 containerd[2210]: time="2024-11-12T22:21:21.746564194Z" 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 22:21:21.746608 containerd[2210]: time="2024-11-12T22:21:21.746603489Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.zfs\"..." type=io.containerd.snapshotter.v1 Nov 12 22:21:21.746748 containerd[2210]: time="2024-11-12T22:21:21.746729504Z" 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 22:21:21.746748 containerd[2210]: time="2024-11-12T22:21:21.746746528Z" level=info msg="loading plugin \"io.containerd.content.v1.content\"..." type=io.containerd.content.v1 Nov 12 22:21:21.746796 containerd[2210]: time="2024-11-12T22:21:21.746766476Z" level=info msg="loading plugin \"io.containerd.metadata.v1.bolt\"..." type=io.containerd.metadata.v1 Nov 12 22:21:21.746796 containerd[2210]: time="2024-11-12T22:21:21.746784180Z" level=info msg="metadata content store policy set" policy=shared Nov 12 22:21:21.747269 containerd[2210]: time="2024-11-12T22:21:21.747246383Z" level=info msg="loading plugin \"io.containerd.gc.v1.scheduler\"..." type=io.containerd.gc.v1 Nov 12 22:21:21.747310 containerd[2210]: time="2024-11-12T22:21:21.747288161Z" level=info msg="loading plugin \"io.containerd.differ.v1.walking\"..." type=io.containerd.differ.v1 Nov 12 22:21:21.747310 containerd[2210]: time="2024-11-12T22:21:21.747304865Z" level=info msg="loading plugin \"io.containerd.lease.v1.manager\"..." type=io.containerd.lease.v1 Nov 12 22:21:21.747360 containerd[2210]: time="2024-11-12T22:21:21.747318884Z" level=info msg="loading plugin \"io.containerd.streaming.v1.manager\"..." type=io.containerd.streaming.v1 Nov 12 22:21:21.747360 containerd[2210]: time="2024-11-12T22:21:21.747332343Z" level=info msg="loading plugin \"io.containerd.runtime.v1.linux\"..." type=io.containerd.runtime.v1 Nov 12 22:21:21.747401 containerd[2210]: time="2024-11-12T22:21:21.747382573Z" level=info msg="loading plugin \"io.containerd.monitor.v1.cgroups\"..." type=io.containerd.monitor.v1 Nov 12 22:21:21.747876 containerd[2210]: time="2024-11-12T22:21:21.747855671Z" level=info msg="loading plugin \"io.containerd.runtime.v2.task\"..." type=io.containerd.runtime.v2 Nov 12 22:21:21.747966 containerd[2210]: time="2024-11-12T22:21:21.747953046Z" level=info msg="loading plugin \"io.containerd.runtime.v2.shim\"..." type=io.containerd.runtime.v2 Nov 12 22:21:21.748012 containerd[2210]: time="2024-11-12T22:21:21.747970471Z" level=info msg="loading plugin \"io.containerd.sandbox.store.v1.local\"..." type=io.containerd.sandbox.store.v1 Nov 12 22:21:21.748012 containerd[2210]: time="2024-11-12T22:21:21.747992261Z" level=info msg="loading plugin \"io.containerd.sandbox.controller.v1.local\"..." type=io.containerd.sandbox.controller.v1 Nov 12 22:21:21.748012 containerd[2210]: time="2024-11-12T22:21:21.748005119Z" level=info msg="loading plugin \"io.containerd.service.v1.containers-service\"..." type=io.containerd.service.v1 Nov 12 22:21:21.748070 containerd[2210]: time="2024-11-12T22:21:21.748017576Z" level=info msg="loading plugin \"io.containerd.service.v1.content-service\"..." type=io.containerd.service.v1 Nov 12 22:21:21.748070 containerd[2210]: time="2024-11-12T22:21:21.748029633Z" level=info msg="loading plugin \"io.containerd.service.v1.diff-service\"..." type=io.containerd.service.v1 Nov 12 22:21:21.748070 containerd[2210]: time="2024-11-12T22:21:21.748042571Z" level=info msg="loading plugin \"io.containerd.service.v1.images-service\"..." type=io.containerd.service.v1 Nov 12 22:21:21.748070 containerd[2210]: time="2024-11-12T22:21:21.748055949Z" level=info msg="loading plugin \"io.containerd.service.v1.introspection-service\"..." type=io.containerd.service.v1 Nov 12 22:21:21.748070 containerd[2210]: time="2024-11-12T22:21:21.748067245Z" level=info msg="loading plugin \"io.containerd.service.v1.namespaces-service\"..." type=io.containerd.service.v1 Nov 12 22:21:21.748240 containerd[2210]: time="2024-11-12T22:21:21.748078982Z" level=info msg="loading plugin \"io.containerd.service.v1.snapshots-service\"..." type=io.containerd.service.v1 Nov 12 22:21:21.748240 containerd[2210]: time="2024-11-12T22:21:21.748091399Z" level=info msg="loading plugin \"io.containerd.service.v1.tasks-service\"..." type=io.containerd.service.v1 Nov 12 22:21:21.748240 containerd[2210]: time="2024-11-12T22:21:21.748124204Z" level=info msg="loading plugin \"io.containerd.grpc.v1.containers\"..." type=io.containerd.grpc.v1 Nov 12 22:21:21.748240 containerd[2210]: time="2024-11-12T22:21:21.748137263Z" level=info msg="loading plugin \"io.containerd.grpc.v1.content\"..." type=io.containerd.grpc.v1 Nov 12 22:21:21.748240 containerd[2210]: time="2024-11-12T22:21:21.748149440Z" level=info msg="loading plugin \"io.containerd.grpc.v1.diff\"..." type=io.containerd.grpc.v1 Nov 12 22:21:21.748240 containerd[2210]: time="2024-11-12T22:21:21.748160695Z" level=info msg="loading plugin \"io.containerd.grpc.v1.events\"..." type=io.containerd.grpc.v1 Nov 12 22:21:21.748240 containerd[2210]: time="2024-11-12T22:21:21.748172031Z" level=info msg="loading plugin \"io.containerd.grpc.v1.images\"..." type=io.containerd.grpc.v1 Nov 12 22:21:21.748240 containerd[2210]: time="2024-11-12T22:21:21.748183847Z" level=info msg="loading plugin \"io.containerd.grpc.v1.introspection\"..." type=io.containerd.grpc.v1 Nov 12 22:21:21.748240 containerd[2210]: time="2024-11-12T22:21:21.748194422Z" level=info msg="loading plugin \"io.containerd.grpc.v1.leases\"..." type=io.containerd.grpc.v1 Nov 12 22:21:21.748240 containerd[2210]: time="2024-11-12T22:21:21.748205918Z" level=info msg="loading plugin \"io.containerd.grpc.v1.namespaces\"..." type=io.containerd.grpc.v1 Nov 12 22:21:21.748240 containerd[2210]: time="2024-11-12T22:21:21.748220098Z" level=info msg="loading plugin \"io.containerd.grpc.v1.sandbox-controllers\"..." type=io.containerd.grpc.v1 Nov 12 22:21:21.748240 containerd[2210]: time="2024-11-12T22:21:21.748238644Z" level=info msg="loading plugin \"io.containerd.grpc.v1.sandboxes\"..." type=io.containerd.grpc.v1 Nov 12 22:21:21.748509 containerd[2210]: time="2024-11-12T22:21:21.748250500Z" level=info msg="loading plugin \"io.containerd.grpc.v1.snapshots\"..." type=io.containerd.grpc.v1 Nov 12 22:21:21.748509 containerd[2210]: time="2024-11-12T22:21:21.748261916Z" level=info msg="loading plugin \"io.containerd.grpc.v1.streaming\"..." type=io.containerd.grpc.v1 Nov 12 22:21:21.748509 containerd[2210]: time="2024-11-12T22:21:21.748274173Z" level=info msg="loading plugin \"io.containerd.grpc.v1.tasks\"..." type=io.containerd.grpc.v1 Nov 12 22:21:21.748509 containerd[2210]: time="2024-11-12T22:21:21.748288193Z" level=info msg="loading plugin \"io.containerd.transfer.v1.local\"..." type=io.containerd.transfer.v1 Nov 12 22:21:21.748509 containerd[2210]: time="2024-11-12T22:21:21.748306778Z" level=info msg="loading plugin \"io.containerd.grpc.v1.transfer\"..." type=io.containerd.grpc.v1 Nov 12 22:21:21.748509 containerd[2210]: time="2024-11-12T22:21:21.748319196Z" level=info msg="loading plugin \"io.containerd.grpc.v1.version\"..." type=io.containerd.grpc.v1 Nov 12 22:21:21.748509 containerd[2210]: time="2024-11-12T22:21:21.748329730Z" level=info msg="loading plugin \"io.containerd.internal.v1.restart\"..." type=io.containerd.internal.v1 Nov 12 22:21:21.748657 containerd[2210]: time="2024-11-12T22:21:21.748633313Z" level=info msg="loading plugin \"io.containerd.tracing.processor.v1.otlp\"..." type=io.containerd.tracing.processor.v1 Nov 12 22:21:21.748679 containerd[2210]: time="2024-11-12T22:21:21.748655143Z" level=info msg="skip loading plugin \"io.containerd.tracing.processor.v1.otlp\"..." error="skip plugin: tracing endpoint not configured" type=io.containerd.tracing.processor.v1 Nov 12 22:21:21.748679 containerd[2210]: time="2024-11-12T22:21:21.748665517Z" level=info msg="loading plugin \"io.containerd.internal.v1.tracing\"..." type=io.containerd.internal.v1 Nov 12 22:21:21.748720 containerd[2210]: time="2024-11-12T22:21:21.748676813Z" level=info msg="skip loading plugin \"io.containerd.internal.v1.tracing\"..." error="skip plugin: tracing endpoint not configured" type=io.containerd.internal.v1 Nov 12 22:21:21.748720 containerd[2210]: time="2024-11-12T22:21:21.748685305Z" level=info msg="loading plugin \"io.containerd.grpc.v1.healthcheck\"..." type=io.containerd.grpc.v1 Nov 12 22:21:21.748720 containerd[2210]: time="2024-11-12T22:21:21.748705934Z" level=info msg="loading plugin \"io.containerd.nri.v1.nri\"..." type=io.containerd.nri.v1 Nov 12 22:21:21.748720 containerd[2210]: time="2024-11-12T22:21:21.748715587Z" level=info msg="NRI interface is disabled by configuration." Nov 12 22:21:21.748789 containerd[2210]: time="2024-11-12T22:21:21.748725281Z" level=info msg="loading plugin \"io.containerd.grpc.v1.cri\"..." type=io.containerd.grpc.v1 Nov 12 22:21:21.749220 containerd[2210]: time="2024-11-12T22:21:21.749171141Z" 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 22:21:21.749324 containerd[2210]: time="2024-11-12T22:21:21.749222132Z" level=info msg="Connect containerd service" Nov 12 22:21:21.749324 containerd[2210]: time="2024-11-12T22:21:21.749249129Z" level=info msg="using legacy CRI server" Nov 12 22:21:21.749324 containerd[2210]: time="2024-11-12T22:21:21.749255859Z" level=info msg="using experimental NRI integration - disable nri plugin to prevent this" Nov 12 22:21:21.749561 containerd[2210]: time="2024-11-12T22:21:21.749523952Z" level=info msg="Get image filesystem path \"/var/lib/containerd/io.containerd.snapshotter.v1.overlayfs\"" Nov 12 22:21:21.750060 containerd[2210]: time="2024-11-12T22:21:21.750037466Z" 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 22:21:21.750641 containerd[2210]: time="2024-11-12T22:21:21.750598046Z" level=info msg="Start subscribing containerd event" Nov 12 22:21:21.750692 containerd[2210]: time="2024-11-12T22:21:21.750658450Z" level=info msg="Start recovering state" Nov 12 22:21:21.750739 containerd[2210]: time="2024-11-12T22:21:21.750711403Z" level=info msg="Start event monitor" Nov 12 22:21:21.750739 containerd[2210]: time="2024-11-12T22:21:21.750731631Z" level=info msg="Start snapshots syncer" Nov 12 22:21:21.750798 containerd[2210]: time="2024-11-12T22:21:21.750742447Z" level=info msg="Start cni network conf syncer for default" Nov 12 22:21:21.750798 containerd[2210]: time="2024-11-12T22:21:21.750749016Z" level=info msg="Start streaming server" Nov 12 22:21:21.753711 containerd[2210]: time="2024-11-12T22:21:21.753678891Z" level=info msg=serving... address=/run/containerd/containerd.sock.ttrpc Nov 12 22:21:21.753836 containerd[2210]: time="2024-11-12T22:21:21.753758802Z" level=info msg=serving... address=/run/containerd/containerd.sock Nov 12 22:21:21.753865 containerd[2210]: time="2024-11-12T22:21:21.753850610Z" level=info msg="containerd successfully booted in 0.034407s" Nov 12 22:21:21.836631 dockerd[2211]: time="2024-11-12T22:21:21.836568916Z" level=info msg="Starting up" Nov 12 22:21:21.929131 systemd[1]: var-lib-docker-overlay2-check\x2doverlayfs\x2dsupport1283188328-merged.mount: Deactivated successfully. Nov 12 22:21:22.038254 dockerd[2211]: time="2024-11-12T22:21:22.037862417Z" level=info msg="[graphdriver] using prior storage driver: overlay2" Nov 12 22:21:22.046155 dockerd[2211]: time="2024-11-12T22:21:22.046085588Z" level=info msg="Loading containers: start." Nov 12 22:21:22.379312 dockerd[2211]: time="2024-11-12T22:21:22.379197553Z" 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 22:21:22.447225 dockerd[2211]: time="2024-11-12T22:21:22.447183518Z" level=info msg="Loading containers: done." Nov 12 22:21:22.459022 systemd[1]: var-lib-docker-overlay2-opaque\x2dbug\x2dcheck2336491501-merged.mount: Deactivated successfully. Nov 12 22:21:22.459381 dockerd[2211]: time="2024-11-12T22:21:22.459222494Z" 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 22:21:22.459381 dockerd[2211]: time="2024-11-12T22:21:22.459348608Z" level=info msg="Docker daemon" commit=8b539b8 containerd-snapshotter=false storage-driver=overlay2 version=27.2.1 Nov 12 22:21:22.459459 dockerd[2211]: time="2024-11-12T22:21:22.459390058Z" level=info msg="Daemon has completed initialization" Nov 12 22:21:22.484832 dockerd[2211]: time="2024-11-12T22:21:22.484752213Z" level=info msg="API listen on /run/docker.sock" Nov 12 22:21:22.484918 systemd[1]: Started docker.service - Docker Application Container Engine. Nov 12 22:21:22.486345 sudo[2058]: pam_unix(sudo:session): session closed for user root Nov 12 22:21:22.487731 sshd[2057]: Connection closed by 10.0.0.1 port 58960 Nov 12 22:21:22.488342 sshd-session[2055]: pam_unix(sshd:session): session closed for user core Nov 12 22:21:22.496126 kernel: EXT4-fs (loop3): unmounting filesystem 4ce96e51-c58f-432e-b85f-d5ad50edcc90. Nov 12 22:21:22.501918 systemd-logind[1363]: Session 14 logged out. Waiting for processes to exit. Nov 12 22:21:22.502586 kernel: EXT4-fs (loop2): unmounting filesystem 8f7006c0-b97b-47d5-bb76-32ad5d61aefe. Nov 12 22:21:22.509394 systemd[1]: Started sshd@14-10.0.0.27:22-10.0.0.1:36384.service - OpenSSH per-connection server daemon (10.0.0.1:36384). Nov 12 22:21:22.528834 systemd[1]: sshd@13-10.0.0.27:22-10.0.0.1:58960.service: Deactivated successfully. Nov 12 22:21:22.531438 systemd[1]: session-14.scope: Deactivated successfully. Nov 12 22:21:22.532464 systemd-logind[1363]: Removed session 14. Nov 12 22:21:22.544485 sshd[2417]: Accepted publickey for core from 10.0.0.1 port 36384 ssh2: RSA SHA256:KPgpt/5uXhXBYNY6jU95wYzOWgpCWHnSiDnDh5jQRRc Nov 12 22:21:22.545677 sshd-session[2417]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Nov 12 22:21:22.549341 systemd-logind[1363]: New session 15 of user core. Nov 12 22:21:22.557245 systemd[1]: Started session-15.scope - Session 15 of User core. Nov 12 22:21:22.680142 kernel: docker0: port 1(veth38887f8) entered blocking state Nov 12 22:21:22.680261 kernel: docker0: port 1(veth38887f8) entered disabled state Nov 12 22:21:22.680293 kernel: veth38887f8: entered allmulticast mode Nov 12 22:21:22.680323 kernel: veth38887f8: entered promiscuous mode Nov 12 22:21:22.680570 systemd-networkd[1317]: veth38887f8: Link UP Nov 12 22:21:22.726689 containerd[2210]: time="2024-11-12T22:21:22.726516093Z" level=info msg="loading plugin \"io.containerd.event.v1.publisher\"..." runtime=io.containerd.runc.v2 type=io.containerd.event.v1 Nov 12 22:21:22.726689 containerd[2210]: time="2024-11-12T22:21:22.726558825Z" level=info msg="loading plugin \"io.containerd.internal.v1.shutdown\"..." runtime=io.containerd.runc.v2 type=io.containerd.internal.v1 Nov 12 22:21:22.726689 containerd[2210]: time="2024-11-12T22:21:22.726569398Z" level=info msg="loading plugin \"io.containerd.ttrpc.v1.task\"..." runtime=io.containerd.runc.v2 type=io.containerd.ttrpc.v1 Nov 12 22:21:22.727328 containerd[2210]: time="2024-11-12T22:21:22.726940930Z" level=info msg="loading plugin \"io.containerd.ttrpc.v1.pause\"..." runtime=io.containerd.runc.v2 type=io.containerd.ttrpc.v1 Nov 12 22:21:22.744339 systemd[1]: Started docker-5e5ae7d046a0d165a1a89fd0c54626c1a9c41defb986f7b7b930821dd48ee779.scope - libcontainer container 5e5ae7d046a0d165a1a89fd0c54626c1a9c41defb986f7b7b930821dd48ee779. Nov 12 22:21:22.786149 kernel: eth0: renamed from veth6828cb8 Nov 12 22:21:22.795686 kernel: docker0: port 1(veth38887f8) entered blocking state Nov 12 22:21:22.795735 kernel: docker0: port 1(veth38887f8) entered forwarding state Nov 12 22:21:22.795771 systemd-networkd[1317]: veth38887f8: Gained carrier Nov 12 22:21:22.796006 systemd-networkd[1317]: docker0: Gained carrier Nov 12 22:21:22.798106 systemd-resolved[1268]: Failed to determine the local hostname and LLMNR/mDNS names, ignoring: No such device or address Nov 12 22:21:22.815575 systemd[1]: docker-5e5ae7d046a0d165a1a89fd0c54626c1a9c41defb986f7b7b930821dd48ee779.scope: Deactivated successfully. Nov 12 22:21:22.828145 containerd[2210]: time="2024-11-12T22:21:22.828072646Z" level=info msg="shim disconnected" id=5e5ae7d046a0d165a1a89fd0c54626c1a9c41defb986f7b7b930821dd48ee779 namespace=moby Nov 12 22:21:22.828145 containerd[2210]: time="2024-11-12T22:21:22.828136404Z" level=warning msg="cleaning up after shim disconnected" id=5e5ae7d046a0d165a1a89fd0c54626c1a9c41defb986f7b7b930821dd48ee779 namespace=moby Nov 12 22:21:22.828145 containerd[2210]: time="2024-11-12T22:21:22.828146296Z" level=info msg="cleaning up dead shim" namespace=moby Nov 12 22:21:22.828415 dockerd[2211]: time="2024-11-12T22:21:22.828337248Z" level=info msg="ignoring event" container=5e5ae7d046a0d165a1a89fd0c54626c1a9c41defb986f7b7b930821dd48ee779 module=libcontainerd namespace=moby topic=/tasks/delete type="*events.TaskDelete" Nov 12 22:21:22.842130 kernel: veth6828cb8: renamed from eth0 Nov 12 22:21:22.847947 systemd-networkd[1317]: veth38887f8: Lost carrier Nov 12 22:21:22.848637 kernel: docker0: port 1(veth38887f8) entered disabled state Nov 12 22:21:22.860722 systemd-networkd[1317]: veth38887f8: Link DOWN Nov 12 22:21:22.861234 kernel: docker0: port 1(veth38887f8) entered disabled state Nov 12 22:21:22.862423 kernel: veth38887f8 (unregistering): left allmulticast mode Nov 12 22:21:22.862456 kernel: veth38887f8 (unregistering): left promiscuous mode Nov 12 22:21:22.862471 kernel: docker0: port 1(veth38887f8) entered disabled state Nov 12 22:21:22.892263 sshd[2420]: Connection closed by 10.0.0.1 port 36384 Nov 12 22:21:22.892813 sshd-session[2417]: pam_unix(sshd:session): session closed for user core Nov 12 22:21:22.895863 systemd[1]: sshd@14-10.0.0.27:22-10.0.0.1:36384.service: Deactivated successfully. Nov 12 22:21:22.897487 systemd[1]: session-15.scope: Deactivated successfully. Nov 12 22:21:22.898030 systemd-logind[1363]: Session 15 logged out. Waiting for processes to exit. Nov 12 22:21:22.898710 systemd-logind[1363]: Removed session 15. Nov 12 22:21:23.036793 systemd[1]: var-lib-docker-overlay2-1df61115dcf7137745862c105063cd24703257e1988beaa2168cde6a364b6dcf\x2dinit-merged.mount: Deactivated successfully. Nov 12 22:21:23.727677 systemd-networkd[1317]: docker0: Lost carrier